Actions
Bug #26037
closedCan't execute ansible role with Foreman 1.21 RC4
Status:
Rejected
Priority:
High
Assignee:
-
Target version:
-
Description
I updated from Foreman 1.20 to 1.21.
ii ansible 2.2.1.0-2 all Configuration management, deployment, and task execution system ii ruby-foreman-ansible 2.3.1-1 all Foreman Ansible plugin ii ruby-smart-proxy-ansible 2.1.0-1 all Ansible support for Foreman smart proxy + Ansible 2.7.7 installed via pip (which works on my other Foreman's <= 1.20)
On 1.20 the roles work's fine. Now i am getting this error:
Scroll to bottom
1:
/var/tmp/foreman-ssh-cmd-5a402fc5-247a-425c-9095-c1f65ec13acf/script: 1: /var/tmp/foreman-ssh-cmd-5a402fc5-247a-425c-9095-c1f65ec13acf/script:
2:
---: not found
3:
/var/tmp/foreman-ssh-cmd-5a402fc5-247a-425c-9095-c1f65ec13acf/script: 2: /var/tmp/foreman-ssh-cmd-5a402fc5-247a-425c-9095-c1f65ec13acf/script:
4:
-: not found
5:
/var/tmp/foreman-ssh-cmd-5a402fc5-247a-425c-9095-c1f65ec13acf/script: 3: /var/tmp/foreman-ssh-cmd-5a402fc5-247a-425c-9095-c1f65ec13acf/script:
6:
tasks:: not found
7:
/var/tmp/foreman-ssh-cmd-5a402fc5-247a-425c-9095-c1f65ec13acf/script: 4: /var/tmp/foreman-ssh-cmd-5a402fc5-247a-425c-9095-c1f65ec13acf/script:
8:
-: not found
9:
/var/tmp/foreman-ssh-cmd-5a402fc5-247a-425c-9095-c1f65ec13acf/script: 5: /var/tmp/foreman-ssh-cmd-5a402fc5-247a-425c-9095-c1f65ec13acf/script:
10:
debug:: not found
11:
/var/tmp/foreman-ssh-cmd-5a402fc5-247a-425c-9095-c1f65ec13acf/script: 6: /var/tmp/foreman-ssh-cmd-5a402fc5-247a-425c-9095-c1f65ec13acf/script:
12:
var:: not found
13:
/var/tmp/foreman-ssh-cmd-5a402fc5-247a-425c-9095-c1f65ec13acf/script: 7: /var/tmp/foreman-ssh-cmd-5a402fc5-247a-425c-9095-c1f65ec13acf/script:
14:
roles:: not found
15:
/var/tmp/foreman-ssh-cmd-5a402fc5-247a-425c-9095-c1f65ec13acf/script: 8: /var/tmp/foreman-ssh-cmd-5a402fc5-247a-425c-9095-c1f65ec13acf/script:
16:
-: not found
17:
Exit status: 127
Production log:
2019-02-12T12:49:00 [I|app|5b665625] Started GET "/ansible/hosts/55/play_roles" for 10.208.1.159 at 2019-02-12 12:49:00 +0100
2019-02-12T12:49:00 [I|app|5b665625] Processing by HostsController#play_roles as HTML
2019-02-12T12:49:00 [I|app|5b665625] Parameters: {"id"=>"55"}
2019-02-12T12:49:00 [I|app|5b665625] Current user set to admin (admin)
2019-02-12T12:49:00 [D|app|5b665625] Current location set to none
2019-02-12T12:49:00 [D|app|5b665625] Current organization set to none
2019-02-12T12:49:00 [I|aud|5b665625] JobInvocation (214) create event on job_category Ansible Playbook
2019-02-12T12:49:00 [I|aud|5b665625] JobInvocation (214) create event on description
2019-02-12T12:49:00 [I|aud|5b665625] JobInvocation (214) create event on concurrency_level
2019-02-12T12:49:00 [I|aud|5b665625] JobInvocation (214) create event on time_span
2019-02-12T12:49:00 [I|aud|5b665625] JobInvocation (214) create event on execution_timeout_interval
2019-02-12T12:49:00 [I|aud|5b665625] JobInvocation (214) create event on password [redacted]
2019-02-12T12:49:00 [I|aud|5b665625] JobInvocation (214) create event on key_passphrase
2019-02-12T12:49:00 [I|aud|5b665625] JobInvocation (214) create event on remote_execution_feature_id 1
2019-02-12T12:49:00 [I|aud|5b665625] JobInvocation (214) create event on sudo_password
2019-02-12T12:49:00 [I|aud|5b665625] JobInvocation (214) update event on description , Run Ansible roles
2019-02-12T12:49:00 [D|dyn|5b665625] ExecutionPlan 0a23fd43-857e-41c2-9a5f-5dfc7c8e3948 pending >> planning
2019-02-12T12:49:00 [D|dyn|5b665625] Step 0a23fd43-857e-41c2-9a5f-5dfc7c8e3948: 1 pending >> running in phase Plan Actions::RemoteExecution::RunHostsJob
2019-02-12T12:49:00 [I|app|5b665625] Current user set to admin (admin)
2019-02-12T12:49:00 [I|app|5b665625] Current user set to admin (admin)
2019-02-12T12:49:00 [D|dyn|5b665625] Step 0a23fd43-857e-41c2-9a5f-5dfc7c8e3948: 1 running >> success in phase Plan Actions::RemoteExecution::RunHostsJob
2019-02-12T12:49:00 [D|dyn|5b665625] ExecutionPlan 0a23fd43-857e-41c2-9a5f-5dfc7c8e3948 planning >> planned
2019-02-12T12:49:00 [I|app|5b665625] Current user set to admin (admin)
2019-02-12T12:49:00 [D|app|] Current organization set to none
2019-02-12T12:49:00 [D|app|] Current location set to none
2019-02-12T12:49:00 [I|app|] Redirected to https://foreman.example.de/job_invocations/214
2019-02-12T12:49:00 [I|app|] Completed 302 Found in 216ms (ActiveRecord: 56.5ms)
2019-02-12T12:49:00 [I|app|76bf5d64] Started GET "/job_invocations/214" for 10.208.1.159 at 2019-02-12 12:49:00 +0100
2019-02-12T12:49:00 [I|app|76bf5d64] Processing by JobInvocationsController#show as HTML
2019-02-12T12:49:00 [I|app|76bf5d64] Parameters: {"id"=>"214"}
2019-02-12T12:49:00 [I|app|76bf5d64] Current user set to admin (admin)
2019-02-12T12:49:00 [D|app|76bf5d64] Current location set to none
2019-02-12T12:49:00 [D|app|76bf5d64] Current organization set to none
2019-02-12T12:49:00 [I|app|76bf5d64] Rendering vendor/ruby/2.3.0/gems/foreman_remote_execution-1.7.0/app/views/job_invocations/show.html.erb within layouts/application
2019-02-12T12:49:00 [I|app|76bf5d64] Rendered vendor/ruby/2.3.0/gems/foreman_remote_execution-1.7.0/app/views/job_invocations/_card_results.html.erb (0.2ms)
2019-02-12T12:49:00 [I|app|76bf5d64] Rendered vendor/ruby/2.3.0/gems/foreman_remote_execution-1.7.0/app/views/job_invocations/_card_schedule.html.erb (2.3ms)
2019-02-12T12:49:00 [I|app|76bf5d64] Rendered vendor/ruby/2.3.0/gems/foreman_remote_execution-1.7.0/app/views/job_invocations/_card_target_hosts.html.erb (2.1ms)
2019-02-12T12:49:00 [I|app|76bf5d64] Rendered vendor/ruby/2.3.0/gems/foreman_remote_execution-1.7.0/app/views/job_invocations/_host_name_td.html.erb (0.8ms)
2019-02-12T12:49:00 [I|app|76bf5d64] Rendered vendor/ruby/2.3.0/gems/foreman_remote_execution-1.7.0/app/views/job_invocations/_host_status_td.html.erb (0.5ms)
2019-02-12T12:49:00 [I|app|76bf5d64] Rendered vendor/ruby/2.3.0/gems/foreman_remote_execution-1.7.0/app/views/job_invocations/_host_actions_td.html.erb (1.6ms)
2019-02-12T12:49:00 [I|app|76bf5d64] Rendered common/_pagination.html.erb (0.6ms)
2019-02-12T12:49:00 [I|app|76bf5d64] Rendered vendor/ruby/2.3.0/gems/foreman_remote_execution-1.7.0/app/views/job_invocations/_tab_hosts.html.erb (7.8ms)
2019-02-12T12:49:00 [I|app|76bf5d64] Rendered vendor/ruby/2.3.0/gems/foreman_remote_execution-1.7.0/app/views/job_invocations/_tab_overview.html.erb (21.2ms)
2019-02-12T12:49:00 [I|app|76bf5d64] Rendered vendor/ruby/2.3.0/gems/foreman_remote_execution-1.7.0/app/views/job_invocations/_user_input.html.erb (11.7ms)
2019-02-12T12:49:00 [I|app|76bf5d64] Rendered vendor/ruby/2.3.0/gems/foreman_remote_execution-1.7.0/app/views/job_invocations/_tab_preview_templates.html.erb (19.0ms)
2019-02-12T12:49:00 [I|app|76bf5d64] Rendered vendor/ruby/2.3.0/gems/foreman_remote_execution-1.7.0/app/views/job_invocations/show.html.erb within layouts/application (62.1ms)
2019-02-12T12:49:00 [I|app|76bf5d64] Rendered layouts/_application_content.html.erb (0.5ms)
2019-02-12T12:49:00 [I|app|76bf5d64] Rendering layouts/base.html.erb
2019-02-12T12:49:00 [I|app|76bf5d64] Rendered layouts/base.html.erb (29.5ms)
2019-02-12T12:49:00 [I|app|76bf5d64] Completed 200 OK in 113ms (Views: 82.7ms | ActiveRecord: 14.3ms)
2019-02-12T12:49:01 [I|app|6d74257f] Started GET "/notification_recipients" for 10.208.1.159 at 2019-02-12 12:49:01 +0100
2019-02-12T12:49:01 [I|app|6d74257f] Processing by NotificationRecipientsController#index as JSON
2019-02-12T12:49:01 [I|app|6d74257f] Current user set to admin (admin)
2019-02-12T12:49:01 [D|app|6d74257f] Current location set to none
2019-02-12T12:49:01 [D|app|6d74257f] Current organization set to none
2019-02-12T12:49:01 [D|not|6d74257f] Cache Hit: notification, reading cache for notification-4
2019-02-12T12:49:01 [D|app|6d74257f] Body: {"notifications":[{"id":416,"seen":false,"level":"success","text":"A job 'Run Ansible roles' has finished successfully","created_at":"2019-02-11T15:30:31.039Z","group":"Jobs","actions":{"links":[{"href":"/job_invocations/193","title":"Job Details"}]}},{"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":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-12T12:49:01 [I|app|6d74257f] Completed 200 OK in 10ms (Views: 0.2ms | ActiveRecord: 0.7ms)
2019-02-12T12:49:01 [I|app|cd7201f6] Started GET "/job_invocations/chart?id=214" for 10.208.1.159 at 2019-02-12 12:49:01 +0100
2019-02-12T12:49:01 [I|app|cd7201f6] Processing by JobInvocationsController#chart as JSON
2019-02-12T12:49:01 [I|app|cd7201f6] Parameters: {"id"=>"214"}
2019-02-12T12:49:01 [I|app|cd7201f6] Current user set to admin (admin)
2019-02-12T12:49:01 [D|app|cd7201f6] Current location set to none
2019-02-12T12:49:01 [D|app|cd7201f6] Current organization set to none
2019-02-12T12:49:01 [I|app|cd7201f6] Completed 200 OK in 38ms (Views: 0.4ms | ActiveRecord: 4.0ms)
2019-02-12T12:49:01 [I|app|975737d2] Started GET "/job_invocations/214?hosts_needs_refresh=&host_ids_needing_name_update%5B%5D=55&host_ids_needing_status_update%5B%5D=55&_=1549972140739" for 10.208.1.159 at 2019-02-12 12:49:01 +0100
2019-02-12T12:49:01 [I|app|975737d2] Processing by JobInvocationsController#show as JS
2019-02-12T12:49:01 [I|app|975737d2] Parameters: {"hosts_needs_refresh"=>"", "host_ids_needing_name_update"=>["55"], "host_ids_needing_status_update"=>["55"], "_"=>"1549972140739", "id"=>"214"}
2019-02-12T12:49:01 [I|app|975737d2] Current user set to admin (admin)
2019-02-12T12:49:01 [D|app|975737d2] Current location set to none
2019-02-12T12:49:01 [D|app|975737d2] Current organization set to none
2019-02-12T12:49:01 [I|app|975737d2] Rendering vendor/ruby/2.3.0/gems/foreman_remote_execution-1.7.0/app/views/job_invocations/show.js.erb
2019-02-12T12:49:01 [I|app|975737d2] Rendered vendor/ruby/2.3.0/gems/foreman_remote_execution-1.7.0/app/views/job_invocations/_host_name_td.html.erb (0.9ms)
2019-02-12T12:49:01 [I|app|975737d2] Rendered vendor/ruby/2.3.0/gems/foreman_remote_execution-1.7.0/app/views/job_invocations/_host_status_td.html.erb (0.5ms)
2019-02-12T12:49:01 [I|app|975737d2] Rendered vendor/ruby/2.3.0/gems/foreman_remote_execution-1.7.0/app/views/job_invocations/show.js.erb (22.5ms)
2019-02-12T12:49:01 [I|app|975737d2] Completed 200 OK in 42ms (Views: 20.8ms | ActiveRecord: 5.6ms)
2019-02-12T12:49:02 [I|app|c5990c14] Started GET "/job_invocations/chart?id=214" for 10.208.1.159 at 2019-02-12 12:49:02 +0100
2019-02-12T12:49:02 [I|app|c5990c14] Processing by JobInvocationsController#chart as JSON
2019-02-12T12:49:02 [I|app|c5990c14] Parameters: {"id"=>"214"}
2019-02-12T12:49:02 [I|app|c5990c14] Current user set to admin (admin)
2019-02-12T12:49:02 [D|app|c5990c14] Current location set to none
2019-02-12T12:49:02 [D|app|c5990c14] Current organization set to none
2019-02-12T12:49:02 [I|app|c5990c14] Completed 200 OK in 32ms (Views: 0.4ms | ActiveRecord: 3.8ms)
2019-02-12T12:49:02 [I|app|3ecc3cbd] Started GET "/job_invocations/214?hosts_needs_refresh=&host_ids_needing_status_update%5B%5D=55&_=1549972140740" for 10.208.1.159 at 2019-02-12 12:49:02 +0100
2019-02-12T12:49:03 [I|app|3ecc3cbd] Processing by JobInvocationsController#show as JS
2019-02-12T12:49:03 [I|app|3ecc3cbd] Parameters: {"hosts_needs_refresh"=>"", "host_ids_needing_status_update"=>["55"], "_"=>"1549972140740", "id"=>"214"}
2019-02-12T12:49:03 [I|app|3ecc3cbd] Current user set to admin (admin)
2019-02-12T12:49:03 [D|app|3ecc3cbd] Current location set to none
2019-02-12T12:49:03 [D|app|3ecc3cbd] Current organization set to none
2019-02-12T12:49:03 [I|app|3ecc3cbd] Rendering vendor/ruby/2.3.0/gems/foreman_remote_execution-1.7.0/app/views/job_invocations/show.js.erb
2019-02-12T12:49:03 [I|app|3ecc3cbd] Rendered vendor/ruby/2.3.0/gems/foreman_remote_execution-1.7.0/app/views/job_invocations/_host_status_td.html.erb (0.5ms)
2019-02-12T12:49:03 [I|app|3ecc3cbd] Rendered vendor/ruby/2.3.0/gems/foreman_remote_execution-1.7.0/app/views/job_invocations/show.js.erb (19.5ms)
2019-02-12T12:49:03 [I|app|3ecc3cbd] Completed 200 OK in 39ms (Views: 17.9ms | ActiveRecord: 5.5ms)
2019-02-12T12:49:03 [I|app|23418601] Started POST "/foreman_tasks/api/tasks/callback" for 10.208.213.10 at 2019-02-12 12:49:03 +0100
2019-02-12T12:49:03 [I|app|23418601] Processing by ForemanTasks::Api::TasksController#callback as XML
2019-02-12T12:49:03 [I|app|23418601] Parameters: {"callback"=>{"task_id"=>"9e8d2a3f-d21e-414c-a1ab-870e230186ae", "step_id"=>3}, "data"=>{"result"=>[{"output_type"=>"stdout", "output"=>"/var/tmp/foreman-ssh-cmd-3dd16084-380c-4409-b450-0f255071e3ba/script: 1: /var/tmp/foreman-ssh-cmd-3dd16084-380c-4409-b450-0f255071e3ba/script: ", "timestamp"=>1549972143.2827482}, {"output_type"=>"stdout", "output"=>"---: not found", "timestamp"=>1549972143.2828517}, {"output_type"=>"stdout", "output"=>"\r\n", "timestamp"=>1549972143.282969}, {"output_type"=>"stdout", "output"=>"/var/tmp/foreman-ssh-cmd-3dd16084-380c-4409-b450-0f255071e3ba/script: 2: /var/tmp/foreman-ssh-cmd-3dd16084-380c-4409-b450-0f255071e3ba/script: ", "timestamp"=>1549972143.2831519}, {"output_type"=>"stdout", "output"=>"-: not found", "timestamp"=>1549972143.2832546}, {"output_type"=>"stdout", "output"=>"\r\n", "timestamp"=>1549972143.2833457}, {"output_type"=>"stdout", "output"=>"/var/tmp/foreman-ssh-cmd-3dd16084-380c-4409-b450-0f255071e3ba/script: 3: /var/tmp/foreman-ssh-cmd-3dd16084-380c-4409-b450-0f255071e3ba/script: ", "timestamp"=>1549972143.2835078}, {"output_type"=>"stdout", "output"=>"tasks:: not found", "timestamp"=>1549972143.2836647}, {"output_type"=>"stdout", "output"=>"\r\n", "timestamp"=>1549972143.2837822}, {"output_type"=>"stdout", "output"=>"/var/tmp/foreman-ssh-cmd-3dd16084-380c-4409-b450-0f255071e3ba/script: 4: /var/tmp/foreman-ssh-cmd-3dd16084-380c-4409-b450-0f255071e3ba/script: ", "timestamp"=>1549972143.2839136}, {"output_type"=>"stdout", "output"=>"-: not found", "timestamp"=>1549972143.2840402}, {"output_type"=>"stdout", "output"=>"\r\n", "timestamp"=>1549972143.2841306}, {"output_type"=>"stdout", "output"=>"/var/tmp/foreman-ssh-cmd-3dd16084-380c-4409-b450-0f255071e3ba/script: 5: /var/tmp/foreman-ssh-cmd-3dd16084-380c-4409-b450-0f255071e3ba/script: ", "timestamp"=>1549972143.2842855}, {"output_type"=>"stdout", "output"=>"debug:: not found", "timestamp"=>1549972143.284383}, {"output_type"=>"stdout", "output"=>"\r\n", "timestamp"=>1549972143.2844718}, {"output_type"=>"stdout", "output"=>"/var/tmp/foreman-ssh-cmd-3dd16084-380c-4409-b450-0f255071e3ba/script: 6: /var/tmp/foreman-ssh-cmd-3dd16084-380c-4409-b450-0f255071e3ba/script: ", "timestamp"=>1549972143.284638}, {"output_type"=>"stdout", "output"=>"var:: not found", "timestamp"=>1549972143.2847645}, {"output_type"=>"stdout", "output"=>"\r\n", "timestamp"=>1549972143.2848554}, {"output_type"=>"stdout", "output"=>"/var/tmp/foreman-ssh-cmd-3dd16084-380c-4409-b450-0f255071e3ba/script: 7: /var/tmp/foreman-ssh-cmd-3dd16084-380c-4409-b450-0f255071e3ba/script: ", "timestamp"=>1549972143.2850173}, {"output_type"=>"stdout", "output"=>"roles:: not found", "timestamp"=>1549972143.2851396}, {"output_type"=>"stdout", "output"=>"\r\n", "timestamp"=>1549972143.2852411}, {"output_type"=>"stdout", "output"=>"/var/tmp/foreman-ssh-cmd-3dd16084-380c-4409-b450-0f255071e3ba/script: 8: /var/tmp/foreman-ssh-cmd-3dd16084-380c-4409-b450-0f255071e3ba/script: ", "timestamp"=>1549972143.285409}, {"output_type"=>"stdout", "output"=>"-: not found", "timestamp"=>1549972143.2855105}, {"output_type"=>"stdout", "output"=>"\r\n", "timestamp"=>1549972143.2856002}], "runner_id"=>"3dd16084-380c-4409-b450-0f255071e3ba", "exit_status"=>127}, "task"=>{}}
2019-02-12T12:49:03 [D|app|23418601] Examining client certificate to extract dn and sans
2019-02-12T12:49:03 [D|app|23418601] Client sent certificate with subject 'foreman.example.de' and subject alt names '["foreman.example.de", "puppet", "puppet.example.de"]'
2019-02-12T12:49:03 [D|app|23418601] Verifying request from ["foreman.example.de", "puppet", "puppet.example.de"] against ["foreman.example.de", "foreman.example.de", "foreman"]
2019-02-12T12:49:03 [D|app|23418601] Current user set to foreman_api_admin (admin)
2019-02-12T12:49:03 [D|app|23418601] Body: {"message":"processing"}
2019-02-12T12:49:03 [I|app|23418601] Completed 200 OK in 17ms (Views: 0.2ms | ActiveRecord: 3.6ms)
2019-02-12T12:49:03 [I|app|57b550ae] Started GET "/job_invocations/chart?id=214" for 10.208.1.159 at 2019-02-12 12:49:03 +0100
2019-02-12T12:49:03 [I|app|57b550ae] Processing by JobInvocationsController#chart as JSON
2019-02-12T12:49:03 [I|app|57b550ae] Parameters: {"id"=>"214"}
2019-02-12T12:49:03 [I|app|57b550ae] Current user set to admin (admin)
2019-02-12T12:49:03 [D|app|57b550ae] Current location set to none
2019-02-12T12:49:03 [D|app|57b550ae] Current organization set to none
2019-02-12T12:49:03 [I|app|57b550ae] Completed 200 OK in 34ms (Views: 0.4ms | ActiveRecord: 4.1ms)
2019-02-12T12:49:04 [I|app|e0240207] Started GET "/job_invocations/214?hosts_needs_refresh=&host_ids_needing_status_update%5B%5D=55&_=1549972140741" for 10.208.1.159 at 2019-02-12 12:49:04 +0100
2019-02-12T12:49:04 [I|app|e0240207] Processing by JobInvocationsController#show as JS
2019-02-12T12:49:04 [I|app|e0240207] Parameters: {"hosts_needs_refresh"=>"", "host_ids_needing_status_update"=>["55"], "_"=>"1549972140741", "id"=>"214"}
2019-02-12T12:49:04 [I|app|e0240207] Current user set to admin (admin)
2019-02-12T12:49:04 [D|app|e0240207] Current location set to none
2019-02-12T12:49:04 [D|app|e0240207] Current organization set to none
2019-02-12T12:49:04 [I|app|e0240207] Rendering vendor/ruby/2.3.0/gems/foreman_remote_execution-1.7.0/app/views/job_invocations/show.js.erb
2019-02-12T12:49:04 [I|app|e0240207] Rendered vendor/ruby/2.3.0/gems/foreman_remote_execution-1.7.0/app/views/job_invocations/_host_status_td.html.erb (0.6ms)
2019-02-12T12:49:04 [I|app|e0240207] Rendered vendor/ruby/2.3.0/gems/foreman_remote_execution-1.7.0/app/views/job_invocations/show.js.erb (20.3ms)
2019-02-12T12:49:04 [I|app|e0240207] Completed 200 OK in 40ms (Views: 18.9ms | ActiveRecord: 5.5ms)
2019-02-12T12:49:04 [I|app|31a210ea] Started GET "/job_invocations/chart?id=214" for 10.208.1.159 at 2019-02-12 12:49:04 +0100
2019-02-12T12:49:04 [I|app|31a210ea] Processing by JobInvocationsController#chart as JSON
2019-02-12T12:49:04 [I|app|31a210ea] Parameters: {"id"=>"214"}
2019-02-12T12:49:04 [I|app|31a210ea] Current user set to admin (admin)
2019-02-12T12:49:04 [D|app|31a210ea] Current location set to none
2019-02-12T12:49:04 [D|app|31a210ea] Current organization set to none
2019-02-12T12:49:04 [I|app|31a210ea] Completed 200 OK in 33ms (Views: 0.4ms | ActiveRecord: 3.8ms)
2019-02-12T12:49:05 [I|app|8e4f9bf9] Started GET "/job_invocations/214?hosts_needs_refresh=&_=1549972140742" for 10.208.1.159 at 2019-02-12 12:49:05 +0100
2019-02-12T12:49:05 [I|app|8e4f9bf9] Processing by JobInvocationsController#show as JS
2019-02-12T12:49:05 [I|app|8e4f9bf9] Parameters: {"hosts_needs_refresh"=>"", "_"=>"1549972140742", "id"=>"214"}
2019-02-12T12:49:05 [I|app|8e4f9bf9] Current user set to admin (admin)
2019-02-12T12:49:05 [D|app|8e4f9bf9] Current location set to none
2019-02-12T12:49:05 [D|app|8e4f9bf9] Current organization set to none
2019-02-12T12:49:05 [I|app|8e4f9bf9] Rendering vendor/ruby/2.3.0/gems/foreman_remote_execution-1.7.0/app/views/job_invocations/show.js.erb
2019-02-12T12:49:05 [I|app|8e4f9bf9] Rendered vendor/ruby/2.3.0/gems/foreman_remote_execution-1.7.0/app/views/job_invocations/show.js.erb (16.0ms)
2019-02-12T12:49:05 [I|app|8e4f9bf9] Completed 200 OK in 36ms (Views: 14.9ms | ActiveRecord: 5.2ms
Proxy Log
2019-02-12T12:49:55 [D] accept: 10.208.213.10:57232
2019-02-12T12:49:55 [D] Rack::Handler::WEBrick is invoked.
2019-02-12T12:49:55 8393ec72 [I] Started GET /tasks/count state=running
2019-02-12T12:49:55 8393ec72 [I] Finished GET /tasks/count with 200 (1.06 ms)
2019-02-12T12:49:55 [D] close: 10.208.213.10:57232
2019-02-12T12:49:56 [D] accept: 10.208.213.10:57234
2019-02-12T12:49:56 [D] Rack::Handler::WEBrick is invoked.
2019-02-12T12:49:56 d2e0bbbf [I] Started POST /tasks/
2019-02-12T12:49:56 d2e0bbbf [D] ExecutionPlan 98086233-6181-4395-b63f-0bf80cfbba63 pending >> planning
2019-02-12T12:49:56 d2e0bbbf [D] Step 98086233-6181-4395-b63f-0bf80cfbba63: 1 pending >> running in phase Plan ForemanRemoteExecutionCore::Actions::RunScript
2019-02-12T12:49:56 d2e0bbbf [D] Step 98086233-6181-4395-b63f-0bf80cfbba63: 4 pending >> running in phase Plan SmartProxyDynflowCore::Callback::Action
2019-02-12T12:49:56 d2e0bbbf [D] Step 98086233-6181-4395-b63f-0bf80cfbba63: 4 running >> success in phase Plan SmartProxyDynflowCore::Callback::Action
2019-02-12T12:49:56 d2e0bbbf [D] Step 98086233-6181-4395-b63f-0bf80cfbba63: 1 running >> success in phase Plan ForemanRemoteExecutionCore::Actions::RunScript
2019-02-12T12:49:56 d2e0bbbf [D] ExecutionPlan 98086233-6181-4395-b63f-0bf80cfbba63 planning >> planned
2019-02-12T12:49:56 d2e0bbbf [I] Finished POST /tasks/ with 200 (18.73 ms)
2019-02-12T12:49:56 [D] ExecutionPlan 98086233-6181-4395-b63f-0bf80cfbba63 planned >> running
2019-02-12T12:49:56 [D] Step 98086233-6181-4395-b63f-0bf80cfbba63: 2 pending >> running in phase Run ForemanRemoteExecutionCore::Actions::RunScript
2019-02-12T12:49:56 [D] Step 98086233-6181-4395-b63f-0bf80cfbba63: 2 running >> suspended in phase Run ForemanRemoteExecutionCore::Actions::RunScript
2019-02-12T12:49:56 [D] start runner 5a402fc5-247a-425c-9095-c1f65ec13acf
2019-02-12T12:49:56 [D] opening session to root@10.208.213.215
2019-02-12T12:49:56 [D] close: 10.208.213.10:57234
2019-02-12T12:49:56 [D] Sending data to /var/tmp/foreman-ssh-cmd-5a402fc5-247a-425c-9095-c1f65ec13acf/script on remote host:
---
- hosts: all
tasks:
- name: Display all parameters known for the Foreman host
debug:
var: foreman_params
roles:
- base
2019-02-12T12:49:56 [D] executing script:
| sh <<WRAPPER
| (/var/tmp/foreman-ssh-cmd-5a402fc5-247a-425c-9095-c1f65ec13acf/script < /dev/null; echo \$?>/var/tmp/foreman-ssh-cmd-5a402fc5-247a-425c-9095-c1f65ec13acf/exit_code) | /usr/bin/tee /var/tmp/foreman-ssh-cmd-5a402fc5-247a-425c-9095-c1f65ec13acf/output
| exit \$(cat /var/tmp/foreman-ssh-cmd-5a402fc5-247a-425c-9095-c1f65ec13acf/exit_code)
| WRAPPER
2019-02-12T12:49:56 [D] refresh runner 5a402fc5-247a-425c-9095-c1f65ec13acf
2019-02-12T12:49:56 [D] refreshing runner
2019-02-12T12:49:56 [D] planning to refresh 5a402fc5-247a-425c-9095-c1f65ec13acf
2019-02-12T12:49:57 [D] Ticker ticking for 1 events
2019-02-12T12:49:57 [D] refresh runner 5a402fc5-247a-425c-9095-c1f65ec13acf
2019-02-12T12:49:57 [D] refreshing runner
2019-02-12T12:49:57 [D] finish runner 5a402fc5-247a-425c-9095-c1f65ec13acf
2019-02-12T12:49:57 [D] closing session for command [5a402fc5-247a-425c-9095-c1f65ec13acf],0 actors left
2019-02-12T12:49:57 [D] terminate 5a402fc5-247a-425c-9095-c1f65ec13acf
2019-02-12T12:49:57 [D] Step 98086233-6181-4395-b63f-0bf80cfbba63: 2 got event #<ForemanTasksCore::Runner::Update:0x0056168a2946d0>
2019-02-12T12:49:57 [D] Step 98086233-6181-4395-b63f-0bf80cfbba63: 2 suspended >> running in phase Run ForemanRemoteExecutionCore::Actions::RunScript
2019-02-12T12:49:57 [D] Step 98086233-6181-4395-b63f-0bf80cfbba63: 2 running >> success in phase Run ForemanRemoteExecutionCore::Actions::RunScript
2019-02-12T12:49:57 [D] Step 98086233-6181-4395-b63f-0bf80cfbba63: 5 pending >> running in phase Run SmartProxyDynflowCore::Callback::Action
2019-02-12T12:49:57 [D] Step 98086233-6181-4395-b63f-0bf80cfbba63: 5 running >> success in phase Run SmartProxyDynflowCore::Callback::Action
2019-02-12T12:49:57 [D] Step 98086233-6181-4395-b63f-0bf80cfbba63: 3 pending >> running in phase Finalize ForemanRemoteExecutionCore::Actions::RunScript
2019-02-12T12:49:57 [E] Script execution failed
2019-02-12T12:49:57 [D] Step 98086233-6181-4395-b63f-0bf80cfbba63: 3 running >> error in phase Finalize ForemanRemoteExecutionCore::Actions::RunScript
2019-02-12T12:49:57 [D] ExecutionPlan 98086233-6181-4395-b63f-0bf80cfbba63 running >> paused
2019-02-12T12:49:57 [D] ExecutionPlan 98086233-6181-4395-b63f-0bf80cfbba63 paused >> stopped
Actions