2020-01-06 20:09:47,707 [salt.utils.decorators:613 ][WARNING ][2044] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-01-06 20:09:48,949 [salt.utils.decorators:613 ][WARNING ][2044] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-01-06 20:09:52,600 [salt.loaded.int.states.file:2298][WARNING ][2418] State for file: /etc/maas/rackd.conf - Neither 'source' nor 'contents' nor 'contents_pillar' nor 'contents_grains' was defined, yet 'replace' was set to 'True'. As there is no source to replace the file with, 'replace' has been set to 'False' to avoid reading the file unnecessarily.
2020-01-06 20:10:07,543 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2740] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2020-01-06 20:10:07,583 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2740] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2020-01-06 20:10:07,624 [salt.utils.parsers:1051][WARNING ][346] Minion received a SIGTERM. Exiting.
2020-01-06 20:10:08,734 [salt.cli.daemons :293 ][INFO    ][2852] Setting up the Salt Minion "mas01.mcp-ovs-ha.local"
2020-01-06 20:10:08,898 [salt.cli.daemons :82  ][INFO    ][2852] Starting up the Salt Minion
2020-01-06 20:10:08,898 [salt.utils.event :1017][INFO    ][2852] Starting pull socket on /var/run/salt/minion/minion_event_501f9ec045_pull.ipc
2020-01-06 20:10:10,139 [salt.minion      :976 ][INFO    ][2852] Creating minion process manager
2020-01-06 20:10:12,414 [salt.loader.10.20.0.2.int.module.cmdmod:395 ][INFO    ][2852] Executing command ['date', '+%z'] in directory '/root'
2020-01-06 20:10:12,437 [salt.utils.schedule:568 ][INFO    ][2852] Updating job settings for scheduled job: __mine_interval
2020-01-06 20:10:12,440 [salt.minion      :1108][INFO    ][2852] Added mine.update to scheduler
2020-01-06 20:10:12,445 [salt.minion      :1975][INFO    ][2852] Minion is starting as user 'root'
2020-01-06 20:10:12,459 [salt.minion      :2336][INFO    ][2852] Minion is ready to receive requests!
2020-01-06 20:10:19,827 [salt.state       :2022][WARNING ][2747] State is set to retry, but a valid dict for retry configuration was not found.  Using retry defaults
2020-01-06 20:10:20,381 [salt.minion      :1308][INFO    ][2852] User sudo_ubuntu Executing command saltutil.find_job with jid 20200106201020356678
2020-01-06 20:10:20,414 [salt.minion      :1432][INFO    ][3034] Starting a new job with PID 3034
2020-01-06 20:10:20,474 [salt.minion      :1711][INFO    ][3034] Returning information for job: 20200106201020356678
2020-01-06 20:10:22,120 [salt.utils.decorators:613 ][WARNING ][2747] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-01-06 20:10:36,020 [salt.utils.decorators:613 ][WARNING ][2747] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-01-06 20:10:50,548 [salt.minion      :1308][INFO    ][2852] User sudo_ubuntu Executing command saltutil.find_job with jid 20200106201050538289
2020-01-06 20:10:50,572 [salt.minion      :1432][INFO    ][3470] Starting a new job with PID 3470
2020-01-06 20:10:50,601 [salt.minion      :1711][INFO    ][3470] Returning information for job: 20200106201050538289
2020-01-06 20:11:18,500 [salt.utils.decorators:613 ][WARNING ][2747] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-01-06 20:11:19,356 [salt.utils.decorators:613 ][WARNING ][2747] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-01-06 20:11:20,642 [salt.minion      :1308][INFO    ][2852] User sudo_ubuntu Executing command saltutil.find_job with jid 20200106201120631535
2020-01-06 20:11:20,665 [salt.minion      :1432][INFO    ][3839] Starting a new job with PID 3839
2020-01-06 20:11:20,697 [salt.minion      :1711][INFO    ][3839] Returning information for job: 20200106201120631535
2020-01-06 20:11:21,637 [salt.loaded.ext.module.maasng:1008][WARNING ][2747] Detected cidr:192.168.11.0/24 in fabric:fabric-4
2020-01-06 20:11:21,638 [salt.loaded.ext.module.maasng:1011][WARNING ][2747] Guessing, that fabric with current name:fabric-4
 should be renamed to:pxe_admin
