2020-01-05 02:10:55,957 [salt.utils.decorators:613 ][WARNING ][2139] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-01-05 02:10:56,845 [salt.utils.decorators:613 ][WARNING ][2139] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-01-05 02:10:59,820 [salt.loaded.int.states.file:2298][WARNING ][2389] 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-01-05 02:11:15,481 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2792] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2020-01-05 02:11:15,514 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2792] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2020-01-05 02:11:15,564 [salt.utils.parsers:1051][WARNING ][336] Minion received a SIGTERM. Exiting.
2020-01-05 02:11:16,578 [salt.cli.daemons :293 ][INFO    ][2920] Setting up the Salt Minion "mas01.mcp-odl-ha.local"
2020-01-05 02:11:16,711 [salt.cli.daemons :82  ][INFO    ][2920] Starting up the Salt Minion
2020-01-05 02:11:16,712 [salt.utils.event :1017][INFO    ][2920] Starting pull socket on /var/run/salt/minion/minion_event_3e82045771_pull.ipc
2020-01-05 02:11:17,882 [salt.minion      :976 ][INFO    ][2920] Creating minion process manager
2020-01-05 02:11:19,898 [salt.loader.10.20.0.2.int.module.cmdmod:395 ][INFO    ][2920] Executing command ['date', '+%z'] in directory '/root'
2020-01-05 02:11:19,923 [salt.utils.schedule:568 ][INFO    ][2920] Updating job settings for scheduled job: __mine_interval
2020-01-05 02:11:19,927 [salt.minion      :1108][INFO    ][2920] Added mine.update to scheduler
2020-01-05 02:11:19,932 [salt.minion      :1975][INFO    ][2920] Minion is starting as user 'root'
2020-01-05 02:11:19,952 [salt.minion      :2336][INFO    ][2920] Minion is ready to receive requests!
2020-01-05 02:11:24,543 [salt.state       :2022][WARNING ][2791] State is set to retry, but a valid dict for retry configuration was not found.  Using retry defaults
2020-01-05 02:11:27,673 [salt.utils.decorators:613 ][WARNING ][2791] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-01-05 02:11:28,034 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105021128011457
2020-01-05 02:11:28,058 [salt.minion      :1432][INFO    ][3382] Starting a new job with PID 3382
2020-01-05 02:11:28,084 [salt.minion      :1711][INFO    ][3382] Returning information for job: 20200105021128011457
2020-01-05 02:11:58,183 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105021158171094
2020-01-05 02:11:58,208 [salt.minion      :1432][INFO    ][3755] Starting a new job with PID 3755
2020-01-05 02:11:58,231 [salt.minion      :1711][INFO    ][3755] Returning information for job: 20200105021158171094
2020-01-05 02:12:28,318 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105021228309182
2020-01-05 02:12:28,333 [salt.minion      :1432][INFO    ][4039] Starting a new job with PID 4039
2020-01-05 02:12:28,360 [salt.minion      :1711][INFO    ][4039] Returning information for job: 20200105021228309182
2020-01-05 02:12:58,395 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105021258383775
2020-01-05 02:12:58,416 [salt.minion      :1432][INFO    ][4325] Starting a new job with PID 4325
2020-01-05 02:12:58,444 [salt.minion      :1711][INFO    ][4325] Returning information for job: 20200105021258383775
2020-01-05 02:13:28,527 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105021328512501
2020-01-05 02:13:28,544 [salt.minion      :1432][INFO    ][4631] Starting a new job with PID 4631
2020-01-05 02:13:28,563 [salt.minion      :1711][INFO    ][4631] Returning information for job: 20200105021328512501
2020-01-05 02:13:58,656 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105021358640094
2020-01-05 02:13:58,684 [salt.minion      :1432][INFO    ][4902] Starting a new job with PID 4902
2020-01-05 02:13:58,707 [salt.minion      :1711][INFO    ][4902] Returning information for job: 20200105021358640094
2020-01-05 02:14:28,779 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105021428767399
2020-01-05 02:14:28,800 [salt.minion      :1432][INFO    ][5199] Starting a new job with PID 5199
2020-01-05 02:14:28,822 [salt.minion      :1711][INFO    ][5199] Returning information for job: 20200105021428767399
2020-01-05 02:14:58,867 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105021458858074
2020-01-05 02:14:58,885 [salt.minion      :1432][INFO    ][5473] Starting a new job with PID 5473
2020-01-05 02:14:58,907 [salt.minion      :1711][INFO    ][5473] Returning information for job: 20200105021458858074
2020-01-05 02:15:28,973 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105021528965959
2020-01-05 02:15:28,990 [salt.minion      :1432][INFO    ][5775] Starting a new job with PID 5775
2020-01-05 02:15:29,014 [salt.minion      :1711][INFO    ][5775] Returning information for job: 20200105021528965959
2020-01-05 02:15:59,102 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105021559087186
2020-01-05 02:15:59,134 [salt.minion      :1432][INFO    ][6058] Starting a new job with PID 6058
2020-01-05 02:15:59,156 [salt.minion      :1711][INFO    ][6058] Returning information for job: 20200105021559087186
2020-01-05 02:16:29,270 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105021629261223
2020-01-05 02:16:29,289 [salt.minion      :1432][INFO    ][6357] Starting a new job with PID 6357
2020-01-05 02:16:29,311 [salt.minion      :1711][INFO    ][6357] Returning information for job: 20200105021629261223
2020-01-05 02:16:59,383 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105021659374371
2020-01-05 02:16:59,402 [salt.minion      :1432][INFO    ][6629] Starting a new job with PID 6629
2020-01-05 02:16:59,425 [salt.minion      :1711][INFO    ][6629] Returning information for job: 20200105021659374371
2020-01-05 02:17:29,532 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105021729522501
2020-01-05 02:17:29,554 [salt.minion      :1432][INFO    ][6929] Starting a new job with PID 6929
2020-01-05 02:17:29,574 [salt.minion      :1711][INFO    ][6929] Returning information for job: 20200105021729522501
2020-01-05 02:17:59,660 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105021759651426
2020-01-05 02:17:59,674 [salt.minion      :1432][INFO    ][7213] Starting a new job with PID 7213
2020-01-05 02:17:59,696 [salt.minion      :1711][INFO    ][7213] Returning information for job: 20200105021759651426
2020-01-05 02:18:29,789 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105021829781067
2020-01-05 02:18:29,809 [salt.minion      :1432][INFO    ][7523] Starting a new job with PID 7523
2020-01-05 02:18:29,833 [salt.minion      :1711][INFO    ][7523] Returning information for job: 20200105021829781067
2020-01-05 02:18:59,951 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105021859935131
2020-01-05 02:18:59,975 [salt.minion      :1432][INFO    ][7796] Starting a new job with PID 7796
2020-01-05 02:18:59,998 [salt.minion      :1711][INFO    ][7796] Returning information for job: 20200105021859935131
2020-01-05 02:19:30,127 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105021930105954
2020-01-05 02:19:30,145 [salt.minion      :1432][INFO    ][8101] Starting a new job with PID 8101
2020-01-05 02:19:30,170 [salt.minion      :1711][INFO    ][8101] Returning information for job: 20200105021930105954
2020-01-05 02:20:00,299 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105022000286072
2020-01-05 02:20:00,320 [salt.minion      :1432][INFO    ][8378] Starting a new job with PID 8378
2020-01-05 02:20:00,344 [salt.minion      :1711][INFO    ][8378] Returning information for job: 20200105022000286072
2020-01-05 02:20:30,456 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105022030443045
2020-01-05 02:20:30,479 [salt.minion      :1432][INFO    ][8682] Starting a new job with PID 8682
2020-01-05 02:20:30,503 [salt.minion      :1711][INFO    ][8682] Returning information for job: 20200105022030443045
2020-01-05 02:21:00,648 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105022100638672
2020-01-05 02:21:00,669 [salt.minion      :1432][INFO    ][8963] Starting a new job with PID 8963
2020-01-05 02:21:00,691 [salt.minion      :1711][INFO    ][8963] Returning information for job: 20200105022100638672
2020-01-05 02:21:30,812 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105022130802794
2020-01-05 02:21:30,830 [salt.minion      :1432][INFO    ][9285] Starting a new job with PID 9285
2020-01-05 02:21:30,858 [salt.minion      :1711][INFO    ][9285] Returning information for job: 20200105022130802794
2020-01-05 02:22:00,994 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105022200982890
2020-01-05 02:22:01,018 [salt.minion      :1432][INFO    ][9574] Starting a new job with PID 9574
2020-01-05 02:22:01,040 [salt.minion      :1711][INFO    ][9574] Returning information for job: 20200105022200982890
2020-01-05 02:22:31,166 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105022231154085
2020-01-05 02:22:31,189 [salt.minion      :1432][INFO    ][9875] Starting a new job with PID 9875
2020-01-05 02:22:31,216 [salt.minion      :1711][INFO    ][9875] Returning information for job: 20200105022231154085
2020-01-05 02:23:01,354 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105022301342757
2020-01-05 02:23:01,371 [salt.minion      :1432][INFO    ][10156] Starting a new job with PID 10156
2020-01-05 02:23:01,394 [salt.minion      :1711][INFO    ][10156] Returning information for job: 20200105022301342757
2020-01-05 02:23:31,535 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105022331526721
2020-01-05 02:23:31,557 [salt.minion      :1432][INFO    ][10467] Starting a new job with PID 10467
2020-01-05 02:23:31,581 [salt.minion      :1711][INFO    ][10467] Returning information for job: 20200105022331526721
2020-01-05 02:24:01,728 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105022401718118
2020-01-05 02:24:01,753 [salt.minion      :1432][INFO    ][10744] Starting a new job with PID 10744
2020-01-05 02:24:01,777 [salt.minion      :1711][INFO    ][10744] Returning information for job: 20200105022401718118
2020-01-05 02:24:31,933 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105022431924006
2020-01-05 02:24:31,960 [salt.minion      :1432][INFO    ][11055] Starting a new job with PID 11055
2020-01-05 02:24:31,981 [salt.minion      :1711][INFO    ][11055] Returning information for job: 20200105022431924006
2020-01-05 02:25:02,150 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105022502140473
2020-01-05 02:25:02,170 [salt.minion      :1432][INFO    ][11339] Starting a new job with PID 11339
2020-01-05 02:25:02,192 [salt.minion      :1711][INFO    ][11339] Returning information for job: 20200105022502140473
2020-01-05 02:25:32,267 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105022532221628
2020-01-05 02:25:32,291 [salt.minion      :1432][INFO    ][11640] Starting a new job with PID 11640
2020-01-05 02:25:32,315 [salt.minion      :1711][INFO    ][11640] Returning information for job: 20200105022532221628
2020-01-05 02:26:02,303 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105022602286996
2020-01-05 02:26:02,326 [salt.minion      :1432][INFO    ][11919] Starting a new job with PID 11919
2020-01-05 02:26:02,353 [salt.minion      :1711][INFO    ][11919] Returning information for job: 20200105022602286996
2020-01-05 02:26:32,391 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105022632375093
2020-01-05 02:26:32,414 [salt.minion      :1432][INFO    ][12226] Starting a new job with PID 12226
2020-01-05 02:26:32,439 [salt.minion      :1711][INFO    ][12226] Returning information for job: 20200105022632375093
2020-01-05 02:26:35,511 [salt.utils.decorators:613 ][WARNING ][2791] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-01-05 02:27:02,440 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105022702431737
2020-01-05 02:27:02,458 [salt.minion      :1432][INFO    ][12496] Starting a new job with PID 12496
2020-01-05 02:27:02,482 [salt.minion      :1711][INFO    ][12496] Returning information for job: 20200105022702431737
2020-01-05 02:27:32,553 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105022732518879
2020-01-05 02:27:32,583 [salt.minion      :1432][INFO    ][12808] Starting a new job with PID 12808
2020-01-05 02:27:32,605 [salt.minion      :1711][INFO    ][12808] Returning information for job: 20200105022732518879
2020-01-05 02:28:02,700 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105022802659631
2020-01-05 02:28:02,722 [salt.minion      :1432][INFO    ][13083] Starting a new job with PID 13083
2020-01-05 02:28:02,744 [salt.minion      :1711][INFO    ][13083] Returning information for job: 20200105022802659631
2020-01-05 02:28:32,821 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105022832810030
2020-01-05 02:28:32,845 [salt.minion      :1432][INFO    ][13381] Starting a new job with PID 13381
2020-01-05 02:28:32,869 [salt.minion      :1711][INFO    ][13381] Returning information for job: 20200105022832810030
2020-01-05 02:29:02,952 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105022902916701
2020-01-05 02:29:02,977 [salt.minion      :1432][INFO    ][13660] Starting a new job with PID 13660
2020-01-05 02:29:03,003 [salt.minion      :1711][INFO    ][13660] Returning information for job: 20200105022902916701
2020-01-05 02:29:33,176 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105022933131684
2020-01-05 02:29:33,193 [salt.minion      :1432][INFO    ][13967] Starting a new job with PID 13967
2020-01-05 02:29:33,220 [salt.minion      :1711][INFO    ][13967] Returning information for job: 20200105022933131684
2020-01-05 02:30:03,263 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105023003253976
2020-01-05 02:30:03,281 [salt.minion      :1432][INFO    ][14163] Starting a new job with PID 14163
2020-01-05 02:30:03,309 [salt.minion      :1711][INFO    ][14163] Returning information for job: 20200105023003253976
2020-01-05 02:30:10,439 [salt.utils.decorators:613 ][WARNING ][2791] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-01-05 02:30:33,436 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105023033422738
2020-01-05 02:30:33,458 [salt.minion      :1432][INFO    ][14330] Starting a new job with PID 14330
2020-01-05 02:30:33,501 [salt.minion      :1711][INFO    ][14330] Returning information for job: 20200105023033422738
2020-01-05 02:31:03,478 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105023103436009
2020-01-05 02:31:03,504 [salt.minion      :1432][INFO    ][14363] Starting a new job with PID 14363
2020-01-05 02:31:03,541 [salt.minion      :1711][INFO    ][14363] Returning information for job: 20200105023103436009
2020-01-05 02:31:33,668 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105023133659032
2020-01-05 02:31:33,686 [salt.minion      :1432][INFO    ][14441] Starting a new job with PID 14441
2020-01-05 02:31:33,730 [salt.minion      :1711][INFO    ][14441] Returning information for job: 20200105023133659032
2020-01-05 02:32:03,861 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105023203837116
2020-01-05 02:32:03,884 [salt.minion      :1432][INFO    ][14476] Starting a new job with PID 14476
2020-01-05 02:32:03,925 [salt.minion      :1711][INFO    ][14476] Returning information for job: 20200105023203837116
2020-01-05 02:32:34,067 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105023234054448
2020-01-05 02:32:34,090 [salt.minion      :1432][INFO    ][14547] Starting a new job with PID 14547
2020-01-05 02:32:34,114 [salt.minion      :1711][INFO    ][14547] Returning information for job: 20200105023234054448
2020-01-05 02:32:49,800 [salt.utils.decorators:613 ][WARNING ][2791] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-01-05 02:32:51,341 [salt.loaded.ext.module.maas:160 ][ERROR   ][2791] Failed for object commissioning_distro_series reason {"commissioning_distro_series": ["'bionic' is not a valid commissioning_distro_series.  It should be one of: '---'."]}
2020-01-05 02:32:52,800 [salt.loaded.ext.module.maas:160 ][ERROR   ][2791] Failed for object default_min_hwe_kernel reason {"default_min_hwe_kernel": ["'ga-18.04' is not a valid default_min_hwe_kernel.  It should be one of: ''."]}
2020-01-05 02:32:52,802 [salt.state       :302 ][ERROR   ][2791] Module function maas.process_maas_config threw an exception. Exception: {'updated': [], 'errors': {'commissioning_distro_series': '{"commissioning_distro_series": ["\'bionic\' is not a valid commissioning_distro_series.  It should be one of: \'---\'."]}', 'default_min_hwe_kernel': '{"default_min_hwe_kernel": ["\'ga-18.04\' is not a valid default_min_hwe_kernel.  It should be one of: \'\'."]}'}, 'success': ['enable_http_proxy', 'upstream_dns', 'default_osystem', 'active_discovery_interval', 'dnssec_validation', 'maas_name', 'network_discovery', 'enable_third_party_drivers', 'default_storage_layout', 'ntp_external_only', 'disk_erase_with_secure_erase', 'default_distro_series']}
2020-01-05 02:32:53,023 [salt.loaded.ext.module.maasng:1008][WARNING ][2791] Detected cidr:192.168.11.0/24 in fabric:fabric-1
2020-01-05 02:32:53,024 [salt.loaded.ext.module.maasng:1011][WARNING ][2791] Guessing, that fabric with current name:fabric-1
 should be renamed to:pxe_admin
