search

saltstack / salt

Software to automate the management and configuration of any infrastructure or application at scale. Get access to the Salt software package repository here:
https://repo.saltproject.io/
Apache License 2.0
14.14k stars 5.47k forks source link

pkg.installed on freebsd #32457

Closed palica closed 6 years ago

palica commented 8 years ago

Description of Issue/Question

When I run try to execute states I am getting errors regarding pkg.installed on FreeBSD 10.2-p13 and salt 2015.8.8

Setup

....

-- snip --
ntp.sls
ntp:
  pkg.installed:
    - name: openntpd
    - version: 5.7p4_2,2
  service.running:
    - name: openntpd
    - require:
      - pkg: ntp

Steps to Reproduce Issue

for example:

salt-call state.sls ntp
[WARNING ] Key master with value ['salt.cupka.name', 'pepper.cupka.name'] has an invalid type of list, a str is required for this value
[INFO    ] Determining pillar cache
[INFO    ] Determining pillar cache
[INFO    ] Loading fresh modules for state activity
[INFO    ] Fetching file from saltenv 'base', ** skipped ** latest already in cache u'salt://ntp/init.sls'
[INFO    ] Running state [Europe/Prague] at time 07:01:33.654285
[INFO    ] Executing state timezone.system for Europe/Prague
[INFO    ] Timezone Europe/Prague already set, UTC already set to Europe/Prague
[INFO    ] Completed state [Europe/Prague] at time 07:01:33.669415
[ERROR   ] Failed to import module win_dacl, this is due most likely to a syntax error:
Traceback (most recent call last):
  File "/usr/local/lib/python2.7/site-packages/salt/loader.py", line 1136, in _load_module
    ), fn_, fpath, desc)
  File "/usr/local/lib/python2.7/site-packages/salt/modules/win_dacl.py", line 39, in <module>
    class daclConstants(object):
  File "/usr/local/lib/python2.7/site-packages/salt/modules/win_dacl.py", line 47, in daclConstants
    FILE_ALL_ACCESS = (ntsecuritycon.STANDARD_RIGHTS_REQUIRED | ntsecuritycon.SYNCHRONIZE | 0x1ff)
NameError: name 'ntsecuritycon' is not defined
[INFO    ] Executing command '/sbin/zfs -?' in directory '/root'
[INFO    ] Running state [openntpd] at time 07:01:38.221561
[INFO    ] Executing state pkg.installed for openntpd
[INFO    ] Executing command 'pkg info -ao' in directory '/root'
[INFO    ] Executing command 'pkg install  -y openntpd-5.7p4_2,2' in directory '/root'
[INFO    ] Executing command 'pkg info -ao' in directory '/root'
[ERROR   ] The following packages failed to install/update: openntpd=5.7p4_2,2
[INFO    ] Completed state [openntpd] at time 07:01:41.183361
local:
----------
          ID: Europe/Prague
    Function: timezone.system
      Result: True
     Comment: Timezone Europe/Prague already set, UTC already set to Europe/Prague
     Started: 07:01:33.654285
    Duration: 15.13 ms
     Changes:   
----------
          ID: ntp
    Function: pkg.installed
        Name: openntpd
      Result: False
     Comment: The following packages failed to install/update: openntpd=5.7p4_2,2
     Started: 07:01:38.221561
    Duration: 2961.8 ms
     Changes:   
----------
          ID: ntp
    Function: service.running
        Name: openntpd
      Result: False
     Comment: One or more requisite failed: ntp.ntp
     Started: 
    Duration: 
     Changes:   

Summary for local
------------
Succeeded: 1
Failed:    2
------------
Total states run:     3

Versions Report

minion:
Salt Version:
           Salt: 2015.8.8

Dependency Versions:
         Jinja2: 2.8
       M2Crypto: Not Installed
           Mako: Not Installed
         PyYAML: 3.11
          PyZMQ: 14.7.0
         Python: 2.7.11 (default, Jan 16 2016, 01:23:17)
           RAET: Not Installed
        Tornado: 4.3
            ZMQ: 4.1.3
           cffi: 1.2.1
       cherrypy: Not Installed
       dateutil: 2.3
          gitdb: Not Installed
      gitpython: Not Installed
          ioflo: Not Installed
        libgit2: Not Installed
        libnacl: Not Installed
   msgpack-pure: Not Installed
 msgpack-python: 0.4.2
   mysql-python: Not Installed
      pycparser: 2.10
       pycrypto: 2.6.1
         pygit2: Not Installed
   python-gnupg: Not Installed
          smmap: Not Installed
        timelib: Not Installed

System Versions:
           dist:   
        machine: amd64
        release: 10.3-RELEASE

master salt:
Salt Version:
           Salt: 2015.8.7

Dependency Versions:
         Jinja2: 2.8
       M2Crypto: Not Installed
           Mako: Not Installed
         PyYAML: 3.11
          PyZMQ: 15.2.0
         Python: 2.7.11 (default, Mar 20 2016, 07:27:30)
           RAET: Not Installed
        Tornado: 4.3
            ZMQ: 4.1.4
           cffi: 1.5.2
       cherrypy: Not Installed
       dateutil: 2.4.2
          gitdb: Not Installed
      gitpython: Not Installed
          ioflo: Not Installed
        libgit2: Not Installed
        libnacl: Not Installed
   msgpack-pure: Not Installed
 msgpack-python: 0.4.7
   mysql-python: Not Installed
      pycparser: 2.14
       pycrypto: 2.6.1
         pygit2: Not Installed
   python-gnupg: Not Installed
          smmap: Not Installed
        timelib: Not Installed

System Versions:
           dist: gentoo 2.2.0 
        machine: x86_64
        release: 4.4.4-ipv6-64
         system: Funtoo Linux - baselayout  2.2.0

master pepper:
Salt Version:
           Salt: 2015.8.7

Dependency Versions:
         Jinja2: 2.8
       M2Crypto: Not Installed
           Mako: Not Installed
         PyYAML: 3.11
          PyZMQ: 15.2.0
         Python: 2.7.11 (default, Mar  5 2016, 01:15:47)
           RAET: Not Installed
        Tornado: 4.3
            ZMQ: 4.1.4
           cffi: Not Installed
       cherrypy: Not Installed
       dateutil: 2.5.0
          gitdb: Not Installed
      gitpython: Not Installed
          ioflo: Not Installed
        libgit2: Not Installed
        libnacl: Not Installed
   msgpack-pure: Not Installed
 msgpack-python: 0.4.7
   mysql-python: Not Installed
      pycparser: Not Installed
       pycrypto: 2.6.1
         pygit2: Not Installed
   python-gnupg: Not Installed
          smmap: Not Installed
        timelib: Not Installed

