Skip to content

Cannot perform relative import error #672

New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Closed
m8mble opened this issue Nov 29, 2019 · 33 comments · Fixed by #719
Closed

Cannot perform relative import error #672

m8mble opened this issue Nov 29, 2019 · 33 comments · Fixed by #719

Comments

@m8mble
Copy link

m8mble commented Nov 29, 2019

I'm encountering the following errors upon gathering facts:

fatal: [thehost.domain.internal]: FAILED! => changed=false
  ansible_facts: {}
  failed_modules:
    setup:
      exception: |-
        Traceback (most recent call last):
          File "master:/Users/m8mble/software/mitogen/ansible_mitogen/runner.py", line 975, in _run
            self._run_code(code, mod)
          File "master:/Users/m8mble/software/mitogen/ansible_mitogen/runner.py", line 939, in _run_code
            exec(code, vars(mod))
          File "master:/usr/local/Cellar/ansible/2.9.1/libexec/lib/python3.7/site-packages/ansible/modules/system/setup.py", line 134, in <module>
        SystemError: Parent module 'ansible.modules.system' not loaded, cannot perform relative import
      failed: true
      module_stderr: |-
        Traceback (most recent call last):
          File "master:/Users/m8mble/software/mitogen/ansible_mitogen/runner.py", line 975, in _run
            self._run_code(code, mod)
          File "master:/Users/m8mble/software/mitogen/ansible_mitogen/runner.py", line 939, in _run_code
            exec(code, vars(mod))
          File "master:/usr/local/Cellar/ansible/2.9.1/libexec/lib/python3.7/site-packages/ansible/modules/system/setup.py", line 134, in <module>
        SystemError: Parent module 'ansible.modules.system' not loaded, cannot perform relative import
      module_stdout: ''
      msg: |-
        MODULE FAILURE
        See stdout/stderr for the exact error
      rc: 1
  msg: |-
    The following modules failed to execute: setup

More details from -vvv below. Running without mitogen in contrast works fine.

Running brew "latest" ansible:

ansible 2.9.1
  config file = /Users/m8mble/.ansible.cfg
  configured module search path = ['/Users/m8mble/.ansible/plugins/modules', '/usr/share/ansible/plugins/modules']
  ansible python module location = /usr/local/Cellar/ansible/2.9.1/libexec/lib/python3.7/site-packages/ansible
  executable location = /usr/local/bin/ansible
  python version = 3.7.5 (default, Nov  1 2019, 02:16:32) [Clang 11.0.0 (clang-1100.0.33.8)]

Configuration (relevant parts):

timeout = 100
strategy_plugins = ~/software/mitogen/ansible_mitogen/plugins/strategy
strategy = mitogen_linear
retry_files_enabled = False
gathering = smart
gather_subset=!hardware
stdout_callback = yaml
bin_ansible_callbacks = True

where ~/software/mitogen is a clone on master (i.e. c289b1699da075e6f4eb581eb8f42c7fddba176e as of writing this).

Host:

Python 2.7.10; Python 3.7.5
Darwin 18.7.0 Darwin Kernel Version 18.7.0 (MacOS 10.14.6 Mojave)

Target:

Python 2.7.12; Python 3.5.2
Linux 4.4.0-165-generic (Ubuntu 16.04.6 LTS)

Output of ansible-config dump --only-changed:

ANSIBLE_PIPELINING(/Users/m8mble/.ansible.cfg) = True
DEFAULT_GATHERING(/Users/m8mble/.ansible.cfg) = smart
DEFAULT_GATHER_SUBSET(/Users/m8mble/.ansible.cfg) = ['!hardware']
DEFAULT_HOST_LIST(/Users/m8mble/.ansible.cfg) = ['/Users/m8mble/work/ansible/inventory/inventory.yml']
DEFAULT_LOAD_CALLBACK_PLUGINS(/Users/m8mble/.ansible.cfg) = True
DEFAULT_ROLES_PATH(/Users/m8mble/.ansible.cfg) = ['/Users/m8mble/work/ansible/roles']
DEFAULT_STDOUT_CALLBACK(/Users/m8mble/.ansible.cfg) = yaml
DEFAULT_TIMEOUT(/Users/m8mble/.ansible.cfg) = 100
DEFAULT_VAULT_PASSWORD_FILE(/Users/m8mble/.ansible.cfg) = /Users/m8mble/work/.vault
DISPLAY_SKIPPED_HOSTS(/Users/m8mble/.ansible.cfg) = True
HOST_KEY_CHECKING(/Users/m8mble/.ansible.cfg) = False
RETRY_FILES_ENABLED(/Users/m8mble/.ansible.cfg) = False

The error with -vvv and more context:

