2018-09-13 12:09:14,304 [salt.utils       :831 ][ERROR   ][1582] DNS lookup or connection check of 'salt' failed.
2018-09-13 12:09:14,305 [salt.minion      :152 ][ERROR   ][1582] Master hostname: 'salt' not found or not responsive. Retrying in 30 seconds
2018-09-13 12:09:17,153 [salt.utils.parsers:1051][WARNING ][1582] Minion received a SIGTERM. Exiting.
2018-09-13 12:09:40,707 [salt.utils.decorators:613 ][WARNING ][1930] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-09-13 12:10:07,952 [salt.utils.decorators:613 ][WARNING ][1930] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-09-13 12:10:17,124 [salt.utils.parsers:1051][WARNING ][1796] Minion received a SIGTERM. Exiting.
2018-09-13 12:12:32,361 [salt.utils.decorators:613 ][WARNING ][10623] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-09-13 12:12:56,684 [salt.utils.decorators:613 ][WARNING ][13449] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-09-13 12:13:00,994 [salt.utils.decorators:613 ][WARNING ][13449] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-09-13 12:14:43,509 [salt.loaded.int.states.file:2150][WARNING ][14677] 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.
2018-09-13 12:14:45,745 [salt.loaded.int.module.cmdmod:395 ][INFO    ][22333] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2018-09-13 12:14:45,773 [salt.loaded.int.module.cmdmod:395 ][INFO    ][22333] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2018-09-13 12:14:45,814 [salt.utils.parsers:1051][WARNING ][1746] Minion received a SIGTERM. Exiting.
2018-09-13 12:14:46,773 [salt.cli.daemons :293 ][INFO    ][22391] Setting up the Salt Minion "mas01.mcp-ovn-ha.local"
2018-09-13 12:14:46,987 [salt.cli.daemons :82  ][INFO    ][22391] Starting up the Salt Minion
2018-09-13 12:14:46,987 [salt.utils.event :1017][INFO    ][22391] Starting pull socket on /var/run/salt/minion/minion_event_d5b98d4eb1_pull.ipc
2018-09-13 12:14:47,587 [salt.minion      :976 ][INFO    ][22391] Creating minion process manager
2018-09-13 12:14:48,518 [salt.loader.10.20.0.2.int.module.cmdmod:395 ][INFO    ][22391] Executing command ['date', '+%z'] in directory '/root'
2018-09-13 12:14:48,546 [salt.utils.schedule:568 ][INFO    ][22391] Updating job settings for scheduled job: __mine_interval
2018-09-13 12:14:48,553 [salt.minion      :1107][INFO    ][22391] Added mine.update to scheduler
2018-09-13 12:14:48,568 [salt.minion      :1965][INFO    ][22391] Minion is starting as user 'root'
2018-09-13 12:14:48,587 [salt.minion      :2324][INFO    ][22391] Minion is ready to receive requests!
2018-09-13 12:14:49,495 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913121449476370
2018-09-13 12:14:49,524 [salt.minion      :1431][INFO    ][22494] Starting a new job with PID 22494
2018-09-13 12:14:49,551 [salt.minion      :1708][INFO    ][22494] Returning information for job: 20180913121449476370
2018-09-13 12:14:59,540 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913121459523435
2018-09-13 12:14:59,571 [salt.minion      :1431][INFO    ][22807] Starting a new job with PID 22807
2018-09-13 12:14:59,603 [salt.minion      :1708][INFO    ][22807] Returning information for job: 20180913121459523435
2018-09-13 12:15:09,583 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913121509565783
2018-09-13 12:15:09,611 [salt.minion      :1431][INFO    ][23033] Starting a new job with PID 23033
2018-09-13 12:15:09,657 [salt.minion      :1708][INFO    ][23033] Returning information for job: 20180913121509565783
2018-09-13 12:15:19,637 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913121519619874
2018-09-13 12:15:19,667 [salt.minion      :1431][INFO    ][23218] Starting a new job with PID 23218
2018-09-13 12:15:19,704 [salt.minion      :1708][INFO    ][23218] Returning information for job: 20180913121519619874
2018-09-13 12:15:29,672 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913121529655057
2018-09-13 12:15:29,700 [salt.minion      :1431][INFO    ][23329] Starting a new job with PID 23329
2018-09-13 12:15:29,729 [salt.minion      :1708][INFO    ][23329] Returning information for job: 20180913121529655057
2018-09-13 12:15:39,713 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913121539692757
2018-09-13 12:15:39,744 [salt.minion      :1431][INFO    ][23444] Starting a new job with PID 23444
2018-09-13 12:15:39,784 [salt.minion      :1708][INFO    ][23444] Returning information for job: 20180913121539692757
2018-09-13 12:15:49,742 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913121549725704
2018-09-13 12:15:49,771 [salt.minion      :1431][INFO    ][24500] Starting a new job with PID 24500
2018-09-13 12:15:49,799 [salt.minion      :1708][INFO    ][24500] Returning information for job: 20180913121549725704
2018-09-13 12:15:59,800 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913121559784986
2018-09-13 12:15:59,822 [salt.minion      :1431][INFO    ][24505] Starting a new job with PID 24505
2018-09-13 12:15:59,853 [salt.minion      :1708][INFO    ][24505] Returning information for job: 20180913121559784986
2018-09-13 12:16:09,826 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913121609812843
2018-09-13 12:16:09,859 [salt.minion      :1431][INFO    ][24905] Starting a new job with PID 24905
2018-09-13 12:16:09,892 [salt.minion      :1708][INFO    ][24905] Returning information for job: 20180913121609812843
2018-09-13 12:16:19,847 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913121619836770
2018-09-13 12:16:19,872 [salt.minion      :1431][INFO    ][26214] Starting a new job with PID 26214
2018-09-13 12:16:19,902 [salt.minion      :1708][INFO    ][26214] Returning information for job: 20180913121619836770
2018-09-13 12:16:30,076 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913121630058870
2018-09-13 12:16:30,102 [salt.minion      :1431][INFO    ][26245] Starting a new job with PID 26245
2018-09-13 12:16:30,131 [salt.minion      :1708][INFO    ][26245] Returning information for job: 20180913121630058870
2018-09-13 12:16:40,114 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913121640098293
2018-09-13 12:16:40,140 [salt.minion      :1431][INFO    ][26254] Starting a new job with PID 26254
2018-09-13 12:16:40,172 [salt.minion      :1708][INFO    ][26254] Returning information for job: 20180913121640098293
2018-09-13 12:16:50,141 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913121650126008
2018-09-13 12:16:50,170 [salt.minion      :1431][INFO    ][26263] Starting a new job with PID 26263
2018-09-13 12:16:50,202 [salt.minion      :1708][INFO    ][26263] Returning information for job: 20180913121650126008
2018-09-13 12:17:00,174 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913121700155039
2018-09-13 12:17:00,202 [salt.minion      :1431][INFO    ][26540] Starting a new job with PID 26540
2018-09-13 12:17:00,238 [salt.minion      :1708][INFO    ][26540] Returning information for job: 20180913121700155039
2018-09-13 12:17:10,213 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913121710190771
2018-09-13 12:17:10,244 [salt.minion      :1431][INFO    ][27159] Starting a new job with PID 27159
2018-09-13 12:17:10,288 [salt.minion      :1708][INFO    ][27159] Returning information for job: 20180913121710190771
2018-09-13 12:17:20,256 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913121720241163
2018-09-13 12:17:20,288 [salt.minion      :1431][INFO    ][27639] Starting a new job with PID 27639
2018-09-13 12:17:20,312 [salt.minion      :1708][INFO    ][27639] Returning information for job: 20180913121720241163
2018-09-13 12:17:30,285 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913121730267451
2018-09-13 12:17:30,309 [salt.minion      :1431][INFO    ][27956] Starting a new job with PID 27956
2018-09-13 12:17:30,342 [salt.minion      :1708][INFO    ][27956] Returning information for job: 20180913121730267451
2018-09-13 12:17:40,313 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913121740301702
2018-09-13 12:17:40,350 [salt.minion      :1431][INFO    ][28430] Starting a new job with PID 28430
2018-09-13 12:17:40,385 [salt.minion      :1708][INFO    ][28430] Returning information for job: 20180913121740301702
2018-09-13 12:17:50,360 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913121750346103
2018-09-13 12:17:50,394 [salt.minion      :1431][INFO    ][28435] Starting a new job with PID 28435
2018-09-13 12:17:50,440 [salt.minion      :1708][INFO    ][28435] Returning information for job: 20180913121750346103
2018-09-13 12:18:00,416 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913121800402752
2018-09-13 12:18:00,449 [salt.minion      :1431][INFO    ][28440] Starting a new job with PID 28440
2018-09-13 12:18:00,490 [salt.minion      :1708][INFO    ][28440] Returning information for job: 20180913121800402752
2018-09-13 12:18:10,472 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913121810456894
2018-09-13 12:18:10,509 [salt.minion      :1431][INFO    ][28446] Starting a new job with PID 28446
2018-09-13 12:18:10,544 [salt.minion      :1708][INFO    ][28446] Returning information for job: 20180913121810456894
2018-09-13 12:18:20,532 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913121820516018
2018-09-13 12:18:20,571 [salt.minion      :1431][INFO    ][28451] Starting a new job with PID 28451
2018-09-13 12:18:20,615 [salt.minion      :1708][INFO    ][28451] Returning information for job: 20180913121820516018
2018-09-13 12:18:30,609 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913121830591780
2018-09-13 12:18:30,638 [salt.minion      :1431][INFO    ][28463] Starting a new job with PID 28463
2018-09-13 12:18:30,685 [salt.minion      :1708][INFO    ][28463] Returning information for job: 20180913121830591780
2018-09-13 12:18:40,681 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913121840661295
2018-09-13 12:18:40,725 [salt.minion      :1431][INFO    ][28468] Starting a new job with PID 28468
2018-09-13 12:18:40,775 [salt.minion      :1708][INFO    ][28468] Returning information for job: 20180913121840661295
2018-09-13 12:18:50,775 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913121850756986
2018-09-13 12:18:50,808 [salt.minion      :1431][INFO    ][28474] Starting a new job with PID 28474
2018-09-13 12:18:50,852 [salt.minion      :1708][INFO    ][28474] Returning information for job: 20180913121850756986
2018-09-13 12:19:00,851 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913121900835953
2018-09-13 12:19:00,892 [salt.minion      :1431][INFO    ][28479] Starting a new job with PID 28479
2018-09-13 12:19:00,934 [salt.minion      :1708][INFO    ][28479] Returning information for job: 20180913121900835953
2018-09-13 12:19:10,933 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913121910921245
2018-09-13 12:19:10,953 [salt.minion      :1431][INFO    ][28668] Starting a new job with PID 28668
2018-09-13 12:19:10,991 [salt.minion      :1708][INFO    ][28668] Returning information for job: 20180913121910921245
2018-09-13 12:19:18,036 [salt.state       :2012][WARNING ][22337] State is set to retry, but a valid dict for retry configuration was not found.  Using retry defaults
2018-09-13 12:19:19,519 [salt.utils.decorators:613 ][WARNING ][22337] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-09-13 12:19:21,017 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913121921001869
2018-09-13 12:19:21,041 [salt.minion      :1431][INFO    ][29534] Starting a new job with PID 29534
2018-09-13 12:19:21,061 [salt.minion      :1708][INFO    ][29534] Returning information for job: 20180913121921001869
2018-09-13 12:19:27,946 [salt.utils.decorators:613 ][WARNING ][22337] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-09-13 12:19:31,071 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913121931053014
2018-09-13 12:19:31,109 [salt.minion      :1431][INFO    ][29844] Starting a new job with PID 29844
2018-09-13 12:19:31,140 [salt.minion      :1708][INFO    ][29844] Returning information for job: 20180913121931053014
2018-09-13 12:19:41,161 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913121941143714
2018-09-13 12:19:41,199 [salt.minion      :1431][INFO    ][30020] Starting a new job with PID 30020
2018-09-13 12:19:41,242 [salt.minion      :1708][INFO    ][30020] Returning information for job: 20180913121941143714
2018-09-13 12:19:51,266 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913121951253017
2018-09-13 12:19:51,295 [salt.minion      :1431][INFO    ][30103] Starting a new job with PID 30103
2018-09-13 12:19:51,313 [salt.minion      :1708][INFO    ][30103] Returning information for job: 20180913121951253017
2018-09-13 12:20:01,350 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913122001329468
2018-09-13 12:20:01,381 [salt.minion      :1431][INFO    ][30155] Starting a new job with PID 30155
2018-09-13 12:20:01,415 [salt.minion      :1708][INFO    ][30155] Returning information for job: 20180913122001329468
2018-09-13 12:20:11,453 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913122011440987
2018-09-13 12:20:11,484 [salt.minion      :1431][INFO    ][30210] Starting a new job with PID 30210
2018-09-13 12:20:11,519 [salt.minion      :1708][INFO    ][30210] Returning information for job: 20180913122011440987
2018-09-13 12:20:21,555 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913122021538965
2018-09-13 12:20:21,586 [salt.minion      :1431][INFO    ][30278] Starting a new job with PID 30278
2018-09-13 12:20:21,619 [salt.minion      :1708][INFO    ][30278] Returning information for job: 20180913122021538965
2018-09-13 12:20:31,657 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913122031642355
2018-09-13 12:20:31,707 [salt.minion      :1431][INFO    ][30341] Starting a new job with PID 30341
2018-09-13 12:20:31,733 [salt.minion      :1708][INFO    ][30341] Returning information for job: 20180913122031642355
2018-09-13 12:20:37,161 [salt.utils.decorators:613 ][WARNING ][22337] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-09-13 12:20:41,770 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913122041757752
2018-09-13 12:20:41,792 [salt.minion      :1431][INFO    ][30395] Starting a new job with PID 30395
2018-09-13 12:20:41,830 [salt.minion      :1708][INFO    ][30395] Returning information for job: 20180913122041757752
2018-09-13 12:20:51,876 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913122051859799
2018-09-13 12:20:51,902 [salt.minion      :1431][INFO    ][30425] Starting a new job with PID 30425
2018-09-13 12:20:51,933 [salt.minion      :1708][INFO    ][30425] Returning information for job: 20180913122051859799
2018-09-13 12:21:01,753 [salt.loaded.ext.module.maasng:1632][WARNING ][22337] boot_source_selections catch error during processing. Most-probably, streams not imported yet.
Sleep:5sRetry:0/5
2018-09-13 12:21:01,754 [salt.loaded.ext.module.maasng:1633][WARNING ][22337] Message:['{"os": ["OS ubuntu with release xenial has no available images for download"]}']
2018-09-13 12:21:01,993 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913122101977401
2018-09-13 12:21:02,019 [salt.minion      :1431][INFO    ][30541] Starting a new job with PID 30541
2018-09-13 12:21:02,072 [salt.minion      :1708][INFO    ][30541] Returning information for job: 20180913122101977401
2018-09-13 12:21:06,841 [salt.loaded.ext.module.maasng:1632][WARNING ][22337] boot_source_selections catch error during processing. Most-probably, streams not imported yet.
Sleep:5sRetry:1/5
2018-09-13 12:21:06,844 [salt.loaded.ext.module.maasng:1633][WARNING ][22337] Message:['{"os": ["OS ubuntu with release xenial has no available images for download"]}']
2018-09-13 12:21:12,126 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913122112111176
2018-09-13 12:21:12,153 [salt.minion      :1431][INFO    ][30558] Starting a new job with PID 30558
2018-09-13 12:21:12,186 [salt.minion      :1708][INFO    ][30558] Returning information for job: 20180913122112111176
2018-09-13 12:21:22,242 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913122122231455
2018-09-13 12:21:22,272 [salt.minion      :1431][INFO    ][30599] Starting a new job with PID 30599
2018-09-13 12:21:22,309 [salt.minion      :1708][INFO    ][30599] Returning information for job: 20180913122122231455
2018-09-13 12:21:32,366 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913122132350779
2018-09-13 12:21:32,406 [salt.minion      :1431][INFO    ][30633] Starting a new job with PID 30633
2018-09-13 12:21:32,462 [salt.minion      :1708][INFO    ][30633] Returning information for job: 20180913122132350779
2018-09-13 12:21:42,533 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913122142521508
2018-09-13 12:21:42,571 [salt.minion      :1431][INFO    ][30651] Starting a new job with PID 30651
2018-09-13 12:21:42,612 [salt.minion      :1708][INFO    ][30651] Returning information for job: 20180913122142521508
2018-09-13 12:21:52,686 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913122152676247
2018-09-13 12:21:52,724 [salt.minion      :1431][INFO    ][30681] Starting a new job with PID 30681
2018-09-13 12:21:52,771 [salt.minion      :1708][INFO    ][30681] Returning information for job: 20180913122152676247
2018-09-13 12:22:02,857 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913122202843665
2018-09-13 12:22:02,894 [salt.minion      :1431][INFO    ][30702] Starting a new job with PID 30702
2018-09-13 12:22:02,944 [salt.minion      :1708][INFO    ][30702] Returning information for job: 20180913122202843665
2018-09-13 12:22:13,033 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913122213024882
2018-09-13 12:22:13,057 [salt.minion      :1431][INFO    ][30720] Starting a new job with PID 30720
2018-09-13 12:22:13,085 [salt.minion      :1708][INFO    ][30720] Returning information for job: 20180913122213024882
2018-09-13 12:22:23,192 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913122223180537
2018-09-13 12:22:23,233 [salt.minion      :1431][INFO    ][30765] Starting a new job with PID 30765
2018-09-13 12:22:23,274 [salt.minion      :1708][INFO    ][30765] Returning information for job: 20180913122223180537
2018-09-13 12:22:33,383 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913122233372767
2018-09-13 12:22:33,415 [salt.minion      :1431][INFO    ][30798] Starting a new job with PID 30798
2018-09-13 12:22:33,456 [salt.minion      :1708][INFO    ][30798] Returning information for job: 20180913122233372767
2018-09-13 12:22:43,579 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913122243555040
2018-09-13 12:22:43,607 [salt.minion      :1431][INFO    ][30811] Starting a new job with PID 30811
2018-09-13 12:22:43,639 [salt.minion      :1708][INFO    ][30811] Returning information for job: 20180913122243555040
2018-09-13 12:22:53,747 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913122253735667
2018-09-13 12:22:53,788 [salt.minion      :1431][INFO    ][30826] Starting a new job with PID 30826
2018-09-13 12:22:53,822 [salt.minion      :1708][INFO    ][30826] Returning information for job: 20180913122253735667
2018-09-13 12:23:03,936 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913122303929317
2018-09-13 12:23:03,977 [salt.minion      :1431][INFO    ][30846] Starting a new job with PID 30846
2018-09-13 12:23:04,004 [salt.minion      :1708][INFO    ][30846] Returning information for job: 20180913122303929317
2018-09-13 12:23:05,574 [salt.utils.decorators:613 ][WARNING ][22337] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-09-13 12:23:14,129 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913122314116032
2018-09-13 12:23:14,170 [salt.minion      :1431][INFO    ][30873] Starting a new job with PID 30873
2018-09-13 12:23:14,217 [salt.minion      :1708][INFO    ][30873] Returning information for job: 20180913122314116032
2018-09-13 12:23:24,349 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913122324343691
2018-09-13 12:23:24,380 [salt.minion      :1431][INFO    ][30905] Starting a new job with PID 30905
2018-09-13 12:23:24,415 [salt.minion      :1708][INFO    ][30905] Returning information for job: 20180913122324343691
2018-09-13 12:23:34,513 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913122334506790
2018-09-13 12:23:34,536 [salt.minion      :1431][INFO    ][31129] Starting a new job with PID 31129
2018-09-13 12:23:34,561 [salt.minion      :1708][INFO    ][31129] Returning information for job: 20180913122334506790
2018-09-13 12:23:34,632 [salt.utils.decorators:613 ][WARNING ][22337] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-09-13 12:23:38,854 [salt.loaded.ext.module.maasng:951 ][WARNING ][22337] Detected cidr:192.168.11.0/24 in fabric:fabric-2
2018-09-13 12:23:38,855 [salt.loaded.ext.module.maasng:954 ][WARNING ][22337] Guessing, that fabric with current name:fabric-2
 should be renamed to:pxe_admin
