2019-06-14 14:51:46,415 [salt.minion      :870 ][ERROR   ][387] Error while bringing up minion for multi-master. Is master at 10.20.0.2 responding?
2019-06-14 14:53:14,218 [salt.utils.decorators:613 ][WARNING ][2169] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-06-14 14:53:15,384 [salt.utils.decorators:613 ][WARNING ][2169] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-06-14 14:53:19,176 [salt.loaded.int.states.file:2298][WARNING ][2417] State for file: /etc/maas/rackd.conf - Neither 'source' nor 'contents' nor 'contents_pillar' nor 'contents_grains' was defined, yet 'replace' was set to 'True'. As there is no source to replace the file with, 'replace' has been set to 'False' to avoid reading the file unnecessarily.
2019-06-14 14:53:31,045 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2677] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2019-06-14 14:53:31,083 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2677] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2019-06-14 14:53:31,128 [salt.utils.parsers:1051][WARNING ][387] Minion received a SIGTERM. Exiting.
2019-06-14 14:53:32,245 [salt.cli.daemons :293 ][INFO    ][2792] Setting up the Salt Minion "mas01.mcp-ovs-dpdk-ha.local"
2019-06-14 14:53:32,414 [salt.cli.daemons :82  ][INFO    ][2792] Starting up the Salt Minion
2019-06-14 14:53:32,415 [salt.utils.event :1017][INFO    ][2792] Starting pull socket on /var/run/salt/minion/minion_event_967fbee23e_pull.ipc
2019-06-14 14:53:33,703 [salt.minion      :976 ][INFO    ][2792] Creating minion process manager
2019-06-14 14:53:35,928 [salt.loader.10.20.0.2.int.module.cmdmod:395 ][INFO    ][2792] Executing command ['date', '+%z'] in directory '/root'
2019-06-14 14:53:35,952 [salt.utils.schedule:568 ][INFO    ][2792] Updating job settings for scheduled job: __mine_interval
2019-06-14 14:53:35,956 [salt.minion      :1108][INFO    ][2792] Added mine.update to scheduler
2019-06-14 14:53:35,961 [salt.minion      :1975][INFO    ][2792] Minion is starting as user 'root'
2019-06-14 14:53:35,974 [salt.minion      :2336][INFO    ][2792] Minion is ready to receive requests!
2019-06-14 14:53:42,355 [salt.state       :2022][WARNING ][2681] State is set to retry, but a valid dict for retry configuration was not found.  Using retry defaults
2019-06-14 14:53:43,557 [salt.minion      :1308][INFO    ][2792] User sudo_ubuntu Executing command saltutil.find_job with jid 20190614145343547971
2019-06-14 14:53:43,582 [salt.minion      :1432][INFO    ][3034] Starting a new job with PID 3034
2019-06-14 14:53:43,619 [salt.minion      :1711][INFO    ][3034] Returning information for job: 20190614145343547971
2019-06-14 14:53:45,594 [salt.utils.decorators:613 ][WARNING ][2681] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-06-14 14:53:57,308 [salt.utils.decorators:613 ][WARNING ][2681] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-06-14 14:54:13,731 [salt.minion      :1308][INFO    ][2792] User sudo_ubuntu Executing command saltutil.find_job with jid 20190614145413714518
2019-06-14 14:54:13,756 [salt.minion      :1432][INFO    ][3834] Starting a new job with PID 3834
2019-06-14 14:54:13,787 [salt.minion      :1711][INFO    ][3834] Returning information for job: 20190614145413714518
2019-06-14 14:54:24,393 [salt.utils.decorators:613 ][WARNING ][2681] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-06-14 14:54:25,502 [salt.utils.decorators:613 ][WARNING ][2681] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-06-14 14:54:27,886 [salt.loaded.ext.module.maasng:1008][WARNING ][2681] Detected cidr:192.168.11.0/24 in fabric:fabric-2
2019-06-14 14:54:27,887 [salt.loaded.ext.module.maasng:1011][WARNING ][2681] Guessing, that fabric with current name:fabric-2
 should be renamed to:pxe_admin