System Versions:
           dist:   
        machine: amd64
        release: 10.3-RELEASE
jfindlay commented 8 years ago

@palica, thanks for reporting. The stack trace is a known, unrelated issue that has been fixed in 2015.8.8.2. Is it possible for you to post your pkg.installed ntp state?

palica commented 8 years ago

Do I have to upgrade the server or them minions? Or both?

Thank you.

My report was intended to show that the pkg.install errors on FreeBSD. I hope that's what you mean with "known stack trace".

pkg.installed ntp state:

ntp:
  pkg.installed:
    - name: openntpd
    - version: 5.9p1,2
  service.running:
    - name: openntpd
    - require:
      - pkg: ntp
palica commented 8 years ago

run with correct package upgrade, but the state still fails

salt-call state.sls ntp
[INFO    ] Loading fresh modules for state activity
[INFO    ] Fetching file from saltenv 'base', ** done ** u'ntp.sls'
[INFO    ] Executing command '/sbin/zfs -?' in directory '/root'
[INFO    ] Running state [openntpd] at time 22:10:06.028480
[INFO    ] Executing state pkg.installed for openntpd
[INFO    ] Executing command 'pkg info -ao' in directory '/root'
[INFO    ] Executing command 'pkg install  -y openntpd-5.9p1,2' in directory '/root'
[INFO    ] Executing command 'pkg info -ao' in directory '/root'
[ERROR   ] Made the following changes:
'openntpd' changed from '5.7p4_1,2' to '5.9p1,2'
'libressl-devel' changed from 'absent' to '2.3.3'
'openssl' changed from '1.0.2_8' to 'absent'

[INFO    ] Loading fresh modules for state activity
[INFO    ] Completed state [openntpd] at time 22:10:32.029160
local:
----------
          ID: ntp
    Function: pkg.installed
        Name: openntpd
      Result: False
     Comment: The following packages failed to install/update: openntpd=5.9p1,2
     Started: 22:10:06.028480
    Duration: 26000.68 ms
     Changes:   
              ----------
              libressl-devel:
                  ----------
                  new:
                      2.3.3
                  old:
              openntpd:
                  ----------
                  new:
                      5.9p1,2
                  old:
                      5.7p4_1,2
              openssl:
                  ----------
                  new:
                  old:
                      1.0.2_8
----------
----------
          ID: ntp
    Function: service.running
        Name: openntpd
      Result: False
     Comment: One or more requisite failed: test.ntp
     Started: 
    Duration: 
     Changes:   

Summary for local
------------
Succeeded: 0 (changed=1)
Failed:    2
------------
Total states run:     2
palica commented 8 years ago

subsequent run where the package is in correct upgraded state

salt-call state.sls ntp
[INFO    ] Loading fresh modules for state activity
[INFO    ] Fetching file from saltenv 'base', ** skipped ** latest already in cache u'salt://ntp.sls'
[INFO    ] Executing command '/sbin/zfs -?' in directory '/root'
[INFO    ] Running state [openntpd] at time 22:13:05.552956
[INFO    ] Executing state pkg.installed for openntpd
[INFO    ] Executing command 'pkg info -ao' in directory '/root'
[INFO    ] Executing command 'pkg install  -y openntpd-5.9p1,2' in directory '/root'
[INFO    ] Executing command 'pkg info -ao' in directory '/root'
[ERROR   ] The following packages failed to install/update: openntpd=5.9p1,2
[INFO    ] Completed state [openntpd] at time 22:13:06.552178
local:
----------
          ID: ntp
    Function: pkg.installed
        Name: openntpd
      Result: False
     Comment: The following packages failed to install/update: openntpd=5.9p1,2
     Started: 22:13:05.552956
    Duration: 999.222 ms
     Changes:   
----------
          ID: ntp
    Function: service.running
        Name: openntpd
      Result: False
     Comment: One or more requisite failed: test.ntp
     Started: 
    Duration: 
     Changes:   

Summary for local
------------
Succeeded: 0
Failed:    2
------------
Total states run:     2
jfindlay commented 8 years ago

@palica, sorry for being confusing. The stack trace in the log is due to another bug that has been fixed, #32004. The pkg.installed error has not been fixed according to my memory. Would you mind running the state with salt-call -l trace state.sls ntp?

palica commented 8 years ago 