2018-09-13 12:23:39,925 [salt.loaded.ext.module.maasng:1177][WARNING ][22337] Ignoring parameter vlan:0
2018-09-13 12:23:44,563 [salt.utils.decorators:613 ][WARNING ][22337] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-09-13 12:23:44,686 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913122344679089
2018-09-13 12:23:44,720 [salt.minion      :1431][INFO    ][31220] Starting a new job with PID 31220
2018-09-13 12:23:44,751 [salt.minion      :1708][INFO    ][31220] Returning information for job: 20180913122344679089
2018-09-13 12:23:45,405 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command state.apply with jid 20180913122345398804
2018-09-13 12:23:45,425 [salt.minion      :1431][INFO    ][31234] Starting a new job with PID 31234
2018-09-13 12:23:49,275 [salt.state       :905 ][INFO    ][31234] Loading fresh modules for state activity
2018-09-13 12:23:49,343 [salt.fileclient  :1215][INFO    ][31234] Fetching file from saltenv 'base', ** done ** 'maas/machines/init.sls'
2018-09-13 12:23:49,389 [salt.state       :1770][INFO    ][31234] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:23:49.389306
2018-09-13 12:23:49,389 [salt.state       :1803][INFO    ][31234] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2018-09-13 12:23:49,392 [salt.loaded.int.module.cmdmod:395 ][INFO    ][31234] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2018-09-13 12:23:50,496 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913122350488976
2018-09-13 12:23:50,513 [salt.minion      :1431][INFO    ][31303] Starting a new job with PID 31303
2018-09-13 12:23:50,543 [salt.minion      :1708][INFO    ][31303] Returning information for job: 20180913122350488976
2018-09-13 12:23:51,134 [salt.state       :290 ][INFO    ][31234] {'pid': 31292, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-09-13 12:23:51,134 [salt.state       :1941][INFO    ][31234] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:23:51.134859 duration_in_ms=1745.553
2018-09-13 12:23:51,136 [salt.state       :1770][INFO    ][31234] Running state [maas.process_machines] at time 12:23:51.136484
2018-09-13 12:23:51,136 [salt.state       :1803][INFO    ][31234] Executing state module.run for [maas.process_machines]
2018-09-13 12:23:51,137 [salt.utils.decorators:613 ][WARNING ][31234] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-09-13 12:23:51,257 [salt.loaded.ext.module.maas:412 ][WARNING ][31234] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2018-09-13 12:23:51,258 [salt.loaded.ext.module.maas:92  ][INFO    ][31234] machine hostname=cmp002 power_type=ipmi power_parameters_power_user=admin power_parameters_power_address=172.30.8.72 mac_addresses=00:25:b5:a0:00:6a power_parameters_power_pass=octopus architecture=amd64/generic
2018-09-13 12:23:52,943 [salt.loaded.ext.module.maas:412 ][WARNING ][31234] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2018-09-13 12:23:52,945 [salt.loaded.ext.module.maas:92  ][INFO    ][31234] machine hostname=cmp001 power_type=ipmi power_parameters_power_user=admin power_parameters_power_address=172.30.8.73 mac_addresses=00:25:b5:a0:00:5a power_parameters_power_pass=octopus architecture=amd64/generic
2018-09-13 12:23:54,624 [salt.loaded.ext.module.maas:412 ][WARNING ][31234] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2018-09-13 12:23:54,625 [salt.loaded.ext.module.maas:92  ][INFO    ][31234] machine hostname=kvm01 power_type=ipmi power_parameters_power_user=admin power_parameters_power_address=172.30.8.75 mac_addresses=00:25:b5:a0:00:2a power_parameters_power_pass=octopus architecture=amd64/generic
2018-09-13 12:23:56,281 [salt.loaded.ext.module.maas:412 ][WARNING ][31234] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2018-09-13 12:23:56,283 [salt.loaded.ext.module.maas:92  ][INFO    ][31234] machine hostname=kvm03 power_type=ipmi power_parameters_power_user=admin power_parameters_power_address=172.30.8.74 mac_addresses=00:25:b5:a0:00:4a power_parameters_power_pass=octopus architecture=amd64/generic
2018-09-13 12:23:58,560 [salt.loaded.ext.module.maas:412 ][WARNING ][31234] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2018-09-13 12:23:58,560 [salt.loaded.ext.module.maas:92  ][INFO    ][31234] machine hostname=kvm02 power_type=ipmi power_parameters_power_user=admin power_parameters_power_address=172.30.8.65 mac_addresses=00:25:b5:a0:00:3a power_parameters_power_pass=octopus architecture=amd64/generic
2018-09-13 12:23:59,737 [salt.state       :290 ][INFO    ][31234] {'ret': {'updated': [], 'errors': {}, 'success': ['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']}}
2018-09-13 12:23:59,738 [salt.state       :1941][INFO    ][31234] Completed state [maas.process_machines] at time 12:23:59.738146 duration_in_ms=8601.652
2018-09-13 12:23:59,745 [salt.minion      :1708][INFO    ][31234] Returning information for job: 20180913122345398804
2018-09-13 12:24:42,333 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command pillar.get with jid 20180913122442270156
2018-09-13 12:24:42,361 [salt.minion      :1431][INFO    ][31665] Starting a new job with PID 31665
2018-09-13 12:24:42,375 [salt.minion      :1708][INFO    ][31665] Returning information for job: 20180913122442270156
2018-09-13 12:24:42,883 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command state.apply with jid 20180913122442884648
2018-09-13 12:24:42,905 [salt.minion      :1431][INFO    ][31670] Starting a new job with PID 31670
2018-09-13 12:24:46,785 [salt.state       :905 ][INFO    ][31670] Loading fresh modules for state activity
2018-09-13 12:24:46,851 [salt.fileclient  :1215][INFO    ][31670] Fetching file from saltenv 'base', ** done ** 'maas/machines/status.sls'
2018-09-13 12:24:46,899 [salt.state       :1770][INFO    ][31670] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:24:46.899656
2018-09-13 12:24:46,900 [salt.state       :1803][INFO    ][31670] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2018-09-13 12:24:46,903 [salt.loaded.int.module.cmdmod:395 ][INFO    ][31670] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2018-09-13 12:24:48,004 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913122448000557
2018-09-13 12:24:48,034 [salt.minion      :1431][INFO    ][31688] Starting a new job with PID 31688
2018-09-13 12:24:48,070 [salt.minion      :1708][INFO    ][31688] Returning information for job: 20180913122448000557
2018-09-13 12:24:48,502 [salt.state       :290 ][INFO    ][31670] {'pid': 31680, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-09-13 12:24:48,503 [salt.state       :1941][INFO    ][31670] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:24:48.503398 duration_in_ms=1603.741
2018-09-13 12:24:48,506 [salt.state       :1770][INFO    ][31670] Running state [maas.machines_status] at time 12:24:48.506120
2018-09-13 12:24:48,506 [salt.state       :1803][INFO    ][31670] Executing state module.run for [maas.machines_status]
2018-09-13 12:24:48,507 [salt.utils.decorators:613 ][WARNING ][31670] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-09-13 12:24:48,783 [salt.state       :290 ][INFO    ][31670] {'ret': {'machines': [{'status': 'Commissioning', 'hostname': u'cmp002', 'system_id': u'4pqqtm'}, {'status': 'Commissioning', 'hostname': u'cmp001', 'system_id': u'8ph7mn'}, {'status': 'Commissioning', 'hostname': u'kvm01', 'system_id': u'rwn4cp'}, {'status': 'Commissioning', 'hostname': u'kvm03', 'system_id': u'tmbdry'}, {'status': 'Commissioning', 'hostname': u'kvm02', 'system_id': u'dwxchw'}], 'summary': Counter({'Commissioning': 5})}}
2018-09-13 12:24:48,785 [salt.state       :1941][INFO    ][31670] Completed state [maas.machines_status] at time 12:24:48.785150 duration_in_ms=279.027
2018-09-13 12:24:48,791 [salt.minion      :1708][INFO    ][31670] Returning information for job: 20180913122442884648
2018-09-13 12:24:59,408 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command state.apply with jid 20180913122459402452
2018-09-13 12:24:59,436 [salt.minion      :1431][INFO    ][31702] Starting a new job with PID 31702
2018-09-13 12:25:00,154 [salt.state       :905 ][INFO    ][31702] Loading fresh modules for state activity
2018-09-13 12:25:00,254 [salt.state       :1770][INFO    ][31702] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:25:00.254764
2018-09-13 12:25:00,255 [salt.state       :1803][INFO    ][31702] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2018-09-13 12:25:00,258 [salt.loaded.int.module.cmdmod:395 ][INFO    ][31702] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2018-09-13 12:25:01,709 [salt.state       :290 ][INFO    ][31702] {'pid': 31709, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-09-13 12:25:01,711 [salt.state       :1941][INFO    ][31702] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:25:01.711368 duration_in_ms=1456.602
2018-09-13 12:25:01,714 [salt.state       :1770][INFO    ][31702] Running state [maas.machines_status] at time 12:25:01.714813
2018-09-13 12:25:01,716 [salt.state       :1803][INFO    ][31702] Executing state module.run for [maas.machines_status]
2018-09-13 12:25:01,717 [salt.utils.decorators:613 ][WARNING ][31702] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-09-13 12:25:01,944 [salt.state       :290 ][INFO    ][31702] {'ret': {'machines': [{'status': 'Commissioning', 'hostname': u'cmp002', 'system_id': u'4pqqtm'}, {'status': 'Commissioning', 'hostname': u'cmp001', 'system_id': u'8ph7mn'}, {'status': 'Commissioning', 'hostname': u'kvm01', 'system_id': u'rwn4cp'}, {'status': 'Commissioning', 'hostname': u'kvm03', 'system_id': u'tmbdry'}, {'status': 'Commissioning', 'hostname': u'kvm02', 'system_id': u'dwxchw'}], 'summary': Counter({'Commissioning': 5})}}
2018-09-13 12:25:01,945 [salt.state       :1941][INFO    ][31702] Completed state [maas.machines_status] at time 12:25:01.945364 duration_in_ms=230.549
2018-09-13 12:25:01,950 [salt.minion      :1708][INFO    ][31702] Returning information for job: 20180913122459402452
2018-09-13 12:25:12,497 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command state.apply with jid 20180913122512494030
2018-09-13 12:25:12,522 [salt.minion      :1431][INFO    ][31725] Starting a new job with PID 31725
2018-09-13 12:25:16,328 [salt.state       :905 ][INFO    ][31725] Loading fresh modules for state activity
2018-09-13 12:25:16,425 [salt.state       :1770][INFO    ][31725] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:25:16.425253
2018-09-13 12:25:16,425 [salt.state       :1803][INFO    ][31725] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2018-09-13 12:25:16,428 [salt.loaded.int.module.cmdmod:395 ][INFO    ][31725] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2018-09-13 12:25:17,550 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913122517545743
2018-09-13 12:25:17,582 [salt.minion      :1431][INFO    ][31752] Starting a new job with PID 31752
2018-09-13 12:25:17,617 [salt.minion      :1708][INFO    ][31752] Returning information for job: 20180913122517545743
2018-09-13 12:25:17,871 [salt.state       :290 ][INFO    ][31725] {'pid': 31744, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-09-13 12:25:17,872 [salt.state       :1941][INFO    ][31725] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:25:17.872546 duration_in_ms=1447.292
2018-09-13 12:25:17,875 [salt.state       :1770][INFO    ][31725] Running state [maas.machines_status] at time 12:25:17.875153
2018-09-13 12:25:17,875 [salt.state       :1803][INFO    ][31725] Executing state module.run for [maas.machines_status]
2018-09-13 12:25:17,876 [salt.utils.decorators:613 ][WARNING ][31725] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-09-13 12:25:18,061 [salt.state       :290 ][INFO    ][31725] {'ret': {'machines': [{'status': 'Commissioning', 'hostname': u'cmp002', 'system_id': u'4pqqtm'}, {'status': 'Commissioning', 'hostname': u'cmp001', 'system_id': u'8ph7mn'}, {'status': 'Commissioning', 'hostname': u'kvm01', 'system_id': u'rwn4cp'}, {'status': 'Commissioning', 'hostname': u'kvm03', 'system_id': u'tmbdry'}, {'status': 'Commissioning', 'hostname': u'kvm02', 'system_id': u'dwxchw'}], 'summary': Counter({'Commissioning': 5})}}
2018-09-13 12:25:18,061 [salt.state       :1941][INFO    ][31725] Completed state [maas.machines_status] at time 12:25:18.061764 duration_in_ms=186.611
2018-09-13 12:25:18,066 [salt.minion      :1708][INFO    ][31725] Returning information for job: 20180913122512494030
2018-09-13 12:25:28,700 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command state.apply with jid 20180913122528695734
2018-09-13 12:25:28,724 [salt.minion      :1431][INFO    ][31809] Starting a new job with PID 31809
2018-09-13 12:25:29,396 [salt.state       :905 ][INFO    ][31809] Loading fresh modules for state activity
2018-09-13 12:25:29,523 [salt.state       :1770][INFO    ][31809] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:25:29.522888
2018-09-13 12:25:29,523 [salt.state       :1803][INFO    ][31809] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2018-09-13 12:25:29,526 [salt.loaded.int.module.cmdmod:395 ][INFO    ][31809] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2018-09-13 12:25:31,037 [salt.state       :290 ][INFO    ][31809] {'pid': 31817, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-09-13 12:25:31,038 [salt.state       :1941][INFO    ][31809] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:25:31.038356 duration_in_ms=1515.467
2018-09-13 12:25:31,041 [salt.state       :1770][INFO    ][31809] Running state [maas.machines_status] at time 12:25:31.041333
2018-09-13 12:25:31,042 [salt.state       :1803][INFO    ][31809] Executing state module.run for [maas.machines_status]
2018-09-13 12:25:31,042 [salt.utils.decorators:613 ][WARNING ][31809] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-09-13 12:25:31,326 [salt.state       :290 ][INFO    ][31809] {'ret': {'machines': [{'status': 'Commissioning', 'hostname': u'cmp002', 'system_id': u'4pqqtm'}, {'status': 'Commissioning', 'hostname': u'cmp001', 'system_id': u'8ph7mn'}, {'status': 'Commissioning', 'hostname': u'kvm01', 'system_id': u'rwn4cp'}, {'status': 'Commissioning', 'hostname': u'kvm03', 'system_id': u'tmbdry'}, {'status': 'Commissioning', 'hostname': u'kvm02', 'system_id': u'dwxchw'}], 'summary': Counter({'Commissioning': 5})}}
2018-09-13 12:25:31,329 [salt.state       :1941][INFO    ][31809] Completed state [maas.machines_status] at time 12:25:31.329460 duration_in_ms=288.126
2018-09-13 12:25:31,334 [salt.minion      :1708][INFO    ][31809] Returning information for job: 20180913122528695734
2018-09-13 12:25:41,906 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command state.apply with jid 20180913122541867660
2018-09-13 12:25:41,930 [salt.minion      :1431][INFO    ][31831] Starting a new job with PID 31831
2018-09-13 12:25:45,490 [salt.state       :905 ][INFO    ][31831] Loading fresh modules for state activity
2018-09-13 12:25:45,561 [salt.state       :1770][INFO    ][31831] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:25:45.561529
2018-09-13 12:25:45,562 [salt.state       :1803][INFO    ][31831] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2018-09-13 12:25:45,564 [salt.loaded.int.module.cmdmod:395 ][INFO    ][31831] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2018-09-13 12:25:46,934 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913122546933325
2018-09-13 12:25:46,956 [salt.minion      :1431][INFO    ][31900] Starting a new job with PID 31900
2018-09-13 12:25:46,979 [salt.minion      :1708][INFO    ][31900] Returning information for job: 20180913122546933325
2018-09-13 12:25:47,223 [salt.state       :290 ][INFO    ][31831] {'pid': 31865, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-09-13 12:25:47,224 [salt.state       :1941][INFO    ][31831] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:25:47.224072 duration_in_ms=1662.543
2018-09-13 12:25:47,226 [salt.state       :1770][INFO    ][31831] Running state [maas.machines_status] at time 12:25:47.226077
2018-09-13 12:25:47,226 [salt.state       :1803][INFO    ][31831] Executing state module.run for [maas.machines_status]
2018-09-13 12:25:47,227 [salt.utils.decorators:613 ][WARNING ][31831] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-09-13 12:25:47,408 [salt.state       :290 ][INFO    ][31831] {'ret': {'machines': [{'status': 'Commissioning', 'hostname': u'cmp002', 'system_id': u'4pqqtm'}, {'status': 'Commissioning', 'hostname': u'cmp001', 'system_id': u'8ph7mn'}, {'status': 'Commissioning', 'hostname': u'kvm01', 'system_id': u'rwn4cp'}, {'status': 'Commissioning', 'hostname': u'kvm03', 'system_id': u'tmbdry'}, {'status': 'Commissioning', 'hostname': u'kvm02', 'system_id': u'dwxchw'}], 'summary': Counter({'Commissioning': 5})}}
2018-09-13 12:25:47,409 [salt.state       :1941][INFO    ][31831] Completed state [maas.machines_status] at time 12:25:47.409347 duration_in_ms=183.268
2018-09-13 12:25:47,414 [salt.minion      :1708][INFO    ][31831] Returning information for job: 20180913122541867660
2018-09-13 12:25:57,986 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command state.apply with jid 20180913122557985426
2018-09-13 12:25:58,010 [salt.minion      :1431][INFO    ][31968] Starting a new job with PID 31968
2018-09-13 12:25:58,631 [salt.state       :905 ][INFO    ][31968] Loading fresh modules for state activity
2018-09-13 12:25:58,740 [salt.state       :1770][INFO    ][31968] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:25:58.740403
2018-09-13 12:25:58,741 [salt.state       :1803][INFO    ][31968] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2018-09-13 12:25:58,744 [salt.loaded.int.module.cmdmod:395 ][INFO    ][31968] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2018-09-13 12:26:00,110 [salt.state       :290 ][INFO    ][31968] {'pid': 31976, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-09-13 12:26:00,112 [salt.state       :1941][INFO    ][31968] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:26:00.112510 duration_in_ms=1372.106
2018-09-13 12:26:00,116 [salt.state       :1770][INFO    ][31968] Running state [maas.machines_status] at time 12:26:00.116294
2018-09-13 12:26:00,117 [salt.state       :1803][INFO    ][31968] Executing state module.run for [maas.machines_status]
2018-09-13 12:26:00,118 [salt.utils.decorators:613 ][WARNING ][31968] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-09-13 12:26:00,399 [salt.state       :290 ][INFO    ][31968] {'ret': {'machines': [{'status': 'Commissioning', 'hostname': u'cmp002', 'system_id': u'4pqqtm'}, {'status': 'Commissioning', 'hostname': u'cmp001', 'system_id': u'8ph7mn'}, {'status': 'Commissioning', 'hostname': u'kvm01', 'system_id': u'rwn4cp'}, {'status': 'Commissioning', 'hostname': u'kvm03', 'system_id': u'tmbdry'}, {'status': 'Commissioning', 'hostname': u'kvm02', 'system_id': u'dwxchw'}], 'summary': Counter({'Commissioning': 5})}}
2018-09-13 12:26:00,402 [salt.state       :1941][INFO    ][31968] Completed state [maas.machines_status] at time 12:26:00.402481 duration_in_ms=286.185
2018-09-13 12:26:00,407 [salt.minion      :1708][INFO    ][31968] Returning information for job: 20180913122557985426
2018-09-13 12:26:10,946 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command state.apply with jid 20180913122610947507
2018-09-13 12:26:10,971 [salt.minion      :1431][INFO    ][31990] Starting a new job with PID 31990
2018-09-13 12:26:14,724 [salt.state       :905 ][INFO    ][31990] Loading fresh modules for state activity
2018-09-13 12:26:14,825 [salt.state       :1770][INFO    ][31990] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:26:14.825019
2018-09-13 12:26:14,825 [salt.state       :1803][INFO    ][31990] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2018-09-13 12:26:14,828 [salt.loaded.int.module.cmdmod:395 ][INFO    ][31990] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2018-09-13 12:26:16,062 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913122616063025
2018-09-13 12:26:16,083 [salt.minion      :1431][INFO    ][32032] Starting a new job with PID 32032
2018-09-13 12:26:16,113 [salt.minion      :1708][INFO    ][32032] Returning information for job: 20180913122616063025
2018-09-13 12:26:16,449 [salt.state       :290 ][INFO    ][31990] {'pid': 32014, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-09-13 12:26:16,449 [salt.state       :1941][INFO    ][31990] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:26:16.449844 duration_in_ms=1624.825
2018-09-13 12:26:16,451 [salt.state       :1770][INFO    ][31990] Running state [maas.machines_status] at time 12:26:16.451180
2018-09-13 12:26:16,451 [salt.state       :1803][INFO    ][31990] Executing state module.run for [maas.machines_status]
2018-09-13 12:26:16,451 [salt.utils.decorators:613 ][WARNING ][31990] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-09-13 12:26:16,643 [salt.state       :290 ][INFO    ][31990] {'ret': {'machines': [{'status': 'Commissioning', 'hostname': u'cmp002', 'system_id': u'4pqqtm'}, {'status': 'Commissioning', 'hostname': u'cmp001', 'system_id': u'8ph7mn'}, {'status': 'Commissioning', 'hostname': u'kvm01', 'system_id': u'rwn4cp'}, {'status': 'Commissioning', 'hostname': u'kvm03', 'system_id': u'tmbdry'}, {'status': 'Commissioning', 'hostname': u'kvm02', 'system_id': u'dwxchw'}], 'summary': Counter({'Commissioning': 5})}}
2018-09-13 12:26:16,643 [salt.state       :1941][INFO    ][31990] Completed state [maas.machines_status] at time 12:26:16.643358 duration_in_ms=192.177
2018-09-13 12:26:16,645 [salt.minion      :1708][INFO    ][31990] Returning information for job: 20180913122610947507
2018-09-13 12:26:27,255 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command state.apply with jid 20180913122627258758
2018-09-13 12:26:27,280 [salt.minion      :1431][INFO    ][32195] Starting a new job with PID 32195
2018-09-13 12:26:27,811 [salt.state       :905 ][INFO    ][32195] Loading fresh modules for state activity
2018-09-13 12:26:27,909 [salt.state       :1770][INFO    ][32195] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:26:27.909540
2018-09-13 12:26:27,910 [salt.state       :1803][INFO    ][32195] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2018-09-13 12:26:27,914 [salt.loaded.int.module.cmdmod:395 ][INFO    ][32195] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2018-09-13 12:26:29,649 [salt.state       :290 ][INFO    ][32195] {'pid': 32235, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-09-13 12:26:29,650 [salt.state       :1941][INFO    ][32195] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:26:29.650158 duration_in_ms=1740.618
2018-09-13 12:26:29,652 [salt.state       :1770][INFO    ][32195] Running state [maas.machines_status] at time 12:26:29.652104
2018-09-13 12:26:29,652 [salt.state       :1803][INFO    ][32195] Executing state module.run for [maas.machines_status]
2018-09-13 12:26:29,653 [salt.utils.decorators:613 ][WARNING ][32195] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-09-13 12:26:29,887 [salt.state       :290 ][INFO    ][32195] {'ret': {'machines': [{'status': 'Commissioning', 'hostname': u'cmp002', 'system_id': u'4pqqtm'}, {'status': 'Commissioning', 'hostname': u'cmp001', 'system_id': u'8ph7mn'}, {'status': 'Commissioning', 'hostname': u'kvm01', 'system_id': u'rwn4cp'}, {'status': 'Commissioning', 'hostname': u'kvm03', 'system_id': u'tmbdry'}, {'status': 'Commissioning', 'hostname': u'kvm02', 'system_id': u'dwxchw'}], 'summary': Counter({'Commissioning': 5})}}
2018-09-13 12:26:29,888 [salt.state       :1941][INFO    ][32195] Completed state [maas.machines_status] at time 12:26:29.888691 duration_in_ms=236.586
2018-09-13 12:26:29,892 [salt.minion      :1708][INFO    ][32195] Returning information for job: 20180913122627258758
2018-09-13 12:26:40,461 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command state.apply with jid 20180913122640462026
2018-09-13 12:26:40,484 [salt.minion      :1431][INFO    ][32306] Starting a new job with PID 32306
2018-09-13 12:26:44,210 [salt.state       :905 ][INFO    ][32306] Loading fresh modules for state activity
2018-09-13 12:26:44,320 [salt.state       :1770][INFO    ][32306] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:26:44.320512
2018-09-13 12:26:44,321 [salt.state       :1803][INFO    ][32306] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2018-09-13 12:26:44,323 [salt.loaded.int.module.cmdmod:395 ][INFO    ][32306] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2018-09-13 12:26:45,540 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913122645540129
2018-09-13 12:26:45,558 [salt.minion      :1431][INFO    ][32340] Starting a new job with PID 32340
2018-09-13 12:26:45,596 [salt.minion      :1708][INFO    ][32340] Returning information for job: 20180913122645540129
2018-09-13 12:26:46,110 [salt.state       :290 ][INFO    ][32306] {'pid': 32329, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-09-13 12:26:46,112 [salt.state       :1941][INFO    ][32306] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:26:46.112275 duration_in_ms=1791.76
2018-09-13 12:26:46,116 [salt.state       :1770][INFO    ][32306] Running state [maas.machines_status] at time 12:26:46.116247
2018-09-13 12:26:46,117 [salt.state       :1803][INFO    ][32306] Executing state module.run for [maas.machines_status]
2018-09-13 12:26:46,118 [salt.utils.decorators:613 ][WARNING ][32306] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-09-13 12:26:46,511 [salt.state       :290 ][INFO    ][32306] {'ret': {'machines': [{'status': 'Commissioning', 'hostname': u'cmp002', 'system_id': u'4pqqtm'}, {'status': 'Commissioning', 'hostname': u'cmp001', 'system_id': u'8ph7mn'}, {'status': 'Commissioning', 'hostname': u'kvm01', 'system_id': u'rwn4cp'}, {'status': 'Commissioning', 'hostname': u'kvm03', 'system_id': u'tmbdry'}, {'status': 'Commissioning', 'hostname': u'kvm02', 'system_id': u'dwxchw'}], 'summary': Counter({'Commissioning': 5})}}
2018-09-13 12:26:46,511 [salt.state       :1941][INFO    ][32306] Completed state [maas.machines_status] at time 12:26:46.511732 duration_in_ms=395.483
2018-09-13 12:26:46,515 [salt.minion      :1708][INFO    ][32306] Returning information for job: 20180913122640462026
2018-09-13 12:26:57,073 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command state.apply with jid 20180913122657071143
2018-09-13 12:26:57,095 [salt.minion      :1431][INFO    ][32449] Starting a new job with PID 32449
2018-09-13 12:26:57,706 [salt.state       :905 ][INFO    ][32449] Loading fresh modules for state activity
2018-09-13 12:26:57,812 [salt.state       :1770][INFO    ][32449] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:26:57.811949
2018-09-13 12:26:57,812 [salt.state       :1803][INFO    ][32449] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2018-09-13 12:26:57,815 [salt.loaded.int.module.cmdmod:395 ][INFO    ][32449] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2018-09-13 12:26:59,380 [salt.state       :290 ][INFO    ][32449] {'pid': 32456, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-09-13 12:26:59,381 [salt.state       :1941][INFO    ][32449] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:26:59.381402 duration_in_ms=1569.452
2018-09-13 12:26:59,384 [salt.state       :1770][INFO    ][32449] Running state [maas.machines_status] at time 12:26:59.384351
2018-09-13 12:26:59,384 [salt.state       :1803][INFO    ][32449] Executing state module.run for [maas.machines_status]
2018-09-13 12:26:59,385 [salt.utils.decorators:613 ][WARNING ][32449] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-09-13 12:26:59,641 [salt.state       :290 ][INFO    ][32449] {'ret': {'machines': [{'status': 'Commissioning', 'hostname': u'cmp002', 'system_id': u'4pqqtm'}, {'status': 'Commissioning', 'hostname': u'cmp001', 'system_id': u'8ph7mn'}, {'status': 'Commissioning', 'hostname': u'kvm01', 'system_id': u'rwn4cp'}, {'status': 'Commissioning', 'hostname': u'kvm03', 'system_id': u'tmbdry'}, {'status': 'Commissioning', 'hostname': u'kvm02', 'system_id': u'dwxchw'}], 'summary': Counter({'Commissioning': 5})}}
2018-09-13 12:26:59,642 [salt.state       :1941][INFO    ][32449] Completed state [maas.machines_status] at time 12:26:59.642030 duration_in_ms=257.679
2018-09-13 12:26:59,646 [salt.minion      :1708][INFO    ][32449] Returning information for job: 20180913122657071143
2018-09-13 12:27:10,183 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command state.apply with jid 20180913122710177147
2018-09-13 12:27:10,207 [salt.minion      :1431][INFO    ][32500] Starting a new job with PID 32500
2018-09-13 12:27:13,971 [salt.state       :905 ][INFO    ][32500] Loading fresh modules for state activity
2018-09-13 12:27:14,074 [salt.state       :1770][INFO    ][32500] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:27:14.073954
2018-09-13 12:27:14,074 [salt.state       :1803][INFO    ][32500] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2018-09-13 12:27:14,077 [salt.loaded.int.module.cmdmod:395 ][INFO    ][32500] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2018-09-13 12:27:15,304 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913122715302528
2018-09-13 12:27:15,334 [salt.minion      :1431][INFO    ][32529] Starting a new job with PID 32529
2018-09-13 12:27:15,369 [salt.minion      :1708][INFO    ][32529] Returning information for job: 20180913122715302528
2018-09-13 12:27:15,570 [salt.state       :290 ][INFO    ][32500] {'pid': 32520, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-09-13 12:27:15,571 [salt.state       :1941][INFO    ][32500] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:27:15.571752 duration_in_ms=1497.795
2018-09-13 12:27:15,575 [salt.state       :1770][INFO    ][32500] Running state [maas.machines_status] at time 12:27:15.575229
2018-09-13 12:27:15,576 [salt.state       :1803][INFO    ][32500] Executing state module.run for [maas.machines_status]
2018-09-13 12:27:15,577 [salt.utils.decorators:613 ][WARNING ][32500] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-09-13 12:27:15,990 [salt.state       :290 ][INFO    ][32500] {'ret': {'machines': [{'status': 'Commissioning', 'hostname': u'cmp002', 'system_id': u'4pqqtm'}, {'status': 'Commissioning', 'hostname': u'cmp001', 'system_id': u'8ph7mn'}, {'status': 'Commissioning', 'hostname': u'kvm01', 'system_id': u'rwn4cp'}, {'status': 'Commissioning', 'hostname': u'kvm03', 'system_id': u'tmbdry'}, {'status': 'Commissioning', 'hostname': u'kvm02', 'system_id': u'dwxchw'}], 'summary': Counter({'Commissioning': 5})}}
2018-09-13 12:27:15,990 [salt.state       :1941][INFO    ][32500] Completed state [maas.machines_status] at time 12:27:15.990730 duration_in_ms=415.5
2018-09-13 12:27:15,994 [salt.minion      :1708][INFO    ][32500] Returning information for job: 20180913122710177147
2018-09-13 12:27:26,540 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command state.apply with jid 20180913122726541646
2018-09-13 12:27:26,568 [salt.minion      :1431][INFO    ][479] Starting a new job with PID 479
2018-09-13 12:27:27,170 [salt.state       :905 ][INFO    ][479] Loading fresh modules for state activity
2018-09-13 12:27:27,259 [salt.state       :1770][INFO    ][479] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:27:27.259867
2018-09-13 12:27:27,260 [salt.state       :1803][INFO    ][479] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2018-09-13 12:27:27,263 [salt.loaded.int.module.cmdmod:395 ][INFO    ][479] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2018-09-13 12:27:28,911 [salt.state       :290 ][INFO    ][479] {'pid': 511, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-09-13 12:27:28,912 [salt.state       :1941][INFO    ][479] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:27:28.912754 duration_in_ms=1652.886
2018-09-13 12:27:28,915 [salt.state       :1770][INFO    ][479] Running state [maas.machines_status] at time 12:27:28.915353
2018-09-13 12:27:28,915 [salt.state       :1803][INFO    ][479] Executing state module.run for [maas.machines_status]
2018-09-13 12:27:28,916 [salt.utils.decorators:613 ][WARNING ][479] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-09-13 12:27:29,405 [salt.state       :290 ][INFO    ][479] {'ret': {'machines': [{'status': 'Commissioning', 'hostname': u'cmp002', 'system_id': u'4pqqtm'}, {'status': 'Commissioning', 'hostname': u'cmp001', 'system_id': u'8ph7mn'}, {'status': 'Commissioning', 'hostname': u'kvm01', 'system_id': u'rwn4cp'}, {'status': 'Commissioning', 'hostname': u'kvm03', 'system_id': u'tmbdry'}, {'status': 'Commissioning', 'hostname': u'kvm02', 'system_id': u'dwxchw'}], 'summary': Counter({'Commissioning': 5})}}
2018-09-13 12:27:29,406 [salt.state       :1941][INFO    ][479] Completed state [maas.machines_status] at time 12:27:29.406265 duration_in_ms=490.91
2018-09-13 12:27:29,411 [salt.minion      :1708][INFO    ][479] Returning information for job: 20180913122726541646
2018-09-13 12:27:39,982 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command state.apply with jid 20180913122739986096
2018-09-13 12:27:40,006 [salt.minion      :1431][INFO    ][573] Starting a new job with PID 573
2018-09-13 12:27:43,986 [salt.state       :905 ][INFO    ][573] Loading fresh modules for state activity
2018-09-13 12:27:44,086 [salt.state       :1770][INFO    ][573] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:27:44.086280
2018-09-13 12:27:44,086 [salt.state       :1803][INFO    ][573] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2018-09-13 12:27:44,089 [salt.loaded.int.module.cmdmod:395 ][INFO    ][573] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2018-09-13 12:27:45,095 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913122745097565
2018-09-13 12:27:45,135 [salt.minion      :1431][INFO    ][592] Starting a new job with PID 592
2018-09-13 12:27:45,175 [salt.minion      :1708][INFO    ][592] Returning information for job: 20180913122745097565
2018-09-13 12:27:45,557 [salt.state       :290 ][INFO    ][573] {'pid': 584, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-09-13 12:27:45,558 [salt.state       :1941][INFO    ][573] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:27:45.558185 duration_in_ms=1471.904
2018-09-13 12:27:45,563 [salt.state       :1770][INFO    ][573] Running state [maas.machines_status] at time 12:27:45.563250
2018-09-13 12:27:45,565 [salt.state       :1803][INFO    ][573] Executing state module.run for [maas.machines_status]
2018-09-13 12:27:45,566 [salt.utils.decorators:613 ][WARNING ][573] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-09-13 12:27:46,003 [salt.state       :290 ][INFO    ][573] {'ret': {'machines': [{'status': 'Commissioning', 'hostname': u'cmp002', 'system_id': u'4pqqtm'}, {'status': 'Commissioning', 'hostname': u'cmp001', 'system_id': u'8ph7mn'}, {'status': 'Commissioning', 'hostname': u'kvm01', 'system_id': u'rwn4cp'}, {'status': 'Commissioning', 'hostname': u'kvm03', 'system_id': u'tmbdry'}, {'status': 'Commissioning', 'hostname': u'kvm02', 'system_id': u'dwxchw'}], 'summary': Counter({'Commissioning': 5})}}
2018-09-13 12:27:46,004 [salt.state       :1941][INFO    ][573] Completed state [maas.machines_status] at time 12:27:46.004234 duration_in_ms=440.988
2018-09-13 12:27:46,009 [salt.minion      :1708][INFO    ][573] Returning information for job: 20180913122739986096
2018-09-13 12:27:56,527 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command state.apply with jid 20180913122756534089
2018-09-13 12:27:56,546 [salt.minion      :1431][INFO    ][687] Starting a new job with PID 687
2018-09-13 12:27:57,120 [salt.state       :905 ][INFO    ][687] Loading fresh modules for state activity
2018-09-13 12:27:57,212 [salt.state       :1770][INFO    ][687] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:27:57.212895
2018-09-13 12:27:57,213 [salt.state       :1803][INFO    ][687] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2018-09-13 12:27:57,215 [salt.loaded.int.module.cmdmod:395 ][INFO    ][687] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2018-09-13 12:27:58,872 [salt.state       :290 ][INFO    ][687] {'pid': 727, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-09-13 12:27:58,872 [salt.state       :1941][INFO    ][687] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:27:58.872573 duration_in_ms=1659.678
2018-09-13 12:27:58,874 [salt.state       :1770][INFO    ][687] Running state [maas.machines_status] at time 12:27:58.873992
2018-09-13 12:27:58,874 [salt.state       :1803][INFO    ][687] Executing state module.run for [maas.machines_status]
2018-09-13 12:27:58,874 [salt.utils.decorators:613 ][WARNING ][687] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-09-13 12:27:59,625 [salt.state       :290 ][INFO    ][687] {'ret': {'machines': [{'status': 'Testing', 'hostname': u'cmp002', 'system_id': u'4pqqtm'}, {'status': 'Testing', 'hostname': u'cmp001', 'system_id': u'8ph7mn'}, {'status': 'Testing', 'hostname': u'kvm01', 'system_id': u'rwn4cp'}, {'status': 'Testing', 'hostname': u'kvm03', 'system_id': u'tmbdry'}, {'status': 'Testing', 'hostname': u'kvm02', 'system_id': u'dwxchw'}], 'summary': Counter({'Testing': 5})}}
2018-09-13 12:27:59,625 [salt.state       :1941][INFO    ][687] Completed state [maas.machines_status] at time 12:27:59.625582 duration_in_ms=751.588
2018-09-13 12:27:59,630 [salt.minion      :1708][INFO    ][687] Returning information for job: 20180913122756534089
2018-09-13 12:28:10,168 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command state.apply with jid 20180913122810172684
2018-09-13 12:28:10,196 [salt.minion      :1431][INFO    ][825] Starting a new job with PID 825
2018-09-13 12:28:13,877 [salt.state       :905 ][INFO    ][825] Loading fresh modules for state activity
2018-09-13 12:28:13,981 [salt.state       :1770][INFO    ][825] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:28:13.981073
2018-09-13 12:28:13,981 [salt.state       :1803][INFO    ][825] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2018-09-13 12:28:13,984 [salt.loaded.int.module.cmdmod:395 ][INFO    ][825] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2018-09-13 12:28:15,212 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913122815212043
2018-09-13 12:28:15,246 [salt.minion      :1431][INFO    ][854] Starting a new job with PID 854
2018-09-13 12:28:15,285 [salt.minion      :1708][INFO    ][854] Returning information for job: 20180913122815212043
2018-09-13 12:28:15,545 [salt.state       :290 ][INFO    ][825] {'pid': 845, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-09-13 12:28:15,546 [salt.state       :1941][INFO    ][825] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:28:15.546363 duration_in_ms=1565.289
2018-09-13 12:28:15,549 [salt.state       :1770][INFO    ][825] Running state [maas.machines_status] at time 12:28:15.549836
2018-09-13 12:28:15,550 [salt.state       :1803][INFO    ][825] Executing state module.run for [maas.machines_status]
2018-09-13 12:28:15,551 [salt.utils.decorators:613 ][WARNING ][825] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-09-13 12:28:16,311 [salt.state       :290 ][INFO    ][825] {'ret': {'machines': [{'status': 'Ready', 'hostname': u'cmp002', 'system_id': u'4pqqtm'}, {'status': 'Ready', 'hostname': u'cmp001', 'system_id': u'8ph7mn'}, {'status': 'Ready', 'hostname': u'kvm01', 'system_id': u'rwn4cp'}, {'status': 'Ready', 'hostname': u'kvm03', 'system_id': u'tmbdry'}, {'status': 'Ready', 'hostname': u'kvm02', 'system_id': u'dwxchw'}], 'summary': Counter({'Ready': 5})}}
2018-09-13 12:28:16,312 [salt.state       :1941][INFO    ][825] Completed state [maas.machines_status] at time 12:28:16.312767 duration_in_ms=762.929
2018-09-13 12:28:16,318 [salt.minion      :1708][INFO    ][825] Returning information for job: 20180913122810172684
2018-09-13 12:28:16,962 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command state.apply with jid 20180913122816966729
2018-09-13 12:28:16,992 [salt.minion      :1431][INFO    ][862] Starting a new job with PID 862
2018-09-13 12:28:17,665 [salt.state       :905 ][INFO    ][862] Loading fresh modules for state activity
2018-09-13 12:28:17,766 [salt.state       :1770][INFO    ][862] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:28:17.766132
2018-09-13 12:28:17,766 [salt.state       :1803][INFO    ][862] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2018-09-13 12:28:17,769 [salt.loaded.int.module.cmdmod:395 ][INFO    ][862] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2018-09-13 12:28:19,230 [salt.state       :290 ][INFO    ][862] {'pid': 869, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-09-13 12:28:19,231 [salt.state       :1941][INFO    ][862] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:28:19.231261 duration_in_ms=1465.127
2018-09-13 12:28:19,233 [salt.state       :1770][INFO    ][862] Running state [maas.machines_status] at time 12:28:19.233247
2018-09-13 12:28:19,233 [salt.state       :1803][INFO    ][862] Executing state module.run for [maas.machines_status]
2018-09-13 12:28:19,233 [salt.utils.decorators:613 ][WARNING ][862] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-09-13 12:28:20,102 [salt.state       :290 ][INFO    ][862] {'ret': {'machines': [{'status': 'Ready', 'hostname': u'cmp002', 'system_id': u'4pqqtm'}, {'status': 'Ready', 'hostname': u'cmp001', 'system_id': u'8ph7mn'}, {'status': 'Ready', 'hostname': u'kvm01', 'system_id': u'rwn4cp'}, {'status': 'Ready', 'hostname': u'kvm03', 'system_id': u'tmbdry'}, {'status': 'Ready', 'hostname': u'kvm02', 'system_id': u'dwxchw'}], 'summary': Counter({'Ready': 5})}}
2018-09-13 12:28:20,103 [salt.state       :1941][INFO    ][862] Completed state [maas.machines_status] at time 12:28:20.103240 duration_in_ms=869.99
2018-09-13 12:28:20,109 [salt.minion      :1708][INFO    ][862] Returning information for job: 20180913122816966729
2018-09-13 12:28:20,795 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command state.apply with jid 20180913122820801554
2018-09-13 12:28:20,824 [salt.minion      :1431][INFO    ][893] Starting a new job with PID 893
2018-09-13 12:28:21,471 [salt.state       :905 ][INFO    ][893] Loading fresh modules for state activity
2018-09-13 12:28:21,544 [salt.fileclient  :1215][INFO    ][893] Fetching file from saltenv 'base', ** done ** 'maas/machines/storage.sls'
2018-09-13 12:28:21,669 [salt.state       :1770][INFO    ][893] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:28:21.669513
2018-09-13 12:28:21,670 [salt.state       :1803][INFO    ][893] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2018-09-13 12:28:21,672 [salt.loaded.int.module.cmdmod:395 ][INFO    ][893] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2018-09-13 12:28:23,291 [salt.state       :290 ][INFO    ][893] {'pid': 915, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-09-13 12:28:23,292 [salt.state       :1941][INFO    ][893] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:28:23.292328 duration_in_ms=1622.814
2018-09-13 12:28:23,296 [salt.state       :1770][INFO    ][893] Running state [maas_machines_storage_cmp002_lvm] at time 12:28:23.296477
2018-09-13 12:28:23,297 [salt.state       :1803][INFO    ][893] Executing state maasng.disk_layout_present for [maas_machines_storage_cmp002_lvm]
2018-09-13 12:28:24,920 [salt.loaded.ext.module.maasng:553 ][INFO    ][893] 4pqqtm
2018-09-13 12:28:24,920 [salt.loaded.ext.module.maasng:569 ][INFO    ][893] sda
2018-09-13 12:28:25,523 [salt.loaded.ext.module.maasng:304 ][INFO    ][893] 4pqqtm
2018-09-13 12:28:25,668 [salt.loaded.ext.module.maasng:310 ][INFO    ][893] [{u'model': u'UCSB-MRAID12G', u'available_size': 0, u'uuid': None, u'name': u'sda', u'resource_uri': u'/MAAS/api/2.0/nodes/4pqqtm/blockdevices/3/', u'used_size': 2397998940160, u'partitions': [{u'uuid': u'bc6dc766-b193-4c1b-9885-807c8f915b5b', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'4pqqtm', u'device_id': 3, u'filesystem': {u'uuid': u'002a5478-1c90-42ef-b228-e741bee4f508', u'mount_point': None, u'mount_options': None, u'fstype': u'lvm-pv', u'label': None}, u'path': u'/dev/disk/by-dname/sda-part2', u'resource_uri': u'/MAAS/api/2.0/nodes/4pqqtm/blockdevices/3/partition/1', u'type': u'partition', u'id': 1, u'size': 2397992648704}], u'tags': [u'rotary'], u'used_for': u'GPT partitioned with 1 partition', u'system_id': u'4pqqtm', u'partition_table_type': u'GPT', u'filesystem': None, u'id_path': u'/dev/disk/by-id/wwn-0x618e7283727559801cc788a9059af6a9', u'path': u'/dev/disk/by-dname/sda', u'serial': u'618e7283727559801cc788a9059af6a9', u'block_size': 4096, u'type': u'physical', u'id': 3, u'size': 2397998940160}, {u'model': None, u'available_size': 0, u'uuid': u'281d1294-8ee6-4ab6-a0df-f220aff71c08', u'name': u'vgroot-lvroot', u'resource_uri': u'/MAAS/api/2.0/nodes/4pqqtm/blockdevices/7/', u'used_size': 2397988454400, u'partitions': [], u'tags': [], u'used_for': u'ext4 formatted filesystem mounted at /', u'system_id': u'4pqqtm', u'partition_table_type': None, u'filesystem': {u'uuid': u'709bf29a-a994-42a7-a996-9bca35a428fd', u'mount_point': u'/', u'mount_options': None, u'fstype': u'ext4', u'label': u'root'}, u'id_path': None, u'path': u'/dev/disk/by-dname/lvroot', u'serial': None, u'block_size': 4096, u'type': u'virtual', u'id': 7, u'size': 2397988454400}]
2018-09-13 12:28:25,668 [salt.loaded.ext.module.maasng:575 ][INFO    ][893] vgroot
2018-09-13 12:28:25,669 [salt.loaded.ext.module.maasng:578 ][INFO    ][893] lvroot
2018-09-13 12:28:25,669 [salt.loaded.ext.module.maasng:582 ][INFO    ][893] 107374182400
2018-09-13 12:28:25,913 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913122825914089
2018-09-13 12:28:25,943 [salt.minion      :1431][INFO    ][964] Starting a new job with PID 964
2018-09-13 12:28:25,970 [salt.minion      :1708][INFO    ][964] Returning information for job: 20180913122825914089
2018-09-13 12:28:26,604 [salt.loaded.ext.module.maasng:588 ][INFO    ][893] {u'hwe_kernel': u'', u'swap_size': None, u'memory_test_status': -1, u'ip_addresses': [u'192.168.11.38'], u'storage_test_status_name': u'Passed', u'power_type': u'ipmi', u'domain': {u'resource_record_count': 2, 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'enp6s0', u'links': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'name': u'untagged', u'dhcp_on': True, u'fabric_id': 2, u'mtu': 1500, u'external_dhcp': None, u'relay_vlan': None, u'primary_rack': u'nyaqce', u'id': 5003, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/'}, u'allow_proxy': True, u'rdns_mode': 2, u'gateway_ip': u'192.168.11.3', u'active_discovery': False, u'cidr': u'192.168.11.0/24', u'id': 3, u'resource_uri': u'/MAAS/api/2.0/subnets/3/'}, u'ip_address': u'192.168.11.38', u'mode': u'dhcp', u'id': 25}], u'tags': [], u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'name': u'untagged', u'dhcp_on': True, u'fabric_id': 2, u'mtu': 1500, u'external_dhcp': None, u'relay_vlan': None, u'primary_rack': u'nyaqce', u'id': 5003, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/'}, u'enabled': True, u'id': 6, u'discovered': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'name': u'untagged', u'dhcp_on': True, u'fabric_id': 2, u'mtu': 1500, u'external_dhcp': None, u'relay_vlan': None, u'primary_rack': u'nyaqce', u'id': 5003, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/'}, u'allow_proxy': True, u'rdns_mode': 2, u'gateway_ip': u'192.168.11.3', u'active_discovery': False, u'cidr': u'192.168.11.0/24', u'id': 3, u'resource_uri': u'/MAAS/api/2.0/subnets/3/'}, u'ip_address': u'192.168.11.38'}], u'mac_address': u'00:25:b5:a0:00:6a', u'parents': [], u'params': u'', u'effective_mtu': 1500, u'system_id': u'4pqqtm', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/4pqqtm/interfaces/6/'}, u'fqdn': u'cmp002.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': 2397998940160, u'block_size': 4096, u'name': u'sda', u'tags': [u'rotary'], u'used_size': 2397998940160, u'filesystem': None, u'uuid': None, u'used_for': u'GPT partitioned with 1 partition', u'system_id': u'4pqqtm', u'partition_table_type': u'GPT', u'path': u'/dev/disk/by-dname/sda', u'id_path': u'/dev/disk/by-id/wwn-0x618e7283727559801cc788a9059af6a9', u'available_size': 0, u'model': u'UCSB-MRAID12G', u'partitions': [{u'size': 2397992648704, u'uuid': u'94d2c210-9a8b-4cdd-9c9e-5c1e2c920f31', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'4pqqtm', u'filesystem': {u'mount_options': None, u'fstype': u'lvm-pv', u'mount_point': None, u'uuid': u'3faff9b5-2510-4700-9ad1-a89a84969a8b', u'label': None}, u'path': u'/dev/disk/by-dname/sda-part2', u'resource_uri': u'/MAAS/api/2.0/nodes/4pqqtm/blockdevices/3/partition/10', u'type': u'partition', u'id': 10, u'device_id': 3}], u'type': u'physical', u'id': 3, u'serial': u'618e7283727559801cc788a9059af6a9', u'resource_uri': u'/MAAS/api/2.0/nodes/4pqqtm/blockdevices/3/'}, u'zone': {u'resource_uri': u'/MAAS/api/2.0/zones/default/', u'description': u'', u'name': u'default', u'id': 1}, u'resource_uri': u'/MAAS/api/2.0/machines/4pqqtm/', u'hostname': u'cmp002', u'storage': 2397998.9401599998, u'testing_status': 2, u'system_id': u'4pqqtm', u'raids': [], u'memory': 32768, u'current_installation_result_id': None, u'default_gateways': {u'ipv4': {u'gateway_ip': None, u'link_id': None}, u'ipv6': {u'gateway_ip': None, u'link_id': None}}, u'status_message': u'Power state queried: off', u'owner_data': {}, u'blockdevice_set': [{u'size': 2397998940160, u'block_size': 4096, u'name': u'sda', u'tags': [u'rotary'], u'used_size': 2397998940160, u'filesystem': None, u'uuid': None, u'used_for': u'GPT partitioned with 1 partition', u'system_id': u'4pqqtm', u'partition_table_type': u'GPT', u'path': u'/dev/disk/by-dname/sda', u'id_path': u'/dev/disk/by-id/wwn-0x618e7283727559801cc788a9059af6a9', u'available_size': 0, u'model': u'UCSB-MRAID12G', u'partitions': [{u'size': 2397992648704, u'uuid': u'94d2c210-9a8b-4cdd-9c9e-5c1e2c920f31', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'4pqqtm', u'filesystem': {u'mount_options': None, u'fstype': u'lvm-pv', u'mount_point': None, u'uuid': u'3faff9b5-2510-4700-9ad1-a89a84969a8b', u'label': None}, u'path': u'/dev/disk/by-dname/sda-part2', u'resource_uri': u'/MAAS/api/2.0/nodes/4pqqtm/blockdevices/3/partition/10', u'type': u'partition', u'id': 10, u'device_id': 3}], u'type': u'physical', u'id': 3, u'serial': u'618e7283727559801cc788a9059af6a9', u'resource_uri': u'/MAAS/api/2.0/nodes/4pqqtm/blockdevices/3/'}, {u'size': 107374182400, u'block_size': 4096, u'name': u'vgroot-lvroot', u'tags': [], u'used_size': 107374182400, u'filesystem': {u'mount_options': None, u'fstype': u'ext4', u'mount_point': u'/', u'uuid': u'4b8cf578-c264-4b6e-9b5f-0835536e8456', u'label': u'root'}, u'uuid': u'a8e48872-d8bb-4cb6-9711-fab4067645c2', u'used_for': u'ext4 formatted filesystem mounted at /', u'system_id': u'4pqqtm', u'partition_table_type': None, u'path': u'/dev/disk/by-dname/lvroot', u'id_path': None, u'available_size': 0, u'model': None, u'partitions': [], u'type': u'virtual', u'id': 16, u'serial': None, u'resource_uri': u'/MAAS/api/2.0/nodes/4pqqtm/blockdevices/16/'}], u'status': 4, u'storage_test_status': 2, u'cpu_count': 16, u'power_state': u'off', u'physicalblockdevice_set': [{u'size': 2397998940160, u'block_size': 4096, u'name': u'sda', u'tags': [u'rotary'], u'used_size': 2397998940160, u'filesystem': None, u'uuid': None, u'used_for': u'GPT partitioned with 1 partition', u'system_id': u'4pqqtm', u'partition_table_type': u'GPT', u'path': u'/dev/disk/by-dname/sda', u'id_path': u'/dev/disk/by-id/wwn-0x618e7283727559801cc788a9059af6a9', u'available_size': 0, u'model': u'UCSB-MRAID12G', u'partitions': [{u'size': 2397992648704, u'uuid': u'94d2c210-9a8b-4cdd-9c9e-5c1e2c920f31', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'4pqqtm', u'filesystem': {u'mount_options': None, u'fstype': u'lvm-pv', u'mount_point': None, u'uuid': u'3faff9b5-2510-4700-9ad1-a89a84969a8b', u'label': None}, u'path': u'/dev/disk/by-dname/sda-part2', u'resource_uri': u'/MAAS/api/2.0/nodes/4pqqtm/blockdevices/3/partition/10', u'type': u'partition', u'id': 10, u'device_id': 3}], u'type': u'physical', u'id': 3, u'serial': u'618e7283727559801cc788a9059af6a9', u'resource_uri': u'/MAAS/api/2.0/nodes/4pqqtm/blockdevices/3/'}], u'memory_test_status_name': u'Unknown', u'other_test_status_name': u'Unknown', u'volume_groups': [{u'__incomplete__': True, u'system_id': u'4pqqtm', u'id': 10}], u'special_filesystems': [], u'current_commissioning_result_id': 2, u'node_type_name': u'Machine', u'current_testing_result_id': 3, u'cpu_test_status': -1, u'architecture': u'amd64/generic', u'bcaches': [], u'status_name': u'Ready', u'netboot': True, u'osystem': u'', u'status_action': u'', u'disable_ipv4': False, u'virtualblockdevice_set': [{u'size': 107374182400, u'block_size': 4096, u'name': u'vgroot-lvroot', u'tags': [], u'used_size': 107374182400, u'filesystem': {u'mount_options': None, u'fstype': u'ext4', u'mount_point': u'/', u'uuid': u'4b8cf578-c264-4b6e-9b5f-0835536e8456', u'label': u'root'}, u'uuid': u'a8e48872-d8bb-4cb6-9711-fab4067645c2', u'used_for': u'ext4 formatted filesystem mounted at /', u'system_id': u'4pqqtm', u'partition_table_type': None, u'path': u'/dev/disk/by-dname/vgroot-lvroot', u'id_path': None, u'available_size': 0, u'model': None, u'partitions': [], u'type': u'virtual', u'id': 16, u'serial': None, u'resource_uri': u'/MAAS/api/2.0/nodes/4pqqtm/blockdevices/16/'}], u'commissioning_status': 2, u'min_hwe_kernel': u'hwe-16.04', u'interface_set': [{u'name': u'enp6s0', u'links': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'name': u'untagged', u'dhcp_on': True, u'fabric_id': 2, u'mtu': 1500, u'external_dhcp': None, u'relay_vlan': None, u'primary_rack': u'nyaqce', u'id': 5003, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/'}, u'allow_proxy': True, u'rdns_mode': 2, u'gateway_ip': u'192.168.11.3', u'active_discovery': False, u'cidr': u'192.168.11.0/24', u'id': 3, u'resource_uri': u'/MAAS/api/2.0/subnets/3/'}, u'ip_address': u'192.168.11.38', u'mode': u'dhcp', u'id': 25}], u'tags': [], u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'name': u'untagged', u'dhcp_on': True, u'fabric_id': 2, u'mtu': 1500, u'external_dhcp': None, u'relay_vlan': None, u'primary_rack': u'nyaqce', u'id': 5003, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/'}, u'enabled': True, u'id': 6, u'discovered': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'name': u'untagged', u'dhcp_on': True, u'fabric_id': 2, u'mtu': 1500, u'external_dhcp': None, u'relay_vlan': None, u'primary_rack': u'nyaqce', u'id': 5003, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/'}, u'allow_proxy': True, u'rdns_mode': 2, u'gateway_ip': u'192.168.11.3', u'active_discovery': False, u'cidr': u'192.168.11.0/24', u'id': 3, u'resource_uri': u'/MAAS/api/2.0/subnets/3/'}, u'ip_address': u'192.168.11.38'}], u'mac_address': u'00:25:b5:a0:00:6a', u'parents': [], u'params': u'', u'effective_mtu': 1500, u'system_id': u'4pqqtm', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/4pqqtm/interfaces/6/'}, {u'name': u'enp8s0', u'links': [{u'mode': u'link_up', u'id': 27}], u'tags': [], u'vlan': {u'fabric': u'fabric-0', u'vid': 0, u'space': u'undefined', u'name': u'untagged', u'dhcp_on': False, u'fabric_id': 0, u'mtu': 1500, u'external_dhcp': u'10.20.0.1', u'relay_vlan': None, u'primary_rack': None, u'id': 5001, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/'}, u'enabled': True, u'id': 23, u'discovered': None, u'mac_address': u'00:25:b5:a0:00:6c', u'parents': [], u'params': u'', u'effective_mtu': 1500, u'system_id': u'4pqqtm', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/4pqqtm/interfaces/23/'}, {u'name': u'enp7s0', u'links': [{u'mode': u'link_up', u'id': 30}], u'tags': [], u'vlan': {u'fabric': u'fabric-0', u'vid': 0, u'space': u'undefined', u'name': u'untagged', u'dhcp_on': False, u'fabric_id': 0, u'mtu': 1500, u'external_dhcp': u'10.20.0.1', u'relay_vlan': None, u'primary_rack': None, u'id': 5001, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/'}, u'enabled': True, u'id': 24, u'discovered': None, u'mac_address': u'00:25:b5:a0:00:6b', u'parents': [], u'params': u'', u'effective_mtu': 1500, u'system_id': u'4pqqtm', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/4pqqtm/interfaces/24/'}, {u'name': u'enp9s0', u'links': [{u'mode': u'link_up', u'id': 31}], u'tags': [], u'vlan': {u'fabric': u'fabric-0', u'vid': 0, u'space': u'undefined', u'name': u'untagged', u'dhcp_on': False, u'fabric_id': 0, u'mtu': 1500, u'external_dhcp': u'10.20.0.1', u'relay_vlan': None, u'primary_rack': None, u'id': 5001, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/'}, u'enabled': True, u'id': 21, u'discovered': None, u'mac_address': u'00:25:b5:a0:00:6d', u'parents': [], u'params': u'', u'effective_mtu': 1500, u'system_id': u'4pqqtm', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/4pqqtm/interfaces/21/'}], u'address_ttl': None, u'other_test_status': -1, u'distro_series': u'', u'commissioning_status_name': u'Passed'}
2018-09-13 12:28:26,605 [salt.state       :290 ][INFO    ][893] {'new': {'storage_layout': 'lvm'}}
2018-09-13 12:28:26,606 [salt.state       :1941][INFO    ][893] Completed state [maas_machines_storage_cmp002_lvm] at time 12:28:26.606257 duration_in_ms=3309.781
2018-09-13 12:28:26,606 [salt.state       :1770][INFO    ][893] Running state [maas_machines_storage_cmp001_lvm] at time 12:28:26.606874
2018-09-13 12:28:26,607 [salt.state       :1803][INFO    ][893] Executing state maasng.disk_layout_present for [maas_machines_storage_cmp001_lvm]
2018-09-13 12:28:28,254 [salt.loaded.ext.module.maasng:553 ][INFO    ][893] 8ph7mn
2018-09-13 12:28:28,255 [salt.loaded.ext.module.maasng:569 ][INFO    ][893] sda
2018-09-13 12:28:29,092 [salt.loaded.ext.module.maasng:304 ][INFO    ][893] 8ph7mn
2018-09-13 12:28:29,251 [salt.loaded.ext.module.maasng:310 ][INFO    ][893] [{u'size': 2397998940160, u'block_size': 4096, u'name': u'sda', u'tags': [u'rotary'], u'used_size': 2397998940160, u'id': 6, u'uuid': None, u'used_for': u'GPT partitioned with 1 partition', u'path': u'/dev/disk/by-dname/sda', u'system_id': u'8ph7mn', u'partition_table_type': u'GPT', u'filesystem': None, u'id_path': u'/dev/disk/by-id/wwn-0x618e72837274f1901cc7889705aa1b02', u'available_size': 0, u'model': u'UCSB-MRAID12G', u'partitions': [{u'uuid': u'49493003-cd1a-4b32-980f-0c4b2938555d', u'resource_uri': u'/MAAS/api/2.0/nodes/8ph7mn/blockdevices/6/partition/9', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'8ph7mn', u'filesystem': {u'mount_options': None, u'label': None, u'mount_point': None, u'uuid': u'af0af051-4a99-4485-88e1-10f6b422c24b', u'fstype': u'lvm-pv'}, u'path': u'/dev/disk/by-dname/sda-part2', u'device_id': 6, u'type': u'partition', u'id': 9, u'size': 2397992648704}], u'type': u'physical', u'serial': u'618e72837274f1901cc7889705aa1b02', u'resource_uri': u'/MAAS/api/2.0/nodes/8ph7mn/blockdevices/6/'}, {u'size': 2397988454400, u'block_size': 4096, u'name': u'vgroot-lvroot', u'tags': [], u'used_size': 2397988454400, u'id': 15, u'uuid': u'f92d42b1-0f9e-41da-b54b-69851057e457', u'used_for': u'ext4 formatted filesystem mounted at /', u'path': u'/dev/disk/by-dname/lvroot', u'system_id': u'8ph7mn', u'partition_table_type': None, u'filesystem': {u'mount_options': None, u'label': u'root', u'mount_point': u'/', u'uuid': u'9e85d4a5-6079-4909-8b3f-fc53f3daa61c', u'fstype': u'ext4'}, u'id_path': None, u'available_size': 0, u'model': None, u'partitions': [], u'type': u'virtual', u'serial': None, u'resource_uri': u'/MAAS/api/2.0/nodes/8ph7mn/blockdevices/15/'}]
2018-09-13 12:28:29,252 [salt.loaded.ext.module.maasng:575 ][INFO    ][893] vgroot
2018-09-13 12:28:29,253 [salt.loaded.ext.module.maasng:578 ][INFO    ][893] lvroot
2018-09-13 12:28:29,253 [salt.loaded.ext.module.maasng:582 ][INFO    ][893] 107374182400
2018-09-13 12:28:30,143 [salt.loaded.ext.module.maasng:588 ][INFO    ][893] {u'hwe_kernel': u'', u'swap_size': None, u'disable_ipv4': False, u'cpu_count': 16, u'power_type': u'ipmi', u'domain': {u'resource_record_count': 2, 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'enp6s0', u'links': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 2, u'dhcp_on': True, u'mtu': 1500, u'external_dhcp': None, u'fabric': u'pxe_admin', u'relay_vlan': None, u'primary_rack': u'nyaqce', u'id': 5003, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/'}, u'allow_proxy': True, u'rdns_mode': 2, u'gateway_ip': u'192.168.11.3', u'active_discovery': False, u'cidr': u'192.168.11.0/24', u'id': 3, u'resource_uri': u'/MAAS/api/2.0/subnets/3/'}, u'ip_address': u'192.168.11.39', u'mode': u'dhcp', u'id': 53}], u'tags': [], u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 2, u'dhcp_on': True, u'mtu': 1500, u'external_dhcp': None, u'fabric': u'pxe_admin', u'relay_vlan': None, u'primary_rack': u'nyaqce', u'id': 5003, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/'}, 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'fabric_id': 2, u'dhcp_on': True, u'mtu': 1500, u'external_dhcp': None, u'fabric': u'pxe_admin', u'relay_vlan': None, u'primary_rack': u'nyaqce', u'id': 5003, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/'}, u'allow_proxy': True, u'rdns_mode': 2, u'gateway_ip': u'192.168.11.3', u'active_discovery': False, u'cidr': u'192.168.11.0/24', u'id': 3, u'resource_uri': u'/MAAS/api/2.0/subnets/3/'}, u'ip_address': u'192.168.11.39'}], u'mac_address': u'00:25:b5:a0:00:5a', u'params': u'', u'effective_mtu': 1500, u'parents': [], u'system_id': u'8ph7mn', u'type': u'physical', u'id': 7, u'resource_uri': u'/MAAS/api/2.0/nodes/8ph7mn/interfaces/7/'}, u'min_hwe_kernel': u'hwe-16.04', 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'status_action': u'', u'zone': {u'resource_uri': u'/MAAS/api/2.0/zones/default/', u'id': 1, u'name': u'default', u'description': u''}, u'node_type_name': u'Machine', u'hostname': u'cmp001', u'storage': 2397998.9401599998, u'testing_status': 2, u'system_id': u'8ph7mn', u'raids': [], u'memory': 32768, u'current_installation_result_id': None, u'default_gateways': {u'ipv4': {u'gateway_ip': None, u'link_id': None}, u'ipv6': {u'gateway_ip': None, u'link_id': None}}, u'status_message': u'Power state queried: off', u'virtualblockdevice_set': [{u'size': 107374182400, u'available_size': 0, u'name': u'vgroot-lvroot', u'tags': [], u'used_size': 107374182400, u'partitions': [], u'uuid': u'4afb1f26-f2f6-48a8-bb1e-11ff44e6b1e5', u'used_for': u'ext4 formatted filesystem mounted at /', u'system_id': u'8ph7mn', u'partition_table_type': None, u'filesystem': {u'uuid': u'055ad1ea-1e6f-4c42-9eaa-642baffffc9c', u'mount_point': u'/', u'mount_options': None, u'fstype': u'ext4', u'label': u'root'}, u'id_path': None, u'path': u'/dev/disk/by-dname/vgroot-lvroot', u'model': None, u'block_size': 4096, u'type': u'virtual', u'id': 17, u'serial': None, u'resource_uri': u'/MAAS/api/2.0/nodes/8ph7mn/blockdevices/17/'}], u'blockdevice_set': [{u'size': 2397998940160, u'available_size': 0, u'name': u'sda', u'tags': [u'rotary'], u'used_size': 2397998940160, u'partitions': [{u'size': 2397992648704, u'uuid': u'5ea5ddd4-8f97-4b14-93f6-f2f0f3674a58', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'8ph7mn', u'filesystem': {u'uuid': u'1da46abc-f678-4018-9b2b-b60d6b1bab8f', u'mount_point': None, u'mount_options': None, u'fstype': u'lvm-pv', u'label': None}, u'path': u'/dev/disk/by-dname/sda-part2', u'device_id': 6, u'type': u'partition', u'id': 11, u'resource_uri': u'/MAAS/api/2.0/nodes/8ph7mn/blockdevices/6/partition/11'}], u'uuid': None, u'used_for': u'GPT partitioned with 1 partition', u'system_id': u'8ph7mn', u'partition_table_type': u'GPT', u'filesystem': None, u'id_path': u'/dev/disk/by-id/wwn-0x618e72837274f1901cc7889705aa1b02', u'path': u'/dev/disk/by-dname/sda', u'model': u'UCSB-MRAID12G', u'block_size': 4096, u'type': u'physical', u'id': 6, u'serial': u'618e72837274f1901cc7889705aa1b02', u'resource_uri': u'/MAAS/api/2.0/nodes/8ph7mn/blockdevices/6/'}, {u'size': 107374182400, u'available_size': 0, u'name': u'vgroot-lvroot', u'tags': [], u'used_size': 107374182400, u'partitions': [], u'uuid': u'4afb1f26-f2f6-48a8-bb1e-11ff44e6b1e5', u'used_for': u'ext4 formatted filesystem mounted at /', u'system_id': u'8ph7mn', u'partition_table_type': None, u'filesystem': {u'uuid': u'055ad1ea-1e6f-4c42-9eaa-642baffffc9c', u'mount_point': u'/', u'mount_options': None, u'fstype': u'ext4', u'label': u'root'}, u'id_path': None, u'path': u'/dev/disk/by-dname/lvroot', u'model': None, u'block_size': 4096, u'type': u'virtual', u'id': 17, u'serial': None, u'resource_uri': u'/MAAS/api/2.0/nodes/8ph7mn/blockdevices/17/'}], u'status': 4, u'bcaches': [], u'storage_test_status_name': u'Passed', u'power_state': u'off', u'owner_data': {}, u'other_test_status_name': u'Unknown', u'volume_groups': [{u'__incomplete__': True, u'system_id': u'8ph7mn', u'id': 11}], u'special_filesystems': [], u'current_commissioning_result_id': 4, u'boot_disk': {u'size': 2397998940160, u'available_size': 0, u'name': u'sda', u'tags': [u'rotary'], u'used_size': 2397998940160, u'partitions': [{u'size': 2397992648704, u'uuid': u'5ea5ddd4-8f97-4b14-93f6-f2f0f3674a58', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'8ph7mn', u'filesystem': {u'uuid': u'1da46abc-f678-4018-9b2b-b60d6b1bab8f', u'mount_point': None, u'mount_options': None, u'fstype': u'lvm-pv', u'label': None}, u'path': u'/dev/disk/by-dname/sda-part2', u'device_id': 6, u'type': u'partition', u'id': 11, u'resource_uri': u'/MAAS/api/2.0/nodes/8ph7mn/blockdevices/6/partition/11'}], u'uuid': None, u'used_for': u'GPT partitioned with 1 partition', u'system_id': u'8ph7mn', u'partition_table_type': u'GPT', u'filesystem': None, u'id_path': u'/dev/disk/by-id/wwn-0x618e72837274f1901cc7889705aa1b02', u'path': u'/dev/disk/by-dname/sda', u'model': u'UCSB-MRAID12G', u'block_size': 4096, u'type': u'physical', u'id': 6, u'serial': u'618e72837274f1901cc7889705aa1b02', u'resource_uri': u'/MAAS/api/2.0/nodes/8ph7mn/blockdevices/6/'}, u'interface_set': [{u'name': u'enp6s0', u'links': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 2, u'dhcp_on': True, u'mtu': 1500, u'external_dhcp': None, u'fabric': u'pxe_admin', u'relay_vlan': None, u'primary_rack': u'nyaqce', u'id': 5003, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/'}, u'allow_proxy': True, u'rdns_mode': 2, u'gateway_ip': u'192.168.11.3', u'active_discovery': False, u'cidr': u'192.168.11.0/24', u'id': 3, u'resource_uri': u'/MAAS/api/2.0/subnets/3/'}, u'ip_address': u'192.168.11.39', u'mode': u'dhcp', u'id': 53}], u'tags': [], u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 2, u'dhcp_on': True, u'mtu': 1500, u'external_dhcp': None, u'fabric': u'pxe_admin', u'relay_vlan': None, u'primary_rack': u'nyaqce', u'id': 5003, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/'}, 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'fabric_id': 2, u'dhcp_on': True, u'mtu': 1500, u'external_dhcp': None, u'fabric': u'pxe_admin', u'relay_vlan': None, u'primary_rack': u'nyaqce', u'id': 5003, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/'}, u'allow_proxy': True, u'rdns_mode': 2, u'gateway_ip': u'192.168.11.3', u'active_discovery': False, u'cidr': u'192.168.11.0/24', u'id': 3, u'resource_uri': u'/MAAS/api/2.0/subnets/3/'}, u'ip_address': u'192.168.11.39'}], u'mac_address': u'00:25:b5:a0:00:5a', u'params': u'', u'effective_mtu': 1500, u'parents': [], u'system_id': u'8ph7mn', u'type': u'physical', u'id': 7, u'resource_uri': u'/MAAS/api/2.0/nodes/8ph7mn/interfaces/7/'}, {u'name': u'enp7s0', u'links': [{u'id': 57, u'mode': u'link_up'}], u'tags': [], u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 0, u'dhcp_on': False, u'mtu': 1500, u'external_dhcp': u'10.20.0.1', u'fabric': u'fabric-0', u'relay_vlan': None, u'primary_rack': None, u'id': 5001, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/'}, u'enabled': True, u'children': [], u'discovered': None, u'mac_address': u'00:25:b5:a0:00:5b', u'params': u'', u'effective_mtu': 1500, u'parents': [], u'system_id': u'8ph7mn', u'type': u'physical', u'id': 25, u'resource_uri': u'/MAAS/api/2.0/nodes/8ph7mn/interfaces/25/'}, {u'name': u'enp8s0', u'links': [{u'id': 59, u'mode': u'link_up'}], u'tags': [], u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 0, u'dhcp_on': False, u'mtu': 1500, u'external_dhcp': u'10.20.0.1', u'fabric': u'fabric-0', u'relay_vlan': None, u'primary_rack': None, u'id': 5001, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/'}, u'enabled': True, u'children': [], u'discovered': None, u'mac_address': u'00:25:b5:a0:00:5c', u'params': u'', u'effective_mtu': 1500, u'parents': [], u'system_id': u'8ph7mn', u'type': u'physical', u'id': 26, u'resource_uri': u'/MAAS/api/2.0/nodes/8ph7mn/interfaces/26/'}, {u'name': u'enp9s0', u'links': [{u'id': 60, u'mode': u'link_up'}], u'tags': [], u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 0, u'dhcp_on': False, u'mtu': 1500, u'external_dhcp': u'10.20.0.1', u'fabric': u'fabric-0', u'relay_vlan': None, u'primary_rack': None, u'id': 5001, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/'}, u'enabled': True, u'children': [], u'discovered': None, u'mac_address': u'00:25:b5:a0:00:5d', u'params': u'', u'effective_mtu': 1500, u'parents': [], u'system_id': u'8ph7mn', u'type': u'physical', u'id': 19, u'resource_uri': u'/MAAS/api/2.0/nodes/8ph7mn/interfaces/19/'}], u'current_testing_result_id': 5, u'cpu_test_status': -1, u'storage_test_status': 2, u'other_test_status': -1, u'status_name': u'Ready', u'physicalblockdevice_set': [{u'size': 2397998940160, u'available_size': 0, u'name': u'sda', u'tags': [u'rotary'], u'used_size': 2397998940160, u'partitions': [{u'size': 2397992648704, u'uuid': u'5ea5ddd4-8f97-4b14-93f6-f2f0f3674a58', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'8ph7mn', u'filesystem': {u'uuid': u'1da46abc-f678-4018-9b2b-b60d6b1bab8f', u'mount_point': None, u'mount_options': None, u'fstype': u'lvm-pv', u'label': None}, u'path': u'/dev/disk/by-dname/sda-part2', u'device_id': 6, u'type': u'partition', u'id': 11, u'resource_uri': u'/MAAS/api/2.0/nodes/8ph7mn/blockdevices/6/partition/11'}], u'uuid': None, u'used_for': u'GPT partitioned with 1 partition', u'system_id': u'8ph7mn', u'partition_table_type': u'GPT', u'filesystem': None, u'id_path': u'/dev/disk/by-id/wwn-0x618e72837274f1901cc7889705aa1b02', u'path': u'/dev/disk/by-dname/sda', u'model': u'UCSB-MRAID12G', u'block_size': 4096, u'type': u'physical', u'id': 6, u'serial': u'618e72837274f1901cc7889705aa1b02', u'resource_uri': u'/MAAS/api/2.0/nodes/8ph7mn/blockdevices/6/'}], u'netboot': True, u'osystem': u'', u'fqdn': u'cmp001.maas', u'memory_test_status_name': u'Unknown', u'commissioning_status': 2, u'architecture': u'amd64/generic', u'commissioning_status_name': u'Passed', u'ip_addresses': [u'192.168.11.39'], u'address_ttl': None, u'resource_uri': u'/MAAS/api/2.0/machines/8ph7mn/', u'distro_series': u'', u'memory_test_status': -1}
2018-09-13 12:28:30,145 [salt.state       :290 ][INFO    ][893] {'new': {'storage_layout': 'lvm'}}
2018-09-13 12:28:30,146 [salt.state       :1941][INFO    ][893] Completed state [maas_machines_storage_cmp001_lvm] at time 12:28:30.145943 duration_in_ms=3539.067
2018-09-13 12:28:30,152 [salt.minion      :1708][INFO    ][893] Returning information for job: 20180913122820801554
2018-09-13 12:28:30,848 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command state.apply with jid 20180913122830846638
2018-09-13 12:28:30,880 [salt.minion      :1431][INFO    ][997] Starting a new job with PID 997
2018-09-13 12:28:31,523 [salt.state       :905 ][INFO    ][997] Loading fresh modules for state activity
2018-09-13 12:28:31,583 [salt.fileclient  :1215][INFO    ][997] Fetching file from saltenv 'base', ** done ** 'maas/machines/deploy.sls'
2018-09-13 12:28:31,624 [salt.state       :1770][INFO    ][997] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:28:31.624085
2018-09-13 12:28:31,624 [salt.state       :1803][INFO    ][997] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2018-09-13 12:28:31,626 [salt.loaded.int.module.cmdmod:395 ][INFO    ][997] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2018-09-13 12:28:33,212 [salt.state       :290 ][INFO    ][997] {'pid': 1004, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-09-13 12:28:33,213 [salt.state       :1941][INFO    ][997] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:28:33.213529 duration_in_ms=1589.443
2018-09-13 12:28:33,217 [salt.state       :1770][INFO    ][997] Running state [maas.deploy_machines] at time 12:28:33.217110
2018-09-13 12:28:33,217 [salt.state       :1803][INFO    ][997] Executing state module.run for [maas.deploy_machines]
2018-09-13 12:28:33,218 [salt.utils.decorators:613 ][WARNING ][997] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-09-13 12:28:34,071 [salt.loaded.ext.module.maas:654 ][INFO    ][997] deploymachines hwe_kernel=hwe-16.04 system_id=4pqqtm distro_series=xenial
2018-09-13 12:28:35,951 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913122835957680
2018-09-13 12:28:35,976 [salt.minion      :1431][INFO    ][1056] Starting a new job with PID 1056
2018-09-13 12:28:36,002 [salt.minion      :1708][INFO    ][1056] Returning information for job: 20180913122835957680
2018-09-13 12:28:37,071 [salt.loaded.ext.module.maas:654 ][INFO    ][997] deploymachines hwe_kernel=hwe-16.04 system_id=8ph7mn distro_series=xenial
2018-09-13 12:28:40,090 [salt.loaded.ext.module.maas:654 ][INFO    ][997] deploymachines hwe_kernel=hwe-16.04 system_id=rwn4cp distro_series=xenial
2018-09-13 12:28:43,390 [salt.loaded.ext.module.maas:654 ][INFO    ][997] deploymachines hwe_kernel=hwe-16.04 system_id=tmbdry distro_series=xenial
2018-09-13 12:28:46,167 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913122846168882
2018-09-13 12:28:46,203 [salt.minion      :1431][INFO    ][1222] Starting a new job with PID 1222
2018-09-13 12:28:46,249 [salt.minion      :1708][INFO    ][1222] Returning information for job: 20180913122846168882
2018-09-13 12:28:46,628 [salt.loaded.ext.module.maas:654 ][INFO    ][997] deploymachines hwe_kernel=hwe-16.04 system_id=dwxchw distro_series=xenial
2018-09-13 12:28:49,481 [salt.state       :290 ][INFO    ][997] {'ret': {'updated': [], 'errors': {}, 'success': ['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']}}
2018-09-13 12:28:49,482 [salt.state       :1941][INFO    ][997] Completed state [maas.deploy_machines] at time 12:28:49.482510 duration_in_ms=16265.398
2018-09-13 12:28:49,491 [salt.minion      :1708][INFO    ][997] Returning information for job: 20180913122830846638
2018-09-13 12:29:00,136 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command pillar.get with jid 20180913122900140413
2018-09-13 12:29:00,169 [salt.minion      :1431][INFO    ][1303] Starting a new job with PID 1303
2018-09-13 12:29:00,183 [salt.minion      :1708][INFO    ][1303] Returning information for job: 20180913122900140413
2018-09-13 12:29:00,789 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command state.apply with jid 20180913122900793854
2018-09-13 12:29:00,817 [salt.minion      :1431][INFO    ][1309] Starting a new job with PID 1309
2018-09-13 12:29:04,602 [salt.state       :905 ][INFO    ][1309] Loading fresh modules for state activity
2018-09-13 12:29:04,675 [salt.state       :1770][INFO    ][1309] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:29:04.675230
2018-09-13 12:29:04,675 [salt.state       :1803][INFO    ][1309] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2018-09-13 12:29:04,679 [salt.loaded.int.module.cmdmod:395 ][INFO    ][1309] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2018-09-13 12:29:05,830 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913122905833394
2018-09-13 12:29:05,863 [salt.minion      :1431][INFO    ][1324] Starting a new job with PID 1324
2018-09-13 12:29:05,889 [salt.minion      :1708][INFO    ][1324] Returning information for job: 20180913122905833394
2018-09-13 12:29:06,189 [salt.state       :290 ][INFO    ][1309] {'pid': 1316, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-09-13 12:29:06,191 [salt.state       :1941][INFO    ][1309] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:29:06.191298 duration_in_ms=1516.067
2018-09-13 12:29:06,195 [salt.state       :1770][INFO    ][1309] Running state [maas.machines_status] at time 12:29:06.195104
2018-09-13 12:29:06,196 [salt.state       :1803][INFO    ][1309] Executing state module.run for [maas.machines_status]
2018-09-13 12:29:06,197 [salt.utils.decorators:613 ][WARNING ][1309] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-09-13 12:29:07,098 [salt.state       :290 ][INFO    ][1309] {'ret': {'machines': [{'status': 'Deploying', 'hostname': u'cmp002', 'system_id': u'4pqqtm'}, {'status': 'Deploying', 'hostname': u'cmp001', 'system_id': u'8ph7mn'}, {'status': 'Deploying', 'hostname': u'kvm01', 'system_id': u'rwn4cp'}, {'status': 'Deploying', 'hostname': u'kvm03', 'system_id': u'tmbdry'}, {'status': 'Deploying', 'hostname': u'kvm02', 'system_id': u'dwxchw'}], 'summary': Counter({'Deploying': 5})}}
2018-09-13 12:29:07,099 [salt.state       :1941][INFO    ][1309] Completed state [maas.machines_status] at time 12:29:07.099528 duration_in_ms=904.424
2018-09-13 12:29:07,104 [salt.minion      :1708][INFO    ][1309] Returning information for job: 20180913122900793854
2018-09-13 12:29:17,749 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command state.apply with jid 20180913122917750620
2018-09-13 12:29:17,776 [salt.minion      :1431][INFO    ][1358] Starting a new job with PID 1358
2018-09-13 12:29:18,462 [salt.state       :905 ][INFO    ][1358] Loading fresh modules for state activity
2018-09-13 12:29:18,563 [salt.state       :1770][INFO    ][1358] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:29:18.563683
2018-09-13 12:29:18,565 [salt.state       :1803][INFO    ][1358] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2018-09-13 12:29:18,568 [salt.loaded.int.module.cmdmod:395 ][INFO    ][1358] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2018-09-13 12:29:20,085 [salt.state       :290 ][INFO    ][1358] {'pid': 1365, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-09-13 12:29:20,086 [salt.state       :1941][INFO    ][1358] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:29:20.086730 duration_in_ms=1523.046
2018-09-13 12:29:20,088 [salt.state       :1770][INFO    ][1358] Running state [maas.machines_status] at time 12:29:20.088771
2018-09-13 12:29:20,089 [salt.state       :1803][INFO    ][1358] Executing state module.run for [maas.machines_status]
2018-09-13 12:29:20,089 [salt.utils.decorators:613 ][WARNING ][1358] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-09-13 12:29:20,961 [salt.state       :290 ][INFO    ][1358] {'ret': {'machines': [{'status': 'Deploying', 'hostname': u'cmp002', 'system_id': u'4pqqtm'}, {'status': 'Deploying', 'hostname': u'cmp001', 'system_id': u'8ph7mn'}, {'status': 'Deploying', 'hostname': u'kvm01', 'system_id': u'rwn4cp'}, {'status': 'Deploying', 'hostname': u'kvm03', 'system_id': u'tmbdry'}, {'status': 'Deploying', 'hostname': u'kvm02', 'system_id': u'dwxchw'}], 'summary': Counter({'Deploying': 5})}}
2018-09-13 12:29:20,963 [salt.state       :1941][INFO    ][1358] Completed state [maas.machines_status] at time 12:29:20.963651 duration_in_ms=874.877
2018-09-13 12:29:20,968 [salt.minion      :1708][INFO    ][1358] Returning information for job: 20180913122917750620
2018-09-13 12:29:31,569 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command state.apply with jid 20180913122931573620
2018-09-13 12:29:31,598 [salt.minion      :1431][INFO    ][1417] Starting a new job with PID 1417
2018-09-13 12:29:35,298 [salt.state       :905 ][INFO    ][1417] Loading fresh modules for state activity
2018-09-13 12:29:35,407 [salt.state       :1770][INFO    ][1417] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:29:35.407026
2018-09-13 12:29:35,407 [salt.state       :1803][INFO    ][1417] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2018-09-13 12:29:35,410 [salt.loaded.int.module.cmdmod:395 ][INFO    ][1417] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2018-09-13 12:29:36,628 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913122936633525
2018-09-13 12:29:36,663 [salt.minion      :1431][INFO    ][1439] Starting a new job with PID 1439
2018-09-13 12:29:36,703 [salt.minion      :1708][INFO    ][1439] Returning information for job: 20180913122936633525
2018-09-13 12:29:37,085 [salt.state       :290 ][INFO    ][1417] {'pid': 1429, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-09-13 12:29:37,086 [salt.state       :1941][INFO    ][1417] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:29:37.086574 duration_in_ms=1679.545
2018-09-13 12:29:37,090 [salt.state       :1770][INFO    ][1417] Running state [maas.machines_status] at time 12:29:37.090118
2018-09-13 12:29:37,091 [salt.state       :1803][INFO    ][1417] Executing state module.run for [maas.machines_status]
2018-09-13 12:29:37,092 [salt.utils.decorators:613 ][WARNING ][1417] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-09-13 12:29:38,060 [salt.state       :290 ][INFO    ][1417] {'ret': {'machines': [{'status': 'Deploying', 'hostname': u'cmp002', 'system_id': u'4pqqtm'}, {'status': 'Deploying', 'hostname': u'cmp001', 'system_id': u'8ph7mn'}, {'status': 'Deploying', 'hostname': u'kvm01', 'system_id': u'rwn4cp'}, {'status': 'Deploying', 'hostname': u'kvm03', 'system_id': u'tmbdry'}, {'status': 'Deploying', 'hostname': u'kvm02', 'system_id': u'dwxchw'}], 'summary': Counter({'Deploying': 5})}}
2018-09-13 12:29:38,061 [salt.state       :1941][INFO    ][1417] Completed state [maas.machines_status] at time 12:29:38.061308 duration_in_ms=971.189
2018-09-13 12:29:38,065 [salt.minion      :1708][INFO    ][1417] Returning information for job: 20180913122931573620
2018-09-13 12:29:48,662 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command state.apply with jid 20180913122948667911
2018-09-13 12:29:48,684 [salt.minion      :1431][INFO    ][1455] Starting a new job with PID 1455
2018-09-13 12:29:49,328 [salt.state       :905 ][INFO    ][1455] Loading fresh modules for state activity
2018-09-13 12:29:49,430 [salt.state       :1770][INFO    ][1455] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:29:49.430163
2018-09-13 12:29:49,430 [salt.state       :1803][INFO    ][1455] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2018-09-13 12:29:49,433 [salt.loaded.int.module.cmdmod:395 ][INFO    ][1455] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2018-09-13 12:29:50,985 [salt.state       :290 ][INFO    ][1455] {'pid': 1463, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-09-13 12:29:50,986 [salt.state       :1941][INFO    ][1455] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:29:50.986234 duration_in_ms=1556.069
2018-09-13 12:29:50,989 [salt.state       :1770][INFO    ][1455] Running state [maas.machines_status] at time 12:29:50.989563
2018-09-13 12:29:50,990 [salt.state       :1803][INFO    ][1455] Executing state module.run for [maas.machines_status]
2018-09-13 12:29:50,991 [salt.utils.decorators:613 ][WARNING ][1455] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-09-13 12:29:51,785 [salt.state       :290 ][INFO    ][1455] {'ret': {'machines': [{'status': 'Deploying', 'hostname': u'cmp002', 'system_id': u'4pqqtm'}, {'status': 'Deploying', 'hostname': u'cmp001', 'system_id': u'8ph7mn'}, {'status': 'Deploying', 'hostname': u'kvm01', 'system_id': u'rwn4cp'}, {'status': 'Deploying', 'hostname': u'kvm03', 'system_id': u'tmbdry'}, {'status': 'Deploying', 'hostname': u'kvm02', 'system_id': u'dwxchw'}], 'summary': Counter({'Deploying': 5})}}
2018-09-13 12:29:51,785 [salt.state       :1941][INFO    ][1455] Completed state [maas.machines_status] at time 12:29:51.785711 duration_in_ms=796.147
2018-09-13 12:29:51,790 [salt.minion      :1708][INFO    ][1455] Returning information for job: 20180913122948667911
2018-09-13 12:30:02,337 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command state.apply with jid 20180913123002340702
2018-09-13 12:30:02,370 [salt.minion      :1431][INFO    ][1483] Starting a new job with PID 1483
2018-09-13 12:30:06,030 [salt.state       :905 ][INFO    ][1483] Loading fresh modules for state activity
2018-09-13 12:30:06,088 [salt.state       :1770][INFO    ][1483] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:30:06.088700
2018-09-13 12:30:06,089 [salt.state       :1803][INFO    ][1483] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2018-09-13 12:30:06,091 [salt.loaded.int.module.cmdmod:395 ][INFO    ][1483] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2018-09-13 12:30:07,366 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913123007373504
2018-09-13 12:30:07,390 [salt.minion      :1431][INFO    ][1499] Starting a new job with PID 1499
2018-09-13 12:30:07,429 [salt.minion      :1708][INFO    ][1499] Returning information for job: 20180913123007373504
2018-09-13 12:30:07,439 [salt.state       :290 ][INFO    ][1483] {'pid': 1490, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-09-13 12:30:07,440 [salt.state       :1941][INFO    ][1483] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:30:07.440086 duration_in_ms=1351.385
2018-09-13 12:30:07,441 [salt.state       :1770][INFO    ][1483] Running state [maas.machines_status] at time 12:30:07.441660
2018-09-13 12:30:07,442 [salt.state       :1803][INFO    ][1483] Executing state module.run for [maas.machines_status]
2018-09-13 12:30:07,442 [salt.utils.decorators:613 ][WARNING ][1483] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-09-13 12:30:08,240 [salt.state       :290 ][INFO    ][1483] {'ret': {'machines': [{'status': 'Deploying', 'hostname': u'cmp002', 'system_id': u'4pqqtm'}, {'status': 'Deploying', 'hostname': u'cmp001', 'system_id': u'8ph7mn'}, {'status': 'Deploying', 'hostname': u'kvm01', 'system_id': u'rwn4cp'}, {'status': 'Deploying', 'hostname': u'kvm03', 'system_id': u'tmbdry'}, {'status': 'Deploying', 'hostname': u'kvm02', 'system_id': u'dwxchw'}], 'summary': Counter({'Deploying': 5})}}
2018-09-13 12:30:08,240 [salt.state       :1941][INFO    ][1483] Completed state [maas.machines_status] at time 12:30:08.240568 duration_in_ms=798.905
2018-09-13 12:30:08,244 [salt.minion      :1708][INFO    ][1483] Returning information for job: 20180913123002340702
2018-09-13 12:30:18,786 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command state.apply with jid 20180913123018790199
2018-09-13 12:30:18,807 [salt.minion      :1431][INFO    ][1577] Starting a new job with PID 1577
2018-09-13 12:30:19,394 [salt.state       :905 ][INFO    ][1577] Loading fresh modules for state activity
2018-09-13 12:30:19,487 [salt.state       :1770][INFO    ][1577] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:30:19.487346
2018-09-13 12:30:19,487 [salt.state       :1803][INFO    ][1577] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2018-09-13 12:30:19,490 [salt.loaded.int.module.cmdmod:395 ][INFO    ][1577] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2018-09-13 12:30:21,214 [salt.state       :290 ][INFO    ][1577] {'pid': 1584, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-09-13 12:30:21,215 [salt.state       :1941][INFO    ][1577] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:30:21.215212 duration_in_ms=1727.865
2018-09-13 12:30:21,217 [salt.state       :1770][INFO    ][1577] Running state [maas.machines_status] at time 12:30:21.217234
2018-09-13 12:30:21,217 [salt.state       :1803][INFO    ][1577] Executing state module.run for [maas.machines_status]
2018-09-13 12:30:21,218 [salt.utils.decorators:613 ][WARNING ][1577] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-09-13 12:30:21,752 [salt.state       :290 ][INFO    ][1577] {'ret': {'machines': [{'status': 'Deploying', 'hostname': u'cmp002', 'system_id': u'4pqqtm'}, {'status': 'Deploying', 'hostname': u'cmp001', 'system_id': u'8ph7mn'}, {'status': 'Deploying', 'hostname': u'kvm01', 'system_id': u'rwn4cp'}, {'status': 'Deploying', 'hostname': u'kvm03', 'system_id': u'tmbdry'}, {'status': 'Deploying', 'hostname': u'kvm02', 'system_id': u'dwxchw'}], 'summary': Counter({'Deploying': 5})}}
2018-09-13 12:30:21,754 [salt.state       :1941][INFO    ][1577] Completed state [maas.machines_status] at time 12:30:21.754835 duration_in_ms=537.599
2018-09-13 12:30:21,759 [salt.minion      :1708][INFO    ][1577] Returning information for job: 20180913123018790199
2018-09-13 12:30:32,233 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command state.apply with jid 20180913123032245070
2018-09-13 12:30:32,250 [salt.minion      :1431][INFO    ][1667] Starting a new job with PID 1667
2018-09-13 12:30:35,972 [salt.state       :905 ][INFO    ][1667] Loading fresh modules for state activity
2018-09-13 12:30:36,033 [salt.state       :1770][INFO    ][1667] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:30:36.033571
2018-09-13 12:30:36,034 [salt.state       :1803][INFO    ][1667] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2018-09-13 12:30:36,035 [salt.loaded.int.module.cmdmod:395 ][INFO    ][1667] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2018-09-13 12:30:37,302 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913123037316983
2018-09-13 12:30:37,325 [salt.minion      :1431][INFO    ][1687] Starting a new job with PID 1687
2018-09-13 12:30:37,347 [salt.minion      :1708][INFO    ][1687] Returning information for job: 20180913123037316983
2018-09-13 12:30:37,605 [salt.state       :290 ][INFO    ][1667] {'pid': 1674, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-09-13 12:30:37,606 [salt.state       :1941][INFO    ][1667] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:30:37.606453 duration_in_ms=1572.881
2018-09-13 12:30:37,609 [salt.state       :1770][INFO    ][1667] Running state [maas.machines_status] at time 12:30:37.609511
2018-09-13 12:30:37,610 [salt.state       :1803][INFO    ][1667] Executing state module.run for [maas.machines_status]
2018-09-13 12:30:37,610 [salt.utils.decorators:613 ][WARNING ][1667] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-09-13 12:30:38,010 [salt.state       :290 ][INFO    ][1667] {'ret': {'machines': [{'status': 'Deploying', 'hostname': u'cmp002', 'system_id': u'4pqqtm'}, {'status': 'Deploying', 'hostname': u'cmp001', 'system_id': u'8ph7mn'}, {'status': 'Deploying', 'hostname': u'kvm01', 'system_id': u'rwn4cp'}, {'status': 'Deploying', 'hostname': u'kvm03', 'system_id': u'tmbdry'}, {'status': 'Deploying', 'hostname': u'kvm02', 'system_id': u'dwxchw'}], 'summary': Counter({'Deploying': 5})}}
2018-09-13 12:30:38,011 [salt.state       :1941][INFO    ][1667] Completed state [maas.machines_status] at time 12:30:38.011153 duration_in_ms=401.643
2018-09-13 12:30:38,013 [salt.minion      :1708][INFO    ][1667] Returning information for job: 20180913123032245070
2018-09-13 12:30:48,546 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command state.apply with jid 20180913123048555554
2018-09-13 12:30:48,571 [salt.minion      :1431][INFO    ][1757] Starting a new job with PID 1757
2018-09-13 12:30:49,282 [salt.state       :905 ][INFO    ][1757] Loading fresh modules for state activity
2018-09-13 12:30:49,401 [salt.state       :1770][INFO    ][1757] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:30:49.401685
2018-09-13 12:30:49,402 [salt.state       :1803][INFO    ][1757] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2018-09-13 12:30:49,406 [salt.loaded.int.module.cmdmod:395 ][INFO    ][1757] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2018-09-13 12:30:51,171 [salt.state       :290 ][INFO    ][1757] {'pid': 1765, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-09-13 12:30:51,172 [salt.state       :1941][INFO    ][1757] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:30:51.172302 duration_in_ms=1770.616
2018-09-13 12:30:51,176 [salt.state       :1770][INFO    ][1757] Running state [maas.machines_status] at time 12:30:51.175987
2018-09-13 12:30:51,176 [salt.state       :1803][INFO    ][1757] Executing state module.run for [maas.machines_status]
2018-09-13 12:30:51,177 [salt.utils.decorators:613 ][WARNING ][1757] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-09-13 12:30:52,054 [salt.state       :290 ][INFO    ][1757] {'ret': {'machines': [{'status': 'Deploying', 'hostname': u'cmp002', 'system_id': u'4pqqtm'}, {'status': 'Deploying', 'hostname': u'cmp001', 'system_id': u'8ph7mn'}, {'status': 'Deploying', 'hostname': u'kvm01', 'system_id': u'rwn4cp'}, {'status': 'Deploying', 'hostname': u'kvm03', 'system_id': u'tmbdry'}, {'status': 'Deploying', 'hostname': u'kvm02', 'system_id': u'dwxchw'}], 'summary': Counter({'Deploying': 5})}}
2018-09-13 12:30:52,055 [salt.state       :1941][INFO    ][1757] Completed state [maas.machines_status] at time 12:30:52.054860 duration_in_ms=878.872
2018-09-13 12:30:52,061 [salt.minion      :1708][INFO    ][1757] Returning information for job: 20180913123048555554
2018-09-13 12:31:02,707 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command state.apply with jid 20180913123102714716
2018-09-13 12:31:02,731 [salt.minion      :1431][INFO    ][1860] Starting a new job with PID 1860
2018-09-13 12:31:06,518 [salt.state       :905 ][INFO    ][1860] Loading fresh modules for state activity
2018-09-13 12:31:06,613 [salt.state       :1770][INFO    ][1860] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:31:06.613565
2018-09-13 12:31:06,614 [salt.state       :1803][INFO    ][1860] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2018-09-13 12:31:06,616 [salt.loaded.int.module.cmdmod:395 ][INFO    ][1860] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2018-09-13 12:31:07,737 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913123107746305
2018-09-13 12:31:07,765 [salt.minion      :1431][INFO    ][1881] Starting a new job with PID 1881
2018-09-13 12:31:07,794 [salt.minion      :1708][INFO    ][1881] Returning information for job: 20180913123107746305
2018-09-13 12:31:08,354 [salt.state       :290 ][INFO    ][1860] {'pid': 1873, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-09-13 12:31:08,355 [salt.state       :1941][INFO    ][1860] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:31:08.355312 duration_in_ms=1741.747
2018-09-13 12:31:08,359 [salt.state       :1770][INFO    ][1860] Running state [maas.machines_status] at time 12:31:08.359123
2018-09-13 12:31:08,359 [salt.state       :1803][INFO    ][1860] Executing state module.run for [maas.machines_status]
2018-09-13 12:31:08,360 [salt.utils.decorators:613 ][WARNING ][1860] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-09-13 12:31:09,201 [salt.state       :290 ][INFO    ][1860] {'ret': {'machines': [{'status': 'Deploying', 'hostname': u'cmp002', 'system_id': u'4pqqtm'}, {'status': 'Deploying', 'hostname': u'cmp001', 'system_id': u'8ph7mn'}, {'status': 'Deploying', 'hostname': u'kvm01', 'system_id': u'rwn4cp'}, {'status': 'Deploying', 'hostname': u'kvm03', 'system_id': u'tmbdry'}, {'status': 'Deploying', 'hostname': u'kvm02', 'system_id': u'dwxchw'}], 'summary': Counter({'Deploying': 5})}}
2018-09-13 12:31:09,202 [salt.state       :1941][INFO    ][1860] Completed state [maas.machines_status] at time 12:31:09.202342 duration_in_ms=843.217
2018-09-13 12:31:09,207 [salt.minion      :1708][INFO    ][1860] Returning information for job: 20180913123102714716
2018-09-13 12:31:19,803 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command state.apply with jid 20180913123119811277
2018-09-13 12:31:19,833 [salt.minion      :1431][INFO    ][1928] Starting a new job with PID 1928
2018-09-13 12:31:20,455 [salt.state       :905 ][INFO    ][1928] Loading fresh modules for state activity
2018-09-13 12:31:20,545 [salt.state       :1770][INFO    ][1928] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:31:20.545288
2018-09-13 12:31:20,545 [salt.state       :1803][INFO    ][1928] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2018-09-13 12:31:20,548 [salt.loaded.int.module.cmdmod:395 ][INFO    ][1928] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2018-09-13 12:31:22,068 [salt.state       :290 ][INFO    ][1928] {'pid': 1943, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-09-13 12:31:22,069 [salt.state       :1941][INFO    ][1928] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:31:22.069322 duration_in_ms=1524.033
2018-09-13 12:31:22,071 [salt.state       :1770][INFO    ][1928] Running state [maas.machines_status] at time 12:31:22.071286
2018-09-13 12:31:22,071 [salt.state       :1803][INFO    ][1928] Executing state module.run for [maas.machines_status]
2018-09-13 12:31:22,072 [salt.utils.decorators:613 ][WARNING ][1928] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-09-13 12:31:22,632 [salt.state       :290 ][INFO    ][1928] {'ret': {'machines': [{'status': 'Deploying', 'hostname': u'cmp002', 'system_id': u'4pqqtm'}, {'status': 'Deploying', 'hostname': u'cmp001', 'system_id': u'8ph7mn'}, {'status': 'Deploying', 'hostname': u'kvm01', 'system_id': u'rwn4cp'}, {'status': 'Deploying', 'hostname': u'kvm03', 'system_id': u'tmbdry'}, {'status': 'Deploying', 'hostname': u'kvm02', 'system_id': u'dwxchw'}], 'summary': Counter({'Deploying': 5})}}
2018-09-13 12:31:22,632 [salt.state       :1941][INFO    ][1928] Completed state [maas.machines_status] at time 12:31:22.632691 duration_in_ms=561.404
2018-09-13 12:31:22,635 [salt.minion      :1708][INFO    ][1928] Returning information for job: 20180913123119811277
2018-09-13 12:31:33,239 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command state.apply with jid 20180913123133248525
2018-09-13 12:31:33,265 [salt.minion      :1431][INFO    ][2620] Starting a new job with PID 2620
2018-09-13 12:31:37,096 [salt.state       :905 ][INFO    ][2620] Loading fresh modules for state activity
2018-09-13 12:31:37,212 [salt.state       :1770][INFO    ][2620] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:31:37.212597
2018-09-13 12:31:37,213 [salt.state       :1803][INFO    ][2620] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2018-09-13 12:31:37,216 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2620] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2018-09-13 12:31:38,316 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913123138326583
2018-09-13 12:31:38,362 [salt.minion      :1431][INFO    ][2635] Starting a new job with PID 2635
2018-09-13 12:31:38,398 [salt.minion      :1708][INFO    ][2635] Returning information for job: 20180913123138326583
2018-09-13 12:31:38,862 [salt.state       :290 ][INFO    ][2620] {'pid': 2627, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-09-13 12:31:38,864 [salt.state       :1941][INFO    ][2620] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:31:38.863937 duration_in_ms=1651.338
2018-09-13 12:31:38,866 [salt.state       :1770][INFO    ][2620] Running state [maas.machines_status] at time 12:31:38.866821
2018-09-13 12:31:38,867 [salt.state       :1803][INFO    ][2620] Executing state module.run for [maas.machines_status]
2018-09-13 12:31:38,868 [salt.utils.decorators:613 ][WARNING ][2620] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-09-13 12:31:39,673 [salt.state       :290 ][INFO    ][2620] {'ret': {'machines': [{'status': 'Deploying', 'hostname': u'cmp002', 'system_id': u'4pqqtm'}, {'status': 'Deploying', 'hostname': u'cmp001', 'system_id': u'8ph7mn'}, {'status': 'Deploying', 'hostname': u'kvm01', 'system_id': u'rwn4cp'}, {'status': 'Deploying', 'hostname': u'kvm03', 'system_id': u'tmbdry'}, {'status': 'Deploying', 'hostname': u'kvm02', 'system_id': u'dwxchw'}], 'summary': Counter({'Deploying': 5})}}
2018-09-13 12:31:39,674 [salt.state       :1941][INFO    ][2620] Completed state [maas.machines_status] at time 12:31:39.674154 duration_in_ms=807.333
2018-09-13 12:31:39,677 [salt.minion      :1708][INFO    ][2620] Returning information for job: 20180913123133248525
2018-09-13 12:31:50,260 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command state.apply with jid 20180913123150270738
2018-09-13 12:31:50,290 [salt.minion      :1431][INFO    ][2649] Starting a new job with PID 2649
2018-09-13 12:31:50,961 [salt.state       :905 ][INFO    ][2649] Loading fresh modules for state activity
2018-09-13 12:31:51,086 [salt.state       :1770][INFO    ][2649] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:31:51.085994
2018-09-13 12:31:51,087 [salt.state       :1803][INFO    ][2649] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2018-09-13 12:31:51,092 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2649] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2018-09-13 12:31:52,881 [salt.state       :290 ][INFO    ][2649] {'pid': 2659, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-09-13 12:31:52,882 [salt.state       :1941][INFO    ][2649] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:31:52.882194 duration_in_ms=1796.2
2018-09-13 12:31:52,884 [salt.state       :1770][INFO    ][2649] Running state [maas.machines_status] at time 12:31:52.883974
2018-09-13 12:31:52,884 [salt.state       :1803][INFO    ][2649] Executing state module.run for [maas.machines_status]
2018-09-13 12:31:52,884 [salt.utils.decorators:613 ][WARNING ][2649] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-09-13 12:31:53,781 [salt.state       :290 ][INFO    ][2649] {'ret': {'machines': [{'status': 'Deploying', 'hostname': u'cmp002', 'system_id': u'4pqqtm'}, {'status': 'Deploying', 'hostname': u'cmp001', 'system_id': u'8ph7mn'}, {'status': 'Deploying', 'hostname': u'kvm01', 'system_id': u'rwn4cp'}, {'status': 'Deploying', 'hostname': u'kvm03', 'system_id': u'tmbdry'}, {'status': 'Deploying', 'hostname': u'kvm02', 'system_id': u'dwxchw'}], 'summary': Counter({'Deploying': 5})}}
2018-09-13 12:31:53,781 [salt.state       :1941][INFO    ][2649] Completed state [maas.machines_status] at time 12:31:53.781788 duration_in_ms=897.812
2018-09-13 12:31:53,786 [salt.minion      :1708][INFO    ][2649] Returning information for job: 20180913123150270738
2018-09-13 12:32:04,366 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command state.apply with jid 20180913123204378451
2018-09-13 12:32:04,382 [salt.minion      :1431][INFO    ][2673] Starting a new job with PID 2673
2018-09-13 12:32:08,082 [salt.state       :905 ][INFO    ][2673] Loading fresh modules for state activity
2018-09-13 12:32:08,175 [salt.state       :1770][INFO    ][2673] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:32:08.175462
2018-09-13 12:32:08,175 [salt.state       :1803][INFO    ][2673] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2018-09-13 12:32:08,178 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2673] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2018-09-13 12:32:09,411 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913123209425717
2018-09-13 12:32:09,448 [salt.minion      :1431][INFO    ][2690] Starting a new job with PID 2690
2018-09-13 12:32:09,485 [salt.minion      :1708][INFO    ][2690] Returning information for job: 20180913123209425717
2018-09-13 12:32:09,630 [salt.state       :290 ][INFO    ][2673] {'pid': 2680, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-09-13 12:32:09,632 [salt.state       :1941][INFO    ][2673] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:32:09.631896 duration_in_ms=1456.427
2018-09-13 12:32:09,635 [salt.state       :1770][INFO    ][2673] Running state [maas.machines_status] at time 12:32:09.635109
2018-09-13 12:32:09,635 [salt.state       :1803][INFO    ][2673] Executing state module.run for [maas.machines_status]
2018-09-13 12:32:09,636 [salt.utils.decorators:613 ][WARNING ][2673] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-09-13 12:32:10,462 [salt.state       :290 ][INFO    ][2673] {'ret': {'machines': [{'status': 'Deploying', 'hostname': u'cmp002', 'system_id': u'4pqqtm'}, {'status': 'Deploying', 'hostname': u'cmp001', 'system_id': u'8ph7mn'}, {'status': 'Deploying', 'hostname': u'kvm01', 'system_id': u'rwn4cp'}, {'status': 'Deploying', 'hostname': u'kvm03', 'system_id': u'tmbdry'}, {'status': 'Deploying', 'hostname': u'kvm02', 'system_id': u'dwxchw'}], 'summary': Counter({'Deploying': 5})}}
2018-09-13 12:32:10,463 [salt.state       :1941][INFO    ][2673] Completed state [maas.machines_status] at time 12:32:10.463416 duration_in_ms=828.306
2018-09-13 12:32:10,468 [salt.minion      :1708][INFO    ][2673] Returning information for job: 20180913123204378451
2018-09-13 12:32:21,076 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command state.apply with jid 20180913123221090080
2018-09-13 12:32:21,109 [salt.minion      :1431][INFO    ][2724] Starting a new job with PID 2724
2018-09-13 12:32:21,738 [salt.state       :905 ][INFO    ][2724] Loading fresh modules for state activity
2018-09-13 12:32:21,819 [salt.state       :1770][INFO    ][2724] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:32:21.819457
2018-09-13 12:32:21,819 [salt.state       :1803][INFO    ][2724] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2018-09-13 12:32:21,821 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2724] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2018-09-13 12:32:23,339 [salt.state       :290 ][INFO    ][2724] {'pid': 2781, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-09-13 12:32:23,341 [salt.state       :1941][INFO    ][2724] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:32:23.340914 duration_in_ms=1521.454
2018-09-13 12:32:23,345 [salt.state       :1770][INFO    ][2724] Running state [maas.machines_status] at time 12:32:23.345545
2018-09-13 12:32:23,346 [salt.state       :1803][INFO    ][2724] Executing state module.run for [maas.machines_status]
2018-09-13 12:32:23,347 [salt.utils.decorators:613 ][WARNING ][2724] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-09-13 12:32:24,000 [salt.state       :290 ][INFO    ][2724] {'ret': {'machines': [{'status': 'Deploying', 'hostname': u'cmp002', 'system_id': u'4pqqtm'}, {'status': 'Deploying', 'hostname': u'cmp001', 'system_id': u'8ph7mn'}, {'status': 'Deploying', 'hostname': u'kvm01', 'system_id': u'rwn4cp'}, {'status': 'Deploying', 'hostname': u'kvm03', 'system_id': u'tmbdry'}, {'status': 'Deploying', 'hostname': u'kvm02', 'system_id': u'dwxchw'}], 'summary': Counter({'Deploying': 5})}}
2018-09-13 12:32:24,000 [salt.state       :1941][INFO    ][2724] Completed state [maas.machines_status] at time 12:32:24.000453 duration_in_ms=654.908
2018-09-13 12:32:24,004 [salt.minion      :1708][INFO    ][2724] Returning information for job: 20180913123221090080
2018-09-13 12:32:34,516 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command state.apply with jid 20180913123234524456
2018-09-13 12:32:34,543 [salt.minion      :1431][INFO    ][2918] Starting a new job with PID 2918
2018-09-13 12:32:38,339 [salt.state       :905 ][INFO    ][2918] Loading fresh modules for state activity
2018-09-13 12:32:38,533 [salt.state       :1770][INFO    ][2918] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:32:38.533713
2018-09-13 12:32:38,534 [salt.state       :1803][INFO    ][2918] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2018-09-13 12:32:38,536 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2918] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2018-09-13 12:32:39,558 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913123239568902
2018-09-13 12:32:39,584 [salt.minion      :1431][INFO    ][2934] Starting a new job with PID 2934
2018-09-13 12:32:39,620 [salt.minion      :1708][INFO    ][2934] Returning information for job: 20180913123239568902
2018-09-13 12:32:39,964 [salt.state       :290 ][INFO    ][2918] {'pid': 2926, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-09-13 12:32:39,965 [salt.state       :1941][INFO    ][2918] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:32:39.965026 duration_in_ms=1431.311
2018-09-13 12:32:39,968 [salt.state       :1770][INFO    ][2918] Running state [maas.machines_status] at time 12:32:39.968270
2018-09-13 12:32:39,969 [salt.state       :1803][INFO    ][2918] Executing state module.run for [maas.machines_status]
2018-09-13 12:32:39,969 [salt.utils.decorators:613 ][WARNING ][2918] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-09-13 12:32:40,798 [salt.state       :290 ][INFO    ][2918] {'ret': {'machines': [{'status': 'Deploying', 'hostname': u'cmp002', 'system_id': u'4pqqtm'}, {'status': 'Deploying', 'hostname': u'cmp001', 'system_id': u'8ph7mn'}, {'status': 'Deploying', 'hostname': u'kvm01', 'system_id': u'rwn4cp'}, {'status': 'Deploying', 'hostname': u'kvm03', 'system_id': u'tmbdry'}, {'status': 'Deploying', 'hostname': u'kvm02', 'system_id': u'dwxchw'}], 'summary': Counter({'Deploying': 5})}}
2018-09-13 12:32:40,799 [salt.state       :1941][INFO    ][2918] Completed state [maas.machines_status] at time 12:32:40.799204 duration_in_ms=830.933
2018-09-13 12:32:40,803 [salt.minion      :1708][INFO    ][2918] Returning information for job: 20180913123234524456
2018-09-13 12:32:51,412 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command state.apply with jid 20180913123251421323
2018-09-13 12:32:51,438 [salt.minion      :1431][INFO    ][2961] Starting a new job with PID 2961
2018-09-13 12:32:52,077 [salt.state       :905 ][INFO    ][2961] Loading fresh modules for state activity
2018-09-13 12:32:52,134 [salt.state       :1770][INFO    ][2961] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:32:52.134697
2018-09-13 12:32:52,135 [salt.state       :1803][INFO    ][2961] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2018-09-13 12:32:52,136 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2961] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2018-09-13 12:32:53,737 [salt.state       :290 ][INFO    ][2961] {'pid': 2968, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-09-13 12:32:53,738 [salt.state       :1941][INFO    ][2961] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:32:53.738713 duration_in_ms=1604.014
2018-09-13 12:32:53,742 [salt.state       :1770][INFO    ][2961] Running state [maas.machines_status] at time 12:32:53.742069
2018-09-13 12:32:53,742 [salt.state       :1803][INFO    ][2961] Executing state module.run for [maas.machines_status]
2018-09-13 12:32:53,743 [salt.utils.decorators:613 ][WARNING ][2961] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-09-13 12:32:54,398 [salt.state       :290 ][INFO    ][2961] {'ret': {'machines': [{'status': 'Deploying', 'hostname': u'cmp002', 'system_id': u'4pqqtm'}, {'status': 'Deploying', 'hostname': u'cmp001', 'system_id': u'8ph7mn'}, {'status': 'Deploying', 'hostname': u'kvm01', 'system_id': u'rwn4cp'}, {'status': 'Deploying', 'hostname': u'kvm03', 'system_id': u'tmbdry'}, {'status': 'Deploying', 'hostname': u'kvm02', 'system_id': u'dwxchw'}], 'summary': Counter({'Deploying': 5})}}
2018-09-13 12:32:54,399 [salt.state       :1941][INFO    ][2961] Completed state [maas.machines_status] at time 12:32:54.399793 duration_in_ms=657.722
2018-09-13 12:32:54,406 [salt.minion      :1708][INFO    ][2961] Returning information for job: 20180913123251421323
2018-09-13 12:33:04,933 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command state.apply with jid 20180913123304946436
2018-09-13 12:33:04,966 [salt.minion      :1431][INFO    ][2986] Starting a new job with PID 2986
2018-09-13 12:33:08,879 [salt.state       :905 ][INFO    ][2986] Loading fresh modules for state activity
2018-09-13 12:33:08,987 [salt.state       :1770][INFO    ][2986] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:33:08.987815
2018-09-13 12:33:08,988 [salt.state       :1803][INFO    ][2986] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2018-09-13 12:33:08,991 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2986] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2018-09-13 12:33:09,988 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913123310000720
2018-09-13 12:33:10,013 [salt.minion      :1431][INFO    ][3003] Starting a new job with PID 3003
2018-09-13 12:33:10,051 [salt.minion      :1708][INFO    ][3003] Returning information for job: 20180913123310000720
2018-09-13 12:33:10,512 [salt.state       :290 ][INFO    ][2986] {'pid': 2995, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-09-13 12:33:10,513 [salt.state       :1941][INFO    ][2986] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:33:10.513233 duration_in_ms=1525.418
2018-09-13 12:33:10,516 [salt.state       :1770][INFO    ][2986] Running state [maas.machines_status] at time 12:33:10.516228
2018-09-13 12:33:10,516 [salt.state       :1803][INFO    ][2986] Executing state module.run for [maas.machines_status]
2018-09-13 12:33:10,517 [salt.utils.decorators:613 ][WARNING ][2986] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-09-13 12:33:11,408 [salt.state       :290 ][INFO    ][2986] {'ret': {'machines': [{'status': 'Deploying', 'hostname': u'cmp002', 'system_id': u'4pqqtm'}, {'status': 'Deploying', 'hostname': u'cmp001', 'system_id': u'8ph7mn'}, {'status': 'Deploying', 'hostname': u'kvm01', 'system_id': u'rwn4cp'}, {'status': 'Deploying', 'hostname': u'kvm03', 'system_id': u'tmbdry'}, {'status': 'Deploying', 'hostname': u'kvm02', 'system_id': u'dwxchw'}], 'summary': Counter({'Deploying': 5})}}
2018-09-13 12:33:11,409 [salt.state       :1941][INFO    ][2986] Completed state [maas.machines_status] at time 12:33:11.409143 duration_in_ms=892.914
2018-09-13 12:33:11,413 [salt.minion      :1708][INFO    ][2986] Returning information for job: 20180913123304946436
2018-09-13 12:33:21,896 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command state.apply with jid 20180913123321910068
2018-09-13 12:33:21,911 [salt.minion      :1431][INFO    ][3124] Starting a new job with PID 3124
2018-09-13 12:33:22,436 [salt.state       :905 ][INFO    ][3124] Loading fresh modules for state activity
2018-09-13 12:33:22,528 [salt.state       :1770][INFO    ][3124] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:33:22.527950
2018-09-13 12:33:22,528 [salt.state       :1803][INFO    ][3124] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2018-09-13 12:33:22,531 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3124] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2018-09-13 12:33:24,132 [salt.state       :290 ][INFO    ][3124] {'pid': 3182, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-09-13 12:33:24,134 [salt.state       :1941][INFO    ][3124] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:33:24.134155 duration_in_ms=1606.204
2018-09-13 12:33:24,138 [salt.state       :1770][INFO    ][3124] Running state [maas.machines_status] at time 12:33:24.138671
2018-09-13 12:33:24,139 [salt.state       :1803][INFO    ][3124] Executing state module.run for [maas.machines_status]
2018-09-13 12:33:24,140 [salt.utils.decorators:613 ][WARNING ][3124] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-09-13 12:33:24,904 [salt.state       :290 ][INFO    ][3124] {'ret': {'machines': [{'status': 'Deploying', 'hostname': u'cmp002', 'system_id': u'4pqqtm'}, {'status': 'Deploying', 'hostname': u'cmp001', 'system_id': u'8ph7mn'}, {'status': 'Deploying', 'hostname': u'kvm01', 'system_id': u'rwn4cp'}, {'status': 'Deploying', 'hostname': u'kvm03', 'system_id': u'tmbdry'}, {'status': 'Deploying', 'hostname': u'kvm02', 'system_id': u'dwxchw'}], 'summary': Counter({'Deploying': 5})}}
2018-09-13 12:33:24,905 [salt.state       :1941][INFO    ][3124] Completed state [maas.machines_status] at time 12:33:24.905015 duration_in_ms=766.344
2018-09-13 12:33:24,909 [salt.minion      :1708][INFO    ][3124] Returning information for job: 20180913123321910068
2018-09-13 12:33:35,436 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command state.apply with jid 20180913123335447733
2018-09-13 12:33:35,466 [salt.minion      :1431][INFO    ][3296] Starting a new job with PID 3296
2018-09-13 12:33:39,519 [salt.state       :905 ][INFO    ][3296] Loading fresh modules for state activity
2018-09-13 12:33:39,634 [salt.state       :1770][INFO    ][3296] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:33:39.633905
2018-09-13 12:33:39,634 [salt.state       :1803][INFO    ][3296] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2018-09-13 12:33:39,639 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3296] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2018-09-13 12:33:40,519 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913123340533047
2018-09-13 12:33:40,563 [salt.minion      :1431][INFO    ][3310] Starting a new job with PID 3310
2018-09-13 12:33:40,605 [salt.minion      :1708][INFO    ][3310] Returning information for job: 20180913123340533047
2018-09-13 12:33:41,273 [salt.state       :290 ][INFO    ][3296] {'pid': 3303, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-09-13 12:33:41,274 [salt.state       :1941][INFO    ][3296] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:33:41.274407 duration_in_ms=1640.502
2018-09-13 12:33:41,277 [salt.state       :1770][INFO    ][3296] Running state [maas.machines_status] at time 12:33:41.277145
2018-09-13 12:33:41,277 [salt.state       :1803][INFO    ][3296] Executing state module.run for [maas.machines_status]
2018-09-13 12:33:41,278 [salt.utils.decorators:613 ][WARNING ][3296] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-09-13 12:33:42,036 [salt.state       :290 ][INFO    ][3296] {'ret': {'machines': [{'status': 'Deploying', 'hostname': u'cmp002', 'system_id': u'4pqqtm'}, {'status': 'Deploying', 'hostname': u'cmp001', 'system_id': u'8ph7mn'}, {'status': 'Deploying', 'hostname': u'kvm01', 'system_id': u'rwn4cp'}, {'status': 'Deploying', 'hostname': u'kvm03', 'system_id': u'tmbdry'}, {'status': 'Deploying', 'hostname': u'kvm02', 'system_id': u'dwxchw'}], 'summary': Counter({'Deploying': 5})}}
2018-09-13 12:33:42,037 [salt.state       :1941][INFO    ][3296] Completed state [maas.machines_status] at time 12:33:42.037043 duration_in_ms=759.896
2018-09-13 12:33:42,041 [salt.minion      :1708][INFO    ][3296] Returning information for job: 20180913123335447733
2018-09-13 12:33:52,579 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command state.apply with jid 20180913123352593281
2018-09-13 12:33:52,600 [salt.minion      :1431][INFO    ][3364] Starting a new job with PID 3364
2018-09-13 12:33:53,295 [salt.state       :905 ][INFO    ][3364] Loading fresh modules for state activity
2018-09-13 12:33:53,397 [salt.state       :1770][INFO    ][3364] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:33:53.397499
2018-09-13 12:33:53,398 [salt.state       :1803][INFO    ][3364] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2018-09-13 12:33:53,401 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3364] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2018-09-13 12:33:54,964 [salt.state       :290 ][INFO    ][3364] {'pid': 3372, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-09-13 12:33:54,966 [salt.state       :1941][INFO    ][3364] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:33:54.966013 duration_in_ms=1568.512
2018-09-13 12:33:54,969 [salt.state       :1770][INFO    ][3364] Running state [maas.machines_status] at time 12:33:54.969234
2018-09-13 12:33:54,970 [salt.state       :1803][INFO    ][3364] Executing state module.run for [maas.machines_status]
2018-09-13 12:33:54,971 [salt.utils.decorators:613 ][WARNING ][3364] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-09-13 12:33:55,917 [salt.state       :290 ][INFO    ][3364] {'ret': {'machines': [{'status': 'Deploying', 'hostname': u'cmp002', 'system_id': u'4pqqtm'}, {'status': 'Deploying', 'hostname': u'cmp001', 'system_id': u'8ph7mn'}, {'status': 'Deploying', 'hostname': u'kvm01', 'system_id': u'rwn4cp'}, {'status': 'Deploying', 'hostname': u'kvm03', 'system_id': u'tmbdry'}, {'status': 'Deploying', 'hostname': u'kvm02', 'system_id': u'dwxchw'}], 'summary': Counter({'Deploying': 5})}}
2018-09-13 12:33:55,918 [salt.state       :1941][INFO    ][3364] Completed state [maas.machines_status] at time 12:33:55.917985 duration_in_ms=948.75
2018-09-13 12:33:55,922 [salt.minion      :1708][INFO    ][3364] Returning information for job: 20180913123352593281
2018-09-13 12:34:06,453 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command state.apply with jid 20180913123406468267
2018-09-13 12:34:06,471 [salt.minion      :1431][INFO    ][3393] Starting a new job with PID 3393
2018-09-13 12:34:10,239 [salt.state       :905 ][INFO    ][3393] Loading fresh modules for state activity
2018-09-13 12:34:10,327 [salt.state       :1770][INFO    ][3393] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:34:10.327397
2018-09-13 12:34:10,328 [salt.state       :1803][INFO    ][3393] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2018-09-13 12:34:10,330 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3393] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2018-09-13 12:34:11,572 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913123411586300
2018-09-13 12:34:11,599 [salt.minion      :1431][INFO    ][3410] Starting a new job with PID 3410
2018-09-13 12:34:11,639 [salt.minion      :1708][INFO    ][3410] Returning information for job: 20180913123411586300
2018-09-13 12:34:12,001 [salt.state       :290 ][INFO    ][3393] {'pid': 3402, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-09-13 12:34:12,002 [salt.state       :1941][INFO    ][3393] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:34:12.002641 duration_in_ms=1675.242
2018-09-13 12:34:12,006 [salt.state       :1770][INFO    ][3393] Running state [maas.machines_status] at time 12:34:12.006050
2018-09-13 12:34:12,007 [salt.state       :1803][INFO    ][3393] Executing state module.run for [maas.machines_status]
2018-09-13 12:34:12,008 [salt.utils.decorators:613 ][WARNING ][3393] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-09-13 12:34:12,715 [salt.state       :290 ][INFO    ][3393] {'ret': {'machines': [{'status': 'Deploying', 'hostname': u'cmp002', 'system_id': u'4pqqtm'}, {'status': 'Deploying', 'hostname': u'cmp001', 'system_id': u'8ph7mn'}, {'status': 'Deploying', 'hostname': u'kvm01', 'system_id': u'rwn4cp'}, {'status': 'Deploying', 'hostname': u'kvm03', 'system_id': u'tmbdry'}, {'status': 'Deploying', 'hostname': u'kvm02', 'system_id': u'dwxchw'}], 'summary': Counter({'Deploying': 5})}}
2018-09-13 12:34:12,716 [salt.state       :1941][INFO    ][3393] Completed state [maas.machines_status] at time 12:34:12.716165 duration_in_ms=710.114
2018-09-13 12:34:12,719 [salt.minion      :1708][INFO    ][3393] Returning information for job: 20180913123406468267
2018-09-13 12:34:23,331 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command state.apply with jid 20180913123423340750
2018-09-13 12:34:23,352 [salt.minion      :1431][INFO    ][3658] Starting a new job with PID 3658
2018-09-13 12:34:23,886 [salt.state       :905 ][INFO    ][3658] Loading fresh modules for state activity
2018-09-13 12:34:23,956 [salt.state       :1770][INFO    ][3658] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:34:23.956725
2018-09-13 12:34:23,957 [salt.state       :1803][INFO    ][3658] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2018-09-13 12:34:23,959 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3658] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2018-09-13 12:34:25,504 [salt.state       :290 ][INFO    ][3658] {'pid': 3684, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-09-13 12:34:25,515 [salt.state       :1941][INFO    ][3658] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:34:25.515681 duration_in_ms=1558.955
2018-09-13 12:34:25,520 [salt.state       :1770][INFO    ][3658] Running state [maas.machines_status] at time 12:34:25.520298
2018-09-13 12:34:25,521 [salt.state       :1803][INFO    ][3658] Executing state module.run for [maas.machines_status]
2018-09-13 12:34:25,522 [salt.utils.decorators:613 ][WARNING ][3658] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-09-13 12:34:26,430 [salt.state       :290 ][INFO    ][3658] {'ret': {'machines': [{'status': 'Deploying', 'hostname': u'cmp002', 'system_id': u'4pqqtm'}, {'status': 'Deploying', 'hostname': u'cmp001', 'system_id': u'8ph7mn'}, {'status': 'Deploying', 'hostname': u'kvm01', 'system_id': u'rwn4cp'}, {'status': 'Deploying', 'hostname': u'kvm03', 'system_id': u'tmbdry'}, {'status': 'Deploying', 'hostname': u'kvm02', 'system_id': u'dwxchw'}], 'summary': Counter({'Deploying': 5})}}
2018-09-13 12:34:26,431 [salt.state       :1941][INFO    ][3658] Completed state [maas.machines_status] at time 12:34:26.431745 duration_in_ms=911.446
2018-09-13 12:34:26,438 [salt.minion      :1708][INFO    ][3658] Returning information for job: 20180913123423340750
2018-09-13 12:34:37,037 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command state.apply with jid 20180913123437052929
2018-09-13 12:34:37,066 [salt.minion      :1431][INFO    ][3802] Starting a new job with PID 3802
2018-09-13 12:34:40,829 [salt.state       :905 ][INFO    ][3802] Loading fresh modules for state activity
2018-09-13 12:34:40,931 [salt.state       :1770][INFO    ][3802] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:34:40.931203
2018-09-13 12:34:40,932 [salt.state       :1803][INFO    ][3802] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2018-09-13 12:34:40,934 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3802] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2018-09-13 12:34:42,164 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913123442174489
2018-09-13 12:34:42,197 [salt.minion      :1431][INFO    ][3818] Starting a new job with PID 3818
2018-09-13 12:34:42,224 [salt.minion      :1708][INFO    ][3818] Returning information for job: 20180913123442174489
2018-09-13 12:34:42,482 [salt.state       :290 ][INFO    ][3802] {'pid': 3809, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-09-13 12:34:42,484 [salt.state       :1941][INFO    ][3802] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:34:42.484467 duration_in_ms=1553.261
2018-09-13 12:34:42,488 [salt.state       :1770][INFO    ][3802] Running state [maas.machines_status] at time 12:34:42.488490
2018-09-13 12:34:42,489 [salt.state       :1803][INFO    ][3802] Executing state module.run for [maas.machines_status]
2018-09-13 12:34:42,490 [salt.utils.decorators:613 ][WARNING ][3802] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-09-13 12:34:43,370 [salt.state       :290 ][INFO    ][3802] {'ret': {'machines': [{'status': 'Deploying', 'hostname': u'cmp002', 'system_id': u'4pqqtm'}, {'status': 'Deploying', 'hostname': u'cmp001', 'system_id': u'8ph7mn'}, {'status': 'Deploying', 'hostname': u'kvm01', 'system_id': u'rwn4cp'}, {'status': 'Deploying', 'hostname': u'kvm03', 'system_id': u'tmbdry'}, {'status': 'Deploying', 'hostname': u'kvm02', 'system_id': u'dwxchw'}], 'summary': Counter({'Deploying': 5})}}
2018-09-13 12:34:43,371 [salt.state       :1941][INFO    ][3802] Completed state [maas.machines_status] at time 12:34:43.371376 duration_in_ms=882.885
2018-09-13 12:34:43,376 [salt.minion      :1708][INFO    ][3802] Returning information for job: 20180913123437052929
2018-09-13 12:34:53,917 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command state.apply with jid 20180913123453931405
2018-09-13 12:34:53,941 [salt.minion      :1431][INFO    ][3834] Starting a new job with PID 3834
2018-09-13 12:34:54,587 [salt.state       :905 ][INFO    ][3834] Loading fresh modules for state activity
2018-09-13 12:34:54,662 [salt.state       :1770][INFO    ][3834] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:34:54.662114
2018-09-13 12:34:54,663 [salt.state       :1803][INFO    ][3834] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2018-09-13 12:34:54,666 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3834] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2018-09-13 12:34:56,086 [salt.state       :290 ][INFO    ][3834] {'pid': 3841, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-09-13 12:34:56,088 [salt.state       :1941][INFO    ][3834] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:34:56.088664 duration_in_ms=1426.549
2018-09-13 12:34:56,092 [salt.state       :1770][INFO    ][3834] Running state [maas.machines_status] at time 12:34:56.092553
2018-09-13 12:34:56,093 [salt.state       :1803][INFO    ][3834] Executing state module.run for [maas.machines_status]
2018-09-13 12:34:56,095 [salt.utils.decorators:613 ][WARNING ][3834] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-09-13 12:34:57,146 [salt.state       :290 ][INFO    ][3834] {'ret': {'machines': [{'status': 'Deploying', 'hostname': u'cmp002', 'system_id': u'4pqqtm'}, {'status': 'Deploying', 'hostname': u'cmp001', 'system_id': u'8ph7mn'}, {'status': 'Deploying', 'hostname': u'kvm01', 'system_id': u'rwn4cp'}, {'status': 'Deploying', 'hostname': u'kvm03', 'system_id': u'tmbdry'}, {'status': 'Deploying', 'hostname': u'kvm02', 'system_id': u'dwxchw'}], 'summary': Counter({'Deploying': 5})}}
2018-09-13 12:34:57,148 [salt.state       :1941][INFO    ][3834] Completed state [maas.machines_status] at time 12:34:57.148248 duration_in_ms=1055.692
2018-09-13 12:34:57,154 [salt.minion      :1708][INFO    ][3834] Returning information for job: 20180913123453931405
2018-09-13 12:35:07,702 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command state.apply with jid 20180913123507718735
2018-09-13 12:35:07,729 [salt.minion      :1431][INFO    ][3858] Starting a new job with PID 3858
2018-09-13 12:35:11,415 [salt.state       :905 ][INFO    ][3858] Loading fresh modules for state activity
2018-09-13 12:35:11,464 [salt.state       :1770][INFO    ][3858] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:35:11.464612
2018-09-13 12:35:11,464 [salt.state       :1803][INFO    ][3858] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2018-09-13 12:35:11,466 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3858] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2018-09-13 12:35:12,753 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913123512770128
2018-09-13 12:35:12,778 [salt.minion      :1431][INFO    ][3875] Starting a new job with PID 3875
2018-09-13 12:35:12,802 [salt.minion      :1708][INFO    ][3875] Returning information for job: 20180913123512770128
2018-09-13 12:35:13,017 [salt.state       :290 ][INFO    ][3858] {'pid': 3866, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-09-13 12:35:13,018 [salt.state       :1941][INFO    ][3858] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:35:13.018041 duration_in_ms=1553.427
2018-09-13 12:35:13,020 [salt.state       :1770][INFO    ][3858] Running state [maas.machines_status] at time 12:35:13.020736
2018-09-13 12:35:13,021 [salt.state       :1803][INFO    ][3858] Executing state module.run for [maas.machines_status]
2018-09-13 12:35:13,021 [salt.utils.decorators:613 ][WARNING ][3858] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-09-13 12:35:13,643 [salt.state       :290 ][INFO    ][3858] {'ret': {'machines': [{'status': 'Deploying', 'hostname': u'cmp002', 'system_id': u'4pqqtm'}, {'status': 'Deploying', 'hostname': u'cmp001', 'system_id': u'8ph7mn'}, {'status': 'Deploying', 'hostname': u'kvm01', 'system_id': u'rwn4cp'}, {'status': 'Deploying', 'hostname': u'kvm03', 'system_id': u'tmbdry'}, {'status': 'Deploying', 'hostname': u'kvm02', 'system_id': u'dwxchw'}], 'summary': Counter({'Deploying': 5})}}
2018-09-13 12:35:13,644 [salt.state       :1941][INFO    ][3858] Completed state [maas.machines_status] at time 12:35:13.644646 duration_in_ms=623.909
2018-09-13 12:35:13,649 [salt.minion      :1708][INFO    ][3858] Returning information for job: 20180913123507718735
2018-09-13 12:35:24,264 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command state.apply with jid 20180913123524279170
2018-09-13 12:35:24,294 [salt.minion      :1431][INFO    ][3911] Starting a new job with PID 3911
2018-09-13 12:35:24,950 [salt.state       :905 ][INFO    ][3911] Loading fresh modules for state activity
2018-09-13 12:35:25,054 [salt.state       :1770][INFO    ][3911] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:35:25.054794
2018-09-13 12:35:25,055 [salt.state       :1803][INFO    ][3911] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2018-09-13 12:35:25,058 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3911] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2018-09-13 12:35:26,515 [salt.state       :290 ][INFO    ][3911] {'pid': 3918, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-09-13 12:35:26,516 [salt.state       :1941][INFO    ][3911] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:35:26.516369 duration_in_ms=1461.574
2018-09-13 12:35:26,518 [salt.state       :1770][INFO    ][3911] Running state [maas.machines_status] at time 12:35:26.518826
2018-09-13 12:35:26,520 [salt.state       :1803][INFO    ][3911] Executing state module.run for [maas.machines_status]
2018-09-13 12:35:26,521 [salt.utils.decorators:613 ][WARNING ][3911] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-09-13 12:35:27,392 [salt.state       :290 ][INFO    ][3911] {'ret': {'machines': [{'status': 'Deploying', 'hostname': u'cmp002', 'system_id': u'4pqqtm'}, {'status': 'Deploying', 'hostname': u'cmp001', 'system_id': u'8ph7mn'}, {'status': 'Deploying', 'hostname': u'kvm01', 'system_id': u'rwn4cp'}, {'status': 'Deploying', 'hostname': u'kvm03', 'system_id': u'tmbdry'}, {'status': 'Deploying', 'hostname': u'kvm02', 'system_id': u'dwxchw'}], 'summary': Counter({'Deploying': 5})}}
2018-09-13 12:35:27,393 [salt.state       :1941][INFO    ][3911] Completed state [maas.machines_status] at time 12:35:27.393161 duration_in_ms=874.334
2018-09-13 12:35:27,397 [salt.minion      :1708][INFO    ][3911] Returning information for job: 20180913123524279170
2018-09-13 12:35:38,006 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command state.apply with jid 20180913123538023345
2018-09-13 12:35:38,033 [salt.minion      :1431][INFO    ][4033] Starting a new job with PID 4033
2018-09-13 12:35:41,719 [salt.state       :905 ][INFO    ][4033] Loading fresh modules for state activity
2018-09-13 12:35:41,770 [salt.state       :1770][INFO    ][4033] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:35:41.770832
2018-09-13 12:35:41,771 [salt.state       :1803][INFO    ][4033] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2018-09-13 12:35:41,772 [salt.loaded.int.module.cmdmod:395 ][INFO    ][4033] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2018-09-13 12:35:43,048 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913123543066716
2018-09-13 12:35:43,077 [salt.minion      :1431][INFO    ][4049] Starting a new job with PID 4049
2018-09-13 12:35:43,105 [salt.minion      :1708][INFO    ][4049] Returning information for job: 20180913123543066716
2018-09-13 12:35:43,141 [salt.state       :290 ][INFO    ][4033] {'pid': 4040, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-09-13 12:35:43,142 [salt.state       :1941][INFO    ][4033] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:35:43.142240 duration_in_ms=1371.405
2018-09-13 12:35:43,145 [salt.state       :1770][INFO    ][4033] Running state [maas.machines_status] at time 12:35:43.145053
2018-09-13 12:35:43,145 [salt.state       :1803][INFO    ][4033] Executing state module.run for [maas.machines_status]
2018-09-13 12:35:43,146 [salt.utils.decorators:613 ][WARNING ][4033] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-09-13 12:35:44,201 [salt.state       :290 ][INFO    ][4033] {'ret': {'machines': [{'status': 'Deploying', 'hostname': u'cmp002', 'system_id': u'4pqqtm'}, {'status': 'Deploying', 'hostname': u'cmp001', 'system_id': u'8ph7mn'}, {'status': 'Deploying', 'hostname': u'kvm01', 'system_id': u'rwn4cp'}, {'status': 'Deploying', 'hostname': u'kvm03', 'system_id': u'tmbdry'}, {'status': 'Deploying', 'hostname': u'kvm02', 'system_id': u'dwxchw'}], 'summary': Counter({'Deploying': 5})}}
2018-09-13 12:35:44,202 [salt.state       :1941][INFO    ][4033] Completed state [maas.machines_status] at time 12:35:44.202341 duration_in_ms=1057.287
2018-09-13 12:35:44,211 [salt.minion      :1708][INFO    ][4033] Returning information for job: 20180913123538023345
2018-09-13 12:35:54,807 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command state.apply with jid 20180913123554826019
2018-09-13 12:35:54,833 [salt.minion      :1431][INFO    ][4152] Starting a new job with PID 4152
2018-09-13 12:35:55,474 [salt.state       :905 ][INFO    ][4152] Loading fresh modules for state activity
2018-09-13 12:35:55,572 [salt.state       :1770][INFO    ][4152] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:35:55.572655
2018-09-13 12:35:55,573 [salt.state       :1803][INFO    ][4152] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2018-09-13 12:35:55,575 [salt.loaded.int.module.cmdmod:395 ][INFO    ][4152] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2018-09-13 12:35:56,966 [salt.state       :290 ][INFO    ][4152] {'pid': 4159, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-09-13 12:35:56,967 [salt.state       :1941][INFO    ][4152] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:35:56.967354 duration_in_ms=1394.697
2018-09-13 12:35:56,969 [salt.state       :1770][INFO    ][4152] Running state [maas.machines_status] at time 12:35:56.969760
2018-09-13 12:35:56,970 [salt.state       :1803][INFO    ][4152] Executing state module.run for [maas.machines_status]
2018-09-13 12:35:56,970 [salt.utils.decorators:613 ][WARNING ][4152] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-09-13 12:35:57,554 [salt.state       :290 ][INFO    ][4152] {'ret': {'machines': [{'status': 'Deployed', 'hostname': u'cmp002', 'system_id': u'4pqqtm'}, {'status': 'Deployed', 'hostname': u'cmp001', 'system_id': u'8ph7mn'}, {'status': 'Deployed', 'hostname': u'kvm01', 'system_id': u'rwn4cp'}, {'status': 'Deployed', 'hostname': u'kvm03', 'system_id': u'tmbdry'}, {'status': 'Deploying', 'hostname': u'kvm02', 'system_id': u'dwxchw'}], 'summary': Counter({'Deployed': 4, 'Deploying': 1})}}
2018-09-13 12:35:57,555 [salt.state       :1941][INFO    ][4152] Completed state [maas.machines_status] at time 12:35:57.555091 duration_in_ms=585.329
2018-09-13 12:35:57,557 [salt.minion      :1708][INFO    ][4152] Returning information for job: 20180913123554826019
2018-09-13 12:36:08,151 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command state.apply with jid 20180913123608168866
2018-09-13 12:36:08,174 [salt.minion      :1431][INFO    ][4226] Starting a new job with PID 4226
2018-09-13 12:36:12,049 [salt.state       :905 ][INFO    ][4226] Loading fresh modules for state activity
2018-09-13 12:36:12,122 [salt.state       :1770][INFO    ][4226] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:36:12.122628
2018-09-13 12:36:12,123 [salt.state       :1803][INFO    ][4226] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2018-09-13 12:36:12,125 [salt.loaded.int.module.cmdmod:395 ][INFO    ][4226] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2018-09-13 12:36:13,273 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command saltutil.find_job with jid 20180913123613290638
2018-09-13 12:36:13,297 [salt.minion      :1431][INFO    ][4269] Starting a new job with PID 4269
2018-09-13 12:36:13,320 [salt.minion      :1708][INFO    ][4269] Returning information for job: 20180913123613290638
2018-09-13 12:36:13,564 [salt.state       :290 ][INFO    ][4226] {'pid': 4249, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-09-13 12:36:13,565 [salt.state       :1941][INFO    ][4226] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:36:13.565152 duration_in_ms=1442.525
2018-09-13 12:36:13,566 [salt.state       :1770][INFO    ][4226] Running state [maas.machines_status] at time 12:36:13.566765
2018-09-13 12:36:13,567 [salt.state       :1803][INFO    ][4226] Executing state module.run for [maas.machines_status]
2018-09-13 12:36:13,567 [salt.utils.decorators:613 ][WARNING ][4226] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-09-13 12:36:14,244 [salt.state       :290 ][INFO    ][4226] {'ret': {'machines': [{'status': 'Deployed', 'hostname': u'cmp002', 'system_id': u'4pqqtm'}, {'status': 'Deployed', 'hostname': u'cmp001', 'system_id': u'8ph7mn'}, {'status': 'Deployed', 'hostname': u'kvm01', 'system_id': u'rwn4cp'}, {'status': 'Deployed', 'hostname': u'kvm03', 'system_id': u'tmbdry'}, {'status': 'Deployed', 'hostname': u'kvm02', 'system_id': u'dwxchw'}], 'summary': Counter({'Deployed': 5})}}
2018-09-13 12:36:14,244 [salt.state       :1941][INFO    ][4226] Completed state [maas.machines_status] at time 12:36:14.244726 duration_in_ms=677.96
2018-09-13 12:36:14,247 [salt.minion      :1708][INFO    ][4226] Returning information for job: 20180913123608168866
2018-09-13 12:36:14,913 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command state.apply with jid 20180913123614930712
2018-09-13 12:36:14,945 [salt.minion      :1431][INFO    ][4278] Starting a new job with PID 4278
2018-09-13 12:36:15,623 [salt.state       :905 ][INFO    ][4278] Loading fresh modules for state activity
2018-09-13 12:36:15,720 [salt.state       :1770][INFO    ][4278] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:36:15.720811
2018-09-13 12:36:15,721 [salt.state       :1803][INFO    ][4278] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2018-09-13 12:36:15,723 [salt.loaded.int.module.cmdmod:395 ][INFO    ][4278] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2018-09-13 12:36:17,095 [salt.state       :290 ][INFO    ][4278] {'pid': 4285, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-09-13 12:36:17,096 [salt.state       :1941][INFO    ][4278] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 12:36:17.096367 duration_in_ms=1375.555
2018-09-13 12:36:17,099 [salt.state       :1770][INFO    ][4278] Running state [maas.machines_status] at time 12:36:17.099218
2018-09-13 12:36:17,099 [salt.state       :1803][INFO    ][4278] Executing state module.run for [maas.machines_status]
2018-09-13 12:36:17,100 [salt.utils.decorators:613 ][WARNING ][4278] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-09-13 12:36:17,844 [salt.state       :290 ][INFO    ][4278] {'ret': {'machines': [{'status': 'Deployed', 'hostname': u'cmp002', 'system_id': u'4pqqtm'}, {'status': 'Deployed', 'hostname': u'cmp001', 'system_id': u'8ph7mn'}, {'status': 'Deployed', 'hostname': u'kvm01', 'system_id': u'rwn4cp'}, {'status': 'Deployed', 'hostname': u'kvm03', 'system_id': u'tmbdry'}, {'status': 'Deployed', 'hostname': u'kvm02', 'system_id': u'dwxchw'}], 'summary': Counter({'Deployed': 5})}}
2018-09-13 12:36:17,844 [salt.state       :1941][INFO    ][4278] Completed state [maas.machines_status] at time 12:36:17.844638 duration_in_ms=745.419
2018-09-13 12:36:17,848 [salt.minion      :1708][INFO    ][4278] Returning information for job: 20180913123614930712
2018-09-13 12:36:18,560 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command pillar.item with jid 20180913123618577537
2018-09-13 12:36:18,586 [salt.minion      :1431][INFO    ][4300] Starting a new job with PID 4300
2018-09-13 12:36:18,599 [salt.minion      :1708][INFO    ][4300] Returning information for job: 20180913123618577537
2018-09-13 13:14:49,591 [salt.utils.schedule:1375][INFO    ][22391] Running scheduled job: __mine_interval
2018-09-13 14:14:49,590 [salt.utils.schedule:1375][INFO    ][22391] Running scheduled job: __mine_interval
2018-09-13 14:18:34,274 [salt.minion      :1307][INFO    ][22391] User sudo_ubuntu Executing command cp.push_dir with jid 20180913141834238594
2018-09-13 14:18:34,299 [salt.minion      :1431][INFO    ][12577] Starting a new job with PID 12577
