2019-08-20 05:07:38,107 [salt.minion      :870 ][ERROR   ][359] Error while bringing up minion for multi-master. Is master at 10.20.0.2 responding?
2019-08-20 05:08:28,150 [salt.minion      :870 ][ERROR   ][359] Error while bringing up minion for multi-master. Is master at 10.20.0.2 responding?
2019-08-20 05:09:18,192 [salt.minion      :870 ][ERROR   ][359] Error while bringing up minion for multi-master. Is master at 10.20.0.2 responding?
2019-08-20 05:10:08,239 [salt.minion      :870 ][ERROR   ][359] Error while bringing up minion for multi-master. Is master at 10.20.0.2 responding?
2019-08-20 05:10:58,286 [salt.minion      :870 ][ERROR   ][359] Error while bringing up minion for multi-master. Is master at 10.20.0.2 responding?
2019-08-20 05:13:07,373 [salt.utils.decorators:613 ][WARNING ][2704] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-08-20 05:13:07,987 [salt.utils.decorators:613 ][WARNING ][2704] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-08-20 05:13:10,192 [salt.loaded.int.states.file:2298][WARNING ][2838] 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-08-20 05:13:15,402 [salt.state       :2022][WARNING ][2953] State is set to retry, but a valid dict for retry configuration was not found.  Using retry defaults
2019-08-20 05:13:18,048 [salt.utils.decorators:613 ][WARNING ][2953] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-08-20 05:28:26,565 [salt.utils.decorators:613 ][WARNING ][2953] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-08-20 05:58:39,823 [salt.utils.decorators:613 ][WARNING ][2953] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-08-20 06:19:22,025 [salt.state       :302 ][ERROR   ][2953] Module function maasng.sync_and_wait_bs_to_all_racks threw an exception. Exception: HTTP Error 401: OK
2019-08-20 06:19:23,415 [salt.loaded.ext.module.maasng:1008][WARNING ][2953] Detected cidr:192.168.11.0/24 in fabric:fabric-2
2019-08-20 06:19:23,415 [salt.loaded.ext.module.maasng:1011][WARNING ][2953] Guessing, that fabric with current name:fabric-2
 should be renamed to:pxe_admin