salt-call -l trace state.sls ntp
[DEBUG   ] Reading configuration from /usr/local/etc/salt/minion
[DEBUG   ] Including configuration from '/usr/local/etc/salt/minion.d/_schedule.conf'
[DEBUG   ] Reading configuration from /usr/local/etc/salt/minion.d/_schedule.conf
[DEBUG   ] Including configuration from '/usr/local/etc/salt/minion.d/grains.conf'
[DEBUG   ] Reading configuration from /usr/local/etc/salt/minion.d/grains.conf
[DEBUG   ] Using cached minion ID from /usr/local/etc/salt/minion_id: mx.kostej.cupka.name
[TRACE   ] None of the required configuration sections, 'logstash_udp_handler' and 'logstash_zmq_handler', were found the in the configuration. Not loading the Logstash logging handlers module.
[TRACE   ] The required configuration section, 'fluent_handler', was not found the in the configuration. Not loading the fluent logging handlers module.
[DEBUG   ] Configuration file path: /usr/local/etc/salt/minion
[WARNING ] Insecure logging configuration detected! Sensitive data may be logged.
[DEBUG   ] Reading configuration from /usr/local/etc/salt/minion
[DEBUG   ] Including configuration from '/usr/local/etc/salt/minion.d/_schedule.conf'
[DEBUG   ] Reading configuration from /usr/local/etc/salt/minion.d/_schedule.conf
[DEBUG   ] Including configuration from '/usr/local/etc/salt/minion.d/grains.conf'
[DEBUG   ] Reading configuration from /usr/local/etc/salt/minion.d/grains.conf
[TRACE   ] 'dmidecode' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] 'smbios' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] Loading core.hwaddr_interfaces grain
[TRACE   ] 'ip' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] Loading core.hostname grain
[TRACE   ] Loading core.get_master grain
[TRACE   ] Loading core.pythonversion grain
[TRACE   ] Loading core.path grain
[TRACE   ] Loading core.get_server_id grain
[TRACE   ] Loading core.ip6 grain
[TRACE   ] 'ip' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] Loading core.ip4 grain
[TRACE   ] 'ip' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] Loading core.saltversion grain
[TRACE   ] Loading core.saltpath grain
[TRACE   ] Loading core.pythonexecutable grain
[TRACE   ] Loading core.fqdn_ip4 grain
[TRACE   ] Loading core.fqdn_ip6 grain
[TRACE   ] Loading core.ip6_interfaces grain
[TRACE   ] Loading core.ip4_interfaces grain
[TRACE   ] Loading core.append_domain grain
[TRACE   ] Loading core.os_data grain
[TRACE   ] 'arch' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] 'dmidecode' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] 'smbios' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] 'virt-what' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[DEBUG   ] Please install 'virt-what' to improve results of the 'virtual' grain.
[TRACE   ] 'systemd-detect-virt' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] 'virt-what' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] 'dmidecode' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] Loading core.zmqversion grain
[TRACE   ] Loading core.saltversioninfo grain
[TRACE   ] Loading core.pythonpath grain
[TRACE   ] Loading core.id_ grain
[TRACE   ] Loading core.locale_info grain
[TRACE   ] Loading core.get_machine_id grain
[TRACE   ] Loading core.ip_interfaces grain
[DEBUG   ] Initializing new SAuth for ('/usr/local/etc/salt/pki/minion', 'mx.kostej.cupka.name', 'tcp://37.187.110.20:4506')
[DEBUG   ] Generated random reconnect delay between '1000ms' and '11000ms' (2970)
[DEBUG   ] Setting zmq_reconnect_ivl to '2970ms'
[DEBUG   ] Setting zmq_reconnect_ivl_max to '11000ms'
[DEBUG   ] Initializing new AsyncZeroMQReqChannel for ('/usr/local/etc/salt/pki/minion', 'mx.kostej.cupka.name', 'tcp://37.187.110.20:4506', 'aes')
[DEBUG   ] Initializing new SAuth for ('/usr/local/etc/salt/pki/minion', 'mx.kostej.cupka.name', 'tcp://37.187.110.20:4506')
[DEBUG   ] Initializing new AsyncZeroMQReqChannel for ('/usr/local/etc/salt/pki/minion', 'mx.kostej.cupka.name', 'tcp://37.187.110.20:4506', 'clear')
[DEBUG   ] Decrypting the current master AES key
[DEBUG   ] Loaded minion key: /usr/local/etc/salt/pki/minion/minion.pem
[DEBUG   ] Loaded minion key: /usr/local/etc/salt/pki/minion/minion.pem
[DEBUG   ] LazyLoaded jinja.render
[DEBUG   ] LazyLoaded yaml.render
[DEBUG   ] LazyLoaded state.sls
[DEBUG   ] LazyLoaded saltutil.is_running
[DEBUG   ] LazyLoaded grains.get
[DEBUG   ] Initializing new AsyncZeroMQReqChannel for ('/usr/local/etc/salt/pki/minion', 'mx.kostej.cupka.name', 'tcp://37.187.110.20:4506', 'aes')
[DEBUG   ] Initializing new SAuth for ('/usr/local/etc/salt/pki/minion', 'mx.kostej.cupka.name', 'tcp://37.187.110.20:4506')
[DEBUG   ] Initializing new AsyncZeroMQReqChannel for ('/usr/local/etc/salt/pki/minion', 'mx.kostej.cupka.name', 'tcp://37.187.110.20:4506', 'aes')
[DEBUG   ] Initializing new SAuth for ('/usr/local/etc/salt/pki/minion', 'mx.kostej.cupka.name', 'tcp://37.187.110.20:4506')
[DEBUG   ] Loaded minion key: /usr/local/etc/salt/pki/minion/minion.pem
[INFO    ] Loading fresh modules for state activity
[DEBUG   ] LazyLoaded jinja.render
[DEBUG   ] LazyLoaded yaml.render
[DEBUG   ] In saltenv 'base', looking at rel_path u'ntp.sls' to resolve u'salt://ntp.sls'
[DEBUG   ] In saltenv 'base', ** considering ** path u'/var/cache/salt/minion/files/base/ntp.sls' to resolve u'salt://ntp.sls'
[INFO    ] Fetching file from saltenv 'base', ** skipped ** latest already in cache u'salt://ntp.sls'
[DEBUG   ] compile template: /var/cache/salt/minion/files/base/ntp.sls
[DEBUG   ] Jinja search path: ['/var/cache/salt/minion/files/base']
[PROFILE ] Time (in seconds) to render '/var/cache/salt/minion/files/base/ntp.sls' using 'jinja' renderer: 0.0236170291901
[DEBUG   ] Rendered data from file: /var/cache/salt/minion/files/base/ntp.sls:
ntp:
  pkg.installed:
    - name: openntpd
    - version: 5.9p1,2
  service.running:
    - name: openntpd
    - require:
      - pkg: ntp
# vim: syntax=yaml tabstop=2 sw=2 sts=2 et si ai