[...]
[mux  7150] 09:50:39.721654 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.basic
[mux  7150] 09:50:39.750983 D mitogen.importer.[ssh.192.168.0.82]: systemd.journal is submodule of a locally loaded package
[mux  7150] 09:50:39.752537 D mitogen.importer.[ssh.192.168.0.82]: ctypes.util is submodule of a locally loaded package
[mux  7150] 09:50:39.761576 D mitogen.importer.[ssh.192.168.0.82]: systemd._journal is submodule of a locally loaded package
[mux  7150] 09:50:39.764754 D mitogen.importer.[ssh.192.168.0.82]: systemd._reader is submodule of a locally loaded package
[mux  7150] 09:50:39.765635 D mitogen.importer.[ssh.192.168.0.82]: systemd.id128 is submodule of a locally loaded package
[mux  7150] 09:50:39.766386 D mitogen.importer.[ssh.192.168.0.82]: requesting selinux
[mux  7150] 09:50:39.766947 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils._text
[mux  7150] 09:50:39.767485 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.six
[mux  7150] 09:50:39.779510 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.common
[mux  7150] 09:50:39.780130 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.common.text
[mux  7150] 09:50:39.780888 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.common.text.converters
[mux  7150] 09:50:39.782342 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.common._collections_compat
[mux  7150] 09:50:39.783011 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.common.text.formatters
[mux  7150] 09:50:39.783558 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.common._json_compat
[mux  7150] 09:50:39.784051 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.common.process
[mux  7150] 09:50:39.784544 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.common.file
[mux  7150] 09:50:39.785405 D mitogen.importer.[ssh.192.168.0.82]: requesting selinux
[mux  7150] 09:50:39.785939 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.common.sys_info
[mux  7150] 09:50:39.786967 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.distro
[mux  7150] 09:50:39.789535 D mitogen.importer.[ssh.192.168.0.82]: requesting distro
[mux  7150] 09:50:39.790382 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.distro._distro
[mux  7150] 09:50:39.798909 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.common._utils
[mux  7150] 09:50:39.799751 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.pycompat24
[mux  7150] 09:50:39.800471 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.common.parameters
[mux  7150] 09:50:39.804637 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.common.collections
[mux  7150] 09:50:39.805537 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.common.validation
[mux  7150] 09:50:39.807562 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.parsing
[mux  7150] 09:50:39.809831 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.parsing.convert_bool
[mux  7150] 09:50:39.810681 D mitogen.importer.[ssh.192.168.0.82]: ansible.module_utils.six has no submodule moves
[mux  7150] 09:50:39.811387 D ansible_mitogen.runner.[ssh.192.168.0.82]: EnvironmentFileWatcher('/home/m8mble/.pam_environment') installed; existing keys: []
[mux  7150] 09:50:39.812176 D ansible_mitogen.runner.[ssh.192.168.0.82]: EnvironmentFileWatcher('/etc/environment') installed; existing keys: [b'PATH']
[mux  7150] 09:50:39.812775 D mitogen.parent.[ssh.192.168.0.82]: upgraded Poller with EpollPoller (new: 4 readers, 0 writers; old: 4 readers, 0 writers)
[mux  7150] 09:50:39.813290 D mitogen.parent.[ssh.192.168.0.82]: upgrading Router(Broker(c7b8)) with capabilities to start new children
[mux  7150] 09:50:39.813775 D mitogen.[ssh.192.168.0.82]: sending message to Context(0, 'master'): Message(0, 2, 2, 105, 1000, ''..0)
[mux  7150] 09:50:39.814272 D mitogen: IdAllocator(Router(Broker(b4d0))): allocating [3..1003)
[mux  7150] 09:50:39.814766 D mitogen: IdAllocator(Router(Broker(b4d0))): allocating [3..1003) to Context(2, 'ssh.192.168.0.82')
[mux  7150] 09:50:39.843465 D mitogen.parent.[ssh.192.168.0.82]: creating connection to context 3 using mitogen.fork
[mux  7150] 09:50:39.846356 D mitogen.parent.[ssh.192.168.0.82]: child for Connection(None) started: pid:113547 stdin:14 stdout:14 stderr:None
[mux  7150] 09:50:39.849821 D mitogen.parent.[ssh.192.168.0.82]: BootstrapProtocol(fork.113547): new child booted successfully
[mux  7150] 09:50:39.851133 D mitogen.[ssh.192.168.0.82]: Router(Broker(c7b8)): registering Context(3, 'fork.113547') to stream <Stream fork.113547 #8400>
[mux  7150] 09:50:39.852114 D mitogen.route_monitor: Adding route to 3 via <Stream ssh.192.168.0.82 #8f90>
[mux  7150] 09:50:39.852764 D mitogen.parent: Router(Broker(b4d0)): adding route to context 3 via <Stream ssh.192.168.0.82 #8f90>
[mux  7150] 09:50:39.855017 D mitogen.[fork.113547]: Router(Broker(1eb8)): registering Context(2, 'parent') to stream <Stream parent #1390>
[mux  7150] 09:50:39.855920 D mitogen.[fork.113547]: Python version is 3.5.2 (default, Jul 10 2019, 11:58:48)
[GCC 5.4.0 20160609]
[mux  7150] 09:50:39.856603 D mitogen.[fork.113547]: Parent is context 2 (parent); my ID is 3
[mux  7150] 09:50:39.857131 D mitogen.[fork.113547]: pid:113547 ppid:113539 uid:1121/1121, gid:100/100 host:'thehost'
[mux  7150] 09:50:39.857659 D mitogen.[fork.113547]: Recovered sys.executable: '/usr/bin/python3'
[mux  7150] 09:50:39.858172 D ansible_mitogen.target.[ssh.192.168.0.82]: Selected temp directory: '/home/m8mble/.ansible/tmp' (from ['/home/m8mble/.ansible/tmp', '/var/tmp', '/tmp', '/tmp', '/var/tmp', '/usr/tmp', '/home/m8mble'])
[mux  7150] 09:50:39.858656 D mitogen.[ssh.192.168.0.82]: Dispatcher: Message(2, 0, 0, 101, 1000, b'\x80\x02(NX\x16\x00\x00\x00ansible_mitogen.targetq\x00NX\n\x00\x00\x00init_childq'..186) -> {'home_dir': '/home/m8mble', 'good_temp_dir': '/home/m8mble/.ansible/tmp', 'fork_context': Context(3, 'fork.113547')}
[task 7151] 09:50:39.860675 D ansible_mitogen.planner: <class 'ansible_mitogen.planner.BinaryPlanner'> rejected 'setup'
[task 7151] 09:50:39.861192 D ansible_mitogen.planner: <class 'ansible_mitogen.planner.NewStylePlanner'> accepted 'setup' (filename '/usr/local/Cellar/ansible/2.9.1/libexec/lib/python3.7/site-packages/ansible/modules/system/setup.py')
[mux  7150] 09:50:39.944767 D mitogen.service: caching small file /usr/local/Cellar/ansible/2.9.1/libexec/lib/python3.7/site-packages/ansible/modules/system/setup.py
[mux  7150] 09:50:39.945143 D mitogen.service: requesting Context(2, 'ssh.192.168.0.82') cache and forward small file to Context(2, 'ssh.192.168.0.82'): /usr/local/Cellar/ansible/2.9.1/libexec/lib/python3.7/site-packages/ansible/modules/system/setup.py
[task 7151] 09:50:39.946221 D mitogen.parent: starting function call to ssh.192.168.0.82: ansible_mitogen.target.run_module(kwargs={'runner_name': 'NewStyleRunner', 'module': 'setup', 'path': '/usr/local/Cellar/ansible/2.9.1/libexec/lib/python3.7/site-packages/ansible/modules/system/setup.py', 'json_args': '{"gather_subset": ["!hardware"], "gather_timeout": 10, "_ansible_check_mode": true, "_ansible_no_log": false, "_ansible_debug": false, "_ansible_diff": true, "_ansible_verbosity": 3, "_ansible_version": "2.9.1", "_ansible_module_name": "setup", "_ansible_syslog_facility": "LOG_USER", "_ansible_selinux_special_fs": ["fuse", "nfs", "vboxsf", "ramfs", "9p", "vfat"], "_ansible_string_conversion_action": "warn", "_ansible_socket": null, "_ansible_shell_executable": "/bin/sh", "_ansible_keep_remote_files": false, "_ansible_tmpdir": null, "_ansible_remote_tmp": "/home/m8mble/.ansible/tmp"}', 'env': {}, 'interpreter_fragment': None, 'is_python': None, 'module_map': {'builtin': ['ansible.module_utils._text', 'ansible.module_utils.common', 'ansible.module_utils.common._utils', 'ansible.module_utils.common.file', 'ansible.module_utils.common.process', 'ansible.module_utils.common.sys_info', 'ansible.module_utils.common.text', 'ansible.module_utils.common.text.formatters', 'ansible.module_utils.distro', 'ansible.module_utils.distro._distro', 'ansible.module_utils.facts', 'ansible.module_utils.facts.ansible_collector', 'ansible.module_utils.facts.collector', 'ansible.module_utils.facts.compat', 'ansible.module_utils.facts.default_collectors', 'ansible.module_utils.facts.hardware', 'ansible.module_utils.facts.hardware.aix', 'ansible.module_utils.facts.hardware.base', 'ansible.module_utils.facts.hardware.darwin', 'ansible.module_utils.facts.hardware.dragonfly', 'ansible.module_utils.facts.hardware.freebsd', 'ansible.module_utils.facts.hardware.hpux', 'ansible.module_utils.facts.hardware.hurd', 'ansible.module_utils.facts.hardware.linux', 'ansible.module_utils.facts.hardware.netbsd', 'ansible.module_utils.facts.hardware.openbsd', 'ansible.module_utils.facts.hardware.sunos', 'ansible.module_utils.facts.namespace', 'ansible.module_utils.facts.network', 'ansible.module_utils.facts.network.aix', 'ansible.module_utils.facts.network.base', 'ansible.module_utils.facts.network.darwin', 'ansible.module_utils.facts.network.dragonfly', 'ansible.module_utils.facts.network.fc_wwn', 'ansible.module_utils.facts.network.freebsd', 'ansible.module_utils.facts.network.generic_bsd', 'ansible.module_utils.facts.network.hpux', 'ansible.module_utils.facts.network.hurd', 'ansible.module_utils.facts.network.iscsi', 'ansible.module_utils.facts.network.linux', 'ansible.module_utils.facts.network.netbsd', 'ansible.module_utils.facts.network.nvme', 'ansible.module_utils.facts.network.openbsd', 'ansible.module_utils.facts.network.sunos', 'ansible.module_utils.facts.other', 'ansible.module_utils.facts.other.facter', 'ansible.module_utils.facts.other.ohai', 'ansible.module_utils.facts.sysctl', 'ansible.module_utils.facts.system', 'ansible.module_utils.facts.system.apparmor', 'ansible.module_utils.facts.system.caps', 'ansible.module_utils.facts.system.chroot', 'ansible.module_utils.facts.system.cmdline', 'ansible.module_utils.facts.system.date_time', 'ansible.module_utils.facts.system.distribution', 'ansible.module_utils.facts.system.dns', 'ansible.module_utils.facts.system.env', 'ansible.module_utils.facts.system.fips', 'ansible.module_utils.facts.system.local', 'ansible.module_utils.facts.system.lsb', 'ansible.module_utils.facts.system.pkg_mgr', 'ansible.module_utils.facts.system.platform', 'ansible.module_utils.facts.system.python', 'ansible.module_utils.facts.system.selinux', 'ansible.module_utils.facts.system.service_mgr', 'ansible.module_utils.facts.system.ssh_pub_keys', 'ansible.module_utils.facts.system.user', 'ansible.module_utils.facts.timeout', 'ansible.module_utils.facts.utils', 'ansible.module_utils.facts.virtual', 'ansible.module_utils.facts.virtual.base', 'ansible.module_utils.facts.virtual.dragonfly', 'ansible.module_utils.facts.virtual.freebsd', 'ansible.module_utils.facts.virtual.hpux', 'ansible.module_utils.facts.virtual.linux', 'ansible.module_utils.facts.virtual.netbsd', 'ansible.module_utils.facts.virtual.openbsd', 'ansible.module_utils.facts.virtual.sunos', 'ansible.module_utils.facts.virtual.sysctl', 'ansible.module_utils.six'], 'custom': []}, 'py_module_name': 'ansible.modules.system.setup', 'good_temp_dir': '/home/m8mble/.ansible/tmp', 'cwd': None, 'extra_env': None, 'emulate_tty': True, 'service_context': Context(0, None)})
[mux  7150] 09:50:39.979848 D mitogen.service.[ssh.192.168.0.82]: PushFileService().store_and_forward('/usr/local/Cellar/ansible/2.9.1/libexec/lib/python3.7/site-packages/ansible/modules/system/setup.py', [blob: 8084 bytes], Context(2, 'ssh.192.168.0.82')) 'mitogen.Pool.c6a0.0'
[mux  7150] 09:50:39.981041 D mitogen.service.[ssh.192.168.0.82]: Pool(c6a0, size=2, th='MainThread'): initialized
[mux  7150] 09:50:39.983131 D mitogen.[ssh.192.168.0.82]: Dispatcher: dispatching ('mckenzie.local-7151-1121a45c0-35706d', 'ansible_mitogen.target', None, 'run_module', (), Kwargs({'kwargs': {'interpreter_fragment': None, 'json_args': '{"gather_subset": ["!hardware"], "gather_timeout": 10, "_ansible_check_mode": true, "_ansible_no_log": false, "_ansible_debug": false, "_ansible_diff": true, "_ansible_verbosity": 3, "_ansible_version": "2.9.1", "_ansible_module_name": "setup", "_ansible_syslog_facility": "LOG_USER", "_ansible_selinux_special_fs": ["fuse", "nfs", "vboxsf", "ramfs", "9p", "vfat"], "_ansible_string_conversion_action": "warn", "_ansible_socket": null, "_ansible_shell_executable": "/bin/sh", "_ansible_keep_remote_files": false, "_ansible_tmpdir": null, "_ansible_remote_tmp": "/home/m8mble/.ansible/tmp"}', 'good_temp_dir': '/home/m8mble/.ansible/tmp', 'cwd': None, 'extra_env': None, 'emulate_tty': True, 'module': 'setup', 'env': {}, 'service_context': Context(0, 'master'), 'path': '/usr/local/Cellar/ansible/2.9.1/libexec/lib/python3.7/site-packages/ansible/modules/system/setup.py', 'runner_name': 'NewStyleRunner', 'py_module_name': 'ansible.modules.system.setup', 'module_map': {'builtin': ['ansible.module_utils._text', 'ansible.module_utils.common', 'ansible.module_utils.common._utils', 'ansible.module_utils.common.file', 'ansible.module_utils.common.process', 'ansible.module_utils.common.sys_info', 'ansible.module_utils.common.text', 'ansible.module_utils.common.text.formatters', 'ansible.module_utils.distro', 'ansible.module_utils.distro._distro', 'ansible.module_utils.facts', 'ansible.module_utils.facts.ansible_collector', 'ansible.module_utils.facts.collector', 'ansible.module_utils.facts.compat', 'ansible.module_utils.facts.default_collectors', 'ansible.module_utils.facts.hardware', 'ansible.module_utils.facts.hardware.aix', 'ansible.module_utils.facts.hardware.base', 'ansible.module_utils.facts.hardware.darwin', 'ansible.module_utils.facts.hardware.dragonfly', 'ansible.module_utils.facts.hardware.freebsd', 'ansible.module_utils.facts.hardware.hpux', 'ansible.module_utils.facts.hardware.hurd', 'ansible.module_utils.facts.hardware.linux', 'ansible.module_utils.facts.hardware.netbsd', 'ansible.module_utils.facts.hardware.openbsd', 'ansible.module_utils.facts.hardware.sunos', 'ansible.module_utils.facts.namespace', 'ansible.module_utils.facts.network', 'ansible.module_utils.facts.network.aix', 'ansible.module_utils.facts.network.base', 'ansible.module_utils.facts.network.darwin', 'ansible.module_utils.facts.network.dragonfly', 'ansible.module_utils.facts.network.fc_wwn', 'ansible.module_utils.facts.network.freebsd', 'ansible.module_utils.facts.network.generic_bsd', 'ansible.module_utils.facts.network.hpux', 'ansible.module_utils.facts.network.hurd', 'ansible.module_utils.facts.network.iscsi', 'ansible.module_utils.facts.network.linux', 'ansible.module_utils.facts.network.netbsd', 'ansible.module_utils.facts.network.nvme', 'ansible.module_utils.facts.network.openbsd', 'ansible.module_utils.facts.network.sunos', 'ansible.module_utils.facts.other', 'ansible.module_utils.facts.other.facter', 'ansible.module_utils.facts.other.ohai', 'ansible.module_utils.facts.sysctl', 'ansible.module_utils.facts.system', 'ansible.module_utils.facts.system.apparmor', 'ansible.module_utils.facts.system.caps', 'ansible.module_utils.facts.system.chroot', 'ansible.module_utils.facts.system.cmdline', 'ansible.module_utils.facts.system.date_time', 'ansible.module_utils.facts.system.distribution', 'ansible.module_utils.facts.system.dns', 'ansible.module_utils.facts.system.env', 'ansible.module_utils.facts.system.fips', 'ansible.module_utils.facts.system.local', 'ansible.module_utils.facts.system.lsb', 'ansible.module_utils.facts.system.pkg_mgr', 'ansible.module_utils.facts.system.platform', 'ansible.module_utils.facts.system.python', 'ansible.module_utils.facts.system.selinux', 'ansible.module_utils.facts.system.service_mgr', 'ansible.module_utils.facts.system.ssh_pub_keys', 'ansible.module_utils.facts.system.user', 'ansible.module_utils.facts.timeout', 'ansible.module_utils.facts.utils', 'ansible.module_utils.facts.virtual', 'ansible.module_utils.facts.virtual.base', 'ansible.module_utils.facts.virtual.dragonfly', 'ansible.module_utils.facts.virtual.freebsd', 'ansible.module_utils.facts.virtual.hpux', 'ansible.module_utils.facts.virtual.linux', 'ansible.module_utils.facts.virtual.netbsd', 'ansible.module_utils.facts.virtual.openbsd', 'ansible.module_utils.facts.virtual.sunos', 'ansible.module_utils.facts.virtual.sysctl', 'ansible.module_utils.six'], 'custom': []}, 'is_python': None}}))
[mux  7150] 09:50:39.984023 D mitogen.importer.[ssh.192.168.0.82]: ansible.module_utils.common has no submodule
[mux  7150] 09:50:39.984716 D mitogen.importer.[ssh.192.168.0.82]: ansible.module_utils.common.text has no submodule
[mux  7150] 09:50:39.985525 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.facts
[mux  7150] 09:50:39.986260 D mitogen.importer.[ssh.192.168.0.82]: sending new ansible.module_utils.facts request to parent
[mux  7150] 09:50:39.986922 D mitogen.responder: ssh.192.168.0.82 requested module ansible.module_utils.facts
[mux  7150] 09:50:39.988986 D mitogen.responder: ansible.module_utils.facts is a package at /usr/local/Cellar/ansible/2.9.1/libexec/lib/python3.7/site-packages/ansible/module_utils/facts/__init__.py with submodules ['ansible_collector', 'collector', 'compat', 'default_collectors', 'hardware', 'namespace', 'network', 'other', 'packages', 'sysctl', 'system', 'timeout', 'utils', 'virtual']
[mux  7150] 09:50:40.037828 D mitogen.responder: sending ansible.module_utils.facts.ansible_collector (6.88 KiB) to ssh.192.168.0.82
[mux  7150] 09:50:40.040258 D mitogen.responder: sending ansible.module_utils.facts.collector (9.94 KiB) to ssh.192.168.0.82
[mux  7150] 09:50:40.041565 D mitogen.responder: sending ansible.module_utils.facts.compat (6.18 KiB) to ssh.192.168.0.82
[mux  7150] 09:50:40.042708 D mitogen.responder: sending ansible.module_utils.facts.default_collectors (6.68 KiB) to ssh.192.168.0.82
[mux  7150] 09:50:40.043344 D mitogen.responder: ansible.module_utils.facts.hardware is a package at /usr/local/Cellar/ansible/2.9.1/libexec/lib/python3.7/site-packages/ansible/module_utils/facts/hardware/__init__.py with submodules ['aix', 'base', 'darwin', 'dragonfly', 'freebsd', 'hpux', 'hurd', 'linux', 'netbsd', 'openbsd', 'sunos']
[mux  7150] 09:50:40.044183 D mitogen.responder: sending ansible.module_utils.facts.hardware (3.94 KiB) to ssh.192.168.0.82
[mux  7150] 09:50:40.045926 D mitogen.responder: sending ansible.module_utils.facts.hardware.aix (7.73 KiB) to ssh.192.168.0.82
[mux  7150] 09:50:40.046968 D mitogen.responder: sending ansible.module_utils.facts.hardware.base (5.73 KiB) to ssh.192.168.0.82
[mux  7150] 09:50:40.048127 D mitogen.responder: sending ansible.module_utils.facts.hardware.darwin (6.24 KiB) to ssh.192.168.0.82
[mux  7150] 09:50:40.049088 D mitogen.responder: sending ansible.module_utils.facts.hardware.dragonfly (4.66 KiB) to ssh.192.168.0.82
[mux  7150] 09:50:40.050367 D mitogen.responder: sending ansible.module_utils.facts.hardware.freebsd (7.10 KiB) to ssh.192.168.0.82
[mux  7150] 09:50:40.051777 D mitogen.responder: sending ansible.module_utils.facts.hardware.hpux (6.80 KiB) to ssh.192.168.0.82
[mux  7150] 09:50:40.052676 D mitogen.responder: sending ansible.module_utils.facts.hardware.hurd (4.93 KiB) to ssh.192.168.0.82
[mux  7150] 09:50:40.056858 D mitogen.responder: sending ansible.module_utils.facts.hardware.linux (15.87 KiB) to ssh.192.168.0.82
[mux  7150] 09:50:40.058021 D mitogen.responder: sending ansible.module_utils.facts.hardware.netbsd (6.61 KiB) to ssh.192.168.0.82
[mux  7150] 09:50:40.059238 D mitogen.responder: sending ansible.module_utils.facts.hardware.openbsd (7.09 KiB) to ssh.192.168.0.82
[mux  7150] 09:50:40.060765 D mitogen.responder: sending ansible.module_utils.facts.hardware.sunos (8.76 KiB) to ssh.192.168.0.82
[mux  7150] 09:50:40.061717 D mitogen.responder: sending ansible.module_utils.facts.namespace (5.49 KiB) to ssh.192.168.0.82
[mux  7150] 09:50:40.062370 D mitogen.responder: ansible.module_utils.facts.network is a package at /usr/local/Cellar/ansible/2.9.1/libexec/lib/python3.7/site-packages/ansible/module_utils/facts/network/__init__.py with submodules ['aix', 'base', 'darwin', 'dragonfly', 'fc_wwn', 'freebsd', 'generic_bsd', 'hpux', 'hurd', 'iscsi', 'linux', 'netbsd', 'nvme', 'openbsd', 'sunos']
[mux  7150] 09:50:40.063180 D mitogen.responder: sending ansible.module_utils.facts.network (3.99 KiB) to ssh.192.168.0.82
[mux  7150] 09:50:40.064389 D mitogen.responder: sending ansible.module_utils.facts.network.aix (6.25 KiB) to ssh.192.168.0.82
[mux  7150] 09:50:40.065355 D mitogen.responder: sending ansible.module_utils.facts.network.base (5.42 KiB) to ssh.192.168.0.82
[mux  7150] 09:50:40.066322 D mitogen.responder: sending ansible.module_utils.facts.network.darwin (5.12 KiB) to ssh.192.168.0.82
[mux  7150] 09:50:40.067194 D mitogen.responder: sending ansible.module_utils.facts.network.dragonfly (4.69 KiB) to ssh.192.168.0.82
[mux  7150] 09:50:40.068270 D mitogen.responder: sending ansible.module_utils.facts.network.fc_wwn (5.67 KiB) to ssh.192.168.0.82
[mux  7150] 09:50:40.069193 D mitogen.responder: sending ansible.module_utils.facts.network.freebsd (4.68 KiB) to ssh.192.168.0.82
[mux  7150] 09:50:40.070813 D mitogen.responder: sending ansible.module_utils.facts.network.generic_bsd (8.61 KiB) to ssh.192.168.0.82
[mux  7150] 09:50:40.071831 D mitogen.responder: sending ansible.module_utils.facts.network.hpux (5.37 KiB) to ssh.192.168.0.82
[mux  7150] 09:50:40.072852 D mitogen.responder: sending ansible.module_utils.facts.network.hurd (5.57 KiB) to ssh.192.168.0.82
[mux  7150] 09:50:40.073973 D mitogen.responder: sending ansible.module_utils.facts.network.iscsi (6.31 KiB) to ssh.192.168.0.82
[mux  7150] 09:50:40.076191 D mitogen.responder: sending ansible.module_utils.facts.network.linux (9.54 KiB) to ssh.192.168.0.82
[mux  7150] 09:50:40.077087 D mitogen.responder: sending ansible.module_utils.facts.network.netbsd (5.12 KiB) to ssh.192.168.0.82
[mux  7150] 09:50:40.078043 D mitogen.responder: sending ansible.module_utils.facts.network.nvme (5.25 KiB) to ssh.192.168.0.82
[mux  7150] 09:50:40.078959 D mitogen.responder: sending ansible.module_utils.facts.network.openbsd (4.91 KiB) to ssh.192.168.0.82
[mux  7150] 09:50:40.080041 D mitogen.responder: sending ansible.module_utils.facts.network.sunos (6.31 KiB) to ssh.192.168.0.82
[mux  7150] 09:50:40.080503 D mitogen.responder: ansible.module_utils.facts.other is a package at /usr/local/Cellar/ansible/2.9.1/libexec/lib/python3.7/site-packages/ansible/module_utils/facts/other/__init__.py with submodules ['facter', 'ohai']
[mux  7150] 09:50:40.081330 D mitogen.responder: sending ansible.module_utils.facts.other (3.83 KiB) to ssh.192.168.0.82
[mux  7150] 09:50:40.082409 D mitogen.responder: sending ansible.module_utils.facts.other.facter (5.55 KiB) to ssh.192.168.0.82
[mux  7150] 09:50:40.083459 D mitogen.responder: sending ansible.module_utils.facts.other.ohai (5.16 KiB) to ssh.192.168.0.82
[mux  7150] 09:50:40.084484 D mitogen.responder: sending ansible.module_utils.facts.sysctl (4.67 KiB) to ssh.192.168.0.82
[mux  7150] 09:50:40.085099 D mitogen.responder: ansible.module_utils.facts.system is a package at /usr/local/Cellar/ansible/2.9.1/libexec/lib/python3.7/site-packages/ansible/module_utils/facts/system/__init__.py with submodules ['apparmor', 'caps', 'chroot', 'cmdline', 'date_time', 'distribution', 'dns', 'env', 'fips', 'local', 'lsb', 'pkg_mgr', 'platform', 'python', 'selinux', 'service_mgr', 'ssh_pub_keys', 'user']
[mux  7150] 09:50:40.085881 D mitogen.responder: sending ansible.module_utils.facts.system (4.05 KiB) to ssh.192.168.0.82
[mux  7150] 09:50:40.086754 D mitogen.responder: sending ansible.module_utils.facts.system.apparmor (4.77 KiB) to ssh.192.168.0.82
[mux  7150] 09:50:40.087687 D mitogen.responder: sending ansible.module_utils.facts.system.caps (5.23 KiB) to ssh.192.168.0.82
[mux  7150] 09:50:40.088607 D mitogen.responder: sending ansible.module_utils.facts.system.chroot (4.78 KiB) to ssh.192.168.0.82
[mux  7150] 09:50:40.089571 D mitogen.responder: sending ansible.module_utils.facts.system.cmdline (5.09 KiB) to ssh.192.168.0.82
[mux  7150] 09:50:40.090508 D mitogen.responder: sending ansible.module_utils.facts.system.date_time (5.18 KiB) to ssh.192.168.0.82
[mux  7150] 09:50:40.093725 D mitogen.responder: sending ansible.module_utils.facts.system.distribution (13.37 KiB) to ssh.192.168.0.82
[mux  7150] 09:50:40.095040 D mitogen.responder: sending ansible.module_utils.facts.system.dns (5.18 KiB) to ssh.192.168.0.82
[mux  7150] 09:50:40.095917 D mitogen.responder: sending ansible.module_utils.facts.system.env (4.68 KiB) to ssh.192.168.0.82
[mux  7150] 09:50:40.096792 D mitogen.responder: sending ansible.module_utils.facts.system.fips (4.80 KiB) to ssh.192.168.0.82
[mux  7150] 09:50:40.097808 D mitogen.responder: sending ansible.module_utils.facts.system.local (5.52 KiB) to ssh.192.168.0.82
[mux  7150] 09:50:40.098809 D mitogen.responder: sending ansible.module_utils.facts.system.lsb (5.53 KiB) to ssh.192.168.0.82
[mux  7150] 09:50:40.100008 D mitogen.responder: sending ansible.module_utils.facts.system.pkg_mgr (6.60 KiB) to ssh.192.168.0.82
[mux  7150] 09:50:40.101017 D mitogen.responder: sending ansible.module_utils.facts.system.platform (5.71 KiB) to ssh.192.168.0.82
[mux  7150] 09:50:40.101929 D mitogen.responder: sending ansible.module_utils.facts.system.python (5.06 KiB) to ssh.192.168.0.82
[mux  7150] 09:50:40.102921 D mitogen.responder: sending ansible.module_utils.facts.system.selinux (5.39 KiB) to ssh.192.168.0.82
[mux  7150] 09:50:40.104053 D mitogen.responder: sending ansible.module_utils.facts.system.service_mgr (7.18 KiB) to ssh.192.168.0.82
[mux  7150] 09:50:40.104984 D mitogen.responder: sending ansible.module_utils.facts.system.ssh_pub_keys (5.13 KiB) to ssh.192.168.0.82
[mux  7150] 09:50:40.105882 D mitogen.responder: sending ansible.module_utils.facts.system.user (4.89 KiB) to ssh.192.168.0.82
[mux  7150] 09:50:40.106815 D mitogen.responder: sending ansible.module_utils.facts.timeout (5.44 KiB) to ssh.192.168.0.82
[mux  7150] 09:50:40.107752 D mitogen.responder: sending ansible.module_utils.facts.utils (5.15 KiB) to ssh.192.168.0.82
[mux  7150] 09:50:40.108284 D mitogen.responder: ansible.module_utils.facts.virtual is a package at /usr/local/Cellar/ansible/2.9.1/libexec/lib/python3.7/site-packages/ansible/module_utils/facts/virtual/__init__.py with submodules ['base', 'dragonfly', 'freebsd', 'hpux', 'linux', 'netbsd', 'openbsd', 'sunos', 'sysctl']
[mux  7150] 09:50:40.109062 D mitogen.responder: sending ansible.module_utils.facts.virtual (3.92 KiB) to ssh.192.168.0.82
[mux  7150] 09:50:40.109977 D mitogen.responder: sending ansible.module_utils.facts.virtual.base (5.26 KiB) to ssh.192.168.0.82
[mux  7150] 09:50:40.110835 D mitogen.responder: sending ansible.module_utils.facts.virtual.dragonfly (4.64 KiB) to ssh.192.168.0.82
[mux  7150] 09:50:40.111735 D mitogen.responder: sending ansible.module_utils.facts.virtual.freebsd (5.05 KiB) to ssh.192.168.0.82
[mux  7150] 09:50:40.112652 D mitogen.responder: sending ansible.module_utils.facts.virtual.hpux (5.04 KiB) to ssh.192.168.0.82
[mux  7150] 09:50:40.114165 D mitogen.responder: sending ansible.module_utils.facts.virtual.linux (7.47 KiB) to ssh.192.168.0.82
[mux  7150] 09:50:40.115254 D mitogen.responder: sending ansible.module_utils.facts.virtual.netbsd (4.92 KiB) to ssh.192.168.0.82
[mux  7150] 09:50:40.116398 D mitogen.responder: sending ansible.module_utils.facts.virtual.openbsd (5.22 KiB) to ssh.192.168.0.82
[mux  7150] 09:50:40.117571 D mitogen.responder: sending ansible.module_utils.facts.virtual.sunos (6.12 KiB) to ssh.192.168.0.82
[mux  7150] 09:50:40.118671 D mitogen.responder: sending ansible.module_utils.facts.virtual.sysctl (5.14 KiB) to ssh.192.168.0.82
[mux  7150] 09:50:40.119053 D mitogen.responder: sending ansible.module_utils.facts (5.50 KiB) to ssh.192.168.0.82
[mux  7150] 09:50:40.119458 D mitogen.importer.[ssh.192.168.0.82]: received ansible.module_utils.facts.ansible_collector
[mux  7150] 09:50:40.119757 D mitogen.importer.[ssh.192.168.0.82]: received ansible.module_utils.facts.collector
[mux  7150] 09:50:40.120045 D mitogen.importer.[ssh.192.168.0.82]: received ansible.module_utils.facts.compat
[mux  7150] 09:50:40.120327 D mitogen.importer.[ssh.192.168.0.82]: received ansible.module_utils.facts.default_collectors
[mux  7150] 09:50:40.120608 D mitogen.importer.[ssh.192.168.0.82]: received ansible.module_utils.facts.hardware
[mux  7150] 09:50:40.120891 D mitogen.importer.[ssh.192.168.0.82]: received ansible.module_utils.facts.hardware.aix
[mux  7150] 09:50:40.121173 D mitogen.importer.[ssh.192.168.0.82]: received ansible.module_utils.facts.hardware.base
[mux  7150] 09:50:40.121451 D mitogen.importer.[ssh.192.168.0.82]: received ansible.module_utils.facts.hardware.darwin
[mux  7150] 09:50:40.121732 D mitogen.importer.[ssh.192.168.0.82]: received ansible.module_utils.facts.hardware.dragonfly
[mux  7150] 09:50:40.122024 D mitogen.importer.[ssh.192.168.0.82]: received ansible.module_utils.facts.hardware.freebsd
[mux  7150] 09:50:40.122317 D mitogen.importer.[ssh.192.168.0.82]: received ansible.module_utils.facts.hardware.hpux
[mux  7150] 09:50:40.122597 D mitogen.importer.[ssh.192.168.0.82]: received ansible.module_utils.facts.hardware.hurd
[mux  7150] 09:50:40.122876 D mitogen.importer.[ssh.192.168.0.82]: received ansible.module_utils.facts.hardware.linux
[mux  7150] 09:50:40.123154 D mitogen.importer.[ssh.192.168.0.82]: received ansible.module_utils.facts.hardware.netbsd
[mux  7150] 09:50:40.123435 D mitogen.importer.[ssh.192.168.0.82]: received ansible.module_utils.facts.hardware.openbsd
[mux  7150] 09:50:40.123723 D mitogen.importer.[ssh.192.168.0.82]: received ansible.module_utils.facts.hardware.sunos
[mux  7150] 09:50:40.124001 D mitogen.importer.[ssh.192.168.0.82]: received ansible.module_utils.facts.namespace
[mux  7150] 09:50:40.124277 D mitogen.importer.[ssh.192.168.0.82]: received ansible.module_utils.facts.network
[mux  7150] 09:50:40.124553 D mitogen.importer.[ssh.192.168.0.82]: received ansible.module_utils.facts.network.aix
[mux  7150] 09:50:40.124832 D mitogen.importer.[ssh.192.168.0.82]: received ansible.module_utils.facts.network.base
[mux  7150] 09:50:40.125113 D mitogen.importer.[ssh.192.168.0.82]: received ansible.module_utils.facts.network.darwin
[mux  7150] 09:50:40.125388 D mitogen.importer.[ssh.192.168.0.82]: received ansible.module_utils.facts.network.dragonfly
[mux  7150] 09:50:40.125667 D mitogen.importer.[ssh.192.168.0.82]: received ansible.module_utils.facts.network.fc_wwn
[mux  7150] 09:50:40.125943 D mitogen.importer.[ssh.192.168.0.82]: received ansible.module_utils.facts.network.freebsd
[mux  7150] 09:50:40.126218 D mitogen.importer.[ssh.192.168.0.82]: received ansible.module_utils.facts.network.generic_bsd
[mux  7150] 09:50:40.126493 D mitogen.importer.[ssh.192.168.0.82]: received ansible.module_utils.facts.network.hpux
[mux  7150] 09:50:40.126769 D mitogen.importer.[ssh.192.168.0.82]: received ansible.module_utils.facts.network.hurd
[mux  7150] 09:50:40.127044 D mitogen.importer.[ssh.192.168.0.82]: received ansible.module_utils.facts.network.iscsi
[mux  7150] 09:50:40.127320 D mitogen.importer.[ssh.192.168.0.82]: received ansible.module_utils.facts.network.linux
[mux  7150] 09:50:40.127595 D mitogen.importer.[ssh.192.168.0.82]: received ansible.module_utils.facts.network.netbsd
[mux  7150] 09:50:40.127870 D mitogen.importer.[ssh.192.168.0.82]: received ansible.module_utils.facts.network.nvme
[mux  7150] 09:50:40.128205 D mitogen.importer.[ssh.192.168.0.82]: received ansible.module_utils.facts.network.openbsd
[mux  7150] 09:50:40.128558 D mitogen.importer.[ssh.192.168.0.82]: received ansible.module_utils.facts.network.sunos
[mux  7150] 09:50:40.128836 D mitogen.importer.[ssh.192.168.0.82]: received ansible.module_utils.facts.other
[mux  7150] 09:50:40.129113 D mitogen.importer.[ssh.192.168.0.82]: received ansible.module_utils.facts.other.facter
[mux  7150] 09:50:40.129390 D mitogen.importer.[ssh.192.168.0.82]: received ansible.module_utils.facts.other.ohai
[mux  7150] 09:50:40.129670 D mitogen.importer.[ssh.192.168.0.82]: received ansible.module_utils.facts.sysctl
[mux  7150] 09:50:40.129946 D mitogen.importer.[ssh.192.168.0.82]: received ansible.module_utils.facts.system
[mux  7150] 09:50:40.130225 D mitogen.importer.[ssh.192.168.0.82]: received ansible.module_utils.facts.system.apparmor
[mux  7150] 09:50:40.130501 D mitogen.importer.[ssh.192.168.0.82]: received ansible.module_utils.facts.system.caps
[mux  7150] 09:50:40.130777 D mitogen.importer.[ssh.192.168.0.82]: received ansible.module_utils.facts.system.chroot
[mux  7150] 09:50:40.131053 D mitogen.importer.[ssh.192.168.0.82]: received ansible.module_utils.facts.system.cmdline
[mux  7150] 09:50:40.131327 D mitogen.importer.[ssh.192.168.0.82]: received ansible.module_utils.facts.system.date_time
[mux  7150] 09:50:40.131629 D mitogen.importer.[ssh.192.168.0.82]: received ansible.module_utils.facts.system.distribution
[mux  7150] 09:50:40.132124 D mitogen.importer.[ssh.192.168.0.82]: received ansible.module_utils.facts.system.dns
[mux  7150] 09:50:40.132438 D mitogen.importer.[ssh.192.168.0.82]: received ansible.module_utils.facts.system.env
[mux  7150] 09:50:40.132717 D mitogen.importer.[ssh.192.168.0.82]: received ansible.module_utils.facts.system.fips
[mux  7150] 09:50:40.133004 D mitogen.importer.[ssh.192.168.0.82]: received ansible.module_utils.facts.system.local
[mux  7150] 09:50:40.133285 D mitogen.importer.[ssh.192.168.0.82]: received ansible.module_utils.facts.system.lsb
[mux  7150] 09:50:40.133564 D mitogen.importer.[ssh.192.168.0.82]: received ansible.module_utils.facts.system.pkg_mgr
[mux  7150] 09:50:40.133842 D mitogen.importer.[ssh.192.168.0.82]: received ansible.module_utils.facts.system.platform
[mux  7150] 09:50:40.134119 D mitogen.importer.[ssh.192.168.0.82]: received ansible.module_utils.facts.system.python
[mux  7150] 09:50:40.134396 D mitogen.importer.[ssh.192.168.0.82]: received ansible.module_utils.facts.system.selinux
[mux  7150] 09:50:40.134694 D mitogen.importer.[ssh.192.168.0.82]: received ansible.module_utils.facts.system.service_mgr
[mux  7150] 09:50:40.134982 D mitogen.importer.[ssh.192.168.0.82]: received ansible.module_utils.facts.system.ssh_pub_keys
[mux  7150] 09:50:40.135261 D mitogen.importer.[ssh.192.168.0.82]: received ansible.module_utils.facts.system.user
[mux  7150] 09:50:40.135599 D mitogen.importer.[ssh.192.168.0.82]: received ansible.module_utils.facts.timeout
[mux  7150] 09:50:40.135876 D mitogen.importer.[ssh.192.168.0.82]: received ansible.module_utils.facts.utils
[mux  7150] 09:50:40.136147 D mitogen.importer.[ssh.192.168.0.82]: received ansible.module_utils.facts.virtual
[mux  7150] 09:50:40.136439 D mitogen.importer.[ssh.192.168.0.82]: received ansible.module_utils.facts.virtual.base
[mux  7150] 09:50:40.136716 D mitogen.importer.[ssh.192.168.0.82]: received ansible.module_utils.facts.virtual.dragonfly
[mux  7150] 09:50:40.137101 D mitogen.importer.[ssh.192.168.0.82]: received ansible.module_utils.facts.virtual.freebsd
[mux  7150] 09:50:40.137392 D mitogen.importer.[ssh.192.168.0.82]: received ansible.module_utils.facts.virtual.hpux
[mux  7150] 09:50:40.137684 D mitogen.importer.[ssh.192.168.0.82]: received ansible.module_utils.facts.virtual.linux
[mux  7150] 09:50:40.139387 D mitogen.importer.[ssh.192.168.0.82]: received ansible.module_utils.facts.virtual.netbsd
[mux  7150] 09:50:40.139764 D mitogen.importer.[ssh.192.168.0.82]: received ansible.module_utils.facts.virtual.openbsd
[mux  7150] 09:50:40.142549 D mitogen.importer.[ssh.192.168.0.82]: received ansible.module_utils.facts.virtual.sunos
[mux  7150] 09:50:40.142922 D mitogen.importer.[ssh.192.168.0.82]: received ansible.module_utils.facts.virtual.sysctl
[mux  7150] 09:50:40.143232 D mitogen.importer.[ssh.192.168.0.82]: received ansible.module_utils.facts
[mux  7150] 09:50:40.144252 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.facts.compat
[mux  7150] 09:50:40.145048 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.facts.namespace
[mux  7150] 09:50:40.146790 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.facts.default_collectors
[mux  7150] 09:50:40.148507 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.facts.other
[mux  7150] 09:50:40.148853 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.facts.other.facter
[mux  7150] 09:50:40.150053 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.facts.collector
[mux  7150] 09:50:40.154400 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.facts.timeout
[mux  7150] 09:50:40.159437 D mitogen.importer.[ssh.192.168.0.82]: multiprocessing.context is submodule of a locally loaded package
[mux  7150] 09:50:40.160754 D mitogen.importer.[ssh.192.168.0.82]: multiprocessing.process is submodule of a locally loaded package
[mux  7150] 09:50:40.162334 D mitogen.importer.[ssh.192.168.0.82]: multiprocessing.pool is submodule of a locally loaded package
[mux  7150] 09:50:40.164608 D mitogen.importer.[ssh.192.168.0.82]: multiprocessing.util is submodule of a locally loaded package
[mux  7150] 09:50:40.167364 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.facts.other.ohai
[mux  7150] 09:50:40.167907 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.facts.system
[mux  7150] 09:50:40.168685 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.facts.system.apparmor
[mux  7150] 09:50:40.169947 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.facts.system.caps
[mux  7150] 09:50:40.171765 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.facts.system.chroot
[mux  7150] 09:50:40.173275 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.facts.system.cmdline
[mux  7150] 09:50:40.175769 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.facts.utils
[mux  7150] 09:50:40.176433 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.facts.system.distribution
[mux  7150] 09:50:40.188092 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.facts.system.date_time
[mux  7150] 09:50:40.189088 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.facts.system.env
[mux  7150] 09:50:40.190040 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.facts.system.dns
[mux  7150] 09:50:40.191017 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.facts.system.fips
[mux  7150] 09:50:40.191701 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.facts.system.local
[mux  7150] 09:50:40.195644 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.facts.system.lsb
[mux  7150] 09:50:40.197527 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.facts.system.pkg_mgr
[mux  7150] 09:50:40.198547 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.facts.system.platform
[mux  7150] 09:50:40.199862 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.facts.system.python
[mux  7150] 09:50:40.210817 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.facts.system.selinux
[mux  7150] 09:50:40.211687 D mitogen.importer.[ssh.192.168.0.82]: requesting selinux
[mux  7150] 09:50:40.214479 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.facts.system.service_mgr
[mux  7150] 09:50:40.219406 D mitogen.importer.[ssh.192.168.0.82]: distutils.version is submodule of a locally loaded package
[mux  7150] 09:50:40.221684 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.facts.system.ssh_pub_keys
[mux  7150] 09:50:40.222603 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.facts.system.user
[mux  7150] 09:50:40.224646 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.facts.hardware
[mux  7150] 09:50:40.226543 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.facts.hardware.base
[mux  7150] 09:50:40.227801 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.facts.hardware.aix
[mux  7150] 09:50:40.228679 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.facts.hardware.darwin
[mux  7150] 09:50:40.229477 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.facts.sysctl
[mux  7150] 09:50:40.230078 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.facts.hardware.dragonfly
[mux  7150] 09:50:40.230562 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.facts.hardware.freebsd
[mux  7150] 09:50:40.231184 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.facts.hardware.hpux
[mux  7150] 09:50:40.232927 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.facts.hardware.hurd
[mux  7150] 09:50:40.233717 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.facts.hardware.linux
[mux  7150] 09:50:40.243458 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.facts.hardware.netbsd
[mux  7150] 09:50:40.244960 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.facts.hardware.openbsd
[mux  7150] 09:50:40.245858 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.facts.hardware.sunos
[mux  7150] 09:50:40.247068 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.facts.network
[mux  7150] 09:50:40.247976 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.facts.network.base
[mux  7150] 09:50:40.249263 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.facts.network.aix
[mux  7150] 09:50:40.252194 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.facts.network.generic_bsd
[mux  7150] 09:50:40.253191 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.facts.network.darwin
[mux  7150] 09:50:40.253897 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.facts.network.dragonfly
[mux  7150] 09:50:40.254567 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.facts.network.fc_wwn
[mux  7150] 09:50:40.255186 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.facts.network.freebsd
[mux  7150] 09:50:40.255772 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.facts.network.hpux
[mux  7150] 09:50:40.256578 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.facts.network.hurd
[mux  7150] 09:50:40.257079 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.facts.network.linux
[mux  7150] 09:50:40.260727 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.facts.network.iscsi
[mux  7150] 09:50:40.261605 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.facts.network.nvme
[mux  7150] 09:50:40.262335 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.facts.network.netbsd
[mux  7150] 09:50:40.263141 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.facts.network.openbsd
[mux  7150] 09:50:40.263823 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.facts.network.sunos
[mux  7150] 09:50:40.264454 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.facts.virtual
[mux  7150] 09:50:40.264940 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.facts.virtual.base
[mux  7150] 09:50:40.265888 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.facts.virtual.dragonfly
[mux  7150] 09:50:40.266917 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.facts.virtual.freebsd
[mux  7150] 09:50:40.267952 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.facts.virtual.sysctl
[mux  7150] 09:50:40.268750 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.facts.virtual.hpux
[mux  7150] 09:50:40.269959 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.facts.virtual.linux
[mux  7150] 09:50:40.270539 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.facts.virtual.netbsd
[mux  7150] 09:50:40.271893 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.facts.virtual.openbsd
[mux  7150] 09:50:40.273638 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.facts.virtual.sunos
[mux  7150] 09:50:40.275911 D mitogen.importer.[ssh.192.168.0.82]: requesting ansible.module_utils.facts.ansible_collector
[mux  7150] 09:50:40.276447 D mitogen.importer.[ssh.192.168.0.82]: ansible.module_utils.facts has no submodule
[mux  7150] 09:50:40.276947 D mitogen.importer.[ssh.192.168.0.82]: ansible.module_utils.facts.hardware has no submodule
[mux  7150] 09:50:40.277439 D mitogen.importer.[ssh.192.168.0.82]: ansible.module_utils.facts.network has no submodule
[mux  7150] 09:50:40.277968 D mitogen.importer.[ssh.192.168.0.82]: ansible.module_utils.facts.other has no submodule
[mux  7150] 09:50:40.278479 D mitogen.importer.[ssh.192.168.0.82]: ansible.module_utils.facts.system has no submodule
[mux  7150] 09:50:40.278968 D mitogen.importer.[ssh.192.168.0.82]: ansible.module_utils.facts.virtual has no submodule
[mux  7150] 09:50:40.279428 D mitogen.importer.[ssh.192.168.0.82]: ansible.module_utils.six has no submodule
[mux  7150] 09:50:40.279855 D mitogen.[ssh.192.168.0.82]: Dispatcher: Message(2, 1, 0, 101, 1003, b'\x80\x02(X$\x00\x00\x00mckenzie.local-7151-1121a45c0-35706dq\x00X\x16\x00\x00'..4919) -> {'stdout': '', 'rc': 1, 'stderr': 'Traceback (most recent call last):\n  File "master:/Users/m8mble/software/mitogen/ansible_mitogen/runner.py", line 975, in _run\n    self._run_code(code, mod)\n  File "master:/Users/m8mble/software/mitogen/ansible_mitogen/runner.py", line 939, in _run_code\n    exec(code, vars(mod))\n  File "master:/usr/local/Cellar/ansible/2.9.1/libexec/lib/python3.7/site-packages/ansible/modules/system/setup.py", line 134, in <module>\nSystemError: Parent module \'ansible.modules.system\' not loaded, cannot perform relative import\n'}
[task 7151] 09:50:40.280457 D ansible_mitogen.connection: Call took 334 ms: ansible_mitogen.target.run_module(kwargs={'runner_name': 'NewStyleRunner', 'module': 'setup', 'path': '/usr/local/Cellar/ansible/2.9.1/libexec/lib/python3.7/site-packages/ansible/modules/system/setup.py', 'json_args': '{"gather_subset": ["!hardware"], "gather_timeout": 10, "_ansible_check_mode": true, "_ansible_no_log": false, "_ansible_debug": false, "_ansible_diff": true, "_ansible_verbosity": 3, "_ansible_version": "2.9.1", "_ansible_module_name": "setup", "_ansible_syslog_facility": "LOG_USER", "_ansible_selinux_special_fs": ["fuse", "nfs", "vboxsf", "ramfs", "9p", "vfat"], "_ansible_string_conversion_action": "warn", "_ansible_socket": null, "_ansible_shell_executable": "/bin/sh", "_ansible_keep_remote_files": false, "_ansible_tmpdir": null, "_ansible_remote_tmp": "/home/m8mble/.ansible/tmp"}', 'env': {}, 'interpreter_fragment': None, 'is_python': None, 'module_map': {'builtin': ['ansible.module_utils._text', 'ansible.module_utils.common', 'ansible.module_utils.common._utils', 'ansible.module_utils.common.file', 'ansible.module_utils.common.process', 'ansible.module_utils.common.sys_info', 'ansible.module_utils.common.text', 'ansible.module_utils.common.text.formatters', 'ansible.module_utils.distro', 'ansible.module_utils.distro._distro', 'ansible.module_utils.facts', 'ansible.module_utils.facts.ansible_collector', 'ansible.module_utils.facts.collector', 'ansible.module_utils.facts.compat', 'ansible.module_utils.facts.default_collectors', 'ansible.module_utils.facts.hardware', 'ansible.module_utils.facts.hardware.aix', 'ansible.module_utils.facts.hardware.base', 'ansible.module_utils.facts.hardware.darwin', 'ansible.module_utils.facts.hardware.dragonfly', 'ansible.module_utils.facts.hardware.freebsd', 'ansible.module_utils.facts.hardware.hpux', 'ansible.module_utils.facts.hardware.hurd', 'ansible.module_utils.facts.hardware.linux', 'ansible.module_utils.facts.hardware.netbsd', 'ansible.module_utils.facts.hardware.openbsd', 'ansible.module_utils.facts.hardware.sunos', 'ansible.module_utils.facts.namespace', 'ansible.module_utils.facts.network', 'ansible.module_utils.facts.network.aix', 'ansible.module_utils.facts.network.base', 'ansible.module_utils.facts.network.darwin', 'ansible.module_utils.facts.network.dragonfly', 'ansible.module_utils.facts.network.fc_wwn', 'ansible.module_utils.facts.network.freebsd', 'ansible.module_utils.facts.network.generic_bsd', 'ansible.module_utils.facts.network.hpux', 'ansible.module_utils.facts.network.hurd', 'ansible.module_utils.facts.network.iscsi', 'ansible.module_utils.facts.network.linux', 'ansible.module_utils.facts.network.netbsd', 'ansible.module_utils.facts.network.nvme', 'ansible.module_utils.facts.network.openbsd', 'ansible.module_utils.facts.network.sunos', 'ansible.module_utils.facts.other', 'ansible.module_utils.facts.other.facter', 'ansible.module_utils.facts.other.ohai', 'ansible.module_utils.facts.sysctl', 'ansible.module_utils.facts.system', 'ansible.module_utils.facts.system.apparmor', 'ansible.module_utils.facts.system.caps', 'ansible.module_utils.facts.system.chroot', 'ansible.module_utils.facts.system.cmdline', 'ansible.module_utils.facts.system.date_time', 'ansible.module_utils.facts.system.distribution', 'ansible.module_utils.facts.system.dns', 'ansible.module_utils.facts.system.env', 'ansible.module_utils.facts.system.fips', 'ansible.module_utils.facts.system.local', 'ansible.module_utils.facts.system.lsb', 'ansible.module_utils.facts.system.pkg_mgr', 'ansible.module_utils.facts.system.platform', 'ansible.module_utils.facts.system.python', 'ansible.module_utils.facts.system.selinux', 'ansible.module_utils.facts.system.service_mgr', 'ansible.module_utils.facts.system.ssh_pub_keys', 'ansible.module_utils.facts.system.user', 'ansible.module_utils.facts.timeout', 'ansible.module_utils.facts.utils', 'ansible.module_utils.facts.virtual', 'ansible.module_utils.facts.virtual.base', 'ansible.module_utils.facts.virtual.dragonfly', 'ansible.module_utils.facts.virtual.freebsd', 'ansible.module_utils.facts.virtual.hpux', 'ansible.module_utils.facts.virtual.linux', 'ansible.module_utils.facts.virtual.netbsd', 'ansible.module_utils.facts.virtual.openbsd', 'ansible.module_utils.facts.virtual.sunos', 'ansible.module_utils.facts.virtual.sysctl', 'ansible.module_utils.six'], 'custom': []}, 'py_module_name': 'ansible.modules.system.setup', 'good_temp_dir': '/home/m8mble/.ansible/tmp', 'cwd': None, 'extra_env': None, 'emulate_tty': True, 'service_context': Context(0, None)})
[task 7151] 09:50:40.281305 D ansible_mitogen.mixins: _remove_tmp_path(None)
[task 7151] 09:50:40.284007 D mitogen.parent: starting no-reply function call to 'ssh.192.168.0.82': mitogen.core.Dispatcher.forget_chain('mckenzie.local-7151-1121a45c0-35706d')
[mux  7150] 09:50:40.284743 D ansible_mitogen.services: decrementing reference count for Context(2, 'ssh.192.168.0.82')
[task 7151] 09:50:40.285499 D mitogen: MitogenProtocol(unix_listener.7150): disconnecting
[mux  7150] 09:50:40.286059 D mitogen: <Side of unix_client.7151 fd 107>: empty read, disconnecting
[task 7151] 09:50:40.286207 D mitogen: Waker(fd=44/45): disconnecting
[mux  7150] 09:50:40.286547 D mitogen: MitogenProtocol(unix_client.7151): disconnecting
[task 7151] 09:50:40.286812 D mitogen: Router(Broker(95d0)): stats: 0 module requests in 0 ms, 0 sent (0 ms minify time), 0 negative responses. Sent 0.0 kb total, 0.0 kb avg.
fatal: [thehost.domain.internal]: FAILED! => changed=false
  ansible_facts: {}
  failed_modules:
    setup:
      exception: |-
        Traceback (most recent call last):
          File "master:/Users/m8mble/software/mitogen/ansible_mitogen/runner.py", line 975, in _run
            self._run_code(code, mod)
          File "master:/Users/m8mble/software/mitogen/ansible_mitogen/runner.py", line 939, in _run_code
            exec(code, vars(mod))
          File "master:/usr/local/Cellar/ansible/2.9.1/libexec/lib/python3.7/site-packages/ansible/modules/system/setup.py", line 134, in <module>
        SystemError: Parent module 'ansible.modules.system' not loaded, cannot perform relative import
      failed: true
      module_stderr: |-
        Traceback (most recent call last):
          File "master:/Users/m8mble/software/mitogen/ansible_mitogen/runner.py", line 975, in _run
            self._run_code(code, mod)
          File "master:/Users/m8mble/software/mitogen/ansible_mitogen/runner.py", line 939, in _run_code
            exec(code, vars(mod))
          File "master:/usr/local/Cellar/ansible/2.9.1/libexec/lib/python3.7/site-packages/ansible/modules/system/setup.py", line 134, in <module>
        SystemError: Parent module 'ansible.modules.system' not loaded, cannot perform relative import
      module_stdout: ''
      msg: |-
        MODULE FAILURE
        See stdout/stderr for the exact error
      rc: 1
  msg: |-
    The following modules failed to execute: setup

