2019-04-19 05:04:25,500 [salt.minion      :870 ][ERROR   ][387] Error while bringing up minion for multi-master. Is master at 10.20.0.2 responding?
2019-04-19 05:05:15,542 [salt.minion      :870 ][ERROR   ][387] Error while bringing up minion for multi-master. Is master at 10.20.0.2 responding?
2019-04-19 05:06:05,589 [salt.minion      :870 ][ERROR   ][387] Error while bringing up minion for multi-master. Is master at 10.20.0.2 responding?
2019-04-19 05:06:55,635 [salt.minion      :870 ][ERROR   ][387] Error while bringing up minion for multi-master. Is master at 10.20.0.2 responding?
2019-04-19 05:07:45,686 [salt.minion      :870 ][ERROR   ][387] Error while bringing up minion for multi-master. Is master at 10.20.0.2 responding?
2019-04-19 05:08:35,735 [salt.minion      :870 ][ERROR   ][387] Error while bringing up minion for multi-master. Is master at 10.20.0.2 responding?
2019-04-19 05:10:07,121 [salt.utils.decorators:613 ][WARNING ][2894] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-04-19 05:10:08,114 [salt.utils.decorators:613 ][WARNING ][2894] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-04-19 05:10:19,125 [salt.loaded.int.states.file:2298][WARNING ][3028] 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-04-19 05:10:23,198 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3240] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2019-04-19 05:10:23,221 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3240] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2019-04-19 05:10:23,262 [salt.utils.parsers:1051][WARNING ][387] Minion received a SIGTERM. Exiting.
2019-04-19 05:10:24,442 [salt.cli.daemons :293 ][INFO    ][3401] Setting up the Salt Minion "mas01.mcp-ovs-dpdk-ha.local"
2019-04-19 05:10:24,614 [salt.cli.daemons :82  ][INFO    ][3401] Starting up the Salt Minion
2019-04-19 05:10:24,614 [salt.utils.event :1017][INFO    ][3401] Starting pull socket on /var/run/salt/minion/minion_event_967fbee23e_pull.ipc
2019-04-19 05:10:25,778 [salt.minion      :976 ][INFO    ][3401] Creating minion process manager
2019-04-19 05:10:26,988 [salt.state       :2022][WARNING ][3244] State is set to retry, but a valid dict for retry configuration was not found.  Using retry defaults
2019-04-19 05:10:28,616 [salt.loader.10.20.0.2.int.module.cmdmod:395 ][INFO    ][3401] Executing command ['date', '+%z'] in directory '/root'
2019-04-19 05:10:28,640 [salt.utils.schedule:568 ][INFO    ][3401] Updating job settings for scheduled job: __mine_interval
2019-04-19 05:10:28,642 [salt.minion      :1108][INFO    ][3401] Added mine.update to scheduler
2019-04-19 05:10:28,649 [salt.minion      :1975][INFO    ][3401] Minion is starting as user 'root'
2019-04-19 05:10:28,663 [salt.minion      :2336][INFO    ][3401] Minion is ready to receive requests!
2019-04-19 05:10:30,313 [salt.utils.decorators:613 ][WARNING ][3244] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-04-19 05:10:35,357 [salt.minion      :1308][INFO    ][3401] User sudo_ubuntu Executing command saltutil.find_job with jid 20190419051035345963
2019-04-19 05:10:35,371 [salt.minion      :1432][INFO    ][3926] Starting a new job with PID 3926
2019-04-19 05:10:35,397 [salt.minion      :1711][INFO    ][3926] Returning information for job: 20190419051035345963
2019-04-19 05:10:42,817 [salt.utils.decorators:613 ][WARNING ][3244] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-04-19 05:11:05,422 [salt.minion      :1308][INFO    ][3401] User sudo_ubuntu Executing command saltutil.find_job with jid 20190419051105413465
2019-04-19 05:11:05,441 [salt.minion      :1432][INFO    ][4644] Starting a new job with PID 4644
2019-04-19 05:11:05,468 [salt.minion      :1711][INFO    ][4644] Returning information for job: 20190419051105413465
2019-04-19 05:11:08,380 [salt.utils.decorators:613 ][WARNING ][3244] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-04-19 05:11:09,244 [salt.utils.decorators:613 ][WARNING ][3244] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-04-19 05:11:11,118 [salt.loaded.ext.module.maasng:1008][WARNING ][3244] Detected cidr:192.168.11.0/24 in fabric:fabric-2
2019-04-19 05:11:11,118 [salt.loaded.ext.module.maasng:1011][WARNING ][3244] Guessing, that fabric with current name:fabric-2
 should be renamed to:pxe_admin
