2020-01-15 23:09:31,455 [salt.utils.decorators:613 ][WARNING ][2252] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-01-15 23:09:32,388 [salt.utils.decorators:613 ][WARNING ][2252] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-01-15 23:09:36,113 [salt.loaded.int.states.file:2298][WARNING ][2475] State for file: /etc/maas/rackd.conf - Neither 'source' nor 'contents' nor 'contents_pillar' nor 'contents_grains' was defined, yet 'replace' was set to 'True'. As there is no source to replace the file with, 'replace' has been set to 'False' to avoid reading the file unnecessarily.
2020-01-15 23:09:47,552 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2742] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2020-01-15 23:09:47,589 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2742] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2020-01-15 23:09:47,632 [salt.utils.parsers:1051][WARNING ][378] Minion received a SIGTERM. Exiting.
2020-01-15 23:09:48,792 [salt.cli.daemons :293 ][INFO    ][2867] Setting up the Salt Minion "mas01.mcp-ovs-dpdk-ha.local"
2020-01-15 23:09:48,977 [salt.cli.daemons :82  ][INFO    ][2867] Starting up the Salt Minion
2020-01-15 23:09:48,978 [salt.utils.event :1017][INFO    ][2867] Starting pull socket on /var/run/salt/minion/minion_event_967fbee23e_pull.ipc
2020-01-15 23:09:50,212 [salt.minion      :976 ][INFO    ][2867] Creating minion process manager
2020-01-15 23:09:52,145 [salt.loader.10.20.0.2.int.module.cmdmod:395 ][INFO    ][2867] Executing command ['date', '+%z'] in directory '/root'
2020-01-15 23:09:52,177 [salt.utils.schedule:568 ][INFO    ][2867] Updating job settings for scheduled job: __mine_interval
2020-01-15 23:09:52,179 [salt.minion      :1108][INFO    ][2867] Added mine.update to scheduler
2020-01-15 23:09:52,187 [salt.minion      :1975][INFO    ][2867] Minion is starting as user 'root'
2020-01-15 23:09:52,204 [salt.minion      :2336][INFO    ][2867] Minion is ready to receive requests!
2020-01-15 23:09:57,434 [salt.state       :2022][WARNING ][2748] State is set to retry, but a valid dict for retry configuration was not found.  Using retry defaults
2020-01-15 23:09:59,580 [salt.utils.decorators:613 ][WARNING ][2748] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-01-15 23:10:00,011 [salt.minion      :1308][INFO    ][2867] User sudo_ubuntu Executing command saltutil.find_job with jid 20200115231000002534
2020-01-15 23:10:00,025 [salt.minion      :1432][INFO    ][3286] Starting a new job with PID 3286
2020-01-15 23:10:00,056 [salt.minion      :1711][INFO    ][3286] Returning information for job: 20200115231000002534
2020-01-15 23:10:13,427 [salt.utils.decorators:613 ][WARNING ][2748] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-01-15 23:10:30,110 [salt.minion      :1308][INFO    ][2867] User sudo_ubuntu Executing command saltutil.find_job with jid 20200115231030096579
2020-01-15 23:10:30,134 [salt.minion      :1432][INFO    ][3619] Starting a new job with PID 3619
2020-01-15 23:10:30,162 [salt.minion      :1711][INFO    ][3619] Returning information for job: 20200115231030096579
2020-01-15 23:11:00,214 [salt.minion      :1308][INFO    ][2867] User sudo_ubuntu Executing command saltutil.find_job with jid 20200115231100204197
2020-01-15 23:11:00,233 [salt.minion      :1432][INFO    ][3873] Starting a new job with PID 3873
2020-01-15 23:11:00,261 [salt.minion      :1711][INFO    ][3873] Returning information for job: 20200115231100204197
2020-01-15 23:11:02,492 [salt.utils.decorators:613 ][WARNING ][2748] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-01-15 23:11:03,614 [salt.utils.decorators:613 ][WARNING ][2748] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-01-15 23:11:05,636 [salt.loaded.ext.module.maasng:1008][WARNING ][2748] Detected cidr:192.168.11.0/24 in fabric:fabric-1
2020-01-15 23:11:05,636 [salt.loaded.ext.module.maasng:1011][WARNING ][2748] Guessing, that fabric with current name:fabric-1
 should be renamed to:pxe_admin
