2019-05-22 20:05:22,685 [salt.minion      :870 ][ERROR   ][382] Error while bringing up minion for multi-master. Is master at 10.20.0.2 responding?
2019-05-22 20:06:48,264 [salt.utils.decorators:613 ][WARNING ][2074] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-05-22 20:06:49,508 [salt.utils.decorators:613 ][WARNING ][2074] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-05-22 20:06:53,176 [salt.loaded.int.states.file:2298][WARNING ][2464] State for file: /etc/maas/rackd.conf - Neither 'source' nor 'contents' nor 'contents_pillar' nor 'contents_grains' was defined, yet 'replace' was set to 'True'. As there is no source to replace the file with, 'replace' has been set to 'False' to avoid reading the file unnecessarily.
2019-05-22 20:07:10,835 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2848] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2019-05-22 20:07:10,869 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2848] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2019-05-22 20:07:10,907 [salt.utils.parsers:1051][WARNING ][382] Minion received a SIGTERM. Exiting.
2019-05-22 20:07:12,014 [salt.cli.daemons :293 ][INFO    ][2964] Setting up the Salt Minion "mas01.mcp-fdio-noha.local"
2019-05-22 20:07:12,184 [salt.cli.daemons :82  ][INFO    ][2964] Starting up the Salt Minion
2019-05-22 20:07:12,185 [salt.utils.event :1017][INFO    ][2964] Starting pull socket on /var/run/salt/minion/minion_event_38d774b16c_pull.ipc
2019-05-22 20:07:13,457 [salt.minion      :976 ][INFO    ][2964] Creating minion process manager
2019-05-22 20:07:15,440 [salt.loader.10.20.0.2.int.module.cmdmod:395 ][INFO    ][2964] Executing command ['date', '+%z'] in directory '/root'
2019-05-22 20:07:15,464 [salt.utils.schedule:568 ][INFO    ][2964] Updating job settings for scheduled job: __mine_interval
2019-05-22 20:07:15,467 [salt.minion      :1108][INFO    ][2964] Added mine.update to scheduler
2019-05-22 20:07:15,474 [salt.minion      :1975][INFO    ][2964] Minion is starting as user 'root'
2019-05-22 20:07:15,491 [salt.minion      :2336][INFO    ][2964] Minion is ready to receive requests!
2019-05-22 20:07:22,450 [salt.state       :2022][WARNING ][2855] State is set to retry, but a valid dict for retry configuration was not found.  Using retry defaults
2019-05-22 20:07:23,484 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522200723471247
2019-05-22 20:07:23,508 [salt.minion      :1432][INFO    ][3228] Starting a new job with PID 3228
2019-05-22 20:07:23,551 [salt.minion      :1711][INFO    ][3228] Returning information for job: 20190522200723471247
2019-05-22 20:07:25,808 [salt.utils.decorators:613 ][WARNING ][2855] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-05-22 20:07:53,684 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522200753670910
2019-05-22 20:07:53,708 [salt.minion      :1432][INFO    ][3744] Starting a new job with PID 3744
2019-05-22 20:07:53,735 [salt.minion      :1711][INFO    ][3744] Returning information for job: 20190522200753670910
2019-05-22 20:08:23,812 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522200823798165
2019-05-22 20:08:23,830 [salt.minion      :1432][INFO    ][3939] Starting a new job with PID 3939
2019-05-22 20:08:23,865 [salt.minion      :1711][INFO    ][3939] Returning information for job: 20190522200823798165
2019-05-22 20:08:53,921 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522200853907708
2019-05-22 20:08:53,950 [salt.minion      :1432][INFO    ][4119] Starting a new job with PID 4119
2019-05-22 20:08:53,988 [salt.minion      :1711][INFO    ][4119] Returning information for job: 20190522200853907708
2019-05-22 20:09:24,045 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522200924028878
2019-05-22 20:09:24,073 [salt.minion      :1432][INFO    ][4294] Starting a new job with PID 4294
2019-05-22 20:09:24,104 [salt.minion      :1711][INFO    ][4294] Returning information for job: 20190522200924028878
2019-05-22 20:09:54,188 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522200954176012
2019-05-22 20:09:54,215 [salt.minion      :1432][INFO    ][4463] Starting a new job with PID 4463
2019-05-22 20:09:54,246 [salt.minion      :1711][INFO    ][4463] Returning information for job: 20190522200954176012
2019-05-22 20:10:24,309 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522201024296778
2019-05-22 20:10:24,341 [salt.minion      :1432][INFO    ][4636] Starting a new job with PID 4636
2019-05-22 20:10:24,373 [salt.minion      :1711][INFO    ][4636] Returning information for job: 20190522201024296778
2019-05-22 20:10:54,426 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522201054408495
2019-05-22 20:10:54,452 [salt.minion      :1432][INFO    ][4877] Starting a new job with PID 4877
2019-05-22 20:10:54,481 [salt.minion      :1711][INFO    ][4877] Returning information for job: 20190522201054408495
2019-05-22 20:11:24,559 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522201124546422
2019-05-22 20:11:24,588 [salt.minion      :1432][INFO    ][5084] Starting a new job with PID 5084
2019-05-22 20:11:24,621 [salt.minion      :1711][INFO    ][5084] Returning information for job: 20190522201124546422
2019-05-22 20:11:54,689 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522201154673706
2019-05-22 20:11:54,715 [salt.minion      :1432][INFO    ][5359] Starting a new job with PID 5359
2019-05-22 20:11:54,745 [salt.minion      :1711][INFO    ][5359] Returning information for job: 20190522201154673706
2019-05-22 20:12:24,831 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522201224817580
2019-05-22 20:12:24,856 [salt.minion      :1432][INFO    ][5596] Starting a new job with PID 5596
2019-05-22 20:12:24,884 [salt.minion      :1711][INFO    ][5596] Returning information for job: 20190522201224817580
2019-05-22 20:12:54,989 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522201254977574
2019-05-22 20:12:55,008 [salt.minion      :1432][INFO    ][5855] Starting a new job with PID 5855
2019-05-22 20:12:55,039 [salt.minion      :1711][INFO    ][5855] Returning information for job: 20190522201254977574
2019-05-22 20:13:25,132 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522201325117060
2019-05-22 20:13:25,153 [salt.minion      :1432][INFO    ][6047] Starting a new job with PID 6047
2019-05-22 20:13:25,181 [salt.minion      :1711][INFO    ][6047] Returning information for job: 20190522201325117060
2019-05-22 20:13:55,261 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522201355248517
2019-05-22 20:13:55,283 [salt.minion      :1432][INFO    ][6266] Starting a new job with PID 6266
2019-05-22 20:13:55,315 [salt.minion      :1711][INFO    ][6266] Returning information for job: 20190522201355248517
2019-05-22 20:14:25,424 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522201425414155
2019-05-22 20:14:25,445 [salt.minion      :1432][INFO    ][6480] Starting a new job with PID 6480
2019-05-22 20:14:25,474 [salt.minion      :1711][INFO    ][6480] Returning information for job: 20190522201425414155
2019-05-22 20:14:55,613 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522201455597174
2019-05-22 20:14:55,633 [salt.minion      :1432][INFO    ][6740] Starting a new job with PID 6740
2019-05-22 20:14:55,669 [salt.minion      :1711][INFO    ][6740] Returning information for job: 20190522201455597174
2019-05-22 20:15:25,782 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522201525765553
2019-05-22 20:15:25,808 [salt.minion      :1432][INFO    ][6981] Starting a new job with PID 6981
2019-05-22 20:15:25,838 [salt.minion      :1711][INFO    ][6981] Returning information for job: 20190522201525765553
2019-05-22 20:15:55,963 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522201555952345
2019-05-22 20:15:55,990 [salt.minion      :1432][INFO    ][7212] Starting a new job with PID 7212
2019-05-22 20:15:56,025 [salt.minion      :1711][INFO    ][7212] Returning information for job: 20190522201555952345
2019-05-22 20:16:26,143 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522201626132188
2019-05-22 20:16:26,169 [salt.minion      :1432][INFO    ][7483] Starting a new job with PID 7483
2019-05-22 20:16:26,208 [salt.minion      :1711][INFO    ][7483] Returning information for job: 20190522201626132188
2019-05-22 20:16:56,348 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522201656336936
2019-05-22 20:16:56,374 [salt.minion      :1432][INFO    ][7714] Starting a new job with PID 7714
2019-05-22 20:16:56,406 [salt.minion      :1711][INFO    ][7714] Returning information for job: 20190522201656336936
2019-05-22 20:17:26,525 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522201726511373
2019-05-22 20:17:26,550 [salt.minion      :1432][INFO    ][7964] Starting a new job with PID 7964
2019-05-22 20:17:26,584 [salt.minion      :1711][INFO    ][7964] Returning information for job: 20190522201726511373
2019-05-22 20:17:56,711 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522201756699011
2019-05-22 20:17:56,735 [salt.minion      :1432][INFO    ][8213] Starting a new job with PID 8213
2019-05-22 20:17:56,764 [salt.minion      :1711][INFO    ][8213] Returning information for job: 20190522201756699011
2019-05-22 20:18:26,897 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522201826883981
2019-05-22 20:18:26,920 [salt.minion      :1432][INFO    ][8446] Starting a new job with PID 8446
2019-05-22 20:18:26,952 [salt.minion      :1711][INFO    ][8446] Returning information for job: 20190522201826883981
2019-05-22 20:18:57,088 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522201857070450
2019-05-22 20:18:57,109 [salt.minion      :1432][INFO    ][8701] Starting a new job with PID 8701
2019-05-22 20:18:57,145 [salt.minion      :1711][INFO    ][8701] Returning information for job: 20190522201857070450
2019-05-22 20:19:27,269 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522201927258590
2019-05-22 20:19:27,284 [salt.minion      :1432][INFO    ][8966] Starting a new job with PID 8966
2019-05-22 20:19:27,316 [salt.minion      :1711][INFO    ][8966] Returning information for job: 20190522201927258590
2019-05-22 20:19:57,454 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522201957443986
2019-05-22 20:19:57,480 [salt.minion      :1432][INFO    ][9195] Starting a new job with PID 9195
2019-05-22 20:19:57,513 [salt.minion      :1711][INFO    ][9195] Returning information for job: 20190522201957443986
2019-05-22 20:20:27,667 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522202027655782
2019-05-22 20:20:27,691 [salt.minion      :1432][INFO    ][9465] Starting a new job with PID 9465
2019-05-22 20:20:27,724 [salt.minion      :1711][INFO    ][9465] Returning information for job: 20190522202027655782
2019-05-22 20:20:57,881 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522202057867412
2019-05-22 20:20:57,906 [salt.minion      :1432][INFO    ][9692] Starting a new job with PID 9692
2019-05-22 20:20:57,947 [salt.minion      :1711][INFO    ][9692] Returning information for job: 20190522202057867412
2019-05-22 20:21:28,085 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522202128071866
2019-05-22 20:21:28,110 [salt.minion      :1432][INFO    ][9925] Starting a new job with PID 9925
2019-05-22 20:21:28,159 [salt.minion      :1711][INFO    ][9925] Returning information for job: 20190522202128071866
2019-05-22 20:21:58,112 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522202158102571
2019-05-22 20:21:58,136 [salt.minion      :1432][INFO    ][10169] Starting a new job with PID 10169
2019-05-22 20:21:58,161 [salt.minion      :1711][INFO    ][10169] Returning information for job: 20190522202158102571
2019-05-22 20:22:28,135 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522202228116824
2019-05-22 20:22:28,158 [salt.minion      :1432][INFO    ][10415] Starting a new job with PID 10415
2019-05-22 20:22:28,180 [salt.minion      :1711][INFO    ][10415] Returning information for job: 20190522202228116824
2019-05-22 20:22:34,519 [salt.utils.decorators:613 ][WARNING ][2855] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-05-22 20:22:58,339 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522202258328910
2019-05-22 20:22:58,355 [salt.minion      :1432][INFO    ][10684] Starting a new job with PID 10684
2019-05-22 20:22:58,377 [salt.minion      :1711][INFO    ][10684] Returning information for job: 20190522202258328910
2019-05-22 20:23:28,556 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522202328542678
2019-05-22 20:23:28,577 [salt.minion      :1432][INFO    ][11015] Starting a new job with PID 11015
2019-05-22 20:23:28,603 [salt.minion      :1711][INFO    ][11015] Returning information for job: 20190522202328542678
2019-05-22 20:23:58,665 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522202358653577
2019-05-22 20:23:58,687 [salt.minion      :1432][INFO    ][11234] Starting a new job with PID 11234
2019-05-22 20:23:58,710 [salt.minion      :1711][INFO    ][11234] Returning information for job: 20190522202358653577
2019-05-22 20:24:28,755 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522202428743957
2019-05-22 20:24:28,775 [salt.minion      :1432][INFO    ][11464] Starting a new job with PID 11464
2019-05-22 20:24:28,796 [salt.minion      :1711][INFO    ][11464] Returning information for job: 20190522202428743957
2019-05-22 20:24:58,783 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522202458771330
2019-05-22 20:24:58,801 [salt.minion      :1432][INFO    ][11703] Starting a new job with PID 11703
2019-05-22 20:24:58,823 [salt.minion      :1711][INFO    ][11703] Returning information for job: 20190522202458771330
2019-05-22 20:25:28,835 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522202528822447
2019-05-22 20:25:28,856 [salt.minion      :1432][INFO    ][11901] Starting a new job with PID 11901
2019-05-22 20:25:28,879 [salt.minion      :1711][INFO    ][11901] Returning information for job: 20190522202528822447
2019-05-22 20:25:58,955 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522202558946883
2019-05-22 20:25:58,974 [salt.minion      :1432][INFO    ][12133] Starting a new job with PID 12133
2019-05-22 20:25:58,997 [salt.minion      :1711][INFO    ][12133] Returning information for job: 20190522202558946883
2019-05-22 20:26:29,159 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522202629151156
2019-05-22 20:26:29,177 [salt.minion      :1432][INFO    ][12403] Starting a new job with PID 12403
2019-05-22 20:26:29,197 [salt.minion      :1711][INFO    ][12403] Returning information for job: 20190522202629151156
2019-05-22 20:26:59,303 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522202659293578
2019-05-22 20:26:59,323 [salt.minion      :1432][INFO    ][12640] Starting a new job with PID 12640
2019-05-22 20:26:59,344 [salt.minion      :1711][INFO    ][12640] Returning information for job: 20190522202659293578
2019-05-22 20:27:29,405 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522202729394564
2019-05-22 20:27:29,422 [salt.minion      :1432][INFO    ][12920] Starting a new job with PID 12920
2019-05-22 20:27:29,443 [salt.minion      :1711][INFO    ][12920] Returning information for job: 20190522202729394564
2019-05-22 20:27:59,589 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522202759578779
2019-05-22 20:27:59,605 [salt.minion      :1432][INFO    ][13144] Starting a new job with PID 13144
2019-05-22 20:27:59,632 [salt.minion      :1711][INFO    ][13144] Returning information for job: 20190522202759578779
2019-05-22 20:28:29,751 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522202829742350
2019-05-22 20:28:29,768 [salt.minion      :1432][INFO    ][13401] Starting a new job with PID 13401
2019-05-22 20:28:29,792 [salt.minion      :1711][INFO    ][13401] Returning information for job: 20190522202829742350
2019-05-22 20:28:59,947 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522202859939696
2019-05-22 20:28:59,971 [salt.minion      :1432][INFO    ][13592] Starting a new job with PID 13592
2019-05-22 20:28:59,993 [salt.minion      :1711][INFO    ][13592] Returning information for job: 20190522202859939696
2019-05-22 20:29:30,142 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522202930131255
2019-05-22 20:29:30,162 [salt.minion      :1432][INFO    ][13827] Starting a new job with PID 13827
2019-05-22 20:29:30,183 [salt.minion      :1711][INFO    ][13827] Returning information for job: 20190522202930131255
2019-05-22 20:30:00,168 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522203000154592
2019-05-22 20:30:00,188 [salt.minion      :1432][INFO    ][13979] Starting a new job with PID 13979
2019-05-22 20:30:00,210 [salt.minion      :1711][INFO    ][13979] Returning information for job: 20190522203000154592
2019-05-22 20:30:30,389 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522203030378315
2019-05-22 20:30:30,406 [salt.minion      :1432][INFO    ][14169] Starting a new job with PID 14169
2019-05-22 20:30:30,425 [salt.minion      :1711][INFO    ][14169] Returning information for job: 20190522203030378315
2019-05-22 20:31:00,493 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522203100480453
2019-05-22 20:31:00,512 [salt.minion      :1432][INFO    ][14321] Starting a new job with PID 14321
2019-05-22 20:31:00,534 [salt.minion      :1711][INFO    ][14321] Returning information for job: 20190522203100480453
2019-05-22 20:31:30,568 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522203130557639
2019-05-22 20:31:30,583 [salt.minion      :1432][INFO    ][14543] Starting a new job with PID 14543
2019-05-22 20:31:30,601 [salt.minion      :1711][INFO    ][14543] Returning information for job: 20190522203130557639
2019-05-22 20:32:00,645 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522203200634503
2019-05-22 20:32:00,666 [salt.minion      :1432][INFO    ][14745] Starting a new job with PID 14745
2019-05-22 20:32:00,688 [salt.minion      :1711][INFO    ][14745] Returning information for job: 20190522203200634503
2019-05-22 20:32:30,789 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522203230776937
2019-05-22 20:32:30,810 [salt.minion      :1432][INFO    ][14958] Starting a new job with PID 14958
2019-05-22 20:32:30,834 [salt.minion      :1711][INFO    ][14958] Returning information for job: 20190522203230776937
2019-05-22 20:33:00,907 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522203300893230
2019-05-22 20:33:00,925 [salt.minion      :1432][INFO    ][15134] Starting a new job with PID 15134
2019-05-22 20:33:00,948 [salt.minion      :1711][INFO    ][15134] Returning information for job: 20190522203300893230
2019-05-22 20:33:30,919 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522203330912015
2019-05-22 20:33:30,934 [salt.minion      :1432][INFO    ][15391] Starting a new job with PID 15391
2019-05-22 20:33:30,955 [salt.minion      :1711][INFO    ][15391] Returning information for job: 20190522203330912015
2019-05-22 20:34:00,959 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522203400951121
2019-05-22 20:34:00,976 [salt.minion      :1432][INFO    ][15598] Starting a new job with PID 15598
2019-05-22 20:34:00,994 [salt.minion      :1711][INFO    ][15598] Returning information for job: 20190522203400951121
2019-05-22 20:34:30,992 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522203430982733
2019-05-22 20:34:31,015 [salt.minion      :1432][INFO    ][15844] Starting a new job with PID 15844
2019-05-22 20:34:31,036 [salt.minion      :1711][INFO    ][15844] Returning information for job: 20190522203430982733
2019-05-22 20:35:01,116 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522203501101540
2019-05-22 20:35:01,135 [salt.minion      :1432][INFO    ][16059] Starting a new job with PID 16059
2019-05-22 20:35:01,157 [salt.minion      :1711][INFO    ][16059] Returning information for job: 20190522203501101540
2019-05-22 20:35:31,181 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522203531168813
2019-05-22 20:35:31,198 [salt.minion      :1432][INFO    ][16316] Starting a new job with PID 16316
2019-05-22 20:35:31,225 [salt.minion      :1711][INFO    ][16316] Returning information for job: 20190522203531168813
2019-05-22 20:36:01,351 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522203601336663
2019-05-22 20:36:01,373 [salt.minion      :1432][INFO    ][16500] Starting a new job with PID 16500
2019-05-22 20:36:01,399 [salt.minion      :1711][INFO    ][16500] Returning information for job: 20190522203601336663
2019-05-22 20:36:31,433 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522203631423945
2019-05-22 20:36:31,446 [salt.minion      :1432][INFO    ][16744] Starting a new job with PID 16744
2019-05-22 20:36:31,473 [salt.minion      :1711][INFO    ][16744] Returning information for job: 20190522203631423945
2019-05-22 20:37:01,494 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522203701487479
2019-05-22 20:37:01,507 [salt.minion      :1432][INFO    ][16970] Starting a new job with PID 16970
2019-05-22 20:37:01,531 [salt.minion      :1711][INFO    ][16970] Returning information for job: 20190522203701487479
2019-05-22 20:37:31,678 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522203731668621
2019-05-22 20:37:31,699 [salt.minion      :1432][INFO    ][17273] Starting a new job with PID 17273
2019-05-22 20:37:31,728 [salt.minion      :1711][INFO    ][17273] Returning information for job: 20190522203731668621
2019-05-22 20:38:01,854 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522203801844800
2019-05-22 20:38:01,870 [salt.minion      :1432][INFO    ][17540] Starting a new job with PID 17540
2019-05-22 20:38:01,899 [salt.minion      :1711][INFO    ][17540] Returning information for job: 20190522203801844800
2019-05-22 20:38:31,924 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522203831912306
2019-05-22 20:38:31,944 [salt.minion      :1432][INFO    ][17843] Starting a new job with PID 17843
2019-05-22 20:38:31,977 [salt.minion      :1711][INFO    ][17843] Returning information for job: 20190522203831912306
2019-05-22 20:39:02,177 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522203902136842
2019-05-22 20:39:02,197 [salt.minion      :1432][INFO    ][18093] Starting a new job with PID 18093
2019-05-22 20:39:02,235 [salt.minion      :1711][INFO    ][18093] Returning information for job: 20190522203902136842
2019-05-22 20:39:32,216 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522203932204874
2019-05-22 20:39:32,240 [salt.minion      :1432][INFO    ][18389] Starting a new job with PID 18389
2019-05-22 20:39:32,267 [salt.minion      :1711][INFO    ][18389] Returning information for job: 20190522203932204874
2019-05-22 20:39:58,212 [salt.utils.decorators:613 ][WARNING ][2855] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-05-22 20:40:02,356 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522204002343776
2019-05-22 20:40:02,376 [salt.minion      :1432][INFO    ][18581] Starting a new job with PID 18581
2019-05-22 20:40:02,399 [salt.minion      :1711][INFO    ][18581] Returning information for job: 20190522204002343776
2019-05-22 20:40:32,464 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522204032450616
2019-05-22 20:40:32,491 [salt.minion      :1432][INFO    ][18657] Starting a new job with PID 18657
2019-05-22 20:40:32,518 [salt.minion      :1711][INFO    ][18657] Returning information for job: 20190522204032450616
2019-05-22 20:41:02,584 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522204102574154
2019-05-22 20:41:02,611 [salt.minion      :1432][INFO    ][18692] Starting a new job with PID 18692
2019-05-22 20:41:02,640 [salt.minion      :1711][INFO    ][18692] Returning information for job: 20190522204102574154
2019-05-22 20:41:32,782 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522204132775068
2019-05-22 20:41:32,803 [salt.minion      :1432][INFO    ][18762] Starting a new job with PID 18762
2019-05-22 20:41:32,829 [salt.minion      :1711][INFO    ][18762] Returning information for job: 20190522204132775068
2019-05-22 20:42:02,886 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522204202871427
2019-05-22 20:42:02,915 [salt.minion      :1432][INFO    ][18913] Starting a new job with PID 18913
2019-05-22 20:42:02,938 [salt.minion      :1711][INFO    ][18913] Returning information for job: 20190522204202871427
2019-05-22 20:42:33,009 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522204233001681
2019-05-22 20:42:33,029 [salt.minion      :1432][INFO    ][18978] Starting a new job with PID 18978
2019-05-22 20:42:33,053 [salt.minion      :1711][INFO    ][18978] Returning information for job: 20190522204233001681
2019-05-22 20:43:03,148 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522204303128550
2019-05-22 20:43:03,172 [salt.minion      :1432][INFO    ][19003] Starting a new job with PID 19003
2019-05-22 20:43:03,195 [salt.minion      :1711][INFO    ][19003] Returning information for job: 20190522204303128550
2019-05-22 20:43:33,318 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522204333304037
2019-05-22 20:43:33,345 [salt.minion      :1432][INFO    ][19070] Starting a new job with PID 19070
2019-05-22 20:43:33,370 [salt.minion      :1711][INFO    ][19070] Returning information for job: 20190522204333304037
2019-05-22 20:44:03,502 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522204403490117
2019-05-22 20:44:03,528 [salt.minion      :1432][INFO    ][19095] Starting a new job with PID 19095
2019-05-22 20:44:03,561 [salt.minion      :1711][INFO    ][19095] Returning information for job: 20190522204403490117
2019-05-22 20:44:33,698 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522204433682355
2019-05-22 20:44:33,727 [salt.minion      :1432][INFO    ][19160] Starting a new job with PID 19160
2019-05-22 20:44:33,751 [salt.minion      :1711][INFO    ][19160] Returning information for job: 20190522204433682355
2019-05-22 20:45:03,727 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522204503712638
2019-05-22 20:45:03,754 [salt.minion      :1432][INFO    ][19185] Starting a new job with PID 19185
2019-05-22 20:45:03,779 [salt.minion      :1711][INFO    ][19185] Returning information for job: 20190522204503712638
2019-05-22 20:45:33,776 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522204533761185
2019-05-22 20:45:33,805 [salt.minion      :1432][INFO    ][19249] Starting a new job with PID 19249
2019-05-22 20:45:33,829 [salt.minion      :1711][INFO    ][19249] Returning information for job: 20190522204533761185
2019-05-22 20:46:03,847 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522204603831472
2019-05-22 20:46:03,875 [salt.minion      :1432][INFO    ][19274] Starting a new job with PID 19274
2019-05-22 20:46:03,897 [salt.minion      :1711][INFO    ][19274] Returning information for job: 20190522204603831472
2019-05-22 20:46:33,943 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522204633930839
2019-05-22 20:46:33,971 [salt.minion      :1432][INFO    ][19341] Starting a new job with PID 19341
2019-05-22 20:46:33,996 [salt.minion      :1711][INFO    ][19341] Returning information for job: 20190522204633930839
2019-05-22 20:47:04,072 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522204704057234
2019-05-22 20:47:04,099 [salt.minion      :1432][INFO    ][19366] Starting a new job with PID 19366
2019-05-22 20:47:04,124 [salt.minion      :1711][INFO    ][19366] Returning information for job: 20190522204704057234
2019-05-22 20:47:34,260 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522204734244206
2019-05-22 20:47:34,285 [salt.minion      :1432][INFO    ][19450] Starting a new job with PID 19450
2019-05-22 20:47:34,309 [salt.minion      :1711][INFO    ][19450] Returning information for job: 20190522204734244206
2019-05-22 20:48:04,409 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522204804391296
2019-05-22 20:48:04,428 [salt.minion      :1432][INFO    ][19477] Starting a new job with PID 19477
2019-05-22 20:48:04,450 [salt.minion      :1711][INFO    ][19477] Returning information for job: 20190522204804391296
2019-05-22 20:48:34,583 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522204834569108
2019-05-22 20:48:34,612 [salt.minion      :1432][INFO    ][19543] Starting a new job with PID 19543
2019-05-22 20:48:34,637 [salt.minion      :1711][INFO    ][19543] Returning information for job: 20190522204834569108
2019-05-22 20:49:04,747 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522204904736789
2019-05-22 20:49:04,772 [salt.minion      :1432][INFO    ][19568] Starting a new job with PID 19568
2019-05-22 20:49:04,795 [salt.minion      :1711][INFO    ][19568] Returning information for job: 20190522204904736789
2019-05-22 20:49:34,929 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522204934918382
2019-05-22 20:49:34,954 [salt.minion      :1432][INFO    ][19635] Starting a new job with PID 19635
2019-05-22 20:49:34,981 [salt.minion      :1711][INFO    ][19635] Returning information for job: 20190522204934918382
2019-05-22 20:50:05,155 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522205005144847
2019-05-22 20:50:05,179 [salt.minion      :1432][INFO    ][19666] Starting a new job with PID 19666
2019-05-22 20:50:05,203 [salt.minion      :1711][INFO    ][19666] Returning information for job: 20190522205005144847
2019-05-22 20:50:35,365 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522205035350143
2019-05-22 20:50:35,393 [salt.minion      :1432][INFO    ][19726] Starting a new job with PID 19726
2019-05-22 20:50:35,417 [salt.minion      :1711][INFO    ][19726] Returning information for job: 20190522205035350143
2019-05-22 20:51:05,444 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522205105433871
2019-05-22 20:51:05,468 [salt.minion      :1432][INFO    ][19752] Starting a new job with PID 19752
2019-05-22 20:51:05,493 [salt.minion      :1711][INFO    ][19752] Returning information for job: 20190522205105433871
2019-05-22 20:51:35,491 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522205135474840
2019-05-22 20:51:35,515 [salt.minion      :1432][INFO    ][19813] Starting a new job with PID 19813
2019-05-22 20:51:35,537 [salt.minion      :1711][INFO    ][19813] Returning information for job: 20190522205135474840
2019-05-22 20:52:05,592 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522205205581449
2019-05-22 20:52:05,619 [salt.minion      :1432][INFO    ][19840] Starting a new job with PID 19840
2019-05-22 20:52:05,644 [salt.minion      :1711][INFO    ][19840] Returning information for job: 20190522205205581449
2019-05-22 20:52:35,668 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522205235655059
2019-05-22 20:52:35,693 [salt.minion      :1432][INFO    ][19906] Starting a new job with PID 19906
2019-05-22 20:52:35,715 [salt.minion      :1711][INFO    ][19906] Returning information for job: 20190522205235655059
2019-05-22 20:53:05,791 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522205305781207
2019-05-22 20:53:05,818 [salt.minion      :1432][INFO    ][19933] Starting a new job with PID 19933
2019-05-22 20:53:05,840 [salt.minion      :1711][INFO    ][19933] Returning information for job: 20190522205305781207
2019-05-22 20:53:35,835 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522205335813621
2019-05-22 20:53:35,861 [salt.minion      :1432][INFO    ][19995] Starting a new job with PID 19995
2019-05-22 20:53:35,883 [salt.minion      :1711][INFO    ][19995] Returning information for job: 20190522205335813621
2019-05-22 20:54:05,922 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522205405908560
2019-05-22 20:54:05,944 [salt.minion      :1432][INFO    ][20022] Starting a new job with PID 20022
2019-05-22 20:54:05,968 [salt.minion      :1711][INFO    ][20022] Returning information for job: 20190522205405908560
2019-05-22 20:54:36,125 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522205436115676
2019-05-22 20:54:36,143 [salt.minion      :1432][INFO    ][20084] Starting a new job with PID 20084
2019-05-22 20:54:36,166 [salt.minion      :1711][INFO    ][20084] Returning information for job: 20190522205436115676
2019-05-22 20:55:00,191 [salt.utils.decorators:613 ][WARNING ][2855] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-05-22 20:55:02,517 [salt.loaded.ext.module.maasng:1008][WARNING ][2855] Detected cidr:192.168.11.0/24 in fabric:fabric-2
2019-05-22 20:55:02,518 [salt.loaded.ext.module.maasng:1011][WARNING ][2855] Guessing, that fabric with current name:fabric-2
 should be renamed to:pxe_admin