2020-01-05 02:32:53,903 [salt.loaded.ext.module.maasng:1235][WARNING ][2791] Ignoring parameter vlan:0
2020-01-05 02:33:06,225 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command state.apply with jid 20200105023306206798
2020-01-05 02:33:06,254 [salt.minion      :1432][INFO    ][14682] Starting a new job with PID 14682
2020-01-05 02:33:14,502 [salt.state       :915 ][INFO    ][14682] Loading fresh modules for state activity
2020-01-05 02:33:16,106 [salt.state       :1780][INFO    ][14682] Running state [maas-region-controller] at time 02:33:16.105951
2020-01-05 02:33:16,106 [salt.state       :1813][INFO    ][14682] Executing state pkg.installed for [maas-region-controller]
2020-01-05 02:33:16,107 [salt.loaded.int.module.cmdmod:395 ][INFO    ][14682] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2020-01-05 02:33:16,240 [salt.state       :300 ][INFO    ][14682] All specified packages are already installed
2020-01-05 02:33:16,240 [salt.state       :1951][INFO    ][14682] Completed state [maas-region-controller] at time 02:33:16.240354 duration_in_ms=134.404
2020-01-05 02:33:16,240 [salt.state       :1780][INFO    ][14682] Running state [python-oauth] at time 02:33:16.240681
2020-01-05 02:33:16,241 [salt.state       :1813][INFO    ][14682] Executing state pkg.installed for [python-oauth]
2020-01-05 02:33:16,250 [salt.state       :300 ][INFO    ][14682] All specified packages are already installed
2020-01-05 02:33:16,250 [salt.state       :1951][INFO    ][14682] Completed state [python-oauth] at time 02:33:16.250428 duration_in_ms=9.746
2020-01-05 02:33:16,254 [salt.state       :1780][INFO    ][14682] Running state [/etc/maas/regiond.conf] at time 02:33:16.254874
2020-01-05 02:33:16,255 [salt.state       :1813][INFO    ][14682] Executing state file.replace for [/etc/maas/regiond.conf]
2020-01-05 02:33:16,260 [salt.state       :300 ][INFO    ][14682] No changes needed to be made
2020-01-05 02:33:16,260 [salt.state       :1951][INFO    ][14682] Completed state [/etc/maas/regiond.conf] at time 02:33:16.260223 duration_in_ms=5.349
2020-01-05 02:33:16,260 [salt.state       :1780][INFO    ][14682] Running state [/usr/lib/python3/dist-packages/provisioningserver/templates/proxy/maas-proxy.conf.template] at time 02:33:16.260720
2020-01-05 02:33:16,261 [salt.state       :1813][INFO    ][14682] Executing state file.managed for [/usr/lib/python3/dist-packages/provisioningserver/templates/proxy/maas-proxy.conf.template]
2020-01-05 02:33:16,336 [salt.state       :300 ][INFO    ][14682] File /usr/lib/python3/dist-packages/provisioningserver/templates/proxy/maas-proxy.conf.template is in the correct state
2020-01-05 02:33:16,336 [salt.state       :1951][INFO    ][14682] Completed state [/usr/lib/python3/dist-packages/provisioningserver/templates/proxy/maas-proxy.conf.template] at time 02:33:16.336541 duration_in_ms=75.819
2020-01-05 02:33:16,338 [salt.state       :1780][INFO    ][14682] Running state [/usr/lib/python3/dist-packages/maasserver/node_status.py] at time 02:33:16.338657
2020-01-05 02:33:16,339 [salt.state       :1813][INFO    ][14682] Executing state file.replace for [/usr/lib/python3/dist-packages/maasserver/node_status.py]
2020-01-05 02:33:16,346 [salt.state       :300 ][INFO    ][14682] No changes needed to be made
2020-01-05 02:33:16,347 [salt.state       :1951][INFO    ][14682] Completed state [/usr/lib/python3/dist-packages/maasserver/node_status.py] at time 02:33:16.347118 duration_in_ms=8.459
2020-01-05 02:33:16,348 [salt.state       :1780][INFO    ][14682] Running state [/usr/lib/python3/dist-packages/maasserver/node_status.py] at time 02:33:16.348187
2020-01-05 02:33:16,348 [salt.state       :1813][INFO    ][14682] Executing state file.replace for [/usr/lib/python3/dist-packages/maasserver/node_status.py]
2020-01-05 02:33:16,353 [salt.state       :300 ][INFO    ][14682] No changes needed to be made
2020-01-05 02:33:16,354 [salt.state       :1951][INFO    ][14682] Completed state [/usr/lib/python3/dist-packages/maasserver/node_status.py] at time 02:33:16.354171 duration_in_ms=5.985
2020-01-05 02:33:16,354 [salt.state       :1780][INFO    ][14682] Running state [/usr/lib/python3/dist-packages/maasserver/models/node.py] at time 02:33:16.354663
2020-01-05 02:33:16,354 [salt.state       :1813][INFO    ][14682] Executing state file.replace for [/usr/lib/python3/dist-packages/maasserver/models/node.py]
2020-01-05 02:33:16,379 [salt.state       :300 ][INFO    ][14682] No changes needed to be made
2020-01-05 02:33:16,379 [salt.state       :1951][INFO    ][14682] Completed state [/usr/lib/python3/dist-packages/maasserver/models/node.py] at time 02:33:16.379938 duration_in_ms=25.275
2020-01-05 02:33:16,380 [salt.state       :1780][INFO    ][14682] Running state [/etc/apache2/conf-enabled/maas-http.conf] at time 02:33:16.380433
2020-01-05 02:33:16,380 [salt.state       :1813][INFO    ][14682] Executing state file.managed for [/etc/apache2/conf-enabled/maas-http.conf]
2020-01-05 02:33:16,425 [salt.state       :300 ][INFO    ][14682] File /etc/apache2/conf-enabled/maas-http.conf is in the correct state
2020-01-05 02:33:16,426 [salt.state       :1951][INFO    ][14682] Completed state [/etc/apache2/conf-enabled/maas-http.conf] at time 02:33:16.426221 duration_in_ms=45.787
2020-01-05 02:33:16,429 [salt.state       :1780][INFO    ][14682] Running state [a2enmod headers] at time 02:33:16.428965
2020-01-05 02:33:16,429 [salt.state       :1813][INFO    ][14682] Executing state cmd.run for [a2enmod headers]
2020-01-05 02:33:16,430 [salt.loaded.int.module.cmdmod:395 ][INFO    ][14682] Executing command 'a2enmod headers' in directory '/root'
2020-01-05 02:33:16,512 [salt.state       :300 ][INFO    ][14682] {'pid': 14745, 'retcode': 0, 'stderr': '', 'stdout': 'Module headers already enabled'}
2020-01-05 02:33:16,513 [salt.state       :1951][INFO    ][14682] Completed state [a2enmod headers] at time 02:33:16.513791 duration_in_ms=84.826
2020-01-05 02:33:16,514 [salt.state       :1780][INFO    ][14682] Running state [/usr/share/maas/web/static/css/maas-styles.css] at time 02:33:16.514471
2020-01-05 02:33:16,515 [salt.state       :1813][INFO    ][14682] Executing state file.managed for [/usr/share/maas/web/static/css/maas-styles.css]
2020-01-05 02:33:16,561 [salt.state       :300 ][INFO    ][14682] File /usr/share/maas/web/static/css/maas-styles.css is in the correct state
2020-01-05 02:33:16,561 [salt.state       :1951][INFO    ][14682] Completed state [/usr/share/maas/web/static/css/maas-styles.css] at time 02:33:16.561384 duration_in_ms=46.913
2020-01-05 02:33:16,562 [salt.state       :1780][INFO    ][14682] Running state [/etc/maas/preseeds/curtin_userdata_amd64_generic_trusty] at time 02:33:16.562284
2020-01-05 02:33:16,562 [salt.state       :1813][INFO    ][14682] Executing state file.managed for [/etc/maas/preseeds/curtin_userdata_amd64_generic_trusty]
2020-01-05 02:33:16,658 [salt.state       :300 ][INFO    ][14682] File /etc/maas/preseeds/curtin_userdata_amd64_generic_trusty is in the correct state
2020-01-05 02:33:16,658 [salt.state       :1951][INFO    ][14682] Completed state [/etc/maas/preseeds/curtin_userdata_amd64_generic_trusty] at time 02:33:16.658605 duration_in_ms=96.32
2020-01-05 02:33:16,659 [salt.state       :1780][INFO    ][14682] Running state [/etc/maas/preseeds/curtin_userdata_amd64_generic_xenial] at time 02:33:16.659649
2020-01-05 02:33:16,660 [salt.state       :1813][INFO    ][14682] Executing state file.managed for [/etc/maas/preseeds/curtin_userdata_amd64_generic_xenial]
2020-01-05 02:33:16,732 [salt.state       :300 ][INFO    ][14682] File /etc/maas/preseeds/curtin_userdata_amd64_generic_xenial is in the correct state
2020-01-05 02:33:16,732 [salt.state       :1951][INFO    ][14682] Completed state [/etc/maas/preseeds/curtin_userdata_amd64_generic_xenial] at time 02:33:16.732709 duration_in_ms=73.06
2020-01-05 02:33:16,734 [salt.state       :1780][INFO    ][14682] Running state [/etc/maas/preseeds/curtin_userdata_arm64_generic_xenial] at time 02:33:16.734262
2020-01-05 02:33:16,734 [salt.state       :1813][INFO    ][14682] Executing state file.managed for [/etc/maas/preseeds/curtin_userdata_arm64_generic_xenial]
2020-01-05 02:33:16,836 [salt.state       :300 ][INFO    ][14682] File /etc/maas/preseeds/curtin_userdata_arm64_generic_xenial is in the correct state
2020-01-05 02:33:16,837 [salt.state       :1951][INFO    ][14682] Completed state [/etc/maas/preseeds/curtin_userdata_arm64_generic_xenial] at time 02:33:16.837068 duration_in_ms=102.806
2020-01-05 02:33:16,838 [salt.state       :1780][INFO    ][14682] Running state [/etc/maas/preseeds/curtin_userdata_amd64_generic_bionic] at time 02:33:16.837957
2020-01-05 02:33:16,838 [salt.state       :1813][INFO    ][14682] Executing state file.managed for [/etc/maas/preseeds/curtin_userdata_amd64_generic_bionic]
2020-01-05 02:33:16,971 [salt.state       :300 ][INFO    ][14682] File /etc/maas/preseeds/curtin_userdata_amd64_generic_bionic is in the correct state
2020-01-05 02:33:16,971 [salt.state       :1951][INFO    ][14682] Completed state [/etc/maas/preseeds/curtin_userdata_amd64_generic_bionic] at time 02:33:16.971782 duration_in_ms=133.824
2020-01-05 02:33:16,972 [salt.state       :1780][INFO    ][14682] Running state [/etc/maas/preseeds/curtin_userdata_arm64_generic_bionic] at time 02:33:16.972348
2020-01-05 02:33:16,972 [salt.state       :1813][INFO    ][14682] Executing state file.managed for [/etc/maas/preseeds/curtin_userdata_arm64_generic_bionic]
2020-01-05 02:33:17,042 [salt.state       :300 ][INFO    ][14682] File /etc/maas/preseeds/curtin_userdata_arm64_generic_bionic is in the correct state
2020-01-05 02:33:17,042 [salt.state       :1951][INFO    ][14682] Completed state [/etc/maas/preseeds/curtin_userdata_arm64_generic_bionic] at time 02:33:17.042433 duration_in_ms=70.084
2020-01-05 02:33:17,042 [salt.state       :1780][INFO    ][14682] Running state [/root/.pgpass] at time 02:33:17.042809
2020-01-05 02:33:17,043 [salt.state       :1813][INFO    ][14682] Executing state file.managed for [/root/.pgpass]
2020-01-05 02:33:17,102 [salt.state       :300 ][INFO    ][14682] File /root/.pgpass is in the correct state
2020-01-05 02:33:17,102 [salt.state       :1951][INFO    ][14682] Completed state [/root/.pgpass] at time 02:33:17.102223 duration_in_ms=59.414
2020-01-05 02:33:17,109 [salt.state       :1780][INFO    ][14682] Running state [maas-region syncdb --noinput] at time 02:33:17.109920
2020-01-05 02:33:17,110 [salt.state       :1813][INFO    ][14682] Executing state cmd.run for [maas-region syncdb --noinput]
2020-01-05 02:33:17,110 [salt.loaded.int.module.cmdmod:395 ][INFO    ][14682] Executing command 'maas-region syncdb --noinput' in directory '/root'
2020-01-05 02:33:20,077 [salt.state       :300 ][INFO    ][14682] {'pid': 14762, 'retcode': 0, 'stderr': '', 'stdout': 'Operations to perform:\n  Synchronize unmigrated apps: staticfiles, messages\n  Apply all migrations: metadataserver, sessions, auth, contenttypes, piston3, sites, maasserver\nSynchronizing apps without migrations:\n  Creating tables...\n    Running deferred SQL...\n  Installing custom SQL...\nRunning migrations:\n  No migrations to apply.'}
2020-01-05 02:33:20,078 [salt.state       :1951][INFO    ][14682] Completed state [maas-region syncdb --noinput] at time 02:33:20.078373 duration_in_ms=2968.45
2020-01-05 02:33:20,078 [salt.state       :2022][WARNING ][14682] State is set to retry, but a valid dict for retry configuration was not found.  Using retry defaults
2020-01-05 02:33:20,083 [salt.state       :1780][INFO    ][14682] Running state [maas-regiond] at time 02:33:20.083437
2020-01-05 02:33:20,083 [salt.state       :1813][INFO    ][14682] Executing state service.running for [maas-regiond]
2020-01-05 02:33:20,085 [salt.loaded.int.module.cmdmod:395 ][INFO    ][14682] Executing command ['systemctl', 'status', 'maas-regiond.service', '-n', '0'] in directory '/root'
2020-01-05 02:33:20,131 [salt.loaded.int.module.cmdmod:395 ][INFO    ][14682] Executing command ['systemctl', 'is-active', 'maas-regiond.service'] in directory '/root'
2020-01-05 02:33:20,151 [salt.loaded.int.module.cmdmod:395 ][INFO    ][14682] Executing command ['systemctl', 'is-enabled', 'maas-regiond.service'] in directory '/root'
2020-01-05 02:33:20,180 [salt.state       :300 ][INFO    ][14682] The service maas-regiond is already running
2020-01-05 02:33:20,181 [salt.state       :1951][INFO    ][14682] Completed state [maas-regiond] at time 02:33:20.180977 duration_in_ms=97.539
2020-01-05 02:33:20,185 [salt.state       :1780][INFO    ][14682] Running state [bind9] at time 02:33:20.185696
2020-01-05 02:33:20,186 [salt.state       :1813][INFO    ][14682] Executing state service.running for [bind9]
2020-01-05 02:33:20,187 [salt.loaded.int.module.cmdmod:395 ][INFO    ][14682] Executing command ['systemctl', 'status', 'bind9.service', '-n', '0'] in directory '/root'
2020-01-05 02:33:20,212 [salt.loaded.int.module.cmdmod:395 ][INFO    ][14682] Executing command ['systemctl', 'is-active', 'bind9.service'] in directory '/root'
2020-01-05 02:33:20,233 [salt.loaded.int.module.cmdmod:395 ][INFO    ][14682] Executing command ['systemctl', 'is-enabled', 'bind9.service'] in directory '/root'
2020-01-05 02:33:20,256 [salt.state       :300 ][INFO    ][14682] The service bind9 is already running
2020-01-05 02:33:20,257 [salt.state       :1951][INFO    ][14682] Completed state [bind9] at time 02:33:20.257731 duration_in_ms=72.034
2020-01-05 02:33:20,260 [salt.state       :1780][INFO    ][14682] Running state [apache2] at time 02:33:20.260699
2020-01-05 02:33:20,261 [salt.state       :1813][INFO    ][14682] Executing state service.running for [apache2]
2020-01-05 02:33:20,264 [salt.loaded.int.module.cmdmod:395 ][INFO    ][14682] Executing command ['systemctl', 'status', 'apache2.service', '-n', '0'] in directory '/root'
2020-01-05 02:33:20,289 [salt.loaded.int.module.cmdmod:395 ][INFO    ][14682] Executing command ['systemctl', 'is-active', 'apache2.service'] in directory '/root'
2020-01-05 02:33:20,314 [salt.loaded.int.module.cmdmod:395 ][INFO    ][14682] Executing command ['systemctl', 'is-enabled', 'apache2.service'] in directory '/root'
2020-01-05 02:33:20,348 [salt.state       :300 ][INFO    ][14682] The service apache2 is already running
2020-01-05 02:33:20,349 [salt.state       :1951][INFO    ][14682] Completed state [apache2] at time 02:33:20.348974 duration_in_ms=88.276
2020-01-05 02:33:20,352 [salt.state       :1780][INFO    ][14682] Running state [maasng.wait_for_http_code] at time 02:33:20.352135
2020-01-05 02:33:20,352 [salt.state       :1813][INFO    ][14682] Executing state module.run for [maasng.wait_for_http_code]
2020-01-05 02:33:20,353 [salt.utils.decorators:613 ][WARNING ][14682] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-01-05 02:33:20,598 [salt.state       :300 ][INFO    ][14682] {'ret': {'comment': 'MAAS API:http://localhost:5240/MAAS up.', 'result': True}}
2020-01-05 02:33:20,599 [salt.state       :1951][INFO    ][14682] Completed state [maasng.wait_for_http_code] at time 02:33:20.599194 duration_in_ms=247.059
2020-01-05 02:33:20,601 [salt.state       :1780][INFO    ][14682] Running state [maas createadmin --username opnfv --password opnfv_secret --email email@example.com && touch /var/lib/maas/.setup_admin] at time 02:33:20.601001
2020-01-05 02:33:20,602 [salt.state       :1813][INFO    ][14682] Executing state cmd.run for [maas createadmin --username opnfv --password opnfv_secret --email email@example.com && touch /var/lib/maas/.setup_admin]
2020-01-05 02:33:20,603 [salt.state       :300 ][INFO    ][14682] /var/lib/maas/.setup_admin exists
2020-01-05 02:33:20,603 [salt.state       :1951][INFO    ][14682] Completed state [maas createadmin --username opnfv --password opnfv_secret --email email@example.com && touch /var/lib/maas/.setup_admin] at time 02:33:20.603353 duration_in_ms=2.351
2020-01-05 02:33:20,604 [salt.state       :1780][INFO    ][14682] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 02:33:20.604511
2020-01-05 02:33:20,605 [salt.state       :1813][INFO    ][14682] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2020-01-05 02:33:20,605 [salt.loaded.int.module.cmdmod:395 ][INFO    ][14682] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2020-01-05 02:33:21,249 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105023321239704
2020-01-05 02:33:21,268 [salt.minion      :1432][INFO    ][14789] Starting a new job with PID 14789
2020-01-05 02:33:21,307 [salt.minion      :1711][INFO    ][14789] Returning information for job: 20200105023321239704
2020-01-05 02:33:22,353 [salt.state       :300 ][INFO    ][14682] {'pid': 14784, 'retcode': 0, 'stderr': '', 'stdout': ''}
2020-01-05 02:33:22,354 [salt.state       :1951][INFO    ][14682] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 02:33:22.354653 duration_in_ms=1750.142
2020-01-05 02:33:22,365 [salt.state       :1780][INFO    ][14682] Running state [maas_region_boot_source_resources_mirror] at time 02:33:22.365232
2020-01-05 02:33:22,365 [salt.state       :1813][INFO    ][14682] Executing state maasng.boot_source_present for [maas_region_boot_source_resources_mirror]
2020-01-05 02:33:22,454 [salt.state       :300 ][INFO    ][14682] {'changes': {}}
2020-01-05 02:33:22,454 [salt.state       :1951][INFO    ][14682] Completed state [maas_region_boot_source_resources_mirror] at time 02:33:22.454363 duration_in_ms=89.131
2020-01-05 02:33:22,455 [salt.state       :1780][INFO    ][14682] Running state [maasng.boot_resources_import] at time 02:33:22.455331
2020-01-05 02:33:22,455 [salt.state       :1813][INFO    ][14682] Executing state module.run for [maasng.boot_resources_import]
2020-01-05 02:33:22,456 [salt.utils.decorators:613 ][WARNING ][14682] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-01-05 02:33:22,540 [salt.loaded.ext.module.maasng:1600][INFO    ][14682] Waiting boot-resources import done
sleep for:5s Left:900.0/900s
2020-01-05 02:33:27,592 [salt.loaded.ext.module.maasng:1600][INFO    ][14682] Waiting boot-resources import done
sleep for:5s Left:895.0/900s
2020-01-05 02:33:32,690 [salt.state       :300 ][INFO    ][14682] {'ret': True}
2020-01-05 02:33:32,690 [salt.state       :1951][INFO    ][14682] Completed state [maasng.boot_resources_import] at time 02:33:32.690652 duration_in_ms=10235.32
2020-01-05 02:33:32,692 [salt.state       :1780][INFO    ][14682] Running state [maas_region_boot_sources_selection_bionic] at time 02:33:32.692008
2020-01-05 02:33:32,692 [salt.state       :1813][INFO    ][14682] Executing state maasng.boot_sources_selections_present for [maas_region_boot_sources_selection_bionic]
2020-01-05 02:33:32,892 [salt.state       :300 ][INFO    ][14682] Requested boot-source selection for http://images.maas.io/ephemeral-v3/daily already exist.
2020-01-05 02:33:32,892 [salt.state       :1951][INFO    ][14682] Completed state [maas_region_boot_sources_selection_bionic] at time 02:33:32.892699 duration_in_ms=200.691
2020-01-05 02:33:32,894 [salt.state       :1780][INFO    ][14682] Running state [maasng.sync_and_wait_bs_to_all_racks] at time 02:33:32.894639
2020-01-05 02:33:32,895 [salt.state       :1813][INFO    ][14682] Executing state module.run for [maasng.sync_and_wait_bs_to_all_racks]
2020-01-05 02:33:32,895 [salt.utils.decorators:613 ][WARNING ][14682] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-01-05 02:33:32,896 [salt.loaded.ext.module.maasng:1771][INFO    ][14682] boot-sources sync initiated for ALL Rack's
2020-01-05 02:33:33,805 [salt.state       :300 ][INFO    ][14682] {'ret': True}
2020-01-05 02:33:33,805 [salt.state       :1951][INFO    ][14682] Completed state [maasng.sync_and_wait_bs_to_all_racks] at time 02:33:33.805487 duration_in_ms=910.847
2020-01-05 02:33:33,807 [salt.state       :1780][INFO    ][14682] Running state [maas.process_maas_config] at time 02:33:33.807861
2020-01-05 02:33:33,808 [salt.state       :1813][INFO    ][14682] Executing state module.run for [maas.process_maas_config]
2020-01-05 02:33:33,809 [salt.utils.decorators:613 ][WARNING ][14682] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-01-05 02:33:33,811 [salt.loaded.ext.module.maas:92  ][INFO    ][14682] maasconfig name=enable_http_proxy value=True
2020-01-05 02:33:33,866 [salt.loaded.ext.module.maas:92  ][INFO    ][14682] maasconfig name=upstream_dns value=8.8.8.8
2020-01-05 02:33:35,332 [salt.loaded.ext.module.maas:92  ][INFO    ][14682] maasconfig name=commissioning_distro_series value=bionic
2020-01-05 02:33:35,400 [salt.loaded.ext.module.maas:92  ][INFO    ][14682] maasconfig name=default_osystem value=ubuntu
2020-01-05 02:33:35,460 [salt.loaded.ext.module.maas:92  ][INFO    ][14682] maasconfig name=active_discovery_interval value=600
2020-01-05 02:33:35,510 [salt.loaded.ext.module.maas:92  ][INFO    ][14682] maasconfig name=dnssec_validation value=no
2020-01-05 02:33:35,560 [salt.loaded.ext.module.maas:92  ][INFO    ][14682] maasconfig name=maas_name value=mas01
2020-01-05 02:33:35,604 [salt.loaded.ext.module.maas:92  ][INFO    ][14682] maasconfig name=network_discovery value=enabled
2020-01-05 02:33:35,695 [salt.loaded.ext.module.maas:92  ][INFO    ][14682] maasconfig name=enable_third_party_drivers value=True
2020-01-05 02:33:35,746 [salt.loaded.ext.module.maas:92  ][INFO    ][14682] maasconfig name=default_storage_layout value=lvm
2020-01-05 02:33:35,800 [salt.loaded.ext.module.maas:92  ][INFO    ][14682] maasconfig name=ntp_external_only value=True
2020-01-05 02:33:35,859 [salt.loaded.ext.module.maas:92  ][INFO    ][14682] maasconfig name=disk_erase_with_secure_erase value=False
2020-01-05 02:33:35,914 [salt.loaded.ext.module.maas:92  ][INFO    ][14682] maasconfig name=default_distro_series value=bionic
2020-01-05 02:33:35,995 [salt.loaded.ext.module.maas:92  ][INFO    ][14682] maasconfig name=default_min_hwe_kernel value=ga-18.04
2020-01-05 02:33:36,109 [salt.state       :300 ][INFO    ][14682] {'ret': {'updated': [], 'errors': {}, 'success': ['enable_http_proxy', 'upstream_dns', 'commissioning_distro_series', 'default_osystem', 'active_discovery_interval', 'dnssec_validation', 'maas_name', 'network_discovery', 'enable_third_party_drivers', 'default_storage_layout', 'ntp_external_only', 'disk_erase_with_secure_erase', 'default_distro_series', 'default_min_hwe_kernel']}}
2020-01-05 02:33:36,109 [salt.state       :1951][INFO    ][14682] Completed state [maas.process_maas_config] at time 02:33:36.109848 duration_in_ms=2301.986
2020-01-05 02:33:36,110 [salt.state       :1780][INFO    ][14682] Running state [pxe_admin] at time 02:33:36.110892
2020-01-05 02:33:36,111 [salt.state       :1813][INFO    ][14682] Executing state maasng.fabric_present for [pxe_admin]
2020-01-05 02:33:36,165 [salt.loaded.ext.module.maasng:945 ][INFO    ][14682] [{u'id': 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'fabric': u'fabric-0', u'relay_vlan': None, u'external_dhcp': None, u'id': 5001, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/'}], u'class_type': None, u'name': u'fabric-0', u'resource_uri': u'/MAAS/api/2.0/fabrics/0/'}, {u'id': 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'fabric': u'fabric-2', u'relay_vlan': None, u'external_dhcp': None, u'id': 5003, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/'}], u'class_type': None, u'name': u'fabric-2', u'resource_uri': u'/MAAS/api/2.0/fabrics/2/'}, {u'id': 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's3ns6m', u'fabric': u'pxe_admin', u'relay_vlan': None, u'external_dhcp': None, u'id': 5002, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/'}], u'class_type': u'', u'name': u'pxe_admin', u'resource_uri': u'/MAAS/api/2.0/fabrics/1/'}]
2020-01-05 02:33:36,220 [salt.loaded.ext.module.maasng:1008][WARNING ][14682] Detected cidr:192.168.11.0/24 in fabric:pxe_admin
2020-01-05 02:33:36,220 [salt.loaded.ext.module.maasng:1011][WARNING ][14682] Guessing, that fabric with current name:pxe_admin
 should be renamed to:pxe_admin
2020-01-05 02:33:36,315 [salt.state       :300 ][INFO    ][14682] {'new': 'Fabric  pxe_admin created', 'result': True}
2020-01-05 02:33:36,316 [salt.state       :1951][INFO    ][14682] Completed state [pxe_admin] at time 02:33:36.316266 duration_in_ms=205.375
2020-01-05 02:33:36,316 [salt.state       :1780][INFO    ][14682] Running state [vlan 0] at time 02:33:36.316583
2020-01-05 02:33:36,316 [salt.state       :1813][INFO    ][14682] Executing state maasng.vlan_present_in_fabric for [vlan 0]
2020-01-05 02:33:36,368 [salt.loaded.ext.module.maasng:945 ][INFO    ][14682] [{u'id': 0, u'class_type': None, u'vlans': [{u'fabric': u'fabric-0', u'vid': 0, u'space': u'undefined', u'dhcp_on': False, u'fabric_id': 0, u'mtu': 1500, u'primary_rack': None, u'relay_vlan': None, u'external_dhcp': None, u'name': u'untagged', u'id': 5001, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/'}], u'name': u'fabric-0', u'resource_uri': u'/MAAS/api/2.0/fabrics/0/'}, {u'id': 2, u'class_type': None, u'vlans': [{u'fabric': u'fabric-2', u'vid': 0, u'space': u'undefined', u'dhcp_on': False, u'fabric_id': 2, u'mtu': 1500, u'primary_rack': None, u'relay_vlan': None, u'external_dhcp': None, u'name': u'untagged', u'id': 5003, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/'}], u'name': u'fabric-2', u'resource_uri': u'/MAAS/api/2.0/fabrics/2/'}, {u'id': 1, u'class_type': u'', u'vlans': [{u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'dhcp_on': True, u'fabric_id': 1, u'mtu': 1500, u'primary_rack': u's3ns6m', u'relay_vlan': None, u'external_dhcp': None, u'name': u'untagged', u'id': 5002, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/'}], u'name': u'pxe_admin', u'resource_uri': u'/MAAS/api/2.0/fabrics/1/'}]
2020-01-05 02:33:36,472 [salt.loaded.ext.module.maasng:945 ][INFO    ][14682] [{u'id': 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'fabric': u'fabric-0', u'relay_vlan': None, u'external_dhcp': None, u'id': 5001, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/'}], u'class_type': None, u'name': u'fabric-0', u'resource_uri': u'/MAAS/api/2.0/fabrics/0/'}, {u'id': 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'fabric': u'fabric-2', u'relay_vlan': None, u'external_dhcp': None, u'id': 5003, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/'}], u'class_type': None, u'name': u'fabric-2', u'resource_uri': u'/MAAS/api/2.0/fabrics/2/'}, {u'id': 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's3ns6m', u'fabric': u'pxe_admin', u'relay_vlan': None, u'external_dhcp': None, u'id': 5002, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/'}], u'class_type': u'', u'name': u'pxe_admin', u'resource_uri': u'/MAAS/api/2.0/fabrics/1/'}]
2020-01-05 02:33:36,704 [salt.loaded.ext.module.maasng:945 ][INFO    ][14682] [{u'id': 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'fabric': u'fabric-0', u'relay_vlan': None, u'external_dhcp': None, u'id': 5001, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/'}], u'class_type': None, u'name': u'fabric-0', u'resource_uri': u'/MAAS/api/2.0/fabrics/0/'}, {u'id': 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'fabric': u'fabric-2', u'relay_vlan': None, u'external_dhcp': None, u'id': 5003, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/'}], u'class_type': None, u'name': u'fabric-2', u'resource_uri': u'/MAAS/api/2.0/fabrics/2/'}, {u'id': 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's3ns6m', u'fabric': u'pxe_admin', u'relay_vlan': None, u'external_dhcp': None, u'id': 5002, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/'}], u'class_type': u'', u'name': u'pxe_admin', u'resource_uri': u'/MAAS/api/2.0/fabrics/1/'}]
2020-01-05 02:33:36,808 [salt.state       :300 ][INFO    ][14682] {'new': 'Vlan untagged was updated'}
2020-01-05 02:33:36,808 [salt.state       :1951][INFO    ][14682] Completed state [vlan 0] at time 02:33:36.808552 duration_in_ms=491.968
2020-01-05 02:33:36,811 [salt.state       :1780][INFO    ][14682] Running state [192.168.11.0/24] at time 02:33:36.811370
2020-01-05 02:33:36,811 [salt.state       :1813][INFO    ][14682] Executing state maasng.subnet_present for [192.168.11.0/24]
2020-01-05 02:33:36,992 [salt.loaded.ext.module.maasng:945 ][INFO    ][14682] [{u'id': 0, u'class_type': None, u'vlans': [{u'fabric': u'fabric-0', u'vid': 0, u'space': u'undefined', u'dhcp_on': False, u'fabric_id': 0, u'mtu': 1500, u'primary_rack': None, u'relay_vlan': None, u'external_dhcp': None, u'name': u'untagged', u'id': 5001, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/'}], u'name': u'fabric-0', u'resource_uri': u'/MAAS/api/2.0/fabrics/0/'}, {u'id': 2, u'class_type': None, u'vlans': [{u'fabric': u'fabric-2', u'vid': 0, u'space': u'undefined', u'dhcp_on': False, u'fabric_id': 2, u'mtu': 1500, u'primary_rack': None, u'relay_vlan': None, u'external_dhcp': None, u'name': u'untagged', u'id': 5003, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/'}], u'name': u'fabric-2', u'resource_uri': u'/MAAS/api/2.0/fabrics/2/'}, {u'id': 1, u'class_type': u'', u'vlans': [{u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'dhcp_on': False, u'fabric_id': 1, u'mtu': 1500, u'primary_rack': u's3ns6m', u'relay_vlan': None, u'external_dhcp': None, u'name': u'untagged', u'id': 5002, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/'}], u'name': u'pxe_admin', u'resource_uri': u'/MAAS/api/2.0/fabrics/1/'}]
2020-01-05 02:33:36,992 [salt.loaded.ext.module.maasng:1235][WARNING ][14682] Ignoring parameter vlan:0
2020-01-05 02:33:37,066 [salt.state       :300 ][INFO    ][14682] Subnet 192.168.11.0/24 has been updated for pxe_admin
2020-01-05 02:33:37,066 [salt.state       :1951][INFO    ][14682] Completed state [192.168.11.0/24] at time 02:33:37.066873 duration_in_ms=255.503
2020-01-05 02:33:37,068 [salt.state       :1780][INFO    ][14682] Running state [maas_create_iprange_1] at time 02:33:37.068188
2020-01-05 02:33:37,068 [salt.state       :1813][INFO    ][14682] Executing state maasng.iprange_present for [maas_create_iprange_1]
2020-01-05 02:33:37,126 [salt.state       :300 ][INFO    ][14682] Iprange maas_create_iprange_1 already exist.
2020-01-05 02:33:37,126 [salt.state       :1951][INFO    ][14682] Completed state [maas_create_iprange_1] at time 02:33:37.126532 duration_in_ms=58.344
2020-01-05 02:33:37,126 [salt.state       :1780][INFO    ][14682] Running state [vlan 0] at time 02:33:37.126811
2020-01-05 02:33:37,127 [salt.state       :1813][INFO    ][14682] Executing state maasng.vlan_present_in_fabric for [vlan 0]
2020-01-05 02:33:37,174 [salt.loaded.ext.module.maasng:945 ][INFO    ][14682] [{u'id': 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'fabric': u'fabric-0', u'relay_vlan': None, u'external_dhcp': None, u'id': 5001, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/'}], u'class_type': None, u'name': u'fabric-0', u'resource_uri': u'/MAAS/api/2.0/fabrics/0/'}, {u'id': 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'fabric': u'fabric-2', u'relay_vlan': None, u'external_dhcp': None, u'id': 5003, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/'}], u'class_type': None, u'name': u'fabric-2', u'resource_uri': u'/MAAS/api/2.0/fabrics/2/'}, {u'id': 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's3ns6m', u'fabric': u'pxe_admin', u'relay_vlan': None, u'external_dhcp': None, u'id': 5002, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/'}], u'class_type': u'', u'name': u'pxe_admin', u'resource_uri': u'/MAAS/api/2.0/fabrics/1/'}]
2020-01-05 02:33:37,285 [salt.loaded.ext.module.maasng:945 ][INFO    ][14682] [{u'class_type': None, 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'external_dhcp': None, u'relay_vlan': None, u'primary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/', u'id': 5001, u'secondary_rack': None, u'fabric': u'fabric-0'}], u'name': u'fabric-0', u'resource_uri': u'/MAAS/api/2.0/fabrics/0/', u'id': 0}, {u'class_type': None, 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'external_dhcp': None, u'relay_vlan': None, u'primary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/', u'id': 5003, u'secondary_rack': None, u'fabric': u'fabric-2'}], u'name': u'fabric-2', u'resource_uri': u'/MAAS/api/2.0/fabrics/2/', u'id': 2}, {u'class_type': u'', 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'external_dhcp': None, u'relay_vlan': None, u'primary_rack': u's3ns6m', u'resource_uri': u'/MAAS/api/2.0/vlans/5002/', u'id': 5002, u'secondary_rack': None, u'fabric': u'pxe_admin'}], u'name': u'pxe_admin', u'resource_uri': u'/MAAS/api/2.0/fabrics/1/', u'id': 1}]
2020-01-05 02:33:37,559 [salt.loaded.ext.module.maasng:945 ][INFO    ][14682] [{u'id': 0, u'vlans': [{u'fabric': u'fabric-0', u'vid': 0, u'space': u'undefined', u'dhcp_on': False, u'fabric_id': 0, u'name': u'untagged', u'primary_rack': None, u'relay_vlan': None, u'external_dhcp': None, u'mtu': 1500, u'id': 5001, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/'}], u'class_type': None, u'name': u'fabric-0', u'resource_uri': u'/MAAS/api/2.0/fabrics/0/'}, {u'id': 2, u'vlans': [{u'fabric': u'fabric-2', u'vid': 0, u'space': u'undefined', u'dhcp_on': False, u'fabric_id': 2, u'name': u'untagged', u'primary_rack': None, u'relay_vlan': None, u'external_dhcp': None, u'mtu': 1500, u'id': 5003, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/'}], u'class_type': None, u'name': u'fabric-2', u'resource_uri': u'/MAAS/api/2.0/fabrics/2/'}, {u'id': 1, u'vlans': [{u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'dhcp_on': False, u'fabric_id': 1, u'name': u'untagged', u'primary_rack': u's3ns6m', u'relay_vlan': None, u'external_dhcp': None, u'mtu': 1500, u'id': 5002, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/'}], u'class_type': u'', u'name': u'pxe_admin', u'resource_uri': u'/MAAS/api/2.0/fabrics/1/'}]
2020-01-05 02:33:37,672 [salt.state       :300 ][INFO    ][14682] {'new': 'Vlan untagged was updated'}
2020-01-05 02:33:37,673 [salt.state       :1951][INFO    ][14682] Completed state [vlan 0] at time 02:33:37.673061 duration_in_ms=546.249
2020-01-05 02:33:37,675 [salt.state       :1780][INFO    ][14682] Running state [opnfv] at time 02:33:37.675583
2020-01-05 02:33:37,676 [salt.state       :1813][INFO    ][14682] Executing state maasng.sshkey_present for [opnfv]
2020-01-05 02:33:37,720 [salt.loaded.ext.module.maasng:1903][INFO    ][14682] [{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-01-05 02:33:37,721 [salt.state       :300 ][INFO    ][14682] SSH key ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC74OvZ7y776Wj5A8gYoVsdCbbUonA1WMCs5kfze0DkD4BUfOiRckbCWpDsZ84y0q/A3tHj3u8/a9JnDyohIIAiswijSxajjvrLfPHa87S25OtoMcjousRMdy5O/WDRfSsgNJrbNYYytMurQMLHMKJHwSY8Z950wKP852g6WoQxv3Lhd7WrZgbPOLo2Y2J/ZywpakYaLeAJOaHe66ZX8b55yS1IL9oYVbrpD/ixBh+PaZrOjoGobYU82xY8RKfpfmTWLm/CO0BgrLk1vIKEVwfIxu+wleagZCUL/XHbO6owtVjXE3l9ZFGE3ZF/WyS4/CuXNomG+pHCQ91fcP3EGx6b already exist for user opnfv.
2020-01-05 02:33:37,722 [salt.state       :1951][INFO    ][14682] Completed state [opnfv] at time 02:33:37.722317 duration_in_ms=46.735
2020-01-05 02:33:37,727 [salt.minion      :1711][INFO    ][14682] Returning information for job: 20200105023306206798
2020-01-05 02:33:38,384 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command state.apply with jid 20200105023338373891
2020-01-05 02:33:38,407 [salt.minion      :1432][INFO    ][15104] Starting a new job with PID 15104
2020-01-05 02:33:45,148 [salt.state       :915 ][INFO    ][15104] Loading fresh modules for state activity
2020-01-05 02:33:45,212 [salt.fileclient  :1219][INFO    ][15104] Fetching file from saltenv 'base', ** done ** 'maas/machines/init.sls'
2020-01-05 02:33:45,261 [salt.state       :1780][INFO    ][15104] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 02:33:45.261655
2020-01-05 02:33:45,261 [salt.state       :1813][INFO    ][15104] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2020-01-05 02:33:45,263 [salt.loaded.int.module.cmdmod:395 ][INFO    ][15104] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2020-01-05 02:33:47,030 [salt.state       :300 ][INFO    ][15104] {'pid': 15134, 'retcode': 0, 'stderr': '', 'stdout': ''}
2020-01-05 02:33:47,031 [salt.state       :1951][INFO    ][15104] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 02:33:47.031332 duration_in_ms=1769.675
2020-01-05 02:33:47,035 [salt.state       :1780][INFO    ][15104] Running state [maas.process_machines] at time 02:33:47.035239
2020-01-05 02:33:47,035 [salt.state       :1813][INFO    ][15104] Executing state module.run for [maas.process_machines]
2020-01-05 02:33:47,038 [salt.utils.decorators:613 ][WARNING ][15104] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-01-05 02:33:47,098 [salt.loaded.ext.module.maas:412 ][WARNING ][15104] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2020-01-05 02:33:47,098 [salt.loaded.ext.module.maas:92  ][INFO    ][15104] 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-01-05 02:33:48,748 [salt.loaded.ext.module.maas:412 ][WARNING ][15104] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2020-01-05 02:33:48,748 [salt.loaded.ext.module.maas:92  ][INFO    ][15104] 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-01-05 02:33:50,158 [salt.loaded.ext.module.maas:412 ][WARNING ][15104] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2020-01-05 02:33:50,158 [salt.loaded.ext.module.maas:92  ][INFO    ][15104] 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-01-05 02:33:51,596 [salt.loaded.ext.module.maas:412 ][WARNING ][15104] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2020-01-05 02:33:51,596 [salt.loaded.ext.module.maas:92  ][INFO    ][15104] 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-01-05 02:33:52,970 [salt.loaded.ext.module.maas:412 ][WARNING ][15104] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2020-01-05 02:33:52,971 [salt.loaded.ext.module.maas:92  ][INFO    ][15104] 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-01-05 02:33:53,458 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105023353446036
2020-01-05 02:33:53,483 [salt.minion      :1432][INFO    ][15385] Starting a new job with PID 15385
2020-01-05 02:33:53,519 [salt.minion      :1711][INFO    ][15385] Returning information for job: 20200105023353446036
2020-01-05 02:33:54,484 [salt.state       :300 ][INFO    ][15104] {'ret': {'updated': [], 'errors': {}, 'success': ['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']}}
2020-01-05 02:33:54,487 [salt.state       :1951][INFO    ][15104] Completed state [maas.process_machines] at time 02:33:54.487427 duration_in_ms=7452.187
2020-01-05 02:33:54,490 [salt.minion      :1711][INFO    ][15104] Returning information for job: 20200105023338373891
2020-01-05 02:34:25,681 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command state.apply with jid 20200105023425672007
2020-01-05 02:34:25,708 [salt.minion      :1432][INFO    ][15454] Starting a new job with PID 15454
2020-01-05 02:34:32,863 [salt.state       :915 ][INFO    ][15454] Loading fresh modules for state activity
2020-01-05 02:34:32,924 [salt.fileclient  :1219][INFO    ][15454] Fetching file from saltenv 'base', ** done ** 'maas/machines/wait_for_ready_or_deployed.sls'
2020-01-05 02:34:32,975 [salt.state       :1780][INFO    ][15454] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 02:34:32.975650
2020-01-05 02:34:32,976 [salt.state       :1813][INFO    ][15454] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2020-01-05 02:34:32,977 [salt.loaded.int.module.cmdmod:395 ][INFO    ][15454] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2020-01-05 02:34:34,709 [salt.state       :300 ][INFO    ][15454] {'pid': 15487, 'retcode': 0, 'stderr': '', 'stdout': ''}
2020-01-05 02:34:34,710 [salt.state       :1951][INFO    ][15454] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 02:34:34.710671 duration_in_ms=1735.02
2020-01-05 02:34:34,714 [salt.state       :1780][INFO    ][15454] Running state [maas.wait_for_machine_status] at time 02:34:34.714543
2020-01-05 02:34:34,715 [salt.state       :1813][INFO    ][15454] Executing state module.run for [maas.wait_for_machine_status]
2020-01-05 02:34:34,716 [salt.utils.decorators:613 ][WARNING ][15454] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-01-05 02:34:35,560 [salt.loaded.ext.module.maas:1023][INFO    ][15454] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1499.16829896s left)
2020-01-05 02:34:40,716 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105023440705093
2020-01-05 02:34:40,747 [salt.minion      :1432][INFO    ][15498] Starting a new job with PID 15498
2020-01-05 02:34:40,772 [salt.minion      :1711][INFO    ][15498] Returning information for job: 20200105023440705093
2020-01-05 02:35:06,432 [salt.loaded.ext.module.maas:1023][INFO    ][15454] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1468.29622102s left)
2020-01-05 02:35:10,811 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105023510788422
2020-01-05 02:35:10,843 [salt.minion      :1432][INFO    ][15521] Starting a new job with PID 15521
2020-01-05 02:35:10,867 [salt.minion      :1711][INFO    ][15521] Returning information for job: 20200105023510788422
2020-01-05 02:35:37,175 [salt.loaded.ext.module.maas:1023][INFO    ][15454] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1437.55315995s left)
2020-01-05 02:35:40,934 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105023540919037
2020-01-05 02:35:40,961 [salt.minion      :1432][INFO    ][15576] Starting a new job with PID 15576
2020-01-05 02:35:40,982 [salt.minion      :1711][INFO    ][15576] Returning information for job: 20200105023540919037
2020-01-05 02:36:08,031 [salt.loaded.ext.module.maas:1023][INFO    ][15454] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1406.69713187s left)
2020-01-05 02:36:11,002 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105023610991481
2020-01-05 02:36:11,029 [salt.minion      :1432][INFO    ][15599] Starting a new job with PID 15599
2020-01-05 02:36:11,050 [salt.minion      :1711][INFO    ][15599] Returning information for job: 20200105023610991481
2020-01-05 02:36:39,122 [salt.loaded.ext.module.maas:1023][INFO    ][15454] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1375.60616684s left)
2020-01-05 02:36:41,094 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105023641082433
2020-01-05 02:36:41,113 [salt.minion      :1432][INFO    ][15680] Starting a new job with PID 15680
2020-01-05 02:36:41,137 [salt.minion      :1711][INFO    ][15680] Returning information for job: 20200105023641082433
2020-01-05 02:37:10,314 [salt.loaded.ext.module.maas:1023][INFO    ][15454] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1344.41405988s left)
2020-01-05 02:37:11,174 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105023711158574
2020-01-05 02:37:11,201 [salt.minion      :1432][INFO    ][15781] Starting a new job with PID 15781
2020-01-05 02:37:11,224 [salt.minion      :1711][INFO    ][15781] Returning information for job: 20200105023711158574
2020-01-05 02:37:41,315 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105023741295977
2020-01-05 02:37:41,341 [salt.minion      :1432][INFO    ][16038] Starting a new job with PID 16038
2020-01-05 02:37:41,367 [salt.minion      :1711][INFO    ][16038] Returning information for job: 20200105023741295977
2020-01-05 02:37:41,702 [salt.loaded.ext.module.maas:1023][INFO    ][15454] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1313.02673292s left)
2020-01-05 02:38:11,407 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105023811392406
2020-01-05 02:38:11,424 [salt.minion      :1432][INFO    ][16175] Starting a new job with PID 16175
2020-01-05 02:38:11,447 [salt.minion      :1711][INFO    ][16175] Returning information for job: 20200105023811392406
2020-01-05 02:38:13,222 [salt.loaded.ext.module.maas:1023][INFO    ][15454] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1281.506634s left)
2020-01-05 02:38:41,510 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105023841498098
2020-01-05 02:38:41,534 [salt.minion      :1432][INFO    ][16344] Starting a new job with PID 16344
2020-01-05 02:38:41,557 [salt.minion      :1711][INFO    ][16344] Returning information for job: 20200105023841498098
2020-01-05 02:38:45,268 [salt.loaded.ext.module.maas:1023][INFO    ][15454] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1249.46092987s left)
2020-01-05 02:39:11,632 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105023911616853
2020-01-05 02:39:11,660 [salt.minion      :1432][INFO    ][16533] Starting a new job with PID 16533
2020-01-05 02:39:11,684 [salt.minion      :1711][INFO    ][16533] Returning information for job: 20200105023911616853
2020-01-05 02:39:18,548 [salt.loaded.ext.module.maas:1023][INFO    ][15454] Waiting status:Ready|Deployed for machines:['cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1216.18101907s left)
2020-01-05 02:39:41,788 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105023941774357
2020-01-05 02:39:41,811 [salt.minion      :1432][INFO    ][16895] Starting a new job with PID 16895
2020-01-05 02:39:41,836 [salt.minion      :1711][INFO    ][16895] Returning information for job: 20200105023941774357
2020-01-05 02:39:50,820 [salt.loaded.ext.module.maas:1023][INFO    ][15454] Waiting status:Ready|Deployed for machines:['kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1183.90871191s left)
2020-01-05 02:40:11,911 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105024011893724
2020-01-05 02:40:11,941 [salt.minion      :1432][INFO    ][17042] Starting a new job with PID 17042
2020-01-05 02:40:11,963 [salt.minion      :1711][INFO    ][17042] Returning information for job: 20200105024011893724
2020-01-05 02:40:23,008 [salt.loaded.ext.module.maas:1023][INFO    ][15454] Waiting status:Ready|Deployed for machines:['kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1151.72023797s left)
2020-01-05 02:40:42,041 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105024042026336
2020-01-05 02:40:42,069 [salt.minion      :1432][INFO    ][17106] Starting a new job with PID 17106
2020-01-05 02:40:42,106 [salt.minion      :1711][INFO    ][17106] Returning information for job: 20200105024042026336
2020-01-05 02:40:55,620 [salt.loaded.ext.module.maas:1023][INFO    ][15454] Waiting status:Ready|Deployed for machines:['kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1119.10816884s left)
2020-01-05 02:41:12,199 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105024112185729
2020-01-05 02:41:12,225 [salt.minion      :1432][INFO    ][17220] Starting a new job with PID 17220
2020-01-05 02:41:12,260 [salt.minion      :1711][INFO    ][17220] Returning information for job: 20200105024112185729
2020-01-05 02:41:29,060 [salt.state       :300 ][INFO    ][15454] {'ret': True}
2020-01-05 02:41:29,060 [salt.state       :1951][INFO    ][15454] Completed state [maas.wait_for_machine_status] at time 02:41:29.060487 duration_in_ms=414345.944
2020-01-05 02:41:29,063 [salt.minion      :1711][INFO    ][15454] Returning information for job: 20200105023425672007
2020-01-05 02:41:29,776 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command state.apply with jid 20200105024129765249
2020-01-05 02:41:29,803 [salt.minion      :1432][INFO    ][17338] Starting a new job with PID 17338
2020-01-05 02:41:37,255 [salt.state       :915 ][INFO    ][17338] Loading fresh modules for state activity
2020-01-05 02:41:37,325 [salt.fileclient  :1219][INFO    ][17338] Fetching file from saltenv 'base', ** done ** 'maas/machines/storage.sls'
2020-01-05 02:41:37,450 [salt.state       :1780][INFO    ][17338] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 02:41:37.450524
2020-01-05 02:41:37,451 [salt.state       :1813][INFO    ][17338] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2020-01-05 02:41:37,454 [salt.loaded.int.module.cmdmod:395 ][INFO    ][17338] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2020-01-05 02:41:39,367 [salt.state       :300 ][INFO    ][17338] {'pid': 17359, 'retcode': 0, 'stderr': '', 'stdout': ''}
2020-01-05 02:41:39,368 [salt.state       :1951][INFO    ][17338] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 02:41:39.368033 duration_in_ms=1917.508
2020-01-05 02:41:39,372 [salt.state       :1780][INFO    ][17338] Running state [maas_machines_storage_cmp002_lvm] at time 02:41:39.372725
2020-01-05 02:41:39,373 [salt.state       :1813][INFO    ][17338] Executing state maasng.disk_layout_present for [maas_machines_storage_cmp002_lvm]
2020-01-05 02:41:40,531 [salt.loaded.ext.module.maasng:610 ][INFO    ][17338] bmtapp
2020-01-05 02:41:40,531 [salt.loaded.ext.module.maasng:626 ][INFO    ][17338] sda
2020-01-05 02:41:41,083 [salt.loaded.ext.module.maasng:361 ][INFO    ][17338] bmtapp
2020-01-05 02:41:41,188 [salt.loaded.ext.module.maasng:367 ][INFO    ][17338] [{u'size': 800109715456, u'partition_table_type': u'MBR', u'uuid': None, u'tags': [u'ssd'], u'used_for': u'MBR partitioned with 1 partition', u'used_size': 800106479616, u'partitions': [{u'size': 800101236736, u'uuid': u'14b9076e-ddfe-4d79-924a-c1283871eead', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'bmtapp', u'filesystem': {u'mount_options': None, u'label': None, u'mount_point': None, u'uuid': u'6213d484-2e8a-45dc-9542-c66b919cdc0e', u'fstype': u'lvm-pv'}, u'path': u'/dev/disk/by-dname/sda-part1', u'resource_uri': u'/MAAS/api/2.0/nodes/bmtapp/blockdevices/1/partition/1', u'type': u'partition', u'id': 1, u'device_id': 1}], u'id': 1, u'path': u'/dev/disk/by-dname/sda', u'system_id': u'bmtapp', u'resource_uri': u'/MAAS/api/2.0/nodes/bmtapp/blockdevices/1/', u'filesystem': None, u'id_path': u'/dev/disk/by-id/wwn-0x600508b1001cb19198eb9a66f8a29401', u'available_size': 0, u'serial': u'600508b1001cb19198eb9a66f8a29401', u'block_size': 4096, u'type': u'physical', u'model': u'LOGICAL VOLUME', u'name': u'sda'}, {u'size': 800097042432, u'partition_table_type': None, u'uuid': u'68788c18-8353-4b55-8c15-6560c975e446', u'tags': [], u'used_for': u'ext4 formatted filesystem mounted at /', u'used_size': 800097042432, u'partitions': [], u'id': 3, u'path': u'/dev/disk/by-dname/lvroot', u'system_id': u'bmtapp', u'resource_uri': u'/MAAS/api/2.0/nodes/bmtapp/blockdevices/3/', u'filesystem': {u'mount_options': None, u'label': u'root', u'mount_point': u'/', u'uuid': u'7dd70f08-b9e9-47a0-9e9c-40fceb9d8f72', u'fstype': u'ext4'}, u'id_path': None, u'available_size': 0, u'serial': None, u'block_size': 4096, u'type': u'virtual', u'model': None, u'name': u'vgroot-lvroot'}]
2020-01-05 02:41:41,189 [salt.loaded.ext.module.maasng:632 ][INFO    ][17338] vgroot
2020-01-05 02:41:41,190 [salt.loaded.ext.module.maasng:635 ][INFO    ][17338] lvroot
2020-01-05 02:41:41,190 [salt.loaded.ext.module.maasng:639 ][INFO    ][17338] 107374182400
2020-01-05 02:41:41,810 [salt.loaded.ext.module.maasng:645 ][INFO    ][17338] {u'domain': {u'resource_record_count': 0, u'name': u'maas', u'authoritative': True, u'ttl': None, u'id': 0, u'resource_uri': u'/MAAS/api/2.0/domains/0/'}, u'testing_status_name': u'Passed', u'ip_addresses': [u'192.168.11.38', u'192.168.11.40'], u'cpu_count': 40, u'power_type': u'ipmi', u'hwe_kernel': u'', u'boot_interface': {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's3ns6m', u'fabric': u'pxe_admin', u'relay_vlan': None, u'external_dhcp': None, u'id': 5002, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/'}, 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'mode': u'dhcp', u'id': 18}], 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's3ns6m', u'fabric': u'pxe_admin', u'relay_vlan': None, u'external_dhcp': None, u'id': 5002, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/'}, u'enabled': True, u'effective_mtu': 1500, u'children': [], u'discovered': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u's3ns6m', u'fabric': u'pxe_admin', u'relay_vlan': None, u'external_dhcp': None, u'id': 5002, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/'}, 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'system_id': u'bmtapp', u'params': u'', u'mac_address': u'9c:b6:54:8a:10:18', u'parents': [], u'type': u'physical', u'id': 4, u'resource_uri': u'/MAAS/api/2.0/nodes/bmtapp/interfaces/4/'}, u'fqdn': u'cmp002.maas', u'status_action': u'', u'tag_names': [], u'swap_size': None, u'owner': None, u'pod': None, u'cache_sets': [], u'cpu_test_status_name': u'Unknown', u'iscsiblockdevice_set': [], u'zone': {u'id': 1, u'description': u'', u'name': u'default', u'resource_uri': u'/MAAS/api/2.0/zones/default/'}, u'node_type_name': u'Machine', u'hostname': u'cmp002', u'storage': 800109.715456, u'testing_status': 2, u'system_id': u'bmtapp', u'power_state': u'off', u'memory': 65536, u'current_installation_result_id': None, u'default_gateways': {u'ipv4': {u'gateway_ip': u'192.168.11.3', u'link_id': None}, u'ipv6': {u'gateway_ip': None, u'link_id': None}}, u'status_message': u'Power state queried: off', u'virtualblockdevice_set': [{u'size': 107374182400, u'partition_table_type': None, u'uuid': u'71451dc4-2a5f-404f-b27f-b209099c9549', u'tags': [], u'used_for': u'ext4 formatted filesystem mounted at /', u'type': u'virtual', u'partitions': [], u'id': 11, u'path': u'/dev/disk/by-dname/vgroot-lvroot', u'system_id': u'bmtapp', u'resource_uri': u'/MAAS/api/2.0/nodes/bmtapp/blockdevices/11/', u'filesystem': {u'mount_options': None, u'label': u'root', u'mount_point': u'/', u'uuid': u'e09de046-c23a-4a07-bb99-0754e7e5acc2', u'fstype': u'ext4'}, u'id_path': None, u'available_size': 0, u'serial': None, u'block_size': 4096, u'used_size': 107374182400, u'model': None, u'name': u'vgroot-lvroot'}], u'blockdevice_set': [{u'size': 800109715456, u'partition_table_type': u'MBR', u'uuid': None, u'tags': [u'ssd'], u'used_for': u'MBR partitioned with 1 partition', u'used_size': 800106479616, u'partitions': [{u'size': 800101236736, u'uuid': u'c9b27488-ded1-4006-baaf-4c7161ce77a2', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'bmtapp', u'filesystem': {u'mount_options': None, u'label': None, u'mount_point': None, u'uuid': u'1c5170b7-8926-4c35-ad2a-50923974cf7e', u'fstype': u'lvm-pv'}, u'path': u'/dev/disk/by-dname/sda-part1', u'resource_uri': u'/MAAS/api/2.0/nodes/bmtapp/blockdevices/1/partition/6', u'type': u'partition', u'id': 6, u'device_id': 1}], u'id': 1, u'path': u'/dev/disk/by-dname/sda', u'system_id': u'bmtapp', u'resource_uri': u'/MAAS/api/2.0/nodes/bmtapp/blockdevices/1/', u'filesystem': None, u'id_path': u'/dev/disk/by-id/wwn-0x600508b1001cb19198eb9a66f8a29401', u'available_size': 0, u'serial': u'600508b1001cb19198eb9a66f8a29401', u'block_size': 4096, u'type': u'physical', u'model': u'LOGICAL VOLUME', u'name': u'sda'}, {u'size': 107374182400, u'partition_table_type': None, u'uuid': u'71451dc4-2a5f-404f-b27f-b209099c9549', u'tags': [], u'used_for': u'ext4 formatted filesystem mounted at /', u'used_size': 107374182400, u'partitions': [], u'id': 11, u'path': u'/dev/disk/by-dname/lvroot', u'system_id': u'bmtapp', u'resource_uri': u'/MAAS/api/2.0/nodes/bmtapp/blockdevices/11/', u'filesystem': {u'mount_options': None, u'label': u'root', u'mount_point': u'/', u'uuid': u'e09de046-c23a-4a07-bb99-0754e7e5acc2', u'fstype': u'ext4'}, u'id_path': None, u'available_size': 0, u'serial': None, u'block_size': 4096, u'type': u'virtual', u'model': None, u'name': u'vgroot-lvroot'}], u'status': 4, u'bcaches': [], u'storage_test_status_name': u'Passed', u'raids': [], u'owner_data': {}, u'memory_test_status_name': u'Unknown', u'other_test_status_name': u'Unknown', u'volume_groups': [{u'__incomplete__': True, u'system_id': u'bmtapp', u'id': 6}], u'special_filesystems': [], u'current_commissioning_result_id': 2, u'boot_disk': {u'size': 800109715456, u'partition_table_type': u'MBR', u'uuid': None, u'tags': [u'ssd'], u'used_for': u'MBR partitioned with 1 partition', u'type': u'physical', u'partitions': [{u'size': 800101236736, u'uuid': u'c9b27488-ded1-4006-baaf-4c7161ce77a2', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'bmtapp', u'filesystem': {u'mount_options': None, u'label': None, u'mount_point': None, u'uuid': u'1c5170b7-8926-4c35-ad2a-50923974cf7e', u'fstype': u'lvm-pv'}, u'path': u'/dev/disk/by-dname/sda-part1', u'resource_uri': u'/MAAS/api/2.0/nodes/bmtapp/blockdevices/1/partition/6', u'type': u'partition', u'id': 6, u'device_id': 1}], u'id': 1, u'path': u'/dev/disk/by-dname/sda', u'system_id': u'bmtapp', u'resource_uri': u'/MAAS/api/2.0/nodes/bmtapp/blockdevices/1/', u'filesystem': None, u'id_path': u'/dev/disk/by-id/wwn-0x600508b1001cb19198eb9a66f8a29401', u'available_size': 0, u'serial': u'600508b1001cb19198eb9a66f8a29401', u'block_size': 4096, u'used_size': 800106479616, u'model': u'LOGICAL VOLUME', u'name': u'sda'}, u'current_testing_result_id': 3, u'cpu_test_status': -1, u'architecture': u'amd64/generic', u'storage_test_status': 2, u'other_test_status': -1, u'status_name': u'Ready', u'physicalblockdevice_set': [{u'size': 800109715456, u'partition_table_type': u'MBR', u'uuid': None, u'tags': [u'ssd'], u'used_for': u'MBR partitioned with 1 partition', u'type': u'physical', u'partitions': [{u'size': 800101236736, u'uuid': u'c9b27488-ded1-4006-baaf-4c7161ce77a2', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'bmtapp', u'filesystem': {u'mount_options': None, u'label': None, u'mount_point': None, u'uuid': u'1c5170b7-8926-4c35-ad2a-50923974cf7e', u'fstype': u'lvm-pv'}, u'path': u'/dev/disk/by-dname/sda-part1', u'resource_uri': u'/MAAS/api/2.0/nodes/bmtapp/blockdevices/1/partition/6', u'type': u'partition', u'id': 6, u'device_id': 1}], u'id': 1, u'path': u'/dev/disk/by-dname/sda', u'system_id': u'bmtapp', u'resource_uri': u'/MAAS/api/2.0/nodes/bmtapp/blockdevices/1/', u'filesystem': None, u'id_path': u'/dev/disk/by-id/wwn-0x600508b1001cb19198eb9a66f8a29401', u'available_size': 0, u'serial': u'600508b1001cb19198eb9a66f8a29401', u'block_size': 4096, u'used_size': 800106479616, u'model': u'LOGICAL VOLUME', u'name': u'sda'}], u'netboot': True, u'osystem': u'', u'node_type': 0, u'disable_ipv4': False, u'commissioning_status': 2, u'min_hwe_kernel': u'ga-18.04', u'commissioning_status_name': u'Passed', u'interface_set': [{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's3ns6m', u'fabric': u'pxe_admin', u'relay_vlan': None, u'external_dhcp': None, u'id': 5002, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/'}, 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'mode': u'dhcp', u'id': 18}], 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's3ns6m', u'fabric': u'pxe_admin', u'relay_vlan': None, u'external_dhcp': None, u'id': 5002, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/'}, u'enabled': True, u'effective_mtu': 1500, u'children': [], u'discovered': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u's3ns6m', u'fabric': u'pxe_admin', u'relay_vlan': None, u'external_dhcp': None, u'id': 5002, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/'}, 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'system_id': u'bmtapp', u'params': u'', u'mac_address': u'9c:b6:54:8a:10:18', u'parents': [], u'type': u'physical', u'id': 4, u'resource_uri': u'/MAAS/api/2.0/nodes/bmtapp/interfaces/4/'}, {u'name': u'ens1f1', u'links': [], u'tags': [u'sriov'], u'vlan': None, u'enabled': True, u'effective_mtu': 1500, u'children': [], u'discovered': None, u'system_id': u'bmtapp', u'params': u'', u'mac_address': u'38:ea:a7:8f:07:51', u'parents': [], u'type': u'physical', u'id': 12, u'resource_uri': u'/MAAS/api/2.0/nodes/bmtapp/interfaces/12/'}, {u'name': u'ens1f0', u'links': [], u'tags': [u'sriov'], u'vlan': None, u'enabled': True, u'effective_mtu': 1500, u'children': [], u'discovered': None, u'system_id': u'bmtapp', u'params': u'', u'mac_address': u'38:ea:a7:8f:07:50', u'parents': [], u'type': u'physical', u'id': 13, u'resource_uri': u'/MAAS/api/2.0/nodes/bmtapp/interfaces/13/'}, {u'name': u'ens2f1', u'links': [{u'mode': u'link_up', u'id': 19}], 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'fabric': u'fabric-0', u'relay_vlan': None, u'external_dhcp': None, u'id': 5001, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/'}, u'enabled': True, u'effective_mtu': 1500, u'children': [], u'discovered': None, u'system_id': u'bmtapp', u'params': u'', u'mac_address': u'38:ea:a7:8f:12:49', u'parents': [], u'type': u'physical', u'id': 11, u'resource_uri': u'/MAAS/api/2.0/nodes/bmtapp/interfaces/11/'}, {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's3ns6m', u'fabric': u'pxe_admin', u'relay_vlan': None, u'external_dhcp': None, u'id': 5002, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/'}, 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'mode': u'link_up', u'id': 20}], 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's3ns6m', u'fabric': u'pxe_admin', u'relay_vlan': None, u'external_dhcp': None, u'id': 5002, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/'}, u'enabled': True, u'effective_mtu': 1500, u'children': [], u'discovered': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u's3ns6m', u'fabric': u'pxe_admin', u'relay_vlan': None, u'external_dhcp': None, u'id': 5002, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/'}, 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'system_id': u'bmtapp', u'params': u'', u'mac_address': u'9c:b6:54:8a:10:1c', u'parents': [], u'type': u'physical', u'id': 14, u'resource_uri': u'/MAAS/api/2.0/nodes/bmtapp/interfaces/14/'}, {u'name': u'ens2f0', u'links': [{u'mode': u'link_up', u'id': 21}], 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'fabric': u'fabric-0', u'relay_vlan': None, u'external_dhcp': None, u'id': 5001, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/'}, u'enabled': True, u'effective_mtu': 1500, u'children': [], u'discovered': None, u'system_id': u'bmtapp', u'params': u'', u'mac_address': u'38:ea:a7:8f:12:48', u'parents': [], u'type': u'physical', u'id': 15, u'resource_uri': u'/MAAS/api/2.0/nodes/bmtapp/interfaces/15/'}], u'address_ttl': None, u'memory_test_status': -1, u'distro_series': u'', u'resource_uri': u'/MAAS/api/2.0/machines/bmtapp/'}
2020-01-05 02:41:41,812 [salt.state       :300 ][INFO    ][17338] {'new': {'storage_layout': 'lvm'}}
2020-01-05 02:41:41,814 [salt.state       :1951][INFO    ][17338] Completed state [maas_machines_storage_cmp002_lvm] at time 02:41:41.813206 duration_in_ms=2440.48
2020-01-05 02:41:41,815 [salt.state       :1780][INFO    ][17338] Running state [maas_machines_storage_cmp001_lvm] at time 02:41:41.815147
2020-01-05 02:41:41,815 [salt.state       :1813][INFO    ][17338] Executing state maasng.disk_layout_present for [maas_machines_storage_cmp001_lvm]
2020-01-05 02:41:42,948 [salt.loaded.ext.module.maasng:610 ][INFO    ][17338] p4qf7c
2020-01-05 02:41:42,949 [salt.loaded.ext.module.maasng:626 ][INFO    ][17338] sda
2020-01-05 02:41:43,477 [salt.loaded.ext.module.maasng:361 ][INFO    ][17338] p4qf7c
2020-01-05 02:41:43,570 [salt.loaded.ext.module.maasng:367 ][INFO    ][17338] [{u'size': 800109715456, u'available_size': 0, u'uuid': None, u'tags': [u'ssd'], u'used_for': u'MBR partitioned with 1 partition', u'type': u'physical', u'partitions': [{u'uuid': u'c9e0993c-5721-4fae-bb2d-d9417df4367e', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'p4qf7c', u'device_id': 2, u'filesystem': {u'label': None, u'mount_point': None, u'mount_options': None, u'fstype': u'lvm-pv', u'uuid': u'ef4b4b23-2283-487b-95ba-c85d19555798'}, u'path': u'/dev/disk/by-dname/sda-part1', u'size': 800101236736, u'type': u'partition', u'id': 2, u'resource_uri': u'/MAAS/api/2.0/nodes/p4qf7c/blockdevices/2/partition/2'}], u'name': u'sda', u'system_id': u'p4qf7c', 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'resource_uri': u'/MAAS/api/2.0/nodes/p4qf7c/blockdevices/2/'}, {u'size': 800097042432, u'available_size': 0, u'uuid': u'7f8bf604-7866-413f-9f03-794b2239caeb', u'tags': [], u'used_for': u'ext4 formatted filesystem mounted at /', u'type': u'virtual', u'partitions': [], u'name': u'vgroot-lvroot', u'system_id': u'p4qf7c', u'partition_table_type': None, u'filesystem': {u'label': u'root', u'mount_point': u'/', u'mount_options': None, u'fstype': u'ext4', u'uuid': u'7930932f-4a40-4d2d-a4f4-02ebc4648ea3'}, 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': 4, u'serial': None, u'resource_uri': u'/MAAS/api/2.0/nodes/p4qf7c/blockdevices/4/'}]
2020-01-05 02:41:43,571 [salt.loaded.ext.module.maasng:632 ][INFO    ][17338] vgroot
2020-01-05 02:41:43,571 [salt.loaded.ext.module.maasng:635 ][INFO    ][17338] lvroot
2020-01-05 02:41:43,571 [salt.loaded.ext.module.maasng:639 ][INFO    ][17338] 107374182400
2020-01-05 02:41:44,215 [salt.loaded.ext.module.maasng:645 ][INFO    ][17338] {u'domain': {u'resource_record_count': 0, u'name': u'maas', u'authoritative': True, u'ttl': None, u'id': 0, u'resource_uri': u'/MAAS/api/2.0/domains/0/'}, u'testing_status_name': u'Passed', u'disable_ipv4': False, u'storage_test_status_name': u'Passed', u'power_type': u'ipmi', u'hwe_kernel': u'', u'memory_test_status_name': u'Unknown', u'min_hwe_kernel': u'ga-18.04', u'status_action': u'', u'tag_names': [], u'swap_size': None, 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'available_size': 0, u'uuid': None, u'name': u'sda', u'tags': [u'ssd'], u'type': u'physical', u'partitions': [{u'uuid': u'1c53f2f0-7e0e-4510-b556-3de981f0e5f6', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'p4qf7c', u'device_id': 2, u'filesystem': {u'label': None, u'mount_point': None, u'mount_options': None, u'fstype': u'lvm-pv', u'uuid': u'f2b16f7b-3c4e-4be4-bfa6-48dfc9f3e9b6'}, u'path': u'/dev/disk/by-dname/sda-part1', u'size': 800101236736, u'type': u'partition', u'id': 7, u'resource_uri': u'/MAAS/api/2.0/nodes/p4qf7c/blockdevices/2/partition/7'}], u'used_for': u'MBR partitioned with 1 partition', u'system_id': u'p4qf7c', 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'resource_uri': u'/MAAS/api/2.0/nodes/p4qf7c/blockdevices/2/'}, u'zone': {u'id': 1, u'description': u'', u'name': u'default', u'resource_uri': u'/MAAS/api/2.0/zones/default/'}, u'node_type_name': u'Machine', u'hostname': u'cmp001', u'storage': 800109.715456, u'testing_status': 2, u'system_id': u'p4qf7c', u'raids': [], u'memory': 65536, u'current_installation_result_id': None, u'default_gateways': {u'ipv4': {u'gateway_ip': u'192.168.11.3', u'link_id': None}, u'ipv6': {u'gateway_ip': None, u'link_id': None}}, u'status_message': u'Power state queried: off', u'ip_addresses': [u'192.168.11.39', u'192.168.11.44'], u'blockdevice_set': [{u'size': 800109715456, u'available_size': 0, u'uuid': None, u'tags': [u'ssd'], u'used_for': u'MBR partitioned with 1 partition', u'type': u'physical', u'partitions': [{u'uuid': u'1c53f2f0-7e0e-4510-b556-3de981f0e5f6', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'p4qf7c', u'device_id': 2, u'filesystem': {u'label': None, u'mount_point': None, u'mount_options': None, u'fstype': u'lvm-pv', u'uuid': u'f2b16f7b-3c4e-4be4-bfa6-48dfc9f3e9b6'}, u'path': u'/dev/disk/by-dname/sda-part1', u'size': 800101236736, u'type': u'partition', u'id': 7, u'resource_uri': u'/MAAS/api/2.0/nodes/p4qf7c/blockdevices/2/partition/7'}], u'name': u'sda', u'system_id': u'p4qf7c', 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'resource_uri': u'/MAAS/api/2.0/nodes/p4qf7c/blockdevices/2/'}, {u'size': 107374182400, u'available_size': 0, u'uuid': u'06e0574d-5bed-490b-8ec4-042775bd6c5c', u'tags': [], u'used_for': u'ext4 formatted filesystem mounted at /', u'type': u'virtual', u'partitions': [], u'name': u'vgroot-lvroot', u'system_id': u'p4qf7c', u'partition_table_type': None, u'filesystem': {u'label': u'root', u'mount_point': u'/', u'mount_options': None, u'fstype': u'ext4', u'uuid': u'ac8c63ba-e5cf-417d-b524-e78e5fa3dca2'}, 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': 12, u'serial': None, u'resource_uri': u'/MAAS/api/2.0/nodes/p4qf7c/blockdevices/12/'}], u'status': 4, u'bcaches': [], 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'p4qf7c', 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'storage_test_status': 2, u'other_test_status': -1, u'status_name': u'Ready', u'physicalblockdevice_set': [{u'size': 800109715456, u'available_size': 0, u'uuid': None, u'name': u'sda', u'tags': [u'ssd'], u'type': u'physical', u'partitions': [{u'uuid': u'1c53f2f0-7e0e-4510-b556-3de981f0e5f6', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'p4qf7c', u'device_id': 2, u'filesystem': {u'label': None, u'mount_point': None, u'mount_options': None, u'fstype': u'lvm-pv', u'uuid': u'f2b16f7b-3c4e-4be4-bfa6-48dfc9f3e9b6'}, u'path': u'/dev/disk/by-dname/sda-part1', u'size': 800101236736, u'type': u'partition', u'id': 7, u'resource_uri': u'/MAAS/api/2.0/nodes/p4qf7c/blockdevices/2/partition/7'}], u'used_for': u'MBR partitioned with 1 partition', u'system_id': u'p4qf7c', 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'resource_uri': u'/MAAS/api/2.0/nodes/p4qf7c/blockdevices/2/'}], u'netboot': True, u'osystem': u'', u'fqdn': u'cmp001.maas', u'node_type': 0, u'virtualblockdevice_set': [{u'size': 107374182400, u'available_size': 0, u'uuid': u'06e0574d-5bed-490b-8ec4-042775bd6c5c', u'name': u'vgroot-lvroot', u'tags': [], u'type': u'virtual', u'partitions': [], u'used_for': u'ext4 formatted filesystem mounted at /', u'system_id': u'p4qf7c', u'partition_table_type': None, u'filesystem': {u'label': u'root', u'mount_point': u'/', u'mount_options': None, u'fstype': u'ext4', u'uuid': u'ac8c63ba-e5cf-417d-b524-e78e5fa3dca2'}, 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': 12, u'serial': None, u'resource_uri': u'/MAAS/api/2.0/nodes/p4qf7c/blockdevices/12/'}], u'commissioning_status': 2, u'architecture': u'amd64/generic', u'boot_interface': {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'dhcp_on': True, u'fabric_id': 1, u'mtu': 1500, u'primary_rack': u's3ns6m', u'relay_vlan': None, u'external_dhcp': None, u'name': u'untagged', u'id': 5002, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/'}, 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'mode': u'dhcp', u'id': 25}], u'tags': [u'sriov'], u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'dhcp_on': True, u'fabric_id': 1, u'mtu': 1500, u'primary_rack': u's3ns6m', u'relay_vlan': None, u'external_dhcp': None, u'name': u'untagged', u'id': 5002, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/'}, u'enabled': True, u'effective_mtu': 1500, u'children': [], u'discovered': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'dhcp_on': True, u'fabric_id': 1, u'mtu': 1500, u'primary_rack': u's3ns6m', u'relay_vlan': None, u'external_dhcp': None, u'name': u'untagged', u'id': 5002, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/'}, 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'parents': [], u'mac_address': u'9c:b6:54:8a:95:a0', u'params': u'', u'system_id': u'p4qf7c', u'type': u'physical', u'id': 5, u'resource_uri': u'/MAAS/api/2.0/nodes/p4qf7c/interfaces/5/'}, u'interface_set': [{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'dhcp_on': True, u'fabric_id': 1, u'mtu': 1500, u'primary_rack': u's3ns6m', u'relay_vlan': None, u'external_dhcp': None, u'name': u'untagged', u'id': 5002, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/'}, 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'mode': u'dhcp', u'id': 25}], u'tags': [u'sriov'], u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'dhcp_on': True, u'fabric_id': 1, u'mtu': 1500, u'primary_rack': u's3ns6m', u'relay_vlan': None, u'external_dhcp': None, u'name': u'untagged', u'id': 5002, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/'}, u'enabled': True, u'effective_mtu': 1500, u'children': [], u'discovered': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'dhcp_on': True, u'fabric_id': 1, u'mtu': 1500, u'primary_rack': u's3ns6m', u'relay_vlan': None, u'external_dhcp': None, u'name': u'untagged', u'id': 5002, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/'}, 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'parents': [], u'mac_address': u'9c:b6:54:8a:95:a0', u'params': u'', u'system_id': u'p4qf7c', u'type': u'physical', u'id': 5, u'resource_uri': u'/MAAS/api/2.0/nodes/p4qf7c/interfaces/5/'}, {u'name': u'ens1f1', u'links': [], u'tags': [u'sriov'], u'vlan': None, u'enabled': True, u'effective_mtu': 1500, u'children': [], u'discovered': None, u'parents': [], u'mac_address': u'38:ea:a7:8f:1f:d5', u'params': u'', u'system_id': u'p4qf7c', u'type': u'physical', u'id': 17, u'resource_uri': u'/MAAS/api/2.0/nodes/p4qf7c/interfaces/17/'}, {u'name': u'ens1f0', u'links': [], u'tags': [u'sriov'], u'vlan': None, u'enabled': True, u'effective_mtu': 1500, u'children': [], u'discovered': None, u'parents': [], u'mac_address': u'38:ea:a7:8f:1f:d4', u'params': u'', u'system_id': u'p4qf7c', u'type': u'physical', u'id': 18, u'resource_uri': u'/MAAS/api/2.0/nodes/p4qf7c/interfaces/18/'}, {u'name': u'ens2f1', u'links': [{u'mode': u'link_up', u'id': 26}], u'tags': [u'sriov'], u'vlan': {u'fabric': u'fabric-0', u'vid': 0, u'space': u'undefined', u'dhcp_on': False, u'fabric_id': 0, u'mtu': 1500, u'primary_rack': None, u'relay_vlan': None, u'external_dhcp': None, u'name': u'untagged', u'id': 5001, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/'}, u'enabled': True, u'effective_mtu': 1500, u'children': [], u'discovered': None, u'parents': [], u'mac_address': u'38:ea:a7:8f:52:cd', u'params': u'', u'system_id': u'p4qf7c', u'type': u'physical', u'id': 16, u'resource_uri': u'/MAAS/api/2.0/nodes/p4qf7c/interfaces/16/'}, {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'dhcp_on': True, u'fabric_id': 1, u'mtu': 1500, u'primary_rack': u's3ns6m', u'relay_vlan': None, u'external_dhcp': None, u'name': u'untagged', u'id': 5002, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/'}, 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'mode': u'link_up', u'id': 27}], u'tags': [u'sriov'], u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'dhcp_on': True, u'fabric_id': 1, u'mtu': 1500, u'primary_rack': u's3ns6m', u'relay_vlan': None, u'external_dhcp': None, u'name': u'untagged', u'id': 5002, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/'}, u'enabled': True, u'effective_mtu': 1500, u'children': [], u'discovered': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'dhcp_on': True, u'fabric_id': 1, u'mtu': 1500, u'primary_rack': u's3ns6m', u'relay_vlan': None, u'external_dhcp': None, u'name': u'untagged', u'id': 5002, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/'}, 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'parents': [], u'mac_address': u'9c:b6:54:8a:95:a4', u'params': u'', u'system_id': u'p4qf7c', u'type': u'physical', u'id': 19, u'resource_uri': u'/MAAS/api/2.0/nodes/p4qf7c/interfaces/19/'}, {u'name': u'ens2f0', u'links': [{u'mode': u'link_up', u'id': 28}], u'tags': [u'sriov'], u'vlan': {u'fabric': u'fabric-0', u'vid': 0, u'space': u'undefined', u'dhcp_on': False, u'fabric_id': 0, u'mtu': 1500, u'primary_rack': None, u'relay_vlan': None, u'external_dhcp': None, u'name': u'untagged', u'id': 5001, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/'}, u'enabled': True, u'effective_mtu': 1500, u'children': [], u'discovered': None, u'parents': [], u'mac_address': u'38:ea:a7:8f:52:cc', u'params': u'', u'system_id': u'p4qf7c', u'type': u'physical', u'id': 20, u'resource_uri': u'/MAAS/api/2.0/nodes/p4qf7c/interfaces/20/'}], u'address_ttl': None, u'memory_test_status': -1, u'distro_series': u'', u'resource_uri': u'/MAAS/api/2.0/machines/p4qf7c/'}
2020-01-05 02:41:44,217 [salt.state       :300 ][INFO    ][17338] {'new': {'storage_layout': 'lvm'}}
2020-01-05 02:41:44,218 [salt.state       :1951][INFO    ][17338] Completed state [maas_machines_storage_cmp001_lvm] at time 02:41:44.218159 duration_in_ms=2403.01
2020-01-05 02:41:44,223 [salt.minion      :1711][INFO    ][17338] Returning information for job: 20200105024129765249
2020-01-05 02:41:44,907 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command state.apply with jid 20200105024144894649
2020-01-05 02:41:44,932 [salt.minion      :1432][INFO    ][17400] Starting a new job with PID 17400
2020-01-05 02:41:46,267 [salt.state       :915 ][INFO    ][17400] Loading fresh modules for state activity
2020-01-05 02:41:46,332 [salt.fileclient  :1219][INFO    ][17400] Fetching file from saltenv 'base', ** done ** 'maas/machines/deploy.sls'
2020-01-05 02:41:46,388 [salt.state       :1780][INFO    ][17400] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 02:41:46.387868
2020-01-05 02:41:46,388 [salt.state       :1813][INFO    ][17400] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2020-01-05 02:41:46,391 [salt.loaded.int.module.cmdmod:395 ][INFO    ][17400] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2020-01-05 02:41:48,227 [salt.state       :300 ][INFO    ][17400] {'pid': 17407, 'retcode': 0, 'stderr': '', 'stdout': ''}
2020-01-05 02:41:48,228 [salt.state       :1951][INFO    ][17400] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 02:41:48.228302 duration_in_ms=1840.435
2020-01-05 02:41:48,231 [salt.state       :1780][INFO    ][17400] Running state [maas.deploy_machines] at time 02:41:48.231633
2020-01-05 02:41:48,232 [salt.state       :1813][INFO    ][17400] Executing state module.run for [maas.deploy_machines]
2020-01-05 02:41:48,234 [salt.utils.decorators:613 ][WARNING ][17400] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-01-05 02:41:48,829 [salt.loaded.ext.module.maas:684 ][INFO    ][17400] deploymachines hwe_kernel=ga-18.04 system_id=bmtapp distro_series=bionic
2020-01-05 02:41:51,345 [salt.loaded.ext.module.maas:684 ][INFO    ][17400] deploymachines hwe_kernel=ga-18.04 system_id=p4qf7c distro_series=bionic
2020-01-05 02:41:53,783 [salt.loaded.ext.module.maas:684 ][INFO    ][17400] deploymachines hwe_kernel=ga-18.04 system_id=xcgnsq distro_series=bionic
2020-01-05 02:41:56,265 [salt.loaded.ext.module.maas:684 ][INFO    ][17400] deploymachines hwe_kernel=ga-18.04 system_id=gg4kya distro_series=bionic
2020-01-05 02:41:58,721 [salt.loaded.ext.module.maas:684 ][INFO    ][17400] deploymachines hwe_kernel=ga-18.04 system_id=wq4aqt distro_series=bionic
2020-01-05 02:42:00,019 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105024200000841
2020-01-05 02:42:00,047 [salt.minion      :1432][INFO    ][17675] Starting a new job with PID 17675
2020-01-05 02:42:00,085 [salt.minion      :1711][INFO    ][17675] Returning information for job: 20200105024200000841
2020-01-05 02:42:01,262 [salt.state       :300 ][INFO    ][17400] {'ret': {'updated': [], 'errors': {}, 'success': ['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']}}
2020-01-05 02:42:01,262 [salt.state       :1951][INFO    ][17400] Completed state [maas.deploy_machines] at time 02:42:01.262693 duration_in_ms=13031.058
2020-01-05 02:42:01,268 [salt.minion      :1711][INFO    ][17400] Returning information for job: 20200105024144894649
2020-01-05 02:42:01,956 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command state.apply with jid 20200105024201941709
2020-01-05 02:42:01,985 [salt.minion      :1432][INFO    ][17693] Starting a new job with PID 17693
2020-01-05 02:42:08,476 [salt.state       :915 ][INFO    ][17693] Loading fresh modules for state activity
2020-01-05 02:42:08,540 [salt.fileclient  :1219][INFO    ][17693] Fetching file from saltenv 'base', ** done ** 'maas/machines/wait_for_deployed.sls'
2020-01-05 02:42:08,589 [salt.state       :1780][INFO    ][17693] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 02:42:08.589205
2020-01-05 02:42:08,589 [salt.state       :1813][INFO    ][17693] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2020-01-05 02:42:08,591 [salt.loaded.int.module.cmdmod:395 ][INFO    ][17693] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2020-01-05 02:42:10,435 [salt.state       :300 ][INFO    ][17693] {'pid': 17706, 'retcode': 0, 'stderr': '', 'stdout': ''}
2020-01-05 02:42:10,435 [salt.state       :1951][INFO    ][17693] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 02:42:10.435627 duration_in_ms=1846.423
2020-01-05 02:42:10,438 [salt.state       :1780][INFO    ][17693] Running state [maas.wait_for_machine_status] at time 02:42:10.438635
2020-01-05 02:42:10,439 [salt.state       :1813][INFO    ][17693] Executing state module.run for [maas.wait_for_machine_status]
2020-01-05 02:42:10,439 [salt.utils.decorators:613 ][WARNING ][17693] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-01-05 02:42:13,400 [salt.loaded.ext.module.maas:1023][INFO    ][17693] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2247.05563092s left)
2020-01-05 02:42:16,996 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105024216980823
2020-01-05 02:42:17,024 [salt.minion      :1432][INFO    ][17728] Starting a new job with PID 17728
2020-01-05 02:42:17,052 [salt.minion      :1711][INFO    ][17728] Returning information for job: 20200105024216980823
2020-01-05 02:42:46,371 [salt.loaded.ext.module.maas:1023][INFO    ][17693] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2214.08449793s left)
2020-01-05 02:42:47,083 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105024247073201
2020-01-05 02:42:47,110 [salt.minion      :1432][INFO    ][17767] Starting a new job with PID 17767
2020-01-05 02:42:47,143 [salt.minion      :1711][INFO    ][17767] Returning information for job: 20200105024247073201
2020-01-05 02:43:17,152 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105024317144442
2020-01-05 02:43:17,170 [salt.minion      :1432][INFO    ][17797] Starting a new job with PID 17797
2020-01-05 02:43:17,198 [salt.minion      :1711][INFO    ][17797] Returning information for job: 20200105024317144442
2020-01-05 02:43:19,331 [salt.loaded.ext.module.maas:1023][INFO    ][17693] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2181.12469506s left)
2020-01-05 02:43:47,237 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105024347223286
2020-01-05 02:43:47,267 [salt.minion      :1432][INFO    ][17834] Starting a new job with PID 17834
2020-01-05 02:43:47,296 [salt.minion      :1711][INFO    ][17834] Returning information for job: 20200105024347223286
2020-01-05 02:43:52,474 [salt.loaded.ext.module.maas:1023][INFO    ][17693] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2147.98209596s left)
2020-01-05 02:44:17,336 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105024417323317
2020-01-05 02:44:17,366 [salt.minion      :1432][INFO    ][17866] Starting a new job with PID 17866
2020-01-05 02:44:17,398 [salt.minion      :1711][INFO    ][17866] Returning information for job: 20200105024417323317
2020-01-05 02:44:25,320 [salt.loaded.ext.module.maas:1023][INFO    ][17693] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2115.13566399s left)
2020-01-05 02:44:47,408 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105024447392147
2020-01-05 02:44:47,438 [salt.minion      :1432][INFO    ][17928] Starting a new job with PID 17928
2020-01-05 02:44:47,472 [salt.minion      :1711][INFO    ][17928] Returning information for job: 20200105024447392147
2020-01-05 02:44:58,243 [salt.loaded.ext.module.maas:1023][INFO    ][17693] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2082.21501589s left)
2020-01-05 02:45:17,499 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105024517482480
2020-01-05 02:45:17,520 [salt.minion      :1432][INFO    ][18025] Starting a new job with PID 18025
2020-01-05 02:45:17,551 [salt.minion      :1711][INFO    ][18025] Returning information for job: 20200105024517482480
2020-01-05 02:45:31,481 [salt.loaded.ext.module.maas:1023][INFO    ][17693] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2048.97515702s left)
2020-01-05 02:45:47,619 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105024547608350
2020-01-05 02:45:47,648 [salt.minion      :1432][INFO    ][18247] Starting a new job with PID 18247
2020-01-05 02:45:47,679 [salt.minion      :1711][INFO    ][18247] Returning information for job: 20200105024547608350
2020-01-05 02:46:04,540 [salt.loaded.ext.module.maas:1023][INFO    ][17693] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2015.91554809s left)
2020-01-05 02:46:17,712 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105024617695488
2020-01-05 02:46:17,735 [salt.minion      :1432][INFO    ][18400] Starting a new job with PID 18400
2020-01-05 02:46:17,771 [salt.minion      :1711][INFO    ][18400] Returning information for job: 20200105024617695488
2020-01-05 02:46:37,556 [salt.loaded.ext.module.maas:1023][INFO    ][17693] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1982.89965606s left)
2020-01-05 02:46:47,843 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105024647828911
2020-01-05 02:46:47,869 [salt.minion      :1432][INFO    ][18573] Starting a new job with PID 18573
2020-01-05 02:46:47,924 [salt.minion      :1711][INFO    ][18573] Returning information for job: 20200105024647828911
2020-01-05 02:47:10,510 [salt.loaded.ext.module.maas:1023][INFO    ][17693] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1949.94587803s left)
2020-01-05 02:47:18,006 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105024717991997
2020-01-05 02:47:18,031 [salt.minion      :1432][INFO    ][18722] Starting a new job with PID 18722
2020-01-05 02:47:18,066 [salt.minion      :1711][INFO    ][18722] Returning information for job: 20200105024717991997
2020-01-05 02:47:43,604 [salt.loaded.ext.module.maas:1023][INFO    ][17693] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1916.85224104s left)
2020-01-05 02:47:48,191 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105024748182168
2020-01-05 02:47:48,218 [salt.minion      :1432][INFO    ][19132] Starting a new job with PID 19132
2020-01-05 02:47:48,254 [salt.minion      :1711][INFO    ][19132] Returning information for job: 20200105024748182168
2020-01-05 02:48:16,559 [salt.loaded.ext.module.maas:1023][INFO    ][17693] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1883.8966639s left)
2020-01-05 02:48:18,338 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105024818324141
2020-01-05 02:48:18,369 [salt.minion      :1432][INFO    ][19269] Starting a new job with PID 19269
2020-01-05 02:48:18,401 [salt.minion      :1711][INFO    ][19269] Returning information for job: 20200105024818324141
2020-01-05 02:48:48,504 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105024848493166
2020-01-05 02:48:48,528 [salt.minion      :1432][INFO    ][19492] Starting a new job with PID 19492
2020-01-05 02:48:48,561 [salt.minion      :1711][INFO    ][19492] Returning information for job: 20200105024848493166
2020-01-05 02:48:49,632 [salt.loaded.ext.module.maas:1023][INFO    ][17693] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1850.82420897s left)
2020-01-05 02:49:18,658 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105024918643173
2020-01-05 02:49:18,685 [salt.minion      :1432][INFO    ][19578] Starting a new job with PID 19578
2020-01-05 02:49:18,715 [salt.minion      :1711][INFO    ][19578] Returning information for job: 20200105024918643173
2020-01-05 02:49:22,641 [salt.loaded.ext.module.maas:1023][INFO    ][17693] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1817.81521201s left)
2020-01-05 02:49:48,825 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105024948813395
2020-01-05 02:49:48,849 [salt.minion      :1432][INFO    ][19782] Starting a new job with PID 19782
2020-01-05 02:49:48,879 [salt.minion      :1711][INFO    ][19782] Returning information for job: 20200105024948813395
2020-01-05 02:49:55,690 [salt.loaded.ext.module.maas:1023][INFO    ][17693] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1784.76568007s left)
2020-01-05 02:50:18,984 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105025018974251
2020-01-05 02:50:19,010 [salt.minion      :1432][INFO    ][19926] Starting a new job with PID 19926
2020-01-05 02:50:19,041 [salt.minion      :1711][INFO    ][19926] Returning information for job: 20200105025018974251
2020-01-05 02:50:29,292 [salt.loaded.ext.module.maas:1023][INFO    ][17693] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1751.16398287s left)
2020-01-05 02:50:49,187 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105025049175295
2020-01-05 02:50:49,216 [salt.minion      :1432][INFO    ][20160] Starting a new job with PID 20160
2020-01-05 02:50:49,244 [salt.minion      :1711][INFO    ][20160] Returning information for job: 20200105025049175295
2020-01-05 02:51:02,271 [salt.loaded.ext.module.maas:1023][INFO    ][17693] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1718.18513799s left)
2020-01-05 02:51:19,368 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105025119353855
2020-01-05 02:51:19,397 [salt.minion      :1432][INFO    ][20308] Starting a new job with PID 20308
2020-01-05 02:51:19,431 [salt.minion      :1711][INFO    ][20308] Returning information for job: 20200105025119353855
2020-01-05 02:51:35,292 [salt.loaded.ext.module.maas:1023][INFO    ][17693] Waiting status:Deployed for machines:['cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1685.16430593s left)
2020-01-05 02:51:49,447 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105025149435941
2020-01-05 02:51:49,473 [salt.minion      :1432][INFO    ][20443] Starting a new job with PID 20443
2020-01-05 02:51:49,511 [salt.minion      :1711][INFO    ][20443] Returning information for job: 20200105025149435941
2020-01-05 02:52:08,204 [salt.loaded.ext.module.maas:1023][INFO    ][17693] Waiting status:Deployed for machines:['kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1652.25190997s left)
2020-01-05 02:52:19,636 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105025219623063
2020-01-05 02:52:19,664 [salt.minion      :1432][INFO    ][20540] Starting a new job with PID 20540
2020-01-05 02:52:19,696 [salt.minion      :1711][INFO    ][20540] Returning information for job: 20200105025219623063
2020-01-05 02:52:41,079 [salt.loaded.ext.module.maas:1023][INFO    ][17693] Waiting status:Deployed for machines:['kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1619.37666798s left)
2020-01-05 02:52:49,833 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105025249821959
2020-01-05 02:52:49,863 [salt.minion      :1432][INFO    ][20694] Starting a new job with PID 20694
2020-01-05 02:52:49,894 [salt.minion      :1711][INFO    ][20694] Returning information for job: 20200105025249821959
2020-01-05 02:53:14,208 [salt.loaded.ext.module.maas:1023][INFO    ][17693] Waiting status:Deployed for machines:['kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1586.24740505s left)
2020-01-05 02:53:20,020 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105025320006361
2020-01-05 02:53:20,043 [salt.minion      :1432][INFO    ][20728] Starting a new job with PID 20728
2020-01-05 02:53:20,076 [salt.minion      :1711][INFO    ][20728] Returning information for job: 20200105025320006361
2020-01-05 02:53:47,023 [salt.loaded.ext.module.maas:1023][INFO    ][17693] Waiting status:Deployed for machines:['kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1553.43288398s left)
2020-01-05 02:53:50,223 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105025350212185
2020-01-05 02:53:50,255 [salt.minion      :1432][INFO    ][20794] Starting a new job with PID 20794
2020-01-05 02:53:50,287 [salt.minion      :1711][INFO    ][20794] Returning information for job: 20200105025350212185
2020-01-05 02:54:20,002 [salt.loaded.ext.module.maas:1023][INFO    ][17693] Waiting status:Deployed for machines:['kvm01', 'kvm03']
sleep for:30s Timeout:2250s (1520.45428205s left)
2020-01-05 02:54:20,299 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105025420285804
2020-01-05 02:54:20,321 [salt.minion      :1432][INFO    ][20891] Starting a new job with PID 20891
2020-01-05 02:54:20,353 [salt.minion      :1711][INFO    ][20891] Returning information for job: 20200105025420285804
2020-01-05 02:54:50,518 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command saltutil.find_job with jid 20200105025450506665
2020-01-05 02:54:50,537 [salt.minion      :1432][INFO    ][21057] Starting a new job with PID 21057
2020-01-05 02:54:50,572 [salt.minion      :1711][INFO    ][21057] Returning information for job: 20200105025450506665
2020-01-05 02:54:52,999 [salt.state       :300 ][INFO    ][17693] {'ret': True}
2020-01-05 02:54:53,000 [salt.state       :1951][INFO    ][17693] Completed state [maas.wait_for_machine_status] at time 02:54:53.000072 duration_in_ms=762561.414
2020-01-05 02:54:53,007 [salt.minion      :1711][INFO    ][17693] Returning information for job: 20200105024201941709
2020-01-05 03:11:20,955 [salt.utils.schedule:1377][INFO    ][2920] Running scheduled job: __mine_interval
2020-01-05 04:11:20,955 [salt.utils.schedule:1377][INFO    ][2920] Running scheduled job: __mine_interval
2020-01-05 04:42:03,972 [salt.minion      :1308][INFO    ][2920] User sudo_ubuntu Executing command cp.push_dir with jid 20200105044203962717
2020-01-05 04:42:03,995 [salt.minion      :1432][INFO    ][28532] Starting a new job with PID 28532