[DEBUG   ] LazyLoaded config.get
[DEBUG   ] Results of YAML rendering: 
OrderedDict([('ntp', OrderedDict([('pkg.installed', [OrderedDict([('name', 'openntpd')]), OrderedDict([('version', '5.9p1,2')])]), ('service.running', [OrderedDict([('name', 'openntpd')]), OrderedDi
ct([('require', [OrderedDict([('pkg', 'ntp')])])])])]))])
[PROFILE ] Time (in seconds) to render '/var/cache/salt/minion/files/base/ntp.sls' using 'yaml' renderer: 0.0421028137207
[TRACE   ] Loaded pkgng as virtual pkg
[DEBUG   ] LazyLoaded pkg.install
[DEBUG   ] LazyLoaded pkg.installed
[TRACE   ] Loaded localemod as virtual locale
[TRACE   ] 'semanage' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] 'initctl' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[DEBUG   ] Error loading module.rh_service: Cannot load rh_service module: OS not in set(['SUSE  Enterprise Server', 'SUSE', 'RedHat', 'CentOS', 'CloudLinux', 'McAfee  OS Server', 'XenServer', 'Amaz
on', 'OEL', 'ScientificLinux', 'ALT', 'Fedora'])
[DEBUG   ] Error loading module.ifttt: IFTTT Secret Key Unavailable, not loading.
[TRACE   ] Loaded freebsdkmod as virtual kmod
[TRACE   ] 'mock' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] 'localectl' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] 'cabal' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] 'nsenter' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[DEBUG   ] Error loading module.dockerng: Docker module could not get imported
[TRACE   ] 'pg_createcluster' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] 'rabbitmqctl' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] 'poudriere' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] Loaded freebsdservice as virtual service
[TRACE   ] 'sysbench' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] 'iptables' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[DEBUG   ] Error loading module.ipmi: No module named pyghmi.ipmi
[TRACE   ] 'ipset' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] 'varnishd' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[DEBUG   ] Error loading module.win_status: Cannot load win_status module on non-windows
[DEBUG   ] Error loading module.victorops: No VictorOps api key found.
[TRACE   ] 'osqueryi' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] 'nsenter' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] Loaded freebsdports as virtual ports
[TRACE   ] 'qemu-nbd' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] Loaded pw_user as virtual user
[TRACE   ] 'udevadm' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] 'firewall-cmd' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] 'gluster' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[DEBUG   ] Error loading module.glusterfs: glusterfs server is not installed
[TRACE   ] 'tuned-adm' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] Loaded sysmod as virtual sys
[TRACE   ] Loaded linux_acl as virtual acl
[DEBUG   ] Error loading module.x509: Could not load x509 module, m2crypto unavailable
[TRACE   ] 'parted' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] Loaded freebsd_sysctl as virtual sysctl
[TRACE   ] 'uwsgi' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] 'setquota' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] Loaded pw_group as virtual group
[TRACE   ] 'sensors' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] 'solr' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] 'apache-solr' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[DEBUG   ] Error loading module.tls: PyOpenSSL version 0.10 or later must be installed before this module can be used.
[TRACE   ] 'guestmount' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[DEBUG   ] Error loading module.vsphere: Missing dependency: The vSphere module requires the pyVmomi Python module.
[TRACE   ] 'lxc-start' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] Loaded freebsdjail as virtual jail
[DEBUG   ] Error loading module.nacl: libnacl import error, perhaps missing python libnacl package
[TRACE   ] 'monit' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] 'apachectl' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] 'facter' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] 'rpm' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] 'racadm' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] 'git' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] Loaded zcbuildout as virtual buildout
[TRACE   ] 'gpg' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] Loaded bsd_shadow as virtual shadow
[TRACE   ] 'nft' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] 'nginx' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] 'traffic_line' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] 'traffic_line' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] 'svn' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] 'htpasswd' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] 'bower' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] Loaded pushover_notify as virtual pushover
[TRACE   ] 'pecl' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] 'chef-client' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] 'dig' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] 'ipvsadm' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] 'mfsgetgoal' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] 'blockdev' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[DEBUG   ] Error loading module.blockdev: Cannot load the blockdev execution module: blockdev utility not found
[TRACE   ] Loaded cmdmod as virtual cmd
[DEBUG   ] LazyLoaded cmd.run_stderr
[INFO    ] Executing command '/sbin/zfs -?' in directory '/root'
[TRACE   ] stdout: usage: zfs command args ...
where 'command' is one of the following:

        create [-pu] [-o property=value] ... <filesystem>
        create [-ps] [-b blocksize] [-o property=value] ... -V <size> <volume>
        destroy [-fnpRrv] <filesystem|volume>
        destroy [-dnpRrv] <filesystem|volume>@<snap>[%<snap>][,...]
        destroy <filesystem|volume>#<bookmark>

        snapshot|snap [-r] [-o property=value] ... <filesystem|volume>@<snap> ...
        rollback [-rRf] <snapshot>
        clone [-p] [-o property=value] ... <snapshot> <filesystem|volume>
        promote <clone-filesystem>
        rename [-f] <filesystem|volume|snapshot> <filesystem|volume|snapshot>
        rename [-f] -p <filesystem|volume> <filesystem|volume>
        rename -r <snapshot> <snapshot>
        rename -u [-p] <filesystem> <filesystem>        bookmark <snapshot> <bookmark>

        list [-Hp] [-r|-d max] [-o property[,...]] [-s property]...
            [-S property]... [-t type[,...]] [filesystem|volume|snapshot] ...

        set <property=value> ... <filesystem|volume|snapshot> ...
        get [-rHp] [-d max] [-o "all" | field[,...]]
            [-t type[,...]] [-s source[,...]]
            <"all" | property[,...]> [filesystem|volume|snapshot] ...
        inherit [-rS] <property> <filesystem|volume|snapshot> ...
        upgrade [-v]
        upgrade [-r] [-V version] <-a | filesystem ...>
        userspace [-Hinp] [-o field[,...]] [-s field] ...
            [-S field] ... [-t type[,...]] <filesystem|snapshot>
        groupspace [-Hinp] [-o field[,...]] [-s field] ...
            [-S field] ... [-t type[,...]] <filesystem|snapshot>

        mount
        mount [-vO] [-o opts] <-a | filesystem>
        unmount|umount [-f] <-a | filesystem|mountpoint>
        share <-a | filesystem>
        unshare <-a | filesystem|mountpoint>

        send [-DnPpRvLe] [-[iI] snapshot] <snapshot>
        send [-Le] [-i snapshot|bookmark] <filesystem|volume|snapshot>
        send [-nvPe] -t <receive_resume_token>
        receive|recv [-vnsFu] <filesystem|volume|snapshot>
        receive|recv [-vnsFu] [-o origin=<snapshot>] [-d | -e] <filesystem>
        receive|recv -A <filesystem|volume>
        allow <filesystem|volume>
        allow [-ldug] <"everyone"|user|group>[,...] <perm|@setname>[,...]
            <filesystem|volume>
        allow [-ld] -e <perm|@setname>[,...] <filesystem|volume>
        allow -c <perm|@setname>[,...] <filesystem|volume>
        allow -s @setname <perm|@setname>[,...] <filesystem|volume>

        unallow [-rldug] <"everyone"|user|group>[,...]
            [<perm|@setname>[,...]] <filesystem|volume>
        unallow [-rld] -e [<perm|@setname>[,...]] <filesystem|volume>
        unallow [-r] -c [<perm|@setname>[,...]] <filesystem|volume>
        unallow [-r] -s @setname [<perm|@setname>[,...]] <filesystem|volume>

        hold [-r] <tag> <snapshot> ...
        holds [-r] <snapshot> ...
        release [-r] <tag> <snapshot> ...
        diff [-FHt] <snapshot> [snapshot|filesystem]

        jail <jailid|jailname> <filesystem>
        unjail <jailid|jailname> <filesystem>

Each dataset is of the form: pool/[dataset/]*dataset[@name]

For the property list, run: zfs set|get

