2020-02-23 07:33:04,708 [salt.utils.decorators:613 ][WARNING ][1545] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-02-23 07:33:05,863 [salt.utils.decorators:613 ][WARNING ][1545] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-02-23 07:33:18,257 [salt.loaded.int.states.file:2298][WARNING ][1694] 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.
2020-02-23 07:33:22,662 [salt.loaded.int.module.cmdmod:395 ][INFO    ][1905] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2020-02-23 07:33:22,703 [salt.loaded.int.module.cmdmod:395 ][INFO    ][1905] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2020-02-23 07:33:22,751 [salt.utils.parsers:1051][WARNING ][154] Minion received a SIGTERM. Exiting.
2020-02-23 07:33:24,010 [salt.cli.daemons :293 ][INFO    ][2065] Setting up the Salt Minion "mas01.mcp-ovs-ha.local"
2020-02-23 07:33:24,268 [salt.cli.daemons :82  ][INFO    ][2065] Starting up the Salt Minion
2020-02-23 07:33:24,269 [salt.utils.event :1017][INFO    ][2065] Starting pull socket on /var/run/salt/minion/minion_event_501f9ec045_pull.ipc
2020-02-23 07:33:25,641 [salt.minion      :976 ][INFO    ][2065] Creating minion process manager
2020-02-23 07:33:26,996 [salt.state       :2022][WARNING ][1910] State is set to retry, but a valid dict for retry configuration was not found.  Using retry defaults
2020-02-23 07:33:27,701 [salt.utils.decorators:613 ][WARNING ][1910] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-02-23 07:33:28,075 [salt.loader.10.20.0.2.int.module.cmdmod:395 ][INFO    ][2065] Executing command ['date', '+%z'] in directory '/root'
2020-02-23 07:33:28,106 [salt.utils.schedule:568 ][INFO    ][2065] Updating job settings for scheduled job: __mine_interval
2020-02-23 07:33:28,109 [salt.minion      :1108][INFO    ][2065] Added mine.update to scheduler
2020-02-23 07:33:28,119 [salt.minion      :1975][INFO    ][2065] Minion is starting as user 'root'
2020-02-23 07:33:28,136 [salt.minion      :2336][INFO    ][2065] Minion is ready to receive requests!
2020-02-23 07:33:34,720 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223073334709745
2020-02-23 07:33:34,736 [salt.minion      :1432][INFO    ][2445] Starting a new job with PID 2445
2020-02-23 07:33:34,775 [salt.minion      :1711][INFO    ][2445] Returning information for job: 20200223073334709745
2020-02-23 07:33:45,191 [salt.utils.decorators:613 ][WARNING ][1910] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-02-23 07:33:47,249 [salt.loaded.ext.module.maasng:1694][WARNING ][1910] boot_source_selections catch error during processing. Most-probably, streams data not imported yet.
Sleep:5s Retry:0/10
2020-02-23 07:33:47,250 [salt.loaded.ext.module.maasng:1695][WARNING ][1910] Message:['{"os": ["OS ubuntu with release bionic has no available images for download"]}']
2020-02-23 07:34:04,863 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223073404850130
2020-02-23 07:34:04,882 [salt.minion      :1432][INFO    ][2654] Starting a new job with PID 2654
2020-02-23 07:34:04,905 [salt.minion      :1711][INFO    ][2654] Returning information for job: 20200223073404850130
2020-02-23 07:34:07,457 [salt.utils.decorators:613 ][WARNING ][1910] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-02-23 07:34:08,343 [salt.utils.decorators:613 ][WARNING ][1910] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-02-23 07:34:10,788 [salt.loaded.ext.module.maasng:1008][WARNING ][1910] Detected cidr:192.168.11.0/24 in fabric:fabric-1
2020-02-23 07:34:10,789 [salt.loaded.ext.module.maasng:1011][WARNING ][1910] Guessing, that fabric with current name:fabric-1
 should be renamed to:pxe_admin