2019-05-22 20:55:03,307 [salt.loaded.ext.module.maasng:1235][WARNING ][2855] Ignoring parameter vlan:0
2019-05-22 20:55:04,186 [salt.utils.decorators:613 ][WARNING ][2855] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-05-22 20:55:05,600 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command state.apply with jid 20190522205505583807
2019-05-22 20:55:05,625 [salt.minion      :1432][INFO    ][20217] Starting a new job with PID 20217
2019-05-22 20:55:15,036 [salt.state       :915 ][INFO    ][20217] Loading fresh modules for state activity
2019-05-22 20:55:15,139 [salt.fileclient  :1219][INFO    ][20217] Fetching file from saltenv 'base', ** done ** 'maas/machines/init.sls'
2019-05-22 20:55:15,200 [salt.state       :1780][INFO    ][20217] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 20:55:15.200282
2019-05-22 20:55:15,200 [salt.state       :1813][INFO    ][20217] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2019-05-22 20:55:15,204 [salt.loaded.int.module.cmdmod:395 ][INFO    ][20217] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2019-05-22 20:55:17,302 [salt.state       :300 ][INFO    ][20217] {'pid': 20239, 'retcode': 0, 'stderr': '', 'stdout': ''}
2019-05-22 20:55:17,303 [salt.state       :1951][INFO    ][20217] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 20:55:17.303217 duration_in_ms=2102.936
2019-05-22 20:55:17,305 [salt.state       :1780][INFO    ][20217] Running state [maas.process_machines] at time 20:55:17.305489
2019-05-22 20:55:17,306 [salt.state       :1813][INFO    ][20217] Executing state module.run for [maas.process_machines]
2019-05-22 20:55:17,307 [salt.utils.decorators:613 ][WARNING ][20217] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-05-22 20:55:17,392 [salt.loaded.ext.module.maas:412 ][WARNING ][20217] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2019-05-22 20:55:17,392 [salt.loaded.ext.module.maas:92  ][INFO    ][20217] machine hostname=gtw01 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
2019-05-22 20:55:20,684 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522205520670321
2019-05-22 20:55:20,707 [salt.minion      :1432][INFO    ][20287] Starting a new job with PID 20287
2019-05-22 20:55:20,732 [salt.minion      :1711][INFO    ][20287] Returning information for job: 20190522205520670321
2019-05-22 20:55:21,847 [salt.loaded.ext.module.maas:412 ][WARNING ][20217] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2019-05-22 20:55:21,847 [salt.loaded.ext.module.maas:92  ][INFO    ][20217] 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
2019-05-22 20:55:26,202 [salt.loaded.ext.module.maas:412 ][WARNING ][20217] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2019-05-22 20:55:26,203 [salt.loaded.ext.module.maas:92  ][INFO    ][20217] 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
2019-05-22 20:55:30,796 [salt.loaded.ext.module.maas:412 ][WARNING ][20217] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2019-05-22 20:55:30,797 [salt.loaded.ext.module.maas:92  ][INFO    ][20217] machine hostname=ctl01 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
2019-05-22 20:55:35,229 [salt.state       :300 ][INFO    ][20217] {'ret': {'updated': [], 'errors': {}, 'success': ['gtw01', 'cmp002', 'cmp001', 'ctl01']}}
2019-05-22 20:55:35,229 [salt.state       :1951][INFO    ][20217] Completed state [maas.process_machines] at time 20:55:35.229607 duration_in_ms=17924.116
2019-05-22 20:55:35,238 [salt.minion      :1711][INFO    ][20217] Returning information for job: 20190522205505583807
2019-05-22 20:56:06,356 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command state.apply with jid 20190522205606341317
2019-05-22 20:56:06,383 [salt.minion      :1432][INFO    ][20521] Starting a new job with PID 20521
2019-05-22 20:56:14,239 [salt.state       :915 ][INFO    ][20521] Loading fresh modules for state activity
2019-05-22 20:56:14,299 [salt.fileclient  :1219][INFO    ][20521] Fetching file from saltenv 'base', ** done ** 'maas/machines/wait_for_ready_or_deployed.sls'
2019-05-22 20:56:14,348 [salt.state       :1780][INFO    ][20521] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 20:56:14.348154
2019-05-22 20:56:14,348 [salt.state       :1813][INFO    ][20521] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2019-05-22 20:56:14,350 [salt.loaded.int.module.cmdmod:395 ][INFO    ][20521] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2019-05-22 20:56:16,048 [salt.state       :300 ][INFO    ][20521] {'pid': 20541, 'retcode': 0, 'stderr': '', 'stdout': ''}
2019-05-22 20:56:16,049 [salt.state       :1951][INFO    ][20521] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 20:56:16.049274 duration_in_ms=1701.12
2019-05-22 20:56:16,052 [salt.state       :1780][INFO    ][20521] Running state [maas.wait_for_machine_status] at time 20:56:16.052393
2019-05-22 20:56:16,052 [salt.state       :1813][INFO    ][20521] Executing state module.run for [maas.wait_for_machine_status]
2019-05-22 20:56:16,053 [salt.utils.decorators:613 ][WARNING ][20521] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-05-22 20:56:16,684 [salt.loaded.ext.module.maas:1023][INFO    ][20521] Waiting status:Ready|Deployed for machines:['gtw01', 'cmp002', 'cmp001', 'ctl01']
sleep for:30s Timeout:1500s (1499.38151193s left)
2019-05-22 20:56:21,436 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522205621422277
2019-05-22 20:56:21,467 [salt.minion      :1432][INFO    ][20551] Starting a new job with PID 20551
2019-05-22 20:56:21,491 [salt.minion      :1711][INFO    ][20551] Returning information for job: 20190522205621422277
2019-05-22 20:56:47,291 [salt.loaded.ext.module.maas:1023][INFO    ][20521] Waiting status:Ready|Deployed for machines:['gtw01', 'cmp002', 'cmp001', 'ctl01']
sleep for:30s Timeout:1500s (1468.77378798s left)
2019-05-22 20:56:51,509 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522205651494847
2019-05-22 20:56:51,539 [salt.minion      :1432][INFO    ][20595] Starting a new job with PID 20595
2019-05-22 20:56:51,561 [salt.minion      :1711][INFO    ][20595] Returning information for job: 20190522205651494847
2019-05-22 20:57:17,900 [salt.loaded.ext.module.maas:1023][INFO    ][20521] Waiting status:Ready|Deployed for machines:['gtw01', 'cmp002', 'cmp001', 'ctl01']
sleep for:30s Timeout:1500s (1438.16559505s left)
2019-05-22 20:57:21,612 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522205721601276
2019-05-22 20:57:21,636 [salt.minion      :1432][INFO    ][20645] Starting a new job with PID 20645
2019-05-22 20:57:21,659 [salt.minion      :1711][INFO    ][20645] Returning information for job: 20190522205721601276
2019-05-22 20:57:48,528 [salt.loaded.ext.module.maas:1023][INFO    ][20521] Waiting status:Ready|Deployed for machines:['gtw01', 'cmp002', 'cmp001', 'ctl01']
sleep for:30s Timeout:1500s (1407.53695107s left)
2019-05-22 20:57:51,653 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522205751643186
2019-05-22 20:57:51,670 [salt.minion      :1432][INFO    ][20714] Starting a new job with PID 20714
2019-05-22 20:57:51,692 [salt.minion      :1711][INFO    ][20714] Returning information for job: 20190522205751643186
2019-05-22 20:58:19,512 [salt.loaded.ext.module.maas:1023][INFO    ][20521] Waiting status:Ready|Deployed for machines:['gtw01', 'cmp002', 'cmp001', 'ctl01']
sleep for:30s Timeout:1500s (1376.55304885s left)
2019-05-22 20:58:21,703 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522205821690768
2019-05-22 20:58:21,725 [salt.minion      :1432][INFO    ][20783] Starting a new job with PID 20783
2019-05-22 20:58:21,748 [salt.minion      :1711][INFO    ][20783] Returning information for job: 20190522205821690768
2019-05-22 20:58:50,335 [salt.loaded.ext.module.maas:1023][INFO    ][20521] Waiting status:Ready|Deployed for machines:['gtw01', 'cmp002', 'cmp001', 'ctl01']
sleep for:30s Timeout:1500s (1345.73032308s left)
2019-05-22 20:58:51,756 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522205851747886
2019-05-22 20:58:51,778 [salt.minion      :1432][INFO    ][20921] Starting a new job with PID 20921
2019-05-22 20:58:51,808 [salt.minion      :1711][INFO    ][20921] Returning information for job: 20190522205851747886
2019-05-22 20:59:21,203 [salt.loaded.ext.module.maas:1023][INFO    ][20521] Waiting status:Ready|Deployed for machines:['gtw01', 'cmp002', 'cmp001', 'ctl01']
sleep for:30s Timeout:1500s (1314.86168599s left)
2019-05-22 20:59:21,849 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522205921832997
2019-05-22 20:59:21,879 [salt.minion      :1432][INFO    ][21121] Starting a new job with PID 21121
2019-05-22 20:59:21,905 [salt.minion      :1711][INFO    ][21121] Returning information for job: 20190522205921832997
2019-05-22 20:59:51,973 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522205951960768
2019-05-22 20:59:52,003 [salt.minion      :1432][INFO    ][21454] Starting a new job with PID 21454
2019-05-22 20:59:52,024 [salt.minion      :1711][INFO    ][21454] Returning information for job: 20190522205951960768
2019-05-22 20:59:52,199 [salt.loaded.ext.module.maas:1023][INFO    ][20521] Waiting status:Ready|Deployed for machines:['gtw01', 'cmp002', 'cmp001', 'ctl01']
sleep for:30s Timeout:1500s (1283.86630988s left)
2019-05-22 21:00:22,053 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522210022040975
2019-05-22 21:00:22,079 [salt.minion      :1432][INFO    ][21556] Starting a new job with PID 21556
2019-05-22 21:00:22,102 [salt.minion      :1711][INFO    ][21556] Returning information for job: 20190522210022040975
2019-05-22 21:00:23,664 [salt.loaded.ext.module.maas:1023][INFO    ][20521] Waiting status:Ready|Deployed for machines:['gtw01', 'cmp001', 'ctl01']
sleep for:30s Timeout:1500s (1252.40151405s left)
2019-05-22 21:00:52,174 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522210052163427
2019-05-22 21:00:52,198 [salt.minion      :1432][INFO    ][21799] Starting a new job with PID 21799
2019-05-22 21:00:52,224 [salt.minion      :1711][INFO    ][21799] Returning information for job: 20190522210052163427
2019-05-22 21:00:55,205 [salt.loaded.ext.module.maas:1023][INFO    ][20521] Waiting status:Ready|Deployed for machines:['gtw01', 'ctl01']
sleep for:30s Timeout:1500s (1220.86007404s left)
2019-05-22 21:01:22,264 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522210122252894
2019-05-22 21:01:22,284 [salt.minion      :1432][INFO    ][21898] Starting a new job with PID 21898
2019-05-22 21:01:22,304 [salt.minion      :1711][INFO    ][21898] Returning information for job: 20190522210122252894
2019-05-22 21:01:27,576 [salt.loaded.ext.module.maas:1023][INFO    ][20521] Waiting status:Ready|Deployed for machines:['gtw01', 'ctl01']
sleep for:30s Timeout:1500s (1188.48912501s left)
2019-05-22 21:01:52,380 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522210152369298
2019-05-22 21:01:52,405 [salt.minion      :1432][INFO    ][22038] Starting a new job with PID 22038
2019-05-22 21:01:52,429 [salt.minion      :1711][INFO    ][22038] Returning information for job: 20190522210152369298
2019-05-22 21:01:59,194 [salt.loaded.ext.module.maas:1023][INFO    ][20521] Waiting status:Ready|Deployed for machines:['gtw01', 'ctl01']
sleep for:30s Timeout:1500s (1156.87187791s left)
2019-05-22 21:02:22,500 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522210222484698
2019-05-22 21:02:22,532 [salt.minion      :1432][INFO    ][22125] Starting a new job with PID 22125
2019-05-22 21:02:22,555 [salt.minion      :1711][INFO    ][22125] Returning information for job: 20190522210222484698
2019-05-22 21:02:31,159 [salt.state       :300 ][INFO    ][20521] {'ret': True}
2019-05-22 21:02:31,160 [salt.state       :1951][INFO    ][20521] Completed state [maas.wait_for_machine_status] at time 21:02:31.160335 duration_in_ms=375107.94
2019-05-22 21:02:31,164 [salt.minion      :1711][INFO    ][20521] Returning information for job: 20190522205606341317
2019-05-22 21:02:31,736 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command state.apply with jid 20190522210231719990
2019-05-22 21:02:31,762 [salt.minion      :1432][INFO    ][22185] Starting a new job with PID 22185
2019-05-22 21:02:39,512 [salt.state       :915 ][INFO    ][22185] Loading fresh modules for state activity
2019-05-22 21:02:39,573 [salt.fileclient  :1219][INFO    ][22185] Fetching file from saltenv 'base', ** done ** 'maas/machines/storage.sls'
2019-05-22 21:02:39,683 [salt.state       :1780][INFO    ][22185] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 21:02:39.683769
2019-05-22 21:02:39,684 [salt.state       :1813][INFO    ][22185] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2019-05-22 21:02:39,686 [salt.loaded.int.module.cmdmod:395 ][INFO    ][22185] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2019-05-22 21:02:41,430 [salt.state       :300 ][INFO    ][22185] {'pid': 22196, 'retcode': 0, 'stderr': '', 'stdout': ''}
2019-05-22 21:02:41,431 [salt.state       :1951][INFO    ][22185] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 21:02:41.431748 duration_in_ms=1747.978
2019-05-22 21:02:41,436 [salt.state       :1780][INFO    ][22185] Running state [maas_machines_storage_cmp002_lvm] at time 21:02:41.436636
2019-05-22 21:02:41,437 [salt.state       :1813][INFO    ][22185] Executing state maasng.disk_layout_present for [maas_machines_storage_cmp002_lvm]
2019-05-22 21:02:42,432 [salt.loaded.ext.module.maasng:610 ][INFO    ][22185] kqbk78
2019-05-22 21:02:42,433 [salt.loaded.ext.module.maasng:626 ][INFO    ][22185] sda
2019-05-22 21:02:42,910 [salt.loaded.ext.module.maasng:361 ][INFO    ][22185] kqbk78
2019-05-22 21:02:43,004 [salt.loaded.ext.module.maasng:367 ][INFO    ][22185] [{u'size': 800109715456, u'model': u'LOGICAL VOLUME', u'name': u'sda', u'tags': [u'ssd'], u'used_size': 800106479616, u'partitions': [{u'uuid': u'845748e6-7f7b-4a11-9d4f-968c8af6a5c3', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'kqbk78', u'device_id': 1, u'filesystem': {u'label': None, u'mount_point': None, u'mount_options': None, u'fstype': u'lvm-pv', u'uuid': u'277a4776-fe7f-4632-aeb3-f9248ea9330d'}, u'path': u'/dev/disk/by-dname/sda-part1', u'resource_uri': u'/MAAS/api/2.0/nodes/kqbk78/blockdevices/1/partition/1', u'type': u'partition', u'id': 1, u'size': 800101236736}], u'uuid': None, u'used_for': u'MBR partitioned with 1 partition', u'path': u'/dev/disk/by-dname/sda', u'system_id': u'kqbk78', u'partition_table_type': u'MBR', 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'id': 1, u'resource_uri': u'/MAAS/api/2.0/nodes/kqbk78/blockdevices/1/'}, {u'size': 800097042432, u'model': None, u'name': u'vgroot-lvroot', u'tags': [], u'used_size': 800097042432, u'partitions': [], u'uuid': u'e4728751-f4ef-41c3-8ed2-1949d27794fc', u'used_for': u'ext4 formatted filesystem mounted at /', u'path': u'/dev/disk/by-dname/lvroot', u'system_id': u'kqbk78', 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'9541f81f-35f2-4a66-a924-582f91d030b5'}, u'id_path': None, u'available_size': 0, u'serial': None, u'block_size': 4096, u'type': u'virtual', u'id': 3, u'resource_uri': u'/MAAS/api/2.0/nodes/kqbk78/blockdevices/3/'}]
2019-05-22 21:02:43,005 [salt.loaded.ext.module.maasng:632 ][INFO    ][22185] vgroot
2019-05-22 21:02:43,007 [salt.loaded.ext.module.maasng:635 ][INFO    ][22185] lvroot
2019-05-22 21:02:43,007 [salt.loaded.ext.module.maasng:639 ][INFO    ][22185] 107374182400
2019-05-22 21:02:43,595 [salt.loaded.ext.module.maasng:645 ][INFO    ][22185] {u'hwe_kernel': u'', u'testing_status_name': u'Passed', u'memory_test_status': -1, u'ip_addresses': [u'192.168.11.38', u'192.168.11.40'], u'cpu_count': 40, u'power_type': u'ipmi', u'domain': {u'resource_record_count': 0, u'name': u'maas', u'authoritative': True, u'ttl': None, u'id': 0, u'resource_uri': u'/MAAS/api/2.0/domains/0/'}, u'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': 2, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'frxkt8', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/', u'id': 5003, u'secondary_rack': None, u'fabric': u'pxe_admin'}, u'allow_proxy': True, u'rdns_mode': 2, u'gateway_ip': u'192.168.11.3', u'active_discovery': False, u'cidr': u'192.168.11.0/24', u'id': 3, u'resource_uri': u'/MAAS/api/2.0/subnets/3/'}, u'ip_address': u'192.168.11.38', u'id': 16, u'mode': u'dhcp'}], u'tags': [u'sriov'], u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 2, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'frxkt8', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/', u'id': 5003, u'secondary_rack': None, u'fabric': u'pxe_admin'}, u'enabled': True, u'id': 5, u'discovered': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 2, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'frxkt8', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/', u'id': 5003, u'secondary_rack': None, u'fabric': u'pxe_admin'}, u'allow_proxy': True, u'rdns_mode': 2, u'gateway_ip': u'192.168.11.3', u'active_discovery': False, u'cidr': u'192.168.11.0/24', u'id': 3, u'resource_uri': u'/MAAS/api/2.0/subnets/3/'}, u'ip_address': u'192.168.11.38'}], u'mac_address': u'9c:b6:54:8a:10:18', u'parents': [], u'effective_mtu': 1500, u'params': u'', u'system_id': u'kqbk78', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/kqbk78/interfaces/5/'}, u'node_type': 0, 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'status_action': u'', u'zone': {u'description': u'', u'resource_uri': u'/MAAS/api/2.0/zones/default/', u'name': u'default', u'id': 1}, u'resource_uri': u'/MAAS/api/2.0/machines/kqbk78/', u'node_type_name': u'Machine', u'hostname': u'cmp002', u'storage': 800109.715456, u'testing_status': 2, u'system_id': u'kqbk78', 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'owner_data': {}, u'blockdevice_set': [{u'size': 800109715456, u'resource_uri': u'/MAAS/api/2.0/nodes/kqbk78/blockdevices/1/', u'name': u'sda', u'tags': [u'ssd'], u'used_size': 800106479616, u'id': 1, u'uuid': None, u'used_for': u'MBR partitioned with 1 partition', u'path': u'/dev/disk/by-dname/sda', u'system_id': u'kqbk78', u'partition_table_type': u'MBR', u'filesystem': None, u'id_path': u'/dev/disk/by-id/wwn-0x600508b1001cb19198eb9a66f8a29401', u'available_size': 0, u'model': u'LOGICAL VOLUME', u'block_size': 4096, u'type': u'physical', u'serial': u'600508b1001cb19198eb9a66f8a29401', u'partitions': [{u'uuid': u'e0ff370b-4a70-476b-a8b5-adafd2f9680d', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'kqbk78', u'device_id': 1, u'filesystem': {u'mount_options': None, u'label': None, u'mount_point': None, u'uuid': u'52b4ce5a-c972-4598-9ca6-91b5d857d016', u'fstype': u'lvm-pv'}, u'path': u'/dev/disk/by-dname/sda-part1', u'resource_uri': u'/MAAS/api/2.0/nodes/kqbk78/blockdevices/1/partition/5', u'type': u'partition', u'id': 5, u'size': 800101236736}]}, {u'size': 107374182400, u'resource_uri': u'/MAAS/api/2.0/nodes/kqbk78/blockdevices/9/', u'name': u'vgroot-lvroot', u'tags': [], u'used_size': 107374182400, u'id': 9, u'uuid': u'721eb5b0-13fe-426c-8073-ac6eb780ca80', u'used_for': u'ext4 formatted filesystem mounted at /', u'path': u'/dev/disk/by-dname/lvroot', u'system_id': u'kqbk78', u'partition_table_type': None, u'filesystem': {u'mount_options': None, u'label': u'root', u'mount_point': u'/', u'uuid': u'ec7689e2-615f-4970-9fc1-061655fb0e9a', u'fstype': u'ext4'}, u'id_path': None, u'available_size': 0, u'model': None, u'block_size': 4096, u'type': u'virtual', u'serial': None, u'partitions': []}], u'status': 4, u'storage_test_status': 2, u'storage_test_status_name': u'Passed', u'raids': [], u'physicalblockdevice_set': [{u'size': 800109715456, u'resource_uri': u'/MAAS/api/2.0/nodes/kqbk78/blockdevices/1/', u'name': u'sda', u'tags': [u'ssd'], u'used_size': 800106479616, u'id': 1, u'uuid': None, u'used_for': u'MBR partitioned with 1 partition', u'path': u'/dev/disk/by-dname/sda', u'system_id': u'kqbk78', u'partition_table_type': u'MBR', u'filesystem': None, u'id_path': u'/dev/disk/by-id/wwn-0x600508b1001cb19198eb9a66f8a29401', u'available_size': 0, u'model': u'LOGICAL VOLUME', u'block_size': 4096, u'type': u'physical', u'serial': u'600508b1001cb19198eb9a66f8a29401', u'partitions': [{u'uuid': u'e0ff370b-4a70-476b-a8b5-adafd2f9680d', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'kqbk78', u'device_id': 1, u'filesystem': {u'mount_options': None, u'label': None, u'mount_point': None, u'uuid': u'52b4ce5a-c972-4598-9ca6-91b5d857d016', u'fstype': u'lvm-pv'}, u'path': u'/dev/disk/by-dname/sda-part1', u'resource_uri': u'/MAAS/api/2.0/nodes/kqbk78/blockdevices/1/partition/5', u'type': u'partition', u'id': 5, u'size': 800101236736}]}], u'memory_test_status_name': u'Unknown', u'other_test_status_name': u'Unknown', u'volume_groups': [{u'__incomplete__': True, u'system_id': u'kqbk78', u'id': 5}], u'special_filesystems': [], u'current_commissioning_result_id': 4, u'boot_disk': {u'size': 800109715456, u'resource_uri': u'/MAAS/api/2.0/nodes/kqbk78/blockdevices/1/', u'name': u'sda', u'tags': [u'ssd'], u'used_size': 800106479616, u'id': 1, u'uuid': None, u'used_for': u'MBR partitioned with 1 partition', u'path': u'/dev/disk/by-dname/sda', u'system_id': u'kqbk78', u'partition_table_type': u'MBR', u'filesystem': None, u'id_path': u'/dev/disk/by-id/wwn-0x600508b1001cb19198eb9a66f8a29401', u'available_size': 0, u'model': u'LOGICAL VOLUME', u'block_size': 4096, u'type': u'physical', u'serial': u'600508b1001cb19198eb9a66f8a29401', u'partitions': [{u'uuid': u'e0ff370b-4a70-476b-a8b5-adafd2f9680d', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'kqbk78', u'device_id': 1, u'filesystem': {u'mount_options': None, u'label': None, u'mount_point': None, u'uuid': u'52b4ce5a-c972-4598-9ca6-91b5d857d016', u'fstype': u'lvm-pv'}, u'path': u'/dev/disk/by-dname/sda-part1', u'resource_uri': u'/MAAS/api/2.0/nodes/kqbk78/blockdevices/1/partition/5', u'type': u'partition', u'id': 5, u'size': 800101236736}]}, u'current_testing_result_id': 5, u'cpu_test_status': -1, u'architecture': u'amd64/generic', u'bcaches': [], u'status_name': u'Ready', u'netboot': True, u'osystem': u'', u'fqdn': u'cmp002.maas', u'disable_ipv4': False, u'virtualblockdevice_set': [{u'size': 107374182400, u'resource_uri': u'/MAAS/api/2.0/nodes/kqbk78/blockdevices/9/', u'name': u'vgroot-lvroot', u'tags': [], u'used_size': 107374182400, u'id': 9, u'uuid': u'721eb5b0-13fe-426c-8073-ac6eb780ca80', u'used_for': u'ext4 formatted filesystem mounted at /', u'path': u'/dev/disk/by-dname/vgroot-lvroot', u'system_id': u'kqbk78', u'partition_table_type': None, u'filesystem': {u'mount_options': None, u'label': u'root', u'mount_point': u'/', u'uuid': u'ec7689e2-615f-4970-9fc1-061655fb0e9a', u'fstype': u'ext4'}, u'id_path': None, u'available_size': 0, u'model': None, u'block_size': 4096, u'type': u'virtual', u'serial': None, u'partitions': []}], u'commissioning_status': 2, u'min_hwe_kernel': u'hwe-16.04', 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': 2, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'frxkt8', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/', u'id': 5003, u'secondary_rack': None, u'fabric': u'pxe_admin'}, u'allow_proxy': True, u'rdns_mode': 2, u'gateway_ip': u'192.168.11.3', u'active_discovery': False, u'cidr': u'192.168.11.0/24', u'id': 3, u'resource_uri': u'/MAAS/api/2.0/subnets/3/'}, u'ip_address': u'192.168.11.38', u'id': 16, u'mode': u'dhcp'}], u'tags': [u'sriov'], u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 2, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'frxkt8', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/', u'id': 5003, u'secondary_rack': None, u'fabric': u'pxe_admin'}, u'enabled': True, u'id': 5, u'discovered': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 2, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'frxkt8', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/', u'id': 5003, u'secondary_rack': None, u'fabric': u'pxe_admin'}, u'allow_proxy': True, u'rdns_mode': 2, u'gateway_ip': u'192.168.11.3', u'active_discovery': False, u'cidr': u'192.168.11.0/24', u'id': 3, u'resource_uri': u'/MAAS/api/2.0/subnets/3/'}, u'ip_address': u'192.168.11.38'}], u'mac_address': u'9c:b6:54:8a:10:18', u'parents': [], u'effective_mtu': 1500, u'params': u'', u'system_id': u'kqbk78', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/kqbk78/interfaces/5/'}, {u'name': u'ens1f0', u'links': [], u'tags': [u'sriov'], u'vlan': None, u'enabled': True, u'id': 12, u'discovered': None, u'mac_address': u'38:ea:a7:8f:07:50', u'parents': [], u'effective_mtu': 1500, u'params': u'', u'system_id': u'kqbk78', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/kqbk78/interfaces/12/'}, {u'name': u'ens1f1', u'links': [], u'tags': [u'sriov'], u'vlan': None, u'enabled': True, u'id': 13, u'discovered': None, u'mac_address': u'38:ea:a7:8f:07:51', u'parents': [], u'effective_mtu': 1500, u'params': u'', u'system_id': u'kqbk78', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/kqbk78/interfaces/13/'}, {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': 2, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'frxkt8', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/', u'id': 5003, u'secondary_rack': None, u'fabric': u'pxe_admin'}, u'allow_proxy': True, u'rdns_mode': 2, u'gateway_ip': u'192.168.11.3', u'active_discovery': False, u'cidr': u'192.168.11.0/24', u'id': 3, u'resource_uri': u'/MAAS/api/2.0/subnets/3/'}, u'id': 17, u'mode': u'link_up'}], u'tags': [u'sriov'], u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 2, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'frxkt8', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/', u'id': 5003, u'secondary_rack': None, u'fabric': u'pxe_admin'}, u'enabled': True, u'id': 10, u'discovered': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 2, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'frxkt8', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/', u'id': 5003, u'secondary_rack': None, u'fabric': u'pxe_admin'}, u'allow_proxy': True, u'rdns_mode': 2, u'gateway_ip': u'192.168.11.3', u'active_discovery': False, u'cidr': u'192.168.11.0/24', u'id': 3, u'resource_uri': u'/MAAS/api/2.0/subnets/3/'}, u'ip_address': u'192.168.11.40'}], u'mac_address': u'9c:b6:54:8a:10:1c', u'parents': [], u'effective_mtu': 1500, u'params': u'', u'system_id': u'kqbk78', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/kqbk78/interfaces/10/'}, {u'name': u'ens2f1', u'links': [{u'id': 18, u'mode': u'link_up'}], u'tags': [u'sriov'], u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 0, u'dhcp_on': False, u'mtu': 1500, u'primary_rack': None, u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/', u'id': 5001, u'secondary_rack': None, u'fabric': u'fabric-0'}, u'enabled': True, u'id': 11, u'discovered': None, u'mac_address': u'38:ea:a7:8f:12:49', u'parents': [], u'effective_mtu': 1500, u'params': u'', u'system_id': u'kqbk78', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/kqbk78/interfaces/11/'}, {u'name': u'ens2f0', u'links': [{u'id': 19, u'mode': u'link_up'}], u'tags': [u'sriov'], u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 0, u'dhcp_on': False, u'mtu': 1500, u'primary_rack': None, u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/', u'id': 5001, u'secondary_rack': None, u'fabric': u'fabric-0'}, u'enabled': True, u'id': 14, u'discovered': None, u'mac_address': u'38:ea:a7:8f:12:48', u'parents': [], u'effective_mtu': 1500, u'params': u'', u'system_id': u'kqbk78', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/kqbk78/interfaces/14/'}], u'address_ttl': None, u'other_test_status': -1, u'distro_series': u'', u'commissioning_status_name': u'Passed'}
2019-05-22 21:02:43,599 [salt.state       :300 ][INFO    ][22185] {'new': {'storage_layout': 'lvm'}}
2019-05-22 21:02:43,600 [salt.state       :1951][INFO    ][22185] Completed state [maas_machines_storage_cmp002_lvm] at time 21:02:43.600175 duration_in_ms=2163.538
2019-05-22 21:02:43,600 [salt.state       :1780][INFO    ][22185] Running state [maas_machines_storage_cmp001_lvm] at time 21:02:43.600530
2019-05-22 21:02:43,600 [salt.state       :1813][INFO    ][22185] Executing state maasng.disk_layout_present for [maas_machines_storage_cmp001_lvm]
2019-05-22 21:02:44,664 [salt.loaded.ext.module.maasng:610 ][INFO    ][22185] sgcg7b
2019-05-22 21:02:44,665 [salt.loaded.ext.module.maasng:626 ][INFO    ][22185] sda
2019-05-22 21:02:45,171 [salt.loaded.ext.module.maasng:361 ][INFO    ][22185] sgcg7b
2019-05-22 21:02:45,271 [salt.loaded.ext.module.maasng:367 ][INFO    ][22185] [{u'model': u'LOGICAL VOLUME', u'partition_table_type': u'MBR', u'block_size': 4096, u'available_size': 0, u'name': u'sda', u'tags': [u'ssd'], u'used_size': 800106479616, u'uuid': None, u'used_for': u'MBR partitioned with 1 partition', u'system_id': u'sgcg7b', u'resource_uri': u'/MAAS/api/2.0/nodes/sgcg7b/blockdevices/2/', u'filesystem': None, u'id_path': u'/dev/disk/by-id/wwn-0x600508b1001cd7e61f5cd3479576479e', u'path': u'/dev/disk/by-dname/sda', u'serial': u'600508b1001cd7e61f5cd3479576479e', u'size': 800109715456, u'type': u'physical', u'id': 2, u'partitions': [{u'size': 800101236736, u'uuid': u'92d010cd-aadd-4c07-8e13-10944458c774', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'sgcg7b', u'filesystem': {u'mount_options': None, u'mount_point': None, u'uuid': u'60f224e6-d796-4c4a-b8c2-8b4fd034e615', u'fstype': u'lvm-pv', u'label': None}, u'path': u'/dev/disk/by-dname/sda-part1', u'device_id': 2, u'type': u'partition', u'id': 2, u'resource_uri': u'/MAAS/api/2.0/nodes/sgcg7b/blockdevices/2/partition/2'}]}, {u'model': None, u'partition_table_type': None, u'block_size': 4096, u'available_size': 0, u'name': u'vgroot-lvroot', u'tags': [], u'used_size': 800097042432, u'uuid': u'2ada4e95-d20d-42b2-bdb6-1b91707ed639', u'used_for': u'ext4 formatted filesystem mounted at /', u'system_id': u'sgcg7b', u'resource_uri': u'/MAAS/api/2.0/nodes/sgcg7b/blockdevices/4/', u'filesystem': {u'mount_options': None, u'mount_point': u'/', u'uuid': u'811b4c0d-5401-4cb2-ad24-51f4a3bac5b4', u'fstype': u'ext4', u'label': u'root'}, u'id_path': None, u'path': u'/dev/disk/by-dname/lvroot', u'serial': None, u'size': 800097042432, u'type': u'virtual', u'id': 4, u'partitions': []}]
2019-05-22 21:02:45,272 [salt.loaded.ext.module.maasng:632 ][INFO    ][22185] vgroot
2019-05-22 21:02:45,272 [salt.loaded.ext.module.maasng:635 ][INFO    ][22185] lvroot
2019-05-22 21:02:45,272 [salt.loaded.ext.module.maasng:639 ][INFO    ][22185] 107374182400
2019-05-22 21:02:45,884 [salt.loaded.ext.module.maasng:645 ][INFO    ][22185] {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'swap_size': None, u'ip_addresses': [u'192.168.11.39', u'192.168.11.43'], u'cpu_count': 40, u'power_type': u'ipmi', u'hwe_kernel': u'', u'memory_test_status_name': u'Unknown', u'fqdn': u'cmp001.maas', u'node_type': 0, u'tag_names': [], u'testing_status_name': u'Passed', u'owner': None, u'pod': None, u'cache_sets': [], u'cpu_test_status_name': u'Unknown', u'iscsiblockdevice_set': [], u'boot_disk': {u'size': 800109715456, u'model': u'LOGICAL VOLUME', u'partition_table_type': u'MBR', u'block_size': 4096, u'available_size': 0, u'name': u'sda', u'tags': [u'ssd'], u'used_size': 800106479616, u'used_for': u'MBR partitioned with 1 partition', u'system_id': u'sgcg7b', u'resource_uri': u'/MAAS/api/2.0/nodes/sgcg7b/blockdevices/2/', u'filesystem': None, u'id_path': u'/dev/disk/by-id/wwn-0x600508b1001cd7e61f5cd3479576479e', u'path': u'/dev/disk/by-dname/sda', u'serial': u'600508b1001cd7e61f5cd3479576479e', u'partitions': [{u'size': 800101236736, u'uuid': u'e090b92e-e6fd-49bd-b922-b49f0c396a03', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'sgcg7b', u'filesystem': {u'mount_options': None, u'mount_point': None, u'uuid': u'a3038e3a-222e-40bd-8899-fbd187d211ac', u'fstype': u'lvm-pv', u'label': None}, u'path': u'/dev/disk/by-dname/sda-part1', u'device_id': 2, u'type': u'partition', u'id': 6, u'resource_uri': u'/MAAS/api/2.0/nodes/sgcg7b/blockdevices/2/partition/6'}], u'type': u'physical', u'id': 2, u'uuid': None}, u'zone': {u'id': 1, u'resource_uri': u'/MAAS/api/2.0/zones/default/', u'name': u'default', u'description': u''}, u'node_type_name': u'Machine', u'hostname': u'cmp001', u'storage': 800109.715456, u'testing_status': 2, u'system_id': u'sgcg7b', 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'disable_ipv4': False, u'blockdevice_set': [{u'model': u'LOGICAL VOLUME', u'partition_table_type': u'MBR', u'block_size': 4096, u'available_size': 0, u'name': u'sda', u'tags': [u'ssd'], u'used_size': 800106479616, u'uuid': None, u'used_for': u'MBR partitioned with 1 partition', u'system_id': u'sgcg7b', u'resource_uri': u'/MAAS/api/2.0/nodes/sgcg7b/blockdevices/2/', u'filesystem': None, u'id_path': u'/dev/disk/by-id/wwn-0x600508b1001cd7e61f5cd3479576479e', u'path': u'/dev/disk/by-dname/sda', u'serial': u'600508b1001cd7e61f5cd3479576479e', u'size': 800109715456, u'type': u'physical', u'id': 2, u'partitions': [{u'size': 800101236736, u'uuid': u'e090b92e-e6fd-49bd-b922-b49f0c396a03', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'sgcg7b', u'filesystem': {u'mount_options': None, u'mount_point': None, u'uuid': u'a3038e3a-222e-40bd-8899-fbd187d211ac', u'fstype': u'lvm-pv', u'label': None}, u'path': u'/dev/disk/by-dname/sda-part1', u'device_id': 2, u'type': u'partition', u'id': 6, u'resource_uri': u'/MAAS/api/2.0/nodes/sgcg7b/blockdevices/2/partition/6'}]}, {u'model': None, u'partition_table_type': None, u'block_size': 4096, u'available_size': 0, u'name': u'vgroot-lvroot', u'tags': [], u'used_size': 107374182400, u'uuid': u'cdde9b67-1d19-4b17-9884-2dd2782b5866', u'used_for': u'ext4 formatted filesystem mounted at /', u'system_id': u'sgcg7b', u'resource_uri': u'/MAAS/api/2.0/nodes/sgcg7b/blockdevices/10/', u'filesystem': {u'mount_options': None, u'mount_point': u'/', u'uuid': u'a8f401bb-470b-4eb9-a95e-4e6564a248cb', u'fstype': u'ext4', u'label': u'root'}, u'id_path': None, u'path': u'/dev/disk/by-dname/lvroot', u'serial': None, u'size': 107374182400, u'type': u'virtual', u'id': 10, u'partitions': []}], u'status': 4, u'storage_test_status': 2, u'storage_test_status_name': u'Passed', u'power_state': u'off', u'physicalblockdevice_set': [{u'size': 800109715456, u'model': u'LOGICAL VOLUME', u'partition_table_type': u'MBR', u'block_size': 4096, u'available_size': 0, u'name': u'sda', u'tags': [u'ssd'], u'used_size': 800106479616, u'used_for': u'MBR partitioned with 1 partition', u'system_id': u'sgcg7b', u'resource_uri': u'/MAAS/api/2.0/nodes/sgcg7b/blockdevices/2/', u'filesystem': None, u'id_path': u'/dev/disk/by-id/wwn-0x600508b1001cd7e61f5cd3479576479e', u'path': u'/dev/disk/by-dname/sda', u'serial': u'600508b1001cd7e61f5cd3479576479e', u'partitions': [{u'size': 800101236736, u'uuid': u'e090b92e-e6fd-49bd-b922-b49f0c396a03', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'sgcg7b', u'filesystem': {u'mount_options': None, u'mount_point': None, u'uuid': u'a3038e3a-222e-40bd-8899-fbd187d211ac', u'fstype': u'lvm-pv', u'label': None}, u'path': u'/dev/disk/by-dname/sda-part1', u'device_id': 2, u'type': u'partition', u'id': 6, u'resource_uri': u'/MAAS/api/2.0/nodes/sgcg7b/blockdevices/2/partition/6'}], u'type': u'physical', u'id': 2, u'uuid': None}], u'other_test_status_name': u'Unknown', u'owner_data': {}, u'volume_groups': [{u'__incomplete__': True, u'system_id': u'sgcg7b', u'id': 6}], u'special_filesystems': [], u'current_commissioning_result_id': 6, 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'dhcp_on': True, u'fabric_id': 2, u'mtu': 1500, u'external_dhcp': None, u'relay_vlan': None, u'primary_rack': u'frxkt8', u'resource_uri': u'/MAAS/api/2.0/vlans/5003/', u'id': 5003, u'secondary_rack': None, u'fabric': u'pxe_admin'}, u'allow_proxy': True, u'rdns_mode': 2, u'gateway_ip': u'192.168.11.3', u'active_discovery': False, u'cidr': u'192.168.11.0/24', u'id': 3, u'resource_uri': u'/MAAS/api/2.0/subnets/3/'}, u'ip_address': u'192.168.11.39', u'mode': u'dhcp', u'id': 22}], u'tags': [u'sriov'], u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'dhcp_on': True, u'fabric_id': 2, u'mtu': 1500, u'external_dhcp': None, u'relay_vlan': None, u'primary_rack': u'frxkt8', u'resource_uri': u'/MAAS/api/2.0/vlans/5003/', u'id': 5003, u'secondary_rack': None, u'fabric': u'pxe_admin'}, u'enabled': True, 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'dhcp_on': True, u'fabric_id': 2, u'mtu': 1500, u'external_dhcp': None, u'relay_vlan': None, u'primary_rack': u'frxkt8', u'resource_uri': u'/MAAS/api/2.0/vlans/5003/', u'id': 5003, u'secondary_rack': None, u'fabric': u'pxe_admin'}, u'allow_proxy': True, u'rdns_mode': 2, u'gateway_ip': u'192.168.11.3', u'active_discovery': False, u'cidr': u'192.168.11.0/24', u'id': 3, u'resource_uri': u'/MAAS/api/2.0/subnets/3/'}, u'ip_address': u'192.168.11.39'}], u'mac_address': u'9c:b6:54:8a:95:a0', u'parents': [], u'effective_mtu': 1500, u'params': u'', u'system_id': u'sgcg7b', u'type': u'physical', u'id': 6, u'resource_uri': u'/MAAS/api/2.0/nodes/sgcg7b/interfaces/6/'}, u'current_testing_result_id': 7, u'cpu_test_status': -1, u'architecture': u'amd64/generic', u'bcaches': [], u'other_test_status': -1, u'status_name': u'Ready', u'netboot': True, u'osystem': u'', u'status_action': u'', u'virtualblockdevice_set': [{u'size': 107374182400, u'model': None, u'partition_table_type': None, u'block_size': 4096, u'available_size': 0, u'name': u'vgroot-lvroot', u'tags': [], u'used_size': 107374182400, u'used_for': u'ext4 formatted filesystem mounted at /', u'system_id': u'sgcg7b', u'resource_uri': u'/MAAS/api/2.0/nodes/sgcg7b/blockdevices/10/', u'filesystem': {u'mount_options': None, u'mount_point': u'/', u'uuid': u'a8f401bb-470b-4eb9-a95e-4e6564a248cb', u'fstype': u'ext4', u'label': u'root'}, u'id_path': None, u'path': u'/dev/disk/by-dname/vgroot-lvroot', u'serial': None, u'partitions': [], u'type': u'virtual', u'id': 10, u'uuid': u'cdde9b67-1d19-4b17-9884-2dd2782b5866'}], u'commissioning_status': 2, u'min_hwe_kernel': u'hwe-16.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'dhcp_on': True, u'fabric_id': 2, u'mtu': 1500, u'external_dhcp': None, u'relay_vlan': None, u'primary_rack': u'frxkt8', u'resource_uri': u'/MAAS/api/2.0/vlans/5003/', u'id': 5003, u'secondary_rack': None, u'fabric': u'pxe_admin'}, u'allow_proxy': True, u'rdns_mode': 2, u'gateway_ip': u'192.168.11.3', u'active_discovery': False, u'cidr': u'192.168.11.0/24', u'id': 3, u'resource_uri': u'/MAAS/api/2.0/subnets/3/'}, u'ip_address': u'192.168.11.39', u'mode': u'dhcp', u'id': 22}], u'tags': [u'sriov'], u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'dhcp_on': True, u'fabric_id': 2, u'mtu': 1500, u'external_dhcp': None, u'relay_vlan': None, u'primary_rack': u'frxkt8', u'resource_uri': u'/MAAS/api/2.0/vlans/5003/', u'id': 5003, u'secondary_rack': None, u'fabric': u'pxe_admin'}, u'enabled': True, 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'dhcp_on': True, u'fabric_id': 2, u'mtu': 1500, u'external_dhcp': None, u'relay_vlan': None, u'primary_rack': u'frxkt8', u'resource_uri': u'/MAAS/api/2.0/vlans/5003/', u'id': 5003, u'secondary_rack': None, u'fabric': u'pxe_admin'}, u'allow_proxy': True, u'rdns_mode': 2, u'gateway_ip': u'192.168.11.3', u'active_discovery': False, u'cidr': u'192.168.11.0/24', u'id': 3, u'resource_uri': u'/MAAS/api/2.0/subnets/3/'}, u'ip_address': u'192.168.11.39'}], u'mac_address': u'9c:b6:54:8a:95:a0', u'parents': [], u'effective_mtu': 1500, u'params': u'', u'system_id': u'sgcg7b', u'type': u'physical', u'id': 6, u'resource_uri': u'/MAAS/api/2.0/nodes/sgcg7b/interfaces/6/'}, {u'name': u'ens1f0', u'links': [], u'tags': [u'sriov'], u'vlan': None, u'enabled': True, u'children': [], u'discovered': None, u'mac_address': u'38:ea:a7:8f:1f:d4', u'parents': [], u'effective_mtu': 1500, u'params': u'', u'system_id': u'sgcg7b', u'type': u'physical', u'id': 15, u'resource_uri': u'/MAAS/api/2.0/nodes/sgcg7b/interfaces/15/'}, {u'name': u'ens1f1', u'links': [], u'tags': [u'sriov'], u'vlan': None, u'enabled': True, u'children': [], u'discovered': None, u'mac_address': u'38:ea:a7:8f:1f:d5', u'parents': [], u'effective_mtu': 1500, u'params': u'', u'system_id': u'sgcg7b', u'type': u'physical', u'id': 16, u'resource_uri': u'/MAAS/api/2.0/nodes/sgcg7b/interfaces/16/'}, {u'name': u'ens2f0', u'links': [{u'mode': u'link_up', u'id': 23}], u'tags': [u'sriov'], u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'dhcp_on': False, u'fabric_id': 0, u'mtu': 1500, u'external_dhcp': None, u'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'enabled': True, u'children': [], u'discovered': None, u'mac_address': u'38:ea:a7:8f:52:cc', u'parents': [], u'effective_mtu': 1500, u'params': u'', u'system_id': u'sgcg7b', u'type': u'physical', u'id': 17, u'resource_uri': u'/MAAS/api/2.0/nodes/sgcg7b/interfaces/17/'}, {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'dhcp_on': True, u'fabric_id': 2, u'mtu': 1500, u'external_dhcp': None, u'relay_vlan': None, u'primary_rack': u'frxkt8', u'resource_uri': u'/MAAS/api/2.0/vlans/5003/', u'id': 5003, u'secondary_rack': None, u'fabric': u'pxe_admin'}, u'allow_proxy': True, u'rdns_mode': 2, u'gateway_ip': u'192.168.11.3', u'active_discovery': False, u'cidr': u'192.168.11.0/24', u'id': 3, u'resource_uri': u'/MAAS/api/2.0/subnets/3/'}, u'mode': u'link_up', u'id': 24}], u'tags': [u'sriov'], u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'dhcp_on': True, u'fabric_id': 2, u'mtu': 1500, u'external_dhcp': None, u'relay_vlan': None, u'primary_rack': u'frxkt8', u'resource_uri': u'/MAAS/api/2.0/vlans/5003/', u'id': 5003, u'secondary_rack': None, u'fabric': u'pxe_admin'}, u'enabled': True, 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'dhcp_on': True, u'fabric_id': 2, u'mtu': 1500, u'external_dhcp': None, u'relay_vlan': None, u'primary_rack': u'frxkt8', u'resource_uri': u'/MAAS/api/2.0/vlans/5003/', u'id': 5003, u'secondary_rack': None, u'fabric': u'pxe_admin'}, u'allow_proxy': True, u'rdns_mode': 2, u'gateway_ip': u'192.168.11.3', u'active_discovery': False, u'cidr': u'192.168.11.0/24', u'id': 3, u'resource_uri': u'/MAAS/api/2.0/subnets/3/'}, u'ip_address': u'192.168.11.43'}], u'mac_address': u'9c:b6:54:8a:95:a4', u'parents': [], u'effective_mtu': 1500, u'params': u'', u'system_id': u'sgcg7b', u'type': u'physical', u'id': 18, u'resource_uri': u'/MAAS/api/2.0/nodes/sgcg7b/interfaces/18/'}, {u'name': u'ens2f1', u'links': [{u'mode': u'link_up', u'id': 25}], u'tags': [u'sriov'], u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'dhcp_on': False, u'fabric_id': 0, u'mtu': 1500, u'external_dhcp': None, u'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'enabled': True, u'children': [], u'discovered': None, u'mac_address': u'38:ea:a7:8f:52:cd', u'parents': [], u'effective_mtu': 1500, u'params': u'', u'system_id': u'sgcg7b', u'type': u'physical', u'id': 19, u'resource_uri': u'/MAAS/api/2.0/nodes/sgcg7b/interfaces/19/'}], u'address_ttl': None, u'memory_test_status': -1, u'distro_series': u'', u'resource_uri': u'/MAAS/api/2.0/machines/sgcg7b/'}
2019-05-22 21:02:45,886 [salt.state       :300 ][INFO    ][22185] {'new': {'storage_layout': 'lvm'}}
2019-05-22 21:02:45,886 [salt.state       :1951][INFO    ][22185] Completed state [maas_machines_storage_cmp001_lvm] at time 21:02:45.886682 duration_in_ms=2286.151
2019-05-22 21:02:45,891 [salt.minion      :1711][INFO    ][22185] Returning information for job: 20190522210231719990
2019-05-22 21:02:46,468 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command state.apply with jid 20190522210246452166
2019-05-22 21:02:46,495 [salt.minion      :1432][INFO    ][22214] Starting a new job with PID 22214
2019-05-22 21:02:47,542 [salt.state       :915 ][INFO    ][22214] Loading fresh modules for state activity
2019-05-22 21:02:47,608 [salt.fileclient  :1219][INFO    ][22214] Fetching file from saltenv 'base', ** done ** 'maas/machines/deploy.sls'
2019-05-22 21:02:47,663 [salt.state       :1780][INFO    ][22214] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 21:02:47.663357
2019-05-22 21:02:47,663 [salt.state       :1813][INFO    ][22214] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2019-05-22 21:02:47,665 [salt.loaded.int.module.cmdmod:395 ][INFO    ][22214] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2019-05-22 21:02:49,474 [salt.state       :300 ][INFO    ][22214] {'pid': 22221, 'retcode': 0, 'stderr': '', 'stdout': ''}
2019-05-22 21:02:49,475 [salt.state       :1951][INFO    ][22214] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 21:02:49.475543 duration_in_ms=1812.185
2019-05-22 21:02:49,480 [salt.state       :1780][INFO    ][22214] Running state [maas.deploy_machines] at time 21:02:49.479933
2019-05-22 21:02:49,480 [salt.state       :1813][INFO    ][22214] Executing state module.run for [maas.deploy_machines]
2019-05-22 21:02:49,481 [salt.utils.decorators:613 ][WARNING ][22214] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-05-22 21:02:49,991 [salt.loaded.ext.module.maas:684 ][INFO    ][22214] deploymachines hwe_kernel=hwe-16.04 system_id=f4fxmn distro_series=xenial
2019-05-22 21:02:56,317 [salt.loaded.ext.module.maas:684 ][INFO    ][22214] deploymachines hwe_kernel=hwe-16.04 system_id=kqbk78 distro_series=xenial
2019-05-22 21:03:01,596 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522210301582196
2019-05-22 21:03:01,620 [salt.minion      :1432][INFO    ][22327] Starting a new job with PID 22327
2019-05-22 21:03:01,643 [salt.minion      :1711][INFO    ][22327] Returning information for job: 20190522210301582196
2019-05-22 21:03:02,691 [salt.loaded.ext.module.maas:684 ][INFO    ][22214] deploymachines hwe_kernel=hwe-16.04 system_id=sgcg7b distro_series=xenial
2019-05-22 21:03:09,039 [salt.loaded.ext.module.maas:684 ][INFO    ][22214] deploymachines hwe_kernel=hwe-16.04 system_id=8dm84m distro_series=xenial
2019-05-22 21:03:15,485 [salt.state       :300 ][INFO    ][22214] {'ret': {'updated': [], 'errors': {}, 'success': ['gtw01', 'cmp002', 'cmp001', 'ctl01']}}
2019-05-22 21:03:15,486 [salt.state       :1951][INFO    ][22214] Completed state [maas.deploy_machines] at time 21:03:15.486098 duration_in_ms=26006.164
2019-05-22 21:03:15,489 [salt.minion      :1711][INFO    ][22214] Returning information for job: 20190522210246452166
2019-05-22 21:03:16,064 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command state.apply with jid 20190522210316053198
2019-05-22 21:03:16,093 [salt.minion      :1432][INFO    ][22463] Starting a new job with PID 22463
2019-05-22 21:03:23,807 [salt.state       :915 ][INFO    ][22463] Loading fresh modules for state activity
2019-05-22 21:03:23,862 [salt.fileclient  :1219][INFO    ][22463] Fetching file from saltenv 'base', ** done ** 'maas/machines/wait_for_deployed.sls'
2019-05-22 21:03:23,908 [salt.state       :1780][INFO    ][22463] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 21:03:23.907992
2019-05-22 21:03:23,908 [salt.state       :1813][INFO    ][22463] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2019-05-22 21:03:23,910 [salt.loaded.int.module.cmdmod:395 ][INFO    ][22463] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2019-05-22 21:03:25,628 [salt.state       :300 ][INFO    ][22463] {'pid': 22476, 'retcode': 0, 'stderr': '', 'stdout': ''}
2019-05-22 21:03:25,629 [salt.state       :1951][INFO    ][22463] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 21:03:25.629206 duration_in_ms=1721.214
2019-05-22 21:03:25,632 [salt.state       :1780][INFO    ][22463] Running state [maas.wait_for_machine_status] at time 21:03:25.632668
2019-05-22 21:03:25,633 [salt.state       :1813][INFO    ][22463] Executing state module.run for [maas.wait_for_machine_status]
2019-05-22 21:03:25,634 [salt.utils.decorators:613 ][WARNING ][22463] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-05-22 21:03:27,680 [salt.loaded.ext.module.maas:1023][INFO    ][22463] Waiting status:Deployed for machines:['gtw01', 'cmp002', 'cmp001', 'ctl01']
sleep for:30s Timeout:2250s (2247.97154403s left)
2019-05-22 21:03:31,121 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522210331108124
2019-05-22 21:03:31,148 [salt.minion      :1432][INFO    ][22516] Starting a new job with PID 22516
2019-05-22 21:03:31,172 [salt.minion      :1711][INFO    ][22516] Returning information for job: 20190522210331108124
2019-05-22 21:03:59,676 [salt.loaded.ext.module.maas:1023][INFO    ][22463] Waiting status:Deployed for machines:['gtw01', 'cmp002', 'cmp001', 'ctl01']
sleep for:30s Timeout:2250s (2215.97496915s left)
2019-05-22 21:04:01,210 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522210401192150
2019-05-22 21:04:01,243 [salt.minion      :1432][INFO    ][22541] Starting a new job with PID 22541
2019-05-22 21:04:01,269 [salt.minion      :1711][INFO    ][22541] Returning information for job: 20190522210401192150
2019-05-22 21:04:31,315 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522210431302466
2019-05-22 21:04:31,340 [salt.minion      :1432][INFO    ][22598] Starting a new job with PID 22598
2019-05-22 21:04:31,362 [salt.minion      :1711][INFO    ][22598] Returning information for job: 20190522210431302466
2019-05-22 21:04:31,587 [salt.loaded.ext.module.maas:1023][INFO    ][22463] Waiting status:Deployed for machines:['gtw01', 'cmp002', 'cmp001', 'ctl01']
sleep for:30s Timeout:2250s (2184.06423521s left)
2019-05-22 21:05:01,389 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522210501376089
2019-05-22 21:05:01,414 [salt.minion      :1432][INFO    ][22613] Starting a new job with PID 22613
2019-05-22 21:05:01,438 [salt.minion      :1711][INFO    ][22613] Returning information for job: 20190522210501376089
2019-05-22 21:05:03,837 [salt.loaded.ext.module.maas:1023][INFO    ][22463] Waiting status:Deployed for machines:['gtw01', 'cmp002', 'cmp001', 'ctl01']
sleep for:30s Timeout:2250s (2151.81382513s left)
2019-05-22 21:05:31,465 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522210531457503
2019-05-22 21:05:31,486 [salt.minion      :1432][INFO    ][22669] Starting a new job with PID 22669
2019-05-22 21:05:31,508 [salt.minion      :1711][INFO    ][22669] Returning information for job: 20190522210531457503
2019-05-22 21:05:35,724 [salt.loaded.ext.module.maas:1023][INFO    ][22463] Waiting status:Deployed for machines:['gtw01', 'cmp002', 'cmp001', 'ctl01']
sleep for:30s Timeout:2250s (2119.92701221s left)
2019-05-22 21:06:01,554 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522210601536866
2019-05-22 21:06:01,584 [salt.minion      :1432][INFO    ][22709] Starting a new job with PID 22709
2019-05-22 21:06:01,614 [salt.minion      :1711][INFO    ][22709] Returning information for job: 20190522210601536866
2019-05-22 21:06:07,705 [salt.loaded.ext.module.maas:1023][INFO    ][22463] Waiting status:Deployed for machines:['gtw01', 'cmp002', 'cmp001', 'ctl01']
sleep for:30s Timeout:2250s (2087.94662213s left)
2019-05-22 21:06:31,676 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522210631665025
2019-05-22 21:06:31,703 [salt.minion      :1432][INFO    ][22908] Starting a new job with PID 22908
2019-05-22 21:06:31,724 [salt.minion      :1711][INFO    ][22908] Returning information for job: 20190522210631665025
2019-05-22 21:06:39,527 [salt.loaded.ext.module.maas:1023][INFO    ][22463] Waiting status:Deployed for machines:['gtw01', 'cmp002', 'cmp001', 'ctl01']
sleep for:30s Timeout:2250s (2056.12448502s left)
2019-05-22 21:07:01,781 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522210701765577
2019-05-22 21:07:01,806 [salt.minion      :1432][INFO    ][22959] Starting a new job with PID 22959
2019-05-22 21:07:01,830 [salt.minion      :1711][INFO    ][22959] Returning information for job: 20190522210701765577
2019-05-22 21:07:11,518 [salt.loaded.ext.module.maas:1023][INFO    ][22463] Waiting status:Deployed for machines:['gtw01', 'cmp002', 'cmp001', 'ctl01']
sleep for:30s Timeout:2250s (2024.13311505s left)
2019-05-22 21:07:16,494 [salt.utils.schedule:1377][INFO    ][2964] Running scheduled job: __mine_interval
2019-05-22 21:07:31,913 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522210731901378
2019-05-22 21:07:31,940 [salt.minion      :1432][INFO    ][23286] Starting a new job with PID 23286
2019-05-22 21:07:31,967 [salt.minion      :1711][INFO    ][23286] Returning information for job: 20190522210731901378
2019-05-22 21:08:02,083 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522210802072569
2019-05-22 21:08:02,108 [salt.minion      :1432][INFO    ][23406] Starting a new job with PID 23406
2019-05-22 21:08:02,136 [salt.minion      :1711][INFO    ][23406] Returning information for job: 20190522210802072569
2019-05-22 21:08:32,288 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522210832277033
2019-05-22 21:08:32,314 [salt.minion      :1432][INFO    ][23611] Starting a new job with PID 23611
2019-05-22 21:08:32,349 [salt.minion      :1711][INFO    ][23611] Returning information for job: 20190522210832277033
2019-05-22 21:09:02,476 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522210902462978
2019-05-22 21:09:02,503 [salt.minion      :1432][INFO    ][23697] Starting a new job with PID 23697
2019-05-22 21:09:02,531 [salt.minion      :1711][INFO    ][23697] Returning information for job: 20190522210902462978
2019-05-22 21:09:32,688 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522210932675961
2019-05-22 21:09:32,712 [salt.minion      :1432][INFO    ][23927] Starting a new job with PID 23927
2019-05-22 21:09:32,742 [salt.minion      :1711][INFO    ][23927] Returning information for job: 20190522210932675961
2019-05-22 21:10:02,912 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522211002889201
2019-05-22 21:10:02,934 [salt.minion      :1432][INFO    ][24182] Starting a new job with PID 24182
2019-05-22 21:10:02,962 [salt.minion      :1711][INFO    ][24182] Returning information for job: 20190522211002889201
2019-05-22 21:10:03,377 [salt.loaded.ext.module.maas:1023][INFO    ][22463] Waiting status:Deployed for machines:['gtw01', 'cmp002', 'cmp001', 'ctl01']
sleep for:30s Timeout:2250s (1852.27458s left)
2019-05-22 21:10:33,087 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522211033070261
2019-05-22 21:10:33,111 [salt.minion      :1432][INFO    ][24488] Starting a new job with PID 24488
2019-05-22 21:10:33,137 [salt.minion      :1711][INFO    ][24488] Returning information for job: 20190522211033070261
2019-05-22 21:10:35,418 [salt.loaded.ext.module.maas:1023][INFO    ][22463] Waiting status:Deployed for machines:['gtw01', 'cmp002', 'cmp001', 'ctl01']
sleep for:30s Timeout:2250s (1820.23354411s left)
2019-05-22 21:11:03,251 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522211103236262
2019-05-22 21:11:03,283 [salt.minion      :1432][INFO    ][24520] Starting a new job with PID 24520
2019-05-22 21:11:03,313 [salt.minion      :1711][INFO    ][24520] Returning information for job: 20190522211103236262
2019-05-22 21:11:07,432 [salt.loaded.ext.module.maas:1023][INFO    ][22463] Waiting status:Deployed for machines:['gtw01', 'cmp002', 'cmp001', 'ctl01']
sleep for:30s Timeout:2250s (1788.21967912s left)
2019-05-22 21:11:33,404 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522211133391030
2019-05-22 21:11:33,432 [salt.minion      :1432][INFO    ][24577] Starting a new job with PID 24577
2019-05-22 21:11:33,473 [salt.minion      :1711][INFO    ][24577] Returning information for job: 20190522211133391030
2019-05-22 21:11:39,687 [salt.loaded.ext.module.maas:1023][INFO    ][22463] Waiting status:Deployed for machines:['gtw01', 'cmp002', 'cmp001', 'ctl01']
sleep for:30s Timeout:2250s (1755.96415615s left)
2019-05-22 21:12:03,589 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522211203574974
2019-05-22 21:12:03,622 [salt.minion      :1432][INFO    ][24596] Starting a new job with PID 24596
2019-05-22 21:12:03,648 [salt.minion      :1711][INFO    ][24596] Returning information for job: 20190522211203574974
2019-05-22 21:12:11,608 [salt.loaded.ext.module.maas:1023][INFO    ][22463] Waiting status:Deployed for machines:['gtw01', 'cmp002', 'cmp001', 'ctl01']
sleep for:30s Timeout:2250s (1724.04295301s left)
2019-05-22 21:12:33,744 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522211233731370
2019-05-22 21:12:33,773 [salt.minion      :1432][INFO    ][24725] Starting a new job with PID 24725
2019-05-22 21:12:33,799 [salt.minion      :1711][INFO    ][24725] Returning information for job: 20190522211233731370
2019-05-22 21:12:43,583 [salt.loaded.ext.module.maas:1023][INFO    ][22463] Waiting status:Deployed for machines:['gtw01', 'cmp001', 'ctl01']
sleep for:30s Timeout:2250s (1692.0686481s left)
2019-05-22 21:13:03,930 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522211303916301
2019-05-22 21:13:03,963 [salt.minion      :1432][INFO    ][24757] Starting a new job with PID 24757
2019-05-22 21:13:03,991 [salt.minion      :1711][INFO    ][24757] Returning information for job: 20190522211303916301
2019-05-22 21:13:15,593 [salt.loaded.ext.module.maas:1023][INFO    ][22463] Waiting status:Deployed for machines:['gtw01', 'cmp001', 'ctl01']
sleep for:30s Timeout:2250s (1660.05828214s left)
2019-05-22 21:13:34,148 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522211334138332
2019-05-22 21:13:34,175 [salt.minion      :1432][INFO    ][24970] Starting a new job with PID 24970
2019-05-22 21:13:34,199 [salt.minion      :1711][INFO    ][24970] Returning information for job: 20190522211334138332
2019-05-22 21:13:47,581 [salt.loaded.ext.module.maas:1023][INFO    ][22463] Waiting status:Deployed for machines:['gtw01', 'ctl01']
sleep for:30s Timeout:2250s (1628.07061601s left)
2019-05-22 21:14:04,340 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522211404323539
2019-05-22 21:14:04,371 [salt.minion      :1432][INFO    ][25000] Starting a new job with PID 25000
2019-05-22 21:14:04,398 [salt.minion      :1711][INFO    ][25000] Returning information for job: 20190522211404323539
2019-05-22 21:14:19,720 [salt.loaded.ext.module.maas:1023][INFO    ][22463] Waiting status:Deployed for machines:['gtw01', 'ctl01']
sleep for:30s Timeout:2250s (1595.93136621s left)
2019-05-22 21:14:34,536 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522211434519690
2019-05-22 21:14:34,565 [salt.minion      :1432][INFO    ][25104] Starting a new job with PID 25104
2019-05-22 21:14:34,588 [salt.minion      :1711][INFO    ][25104] Returning information for job: 20190522211434519690
2019-05-22 21:14:51,724 [salt.loaded.ext.module.maas:1023][INFO    ][22463] Waiting status:Deployed for machines:['gtw01', 'ctl01']
sleep for:30s Timeout:2250s (1563.92764616s left)
2019-05-22 21:15:04,732 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522211504718148
2019-05-22 21:15:04,762 [salt.minion      :1432][INFO    ][25122] Starting a new job with PID 25122
2019-05-22 21:15:04,785 [salt.minion      :1711][INFO    ][25122] Returning information for job: 20190522211504718148
2019-05-22 21:15:23,852 [salt.loaded.ext.module.maas:1023][INFO    ][22463] Waiting status:Deployed for machines:['gtw01', 'ctl01']
sleep for:30s Timeout:2250s (1531.79928422s left)
2019-05-22 21:15:34,917 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522211534902653
2019-05-22 21:15:34,939 [salt.minion      :1432][INFO    ][25174] Starting a new job with PID 25174
2019-05-22 21:15:34,964 [salt.minion      :1711][INFO    ][25174] Returning information for job: 20190522211534902653
2019-05-22 21:15:55,840 [salt.loaded.ext.module.maas:1023][INFO    ][22463] Waiting status:Deployed for machines:['gtw01', 'ctl01']
sleep for:30s Timeout:2250s (1499.81169701s left)
2019-05-22 21:16:05,106 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522211605092839
2019-05-22 21:16:05,135 [salt.minion      :1432][INFO    ][25192] Starting a new job with PID 25192
2019-05-22 21:16:05,166 [salt.minion      :1711][INFO    ][25192] Returning information for job: 20190522211605092839
2019-05-22 21:16:27,950 [salt.loaded.ext.module.maas:1023][INFO    ][22463] Waiting status:Deployed for machines:['gtw01', 'ctl01']
sleep for:30s Timeout:2250s (1467.70195103s left)
2019-05-22 21:16:35,131 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522211635117077
2019-05-22 21:16:35,157 [salt.minion      :1432][INFO    ][25248] Starting a new job with PID 25248
2019-05-22 21:16:35,181 [salt.minion      :1711][INFO    ][25248] Returning information for job: 20190522211635117077
2019-05-22 21:17:00,092 [salt.loaded.ext.module.maas:1023][INFO    ][22463] Waiting status:Deployed for machines:['gtw01', 'ctl01']
sleep for:30s Timeout:2250s (1435.55957603s left)
2019-05-22 21:17:05,360 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522211705343397
2019-05-22 21:17:05,393 [salt.minion      :1432][INFO    ][25271] Starting a new job with PID 25271
2019-05-22 21:17:05,418 [salt.minion      :1711][INFO    ][25271] Returning information for job: 20190522211705343397
2019-05-22 21:17:32,112 [salt.loaded.ext.module.maas:1023][INFO    ][22463] Waiting status:Deployed for machines:['gtw01', 'ctl01']
sleep for:30s Timeout:2250s (1403.53919005s left)
2019-05-22 21:17:35,404 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522211735390582
2019-05-22 21:17:35,432 [salt.minion      :1432][INFO    ][25346] Starting a new job with PID 25346
2019-05-22 21:17:35,457 [salt.minion      :1711][INFO    ][25346] Returning information for job: 20190522211735390582
2019-05-22 21:18:04,074 [salt.loaded.ext.module.maas:1023][INFO    ][22463] Waiting status:Deployed for machines:['gtw01', 'ctl01']
sleep for:30s Timeout:2250s (1371.57737207s left)
2019-05-22 21:18:05,442 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522211805428357
2019-05-22 21:18:05,476 [salt.minion      :1432][INFO    ][25370] Starting a new job with PID 25370
2019-05-22 21:18:05,502 [salt.minion      :1711][INFO    ][25370] Returning information for job: 20190522211805428357
2019-05-22 21:18:35,512 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522211835501340
2019-05-22 21:18:35,538 [salt.minion      :1432][INFO    ][25423] Starting a new job with PID 25423
2019-05-22 21:18:35,562 [salt.minion      :1711][INFO    ][25423] Returning information for job: 20190522211835501340
2019-05-22 21:18:36,309 [salt.loaded.ext.module.maas:993 ][INFO    ][22463] Machine 8dm84m mark broken
2019-05-22 21:18:36,968 [salt.loaded.ext.module.maas:996 ][INFO    ][22463] Machine 8dm84m mark fixed
2019-05-22 21:18:37,920 [salt.loaded.ext.module.maas:684 ][INFO    ][22463] deploymachines hwe_kernel=hwe-16.04 system_id=f4fxmn distro_series=xenial
2019-05-22 21:18:40,531 [salt.loaded.ext.module.maas:684 ][INFO    ][22463] deploymachines hwe_kernel=hwe-16.04 system_id=8dm84m distro_series=xenial
2019-05-22 21:18:44,026 [salt.loaded.ext.module.maas:1023][INFO    ][22463] Waiting status:Deployed for machines:['gtw01', 'ctl01']
sleep for:30s Timeout:2250s (1331.62586904s left)
2019-05-22 21:19:05,554 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522211905536746
2019-05-22 21:19:05,585 [salt.minion      :1432][INFO    ][25610] Starting a new job with PID 25610
2019-05-22 21:19:05,610 [salt.minion      :1711][INFO    ][25610] Returning information for job: 20190522211905536746
2019-05-22 21:19:16,020 [salt.loaded.ext.module.maas:1023][INFO    ][22463] Waiting status:Deployed for machines:['gtw01', 'ctl01']
sleep for:30s Timeout:2250s (1299.63086605s left)
2019-05-22 21:19:35,640 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522211935626544
2019-05-22 21:19:35,670 [salt.minion      :1432][INFO    ][25663] Starting a new job with PID 25663
2019-05-22 21:19:35,693 [salt.minion      :1711][INFO    ][25663] Returning information for job: 20190522211935626544
2019-05-22 21:19:48,172 [salt.loaded.ext.module.maas:1023][INFO    ][22463] Waiting status:Deployed for machines:['gtw01', 'ctl01']
sleep for:30s Timeout:2250s (1267.479357s left)
2019-05-22 21:20:05,693 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522212005678959
2019-05-22 21:20:05,719 [salt.minion      :1432][INFO    ][25679] Starting a new job with PID 25679
2019-05-22 21:20:05,745 [salt.minion      :1711][INFO    ][25679] Returning information for job: 20190522212005678959
2019-05-22 21:20:20,180 [salt.loaded.ext.module.maas:1023][INFO    ][22463] Waiting status:Deployed for machines:['gtw01', 'ctl01']
sleep for:30s Timeout:2250s (1235.47131705s left)
2019-05-22 21:20:35,804 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522212035788561
2019-05-22 21:20:35,838 [salt.minion      :1432][INFO    ][25732] Starting a new job with PID 25732
2019-05-22 21:20:35,862 [salt.minion      :1711][INFO    ][25732] Returning information for job: 20190522212035788561
2019-05-22 21:20:52,151 [salt.loaded.ext.module.maas:1023][INFO    ][22463] Waiting status:Deployed for machines:['gtw01', 'ctl01']
sleep for:30s Timeout:2250s (1203.50065517s left)
2019-05-22 21:21:05,913 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522212105900604
2019-05-22 21:21:05,946 [salt.minion      :1432][INFO    ][25754] Starting a new job with PID 25754
2019-05-22 21:21:05,969 [salt.minion      :1711][INFO    ][25754] Returning information for job: 20190522212105900604
2019-05-22 21:21:24,076 [salt.loaded.ext.module.maas:1023][INFO    ][22463] Waiting status:Deployed for machines:['gtw01', 'ctl01']
sleep for:30s Timeout:2250s (1171.57486415s left)
2019-05-22 21:21:36,065 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522212136047454
2019-05-22 21:21:36,096 [salt.minion      :1432][INFO    ][25804] Starting a new job with PID 25804
2019-05-22 21:21:36,119 [salt.minion      :1711][INFO    ][25804] Returning information for job: 20190522212136047454
2019-05-22 21:21:56,225 [salt.loaded.ext.module.maas:1023][INFO    ][22463] Waiting status:Deployed for machines:['gtw01', 'ctl01']
sleep for:30s Timeout:2250s (1139.42665219s left)
2019-05-22 21:22:06,196 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522212206184192
2019-05-22 21:22:06,220 [salt.minion      :1432][INFO    ][25822] Starting a new job with PID 25822
2019-05-22 21:22:06,244 [salt.minion      :1711][INFO    ][25822] Returning information for job: 20190522212206184192
2019-05-22 21:22:28,279 [salt.loaded.ext.module.maas:1023][INFO    ][22463] Waiting status:Deployed for machines:['gtw01', 'ctl01']
sleep for:30s Timeout:2250s (1107.3725512s left)
2019-05-22 21:22:36,344 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522212236328457
2019-05-22 21:22:36,372 [salt.minion      :1432][INFO    ][25875] Starting a new job with PID 25875
2019-05-22 21:22:36,393 [salt.minion      :1711][INFO    ][25875] Returning information for job: 20190522212236328457
2019-05-22 21:23:00,108 [salt.loaded.ext.module.maas:1023][INFO    ][22463] Waiting status:Deployed for machines:['gtw01', 'ctl01']
sleep for:30s Timeout:2250s (1075.54341817s left)
2019-05-22 21:23:06,547 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522212306537809
2019-05-22 21:23:06,569 [salt.minion      :1432][INFO    ][25929] Starting a new job with PID 25929
2019-05-22 21:23:06,592 [salt.minion      :1711][INFO    ][25929] Returning information for job: 20190522212306537809
2019-05-22 21:23:32,226 [salt.loaded.ext.module.maas:1023][INFO    ][22463] Waiting status:Deployed for machines:['gtw01', 'ctl01']
sleep for:30s Timeout:2250s (1043.42489219s left)
2019-05-22 21:23:36,692 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522212336675357
2019-05-22 21:23:36,719 [salt.minion      :1432][INFO    ][26034] Starting a new job with PID 26034
2019-05-22 21:23:36,744 [salt.minion      :1711][INFO    ][26034] Returning information for job: 20190522212336675357
2019-05-22 21:24:04,240 [salt.loaded.ext.module.maas:1023][INFO    ][22463] Waiting status:Deployed for machines:['gtw01', 'ctl01']
sleep for:30s Timeout:2250s (1011.41097021s left)
2019-05-22 21:24:06,728 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522212406711648
2019-05-22 21:24:06,755 [salt.minion      :1432][INFO    ][26059] Starting a new job with PID 26059
2019-05-22 21:24:06,780 [salt.minion      :1711][INFO    ][26059] Returning information for job: 20190522212406711648
2019-05-22 21:24:36,252 [salt.loaded.ext.module.maas:1023][INFO    ][22463] Waiting status:Deployed for machines:['gtw01', 'ctl01']
sleep for:30s Timeout:2250s (979.399824142s left)
2019-05-22 21:24:36,940 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522212436926976
2019-05-22 21:24:36,968 [salt.minion      :1432][INFO    ][26397] Starting a new job with PID 26397
2019-05-22 21:24:36,992 [salt.minion      :1711][INFO    ][26397] Returning information for job: 20190522212436926976
2019-05-22 21:25:06,977 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522212506959632
2019-05-22 21:25:06,996 [salt.minion      :1432][INFO    ][26414] Starting a new job with PID 26414
2019-05-22 21:25:07,023 [salt.minion      :1711][INFO    ][26414] Returning information for job: 20190522212506959632
2019-05-22 21:25:08,368 [salt.loaded.ext.module.maas:1023][INFO    ][22463] Waiting status:Deployed for machines:['gtw01', 'ctl01']
sleep for:30s Timeout:2250s (947.283420086s left)
2019-05-22 21:25:37,001 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522212536986149
2019-05-22 21:25:37,028 [salt.minion      :1432][INFO    ][26500] Starting a new job with PID 26500
2019-05-22 21:25:37,049 [salt.minion      :1711][INFO    ][26500] Returning information for job: 20190522212536986149
2019-05-22 21:25:40,401 [salt.loaded.ext.module.maas:1023][INFO    ][22463] Waiting status:Deployed for machines:['gtw01', 'ctl01']
sleep for:30s Timeout:2250s (915.250679016s left)
2019-05-22 21:26:07,065 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522212607048282
2019-05-22 21:26:07,093 [salt.minion      :1432][INFO    ][26523] Starting a new job with PID 26523
2019-05-22 21:26:07,115 [salt.minion      :1711][INFO    ][26523] Returning information for job: 20190522212607048282
2019-05-22 21:26:12,501 [salt.loaded.ext.module.maas:1023][INFO    ][22463] Waiting status:Deployed for machines:['gtw01', 'ctl01']
sleep for:30s Timeout:2250s (883.150615215s left)
2019-05-22 21:26:37,145 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522212637129129
2019-05-22 21:26:37,180 [salt.minion      :1432][INFO    ][26767] Starting a new job with PID 26767
2019-05-22 21:26:37,204 [salt.minion      :1711][INFO    ][26767] Returning information for job: 20190522212637129129
2019-05-22 21:26:44,650 [salt.loaded.ext.module.maas:1023][INFO    ][22463] Waiting status:Deployed for machines:['gtw01', 'ctl01']
sleep for:30s Timeout:2250s (851.001754999s left)
2019-05-22 21:27:07,268 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522212707255532
2019-05-22 21:27:07,297 [salt.minion      :1432][INFO    ][26794] Starting a new job with PID 26794
2019-05-22 21:27:07,323 [salt.minion      :1711][INFO    ][26794] Returning information for job: 20190522212707255532
2019-05-22 21:27:16,667 [salt.loaded.ext.module.maas:1023][INFO    ][22463] Waiting status:Deployed for machines:['gtw01', 'ctl01']
sleep for:30s Timeout:2250s (818.984352112s left)
2019-05-22 21:27:37,381 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522212737371968
2019-05-22 21:27:37,410 [salt.minion      :1432][INFO    ][27147] Starting a new job with PID 27147
2019-05-22 21:27:37,435 [salt.minion      :1711][INFO    ][27147] Returning information for job: 20190522212737371968
2019-05-22 21:27:48,620 [salt.loaded.ext.module.maas:1023][INFO    ][22463] Waiting status:Deployed for machines:['gtw01', 'ctl01']
sleep for:30s Timeout:2250s (787.03137517s left)
2019-05-22 21:28:07,553 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522212807533811
2019-05-22 21:28:07,583 [salt.minion      :1432][INFO    ][27170] Starting a new job with PID 27170
2019-05-22 21:28:07,612 [salt.minion      :1711][INFO    ][27170] Returning information for job: 20190522212807533811
2019-05-22 21:28:20,611 [salt.loaded.ext.module.maas:1023][INFO    ][22463] Waiting status:Deployed for machines:['gtw01', 'ctl01']
sleep for:30s Timeout:2250s (755.039871216s left)
2019-05-22 21:28:37,699 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522212837684325
2019-05-22 21:28:37,728 [salt.minion      :1432][INFO    ][27227] Starting a new job with PID 27227
2019-05-22 21:28:37,749 [salt.minion      :1711][INFO    ][27227] Returning information for job: 20190522212837684325
2019-05-22 21:28:52,596 [salt.loaded.ext.module.maas:1023][INFO    ][22463] Waiting status:Deployed for machines:['gtw01', 'ctl01']
sleep for:30s Timeout:2250s (723.05548501s left)
2019-05-22 21:29:07,875 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522212907858802
2019-05-22 21:29:07,901 [salt.minion      :1432][INFO    ][27248] Starting a new job with PID 27248
2019-05-22 21:29:07,932 [salt.minion      :1711][INFO    ][27248] Returning information for job: 20190522212907858802
2019-05-22 21:29:24,560 [salt.loaded.ext.module.maas:1023][INFO    ][22463] Waiting status:Deployed for machines:['gtw01', 'ctl01']
sleep for:30s Timeout:2250s (691.090968132s left)
2019-05-22 21:29:38,091 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522212938076767
2019-05-22 21:29:38,118 [salt.minion      :1432][INFO    ][27307] Starting a new job with PID 27307
2019-05-22 21:29:38,142 [salt.minion      :1711][INFO    ][27307] Returning information for job: 20190522212938076767
2019-05-22 21:29:56,768 [salt.loaded.ext.module.maas:1023][INFO    ][22463] Waiting status:Deployed for machines:['gtw01', 'ctl01']
sleep for:30s Timeout:2250s (658.882934093s left)
2019-05-22 21:30:08,300 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522213008283401
2019-05-22 21:30:08,331 [salt.minion      :1432][INFO    ][27325] Starting a new job with PID 27325
2019-05-22 21:30:08,357 [salt.minion      :1711][INFO    ][27325] Returning information for job: 20190522213008283401
2019-05-22 21:30:29,005 [salt.loaded.ext.module.maas:1023][INFO    ][22463] Waiting status:Deployed for machines:['gtw01', 'ctl01']
sleep for:30s Timeout:2250s (626.646624088s left)
2019-05-22 21:30:38,503 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522213038489391
2019-05-22 21:30:38,532 [salt.minion      :1432][INFO    ][27379] Starting a new job with PID 27379
2019-05-22 21:30:38,553 [salt.minion      :1711][INFO    ][27379] Returning information for job: 20190522213038489391
2019-05-22 21:31:01,035 [salt.loaded.ext.module.maas:1023][INFO    ][22463] Waiting status:Deployed for machines:['gtw01', 'ctl01']
sleep for:30s Timeout:2250s (594.616478205s left)
2019-05-22 21:31:08,716 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522213108697270
2019-05-22 21:31:08,746 [salt.minion      :1432][INFO    ][27418] Starting a new job with PID 27418
2019-05-22 21:31:08,768 [salt.minion      :1711][INFO    ][27418] Returning information for job: 20190522213108697270
2019-05-22 21:31:33,093 [salt.loaded.ext.module.maas:1023][INFO    ][22463] Waiting status:Deployed for machines:['ctl01']
sleep for:30s Timeout:2250s (562.558521032s left)
2019-05-22 21:31:38,776 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command saltutil.find_job with jid 20190522213138759630
2019-05-22 21:31:38,806 [salt.minion      :1432][INFO    ][27601] Starting a new job with PID 27601
2019-05-22 21:31:38,835 [salt.minion      :1711][INFO    ][27601] Returning information for job: 20190522213138759630
2019-05-22 21:32:05,065 [salt.state       :300 ][INFO    ][22463] {'ret': True}
2019-05-22 21:32:05,066 [salt.state       :1951][INFO    ][22463] Completed state [maas.wait_for_machine_status] at time 21:32:05.065594 duration_in_ms=1719432.923
2019-05-22 21:32:05,072 [salt.minion      :1711][INFO    ][22463] Returning information for job: 20190522210316053198
2019-05-22 22:07:16,494 [salt.utils.schedule:1377][INFO    ][2964] Running scheduled job: __mine_interval
2019-05-22 22:24:27,916 [salt.minion      :1308][INFO    ][2964] User sudo_ubuntu Executing command cp.push_dir with jid 20190522222427905286
2019-05-22 22:24:27,942 [salt.minion      :1432][INFO    ][31521] Starting a new job with PID 31521
