2017-09-18 02:38:06,824 [salt.cli.daemons ][WARNING ][2512] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-09-18 03:19:41,317 [salt.state       ][ERROR   ][3869] No contents found in top file
2017-09-18 03:19:59,184 [salt.utils.parsers][WARNING ][2512] Minion received a SIGTERM. Exiting.
2017-09-18 03:22:12,236 [salt.cli.daemons ][WARNING ][3320] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-09-18 03:25:43,264 [py.warnings      ][WARNING ][16429] /usr/lib/python2.7/dist-packages/salt/utils/templates.py:73: DeprecationWarning: Starting in 2015.5, cmd.run uses python_shell=False by default, which doesn't support shellisms (pipes, env variables, etc). cmd.run is currently aliased to cmd.shell to prevent breakage. Please switch to cmd.shell or set python_shell=True to avoid breakage in the future, when this aliasing is removed.

2017-09-18 03:26:41,379 [salt.loaded.int.module.cmdmod][ERROR   ][16429] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-18 03:26:41,379 [salt.loaded.int.module.cmdmod][ERROR   ][16429] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-18 03:26:48,368 [salt.loaded.int.module.cmdmod][ERROR   ][16429] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-18 03:26:48,368 [salt.loaded.int.module.cmdmod][ERROR   ][16429] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-18 03:26:57,459 [salt.loaded.int.module.cmdmod][ERROR   ][16429] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-18 03:26:57,459 [salt.loaded.int.module.cmdmod][ERROR   ][16429] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-18 03:27:07,858 [salt.loaded.int.module.cmdmod][ERROR   ][16429] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-18 03:27:07,858 [salt.loaded.int.module.cmdmod][ERROR   ][16429] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-18 03:27:17,167 [salt.loaded.int.module.cmdmod][ERROR   ][16429] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-18 03:27:17,167 [salt.loaded.int.module.cmdmod][ERROR   ][16429] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-18 03:27:23,497 [salt.loaded.int.module.cmdmod][ERROR   ][16429] Command 'while true; do salt-call saltutil.running|grep fun: && continue; salt-call --local service.restart salt-minion; break; done' failed with return code: None
2017-09-18 03:27:25,626 [salt.loaded.int.module.cmdmod][INFO    ][24031] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-09-18 03:27:25,633 [salt.loaded.int.module.cmdmod][INFO    ][24031] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-09-18 03:27:25,642 [salt.loaded.int.module.cmdmod][INFO    ][24031] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2017-09-18 03:27:25,650 [salt.utils.parsers][WARNING ][3320] Minion received a SIGTERM. Exiting.
2017-09-18 03:27:25,899 [salt.cli.daemons ][INFO    ][24106] Setting up the Salt Minion "kvm01.baremetal-mcp-ocata-odl-ha.local"
2017-09-18 03:27:26,403 [salt.minion      ][INFO    ][24106] Creating minion process manager
2017-09-18 03:27:26,404 [salt.cli.daemons ][WARNING ][24106] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-09-18 03:27:26,404 [salt.cli.daemons ][INFO    ][24106] The Salt Minion is starting up
2017-09-18 03:27:26,404 [salt.minion      ][INFO    ][24106] Minion is starting as user 'root'
2017-09-18 03:27:26,405 [salt.utils.event ][INFO    ][24106] Starting pull socket on /var/run/salt/minion/minion_event_127643860a_pull.ipc
2017-09-18 03:27:27,175 [salt.loaded.int.module.cmdmod][INFO    ][24106] Executing command ['date', '+%z'] in directory '/root'
2017-09-18 03:27:27,182 [salt.utils.schedule][INFO    ][24106] Updating job settings for scheduled job: __mine_interval
2017-09-18 03:27:27,184 [salt.minion      ][INFO    ][24106] Added mine.update to scheduler
2017-09-18 03:27:27,330 [salt.minion      ][INFO    ][24106] Minion is ready to receive requests!
2017-09-18 03:27:27,331 [salt.minion      ][INFO    ][24106] User sudo_ubuntu Executing command saltutil.sync_all with jid 20170918032727271861
2017-09-18 03:27:27,343 [salt.minion      ][INFO    ][24195] Starting a new job with PID 24195
2017-09-18 03:27:28,332 [salt.utils.schedule][INFO    ][24106] Running scheduled job: __mine_interval
2017-09-18 03:27:29,835 [salt.state       ][INFO    ][24195] Loading fresh modules for state activity
2017-09-18 03:27:29,854 [salt.state       ][ERROR   ][24195] No contents found in top file
2017-09-18 03:27:29,855 [salt.utils.extmods][INFO    ][24195] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-09-18 03:27:29,858 [salt.utils.extmods][INFO    ][24195] Syncing beacons for environment 'base'
2017-09-18 03:27:29,858 [salt.utils.extmods][INFO    ][24195] Loading cache from salt://_beacons, for base)
2017-09-18 03:27:29,858 [salt.fileclient  ][INFO    ][24195] Caching directory '_beacons/' for environment 'base'
2017-09-18 03:27:29,879 [salt.utils.extmods][INFO    ][24195] Syncing modules for environment 'base'
2017-09-18 03:27:29,879 [salt.utils.extmods][INFO    ][24195] Loading cache from salt://_modules, for base)
2017-09-18 03:27:29,879 [salt.fileclient  ][INFO    ][24195] Caching directory '_modules/' for environment 'base'
2017-09-18 03:27:29,980 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-09-18 03:27:30,136 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-09-18 03:27:30,234 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-09-18 03:27:30,348 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-09-18 03:27:30,450 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-09-18 03:27:30,486 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-09-18 03:27:30,533 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-09-18 03:27:30,571 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-09-18 03:27:30,652 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-09-18 03:27:30,695 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-09-18 03:27:30,748 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-09-18 03:27:30,785 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-09-18 03:27:30,844 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-09-18 03:27:30,874 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-09-18 03:27:30,941 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-09-18 03:27:31,001 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-09-18 03:27:31,049 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-09-18 03:27:31,188 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-09-18 03:27:31,280 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-09-18 03:27:31,292 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-09-18 03:27:31,338 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-09-18 03:27:31,351 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-09-18 03:27:31,379 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-09-18 03:27:31,391 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-09-18 03:27:31,416 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-09-18 03:27:31,465 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-09-18 03:27:31,495 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-09-18 03:27:31,523 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-09-18 03:27:31,541 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-09-18 03:27:31,573 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-09-18 03:27:31,599 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-09-18 03:27:31,621 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-09-18 03:27:31,624 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-09-18 03:27:31,624 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-09-18 03:27:31,625 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-09-18 03:27:31,632 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-09-18 03:27:31,645 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-09-18 03:27:31,652 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-09-18 03:27:31,693 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-09-18 03:27:31,726 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-09-18 03:27:31,755 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-09-18 03:27:31,756 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-09-18 03:27:31,756 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-09-18 03:27:31,756 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-09-18 03:27:31,757 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-09-18 03:27:31,757 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-09-18 03:27:31,758 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-09-18 03:27:31,758 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-09-18 03:27:31,758 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-09-18 03:27:31,759 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-09-18 03:27:31,759 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-09-18 03:27:31,760 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-09-18 03:27:31,760 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-09-18 03:27:31,771 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-09-18 03:27:31,778 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-09-18 03:27:31,779 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-09-18 03:27:31,779 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-09-18 03:27:31,779 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-09-18 03:27:31,780 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-09-18 03:27:31,780 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-09-18 03:27:31,781 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-09-18 03:27:31,781 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-09-18 03:27:31,781 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-09-18 03:27:31,782 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_modules/testing/django_client_proxy.py' to '/var/cache/salt/minion/extmods/modules/testing/django_client_proxy.py'
2017-09-18 03:27:31,782 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-09-18 03:27:31,783 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-09-18 03:27:31,790 [salt.utils.extmods][INFO    ][24195] Syncing states for environment 'base'
2017-09-18 03:27:31,791 [salt.utils.extmods][INFO    ][24195] Loading cache from salt://_states, for base)
2017-09-18 03:27:31,791 [salt.fileclient  ][INFO    ][24195] Caching directory '_states/' for environment 'base'
2017-09-18 03:27:31,847 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-09-18 03:27:31,896 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-09-18 03:27:31,943 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-09-18 03:27:31,955 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-09-18 03:27:31,971 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-09-18 03:27:31,985 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-09-18 03:27:32,003 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-09-18 03:27:32,046 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-09-18 03:27:32,181 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-09-18 03:27:32,221 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-09-18 03:27:32,254 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-09-18 03:27:32,300 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-09-18 03:27:32,347 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-09-18 03:27:32,405 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-09-18 03:27:32,449 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-09-18 03:27:32,467 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-09-18 03:27:32,485 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-09-18 03:27:32,515 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-09-18 03:27:32,544 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-09-18 03:27:32,587 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-09-18 03:27:32,641 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-09-18 03:27:32,679 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-09-18 03:27:32,746 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-09-18 03:27:32,790 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-09-18 03:27:32,809 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-09-18 03:27:32,822 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-09-18 03:27:32,924 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-09-18 03:27:33,030 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-09-18 03:27:33,137 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-09-18 03:27:33,140 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-09-18 03:27:33,140 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-09-18 03:27:33,141 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-09-18 03:27:33,141 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-09-18 03:27:33,141 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-09-18 03:27:33,141 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-09-18 03:27:33,142 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-09-18 03:27:33,142 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-09-18 03:27:33,142 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-09-18 03:27:33,142 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-09-18 03:27:33,143 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-09-18 03:27:33,143 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-09-18 03:27:33,143 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-09-18 03:27:33,143 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-09-18 03:27:33,144 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-09-18 03:27:33,144 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-09-18 03:27:33,144 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-09-18 03:27:33,144 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-09-18 03:27:33,145 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-09-18 03:27:33,145 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-09-18 03:27:33,145 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-09-18 03:27:33,145 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-09-18 03:27:33,146 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-09-18 03:27:33,146 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-09-18 03:27:33,146 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-09-18 03:27:33,147 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-09-18 03:27:33,147 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-09-18 03:27:33,147 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-09-18 03:27:33,147 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-09-18 03:27:33,148 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-09-18 03:27:33,150 [salt.utils.extmods][INFO    ][24195] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-09-18 03:27:33,153 [salt.utils.extmods][INFO    ][24195] Syncing sdb for environment 'base'
2017-09-18 03:27:33,153 [salt.utils.extmods][INFO    ][24195] Loading cache from salt://_sdb, for base)
2017-09-18 03:27:33,153 [salt.fileclient  ][INFO    ][24195] Caching directory '_sdb/' for environment 'base'
2017-09-18 03:27:33,181 [salt.utils.extmods][INFO    ][24195] Syncing grains for environment 'base'
2017-09-18 03:27:33,182 [salt.utils.extmods][INFO    ][24195] Loading cache from salt://_grains, for base)
2017-09-18 03:27:33,182 [salt.fileclient  ][INFO    ][24195] Caching directory '_grains/' for environment 'base'
2017-09-18 03:27:33,235 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-09-18 03:27:33,282 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-09-18 03:27:33,385 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-09-18 03:27:33,444 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-09-18 03:27:33,517 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-09-18 03:27:33,565 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-09-18 03:27:33,650 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-09-18 03:27:33,709 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-09-18 03:27:33,744 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-09-18 03:27:33,850 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-09-18 03:27:33,953 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-09-18 03:27:33,956 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-09-18 03:27:34,044 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-09-18 03:27:34,054 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-09-18 03:27:34,054 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-09-18 03:27:34,055 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-09-18 03:27:34,055 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-09-18 03:27:34,056 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-09-18 03:27:34,056 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-09-18 03:27:34,057 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-09-18 03:27:34,057 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-09-18 03:27:34,058 [salt.utils.extmods][INFO    ][24195] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-09-18 03:27:34,060 [salt.utils.extmods][INFO    ][24195] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-09-18 03:27:34,063 [salt.utils.extmods][INFO    ][24195] Syncing renderers for environment 'base'
2017-09-18 03:27:34,063 [salt.utils.extmods][INFO    ][24195] Loading cache from salt://_renderers, for base)
2017-09-18 03:27:34,063 [salt.fileclient  ][INFO    ][24195] Caching directory '_renderers/' for environment 'base'
2017-09-18 03:27:34,092 [salt.utils.extmods][INFO    ][24195] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-09-18 03:27:34,094 [salt.utils.extmods][INFO    ][24195] Syncing returners for environment 'base'
2017-09-18 03:27:34,094 [salt.utils.extmods][INFO    ][24195] Loading cache from salt://_returners, for base)
2017-09-18 03:27:34,094 [salt.fileclient  ][INFO    ][24195] Caching directory '_returners/' for environment 'base'
2017-09-18 03:27:34,192 [salt.utils.extmods][INFO    ][24195] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-09-18 03:27:34,195 [salt.utils.extmods][INFO    ][24195] Syncing output for environment 'base'
2017-09-18 03:27:34,195 [salt.utils.extmods][INFO    ][24195] Loading cache from salt://_output, for base)
2017-09-18 03:27:34,195 [salt.fileclient  ][INFO    ][24195] Caching directory '_output/' for environment 'base'
2017-09-18 03:27:34,233 [salt.utils.extmods][INFO    ][24195] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-09-18 03:27:34,235 [salt.utils.extmods][INFO    ][24195] Syncing utils for environment 'base'
2017-09-18 03:27:34,235 [salt.utils.extmods][INFO    ][24195] Loading cache from salt://_utils, for base)
2017-09-18 03:27:34,235 [salt.fileclient  ][INFO    ][24195] Caching directory '_utils/' for environment 'base'
2017-09-18 03:27:34,271 [salt.utils.extmods][INFO    ][24195] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-09-18 03:27:34,274 [salt.utils.extmods][INFO    ][24195] Syncing log_handlers for environment 'base'
2017-09-18 03:27:34,274 [salt.utils.extmods][INFO    ][24195] Loading cache from salt://_log_handlers, for base)
2017-09-18 03:27:34,274 [salt.fileclient  ][INFO    ][24195] Caching directory '_log_handlers/' for environment 'base'
2017-09-18 03:27:34,297 [salt.utils.extmods][INFO    ][24195] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-09-18 03:27:34,300 [salt.utils.extmods][INFO    ][24195] Syncing proxy for environment 'base'
2017-09-18 03:27:34,300 [salt.utils.extmods][INFO    ][24195] Loading cache from salt://_proxy, for base)
2017-09-18 03:27:34,300 [salt.fileclient  ][INFO    ][24195] Caching directory '_proxy/' for environment 'base'
2017-09-18 03:27:34,332 [salt.utils.extmods][INFO    ][24195] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-09-18 03:27:34,334 [salt.utils.extmods][INFO    ][24195] Syncing engines for environment 'base'
2017-09-18 03:27:34,335 [salt.utils.extmods][INFO    ][24195] Loading cache from salt://_engines, for base)
2017-09-18 03:27:34,335 [salt.fileclient  ][INFO    ][24195] Caching directory '_engines/' for environment 'base'
2017-09-18 03:27:34,363 [salt.minion      ][INFO    ][24195] Returning information for job: 20170918032727271861
2017-09-18 03:27:36,139 [salt.minion      ][INFO    ][24106] User sudo_ubuntu Executing command state.sls with jid 20170918032736136565
2017-09-18 03:27:36,155 [salt.minion      ][INFO    ][24302] Starting a new job with PID 24302
2017-09-18 03:27:36,540 [salt.state       ][INFO    ][24302] Loading fresh modules for state activity
2017-09-18 03:27:36,677 [salt.fileclient  ][INFO    ][24302] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-09-18 03:27:36,697 [salt.fileclient  ][INFO    ][24302] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-09-18 03:27:36,831 [salt.fileclient  ][INFO    ][24302] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-18 03:27:36,904 [salt.fileclient  ][INFO    ][24302] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-09-18 03:27:36,921 [salt.fileclient  ][INFO    ][24302] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-09-18 03:27:36,956 [salt.fileclient  ][INFO    ][24302] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-18 03:27:37,063 [salt.fileclient  ][INFO    ][24302] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-09-18 03:27:37,185 [salt.fileclient  ][INFO    ][24302] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-18 03:27:37,227 [salt.fileclient  ][INFO    ][24302] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-09-18 03:27:37,246 [salt.fileclient  ][INFO    ][24302] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-09-18 03:27:37,259 [salt.fileclient  ][INFO    ][24302] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-09-18 03:27:37,276 [salt.fileclient  ][INFO    ][24302] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-09-18 03:27:37,284 [salt.loaded.int.module.cmdmod][INFO    ][24302] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-09-18 03:27:37,305 [salt.fileclient  ][INFO    ][24302] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-09-18 03:27:37,320 [py.warnings      ][WARNING ][24302] /usr/lib/python2.7/dist-packages/salt/utils/templates.py:73: DeprecationWarning: Starting in 2015.5, cmd.run uses python_shell=False by default, which doesn't support shellisms (pipes, env variables, etc). cmd.run is currently aliased to cmd.shell to prevent breakage. Please switch to cmd.shell or set python_shell=True to avoid breakage in the future, when this aliasing is removed.

