Remove two obsolete comments in log_error().
[privoxy.git] / errlog.c
1 const char errlog_rcs[] = "$Id: errlog.c,v 1.104 2010/07/26 11:20:17 fabiankeil Exp $";
2 /*********************************************************************
3  *
4  * File        :  $Source: /cvsroot/ijbswa/current/errlog.c,v $
5  *
6  * Purpose     :  Log errors to a designated destination in an elegant,
7  *                printf-like fashion.
8  *
9  * Copyright   :  Written by and Copyright (C) 2001-2010 the
10  *                Privoxy team. http://www.privoxy.org/
11  *
12  *                Based on the Internet Junkbuster originally written
13  *                by and Copyright (C) 1997 Anonymous Coders and 
14  *                Junkbusters Corporation.  http://www.junkbusters.com
15  *
16  *                This program is free software; you can redistribute it 
17  *                and/or modify it under the terms of the GNU General
18  *                Public License as published by the Free Software
19  *                Foundation; either version 2 of the License, or (at
20  *                your option) any later version.
21  *
22  *                This program is distributed in the hope that it will
23  *                be useful, but WITHOUT ANY WARRANTY; without even the
24  *                implied warranty of MERCHANTABILITY or FITNESS FOR A
25  *                PARTICULAR PURPOSE.  See the GNU General Public
26  *                License for more details.
27  *
28  *                The GNU General Public License should be included with
29  *                this file.  If not, you can view it at
30  *                http://www.gnu.org/copyleft/gpl.html
31  *                or write to the Free Software Foundation, Inc., 59
32  *                Temple Place - Suite 330, Boston, MA  02111-1307, USA.
33  *
34  *********************************************************************/
35
36
37 #include <stdlib.h>
38 #include <stdio.h>
39 #include <stdarg.h>
40 #include <string.h>
41 #include <ctype.h>
42
43 #include "config.h"
44 #include "miscutil.h"
45
46 /* For gettimeofday() */
47 #include <sys/time.h>
48
49 #if !defined(_WIN32) && !defined(__OS2__)
50 #include <unistd.h>
51 #endif /* !defined(_WIN32) && !defined(__OS2__) */
52
53 #include <errno.h>
54 #include <assert.h>
55
56 #ifdef _WIN32
57 #ifndef STRICT
58 #define STRICT
59 #endif
60 #include <windows.h>
61 #ifndef _WIN_CONSOLE
62 #include "w32log.h"
63 #endif /* ndef _WIN_CONSOLE */
64 #endif /* def _WIN32 */
65 #ifdef _MSC_VER
66 #define inline __inline
67 #endif /* def _MSC_VER */
68
69 #ifdef __OS2__
70 #include <sys/socket.h> /* For sock_errno */
71 #define INCL_DOS
72 #include <os2.h>
73 #endif
74
75 #include "errlog.h"
76 #include "project.h"
77 #include "jcc.h"
78
79 const char errlog_h_rcs[] = ERRLOG_H_VERSION;
80
81
82 /*
83  * LOG_LEVEL_FATAL cannot be turned off.  (There are
84  * some exceptional situations where we need to get a
85  * message to the user).
86  */
87 #define LOG_LEVEL_MINIMUM  LOG_LEVEL_FATAL
88
89 /* where to log (default: stderr) */
90 static FILE *logfp = NULL;
91
92 /* logging detail level. XXX: stupid name. */
93 static int debug = (LOG_LEVEL_FATAL | LOG_LEVEL_ERROR);
94
95 /* static functions */
96 static void fatal_error(const char * error_message);
97 #ifdef _WIN32
98 static char *w32_socket_strerr(int errcode, char *tmp_buf);
99 #endif
100 #ifdef __OS2__
101 static char *os2_socket_strerr(int errcode, char *tmp_buf);
102 #endif
103
104 #ifdef MUTEX_LOCKS_AVAILABLE
105 static inline void lock_logfile(void)
106 {
107    privoxy_mutex_lock(&log_mutex);
108 }
109 static inline void unlock_logfile(void)
110 {
111    privoxy_mutex_unlock(&log_mutex);
112 }
113 static inline void lock_loginit(void)
114 {
115    privoxy_mutex_lock(&log_init_mutex);
116 }
117 static inline void unlock_loginit(void)
118 {
119    privoxy_mutex_unlock(&log_init_mutex);
120 }
121 #else /* ! MUTEX_LOCKS_AVAILABLE */
122 /*
123  * FIXME we need a cross-platform locking mechanism.
124  * The locking/unlocking functions below should be 
125  * fleshed out for non-pthread implementations.
126  */ 
127 static inline void lock_logfile() {}
128 static inline void unlock_logfile() {}
129 static inline void lock_loginit() {}
130 static inline void unlock_loginit() {}
131 #endif
132
133 /*********************************************************************
134  *
135  * Function    :  fatal_error
136  *
137  * Description :  Displays a fatal error to standard error (or, on 
138  *                a WIN32 GUI, to a dialog box), and exits Privoxy
139  *                with status code 1.
140  *
141  * Parameters  :
142  *          1  :  error_message = The error message to display.
143  *
144  * Returns     :  Does not return.
145  *
146  *********************************************************************/
147 static void fatal_error(const char *error_message)
148 {
149 #if defined(_WIN32) && !defined(_WIN_CONSOLE)
150    /* Skip timestamp and thread id for the message box. */
151    const char *box_message = strstr(error_message, "Fatal error");
152    if (NULL == box_message)
153    {
154       /* Shouldn't happen but ... */
155       box_message = error_message;
156    }
157    MessageBox(g_hwndLogFrame, box_message, "Privoxy Error", 
158       MB_OK | MB_ICONERROR | MB_TASKMODAL | MB_SETFOREGROUND | MB_TOPMOST);  
159
160    /* Cleanup - remove taskbar icon etc. */
161    TermLogWindow();
162 #endif /* defined(_WIN32) && !defined(_WIN_CONSOLE) */
163
164    if (logfp != NULL)
165    {
166       fputs(error_message, logfp);
167    }
168
169 #if defined(unix)
170    if (pidfile)
171    {
172       unlink(pidfile);
173    }
174 #endif /* unix */
175
176    exit(1);
177 }
178
179
180 /*********************************************************************
181  *
182  * Function    :  show_version
183  *
184  * Description :  Logs the Privoxy version and the program name.
185  *
186  * Parameters  :
187  *          1  :  prog_name = The program name.
188  *
189  * Returns     :  Nothing.
190  *
191  *********************************************************************/
192 void show_version(const char *prog_name)
193 {
194    log_error(LOG_LEVEL_INFO, "Privoxy version " VERSION);
195    if (prog_name != NULL)
196    {
197       log_error(LOG_LEVEL_INFO, "Program name: %s", prog_name);
198    }
199 }
200
201
202 /*********************************************************************
203  *
204  * Function    :  init_log_module
205  *
206  * Description :  Initializes the logging module to log to stderr.
207  *                Can only be called while stderr hasn't been closed
208  *                yet and is only supposed to be called once.
209  *
210  * Parameters  :
211  *          1  :  prog_name = The program name.
212  *
213  * Returns     :  Nothing.
214  *
215  *********************************************************************/
216 void init_log_module(void)
217 {
218    lock_logfile();
219    logfp = stderr;
220    unlock_logfile();
221    set_debug_level(debug);
222 }
223
224
225 /*********************************************************************
226  *
227  * Function    :  set_debug_level
228  *
229  * Description :  Sets the debug level to the provided value
230  *                plus LOG_LEVEL_MINIMUM.
231  *
232  *                XXX: we should only use the LOG_LEVEL_MINIMUM
233  *                until the first time the configuration file has
234  *                been parsed.
235  *                
236  * Parameters  :  1: debug_level = The debug level to set.
237  *
238  * Returns     :  Nothing.
239  *
240  *********************************************************************/
241 void set_debug_level(int debug_level)
242 {
243    debug = debug_level | LOG_LEVEL_MINIMUM;
244 }
245
246
247 /*********************************************************************
248  *
249  * Function    :  disable_logging
250  *
251  * Description :  Disables logging.
252  *                
253  * Parameters  :  None.
254  *
255  * Returns     :  Nothing.
256  *
257  *********************************************************************/
258 void disable_logging(void)
259 {
260    if (logfp != NULL)
261    {
262       log_error(LOG_LEVEL_INFO,
263          "No logfile configured. Please enable it before reporting any problems.");
264       lock_logfile();
265       fclose(logfp);
266       logfp = NULL;
267       unlock_logfile();
268    }
269 }
270
271
272 /*********************************************************************
273  *
274  * Function    :  init_error_log
275  *
276  * Description :  Initializes the logging module to log to a file.
277  *
278  *                XXX: should be renamed.
279  *
280  * Parameters  :
281  *          1  :  prog_name  = The program name.
282  *          2  :  logfname   = The logfile to (re)open.
283  *
284  * Returns     :  N/A
285  *
286  *********************************************************************/
287 void init_error_log(const char *prog_name, const char *logfname)
288 {
289    FILE *fp;
290
291    assert(NULL != logfname);
292
293    lock_loginit();
294
295    if ((logfp != NULL) && (logfp != stderr))
296    {
297       log_error(LOG_LEVEL_INFO, "(Re-)Opening logfile \'%s\'", logfname);
298    }
299
300    /* set the designated log file */
301    fp = fopen(logfname, "a");
302    if ((NULL == fp) && (logfp != NULL))
303    {
304       /*
305        * Some platforms (like OS/2) don't allow us to open
306        * the same file twice, therefore we give it another
307        * shot after closing the old file descriptor first.
308        *
309        * We don't do it right away because it prevents us
310        * from logging the "can't open logfile" message to
311        * the old logfile.
312        *
313        * XXX: this is a lame workaround and once the next
314        * release is out we should stop bothering reopening
315        * the logfile unless we have to.
316        *
317        * Currently we reopen it every time the config file
318        * has been reloaded, but actually we only have to
319        * reopen it if the file name changed or if the
320        * configuration reload was caused by a SIGHUP.
321        */
322       log_error(LOG_LEVEL_INFO, "Failed to reopen logfile: \'%s\'. "
323          "Retrying after closing the old file descriptor first. If that "
324          "doesn't work, Privoxy will exit without being able to log a message.",
325          logfname);
326       lock_logfile();
327       fclose(logfp);
328       logfp = NULL;
329       unlock_logfile();
330       fp = fopen(logfname, "a");
331    }
332
333    if (NULL == fp)
334    {
335       log_error(LOG_LEVEL_FATAL, "init_error_log(): can't open logfile: \'%s\'", logfname);
336    }
337
338    /* set logging to be completely unbuffered */
339    setbuf(fp, NULL);
340
341    lock_logfile();
342    if (logfp != NULL)
343    {
344       fclose(logfp);
345    }
346 #ifdef unix
347    if (daemon_mode && (logfp == stderr))
348    {
349       if (dup2(1, 2) == -1)
350       {
351          /*
352           * We only use fatal_error() to clear the pid
353           * file and to exit. Given that stderr has just
354           * been closed, the user will not see the error
355           * message.
356           */
357          fatal_error("Failed to reserve fd 2.");
358       }
359    }
360 #endif
361    logfp = fp;
362    unlock_logfile();
363
364    show_version(prog_name);
365
366    unlock_loginit();
367
368 } /* init_error_log */
369
370
371 /*********************************************************************
372  *
373  * Function    :  get_thread_id
374  *
375  * Description :  Returns a number that is different for each thread.
376  *
377  *                XXX: Should be moved elsewhere (miscutil.c?)
378  *                
379  * Parameters  :  None
380  *
381  * Returns     :  thread_id
382  *
383  *********************************************************************/
384 static long get_thread_id(void)
385 {
386    long this_thread = 1;  /* was: pthread_t this_thread;*/
387
388 #ifdef __OS2__
389    PTIB     ptib;
390    APIRET   ulrc; /* XXX: I have no clue what this does */
391 #endif /* __OS2__ */
392
393    /* FIXME get current thread id */
394 #ifdef FEATURE_PTHREAD
395    this_thread = (long)pthread_self();
396 #ifdef __MACH__
397    /*
398     * Mac OSX (and perhaps other Mach instances) doesn't have a debuggable
399     * value at the first 4 bytes of pthread_self()'s return value, a pthread_t.
400     * pthread_t is supposed to be opaque... but it's fairly random, though, so
401     * we make it mostly presentable.
402     */
403    this_thread = abs(this_thread % 1000);
404 #endif /* def __MACH__ */
405 #elif defined(_WIN32)
406    this_thread = GetCurrentThreadId();
407 #elif defined(__OS2__)
408    ulrc = DosGetInfoBlocks(&ptib, NULL);
409    if (ulrc == 0)
410      this_thread = ptib -> tib_ptib2 -> tib2_ultid;
411 #endif /* def FEATURE_PTHREAD */
412
413    return this_thread;
414 }
415
416
417 /*********************************************************************
418  *
419  * Function    :  get_log_timestamp
420  *
421  * Description :  Generates the time stamp for the log message prefix.
422  *
423  * Parameters  :
424  *          1  :  buffer = Storage buffer
425  *          2  :  buffer_size = Size of storage buffer
426  *
427  * Returns     :  Number of written characters or 0 for error.
428  *
429  *********************************************************************/
430 static inline size_t get_log_timestamp(char *buffer, size_t buffer_size)
431 {
432    size_t length;
433    time_t now; 
434    struct tm tm_now;
435    struct timeval tv_now; /* XXX: stupid name */
436    long msecs;
437    int msecs_length = 0;
438
439    gettimeofday(&tv_now, NULL);
440    msecs = tv_now.tv_usec / 1000;
441    now = tv_now.tv_sec;
442
443 #ifdef HAVE_LOCALTIME_R
444    tm_now = *localtime_r(&now, &tm_now);
445 #elif defined(MUTEX_LOCKS_AVAILABLE)
446    privoxy_mutex_lock(&localtime_mutex);
447    tm_now = *localtime(&now); 
448    privoxy_mutex_unlock(&localtime_mutex);
449 #else
450    tm_now = *localtime(&now); 
451 #endif
452
453    length = strftime(buffer, buffer_size, "%b %d %H:%M:%S", &tm_now);
454    if (length > (size_t)0)
455    {
456       msecs_length = snprintf(buffer+length, buffer_size - length, ".%.3ld", msecs);               
457    }
458    if (msecs_length > 0)
459    {
460       length += (size_t)msecs_length;
461    }
462    else
463    {
464       length = 0;
465    }
466
467    return length;
468 }
469
470
471 /*********************************************************************
472  *
473  * Function    :  get_clf_timestamp
474  *
475  * Description :  Generates a Common Log Format time string.
476  *
477  * Parameters  :
478  *          1  :  buffer = Storage buffer
479  *          2  :  buffer_size = Size of storage buffer
480  *
481  * Returns     :  Number of written characters or 0 for error.
482  *
483  *********************************************************************/
484 static inline size_t get_clf_timestamp(char *buffer, size_t buffer_size)
485 {
486    /*
487     * Complex because not all OSs have tm_gmtoff or
488     * the %z field in strftime()
489     */
490    time_t now;
491    struct tm *tm_now; 
492    struct tm gmt;
493 #ifdef HAVE_LOCALTIME_R
494    struct tm dummy;
495 #endif
496    int days, hrs, mins;
497    size_t length;
498    int tz_length = 0;
499
500    time (&now); 
501 #ifdef HAVE_GMTIME_R
502    gmt = *gmtime_r(&now, &gmt);
503 #elif defined(MUTEX_LOCKS_AVAILABLE)
504    privoxy_mutex_lock(&gmtime_mutex);
505    gmt = *gmtime(&now);
506    privoxy_mutex_unlock(&gmtime_mutex);
507 #else
508    gmt = *gmtime(&now);
509 #endif
510 #ifdef HAVE_LOCALTIME_R
511    tm_now = localtime_r(&now, &dummy);
512 #elif defined(MUTEX_LOCKS_AVAILABLE)
513    privoxy_mutex_lock(&localtime_mutex);
514    tm_now = localtime(&now); 
515    privoxy_mutex_unlock(&localtime_mutex);
516 #else
517    tm_now = localtime(&now); 
518 #endif
519    days = tm_now->tm_yday - gmt.tm_yday; 
520    hrs = ((days < -1 ? 24 : 1 < days ? -24 : days * 24) + tm_now->tm_hour - gmt.tm_hour); 
521    mins = hrs * 60 + tm_now->tm_min - gmt.tm_min; 
522
523    length = strftime(buffer, buffer_size, "%d/%b/%Y:%H:%M:%S ", tm_now);
524
525    if (length > (size_t)0)
526    {
527       tz_length = snprintf(buffer+length, buffer_size-length,
528                      "%+03d%02d", mins / 60, abs(mins) % 60);
529    }
530    if (tz_length > 0)
531    {
532       length += (size_t)tz_length;
533    }
534    else
535    {
536       length = 0;
537    }
538
539    return length;
540 }
541
542
543 /*********************************************************************
544  *
545  * Function    :  get_log_level_string
546  *
547  * Description :  Translates a numerical loglevel into a string.
548  *
549  * Parameters  :  
550  *          1  :  loglevel = LOG_LEVEL_FOO
551  *
552  * Returns     :  Log level string.
553  *
554  *********************************************************************/
555 static inline const char *get_log_level_string(int loglevel)
556 {
557    char *log_level_string = NULL;
558
559    assert(0 < loglevel);
560
561    switch (loglevel)
562    {
563       case LOG_LEVEL_ERROR:
564          log_level_string = "Error";
565          break;
566       case LOG_LEVEL_FATAL:
567          log_level_string = "Fatal error";
568          break;
569       case LOG_LEVEL_GPC:
570          log_level_string = "Request";
571          break;
572       case LOG_LEVEL_CONNECT:
573          log_level_string = "Connect";
574          break;
575       case LOG_LEVEL_LOG:
576          log_level_string = "Writing";
577          break;
578       case LOG_LEVEL_HEADER:
579          log_level_string = "Header";
580          break;
581       case LOG_LEVEL_INFO:
582          log_level_string = "Info";
583          break;
584       case LOG_LEVEL_RE_FILTER:
585          log_level_string = "Re-Filter";
586          break;
587 #ifdef FEATURE_FORCE_LOAD
588       case LOG_LEVEL_FORCE:
589          log_level_string = "Force";
590          break;
591 #endif /* def FEATURE_FORCE_LOAD */
592       case LOG_LEVEL_REDIRECTS:
593          log_level_string = "Redirect";
594          break;
595       case LOG_LEVEL_DEANIMATE:
596          log_level_string = "Gif-Deanimate";
597          break;
598       case LOG_LEVEL_CRUNCH:
599          log_level_string = "Crunch";
600          break;
601       case LOG_LEVEL_CGI:
602          log_level_string = "CGI";
603          break;
604       default:
605          log_level_string = "Unknown log level";
606          break;
607    }
608    assert(NULL != log_level_string);
609
610    return log_level_string;
611 }
612
613
614 /*********************************************************************
615  *
616  * Function    :  log_error
617  *
618  * Description :  This is the error-reporting and logging function.
619  *
620  * Parameters  :
621  *          1  :  loglevel  = the type of message to be logged
622  *          2  :  fmt       = the main string we want logged, printf-like
623  *          3  :  ...       = arguments to be inserted in fmt (printf-like).
624  *
625  * Returns     :  N/A
626  *
627  *********************************************************************/
628 void log_error(int loglevel, const char *fmt, ...)
629 {
630    va_list ap;
631    char *outbuf = NULL;
632    static char *outbuf_save = NULL;
633    char tempbuf[BUFFER_SIZE];
634    size_t length = 0;
635    const char * src = fmt;
636    long thread_id;
637    char timestamp[30];
638    /*
639     * XXX: Make this a config option,
640     * why else do we allocate instead of using
641     * an array?
642     */
643    size_t log_buffer_size = BUFFER_SIZE;
644
645 #if defined(_WIN32) && !defined(_WIN_CONSOLE)
646    /*
647     * Irrespective of debug setting, a GET/POST/CONNECT makes
648     * the taskbar icon animate.  (There is an option to disable
649     * this but checking that is handled inside LogShowActivity()).
650     */
651    if ((loglevel == LOG_LEVEL_GPC) || (loglevel == LOG_LEVEL_CRUNCH))
652    {
653       LogShowActivity();
654    }
655 #endif /* defined(_WIN32) && !defined(_WIN_CONSOLE) */
656
657    /*
658     * verify that the loglevel applies to current
659     * settings and that logging is enabled.
660     * Bail out otherwise.
661     */
662    if ((0 == (loglevel & debug))
663 #ifndef _WIN32
664       || (logfp == NULL)
665 #endif
666       )
667    {
668       if (loglevel == LOG_LEVEL_FATAL)
669       {
670          fatal_error("Fatal error. You're not supposed to"
671             "see this message. Please file a bug report.");
672       }
673       return;
674    }
675
676    thread_id = get_thread_id();
677    get_log_timestamp(timestamp, sizeof(timestamp));
678
679    /* protect the whole function because of the static buffer (outbuf) */
680    lock_logfile();
681
682    if (NULL == outbuf_save) 
683    {
684       outbuf_save = (char*)zalloc(log_buffer_size + 1); /* +1 for paranoia */
685       if (NULL == outbuf_save)
686       {
687          snprintf(tempbuf, sizeof(tempbuf),
688             "%s %08lx Fatal error: Out of memory in log_error().",
689             timestamp, thread_id);
690          fatal_error(tempbuf); /* Exit */
691          return;
692       }
693    }
694    outbuf = outbuf_save;
695
696    /*
697     * Memsetting the whole buffer to zero (in theory)
698     * makes things easier later on.
699     */
700    memset(outbuf, 0, log_buffer_size);
701
702    /* Add prefix for everything but Common Log Format messages */
703    if (loglevel != LOG_LEVEL_CLF)
704    {
705       length = (size_t)snprintf(outbuf, log_buffer_size, "%s %08lx %s: ",
706          timestamp, thread_id, get_log_level_string(loglevel));
707    }
708
709    /* get ready to scan var. args. */
710    va_start(ap, fmt);
711
712    /* build formatted message from fmt and var-args */
713    while ((*src) && (length < log_buffer_size-2))
714    {
715       const char *sval = NULL; /* %N string  */
716       int ival;                /* %N string length or an error code */
717       unsigned uval;           /* %u value */
718       long lval;               /* %l value */
719       unsigned long ulval;     /* %ul value */
720       char ch;
721       const char *format_string = tempbuf;
722
723       ch = *src++;
724       if (ch != '%')
725       {
726          outbuf[length++] = ch;
727          /*
728           * XXX: Only necessary on platforms where multiple threads
729           * can write to the buffer at the same time because we
730           * don't support mutexes (OS/2 for example).
731           */
732          outbuf[length] = '\0';
733          continue;
734       }
735       outbuf[length] = '\0';
736       ch = *src++;
737       switch (ch) {
738          case '%':
739             tempbuf[0] = '%';
740             tempbuf[1] = '\0';
741             break;
742          case 'd':
743             ival = va_arg( ap, int );
744             snprintf(tempbuf, sizeof(tempbuf), "%d", ival);
745             break;
746          case 'u':
747             uval = va_arg( ap, unsigned );
748             snprintf(tempbuf, sizeof(tempbuf), "%u", uval);
749             break;
750          case 'l':
751             /* this is a modifier that must be followed by u, lu, or d */
752             ch = *src++;
753             if (ch == 'd')
754             {
755                lval = va_arg( ap, long );
756                snprintf(tempbuf, sizeof(tempbuf), "%ld", lval);
757             }
758             else if (ch == 'u')
759             {
760                ulval = va_arg( ap, unsigned long );
761                snprintf(tempbuf, sizeof(tempbuf), "%lu", ulval);
762             }
763             else if ((ch == 'l') && (*src == 'u'))
764             {
765                unsigned long long lluval = va_arg(ap, unsigned long long);
766                snprintf(tempbuf, sizeof(tempbuf), "%llu", lluval);
767                src++;
768             }
769             else
770             {
771                snprintf(tempbuf, sizeof(tempbuf), "Bad format string: \"%s\"", fmt);
772                loglevel = LOG_LEVEL_FATAL;
773             }
774             break;
775          case 'c':
776             /*
777              * Note that char paramaters are converted to int, so we need to
778              * pass "int" to va_arg.  (See K&R, 2nd ed, section A7.3.2, page 202)
779              */
780             tempbuf[0] = (char) va_arg(ap, int);
781             tempbuf[1] = '\0';
782             break;
783          case 's':
784             format_string = va_arg(ap, char *);
785             if (format_string == NULL)
786             {
787                format_string = "[null]";
788             }
789             break;
790          case 'N':
791             /*
792              * Non-standard: Print a counted unterminated string,
793              * replacing unprintable bytes with their hex value.
794              * Takes 2 parameters: int length, const char * string.
795              */
796             ival = va_arg(ap, int);
797             sval = va_arg(ap, char *);
798             if (sval == NULL)
799             {
800                format_string = "[null]";
801             }
802             else if (ival <= 0)
803             {
804                if (0 == ival)
805                {
806                   /* That's ok (but stupid) */
807                   tempbuf[0] = '\0';
808                }
809                else
810                {
811                   /*
812                    * That's not ok (and even more stupid)
813                    */
814                   assert(ival >= 0);
815                   format_string = "[counted string lenght < 0]";
816                }
817             }
818             while ((ival-- > 0) && (length < log_buffer_size - 6))
819             {
820                if (isprint((int)*sval) && (*sval != '\\'))
821                {
822                   outbuf[length++] = *sval;
823                   outbuf[length] = '\0';
824                }
825                else
826                {
827                   snprintf(outbuf + length, log_buffer_size - length - 2,
828                      "\\x%.2x", (int)*sval);
829                   length += 4;
830                }
831                sval++;
832             }
833             /*
834              * XXX: In case of printable characters at the end of
835              *      the %N string, we're not using the whole buffer.
836              */
837             format_string = (length < log_buffer_size - 6) ? "" : "[too long]";
838             break;
839          case 'E':
840             /* Non-standard: Print error code from errno */
841 #ifdef _WIN32
842             ival = WSAGetLastError();
843             format_string = w32_socket_strerr(ival, tempbuf);
844 #elif __OS2__
845             ival = sock_errno();
846             if (ival != 0)
847             {
848                format_string = os2_socket_strerr(ival, tempbuf);
849             }
850             else
851             {
852                ival = errno;
853                format_string = strerror(ival);
854             }
855 #else /* ifndef _WIN32 */
856             ival = errno; 
857 #ifdef HAVE_STRERROR
858             format_string = strerror(ival);
859 #else /* ifndef HAVE_STRERROR */
860             format_string = NULL;
861 #endif /* ndef HAVE_STRERROR */
862             if (sval == NULL)
863             {
864                snprintf(tempbuf, sizeof(tempbuf), "(errno = %d)", ival);
865             }
866 #endif /* ndef _WIN32 */
867             break;
868          case 'T':
869             /* Non-standard: Print a Common Log File timestamp */
870             get_clf_timestamp(tempbuf, sizeof(tempbuf));
871             break;
872          default:
873             snprintf(tempbuf, sizeof(tempbuf), "Bad format string: \"%s\"", fmt);
874             loglevel = LOG_LEVEL_FATAL;
875             break;
876       }
877
878       assert(length < log_buffer_size);
879       length += strlcpy(outbuf + length, format_string, log_buffer_size - length);
880
881       if (length >= log_buffer_size-2)
882       {
883          static const char warning[] = "... [too long, truncated]";
884
885          length = log_buffer_size - sizeof(warning) - 1;
886          length += strlcpy(outbuf + length, warning, log_buffer_size - length);
887          assert(length < log_buffer_size);
888
889          break;
890       }
891    }
892
893    /* done with var. args */
894    va_end(ap);
895
896    assert(length < log_buffer_size);
897    length += strlcpy(outbuf + length, "\n", log_buffer_size - length);
898
899    /* Some sanity checks */
900    if ((length >= log_buffer_size)
901     || (outbuf[log_buffer_size-1] != '\0')
902     || (outbuf[log_buffer_size] != '\0')
903       )
904    {
905       /* Repeat as assertions */
906       assert(length < log_buffer_size);
907       assert(outbuf[log_buffer_size-1] == '\0');
908       /*
909        * outbuf's real size is log_buffer_size+1,
910        * so while this looks like an off-by-one,
911        * we're only checking our paranoia byte.
912        */
913       assert(outbuf[log_buffer_size] == '\0');
914
915       snprintf(outbuf, log_buffer_size,
916          "%s %08lx Fatal error: log_error()'s sanity checks failed."
917          "length: %d. Exiting.",
918          timestamp, thread_id, (int)length);
919       loglevel = LOG_LEVEL_FATAL;
920    }
921
922 #ifndef _WIN32
923    /*
924     * On Windows this is acceptable in case
925     * we are logging to the GUI window only.
926     */
927    assert(NULL != logfp);
928 #endif
929
930    if (loglevel == LOG_LEVEL_FATAL)
931    {
932       fatal_error(outbuf_save);
933       /* Never get here */
934    }
935    if (logfp != NULL)
936    {
937       fputs(outbuf_save, logfp);
938    }
939
940 #if defined(_WIN32) && !defined(_WIN_CONSOLE)
941    /* Write to display */
942    LogPutString(outbuf_save);
943 #endif /* defined(_WIN32) && !defined(_WIN_CONSOLE) */
944
945    unlock_logfile();
946
947 }
948
949
950 /*********************************************************************
951  *
952  * Function    :  jb_err_to_string
953  *
954  * Description :  Translates JB_ERR_FOO codes into strings.
955  *
956  *                XXX: the type of error codes is jb_err
957  *                but the typedef'inition is currently not
958  *                visible to all files that include errlog.h.
959  *
960  * Parameters  :
961  *          1  :  jb_error = a valid jb_err code
962  *
963  * Returns     :  A string with the jb_err translation
964  *
965  *********************************************************************/
966 const char *jb_err_to_string(int jb_error)
967 {
968    switch (jb_error)
969    {
970       case JB_ERR_OK:
971          return "Success, no error";
972       case JB_ERR_MEMORY:
973          return "Out of memory";
974       case JB_ERR_CGI_PARAMS:
975          return "Missing or corrupt CGI parameters";
976       case JB_ERR_FILE:
977          return "Error opening, reading or writing a file";
978       case JB_ERR_PARSE:
979          return "Parse error";
980       case JB_ERR_MODIFIED:
981          return "File has been modified outside of the CGI actions editor.";
982       case JB_ERR_COMPRESS:
983          return "(De)compression failure";
984       default:
985          assert(0);
986          return "Unknown error";
987    }
988    assert(0);
989    return "Internal error";
990 }
991
992 #ifdef _WIN32
993 /*********************************************************************
994  *
995  * Function    :  w32_socket_strerr
996  *
997  * Description :  Translate the return value from WSAGetLastError()
998  *                into a string.
999  *
1000  * Parameters  :
1001  *          1  :  errcode = The return value from WSAGetLastError().
1002  *          2  :  tmp_buf = A temporary buffer that might be used to
1003  *                          store the string.
1004  *
1005  * Returns     :  String representing the error code.  This may be
1006  *                a global string constant or a string stored in
1007  *                tmp_buf.
1008  *
1009  *********************************************************************/
1010 static char *w32_socket_strerr(int errcode, char *tmp_buf)
1011 {
1012 #define TEXT_FOR_ERROR(code,text) \
1013    if (errcode == code)           \
1014    {                              \
1015       return #code " - " text;    \
1016    }
1017
1018    TEXT_FOR_ERROR(WSAEACCES, "Permission denied")
1019    TEXT_FOR_ERROR(WSAEADDRINUSE, "Address already in use.")
1020    TEXT_FOR_ERROR(WSAEADDRNOTAVAIL, "Cannot assign requested address.");
1021    TEXT_FOR_ERROR(WSAEAFNOSUPPORT, "Address family not supported by protocol family.");
1022    TEXT_FOR_ERROR(WSAEALREADY, "Operation already in progress.");
1023    TEXT_FOR_ERROR(WSAECONNABORTED, "Software caused connection abort.");
1024    TEXT_FOR_ERROR(WSAECONNREFUSED, "Connection refused.");
1025    TEXT_FOR_ERROR(WSAECONNRESET, "Connection reset by peer.");
1026    TEXT_FOR_ERROR(WSAEDESTADDRREQ, "Destination address required.");
1027    TEXT_FOR_ERROR(WSAEFAULT, "Bad address.");
1028    TEXT_FOR_ERROR(WSAEHOSTDOWN, "Host is down.");
1029    TEXT_FOR_ERROR(WSAEHOSTUNREACH, "No route to host.");
1030    TEXT_FOR_ERROR(WSAEINPROGRESS, "Operation now in progress.");
1031    TEXT_FOR_ERROR(WSAEINTR, "Interrupted function call.");
1032    TEXT_FOR_ERROR(WSAEINVAL, "Invalid argument.");
1033    TEXT_FOR_ERROR(WSAEISCONN, "Socket is already connected.");
1034    TEXT_FOR_ERROR(WSAEMFILE, "Too many open sockets.");
1035    TEXT_FOR_ERROR(WSAEMSGSIZE, "Message too long.");
1036    TEXT_FOR_ERROR(WSAENETDOWN, "Network is down.");
1037    TEXT_FOR_ERROR(WSAENETRESET, "Network dropped connection on reset.");
1038    TEXT_FOR_ERROR(WSAENETUNREACH, "Network is unreachable.");
1039    TEXT_FOR_ERROR(WSAENOBUFS, "No buffer space available.");
1040    TEXT_FOR_ERROR(WSAENOPROTOOPT, "Bad protocol option.");
1041    TEXT_FOR_ERROR(WSAENOTCONN, "Socket is not connected.");
1042    TEXT_FOR_ERROR(WSAENOTSOCK, "Socket operation on non-socket.");
1043    TEXT_FOR_ERROR(WSAEOPNOTSUPP, "Operation not supported.");
1044    TEXT_FOR_ERROR(WSAEPFNOSUPPORT, "Protocol family not supported.");
1045    TEXT_FOR_ERROR(WSAEPROCLIM, "Too many processes.");
1046    TEXT_FOR_ERROR(WSAEPROTONOSUPPORT, "Protocol not supported.");
1047    TEXT_FOR_ERROR(WSAEPROTOTYPE, "Protocol wrong type for socket.");
1048    TEXT_FOR_ERROR(WSAESHUTDOWN, "Cannot send after socket shutdown.");
1049    TEXT_FOR_ERROR(WSAESOCKTNOSUPPORT, "Socket type not supported.");
1050    TEXT_FOR_ERROR(WSAETIMEDOUT, "Connection timed out.");
1051    TEXT_FOR_ERROR(WSAEWOULDBLOCK, "Resource temporarily unavailable.");
1052    TEXT_FOR_ERROR(WSAHOST_NOT_FOUND, "Host not found.");
1053    TEXT_FOR_ERROR(WSANOTINITIALISED, "Successful WSAStartup not yet performed.");
1054    TEXT_FOR_ERROR(WSANO_DATA, "Valid name, no data record of requested type.");
1055    TEXT_FOR_ERROR(WSANO_RECOVERY, "This is a non-recoverable error.");
1056    TEXT_FOR_ERROR(WSASYSNOTREADY, "Network subsystem is unavailable.");
1057    TEXT_FOR_ERROR(WSATRY_AGAIN, "Non-authoritative host not found.");
1058    TEXT_FOR_ERROR(WSAVERNOTSUPPORTED, "WINSOCK.DLL version out of range.");
1059    TEXT_FOR_ERROR(WSAEDISCON, "Graceful shutdown in progress.");
1060    /*
1061     * The following error codes are documented in the Microsoft WinSock
1062     * reference guide, but don't actually exist.
1063     *
1064     * TEXT_FOR_ERROR(WSA_INVALID_HANDLE, "Specified event object handle is invalid.");
1065     * TEXT_FOR_ERROR(WSA_INVALID_PARAMETER, "One or more parameters are invalid.");
1066     * TEXT_FOR_ERROR(WSAINVALIDPROCTABLE, "Invalid procedure table from service provider.");
1067     * TEXT_FOR_ERROR(WSAINVALIDPROVIDER, "Invalid service provider version number.");
1068     * TEXT_FOR_ERROR(WSA_IO_PENDING, "Overlapped operations will complete later.");
1069     * TEXT_FOR_ERROR(WSA_IO_INCOMPLETE, "Overlapped I/O event object not in signaled state.");
1070     * TEXT_FOR_ERROR(WSA_NOT_ENOUGH_MEMORY, "Insufficient memory available.");
1071     * TEXT_FOR_ERROR(WSAPROVIDERFAILEDINIT, "Unable to initialize a service provider.");
1072     * TEXT_FOR_ERROR(WSASYSCALLFAILURE, "System call failure.");
1073     * TEXT_FOR_ERROR(WSA_OPERATION_ABORTED, "Overlapped operation aborted.");
1074     */
1075
1076    sprintf(tmp_buf, "(error number %d)", errcode);
1077    return tmp_buf;
1078 }
1079 #endif /* def _WIN32 */
1080
1081
1082 #ifdef __OS2__
1083 /*********************************************************************
1084  *
1085  * Function    :  os2_socket_strerr
1086  *
1087  * Description :  Translate the return value from sock_errno()
1088  *                into a string.
1089  *
1090  * Parameters  :
1091  *          1  :  errcode = The return value from sock_errno().
1092  *          2  :  tmp_buf = A temporary buffer that might be used to
1093  *                          store the string.
1094  *
1095  * Returns     :  String representing the error code.  This may be
1096  *                a global string constant or a string stored in
1097  *                tmp_buf.
1098  *
1099  *********************************************************************/
1100 static char *os2_socket_strerr(int errcode, char *tmp_buf)
1101 {
1102 #define TEXT_FOR_ERROR(code,text) \
1103    if (errcode == code)           \
1104    {                              \
1105       return #code " - " text;    \
1106    }
1107
1108    TEXT_FOR_ERROR(SOCEPERM          , "Not owner.")
1109    TEXT_FOR_ERROR(SOCESRCH          , "No such process.")
1110    TEXT_FOR_ERROR(SOCEINTR          , "Interrupted system call.")
1111    TEXT_FOR_ERROR(SOCENXIO          , "No such device or address.")
1112    TEXT_FOR_ERROR(SOCEBADF          , "Bad file number.")
1113    TEXT_FOR_ERROR(SOCEACCES         , "Permission denied.")
1114    TEXT_FOR_ERROR(SOCEFAULT         , "Bad address.")
1115    TEXT_FOR_ERROR(SOCEINVAL         , "Invalid argument.")
1116    TEXT_FOR_ERROR(SOCEMFILE         , "Too many open files.")
1117    TEXT_FOR_ERROR(SOCEPIPE          , "Broken pipe.")
1118    TEXT_FOR_ERROR(SOCEWOULDBLOCK    , "Operation would block.")
1119    TEXT_FOR_ERROR(SOCEINPROGRESS    , "Operation now in progress.")
1120    TEXT_FOR_ERROR(SOCEALREADY       , "Operation already in progress.")
1121    TEXT_FOR_ERROR(SOCENOTSOCK       , "Socket operation on non-socket.")
1122    TEXT_FOR_ERROR(SOCEDESTADDRREQ   , "Destination address required.")
1123    TEXT_FOR_ERROR(SOCEMSGSIZE       , "Message too long.")
1124    TEXT_FOR_ERROR(SOCEPROTOTYPE     , "Protocol wrong type for socket.")
1125    TEXT_FOR_ERROR(SOCENOPROTOOPT    , "Protocol not available.")
1126    TEXT_FOR_ERROR(SOCEPROTONOSUPPORT, "Protocol not supported.")
1127    TEXT_FOR_ERROR(SOCESOCKTNOSUPPORT, "Socket type not supported.")
1128    TEXT_FOR_ERROR(SOCEOPNOTSUPP     , "Operation not supported.")
1129    TEXT_FOR_ERROR(SOCEPFNOSUPPORT   , "Protocol family not supported.")
1130    TEXT_FOR_ERROR(SOCEAFNOSUPPORT   , "Address family not supported by protocol family.")
1131    TEXT_FOR_ERROR(SOCEADDRINUSE     , "Address already in use.")
1132    TEXT_FOR_ERROR(SOCEADDRNOTAVAIL  , "Can't assign requested address.")
1133    TEXT_FOR_ERROR(SOCENETDOWN       , "Network is down.")
1134    TEXT_FOR_ERROR(SOCENETUNREACH    , "Network is unreachable.")
1135    TEXT_FOR_ERROR(SOCENETRESET      , "Network dropped connection on reset.")
1136    TEXT_FOR_ERROR(SOCECONNABORTED   , "Software caused connection abort.")
1137    TEXT_FOR_ERROR(SOCECONNRESET     , "Connection reset by peer.")
1138    TEXT_FOR_ERROR(SOCENOBUFS        , "No buffer space available.")
1139    TEXT_FOR_ERROR(SOCEISCONN        , "Socket is already connected.")
1140    TEXT_FOR_ERROR(SOCENOTCONN       , "Socket is not connected.")
1141    TEXT_FOR_ERROR(SOCESHUTDOWN      , "Can't send after socket shutdown.")
1142    TEXT_FOR_ERROR(SOCETOOMANYREFS   , "Too many references: can't splice.")
1143    TEXT_FOR_ERROR(SOCETIMEDOUT      , "Operation timed out.")
1144    TEXT_FOR_ERROR(SOCECONNREFUSED   , "Connection refused.")
1145    TEXT_FOR_ERROR(SOCELOOP          , "Too many levels of symbolic links.")
1146    TEXT_FOR_ERROR(SOCENAMETOOLONG   , "File name too long.")
1147    TEXT_FOR_ERROR(SOCEHOSTDOWN      , "Host is down.")
1148    TEXT_FOR_ERROR(SOCEHOSTUNREACH   , "No route to host.")
1149    TEXT_FOR_ERROR(SOCENOTEMPTY      , "Directory not empty.")
1150    TEXT_FOR_ERROR(SOCEOS2ERR        , "OS/2 Error.")
1151
1152    sprintf(tmp_buf, "(error number %d)", errcode);
1153    return tmp_buf;
1154 }
1155 #endif /* def __OS2__ */
1156
1157
1158 /*
1159   Local Variables:
1160   tab-width: 3
1161   end:
1162 */