Executing Ansible ERRNO 110

ansible

#1

Problem:
Extrem slowly executing of Ansible because of ERRNO 110.
But… The execution works !

Foreman and Proxy versions:
Foreman 1.20
Ansible 2.2.1.0

Foreman and Proxy plugin versions:

Ansible log

 8:
 [WARNING]: Failure using method (v2_runner_on_ok) in callback plugin
   9:
(</usr/lib/python2.7/dist-
  10:
packages/ansible/plugins/callback/foreman.CallbackModule object at
  11:
0x7ff7a4a8d350>): HTTPConnectionPool(host='localhost.de', port=3000): Max
  12:
retries exceeded with url: /api/v2/hosts/facts (Caused by
  13:
NewConnectionError('<requests.packages.urllib3.connection.HTTPConnection object
  14:
at 0x7ff7a3e21a50>: Failed to establish a new connection: [Errno 110]
  15:
Connection timed out',))

Loops a lot of times…
production.log after executing

vendor/ruby/2.3.0/gems/railties-5.2.1/lib/rails/railtie.rb:190:in `method_missing'
vendor/ruby/2.3.0/gems/rack-2.0.6/lib/rack/urlmap.rb:68:in `block in call'
vendor/ruby/2.3.0/gems/rack-2.0.6/lib/rack/urlmap.rb:53:in `each'
vendor/ruby/2.3.0/gems/rack-2.0.6/lib/rack/urlmap.rb:53:in `call'
/usr/lib/ruby/vendor_ruby/phusion_passenger/rack/thread_handler_extension.rb:97:in `process_request'
/usr/lib/ruby/vendor_ruby/phusion_passenger/request_handler/thread_handler.rb:152:in `accept_and_process_next_request'
/usr/lib/ruby/vendor_ruby/phusion_passenger/request_handler/thread_handler.rb:113:in `main_loop'
/usr/lib/ruby/vendor_ruby/phusion_passenger/request_handler.rb:416:in `block (3 levels) in start_threads'
/usr/lib/ruby/vendor_ruby/phusion_passenger/utils.rb:113:in `block in create_thread_and_abort_on_exception'
vendor/ruby/2.3.0/gems/logging-2.2.2/lib/logging/diagnostic_context.rb:474:in `block in create_with_logging_context'
2019-02-11T16:26:00 [I|app|] Started GET "/notification_recipients" for 10.208.1.159 at 2019-02-11 16:26:00 +0100
2019-02-11T16:26:00 [I|app|c576c] Processing by NotificationRecipientsController#index as JSON
2019-02-11T16:26:00 [I|app|c576c] Current user set to admin (admin)
2019-02-11T16:26:00 [D|not|c576c] Cache Hit: notification, reading cache for notification-4
2019-02-11T16:26:00 [D|app|c576c] Body: {"notifications":[{"id":415,"seen":false,"level":"success","text":"A job 'Ansible - Test Playbook' has finished successfully","created_at":"2019-02-11T15:06:05.445Z","group":"Jobs","actions":{"links":[{"href":"/job_invocations/192","title":"Job Details"}]}},{"id":414,"seen":false,"level":"success","text":"A job 'Run Ansible roles' has finished successfully","created_at":"2019-02-11T13:54:07.373Z","group":"Jobs","actions":{"links":[{"href":"/job_invocations/191","title":"Job Details"}]}},{"id":413,"seen":false,"level":"success","text":"A job 'Run Ansible roles' has finished successfully","created_at":"2019-02-11T13:27:01.217Z","group":"Jobs","actions":{"links":[{"href":"/job_invocations/190","title":"Job Details"}]}},{"id":412,"seen":false,"level":"success","text":"A job 'Run Ansible roles' has finished successfully","created_at":"2019-02-11T12:08:08.811Z","group":"Jobs","actions":{"links":[{"href":"/job_invocations/189","title":"Job Details"}]}},{"id":411,"seen":false,"level":"success","text":"A job 'Run Ansible roles' has finished successfully","created_at":"2019-02-11T11:58:58.346Z","group":"Jobs","actions":{"links":[{"href":"/job_invocations/188","title":"Job Details"}]}},{"id":410,"seen":false,"level":"success","text":"A job 'Run Ansible roles' has finished successfully","created_at":"2019-02-11T11:46:58.258Z","group":"Jobs","actions":{"links":[{"href":"/job_invocations/187","title":"Job Details"}]}},{"id":409,"seen":false,"level":"success","text":"A job 'Run Ansible roles' has finished successfully","created_at":"2019-02-11T11:26:00.037Z","group":"Jobs","actions":{"links":[{"href":"/job_invocations/186","title":"Job Details"}]}},{"id":408,"seen":false,"level":"success","text":"A job 'Run Ansible roles' has finished successfully","created_at":"2019-02-11T11:07:37.832Z","group":"Jobs","actions":{"links":[{"href":"/job_invocations/185","title":"Job Details"}]}},{"id":407,"seen":false,"level":"success","text":"A job 'Run Ansible roles' has finished successfully","created_at":"2019-02-11T11:03:47.159Z","group":"Jobs","actions":{"links":[{"href":"/job_invocations/184","title":"Job Details"}]}},{"id":335,"seen":false,"level":"warning","text":"The organizations_enabled setting has been deprecated and will be removed in version 1.21","created_at":"2019-01-27T05:25:22.635Z","group":"Deprecations","actions":{"links":[{"href":"https://community.theforeman.org/t/proposal-remove-support-for-disabling-taxonomies-or-login/10972","title":"Further Information","external":true}]}},{"id":334,"seen":false,"level":"warning","text":"The locations_enabled setting has been deprecated and will be removed in version 1.21","created_at":"2019-01-27T05:25:22.574Z","group":"Deprecations","actions":{"links":[{"href":"https://community.theforeman.org/t/proposal-remove-support-for-disabling-taxonomies-or-login/10972","title":"Further Information","external":true}]}}]}
2019-02-11T16:26:00 [I|app|c576c] Completed 200 OK in 7ms (Views: 0.2ms | ActiveRecord: 0.9ms)
2019-02-11T16:26:01 [I|app|] Started GET "/job_invocations/chart?id=193" for 10.208.1.159 at 2019-02-11 16:26:01 +0100
2019-02-11T16:26:01 [I|app|959aa] Processing by JobInvocationsController#chart as JSON
2019-02-11T16:26:01 [I|app|959aa]   Parameters: {"id"=>"193"}
2019-02-11T16:26:01 [I|app|959aa] Current user set to admin (admin)
2019-02-11T16:26:01 [I|app|959aa] Completed 200 OK in 33ms (Views: 0.5ms | ActiveRecord: 4.1ms)
2019-02-11T16:26:02 [I|app|] Started GET "/job_invocations/193?hosts_needs_refresh=&host_ids_needing_name_update%5B%5D=55&host_ids_needing_status_update%5B%5D=55&_=1549898760747" for 10.208.1.159 at 2019-02-11 16:26:02 +0100
2019-02-11T16:26:02 [I|app|d2610] Processing by JobInvocationsController#show as JS
2019-02-11T16:26:02 [I|app|d2610]   Parameters: {"hosts_needs_refresh"=>"", "host_ids_needing_name_update"=>["55"], "host_ids_needing_status_update"=>["55"], "_"=>"1549898760747", "id"=>"193"}
2019-02-11T16:26:02 [I|app|d2610] Current user set to admin (admin)
2019-02-11T16:26:02 [I|app|d2610]   Rendering vendor/ruby/2.3.0/gems/foreman_remote_execution-1.6.4/app/views/job_invocations/show.js.erb
2019-02-11T16:26:02 [I|app|d2610]   Rendered vendor/ruby/2.3.0/gems/foreman_remote_execution-1.6.4/app/views/job_invocations/_host_name_td.html.erb (0.9ms)
2019-02-11T16:26:02 [I|app|d2610]   Rendered vendor/ruby/2.3.0/gems/foreman_remote_execution-1.6.4/app/views/job_invocations/_host_status_td.html.erb (0.6ms)
2019-02-11T16:26:02 [I|app|d2610]   Rendered vendor/ruby/2.3.0/gems/foreman_remote_execution-1.6.4/app/views/job_invocations/show.js.erb (25.1ms)
2019-02-11T16:26:02 [I|app|d2610] Completed 200 OK in 42ms (Views: 23.1ms | ActiveRecord: 6.1ms)
2019-02-11T16:26:02 [I|app|] Started GET "/job_invocations/chart?id=193" for 10.208.1.159 at 2019-02-11 16:26:02 +0100
2019-02-11T16:26:02 [I|app|1e30f] Processing by JobInvocationsController#chart as JSON
2019-02-11T16:26:02 [I|app|1e30f]   Parameters: {"id"=>"193"}
2019-02-11T16:26:02 [I|app|1e30f] Current user set to admin (admin)
2019-02-11T16:26:02 [I|app|1e30f] Completed 200 OK in 31ms (Views: 0.5ms | ActiveRecord: 4.3ms)
2019-02-11T16:26:03 [I|app|] Started GET "/job_invocations/193?hosts_needs_refresh=&host_ids_needing_status_update%5B%5D=55&_=1549898760748" for 10.208.1.159 at 2019-02-11 16:26:03 +0100
2019-02-11T16:26:03 [I|app|62b0c] Processing by JobInvocationsController#show as JS
2019-02-11T16:26:03 [I|app|62b0c]   Parameters: {"hosts_needs_refresh"=>"", "host_ids_needing_status_update"=>["55"], "_"=>"1549898760748", "id"=>"193"}
2019-02-11T16:26:03 [I|app|62b0c] Current user set to admin (admin)
2019-02-11T16:26:03 [I|app|62b0c]   Rendering vendor/ruby/2.3.0/gems/foreman_remote_execution-1.6.4/app/views/job_invocations/show.js.erb
2019-02-11T16:26:03 [I|app|62b0c]   Rendered vendor/ruby/2.3.0/gems/foreman_remote_execution-1.6.4/app/views/job_invocations/_host_status_td.html.erb (0.7ms)
2019-02-11T16:26:03 [I|app|62b0c]   Rendered vendor/ruby/2.3.0/gems/foreman_remote_execution-1.6.4/app/views/job_invocations/show.js.erb (23.3ms)
2019-02-11T16:26:03 [I|app|62b0c] Completed 200 OK in 40ms (Views: 21.4ms | ActiveRecord: 6.0ms)
2019-02-11T16:26:03 [I|app|] Started GET "/job_invocations/chart?id=193" for 10.208.1.159 at 2019-02-11 16:26:03 +0100
2019-02-11T16:26:03 [I|app|b54c7] Processing by JobInvocationsController#chart as JSON
2019-02-11T16:26:03 [I|app|b54c7]   Parameters: {"id"=>"193"}
2019-02-11T16:26:03 [I|app|b54c7] Current user set to admin (admin)
2019-02-11T16:26:03 [I|app|b54c7] Completed 200 OK in 31ms (Views: 0.5ms | ActiveRecord: 4.0ms)
2019-02-11T16:26:04 [I|app|] Started GET "/template_invocations/386" for 10.208.1.159 at 2019-02-11 16:26:04 +0100
2019-02-11T16:26:04 [I|app|864fa] Processing by TemplateInvocationsController#show as HTML
2019-02-11T16:26:04 [I|app|864fa]   Parameters: {"id"=>"386"}
2019-02-11T16:26:04 [I|app|864fa] Current user set to admin (admin)
2019-02-11T16:26:04 [I|app|864fa]   Rendering vendor/ruby/2.3.0/gems/foreman_remote_execution-1.6.4/app/views/template_invocations/show.html.erb within layouts/application
2019-02-11T16:26:04 [I|app|] Started GET "/job_invocations/193?hosts_needs_refresh=&host_ids_needing_status_update%5B%5D=55&_=1549898760749" for 10.208.1.159 at 2019-02-11 16:26:04 +0100
2019-02-11T16:26:04 [I|app|9a83e] Processing by JobInvocationsController#show as JS
2019-02-11T16:26:04 [I|app|9a83e]   Parameters: {"hosts_needs_refresh"=>"", "host_ids_needing_status_update"=>["55"], "_"=>"1549898760749", "id"=>"193"}
2019-02-11T16:26:04 [I|app|864fa]   Rendered collection of vendor/ruby/2.3.0/gems/foreman_remote_execution-1.6.4/app/views/template_invocations/_output_line_set.html.erb [2 times] (1.6ms)
2019-02-11T16:26:04 [I|app|864fa]   Rendered vendor/ruby/2.3.0/gems/foreman_remote_execution-1.6.4/app/views/template_invocations/_refresh.js.erb (0.2ms)
2019-02-11T16:26:04 [I|app|864fa]   Rendered vendor/ruby/2.3.0/gems/foreman_remote_execution-1.6.4/app/views/template_invocations/show.html.erb within layouts/application (21.9ms)
2019-02-11T16:26:04 [I|app|864fa]   Rendered layouts/_application_content.html.erb (0.4ms)
2019-02-11T16:26:04 [I|app|864fa]   Rendering layouts/base.html.erb
2019-02-11T16:26:04 [I|app|9a83e] Current user set to admin (admin)
2019-02-11T16:26:04 [I|app|864fa]   Rendered layouts/base.html.erb (18.8ms)
2019-02-11T16:26:04 [I|app|864fa] Completed 200 OK in 162ms (Views: 42.2ms | ActiveRecord: 4.9ms)
2019-02-11T16:26:04 [I|app|] Started GET "/template_invocations/386" for 10.208.1.159 at 2019-02-11 16:26:04 +0100
2019-02-11T16:26:04 [I|app|0a649] Processing by TemplateInvocationsController#show as HTML
2019-02-11T16:26:04 [I|app|0a649]   Parameters: {"id"=>"386"}
2019-02-11T16:26:04 [I|app|0a649] Current user set to admin (admin)
2019-02-11T16:26:04 [I|app|0a649]   Rendering vendor/ruby/2.3.0/gems/foreman_remote_execution-1.6.4/app/views/template_invocations/show.html.erb within layouts/application
2019-02-11T16:26:04 [I|app|0a649]   Rendered collection of vendor/ruby/2.3.0/gems/foreman_remote_execution-1.6.4/app/views/template_invocations/_output_line_set.html.erb [2 times] (1.7ms)
2019-02-11T16:26:04 [I|app|0a649]   Rendered vendor/ruby/2.3.0/gems/foreman_remote_execution-1.6.4/app/views/template_invocations/_refresh.js.erb (0.3ms)
2019-02-11T16:26:04 [I|app|0a649]   Rendered vendor/ruby/2.3.0/gems/foreman_remote_execution-1.6.4/app/views/template_invocations/show.html.erb within layouts/application (19.0ms)
2019-02-11T16:26:04 [I|app|0a649]   Rendered layouts/_application_content.html.erb (0.5ms)
2019-02-11T16:26:04 [I|app|0a649]   Rendering layouts/base.html.erb
2019-02-11T16:26:04 [I|app|0a649]   Rendered layouts/base.html.erb (18.2ms)
2019-02-11T16:26:04 [I|app|0a649] Completed 200 OK in 157ms (Views: 38.8ms | ActiveRecord: 4.3ms)
2019-02-11T16:26:04 [I|app|9a83e]   Rendering vendor/ruby/2.3.0/gems/foreman_remote_execution-1.6.4/app/views/job_invocations/show.js.erb
2019-02-11T16:26:04 [I|app|] Started GET "/javascripts/locale/en/app.js" for 10.208.1.159 at 2019-02-11 16:26:04 +0100
2019-02-11T16:26:04 [I|app|9a83e]   Rendered vendor/ruby/2.3.0/gems/foreman_remote_execution-1.6.4/app/views/job_invocations/_host_status_td.html.erb (1.8ms)
2019-02-11T16:26:04 [I|app|9a83e]   Rendered vendor/ruby/2.3.0/gems/foreman_remote_execution-1.6.4/app/views/job_invocations/show.js.erb (75.8ms)
2019-02-11T16:26:04 [I|app|9a83e] Completed 200 OK in 300ms (Views: 74.3ms | ActiveRecord: 33.3ms)
2019-02-11T16:26:04 [F|app|]   
2019-02-11T16:26:04 [F|app|] ActionController::RoutingError (No route matches [GET] "/javascripts/locale/en/app.js"):
2019-02-11T16:26:04 [F|app|]   
2019-02-11T16:26:04 [F|app|] vendor/ruby/2.3.0/gems/actionpack-5.2.1/lib/action_dispatch/middleware/debug_exceptions.rb:65:in `call'
vendor/ruby/2.3.0/gems/actionpack-5.2.1/lib/action_dispatch/middleware/show_exceptions.rb:33:in `call'
vendor/ruby/2.3.0/gems/railties-5.2.1/lib/rails/rack/logger.rb:38:in `call_app'
vendor/ruby/2.3.0/gems/railties-5.2.1/lib/rails/rack/logger.rb:28:in `call'
vendor/ruby/2.3.0/gems/sprockets-rails-3.2.1/lib/sprockets/rails/quiet_assets.rb:13:in `call'
vendor/ruby/2.3.0/gems/actionpack-5.2.1/lib/action_dispatch/middleware/remote_ip.rb:81:in `call'
vendor/ruby/2.3.0/gems/actionpack-5.2.1/lib/action_dispatch/middleware/request_id.rb:27:in `call'
vendor/ruby/2.3.0/gems/rack-2.0.6/lib/rack/method_override.rb:22:in `call'
vendor/ruby/2.3.0/gems/rack-2.0.6/lib/rack/runtime.rb:22:in `call'
vendor/ruby/2.3.0/gems/activesupport-5.2.1/lib/active_support/cache/strategy/local_cache_middleware.rb:29:in `call'
vendor/ruby/2.3.0/gems/actionpack-5.2.1/lib/action_dispatch/middleware/executor.rb:14:in `call'
vendor/ruby/2.3.0/gems/actionpack-5.2.1/lib/action_dispatch/middleware/static.rb:127:in `call'
vendor/ruby/2.3.0/gems/rack-2.0.6/lib/rack/sendfile.rb:111:in `call'
vendor/ruby/2.3.0/gems/secure_headers-6.0.0/lib/secure_headers/middleware.rb:13:in `call'
vendor/ruby/2.3.0/gems/railties-5.2.1/lib/rails/engine.rb:524:in `call'
vendor/ruby/2.3.0/gems/railties-5.2.1/lib/rails/railtie.rb:190:in `public_send'
vendor/ruby/2.3.0/gems/railties-5.2.1/lib/rails/railtie.rb:190:in `method_missing'
vendor/ruby/2.3.0/gems/rack-2.0.6/lib/rack/urlmap.rb:68:in `block in call'
vendor/ruby/2.3.0/gems/rack-2.0.6/lib/rack/urlmap.rb:53:in `each'
vendor/ruby/2.3.0/gems/rack-2.0.6/lib/rack/urlmap.rb:53:in `call'
/usr/lib/ruby/vendor_ruby/phusion_passenger/rack/thread_handler_extension.rb:97:in `process_request'
/usr/lib/ruby/vendor_ruby/phusion_passenger/request_handler/thread_handler.rb:152:in `accept_and_process_next_request'
/usr/lib/ruby/vendor_ruby/phusion_passenger/request_handler/thread_handler.rb:113:in `main_loop'
/usr/lib/ruby/vendor_ruby/phusion_passenger/request_handler.rb:416:in `block (3 levels) in start_threads'
/usr/lib/ruby/vendor_ruby/phusion_passenger/utils.rb:113:in `block in create_thread_and_abort_on_exception'
vendor/ruby/2.3.0/gems/logging-2.2.2/lib/logging/diagnostic_context.rb:474:in `block in create_with_logging_context'
2019-02-11T16:26:04 [I|app|] Started GET "/javascripts/locale/en/app.js" for 10.208.1.159 at 2019-02-11 16:26:04 +0100
2019-02-11T16:26:04 [F|app|]   
2019-02-11T16:26:04 [F|app|] ActionController::RoutingError (No route matches [GET] "/javascripts/locale/en/app.js"):
2019-02-11T16:26:04 [F|app|]   
2019-02-11T16:26:04 [F|app|] vendor/ruby/2.3.0/gems/actionpack-5.2.1/lib/action_dispatch/middleware/debug_exceptions.rb:65:in `call'
vendor/ruby/2.3.0/gems/actionpack-5.2.1/lib/action_dispatch/middleware/show_exceptions.rb:33:in `call'
vendor/ruby/2.3.0/gems/railties-5.2.1/lib/rails/rack/logger.rb:38:in `call_app'
vendor/ruby/2.3.0/gems/railties-5.2.1/lib/rails/rack/logger.rb:28:in `call'
vendor/ruby/2.3.0/gems/sprockets-rails-3.2.1/lib/sprockets/rails/quiet_assets.rb:13:in `call'
vendor/ruby/2.3.0/gems/actionpack-5.2.1/lib/action_dispatch/middleware/remote_ip.rb:81:in `call'
vendor/ruby/2.3.0/gems/actionpack-5.2.1/lib/action_dispatch/middleware/request_id.rb:27:in `call'
vendor/ruby/2.3.0/gems/rack-2.0.6/lib/rack/method_override.rb:22:in `call'
vendor/ruby/2.3.0/gems/rack-2.0.6/lib/rack/runtime.rb:22:in `call'
vendor/ruby/2.3.0/gems/activesupport-5.2.1/lib/active_support/cache/strategy/local_cache_middleware.rb:29:in `call'
vendor/ruby/2.3.0/gems/actionpack-5.2.1/lib/action_dispatch/middleware/executor.rb:14:in `call'
vendor/ruby/2.3.0/gems/actionpack-5.2.1/lib/action_dispatch/middleware/static.rb:127:in `call'
vendor/ruby/2.3.0/gems/rack-2.0.6/lib/rack/sendfile.rb:111:in `call'
vendor/ruby/2.3.0/gems/secure_headers-6.0.0/lib/secure_headers/middleware.rb:13:in `call'
vendor/ruby/2.3.0/gems/railties-5.2.1/lib/rails/engine.rb:524:in `call'
vendor/ruby/2.3.0/gems/railties-5.2.1/lib/rails/railtie.rb:190:in `public_send'
vendor/ruby/2.3.0/gems/railties-5.2.1/lib/rails/railtie.rb:190:in `method_missing'
vendor/ruby/2.3.0/gems/rack-2.0.6/lib/rack/urlmap.rb:68:in `block in call'
vendor/ruby/2.3.0/gems/rack-2.0.6/lib/rack/urlmap.rb:53:in `each'
vendor/ruby/2.3.0/gems/rack-2.0.6/lib/rack/urlmap.rb:53:in `call'
/usr/lib/ruby/vendor_ruby/phusion_passenger/rack/thread_handler_extension.rb:97:in `process_request'
/usr/lib/ruby/vendor_ruby/phusion_passenger/request_handler/thread_handler.rb:152:in `accept_and_process_next_request'
/usr/lib/ruby/vendor_ruby/phusion_passenger/request_handler/thread_handler.rb:113:in `main_loop'
/usr/lib/ruby/vendor_ruby/phusion_passenger/request_handler.rb:416:in `block (3 levels) in start_threads'
/usr/lib/ruby/vendor_ruby/phusion_passenger/utils.rb:113:in `block in create_thread_and_abort_on_exception'
vendor/ruby/2.3.0/gems/logging-2.2.2/lib/logging/diagnostic_context.rb:474:in `block in create_with_logging_context'
2019-02-11T16:26:04 [I|app|] Started GET "/notification_recipients" for 10.208.1.159 at 2019-02-11 16:26:04 +0100
2019-02-11T16:26:04 [I|app|8f148] Processing by NotificationRecipientsController#index as JSON
2019-02-11T16:26:04 [I|app|8f148] Current user set to admin (admin)
2019-02-11T16:26:04 [D|not|8f148] Cache Hit: notification, reading cache for notification-4
2019-02-11T16:26:04 [D|app|8f148] Body: {"notifications":[{"id":415,"seen":false,"level":"success","text":"A job 'Ansible - Test Playbook' has finished successfully","created_at":"2019-02-11T15:06:05.445Z","group":"Jobs","actions":{"links":[{"href":"/job_invocations/192","title":"Job Details"}]}},{"id":414,"seen":false,"level":"success","text":"A job 'Run Ansible roles' has finished successfully","created_at":"2019-02-11T13:54:07.373Z","group":"Jobs","actions":{"links":[{"href":"/job_invocations/191","title":"Job Details"}]}},{"id":413,"seen":false,"level":"success","text":"A job 'Run Ansible roles' has finished successfully","created_at":"2019-02-11T13:27:01.217Z","group":"Jobs","actions":{"links":[{"href":"/job_invocations/190","title":"Job Details"}]}},{"id":412,"seen":false,"level":"success","text":"A job 'Run Ansible roles' has finished successfully","created_at":"2019-02-11T12:08:08.811Z","group":"Jobs","actions":{"links":[{"href":"/job_invocations/189","title":"Job Details"}]}},{"id":411,"seen":false,"level":"success","text":"A job 'Run Ansible roles' has finished successfully","created_at":"2019-02-11T11:58:58.346Z","group":"Jobs","actions":{"links":[{"href":"/job_invocations/188","title":"Job Details"}]}},{"id":410,"seen":false,"level":"success","text":"A job 'Run Ansible roles' has finished successfully","created_at":"2019-02-11T11:46:58.258Z","group":"Jobs","actions":{"links":[{"href":"/job_invocations/187","title":"Job Details"}]}},{"id":409,"seen":false,"level":"success","text":"A job 'Run Ansible roles' has finished successfully","created_at":"2019-02-11T11:26:00.037Z","group":"Jobs","actions":{"links":[{"href":"/job_invocations/186","title":"Job Details"}]}},{"id":408,"seen":false,"level":"success","text":"A job 'Run Ansible roles' has finished successfully","created_at":"2019-02-11T11:07:37.832Z","group":"Jobs","actions":{"links":[{"href":"/job_invocations/185","title":"Job Details"}]}},{"id":407,"seen":false,"level":"success","text":"A job 'Run Ansible roles' has finished successfully","created_at":"2019-02-11T11:03:47.159Z","group":"Jobs","actions":{"links":[{"href":"/job_invocations/184","title":"Job Details"}]}},{"id":335,"seen":false,"level":"warning","text":"The organizations_enabled setting has been deprecated and will be removed in version 1.21","created_at":"2019-01-27T05:25:22.635Z","group":"Deprecations","actions":{"links":[{"href":"https://community.theforeman.org/t/proposal-remove-support-for-disabling-taxonomies-or-login/10972","title":"Further Information","external":true}]}},{"id":334,"seen":false,"level":"warning","text":"The locations_enabled setting has been deprecated and will be removed in version 1.21","created_at":"2019-01-27T05:25:22.574Z","group":"Deprecations","actions":{"links":[{"href":"https://community.theforeman.org/t/proposal-remove-support-for-disabling-taxonomies-or-login/10972","title":"Further Information","external":true}]}}]}

That’s not the whole production log. It’s to long for pasting here.


#2

Do you happen to have ohai (chef facter) installed? That can generate a lot of facts. We just found out very annoying issue in ansible foreman callback that makes facts uploaded several times.


#3

Not that i know. Should be at the package list dpkg -l or?


#4

Sorry, now when I look at the trace in more details (not on phone), connecting to localhost.de is probably the issue. Check your ansible callback configuration in ansible.cfg. I suppose localhost.de is not your Foreman FQDN. Also most likely you have Apache with passenger setup, meaning the port shouldn’t be 3000 but rather 443 (standard SSL)


#5

Yeah normally it makes no sense… But on my other two Foreman instances, callback is exactly configured like that.
I will test it, with the new configuration.


#7

Installed ansible via pip.
Works for me now. No changes on the callback needed.