2019-04-19 05:11:11,783 [salt.loaded.ext.module.maasng:1235][WARNING ][3244] Ignoring parameter vlan:0
2019-04-19 05:11:12,517 [salt.utils.decorators:613 ][WARNING ][3244] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-04-19 05:11:13,462 [salt.minion      :1308][INFO    ][3401] User sudo_ubuntu Executing command state.apply with jid 20190419051113448879
2019-04-19 05:11:13,476 [salt.minion      :1432][INFO    ][4869] Starting a new job with PID 4869
2019-04-19 05:11:21,892 [salt.state       :915 ][INFO    ][4869] Loading fresh modules for state activity
2019-04-19 05:11:21,952 [salt.fileclient  :1219][INFO    ][4869] Fetching file from saltenv 'base', ** done ** 'maas/machines/init.sls'
2019-04-19 05:11:22,010 [salt.state       :1780][INFO    ][4869] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 05:11:22.010160
2019-04-19 05:11:22,010 [salt.state       :1813][INFO    ][4869] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2019-04-19 05:11:22,016 [salt.loaded.int.module.cmdmod:395 ][INFO    ][4869] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2019-04-19 05:11:23,887 [salt.state       :300 ][INFO    ][4869] {'pid': 4928, 'retcode': 0, 'stderr': '', 'stdout': ''}
2019-04-19 05:11:23,888 [salt.state       :1951][INFO    ][4869] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 05:11:23.888585 duration_in_ms=1878.424
2019-04-19 05:11:23,891 [salt.state       :1780][INFO    ][4869] Running state [maas.process_machines] at time 05:11:23.891512
2019-04-19 05:11:23,892 [salt.state       :1813][INFO    ][4869] Executing state module.run for [maas.process_machines]
2019-04-19 05:11:23,893 [salt.utils.decorators:613 ][WARNING ][4869] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-04-19 05:11:23,959 [salt.loaded.ext.module.maas:412 ][WARNING ][4869] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2019-04-19 05:11:23,959 [salt.loaded.ext.module.maas:92  ][INFO    ][4869] 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-04-19 05:11:25,196 [salt.loaded.ext.module.maas:412 ][WARNING ][4869] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2019-04-19 05:11:25,196 [salt.loaded.ext.module.maas:92  ][INFO    ][4869] 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-04-19 05:11:26,229 [salt.loaded.ext.module.maas:412 ][WARNING ][4869] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2019-04-19 05:11:26,229 [salt.loaded.ext.module.maas:92  ][INFO    ][4869] 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-04-19 05:11:27,337 [salt.loaded.ext.module.maas:412 ][WARNING ][4869] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2019-04-19 05:11:27,337 [salt.loaded.ext.module.maas:92  ][INFO    ][4869] 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-04-19 05:11:28,460 [salt.loaded.ext.module.maas:412 ][WARNING ][4869] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2019-04-19 05:11:28,460 [salt.loaded.ext.module.maas:92  ][INFO    ][4869] 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-04-19 05:11:28,545 [salt.minion      :1308][INFO    ][3401] User sudo_ubuntu Executing command saltutil.find_job with jid 20190419051128538268
2019-04-19 05:11:28,562 [salt.minion      :1432][INFO    ][5145] Starting a new job with PID 5145
2019-04-19 05:11:28,597 [salt.minion      :1711][INFO    ][5145] Returning information for job: 20190419051128538268
2019-04-19 05:11:29,568 [salt.state       :300 ][INFO    ][4869] {'ret': {'updated': [], 'errors': {}, 'success': ['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']}}
2019-04-19 05:11:29,569 [salt.state       :1951][INFO    ][4869] Completed state [maas.process_machines] at time 05:11:29.569245 duration_in_ms=5677.732
2019-04-19 05:11:29,575 [salt.minion      :1711][INFO    ][4869] Returning information for job: 20190419051113448879
2019-04-19 05:12:00,944 [salt.minion      :1308][INFO    ][3401] User sudo_ubuntu Executing command state.apply with jid 20190419051200931198
2019-04-19 05:12:00,961 [salt.minion      :1432][INFO    ][5265] Starting a new job with PID 5265
2019-04-19 05:12:09,013 [salt.state       :915 ][INFO    ][5265] Loading fresh modules for state activity
2019-04-19 05:12:09,068 [salt.fileclient  :1219][INFO    ][5265] Fetching file from saltenv 'base', ** done ** 'maas/machines/wait_for_ready_or_deployed.sls'
2019-04-19 05:12:09,111 [salt.state       :1780][INFO    ][5265] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 05:12:09.111317
2019-04-19 05:12:09,111 [salt.state       :1813][INFO    ][5265] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2019-04-19 05:12:09,113 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5265] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2019-04-19 05:12:10,933 [salt.state       :300 ][INFO    ][5265] {'pid': 5273, 'retcode': 0, 'stderr': '', 'stdout': ''}
2019-04-19 05:12:10,934 [salt.state       :1951][INFO    ][5265] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 05:12:10.934600 duration_in_ms=1823.281
2019-04-19 05:12:10,939 [salt.state       :1780][INFO    ][5265] Running state [maas.wait_for_machine_status] at time 05:12:10.939280
2019-04-19 05:12:10,940 [salt.state       :1813][INFO    ][5265] Executing state module.run for [maas.wait_for_machine_status]
2019-04-19 05:12:10,940 [salt.utils.decorators:613 ][WARNING ][5265] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-04-19 05:12:11,727 [salt.loaded.ext.module.maas:1023][INFO    ][5265] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1499.22832417s left)
2019-04-19 05:12:15,965 [salt.minion      :1308][INFO    ][3401] User sudo_ubuntu Executing command saltutil.find_job with jid 20190419051215954621
2019-04-19 05:12:15,980 [salt.minion      :1432][INFO    ][5285] Starting a new job with PID 5285
2019-04-19 05:12:16,007 [salt.minion      :1711][INFO    ][5285] Returning information for job: 20190419051215954621
2019-04-19 05:12:42,468 [salt.loaded.ext.module.maas:1023][INFO    ][5265] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1468.48764205s left)
2019-04-19 05:12:45,989 [salt.minion      :1308][INFO    ][3401] User sudo_ubuntu Executing command saltutil.find_job with jid 20190419051245981127
2019-04-19 05:12:46,005 [salt.minion      :1432][INFO    ][5349] Starting a new job with PID 5349
2019-04-19 05:12:46,032 [salt.minion      :1711][INFO    ][5349] Returning information for job: 20190419051245981127
2019-04-19 05:13:13,421 [salt.loaded.ext.module.maas:1023][INFO    ][5265] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1437.53528309s left)
2019-04-19 05:13:16,015 [salt.minion      :1308][INFO    ][3401] User sudo_ubuntu Executing command saltutil.find_job with jid 20190419051316005865
2019-04-19 05:13:16,039 [salt.minion      :1432][INFO    ][5381] Starting a new job with PID 5381
2019-04-19 05:13:16,064 [salt.minion      :1711][INFO    ][5381] Returning information for job: 20190419051316005865
2019-04-19 05:13:44,274 [salt.loaded.ext.module.maas:1023][INFO    ][5265] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1406.68154812s left)
2019-04-19 05:13:46,027 [salt.minion      :1308][INFO    ][3401] User sudo_ubuntu Executing command saltutil.find_job with jid 20190419051346019164
2019-04-19 05:13:46,044 [salt.minion      :1432][INFO    ][5450] Starting a new job with PID 5450
2019-04-19 05:13:46,074 [salt.minion      :1711][INFO    ][5450] Returning information for job: 20190419051346019164
2019-04-19 05:14:15,250 [salt.loaded.ext.module.maas:1023][INFO    ][5265] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1375.70560312s left)
2019-04-19 05:14:16,254 [salt.minion      :1308][INFO    ][3401] User sudo_ubuntu Executing command saltutil.find_job with jid 20190419051416241013
2019-04-19 05:14:16,270 [salt.minion      :1432][INFO    ][5510] Starting a new job with PID 5510
2019-04-19 05:14:16,295 [salt.minion      :1711][INFO    ][5510] Returning information for job: 20190419051416241013
2019-04-19 05:14:46,265 [salt.loaded.ext.module.maas:1023][INFO    ][5265] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1344.69069719s left)
2019-04-19 05:14:46,286 [salt.minion      :1308][INFO    ][3401] User sudo_ubuntu Executing command saltutil.find_job with jid 20190419051446271976
2019-04-19 05:14:46,310 [salt.minion      :1432][INFO    ][5707] Starting a new job with PID 5707
2019-04-19 05:14:46,341 [salt.minion      :1711][INFO    ][5707] Returning information for job: 20190419051446271976
2019-04-19 05:15:16,317 [salt.minion      :1308][INFO    ][3401] User sudo_ubuntu Executing command saltutil.find_job with jid 20190419051516302907
2019-04-19 05:15:16,334 [salt.minion      :1432][INFO    ][5783] Starting a new job with PID 5783
2019-04-19 05:15:16,364 [salt.minion      :1711][INFO    ][5783] Returning information for job: 20190419051516302907
2019-04-19 05:15:17,417 [salt.loaded.ext.module.maas:1023][INFO    ][5265] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1313.539114s left)
2019-04-19 05:15:46,374 [salt.minion      :1308][INFO    ][3401] User sudo_ubuntu Executing command saltutil.find_job with jid 20190419051546357797
2019-04-19 05:15:46,393 [salt.minion      :1432][INFO    ][6097] Starting a new job with PID 6097
2019-04-19 05:15:46,421 [salt.minion      :1711][INFO    ][6097] Returning information for job: 20190419051546357797
2019-04-19 05:15:48,760 [salt.loaded.ext.module.maas:1023][INFO    ][5265] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1282.19539809s left)
2019-04-19 05:16:16,448 [salt.minion      :1308][INFO    ][3401] User sudo_ubuntu Executing command saltutil.find_job with jid 20190419051616438361
2019-04-19 05:16:16,470 [salt.minion      :1432][INFO    ][6242] Starting a new job with PID 6242
2019-04-19 05:16:16,506 [salt.minion      :1711][INFO    ][6242] Returning information for job: 20190419051616438361
2019-04-19 05:16:20,390 [salt.loaded.ext.module.maas:1023][INFO    ][5265] Waiting status:Ready|Deployed for machines:['cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1250.56599402s left)
2019-04-19 05:16:46,595 [salt.minion      :1308][INFO    ][3401] User sudo_ubuntu Executing command saltutil.find_job with jid 20190419051646579849
2019-04-19 05:16:46,616 [salt.minion      :1432][INFO    ][6597] Starting a new job with PID 6597
2019-04-19 05:16:46,645 [salt.minion      :1711][INFO    ][6597] Returning information for job: 20190419051646579849
2019-04-19 05:16:52,665 [salt.loaded.ext.module.maas:1023][INFO    ][5265] Waiting status:Ready|Deployed for machines:['kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1218.29103804s left)
2019-04-19 05:17:16,703 [salt.minion      :1308][INFO    ][3401] User sudo_ubuntu Executing command saltutil.find_job with jid 20190419051716691482
2019-04-19 05:17:16,722 [salt.minion      :1432][INFO    ][6763] Starting a new job with PID 6763
2019-04-19 05:17:16,751 [salt.minion      :1711][INFO    ][6763] Returning information for job: 20190419051716691482
2019-04-19 05:17:24,933 [salt.loaded.ext.module.maas:1023][INFO    ][5265] Waiting status:Ready|Deployed for machines:['kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1186.02256608s left)
2019-04-19 05:17:46,798 [salt.minion      :1308][INFO    ][3401] User sudo_ubuntu Executing command saltutil.find_job with jid 20190419051746787079
2019-04-19 05:17:46,821 [salt.minion      :1432][INFO    ][6946] Starting a new job with PID 6946
2019-04-19 05:17:46,857 [salt.minion      :1711][INFO    ][6946] Returning information for job: 20190419051746787079
2019-04-19 05:17:57,368 [salt.loaded.ext.module.maas:1023][INFO    ][5265] Waiting status:Ready|Deployed for machines:['kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1153.58770418s left)
2019-04-19 05:18:16,914 [salt.minion      :1308][INFO    ][3401] User sudo_ubuntu Executing command saltutil.find_job with jid 20190419051816902034
2019-04-19 05:18:16,930 [salt.minion      :1432][INFO    ][7108] Starting a new job with PID 7108
2019-04-19 05:18:16,956 [salt.minion      :1711][INFO    ][7108] Returning information for job: 20190419051816902034
2019-04-19 05:18:30,359 [salt.state       :300 ][INFO    ][5265] {'ret': True}
2019-04-19 05:18:30,360 [salt.state       :1951][INFO    ][5265] Completed state [maas.wait_for_machine_status] at time 05:18:30.360132 duration_in_ms=379420.851
2019-04-19 05:18:30,364 [salt.minion      :1711][INFO    ][5265] Returning information for job: 20190419051200931198
2019-04-19 05:18:31,161 [salt.minion      :1308][INFO    ][3401] User sudo_ubuntu Executing command state.apply with jid 20190419051831150708
2019-04-19 05:18:31,183 [salt.minion      :1432][INFO    ][7226] Starting a new job with PID 7226
2019-04-19 05:18:39,352 [salt.state       :915 ][INFO    ][7226] Loading fresh modules for state activity
2019-04-19 05:18:39,408 [salt.fileclient  :1219][INFO    ][7226] Fetching file from saltenv 'base', ** done ** 'maas/machines/storage.sls'
2019-04-19 05:18:39,508 [salt.state       :1780][INFO    ][7226] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 05:18:39.508512
2019-04-19 05:18:39,508 [salt.state       :1813][INFO    ][7226] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2019-04-19 05:18:39,510 [salt.loaded.int.module.cmdmod:395 ][INFO    ][7226] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2019-04-19 05:18:41,348 [salt.state       :300 ][INFO    ][7226] {'pid': 7250, 'retcode': 0, 'stderr': '', 'stdout': ''}
2019-04-19 05:18:41,349 [salt.state       :1951][INFO    ][7226] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 05:18:41.349039 duration_in_ms=1840.527
2019-04-19 05:18:41,351 [salt.state       :1780][INFO    ][7226] Running state [maas_machines_storage_cmp002_lvm] at time 05:18:41.351521
2019-04-19 05:18:41,351 [salt.state       :1813][INFO    ][7226] Executing state maasng.disk_layout_present for [maas_machines_storage_cmp002_lvm]
2019-04-19 05:18:42,421 [salt.loaded.ext.module.maasng:610 ][INFO    ][7226] b7ggd7
2019-04-19 05:18:42,421 [salt.loaded.ext.module.maasng:626 ][INFO    ][7226] sda
2019-04-19 05:18:42,957 [salt.loaded.ext.module.maasng:361 ][INFO    ][7226] b7ggd7
2019-04-19 05:18:43,049 [salt.loaded.ext.module.maasng:367 ][INFO    ][7226] [{u'size': 800109715456, u'uuid': None, u'tags': [u'ssd'], u'used_for': u'MBR partitioned with 1 partition', u'type': u'physical', u'partitions': [{u'size': 800101236736, u'uuid': u'686d0a62-7b3c-4a81-8d36-26c91f92bb03', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'b7ggd7', u'filesystem': {u'mount_options': None, u'label': None, u'mount_point': None, u'uuid': u'3b6c2333-4e9e-4105-b89a-1aa6e4987dbe', u'fstype': u'lvm-pv'}, u'path': u'/dev/disk/by-dname/sda-part1', u'resource_uri': u'/MAAS/api/2.0/nodes/b7ggd7/blockdevices/1/partition/1', u'type': u'partition', u'id': 1, u'device_id': 1}], u'filesystem': None, u'id': 1, u'name': u'sda', u'system_id': u'b7ggd7', 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'resource_uri': u'/MAAS/api/2.0/nodes/b7ggd7/blockdevices/1/'}, {u'size': 800097042432, u'uuid': u'8f028e6e-4af9-4444-b653-b8f854b5e735', u'tags': [], u'used_for': u'ext4 formatted filesystem mounted at /', u'type': u'virtual', u'partitions': [], u'filesystem': {u'mount_options': None, u'label': u'root', u'mount_point': u'/', u'uuid': u'e5e31f67-9650-41ba-8be2-bf721bf5b50b', u'fstype': u'ext4'}, u'id': 3, u'name': u'vgroot-lvroot', u'system_id': u'b7ggd7', 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'resource_uri': u'/MAAS/api/2.0/nodes/b7ggd7/blockdevices/3/'}]
2019-04-19 05:18:43,049 [salt.loaded.ext.module.maasng:632 ][INFO    ][7226] vgroot
2019-04-19 05:18:43,050 [salt.loaded.ext.module.maasng:635 ][INFO    ][7226] lvroot
2019-04-19 05:18:43,050 [salt.loaded.ext.module.maasng:639 ][INFO    ][7226] 107374182400
2019-04-19 05:18:43,652 [salt.loaded.ext.module.maasng:645 ][INFO    ][7226] {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'memory_test_status': -1, u'ip_addresses': [u'192.168.11.38', u'192.168.11.40'], u'cpu_count': 40, u'owner_data': {}, u'hwe_kernel': u'', u'boot_interface': {u'name': u'eno1', u'links': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'dhcp_on': True, u'fabric_id': 2, u'mtu': 1500, u'external_dhcp': None, u'fabric': u'pxe_admin', u'relay_vlan': None, u'primary_rack': u'nq3wtr', u'id': 5003, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/'}, u'allow_proxy': True, u'rdns_mode': 2, u'gateway_ip': u'192.168.11.3', u'active_discovery': False, u'cidr': u'192.168.11.0/24', u'id': 3, u'resource_uri': u'/MAAS/api/2.0/subnets/3/'}, u'ip_address': u'192.168.11.38', u'mode': u'dhcp', u'id': 18}], u'tags': [u'sriov'], u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'dhcp_on': True, u'fabric_id': 2, u'mtu': 1500, u'external_dhcp': None, u'fabric': u'pxe_admin', u'relay_vlan': None, u'primary_rack': u'nq3wtr', u'id': 5003, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/'}, u'enabled': True, u'effective_mtu': 1500, 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'name': u'untagged', u'vid': 0, u'space': u'undefined', u'dhcp_on': True, u'fabric_id': 2, u'mtu': 1500, u'external_dhcp': None, u'fabric': u'pxe_admin', u'relay_vlan': None, u'primary_rack': u'nq3wtr', u'id': 5003, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/'}, u'allow_proxy': True, u'rdns_mode': 2, u'gateway_ip': u'192.168.11.3', u'active_discovery': False, u'cidr': u'192.168.11.0/24', u'id': 3, u'resource_uri': u'/MAAS/api/2.0/subnets/3/'}, u'ip_address': u'192.168.11.38'}], u'system_id': u'b7ggd7', u'params': u'', u'mac_address': u'9c:b6:54:8a:10:18', u'parents': [], u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/b7ggd7/interfaces/4/'}, u'node_type': 0, u'tag_names': [], u'swap_size': None, u'owner': None, u'pod': None, u'cache_sets': [], u'iscsiblockdevice_set': [], u'status_action': u'', 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'used_for': u'MBR partitioned with 1 partition', u'path': u'/dev/disk/by-dname/sda', u'system_id': u'b7ggd7', u'partition_table_type': u'MBR', u'filesystem': None, u'id_path': u'/dev/disk/by-id/wwn-0x600508b1001cb19198eb9a66f8a29401', u'available_size': 0, u'serial': u'600508b1001cb19198eb9a66f8a29401', u'resource_uri': u'/MAAS/api/2.0/nodes/b7ggd7/blockdevices/1/', u'type': u'physical', u'model': u'LOGICAL VOLUME', u'partitions': [{u'size': 800101236736, u'uuid': u'b38f27fa-7e96-471a-87fd-d08a64f08c89', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'b7ggd7', u'filesystem': {u'uuid': u'd7704b94-e329-4554-b702-7d0910350070', 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'resource_uri': u'/MAAS/api/2.0/nodes/b7ggd7/blockdevices/1/partition/6', u'type': u'partition', u'id': 6, u'device_id': 1}]}, {u'size': 107374182400, u'block_size': 4096, u'uuid': u'9f5316bd-e516-4cba-b6be-681a99722455', u'name': u'vgroot-lvroot', u'tags': [], u'used_size': 107374182400, u'id': 11, u'used_for': u'ext4 formatted filesystem mounted at /', u'path': u'/dev/disk/by-dname/lvroot', u'system_id': u'b7ggd7', u'partition_table_type': None, u'filesystem': {u'uuid': u'9da18562-59dd-4f39-adbd-64bea07a6733', u'label': u'root', u'mount_point': u'/', u'mount_options': None, u'fstype': u'ext4'}, u'id_path': None, u'available_size': 0, u'serial': None, u'resource_uri': u'/MAAS/api/2.0/nodes/b7ggd7/blockdevices/11/', u'type': u'virtual', u'model': None, u'partitions': []}], u'zone': {u'description': u'', u'id': 1, u'name': u'default', u'resource_uri': u'/MAAS/api/2.0/zones/default/'}, u'current_commissioning_result_id': 2, u'node_type_name': u'Machine', u'hostname': u'cmp002', u'storage': 800109.715456, u'testing_status': 2, u'system_id': u'b7ggd7', u'raids': [], u'memory': 65536, u'current_installation_result_id': None, u'default_gateways': {u'ipv4': {u'gateway_ip': u'192.168.11.3', u'link_id': None}, u'ipv6': {u'gateway_ip': None, u'link_id': None}}, u'status_message': u'Power state queried: off', u'disable_ipv4': False, u'min_hwe_kernel': u'hwe-16.04', 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'block_size': 4096, u'uuid': None, u'name': u'sda', u'tags': [u'ssd'], u'used_size': 800106479616, u'used_for': u'MBR partitioned with 1 partition', u'path': u'/dev/disk/by-dname/sda', u'system_id': u'b7ggd7', u'partition_table_type': u'MBR', u'filesystem': None, u'id_path': u'/dev/disk/by-id/wwn-0x600508b1001cb19198eb9a66f8a29401', u'available_size': 0, u'model': u'LOGICAL VOLUME', u'resource_uri': u'/MAAS/api/2.0/nodes/b7ggd7/blockdevices/1/', u'type': u'physical', u'id': 1, u'serial': u'600508b1001cb19198eb9a66f8a29401', u'partitions': [{u'size': 800101236736, u'uuid': u'b38f27fa-7e96-471a-87fd-d08a64f08c89', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'b7ggd7', u'filesystem': {u'uuid': u'd7704b94-e329-4554-b702-7d0910350070', 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'resource_uri': u'/MAAS/api/2.0/nodes/b7ggd7/blockdevices/1/partition/6', u'type': u'partition', u'id': 6, u'device_id': 1}]}], u'other_test_status_name': u'Unknown', u'volume_groups': [{u'__incomplete__': True, u'system_id': u'b7ggd7', u'id': 6}], u'special_filesystems': [], u'cpu_test_status_name': u'Unknown', u'boot_disk': {u'size': 800109715456, u'block_size': 4096, u'uuid': None, u'name': u'sda', u'tags': [u'ssd'], u'used_size': 800106479616, u'used_for': u'MBR partitioned with 1 partition', u'path': u'/dev/disk/by-dname/sda', u'system_id': u'b7ggd7', u'partition_table_type': u'MBR', u'filesystem': None, u'id_path': u'/dev/disk/by-id/wwn-0x600508b1001cb19198eb9a66f8a29401', u'available_size': 0, u'model': u'LOGICAL VOLUME', u'resource_uri': u'/MAAS/api/2.0/nodes/b7ggd7/blockdevices/1/', u'type': u'physical', u'id': 1, u'serial': u'600508b1001cb19198eb9a66f8a29401', u'partitions': [{u'size': 800101236736, u'uuid': u'b38f27fa-7e96-471a-87fd-d08a64f08c89', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'b7ggd7', u'filesystem': {u'uuid': u'd7704b94-e329-4554-b702-7d0910350070', 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'resource_uri': u'/MAAS/api/2.0/nodes/b7ggd7/blockdevices/1/partition/6', u'type': u'partition', u'id': 6, u'device_id': 1}]}, u'current_testing_result_id': 3, u'cpu_test_status': -1, u'storage_test_status': 2, u'status_name': u'Ready', u'netboot': True, u'osystem': u'', u'fqdn': u'cmp002.maas', u'memory_test_status_name': u'Unknown', u'virtualblockdevice_set': [{u'size': 107374182400, u'block_size': 4096, u'uuid': u'9f5316bd-e516-4cba-b6be-681a99722455', u'name': u'vgroot-lvroot', u'tags': [], u'used_size': 107374182400, u'used_for': u'ext4 formatted filesystem mounted at /', u'path': u'/dev/disk/by-dname/vgroot-lvroot', u'system_id': u'b7ggd7', u'partition_table_type': None, u'filesystem': {u'uuid': u'9da18562-59dd-4f39-adbd-64bea07a6733', u'label': u'root', u'mount_point': u'/', u'mount_options': None, u'fstype': u'ext4'}, u'id_path': None, u'available_size': 0, u'model': None, u'resource_uri': u'/MAAS/api/2.0/nodes/b7ggd7/blockdevices/11/', u'type': u'virtual', u'id': 11, u'serial': None, u'partitions': []}], 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'dhcp_on': True, u'fabric_id': 2, u'mtu': 1500, u'external_dhcp': None, u'fabric': u'pxe_admin', u'relay_vlan': None, u'primary_rack': u'nq3wtr', u'id': 5003, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/'}, u'allow_proxy': True, u'rdns_mode': 2, u'gateway_ip': u'192.168.11.3', u'active_discovery': False, u'cidr': u'192.168.11.0/24', u'id': 3, u'resource_uri': u'/MAAS/api/2.0/subnets/3/'}, u'ip_address': u'192.168.11.38', u'mode': u'dhcp', u'id': 18}], u'tags': [u'sriov'], u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'dhcp_on': True, u'fabric_id': 2, u'mtu': 1500, u'external_dhcp': None, u'fabric': u'pxe_admin', u'relay_vlan': None, u'primary_rack': u'nq3wtr', u'id': 5003, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/'}, u'enabled': True, u'effective_mtu': 1500, 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'name': u'untagged', u'vid': 0, u'space': u'undefined', u'dhcp_on': True, u'fabric_id': 2, u'mtu': 1500, u'external_dhcp': None, u'fabric': u'pxe_admin', u'relay_vlan': None, u'primary_rack': u'nq3wtr', u'id': 5003, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/'}, u'allow_proxy': True, u'rdns_mode': 2, u'gateway_ip': u'192.168.11.3', u'active_discovery': False, u'cidr': u'192.168.11.0/24', u'id': 3, u'resource_uri': u'/MAAS/api/2.0/subnets/3/'}, u'ip_address': u'192.168.11.38'}], u'system_id': u'b7ggd7', u'params': u'', u'mac_address': u'9c:b6:54:8a:10:18', u'parents': [], u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/b7ggd7/interfaces/4/'}, {u'name': u'ens1f0', u'links': [], u'tags': [u'sriov'], u'vlan': None, u'enabled': True, u'effective_mtu': 1500, u'id': 15, u'discovered': None, u'system_id': u'b7ggd7', u'params': u'', u'mac_address': u'38:ea:a7:8f:07:50', u'parents': [], u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/b7ggd7/interfaces/15/'}, {u'name': u'ens2f0', u'links': [{u'mode': u'link_up', u'id': 19}], u'tags': [u'sriov'], u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'dhcp_on': False, u'fabric_id': 0, u'mtu': 1500, u'external_dhcp': None, u'fabric': u'fabric-0', u'relay_vlan': None, u'primary_rack': None, u'id': 5001, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/'}, u'enabled': True, u'effective_mtu': 1500, u'id': 13, u'discovered': None, u'system_id': u'b7ggd7', u'params': u'', u'mac_address': u'38:ea:a7:8f:12:48', u'parents': [], u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/b7ggd7/interfaces/13/'}, {u'name': u'eno2', u'links': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'dhcp_on': True, u'fabric_id': 2, u'mtu': 1500, u'external_dhcp': None, u'fabric': u'pxe_admin', u'relay_vlan': None, u'primary_rack': u'nq3wtr', 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'mode': u'link_up', u'id': 20}], u'tags': [u'sriov'], u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'dhcp_on': True, u'fabric_id': 2, u'mtu': 1500, u'external_dhcp': None, u'fabric': u'pxe_admin', u'relay_vlan': None, u'primary_rack': u'nq3wtr', u'id': 5003, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/'}, u'enabled': True, u'effective_mtu': 1500, u'id': 14, u'discovered': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'dhcp_on': True, u'fabric_id': 2, u'mtu': 1500, u'external_dhcp': None, u'fabric': u'pxe_admin', u'relay_vlan': None, u'primary_rack': u'nq3wtr', 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.40'}], u'system_id': u'b7ggd7', u'params': u'', u'mac_address': u'9c:b6:54:8a:10:1c', u'parents': [], u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/b7ggd7/interfaces/14/'}, {u'name': u'ens2f1', u'links': [{u'mode': u'link_up', u'id': 21}], u'tags': [u'sriov'], u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'dhcp_on': False, u'fabric_id': 0, u'mtu': 1500, u'external_dhcp': None, u'fabric': u'fabric-0', u'relay_vlan': None, u'primary_rack': None, u'id': 5001, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/'}, u'enabled': True, u'effective_mtu': 1500, u'id': 11, u'discovered': None, u'system_id': u'b7ggd7', u'params': u'', u'mac_address': u'38:ea:a7:8f:12:49', u'parents': [], u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/b7ggd7/interfaces/11/'}, {u'name': u'ens1f1', u'links': [], u'tags': [u'sriov'], u'vlan': None, u'enabled': True, u'effective_mtu': 1500, u'id': 12, u'discovered': None, u'system_id': u'b7ggd7', u'params': u'', u'mac_address': u'38:ea:a7:8f:07:51', u'parents': [], u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/b7ggd7/interfaces/12/'}], u'address_ttl': None, u'other_test_status': -1, u'distro_series': u'', u'resource_uri': u'/MAAS/api/2.0/machines/b7ggd7/'}
2019-04-19 05:18:43,654 [salt.state       :300 ][INFO    ][7226] {'new': {'storage_layout': 'lvm'}}
2019-04-19 05:18:43,654 [salt.state       :1951][INFO    ][7226] Completed state [maas_machines_storage_cmp002_lvm] at time 05:18:43.654272 duration_in_ms=2302.75
2019-04-19 05:18:43,654 [salt.state       :1780][INFO    ][7226] Running state [maas_machines_storage_cmp001_lvm] at time 05:18:43.654687
2019-04-19 05:18:43,656 [salt.state       :1813][INFO    ][7226] Executing state maasng.disk_layout_present for [maas_machines_storage_cmp001_lvm]
2019-04-19 05:18:44,848 [salt.loaded.ext.module.maasng:610 ][INFO    ][7226] mhpe3r
2019-04-19 05:18:44,849 [salt.loaded.ext.module.maasng:626 ][INFO    ][7226] sda
2019-04-19 05:18:45,320 [salt.loaded.ext.module.maasng:361 ][INFO    ][7226] mhpe3r
2019-04-19 05:18:45,396 [salt.loaded.ext.module.maasng:367 ][INFO    ][7226] [{u'size': 800109715456, u'available_size': 0, u'uuid': None, u'tags': [u'ssd'], u'used_for': u'MBR partitioned with 1 partition', u'type': u'physical', u'partitions': [{u'size': 800101236736, u'uuid': u'6e89392e-91df-4948-9a3d-0678f70d36ef', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'mhpe3r', u'filesystem': {u'uuid': u'f321bd16-965a-45b1-b3a0-98cf9cd683f8', u'fstype': u'lvm-pv', u'mount_point': None, u'mount_options': None, u'label': None}, u'path': u'/dev/disk/by-dname/sda-part1', u'resource_uri': u'/MAAS/api/2.0/nodes/mhpe3r/blockdevices/2/partition/2', u'type': u'partition', u'id': 2, u'device_id': 2}], u'name': u'sda', u'system_id': u'mhpe3r', u'partition_table_type': u'MBR', u'filesystem': None, u'id_path': u'/dev/disk/by-id/wwn-0x600508b1001cd7e61f5cd3479576479e', u'path': u'/dev/disk/by-dname/sda', u'model': u'LOGICAL VOLUME', u'block_size': 4096, u'used_size': 800106479616, u'id': 2, u'serial': u'600508b1001cd7e61f5cd3479576479e', u'resource_uri': u'/MAAS/api/2.0/nodes/mhpe3r/blockdevices/2/'}, {u'size': 800097042432, u'available_size': 0, u'uuid': u'724e5e72-6161-4dde-98df-cfde7da2046b', u'tags': [], u'used_for': u'ext4 formatted filesystem mounted at /', u'type': u'virtual', u'partitions': [], u'name': u'vgroot-lvroot', u'system_id': u'mhpe3r', u'partition_table_type': None, u'filesystem': {u'uuid': u'efb7f7bf-5a53-49d1-ac6d-2cf7f3797e37', u'fstype': u'ext4', u'mount_point': u'/', u'mount_options': None, u'label': u'root'}, u'id_path': None, u'path': u'/dev/disk/by-dname/lvroot', u'model': None, u'block_size': 4096, u'used_size': 800097042432, u'id': 4, u'serial': None, u'resource_uri': u'/MAAS/api/2.0/nodes/mhpe3r/blockdevices/4/'}]
2019-04-19 05:18:45,397 [salt.loaded.ext.module.maasng:632 ][INFO    ][7226] vgroot
2019-04-19 05:18:45,397 [salt.loaded.ext.module.maasng:635 ][INFO    ][7226] lvroot
2019-04-19 05:18:45,397 [salt.loaded.ext.module.maasng:639 ][INFO    ][7226] 107374182400
2019-04-19 05:18:45,885 [salt.loaded.ext.module.maasng:645 ][INFO    ][7226] {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'memory_test_status': -1, u'ip_addresses': [u'192.168.11.39', u'192.168.11.44'], u'cpu_count': 40, u'owner_data': {}, u'hwe_kernel': u'', u'boot_interface': {u'name': u'eno1', u'links': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'dhcp_on': True, u'fabric_id': 2, u'mtu': 1500, u'external_dhcp': None, u'fabric': u'pxe_admin', u'relay_vlan': None, u'primary_rack': u'nq3wtr', u'id': 5003, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/'}, u'allow_proxy': True, u'rdns_mode': 2, u'gateway_ip': u'192.168.11.3', u'active_discovery': False, u'cidr': u'192.168.11.0/24', u'id': 3, u'resource_uri': u'/MAAS/api/2.0/subnets/3/'}, u'ip_address': u'192.168.11.39', u'mode': u'dhcp', u'id': 24}], u'tags': [u'sriov'], u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'dhcp_on': True, u'fabric_id': 2, u'mtu': 1500, u'external_dhcp': None, u'fabric': u'pxe_admin', u'relay_vlan': None, u'primary_rack': u'nq3wtr', u'id': 5003, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/'}, u'enabled': True, u'effective_mtu': 1500, u'id': 5, u'discovered': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'dhcp_on': True, u'fabric_id': 2, u'mtu': 1500, u'external_dhcp': None, u'fabric': u'pxe_admin', u'relay_vlan': None, u'primary_rack': u'nq3wtr', 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'system_id': u'mhpe3r', u'params': u'', u'mac_address': u'9c:b6:54:8a:95:a0', u'parents': [], u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/mhpe3r/interfaces/5/'}, u'node_type': 0, u'tag_names': [], u'swap_size': None, u'owner': None, u'pod': None, u'cache_sets': [], u'iscsiblockdevice_set': [], u'status_action': u'', 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': 2, u'used_for': u'MBR partitioned with 1 partition', u'path': u'/dev/disk/by-dname/sda', u'system_id': u'mhpe3r', u'partition_table_type': u'MBR', u'filesystem': None, u'id_path': u'/dev/disk/by-id/wwn-0x600508b1001cd7e61f5cd3479576479e', u'available_size': 0, u'serial': u'600508b1001cd7e61f5cd3479576479e', u'resource_uri': u'/MAAS/api/2.0/nodes/mhpe3r/blockdevices/2/', u'type': u'physical', u'model': u'LOGICAL VOLUME', u'partitions': [{u'size': 800101236736, u'uuid': u'32614bfc-ef72-4f66-a8a2-b20e78c66da6', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'mhpe3r', u'filesystem': {u'uuid': u'c1b7f545-2bf6-476f-bfb9-9b3f5588141f', 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'resource_uri': u'/MAAS/api/2.0/nodes/mhpe3r/blockdevices/2/partition/7', u'type': u'partition', u'id': 7, u'device_id': 2}]}, {u'size': 107374182400, u'block_size': 4096, u'uuid': u'cd65193b-b8e6-445f-8564-eaa2eb217764', u'name': u'vgroot-lvroot', u'tags': [], u'used_size': 107374182400, u'id': 12, u'used_for': u'ext4 formatted filesystem mounted at /', u'path': u'/dev/disk/by-dname/lvroot', u'system_id': u'mhpe3r', u'partition_table_type': None, u'filesystem': {u'uuid': u'58c9a007-b2f2-485e-a0cb-5ed3a25acde7', u'label': u'root', u'mount_point': u'/', u'mount_options': None, u'fstype': u'ext4'}, u'id_path': None, u'available_size': 0, u'serial': None, u'resource_uri': u'/MAAS/api/2.0/nodes/mhpe3r/blockdevices/12/', u'type': u'virtual', u'model': None, u'partitions': []}], u'zone': {u'description': u'', u'id': 1, u'name': u'default', u'resource_uri': u'/MAAS/api/2.0/zones/default/'}, 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'mhpe3r', u'raids': [], u'memory': 65536, u'current_installation_result_id': None, u'default_gateways': {u'ipv4': {u'gateway_ip': u'192.168.11.3', u'link_id': None}, u'ipv6': {u'gateway_ip': None, u'link_id': None}}, u'status_message': u'Power state queried: off', u'disable_ipv4': False, u'min_hwe_kernel': u'hwe-16.04', 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'block_size': 4096, u'uuid': None, u'name': u'sda', u'tags': [u'ssd'], u'used_size': 800106479616, u'used_for': u'MBR partitioned with 1 partition', u'path': u'/dev/disk/by-dname/sda', u'system_id': u'mhpe3r', 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'resource_uri': u'/MAAS/api/2.0/nodes/mhpe3r/blockdevices/2/', u'type': u'physical', u'id': 2, u'serial': u'600508b1001cd7e61f5cd3479576479e', u'partitions': [{u'size': 800101236736, u'uuid': u'32614bfc-ef72-4f66-a8a2-b20e78c66da6', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'mhpe3r', u'filesystem': {u'uuid': u'c1b7f545-2bf6-476f-bfb9-9b3f5588141f', 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'resource_uri': u'/MAAS/api/2.0/nodes/mhpe3r/blockdevices/2/partition/7', u'type': u'partition', u'id': 7, u'device_id': 2}]}], u'other_test_status_name': u'Unknown', u'volume_groups': [{u'__incomplete__': True, u'system_id': u'mhpe3r', u'id': 7}], u'special_filesystems': [], u'cpu_test_status_name': u'Unknown', u'boot_disk': {u'size': 800109715456, u'block_size': 4096, u'uuid': None, u'name': u'sda', u'tags': [u'ssd'], u'used_size': 800106479616, u'used_for': u'MBR partitioned with 1 partition', u'path': u'/dev/disk/by-dname/sda', u'system_id': u'mhpe3r', 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'resource_uri': u'/MAAS/api/2.0/nodes/mhpe3r/blockdevices/2/', u'type': u'physical', u'id': 2, u'serial': u'600508b1001cd7e61f5cd3479576479e', u'partitions': [{u'size': 800101236736, u'uuid': u'32614bfc-ef72-4f66-a8a2-b20e78c66da6', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'mhpe3r', u'filesystem': {u'uuid': u'c1b7f545-2bf6-476f-bfb9-9b3f5588141f', 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'resource_uri': u'/MAAS/api/2.0/nodes/mhpe3r/blockdevices/2/partition/7', u'type': u'partition', u'id': 7, u'device_id': 2}]}, u'current_testing_result_id': 5, u'cpu_test_status': -1, u'storage_test_status': 2, u'status_name': u'Ready', u'netboot': True, u'osystem': u'', u'fqdn': u'cmp001.maas', u'memory_test_status_name': u'Unknown', u'virtualblockdevice_set': [{u'size': 107374182400, u'block_size': 4096, u'uuid': u'cd65193b-b8e6-445f-8564-eaa2eb217764', u'name': u'vgroot-lvroot', u'tags': [], u'used_size': 107374182400, u'used_for': u'ext4 formatted filesystem mounted at /', u'path': u'/dev/disk/by-dname/vgroot-lvroot', u'system_id': u'mhpe3r', u'partition_table_type': None, u'filesystem': {u'uuid': u'58c9a007-b2f2-485e-a0cb-5ed3a25acde7', u'label': u'root', u'mount_point': u'/', u'mount_options': None, u'fstype': u'ext4'}, u'id_path': None, u'available_size': 0, u'model': None, u'resource_uri': u'/MAAS/api/2.0/nodes/mhpe3r/blockdevices/12/', u'type': u'virtual', u'id': 12, u'serial': None, u'partitions': []}], 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'dhcp_on': True, u'fabric_id': 2, u'mtu': 1500, u'external_dhcp': None, u'fabric': u'pxe_admin', u'relay_vlan': None, u'primary_rack': u'nq3wtr', u'id': 5003, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/'}, u'allow_proxy': True, u'rdns_mode': 2, u'gateway_ip': u'192.168.11.3', u'active_discovery': False, u'cidr': u'192.168.11.0/24', u'id': 3, u'resource_uri': u'/MAAS/api/2.0/subnets/3/'}, u'ip_address': u'192.168.11.39', u'mode': u'dhcp', u'id': 24}], u'tags': [u'sriov'], u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'dhcp_on': True, u'fabric_id': 2, u'mtu': 1500, u'external_dhcp': None, u'fabric': u'pxe_admin', u'relay_vlan': None, u'primary_rack': u'nq3wtr', u'id': 5003, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/'}, u'enabled': True, u'effective_mtu': 1500, u'id': 5, u'discovered': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'dhcp_on': True, u'fabric_id': 2, u'mtu': 1500, u'external_dhcp': None, u'fabric': u'pxe_admin', u'relay_vlan': None, u'primary_rack': u'nq3wtr', 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'system_id': u'mhpe3r', u'params': u'', u'mac_address': u'9c:b6:54:8a:95:a0', u'parents': [], u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/mhpe3r/interfaces/5/'}, {u'name': u'ens1f1', u'links': [], u'tags': [u'sriov'], u'vlan': None, u'enabled': True, u'effective_mtu': 1500, u'id': 17, u'discovered': None, u'system_id': u'mhpe3r', u'params': u'', u'mac_address': u'38:ea:a7:8f:1f:d5', u'parents': [], u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/mhpe3r/interfaces/17/'}, {u'name': u'ens1f0', u'links': [], u'tags': [u'sriov'], u'vlan': None, u'enabled': True, u'effective_mtu': 1500, u'id': 20, u'discovered': None, u'system_id': u'mhpe3r', u'params': u'', u'mac_address': u'38:ea:a7:8f:1f:d4', u'parents': [], u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/mhpe3r/interfaces/20/'}, {u'name': u'ens2f1', u'links': [{u'mode': u'link_up', u'id': 25}], u'tags': [u'sriov'], u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'dhcp_on': False, u'fabric_id': 0, u'mtu': 1500, u'external_dhcp': None, u'fabric': u'fabric-0', u'relay_vlan': None, u'primary_rack': None, u'id': 5001, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/'}, u'enabled': True, u'effective_mtu': 1500, u'id': 16, u'discovered': None, u'system_id': u'mhpe3r', u'params': u'', u'mac_address': u'38:ea:a7:8f:52:cd', u'parents': [], u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/mhpe3r/interfaces/16/'}, {u'name': u'ens2f0', u'links': [{u'mode': u'link_up', u'id': 26}], u'tags': [u'sriov'], u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'dhcp_on': False, u'fabric_id': 0, u'mtu': 1500, u'external_dhcp': None, u'fabric': u'fabric-0', u'relay_vlan': None, u'primary_rack': None, u'id': 5001, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/'}, u'enabled': True, u'effective_mtu': 1500, u'id': 18, u'discovered': None, u'system_id': u'mhpe3r', u'params': u'', u'mac_address': u'38:ea:a7:8f:52:cc', u'parents': [], u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/mhpe3r/interfaces/18/'}, {u'name': u'eno2', u'links': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'dhcp_on': True, u'fabric_id': 2, u'mtu': 1500, u'external_dhcp': None, u'fabric': u'pxe_admin', u'relay_vlan': None, u'primary_rack': u'nq3wtr', 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'mode': u'link_up', u'id': 27}], u'tags': [u'sriov'], u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'dhcp_on': True, u'fabric_id': 2, u'mtu': 1500, u'external_dhcp': None, u'fabric': u'pxe_admin', u'relay_vlan': None, u'primary_rack': u'nq3wtr', u'id': 5003, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/'}, u'enabled': True, u'effective_mtu': 1500, u'id': 19, u'discovered': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'dhcp_on': True, u'fabric_id': 2, u'mtu': 1500, u'external_dhcp': None, u'fabric': u'pxe_admin', u'relay_vlan': None, u'primary_rack': u'nq3wtr', 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'system_id': u'mhpe3r', u'params': u'', u'mac_address': u'9c:b6:54:8a:95:a4', u'parents': [], u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/mhpe3r/interfaces/19/'}], u'address_ttl': None, u'other_test_status': -1, u'distro_series': u'', u'resource_uri': u'/MAAS/api/2.0/machines/mhpe3r/'}
2019-04-19 05:18:45,887 [salt.state       :300 ][INFO    ][7226] {'new': {'storage_layout': 'lvm'}}
2019-04-19 05:18:45,887 [salt.state       :1951][INFO    ][7226] Completed state [maas_machines_storage_cmp001_lvm] at time 05:18:45.887819 duration_in_ms=2233.131
2019-04-19 05:18:45,890 [salt.minion      :1711][INFO    ][7226] Returning information for job: 20190419051831150708
2019-04-19 05:18:46,558 [salt.minion      :1308][INFO    ][3401] User sudo_ubuntu Executing command state.apply with jid 20190419051846546960
2019-04-19 05:18:46,579 [salt.minion      :1432][INFO    ][7270] Starting a new job with PID 7270
2019-04-19 05:18:47,765 [salt.state       :915 ][INFO    ][7270] Loading fresh modules for state activity
2019-04-19 05:18:47,821 [salt.fileclient  :1219][INFO    ][7270] Fetching file from saltenv 'base', ** done ** 'maas/machines/deploy.sls'
2019-04-19 05:18:47,869 [salt.state       :1780][INFO    ][7270] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 05:18:47.868994
2019-04-19 05:18:47,869 [salt.state       :1813][INFO    ][7270] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2019-04-19 05:18:47,871 [salt.loaded.int.module.cmdmod:395 ][INFO    ][7270] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2019-04-19 05:18:49,813 [salt.state       :300 ][INFO    ][7270] {'pid': 7277, 'retcode': 0, 'stderr': '', 'stdout': ''}
2019-04-19 05:18:49,814 [salt.state       :1951][INFO    ][7270] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 05:18:49.814584 duration_in_ms=1945.591
2019-04-19 05:18:49,818 [salt.state       :1780][INFO    ][7270] Running state [maas.deploy_machines] at time 05:18:49.817988
2019-04-19 05:18:49,818 [salt.state       :1813][INFO    ][7270] Executing state module.run for [maas.deploy_machines]
2019-04-19 05:18:49,820 [salt.utils.decorators:613 ][WARNING ][7270] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-04-19 05:18:50,336 [salt.loaded.ext.module.maas:684 ][INFO    ][7270] deploymachines hwe_kernel=hwe-16.04 system_id=b7ggd7 distro_series=xenial
2019-04-19 05:18:52,702 [salt.loaded.ext.module.maas:684 ][INFO    ][7270] deploymachines hwe_kernel=hwe-16.04 system_id=mhpe3r distro_series=xenial
2019-04-19 05:18:55,088 [salt.loaded.ext.module.maas:684 ][INFO    ][7270] deploymachines hwe_kernel=hwe-16.04 system_id=6kxey8 distro_series=xenial
2019-04-19 05:18:57,456 [salt.loaded.ext.module.maas:684 ][INFO    ][7270] deploymachines hwe_kernel=hwe-16.04 system_id=qycnbx distro_series=xenial
2019-04-19 05:18:59,828 [salt.loaded.ext.module.maas:684 ][INFO    ][7270] deploymachines hwe_kernel=hwe-16.04 system_id=sfnyke distro_series=xenial
2019-04-19 05:19:01,617 [salt.minion      :1308][INFO    ][3401] User sudo_ubuntu Executing command saltutil.find_job with jid 20190419051901608868
2019-04-19 05:19:01,636 [salt.minion      :1432][INFO    ][7554] Starting a new job with PID 7554
2019-04-19 05:19:01,661 [salt.minion      :1711][INFO    ][7554] Returning information for job: 20190419051901608868
2019-04-19 05:19:02,099 [salt.state       :300 ][INFO    ][7270] {'ret': {'updated': [], 'errors': {}, 'success': ['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']}}
2019-04-19 05:19:02,099 [salt.state       :1951][INFO    ][7270] Completed state [maas.deploy_machines] at time 05:19:02.099510 duration_in_ms=12281.52
2019-04-19 05:19:02,102 [salt.minion      :1711][INFO    ][7270] Returning information for job: 20190419051846546960
2019-04-19 05:19:02,813 [salt.minion      :1308][INFO    ][3401] User sudo_ubuntu Executing command state.apply with jid 20190419051902797795
2019-04-19 05:19:02,830 [salt.minion      :1432][INFO    ][7573] Starting a new job with PID 7573
2019-04-19 05:19:11,012 [salt.state       :915 ][INFO    ][7573] Loading fresh modules for state activity
2019-04-19 05:19:11,072 [salt.fileclient  :1219][INFO    ][7573] Fetching file from saltenv 'base', ** done ** 'maas/machines/wait_for_deployed.sls'
2019-04-19 05:19:11,123 [salt.state       :1780][INFO    ][7573] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 05:19:11.123597
2019-04-19 05:19:11,123 [salt.state       :1813][INFO    ][7573] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2019-04-19 05:19:11,125 [salt.loaded.int.module.cmdmod:395 ][INFO    ][7573] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2019-04-19 05:19:13,081 [salt.state       :300 ][INFO    ][7573] {'pid': 7589, 'retcode': 0, 'stderr': '', 'stdout': ''}
2019-04-19 05:19:13,082 [salt.state       :1951][INFO    ][7573] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 05:19:13.081978 duration_in_ms=1958.382
2019-04-19 05:19:13,085 [salt.state       :1780][INFO    ][7573] Running state [maas.wait_for_machine_status] at time 05:19:13.085216
2019-04-19 05:19:13,085 [salt.state       :1813][INFO    ][7573] Executing state module.run for [maas.wait_for_machine_status]
2019-04-19 05:19:13,086 [salt.utils.decorators:613 ][WARNING ][7573] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-04-19 05:19:15,955 [salt.loaded.ext.module.maas:1023][INFO    ][7573] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2247.1436739s left)
2019-04-19 05:19:17,873 [salt.minion      :1308][INFO    ][3401] User sudo_ubuntu Executing command saltutil.find_job with jid 20190419051917862317
2019-04-19 05:19:17,890 [salt.minion      :1432][INFO    ][7600] Starting a new job with PID 7600
2019-04-19 05:19:17,918 [salt.minion      :1711][INFO    ][7600] Returning information for job: 20190419051917862317
2019-04-19 05:19:47,933 [salt.minion      :1308][INFO    ][3401] User sudo_ubuntu Executing command saltutil.find_job with jid 20190419051947923438
2019-04-19 05:19:47,950 [salt.minion      :1432][INFO    ][7668] Starting a new job with PID 7668
2019-04-19 05:19:47,979 [salt.minion      :1711][INFO    ][7668] Returning information for job: 20190419051947923438
2019-04-19 05:19:48,708 [salt.loaded.ext.module.maas:1023][INFO    ][7573] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2214.38999391s left)
2019-04-19 05:20:18,026 [salt.minion      :1308][INFO    ][3401] User sudo_ubuntu Executing command saltutil.find_job with jid 20190419052018011088
2019-04-19 05:20:18,049 [salt.minion      :1432][INFO    ][7694] Starting a new job with PID 7694
2019-04-19 05:20:18,079 [salt.minion      :1711][INFO    ][7694] Returning information for job: 20190419052018011088
2019-04-19 05:20:21,670 [salt.loaded.ext.module.maas:1023][INFO    ][7573] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2181.42800808s left)
2019-04-19 05:20:48,082 [salt.minion      :1308][INFO    ][3401] User sudo_ubuntu Executing command saltutil.find_job with jid 20190419052048065690
2019-04-19 05:20:48,108 [salt.minion      :1432][INFO    ][7781] Starting a new job with PID 7781
2019-04-19 05:20:48,143 [salt.minion      :1711][INFO    ][7781] Returning information for job: 20190419052048065690
2019-04-19 05:20:54,492 [salt.loaded.ext.module.maas:1023][INFO    ][7573] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2148.60600686s left)
2019-04-19 05:21:18,165 [salt.minion      :1308][INFO    ][3401] User sudo_ubuntu Executing command saltutil.find_job with jid 20190419052118148948
2019-04-19 05:21:18,189 [salt.minion      :1432][INFO    ][7816] Starting a new job with PID 7816
2019-04-19 05:21:18,217 [salt.minion      :1711][INFO    ][7816] Returning information for job: 20190419052118148948
2019-04-19 05:21:27,002 [salt.loaded.ext.module.maas:1023][INFO    ][7573] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2116.09595299s left)
2019-04-19 05:21:48,212 [salt.minion      :1308][INFO    ][3401] User sudo_ubuntu Executing command saltutil.find_job with jid 20190419052148197691
2019-04-19 05:21:48,230 [salt.minion      :1432][INFO    ][7901] Starting a new job with PID 7901
2019-04-19 05:21:48,254 [salt.minion      :1711][INFO    ][7901] Returning information for job: 20190419052148197691
2019-04-19 05:21:59,644 [salt.loaded.ext.module.maas:1023][INFO    ][7573] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2083.45395088s left)
2019-04-19 05:22:18,241 [salt.minion      :1308][INFO    ][3401] User sudo_ubuntu Executing command saltutil.find_job with jid 20190419052218231921
2019-04-19 05:22:18,253 [salt.minion      :1432][INFO    ][7983] Starting a new job with PID 7983
2019-04-19 05:22:18,278 [salt.minion      :1711][INFO    ][7983] Returning information for job: 20190419052218231921
2019-04-19 05:22:33,319 [salt.loaded.ext.module.maas:1023][INFO    ][7573] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2049.7794559s left)
2019-04-19 05:22:48,298 [salt.minion      :1308][INFO    ][3401] User sudo_ubuntu Executing command saltutil.find_job with jid 20190419052248287705
2019-04-19 05:22:48,319 [salt.minion      :1432][INFO    ][8278] Starting a new job with PID 8278
2019-04-19 05:22:48,347 [salt.minion      :1711][INFO    ][8278] Returning information for job: 20190419052248287705
2019-04-19 05:23:05,984 [salt.loaded.ext.module.maas:1023][INFO    ][7573] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2017.11514091s left)
2019-04-19 05:23:18,322 [salt.minion      :1308][INFO    ][3401] User sudo_ubuntu Executing command saltutil.find_job with jid 20190419052318315372
2019-04-19 05:23:18,336 [salt.minion      :1432][INFO    ][8371] Starting a new job with PID 8371
2019-04-19 05:23:18,362 [salt.minion      :1711][INFO    ][8371] Returning information for job: 20190419052318315372
2019-04-19 05:23:38,718 [salt.loaded.ext.module.maas:1023][INFO    ][7573] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1984.38389993s left)
2019-04-19 05:23:48,388 [salt.minion      :1308][INFO    ][3401] User sudo_ubuntu Executing command saltutil.find_job with jid 20190419052348378741
2019-04-19 05:23:48,405 [salt.minion      :1432][INFO    ][8638] Starting a new job with PID 8638
2019-04-19 05:23:48,440 [salt.minion      :1711][INFO    ][8638] Returning information for job: 20190419052348378741
2019-04-19 05:24:11,274 [salt.loaded.ext.module.maas:1023][INFO    ][7573] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1951.82443309s left)
2019-04-19 05:24:18,431 [salt.minion      :1308][INFO    ][3401] User sudo_ubuntu Executing command saltutil.find_job with jid 20190419052418423668
2019-04-19 05:24:18,444 [salt.minion      :1432][INFO    ][8690] Starting a new job with PID 8690
2019-04-19 05:24:18,471 [salt.minion      :1711][INFO    ][8690] Returning information for job: 20190419052418423668
2019-04-19 05:24:44,375 [salt.loaded.ext.module.maas:1023][INFO    ][7573] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1918.72340894s left)
2019-04-19 05:24:48,571 [salt.minion      :1308][INFO    ][3401] User sudo_ubuntu Executing command saltutil.find_job with jid 20190419052448559722
2019-04-19 05:24:48,586 [salt.minion      :1432][INFO    ][9251] Starting a new job with PID 9251
2019-04-19 05:24:48,617 [salt.minion      :1711][INFO    ][9251] Returning information for job: 20190419052448559722
2019-04-19 05:25:17,437 [salt.loaded.ext.module.maas:1023][INFO    ][7573] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1885.66128087s left)
2019-04-19 05:25:18,649 [salt.minion      :1308][INFO    ][3401] User sudo_ubuntu Executing command saltutil.find_job with jid 20190419052518639988
2019-04-19 05:25:18,670 [salt.minion      :1432][INFO    ][9292] Starting a new job with PID 9292
2019-04-19 05:25:18,700 [salt.minion      :1711][INFO    ][9292] Returning information for job: 20190419052518639988
2019-04-19 05:25:48,818 [salt.minion      :1308][INFO    ][3401] User sudo_ubuntu Executing command saltutil.find_job with jid 20190419052548806555
2019-04-19 05:25:48,838 [salt.minion      :1432][INFO    ][9650] Starting a new job with PID 9650
2019-04-19 05:25:48,870 [salt.minion      :1711][INFO    ][9650] Returning information for job: 20190419052548806555
2019-04-19 05:25:50,422 [salt.loaded.ext.module.maas:1023][INFO    ][7573] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1852.67590594s left)
2019-04-19 05:26:18,929 [salt.minion      :1308][INFO    ][3401] User sudo_ubuntu Executing command saltutil.find_job with jid 20190419052618915932
2019-04-19 05:26:18,947 [salt.minion      :1432][INFO    ][9699] Starting a new job with PID 9699
2019-04-19 05:26:18,976 [salt.minion      :1711][INFO    ][9699] Returning information for job: 20190419052618915932
2019-04-19 05:26:23,506 [salt.loaded.ext.module.maas:1023][INFO    ][7573] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1819.59227991s left)
2019-04-19 05:26:49,100 [salt.minion      :1308][INFO    ][3401] User sudo_ubuntu Executing command saltutil.find_job with jid 20190419052649086757
2019-04-19 05:26:49,121 [salt.minion      :1432][INFO    ][10096] Starting a new job with PID 10096
2019-04-19 05:26:49,149 [salt.minion      :1711][INFO    ][10096] Returning information for job: 20190419052649086757
2019-04-19 05:26:56,466 [salt.loaded.ext.module.maas:1023][INFO    ][7573] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1786.63238001s left)
2019-04-19 05:27:19,211 [salt.minion      :1308][INFO    ][3401] User sudo_ubuntu Executing command saltutil.find_job with jid 20190419052719203550
2019-04-19 05:27:19,233 [salt.minion      :1432][INFO    ][10169] Starting a new job with PID 10169
2019-04-19 05:27:19,265 [salt.minion      :1711][INFO    ][10169] Returning information for job: 20190419052719203550
2019-04-19 05:27:29,186 [salt.loaded.ext.module.maas:1023][INFO    ][7573] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1753.912431s left)
2019-04-19 05:27:49,337 [salt.minion      :1308][INFO    ][3401] User sudo_ubuntu Executing command saltutil.find_job with jid 20190419052749320197
2019-04-19 05:27:49,355 [salt.minion      :1432][INFO    ][10499] Starting a new job with PID 10499
2019-04-19 05:27:49,385 [salt.minion      :1711][INFO    ][10499] Returning information for job: 20190419052749320197
2019-04-19 05:28:01,903 [salt.loaded.ext.module.maas:1023][INFO    ][7573] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1721.19507599s left)
2019-04-19 05:28:19,470 [salt.minion      :1308][INFO    ][3401] User sudo_ubuntu Executing command saltutil.find_job with jid 20190419052819455800
2019-04-19 05:28:19,487 [salt.minion      :1432][INFO    ][10569] Starting a new job with PID 10569
2019-04-19 05:28:19,521 [salt.minion      :1711][INFO    ][10569] Returning information for job: 20190419052819455800
2019-04-19 05:28:34,802 [salt.loaded.ext.module.maas:1023][INFO    ][7573] Waiting status:Deployed for machines:['cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1688.29652905s left)
2019-04-19 05:28:49,629 [salt.minion      :1308][INFO    ][3401] User sudo_ubuntu Executing command saltutil.find_job with jid 20190419052849618670
2019-04-19 05:28:49,653 [salt.minion      :1432][INFO    ][10773] Starting a new job with PID 10773
2019-04-19 05:28:49,672 [salt.minion      :1711][INFO    ][10773] Returning information for job: 20190419052849618670
2019-04-19 05:29:07,703 [salt.loaded.ext.module.maas:1023][INFO    ][7573] Waiting status:Deployed for machines:['kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1655.39527988s left)
2019-04-19 05:29:19,693 [salt.minion      :1308][INFO    ][3401] User sudo_ubuntu Executing command saltutil.find_job with jid 20190419052919683339
2019-04-19 05:29:19,715 [salt.minion      :1432][INFO    ][10835] Starting a new job with PID 10835
2019-04-19 05:29:19,739 [salt.minion      :1711][INFO    ][10835] Returning information for job: 20190419052919683339
2019-04-19 05:29:40,706 [salt.loaded.ext.module.maas:1023][INFO    ][7573] Waiting status:Deployed for machines:['kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1622.39233303s left)
2019-04-19 05:29:49,872 [salt.minion      :1308][INFO    ][3401] User sudo_ubuntu Executing command saltutil.find_job with jid 20190419052949856383
2019-04-19 05:29:49,897 [salt.minion      :1432][INFO    ][11020] Starting a new job with PID 11020
2019-04-19 05:29:49,920 [salt.minion      :1711][INFO    ][11020] Returning information for job: 20190419052949856383
2019-04-19 05:30:13,615 [salt.loaded.ext.module.maas:1023][INFO    ][7573] Waiting status:Deployed for machines:['kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1589.48351288s left)
2019-04-19 05:30:20,018 [salt.minion      :1308][INFO    ][3401] User sudo_ubuntu Executing command saltutil.find_job with jid 20190419053020011443
2019-04-19 05:30:20,033 [salt.minion      :1432][INFO    ][11053] Starting a new job with PID 11053
2019-04-19 05:30:20,052 [salt.minion      :1711][INFO    ][11053] Returning information for job: 20190419053020011443
2019-04-19 05:30:46,425 [salt.loaded.ext.module.maas:1023][INFO    ][7573] Waiting status:Deployed for machines:['kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1556.67385101s left)
2019-04-19 05:30:50,080 [salt.minion      :1308][INFO    ][3401] User sudo_ubuntu Executing command saltutil.find_job with jid 20190419053050064190
2019-04-19 05:30:50,100 [salt.minion      :1432][INFO    ][11266] Starting a new job with PID 11266
2019-04-19 05:30:50,125 [salt.minion      :1711][INFO    ][11266] Returning information for job: 20190419053050064190
2019-04-19 05:31:19,424 [salt.loaded.ext.module.maas:1023][INFO    ][7573] Waiting status:Deployed for machines:['kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1523.67458892s left)
2019-04-19 05:31:20,258 [salt.minion      :1308][INFO    ][3401] User sudo_ubuntu Executing command saltutil.find_job with jid 20190419053120244779
2019-04-19 05:31:20,280 [salt.minion      :1432][INFO    ][11340] Starting a new job with PID 11340
2019-04-19 05:31:20,302 [salt.minion      :1711][INFO    ][11340] Returning information for job: 20190419053120244779
2019-04-19 05:31:50,318 [salt.minion      :1308][INFO    ][3401] User sudo_ubuntu Executing command saltutil.find_job with jid 20190419053150310493
2019-04-19 05:31:50,337 [salt.minion      :1432][INFO    ][11549] Starting a new job with PID 11549
2019-04-19 05:31:50,358 [salt.minion      :1711][INFO    ][11549] Returning information for job: 20190419053150310493
2019-04-19 05:31:52,159 [salt.loaded.ext.module.maas:1023][INFO    ][7573] Waiting status:Deployed for machines:['kvm03']
sleep for:30s Timeout:2250s (1490.93919396s left)
2019-04-19 05:32:20,493 [salt.minion      :1308][INFO    ][3401] User sudo_ubuntu Executing command saltutil.find_job with jid 20190419053220478126
2019-04-19 05:32:20,515 [salt.minion      :1432][INFO    ][11613] Starting a new job with PID 11613
2019-04-19 05:32:20,539 [salt.minion      :1711][INFO    ][11613] Returning information for job: 20190419053220478126
2019-04-19 05:32:24,730 [salt.state       :300 ][INFO    ][7573] {'ret': True}
2019-04-19 05:32:24,730 [salt.state       :1951][INFO    ][7573] Completed state [maas.wait_for_machine_status] at time 05:32:24.730706 duration_in_ms=791645.486
2019-04-19 05:32:24,739 [salt.minion      :1711][INFO    ][7573] Returning information for job: 20190419051902797795
2019-04-19 06:10:29,666 [salt.utils.schedule:1377][INFO    ][3401] Running scheduled job: __mine_interval
2019-04-19 07:10:29,667 [salt.utils.schedule:1377][INFO    ][3401] Running scheduled job: __mine_interval
2019-04-19 07:10:41,649 [salt.minion      :1308][INFO    ][3401] User sudo_ubuntu Executing command cp.push_dir with jid 20190419071041639056
2019-04-19 07:10:41,672 [salt.minion      :1432][INFO    ][22089] Starting a new job with PID 22089