2019-06-14 14:54:28,672 [salt.loaded.ext.module.maasng:1235][WARNING ][2681] Ignoring parameter vlan:0
2019-06-14 14:54:29,657 [salt.utils.decorators:613 ][WARNING ][2681] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-06-14 14:54:30,667 [salt.minion      :1308][INFO    ][2792] User sudo_ubuntu Executing command state.apply with jid 20190614145430652625
2019-06-14 14:54:30,683 [salt.minion      :1432][INFO    ][4233] Starting a new job with PID 4233
2019-06-14 14:54:39,093 [salt.state       :915 ][INFO    ][4233] Loading fresh modules for state activity
2019-06-14 14:54:39,169 [salt.fileclient  :1219][INFO    ][4233] Fetching file from saltenv 'base', ** done ** 'maas/machines/init.sls'
2019-06-14 14:54:39,231 [salt.state       :1780][INFO    ][4233] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 14:54:39.231641
2019-06-14 14:54:39,232 [salt.state       :1813][INFO    ][4233] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2019-06-14 14:54:39,234 [salt.loaded.int.module.cmdmod:395 ][INFO    ][4233] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2019-06-14 14:54:41,129 [salt.state       :300 ][INFO    ][4233] {'pid': 4262, 'retcode': 0, 'stderr': '', 'stdout': ''}
2019-06-14 14:54:41,131 [salt.state       :1951][INFO    ][4233] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 14:54:41.130953 duration_in_ms=1899.311
2019-06-14 14:54:41,134 [salt.state       :1780][INFO    ][4233] Running state [maas.process_machines] at time 14:54:41.134316
2019-06-14 14:54:41,135 [salt.state       :1813][INFO    ][4233] Executing state module.run for [maas.process_machines]
2019-06-14 14:54:41,136 [salt.utils.decorators:613 ][WARNING ][4233] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-06-14 14:54:41,202 [salt.loaded.ext.module.maas:412 ][WARNING ][4233] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2019-06-14 14:54:41,203 [salt.loaded.ext.module.maas:92  ][INFO    ][4233] machine hostname=cmp002 power_type=ipmi mac_addresses=9c:b6:54:8a:10:18 power_parameters_power_address=172.16.1.20 power_parameters_power_pass=Winter2017 architecture=amd64/generic power_parameters_power_user=opnfv
2019-06-14 14:54:42,780 [salt.loaded.ext.module.maas:412 ][WARNING ][4233] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2019-06-14 14:54:42,781 [salt.loaded.ext.module.maas:92  ][INFO    ][4233] machine hostname=cmp001 power_type=ipmi mac_addresses=9c:b6:54:8a:95:a0 power_parameters_power_address=172.16.1.19 power_parameters_power_pass=Winter2017 architecture=amd64/generic power_parameters_power_user=opnfv
2019-06-14 14:54:44,106 [salt.loaded.ext.module.maas:412 ][WARNING ][4233] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2019-06-14 14:54:44,107 [salt.loaded.ext.module.maas:92  ][INFO    ][4233] 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
2019-06-14 14:54:45,536 [salt.loaded.ext.module.maas:412 ][WARNING ][4233] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2019-06-14 14:54:45,537 [salt.loaded.ext.module.maas:92  ][INFO    ][4233] 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
2019-06-14 14:54:45,740 [salt.minion      :1308][INFO    ][2792] User sudo_ubuntu Executing command saltutil.find_job with jid 20190614145445729116
2019-06-14 14:54:45,762 [salt.minion      :1432][INFO    ][4445] Starting a new job with PID 4445
2019-06-14 14:54:45,792 [salt.minion      :1711][INFO    ][4445] Returning information for job: 20190614145445729116
2019-06-14 14:54:46,854 [salt.loaded.ext.module.maas:412 ][WARNING ][4233] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2019-06-14 14:54:46,855 [salt.loaded.ext.module.maas:92  ][INFO    ][4233] 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
2019-06-14 14:54:48,334 [salt.state       :300 ][INFO    ][4233] {'ret': {'updated': [], 'errors': {}, 'success': ['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']}}
2019-06-14 14:54:48,336 [salt.state       :1951][INFO    ][4233] Completed state [maas.process_machines] at time 14:54:48.336458 duration_in_ms=7202.154
2019-06-14 14:54:48,343 [salt.minion      :1711][INFO    ][4233] Returning information for job: 20190614145430652625
2019-06-14 14:55:19,724 [salt.minion      :1308][INFO    ][2792] User sudo_ubuntu Executing command state.apply with jid 20190614145519709797
2019-06-14 14:55:19,752 [salt.minion      :1432][INFO    ][4592] Starting a new job with PID 4592
2019-06-14 14:55:27,885 [salt.state       :915 ][INFO    ][4592] Loading fresh modules for state activity
2019-06-14 14:55:27,952 [salt.fileclient  :1219][INFO    ][4592] Fetching file from saltenv 'base', ** done ** 'maas/machines/wait_for_ready_or_deployed.sls'
2019-06-14 14:55:28,011 [salt.state       :1780][INFO    ][4592] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 14:55:28.011098
2019-06-14 14:55:28,011 [salt.state       :1813][INFO    ][4592] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2019-06-14 14:55:28,013 [salt.loaded.int.module.cmdmod:395 ][INFO    ][4592] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2019-06-14 14:55:29,918 [salt.state       :300 ][INFO    ][4592] {'pid': 4599, 'retcode': 0, 'stderr': '', 'stdout': ''}
2019-06-14 14:55:29,919 [salt.state       :1951][INFO    ][4592] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 14:55:29.919054 duration_in_ms=1907.956
2019-06-14 14:55:29,922 [salt.state       :1780][INFO    ][4592] Running state [maas.wait_for_machine_status] at time 14:55:29.922862
2019-06-14 14:55:29,923 [salt.state       :1813][INFO    ][4592] Executing state module.run for [maas.wait_for_machine_status]
2019-06-14 14:55:29,924 [salt.utils.decorators:613 ][WARNING ][4592] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-06-14 14:55:30,767 [salt.loaded.ext.module.maas:1023][INFO    ][4592] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1499.17141581s left)
2019-06-14 14:55:34,749 [salt.minion      :1308][INFO    ][2792] User sudo_ubuntu Executing command saltutil.find_job with jid 20190614145534737618
2019-06-14 14:55:34,776 [salt.minion      :1432][INFO    ][4621] Starting a new job with PID 4621
2019-06-14 14:55:34,814 [salt.minion      :1711][INFO    ][4621] Returning information for job: 20190614145534737618
2019-06-14 14:56:01,703 [salt.loaded.ext.module.maas:1023][INFO    ][4592] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1468.23551083s left)
2019-06-14 14:56:04,849 [salt.minion      :1308][INFO    ][2792] User sudo_ubuntu Executing command saltutil.find_job with jid 20190614145604833917
2019-06-14 14:56:04,880 [salt.minion      :1432][INFO    ][4666] Starting a new job with PID 4666
2019-06-14 14:56:04,909 [salt.minion      :1711][INFO    ][4666] Returning information for job: 20190614145604833917
2019-06-14 14:56:32,425 [salt.loaded.ext.module.maas:1023][INFO    ][4592] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1437.51384902s left)
2019-06-14 14:56:34,949 [salt.minion      :1308][INFO    ][2792] User sudo_ubuntu Executing command saltutil.find_job with jid 20190614145634936640
2019-06-14 14:56:34,967 [salt.minion      :1432][INFO    ][4696] Starting a new job with PID 4696
2019-06-14 14:56:34,999 [salt.minion      :1711][INFO    ][4696] Returning information for job: 20190614145634936640
2019-06-14 14:57:03,208 [salt.loaded.ext.module.maas:1023][INFO    ][4592] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1406.73120689s left)
2019-06-14 14:57:04,987 [salt.minion      :1308][INFO    ][2792] User sudo_ubuntu Executing command saltutil.find_job with jid 20190614145704972645
2019-06-14 14:57:05,015 [salt.minion      :1432][INFO    ][4744] Starting a new job with PID 4744
2019-06-14 14:57:05,045 [salt.minion      :1711][INFO    ][4744] Returning information for job: 20190614145704972645
2019-06-14 14:57:34,297 [salt.loaded.ext.module.maas:1023][INFO    ][4592] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1375.641716s left)
2019-06-14 14:57:35,083 [salt.minion      :1308][INFO    ][2792] User sudo_ubuntu Executing command saltutil.find_job with jid 20190614145735072792
2019-06-14 14:57:35,107 [salt.minion      :1432][INFO    ][4806] Starting a new job with PID 4806
2019-06-14 14:57:35,136 [salt.minion      :1711][INFO    ][4806] Returning information for job: 20190614145735072792
2019-06-14 14:58:05,191 [salt.minion      :1308][INFO    ][2792] User sudo_ubuntu Executing command saltutil.find_job with jid 20190614145805176394
2019-06-14 14:58:05,212 [salt.minion      :1432][INFO    ][4964] Starting a new job with PID 4964
2019-06-14 14:58:05,244 [salt.minion      :1711][INFO    ][4964] Returning information for job: 20190614145805176394
2019-06-14 14:58:05,460 [salt.loaded.ext.module.maas:1023][INFO    ][4592] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1344.47876883s left)
2019-06-14 14:58:35,316 [salt.minion      :1308][INFO    ][2792] User sudo_ubuntu Executing command saltutil.find_job with jid 20190614145835303032
2019-06-14 14:58:35,346 [salt.minion      :1432][INFO    ][5040] Starting a new job with PID 5040
2019-06-14 14:58:35,378 [salt.minion      :1711][INFO    ][5040] Returning information for job: 20190614145835303032
2019-06-14 14:58:36,621 [salt.loaded.ext.module.maas:1023][INFO    ][4592] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1313.31784487s left)
2019-06-14 14:59:05,432 [salt.minion      :1308][INFO    ][2792] User sudo_ubuntu Executing command saltutil.find_job with jid 20190614145905421659
2019-06-14 14:59:05,447 [salt.minion      :1432][INFO    ][5383] Starting a new job with PID 5383
2019-06-14 14:59:05,478 [salt.minion      :1711][INFO    ][5383] Returning information for job: 20190614145905421659
2019-06-14 14:59:07,783 [salt.loaded.ext.module.maas:1023][INFO    ][4592] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1282.15545797s left)
2019-06-14 14:59:35,503 [salt.minion      :1308][INFO    ][2792] User sudo_ubuntu Executing command saltutil.find_job with jid 20190614145935489283
2019-06-14 14:59:35,529 [salt.minion      :1432][INFO    ][5472] Starting a new job with PID 5472
2019-06-14 14:59:35,563 [salt.minion      :1711][INFO    ][5472] Returning information for job: 20190614145935489283
2019-06-14 14:59:39,642 [salt.loaded.ext.module.maas:1023][INFO    ][4592] Waiting status:Ready|Deployed for machines:['cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1250.29661679s left)
2019-06-14 15:00:05,683 [salt.minion      :1308][INFO    ][2792] User sudo_ubuntu Executing command saltutil.find_job with jid 20190614150005664148
2019-06-14 15:00:05,710 [salt.minion      :1432][INFO    ][5773] Starting a new job with PID 5773
2019-06-14 15:00:05,746 [salt.minion      :1711][INFO    ][5773] Returning information for job: 20190614150005664148
2019-06-14 15:00:11,677 [salt.loaded.ext.module.maas:1023][INFO    ][4592] Waiting status:Ready|Deployed for machines:['kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1218.26220489s left)
2019-06-14 15:00:35,814 [salt.minion      :1308][INFO    ][2792] User sudo_ubuntu Executing command saltutil.find_job with jid 20190614150035800932
2019-06-14 15:00:35,839 [salt.minion      :1432][INFO    ][5919] Starting a new job with PID 5919
2019-06-14 15:00:35,873 [salt.minion      :1711][INFO    ][5919] Returning information for job: 20190614150035800932
2019-06-14 15:00:44,074 [salt.loaded.ext.module.maas:1023][INFO    ][4592] Waiting status:Ready|Deployed for machines:['kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1185.8647089s left)
2019-06-14 15:01:05,972 [salt.minion      :1308][INFO    ][2792] User sudo_ubuntu Executing command saltutil.find_job with jid 20190614150105958804
2019-06-14 15:01:06,003 [salt.minion      :1432][INFO    ][6160] Starting a new job with PID 6160
2019-06-14 15:01:06,032 [salt.minion      :1711][INFO    ][6160] Returning information for job: 20190614150105958804
2019-06-14 15:01:16,180 [salt.loaded.ext.module.maas:1023][INFO    ][4592] Waiting status:Ready|Deployed for machines:['kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1153.7589879s left)
2019-06-14 15:01:36,112 [salt.minion      :1308][INFO    ][2792] User sudo_ubuntu Executing command saltutil.find_job with jid 20190614150136097193
2019-06-14 15:01:36,139 [salt.minion      :1432][INFO    ][6310] Starting a new job with PID 6310
2019-06-14 15:01:36,171 [salt.minion      :1711][INFO    ][6310] Returning information for job: 20190614150136097193
2019-06-14 15:01:49,308 [salt.state       :300 ][INFO    ][4592] {'ret': True}
2019-06-14 15:01:49,309 [salt.state       :1951][INFO    ][4592] Completed state [maas.wait_for_machine_status] at time 15:01:49.309109 duration_in_ms=379386.246
2019-06-14 15:01:49,314 [salt.minion      :1711][INFO    ][4592] Returning information for job: 20190614145519709797
2019-06-14 15:01:50,065 [salt.minion      :1308][INFO    ][2792] User sudo_ubuntu Executing command state.apply with jid 20190614150150051457
2019-06-14 15:01:50,093 [salt.minion      :1432][INFO    ][6415] Starting a new job with PID 6415
2019-06-14 15:01:58,428 [salt.state       :915 ][INFO    ][6415] Loading fresh modules for state activity
2019-06-14 15:01:58,488 [salt.fileclient  :1219][INFO    ][6415] Fetching file from saltenv 'base', ** done ** 'maas/machines/storage.sls'
2019-06-14 15:01:58,590 [salt.state       :1780][INFO    ][6415] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 15:01:58.590538
2019-06-14 15:01:58,590 [salt.state       :1813][INFO    ][6415] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2019-06-14 15:01:58,592 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6415] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2019-06-14 15:02:00,561 [salt.state       :300 ][INFO    ][6415] {'pid': 6441, 'retcode': 0, 'stderr': '', 'stdout': ''}
2019-06-14 15:02:00,563 [salt.state       :1951][INFO    ][6415] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 15:02:00.563310 duration_in_ms=1972.771
2019-06-14 15:02:00,567 [salt.state       :1780][INFO    ][6415] Running state [maas_machines_storage_cmp002_lvm] at time 15:02:00.567905
2019-06-14 15:02:00,568 [salt.state       :1813][INFO    ][6415] Executing state maasng.disk_layout_present for [maas_machines_storage_cmp002_lvm]
2019-06-14 15:02:01,834 [salt.loaded.ext.module.maasng:610 ][INFO    ][6415] gd3bgx
2019-06-14 15:02:01,834 [salt.loaded.ext.module.maasng:626 ][INFO    ][6415] sda
2019-06-14 15:02:02,429 [salt.loaded.ext.module.maasng:361 ][INFO    ][6415] gd3bgx
2019-06-14 15:02:02,532 [salt.loaded.ext.module.maasng:367 ][INFO    ][6415] [{u'size': 800109715456, u'resource_uri': u'/MAAS/api/2.0/nodes/gd3bgx/blockdevices/1/', u'name': u'sda', u'tags': [u'ssd'], u'used_for': u'MBR partitioned with 1 partition', u'type': u'physical', u'partitions': [{u'uuid': u'a459afc5-5bfa-471d-b935-6ccb6b8a7983', u'resource_uri': u'/MAAS/api/2.0/nodes/gd3bgx/blockdevices/1/partition/1', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'gd3bgx', u'filesystem': {u'uuid': u'a85dea92-adaa-4c12-b1d7-7168b5ed4377', 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'size': 800101236736, u'type': u'partition', u'id': 1, u'device_id': 1}], u'filesystem': None, u'id': 1, u'system_id': u'gd3bgx', 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'serial': u'600508b1001cb19198eb9a66f8a29401', u'block_size': 4096, u'used_size': 800106479616, u'model': u'LOGICAL VOLUME', u'uuid': None}, {u'size': 800097042432, u'resource_uri': u'/MAAS/api/2.0/nodes/gd3bgx/blockdevices/3/', u'name': u'vgroot-lvroot', u'tags': [], u'used_for': u'ext4 formatted filesystem mounted at /', u'type': u'virtual', u'partitions': [], u'filesystem': {u'uuid': u'778a35cc-be89-4ab9-a16f-0461be55498a', u'label': u'root', u'mount_point': u'/', u'mount_options': None, u'fstype': u'ext4'}, u'id': 3, u'system_id': u'gd3bgx', u'partition_table_type': None, u'path': u'/dev/disk/by-dname/lvroot', u'id_path': None, u'available_size': 0, u'serial': None, u'block_size': 4096, u'used_size': 800097042432, u'model': None, u'uuid': u'0c9aa3f2-3c18-46e6-a8e5-a56d29960a80'}]
2019-06-14 15:02:02,533 [salt.loaded.ext.module.maasng:632 ][INFO    ][6415] vgroot
2019-06-14 15:02:02,533 [salt.loaded.ext.module.maasng:635 ][INFO    ][6415] lvroot
2019-06-14 15:02:02,535 [salt.loaded.ext.module.maasng:639 ][INFO    ][6415] 107374182400
2019-06-14 15:02:03,156 [salt.loaded.ext.module.maasng:645 ][INFO    ][6415] {u'hwe_kernel': u'', u'swap_size': None, u'memory_test_status': -1, u'disable_ipv4': False, u'cpu_count': 40, u'power_type': u'ipmi', u'domain': {u'resource_record_count': 0, u'name': u'maas', u'authoritative': True, u'ttl': None, u'id': 0, u'resource_uri': u'/MAAS/api/2.0/domains/0/'}, u'memory_test_status_name': u'Unknown', u'node_type': 0, u'tag_names': [], u'testing_status_name': u'Passed', u'owner': None, u'pod': None, u'cache_sets': [], u'iscsiblockdevice_set': [], u'status_action': u'', u'blockdevice_set': [{u'resource_uri': u'/MAAS/api/2.0/nodes/gd3bgx/blockdevices/1/', u'available_size': 0, u'name': u'sda', u'tags': [u'ssd'], u'used_size': 800106479616, u'partitions': [{u'uuid': u'a5727f43-dbe9-49a0-b4b8-8c4b79abf52e', u'resource_uri': u'/MAAS/api/2.0/nodes/gd3bgx/blockdevices/1/partition/6', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'gd3bgx', u'filesystem': {u'mount_options': None, u'mount_point': None, u'uuid': u'5e094d7c-fbbb-444a-8712-3460f0575ba2', u'fstype': u'lvm-pv', u'label': None}, u'path': u'/dev/disk/by-dname/sda-part1', u'device_id': 1, u'type': u'partition', u'id': 6, u'size': 800101236736}], u'uuid': None, u'used_for': u'MBR partitioned with 1 partition', u'system_id': u'gd3bgx', u'partition_table_type': u'MBR', u'filesystem': None, u'id_path': u'/dev/disk/by-id/wwn-0x600508b1001cb19198eb9a66f8a29401', u'path': u'/dev/disk/by-dname/sda', u'model': u'LOGICAL VOLUME', u'block_size': 4096, u'type': u'physical', u'id': 1, u'serial': u'600508b1001cb19198eb9a66f8a29401', u'size': 800109715456}, {u'resource_uri': u'/MAAS/api/2.0/nodes/gd3bgx/blockdevices/11/', u'available_size': 0, u'name': u'vgroot-lvroot', u'tags': [], u'used_size': 107374182400, u'partitions': [], u'uuid': u'25de0a8d-2bbf-40e4-8675-a4430e15bd72', u'used_for': u'ext4 formatted filesystem mounted at /', u'system_id': u'gd3bgx', u'partition_table_type': None, u'filesystem': {u'mount_options': None, u'mount_point': u'/', u'uuid': u'9e02a8df-3b8a-4c2a-9729-564e7f1175c7', 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': 11, u'serial': None, u'size': 107374182400}], u'zone': {u'id': 1, u'resource_uri': u'/MAAS/api/2.0/zones/default/', u'name': u'default', u'description': u''}, u'node_type_name': u'Machine', u'hostname': u'cmp002', u'storage': 800109.715456, u'testing_status': 2, u'system_id': u'gd3bgx', 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.38', u'192.168.11.40'], u'architecture': u'amd64/generic', u'status': 4, u'bcaches': [], 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'gd3bgx', u'id': 6}], u'special_filesystems': [], u'cpu_test_status_name': u'Unknown', 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'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'dhcp_on': True, u'fabric_id': 2, u'mtu': 1500, u'primary_rack': u'8w8tx7', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/', u'id': 5003, u'secondary_rack': None, u'name': u'untagged'}, u'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': 18}], u'tags': [u'sriov'], u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'dhcp_on': True, u'fabric_id': 2, u'mtu': 1500, u'primary_rack': u'8w8tx7', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/', u'id': 5003, u'secondary_rack': None, u'name': u'untagged'}, u'enabled': True, u'parents': [], u'children': [], u'discovered': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'dhcp_on': True, u'fabric_id': 2, u'mtu': 1500, u'primary_rack': u'8w8tx7', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/', u'id': 5003, u'secondary_rack': None, u'name': u'untagged'}, u'allow_proxy': True, u'rdns_mode': 2, u'gateway_ip': u'192.168.11.3', u'active_discovery': False, u'cidr': u'192.168.11.0/24', u'id': 3, u'resource_uri': u'/MAAS/api/2.0/subnets/3/'}, u'ip_address': u'192.168.11.38'}], u'mac_address': u'9c:b6:54:8a:10:18', u'system_id': u'gd3bgx', u'effective_mtu': 1500, u'params': u'', u'type': u'physical', u'id': 4, u'resource_uri': u'/MAAS/api/2.0/nodes/gd3bgx/interfaces/4/'}, {u'name': u'ens1f0', u'links': [], u'tags': [u'sriov'], u'vlan': None, u'enabled': True, u'parents': [], u'children': [], u'discovered': None, u'mac_address': u'38:ea:a7:8f:07:50', u'system_id': u'gd3bgx', u'effective_mtu': 1500, u'params': u'', u'type': u'physical', u'id': 14, u'resource_uri': u'/MAAS/api/2.0/nodes/gd3bgx/interfaces/14/'}, {u'name': u'ens1f1', u'links': [], u'tags': [u'sriov'], u'vlan': None, u'enabled': True, u'parents': [], u'children': [], u'discovered': None, u'mac_address': u'38:ea:a7:8f:07:51', u'system_id': u'gd3bgx', u'effective_mtu': 1500, u'params': u'', u'type': u'physical', u'id': 15, u'resource_uri': u'/MAAS/api/2.0/nodes/gd3bgx/interfaces/15/'}, {u'name': u'ens2f0', u'links': [{u'mode': u'link_up', u'id': 19}], u'tags': [u'sriov'], u'vlan': {u'fabric': u'fabric-0', u'vid': 0, u'space': u'undefined', u'dhcp_on': False, u'fabric_id': 0, u'mtu': 1500, u'primary_rack': None, u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/', u'id': 5001, u'secondary_rack': None, u'name': u'untagged'}, u'enabled': True, u'parents': [], u'children': [], u'discovered': None, u'mac_address': u'38:ea:a7:8f:12:48', u'system_id': u'gd3bgx', u'effective_mtu': 1500, u'params': u'', u'type': u'physical', u'id': 13, u'resource_uri': u'/MAAS/api/2.0/nodes/gd3bgx/interfaces/13/'}, {u'name': u'eno2', u'links': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'dhcp_on': True, u'fabric_id': 2, u'mtu': 1500, u'primary_rack': u'8w8tx7', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/', u'id': 5003, u'secondary_rack': None, u'name': u'untagged'}, u'allow_proxy': True, u'rdns_mode': 2, u'gateway_ip': u'192.168.11.3', u'active_discovery': False, u'cidr': u'192.168.11.0/24', u'id': 3, u'resource_uri': u'/MAAS/api/2.0/subnets/3/'}, u'mode': u'link_up', u'id': 20}], u'tags': [u'sriov'], u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'dhcp_on': True, u'fabric_id': 2, u'mtu': 1500, u'primary_rack': u'8w8tx7', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/', u'id': 5003, u'secondary_rack': None, u'name': u'untagged'}, u'enabled': True, u'parents': [], u'children': [], u'discovered': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'dhcp_on': True, u'fabric_id': 2, u'mtu': 1500, u'primary_rack': u'8w8tx7', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/', u'id': 5003, u'secondary_rack': None, u'name': u'untagged'}, u'allow_proxy': True, u'rdns_mode': 2, u'gateway_ip': u'192.168.11.3', u'active_discovery': False, u'cidr': u'192.168.11.0/24', u'id': 3, u'resource_uri': u'/MAAS/api/2.0/subnets/3/'}, u'ip_address': u'192.168.11.40'}], u'mac_address': u'9c:b6:54:8a:10:1c', u'system_id': u'gd3bgx', u'effective_mtu': 1500, u'params': u'', u'type': u'physical', u'id': 11, u'resource_uri': u'/MAAS/api/2.0/nodes/gd3bgx/interfaces/11/'}, {u'name': u'ens2f1', u'links': [{u'mode': u'link_up', u'id': 21}], u'tags': [u'sriov'], u'vlan': {u'fabric': u'fabric-0', u'vid': 0, u'space': u'undefined', u'dhcp_on': False, u'fabric_id': 0, u'mtu': 1500, u'primary_rack': None, u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/', u'id': 5001, u'secondary_rack': None, u'name': u'untagged'}, u'enabled': True, u'parents': [], u'children': [], u'discovered': None, u'mac_address': u'38:ea:a7:8f:12:49', u'system_id': u'gd3bgx', u'effective_mtu': 1500, u'params': u'', u'type': u'physical', u'id': 12, u'resource_uri': u'/MAAS/api/2.0/nodes/gd3bgx/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'physicalblockdevice_set': [{u'available_size': 0, u'name': u'sda', u'resource_uri': u'/MAAS/api/2.0/nodes/gd3bgx/blockdevices/1/', u'type': u'physical', u'partitions': [{u'uuid': u'a5727f43-dbe9-49a0-b4b8-8c4b79abf52e', u'resource_uri': u'/MAAS/api/2.0/nodes/gd3bgx/blockdevices/1/partition/6', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'gd3bgx', u'filesystem': {u'mount_options': None, u'mount_point': None, u'uuid': u'5e094d7c-fbbb-444a-8712-3460f0575ba2', u'fstype': u'lvm-pv', u'label': None}, u'path': u'/dev/disk/by-dname/sda-part1', u'device_id': 1, u'type': u'partition', u'id': 6, u'size': 800101236736}], u'tags': [u'ssd'], u'uuid': None, u'used_for': u'MBR partitioned with 1 partition', u'system_id': u'gd3bgx', u'partition_table_type': u'MBR', u'filesystem': None, u'id_path': u'/dev/disk/by-id/wwn-0x600508b1001cb19198eb9a66f8a29401', u'path': u'/dev/disk/by-dname/sda', u'model': u'LOGICAL VOLUME', u'block_size': 4096, u'used_size': 800106479616, u'id': 1, u'serial': u'600508b1001cb19198eb9a66f8a29401', u'size': 800109715456}], u'netboot': True, u'osystem': u'', u'fqdn': u'cmp002.maas', u'virtualblockdevice_set': [{u'available_size': 0, u'name': u'vgroot-lvroot', u'resource_uri': u'/MAAS/api/2.0/nodes/gd3bgx/blockdevices/11/', u'type': u'virtual', u'partitions': [], u'tags': [], u'uuid': u'25de0a8d-2bbf-40e4-8675-a4430e15bd72', u'used_for': u'ext4 formatted filesystem mounted at /', u'system_id': u'gd3bgx', u'partition_table_type': None, u'filesystem': {u'mount_options': None, u'mount_point': u'/', u'uuid': u'9e02a8df-3b8a-4c2a-9729-564e7f1175c7', 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'used_size': 107374182400, u'id': 11, u'serial': None, u'size': 107374182400}], u'commissioning_status': 2, u'min_hwe_kernel': u'hwe-16.04', u'boot_interface': {u'name': u'eno1', u'links': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'dhcp_on': True, u'fabric_id': 2, u'mtu': 1500, u'primary_rack': u'8w8tx7', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/', u'id': 5003, u'secondary_rack': None, u'name': u'untagged'}, u'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': 18}], u'tags': [u'sriov'], u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'dhcp_on': True, u'fabric_id': 2, u'mtu': 1500, u'primary_rack': u'8w8tx7', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/', u'id': 5003, u'secondary_rack': None, u'name': u'untagged'}, u'enabled': True, u'parents': [], u'children': [], u'discovered': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'dhcp_on': True, u'fabric_id': 2, u'mtu': 1500, u'primary_rack': u'8w8tx7', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/', u'id': 5003, u'secondary_rack': None, u'name': u'untagged'}, u'allow_proxy': True, u'rdns_mode': 2, u'gateway_ip': u'192.168.11.3', u'active_discovery': False, u'cidr': u'192.168.11.0/24', u'id': 3, u'resource_uri': u'/MAAS/api/2.0/subnets/3/'}, u'ip_address': u'192.168.11.38'}], u'mac_address': u'9c:b6:54:8a:10:18', u'system_id': u'gd3bgx', u'effective_mtu': 1500, u'params': u'', u'type': u'physical', u'id': 4, u'resource_uri': u'/MAAS/api/2.0/nodes/gd3bgx/interfaces/4/'}, u'current_commissioning_result_id': 2, u'address_ttl': None, u'resource_uri': u'/MAAS/api/2.0/machines/gd3bgx/', u'distro_series': u'', u'boot_disk': {u'available_size': 0, u'name': u'sda', u'resource_uri': u'/MAAS/api/2.0/nodes/gd3bgx/blockdevices/1/', u'type': u'physical', u'partitions': [{u'uuid': u'a5727f43-dbe9-49a0-b4b8-8c4b79abf52e', u'resource_uri': u'/MAAS/api/2.0/nodes/gd3bgx/blockdevices/1/partition/6', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'gd3bgx', u'filesystem': {u'mount_options': None, u'mount_point': None, u'uuid': u'5e094d7c-fbbb-444a-8712-3460f0575ba2', u'fstype': u'lvm-pv', u'label': None}, u'path': u'/dev/disk/by-dname/sda-part1', u'device_id': 1, u'type': u'partition', u'id': 6, u'size': 800101236736}], u'tags': [u'ssd'], u'uuid': None, u'used_for': u'MBR partitioned with 1 partition', u'system_id': u'gd3bgx', u'partition_table_type': u'MBR', u'filesystem': None, u'id_path': u'/dev/disk/by-id/wwn-0x600508b1001cb19198eb9a66f8a29401', u'path': u'/dev/disk/by-dname/sda', u'model': u'LOGICAL VOLUME', u'block_size': 4096, u'used_size': 800106479616, u'id': 1, u'serial': u'600508b1001cb19198eb9a66f8a29401', u'size': 800109715456}}
2019-06-14 15:02:03,160 [salt.state       :300 ][INFO    ][6415] {'new': {'storage_layout': 'lvm'}}
2019-06-14 15:02:03,161 [salt.state       :1951][INFO    ][6415] Completed state [maas_machines_storage_cmp002_lvm] at time 15:02:03.160926 duration_in_ms=2593.019
2019-06-14 15:02:03,162 [salt.state       :1780][INFO    ][6415] Running state [maas_machines_storage_cmp001_lvm] at time 15:02:03.161673
2019-06-14 15:02:03,162 [salt.state       :1813][INFO    ][6415] Executing state maasng.disk_layout_present for [maas_machines_storage_cmp001_lvm]
2019-06-14 15:02:04,316 [salt.loaded.ext.module.maasng:610 ][INFO    ][6415] fqgswt
2019-06-14 15:02:04,317 [salt.loaded.ext.module.maasng:626 ][INFO    ][6415] sda
2019-06-14 15:02:04,879 [salt.loaded.ext.module.maasng:361 ][INFO    ][6415] fqgswt
2019-06-14 15:02:04,971 [salt.loaded.ext.module.maasng:367 ][INFO    ][6415] [{u'size': 800109715456, u'name': u'sda', u'tags': [u'ssd'], u'used_size': 800106479616, u'id': 2, u'partitions': [{u'uuid': u'8d32dbf1-28d2-4695-803e-fdb268515f20', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'fqgswt', u'device_id': 2, u'filesystem': {u'mount_options': None, u'label': None, u'mount_point': None, u'uuid': u'f71ec82e-e098-48ca-9e3b-86aa18d79788', u'fstype': u'lvm-pv'}, u'path': u'/dev/disk/by-dname/sda-part1', u'resource_uri': u'/MAAS/api/2.0/nodes/fqgswt/blockdevices/2/partition/2', u'type': u'partition', u'id': 2, u'size': 800101236736}], u'uuid': None, u'used_for': u'MBR partitioned with 1 partition', u'path': u'/dev/disk/by-dname/sda', u'system_id': u'fqgswt', u'partition_table_type': u'MBR', u'filesystem': None, u'id_path': u'/dev/disk/by-id/wwn-0x600508b1001cd7e61f5cd3479576479e', u'available_size': 0, u'model': u'LOGICAL VOLUME', u'block_size': 4096, u'type': u'physical', u'serial': u'600508b1001cd7e61f5cd3479576479e', u'resource_uri': u'/MAAS/api/2.0/nodes/fqgswt/blockdevices/2/'}, {u'size': 800097042432, u'name': u'vgroot-lvroot', u'tags': [], u'used_size': 800097042432, u'id': 4, u'partitions': [], u'uuid': u'656e9400-e6b6-498e-ad2a-2d000439da50', u'used_for': u'ext4 formatted filesystem mounted at /', u'path': u'/dev/disk/by-dname/lvroot', u'system_id': u'fqgswt', u'partition_table_type': None, u'filesystem': {u'mount_options': None, u'label': u'root', u'mount_point': u'/', u'uuid': u'6a3b9305-de94-451c-a056-fa2ac6cd67a5', u'fstype': u'ext4'}, u'id_path': None, u'available_size': 0, u'model': None, u'block_size': 4096, u'type': u'virtual', u'serial': None, u'resource_uri': u'/MAAS/api/2.0/nodes/fqgswt/blockdevices/4/'}]
2019-06-14 15:02:04,971 [salt.loaded.ext.module.maasng:632 ][INFO    ][6415] vgroot
2019-06-14 15:02:04,971 [salt.loaded.ext.module.maasng:635 ][INFO    ][6415] lvroot
2019-06-14 15:02:04,972 [salt.loaded.ext.module.maasng:639 ][INFO    ][6415] 107374182400
2019-06-14 15:02:05,185 [salt.minion      :1308][INFO    ][2792] User sudo_ubuntu Executing command saltutil.find_job with jid 20190614150205170749
2019-06-14 15:02:05,209 [salt.minion      :1432][INFO    ][6461] Starting a new job with PID 6461
2019-06-14 15:02:05,239 [salt.minion      :1711][INFO    ][6461] Returning information for job: 20190614150205170749
2019-06-14 15:02:05,591 [salt.loaded.ext.module.maasng:645 ][INFO    ][6415] {u'domain': {u'resource_record_count': 0, u'name': u'maas', u'authoritative': True, u'ttl': None, u'id': 0, u'resource_uri': u'/MAAS/api/2.0/domains/0/'}, u'testing_status_name': u'Passed', u'disable_ipv4': False, u'cpu_count': 40, u'power_type': u'ipmi', u'hwe_kernel': u'', u'memory_test_status_name': u'Unknown', u'status_action': u'', u'tag_names': [], u'swap_size': None, u'owner': None, u'pod': None, u'cache_sets': [], u'iscsiblockdevice_set': [], u'zone': {u'description': u'', u'resource_uri': u'/MAAS/api/2.0/zones/default/', u'name': u'default', u'id': 1}, u'current_commissioning_result_id': 4, u'node_type_name': u'Machine', u'hostname': u'cmp001', u'storage': 800109.715456, u'testing_status': 2, u'system_id': u'fqgswt', u'power_state': u'off', u'memory': 65536, u'current_installation_result_id': None, u'default_gateways': {u'ipv4': {u'gateway_ip': u'192.168.11.3', u'link_id': None}, u'ipv6': {u'gateway_ip': None, u'link_id': None}}, u'status_message': u'Power state queried: off', u'virtualblockdevice_set': [{u'size': 107374182400, u'name': u'vgroot-lvroot', u'tags': [], u'used_size': 107374182400, u'id': 12, u'partitions': [], u'uuid': u'95dd90e3-9d87-4419-96f4-c7f2bd2a09f9', u'used_for': u'ext4 formatted filesystem mounted at /', u'path': u'/dev/disk/by-dname/vgroot-lvroot', u'system_id': u'fqgswt', u'partition_table_type': None, u'filesystem': {u'mount_options': None, u'label': u'root', u'mount_point': u'/', u'uuid': u'41d95143-fdf8-447b-9b9e-c49020f08c7d', u'fstype': u'ext4'}, u'id_path': None, u'available_size': 0, u'model': None, u'block_size': 4096, u'type': u'virtual', u'serial': None, u'resource_uri': u'/MAAS/api/2.0/nodes/fqgswt/blockdevices/12/'}], u'blockdevice_set': [{u'size': 800109715456, u'name': u'sda', u'tags': [u'ssd'], u'used_size': 800106479616, u'id': 2, u'partitions': [{u'uuid': u'8f00a38b-6024-4296-997e-7c61cb6237ac', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'fqgswt', u'device_id': 2, u'filesystem': {u'mount_options': None, u'label': None, u'mount_point': None, u'uuid': u'400255bf-7277-4041-bbb1-d830dbe24280', u'fstype': u'lvm-pv'}, u'path': u'/dev/disk/by-dname/sda-part1', u'resource_uri': u'/MAAS/api/2.0/nodes/fqgswt/blockdevices/2/partition/7', u'type': u'partition', u'id': 7, u'size': 800101236736}], u'uuid': None, u'used_for': u'MBR partitioned with 1 partition', u'path': u'/dev/disk/by-dname/sda', u'system_id': u'fqgswt', u'partition_table_type': u'MBR', u'filesystem': None, u'id_path': u'/dev/disk/by-id/wwn-0x600508b1001cd7e61f5cd3479576479e', u'available_size': 0, u'model': u'LOGICAL VOLUME', u'block_size': 4096, u'type': u'physical', u'serial': u'600508b1001cd7e61f5cd3479576479e', u'resource_uri': u'/MAAS/api/2.0/nodes/fqgswt/blockdevices/2/'}, {u'size': 107374182400, u'name': u'vgroot-lvroot', u'tags': [], u'used_size': 107374182400, u'id': 12, u'partitions': [], u'uuid': u'95dd90e3-9d87-4419-96f4-c7f2bd2a09f9', u'used_for': u'ext4 formatted filesystem mounted at /', u'path': u'/dev/disk/by-dname/lvroot', u'system_id': u'fqgswt', u'partition_table_type': None, u'filesystem': {u'mount_options': None, u'label': u'root', u'mount_point': u'/', u'uuid': u'41d95143-fdf8-447b-9b9e-c49020f08c7d', u'fstype': u'ext4'}, u'id_path': None, u'available_size': 0, u'model': None, u'block_size': 4096, u'type': u'virtual', u'serial': None, u'resource_uri': u'/MAAS/api/2.0/nodes/fqgswt/blockdevices/12/'}], u'status': 4, u'bcaches': [], u'storage_test_status_name': u'Passed', u'raids': [], u'owner_data': {}, u'ip_addresses': [u'192.168.11.39', u'192.168.11.44'], u'other_test_status_name': u'Unknown', u'volume_groups': [{u'__incomplete__': True, u'system_id': u'fqgswt', u'id': 7}], u'special_filesystems': [], u'cpu_test_status_name': u'Unknown', u'boot_disk': {u'size': 800109715456, u'name': u'sda', u'tags': [u'ssd'], u'used_size': 800106479616, u'id': 2, u'partitions': [{u'uuid': u'8f00a38b-6024-4296-997e-7c61cb6237ac', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'fqgswt', u'device_id': 2, u'filesystem': {u'mount_options': None, u'label': None, u'mount_point': None, u'uuid': u'400255bf-7277-4041-bbb1-d830dbe24280', u'fstype': u'lvm-pv'}, u'path': u'/dev/disk/by-dname/sda-part1', u'resource_uri': u'/MAAS/api/2.0/nodes/fqgswt/blockdevices/2/partition/7', u'type': u'partition', u'id': 7, u'size': 800101236736}], u'uuid': None, u'used_for': u'MBR partitioned with 1 partition', u'path': u'/dev/disk/by-dname/sda', u'system_id': u'fqgswt', u'partition_table_type': u'MBR', u'filesystem': None, u'id_path': u'/dev/disk/by-id/wwn-0x600508b1001cd7e61f5cd3479576479e', u'available_size': 0, u'model': u'LOGICAL VOLUME', u'block_size': 4096, u'type': u'physical', u'serial': u'600508b1001cd7e61f5cd3479576479e', u'resource_uri': u'/MAAS/api/2.0/nodes/fqgswt/blockdevices/2/'}, u'interface_set': [{u'name': u'eno1', u'links': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'dhcp_on': True, u'fabric_id': 2, u'name': u'untagged', u'primary_rack': u'8w8tx7', u'relay_vlan': None, u'external_dhcp': None, u'mtu': 1500, u'id': 5003, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/'}, u'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'id': 25, u'mode': u'dhcp'}], u'tags': [u'sriov'], u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'dhcp_on': True, u'fabric_id': 2, u'name': u'untagged', u'primary_rack': u'8w8tx7', u'relay_vlan': None, u'external_dhcp': None, u'mtu': 1500, u'id': 5003, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/'}, u'enabled': True, u'id': 5, u'discovered': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'dhcp_on': True, u'fabric_id': 2, u'name': u'untagged', u'primary_rack': u'8w8tx7', u'relay_vlan': None, u'external_dhcp': None, u'mtu': 1500, u'id': 5003, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/'}, u'allow_proxy': True, u'rdns_mode': 2, u'gateway_ip': u'192.168.11.3', u'active_discovery': False, u'cidr': u'192.168.11.0/24', u'id': 3, u'resource_uri': u'/MAAS/api/2.0/subnets/3/'}, u'ip_address': u'192.168.11.39'}], u'mac_address': u'9c:b6:54:8a:95:a0', u'parents': [], u'params': u'', u'effective_mtu': 1500, u'system_id': u'fqgswt', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/fqgswt/interfaces/5/'}, {u'name': u'ens1f0', u'links': [], u'tags': [u'sriov'], u'vlan': None, u'enabled': True, u'id': 16, u'discovered': None, u'mac_address': u'38:ea:a7:8f:1f:d4', u'parents': [], u'params': u'', u'effective_mtu': 1500, u'system_id': u'fqgswt', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/fqgswt/interfaces/16/'}, {u'name': u'ens1f1', u'links': [], u'tags': [u'sriov'], u'vlan': None, u'enabled': True, u'id': 17, u'discovered': None, u'mac_address': u'38:ea:a7:8f:1f:d5', u'parents': [], u'params': u'', u'effective_mtu': 1500, u'system_id': u'fqgswt', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/fqgswt/interfaces/17/'}, {u'name': u'ens2f1', u'links': [{u'id': 26, u'mode': u'link_up'}], u'tags': [u'sriov'], u'vlan': {u'fabric': u'fabric-0', u'vid': 0, u'space': u'undefined', u'dhcp_on': False, u'fabric_id': 0, u'name': u'untagged', u'primary_rack': None, u'relay_vlan': None, u'external_dhcp': None, u'mtu': 1500, u'id': 5001, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/'}, u'enabled': True, u'id': 18, u'discovered': None, u'mac_address': u'38:ea:a7:8f:52:cd', u'parents': [], u'params': u'', u'effective_mtu': 1500, u'system_id': u'fqgswt', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/fqgswt/interfaces/18/'}, {u'name': u'ens2f0', u'links': [{u'id': 27, u'mode': u'link_up'}], u'tags': [u'sriov'], u'vlan': {u'fabric': u'fabric-0', u'vid': 0, u'space': u'undefined', u'dhcp_on': False, u'fabric_id': 0, u'name': u'untagged', u'primary_rack': None, u'relay_vlan': None, u'external_dhcp': None, u'mtu': 1500, u'id': 5001, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/'}, u'enabled': True, u'id': 19, u'discovered': None, u'mac_address': u'38:ea:a7:8f:52:cc', u'parents': [], u'params': u'', u'effective_mtu': 1500, u'system_id': u'fqgswt', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/fqgswt/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'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'dhcp_on': True, u'fabric_id': 2, u'name': u'untagged', u'primary_rack': u'8w8tx7', u'relay_vlan': None, u'external_dhcp': None, u'mtu': 1500, u'id': 5003, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/'}, u'allow_proxy': True, u'rdns_mode': 2, u'gateway_ip': u'192.168.11.3', u'active_discovery': False, u'cidr': u'192.168.11.0/24', u'id': 3, u'resource_uri': u'/MAAS/api/2.0/subnets/3/'}, u'id': 28, u'mode': u'link_up'}], u'tags': [u'sriov'], u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'dhcp_on': True, u'fabric_id': 2, u'name': u'untagged', u'primary_rack': u'8w8tx7', u'relay_vlan': None, u'external_dhcp': None, u'mtu': 1500, u'id': 5003, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/'}, u'enabled': True, u'id': 20, u'discovered': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'dhcp_on': True, u'fabric_id': 2, u'name': u'untagged', u'primary_rack': u'8w8tx7', u'relay_vlan': None, u'external_dhcp': None, u'mtu': 1500, u'id': 5003, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/'}, u'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.44'}], u'mac_address': u'9c:b6:54:8a:95:a4', u'parents': [], u'params': u'', u'effective_mtu': 1500, u'system_id': u'fqgswt', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/fqgswt/interfaces/20/'}], u'current_testing_result_id': 5, u'cpu_test_status': -1, u'architecture': u'amd64/generic', u'storage_test_status': 2, u'other_test_status': -1, u'status_name': u'Ready', u'physicalblockdevice_set': [{u'size': 800109715456, u'name': u'sda', u'tags': [u'ssd'], u'used_size': 800106479616, u'id': 2, u'partitions': [{u'uuid': u'8f00a38b-6024-4296-997e-7c61cb6237ac', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'fqgswt', u'device_id': 2, u'filesystem': {u'mount_options': None, u'label': None, u'mount_point': None, u'uuid': u'400255bf-7277-4041-bbb1-d830dbe24280', u'fstype': u'lvm-pv'}, u'path': u'/dev/disk/by-dname/sda-part1', u'resource_uri': u'/MAAS/api/2.0/nodes/fqgswt/blockdevices/2/partition/7', u'type': u'partition', u'id': 7, u'size': 800101236736}], u'uuid': None, u'used_for': u'MBR partitioned with 1 partition', u'path': u'/dev/disk/by-dname/sda', u'system_id': u'fqgswt', u'partition_table_type': u'MBR', u'filesystem': None, u'id_path': u'/dev/disk/by-id/wwn-0x600508b1001cd7e61f5cd3479576479e', u'available_size': 0, u'model': u'LOGICAL VOLUME', u'block_size': 4096, u'type': u'physical', u'serial': u'600508b1001cd7e61f5cd3479576479e', u'resource_uri': u'/MAAS/api/2.0/nodes/fqgswt/blockdevices/2/'}], u'netboot': True, u'osystem': u'', u'fqdn': u'cmp001.maas', u'node_type': 0, u'commissioning_status': 2, u'min_hwe_kernel': u'hwe-16.04', u'commissioning_status_name': u'Passed', u'boot_interface': {u'name': u'eno1', u'links': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'dhcp_on': True, u'fabric_id': 2, u'name': u'untagged', u'primary_rack': u'8w8tx7', u'relay_vlan': None, u'external_dhcp': None, u'mtu': 1500, u'id': 5003, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/'}, u'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'id': 25, u'mode': u'dhcp'}], u'tags': [u'sriov'], u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'dhcp_on': True, u'fabric_id': 2, u'name': u'untagged', u'primary_rack': u'8w8tx7', u'relay_vlan': None, u'external_dhcp': None, u'mtu': 1500, u'id': 5003, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/'}, u'enabled': True, u'id': 5, u'discovered': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'dhcp_on': True, u'fabric_id': 2, u'name': u'untagged', u'primary_rack': u'8w8tx7', u'relay_vlan': None, u'external_dhcp': None, u'mtu': 1500, u'id': 5003, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/'}, u'allow_proxy': True, u'rdns_mode': 2, u'gateway_ip': u'192.168.11.3', u'active_discovery': False, u'cidr': u'192.168.11.0/24', u'id': 3, u'resource_uri': u'/MAAS/api/2.0/subnets/3/'}, u'ip_address': u'192.168.11.39'}], u'mac_address': u'9c:b6:54:8a:95:a0', u'parents': [], u'params': u'', u'effective_mtu': 1500, u'system_id': u'fqgswt', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/fqgswt/interfaces/5/'}, u'address_ttl': None, u'memory_test_status': -1, u'distro_series': u'', u'resource_uri': u'/MAAS/api/2.0/machines/fqgswt/'}
2019-06-14 15:02:05,595 [salt.state       :300 ][INFO    ][6415] {'new': {'storage_layout': 'lvm'}}
2019-06-14 15:02:05,595 [salt.state       :1951][INFO    ][6415] Completed state [maas_machines_storage_cmp001_lvm] at time 15:02:05.595853 duration_in_ms=2434.179
2019-06-14 15:02:05,599 [salt.minion      :1711][INFO    ][6415] Returning information for job: 20190614150150051457
2019-06-14 15:02:06,337 [salt.minion      :1308][INFO    ][2792] User sudo_ubuntu Executing command state.apply with jid 20190614150206323036
2019-06-14 15:02:06,364 [salt.minion      :1432][INFO    ][6468] Starting a new job with PID 6468
2019-06-14 15:02:07,495 [salt.state       :915 ][INFO    ][6468] Loading fresh modules for state activity
2019-06-14 15:02:07,558 [salt.fileclient  :1219][INFO    ][6468] Fetching file from saltenv 'base', ** done ** 'maas/machines/deploy.sls'
2019-06-14 15:02:07,609 [salt.state       :1780][INFO    ][6468] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 15:02:07.609080
2019-06-14 15:02:07,609 [salt.state       :1813][INFO    ][6468] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2019-06-14 15:02:07,611 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6468] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2019-06-14 15:02:09,464 [salt.state       :300 ][INFO    ][6468] {'pid': 6475, 'retcode': 0, 'stderr': '', 'stdout': ''}
2019-06-14 15:02:09,466 [salt.state       :1951][INFO    ][6468] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 15:02:09.465707 duration_in_ms=1856.624
2019-06-14 15:02:09,469 [salt.state       :1780][INFO    ][6468] Running state [maas.deploy_machines] at time 15:02:09.468964
2019-06-14 15:02:09,469 [salt.state       :1813][INFO    ][6468] Executing state module.run for [maas.deploy_machines]
2019-06-14 15:02:09,471 [salt.utils.decorators:613 ][WARNING ][6468] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-06-14 15:02:10,061 [salt.loaded.ext.module.maas:684 ][INFO    ][6468] deploymachines hwe_kernel=hwe-16.04 system_id=gd3bgx distro_series=xenial
2019-06-14 15:02:12,635 [salt.loaded.ext.module.maas:684 ][INFO    ][6468] deploymachines hwe_kernel=hwe-16.04 system_id=fqgswt distro_series=xenial
2019-06-14 15:02:15,189 [salt.loaded.ext.module.maas:684 ][INFO    ][6468] deploymachines hwe_kernel=hwe-16.04 system_id=xscab4 distro_series=xenial
2019-06-14 15:02:17,825 [salt.loaded.ext.module.maas:684 ][INFO    ][6468] deploymachines hwe_kernel=hwe-16.04 system_id=76a4wn distro_series=xenial
2019-06-14 15:02:20,335 [salt.loaded.ext.module.maas:684 ][INFO    ][6468] deploymachines hwe_kernel=hwe-16.04 system_id=r8hpgs distro_series=xenial
2019-06-14 15:02:21,455 [salt.minion      :1308][INFO    ][2792] User sudo_ubuntu Executing command saltutil.find_job with jid 20190614150221443176
2019-06-14 15:02:21,474 [salt.minion      :1432][INFO    ][6726] Starting a new job with PID 6726
2019-06-14 15:02:21,504 [salt.minion      :1711][INFO    ][6726] Returning information for job: 20190614150221443176
2019-06-14 15:02:22,903 [salt.state       :300 ][INFO    ][6468] {'ret': {'updated': [], 'errors': {}, 'success': ['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']}}
2019-06-14 15:02:22,904 [salt.state       :1951][INFO    ][6468] Completed state [maas.deploy_machines] at time 15:02:22.904022 duration_in_ms=13435.056
2019-06-14 15:02:22,907 [salt.minion      :1711][INFO    ][6468] Returning information for job: 20190614150206323036
2019-06-14 15:02:23,619 [salt.minion      :1308][INFO    ][2792] User sudo_ubuntu Executing command state.apply with jid 20190614150223610608
2019-06-14 15:02:23,639 [salt.minion      :1432][INFO    ][6755] Starting a new job with PID 6755
2019-06-14 15:02:32,120 [salt.state       :915 ][INFO    ][6755] Loading fresh modules for state activity
2019-06-14 15:02:32,189 [salt.fileclient  :1219][INFO    ][6755] Fetching file from saltenv 'base', ** done ** 'maas/machines/wait_for_deployed.sls'
2019-06-14 15:02:32,240 [salt.state       :1780][INFO    ][6755] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 15:02:32.240746
2019-06-14 15:02:32,241 [salt.state       :1813][INFO    ][6755] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2019-06-14 15:02:32,243 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6755] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2019-06-14 15:02:34,178 [salt.state       :300 ][INFO    ][6755] {'pid': 6782, 'retcode': 0, 'stderr': '', 'stdout': ''}
2019-06-14 15:02:34,179 [salt.state       :1951][INFO    ][6755] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 15:02:34.179689 duration_in_ms=1938.941
2019-06-14 15:02:34,182 [salt.state       :1780][INFO    ][6755] Running state [maas.wait_for_machine_status] at time 15:02:34.182562
2019-06-14 15:02:34,182 [salt.state       :1813][INFO    ][6755] Executing state module.run for [maas.wait_for_machine_status]
2019-06-14 15:02:34,183 [salt.utils.decorators:613 ][WARNING ][6755] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-06-14 15:02:37,179 [salt.loaded.ext.module.maas:1023][INFO    ][6755] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2247.01618886s left)
2019-06-14 15:02:38,652 [salt.minion      :1308][INFO    ][2792] User sudo_ubuntu Executing command saltutil.find_job with jid 20190614150238636381
2019-06-14 15:02:38,682 [salt.minion      :1432][INFO    ][6793] Starting a new job with PID 6793
2019-06-14 15:02:38,719 [salt.minion      :1711][INFO    ][6793] Returning information for job: 20190614150238636381
2019-06-14 15:03:08,755 [salt.minion      :1308][INFO    ][2792] User sudo_ubuntu Executing command saltutil.find_job with jid 20190614150308743832
2019-06-14 15:03:08,776 [salt.minion      :1432][INFO    ][6839] Starting a new job with PID 6839
2019-06-14 15:03:08,804 [salt.minion      :1711][INFO    ][6839] Returning information for job: 20190614150308743832
2019-06-14 15:03:10,110 [salt.loaded.ext.module.maas:1023][INFO    ][6755] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2214.08538795s left)
2019-06-14 15:03:38,880 [salt.minion      :1308][INFO    ][2792] User sudo_ubuntu Executing command saltutil.find_job with jid 20190614150338862919
2019-06-14 15:03:38,907 [salt.minion      :1432][INFO    ][6874] Starting a new job with PID 6874
2019-06-14 15:03:38,936 [salt.minion      :1711][INFO    ][6874] Returning information for job: 20190614150338862919
2019-06-14 15:03:43,192 [salt.loaded.ext.module.maas:1023][INFO    ][6755] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2181.00352597s left)
2019-06-14 15:04:08,971 [salt.minion      :1308][INFO    ][2792] User sudo_ubuntu Executing command saltutil.find_job with jid 20190614150408954605
2019-06-14 15:04:08,997 [salt.minion      :1432][INFO    ][6934] Starting a new job with PID 6934
2019-06-14 15:04:09,025 [salt.minion      :1711][INFO    ][6934] Returning information for job: 20190614150408954605
2019-06-14 15:04:16,254 [salt.loaded.ext.module.maas:1023][INFO    ][6755] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2147.94123793s left)
2019-06-14 15:04:39,055 [salt.minion      :1308][INFO    ][2792] User sudo_ubuntu Executing command saltutil.find_job with jid 20190614150439042630
2019-06-14 15:04:39,081 [salt.minion      :1432][INFO    ][6964] Starting a new job with PID 6964
2019-06-14 15:04:39,111 [salt.minion      :1711][INFO    ][6964] Returning information for job: 20190614150439042630
2019-06-14 15:04:49,239 [salt.loaded.ext.module.maas:1023][INFO    ][6755] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2114.95604205s left)
2019-06-14 15:05:09,163 [salt.minion      :1308][INFO    ][2792] User sudo_ubuntu Executing command saltutil.find_job with jid 20190614150509143409
2019-06-14 15:05:09,193 [salt.minion      :1432][INFO    ][7039] Starting a new job with PID 7039
2019-06-14 15:05:09,237 [salt.minion      :1711][INFO    ][7039] Returning information for job: 20190614150509143409
2019-06-14 15:05:22,348 [salt.loaded.ext.module.maas:1023][INFO    ][6755] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2081.84753394s left)
2019-06-14 15:05:39,295 [salt.minion      :1308][INFO    ][2792] User sudo_ubuntu Executing command saltutil.find_job with jid 20190614150539282497
2019-06-14 15:05:39,321 [salt.minion      :1432][INFO    ][7141] Starting a new job with PID 7141
2019-06-14 15:05:39,351 [salt.minion      :1711][INFO    ][7141] Returning information for job: 20190614150539282497
2019-06-14 15:05:55,301 [salt.loaded.ext.module.maas:1023][INFO    ][6755] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2048.89471197s left)
2019-06-14 15:06:09,430 [salt.minion      :1308][INFO    ][2792] User sudo_ubuntu Executing command saltutil.find_job with jid 20190614150609417498
2019-06-14 15:06:09,462 [salt.minion      :1432][INFO    ][7364] Starting a new job with PID 7364
2019-06-14 15:06:09,496 [salt.minion      :1711][INFO    ][7364] Returning information for job: 20190614150609417498
2019-06-14 15:06:28,307 [salt.loaded.ext.module.maas:1023][INFO    ][6755] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2015.88931894s left)
2019-06-14 15:06:39,563 [salt.minion      :1308][INFO    ][2792] User sudo_ubuntu Executing command saltutil.find_job with jid 20190614150639551440
2019-06-14 15:06:39,584 [salt.minion      :1432][INFO    ][7451] Starting a new job with PID 7451
2019-06-14 15:06:39,613 [salt.minion      :1711][INFO    ][7451] Returning information for job: 20190614150639551440
2019-06-14 15:07:01,293 [salt.loaded.ext.module.maas:1023][INFO    ][6755] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1982.90298295s left)
2019-06-14 15:07:09,704 [salt.minion      :1308][INFO    ][2792] User sudo_ubuntu Executing command saltutil.find_job with jid 20190614150709689679
2019-06-14 15:07:09,735 [salt.minion      :1432][INFO    ][7716] Starting a new job with PID 7716
2019-06-14 15:07:09,766 [salt.minion      :1711][INFO    ][7716] Returning information for job: 20190614150709689679
2019-06-14 15:07:34,279 [salt.loaded.ext.module.maas:1023][INFO    ][6755] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1949.916749s left)
2019-06-14 15:07:39,851 [salt.minion      :1308][INFO    ][2792] User sudo_ubuntu Executing command saltutil.find_job with jid 20190614150739841562
2019-06-14 15:07:39,881 [salt.minion      :1432][INFO    ][7765] Starting a new job with PID 7765
2019-06-14 15:07:39,911 [salt.minion      :1711][INFO    ][7765] Returning information for job: 20190614150739841562
2019-06-14 15:08:07,543 [salt.loaded.ext.module.maas:1023][INFO    ][6755] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1916.65283704s left)
2019-06-14 15:08:10,059 [salt.minion      :1308][INFO    ][2792] User sudo_ubuntu Executing command saltutil.find_job with jid 20190614150810045454
2019-06-14 15:08:10,089 [salt.minion      :1432][INFO    ][8212] Starting a new job with PID 8212
2019-06-14 15:08:10,117 [salt.minion      :1711][INFO    ][8212] Returning information for job: 20190614150810045454
2019-06-14 15:08:40,216 [salt.minion      :1308][INFO    ][2792] User sudo_ubuntu Executing command saltutil.find_job with jid 20190614150840200102
2019-06-14 15:08:40,242 [salt.minion      :1432][INFO    ][8250] Starting a new job with PID 8250
2019-06-14 15:08:40,272 [salt.minion      :1711][INFO    ][8250] Returning information for job: 20190614150840200102
2019-06-14 15:08:40,527 [salt.loaded.ext.module.maas:1023][INFO    ][6755] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1883.66851306s left)
2019-06-14 15:09:10,393 [salt.minion      :1308][INFO    ][2792] User sudo_ubuntu Executing command saltutil.find_job with jid 20190614150910382628
2019-06-14 15:09:10,423 [salt.minion      :1432][INFO    ][8625] Starting a new job with PID 8625
2019-06-14 15:09:10,456 [salt.minion      :1711][INFO    ][8625] Returning information for job: 20190614150910382628
2019-06-14 15:09:13,456 [salt.loaded.ext.module.maas:1023][INFO    ][6755] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1850.7395339s left)
2019-06-14 15:09:40,577 [salt.minion      :1308][INFO    ][2792] User sudo_ubuntu Executing command saltutil.find_job with jid 20190614150940556528
2019-06-14 15:09:40,602 [salt.minion      :1432][INFO    ][8663] Starting a new job with PID 8663
2019-06-14 15:09:40,631 [salt.minion      :1711][INFO    ][8663] Returning information for job: 20190614150940556528
2019-06-14 15:09:47,676 [salt.loaded.ext.module.maas:1023][INFO    ][6755] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1816.51920199s left)
2019-06-14 15:10:10,796 [salt.minion      :1308][INFO    ][2792] User sudo_ubuntu Executing command saltutil.find_job with jid 20190614151010780117
2019-06-14 15:10:10,822 [salt.minion      :1432][INFO    ][9019] Starting a new job with PID 9019
2019-06-14 15:10:10,856 [salt.minion      :1711][INFO    ][9019] Returning information for job: 20190614151010780117
2019-06-14 15:10:20,778 [salt.loaded.ext.module.maas:1023][INFO    ][6755] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1783.41715193s left)
2019-06-14 15:10:40,983 [salt.minion      :1308][INFO    ][2792] User sudo_ubuntu Executing command saltutil.find_job with jid 20190614151040965541
2019-06-14 15:10:41,011 [salt.minion      :1432][INFO    ][9086] Starting a new job with PID 9086
2019-06-14 15:10:41,050 [salt.minion      :1711][INFO    ][9086] Returning information for job: 20190614151040965541
2019-06-14 15:10:53,947 [salt.loaded.ext.module.maas:1023][INFO    ][6755] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1750.248245s left)
2019-06-14 15:11:11,008 [salt.minion      :1308][INFO    ][2792] User sudo_ubuntu Executing command saltutil.find_job with jid 20190614151110995478
2019-06-14 15:11:11,027 [salt.minion      :1432][INFO    ][9477] Starting a new job with PID 9477
2019-06-14 15:11:11,057 [salt.minion      :1711][INFO    ][9477] Returning information for job: 20190614151110995478
2019-06-14 15:11:26,778 [salt.loaded.ext.module.maas:1023][INFO    ][6755] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1717.41706705s left)
2019-06-14 15:11:41,182 [salt.minion      :1308][INFO    ][2792] User sudo_ubuntu Executing command saltutil.find_job with jid 20190614151141168247
2019-06-14 15:11:41,208 [salt.minion      :1432][INFO    ][9528] Starting a new job with PID 9528
2019-06-14 15:11:41,250 [salt.minion      :1711][INFO    ][9528] Returning information for job: 20190614151141168247
2019-06-14 15:11:59,885 [salt.loaded.ext.module.maas:1023][INFO    ][6755] Waiting status:Deployed for machines:['cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1684.31108809s left)
2019-06-14 15:12:11,388 [salt.minion      :1308][INFO    ][2792] User sudo_ubuntu Executing command saltutil.find_job with jid 20190614151211372800
2019-06-14 15:12:11,419 [salt.minion      :1432][INFO    ][9622] Starting a new job with PID 9622
2019-06-14 15:12:11,447 [salt.minion      :1711][INFO    ][9622] Returning information for job: 20190614151211372800
2019-06-14 15:12:32,771 [salt.loaded.ext.module.maas:1023][INFO    ][6755] Waiting status:Deployed for machines:['kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1651.42483497s left)
2019-06-14 15:12:41,480 [salt.minion      :1308][INFO    ][2792] User sudo_ubuntu Executing command saltutil.find_job with jid 20190614151241459003
2019-06-14 15:12:41,512 [salt.minion      :1432][INFO    ][9664] Starting a new job with PID 9664
2019-06-14 15:12:41,541 [salt.minion      :1711][INFO    ][9664] Returning information for job: 20190614151241459003
2019-06-14 15:13:05,688 [salt.loaded.ext.module.maas:1023][INFO    ][6755] Waiting status:Deployed for machines:['kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1618.50801492s left)
2019-06-14 15:13:11,706 [salt.minion      :1308][INFO    ][2792] User sudo_ubuntu Executing command saltutil.find_job with jid 20190614151311688918
2019-06-14 15:13:11,732 [salt.minion      :1432][INFO    ][9952] Starting a new job with PID 9952
2019-06-14 15:13:11,763 [salt.minion      :1711][INFO    ][9952] Returning information for job: 20190614151311688918
2019-06-14 15:13:38,704 [salt.loaded.ext.module.maas:1023][INFO    ][6755] Waiting status:Deployed for machines:['kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1585.49188304s left)
2019-06-14 15:13:41,921 [salt.minion      :1308][INFO    ][2792] User sudo_ubuntu Executing command saltutil.find_job with jid 20190614151341905525
2019-06-14 15:13:41,951 [salt.minion      :1432][INFO    ][10119] Starting a new job with PID 10119
2019-06-14 15:13:41,983 [salt.minion      :1711][INFO    ][10119] Returning information for job: 20190614151341905525
2019-06-14 15:14:11,923 [salt.loaded.ext.module.maas:1023][INFO    ][6755] Waiting status:Deployed for machines:['kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1552.27250195s left)
2019-06-14 15:14:12,128 [salt.minion      :1308][INFO    ][2792] User sudo_ubuntu Executing command saltutil.find_job with jid 20190614151412115021
2019-06-14 15:14:12,155 [salt.minion      :1432][INFO    ][10178] Starting a new job with PID 10178
2019-06-14 15:14:12,182 [salt.minion      :1711][INFO    ][10178] Returning information for job: 20190614151412115021
2019-06-14 15:14:42,360 [salt.minion      :1308][INFO    ][2792] User sudo_ubuntu Executing command saltutil.find_job with jid 20190614151442344256
2019-06-14 15:14:42,392 [salt.minion      :1432][INFO    ][10251] Starting a new job with PID 10251
2019-06-14 15:14:42,431 [salt.minion      :1711][INFO    ][10251] Returning information for job: 20190614151442344256
2019-06-14 15:14:44,969 [salt.loaded.ext.module.maas:1023][INFO    ][6755] Waiting status:Deployed for machines:['kvm01', 'kvm03']
sleep for:30s Timeout:2250s (1519.22697592s left)
2019-06-14 15:15:12,499 [salt.minion      :1308][INFO    ][2792] User sudo_ubuntu Executing command saltutil.find_job with jid 20190614151512486060
2019-06-14 15:15:12,523 [salt.minion      :1432][INFO    ][10429] Starting a new job with PID 10429
2019-06-14 15:15:12,549 [salt.minion      :1711][INFO    ][10429] Returning information for job: 20190614151512486060
2019-06-14 15:15:18,041 [salt.state       :300 ][INFO    ][6755] {'ret': True}
2019-06-14 15:15:18,042 [salt.state       :1951][INFO    ][6755] Completed state [maas.wait_for_machine_status] at time 15:15:18.042027 duration_in_ms=763859.461
2019-06-14 15:15:18,048 [salt.minion      :1711][INFO    ][6755] Returning information for job: 20190614150223610608
2019-06-14 15:53:36,976 [salt.utils.schedule:1377][INFO    ][2792] Running scheduled job: __mine_interval
2019-06-14 16:42:56,782 [salt.minion      :1308][INFO    ][2792] User sudo_ubuntu Executing command cp.push_dir with jid 20190614164256768018
2019-06-14 16:42:56,815 [salt.minion      :1432][INFO    ][16747] Starting a new job with PID 16747