2017-09-18 03:27:37,320 [salt.loaded.int.module.cmdmod][INFO    ][24302] Executing command 'salt-minion --version' in directory '/root'
2017-09-18 03:27:37,568 [salt.fileclient  ][INFO    ][24302] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-09-18 03:27:37,585 [salt.fileclient  ][INFO    ][24302] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-09-18 03:27:37,596 [salt.fileclient  ][INFO    ][24302] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-09-18 03:27:37,608 [salt.fileclient  ][INFO    ][24302] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-09-18 03:27:37,651 [salt.fileclient  ][INFO    ][24302] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-09-18 03:27:37,682 [salt.fileclient  ][INFO    ][24302] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-09-18 03:27:37,796 [salt.fileclient  ][INFO    ][24302] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-09-18 03:27:37,815 [salt.fileclient  ][INFO    ][24302] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-18 03:27:37,865 [salt.fileclient  ][INFO    ][24302] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-09-18 03:27:37,883 [salt.fileclient  ][INFO    ][24302] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-18 03:27:37,922 [salt.fileclient  ][INFO    ][24302] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-09-18 03:27:37,939 [salt.fileclient  ][INFO    ][24302] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-09-18 03:27:37,953 [salt.fileclient  ][INFO    ][24302] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-09-18 03:27:37,970 [salt.fileclient  ][INFO    ][24302] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-09-18 03:27:37,979 [salt.loaded.int.module.cmdmod][INFO    ][24302] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-09-18 03:27:38,001 [salt.fileclient  ][INFO    ][24302] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-09-18 03:27:38,015 [salt.loaded.int.module.cmdmod][INFO    ][24302] Executing command 'salt-minion --version' in directory '/root'
2017-09-18 03:27:38,254 [salt.fileclient  ][INFO    ][24302] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-09-18 03:27:38,273 [salt.fileclient  ][INFO    ][24302] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-09-18 03:27:38,284 [salt.fileclient  ][INFO    ][24302] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-09-18 03:27:38,296 [salt.fileclient  ][INFO    ][24302] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-09-18 03:27:38,341 [salt.fileclient  ][INFO    ][24302] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-09-18 03:27:38,433 [salt.fileclient  ][INFO    ][24302] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-09-18 03:27:38,509 [salt.fileclient  ][INFO    ][24302] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-09-18 03:27:38,567 [salt.fileclient  ][INFO    ][24302] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-18 03:27:38,934 [salt.state       ][INFO    ][24302] Running state [salt-minion] at time 03:27:38.934002
2017-09-18 03:27:38,934 [salt.state       ][INFO    ][24302] Executing state pkg.installed for salt-minion
2017-09-18 03:27:38,935 [salt.loaded.int.module.cmdmod][INFO    ][24302] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-18 03:27:39,191 [salt.state       ][INFO    ][24302] Package salt-minion is already installed
2017-09-18 03:27:39,191 [salt.state       ][INFO    ][24302] Completed state [salt-minion] at time 03:27:39.190916 duration_in_ms=256.913
2017-09-18 03:27:39,191 [salt.state       ][INFO    ][24302] Running state [python-yaml] at time 03:27:39.191117
2017-09-18 03:27:39,191 [salt.state       ][INFO    ][24302] Executing state pkg.installed for python-yaml
2017-09-18 03:27:39,194 [salt.state       ][INFO    ][24302] Package python-yaml is already installed
2017-09-18 03:27:39,194 [salt.state       ][INFO    ][24302] Completed state [python-yaml] at time 03:27:39.193997 duration_in_ms=2.88
2017-09-18 03:27:39,194 [salt.state       ][INFO    ][24302] Running state [python-psutil] at time 03:27:39.194138
2017-09-18 03:27:39,194 [salt.state       ][INFO    ][24302] Executing state pkg.installed for python-psutil
2017-09-18 03:27:39,197 [salt.state       ][INFO    ][24302] Package python-psutil is already installed
2017-09-18 03:27:39,197 [salt.state       ][INFO    ][24302] Completed state [python-psutil] at time 03:27:39.196877 duration_in_ms=2.739
2017-09-18 03:27:39,197 [salt.state       ][INFO    ][24302] Running state [python-m2crypto] at time 03:27:39.197022
2017-09-18 03:27:39,197 [salt.state       ][INFO    ][24302] Executing state pkg.installed for python-m2crypto
2017-09-18 03:27:39,200 [salt.state       ][INFO    ][24302] Package python-m2crypto is already installed
2017-09-18 03:27:39,200 [salt.state       ][INFO    ][24302] Completed state [python-m2crypto] at time 03:27:39.199795 duration_in_ms=2.773
2017-09-18 03:27:39,201 [salt.state       ][INFO    ][24302] Running state [/etc/salt/minion.d/minion.conf] at time 03:27:39.201275
2017-09-18 03:27:39,201 [salt.state       ][INFO    ][24302] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-09-18 03:27:39,300 [salt.fileclient  ][INFO    ][24302] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-09-18 03:27:39,346 [salt.fileclient  ][INFO    ][24302] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-18 03:27:39,388 [salt.fileclient  ][INFO    ][24302] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-18 03:27:39,417 [salt.state       ][INFO    ][24302] File /etc/salt/minion.d/minion.conf is in the correct state
2017-09-18 03:27:39,417 [salt.state       ][INFO    ][24302] Completed state [/etc/salt/minion.d/minion.conf] at time 03:27:39.417341 duration_in_ms=216.066
2017-09-18 03:27:39,418 [salt.state       ][INFO    ][24302] Running state [/etc/salt/minion.d/_virt.conf] at time 03:27:39.417668
2017-09-18 03:27:39,418 [salt.state       ][INFO    ][24302] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-09-18 03:27:39,472 [salt.state       ][INFO    ][24302] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-09-18 03:27:39,472 [salt.state       ][INFO    ][24302] Completed state [/etc/salt/minion.d/_virt.conf] at time 03:27:39.472235 duration_in_ms=54.566
2017-09-18 03:27:39,474 [salt.state       ][INFO    ][24302] Running state [salt-minion] at time 03:27:39.473547
2017-09-18 03:27:39,474 [salt.state       ][INFO    ][24302] Executing state service.running for salt-minion
2017-09-18 03:27:39,474 [salt.loaded.int.module.cmdmod][INFO    ][24302] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-09-18 03:27:39,487 [salt.loaded.int.module.cmdmod][INFO    ][24302] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-09-18 03:27:39,492 [salt.loaded.int.module.cmdmod][INFO    ][24302] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-09-18 03:27:39,498 [salt.state       ][INFO    ][24302] The service salt-minion is already running
2017-09-18 03:27:39,498 [salt.state       ][INFO    ][24302] Completed state [salt-minion] at time 03:27:39.497907 duration_in_ms=24.36
2017-09-18 03:27:39,499 [salt.state       ][INFO    ][24302] Running state [/etc/salt/grains.d] at time 03:27:39.498923
2017-09-18 03:27:39,499 [salt.state       ][INFO    ][24302] Executing state file.directory for /etc/salt/grains.d
2017-09-18 03:27:39,500 [salt.state       ][INFO    ][24302] Directory /etc/salt/grains.d is in the correct state
2017-09-18 03:27:39,500 [salt.state       ][INFO    ][24302] Completed state [/etc/salt/grains.d] at time 03:27:39.499754 duration_in_ms=0.832
2017-09-18 03:27:39,500 [salt.state       ][INFO    ][24302] Running state [/etc/salt/grains] at time 03:27:39.500188
2017-09-18 03:27:39,500 [salt.state       ][INFO    ][24302] Executing state file.managed for /etc/salt/grains
2017-09-18 03:27:39,501 [salt.state       ][INFO    ][24302] File /etc/salt/grains exists with proper permissions. No changes made.
2017-09-18 03:27:39,501 [salt.state       ][INFO    ][24302] Completed state [/etc/salt/grains] at time 03:27:39.500784 duration_in_ms=0.596
2017-09-18 03:27:39,501 [salt.state       ][INFO    ][24302] Running state [/etc/salt/grains.d/placeholder] at time 03:27:39.501063
2017-09-18 03:27:39,501 [salt.state       ][INFO    ][24302] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-09-18 03:27:39,502 [salt.state       ][INFO    ][24302] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-09-18 03:27:39,502 [salt.state       ][INFO    ][24302] Completed state [/etc/salt/grains.d/placeholder] at time 03:27:39.501692 duration_in_ms=0.629
2017-09-18 03:27:39,502 [salt.state       ][INFO    ][24302] Running state [/etc/salt/grains.d/sphinx] at time 03:27:39.501973
2017-09-18 03:27:39,502 [salt.state       ][INFO    ][24302] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-09-18 03:27:39,573 [salt.state       ][INFO    ][24302] File /etc/salt/grains.d/sphinx is in the correct state
2017-09-18 03:27:39,573 [salt.state       ][INFO    ][24302] Completed state [/etc/salt/grains.d/sphinx] at time 03:27:39.572811 duration_in_ms=70.838
2017-09-18 03:27:39,573 [salt.state       ][INFO    ][24302] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 03:27:39.573262
2017-09-18 03:27:39,573 [salt.state       ][INFO    ][24302] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-09-18 03:27:39,574 [salt.state       ][INFO    ][24302] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-09-18 03:27:39,574 [salt.state       ][INFO    ][24302] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 03:27:39.573910 duration_in_ms=0.648
2017-09-18 03:27:39,574 [salt.state       ][INFO    ][24302] Running state [/etc/salt/grains.d/dns_records] at time 03:27:39.574211
2017-09-18 03:27:39,574 [salt.state       ][INFO    ][24302] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-09-18 03:27:39,626 [salt.state       ][INFO    ][24302] File /etc/salt/grains.d/dns_records is in the correct state
2017-09-18 03:27:39,627 [salt.state       ][INFO    ][24302] Completed state [/etc/salt/grains.d/dns_records] at time 03:27:39.626604 duration_in_ms=52.392
2017-09-18 03:27:39,627 [salt.state       ][INFO    ][24302] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 03:27:39.627156
2017-09-18 03:27:39,627 [salt.state       ][INFO    ][24302] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-09-18 03:27:39,628 [salt.state       ][INFO    ][24302] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-09-18 03:27:39,628 [salt.state       ][INFO    ][24302] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 03:27:39.627651 duration_in_ms=0.495
2017-09-18 03:27:39,628 [salt.state       ][INFO    ][24302] Running state [/etc/salt/grains.d/salt] at time 03:27:39.627908
2017-09-18 03:27:39,628 [salt.state       ][INFO    ][24302] Executing state file.managed for /etc/salt/grains.d/salt
2017-09-18 03:27:39,646 [salt.state       ][INFO    ][24302] File /etc/salt/grains.d/salt is in the correct state
2017-09-18 03:27:39,646 [salt.state       ][INFO    ][24302] Completed state [/etc/salt/grains.d/salt] at time 03:27:39.645747 duration_in_ms=17.838
2017-09-18 03:27:39,646 [salt.state       ][INFO    ][24302] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 03:27:39.646193
2017-09-18 03:27:39,646 [salt.state       ][INFO    ][24302] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-09-18 03:27:39,647 [salt.state       ][INFO    ][24302] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-09-18 03:27:39,647 [salt.state       ][INFO    ][24302] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 03:27:39.646656 duration_in_ms=0.463
2017-09-18 03:27:39,648 [salt.state       ][INFO    ][24302] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 03:27:39.647796
2017-09-18 03:27:39,648 [salt.state       ][INFO    ][24302] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-09-18 03:27:39,648 [salt.state       ][INFO    ][24302] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-09-18 03:27:39,648 [salt.state       ][INFO    ][24302] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 03:27:39.648258 duration_in_ms=0.462
2017-09-18 03:27:39,649 [salt.state       ][INFO    ][24302] Running state [mine.update] at time 03:27:39.648648
2017-09-18 03:27:39,649 [salt.state       ][INFO    ][24302] Executing state module.wait for mine.update
2017-09-18 03:27:39,649 [salt.state       ][INFO    ][24302] No changes made for mine.update
2017-09-18 03:27:39,649 [salt.state       ][INFO    ][24302] Completed state [mine.update] at time 03:27:39.649076 duration_in_ms=0.428
2017-09-18 03:27:39,649 [salt.state       ][INFO    ][24302] Running state [ca-certificates] at time 03:27:39.649217
2017-09-18 03:27:39,649 [salt.state       ][INFO    ][24302] Executing state pkg.installed for ca-certificates
2017-09-18 03:27:39,652 [salt.state       ][INFO    ][24302] Package ca-certificates is already installed
2017-09-18 03:27:39,652 [salt.state       ][INFO    ][24302] Completed state [ca-certificates] at time 03:27:39.652350 duration_in_ms=3.133
2017-09-18 03:27:39,653 [salt.state       ][INFO    ][24302] Running state [update-ca-certificates] at time 03:27:39.652756
2017-09-18 03:27:39,653 [salt.state       ][INFO    ][24302] Executing state cmd.wait for update-ca-certificates
2017-09-18 03:27:39,653 [salt.state       ][INFO    ][24302] No changes made for update-ca-certificates
2017-09-18 03:27:39,653 [salt.state       ][INFO    ][24302] Completed state [update-ca-certificates] at time 03:27:39.653195 duration_in_ms=0.439
2017-09-18 03:27:39,653 [salt.state       ][INFO    ][24302] Running state [libvirt-dev] at time 03:27:39.653328
2017-09-18 03:27:39,653 [salt.state       ][INFO    ][24302] Executing state pkg.installed for libvirt-dev
2017-09-18 03:27:39,656 [salt.state       ][INFO    ][24302] Package libvirt-dev is already installed
2017-09-18 03:27:39,656 [salt.state       ][INFO    ][24302] Completed state [libvirt-dev] at time 03:27:39.656123 duration_in_ms=2.795
2017-09-18 03:27:39,656 [salt.state       ][INFO    ][24302] Running state [pkg-config] at time 03:27:39.656259
2017-09-18 03:27:39,656 [salt.state       ][INFO    ][24302] Executing state pkg.installed for pkg-config
2017-09-18 03:27:39,659 [salt.state       ][INFO    ][24302] Package pkg-config is already installed
2017-09-18 03:27:39,659 [salt.state       ][INFO    ][24302] Completed state [pkg-config] at time 03:27:39.659070 duration_in_ms=2.81
2017-09-18 03:27:39,659 [salt.state       ][INFO    ][24302] Running state [virtng.init] at time 03:27:39.659207
2017-09-18 03:27:39,659 [salt.state       ][INFO    ][24302] Executing state module.run for virtng.init
2017-09-18 03:27:39,723 [salt.loaded.int.module.cmdmod][INFO    ][24302] Executing command ['git', '--version'] in directory '/root'
2017-09-18 03:27:39,823 [salt.loaded.int.module.cmdmod][INFO    ][24302] Executing command 'virsh list --all --name| grep -E "^prx01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-18 03:27:39,839 [salt.state       ][INFO    ][24302] unless execution succeeded
2017-09-18 03:27:39,935 [salt.state       ][INFO    ][24302] Completed state [virtng.init] at time 03:27:39.934958 duration_in_ms=275.749
2017-09-18 03:27:39,935 [salt.state       ][INFO    ][24302] Running state [virt.set_autostart] at time 03:27:39.935242
2017-09-18 03:27:39,935 [salt.state       ][INFO    ][24302] Executing state module.run for virt.set_autostart
2017-09-18 03:27:39,937 [salt.loaded.int.module.cmdmod][INFO    ][24302] Executing command 'virsh list --autostart --name| grep -E "^prx01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-18 03:27:39,953 [salt.state       ][INFO    ][24302] unless execution succeeded
2017-09-18 03:27:39,953 [salt.state       ][INFO    ][24302] Completed state [virt.set_autostart] at time 03:27:39.952840 duration_in_ms=17.598
2017-09-18 03:27:39,953 [salt.state       ][INFO    ][24302] Running state [virtng.init] at time 03:27:39.953047
2017-09-18 03:27:39,953 [salt.state       ][INFO    ][24302] Executing state module.run for virtng.init
2017-09-18 03:27:39,955 [salt.loaded.int.module.cmdmod][INFO    ][24302] Executing command 'virsh list --all --name| grep -E "^mdb01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-18 03:27:39,969 [salt.state       ][INFO    ][24302] unless execution succeeded
2017-09-18 03:27:39,969 [salt.state       ][INFO    ][24302] Completed state [virtng.init] at time 03:27:39.969014 duration_in_ms=15.967
2017-09-18 03:27:39,969 [salt.state       ][INFO    ][24302] Running state [virt.set_autostart] at time 03:27:39.969224
2017-09-18 03:27:39,969 [salt.state       ][INFO    ][24302] Executing state module.run for virt.set_autostart
2017-09-18 03:27:39,971 [salt.loaded.int.module.cmdmod][INFO    ][24302] Executing command 'virsh list --autostart --name| grep -E "^mdb01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-18 03:27:39,986 [salt.state       ][INFO    ][24302] unless execution succeeded
2017-09-18 03:27:39,986 [salt.state       ][INFO    ][24302] Completed state [virt.set_autostart] at time 03:27:39.986155 duration_in_ms=16.93
2017-09-18 03:27:39,986 [salt.state       ][INFO    ][24302] Running state [virtng.init] at time 03:27:39.986374
2017-09-18 03:27:39,987 [salt.state       ][INFO    ][24302] Executing state module.run for virtng.init
2017-09-18 03:27:39,988 [salt.loaded.int.module.cmdmod][INFO    ][24302] Executing command 'virsh list --all --name| grep -E "^msg01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-18 03:27:40,002 [salt.state       ][INFO    ][24302] unless execution succeeded
2017-09-18 03:27:40,002 [salt.state       ][INFO    ][24302] Completed state [virtng.init] at time 03:27:40.002299 duration_in_ms=15.924
2017-09-18 03:27:40,003 [salt.state       ][INFO    ][24302] Running state [virt.set_autostart] at time 03:27:40.002504
2017-09-18 03:27:40,003 [salt.state       ][INFO    ][24302] Executing state module.run for virt.set_autostart
2017-09-18 03:27:40,005 [salt.loaded.int.module.cmdmod][INFO    ][24302] Executing command 'virsh list --autostart --name| grep -E "^msg01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-18 03:27:40,019 [salt.state       ][INFO    ][24302] unless execution succeeded
2017-09-18 03:27:40,019 [salt.state       ][INFO    ][24302] Completed state [virt.set_autostart] at time 03:27:40.019296 duration_in_ms=16.792
2017-09-18 03:27:40,020 [salt.state       ][INFO    ][24302] Running state [virtng.init] at time 03:27:40.019499
2017-09-18 03:27:40,020 [salt.state       ][INFO    ][24302] Executing state module.run for virtng.init
2017-09-18 03:27:40,022 [salt.loaded.int.module.cmdmod][INFO    ][24302] Executing command 'virsh list --all --name| grep -E "^dbs01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-18 03:27:40,036 [salt.state       ][INFO    ][24302] unless execution succeeded
2017-09-18 03:27:40,036 [salt.state       ][INFO    ][24302] Completed state [virtng.init] at time 03:27:40.035937 duration_in_ms=16.438
2017-09-18 03:27:40,036 [salt.state       ][INFO    ][24302] Running state [virt.set_autostart] at time 03:27:40.036154
2017-09-18 03:27:40,036 [salt.state       ][INFO    ][24302] Executing state module.run for virt.set_autostart
2017-09-18 03:27:40,038 [salt.loaded.int.module.cmdmod][INFO    ][24302] Executing command 'virsh list --autostart --name| grep -E "^dbs01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-18 03:27:40,050 [salt.state       ][INFO    ][24302] unless execution succeeded
2017-09-18 03:27:40,051 [salt.state       ][INFO    ][24302] Completed state [virt.set_autostart] at time 03:27:40.050625 duration_in_ms=14.469
2017-09-18 03:27:40,051 [salt.state       ][INFO    ][24302] Running state [virtng.init] at time 03:27:40.050908
2017-09-18 03:27:40,051 [salt.state       ][INFO    ][24302] Executing state module.run for virtng.init
2017-09-18 03:27:40,054 [salt.loaded.int.module.cmdmod][INFO    ][24302] Executing command 'virsh list --all --name| grep -E "^ctl01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-18 03:27:40,065 [salt.state       ][INFO    ][24302] unless execution succeeded
2017-09-18 03:27:40,065 [salt.state       ][INFO    ][24302] Completed state [virtng.init] at time 03:27:40.065363 duration_in_ms=14.455
2017-09-18 03:27:40,066 [salt.state       ][INFO    ][24302] Running state [virt.set_autostart] at time 03:27:40.065579
2017-09-18 03:27:40,066 [salt.state       ][INFO    ][24302] Executing state module.run for virt.set_autostart
2017-09-18 03:27:40,068 [salt.loaded.int.module.cmdmod][INFO    ][24302] Executing command 'virsh list --autostart --name| grep -E "^ctl01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-18 03:27:40,080 [salt.state       ][INFO    ][24302] unless execution succeeded
2017-09-18 03:27:40,080 [salt.state       ][INFO    ][24302] Completed state [virt.set_autostart] at time 03:27:40.079918 duration_in_ms=14.339
2017-09-18 03:27:40,082 [salt.minion      ][INFO    ][24302] Returning information for job: 20170918032736136565
2017-09-18 03:27:57,173 [salt.minion      ][INFO    ][24106] User sudo_ubuntu Executing command pillar.get with jid 20170918032757169306
2017-09-18 03:27:57,185 [salt.minion      ][INFO    ][24401] Starting a new job with PID 24401
2017-09-18 03:27:57,275 [salt.minion      ][INFO    ][24401] Returning information for job: 20170918032757169306
2017-09-18 03:28:54,668 [salt.minion      ][INFO    ][24106] User sudo_ubuntu Executing command saltutil.sync_all with jid 20170918032854661492
2017-09-18 03:28:54,687 [salt.minion      ][INFO    ][24418] Starting a new job with PID 24418
2017-09-18 03:28:58,306 [salt.state       ][INFO    ][24418] Loading fresh modules for state activity
2017-09-18 03:28:58,404 [salt.state       ][ERROR   ][24418] No contents found in top file
2017-09-18 03:28:58,405 [salt.utils.extmods][INFO    ][24418] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-09-18 03:28:58,408 [salt.utils.extmods][INFO    ][24418] Syncing beacons for environment 'base'
2017-09-18 03:28:58,408 [salt.utils.extmods][INFO    ][24418] Loading cache from salt://_beacons, for base)
2017-09-18 03:28:58,408 [salt.fileclient  ][INFO    ][24418] Caching directory '_beacons/' for environment 'base'
2017-09-18 03:28:58,468 [salt.utils.extmods][INFO    ][24418] Syncing modules for environment 'base'
2017-09-18 03:28:58,468 [salt.utils.extmods][INFO    ][24418] Loading cache from salt://_modules, for base)
2017-09-18 03:28:58,468 [salt.fileclient  ][INFO    ][24418] Caching directory '_modules/' for environment 'base'
2017-09-18 03:28:58,522 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-09-18 03:28:58,529 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-09-18 03:28:59,203 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-09-18 03:28:59,261 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-09-18 03:28:59,275 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-09-18 03:28:59,285 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-09-18 03:28:59,327 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-09-18 03:28:59,345 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-09-18 03:28:59,441 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-09-18 03:28:59,496 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-09-18 03:28:59,536 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-09-18 03:28:59,543 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-09-18 03:28:59,552 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-09-18 03:28:59,564 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-09-18 03:28:59,583 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-09-18 03:28:59,592 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-09-18 03:28:59,699 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-09-18 03:28:59,709 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-09-18 03:28:59,720 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-09-18 03:28:59,744 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-09-18 03:28:59,758 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-09-18 03:28:59,777 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-09-18 03:28:59,790 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-09-18 03:28:59,943 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-09-18 03:28:59,956 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-09-18 03:29:00,031 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-09-18 03:29:00,114 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-09-18 03:29:00,184 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-09-18 03:29:00,222 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-09-18 03:29:00,244 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-09-18 03:29:00,305 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-09-18 03:29:00,317 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-09-18 03:29:00,319 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-09-18 03:29:00,319 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-09-18 03:29:00,320 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-09-18 03:29:00,320 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-09-18 03:29:00,320 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-09-18 03:29:00,320 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-09-18 03:29:00,321 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-09-18 03:29:00,321 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-09-18 03:29:00,321 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-09-18 03:29:00,321 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-09-18 03:29:00,322 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-09-18 03:29:00,322 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-09-18 03:29:00,322 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-09-18 03:29:00,322 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-09-18 03:29:00,323 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-09-18 03:29:00,323 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-09-18 03:29:00,323 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-09-18 03:29:00,323 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-09-18 03:29:00,324 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-09-18 03:29:00,324 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-09-18 03:29:00,324 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-09-18 03:29:00,324 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-09-18 03:29:00,325 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-09-18 03:29:00,325 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-09-18 03:29:00,325 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-09-18 03:29:00,325 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-09-18 03:29:00,326 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-09-18 03:29:00,326 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-09-18 03:29:00,326 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-09-18 03:29:00,326 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-09-18 03:29:00,326 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-09-18 03:29:00,327 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_modules/testing/django_client_proxy.py' to '/var/cache/salt/minion/extmods/modules/testing/django_client_proxy.py'
2017-09-18 03:29:00,327 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-09-18 03:29:00,327 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-09-18 03:29:00,331 [salt.utils.extmods][INFO    ][24418] Syncing states for environment 'base'
2017-09-18 03:29:00,332 [salt.utils.extmods][INFO    ][24418] Loading cache from salt://_states, for base)
2017-09-18 03:29:00,332 [salt.fileclient  ][INFO    ][24418] Caching directory '_states/' for environment 'base'
2017-09-18 03:29:00,444 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-09-18 03:29:00,458 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-09-18 03:29:00,491 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-09-18 03:29:00,525 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-09-18 03:29:00,539 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-09-18 03:29:00,555 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-09-18 03:29:00,612 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-09-18 03:29:00,626 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-09-18 03:29:00,690 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-09-18 03:29:00,705 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-09-18 03:29:00,725 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-09-18 03:29:00,743 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-09-18 03:29:00,806 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-09-18 03:29:00,818 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-09-18 03:29:00,833 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-09-18 03:29:00,869 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-09-18 03:29:00,907 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-09-18 03:29:01,032 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-09-18 03:29:01,054 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-09-18 03:29:01,137 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-09-18 03:29:01,152 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-09-18 03:29:01,165 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-09-18 03:29:01,185 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-09-18 03:29:01,339 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-09-18 03:29:01,420 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-09-18 03:29:01,435 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-09-18 03:29:01,471 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-09-18 03:29:01,482 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-09-18 03:29:01,552 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-09-18 03:29:01,555 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-09-18 03:29:01,556 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-09-18 03:29:01,556 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-09-18 03:29:01,556 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-09-18 03:29:01,556 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-09-18 03:29:01,557 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-09-18 03:29:01,557 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-09-18 03:29:01,557 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-09-18 03:29:01,557 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-09-18 03:29:01,557 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-09-18 03:29:01,558 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-09-18 03:29:01,558 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-09-18 03:29:01,558 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-09-18 03:29:01,558 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-09-18 03:29:01,558 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-09-18 03:29:01,559 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-09-18 03:29:01,559 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-09-18 03:29:01,559 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-09-18 03:29:01,559 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-09-18 03:29:01,559 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-09-18 03:29:01,560 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-09-18 03:29:01,560 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-09-18 03:29:01,560 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-09-18 03:29:01,560 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-09-18 03:29:01,560 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-09-18 03:29:01,561 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-09-18 03:29:01,561 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-09-18 03:29:01,561 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-09-18 03:29:01,561 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-09-18 03:29:01,562 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-09-18 03:29:01,564 [salt.utils.extmods][INFO    ][24418] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-09-18 03:29:01,566 [salt.utils.extmods][INFO    ][24418] Syncing sdb for environment 'base'
2017-09-18 03:29:01,566 [salt.utils.extmods][INFO    ][24418] Loading cache from salt://_sdb, for base)
2017-09-18 03:29:01,566 [salt.fileclient  ][INFO    ][24418] Caching directory '_sdb/' for environment 'base'
2017-09-18 03:29:01,604 [salt.utils.extmods][INFO    ][24418] Syncing grains for environment 'base'
2017-09-18 03:29:01,604 [salt.utils.extmods][INFO    ][24418] Loading cache from salt://_grains, for base)
2017-09-18 03:29:01,604 [salt.fileclient  ][INFO    ][24418] Caching directory '_grains/' for environment 'base'
2017-09-18 03:29:02,490 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-09-18 03:29:02,507 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-09-18 03:29:02,521 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-09-18 03:29:02,729 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-09-18 03:29:03,849 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-09-18 03:29:03,858 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-09-18 03:29:03,865 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-09-18 03:29:03,874 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-09-18 03:29:03,884 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-09-18 03:29:03,892 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-09-18 03:29:04,326 [salt.fileclient  ][INFO    ][24418] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-09-18 03:29:04,329 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-09-18 03:29:04,329 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-09-18 03:29:04,329 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-09-18 03:29:04,329 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-09-18 03:29:04,330 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-09-18 03:29:04,330 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-09-18 03:29:04,330 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-09-18 03:29:04,330 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-09-18 03:29:04,331 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-09-18 03:29:04,331 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-09-18 03:29:04,331 [salt.utils.extmods][INFO    ][24418] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-09-18 03:29:04,333 [salt.utils.extmods][INFO    ][24418] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-09-18 03:29:04,336 [salt.utils.extmods][INFO    ][24418] Syncing renderers for environment 'base'
2017-09-18 03:29:04,336 [salt.utils.extmods][INFO    ][24418] Loading cache from salt://_renderers, for base)
2017-09-18 03:29:04,336 [salt.fileclient  ][INFO    ][24418] Caching directory '_renderers/' for environment 'base'
2017-09-18 03:29:04,354 [salt.utils.extmods][INFO    ][24418] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-09-18 03:29:04,356 [salt.utils.extmods][INFO    ][24418] Syncing returners for environment 'base'
2017-09-18 03:29:04,356 [salt.utils.extmods][INFO    ][24418] Loading cache from salt://_returners, for base)
2017-09-18 03:29:04,356 [salt.fileclient  ][INFO    ][24418] Caching directory '_returners/' for environment 'base'
2017-09-18 03:29:04,373 [salt.utils.extmods][INFO    ][24418] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-09-18 03:29:04,375 [salt.utils.extmods][INFO    ][24418] Syncing output for environment 'base'
2017-09-18 03:29:04,375 [salt.utils.extmods][INFO    ][24418] Loading cache from salt://_output, for base)
2017-09-18 03:29:04,376 [salt.fileclient  ][INFO    ][24418] Caching directory '_output/' for environment 'base'
2017-09-18 03:29:04,399 [salt.utils.extmods][INFO    ][24418] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-09-18 03:29:04,402 [salt.utils.extmods][INFO    ][24418] Syncing utils for environment 'base'
2017-09-18 03:29:04,402 [salt.utils.extmods][INFO    ][24418] Loading cache from salt://_utils, for base)
2017-09-18 03:29:04,402 [salt.fileclient  ][INFO    ][24418] Caching directory '_utils/' for environment 'base'
2017-09-18 03:29:04,428 [salt.utils.extmods][INFO    ][24418] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-09-18 03:29:04,431 [salt.utils.extmods][INFO    ][24418] Syncing log_handlers for environment 'base'
2017-09-18 03:29:04,431 [salt.utils.extmods][INFO    ][24418] Loading cache from salt://_log_handlers, for base)
2017-09-18 03:29:04,431 [salt.fileclient  ][INFO    ][24418] Caching directory '_log_handlers/' for environment 'base'
2017-09-18 03:29:04,449 [salt.utils.extmods][INFO    ][24418] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-09-18 03:29:04,452 [salt.utils.extmods][INFO    ][24418] Syncing proxy for environment 'base'
2017-09-18 03:29:04,452 [salt.utils.extmods][INFO    ][24418] Loading cache from salt://_proxy, for base)
2017-09-18 03:29:04,452 [salt.fileclient  ][INFO    ][24418] Caching directory '_proxy/' for environment 'base'
2017-09-18 03:29:04,469 [salt.utils.extmods][INFO    ][24418] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-09-18 03:29:04,472 [salt.utils.extmods][INFO    ][24418] Syncing engines for environment 'base'
2017-09-18 03:29:04,472 [salt.utils.extmods][INFO    ][24418] Loading cache from salt://_engines, for base)
2017-09-18 03:29:04,472 [salt.fileclient  ][INFO    ][24418] Caching directory '_engines/' for environment 'base'
2017-09-18 03:29:04,492 [salt.minion      ][INFO    ][24418] Returning information for job: 20170918032854661492
2017-09-18 04:04:51,541 [salt.minion      ][INFO    ][24106] User sudo_ubuntu Executing command test.ping with jid 20170918040451535979
2017-09-18 04:04:51,562 [salt.minion      ][INFO    ][25198] Starting a new job with PID 25198
2017-09-18 04:04:51,588 [salt.minion      ][INFO    ][25198] Returning information for job: 20170918040451535979
2017-09-18 04:05:33,093 [salt.minion      ][INFO    ][24106] User sudo_ubuntu Executing command state.sls with jid 20170918040533084952
2017-09-18 04:05:33,108 [salt.minion      ][INFO    ][25214] Starting a new job with PID 25214
2017-09-18 04:05:33,582 [salt.state       ][INFO    ][25214] Loading fresh modules for state activity
2017-09-18 04:05:33,605 [salt.fileclient  ][INFO    ][25214] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-09-18 04:05:33,622 [salt.fileclient  ][INFO    ][25214] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-09-18 04:05:33,645 [salt.fileclient  ][INFO    ][25214] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-09-18 04:05:33,951 [salt.state       ][INFO    ][25214] Running state [lsof] at time 04:05:33.951385
2017-09-18 04:05:33,952 [salt.state       ][INFO    ][25214] Executing state pkg.installed for lsof
2017-09-18 04:05:33,952 [salt.loaded.int.module.cmdmod][INFO    ][25214] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-18 04:05:34,203 [salt.state       ][INFO    ][25214] Package lsof is already installed
2017-09-18 04:05:34,203 [salt.state       ][INFO    ][25214] Completed state [lsof] at time 04:05:34.202961 duration_in_ms=251.576
2017-09-18 04:05:34,203 [salt.state       ][INFO    ][25214] Running state [keepalived] at time 04:05:34.203154
2017-09-18 04:05:34,203 [salt.state       ][INFO    ][25214] Executing state pkg.installed for keepalived
2017-09-18 04:05:34,218 [salt.loaded.int.module.cmdmod][INFO    ][25214] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-09-18 04:05:38,004 [salt.loaded.int.module.cmdmod][INFO    ][25214] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'keepalived'] in directory '/root'
2017-09-18 04:05:43,141 [salt.minion      ][INFO    ][24106] User sudo_ubuntu Executing command saltutil.find_job with jid 20170918040543130893
2017-09-18 04:05:43,158 [salt.minion      ][INFO    ][26537] Starting a new job with PID 26537
2017-09-18 04:05:43,170 [salt.minion      ][INFO    ][26537] Returning information for job: 20170918040543130893
2017-09-18 04:05:45,525 [salt.loaded.int.module.cmdmod][INFO    ][25214] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-18 04:05:45,548 [salt.state       ][INFO    ][25214] Made the following changes:
'libsnmp30' changed from 'absent' to '5.7.3+dfsg-1ubuntu4'
'libsnmp-base' changed from 'absent' to '5.7.3+dfsg-1ubuntu4'
'keepalived' changed from 'absent' to '1:1.2.19-1ubuntu0.2'
'ipvsadm' changed from 'absent' to '1:1.28-3'
'libsensors4' changed from 'absent' to '1:3.4.0-2'

