2020-02-05 12:49:46,791 [salt.utils.decorators:613 ][WARNING ][1536] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-02-05 12:49:47,882 [salt.utils.decorators:613 ][WARNING ][1536] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-02-05 12:49:59,952 [salt.loaded.int.states.file:2298][WARNING ][1689] 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-05 12:50:04,254 [salt.loaded.int.module.cmdmod:395 ][INFO    ][1900] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2020-02-05 12:50:04,299 [salt.loaded.int.module.cmdmod:395 ][INFO    ][1900] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2020-02-05 12:50:04,346 [salt.utils.parsers:1051][WARNING ][154] Minion received a SIGTERM. Exiting.
2020-02-05 12:50:05,628 [salt.cli.daemons :293 ][INFO    ][2030] Setting up the Salt Minion "mas01.mcp-ovs-ha.local"
2020-02-05 12:50:05,890 [salt.cli.daemons :82  ][INFO    ][2030] Starting up the Salt Minion
2020-02-05 12:50:05,891 [salt.utils.event :1017][INFO    ][2030] Starting pull socket on /var/run/salt/minion/minion_event_501f9ec045_pull.ipc
2020-02-05 12:50:07,271 [salt.minion      :976 ][INFO    ][2030] Creating minion process manager
2020-02-05 12:50:08,650 [salt.state       :2022][WARNING ][1904] State is set to retry, but a valid dict for retry configuration was not found.  Using retry defaults
2020-02-05 12:50:09,387 [salt.utils.decorators:613 ][WARNING ][1904] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-02-05 12:50:09,762 [salt.loader.10.20.0.2.int.module.cmdmod:395 ][INFO    ][2030] Executing command ['date', '+%z'] in directory '/root'
2020-02-05 12:50:09,792 [salt.utils.schedule:568 ][INFO    ][2030] Updating job settings for scheduled job: __mine_interval
2020-02-05 12:50:09,794 [salt.minion      :1108][INFO    ][2030] Added mine.update to scheduler
2020-02-05 12:50:09,800 [salt.minion      :1975][INFO    ][2030] Minion is starting as user 'root'
2020-02-05 12:50:09,818 [salt.minion      :2336][INFO    ][2030] Minion is ready to receive requests!
2020-02-05 12:50:16,416 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205125016401097
2020-02-05 12:50:16,437 [salt.minion      :1432][INFO    ][2445] Starting a new job with PID 2445
2020-02-05 12:50:16,466 [salt.minion      :1711][INFO    ][2445] Returning information for job: 20200205125016401097
2020-02-05 12:50:21,628 [salt.utils.decorators:613 ][WARNING ][1904] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-02-05 12:50:46,528 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205125046519399
2020-02-05 12:50:46,549 [salt.minion      :1432][INFO    ][2646] Starting a new job with PID 2646
2020-02-05 12:50:46,580 [salt.minion      :1711][INFO    ][2646] Returning information for job: 20200205125046519399
2020-02-05 12:50:52,219 [salt.utils.decorators:613 ][WARNING ][1904] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-02-05 12:50:52,969 [salt.utils.decorators:613 ][WARNING ][1904] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-02-05 12:50:55,561 [salt.loaded.ext.module.maasng:1008][WARNING ][1904] Detected cidr:192.168.11.0/24 in fabric:fabric-1
2020-02-05 12:50:55,562 [salt.loaded.ext.module.maasng:1011][WARNING ][1904] Guessing, that fabric with current name:fabric-1
 should be renamed to:pxe_admin