For the delegated permission list, run: zfs allow|unallow
[TRACE   ] Loaded ini_manage as virtual ini
[TRACE   ] 'hponcfg' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] 'sudo' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] 'apachectl' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] Loaded etcd_mod as virtual etcd
[TRACE   ] 'npm' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[DEBUG   ] Error loading module.npm: npm execution module could not be loaded because the npm binary could not be located
[TRACE   ] 'svok' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] Loaded slack_notify as virtual slack
[TRACE   ] 'virtualenv' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] 'virtualenv-2.7' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] 'virtualenv-2.6' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] 'virtualenv2' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] Loaded virtualenv_mod as virtual virtualenv
[TRACE   ] Loaded djangomod as virtual django
[TRACE   ] 'hadoop' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] Depends decorator instantiated with dep list of ('zipfile',)
[TRACE   ] Depends decorator instantiated with dep list of ('zipfile',)
[TRACE   ] Unloading salt.loaded.int.module.archive.<function zip_ at 0x80ec3c2a8> because dependency (zipfile) is not imported
[TRACE   ] Unloading salt.loaded.int.module.archive.<function unzip at 0x80ed208c0> because dependency (zipfile) is not imported
[TRACE   ] Loaded mod_random as virtual random
[TRACE   ] Unloading salt.loaded.int.module.archive.<function zip_ at 0x80ec3c2a8> because dependency (zipfile) is not imported
[TRACE   ] Unloading salt.loaded.int.module.archive.<function unzip at 0x80ed208c0> because dependency (zipfile) is not imported
[TRACE   ] Depends decorator instantiated with dep list of ('non_existantmodulename',)
[TRACE   ] Unloading salt.loaded.int.module.archive.<function zip_ at 0x80ec3c2a8> because dependency (zipfile) is not imported
[TRACE   ] Unloading salt.loaded.int.module.archive.<function unzip at 0x80ed208c0> because dependency (zipfile) is not imported
[TRACE   ] Unloading salt.loaded.int.module.test.<function missing_func at 0x80ed3e578> because dependency (non_existantmodulename) is not imported
[TRACE   ] 'riak' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] Unloading salt.loaded.int.module.archive.<function zip_ at 0x80ec3c2a8> because dependency (zipfile) is not imported
[TRACE   ] Unloading salt.loaded.int.module.archive.<function unzip at 0x80ed208c0> because dependency (zipfile) is not imported
[TRACE   ] Unloading salt.loaded.int.module.test.<function missing_func at 0x80ed3e578> because dependency (non_existantmodulename) is not imported
[TRACE   ] Unloading salt.loaded.int.module.archive.<function zip_ at 0x80ec3c2a8> because dependency (zipfile) is not imported
[TRACE   ] Unloading salt.loaded.int.module.archive.<function unzip at 0x80ed208c0> because dependency (zipfile) is not imported
[TRACE   ] Unloading salt.loaded.int.module.test.<function missing_func at 0x80ed3e578> because dependency (non_existantmodulename) is not imported
[TRACE   ] Unloading salt.loaded.int.module.archive.<function zip_ at 0x80ec3c2a8> because dependency (zipfile) is not imported
[TRACE   ] Unloading salt.loaded.int.module.archive.<function unzip at 0x80ed208c0> because dependency (zipfile) is not imported
[TRACE   ] Unloading salt.loaded.int.module.test.<function missing_func at 0x80ed3e578> because dependency (non_existantmodulename) is not imported
[TRACE   ] Unloading salt.loaded.int.module.archive.<function zip_ at 0x80ec3c2a8> because dependency (zipfile) is not imported
[TRACE   ] Unloading salt.loaded.int.module.archive.<function unzip at 0x80ed208c0> because dependency (zipfile) is not imported
[TRACE   ] Unloading salt.loaded.int.module.test.<function missing_func at 0x80ed3e578> because dependency (non_existantmodulename) is not imported
[TRACE   ] Unloading salt.loaded.int.module.archive.<function zip_ at 0x80ec3c2a8> because dependency (zipfile) is not imported
[TRACE   ] Unloading salt.loaded.int.module.archive.<function unzip at 0x80ed208c0> because dependency (zipfile) is not imported
[TRACE   ] Unloading salt.loaded.int.module.test.<function missing_func at 0x80ed3e578> because dependency (non_existantmodulename) is not imported
[TRACE   ] Unloading salt.loaded.int.module.archive.<function zip_ at 0x80ec3c2a8> because dependency (zipfile) is not imported
[TRACE   ] Unloading salt.loaded.int.module.archive.<function unzip at 0x80ed208c0> because dependency (zipfile) is not imported
[TRACE   ] Unloading salt.loaded.int.module.test.<function missing_func at 0x80ed3e578> because dependency (non_existantmodulename) is not imported
[TRACE   ] 'dmidecode' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] 'smbios' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[DEBUG   ] SMBIOS: neither dmidecode nor smbios found!
[TRACE   ] Unloading salt.loaded.int.module.archive.<function zip_ at 0x80ec3c2a8> because dependency (zipfile) is not imported
[TRACE   ] Unloading salt.loaded.int.module.archive.<function unzip at 0x80ed208c0> because dependency (zipfile) is not imported
[TRACE   ] Unloading salt.loaded.int.module.test.<function missing_func at 0x80ed3e578> because dependency (non_existantmodulename) is not imported
[TRACE   ] Depends decorator instantiated with dep list of ('cx_Oracle',)
[TRACE   ] Depends decorator instantiated with dep list of ('cx_Oracle',)
[TRACE   ] Depends decorator instantiated with dep list of ('cx_Oracle',)
[TRACE   ] 'qemu-img' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] 'racadm' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] 'system_profiler' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] 'psql' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] Unloading salt.loaded.int.module.oracle.<function run_query at 0x80edbd578> because dependency (cx_Oracle) is not imported
[TRACE   ] Unloading salt.loaded.int.module.oracle.<function client_version at 0x80edbd9b0> because dependency (cx_Oracle) is not imported
[TRACE   ] Unloading salt.loaded.int.module.oracle.<function version at 0x80edbd938> because dependency (cx_Oracle) is not imported
[TRACE   ] Unloading salt.loaded.int.module.archive.<function zip_ at 0x80ec3c2a8> because dependency (zipfile) is not imported
[TRACE   ] Unloading salt.loaded.int.module.archive.<function unzip at 0x80ed208c0> because dependency (zipfile) is not imported
[TRACE   ] Unloading salt.loaded.int.module.test.<function missing_func at 0x80ed3e578> because dependency (non_existantmodulename) is not imported
[TRACE   ] Unloading salt.loaded.int.module.oracle.<function run_query at 0x80edbd578> because dependency (cx_Oracle) is not imported
[TRACE   ] Unloading salt.loaded.int.module.oracle.<function client_version at 0x80edbd9b0> because dependency (cx_Oracle) is not imported
[TRACE   ] Unloading salt.loaded.int.module.oracle.<function version at 0x80edbd938> because dependency (cx_Oracle) is not imported
[TRACE   ] Unloading salt.loaded.int.module.archive.<function zip_ at 0x80ec3c2a8> because dependency (zipfile) is not imported
[TRACE   ] Unloading salt.loaded.int.module.archive.<function unzip at 0x80ed208c0> because dependency (zipfile) is not imported
[TRACE   ] Unloading salt.loaded.int.module.test.<function missing_func at 0x80ed3e578> because dependency (non_existantmodulename) is not imported
[TRACE   ] 'znc' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] Unloading salt.loaded.int.module.oracle.<function run_query at 0x80edbd578> because dependency (cx_Oracle) is not imported
[TRACE   ] Unloading salt.loaded.int.module.oracle.<function client_version at 0x80edbd9b0> because dependency (cx_Oracle) is not imported
[TRACE   ] Unloading salt.loaded.int.module.oracle.<function version at 0x80edbd938> because dependency (cx_Oracle) is not imported
[TRACE   ] Unloading salt.loaded.int.module.archive.<function zip_ at 0x80ec3c2a8> because dependency (zipfile) is not imported
[TRACE   ] Unloading salt.loaded.int.module.archive.<function unzip at 0x80ed208c0> because dependency (zipfile) is not imported
[TRACE   ] Unloading salt.loaded.int.module.test.<function missing_func at 0x80ed3e578> because dependency (non_existantmodulename) is not imported
[DEBUG   ] Error loading module.boto_cloudwatch: The boto_cloudwatch module cannot be loaded: boto libraries are unavailable.
[TRACE   ] 'port' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] 'postfix' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] 'aws' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] 'lvm' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] Unloading salt.loaded.int.module.oracle.<function run_query at 0x80edbd578> because dependency (cx_Oracle) is not imported
[TRACE   ] Unloading salt.loaded.int.module.oracle.<function client_version at 0x80edbd9b0> because dependency (cx_Oracle) is not imported
[TRACE   ] Unloading salt.loaded.int.module.oracle.<function version at 0x80edbd938> because dependency (cx_Oracle) is not imported
[TRACE   ] Unloading salt.loaded.int.module.archive.<function zip_ at 0x80ec3c2a8> because dependency (zipfile) is not imported
[TRACE   ] Unloading salt.loaded.int.module.archive.<function unzip at 0x80ed208c0> because dependency (zipfile) is not imported
[TRACE   ] Unloading salt.loaded.int.module.test.<function missing_func at 0x80ed3e578> because dependency (non_existantmodulename) is not imported
[TRACE   ] 'brew' could not be found in the following search path: ['/sbin', '/bin', '/usr/sbin', '/usr/bin', '/usr/games', '/usr/local/sbin', '/usr/local/bin', '/root/bin']
[TRACE   ] Unloading salt.loaded.int.module.oracle.<function run_query at 0x80edbd578> because dependency (cx_Oracle) is not imported
[TRACE   ] Unloading salt.loaded.int.module.oracle.<function client_version at 0x80edbd9b0> because dependency (cx_Oracle) is not imported
[TRACE   ] Unloading salt.loaded.int.module.oracle.<function version at 0x80edbd938> because dependency (cx_Oracle) is not imported
[TRACE   ] Unloading salt.loaded.int.module.archive.<function zip_ at 0x80ec3c2a8> because dependency (zipfile) is not imported
[TRACE   ] Unloading salt.loaded.int.module.archive.<function unzip at 0x80ed208c0> because dependency (zipfile) is not imported
[TRACE   ] Unloading salt.loaded.int.module.test.<function missing_func at 0x80ed3e578> because dependency (non_existantmodulename) is not imported
[TRACE   ] Unloading salt.loaded.int.module.oracle.<function run_query at 0x80edbd578> because dependency (cx_Oracle) is not imported
[TRACE   ] Unloading salt.loaded.int.module.oracle.<function client_version at 0x80edbd9b0> because dependency (cx_Oracle) is not imported
[TRACE   ] Unloading salt.loaded.int.module.oracle.<function version at 0x80edbd938> because dependency (cx_Oracle) is not imported
[TRACE   ] Unloading salt.loaded.int.module.archive.<function zip_ at 0x80ec3c2a8> because dependency (zipfile) is not imported
[TRACE   ] Unloading salt.loaded.int.module.archive.<function unzip at 0x80ed208c0> because dependency (zipfile) is not imported
[TRACE   ] Unloading salt.loaded.int.module.test.<function missing_func at 0x80ed3e578> because dependency (non_existantmodulename) is not imported
[TRACE   ] Unloading salt.loaded.int.module.oracle.<function run_query at 0x80edbd578> because dependency (cx_Oracle) is not imported
[TRACE   ] Unloading salt.loaded.int.module.oracle.<function client_version at 0x80edbd9b0> because dependency (cx_Oracle) is not imported
[TRACE   ] Unloading salt.loaded.int.module.oracle.<function version at 0x80edbd938> because dependency (cx_Oracle) is not imported
[TRACE   ] Unloading salt.loaded.int.module.archive.<function zip_ at 0x80ec3c2a8> because dependency (zipfile) is not imported
[TRACE   ] Unloading salt.loaded.int.module.archive.<function unzip at 0x80ed208c0> because dependency (zipfile) is not imported
[TRACE   ] Unloading salt.loaded.int.module.test.<function missing_func at 0x80ed3e578> because dependency (non_existantmodulename) is not imported
[DEBUG   ] Could not LazyLoad pkg.ex_mod_init
[INFO    ] Running state [openntpd] at time 22:15:48.438211
[INFO    ] Executing state pkg.installed for openntpd
[INFO    ] Executing command 'pkg info -ao' in directory '/root'
[TRACE   ] stdout: ca_root_nss-3.22.2             security/ca_root_nss
gettext-runtime-0.19.7         devel/gettext-runtime
gmp-5.1.3_3                    math/gmp
indexinfo-0.2.4                print/indexinfo
libasr-1.0.2                   dns/libasr
libevent2-2.0.22_1             devel/libevent2
libffi-3.2.1                   devel/libffi
libressl-devel-2.3.3           security/libressl-devel
libsodium-1.0.3                security/libsodium
libzmq4-4.1.4                  net/libzmq4
mosh-1.2.5                     net/mosh
nano-2.4.3                     editors/nano
openntpd-5.9p1,2               net/openntpd
openpgm-5.2.122_2              net/openpgm
perl5-5.20.3_8                 lang/perl5.20
pkg-1.7.2                      ports-mgmt/pkg
protobuf-2.6.1                 devel/protobuf
py27-Babel-2.2.0_1             devel/py-babel
py27-Jinja2-2.8                devel/py-Jinja2
py27-MarkupSafe-0.23           textproc/py-MarkupSafe
py27-backports_abc-0.4         devel/py-backports_abc
py27-botocore-1.3.17           devel/py-botocore
py27-certifi-2015.11.20        security/py-certifi
py27-dateutil-2.5.0            devel/py-dateutil
py27-docutils-0.12             textproc/py-docutils
py27-enum34-1.0.4              devel/py-enum34
py27-futures-3.0.5             devel/py-futures
py27-jmespath-0.9.0            devel/py-jmespath
py27-libcloud-0.20.1           net/py-libcloud
py27-msgpack-python-0.4.7      devel/py-msgpack-python
py27-progressbar-2.3           misc/py-progressbar
py27-pycrypto-2.6.1_1          security/py-pycrypto
py27-pytz-2015.7,1             devel/py-pytz
py27-pyzmq-15.2.0              net/py-pyzmq
py27-requests-2.9.1            www/py-requests
py27-salt-2015.8.7             sysutils/py-salt
py27-setuptools27-20.0         devel/py-setuptools27
py27-singledispatch-3.4.0.3    devel/py-singledispatch
py27-six-1.10.0                devel/py-six
py27-tornado-4.3               www/py-tornado
py27-yaml-3.11                 devel/py-yaml
python2-2_3                    lang/python2
python27-2.7.11_1              lang/python27
[DEBUG   ] Could not LazyLoad pkg.normalize_name
[DEBUG   ] Could not LazyLoad pkg.check_db
[DEBUG   ] Could not LazyLoad pkg.check_extra_requirements
[DEBUG   ] Could not LazyLoad pkg.version_clean
[DEBUG   ] Could not LazyLoad pkg.version_cmp
[DEBUG   ] Current version ({'origin': 'net/openntpd', 'version': ['5.9p1,2']}) did not match desired version specification (5.9p1,2), adding to installation targets
[DEBUG   ] Could not LazyLoad pkg.normalize_name
[INFO    ] Executing command 'pkg install  -y openntpd-5.9p1,2' in directory '/root'
[TRACE   ] output: Updating FreeBSD repository catalogue...
FreeBSD repository is up-to-date.
All repositories are up-to-date.
Checking integrity... done (0 conflicting)
The most recent version of packages are already installed
[INFO    ] Executing command 'pkg info -ao' in directory '/root'
[TRACE   ] stdout: ca_root_nss-3.22.2             security/ca_root_nss
gettext-runtime-0.19.7         devel/gettext-runtime
gmp-5.1.3_3                    math/gmp
indexinfo-0.2.4                print/indexinfo
libasr-1.0.2                   dns/libasr
libevent2-2.0.22_1             devel/libevent2
libffi-3.2.1                   devel/libffi
libressl-devel-2.3.3           security/libressl-devel
libsodium-1.0.3                security/libsodium
libzmq4-4.1.4                  net/libzmq4
mosh-1.2.5                     net/mosh
nano-2.4.3                     editors/nano
openntpd-5.9p1,2               net/openntpd
openpgm-5.2.122_2              net/openpgm
perl5-5.20.3_8                 lang/perl5.20
pkg-1.7.2                      ports-mgmt/pkg
protobuf-2.6.1                 devel/protobuf
py27-Babel-2.2.0_1             devel/py-babel
py27-Jinja2-2.8                devel/py-Jinja2
py27-MarkupSafe-0.23           textproc/py-MarkupSafe
py27-backports_abc-0.4         devel/py-backports_abc
py27-botocore-1.3.17           devel/py-botocore
py27-certifi-2015.11.20        security/py-certifi
py27-dateutil-2.5.0            devel/py-dateutil
py27-docutils-0.12             textproc/py-docutils
py27-enum34-1.0.4              devel/py-enum34
py27-futures-3.0.5             devel/py-futures
py27-jmespath-0.9.0            devel/py-jmespath
py27-libcloud-0.20.1           net/py-libcloud
py27-msgpack-python-0.4.7      devel/py-msgpack-python
py27-progressbar-2.3           misc/py-progressbar
py27-pycrypto-2.6.1_1          security/py-pycrypto
py27-pytz-2015.7,1             devel/py-pytz
py27-pyzmq-15.2.0              net/py-pyzmq
py27-requests-2.9.1            www/py-requests
py27-salt-2015.8.7             sysutils/py-salt
py27-setuptools27-20.0         devel/py-setuptools27
py27-singledispatch-3.4.0.3    devel/py-singledispatch
py27-six-1.10.0                devel/py-six
py27-tornado-4.3               www/py-tornado
py27-yaml-3.11                 devel/py-yaml
python2-2_3                    lang/python2
python27-2.7.11_1              lang/python27
[DEBUG   ] Could not LazyLoad pkg.hold
[DEBUG   ] Could not LazyLoad pkg.version_clean
[DEBUG   ] Could not LazyLoad pkg.version_cmp
[ERROR   ] The following packages failed to install/update: openntpd=5.9p1,2
[INFO    ] Completed state [openntpd] at time 22:15:49.537007
[DEBUG   ] LazyLoaded service.running
[DEBUG   ] File /var/cache/salt/minion/accumulator/34575015696 does not exist, no need to cleanup.
[DEBUG   ] Initializing new AsyncZeroMQReqChannel for ('/usr/local/etc/salt/pki/minion', 'mx.kostej.cupka.name', 'tcp://37.187.110.20:4506', 'aes')
[DEBUG   ] Initializing new SAuth for ('/usr/local/etc/salt/pki/minion', 'mx.kostej.cupka.name', 'tcp://37.187.110.20:4506')
[DEBUG   ] LazyLoaded highstate.output
[TRACE   ] data = {'local': {'pkg_|-ntp_|-openntpd_|-installed': {'comment': u'The following packages failed to install/update: openntpd=5.9p1,2', 'name': 'openntpd', 'start_time': '22:15:48.438211'
, 'result': False, 'duration': u'1098.796 ms', '__run_num__': 0, 'changes': {}}, 'service_|-ntp_|-openntpd_|-running': {'comment': u'One or more requisite failed: ntp.ntp', 'start_time': u'', 'resu
lt': False, 'duration': u'', '__run_num__': 1, '__sls__': u'ntp', 'changes': {}}}}
local:
----------
          ID: ntp
    Function: pkg.installed
        Name: openntpd
      Result: False
     Comment: The following packages failed to install/update: openntpd=5.9p1,2
     Started: 22:15:48.438211
    Duration: 1098.796 ms
     Changes:   
----------
          ID: ntp
    Function: service.running
        Name: openntpd
      Result: False
     Comment: One or more requisite failed: ntp.ntp
     Started: 
    Duration: 
     Changes:   

Summary for local
------------
Succeeded: 0
Failed:    2
------------
Total states run:     2
UtahDave commented 8 years ago

Can you manually install that exact version of openntpd on your freebsd box?

palica commented 8 years ago 
[INFO    ] Executing state pkg.installed for openntpd
[INFO    ] Executing command 'pkg info -ao' in directory '/root'
[INFO    ] Executing command 'pkg install  -y openntpd-5.7p4_2,2' in directory '/root'
[INFO    ] Executing command 'pkg info -ao' in directory '/root'
[ERROR   ] The following packages failed to install/update: openntpd=5.7p4_2,2
[INFO    ] Completed state [openntpd] at time 18:32:08.447866
local:
----------
          ID: ntp
    Function: pkg.installed
        Name: openntpd
      Result: False
     Comment: The following packages failed to install/update: openntpd=5.7p4_2,2
     Started: 18:32:07.053822
    Duration: 1394.044 ms
     Changes:   
----------
          ID: ntp
    Function: service.running
        Name: openntpd
      Result: False
     Comment: One or more requisite failed: test.ntp
     Started: 
    Duration: 
     Changes:   

Summary for local
------------
Succeeded: 0
Failed:    2
------------
Total states run:     2
root@kos:/usr/ports/net/openntpd # pkg install  -y openntpd-5.7p4_2,2
Updating FreeBSD repository catalogue...
FreeBSD repository is up-to-date.
All repositories are up-to-date.
Checking integrity... done (0 conflicting)
The most recent version of packages are already installed
Chlytor commented 8 years ago

This is an old bug. It's been a while since I looked into it but IIRC the pkg module is expecting a full origin (www/apache24) but the pkgng module returns just the port name (apache24).

The following one line patch fixes the problem but you must use the origin in your sls files:

--- salt/modules/pkgng.py.orig  2014-11-28 17:29:54 UTC
+++ salt/modules/pkgng.py
@@ -336,6 +336,7 @@ def list_pkgs(versions_as_list=False,
         try:
             pkg, origin = line.split()
             pkgname, pkgver = pkg.rsplit('-', 1)
+       pkgname = origin
         except ValueError:
             continue
         __salt__['pkg_resource.add_pkg'](ret, pkgname, pkgver)
jfindlay commented 8 years ago

@Chlytor, is there a way to determine the origin from the shortened package name? This is possible with gentoo portage, for example, unless the shortened package name is not unique across all origins.

Chlytor commented 8 years ago

Not always, but in this case the package name and origin are both known and the package has been successfully installed. The error is just a mismatch between expected and actual return values.

Again it's been a while since I looked at the code but my workaround still works in current versions.

jfindlay commented 8 years ago

@Chlytor, thanks. You are welcome to submit a pull request.

melvyn-sopacua commented 8 years ago

Not sure it's the right fix and also quite weird how and what is built up here.

I'll look deeper this weekend, but on first glance, creating a dict origins[origin] = origin doesn't seem to be a fruitful operation or a datamodel in need of refactoring at best.

Based upon above, the better fix is probably to pass origin to pkg_resource.add_pkg and leave pkgname alone. However, I think the real bug is more about "how to invoke the tool with what information to get it to do what you want".

There's more evidence of that in the module, since it doesn't use the query command at all - the command that can provide machine-readable output. So far have come up with the diff below, but I'll continue this weekend.

     ret = {}
     origins = {}
     out = __salt__['cmd.run_stdout'](
-        _pkg(jail, chroot, root) + ['info', '-ao'],
+        _pkg(jail, chroot, root) + ['query', '%o|%n|%v'],
         output_loglevel='trace',
         python_shell=False)
     for line in salt.utils.itertools.split(out, '\n'):
         if not line:
             continue
         try:
-            pkg, origin = line.split()
-            pkgname, pkgver = pkg.rsplit('-', 1)
+            origin, pkgname, pkgver = line.split('|')
         except ValueError:
             continue
-        __salt__['pkg_resource.add_pkg'](ret, pkgname, pkgver)
+        __salt__['pkg_resource.add_pkg'](ret, origin, pkgver)
         origins[pkgname] = origin

     __salt__['pkg_resource.sort_pkglist'](ret)
kev009 commented 8 years ago

Can you check if https://github.com/saltstack/salt/pull/36550 takes care of this?

palica commented 7 years ago

Well this is what I get:

salt-call state.sls test [WARNING ] /usr/local/lib/python2.7/site-packages/salt/grains/core.py:1493: DeprecationWarning: The "osmajorrelease" will be a type of an integer.

[ERROR ] Made the following changes: 'tmux' changed from 'absent' to '2.3' 'libevent2' changed from 'absent' to '2.0.22_1'

local:

      ID: tmux
Function: pkg.installed
  Result: False
 Comment: The following packages failed to install/update: tmux=2.3
 Started: 13:06:25.725305
Duration: 5013.231 ms
 Changes:
          ----------
          libevent2:
              ----------
              new:
                  2.0.22_1
              old:
          tmux:
              ----------
              new:
                  2.3
              old:

Summary for local

Succeeded: 0 (changed=1)

Failed: 1

Total states run: 1 Total run time: 5.013 s

and running for second time:

salt-call state.sls test [WARNING ] /usr/local/lib/python2.7/site-packages/salt/grains/core.py:1493: DeprecationWarning: The "osmajorrelease" will be a type of an integer.

[ERROR ] The following packages failed to install/update: tmux=2.3

local:

      ID: tmux
Function: pkg.installed
  Result: False
 Comment: The following packages failed to install/update: tmux=2.3
 Started: 13:08:57.089866
Duration: 1301.813 ms
 Changes:

Summary for local

Succeeded: 0

Failed: 1

Total states run: 1 Total run time: 1.302 s

Tmux is nevertheless installed and works fine. local: 2016.3.3

palica commented 7 years ago

but I am using salt 2016.3.3 on both the master and minion, I didn't apply your patch manualy. So what I am trying to say is: I hope your patch has made it into 2016.3.3 release.

thanks pavol

stale[bot] commented 6 years ago

This issue has been automatically marked as stale because it has not had recent activity. It will be closed if no further activity occurs. Thank you for your contributions.

If this issue is closed prematurely, please leave a comment and we will gladly reopen the issue.