2017-09-18 04:05:45,556 [salt.state       ][INFO    ][25214] Loading fresh modules for state activity
2017-09-18 04:05:45,568 [salt.state       ][INFO    ][25214] Completed state [keepalived] at time 04:05:45.568036 duration_in_ms=11364.881
2017-09-18 04:05:45,570 [salt.state       ][INFO    ][25214] Running state [/etc/keepalived/keepalived.conf] at time 04:05:45.569780
2017-09-18 04:05:45,570 [salt.state       ][INFO    ][25214] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-09-18 04:05:45,595 [salt.fileclient  ][INFO    ][25214] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-09-18 04:05:45,625 [salt.fileclient  ][INFO    ][25214] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-09-18 04:05:45,631 [salt.state       ][INFO    ][25214] File changed:
New file
2017-09-18 04:05:45,631 [salt.state       ][INFO    ][25214] Completed state [/etc/keepalived/keepalived.conf] at time 04:05:45.631432 duration_in_ms=61.652
2017-09-18 04:05:45,688 [salt.state       ][INFO    ][25214] Running state [keepalived] at time 04:05:45.688042
2017-09-18 04:05:45,688 [salt.state       ][INFO    ][25214] Executing state service.running for keepalived
2017-09-18 04:05:45,690 [salt.loaded.int.module.cmdmod][INFO    ][25214] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-09-18 04:05:45,699 [salt.loaded.int.module.cmdmod][INFO    ][25214] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-09-18 04:05:45,706 [salt.loaded.int.module.cmdmod][INFO    ][25214] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-09-18 04:05:45,712 [salt.loaded.int.module.cmdmod][INFO    ][25214] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-09-18 04:05:45,720 [salt.loaded.int.module.cmdmod][INFO    ][25214] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'keepalived.service'] in directory '/root'
2017-09-18 04:05:45,768 [salt.loaded.int.module.cmdmod][INFO    ][25214] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-09-18 04:05:45,775 [salt.loaded.int.module.cmdmod][INFO    ][25214] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-09-18 04:05:45,781 [salt.loaded.int.module.cmdmod][INFO    ][25214] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-09-18 04:05:45,788 [salt.state       ][INFO    ][25214] {'keepalived': True}
2017-09-18 04:05:45,789 [salt.state       ][INFO    ][25214] Completed state [keepalived] at time 04:05:45.788672 duration_in_ms=100.63
2017-09-18 04:05:45,789 [salt.minion      ][INFO    ][25214] Returning information for job: 20170918040533084952
2017-09-18 04:08:57,026 [salt.minion      ][INFO    ][24106] User sudo_ubuntu Executing command pillar.get with jid 20170918040857018837
2017-09-18 04:08:57,054 [salt.minion      ][INFO    ][26875] Starting a new job with PID 26875
2017-09-18 04:08:57,058 [salt.minion      ][INFO    ][26875] Returning information for job: 20170918040857018837
2017-09-18 04:14:34,585 [salt.minion      ][INFO    ][24106] User sudo_ubuntu Executing command state.sls with jid 20170918041434578750
2017-09-18 04:14:34,601 [salt.minion      ][INFO    ][26980] Starting a new job with PID 26980
2017-09-18 04:14:36,178 [salt.state       ][INFO    ][26980] Loading fresh modules for state activity
2017-09-18 04:14:36,200 [salt.fileclient  ][INFO    ][26980] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-09-18 04:14:36,218 [salt.fileclient  ][INFO    ][26980] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-09-18 04:14:36,489 [salt.state       ][INFO    ][26980] Running state [attr] at time 04:14:36.489109
2017-09-18 04:14:36,489 [salt.state       ][INFO    ][26980] Executing state pkg.installed for attr
2017-09-18 04:14:36,490 [salt.loaded.int.module.cmdmod][INFO    ][26980] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-18 04:14:36,790 [salt.loaded.int.module.cmdmod][INFO    ][26980] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-09-18 04:14:38,791 [salt.loaded.int.module.cmdmod][INFO    ][26980] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'attr'] in directory '/root'
2017-09-18 04:14:41,623 [salt.loaded.int.module.cmdmod][INFO    ][26980] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-18 04:14:41,646 [salt.state       ][INFO    ][26980] Made the following changes:
'attr' changed from 'absent' to '1:2.4.47-2'