PLAY RECAP *********************************************************************************************************************************************************************************************************************************************************************
thehost.domain.internal : ok=0    changed=0    unreachable=0    failed=1    skipped=0    rescued=0    ignored=0

[mux  7150] 09:50:40.296498 D mitogen: Waker(fd=38/40): disconnecting
[mux  7150] 09:50:40.297075 D mitogen.service: thread mitogen.Pool.b710.8 exiting gracefully
[mux  7150] 09:50:40.297706 D mitogen.service: thread mitogen.Pool.b710.7 exiting gracefully
[mux  7150] 09:50:40.298157 D mitogen.parent: MitogenProtocol(ssh.192.168.0.82): requesting child shutdown
[mux  7150] 09:50:40.298538 D mitogen.service: thread mitogen.Pool.b710.11 exiting gracefully
[mux  7150] 09:50:40.298612 D mitogen: SetupProtocol(ssh.192.168.0.82): disconnecting
[mux  7150] 09:50:40.299244 D mitogen.service: thread mitogen.Pool.b710.5 exiting gracefully
[mux  7150] 09:50:40.299580 D mitogen.service: thread mitogen.Pool.b710.10 exiting gracefully
[mux  7150] 09:50:40.300184 D mitogen.service: thread mitogen.Pool.b710.9 exiting gracefully
[mux  7150] 09:50:40.300521 D mitogen.service: thread mitogen.Pool.b710.4 exiting gracefully
[mux  7150] 09:50:40.301021 D mitogen.service: thread mitogen.Pool.b710.6 exiting gracefully
[mux  7150] 09:50:40.301473 D mitogen.service: thread mitogen.Pool.b710.13 exiting gracefully
[mux  7150] 09:50:40.302015 D mitogen.service: thread mitogen.Pool.b710.12 exiting gracefully
[mux  7150] 09:50:40.302561 D mitogen.service: thread mitogen.Pool.b710.15 exiting gracefully
[mux  7150] 09:50:40.303010 D mitogen.service: thread mitogen.Pool.b710.16 exiting gracefully
[mux  7150] 09:50:40.303075 D mitogen.service: thread mitogen.Pool.b710.14 exiting gracefully
[mux  7150] 09:50:40.303515 D mitogen.service: thread mitogen.Pool.b710.17 exiting gracefully
[mux  7150] 09:50:40.304063 D mitogen.service: thread mitogen.Pool.b710.20 exiting gracefully
[mux  7150] 09:50:40.304498 D mitogen.service: thread mitogen.Pool.b710.21 exiting gracefully
[mux  7150] 09:50:40.305052 D mitogen.service: thread mitogen.Pool.b710.19 exiting gracefully
[mux  7150] 09:50:40.305600 D mitogen.service: thread mitogen.Pool.b710.18 exiting gracefully
[mux  7150] 09:50:40.305994 D mitogen.service: thread mitogen.Pool.b710.22 exiting gracefully
[mux  7150] 09:50:40.306427 D mitogen.service: thread mitogen.Pool.b710.23 exiting gracefully
[mux  7150] 09:50:40.306494 D mitogen.service: thread mitogen.Pool.b710.25 exiting gracefully
[mux  7150] 09:50:40.306927 D mitogen.service: thread mitogen.Pool.b710.24 exiting gracefully
[mux  7150] 09:50:40.307497 D mitogen.service: thread mitogen.Pool.b710.26 exiting gracefully
[mux  7150] 09:50:40.307960 D mitogen.service: thread mitogen.Pool.b710.27 exiting gracefully
[mux  7150] 09:50:40.308427 D mitogen.service: thread mitogen.Pool.b710.28 exiting gracefully
[mux  7150] 09:50:40.309218 D mitogen.service: thread mitogen.Pool.b710.29 exiting gracefully
[mux  7150] 09:50:40.309274 D mitogen.[ssh.192.168.0.82]: Dispatcher: dispatching (None, 'mitogen.core', 'Dispatcher', 'forget_chain', ('mckenzie.local-7151-1121a45c0-35706d',), Kwargs({}))
[mux  7150] 09:50:40.309342 D mitogen.service: thread mitogen.Pool.b710.30 exiting gracefully
[mux  7150] 09:50:40.309780 D mitogen.service: thread mitogen.Pool.b710.0 exiting gracefully
[mux  7150] 09:50:40.310230 D mitogen.service: thread mitogen.Pool.b710.31 exiting gracefully
[mux  7150] 09:50:40.310676 D mitogen.service: thread mitogen.Pool.b710.1 exiting gracefully
[mux  7150] 09:50:40.310990 D mitogen.[ssh.192.168.0.82]: Dispatcher: Message(2, 1, 0, 101, 0, b'\x80\x02(NX\x0c\x00\x00\x00mitogen.coreq\x00X\n\x00\x00\x00Dispatcherq\x01X\x0c\x00\x00\x00forge'..141) -> None
[mux  7150] 09:50:40.311025 D mitogen.service: thread mitogen.Pool.b710.3 exiting gracefully
[mux  7150] 09:50:40.311351 D mitogen.service: thread mitogen.Pool.b710.2 exiting gracefully
[mux  7150] 09:50:40.335706 D mitogen.[ssh.192.168.0.82]: shutdown request from context 0
[mux  7150] 09:50:40.336716 D mitogen.[ssh.192.168.0.82]: Broker(c7b8): shutting down
[mux  7150] 09:50:40.337612 D mitogen.[ssh.192.168.0.82]: IoLoggerProtocol(stderr): shutting down
[mux  7150] 09:50:40.338443 D mitogen.[ssh.192.168.0.82]: Waker(fd=3/4): shutting down
[mux  7150] 09:50:40.339138 D mitogen.[ssh.192.168.0.82]: Waker(fd=3/4): disconnecting
[mux  7150] 09:50:40.339820 D mitogen.[ssh.192.168.0.82]: MitogenProtocol(parent): shutting down
[mux  7150] 09:50:40.340499 D mitogen.parent.[ssh.192.168.0.82]: MitogenProtocol(fork.113547): requesting child shutdown
[mux  7150] 09:50:40.341079 D mitogen.[ssh.192.168.0.82]: IoLoggerProtocol(stdout): shutting down
[mux  7150] 09:50:40.341637 D mitogen.[ssh.192.168.0.82]: <Side of stderr fd 9>: empty read, disconnecting
[mux  7150] 09:50:40.342138 D mitogen.[ssh.192.168.0.82]: IoLoggerProtocol(stderr): disconnecting
[mux  7150] 09:50:40.342626 D mitogen.[ssh.192.168.0.82]: <Side of stdout fd 7>: empty read, disconnecting
[mux  7150] 09:50:40.343110 D mitogen.[ssh.192.168.0.82]: IoLoggerProtocol(stdout): disconnecting
[mux  7150] 09:50:40.343593 D mitogen.[fork.113547]: shutdown request from context 2
[mux  7150] 09:50:40.344051 D mitogen.[fork.113547]: Broker(1eb8): shutting down
[mux  7150] 09:50:40.344449 D mitogen.[fork.113547]: IoLoggerProtocol(stderr): shutting down
[mux  7150] 09:50:40.344846 D mitogen.[ssh.192.168.0.82]: <Side of fork.113547 fd 14>: empty read, disconnecting
[mux  7150] 09:50:40.345242 D mitogen.parent.[ssh.192.168.0.82]: Process fork.113547 pid 113547: exited with return code 0
[mux  7150] 09:50:40.345648 D mitogen.[ssh.192.168.0.82]: Context(3, 'fork.113547'): disconnecting
[mux  7150] 09:50:40.346067 D mitogen.route_monitor.[ssh.192.168.0.82]: stream fork.113547 is gone; propagating DEL_ROUTE for {3}
[mux  7150] 09:50:40.346469 D mitogen.parent.[ssh.192.168.0.82]: Router(Broker(c7b8)): deleting route to 3
[mux  7150] 09:50:40.346881 D mitogen.route_monitor: firing local disconnect signal for Context(3, 'fork.113547')
[mux  7150] 09:50:40.347282 D mitogen.route_monitor: deleting route to 3 via <Stream ssh.192.168.0.82 #8f90>
[mux  7150] 09:50:40.347670 D mitogen.parent: Router(Broker(b4d0)): deleting route to 3
[mux  7150] 09:50:40.348081 D mitogen.[ssh.192.168.0.82]: MitogenProtocol(fork.113547): disconnecting
[mux  7150] 09:50:40.348484 D mitogen.[ssh.192.168.0.82]: Broker(c7b8): force disconnecting <Side of parent fd 5>
[mux  7150] 09:50:40.348824 D mitogen.[ssh.192.168.0.82]: parent stream is gone, dying.
[mux  7150] 09:50:40.349161 D mitogen.[ssh.192.168.0.82]: Broker(c7b8): shutting down
[mux  7150] 09:50:40.349513 D mitogen: <Side of ssh.192.168.0.82 fd 108>: empty read, disconnecting
[mux  7150] 09:50:40.349910 D mitogen.parent: PopenProcess ssh.192.168.0.82 pid 7152: exited with return code 255
[mux  7150] 09:50:40.350270 I ansible_mitogen.services: ContextService(): Forgetting Context(2, 'ssh.192.168.0.82') due to stream disconnect
[mux  7150] 09:50:40.350629 D mitogen.route_monitor: stream ssh.192.168.0.82 is gone; propagating DEL_ROUTE for {2}
[mux  7150] 09:50:40.350963 D mitogen.parent: Router(Broker(b4d0)): deleting route to 2
[mux  7150] 09:50:40.351298 I ansible_mitogen.services: ContextService(): Forgetting Context(2, 'ssh.192.168.0.82') due to stream disconnect
[mux  7150] 09:50:40.351630 D ansible_mitogen.services: ContextService(): attempt to forget unknown Context(2, 'ssh.192.168.0.82')
[mux  7150] 09:50:40.351962 D mitogen: MitogenProtocol(ssh.192.168.0.82): disconnecting
[mux  7150] 09:50:40.352447 D mitogen: Router(Broker(b4d0)): stats: 1 module requests in 131 ms, 118 sent (199 ms minify time), 0 negative responses. Sent 627.3 kb total, 5.3 kb avg.
[mux  7150] 09:50:40.352907 D mitogen.service: FileService().on_shutdown()
[top  7146] 09:50:40.357692 D ansible_mitogen.process: multiplexer 0 PID 7150 exited with return code 0
@apple4ever
Copy link

