2 * Bacula message handling routines
4 * Kern Sibbald, April 2000
11 Copyright (C) 2000-2003 Kern Sibbald and John Walker
13 This program is free software; you can redistribute it and/or
14 modify it under the terms of the GNU General Public License as
15 published by the Free Software Foundation; either version 2 of
16 the License, or (at your option) any later version.
18 This program is distributed in the hope that it will be useful,
19 but WITHOUT ANY WARRANTY; without even the implied warranty of
20 MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE. See the GNU
21 General Public License for more details.
23 You should have received a copy of the GNU General Public
24 License along with this program; if not, write to the Free
25 Software Foundation, Inc., 59 Temple Place - Suite 330, Boston,
34 #define FULL_LOCATION 1 /* set for file:line in Debug messages */
36 char *working_directory = NULL; /* working directory path stored here */
37 int debug_level = 5; /* debug level */
38 time_t daemon_start_time = 0; /* Daemon start time */
40 char my_name[20]; /* daemon name is stored here */
41 char *exepath = (char *)NULL;
42 char *exename = (char *)NULL;
43 int console_msg_pending = 0;
49 FILE *trace_fd = NULL;
52 /* Forward referenced functions */
54 /* Imported functions */
59 static MSGS *daemon_msgs; /* global messages */
62 * Set daemon name. Also, find canonical execution
63 * path. Note, exepath has spare room for tacking on
64 * the exename so that we can reconstruct the full name.
66 * Note, this routine can get called multiple times
67 * The second time is to put the name as found in the
68 * Resource record. On the second call, generally,
69 * argv is NULL to avoid doing the path code twice.
71 #define BTRACE_EXTRA 20
72 void my_name_is(int argc, char *argv[], char *name)
75 char cpath[400], npath[400];
78 bstrncpy(my_name, name, sizeof(my_name));
79 if (argc>0 && argv && argv[0]) {
80 /* strip trailing filename and save exepath */
81 for (l=p=argv[0]; *p; p++) {
83 l = p; /* set pos of last slash */
91 /* On Windows allow c: junk */
101 exename = (char *)malloc(len);
107 exepath = (char *)malloc(strlen(argv[0]) + 1 + len);
108 for (p=argv[0],q=exepath; p < l; ) {
112 Dmsg1(200, "exepath=%s\n", exepath);
113 if (strchr(exepath, '.') || exepath[0] != '/') {
115 if (getcwd(cpath, sizeof(cpath))) {
116 if (chdir(exepath) == 0) {
117 if (!getcwd(npath, sizeof(npath))) {
124 exepath = (char *)malloc(strlen(npath) + 1 + len);
125 strcpy(exepath, npath);
128 Dmsg1(200, "Normalized exepath=%s\n", exepath);
134 * Initialize message handler for a daemon or a Job
135 * We make a copy of the MSGS resource passed, so it belows
136 * to the job or daemon and thus can be modified.
138 * NULL for jcr -> initialize global messages for daemon
139 * non-NULL -> initialize jcr using Message resource
142 init_msg(void *vjcr, MSGS *msg)
144 DEST *d, *dnew, *temp_chain = NULL;
145 JCR *jcr = (JCR *)vjcr;
148 * If msg is NULL, initialize global chain for STDOUT and syslog
152 daemon_msgs = (MSGS *)malloc(sizeof(MSGS));
153 memset(daemon_msgs, 0, sizeof(MSGS));
154 for (i=1; i<=M_MAX; i++) {
155 add_msg_dest(daemon_msgs, MD_STDOUT, i, NULL, NULL);
156 add_msg_dest(daemon_msgs, MD_SYSLOG, i, NULL, NULL);
158 Dmsg1(050, "Create daemon global message resource 0x%x\n", daemon_msgs);
163 * Walk down the message resource chain duplicating it
164 * for the current Job. ****FIXME***** segfault on memcpy
166 for (d=msg->dest_chain; d; d=d->next) {
167 dnew = (DEST *)malloc(sizeof(DEST));
168 memcpy(dnew, d, sizeof(DEST));
169 dnew->next = temp_chain;
171 dnew->mail_filename = NULL;
173 dnew->mail_cmd = bstrdup(d->mail_cmd);
176 dnew->where = bstrdup(d->where);
182 jcr->jcr_msgs = (MSGS *)malloc(sizeof(MSGS));
183 memset(jcr->jcr_msgs, 0, sizeof(MSGS));
184 jcr->jcr_msgs->dest_chain = temp_chain;
185 memcpy(jcr->jcr_msgs->send_msg, msg->send_msg, sizeof(msg->send_msg));
187 daemon_msgs = (MSGS *)malloc(sizeof(MSGS));
188 memset(daemon_msgs, 0, sizeof(MSGS));
189 daemon_msgs->dest_chain = temp_chain;
190 memcpy(daemon_msgs->send_msg, msg->send_msg, sizeof(msg->send_msg));
192 Dmsg2(050, "Copy message resource 0x%x to 0x%x\n", msg, temp_chain);
196 /* Initialize so that the console (User Agent) can
197 * receive messages -- stored in a file.
199 void init_console_msg(char *wd)
203 sprintf(con_fname, "%s/%s.conmsg", wd, my_name);
204 fd = open(con_fname, O_CREAT|O_RDWR|O_BINARY, 0600);
206 Emsg2(M_ERROR_TERM, 0, _("Could not open console message file %s: ERR=%s\n"),
207 con_fname, strerror(errno));
209 if (lseek(fd, 0, SEEK_END) > 0) {
210 console_msg_pending = 1;
213 con_fd = fopen(con_fname, "a+");
215 Emsg2(M_ERROR, 0, _("Could not open console message file %s: ERR=%s\n"),
216 con_fname, strerror(errno));
218 if (rwl_init(&con_lock) != 0) {
219 Emsg1(M_ERROR_TERM, 0, _("Could not get con mutex: ERR=%s\n"),
225 * Called only during parsing of the config file.
227 * Add a message destination. I.e. associate a message type with
228 * a destination (code).
229 * Note, where in the case of dest_code FILE is a filename,
230 * but in the case of MAIL is a space separated list of
231 * email addresses, ...
233 void add_msg_dest(MSGS *msg, int dest_code, int msg_type, char *where, char *mail_cmd)
237 * First search the existing chain and see if we
238 * can simply add this msg_type to an existing entry.
240 for (d=msg->dest_chain; d; d=d->next) {
241 if (dest_code == d->dest_code && ((where == NULL && d->where == NULL) ||
242 (strcmp(where, d->where) == 0))) {
243 Dmsg4(200, "Add to existing d=%x msgtype=%d destcode=%d where=%s\n",
244 d, msg_type, dest_code, NPRT(where));
245 set_bit(msg_type, d->msg_types);
246 set_bit(msg_type, msg->send_msg); /* set msg_type bit in our local */
250 /* Not found, create a new entry */
251 d = (DEST *)malloc(sizeof(DEST));
252 memset(d, 0, sizeof(DEST));
253 d->next = msg->dest_chain;
254 d->dest_code = dest_code;
255 set_bit(msg_type, d->msg_types); /* set type bit in structure */
256 set_bit(msg_type, msg->send_msg); /* set type bit in our local */
258 d->where = bstrdup(where);
261 d->mail_cmd = bstrdup(mail_cmd);
263 Dmsg5(200, "add new d=%x msgtype=%d destcode=%d where=%s mailcmd=%s\n",
264 d, msg_type, dest_code, NPRT(where), NPRT(d->mail_cmd));
269 * Called only during parsing of the config file.
271 * Remove a message destination
273 void rem_msg_dest(MSGS *msg, int dest_code, int msg_type, char *where)
277 for (d=msg->dest_chain; d; d=d->next) {
278 Dmsg2(200, "Remove_msg_dest d=%x where=%s\n", d, NPRT(d->where));
279 if (bit_is_set(msg_type, d->msg_types) && (dest_code == d->dest_code) &&
280 ((where == NULL && d->where == NULL) ||
281 (strcmp(where, d->where) == 0))) {
282 Dmsg3(200, "Found for remove d=%x msgtype=%d destcode=%d\n",
283 d, msg_type, dest_code);
284 clear_bit(msg_type, d->msg_types);
285 Dmsg0(200, "Return rem_msg_dest\n");
291 static void make_unique_spool_filename(JCR *jcr, POOLMEM **name, int fd)
293 Mmsg(name, "%s/%s.spool.%s.%d", working_directory, my_name,
297 int open_spool_file(void *vjcr, BSOCK *bs)
299 POOLMEM *name = get_pool_memory(PM_MESSAGE);
300 JCR *jcr = (JCR *)vjcr;
302 make_unique_spool_filename(jcr, &name, bs->fd);
303 bs->spool_fd = fopen(name, "w+");
305 Jmsg(jcr, M_ERROR, 0, "fopen spool file %s failed: ERR=%s\n", name, strerror(errno));
306 free_pool_memory(name);
309 free_pool_memory(name);
313 int close_spool_file(void *vjcr, BSOCK *bs)
315 POOLMEM *name = get_pool_memory(PM_MESSAGE);
316 JCR *jcr = (JCR *)vjcr;
318 make_unique_spool_filename(jcr, &name, bs->fd);
319 fclose(bs->spool_fd);
321 free_pool_memory(name);
328 * Create a unique filename for the mail command
330 static void make_unique_mail_filename(JCR *jcr, POOLMEM **name, DEST *d)
333 Mmsg(name, "%s/%s.mail.%s.%d", working_directory, my_name,
336 Mmsg(name, "%s/%s.mail.%s.%d", working_directory, my_name,
339 Dmsg1(200, "mailname=%s\n", *name);
345 static BPIPE *open_mail_pipe(JCR *jcr, POOLMEM **cmd, DEST *d)
349 if (d->mail_cmd && jcr) {
350 *cmd = edit_job_codes(jcr, *cmd, d->mail_cmd, d->where);
352 Mmsg(cmd, "mail -s \"Bacula Message\" %s", d->where);
356 if (!(bpipe = open_bpipe(*cmd, 120, "rw"))) {
357 Jmsg(jcr, M_ERROR, 0, "open mail pipe %s failed: ERR=%s\n", *cmd, strerror(errno));
363 * Close the messages for this Messages resource, which means to close
364 * any open files, and dispatch any pending email messages.
366 void close_msg(void *vjcr)
369 JCR *jcr = (JCR *)vjcr;
375 Dmsg1(050, "Close_msg jcr=0x%x\n", jcr);
377 if (jcr == NULL) { /* NULL -> global chain */
381 msgs = jcr->jcr_msgs;
382 jcr->jcr_msgs = NULL;
387 Dmsg1(150, "===Begin close msg resource at 0x%x\n", msgs);
388 cmd = get_pool_memory(PM_MESSAGE);
389 for (d=msgs->dest_chain; d; ) {
391 switch (d->dest_code) {
395 fclose(d->fd); /* close open file descriptor */
399 case MD_MAIL_ON_ERROR:
400 Dmsg0(150, "Got MD_MAIL or MD_MAIL_ON_ERROR\n");
404 if (d->dest_code == MD_MAIL_ON_ERROR && jcr &&
405 jcr->JobStatus == JS_Terminated) {
409 if (!(bpipe=open_mail_pipe(jcr, &cmd, d))) {
410 Dmsg0(000, "open mail pipe failed.\n");
413 Dmsg0(150, "Opened mail pipe\n");
415 line = get_memory(len);
417 while (fgets(line, len, d->fd)) {
418 fputs(line, bpipe->wfd);
420 if (!close_wpipe(bpipe)) { /* close write pipe sending mail */
421 Dmsg1(000, "close error: ERR=%s\n", strerror(errno));
425 * Since we are closing all messages, before "recursing"
426 * make sure we are not closing the daemon messages, otherwise
429 if (msgs != daemon_msgs) {
430 /* read what mail prog returned -- should be nothing */
431 while (fgets(line, len, bpipe->rfd)) {
432 Jmsg1(jcr, M_INFO, 0, _("Mail prog: %s"), line);
436 stat = close_bpipe(bpipe);
437 if (stat != 0 && msgs != daemon_msgs) {
438 Dmsg1(150, "Calling emsg. CMD=%s\n", cmd);
439 Jmsg2(jcr, M_ERROR, 0, _("Mail program terminated in error. stat=%d\n"
440 "CMD=%s\n"), stat, cmd);
444 /* Remove temp file */
446 unlink(d->mail_filename);
447 free_pool_memory(d->mail_filename);
448 d->mail_filename = NULL;
449 Dmsg0(150, "end mail or mail on error\n");
456 d = d->next; /* point to next buffer */
458 free_pool_memory(cmd);
459 Dmsg0(150, "Done walking message chain.\n");
462 Dmsg0(150, "===End close msg resource\n");
466 * Free memory associated with Messages resource
468 void free_msgs_res(MSGS *msgs)
472 for (d=msgs->dest_chain; d; ) {
479 old = d; /* save pointer to release */
480 d = d->next; /* point to next buffer */
481 free(old); /* free the destination item */
483 msgs->dest_chain = NULL;
489 * Terminate the message handler for good.
490 * Release the global destination chain.
492 * Also, clean up a few other items (cons, exepath). Note,
493 * these really should be done elsewhere.
497 Dmsg0(100, "Enter term_msg\n");
498 close_msg(NULL); /* close global chain */
522 * Handle sending the message to the appropriate place
524 void dispatch_message(void *vjcr, int type, int level, char *msg)
527 char dt[MAX_TIME_LENGTH];
529 JCR *jcr = (JCR *) vjcr;
534 Dmsg2(200, "Enter dispatch_msg type=%d msg=%s\n", type, msg);
536 if (type == M_ABORT || type == M_ERROR_TERM) {
537 fputs(msg, stdout); /* print this here to INSURE that it is printed */
540 /* Now figure out where to send the message */
543 msgs = jcr->jcr_msgs;
548 for (d=msgs->dest_chain; d; d=d->next) {
549 if (bit_is_set(type, d->msg_types)) {
550 switch (d->dest_code) {
552 Dmsg1(400, "CONSOLE for following msg: %s", msg);
554 con_fd = fopen(con_fname, "a+");
555 Dmsg0(200, "Console file not open.\n");
558 Pw(con_lock); /* get write lock on console message file */
560 bstrftime(dt, sizeof(dt), time(NULL));
563 fwrite(dt, len, 1, con_fd);
566 fwrite(msg, len, 1, con_fd);
567 if (msg[len-1] != '\n') {
568 fwrite("\n", 2, 1, con_fd);
571 fwrite("\n", 2, 1, con_fd);
574 console_msg_pending = TRUE;
579 Dmsg1(400, "SYSLOG for collowing msg: %s\n", msg);
580 /* We really should do an openlog() here */
581 syslog(LOG_DAEMON|LOG_ERR, msg);
584 Dmsg1(400, "OPERATOR for collowing msg: %s\n", msg);
585 mcmd = get_pool_memory(PM_MESSAGE);
586 if ((bpipe=open_mail_pipe(jcr, &mcmd, d))) {
588 fputs(msg, bpipe->wfd);
589 /* Messages to the operator go one at a time */
590 stat = close_bpipe(bpipe);
592 Emsg1(M_ERROR, 0, _("Operator mail program terminated in error.\nCMD=%s\n"),
596 free_pool_memory(mcmd);
599 case MD_MAIL_ON_ERROR:
600 Dmsg1(400, "MAIL for following msg: %s", msg);
602 POOLMEM *name = get_pool_memory(PM_MESSAGE);
603 make_unique_mail_filename(jcr, &name, d);
604 d->fd = fopen(name, "w+");
607 Emsg2(M_ERROR, 0, "fopen %s failed: ERR=%s\n", name, strerror(errno));
609 free_pool_memory(name);
612 d->mail_filename = name;
615 if (len > d->max_len) {
616 d->max_len = len; /* keep max line length */
621 Dmsg1(400, "FILE for following msg: %s", msg);
623 d->fd = fopen(d->where, "w+");
626 Emsg2(M_ERROR, 0, "fopen %s failed: ERR=%s\n", d->where, strerror(errno));
634 Dmsg1(400, "APPEND for following msg: %s", msg);
636 d->fd = fopen(d->where, "a");
639 Emsg2(M_ERROR, 0, "fopen %s failed: ERR=%s\n", d->where, strerror(errno));
647 Dmsg1(400, "DIRECTOR for following msg: %s", msg);
648 if (jcr && jcr->dir_bsock && !jcr->dir_bsock->errors) {
650 jcr->dir_bsock->msglen = Mmsg(&(jcr->dir_bsock->msg),
651 "Jmsg Job=%s type=%d level=%d %s", jcr->Job,
652 type, level, msg) + 1;
653 bnet_send(jcr->dir_bsock);
657 Dmsg1(400, "STDOUT for following msg: %s", msg);
658 if (type != M_ABORT && type != M_ERROR_TERM) /* already printed */
662 Dmsg1(400, "STDERR for following msg: %s", msg);
673 /*********************************************************************
675 * subroutine prints a debug message if the level number
676 * is less than or equal the debug_level. File and line numbers
677 * are included for more detail if desired, but not currently
680 * If the level is negative, the details of file and line number
684 d_msg(char *file, int line, int level, char *fmt,...)
696 if (level <= debug_level) {
699 len= sprintf(buf, "%s: %s:%d ", my_name, file, line);
706 va_start(arg_ptr, fmt);
707 bvsnprintf(buf+len, sizeof(buf)-len, (char *)fmt, arg_ptr);
715 /*********************************************************************
717 * subroutine writes a debug message to the trace file if the level number
718 * is less than or equal the debug_level. File and line numbers
719 * are included for more detail if desired, but not currently
722 * If the level is negative, the details of file and line number
726 t_msg(char *file, int line, int level, char *fmt,...)
740 if (level <= debug_level) {
742 trace_fd = fopen("bacula.trace", "a+");
744 Emsg1(M_ABORT, 0, _("Cannot open bacula.trace: ERR=%s\n"),
751 len = sprintf(buf, "%s: %s:%d ", my_name, file, line);
758 va_start(arg_ptr, fmt);
759 bvsnprintf(buf+len, sizeof(buf)-len, (char *)fmt, arg_ptr);
762 fputs(buf, trace_fd);
769 /* *********************************************************
771 * print an error message
775 e_msg(char *file, int line, int type, int level, char *fmt,...)
782 * Check if we have a message destination defined.
783 * We always report M_ABORT and M_ERROR_TERM
785 if (!daemon_msgs || ((type != M_ABORT && type != M_ERROR_TERM) &&
786 !bit_is_set(type, daemon_msgs->send_msg))) {
787 return; /* no destination */
791 len = sprintf(buf, "%s: ABORTING due to ERROR in %s:%d\n",
792 my_name, file, line);
795 len = sprintf(buf, "%s: ERROR TERMINATION at %s:%d\n",
796 my_name, file, line);
799 if (level == -1) /* skip details */
800 len = sprintf(buf, "%s: Fatal Error because: ", my_name);
802 len = sprintf(buf, "%s: Fatal Error at %s:%d because:\n", my_name, file, line);
805 if (level == -1) /* skip details */
806 len = sprintf(buf, "%s: Error: ", my_name);
808 len = sprintf(buf, "%s: Error in %s:%d ", my_name, file, line);
811 len = sprintf(buf, "%s: Warning: ", my_name);
814 len = sprintf(buf, "%s: ", my_name);
818 va_start(arg_ptr, fmt);
819 bvsnprintf(buf+len, sizeof(buf)-len, (char *)fmt, arg_ptr);
822 dispatch_message(NULL, type, level, buf);
824 if (type == M_ABORT) {
826 p[0] = 0; /* generate segmentation violation */
828 if (type == M_ERROR_TERM) {
833 /* *********************************************************
835 * Generate a Job message
839 Jmsg(void *vjcr, int type, int level, char *fmt,...)
844 JCR *jcr = (JCR *)vjcr;
849 Dmsg1(200, "Enter Jmsg type=%d\n", type);
854 msgs = jcr->jcr_msgs;
858 msgs = daemon_msgs; /* if no jcr, we use daemon handler */
861 job = ""; /* Set null job name if none */
865 * Check if we have a message destination defined.
866 * We always report M_ABORT and M_ERROR_TERM
868 if (msgs && (type != M_ABORT && type != M_ERROR_TERM) &&
869 !bit_is_set(type, msgs->send_msg)) {
870 return; /* no destination */
874 len = sprintf(rbuf, "%s ABORTING due to ERROR\n", my_name);
877 len = sprintf(rbuf, "%s ERROR TERMINATION\n", my_name);
880 len = sprintf(rbuf, "%s: %s Fatal error: ", my_name, job);
882 set_jcr_job_status(jcr, JS_FatalError);
886 len = sprintf(rbuf, "%s: %s Error: ", my_name, job);
892 len = sprintf(rbuf, "%s: %s Warning: ", my_name, job);
895 len = sprintf(rbuf, "%s: ", my_name);
899 va_start(arg_ptr, fmt);
900 bvsnprintf(rbuf+len, sizeof(rbuf)-len, fmt, arg_ptr);
903 dispatch_message(jcr, type, level, rbuf);
905 if (type == M_ABORT){
907 p[0] = 0; /* generate segmentation violation */
909 if (type == M_ERROR_TERM) {
915 * Edit a message into a Pool memory buffer, with file:lineno
917 int m_msg(char *file, int line, POOLMEM **pool_buf, char *fmt, ...)
922 i = sprintf(*pool_buf, "%s:%d ", file, line);
925 maxlen = sizeof_pool_memory(*pool_buf) - i - 1;
926 va_start(arg_ptr, fmt);
927 len = bvsnprintf(*pool_buf+i, maxlen, fmt, arg_ptr);
929 if (len < 0 || len >= maxlen) {
930 *pool_buf = realloc_pool_memory(*pool_buf, maxlen + i + 200);
937 * Edit a message into a Pool Memory buffer NO file:lineno
938 * Returns: string length of what was edited.
940 int Mmsg(POOLMEM **pool_buf, char *fmt, ...)
946 maxlen = sizeof_pool_memory(*pool_buf) - 1;
947 va_start(arg_ptr, fmt);
948 len = bvsnprintf(*pool_buf, maxlen, fmt, arg_ptr);
950 if (len < 0 || len >= maxlen) {
951 *pool_buf = realloc_pool_memory(*pool_buf, maxlen + 200);
959 * If we come here, prefix the message with the file:line-number,
960 * then pass it on to the normal Jmsg routine.
962 void j_msg(char *file, int line, void *jcr, int type, int level, char *fmt,...)
968 pool_buf = get_pool_memory(PM_EMSG);
969 i = sprintf(pool_buf, "%s:%d ", file, line);
972 maxlen = sizeof_pool_memory(pool_buf) - i - 1;
973 va_start(arg_ptr, fmt);
974 len = bvsnprintf(pool_buf+i, maxlen, fmt, arg_ptr);
976 if (len < 0 || len >= maxlen) {
977 pool_buf = realloc_pool_memory(pool_buf, maxlen + i + 200);
981 Jmsg(jcr, type, level, "%s", pool_buf);
982 free_memory(pool_buf);