2019-09-02 02:06:44,484 [salt.utils.decorators:613 ][WARNING ][2213] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-09-02 02:06:45,393 [salt.utils.decorators:613 ][WARNING ][2213] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-09-02 02:06:48,304 [salt.loaded.int.states.file:2298][WARNING ][2451] 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-09-02 02:07:03,387 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2858] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2019-09-02 02:07:03,407 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2858] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2019-09-02 02:07:03,447 [salt.utils.parsers:1051][WARNING ][378] Minion received a SIGTERM. Exiting.
2019-09-02 02:07:04,467 [salt.cli.daemons :293 ][INFO    ][2968] Setting up the Salt Minion "mas01.mcp-odl-ha.local"
2019-09-02 02:07:04,579 [salt.cli.daemons :82  ][INFO    ][2968] Starting up the Salt Minion
2019-09-02 02:07:04,580 [salt.utils.event :1017][INFO    ][2968] Starting pull socket on /var/run/salt/minion/minion_event_3e82045771_pull.ipc
2019-09-02 02:07:05,631 [salt.minion      :976 ][INFO    ][2968] Creating minion process manager
2019-09-02 02:07:07,374 [salt.loader.10.20.0.2.int.module.cmdmod:395 ][INFO    ][2968] Executing command ['date', '+%z'] in directory '/root'
2019-09-02 02:07:07,391 [salt.utils.schedule:568 ][INFO    ][2968] Updating job settings for scheduled job: __mine_interval
2019-09-02 02:07:07,393 [salt.minion      :1108][INFO    ][2968] Added mine.update to scheduler
2019-09-02 02:07:07,399 [salt.minion      :1975][INFO    ][2968] Minion is starting as user 'root'
2019-09-02 02:07:07,412 [salt.minion      :2336][INFO    ][2968] Minion is ready to receive requests!
2019-09-02 02:07:11,797 [salt.state       :2022][WARNING ][2862] State is set to retry, but a valid dict for retry configuration was not found.  Using retry defaults
2019-09-02 02:07:14,828 [salt.utils.decorators:613 ][WARNING ][2862] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-09-02 02:07:16,283 [salt.minion      :1308][INFO    ][2968] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902020716269163
2019-09-02 02:07:16,305 [salt.minion      :1432][INFO    ][3413] Starting a new job with PID 3413
2019-09-02 02:07:16,330 [salt.minion      :1711][INFO    ][3413] Returning information for job: 20190902020716269163
2019-09-02 02:07:25,784 [salt.utils.decorators:613 ][WARNING ][2862] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-09-02 02:07:46,392 [salt.minion      :1308][INFO    ][2968] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902020746380762
2019-09-02 02:07:46,411 [salt.minion      :1432][INFO    ][4176] Starting a new job with PID 4176
2019-09-02 02:07:46,430 [salt.minion      :1711][INFO    ][4176] Returning information for job: 20190902020746380762
2019-09-02 02:07:47,634 [salt.utils.decorators:613 ][WARNING ][2862] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-09-02 02:07:48,565 [salt.utils.decorators:613 ][WARNING ][2862] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-09-02 02:07:50,844 [salt.loaded.ext.module.maasng:1008][WARNING ][2862] Detected cidr:192.168.11.0/24 in fabric:fabric-1
2019-09-02 02:07:50,844 [salt.loaded.ext.module.maasng:1011][WARNING ][2862] Guessing, that fabric with current name:fabric-1
 should be renamed to:pxe_admin
