No one having any Idea?

Bump after 2 weeks and absolutely no support-answer 

And still no answer or support.

I am still having this Problem and it is a real pita by now.

Currently on 22.10.10 and preparing a move to debian for 23.x

Debug in the Log shows that the ENgine gets a return-Code2 and a “

(No output returned from plugin)” while on the cli it works just fine

@Fabrix Do you have any Idea who could be of help here?

Hi @TA-FFM, please give me a moment, I'll see what I can do

Hi @TA-FFM do you use a Centreon Plugin or a custom plugin?
Can you add a screenshot of the result in Centreon UI an in CLI ?

Hello Laurent,

i had the Problem before wih other scripts (don’t remember them actually now) and currentltly have it with https://exchange.nagios.org/directory/Plugins/Network-Protocols/Others/BGP-2D4/EGP/EIGRP/HSRP/IGRP/OSPF/Others/STP/TACACS+/check_tacacs_plus/details

Funny enough, i seem to not have the Problem on a debian 23,04-Test-Install i exported the Host/Service-Config to .- also it works fine in a Centreon 2.5.2-install (don’t beat me, it’s beeing replaced by the actual one)

Maybe this helps too - centengine-log V2 with setting to “trace” - all specifics have been replaced (passwords, Hostnames, etc)

2023-09-28T08:27:38.925+02:00] :events] ndebug] b9189] ** Event Check Loop
b2023-09-28T08:27:38.925+02:00] :events] ndebug] b9189] Next High Priority Event Time: Thu Sep 28 08:27:40 2023
b2023-09-28T08:27:38.925+02:00] :events] ndebug] b9189] Next Low Priority Event Time:  Thu Sep 28 08:27:38 2023
<2023-09-28T08:27:38.925+02:00] 2events] edebug] e9189] Current/Max Service Checks: 0/0
<2023-09-28T08:27:38.925+02:00] 2events] edebug] e9189] Running event...
<2023-09-28T08:27:38.925+02:00] 2functions] itrace] r9189] handle_timed_event()
<2023-09-28T08:27:38.925+02:00] 2events] etrace] r9189] ** Timed Event ** Type: 0, Run Time: Thu Sep 28 08:27:38 2023
<2023-09-28T08:27:38.925+02:00] 2events] etrace] r9189] ** Service Check Event ==> Host: 'our-tacacs-host', Service: 'service_tacacs_plus', Options: 0, Latency: 0.925 sec
<2023-09-28T08:27:38.925+02:00] 2functions] itrace] r9189] run_scheduled_service_check()
<2023-09-28T08:27:38.925+02:00] 2checks] etrace] r9189] Attempting to run scheduled check of service 'service_tacacs_plus' on host 'our-tacacs-host': check options=0, latency=0.925
<2023-09-28T08:27:38.925+02:00] 2functions] itrace] r9189] service::run_async_check, check_options=0, latency=0.925, scheduled_check=true, reschedule_check=true
<2023-09-28T08:27:38.925+02:00] 2checks] etrace] r9189] ** Running async check of service 'service_tacacs_plus on host 'our-tacacs-host'...
<2023-09-28T08:27:38.925+02:00] 2functions] itrace] r9189] check_service_check_viability()
<2023-09-28T08:27:38.925+02:00] 2functions] itrace] r9189] check_time_against_period()
<2023-09-28T08:27:38.925+02:00] 2functions] itrace] r9189] get_next_valid_time_per_timeperiod()
<2023-09-28T08:27:38.925+02:00] 2functions] itrace] r9189] get_next_valid_time_per_timeperiod 24x7 valid_time=1695882458
<2023-09-28T08:27:38.925+02:00] 2functions] itrace] r9189] check_time_against_period 24x7 ret=true
<2023-09-28T08:27:38.925+02:00] 2functions] itrace] r9189] service::authorized_by_dependencies()
<2023-09-28T08:27:38.925+02:00] 2checks] etrace] r9189] Checking service 'service_tacacs_plus' on host 'our-tacacs-host'...
<2023-09-28T08:27:38.925+02:00] 2functions] itrace] r9189] get_raw_command_line_r()
<2023-09-28T08:27:38.925+02:00] 2commands] adebug] e9189] Raw Command Input: $USER1$/check_tacacs_plus_file.pl -H $HOSTADDRESS$ -k $ARG1$
<2023-09-28T08:27:38.925+02:00] 2functions] itrace] r9189] process_macros_r()
<2023-09-28T08:27:38.925+02:00] 2macros] ctrace] r9189] **** BEGIN MACRO PROCESSING **** Processing: 'tacacs-key'
<2023-09-28T08:27:38.925+02:00] 2macros] ctrace] r9189]   Done.  Final output: 'tacacs-key' **** END MACRO PROCESSING ****
*2023-09-28T08:27:38.925+02:00] +functions] ctrace] [9189] process_macros_r()
(2023-09-28T08:27:38.925+02:00] +macros] mtrace] [9189] **** BEGIN MACRO PROCESSING **** Processing: 'nagios'
s2023-09-28T08:27:38.926+02:00] +macros] mtrace] [9189]   Done.  Final output: 'nagios' **** END MACRO PROCESSING ****
*2023-09-28T08:27:38.926+02:00] 2functions] utrace] ]9189] process_macros_r()
_2023-09-28T08:27:38.926+02:00] 2macros] trace] ]9189] **** BEGIN MACRO PROCESSING **** Processing: 'tacacs-pw'
-2023-09-28T08:27:38.926+02:00] 2macros] trace] ]9189]   Done.  Final output: 'tacacs-pw' **** END MACRO PROCESSING ****
G2023-09-28T08:27:38.926+02:00] .commands] debug] d9189] Expanded Command Output: $USER1$/check_tacacs_plus_file.pl -H $HOSTADDRESS$ -k $ARG1$
$2023-09-28T08:27:38.926+02:00] .checks] 0trace] k9189] Current running service checks: 1
c2023-09-28T08:27:38.926+02:00] .functions] [trace] n9189] process_macros_r()
o2023-09-28T08:27:38.926+02:00] .macros] 0trace] o9189] **** BEGIN MACRO PROCESSING **** Processing: '$USER1$/check_tacacs_plus_file.pl -H $HOSTADDRESS$ -k $ARG1$'
A2023-09-28T08:27:38.926+02:00] .macros] 0trace] o9189]   Processed 'USER1', To '/usr/local/nagios/libexec', Clean Options: 0, Free: 0
F2023-09-28T08:27:38.926+02:00] 8macros] 0trace] r9189]   Processed 'USER1', Clean Options: 0, Free: 0
2023-09-28T08:27:38.926+02:00] 3macros] :trace] c9189]   Cleaning options: global=0, local=0, effective=0
f2023-09-28T08:27:38.926+02:00] :macros] 2trace] a9189]   Uncleaned macro.  Running output (25): '/usr/local/nagios/libexec'
o2023-09-28T08:27:38.926+02:00] 2macros] +trace] [9189]   Just finished macro.  Running output (25): '/usr/local/nagios/libexec'
g2023-09-28T08:27:38.926+02:00] 8macros] 2trace] ]9189]   macrosc2] (HOSTADDRESS) match.
D2023-09-28T08:27:38.926+02:00] 0macros] 9trace] 09189]   Processed 'HOSTADDRESS', To 'tacacs-Host-IP', Clean Options: 0, Free: 1
o2023-09-28T08:27:38.926+02:00] Tmacros] .trace] 09189]   Processed 'HOSTADDRESS', Clean Options: 0, Free: 1
i2023-09-28T08:27:38.926+02:00] 8macros] 8trace] :9189]   Cleaning options: global=0, local=0, effective=0
a2023-09-28T08:27:38.926+02:00] 2macros] 3trace] 29189]   Uncleaned macro.  Running output (66): '/usr/local/nagios/libexec/check_tacacs_plus_file.pl -H tacacs-Host-IP'
2023-09-28T08:27:38.926+02:00] 9macros] 7trace] +9189]   Just finished macro.  Running output (66): '/usr/local/nagios/libexec/check_tacacs_plus_file.pl -H tacacs-Host-IP'
p2023-09-28T08:27:38.926+02:00] -macros] :trace] 29189]   Processed 'ARG1', To 'tacacs-key', Clean Options: 0, Free: 0
a2023-09-28T08:27:38.926+02:00] 3macros] 8trace] 99189]   Processed 'ARG1', Clean Options: 0, Free: 0
e2023-09-28T08:27:38.926+02:00] 2macros] 0trace] .9189]   Cleaning options: global=0, local=0, effective=0
=2023-09-28T08:27:38.926+02:00] 0macros] Ttrace] 89189]   Uncleaned macro.  Running output (78): '/usr/local/nagios/libexec/check_tacacs_plus_file.pl -H tacacs-Host-IP -k tacacs-key'
a2023-09-28T08:27:38.926+02:00] [macros] 2trace] :9189]   Just finished macro.  Running output (78): '/usr/local/nagios/libexec/check_tacacs_plus_file.pl -H tacacs-Host-IP -k tacacs-key'
a2023-09-28T08:27:38.926+02:00] /macros] 9trace] 29189]   Done.  Final output: '/usr/local/nagios/libexec/check_tacacs_plus_file.pl -H tacacs-Host-IP -k tacacs-key' **** END MACRO PROCESSING ****
*2023-09-28T08:27:38.926+02:00] rcommands] 9trace] 29189] raw::run: cmd='/usr/local/nagios/libexec/check_tacacs_plus_file.pl -H tacacs-Host-IP -k tacacs-key', timeout=60
-2023-09-28T08:27:38.926+02:00] rcommands] 9trace] 29189] raw::run: id=4 , process=0x2ca74a0
:2023-09-28T08:27:38.927+02:00] rcommands] 9trace] 29189] raw::run: start process success: id=4
n2023-09-28T08:27:38.927+02:00] rchecks] -debug] 89189] run id=4 /usr/local/nagios/libexec/check_tacacs_plus_file.pl -H tacacs-Host-IP -k tacacs-key for service 80380 host our-tacacs-host
i2023-09-28T08:27:38.927+02:00] revents] -debug] 89189] ** Event Check Loop
u2023-09-28T08:27:38.927+02:00] revents] -debug] 89189] Next High Priority Event Time: Thu Sep 28 08:27:40 2023
T2023-09-28T08:27:38.927+02:00] revents] -debug] 89189] Next Low Priority Event Time:  Thu Sep 28 08:32:20 2023
i2023-09-28T08:27:38.927+02:00] bevents] 3debug] 09189] Current/Max Service Checks: 1/0
C2023-09-28T08:27:38.927+02:00] bevents] 3debug] 09189] No events to execute at the moment. Idling for a bit...
t2023-09-28T08:27:39.061+02:00] bcommands] 0trace] :9189] raw::finished: process=0x2ca74a0
a2023-09-28T08:27:39.061+02:00] bcommands] 0trace] :9189] raw::finished: id=4
a2023-09-28T08:27:39.061+02:00] bcommands] 0trace] :9189] raw::finished: id=4, start_time=Thu Sep 28 08:27:38 2023: , end_time=Thu Sep 28 08:27:39 2023: , exit_code=2, exit_status=0, output=''
o2023-09-28T08:27:39.061+02:00] bfunctions] 9trace] 29189] checker::finished: res=0x7fa88725a320
r2023-09-28T08:27:39.927+02:00] bevents] 3debug] 09189] ** Event Check Loop
b2023-09-28T08:27:39.927+02:00] bevents] 3debug] 09189] Next High Priority Event Time: Thu Sep 28 08:27:40 2023
2023-09-28T08:27:39.927+02:00] bevents] 3debug] 09189] Next Low Priority Event Time:  Thu Sep 28 08:32:20 2023
T2023-09-28T08:27:39.927+02:00] 2023-09-28T08:27:39.927+02:00] 2023-09-28T08:27:40.927+02:00] e2023-09-28T08:27:40.927+02:00] t2023-09-28T08:27:40.927+02:00] 2023-09-28T08:27:40.927+02:00] 3events] 0debug] 89189] Current/Max Service Checks: 1/0
]2023-09-28T08:27:40.927+02:00] 0functions] -trace] 89189] handle_timed_event()
r2023-09-28T08:27:40.928+02:00] )events] 0trace] 89189] ** Timed Event ** Type: 5, Run Time: Thu Sep 28 08:27:40 2023
u2023-09-28T08:27:40.928+02:00] 3events] 0trace] 89189] ** Check Result Reaper
c2023-09-28T08:27:40.928+02:00] rfunctions] -trace] 89189] checker::reap()
s2023-09-28T08:27:40.928+02:00] )checks] 0trace] 89189] Starting to reap check results.
]2023-09-28T08:27:40.928+02:00] .checks] 0trace] 89189] Found a check result (#1) to handle...
2023-09-28T08:27:40.928+02:00] .checks] 0debug] 89189] Handling check result for service 5833/80380...
2023-09-28T08:27:40.928+02:00] .functions] -trace] 89189] handle_async_service_check_result()
n2023-09-28T08:27:40.928+02:00] )checks] 0trace] 89189] ** Handling check result for service 'service_tacacs_plus' on host 'our-tacacs-host'...
l2023-09-28T08:27:40.928+02:00] .checks] 0debug] 89189] HOST: our-tacacs-host, SERVICE: service_tacacs_plus, CHECK TYPE: Active, OPTIONS: 0, RESCHEDULE: Yes, EXITED OK: Yes, EXEC TIME: 0.13551800000000003, return CODE: 2, OUTPUT: 
02023-09-28T08:27:40.928+02:00] �checks] 2debug] 29189] Parsing check output Short Output: (No output returned from plugin) Long Output: nullptr Perf Data: nullptr
O2023-09-28T08:27:40.928+02:00] tchecks] 2debug] 29189] ST: HARD  CA: 7 MA: 7 CS: 2 LS: 2 LHS: 2
R2023-09-28T08:27:40.928+02:00] :checks] [debug] -9189] Service is in a non-OK state!
92023-09-28T08:27:40.928+02:00] tchecks] [debug] -9189] Host is currently UP, so we'll recheck its state to make sure...
l2023-09-28T08:27:40.928+02:00] .checks] [debug] -9189] * Using last known host state: 0
92023-09-28T08:27:40.928+02:00] :checks] [debug] -9189] Current/Max Attempt(s): 7/7
2023-09-28T08:27:40.928+02:00] 7checks] [debug] -9189] Service has reached max number of rechecks, so we'll handle the error...
h2023-09-28T08:27:40.928+02:00] .functions] 2trace] T9189] check_for_flapping()
[2023-09-28T08:27:40.928+02:00] gchecks] [debug] -9189] Checking service 'service_tacacs_plus' on host 'our-tacacs-host' for flapping...
t2023-09-28T08:27:40.928+02:00] .checks] [debug] -9189] LFT=20.00, HFT=30.00, CPC=0.00, PSC=0.00%
.2023-09-28T08:27:40.928+02:00] 0functions] 2trace] T9189] host::check_for_flapping()
]2023-09-28T08:27:40.928+02:00] gchecks] [debug] -9189] Checking host 'our-tacacs-host' for flapping...
t2023-09-28T08:27:40.928+02:00] .checks] [debug] -9189] LFT=20.00, HFT=30, CPC=0, PSC=0%
92023-09-28T08:27:40.928+02:00] =functions] 2trace] T9189] notifier::notify(0)
2023-09-28T08:27:40.928+02:00] (functions] 2trace] T9189] notifier::is_notification_viable_normal()
e2023-09-28T08:27:40.928+02:00] lnotifications] 9debug] 29189] Notifications are disabled, so notifications will not be sent out.
n2023-09-28T08:27:40.928+02:00] uchecks] [debug] -9189] Rescheduling next check of service at Thu Sep 28 08:32:38 2023
s2023-09-28T08:27:40.928+02:00] 0functions] 2trace] T9189] get_next_valid_time()
t2023-09-28T08:27:40.928+02:00] efunctions] 2trace] T9189] get_next_valid_time_per_timeperiod()
e2023-09-28T08:27:40.928+02:00] dfunctions] 2trace] T9189] get_next_valid_time_per_timeperiod 24x7 valid_time=1695882758
m2023-09-28T08:27:40.928+02:00] 7functions] 2trace] T9189] schedule_service_check()
c2023-09-28T08:27:40.928+02:00] kchecks] [trace] -9189] Scheduling a non-forced, active check of service 'service_tacacs_plus' on host 'our-tacacs-host' @ Thu Sep 28 08:32:38 2023
c2023-09-28T08:27:40.928+02:00] 0functions] 2trace] T9189] resort_event_list()
2023-09-28T08:27:40.928+02:00] tchecks] [debug] -9189] Scheduling new service check event.
S2023-09-28T08:27:40.928+02:00] nfunctions] 2trace] T9189] reschedule_event()
]2023-09-28T08:27:40.928+02:00] tfunctions] 2trace] T9189] add_event()
n2023-09-28T08:27:40.928+02:00] tchecks] [trace] -9189] Finished reaping 1 check results

Hi @TA-FFM can you check if the plugin return a “return code” by executing this command just après plugin execution:

echo $?

Hi Laurent, 

like this?

Regards

Sry, bad cropping before

Ok so output look like correct and return code too.

but the issue is I don’t know if Centreon Engine process can have access to /usr/local/nagios/libexec directory

Good Morning laurent,

well it is registered as $USER1$ since the old centreon and i have around ~200 skripts lying in there and only a few are having these problems. Hundreds of calls of scripts there work. Naturally centreon-engine has access-rights to that dir.

Regards

Timo

Hey @Laurent ,

any news here?

Hi @TA-FFM do you enable Centreon Perl connector in the command definition? If yes, can you disable it?