2017-09-18 04:14:41,654 [salt.state       ][INFO    ][26980] Loading fresh modules for state activity
2017-09-18 04:14:41,666 [salt.state       ][INFO    ][26980] Completed state [attr] at time 04:14:41.665703 duration_in_ms=5176.593
2017-09-18 04:14:41,671 [salt.state       ][INFO    ][26980] Running state [glusterfs-server] at time 04:14:41.670898
2017-09-18 04:14:41,671 [salt.state       ][INFO    ][26980] Executing state pkg.installed for glusterfs-server
2017-09-18 04:14:41,864 [salt.loaded.int.module.cmdmod][INFO    ][26980] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'glusterfs-server'] in directory '/root'
2017-09-18 04:14:44,682 [salt.minion      ][INFO    ][24106] User sudo_ubuntu Executing command saltutil.find_job with jid 20170918041444672835
2017-09-18 04:14:44,697 [salt.minion      ][INFO    ][28014] Starting a new job with PID 28014
2017-09-18 04:14:44,712 [salt.minion      ][INFO    ][28014] Returning information for job: 20170918041444672835
2017-09-18 04:14:54,887 [salt.minion      ][INFO    ][24106] User sudo_ubuntu Executing command saltutil.find_job with jid 20170918041454877436
2017-09-18 04:14:54,901 [salt.minion      ][INFO    ][30858] Starting a new job with PID 30858
2017-09-18 04:14:54,912 [salt.minion      ][INFO    ][30858] Returning information for job: 20170918041454877436
2017-09-18 04:14:58,635 [salt.loaded.int.module.cmdmod][INFO    ][26980] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-18 04:14:58,658 [salt.state       ][INFO    ][26980] Made the following changes:
'keyutils' changed from 'absent' to '1.5.9-8ubuntu1'
'nfs-common' changed from 'absent' to '1:1.2.8-9ubuntu12.1'
'rpcbind' changed from 'absent' to '0.2.3-0.2'
'glusterfs-common' changed from 'absent' to '3.7.6-1ubuntu1'
'librdmacm1' changed from 'absent' to '1.0.21-1'
'libnfsidmap2' changed from 'absent' to '0.25-5'
'portmap' changed from 'absent' to '1'
'libattr1-dev' changed from 'absent' to '1:2.4.47-2'
'attr-dev' changed from 'absent' to '1'
'acl-dev' changed from 'absent' to '1'
'glusterfs-server' changed from 'absent' to '3.7.6-1ubuntu1'
'glusterfs-client' changed from 'absent' to '3.7.6-1ubuntu1'
'libpython2.7' changed from 'absent' to '2.7.12-1ubuntu0~16.04.1'
'nfs-client' changed from 'absent' to '1'
'liburcu4' changed from 'absent' to '0.9.1-3'
'libacl1-dev' changed from 'absent' to '2.2.52-3'
'libibverbs1' changed from 'absent' to '1.1.8-1.1ubuntu2'
'libtirpc1' changed from 'absent' to '0.2.5-1'