Seems to be the same as mine in #665

@Shm013
Copy link

Shm013 commented Dec 5, 2019

I have the same problem with target nodes with python3.5 (ubuntu16.04 LTS). I has fails while running setup module.
I tried to install python 3.6 from sources and it work, but there is another problem - it fails if I run apt module (I think it because python-apt or something else is missing for python3.7)
My solution is to use python2 for ubuntu16 for this I add into node specific for all ubuntu16:
ansible_python_interpreter: python
It run python2.7 on host. I have not problems with ubuntu18.04 with python3.6

Sorry for my English.

@apple4ever
Copy link

@Shm013 Ah good catch. I'm running 16.04 on my hosts too which comes with Python 3.5.2.

I have been specifying python3 which is my preferred solution.

@opoplawski
Copy link
Contributor

Switching to python2 for ubuntu 16.04 is problematic for me because it appears that the firewalld package only provides python3 bindings.

@atomlab
Copy link

atomlab commented Jan 22, 2020

I have same issue.

TASK [Gathering Facts] **************************************************************************************
fatal: [nexus]: FAILED! => {"ansible_facts": {}, "changed": false, "failed_modules": {"setup": {"exception": "Traceback (most recent call last):\n File "master:/Users/user/.virtenv/myenv/lib/python3.7/site-packages/ansible_mitogen/runner.py", line 975, in _run\n self._run_code(code, mod)\n File "master:/Users/user/.virtenv/myenv/lib/python3.7/site-packages/ansible_mitogen/runner.py", line 939, in _run_code\n exec(code, vars(mod))\n File "master:/Users/user/.virtenv/myenv/lib/python3.7/site-packages/ansible/modules/system/setup.py", line 134, in \nSystemError: Parent module 'ansible.modules.system' not loaded, cannot perform relative import\n", "failed": true, "module_stderr": "Traceback (most recent call last):\n File "master:/Users/user/.virtenv/myenv/lib/python3.7/site-packages/ansible_mitogen/runner.py", line 975, in _run\n self._run_code(code, mod)\n File "master:/Users/user/.virtenv/myenv/lib/python3.7/site-packages/ansible_mitogen/runner.py", line 939, in _run_code\n exec(code, vars(mod))\n File "master:/Users/user/.virtenv/myenv/lib/python3.7/site-packages/ansible/modules/system/setup.py", line 134, in \nSystemError: Parent module 'ansible.modules.system' not loaded, cannot perform relative import\n", "module_stdout": "", "msg": "MODULE FAILURE\nSee stdout/stderr for the exact error", "rc": 1}}, "msg": "The following modules failed to execute: setup\n"}

