cta-admin add client host and username in cta-frontend logs
Problem to solve
Currently there is no way to know from the cta-frontend
logs who issued a cta-admin command and from where.
This is a problem if multiple operators are taking actions without communicating to the rest of the operation team.
It would be also convenient to identify actions taken by a probe/the alarming system.
Current behavior
[1566285489.189091000] Aug 20 09:18:09.189091 ctapps-frontend01
cta-frontend: LVL="INFO" PID="16427" TID="16459" MSG="In
RequestMessage::process(): Admin command succeeded: drive ls"
adminTime="0.013423"
[1566285497.205766000] Aug 20 09:18:17.205766 ctapps-frontend01
cta-frontend: LVL="INFO" PID="16427" TID="16490" MSG="In
Scheduler::authorizeAdmin(): success." catalogueTime="0.000017"
[1566285497.222807000] Aug 20 09:18:17.222807 ctapps-frontend01
cta-frontend: LVL="INFO" PID="16427" TID="16490" MSG="In
Scheduler::getDriveStates(): success." schedulerDbTime="0.016941"
[1566285497.234821000] Aug 20 09:18:17.234821 ctapps-frontend01
cta-frontend: LVL="INFO" PID="16427" TID="16490" MSG="In
Scheduler::setDesiredDriveState(): success." drive="I1L80642" up="down"
force="no" schedulerDbTime="0.011896"
[1566285497.245783000] Aug 20 09:18:17.245783 ctapps-frontend01
cta-frontend: LVL="INFO" PID="16427" TID="16490" MSG="In
Scheduler::setDesiredDriveState(): success." drive="I1L80931" up="down"
force="no" schedulerDbTime="0.010865"
[1566285497.257914000] Aug 20 09:18:17.257914 ctapps-frontend01
cta-frontend: LVL="INFO" PID="16427" TID="16490" MSG="In
Scheduler::setDesiredDriveState(): success." drive="I3550912" up="down"
force="no" schedulerDbTime="0.012032"
[1566285497.268481000] Aug 20 09:18:17.268481 ctapps-frontend01
cta-frontend: LVL="INFO" PID="16427" TID="16490" MSG="In
Scheduler::setDesiredDriveState(): success." drive="I3550913" up="down"
force="no" schedulerDbTime="0.010476"
[1566285497.280631000] Aug 20 09:18:17.280631 ctapps-frontend01
cta-frontend: LVL="INFO" PID="16427" TID="16490" MSG="In
Scheduler::setDesiredDriveState(): success." drive="I3550914" up="down"
force="no" schedulerDbTime="0.012039"
[1566285497.293643000] Aug 20 09:18:17.293643 ctapps-frontend01
cta-frontend: LVL="INFO" PID="16427" TID="16490" MSG="In
Scheduler::setDesiredDriveState(): success." drive="I3551422" up="down"
force="no" schedulerDbTime="0.012917"
[1566285497.306154000] Aug 20 09:18:17.306154 ctapps-frontend01
cta-frontend: LVL="INFO" PID="16427" TID="16490" MSG="In
Scheduler::setDesiredDriveState(): success." drive="I3551431" up="down"
force="no" schedulerDbTime="0.012419"
[1566285497.317142000] Aug 20 09:18:17.317142 ctapps-frontend01
cta-frontend: LVL="INFO" PID="16427" TID="16490" MSG="In
Scheduler::setDesiredDriveState(): success." drive="I3JD0941" up="down"
force="no" schedulerDbTime="0.010890"
[1566285497.329010000] Aug 20 09:18:17.329010 ctapps-frontend01
cta-frontend: LVL="INFO" PID="16427" TID="16490" MSG="In
Scheduler::setDesiredDriveState(): success." drive="I3JD0942" up="down"
force="no" schedulerDbTime="0.011772"
[1566285497.339412000] Aug 20 09:18:17.339412 ctapps-frontend01
cta-frontend: LVL="INFO" PID="16427" TID="16490" MSG="In
Scheduler::setDesiredDriveState(): success." drive="I4550843" up="down"
force="no" schedulerDbTime="0.010310"
[1566285497.351134000] Aug 20 09:18:17.351134 ctapps-frontend01
cta-frontend: LVL="INFO" PID="16427" TID="16490" MSG="In
Scheduler::setDesiredDriveState(): success." drive="I4550844" up="down"
force="no" schedulerDbTime="0.011628"
[1566285497.364092000] Aug 20 09:18:17.364092 ctapps-frontend01
cta-frontend: LVL="INFO" PID="16427" TID="16490" MSG="In
Scheduler::setDesiredDriveState(): success." drive="I4551414" up="down"
force="no" schedulerDbTime="0.012867"
[1566285497.373883000] Aug 20 09:18:17.373883 ctapps-frontend01
cta-frontend: LVL="INFO" PID="16427" TID="16490" MSG="In
Scheduler::setDesiredDriveState(): success." drive="I4551413" up="down"
force="no" schedulerDbTime="0.009698"
[1566285497.383833000] Aug 20 09:18:17.383833 ctapps-frontend01
cta-frontend: LVL="INFO" PID="16427" TID="16490" MSG="In
Scheduler::setDesiredDriveState(): success." drive="I3550924" up="down"
force="no" schedulerDbTime="0.009854"
[1566285497.395998000] Aug 20 09:18:17.395998 ctapps-frontend01
cta-frontend: LVL="INFO" PID="16427" TID="16490" MSG="In
Scheduler::setDesiredDriveState(): success." drive="I4550831" up="down"
force="no" schedulerDbTime="0.012075"
[1566285497.405821000] Aug 20 09:18:17.405821 ctapps-frontend01
cta-frontend: LVL="INFO" PID="16427" TID="16490" MSG="In
Scheduler::setDesiredDriveState(): success." drive="I4550823" up="down"
force="no" schedulerDbTime="0.009709"
[1566285497.406099000] Aug 20 09:18:17.406099 ctapps-frontend01
cta-frontend: LVL="INFO" PID="16427" TID="16490" MSG="In
RequestMessage::process(): Admin command succeeded: drive down"
adminTime="0.200084"
[1566285500.673684000] Aug 20 09:18:20.673684 ctapps-frontend01
cta-frontend: LVL="INFO" PID="16427" TID="16685" MSG="In
Scheduler::authorizeAdmin(): success." catalogueTime="0.001346"
[1566285500.692416000] Aug 20 09:18:20.692416 ctapps-frontend01
cta-frontend: LVL="INFO" PID="16427" TID="16685" MSG="In
Scheduler::getDriveStates(): success." schedulerDbTime="0.018543"
[1566285500.692718000] Aug 20 09:18:20.692718 ctapps-frontend01
cta-frontend: LVL="INFO" PID="16427" TID="16685" MSG="In
RequestMessage::process(): Admin command succeeded: drive ls"
adminTime="0.018661"
[1566285509.420394000] Aug 20 09:18:29.420394 ctapps-frontend01
cta-frontend: LVL="INFO" PID="16427" TID="16575" MSG="In
Scheduler::authorizeAdmin(): success." catalogueTime="0.000020"
We have krb5 authentication and we know where the command was issued we should add this information in the logs.