2017-09-18 04:14:58,665 [salt.state       ][INFO    ][26980] Loading fresh modules for state activity
2017-09-18 04:14:58,678 [salt.state       ][INFO    ][26980] Completed state [glusterfs-server] at time 04:14:58.677661 duration_in_ms=17006.761
2017-09-18 04:14:58,683 [salt.state       ][INFO    ][26980] Running state [bc] at time 04:14:58.682627
2017-09-18 04:14:58,683 [salt.state       ][INFO    ][26980] Executing state pkg.installed for bc
2017-09-18 04:14:58,934 [salt.loaded.int.module.cmdmod][INFO    ][26980] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'bc'] in directory '/root'
2017-09-18 04:15:01,719 [salt.loaded.int.module.cmdmod][INFO    ][26980] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-18 04:15:01,744 [salt.state       ][INFO    ][26980] Made the following changes:
'bc' changed from 'absent' to '1.06.95-9build1'

2017-09-18 04:15:01,754 [salt.state       ][INFO    ][26980] Loading fresh modules for state activity
2017-09-18 04:15:01,767 [salt.state       ][INFO    ][26980] Completed state [bc] at time 04:15:01.767116 duration_in_ms=3084.489
2017-09-18 04:15:01,768 [salt.transport.ipc][ERROR   ][24106] Exception occurred while handling stream: [Errno 0] Success
2017-09-18 04:15:01,827 [salt.state       ][INFO    ][26980] Running state [glusterfs-server] at time 04:15:01.827397
2017-09-18 04:15:01,828 [salt.state       ][INFO    ][26980] Executing state service.running for glusterfs-server
2017-09-18 04:15:01,830 [salt.loaded.int.module.cmdmod][INFO    ][26980] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-09-18 04:15:01,839 [salt.loaded.int.module.cmdmod][INFO    ][26980] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-09-18 04:15:01,847 [salt.loaded.int.module.cmdmod][INFO    ][26980] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-09-18 04:15:01,854 [salt.state       ][INFO    ][26980] The service glusterfs-server is already running
2017-09-18 04:15:01,855 [salt.state       ][INFO    ][26980] Completed state [glusterfs-server] at time 04:15:01.854547 duration_in_ms=27.15
2017-09-18 04:15:01,856 [salt.state       ][INFO    ][26980] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 04:15:01.856310
2017-09-18 04:15:01,857 [salt.state       ][INFO    ][26980] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-09-18 04:15:01,872 [salt.state       ][INFO    ][26980] File changed:
New file
2017-09-18 04:15:01,873 [salt.state       ][INFO    ][26980] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 04:15:01.872501 duration_in_ms=16.192
2017-09-18 04:15:01,873 [salt.state       ][INFO    ][26980] Running state [/srv/glusterfs/glance] at time 04:15:01.872702
2017-09-18 04:15:01,873 [salt.state       ][INFO    ][26980] Executing state file.directory for /srv/glusterfs/glance
2017-09-18 04:15:01,874 [salt.state       ][INFO    ][26980] {'/srv/glusterfs/glance': 'New Dir'}
2017-09-18 04:15:01,874 [salt.state       ][INFO    ][26980] Completed state [/srv/glusterfs/glance] at time 04:15:01.873780 duration_in_ms=1.077
2017-09-18 04:15:01,874 [salt.state       ][INFO    ][26980] Running state [/srv/glusterfs/keystone-keys] at time 04:15:01.873959
2017-09-18 04:15:01,874 [salt.state       ][INFO    ][26980] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-09-18 04:15:01,875 [salt.state       ][INFO    ][26980] {'/srv/glusterfs/keystone-keys': 'New Dir'}
2017-09-18 04:15:01,875 [salt.state       ][INFO    ][26980] Completed state [/srv/glusterfs/keystone-keys] at time 04:15:01.874736 duration_in_ms=0.777
2017-09-18 04:15:01,875 [salt.state       ][INFO    ][26980] Running state [/srv/glusterfs/nova_instances] at time 04:15:01.874910
2017-09-18 04:15:01,875 [salt.state       ][INFO    ][26980] Executing state file.directory for /srv/glusterfs/nova_instances
2017-09-18 04:15:01,876 [salt.state       ][INFO    ][26980] {'/srv/glusterfs/nova_instances': 'New Dir'}
2017-09-18 04:15:01,876 [salt.state       ][INFO    ][26980] Completed state [/srv/glusterfs/nova_instances] at time 04:15:01.875661 duration_in_ms=0.75
2017-09-18 04:15:01,876 [salt.state       ][INFO    ][26980] Running state [/srv/glusterfs/keystone-credential-keys] at time 04:15:01.875833
2017-09-18 04:15:01,876 [salt.state       ][INFO    ][26980] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-09-18 04:15:01,876 [salt.state       ][INFO    ][26980] {'/srv/glusterfs/keystone-credential-keys': 'New Dir'}
2017-09-18 04:15:01,877 [salt.state       ][INFO    ][26980] Completed state [/srv/glusterfs/keystone-credential-keys] at time 04:15:01.876604 duration_in_ms=0.771
2017-09-18 04:15:01,877 [salt.minion      ][INFO    ][26980] Returning information for job: 20170918041434578750
2017-09-18 04:15:03,995 [salt.minion      ][INFO    ][24106] User sudo_ubuntu Executing command test.ping with jid 20170918041503988264
2017-09-18 04:15:04,010 [salt.minion      ][INFO    ][31709] Starting a new job with PID 31709
2017-09-18 04:15:04,036 [salt.minion      ][INFO    ][31709] Returning information for job: 20170918041503988264
2017-09-18 04:15:49,825 [salt.minion      ][INFO    ][24106] User sudo_ubuntu Executing command state.sls with jid 20170918041549817086
2017-09-18 04:15:49,841 [salt.minion      ][INFO    ][31939] Starting a new job with PID 31939
2017-09-18 04:15:50,231 [salt.state       ][INFO    ][31939] Loading fresh modules for state activity
2017-09-18 04:15:50,253 [salt.fileclient  ][INFO    ][31939] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-09-18 04:15:50,286 [salt.fileclient  ][INFO    ][31939] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-09-18 04:15:50,348 [salt.fileclient  ][INFO    ][31939] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-09-18 04:15:50,365 [salt.fileclient  ][INFO    ][31939] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-09-18 04:15:50,632 [salt.state       ][INFO    ][31939] Running state [attr] at time 04:15:50.632298
2017-09-18 04:15:50,633 [salt.state       ][INFO    ][31939] Executing state pkg.installed for attr
2017-09-18 04:15:50,633 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-18 04:15:50,914 [salt.state       ][INFO    ][31939] Package attr is already installed
2017-09-18 04:15:50,914 [salt.state       ][INFO    ][31939] Completed state [attr] at time 04:15:50.913895 duration_in_ms=281.598
2017-09-18 04:15:50,914 [salt.state       ][INFO    ][31939] Running state [glusterfs-server] at time 04:15:50.914089
2017-09-18 04:15:50,914 [salt.state       ][INFO    ][31939] Executing state pkg.installed for glusterfs-server
2017-09-18 04:15:50,917 [salt.state       ][INFO    ][31939] Package glusterfs-server is already installed
2017-09-18 04:15:50,917 [salt.state       ][INFO    ][31939] Completed state [glusterfs-server] at time 04:15:50.916915 duration_in_ms=2.826
2017-09-18 04:15:50,917 [salt.state       ][INFO    ][31939] Running state [bc] at time 04:15:50.917055
2017-09-18 04:15:50,917 [salt.state       ][INFO    ][31939] Executing state pkg.installed for bc
2017-09-18 04:15:50,920 [salt.state       ][INFO    ][31939] Package bc is already installed
2017-09-18 04:15:50,920 [salt.state       ][INFO    ][31939] Completed state [bc] at time 04:15:50.920065 duration_in_ms=3.01
2017-09-18 04:15:50,921 [salt.state       ][INFO    ][31939] Running state [glusterfs-server] at time 04:15:50.920838
2017-09-18 04:15:50,921 [salt.state       ][INFO    ][31939] Executing state service.running for glusterfs-server
2017-09-18 04:15:50,921 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-09-18 04:15:50,930 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2017-09-18 04:15:50,974 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-09-18 04:15:50,985 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-09-18 04:15:50,990 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-09-18 04:15:50,999 [salt.state       ][INFO    ][31939] The service glusterfs-server is already running
2017-09-18 04:15:50,999 [salt.state       ][INFO    ][31939] Completed state [glusterfs-server] at time 04:15:50.999006 duration_in_ms=78.168
2017-09-18 04:15:51,000 [salt.state       ][INFO    ][31939] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 04:15:51.000464
2017-09-18 04:15:51,001 [salt.state       ][INFO    ][31939] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-09-18 04:15:51,006 [salt.state       ][INFO    ][31939] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-09-18 04:15:51,006 [salt.state       ][INFO    ][31939] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 04:15:51.005901 duration_in_ms=5.438
2017-09-18 04:15:51,006 [salt.state       ][INFO    ][31939] Running state [/srv/glusterfs/glance] at time 04:15:51.006049
2017-09-18 04:15:51,006 [salt.state       ][INFO    ][31939] Executing state file.directory for /srv/glusterfs/glance
2017-09-18 04:15:51,006 [salt.state       ][INFO    ][31939] Directory /srv/glusterfs/glance is in the correct state
2017-09-18 04:15:51,007 [salt.state       ][INFO    ][31939] Completed state [/srv/glusterfs/glance] at time 04:15:51.006594 duration_in_ms=0.545
2017-09-18 04:15:51,007 [salt.state       ][INFO    ][31939] Running state [/srv/glusterfs/keystone-keys] at time 04:15:51.006727
2017-09-18 04:15:51,007 [salt.state       ][INFO    ][31939] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-09-18 04:15:51,007 [salt.state       ][INFO    ][31939] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-09-18 04:15:51,007 [salt.state       ][INFO    ][31939] Completed state [/srv/glusterfs/keystone-keys] at time 04:15:51.007266 duration_in_ms=0.539
2017-09-18 04:15:51,007 [salt.state       ][INFO    ][31939] Running state [/srv/glusterfs/nova_instances] at time 04:15:51.007400
2017-09-18 04:15:51,008 [salt.state       ][INFO    ][31939] Executing state file.directory for /srv/glusterfs/nova_instances
2017-09-18 04:15:51,008 [salt.state       ][INFO    ][31939] Directory /srv/glusterfs/nova_instances is in the correct state
2017-09-18 04:15:51,008 [salt.state       ][INFO    ][31939] Completed state [/srv/glusterfs/nova_instances] at time 04:15:51.007936 duration_in_ms=0.536
2017-09-18 04:15:51,008 [salt.state       ][INFO    ][31939] Running state [/srv/glusterfs/keystone-credential-keys] at time 04:15:51.008073
2017-09-18 04:15:51,008 [salt.state       ][INFO    ][31939] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-09-18 04:15:51,009 [salt.state       ][INFO    ][31939] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-09-18 04:15:51,009 [salt.state       ][INFO    ][31939] Completed state [/srv/glusterfs/keystone-credential-keys] at time 04:15:51.008604 duration_in_ms=0.53
2017-09-18 04:15:51,058 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command ['git', '--version'] in directory '/root'
2017-09-18 04:15:51,150 [salt.state       ][INFO    ][31939] Running state [sleep 5] at time 04:15:51.149545
2017-09-18 04:15:51,150 [salt.state       ][INFO    ][31939] Executing state cmd.wait for sleep 5
2017-09-18 04:15:51,150 [salt.state       ][INFO    ][31939] No changes made for sleep 5
2017-09-18 04:15:51,150 [salt.state       ][INFO    ][31939] Completed state [sleep 5] at time 04:15:51.150192 duration_in_ms=0.647
2017-09-18 04:15:51,151 [salt.state       ][INFO    ][31939] Running state [10.167.4.141] at time 04:15:51.150603
2017-09-18 04:15:51,151 [salt.state       ][INFO    ][31939] Executing state glusterfs.peered for 10.167.4.141
2017-09-18 04:15:51,151 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command 'gluster --version' in directory '/root'
2017-09-18 04:15:51,160 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 04:15:51,209 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command 'gluster --version' in directory '/root'
2017-09-18 04:15:51,216 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 04:15:51,266 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command 'gluster --version' in directory '/root'
2017-09-18 04:15:51,273 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 04:15:51,320 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command 'gluster --version' in directory '/root'
2017-09-18 04:15:51,327 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 04:15:51,373 [salt.state       ][INFO    ][31939] Peering with localhost is not needed
2017-09-18 04:15:51,373 [salt.state       ][INFO    ][31939] Completed state [10.167.4.141] at time 04:15:51.372908 duration_in_ms=222.305
2017-09-18 04:15:51,375 [salt.state       ][INFO    ][31939] Running state [10.167.4.142] at time 04:15:51.375165
2017-09-18 04:15:51,375 [salt.state       ][INFO    ][31939] Executing state glusterfs.peered for 10.167.4.142
2017-09-18 04:15:51,376 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command 'gluster --version' in directory '/root'
2017-09-18 04:15:51,383 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 04:15:51,429 [salt.state       ][INFO    ][31939] Host 10.167.4.142 already peered
2017-09-18 04:15:51,429 [salt.state       ][INFO    ][31939] Completed state [10.167.4.142] at time 04:15:51.429192 duration_in_ms=54.027
2017-09-18 04:15:51,431 [salt.state       ][INFO    ][31939] Running state [10.167.4.143] at time 04:15:51.431325
2017-09-18 04:15:51,432 [salt.state       ][INFO    ][31939] Executing state glusterfs.peered for 10.167.4.143
2017-09-18 04:15:51,432 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command 'gluster --version' in directory '/root'
2017-09-18 04:15:51,440 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 04:15:51,489 [salt.state       ][INFO    ][31939] Host 10.167.4.143 already peered
2017-09-18 04:15:51,489 [salt.state       ][INFO    ][31939] Completed state [10.167.4.143] at time 04:15:51.489087 duration_in_ms=57.762
2017-09-18 04:15:51,490 [salt.state       ][INFO    ][31939] Running state [glance] at time 04:15:51.489876
2017-09-18 04:15:51,490 [salt.state       ][INFO    ][31939] Executing state glusterfs.created for glance
2017-09-18 04:15:51,490 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command 'gluster --version' in directory '/root'
2017-09-18 04:15:51,498 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 04:15:51,545 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command 'gluster --version' in directory '/root'
2017-09-18 04:15:51,552 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 04:15:51,602 [salt.state       ][INFO    ][31939] Volume glance already exists and is started.
2017-09-18 04:15:51,603 [salt.state       ][INFO    ][31939] Completed state [glance] at time 04:15:51.602523 duration_in_ms=112.647
2017-09-18 04:15:51,605 [salt.state       ][INFO    ][31939] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 04:15:51.605028
2017-09-18 04:15:51,605 [salt.state       ][INFO    ][31939] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-09-18 04:15:51,606 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-09-18 04:15:51,652 [salt.state       ][INFO    ][31939] unless execution succeeded
2017-09-18 04:15:51,652 [salt.state       ][INFO    ][31939] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 04:15:51.652250 duration_in_ms=47.222
2017-09-18 04:15:51,653 [salt.state       ][INFO    ][31939] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 04:15:51.652610
2017-09-18 04:15:51,653 [salt.state       ][INFO    ][31939] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-09-18 04:15:51,653 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-09-18 04:15:51,698 [salt.state       ][INFO    ][31939] unless execution succeeded
2017-09-18 04:15:51,698 [salt.state       ][INFO    ][31939] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 04:15:51.698433 duration_in_ms=45.823
2017-09-18 04:15:51,699 [salt.state       ][INFO    ][31939] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 04:15:51.698799
2017-09-18 04:15:51,699 [salt.state       ][INFO    ][31939] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-09-18 04:15:51,699 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-09-18 04:15:51,746 [salt.state       ][INFO    ][31939] unless execution succeeded
2017-09-18 04:15:51,746 [salt.state       ][INFO    ][31939] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 04:15:51.745806 duration_in_ms=47.005
2017-09-18 04:15:51,746 [salt.state       ][INFO    ][31939] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 04:15:51.746246
2017-09-18 04:15:51,746 [salt.state       ][INFO    ][31939] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-09-18 04:15:51,747 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-09-18 04:15:51,793 [salt.state       ][INFO    ][31939] unless execution succeeded
2017-09-18 04:15:51,794 [salt.state       ][INFO    ][31939] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 04:15:51.793667 duration_in_ms=47.421
2017-09-18 04:15:51,794 [salt.state       ][INFO    ][31939] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 04:15:51.794113
2017-09-18 04:15:51,794 [salt.state       ][INFO    ][31939] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-09-18 04:15:51,795 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-09-18 04:15:51,840 [salt.state       ][INFO    ][31939] unless execution succeeded
2017-09-18 04:15:51,840 [salt.state       ][INFO    ][31939] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 04:15:51.840117 duration_in_ms=46.003
2017-09-18 04:15:51,841 [salt.state       ][INFO    ][31939] Running state [glance] at time 04:15:51.841029
2017-09-18 04:15:51,841 [salt.state       ][INFO    ][31939] Executing state glusterfs.started for glance
2017-09-18 04:15:51,842 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command 'gluster --version' in directory '/root'
2017-09-18 04:15:51,849 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 04:15:51,897 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command 'gluster --version' in directory '/root'
2017-09-18 04:15:51,904 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 04:15:51,953 [salt.state       ][INFO    ][31939] Volume glance is already started
2017-09-18 04:15:51,953 [salt.state       ][INFO    ][31939] Completed state [glance] at time 04:15:51.952842 duration_in_ms=111.812
2017-09-18 04:15:51,954 [salt.state       ][INFO    ][31939] Running state [keystone-keys] at time 04:15:51.953649
2017-09-18 04:15:51,954 [salt.state       ][INFO    ][31939] Executing state glusterfs.created for keystone-keys
2017-09-18 04:15:51,954 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command 'gluster --version' in directory '/root'
2017-09-18 04:15:51,962 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 04:15:52,009 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command 'gluster --version' in directory '/root'
2017-09-18 04:15:52,015 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 04:15:52,066 [salt.state       ][INFO    ][31939] Volume keystone-keys already exists and is started.
2017-09-18 04:15:52,066 [salt.state       ][INFO    ][31939] Completed state [keystone-keys] at time 04:15:52.066197 duration_in_ms=112.547
2017-09-18 04:15:52,069 [salt.state       ][INFO    ][31939] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 04:15:52.068827
2017-09-18 04:15:52,069 [salt.state       ][INFO    ][31939] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-09-18 04:15:52,069 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-09-18 04:15:52,116 [salt.state       ][INFO    ][31939] unless execution succeeded
2017-09-18 04:15:52,116 [salt.state       ][INFO    ][31939] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 04:15:52.116446 duration_in_ms=47.618
2017-09-18 04:15:52,117 [salt.state       ][INFO    ][31939] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 04:15:52.116884
2017-09-18 04:15:52,117 [salt.state       ][INFO    ][31939] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-09-18 04:15:52,118 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-09-18 04:15:52,164 [salt.state       ][INFO    ][31939] unless execution succeeded
2017-09-18 04:15:52,165 [salt.state       ][INFO    ][31939] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 04:15:52.164628 duration_in_ms=47.744
2017-09-18 04:15:52,165 [salt.state       ][INFO    ][31939] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 04:15:52.165038
2017-09-18 04:15:52,165 [salt.state       ][INFO    ][31939] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-09-18 04:15:52,166 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-09-18 04:15:52,212 [salt.state       ][INFO    ][31939] unless execution succeeded
2017-09-18 04:15:52,212 [salt.state       ][INFO    ][31939] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 04:15:52.211728 duration_in_ms=46.69
2017-09-18 04:15:52,212 [salt.state       ][INFO    ][31939] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 04:15:52.212152
2017-09-18 04:15:52,212 [salt.state       ][INFO    ][31939] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-09-18 04:15:52,213 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-09-18 04:15:52,258 [salt.state       ][INFO    ][31939] unless execution succeeded
2017-09-18 04:15:52,258 [salt.state       ][INFO    ][31939] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 04:15:52.258380 duration_in_ms=46.228
2017-09-18 04:15:52,259 [salt.state       ][INFO    ][31939] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 04:15:52.258743
2017-09-18 04:15:52,259 [salt.state       ][INFO    ][31939] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-09-18 04:15:52,259 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-09-18 04:15:52,304 [salt.state       ][INFO    ][31939] unless execution succeeded
2017-09-18 04:15:52,305 [salt.state       ][INFO    ][31939] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 04:15:52.304536 duration_in_ms=45.792
2017-09-18 04:15:52,305 [salt.state       ][INFO    ][31939] Running state [keystone-keys] at time 04:15:52.305430
2017-09-18 04:15:52,306 [salt.state       ][INFO    ][31939] Executing state glusterfs.started for keystone-keys
2017-09-18 04:15:52,306 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command 'gluster --version' in directory '/root'
2017-09-18 04:15:52,313 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 04:15:52,359 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command 'gluster --version' in directory '/root'
2017-09-18 04:15:52,366 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 04:15:52,415 [salt.state       ][INFO    ][31939] Volume keystone-keys is already started
2017-09-18 04:15:52,415 [salt.state       ][INFO    ][31939] Completed state [keystone-keys] at time 04:15:52.415313 duration_in_ms=109.883
2017-09-18 04:15:52,416 [salt.state       ][INFO    ][31939] Running state [nova_instances] at time 04:15:52.416293
2017-09-18 04:15:52,417 [salt.state       ][INFO    ][31939] Executing state glusterfs.created for nova_instances
2017-09-18 04:15:52,417 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command 'gluster --version' in directory '/root'
2017-09-18 04:15:52,425 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 04:15:52,471 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command 'gluster --version' in directory '/root'
2017-09-18 04:15:52,484 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 04:15:52,533 [salt.state       ][INFO    ][31939] Volume nova_instances already exists and is started.
2017-09-18 04:15:52,534 [salt.state       ][INFO    ][31939] Completed state [nova_instances] at time 04:15:52.533649 duration_in_ms=117.356
2017-09-18 04:15:52,536 [salt.state       ][INFO    ][31939] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 04:15:52.536364
2017-09-18 04:15:52,537 [salt.state       ][INFO    ][31939] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-09-18 04:15:52,537 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-09-18 04:15:52,585 [salt.state       ][INFO    ][31939] unless execution succeeded
2017-09-18 04:15:52,585 [salt.state       ][INFO    ][31939] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 04:15:52.585197 duration_in_ms=48.833
2017-09-18 04:15:52,586 [salt.state       ][INFO    ][31939] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 04:15:52.585635
2017-09-18 04:15:52,586 [salt.state       ][INFO    ][31939] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'
2017-09-18 04:15:52,586 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-09-18 04:15:52,633 [salt.state       ][INFO    ][31939] unless execution succeeded
2017-09-18 04:15:52,633 [salt.state       ][INFO    ][31939] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 04:15:52.632742 duration_in_ms=47.107
2017-09-18 04:15:52,633 [salt.state       ][INFO    ][31939] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 04:15:52.633140
2017-09-18 04:15:52,633 [salt.state       ][INFO    ][31939] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'True'
2017-09-18 04:15:52,634 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: True'' in directory '/root'
2017-09-18 04:15:52,681 [salt.state       ][INFO    ][31939] unless execution succeeded
2017-09-18 04:15:52,681 [salt.state       ][INFO    ][31939] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 04:15:52.681420 duration_in_ms=48.28
2017-09-18 04:15:52,682 [salt.state       ][INFO    ][31939] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 04:15:52.681872
2017-09-18 04:15:52,682 [salt.state       ][INFO    ][31939] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'True'
2017-09-18 04:15:52,683 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: True'' in directory '/root'
2017-09-18 04:15:52,730 [salt.state       ][INFO    ][31939] unless execution succeeded
2017-09-18 04:15:52,730 [salt.state       ][INFO    ][31939] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 04:15:52.729758 duration_in_ms=47.886
2017-09-18 04:15:52,730 [salt.state       ][INFO    ][31939] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 04:15:52.730184
2017-09-18 04:15:52,730 [salt.state       ][INFO    ][31939] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-09-18 04:15:52,731 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-09-18 04:15:52,777 [salt.state       ][INFO    ][31939] unless execution succeeded
2017-09-18 04:15:52,777 [salt.state       ][INFO    ][31939] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 04:15:52.776826 duration_in_ms=46.642
2017-09-18 04:15:52,778 [salt.state       ][INFO    ][31939] Running state [nova_instances] at time 04:15:52.777744
2017-09-18 04:15:52,778 [salt.state       ][INFO    ][31939] Executing state glusterfs.started for nova_instances
2017-09-18 04:15:52,778 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command 'gluster --version' in directory '/root'
2017-09-18 04:15:52,786 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 04:15:52,832 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command 'gluster --version' in directory '/root'
2017-09-18 04:15:52,840 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 04:15:52,906 [salt.state       ][INFO    ][31939] Volume nova_instances is already started
2017-09-18 04:15:52,906 [salt.state       ][INFO    ][31939] Completed state [nova_instances] at time 04:15:52.906398 duration_in_ms=128.649
2017-09-18 04:15:52,907 [salt.state       ][INFO    ][31939] Running state [keystone-credential-keys] at time 04:15:52.907276
2017-09-18 04:15:52,908 [salt.state       ][INFO    ][31939] Executing state glusterfs.created for keystone-credential-keys
2017-09-18 04:15:52,908 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command 'gluster --version' in directory '/root'
2017-09-18 04:15:52,916 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 04:15:52,963 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command 'gluster --version' in directory '/root'
2017-09-18 04:15:52,971 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 04:15:53,021 [salt.state       ][INFO    ][31939] Volume keystone-credential-keys already exists and is started.
2017-09-18 04:15:53,021 [salt.state       ][INFO    ][31939] Completed state [keystone-credential-keys] at time 04:15:53.021136 duration_in_ms=113.86
2017-09-18 04:15:53,024 [salt.state       ][INFO    ][31939] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 04:15:53.024025
2017-09-18 04:15:53,024 [salt.state       ][INFO    ][31939] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-09-18 04:15:53,025 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-09-18 04:15:53,075 [salt.state       ][INFO    ][31939] unless execution succeeded
2017-09-18 04:15:53,075 [salt.state       ][INFO    ][31939] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 04:15:53.075241 duration_in_ms=51.215
2017-09-18 04:15:53,076 [salt.state       ][INFO    ][31939] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 04:15:53.076363
2017-09-18 04:15:53,077 [salt.state       ][INFO    ][31939] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-09-18 04:15:53,078 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-09-18 04:15:53,129 [salt.state       ][INFO    ][31939] unless execution succeeded
2017-09-18 04:15:53,129 [salt.state       ][INFO    ][31939] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 04:15:53.129127 duration_in_ms=52.764
2017-09-18 04:15:53,130 [salt.state       ][INFO    ][31939] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 04:15:53.129622
2017-09-18 04:15:53,130 [salt.state       ][INFO    ][31939] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-09-18 04:15:53,130 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-09-18 04:15:53,179 [salt.state       ][INFO    ][31939] unless execution succeeded
2017-09-18 04:15:53,179 [salt.state       ][INFO    ][31939] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 04:15:53.179396 duration_in_ms=49.773
2017-09-18 04:15:53,180 [salt.state       ][INFO    ][31939] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 04:15:53.179858
2017-09-18 04:15:53,180 [salt.state       ][INFO    ][31939] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-09-18 04:15:53,181 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-09-18 04:15:53,227 [salt.state       ][INFO    ][31939] unless execution succeeded
2017-09-18 04:15:53,227 [salt.state       ][INFO    ][31939] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 04:15:53.227437 duration_in_ms=47.578
2017-09-18 04:15:53,228 [salt.state       ][INFO    ][31939] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 04:15:53.227943
2017-09-18 04:15:53,228 [salt.state       ][INFO    ][31939] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-09-18 04:15:53,229 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-09-18 04:15:53,276 [salt.state       ][INFO    ][31939] unless execution succeeded
2017-09-18 04:15:53,276 [salt.state       ][INFO    ][31939] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 04:15:53.276212 duration_in_ms=48.268
2017-09-18 04:15:53,277 [salt.state       ][INFO    ][31939] Running state [keystone-credential-keys] at time 04:15:53.277186
2017-09-18 04:15:53,277 [salt.state       ][INFO    ][31939] Executing state glusterfs.started for keystone-credential-keys
2017-09-18 04:15:53,278 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command 'gluster --version' in directory '/root'
2017-09-18 04:15:53,286 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 04:15:53,334 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command 'gluster --version' in directory '/root'
2017-09-18 04:15:53,343 [salt.loaded.int.module.cmdmod][INFO    ][31939] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 04:15:53,394 [salt.state       ][INFO    ][31939] Volume keystone-credential-keys is already started
2017-09-18 04:15:53,394 [salt.state       ][INFO    ][31939] Completed state [keystone-credential-keys] at time 04:15:53.393990 duration_in_ms=116.804
2017-09-18 04:15:53,397 [salt.minion      ][INFO    ][31939] Returning information for job: 20170918041549817086
2017-09-18 04:15:54,430 [salt.minion      ][INFO    ][24106] User sudo_ubuntu Executing command test.ping with jid 20170918041554427359
2017-09-18 04:15:54,445 [salt.minion      ][INFO    ][32340] Starting a new job with PID 32340
2017-09-18 04:15:54,469 [salt.minion      ][INFO    ][32340] Returning information for job: 20170918041554427359
2017-09-18 04:15:55,117 [salt.minion      ][INFO    ][24106] User sudo_ubuntu Executing command cmd.run with jid 20170918041555110615
2017-09-18 04:15:55,133 [salt.minion      ][INFO    ][32346] Starting a new job with PID 32346
2017-09-18 04:15:55,137 [salt.loaded.int.module.cmdmod][INFO    ][32346] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-09-18 04:15:55,247 [salt.minion      ][INFO    ][32346] Returning information for job: 20170918041555110615
2017-09-18 04:27:28,332 [salt.utils.schedule][INFO    ][24106] Running scheduled job: __mine_interval
2017-09-18 05:11:24,294 [salt.minion      ][INFO    ][24106] User sudo_ubuntu Executing command cp.push_dir with jid 20170918051124277890
2017-09-18 05:11:24,312 [salt.minion      ][INFO    ][675] Starting a new job with PID 675