[defaults]
inventory=inventory
roles_path=./roles
log_path=~/ansible.log
timeout=30
deprecation_warnings = True
strategy_plugins = ~/.virtenv/myenv/lib/python3.7/site-packages/ansible_mitogen/plugins/strategy
strategy = mitogen_linear
ansible_managed = THIS FILE IS MANAGED BY ANSIBLE, ALL CHANGES WILL BE LOST!!!
ansible_python_interpreter = /usr/bin/python3
host_key_checking = False
jinja2_extensions = jinja2.ext.do

Controller system

mitogen 0.2.9
ansible 2.9.4
python 3.7.3

Remote system

Python 3.5.3

If I disable strategy_plugins and strategy when I not see error and all works fine.

#strategy_plugins = ~/.virtenv/myenv/lib/python3.7/site-packages/ansible_mitogen/plugins/strategy
#strategy = mitogen_linear

@kormat
Copy link

kormat commented Feb 11, 2020

This issue is caused by ansible 2.9, by this PR: ansible/ansible#61196. If you downgrade to ansible 2.8.8, the problem goes away.

@FloMiau
Copy link

FloMiau commented Apr 4, 2020

I've got the same problem. Has somebody reported this to the ansible project?

@jpiron
Copy link

jpiron commented May 13, 2020