2020-01-06 20:11:22,382 [salt.loaded.ext.module.maasng:1235][WARNING ][2747] Ignoring parameter vlan:0
2020-01-06 20:11:24,317 [salt.minion      :1308][INFO    ][2852] User sudo_ubuntu Executing command state.apply with jid 20200106201124308353
2020-01-06 20:11:24,337 [salt.minion      :1432][INFO    ][3909] Starting a new job with PID 3909
2020-01-06 20:11:32,821 [salt.state       :915 ][INFO    ][3909] Loading fresh modules for state activity
2020-01-06 20:11:32,899 [salt.fileclient  :1219][INFO    ][3909] Fetching file from saltenv 'base', ** done ** 'maas/machines/init.sls'
2020-01-06 20:11:32,956 [salt.state       :1780][INFO    ][3909] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 20:11:32.956777
2020-01-06 20:11:32,957 [salt.state       :1813][INFO    ][3909] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2020-01-06 20:11:32,959 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3909] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2020-01-06 20:11:34,832 [salt.state       :300 ][INFO    ][3909] {'pid': 3936, 'retcode': 0, 'stderr': '', 'stdout': ''}
2020-01-06 20:11:34,834 [salt.state       :1951][INFO    ][3909] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 20:11:34.833988 duration_in_ms=1877.211
2020-01-06 20:11:34,837 [salt.state       :1780][INFO    ][3909] Running state [maas.process_machines] at time 20:11:34.837274
2020-01-06 20:11:34,838 [salt.state       :1813][INFO    ][3909] Executing state module.run for [maas.process_machines]
2020-01-06 20:11:34,839 [salt.utils.decorators:613 ][WARNING ][3909] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-01-06 20:11:34,906 [salt.loaded.ext.module.maas:412 ][WARNING ][3909] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2020-01-06 20:11:34,906 [salt.loaded.ext.module.maas:92  ][INFO    ][3909] machine hostname=cmp002 power_type=ipmi mac_addresses=9c:b6:54:8a:10:18 power_parameters_power_address=172.16.1.20 power_parameters_power_pass=Winter2017 architecture=amd64/generic power_parameters_power_user=opnfv
2020-01-06 20:11:36,420 [salt.loaded.ext.module.maas:412 ][WARNING ][3909] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2020-01-06 20:11:36,422 [salt.loaded.ext.module.maas:92  ][INFO    ][3909] machine hostname=cmp001 power_type=ipmi mac_addresses=9c:b6:54:8a:95:a0 power_parameters_power_address=172.16.1.19 power_parameters_power_pass=Winter2017 architecture=amd64/generic power_parameters_power_user=opnfv
2020-01-06 20:11:37,916 [salt.loaded.ext.module.maas:412 ][WARNING ][3909] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2020-01-06 20:11:37,916 [salt.loaded.ext.module.maas:92  ][INFO    ][3909] machine hostname=kvm01 power_type=ipmi mac_addresses=14:58:d0:54:e7:88 power_parameters_power_address=172.16.1.16 power_parameters_power_pass=Winter2017 architecture=amd64/generic power_parameters_power_user=opnfv
2020-01-06 20:11:39,357 [salt.loaded.ext.module.maas:412 ][WARNING ][3909] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2020-01-06 20:11:39,360 [salt.loaded.ext.module.maas:92  ][INFO    ][3909] machine hostname=kvm03 power_type=ipmi mac_addresses=14:58:d0:54:7a:28 power_parameters_power_address=172.16.1.18 power_parameters_power_pass=Winter2017 architecture=amd64/generic power_parameters_power_user=opnfv
2020-01-06 20:11:39,362 [salt.minion      :1308][INFO    ][2852] User sudo_ubuntu Executing command saltutil.find_job with jid 20200106201139350128
2020-01-06 20:11:39,387 [salt.minion      :1432][INFO    ][4103] Starting a new job with PID 4103
2020-01-06 20:11:39,422 [salt.minion      :1711][INFO    ][4103] Returning information for job: 20200106201139350128
2020-01-06 20:11:40,800 [salt.loaded.ext.module.maas:412 ][WARNING ][3909] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2020-01-06 20:11:40,801 [salt.loaded.ext.module.maas:92  ][INFO    ][3909] machine hostname=kvm02 power_type=ipmi mac_addresses=14:58:d0:54:6a:60 power_parameters_power_address=172.16.1.17 power_parameters_power_pass=Winter2017 architecture=amd64/generic power_parameters_power_user=opnfv
2020-01-06 20:11:42,312 [salt.state       :300 ][INFO    ][3909] {'ret': {'updated': [], 'errors': {}, 'success': ['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']}}
2020-01-06 20:11:42,313 [salt.state       :1951][INFO    ][3909] Completed state [maas.process_machines] at time 20:11:42.313036 duration_in_ms=7475.778
2020-01-06 20:11:42,316 [salt.minion      :1711][INFO    ][3909] Returning information for job: 20200106201124308353
2020-01-06 20:12:13,730 [salt.minion      :1308][INFO    ][2852] User sudo_ubuntu Executing command state.apply with jid 20200106201213714082
2020-01-06 20:12:13,757 [salt.minion      :1432][INFO    ][4447] Starting a new job with PID 4447
2020-01-06 20:12:22,304 [salt.state       :915 ][INFO    ][4447] Loading fresh modules for state activity
2020-01-06 20:12:22,377 [salt.fileclient  :1219][INFO    ][4447] Fetching file from saltenv 'base', ** done ** 'maas/machines/wait_for_ready_or_deployed.sls'
2020-01-06 20:12:22,430 [salt.state       :1780][INFO    ][4447] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 20:12:22.430189
2020-01-06 20:12:22,430 [salt.state       :1813][INFO    ][4447] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2020-01-06 20:12:22,432 [salt.loaded.int.module.cmdmod:395 ][INFO    ][4447] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2020-01-06 20:12:24,339 [salt.state       :300 ][INFO    ][4447] {'pid': 4455, 'retcode': 0, 'stderr': '', 'stdout': ''}
2020-01-06 20:12:24,340 [salt.state       :1951][INFO    ][4447] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 20:12:24.340697 duration_in_ms=1910.508
2020-01-06 20:12:24,345 [salt.state       :1780][INFO    ][4447] Running state [maas.wait_for_machine_status] at time 20:12:24.345262
2020-01-06 20:12:24,345 [salt.state       :1813][INFO    ][4447] Executing state module.run for [maas.wait_for_machine_status]
2020-01-06 20:12:24,346 [salt.utils.decorators:613 ][WARNING ][4447] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-01-06 20:12:25,146 [salt.loaded.ext.module.maas:1023][INFO    ][4447] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1499.21437788s left)
2020-01-06 20:12:28,827 [salt.minion      :1308][INFO    ][2852] User sudo_ubuntu Executing command saltutil.find_job with jid 20200106201228813594
2020-01-06 20:12:28,852 [salt.minion      :1432][INFO    ][4481] Starting a new job with PID 4481
2020-01-06 20:12:28,884 [salt.minion      :1711][INFO    ][4481] Returning information for job: 20200106201228813594
2020-01-06 20:12:55,964 [salt.loaded.ext.module.maas:1023][INFO    ][4447] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1468.39615107s left)
2020-01-06 20:12:58,922 [salt.minion      :1308][INFO    ][2852] User sudo_ubuntu Executing command saltutil.find_job with jid 20200106201258905746
2020-01-06 20:12:58,950 [salt.minion      :1432][INFO    ][4513] Starting a new job with PID 4513
2020-01-06 20:12:58,980 [salt.minion      :1711][INFO    ][4513] Returning information for job: 20200106201258905746
2020-01-06 20:13:26,824 [salt.loaded.ext.module.maas:1023][INFO    ][4447] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1437.53642893s left)
2020-01-06 20:13:29,031 [salt.minion      :1308][INFO    ][2852] User sudo_ubuntu Executing command saltutil.find_job with jid 20200106201329018759
2020-01-06 20:13:29,052 [salt.minion      :1432][INFO    ][4553] Starting a new job with PID 4553
2020-01-06 20:13:29,084 [salt.minion      :1711][INFO    ][4553] Returning information for job: 20200106201329018759
2020-01-06 20:13:57,672 [salt.loaded.ext.module.maas:1023][INFO    ][4447] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1406.68859792s left)
2020-01-06 20:13:59,120 [salt.minion      :1308][INFO    ][2852] User sudo_ubuntu Executing command saltutil.find_job with jid 20200106201359106357
2020-01-06 20:13:59,151 [salt.minion      :1432][INFO    ][4588] Starting a new job with PID 4588
2020-01-06 20:13:59,179 [salt.minion      :1711][INFO    ][4588] Returning information for job: 20200106201359106357
2020-01-06 20:14:28,752 [salt.loaded.ext.module.maas:1023][INFO    ][4447] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1375.60889983s left)
2020-01-06 20:14:29,231 [salt.minion      :1308][INFO    ][2852] User sudo_ubuntu Executing command saltutil.find_job with jid 20200106201429214752
2020-01-06 20:14:29,260 [salt.minion      :1432][INFO    ][4659] Starting a new job with PID 4659
2020-01-06 20:14:29,294 [salt.minion      :1711][INFO    ][4659] Returning information for job: 20200106201429214752
2020-01-06 20:14:59,337 [salt.minion      :1308][INFO    ][2852] User sudo_ubuntu Executing command saltutil.find_job with jid 20200106201459321224
2020-01-06 20:14:59,364 [salt.minion      :1432][INFO    ][4762] Starting a new job with PID 4762
2020-01-06 20:14:59,392 [salt.minion      :1711][INFO    ][4762] Returning information for job: 20200106201459321224
2020-01-06 20:14:59,924 [salt.loaded.ext.module.maas:1023][INFO    ][4447] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1344.43656397s left)
2020-01-06 20:15:29,480 [salt.minion      :1308][INFO    ][2852] User sudo_ubuntu Executing command saltutil.find_job with jid 20200106201529457004
2020-01-06 20:15:29,508 [salt.minion      :1432][INFO    ][5048] Starting a new job with PID 5048
2020-01-06 20:15:29,541 [salt.minion      :1711][INFO    ][5048] Returning information for job: 20200106201529457004
2020-01-06 20:15:31,275 [salt.loaded.ext.module.maas:1023][INFO    ][4447] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1313.08563685s left)
2020-01-06 20:15:59,580 [salt.minion      :1308][INFO    ][2852] User sudo_ubuntu Executing command saltutil.find_job with jid 20200106201559568938
2020-01-06 20:15:59,601 [salt.minion      :1432][INFO    ][5195] Starting a new job with PID 5195
2020-01-06 20:15:59,630 [salt.minion      :1711][INFO    ][5195] Returning information for job: 20200106201559568938
2020-01-06 20:16:02,630 [salt.loaded.ext.module.maas:1023][INFO    ][4447] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1281.73055291s left)
2020-01-06 20:16:29,675 [salt.minion      :1308][INFO    ][2852] User sudo_ubuntu Executing command saltutil.find_job with jid 20200106201629663679
2020-01-06 20:16:29,703 [salt.minion      :1432][INFO    ][5298] Starting a new job with PID 5298
2020-01-06 20:16:29,733 [salt.minion      :1711][INFO    ][5298] Returning information for job: 20200106201629663679
2020-01-06 20:16:34,616 [salt.loaded.ext.module.maas:1023][INFO    ][4447] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1249.7441709s left)
2020-01-06 20:16:59,811 [salt.minion      :1308][INFO    ][2852] User sudo_ubuntu Executing command saltutil.find_job with jid 20200106201659795694
2020-01-06 20:16:59,836 [salt.minion      :1432][INFO    ][5513] Starting a new job with PID 5513
2020-01-06 20:16:59,869 [salt.minion      :1711][INFO    ][5513] Returning information for job: 20200106201659795694
2020-01-06 20:17:07,048 [salt.loaded.ext.module.maas:1023][INFO    ][4447] Waiting status:Ready|Deployed for machines:['cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1217.3129859s left)
2020-01-06 20:17:29,997 [salt.minion      :1308][INFO    ][2852] User sudo_ubuntu Executing command saltutil.find_job with jid 20200106201729986653
2020-01-06 20:17:30,024 [salt.minion      :1432][INFO    ][5980] Starting a new job with PID 5980
2020-01-06 20:17:30,054 [salt.minion      :1711][INFO    ][5980] Returning information for job: 20200106201729986653
2020-01-06 20:17:39,328 [salt.loaded.ext.module.maas:1023][INFO    ][4447] Waiting status:Ready|Deployed for machines:['kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1185.03308797s left)
2020-01-06 20:18:00,118 [salt.minion      :1308][INFO    ][2852] User sudo_ubuntu Executing command saltutil.find_job with jid 20200106201800102932
2020-01-06 20:18:00,146 [salt.minion      :1432][INFO    ][6025] Starting a new job with PID 6025
2020-01-06 20:18:00,175 [salt.minion      :1711][INFO    ][6025] Returning information for job: 20200106201800102932
2020-01-06 20:18:11,818 [salt.loaded.ext.module.maas:1023][INFO    ][4447] Waiting status:Ready|Deployed for machines:['kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1152.54303288s left)
2020-01-06 20:18:30,268 [salt.minion      :1308][INFO    ][2852] User sudo_ubuntu Executing command saltutil.find_job with jid 20200106201830251766
2020-01-06 20:18:30,292 [salt.minion      :1432][INFO    ][6150] Starting a new job with PID 6150
2020-01-06 20:18:30,321 [salt.minion      :1711][INFO    ][6150] Returning information for job: 20200106201830251766
2020-01-06 20:18:44,739 [salt.state       :300 ][INFO    ][4447] {'ret': True}
2020-01-06 20:18:44,740 [salt.state       :1951][INFO    ][4447] Completed state [maas.wait_for_machine_status] at time 20:18:44.740386 duration_in_ms=380395.125
2020-01-06 20:18:44,746 [salt.minion      :1711][INFO    ][4447] Returning information for job: 20200106201213714082
2020-01-06 20:18:45,490 [salt.minion      :1308][INFO    ][2852] User sudo_ubuntu Executing command state.apply with jid 20200106201845476689
2020-01-06 20:18:45,514 [salt.minion      :1432][INFO    ][6185] Starting a new job with PID 6185
2020-01-06 20:18:54,067 [salt.state       :915 ][INFO    ][6185] Loading fresh modules for state activity
2020-01-06 20:18:54,136 [salt.fileclient  :1219][INFO    ][6185] Fetching file from saltenv 'base', ** done ** 'maas/machines/storage.sls'
2020-01-06 20:18:54,239 [salt.state       :1780][INFO    ][6185] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 20:18:54.239745
2020-01-06 20:18:54,240 [salt.state       :1813][INFO    ][6185] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2020-01-06 20:18:54,242 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6185] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2020-01-06 20:18:56,128 [salt.state       :300 ][INFO    ][6185] {'pid': 6222, 'retcode': 0, 'stderr': '', 'stdout': ''}
2020-01-06 20:18:56,130 [salt.state       :1951][INFO    ][6185] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 20:18:56.130648 duration_in_ms=1890.903
2020-01-06 20:18:56,134 [salt.state       :1780][INFO    ][6185] Running state [maas_machines_storage_cmp002_lvm] at time 20:18:56.134836
2020-01-06 20:18:56,135 [salt.state       :1813][INFO    ][6185] Executing state maasng.disk_layout_present for [maas_machines_storage_cmp002_lvm]
2020-01-06 20:18:57,270 [salt.loaded.ext.module.maasng:610 ][INFO    ][6185] 4scnnb
2020-01-06 20:18:57,271 [salt.loaded.ext.module.maasng:626 ][INFO    ][6185] sda
2020-01-06 20:18:57,756 [salt.loaded.ext.module.maasng:361 ][INFO    ][6185] 4scnnb
2020-01-06 20:18:57,846 [salt.loaded.ext.module.maasng:367 ][INFO    ][6185] [{u'resource_uri': u'/MAAS/api/2.0/nodes/4scnnb/blockdevices/1/', u'available_size': 0, u'uuid': None, u'name': u'sda', u'tags': [u'ssd'], u'used_for': u'MBR partitioned with 1 partition', u'used_size': 800106479616, u'partitions': [{u'uuid': u'491fad79-fa52-47b1-b727-32bb93baead7', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'4scnnb', u'device_id': 1, u'filesystem': {u'label': None, u'uuid': u'b9afa651-80ab-43b3-aa44-a7d3e352e4e8', 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/4scnnb/blockdevices/1/partition/1', u'type': u'partition', u'id': 1, u'size': 800101236736}], u'id': 1, u'system_id': u'4scnnb', 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'serial': u'600508b1001cb19198eb9a66f8a29401', u'block_size': 4096, u'type': u'physical', u'model': u'LOGICAL VOLUME', u'size': 800109715456}, {u'resource_uri': u'/MAAS/api/2.0/nodes/4scnnb/blockdevices/3/', u'available_size': 0, u'uuid': u'b064f038-8656-4703-8c5e-16963bffb174', u'name': u'vgroot-lvroot', u'tags': [], u'used_for': u'ext4 formatted filesystem mounted at /', u'used_size': 800097042432, u'partitions': [], u'id': 3, u'system_id': u'4scnnb', u'partition_table_type': None, u'filesystem': {u'label': u'root', u'uuid': u'c5a80dcd-675a-4d5d-97df-7c5b0aaf958c', u'mount_point': u'/', u'mount_options': None, u'fstype': u'ext4'}, u'id_path': None, u'path': u'/dev/disk/by-dname/lvroot', u'serial': None, u'block_size': 4096, u'type': u'virtual', u'model': None, u'size': 800097042432}]
2020-01-06 20:18:57,846 [salt.loaded.ext.module.maasng:632 ][INFO    ][6185] vgroot
2020-01-06 20:18:57,847 [salt.loaded.ext.module.maasng:635 ][INFO    ][6185] lvroot
2020-01-06 20:18:57,847 [salt.loaded.ext.module.maasng:639 ][INFO    ][6185] 107374182400
2020-01-06 20:18:58,370 [salt.loaded.ext.module.maasng:645 ][INFO    ][6185] {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'ip_addresses': [u'192.168.11.38', u'192.168.11.40'], u'cpu_count': 40, u'power_type': u'ipmi', u'hwe_kernel': u'', u'memory_test_status_name': u'Unknown', u'fqdn': u'cmp002.maas', u'node_type': 0, u'tag_names': [], u'swap_size': None, u'owner': None, u'pod': None, u'cache_sets': [], u'cpu_test_status_name': u'Unknown', u'iscsiblockdevice_set': [], u'zone': {u'description': u'', u'id': 1, u'name': u'default', u'resource_uri': u'/MAAS/api/2.0/zones/default/'}, u'resource_uri': u'/MAAS/api/2.0/machines/4scnnb/', u'node_type_name': u'Machine', u'hostname': u'cmp002', u'storage': 800109.715456, u'testing_status': 2, u'system_id': u'4scnnb', u'raids': [], u'memory': 65536, u'current_installation_result_id': None, u'default_gateways': {u'ipv4': {u'gateway_ip': u'192.168.11.3', u'link_id': None}, u'ipv6': {u'gateway_ip': None, u'link_id': None}}, u'status_message': u'Power state queried: off', u'virtualblockdevice_set': [{u'size': 107374182400, u'model': None, u'uuid': u'9f5dbb7d-0f45-470c-b4c2-64ee024d017d', u'name': u'vgroot-lvroot', u'tags': [], u'type': u'virtual', u'id': 11, u'used_for': u'ext4 formatted filesystem mounted at /', u'path': u'/dev/disk/by-dname/vgroot-lvroot', u'system_id': u'4scnnb', u'partition_table_type': None, u'filesystem': {u'mount_options': None, u'mount_point': u'/', u'uuid': u'587048f0-53f6-4744-aeef-1870c9dbbbd6', u'fstype': u'ext4', u'label': u'root'}, u'id_path': None, u'available_size': 0, u'serial': None, u'block_size': 4096, u'used_size': 107374182400, u'resource_uri': u'/MAAS/api/2.0/nodes/4scnnb/blockdevices/11/', u'partitions': []}], u'min_hwe_kernel': u'ga-18.04', u'status': 4, u'storage_test_status': 2, u'storage_test_status_name': u'Passed', u'power_state': u'off', u'physicalblockdevice_set': [{u'size': 800109715456, u'model': u'LOGICAL VOLUME', u'uuid': None, u'name': u'sda', u'tags': [u'ssd'], u'type': u'physical', u'id': 1, u'used_for': u'MBR partitioned with 1 partition', u'path': u'/dev/disk/by-dname/sda', u'system_id': u'4scnnb', u'partition_table_type': u'MBR', u'filesystem': None, u'id_path': u'/dev/disk/by-id/wwn-0x600508b1001cb19198eb9a66f8a29401', u'available_size': 0, u'serial': u'600508b1001cb19198eb9a66f8a29401', u'block_size': 4096, u'used_size': 800106479616, u'resource_uri': u'/MAAS/api/2.0/nodes/4scnnb/blockdevices/1/', u'partitions': [{u'size': 800101236736, u'uuid': u'57546289-52cb-4dfe-9cb3-f0fe3911bc53', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'4scnnb', u'filesystem': {u'mount_options': None, u'mount_point': None, u'uuid': u'ce03157e-0c13-4d98-95fc-d9fcd16e1bab', u'fstype': u'lvm-pv', u'label': None}, u'path': u'/dev/disk/by-dname/sda-part1', u'resource_uri': u'/MAAS/api/2.0/nodes/4scnnb/blockdevices/1/partition/6', u'type': u'partition', u'id': 6, u'device_id': 1}]}], u'other_test_status_name': u'Unknown', u'owner_data': {}, u'volume_groups': [{u'__incomplete__': True, u'system_id': u'4scnnb', u'id': 6}], u'special_filesystems': [], u'current_commissioning_result_id': 2, u'boot_disk': {u'size': 800109715456, u'model': u'LOGICAL VOLUME', u'uuid': None, u'name': u'sda', u'tags': [u'ssd'], u'type': u'physical', u'id': 1, u'used_for': u'MBR partitioned with 1 partition', u'path': u'/dev/disk/by-dname/sda', u'system_id': u'4scnnb', u'partition_table_type': u'MBR', u'filesystem': None, u'id_path': u'/dev/disk/by-id/wwn-0x600508b1001cb19198eb9a66f8a29401', u'available_size': 0, u'serial': u'600508b1001cb19198eb9a66f8a29401', u'block_size': 4096, u'used_size': 800106479616, u'resource_uri': u'/MAAS/api/2.0/nodes/4scnnb/blockdevices/1/', u'partitions': [{u'size': 800101236736, u'uuid': u'57546289-52cb-4dfe-9cb3-f0fe3911bc53', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'4scnnb', u'filesystem': {u'mount_options': None, u'mount_point': None, u'uuid': u'ce03157e-0c13-4d98-95fc-d9fcd16e1bab', u'fstype': u'lvm-pv', u'label': None}, u'path': u'/dev/disk/by-dname/sda-part1', u'resource_uri': u'/MAAS/api/2.0/nodes/4scnnb/blockdevices/1/partition/6', u'type': u'partition', u'id': 6, u'device_id': 1}]}, u'interface_set': [{u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'dhcp_on': True, u'fabric_id': 4, u'mtu': 1500, u'external_dhcp': None, u'relay_vlan': None, u'primary_rack': u'7mhg7n', u'resource_uri': u'/MAAS/api/2.0/vlans/5005/', u'id': 5005, u'secondary_rack': None, u'name': u'untagged'}, 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': 4, u'mtu': 1500, u'external_dhcp': None, u'relay_vlan': None, u'primary_rack': u'7mhg7n', u'resource_uri': u'/MAAS/api/2.0/vlans/5005/', u'id': 5005, 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': 6, u'resource_uri': u'/MAAS/api/2.0/subnets/6/'}, u'ip_address': u'192.168.11.38', u'mode': u'dhcp', u'id': 21}], u'tags': [u'sriov'], u'effective_mtu': 1500, u'enabled': True, u'parents': [], 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': 4, u'mtu': 1500, u'external_dhcp': None, u'relay_vlan': None, u'primary_rack': u'7mhg7n', u'resource_uri': u'/MAAS/api/2.0/vlans/5005/', u'id': 5005, 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': 6, u'resource_uri': u'/MAAS/api/2.0/subnets/6/'}, u'ip_address': u'192.168.11.38'}], u'params': u'', u'mac_address': u'9c:b6:54:8a:10:18', u'id': 4, u'system_id': u'4scnnb', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/4scnnb/interfaces/4/'}, {u'vlan': None, u'name': u'ens1f0', u'links': [], u'tags': [u'sriov'], u'effective_mtu': 1500, u'enabled': True, u'parents': [], u'discovered': None, u'params': u'', u'mac_address': u'38:ea:a7:8f:07:50', u'id': 13, u'system_id': u'4scnnb', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/4scnnb/interfaces/13/'}, {u'vlan': None, u'name': u'ens1f1', u'links': [], u'tags': [u'sriov'], u'effective_mtu': 1500, u'enabled': True, u'parents': [], u'discovered': None, u'params': u'', u'mac_address': u'38:ea:a7:8f:07:51', u'id': 14, u'system_id': u'4scnnb', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/4scnnb/interfaces/14/'}, {u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'dhcp_on': True, u'fabric_id': 4, u'mtu': 1500, u'external_dhcp': None, u'relay_vlan': None, u'primary_rack': u'7mhg7n', u'resource_uri': u'/MAAS/api/2.0/vlans/5005/', u'id': 5005, u'secondary_rack': None, u'name': u'untagged'}, 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': 4, u'mtu': 1500, u'external_dhcp': None, u'relay_vlan': None, u'primary_rack': u'7mhg7n', u'resource_uri': u'/MAAS/api/2.0/vlans/5005/', u'id': 5005, 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': 6, u'resource_uri': u'/MAAS/api/2.0/subnets/6/'}, u'mode': u'link_up', u'id': 22}], u'tags': [u'sriov'], u'effective_mtu': 1500, u'enabled': True, u'parents': [], 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': 4, u'mtu': 1500, u'external_dhcp': None, u'relay_vlan': None, u'primary_rack': u'7mhg7n', u'resource_uri': u'/MAAS/api/2.0/vlans/5005/', u'id': 5005, 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': 6, u'resource_uri': u'/MAAS/api/2.0/subnets/6/'}, u'ip_address': u'192.168.11.40'}], u'params': u'', u'mac_address': u'9c:b6:54:8a:10:1c', u'id': 15, u'system_id': u'4scnnb', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/4scnnb/interfaces/15/'}, {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'external_dhcp': None, u'relay_vlan': None, u'primary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/', u'id': 5001, u'secondary_rack': None, u'name': u'untagged'}, u'name': u'ens2f0', u'links': [{u'mode': u'link_up', u'id': 23}], u'tags': [u'sriov'], u'effective_mtu': 1500, u'enabled': True, u'parents': [], u'discovered': None, u'params': u'', u'mac_address': u'38:ea:a7:8f:12:48', u'id': 11, u'system_id': u'4scnnb', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/4scnnb/interfaces/11/'}, {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'external_dhcp': None, u'relay_vlan': None, u'primary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/', u'id': 5001, u'secondary_rack': None, u'name': u'untagged'}, u'name': u'ens2f1', u'links': [{u'mode': u'link_up', u'id': 24}], u'tags': [u'sriov'], u'effective_mtu': 1500, u'enabled': True, u'parents': [], u'discovered': None, u'params': u'', u'mac_address': u'38:ea:a7:8f:12:49', u'id': 12, u'system_id': u'4scnnb', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/4scnnb/interfaces/12/'}], u'current_testing_result_id': 3, u'cpu_test_status': -1, u'bcaches': [], u'other_test_status': -1, u'status_name': u'Ready', u'netboot': True, u'osystem': u'', u'status_action': u'', u'disable_ipv4': False, u'commissioning_status': 2, u'architecture': u'amd64/generic', u'commissioning_status_name': u'Passed', u'boot_interface': {u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'dhcp_on': True, u'fabric_id': 4, u'mtu': 1500, u'external_dhcp': None, u'relay_vlan': None, u'primary_rack': u'7mhg7n', u'resource_uri': u'/MAAS/api/2.0/vlans/5005/', u'id': 5005, u'secondary_rack': None, u'name': u'untagged'}, 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': 4, u'mtu': 1500, u'external_dhcp': None, u'relay_vlan': None, u'primary_rack': u'7mhg7n', u'resource_uri': u'/MAAS/api/2.0/vlans/5005/', u'id': 5005, 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': 6, u'resource_uri': u'/MAAS/api/2.0/subnets/6/'}, u'ip_address': u'192.168.11.38', u'mode': u'dhcp', u'id': 21}], u'tags': [u'sriov'], u'effective_mtu': 1500, u'enabled': True, u'parents': [], 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': 4, u'mtu': 1500, u'external_dhcp': None, u'relay_vlan': None, u'primary_rack': u'7mhg7n', u'resource_uri': u'/MAAS/api/2.0/vlans/5005/', u'id': 5005, 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': 6, u'resource_uri': u'/MAAS/api/2.0/subnets/6/'}, u'ip_address': u'192.168.11.38'}], u'params': u'', u'mac_address': u'9c:b6:54:8a:10:18', u'id': 4, u'system_id': u'4scnnb', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/4scnnb/interfaces/4/'}, u'address_ttl': None, u'blockdevice_set': [{u'size': 800109715456, u'model': u'LOGICAL VOLUME', u'id_path': u'/dev/disk/by-id/wwn-0x600508b1001cb19198eb9a66f8a29401', u'uuid': None, u'name': u'sda', u'tags': [u'ssd'], u'type': u'physical', u'used_for': u'MBR partitioned with 1 partition', u'path': u'/dev/disk/by-dname/sda', u'system_id': u'4scnnb', u'partition_table_type': u'MBR', u'filesystem': None, u'id': 1, u'available_size': 0, u'serial': u'600508b1001cb19198eb9a66f8a29401', u'block_size': 4096, u'used_size': 800106479616, u'resource_uri': u'/MAAS/api/2.0/nodes/4scnnb/blockdevices/1/', u'partitions': [{u'size': 800101236736, u'uuid': u'57546289-52cb-4dfe-9cb3-f0fe3911bc53', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'4scnnb', u'filesystem': {u'mount_options': None, u'mount_point': None, u'uuid': u'ce03157e-0c13-4d98-95fc-d9fcd16e1bab', u'fstype': u'lvm-pv', u'label': None}, u'path': u'/dev/disk/by-dname/sda-part1', u'resource_uri': u'/MAAS/api/2.0/nodes/4scnnb/blockdevices/1/partition/6', u'type': u'partition', u'id': 6, u'device_id': 1}]}, {u'size': 107374182400, u'model': None, u'id_path': None, u'uuid': u'9f5dbb7d-0f45-470c-b4c2-64ee024d017d', u'name': u'vgroot-lvroot', u'tags': [], u'type': u'virtual', u'used_for': u'ext4 formatted filesystem mounted at /', u'path': u'/dev/disk/by-dname/lvroot', u'system_id': u'4scnnb', u'partition_table_type': None, u'filesystem': {u'mount_options': None, u'mount_point': u'/', u'uuid': u'587048f0-53f6-4744-aeef-1870c9dbbbd6', u'fstype': u'ext4', u'label': u'root'}, u'id': 11, u'available_size': 0, u'serial': None, u'block_size': 4096, u'used_size': 107374182400, u'resource_uri': u'/MAAS/api/2.0/nodes/4scnnb/blockdevices/11/', u'partitions': []}], u'distro_series': u'', u'memory_test_status': -1}
2020-01-06 20:18:58,372 [salt.state       :300 ][INFO    ][6185] {'new': {'storage_layout': 'lvm'}}
2020-01-06 20:18:58,372 [salt.state       :1951][INFO    ][6185] Completed state [maas_machines_storage_cmp002_lvm] at time 20:18:58.372400 duration_in_ms=2237.565
2020-01-06 20:18:58,372 [salt.state       :1780][INFO    ][6185] Running state [maas_machines_storage_cmp001_lvm] at time 20:18:58.372796
2020-01-06 20:18:58,373 [salt.state       :1813][INFO    ][6185] Executing state maasng.disk_layout_present for [maas_machines_storage_cmp001_lvm]
2020-01-06 20:18:59,470 [salt.loaded.ext.module.maasng:610 ][INFO    ][6185] 63msbg
2020-01-06 20:18:59,470 [salt.loaded.ext.module.maasng:626 ][INFO    ][6185] sda
2020-01-06 20:19:00,083 [salt.loaded.ext.module.maasng:361 ][INFO    ][6185] 63msbg
2020-01-06 20:19:00,172 [salt.loaded.ext.module.maasng:367 ][INFO    ][6185] [{u'size': 800109715456, u'resource_uri': u'/MAAS/api/2.0/nodes/63msbg/blockdevices/2/', 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'63msbg', 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'block_size': 4096, u'type': u'physical', u'model': u'LOGICAL VOLUME', u'partitions': [{u'uuid': u'1dda458b-386f-4890-abd9-a83ca0034dd4', u'resource_uri': u'/MAAS/api/2.0/nodes/63msbg/blockdevices/2/partition/2', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'63msbg', u'filesystem': {u'mount_options': None, u'fstype': u'lvm-pv', u'mount_point': None, u'uuid': u'f3c491b5-464d-4183-802c-89ceef90abf4', u'label': None}, u'path': u'/dev/disk/by-dname/sda-part1', u'device_id': 2, u'type': u'partition', u'id': 2, u'size': 800101236736}]}, {u'size': 800097042432, u'resource_uri': u'/MAAS/api/2.0/nodes/63msbg/blockdevices/4/', u'uuid': u'09de4524-ff6e-4e46-939e-cf362add2392', u'name': u'vgroot-lvroot', u'tags': [], u'used_size': 800097042432, u'id': 4, u'used_for': u'ext4 formatted filesystem mounted at /', u'path': u'/dev/disk/by-dname/lvroot', u'system_id': u'63msbg', u'partition_table_type': None, u'filesystem': {u'mount_options': None, u'fstype': u'ext4', u'mount_point': u'/', u'uuid': u'eadfcf9e-cc0b-4733-add4-e8284c195e5e', u'label': u'root'}, u'id_path': None, u'available_size': 0, u'serial': None, u'block_size': 4096, u'type': u'virtual', u'model': None, u'partitions': []}]
2020-01-06 20:19:00,172 [salt.loaded.ext.module.maasng:632 ][INFO    ][6185] vgroot
2020-01-06 20:19:00,172 [salt.loaded.ext.module.maasng:635 ][INFO    ][6185] lvroot
2020-01-06 20:19:00,173 [salt.loaded.ext.module.maasng:639 ][INFO    ][6185] 107374182400
2020-01-06 20:19:00,586 [salt.minion      :1308][INFO    ][2852] User sudo_ubuntu Executing command saltutil.find_job with jid 20200106201900577760
2020-01-06 20:19:00,603 [salt.minion      :1432][INFO    ][6256] Starting a new job with PID 6256
2020-01-06 20:19:00,631 [salt.minion      :1711][INFO    ][6256] Returning information for job: 20200106201900577760
2020-01-06 20:19:00,778 [salt.loaded.ext.module.maasng:645 ][INFO    ][6185] {u'hwe_kernel': u'', 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'storage_test_status_name': u'Passed', 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'swap_size': None, u'owner': None, u'pod': None, u'cache_sets': [], u'cpu_test_status_name': u'Unknown', u'iscsiblockdevice_set': [], u'status_action': u'', u'zone': {u'id': 1, u'description': u'', u'name': u'default', u'resource_uri': u'/MAAS/api/2.0/zones/default/'}, u'node_type_name': u'Machine', u'hostname': u'cmp001', u'storage': 800109.715456, u'testing_status': 2, u'system_id': u'63msbg', 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'disable_ipv4': False, u'blockdevice_set': [{u'resource_uri': u'/MAAS/api/2.0/nodes/63msbg/blockdevices/2/', u'available_size': 0, u'uuid': None, u'name': u'sda', u'tags': [u'ssd'], u'used_for': u'MBR partitioned with 1 partition', u'used_size': 800106479616, u'partitions': [{u'uuid': u'c0eaedbd-a2bd-4c72-b016-36d889f2d018', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'63msbg', u'device_id': 2, u'filesystem': {u'label': None, u'uuid': u'15faa19e-7341-40be-a11f-796c57d8c529', 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/63msbg/blockdevices/2/partition/7', u'type': u'partition', u'id': 7, u'size': 800101236736}], u'id': 2, u'system_id': u'63msbg', 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'serial': u'600508b1001cd7e61f5cd3479576479e', u'block_size': 4096, u'type': u'physical', u'model': u'LOGICAL VOLUME', u'size': 800109715456}, {u'resource_uri': u'/MAAS/api/2.0/nodes/63msbg/blockdevices/12/', u'available_size': 0, u'uuid': u'24fd956a-2370-4d4f-b868-6604056033a0', u'name': u'vgroot-lvroot', u'tags': [], u'used_for': u'ext4 formatted filesystem mounted at /', u'used_size': 107374182400, u'partitions': [], u'id': 12, u'system_id': u'63msbg', u'partition_table_type': None, u'filesystem': {u'label': u'root', u'uuid': u'037c4015-07bd-497e-83e9-f9e1ce4f62ac', u'mount_point': u'/', u'mount_options': None, u'fstype': u'ext4'}, u'id_path': None, u'path': u'/dev/disk/by-dname/lvroot', u'serial': None, u'block_size': 4096, u'type': u'virtual', u'model': None, u'size': 107374182400}], u'status': 4, u'storage_test_status': 2, u'cpu_count': 40, u'raids': [], u'physicalblockdevice_set': [{u'model': u'LOGICAL VOLUME', u'resource_uri': u'/MAAS/api/2.0/nodes/63msbg/blockdevices/2/', u'available_size': 0, u'uuid': None, u'tags': [u'ssd'], u'used_for': u'MBR partitioned with 1 partition', u'used_size': 800106479616, u'partitions': [{u'uuid': u'c0eaedbd-a2bd-4c72-b016-36d889f2d018', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'63msbg', u'device_id': 2, u'filesystem': {u'label': None, u'uuid': u'15faa19e-7341-40be-a11f-796c57d8c529', 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/63msbg/blockdevices/2/partition/7', u'type': u'partition', u'id': 7, u'size': 800101236736}], u'name': u'sda', u'system_id': u'63msbg', 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'serial': u'600508b1001cd7e61f5cd3479576479e', u'block_size': 4096, u'type': u'physical', u'id': 2, u'size': 800109715456}], u'other_test_status_name': u'Unknown', u'owner_data': {}, u'volume_groups': [{u'__incomplete__': True, u'system_id': u'63msbg', u'id': 7}], u'special_filesystems': [], u'current_commissioning_result_id': 4, u'boot_disk': {u'model': u'LOGICAL VOLUME', u'resource_uri': u'/MAAS/api/2.0/nodes/63msbg/blockdevices/2/', u'available_size': 0, u'uuid': None, u'tags': [u'ssd'], u'used_for': u'MBR partitioned with 1 partition', u'used_size': 800106479616, u'partitions': [{u'uuid': u'c0eaedbd-a2bd-4c72-b016-36d889f2d018', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'63msbg', u'device_id': 2, u'filesystem': {u'label': None, u'uuid': u'15faa19e-7341-40be-a11f-796c57d8c529', 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/63msbg/blockdevices/2/partition/7', u'type': u'partition', u'id': 7, u'size': 800101236736}], u'name': u'sda', u'system_id': u'63msbg', 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'serial': u'600508b1001cd7e61f5cd3479576479e', u'block_size': 4096, u'type': u'physical', u'id': 2, u'size': 800109715456}, u'current_testing_result_id': 5, u'cpu_test_status': -1, u'architecture': u'amd64/generic', u'bcaches': [], u'other_test_status': -1, u'status_name': u'Ready', u'netboot': True, u'osystem': u'', u'fqdn': u'cmp001.maas', u'virtualblockdevice_set': [{u'model': None, u'resource_uri': u'/MAAS/api/2.0/nodes/63msbg/blockdevices/12/', u'available_size': 0, u'uuid': u'24fd956a-2370-4d4f-b868-6604056033a0', u'tags': [], u'used_for': u'ext4 formatted filesystem mounted at /', u'used_size': 107374182400, u'partitions': [], u'name': u'vgroot-lvroot', u'system_id': u'63msbg', u'partition_table_type': None, u'filesystem': {u'label': u'root', u'uuid': u'037c4015-07bd-497e-83e9-f9e1ce4f62ac', u'mount_point': u'/', u'mount_options': None, u'fstype': u'ext4'}, u'id_path': None, u'path': u'/dev/disk/by-dname/vgroot-lvroot', u'serial': None, u'block_size': 4096, u'type': u'virtual', u'id': 12, u'size': 107374182400}], u'commissioning_status': 2, u'min_hwe_kernel': u'ga-18.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'fabric_id': 4, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'7mhg7n', u'relay_vlan': None, u'external_dhcp': None, u'name': u'untagged', u'id': 5005, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5005/'}, 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': 6, u'resource_uri': u'/MAAS/api/2.0/subnets/6/'}, u'ip_address': u'192.168.11.39', u'mode': u'dhcp', u'id': 29}], u'tags': [u'sriov'], u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'fabric_id': 4, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'7mhg7n', u'relay_vlan': None, u'external_dhcp': None, u'name': u'untagged', u'id': 5005, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5005/'}, u'enabled': True, u'children': [], u'discovered': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'fabric_id': 4, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'7mhg7n', u'relay_vlan': None, u'external_dhcp': None, u'name': u'untagged', u'id': 5005, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5005/'}, 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': 6, u'resource_uri': u'/MAAS/api/2.0/subnets/6/'}, u'ip_address': u'192.168.11.39'}], u'mac_address': u'9c:b6:54:8a:95:a0', u'params': u'', u'effective_mtu': 1500, u'parents': [], u'system_id': u'63msbg', u'type': u'physical', u'id': 5, u'resource_uri': u'/MAAS/api/2.0/nodes/63msbg/interfaces/5/'}, 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'fabric_id': 4, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'7mhg7n', u'relay_vlan': None, u'external_dhcp': None, u'name': u'untagged', u'id': 5005, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5005/'}, 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': 6, u'resource_uri': u'/MAAS/api/2.0/subnets/6/'}, u'ip_address': u'192.168.11.39', u'mode': u'dhcp', u'id': 29}], u'tags': [u'sriov'], u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'fabric_id': 4, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'7mhg7n', u'relay_vlan': None, u'external_dhcp': None, u'name': u'untagged', u'id': 5005, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5005/'}, u'enabled': True, u'children': [], u'discovered': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'fabric_id': 4, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'7mhg7n', u'relay_vlan': None, u'external_dhcp': None, u'name': u'untagged', u'id': 5005, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5005/'}, 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': 6, u'resource_uri': u'/MAAS/api/2.0/subnets/6/'}, u'ip_address': u'192.168.11.39'}], u'mac_address': u'9c:b6:54:8a:95:a0', u'params': u'', u'effective_mtu': 1500, u'parents': [], u'system_id': u'63msbg', u'type': u'physical', u'id': 5, u'resource_uri': u'/MAAS/api/2.0/nodes/63msbg/interfaces/5/'}, {u'name': u'ens1f1', u'links': [], u'tags': [u'sriov'], u'vlan': None, u'enabled': True, u'children': [], u'discovered': None, u'mac_address': u'38:ea:a7:8f:1f:d5', u'params': u'', u'effective_mtu': 1500, u'parents': [], u'system_id': u'63msbg', u'type': u'physical', u'id': 16, u'resource_uri': u'/MAAS/api/2.0/nodes/63msbg/interfaces/16/'}, {u'name': u'ens1f0', u'links': [], u'tags': [u'sriov'], u'vlan': None, u'enabled': True, u'children': [], u'discovered': None, u'mac_address': u'38:ea:a7:8f:1f:d4', u'params': u'', u'effective_mtu': 1500, u'parents': [], u'system_id': u'63msbg', u'type': u'physical', u'id': 19, u'resource_uri': u'/MAAS/api/2.0/nodes/63msbg/interfaces/19/'}, {u'name': u'ens2f0', u'links': [{u'mode': u'link_up', u'id': 30}], u'tags': [u'sriov'], u'vlan': {u'fabric': u'fabric-0', u'vid': 0, u'space': u'undefined', u'fabric_id': 0, u'dhcp_on': False, u'mtu': 1500, u'primary_rack': None, u'relay_vlan': None, u'external_dhcp': None, u'name': u'untagged', u'id': 5001, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/'}, u'enabled': True, u'children': [], u'discovered': None, u'mac_address': u'38:ea:a7:8f:52:cc', u'params': u'', u'effective_mtu': 1500, u'parents': [], u'system_id': u'63msbg', u'type': u'physical', u'id': 17, u'resource_uri': u'/MAAS/api/2.0/nodes/63msbg/interfaces/17/'}, {u'name': u'eno2', u'links': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'fabric_id': 4, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'7mhg7n', u'relay_vlan': None, u'external_dhcp': None, u'name': u'untagged', u'id': 5005, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5005/'}, 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': 6, u'resource_uri': u'/MAAS/api/2.0/subnets/6/'}, u'mode': u'link_up', u'id': 31}], u'tags': [u'sriov'], u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'fabric_id': 4, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'7mhg7n', u'relay_vlan': None, u'external_dhcp': None, u'name': u'untagged', u'id': 5005, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5005/'}, u'enabled': True, u'children': [], u'discovered': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'fabric_id': 4, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'7mhg7n', u'relay_vlan': None, u'external_dhcp': None, u'name': u'untagged', u'id': 5005, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5005/'}, 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': 6, u'resource_uri': u'/MAAS/api/2.0/subnets/6/'}, u'ip_address': u'192.168.11.44'}], u'mac_address': u'9c:b6:54:8a:95:a4', u'params': u'', u'effective_mtu': 1500, u'parents': [], u'system_id': u'63msbg', u'type': u'physical', u'id': 18, u'resource_uri': u'/MAAS/api/2.0/nodes/63msbg/interfaces/18/'}, {u'name': u'ens2f1', u'links': [{u'mode': u'link_up', u'id': 32}], u'tags': [u'sriov'], u'vlan': {u'fabric': u'fabric-0', u'vid': 0, u'space': u'undefined', u'fabric_id': 0, u'dhcp_on': False, u'mtu': 1500, u'primary_rack': None, u'relay_vlan': None, u'external_dhcp': None, u'name': u'untagged', u'id': 5001, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/'}, u'enabled': True, u'children': [], u'discovered': None, u'mac_address': u'38:ea:a7:8f:52:cd', u'params': u'', u'effective_mtu': 1500, u'parents': [], u'system_id': u'63msbg', u'type': u'physical', u'id': 20, u'resource_uri': u'/MAAS/api/2.0/nodes/63msbg/interfaces/20/'}], u'address_ttl': None, u'resource_uri': u'/MAAS/api/2.0/machines/63msbg/', u'distro_series': u'', u'commissioning_status_name': u'Passed'}
2020-01-06 20:19:00,780 [salt.state       :300 ][INFO    ][6185] {'new': {'storage_layout': 'lvm'}}
2020-01-06 20:19:00,780 [salt.state       :1951][INFO    ][6185] Completed state [maas_machines_storage_cmp001_lvm] at time 20:19:00.780891 duration_in_ms=2408.093
2020-01-06 20:19:00,784 [salt.minion      :1711][INFO    ][6185] Returning information for job: 20200106201845476689
2020-01-06 20:19:01,495 [salt.minion      :1308][INFO    ][2852] User sudo_ubuntu Executing command state.apply with jid 20200106201901478829
2020-01-06 20:19:01,516 [salt.minion      :1432][INFO    ][6272] Starting a new job with PID 6272
2020-01-06 20:19:02,666 [salt.state       :915 ][INFO    ][6272] Loading fresh modules for state activity
2020-01-06 20:19:02,719 [salt.fileclient  :1219][INFO    ][6272] Fetching file from saltenv 'base', ** done ** 'maas/machines/deploy.sls'
2020-01-06 20:19:02,767 [salt.state       :1780][INFO    ][6272] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 20:19:02.766977
2020-01-06 20:19:02,767 [salt.state       :1813][INFO    ][6272] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2020-01-06 20:19:02,769 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6272] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2020-01-06 20:19:04,708 [salt.state       :300 ][INFO    ][6272] {'pid': 6279, 'retcode': 0, 'stderr': '', 'stdout': ''}
2020-01-06 20:19:04,710 [salt.state       :1951][INFO    ][6272] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 20:19:04.709212 duration_in_ms=1942.236
2020-01-06 20:19:04,714 [salt.state       :1780][INFO    ][6272] Running state [maas.deploy_machines] at time 20:19:04.713915
2020-01-06 20:19:04,714 [salt.state       :1813][INFO    ][6272] Executing state module.run for [maas.deploy_machines]
2020-01-06 20:19:04,716 [salt.utils.decorators:613 ][WARNING ][6272] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-01-06 20:19:05,294 [salt.loaded.ext.module.maas:684 ][INFO    ][6272] deploymachines hwe_kernel=ga-18.04 system_id=4scnnb distro_series=bionic
2020-01-06 20:19:07,823 [salt.loaded.ext.module.maas:684 ][INFO    ][6272] deploymachines hwe_kernel=ga-18.04 system_id=63msbg distro_series=bionic
2020-01-06 20:19:10,498 [salt.loaded.ext.module.maas:684 ][INFO    ][6272] deploymachines hwe_kernel=ga-18.04 system_id=ammwy4 distro_series=bionic
2020-01-06 20:19:12,916 [salt.loaded.ext.module.maas:684 ][INFO    ][6272] deploymachines hwe_kernel=ga-18.04 system_id=ccsryd distro_series=bionic
2020-01-06 20:19:15,392 [salt.loaded.ext.module.maas:684 ][INFO    ][6272] deploymachines hwe_kernel=ga-18.04 system_id=cwt48r distro_series=bionic
2020-01-06 20:19:16,521 [salt.minion      :1308][INFO    ][2852] User sudo_ubuntu Executing command saltutil.find_job with jid 20200106201916508903
2020-01-06 20:19:16,544 [salt.minion      :1432][INFO    ][6539] Starting a new job with PID 6539
2020-01-06 20:19:16,573 [salt.minion      :1711][INFO    ][6539] Returning information for job: 20200106201916508903
2020-01-06 20:19:17,880 [salt.state       :300 ][INFO    ][6272] {'ret': {'updated': [], 'errors': {}, 'success': ['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']}}
2020-01-06 20:19:17,880 [salt.state       :1951][INFO    ][6272] Completed state [maas.deploy_machines] at time 20:19:17.880684 duration_in_ms=13166.768
2020-01-06 20:19:17,884 [salt.minion      :1711][INFO    ][6272] Returning information for job: 20200106201901478829
2020-01-06 20:19:18,639 [salt.minion      :1308][INFO    ][2852] User sudo_ubuntu Executing command state.apply with jid 20200106201918622664
2020-01-06 20:19:18,664 [salt.minion      :1432][INFO    ][6567] Starting a new job with PID 6567
2020-01-06 20:19:27,234 [salt.state       :915 ][INFO    ][6567] Loading fresh modules for state activity
2020-01-06 20:19:27,292 [salt.fileclient  :1219][INFO    ][6567] Fetching file from saltenv 'base', ** done ** 'maas/machines/wait_for_deployed.sls'
2020-01-06 20:19:27,347 [salt.state       :1780][INFO    ][6567] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 20:19:27.347099
2020-01-06 20:19:27,347 [salt.state       :1813][INFO    ][6567] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2020-01-06 20:19:27,349 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6567] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2020-01-06 20:19:29,185 [salt.state       :300 ][INFO    ][6567] {'pid': 6602, 'retcode': 0, 'stderr': '', 'stdout': ''}
2020-01-06 20:19:29,187 [salt.state       :1951][INFO    ][6567] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 20:19:29.186827 duration_in_ms=1839.728
2020-01-06 20:19:29,191 [salt.state       :1780][INFO    ][6567] Running state [maas.wait_for_machine_status] at time 20:19:29.191586
2020-01-06 20:19:29,192 [salt.state       :1813][INFO    ][6567] Executing state module.run for [maas.wait_for_machine_status]
2020-01-06 20:19:29,192 [salt.utils.decorators:613 ][WARNING ][6567] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2020-01-06 20:19:32,056 [salt.loaded.ext.module.maas:1023][INFO    ][6567] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2247.14931393s left)
2020-01-06 20:19:33,757 [salt.minion      :1308][INFO    ][2852] User sudo_ubuntu Executing command saltutil.find_job with jid 20200106201933746841
2020-01-06 20:19:33,789 [salt.minion      :1432][INFO    ][6617] Starting a new job with PID 6617
2020-01-06 20:19:33,819 [salt.minion      :1711][INFO    ][6617] Returning information for job: 20200106201933746841
2020-01-06 20:20:03,855 [salt.minion      :1308][INFO    ][2852] User sudo_ubuntu Executing command saltutil.find_job with jid 20200106202003843250
2020-01-06 20:20:03,879 [salt.minion      :1432][INFO    ][6654] Starting a new job with PID 6654
2020-01-06 20:20:03,909 [salt.minion      :1711][INFO    ][6654] Returning information for job: 20200106202003843250
2020-01-06 20:20:05,039 [salt.loaded.ext.module.maas:1023][INFO    ][6567] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2214.16689014s left)
2020-01-06 20:20:33,974 [salt.minion      :1308][INFO    ][2852] User sudo_ubuntu Executing command saltutil.find_job with jid 20200106202033957573
2020-01-06 20:20:34,000 [salt.minion      :1432][INFO    ][6709] Starting a new job with PID 6709
2020-01-06 20:20:34,034 [salt.minion      :1711][INFO    ][6709] Returning information for job: 20200106202033957573
2020-01-06 20:20:38,133 [salt.loaded.ext.module.maas:1023][INFO    ][6567] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2181.07289696s left)
2020-01-06 20:21:04,063 [salt.minion      :1308][INFO    ][2852] User sudo_ubuntu Executing command saltutil.find_job with jid 20200106202104045236
2020-01-06 20:21:04,093 [salt.minion      :1432][INFO    ][6744] Starting a new job with PID 6744
2020-01-06 20:21:04,138 [salt.minion      :1711][INFO    ][6744] Returning information for job: 20200106202104045236
2020-01-06 20:21:10,928 [salt.loaded.ext.module.maas:1023][INFO    ][6567] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2148.27713013s left)
2020-01-06 20:21:34,172 [salt.minion      :1308][INFO    ][2852] User sudo_ubuntu Executing command saltutil.find_job with jid 20200106202134156378
2020-01-06 20:21:34,200 [salt.minion      :1432][INFO    ][6789] Starting a new job with PID 6789
2020-01-06 20:21:34,232 [salt.minion      :1711][INFO    ][6789] Returning information for job: 20200106202134156378
2020-01-06 20:21:43,978 [salt.loaded.ext.module.maas:1023][INFO    ][6567] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2115.22751212s left)
2020-01-06 20:22:04,247 [salt.minion      :1308][INFO    ][2852] User sudo_ubuntu Executing command saltutil.find_job with jid 20200106202204230112
2020-01-06 20:22:04,275 [salt.minion      :1432][INFO    ][6837] Starting a new job with PID 6837
2020-01-06 20:22:04,305 [salt.minion      :1711][INFO    ][6837] Returning information for job: 20200106202204230112
2020-01-06 20:22:17,438 [salt.loaded.ext.module.maas:1023][INFO    ][6567] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2081.76758099s left)
2020-01-06 20:22:34,342 [salt.minion      :1308][INFO    ][2852] User sudo_ubuntu Executing command saltutil.find_job with jid 20200106202234326361
2020-01-06 20:22:34,368 [salt.minion      :1432][INFO    ][6977] Starting a new job with PID 6977
2020-01-06 20:22:34,404 [salt.minion      :1711][INFO    ][6977] Returning information for job: 20200106202234326361
2020-01-06 20:22:50,598 [salt.loaded.ext.module.maas:1023][INFO    ][6567] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2048.60774112s left)
2020-01-06 20:23:04,443 [salt.minion      :1308][INFO    ][2852] User sudo_ubuntu Executing command saltutil.find_job with jid 20200106202304432387
2020-01-06 20:23:04,468 [salt.minion      :1432][INFO    ][7120] Starting a new job with PID 7120
2020-01-06 20:23:04,498 [salt.minion      :1711][INFO    ][7120] Returning information for job: 20200106202304432387
2020-01-06 20:23:24,202 [salt.loaded.ext.module.maas:1023][INFO    ][6567] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2015.00379205s left)
2020-01-06 20:23:34,567 [salt.minion      :1308][INFO    ][2852] User sudo_ubuntu Executing command saltutil.find_job with jid 20200106202334556279
2020-01-06 20:23:34,588 [salt.minion      :1432][INFO    ][7391] Starting a new job with PID 7391
2020-01-06 20:23:34,617 [salt.minion      :1711][INFO    ][7391] Returning information for job: 20200106202334556279
2020-01-06 20:23:57,748 [salt.loaded.ext.module.maas:1023][INFO    ][6567] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1981.45789099s left)
2020-01-06 20:24:04,695 [salt.minion      :1308][INFO    ][2852] User sudo_ubuntu Executing command saltutil.find_job with jid 20200106202404681057
2020-01-06 20:24:04,721 [salt.minion      :1432][INFO    ][7535] Starting a new job with PID 7535
2020-01-06 20:24:04,748 [salt.minion      :1711][INFO    ][7535] Returning information for job: 20200106202404681057
2020-01-06 20:24:30,576 [salt.loaded.ext.module.maas:1023][INFO    ][6567] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1948.62949395s left)
2020-01-06 20:24:34,896 [salt.minion      :1308][INFO    ][2852] User sudo_ubuntu Executing command saltutil.find_job with jid 20200106202434872470
2020-01-06 20:24:34,924 [salt.minion      :1432][INFO    ][7882] Starting a new job with PID 7882
2020-01-06 20:24:34,954 [salt.minion      :1711][INFO    ][7882] Returning information for job: 20200106202434872470
2020-01-06 20:25:03,610 [salt.loaded.ext.module.maas:1023][INFO    ][6567] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1915.59593391s left)
2020-01-06 20:25:05,042 [salt.minion      :1308][INFO    ][2852] User sudo_ubuntu Executing command saltutil.find_job with jid 20200106202505030221
2020-01-06 20:25:05,070 [salt.minion      :1432][INFO    ][8024] Starting a new job with PID 8024
2020-01-06 20:25:05,097 [salt.minion      :1711][INFO    ][8024] Returning information for job: 20200106202505030221
2020-01-06 20:25:35,195 [salt.minion      :1308][INFO    ][2852] User sudo_ubuntu Executing command saltutil.find_job with jid 20200106202535184038
2020-01-06 20:25:35,211 [salt.minion      :1432][INFO    ][8301] Starting a new job with PID 8301
2020-01-06 20:25:35,234 [salt.minion      :1711][INFO    ][8301] Returning information for job: 20200106202535184038
2020-01-06 20:25:36,764 [salt.loaded.ext.module.maas:1023][INFO    ][6567] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1882.44144392s left)
2020-01-06 20:26:05,322 [salt.minion      :1308][INFO    ][2852] User sudo_ubuntu Executing command saltutil.find_job with jid 20200106202605310701
2020-01-06 20:26:05,351 [salt.minion      :1432][INFO    ][8417] Starting a new job with PID 8417
2020-01-06 20:26:05,374 [salt.minion      :1711][INFO    ][8417] Returning information for job: 20200106202605310701
2020-01-06 20:26:09,792 [salt.loaded.ext.module.maas:1023][INFO    ][6567] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1849.41300392s left)
2020-01-06 20:26:35,504 [salt.minion      :1308][INFO    ][2852] User sudo_ubuntu Executing command saltutil.find_job with jid 20200106202635487744
2020-01-06 20:26:35,529 [salt.minion      :1432][INFO    ][8641] Starting a new job with PID 8641
2020-01-06 20:26:35,550 [salt.minion      :1711][INFO    ][8641] Returning information for job: 20200106202635487744
2020-01-06 20:26:42,576 [salt.loaded.ext.module.maas:1023][INFO    ][6567] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1816.62899613s left)
2020-01-06 20:27:05,643 [salt.minion      :1308][INFO    ][2852] User sudo_ubuntu Executing command saltutil.find_job with jid 20200106202705630444
2020-01-06 20:27:05,668 [salt.minion      :1432][INFO    ][8751] Starting a new job with PID 8751
2020-01-06 20:27:05,692 [salt.minion      :1711][INFO    ][8751] Returning information for job: 20200106202705630444
2020-01-06 20:27:15,638 [salt.loaded.ext.module.maas:1023][INFO    ][6567] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1783.56737614s left)
2020-01-06 20:27:35,816 [salt.minion      :1308][INFO    ][2852] User sudo_ubuntu Executing command saltutil.find_job with jid 20200106202735796060
2020-01-06 20:27:35,847 [salt.minion      :1432][INFO    ][9037] Starting a new job with PID 9037
2020-01-06 20:27:35,871 [salt.minion      :1711][INFO    ][9037] Returning information for job: 20200106202735796060
2020-01-06 20:27:48,529 [salt.loaded.ext.module.maas:1023][INFO    ][6567] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1750.67682099s left)
2020-01-06 20:28:05,969 [salt.minion      :1308][INFO    ][2852] User sudo_ubuntu Executing command saltutil.find_job with jid 20200106202805956320
2020-01-06 20:28:05,995 [salt.minion      :1432][INFO    ][9143] Starting a new job with PID 9143
2020-01-06 20:28:06,017 [salt.minion      :1711][INFO    ][9143] Returning information for job: 20200106202805956320
2020-01-06 20:28:21,634 [salt.loaded.ext.module.maas:1023][INFO    ][6567] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1717.57151413s left)
2020-01-06 20:28:36,131 [salt.minion      :1308][INFO    ][2852] User sudo_ubuntu Executing command saltutil.find_job with jid 20200106202836115435
2020-01-06 20:28:36,157 [salt.minion      :1432][INFO    ][9260] Starting a new job with PID 9260
2020-01-06 20:28:36,183 [salt.minion      :1711][INFO    ][9260] Returning information for job: 20200106202836115435
2020-01-06 20:28:54,636 [salt.loaded.ext.module.maas:1023][INFO    ][6567] Waiting status:Deployed for machines:['kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1684.569947s left)
2020-01-06 20:29:06,204 [salt.minion      :1308][INFO    ][2852] User sudo_ubuntu Executing command saltutil.find_job with jid 20200106202906184854
2020-01-06 20:29:06,240 [salt.minion      :1432][INFO    ][9375] Starting a new job with PID 9375
2020-01-06 20:29:06,266 [salt.minion      :1711][INFO    ][9375] Returning information for job: 20200106202906184854
2020-01-06 20:29:27,768 [salt.loaded.ext.module.maas:1023][INFO    ][6567] Waiting status:Deployed for machines:['kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1651.43787503s left)
2020-01-06 20:29:36,422 [salt.minion      :1308][INFO    ][2852] User sudo_ubuntu Executing command saltutil.find_job with jid 20200106202936407328
2020-01-06 20:29:36,451 [salt.minion      :1432][INFO    ][9576] Starting a new job with PID 9576
2020-01-06 20:29:36,472 [salt.minion      :1711][INFO    ][9576] Returning information for job: 20200106202936407328
2020-01-06 20:30:00,635 [salt.loaded.ext.module.maas:1023][INFO    ][6567] Waiting status:Deployed for machines:['kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1618.57068515s left)
2020-01-06 20:30:06,615 [salt.minion      :1308][INFO    ][2852] User sudo_ubuntu Executing command saltutil.find_job with jid 20200106203006591155
2020-01-06 20:30:06,651 [salt.minion      :1432][INFO    ][9705] Starting a new job with PID 9705
2020-01-06 20:30:06,684 [salt.minion      :1711][INFO    ][9705] Returning information for job: 20200106203006591155
2020-01-06 20:30:33,516 [salt.loaded.ext.module.maas:1023][INFO    ][6567] Waiting status:Deployed for machines:['kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1585.68929601s left)
2020-01-06 20:30:36,812 [salt.minion      :1308][INFO    ][2852] User sudo_ubuntu Executing command saltutil.find_job with jid 20200106203036794820
2020-01-06 20:30:36,843 [salt.minion      :1432][INFO    ][9752] Starting a new job with PID 9752
2020-01-06 20:30:36,865 [salt.minion      :1711][INFO    ][9752] Returning information for job: 20200106203036794820
2020-01-06 20:31:06,258 [salt.loaded.ext.module.maas:1023][INFO    ][6567] Waiting status:Deployed for machines:['kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1552.94865298s left)
2020-01-06 20:31:07,006 [salt.minion      :1308][INFO    ][2852] User sudo_ubuntu Executing command saltutil.find_job with jid 20200106203106995288
2020-01-06 20:31:07,031 [salt.minion      :1432][INFO    ][9796] Starting a new job with PID 9796
2020-01-06 20:31:07,053 [salt.minion      :1711][INFO    ][9796] Returning information for job: 20200106203106995288
2020-01-06 20:31:37,131 [salt.minion      :1308][INFO    ][2852] User sudo_ubuntu Executing command saltutil.find_job with jid 20200106203137118943
2020-01-06 20:31:37,152 [salt.minion      :1432][INFO    ][9919] Starting a new job with PID 9919
2020-01-06 20:31:37,174 [salt.minion      :1711][INFO    ][9919] Returning information for job: 20200106203137118943
2020-01-06 20:31:39,355 [salt.loaded.ext.module.maas:1023][INFO    ][6567] Waiting status:Deployed for machines:['kvm03']
sleep for:30s Timeout:2250s (1519.85071802s left)
2020-01-06 20:32:07,346 [salt.minion      :1308][INFO    ][2852] User sudo_ubuntu Executing command saltutil.find_job with jid 20200106203207333817
2020-01-06 20:32:07,372 [salt.minion      :1432][INFO    ][10016] Starting a new job with PID 10016
2020-01-06 20:32:07,399 [salt.minion      :1711][INFO    ][10016] Returning information for job: 20200106203207333817
2020-01-06 20:32:12,088 [salt.state       :300 ][INFO    ][6567] {'ret': True}
2020-01-06 20:32:12,089 [salt.state       :1951][INFO    ][6567] Completed state [maas.wait_for_machine_status] at time 20:32:12.088978 duration_in_ms=762897.388
2020-01-06 20:32:12,097 [salt.minion      :1711][INFO    ][6567] Returning information for job: 20200106201918622664
2020-01-06 21:10:13,465 [salt.utils.schedule:1377][INFO    ][2852] Running scheduled job: __mine_interval
2020-01-06 22:10:13,465 [salt.utils.schedule:1377][INFO    ][2852] Running scheduled job: __mine_interval
2020-01-06 22:18:55,307 [salt.minion      :1308][INFO    ][2852] User sudo_ubuntu Executing command cp.push_dir with jid 20200106221855291274
2020-01-06 22:18:55,336 [salt.minion      :1432][INFO    ][17488] Starting a new job with PID 17488