2020-02-05 12:50:56,123 [salt.loaded.ext.module.maasng:1235][WARNING ][1904] Ignoring parameter vlan:0
2020-02-05 12:50:58,083 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command state.apply with jid 20200205125058066737
2020-02-05 12:50:58,107 [salt.minion      :1432][INFO    ][2702] Starting a new job with PID 2702
2020-02-05 12:51:06,322 [salt.state       :915 ][INFO    ][2702] Loading fresh modules for state activity
2020-02-05 12:51:06,403 [salt.fileclient  :1219][INFO    ][2702] Fetching file from saltenv 'base', ** done ** 'maas/machines/init.sls'
2020-02-05 12:51:06,456 [salt.state       :1780][INFO    ][2702] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:51:06.456613
2020-02-05 12:51:06,457 [salt.state       :1813][INFO    ][2702] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2020-02-05 12:51:06,459 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2702] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2020-02-05 12:51:08,708 [salt.state       :300 ][INFO    ][2702] {'pid': 2716, 'retcode': 0, 'stderr': '', 'stdout': ''}
2020-02-05 12:51:08,710 [salt.state       :1951][INFO    ][2702] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:51:08.709980 duration_in_ms=2253.367
2020-02-05 12:51:08,713 [salt.state       :1780][INFO    ][2702] Running state [maas.process_machines] at time 12:51:08.713485
2020-02-05 12:51:08,714 [salt.state       :1813][INFO    ][2702] Executing state module.run for [maas.process_machines]
2020-02-05 12:51:08,714 [salt.utils.decorators:613 ][WARNING ][2702] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-02-05 12:51:08,776 [salt.loaded.ext.module.maas:412 ][WARNING ][2702] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2020-02-05 12:51:08,776 [salt.loaded.ext.module.maas:92  ][INFO    ][2702] 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-05 12:51:09,660 [salt.loaded.ext.module.maas:412 ][WARNING ][2702] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2020-02-05 12:51:09,661 [salt.loaded.ext.module.maas:92  ][INFO    ][2702] 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-05 12:51:10,539 [salt.loaded.ext.module.maas:412 ][WARNING ][2702] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2020-02-05 12:51:10,540 [salt.loaded.ext.module.maas:92  ][INFO    ][2702] 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-05 12:51:11,412 [salt.loaded.ext.module.maas:412 ][WARNING ][2702] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2020-02-05 12:51:11,412 [salt.loaded.ext.module.maas:92  ][INFO    ][2702] 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-05 12:51:12,237 [salt.loaded.ext.module.maas:412 ][WARNING ][2702] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2020-02-05 12:51:12,238 [salt.loaded.ext.module.maas:92  ][INFO    ][2702] 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-05 12:51:13,101 [salt.state       :300 ][INFO    ][2702] {'ret': {'updated': [], 'errors': {}, 'success': ['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']}}
2020-02-05 12:51:13,103 [salt.state       :1951][INFO    ][2702] Completed state [maas.process_machines] at time 12:51:13.102857 duration_in_ms=4389.37
2020-02-05 12:51:13,107 [salt.minion      :1711][INFO    ][2702] Returning information for job: 20200205125058066737
2020-02-05 12:51:44,840 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command state.apply with jid 20200205125144827739
2020-02-05 12:51:44,858 [salt.minion      :1432][INFO    ][2801] Starting a new job with PID 2801
2020-02-05 12:51:53,134 [salt.state       :915 ][INFO    ][2801] Loading fresh modules for state activity
2020-02-05 12:51:53,200 [salt.fileclient  :1219][INFO    ][2801] Fetching file from saltenv 'base', ** done ** 'maas/machines/wait_for_ready_or_deployed.sls'
2020-02-05 12:51:53,261 [salt.state       :1780][INFO    ][2801] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:51:53.261098
2020-02-05 12:51:53,261 [salt.state       :1813][INFO    ][2801] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2020-02-05 12:51:53,263 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2801] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2020-02-05 12:51:55,290 [salt.state       :300 ][INFO    ][2801] {'pid': 2808, 'retcode': 0, 'stderr': '', 'stdout': ''}
2020-02-05 12:51:55,291 [salt.state       :1951][INFO    ][2801] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:51:55.291382 duration_in_ms=2030.284
2020-02-05 12:51:55,295 [salt.state       :1780][INFO    ][2801] Running state [maas.wait_for_machine_status] at time 12:51:55.294956
2020-02-05 12:51:55,295 [salt.state       :1813][INFO    ][2801] Executing state module.run for [maas.wait_for_machine_status]
2020-02-05 12:51:55,296 [salt.utils.decorators:613 ][WARNING ][2801] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-02-05 12:51:56,314 [salt.loaded.ext.module.maas:1024][INFO    ][2801] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1498.99534297s left)
2020-02-05 12:51:59,902 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205125159879990
2020-02-05 12:51:59,929 [salt.minion      :1432][INFO    ][2817] Starting a new job with PID 2817
2020-02-05 12:51:59,952 [salt.minion      :1711][INFO    ][2817] Returning information for job: 20200205125159879990
2020-02-05 12:52:27,308 [salt.loaded.ext.module.maas:1024][INFO    ][2801] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1468.00137997s left)
2020-02-05 12:52:29,992 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205125229980631
2020-02-05 12:52:30,022 [salt.minion      :1432][INFO    ][2844] Starting a new job with PID 2844
2020-02-05 12:52:30,049 [salt.minion      :1711][INFO    ][2844] Returning information for job: 20200205125229980631
2020-02-05 12:52:58,272 [salt.loaded.ext.module.maas:1024][INFO    ][2801] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1437.03758192s left)
2020-02-05 12:53:00,080 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205125300060955
2020-02-05 12:53:00,107 [salt.minion      :1432][INFO    ][2868] Starting a new job with PID 2868
2020-02-05 12:53:00,132 [salt.minion      :1711][INFO    ][2868] Returning information for job: 20200205125300060955
2020-02-05 12:53:29,193 [salt.loaded.ext.module.maas:1024][INFO    ][2801] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1406.11685109s left)
2020-02-05 12:53:30,164 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205125330150677
2020-02-05 12:53:30,191 [salt.minion      :1432][INFO    ][2895] Starting a new job with PID 2895
2020-02-05 12:53:30,215 [salt.minion      :1711][INFO    ][2895] Returning information for job: 20200205125330150677
2020-02-05 12:54:00,212 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205125400197233
2020-02-05 12:54:00,237 [salt.minion      :1432][INFO    ][2931] Starting a new job with PID 2931
2020-02-05 12:54:00,262 [salt.minion      :1711][INFO    ][2931] Returning information for job: 20200205125400197233
2020-02-05 12:54:00,438 [salt.loaded.ext.module.maas:1024][INFO    ][2801] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1374.87184596s left)
2020-02-05 12:54:30,301 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205125430286037
2020-02-05 12:54:30,325 [salt.minion      :1432][INFO    ][2992] Starting a new job with PID 2992
2020-02-05 12:54:30,350 [salt.minion      :1711][INFO    ][2992] Returning information for job: 20200205125430286037
2020-02-05 12:54:31,718 [salt.loaded.ext.module.maas:1024][INFO    ][2801] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1343.59140706s left)
2020-02-05 12:55:00,407 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205125500388463
2020-02-05 12:55:00,429 [salt.minion      :1432][INFO    ][3031] Starting a new job with PID 3031
2020-02-05 12:55:00,452 [salt.minion      :1711][INFO    ][3031] Returning information for job: 20200205125500388463
2020-02-05 12:55:03,219 [salt.loaded.ext.module.maas:1024][INFO    ][2801] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1312.09085011s left)
2020-02-05 12:55:30,491 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205125530478253
2020-02-05 12:55:30,505 [salt.minion      :1432][INFO    ][3102] Starting a new job with PID 3102
2020-02-05 12:55:30,529 [salt.minion      :1711][INFO    ][3102] Returning information for job: 20200205125530478253
2020-02-05 12:55:34,688 [salt.loaded.ext.module.maas:1024][INFO    ][2801] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1280.6212101s left)
2020-02-05 12:56:00,580 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205125600568520
2020-02-05 12:56:00,600 [salt.minion      :1432][INFO    ][3163] Starting a new job with PID 3163
2020-02-05 12:56:00,623 [salt.minion      :1711][INFO    ][3163] Returning information for job: 20200205125600568520
2020-02-05 12:56:06,591 [salt.loaded.ext.module.maas:1024][INFO    ][2801] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1248.71837091s left)
2020-02-05 12:56:30,694 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205125630676916
2020-02-05 12:56:30,723 [salt.minion      :1432][INFO    ][3238] Starting a new job with PID 3238
2020-02-05 12:56:30,748 [salt.minion      :1711][INFO    ][3238] Returning information for job: 20200205125630676916
2020-02-05 12:56:38,835 [salt.loaded.ext.module.maas:1024][INFO    ][2801] Waiting status:Ready|Deployed for machines:['cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1216.47431993s left)
2020-02-05 12:57:00,801 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205125700787246
2020-02-05 12:57:00,827 [salt.minion      :1432][INFO    ][3267] Starting a new job with PID 3267
2020-02-05 12:57:00,854 [salt.minion      :1711][INFO    ][3267] Returning information for job: 20200205125700787246
2020-02-05 12:57:11,379 [salt.loaded.ext.module.maas:1024][INFO    ][2801] Waiting status:Ready|Deployed for machines:['kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1183.93085504s left)
2020-02-05 12:57:30,922 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205125730906747
2020-02-05 12:57:30,948 [salt.minion      :1432][INFO    ][3299] Starting a new job with PID 3299
2020-02-05 12:57:30,975 [salt.minion      :1711][INFO    ][3299] Returning information for job: 20200205125730906747
2020-02-05 12:57:43,835 [salt.loaded.ext.module.maas:1024][INFO    ][2801] Waiting status:Ready|Deployed for machines:['kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1151.47495008s left)
2020-02-05 12:58:01,055 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205125801043801
2020-02-05 12:58:01,071 [salt.minion      :1432][INFO    ][3379] Starting a new job with PID 3379
2020-02-05 12:58:01,096 [salt.minion      :1711][INFO    ][3379] Returning information for job: 20200205125801043801
2020-02-05 12:58:17,205 [salt.loaded.ext.module.maas:1024][INFO    ][2801] Waiting status:Ready|Deployed for machines:['kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1118.10485005s left)
2020-02-05 12:58:31,176 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205125831162597
2020-02-05 12:58:31,204 [salt.minion      :1432][INFO    ][3406] Starting a new job with PID 3406
2020-02-05 12:58:31,232 [salt.minion      :1711][INFO    ][3406] Returning information for job: 20200205125831162597
2020-02-05 12:58:50,599 [salt.state       :300 ][INFO    ][2801] {'ret': True}
2020-02-05 12:58:50,600 [salt.state       :1951][INFO    ][2801] Completed state [maas.wait_for_machine_status] at time 12:58:50.600038 duration_in_ms=415305.081
2020-02-05 12:58:50,603 [salt.minion      :1711][INFO    ][2801] Returning information for job: 20200205125144827739
2020-02-05 12:58:51,560 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command state.apply with jid 20200205125851543975
2020-02-05 12:58:51,586 [salt.minion      :1432][INFO    ][3441] Starting a new job with PID 3441
2020-02-05 12:58:59,802 [salt.state       :915 ][INFO    ][3441] Loading fresh modules for state activity
2020-02-05 12:58:59,876 [salt.fileclient  :1219][INFO    ][3441] Fetching file from saltenv 'base', ** done ** 'maas/machines/storage.sls'
2020-02-05 12:58:59,992 [salt.state       :1780][INFO    ][3441] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:58:59.992691
2020-02-05 12:58:59,993 [salt.state       :1813][INFO    ][3441] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2020-02-05 12:58:59,997 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3441] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2020-02-05 12:59:02,108 [salt.state       :300 ][INFO    ][3441] {'pid': 3448, 'retcode': 0, 'stderr': '', 'stdout': ''}
2020-02-05 12:59:02,110 [salt.state       :1951][INFO    ][3441] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:59:02.110189 duration_in_ms=2117.493
2020-02-05 12:59:02,114 [salt.state       :1780][INFO    ][3441] Running state [maas_machines_storage_cmp002_lvm] at time 12:59:02.114497
2020-02-05 12:59:02,115 [salt.state       :1813][INFO    ][3441] Executing state maasng.disk_layout_present for [maas_machines_storage_cmp002_lvm]
2020-02-05 12:59:03,414 [salt.loaded.ext.module.maasng:610 ][INFO    ][3441] dr3ax3
2020-02-05 12:59:03,415 [salt.loaded.ext.module.maasng:626 ][INFO    ][3441] sda
2020-02-05 12:59:04,039 [salt.loaded.ext.module.maasng:361 ][INFO    ][3441] dr3ax3
2020-02-05 12:59:04,118 [salt.loaded.ext.module.maasng:367 ][INFO    ][3441] [{u'resource_uri': u'/MAAS/api/2.0/nodes/dr3ax3/blockdevices/1/', u'available_size': 0, u'name': u'sda', u'tags': [u'ssd'], u'type': u'physical', u'partitions': [{u'uuid': u'4a6acc18-03a5-4846-97b4-6bc332283c49', u'resource_uri': u'/MAAS/api/2.0/nodes/dr3ax3/blockdevices/1/partition/1', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'dr3ax3', u'filesystem': {u'mount_options': None, u'label': None, u'mount_point': None, u'uuid': u'3b460ea3-e531-47ce-baa7-970fa7dcb9d0', u'fstype': u'lvm-pv'}, u'path': u'/dev/disk/by-dname/sda-part1', u'device_id': 1, u'type': u'partition', u'id': 1, u'size': 800101236736}], u'uuid': None, u'id': 1, u'used_for': u'MBR partitioned with 1 partition', u'system_id': u'dr3ax3', 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/dr3ax3/blockdevices/3/', u'available_size': 0, u'name': u'vgroot-lvroot', u'tags': [], u'type': u'virtual', u'partitions': [], u'uuid': u'515e412c-b994-4b54-8cf7-e5713ce9b84c', u'id': 3, u'used_for': u'ext4 formatted filesystem mounted at /', u'system_id': u'dr3ax3', u'partition_table_type': None, u'filesystem': {u'mount_options': None, u'label': u'root', u'mount_point': u'/', u'uuid': u'91a45e28-f5f5-428f-a7b9-05f72c5ea1f2', 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-05 12:59:04,118 [salt.loaded.ext.module.maasng:632 ][INFO    ][3441] vgroot
2020-02-05 12:59:04,118 [salt.loaded.ext.module.maasng:635 ][INFO    ][3441] lvroot
2020-02-05 12:59:04,119 [salt.loaded.ext.module.maasng:639 ][INFO    ][3441] 107374182400
2020-02-05 12:59:04,822 [salt.loaded.ext.module.maasng:645 ][INFO    ][3441] {u'node_type_name': u'Machine', u'hwe_kernel': None, u'swap_size': None, 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'memory_test_status_name': u'Unknown', u'status_action': u'', u'tag_names': [], u'testing_status_name': u'Passed', 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'size': 800109715456, u'model': u'LOGICAL VOLUME', u'resource_uri': u'/MAAS/api/2.0/nodes/dr3ax3/blockdevices/1/', u'available_size': 0, u'name': u'sda', u'tags': [u'ssd'], u'type': u'physical', u'id': 1, u'uuid': None, u'used_for': u'MBR partitioned with 1 partition', u'system_id': u'dr3ax3', 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'block_size': 4096, u'used_size': 800106479616, u'serial': u'600508b1001cb19198eb9a66f8a29401', u'partitions': [{u'uuid': u'9523e55c-3c94-40c1-9513-3625e613e785', u'resource_uri': u'/MAAS/api/2.0/nodes/dr3ax3/blockdevices/1/partition/6', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'dr3ax3', u'filesystem': {u'mount_options': None, u'label': None, u'mount_point': None, u'uuid': u'f92fb77d-71dd-4b71-acc9-150f7398d1be', 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'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/dr3ax3/', 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'dr3ax3', 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'virtualblockdevice_set': [{u'size': 107374182400, u'resource_uri': u'/MAAS/api/2.0/nodes/dr3ax3/blockdevices/11/', u'available_size': 0, u'name': u'vgroot-lvroot', u'tags': [], u'type': u'virtual', u'id': 11, u'uuid': u'527f25d4-0c39-4e7e-8541-a33337ac4293', u'used_for': u'ext4 formatted filesystem mounted at /', u'system_id': u'dr3ax3', u'partition_table_type': None, u'filesystem': {u'mount_options': None, u'label': u'root', u'mount_point': u'/', u'uuid': u'5c64fa70-7fb6-4ada-8fb8-d47b70ee0354', 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'partitions': []}], u'blockdevice_set': [{u'resource_uri': u'/MAAS/api/2.0/nodes/dr3ax3/blockdevices/1/', u'available_size': 0, u'name': u'sda', u'tags': [u'ssd'], u'type': u'physical', u'partitions': [{u'uuid': u'9523e55c-3c94-40c1-9513-3625e613e785', u'resource_uri': u'/MAAS/api/2.0/nodes/dr3ax3/blockdevices/1/partition/6', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'dr3ax3', u'filesystem': {u'mount_options': None, u'label': None, u'mount_point': None, u'uuid': u'f92fb77d-71dd-4b71-acc9-150f7398d1be', 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'uuid': None, u'id': 1, u'used_for': u'MBR partitioned with 1 partition', u'system_id': u'dr3ax3', 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/dr3ax3/blockdevices/11/', u'available_size': 0, u'name': u'vgroot-lvroot', u'tags': [], u'type': u'virtual', u'partitions': [], u'uuid': u'527f25d4-0c39-4e7e-8541-a33337ac4293', u'id': 11, u'used_for': u'ext4 formatted filesystem mounted at /', u'system_id': u'dr3ax3', u'partition_table_type': None, u'filesystem': {u'mount_options': None, u'label': u'root', u'mount_point': u'/', u'uuid': u'5c64fa70-7fb6-4ada-8fb8-d47b70ee0354', 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'status': 4, u'storage_test_status': 2, u'storage_test_status_name': u'Passed', u'power_state': u'off', u'physicalblockdevice_set': [{u'size': 800109715456, u'model': u'LOGICAL VOLUME', u'resource_uri': u'/MAAS/api/2.0/nodes/dr3ax3/blockdevices/1/', u'available_size': 0, u'name': u'sda', u'tags': [u'ssd'], u'type': u'physical', u'id': 1, u'uuid': None, u'used_for': u'MBR partitioned with 1 partition', u'system_id': u'dr3ax3', 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'block_size': 4096, u'used_size': 800106479616, u'serial': u'600508b1001cb19198eb9a66f8a29401', u'partitions': [{u'uuid': u'9523e55c-3c94-40c1-9513-3625e613e785', u'resource_uri': u'/MAAS/api/2.0/nodes/dr3ax3/blockdevices/1/partition/6', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'dr3ax3', u'filesystem': {u'mount_options': None, u'label': None, u'mount_point': None, u'uuid': u'f92fb77d-71dd-4b71-acc9-150f7398d1be', 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'ip_addresses': [u'192.168.11.38', u'192.168.11.40'], u'other_test_status_name': u'Unknown', u'owner_data': {}, u'volume_groups': [{u'__incomplete__': True, u'system_id': u'dr3ax3', u'id': 6}], u'special_filesystems': [], u'current_commissioning_result_id': 2, u'commissioning_status_name': u'Passed', 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'bcaches': [], u'locked': False, u'status_name': u'Ready', u'netboot': True, u'osystem': u'', u'fqdn': u'cmp002.maas', u'node_type': 0, u'commissioning_status': 2, u'min_hwe_kernel': u'ga-18.04', u'boot_interface': {u'product': u'ProLiant BL460c Gen8 (735151-B21)', 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'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'b334ym', 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'fabric': u'pxe_admin'}, 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': 2, u'resource_uri': u'/MAAS/api/2.0/subnets/2/'}, u'ip_address': u'192.168.11.38', u'id': 19, u'mode': u'dhcp'}], u'tags': [u'sriov'], u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'b334ym', 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'fabric': u'pxe_admin'}, u'enabled': True, u'id': 4, u'discovered': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'b334ym', 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'fabric': u'pxe_admin'}, 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': 2, u'resource_uri': u'/MAAS/api/2.0/subnets/2/'}, u'ip_address': u'192.168.11.38'}], u'mac_address': u'9c:b6:54:8a:10:18', u'parents': [], u'params': u'', u'effective_mtu': 1500, u'system_id': u'dr3ax3', u'firmware_version': u'bc 7.8.24', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/dr3ax3/interfaces/4/'}, u'interface_set': [{u'product': u'ProLiant BL460c Gen8 (735151-B21)', 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'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'b334ym', 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'fabric': u'pxe_admin'}, 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': 2, u'resource_uri': u'/MAAS/api/2.0/subnets/2/'}, u'ip_address': u'192.168.11.38', u'id': 19, u'mode': u'dhcp'}], u'tags': [u'sriov'], u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'b334ym', 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'fabric': u'pxe_admin'}, u'enabled': True, u'id': 4, u'discovered': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'b334ym', 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'fabric': u'pxe_admin'}, 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': 2, u'resource_uri': u'/MAAS/api/2.0/subnets/2/'}, u'ip_address': u'192.168.11.38'}], u'mac_address': u'9c:b6:54:8a:10:18', u'parents': [], u'params': u'', u'effective_mtu': 1500, u'system_id': u'dr3ax3', u'firmware_version': u'bc 7.8.24', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/dr3ax3/interfaces/4/'}, {u'product': u'ProLiant BL460c Gen8 (735151-B21)', u'vendor': u'HP', u'name': u'ens1f0', u'links': [], u'tags': [u'sriov'], u'vlan': None, u'enabled': True, u'id': 11, u'discovered': None, u'mac_address': u'38:ea:a7:8f:07:50', u'parents': [], u'params': u'', u'effective_mtu': 1500, u'system_id': u'dr3ax3', u'firmware_version': u'bc 7.8.24', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/dr3ax3/interfaces/11/'}, {u'product': u'ProLiant BL460c Gen8 (735151-B21)', 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'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'b334ym', 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'fabric': u'pxe_admin'}, 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': 2, u'resource_uri': u'/MAAS/api/2.0/subnets/2/'}, u'id': 20, u'mode': u'link_up'}], u'tags': [u'sriov'], u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'b334ym', 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'fabric': u'pxe_admin'}, u'enabled': True, u'id': 12, u'discovered': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'b334ym', 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'fabric': u'pxe_admin'}, 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': 2, u'resource_uri': u'/MAAS/api/2.0/subnets/2/'}, u'ip_address': u'192.168.11.40'}], u'mac_address': u'9c:b6:54:8a:10:1c', u'parents': [], u'params': u'', u'effective_mtu': 1500, u'system_id': u'dr3ax3', u'firmware_version': u'bc 7.8.24', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/dr3ax3/interfaces/12/'}, {u'product': u'ProLiant BL460c Gen8 (735151-B21)', u'vendor': u'HP', u'name': u'ens1f1', u'links': [], u'tags': [u'sriov'], u'vlan': None, u'enabled': True, u'id': 13, u'discovered': None, u'mac_address': u'38:ea:a7:8f:07:51', u'parents': [], u'params': u'', u'effective_mtu': 1500, u'system_id': u'dr3ax3', u'firmware_version': u'bc 7.8.24', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/dr3ax3/interfaces/13/'}, {u'product': u'ProLiant BL460c Gen8 (735151-B21)', u'vendor': u'HP', u'name': u'ens2f0', u'links': [{u'id': 21, u'mode': u'link_up'}], u'tags': [u'sriov'], u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 0, u'dhcp_on': False, u'mtu': 1500, u'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'fabric': u'fabric-0'}, u'enabled': True, u'id': 14, u'discovered': None, u'mac_address': u'38:ea:a7:8f:12:48', u'parents': [], u'params': u'', u'effective_mtu': 1500, u'system_id': u'dr3ax3', u'firmware_version': u'bc 7.8.24', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/dr3ax3/interfaces/14/'}, {u'product': u'ProLiant BL460c Gen8 (735151-B21)', u'vendor': u'HP', u'name': u'ens2f1', u'links': [{u'id': 22, u'mode': u'link_up'}], u'tags': [u'sriov'], u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 0, u'dhcp_on': False, u'mtu': 1500, u'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'fabric': u'fabric-0'}, u'enabled': True, u'id': 15, u'discovered': None, u'mac_address': u'38:ea:a7:8f:12:49', u'parents': [], u'params': u'', u'effective_mtu': 1500, u'system_id': u'dr3ax3', u'firmware_version': u'bc 7.8.24', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/dr3ax3/interfaces/15/'}], u'address_ttl': None, u'other_test_status': -1, u'distro_series': u'', u'memory_test_status': -1}
2020-02-05 12:59:04,823 [salt.state       :300 ][INFO    ][3441] {'new': {'storage_layout': 'lvm'}}
2020-02-05 12:59:04,823 [salt.state       :1951][INFO    ][3441] Completed state [maas_machines_storage_cmp002_lvm] at time 12:59:04.823912 duration_in_ms=2709.414
2020-02-05 12:59:04,824 [salt.state       :1780][INFO    ][3441] Running state [maas_machines_storage_cmp001_lvm] at time 12:59:04.824320
2020-02-05 12:59:04,824 [salt.state       :1813][INFO    ][3441] Executing state maasng.disk_layout_present for [maas_machines_storage_cmp001_lvm]
2020-02-05 12:59:06,082 [salt.loaded.ext.module.maasng:610 ][INFO    ][3441] 87mhmd
2020-02-05 12:59:06,082 [salt.loaded.ext.module.maasng:626 ][INFO    ][3441] sda
2020-02-05 12:59:06,660 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205125906647750
2020-02-05 12:59:06,683 [salt.minion      :1432][INFO    ][3465] Starting a new job with PID 3465
2020-02-05 12:59:06,711 [salt.minion      :1711][INFO    ][3465] Returning information for job: 20200205125906647750
2020-02-05 12:59:06,862 [salt.loaded.ext.module.maasng:361 ][INFO    ][3441] 87mhmd
2020-02-05 12:59:06,945 [salt.loaded.ext.module.maasng:367 ][INFO    ][3441] [{u'model': u'LOGICAL VOLUME', u'resource_uri': u'/MAAS/api/2.0/nodes/87mhmd/blockdevices/2/', u'name': u'sda', u'tags': [u'ssd'], u'used_size': 800106479616, u'partitions': [{u'uuid': u'1f813920-358e-45ae-8887-3071482dbcc1', u'resource_uri': u'/MAAS/api/2.0/nodes/87mhmd/blockdevices/2/partition/2', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'87mhmd', u'filesystem': {u'mount_options': None, u'label': None, u'mount_point': None, u'uuid': u'e2d1181b-843a-415d-98e2-e84808a65851', 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'filesystem': None, u'uuid': None, u'used_for': u'MBR partitioned with 1 partition', u'system_id': u'87mhmd', u'partition_table_type': u'MBR', u'path': u'/dev/disk/by-dname/sda', u'id_path': u'/dev/disk/by-id/wwn-0x600508b1001cd7e61f5cd3479576479e', u'available_size': 0, u'serial': u'600508b1001cd7e61f5cd3479576479e', u'block_size': 4096, u'type': u'physical', u'id': 2, u'size': 800109715456}, {u'model': None, u'resource_uri': u'/MAAS/api/2.0/nodes/87mhmd/blockdevices/4/', u'name': u'vgroot-lvroot', u'tags': [], u'used_size': 800097042432, u'partitions': [], u'filesystem': {u'mount_options': None, u'label': u'root', u'mount_point': u'/', u'uuid': u'4c255f24-4f32-4299-ab1c-2cfdd08fb510', u'fstype': u'ext4'}, u'uuid': u'947c2672-43ac-4e9e-b15e-b08f0868707e', u'used_for': u'ext4 formatted filesystem mounted at /', u'system_id': u'87mhmd', u'partition_table_type': None, u'path': u'/dev/disk/by-dname/lvroot', u'id_path': None, u'available_size': 0, u'serial': None, u'block_size': 4096, u'type': u'virtual', u'id': 4, u'size': 800097042432}]
2020-02-05 12:59:06,946 [salt.loaded.ext.module.maasng:632 ][INFO    ][3441] vgroot
2020-02-05 12:59:06,946 [salt.loaded.ext.module.maasng:635 ][INFO    ][3441] lvroot
2020-02-05 12:59:06,946 [salt.loaded.ext.module.maasng:639 ][INFO    ][3441] 107374182400
2020-02-05 12:59:07,597 [salt.loaded.ext.module.maasng:645 ][INFO    ][3441] {u'node_type_name': u'Machine', u'hwe_kernel': None, u'swap_size': None, 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'memory_test_status_name': u'Unknown', u'status_action': u'', u'tag_names': [], u'testing_status_name': u'Passed', 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'size': 800109715456, u'model': u'LOGICAL VOLUME', u'resource_uri': u'/MAAS/api/2.0/nodes/87mhmd/blockdevices/2/', u'available_size': 0, u'name': u'sda', u'tags': [u'ssd'], u'type': u'physical', u'id': 2, u'uuid': None, u'used_for': u'MBR partitioned with 1 partition', u'system_id': u'87mhmd', 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'partitions': [{u'uuid': u'2fc7c5b2-3236-479a-b426-070e7e287708', u'resource_uri': u'/MAAS/api/2.0/nodes/87mhmd/blockdevices/2/partition/7', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'87mhmd', u'filesystem': {u'mount_options': None, u'label': None, u'mount_point': None, u'uuid': u'de2f1504-f55e-4430-83e7-f9237423e0f8', u'fstype': u'lvm-pv'}, u'path': u'/dev/disk/by-dname/sda-part1', u'device_id': 2, u'type': u'partition', u'id': 7, u'size': 800101236736}]}, 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/87mhmd/', 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'87mhmd', 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'virtualblockdevice_set': [{u'size': 107374182400, u'resource_uri': u'/MAAS/api/2.0/nodes/87mhmd/blockdevices/12/', u'available_size': 0, u'name': u'vgroot-lvroot', u'tags': [], u'type': u'virtual', u'id': 12, u'uuid': u'41d1fdab-a928-4c05-9d75-da0836c94f01', u'used_for': u'ext4 formatted filesystem mounted at /', u'system_id': u'87mhmd', u'partition_table_type': None, u'filesystem': {u'mount_options': None, u'label': u'root', u'mount_point': u'/', u'uuid': u'6a8bc998-b601-43fc-8b85-56160dd1b2ff', 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'partitions': []}], u'blockdevice_set': [{u'resource_uri': u'/MAAS/api/2.0/nodes/87mhmd/blockdevices/2/', u'available_size': 0, u'name': u'sda', u'tags': [u'ssd'], u'type': u'physical', u'partitions': [{u'uuid': u'2fc7c5b2-3236-479a-b426-070e7e287708', u'resource_uri': u'/MAAS/api/2.0/nodes/87mhmd/blockdevices/2/partition/7', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'87mhmd', u'filesystem': {u'mount_options': None, u'label': None, u'mount_point': None, u'uuid': u'de2f1504-f55e-4430-83e7-f9237423e0f8', u'fstype': u'lvm-pv'}, u'path': u'/dev/disk/by-dname/sda-part1', u'device_id': 2, u'type': u'partition', u'id': 7, u'size': 800101236736}], u'uuid': None, u'id': 2, u'used_for': u'MBR partitioned with 1 partition', u'system_id': u'87mhmd', 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/87mhmd/blockdevices/12/', u'available_size': 0, u'name': u'vgroot-lvroot', u'tags': [], u'type': u'virtual', u'partitions': [], u'uuid': u'41d1fdab-a928-4c05-9d75-da0836c94f01', u'id': 12, u'used_for': u'ext4 formatted filesystem mounted at /', u'system_id': u'87mhmd', u'partition_table_type': None, u'filesystem': {u'mount_options': None, u'label': u'root', u'mount_point': u'/', u'uuid': u'6a8bc998-b601-43fc-8b85-56160dd1b2ff', 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'status': 4, u'storage_test_status': 2, u'storage_test_status_name': u'Passed', u'power_state': u'off', u'physicalblockdevice_set': [{u'size': 800109715456, u'model': u'LOGICAL VOLUME', u'resource_uri': u'/MAAS/api/2.0/nodes/87mhmd/blockdevices/2/', u'available_size': 0, u'name': u'sda', u'tags': [u'ssd'], u'type': u'physical', u'id': 2, u'uuid': None, u'used_for': u'MBR partitioned with 1 partition', u'system_id': u'87mhmd', 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'partitions': [{u'uuid': u'2fc7c5b2-3236-479a-b426-070e7e287708', u'resource_uri': u'/MAAS/api/2.0/nodes/87mhmd/blockdevices/2/partition/7', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'87mhmd', u'filesystem': {u'mount_options': None, u'label': None, u'mount_point': None, u'uuid': u'de2f1504-f55e-4430-83e7-f9237423e0f8', u'fstype': u'lvm-pv'}, u'path': u'/dev/disk/by-dname/sda-part1', u'device_id': 2, u'type': u'partition', u'id': 7, u'size': 800101236736}]}], u'ip_addresses': [u'192.168.11.39', u'192.168.11.44'], u'other_test_status_name': u'Unknown', u'owner_data': {}, u'volume_groups': [{u'__incomplete__': True, u'system_id': u'87mhmd', u'id': 7}], u'special_filesystems': [], u'current_commissioning_result_id': 4, u'commissioning_status_name': u'Passed', 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'architecture': u'amd64/generic', u'bcaches': [], u'locked': False, u'status_name': u'Ready', u'netboot': True, u'osystem': u'', u'fqdn': u'cmp001.maas', u'node_type': 0, u'commissioning_status': 2, u'min_hwe_kernel': u'ga-18.04', u'boot_interface': {u'product': u'ProLiant BL460c Gen8 (735151-B21)', 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'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'b334ym', 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'fabric': u'pxe_admin'}, 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': 2, u'resource_uri': u'/MAAS/api/2.0/subnets/2/'}, u'ip_address': u'192.168.11.39', u'id': 28, u'mode': u'dhcp'}], u'tags': [u'sriov'], u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'b334ym', 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'fabric': u'pxe_admin'}, u'enabled': True, u'id': 5, u'discovered': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'b334ym', 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'fabric': u'pxe_admin'}, 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': 2, u'resource_uri': u'/MAAS/api/2.0/subnets/2/'}, u'ip_address': u'192.168.11.39'}], u'mac_address': u'9c:b6:54:8a:95:a0', u'parents': [], u'params': u'', u'effective_mtu': 1500, u'system_id': u'87mhmd', u'firmware_version': u'bc 7.8.24', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/87mhmd/interfaces/5/'}, u'interface_set': [{u'product': u'ProLiant BL460c Gen8 (735151-B21)', 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'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'b334ym', 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'fabric': u'pxe_admin'}, 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': 2, u'resource_uri': u'/MAAS/api/2.0/subnets/2/'}, u'ip_address': u'192.168.11.39', u'id': 28, u'mode': u'dhcp'}], u'tags': [u'sriov'], u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'b334ym', 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'fabric': u'pxe_admin'}, u'enabled': True, u'id': 5, u'discovered': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'b334ym', 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'fabric': u'pxe_admin'}, 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': 2, u'resource_uri': u'/MAAS/api/2.0/subnets/2/'}, u'ip_address': u'192.168.11.39'}], u'mac_address': u'9c:b6:54:8a:95:a0', u'parents': [], u'params': u'', u'effective_mtu': 1500, u'system_id': u'87mhmd', u'firmware_version': u'bc 7.8.24', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/87mhmd/interfaces/5/'}, {u'product': u'ProLiant BL460c Gen8 (735151-B21)', u'vendor': u'HP', u'name': u'ens1f0', u'links': [], u'tags': [u'sriov'], u'vlan': None, u'enabled': True, u'id': 16, u'discovered': None, u'mac_address': u'38:ea:a7:8f:1f:d4', u'parents': [], u'params': u'', u'effective_mtu': 1500, u'system_id': u'87mhmd', u'firmware_version': u'bc 7.8.24', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/87mhmd/interfaces/16/'}, {u'product': u'ProLiant BL460c Gen8 (735151-B21)', 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'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'b334ym', 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'fabric': u'pxe_admin'}, 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': 2, u'resource_uri': u'/MAAS/api/2.0/subnets/2/'}, u'id': 29, u'mode': u'link_up'}], u'tags': [u'sriov'], u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'b334ym', 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'fabric': u'pxe_admin'}, u'enabled': True, u'id': 17, u'discovered': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'b334ym', 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'fabric': u'pxe_admin'}, 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': 2, u'resource_uri': u'/MAAS/api/2.0/subnets/2/'}, u'ip_address': u'192.168.11.44'}], u'mac_address': u'9c:b6:54:8a:95:a4', u'parents': [], u'params': u'', u'effective_mtu': 1500, u'system_id': u'87mhmd', u'firmware_version': u'bc 7.8.24', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/87mhmd/interfaces/17/'}, {u'product': u'ProLiant BL460c Gen8 (735151-B21)', u'vendor': u'HP', u'name': u'ens1f1', u'links': [], u'tags': [u'sriov'], u'vlan': None, u'enabled': True, u'id': 18, u'discovered': None, u'mac_address': u'38:ea:a7:8f:1f:d5', u'parents': [], u'params': u'', u'effective_mtu': 1500, u'system_id': u'87mhmd', u'firmware_version': u'bc 7.8.24', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/87mhmd/interfaces/18/'}, {u'product': u'ProLiant BL460c Gen8 (735151-B21)', u'vendor': u'HP', u'name': u'ens2f0', u'links': [{u'id': 30, u'mode': u'link_up'}], u'tags': [u'sriov'], u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 0, u'dhcp_on': False, u'mtu': 1500, u'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'fabric': u'fabric-0'}, u'enabled': True, u'id': 19, u'discovered': None, u'mac_address': u'38:ea:a7:8f:52:cc', u'parents': [], u'params': u'', u'effective_mtu': 1500, u'system_id': u'87mhmd', u'firmware_version': u'bc 7.8.24', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/87mhmd/interfaces/19/'}, {u'product': u'ProLiant BL460c Gen8 (735151-B21)', u'vendor': u'HP', u'name': u'ens2f1', u'links': [{u'id': 31, u'mode': u'link_up'}], u'tags': [u'sriov'], u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 0, u'dhcp_on': False, u'mtu': 1500, u'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'fabric': u'fabric-0'}, u'enabled': True, u'id': 20, u'discovered': None, u'mac_address': u'38:ea:a7:8f:52:cd', u'parents': [], u'params': u'', u'effective_mtu': 1500, u'system_id': u'87mhmd', u'firmware_version': u'bc 7.8.24', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/87mhmd/interfaces/20/'}], u'address_ttl': None, u'other_test_status': -1, u'distro_series': u'', u'memory_test_status': -1}
2020-02-05 12:59:07,600 [salt.state       :300 ][INFO    ][3441] {'new': {'storage_layout': 'lvm'}}
2020-02-05 12:59:07,600 [salt.state       :1951][INFO    ][3441] Completed state [maas_machines_storage_cmp001_lvm] at time 12:59:07.600608 duration_in_ms=2776.286
2020-02-05 12:59:07,607 [salt.minion      :1711][INFO    ][3441] Returning information for job: 20200205125851543975
2020-02-05 12:59:08,547 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command state.apply with jid 20200205125908533911
2020-02-05 12:59:08,570 [salt.minion      :1432][INFO    ][3472] Starting a new job with PID 3472
2020-02-05 12:59:09,751 [salt.state       :915 ][INFO    ][3472] Loading fresh modules for state activity
2020-02-05 12:59:09,825 [salt.fileclient  :1219][INFO    ][3472] Fetching file from saltenv 'base', ** done ** 'maas/machines/deploy.sls'
2020-02-05 12:59:09,889 [salt.state       :1780][INFO    ][3472] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:59:09.888955
2020-02-05 12:59:09,889 [salt.state       :1813][INFO    ][3472] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2020-02-05 12:59:09,891 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3472] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2020-02-05 12:59:12,107 [salt.state       :300 ][INFO    ][3472] {'pid': 3479, 'retcode': 0, 'stderr': '', 'stdout': ''}
2020-02-05 12:59:12,108 [salt.state       :1951][INFO    ][3472] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:59:12.108126 duration_in_ms=2219.171
2020-02-05 12:59:12,112 [salt.state       :1780][INFO    ][3472] Running state [maas.deploy_machines] at time 12:59:12.112218
2020-02-05 12:59:12,112 [salt.state       :1813][INFO    ][3472] Executing state module.run for [maas.deploy_machines]
2020-02-05 12:59:12,114 [salt.utils.decorators:613 ][WARNING ][3472] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-02-05 12:59:12,727 [salt.loaded.ext.module.maas:684 ][INFO    ][3472] deploymachines hwe_kernel=ga-18.04 system_id=dr3ax3 distro_series=bionic
2020-02-05 12:59:14,893 [salt.loaded.ext.module.maas:684 ][INFO    ][3472] deploymachines hwe_kernel=ga-18.04 system_id=87mhmd distro_series=bionic
2020-02-05 12:59:16,763 [salt.loaded.ext.module.maas:684 ][INFO    ][3472] deploymachines hwe_kernel=ga-18.04 system_id=dgysrr distro_series=bionic
2020-02-05 12:59:18,610 [salt.loaded.ext.module.maas:684 ][INFO    ][3472] deploymachines hwe_kernel=ga-18.04 system_id=b3b8gx distro_series=bionic
2020-02-05 12:59:20,567 [salt.loaded.ext.module.maas:684 ][INFO    ][3472] deploymachines hwe_kernel=ga-18.04 system_id=8qetyg distro_series=bionic
2020-02-05 12:59:22,492 [salt.state       :300 ][INFO    ][3472] {'ret': {'updated': [], 'errors': {}, 'success': ['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']}}
2020-02-05 12:59:22,494 [salt.state       :1951][INFO    ][3472] Completed state [maas.deploy_machines] at time 12:59:22.494292 duration_in_ms=10382.074
2020-02-05 12:59:22,500 [salt.minion      :1711][INFO    ][3472] Returning information for job: 20200205125908533911
2020-02-05 12:59:23,447 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command state.apply with jid 20200205125923432649
2020-02-05 12:59:23,474 [salt.minion      :1432][INFO    ][3531] Starting a new job with PID 3531
2020-02-05 12:59:31,979 [salt.state       :915 ][INFO    ][3531] Loading fresh modules for state activity
2020-02-05 12:59:32,042 [salt.fileclient  :1219][INFO    ][3531] Fetching file from saltenv 'base', ** done ** 'maas/machines/wait_for_deployed.sls'
2020-02-05 12:59:32,108 [salt.state       :1780][INFO    ][3531] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:59:32.108000
2020-02-05 12:59:32,108 [salt.state       :1813][INFO    ][3531] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2020-02-05 12:59:32,110 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3531] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2020-02-05 12:59:34,387 [salt.state       :300 ][INFO    ][3531] {'pid': 3552, 'retcode': 0, 'stderr': '', 'stdout': ''}
2020-02-05 12:59:34,389 [salt.state       :1951][INFO    ][3531] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:59:34.388865 duration_in_ms=2280.864
2020-02-05 12:59:34,393 [salt.state       :1780][INFO    ][3531] Running state [maas.wait_for_machine_status] at time 12:59:34.393048
2020-02-05 12:59:34,393 [salt.state       :1813][INFO    ][3531] Executing state module.run for [maas.wait_for_machine_status]
2020-02-05 12:59:34,394 [salt.utils.decorators:613 ][WARNING ][3531] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-02-05 12:59:37,699 [salt.loaded.ext.module.maas:1024][INFO    ][3531] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2246.70899701s left)
2020-02-05 12:59:38,511 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205125938497506
2020-02-05 12:59:38,536 [salt.minion      :1432][INFO    ][3566] Starting a new job with PID 3566
2020-02-05 12:59:38,572 [salt.minion      :1711][INFO    ][3566] Returning information for job: 20200205125938497506
2020-02-05 13:00:08,619 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205130008607021
2020-02-05 13:00:08,641 [salt.minion      :1432][INFO    ][3599] Starting a new job with PID 3599
2020-02-05 13:00:08,679 [salt.minion      :1711][INFO    ][3599] Returning information for job: 20200205130008607021
2020-02-05 13:00:11,229 [salt.loaded.ext.module.maas:1024][INFO    ][3531] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2213.17949009s left)
2020-02-05 13:00:38,716 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205130038697025
2020-02-05 13:00:38,744 [salt.minion      :1432][INFO    ][3636] Starting a new job with PID 3636
2020-02-05 13:00:38,768 [salt.minion      :1711][INFO    ][3636] Returning information for job: 20200205130038697025
2020-02-05 13:00:44,774 [salt.loaded.ext.module.maas:1024][INFO    ][3531] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2179.63422918s left)
2020-02-05 13:01:08,801 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205130108787484
2020-02-05 13:01:08,830 [salt.minion      :1432][INFO    ][3665] Starting a new job with PID 3665
2020-02-05 13:01:08,854 [salt.minion      :1711][INFO    ][3665] Returning information for job: 20200205130108787484
2020-02-05 13:01:18,532 [salt.loaded.ext.module.maas:1024][INFO    ][3531] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2145.87610197s left)
2020-02-05 13:01:38,887 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205130138870873
2020-02-05 13:01:38,915 [salt.minion      :1432][INFO    ][3695] Starting a new job with PID 3695
2020-02-05 13:01:38,942 [salt.minion      :1711][INFO    ][3695] Returning information for job: 20200205130138870873
2020-02-05 13:01:51,635 [salt.loaded.ext.module.maas:1024][INFO    ][3531] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2112.77283812s left)
2020-02-05 13:02:08,998 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205130208975835
2020-02-05 13:02:09,027 [salt.minion      :1432][INFO    ][3729] Starting a new job with PID 3729
2020-02-05 13:02:09,051 [salt.minion      :1711][INFO    ][3729] Returning information for job: 20200205130208975835
2020-02-05 13:02:25,264 [salt.loaded.ext.module.maas:1024][INFO    ][3531] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2079.14450216s left)
2020-02-05 13:02:39,072 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205130239055874
2020-02-05 13:02:39,104 [salt.minion      :1432][INFO    ][3788] Starting a new job with PID 3788
2020-02-05 13:02:39,127 [salt.minion      :1711][INFO    ][3788] Returning information for job: 20200205130239055874
2020-02-05 13:02:58,847 [salt.loaded.ext.module.maas:1024][INFO    ][3531] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2045.56167603s left)
2020-02-05 13:03:09,191 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205130309174906
2020-02-05 13:03:09,218 [salt.minion      :1432][INFO    ][3841] Starting a new job with PID 3841
2020-02-05 13:03:09,243 [salt.minion      :1711][INFO    ][3841] Returning information for job: 20200205130309174906
2020-02-05 13:03:29,506 [salt.loaded.ext.module.maas:993 ][INFO    ][3531] Machine dr3ax3 mark broken
2020-02-05 13:03:39,307 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205130339292370
2020-02-05 13:03:39,332 [salt.minion      :1432][INFO    ][3891] Starting a new job with PID 3891
2020-02-05 13:03:39,355 [salt.minion      :1711][INFO    ][3891] Returning information for job: 20200205130339292370
2020-02-05 13:04:00,188 [salt.loaded.ext.module.maas:997 ][INFO    ][3531] Machine dr3ax3 mark fixed
2020-02-05 13:04:01,235 [salt.loaded.ext.module.maas:684 ][INFO    ][3531] deploymachines hwe_kernel=ga-18.04 system_id=dr3ax3 distro_series=bionic
2020-02-05 13:04:03,931 [salt.loaded.ext.module.maas:993 ][INFO    ][3531] Machine 87mhmd mark broken
2020-02-05 13:04:09,400 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205130409384040
2020-02-05 13:04:09,453 [salt.minion      :1432][INFO    ][3950] Starting a new job with PID 3950
2020-02-05 13:04:09,487 [salt.minion      :1711][INFO    ][3950] Returning information for job: 20200205130409384040
2020-02-05 13:04:34,581 [salt.loaded.ext.module.maas:997 ][INFO    ][3531] Machine 87mhmd mark fixed
2020-02-05 13:04:36,241 [salt.loaded.ext.module.maas:684 ][INFO    ][3531] deploymachines hwe_kernel=ga-18.04 system_id=87mhmd distro_series=bionic
2020-02-05 13:04:39,555 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205130439541185
2020-02-05 13:04:39,574 [salt.minion      :1432][INFO    ][4045] Starting a new job with PID 4045
2020-02-05 13:04:39,601 [salt.minion      :1711][INFO    ][4045] Returning information for job: 20200205130439541185
2020-02-05 13:04:40,262 [salt.loaded.ext.module.maas:1024][INFO    ][3531] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1944.1459651s left)
2020-02-05 13:05:09,674 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205130509660885
2020-02-05 13:05:09,703 [salt.minion      :1432][INFO    ][4078] Starting a new job with PID 4078
2020-02-05 13:05:09,728 [salt.minion      :1711][INFO    ][4078] Returning information for job: 20200205130509660885
2020-02-05 13:05:14,127 [salt.loaded.ext.module.maas:1024][INFO    ][3531] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1910.28172112s left)
2020-02-05 13:05:39,823 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205130539802587
2020-02-05 13:05:39,843 [salt.minion      :1432][INFO    ][4109] Starting a new job with PID 4109
2020-02-05 13:05:39,866 [salt.minion      :1711][INFO    ][4109] Returning information for job: 20200205130539802587
2020-02-05 13:05:47,469 [salt.loaded.ext.module.maas:1024][INFO    ][3531] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1876.93917799s left)
2020-02-05 13:06:09,939 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205130609930404
2020-02-05 13:06:09,967 [salt.minion      :1432][INFO    ][4134] Starting a new job with PID 4134
2020-02-05 13:06:09,991 [salt.minion      :1711][INFO    ][4134] Returning information for job: 20200205130609930404
2020-02-05 13:06:21,155 [salt.loaded.ext.module.maas:1024][INFO    ][3531] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1843.25378418s left)
2020-02-05 13:06:40,070 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205130640055734
2020-02-05 13:06:40,096 [salt.minion      :1432][INFO    ][4164] Starting a new job with PID 4164
2020-02-05 13:06:40,124 [salt.minion      :1711][INFO    ][4164] Returning information for job: 20200205130640055734
2020-02-05 13:06:54,299 [salt.loaded.ext.module.maas:1024][INFO    ][3531] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1810.10919404s left)
2020-02-05 13:07:10,213 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205130710197066
2020-02-05 13:07:10,237 [salt.minion      :1432][INFO    ][4210] Starting a new job with PID 4210
2020-02-05 13:07:10,262 [salt.minion      :1711][INFO    ][4210] Returning information for job: 20200205130710197066
2020-02-05 13:07:27,661 [salt.loaded.ext.module.maas:1024][INFO    ][3531] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1776.74707699s left)
2020-02-05 13:07:40,354 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205130740341418
2020-02-05 13:07:40,372 [salt.minion      :1432][INFO    ][4272] Starting a new job with PID 4272
2020-02-05 13:07:40,396 [salt.minion      :1711][INFO    ][4272] Returning information for job: 20200205130740341418
2020-02-05 13:07:58,336 [salt.loaded.ext.module.maas:993 ][INFO    ][3531] Machine dr3ax3 mark broken
2020-02-05 13:08:10,495 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205130810481056
2020-02-05 13:08:10,516 [salt.minion      :1432][INFO    ][4313] Starting a new job with PID 4313
2020-02-05 13:08:10,541 [salt.minion      :1711][INFO    ][4313] Returning information for job: 20200205130810481056
2020-02-05 13:08:29,022 [salt.loaded.ext.module.maas:997 ][INFO    ][3531] Machine dr3ax3 mark fixed
2020-02-05 13:08:29,548 [salt.loaded.ext.module.maas:1001][INFO    ][3531] Machine dr3ax3 fio test
2020-02-05 13:08:33,652 [salt.loaded.ext.module.maas:1024][INFO    ][3531] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1710.75596404s left)
2020-02-05 13:08:40,660 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205130840646467
2020-02-05 13:08:40,689 [salt.minion      :1432][INFO    ][4371] Starting a new job with PID 4371
2020-02-05 13:08:40,709 [salt.minion      :1711][INFO    ][4371] Returning information for job: 20200205130840646467
2020-02-05 13:09:04,982 [salt.loaded.ext.module.maas:993 ][INFO    ][3531] Machine 87mhmd mark broken
2020-02-05 13:09:10,819 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205130910801314
2020-02-05 13:09:10,845 [salt.minion      :1432][INFO    ][4404] Starting a new job with PID 4404
2020-02-05 13:09:10,868 [salt.minion      :1711][INFO    ][4404] Returning information for job: 20200205130910801314
2020-02-05 13:09:35,598 [salt.loaded.ext.module.maas:997 ][INFO    ][3531] Machine 87mhmd mark fixed
2020-02-05 13:09:36,086 [salt.loaded.ext.module.maas:1001][INFO    ][3531] Machine 87mhmd fio test
2020-02-05 13:09:39,058 [salt.loaded.ext.module.maas:1024][INFO    ][3531] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1645.35047913s left)
2020-02-05 13:09:40,996 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205130940981932
2020-02-05 13:09:41,030 [salt.minion      :1432][INFO    ][4442] Starting a new job with PID 4442
2020-02-05 13:09:41,072 [salt.minion      :1711][INFO    ][4442] Returning information for job: 20200205130940981932
2020-02-05 13:10:11,192 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205131011180008
2020-02-05 13:10:11,213 [salt.minion      :1432][INFO    ][4477] Starting a new job with PID 4477
2020-02-05 13:10:11,238 [salt.minion      :1711][INFO    ][4477] Returning information for job: 20200205131011180008
2020-02-05 13:10:11,920 [salt.loaded.ext.module.maas:1024][INFO    ][3531] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1612.48871899s left)
2020-02-05 13:10:41,372 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205131041356071
2020-02-05 13:10:41,399 [salt.minion      :1432][INFO    ][4513] Starting a new job with PID 4513
2020-02-05 13:10:41,424 [salt.minion      :1711][INFO    ][4513] Returning information for job: 20200205131041356071
2020-02-05 13:10:44,905 [salt.loaded.ext.module.maas:1024][INFO    ][3531] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1579.50381398s left)
2020-02-05 13:11:11,536 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205131111524053
2020-02-05 13:11:11,557 [salt.minion      :1432][INFO    ][4555] Starting a new job with PID 4555
2020-02-05 13:11:11,582 [salt.minion      :1711][INFO    ][4555] Returning information for job: 20200205131111524053
2020-02-05 13:11:17,697 [salt.loaded.ext.module.maas:1024][INFO    ][3531] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1546.71132517s left)
2020-02-05 13:11:41,727 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205131141711075
2020-02-05 13:11:41,752 [salt.minion      :1432][INFO    ][4582] Starting a new job with PID 4582
2020-02-05 13:11:41,781 [salt.minion      :1711][INFO    ][4582] Returning information for job: 20200205131141711075
2020-02-05 13:11:50,536 [salt.loaded.ext.module.maas:1024][INFO    ][3531] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1513.87193608s left)
2020-02-05 13:12:11,935 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205131211919696
2020-02-05 13:12:11,952 [salt.minion      :1432][INFO    ][4621] Starting a new job with PID 4621
2020-02-05 13:12:11,978 [salt.minion      :1711][INFO    ][4621] Returning information for job: 20200205131211919696
2020-02-05 13:12:23,342 [salt.loaded.ext.module.maas:1024][INFO    ][3531] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1481.06652808s left)
2020-02-05 13:12:42,116 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205131242104740
2020-02-05 13:12:42,133 [salt.minion      :1432][INFO    ][4662] Starting a new job with PID 4662
2020-02-05 13:12:42,158 [salt.minion      :1711][INFO    ][4662] Returning information for job: 20200205131242104740
2020-02-05 13:12:56,300 [salt.loaded.ext.module.maas:1024][INFO    ][3531] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1448.10866714s left)
2020-02-05 13:13:12,250 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205131312232112
2020-02-05 13:13:12,275 [salt.minion      :1432][INFO    ][4731] Starting a new job with PID 4731
2020-02-05 13:13:12,302 [salt.minion      :1711][INFO    ][4731] Returning information for job: 20200205131312232112
2020-02-05 13:13:29,576 [salt.loaded.ext.module.maas:1024][INFO    ][3531] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (1414.83197618s left)
2020-02-05 13:13:42,267 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205131342256405
2020-02-05 13:13:42,293 [salt.minion      :1432][INFO    ][4784] Starting a new job with PID 4784
2020-02-05 13:13:42,319 [salt.minion      :1711][INFO    ][4784] Returning information for job: 20200205131342256405
2020-02-05 13:14:02,792 [salt.loaded.ext.module.maas:1024][INFO    ][3531] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (1381.6158731s left)
2020-02-05 13:14:12,320 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205131412307120
2020-02-05 13:14:12,346 [salt.minion      :1432][INFO    ][4824] Starting a new job with PID 4824
2020-02-05 13:14:12,371 [salt.minion      :1711][INFO    ][4824] Returning information for job: 20200205131412307120
2020-02-05 13:14:35,919 [salt.loaded.ext.module.maas:1024][INFO    ][3531] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (1348.48962712s left)
2020-02-05 13:14:42,371 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205131442357027
2020-02-05 13:14:42,393 [salt.minion      :1432][INFO    ][4851] Starting a new job with PID 4851
2020-02-05 13:14:42,432 [salt.minion      :1711][INFO    ][4851] Returning information for job: 20200205131442357027
2020-02-05 13:15:09,355 [salt.loaded.ext.module.maas:1024][INFO    ][3531] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (1315.053056s left)
2020-02-05 13:15:12,475 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205131512456966
2020-02-05 13:15:12,501 [salt.minion      :1432][INFO    ][4903] Starting a new job with PID 4903
2020-02-05 13:15:12,530 [salt.minion      :1711][INFO    ][4903] Returning information for job: 20200205131512456966
2020-02-05 13:15:42,524 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205131542515260
2020-02-05 13:15:42,544 [salt.minion      :1432][INFO    ][4921] Starting a new job with PID 4921
2020-02-05 13:15:42,577 [salt.minion      :1711][INFO    ][4921] Returning information for job: 20200205131542515260
2020-02-05 13:15:42,829 [salt.loaded.ext.module.maas:1024][INFO    ][3531] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (1281.57883215s left)
2020-02-05 13:16:12,624 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205131612609046
2020-02-05 13:16:12,651 [salt.minion      :1432][INFO    ][4957] Starting a new job with PID 4957
2020-02-05 13:16:12,687 [salt.minion      :1711][INFO    ][4957] Returning information for job: 20200205131612609046
2020-02-05 13:16:16,154 [salt.loaded.ext.module.maas:1024][INFO    ][3531] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (1248.25484204s left)
2020-02-05 13:16:42,728 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205131642713985
2020-02-05 13:16:42,749 [salt.minion      :1432][INFO    ][4976] Starting a new job with PID 4976
2020-02-05 13:16:42,783 [salt.minion      :1711][INFO    ][4976] Returning information for job: 20200205131642713985
2020-02-05 13:16:49,583 [salt.loaded.ext.module.maas:1024][INFO    ][3531] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (1214.82488918s left)
2020-02-05 13:17:12,848 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205131712834745
2020-02-05 13:17:12,877 [salt.minion      :1432][INFO    ][5013] Starting a new job with PID 5013
2020-02-05 13:17:12,906 [salt.minion      :1711][INFO    ][5013] Returning information for job: 20200205131712834745
2020-02-05 13:17:22,963 [salt.loaded.ext.module.maas:1024][INFO    ][3531] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (1181.44523311s left)
2020-02-05 13:17:42,975 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205131742962744
2020-02-05 13:17:42,997 [salt.minion      :1432][INFO    ][5038] Starting a new job with PID 5038
2020-02-05 13:17:43,024 [salt.minion      :1711][INFO    ][5038] Returning information for job: 20200205131742962744
2020-02-05 13:17:56,329 [salt.loaded.ext.module.maas:1024][INFO    ][3531] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (1148.07976007s left)
2020-02-05 13:18:13,130 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205131813116382
2020-02-05 13:18:13,160 [salt.minion      :1432][INFO    ][5070] Starting a new job with PID 5070
2020-02-05 13:18:13,200 [salt.minion      :1711][INFO    ][5070] Returning information for job: 20200205131813116382
2020-02-05 13:18:29,865 [salt.loaded.ext.module.maas:1024][INFO    ][3531] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (1114.54320312s left)
2020-02-05 13:18:43,286 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205131843273213
2020-02-05 13:18:43,309 [salt.minion      :1432][INFO    ][5104] Starting a new job with PID 5104
2020-02-05 13:18:43,335 [salt.minion      :1711][INFO    ][5104] Returning information for job: 20200205131843273213
2020-02-05 13:19:03,195 [salt.loaded.ext.module.maas:1024][INFO    ][3531] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (1081.21312714s left)
2020-02-05 13:19:13,458 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205131913442350
2020-02-05 13:19:13,483 [salt.minion      :1432][INFO    ][5132] Starting a new job with PID 5132
2020-02-05 13:19:13,509 [salt.minion      :1711][INFO    ][5132] Returning information for job: 20200205131913442350
2020-02-05 13:19:36,619 [salt.loaded.ext.module.maas:1024][INFO    ][3531] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (1047.79150605s left)
2020-02-05 13:19:43,631 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205131943622015
2020-02-05 13:19:43,654 [salt.minion      :1432][INFO    ][5153] Starting a new job with PID 5153
2020-02-05 13:19:43,688 [salt.minion      :1711][INFO    ][5153] Returning information for job: 20200205131943622015
2020-02-05 13:20:10,092 [salt.loaded.ext.module.maas:1024][INFO    ][3531] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (1014.31662917s left)
2020-02-05 13:20:13,814 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205132013798673
2020-02-05 13:20:13,844 [salt.minion      :1432][INFO    ][5183] Starting a new job with PID 5183
2020-02-05 13:20:13,872 [salt.minion      :1711][INFO    ][5183] Returning information for job: 20200205132013798673
2020-02-05 13:20:43,288 [salt.loaded.ext.module.maas:1024][INFO    ][3531] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (981.120783091s left)
2020-02-05 13:20:43,992 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205132043980879
2020-02-05 13:20:44,019 [salt.minion      :1432][INFO    ][5210] Starting a new job with PID 5210
2020-02-05 13:20:44,044 [salt.minion      :1711][INFO    ][5210] Returning information for job: 20200205132043980879
2020-02-05 13:21:14,012 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205132113997991
2020-02-05 13:21:14,036 [salt.minion      :1432][INFO    ][5230] Starting a new job with PID 5230
2020-02-05 13:21:14,064 [salt.minion      :1711][INFO    ][5230] Returning information for job: 20200205132113997991
2020-02-05 13:21:16,739 [salt.loaded.ext.module.maas:1024][INFO    ][3531] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (947.669381142s left)
2020-02-05 13:21:44,042 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205132144029080
2020-02-05 13:21:44,064 [salt.minion      :1432][INFO    ][5255] Starting a new job with PID 5255
2020-02-05 13:21:44,089 [salt.minion      :1711][INFO    ][5255] Returning information for job: 20200205132144029080
2020-02-05 13:21:49,990 [salt.loaded.ext.module.maas:1024][INFO    ][3531] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (914.418177128s left)
2020-02-05 13:22:14,255 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205132214240301
2020-02-05 13:22:14,282 [salt.minion      :1432][INFO    ][5276] Starting a new job with PID 5276
2020-02-05 13:22:14,308 [salt.minion      :1711][INFO    ][5276] Returning information for job: 20200205132214240301
2020-02-05 13:22:23,175 [salt.loaded.ext.module.maas:1024][INFO    ][3531] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (881.233165026s left)
2020-02-05 13:22:44,304 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205132244292209
2020-02-05 13:22:44,323 [salt.minion      :1432][INFO    ][5305] Starting a new job with PID 5305
2020-02-05 13:22:44,349 [salt.minion      :1711][INFO    ][5305] Returning information for job: 20200205132244292209
2020-02-05 13:22:56,406 [salt.loaded.ext.module.maas:1024][INFO    ][3531] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (848.001880169s left)
2020-02-05 13:23:14,331 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205132314322618
2020-02-05 13:23:14,359 [salt.minion      :1432][INFO    ][5329] Starting a new job with PID 5329
2020-02-05 13:23:14,388 [salt.minion      :1711][INFO    ][5329] Returning information for job: 20200205132314322618
2020-02-05 13:23:29,598 [salt.loaded.ext.module.maas:1024][INFO    ][3531] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (814.810137033s left)
2020-02-05 13:23:44,434 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205132344424548
2020-02-05 13:23:44,461 [salt.minion      :1432][INFO    ][5350] Starting a new job with PID 5350
2020-02-05 13:23:44,484 [salt.minion      :1711][INFO    ][5350] Returning information for job: 20200205132344424548
2020-02-05 13:24:02,936 [salt.loaded.ext.module.maas:1024][INFO    ][3531] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (781.472339153s left)
2020-02-05 13:24:14,488 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205132414477981
2020-02-05 13:24:14,516 [salt.minion      :1432][INFO    ][5376] Starting a new job with PID 5376
2020-02-05 13:24:14,541 [salt.minion      :1711][INFO    ][5376] Returning information for job: 20200205132414477981
2020-02-05 13:24:35,974 [salt.loaded.ext.module.maas:1024][INFO    ][3531] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (748.434020996s left)
2020-02-05 13:24:44,620 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205132444604727
2020-02-05 13:24:44,642 [salt.minion      :1432][INFO    ][5397] Starting a new job with PID 5397
2020-02-05 13:24:44,672 [salt.minion      :1711][INFO    ][5397] Returning information for job: 20200205132444604727
2020-02-05 13:25:09,207 [salt.loaded.ext.module.maas:1024][INFO    ][3531] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (715.201249123s left)
2020-02-05 13:25:14,743 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205132514728425
2020-02-05 13:25:14,770 [salt.minion      :1432][INFO    ][5418] Starting a new job with PID 5418
2020-02-05 13:25:14,795 [salt.minion      :1711][INFO    ][5418] Returning information for job: 20200205132514728425
2020-02-05 13:25:42,254 [salt.loaded.ext.module.maas:1024][INFO    ][3531] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (682.154330015s left)
2020-02-05 13:25:44,883 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205132544869969
2020-02-05 13:25:44,911 [salt.minion      :1432][INFO    ][5438] Starting a new job with PID 5438
2020-02-05 13:25:44,937 [salt.minion      :1711][INFO    ][5438] Returning information for job: 20200205132544869969
2020-02-05 13:26:15,059 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205132615048291
2020-02-05 13:26:15,079 [salt.minion      :1432][INFO    ][5459] Starting a new job with PID 5459
2020-02-05 13:26:15,109 [salt.minion      :1711][INFO    ][5459] Returning information for job: 20200205132615048291
2020-02-05 13:26:15,349 [salt.loaded.ext.module.maas:1024][INFO    ][3531] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (649.059002161s left)
2020-02-05 13:26:45,275 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205132645264230
2020-02-05 13:26:45,301 [salt.minion      :1432][INFO    ][5479] Starting a new job with PID 5479
2020-02-05 13:26:45,325 [salt.minion      :1711][INFO    ][5479] Returning information for job: 20200205132645264230
2020-02-05 13:26:48,655 [salt.loaded.ext.module.maas:1024][INFO    ][3531] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (615.752892017s left)
2020-02-05 13:27:15,315 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205132715307147
2020-02-05 13:27:15,328 [salt.minion      :1432][INFO    ][5503] Starting a new job with PID 5503
2020-02-05 13:27:15,356 [salt.minion      :1711][INFO    ][5503] Returning information for job: 20200205132715307147
2020-02-05 13:27:21,853 [salt.loaded.ext.module.maas:1024][INFO    ][3531] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (582.55550313s left)
2020-02-05 13:27:45,520 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205132745507115
2020-02-05 13:27:45,542 [salt.minion      :1432][INFO    ][5525] Starting a new job with PID 5525
2020-02-05 13:27:45,564 [salt.minion      :1711][INFO    ][5525] Returning information for job: 20200205132745507115
2020-02-05 13:27:55,012 [salt.loaded.ext.module.maas:1024][INFO    ][3531] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (549.396717072s left)
2020-02-05 13:28:15,586 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205132815571709
2020-02-05 13:28:15,612 [salt.minion      :1432][INFO    ][5549] Starting a new job with PID 5549
2020-02-05 13:28:15,637 [salt.minion      :1711][INFO    ][5549] Returning information for job: 20200205132815571709
2020-02-05 13:28:28,126 [salt.loaded.ext.module.maas:1024][INFO    ][3531] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (516.281848192s left)
2020-02-05 13:28:45,668 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205132845652941
2020-02-05 13:28:45,696 [salt.minion      :1432][INFO    ][5568] Starting a new job with PID 5568
2020-02-05 13:28:45,719 [salt.minion      :1711][INFO    ][5568] Returning information for job: 20200205132845652941
2020-02-05 13:29:01,326 [salt.loaded.ext.module.maas:1024][INFO    ][3531] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (483.081839085s left)
2020-02-05 13:29:15,775 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205132915760883
2020-02-05 13:29:15,799 [salt.minion      :1432][INFO    ][5590] Starting a new job with PID 5590
2020-02-05 13:29:15,829 [salt.minion      :1711][INFO    ][5590] Returning information for job: 20200205132915760883
2020-02-05 13:29:34,465 [salt.loaded.ext.module.maas:1024][INFO    ][3531] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (449.942918062s left)
2020-02-05 13:29:45,802 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205132945788375
2020-02-05 13:29:45,830 [salt.minion      :1432][INFO    ][5609] Starting a new job with PID 5609
2020-02-05 13:29:45,854 [salt.minion      :1711][INFO    ][5609] Returning information for job: 20200205132945788375
2020-02-05 13:30:07,557 [salt.loaded.ext.module.maas:1024][INFO    ][3531] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (416.851253033s left)
2020-02-05 13:30:15,965 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205133015948530
2020-02-05 13:30:15,991 [salt.minion      :1432][INFO    ][5641] Starting a new job with PID 5641
2020-02-05 13:30:16,016 [salt.minion      :1711][INFO    ][5641] Returning information for job: 20200205133015948530
2020-02-05 13:30:40,606 [salt.loaded.ext.module.maas:1024][INFO    ][3531] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (383.80216217s left)
2020-02-05 13:30:46,032 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205133046021145
2020-02-05 13:30:46,063 [salt.minion      :1432][INFO    ][5671] Starting a new job with PID 5671
2020-02-05 13:30:46,092 [salt.minion      :1711][INFO    ][5671] Returning information for job: 20200205133046021145
2020-02-05 13:31:13,759 [salt.loaded.ext.module.maas:1024][INFO    ][3531] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (350.649793148s left)
2020-02-05 13:31:16,248 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205133116238240
2020-02-05 13:31:16,267 [salt.minion      :1432][INFO    ][5691] Starting a new job with PID 5691
2020-02-05 13:31:16,293 [salt.minion      :1711][INFO    ][5691] Returning information for job: 20200205133116238240
2020-02-05 13:31:46,411 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205133146396041
2020-02-05 13:31:46,431 [salt.minion      :1432][INFO    ][5713] Starting a new job with PID 5713
2020-02-05 13:31:46,456 [salt.minion      :1711][INFO    ][5713] Returning information for job: 20200205133146396041
2020-02-05 13:31:46,908 [salt.loaded.ext.module.maas:1024][INFO    ][3531] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (317.500111103s left)
2020-02-05 13:32:16,611 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205133216594603
2020-02-05 13:32:16,636 [salt.minion      :1432][INFO    ][5734] Starting a new job with PID 5734
2020-02-05 13:32:16,660 [salt.minion      :1711][INFO    ][5734] Returning information for job: 20200205133216594603
2020-02-05 13:32:19,988 [salt.loaded.ext.module.maas:1024][INFO    ][3531] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (284.420310974s left)
2020-02-05 13:32:46,839 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205133246826581
2020-02-05 13:32:46,868 [salt.minion      :1432][INFO    ][5755] Starting a new job with PID 5755
2020-02-05 13:32:46,891 [salt.minion      :1711][INFO    ][5755] Returning information for job: 20200205133246826581
2020-02-05 13:32:53,086 [salt.loaded.ext.module.maas:1024][INFO    ][3531] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (251.322391033s left)
2020-02-05 13:33:16,912 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205133316895953
2020-02-05 13:33:16,942 [salt.minion      :1432][INFO    ][5776] Starting a new job with PID 5776
2020-02-05 13:33:16,967 [salt.minion      :1711][INFO    ][5776] Returning information for job: 20200205133316895953
2020-02-05 13:33:26,260 [salt.loaded.ext.module.maas:1024][INFO    ][3531] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (218.148092031s left)
2020-02-05 13:33:46,942 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205133346927856
2020-02-05 13:33:46,968 [salt.minion      :1432][INFO    ][5797] Starting a new job with PID 5797
2020-02-05 13:33:46,994 [salt.minion      :1711][INFO    ][5797] Returning information for job: 20200205133346927856
2020-02-05 13:33:59,313 [salt.loaded.ext.module.maas:1024][INFO    ][3531] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (185.095035076s left)
2020-02-05 13:34:17,011 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205133416998229
2020-02-05 13:34:17,038 [salt.minion      :1432][INFO    ][5818] Starting a new job with PID 5818
2020-02-05 13:34:17,067 [salt.minion      :1711][INFO    ][5818] Returning information for job: 20200205133416998229
2020-02-05 13:34:32,519 [salt.loaded.ext.module.maas:1024][INFO    ][3531] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (151.889183998s left)
2020-02-05 13:34:47,158 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205133447144766
2020-02-05 13:34:47,182 [salt.minion      :1432][INFO    ][5840] Starting a new job with PID 5840
2020-02-05 13:34:47,208 [salt.minion      :1711][INFO    ][5840] Returning information for job: 20200205133447144766
2020-02-05 13:35:05,544 [salt.loaded.ext.module.maas:1024][INFO    ][3531] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (118.863870144s left)
2020-02-05 13:35:17,259 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205133517245179
2020-02-05 13:35:17,289 [salt.minion      :1432][INFO    ][5861] Starting a new job with PID 5861
2020-02-05 13:35:17,316 [salt.minion      :1711][INFO    ][5861] Returning information for job: 20200205133517245179
2020-02-05 13:35:38,611 [salt.loaded.ext.module.maas:1024][INFO    ][3531] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (85.7974560261s left)
2020-02-05 13:35:47,440 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205133547423592
2020-02-05 13:35:47,468 [salt.minion      :1432][INFO    ][5883] Starting a new job with PID 5883
2020-02-05 13:35:47,494 [salt.minion      :1711][INFO    ][5883] Returning information for job: 20200205133547423592
2020-02-05 13:36:11,783 [salt.loaded.ext.module.maas:1024][INFO    ][3531] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (52.6249361038s left)
2020-02-05 13:36:17,580 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205133617563592
2020-02-05 13:36:17,612 [salt.minion      :1432][INFO    ][5905] Starting a new job with PID 5905
2020-02-05 13:36:17,645 [salt.minion      :1711][INFO    ][5905] Returning information for job: 20200205133617563592
2020-02-05 13:36:44,980 [salt.loaded.ext.module.maas:1024][INFO    ][3531] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (19.4282310009s left)
2020-02-05 13:36:47,770 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205133647754495
2020-02-05 13:36:47,798 [salt.minion      :1432][INFO    ][5927] Starting a new job with PID 5927
2020-02-05 13:36:47,826 [salt.minion      :1711][INFO    ][5927] Returning information for job: 20200205133647754495
2020-02-05 13:37:17,950 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205133717937923
2020-02-05 13:37:17,976 [salt.minion      :1432][INFO    ][5950] Starting a new job with PID 5950
2020-02-05 13:37:18,002 [salt.minion      :1711][INFO    ][5950] Returning information for job: 20200205133717937923
2020-02-05 13:37:18,267 [salt.state       :302 ][ERROR   ][3531] Module function maas.wait_for_machine_status threw an exception. Exception: Machines:['cmp002', 'cmp001']not in Deployed state
2020-02-05 13:37:18,267 [salt.state       :1951][INFO    ][3531] Completed state [maas.wait_for_machine_status] at time 13:37:18.267715 duration_in_ms=2263874.666
2020-02-05 13:37:18,274 [salt.minion      :1711][INFO    ][3531] Returning information for job: 20200205125923432649
2020-02-05 13:37:29,510 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command pillar.get with jid 20200205133729497494
2020-02-05 13:37:29,539 [salt.minion      :1432][INFO    ][5958] Starting a new job with PID 5958
2020-02-05 13:37:29,551 [salt.minion      :1711][INFO    ][5958] Returning information for job: 20200205133729497494
2020-02-05 13:37:30,456 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command service.status with jid 20200205133730441837
2020-02-05 13:37:30,483 [salt.minion      :1432][INFO    ][5963] Starting a new job with PID 5963
2020-02-05 13:37:31,230 [salt.loader.10.20.0.2.int.module.cmdmod:395 ][INFO    ][5963] Executing command ['systemctl', 'status', 'maas-fixup.service', '-n', '0'] in directory '/root'
2020-02-05 13:37:31,286 [salt.loader.10.20.0.2.int.module.cmdmod:395 ][INFO    ][5963] Executing command ['systemctl', 'is-active', 'maas-fixup.service'] in directory '/root'
2020-02-05 13:37:31,309 [salt.minion      :1711][INFO    ][5963] Returning information for job: 20200205133730441837
2020-02-05 13:37:32,291 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command state.apply with jid 20200205133732277258
2020-02-05 13:37:32,318 [salt.minion      :1432][INFO    ][5980] Starting a new job with PID 5980
2020-02-05 13:37:40,626 [salt.state       :915 ][INFO    ][5980] Loading fresh modules for state activity
2020-02-05 13:37:41,292 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5980] Executing command 'salt-minion --version' in directory '/root'
2020-02-05 13:37:41,654 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5980] Executing command 'salt-minion --version' in directory '/root'
2020-02-05 13:37:42,796 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5980] Executing command 'salt-minion --version' in directory '/root'
2020-02-05 13:37:43,177 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5980] Executing command 'salt-minion --version' in directory '/root'
2020-02-05 13:37:45,523 [salt.state       :1780][INFO    ][5980] Running state [salt-minion] at time 13:37:45.523260
2020-02-05 13:37:45,523 [salt.state       :1813][INFO    ][5980] Executing state pkg.installed for [salt-minion]
2020-02-05 13:37:45,524 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5980] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2020-02-05 13:37:45,656 [salt.state       :300 ][INFO    ][5980] All specified packages are already installed
2020-02-05 13:37:45,656 [salt.state       :1951][INFO    ][5980] Completed state [salt-minion] at time 13:37:45.656698 duration_in_ms=133.438
2020-02-05 13:37:45,657 [salt.state       :1780][INFO    ][5980] Running state [salt_minion_dependency_packages] at time 13:37:45.657082
2020-02-05 13:37:45,657 [salt.state       :1813][INFO    ][5980] Executing state pkg.installed for [salt_minion_dependency_packages]
2020-02-05 13:37:45,667 [salt.state       :300 ][INFO    ][5980] All specified packages are already installed
2020-02-05 13:37:45,667 [salt.state       :1951][INFO    ][5980] Completed state [salt_minion_dependency_packages] at time 13:37:45.667919 duration_in_ms=10.837
2020-02-05 13:37:45,671 [salt.state       :1780][INFO    ][5980] Running state [/etc/salt/minion.d/minion.conf] at time 13:37:45.671637
2020-02-05 13:37:45,671 [salt.state       :1813][INFO    ][5980] Executing state file.managed for [/etc/salt/minion.d/minion.conf]
2020-02-05 13:37:45,958 [salt.state       :300 ][INFO    ][5980] File /etc/salt/minion.d/minion.conf is in the correct state
2020-02-05 13:37:45,959 [salt.state       :1951][INFO    ][5980] Completed state [/etc/salt/minion.d/minion.conf] at time 13:37:45.959166 duration_in_ms=287.528
2020-02-05 13:37:45,959 [salt.state       :1780][INFO    ][5980] Running state [python-netaddr] at time 13:37:45.959530
2020-02-05 13:37:45,959 [salt.state       :1813][INFO    ][5980] Executing state pkg.installed for [python-netaddr]
2020-02-05 13:37:45,968 [salt.state       :300 ][INFO    ][5980] All specified packages are already installed
2020-02-05 13:37:45,969 [salt.state       :1951][INFO    ][5980] Completed state [python-netaddr] at time 13:37:45.969151 duration_in_ms=9.621
2020-02-05 13:37:45,973 [salt.state       :1780][INFO    ][5980] Running state [/etc/systemd/system/salt-minion.service.d/50-restarts.conf] at time 13:37:45.973003
2020-02-05 13:37:45,973 [salt.state       :1813][INFO    ][5980] Executing state file.managed for [/etc/systemd/system/salt-minion.service.d/50-restarts.conf]
2020-02-05 13:37:45,990 [salt.state       :300 ][INFO    ][5980] File /etc/systemd/system/salt-minion.service.d/50-restarts.conf is in the correct state
2020-02-05 13:37:45,990 [salt.state       :1951][INFO    ][5980] Completed state [/etc/systemd/system/salt-minion.service.d/50-restarts.conf] at time 13:37:45.990748 duration_in_ms=17.744
2020-02-05 13:37:45,992 [salt.state       :1780][INFO    ][5980] Running state [salt-minion] at time 13:37:45.992646
2020-02-05 13:37:45,993 [salt.state       :1813][INFO    ][5980] Executing state service.running for [salt-minion]
2020-02-05 13:37:45,994 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5980] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2020-02-05 13:37:46,048 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5980] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2020-02-05 13:37:46,076 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5980] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2020-02-05 13:37:46,105 [salt.state       :300 ][INFO    ][5980] The service salt-minion is already running
2020-02-05 13:37:46,106 [salt.state       :1951][INFO    ][5980] Completed state [salt-minion] at time 13:37:46.106046 duration_in_ms=113.399
2020-02-05 13:37:46,108 [salt.state       :1780][INFO    ][5980] Running state [/etc/salt/grains.d] at time 13:37:46.108810
2020-02-05 13:37:46,111 [salt.state       :1813][INFO    ][5980] Executing state file.directory for [/etc/salt/grains.d]
2020-02-05 13:37:46,112 [salt.state       :300 ][INFO    ][5980] Directory /etc/salt/grains.d is in the correct state
Directory /etc/salt/grains.d updated
2020-02-05 13:37:46,113 [salt.state       :1951][INFO    ][5980] Completed state [/etc/salt/grains.d] at time 13:37:46.113210 duration_in_ms=4.401
2020-02-05 13:37:46,114 [salt.state       :1780][INFO    ][5980] Running state [/etc/salt/grains] at time 13:37:46.114239
2020-02-05 13:37:46,114 [salt.state       :1813][INFO    ][5980] Executing state file.managed for [/etc/salt/grains]
2020-02-05 13:37:46,115 [salt.state       :300 ][INFO    ][5980] File /etc/salt/grains exists with proper permissions. No changes made.
2020-02-05 13:37:46,115 [salt.state       :1951][INFO    ][5980] Completed state [/etc/salt/grains] at time 13:37:46.115768 duration_in_ms=1.529
2020-02-05 13:37:46,116 [salt.state       :1780][INFO    ][5980] Running state [/etc/salt/grains.d/placeholder] at time 13:37:46.116476
2020-02-05 13:37:46,116 [salt.state       :1813][INFO    ][5980] Executing state file.managed for [/etc/salt/grains.d/placeholder]
2020-02-05 13:37:46,117 [salt.state       :300 ][INFO    ][5980] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2020-02-05 13:37:46,118 [salt.state       :1951][INFO    ][5980] Completed state [/etc/salt/grains.d/placeholder] at time 13:37:46.118005 duration_in_ms=1.53
2020-02-05 13:37:46,118 [salt.state       :1780][INFO    ][5980] Running state [/etc/salt/grains.d/sphinx] at time 13:37:46.118729
2020-02-05 13:37:46,119 [salt.state       :1813][INFO    ][5980] Executing state file.managed for [/etc/salt/grains.d/sphinx]
2020-02-05 13:37:46,120 [salt.state       :300 ][INFO    ][5980] File /etc/salt/grains.d/sphinx is in the correct state
2020-02-05 13:37:46,122 [salt.state       :1951][INFO    ][5980] Completed state [/etc/salt/grains.d/sphinx] at time 13:37:46.121218 duration_in_ms=2.489
2020-02-05 13:37:46,125 [salt.state       :1780][INFO    ][5980] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 13:37:46.125606
2020-02-05 13:37:46,125 [salt.state       :1813][INFO    ][5980] Executing state cmd.wait for [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"]
2020-02-05 13:37:46,126 [salt.state       :300 ][INFO    ][5980] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2020-02-05 13:37:46,126 [salt.state       :1951][INFO    ][5980] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 13:37:46.126493 duration_in_ms=0.887
2020-02-05 13:37:46,127 [salt.state       :1780][INFO    ][5980] Running state [/etc/salt/grains.d/dns_records] at time 13:37:46.127031
2020-02-05 13:37:46,127 [salt.state       :1813][INFO    ][5980] Executing state file.managed for [/etc/salt/grains.d/dns_records]
2020-02-05 13:37:46,128 [salt.state       :300 ][INFO    ][5980] File /etc/salt/grains.d/dns_records is in the correct state
2020-02-05 13:37:46,128 [salt.state       :1951][INFO    ][5980] Completed state [/etc/salt/grains.d/dns_records] at time 13:37:46.128609 duration_in_ms=1.578
2020-02-05 13:37:46,130 [salt.state       :1780][INFO    ][5980] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 13:37:46.130078
2020-02-05 13:37:46,130 [salt.state       :1813][INFO    ][5980] 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-05 13:37:46,130 [salt.state       :300 ][INFO    ][5980] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2020-02-05 13:37:46,130 [salt.state       :1951][INFO    ][5980] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 13:37:46.130907 duration_in_ms=0.829
2020-02-05 13:37:46,131 [salt.state       :1780][INFO    ][5980] Running state [/etc/salt/grains.d/salt] at time 13:37:46.131430
2020-02-05 13:37:46,131 [salt.state       :1813][INFO    ][5980] Executing state file.managed for [/etc/salt/grains.d/salt]
2020-02-05 13:37:46,132 [salt.state       :300 ][INFO    ][5980] File /etc/salt/grains.d/salt is in the correct state
2020-02-05 13:37:46,133 [salt.state       :1951][INFO    ][5980] Completed state [/etc/salt/grains.d/salt] at time 13:37:46.133026 duration_in_ms=1.597
2020-02-05 13:37:46,134 [salt.state       :1780][INFO    ][5980] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 13:37:46.134601
2020-02-05 13:37:46,134 [salt.state       :1813][INFO    ][5980] Executing state cmd.wait for [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"]
2020-02-05 13:37:46,135 [salt.state       :300 ][INFO    ][5980] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2020-02-05 13:37:46,135 [salt.state       :1951][INFO    ][5980] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 13:37:46.135456 duration_in_ms=0.855
2020-02-05 13:37:46,138 [salt.state       :1780][INFO    ][5980] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 13:37:46.138002
2020-02-05 13:37:46,138 [salt.state       :1813][INFO    ][5980] Executing state cmd.wait for [cat /etc/salt/grains.d/* > /etc/salt/grains]
2020-02-05 13:37:46,138 [salt.state       :300 ][INFO    ][5980] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2020-02-05 13:37:46,138 [salt.state       :1951][INFO    ][5980] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 13:37:46.138868 duration_in_ms=0.867
2020-02-05 13:37:46,139 [salt.state       :1780][INFO    ][5980] Running state [mine.update] at time 13:37:46.139567
2020-02-05 13:37:46,139 [salt.state       :1813][INFO    ][5980] Executing state module.wait for [mine.update]
2020-02-05 13:37:46,140 [salt.state       :300 ][INFO    ][5980] No changes made for mine.update
2020-02-05 13:37:46,140 [salt.state       :1951][INFO    ][5980] Completed state [mine.update] at time 13:37:46.140363 duration_in_ms=0.796
2020-02-05 13:37:46,140 [salt.state       :1780][INFO    ][5980] Running state [ca-certificates] at time 13:37:46.140643
2020-02-05 13:37:46,140 [salt.state       :1813][INFO    ][5980] Executing state pkg.installed for [ca-certificates]
2020-02-05 13:37:46,151 [salt.state       :300 ][INFO    ][5980] All specified packages are already installed
2020-02-05 13:37:46,151 [salt.state       :1951][INFO    ][5980] Completed state [ca-certificates] at time 13:37:46.151389 duration_in_ms=10.746
2020-02-05 13:37:46,152 [salt.state       :1780][INFO    ][5980] Running state [update-ca-certificates] at time 13:37:46.152125
2020-02-05 13:37:46,152 [salt.state       :1813][INFO    ][5980] Executing state cmd.wait for [update-ca-certificates]
2020-02-05 13:37:46,152 [salt.state       :300 ][INFO    ][5980] No changes made for update-ca-certificates
2020-02-05 13:37:46,153 [salt.state       :1951][INFO    ][5980] Completed state [update-ca-certificates] at time 13:37:46.152937 duration_in_ms=0.812
2020-02-05 13:37:46,153 [salt.state       :1780][INFO    ][5980] Running state [iptables] at time 13:37:46.153218
2020-02-05 13:37:46,153 [salt.state       :1813][INFO    ][5980] Executing state pkg.installed for [iptables]
2020-02-05 13:37:46,163 [salt.state       :300 ][INFO    ][5980] All specified packages are already installed
2020-02-05 13:37:46,163 [salt.state       :1951][INFO    ][5980] Completed state [iptables] at time 13:37:46.163704 duration_in_ms=10.486
2020-02-05 13:37:46,164 [salt.state       :1780][INFO    ][5980] Running state [iptables-persistent] at time 13:37:46.163998
2020-02-05 13:37:46,164 [salt.state       :1813][INFO    ][5980] Executing state pkg.installed for [iptables-persistent]
2020-02-05 13:37:46,173 [salt.state       :300 ][INFO    ][5980] All specified packages are already installed
2020-02-05 13:37:46,174 [salt.state       :1951][INFO    ][5980] Completed state [iptables-persistent] at time 13:37:46.174055 duration_in_ms=10.058
2020-02-05 13:37:46,175 [salt.state       :1780][INFO    ][5980] Running state [iptables_modules_v4_load] at time 13:37:46.175110
2020-02-05 13:37:46,175 [salt.state       :1813][INFO    ][5980] Executing state kmod.present for [iptables_modules_v4_load]
2020-02-05 13:37:46,176 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5980] Executing command 'lsmod' in directory '/root'
2020-02-05 13:37:46,201 [salt.state       :300 ][INFO    ][5980] Kernel modules iptable_filter, ip_tables are already present
2020-02-05 13:37:46,202 [salt.state       :1951][INFO    ][5980] Completed state [iptables_modules_v4_load] at time 13:37:46.202396 duration_in_ms=27.285
2020-02-05 13:37:46,204 [salt.state       :1780][INFO    ][5980] Running state [/etc/iptables/rules.v4] at time 13:37:46.203911
2020-02-05 13:37:46,204 [salt.state       :1813][INFO    ][5980] Executing state file.managed for [/etc/iptables/rules.v4]
2020-02-05 13:37:46,315 [salt.state       :300 ][INFO    ][5980] File /etc/iptables/rules.v4 is in the correct state
2020-02-05 13:37:46,315 [salt.state       :1951][INFO    ][5980] Completed state [/etc/iptables/rules.v4] at time 13:37:46.315800 duration_in_ms=111.89
2020-02-05 13:37:46,317 [salt.state       :1780][INFO    ][5980] Running state [find /usr/share/netfilter-persistent/plugins.d/[0-9]*-ip4tables -exec {} start \;] at time 13:37:46.316941
2020-02-05 13:37:46,317 [salt.state       :1813][INFO    ][5980] Executing state cmd.run for [find /usr/share/netfilter-persistent/plugins.d/[0-9]*-ip4tables -exec {} start \;]
2020-02-05 13:37:46,317 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5980] Executing command 'test $(iptables-save | wc -l) -eq 0' in directory '/root'
2020-02-05 13:37:46,340 [salt.state       :300 ][INFO    ][5980] onlyif execution failed
2020-02-05 13:37:46,340 [salt.state       :1951][INFO    ][5980] Completed state [find /usr/share/netfilter-persistent/plugins.d/[0-9]*-ip4tables -exec {} start \;] at time 13:37:46.340715 duration_in_ms=23.773
2020-02-05 13:37:46,343 [salt.state       :1780][INFO    ][5980] Running state [netfilter-persistent] at time 13:37:46.343302
2020-02-05 13:37:46,344 [salt.state       :1813][INFO    ][5980] Executing state service.running for [netfilter-persistent]
2020-02-05 13:37:46,345 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5980] Executing command ['systemctl', 'status', 'netfilter-persistent.service', '-n', '0'] in directory '/root'
2020-02-05 13:37:46,376 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5980] Executing command ['systemctl', 'is-active', 'netfilter-persistent.service'] in directory '/root'
2020-02-05 13:37:46,402 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5980] Executing command ['systemctl', 'is-enabled', 'netfilter-persistent.service'] in directory '/root'
2020-02-05 13:37:46,429 [salt.state       :300 ][INFO    ][5980] The service netfilter-persistent is already running
2020-02-05 13:37:46,429 [salt.state       :1951][INFO    ][5980] Completed state [netfilter-persistent] at time 13:37:46.429513 duration_in_ms=86.209
2020-02-05 13:37:46,431 [salt.state       :1780][INFO    ][5980] Running state [iptables_extra.remove_stale_tables] at time 13:37:46.431301
2020-02-05 13:37:46,431 [salt.state       :1813][INFO    ][5980] Executing state module.wait for [iptables_extra.remove_stale_tables]
2020-02-05 13:37:46,432 [salt.state       :300 ][INFO    ][5980] No changes made for iptables_extra.remove_stale_tables
2020-02-05 13:37:46,433 [salt.state       :1951][INFO    ][5980] Completed state [iptables_extra.remove_stale_tables] at time 13:37:46.433013 duration_in_ms=1.712
2020-02-05 13:37:46,435 [salt.state       :1780][INFO    ][5980] Running state [find /usr/share/netfilter-persistent/plugins.d/[0-9]*-ip6tables -exec {} flush \;] at time 13:37:46.435223
2020-02-05 13:37:46,435 [salt.state       :1813][INFO    ][5980] Executing state cmd.run for [find /usr/share/netfilter-persistent/plugins.d/[0-9]*-ip6tables -exec {} flush \;]
2020-02-05 13:37:46,436 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5980] Executing command 'test $(which ip6tables-save) -eq 0 && test $(ip6tables-save | wc -l) -ne 0' in directory '/root'
2020-02-05 13:37:46,454 [salt.state       :300 ][INFO    ][5980] onlyif execution failed
2020-02-05 13:37:46,454 [salt.state       :1951][INFO    ][5980] Completed state [find /usr/share/netfilter-persistent/plugins.d/[0-9]*-ip6tables -exec {} flush \;] at time 13:37:46.454778 duration_in_ms=19.554
2020-02-05 13:37:46,456 [salt.state       :1780][INFO    ][5980] Running state [/etc/iptables/rules.v6] at time 13:37:46.456180
2020-02-05 13:37:46,456 [salt.state       :1813][INFO    ][5980] Executing state file.absent for [/etc/iptables/rules.v6]
2020-02-05 13:37:46,459 [salt.state       :300 ][INFO    ][5980] File /etc/iptables/rules.v6 is not present
2020-02-05 13:37:46,459 [salt.state       :1951][INFO    ][5980] Completed state [/etc/iptables/rules.v6] at time 13:37:46.459892 duration_in_ms=3.712
2020-02-05 13:37:46,460 [salt.state       :1780][INFO    ][5980] Running state [iptables_extra.flush_all] at time 13:37:46.460670
2020-02-05 13:37:46,460 [salt.state       :1813][INFO    ][5980] Executing state module.wait for [iptables_extra.flush_all]
2020-02-05 13:37:46,461 [salt.state       :300 ][INFO    ][5980] No changes made for iptables_extra.flush_all
2020-02-05 13:37:46,461 [salt.state       :1951][INFO    ][5980] Completed state [iptables_extra.flush_all] at time 13:37:46.461547 duration_in_ms=0.877
2020-02-05 13:37:46,464 [salt.minion      :1711][INFO    ][5980] Returning information for job: 20200205133732277258
2020-02-05 13:37:47,392 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command state.apply with jid 20200205133747377124
2020-02-05 13:37:47,422 [salt.minion      :1432][INFO    ][6063] Starting a new job with PID 6063
2020-02-05 13:37:48,522 [salt.state       :915 ][INFO    ][6063] Loading fresh modules for state activity
2020-02-05 13:37:49,835 [salt.state       :1780][INFO    ][6063] Running state [maas-rack-controller] at time 13:37:49.835620
2020-02-05 13:37:49,836 [salt.state       :1813][INFO    ][6063] Executing state pkg.installed for [maas-rack-controller]
2020-02-05 13:37:49,836 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6063] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2020-02-05 13:37:49,957 [salt.state       :300 ][INFO    ][6063] All specified packages are already installed
2020-02-05 13:37:49,958 [salt.state       :1951][INFO    ][6063] Completed state [maas-rack-controller] at time 13:37:49.958147 duration_in_ms=122.526
2020-02-05 13:37:49,958 [salt.state       :1780][INFO    ][6063] Running state [ipmitool] at time 13:37:49.958860
2020-02-05 13:37:49,959 [salt.state       :1813][INFO    ][6063] Executing state pkg.installed for [ipmitool]
2020-02-05 13:37:49,974 [salt.state       :300 ][INFO    ][6063] All specified packages are already installed
2020-02-05 13:37:49,975 [salt.state       :1951][INFO    ][6063] Completed state [ipmitool] at time 13:37:49.975268 duration_in_ms=16.408
2020-02-05 13:37:49,980 [salt.state       :1780][INFO    ][6063] Running state [/etc/maas/rackd.conf] at time 13:37:49.980118
2020-02-05 13:37:49,980 [salt.state       :1813][INFO    ][6063] Executing state file.line for [/etc/maas/rackd.conf]
2020-02-05 13:37:49,981 [salt.state       :300 ][INFO    ][6063] No changes needed to be made
2020-02-05 13:37:49,981 [salt.state       :1951][INFO    ][6063] Completed state [/etc/maas/rackd.conf] at time 13:37:49.981672 duration_in_ms=1.554
2020-02-05 13:37:49,982 [salt.state       :1780][INFO    ][6063] Running state [/etc/maas/rackd.conf] at time 13:37:49.981958
2020-02-05 13:37:49,982 [salt.state       :1813][INFO    ][6063] Executing state file.managed for [/etc/maas/rackd.conf]
2020-02-05 13:37:49,982 [salt.loaded.int.states.file:2298][WARNING ][6063] 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-05 13:37:49,983 [salt.state       :300 ][INFO    ][6063] File /etc/maas/rackd.conf exists with proper permissions. No changes made.
2020-02-05 13:37:49,983 [salt.state       :1951][INFO    ][6063] Completed state [/etc/maas/rackd.conf] at time 13:37:49.983467 duration_in_ms=1.509
2020-02-05 13:37:49,984 [salt.state       :1780][INFO    ][6063] Running state [maas-rackd] at time 13:37:49.984683
2020-02-05 13:37:49,985 [salt.state       :1813][INFO    ][6063] Executing state service.running for [maas-rackd]
2020-02-05 13:37:49,986 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6063] Executing command ['systemctl', 'status', 'maas-rackd.service', '-n', '0'] in directory '/root'
2020-02-05 13:37:50,036 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6063] Executing command ['systemctl', 'is-active', 'maas-rackd.service'] in directory '/root'
2020-02-05 13:37:50,065 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6063] Executing command ['systemctl', 'is-enabled', 'maas-rackd.service'] in directory '/root'
2020-02-05 13:37:50,090 [salt.state       :300 ][INFO    ][6063] The service maas-rackd is already running
2020-02-05 13:37:50,090 [salt.state       :1951][INFO    ][6063] Completed state [maas-rackd] at time 13:37:50.090627 duration_in_ms=105.943
2020-02-05 13:37:50,092 [salt.minion      :1711][INFO    ][6063] Returning information for job: 20200205133747377124
2020-02-05 13:37:51,011 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command state.apply with jid 20200205133750994979
2020-02-05 13:37:51,037 [salt.minion      :1432][INFO    ][6086] Starting a new job with PID 6086
2020-02-05 13:37:52,187 [salt.state       :915 ][INFO    ][6086] Loading fresh modules for state activity
2020-02-05 13:37:53,623 [salt.state       :1780][INFO    ][6086] Running state [maas-region-controller] at time 13:37:53.623491
2020-02-05 13:37:53,624 [salt.state       :1813][INFO    ][6086] Executing state pkg.installed for [maas-region-controller]
2020-02-05 13:37:53,624 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6086] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2020-02-05 13:37:53,750 [salt.state       :300 ][INFO    ][6086] All specified packages are already installed
2020-02-05 13:37:53,751 [salt.state       :1951][INFO    ][6086] Completed state [maas-region-controller] at time 13:37:53.751047 duration_in_ms=127.557
2020-02-05 13:37:53,752 [salt.state       :1780][INFO    ][6086] Running state [python-oauth] at time 13:37:53.751844
2020-02-05 13:37:53,752 [salt.state       :1813][INFO    ][6086] Executing state pkg.installed for [python-oauth]
2020-02-05 13:37:53,770 [salt.state       :300 ][INFO    ][6086] All specified packages are already installed
2020-02-05 13:37:53,770 [salt.state       :1951][INFO    ][6086] Completed state [python-oauth] at time 13:37:53.770700 duration_in_ms=18.858
2020-02-05 13:37:53,775 [salt.state       :1780][INFO    ][6086] Running state [/etc/maas/regiond.conf] at time 13:37:53.775609
2020-02-05 13:37:53,776 [salt.state       :1813][INFO    ][6086] Executing state file.replace for [/etc/maas/regiond.conf]
2020-02-05 13:37:53,786 [salt.state       :300 ][INFO    ][6086] No changes needed to be made
2020-02-05 13:37:53,786 [salt.state       :1951][INFO    ][6086] Completed state [/etc/maas/regiond.conf] at time 13:37:53.786374 duration_in_ms=10.765
2020-02-05 13:37:53,787 [salt.state       :1780][INFO    ][6086] Running state [/usr/lib/python3/dist-packages/provisioningserver/templates/proxy/maas-proxy.conf.template] at time 13:37:53.787163
2020-02-05 13:37:53,787 [salt.state       :1813][INFO    ][6086] Executing state file.managed for [/usr/lib/python3/dist-packages/provisioningserver/templates/proxy/maas-proxy.conf.template]
2020-02-05 13:37:53,850 [salt.state       :300 ][INFO    ][6086] File /usr/lib/python3/dist-packages/provisioningserver/templates/proxy/maas-proxy.conf.template is in the correct state
2020-02-05 13:37:53,850 [salt.state       :1951][INFO    ][6086] Completed state [/usr/lib/python3/dist-packages/provisioningserver/templates/proxy/maas-proxy.conf.template] at time 13:37:53.850888 duration_in_ms=63.726
2020-02-05 13:37:53,851 [salt.state       :1780][INFO    ][6086] Running state [/usr/lib/python3/dist-packages/maasserver/node_status.py] at time 13:37:53.851449
2020-02-05 13:37:53,851 [salt.state       :1813][INFO    ][6086] Executing state file.replace for [/usr/lib/python3/dist-packages/maasserver/node_status.py]
2020-02-05 13:37:53,856 [salt.state       :300 ][INFO    ][6086] No changes needed to be made
2020-02-05 13:37:53,856 [salt.state       :1951][INFO    ][6086] Completed state [/usr/lib/python3/dist-packages/maasserver/node_status.py] at time 13:37:53.856314 duration_in_ms=4.865
2020-02-05 13:37:53,858 [salt.state       :1780][INFO    ][6086] Running state [/usr/lib/python3/dist-packages/maasserver/node_status.py] at time 13:37:53.858105
2020-02-05 13:37:53,858 [salt.state       :1813][INFO    ][6086] Executing state file.replace for [/usr/lib/python3/dist-packages/maasserver/node_status.py]
2020-02-05 13:37:53,866 [salt.state       :300 ][INFO    ][6086] No changes needed to be made
2020-02-05 13:37:53,866 [salt.state       :1951][INFO    ][6086] Completed state [/usr/lib/python3/dist-packages/maasserver/node_status.py] at time 13:37:53.866347 duration_in_ms=8.242
2020-02-05 13:37:53,866 [salt.state       :1780][INFO    ][6086] Running state [/usr/lib/python3/dist-packages/maasserver/models/node.py] at time 13:37:53.866864
2020-02-05 13:37:53,867 [salt.state       :1813][INFO    ][6086] Executing state file.replace for [/usr/lib/python3/dist-packages/maasserver/models/node.py]
2020-02-05 13:37:53,901 [salt.state       :300 ][INFO    ][6086] No changes needed to be made
2020-02-05 13:37:53,901 [salt.state       :1951][INFO    ][6086] Completed state [/usr/lib/python3/dist-packages/maasserver/models/node.py] at time 13:37:53.901457 duration_in_ms=34.592
2020-02-05 13:37:53,901 [salt.state       :1780][INFO    ][6086] Running state [/usr/share/maas/web/static/css/maas-styles.css] at time 13:37:53.901792
2020-02-05 13:37:53,902 [salt.state       :1813][INFO    ][6086] Executing state file.managed for [/usr/share/maas/web/static/css/maas-styles.css]
2020-02-05 13:37:53,927 [salt.state       :300 ][INFO    ][6086] File /usr/share/maas/web/static/css/maas-styles.css is in the correct state
2020-02-05 13:37:53,927 [salt.state       :1951][INFO    ][6086] Completed state [/usr/share/maas/web/static/css/maas-styles.css] at time 13:37:53.927786 duration_in_ms=25.993
2020-02-05 13:37:53,928 [salt.state       :1780][INFO    ][6086] Running state [/etc/maas/preseeds/curtin_userdata_amd64_generic_trusty] at time 13:37:53.928574
2020-02-05 13:37:53,929 [salt.state       :1813][INFO    ][6086] Executing state file.managed for [/etc/maas/preseeds/curtin_userdata_amd64_generic_trusty]
2020-02-05 13:37:53,982 [salt.state       :300 ][INFO    ][6086] File /etc/maas/preseeds/curtin_userdata_amd64_generic_trusty is in the correct state
2020-02-05 13:37:53,982 [salt.state       :1951][INFO    ][6086] Completed state [/etc/maas/preseeds/curtin_userdata_amd64_generic_trusty] at time 13:37:53.982892 duration_in_ms=54.318
2020-02-05 13:37:53,984 [salt.state       :1780][INFO    ][6086] Running state [/etc/maas/preseeds/curtin_userdata_amd64_generic_xenial] at time 13:37:53.983948
2020-02-05 13:37:53,984 [salt.state       :1813][INFO    ][6086] Executing state file.managed for [/etc/maas/preseeds/curtin_userdata_amd64_generic_xenial]
2020-02-05 13:37:54,055 [salt.state       :300 ][INFO    ][6086] File /etc/maas/preseeds/curtin_userdata_amd64_generic_xenial is in the correct state
2020-02-05 13:37:54,055 [salt.state       :1951][INFO    ][6086] Completed state [/etc/maas/preseeds/curtin_userdata_amd64_generic_xenial] at time 13:37:54.055888 duration_in_ms=71.941
2020-02-05 13:37:54,056 [salt.state       :1780][INFO    ][6086] Running state [/etc/maas/preseeds/curtin_userdata_arm64_generic_xenial] at time 13:37:54.056842
2020-02-05 13:37:54,057 [salt.state       :1813][INFO    ][6086] Executing state file.managed for [/etc/maas/preseeds/curtin_userdata_arm64_generic_xenial]
2020-02-05 13:37:54,143 [salt.state       :300 ][INFO    ][6086] File /etc/maas/preseeds/curtin_userdata_arm64_generic_xenial is in the correct state
2020-02-05 13:37:54,144 [salt.state       :1951][INFO    ][6086] Completed state [/etc/maas/preseeds/curtin_userdata_arm64_generic_xenial] at time 13:37:54.144011 duration_in_ms=87.17
2020-02-05 13:37:54,144 [salt.state       :1780][INFO    ][6086] Running state [/etc/maas/preseeds/curtin_userdata_amd64_generic_bionic] at time 13:37:54.144548
2020-02-05 13:37:54,144 [salt.state       :1813][INFO    ][6086] Executing state file.managed for [/etc/maas/preseeds/curtin_userdata_amd64_generic_bionic]
2020-02-05 13:37:54,212 [salt.state       :300 ][INFO    ][6086] File /etc/maas/preseeds/curtin_userdata_amd64_generic_bionic is in the correct state
2020-02-05 13:37:54,212 [salt.state       :1951][INFO    ][6086] Completed state [/etc/maas/preseeds/curtin_userdata_amd64_generic_bionic] at time 13:37:54.212875 duration_in_ms=68.326
2020-02-05 13:37:54,214 [salt.state       :1780][INFO    ][6086] Running state [/etc/maas/preseeds/curtin_userdata_arm64_generic_bionic] at time 13:37:54.213969
2020-02-05 13:37:54,214 [salt.state       :1813][INFO    ][6086] Executing state file.managed for [/etc/maas/preseeds/curtin_userdata_arm64_generic_bionic]
2020-02-05 13:37:54,282 [salt.state       :300 ][INFO    ][6086] File /etc/maas/preseeds/curtin_userdata_arm64_generic_bionic is in the correct state
2020-02-05 13:37:54,282 [salt.state       :1951][INFO    ][6086] Completed state [/etc/maas/preseeds/curtin_userdata_arm64_generic_bionic] at time 13:37:54.282869 duration_in_ms=68.899
2020-02-05 13:37:54,283 [salt.state       :1780][INFO    ][6086] Running state [/root/.pgpass] at time 13:37:54.283361
2020-02-05 13:37:54,283 [salt.state       :1813][INFO    ][6086] Executing state file.managed for [/root/.pgpass]
2020-02-05 13:37:54,336 [salt.state       :300 ][INFO    ][6086] File /root/.pgpass is in the correct state
2020-02-05 13:37:54,336 [salt.state       :1951][INFO    ][6086] Completed state [/root/.pgpass] at time 13:37:54.336363 duration_in_ms=53.002
2020-02-05 13:37:54,342 [salt.state       :1780][INFO    ][6086] Running state [maas-region migrate --noinput] at time 13:37:54.342434
2020-02-05 13:37:54,342 [salt.state       :1813][INFO    ][6086] Executing state cmd.run for [maas-region migrate --noinput]
2020-02-05 13:37:54,343 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6086] Executing command 'maas-region migrate --noinput' in directory '/root'
2020-02-05 13:37:57,299 [salt.state       :300 ][INFO    ][6086] {'pid': 6117, '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-05 13:37:57,300 [salt.state       :1951][INFO    ][6086] Completed state [maas-region migrate --noinput] at time 13:37:57.299938 duration_in_ms=2957.502
2020-02-05 13:37:57,300 [salt.state       :2022][WARNING ][6086] State is set to retry, but a valid dict for retry configuration was not found.  Using retry defaults
2020-02-05 13:37:57,303 [salt.state       :1780][INFO    ][6086] Running state [maas-regiond] at time 13:37:57.303833
2020-02-05 13:37:57,304 [salt.state       :1813][INFO    ][6086] Executing state service.running for [maas-regiond]
2020-02-05 13:37:57,306 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6086] Executing command ['systemctl', 'status', 'maas-regiond.service', '-n', '0'] in directory '/root'
2020-02-05 13:37:57,360 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6086] Executing command ['systemctl', 'is-active', 'maas-regiond.service'] in directory '/root'
2020-02-05 13:37:57,387 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6086] Executing command ['systemctl', 'is-enabled', 'maas-regiond.service'] in directory '/root'
2020-02-05 13:37:57,417 [salt.state       :300 ][INFO    ][6086] The service maas-regiond is already running
2020-02-05 13:37:57,418 [salt.state       :1951][INFO    ][6086] Completed state [maas-regiond] at time 13:37:57.418253 duration_in_ms=114.419
2020-02-05 13:37:57,421 [salt.state       :1780][INFO    ][6086] Running state [bind9] at time 13:37:57.420940
2020-02-05 13:37:57,421 [salt.state       :1813][INFO    ][6086] Executing state service.running for [bind9]
2020-02-05 13:37:57,423 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6086] Executing command ['systemctl', 'status', 'bind9.service', '-n', '0'] in directory '/root'
2020-02-05 13:37:57,454 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6086] Executing command ['systemctl', 'is-active', 'bind9.service'] in directory '/root'
2020-02-05 13:37:57,483 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6086] Executing command ['systemctl', 'is-enabled', 'bind9.service'] in directory '/root'
2020-02-05 13:37:57,514 [salt.state       :300 ][INFO    ][6086] The service bind9 is already running
2020-02-05 13:37:57,514 [salt.state       :1951][INFO    ][6086] Completed state [bind9] at time 13:37:57.514592 duration_in_ms=93.653
2020-02-05 13:37:57,517 [salt.state       :1780][INFO    ][6086] Running state [maasng.wait_for_http_code] at time 13:37:57.517596
2020-02-05 13:37:57,518 [salt.state       :1813][INFO    ][6086] Executing state module.run for [maasng.wait_for_http_code]
2020-02-05 13:37:57,519 [salt.utils.decorators:613 ][WARNING ][6086] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-02-05 13:37:57,662 [salt.state       :300 ][INFO    ][6086] {'ret': {'comment': 'MAAS API:http://localhost:5240/MAAS up.', 'result': True}}
2020-02-05 13:37:57,662 [salt.state       :1951][INFO    ][6086] Completed state [maasng.wait_for_http_code] at time 13:37:57.662545 duration_in_ms=144.949
2020-02-05 13:37:57,664 [salt.state       :1780][INFO    ][6086] Running state [maas createadmin --username opnfv --password opnfv_secret --email email@example.com && touch /var/lib/maas/.setup_admin] at time 13:37:57.664209
2020-02-05 13:37:57,664 [salt.state       :1813][INFO    ][6086] Executing state cmd.run for [maas createadmin --username opnfv --password opnfv_secret --email email@example.com && touch /var/lib/maas/.setup_admin]
2020-02-05 13:37:57,666 [salt.state       :300 ][INFO    ][6086] /var/lib/maas/.setup_admin exists
2020-02-05 13:37:57,667 [salt.state       :1951][INFO    ][6086] Completed state [maas createadmin --username opnfv --password opnfv_secret --email email@example.com && touch /var/lib/maas/.setup_admin] at time 13:37:57.667038 duration_in_ms=2.829
2020-02-05 13:37:57,668 [salt.state       :1780][INFO    ][6086] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 13:37:57.668489
2020-02-05 13:37:57,669 [salt.state       :1813][INFO    ][6086] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2020-02-05 13:37:57,670 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6086] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2020-02-05 13:37:59,839 [salt.state       :300 ][INFO    ][6086] {'pid': 6131, 'retcode': 0, 'stderr': '', 'stdout': ''}
2020-02-05 13:37:59,840 [salt.state       :1951][INFO    ][6086] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 13:37:59.840474 duration_in_ms=2171.984
2020-02-05 13:37:59,851 [salt.state       :1780][INFO    ][6086] Running state [maas_region_boot_source_resources_mirror] at time 13:37:59.851535
2020-02-05 13:37:59,852 [salt.state       :1813][INFO    ][6086] Executing state maasng.boot_source_present for [maas_region_boot_source_resources_mirror]
2020-02-05 13:37:59,925 [salt.state       :300 ][INFO    ][6086] {'changes': {}}
2020-02-05 13:37:59,925 [salt.state       :1951][INFO    ][6086] Completed state [maas_region_boot_source_resources_mirror] at time 13:37:59.925516 duration_in_ms=73.981
2020-02-05 13:37:59,927 [salt.state       :1780][INFO    ][6086] Running state [maasng.boot_resources_import] at time 13:37:59.927050
2020-02-05 13:37:59,927 [salt.state       :1813][INFO    ][6086] Executing state module.run for [maasng.boot_resources_import]
2020-02-05 13:37:59,928 [salt.utils.decorators:613 ][WARNING ][6086] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-02-05 13:37:59,980 [salt.loaded.ext.module.maasng:1600][INFO    ][6086] Waiting boot-resources import done
sleep for:5s Left:900.0/900s
2020-02-05 13:38:05,005 [salt.loaded.ext.module.maasng:1600][INFO    ][6086] Waiting boot-resources import done
sleep for:5s Left:895.0/900s
2020-02-05 13:38:06,136 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205133806122191
2020-02-05 13:38:06,162 [salt.minion      :1432][INFO    ][6160] Starting a new job with PID 6160
2020-02-05 13:38:06,191 [salt.minion      :1711][INFO    ][6160] Returning information for job: 20200205133806122191
2020-02-05 13:38:10,085 [salt.state       :300 ][INFO    ][6086] {'ret': True}
2020-02-05 13:38:10,085 [salt.state       :1951][INFO    ][6086] Completed state [maasng.boot_resources_import] at time 13:38:10.085858 duration_in_ms=10158.807
2020-02-05 13:38:10,086 [salt.state       :1780][INFO    ][6086] Running state [maas_region_boot_sources_selection_bionic] at time 13:38:10.086625
2020-02-05 13:38:10,086 [salt.state       :1813][INFO    ][6086] Executing state maasng.boot_sources_selections_present for [maas_region_boot_sources_selection_bionic]
2020-02-05 13:38:10,224 [salt.state       :300 ][INFO    ][6086] Requested boot-source selection for http://images.maas.io/ephemeral-v3/daily already exist.
2020-02-05 13:38:10,225 [salt.state       :1951][INFO    ][6086] Completed state [maas_region_boot_sources_selection_bionic] at time 13:38:10.225150 duration_in_ms=138.524
2020-02-05 13:38:10,226 [salt.state       :1780][INFO    ][6086] Running state [maasng.sync_and_wait_bs_to_all_racks] at time 13:38:10.226674
2020-02-05 13:38:10,227 [salt.state       :1813][INFO    ][6086] Executing state module.run for [maasng.sync_and_wait_bs_to_all_racks]
2020-02-05 13:38:10,227 [salt.utils.decorators:613 ][WARNING ][6086] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-02-05 13:38:10,228 [salt.loaded.ext.module.maasng:1771][INFO    ][6086] boot-sources sync initiated for ALL Rack's
2020-02-05 13:38:10,958 [salt.state       :300 ][INFO    ][6086] {'ret': True}
2020-02-05 13:38:10,959 [salt.state       :1951][INFO    ][6086] Completed state [maasng.sync_and_wait_bs_to_all_racks] at time 13:38:10.958948 duration_in_ms=732.272
2020-02-05 13:38:10,962 [salt.state       :1780][INFO    ][6086] Running state [maas.process_maas_config] at time 13:38:10.962809
2020-02-05 13:38:10,963 [salt.state       :1813][INFO    ][6086] Executing state module.run for [maas.process_maas_config]
2020-02-05 13:38:10,964 [salt.utils.decorators:613 ][WARNING ][6086] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-02-05 13:38:10,965 [salt.loaded.ext.module.maas:92  ][INFO    ][6086] maasconfig name=enable_http_proxy value=True
2020-02-05 13:38:10,999 [salt.loaded.ext.module.maas:92  ][INFO    ][6086] maasconfig name=upstream_dns value=8.8.8.8
2020-02-05 13:38:11,061 [salt.loaded.ext.module.maas:92  ][INFO    ][6086] maasconfig name=commissioning_distro_series value=bionic
2020-02-05 13:38:11,102 [salt.loaded.ext.module.maas:92  ][INFO    ][6086] maasconfig name=default_osystem value=ubuntu
2020-02-05 13:38:11,138 [salt.loaded.ext.module.maas:92  ][INFO    ][6086] maasconfig name=active_discovery_interval value=600
2020-02-05 13:38:12,562 [salt.loaded.ext.module.maas:92  ][INFO    ][6086] maasconfig name=dnssec_validation value=no
2020-02-05 13:38:12,812 [salt.loaded.ext.module.maas:92  ][INFO    ][6086] maasconfig name=kernel_opts value=spectre_v2=off nopti kpti=off nospec_store_bypass_disable noibrs noibpb
2020-02-05 13:38:13,058 [salt.loaded.ext.module.maas:92  ][INFO    ][6086] maasconfig name=network_discovery value=enabled
2020-02-05 13:38:13,130 [salt.loaded.ext.module.maas:92  ][INFO    ][6086] maasconfig name=enable_third_party_drivers value=True
2020-02-05 13:38:13,162 [salt.loaded.ext.module.maas:92  ][INFO    ][6086] maasconfig name=default_storage_layout value=lvm
2020-02-05 13:38:13,190 [salt.loaded.ext.module.maas:92  ][INFO    ][6086] maasconfig name=maas_name value=mas01
2020-02-05 13:38:13,220 [salt.loaded.ext.module.maas:92  ][INFO    ][6086] maasconfig name=disk_erase_with_secure_erase value=False
2020-02-05 13:38:13,259 [salt.loaded.ext.module.maas:92  ][INFO    ][6086] maasconfig name=default_distro_series value=bionic
2020-02-05 13:38:13,299 [salt.loaded.ext.module.maas:92  ][INFO    ][6086] maasconfig name=ntp_external_only value=True
2020-02-05 13:38:13,559 [salt.loaded.ext.module.maas:92  ][INFO    ][6086] maasconfig name=default_min_hwe_kernel value=ga-18.04
2020-02-05 13:38:13,604 [salt.state       :300 ][INFO    ][6086] {'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-05 13:38:13,604 [salt.state       :1951][INFO    ][6086] Completed state [maas.process_maas_config] at time 13:38:13.604834 duration_in_ms=2642.024
2020-02-05 13:38:13,605 [salt.state       :1780][INFO    ][6086] Running state [pxe_admin] at time 13:38:13.605837
2020-02-05 13:38:13,606 [salt.state       :1813][INFO    ][6086] Executing state maasng.fabric_present for [pxe_admin]
2020-02-05 13:38:13,643 [salt.loaded.ext.module.maasng:945 ][INFO    ][6086] [{u'resource_uri': u'/MAAS/api/2.0/fabrics/0/', u'vlans': [{u'name': u'untagged', 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'fabric': u'fabric-0'}], 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'name': u'untagged', 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'fabric': u'fabric-2'}], 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'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'b334ym', 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'fabric': u'pxe_admin'}], u'class_type': None, u'name': u'pxe_admin', u'id': 1}]
2020-02-05 13:38:13,725 [salt.loaded.ext.module.maasng:1008][WARNING ][6086] Detected cidr:192.168.11.0/24 in fabric:pxe_admin
2020-02-05 13:38:13,726 [salt.loaded.ext.module.maasng:1011][WARNING ][6086] Guessing, that fabric with current name:pxe_admin
 should be renamed to:pxe_admin
2020-02-05 13:38:13,757 [salt.state       :300 ][INFO    ][6086] {'new': 'Fabric  pxe_admin created', 'result': True}
2020-02-05 13:38:13,758 [salt.state       :1951][INFO    ][6086] Completed state [pxe_admin] at time 13:38:13.758312 duration_in_ms=152.474
2020-02-05 13:38:13,758 [salt.state       :1780][INFO    ][6086] Running state [vlan 0] at time 13:38:13.758866
2020-02-05 13:38:13,759 [salt.state       :1813][INFO    ][6086] Executing state maasng.vlan_present_in_fabric for [vlan 0]
2020-02-05 13:38:13,802 [salt.loaded.ext.module.maasng:945 ][INFO    ][6086] [{u'resource_uri': u'/MAAS/api/2.0/fabrics/0/', u'vlans': [{u'name': u'untagged', 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'fabric': u'fabric-0'}], 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'name': u'untagged', 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'fabric': u'fabric-2'}], 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'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'b334ym', 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'fabric': u'pxe_admin'}], u'class_type': None, u'name': u'pxe_admin', u'id': 1}]
2020-02-05 13:38:13,879 [salt.loaded.ext.module.maasng:945 ][INFO    ][6086] [{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'b334ym', 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-05 13:38:14,098 [salt.loaded.ext.module.maasng:945 ][INFO    ][6086] [{u'resource_uri': u'/MAAS/api/2.0/fabrics/0/', u'vlans': [{u'name': u'untagged', 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'fabric': u'fabric-0'}], 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'name': u'untagged', 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'fabric': u'fabric-2'}], 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'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'b334ym', 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'fabric': u'pxe_admin'}], u'class_type': None, u'name': u'pxe_admin', u'id': 1}]
2020-02-05 13:38:14,166 [salt.state       :300 ][INFO    ][6086] {'new': 'Vlan untagged was updated'}
2020-02-05 13:38:14,166 [salt.state       :1951][INFO    ][6086] Completed state [vlan 0] at time 13:38:14.166653 duration_in_ms=407.786
2020-02-05 13:38:14,168 [salt.state       :1780][INFO    ][6086] Running state [192.168.11.0/24] at time 13:38:14.168147
2020-02-05 13:38:14,168 [salt.state       :1813][INFO    ][6086] Executing state maasng.subnet_present for [192.168.11.0/24]
2020-02-05 13:38:14,319 [salt.loaded.ext.module.maasng:945 ][INFO    ][6086] [{u'resource_uri': u'/MAAS/api/2.0/fabrics/0/', u'vlans': [{u'name': u'untagged', 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'fabric': u'fabric-0'}], 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'name': u'untagged', 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'fabric': u'fabric-2'}], 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'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': False, u'mtu': 1500, u'primary_rack': u'b334ym', 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'fabric': u'pxe_admin'}], u'class_type': None, u'name': u'pxe_admin', u'id': 1}]
2020-02-05 13:38:14,320 [salt.loaded.ext.module.maasng:1235][WARNING ][6086] Ignoring parameter vlan:0
2020-02-05 13:38:14,368 [salt.state       :300 ][INFO    ][6086] Subnet 192.168.11.0/24 has been updated for pxe_admin
2020-02-05 13:38:14,368 [salt.state       :1951][INFO    ][6086] Completed state [192.168.11.0/24] at time 13:38:14.368692 duration_in_ms=200.545
2020-02-05 13:38:14,371 [salt.state       :1780][INFO    ][6086] Running state [maas_create_iprange_1] at time 13:38:14.371074
2020-02-05 13:38:14,371 [salt.state       :1813][INFO    ][6086] Executing state maasng.iprange_present for [maas_create_iprange_1]
2020-02-05 13:38:14,419 [salt.state       :300 ][INFO    ][6086] Iprange maas_create_iprange_1 already exist.
2020-02-05 13:38:14,419 [salt.state       :1951][INFO    ][6086] Completed state [maas_create_iprange_1] at time 13:38:14.419269 duration_in_ms=48.195
2020-02-05 13:38:14,419 [salt.state       :1780][INFO    ][6086] Running state [vlan 0] at time 13:38:14.419578
2020-02-05 13:38:14,419 [salt.state       :1813][INFO    ][6086] Executing state maasng.vlan_present_in_fabric for [vlan 0]
2020-02-05 13:38:14,455 [salt.loaded.ext.module.maasng:945 ][INFO    ][6086] [{u'resource_uri': u'/MAAS/api/2.0/fabrics/0/', u'vlans': [{u'name': u'untagged', 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'fabric': u'fabric-0'}], 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'name': u'untagged', 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'fabric': u'fabric-2'}], 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'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': False, u'mtu': 1500, u'primary_rack': u'b334ym', 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'fabric': u'pxe_admin'}], u'class_type': None, u'name': u'pxe_admin', u'id': 1}]
2020-02-05 13:38:14,524 [salt.loaded.ext.module.maasng:945 ][INFO    ][6086] [{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'b334ym', 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-05 13:38:14,703 [salt.loaded.ext.module.maasng:945 ][INFO    ][6086] [{u'resource_uri': u'/MAAS/api/2.0/fabrics/0/', u'vlans': [{u'name': u'untagged', 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'fabric': u'fabric-0'}], 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'name': u'untagged', 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'fabric': u'fabric-2'}], 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'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': False, u'mtu': 1500, u'primary_rack': u'b334ym', 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'fabric': u'pxe_admin'}], u'class_type': None, u'name': u'pxe_admin', u'id': 1}]
2020-02-05 13:38:14,772 [salt.state       :300 ][INFO    ][6086] {'new': 'Vlan untagged was updated'}
2020-02-05 13:38:14,772 [salt.state       :1951][INFO    ][6086] Completed state [vlan 0] at time 13:38:14.772479 duration_in_ms=352.899
2020-02-05 13:38:14,774 [salt.state       :1780][INFO    ][6086] Running state [opnfv] at time 13:38:14.774340
2020-02-05 13:38:14,774 [salt.state       :1813][INFO    ][6086] Executing state maasng.sshkey_present for [opnfv]
2020-02-05 13:38:14,810 [salt.loaded.ext.module.maasng:1903][INFO    ][6086] [{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-05 13:38:14,810 [salt.state       :300 ][INFO    ][6086] SSH key ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC74OvZ7y776Wj5A8gYoVsdCbbUonA1WMCs5kfze0DkD4BUfOiRckbCWpDsZ84y0q/A3tHj3u8/a9JnDyohIIAiswijSxajjvrLfPHa87S25OtoMcjousRMdy5O/WDRfSsgNJrbNYYytMurQMLHMKJHwSY8Z950wKP852g6WoQxv3Lhd7WrZgbPOLo2Y2J/ZywpakYaLeAJOaHe66ZX8b55yS1IL9oYVbrpD/ixBh+PaZrOjoGobYU82xY8RKfpfmTWLm/CO0BgrLk1vIKEVwfIxu+wleagZCUL/XHbO6owtVjXE3l9ZFGE3ZF/WyS4/CuXNomG+pHCQ91fcP3EGx6b already exist for user opnfv.
2020-02-05 13:38:14,811 [salt.state       :1951][INFO    ][6086] Completed state [opnfv] at time 13:38:14.811075 duration_in_ms=36.735
2020-02-05 13:38:14,817 [salt.minion      :1711][INFO    ][6086] Returning information for job: 20200205133750994979
2020-02-05 13:38:15,830 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command state.apply with jid 20200205133815808478
2020-02-05 13:38:15,856 [salt.minion      :1432][INFO    ][6210] Starting a new job with PID 6210
2020-02-05 13:38:24,121 [salt.state       :915 ][INFO    ][6210] Loading fresh modules for state activity
2020-02-05 13:38:24,252 [salt.state       :1780][INFO    ][6210] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 13:38:24.252872
2020-02-05 13:38:24,253 [salt.state       :1813][INFO    ][6210] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2020-02-05 13:38:24,258 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6210] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2020-02-05 13:38:26,446 [salt.state       :300 ][INFO    ][6210] {'pid': 6223, 'retcode': 0, 'stderr': '', 'stdout': ''}
2020-02-05 13:38:26,447 [salt.state       :1951][INFO    ][6210] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 13:38:26.447417 duration_in_ms=2194.545
2020-02-05 13:38:26,451 [salt.state       :1780][INFO    ][6210] Running state [maas.process_machines] at time 13:38:26.451108
2020-02-05 13:38:26,451 [salt.state       :1813][INFO    ][6210] Executing state module.run for [maas.process_machines]
2020-02-05 13:38:26,452 [salt.utils.decorators:613 ][WARNING ][6210] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-02-05 13:38:27,063 [salt.loaded.ext.module.maas:412 ][WARNING ][6210] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2020-02-05 13:38:27,064 [salt.loaded.ext.module.maas:92  ][INFO    ][6210] 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=dr3ax3 architecture=amd64/generic power_parameters_power_user=opnfv
2020-02-05 13:38:27,766 [salt.loaded.ext.module.maas:412 ][WARNING ][6210] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2020-02-05 13:38:27,767 [salt.loaded.ext.module.maas:92  ][INFO    ][6210] 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=87mhmd architecture=amd64/generic power_parameters_power_user=opnfv
2020-02-05 13:38:28,487 [salt.loaded.ext.module.maas:412 ][WARNING ][6210] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2020-02-05 13:38:28,488 [salt.loaded.ext.module.maas:92  ][INFO    ][6210] 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=dgysrr architecture=amd64/generic power_parameters_power_user=opnfv
2020-02-05 13:38:29,201 [salt.loaded.ext.module.maas:412 ][WARNING ][6210] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2020-02-05 13:38:29,202 [salt.loaded.ext.module.maas:92  ][INFO    ][6210] 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=b3b8gx architecture=amd64/generic power_parameters_power_user=opnfv
2020-02-05 13:38:29,896 [salt.loaded.ext.module.maas:412 ][WARNING ][6210] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2020-02-05 13:38:29,898 [salt.loaded.ext.module.maas:92  ][INFO    ][6210] 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=8qetyg architecture=amd64/generic power_parameters_power_user=opnfv
2020-02-05 13:38:30,601 [salt.state       :300 ][INFO    ][6210] {'ret': {'updated': ['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02'], 'errors': {}, 'success': []}}
2020-02-05 13:38:30,602 [salt.state       :1951][INFO    ][6210] Completed state [maas.process_machines] at time 13:38:30.602216 duration_in_ms=4151.107
2020-02-05 13:38:30,607 [salt.minion      :1711][INFO    ][6210] Returning information for job: 20200205133815808478
2020-02-05 13:39:05,099 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command state.apply with jid 20200205133905083881
2020-02-05 13:39:05,126 [salt.minion      :1432][INFO    ][6254] Starting a new job with PID 6254
2020-02-05 13:39:13,559 [salt.state       :915 ][INFO    ][6254] Loading fresh modules for state activity
2020-02-05 13:39:13,669 [salt.state       :1780][INFO    ][6254] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 13:39:13.669024
2020-02-05 13:39:13,669 [salt.state       :1813][INFO    ][6254] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2020-02-05 13:39:13,671 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6254] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2020-02-05 13:39:15,718 [salt.state       :300 ][INFO    ][6254] {'pid': 6269, 'retcode': 0, 'stderr': '', 'stdout': ''}
2020-02-05 13:39:15,719 [salt.state       :1951][INFO    ][6254] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 13:39:15.719265 duration_in_ms=2050.242
2020-02-05 13:39:15,722 [salt.state       :1780][INFO    ][6254] Running state [maas.wait_for_machine_status] at time 13:39:15.721200
2020-02-05 13:39:15,722 [salt.state       :1813][INFO    ][6254] Executing state module.run for [maas.wait_for_machine_status]
2020-02-05 13:39:15,723 [salt.utils.decorators:613 ][WARNING ][6254] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-02-05 13:39:18,877 [salt.state       :300 ][INFO    ][6254] {'ret': True}
2020-02-05 13:39:18,878 [salt.state       :1951][INFO    ][6254] Completed state [maas.wait_for_machine_status] at time 13:39:18.878229 duration_in_ms=3157.027
2020-02-05 13:39:18,883 [salt.minion      :1711][INFO    ][6254] Returning information for job: 20200205133905083881
2020-02-05 13:39:19,865 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command state.apply with jid 20200205133919806420
2020-02-05 13:39:19,891 [salt.minion      :1432][INFO    ][6283] Starting a new job with PID 6283
2020-02-05 13:39:21,072 [salt.state       :915 ][INFO    ][6283] Loading fresh modules for state activity
2020-02-05 13:39:21,236 [salt.state       :1780][INFO    ][6283] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 13:39:21.236124
2020-02-05 13:39:21,236 [salt.state       :1813][INFO    ][6283] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2020-02-05 13:39:21,238 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6283] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2020-02-05 13:39:23,485 [salt.state       :300 ][INFO    ][6283] {'pid': 6290, 'retcode': 0, 'stderr': '', 'stdout': ''}
2020-02-05 13:39:23,486 [salt.state       :1951][INFO    ][6283] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 13:39:23.486282 duration_in_ms=2250.155
2020-02-05 13:39:23,490 [salt.state       :1780][INFO    ][6283] Running state [maas_machines_storage_cmp002_lvm] at time 13:39:23.489927
2020-02-05 13:39:23,490 [salt.state       :1813][INFO    ][6283] Executing state maasng.disk_layout_present for [maas_machines_storage_cmp002_lvm]
2020-02-05 13:39:24,852 [salt.loaded.ext.module.maasng:610 ][INFO    ][6283] dr3ax3
2020-02-05 13:39:24,853 [salt.loaded.ext.module.maasng:626 ][INFO    ][6283] sda
2020-02-05 13:39:25,496 [salt.loaded.ext.module.maasng:361 ][INFO    ][6283] dr3ax3
2020-02-05 13:39:25,570 [salt.loaded.ext.module.maasng:367 ][INFO    ][6283] [{u'resource_uri': u'/MAAS/api/2.0/nodes/dr3ax3/blockdevices/1/', u'name': u'sda', u'tags': [u'ssd'], u'used_size': 800106479616, u'partitions': [{u'uuid': u'ab2804ed-9153-4c54-bbda-1a135ff89631', u'resource_uri': u'/MAAS/api/2.0/nodes/dr3ax3/blockdevices/1/partition/8', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'dr3ax3', u'filesystem': {u'mount_options': None, u'label': None, u'mount_point': None, u'uuid': u'e3490183-7ff4-418b-b26c-0c55f9fbe538', 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'filesystem': None, u'uuid': None, u'id': 1, u'used_for': u'MBR partitioned with 1 partition', u'system_id': u'dr3ax3', u'partition_table_type': u'MBR', u'available_size': 0, 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'type': u'physical', u'serial': u'600508b1001cb19198eb9a66f8a29401', u'size': 800109715456}, {u'resource_uri': u'/MAAS/api/2.0/nodes/dr3ax3/blockdevices/13/', u'name': u'vgroot-lvroot', u'tags': [], u'used_size': 800097042432, u'partitions': [], u'filesystem': {u'mount_options': None, u'label': u'root', u'mount_point': u'/', u'uuid': u'a3367de0-3217-41fa-afec-c5b124102abe', u'fstype': u'ext4'}, u'uuid': u'10f7c902-b254-4e3b-89d7-404b003263ac', u'id': 13, u'used_for': u'ext4 formatted filesystem mounted at /', u'system_id': u'dr3ax3', u'partition_table_type': None, u'available_size': 0, u'id_path': None, u'path': u'/dev/disk/by-dname/lvroot', u'model': None, u'block_size': 4096, u'type': u'virtual', u'serial': None, u'size': 800097042432}]
2020-02-05 13:39:25,571 [salt.loaded.ext.module.maasng:632 ][INFO    ][6283] vgroot
2020-02-05 13:39:25,571 [salt.loaded.ext.module.maasng:635 ][INFO    ][6283] lvroot
2020-02-05 13:39:25,572 [salt.loaded.ext.module.maasng:639 ][INFO    ][6283] 107374182400
2020-02-05 13:39:26,174 [salt.loaded.ext.module.maasng:645 ][INFO    ][6283] {u'node_type_name': u'Machine', u'hwe_kernel': None, u'swap_size': None, 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'memory_test_status_name': u'Unknown', u'status_action': u'', u'tag_names': [], u'testing_status_name': u'Passed', 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'size': 800109715456, u'model': u'LOGICAL VOLUME', u'resource_uri': u'/MAAS/api/2.0/nodes/dr3ax3/blockdevices/1/', u'available_size': 0, u'name': u'sda', u'tags': [u'ssd'], u'type': u'physical', u'id': 1, u'uuid': None, u'used_for': u'MBR partitioned with 1 partition', u'system_id': u'dr3ax3', 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'block_size': 4096, u'used_size': 800106479616, u'serial': u'600508b1001cb19198eb9a66f8a29401', u'partitions': [{u'uuid': u'9945e6b7-9657-441b-8aa3-ec37ad8a2c76', u'resource_uri': u'/MAAS/api/2.0/nodes/dr3ax3/blockdevices/1/partition/10', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'dr3ax3', u'filesystem': {u'mount_options': None, u'label': None, u'mount_point': None, u'uuid': u'01a968b9-fc68-4e7c-a4b4-bfede67da61a', 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'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/dr3ax3/', 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'dr3ax3', 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'virtualblockdevice_set': [{u'size': 107374182400, u'resource_uri': u'/MAAS/api/2.0/nodes/dr3ax3/blockdevices/15/', u'available_size': 0, u'name': u'vgroot-lvroot', u'tags': [], u'type': u'virtual', u'id': 15, u'uuid': u'5eace164-31d1-41d0-9178-0b8e7a029a08', u'used_for': u'ext4 formatted filesystem mounted at /', u'system_id': u'dr3ax3', u'partition_table_type': None, u'filesystem': {u'mount_options': None, u'label': u'root', u'mount_point': u'/', u'uuid': u'03107826-0a1f-4809-88c0-a1dc4eda0221', 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'partitions': []}], u'blockdevice_set': [{u'resource_uri': u'/MAAS/api/2.0/nodes/dr3ax3/blockdevices/1/', u'available_size': 0, u'name': u'sda', u'tags': [u'ssd'], u'type': u'physical', u'partitions': [{u'uuid': u'9945e6b7-9657-441b-8aa3-ec37ad8a2c76', u'resource_uri': u'/MAAS/api/2.0/nodes/dr3ax3/blockdevices/1/partition/10', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'dr3ax3', u'filesystem': {u'mount_options': None, u'label': None, u'mount_point': None, u'uuid': u'01a968b9-fc68-4e7c-a4b4-bfede67da61a', 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'uuid': None, u'id': 1, u'used_for': u'MBR partitioned with 1 partition', u'system_id': u'dr3ax3', 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/dr3ax3/blockdevices/15/', u'available_size': 0, u'name': u'vgroot-lvroot', u'tags': [], u'type': u'virtual', u'partitions': [], u'uuid': u'5eace164-31d1-41d0-9178-0b8e7a029a08', u'id': 15, u'used_for': u'ext4 formatted filesystem mounted at /', u'system_id': u'dr3ax3', u'partition_table_type': None, u'filesystem': {u'mount_options': None, u'label': u'root', u'mount_point': u'/', u'uuid': u'03107826-0a1f-4809-88c0-a1dc4eda0221', 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'status': 4, u'storage_test_status': 2, u'storage_test_status_name': u'Passed', u'power_state': u'off', u'physicalblockdevice_set': [{u'size': 800109715456, u'model': u'LOGICAL VOLUME', u'resource_uri': u'/MAAS/api/2.0/nodes/dr3ax3/blockdevices/1/', u'available_size': 0, u'name': u'sda', u'tags': [u'ssd'], u'type': u'physical', u'id': 1, u'uuid': None, u'used_for': u'MBR partitioned with 1 partition', u'system_id': u'dr3ax3', 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'block_size': 4096, u'used_size': 800106479616, u'serial': u'600508b1001cb19198eb9a66f8a29401', u'partitions': [{u'uuid': u'9945e6b7-9657-441b-8aa3-ec37ad8a2c76', u'resource_uri': u'/MAAS/api/2.0/nodes/dr3ax3/blockdevices/1/partition/10', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'dr3ax3', u'filesystem': {u'mount_options': None, u'label': None, u'mount_point': None, u'uuid': u'01a968b9-fc68-4e7c-a4b4-bfede67da61a', 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'ip_addresses': [], u'other_test_status_name': u'Unknown', u'owner_data': {}, u'volume_groups': [{u'__incomplete__': True, u'system_id': u'dr3ax3', u'id': 10}], u'special_filesystems': [], u'current_commissioning_result_id': 19, u'commissioning_status_name': u'Passed', 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'bcaches': [], u'locked': False, u'status_name': u'Ready', u'netboot': True, u'osystem': u'', u'fqdn': u'cmp002.maas', u'node_type': 0, u'commissioning_status': 2, u'min_hwe_kernel': u'ga-18.04', u'boot_interface': {u'product': u'ProLiant BL460c Gen8 (735151-B21)', 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'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'b334ym', 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'fabric': u'pxe_admin'}, 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': 2, u'resource_uri': u'/MAAS/api/2.0/subnets/2/'}, u'id': 62, u'mode': u'dhcp'}], u'tags': [u'sriov'], u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'b334ym', 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'fabric': u'pxe_admin'}, u'enabled': True, u'id': 4, u'discovered': [], u'mac_address': u'9c:b6:54:8a:10:18', u'parents': [], u'params': u'', u'effective_mtu': 1500, u'system_id': u'dr3ax3', u'firmware_version': u'bc 7.8.24', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/dr3ax3/interfaces/4/'}, u'interface_set': [{u'product': u'ProLiant BL460c Gen8 (735151-B21)', 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'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'b334ym', 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'fabric': u'pxe_admin'}, 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': 2, u'resource_uri': u'/MAAS/api/2.0/subnets/2/'}, u'id': 62, u'mode': u'dhcp'}], u'tags': [u'sriov'], u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'b334ym', 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'fabric': u'pxe_admin'}, u'enabled': True, u'id': 4, u'discovered': [], u'mac_address': u'9c:b6:54:8a:10:18', u'parents': [], u'params': u'', u'effective_mtu': 1500, u'system_id': u'dr3ax3', u'firmware_version': u'bc 7.8.24', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/dr3ax3/interfaces/4/'}, {u'product': u'ProLiant BL460c Gen8 (735151-B21)', u'vendor': u'HP', u'name': u'ens1f0', u'links': [], u'tags': [u'sriov'], u'vlan': None, u'enabled': True, u'id': 11, u'discovered': None, u'mac_address': u'38:ea:a7:8f:07:50', u'parents': [], u'params': u'', u'effective_mtu': 1500, u'system_id': u'dr3ax3', u'firmware_version': u'bc 7.8.24', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/dr3ax3/interfaces/11/'}, {u'product': u'ProLiant BL460c Gen8 (735151-B21)', 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'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'b334ym', 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'fabric': u'pxe_admin'}, 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': 2, u'resource_uri': u'/MAAS/api/2.0/subnets/2/'}, u'id': 63, u'mode': u'link_up'}], u'tags': [u'sriov'], u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'b334ym', 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'fabric': u'pxe_admin'}, u'enabled': True, u'id': 12, u'discovered': [], u'mac_address': u'9c:b6:54:8a:10:1c', u'parents': [], u'params': u'', u'effective_mtu': 1500, u'system_id': u'dr3ax3', u'firmware_version': u'bc 7.8.24', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/dr3ax3/interfaces/12/'}, {u'product': u'ProLiant BL460c Gen8 (735151-B21)', u'vendor': u'HP', u'name': u'ens1f1', u'links': [], u'tags': [u'sriov'], u'vlan': None, u'enabled': True, u'id': 13, u'discovered': None, u'mac_address': u'38:ea:a7:8f:07:51', u'parents': [], u'params': u'', u'effective_mtu': 1500, u'system_id': u'dr3ax3', u'firmware_version': u'bc 7.8.24', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/dr3ax3/interfaces/13/'}, {u'product': u'ProLiant BL460c Gen8 (735151-B21)', u'vendor': u'HP', u'name': u'ens2f0', u'links': [{u'id': 64, u'mode': u'link_up'}], u'tags': [u'sriov'], u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 0, u'dhcp_on': False, u'mtu': 1500, u'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'fabric': u'fabric-0'}, u'enabled': True, u'id': 14, u'discovered': None, u'mac_address': u'38:ea:a7:8f:12:48', u'parents': [], u'params': u'', u'effective_mtu': 1500, u'system_id': u'dr3ax3', u'firmware_version': u'bc 7.8.24', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/dr3ax3/interfaces/14/'}, {u'product': u'ProLiant BL460c Gen8 (735151-B21)', u'vendor': u'HP', u'name': u'ens2f1', u'links': [{u'id': 65, u'mode': u'link_up'}], u'tags': [u'sriov'], u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 0, u'dhcp_on': False, u'mtu': 1500, u'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'fabric': u'fabric-0'}, u'enabled': True, u'id': 15, u'discovered': None, u'mac_address': u'38:ea:a7:8f:12:49', u'parents': [], u'params': u'', u'effective_mtu': 1500, u'system_id': u'dr3ax3', u'firmware_version': u'bc 7.8.24', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/dr3ax3/interfaces/15/'}], u'address_ttl': None, u'other_test_status': -1, u'distro_series': u'', u'memory_test_status': -1}
2020-02-05 13:39:26,176 [salt.state       :300 ][INFO    ][6283] {'new': {'storage_layout': 'lvm'}}
2020-02-05 13:39:26,178 [salt.state       :1951][INFO    ][6283] Completed state [maas_machines_storage_cmp002_lvm] at time 13:39:26.177200 duration_in_ms=2687.546
2020-02-05 13:39:26,178 [salt.state       :1780][INFO    ][6283] Running state [maas_machines_storage_cmp001_lvm] at time 13:39:26.178567
2020-02-05 13:39:26,178 [salt.state       :1813][INFO    ][6283] Executing state maasng.disk_layout_present for [maas_machines_storage_cmp001_lvm]
2020-02-05 13:39:27,363 [salt.loaded.ext.module.maasng:610 ][INFO    ][6283] 87mhmd
2020-02-05 13:39:27,363 [salt.loaded.ext.module.maasng:626 ][INFO    ][6283] sda
2020-02-05 13:39:27,968 [salt.loaded.ext.module.maasng:361 ][INFO    ][6283] 87mhmd
2020-02-05 13:39:28,049 [salt.loaded.ext.module.maasng:367 ][INFO    ][6283] [{u'resource_uri': u'/MAAS/api/2.0/nodes/87mhmd/blockdevices/2/', u'available_size': 0, u'name': u'sda', u'tags': [u'ssd'], u'type': u'physical', u'partitions': [{u'uuid': u'029e7b24-ec37-46f0-8e1b-f2dd84a3b170', u'resource_uri': u'/MAAS/api/2.0/nodes/87mhmd/blockdevices/2/partition/9', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'87mhmd', u'filesystem': {u'mount_options': None, u'label': None, u'mount_point': None, u'uuid': u'b39ff6e2-143c-457e-8350-086e5f782860', u'fstype': u'lvm-pv'}, u'path': u'/dev/disk/by-dname/sda-part1', u'device_id': 2, u'type': u'partition', u'id': 9, u'size': 800101236736}], u'uuid': None, u'used_for': u'MBR partitioned with 1 partition', u'system_id': u'87mhmd', 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'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/87mhmd/blockdevices/14/', u'available_size': 0, u'name': u'vgroot-lvroot', u'tags': [], u'type': u'virtual', u'partitions': [], u'uuid': u'cf113d2f-c042-4324-93b5-d0a7e528c637', u'used_for': u'ext4 formatted filesystem mounted at /', u'system_id': u'87mhmd', u'partition_table_type': None, u'filesystem': {u'mount_options': None, u'label': u'root', u'mount_point': u'/', u'uuid': u'fc72bbfd-5241-4cb4-94d6-56b3b681b3f0', 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': 800097042432, u'id': 14, u'serial': None, u'size': 800097042432}]
2020-02-05 13:39:28,050 [salt.loaded.ext.module.maasng:632 ][INFO    ][6283] vgroot
2020-02-05 13:39:28,051 [salt.loaded.ext.module.maasng:635 ][INFO    ][6283] lvroot
2020-02-05 13:39:28,051 [salt.loaded.ext.module.maasng:639 ][INFO    ][6283] 107374182400
2020-02-05 13:39:28,654 [salt.loaded.ext.module.maasng:645 ][INFO    ][6283] {u'hwe_kernel': None, u'testing_status_name': u'Passed', u'disable_ipv4': False, u'storage_test_status_name': u'Passed', 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'memory_test_status_name': u'Unknown', 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'iscsiblockdevice_set': [], u'boot_disk': {u'model': u'LOGICAL VOLUME', u'resource_uri': u'/MAAS/api/2.0/nodes/87mhmd/blockdevices/2/', u'available_size': 0, u'name': u'sda', u'tags': [u'ssd'], u'type': u'physical', u'partitions': [{u'uuid': u'3ebc07c9-4ce8-437b-b3f6-05c532379bc5', u'resource_uri': u'/MAAS/api/2.0/nodes/87mhmd/blockdevices/2/partition/11', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'87mhmd', u'filesystem': {u'mount_options': None, u'label': None, u'mount_point': None, u'uuid': u'7591a950-469b-4f37-b9a3-8df1b98823ca', u'fstype': u'lvm-pv'}, u'path': u'/dev/disk/by-dname/sda-part1', u'device_id': 2, u'type': u'partition', u'id': 11, u'size': 800101236736}], u'uuid': None, u'used_for': u'MBR partitioned with 1 partition', u'system_id': u'87mhmd', 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'id': 2, u'serial': u'600508b1001cd7e61f5cd3479576479e', u'size': 800109715456}, u'blockdevice_set': [{u'resource_uri': u'/MAAS/api/2.0/nodes/87mhmd/blockdevices/2/', u'available_size': 0, u'name': u'sda', u'tags': [u'ssd'], u'type': u'physical', u'partitions': [{u'uuid': u'3ebc07c9-4ce8-437b-b3f6-05c532379bc5', u'resource_uri': u'/MAAS/api/2.0/nodes/87mhmd/blockdevices/2/partition/11', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'87mhmd', u'filesystem': {u'mount_options': None, u'label': None, u'mount_point': None, u'uuid': u'7591a950-469b-4f37-b9a3-8df1b98823ca', u'fstype': u'lvm-pv'}, u'path': u'/dev/disk/by-dname/sda-part1', u'device_id': 2, u'type': u'partition', u'id': 11, u'size': 800101236736}], u'uuid': None, u'used_for': u'MBR partitioned with 1 partition', u'system_id': u'87mhmd', 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'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/87mhmd/blockdevices/16/', u'available_size': 0, u'name': u'vgroot-lvroot', u'tags': [], u'type': u'virtual', u'partitions': [], u'uuid': u'03d82f74-a314-412f-b442-9547ee76dad2', u'used_for': u'ext4 formatted filesystem mounted at /', u'system_id': u'87mhmd', u'partition_table_type': None, u'filesystem': {u'mount_options': None, u'label': u'root', u'mount_point': u'/', u'uuid': u'a62d7a2a-6b2c-43ac-970c-9fa81573a348', 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': 16, u'serial': None, u'size': 107374182400}], 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/87mhmd/', u'node_type_name': u'Machine', u'hostname': u'cmp001', u'storage': 800109.715456, u'testing_status': 2, u'system_id': u'87mhmd', 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'storage_test_status': 2, u'cpu_count': 40, 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'87mhmd', u'id': 11}], u'special_filesystems': [], u'cpu_test_status_name': u'Unknown', 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'b334ym', 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'b334ym', 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': 2, u'resource_uri': u'/MAAS/api/2.0/subnets/2/'}, u'id': 69, u'mode': u'dhcp'}], u'tags': [u'sriov'], u'mac_address': u'9c:b6:54:8a:95:a0', u'enabled': True, u'children': [], u'discovered': [], u'params': u'', u'effective_mtu': 1500, u'parents': [], u'firmware_version': u'bc 7.8.24', u'system_id': u'87mhmd', u'type': u'physical', u'id': 5, u'resource_uri': u'/MAAS/api/2.0/nodes/87mhmd/interfaces/5/'}, 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'b334ym', 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'b334ym', 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': 2, u'resource_uri': u'/MAAS/api/2.0/subnets/2/'}, u'id': 69, u'mode': u'dhcp'}], u'tags': [u'sriov'], u'mac_address': u'9c:b6:54:8a:95:a0', u'enabled': True, u'children': [], u'discovered': [], u'params': u'', u'effective_mtu': 1500, u'parents': [], u'firmware_version': u'bc 7.8.24', u'system_id': u'87mhmd', u'type': u'physical', u'id': 5, u'resource_uri': u'/MAAS/api/2.0/nodes/87mhmd/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'children': [], u'discovered': None, u'params': u'', u'effective_mtu': 1500, u'parents': [], u'firmware_version': u'bc 7.8.24', u'system_id': u'87mhmd', u'type': u'physical', u'id': 16, u'resource_uri': u'/MAAS/api/2.0/nodes/87mhmd/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'b334ym', 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'b334ym', 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': 2, u'resource_uri': u'/MAAS/api/2.0/subnets/2/'}, u'id': 70, u'mode': u'link_up'}], u'tags': [u'sriov'], u'mac_address': u'9c:b6:54:8a:95:a4', u'enabled': True, u'children': [], u'discovered': [], u'params': u'', u'effective_mtu': 1500, u'parents': [], u'firmware_version': u'bc 7.8.24', u'system_id': u'87mhmd', u'type': u'physical', u'id': 17, u'resource_uri': u'/MAAS/api/2.0/nodes/87mhmd/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'children': [], u'discovered': None, u'params': u'', u'effective_mtu': 1500, u'parents': [], u'firmware_version': u'bc 7.8.24', u'system_id': u'87mhmd', u'type': u'physical', u'id': 18, u'resource_uri': u'/MAAS/api/2.0/nodes/87mhmd/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': 71, u'mode': u'link_up'}], u'tags': [u'sriov'], u'mac_address': u'38:ea:a7:8f:52:cc', u'enabled': True, u'children': [], u'discovered': None, u'params': u'', u'effective_mtu': 1500, u'parents': [], u'firmware_version': u'bc 7.8.24', u'system_id': u'87mhmd', u'type': u'physical', u'id': 19, u'resource_uri': u'/MAAS/api/2.0/nodes/87mhmd/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': 72, u'mode': u'link_up'}], u'tags': [u'sriov'], u'mac_address': u'38:ea:a7:8f:52:cd', u'enabled': True, u'children': [], u'discovered': None, u'params': u'', u'effective_mtu': 1500, u'parents': [], u'firmware_version': u'bc 7.8.24', u'system_id': u'87mhmd', u'type': u'physical', u'id': 20, u'resource_uri': u'/MAAS/api/2.0/nodes/87mhmd/interfaces/20/'}], 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'bcaches': [], 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/87mhmd/blockdevices/2/', u'available_size': 0, u'name': u'sda', u'tags': [u'ssd'], u'type': u'physical', u'partitions': [{u'uuid': u'3ebc07c9-4ce8-437b-b3f6-05c532379bc5', u'resource_uri': u'/MAAS/api/2.0/nodes/87mhmd/blockdevices/2/partition/11', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'87mhmd', u'filesystem': {u'mount_options': None, u'label': None, u'mount_point': None, u'uuid': u'7591a950-469b-4f37-b9a3-8df1b98823ca', u'fstype': u'lvm-pv'}, u'path': u'/dev/disk/by-dname/sda-part1', u'device_id': 2, u'type': u'partition', u'id': 11, u'size': 800101236736}], u'uuid': None, u'used_for': u'MBR partitioned with 1 partition', u'system_id': u'87mhmd', 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'id': 2, u'serial': u'600508b1001cd7e61f5cd3479576479e', u'size': 800109715456}], u'netboot': True, u'osystem': u'', u'node_type': 0, u'virtualblockdevice_set': [{u'resource_uri': u'/MAAS/api/2.0/nodes/87mhmd/blockdevices/16/', u'available_size': 0, u'name': u'vgroot-lvroot', u'tags': [], u'type': u'virtual', u'partitions': [], u'uuid': u'03d82f74-a314-412f-b442-9547ee76dad2', u'used_for': u'ext4 formatted filesystem mounted at /', u'system_id': u'87mhmd', u'partition_table_type': None, u'filesystem': {u'mount_options': None, u'label': u'root', u'mount_point': u'/', u'uuid': u'a62d7a2a-6b2c-43ac-970c-9fa81573a348', u'fstype': u'ext4'}, u'id_path': None, u'path': u'/dev/disk/by-dname/vgroot-lvroot', u'model': None, u'block_size': 4096, u'used_size': 107374182400, u'id': 16, u'serial': None, u'size': 107374182400}], u'commissioning_status': 2, u'architecture': u'amd64/generic', u'commissioning_status_name': u'Passed', u'current_commissioning_result_id': 21, u'address_ttl': None, u'other_test_status': -1, 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'distro_series': u'', u'memory_test_status': -1}
2020-02-05 13:39:28,656 [salt.state       :300 ][INFO    ][6283] {'new': {'storage_layout': 'lvm'}}
2020-02-05 13:39:28,656 [salt.state       :1951][INFO    ][6283] Completed state [maas_machines_storage_cmp001_lvm] at time 13:39:28.656325 duration_in_ms=2477.756
2020-02-05 13:39:28,660 [salt.minion      :1711][INFO    ][6283] Returning information for job: 20200205133919806420
2020-02-05 13:39:29,606 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command state.apply with jid 20200205133929588823
2020-02-05 13:39:29,632 [salt.minion      :1432][INFO    ][6302] Starting a new job with PID 6302
2020-02-05 13:39:37,927 [salt.state       :915 ][INFO    ][6302] Loading fresh modules for state activity
2020-02-05 13:39:38,044 [salt.state       :1780][INFO    ][6302] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 13:39:38.044701
2020-02-05 13:39:38,045 [salt.state       :1813][INFO    ][6302] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2020-02-05 13:39:38,047 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6302] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2020-02-05 13:39:40,321 [salt.state       :300 ][INFO    ][6302] {'pid': 6315, 'retcode': 0, 'stderr': '', 'stdout': ''}
2020-02-05 13:39:40,322 [salt.state       :1951][INFO    ][6302] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 13:39:40.322584 duration_in_ms=2277.884
2020-02-05 13:39:40,326 [salt.state       :1780][INFO    ][6302] Running state [maas.deploy_machines] at time 13:39:40.326155
2020-02-05 13:39:40,326 [salt.state       :1813][INFO    ][6302] Executing state module.run for [maas.deploy_machines]
2020-02-05 13:39:40,327 [salt.utils.decorators:613 ][WARNING ][6302] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-02-05 13:39:40,960 [salt.loaded.ext.module.maas:684 ][INFO    ][6302] deploymachines hwe_kernel=ga-18.04 system_id=dr3ax3 distro_series=bionic
2020-02-05 13:39:42,829 [salt.loaded.ext.module.maas:684 ][INFO    ][6302] deploymachines hwe_kernel=ga-18.04 system_id=87mhmd distro_series=bionic
2020-02-05 13:39:44,684 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205133944671172
2020-02-05 13:39:44,716 [salt.minion      :1432][INFO    ][6335] Starting a new job with PID 6335
2020-02-05 13:39:44,752 [salt.state       :300 ][INFO    ][6302] {'ret': {'updated': ['kvm01', 'kvm03', 'kvm02'], 'errors': {}, 'success': ['cmp002', 'cmp001']}}
2020-02-05 13:39:44,756 [salt.state       :1951][INFO    ][6302] Completed state [maas.deploy_machines] at time 13:39:44.753182 duration_in_ms=4427.027
2020-02-05 13:39:44,759 [salt.minion      :1711][INFO    ][6335] Returning information for job: 20200205133944671172
2020-02-05 13:39:44,761 [salt.minion      :1711][INFO    ][6302] Returning information for job: 20200205133929588823
2020-02-05 13:39:45,679 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command state.apply with jid 20200205133945663583
2020-02-05 13:39:45,706 [salt.minion      :1432][INFO    ][6346] Starting a new job with PID 6346
2020-02-05 13:39:46,810 [salt.state       :915 ][INFO    ][6346] Loading fresh modules for state activity
2020-02-05 13:39:46,921 [salt.state       :1780][INFO    ][6346] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 13:39:46.921253
2020-02-05 13:39:46,922 [salt.state       :1813][INFO    ][6346] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2020-02-05 13:39:46,926 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6346] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2020-02-05 13:39:49,010 [salt.state       :300 ][INFO    ][6346] {'pid': 6353, 'retcode': 0, 'stderr': '', 'stdout': ''}
2020-02-05 13:39:49,011 [salt.state       :1951][INFO    ][6346] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 13:39:49.011673 duration_in_ms=2090.42
2020-02-05 13:39:49,016 [salt.state       :1780][INFO    ][6346] Running state [maas.wait_for_machine_status] at time 13:39:49.016010
2020-02-05 13:39:49,016 [salt.state       :1813][INFO    ][6346] Executing state module.run for [maas.wait_for_machine_status]
2020-02-05 13:39:49,016 [salt.utils.decorators:613 ][WARNING ][6346] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-02-05 13:39:52,089 [salt.loaded.ext.module.maas:1024][INFO    ][6346] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (2246.94122887s left)
2020-02-05 13:40:00,770 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205134000754840
2020-02-05 13:40:00,797 [salt.minion      :1432][INFO    ][6368] Starting a new job with PID 6368
2020-02-05 13:40:00,823 [salt.minion      :1711][INFO    ][6368] Returning information for job: 20200205134000754840
2020-02-05 13:40:25,159 [salt.loaded.ext.module.maas:1024][INFO    ][6346] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (2213.87084484s left)
2020-02-05 13:40:30,860 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205134030844393
2020-02-05 13:40:30,891 [salt.minion      :1432][INFO    ][6408] Starting a new job with PID 6408
2020-02-05 13:40:30,916 [salt.minion      :1711][INFO    ][6408] Returning information for job: 20200205134030844393
2020-02-05 13:40:58,381 [salt.loaded.ext.module.maas:1024][INFO    ][6346] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (2180.64925885s left)
2020-02-05 13:41:00,939 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205134100924378
2020-02-05 13:41:00,964 [salt.minion      :1432][INFO    ][6428] Starting a new job with PID 6428
2020-02-05 13:41:00,991 [salt.minion      :1711][INFO    ][6428] Returning information for job: 20200205134100924378
2020-02-05 13:41:31,011 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205134130999192
2020-02-05 13:41:31,033 [salt.minion      :1432][INFO    ][6449] Starting a new job with PID 6449
2020-02-05 13:41:31,058 [salt.minion      :1711][INFO    ][6449] Returning information for job: 20200205134130999192
2020-02-05 13:41:31,653 [salt.loaded.ext.module.maas:1024][INFO    ][6346] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (2147.37750101s left)
2020-02-05 13:42:01,094 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205134201078979
2020-02-05 13:42:01,123 [salt.minion      :1432][INFO    ][6467] Starting a new job with PID 6467
2020-02-05 13:42:01,150 [salt.minion      :1711][INFO    ][6467] Returning information for job: 20200205134201078979
2020-02-05 13:42:04,771 [salt.loaded.ext.module.maas:1024][INFO    ][6346] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (2114.25855494s left)
2020-02-05 13:42:31,139 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205134231126536
2020-02-05 13:42:31,163 [salt.minion      :1432][INFO    ][6501] Starting a new job with PID 6501
2020-02-05 13:42:31,187 [salt.minion      :1711][INFO    ][6501] Returning information for job: 20200205134231126536
2020-02-05 13:42:38,049 [salt.loaded.ext.module.maas:1024][INFO    ][6346] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (2080.98135781s left)
2020-02-05 13:43:01,195 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205134301179673
2020-02-05 13:43:01,220 [salt.minion      :1432][INFO    ][6562] Starting a new job with PID 6562
2020-02-05 13:43:01,247 [salt.minion      :1711][INFO    ][6562] Returning information for job: 20200205134301179673
2020-02-05 13:43:11,539 [salt.loaded.ext.module.maas:1024][INFO    ][6346] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (2047.49201083s left)
2020-02-05 13:43:31,288 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205134331273675
2020-02-05 13:43:31,318 [salt.minion      :1432][INFO    ][6609] Starting a new job with PID 6609
2020-02-05 13:43:31,343 [salt.minion      :1711][INFO    ][6609] Returning information for job: 20200205134331273675
2020-02-05 13:43:45,157 [salt.loaded.ext.module.maas:1024][INFO    ][6346] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (2013.873523s left)
2020-02-05 13:44:01,396 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205134401379814
2020-02-05 13:44:01,424 [salt.minion      :1432][INFO    ][6628] Starting a new job with PID 6628
2020-02-05 13:44:01,451 [salt.minion      :1711][INFO    ][6628] Returning information for job: 20200205134401379814
2020-02-05 13:44:18,571 [salt.loaded.ext.module.maas:1024][INFO    ][6346] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (1980.45876384s left)
2020-02-05 13:44:31,498 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205134431484720
2020-02-05 13:44:31,515 [salt.minion      :1432][INFO    ][6659] Starting a new job with PID 6659
2020-02-05 13:44:31,544 [salt.minion      :1711][INFO    ][6659] Returning information for job: 20200205134431484720
2020-02-05 13:44:51,896 [salt.loaded.ext.module.maas:1024][INFO    ][6346] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (1947.13423991s left)
2020-02-05 13:45:01,589 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205134501572769
2020-02-05 13:45:01,615 [salt.minion      :1432][INFO    ][6681] Starting a new job with PID 6681
2020-02-05 13:45:01,639 [salt.minion      :1711][INFO    ][6681] Returning information for job: 20200205134501572769
2020-02-05 13:45:25,550 [salt.loaded.ext.module.maas:1024][INFO    ][6346] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (1913.48000193s left)
2020-02-05 13:45:31,717 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205134531702728
2020-02-05 13:45:31,748 [salt.minion      :1432][INFO    ][6704] Starting a new job with PID 6704
2020-02-05 13:45:31,776 [salt.minion      :1711][INFO    ][6704] Returning information for job: 20200205134531702728
2020-02-05 13:45:59,133 [salt.loaded.ext.module.maas:1024][INFO    ][6346] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (1879.89735079s left)
2020-02-05 13:46:01,838 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205134601823853
2020-02-05 13:46:01,865 [salt.minion      :1432][INFO    ][6731] Starting a new job with PID 6731
2020-02-05 13:46:01,907 [salt.minion      :1711][INFO    ][6731] Returning information for job: 20200205134601823853
2020-02-05 13:46:31,967 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205134631954923
2020-02-05 13:46:31,991 [salt.minion      :1432][INFO    ][6753] Starting a new job with PID 6753
2020-02-05 13:46:32,020 [salt.minion      :1711][INFO    ][6753] Returning information for job: 20200205134631954923
2020-02-05 13:46:32,551 [salt.loaded.ext.module.maas:1024][INFO    ][6346] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (1846.47870994s left)
2020-02-05 13:47:02,112 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205134702100682
2020-02-05 13:47:02,140 [salt.minion      :1432][INFO    ][6771] Starting a new job with PID 6771
2020-02-05 13:47:02,168 [salt.minion      :1711][INFO    ][6771] Returning information for job: 20200205134702100682
2020-02-05 13:47:05,997 [salt.loaded.ext.module.maas:1024][INFO    ][6346] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (1813.0326798s left)
2020-02-05 13:47:32,244 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205134732231340
2020-02-05 13:47:32,272 [salt.minion      :1432][INFO    ][6793] Starting a new job with PID 6793
2020-02-05 13:47:32,295 [salt.minion      :1711][INFO    ][6793] Returning information for job: 20200205134732231340
2020-02-05 13:47:39,452 [salt.loaded.ext.module.maas:1024][INFO    ][6346] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (1779.57843781s left)
2020-02-05 13:48:02,386 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205134802374888
2020-02-05 13:48:02,410 [salt.minion      :1432][INFO    ][6813] Starting a new job with PID 6813
2020-02-05 13:48:02,435 [salt.minion      :1711][INFO    ][6813] Returning information for job: 20200205134802374888
2020-02-05 13:48:12,864 [salt.loaded.ext.module.maas:1024][INFO    ][6346] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (1746.16592002s left)
2020-02-05 13:48:32,515 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205134832502070
2020-02-05 13:48:32,542 [salt.minion      :1432][INFO    ][6837] Starting a new job with PID 6837
2020-02-05 13:48:32,568 [salt.minion      :1711][INFO    ][6837] Returning information for job: 20200205134832502070
2020-02-05 13:48:46,408 [salt.loaded.ext.module.maas:1024][INFO    ][6346] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (1712.62184191s left)
2020-02-05 13:49:02,675 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205134902660985
2020-02-05 13:49:02,702 [salt.minion      :1432][INFO    ][6858] Starting a new job with PID 6858
2020-02-05 13:49:02,728 [salt.minion      :1711][INFO    ][6858] Returning information for job: 20200205134902660985
2020-02-05 13:49:19,823 [salt.loaded.ext.module.maas:1024][INFO    ][6346] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (1679.20695186s left)
2020-02-05 13:49:32,830 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205134932816221
2020-02-05 13:49:32,860 [salt.minion      :1432][INFO    ][6882] Starting a new job with PID 6882
2020-02-05 13:49:32,888 [salt.minion      :1711][INFO    ][6882] Returning information for job: 20200205134932816221
2020-02-05 13:49:53,190 [salt.loaded.ext.module.maas:1024][INFO    ][6346] Waiting status:Deployed for machines:['cmp002', 'cmp001']
sleep for:30s Timeout:2250s (1645.83999991s left)
2020-02-05 13:50:03,000 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205135002985767
2020-02-05 13:50:03,026 [salt.minion      :1432][INFO    ][6922] Starting a new job with PID 6922
2020-02-05 13:50:03,053 [salt.minion      :1711][INFO    ][6922] Returning information for job: 20200205135002985767
2020-02-05 13:50:10,822 [salt.utils.schedule:1377][INFO    ][2030] Running scheduled job: __mine_interval
2020-02-05 13:50:26,544 [salt.loaded.ext.module.maas:1024][INFO    ][6346] Waiting status:Deployed for machines:['cmp001']
sleep for:30s Timeout:2250s (1612.48618197s left)
2020-02-05 13:50:33,188 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command saltutil.find_job with jid 20200205135033172780
2020-02-05 13:50:33,213 [salt.minion      :1432][INFO    ][6981] Starting a new job with PID 6981
2020-02-05 13:50:33,239 [salt.minion      :1711][INFO    ][6981] Returning information for job: 20200205135033172780
2020-02-05 13:51:00,063 [salt.state       :300 ][INFO    ][6346] {'ret': True}
2020-02-05 13:51:00,063 [salt.state       :1951][INFO    ][6346] Completed state [maas.wait_for_machine_status] at time 13:51:00.063767 duration_in_ms=671047.756
2020-02-05 13:51:00,070 [salt.minion      :1711][INFO    ][6346] Returning information for job: 20200205133945663583
2020-02-05 14:50:10,822 [salt.utils.schedule:1377][INFO    ][2030] Running scheduled job: __mine_interval
2020-02-05 15:31:58,489 [salt.minion      :1308][INFO    ][2030] User sudo_ubuntu Executing command cp.push_dir with jid 20200205153158479612
2020-02-05 15:31:58,513 [salt.minion      :1432][INFO    ][10515] Starting a new job with PID 10515
