That looks like a paramiko issue. Could you open an issue at github.com/ansible/ansible and provide this output along with the output from `pip freeze`? From there we can further troubleshoot the bug.
On Tue, Nov 28, 2017 at 9:57 AM Lukas M <[email protected]> wrote: > Yes, I looked through this link and through the log file but the suggested > errors and solutions didn't work for me either.. > Here is the log file content: > > ########################################################################################################## > > > 2017-11-28 09:29:37,505 p=24401 u=lukasm | 24401 1511879377.50471: > starting run > 2017-11-28 09:29:37,635 p=24401 u=lukasm | ansible-playbook 2.4.1.0 > config file = /etc/ansible/ansible.cfg > configured module search path = > [u'/home/lukasm/.ansible/plugins/modules', > u'/usr/share/ansible/plugins/modules'] > ansible python module location = /usr/lib/python2.7/site-packages/ansible > executable location = /usr/bin/ansible-playbook > python version = 2.7.5 (default, Aug 4 2017, 00:39:18) [GCC 4.8.5 > 20150623 (Red Hat 4.8.5-16)] > 2017-11-28 09:29:37,635 p=24401 u=lukasm | Using /etc/ansible/ansible.cfg > as config file > 2017-11-28 09:29:37,635 p=24401 u=lukasm | 24401 1511879377.63537: Added > group all to inventory > 2017-11-28 09:29:37,635 p=24401 u=lukasm | 24401 1511879377.63552: Added > group ungrouped to inventory > 2017-11-28 09:29:37,635 p=24401 u=lukasm | 24401 1511879377.63565: Group > all now contains ungrouped > 2017-11-28 09:29:37,636 p=24401 u=lukasm | 24401 1511879377.63652: > Loading CacheModule 'memory' from > /usr/lib/python2.7/site-packages/ansible/plugins/cache/memory.py > 2017-11-28 09:29:37,636 p=24401 u=lukasm | setting up inventory plugins > 2017-11-28 09:29:37,637 p=24401 u=lukasm | 24401 1511879377.63782: > Loading InventoryModule 'host_list' from > /usr/lib/python2.7/site-packages/ansible/plugins/inventory/host_list.py > 2017-11-28 09:29:37,638 p=24401 u=lukasm | 24401 1511879377.63808: > Loading InventoryModule 'script' from > /usr/lib/python2.7/site-packages/ansible/plugins/inventory/script.py > 2017-11-28 09:29:37,638 p=24401 u=lukasm | 24401 1511879377.63837: > Loading InventoryModule 'yaml' from > /usr/lib/python2.7/site-packages/ansible/plugins/inventory/yaml.py > 2017-11-28 09:29:37,638 p=24401 u=lukasm | 24401 1511879377.63871: > Loading InventoryModule 'ini' from > /usr/lib/python2.7/site-packages/ansible/plugins/inventory/ini.py > 2017-11-28 09:29:37,638 p=24401 u=lukasm | 24401 1511879377.63887: > Examining possible inventory source: /etc/ansible/hosts > 2017-11-28 09:29:37,639 p=24401 u=lukasm | 24401 1511879377.63899: > Attempting to use plugin host_list > (/usr/lib/python2.7/site-packages/ansible/plugins/inventory/host_list.py) > 2017-11-28 09:29:37,639 p=24401 u=lukasm | 24401 1511879377.63911: > /etc/ansible/hosts did not meet host_list requirements > 2017-11-28 09:29:37,639 p=24401 u=lukasm | 24401 1511879377.63922: > Attempting to use plugin script > (/usr/lib/python2.7/site-packages/ansible/plugins/inventory/script.py) > 2017-11-28 09:29:37,639 p=24401 u=lukasm | 24401 1511879377.63938: > /etc/ansible/hosts did not meet script requirements > 2017-11-28 09:29:37,639 p=24401 u=lukasm | 24401 1511879377.63950: > Attempting to use plugin yaml > (/usr/lib/python2.7/site-packages/ansible/plugins/inventory/yaml.py) > 2017-11-28 09:29:37,640 p=24401 u=lukasm | 24401 1511879377.64045: > Loading data from /etc/ansible/hosts > 2017-11-28 09:29:37,642 p=24401 u=lukasm | 24401 1511879377.64277: > /etc/ansible/hosts did not meet yaml requirements > 2017-11-28 09:29:37,643 p=24401 u=lukasm | 24401 1511879377.64318: > Attempting to use plugin ini > (/usr/lib/python2.7/site-packages/ansible/plugins/inventory/ini.py) > 2017-11-28 09:29:37,647 p=24401 u=lukasm | 24401 1511879377.64778: Added > group switches to inventory > 2017-11-28 09:29:37,648 p=24401 u=lukasm | 24401 1511879377.64862: set > inventory_file for 3850-TEST > 2017-11-28 09:29:37,649 p=24401 u=lukasm | 24401 1511879377.64906: set > inventory_dir for 3850-TEST > 2017-11-28 09:29:37,649 p=24401 u=lukasm | 24401 1511879377.64939: Added > host 3850-TEST to inventory > 2017-11-28 09:29:37,649 p=24401 u=lukasm | 24401 1511879377.64968: Added > host 3850-TEST to group switches > 2017-11-28 09:29:37,650 p=24401 u=lukasm | 24401 1511879377.64999: set > ansible_host for 3850-TEST > 2017-11-28 09:29:37,650 p=24401 u=lukasm | Parsed /etc/ansible/hosts > inventory source with ini plugin > 2017-11-28 09:29:37,650 p=24401 u=lukasm | 24401 1511879377.65072: > Reconcile groups and hosts in inventory. > 2017-11-28 09:29:37,651 p=24401 u=lukasm | 24401 1511879377.65108: Group > all now contains switches > 2017-11-28 09:29:37,651 p=24401 u=lukasm | 24401 1511879377.65145: Group > all now contains 3850-TEST > 2017-11-28 09:29:37,651 p=24401 u=lukasm | 24401 1511879377.65164: > Loading CacheModule 'memory' from > /usr/lib/python2.7/site-packages/ansible/plugins/cache/memory.py > (found_in_cache=True, class_only=False) > 2017-11-28 09:29:37,661 p=24401 u=lukasm | 24401 1511879377.66144: > Loading data from /etc/ansible/templates/backup.yaml > 2017-11-28 09:29:37,749 p=24401 u=lukasm | 24401 1511879377.74934: > Loading CallbackModule 'default' from > /usr/lib/python2.7/site-packages/ansible/plugins/callback/default.py > 2017-11-28 09:29:37,749 p=24401 u=lukasm | Loading callback plugin > default of type stdout, v2.0 from > /usr/lib/python2.7/site-packages/ansible/plugins/callback/__init__.pyc > 2017-11-28 09:29:37,754 p=24401 u=lukasm | 24401 1511879377.75480: > assigned :doc > 2017-11-28 09:29:37,756 p=24401 u=lukasm | 24401 1511879377.75619: > Loading CallbackModule 'actionable' from > /usr/lib/python2.7/site-packages/ansible/plugins/callback/actionable.py > (found_in_cache=False, class_only=True) > 2017-11-28 09:29:37,760 p=24401 u=lukasm | 24401 1511879377.76039: > assigned :doc > 2017-11-28 09:29:37,760 p=24401 u=lukasm | 24401 1511879377.76072: > Loading CallbackModule 'context_demo' from > /usr/lib/python2.7/site-packages/ansible/plugins/callback/context_demo.py > (found_in_cache=False, class_only=True) > 2017-11-28 09:29:37,762 p=24401 u=lukasm | 24401 1511879377.76293: > assigned :doc > 2017-11-28 09:29:37,763 p=24401 u=lukasm | 24401 1511879377.76323: > Loading CallbackModule 'debug' from > /usr/lib/python2.7/site-packages/ansible/plugins/callback/debug.py > (found_in_cache=False, class_only=True) > 2017-11-28 09:29:37,765 p=24401 u=lukasm | 24401 1511879377.76555: > assigned :doc > 2017-11-28 09:29:37,765 p=24401 u=lukasm | 24401 1511879377.76573: > Loading CallbackModule 'default' from > /usr/lib/python2.7/site-packages/ansible/plugins/callback/default.py > (found_in_cache=False, class_only=True) > 2017-11-28 09:29:37,788 p=24401 u=lukasm | 24401 1511879377.78805: > assigned :doc > 2017-11-28 09:29:37,789 p=24401 u=lukasm | 24401 1511879377.78900: > Loading CallbackModule 'dense' from > /usr/lib/python2.7/site-packages/ansible/plugins/callback/dense.py > (found_in_cache=False, class_only=True) > 2017-11-28 09:29:37,794 p=24401 u=lukasm | 24401 1511879377.79429: > assigned :doc > 2017-11-28 09:29:37,815 p=24401 u=lukasm | 24401 1511879377.81504: > Loading CallbackModule 'foreman' from > /usr/lib/python2.7/site-packages/ansible/plugins/callback/foreman.py > (found_in_cache=False, class_only=True) > 2017-11-28 09:29:37,823 p=24401 u=lukasm | 24401 1511879377.82330: > assigned :doc > 2017-11-28 09:29:37,823 p=24401 u=lukasm | 24401 1511879377.82356: > Loaded config def from plugin (callback/foreman) > 2017-11-28 09:29:37,823 p=24401 u=lukasm | 24401 1511879377.82384: > Loading CallbackModule 'full_skip' from > /usr/lib/python2.7/site-packages/ansible/plugins/callback/full_skip.py > (found_in_cache=False, class_only=True) > 2017-11-28 09:29:37,826 p=24401 u=lukasm | 24401 1511879377.82642: > assigned :doc > 2017-11-28 09:29:37,839 p=24401 u=lukasm | 24401 1511879377.83949: > Loading CallbackModule 'hipchat' from > /usr/lib/python2.7/site-packages/ansible/plugins/callback/hipchat.py > (found_in_cache=False, class_only=True) > 2017-11-28 09:29:37,848 p=24401 u=lukasm | 24401 1511879377.84870: > assigned :doc > 2017-11-28 09:29:37,848 p=24401 u=lukasm | 24401 1511879377.84892: > Loaded config def from plugin (callback/hipchat) > 2017-11-28 09:29:37,849 p=24401 u=lukasm | 24401 1511879377.84925: > Loading CallbackModule 'jabber' from > /usr/lib/python2.7/site-packages/ansible/plugins/callback/jabber.py > (found_in_cache=False, class_only=True) > 2017-11-28 09:29:37,856 p=24401 u=lukasm | 24401 1511879377.85638: > assigned :doc > 2017-11-28 09:29:37,856 p=24401 u=lukasm | 24401 1511879377.85661: > Loaded config def from plugin (callback/jabber) > 2017-11-28 09:29:37,856 p=24401 u=lukasm | 24401 1511879377.85688: > Loading CallbackModule 'json' from > /usr/lib/python2.7/site-packages/ansible/plugins/callback/json.py > (found_in_cache=False, class_only=True) > 2017-11-28 09:29:37,859 p=24401 u=lukasm | 24401 1511879377.85909: > assigned :doc > 2017-11-28 09:29:37,859 p=24401 u=lukasm | 24401 1511879377.85960: > Loading CallbackModule 'junit' from > /usr/lib/python2.7/site-packages/ansible/plugins/callback/junit.py > (found_in_cache=False, class_only=True) > 2017-11-28 09:29:37,873 p=24401 u=lukasm | 24401 1511879377.87323: > assigned :doc > 2017-11-28 09:29:37,873 p=24401 u=lukasm | 24401 1511879377.87357: > Loaded config def from plugin (callback/junit) > 2017-11-28 09:29:37,873 p=24401 u=lukasm | 24401 1511879377.87387: > Loading CallbackModule 'log_plays' from > /usr/lib/python2.7/site-packages/ansible/plugins/callback/log_plays.py > (found_in_cache=False, class_only=True) > 2017-11-28 09:29:37,876 p=24401 u=lukasm | 24401 1511879377.87666: > assigned :doc > 2017-11-28 09:29:37,877 p=24401 u=lukasm | 24401 1511879377.87719: > Loading CallbackModule 'logentries' from > /usr/lib/python2.7/site-packages/ansible/plugins/callback/logentries.py > (found_in_cache=False, class_only=True) > 2017-11-28 09:29:37,892 p=24401 u=lukasm | 24401 1511879377.89276: > assigned :doc > 2017-11-28 09:29:37,892 p=24401 u=lukasm | 24401 1511879377.89289: > assigned :plainexamples > 2017-11-28 09:29:37,893 p=24401 u=lukasm | 24401 1511879377.89313: > Loaded config def from plugin (callback/logentries) > 2017-11-28 09:29:37,893 p=24401 u=lukasm | 24401 1511879377.89355: > Loading CallbackModule 'logstash' from > /usr/lib/python2.7/site-packages/ansible/plugins/callback/logstash.py > (found_in_cache=False, class_only=True) > 2017-11-28 09:29:37,899 p=24401 u=lukasm | 24401 1511879377.89977: > assigned :doc > 2017-11-28 09:29:37,900 p=24401 u=lukasm | 24401 1511879377.89999: > Loaded config def from plugin (callback/logstash) > 2017-11-28 09:29:37,901 p=24401 u=lukasm | 24401 1511879377.90171: > Loading CallbackModule 'mail' from > /usr/lib/python2.7/site-packages/ansible/plugins/callback/mail.py > (found_in_cache=False, class_only=True) > 2017-11-28 09:29:37,912 p=24401 u=lukasm | 24401 1511879377.91273: > assigned :doc > 2017-11-28 09:29:37,913 p=24401 u=lukasm | 24401 1511879377.91295: > Loaded config def from plugin (callback/mail) > 2017-11-28 09:29:37,913 p=24401 u=lukasm | 24401 1511879377.91323: > Loading CallbackModule 'minimal' from > /usr/lib/python2.7/site-packages/ansible/plugins/callback/minimal.py > (found_in_cache=False, class_only=True) > 2017-11-28 09:29:37,915 p=24401 u=lukasm | 24401 1511879377.91549: > assigned :doc > 2017-11-28 09:29:37,915 p=24401 u=lukasm | 24401 1511879377.91583: > Loading CallbackModule 'oneline' from > /usr/lib/python2.7/site-packages/ansible/plugins/callback/oneline.py > (found_in_cache=False, class_only=True) > 2017-11-28 09:29:37,918 p=24401 u=lukasm | 24401 1511879377.91798: > assigned :doc > 2017-11-28 09:29:37,918 p=24401 u=lukasm | 24401 1511879377.91839: > Loading CallbackModule 'osx_say' from > /usr/lib/python2.7/site-packages/ansible/plugins/callback/osx_say.py > (found_in_cache=False, class_only=True) > 2017-11-28 09:29:37,922 p=24401 u=lukasm | 24401 1511879377.92217: > assigned :doc > 2017-11-28 09:29:37,923 p=24401 u=lukasm | 24401 1511879377.92316: > Loading CallbackModule 'profile_roles' from > /usr/lib/python2.7/site-packages/ansible/plugins/callback/profile_roles.py > (found_in_cache=False, class_only=True) > 2017-11-28 09:29:37,929 p=24401 u=lukasm | 24401 1511879377.92940: > assigned :doc > 2017-11-28 09:29:37,930 p=24401 u=lukasm | 24401 1511879377.93037: > Loading CallbackModule 'profile_tasks' from > /usr/lib/python2.7/site-packages/ansible/plugins/callback/profile_tasks.py > (found_in_cache=False, class_only=True) > 2017-11-28 09:29:37,938 p=24401 u=lukasm | 24401 1511879377.93891: > assigned :doc > 2017-11-28 09:29:37,939 p=24401 u=lukasm | 24401 1511879377.93904: > assigned :plainexamples > 2017-11-28 09:29:37,939 p=24401 u=lukasm | 24401 1511879377.93924: > Loaded config def from plugin (callback/profile_tasks) > 2017-11-28 09:29:37,939 p=24401 u=lukasm | 24401 1511879377.93963: > Loading CallbackModule 'selective' from > /usr/lib/python2.7/site-packages/ansible/plugins/callback/selective.py > (found_in_cache=False, class_only=True) > 2017-11-28 09:29:37,946 p=24401 u=lukasm | 24401 1511879377.94649: > assigned :doc > 2017-11-28 09:29:37,946 p=24401 u=lukasm | 24401 1511879377.94662: > assigned :plainexamples > 2017-11-28 09:29:37,946 p=24401 u=lukasm | 24401 1511879377.94689: > Loaded config def from plugin (callback/selective) > 2017-11-28 09:29:37,947 p=24401 u=lukasm | 24401 1511879377.94717: > Loading CallbackModule 'skippy' from > /usr/lib/python2.7/site-packages/ansible/plugins/callback/skippy.py > (found_in_cache=False, class_only=True) > 2017-11-28 09:29:37,949 p=24401 u=lukasm | 24401 1511879377.94954: > assigned :doc > 2017-11-28 09:29:37,949 p=24401 u=lukasm | 24401 1511879377.94992: > Loading CallbackModule 'slack' from > /usr/lib/python2.7/site-packages/ansible/plugins/callback/slack.py > (found_in_cache=False, class_only=True) > 2017-11-28 09:29:37,963 p=24401 u=lukasm | 24401 1511879377.96318: > assigned :doc > 2017-11-28 09:29:37,963 p=24401 u=lukasm | 24401 1511879377.96349: > Loaded config def from plugin (callback/slack) > 2017-11-28 09:29:37,963 p=24401 u=lukasm | 24401 1511879377.96378: > Loading CallbackModule 'stderr' from > /usr/lib/python2.7/site-packages/ansible/plugins/callback/stderr.py > (found_in_cache=False, class_only=True) > 2017-11-28 09:29:37,966 p=24401 u=lukasm | 24401 1511879377.96670: > assigned :doc > 2017-11-28 09:29:37,967 p=24401 u=lukasm | 24401 1511879377.96758: > Loading CallbackModule 'syslog_json' from > /usr/lib/python2.7/site-packages/ansible/plugins/callback/syslog_json.py > (found_in_cache=False, class_only=True) > 2017-11-28 09:29:37,982 p=24401 u=lukasm | 24401 1511879377.98246: > assigned :doc > 2017-11-28 09:29:37,982 p=24401 u=lukasm | 24401 1511879377.98265: > Loaded config def from plugin (callback/syslog_json) > 2017-11-28 09:29:37,982 p=24401 u=lukasm | 24401 1511879377.98292: > Loading CallbackModule 'timer' from > /usr/lib/python2.7/site-packages/ansible/plugins/callback/timer.py > (found_in_cache=False, class_only=True) > 2017-11-28 09:29:37,985 p=24401 u=lukasm | 24401 1511879377.98496: > assigned :doc > 2017-11-28 09:29:37,985 p=24401 u=lukasm | 24401 1511879377.98528: > Loading CallbackModule 'tree' from > /usr/lib/python2.7/site-packages/ansible/plugins/callback/tree.py > (found_in_cache=False, class_only=True) > 2017-11-28 09:29:37,987 p=24401 u=lukasm | 24401 1511879377.98789: > assigned :doc > 2017-11-28 09:29:37,988 p=24401 u=lukasm | PLAYBOOK: backup.yaml > *********************************************************************************************************************************************************************** > 2017-11-28 09:29:37,988 p=24401 u=lukasm | 1 plays in backup.yaml > 2017-11-28 09:29:37,988 p=24401 u=lukasm | 24401 1511879377.98835: in > VariableManager get_vars() > 2017-11-28 09:29:38,004 p=24401 u=lukasm | 24401 1511879378.00408: > Loading FilterModule 'core' from > /usr/lib/python2.7/site-packages/ansible/plugins/filter/core.py > 2017-11-28 09:29:38,014 p=24401 u=lukasm | 24401 1511879378.01477: > Loading FilterModule 'ipaddr' from > /usr/lib/python2.7/site-packages/ansible/plugins/filter/ipaddr.py > 2017-11-28 09:29:38,015 p=24401 u=lukasm | 24401 1511879378.01509: > Loading FilterModule 'json_query' from > /usr/lib/python2.7/site-packages/ansible/plugins/filter/json_query.py > 2017-11-28 09:29:38,015 p=24401 u=lukasm | 24401 1511879378.01541: > Loading FilterModule 'mathstuff' from > /usr/lib/python2.7/site-packages/ansible/plugins/filter/mathstuff.py > 2017-11-28 09:29:38,016 p=24401 u=lukasm | 24401 1511879378.01604: > Loading FilterModule 'network' from > /usr/lib/python2.7/site-packages/ansible/plugins/filter/network.py > 2017-11-28 09:29:38,016 p=24401 u=lukasm | 24401 1511879378.01630: > Loading FilterModule 'urlsplit' from > /usr/lib/python2.7/site-packages/ansible/plugins/filter/urlsplit.py > 2017-11-28 09:29:38,017 p=24401 u=lukasm | 24401 1511879378.01708: > Loading TestModule 'core' from > /usr/lib/python2.7/site-packages/ansible/plugins/test/core.py > 2017-11-28 09:29:38,017 p=24401 u=lukasm | 24401 1511879378.01732: > Loading TestModule 'files' from > /usr/lib/python2.7/site-packages/ansible/plugins/test/files.py > 2017-11-28 09:29:38,018 p=24401 u=lukasm | 24401 1511879378.01807: > Loading TestModule 'mathstuff' from > /usr/lib/python2.7/site-packages/ansible/plugins/test/mathstuff.py > 2017-11-28 09:29:38,022 p=24401 u=lukasm | 24401 1511879378.02241: done > with get_vars() > 2017-11-28 09:29:38,022 p=24401 u=lukasm | 24401 1511879378.02284: in > VariableManager get_vars() > 2017-11-28 09:29:38,023 p=24401 u=lukasm | 24401 1511879378.02317: > Loading FilterModule 'core' from > /usr/lib/python2.7/site-packages/ansible/plugins/filter/core.py > (found_in_cache=True, class_only=False) > 2017-11-28 09:29:38,023 p=24401 u=lukasm | 24401 1511879378.02329: > Loading FilterModule 'ipaddr' from > /usr/lib/python2.7/site-packages/ansible/plugins/filter/ipaddr.py > (found_in_cache=True, class_only=False) > 2017-11-28 09:29:38,023 p=24401 u=lukasm | 24401 1511879378.02347: > Loading FilterModule 'json_query' from > /usr/lib/python2.7/site-packages/ansible/plugins/filter/json_query.py > (found_in_cache=True, class_only=False) > 2017-11-28 09:29:38,023 p=24401 u=lukasm | 24401 1511879378.02359: > Loading FilterModule 'mathstuff' from > /usr/lib/python2.7/site-packages/ansible/plugins/filter/mathstuff.py > (found_in_cache=True, class_only=False) > 2017-11-28 09:29:38,023 p=24401 u=lukasm | 24401 1511879378.02370: > Loading FilterModule 'network' from > /usr/lib/python2.7/site-packages/ansible/plugins/filter/network.py > (found_in_cache=True, class_only=False) > 2017-11-28 09:29:38,023 p=24401 u=lukasm | 24401 1511879378.02382: > Loading FilterModule 'urlsplit' from > /usr/lib/python2.7/site-packages/ansible/plugins/filter/urlsplit.py > (found_in_cache=True, class_only=False) > 2017-11-28 09:29:38,024 p=24401 u=lukasm | 24401 1511879378.02422: > Loading TestModule 'core' from > /usr/lib/python2.7/site-packages/ansible/plugins/test/core.py > (found_in_cache=True, class_only=False) > 2017-11-28 09:29:38,024 p=24401 u=lukasm | 24401 1511879378.02437: > Loading TestModule 'files' from > /usr/lib/python2.7/site-packages/ansible/plugins/test/files.py > (found_in_cache=True, class_only=False) > 2017-11-28 09:29:38,024 p=24401 u=lukasm | 24401 1511879378.02450: > Loading TestModule 'mathstuff' from > /usr/lib/python2.7/site-packages/ansible/plugins/test/mathstuff.py > (found_in_cache=True, class_only=False) > 2017-11-28 09:29:38,025 p=24401 u=lukasm | 24401 1511879378.02514: done > with get_vars() > 2017-11-28 09:29:38,025 p=24401 u=lukasm | PLAY [all] > ********************************************************************************************************************************************************************************** > 2017-11-28 09:29:38,031 p=24401 u=lukasm | 24401 1511879378.03095: > Loading StrategyModule 'linear' from > /usr/lib/python2.7/site-packages/ansible/plugins/strategy/linear.py > 2017-11-28 09:29:38,032 p=24401 u=lukasm | 24401 1511879378.03256: > getting the remaining hosts for this loop > 2017-11-28 09:29:38,032 p=24401 u=lukasm | 24401 1511879378.03271: done > getting the remaining hosts for this loop > 2017-11-28 09:29:38,032 p=24401 u=lukasm | 24401 1511879378.03283: > building list of next tasks for hosts > 2017-11-28 09:29:38,032 p=24401 u=lukasm | 24401 1511879378.03294: > getting the next task for host 3850-TEST > 2017-11-28 09:29:38,033 p=24401 u=lukasm | 24401 1511879378.03307: done > getting next task for host 3850-TEST > 2017-11-28 09:29:38,033 p=24401 u=lukasm | 24401 1511879378.03318: ^ > task is: TASK: meta (flush_handlers) > 2017-11-28 09:29:38,033 p=24401 u=lukasm | 24401 1511879378.03329: ^ > state is: HOST STATE: block=1, task=1, rescue=0, always=0, > run_state=ITERATING_TASKS, fail_state=FAILED_NONE, pending_setup=False, > tasks child state? (None), rescue child state? (None), always child state? > (None), did rescue? False, did start at task? False > 2017-11-28 09:29:38,033 p=24401 u=lukasm | 24401 1511879378.03343: done > building task lists > 2017-11-28 09:29:38,033 p=24401 u=lukasm | 24401 1511879378.03353: > counting tasks in each state of execution > 2017-11-28 09:29:38,033 p=24401 u=lukasm | 24401 1511879378.03363: done > counting tasks in each state of execution: > num_setups: 0 > num_tasks: 1 > num_rescue: 0 > num_always: 0 > 2017-11-28 09:29:38,033 p=24401 u=lukasm | 24401 1511879378.03375: > advancing hosts in ITERATING_TASKS > 2017-11-28 09:29:38,033 p=24401 u=lukasm | 24401 1511879378.03385: > starting to advance hosts > 2017-11-28 09:29:38,033 p=24401 u=lukasm | 24401 1511879378.03395: > getting the next task for host 3850-TEST > 2017-11-28 09:29:38,034 p=24401 u=lukasm | 24401 1511879378.03407: done > getting next task for host 3850-TEST > 2017-11-28 09:29:38,034 p=24401 u=lukasm | 24401 1511879378.03418: ^ > task is: TASK: meta (flush_handlers) > 2017-11-28 09:29:38,034 p=24401 u=lukasm | 24401 1511879378.03428: ^ > state is: HOST STATE: block=1, task=1, rescue=0, always=0, > run_state=ITERATING_TASKS, fail_state=FAILED_NONE, pending_setup=False, > tasks child state? (None), rescue child state? (None), always child state? > (None), did rescue? False, did start at task? False > 2017-11-28 09:29:38,034 p=24401 u=lukasm | 24401 1511879378.03440: done > advancing hosts to next task > 2017-11-28 09:29:38,034 p=24401 u=lukasm | META: ran handlers > 2017-11-28 09:29:38,034 p=24401 u=lukasm | 24401 1511879378.03465: done > queuing things up, now waiting for results queue to drain > 2017-11-28 09:29:38,034 p=24401 u=lukasm | 24401 1511879378.03475: > results queue empty > 2017-11-28 09:29:38,034 p=24401 u=lukasm | 24401 1511879378.03485: > checking for any_errors_fatal > 2017-11-28 09:29:38,034 p=24401 u=lukasm | 24401 1511879378.03495: done > checking for any_errors_fatal > 2017-11-28 09:29:38,035 p=24401 u=lukasm | 24401 1511879378.03504: > checking for max_fail_percentage > 2017-11-28 09:29:38,035 p=24401 u=lukasm | 24401 1511879378.03514: done > checking for max_fail_percentage > 2017-11-28 09:29:38,035 p=24401 u=lukasm | 24401 1511879378.03523: > checking to see if all hosts have failed and the running result is not ok > 2017-11-28 09:29:38,035 p=24401 u=lukasm | 24401 1511879378.03534: done > checking to see if all hosts have failed > 2017-11-28 09:29:38,035 p=24401 u=lukasm | 24401 1511879378.03544: > getting the remaining hosts for this loop > 2017-11-28 09:29:38,035 p=24401 u=lukasm | 24401 1511879378.03555: done > getting the remaining hosts for this loop > 2017-11-28 09:29:38,035 p=24401 u=lukasm | 24401 1511879378.03566: > building list of next tasks for hosts > 2017-11-28 09:29:38,035 p=24401 u=lukasm | 24401 1511879378.03576: > getting the next task for host 3850-TEST > 2017-11-28 09:29:38,035 p=24401 u=lukasm | 24401 1511879378.03588: done > getting next task for host 3850-TEST > 2017-11-28 09:29:38,036 p=24401 u=lukasm | 24401 1511879378.03598: ^ > task is: TASK: Execute Show run command > 2017-11-28 09:29:38,036 p=24401 u=lukasm | 24401 1511879378.03609: ^ > state is: HOST STATE: block=2, task=1, rescue=0, always=0, > run_state=ITERATING_TASKS, fail_state=FAILED_NONE, pending_setup=False, > tasks child state? (None), rescue child state? (None), always child state? > (None), did rescue? False, did start at task? False > 2017-11-28 09:29:38,036 p=24401 u=lukasm | 24401 1511879378.03619: done > building task lists > 2017-11-28 09:29:38,036 p=24401 u=lukasm | 24401 1511879378.03628: > counting tasks in each state of execution > 2017-11-28 09:29:38,036 p=24401 u=lukasm | 24401 1511879378.03640: done > counting tasks in each state of execution: > num_setups: 0 > num_tasks: 1 > num_rescue: 0 > num_always: 0 > 2017-11-28 09:29:38,036 p=24401 u=lukasm | 24401 1511879378.03650: > advancing hosts in ITERATING_TASKS > 2017-11-28 09:29:38,036 p=24401 u=lukasm | 24401 1511879378.03660: > starting to advance hosts > 2017-11-28 09:29:38,036 p=24401 u=lukasm | 24401 1511879378.03670: > getting the next task for host 3850-TEST > 2017-11-28 09:29:38,036 p=24401 u=lukasm | 24401 1511879378.03681: done > getting next task for host 3850-TEST > 2017-11-28 09:29:38,036 p=24401 u=lukasm | 24401 1511879378.03692: ^ > task is: TASK: Execute Show run command > 2017-11-28 09:29:38,037 p=24401 u=lukasm | 24401 1511879378.03702: ^ > state is: HOST STATE: block=2, task=1, rescue=0, always=0, > run_state=ITERATING_TASKS, fail_state=FAILED_NONE, pending_setup=False, > tasks child state? (None), rescue child state? (None), always child state? > (None), did rescue? False, did start at task? False > 2017-11-28 09:29:38,037 p=24401 u=lukasm | 24401 1511879378.03713: done > advancing hosts to next task > 2017-11-28 09:29:38,037 p=24401 u=lukasm | 24401 1511879378.03726: > getting variables > 2017-11-28 09:29:38,037 p=24401 u=lukasm | 24401 1511879378.03738: in > VariableManager get_vars() > 2017-11-28 09:29:38,037 p=24401 u=lukasm | 24401 1511879378.03770: > Loading FilterModule 'core' from > /usr/lib/python2.7/site-packages/ansible/plugins/filter/core.py > (found_in_cache=True, class_only=False) > 2017-11-28 09:29:38,037 p=24401 u=lukasm | 24401 1511879378.03782: > Loading FilterModule 'ipaddr' from > /usr/lib/python2.7/site-packages/ansible/plugins/filter/ipaddr.py > (found_in_cache=True, class_only=False) > 2017-11-28 09:29:38,037 p=24401 u=lukasm | 24401 1511879378.03794: > Loading FilterModule 'json_query' from > /usr/lib/python2.7/site-packages/ansible/plugins/filter/json_query.py > (found_in_cache=True, class_only=False) > 2017-11-28 09:29:38,038 p=24401 u=lukasm | 24401 1511879378.03805: > Loading FilterModule 'mathstuff' from > /usr/lib/python2.7/site-packages/ansible/plugins/filter/mathstuff.py > (found_in_cache=True, class_only=False) > 2017-11-28 09:29:38,038 p=24401 u=lukasm | 24401 1511879378.03816: > Loading FilterModule 'network' from > /usr/lib/python2.7/site-packages/ansible/plugins/filter/network.py > (found_in_cache=True, class_only=False) > 2017-11-28 09:29:38,038 p=24401 u=lukasm | 24401 1511879378.03827: > Loading FilterModule 'urlsplit' from > /usr/lib/python2.7/site-packages/ansible/plugins/filter/urlsplit.py > (found_in_cache=True, class_only=False) > 2017-11-28 09:29:38,038 p=24401 u=lukasm | 24401 1511879378.03853: > Loading TestModule 'core' from > /usr/lib/python2.7/site-packages/ansible/plugins/test/core.py > (found_in_cache=True, class_only=False) > 2017-11-28 09:29:38,038 p=24401 u=lukasm | 24401 1511879378.03865: > Loading TestModule 'files' from > /usr/lib/python2.7/site-packages/ansible/plugins/test/files.py > (found_in_cache=True, class_only=False) > 2017-11-28 09:29:38,038 p=24401 u=lukasm | 24401 1511879378.03876: > Loading TestModule 'mathstuff' from > /usr/lib/python2.7/site-packages/ansible/plugins/test/mathstuff.py > (found_in_cache=True, class_only=False) > 2017-11-28 09:29:38,039 p=24401 u=lukasm | 24401 1511879378.03955: > Calling all_inventory to load vars for 3850-TEST > 2017-11-28 09:29:38,039 p=24401 u=lukasm | 24401 1511879378.03983: > Calling groups_inventory to load vars for 3850-TEST > 2017-11-28 09:29:38,040 p=24401 u=lukasm | 24401 1511879378.03996: > Calling all_plugins_inventory to load vars for 3850-TEST > 2017-11-28 09:29:38,040 p=24401 u=lukasm | 24401 1511879378.04071: > Loading VarsModule 'host_group_vars' from > /usr/lib/python2.7/site-packages/ansible/plugins/vars/host_group_vars.py > 2017-11-28 09:29:38,040 p=24401 u=lukasm | 24401 1511879378.04094: > Calling all_plugins_play to load vars for 3850-TEST > 2017-11-28 09:29:38,041 p=24401 u=lukasm | 24401 1511879378.04116: > Loading VarsModule 'host_group_vars' from > /usr/lib/python2.7/site-packages/ansible/plugins/vars/host_group_vars.py > (found_in_cache=True, class_only=False) > 2017-11-28 09:29:38,041 p=24401 u=lukasm | 24401 1511879378.04140: > Calling groups_plugins_inventory to load vars for 3850-TEST > 2017-11-28 09:29:38,041 p=24401 u=lukasm | 24401 1511879378.04164: > Loading VarsModule 'host_group_vars' from > /usr/lib/python2.7/site-packages/ansible/plugins/vars/host_group_vars.py > (found_in_cache=True, class_only=False) > 2017-11-28 09:29:38,041 p=24401 u=lukasm | 24401 1511879378.04185: > Calling groups_plugins_play to load vars for 3850-TEST > 2017-11-28 09:29:38,042 p=24401 u=lukasm | 24401 1511879378.04206: > Loading VarsModule 'host_group_vars' from > /usr/lib/python2.7/site-packages/ansible/plugins/vars/host_group_vars.py > (found_in_cache=True, class_only=False) > 2017-11-28 09:29:38,042 p=24401 u=lukasm | 24401 1511879378.04242: > Loading VarsModule 'host_group_vars' from > /usr/lib/python2.7/site-packages/ansible/plugins/vars/host_group_vars.py > (found_in_cache=True, class_only=False) > 2017-11-28 09:29:38,042 p=24401 u=lukasm | 24401 1511879378.04262: > processing dir /etc/ansible/host_vars > 2017-11-28 09:29:38,042 p=24401 u=lukasm | 24401 1511879378.04278: > Loading data from /etc/ansible/host_vars/3850-TEST > 2017-11-28 09:29:38,045 p=24401 u=lukasm | 24401 1511879378.04571: > Loading VarsModule 'host_group_vars' from > /usr/lib/python2.7/site-packages/ansible/plugins/vars/host_group_vars.py > (found_in_cache=True, class_only=False) > 2017-11-28 09:29:38,046 p=24401 u=lukasm | 24401 1511879378.04671: done > with get_vars() > 2017-11-28 09:29:38,047 p=24401 u=lukasm | 24401 1511879378.04723: done > getting variables > 2017-11-28 09:29:38,047 p=24401 u=lukasm | 24401 1511879378.04759: > sending task start callback, copying the task so we can template it > temporarily > 2017-11-28 09:29:38,048 p=24401 u=lukasm | 24401 1511879378.04791: done > copying, going to template now > 2017-11-28 09:29:38,048 p=24401 u=lukasm | 24401 1511879378.04822: done > templating > 2017-11-28 09:29:38,048 p=24401 u=lukasm | 24401 1511879378.04850: here > goes the callback... > 2017-11-28 09:29:38,048 p=24401 u=lukasm | TASK [Execute Show run > command] > ************************************************************************************************************************************************************* > 2017-11-28 09:29:38,049 p=24401 u=lukasm | task path: > /etc/ansible/templates/backup.yaml:7 > 2017-11-28 09:29:38,049 p=24401 u=lukasm | 24401 1511879378.04949: > sending task start callback > 2017-11-28 09:29:38,049 p=24401 u=lukasm | 24401 1511879378.04980: > entering _queue_task() for 3850-TEST/ios_command > 2017-11-28 09:29:38,050 p=24401 u=lukasm | 24401 1511879378.05009: > Creating lock for ios_command > 2017-11-28 09:29:38,052 p=24401 u=lukasm | 24401 1511879378.05194: > worker is 1 (out of 1 available) > 2017-11-28 09:29:38,052 p=24401 u=lukasm | 24401 1511879378.05260: > exiting _queue_task() for 3850-TEST/ios_command > 2017-11-28 09:29:38,052 p=24401 u=lukasm | 24401 1511879378.05279: done > queuing things up, now waiting for results queue to drain > 2017-11-28 09:29:38,052 p=24401 u=lukasm | 24401 1511879378.05291: > waiting for pending results... > 2017-11-28 09:29:38,057 p=24401 u=lukasm | 24413 1511879378.05742: > running TaskExecutor() for 3850-TEST/TASK: Execute Show run command > 2017-11-28 09:29:38,059 p=24401 u=lukasm | 24413 1511879378.05887: in > run() - task 0050569e-a860-2e0a-50e5-000000000008 > 2017-11-28 09:29:38,060 p=24401 u=lukasm | 24413 1511879378.06036: > calling self._execute() > 2017-11-28 09:29:38,063 p=24401 u=lukasm | 24413 1511879378.06350: > Loading FilterModule 'core' from > /usr/lib/python2.7/site-packages/ansible/plugins/filter/core.py > (found_in_cache=True, class_only=False) > 2017-11-28 09:29:38,063 p=24401 u=lukasm | 24413 1511879378.06367: > Loading FilterModule 'ipaddr' from > /usr/lib/python2.7/site-packages/ansible/plugins/filter/ipaddr.py > (found_in_cache=True, class_only=False) > 2017-11-28 09:29:38,063 p=24401 u=lukasm | 24413 1511879378.06381: > Loading FilterModule 'json_query' from > /usr/lib/python2.7/site-packages/ansible/plugins/filter/json_query.py > (found_in_cache=True, class_only=False) > 2017-11-28 09:29:38,063 p=24401 u=lukasm | 24413 1511879378.06393: > Loading FilterModule 'mathstuff' from > /usr/lib/python2.7/site-packages/ansible/plugins/filter/mathstuff.py > (found_in_cache=True, class_only=False) > 2017-11-28 09:29:38,064 p=24401 u=lukasm | 24413 1511879378.06406: > Loading FilterModule 'network' from > /usr/lib/python2.7/site-packages/ansible/plugins/filter/network.py > (found_in_cache=True, class_only=False) > 2017-11-28 09:29:38,064 p=24401 u=lukasm | 24413 1511879378.06419: > Loading FilterModule 'urlsplit' from > /usr/lib/python2.7/site-packages/ansible/plugins/filter/urlsplit.py > (found_in_cache=True, class_only=False) > 2017-11-28 09:29:38,064 p=24401 u=lukasm | 24413 1511879378.06463: > Loading TestModule 'core' from > /usr/lib/python2.7/site-packages/ansible/plugins/test/core.py > (found_in_cache=True, class_only=False) > 2017-11-28 09:29:38,064 p=24401 u=lukasm | 24413 1511879378.06477: > Loading TestModule 'files' from > /usr/lib/python2.7/site-packages/ansible/plugins/test/files.py > (found_in_cache=True, class_only=False) > 2017-11-28 09:29:38,064 p=24401 u=lukasm | 24413 1511879378.06491: > Loading TestModule 'mathstuff' from > /usr/lib/python2.7/site-packages/ansible/plugins/test/mathstuff.py > (found_in_cache=True, class_only=False) > 2017-11-28 09:29:38,069 p=24401 u=lukasm | 24413 1511879378.06975: > Loading Connection 'local' from > /usr/lib/python2.7/site-packages/ansible/plugins/connection/local.py > 2017-11-28 09:29:38,070 p=24401 u=lukasm | 24413 1511879378.07047: > Loading ShellModule 'csh' from > /usr/lib/python2.7/site-packages/ansible/plugins/shell/csh.py > 2017-11-28 09:29:38,071 p=24401 u=lukasm | 24413 1511879378.07094: > Loading ShellModule 'fish' from > /usr/lib/python2.7/site-packages/ansible/plugins/shell/fish.py > 2017-11-28 09:29:38,071 p=24401 u=lukasm | 24413 1511879378.07110: > Loading ShellModule 'powershell' from > /usr/lib/python2.7/site-packages/ansible/plugins/shell/powershell.py > 2017-11-28 09:29:38,071 p=24401 u=lukasm | 24413 1511879378.07123: > Loading ShellModule 'sh' from > /usr/lib/python2.7/site-packages/ansible/plugins/shell/sh.py > 2017-11-28 09:29:38,071 p=24401 u=lukasm | 24413 1511879378.07154: > Loading ShellModule 'sh' from > /usr/lib/python2.7/site-packages/ansible/plugins/shell/sh.py > (found_in_cache=True, class_only=False) > 2017-11-28 09:29:38,077 p=24401 u=lukasm | 24413 1511879378.07701: > assigned :doc > 2017-11-28 09:29:38,078 p=24401 u=lukasm | 24413 1511879378.07814: > Loading ActionModule 'ios' from > /usr/lib/python2.7/site-packages/ansible/plugins/action/ios.py > 2017-11-28 09:29:38,078 p=24401 u=lukasm | 24413 1511879378.07831: > starting attempt loop > 2017-11-28 09:29:38,078 p=24401 u=lukasm | 24413 1511879378.07875: > running the handler > 2017-11-28 09:29:38,081 p=24401 u=lukasm | 24413 1511879378.08154: > Loading Connection 'persistent' from > /usr/lib/python2.7/site-packages/ansible/plugins/connection/persistent.py > 2017-11-28 09:29:38,082 p=24401 u=lukasm | 24413 1511879378.08212: > Loading ShellModule 'csh' from > /usr/lib/python2.7/site-packages/ansible/plugins/shell/csh.py > (found_in_cache=True, class_only=False) > 2017-11-28 09:29:38,082 p=24401 u=lukasm | 24413 1511879378.08247: > Loading ShellModule 'fish' from > /usr/lib/python2.7/site-packages/ansible/plugins/shell/fish.py > (found_in_cache=True, class_only=False) > 2017-11-28 09:29:38,082 p=24401 u=lukasm | 24413 1511879378.08278: > Loading ShellModule 'powershell' from > /usr/lib/python2.7/site-packages/ansible/plugins/shell/powershell.py > (found_in_cache=True, class_only=False) > 2017-11-28 09:29:38,083 p=24401 u=lukasm | 24413 1511879378.08299: > Loading ShellModule 'sh' from > /usr/lib/python2.7/site-packages/ansible/plugins/shell/sh.py > (found_in_cache=True, class_only=False) > 2017-11-28 09:29:38,083 p=24401 u=lukasm | 24413 1511879378.08338: > Loading ShellModule 'sh' from > /usr/lib/python2.7/site-packages/ansible/plugins/shell/sh.py > (found_in_cache=True, class_only=False) > 2017-11-28 09:29:38,088 p=24401 u=lukasm | 24413 1511879378.08798: > assigned :doc > 2017-11-28 09:29:38,733 p=24414 u=lukasm | 24414 1511879378.73374: > Loading Connection 'ssh' from > /usr/lib/python2.7/site-packages/ansible/plugins/connection/ssh.py > (found_in_cache=False, class_only=True) > 2017-11-28 09:29:38,777 p=24414 u=lukasm | 24414 1511879378.77775: > assigned :doc > 2017-11-28 09:29:38,778 p=24414 u=lukasm | 24414 1511879378.77828: > Loaded config def from plugin (connection/ssh) > 2017-11-28 09:29:38,781 p=24414 u=lukasm | creating new control socket > for host 10.0.111.10:22 as user ansible > 2017-11-28 09:29:38,782 p=24414 u=lukasm | control socket path is > /home/lukasm/.ansible/pc/f236feb178 > 2017-11-28 09:29:38,782 p=24414 u=lukasm | current working directory is > /etc/ansible/templates > 2017-11-28 09:29:38,782 p=24414 u=lukasm | using connection plugin > network_cli > 2017-11-28 09:29:38,834 p=24414 u=lukasm | failed to create control > socket for host 10.0.111.10 > 2017-11-28 09:29:38,835 p=24414 u=lukasm | Traceback (most recent call > last): > File "/usr/bin/ansible-connection", line 315, in main > server = Server(socket_path, pc) > File "/usr/bin/ansible-connection", line 111, in __init__ > self.connection = connection_loader.get(play_context.connection, > play_context, sys.stdin) > File "/usr/lib/python2.7/site-packages/ansible/plugins/loader.py", line > 363, in get > self._module_cache[path] = self._load_module_source(name, path) > File "/usr/lib/python2.7/site-packages/ansible/plugins/loader.py", line > 339, in _load_module_source > module = imp.load_source(full_name, path, module_file) > File > "/usr/lib/python2.7/site-packages/ansible/plugins/connection/network_cli.py", > line 61, in <module> > from ansible.plugins.connection.paramiko_ssh import Connection as > _Connection > File > "/usr/lib/python2.7/site-packages/ansible/plugins/connection/paramiko_ssh.py", > line 94, in <module> > import paramiko > File "/usr/lib/python2.7/site-packages/paramiko/__init__.py", line 22, > in <module> > from paramiko.transport import SecurityOptions, Transport > File "/usr/lib/python2.7/site-packages/paramiko/transport.py", line 38, > in <module> > from paramiko.auth_handler import AuthHandler > File "/usr/lib/python2.7/site-packages/paramiko/auth_handler.py", line > 48, in <module> > from paramiko.ssh_gss import GSSAuth, GSS_EXCEPTIONS > File "/usr/lib/python2.7/site-packages/paramiko/ssh_gss.py", line 54, in > <module> > GSS_EXCEPTIONS = (gssapi.GSSException,) > AttributeError: 'module' object has no attribute 'GSSException' > > 2017-11-28 09:30:08,961 p=24401 u=lukasm | 24413 1511879408.96180: > handler run complete > 2017-11-28 09:30:08,962 p=24401 u=lukasm | 24413 1511879408.96221: > attempt loop complete, returning result > 2017-11-28 09:30:08,962 p=24401 u=lukasm | 24413 1511879408.96236: > _execute() done > 2017-11-28 09:30:08,962 p=24401 u=lukasm | 24413 1511879408.96248: > dumping result to json > 2017-11-28 09:30:08,962 p=24401 u=lukasm | 24413 1511879408.96260: done > dumping result, returning > 2017-11-28 09:30:08,962 p=24401 u=lukasm | 24413 1511879408.96277: done > running TaskExecutor() for 3850-TEST/TASK: Execute Show run command > [0050569e-a860-2e0a-50e5-000000000008] > 2017-11-28 09:30:08,963 p=24401 u=lukasm | 24413 1511879408.96297: > sending task result for task 0050569e-a860-2e0a-50e5-000000000008 > 2017-11-28 09:30:08,964 p=24401 u=lukasm | 24413 1511879408.96340: done > sending task result for task 0050569e-a860-2e0a-50e5-000000000008 > 2017-11-28 09:30:08,964 p=24401 u=lukasm | 24413 1511879408.96417: > WORKER PROCESS EXITING > 2017-11-28 09:30:08,965 p=24401 u=lukasm | 24401 1511879408.96548: > marking 3850-TEST as failed > 2017-11-28 09:30:08,965 p=24401 u=lukasm | 24401 1511879408.96572: > marking host 3850-TEST failed, current state: HOST STATE: block=2, task=1, > rescue=0, always=0, run_state=ITERATING_TASKS, fail_state=FAILED_NONE, > pending_setup=False, tasks child state? (None), rescue child state? (None), > always child state? (None), did rescue? False, did start at task? False > 2017-11-28 09:30:08,965 p=24401 u=lukasm | 24401 1511879408.96588: ^ > failed state is now: HOST STATE: block=2, task=1, rescue=0, always=0, > run_state=ITERATING_COMPLETE, fail_state=FAILED_TASKS, pending_setup=False, > tasks child state? (None), rescue child state? (None), always child state? > (None), did rescue? False, did start at task? False > 2017-11-28 09:30:08,966 p=24401 u=lukasm | 24401 1511879408.96602: > getting the next task for host 3850-TEST > 2017-11-28 09:30:08,966 p=24401 u=lukasm | 24401 1511879408.96615: host > 3850-TEST is done iterating, returning > 2017-11-28 09:30:08,966 p=24401 u=lukasm | fatal: [3850-TEST]: FAILED! => > { > "changed": false, > "failed": true, > "msg": "unable to open shell. Please see: > https://docs.ansible.com/ansible/network_debug_troubleshooting.html#unable-to-open-shell > " > } > 2017-11-28 09:30:08,966 p=24401 u=lukasm | 24401 1511879408.96672: no > more pending results, returning what we have > 2017-11-28 09:30:08,967 p=24401 u=lukasm | 24401 1511879408.96705: > results queue empty > 2017-11-28 09:30:08,967 p=24401 u=lukasm | 24401 1511879408.96738: > checking for any_errors_fatal > 2017-11-28 09:30:08,967 p=24401 u=lukasm | 24401 1511879408.96765: done > checking for any_errors_fatal > 2017-11-28 09:30:08,968 p=24401 u=lukasm | 24401 1511879408.96798: > checking for max_fail_percentage > 2017-11-28 09:30:08,968 p=24401 u=lukasm | 24401 1511879408.96827: done > checking for max_fail_percentage > 2017-11-28 09:30:08,968 p=24401 u=lukasm | 24401 1511879408.96853: > checking to see if all hosts have failed and the running result is not ok > 2017-11-28 09:30:08,968 p=24401 u=lukasm | 24401 1511879408.96881: done > checking to see if all hosts have failed > 2017-11-28 09:30:08,969 p=24401 u=lukasm | 24401 1511879408.96908: > getting the remaining hosts for this loop > 2017-11-28 09:30:08,969 p=24401 u=lukasm | 24401 1511879408.96942: done > getting the remaining hosts for this loop > 2017-11-28 09:30:08,969 p=24401 u=lukasm | 24401 1511879408.96977: > building list of next tasks for hosts > 2017-11-28 09:30:08,970 p=24401 u=lukasm | 24401 1511879408.97001: > getting the next task for host 3850-TEST > 2017-11-28 09:30:08,970 p=24401 u=lukasm | 24401 1511879408.97031: host > 3850-TEST is done iterating, returning > 2017-11-28 09:30:08,970 p=24401 u=lukasm | 24401 1511879408.97057: done > building task lists > 2017-11-28 09:30:08,970 p=24401 u=lukasm | 24401 1511879408.97086: > counting tasks in each state of execution > 2017-11-28 09:30:08,971 p=24401 u=lukasm | 24401 1511879408.97109: done > counting tasks in each state of execution: > num_setups: 0 > num_tasks: 0 > num_rescue: 0 > num_always: 0 > 2017-11-28 09:30:08,971 p=24401 u=lukasm | 24401 1511879408.97141: all > hosts are done, so returning None's for all hosts > 2017-11-28 09:30:08,971 p=24401 u=lukasm | 24401 1511879408.97170: done > queuing things up, now waiting for results queue to drain > 2017-11-28 09:30:08,972 p=24401 u=lukasm | 24401 1511879408.97199: > results queue empty > 2017-11-28 09:30:08,972 p=24401 u=lukasm | 24401 1511879408.97226: > checking for any_errors_fatal > 2017-11-28 09:30:08,972 p=24401 u=lukasm | 24401 1511879408.97253: done > checking for any_errors_fatal > 2017-11-28 09:30:08,972 p=24401 u=lukasm | 24401 1511879408.97280: > checking for max_fail_percentage > 2017-11-28 09:30:08,973 p=24401 u=lukasm | 24401 1511879408.97307: done > checking for max_fail_percentage > 2017-11-28 09:30:08,973 p=24401 u=lukasm | 24401 1511879408.97340: > checking to see if all hosts have failed and the running result is not ok > 2017-11-28 09:30:08,973 p=24401 u=lukasm | 24401 1511879408.97368: done > checking to see if all hosts have failed > 2017-11-28 09:30:08,973 p=24401 u=lukasm | 24401 1511879408.97392: > getting the next task for host 3850-TEST > 2017-11-28 09:30:08,974 p=24401 u=lukasm | 24401 1511879408.97403: host > 3850-TEST is done iterating, returning > 2017-11-28 09:30:08,974 p=24401 u=lukasm | 24401 1511879408.97414: > running handlers > 2017-11-28 09:30:08,975 p=24401 u=lukasm | [WARNING]: Could not create > retry file '/etc/ansible/templates/backup.retry'. [Errno 13] > Permission denied: u'/etc/ansible/templates/backup.retry' > > 2017-11-28 09:30:08,975 p=24401 u=lukasm | PLAY RECAP > ********************************************************************************************************************************************************************************** > 2017-11-28 09:30:08,976 p=24401 u=lukasm | 3850-TEST : > ok=0 changed=0 unreachable=0 failed=1 > 2017-11-28 09:30:08,976 p=24401 u=lukasm | 24401 1511879408.97618: > RUNNING CLEANUP > > > > ########################################################################################################## > > On Tuesday, November 28, 2017 at 9:25:53 AM UTC-5, Kai Stian Olstad wrote: >> >> On Monday, 27 November 2017 21.12.43 CET Lukas M wrote: >> > TASK [Execute Show run command] >> > >> ************************************************************************************************************************************************************* >> >> > fatal: [3850-TEST]: FAILED! => {"changed": false, "failed": true, >> "msg": >> > "unable to open shell. Please see: >> > >> https://docs.ansible.com/ansible/network_debug_troubleshooting.html#unable-to-open-shell"} >> >> > to retry, use: --limit >> > @/home/lukasm/ansibleScripting/networkingTest/templates/backup.retry >> > >> > PLAY RECAP >> > >> ********************************************************************************************************************************************************************************** >> >> > 3850-TEST : ok=0 changed=0 unreachable=0 >> failed=1 >> > >> > _____________________________________________________________ >> > >> > I have tried to find this error and possible solutions for it in >> different >> > forums but the suggested solutions haven't worked for me yet. Any help >> > would be great as I am out of thoughts on what to do next. >> >> Have you read the link and done as it say? >> If so, where are the logs for that? >> >> -- >> Kai Stian Olstad >> > -- > You received this message because you are subscribed to the Google Groups > "Ansible Project" group. > To unsubscribe from this group and stop receiving emails from it, send an > email to [email protected]. > To post to this group, send email to [email protected]. > To view this discussion on the web visit > https://groups.google.com/d/msgid/ansible-project/fa6b8d52-e84c-4ec3-9b93-33e7cec035a7%40googlegroups.com > <https://groups.google.com/d/msgid/ansible-project/fa6b8d52-e84c-4ec3-9b93-33e7cec035a7%40googlegroups.com?utm_medium=email&utm_source=footer> > . > For more options, visit https://groups.google.com/d/optout. > -- You received this message because you are subscribed to the Google Groups "Ansible Project" group. To unsubscribe from this group and stop receiving emails from it, send an email to [email protected]. To post to this group, send email to [email protected]. To view this discussion on the web visit https://groups.google.com/d/msgid/ansible-project/CAKEs6ac9%3Ddw9xm_Kfpxvx4Ytd2uZ70pzBCqsnarjXPneKykEVw%40mail.gmail.com. For more options, visit https://groups.google.com/d/optout.