2019-08-20 06:19:26,104 [salt.loaded.ext.module.maasng:1235][WARNING ][2953] Ignoring parameter vlan:0
2019-08-20 06:19:28,298 [salt.utils.decorators:613 ][WARNING ][2953] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-08-20 06:19:31,874 [salt.loaded.int.module.cmdmod:395 ][INFO    ][29622] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2019-08-20 06:19:31,901 [salt.loaded.int.module.cmdmod:395 ][INFO    ][29622] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2019-08-20 06:19:31,922 [salt.utils.parsers:1051][WARNING ][359] Minion received a SIGTERM. Exiting.
2019-08-20 06:19:32,990 [salt.cli.daemons :293 ][INFO    ][29668] Setting up the Salt Minion "mas01.mcp-ovs-dpdk-ha.local"
2019-08-20 06:19:33,088 [salt.cli.daemons :82  ][INFO    ][29668] Starting up the Salt Minion
2019-08-20 06:19:33,089 [salt.utils.event :1017][INFO    ][29668] Starting pull socket on /var/run/salt/minion/minion_event_967fbee23e_pull.ipc
2019-08-20 06:19:34,062 [salt.minion      :976 ][INFO    ][29668] Creating minion process manager
2019-08-20 06:19:35,546 [salt.loader.10.20.0.2.int.module.cmdmod:395 ][INFO    ][29668] Executing command ['date', '+%z'] in directory '/root'
2019-08-20 06:19:35,566 [salt.utils.schedule:568 ][INFO    ][29668] Updating job settings for scheduled job: __mine_interval
2019-08-20 06:19:35,568 [salt.minion      :1108][INFO    ][29668] Added mine.update to scheduler
2019-08-20 06:19:35,572 [salt.minion      :1975][INFO    ][29668] Minion is starting as user 'root'
2019-08-20 06:19:35,584 [salt.minion      :2336][INFO    ][29668] Minion is ready to receive requests!
2019-08-20 06:19:40,285 [salt.minion      :1308][INFO    ][29668] User sudo_ubuntu Executing command state.apply with jid 20190820061940273016
2019-08-20 06:19:40,308 [salt.minion      :1432][INFO    ][29748] Starting a new job with PID 29748
2019-08-20 06:19:44,084 [salt.state       :915 ][INFO    ][29748] Loading fresh modules for state activity
2019-08-20 06:19:44,685 [salt.state       :1780][INFO    ][29748] Running state [maas-region-controller] at time 06:19:44.684983
2019-08-20 06:19:44,685 [salt.state       :1813][INFO    ][29748] Executing state pkg.installed for [maas-region-controller]
2019-08-20 06:19:44,685 [salt.loaded.int.module.cmdmod:395 ][INFO    ][29748] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2019-08-20 06:19:44,778 [salt.state       :300 ][INFO    ][29748] All specified packages are already installed
2019-08-20 06:19:44,779 [salt.state       :1951][INFO    ][29748] Completed state [maas-region-controller] at time 06:19:44.779073 duration_in_ms=94.089
2019-08-20 06:19:44,779 [salt.state       :1780][INFO    ][29748] Running state [python-oauth] at time 06:19:44.779402
2019-08-20 06:19:44,779 [salt.state       :1813][INFO    ][29748] Executing state pkg.installed for [python-oauth]
2019-08-20 06:19:44,786 [salt.state       :300 ][INFO    ][29748] All specified packages are already installed
2019-08-20 06:19:44,787 [salt.state       :1951][INFO    ][29748] Completed state [python-oauth] at time 06:19:44.787052 duration_in_ms=7.65
2019-08-20 06:19:44,790 [salt.state       :1780][INFO    ][29748] Running state [/etc/maas/regiond.conf] at time 06:19:44.790255
2019-08-20 06:19:44,790 [salt.state       :1813][INFO    ][29748] Executing state file.replace for [/etc/maas/regiond.conf]
2019-08-20 06:19:44,844 [salt.state       :300 ][INFO    ][29748] No changes needed to be made
2019-08-20 06:19:44,844 [salt.state       :1951][INFO    ][29748] Completed state [/etc/maas/regiond.conf] at time 06:19:44.844359 duration_in_ms=54.103
2019-08-20 06:19:44,845 [salt.state       :1780][INFO    ][29748] Running state [/usr/lib/python3/dist-packages/provisioningserver/templates/proxy/maas-proxy.conf.template] at time 06:19:44.845157
2019-08-20 06:19:44,845 [salt.state       :1813][INFO    ][29748] Executing state file.managed for [/usr/lib/python3/dist-packages/provisioningserver/templates/proxy/maas-proxy.conf.template]
2019-08-20 06:19:44,920 [salt.state       :300 ][INFO    ][29748] File /usr/lib/python3/dist-packages/provisioningserver/templates/proxy/maas-proxy.conf.template is in the correct state
2019-08-20 06:19:44,921 [salt.state       :1951][INFO    ][29748] Completed state [/usr/lib/python3/dist-packages/provisioningserver/templates/proxy/maas-proxy.conf.template] at time 06:19:44.921055 duration_in_ms=75.898
2019-08-20 06:19:44,921 [salt.state       :1780][INFO    ][29748] Running state [/usr/lib/python3/dist-packages/maasserver/node_status.py] at time 06:19:44.921676
2019-08-20 06:19:44,922 [salt.state       :1813][INFO    ][29748] Executing state file.replace for [/usr/lib/python3/dist-packages/maasserver/node_status.py]
2019-08-20 06:19:44,934 [salt.state       :300 ][INFO    ][29748] No changes needed to be made
2019-08-20 06:19:44,934 [salt.state       :1951][INFO    ][29748] Completed state [/usr/lib/python3/dist-packages/maasserver/node_status.py] at time 06:19:44.934706 duration_in_ms=13.031
2019-08-20 06:19:44,935 [salt.state       :1780][INFO    ][29748] Running state [/usr/lib/python3/dist-packages/maasserver/node_status.py] at time 06:19:44.935299
2019-08-20 06:19:44,935 [salt.state       :1813][INFO    ][29748] Executing state file.replace for [/usr/lib/python3/dist-packages/maasserver/node_status.py]
2019-08-20 06:19:44,958 [salt.state       :300 ][INFO    ][29748] No changes needed to be made
2019-08-20 06:19:44,958 [salt.state       :1951][INFO    ][29748] Completed state [/usr/lib/python3/dist-packages/maasserver/node_status.py] at time 06:19:44.958745 duration_in_ms=23.445
2019-08-20 06:19:44,959 [salt.state       :1780][INFO    ][29748] Running state [/usr/lib/python3/dist-packages/maasserver/models/node.py] at time 06:19:44.959345
2019-08-20 06:19:44,959 [salt.state       :1813][INFO    ][29748] Executing state file.replace for [/usr/lib/python3/dist-packages/maasserver/models/node.py]
2019-08-20 06:19:44,987 [salt.state       :300 ][INFO    ][29748] No changes needed to be made
2019-08-20 06:19:44,988 [salt.state       :1951][INFO    ][29748] Completed state [/usr/lib/python3/dist-packages/maasserver/models/node.py] at time 06:19:44.988182 duration_in_ms=28.837
2019-08-20 06:19:44,988 [salt.state       :1780][INFO    ][29748] Running state [/etc/apache2/conf-enabled/maas-http.conf] at time 06:19:44.988747
2019-08-20 06:19:44,989 [salt.state       :1813][INFO    ][29748] Executing state file.managed for [/etc/apache2/conf-enabled/maas-http.conf]
2019-08-20 06:19:45,001 [salt.state       :300 ][INFO    ][29748] File /etc/apache2/conf-enabled/maas-http.conf is in the correct state
2019-08-20 06:19:45,001 [salt.state       :1951][INFO    ][29748] Completed state [/etc/apache2/conf-enabled/maas-http.conf] at time 06:19:45.001447 duration_in_ms=12.701
2019-08-20 06:19:45,002 [salt.state       :1780][INFO    ][29748] Running state [a2enmod headers] at time 06:19:45.002743
2019-08-20 06:19:45,003 [salt.state       :1813][INFO    ][29748] Executing state cmd.run for [a2enmod headers]
2019-08-20 06:19:45,003 [salt.loaded.int.module.cmdmod:395 ][INFO    ][29748] Executing command 'a2enmod headers' in directory '/root'
2019-08-20 06:19:45,078 [salt.state       :300 ][INFO    ][29748] {'pid': 29806, 'retcode': 0, 'stderr': '', 'stdout': 'Module headers already enabled'}
2019-08-20 06:19:45,078 [salt.state       :1951][INFO    ][29748] Completed state [a2enmod headers] at time 06:19:45.078443 duration_in_ms=75.7
2019-08-20 06:19:45,078 [salt.state       :1780][INFO    ][29748] Running state [/usr/share/maas/web/static/css/maas-styles.css] at time 06:19:45.078797
2019-08-20 06:19:45,079 [salt.state       :1813][INFO    ][29748] Executing state file.managed for [/usr/share/maas/web/static/css/maas-styles.css]
2019-08-20 06:19:45,093 [salt.state       :300 ][INFO    ][29748] File /usr/share/maas/web/static/css/maas-styles.css is in the correct state
2019-08-20 06:19:45,093 [salt.state       :1951][INFO    ][29748] Completed state [/usr/share/maas/web/static/css/maas-styles.css] at time 06:19:45.093279 duration_in_ms=14.482
2019-08-20 06:19:45,093 [salt.state       :1780][INFO    ][29748] Running state [/etc/maas/preseeds/curtin_userdata_amd64_generic_trusty] at time 06:19:45.093736
2019-08-20 06:19:45,094 [salt.state       :1813][INFO    ][29748] Executing state file.managed for [/etc/maas/preseeds/curtin_userdata_amd64_generic_trusty]
2019-08-20 06:19:45,154 [salt.state       :300 ][INFO    ][29748] File /etc/maas/preseeds/curtin_userdata_amd64_generic_trusty is in the correct state
2019-08-20 06:19:45,154 [salt.state       :1951][INFO    ][29748] Completed state [/etc/maas/preseeds/curtin_userdata_amd64_generic_trusty] at time 06:19:45.154462 duration_in_ms=60.726
2019-08-20 06:19:45,154 [salt.state       :1780][INFO    ][29748] Running state [/etc/maas/preseeds/curtin_userdata_amd64_generic_xenial] at time 06:19:45.154944
2019-08-20 06:19:45,155 [salt.state       :1813][INFO    ][29748] Executing state file.managed for [/etc/maas/preseeds/curtin_userdata_amd64_generic_xenial]
2019-08-20 06:19:45,214 [salt.state       :300 ][INFO    ][29748] File /etc/maas/preseeds/curtin_userdata_amd64_generic_xenial is in the correct state
2019-08-20 06:19:45,215 [salt.state       :1951][INFO    ][29748] Completed state [/etc/maas/preseeds/curtin_userdata_amd64_generic_xenial] at time 06:19:45.215164 duration_in_ms=60.218
2019-08-20 06:19:45,216 [salt.state       :1780][INFO    ][29748] Running state [/etc/maas/preseeds/curtin_userdata_arm64_generic_xenial] at time 06:19:45.215992
2019-08-20 06:19:45,216 [salt.state       :1813][INFO    ][29748] Executing state file.managed for [/etc/maas/preseeds/curtin_userdata_arm64_generic_xenial]
2019-08-20 06:19:45,316 [salt.state       :300 ][INFO    ][29748] File /etc/maas/preseeds/curtin_userdata_arm64_generic_xenial is in the correct state
2019-08-20 06:19:45,317 [salt.state       :1951][INFO    ][29748] Completed state [/etc/maas/preseeds/curtin_userdata_arm64_generic_xenial] at time 06:19:45.317077 duration_in_ms=101.084
2019-08-20 06:19:45,317 [salt.state       :1780][INFO    ][29748] Running state [/root/.pgpass] at time 06:19:45.317591
2019-08-20 06:19:45,318 [salt.state       :1813][INFO    ][29748] Executing state file.managed for [/root/.pgpass]
2019-08-20 06:19:45,376 [salt.state       :300 ][INFO    ][29748] File /root/.pgpass is in the correct state
2019-08-20 06:19:45,376 [salt.state       :1951][INFO    ][29748] Completed state [/root/.pgpass] at time 06:19:45.376400 duration_in_ms=58.808
2019-08-20 06:19:45,382 [salt.state       :1780][INFO    ][29748] Running state [maas-region syncdb --noinput] at time 06:19:45.382640
2019-08-20 06:19:45,383 [salt.state       :1813][INFO    ][29748] Executing state cmd.run for [maas-region syncdb --noinput]
2019-08-20 06:19:45,383 [salt.loaded.int.module.cmdmod:395 ][INFO    ][29748] Executing command 'maas-region syncdb --noinput' in directory '/root'
2019-08-20 06:19:47,204 [salt.state       :300 ][INFO    ][29748] {'pid': 29819, 'retcode': 0, 'stderr': '', 'stdout': 'Operations to perform:\n  Synchronize unmigrated apps: staticfiles, messages\n  Apply all migrations: contenttypes, maasserver, sessions, auth, sites, piston3, metadataserver\nSynchronizing apps without migrations:\n  Creating tables...\n    Running deferred SQL...\n  Installing custom SQL...\nRunning migrations:\n  No migrations to apply.'}
2019-08-20 06:19:47,205 [salt.state       :1951][INFO    ][29748] Completed state [maas-region syncdb --noinput] at time 06:19:47.205542 duration_in_ms=1822.9
2019-08-20 06:19:47,206 [salt.state       :2022][WARNING ][29748] State is set to retry, but a valid dict for retry configuration was not found.  Using retry defaults
2019-08-20 06:19:47,208 [salt.state       :1780][INFO    ][29748] Running state [maas-regiond] at time 06:19:47.208736
2019-08-20 06:19:47,209 [salt.state       :1813][INFO    ][29748] Executing state service.running for [maas-regiond]
2019-08-20 06:19:47,210 [salt.loaded.int.module.cmdmod:395 ][INFO    ][29748] Executing command ['systemctl', 'status', 'maas-regiond.service', '-n', '0'] in directory '/root'
2019-08-20 06:19:47,250 [salt.loaded.int.module.cmdmod:395 ][INFO    ][29748] Executing command ['systemctl', 'is-active', 'maas-regiond.service'] in directory '/root'
2019-08-20 06:19:47,269 [salt.loaded.int.module.cmdmod:395 ][INFO    ][29748] Executing command ['systemctl', 'is-enabled', 'maas-regiond.service'] in directory '/root'
2019-08-20 06:19:47,286 [salt.state       :300 ][INFO    ][29748] The service maas-regiond is already running
2019-08-20 06:19:47,286 [salt.state       :1951][INFO    ][29748] Completed state [maas-regiond] at time 06:19:47.286826 duration_in_ms=78.09
2019-08-20 06:19:47,289 [salt.state       :1780][INFO    ][29748] Running state [bind9] at time 06:19:47.289107
2019-08-20 06:19:47,289 [salt.state       :1813][INFO    ][29748] Executing state service.running for [bind9]
2019-08-20 06:19:47,290 [salt.loaded.int.module.cmdmod:395 ][INFO    ][29748] Executing command ['systemctl', 'status', 'bind9.service', '-n', '0'] in directory '/root'
2019-08-20 06:19:47,311 [salt.loaded.int.module.cmdmod:395 ][INFO    ][29748] Executing command ['systemctl', 'is-active', 'bind9.service'] in directory '/root'
2019-08-20 06:19:47,331 [salt.loaded.int.module.cmdmod:395 ][INFO    ][29748] Executing command ['systemctl', 'is-enabled', 'bind9.service'] in directory '/root'
2019-08-20 06:19:47,349 [salt.state       :300 ][INFO    ][29748] The service bind9 is already running
2019-08-20 06:19:47,349 [salt.state       :1951][INFO    ][29748] Completed state [bind9] at time 06:19:47.349705 duration_in_ms=60.599
2019-08-20 06:19:47,351 [salt.state       :1780][INFO    ][29748] Running state [apache2] at time 06:19:47.351548
2019-08-20 06:19:47,351 [salt.state       :1813][INFO    ][29748] Executing state service.running for [apache2]
2019-08-20 06:19:47,352 [salt.loaded.int.module.cmdmod:395 ][INFO    ][29748] Executing command ['systemctl', 'status', 'apache2.service', '-n', '0'] in directory '/root'
2019-08-20 06:19:47,371 [salt.loaded.int.module.cmdmod:395 ][INFO    ][29748] Executing command ['systemctl', 'is-active', 'apache2.service'] in directory '/root'
2019-08-20 06:19:47,388 [salt.loaded.int.module.cmdmod:395 ][INFO    ][29748] Executing command ['systemctl', 'is-enabled', 'apache2.service'] in directory '/root'
2019-08-20 06:19:47,409 [salt.state       :300 ][INFO    ][29748] The service apache2 is already running
2019-08-20 06:19:47,410 [salt.state       :1951][INFO    ][29748] Completed state [apache2] at time 06:19:47.410267 duration_in_ms=58.719
2019-08-20 06:19:47,411 [salt.state       :1780][INFO    ][29748] Running state [maasng.wait_for_http_code] at time 06:19:47.411925
2019-08-20 06:19:47,412 [salt.state       :1813][INFO    ][29748] Executing state module.run for [maasng.wait_for_http_code]
2019-08-20 06:19:47,412 [salt.utils.decorators:613 ][WARNING ][29748] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-08-20 06:19:47,531 [salt.state       :300 ][INFO    ][29748] {'ret': {'comment': 'MAAS API:http://localhost:5240/MAAS up.', 'result': True}}
2019-08-20 06:19:47,532 [salt.state       :1951][INFO    ][29748] Completed state [maasng.wait_for_http_code] at time 06:19:47.532024 duration_in_ms=120.098
2019-08-20 06:19:47,533 [salt.state       :1780][INFO    ][29748] Running state [maas createadmin --username opnfv --password opnfv_secret --email email@example.com && touch /var/lib/maas/.setup_admin] at time 06:19:47.533292
2019-08-20 06:19:47,533 [salt.state       :1813][INFO    ][29748] Executing state cmd.run for [maas createadmin --username opnfv --password opnfv_secret --email email@example.com && touch /var/lib/maas/.setup_admin]
2019-08-20 06:19:47,534 [salt.state       :300 ][INFO    ][29748] /var/lib/maas/.setup_admin exists
2019-08-20 06:19:47,534 [salt.state       :1951][INFO    ][29748] Completed state [maas createadmin --username opnfv --password opnfv_secret --email email@example.com && touch /var/lib/maas/.setup_admin] at time 06:19:47.534869 duration_in_ms=1.576
2019-08-20 06:19:47,536 [salt.state       :1780][INFO    ][29748] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 06:19:47.536036
2019-08-20 06:19:47,536 [salt.state       :1813][INFO    ][29748] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2019-08-20 06:19:47,537 [salt.loaded.int.module.cmdmod:395 ][INFO    ][29748] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2019-08-20 06:19:49,112 [salt.state       :300 ][INFO    ][29748] {'pid': 29841, 'retcode': 0, 'stderr': '', 'stdout': ''}
2019-08-20 06:19:49,113 [salt.state       :1951][INFO    ][29748] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 06:19:49.113412 duration_in_ms=1577.376
2019-08-20 06:19:49,122 [salt.state       :1780][INFO    ][29748] Running state [maas_region_boot_source_resources_mirror] at time 06:19:49.122183
2019-08-20 06:19:49,122 [salt.state       :1813][INFO    ][29748] Executing state maasng.boot_source_present for [maas_region_boot_source_resources_mirror]
2019-08-20 06:19:49,229 [salt.state       :300 ][INFO    ][29748] {'changes': {}}
2019-08-20 06:19:49,229 [salt.state       :1951][INFO    ][29748] Completed state [maas_region_boot_source_resources_mirror] at time 06:19:49.229438 duration_in_ms=107.254
2019-08-20 06:19:49,230 [salt.state       :1780][INFO    ][29748] Running state [maasng.boot_resources_import] at time 06:19:49.230715
2019-08-20 06:19:49,231 [salt.state       :1813][INFO    ][29748] Executing state module.run for [maasng.boot_resources_import]
2019-08-20 06:19:49,231 [salt.utils.decorators:613 ][WARNING ][29748] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-08-20 06:19:49,343 [salt.loaded.ext.module.maasng:1600][INFO    ][29748] Waiting boot-resources import done
sleep for:5s Left:900.0/900s
2019-08-20 06:19:54,402 [salt.loaded.ext.module.maasng:1600][INFO    ][29748] Waiting boot-resources import done
sleep for:5s Left:895.0/900s
2019-08-20 06:19:55,378 [salt.minion      :1308][INFO    ][29668] User sudo_ubuntu Executing command saltutil.find_job with jid 20190820061955362126
2019-08-20 06:19:55,402 [salt.minion      :1432][INFO    ][29865] Starting a new job with PID 29865
2019-08-20 06:19:55,425 [salt.minion      :1711][INFO    ][29865] Returning information for job: 20190820061955362126
2019-08-20 06:19:59,463 [salt.loaded.ext.module.maasng:1600][INFO    ][29748] Waiting boot-resources import done
sleep for:5s Left:890.0/900s
2019-08-20 06:20:04,578 [salt.state       :300 ][INFO    ][29748] {'ret': True}
2019-08-20 06:20:04,578 [salt.state       :1951][INFO    ][29748] Completed state [maasng.boot_resources_import] at time 06:20:04.578470 duration_in_ms=15347.756
2019-08-20 06:20:04,579 [salt.state       :1780][INFO    ][29748] Running state [maas_region_boot_sources_selection_xenial] at time 06:20:04.579575
2019-08-20 06:20:04,580 [salt.state       :1813][INFO    ][29748] Executing state maasng.boot_sources_selections_present for [maas_region_boot_sources_selection_xenial]
2019-08-20 06:20:04,807 [salt.state       :300 ][INFO    ][29748] Requested boot-source selection for http://images.maas.io/ephemeral-v3/daily already exist.
2019-08-20 06:20:04,808 [salt.state       :1951][INFO    ][29748] Completed state [maas_region_boot_sources_selection_xenial] at time 06:20:04.808348 duration_in_ms=228.772
2019-08-20 06:20:04,809 [salt.state       :1780][INFO    ][29748] Running state [maasng.sync_and_wait_bs_to_all_racks] at time 06:20:04.809698
2019-08-20 06:20:04,810 [salt.state       :1813][INFO    ][29748] Executing state module.run for [maasng.sync_and_wait_bs_to_all_racks]
2019-08-20 06:20:04,810 [salt.utils.decorators:613 ][WARNING ][29748] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-08-20 06:20:04,811 [salt.loaded.ext.module.maasng:1771][INFO    ][29748] boot-sources sync initiated for ALL Rack's
2019-08-20 06:20:05,802 [salt.state       :300 ][INFO    ][29748] {'ret': True}
2019-08-20 06:20:05,802 [salt.state       :1951][INFO    ][29748] Completed state [maasng.sync_and_wait_bs_to_all_racks] at time 06:20:05.802585 duration_in_ms=992.887
2019-08-20 06:20:05,804 [salt.state       :1780][INFO    ][29748] Running state [maas.process_maas_config] at time 06:20:05.804286
2019-08-20 06:20:05,804 [salt.state       :1813][INFO    ][29748] Executing state module.run for [maas.process_maas_config]
2019-08-20 06:20:05,805 [salt.utils.decorators:613 ][WARNING ][29748] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-08-20 06:20:05,805 [salt.loaded.ext.module.maas:92  ][INFO    ][29748] maasconfig name=enable_http_proxy value=True
2019-08-20 06:20:05,869 [salt.loaded.ext.module.maas:92  ][INFO    ][29748] maasconfig name=upstream_dns value=8.8.8.8
2019-08-20 06:20:05,934 [salt.loaded.ext.module.maas:92  ][INFO    ][29748] maasconfig name=commissioning_distro_series value=xenial
2019-08-20 06:20:06,006 [salt.loaded.ext.module.maas:92  ][INFO    ][29748] maasconfig name=default_osystem value=ubuntu
2019-08-20 06:20:06,071 [salt.loaded.ext.module.maas:92  ][INFO    ][29748] maasconfig name=active_discovery_interval value=600
2019-08-20 06:20:06,145 [salt.loaded.ext.module.maas:92  ][INFO    ][29748] maasconfig name=dnssec_validation value=no
2019-08-20 06:20:06,203 [salt.loaded.ext.module.maas:92  ][INFO    ][29748] maasconfig name=maas_name value=mas01
2019-08-20 06:20:08,931 [salt.loaded.ext.module.maas:92  ][INFO    ][29748] maasconfig name=network_discovery value=enabled
2019-08-20 06:20:09,049 [salt.loaded.ext.module.maas:92  ][INFO    ][29748] maasconfig name=enable_third_party_drivers value=True
2019-08-20 06:20:09,102 [salt.loaded.ext.module.maas:92  ][INFO    ][29748] maasconfig name=default_storage_layout value=lvm
2019-08-20 06:20:09,159 [salt.loaded.ext.module.maas:92  ][INFO    ][29748] maasconfig name=ntp_external_only value=True
2019-08-20 06:20:09,233 [salt.loaded.ext.module.maas:92  ][INFO    ][29748] maasconfig name=disk_erase_with_secure_erase value=False
2019-08-20 06:20:09,290 [salt.loaded.ext.module.maas:92  ][INFO    ][29748] maasconfig name=default_distro_series value=xenial
2019-08-20 06:20:09,376 [salt.loaded.ext.module.maas:92  ][INFO    ][29748] maasconfig name=default_min_hwe_kernel value=hwe-16.04
2019-08-20 06:20:09,516 [salt.state       :300 ][INFO    ][29748] {'ret': {'updated': [], 'errors': {}, 'success': ['enable_http_proxy', 'upstream_dns', 'commissioning_distro_series', 'default_osystem', 'active_discovery_interval', 'dnssec_validation', 'maas_name', 'network_discovery', 'enable_third_party_drivers', 'default_storage_layout', 'ntp_external_only', 'disk_erase_with_secure_erase', 'default_distro_series', 'default_min_hwe_kernel']}}
2019-08-20 06:20:09,516 [salt.state       :1951][INFO    ][29748] Completed state [maas.process_maas_config] at time 06:20:09.516445 duration_in_ms=3712.158
2019-08-20 06:20:09,517 [salt.state       :1780][INFO    ][29748] Running state [pxe_admin] at time 06:20:09.517205
2019-08-20 06:20:09,517 [salt.state       :1813][INFO    ][29748] Executing state maasng.fabric_present for [pxe_admin]
2019-08-20 06:20:09,590 [salt.loaded.ext.module.maasng:945 ][INFO    ][29748] [{u'class_type': None, u'resource_uri': u'/MAAS/api/2.0/fabrics/0/', u'vlans': [{u'fabric': u'fabric-0', u'vid': 0, u'space': u'undefined', u'dhcp_on': False, u'fabric_id': 0, u'mtu': 1500, u'primary_rack': None, u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/', u'id': 5001, u'secondary_rack': None, u'name': u'untagged'}], u'name': u'fabric-0', u'id': 0}, {u'class_type': None, u'resource_uri': u'/MAAS/api/2.0/fabrics/1/', u'vlans': [{u'fabric': u'fabric-1', u'vid': 0, u'space': u'undefined', u'dhcp_on': False, u'fabric_id': 1, u'mtu': 1500, u'primary_rack': None, 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'name': u'fabric-1', u'id': 1}, {u'class_type': u'', u'resource_uri': u'/MAAS/api/2.0/fabrics/2/', u'vlans': [{u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'dhcp_on': True, u'fabric_id': 2, u'mtu': 1500, u'primary_rack': u'mnf6hm', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/', u'id': 5003, u'secondary_rack': None, u'name': u'untagged'}], u'name': u'pxe_admin', u'id': 2}]
2019-08-20 06:20:09,665 [salt.loaded.ext.module.maasng:1008][WARNING ][29748] Detected cidr:192.168.11.0/24 in fabric:pxe_admin
2019-08-20 06:20:09,666 [salt.loaded.ext.module.maasng:1011][WARNING ][29748] Guessing, that fabric with current name:pxe_admin
 should be renamed to:pxe_admin