It has been : ansible/ansible#68276

@lunarfs
Copy link

lunarfs commented May 26, 2020

It has been : ansible/ansible#68276

Ansible closed the issue with reference to the issue needs fixing in the mitogen project

@s1113950
Copy link
Collaborator

I'll take a look soon. My schedule is a bit hectic but I should be able to get to it by the end of the week.

@lunarfs
Copy link

lunarfs commented May 26, 2020

I'll take a look soon. My schedule is a bit hectic but I should be able to get to it by the end of the week.

So on a note I changed
/usr/local/lib/python3.8/site-packages/ansible/modules/system/setup.py
line 134 from
from ...module_utils.basic import AnsibleModule
to
from ansible.module_utils.basic import AnsibleModule
and my playbook ran trough, I am absolutley not a Python developer, this might not be a propper fix.. most likeley not. but maybe a workarround in some cases

@s1113950
Copy link
Collaborator

That's in the Ansible module, but they're saying it's on Mitogen's end? 🤔 interesting.
@lunarfs do you have a minimally reproducible playbook I can use to repro the problem?

@lunarfs
Copy link

lunarfs commented May 26, 2020

Let me try.
so i have ssh to myservice.mydomain.org on port 1234
keys is handled in my ssh config
then when running
ansible -i inventory playbook.yml
i get the error.
Inventory file:

all:
  children:
    devs:
      children:
        myservice:
    myservice:
      hosts:
        "myservice":
          "ansible_port": "1234"

      vars:
       "service": "myservice"
  vars:
    ansible_python_interpreter: /usr/bin/python3
    ansible_host: "myservice.mydomain.org"

Playbook

---

- hosts: myservice
  gather_facts: true
  tasks:
    - debug:
        msg: "test"

a little info on my setup

ansible --version
ansible 2.9.2
  config file = /home/work/ansible/ansible.cfg
  configured module search path = ['/home/ansibleme/.ansible/plugins/modules', '/usr/share/ansible/plugins/modules']
  ansible python module location = /usr/local/lib/python3.8/site-packages/ansible
  executable location = /usr/local/bin/ansible
  python version = 3.8.1 (default, Jan  9 2020, 13:05:01) [GCC 4.8.5 20150623 (Red Hat 4.8.5-39)]

so we are running inside a docker container and has been doing so for very long time , also before this started happening (when we upgraded to 2.9.2)
the dockerfile is rather complex, and i do not think it adds value here..

@s1113950
Copy link
Collaborator

Can you upgrade to Ansible 2.9.6 and Mitogen master and see if the issue goes away? There's new things like ansible_python_interpreter discovery in latest Mitogen. Just wanna make sure the issue is still an issue on master. I haven't experienced a relative import error myself on master.

@lunarfs
Copy link

lunarfs commented May 26, 2020

I will try to do that, i will be back with an answer tomorrow (it takes some time to build the docker container..) and have some other stuff i need to lookinto also.. but you will hear more about how it went

@s1113950
Copy link
Collaborator

Sounds good, thanks! If you have a public docker image already built that I can repro with that'll work too

@lunarfs
Copy link

lunarfs commented May 27, 2020

Hi,
same issue with mitogen-master and ansible 2.9.6

ansible --version
ansible 2.9.6
  config file = /home/work/ansible/ansible.cfg
  configured module search path = ['/home/ansibleme/.ansible/plugins/modules', '/usr/share/ansible/plugins/modules']
  ansible python module location = /usr/local/lib/python3.8/site-packages/ansible
  executable location = /usr/local/bin/ansible
  python version = 3.8.1 (default, May 27 2020, 06:43:11) [GCC 4.8.5 20150623 (Red Hat 4.8.5-39)]