2020-01-15 23:11:06,380 [salt.loaded.ext.module.maasng:1235][WARNING ][2748] Ignoring parameter vlan:0
2020-01-15 23:11:07,312 [salt.utils.decorators:613 ][WARNING ][2748] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-01-15 23:11:08,413 [salt.minion      :1308][INFO    ][2867] User sudo_ubuntu Executing command state.apply with jid 20200115231108399936
2020-01-15 23:11:08,435 [salt.minion      :1432][INFO    ][4133] Starting a new job with PID 4133
2020-01-15 23:11:15,062 [salt.state       :915 ][INFO    ][4133] Loading fresh modules for state activity
2020-01-15 23:11:15,143 [salt.fileclient  :1219][INFO    ][4133] Fetching file from saltenv 'base', ** done ** 'maas/machines/init.sls'
2020-01-15 23:11:15,186 [salt.state       :1780][INFO    ][4133] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 23:11:15.186327
2020-01-15 23:11:15,186 [salt.state       :1813][INFO    ][4133] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2020-01-15 23:11:15,188 [salt.loaded.int.module.cmdmod:395 ][INFO    ][4133] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2020-01-15 23:11:17,326 [salt.state       :300 ][INFO    ][4133] {'pid': 4157, 'retcode': 0, 'stderr': '', 'stdout': ''}
2020-01-15 23:11:17,327 [salt.state       :1951][INFO    ][4133] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 23:11:17.327430 duration_in_ms=2141.1
2020-01-15 23:11:17,331 [salt.state       :1780][INFO    ][4133] Running state [maas.process_machines] at time 23:11:17.331035
2020-01-15 23:11:17,331 [salt.state       :1813][INFO    ][4133] Executing state module.run for [maas.process_machines]
2020-01-15 23:11:17,332 [salt.utils.decorators:613 ][WARNING ][4133] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-01-15 23:11:17,404 [salt.loaded.ext.module.maas:412 ][WARNING ][4133] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2020-01-15 23:11:17,405 [salt.loaded.ext.module.maas:92  ][INFO    ][4133] machine hostname=cmp002 power_type=ipmi mac_addresses=9c:b6:54:8a:10:18 power_parameters_power_address=172.16.1.20 power_parameters_power_pass=Winter2017 architecture=amd64/generic power_parameters_power_user=opnfv
2020-01-15 23:11:18,893 [salt.loaded.ext.module.maas:412 ][WARNING ][4133] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2020-01-15 23:11:18,898 [salt.loaded.ext.module.maas:92  ][INFO    ][4133] machine hostname=cmp001 power_type=ipmi mac_addresses=9c:b6:54:8a:95:a0 power_parameters_power_address=172.16.1.19 power_parameters_power_pass=Winter2017 architecture=amd64/generic power_parameters_power_user=opnfv
2020-01-15 23:11:20,371 [salt.loaded.ext.module.maas:412 ][WARNING ][4133] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2020-01-15 23:11:20,372 [salt.loaded.ext.module.maas:92  ][INFO    ][4133] machine hostname=kvm01 power_type=ipmi mac_addresses=14:58:d0:54:e7:88 power_parameters_power_address=172.16.1.16 power_parameters_power_pass=Winter2017 architecture=amd64/generic power_parameters_power_user=opnfv
2020-01-15 23:11:21,863 [salt.loaded.ext.module.maas:412 ][WARNING ][4133] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2020-01-15 23:11:21,864 [salt.loaded.ext.module.maas:92  ][INFO    ][4133] machine hostname=kvm03 power_type=ipmi mac_addresses=14:58:d0:54:7a:28 power_parameters_power_address=172.16.1.18 power_parameters_power_pass=Winter2017 architecture=amd64/generic power_parameters_power_user=opnfv
2020-01-15 23:11:23,380 [salt.loaded.ext.module.maas:412 ][WARNING ][4133] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2020-01-15 23:11:23,380 [salt.loaded.ext.module.maas:92  ][INFO    ][4133] machine hostname=kvm02 power_type=ipmi mac_addresses=14:58:d0:54:6a:60 power_parameters_power_address=172.16.1.17 power_parameters_power_pass=Winter2017 architecture=amd64/generic power_parameters_power_user=opnfv
2020-01-15 23:11:23,498 [salt.minion      :1308][INFO    ][2867] User sudo_ubuntu Executing command saltutil.find_job with jid 20200115231123487706
2020-01-15 23:11:23,520 [salt.minion      :1432][INFO    ][4386] Starting a new job with PID 4386
2020-01-15 23:11:23,556 [salt.minion      :1711][INFO    ][4386] Returning information for job: 20200115231123487706
2020-01-15 23:11:24,900 [salt.state       :300 ][INFO    ][4133] {'ret': {'updated': [], 'errors': {}, 'success': ['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']}}
2020-01-15 23:11:24,900 [salt.state       :1951][INFO    ][4133] Completed state [maas.process_machines] at time 23:11:24.900788 duration_in_ms=7569.754
2020-01-15 23:11:24,905 [salt.minion      :1711][INFO    ][4133] Returning information for job: 20200115231108399936
2020-01-15 23:11:56,377 [salt.minion      :1308][INFO    ][2867] User sudo_ubuntu Executing command state.apply with jid 20200115231156362842
2020-01-15 23:11:56,401 [salt.minion      :1432][INFO    ][4488] Starting a new job with PID 4488
2020-01-15 23:12:02,776 [salt.state       :915 ][INFO    ][4488] Loading fresh modules for state activity
2020-01-15 23:12:02,829 [salt.fileclient  :1219][INFO    ][4488] Fetching file from saltenv 'base', ** done ** 'maas/machines/wait_for_ready_or_deployed.sls'
2020-01-15 23:12:02,878 [salt.state       :1780][INFO    ][4488] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 23:12:02.878440
2020-01-15 23:12:02,878 [salt.state       :1813][INFO    ][4488] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2020-01-15 23:12:02,880 [salt.loaded.int.module.cmdmod:395 ][INFO    ][4488] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2020-01-15 23:12:04,727 [salt.state       :300 ][INFO    ][4488] {'pid': 4520, 'retcode': 0, 'stderr': '', 'stdout': ''}
2020-01-15 23:12:04,728 [salt.state       :1951][INFO    ][4488] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 23:12:04.728681 duration_in_ms=1850.241
2020-01-15 23:12:04,732 [salt.state       :1780][INFO    ][4488] Running state [maas.wait_for_machine_status] at time 23:12:04.732605
2020-01-15 23:12:04,734 [salt.state       :1813][INFO    ][4488] Executing state module.run for [maas.wait_for_machine_status]
2020-01-15 23:12:04,735 [salt.utils.decorators:613 ][WARNING ][4488] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-01-15 23:12:05,578 [salt.loaded.ext.module.maas:1023][INFO    ][4488] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1499.16835713s left)
2020-01-15 23:12:11,420 [salt.minion      :1308][INFO    ][2867] User sudo_ubuntu Executing command saltutil.find_job with jid 20200115231211404708
2020-01-15 23:12:11,451 [salt.minion      :1432][INFO    ][4531] Starting a new job with PID 4531
2020-01-15 23:12:11,481 [salt.minion      :1711][INFO    ][4531] Returning information for job: 20200115231211404708
2020-01-15 23:12:36,567 [salt.loaded.ext.module.maas:1023][INFO    ][4488] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1468.17942119s left)
2020-01-15 23:12:41,515 [salt.minion      :1308][INFO    ][2867] User sudo_ubuntu Executing command saltutil.find_job with jid 20200115231241503919
2020-01-15 23:12:41,544 [salt.minion      :1432][INFO    ][4550] Starting a new job with PID 4550
2020-01-15 23:12:41,576 [salt.minion      :1711][INFO    ][4550] Returning information for job: 20200115231241503919
2020-01-15 23:13:07,411 [salt.loaded.ext.module.maas:1023][INFO    ][4488] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1437.33555007s left)
2020-01-15 23:13:11,607 [salt.minion      :1308][INFO    ][2867] User sudo_ubuntu Executing command saltutil.find_job with jid 20200115231311595629
2020-01-15 23:13:11,636 [salt.minion      :1432][INFO    ][4604] Starting a new job with PID 4604
2020-01-15 23:13:11,668 [salt.minion      :1711][INFO    ][4604] Returning information for job: 20200115231311595629
2020-01-15 23:13:38,257 [salt.loaded.ext.module.maas:1023][INFO    ][4488] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1406.48955011s left)
2020-01-15 23:13:41,702 [salt.minion      :1308][INFO    ][2867] User sudo_ubuntu Executing command saltutil.find_job with jid 20200115231341690423
2020-01-15 23:13:41,727 [salt.minion      :1432][INFO    ][4624] Starting a new job with PID 4624
2020-01-15 23:13:41,756 [salt.minion      :1711][INFO    ][4624] Returning information for job: 20200115231341690423
2020-01-15 23:14:09,314 [salt.loaded.ext.module.maas:1023][INFO    ][4488] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1375.43261719s left)
2020-01-15 23:14:11,778 [salt.minion      :1308][INFO    ][2867] User sudo_ubuntu Executing command saltutil.find_job with jid 20200115231411768868
2020-01-15 23:14:11,793 [salt.minion      :1432][INFO    ][4705] Starting a new job with PID 4705
2020-01-15 23:14:11,851 [salt.minion      :1711][INFO    ][4705] Returning information for job: 20200115231411768868
2020-01-15 23:14:40,468 [salt.loaded.ext.module.maas:1023][INFO    ][4488] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1344.27848506s left)
2020-01-15 23:14:41,880 [salt.minion      :1308][INFO    ][2867] User sudo_ubuntu Executing command saltutil.find_job with jid 20200115231441865823
2020-01-15 23:14:41,914 [salt.minion      :1432][INFO    ][4789] Starting a new job with PID 4789
2020-01-15 23:14:41,942 [salt.minion      :1711][INFO    ][4789] Returning information for job: 20200115231441865823
2020-01-15 23:15:11,834 [salt.loaded.ext.module.maas:1023][INFO    ][4488] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1312.91216803s left)
2020-01-15 23:15:12,045 [salt.minion      :1308][INFO    ][2867] User sudo_ubuntu Executing command saltutil.find_job with jid 20200115231512028591
2020-01-15 23:15:12,071 [salt.minion      :1432][INFO    ][5133] Starting a new job with PID 5133
2020-01-15 23:15:12,105 [salt.minion      :1711][INFO    ][5133] Returning information for job: 20200115231512028591
2020-01-15 23:15:42,168 [salt.minion      :1308][INFO    ][2867] User sudo_ubuntu Executing command saltutil.find_job with jid 20200115231542148265
2020-01-15 23:15:42,192 [salt.minion      :1432][INFO    ][5219] Starting a new job with PID 5219
2020-01-15 23:15:42,224 [salt.minion      :1711][INFO    ][5219] Returning information for job: 20200115231542148265
2020-01-15 23:15:43,265 [salt.loaded.ext.module.maas:1023][INFO    ][4488] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1281.48115611s left)
2020-01-15 23:16:12,292 [salt.minion      :1308][INFO    ][2867] User sudo_ubuntu Executing command saltutil.find_job with jid 20200115231612273820
2020-01-15 23:16:12,314 [salt.minion      :1432][INFO    ][5377] Starting a new job with PID 5377
2020-01-15 23:16:12,342 [salt.minion      :1711][INFO    ][5377] Returning information for job: 20200115231612273820
2020-01-15 23:16:15,054 [salt.loaded.ext.module.maas:1023][INFO    ][4488] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1249.69231319s left)
2020-01-15 23:16:42,418 [salt.minion      :1308][INFO    ][2867] User sudo_ubuntu Executing command saltutil.find_job with jid 20200115231642402315
2020-01-15 23:16:42,444 [salt.minion      :1432][INFO    ][5525] Starting a new job with PID 5525
2020-01-15 23:16:42,474 [salt.minion      :1711][INFO    ][5525] Returning information for job: 20200115231642402315
2020-01-15 23:16:47,200 [salt.loaded.ext.module.maas:1023][INFO    ][4488] Waiting status:Ready|Deployed for machines:['cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1217.54664207s left)
2020-01-15 23:17:12,611 [salt.minion      :1308][INFO    ][2867] User sudo_ubuntu Executing command saltutil.find_job with jid 20200115231712598928
2020-01-15 23:17:12,636 [salt.minion      :1432][INFO    ][6039] Starting a new job with PID 6039
2020-01-15 23:17:12,671 [salt.minion      :1711][INFO    ][6039] Returning information for job: 20200115231712598928
2020-01-15 23:17:19,456 [salt.loaded.ext.module.maas:1023][INFO    ][4488] Waiting status:Ready|Deployed for machines:['kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1185.29052615s left)
2020-01-15 23:17:42,724 [salt.minion      :1308][INFO    ][2867] User sudo_ubuntu Executing command saltutil.find_job with jid 20200115231742709858
2020-01-15 23:17:42,752 [salt.minion      :1432][INFO    ][6070] Starting a new job with PID 6070
2020-01-15 23:17:42,784 [salt.minion      :1711][INFO    ][6070] Returning information for job: 20200115231742709858
2020-01-15 23:17:51,996 [salt.loaded.ext.module.maas:1023][INFO    ][4488] Waiting status:Ready|Deployed for machines:['kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1152.75016713s left)
2020-01-15 23:18:12,863 [salt.minion      :1308][INFO    ][2867] User sudo_ubuntu Executing command saltutil.find_job with jid 20200115231812853727
2020-01-15 23:18:12,890 [salt.minion      :1432][INFO    ][6236] Starting a new job with PID 6236
2020-01-15 23:18:12,923 [salt.minion      :1711][INFO    ][6236] Returning information for job: 20200115231812853727
2020-01-15 23:18:24,890 [salt.loaded.ext.module.maas:1023][INFO    ][4488] Waiting status:Ready|Deployed for machines:['kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1119.85634017s left)
2020-01-15 23:18:42,991 [salt.minion      :1308][INFO    ][2867] User sudo_ubuntu Executing command saltutil.find_job with jid 20200115231842976957
2020-01-15 23:18:43,020 [salt.minion      :1432][INFO    ][6284] Starting a new job with PID 6284
2020-01-15 23:18:43,055 [salt.minion      :1711][INFO    ][6284] Returning information for job: 20200115231842976957
2020-01-15 23:18:57,792 [salt.state       :300 ][INFO    ][4488] {'ret': True}
2020-01-15 23:18:57,793 [salt.state       :1951][INFO    ][4488] Completed state [maas.wait_for_machine_status] at time 23:18:57.793457 duration_in_ms=413060.852
2020-01-15 23:18:57,800 [salt.minion      :1711][INFO    ][4488] Returning information for job: 20200115231156362842
2020-01-15 23:18:58,571 [salt.minion      :1308][INFO    ][2867] User sudo_ubuntu Executing command state.apply with jid 20200115231858560111
2020-01-15 23:18:58,598 [salt.minion      :1432][INFO    ][6328] Starting a new job with PID 6328
2020-01-15 23:19:05,048 [salt.state       :915 ][INFO    ][6328] Loading fresh modules for state activity
2020-01-15 23:19:05,114 [salt.fileclient  :1219][INFO    ][6328] Fetching file from saltenv 'base', ** done ** 'maas/machines/storage.sls'
2020-01-15 23:19:05,222 [salt.state       :1780][INFO    ][6328] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 23:19:05.222379
2020-01-15 23:19:05,222 [salt.state       :1813][INFO    ][6328] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2020-01-15 23:19:05,224 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6328] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2020-01-15 23:19:07,098 [salt.state       :300 ][INFO    ][6328] {'pid': 6413, 'retcode': 0, 'stderr': '', 'stdout': ''}
2020-01-15 23:19:07,099 [salt.state       :1951][INFO    ][6328] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 23:19:07.098996 duration_in_ms=1876.617
2020-01-15 23:19:07,101 [salt.state       :1780][INFO    ][6328] Running state [maas_machines_storage_cmp002_lvm] at time 23:19:07.101177
2020-01-15 23:19:07,101 [salt.state       :1813][INFO    ][6328] Executing state maasng.disk_layout_present for [maas_machines_storage_cmp002_lvm]
2020-01-15 23:19:08,233 [salt.loaded.ext.module.maasng:610 ][INFO    ][6328] bgpdg3
2020-01-15 23:19:08,233 [salt.loaded.ext.module.maasng:626 ][INFO    ][6328] sda
2020-01-15 23:19:08,803 [salt.loaded.ext.module.maasng:361 ][INFO    ][6328] bgpdg3
2020-01-15 23:19:08,891 [salt.loaded.ext.module.maasng:367 ][INFO    ][6328] [{u'size': 800109715456, u'block_size': 4096, u'uuid': None, u'name': u'sda', u'tags': [u'ssd'], u'used_size': 800106479616, u'id': 1, u'filesystem': None, u'used_for': u'MBR partitioned with 1 partition', u'system_id': u'bgpdg3', u'partition_table_type': u'MBR', u'path': u'/dev/disk/by-dname/sda', u'id_path': u'/dev/disk/by-id/wwn-0x600508b1001cb19198eb9a66f8a29401', u'available_size': 0, u'model': u'LOGICAL VOLUME', u'partitions': [{u'size': 800101236736, u'uuid': u'311ae8f1-f9d8-4388-bafa-bad335ff74ee', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'bgpdg3', u'filesystem': {u'uuid': u'546b0fda-514b-4ac5-8139-dd3690d58f45', u'label': None, u'mount_point': None, u'mount_options': None, u'fstype': u'lvm-pv'}, u'path': u'/dev/disk/by-dname/sda-part1', u'device_id': 1, u'type': u'partition', u'id': 1, u'resource_uri': u'/MAAS/api/2.0/nodes/bgpdg3/blockdevices/1/partition/1'}], u'type': u'physical', u'serial': u'600508b1001cb19198eb9a66f8a29401', u'resource_uri': u'/MAAS/api/2.0/nodes/bgpdg3/blockdevices/1/'}, {u'size': 800097042432, u'block_size': 4096, u'uuid': u'0b81c60d-e965-4973-9ffe-28fb64853476', u'name': u'vgroot-lvroot', u'tags': [], u'used_size': 800097042432, u'id': 3, u'filesystem': {u'uuid': u'c415f9f5-e473-4655-93c6-0f395f22ac9c', u'label': u'root', u'mount_point': u'/', u'mount_options': None, u'fstype': u'ext4'}, u'used_for': u'ext4 formatted filesystem mounted at /', u'system_id': u'bgpdg3', 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'serial': None, u'resource_uri': u'/MAAS/api/2.0/nodes/bgpdg3/blockdevices/3/'}]
2020-01-15 23:19:08,892 [salt.loaded.ext.module.maasng:632 ][INFO    ][6328] vgroot
2020-01-15 23:19:08,892 [salt.loaded.ext.module.maasng:635 ][INFO    ][6328] lvroot
2020-01-15 23:19:08,892 [salt.loaded.ext.module.maasng:639 ][INFO    ][6328] 107374182400
2020-01-15 23:19:09,476 [salt.loaded.ext.module.maasng:645 ][INFO    ][6328] {u'hwe_kernel': u'', u'swap_size': None, u'ip_addresses': [u'192.168.11.38', u'192.168.11.40'], u'cpu_count': 40, u'owner_data': {}, u'domain': {u'resource_record_count': 0, u'name': u'maas', u'authoritative': True, u'ttl': None, u'id': 0, u'resource_uri': u'/MAAS/api/2.0/domains/0/'}, u'boot_interface': {u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'4tdgas', u'relay_vlan': None, u'external_dhcp': None, u'name': u'untagged', u'id': 5002, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/'}, u'name': u'eno1', u'links': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'4tdgas', u'relay_vlan': None, u'external_dhcp': None, u'name': u'untagged', u'id': 5002, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/'}, u'allow_proxy': True, u'rdns_mode': 2, u'gateway_ip': u'192.168.11.3', u'active_discovery': False, u'cidr': u'192.168.11.0/24', u'id': 2, u'resource_uri': u'/MAAS/api/2.0/subnets/2/'}, u'ip_address': u'192.168.11.38', u'id': 18, u'mode': u'dhcp'}], u'tags': [u'sriov'], u'effective_mtu': 1500, u'enabled': True, u'id': 4, u'discovered': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'4tdgas', u'relay_vlan': None, u'external_dhcp': None, u'name': u'untagged', u'id': 5002, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/'}, u'allow_proxy': True, u'rdns_mode': 2, u'gateway_ip': u'192.168.11.3', u'active_discovery': False, u'cidr': u'192.168.11.0/24', u'id': 2, u'resource_uri': u'/MAAS/api/2.0/subnets/2/'}, u'ip_address': u'192.168.11.38'}], u'parents': [], u'mac_address': u'9c:b6:54:8a:10:18', u'params': u'', u'system_id': u'bgpdg3', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/bgpdg3/interfaces/4/'}, u'status_action': u'', u'tag_names': [], u'testing_status_name': u'Passed', u'owner': None, u'pod': None, u'cache_sets': [], u'iscsiblockdevice_set': [], u'boot_disk': {u'size': 800109715456, u'uuid': None, u'name': u'sda', u'tags': [u'ssd'], u'used_size': 800106479616, u'partitions': [{u'size': 800101236736, u'uuid': u'61f5c65f-533f-4a2f-91c3-e0e6f4cbfc80', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'bgpdg3', u'filesystem': {u'uuid': u'bf9c5803-5539-431a-8dcd-cf72b92511dc', u'label': None, u'mount_point': None, u'mount_options': None, u'fstype': u'lvm-pv'}, u'path': u'/dev/disk/by-dname/sda-part1', u'device_id': 1, u'type': u'partition', u'id': 6, u'resource_uri': u'/MAAS/api/2.0/nodes/bgpdg3/blockdevices/1/partition/6'}], u'filesystem': None, u'used_for': u'MBR partitioned with 1 partition', u'id_path': u'/dev/disk/by-id/wwn-0x600508b1001cb19198eb9a66f8a29401', u'system_id': u'bgpdg3', u'partition_table_type': u'MBR', u'path': u'/dev/disk/by-dname/sda', u'id': 1, u'available_size': 0, u'model': u'LOGICAL VOLUME', u'block_size': 4096, u'type': u'physical', u'serial': u'600508b1001cb19198eb9a66f8a29401', u'resource_uri': u'/MAAS/api/2.0/nodes/bgpdg3/blockdevices/1/'}, u'blockdevice_set': [{u'size': 800109715456, u'block_size': 4096, u'uuid': None, u'name': u'sda', u'tags': [u'ssd'], u'used_size': 800106479616, u'id': 1, u'filesystem': None, u'used_for': u'MBR partitioned with 1 partition', u'system_id': u'bgpdg3', u'partition_table_type': u'MBR', u'path': u'/dev/disk/by-dname/sda', u'id_path': u'/dev/disk/by-id/wwn-0x600508b1001cb19198eb9a66f8a29401', u'available_size': 0, u'model': u'LOGICAL VOLUME', u'partitions': [{u'size': 800101236736, u'uuid': u'61f5c65f-533f-4a2f-91c3-e0e6f4cbfc80', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'bgpdg3', u'filesystem': {u'uuid': u'bf9c5803-5539-431a-8dcd-cf72b92511dc', u'label': None, u'mount_point': None, u'mount_options': None, u'fstype': u'lvm-pv'}, u'path': u'/dev/disk/by-dname/sda-part1', u'device_id': 1, u'type': u'partition', u'id': 6, u'resource_uri': u'/MAAS/api/2.0/nodes/bgpdg3/blockdevices/1/partition/6'}], u'type': u'physical', u'serial': u'600508b1001cb19198eb9a66f8a29401', u'resource_uri': u'/MAAS/api/2.0/nodes/bgpdg3/blockdevices/1/'}, {u'size': 107374182400, u'block_size': 4096, u'uuid': u'39dd822f-3dd8-4b3b-97c8-ca31a40eb54a', u'name': u'vgroot-lvroot', u'tags': [], u'used_size': 107374182400, u'id': 11, u'filesystem': {u'uuid': u'9b7c1380-efb9-4861-a8f9-bf45db227cf5', u'label': u'root', u'mount_point': u'/', u'mount_options': None, u'fstype': u'ext4'}, u'used_for': u'ext4 formatted filesystem mounted at /', u'system_id': u'bgpdg3', 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'serial': None, u'resource_uri': u'/MAAS/api/2.0/nodes/bgpdg3/blockdevices/11/'}], u'zone': {u'id': 1, u'resource_uri': u'/MAAS/api/2.0/zones/default/', u'name': u'default', u'description': u''}, u'node_type_name': u'Machine', u'hostname': u'cmp002', u'storage': 800109.715456, u'node_type': 0, u'testing_status': 2, u'system_id': u'bgpdg3', u'raids': [], u'memory': 65536, u'current_installation_result_id': None, u'default_gateways': {u'ipv4': {u'gateway_ip': u'192.168.11.3', u'link_id': None}, u'ipv6': {u'gateway_ip': None, u'link_id': None}}, u'status_message': u'Power state queried: off', u'virtualblockdevice_set': [{u'size': 107374182400, u'uuid': u'39dd822f-3dd8-4b3b-97c8-ca31a40eb54a', u'name': u'vgroot-lvroot', u'tags': [], u'used_size': 107374182400, u'partitions': [], u'filesystem': {u'uuid': u'9b7c1380-efb9-4861-a8f9-bf45db227cf5', u'label': u'root', u'mount_point': u'/', u'mount_options': None, u'fstype': u'ext4'}, u'used_for': u'ext4 formatted filesystem mounted at /', u'id_path': None, u'system_id': u'bgpdg3', u'partition_table_type': None, u'path': u'/dev/disk/by-dname/vgroot-lvroot', u'id': 11, u'available_size': 0, u'model': None, u'block_size': 4096, u'type': u'virtual', u'serial': None, u'resource_uri': u'/MAAS/api/2.0/nodes/bgpdg3/blockdevices/11/'}], u'architecture': u'amd64/generic', u'status': 4, u'bcaches': [], u'storage_test_status_name': u'Passed', u'power_state': u'off', u'power_type': u'ipmi', u'physicalblockdevice_set': [{u'size': 800109715456, u'uuid': None, u'name': u'sda', u'tags': [u'ssd'], u'used_size': 800106479616, u'partitions': [{u'size': 800101236736, u'uuid': u'61f5c65f-533f-4a2f-91c3-e0e6f4cbfc80', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'bgpdg3', u'filesystem': {u'uuid': u'bf9c5803-5539-431a-8dcd-cf72b92511dc', u'label': None, u'mount_point': None, u'mount_options': None, u'fstype': u'lvm-pv'}, u'path': u'/dev/disk/by-dname/sda-part1', u'device_id': 1, u'type': u'partition', u'id': 6, u'resource_uri': u'/MAAS/api/2.0/nodes/bgpdg3/blockdevices/1/partition/6'}], u'filesystem': None, u'used_for': u'MBR partitioned with 1 partition', u'id_path': u'/dev/disk/by-id/wwn-0x600508b1001cb19198eb9a66f8a29401', u'system_id': u'bgpdg3', u'partition_table_type': u'MBR', u'path': u'/dev/disk/by-dname/sda', u'id': 1, u'available_size': 0, u'model': u'LOGICAL VOLUME', u'block_size': 4096, u'type': u'physical', u'serial': u'600508b1001cb19198eb9a66f8a29401', u'resource_uri': u'/MAAS/api/2.0/nodes/bgpdg3/blockdevices/1/'}], u'other_test_status_name': u'Unknown', u'volume_groups': [{u'__incomplete__': True, u'system_id': u'bgpdg3', u'id': 6}], u'special_filesystems': [], u'current_commissioning_result_id': 2, u'memory_test_status_name': u'Unknown', u'interface_set': [{u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'4tdgas', u'relay_vlan': None, u'external_dhcp': None, u'name': u'untagged', u'id': 5002, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/'}, u'name': u'eno1', u'links': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'4tdgas', u'relay_vlan': None, u'external_dhcp': None, u'name': u'untagged', u'id': 5002, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/'}, u'allow_proxy': True, u'rdns_mode': 2, u'gateway_ip': u'192.168.11.3', u'active_discovery': False, u'cidr': u'192.168.11.0/24', u'id': 2, u'resource_uri': u'/MAAS/api/2.0/subnets/2/'}, u'ip_address': u'192.168.11.38', u'id': 18, u'mode': u'dhcp'}], u'tags': [u'sriov'], u'effective_mtu': 1500, u'enabled': True, u'id': 4, u'discovered': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'4tdgas', u'relay_vlan': None, u'external_dhcp': None, u'name': u'untagged', u'id': 5002, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/'}, u'allow_proxy': True, u'rdns_mode': 2, u'gateway_ip': u'192.168.11.3', u'active_discovery': False, u'cidr': u'192.168.11.0/24', u'id': 2, u'resource_uri': u'/MAAS/api/2.0/subnets/2/'}, u'ip_address': u'192.168.11.38'}], u'parents': [], u'mac_address': u'9c:b6:54:8a:10:18', u'params': u'', u'system_id': u'bgpdg3', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/bgpdg3/interfaces/4/'}, {u'vlan': None, u'name': u'ens1f1', u'links': [], u'tags': [u'sriov'], u'effective_mtu': 1500, u'enabled': True, u'id': 14, u'discovered': None, u'parents': [], u'mac_address': u'38:ea:a7:8f:07:51', u'params': u'', u'system_id': u'bgpdg3', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/bgpdg3/interfaces/14/'}, {u'vlan': None, u'name': u'ens1f0', u'links': [], u'tags': [u'sriov'], u'effective_mtu': 1500, u'enabled': True, u'id': 15, u'discovered': None, u'parents': [], u'mac_address': u'38:ea:a7:8f:07:50', u'params': u'', u'system_id': u'bgpdg3', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/bgpdg3/interfaces/15/'}, {u'vlan': {u'fabric': u'fabric-0', u'vid': 0, u'space': u'undefined', u'fabric_id': 0, u'dhcp_on': False, u'mtu': 1500, u'primary_rack': None, u'relay_vlan': None, u'external_dhcp': None, u'name': u'untagged', u'id': 5001, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/'}, u'name': u'ens2f1', u'links': [{u'mode': u'link_up', u'id': 19}], u'tags': [u'sriov'], u'effective_mtu': 1500, u'enabled': True, u'id': 13, u'discovered': None, u'parents': [], u'mac_address': u'38:ea:a7:8f:12:49', u'params': u'', u'system_id': u'bgpdg3', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/bgpdg3/interfaces/13/'}, {u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'4tdgas', u'relay_vlan': None, u'external_dhcp': None, u'name': u'untagged', u'id': 5002, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/'}, u'name': u'eno2', u'links': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'4tdgas', u'relay_vlan': None, u'external_dhcp': None, u'name': u'untagged', u'id': 5002, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/'}, u'allow_proxy': True, u'rdns_mode': 2, u'gateway_ip': u'192.168.11.3', u'active_discovery': False, u'cidr': u'192.168.11.0/24', u'id': 2, u'resource_uri': u'/MAAS/api/2.0/subnets/2/'}, u'id': 20, u'mode': u'link_up'}], u'tags': [u'sriov'], u'effective_mtu': 1500, u'enabled': True, u'id': 11, u'discovered': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'4tdgas', u'relay_vlan': None, u'external_dhcp': None, u'name': u'untagged', u'id': 5002, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/'}, u'allow_proxy': True, u'rdns_mode': 2, u'gateway_ip': u'192.168.11.3', u'active_discovery': False, u'cidr': u'192.168.11.0/24', u'id': 2, u'resource_uri': u'/MAAS/api/2.0/subnets/2/'}, u'ip_address': u'192.168.11.40'}], u'parents': [], u'mac_address': u'9c:b6:54:8a:10:1c', u'params': u'', u'system_id': u'bgpdg3', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/bgpdg3/interfaces/11/'}, {u'vlan': {u'fabric': u'fabric-0', u'vid': 0, u'space': u'undefined', u'fabric_id': 0, u'dhcp_on': False, u'mtu': 1500, u'primary_rack': None, u'relay_vlan': None, u'external_dhcp': None, u'name': u'untagged', u'id': 5001, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/'}, u'name': u'ens2f0', u'links': [{u'mode': u'link_up', u'id': 21}], u'tags': [u'sriov'], u'effective_mtu': 1500, u'enabled': True, u'id': 12, u'discovered': None, u'parents': [], u'mac_address': u'38:ea:a7:8f:12:48', u'params': u'', u'system_id': u'bgpdg3', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/bgpdg3/interfaces/12/'}], u'current_testing_result_id': 3, u'cpu_test_status': -1, u'storage_test_status': 2, u'other_test_status': -1, u'status_name': u'Ready', u'netboot': True, u'osystem': u'', u'fqdn': u'cmp002.maas', u'disable_ipv4': False, u'commissioning_status': 2, u'min_hwe_kernel': u'hwe-18.04', u'commissioning_status_name': u'Passed', u'cpu_test_status_name': u'Unknown', u'address_ttl': None, u'resource_uri': u'/MAAS/api/2.0/machines/bgpdg3/', u'distro_series': u'', u'memory_test_status': -1}
2020-01-15 23:19:09,479 [salt.state       :300 ][INFO    ][6328] {'new': {'storage_layout': 'lvm'}}
2020-01-15 23:19:09,480 [salt.state       :1951][INFO    ][6328] Completed state [maas_machines_storage_cmp002_lvm] at time 23:19:09.479931 duration_in_ms=2378.753
2020-01-15 23:19:09,480 [salt.state       :1780][INFO    ][6328] Running state [maas_machines_storage_cmp001_lvm] at time 23:19:09.480692
2020-01-15 23:19:09,481 [salt.state       :1813][INFO    ][6328] Executing state maasng.disk_layout_present for [maas_machines_storage_cmp001_lvm]
2020-01-15 23:19:10,596 [salt.loaded.ext.module.maasng:610 ][INFO    ][6328] gdthex
2020-01-15 23:19:10,597 [salt.loaded.ext.module.maasng:626 ][INFO    ][6328] sda
2020-01-15 23:19:11,163 [salt.loaded.ext.module.maasng:361 ][INFO    ][6328] gdthex
2020-01-15 23:19:11,259 [salt.loaded.ext.module.maasng:367 ][INFO    ][6328] [{u'size': 800109715456, u'resource_uri': u'/MAAS/api/2.0/nodes/gdthex/blockdevices/2/', u'available_size': 0, u'uuid': None, u'tags': [u'ssd'], u'type': u'physical', u'partitions': [{u'size': 800101236736, u'uuid': u'0aeee6d9-44be-468d-ad33-f123b7352851', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'gdthex', u'filesystem': {u'mount_options': None, u'label': None, u'mount_point': None, u'uuid': u'01481740-480a-427e-a504-dfea9165a080', u'fstype': u'lvm-pv'}, u'path': u'/dev/disk/by-dname/sda-part1', u'resource_uri': u'/MAAS/api/2.0/nodes/gdthex/blockdevices/2/partition/2', u'type': u'partition', u'id': 2, u'device_id': 2}], u'used_for': u'MBR partitioned with 1 partition', u'system_id': u'gdthex', u'partition_table_type': u'MBR', u'filesystem': None, u'id_path': u'/dev/disk/by-id/wwn-0x600508b1001cd7e61f5cd3479576479e', u'path': u'/dev/disk/by-dname/sda', u'model': u'LOGICAL VOLUME', u'block_size': 4096, u'used_size': 800106479616, u'id': 2, u'serial': u'600508b1001cd7e61f5cd3479576479e', u'name': u'sda'}, {u'size': 800097042432, u'resource_uri': u'/MAAS/api/2.0/nodes/gdthex/blockdevices/4/', u'available_size': 0, u'uuid': u'034ac530-2d6d-406d-9cc7-189caf9dc48b', u'tags': [], u'type': u'virtual', u'partitions': [], u'used_for': u'ext4 formatted filesystem mounted at /', u'system_id': u'gdthex', u'partition_table_type': None, u'filesystem': {u'mount_options': None, u'label': u'root', u'mount_point': u'/', u'uuid': u'6f3abbed-e59b-4262-b6e7-f9c72eda3986', u'fstype': u'ext4'}, u'id_path': None, u'path': u'/dev/disk/by-dname/lvroot', u'model': None, u'block_size': 4096, u'used_size': 800097042432, u'id': 4, u'serial': None, u'name': u'vgroot-lvroot'}]
2020-01-15 23:19:11,260 [salt.loaded.ext.module.maasng:632 ][INFO    ][6328] vgroot
2020-01-15 23:19:11,260 [salt.loaded.ext.module.maasng:635 ][INFO    ][6328] lvroot
2020-01-15 23:19:11,260 [salt.loaded.ext.module.maasng:639 ][INFO    ][6328] 107374182400
2020-01-15 23:19:11,881 [salt.loaded.ext.module.maasng:645 ][INFO    ][6328] {u'domain': {u'resource_record_count': 0, u'name': u'maas', u'authoritative': True, u'ttl': None, u'id': 0, u'resource_uri': u'/MAAS/api/2.0/domains/0/'}, u'swap_size': None, u'boot_interface': {u'name': u'eno1', u'links': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'external_dhcp': None, u'relay_vlan': None, u'primary_rack': u'4tdgas', u'resource_uri': u'/MAAS/api/2.0/vlans/5002/', u'id': 5002, u'secondary_rack': None, u'fabric': u'pxe_admin'}, u'allow_proxy': True, u'rdns_mode': 2, u'gateway_ip': u'192.168.11.3', u'active_discovery': False, u'cidr': u'192.168.11.0/24', u'id': 2, u'resource_uri': u'/MAAS/api/2.0/subnets/2/'}, u'ip_address': u'192.168.11.39', u'id': 26, u'mode': u'dhcp'}], u'tags': [u'sriov'], u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'external_dhcp': None, u'relay_vlan': None, u'primary_rack': u'4tdgas', u'resource_uri': u'/MAAS/api/2.0/vlans/5002/', u'id': 5002, u'secondary_rack': None, u'fabric': u'pxe_admin'}, u'enabled': True, u'children': [], u'discovered': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'external_dhcp': None, u'relay_vlan': None, u'primary_rack': u'4tdgas', u'resource_uri': u'/MAAS/api/2.0/vlans/5002/', u'id': 5002, u'secondary_rack': None, u'fabric': u'pxe_admin'}, u'allow_proxy': True, u'rdns_mode': 2, u'gateway_ip': u'192.168.11.3', u'active_discovery': False, u'cidr': u'192.168.11.0/24', u'id': 2, u'resource_uri': u'/MAAS/api/2.0/subnets/2/'}, u'ip_address': u'192.168.11.39'}], u'mac_address': u'9c:b6:54:8a:95:a0', u'params': u'', u'effective_mtu': 1500, u'parents': [], u'system_id': u'gdthex', u'type': u'physical', u'id': 5, u'resource_uri': u'/MAAS/api/2.0/nodes/gdthex/interfaces/5/'}, u'disable_ipv4': False, u'cpu_count': 40, u'power_type': u'ipmi', u'hwe_kernel': u'', u'memory_test_status_name': u'Unknown', u'min_hwe_kernel': u'hwe-18.04', u'status_action': u'', u'tag_names': [], u'testing_status_name': u'Passed', u'owner': None, u'pod': None, u'cache_sets': [], u'iscsiblockdevice_set': [], u'boot_disk': {u'size': 800109715456, u'model': u'LOGICAL VOLUME', u'resource_uri': u'/MAAS/api/2.0/nodes/gdthex/blockdevices/2/', u'uuid': None, u'tags': [u'ssd'], u'type': u'physical', u'partitions': [{u'size': 800101236736, u'uuid': u'c0668f4d-0000-45cf-8c0a-2174b04f5ce2', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'gdthex', u'filesystem': {u'mount_options': None, u'label': None, u'mount_point': None, u'uuid': u'55e53a5a-81bd-415a-8f60-05f4a8f8cc5f', u'fstype': u'lvm-pv'}, u'path': u'/dev/disk/by-dname/sda-part1', u'resource_uri': u'/MAAS/api/2.0/nodes/gdthex/blockdevices/2/partition/7', u'type': u'partition', u'id': 7, u'device_id': 2}], u'used_for': u'MBR partitioned with 1 partition', u'system_id': u'gdthex', u'partition_table_type': u'MBR', u'filesystem': None, u'id_path': u'/dev/disk/by-id/wwn-0x600508b1001cd7e61f5cd3479576479e', u'available_size': 0, u'path': u'/dev/disk/by-dname/sda', u'block_size': 4096, u'used_size': 800106479616, u'id': 2, u'serial': u'600508b1001cd7e61f5cd3479576479e', u'name': u'sda'}, u'zone': {u'description': u'', u'resource_uri': u'/MAAS/api/2.0/zones/default/', u'name': u'default', u'id': 1}, u'resource_uri': u'/MAAS/api/2.0/machines/gdthex/', u'current_commissioning_result_id': 4, u'hostname': u'cmp001', u'storage': 800109.715456, u'testing_status': 2, u'system_id': u'gdthex', u'power_state': u'off', u'memory': 65536, u'current_installation_result_id': None, u'default_gateways': {u'ipv4': {u'gateway_ip': u'192.168.11.3', u'link_id': None}, u'ipv6': {u'gateway_ip': None, u'link_id': None}}, u'status_message': u'Power state queried: off', u'ip_addresses': [u'192.168.11.39', u'192.168.11.42'], u'blockdevice_set': [{u'size': 800109715456, u'resource_uri': u'/MAAS/api/2.0/nodes/gdthex/blockdevices/2/', u'available_size': 0, u'uuid': None, u'tags': [u'ssd'], u'type': u'physical', u'partitions': [{u'size': 800101236736, u'uuid': u'c0668f4d-0000-45cf-8c0a-2174b04f5ce2', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'gdthex', u'filesystem': {u'mount_options': None, u'label': None, u'mount_point': None, u'uuid': u'55e53a5a-81bd-415a-8f60-05f4a8f8cc5f', u'fstype': u'lvm-pv'}, u'path': u'/dev/disk/by-dname/sda-part1', u'resource_uri': u'/MAAS/api/2.0/nodes/gdthex/blockdevices/2/partition/7', u'type': u'partition', u'id': 7, u'device_id': 2}], u'used_for': u'MBR partitioned with 1 partition', u'system_id': u'gdthex', u'partition_table_type': u'MBR', u'filesystem': None, u'id_path': u'/dev/disk/by-id/wwn-0x600508b1001cd7e61f5cd3479576479e', u'path': u'/dev/disk/by-dname/sda', u'model': u'LOGICAL VOLUME', u'block_size': 4096, u'used_size': 800106479616, u'id': 2, u'serial': u'600508b1001cd7e61f5cd3479576479e', u'name': u'sda'}, {u'size': 107374182400, u'resource_uri': u'/MAAS/api/2.0/nodes/gdthex/blockdevices/12/', u'available_size': 0, u'uuid': u'33198905-96e1-40d4-94dc-0e00144b18eb', u'tags': [], u'type': u'virtual', u'partitions': [], u'used_for': u'ext4 formatted filesystem mounted at /', u'system_id': u'gdthex', u'partition_table_type': None, u'filesystem': {u'mount_options': None, u'label': u'root', u'mount_point': u'/', u'uuid': u'f3746779-5860-40bd-abbf-192f23214887', u'fstype': u'ext4'}, u'id_path': None, u'path': u'/dev/disk/by-dname/lvroot', u'model': None, u'block_size': 4096, u'used_size': 107374182400, u'id': 12, u'serial': None, u'name': u'vgroot-lvroot'}], u'status': 4, u'storage_test_status': 2, u'storage_test_status_name': u'Passed', u'raids': [], u'owner_data': {}, u'other_test_status_name': u'Unknown', u'volume_groups': [{u'__incomplete__': True, u'system_id': u'gdthex', u'id': 7}], u'special_filesystems': [], u'cpu_test_status_name': u'Unknown', u'node_type_name': u'Machine', u'current_testing_result_id': 5, u'cpu_test_status': -1, u'bcaches': [], u'status_name': u'Ready', u'physicalblockdevice_set': [{u'size': 800109715456, u'model': u'LOGICAL VOLUME', u'resource_uri': u'/MAAS/api/2.0/nodes/gdthex/blockdevices/2/', u'uuid': None, u'tags': [u'ssd'], u'type': u'physical', u'partitions': [{u'size': 800101236736, u'uuid': u'c0668f4d-0000-45cf-8c0a-2174b04f5ce2', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'gdthex', u'filesystem': {u'mount_options': None, u'label': None, u'mount_point': None, u'uuid': u'55e53a5a-81bd-415a-8f60-05f4a8f8cc5f', u'fstype': u'lvm-pv'}, u'path': u'/dev/disk/by-dname/sda-part1', u'resource_uri': u'/MAAS/api/2.0/nodes/gdthex/blockdevices/2/partition/7', u'type': u'partition', u'id': 7, u'device_id': 2}], u'used_for': u'MBR partitioned with 1 partition', u'system_id': u'gdthex', u'partition_table_type': u'MBR', u'filesystem': None, u'id_path': u'/dev/disk/by-id/wwn-0x600508b1001cd7e61f5cd3479576479e', u'available_size': 0, u'path': u'/dev/disk/by-dname/sda', u'block_size': 4096, u'used_size': 800106479616, u'id': 2, u'serial': u'600508b1001cd7e61f5cd3479576479e', u'name': u'sda'}], u'netboot': True, u'osystem': u'', u'fqdn': u'cmp001.maas', u'node_type': 0, u'virtualblockdevice_set': [{u'size': 107374182400, u'model': None, u'resource_uri': u'/MAAS/api/2.0/nodes/gdthex/blockdevices/12/', u'uuid': u'33198905-96e1-40d4-94dc-0e00144b18eb', u'tags': [], u'type': u'virtual', u'partitions': [], u'used_for': u'ext4 formatted filesystem mounted at /', u'system_id': u'gdthex', u'partition_table_type': None, u'filesystem': {u'mount_options': None, u'label': u'root', u'mount_point': u'/', u'uuid': u'f3746779-5860-40bd-abbf-192f23214887', u'fstype': u'ext4'}, u'id_path': None, u'available_size': 0, u'path': u'/dev/disk/by-dname/vgroot-lvroot', u'block_size': 4096, u'used_size': 107374182400, u'id': 12, u'serial': None, u'name': u'vgroot-lvroot'}], u'commissioning_status': 2, u'architecture': u'amd64/generic', u'commissioning_status_name': u'Passed', u'interface_set': [{u'name': u'eno1', u'links': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'external_dhcp': None, u'relay_vlan': None, u'primary_rack': u'4tdgas', u'resource_uri': u'/MAAS/api/2.0/vlans/5002/', u'id': 5002, u'secondary_rack': None, u'fabric': u'pxe_admin'}, u'allow_proxy': True, u'rdns_mode': 2, u'gateway_ip': u'192.168.11.3', u'active_discovery': False, u'cidr': u'192.168.11.0/24', u'id': 2, u'resource_uri': u'/MAAS/api/2.0/subnets/2/'}, u'ip_address': u'192.168.11.39', u'id': 26, u'mode': u'dhcp'}], u'tags': [u'sriov'], u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'external_dhcp': None, u'relay_vlan': None, u'primary_rack': u'4tdgas', u'resource_uri': u'/MAAS/api/2.0/vlans/5002/', u'id': 5002, u'secondary_rack': None, u'fabric': u'pxe_admin'}, u'enabled': True, u'children': [], u'discovered': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'external_dhcp': None, u'relay_vlan': None, u'primary_rack': u'4tdgas', u'resource_uri': u'/MAAS/api/2.0/vlans/5002/', u'id': 5002, u'secondary_rack': None, u'fabric': u'pxe_admin'}, u'allow_proxy': True, u'rdns_mode': 2, u'gateway_ip': u'192.168.11.3', u'active_discovery': False, u'cidr': u'192.168.11.0/24', u'id': 2, u'resource_uri': u'/MAAS/api/2.0/subnets/2/'}, u'ip_address': u'192.168.11.39'}], u'mac_address': u'9c:b6:54:8a:95:a0', u'params': u'', u'effective_mtu': 1500, u'parents': [], u'system_id': u'gdthex', u'type': u'physical', u'id': 5, u'resource_uri': u'/MAAS/api/2.0/nodes/gdthex/interfaces/5/'}, {u'name': u'ens1f1', u'links': [], u'tags': [u'sriov'], u'vlan': None, u'enabled': True, u'children': [], u'discovered': None, u'mac_address': u'38:ea:a7:8f:1f:d5', u'params': u'', u'effective_mtu': 1500, u'parents': [], u'system_id': u'gdthex', u'type': u'physical', u'id': 17, u'resource_uri': u'/MAAS/api/2.0/nodes/gdthex/interfaces/17/'}, {u'name': u'ens1f0', u'links': [], u'tags': [u'sriov'], u'vlan': None, u'enabled': True, u'children': [], u'discovered': None, u'mac_address': u'38:ea:a7:8f:1f:d4', u'params': u'', u'effective_mtu': 1500, u'parents': [], u'system_id': u'gdthex', u'type': u'physical', u'id': 18, u'resource_uri': u'/MAAS/api/2.0/nodes/gdthex/interfaces/18/'}, {u'name': u'ens2f1', u'links': [{u'id': 27, u'mode': u'link_up'}], u'tags': [u'sriov'], u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 0, u'dhcp_on': False, u'mtu': 1500, u'external_dhcp': None, u'relay_vlan': None, u'primary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/', u'id': 5001, u'secondary_rack': None, u'fabric': u'fabric-0'}, u'enabled': True, u'children': [], u'discovered': None, u'mac_address': u'38:ea:a7:8f:52:cd', u'params': u'', u'effective_mtu': 1500, u'parents': [], u'system_id': u'gdthex', u'type': u'physical', u'id': 16, u'resource_uri': u'/MAAS/api/2.0/nodes/gdthex/interfaces/16/'}, {u'name': u'ens2f0', u'links': [{u'id': 28, u'mode': u'link_up'}], u'tags': [u'sriov'], u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 0, u'dhcp_on': False, u'mtu': 1500, u'external_dhcp': None, u'relay_vlan': None, u'primary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/', u'id': 5001, u'secondary_rack': None, u'fabric': u'fabric-0'}, u'enabled': True, u'children': [], u'discovered': None, u'mac_address': u'38:ea:a7:8f:52:cc', u'params': u'', u'effective_mtu': 1500, u'parents': [], u'system_id': u'gdthex', u'type': u'physical', u'id': 19, u'resource_uri': u'/MAAS/api/2.0/nodes/gdthex/interfaces/19/'}, {u'name': u'eno2', u'links': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'external_dhcp': None, u'relay_vlan': None, u'primary_rack': u'4tdgas', u'resource_uri': u'/MAAS/api/2.0/vlans/5002/', u'id': 5002, u'secondary_rack': None, u'fabric': u'pxe_admin'}, u'allow_proxy': True, u'rdns_mode': 2, u'gateway_ip': u'192.168.11.3', u'active_discovery': False, u'cidr': u'192.168.11.0/24', u'id': 2, u'resource_uri': u'/MAAS/api/2.0/subnets/2/'}, u'id': 29, u'mode': u'link_up'}], u'tags': [u'sriov'], u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'external_dhcp': None, u'relay_vlan': None, u'primary_rack': u'4tdgas', u'resource_uri': u'/MAAS/api/2.0/vlans/5002/', u'id': 5002, u'secondary_rack': None, u'fabric': u'pxe_admin'}, u'enabled': True, u'children': [], u'discovered': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'external_dhcp': None, u'relay_vlan': None, u'primary_rack': u'4tdgas', u'resource_uri': u'/MAAS/api/2.0/vlans/5002/', u'id': 5002, u'secondary_rack': None, u'fabric': u'pxe_admin'}, u'allow_proxy': True, u'rdns_mode': 2, u'gateway_ip': u'192.168.11.3', u'active_discovery': False, u'cidr': u'192.168.11.0/24', u'id': 2, u'resource_uri': u'/MAAS/api/2.0/subnets/2/'}, u'ip_address': u'192.168.11.42'}], u'mac_address': u'9c:b6:54:8a:95:a4', u'params': u'', u'effective_mtu': 1500, u'parents': [], u'system_id': u'gdthex', u'type': u'physical', u'id': 20, u'resource_uri': u'/MAAS/api/2.0/nodes/gdthex/interfaces/20/'}], u'address_ttl': None, u'other_test_status': -1, u'distro_series': u'', u'memory_test_status': -1}
2020-01-15 23:19:11,884 [salt.state       :300 ][INFO    ][6328] {'new': {'storage_layout': 'lvm'}}
2020-01-15 23:19:11,884 [salt.state       :1951][INFO    ][6328] Completed state [maas_machines_storage_cmp001_lvm] at time 23:19:11.884639 duration_in_ms=2403.946
2020-01-15 23:19:11,889 [salt.minion      :1711][INFO    ][6328] Returning information for job: 20200115231858560111
2020-01-15 23:19:12,624 [salt.minion      :1308][INFO    ][2867] User sudo_ubuntu Executing command state.apply with jid 20200115231912612837
2020-01-15 23:19:12,651 [salt.minion      :1432][INFO    ][6431] Starting a new job with PID 6431
2020-01-15 23:19:13,620 [salt.state       :915 ][INFO    ][6431] Loading fresh modules for state activity
2020-01-15 23:19:13,678 [salt.fileclient  :1219][INFO    ][6431] Fetching file from saltenv 'base', ** done ** 'maas/machines/deploy.sls'
2020-01-15 23:19:13,727 [salt.state       :1780][INFO    ][6431] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 23:19:13.727365
2020-01-15 23:19:13,727 [salt.state       :1813][INFO    ][6431] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2020-01-15 23:19:13,729 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6431] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2020-01-15 23:19:15,663 [salt.state       :300 ][INFO    ][6431] {'pid': 6438, 'retcode': 0, 'stderr': '', 'stdout': ''}
2020-01-15 23:19:15,664 [salt.state       :1951][INFO    ][6431] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 23:19:15.664421 duration_in_ms=1937.057
2020-01-15 23:19:15,667 [salt.state       :1780][INFO    ][6431] Running state [maas.deploy_machines] at time 23:19:15.667896
2020-01-15 23:19:15,668 [salt.state       :1813][INFO    ][6431] Executing state module.run for [maas.deploy_machines]
2020-01-15 23:19:15,669 [salt.utils.decorators:613 ][WARNING ][6431] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-01-15 23:19:16,396 [salt.loaded.ext.module.maas:684 ][INFO    ][6431] deploymachines hwe_kernel=hwe-18.04 system_id=bgpdg3 distro_series=bionic
2020-01-15 23:19:18,911 [salt.loaded.ext.module.maas:684 ][INFO    ][6431] deploymachines hwe_kernel=hwe-18.04 system_id=gdthex distro_series=bionic
2020-01-15 23:19:21,357 [salt.loaded.ext.module.maas:684 ][INFO    ][6431] deploymachines hwe_kernel=hwe-18.04 system_id=qdcnmq distro_series=bionic
2020-01-15 23:19:23,866 [salt.loaded.ext.module.maas:684 ][INFO    ][6431] deploymachines hwe_kernel=hwe-18.04 system_id=aapp8w distro_series=bionic
2020-01-15 23:19:26,454 [salt.loaded.ext.module.maas:684 ][INFO    ][6431] deploymachines hwe_kernel=hwe-18.04 system_id=xf8hwf distro_series=bionic
2020-01-15 23:19:27,696 [salt.minion      :1308][INFO    ][2867] User sudo_ubuntu Executing command saltutil.find_job with jid 20200115231927683323
2020-01-15 23:19:27,722 [salt.minion      :1432][INFO    ][6694] Starting a new job with PID 6694
2020-01-15 23:19:27,755 [salt.minion      :1711][INFO    ][6694] Returning information for job: 20200115231927683323
2020-01-15 23:19:28,935 [salt.state       :300 ][INFO    ][6431] {'ret': {'updated': [], 'errors': {}, 'success': ['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']}}
2020-01-15 23:19:28,935 [salt.state       :1951][INFO    ][6431] Completed state [maas.deploy_machines] at time 23:19:28.935441 duration_in_ms=13267.544
2020-01-15 23:19:28,940 [salt.minion      :1711][INFO    ][6431] Returning information for job: 20200115231912612837
2020-01-15 23:19:29,636 [salt.minion      :1308][INFO    ][2867] User sudo_ubuntu Executing command state.apply with jid 20200115231929625697
2020-01-15 23:19:29,662 [salt.minion      :1432][INFO    ][6718] Starting a new job with PID 6718
2020-01-15 23:19:35,925 [salt.state       :915 ][INFO    ][6718] Loading fresh modules for state activity
2020-01-15 23:19:35,983 [salt.fileclient  :1219][INFO    ][6718] Fetching file from saltenv 'base', ** done ** 'maas/machines/wait_for_deployed.sls'
2020-01-15 23:19:36,027 [salt.state       :1780][INFO    ][6718] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 23:19:36.027380
2020-01-15 23:19:36,027 [salt.state       :1813][INFO    ][6718] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2020-01-15 23:19:36,029 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6718] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2020-01-15 23:19:37,999 [salt.state       :300 ][INFO    ][6718] {'pid': 6736, 'retcode': 0, 'stderr': '', 'stdout': ''}
2020-01-15 23:19:38,000 [salt.state       :1951][INFO    ][6718] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 23:19:38.000107 duration_in_ms=1972.726
2020-01-15 23:19:38,004 [salt.state       :1780][INFO    ][6718] Running state [maas.wait_for_machine_status] at time 23:19:38.004332
2020-01-15 23:19:38,004 [salt.state       :1813][INFO    ][6718] Executing state module.run for [maas.wait_for_machine_status]
2020-01-15 23:19:38,005 [salt.utils.decorators:613 ][WARNING ][6718] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-01-15 23:19:40,799 [salt.loaded.ext.module.maas:1023][INFO    ][6718] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2247.21915507s left)
2020-01-15 23:19:44,664 [salt.minion      :1308][INFO    ][2867] User sudo_ubuntu Executing command saltutil.find_job with jid 20200115231944649987
2020-01-15 23:19:44,691 [salt.minion      :1432][INFO    ][6747] Starting a new job with PID 6747
2020-01-15 23:19:44,722 [salt.minion      :1711][INFO    ][6747] Returning information for job: 20200115231944649987
2020-01-15 23:20:13,782 [salt.loaded.ext.module.maas:1023][INFO    ][6718] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2214.23569798s left)
2020-01-15 23:20:14,775 [salt.minion      :1308][INFO    ][2867] User sudo_ubuntu Executing command saltutil.find_job with jid 20200115232014760743
2020-01-15 23:20:14,804 [salt.minion      :1432][INFO    ][6822] Starting a new job with PID 6822
2020-01-15 23:20:14,835 [salt.minion      :1711][INFO    ][6822] Returning information for job: 20200115232014760743
2020-01-15 23:20:44,857 [salt.minion      :1308][INFO    ][2867] User sudo_ubuntu Executing command saltutil.find_job with jid 20200115232044849990
2020-01-15 23:20:44,877 [salt.minion      :1432][INFO    ][6844] Starting a new job with PID 6844
2020-01-15 23:20:44,903 [salt.minion      :1711][INFO    ][6844] Returning information for job: 20200115232044849990
2020-01-15 23:20:46,651 [salt.loaded.ext.module.maas:1023][INFO    ][6718] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2181.36717606s left)
2020-01-15 23:21:14,928 [salt.minion      :1308][INFO    ][2867] User sudo_ubuntu Executing command saltutil.find_job with jid 20200115232114918525
2020-01-15 23:21:14,954 [salt.minion      :1432][INFO    ][6894] Starting a new job with PID 6894
2020-01-15 23:21:14,986 [salt.minion      :1711][INFO    ][6894] Returning information for job: 20200115232114918525
2020-01-15 23:21:19,498 [salt.loaded.ext.module.maas:1023][INFO    ][6718] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2148.51993513s left)
2020-01-15 23:21:45,027 [salt.minion      :1308][INFO    ][2867] User sudo_ubuntu Executing command saltutil.find_job with jid 20200115232145008296
2020-01-15 23:21:45,057 [salt.minion      :1432][INFO    ][6914] Starting a new job with PID 6914
2020-01-15 23:21:45,094 [salt.minion      :1711][INFO    ][6914] Returning information for job: 20200115232145008296
2020-01-15 23:21:52,286 [salt.loaded.ext.module.maas:1023][INFO    ][6718] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2115.73193216s left)
2020-01-15 23:22:15,144 [salt.minion      :1308][INFO    ][2867] User sudo_ubuntu Executing command saltutil.find_job with jid 20200115232215127935
2020-01-15 23:22:15,169 [salt.minion      :1432][INFO    ][7003] Starting a new job with PID 7003
2020-01-15 23:22:15,207 [salt.minion      :1711][INFO    ][7003] Returning information for job: 20200115232215127935
2020-01-15 23:22:25,193 [salt.loaded.ext.module.maas:1023][INFO    ][6718] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2082.82550001s left)
2020-01-15 23:22:45,262 [salt.minion      :1308][INFO    ][2867] User sudo_ubuntu Executing command saltutil.find_job with jid 20200115232245246302
2020-01-15 23:22:45,292 [salt.minion      :1432][INFO    ][7064] Starting a new job with PID 7064
2020-01-15 23:22:45,327 [salt.minion      :1711][INFO    ][7064] Returning information for job: 20200115232245246302
2020-01-15 23:22:58,120 [salt.loaded.ext.module.maas:1023][INFO    ][6718] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2049.89770103s left)
2020-01-15 23:23:15,407 [salt.minion      :1308][INFO    ][2867] User sudo_ubuntu Executing command saltutil.find_job with jid 20200115232315397150
2020-01-15 23:23:15,436 [salt.minion      :1432][INFO    ][7416] Starting a new job with PID 7416
2020-01-15 23:23:15,467 [salt.minion      :1711][INFO    ][7416] Returning information for job: 20200115232315397150
2020-01-15 23:23:31,034 [salt.loaded.ext.module.maas:1023][INFO    ][6718] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2016.98394918s left)
2020-01-15 23:23:45,526 [salt.minion      :1308][INFO    ][2867] User sudo_ubuntu Executing command saltutil.find_job with jid 20200115232345516106
2020-01-15 23:23:45,550 [salt.minion      :1432][INFO    ][7494] Starting a new job with PID 7494
2020-01-15 23:23:45,584 [salt.minion      :1711][INFO    ][7494] Returning information for job: 20200115232345516106
2020-01-15 23:24:04,095 [salt.loaded.ext.module.maas:1023][INFO    ][6718] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1983.92305207s left)
2020-01-15 23:24:15,661 [salt.minion      :1308][INFO    ][2867] User sudo_ubuntu Executing command saltutil.find_job with jid 20200115232415640788
2020-01-15 23:24:15,681 [salt.minion      :1432][INFO    ][7646] Starting a new job with PID 7646
2020-01-15 23:24:15,718 [salt.minion      :1711][INFO    ][7646] Returning information for job: 20200115232415640788
2020-01-15 23:24:37,123 [salt.loaded.ext.module.maas:1023][INFO    ][6718] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1950.89459109s left)
2020-01-15 23:24:45,807 [salt.minion      :1308][INFO    ][2867] User sudo_ubuntu Executing command saltutil.find_job with jid 20200115232445782782
2020-01-15 23:24:45,843 [salt.minion      :1432][INFO    ][7783] Starting a new job with PID 7783
2020-01-15 23:24:45,885 [salt.minion      :1711][INFO    ][7783] Returning information for job: 20200115232445782782
2020-01-15 23:25:10,177 [salt.loaded.ext.module.maas:1023][INFO    ][6718] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1917.84109402s left)
2020-01-15 23:25:16,029 [salt.minion      :1308][INFO    ][2867] User sudo_ubuntu Executing command saltutil.find_job with jid 20200115232516016563
2020-01-15 23:25:16,056 [salt.minion      :1432][INFO    ][8269] Starting a new job with PID 8269
2020-01-15 23:25:16,096 [salt.minion      :1711][INFO    ][8269] Returning information for job: 20200115232516016563
2020-01-15 23:25:43,076 [salt.loaded.ext.module.maas:1023][INFO    ][6718] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1884.94200897s left)
2020-01-15 23:25:46,172 [salt.minion      :1308][INFO    ][2867] User sudo_ubuntu Executing command saltutil.find_job with jid 20200115232546157712
2020-01-15 23:25:46,195 [salt.minion      :1432][INFO    ][8312] Starting a new job with PID 8312
2020-01-15 23:25:46,226 [salt.minion      :1711][INFO    ][8312] Returning information for job: 20200115232546157712
2020-01-15 23:26:15,964 [salt.loaded.ext.module.maas:1023][INFO    ][6718] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1852.05399108s left)
2020-01-15 23:26:16,331 [salt.minion      :1308][INFO    ][2867] User sudo_ubuntu Executing command saltutil.find_job with jid 20200115232616316666
2020-01-15 23:26:16,361 [salt.minion      :1432][INFO    ][8621] Starting a new job with PID 8621
2020-01-15 23:26:16,391 [salt.minion      :1711][INFO    ][8621] Returning information for job: 20200115232616316666
2020-01-15 23:26:46,495 [salt.minion      :1308][INFO    ][2867] User sudo_ubuntu Executing command saltutil.find_job with jid 20200115232646484536
2020-01-15 23:26:46,520 [salt.minion      :1432][INFO    ][8654] Starting a new job with PID 8654
2020-01-15 23:26:46,551 [salt.minion      :1711][INFO    ][8654] Returning information for job: 20200115232646484536
2020-01-15 23:26:49,119 [salt.loaded.ext.module.maas:1023][INFO    ][6718] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1818.89950609s left)
2020-01-15 23:27:16,691 [salt.minion      :1308][INFO    ][2867] User sudo_ubuntu Executing command saltutil.find_job with jid 20200115232716678818
2020-01-15 23:27:16,716 [salt.minion      :1432][INFO    ][8901] Starting a new job with PID 8901
2020-01-15 23:27:16,744 [salt.minion      :1711][INFO    ][8901] Returning information for job: 20200115232716678818
2020-01-15 23:27:21,920 [salt.loaded.ext.module.maas:1023][INFO    ][6718] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1786.09853101s left)
2020-01-15 23:27:46,834 [salt.minion      :1308][INFO    ][2867] User sudo_ubuntu Executing command saltutil.find_job with jid 20200115232746819326
2020-01-15 23:27:46,861 [salt.minion      :1432][INFO    ][8939] Starting a new job with PID 8939
2020-01-15 23:27:46,895 [salt.minion      :1711][INFO    ][8939] Returning information for job: 20200115232746819326
2020-01-15 23:27:54,994 [salt.loaded.ext.module.maas:1023][INFO    ][6718] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1753.02367115s left)
2020-01-15 23:28:17,037 [salt.minion      :1308][INFO    ][2867] User sudo_ubuntu Executing command saltutil.find_job with jid 20200115232817025435
2020-01-15 23:28:17,066 [salt.minion      :1432][INFO    ][9230] Starting a new job with PID 9230
2020-01-15 23:28:17,112 [salt.minion      :1711][INFO    ][9230] Returning information for job: 20200115232817025435
2020-01-15 23:28:27,766 [salt.loaded.ext.module.maas:1023][INFO    ][6718] Waiting status:Deployed for machines:['cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1720.25203609s left)
2020-01-15 23:28:47,171 [salt.minion      :1308][INFO    ][2867] User sudo_ubuntu Executing command saltutil.find_job with jid 20200115232847154410
2020-01-15 23:28:47,194 [salt.minion      :1432][INFO    ][9274] Starting a new job with PID 9274
2020-01-15 23:28:47,224 [salt.minion      :1711][INFO    ][9274] Returning information for job: 20200115232847154410
2020-01-15 23:29:00,612 [salt.loaded.ext.module.maas:1023][INFO    ][6718] Waiting status:Deployed for machines:['kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1687.40651608s left)
2020-01-15 23:29:17,337 [salt.minion      :1308][INFO    ][2867] User sudo_ubuntu Executing command saltutil.find_job with jid 20200115232917323488
2020-01-15 23:29:17,361 [salt.minion      :1432][INFO    ][9512] Starting a new job with PID 9512
2020-01-15 23:29:17,398 [salt.minion      :1711][INFO    ][9512] Returning information for job: 20200115232917323488
2020-01-15 23:29:33,778 [salt.loaded.ext.module.maas:1023][INFO    ][6718] Waiting status:Deployed for machines:['kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1654.23993397s left)
2020-01-15 23:29:47,523 [salt.minion      :1308][INFO    ][2867] User sudo_ubuntu Executing command saltutil.find_job with jid 20200115232947508655
2020-01-15 23:29:47,547 [salt.minion      :1432][INFO    ][9676] Starting a new job with PID 9676
2020-01-15 23:29:47,576 [salt.minion      :1711][INFO    ][9676] Returning information for job: 20200115232947508655
2020-01-15 23:30:06,613 [salt.loaded.ext.module.maas:1023][INFO    ][6718] Waiting status:Deployed for machines:['kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1621.40549016s left)
2020-01-15 23:30:17,730 [salt.minion      :1308][INFO    ][2867] User sudo_ubuntu Executing command saltutil.find_job with jid 20200115233017714279
2020-01-15 23:30:17,753 [salt.minion      :1432][INFO    ][9818] Starting a new job with PID 9818
2020-01-15 23:30:17,785 [salt.minion      :1711][INFO    ][9818] Returning information for job: 20200115233017714279
2020-01-15 23:30:39,579 [salt.loaded.ext.module.maas:1023][INFO    ][6718] Waiting status:Deployed for machines:['kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1588.4387002s left)
2020-01-15 23:30:47,923 [salt.minion      :1308][INFO    ][2867] User sudo_ubuntu Executing command saltutil.find_job with jid 20200115233047907030
2020-01-15 23:30:47,947 [salt.minion      :1432][INFO    ][9853] Starting a new job with PID 9853
2020-01-15 23:30:47,977 [salt.minion      :1711][INFO    ][9853] Returning information for job: 20200115233047907030
2020-01-15 23:31:12,597 [salt.loaded.ext.module.maas:1023][INFO    ][6718] Waiting status:Deployed for machines:['kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1555.42074609s left)
2020-01-15 23:31:18,134 [salt.minion      :1308][INFO    ][2867] User sudo_ubuntu Executing command saltutil.find_job with jid 20200115233118119905
2020-01-15 23:31:18,164 [salt.minion      :1432][INFO    ][9918] Starting a new job with PID 9918
2020-01-15 23:31:18,192 [salt.minion      :1711][INFO    ][9918] Returning information for job: 20200115233118119905
2020-01-15 23:31:45,398 [salt.loaded.ext.module.maas:1023][INFO    ][6718] Waiting status:Deployed for machines:['kvm01', 'kvm03']
sleep for:30s Timeout:2250s (1522.62051105s left)
2020-01-15 23:31:48,312 [salt.minion      :1308][INFO    ][2867] User sudo_ubuntu Executing command saltutil.find_job with jid 20200115233148296082
2020-01-15 23:31:48,336 [salt.minion      :1432][INFO    ][10016] Starting a new job with PID 10016
2020-01-15 23:31:48,365 [salt.minion      :1711][INFO    ][10016] Returning information for job: 20200115233148296082
2020-01-15 23:32:18,516 [salt.minion      :1308][INFO    ][2867] User sudo_ubuntu Executing command saltutil.find_job with jid 20200115233218507321
2020-01-15 23:32:18,540 [salt.minion      :1432][INFO    ][10322] Starting a new job with PID 10322
2020-01-15 23:32:18,571 [salt.minion      :1711][INFO    ][10322] Returning information for job: 20200115233218507321
2020-01-15 23:32:18,794 [salt.state       :300 ][INFO    ][6718] {'ret': True}
2020-01-15 23:32:18,795 [salt.state       :1951][INFO    ][6718] Completed state [maas.wait_for_machine_status] at time 23:32:18.795310 duration_in_ms=760790.975
2020-01-15 23:32:18,805 [salt.minion      :1711][INFO    ][6718] Returning information for job: 20200115231929625697
2020-01-16 00:09:53,212 [salt.utils.schedule:1377][INFO    ][2867] Running scheduled job: __mine_interval
2020-01-16 01:09:53,212 [salt.utils.schedule:1377][INFO    ][2867] Running scheduled job: __mine_interval
2020-01-16 01:13:09,423 [salt.minion      :1308][INFO    ][2867] User sudo_ubuntu Executing command cp.push_dir with jid 20200116011309414224
2020-01-16 01:13:09,449 [salt.minion      :1432][INFO    ][17452] Starting a new job with PID 17452