2019-09-02 02:07:51,596 [salt.loaded.ext.module.maasng:1235][WARNING ][2862] Ignoring parameter vlan:0
2019-09-02 02:07:53,180 [salt.minion      :1308][INFO    ][2968] User sudo_ubuntu Executing command state.apply with jid 20190902020753160347
2019-09-02 02:07:53,203 [salt.minion      :1432][INFO    ][4401] Starting a new job with PID 4401
2019-09-02 02:07:59,268 [salt.state       :915 ][INFO    ][4401] Loading fresh modules for state activity
2019-09-02 02:07:59,335 [salt.fileclient  :1219][INFO    ][4401] Fetching file from saltenv 'base', ** done ** 'maas/machines/init.sls'
2019-09-02 02:07:59,380 [salt.state       :1780][INFO    ][4401] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 02:07:59.379979
2019-09-02 02:07:59,380 [salt.state       :1813][INFO    ][4401] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2019-09-02 02:07:59,382 [salt.loaded.int.module.cmdmod:395 ][INFO    ][4401] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2019-09-02 02:08:01,076 [salt.state       :300 ][INFO    ][4401] {'pid': 4425, 'retcode': 0, 'stderr': '', 'stdout': ''}
2019-09-02 02:08:01,077 [salt.state       :1951][INFO    ][4401] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 02:08:01.077340 duration_in_ms=1697.361
2019-09-02 02:08:01,080 [salt.state       :1780][INFO    ][4401] Running state [maas.process_machines] at time 02:08:01.080127
2019-09-02 02:08:01,080 [salt.state       :1813][INFO    ][4401] Executing state module.run for [maas.process_machines]
2019-09-02 02:08:01,083 [salt.utils.decorators:613 ][WARNING ][4401] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-09-02 02:08:01,139 [salt.loaded.ext.module.maas:412 ][WARNING ][4401] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2019-09-02 02:08:01,140 [salt.loaded.ext.module.maas:92  ][INFO    ][4401] 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-09-02 02:08:02,728 [salt.loaded.ext.module.maas:412 ][WARNING ][4401] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2019-09-02 02:08:02,729 [salt.loaded.ext.module.maas:92  ][INFO    ][4401] 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-09-02 02:08:04,053 [salt.loaded.ext.module.maas:412 ][WARNING ][4401] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2019-09-02 02:08:04,054 [salt.loaded.ext.module.maas:92  ][INFO    ][4401] 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-09-02 02:08:05,293 [salt.loaded.ext.module.maas:412 ][WARNING ][4401] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2019-09-02 02:08:05,296 [salt.loaded.ext.module.maas:92  ][INFO    ][4401] 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-09-02 02:08:06,581 [salt.loaded.ext.module.maas:412 ][WARNING ][4401] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2019-09-02 02:08:06,581 [salt.loaded.ext.module.maas:92  ][INFO    ][4401] 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-09-02 02:08:07,919 [salt.state       :300 ][INFO    ][4401] {'ret': {'updated': [], 'errors': {}, 'success': ['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']}}
2019-09-02 02:08:07,919 [salt.state       :1951][INFO    ][4401] Completed state [maas.process_machines] at time 02:08:07.919371 duration_in_ms=6839.244
2019-09-02 02:08:07,924 [salt.minion      :1711][INFO    ][4401] Returning information for job: 20190902020753160347
2019-09-02 02:08:39,013 [salt.minion      :1308][INFO    ][2968] User sudo_ubuntu Executing command state.apply with jid 20190902020838996736
2019-09-02 02:08:39,040 [salt.minion      :1432][INFO    ][4763] Starting a new job with PID 4763
2019-09-02 02:08:45,145 [salt.state       :915 ][INFO    ][4763] Loading fresh modules for state activity
2019-09-02 02:08:45,203 [salt.fileclient  :1219][INFO    ][4763] Fetching file from saltenv 'base', ** done ** 'maas/machines/wait_for_ready_or_deployed.sls'
2019-09-02 02:08:45,252 [salt.state       :1780][INFO    ][4763] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 02:08:45.252869
2019-09-02 02:08:45,253 [salt.state       :1813][INFO    ][4763] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2019-09-02 02:08:45,255 [salt.loaded.int.module.cmdmod:395 ][INFO    ][4763] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2019-09-02 02:08:47,112 [salt.state       :300 ][INFO    ][4763] {'pid': 4773, 'retcode': 0, 'stderr': '', 'stdout': ''}
2019-09-02 02:08:47,113 [salt.state       :1951][INFO    ][4763] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 02:08:47.113025 duration_in_ms=1860.155
2019-09-02 02:08:47,116 [salt.state       :1780][INFO    ][4763] Running state [maas.wait_for_machine_status] at time 02:08:47.116720
2019-09-02 02:08:47,117 [salt.state       :1813][INFO    ][4763] Executing state module.run for [maas.wait_for_machine_status]
2019-09-02 02:08:47,118 [salt.utils.decorators:613 ][WARNING ][4763] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-09-02 02:08:47,992 [salt.loaded.ext.module.maas:1023][INFO    ][4763] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1499.13897514s left)
2019-09-02 02:08:54,112 [salt.minion      :1308][INFO    ][2968] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902020854096870
2019-09-02 02:08:54,139 [salt.minion      :1432][INFO    ][4787] Starting a new job with PID 4787
2019-09-02 02:08:54,161 [salt.minion      :1711][INFO    ][4787] Returning information for job: 20190902020854096870
2019-09-02 02:09:18,939 [salt.loaded.ext.module.maas:1023][INFO    ][4763] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1468.19193006s left)
2019-09-02 02:09:24,178 [salt.minion      :1308][INFO    ][2968] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902020924166953
2019-09-02 02:09:24,199 [salt.minion      :1432][INFO    ][4842] Starting a new job with PID 4842
2019-09-02 02:09:24,221 [salt.minion      :1711][INFO    ][4842] Returning information for job: 20190902020924166953
2019-09-02 02:09:49,765 [salt.loaded.ext.module.maas:1023][INFO    ][4763] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1437.36554599s left)
2019-09-02 02:09:54,265 [salt.minion      :1308][INFO    ][2968] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902020954251293
2019-09-02 02:09:54,294 [salt.minion      :1432][INFO    ][4863] Starting a new job with PID 4863
2019-09-02 02:09:54,316 [salt.minion      :1711][INFO    ][4863] Returning information for job: 20190902020954251293
2019-09-02 02:10:20,617 [salt.loaded.ext.module.maas:1023][INFO    ][4763] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1406.51409197s left)
2019-09-02 02:10:24,356 [salt.minion      :1308][INFO    ][2968] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902021024344213
2019-09-02 02:10:24,388 [salt.minion      :1432][INFO    ][4921] Starting a new job with PID 4921
2019-09-02 02:10:24,412 [salt.minion      :1711][INFO    ][4921] Returning information for job: 20190902021024344213
2019-09-02 02:10:51,763 [salt.loaded.ext.module.maas:1023][INFO    ][4763] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1375.36808896s left)
2019-09-02 02:10:54,452 [salt.minion      :1308][INFO    ][2968] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902021054438567
2019-09-02 02:10:54,479 [salt.minion      :1432][INFO    ][4976] Starting a new job with PID 4976
2019-09-02 02:10:54,504 [salt.minion      :1711][INFO    ][4976] Returning information for job: 20190902021054438567
2019-09-02 02:11:22,895 [salt.loaded.ext.module.maas:1023][INFO    ][4763] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1344.23618293s left)
2019-09-02 02:11:24,564 [salt.minion      :1308][INFO    ][2968] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902021124548416
2019-09-02 02:11:24,591 [salt.minion      :1432][INFO    ][5231] Starting a new job with PID 5231
2019-09-02 02:11:24,612 [salt.minion      :1711][INFO    ][5231] Returning information for job: 20190902021124548416
2019-09-02 02:11:54,212 [salt.loaded.ext.module.maas:1023][INFO    ][4763] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1312.91863298s left)
2019-09-02 02:11:54,656 [salt.minion      :1308][INFO    ][2968] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902021154643881
2019-09-02 02:11:54,683 [salt.minion      :1432][INFO    ][5283] Starting a new job with PID 5283
2019-09-02 02:11:54,707 [salt.minion      :1711][INFO    ][5283] Returning information for job: 20190902021154643881
2019-09-02 02:12:24,800 [salt.minion      :1308][INFO    ][2968] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902021224783980
2019-09-02 02:12:24,821 [salt.minion      :1432][INFO    ][5542] Starting a new job with PID 5542
2019-09-02 02:12:24,841 [salt.minion      :1711][INFO    ][5542] Returning information for job: 20190902021224783980
2019-09-02 02:12:25,944 [salt.loaded.ext.module.maas:1023][INFO    ][4763] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1281.18638992s left)
2019-09-02 02:12:54,897 [salt.minion      :1308][INFO    ][2968] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902021254879004
2019-09-02 02:12:54,927 [salt.minion      :1432][INFO    ][5621] Starting a new job with PID 5621
2019-09-02 02:12:54,950 [salt.minion      :1711][INFO    ][5621] Returning information for job: 20190902021254879004
2019-09-02 02:12:57,627 [salt.loaded.ext.module.maas:1023][INFO    ][4763] Waiting status:Ready|Deployed for machines:['cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1249.50351501s left)
2019-09-02 02:13:25,051 [salt.minion      :1308][INFO    ][2968] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902021325034642
2019-09-02 02:13:25,077 [salt.minion      :1432][INFO    ][6024] Starting a new job with PID 6024
2019-09-02 02:13:25,103 [salt.minion      :1711][INFO    ][6024] Returning information for job: 20190902021325034642
2019-09-02 02:13:29,732 [salt.loaded.ext.module.maas:1023][INFO    ][4763] Waiting status:Ready|Deployed for machines:['kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1217.39818096s left)
2019-09-02 02:13:55,173 [salt.minion      :1308][INFO    ][2968] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902021355156294
2019-09-02 02:13:55,205 [salt.minion      :1432][INFO    ][6055] Starting a new job with PID 6055
2019-09-02 02:13:55,227 [salt.minion      :1711][INFO    ][6055] Returning information for job: 20190902021355156294
2019-09-02 02:14:02,086 [salt.loaded.ext.module.maas:1023][INFO    ][4763] Waiting status:Ready|Deployed for machines:['kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1185.04473495s left)
2019-09-02 02:14:25,304 [salt.minion      :1308][INFO    ][2968] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902021425291104
2019-09-02 02:14:25,336 [salt.minion      :1432][INFO    ][6189] Starting a new job with PID 6189
2019-09-02 02:14:25,359 [salt.minion      :1711][INFO    ][6189] Returning information for job: 20190902021425291104
2019-09-02 02:14:34,728 [salt.loaded.ext.module.maas:1023][INFO    ][4763] Waiting status:Ready|Deployed for machines:['kvm02']
sleep for:30s Timeout:1500s (1152.40281105s left)
2019-09-02 02:14:55,431 [salt.minion      :1308][INFO    ][2968] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902021455417546
2019-09-02 02:14:55,458 [salt.minion      :1432][INFO    ][6224] Starting a new job with PID 6224
2019-09-02 02:14:55,480 [salt.minion      :1711][INFO    ][6224] Returning information for job: 20190902021455417546
2019-09-02 02:15:07,270 [salt.loaded.ext.module.maas:1023][INFO    ][4763] Waiting status:Ready|Deployed for machines:['kvm02']
sleep for:30s Timeout:1500s (1119.86078405s left)
2019-09-02 02:15:25,576 [salt.minion      :1308][INFO    ][2968] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902021525559421
2019-09-02 02:15:25,604 [salt.minion      :1432][INFO    ][6280] Starting a new job with PID 6280
2019-09-02 02:15:25,627 [salt.minion      :1711][INFO    ][6280] Returning information for job: 20190902021525559421
2019-09-02 02:15:39,784 [salt.loaded.ext.module.maas:1023][INFO    ][4763] Waiting status:Ready|Deployed for machines:['kvm02']
sleep for:30s Timeout:1500s (1087.34663701s left)
2019-09-02 02:15:55,709 [salt.minion      :1308][INFO    ][2968] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902021555699504
2019-09-02 02:15:55,736 [salt.minion      :1432][INFO    ][6300] Starting a new job with PID 6300
2019-09-02 02:15:55,759 [salt.minion      :1711][INFO    ][6300] Returning information for job: 20190902021555699504
2019-09-02 02:16:12,316 [salt.loaded.ext.module.maas:1023][INFO    ][4763] Waiting status:Ready|Deployed for machines:['kvm02']
sleep for:30s Timeout:1500s (1054.81430793s left)
2019-09-02 02:16:25,848 [salt.minion      :1308][INFO    ][2968] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902021625839289
2019-09-02 02:16:25,879 [salt.minion      :1432][INFO    ][6356] Starting a new job with PID 6356
2019-09-02 02:16:25,899 [salt.minion      :1711][INFO    ][6356] Returning information for job: 20190902021625839289
2019-09-02 02:16:45,031 [salt.loaded.ext.module.maas:1023][INFO    ][4763] Waiting status:Ready|Deployed for machines:['kvm02']
sleep for:30s Timeout:1500s (1022.09997201s left)
2019-09-02 02:16:56,003 [salt.minion      :1308][INFO    ][2968] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902021655994693
2019-09-02 02:16:56,033 [salt.minion      :1432][INFO    ][6376] Starting a new job with PID 6376
2019-09-02 02:16:56,058 [salt.minion      :1711][INFO    ][6376] Returning information for job: 20190902021655994693
2019-09-02 02:17:17,763 [salt.loaded.ext.module.maas:1023][INFO    ][4763] Waiting status:Ready|Deployed for machines:['kvm02']
sleep for:30s Timeout:1500s (989.367845058s left)
2019-09-02 02:17:26,152 [salt.minion      :1308][INFO    ][2968] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902021726138667
2019-09-02 02:17:26,183 [salt.minion      :1432][INFO    ][6451] Starting a new job with PID 6451
2019-09-02 02:17:26,207 [salt.minion      :1711][INFO    ][6451] Returning information for job: 20190902021726138667
2019-09-02 02:17:50,384 [salt.loaded.ext.module.maas:1023][INFO    ][4763] Waiting status:Ready|Deployed for machines:['kvm02']
sleep for:30s Timeout:1500s (956.746907949s left)
2019-09-02 02:17:56,336 [salt.minion      :1308][INFO    ][2968] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902021756323119
2019-09-02 02:17:56,361 [salt.minion      :1432][INFO    ][6479] Starting a new job with PID 6479
2019-09-02 02:17:56,382 [salt.minion      :1711][INFO    ][6479] Returning information for job: 20190902021756323119
2019-09-02 02:18:23,064 [salt.loaded.ext.module.maas:981 ][INFO    ][4763] Machine ynw8np deleted
2019-09-02 02:18:23,844 [salt.loaded.ext.module.maas:412 ][WARNING ][4763] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2019-09-02 02:18:23,845 [salt.loaded.ext.module.maas:92  ][INFO    ][4763] 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 system_id=gngcxr architecture=amd64/generic power_parameters_power_user=opnfv
2019-09-02 02:18:24,996 [salt.loaded.ext.module.maas:412 ][WARNING ][4763] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2019-09-02 02:18:24,996 [salt.loaded.ext.module.maas:92  ][INFO    ][4763] 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 system_id=prqykn architecture=amd64/generic power_parameters_power_user=opnfv
2019-09-02 02:18:26,202 [salt.loaded.ext.module.maas:412 ][WARNING ][4763] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2019-09-02 02:18:26,204 [salt.loaded.ext.module.maas:92  ][INFO    ][4763] 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 system_id=em4ms3 architecture=amd64/generic power_parameters_power_user=opnfv
2019-09-02 02:18:26,485 [salt.minion      :1308][INFO    ][2968] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902021826472843
2019-09-02 02:18:26,512 [salt.minion      :1432][INFO    ][6641] Starting a new job with PID 6641
2019-09-02 02:18:26,536 [salt.minion      :1711][INFO    ][6641] Returning information for job: 20190902021826472843
2019-09-02 02:18:27,394 [salt.loaded.ext.module.maas:412 ][WARNING ][4763] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2019-09-02 02:18:27,395 [salt.loaded.ext.module.maas:92  ][INFO    ][4763] 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 system_id=rtxmke architecture=amd64/generic power_parameters_power_user=opnfv
2019-09-02 02:18:28,564 [salt.loaded.ext.module.maas:412 ][WARNING ][4763] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2019-09-02 02:18:28,565 [salt.loaded.ext.module.maas:92  ][INFO    ][4763] 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-09-02 02:18:30,007 [salt.loaded.ext.module.maas:1023][INFO    ][4763] Waiting status:Ready|Deployed for machines:['kvm02']
sleep for:30s Timeout:1500s (917.123655081s left)
2019-09-02 02:18:56,664 [salt.minion      :1308][INFO    ][2968] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902021856650835
2019-09-02 02:18:56,691 [salt.minion      :1432][INFO    ][6776] Starting a new job with PID 6776
2019-09-02 02:18:56,712 [salt.minion      :1711][INFO    ][6776] Returning information for job: 20190902021856650835
2019-09-02 02:19:02,607 [salt.loaded.ext.module.maas:1023][INFO    ][4763] Waiting status:Ready|Deployed for machines:['kvm02']
sleep for:30s Timeout:1500s (884.523230076s left)
2019-09-02 02:19:26,844 [salt.minion      :1308][INFO    ][2968] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902021926835385
2019-09-02 02:19:26,868 [salt.minion      :1432][INFO    ][6834] Starting a new job with PID 6834
2019-09-02 02:19:26,890 [salt.minion      :1711][INFO    ][6834] Returning information for job: 20190902021926835385
2019-09-02 02:19:35,100 [salt.loaded.ext.module.maas:1023][INFO    ][4763] Waiting status:Ready|Deployed for machines:['kvm02']
sleep for:30s Timeout:1500s (852.030872107s left)
2019-09-02 02:19:57,036 [salt.minion      :1308][INFO    ][2968] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902021957020198
2019-09-02 02:19:57,068 [salt.minion      :1432][INFO    ][6854] Starting a new job with PID 6854
2019-09-02 02:19:57,090 [salt.minion      :1711][INFO    ][6854] Returning information for job: 20190902021957020198
2019-09-02 02:20:07,767 [salt.loaded.ext.module.maas:1023][INFO    ][4763] Waiting status:Ready|Deployed for machines:['kvm02']
sleep for:30s Timeout:1500s (819.363282919s left)
2019-09-02 02:20:27,233 [salt.minion      :1308][INFO    ][2968] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902022027215826
2019-09-02 02:20:27,260 [salt.minion      :1432][INFO    ][6910] Starting a new job with PID 6910
2019-09-02 02:20:27,281 [salt.minion      :1711][INFO    ][6910] Returning information for job: 20190902022027215826
2019-09-02 02:20:40,484 [salt.loaded.ext.module.maas:1023][INFO    ][4763] Waiting status:Ready|Deployed for machines:['kvm02']
sleep for:30s Timeout:1500s (786.64648509s left)
2019-09-02 02:20:57,439 [salt.minion      :1308][INFO    ][2968] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902022057426972
2019-09-02 02:20:57,465 [salt.minion      :1432][INFO    ][6937] Starting a new job with PID 6937
2019-09-02 02:20:57,485 [salt.minion      :1711][INFO    ][6937] Returning information for job: 20190902022057426972
2019-09-02 02:21:12,971 [salt.loaded.ext.module.maas:1023][INFO    ][4763] Waiting status:Ready|Deployed for machines:['kvm02']
sleep for:30s Timeout:1500s (754.159538031s left)
2019-09-02 02:21:27,642 [salt.minion      :1308][INFO    ][2968] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902022127633360
2019-09-02 02:21:27,658 [salt.minion      :1432][INFO    ][6999] Starting a new job with PID 6999
2019-09-02 02:21:27,678 [salt.minion      :1711][INFO    ][6999] Returning information for job: 20190902022127633360
2019-09-02 02:21:45,627 [salt.loaded.ext.module.maas:1023][INFO    ][4763] Waiting status:Ready|Deployed for machines:['kvm02']
sleep for:30s Timeout:1500s (721.505618095s left)
2019-09-02 02:21:57,846 [salt.minion      :1308][INFO    ][2968] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902022157831029
2019-09-02 02:21:57,873 [salt.minion      :1432][INFO    ][7027] Starting a new job with PID 7027
2019-09-02 02:21:57,894 [salt.minion      :1711][INFO    ][7027] Returning information for job: 20190902022157831029
2019-09-02 02:22:18,174 [salt.loaded.ext.module.maas:1023][INFO    ][4763] Waiting status:Ready|Deployed for machines:['kvm02']
sleep for:30s Timeout:1500s (688.956424952s left)
2019-09-02 02:22:27,895 [salt.minion      :1308][INFO    ][2968] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902022227880406
2019-09-02 02:22:27,922 [salt.minion      :1432][INFO    ][7092] Starting a new job with PID 7092
2019-09-02 02:22:27,942 [salt.minion      :1711][INFO    ][7092] Returning information for job: 20190902022227880406
2019-09-02 02:22:50,341 [salt.loaded.ext.module.maas:1023][INFO    ][4763] Waiting status:Ready|Deployed for machines:['kvm02']
sleep for:30s Timeout:1500s (656.789801121s left)
2019-09-02 02:22:58,092 [salt.minion      :1308][INFO    ][2968] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902022258078376
2019-09-02 02:22:58,116 [salt.minion      :1432][INFO    ][7155] Starting a new job with PID 7155
2019-09-02 02:22:58,140 [salt.minion      :1711][INFO    ][7155] Returning information for job: 20190902022258078376
2019-09-02 02:23:22,582 [salt.loaded.ext.module.maas:1023][INFO    ][4763] Waiting status:Ready|Deployed for machines:['kvm02']
sleep for:30s Timeout:1500s (624.549194098s left)
2019-09-02 02:23:28,162 [salt.minion      :1308][INFO    ][2968] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902022328151117
2019-09-02 02:23:28,187 [salt.minion      :1432][INFO    ][7327] Starting a new job with PID 7327
2019-09-02 02:23:28,209 [salt.minion      :1711][INFO    ][7327] Returning information for job: 20190902022328151117
2019-09-02 02:23:54,874 [salt.loaded.ext.module.maas:1023][INFO    ][4763] Waiting status:Ready|Deployed for machines:['kvm02']
sleep for:30s Timeout:1500s (592.256593943s left)
2019-09-02 02:23:58,239 [salt.minion      :1308][INFO    ][2968] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902022358219928
2019-09-02 02:23:58,268 [salt.minion      :1432][INFO    ][7369] Starting a new job with PID 7369
2019-09-02 02:23:58,294 [salt.minion      :1711][INFO    ][7369] Returning information for job: 20190902022358219928
2019-09-02 02:24:27,164 [salt.loaded.ext.module.maas:1023][INFO    ][4763] Waiting status:Ready|Deployed for machines:['kvm02']
sleep for:30s Timeout:1500s (559.967127085s left)
2019-09-02 02:24:28,356 [salt.minion      :1308][INFO    ][2968] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902022428337202
2019-09-02 02:24:28,384 [salt.minion      :1432][INFO    ][7471] Starting a new job with PID 7471
2019-09-02 02:24:28,409 [salt.minion      :1711][INFO    ][7471] Returning information for job: 20190902022428337202
2019-09-02 02:24:58,459 [salt.minion      :1308][INFO    ][2968] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902022458440242
2019-09-02 02:24:58,482 [salt.minion      :1432][INFO    ][7537] Starting a new job with PID 7537
2019-09-02 02:24:58,504 [salt.minion      :1711][INFO    ][7537] Returning information for job: 20190902022458440242
2019-09-02 02:24:59,780 [salt.state       :300 ][INFO    ][4763] {'ret': True}
2019-09-02 02:24:59,781 [salt.state       :1951][INFO    ][4763] Completed state [maas.wait_for_machine_status] at time 02:24:59.781297 duration_in_ms=972664.571
2019-09-02 02:24:59,789 [salt.minion      :1711][INFO    ][4763] Returning information for job: 20190902020838996736
2019-09-02 02:25:00,391 [salt.minion      :1308][INFO    ][2968] User sudo_ubuntu Executing command state.apply with jid 20190902022500373625
2019-09-02 02:25:00,419 [salt.minion      :1432][INFO    ][7546] Starting a new job with PID 7546
2019-09-02 02:25:06,487 [salt.state       :915 ][INFO    ][7546] Loading fresh modules for state activity
2019-09-02 02:25:06,548 [salt.fileclient  :1219][INFO    ][7546] Fetching file from saltenv 'base', ** done ** 'maas/machines/storage.sls'
2019-09-02 02:25:06,645 [salt.state       :1780][INFO    ][7546] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 02:25:06.645211
2019-09-02 02:25:06,645 [salt.state       :1813][INFO    ][7546] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2019-09-02 02:25:06,647 [salt.loaded.int.module.cmdmod:395 ][INFO    ][7546] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2019-09-02 02:25:08,361 [salt.state       :300 ][INFO    ][7546] {'pid': 7565, 'retcode': 0, 'stderr': '', 'stdout': ''}
2019-09-02 02:25:08,362 [salt.state       :1951][INFO    ][7546] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 02:25:08.362394 duration_in_ms=1717.182
2019-09-02 02:25:08,367 [salt.state       :1780][INFO    ][7546] Running state [maas_machines_storage_cmp002_lvm] at time 02:25:08.367562
2019-09-02 02:25:08,368 [salt.state       :1813][INFO    ][7546] Executing state maasng.disk_layout_present for [maas_machines_storage_cmp002_lvm]
2019-09-02 02:25:09,546 [salt.loaded.ext.module.maasng:610 ][INFO    ][7546] gngcxr
2019-09-02 02:25:09,546 [salt.loaded.ext.module.maasng:626 ][INFO    ][7546] sda
2019-09-02 02:25:10,038 [salt.loaded.ext.module.maasng:361 ][INFO    ][7546] gngcxr
2019-09-02 02:25:10,135 [salt.loaded.ext.module.maasng:367 ][INFO    ][7546] [{u'block_size': 4096, u'available_size': 0, u'name': u'sda', u'tags': [u'ssd'], u'type': u'physical', u'id': 1, u'partitions': [{u'uuid': u'adb4a483-cfbb-4ae9-ac78-1720a3624d4f', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'gngcxr', u'device_id': 1, u'filesystem': {u'label': None, u'mount_point': None, u'uuid': u'51fce02e-cc81-412c-8843-9f79619ccfc2', u'fstype': u'lvm-pv', u'mount_options': None}, u'path': u'/dev/disk/by-dname/sda-part1', u'resource_uri': u'/MAAS/api/2.0/nodes/gngcxr/blockdevices/1/partition/1', u'type': u'partition', u'id': 1, u'size': 800101236736}], u'uuid': None, u'used_for': u'MBR partitioned with 1 partition', u'system_id': u'gngcxr', u'partition_table_type': u'MBR', u'filesystem': None, u'id_path': u'/dev/disk/by-id/wwn-0x600508b1001cb19198eb9a66f8a29401', u'path': u'/dev/disk/by-dname/sda', u'model': u'LOGICAL VOLUME', u'resource_uri': u'/MAAS/api/2.0/nodes/gngcxr/blockdevices/1/', u'used_size': 800106479616, u'serial': u'600508b1001cb19198eb9a66f8a29401', u'size': 800109715456}, {u'block_size': 4096, u'available_size': 0, u'name': u'vgroot-lvroot', u'tags': [], u'type': u'virtual', u'id': 3, u'partitions': [], u'uuid': u'76ce0db0-3d05-4d6d-aa7c-7bd35523425c', u'used_for': u'ext4 formatted filesystem mounted at /', u'system_id': u'gngcxr', u'partition_table_type': None, u'filesystem': {u'label': u'root', u'mount_point': u'/', u'uuid': u'43d57ab1-dea1-4c92-87d6-4b032985eff9', u'fstype': u'ext4', u'mount_options': None}, u'id_path': None, u'path': u'/dev/disk/by-dname/lvroot', u'model': None, u'resource_uri': u'/MAAS/api/2.0/nodes/gngcxr/blockdevices/3/', u'used_size': 800097042432, u'serial': None, u'size': 800097042432}]
2019-09-02 02:25:10,135 [salt.loaded.ext.module.maasng:632 ][INFO    ][7546] vgroot
2019-09-02 02:25:10,136 [salt.loaded.ext.module.maasng:635 ][INFO    ][7546] lvroot
2019-09-02 02:25:10,136 [salt.loaded.ext.module.maasng:639 ][INFO    ][7546] 107374182400
2019-09-02 02:25:10,727 [salt.loaded.ext.module.maasng:645 ][INFO    ][7546] {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'boot_interface': {u'name': u'eno1', u'links': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'qh3rnt', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/', u'id': 5002, u'secondary_rack': None, u'fabric': u'pxe_admin'}, u'allow_proxy': True, u'rdns_mode': 2, u'gateway_ip': u'192.168.11.3', u'active_discovery': False, u'cidr': u'192.168.11.0/24', u'id': 2, u'resource_uri': u'/MAAS/api/2.0/subnets/2/'}, u'mode': u'dhcp', u'id': 18}], u'tags': [u'sriov'], u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'qh3rnt', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/', u'id': 5002, u'secondary_rack': None, u'fabric': u'pxe_admin'}, u'enabled': True, u'children': [], u'discovered': [], u'mac_address': u'9c:b6:54:8a:10:18', u'parents': [], u'params': u'', u'effective_mtu': 1500, u'system_id': u'gngcxr', u'type': u'physical', u'id': 4, u'resource_uri': u'/MAAS/api/2.0/nodes/gngcxr/interfaces/4/'}, u'ip_addresses': [], u'cpu_count': 40, u'power_type': u'ipmi', u'hwe_kernel': u'', 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'iscsiblockdevice_set': [], u'status_action': u'', u'blockdevice_set': [{u'size': 800109715456, u'resource_uri': u'/MAAS/api/2.0/nodes/gngcxr/blockdevices/1/', u'name': u'sda', u'tags': [u'ssd'], u'type': u'physical', u'filesystem': None, u'uuid': None, u'used_for': u'MBR partitioned with 1 partition', u'system_id': u'gngcxr', u'partition_table_type': u'MBR', u'available_size': 0, u'id_path': u'/dev/disk/by-id/wwn-0x600508b1001cb19198eb9a66f8a29401', u'path': u'/dev/disk/by-dname/sda', u'model': u'LOGICAL VOLUME', u'block_size': 4096, u'used_size': 800106479616, u'id': 1, u'serial': u'600508b1001cb19198eb9a66f8a29401', u'partitions': [{u'uuid': u'1371473f-84d5-4a5b-97ed-3a042b35a197', u'resource_uri': u'/MAAS/api/2.0/nodes/gngcxr/blockdevices/1/partition/6', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'gngcxr', u'filesystem': {u'mount_options': None, u'label': None, u'mount_point': None, u'uuid': u'ea9c315b-556a-4b7d-8e23-932cfbdfe970', u'fstype': u'lvm-pv'}, u'path': u'/dev/disk/by-dname/sda-part1', u'size': 800101236736, u'type': u'partition', u'id': 6, u'device_id': 1}]}, {u'size': 107374182400, u'resource_uri': u'/MAAS/api/2.0/nodes/gngcxr/blockdevices/11/', u'name': u'vgroot-lvroot', u'tags': [], u'type': u'virtual', u'filesystem': {u'mount_options': None, u'label': u'root', u'mount_point': u'/', u'uuid': u'ec29ea36-cc23-449c-a0b8-f619213f22d1', u'fstype': u'ext4'}, u'uuid': u'b00f837c-ba6e-4f9f-97fd-c1354a4d42fc', u'used_for': u'ext4 formatted filesystem mounted at /', u'system_id': u'gngcxr', u'partition_table_type': None, u'available_size': 0, u'id_path': None, u'path': u'/dev/disk/by-dname/lvroot', u'model': None, u'block_size': 4096, u'used_size': 107374182400, u'id': 11, u'serial': None, u'partitions': []}], u'zone': {u'id': 1, u'description': u'', u'name': u'default', u'resource_uri': u'/MAAS/api/2.0/zones/default/'}, u'resource_uri': u'/MAAS/api/2.0/machines/gngcxr/', u'current_commissioning_result_id': 2, u'hostname': u'cmp002', u'storage': 800109.715456, u'testing_status': 2, u'system_id': u'gngcxr', 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'resource_uri': u'/MAAS/api/2.0/nodes/gngcxr/blockdevices/11/', u'name': u'vgroot-lvroot', u'tags': [], u'type': u'virtual', u'filesystem': {u'mount_options': None, u'label': u'root', u'mount_point': u'/', u'uuid': u'ec29ea36-cc23-449c-a0b8-f619213f22d1', u'fstype': u'ext4'}, u'uuid': u'b00f837c-ba6e-4f9f-97fd-c1354a4d42fc', u'used_for': u'ext4 formatted filesystem mounted at /', u'system_id': u'gngcxr', u'partition_table_type': None, u'available_size': 0, u'id_path': None, u'path': u'/dev/disk/by-dname/vgroot-lvroot', u'model': None, u'block_size': 4096, u'used_size': 107374182400, u'id': 11, u'serial': None, u'partitions': []}], u'architecture': u'amd64/generic', u'status': 4, u'bcaches': [], u'storage_test_status_name': u'Passed', u'power_state': u'off', u'owner_data': {}, u'other_test_status_name': u'Unknown', u'volume_groups': [{u'__incomplete__': True, u'system_id': u'gngcxr', u'id': 6}], u'special_filesystems': [], u'cpu_test_status_name': u'Unknown', u'boot_disk': {u'size': 800109715456, u'resource_uri': u'/MAAS/api/2.0/nodes/gngcxr/blockdevices/1/', u'name': u'sda', u'tags': [u'ssd'], u'type': u'physical', u'filesystem': None, u'uuid': None, u'used_for': u'MBR partitioned with 1 partition', u'system_id': u'gngcxr', u'partition_table_type': u'MBR', u'available_size': 0, u'id_path': u'/dev/disk/by-id/wwn-0x600508b1001cb19198eb9a66f8a29401', u'path': u'/dev/disk/by-dname/sda', u'model': u'LOGICAL VOLUME', u'block_size': 4096, u'used_size': 800106479616, u'id': 1, u'serial': u'600508b1001cb19198eb9a66f8a29401', u'partitions': [{u'uuid': u'1371473f-84d5-4a5b-97ed-3a042b35a197', u'resource_uri': u'/MAAS/api/2.0/nodes/gngcxr/blockdevices/1/partition/6', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'gngcxr', u'filesystem': {u'mount_options': None, u'label': None, u'mount_point': None, u'uuid': u'ea9c315b-556a-4b7d-8e23-932cfbdfe970', u'fstype': u'lvm-pv'}, u'path': u'/dev/disk/by-dname/sda-part1', u'size': 800101236736, 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'physicalblockdevice_set': [{u'size': 800109715456, u'resource_uri': u'/MAAS/api/2.0/nodes/gngcxr/blockdevices/1/', u'name': u'sda', u'tags': [u'ssd'], u'type': u'physical', u'filesystem': None, u'uuid': None, u'used_for': u'MBR partitioned with 1 partition', u'system_id': u'gngcxr', u'partition_table_type': u'MBR', u'available_size': 0, u'id_path': u'/dev/disk/by-id/wwn-0x600508b1001cb19198eb9a66f8a29401', u'path': u'/dev/disk/by-dname/sda', u'model': u'LOGICAL VOLUME', u'block_size': 4096, u'used_size': 800106479616, u'id': 1, u'serial': u'600508b1001cb19198eb9a66f8a29401', u'partitions': [{u'uuid': u'1371473f-84d5-4a5b-97ed-3a042b35a197', u'resource_uri': u'/MAAS/api/2.0/nodes/gngcxr/blockdevices/1/partition/6', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'gngcxr', u'filesystem': {u'mount_options': None, u'label': None, u'mount_point': None, u'uuid': u'ea9c315b-556a-4b7d-8e23-932cfbdfe970', u'fstype': u'lvm-pv'}, u'path': u'/dev/disk/by-dname/sda-part1', u'size': 800101236736, u'type': u'partition', u'id': 6, u'device_id': 1}]}], u'netboot': True, u'osystem': u'', u'fqdn': u'cmp002.maas', u'disable_ipv4': False, u'commissioning_status': 2, u'min_hwe_kernel': u'ga-16.04', u'commissioning_status_name': u'Passed', u'interface_set': [{u'name': u'eno1', u'links': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'qh3rnt', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/', u'id': 5002, u'secondary_rack': None, u'fabric': u'pxe_admin'}, u'allow_proxy': True, u'rdns_mode': 2, u'gateway_ip': u'192.168.11.3', u'active_discovery': False, u'cidr': u'192.168.11.0/24', u'id': 2, u'resource_uri': u'/MAAS/api/2.0/subnets/2/'}, u'mode': u'dhcp', u'id': 18}], u'tags': [u'sriov'], u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'qh3rnt', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/', u'id': 5002, u'secondary_rack': None, u'fabric': u'pxe_admin'}, u'enabled': True, u'children': [], u'discovered': [], u'mac_address': u'9c:b6:54:8a:10:18', u'parents': [], u'params': u'', u'effective_mtu': 1500, u'system_id': u'gngcxr', u'type': u'physical', u'id': 4, u'resource_uri': u'/MAAS/api/2.0/nodes/gngcxr/interfaces/4/'}, {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:07:51', u'parents': [], u'params': u'', u'effective_mtu': 1500, u'system_id': u'gngcxr', u'type': u'physical', u'id': 14, u'resource_uri': u'/MAAS/api/2.0/nodes/gngcxr/interfaces/14/'}, {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:07:50', u'parents': [], u'params': u'', u'effective_mtu': 1500, u'system_id': u'gngcxr', u'type': u'physical', u'id': 15, u'resource_uri': u'/MAAS/api/2.0/nodes/gngcxr/interfaces/15/'}, {u'name': u'ens2f1', 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'fabric_id': 0, u'dhcp_on': False, u'mtu': 1500, u'primary_rack': None, u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/', u'id': 5001, u'secondary_rack': None, u'fabric': u'fabric-0'}, u'enabled': True, u'children': [], u'discovered': None, u'mac_address': u'38:ea:a7:8f:12:49', u'parents': [], u'params': u'', u'effective_mtu': 1500, u'system_id': u'gngcxr', u'type': u'physical', u'id': 11, u'resource_uri': u'/MAAS/api/2.0/nodes/gngcxr/interfaces/11/'}, {u'name': u'ens2f0', u'links': [{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'fabric_id': 0, u'dhcp_on': False, u'mtu': 1500, u'primary_rack': None, u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/', u'id': 5001, u'secondary_rack': None, u'fabric': u'fabric-0'}, u'enabled': True, u'children': [], u'discovered': None, u'mac_address': u'38:ea:a7:8f:12:48', u'parents': [], u'params': u'', u'effective_mtu': 1500, u'system_id': u'gngcxr', u'type': u'physical', u'id': 12, u'resource_uri': u'/MAAS/api/2.0/nodes/gngcxr/interfaces/12/'}, {u'name': u'eno2', u'links': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'qh3rnt', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/', u'id': 5002, u'secondary_rack': None, u'fabric': u'pxe_admin'}, u'allow_proxy': True, u'rdns_mode': 2, u'gateway_ip': u'192.168.11.3', u'active_discovery': False, u'cidr': u'192.168.11.0/24', u'id': 2, u'resource_uri': u'/MAAS/api/2.0/subnets/2/'}, u'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'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'qh3rnt', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/', u'id': 5002, u'secondary_rack': None, u'fabric': u'pxe_admin'}, u'enabled': True, u'children': [], u'discovered': [], u'mac_address': u'9c:b6:54:8a:10:1c', u'parents': [], u'params': u'', u'effective_mtu': 1500, u'system_id': u'gngcxr', u'type': u'physical', u'id': 13, u'resource_uri': u'/MAAS/api/2.0/nodes/gngcxr/interfaces/13/'}], u'address_ttl': None, u'other_test_status': -1, u'distro_series': u'', u'node_type_name': u'Machine'}
2019-09-02 02:25:10,729 [salt.state       :300 ][INFO    ][7546] {'new': {'storage_layout': 'lvm'}}
2019-09-02 02:25:10,731 [salt.state       :1951][INFO    ][7546] Completed state [maas_machines_storage_cmp002_lvm] at time 02:25:10.729708 duration_in_ms=2362.144
2019-09-02 02:25:10,731 [salt.state       :1780][INFO    ][7546] Running state [maas_machines_storage_cmp001_lvm] at time 02:25:10.731737
2019-09-02 02:25:10,732 [salt.state       :1813][INFO    ][7546] Executing state maasng.disk_layout_present for [maas_machines_storage_cmp001_lvm]
2019-09-02 02:25:11,891 [salt.loaded.ext.module.maasng:610 ][INFO    ][7546] prqykn
2019-09-02 02:25:11,892 [salt.loaded.ext.module.maasng:626 ][INFO    ][7546] sda
2019-09-02 02:25:12,538 [salt.loaded.ext.module.maasng:361 ][INFO    ][7546] prqykn
2019-09-02 02:25:12,629 [salt.loaded.ext.module.maasng:367 ][INFO    ][7546] [{u'model': u'LOGICAL VOLUME', u'block_size': 4096, u'available_size': 0, u'name': u'sda', u'tags': [u'ssd'], u'type': u'physical', u'id': 2, u'uuid': None, u'used_for': u'MBR partitioned with 1 partition', u'system_id': u'prqykn', 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'partitions': [{u'size': 800101236736, u'uuid': u'6b10d0a0-b8c0-4e21-82e4-fd17bc9e8ccc', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'prqykn', u'filesystem': {u'mount_options': None, u'label': None, u'mount_point': None, u'uuid': u'e93f1f64-d5b9-4aaf-83b6-6775130e7c4a', u'fstype': u'lvm-pv'}, u'path': u'/dev/disk/by-dname/sda-part1', u'device_id': 2, u'type': u'partition', u'id': 2, u'resource_uri': u'/MAAS/api/2.0/nodes/prqykn/blockdevices/2/partition/2'}], u'used_size': 800106479616, u'resource_uri': u'/MAAS/api/2.0/nodes/prqykn/blockdevices/2/', u'size': 800109715456}, {u'model': None, u'block_size': 4096, u'available_size': 0, u'name': u'vgroot-lvroot', u'tags': [], u'type': u'virtual', u'id': 4, u'uuid': u'd12ad7e9-1f40-46cc-ab28-ef530047be83', u'used_for': u'ext4 formatted filesystem mounted at /', u'system_id': u'prqykn', u'partition_table_type': None, u'filesystem': {u'mount_options': None, u'label': u'root', u'mount_point': u'/', u'uuid': u'4af416bb-9b20-4131-a408-20c70c093811', u'fstype': u'ext4'}, u'id_path': None, u'path': u'/dev/disk/by-dname/lvroot', u'serial': None, u'partitions': [], u'used_size': 800097042432, u'resource_uri': u'/MAAS/api/2.0/nodes/prqykn/blockdevices/4/', u'size': 800097042432}]
2019-09-02 02:25:12,629 [salt.loaded.ext.module.maasng:632 ][INFO    ][7546] vgroot
2019-09-02 02:25:12,630 [salt.loaded.ext.module.maasng:635 ][INFO    ][7546] lvroot
2019-09-02 02:25:12,630 [salt.loaded.ext.module.maasng:639 ][INFO    ][7546] 107374182400
2019-09-02 02:25:13,209 [salt.loaded.ext.module.maasng:645 ][INFO    ][7546] {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'cpu_count': 40, u'owner_data': {}, u'hwe_kernel': u'', u'memory_test_status_name': u'Unknown', u'min_hwe_kernel': u'ga-16.04', u'status_action': u'', u'tag_names': [], u'swap_size': None, u'commissioning_status_name': u'Passed', u'owner': None, u'pod': None, u'cache_sets': [], u'iscsiblockdevice_set': [], u'boot_disk': {u'size': 800109715456, u'block_size': 4096, u'available_size': 0, u'name': u'sda', u'tags': [u'ssd'], u'type': u'physical', u'id': 2, u'uuid': None, u'used_for': u'MBR partitioned with 1 partition', u'system_id': u'prqykn', 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'resource_uri': u'/MAAS/api/2.0/nodes/prqykn/blockdevices/2/', u'used_size': 800106479616, u'serial': u'600508b1001cd7e61f5cd3479576479e', u'partitions': [{u'size': 800101236736, u'uuid': u'66ec65b4-b763-4269-b159-5fdadc67e335', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'prqykn', u'filesystem': {u'mount_options': None, u'label': None, u'mount_point': None, u'uuid': u'c952f526-71d3-4207-8d5f-507a4c3dad05', u'fstype': u'lvm-pv'}, u'path': u'/dev/disk/by-dname/sda-part1', u'device_id': 2, u'type': u'partition', u'id': 7, u'resource_uri': u'/MAAS/api/2.0/nodes/prqykn/blockdevices/2/partition/7'}]}, 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'hostname': u'cmp001', u'storage': 800109.715456, u'testing_status': 2, u'system_id': u'prqykn', 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'model': u'LOGICAL VOLUME', u'block_size': 4096, u'available_size': 0, u'name': u'sda', u'tags': [u'ssd'], u'type': u'physical', u'id': 2, u'uuid': None, u'used_for': u'MBR partitioned with 1 partition', u'system_id': u'prqykn', 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'partitions': [{u'size': 800101236736, u'uuid': u'66ec65b4-b763-4269-b159-5fdadc67e335', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'prqykn', u'filesystem': {u'mount_options': None, u'label': None, u'mount_point': None, u'uuid': u'c952f526-71d3-4207-8d5f-507a4c3dad05', u'fstype': u'lvm-pv'}, u'path': u'/dev/disk/by-dname/sda-part1', u'device_id': 2, u'type': u'partition', u'id': 7, u'resource_uri': u'/MAAS/api/2.0/nodes/prqykn/blockdevices/2/partition/7'}], u'used_size': 800106479616, u'resource_uri': u'/MAAS/api/2.0/nodes/prqykn/blockdevices/2/', u'size': 800109715456}, {u'model': None, u'block_size': 4096, u'available_size': 0, u'name': u'vgroot-lvroot', u'tags': [], u'type': u'virtual', u'id': 12, u'uuid': u'c3391f16-5c5f-4cea-ba44-492d5eaf7605', u'used_for': u'ext4 formatted filesystem mounted at /', u'system_id': u'prqykn', u'partition_table_type': None, u'filesystem': {u'mount_options': None, u'label': u'root', u'mount_point': u'/', u'uuid': u'4990546d-9d43-406d-9829-214eba3514d3', u'fstype': u'ext4'}, u'id_path': None, u'path': u'/dev/disk/by-dname/lvroot', u'serial': None, u'partitions': [], u'used_size': 107374182400, u'resource_uri': u'/MAAS/api/2.0/nodes/prqykn/blockdevices/12/', u'size': 107374182400}], u'status': 4, u'storage_test_status': 2, u'storage_test_status_name': u'Passed', u'raids': [], u'power_type': u'ipmi', u'physicalblockdevice_set': [{u'size': 800109715456, u'block_size': 4096, u'available_size': 0, u'name': u'sda', u'tags': [u'ssd'], u'type': u'physical', u'id': 2, u'uuid': None, u'used_for': u'MBR partitioned with 1 partition', u'system_id': u'prqykn', 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'resource_uri': u'/MAAS/api/2.0/nodes/prqykn/blockdevices/2/', u'used_size': 800106479616, u'serial': u'600508b1001cd7e61f5cd3479576479e', u'partitions': [{u'size': 800101236736, u'uuid': u'66ec65b4-b763-4269-b159-5fdadc67e335', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'prqykn', u'filesystem': {u'mount_options': None, u'label': None, u'mount_point': None, u'uuid': u'c952f526-71d3-4207-8d5f-507a4c3dad05', u'fstype': u'lvm-pv'}, u'path': u'/dev/disk/by-dname/sda-part1', u'device_id': 2, u'type': u'partition', u'id': 7, u'resource_uri': u'/MAAS/api/2.0/nodes/prqykn/blockdevices/2/partition/7'}]}], u'other_test_status_name': u'Unknown', u'volume_groups': [{u'__incomplete__': True, u'system_id': u'prqykn', u'id': 7}], u'special_filesystems': [], u'cpu_test_status_name': u'Unknown', u'node_type_name': u'Machine', u'current_testing_result_id': 5, u'cpu_test_status': -1, u'bcaches': [], u'other_test_status': -1, u'status_name': u'Ready', u'netboot': True, u'osystem': u'', u'fqdn': u'cmp001.maas', u'node_type': 0, u'virtualblockdevice_set': [{u'size': 107374182400, u'block_size': 4096, u'available_size': 0, u'name': u'vgroot-lvroot', u'tags': [], u'type': u'virtual', u'id': 12, u'uuid': u'c3391f16-5c5f-4cea-ba44-492d5eaf7605', u'used_for': u'ext4 formatted filesystem mounted at /', u'system_id': u'prqykn', u'partition_table_type': None, u'filesystem': {u'mount_options': None, u'label': u'root', u'mount_point': u'/', u'uuid': u'4990546d-9d43-406d-9829-214eba3514d3', u'fstype': u'ext4'}, u'id_path': None, u'path': u'/dev/disk/by-dname/vgroot-lvroot', u'model': None, u'resource_uri': u'/MAAS/api/2.0/nodes/prqykn/blockdevices/12/', u'used_size': 107374182400, u'serial': None, u'partitions': []}], u'commissioning_status': 2, u'architecture': u'amd64/generic', 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': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'qh3rnt', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/', u'id': 5002, 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': 2, u'resource_uri': u'/MAAS/api/2.0/subnets/2/'}, u'id': 24, u'mode': u'dhcp'}], u'tags': [u'sriov'], u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'qh3rnt', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/', u'id': 5002, u'secondary_rack': None, u'name': u'untagged'}, u'enabled': True, u'effective_mtu': 1500, u'id': 5, u'discovered': [], u'system_id': u'prqykn', 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/prqykn/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': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'qh3rnt', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/', u'id': 5002, 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': 2, u'resource_uri': u'/MAAS/api/2.0/subnets/2/'}, u'id': 24, u'mode': u'dhcp'}], u'tags': [u'sriov'], u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'qh3rnt', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/', u'id': 5002, u'secondary_rack': None, u'name': u'untagged'}, u'enabled': True, u'effective_mtu': 1500, u'id': 5, u'discovered': [], u'system_id': u'prqykn', 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/prqykn/interfaces/5/'}, {u'name': u'ens1f1', u'links': [], u'tags': [u'sriov'], u'vlan': None, u'enabled': True, u'effective_mtu': 1500, u'id': 16, u'discovered': None, u'system_id': u'prqykn', 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/prqykn/interfaces/16/'}, {u'name': u'ens1f0', 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'prqykn', 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/prqykn/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': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'qh3rnt', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/', u'id': 5002, 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': 2, u'resource_uri': u'/MAAS/api/2.0/subnets/2/'}, u'id': 25, u'mode': u'link_up'}], u'tags': [u'sriov'], u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': True, u'mtu': 1500, u'primary_rack': u'qh3rnt', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/', u'id': 5002, u'secondary_rack': None, u'name': u'untagged'}, u'enabled': True, u'effective_mtu': 1500, u'id': 18, u'discovered': [], u'system_id': u'prqykn', 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/prqykn/interfaces/18/'}, {u'name': u'ens2f0', u'links': [{u'id': 26, u'mode': u'link_up'}], u'tags': [u'sriov'], u'vlan': {u'fabric': u'fabric-0', u'vid': 0, u'space': u'undefined', u'fabric_id': 0, u'dhcp_on': False, u'mtu': 1500, u'primary_rack': None, u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/', u'id': 5001, u'secondary_rack': None, u'name': u'untagged'}, u'enabled': True, u'effective_mtu': 1500, u'id': 19, u'discovered': None, u'system_id': u'prqykn', 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/prqykn/interfaces/19/'}, {u'name': u'ens2f1', u'links': [{u'id': 27, u'mode': u'link_up'}], u'tags': [u'sriov'], u'vlan': {u'fabric': u'fabric-0', u'vid': 0, u'space': u'undefined', u'fabric_id': 0, u'dhcp_on': False, u'mtu': 1500, u'primary_rack': None, u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/', u'id': 5001, u'secondary_rack': None, u'name': u'untagged'}, u'enabled': True, u'effective_mtu': 1500, u'id': 20, u'discovered': None, u'system_id': u'prqykn', 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/prqykn/interfaces/20/'}], u'address_ttl': None, u'memory_test_status': -1, u'distro_series': u'', u'resource_uri': u'/MAAS/api/2.0/machines/prqykn/'}
2019-09-02 02:25:13,212 [salt.state       :300 ][INFO    ][7546] {'new': {'storage_layout': 'lvm'}}
2019-09-02 02:25:13,212 [salt.state       :1951][INFO    ][7546] Completed state [maas_machines_storage_cmp001_lvm] at time 02:25:13.212822 duration_in_ms=2481.083
2019-09-02 02:25:13,219 [salt.minion      :1711][INFO    ][7546] Returning information for job: 20190902022500373625
2019-09-02 02:25:13,784 [salt.minion      :1308][INFO    ][2968] User sudo_ubuntu Executing command state.apply with jid 20190902022513771177
2019-09-02 02:25:13,810 [salt.minion      :1432][INFO    ][7584] Starting a new job with PID 7584
2019-09-02 02:25:14,849 [salt.state       :915 ][INFO    ][7584] Loading fresh modules for state activity
2019-09-02 02:25:14,912 [salt.fileclient  :1219][INFO    ][7584] Fetching file from saltenv 'base', ** done ** 'maas/machines/deploy.sls'
2019-09-02 02:25:14,976 [salt.state       :1780][INFO    ][7584] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 02:25:14.976675
2019-09-02 02:25:14,977 [salt.state       :1813][INFO    ][7584] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2019-09-02 02:25:14,981 [salt.loaded.int.module.cmdmod:395 ][INFO    ][7584] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2019-09-02 02:25:16,809 [salt.state       :300 ][INFO    ][7584] {'pid': 7604, 'retcode': 0, 'stderr': '', 'stdout': ''}
2019-09-02 02:25:16,810 [salt.state       :1951][INFO    ][7584] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 02:25:16.810343 duration_in_ms=1833.668
2019-09-02 02:25:16,812 [salt.state       :1780][INFO    ][7584] Running state [maas.deploy_machines] at time 02:25:16.811965
2019-09-02 02:25:16,812 [salt.state       :1813][INFO    ][7584] Executing state module.run for [maas.deploy_machines]
2019-09-02 02:25:16,813 [salt.utils.decorators:613 ][WARNING ][7584] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-09-02 02:25:17,347 [salt.loaded.ext.module.maas:684 ][INFO    ][7584] deploymachines hwe_kernel=ga-16.04 system_id=gngcxr distro_series=xenial
2019-09-02 02:25:19,818 [salt.loaded.ext.module.maas:684 ][INFO    ][7584] deploymachines hwe_kernel=ga-16.04 system_id=prqykn distro_series=xenial
2019-09-02 02:25:22,281 [salt.loaded.ext.module.maas:684 ][INFO    ][7584] deploymachines hwe_kernel=ga-16.04 system_id=em4ms3 distro_series=xenial
2019-09-02 02:25:24,847 [salt.loaded.ext.module.maas:684 ][INFO    ][7584] deploymachines hwe_kernel=ga-16.04 system_id=rtxmke distro_series=xenial
2019-09-02 02:25:27,288 [salt.loaded.ext.module.maas:684 ][INFO    ][7584] deploymachines hwe_kernel=ga-16.04 system_id=fdq6s3 distro_series=xenial
2019-09-02 02:25:28,819 [salt.minion      :1308][INFO    ][2968] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902022528807158
2019-09-02 02:25:28,842 [salt.minion      :1432][INFO    ][7879] Starting a new job with PID 7879
2019-09-02 02:25:28,864 [salt.minion      :1711][INFO    ][7879] Returning information for job: 20190902022528807158
2019-09-02 02:25:29,843 [salt.state       :300 ][INFO    ][7584] {'ret': {'updated': [], 'errors': {}, 'success': ['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']}}
2019-09-02 02:25:29,844 [salt.state       :1951][INFO    ][7584] Completed state [maas.deploy_machines] at time 02:25:29.844000 duration_in_ms=13032.034
2019-09-02 02:25:29,847 [salt.minion      :1711][INFO    ][7584] Returning information for job: 20190902022513771177
2019-09-02 02:25:30,416 [salt.minion      :1308][INFO    ][2968] User sudo_ubuntu Executing command state.apply with jid 20190902022530405585
2019-09-02 02:25:30,444 [salt.minion      :1432][INFO    ][7899] Starting a new job with PID 7899
2019-09-02 02:25:36,517 [salt.state       :915 ][INFO    ][7899] Loading fresh modules for state activity
2019-09-02 02:25:36,584 [salt.fileclient  :1219][INFO    ][7899] Fetching file from saltenv 'base', ** done ** 'maas/machines/wait_for_deployed.sls'
2019-09-02 02:25:36,633 [salt.state       :1780][INFO    ][7899] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 02:25:36.633096
2019-09-02 02:25:36,633 [salt.state       :1813][INFO    ][7899] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2019-09-02 02:25:36,635 [salt.loaded.int.module.cmdmod:395 ][INFO    ][7899] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2019-09-02 02:25:38,437 [salt.state       :300 ][INFO    ][7899] {'pid': 7917, 'retcode': 0, 'stderr': '', 'stdout': ''}
2019-09-02 02:25:38,439 [salt.state       :1951][INFO    ][7899] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 02:25:38.439271 duration_in_ms=1806.174
2019-09-02 02:25:38,443 [salt.state       :1780][INFO    ][7899] Running state [maas.wait_for_machine_status] at time 02:25:38.443019
2019-09-02 02:25:38,443 [salt.state       :1813][INFO    ][7899] Executing state module.run for [maas.wait_for_machine_status]
2019-09-02 02:25:38,444 [salt.utils.decorators:613 ][WARNING ][7899] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-09-02 02:25:40,917 [salt.loaded.ext.module.maas:1023][INFO    ][7899] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2247.54067111s left)
2019-09-02 02:25:45,486 [salt.minion      :1308][INFO    ][2968] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902022545471424
2019-09-02 02:25:45,510 [salt.minion      :1432][INFO    ][7931] Starting a new job with PID 7931
2019-09-02 02:25:45,532 [salt.minion      :1711][INFO    ][7931] Returning information for job: 20190902022545471424
2019-09-02 02:26:13,467 [salt.loaded.ext.module.maas:1023][INFO    ][7899] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2214.99076414s left)
2019-09-02 02:26:15,562 [salt.minion      :1308][INFO    ][2968] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902022615547013
2019-09-02 02:26:15,591 [salt.minion      :1432][INFO    ][7982] Starting a new job with PID 7982
2019-09-02 02:26:15,612 [salt.minion      :1711][INFO    ][7982] Returning information for job: 20190902022615547013
2019-09-02 02:26:45,644 [salt.minion      :1308][INFO    ][2968] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902022645632652
2019-09-02 02:26:45,667 [salt.minion      :1432][INFO    ][8004] Starting a new job with PID 8004
2019-09-02 02:26:45,690 [salt.minion      :1711][INFO    ][8004] Returning information for job: 20190902022645632652
2019-09-02 02:26:46,000 [salt.loaded.ext.module.maas:1023][INFO    ][7899] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2182.45697999s left)
2019-09-02 02:27:15,736 [salt.minion      :1308][INFO    ][2968] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902022715720452
2019-09-02 02:27:15,760 [salt.minion      :1432][INFO    ][8187] Starting a new job with PID 8187
2019-09-02 02:27:15,789 [salt.minion      :1711][INFO    ][8187] Returning information for job: 20190902022715720452
2019-09-02 02:27:18,683 [salt.loaded.ext.module.maas:1023][INFO    ][7899] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2149.77462697s left)
2019-09-02 02:27:45,829 [salt.minion      :1308][INFO    ][2968] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902022745819796
2019-09-02 02:27:45,857 [salt.minion      :1432][INFO    ][8223] Starting a new job with PID 8223
2019-09-02 02:27:45,879 [salt.minion      :1711][INFO    ][8223] Returning information for job: 20190902022745819796
2019-09-02 02:27:51,358 [salt.loaded.ext.module.maas:1023][INFO    ][7899] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2117.09931397s left)
2019-09-02 02:28:15,909 [salt.minion      :1308][INFO    ][2968] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902022815896306
2019-09-02 02:28:15,934 [salt.minion      :1432][INFO    ][8323] Starting a new job with PID 8323
2019-09-02 02:28:15,968 [salt.minion      :1711][INFO    ][8323] Returning information for job: 20190902022815896306
2019-09-02 02:28:24,054 [salt.loaded.ext.module.maas:1023][INFO    ][7899] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2084.40323091s left)
2019-09-02 02:28:46,003 [salt.minion      :1308][INFO    ][2968] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902022845984737
2019-09-02 02:28:46,031 [salt.minion      :1432][INFO    ][8411] Starting a new job with PID 8411
2019-09-02 02:28:46,057 [salt.minion      :1711][INFO    ][8411] Returning information for job: 20190902022845984737
2019-09-02 02:28:56,866 [salt.loaded.ext.module.maas:1023][INFO    ][7899] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2051.59130502s left)
2019-09-02 02:29:16,112 [salt.minion      :1308][INFO    ][2968] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902022916093679
2019-09-02 02:29:16,139 [salt.minion      :1432][INFO    ][8591] Starting a new job with PID 8591
2019-09-02 02:29:16,172 [salt.minion      :1711][INFO    ][8591] Returning information for job: 20190902022916093679
2019-09-02 02:29:29,728 [salt.loaded.ext.module.maas:1023][INFO    ][7899] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2018.72941804s left)
2019-09-02 02:29:46,216 [salt.minion      :1308][INFO    ][2968] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902022946203531
2019-09-02 02:29:46,236 [salt.minion      :1432][INFO    ][8819] Starting a new job with PID 8819
2019-09-02 02:29:46,257 [salt.minion      :1711][INFO    ][8819] Returning information for job: 20190902022946203531
2019-09-02 02:30:02,606 [salt.loaded.ext.module.maas:1023][INFO    ][7899] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1985.85210991s left)
2019-09-02 02:30:16,316 [salt.minion      :1308][INFO    ][2968] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902023016296975
2019-09-02 02:30:16,343 [salt.minion      :1432][INFO    ][9090] Starting a new job with PID 9090
2019-09-02 02:30:16,389 [salt.minion      :1711][INFO    ][9090] Returning information for job: 20190902023016296975
2019-09-02 02:30:35,656 [salt.loaded.ext.module.maas:1023][INFO    ][7899] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1952.80172014s left)
2019-09-02 02:30:46,483 [salt.minion      :1308][INFO    ][2968] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902023046468747
2019-09-02 02:30:46,513 [salt.minion      :1432][INFO    ][9222] Starting a new job with PID 9222
2019-09-02 02:30:46,536 [salt.minion      :1711][INFO    ][9222] Returning information for job: 20190902023046468747
2019-09-02 02:31:08,689 [salt.loaded.ext.module.maas:1023][INFO    ][7899] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1919.76875806s left)
2019-09-02 02:31:16,640 [salt.minion      :1308][INFO    ][2968] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902023116627390
2019-09-02 02:31:16,669 [salt.minion      :1432][INFO    ][9484] Starting a new job with PID 9484
2019-09-02 02:31:16,739 [salt.minion      :1711][INFO    ][9484] Returning information for job: 20190902023116627390
2019-09-02 02:31:41,807 [salt.loaded.ext.module.maas:1023][INFO    ][7899] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1886.65011001s left)
2019-09-02 02:31:46,865 [salt.minion      :1308][INFO    ][2968] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902023146849111
2019-09-02 02:31:46,900 [salt.minion      :1432][INFO    ][9778] Starting a new job with PID 9778
2019-09-02 02:31:46,924 [salt.minion      :1711][INFO    ][9778] Returning information for job: 20190902023146849111
2019-09-02 02:32:14,877 [salt.loaded.ext.module.maas:1023][INFO    ][7899] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1853.58037496s left)
2019-09-02 02:32:17,051 [salt.minion      :1308][INFO    ][2968] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902023217036626
2019-09-02 02:32:17,076 [salt.minion      :1432][INFO    ][10073] Starting a new job with PID 10073
2019-09-02 02:32:17,113 [salt.minion      :1711][INFO    ][10073] Returning information for job: 20190902023217036626
2019-09-02 02:32:47,220 [salt.minion      :1308][INFO    ][2968] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902023247211727
2019-09-02 02:32:47,250 [salt.minion      :1432][INFO    ][10252] Starting a new job with PID 10252
2019-09-02 02:32:47,274 [salt.minion      :1711][INFO    ][10252] Returning information for job: 20190902023247211727
2019-09-02 02:32:47,811 [salt.loaded.ext.module.maas:1023][INFO    ][7899] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1820.64621711s left)
2019-09-02 02:33:17,409 [salt.minion      :1308][INFO    ][2968] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902023317395665
2019-09-02 02:33:17,436 [salt.minion      :1432][INFO    ][10512] Starting a new job with PID 10512
2019-09-02 02:33:17,457 [salt.minion      :1711][INFO    ][10512] Returning information for job: 20190902023317395665
2019-09-02 02:33:21,008 [salt.loaded.ext.module.maas:1023][INFO    ][7899] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1787.44916105s left)
2019-09-02 02:33:47,543 [salt.minion      :1308][INFO    ][2968] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902023347527442
2019-09-02 02:33:47,568 [salt.minion      :1432][INFO    ][10550] Starting a new job with PID 10550
2019-09-02 02:33:47,591 [salt.minion      :1711][INFO    ][10550] Returning information for job: 20190902023347527442
2019-09-02 02:33:53,892 [salt.loaded.ext.module.maas:1023][INFO    ][7899] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1754.56573606s left)
2019-09-02 02:34:17,728 [salt.minion      :1308][INFO    ][2968] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902023417717019
2019-09-02 02:34:17,752 [salt.minion      :1432][INFO    ][10743] Starting a new job with PID 10743
2019-09-02 02:34:17,777 [salt.minion      :1711][INFO    ][10743] Returning information for job: 20190902023417717019
2019-09-02 02:34:27,301 [salt.loaded.ext.module.maas:1023][INFO    ][7899] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1721.15641308s left)
2019-09-02 02:34:47,783 [salt.minion      :1308][INFO    ][2968] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902023447766515
2019-09-02 02:34:47,809 [salt.minion      :1432][INFO    ][10791] Starting a new job with PID 10791
2019-09-02 02:34:47,836 [salt.minion      :1711][INFO    ][10791] Returning information for job: 20190902023447766515
2019-09-02 02:35:00,237 [salt.loaded.ext.module.maas:1023][INFO    ][7899] Waiting status:Deployed for machines:['kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1688.22102094s left)
2019-09-02 02:35:17,896 [salt.minion      :1308][INFO    ][2968] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902023517886369
2019-09-02 02:35:17,924 [salt.minion      :1432][INFO    ][11054] Starting a new job with PID 11054
2019-09-02 02:35:17,947 [salt.minion      :1711][INFO    ][11054] Returning information for job: 20190902023517886369
2019-09-02 02:35:33,159 [salt.loaded.ext.module.maas:1023][INFO    ][7899] Waiting status:Deployed for machines:['kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1655.29809499s left)
2019-09-02 02:35:48,071 [salt.minion      :1308][INFO    ][2968] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902023548054443
2019-09-02 02:35:48,102 [salt.minion      :1432][INFO    ][11074] Starting a new job with PID 11074
2019-09-02 02:35:48,125 [salt.minion      :1711][INFO    ][11074] Returning information for job: 20190902023548054443
2019-09-02 02:36:06,051 [salt.loaded.ext.module.maas:1023][INFO    ][7899] Waiting status:Deployed for machines:['kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1622.40603614s left)
2019-09-02 02:36:18,260 [salt.minion      :1308][INFO    ][2968] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902023618244726
2019-09-02 02:36:18,289 [salt.minion      :1432][INFO    ][11129] Starting a new job with PID 11129
2019-09-02 02:36:18,316 [salt.minion      :1711][INFO    ][11129] Returning information for job: 20190902023618244726
2019-09-02 02:36:39,020 [salt.loaded.ext.module.maas:1023][INFO    ][7899] Waiting status:Deployed for machines:['kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1589.43725491s left)
2019-09-02 02:36:48,427 [salt.minion      :1308][INFO    ][2968] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902023648412965
2019-09-02 02:36:48,455 [salt.minion      :1432][INFO    ][11148] Starting a new job with PID 11148
2019-09-02 02:36:48,478 [salt.minion      :1711][INFO    ][11148] Returning information for job: 20190902023648412965
2019-09-02 02:37:11,955 [salt.loaded.ext.module.maas:1023][INFO    ][7899] Waiting status:Deployed for machines:['kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1556.50196695s left)
2019-09-02 02:37:18,624 [salt.minion      :1308][INFO    ][2968] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902023718608395
2019-09-02 02:37:18,648 [salt.minion      :1432][INFO    ][11219] Starting a new job with PID 11219
2019-09-02 02:37:18,675 [salt.minion      :1711][INFO    ][11219] Returning information for job: 20190902023718608395
2019-09-02 02:37:44,946 [salt.loaded.ext.module.maas:1023][INFO    ][7899] Waiting status:Deployed for machines:['kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1523.5109551s left)
2019-09-02 02:37:48,797 [salt.minion      :1308][INFO    ][2968] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902023748783803
2019-09-02 02:37:48,814 [salt.minion      :1432][INFO    ][11335] Starting a new job with PID 11335
2019-09-02 02:37:48,835 [salt.minion      :1711][INFO    ][11335] Returning information for job: 20190902023748783803
2019-09-02 02:38:18,991 [salt.minion      :1308][INFO    ][2968] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902023818979563
2019-09-02 02:38:19,015 [salt.minion      :1432][INFO    ][11600] Starting a new job with PID 11600
2019-09-02 02:38:19,039 [salt.minion      :1711][INFO    ][11600] Returning information for job: 20190902023818979563
2019-09-02 02:38:19,075 [salt.state       :300 ][INFO    ][7899] {'ret': True}
2019-09-02 02:38:19,075 [salt.state       :1951][INFO    ][7899] Completed state [maas.wait_for_machine_status] at time 02:38:19.075453 duration_in_ms=760632.431
2019-09-02 02:38:19,084 [salt.minion      :1711][INFO    ][7899] Returning information for job: 20190902022530405585
2019-09-02 03:07:08,415 [salt.utils.schedule:1377][INFO    ][2968] Running scheduled job: __mine_interval
2019-09-02 04:05:34,686 [salt.minion      :1308][INFO    ][2968] User sudo_ubuntu Executing command cp.push_dir with jid 20190902040534674744
2019-09-02 04:05:34,710 [salt.minion      :1432][INFO    ][17554] Starting a new job with PID 17554