ansible.cfg:

cat ansible.cfg | grep strategy
strategy_plugins = /opt/mitogen/ansible_mitogen/plugins/strategy
strategy = mitogen_linear

instal mitogen:

wget -q https://github.com/dw/mitogen/archive/master.zip -O /tmp/mitogen.zip
unzip /tmp/mitogen.zip -d /opt/
ln -s /opt/mitogen-master /opt/mitogen

output from run

TASK [Gathering Facts] ****************************************************************************************************************************************************************************************************************
Wednesday 27 May 2020  10:17:23 +0000 (0:00:00.055)       0:00:05.767 ********* 
fatal: [myservice1]: FAILED! => {"ansible_facts": {}, "changed": false, "failed_modules": {"setup": {"exception": "Traceback (most recent call last):\n  File \"master:/opt/mitogen-master/ansible_mitogen/runner.py\", line 975, in _run\n    self._run_code(code, mod)\n  File \"master:/opt/mitogen-master/ansible_mitogen/runner.py\", line 939, in _run_code\n    exec(code, vars(mod))\n  File \"master:/usr/local/lib/python3.8/site-packages/ansible/modules/system/setup.py\", line 134, in <module>\nSystemError: Parent module 'ansible.modules.system' not loaded, cannot perform relative import\n", "failed": true, "module_stderr": "Traceback (most recent call last):\n  File \"master:/opt/mitogen-master/ansible_mitogen/runner.py\", line 975, in _run\n    self._run_code(code, mod)\n  File \"master:/opt/mitogen-master/ansible_mitogen/runner.py\", line 939, in _run_code\n    exec(code, vars(mod))\n  File \"master:/usr/local/lib/python3.8/site-packages/ansible/modules/system/setup.py\", line 134, in <module>\nSystemError: Parent module 'ansible.modules.system' not loaded, cannot perform relative import\n", "module_stdout": "", "msg": "MODULE FAILURE\nSee stdout/stderr for the exact error", "rc": 1}}, "msg": "The following modules failed to execute: setup\n"}

@s1113950
Copy link
Collaborator

Can you try python 3.7? I just realized we have no tests for Python 3.8 yet, maybe that's the issue.

@macmonac
Copy link

Hello,
The last merge on master (https://github.com/dw/mitogen.git) is 12 days ago.
A push forgot ?
Regards

@lunarfs
Copy link

lunarfs commented May 28, 2020

Hi,

same issue with python 3.7.
I will try to reproduce with a dockercontainer where i can share the dockerfile

ansible 2.9.6
  config file = /home/work/ansible/ansible.cfg
  configured module search path = ['/home/ansibleme/.ansible/plugins/modules', '/usr/share/ansible/plugins/modules']
  ansible python module location = /usr/local/lib/python3.7/site-packages/ansible
  executable location = /usr/local/bin/ansible
  python version = 3.7.0 (default, May 28 2020, 07:39:51) [GCC 4.8.5 20150623 (Red Hat 4.8.5-39)]

@s1113950
Copy link
Collaborator

Hello,
The last merge on master (https://github.com/dw/mitogen.git) is 12 days ago.
A push forgot ?
Regards

@macmonac currently there is development on collections for bleeding edge Ansible which will take awhile, which is why the last master merge was 12 days ago 😅

@s1113950
Copy link
Collaborator

@lunarfs a dockerfile would be awesome, thank you 👍

@lunarfs
Copy link

lunarfs commented May 28, 2020

Start the container:
note ~/work/ansible on your machine will be mounted in on /home/work and files edited there will continue to have your user/group id (see userwrapper script at the bottom)
so the container is rather large, it contains alot of tools.

docker pull fvissing/ansible:77389e9a8b9c
docker run --name ansible -e ANSIBLEME_GROUPID=$(id -g) -e ANSIBLEME_USERID=$(id -u) -v ~/work/ansible:/home/work   fvissing/ansible:77389e9a8b9c &

give it a minute or so to propperly startup , depending on wheter you run mac or linux.. mac does spend a lot of time making sure the permissions are all set corectley.
now to work in the container run
docker exec -ti ansible bash
then inside the container

su ansibleme
cd /home/work

So there is no files in this container, it is only a utility container. It usually is wrapped with some toolling, and it alsop contains some more tools, i did spend some time making this version that i could share, hope it is ok

a little background.

so in general i would have concerns running third party docker containers on my laptop.. so just to clearify some things.. here is the userwrapper script that the container runs on starrtup (this takes some time, especially for those running docker for mac)

#!/bin/bash
set -x

ANSIBLEME_GROUPID=$1
ANSIBLEME_USERID=$2

/sbin/groupmod -g ${ANSIBLEME_GROUPID} ansibleme
echo "exited $? , this might fail if we overlap with an existing group id.. this is not fatal"
echo "" >> /home/ansibleme/.bashrc
echo "exited $?"
set -e
sed -i "s/<K8S_PROD_POINTER>/$K8S_PROD_POINTER/g" /home/ansibleme/.bashrc
sed -i "s/<K8S_NONPROD_POINTER>/$K8S_NONPROD_POINTER/g" /home/ansibleme/.bashrc
chown ansibleme: /home/ansibleme/{.ssh,.bashrc,.bash_profile,.ssh/authorized_keys,.m2}
echo "exited $?"
/sbin/usermod -u ${ANSIBLEME_USERID} -g ${ANSIBLEME_GROUPID} ansibleme
echo "exited $?"
sudo -u ansibleme id
sudo ln -s /home/work /home/ansibleme
sudo ln -s /home/repository /home/ansibleme/.m2/
sudo npm config set cache /home/npm/ --global
sudo chmod go+rwx /var/run/docker.sock
touch /var/run/user-wrapper

and the Dockerfile

FROM jdeathe/centos-ssh:centos-7

HEALTHCHECK --interval=5s --timeout=3s CMD /usr/bin/healthcheck

RUN yum install -y wget \
    && wget https://www.python.org/ftp/python/3.7.0/Python-3.7.0.tgz -O /tmp/python.tgz \
    && mkdir /tmp/python \
    && yum install -y gcc openssl-devel bzip2-devel libffi-devel \
    && tar zxfv /tmp/python.tgz --directory /tmp/python --strip 1 \
    && rm -f /tmp/python.tgz \
    && cd /tmp/python \
    && ./configure --enable-optimizations \
    && make install \
    && rm -rf /tmp/python
RUN pip3 install --upgrade pip \
    && pip3 install ansible==2.9.6
RUN groupadd --g 1000 ansibleme \
    && adduser -u 1000 -g 1000 ansibleme \
    && echo "ansibleme ALL=NOPASSWD: ALL" \
        >  /etc/sudoers.d/ansibleme \
    && mkdir -p \
        /home/ansibleme/.ssh \
    && chmod 0700 \
        /home/ansibleme/.ssh \
    && touch /home/ansibleme/.bash_profile \
    && echo "ANSIBLEME_USERID=\"\${ANSIBLEME_USERID:3000}\"" \
        >>  /opt/scmi/environment.sh \
    && echo "ANSIBLEME_GROUPID=\"\${ANSIBLEME_GROUPID:3000}\"" \
        >>  /opt/scmi/environment.sh \
    && sed -i 's~SSH_USER_SHELL~SSH_USER_SHELL\n ANSIBLEME_USERID\n ANSIBLEME_GROUPID~g' \
        /opt/scmi/service-unit.sh \
    && sed -i 's~\${DOCKER_PUBLISH}"~--env \\"ANSIBLEME_USERID=\${ANSIBLEME_USERID)\\" \\\n--env \\"ANSIBLEME_GROUPID=\${ANSIBLEME_GROUPID)\\" \\\n\${DOCKER_PUBLISH}"~g' \
        /opt/scmi/default.sh \
    && ln -sf \
        /tmp \
        /home/ansibleme/.ansible \
    && wget -q "http://repos.fedorapeople.org/repos/dchen/apache-maven/epel-apache-maven.repo" \
        -O epel-apache-maven.repo \
    && cp epel-apache-maven.repo \
        /etc/yum.repos.d/epel-apache-maven.repo \
    && rm -f epel-apache-maven.repo \
    && yum clean all \
    && echo "exclude=ansible-*">> /etc/yum.conf && \
    yum update -y && \
    yum clean all
RUN mkdir -p /home/ansibleme/.m2
RUN yum install -y unzip && \
    wget -q https://github.com/dw/mitogen/archive/master.zip -O /tmp/mitogen.zip && \
    unzip /tmp/mitogen.zip -d /opt/ && \
    ln -s /opt/mitogen-master /opt/mitogen && \
    rm -f /tmp/mitogen.zip
ADD ansible/files/user-wrapper.conf /etc/supervisord.d/user-wrapper.conf
ADD ansible/files/user-wrapper.sh /sbin/user-wrapper.sh
RUN chmod u+x /sbin/user-wrapper.sh
ADD ansible/files/bashrc /home/ansibleme/.bashrc
ENV ANSIBLEME_GROUPID="1000" \
    ANSIBLEME_USERID="1000"
RUN yum versionlock delete sudo
CMD ["/usr/bin/supervisord", "--configuration=/etc/supervisord.conf"]

ONBUILD RUN yum update -y && \
    yum clean all

so the ADD sections is a problem if you want to build the container yourself.. but now i done it, so it should not be an issue i guess.
So I will not be awailable tomorrow, but i will stick arround n hour or two today if you have questios feel free to ask

@s1113950
Copy link
Collaborator

I think I have enough info to repro; I don't have time to do it now but I'll get to it within the next few days for sure 👍

@s1113950
Copy link
Collaborator

s1113950 commented May 31, 2020

Able to repro now, thanks everyone for the info!
My test scenario on various target containers:

Ansible 2.9.6
Mitogen master
various python3.5 versions

I ran this command:

ansible all -c docker -i 'testMitogen,' -e ansible_user=root -e ansible_python_interpreter=/usr/local/bin/python3 -m setup

Breaks:
python:3.5.1
python:3.5.2
python:3.5.3-jessie

Works:
python:3.5.4-jessie
python:3.5.5-jessie
python:3.5.9-buster.

Looks like the bug is Mitogen + Ansible 2.9 + Python 3.5.1-Python 3.5.3.

@s1113950
Copy link
Collaborator

s1113950 commented Jun 5, 2020

#719 this patch fixed it for me! :) The patch will make it in the next release(s) of Mitogen, which will be around when Ansible 2.10 is released.

@opoplawski
Copy link
Contributor

Any chance of a 2.9.1 release soon with this fix? Would be very helpful for myself at least. ansible 2.10 seems targeted for 2020-08-13.

@s1113950
Copy link
Collaborator

s1113950 commented Jul 9, 2020

Hmm, that is later than I expected 🤔 I don't have access to Mitogen's PyPi account, so that would be up to @dw .

@apple4ever
Copy link

Confirmed fixed for me too! YAY finally!

@opoplawski
Copy link
Contributor

I just applied the patch locally and that's working well so far. Thanks.

@iredmail
Copy link

iredmail commented Oct 9, 2020

Dear @dw , any plan for a bug fix release with this patch?

@alexmick
Copy link

alexmick commented Oct 9, 2020

Would love to see this released here too 👍

@s1113950
Copy link
Collaborator

Fix released here:
https://github.com/dw/mitogen/releases/tag/v0.2.10-rc.0 - Ansible < 2.10
https://github.com/dw/mitogen/releases/tag/v0.3.0-rc.0 - Ansible 2.10+

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
None yet
Projects
None yet
Development

Successfully merging a pull request may close this issue.