2020-02-23 07:34:11,374 [salt.loaded.ext.module.maasng:1235][WARNING ][1910] Ignoring parameter vlan:0
2020-02-23 07:34:13,281 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command state.apply with jid 20200223073413267195
2020-02-23 07:34:13,299 [salt.minion      :1432][INFO    ][2696] Starting a new job with PID 2696
2020-02-23 07:34:21,578 [salt.state       :915 ][INFO    ][2696] Loading fresh modules for state activity
2020-02-23 07:34:21,654 [salt.fileclient  :1219][INFO    ][2696] Fetching file from saltenv 'base', ** done ** 'maas/machines/init.sls'
2020-02-23 07:34:21,708 [salt.state       :1780][INFO    ][2696] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 07:34:21.707942
2020-02-23 07:34:21,709 [salt.state       :1813][INFO    ][2696] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2020-02-23 07:34:21,712 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2696] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2020-02-23 07:34:24,091 [salt.state       :300 ][INFO    ][2696] {'pid': 2710, 'retcode': 0, 'stderr': '', 'stdout': ''}
2020-02-23 07:34:24,093 [salt.state       :1951][INFO    ][2696] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 07:34:24.092988 duration_in_ms=2385.046
2020-02-23 07:34:24,096 [salt.state       :1780][INFO    ][2696] Running state [maas.process_machines] at time 07:34:24.096737
2020-02-23 07:34:24,097 [salt.state       :1813][INFO    ][2696] Executing state module.run for [maas.process_machines]
2020-02-23 07:34:24,097 [salt.utils.decorators:613 ][WARNING ][2696] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-02-23 07:34:24,157 [salt.loaded.ext.module.maas:412 ][WARNING ][2696] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2020-02-23 07:34:24,158 [salt.loaded.ext.module.maas:92  ][INFO    ][2696] machine hostname=cmp002 power_type=ipmi mac_addresses=9c:b6:54:8a:10:18 power_parameters_power_address=172.16.1.20 power_parameters_power_pass=Winter2017 architecture=amd64/generic power_parameters_power_user=opnfv
2020-02-23 07:34:25,115 [salt.loaded.ext.module.maas:412 ][WARNING ][2696] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2020-02-23 07:34:25,115 [salt.loaded.ext.module.maas:92  ][INFO    ][2696] machine hostname=cmp001 power_type=ipmi mac_addresses=9c:b6:54:8a:95:a0 power_parameters_power_address=172.16.1.19 power_parameters_power_pass=Winter2017 architecture=amd64/generic power_parameters_power_user=opnfv
2020-02-23 07:34:25,989 [salt.loaded.ext.module.maas:412 ][WARNING ][2696] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2020-02-23 07:34:25,990 [salt.loaded.ext.module.maas:92  ][INFO    ][2696] machine hostname=kvm01 power_type=ipmi mac_addresses=14:58:d0:54:e7:88 power_parameters_power_address=172.16.1.16 power_parameters_power_pass=Winter2017 architecture=amd64/generic power_parameters_power_user=opnfv
2020-02-23 07:34:26,759 [salt.loaded.ext.module.maas:412 ][WARNING ][2696] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2020-02-23 07:34:26,763 [salt.loaded.ext.module.maas:92  ][INFO    ][2696] machine hostname=kvm03 power_type=ipmi mac_addresses=14:58:d0:54:7a:28 power_parameters_power_address=172.16.1.18 power_parameters_power_pass=Winter2017 architecture=amd64/generic power_parameters_power_user=opnfv
2020-02-23 07:34:27,596 [salt.loaded.ext.module.maas:412 ][WARNING ][2696] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2020-02-23 07:34:27,596 [salt.loaded.ext.module.maas:92  ][INFO    ][2696] machine hostname=kvm02 power_type=ipmi mac_addresses=14:58:d0:54:6a:60 power_parameters_power_address=172.16.1.17 power_parameters_power_pass=Winter2017 architecture=amd64/generic power_parameters_power_user=opnfv
2020-02-23 07:34:28,346 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223073428334102
2020-02-23 07:34:28,368 [salt.minion      :1432][INFO    ][2745] Starting a new job with PID 2745
2020-02-23 07:34:28,395 [salt.minion      :1711][INFO    ][2745] Returning information for job: 20200223073428334102
2020-02-23 07:34:28,450 [salt.state       :300 ][INFO    ][2696] {'ret': {'updated': [], 'errors': {}, 'success': ['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']}}
2020-02-23 07:34:28,451 [salt.state       :1951][INFO    ][2696] Completed state [maas.process_machines] at time 07:34:28.451197 duration_in_ms=4354.458
2020-02-23 07:34:28,458 [salt.minion      :1711][INFO    ][2696] Returning information for job: 20200223073413267195
2020-02-23 07:35:00,333 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command state.apply with jid 20200223073500325653
2020-02-23 07:35:00,352 [salt.minion      :1432][INFO    ][2809] Starting a new job with PID 2809
2020-02-23 07:35:08,693 [salt.state       :915 ][INFO    ][2809] Loading fresh modules for state activity
2020-02-23 07:35:08,765 [salt.fileclient  :1219][INFO    ][2809] Fetching file from saltenv 'base', ** done ** 'maas/machines/wait_for_ready_or_deployed.sls'
2020-02-23 07:35:08,816 [salt.state       :1780][INFO    ][2809] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 07:35:08.816524
2020-02-23 07:35:08,816 [salt.state       :1813][INFO    ][2809] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2020-02-23 07:35:08,818 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2809] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2020-02-23 07:35:11,147 [salt.state       :300 ][INFO    ][2809] {'pid': 2822, 'retcode': 0, 'stderr': '', 'stdout': ''}
2020-02-23 07:35:11,149 [salt.state       :1951][INFO    ][2809] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 07:35:11.149223 duration_in_ms=2332.698
2020-02-23 07:35:11,153 [salt.state       :1780][INFO    ][2809] Running state [maas.wait_for_machine_status] at time 07:35:11.153783
2020-02-23 07:35:11,154 [salt.state       :1813][INFO    ][2809] Executing state module.run for [maas.wait_for_machine_status]
2020-02-23 07:35:11,155 [salt.utils.decorators:613 ][WARNING ][2809] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-02-23 07:35:12,131 [salt.loaded.ext.module.maas:1024][INFO    ][2809] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1499.03821492s left)
2020-02-23 07:35:15,451 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223073515438621
2020-02-23 07:35:15,474 [salt.minion      :1432][INFO    ][2831] Starting a new job with PID 2831
2020-02-23 07:35:15,501 [salt.minion      :1711][INFO    ][2831] Returning information for job: 20200223073515438621
2020-02-23 07:35:43,135 [salt.loaded.ext.module.maas:1024][INFO    ][2809] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1468.03436995s left)
2020-02-23 07:35:45,539 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223073545525988
2020-02-23 07:35:45,563 [salt.minion      :1432][INFO    ][2858] Starting a new job with PID 2858
2020-02-23 07:35:45,590 [salt.minion      :1711][INFO    ][2858] Returning information for job: 20200223073545525988
2020-02-23 07:36:14,051 [salt.loaded.ext.module.maas:1024][INFO    ][2809] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1437.118402s left)
2020-02-23 07:36:15,609 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223073615597193
2020-02-23 07:36:15,634 [salt.minion      :1432][INFO    ][2882] Starting a new job with PID 2882
2020-02-23 07:36:15,659 [salt.minion      :1711][INFO    ][2882] Returning information for job: 20200223073615597193
2020-02-23 07:36:44,977 [salt.loaded.ext.module.maas:1024][INFO    ][2809] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1406.19211102s left)
2020-02-23 07:36:45,669 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223073645659508
2020-02-23 07:36:45,692 [salt.minion      :1432][INFO    ][2909] Starting a new job with PID 2909
2020-02-23 07:36:45,716 [salt.minion      :1711][INFO    ][2909] Returning information for job: 20200223073645659508
2020-02-23 07:37:15,719 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223073715705175
2020-02-23 07:37:15,741 [salt.minion      :1432][INFO    ][2945] Starting a new job with PID 2945
2020-02-23 07:37:15,766 [salt.minion      :1711][INFO    ][2945] Returning information for job: 20200223073715705175
2020-02-23 07:37:16,153 [salt.loaded.ext.module.maas:1024][INFO    ][2809] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1375.0159359s left)
2020-02-23 07:37:45,789 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223073745777863
2020-02-23 07:37:45,803 [salt.minion      :1432][INFO    ][3005] Starting a new job with PID 3005
2020-02-23 07:37:45,835 [salt.minion      :1711][INFO    ][3005] Returning information for job: 20200223073745777863
2020-02-23 07:37:47,574 [salt.loaded.ext.module.maas:1024][INFO    ][2809] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1343.59552503s left)
2020-02-23 07:38:15,875 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223073815860863
2020-02-23 07:38:15,895 [salt.minion      :1432][INFO    ][3043] Starting a new job with PID 3043
2020-02-23 07:38:15,919 [salt.minion      :1711][INFO    ][3043] Returning information for job: 20200223073815860863
2020-02-23 07:38:18,914 [salt.loaded.ext.module.maas:1024][INFO    ][2809] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1312.25552893s left)
2020-02-23 07:38:45,966 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223073845954182
2020-02-23 07:38:45,987 [salt.minion      :1432][INFO    ][3109] Starting a new job with PID 3109
2020-02-23 07:38:46,011 [salt.minion      :1711][INFO    ][3109] Returning information for job: 20200223073845954182
2020-02-23 07:38:50,541 [salt.loaded.ext.module.maas:1024][INFO    ][2809] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1280.62814999s left)
2020-02-23 07:39:16,010 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223073915993851
2020-02-23 07:39:16,031 [salt.minion      :1432][INFO    ][3160] Starting a new job with PID 3160
2020-02-23 07:39:16,070 [salt.minion      :1711][INFO    ][3160] Returning information for job: 20200223073915993851
2020-02-23 07:39:22,449 [salt.loaded.ext.module.maas:1024][INFO    ][2809] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1248.72055197s left)
2020-02-23 07:39:46,135 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223073946121963
2020-02-23 07:39:46,157 [salt.minion      :1432][INFO    ][3222] Starting a new job with PID 3222
2020-02-23 07:39:46,183 [salt.minion      :1711][INFO    ][3222] Returning information for job: 20200223073946121963
2020-02-23 07:39:54,954 [salt.loaded.ext.module.maas:1024][INFO    ][2809] Waiting status:Ready|Deployed for machines:['cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1216.21504998s left)
2020-02-23 07:40:16,257 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223074016243986
2020-02-23 07:40:16,282 [salt.minion      :1432][INFO    ][3272] Starting a new job with PID 3272
2020-02-23 07:40:16,306 [salt.minion      :1711][INFO    ][3272] Returning information for job: 20200223074016243986
2020-02-23 07:40:27,662 [salt.loaded.ext.module.maas:1024][INFO    ][2809] Waiting status:Ready|Deployed for machines:['kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1183.50760198s left)
2020-02-23 07:40:46,385 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223074046370270
2020-02-23 07:40:46,409 [salt.minion      :1432][INFO    ][3305] Starting a new job with PID 3305
2020-02-23 07:40:46,439 [salt.minion      :1711][INFO    ][3305] Returning information for job: 20200223074046370270
2020-02-23 07:41:00,173 [salt.loaded.ext.module.maas:1024][INFO    ][2809] Waiting status:Ready|Deployed for machines:['kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1150.9959619s left)
2020-02-23 07:41:16,511 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223074116497430
2020-02-23 07:41:16,542 [salt.minion      :1432][INFO    ][3352] Starting a new job with PID 3352
2020-02-23 07:41:16,577 [salt.minion      :1711][INFO    ][3352] Returning information for job: 20200223074116497430
2020-02-23 07:41:33,542 [salt.loaded.ext.module.maas:1024][INFO    ][2809] Waiting status:Ready|Deployed for machines:['kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1117.62742305s left)
2020-02-23 07:41:46,645 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223074146631639
2020-02-23 07:41:46,670 [salt.minion      :1432][INFO    ][3415] Starting a new job with PID 3415
2020-02-23 07:41:46,697 [salt.minion      :1711][INFO    ][3415] Returning information for job: 20200223074146631639
2020-02-23 07:42:06,951 [salt.state       :300 ][INFO    ][2809] {'ret': True}
2020-02-23 07:42:06,951 [salt.state       :1951][INFO    ][2809] Completed state [maas.wait_for_machine_status] at time 07:42:06.951678 duration_in_ms=415797.893
2020-02-23 07:42:06,957 [salt.minion      :1711][INFO    ][2809] Returning information for job: 20200223073500325653
2020-02-23 07:42:07,899 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command state.apply with jid 20200223074207882645
2020-02-23 07:42:07,924 [salt.minion      :1432][INFO    ][3450] Starting a new job with PID 3450
2020-02-23 07:42:16,167 [salt.state       :915 ][INFO    ][3450] Loading fresh modules for state activity
2020-02-23 07:42:16,223 [salt.fileclient  :1219][INFO    ][3450] Fetching file from saltenv 'base', ** done ** 'maas/machines/storage.sls'
2020-02-23 07:42:16,335 [salt.state       :1780][INFO    ][3450] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 07:42:16.335255
2020-02-23 07:42:16,335 [salt.state       :1813][INFO    ][3450] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2020-02-23 07:42:16,338 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3450] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2020-02-23 07:42:18,619 [salt.state       :300 ][INFO    ][3450] {'pid': 3457, 'retcode': 0, 'stderr': '', 'stdout': ''}
2020-02-23 07:42:18,619 [salt.state       :1951][INFO    ][3450] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 07:42:18.619690 duration_in_ms=2284.436
2020-02-23 07:42:18,622 [salt.state       :1780][INFO    ][3450] Running state [maas_machines_storage_cmp002_lvm] at time 07:42:18.622292
2020-02-23 07:42:18,622 [salt.state       :1813][INFO    ][3450] Executing state maasng.disk_layout_present for [maas_machines_storage_cmp002_lvm]
2020-02-23 07:42:20,039 [salt.loaded.ext.module.maasng:610 ][INFO    ][3450] arrwft
2020-02-23 07:42:20,039 [salt.loaded.ext.module.maasng:626 ][INFO    ][3450] sda
2020-02-23 07:42:20,708 [salt.loaded.ext.module.maasng:361 ][INFO    ][3450] arrwft
2020-02-23 07:42:20,790 [salt.loaded.ext.module.maasng:367 ][INFO    ][3450] [{u'resource_uri': u'/MAAS/api/2.0/nodes/arrwft/blockdevices/1/', u'available_size': 0, u'uuid': None, u'name': u'sda', u'tags': [u'ssd'], u'type': u'physical', u'partitions': [{u'uuid': u'ee4a7b7a-8e39-46af-b1f6-bf693f14b283', u'resource_uri': u'/MAAS/api/2.0/nodes/arrwft/blockdevices/1/partition/1', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'arrwft', u'filesystem': {u'mount_options': None, u'label': None, u'mount_point': None, u'uuid': u'24debfb9-6457-4516-9965-9795703239ae', u'fstype': u'lvm-pv'}, u'path': u'/dev/disk/by-dname/sda-part1', u'size': 800101236736, u'type': u'partition', u'id': 1, u'device_id': 1}], u'id': 1, u'used_for': u'MBR partitioned with 1 partition', u'system_id': u'arrwft', u'partition_table_type': u'MBR', u'filesystem': None, u'id_path': u'/dev/disk/by-id/wwn-0x600508b1001cb19198eb9a66f8a29401', u'path': u'/dev/disk/by-dname/sda', u'serial': u'600508b1001cb19198eb9a66f8a29401', u'block_size': 4096, u'used_size': 800106479616, u'model': u'LOGICAL VOLUME', u'size': 800109715456}, {u'resource_uri': u'/MAAS/api/2.0/nodes/arrwft/blockdevices/3/', u'available_size': 0, u'uuid': u'eda2c64a-6201-4cbd-b126-4f34cd31342c', u'name': u'vgroot-lvroot', u'tags': [], u'type': u'virtual', u'partitions': [], u'id': 3, u'used_for': u'ext4 formatted filesystem mounted at /', u'system_id': u'arrwft', u'partition_table_type': None, u'filesystem': {u'mount_options': None, u'label': u'root', u'mount_point': u'/', u'uuid': u'95d87d1f-1d04-4db9-b045-02a2f5a2d961', u'fstype': u'ext4'}, u'id_path': None, u'path': u'/dev/disk/by-dname/lvroot', u'serial': None, u'block_size': 4096, u'used_size': 800097042432, u'model': None, u'size': 800097042432}]
2020-02-23 07:42:20,791 [salt.loaded.ext.module.maasng:632 ][INFO    ][3450] vgroot
2020-02-23 07:42:20,791 [salt.loaded.ext.module.maasng:635 ][INFO    ][3450] lvroot
2020-02-23 07:42:20,791 [salt.loaded.ext.module.maasng:639 ][INFO    ][3450] 107374182400
2020-02-23 07:42:21,433 [salt.loaded.ext.module.maasng:645 ][INFO    ][3450] {u'domain': {u'resource_record_count': 0, u'name': u'maas', u'authoritative': True, u'is_default': True, u'ttl': None, u'id': 0, u'resource_uri': u'/MAAS/api/2.0/domains/0/'}, u'swap_size': None, u'ip_addresses': [u'192.168.11.38', u'192.168.11.40'], u'cpu_count': 40, u'owner_data': {}, u'hwe_kernel': None, u'boot_interface': {u'product': u'ProLiant BL460c Gen8 (735151-B21)', u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'hdkn4c', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/', u'id': 5002, u'secondary_rack': None, u'name': u'untagged'}, u'vendor': u'HP', u'name': u'eno1', 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'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'hdkn4c', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/', u'id': 5002, u'secondary_rack': None, u'name': u'untagged'}, 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'id': 20, u'mode': u'dhcp'}], u'tags': [u'sriov'], u'effective_mtu': 1500, u'enabled': True, u'parents': [], 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'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'hdkn4c', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/', u'id': 5002, u'secondary_rack': None, u'name': u'untagged'}, 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'params': u'', u'mac_address': u'9c:b6:54:8a:10:18', u'id': 4, u'system_id': u'arrwft', u'firmware_version': u'bc 7.8.24', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/arrwft/interfaces/4/'}, u'node_type': 0, u'tag_names': [], u'testing_status_name': u'Passed', u'cpu_speed': 2800, u'owner': None, u'pod': None, u'cache_sets': [], u'iscsiblockdevice_set': [], u'status_action': u'', u'zone': {u'id': 1, u'resource_uri': u'/MAAS/api/2.0/zones/default/', u'name': u'default', u'description': u''}, u'resource_uri': u'/MAAS/api/2.0/machines/arrwft/', u'current_commissioning_result_id': 2, u'hardware_info': {u'mainboard_firmware_version': u'I31', u'mainboard_product': u'Unknown', u'system_vendor': u'HP', u'cpu_model': u'Intel(R) Xeon(R) CPU E5-2680 v2', u'mainboard_firmware_date': u'12/20/2013', u'mainboard_vendor': u'Unknown', u'system_serial': u'USE410T2Y0', u'system_version': u'Unknown', u'system_product': u'ProLiant BL460c Gen8 (735151-B21)'}, u'hostname': u'cmp002', u'storage': 800109.715456, u'testing_status': 2, u'system_id': u'arrwft', u'power_state': u'off', u'memory': 65536, u'current_installation_result_id': None, u'default_gateways': {u'ipv4': {u'gateway_ip': u'192.168.11.3', u'link_id': None}, u'ipv6': {u'gateway_ip': None, u'link_id': None}}, u'status_message': u'Power state queried: off', u'disable_ipv4': False, u'blockdevice_set': [{u'size': 800109715456, u'resource_uri': u'/MAAS/api/2.0/nodes/arrwft/blockdevices/1/', u'available_size': 0, u'uuid': None, u'name': u'sda', u'tags': [u'ssd'], u'type': u'physical', u'used_for': u'MBR partitioned with 1 partition', u'system_id': u'arrwft', u'partition_table_type': u'MBR', u'filesystem': None, u'id_path': u'/dev/disk/by-id/wwn-0x600508b1001cb19198eb9a66f8a29401', u'path': u'/dev/disk/by-dname/sda', u'model': u'LOGICAL VOLUME', u'block_size': 4096, u'used_size': 800106479616, u'id': 1, u'serial': u'600508b1001cb19198eb9a66f8a29401', u'partitions': [{u'uuid': u'fa03dc24-43f1-4d9c-bff4-7c7438d95c93', u'resource_uri': u'/MAAS/api/2.0/nodes/arrwft/blockdevices/1/partition/6', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'arrwft', u'filesystem': {u'mount_options': None, u'label': None, u'mount_point': None, u'uuid': u'7b19564c-b281-4046-af36-b7ab5e77d8b4', u'fstype': u'lvm-pv'}, u'path': u'/dev/disk/by-dname/sda-part1', u'device_id': 1, u'type': u'partition', u'id': 6, u'size': 800101236736}]}, {u'size': 107374182400, u'resource_uri': u'/MAAS/api/2.0/nodes/arrwft/blockdevices/11/', u'available_size': 0, u'uuid': u'1ddaf874-8bd3-4843-8c2b-7441afe162dc', u'name': u'vgroot-lvroot', u'tags': [], u'type': u'virtual', u'used_for': u'ext4 formatted filesystem mounted at /', u'system_id': u'arrwft', u'partition_table_type': None, u'filesystem': {u'mount_options': None, u'label': u'root', u'mount_point': u'/', u'uuid': u'45ef286a-5eaa-4cf9-a969-ffa8b9caca54', u'fstype': u'ext4'}, u'id_path': None, u'path': u'/dev/disk/by-dname/lvroot', u'model': None, u'block_size': 4096, u'used_size': 107374182400, u'id': 11, u'serial': None, u'partitions': []}], u'status': 4, u'bcaches': [], u'storage_test_status_name': u'Passed', u'raids': [], 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'ssd'], u'type': u'physical', u'id': 1, u'used_for': u'MBR partitioned with 1 partition', u'resource_uri': u'/MAAS/api/2.0/nodes/arrwft/blockdevices/1/', u'system_id': u'arrwft', u'partition_table_type': u'MBR', u'filesystem': None, u'id_path': u'/dev/disk/by-id/wwn-0x600508b1001cb19198eb9a66f8a29401', u'path': u'/dev/disk/by-dname/sda', u'firmware_version': u'5.22', u'size': 800109715456, u'used_size': 800106479616, u'model': u'LOGICAL VOLUME', u'serial': u'600508b1001cb19198eb9a66f8a29401', u'partitions': [{u'uuid': u'fa03dc24-43f1-4d9c-bff4-7c7438d95c93', u'resource_uri': u'/MAAS/api/2.0/nodes/arrwft/blockdevices/1/partition/6', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'arrwft', u'filesystem': {u'mount_options': None, u'label': None, u'mount_point': None, u'uuid': u'7b19564c-b281-4046-af36-b7ab5e77d8b4', u'fstype': u'lvm-pv'}, u'path': u'/dev/disk/by-dname/sda-part1', u'device_id': 1, u'type': u'partition', u'id': 6, u'size': 800101236736}]}], u'other_test_status_name': u'Unknown', u'volume_groups': [{u'__incomplete__': True, u'system_id': u'arrwft', u'id': 6}], u'special_filesystems': [], u'cpu_test_status_name': u'Unknown', u'node_type_name': u'Machine', u'current_testing_result_id': 3, u'cpu_test_status': -1, u'pool': {u'id': 0, u'resource_uri': u'/MAAS/api/2.0/resourcepool/0/', u'name': u'default', u'description': u'Default pool'}, u'architecture': u'amd64/generic', u'storage_test_status': 2, u'other_test_status': -1, u'locked': False, u'status_name': u'Ready', u'netboot': True, u'osystem': u'', u'fqdn': u'cmp002.maas', u'memory_test_status_name': u'Unknown', u'virtualblockdevice_set': [{u'block_size': 4096, u'available_size': 0, u'uuid': u'1ddaf874-8bd3-4843-8c2b-7441afe162dc', u'name': u'vgroot-lvroot', u'tags': [], u'type': u'virtual', u'used_for': u'ext4 formatted filesystem mounted at /', u'resource_uri': u'/MAAS/api/2.0/nodes/arrwft/blockdevices/11/', u'system_id': u'arrwft', u'partition_table_type': None, u'filesystem': {u'mount_options': None, u'label': u'root', u'mount_point': u'/', u'uuid': u'45ef286a-5eaa-4cf9-a969-ffa8b9caca54', u'fstype': u'ext4'}, u'id_path': None, u'path': u'/dev/disk/by-dname/vgroot-lvroot', u'model': None, u'partitions': [], u'used_size': 107374182400, u'id': 11, u'serial': None, u'size': 107374182400}], u'commissioning_status': 2, u'min_hwe_kernel': u'ga-18.04', u'commissioning_status_name': u'Passed', u'interface_set': [{u'product': u'ProLiant BL460c Gen8 (735151-B21)', u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'hdkn4c', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/', u'id': 5002, u'secondary_rack': None, u'name': u'untagged'}, u'vendor': u'HP', u'name': u'eno1', 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'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'hdkn4c', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/', u'id': 5002, u'secondary_rack': None, u'name': u'untagged'}, 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'id': 20, u'mode': u'dhcp'}], u'tags': [u'sriov'], u'effective_mtu': 1500, u'enabled': True, u'parents': [], 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'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'hdkn4c', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/', u'id': 5002, u'secondary_rack': None, u'name': u'untagged'}, 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'params': u'', u'mac_address': u'9c:b6:54:8a:10:18', u'id': 4, u'system_id': u'arrwft', u'firmware_version': u'bc 7.8.24', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/arrwft/interfaces/4/'}, {u'product': u'ProLiant BL460c Gen8 (735151-B21)', u'vlan': None, u'vendor': u'HP', u'name': u'ens1f0', u'links': [], u'tags': [u'sriov'], u'effective_mtu': 1500, u'enabled': True, u'parents': [], u'discovered': None, u'params': u'', u'mac_address': u'38:ea:a7:8f:07:50', u'id': 11, u'system_id': u'arrwft', u'firmware_version': u'bc 7.8.24', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/arrwft/interfaces/11/'}, {u'product': u'ProLiant BL460c Gen8 (735151-B21)', u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'hdkn4c', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/', u'id': 5002, u'secondary_rack': None, u'name': u'untagged'}, u'vendor': u'HP', u'name': u'eno2', 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'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'hdkn4c', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/', u'id': 5002, u'secondary_rack': None, u'name': u'untagged'}, 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'id': 21, u'mode': u'link_up'}], u'tags': [u'sriov'], u'effective_mtu': 1500, u'enabled': True, u'parents': [], 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'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'hdkn4c', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/', u'id': 5002, u'secondary_rack': None, u'name': u'untagged'}, 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.40'}], u'params': u'', u'mac_address': u'9c:b6:54:8a:10:1c', u'id': 12, u'system_id': u'arrwft', u'firmware_version': u'bc 7.8.24', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/arrwft/interfaces/12/'}, {u'product': u'ProLiant BL460c Gen8 (735151-B21)', u'vlan': None, u'vendor': u'HP', u'name': u'ens1f1', u'links': [], u'tags': [u'sriov'], u'effective_mtu': 1500, u'enabled': True, u'parents': [], u'discovered': None, u'params': u'', u'mac_address': u'38:ea:a7:8f:07:51', u'id': 13, u'system_id': u'arrwft', u'firmware_version': u'bc 7.8.24', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/arrwft/interfaces/13/'}, {u'product': u'ProLiant BL460c Gen8 (735151-B21)', u'vlan': {u'fabric': u'fabric-0', u'vid': 0, u'space': u'undefined', u'fabric_id': 0, u'dhcp_on': False, u'mtu': 1500, u'primary_rack': None, u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/', u'id': 5001, u'secondary_rack': None, u'name': u'untagged'}, u'vendor': u'HP', u'name': u'ens2f0', u'links': [{u'id': 22, u'mode': u'link_up'}], u'tags': [u'sriov'], u'effective_mtu': 1500, u'enabled': True, u'parents': [], u'discovered': None, u'params': u'', u'mac_address': u'38:ea:a7:8f:12:48', u'id': 14, u'system_id': u'arrwft', u'firmware_version': u'bc 7.8.24', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/arrwft/interfaces/14/'}, {u'product': u'ProLiant BL460c Gen8 (735151-B21)', u'vlan': {u'fabric': u'fabric-0', u'vid': 0, u'space': u'undefined', u'fabric_id': 0, u'dhcp_on': False, u'mtu': 1500, u'primary_rack': None, u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/', u'id': 5001, u'secondary_rack': None, u'name': u'untagged'}, u'vendor': u'HP', u'name': u'ens2f1', u'links': [{u'id': 23, u'mode': u'link_up'}], u'tags': [u'sriov'], u'effective_mtu': 1500, u'enabled': True, u'parents': [], u'discovered': None, u'params': u'', u'mac_address': u'38:ea:a7:8f:12:49', u'id': 15, u'system_id': u'arrwft', u'firmware_version': u'bc 7.8.24', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/arrwft/interfaces/15/'}], u'address_ttl': None, u'memory_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'ssd'], u'type': u'physical', u'id': 1, u'used_for': u'MBR partitioned with 1 partition', u'resource_uri': u'/MAAS/api/2.0/nodes/arrwft/blockdevices/1/', u'system_id': u'arrwft', u'partition_table_type': u'MBR', u'filesystem': None, u'id_path': u'/dev/disk/by-id/wwn-0x600508b1001cb19198eb9a66f8a29401', u'path': u'/dev/disk/by-dname/sda', u'firmware_version': u'5.22', u'size': 800109715456, u'used_size': 800106479616, u'model': u'LOGICAL VOLUME', u'serial': u'600508b1001cb19198eb9a66f8a29401', u'partitions': [{u'uuid': u'fa03dc24-43f1-4d9c-bff4-7c7438d95c93', u'resource_uri': u'/MAAS/api/2.0/nodes/arrwft/blockdevices/1/partition/6', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'arrwft', u'filesystem': {u'mount_options': None, u'label': None, u'mount_point': None, u'uuid': u'7b19564c-b281-4046-af36-b7ab5e77d8b4', u'fstype': u'lvm-pv'}, u'path': u'/dev/disk/by-dname/sda-part1', u'device_id': 1, u'type': u'partition', u'id': 6, u'size': 800101236736}]}}
2020-02-23 07:42:21,435 [salt.state       :300 ][INFO    ][3450] {'new': {'storage_layout': 'lvm'}}
2020-02-23 07:42:21,436 [salt.state       :1951][INFO    ][3450] Completed state [maas_machines_storage_cmp002_lvm] at time 07:42:21.436123 duration_in_ms=2813.829
2020-02-23 07:42:21,437 [salt.state       :1780][INFO    ][3450] Running state [maas_machines_storage_cmp001_lvm] at time 07:42:21.437256
2020-02-23 07:42:21,437 [salt.state       :1813][INFO    ][3450] Executing state maasng.disk_layout_present for [maas_machines_storage_cmp001_lvm]
2020-02-23 07:42:22,750 [salt.loaded.ext.module.maasng:610 ][INFO    ][3450] pm8hsd
2020-02-23 07:42:22,751 [salt.loaded.ext.module.maasng:626 ][INFO    ][3450] sda
2020-02-23 07:42:22,919 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223074222910275
2020-02-23 07:42:22,941 [salt.minion      :1432][INFO    ][3473] Starting a new job with PID 3473
2020-02-23 07:42:22,966 [salt.minion      :1711][INFO    ][3473] Returning information for job: 20200223074222910275
2020-02-23 07:42:23,408 [salt.loaded.ext.module.maasng:361 ][INFO    ][3450] pm8hsd
2020-02-23 07:42:23,499 [salt.loaded.ext.module.maasng:367 ][INFO    ][3450] [{u'resource_uri': u'/MAAS/api/2.0/nodes/pm8hsd/blockdevices/2/', u'uuid': None, u'name': u'sda', u'tags': [u'ssd'], u'type': u'physical', u'partitions': [{u'uuid': u'0a281989-74d7-4211-b2d1-c007930797fb', u'resource_uri': u'/MAAS/api/2.0/nodes/pm8hsd/blockdevices/2/partition/2', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'pm8hsd', u'filesystem': {u'mount_options': None, u'label': None, u'mount_point': None, u'uuid': u'd8a8f2ea-a87e-4798-aa7f-ed0624f5ace6', u'fstype': u'lvm-pv'}, u'path': u'/dev/disk/by-dname/sda-part1', u'size': 800101236736, u'type': u'partition', u'id': 2, u'device_id': 2}], u'used_for': u'MBR partitioned with 1 partition', u'path': u'/dev/disk/by-dname/sda', u'system_id': u'pm8hsd', u'partition_table_type': u'MBR', u'filesystem': None, u'id_path': u'/dev/disk/by-id/wwn-0x600508b1001cd7e61f5cd3479576479e', u'available_size': 0, u'model': u'LOGICAL VOLUME', u'block_size': 4096, u'used_size': 800106479616, u'id': 2, u'serial': u'600508b1001cd7e61f5cd3479576479e', u'size': 800109715456}, {u'resource_uri': u'/MAAS/api/2.0/nodes/pm8hsd/blockdevices/4/', u'uuid': u'614f2c4d-d379-4d73-bfee-a405c3fe94a8', u'name': u'vgroot-lvroot', u'tags': [], u'type': u'virtual', u'partitions': [], u'used_for': u'ext4 formatted filesystem mounted at /', u'path': u'/dev/disk/by-dname/lvroot', u'system_id': u'pm8hsd', u'partition_table_type': None, u'filesystem': {u'mount_options': None, u'label': u'root', u'mount_point': u'/', u'uuid': u'0e7c62ad-9ced-4fe7-ad06-c0e5316c318e', u'fstype': u'ext4'}, u'id_path': None, u'available_size': 0, u'model': None, u'block_size': 4096, u'used_size': 800097042432, u'id': 4, u'serial': None, u'size': 800097042432}]
2020-02-23 07:42:23,500 [salt.loaded.ext.module.maasng:632 ][INFO    ][3450] vgroot
2020-02-23 07:42:23,500 [salt.loaded.ext.module.maasng:635 ][INFO    ][3450] lvroot
2020-02-23 07:42:23,501 [salt.loaded.ext.module.maasng:639 ][INFO    ][3450] 107374182400
2020-02-23 07:42:24,139 [salt.loaded.ext.module.maasng:645 ][INFO    ][3450] {u'hwe_kernel': None, u'testing_status_name': u'Passed', u'disable_ipv4': False, u'cpu_count': 40, u'power_type': u'ipmi', u'domain': {u'resource_record_count': 0, u'name': u'maas', u'authoritative': True, u'is_default': True, u'ttl': None, u'id': 0, u'resource_uri': u'/MAAS/api/2.0/domains/0/'}, u'boot_interface': {u'product': u'ProLiant BL460c Gen8 (735151-B21)', u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'hdkn4c', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/', u'id': 5002, u'secondary_rack': None, u'name': u'untagged'}, u'vendor': u'HP', u'name': u'eno1', 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'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'hdkn4c', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/', u'id': 5002, u'secondary_rack': None, u'name': u'untagged'}, 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.39', u'id': 29, u'mode': u'dhcp'}], u'tags': [u'sriov'], u'mac_address': u'9c:b6:54:8a:95:a0', u'enabled': True, u'parents': [], 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'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'hdkn4c', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/', u'id': 5002, u'secondary_rack': None, u'name': u'untagged'}, 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.39'}], u'system_id': u'pm8hsd', u'effective_mtu': 1500, u'id': 5, u'params': u'', u'firmware_version': u'bc 7.8.24', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/pm8hsd/interfaces/5/'}, u'fqdn': u'cmp001.maas', u'status_action': u'', u'tag_names': [], u'swap_size': None, u'cpu_speed': 2800, u'owner': None, u'pod': None, u'cache_sets': [], u'cpu_test_status_name': u'Unknown', u'iscsiblockdevice_set': [], u'boot_disk': {u'model': u'LOGICAL VOLUME', u'resource_uri': u'/MAAS/api/2.0/nodes/pm8hsd/blockdevices/2/', u'available_size': 0, u'uuid': None, u'name': u'sda', u'tags': [u'ssd'], u'type': u'physical', u'partitions': [{u'uuid': u'9e84e7f6-e5a4-4b27-af0b-838934d1df09', u'resource_uri': u'/MAAS/api/2.0/nodes/pm8hsd/blockdevices/2/partition/7', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'pm8hsd', u'filesystem': {u'mount_options': None, u'label': None, u'mount_point': None, u'uuid': u'62b65eff-bdf0-42ad-afc4-526f37cd2767', u'fstype': u'lvm-pv'}, u'path': u'/dev/disk/by-dname/sda-part1', u'size': 800101236736, u'type': u'partition', u'id': 7, u'device_id': 2}], u'id': 2, u'used_for': u'MBR partitioned with 1 partition', u'system_id': u'pm8hsd', u'partition_table_type': u'MBR', u'filesystem': None, u'id_path': u'/dev/disk/by-id/wwn-0x600508b1001cd7e61f5cd3479576479e', u'path': u'/dev/disk/by-dname/sda', u'firmware_version': u'5.22', u'block_size': 4096, u'used_size': 800106479616, u'serial': u'600508b1001cd7e61f5cd3479576479e', u'size': 800109715456}, u'zone': {u'id': 1, u'resource_uri': u'/MAAS/api/2.0/zones/default/', u'name': u'default', u'description': u''}, u'resource_uri': u'/MAAS/api/2.0/machines/pm8hsd/', u'hardware_info': {u'mainboard_firmware_version': u'I31', u'mainboard_product': u'Unknown', u'system_vendor': u'HP', u'cpu_model': u'Intel(R) Xeon(R) CPU E5-2680 v2', u'mainboard_firmware_date': u'06/01/2015', u'mainboard_vendor': u'Unknown', u'system_serial': u'USE410T2XY', u'system_version': u'Unknown', u'system_product': u'ProLiant BL460c Gen8 (735151-B21)'}, u'hostname': u'cmp001', u'storage': 800109.715456, u'testing_status': 2, u'system_id': u'pm8hsd', u'raids': [], u'memory': 65536, u'current_installation_result_id': None, u'default_gateways': {u'ipv4': {u'gateway_ip': u'192.168.11.3', u'link_id': None}, u'ipv6': {u'gateway_ip': None, u'link_id': None}}, u'status_message': u'Power state queried: off', u'ip_addresses': [u'192.168.11.39', u'192.168.11.44'], u'min_hwe_kernel': u'ga-18.04', u'status': 4, u'bcaches': [], u'storage_test_status_name': u'Passed', u'power_state': u'off', u'owner_data': {}, u'other_test_status_name': u'Unknown', u'volume_groups': [{u'__incomplete__': True, u'system_id': u'pm8hsd', u'id': 7}], u'special_filesystems': [], u'current_commissioning_result_id': 4, u'node_type_name': u'Machine', u'current_testing_result_id': 5, u'cpu_test_status': -1, u'pool': {u'id': 0, u'resource_uri': u'/MAAS/api/2.0/resourcepool/0/', u'name': u'default', u'description': u'Default pool'}, u'storage_test_status': 2, u'other_test_status': -1, u'locked': False, u'status_name': u'Ready', u'physicalblockdevice_set': [{u'model': u'LOGICAL VOLUME', u'resource_uri': u'/MAAS/api/2.0/nodes/pm8hsd/blockdevices/2/', u'available_size': 0, u'uuid': None, u'name': u'sda', u'tags': [u'ssd'], u'type': u'physical', u'partitions': [{u'uuid': u'9e84e7f6-e5a4-4b27-af0b-838934d1df09', u'resource_uri': u'/MAAS/api/2.0/nodes/pm8hsd/blockdevices/2/partition/7', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'pm8hsd', u'filesystem': {u'mount_options': None, u'label': None, u'mount_point': None, u'uuid': u'62b65eff-bdf0-42ad-afc4-526f37cd2767', u'fstype': u'lvm-pv'}, u'path': u'/dev/disk/by-dname/sda-part1', u'size': 800101236736, u'type': u'partition', u'id': 7, u'device_id': 2}], u'id': 2, u'used_for': u'MBR partitioned with 1 partition', u'system_id': u'pm8hsd', u'partition_table_type': u'MBR', u'filesystem': None, u'id_path': u'/dev/disk/by-id/wwn-0x600508b1001cd7e61f5cd3479576479e', u'path': u'/dev/disk/by-dname/sda', u'firmware_version': u'5.22', u'block_size': 4096, u'used_size': 800106479616, u'serial': u'600508b1001cd7e61f5cd3479576479e', u'size': 800109715456}], u'netboot': True, u'osystem': u'', u'node_type': 0, u'memory_test_status_name': u'Unknown', u'virtualblockdevice_set': [{u'resource_uri': u'/MAAS/api/2.0/nodes/pm8hsd/blockdevices/12/', u'available_size': 0, u'uuid': u'1b33f18c-957d-40b4-a012-5c659ae7bfab', u'name': u'vgroot-lvroot', u'tags': [], u'type': u'virtual', u'partitions': [], u'id': 12, u'used_for': u'ext4 formatted filesystem mounted at /', u'system_id': u'pm8hsd', u'partition_table_type': None, u'filesystem': {u'mount_options': None, u'label': u'root', u'mount_point': u'/', u'uuid': u'51974f1e-db99-42a7-8c56-339b2095927e', u'fstype': u'ext4'}, u'id_path': None, u'path': u'/dev/disk/by-dname/vgroot-lvroot', u'serial': None, u'block_size': 4096, u'used_size': 107374182400, u'model': None, u'size': 107374182400}], u'commissioning_status': 2, u'architecture': u'amd64/generic', u'commissioning_status_name': u'Passed', u'interface_set': [{u'product': u'ProLiant BL460c Gen8 (735151-B21)', u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'hdkn4c', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/', u'id': 5002, u'secondary_rack': None, u'name': u'untagged'}, u'vendor': u'HP', u'name': u'eno1', 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'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'hdkn4c', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/', u'id': 5002, u'secondary_rack': None, u'name': u'untagged'}, 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.39', u'id': 29, u'mode': u'dhcp'}], u'tags': [u'sriov'], u'mac_address': u'9c:b6:54:8a:95:a0', u'enabled': True, u'parents': [], 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'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'hdkn4c', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/', u'id': 5002, u'secondary_rack': None, u'name': u'untagged'}, 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.39'}], u'system_id': u'pm8hsd', u'effective_mtu': 1500, u'id': 5, u'params': u'', u'firmware_version': u'bc 7.8.24', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/pm8hsd/interfaces/5/'}, {u'product': u'ProLiant BL460c Gen8 (735151-B21)', u'vlan': None, u'vendor': u'HP', u'name': u'ens1f0', u'links': [], u'tags': [u'sriov'], u'mac_address': u'38:ea:a7:8f:1f:d4', u'enabled': True, u'parents': [], u'discovered': None, u'system_id': u'pm8hsd', u'effective_mtu': 1500, u'id': 16, u'params': u'', u'firmware_version': u'bc 7.8.24', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/pm8hsd/interfaces/16/'}, {u'product': u'ProLiant BL460c Gen8 (735151-B21)', u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'hdkn4c', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/', u'id': 5002, u'secondary_rack': None, u'name': u'untagged'}, u'vendor': u'HP', u'name': u'eno2', 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'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'hdkn4c', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/', u'id': 5002, u'secondary_rack': None, u'name': u'untagged'}, 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'id': 30, u'mode': u'link_up'}], u'tags': [u'sriov'], u'mac_address': u'9c:b6:54:8a:95:a4', u'enabled': True, u'parents': [], 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'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'hdkn4c', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/', u'id': 5002, u'secondary_rack': None, u'name': u'untagged'}, 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.44'}], u'system_id': u'pm8hsd', u'effective_mtu': 1500, u'id': 17, u'params': u'', u'firmware_version': u'bc 7.8.24', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/pm8hsd/interfaces/17/'}, {u'product': u'ProLiant BL460c Gen8 (735151-B21)', u'vlan': None, u'vendor': u'HP', u'name': u'ens1f1', u'links': [], u'tags': [u'sriov'], u'mac_address': u'38:ea:a7:8f:1f:d5', u'enabled': True, u'parents': [], u'discovered': None, u'system_id': u'pm8hsd', u'effective_mtu': 1500, u'id': 18, u'params': u'', u'firmware_version': u'bc 7.8.24', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/pm8hsd/interfaces/18/'}, {u'product': u'ProLiant BL460c Gen8 (735151-B21)', u'vlan': {u'fabric': u'fabric-0', u'vid': 0, u'space': u'undefined', u'fabric_id': 0, u'dhcp_on': False, u'mtu': 1500, u'primary_rack': None, u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/', u'id': 5001, u'secondary_rack': None, u'name': u'untagged'}, u'vendor': u'HP', u'name': u'ens2f0', u'links': [{u'id': 31, u'mode': u'link_up'}], u'tags': [u'sriov'], u'mac_address': u'38:ea:a7:8f:52:cc', u'enabled': True, u'parents': [], u'discovered': None, u'system_id': u'pm8hsd', u'effective_mtu': 1500, u'id': 19, u'params': u'', u'firmware_version': u'bc 7.8.24', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/pm8hsd/interfaces/19/'}, {u'product': u'ProLiant BL460c Gen8 (735151-B21)', u'vlan': {u'fabric': u'fabric-0', u'vid': 0, u'space': u'undefined', u'fabric_id': 0, u'dhcp_on': False, u'mtu': 1500, u'primary_rack': None, u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/', u'id': 5001, u'secondary_rack': None, u'name': u'untagged'}, u'vendor': u'HP', u'name': u'ens2f1', u'links': [{u'id': 32, u'mode': u'link_up'}], u'tags': [u'sriov'], u'mac_address': u'38:ea:a7:8f:52:cd', u'enabled': True, u'parents': [], u'discovered': None, u'system_id': u'pm8hsd', u'effective_mtu': 1500, u'id': 20, u'params': u'', u'firmware_version': u'bc 7.8.24', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/pm8hsd/interfaces/20/'}], u'address_ttl': None, u'blockdevice_set': [{u'resource_uri': u'/MAAS/api/2.0/nodes/pm8hsd/blockdevices/2/', u'available_size': 0, u'uuid': None, u'name': u'sda', u'tags': [u'ssd'], u'type': u'physical', u'partitions': [{u'uuid': u'9e84e7f6-e5a4-4b27-af0b-838934d1df09', u'resource_uri': u'/MAAS/api/2.0/nodes/pm8hsd/blockdevices/2/partition/7', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'pm8hsd', u'filesystem': {u'mount_options': None, u'label': None, u'mount_point': None, u'uuid': u'62b65eff-bdf0-42ad-afc4-526f37cd2767', u'fstype': u'lvm-pv'}, u'path': u'/dev/disk/by-dname/sda-part1', u'size': 800101236736, u'type': u'partition', u'id': 7, u'device_id': 2}], u'id': 2, u'used_for': u'MBR partitioned with 1 partition', u'system_id': u'pm8hsd', u'partition_table_type': u'MBR', u'filesystem': None, u'id_path': u'/dev/disk/by-id/wwn-0x600508b1001cd7e61f5cd3479576479e', u'path': u'/dev/disk/by-dname/sda', u'serial': u'600508b1001cd7e61f5cd3479576479e', u'block_size': 4096, u'used_size': 800106479616, u'model': u'LOGICAL VOLUME', u'size': 800109715456}, {u'resource_uri': u'/MAAS/api/2.0/nodes/pm8hsd/blockdevices/12/', u'available_size': 0, u'uuid': u'1b33f18c-957d-40b4-a012-5c659ae7bfab', u'name': u'vgroot-lvroot', u'tags': [], u'type': u'virtual', u'partitions': [], u'id': 12, u'used_for': u'ext4 formatted filesystem mounted at /', u'system_id': u'pm8hsd', u'partition_table_type': None, u'filesystem': {u'mount_options': None, u'label': u'root', u'mount_point': u'/', u'uuid': u'51974f1e-db99-42a7-8c56-339b2095927e', u'fstype': u'ext4'}, u'id_path': None, u'path': u'/dev/disk/by-dname/lvroot', u'serial': None, u'block_size': 4096, u'used_size': 107374182400, u'model': None, u'size': 107374182400}], u'distro_series': u'', u'memory_test_status': -1}
2020-02-23 07:42:24,142 [salt.state       :300 ][INFO    ][3450] {'new': {'storage_layout': 'lvm'}}
2020-02-23 07:42:24,143 [salt.state       :1951][INFO    ][3450] Completed state [maas_machines_storage_cmp001_lvm] at time 07:42:24.143295 duration_in_ms=2706.037
2020-02-23 07:42:24,149 [salt.minion      :1711][INFO    ][3450] Returning information for job: 20200223074207882645
2020-02-23 07:42:25,121 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command state.apply with jid 20200223074225100487
2020-02-23 07:42:25,149 [salt.minion      :1432][INFO    ][3480] Starting a new job with PID 3480
2020-02-23 07:42:26,363 [salt.state       :915 ][INFO    ][3480] Loading fresh modules for state activity
2020-02-23 07:42:26,429 [salt.fileclient  :1219][INFO    ][3480] Fetching file from saltenv 'base', ** done ** 'maas/machines/deploy.sls'
2020-02-23 07:42:26,492 [salt.state       :1780][INFO    ][3480] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 07:42:26.492512
2020-02-23 07:42:26,492 [salt.state       :1813][INFO    ][3480] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2020-02-23 07:42:26,494 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3480] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2020-02-23 07:42:28,793 [salt.state       :300 ][INFO    ][3480] {'pid': 3487, 'retcode': 0, 'stderr': '', 'stdout': ''}
2020-02-23 07:42:28,794 [salt.state       :1951][INFO    ][3480] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 07:42:28.794504 duration_in_ms=2301.994
2020-02-23 07:42:28,798 [salt.state       :1780][INFO    ][3480] Running state [maas.deploy_machines] at time 07:42:28.798038
2020-02-23 07:42:28,798 [salt.state       :1813][INFO    ][3480] Executing state module.run for [maas.deploy_machines]
2020-02-23 07:42:28,799 [salt.utils.decorators:613 ][WARNING ][3480] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-02-23 07:42:29,682 [salt.loaded.ext.module.maas:684 ][INFO    ][3480] deploymachines hwe_kernel=ga-18.04 system_id=arrwft distro_series=bionic
2020-02-23 07:42:31,775 [salt.loaded.ext.module.maas:684 ][INFO    ][3480] deploymachines hwe_kernel=ga-18.04 system_id=pm8hsd distro_series=bionic
2020-02-23 07:42:33,693 [salt.loaded.ext.module.maas:684 ][INFO    ][3480] deploymachines hwe_kernel=ga-18.04 system_id=etecgh distro_series=bionic
2020-02-23 07:42:35,493 [salt.loaded.ext.module.maas:684 ][INFO    ][3480] deploymachines hwe_kernel=ga-18.04 system_id=whwmah distro_series=bionic
2020-02-23 07:42:37,602 [salt.loaded.ext.module.maas:684 ][INFO    ][3480] deploymachines hwe_kernel=ga-18.04 system_id=hnx7aa distro_series=bionic
2020-02-23 07:42:39,603 [salt.state       :300 ][INFO    ][3480] {'ret': {'updated': [], 'errors': {}, 'success': ['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']}}
2020-02-23 07:42:39,603 [salt.state       :1951][INFO    ][3480] Completed state [maas.deploy_machines] at time 07:42:39.603677 duration_in_ms=10805.64
2020-02-23 07:42:39,609 [salt.minion      :1711][INFO    ][3480] Returning information for job: 20200223074225100487
2020-02-23 07:42:40,593 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command state.apply with jid 20200223074240580816
2020-02-23 07:42:40,615 [salt.minion      :1432][INFO    ][3539] Starting a new job with PID 3539
2020-02-23 07:42:48,519 [salt.state       :915 ][INFO    ][3539] Loading fresh modules for state activity
2020-02-23 07:42:48,586 [salt.fileclient  :1219][INFO    ][3539] Fetching file from saltenv 'base', ** done ** 'maas/machines/wait_for_deployed.sls'
2020-02-23 07:42:48,643 [salt.state       :1780][INFO    ][3539] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 07:42:48.643424
2020-02-23 07:42:48,643 [salt.state       :1813][INFO    ][3539] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2020-02-23 07:42:48,646 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3539] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2020-02-23 07:42:50,977 [salt.state       :300 ][INFO    ][3539] {'pid': 3550, 'retcode': 0, 'stderr': '', 'stdout': ''}
2020-02-23 07:42:50,978 [salt.state       :1951][INFO    ][3539] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 07:42:50.978257 duration_in_ms=2334.834
2020-02-23 07:42:50,981 [salt.state       :1780][INFO    ][3539] Running state [maas.wait_for_machine_status] at time 07:42:50.981670
2020-02-23 07:42:50,982 [salt.state       :1813][INFO    ][3539] Executing state module.run for [maas.wait_for_machine_status]
2020-02-23 07:42:50,983 [salt.utils.decorators:613 ][WARNING ][3539] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-02-23 07:42:54,322 [salt.loaded.ext.module.maas:1024][INFO    ][3539] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2246.67658782s left)
2020-02-23 07:42:55,725 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223074255710570
2020-02-23 07:42:55,750 [salt.minion      :1432][INFO    ][3565] Starting a new job with PID 3565
2020-02-23 07:42:55,781 [salt.minion      :1711][INFO    ][3565] Returning information for job: 20200223074255710570
2020-02-23 07:43:25,807 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223074325797900
2020-02-23 07:43:25,830 [salt.minion      :1432][INFO    ][3597] Starting a new job with PID 3597
2020-02-23 07:43:25,856 [salt.minion      :1711][INFO    ][3597] Returning information for job: 20200223074325797900
2020-02-23 07:43:27,708 [salt.loaded.ext.module.maas:1024][INFO    ][3539] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2213.29101396s left)
2020-02-23 07:43:55,869 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223074355856595
2020-02-23 07:43:55,895 [salt.minion      :1432][INFO    ][3634] Starting a new job with PID 3634
2020-02-23 07:43:55,923 [salt.minion      :1711][INFO    ][3634] Returning information for job: 20200223074355856595
2020-02-23 07:44:01,299 [salt.loaded.ext.module.maas:1024][INFO    ][3539] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2179.69952989s left)
2020-02-23 07:44:25,930 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223074425922479
2020-02-23 07:44:25,949 [salt.minion      :1432][INFO    ][3663] Starting a new job with PID 3663
2020-02-23 07:44:25,976 [salt.minion      :1711][INFO    ][3663] Returning information for job: 20200223074425922479
2020-02-23 07:44:34,847 [salt.loaded.ext.module.maas:1024][INFO    ][3539] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2146.15167284s left)
2020-02-23 07:44:55,987 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223074455973005
2020-02-23 07:44:56,013 [salt.minion      :1432][INFO    ][3693] Starting a new job with PID 3693
2020-02-23 07:44:56,039 [salt.minion      :1711][INFO    ][3693] Returning information for job: 20200223074455973005
2020-02-23 07:45:08,375 [salt.loaded.ext.module.maas:1024][INFO    ][3539] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2112.62321281s left)
2020-02-23 07:45:26,034 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223074526020462
2020-02-23 07:45:26,061 [salt.minion      :1432][INFO    ][3728] Starting a new job with PID 3728
2020-02-23 07:45:26,089 [salt.minion      :1711][INFO    ][3728] Returning information for job: 20200223074526020462
2020-02-23 07:45:41,765 [salt.loaded.ext.module.maas:1024][INFO    ][3539] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2079.23319602s left)
2020-02-23 07:45:56,135 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223074556126096
2020-02-23 07:45:56,163 [salt.minion      :1432][INFO    ][3783] Starting a new job with PID 3783
2020-02-23 07:45:56,191 [salt.minion      :1711][INFO    ][3783] Returning information for job: 20200223074556126096
2020-02-23 07:46:12,490 [salt.loaded.ext.module.maas:993 ][INFO    ][3539] Machine arrwft mark broken
2020-02-23 07:46:26,250 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223074626230860
2020-02-23 07:46:26,278 [salt.minion      :1432][INFO    ][3836] Starting a new job with PID 3836
2020-02-23 07:46:26,306 [salt.minion      :1711][INFO    ][3836] Returning information for job: 20200223074626230860
2020-02-23 07:46:43,136 [salt.loaded.ext.module.maas:997 ][INFO    ][3539] Machine arrwft mark fixed
2020-02-23 07:46:44,367 [salt.loaded.ext.module.maas:684 ][INFO    ][3539] deploymachines hwe_kernel=ga-18.04 system_id=arrwft distro_series=bionic
2020-02-23 07:46:47,098 [salt.loaded.ext.module.maas:993 ][INFO    ][3539] Machine pm8hsd mark broken
2020-02-23 07:46:56,339 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223074656329363
2020-02-23 07:46:56,360 [salt.minion      :1432][INFO    ][3903] Starting a new job with PID 3903
2020-02-23 07:46:56,389 [salt.minion      :1711][INFO    ][3903] Returning information for job: 20200223074656329363
2020-02-23 07:47:17,706 [salt.loaded.ext.module.maas:997 ][INFO    ][3539] Machine pm8hsd mark fixed
2020-02-23 07:47:18,727 [salt.loaded.ext.module.maas:684 ][INFO    ][3539] deploymachines hwe_kernel=ga-18.04 system_id=pm8hsd distro_series=bionic
2020-02-23 07:47:22,444 [salt.loaded.ext.module.maas:1024][INFO    ][3539] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1978.55498886s left)
2020-02-23 07:47:26,421 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223074726410461
2020-02-23 07:47:26,447 [salt.minion      :1432][INFO    ][3953] Starting a new job with PID 3953
2020-02-23 07:47:26,474 [salt.minion      :1711][INFO    ][3953] Returning information for job: 20200223074726410461
2020-02-23 07:47:56,165 [salt.loaded.ext.module.maas:1024][INFO    ][3539] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1944.83409882s left)
2020-02-23 07:47:56,550 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223074756541659
2020-02-23 07:47:56,573 [salt.minion      :1432][INFO    ][4043] Starting a new job with PID 4043
2020-02-23 07:47:56,601 [salt.minion      :1711][INFO    ][4043] Returning information for job: 20200223074756541659
2020-02-23 07:48:26,674 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223074826660160
2020-02-23 07:48:26,694 [salt.minion      :1432][INFO    ][4072] Starting a new job with PID 4072
2020-02-23 07:48:26,722 [salt.minion      :1711][INFO    ][4072] Returning information for job: 20200223074826660160
2020-02-23 07:48:29,649 [salt.loaded.ext.module.maas:1024][INFO    ][3539] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1911.35009599s left)
2020-02-23 07:48:56,794 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223074856776805
2020-02-23 07:48:56,819 [salt.minion      :1432][INFO    ][4103] Starting a new job with PID 4103
2020-02-23 07:48:56,847 [salt.minion      :1711][INFO    ][4103] Returning information for job: 20200223074856776805
2020-02-23 07:49:02,883 [salt.loaded.ext.module.maas:1024][INFO    ][3539] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1878.11532283s left)
2020-02-23 07:49:26,883 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223074926870641
2020-02-23 07:49:26,903 [salt.minion      :1432][INFO    ][4141] Starting a new job with PID 4141
2020-02-23 07:49:26,935 [salt.minion      :1711][INFO    ][4141] Returning information for job: 20200223074926870641
2020-02-23 07:49:36,326 [salt.loaded.ext.module.maas:1024][INFO    ][3539] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1844.67284298s left)
2020-02-23 07:49:56,991 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223074956977745
2020-02-23 07:49:57,018 [salt.minion      :1432][INFO    ][4178] Starting a new job with PID 4178
2020-02-23 07:49:57,040 [salt.minion      :1711][INFO    ][4178] Returning information for job: 20200223074956977745
2020-02-23 07:50:09,882 [salt.loaded.ext.module.maas:1024][INFO    ][3539] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1811.11634398s left)
2020-02-23 07:50:27,131 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223075027114969
2020-02-23 07:50:27,154 [salt.minion      :1432][INFO    ][4233] Starting a new job with PID 4233
2020-02-23 07:50:27,179 [salt.minion      :1711][INFO    ][4233] Returning information for job: 20200223075027114969
2020-02-23 07:50:40,570 [salt.loaded.ext.module.maas:993 ][INFO    ][3539] Machine arrwft mark broken
2020-02-23 07:50:57,268 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223075057254782
2020-02-23 07:50:57,294 [salt.minion      :1432][INFO    ][4283] Starting a new job with PID 4283
2020-02-23 07:50:57,319 [salt.minion      :1711][INFO    ][4283] Returning information for job: 20200223075057254782
2020-02-23 07:51:11,243 [salt.loaded.ext.module.maas:997 ][INFO    ][3539] Machine arrwft mark fixed
2020-02-23 07:51:11,705 [salt.loaded.ext.module.maas:1001][INFO    ][3539] Machine arrwft fio test
2020-02-23 07:51:15,593 [salt.loaded.ext.module.maas:1024][INFO    ][3539] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1745.40557694s left)
2020-02-23 07:51:27,398 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223075127385644
2020-02-23 07:51:27,423 [salt.minion      :1432][INFO    ][4320] Starting a new job with PID 4320
2020-02-23 07:51:27,447 [salt.minion      :1711][INFO    ][4320] Returning information for job: 20200223075127385644
2020-02-23 07:51:48,842 [salt.loaded.ext.module.maas:1024][INFO    ][3539] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1712.15669298s left)
2020-02-23 07:51:57,558 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223075157543419
2020-02-23 07:51:57,585 [salt.minion      :1432][INFO    ][4368] Starting a new job with PID 4368
2020-02-23 07:51:57,615 [salt.minion      :1711][INFO    ][4368] Returning information for job: 20200223075157543419
2020-02-23 07:52:20,166 [salt.loaded.ext.module.maas:993 ][INFO    ][3539] Machine pm8hsd mark broken
2020-02-23 07:52:27,714 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223075227702930
2020-02-23 07:52:27,741 [salt.minion      :1432][INFO    ][4401] Starting a new job with PID 4401
2020-02-23 07:52:27,767 [salt.minion      :1711][INFO    ][4401] Returning information for job: 20200223075227702930
2020-02-23 07:52:50,808 [salt.loaded.ext.module.maas:997 ][INFO    ][3539] Machine pm8hsd mark fixed
2020-02-23 07:52:51,304 [salt.loaded.ext.module.maas:1001][INFO    ][3539] Machine pm8hsd fio test
2020-02-23 07:52:54,366 [salt.loaded.ext.module.maas:1024][INFO    ][3539] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1646.63298893s left)
2020-02-23 07:52:57,869 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223075257857444
2020-02-23 07:52:57,895 [salt.minion      :1432][INFO    ][4438] Starting a new job with PID 4438
2020-02-23 07:52:57,920 [salt.minion      :1711][INFO    ][4438] Returning information for job: 20200223075257857444
2020-02-23 07:53:27,283 [salt.loaded.ext.module.maas:1024][INFO    ][3539] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1613.71584392s left)
2020-02-23 07:53:28,028 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223075328019718
2020-02-23 07:53:28,059 [salt.minion      :1432][INFO    ][4476] Starting a new job with PID 4476
2020-02-23 07:53:28,085 [salt.minion      :1711][INFO    ][4476] Returning information for job: 20200223075328019718
2020-02-23 07:53:58,162 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223075358154121
2020-02-23 07:53:58,181 [salt.minion      :1432][INFO    ][4522] Starting a new job with PID 4522
2020-02-23 07:53:58,206 [salt.minion      :1711][INFO    ][4522] Returning information for job: 20200223075358154121
2020-02-23 07:54:00,179 [salt.loaded.ext.module.maas:1024][INFO    ][3539] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1580.82019091s left)
2020-02-23 07:54:28,353 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223075428337695
2020-02-23 07:54:28,377 [salt.minion      :1432][INFO    ][4560] Starting a new job with PID 4560
2020-02-23 07:54:28,398 [salt.minion      :1711][INFO    ][4560] Returning information for job: 20200223075428337695
2020-02-23 07:54:33,199 [salt.loaded.ext.module.maas:1024][INFO    ][3539] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1547.79980493s left)
2020-02-23 07:54:58,526 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223075458508951
2020-02-23 07:54:58,558 [salt.minion      :1432][INFO    ][4589] Starting a new job with PID 4589
2020-02-23 07:54:58,586 [salt.minion      :1711][INFO    ][4589] Returning information for job: 20200223075458508951
2020-02-23 07:55:06,328 [salt.loaded.ext.module.maas:1024][INFO    ][3539] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1514.67115498s left)
2020-02-23 07:55:28,713 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223075528701907
2020-02-23 07:55:28,733 [salt.minion      :1432][INFO    ][4621] Starting a new job with PID 4621
2020-02-23 07:55:28,758 [salt.minion      :1711][INFO    ][4621] Returning information for job: 20200223075528701907
2020-02-23 07:55:39,268 [salt.loaded.ext.module.maas:1024][INFO    ][3539] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1481.73031998s left)
2020-02-23 07:55:58,889 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223075558880100
2020-02-23 07:55:58,905 [salt.minion      :1432][INFO    ][4665] Starting a new job with PID 4665
2020-02-23 07:55:58,937 [salt.minion      :1711][INFO    ][4665] Returning information for job: 20200223075558880100
2020-02-23 07:56:12,411 [salt.loaded.ext.module.maas:1024][INFO    ][3539] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1448.58761501s left)
2020-02-23 07:56:28,903 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223075628895774
2020-02-23 07:56:28,920 [salt.minion      :1432][INFO    ][4747] Starting a new job with PID 4747
2020-02-23 07:56:28,949 [salt.minion      :1711][INFO    ][4747] Returning information for job: 20200223075628895774
2020-02-23 07:56:45,747 [salt.loaded.ext.module.maas:1024][INFO    ][3539] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (1415.25120687s left)
2020-02-23 07:56:58,989 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223075658980159
2020-02-23 07:56:59,014 [salt.minion      :1432][INFO    ][4788] Starting a new job with PID 4788
2020-02-23 07:56:59,060 [salt.minion      :1711][INFO    ][4788] Returning information for job: 20200223075658980159
2020-02-23 07:57:18,821 [salt.loaded.ext.module.maas:1024][INFO    ][3539] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (1382.17728591s left)
2020-02-23 07:57:29,217 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223075729202828
2020-02-23 07:57:29,247 [salt.minion      :1432][INFO    ][4820] Starting a new job with PID 4820
2020-02-23 07:57:29,272 [salt.minion      :1711][INFO    ][4820] Returning information for job: 20200223075729202828
2020-02-23 07:57:52,126 [salt.loaded.ext.module.maas:1024][INFO    ][3539] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (1348.87284493s left)
2020-02-23 07:57:59,427 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223075759410364
2020-02-23 07:57:59,452 [salt.minion      :1432][INFO    ][4856] Starting a new job with PID 4856
2020-02-23 07:57:59,476 [salt.minion      :1711][INFO    ][4856] Returning information for job: 20200223075759410364
2020-02-23 07:58:25,631 [salt.loaded.ext.module.maas:1024][INFO    ][3539] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (1315.36778283s left)
2020-02-23 07:58:29,445 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223075829435155
2020-02-23 07:58:29,466 [salt.minion      :1432][INFO    ][4905] Starting a new job with PID 4905
2020-02-23 07:58:29,489 [salt.minion      :1711][INFO    ][4905] Returning information for job: 20200223075829435155
2020-02-23 07:58:59,153 [salt.loaded.ext.module.maas:1024][INFO    ][3539] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (1281.84552598s left)
2020-02-23 07:58:59,459 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223075859451254
2020-02-23 07:58:59,478 [salt.minion      :1432][INFO    ][4933] Starting a new job with PID 4933
2020-02-23 07:58:59,505 [salt.minion      :1711][INFO    ][4933] Returning information for job: 20200223075859451254
2020-02-23 07:59:29,482 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223075929474266
2020-02-23 07:59:29,502 [salt.minion      :1432][INFO    ][4961] Starting a new job with PID 4961
2020-02-23 07:59:29,527 [salt.minion      :1711][INFO    ][4961] Returning information for job: 20200223075929474266
2020-02-23 07:59:32,656 [salt.loaded.ext.module.maas:1024][INFO    ][3539] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (1248.343153s left)
2020-02-23 07:59:59,510 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223075959498003
2020-02-23 07:59:59,528 [salt.minion      :1432][INFO    ][4988] Starting a new job with PID 4988
2020-02-23 07:59:59,554 [salt.minion      :1711][INFO    ][4988] Returning information for job: 20200223075959498003
2020-02-23 08:00:06,101 [salt.loaded.ext.module.maas:1024][INFO    ][3539] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (1214.89724898s left)
2020-02-23 08:00:29,524 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223080029513224
2020-02-23 08:00:29,543 [salt.minion      :1432][INFO    ][5015] Starting a new job with PID 5015
2020-02-23 08:00:29,573 [salt.minion      :1711][INFO    ][5015] Returning information for job: 20200223080029513224
2020-02-23 08:00:39,503 [salt.loaded.ext.module.maas:1024][INFO    ][3539] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (1181.49603081s left)
2020-02-23 08:00:59,561 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223080059547962
2020-02-23 08:00:59,585 [salt.minion      :1432][INFO    ][5044] Starting a new job with PID 5044
2020-02-23 08:00:59,615 [salt.minion      :1711][INFO    ][5044] Returning information for job: 20200223080059547962
2020-02-23 08:01:12,839 [salt.loaded.ext.module.maas:1024][INFO    ][3539] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (1148.15941691s left)
2020-02-23 08:01:29,644 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223080129633693
2020-02-23 08:01:29,668 [salt.minion      :1432][INFO    ][5075] Starting a new job with PID 5075
2020-02-23 08:01:29,697 [salt.minion      :1711][INFO    ][5075] Returning information for job: 20200223080129633693
2020-02-23 08:01:46,335 [salt.loaded.ext.module.maas:1024][INFO    ][3539] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (1114.6638608s left)
2020-02-23 08:01:59,730 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223080159719656
2020-02-23 08:01:59,752 [salt.minion      :1432][INFO    ][5102] Starting a new job with PID 5102
2020-02-23 08:01:59,776 [salt.minion      :1711][INFO    ][5102] Returning information for job: 20200223080159719656
2020-02-23 08:02:19,700 [salt.loaded.ext.module.maas:1024][INFO    ][3539] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (1081.29881787s left)
2020-02-23 08:02:29,826 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223080229814727
2020-02-23 08:02:29,847 [salt.minion      :1432][INFO    ][5134] Starting a new job with PID 5134
2020-02-23 08:02:29,873 [salt.minion      :1711][INFO    ][5134] Returning information for job: 20200223080229814727
2020-02-23 08:02:53,043 [salt.loaded.ext.module.maas:1024][INFO    ][3539] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (1047.95581889s left)
2020-02-23 08:02:59,938 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223080259926650
2020-02-23 08:02:59,962 [salt.minion      :1432][INFO    ][5154] Starting a new job with PID 5154
2020-02-23 08:02:59,991 [salt.minion      :1711][INFO    ][5154] Returning information for job: 20200223080259926650
2020-02-23 08:03:26,561 [salt.loaded.ext.module.maas:1024][INFO    ][3539] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (1014.43816996s left)
2020-02-23 08:03:30,039 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223080330029007
2020-02-23 08:03:30,056 [salt.minion      :1432][INFO    ][5194] Starting a new job with PID 5194
2020-02-23 08:03:30,082 [salt.minion      :1711][INFO    ][5194] Returning information for job: 20200223080330029007
2020-02-23 08:04:00,014 [salt.loaded.ext.module.maas:1024][INFO    ][3539] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (980.984803915s left)
2020-02-23 08:04:00,183 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223080400173653
2020-02-23 08:04:00,198 [salt.minion      :1432][INFO    ][5225] Starting a new job with PID 5225
2020-02-23 08:04:00,226 [salt.minion      :1711][INFO    ][5225] Returning information for job: 20200223080400173653
2020-02-23 08:04:30,309 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223080430297503
2020-02-23 08:04:30,323 [salt.minion      :1432][INFO    ][5261] Starting a new job with PID 5261
2020-02-23 08:04:30,350 [salt.minion      :1711][INFO    ][5261] Returning information for job: 20200223080430297503
2020-02-23 08:04:33,261 [salt.loaded.ext.module.maas:1024][INFO    ][3539] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (947.737330914s left)
2020-02-23 08:05:00,447 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223080500437666
2020-02-23 08:05:00,462 [salt.minion      :1432][INFO    ][5280] Starting a new job with PID 5280
2020-02-23 08:05:00,485 [salt.minion      :1711][INFO    ][5280] Returning information for job: 20200223080500437666
2020-02-23 08:05:06,507 [salt.loaded.ext.module.maas:1024][INFO    ][3539] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (914.491643906s left)
2020-02-23 08:05:30,605 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223080530589593
2020-02-23 08:05:30,627 [salt.minion      :1432][INFO    ][5319] Starting a new job with PID 5319
2020-02-23 08:05:30,653 [salt.minion      :1711][INFO    ][5319] Returning information for job: 20200223080530589593
2020-02-23 08:05:39,902 [salt.loaded.ext.module.maas:1024][INFO    ][3539] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (881.096745014s left)
2020-02-23 08:06:00,784 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223080600771097
2020-02-23 08:06:00,808 [salt.minion      :1432][INFO    ][5341] Starting a new job with PID 5341
2020-02-23 08:06:00,835 [salt.minion      :1711][INFO    ][5341] Returning information for job: 20200223080600771097
2020-02-23 08:06:13,121 [salt.loaded.ext.module.maas:1024][INFO    ][3539] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (847.877864838s left)
2020-02-23 08:06:30,967 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223080630958522
2020-02-23 08:06:30,986 [salt.minion      :1432][INFO    ][5381] Starting a new job with PID 5381
2020-02-23 08:06:31,010 [salt.minion      :1711][INFO    ][5381] Returning information for job: 20200223080630958522
2020-02-23 08:06:46,426 [salt.loaded.ext.module.maas:1024][INFO    ][3539] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (814.572206974s left)
2020-02-23 08:07:01,182 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223080701171454
2020-02-23 08:07:01,206 [salt.minion      :1432][INFO    ][5404] Starting a new job with PID 5404
2020-02-23 08:07:01,234 [salt.minion      :1711][INFO    ][5404] Returning information for job: 20200223080701171454
2020-02-23 08:07:19,431 [salt.loaded.ext.module.maas:1024][INFO    ][3539] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (781.567289829s left)
2020-02-23 08:07:31,389 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223080731372098
2020-02-23 08:07:31,417 [salt.minion      :1432][INFO    ][5444] Starting a new job with PID 5444
2020-02-23 08:07:31,449 [salt.minion      :1711][INFO    ][5444] Returning information for job: 20200223080731372098
2020-02-23 08:07:52,633 [salt.loaded.ext.module.maas:1024][INFO    ][3539] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (748.36529398s left)
2020-02-23 08:08:01,421 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223080801407180
2020-02-23 08:08:01,446 [salt.minion      :1432][INFO    ][5466] Starting a new job with PID 5466
2020-02-23 08:08:01,471 [salt.minion      :1711][INFO    ][5466] Returning information for job: 20200223080801407180
2020-02-23 08:08:25,624 [salt.loaded.ext.module.maas:1024][INFO    ][3539] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (715.375003815s left)
2020-02-23 08:08:31,446 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223080831438332
2020-02-23 08:08:31,472 [salt.minion      :1432][INFO    ][5499] Starting a new job with PID 5499
2020-02-23 08:08:31,497 [salt.minion      :1711][INFO    ][5499] Returning information for job: 20200223080831438332
2020-02-23 08:08:59,108 [salt.loaded.ext.module.maas:1024][INFO    ][3539] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (681.890478849s left)
2020-02-23 08:09:01,497 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223080901484854
2020-02-23 08:09:01,526 [salt.minion      :1432][INFO    ][5521] Starting a new job with PID 5521
2020-02-23 08:09:01,551 [salt.minion      :1711][INFO    ][5521] Returning information for job: 20200223080901484854
2020-02-23 08:09:31,582 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223080931571285
2020-02-23 08:09:31,607 [salt.minion      :1432][INFO    ][5554] Starting a new job with PID 5554
2020-02-23 08:09:31,638 [salt.minion      :1711][INFO    ][5554] Returning information for job: 20200223080931571285
2020-02-23 08:09:32,208 [salt.loaded.ext.module.maas:1024][INFO    ][3539] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (648.791165829s left)
2020-02-23 08:10:01,659 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223081001649374
2020-02-23 08:10:01,680 [salt.minion      :1432][INFO    ][5574] Starting a new job with PID 5574
2020-02-23 08:10:01,708 [salt.minion      :1711][INFO    ][5574] Returning information for job: 20200223081001649374
2020-02-23 08:10:05,366 [salt.loaded.ext.module.maas:1024][INFO    ][3539] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (615.633171797s left)
2020-02-23 08:10:31,775 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223081031757454
2020-02-23 08:10:31,794 [salt.minion      :1432][INFO    ][5607] Starting a new job with PID 5607
2020-02-23 08:10:31,819 [salt.minion      :1711][INFO    ][5607] Returning information for job: 20200223081031757454
2020-02-23 08:10:38,426 [salt.loaded.ext.module.maas:1024][INFO    ][3539] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (582.57296896s left)
2020-02-23 08:11:01,886 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223081101868900
2020-02-23 08:11:01,916 [salt.minion      :1432][INFO    ][5629] Starting a new job with PID 5629
2020-02-23 08:11:01,940 [salt.minion      :1711][INFO    ][5629] Returning information for job: 20200223081101868900
2020-02-23 08:11:11,591 [salt.loaded.ext.module.maas:1024][INFO    ][3539] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (549.408077002s left)
2020-02-23 08:11:31,999 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223081131979814
2020-02-23 08:11:32,027 [salt.minion      :1432][INFO    ][5663] Starting a new job with PID 5663
2020-02-23 08:11:32,059 [salt.minion      :1711][INFO    ][5663] Returning information for job: 20200223081131979814
2020-02-23 08:11:44,700 [salt.loaded.ext.module.maas:1024][INFO    ][3539] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (516.299129009s left)
2020-02-23 08:12:02,138 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223081202123621
2020-02-23 08:12:02,163 [salt.minion      :1432][INFO    ][5685] Starting a new job with PID 5685
2020-02-23 08:12:02,191 [salt.minion      :1711][INFO    ][5685] Returning information for job: 20200223081202123621
2020-02-23 08:12:17,983 [salt.loaded.ext.module.maas:1024][INFO    ][3539] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (483.015501976s left)
2020-02-23 08:12:32,301 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223081232288115
2020-02-23 08:12:32,331 [salt.minion      :1432][INFO    ][5721] Starting a new job with PID 5721
2020-02-23 08:12:32,361 [salt.minion      :1711][INFO    ][5721] Returning information for job: 20200223081232288115
2020-02-23 08:12:51,260 [salt.loaded.ext.module.maas:1024][INFO    ][3539] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (449.739206791s left)
2020-02-23 08:13:02,488 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223081302476997
2020-02-23 08:13:02,513 [salt.minion      :1432][INFO    ][5742] Starting a new job with PID 5742
2020-02-23 08:13:02,542 [salt.minion      :1711][INFO    ][5742] Returning information for job: 20200223081302476997
2020-02-23 08:13:24,522 [salt.loaded.ext.module.maas:1024][INFO    ][3539] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (416.476590872s left)
2020-02-23 08:13:32,663 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223081332650749
2020-02-23 08:13:32,692 [salt.minion      :1432][INFO    ][5788] Starting a new job with PID 5788
2020-02-23 08:13:32,720 [salt.minion      :1711][INFO    ][5788] Returning information for job: 20200223081332650749
2020-02-23 08:13:57,688 [salt.loaded.ext.module.maas:1024][INFO    ][3539] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (383.310239792s left)
2020-02-23 08:14:02,695 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223081402684604
2020-02-23 08:14:02,723 [salt.minion      :1432][INFO    ][5818] Starting a new job with PID 5818
2020-02-23 08:14:02,753 [salt.minion      :1711][INFO    ][5818] Returning information for job: 20200223081402684604
2020-02-23 08:14:31,076 [salt.loaded.ext.module.maas:1024][INFO    ][3539] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (349.923223019s left)
2020-02-23 08:14:32,741 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223081432731335
2020-02-23 08:14:32,768 [salt.minion      :1432][INFO    ][5854] Starting a new job with PID 5854
2020-02-23 08:14:32,800 [salt.minion      :1711][INFO    ][5854] Returning information for job: 20200223081432731335
2020-02-23 08:15:02,770 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223081502759180
2020-02-23 08:15:02,792 [salt.minion      :1432][INFO    ][5875] Starting a new job with PID 5875
2020-02-23 08:15:02,817 [salt.minion      :1711][INFO    ][5875] Returning information for job: 20200223081502759180
2020-02-23 08:15:04,329 [salt.loaded.ext.module.maas:1024][INFO    ][3539] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (316.669859886s left)
2020-02-23 08:15:32,826 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223081532816363
2020-02-23 08:15:32,853 [salt.minion      :1432][INFO    ][5908] Starting a new job with PID 5908
2020-02-23 08:15:32,883 [salt.minion      :1711][INFO    ][5908] Returning information for job: 20200223081532816363
2020-02-23 08:15:37,607 [salt.loaded.ext.module.maas:1024][INFO    ][3539] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (283.391590834s left)
2020-02-23 08:16:02,874 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223081602861183
2020-02-23 08:16:02,895 [salt.minion      :1432][INFO    ][5928] Starting a new job with PID 5928
2020-02-23 08:16:02,920 [salt.minion      :1711][INFO    ][5928] Returning information for job: 20200223081602861183
2020-02-23 08:16:10,781 [salt.loaded.ext.module.maas:1024][INFO    ][3539] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (250.21813488s left)
2020-02-23 08:16:32,931 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223081632920587
2020-02-23 08:16:32,959 [salt.minion      :1432][INFO    ][5961] Starting a new job with PID 5961
2020-02-23 08:16:32,985 [salt.minion      :1711][INFO    ][5961] Returning information for job: 20200223081632920587
2020-02-23 08:16:43,814 [salt.loaded.ext.module.maas:1024][INFO    ][3539] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (217.185007811s left)
2020-02-23 08:17:03,058 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223081703051027
2020-02-23 08:17:03,076 [salt.minion      :1432][INFO    ][5984] Starting a new job with PID 5984
2020-02-23 08:17:03,107 [salt.minion      :1711][INFO    ][5984] Returning information for job: 20200223081703051027
2020-02-23 08:17:16,886 [salt.loaded.ext.module.maas:1024][INFO    ][3539] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (184.112457991s left)
2020-02-23 08:17:33,130 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223081733119973
2020-02-23 08:17:33,156 [salt.minion      :1432][INFO    ][6016] Starting a new job with PID 6016
2020-02-23 08:17:33,183 [salt.minion      :1711][INFO    ][6016] Returning information for job: 20200223081733119973
2020-02-23 08:17:50,070 [salt.loaded.ext.module.maas:1024][INFO    ][3539] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (150.928915977s left)
2020-02-23 08:18:03,248 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223081803237435
2020-02-23 08:18:03,269 [salt.minion      :1432][INFO    ][6039] Starting a new job with PID 6039
2020-02-23 08:18:03,299 [salt.minion      :1711][INFO    ][6039] Returning information for job: 20200223081803237435
2020-02-23 08:18:23,331 [salt.loaded.ext.module.maas:1024][INFO    ][3539] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (117.667490005s left)
2020-02-23 08:18:33,345 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223081833334718
2020-02-23 08:18:33,370 [salt.minion      :1432][INFO    ][6073] Starting a new job with PID 6073
2020-02-23 08:18:33,398 [salt.minion      :1711][INFO    ][6073] Returning information for job: 20200223081833334718
2020-02-23 08:18:56,426 [salt.loaded.ext.module.maas:1024][INFO    ][3539] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (84.5727348328s left)
2020-02-23 08:19:03,523 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223081903513307
2020-02-23 08:19:03,546 [salt.minion      :1432][INFO    ][6099] Starting a new job with PID 6099
2020-02-23 08:19:03,574 [salt.minion      :1711][INFO    ][6099] Returning information for job: 20200223081903513307
2020-02-23 08:19:29,579 [salt.loaded.ext.module.maas:1024][INFO    ][3539] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (51.4199588299s left)
2020-02-23 08:19:33,657 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223081933645227
2020-02-23 08:19:33,683 [salt.minion      :1432][INFO    ][6128] Starting a new job with PID 6128
2020-02-23 08:19:33,709 [salt.minion      :1711][INFO    ][6128] Returning information for job: 20200223081933645227
2020-02-23 08:20:02,654 [salt.loaded.ext.module.maas:1024][INFO    ][3539] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (18.3449478149s left)
2020-02-23 08:20:03,842 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223082003830006
2020-02-23 08:20:03,871 [salt.minion      :1432][INFO    ][6154] Starting a new job with PID 6154
2020-02-23 08:20:03,896 [salt.minion      :1711][INFO    ][6154] Returning information for job: 20200223082003830006
2020-02-23 08:20:34,066 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223082034057773
2020-02-23 08:20:34,091 [salt.minion      :1432][INFO    ][6182] Starting a new job with PID 6182
2020-02-23 08:20:34,122 [salt.minion      :1711][INFO    ][6182] Returning information for job: 20200223082034057773
2020-02-23 08:20:35,949 [salt.state       :302 ][ERROR   ][3539] Module function maas.wait_for_machine_status threw an exception. Exception: Machines:['cmp002', 'cmp001']not in Deployed state
2020-02-23 08:20:35,949 [salt.state       :1951][INFO    ][3539] Completed state [maas.wait_for_machine_status] at time 08:20:35.949504 duration_in_ms=2264967.833
2020-02-23 08:20:35,955 [salt.minion      :1711][INFO    ][3539] Returning information for job: 20200223074240580816
2020-02-23 08:20:47,201 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command pillar.get with jid 20200223082047189083
2020-02-23 08:20:47,228 [salt.minion      :1432][INFO    ][6191] Starting a new job with PID 6191
2020-02-23 08:20:47,236 [salt.minion      :1711][INFO    ][6191] Returning information for job: 20200223082047189083
2020-02-23 08:20:48,190 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command service.status with jid 20200223082048181258
2020-02-23 08:20:48,211 [salt.minion      :1432][INFO    ][6196] Starting a new job with PID 6196
2020-02-23 08:20:49,019 [salt.loader.10.20.0.2.int.module.cmdmod:395 ][INFO    ][6196] Executing command ['systemctl', 'status', 'maas-fixup.service', '-n', '0'] in directory '/root'
2020-02-23 08:20:49,062 [salt.loader.10.20.0.2.int.module.cmdmod:395 ][INFO    ][6196] Executing command ['systemctl', 'is-active', 'maas-fixup.service'] in directory '/root'
2020-02-23 08:20:49,085 [salt.minion      :1711][INFO    ][6196] Returning information for job: 20200223082048181258
2020-02-23 08:20:50,039 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command state.apply with jid 20200223082050029838
2020-02-23 08:20:50,063 [salt.minion      :1432][INFO    ][6207] Starting a new job with PID 6207
2020-02-23 08:20:58,427 [salt.state       :915 ][INFO    ][6207] Loading fresh modules for state activity
2020-02-23 08:20:59,079 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6207] Executing command 'salt-minion --version' in directory '/root'
2020-02-23 08:20:59,528 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6207] Executing command 'salt-minion --version' in directory '/root'
2020-02-23 08:21:00,634 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6207] Executing command 'salt-minion --version' in directory '/root'
2020-02-23 08:21:01,028 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6207] Executing command 'salt-minion --version' in directory '/root'
2020-02-23 08:21:03,369 [salt.state       :1780][INFO    ][6207] Running state [salt-minion] at time 08:21:03.369272
2020-02-23 08:21:03,369 [salt.state       :1813][INFO    ][6207] Executing state pkg.installed for [salt-minion]
2020-02-23 08:21:03,370 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6207] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2020-02-23 08:21:03,506 [salt.state       :300 ][INFO    ][6207] All specified packages are already installed
2020-02-23 08:21:03,506 [salt.state       :1951][INFO    ][6207] Completed state [salt-minion] at time 08:21:03.506659 duration_in_ms=137.387
2020-02-23 08:21:03,507 [salt.state       :1780][INFO    ][6207] Running state [salt_minion_dependency_packages] at time 08:21:03.507090
2020-02-23 08:21:03,507 [salt.state       :1813][INFO    ][6207] Executing state pkg.installed for [salt_minion_dependency_packages]
2020-02-23 08:21:03,517 [salt.state       :300 ][INFO    ][6207] All specified packages are already installed
2020-02-23 08:21:03,517 [salt.state       :1951][INFO    ][6207] Completed state [salt_minion_dependency_packages] at time 08:21:03.517714 duration_in_ms=10.624
2020-02-23 08:21:03,521 [salt.state       :1780][INFO    ][6207] Running state [/etc/salt/minion.d/minion.conf] at time 08:21:03.521298
2020-02-23 08:21:03,521 [salt.state       :1813][INFO    ][6207] Executing state file.managed for [/etc/salt/minion.d/minion.conf]
2020-02-23 08:21:03,852 [salt.state       :300 ][INFO    ][6207] File /etc/salt/minion.d/minion.conf is in the correct state
2020-02-23 08:21:03,853 [salt.state       :1951][INFO    ][6207] Completed state [/etc/salt/minion.d/minion.conf] at time 08:21:03.853019 duration_in_ms=331.721
2020-02-23 08:21:03,853 [salt.state       :1780][INFO    ][6207] Running state [python-netaddr] at time 08:21:03.853349
2020-02-23 08:21:03,853 [salt.state       :1813][INFO    ][6207] Executing state pkg.installed for [python-netaddr]
2020-02-23 08:21:03,862 [salt.state       :300 ][INFO    ][6207] All specified packages are already installed
2020-02-23 08:21:03,863 [salt.state       :1951][INFO    ][6207] Completed state [python-netaddr] at time 08:21:03.863066 duration_in_ms=9.717
2020-02-23 08:21:03,866 [salt.state       :1780][INFO    ][6207] Running state [/etc/systemd/system/salt-minion.service.d/50-restarts.conf] at time 08:21:03.866860
2020-02-23 08:21:03,867 [salt.state       :1813][INFO    ][6207] Executing state file.managed for [/etc/systemd/system/salt-minion.service.d/50-restarts.conf]
2020-02-23 08:21:03,883 [salt.state       :300 ][INFO    ][6207] File /etc/systemd/system/salt-minion.service.d/50-restarts.conf is in the correct state
2020-02-23 08:21:03,883 [salt.state       :1951][INFO    ][6207] Completed state [/etc/systemd/system/salt-minion.service.d/50-restarts.conf] at time 08:21:03.883509 duration_in_ms=16.647
2020-02-23 08:21:03,886 [salt.state       :1780][INFO    ][6207] Running state [salt-minion] at time 08:21:03.886202
2020-02-23 08:21:03,886 [salt.state       :1813][INFO    ][6207] Executing state service.running for [salt-minion]
2020-02-23 08:21:03,887 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6207] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2020-02-23 08:21:03,942 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6207] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2020-02-23 08:21:03,962 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6207] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2020-02-23 08:21:03,992 [salt.state       :300 ][INFO    ][6207] The service salt-minion is already running
2020-02-23 08:21:03,993 [salt.state       :1951][INFO    ][6207] Completed state [salt-minion] at time 08:21:03.993114 duration_in_ms=106.911
2020-02-23 08:21:03,998 [salt.state       :1780][INFO    ][6207] Running state [/etc/salt/grains.d] at time 08:21:03.998385
2020-02-23 08:21:03,999 [salt.state       :1813][INFO    ][6207] Executing state file.directory for [/etc/salt/grains.d]
2020-02-23 08:21:04,001 [salt.state       :300 ][INFO    ][6207] Directory /etc/salt/grains.d is in the correct state
Directory /etc/salt/grains.d updated
2020-02-23 08:21:04,001 [salt.state       :1951][INFO    ][6207] Completed state [/etc/salt/grains.d] at time 08:21:04.001351 duration_in_ms=2.968
2020-02-23 08:21:04,002 [salt.state       :1780][INFO    ][6207] Running state [/etc/salt/grains] at time 08:21:04.002506
2020-02-23 08:21:04,003 [salt.state       :1813][INFO    ][6207] Executing state file.managed for [/etc/salt/grains]
2020-02-23 08:21:04,003 [salt.state       :300 ][INFO    ][6207] File /etc/salt/grains exists with proper permissions. No changes made.
2020-02-23 08:21:04,004 [salt.state       :1951][INFO    ][6207] Completed state [/etc/salt/grains] at time 08:21:04.004218 duration_in_ms=1.712
2020-02-23 08:21:04,005 [salt.state       :1780][INFO    ][6207] Running state [/etc/salt/grains.d/placeholder] at time 08:21:04.005324
2020-02-23 08:21:04,005 [salt.state       :1813][INFO    ][6207] Executing state file.managed for [/etc/salt/grains.d/placeholder]
2020-02-23 08:21:04,006 [salt.state       :300 ][INFO    ][6207] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2020-02-23 08:21:04,007 [salt.state       :1951][INFO    ][6207] Completed state [/etc/salt/grains.d/placeholder] at time 08:21:04.006984 duration_in_ms=1.66
2020-02-23 08:21:04,007 [salt.state       :1780][INFO    ][6207] Running state [/etc/salt/grains.d/sphinx] at time 08:21:04.007798
2020-02-23 08:21:04,008 [salt.state       :1813][INFO    ][6207] Executing state file.managed for [/etc/salt/grains.d/sphinx]
2020-02-23 08:21:04,011 [salt.state       :300 ][INFO    ][6207] File /etc/salt/grains.d/sphinx is in the correct state
2020-02-23 08:21:04,011 [salt.state       :1951][INFO    ][6207] Completed state [/etc/salt/grains.d/sphinx] at time 08:21:04.011820 duration_in_ms=4.022
2020-02-23 08:21:04,015 [salt.state       :1780][INFO    ][6207] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 08:21:04.015520
2020-02-23 08:21:04,015 [salt.state       :1813][INFO    ][6207] Executing state cmd.wait for [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"]
2020-02-23 08:21:04,016 [salt.state       :300 ][INFO    ][6207] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2020-02-23 08:21:04,016 [salt.state       :1951][INFO    ][6207] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 08:21:04.016424 duration_in_ms=0.904
2020-02-23 08:21:04,017 [salt.state       :1780][INFO    ][6207] Running state [/etc/salt/grains.d/dns_records] at time 08:21:04.016946
2020-02-23 08:21:04,017 [salt.state       :1813][INFO    ][6207] Executing state file.managed for [/etc/salt/grains.d/dns_records]
2020-02-23 08:21:04,018 [salt.state       :300 ][INFO    ][6207] File /etc/salt/grains.d/dns_records is in the correct state
2020-02-23 08:21:04,018 [salt.state       :1951][INFO    ][6207] Completed state [/etc/salt/grains.d/dns_records] at time 08:21:04.018516 duration_in_ms=1.57
2020-02-23 08:21:04,019 [salt.state       :1780][INFO    ][6207] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 08:21:04.019469
2020-02-23 08:21:04,019 [salt.state       :1813][INFO    ][6207] Executing state cmd.wait for [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"]
2020-02-23 08:21:04,020 [salt.state       :300 ][INFO    ][6207] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2020-02-23 08:21:04,021 [salt.state       :1951][INFO    ][6207] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 08:21:04.021734 duration_in_ms=2.264
2020-02-23 08:21:04,022 [salt.state       :1780][INFO    ][6207] Running state [/etc/salt/grains.d/salt] at time 08:21:04.022257
2020-02-23 08:21:04,022 [salt.state       :1813][INFO    ][6207] Executing state file.managed for [/etc/salt/grains.d/salt]
2020-02-23 08:21:04,023 [salt.state       :300 ][INFO    ][6207] File /etc/salt/grains.d/salt is in the correct state
2020-02-23 08:21:04,023 [salt.state       :1951][INFO    ][6207] Completed state [/etc/salt/grains.d/salt] at time 08:21:04.023870 duration_in_ms=1.613
2020-02-23 08:21:04,025 [salt.state       :1780][INFO    ][6207] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 08:21:04.025420
2020-02-23 08:21:04,025 [salt.state       :1813][INFO    ][6207] Executing state cmd.wait for [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"]
2020-02-23 08:21:04,026 [salt.state       :300 ][INFO    ][6207] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2020-02-23 08:21:04,026 [salt.state       :1951][INFO    ][6207] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 08:21:04.026269 duration_in_ms=0.849
2020-02-23 08:21:04,028 [salt.state       :1780][INFO    ][6207] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 08:21:04.028239
2020-02-23 08:21:04,028 [salt.state       :1813][INFO    ][6207] Executing state cmd.wait for [cat /etc/salt/grains.d/* > /etc/salt/grains]
2020-02-23 08:21:04,028 [salt.state       :300 ][INFO    ][6207] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2020-02-23 08:21:04,029 [salt.state       :1951][INFO    ][6207] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 08:21:04.029145 duration_in_ms=0.906
2020-02-23 08:21:04,029 [salt.state       :1780][INFO    ][6207] Running state [mine.update] at time 08:21:04.029834
2020-02-23 08:21:04,030 [salt.state       :1813][INFO    ][6207] Executing state module.wait for [mine.update]
2020-02-23 08:21:04,030 [salt.state       :300 ][INFO    ][6207] No changes made for mine.update
2020-02-23 08:21:04,030 [salt.state       :1951][INFO    ][6207] Completed state [mine.update] at time 08:21:04.030612 duration_in_ms=0.779
2020-02-23 08:21:04,030 [salt.state       :1780][INFO    ][6207] Running state [ca-certificates] at time 08:21:04.030888
2020-02-23 08:21:04,031 [salt.state       :1813][INFO    ][6207] Executing state pkg.installed for [ca-certificates]
2020-02-23 08:21:04,041 [salt.state       :300 ][INFO    ][6207] All specified packages are already installed
2020-02-23 08:21:04,041 [salt.state       :1951][INFO    ][6207] Completed state [ca-certificates] at time 08:21:04.041820 duration_in_ms=10.932
2020-02-23 08:21:04,042 [salt.state       :1780][INFO    ][6207] Running state [update-ca-certificates] at time 08:21:04.042549
2020-02-23 08:21:04,042 [salt.state       :1813][INFO    ][6207] Executing state cmd.wait for [update-ca-certificates]
2020-02-23 08:21:04,043 [salt.state       :300 ][INFO    ][6207] No changes made for update-ca-certificates
2020-02-23 08:21:04,043 [salt.state       :1951][INFO    ][6207] Completed state [update-ca-certificates] at time 08:21:04.043365 duration_in_ms=0.816
2020-02-23 08:21:04,043 [salt.state       :1780][INFO    ][6207] Running state [iptables] at time 08:21:04.043655
2020-02-23 08:21:04,043 [salt.state       :1813][INFO    ][6207] Executing state pkg.installed for [iptables]
2020-02-23 08:21:04,054 [salt.state       :300 ][INFO    ][6207] All specified packages are already installed
2020-02-23 08:21:04,054 [salt.state       :1951][INFO    ][6207] Completed state [iptables] at time 08:21:04.054754 duration_in_ms=11.098
2020-02-23 08:21:04,055 [salt.state       :1780][INFO    ][6207] Running state [iptables-persistent] at time 08:21:04.055044
2020-02-23 08:21:04,055 [salt.state       :1813][INFO    ][6207] Executing state pkg.installed for [iptables-persistent]
2020-02-23 08:21:04,065 [salt.state       :300 ][INFO    ][6207] All specified packages are already installed
2020-02-23 08:21:04,065 [salt.state       :1951][INFO    ][6207] Completed state [iptables-persistent] at time 08:21:04.065552 duration_in_ms=10.508
2020-02-23 08:21:04,066 [salt.state       :1780][INFO    ][6207] Running state [iptables_modules_v4_load] at time 08:21:04.066605
2020-02-23 08:21:04,066 [salt.state       :1813][INFO    ][6207] Executing state kmod.present for [iptables_modules_v4_load]
2020-02-23 08:21:04,067 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6207] Executing command 'lsmod' in directory '/root'
2020-02-23 08:21:04,089 [salt.state       :300 ][INFO    ][6207] Kernel modules iptable_filter, ip_tables are already present
2020-02-23 08:21:04,089 [salt.state       :1951][INFO    ][6207] Completed state [iptables_modules_v4_load] at time 08:21:04.089484 duration_in_ms=22.878
2020-02-23 08:21:04,090 [salt.state       :1780][INFO    ][6207] Running state [/etc/iptables/rules.v4] at time 08:21:04.090507
2020-02-23 08:21:04,091 [salt.state       :1813][INFO    ][6207] Executing state file.managed for [/etc/iptables/rules.v4]
2020-02-23 08:21:04,199 [salt.state       :300 ][INFO    ][6207] File /etc/iptables/rules.v4 is in the correct state
2020-02-23 08:21:04,199 [salt.state       :1951][INFO    ][6207] Completed state [/etc/iptables/rules.v4] at time 08:21:04.199287 duration_in_ms=108.78
2020-02-23 08:21:04,201 [salt.state       :1780][INFO    ][6207] Running state [find /usr/share/netfilter-persistent/plugins.d/[0-9]*-ip4tables -exec {} start \;] at time 08:21:04.201319
2020-02-23 08:21:04,201 [salt.state       :1813][INFO    ][6207] Executing state cmd.run for [find /usr/share/netfilter-persistent/plugins.d/[0-9]*-ip4tables -exec {} start \;]
2020-02-23 08:21:04,202 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6207] Executing command 'test $(iptables-save | wc -l) -eq 0' in directory '/root'
2020-02-23 08:21:04,221 [salt.state       :300 ][INFO    ][6207] onlyif execution failed
2020-02-23 08:21:04,222 [salt.state       :1951][INFO    ][6207] Completed state [find /usr/share/netfilter-persistent/plugins.d/[0-9]*-ip4tables -exec {} start \;] at time 08:21:04.222019 duration_in_ms=20.7
2020-02-23 08:21:04,223 [salt.state       :1780][INFO    ][6207] Running state [netfilter-persistent] at time 08:21:04.223586
2020-02-23 08:21:04,224 [salt.state       :1813][INFO    ][6207] Executing state service.running for [netfilter-persistent]
2020-02-23 08:21:04,227 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6207] Executing command ['systemctl', 'status', 'netfilter-persistent.service', '-n', '0'] in directory '/root'
2020-02-23 08:21:04,254 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6207] Executing command ['systemctl', 'is-active', 'netfilter-persistent.service'] in directory '/root'
2020-02-23 08:21:04,278 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6207] Executing command ['systemctl', 'is-enabled', 'netfilter-persistent.service'] in directory '/root'
2020-02-23 08:21:04,304 [salt.state       :300 ][INFO    ][6207] The service netfilter-persistent is already running
2020-02-23 08:21:04,305 [salt.state       :1951][INFO    ][6207] Completed state [netfilter-persistent] at time 08:21:04.305353 duration_in_ms=81.767
2020-02-23 08:21:04,307 [salt.state       :1780][INFO    ][6207] Running state [iptables_extra.remove_stale_tables] at time 08:21:04.307035
2020-02-23 08:21:04,307 [salt.state       :1813][INFO    ][6207] Executing state module.wait for [iptables_extra.remove_stale_tables]
2020-02-23 08:21:04,308 [salt.state       :300 ][INFO    ][6207] No changes made for iptables_extra.remove_stale_tables
2020-02-23 08:21:04,310 [salt.state       :1951][INFO    ][6207] Completed state [iptables_extra.remove_stale_tables] at time 08:21:04.310471 duration_in_ms=3.436
2020-02-23 08:21:04,310 [salt.state       :1780][INFO    ][6207] Running state [find /usr/share/netfilter-persistent/plugins.d/[0-9]*-ip6tables -exec {} flush \;] at time 08:21:04.310776
2020-02-23 08:21:04,311 [salt.state       :1813][INFO    ][6207] Executing state cmd.run for [find /usr/share/netfilter-persistent/plugins.d/[0-9]*-ip6tables -exec {} flush \;]
2020-02-23 08:21:04,311 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6207] Executing command 'test $(which ip6tables-save) -eq 0 && test $(ip6tables-save | wc -l) -ne 0' in directory '/root'
2020-02-23 08:21:04,328 [salt.state       :300 ][INFO    ][6207] onlyif execution failed
2020-02-23 08:21:04,328 [salt.state       :1951][INFO    ][6207] Completed state [find /usr/share/netfilter-persistent/plugins.d/[0-9]*-ip6tables -exec {} flush \;] at time 08:21:04.328868 duration_in_ms=18.091
2020-02-23 08:21:04,330 [salt.state       :1780][INFO    ][6207] Running state [/etc/iptables/rules.v6] at time 08:21:04.330181
2020-02-23 08:21:04,330 [salt.state       :1813][INFO    ][6207] Executing state file.absent for [/etc/iptables/rules.v6]
2020-02-23 08:21:04,331 [salt.state       :300 ][INFO    ][6207] File /etc/iptables/rules.v6 is not present
2020-02-23 08:21:04,331 [salt.state       :1951][INFO    ][6207] Completed state [/etc/iptables/rules.v6] at time 08:21:04.331484 duration_in_ms=1.303
2020-02-23 08:21:04,335 [salt.state       :1780][INFO    ][6207] Running state [iptables_extra.flush_all] at time 08:21:04.335808
2020-02-23 08:21:04,336 [salt.state       :1813][INFO    ][6207] Executing state module.wait for [iptables_extra.flush_all]
2020-02-23 08:21:04,336 [salt.state       :300 ][INFO    ][6207] No changes made for iptables_extra.flush_all
2020-02-23 08:21:04,336 [salt.state       :1951][INFO    ][6207] Completed state [iptables_extra.flush_all] at time 08:21:04.336661 duration_in_ms=0.854
2020-02-23 08:21:04,339 [salt.minion      :1711][INFO    ][6207] Returning information for job: 20200223082050029838
2020-02-23 08:21:05,301 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command state.apply with jid 20200223082105288605
2020-02-23 08:21:05,331 [salt.minion      :1432][INFO    ][6301] Starting a new job with PID 6301
2020-02-23 08:21:06,495 [salt.state       :915 ][INFO    ][6301] Loading fresh modules for state activity
2020-02-23 08:21:07,792 [salt.state       :1780][INFO    ][6301] Running state [maas-rack-controller] at time 08:21:07.792180
2020-02-23 08:21:07,792 [salt.state       :1813][INFO    ][6301] Executing state pkg.installed for [maas-rack-controller]
2020-02-23 08:21:07,793 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6301] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2020-02-23 08:21:07,908 [salt.state       :300 ][INFO    ][6301] All specified packages are already installed
2020-02-23 08:21:07,909 [salt.state       :1951][INFO    ][6301] Completed state [maas-rack-controller] at time 08:21:07.909359 duration_in_ms=117.18
2020-02-23 08:21:07,909 [salt.state       :1780][INFO    ][6301] Running state [ipmitool] at time 08:21:07.909767
2020-02-23 08:21:07,910 [salt.state       :1813][INFO    ][6301] Executing state pkg.installed for [ipmitool]
2020-02-23 08:21:07,919 [salt.state       :300 ][INFO    ][6301] All specified packages are already installed
2020-02-23 08:21:07,919 [salt.state       :1951][INFO    ][6301] Completed state [ipmitool] at time 08:21:07.919342 duration_in_ms=9.575
2020-02-23 08:21:07,926 [salt.state       :1780][INFO    ][6301] Running state [/etc/maas/rackd.conf] at time 08:21:07.926186
2020-02-23 08:21:07,926 [salt.state       :1813][INFO    ][6301] Executing state file.line for [/etc/maas/rackd.conf]
2020-02-23 08:21:07,928 [salt.state       :300 ][INFO    ][6301] No changes needed to be made
2020-02-23 08:21:07,928 [salt.state       :1951][INFO    ][6301] Completed state [/etc/maas/rackd.conf] at time 08:21:07.928790 duration_in_ms=2.604
2020-02-23 08:21:07,929 [salt.state       :1780][INFO    ][6301] Running state [/etc/maas/rackd.conf] at time 08:21:07.929279
2020-02-23 08:21:07,929 [salt.state       :1813][INFO    ][6301] Executing state file.managed for [/etc/maas/rackd.conf]
2020-02-23 08:21:07,930 [salt.loaded.int.states.file:2298][WARNING ][6301] 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.
2020-02-23 08:21:07,931 [salt.state       :300 ][INFO    ][6301] File /etc/maas/rackd.conf exists with proper permissions. No changes made.
2020-02-23 08:21:07,931 [salt.state       :1951][INFO    ][6301] Completed state [/etc/maas/rackd.conf] at time 08:21:07.931678 duration_in_ms=2.399
2020-02-23 08:21:07,934 [salt.state       :1780][INFO    ][6301] Running state [maas-rackd] at time 08:21:07.934342
2020-02-23 08:21:07,934 [salt.state       :1813][INFO    ][6301] Executing state service.running for [maas-rackd]
2020-02-23 08:21:07,935 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6301] Executing command ['systemctl', 'status', 'maas-rackd.service', '-n', '0'] in directory '/root'
2020-02-23 08:21:07,983 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6301] Executing command ['systemctl', 'is-active', 'maas-rackd.service'] in directory '/root'
2020-02-23 08:21:08,006 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6301] Executing command ['systemctl', 'is-enabled', 'maas-rackd.service'] in directory '/root'
2020-02-23 08:21:08,033 [salt.state       :300 ][INFO    ][6301] The service maas-rackd is already running
2020-02-23 08:21:08,034 [salt.state       :1951][INFO    ][6301] Completed state [maas-rackd] at time 08:21:08.033981 duration_in_ms=99.638
2020-02-23 08:21:08,037 [salt.minion      :1711][INFO    ][6301] Returning information for job: 20200223082105288605
2020-02-23 08:21:08,982 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command state.apply with jid 20200223082108967927
2020-02-23 08:21:09,007 [salt.minion      :1432][INFO    ][6324] Starting a new job with PID 6324
2020-02-23 08:21:10,162 [salt.state       :915 ][INFO    ][6324] Loading fresh modules for state activity
2020-02-23 08:21:11,591 [salt.state       :1780][INFO    ][6324] Running state [maas-region-controller] at time 08:21:11.591509
2020-02-23 08:21:11,592 [salt.state       :1813][INFO    ][6324] Executing state pkg.installed for [maas-region-controller]
2020-02-23 08:21:11,593 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6324] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2020-02-23 08:21:11,717 [salt.state       :300 ][INFO    ][6324] All specified packages are already installed
2020-02-23 08:21:11,718 [salt.state       :1951][INFO    ][6324] Completed state [maas-region-controller] at time 08:21:11.717946 duration_in_ms=126.436
2020-02-23 08:21:11,718 [salt.state       :1780][INFO    ][6324] Running state [python-oauth] at time 08:21:11.718342
2020-02-23 08:21:11,718 [salt.state       :1813][INFO    ][6324] Executing state pkg.installed for [python-oauth]
2020-02-23 08:21:11,735 [salt.state       :300 ][INFO    ][6324] All specified packages are already installed
2020-02-23 08:21:11,735 [salt.state       :1951][INFO    ][6324] Completed state [python-oauth] at time 08:21:11.735351 duration_in_ms=17.008
2020-02-23 08:21:11,741 [salt.state       :1780][INFO    ][6324] Running state [/etc/maas/regiond.conf] at time 08:21:11.741396
2020-02-23 08:21:11,741 [salt.state       :1813][INFO    ][6324] Executing state file.replace for [/etc/maas/regiond.conf]
2020-02-23 08:21:11,747 [salt.state       :300 ][INFO    ][6324] No changes needed to be made
2020-02-23 08:21:11,747 [salt.state       :1951][INFO    ][6324] Completed state [/etc/maas/regiond.conf] at time 08:21:11.747848 duration_in_ms=6.452
2020-02-23 08:21:11,749 [salt.state       :1780][INFO    ][6324] Running state [/usr/lib/python3/dist-packages/provisioningserver/templates/proxy/maas-proxy.conf.template] at time 08:21:11.748982
2020-02-23 08:21:11,749 [salt.state       :1813][INFO    ][6324] Executing state file.managed for [/usr/lib/python3/dist-packages/provisioningserver/templates/proxy/maas-proxy.conf.template]
2020-02-23 08:21:11,824 [salt.state       :300 ][INFO    ][6324] File /usr/lib/python3/dist-packages/provisioningserver/templates/proxy/maas-proxy.conf.template is in the correct state
2020-02-23 08:21:11,824 [salt.state       :1951][INFO    ][6324] Completed state [/usr/lib/python3/dist-packages/provisioningserver/templates/proxy/maas-proxy.conf.template] at time 08:21:11.824660 duration_in_ms=75.678
2020-02-23 08:21:11,825 [salt.state       :1780][INFO    ][6324] Running state [/usr/lib/python3/dist-packages/maasserver/node_status.py] at time 08:21:11.825187
2020-02-23 08:21:11,825 [salt.state       :1813][INFO    ][6324] Executing state file.replace for [/usr/lib/python3/dist-packages/maasserver/node_status.py]
2020-02-23 08:21:11,830 [salt.state       :300 ][INFO    ][6324] No changes needed to be made
2020-02-23 08:21:11,830 [salt.state       :1951][INFO    ][6324] Completed state [/usr/lib/python3/dist-packages/maasserver/node_status.py] at time 08:21:11.830476 duration_in_ms=5.289
2020-02-23 08:21:11,831 [salt.state       :1780][INFO    ][6324] Running state [/usr/lib/python3/dist-packages/maasserver/node_status.py] at time 08:21:11.830981
2020-02-23 08:21:11,831 [salt.state       :1813][INFO    ][6324] Executing state file.replace for [/usr/lib/python3/dist-packages/maasserver/node_status.py]
2020-02-23 08:21:11,836 [salt.state       :300 ][INFO    ][6324] No changes needed to be made
2020-02-23 08:21:11,836 [salt.state       :1951][INFO    ][6324] Completed state [/usr/lib/python3/dist-packages/maasserver/node_status.py] at time 08:21:11.836709 duration_in_ms=5.728
2020-02-23 08:21:11,837 [salt.state       :1780][INFO    ][6324] Running state [/usr/lib/python3/dist-packages/maasserver/models/node.py] at time 08:21:11.837221
2020-02-23 08:21:11,837 [salt.state       :1813][INFO    ][6324] Executing state file.replace for [/usr/lib/python3/dist-packages/maasserver/models/node.py]
2020-02-23 08:21:11,864 [salt.state       :300 ][INFO    ][6324] No changes needed to be made
2020-02-23 08:21:11,864 [salt.state       :1951][INFO    ][6324] Completed state [/usr/lib/python3/dist-packages/maasserver/models/node.py] at time 08:21:11.864808 duration_in_ms=27.586
2020-02-23 08:21:11,865 [salt.state       :1780][INFO    ][6324] Running state [/usr/share/maas/web/static/css/maas-styles.css] at time 08:21:11.865096
2020-02-23 08:21:11,865 [salt.state       :1813][INFO    ][6324] Executing state file.managed for [/usr/share/maas/web/static/css/maas-styles.css]
2020-02-23 08:21:11,882 [salt.state       :300 ][INFO    ][6324] File /usr/share/maas/web/static/css/maas-styles.css is in the correct state
2020-02-23 08:21:11,882 [salt.state       :1951][INFO    ][6324] Completed state [/usr/share/maas/web/static/css/maas-styles.css] at time 08:21:11.882683 duration_in_ms=17.587
2020-02-23 08:21:11,883 [salt.state       :1780][INFO    ][6324] Running state [/etc/maas/preseeds/curtin_userdata_amd64_generic_trusty] at time 08:21:11.883554
2020-02-23 08:21:11,884 [salt.state       :1813][INFO    ][6324] Executing state file.managed for [/etc/maas/preseeds/curtin_userdata_amd64_generic_trusty]
2020-02-23 08:21:11,945 [salt.state       :300 ][INFO    ][6324] File /etc/maas/preseeds/curtin_userdata_amd64_generic_trusty is in the correct state
2020-02-23 08:21:11,945 [salt.state       :1951][INFO    ][6324] Completed state [/etc/maas/preseeds/curtin_userdata_amd64_generic_trusty] at time 08:21:11.945406 duration_in_ms=61.852
2020-02-23 08:21:11,946 [salt.state       :1780][INFO    ][6324] Running state [/etc/maas/preseeds/curtin_userdata_amd64_generic_xenial] at time 08:21:11.946002
2020-02-23 08:21:11,946 [salt.state       :1813][INFO    ][6324] Executing state file.managed for [/etc/maas/preseeds/curtin_userdata_amd64_generic_xenial]
2020-02-23 08:21:12,005 [salt.state       :300 ][INFO    ][6324] File /etc/maas/preseeds/curtin_userdata_amd64_generic_xenial is in the correct state
2020-02-23 08:21:12,006 [salt.state       :1951][INFO    ][6324] Completed state [/etc/maas/preseeds/curtin_userdata_amd64_generic_xenial] at time 08:21:12.006266 duration_in_ms=60.262
2020-02-23 08:21:12,007 [salt.state       :1780][INFO    ][6324] Running state [/etc/maas/preseeds/curtin_userdata_arm64_generic_xenial] at time 08:21:12.007559
2020-02-23 08:21:12,008 [salt.state       :1813][INFO    ][6324] Executing state file.managed for [/etc/maas/preseeds/curtin_userdata_arm64_generic_xenial]
2020-02-23 08:21:12,095 [salt.state       :300 ][INFO    ][6324] File /etc/maas/preseeds/curtin_userdata_arm64_generic_xenial is in the correct state
2020-02-23 08:21:12,095 [salt.state       :1951][INFO    ][6324] Completed state [/etc/maas/preseeds/curtin_userdata_arm64_generic_xenial] at time 08:21:12.095862 duration_in_ms=88.304
2020-02-23 08:21:12,097 [salt.state       :1780][INFO    ][6324] Running state [/etc/maas/preseeds/curtin_userdata_amd64_generic_bionic] at time 08:21:12.097632
2020-02-23 08:21:12,098 [salt.state       :1813][INFO    ][6324] Executing state file.managed for [/etc/maas/preseeds/curtin_userdata_amd64_generic_bionic]
2020-02-23 08:21:12,169 [salt.state       :300 ][INFO    ][6324] File /etc/maas/preseeds/curtin_userdata_amd64_generic_bionic is in the correct state
2020-02-23 08:21:12,170 [salt.state       :1951][INFO    ][6324] Completed state [/etc/maas/preseeds/curtin_userdata_amd64_generic_bionic] at time 08:21:12.170031 duration_in_ms=72.399
2020-02-23 08:21:12,170 [salt.state       :1780][INFO    ][6324] Running state [/etc/maas/preseeds/curtin_userdata_arm64_generic_bionic] at time 08:21:12.170602
2020-02-23 08:21:12,170 [salt.state       :1813][INFO    ][6324] Executing state file.managed for [/etc/maas/preseeds/curtin_userdata_arm64_generic_bionic]
2020-02-23 08:21:12,240 [salt.state       :300 ][INFO    ][6324] File /etc/maas/preseeds/curtin_userdata_arm64_generic_bionic is in the correct state
2020-02-23 08:21:12,240 [salt.state       :1951][INFO    ][6324] Completed state [/etc/maas/preseeds/curtin_userdata_arm64_generic_bionic] at time 08:21:12.240782 duration_in_ms=70.18
2020-02-23 08:21:12,241 [salt.state       :1780][INFO    ][6324] Running state [/root/.pgpass] at time 08:21:12.241133
2020-02-23 08:21:12,241 [salt.state       :1813][INFO    ][6324] Executing state file.managed for [/root/.pgpass]
2020-02-23 08:21:12,301 [salt.state       :300 ][INFO    ][6324] File /root/.pgpass is in the correct state
2020-02-23 08:21:12,302 [salt.state       :1951][INFO    ][6324] Completed state [/root/.pgpass] at time 08:21:12.302798 duration_in_ms=61.66
2020-02-23 08:21:12,314 [salt.state       :1780][INFO    ][6324] Running state [maas-region migrate --noinput] at time 08:21:12.314928
2020-02-23 08:21:12,315 [salt.state       :1813][INFO    ][6324] Executing state cmd.run for [maas-region migrate --noinput]
2020-02-23 08:21:12,316 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6324] Executing command 'maas-region migrate --noinput' in directory '/root'
2020-02-23 08:21:15,676 [salt.state       :300 ][INFO    ][6324] {'pid': 6355, 'retcode': 0, 'stderr': '', 'stdout': 'Operations to perform:\n  Apply all migrations: auth, contenttypes, maasserver, metadataserver, piston3, sessions, sites\nRunning migrations:\n  No migrations to apply.'}
2020-02-23 08:21:15,676 [salt.state       :1951][INFO    ][6324] Completed state [maas-region migrate --noinput] at time 08:21:15.676839 duration_in_ms=3361.911
2020-02-23 08:21:15,677 [salt.state       :2022][WARNING ][6324] State is set to retry, but a valid dict for retry configuration was not found.  Using retry defaults
2020-02-23 08:21:15,678 [salt.state       :1780][INFO    ][6324] Running state [maas-regiond] at time 08:21:15.678846
2020-02-23 08:21:15,679 [salt.state       :1813][INFO    ][6324] Executing state service.running for [maas-regiond]
2020-02-23 08:21:15,680 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6324] Executing command ['systemctl', 'status', 'maas-regiond.service', '-n', '0'] in directory '/root'
2020-02-23 08:21:15,727 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6324] Executing command ['systemctl', 'is-active', 'maas-regiond.service'] in directory '/root'
2020-02-23 08:21:15,749 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6324] Executing command ['systemctl', 'is-enabled', 'maas-regiond.service'] in directory '/root'
2020-02-23 08:21:15,776 [salt.state       :300 ][INFO    ][6324] The service maas-regiond is already running
2020-02-23 08:21:15,777 [salt.state       :1951][INFO    ][6324] Completed state [maas-regiond] at time 08:21:15.777084 duration_in_ms=98.238
2020-02-23 08:21:15,779 [salt.state       :1780][INFO    ][6324] Running state [bind9] at time 08:21:15.779202
2020-02-23 08:21:15,779 [salt.state       :1813][INFO    ][6324] Executing state service.running for [bind9]
2020-02-23 08:21:15,782 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6324] Executing command ['systemctl', 'status', 'bind9.service', '-n', '0'] in directory '/root'
2020-02-23 08:21:15,806 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6324] Executing command ['systemctl', 'is-active', 'bind9.service'] in directory '/root'
2020-02-23 08:21:15,826 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6324] Executing command ['systemctl', 'is-enabled', 'bind9.service'] in directory '/root'
2020-02-23 08:21:15,850 [salt.state       :300 ][INFO    ][6324] The service bind9 is already running
2020-02-23 08:21:15,851 [salt.state       :1951][INFO    ][6324] Completed state [bind9] at time 08:21:15.851128 duration_in_ms=71.925
2020-02-23 08:21:15,856 [salt.state       :1780][INFO    ][6324] Running state [maasng.wait_for_http_code] at time 08:21:15.856066
2020-02-23 08:21:15,856 [salt.state       :1813][INFO    ][6324] Executing state module.run for [maasng.wait_for_http_code]
2020-02-23 08:21:15,857 [salt.utils.decorators:613 ][WARNING ][6324] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-02-23 08:21:15,915 [salt.state       :300 ][INFO    ][6324] {'ret': {'comment': 'MAAS API:http://localhost:5240/MAAS up.', 'result': True}}
2020-02-23 08:21:15,917 [salt.state       :1951][INFO    ][6324] Completed state [maasng.wait_for_http_code] at time 08:21:15.916971 duration_in_ms=60.904
2020-02-23 08:21:15,918 [salt.state       :1780][INFO    ][6324] Running state [maas createadmin --username opnfv --password opnfv_secret --email email@example.com && touch /var/lib/maas/.setup_admin] at time 08:21:15.918464
2020-02-23 08:21:15,919 [salt.state       :1813][INFO    ][6324] Executing state cmd.run for [maas createadmin --username opnfv --password opnfv_secret --email email@example.com && touch /var/lib/maas/.setup_admin]
2020-02-23 08:21:15,920 [salt.state       :300 ][INFO    ][6324] /var/lib/maas/.setup_admin exists
2020-02-23 08:21:15,920 [salt.state       :1951][INFO    ][6324] Completed state [maas createadmin --username opnfv --password opnfv_secret --email email@example.com && touch /var/lib/maas/.setup_admin] at time 08:21:15.920689 duration_in_ms=2.227
2020-02-23 08:21:15,922 [salt.state       :1780][INFO    ][6324] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 08:21:15.921993
2020-02-23 08:21:15,922 [salt.state       :1813][INFO    ][6324] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2020-02-23 08:21:15,923 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6324] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2020-02-23 08:21:18,121 [salt.state       :300 ][INFO    ][6324] {'pid': 6369, 'retcode': 0, 'stderr': '', 'stdout': ''}
2020-02-23 08:21:18,122 [salt.state       :1951][INFO    ][6324] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 08:21:18.122492 duration_in_ms=2200.498
2020-02-23 08:21:18,133 [salt.state       :1780][INFO    ][6324] Running state [maas_region_boot_source_resources_mirror] at time 08:21:18.133870
2020-02-23 08:21:18,134 [salt.state       :1813][INFO    ][6324] Executing state maasng.boot_source_present for [maas_region_boot_source_resources_mirror]
2020-02-23 08:21:18,307 [salt.state       :300 ][INFO    ][6324] {'changes': {}}
2020-02-23 08:21:18,307 [salt.state       :1951][INFO    ][6324] Completed state [maas_region_boot_source_resources_mirror] at time 08:21:18.307799 duration_in_ms=173.928
2020-02-23 08:21:18,309 [salt.state       :1780][INFO    ][6324] Running state [maasng.boot_resources_import] at time 08:21:18.309792
2020-02-23 08:21:18,310 [salt.state       :1813][INFO    ][6324] Executing state module.run for [maasng.boot_resources_import]
2020-02-23 08:21:18,311 [salt.utils.decorators:613 ][WARNING ][6324] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-02-23 08:21:18,394 [salt.loaded.ext.module.maasng:1600][INFO    ][6324] Waiting boot-resources import done
sleep for:5s Left:900.0/900s
2020-02-23 08:21:23,471 [salt.state       :300 ][INFO    ][6324] {'ret': True}
2020-02-23 08:21:23,472 [salt.state       :1951][INFO    ][6324] Completed state [maasng.boot_resources_import] at time 08:21:23.471957 duration_in_ms=5162.165
2020-02-23 08:21:23,474 [salt.state       :1780][INFO    ][6324] Running state [maas_region_boot_sources_selection_bionic] at time 08:21:23.474226
2020-02-23 08:21:23,474 [salt.state       :1813][INFO    ][6324] Executing state maasng.boot_sources_selections_present for [maas_region_boot_sources_selection_bionic]
2020-02-23 08:21:23,589 [salt.state       :300 ][INFO    ][6324] Requested boot-source selection for http://images.maas.io/ephemeral-v3/daily already exist.
2020-02-23 08:21:23,589 [salt.state       :1951][INFO    ][6324] Completed state [maas_region_boot_sources_selection_bionic] at time 08:21:23.589559 duration_in_ms=115.332
2020-02-23 08:21:23,591 [salt.state       :1780][INFO    ][6324] Running state [maasng.sync_and_wait_bs_to_all_racks] at time 08:21:23.591154
2020-02-23 08:21:23,591 [salt.state       :1813][INFO    ][6324] Executing state module.run for [maasng.sync_and_wait_bs_to_all_racks]
2020-02-23 08:21:23,594 [salt.utils.decorators:613 ][WARNING ][6324] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-02-23 08:21:23,595 [salt.loaded.ext.module.maasng:1771][INFO    ][6324] boot-sources sync initiated for ALL Rack's
2020-02-23 08:21:24,015 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223082124002671
2020-02-23 08:21:24,033 [salt.minion      :1432][INFO    ][6401] Starting a new job with PID 6401
2020-02-23 08:21:24,065 [salt.minion      :1711][INFO    ][6401] Returning information for job: 20200223082124002671
2020-02-23 08:21:24,349 [salt.state       :300 ][INFO    ][6324] {'ret': True}
2020-02-23 08:21:24,350 [salt.state       :1951][INFO    ][6324] Completed state [maasng.sync_and_wait_bs_to_all_racks] at time 08:21:24.350133 duration_in_ms=758.979
2020-02-23 08:21:24,352 [salt.state       :1780][INFO    ][6324] Running state [maas.process_maas_config] at time 08:21:24.352234
2020-02-23 08:21:24,353 [salt.state       :1813][INFO    ][6324] Executing state module.run for [maas.process_maas_config]
2020-02-23 08:21:24,354 [salt.utils.decorators:613 ][WARNING ][6324] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-02-23 08:21:24,354 [salt.loaded.ext.module.maas:92  ][INFO    ][6324] maasconfig name=enable_http_proxy value=True
2020-02-23 08:21:24,391 [salt.loaded.ext.module.maas:92  ][INFO    ][6324] maasconfig name=upstream_dns value=8.8.8.8
2020-02-23 08:21:24,429 [salt.loaded.ext.module.maas:92  ][INFO    ][6324] maasconfig name=commissioning_distro_series value=bionic
2020-02-23 08:21:24,477 [salt.loaded.ext.module.maas:92  ][INFO    ][6324] maasconfig name=default_osystem value=ubuntu
2020-02-23 08:21:24,513 [salt.loaded.ext.module.maas:92  ][INFO    ][6324] maasconfig name=active_discovery_interval value=600
2020-02-23 08:21:25,902 [salt.loaded.ext.module.maas:92  ][INFO    ][6324] maasconfig name=dnssec_validation value=no
2020-02-23 08:21:26,257 [salt.loaded.ext.module.maas:92  ][INFO    ][6324] maasconfig name=kernel_opts value=spectre_v2=off nopti kpti=off nospec_store_bypass_disable noibrs noibpb
2020-02-23 08:21:26,490 [salt.loaded.ext.module.maas:92  ][INFO    ][6324] maasconfig name=network_discovery value=enabled
2020-02-23 08:21:26,773 [salt.loaded.ext.module.maas:92  ][INFO    ][6324] maasconfig name=enable_third_party_drivers value=True
2020-02-23 08:21:26,812 [salt.loaded.ext.module.maas:92  ][INFO    ][6324] maasconfig name=default_storage_layout value=lvm
2020-02-23 08:21:26,842 [salt.loaded.ext.module.maas:92  ][INFO    ][6324] maasconfig name=maas_name value=mas01
2020-02-23 08:21:26,899 [salt.loaded.ext.module.maas:92  ][INFO    ][6324] maasconfig name=disk_erase_with_secure_erase value=False
2020-02-23 08:21:26,930 [salt.loaded.ext.module.maas:92  ][INFO    ][6324] maasconfig name=default_distro_series value=bionic
2020-02-23 08:21:26,972 [salt.loaded.ext.module.maas:92  ][INFO    ][6324] maasconfig name=ntp_external_only value=True
2020-02-23 08:21:27,001 [salt.loaded.ext.module.maas:92  ][INFO    ][6324] maasconfig name=default_min_hwe_kernel value=ga-18.04
2020-02-23 08:21:27,069 [salt.state       :300 ][INFO    ][6324] {'ret': {'updated': [], 'errors': {}, 'success': ['enable_http_proxy', 'upstream_dns', 'commissioning_distro_series', 'default_osystem', 'active_discovery_interval', 'dnssec_validation', 'kernel_opts', 'network_discovery', 'enable_third_party_drivers', 'default_storage_layout', 'maas_name', 'disk_erase_with_secure_erase', 'default_distro_series', 'ntp_external_only', 'default_min_hwe_kernel']}}
2020-02-23 08:21:27,069 [salt.state       :1951][INFO    ][6324] Completed state [maas.process_maas_config] at time 08:21:27.069689 duration_in_ms=2717.439
2020-02-23 08:21:27,070 [salt.state       :1780][INFO    ][6324] Running state [pxe_admin] at time 08:21:27.070751
2020-02-23 08:21:27,071 [salt.state       :1813][INFO    ][6324] Executing state maasng.fabric_present for [pxe_admin]
2020-02-23 08:21:27,117 [salt.loaded.ext.module.maasng:945 ][INFO    ][6324] [{u'resource_uri': u'/MAAS/api/2.0/fabrics/0/', u'vlans': [{u'fabric': u'fabric-0', u'vid': 0, u'space': u'undefined', u'fabric_id': 0, u'dhcp_on': False, u'mtu': 1500, u'primary_rack': None, u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/', u'id': 5001, u'secondary_rack': None, u'name': u'untagged'}], u'class_type': None, u'name': u'fabric-0', u'id': 0}, {u'resource_uri': u'/MAAS/api/2.0/fabrics/2/', u'vlans': [{u'fabric': u'fabric-2', u'vid': 0, u'space': u'undefined', u'fabric_id': 2, u'dhcp_on': False, u'mtu': 1500, u'primary_rack': None, u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/', u'id': 5003, u'secondary_rack': None, u'name': u'untagged'}], u'class_type': None, u'name': u'fabric-2', u'id': 2}, {u'resource_uri': u'/MAAS/api/2.0/fabrics/1/', u'vlans': [{u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'hdkn4c', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/', u'id': 5002, u'secondary_rack': None, u'name': u'untagged'}], u'class_type': None, u'name': u'pxe_admin', u'id': 1}]
2020-02-23 08:21:27,174 [salt.loaded.ext.module.maasng:1008][WARNING ][6324] Detected cidr:192.168.11.0/24 in fabric:pxe_admin
2020-02-23 08:21:27,174 [salt.loaded.ext.module.maasng:1011][WARNING ][6324] Guessing, that fabric with current name:pxe_admin
 should be renamed to:pxe_admin
2020-02-23 08:21:27,213 [salt.state       :300 ][INFO    ][6324] {'new': 'Fabric  pxe_admin created', 'result': True}
2020-02-23 08:21:27,214 [salt.state       :1951][INFO    ][6324] Completed state [pxe_admin] at time 08:21:27.214140 duration_in_ms=143.389
2020-02-23 08:21:27,214 [salt.state       :1780][INFO    ][6324] Running state [vlan 0] at time 08:21:27.214710
2020-02-23 08:21:27,215 [salt.state       :1813][INFO    ][6324] Executing state maasng.vlan_present_in_fabric for [vlan 0]
2020-02-23 08:21:27,259 [salt.loaded.ext.module.maasng:945 ][INFO    ][6324] [{u'resource_uri': u'/MAAS/api/2.0/fabrics/0/', u'vlans': [{u'fabric': u'fabric-0', u'vid': 0, u'space': u'undefined', u'fabric_id': 0, u'dhcp_on': False, u'mtu': 1500, u'primary_rack': None, u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/', u'id': 5001, u'secondary_rack': None, u'name': u'untagged'}], u'class_type': None, u'name': u'fabric-0', u'id': 0}, {u'resource_uri': u'/MAAS/api/2.0/fabrics/2/', u'vlans': [{u'fabric': u'fabric-2', u'vid': 0, u'space': u'undefined', u'fabric_id': 2, u'dhcp_on': False, u'mtu': 1500, u'primary_rack': None, u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/', u'id': 5003, u'secondary_rack': None, u'name': u'untagged'}], u'class_type': None, u'name': u'fabric-2', u'id': 2}, {u'resource_uri': u'/MAAS/api/2.0/fabrics/1/', u'vlans': [{u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'hdkn4c', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/', u'id': 5002, u'secondary_rack': None, u'name': u'untagged'}], u'class_type': None, u'name': u'pxe_admin', u'id': 1}]
2020-02-23 08:21:27,385 [salt.loaded.ext.module.maasng:945 ][INFO    ][6324] [{u'id': 0, u'vlans': [{u'fabric': u'fabric-0', u'vid': 0, u'space': u'undefined', u'fabric_id': 0, u'dhcp_on': False, u'mtu': 1500, u'primary_rack': None, u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/', u'id': 5001, u'secondary_rack': None, u'name': u'untagged'}], u'class_type': None, u'resource_uri': u'/MAAS/api/2.0/fabrics/0/', u'name': u'fabric-0'}, {u'id': 2, u'vlans': [{u'fabric': u'fabric-2', u'vid': 0, u'space': u'undefined', u'fabric_id': 2, u'dhcp_on': False, u'mtu': 1500, u'primary_rack': None, u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/', u'id': 5003, u'secondary_rack': None, u'name': u'untagged'}], u'class_type': None, u'resource_uri': u'/MAAS/api/2.0/fabrics/2/', u'name': u'fabric-2'}, {u'id': 1, u'vlans': [{u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'hdkn4c', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/', u'id': 5002, u'secondary_rack': None, u'name': u'untagged'}], u'class_type': None, u'resource_uri': u'/MAAS/api/2.0/fabrics/1/', u'name': u'pxe_admin'}]
2020-02-23 08:21:27,582 [salt.loaded.ext.module.maasng:945 ][INFO    ][6324] [{u'resource_uri': u'/MAAS/api/2.0/fabrics/0/', u'vlans': [{u'fabric': u'fabric-0', u'vid': 0, u'space': u'undefined', u'fabric_id': 0, u'dhcp_on': False, u'mtu': 1500, u'primary_rack': None, u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/', u'id': 5001, u'secondary_rack': None, u'name': u'untagged'}], u'class_type': None, u'name': u'fabric-0', u'id': 0}, {u'resource_uri': u'/MAAS/api/2.0/fabrics/2/', u'vlans': [{u'fabric': u'fabric-2', u'vid': 0, u'space': u'undefined', u'fabric_id': 2, u'dhcp_on': False, u'mtu': 1500, u'primary_rack': None, u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/', u'id': 5003, u'secondary_rack': None, u'name': u'untagged'}], u'class_type': None, u'name': u'fabric-2', u'id': 2}, {u'resource_uri': u'/MAAS/api/2.0/fabrics/1/', u'vlans': [{u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'hdkn4c', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/', u'id': 5002, u'secondary_rack': None, u'name': u'untagged'}], u'class_type': None, u'name': u'pxe_admin', u'id': 1}]
2020-02-23 08:21:27,643 [salt.state       :300 ][INFO    ][6324] {'new': 'Vlan untagged was updated'}
2020-02-23 08:21:27,643 [salt.state       :1951][INFO    ][6324] Completed state [vlan 0] at time 08:21:27.643842 duration_in_ms=429.131
2020-02-23 08:21:27,645 [salt.state       :1780][INFO    ][6324] Running state [192.168.11.0/24] at time 08:21:27.645563
2020-02-23 08:21:27,646 [salt.state       :1813][INFO    ][6324] Executing state maasng.subnet_present for [192.168.11.0/24]
2020-02-23 08:21:27,795 [salt.loaded.ext.module.maasng:945 ][INFO    ][6324] [{u'id': 0, u'vlans': [{u'fabric': u'fabric-0', u'vid': 0, u'space': u'undefined', u'fabric_id': 0, u'dhcp_on': False, u'mtu': 1500, u'primary_rack': None, u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/', u'id': 5001, u'secondary_rack': None, u'name': u'untagged'}], u'class_type': None, u'resource_uri': u'/MAAS/api/2.0/fabrics/0/', u'name': u'fabric-0'}, {u'id': 2, u'vlans': [{u'fabric': u'fabric-2', u'vid': 0, u'space': u'undefined', u'fabric_id': 2, u'dhcp_on': False, u'mtu': 1500, u'primary_rack': None, u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/', u'id': 5003, u'secondary_rack': None, u'name': u'untagged'}], u'class_type': None, u'resource_uri': u'/MAAS/api/2.0/fabrics/2/', u'name': u'fabric-2'}, {u'id': 1, u'vlans': [{u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': False, u'mtu': 1500, u'primary_rack': u'hdkn4c', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/', u'id': 5002, u'secondary_rack': None, u'name': u'untagged'}], u'class_type': None, u'resource_uri': u'/MAAS/api/2.0/fabrics/1/', u'name': u'pxe_admin'}]
2020-02-23 08:21:27,797 [salt.loaded.ext.module.maasng:1235][WARNING ][6324] Ignoring parameter vlan:0
2020-02-23 08:21:27,849 [salt.state       :300 ][INFO    ][6324] Subnet 192.168.11.0/24 has been updated for pxe_admin
2020-02-23 08:21:27,849 [salt.state       :1951][INFO    ][6324] Completed state [192.168.11.0/24] at time 08:21:27.849876 duration_in_ms=204.313
2020-02-23 08:21:27,851 [salt.state       :1780][INFO    ][6324] Running state [maas_create_iprange_1] at time 08:21:27.851214
2020-02-23 08:21:27,851 [salt.state       :1813][INFO    ][6324] Executing state maasng.iprange_present for [maas_create_iprange_1]
2020-02-23 08:21:27,899 [salt.state       :300 ][INFO    ][6324] Iprange maas_create_iprange_1 already exist.
2020-02-23 08:21:27,899 [salt.state       :1951][INFO    ][6324] Completed state [maas_create_iprange_1] at time 08:21:27.899609 duration_in_ms=48.395
2020-02-23 08:21:27,900 [salt.state       :1780][INFO    ][6324] Running state [vlan 0] at time 08:21:27.900067
2020-02-23 08:21:27,901 [salt.state       :1813][INFO    ][6324] Executing state maasng.vlan_present_in_fabric for [vlan 0]
2020-02-23 08:21:27,943 [salt.loaded.ext.module.maasng:945 ][INFO    ][6324] [{u'resource_uri': u'/MAAS/api/2.0/fabrics/0/', u'vlans': [{u'fabric': u'fabric-0', u'vid': 0, u'space': u'undefined', u'fabric_id': 0, u'dhcp_on': False, u'mtu': 1500, u'primary_rack': None, u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/', u'id': 5001, u'secondary_rack': None, u'name': u'untagged'}], u'class_type': None, u'name': u'fabric-0', u'id': 0}, {u'resource_uri': u'/MAAS/api/2.0/fabrics/2/', u'vlans': [{u'fabric': u'fabric-2', u'vid': 0, u'space': u'undefined', u'fabric_id': 2, u'dhcp_on': False, u'mtu': 1500, u'primary_rack': None, u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/', u'id': 5003, u'secondary_rack': None, u'name': u'untagged'}], u'class_type': None, u'name': u'fabric-2', u'id': 2}, {u'resource_uri': u'/MAAS/api/2.0/fabrics/1/', u'vlans': [{u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': False, u'mtu': 1500, u'primary_rack': u'hdkn4c', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/', u'id': 5002, u'secondary_rack': None, u'name': u'untagged'}], u'class_type': None, u'name': u'pxe_admin', u'id': 1}]
2020-02-23 08:21:28,022 [salt.loaded.ext.module.maasng:945 ][INFO    ][6324] [{u'resource_uri': u'/MAAS/api/2.0/fabrics/0/', u'vlans': [{u'fabric': u'fabric-0', u'vid': 0, u'space': u'undefined', u'fabric_id': 0, u'dhcp_on': False, u'mtu': 1500, u'primary_rack': None, u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/', u'id': 5001, u'secondary_rack': None, u'name': u'untagged'}], u'class_type': None, u'name': u'fabric-0', u'id': 0}, {u'resource_uri': u'/MAAS/api/2.0/fabrics/2/', u'vlans': [{u'fabric': u'fabric-2', u'vid': 0, u'space': u'undefined', u'fabric_id': 2, u'dhcp_on': False, u'mtu': 1500, u'primary_rack': None, u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/', u'id': 5003, u'secondary_rack': None, u'name': u'untagged'}], u'class_type': None, u'name': u'fabric-2', u'id': 2}, {u'resource_uri': u'/MAAS/api/2.0/fabrics/1/', u'vlans': [{u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': False, u'mtu': 1500, u'primary_rack': u'hdkn4c', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/', u'id': 5002, u'secondary_rack': None, u'name': u'untagged'}], u'class_type': None, u'name': u'pxe_admin', u'id': 1}]
2020-02-23 08:21:28,241 [salt.loaded.ext.module.maasng:945 ][INFO    ][6324] [{u'id': 0, u'vlans': [{u'fabric': u'fabric-0', u'vid': 0, u'space': u'undefined', u'fabric_id': 0, u'dhcp_on': False, u'mtu': 1500, u'primary_rack': None, u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/', u'id': 5001, u'secondary_rack': None, u'name': u'untagged'}], u'class_type': None, u'resource_uri': u'/MAAS/api/2.0/fabrics/0/', u'name': u'fabric-0'}, {u'id': 2, u'vlans': [{u'fabric': u'fabric-2', u'vid': 0, u'space': u'undefined', u'fabric_id': 2, u'dhcp_on': False, u'mtu': 1500, u'primary_rack': None, u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/', u'id': 5003, u'secondary_rack': None, u'name': u'untagged'}], u'class_type': None, u'resource_uri': u'/MAAS/api/2.0/fabrics/2/', u'name': u'fabric-2'}, {u'id': 1, u'vlans': [{u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': False, u'mtu': 1500, u'primary_rack': u'hdkn4c', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/', u'id': 5002, u'secondary_rack': None, u'name': u'untagged'}], u'class_type': None, u'resource_uri': u'/MAAS/api/2.0/fabrics/1/', u'name': u'pxe_admin'}]
2020-02-23 08:21:28,329 [salt.state       :300 ][INFO    ][6324] {'new': 'Vlan untagged was updated'}
2020-02-23 08:21:28,330 [salt.state       :1951][INFO    ][6324] Completed state [vlan 0] at time 08:21:28.330348 duration_in_ms=430.28
2020-02-23 08:21:28,331 [salt.state       :1780][INFO    ][6324] Running state [opnfv] at time 08:21:28.331289
2020-02-23 08:21:28,331 [salt.state       :1813][INFO    ][6324] Executing state maasng.sshkey_present for [opnfv]
2020-02-23 08:21:28,377 [salt.loaded.ext.module.maasng:1903][INFO    ][6324] [{u'resource_uri': u'/MAAS/api/2.0/account/prefs/sshkeys/1/', u'id': 1, u'key': u'ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC74OvZ7y776Wj5A8gYoVsdCbbUonA1WMCs5kfze0DkD4BUfOiRckbCWpDsZ84y0q/A3tHj3u8/a9JnDyohIIAiswijSxajjvrLfPHa87S25OtoMcjousRMdy5O/WDRfSsgNJrbNYYytMurQMLHMKJHwSY8Z950wKP852g6WoQxv3Lhd7WrZgbPOLo2Y2J/ZywpakYaLeAJOaHe66ZX8b55yS1IL9oYVbrpD/ixBh+PaZrOjoGobYU82xY8RKfpfmTWLm/CO0BgrLk1vIKEVwfIxu+wleagZCUL/XHbO6owtVjXE3l9ZFGE3ZF/WyS4/CuXNomG+pHCQ91fcP3EGx6b', u'keysource': u''}]
2020-02-23 08:21:28,378 [salt.state       :300 ][INFO    ][6324] SSH key ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC74OvZ7y776Wj5A8gYoVsdCbbUonA1WMCs5kfze0DkD4BUfOiRckbCWpDsZ84y0q/A3tHj3u8/a9JnDyohIIAiswijSxajjvrLfPHa87S25OtoMcjousRMdy5O/WDRfSsgNJrbNYYytMurQMLHMKJHwSY8Z950wKP852g6WoQxv3Lhd7WrZgbPOLo2Y2J/ZywpakYaLeAJOaHe66ZX8b55yS1IL9oYVbrpD/ixBh+PaZrOjoGobYU82xY8RKfpfmTWLm/CO0BgrLk1vIKEVwfIxu+wleagZCUL/XHbO6owtVjXE3l9ZFGE3ZF/WyS4/CuXNomG+pHCQ91fcP3EGx6b already exist for user opnfv.
2020-02-23 08:21:28,378 [salt.state       :1951][INFO    ][6324] Completed state [opnfv] at time 08:21:28.378826 duration_in_ms=47.536
2020-02-23 08:21:28,386 [salt.minion      :1711][INFO    ][6324] Returning information for job: 20200223082108967927
2020-02-23 08:21:29,532 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command state.apply with jid 20200223082129521522
2020-02-23 08:21:29,550 [salt.minion      :1432][INFO    ][6453] Starting a new job with PID 6453
2020-02-23 08:21:37,910 [salt.state       :915 ][INFO    ][6453] Loading fresh modules for state activity
2020-02-23 08:21:38,023 [salt.state       :1780][INFO    ][6453] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 08:21:38.023177
2020-02-23 08:21:38,023 [salt.state       :1813][INFO    ][6453] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2020-02-23 08:21:38,025 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6453] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2020-02-23 08:21:40,266 [salt.state       :300 ][INFO    ][6453] {'pid': 6469, 'retcode': 0, 'stderr': '', 'stdout': ''}
2020-02-23 08:21:40,266 [salt.state       :1951][INFO    ][6453] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 08:21:40.266885 duration_in_ms=2243.709
2020-02-23 08:21:40,268 [salt.state       :1780][INFO    ][6453] Running state [maas.process_machines] at time 08:21:40.268872
2020-02-23 08:21:40,269 [salt.state       :1813][INFO    ][6453] Executing state module.run for [maas.process_machines]
2020-02-23 08:21:40,269 [salt.utils.decorators:613 ][WARNING ][6453] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-02-23 08:21:40,925 [salt.loaded.ext.module.maas:412 ][WARNING ][6453] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2020-02-23 08:21:40,926 [salt.loaded.ext.module.maas:92  ][INFO    ][6453] machine hostname=cmp002 power_type=ipmi mac_addresses=['9c:b6:54:8a:10:18'] power_parameters_power_address=172.16.1.20 power_parameters_power_pass=Winter2017 system_id=arrwft architecture=amd64/generic power_parameters_power_user=opnfv
2020-02-23 08:21:41,610 [salt.loaded.ext.module.maas:412 ][WARNING ][6453] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2020-02-23 08:21:41,611 [salt.loaded.ext.module.maas:92  ][INFO    ][6453] machine hostname=cmp001 power_type=ipmi mac_addresses=['9c:b6:54:8a:95:a0'] power_parameters_power_address=172.16.1.19 power_parameters_power_pass=Winter2017 system_id=pm8hsd architecture=amd64/generic power_parameters_power_user=opnfv
2020-02-23 08:21:42,311 [salt.loaded.ext.module.maas:412 ][WARNING ][6453] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2020-02-23 08:21:42,312 [salt.loaded.ext.module.maas:92  ][INFO    ][6453] machine hostname=kvm01 power_type=ipmi mac_addresses=['14:58:d0:54:e7:88'] power_parameters_power_address=172.16.1.16 power_parameters_power_pass=Winter2017 system_id=etecgh architecture=amd64/generic power_parameters_power_user=opnfv
2020-02-23 08:21:42,989 [salt.loaded.ext.module.maas:412 ][WARNING ][6453] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2020-02-23 08:21:42,990 [salt.loaded.ext.module.maas:92  ][INFO    ][6453] machine hostname=kvm03 power_type=ipmi mac_addresses=['14:58:d0:54:7a:28'] power_parameters_power_address=172.16.1.18 power_parameters_power_pass=Winter2017 system_id=whwmah architecture=amd64/generic power_parameters_power_user=opnfv
2020-02-23 08:21:43,708 [salt.loaded.ext.module.maas:412 ][WARNING ][6453] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2020-02-23 08:21:43,709 [salt.loaded.ext.module.maas:92  ][INFO    ][6453] machine hostname=kvm02 power_type=ipmi mac_addresses=['14:58:d0:54:6a:60'] power_parameters_power_address=172.16.1.17 power_parameters_power_pass=Winter2017 system_id=hnx7aa architecture=amd64/generic power_parameters_power_user=opnfv
2020-02-23 08:21:44,426 [salt.state       :300 ][INFO    ][6453] {'ret': {'updated': ['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02'], 'errors': {}, 'success': []}}
2020-02-23 08:21:44,426 [salt.state       :1951][INFO    ][6453] Completed state [maas.process_machines] at time 08:21:44.426812 duration_in_ms=4157.938
2020-02-23 08:21:44,431 [salt.minion      :1711][INFO    ][6453] Returning information for job: 20200223082129521522
2020-02-23 08:22:19,016 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command state.apply with jid 20200223082219003861
2020-02-23 08:22:19,043 [salt.minion      :1432][INFO    ][6500] Starting a new job with PID 6500
2020-02-23 08:22:27,217 [salt.state       :915 ][INFO    ][6500] Loading fresh modules for state activity
2020-02-23 08:22:27,327 [salt.state       :1780][INFO    ][6500] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 08:22:27.327520
2020-02-23 08:22:27,327 [salt.state       :1813][INFO    ][6500] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2020-02-23 08:22:27,330 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6500] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2020-02-23 08:22:29,585 [salt.state       :300 ][INFO    ][6500] {'pid': 6513, 'retcode': 0, 'stderr': '', 'stdout': ''}
2020-02-23 08:22:29,586 [salt.state       :1951][INFO    ][6500] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 08:22:29.586226 duration_in_ms=2258.707
2020-02-23 08:22:29,588 [salt.state       :1780][INFO    ][6500] Running state [maas.wait_for_machine_status] at time 08:22:29.588069
2020-02-23 08:22:29,589 [salt.state       :1813][INFO    ][6500] Executing state module.run for [maas.wait_for_machine_status]
2020-02-23 08:22:29,590 [salt.utils.decorators:613 ][WARNING ][6500] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-02-23 08:22:32,603 [salt.state       :300 ][INFO    ][6500] {'ret': True}
2020-02-23 08:22:32,603 [salt.state       :1951][INFO    ][6500] Completed state [maas.wait_for_machine_status] at time 08:22:32.603765 duration_in_ms=3015.695
2020-02-23 08:22:32,609 [salt.minion      :1711][INFO    ][6500] Returning information for job: 20200223082219003861
2020-02-23 08:22:33,573 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command state.apply with jid 20200223082233519956
2020-02-23 08:22:33,599 [salt.minion      :1432][INFO    ][6540] Starting a new job with PID 6540
2020-02-23 08:22:34,762 [salt.state       :915 ][INFO    ][6540] Loading fresh modules for state activity
2020-02-23 08:22:34,935 [salt.state       :1780][INFO    ][6540] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 08:22:34.935053
2020-02-23 08:22:34,935 [salt.state       :1813][INFO    ][6540] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2020-02-23 08:22:34,938 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6540] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2020-02-23 08:22:37,164 [salt.state       :300 ][INFO    ][6540] {'pid': 6547, 'retcode': 0, 'stderr': '', 'stdout': ''}
2020-02-23 08:22:37,166 [salt.state       :1951][INFO    ][6540] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 08:22:37.166207 duration_in_ms=2231.152
2020-02-23 08:22:37,170 [salt.state       :1780][INFO    ][6540] Running state [maas_machines_storage_cmp002_lvm] at time 08:22:37.170021
2020-02-23 08:22:37,170 [salt.state       :1813][INFO    ][6540] Executing state maasng.disk_layout_present for [maas_machines_storage_cmp002_lvm]
2020-02-23 08:22:38,488 [salt.loaded.ext.module.maasng:610 ][INFO    ][6540] arrwft
2020-02-23 08:22:38,489 [salt.loaded.ext.module.maasng:626 ][INFO    ][6540] sda
2020-02-23 08:22:39,081 [salt.loaded.ext.module.maasng:361 ][INFO    ][6540] arrwft
2020-02-23 08:22:39,182 [salt.loaded.ext.module.maasng:367 ][INFO    ][6540] [{u'resource_uri': u'/MAAS/api/2.0/nodes/arrwft/blockdevices/1/', u'uuid': None, u'tags': [u'ssd'], u'used_size': 800106479616, u'id': 1, u'filesystem': None, u'partitions': [{u'uuid': u'de2f9c99-9eef-4df4-8e0c-6a76937edfef', u'resource_uri': u'/MAAS/api/2.0/nodes/arrwft/blockdevices/1/partition/8', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'arrwft', u'filesystem': {u'mount_options': None, u'label': None, u'mount_point': None, u'uuid': u'd4785633-a1ac-4cbb-8f00-f7fce5219a5c', u'fstype': u'lvm-pv'}, u'path': u'/dev/disk/by-dname/sda-part1', u'size': 800101236736, u'type': u'partition', u'id': 8, u'device_id': 1}], u'name': u'sda', u'system_id': u'arrwft', u'partition_table_type': u'MBR', u'path': u'/dev/disk/by-dname/sda', u'id_path': u'/dev/disk/by-id/wwn-0x600508b1001cb19198eb9a66f8a29401', u'available_size': 0, u'model': u'LOGICAL VOLUME', u'block_size': 4096, u'type': u'physical', u'used_for': u'MBR partitioned with 1 partition', u'serial': u'600508b1001cb19198eb9a66f8a29401', u'size': 800109715456}, {u'resource_uri': u'/MAAS/api/2.0/nodes/arrwft/blockdevices/13/', u'uuid': u'6272d198-8250-44e7-b1bf-f5c7f59f5cdb', u'tags': [], u'used_size': 800097042432, u'id': 13, u'filesystem': {u'mount_options': None, u'label': u'root', u'mount_point': u'/', u'uuid': u'23367870-21ce-4841-9c07-1a2880f18f21', u'fstype': u'ext4'}, u'partitions': [], u'name': u'vgroot-lvroot', u'system_id': u'arrwft', u'partition_table_type': None, u'path': u'/dev/disk/by-dname/lvroot', u'id_path': None, u'available_size': 0, u'model': None, u'block_size': 4096, u'type': u'virtual', u'used_for': u'ext4 formatted filesystem mounted at /', u'serial': None, u'size': 800097042432}]
2020-02-23 08:22:39,183 [salt.loaded.ext.module.maasng:632 ][INFO    ][6540] vgroot
2020-02-23 08:22:39,183 [salt.loaded.ext.module.maasng:635 ][INFO    ][6540] lvroot
2020-02-23 08:22:39,184 [salt.loaded.ext.module.maasng:639 ][INFO    ][6540] 107374182400
2020-02-23 08:22:39,814 [salt.loaded.ext.module.maasng:645 ][INFO    ][6540] {u'domain': {u'resource_record_count': 0, u'name': u'maas', u'authoritative': True, u'is_default': True, u'ttl': None, u'id': 0, u'resource_uri': u'/MAAS/api/2.0/domains/0/'}, u'swap_size': None, u'ip_addresses': [], u'cpu_count': 40, u'owner_data': {}, u'hwe_kernel': None, u'boot_interface': {u'product': u'ProLiant BL460c Gen8 (735151-B21)', u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'hdkn4c', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/', u'id': 5002, u'secondary_rack': None, u'name': u'untagged'}, u'vendor': u'HP', u'name': u'eno1', 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'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'hdkn4c', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/', u'id': 5002, u'secondary_rack': None, u'name': u'untagged'}, 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'id': 63, u'mode': u'dhcp'}], u'tags': [u'sriov'], u'effective_mtu': 1500, u'enabled': True, u'parents': [], u'discovered': [], u'params': u'', u'mac_address': u'9c:b6:54:8a:10:18', u'id': 4, u'system_id': u'arrwft', u'firmware_version': u'bc 7.8.24', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/arrwft/interfaces/4/'}, u'node_type': 0, u'tag_names': [], u'testing_status_name': u'Passed', u'cpu_speed': 2800, u'owner': None, u'pod': None, u'cache_sets': [], u'iscsiblockdevice_set': [], u'status_action': u'', u'zone': {u'id': 1, u'resource_uri': u'/MAAS/api/2.0/zones/default/', u'name': u'default', u'description': u''}, u'resource_uri': u'/MAAS/api/2.0/machines/arrwft/', u'current_commissioning_result_id': 19, u'hardware_info': {u'mainboard_firmware_version': u'I31', u'mainboard_product': u'Unknown', u'system_vendor': u'HP', u'cpu_model': u'Intel(R) Xeon(R) CPU E5-2680 v2', u'mainboard_firmware_date': u'12/20/2013', u'mainboard_vendor': u'Unknown', u'system_serial': u'USE410T2Y0', u'system_version': u'Unknown', u'system_product': u'ProLiant BL460c Gen8 (735151-B21)'}, u'hostname': u'cmp002', u'storage': 800109.715456, u'testing_status': 2, u'system_id': u'arrwft', u'power_state': u'off', u'memory': 65536, u'current_installation_result_id': None, u'default_gateways': {u'ipv4': {u'gateway_ip': u'192.168.11.3', u'link_id': None}, u'ipv6': {u'gateway_ip': None, u'link_id': None}}, u'status_message': u'Power state queried: off', u'disable_ipv4': False, u'blockdevice_set': [{u'size': 800109715456, u'resource_uri': u'/MAAS/api/2.0/nodes/arrwft/blockdevices/1/', u'available_size': 0, u'uuid': None, u'name': u'sda', u'tags': [u'ssd'], u'type': u'physical', u'used_for': u'MBR partitioned with 1 partition', u'system_id': u'arrwft', u'partition_table_type': u'MBR', u'filesystem': None, u'id_path': u'/dev/disk/by-id/wwn-0x600508b1001cb19198eb9a66f8a29401', u'path': u'/dev/disk/by-dname/sda', u'model': u'LOGICAL VOLUME', u'block_size': 4096, u'used_size': 800106479616, u'id': 1, u'serial': u'600508b1001cb19198eb9a66f8a29401', u'partitions': [{u'uuid': u'c33e11ec-6eb6-4ea7-ac22-c77097e52642', u'resource_uri': u'/MAAS/api/2.0/nodes/arrwft/blockdevices/1/partition/10', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'arrwft', u'filesystem': {u'mount_options': None, u'label': None, u'mount_point': None, u'uuid': u'64a3bc9d-b7d1-4697-a112-3f1a6a7ae587', u'fstype': u'lvm-pv'}, u'path': u'/dev/disk/by-dname/sda-part1', u'device_id': 1, u'type': u'partition', u'id': 10, u'size': 800101236736}]}, {u'size': 107374182400, u'resource_uri': u'/MAAS/api/2.0/nodes/arrwft/blockdevices/15/', u'available_size': 0, u'uuid': u'd88b7a54-aa06-4219-8d3b-5e2cb5714be8', u'name': u'vgroot-lvroot', u'tags': [], u'type': u'virtual', u'used_for': u'ext4 formatted filesystem mounted at /', u'system_id': u'arrwft', u'partition_table_type': None, u'filesystem': {u'mount_options': None, u'label': u'root', u'mount_point': u'/', u'uuid': u'7905b2b8-1d19-48cf-8087-5dd83e6f8064', u'fstype': u'ext4'}, u'id_path': None, u'path': u'/dev/disk/by-dname/lvroot', u'model': None, u'block_size': 4096, u'used_size': 107374182400, u'id': 15, u'serial': None, u'partitions': []}], u'status': 4, u'bcaches': [], u'storage_test_status_name': u'Passed', u'raids': [], 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'ssd'], u'type': u'physical', u'id': 1, u'used_for': u'MBR partitioned with 1 partition', u'resource_uri': u'/MAAS/api/2.0/nodes/arrwft/blockdevices/1/', u'system_id': u'arrwft', u'partition_table_type': u'MBR', u'filesystem': None, u'id_path': u'/dev/disk/by-id/wwn-0x600508b1001cb19198eb9a66f8a29401', u'path': u'/dev/disk/by-dname/sda', u'firmware_version': u'5.22', u'size': 800109715456, u'used_size': 800106479616, u'model': u'LOGICAL VOLUME', u'serial': u'600508b1001cb19198eb9a66f8a29401', u'partitions': [{u'uuid': u'c33e11ec-6eb6-4ea7-ac22-c77097e52642', u'resource_uri': u'/MAAS/api/2.0/nodes/arrwft/blockdevices/1/partition/10', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'arrwft', u'filesystem': {u'mount_options': None, u'label': None, u'mount_point': None, u'uuid': u'64a3bc9d-b7d1-4697-a112-3f1a6a7ae587', u'fstype': u'lvm-pv'}, u'path': u'/dev/disk/by-dname/sda-part1', u'device_id': 1, u'type': u'partition', u'id': 10, u'size': 800101236736}]}], u'other_test_status_name': u'Unknown', u'volume_groups': [{u'__incomplete__': True, u'system_id': u'arrwft', u'id': 10}], u'special_filesystems': [], u'cpu_test_status_name': u'Unknown', u'node_type_name': u'Machine', u'current_testing_result_id': 20, u'cpu_test_status': -1, u'pool': {u'id': 0, u'resource_uri': u'/MAAS/api/2.0/resourcepool/0/', u'name': u'default', u'description': u'Default pool'}, u'architecture': u'amd64/generic', u'storage_test_status': 2, u'other_test_status': -1, u'locked': False, u'status_name': u'Ready', u'netboot': True, u'osystem': u'', u'fqdn': u'cmp002.maas', u'memory_test_status_name': u'Unknown', u'virtualblockdevice_set': [{u'block_size': 4096, u'available_size': 0, u'uuid': u'd88b7a54-aa06-4219-8d3b-5e2cb5714be8', u'name': u'vgroot-lvroot', u'tags': [], u'type': u'virtual', u'used_for': u'ext4 formatted filesystem mounted at /', u'resource_uri': u'/MAAS/api/2.0/nodes/arrwft/blockdevices/15/', u'system_id': u'arrwft', u'partition_table_type': None, u'filesystem': {u'mount_options': None, u'label': u'root', u'mount_point': u'/', u'uuid': u'7905b2b8-1d19-48cf-8087-5dd83e6f8064', u'fstype': u'ext4'}, u'id_path': None, u'path': u'/dev/disk/by-dname/vgroot-lvroot', u'model': None, u'partitions': [], u'used_size': 107374182400, u'id': 15, u'serial': None, u'size': 107374182400}], u'commissioning_status': 2, u'min_hwe_kernel': u'ga-18.04', u'commissioning_status_name': u'Passed', u'interface_set': [{u'product': u'ProLiant BL460c Gen8 (735151-B21)', u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'hdkn4c', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/', u'id': 5002, u'secondary_rack': None, u'name': u'untagged'}, u'vendor': u'HP', u'name': u'eno1', 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'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'hdkn4c', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/', u'id': 5002, u'secondary_rack': None, u'name': u'untagged'}, 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'id': 63, u'mode': u'dhcp'}], u'tags': [u'sriov'], u'effective_mtu': 1500, u'enabled': True, u'parents': [], u'discovered': [], u'params': u'', u'mac_address': u'9c:b6:54:8a:10:18', u'id': 4, u'system_id': u'arrwft', u'firmware_version': u'bc 7.8.24', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/arrwft/interfaces/4/'}, {u'product': u'ProLiant BL460c Gen8 (735151-B21)', u'vlan': None, u'vendor': u'HP', u'name': u'ens1f0', u'links': [], u'tags': [u'sriov'], u'effective_mtu': 1500, u'enabled': True, u'parents': [], u'discovered': None, u'params': u'', u'mac_address': u'38:ea:a7:8f:07:50', u'id': 11, u'system_id': u'arrwft', u'firmware_version': u'bc 7.8.24', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/arrwft/interfaces/11/'}, {u'product': u'ProLiant BL460c Gen8 (735151-B21)', u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'hdkn4c', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/', u'id': 5002, u'secondary_rack': None, u'name': u'untagged'}, u'vendor': u'HP', u'name': u'eno2', 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'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'hdkn4c', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/', u'id': 5002, u'secondary_rack': None, u'name': u'untagged'}, 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'id': 64, u'mode': u'link_up'}], u'tags': [u'sriov'], u'effective_mtu': 1500, u'enabled': True, u'parents': [], u'discovered': [], u'params': u'', u'mac_address': u'9c:b6:54:8a:10:1c', u'id': 12, u'system_id': u'arrwft', u'firmware_version': u'bc 7.8.24', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/arrwft/interfaces/12/'}, {u'product': u'ProLiant BL460c Gen8 (735151-B21)', u'vlan': None, u'vendor': u'HP', u'name': u'ens1f1', u'links': [], u'tags': [u'sriov'], u'effective_mtu': 1500, u'enabled': True, u'parents': [], u'discovered': None, u'params': u'', u'mac_address': u'38:ea:a7:8f:07:51', u'id': 13, u'system_id': u'arrwft', u'firmware_version': u'bc 7.8.24', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/arrwft/interfaces/13/'}, {u'product': u'ProLiant BL460c Gen8 (735151-B21)', u'vlan': {u'fabric': u'fabric-0', u'vid': 0, u'space': u'undefined', u'fabric_id': 0, u'dhcp_on': False, u'mtu': 1500, u'primary_rack': None, u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/', u'id': 5001, u'secondary_rack': None, u'name': u'untagged'}, u'vendor': u'HP', u'name': u'ens2f0', u'links': [{u'id': 65, u'mode': u'link_up'}], u'tags': [u'sriov'], u'effective_mtu': 1500, u'enabled': True, u'parents': [], u'discovered': None, u'params': u'', u'mac_address': u'38:ea:a7:8f:12:48', u'id': 14, u'system_id': u'arrwft', u'firmware_version': u'bc 7.8.24', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/arrwft/interfaces/14/'}, {u'product': u'ProLiant BL460c Gen8 (735151-B21)', u'vlan': {u'fabric': u'fabric-0', u'vid': 0, u'space': u'undefined', u'fabric_id': 0, u'dhcp_on': False, u'mtu': 1500, u'primary_rack': None, u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/', u'id': 5001, u'secondary_rack': None, u'name': u'untagged'}, u'vendor': u'HP', u'name': u'ens2f1', u'links': [{u'id': 66, u'mode': u'link_up'}], u'tags': [u'sriov'], u'effective_mtu': 1500, u'enabled': True, u'parents': [], u'discovered': None, u'params': u'', u'mac_address': u'38:ea:a7:8f:12:49', u'id': 15, u'system_id': u'arrwft', u'firmware_version': u'bc 7.8.24', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/arrwft/interfaces/15/'}], u'address_ttl': None, u'memory_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'ssd'], u'type': u'physical', u'id': 1, u'used_for': u'MBR partitioned with 1 partition', u'resource_uri': u'/MAAS/api/2.0/nodes/arrwft/blockdevices/1/', u'system_id': u'arrwft', u'partition_table_type': u'MBR', u'filesystem': None, u'id_path': u'/dev/disk/by-id/wwn-0x600508b1001cb19198eb9a66f8a29401', u'path': u'/dev/disk/by-dname/sda', u'firmware_version': u'5.22', u'size': 800109715456, u'used_size': 800106479616, u'model': u'LOGICAL VOLUME', u'serial': u'600508b1001cb19198eb9a66f8a29401', u'partitions': [{u'uuid': u'c33e11ec-6eb6-4ea7-ac22-c77097e52642', u'resource_uri': u'/MAAS/api/2.0/nodes/arrwft/blockdevices/1/partition/10', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'arrwft', u'filesystem': {u'mount_options': None, u'label': None, u'mount_point': None, u'uuid': u'64a3bc9d-b7d1-4697-a112-3f1a6a7ae587', u'fstype': u'lvm-pv'}, u'path': u'/dev/disk/by-dname/sda-part1', u'device_id': 1, u'type': u'partition', u'id': 10, u'size': 800101236736}]}}
2020-02-23 08:22:39,817 [salt.state       :300 ][INFO    ][6540] {'new': {'storage_layout': 'lvm'}}
2020-02-23 08:22:39,817 [salt.state       :1951][INFO    ][6540] Completed state [maas_machines_storage_cmp002_lvm] at time 08:22:39.817683 duration_in_ms=2647.662
2020-02-23 08:22:39,818 [salt.state       :1780][INFO    ][6540] Running state [maas_machines_storage_cmp001_lvm] at time 08:22:39.818120
2020-02-23 08:22:39,818 [salt.state       :1813][INFO    ][6540] Executing state maasng.disk_layout_present for [maas_machines_storage_cmp001_lvm]
2020-02-23 08:22:41,043 [salt.loaded.ext.module.maasng:610 ][INFO    ][6540] pm8hsd
2020-02-23 08:22:41,044 [salt.loaded.ext.module.maasng:626 ][INFO    ][6540] sda
2020-02-23 08:22:41,647 [salt.loaded.ext.module.maasng:361 ][INFO    ][6540] pm8hsd
2020-02-23 08:22:41,729 [salt.loaded.ext.module.maasng:367 ][INFO    ][6540] [{u'resource_uri': u'/MAAS/api/2.0/nodes/pm8hsd/blockdevices/2/', u'uuid': None, u'name': u'sda', u'tags': [u'ssd'], u'type': u'physical', u'partitions': [{u'uuid': u'b9803e82-d575-4d6c-8684-1eb694c91a30', u'resource_uri': u'/MAAS/api/2.0/nodes/pm8hsd/blockdevices/2/partition/9', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'pm8hsd', u'filesystem': {u'mount_options': None, u'label': None, u'mount_point': None, u'uuid': u'59b20ef0-8b1e-4880-9726-e29d61189fcb', u'fstype': u'lvm-pv'}, u'path': u'/dev/disk/by-dname/sda-part1', u'size': 800101236736, u'type': u'partition', u'id': 9, u'device_id': 2}], u'used_for': u'MBR partitioned with 1 partition', u'path': u'/dev/disk/by-dname/sda', u'system_id': u'pm8hsd', u'partition_table_type': u'MBR', u'filesystem': None, u'id_path': u'/dev/disk/by-id/wwn-0x600508b1001cd7e61f5cd3479576479e', u'available_size': 0, u'model': u'LOGICAL VOLUME', u'block_size': 4096, u'used_size': 800106479616, u'id': 2, u'serial': u'600508b1001cd7e61f5cd3479576479e', u'size': 800109715456}, {u'resource_uri': u'/MAAS/api/2.0/nodes/pm8hsd/blockdevices/14/', u'uuid': u'd90ec247-e811-4280-82e5-edda1de6dc90', u'name': u'vgroot-lvroot', u'tags': [], u'type': u'virtual', u'partitions': [], u'used_for': u'ext4 formatted filesystem mounted at /', u'path': u'/dev/disk/by-dname/lvroot', u'system_id': u'pm8hsd', u'partition_table_type': None, u'filesystem': {u'mount_options': None, u'label': u'root', u'mount_point': u'/', u'uuid': u'71d92d8d-99ab-4451-99a5-0d020378f8a2', u'fstype': u'ext4'}, u'id_path': None, u'available_size': 0, u'model': None, u'block_size': 4096, u'used_size': 800097042432, u'id': 14, u'serial': None, u'size': 800097042432}]
2020-02-23 08:22:41,729 [salt.loaded.ext.module.maasng:632 ][INFO    ][6540] vgroot
2020-02-23 08:22:41,729 [salt.loaded.ext.module.maasng:635 ][INFO    ][6540] lvroot
2020-02-23 08:22:41,729 [salt.loaded.ext.module.maasng:639 ][INFO    ][6540] 107374182400
2020-02-23 08:22:42,335 [salt.loaded.ext.module.maasng:645 ][INFO    ][6540] {u'hwe_kernel': None, u'testing_status_name': u'Passed', u'disable_ipv4': False, u'cpu_count': 40, u'power_type': u'ipmi', u'domain': {u'resource_record_count': 0, u'name': u'maas', u'authoritative': True, u'is_default': True, u'ttl': None, u'id': 0, u'resource_uri': u'/MAAS/api/2.0/domains/0/'}, u'boot_interface': {u'product': u'ProLiant BL460c Gen8 (735151-B21)', u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'hdkn4c', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/', u'id': 5002, u'secondary_rack': None, u'name': u'untagged'}, u'vendor': u'HP', u'name': u'eno1', 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'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'hdkn4c', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/', u'id': 5002, u'secondary_rack': None, u'name': u'untagged'}, 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'id': 70, u'mode': u'dhcp'}], u'tags': [u'sriov'], u'mac_address': u'9c:b6:54:8a:95:a0', u'enabled': True, u'parents': [], u'discovered': [], u'system_id': u'pm8hsd', u'effective_mtu': 1500, u'id': 5, u'params': u'', u'firmware_version': u'bc 7.8.24', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/pm8hsd/interfaces/5/'}, u'fqdn': u'cmp001.maas', u'status_action': u'', u'tag_names': [], u'swap_size': None, u'cpu_speed': 2800, u'owner': None, u'pod': None, u'cache_sets': [], u'cpu_test_status_name': u'Unknown', u'iscsiblockdevice_set': [], u'boot_disk': {u'model': u'LOGICAL VOLUME', u'resource_uri': u'/MAAS/api/2.0/nodes/pm8hsd/blockdevices/2/', u'available_size': 0, u'uuid': None, u'name': u'sda', u'tags': [u'ssd'], u'type': u'physical', u'partitions': [{u'uuid': u'3d9e5c3a-7aa4-4238-8d2c-25b6f115412b', u'resource_uri': u'/MAAS/api/2.0/nodes/pm8hsd/blockdevices/2/partition/11', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'pm8hsd', u'filesystem': {u'mount_options': None, u'label': None, u'mount_point': None, u'uuid': u'3513dfb1-7509-4716-ae1e-6857dcaf5236', u'fstype': u'lvm-pv'}, u'path': u'/dev/disk/by-dname/sda-part1', u'size': 800101236736, u'type': u'partition', u'id': 11, u'device_id': 2}], u'id': 2, u'used_for': u'MBR partitioned with 1 partition', u'system_id': u'pm8hsd', u'partition_table_type': u'MBR', u'filesystem': None, u'id_path': u'/dev/disk/by-id/wwn-0x600508b1001cd7e61f5cd3479576479e', u'path': u'/dev/disk/by-dname/sda', u'firmware_version': u'5.22', u'block_size': 4096, u'used_size': 800106479616, u'serial': u'600508b1001cd7e61f5cd3479576479e', u'size': 800109715456}, u'zone': {u'id': 1, u'resource_uri': u'/MAAS/api/2.0/zones/default/', u'name': u'default', u'description': u''}, u'resource_uri': u'/MAAS/api/2.0/machines/pm8hsd/', u'hardware_info': {u'mainboard_firmware_version': u'I31', u'mainboard_product': u'Unknown', u'system_vendor': u'HP', u'cpu_model': u'Intel(R) Xeon(R) CPU E5-2680 v2', u'mainboard_firmware_date': u'06/01/2015', u'mainboard_vendor': u'Unknown', u'system_serial': u'USE410T2XY', u'system_version': u'Unknown', u'system_product': u'ProLiant BL460c Gen8 (735151-B21)'}, u'hostname': u'cmp001', u'storage': 800109.715456, u'testing_status': 2, u'system_id': u'pm8hsd', u'raids': [], u'memory': 65536, u'current_installation_result_id': None, u'default_gateways': {u'ipv4': {u'gateway_ip': u'192.168.11.3', u'link_id': None}, u'ipv6': {u'gateway_ip': None, u'link_id': None}}, u'status_message': u'Power state queried: off', u'ip_addresses': [], u'min_hwe_kernel': u'ga-18.04', u'status': 4, u'bcaches': [], u'storage_test_status_name': u'Passed', u'power_state': u'off', u'owner_data': {}, u'other_test_status_name': u'Unknown', u'volume_groups': [{u'__incomplete__': True, u'system_id': u'pm8hsd', u'id': 11}], u'special_filesystems': [], u'current_commissioning_result_id': 21, u'node_type_name': u'Machine', u'current_testing_result_id': 22, u'cpu_test_status': -1, u'pool': {u'id': 0, u'resource_uri': u'/MAAS/api/2.0/resourcepool/0/', u'name': u'default', u'description': u'Default pool'}, u'storage_test_status': 2, u'other_test_status': -1, u'locked': False, u'status_name': u'Ready', u'physicalblockdevice_set': [{u'model': u'LOGICAL VOLUME', u'resource_uri': u'/MAAS/api/2.0/nodes/pm8hsd/blockdevices/2/', u'available_size': 0, u'uuid': None, u'name': u'sda', u'tags': [u'ssd'], u'type': u'physical', u'partitions': [{u'uuid': u'3d9e5c3a-7aa4-4238-8d2c-25b6f115412b', u'resource_uri': u'/MAAS/api/2.0/nodes/pm8hsd/blockdevices/2/partition/11', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'pm8hsd', u'filesystem': {u'mount_options': None, u'label': None, u'mount_point': None, u'uuid': u'3513dfb1-7509-4716-ae1e-6857dcaf5236', u'fstype': u'lvm-pv'}, u'path': u'/dev/disk/by-dname/sda-part1', u'size': 800101236736, u'type': u'partition', u'id': 11, u'device_id': 2}], u'id': 2, u'used_for': u'MBR partitioned with 1 partition', u'system_id': u'pm8hsd', u'partition_table_type': u'MBR', u'filesystem': None, u'id_path': u'/dev/disk/by-id/wwn-0x600508b1001cd7e61f5cd3479576479e', u'path': u'/dev/disk/by-dname/sda', u'firmware_version': u'5.22', u'block_size': 4096, u'used_size': 800106479616, u'serial': u'600508b1001cd7e61f5cd3479576479e', u'size': 800109715456}], u'netboot': True, u'osystem': u'', u'node_type': 0, u'memory_test_status_name': u'Unknown', u'virtualblockdevice_set': [{u'resource_uri': u'/MAAS/api/2.0/nodes/pm8hsd/blockdevices/16/', u'available_size': 0, u'uuid': u'ed326531-0026-4bad-9085-7de948e6a5cb', 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'pm8hsd', u'partition_table_type': None, u'filesystem': {u'mount_options': None, u'label': u'root', u'mount_point': u'/', u'uuid': u'1818d73b-a1a7-4617-be0c-dfe314637c1e', u'fstype': u'ext4'}, u'id_path': None, u'path': u'/dev/disk/by-dname/vgroot-lvroot', u'serial': None, u'block_size': 4096, u'used_size': 107374182400, u'model': None, u'size': 107374182400}], u'commissioning_status': 2, u'architecture': u'amd64/generic', u'commissioning_status_name': u'Passed', u'interface_set': [{u'product': u'ProLiant BL460c Gen8 (735151-B21)', u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'hdkn4c', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/', u'id': 5002, u'secondary_rack': None, u'name': u'untagged'}, u'vendor': u'HP', u'name': u'eno1', 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'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'hdkn4c', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/', u'id': 5002, u'secondary_rack': None, u'name': u'untagged'}, 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'id': 70, u'mode': u'dhcp'}], u'tags': [u'sriov'], u'mac_address': u'9c:b6:54:8a:95:a0', u'enabled': True, u'parents': [], u'discovered': [], u'system_id': u'pm8hsd', u'effective_mtu': 1500, u'id': 5, u'params': u'', u'firmware_version': u'bc 7.8.24', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/pm8hsd/interfaces/5/'}, {u'product': u'ProLiant BL460c Gen8 (735151-B21)', u'vlan': None, u'vendor': u'HP', u'name': u'ens1f0', u'links': [], u'tags': [u'sriov'], u'mac_address': u'38:ea:a7:8f:1f:d4', u'enabled': True, u'parents': [], u'discovered': None, u'system_id': u'pm8hsd', u'effective_mtu': 1500, u'id': 16, u'params': u'', u'firmware_version': u'bc 7.8.24', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/pm8hsd/interfaces/16/'}, {u'product': u'ProLiant BL460c Gen8 (735151-B21)', u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'hdkn4c', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/', u'id': 5002, u'secondary_rack': None, u'name': u'untagged'}, u'vendor': u'HP', u'name': u'eno2', 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'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'hdkn4c', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/', u'id': 5002, u'secondary_rack': None, u'name': u'untagged'}, 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'id': 71, u'mode': u'link_up'}], u'tags': [u'sriov'], u'mac_address': u'9c:b6:54:8a:95:a4', u'enabled': True, u'parents': [], u'discovered': [], u'system_id': u'pm8hsd', u'effective_mtu': 1500, u'id': 17, u'params': u'', u'firmware_version': u'bc 7.8.24', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/pm8hsd/interfaces/17/'}, {u'product': u'ProLiant BL460c Gen8 (735151-B21)', u'vlan': None, u'vendor': u'HP', u'name': u'ens1f1', u'links': [], u'tags': [u'sriov'], u'mac_address': u'38:ea:a7:8f:1f:d5', u'enabled': True, u'parents': [], u'discovered': None, u'system_id': u'pm8hsd', u'effective_mtu': 1500, u'id': 18, u'params': u'', u'firmware_version': u'bc 7.8.24', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/pm8hsd/interfaces/18/'}, {u'product': u'ProLiant BL460c Gen8 (735151-B21)', u'vlan': {u'fabric': u'fabric-0', u'vid': 0, u'space': u'undefined', u'fabric_id': 0, u'dhcp_on': False, u'mtu': 1500, u'primary_rack': None, u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/', u'id': 5001, u'secondary_rack': None, u'name': u'untagged'}, u'vendor': u'HP', u'name': u'ens2f0', u'links': [{u'id': 72, u'mode': u'link_up'}], u'tags': [u'sriov'], u'mac_address': u'38:ea:a7:8f:52:cc', u'enabled': True, u'parents': [], u'discovered': None, u'system_id': u'pm8hsd', u'effective_mtu': 1500, u'id': 19, u'params': u'', u'firmware_version': u'bc 7.8.24', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/pm8hsd/interfaces/19/'}, {u'product': u'ProLiant BL460c Gen8 (735151-B21)', u'vlan': {u'fabric': u'fabric-0', u'vid': 0, u'space': u'undefined', u'fabric_id': 0, u'dhcp_on': False, u'mtu': 1500, u'primary_rack': None, u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/', u'id': 5001, u'secondary_rack': None, u'name': u'untagged'}, u'vendor': u'HP', u'name': u'ens2f1', u'links': [{u'id': 73, u'mode': u'link_up'}], u'tags': [u'sriov'], u'mac_address': u'38:ea:a7:8f:52:cd', u'enabled': True, u'parents': [], u'discovered': None, u'system_id': u'pm8hsd', u'effective_mtu': 1500, u'id': 20, u'params': u'', u'firmware_version': u'bc 7.8.24', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/pm8hsd/interfaces/20/'}], u'address_ttl': None, u'blockdevice_set': [{u'resource_uri': u'/MAAS/api/2.0/nodes/pm8hsd/blockdevices/2/', u'available_size': 0, u'uuid': None, u'name': u'sda', u'tags': [u'ssd'], u'type': u'physical', u'partitions': [{u'uuid': u'3d9e5c3a-7aa4-4238-8d2c-25b6f115412b', u'resource_uri': u'/MAAS/api/2.0/nodes/pm8hsd/blockdevices/2/partition/11', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'pm8hsd', u'filesystem': {u'mount_options': None, u'label': None, u'mount_point': None, u'uuid': u'3513dfb1-7509-4716-ae1e-6857dcaf5236', u'fstype': u'lvm-pv'}, u'path': u'/dev/disk/by-dname/sda-part1', u'size': 800101236736, u'type': u'partition', u'id': 11, u'device_id': 2}], u'id': 2, u'used_for': u'MBR partitioned with 1 partition', u'system_id': u'pm8hsd', u'partition_table_type': u'MBR', u'filesystem': None, u'id_path': u'/dev/disk/by-id/wwn-0x600508b1001cd7e61f5cd3479576479e', u'path': u'/dev/disk/by-dname/sda', u'serial': u'600508b1001cd7e61f5cd3479576479e', u'block_size': 4096, u'used_size': 800106479616, u'model': u'LOGICAL VOLUME', u'size': 800109715456}, {u'resource_uri': u'/MAAS/api/2.0/nodes/pm8hsd/blockdevices/16/', u'available_size': 0, u'uuid': u'ed326531-0026-4bad-9085-7de948e6a5cb', 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'pm8hsd', u'partition_table_type': None, u'filesystem': {u'mount_options': None, u'label': u'root', u'mount_point': u'/', u'uuid': u'1818d73b-a1a7-4617-be0c-dfe314637c1e', u'fstype': u'ext4'}, u'id_path': None, u'path': u'/dev/disk/by-dname/lvroot', u'serial': None, u'block_size': 4096, u'used_size': 107374182400, u'model': None, u'size': 107374182400}], u'distro_series': u'', u'memory_test_status': -1}
2020-02-23 08:22:42,338 [salt.state       :300 ][INFO    ][6540] {'new': {'storage_layout': 'lvm'}}
2020-02-23 08:22:42,339 [salt.state       :1951][INFO    ][6540] Completed state [maas_machines_storage_cmp001_lvm] at time 08:22:42.338975 duration_in_ms=2520.853
2020-02-23 08:22:42,341 [salt.minion      :1711][INFO    ][6540] Returning information for job: 20200223082233519956
2020-02-23 08:22:43,313 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command state.apply with jid 20200223082243295812
2020-02-23 08:22:43,339 [salt.minion      :1432][INFO    ][6559] Starting a new job with PID 6559
2020-02-23 08:22:51,546 [salt.state       :915 ][INFO    ][6559] Loading fresh modules for state activity
2020-02-23 08:22:51,654 [salt.state       :1780][INFO    ][6559] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 08:22:51.654873
2020-02-23 08:22:51,655 [salt.state       :1813][INFO    ][6559] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2020-02-23 08:22:51,657 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6559] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2020-02-23 08:22:53,918 [salt.state       :300 ][INFO    ][6559] {'pid': 6572, 'retcode': 0, 'stderr': '', 'stdout': ''}
2020-02-23 08:22:53,919 [salt.state       :1951][INFO    ][6559] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 08:22:53.919412 duration_in_ms=2264.54
2020-02-23 08:22:53,922 [salt.state       :1780][INFO    ][6559] Running state [maas.deploy_machines] at time 08:22:53.921938
2020-02-23 08:22:53,922 [salt.state       :1813][INFO    ][6559] Executing state module.run for [maas.deploy_machines]
2020-02-23 08:22:53,922 [salt.utils.decorators:613 ][WARNING ][6559] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-02-23 08:22:54,674 [salt.loaded.ext.module.maas:684 ][INFO    ][6559] deploymachines hwe_kernel=ga-18.04 system_id=arrwft distro_series=bionic
2020-02-23 08:22:56,543 [salt.loaded.ext.module.maas:684 ][INFO    ][6559] deploymachines hwe_kernel=ga-18.04 system_id=pm8hsd distro_series=bionic
2020-02-23 08:22:58,401 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223082258389869
2020-02-23 08:22:58,425 [salt.minion      :1432][INFO    ][6589] Starting a new job with PID 6589
2020-02-23 08:22:58,445 [salt.state       :300 ][INFO    ][6559] {'ret': {'updated': ['kvm01', 'kvm03', 'kvm02'], 'errors': {}, 'success': ['cmp002', 'cmp001']}}
2020-02-23 08:22:58,446 [salt.state       :1951][INFO    ][6559] Completed state [maas.deploy_machines] at time 08:22:58.445935 duration_in_ms=4523.995
2020-02-23 08:22:58,450 [salt.minion      :1711][INFO    ][6559] Returning information for job: 20200223082243295812
2020-02-23 08:22:58,462 [salt.minion      :1711][INFO    ][6589] Returning information for job: 20200223082258389869
2020-02-23 08:22:59,323 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command state.apply with jid 20200223082259309886
2020-02-23 08:22:59,361 [salt.minion      :1432][INFO    ][6602] Starting a new job with PID 6602
2020-02-23 08:23:00,521 [salt.state       :915 ][INFO    ][6602] Loading fresh modules for state activity
2020-02-23 08:23:00,634 [salt.state       :1780][INFO    ][6602] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 08:23:00.634693
2020-02-23 08:23:00,635 [salt.state       :1813][INFO    ][6602] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2020-02-23 08:23:00,637 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6602] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2020-02-23 08:23:03,021 [salt.state       :300 ][INFO    ][6602] {'pid': 6611, 'retcode': 0, 'stderr': '', 'stdout': ''}
2020-02-23 08:23:03,022 [salt.state       :1951][INFO    ][6602] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 08:23:03.022280 duration_in_ms=2387.588
2020-02-23 08:23:03,026 [salt.state       :1780][INFO    ][6602] Running state [maas.wait_for_machine_status] at time 08:23:03.026071
2020-02-23 08:23:03,026 [salt.state       :1813][INFO    ][6602] Executing state module.run for [maas.wait_for_machine_status]
2020-02-23 08:23:03,027 [salt.utils.decorators:613 ][WARNING ][6602] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-02-23 08:23:06,062 [salt.loaded.ext.module.maas:1024][INFO    ][6602] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (2246.98445702s left)
2020-02-23 08:23:14,366 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223082314354151
2020-02-23 08:23:14,387 [salt.minion      :1432][INFO    ][6632] Starting a new job with PID 6632
2020-02-23 08:23:14,415 [salt.minion      :1711][INFO    ][6632] Returning information for job: 20200223082314354151
2020-02-23 08:23:39,283 [salt.loaded.ext.module.maas:1024][INFO    ][6602] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (2213.76303792s left)
2020-02-23 08:23:44,446 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223082344438185
2020-02-23 08:23:44,474 [salt.minion      :1432][INFO    ][6678] Starting a new job with PID 6678
2020-02-23 08:23:44,499 [salt.minion      :1711][INFO    ][6678] Returning information for job: 20200223082344438185
2020-02-23 08:24:12,368 [salt.loaded.ext.module.maas:1024][INFO    ][6602] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (2180.67849588s left)
2020-02-23 08:24:14,527 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223082414511690
2020-02-23 08:24:14,557 [salt.minion      :1432][INFO    ][6706] Starting a new job with PID 6706
2020-02-23 08:24:14,582 [salt.minion      :1711][INFO    ][6706] Returning information for job: 20200223082414511690
2020-02-23 08:24:44,610 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223082444595833
2020-02-23 08:24:44,632 [salt.minion      :1432][INFO    ][6734] Starting a new job with PID 6734
2020-02-23 08:24:44,660 [salt.minion      :1711][INFO    ][6734] Returning information for job: 20200223082444595833
2020-02-23 08:24:45,698 [salt.loaded.ext.module.maas:1024][INFO    ][6602] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (2147.34774089s left)
2020-02-23 08:25:14,683 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223082514665660
2020-02-23 08:25:14,707 [salt.minion      :1432][INFO    ][6758] Starting a new job with PID 6758
2020-02-23 08:25:14,732 [salt.minion      :1711][INFO    ][6758] Returning information for job: 20200223082514665660
2020-02-23 08:25:18,965 [salt.loaded.ext.module.maas:1024][INFO    ][6602] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (2114.08090901s left)
2020-02-23 08:25:44,764 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223082544753093
2020-02-23 08:25:44,789 [salt.minion      :1432][INFO    ][6798] Starting a new job with PID 6798
2020-02-23 08:25:44,814 [salt.minion      :1711][INFO    ][6798] Returning information for job: 20200223082544753093
2020-02-23 08:25:52,230 [salt.loaded.ext.module.maas:1024][INFO    ][6602] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (2080.81583095s left)
2020-02-23 08:26:14,864 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223082614848916
2020-02-23 08:26:14,892 [salt.minion      :1432][INFO    ][6857] Starting a new job with PID 6857
2020-02-23 08:26:14,923 [salt.minion      :1711][INFO    ][6857] Returning information for job: 20200223082614848916
2020-02-23 08:26:25,540 [salt.loaded.ext.module.maas:1024][INFO    ][6602] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (2047.50583386s left)
2020-02-23 08:26:44,957 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223082644942914
2020-02-23 08:26:44,983 [salt.minion      :1432][INFO    ][6914] Starting a new job with PID 6914
2020-02-23 08:26:45,023 [salt.minion      :1711][INFO    ][6914] Returning information for job: 20200223082644942914
2020-02-23 08:26:59,113 [salt.loaded.ext.module.maas:1024][INFO    ][6602] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (2013.9328599s left)
2020-02-23 08:27:15,079 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223082715065823
2020-02-23 08:27:15,108 [salt.minion      :1432][INFO    ][6941] Starting a new job with PID 6941
2020-02-23 08:27:15,141 [salt.minion      :1711][INFO    ][6941] Returning information for job: 20200223082715065823
2020-02-23 08:27:33,167 [salt.loaded.ext.module.maas:1024][INFO    ][6602] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (1979.87940502s left)
2020-02-23 08:27:45,195 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223082745176610
2020-02-23 08:27:45,227 [salt.minion      :1432][INFO    ][6968] Starting a new job with PID 6968
2020-02-23 08:27:45,253 [salt.minion      :1711][INFO    ][6968] Returning information for job: 20200223082745176610
2020-02-23 08:28:06,551 [salt.loaded.ext.module.maas:1024][INFO    ][6602] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (1946.49531102s left)
2020-02-23 08:28:15,298 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223082815285468
2020-02-23 08:28:15,326 [salt.minion      :1432][INFO    ][6993] Starting a new job with PID 6993
2020-02-23 08:28:15,363 [salt.minion      :1711][INFO    ][6993] Returning information for job: 20200223082815285468
2020-02-23 08:28:40,013 [salt.loaded.ext.module.maas:1024][INFO    ][6602] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (1913.03359199s left)
2020-02-23 08:28:45,415 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223082845400921
2020-02-23 08:28:45,441 [salt.minion      :1432][INFO    ][7023] Starting a new job with PID 7023
2020-02-23 08:28:45,469 [salt.minion      :1711][INFO    ][7023] Returning information for job: 20200223082845400921
2020-02-23 08:29:13,542 [salt.loaded.ext.module.maas:1024][INFO    ][6602] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (1879.50387001s left)
2020-02-23 08:29:15,513 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223082915505028
2020-02-23 08:29:15,527 [salt.minion      :1432][INFO    ][7048] Starting a new job with PID 7048
2020-02-23 08:29:15,555 [salt.minion      :1711][INFO    ][7048] Returning information for job: 20200223082915505028
2020-02-23 08:29:45,610 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223082945602788
2020-02-23 08:29:45,629 [salt.minion      :1432][INFO    ][7075] Starting a new job with PID 7075
2020-02-23 08:29:45,659 [salt.minion      :1711][INFO    ][7075] Returning information for job: 20200223082945602788
2020-02-23 08:29:47,029 [salt.loaded.ext.module.maas:1024][INFO    ][6602] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (1846.01679087s left)
2020-02-23 08:30:15,731 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223083015721636
2020-02-23 08:30:15,761 [salt.minion      :1432][INFO    ][7100] Starting a new job with PID 7100
2020-02-23 08:30:15,787 [salt.minion      :1711][INFO    ][7100] Returning information for job: 20200223083015721636
2020-02-23 08:30:20,455 [salt.loaded.ext.module.maas:1024][INFO    ][6602] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (1812.59063888s left)
2020-02-23 08:30:45,858 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223083045846851
2020-02-23 08:30:45,882 [salt.minion      :1432][INFO    ][7127] Starting a new job with PID 7127
2020-02-23 08:30:45,916 [salt.minion      :1711][INFO    ][7127] Returning information for job: 20200223083045846851
2020-02-23 08:30:53,972 [salt.loaded.ext.module.maas:1024][INFO    ][6602] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (1779.07460785s left)
2020-02-23 08:31:15,991 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223083115982129
2020-02-23 08:31:16,017 [salt.minion      :1432][INFO    ][7153] Starting a new job with PID 7153
2020-02-23 08:31:16,046 [salt.minion      :1711][INFO    ][7153] Returning information for job: 20200223083115982129
2020-02-23 08:31:27,310 [salt.loaded.ext.module.maas:1024][INFO    ][6602] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (1745.73626995s left)
2020-02-23 08:31:46,142 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223083146128203
2020-02-23 08:31:46,169 [salt.minion      :1432][INFO    ][7205] Starting a new job with PID 7205
2020-02-23 08:31:46,195 [salt.minion      :1711][INFO    ][7205] Returning information for job: 20200223083146128203
2020-02-23 08:32:00,950 [salt.loaded.ext.module.maas:1024][INFO    ][6602] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (1712.09572196s left)
2020-02-23 08:32:16,291 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223083216277120
2020-02-23 08:32:16,319 [salt.minion      :1432][INFO    ][7232] Starting a new job with PID 7232
2020-02-23 08:32:16,345 [salt.minion      :1711][INFO    ][7232] Returning information for job: 20200223083216277120
2020-02-23 08:32:34,499 [salt.loaded.ext.module.maas:1024][INFO    ][6602] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (1678.54727983s left)
2020-02-23 08:32:46,449 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223083246439210
2020-02-23 08:32:46,473 [salt.minion      :1432][INFO    ][7270] Starting a new job with PID 7270
2020-02-23 08:32:46,505 [salt.minion      :1711][INFO    ][7270] Returning information for job: 20200223083246439210
2020-02-23 08:33:07,754 [salt.loaded.ext.module.maas:1024][INFO    ][6602] Waiting status:Deployed for machines:['cmp001']
sleep for:30s Timeout:2250s (1645.29244089s left)
2020-02-23 08:33:16,622 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223083316609758
2020-02-23 08:33:16,641 [salt.minion      :1432][INFO    ][7300] Starting a new job with PID 7300
2020-02-23 08:33:16,667 [salt.minion      :1711][INFO    ][7300] Returning information for job: 20200223083316609758
2020-02-23 08:33:29,140 [salt.utils.schedule:1377][INFO    ][2065] Running scheduled job: __mine_interval
2020-02-23 08:33:41,266 [salt.loaded.ext.module.maas:1024][INFO    ][6602] Waiting status:Deployed for machines:['cmp001']
sleep for:30s Timeout:2250s (1611.78060985s left)
2020-02-23 08:33:46,780 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command saltutil.find_job with jid 20200223083346771185
2020-02-23 08:33:46,803 [salt.minion      :1432][INFO    ][7369] Starting a new job with PID 7369
2020-02-23 08:33:46,831 [salt.minion      :1711][INFO    ][7369] Returning information for job: 20200223083346771185
2020-02-23 08:34:14,786 [salt.state       :300 ][INFO    ][6602] {'ret': True}
2020-02-23 08:34:14,786 [salt.state       :1951][INFO    ][6602] Completed state [maas.wait_for_machine_status] at time 08:34:14.786523 duration_in_ms=671760.451
2020-02-23 08:34:14,790 [salt.minion      :1711][INFO    ][6602] Returning information for job: 20200223082259309886
2020-02-23 09:33:29,139 [salt.utils.schedule:1377][INFO    ][2065] Running scheduled job: __mine_interval
2020-02-23 10:10:12,138 [salt.minion      :1308][INFO    ][2065] User sudo_ubuntu Executing command cp.push_dir with jid 20200223101012127267
2020-02-23 10:10:12,163 [salt.minion      :1432][INFO    ][11890] Starting a new job with PID 11890