2019-08-20 06:20:09,737 [salt.state       :300 ][INFO    ][29748] {'new': 'Fabric  pxe_admin created', 'result': True}
2019-08-20 06:20:09,738 [salt.state       :1951][INFO    ][29748] Completed state [pxe_admin] at time 06:20:09.738192 duration_in_ms=220.986
2019-08-20 06:20:09,738 [salt.state       :1780][INFO    ][29748] Running state [vlan 0] at time 06:20:09.738633
2019-08-20 06:20:09,739 [salt.state       :1813][INFO    ][29748] Executing state maasng.vlan_present_in_fabric for [vlan 0]
2019-08-20 06:20:09,796 [salt.loaded.ext.module.maasng:945 ][INFO    ][29748] [{u'id': 0, u'vlans': [{u'vid': 0, u'fabric': u'fabric-0', u'name': u'untagged', u'space': u'undefined', u'dhcp_on': False, u'fabric_id': 0, u'mtu': 1500, u'primary_rack': None, u'relay_vlan': None, u'external_dhcp': None, u'id': 5001, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/'}], u'class_type': None, u'name': u'fabric-0', u'resource_uri': u'/MAAS/api/2.0/fabrics/0/'}, {u'id': 1, u'vlans': [{u'vid': 0, u'fabric': u'fabric-1', u'name': u'untagged', u'space': u'undefined', u'dhcp_on': False, u'fabric_id': 1, u'mtu': 1500, u'primary_rack': None, u'relay_vlan': None, u'external_dhcp': None, u'id': 5002, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/'}], u'class_type': None, u'name': u'fabric-1', u'resource_uri': u'/MAAS/api/2.0/fabrics/1/'}, {u'id': 2, u'vlans': [{u'vid': 0, u'fabric': u'pxe_admin', u'name': u'untagged', u'space': u'undefined', u'dhcp_on': True, u'fabric_id': 2, u'mtu': 1500, u'primary_rack': u'mnf6hm', u'relay_vlan': None, u'external_dhcp': None, u'id': 5003, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/'}], u'class_type': u'', u'name': u'pxe_admin', u'resource_uri': u'/MAAS/api/2.0/fabrics/2/'}]
2019-08-20 06:20:09,908 [salt.loaded.ext.module.maasng:945 ][INFO    ][29748] [{u'id': 0, u'vlans': [{u'vid': 0, u'fabric': u'fabric-0', u'name': u'untagged', u'space': u'undefined', u'dhcp_on': False, u'fabric_id': 0, u'mtu': 1500, u'primary_rack': None, u'relay_vlan': None, u'external_dhcp': None, u'id': 5001, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/'}], u'class_type': None, u'name': u'fabric-0', u'resource_uri': u'/MAAS/api/2.0/fabrics/0/'}, {u'id': 1, u'vlans': [{u'vid': 0, u'fabric': u'fabric-1', u'name': u'untagged', u'space': u'undefined', u'dhcp_on': False, u'fabric_id': 1, u'mtu': 1500, u'primary_rack': None, u'relay_vlan': None, u'external_dhcp': None, u'id': 5002, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/'}], u'class_type': None, u'name': u'fabric-1', u'resource_uri': u'/MAAS/api/2.0/fabrics/1/'}, {u'id': 2, u'vlans': [{u'vid': 0, u'fabric': u'pxe_admin', u'name': u'untagged', u'space': u'undefined', u'dhcp_on': True, u'fabric_id': 2, u'mtu': 1500, u'primary_rack': u'mnf6hm', u'relay_vlan': None, u'external_dhcp': None, u'id': 5003, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/'}], u'class_type': u'', u'name': u'pxe_admin', u'resource_uri': u'/MAAS/api/2.0/fabrics/2/'}]
2019-08-20 06:20:10,123 [salt.loaded.ext.module.maasng:945 ][INFO    ][29748] [{u'id': 0, u'class_type': None, u'vlans': [{u'fabric': u'fabric-0', u'vid': 0, u'space': u'undefined', u'fabric_id': 0, u'dhcp_on': False, u'name': u'untagged', u'primary_rack': None, u'relay_vlan': None, u'external_dhcp': None, u'mtu': 1500, u'id': 5001, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/'}], u'name': u'fabric-0', u'resource_uri': u'/MAAS/api/2.0/fabrics/0/'}, {u'id': 1, u'class_type': None, u'vlans': [{u'fabric': u'fabric-1', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': False, u'name': u'untagged', u'primary_rack': None, u'relay_vlan': None, u'external_dhcp': None, u'mtu': 1500, u'id': 5002, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/'}], u'name': u'fabric-1', u'resource_uri': u'/MAAS/api/2.0/fabrics/1/'}, {u'id': 2, u'class_type': u'', u'vlans': [{u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'fabric_id': 2, u'dhcp_on': True, u'name': u'untagged', u'primary_rack': u'mnf6hm', u'relay_vlan': None, u'external_dhcp': None, u'mtu': 1500, u'id': 5003, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/'}], u'name': u'pxe_admin', u'resource_uri': u'/MAAS/api/2.0/fabrics/2/'}]
2019-08-20 06:20:10,210 [salt.state       :300 ][INFO    ][29748] {'new': 'Vlan untagged was updated'}
2019-08-20 06:20:10,211 [salt.state       :1951][INFO    ][29748] Completed state [vlan 0] at time 06:20:10.211113 duration_in_ms=472.478
2019-08-20 06:20:10,212 [salt.state       :1780][INFO    ][29748] Running state [192.168.11.0/24] at time 06:20:10.212772
2019-08-20 06:20:10,213 [salt.state       :1813][INFO    ][29748] Executing state maasng.subnet_present for [192.168.11.0/24]
2019-08-20 06:20:10,395 [salt.loaded.ext.module.maasng:945 ][INFO    ][29748] [{u'id': 0, u'vlans': [{u'vid': 0, u'fabric': u'fabric-0', u'name': u'untagged', u'space': u'undefined', u'dhcp_on': False, u'fabric_id': 0, u'mtu': 1500, u'primary_rack': None, u'relay_vlan': None, u'external_dhcp': None, u'id': 5001, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/'}], u'class_type': None, u'name': u'fabric-0', u'resource_uri': u'/MAAS/api/2.0/fabrics/0/'}, {u'id': 1, u'vlans': [{u'vid': 0, u'fabric': u'fabric-1', u'name': u'untagged', u'space': u'undefined', u'dhcp_on': False, u'fabric_id': 1, u'mtu': 1500, u'primary_rack': None, u'relay_vlan': None, u'external_dhcp': None, u'id': 5002, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/'}], u'class_type': None, u'name': u'fabric-1', u'resource_uri': u'/MAAS/api/2.0/fabrics/1/'}, {u'id': 2, u'vlans': [{u'vid': 0, u'fabric': u'pxe_admin', u'name': u'untagged', u'space': u'undefined', u'dhcp_on': False, u'fabric_id': 2, u'mtu': 1500, u'primary_rack': u'mnf6hm', u'relay_vlan': None, u'external_dhcp': None, u'id': 5003, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/'}], u'class_type': u'', u'name': u'pxe_admin', u'resource_uri': u'/MAAS/api/2.0/fabrics/2/'}]
2019-08-20 06:20:10,396 [salt.loaded.ext.module.maasng:1235][WARNING ][29748] Ignoring parameter vlan:0
2019-08-20 06:20:10,489 [salt.state       :300 ][INFO    ][29748] Subnet 192.168.11.0/24 has been updated for pxe_admin
2019-08-20 06:20:10,489 [salt.state       :1951][INFO    ][29748] Completed state [192.168.11.0/24] at time 06:20:10.489565 duration_in_ms=276.794
2019-08-20 06:20:10,490 [salt.state       :1780][INFO    ][29748] Running state [maas_create_iprange_1] at time 06:20:10.490212
2019-08-20 06:20:10,490 [salt.state       :1813][INFO    ][29748] Executing state maasng.iprange_present for [maas_create_iprange_1]
2019-08-20 06:20:10,552 [salt.state       :300 ][INFO    ][29748] Iprange maas_create_iprange_1 already exist.
2019-08-20 06:20:10,552 [salt.state       :1951][INFO    ][29748] Completed state [maas_create_iprange_1] at time 06:20:10.552373 duration_in_ms=62.16
2019-08-20 06:20:10,552 [salt.state       :1780][INFO    ][29748] Running state [vlan 0] at time 06:20:10.552701
2019-08-20 06:20:10,553 [salt.state       :1813][INFO    ][29748] Executing state maasng.vlan_present_in_fabric for [vlan 0]
2019-08-20 06:20:10,602 [salt.loaded.ext.module.maasng:945 ][INFO    ][29748] [{u'id': 0, u'class_type': None, u'vlans': [{u'fabric': u'fabric-0', u'vid': 0, u'space': u'undefined', u'fabric_id': 0, u'dhcp_on': False, u'name': u'untagged', u'primary_rack': None, u'relay_vlan': None, u'external_dhcp': None, u'mtu': 1500, u'id': 5001, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/'}], u'name': u'fabric-0', u'resource_uri': u'/MAAS/api/2.0/fabrics/0/'}, {u'id': 1, u'class_type': None, u'vlans': [{u'fabric': u'fabric-1', u'vid': 0, u'space': u'undefined', u'fabric_id': 1, u'dhcp_on': False, u'name': u'untagged', u'primary_rack': None, u'relay_vlan': None, u'external_dhcp': None, u'mtu': 1500, u'id': 5002, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/'}], u'name': u'fabric-1', u'resource_uri': u'/MAAS/api/2.0/fabrics/1/'}, {u'id': 2, u'class_type': u'', u'vlans': [{u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'fabric_id': 2, u'dhcp_on': False, u'name': u'untagged', u'primary_rack': u'mnf6hm', u'relay_vlan': None, u'external_dhcp': None, u'mtu': 1500, u'id': 5003, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/'}], u'name': u'pxe_admin', u'resource_uri': u'/MAAS/api/2.0/fabrics/2/'}]
2019-08-20 06:20:10,698 [salt.loaded.ext.module.maasng:945 ][INFO    ][29748] [{u'id': 0, u'vlans': [{u'vid': 0, u'fabric': u'fabric-0', u'name': u'untagged', u'space': u'undefined', u'dhcp_on': False, u'fabric_id': 0, u'mtu': 1500, u'primary_rack': None, u'relay_vlan': None, u'external_dhcp': None, u'id': 5001, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/'}], u'class_type': None, u'name': u'fabric-0', u'resource_uri': u'/MAAS/api/2.0/fabrics/0/'}, {u'id': 1, u'vlans': [{u'vid': 0, u'fabric': u'fabric-1', u'name': u'untagged', u'space': u'undefined', u'dhcp_on': False, u'fabric_id': 1, u'mtu': 1500, u'primary_rack': None, u'relay_vlan': None, u'external_dhcp': None, u'id': 5002, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/'}], u'class_type': None, u'name': u'fabric-1', u'resource_uri': u'/MAAS/api/2.0/fabrics/1/'}, {u'id': 2, u'vlans': [{u'vid': 0, u'fabric': u'pxe_admin', u'name': u'untagged', u'space': u'undefined', u'dhcp_on': False, u'fabric_id': 2, u'mtu': 1500, u'primary_rack': u'mnf6hm', u'relay_vlan': None, u'external_dhcp': None, u'id': 5003, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/'}], u'class_type': u'', u'name': u'pxe_admin', u'resource_uri': u'/MAAS/api/2.0/fabrics/2/'}]
2019-08-20 06:20:10,928 [salt.loaded.ext.module.maasng:945 ][INFO    ][29748] [{u'id': 0, u'vlans': [{u'vid': 0, u'fabric': u'fabric-0', u'name': u'untagged', u'space': u'undefined', u'dhcp_on': False, u'fabric_id': 0, u'mtu': 1500, u'primary_rack': None, u'relay_vlan': None, u'external_dhcp': None, u'id': 5001, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/'}], u'class_type': None, u'name': u'fabric-0', u'resource_uri': u'/MAAS/api/2.0/fabrics/0/'}, {u'id': 1, u'vlans': [{u'vid': 0, u'fabric': u'fabric-1', u'name': u'untagged', u'space': u'undefined', u'dhcp_on': False, u'fabric_id': 1, u'mtu': 1500, u'primary_rack': None, u'relay_vlan': None, u'external_dhcp': None, u'id': 5002, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5002/'}], u'class_type': None, u'name': u'fabric-1', u'resource_uri': u'/MAAS/api/2.0/fabrics/1/'}, {u'id': 2, u'vlans': [{u'vid': 0, u'fabric': u'pxe_admin', u'name': u'untagged', u'space': u'undefined', u'dhcp_on': False, u'fabric_id': 2, u'mtu': 1500, u'primary_rack': u'mnf6hm', u'relay_vlan': None, u'external_dhcp': None, u'id': 5003, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/'}], u'class_type': u'', u'name': u'pxe_admin', u'resource_uri': u'/MAAS/api/2.0/fabrics/2/'}]
2019-08-20 06:20:11,027 [salt.state       :300 ][INFO    ][29748] {'new': 'Vlan untagged was updated'}
2019-08-20 06:20:11,027 [salt.state       :1951][INFO    ][29748] Completed state [vlan 0] at time 06:20:11.027456 duration_in_ms=474.754
2019-08-20 06:20:11,028 [salt.state       :1780][INFO    ][29748] Running state [opnfv] at time 06:20:11.028378
2019-08-20 06:20:11,028 [salt.state       :1813][INFO    ][29748] Executing state maasng.sshkey_present for [opnfv]
2019-08-20 06:20:11,067 [salt.loaded.ext.module.maasng:1903][INFO    ][29748] [{u'resource_uri': u'/MAAS/api/2.0/account/prefs/sshkeys/1/', u'id': 1, u'key': u'ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC9EPrpVPjbJtSqDZMX5nXn6LMNnuXDhsh1V4Zf0ynamBhtwcs6ztm8AaLppz+mdXFAdO0jHy1U72eWTefrkaMjL/tFjZY03xJnuRPmhzPOy/LT8tOjkp1SRLb3JhYoKUDcJIJ2aAv0SIDuXhTT8r4aUvJOWUSv0Og34WfS1afOLKSjiz1j2sOW2iG1nim0uF+sX1K3GHPnE5LtwJMAG4WQO1yK9XG3CUxkaYnJRdMfwAx5QAhGhxu/bK7NwyTNxz8fkPdJhxookorf7JetCWwq6ScSTbAHqoTWbzLh4BhNVMOEdbMKAODdOXj2ii5mEFnQYBBmh1dXSP3k2bzD/TCP', u'keysource': u''}]
2019-08-20 06:20:11,067 [salt.state       :300 ][INFO    ][29748] SSH key ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC9EPrpVPjbJtSqDZMX5nXn6LMNnuXDhsh1V4Zf0ynamBhtwcs6ztm8AaLppz+mdXFAdO0jHy1U72eWTefrkaMjL/tFjZY03xJnuRPmhzPOy/LT8tOjkp1SRLb3JhYoKUDcJIJ2aAv0SIDuXhTT8r4aUvJOWUSv0Og34WfS1afOLKSjiz1j2sOW2iG1nim0uF+sX1K3GHPnE5LtwJMAG4WQO1yK9XG3CUxkaYnJRdMfwAx5QAhGhxu/bK7NwyTNxz8fkPdJhxookorf7JetCWwq6ScSTbAHqoTWbzLh4BhNVMOEdbMKAODdOXj2ii5mEFnQYBBmh1dXSP3k2bzD/TCP already exist for user opnfv.
2019-08-20 06:20:11,068 [salt.state       :1951][INFO    ][29748] Completed state [opnfv] at time 06:20:11.067966 duration_in_ms=39.586
2019-08-20 06:20:11,068 [salt.state       :1780][INFO    ][29748] Running state [maas.process_tags] at time 06:20:11.068909
2019-08-20 06:20:11,069 [salt.state       :1813][INFO    ][29748] Executing state module.run for [maas.process_tags]
2019-08-20 06:20:11,069 [salt.utils.decorators:613 ][WARNING ][29748] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-08-20 06:20:11,109 [salt.loaded.ext.module.maas:92  ][INFO    ][29748] tags comment=Enable 1G pagesizes on aarch64 definition=//capability[@id="asimd"] name=aarch64_hugepages_1g kernel_opts=default_hugepagesz=1G hugepagesz=1G
2019-08-20 06:20:11,217 [salt.state       :300 ][INFO    ][29748] {'ret': {'updated': ['aarch64_hugepages_1g'], 'errors': {}, 'success': []}}
2019-08-20 06:20:11,218 [salt.state       :1951][INFO    ][29748] Completed state [maas.process_tags] at time 06:20:11.218001 duration_in_ms=149.091
2019-08-20 06:20:11,222 [salt.minion      :1711][INFO    ][29748] Returning information for job: 20190820061940273016
2019-08-20 06:20:11,874 [salt.minion      :1308][INFO    ][29668] User sudo_ubuntu Executing command state.apply with jid 20190820062011866129
2019-08-20 06:20:11,892 [salt.minion      :1432][INFO    ][30273] Starting a new job with PID 30273
2019-08-20 06:20:15,433 [salt.state       :915 ][INFO    ][30273] Loading fresh modules for state activity
2019-08-20 06:20:15,491 [salt.fileclient  :1219][INFO    ][30273] Fetching file from saltenv 'base', ** done ** 'maas/machines/init.sls'
2019-08-20 06:20:15,530 [salt.state       :1780][INFO    ][30273] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 06:20:15.530085
2019-08-20 06:20:15,530 [salt.state       :1813][INFO    ][30273] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2019-08-20 06:20:15,532 [salt.loaded.int.module.cmdmod:395 ][INFO    ][30273] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2019-08-20 06:20:16,963 [salt.state       :300 ][INFO    ][30273] {'pid': 30297, 'retcode': 0, 'stderr': '', 'stdout': ''}
2019-08-20 06:20:16,963 [salt.state       :1951][INFO    ][30273] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 06:20:16.963877 duration_in_ms=1433.793
2019-08-20 06:20:16,965 [salt.state       :1780][INFO    ][30273] Running state [maas.process_machines] at time 06:20:16.965400
2019-08-20 06:20:16,965 [salt.state       :1813][INFO    ][30273] Executing state module.run for [maas.process_machines]
2019-08-20 06:20:16,965 [salt.utils.decorators:613 ][WARNING ][30273] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-08-20 06:20:17,014 [salt.loaded.ext.module.maas:412 ][WARNING ][30273] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2019-08-20 06:20:17,015 [salt.loaded.ext.module.maas:92  ][INFO    ][30273] machine hostname=cmp002 power_type=ipmi mac_addresses=00:25:b5:a0:00:6a power_parameters_power_address=172.30.8.72 power_parameters_power_pass=octopus architecture=amd64/generic power_parameters_power_user=admin
2019-08-20 06:20:18,199 [salt.loaded.ext.module.maas:412 ][WARNING ][30273] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2019-08-20 06:20:18,200 [salt.loaded.ext.module.maas:92  ][INFO    ][30273] machine hostname=cmp001 power_type=ipmi mac_addresses=00:25:b5:a0:00:5a power_parameters_power_address=172.30.8.73 power_parameters_power_pass=octopus architecture=amd64/generic power_parameters_power_user=admin
2019-08-20 06:20:19,396 [salt.loaded.ext.module.maas:412 ][WARNING ][30273] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2019-08-20 06:20:19,396 [salt.loaded.ext.module.maas:92  ][INFO    ][30273] machine hostname=kvm01 power_type=ipmi mac_addresses=00:25:b5:a0:00:2a power_parameters_power_address=172.30.8.75 power_parameters_power_pass=octopus architecture=amd64/generic power_parameters_power_user=admin
2019-08-20 06:20:20,720 [salt.loaded.ext.module.maas:412 ][WARNING ][30273] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2019-08-20 06:20:20,720 [salt.loaded.ext.module.maas:92  ][INFO    ][30273] machine hostname=kvm03 power_type=ipmi mac_addresses=00:25:b5:a0:00:4a power_parameters_power_address=172.30.8.74 power_parameters_power_pass=octopus architecture=amd64/generic power_parameters_power_user=admin
2019-08-20 06:20:22,187 [salt.loaded.ext.module.maas:412 ][WARNING ][30273] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2019-08-20 06:20:22,187 [salt.loaded.ext.module.maas:92  ][INFO    ][30273] machine hostname=kvm02 power_type=ipmi mac_addresses=00:25:b5:a0:00:3a power_parameters_power_address=172.30.8.65 power_parameters_power_pass=octopus architecture=amd64/generic power_parameters_power_user=admin
2019-08-20 06:20:23,373 [salt.state       :300 ][INFO    ][30273] {'ret': {'updated': [], 'errors': {}, 'success': ['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']}}
2019-08-20 06:20:23,374 [salt.state       :1951][INFO    ][30273] Completed state [maas.process_machines] at time 06:20:23.374254 duration_in_ms=6408.852
2019-08-20 06:20:23,377 [salt.minion      :1711][INFO    ][30273] Returning information for job: 20190820062011866129
2019-08-20 06:20:54,483 [salt.minion      :1308][INFO    ][29668] User sudo_ubuntu Executing command state.apply with jid 20190820062054470023
2019-08-20 06:20:54,500 [salt.minion      :1432][INFO    ][30616] Starting a new job with PID 30616
2019-08-20 06:20:58,202 [salt.state       :915 ][INFO    ][30616] Loading fresh modules for state activity
2019-08-20 06:20:58,230 [salt.fileclient  :1219][INFO    ][30616] Fetching file from saltenv 'base', ** done ** 'maas/machines/wait_for_ready_or_deployed.sls'
2019-08-20 06:20:58,256 [salt.state       :1780][INFO    ][30616] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 06:20:58.256267
2019-08-20 06:20:58,256 [salt.state       :1813][INFO    ][30616] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2019-08-20 06:20:58,257 [salt.loaded.int.module.cmdmod:395 ][INFO    ][30616] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2019-08-20 06:20:59,667 [salt.state       :300 ][INFO    ][30616] {'pid': 30624, 'retcode': 0, 'stderr': '', 'stdout': ''}
2019-08-20 06:20:59,667 [salt.state       :1951][INFO    ][30616] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 06:20:59.667481 duration_in_ms=1411.213
2019-08-20 06:20:59,669 [salt.state       :1780][INFO    ][30616] Running state [maas.wait_for_machine_status] at time 06:20:59.669027
2019-08-20 06:20:59,669 [salt.state       :1813][INFO    ][30616] Executing state module.run for [maas.wait_for_machine_status]
2019-08-20 06:20:59,669 [salt.utils.decorators:613 ][WARNING ][30616] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-08-20 06:21:00,622 [salt.loaded.ext.module.maas:1023][INFO    ][30616] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1499.05160403s left)
2019-08-20 06:21:09,601 [salt.minion      :1308][INFO    ][29668] User sudo_ubuntu Executing command saltutil.find_job with jid 20190820062109588687
2019-08-20 06:21:09,625 [salt.minion      :1432][INFO    ][30636] Starting a new job with PID 30636
2019-08-20 06:21:09,648 [salt.minion      :1711][INFO    ][30636] Returning information for job: 20190820062109588687
2019-08-20 06:21:31,643 [salt.loaded.ext.module.maas:1023][INFO    ][30616] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1468.03068995s left)
2019-08-20 06:21:39,644 [salt.minion      :1308][INFO    ][29668] User sudo_ubuntu Executing command saltutil.find_job with jid 20190820062139631865
2019-08-20 06:21:39,667 [salt.minion      :1432][INFO    ][30689] Starting a new job with PID 30689
2019-08-20 06:21:39,692 [salt.minion      :1711][INFO    ][30689] Returning information for job: 20190820062139631865
2019-08-20 06:22:02,805 [salt.loaded.ext.module.maas:1023][INFO    ][30616] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1436.86858392s left)
2019-08-20 06:22:09,704 [salt.minion      :1308][INFO    ][29668] User sudo_ubuntu Executing command saltutil.find_job with jid 20190820062209693131
2019-08-20 06:22:09,723 [salt.minion      :1432][INFO    ][30810] Starting a new job with PID 30810
2019-08-20 06:22:09,745 [salt.minion      :1711][INFO    ][30810] Returning information for job: 20190820062209693131
2019-08-20 06:22:34,034 [salt.loaded.ext.module.maas:1023][INFO    ][30616] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1405.64025187s left)
2019-08-20 06:22:39,750 [salt.minion      :1308][INFO    ][29668] User sudo_ubuntu Executing command saltutil.find_job with jid 20190820062239736982
2019-08-20 06:22:39,772 [salt.minion      :1432][INFO    ][30951] Starting a new job with PID 30951
2019-08-20 06:22:39,795 [salt.minion      :1711][INFO    ][30951] Returning information for job: 20190820062239736982
2019-08-20 06:23:05,617 [salt.loaded.ext.module.maas:1023][INFO    ][30616] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1374.05642986s left)
2019-08-20 06:23:09,803 [salt.minion      :1308][INFO    ][29668] User sudo_ubuntu Executing command saltutil.find_job with jid 20190820062309789269
2019-08-20 06:23:09,827 [salt.minion      :1432][INFO    ][31116] Starting a new job with PID 31116
2019-08-20 06:23:09,851 [salt.minion      :1711][INFO    ][31116] Returning information for job: 20190820062309789269
2019-08-20 06:23:36,981 [salt.loaded.ext.module.maas:1023][INFO    ][30616] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1342.69294286s left)
2019-08-20 06:23:39,857 [salt.minion      :1308][INFO    ][29668] User sudo_ubuntu Executing command saltutil.find_job with jid 20190820062339844227
2019-08-20 06:23:39,879 [salt.minion      :1432][INFO    ][31743] Starting a new job with PID 31743
2019-08-20 06:23:39,904 [salt.minion      :1711][INFO    ][31743] Returning information for job: 20190820062339844227
2019-08-20 06:24:09,919 [salt.minion      :1308][INFO    ][29668] User sudo_ubuntu Executing command saltutil.find_job with jid 20190820062409903866
2019-08-20 06:24:09,942 [salt.minion      :1432][INFO    ][31886] Starting a new job with PID 31886
2019-08-20 06:24:09,965 [salt.minion      :1711][INFO    ][31886] Returning information for job: 20190820062409903866
2019-08-20 06:24:10,513 [salt.state       :300 ][INFO    ][30616] {'ret': True}
2019-08-20 06:24:10,513 [salt.state       :1951][INFO    ][30616] Completed state [maas.wait_for_machine_status] at time 06:24:10.513360 duration_in_ms=190844.331
2019-08-20 06:24:10,517 [salt.minion      :1711][INFO    ][30616] Returning information for job: 20190820062054470023
2019-08-20 06:24:11,147 [salt.minion      :1308][INFO    ][29668] User sudo_ubuntu Executing command state.apply with jid 20190820062411134268
2019-08-20 06:24:11,169 [salt.minion      :1432][INFO    ][31894] Starting a new job with PID 31894
2019-08-20 06:24:14,846 [salt.state       :915 ][INFO    ][31894] Loading fresh modules for state activity
2019-08-20 06:24:14,899 [salt.fileclient  :1219][INFO    ][31894] Fetching file from saltenv 'base', ** done ** 'maas/machines/storage.sls'
2019-08-20 06:24:14,984 [salt.state       :1780][INFO    ][31894] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 06:24:14.984724
2019-08-20 06:24:14,985 [salt.state       :1813][INFO    ][31894] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2019-08-20 06:24:14,986 [salt.loaded.int.module.cmdmod:395 ][INFO    ][31894] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2019-08-20 06:24:16,424 [salt.state       :300 ][INFO    ][31894] {'pid': 31918, 'retcode': 0, 'stderr': '', 'stdout': ''}
2019-08-20 06:24:16,425 [salt.state       :1951][INFO    ][31894] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 06:24:16.425082 duration_in_ms=1440.358
2019-08-20 06:24:16,426 [salt.state       :1780][INFO    ][31894] Running state [maas_machines_storage_cmp002_lvm] at time 06:24:16.426536
2019-08-20 06:24:16,426 [salt.state       :1813][INFO    ][31894] Executing state maasng.disk_layout_present for [maas_machines_storage_cmp002_lvm]
2019-08-20 06:24:17,679 [salt.loaded.ext.module.maasng:610 ][INFO    ][31894] rsqmqq
2019-08-20 06:24:17,680 [salt.loaded.ext.module.maasng:626 ][INFO    ][31894] sda
2019-08-20 06:24:18,340 [salt.loaded.ext.module.maasng:361 ][INFO    ][31894] rsqmqq
2019-08-20 06:24:18,478 [salt.loaded.ext.module.maasng:367 ][INFO    ][31894] [{u'partition_table_type': u'GPT', u'block_size': 4096, u'uuid': None, u'name': u'sda', u'tags': [u'rotary'], u'type': u'physical', u'path': u'/dev/disk/by-dname/sda', u'used_for': u'GPT partitioned with 1 partition', u'id_path': u'/dev/disk/by-id/wwn-0x618e728372755980239b15112698bc66', u'system_id': u'rsqmqq', u'resource_uri': u'/MAAS/api/2.0/nodes/rsqmqq/blockdevices/1/', u'filesystem': None, u'id': 1, u'available_size': 0, u'model': u'UCSB-MRAID12G', u'size': 2397998940160, u'used_size': 2397998940160, u'serial': u'618e728372755980239b15112698bc66', u'partitions': [{u'uuid': u'7882bb1d-a886-4c48-9253-8b992ab3889a', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'rsqmqq', u'device_id': 1, u'filesystem': {u'mount_options': None, u'label': None, u'mount_point': None, u'uuid': u'026d830b-cc21-45ca-b4c0-30e288381218', u'fstype': u'lvm-pv'}, u'path': u'/dev/disk/by-dname/sda-part2', u'size': 2397992648704, u'type': u'partition', u'id': 6, u'resource_uri': u'/MAAS/api/2.0/nodes/rsqmqq/blockdevices/1/partition/6'}]}, {u'partition_table_type': None, u'block_size': 4096, u'uuid': u'd071e87e-e73a-46f5-a788-132539d4d643', u'name': u'vgroot-lvroot', u'tags': [], u'type': u'virtual', u'path': u'/dev/disk/by-dname/lvroot', u'used_for': u'ext4 formatted filesystem mounted at /', u'id_path': None, u'system_id': u'rsqmqq', u'resource_uri': u'/MAAS/api/2.0/nodes/rsqmqq/blockdevices/11/', u'filesystem': {u'mount_options': None, u'label': u'root', u'mount_point': u'/', u'uuid': u'282448d6-c460-4402-848e-c7eb24686b1f', u'fstype': u'ext4'}, u'id': 11, u'available_size': 0, u'model': None, u'size': 2397988454400, u'used_size': 2397988454400, u'serial': None, u'partitions': []}]
2019-08-20 06:24:18,478 [salt.loaded.ext.module.maasng:632 ][INFO    ][31894] vgroot
2019-08-20 06:24:18,479 [salt.loaded.ext.module.maasng:635 ][INFO    ][31894] lvroot
2019-08-20 06:24:18,479 [salt.loaded.ext.module.maasng:639 ][INFO    ][31894] 107374182400
2019-08-20 06:24:19,012 [salt.loaded.ext.module.maasng:645 ][INFO    ][31894] {u'hwe_kernel': u'', u'testing_status_name': u'Passed', u'ip_addresses': [u'192.168.11.42'], u'cpu_count': 16, u'owner_data': {}, u'domain': {u'resource_record_count': 0, u'name': u'maas', u'authoritative': True, u'ttl': None, u'id': 0, u'resource_uri': u'/MAAS/api/2.0/domains/0/'}, u'memory_test_status_name': u'Unknown', u'status_action': u'', u'tag_names': [], u'swap_size': None, u'owner': None, u'pod': None, u'cache_sets': [], u'iscsiblockdevice_set': [], u'boot_disk': {u'model': u'UCSB-MRAID12G', u'block_size': 4096, u'available_size': 0, u'name': u'sda', u'tags': [u'rotary'], u'type': u'physical', u'id': 1, u'uuid': None, u'used_for': u'GPT partitioned with 1 partition', u'system_id': u'rsqmqq', u'partition_table_type': u'GPT', u'filesystem': None, u'id_path': u'/dev/disk/by-id/wwn-0x618e728372755980239b15112698bc66', u'path': u'/dev/disk/by-dname/sda', u'serial': u'618e728372755980239b15112698bc66', u'partitions': [{u'uuid': u'114805b1-6c37-4a44-a226-1b1dbd972f04', u'resource_uri': u'/MAAS/api/2.0/nodes/rsqmqq/blockdevices/1/partition/10', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'rsqmqq', u'filesystem': {u'mount_options': None, u'mount_point': None, u'uuid': u'854fb8a1-6a32-407c-af50-2fb90eb45871', u'fstype': u'lvm-pv', u'label': None}, u'path': u'/dev/disk/by-dname/sda-part2', u'size': 2397992648704, u'type': u'partition', u'id': 10, u'device_id': 1}], u'used_size': 2397998940160, u'resource_uri': u'/MAAS/api/2.0/nodes/rsqmqq/blockdevices/1/', u'size': 2397998940160}, 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/rsqmqq/', u'node_type_name': u'Machine', u'hostname': u'cmp002', u'storage': 2397998.9401599998, u'testing_status': 2, u'system_id': u'rsqmqq', u'raids': [], u'memory': 32768, u'current_installation_result_id': None, u'default_gateways': {u'ipv4': {u'gateway_ip': None, u'link_id': None}, u'ipv6': {u'gateway_ip': None, u'link_id': None}}, u'status_message': u"From 'Testing' to 'Ready'", u'disable_ipv4': False, u'blockdevice_set': [{u'model': u'UCSB-MRAID12G', u'block_size': 4096, u'available_size': 0, u'uuid': None, u'name': u'sda', u'tags': [u'rotary'], u'system_id': u'rsqmqq', u'type': u'physical', u'used_for': u'GPT partitioned with 1 partition', u'resource_uri': u'/MAAS/api/2.0/nodes/rsqmqq/blockdevices/1/', u'partition_table_type': u'GPT', u'filesystem': None, u'id_path': u'/dev/disk/by-id/wwn-0x618e728372755980239b15112698bc66', u'path': u'/dev/disk/by-dname/sda', u'serial': u'618e728372755980239b15112698bc66', u'partitions': [{u'uuid': u'114805b1-6c37-4a44-a226-1b1dbd972f04', u'resource_uri': u'/MAAS/api/2.0/nodes/rsqmqq/blockdevices/1/partition/10', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'rsqmqq', u'filesystem': {u'mount_options': None, u'mount_point': None, u'uuid': u'854fb8a1-6a32-407c-af50-2fb90eb45871', u'fstype': u'lvm-pv', u'label': None}, u'path': u'/dev/disk/by-dname/sda-part2', u'size': 2397992648704, u'type': u'partition', u'id': 10, u'device_id': 1}], u'used_size': 2397998940160, u'id': 1, u'size': 2397998940160}, {u'model': None, u'block_size': 4096, u'available_size': 0, u'uuid': u'efe453cf-3fad-4be3-aeb4-7a5c645e6898', u'name': u'vgroot-lvroot', u'tags': [], u'system_id': u'rsqmqq', u'type': u'virtual', u'used_for': u'ext4 formatted filesystem mounted at /', u'resource_uri': u'/MAAS/api/2.0/nodes/rsqmqq/blockdevices/15/', u'partition_table_type': None, u'filesystem': {u'mount_options': None, u'mount_point': u'/', u'uuid': u'31a21fd3-7293-44d4-be96-4a15eda6520b', u'fstype': u'ext4', u'label': u'root'}, u'id_path': None, u'path': u'/dev/disk/by-dname/lvroot', u'serial': None, u'partitions': [], u'used_size': 107374182400, u'id': 15, u'size': 107374182400}], u'status': 4, u'bcaches': [], u'storage_test_status_name': u'Passed', u'power_state': u'on', u'power_type': u'ipmi', u'physicalblockdevice_set': [{u'model': u'UCSB-MRAID12G', u'block_size': 4096, u'available_size': 0, u'name': u'sda', u'tags': [u'rotary'], u'type': u'physical', u'id': 1, u'uuid': None, u'used_for': u'GPT partitioned with 1 partition', u'system_id': u'rsqmqq', u'partition_table_type': u'GPT', u'filesystem': None, u'id_path': u'/dev/disk/by-id/wwn-0x618e728372755980239b15112698bc66', u'path': u'/dev/disk/by-dname/sda', u'serial': u'618e728372755980239b15112698bc66', u'partitions': [{u'uuid': u'114805b1-6c37-4a44-a226-1b1dbd972f04', u'resource_uri': u'/MAAS/api/2.0/nodes/rsqmqq/blockdevices/1/partition/10', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'rsqmqq', u'filesystem': {u'mount_options': None, u'mount_point': None, u'uuid': u'854fb8a1-6a32-407c-af50-2fb90eb45871', u'fstype': u'lvm-pv', u'label': None}, u'path': u'/dev/disk/by-dname/sda-part2', u'size': 2397992648704, u'type': u'partition', u'id': 10, u'device_id': 1}], u'used_size': 2397998940160, u'resource_uri': u'/MAAS/api/2.0/nodes/rsqmqq/blockdevices/1/', u'size': 2397998940160}], u'other_test_status_name': u'Unknown', u'volume_groups': [{u'__incomplete__': True, u'system_id': u'rsqmqq', u'id': 10}], u'special_filesystems': [], u'cpu_test_status_name': u'Unknown', u'commissioning_status_name': u'Passed', u'interface_set': [{u'name': u'enp6s0', 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': 2, u'dhcp_on': True, u'name': u'untagged', u'primary_rack': u'mnf6hm', u'relay_vlan': None, u'external_dhcp': None, u'mtu': 1500, u'id': 5003, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/'}, u'allow_proxy': True, u'rdns_mode': 2, u'gateway_ip': u'192.168.11.3', u'active_discovery': False, u'cidr': u'192.168.11.0/24', u'id': 3, u'resource_uri': u'/MAAS/api/2.0/subnets/3/'}, u'ip_address': u'192.168.11.42', u'mode': u'dhcp', u'id': 39}], u'tags': [], u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'fabric_id': 2, u'dhcp_on': True, u'name': u'untagged', u'primary_rack': u'mnf6hm', u'relay_vlan': None, u'external_dhcp': None, u'mtu': 1500, u'id': 5003, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/'}, u'enabled': True, u'id': 4, u'discovered': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'fabric_id': 2, u'dhcp_on': True, u'name': u'untagged', u'primary_rack': u'mnf6hm', u'relay_vlan': None, u'external_dhcp': None, u'mtu': 1500, u'id': 5003, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/'}, u'allow_proxy': True, u'rdns_mode': 2, u'gateway_ip': u'192.168.11.3', u'active_discovery': False, u'cidr': u'192.168.11.0/24', u'id': 3, u'resource_uri': u'/MAAS/api/2.0/subnets/3/'}, u'ip_address': u'192.168.11.42'}], u'mac_address': u'00:25:b5:a0:00:6a', u'system_id': u'rsqmqq', u'params': u'', u'effective_mtu': 1500, u'parents': [], u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/rsqmqq/interfaces/4/'}, {u'name': u'enp7s0', u'links': [{u'mode': u'link_up', u'id': 42}], u'tags': [], u'vlan': {u'fabric': u'fabric-0', u'vid': 0, u'space': u'undefined', u'fabric_id': 0, u'dhcp_on': False, u'name': u'untagged', u'primary_rack': None, u'relay_vlan': None, u'external_dhcp': None, u'mtu': 1500, u'id': 5001, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/'}, u'enabled': True, u'id': 9, u'discovered': None, u'mac_address': u'00:25:b5:a0:00:6b', u'system_id': u'rsqmqq', u'params': u'', u'effective_mtu': 1500, u'parents': [], u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/rsqmqq/interfaces/9/'}, {u'name': u'enp8s0', u'links': [{u'mode': u'link_up', u'id': 47}], u'tags': [], u'vlan': {u'fabric': u'fabric-0', u'vid': 0, u'space': u'undefined', u'fabric_id': 0, u'dhcp_on': False, u'name': u'untagged', u'primary_rack': None, u'relay_vlan': None, u'external_dhcp': None, u'mtu': 1500, u'id': 5001, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/'}, u'enabled': True, u'id': 13, u'discovered': None, u'mac_address': u'00:25:b5:a0:00:6c', u'system_id': u'rsqmqq', u'params': u'', u'effective_mtu': 1500, u'parents': [], u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/rsqmqq/interfaces/13/'}, {u'name': u'enp9s0', u'links': [{u'mode': u'link_up', u'id': 52}], u'tags': [], u'vlan': {u'fabric': u'fabric-0', u'vid': 0, u'space': u'undefined', u'fabric_id': 0, u'dhcp_on': False, u'name': u'untagged', u'primary_rack': None, u'relay_vlan': None, u'external_dhcp': None, u'mtu': 1500, u'id': 5001, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/'}, u'enabled': True, u'id': 14, u'discovered': None, u'mac_address': u'00:25:b5:a0:00:6d', u'system_id': u'rsqmqq', u'params': u'', u'effective_mtu': 1500, u'parents': [], u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/rsqmqq/interfaces/14/'}], u'current_testing_result_id': 3, u'cpu_test_status': -1, u'architecture': u'amd64/generic', u'storage_test_status': 2, u'status_name': u'Ready', u'netboot': True, u'osystem': u'', u'fqdn': u'cmp002.maas', u'node_type': 0, u'virtualblockdevice_set': [{u'model': None, u'block_size': 4096, u'available_size': 0, u'name': u'vgroot-lvroot', u'tags': [], u'type': u'virtual', u'id': 15, u'uuid': u'efe453cf-3fad-4be3-aeb4-7a5c645e6898', u'used_for': u'ext4 formatted filesystem mounted at /', u'system_id': u'rsqmqq', u'partition_table_type': None, u'filesystem': {u'mount_options': None, u'mount_point': u'/', u'uuid': u'31a21fd3-7293-44d4-be96-4a15eda6520b', u'fstype': u'ext4', u'label': u'root'}, u'id_path': None, u'path': u'/dev/disk/by-dname/vgroot-lvroot', u'serial': None, u'partitions': [], u'used_size': 107374182400, u'resource_uri': u'/MAAS/api/2.0/nodes/rsqmqq/blockdevices/15/', u'size': 107374182400}], u'commissioning_status': 2, u'min_hwe_kernel': u'hwe-16.04', u'boot_interface': {u'name': u'enp6s0', 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': 2, u'dhcp_on': True, u'name': u'untagged', u'primary_rack': u'mnf6hm', u'relay_vlan': None, u'external_dhcp': None, u'mtu': 1500, u'id': 5003, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/'}, u'allow_proxy': True, u'rdns_mode': 2, u'gateway_ip': u'192.168.11.3', u'active_discovery': False, u'cidr': u'192.168.11.0/24', u'id': 3, u'resource_uri': u'/MAAS/api/2.0/subnets/3/'}, u'ip_address': u'192.168.11.42', u'mode': u'dhcp', u'id': 39}], u'tags': [], u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'fabric_id': 2, u'dhcp_on': True, u'name': u'untagged', u'primary_rack': u'mnf6hm', u'relay_vlan': None, u'external_dhcp': None, u'mtu': 1500, u'id': 5003, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/'}, u'enabled': True, u'id': 4, u'discovered': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'fabric_id': 2, u'dhcp_on': True, u'name': u'untagged', u'primary_rack': u'mnf6hm', u'relay_vlan': None, u'external_dhcp': None, u'mtu': 1500, u'id': 5003, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/'}, u'allow_proxy': True, u'rdns_mode': 2, u'gateway_ip': u'192.168.11.3', u'active_discovery': False, u'cidr': u'192.168.11.0/24', u'id': 3, u'resource_uri': u'/MAAS/api/2.0/subnets/3/'}, u'ip_address': u'192.168.11.42'}], u'mac_address': u'00:25:b5:a0:00:6a', u'system_id': u'rsqmqq', u'params': u'', u'effective_mtu': 1500, u'parents': [], u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/rsqmqq/interfaces/4/'}, u'current_commissioning_result_id': 2, u'address_ttl': None, u'other_test_status': -1, u'distro_series': u'', u'memory_test_status': -1}
2019-08-20 06:24:19,014 [salt.state       :300 ][INFO    ][31894] {'new': {'storage_layout': 'lvm'}}
2019-08-20 06:24:19,014 [salt.state       :1951][INFO    ][31894] Completed state [maas_machines_storage_cmp002_lvm] at time 06:24:19.014398 duration_in_ms=2587.859
2019-08-20 06:24:19,014 [salt.state       :1780][INFO    ][31894] Running state [maas_machines_storage_cmp001_lvm] at time 06:24:19.014807
2019-08-20 06:24:19,015 [salt.state       :1813][INFO    ][31894] Executing state maasng.disk_layout_present for [maas_machines_storage_cmp001_lvm]
2019-08-20 06:24:20,473 [salt.loaded.ext.module.maasng:610 ][INFO    ][31894] cewsdw
2019-08-20 06:24:20,473 [salt.loaded.ext.module.maasng:626 ][INFO    ][31894] sda
2019-08-20 06:24:21,246 [salt.loaded.ext.module.maasng:361 ][INFO    ][31894] cewsdw
2019-08-20 06:24:21,334 [salt.loaded.ext.module.maasng:367 ][INFO    ][31894] [{u'model': u'UCSB-MRAID12G', u'block_size': 4096, u'name': u'sda', u'tags': [u'rotary'], u'used_size': 2397998940160, u'partitions': [{u'size': 2397992648704, u'uuid': u'f4ce2b6a-65ca-4618-9b77-ee86ad8d6569', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'cewsdw', u'filesystem': {u'mount_options': None, u'label': None, u'mount_point': None, u'uuid': u'5a72cb8e-8449-4dd0-a2e5-c401e32b0cb0', u'fstype': u'lvm-pv'}, u'path': u'/dev/disk/by-dname/sda-part2', u'device_id': 4, u'type': u'partition', u'id': 7, u'resource_uri': u'/MAAS/api/2.0/nodes/cewsdw/blockdevices/4/partition/7'}], u'filesystem': None, u'uuid': None, u'used_for': u'GPT partitioned with 1 partition', u'system_id': u'cewsdw', u'partition_table_type': u'GPT', u'path': u'/dev/disk/by-dname/sda', u'id_path': u'/dev/disk/by-id/wwn-0x618e72837274f1901cc7889705aa1b02', u'available_size': 0, u'serial': u'618e72837274f1901cc7889705aa1b02', u'size': 2397998940160, u'type': u'physical', u'id': 4, u'resource_uri': u'/MAAS/api/2.0/nodes/cewsdw/blockdevices/4/'}, {u'model': None, u'block_size': 4096, u'name': u'vgroot-lvroot', u'tags': [], u'used_size': 2397988454400, u'partitions': [], u'filesystem': {u'mount_options': None, u'label': u'root', u'mount_point': u'/', u'uuid': u'b458c188-c5c2-4a1b-92a3-b82fed790bff', u'fstype': u'ext4'}, u'uuid': u'e5db6101-e9df-473d-bbed-5d6c600ee444', u'used_for': u'ext4 formatted filesystem mounted at /', u'system_id': u'cewsdw', u'partition_table_type': None, u'path': u'/dev/disk/by-dname/lvroot', u'id_path': None, u'available_size': 0, u'serial': None, u'size': 2397988454400, u'type': u'virtual', u'id': 12, u'resource_uri': u'/MAAS/api/2.0/nodes/cewsdw/blockdevices/12/'}]
2019-08-20 06:24:21,334 [salt.loaded.ext.module.maasng:632 ][INFO    ][31894] vgroot
2019-08-20 06:24:21,334 [salt.loaded.ext.module.maasng:635 ][INFO    ][31894] lvroot
2019-08-20 06:24:21,334 [salt.loaded.ext.module.maasng:639 ][INFO    ][31894] 107374182400
2019-08-20 06:24:21,995 [salt.loaded.ext.module.maasng:645 ][INFO    ][31894] {u'domain': {u'resource_record_count': 0, u'name': u'maas', u'authoritative': True, u'ttl': None, u'id': 0, u'resource_uri': u'/MAAS/api/2.0/domains/0/'}, u'testing_status_name': u'Passed', u'memory_test_status': -1, u'ip_addresses': [u'192.168.11.38'], u'storage_test_status_name': u'Passed', u'power_type': u'ipmi', u'hwe_kernel': u'', u'boot_interface': {u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'dhcp_on': True, u'fabric_id': 2, u'mtu': 1500, u'primary_rack': u'mnf6hm', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/', u'id': 5003, u'secondary_rack': None, u'name': u'untagged'}, u'name': u'enp6s0', u'links': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'dhcp_on': True, u'fabric_id': 2, u'mtu': 1500, u'primary_rack': u'mnf6hm', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/', u'id': 5003, u'secondary_rack': None, u'name': u'untagged'}, u'allow_proxy': True, u'rdns_mode': 2, u'gateway_ip': u'192.168.11.3', u'active_discovery': False, u'cidr': u'192.168.11.0/24', u'id': 3, u'resource_uri': u'/MAAS/api/2.0/subnets/3/'}, u'ip_address': u'192.168.11.38', u'mode': u'dhcp', u'id': 40}], u'tags': [], u'mac_address': u'00:25:b5:a0:00:5a', 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'dhcp_on': True, u'fabric_id': 2, u'mtu': 1500, u'primary_rack': u'mnf6hm', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/', u'id': 5003, u'secondary_rack': None, u'name': u'untagged'}, u'allow_proxy': True, u'rdns_mode': 2, u'gateway_ip': u'192.168.11.3', u'active_discovery': False, u'cidr': u'192.168.11.0/24', u'id': 3, u'resource_uri': u'/MAAS/api/2.0/subnets/3/'}, u'ip_address': u'192.168.11.38'}], u'system_id': u'cewsdw', u'params': u'', u'effective_mtu': 1500, u'parents': [], u'type': u'physical', u'id': 5, u'resource_uri': u'/MAAS/api/2.0/nodes/cewsdw/interfaces/5/'}, u'status_action': u'', u'tag_names': [], u'swap_size': None, u'owner': None, u'pod': None, u'cache_sets': [], u'iscsiblockdevice_set': [], u'boot_disk': {u'block_size': 4096, u'available_size': 0, u'name': u'sda', u'tags': [u'rotary'], u'type': u'physical', u'partitions': [{u'size': 2397992648704, u'uuid': u'b5f67321-d85b-4eff-b4be-729ece14e1b6', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'cewsdw', u'filesystem': {u'uuid': u'b44af4f8-2dae-483d-bf52-49a996e30fc7', u'label': None, u'mount_point': None, u'mount_options': None, u'fstype': u'lvm-pv'}, u'path': u'/dev/disk/by-dname/sda-part2', u'resource_uri': u'/MAAS/api/2.0/nodes/cewsdw/blockdevices/4/partition/11', u'type': u'partition', u'id': 11, u'device_id': 4}], u'uuid': None, u'used_for': u'GPT partitioned with 1 partition', u'id_path': u'/dev/disk/by-id/wwn-0x618e72837274f1901cc7889705aa1b02', u'system_id': u'cewsdw', u'partition_table_type': u'GPT', u'filesystem': None, u'id': 4, u'path': u'/dev/disk/by-dname/sda', u'model': u'UCSB-MRAID12G', u'size': 2397998940160, u'used_size': 2397998940160, u'serial': u'618e72837274f1901cc7889705aa1b02', u'resource_uri': u'/MAAS/api/2.0/nodes/cewsdw/blockdevices/4/'}, u'zone': {u'description': u'', u'resource_uri': u'/MAAS/api/2.0/zones/default/', u'name': u'default', u'id': 1}, u'resource_uri': u'/MAAS/api/2.0/machines/cewsdw/', u'current_commissioning_result_id': 4, u'hostname': u'cmp001', u'storage': 2397998.9401599998, u'node_type': 0, u'testing_status': 2, u'system_id': u'cewsdw', u'raids': [], u'memory': 32768, u'current_installation_result_id': None, u'default_gateways': {u'ipv4': {u'gateway_ip': None, u'link_id': None}, u'ipv6': {u'gateway_ip': None, u'link_id': None}}, u'status_message': u'Power state queried: off', u'physicalblockdevice_set': [{u'block_size': 4096, u'available_size': 0, u'name': u'sda', u'tags': [u'rotary'], u'type': u'physical', u'partitions': [{u'size': 2397992648704, u'uuid': u'b5f67321-d85b-4eff-b4be-729ece14e1b6', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'cewsdw', u'filesystem': {u'uuid': u'b44af4f8-2dae-483d-bf52-49a996e30fc7', u'label': None, u'mount_point': None, u'mount_options': None, u'fstype': u'lvm-pv'}, u'path': u'/dev/disk/by-dname/sda-part2', u'resource_uri': u'/MAAS/api/2.0/nodes/cewsdw/blockdevices/4/partition/11', u'type': u'partition', u'id': 11, u'device_id': 4}], u'uuid': None, u'used_for': u'GPT partitioned with 1 partition', u'id_path': u'/dev/disk/by-id/wwn-0x618e72837274f1901cc7889705aa1b02', u'system_id': u'cewsdw', u'partition_table_type': u'GPT', u'filesystem': None, u'id': 4, u'path': u'/dev/disk/by-dname/sda', u'model': u'UCSB-MRAID12G', u'size': 2397998940160, u'used_size': 2397998940160, u'serial': u'618e72837274f1901cc7889705aa1b02', u'resource_uri': u'/MAAS/api/2.0/nodes/cewsdw/blockdevices/4/'}], u'blockdevice_set': [{u'size': 2397998940160, u'block_size': 4096, u'available_size': 0, u'name': u'sda', u'tags': [u'rotary'], u'used_size': 2397998940160, u'uuid': None, u'used_for': u'GPT partitioned with 1 partition', u'system_id': u'cewsdw', u'partition_table_type': u'GPT', u'filesystem': None, u'id_path': u'/dev/disk/by-id/wwn-0x618e72837274f1901cc7889705aa1b02', u'path': u'/dev/disk/by-dname/sda', u'model': u'UCSB-MRAID12G', u'partitions': [{u'size': 2397992648704, u'uuid': u'b5f67321-d85b-4eff-b4be-729ece14e1b6', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'cewsdw', u'filesystem': {u'uuid': u'b44af4f8-2dae-483d-bf52-49a996e30fc7', u'label': None, u'mount_point': None, u'mount_options': None, u'fstype': u'lvm-pv'}, u'path': u'/dev/disk/by-dname/sda-part2', u'resource_uri': u'/MAAS/api/2.0/nodes/cewsdw/blockdevices/4/partition/11', u'type': u'partition', u'id': 11, u'device_id': 4}], u'type': u'physical', u'id': 4, u'serial': u'618e72837274f1901cc7889705aa1b02', u'resource_uri': u'/MAAS/api/2.0/nodes/cewsdw/blockdevices/4/'}, {u'size': 107374182400, u'block_size': 4096, u'available_size': 0, u'name': u'vgroot-lvroot', u'tags': [], u'used_size': 107374182400, u'uuid': u'ffab5cf7-c9d8-490f-8742-a753e521e2b3', u'used_for': u'ext4 formatted filesystem mounted at /', u'system_id': u'cewsdw', u'partition_table_type': None, u'filesystem': {u'uuid': u'98c3f904-78c9-4b46-bdc0-3ed51a0c9cd6', u'label': u'root', 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'model': None, u'partitions': [], u'type': u'virtual', u'id': 16, u'serial': None, u'resource_uri': u'/MAAS/api/2.0/nodes/cewsdw/blockdevices/16/'}], u'status': 4, u'bcaches': [], u'cpu_count': 16, u'power_state': u'off', u'owner_data': {}, u'memory_test_status_name': u'Unknown', u'other_test_status_name': u'Unknown', u'volume_groups': [{u'__incomplete__': True, u'system_id': u'cewsdw', u'id': 11}], u'special_filesystems': [], u'cpu_test_status_name': u'Unknown', u'commissioning_status_name': u'Passed', u'current_testing_result_id': 5, u'cpu_test_status': -1, u'architecture': u'amd64/generic', u'storage_test_status': 2, u'status_name': u'Ready', u'netboot': True, u'osystem': u'', u'fqdn': u'cmp001.maas', u'disable_ipv4': False, u'virtualblockdevice_set': [{u'block_size': 4096, u'available_size': 0, u'name': u'vgroot-lvroot', u'tags': [], u'type': u'virtual', u'partitions': [], u'uuid': u'ffab5cf7-c9d8-490f-8742-a753e521e2b3', u'used_for': u'ext4 formatted filesystem mounted at /', u'id_path': None, u'system_id': u'cewsdw', u'partition_table_type': None, u'filesystem': {u'uuid': u'98c3f904-78c9-4b46-bdc0-3ed51a0c9cd6', u'label': u'root', u'mount_point': u'/', u'mount_options': None, u'fstype': u'ext4'}, u'id': 16, u'path': u'/dev/disk/by-dname/vgroot-lvroot', u'model': None, u'size': 107374182400, u'used_size': 107374182400, u'serial': None, u'resource_uri': u'/MAAS/api/2.0/nodes/cewsdw/blockdevices/16/'}], u'commissioning_status': 2, u'min_hwe_kernel': u'hwe-16.04', u'interface_set': [{u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'dhcp_on': True, u'fabric_id': 2, u'mtu': 1500, u'primary_rack': u'mnf6hm', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/', u'id': 5003, u'secondary_rack': None, u'name': u'untagged'}, u'name': u'enp6s0', u'links': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'fabric': u'pxe_admin', u'vid': 0, u'space': u'undefined', u'dhcp_on': True, u'fabric_id': 2, u'mtu': 1500, u'primary_rack': u'mnf6hm', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/', u'id': 5003, u'secondary_rack': None, u'name': u'untagged'}, u'allow_proxy': True, u'rdns_mode': 2, u'gateway_ip': u'192.168.11.3', u'active_discovery': False, u'cidr': u'192.168.11.0/24', u'id': 3, u'resource_uri': u'/MAAS/api/2.0/subnets/3/'}, u'ip_address': u'192.168.11.38', u'mode': u'dhcp', u'id': 40}], u'tags': [], u'mac_address': u'00:25:b5:a0:00:5a', 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'dhcp_on': True, u'fabric_id': 2, u'mtu': 1500, u'primary_rack': u'mnf6hm', u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/', u'id': 5003, u'secondary_rack': None, u'name': u'untagged'}, u'allow_proxy': True, u'rdns_mode': 2, u'gateway_ip': u'192.168.11.3', u'active_discovery': False, u'cidr': u'192.168.11.0/24', u'id': 3, u'resource_uri': u'/MAAS/api/2.0/subnets/3/'}, u'ip_address': u'192.168.11.38'}], u'system_id': u'cewsdw', u'params': u'', u'effective_mtu': 1500, u'parents': [], u'type': u'physical', u'id': 5, u'resource_uri': u'/MAAS/api/2.0/nodes/cewsdw/interfaces/5/'}, {u'vlan': {u'fabric': u'fabric-0', u'vid': 0, u'space': u'undefined', u'dhcp_on': False, u'fabric_id': 0, u'mtu': 1500, u'primary_rack': None, u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/', u'id': 5001, u'secondary_rack': None, u'name': u'untagged'}, u'name': u'enp7s0', u'links': [{u'mode': u'link_up', u'id': 41}], u'tags': [], u'mac_address': u'00:25:b5:a0:00:5b', u'enabled': True, u'children': [], u'discovered': None, u'system_id': u'cewsdw', u'params': u'', u'effective_mtu': 1500, u'parents': [], u'type': u'physical', u'id': 10, u'resource_uri': u'/MAAS/api/2.0/nodes/cewsdw/interfaces/10/'}, {u'vlan': {u'fabric': u'fabric-0', u'vid': 0, u'space': u'undefined', u'dhcp_on': False, u'fabric_id': 0, u'mtu': 1500, u'primary_rack': None, u'relay_vlan': None, u'external_dhcp': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/', u'id': 5001, u'secondary_rack': None, u'name': u'untagged'}, u'name': u'enp9s0', u'links': [{u'mode': u'link_up', u'id': 46}], u'tags': [], u'mac_address': u'00:25:b5:a0:00:5d', u'enabled': True, u'children': [], u'discovered': None, u'system_id': u'cewsdw', u'params': u'', u'effective_mtu': 1500, u'parents': [], u'type': u'physical', u'id': 11, u'resource_uri': u'/MAAS/api/2.0/nodes/cewsdw/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'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'name': u'enp8s0', u'links': [{u'mode': u'link_up', u'id': 51}], u'tags': [], u'mac_address': u'00:25:b5:a0:00:5c', u'enabled': True, u'children': [], u'discovered': None, u'system_id': u'cewsdw', u'params': u'', u'effective_mtu': 1500, u'parents': [], u'type': u'physical', u'id': 12, u'resource_uri': u'/MAAS/api/2.0/nodes/cewsdw/interfaces/12/'}], u'address_ttl': None, u'other_test_status': -1, u'distro_series': u'', u'node_type_name': u'Machine'}
2019-08-20 06:24:21,997 [salt.state       :300 ][INFO    ][31894] {'new': {'storage_layout': 'lvm'}}
2019-08-20 06:24:21,997 [salt.state       :1951][INFO    ][31894] Completed state [maas_machines_storage_cmp001_lvm] at time 06:24:21.997814 duration_in_ms=2983.005
2019-08-20 06:24:22,001 [salt.minion      :1711][INFO    ][31894] Returning information for job: 20190820062411134268
2019-08-20 06:24:22,639 [salt.minion      :1308][INFO    ][29668] User sudo_ubuntu Executing command state.apply with jid 20190820062422626254
2019-08-20 06:24:22,662 [salt.minion      :1432][INFO    ][32007] Starting a new job with PID 32007
2019-08-20 06:24:23,449 [salt.state       :915 ][INFO    ][32007] Loading fresh modules for state activity
2019-08-20 06:24:23,491 [salt.fileclient  :1219][INFO    ][32007] Fetching file from saltenv 'base', ** done ** 'maas/machines/deploy.sls'
2019-08-20 06:24:23,530 [salt.state       :1780][INFO    ][32007] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 06:24:23.530010
2019-08-20 06:24:23,530 [salt.state       :1813][INFO    ][32007] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2019-08-20 06:24:23,532 [salt.loaded.int.module.cmdmod:395 ][INFO    ][32007] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2019-08-20 06:24:25,016 [salt.state       :300 ][INFO    ][32007] {'pid': 32014, 'retcode': 0, 'stderr': '', 'stdout': ''}
2019-08-20 06:24:25,017 [salt.state       :1951][INFO    ][32007] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 06:24:25.017744 duration_in_ms=1487.733
2019-08-20 06:24:25,020 [salt.state       :1780][INFO    ][32007] Running state [maas.deploy_machines] at time 06:24:25.020419
2019-08-20 06:24:25,021 [salt.state       :1813][INFO    ][32007] Executing state module.run for [maas.deploy_machines]
2019-08-20 06:24:25,022 [salt.utils.decorators:613 ][WARNING ][32007] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-08-20 06:24:25,780 [salt.loaded.ext.module.maas:684 ][INFO    ][32007] deploymachines hwe_kernel=hwe-16.04 system_id=rsqmqq distro_series=xenial
2019-08-20 06:24:28,503 [salt.loaded.ext.module.maas:684 ][INFO    ][32007] deploymachines hwe_kernel=hwe-16.04 system_id=cewsdw distro_series=xenial
2019-08-20 06:24:31,001 [salt.loaded.ext.module.maas:684 ][INFO    ][32007] deploymachines hwe_kernel=hwe-16.04 system_id=rdgw8b distro_series=xenial
2019-08-20 06:24:33,523 [salt.loaded.ext.module.maas:684 ][INFO    ][32007] deploymachines hwe_kernel=hwe-16.04 system_id=t7w847 distro_series=xenial
2019-08-20 06:24:35,935 [salt.loaded.ext.module.maas:684 ][INFO    ][32007] deploymachines hwe_kernel=hwe-16.04 system_id=tctq8c distro_series=xenial
2019-08-20 06:24:37,726 [salt.minion      :1308][INFO    ][29668] User sudo_ubuntu Executing command saltutil.find_job with jid 20190820062437714344
2019-08-20 06:24:37,748 [salt.minion      :1432][INFO    ][32269] Starting a new job with PID 32269
2019-08-20 06:24:37,770 [salt.minion      :1711][INFO    ][32269] Returning information for job: 20190820062437714344
2019-08-20 06:24:38,643 [salt.state       :300 ][INFO    ][32007] {'ret': {'updated': [], 'errors': {}, 'success': ['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']}}
2019-08-20 06:24:38,644 [salt.state       :1951][INFO    ][32007] Completed state [maas.deploy_machines] at time 06:24:38.644100 duration_in_ms=13623.679
2019-08-20 06:24:38,648 [salt.minion      :1711][INFO    ][32007] Returning information for job: 20190820062422626254
2019-08-20 06:24:39,250 [salt.minion      :1308][INFO    ][29668] User sudo_ubuntu Executing command state.apply with jid 20190820062439240991
2019-08-20 06:24:39,270 [salt.minion      :1432][INFO    ][32285] Starting a new job with PID 32285
2019-08-20 06:24:42,847 [salt.state       :915 ][INFO    ][32285] Loading fresh modules for state activity
2019-08-20 06:24:42,888 [salt.fileclient  :1219][INFO    ][32285] Fetching file from saltenv 'base', ** done ** 'maas/machines/wait_for_deployed.sls'
2019-08-20 06:24:42,924 [salt.state       :1780][INFO    ][32285] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 06:24:42.924609
2019-08-20 06:24:42,925 [salt.state       :1813][INFO    ][32285] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2019-08-20 06:24:42,926 [salt.loaded.int.module.cmdmod:395 ][INFO    ][32285] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2019-08-20 06:24:44,325 [salt.state       :300 ][INFO    ][32285] {'pid': 32304, 'retcode': 0, 'stderr': '', 'stdout': ''}
2019-08-20 06:24:44,326 [salt.state       :1951][INFO    ][32285] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 06:24:44.326753 duration_in_ms=1402.142
2019-08-20 06:24:44,330 [salt.state       :1780][INFO    ][32285] Running state [maas.wait_for_machine_status] at time 06:24:44.330129
2019-08-20 06:24:44,330 [salt.state       :1813][INFO    ][32285] Executing state module.run for [maas.wait_for_machine_status]
2019-08-20 06:24:44,331 [salt.utils.decorators:613 ][WARNING ][32285] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-08-20 06:24:47,397 [salt.loaded.ext.module.maas:1023][INFO    ][32285] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2246.94393396s left)
2019-08-20 06:24:54,356 [salt.minion      :1308][INFO    ][29668] User sudo_ubuntu Executing command saltutil.find_job with jid 20190820062454342871
2019-08-20 06:24:54,379 [salt.minion      :1432][INFO    ][32316] Starting a new job with PID 32316
2019-08-20 06:24:54,402 [salt.minion      :1711][INFO    ][32316] Returning information for job: 20190820062454342871
2019-08-20 06:25:20,652 [salt.loaded.ext.module.maas:1023][INFO    ][32285] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2213.68941593s left)
2019-08-20 06:25:24,400 [salt.minion      :1308][INFO    ][29668] User sudo_ubuntu Executing command saltutil.find_job with jid 20190820062524387869
2019-08-20 06:25:24,423 [salt.minion      :1432][INFO    ][32446] Starting a new job with PID 32446
2019-08-20 06:25:24,447 [salt.minion      :1711][INFO    ][32446] Returning information for job: 20190820062524387869
2019-08-20 06:25:54,186 [salt.loaded.ext.module.maas:1023][INFO    ][32285] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2180.15546203s left)
2019-08-20 06:25:54,514 [salt.minion      :1308][INFO    ][29668] User sudo_ubuntu Executing command saltutil.find_job with jid 20190820062554501404
2019-08-20 06:25:54,537 [salt.minion      :1432][INFO    ][32464] Starting a new job with PID 32464
2019-08-20 06:25:54,560 [salt.minion      :1711][INFO    ][32464] Returning information for job: 20190820062554501404
2019-08-20 06:26:24,561 [salt.minion      :1308][INFO    ][29668] User sudo_ubuntu Executing command saltutil.find_job with jid 20190820062624549312
2019-08-20 06:26:24,580 [salt.minion      :1432][INFO    ][32597] Starting a new job with PID 32597
2019-08-20 06:26:24,591 [salt.minion      :1711][INFO    ][32597] Returning information for job: 20190820062624549312
2019-08-20 06:26:27,529 [salt.loaded.ext.module.maas:1023][INFO    ][32285] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2146.81262207s left)
2019-08-20 06:26:54,601 [salt.minion      :1308][INFO    ][29668] User sudo_ubuntu Executing command saltutil.find_job with jid 20190820062654588336
2019-08-20 06:26:54,623 [salt.minion      :1432][INFO    ][32761] Starting a new job with PID 32761
2019-08-20 06:26:54,647 [salt.minion      :1711][INFO    ][32761] Returning information for job: 20190820062654588336
2019-08-20 06:27:01,105 [salt.loaded.ext.module.maas:1023][INFO    ][32285] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2113.23648691s left)
2019-08-20 06:27:24,664 [salt.minion      :1308][INFO    ][29668] User sudo_ubuntu Executing command saltutil.find_job with jid 20190820062724652217
2019-08-20 06:27:24,687 [salt.minion      :1432][INFO    ][1104] Starting a new job with PID 1104
2019-08-20 06:27:24,710 [salt.minion      :1711][INFO    ][1104] Returning information for job: 20190820062724652217
2019-08-20 06:27:33,706 [salt.loaded.ext.module.maas:1023][INFO    ][32285] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2080.63485003s left)
2019-08-20 06:27:54,731 [salt.minion      :1308][INFO    ][29668] User sudo_ubuntu Executing command saltutil.find_job with jid 20190820062754718150
2019-08-20 06:27:54,750 [salt.minion      :1432][INFO    ][1125] Starting a new job with PID 1125
2019-08-20 06:27:54,773 [salt.minion      :1711][INFO    ][1125] Returning information for job: 20190820062754718150
2019-08-20 06:28:07,073 [salt.loaded.ext.module.maas:1023][INFO    ][32285] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2047.26799893s left)
2019-08-20 06:28:24,787 [salt.minion      :1308][INFO    ][29668] User sudo_ubuntu Executing command saltutil.find_job with jid 20190820062824774880
2019-08-20 06:28:24,810 [salt.minion      :1432][INFO    ][1268] Starting a new job with PID 1268
2019-08-20 06:28:24,835 [salt.minion      :1711][INFO    ][1268] Returning information for job: 20190820062824774880
2019-08-20 06:28:40,801 [salt.loaded.ext.module.maas:1023][INFO    ][32285] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2013.53992701s left)
2019-08-20 06:28:54,852 [salt.minion      :1308][INFO    ][29668] User sudo_ubuntu Executing command saltutil.find_job with jid 20190820062854839515
2019-08-20 06:28:54,875 [salt.minion      :1432][INFO    ][1298] Starting a new job with PID 1298
2019-08-20 06:28:54,900 [salt.minion      :1711][INFO    ][1298] Returning information for job: 20190820062854839515
2019-08-20 06:29:14,090 [salt.loaded.ext.module.maas:1023][INFO    ][32285] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1980.25087905s left)
2019-08-20 06:29:24,926 [salt.minion      :1308][INFO    ][29668] User sudo_ubuntu Executing command saltutil.find_job with jid 20190820062924913329
2019-08-20 06:29:24,949 [salt.minion      :1432][INFO    ][1777] Starting a new job with PID 1777
2019-08-20 06:29:24,973 [salt.minion      :1711][INFO    ][1777] Returning information for job: 20190820062924913329
2019-08-20 06:29:47,434 [salt.loaded.ext.module.maas:1023][INFO    ][32285] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1946.90713811s left)
2019-08-20 06:29:54,998 [salt.minion      :1308][INFO    ][29668] User sudo_ubuntu Executing command saltutil.find_job with jid 20190820062954985605
2019-08-20 06:29:55,021 [salt.minion      :1432][INFO    ][1800] Starting a new job with PID 1800
2019-08-20 06:29:55,046 [salt.minion      :1711][INFO    ][1800] Returning information for job: 20190820062954985605
2019-08-20 06:30:20,018 [salt.loaded.ext.module.maas:1023][INFO    ][32285] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1914.3231709s left)
2019-08-20 06:30:25,074 [salt.minion      :1308][INFO    ][29668] User sudo_ubuntu Executing command saltutil.find_job with jid 20190820063025061607
2019-08-20 06:30:25,097 [salt.minion      :1432][INFO    ][2304] Starting a new job with PID 2304
2019-08-20 06:30:25,121 [salt.minion      :1711][INFO    ][2304] Returning information for job: 20190820063025061607
2019-08-20 06:30:53,760 [salt.loaded.ext.module.maas:1023][INFO    ][32285] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1880.58160996s left)
2019-08-20 06:30:55,156 [salt.minion      :1308][INFO    ][29668] User sudo_ubuntu Executing command saltutil.find_job with jid 20190820063055143137
2019-08-20 06:30:55,179 [salt.minion      :1432][INFO    ][2324] Starting a new job with PID 2324
2019-08-20 06:30:55,203 [salt.minion      :1711][INFO    ][2324] Returning information for job: 20190820063055143137
2019-08-20 06:31:25,246 [salt.minion      :1308][INFO    ][29668] User sudo_ubuntu Executing command saltutil.find_job with jid 20190820063125234095
2019-08-20 06:31:25,269 [salt.minion      :1432][INFO    ][2436] Starting a new job with PID 2436
2019-08-20 06:31:25,292 [salt.minion      :1711][INFO    ][2436] Returning information for job: 20190820063125234095
2019-08-20 06:31:27,495 [salt.loaded.ext.module.maas:1023][INFO    ][32285] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1846.84566903s left)
2019-08-20 06:31:55,339 [salt.minion      :1308][INFO    ][29668] User sudo_ubuntu Executing command saltutil.find_job with jid 20190820063155323942
2019-08-20 06:31:55,362 [salt.minion      :1432][INFO    ][2454] Starting a new job with PID 2454
2019-08-20 06:31:55,385 [salt.minion      :1711][INFO    ][2454] Returning information for job: 20190820063155323942
2019-08-20 06:32:01,137 [salt.loaded.ext.module.maas:1023][INFO    ][32285] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1813.20434594s left)
2019-08-20 06:32:25,471 [salt.minion      :1308][INFO    ][29668] User sudo_ubuntu Executing command saltutil.find_job with jid 20190820063225459449
2019-08-20 06:32:25,495 [salt.minion      :1432][INFO    ][2766] Starting a new job with PID 2766
2019-08-20 06:32:25,519 [salt.minion      :1711][INFO    ][2766] Returning information for job: 20190820063225459449
2019-08-20 06:32:34,595 [salt.state       :300 ][INFO    ][32285] {'ret': True}
2019-08-20 06:32:34,596 [salt.state       :1951][INFO    ][32285] Completed state [maas.wait_for_machine_status] at time 06:32:34.596385 duration_in_ms=470266.254
2019-08-20 06:32:34,601 [salt.minion      :1711][INFO    ][32285] Returning information for job: 20190820062439240991
2019-08-20 07:19:36,586 [salt.utils.schedule:1377][INFO    ][29668] Running scheduled job: __mine_interval
2019-08-20 08:04:58,556 [salt.minion      :1308][INFO    ][29668] User sudo_ubuntu Executing command cp.push_dir with jid 20190820080458544720
2019-08-20 08:04:58,580 [salt.minion      :1432][INFO    ][9618] Starting a new job with PID 9618
