X-Git-Url: https://git.distorted.org.uk/u/mdw/putty/blobdiff_plain/3896fb22181b4b0edcf95814435b5f899198758f..aca589d972c5c12706d57322e89f9dec2b2a3a00:/logging.c diff --git a/logging.c b/logging.c index 67b24560..f1c42cde 100644 --- a/logging.c +++ b/logging.c @@ -10,11 +10,12 @@ /* log session to file stuff ... */ struct LogContext { FILE *lgfp; - char currlogfilename[FILENAME_MAX]; + Filename currlogfilename; void *frontend; + Config cfg; }; -static void xlatlognam(char *d, char *s, char *hostname, struct tm *tm); +static void xlatlognam(Filename *d, Filename s, char *hostname, struct tm *tm); /* * Log session traffic. @@ -22,8 +23,8 @@ static void xlatlognam(char *d, char *s, char *hostname, struct tm *tm); void logtraffic(void *handle, unsigned char c, int logmode) { struct LogContext *ctx = (struct LogContext *)handle; - if (cfg.logtype > 0) { - if (cfg.logtype == logmode) { + if (ctx->cfg.logtype > 0) { + if (ctx->cfg.logtype == logmode) { /* deferred open file from pgm start? */ if (!ctx->lgfp) logfopen(ctx); @@ -34,49 +35,131 @@ void logtraffic(void *handle, unsigned char c, int logmode) } /* - * Log an Event Log entry (used in SSH packet logging mode). + * Flush any open log file. */ -void log_eventlog(void *handle, char *event) +void logflush(void *handle) { + struct LogContext *ctx = (struct LogContext *)handle; + if (ctx->cfg.logtype > 0) + if (ctx->lgfp) + fflush(ctx->lgfp); +} + +/* + * Log an Event Log entry. Used in SSH packet logging mode; this is + * also as convenient a place as any to put the output of Event Log + * entries to stderr when a command-line tool is in verbose mode. + * (In particular, this is a better place to put it than in the + * front ends, because it only has to be done once for all + * platforms. Platforms which don't have a meaningful stderr can + * just avoid defining FLAG_STDERR. + */ +void log_eventlog(void *handle, const char *event) { struct LogContext *ctx = (struct LogContext *)handle; - if (cfg.logtype != LGTYP_PACKETS) + if ((flags & FLAG_STDERR) && (flags & FLAG_VERBOSE)) { + fprintf(stderr, "%s\n", event); + fflush(stderr); + } + if (ctx->cfg.logtype != LGTYP_PACKETS) return; if (!ctx->lgfp) logfopen(ctx); if (ctx->lgfp) - fprintf(ctx->lgfp, "Event Log: %s\n", event); + fprintf(ctx->lgfp, "Event Log: %s\r\n", event); } /* * Log an SSH packet. + * If n_blanks != 0, blank or omit some parts. + * Set of blanking areas must be in increasing order. */ void log_packet(void *handle, int direction, int type, - char *texttype, void *data, int len) + char *texttype, void *data, int len, + int n_blanks, const struct logblank_t *blanks) { struct LogContext *ctx = (struct LogContext *)handle; - int i, j; char dumpdata[80], smalldata[5]; - if (cfg.logtype != LGTYP_PACKETS) + if (ctx->cfg.logtype != LGTYP_PACKETS) return; if (!ctx->lgfp) logfopen(ctx); if (ctx->lgfp) { - fprintf(ctx->lgfp, "%s packet type %d / 0x%02x (%s)\n", + int p = 0, b = 0, omitted = 0; + int output_pos = 0; /* NZ if pending output in dumpdata */ + + /* Packet header. */ + fprintf(ctx->lgfp, "%s packet type %d / 0x%02x (%s)\r\n", direction == PKT_INCOMING ? "Incoming" : "Outgoing", type, type, texttype); - for (i = 0; i < len; i += 16) { - sprintf(dumpdata, " %08x%*s\n", i, 1+3*16+2+16, ""); - for (j = 0; j < 16 && i+j < len; j++) { - int c = ((unsigned char *)data)[i+j]; - sprintf(smalldata, "%02x", c); - dumpdata[10+2+3*j] = smalldata[0]; - dumpdata[10+2+3*j+1] = smalldata[1]; - dumpdata[10+1+3*16+2+j] = (isprint(c) ? c : '.'); + + /* + * Output a hex/ASCII dump of the packet body, blanking/omitting + * parts as specified. + */ + while (p < len) { + int blktype; + + /* Move to a current entry in the blanking array. */ + while ((b < n_blanks) && + (p >= blanks[b].offset + blanks[b].len)) + b++; + /* Work out what type of blanking to apply to + * this byte. */ + blktype = PKTLOG_EMIT; /* default */ + if ((b < n_blanks) && + (p >= blanks[b].offset) && + (p < blanks[b].offset + blanks[b].len)) + blktype = blanks[b].type; + + /* If we're about to stop omitting, it's time to say how + * much we omitted. */ + if ((blktype != PKTLOG_OMIT) && omitted) { + fprintf(ctx->lgfp, " (%d byte%s omitted)\r\n", + omitted, (omitted==1?"":"s")); + omitted = 0; + } + + /* (Re-)initialise dumpdata as necessary + * (start of row, or if we've just stopped omitting) */ + if (!output_pos && !omitted) + sprintf(dumpdata, " %08x%*s\r\n", p-(p%16), 1+3*16+2+16, ""); + + /* Deal with the current byte. */ + if (blktype == PKTLOG_OMIT) { + omitted++; + } else { + int c; + if (blktype == PKTLOG_BLANK) { + c = 'X'; + sprintf(smalldata, "XX"); + } else { /* PKTLOG_EMIT */ + c = ((unsigned char *)data)[p]; + sprintf(smalldata, "%02x", c); + } + dumpdata[10+2+3*(p%16)] = smalldata[0]; + dumpdata[10+2+3*(p%16)+1] = smalldata[1]; + dumpdata[10+1+3*16+2+(p%16)] = (isprint(c) ? c : '.'); + output_pos = (p%16) + 1; } - strcpy(dumpdata + 10+1+3*16+2+j, "\n"); - fputs(dumpdata, ctx->lgfp); + + p++; + + /* Flush row if necessary */ + if (((p % 16) == 0) || (p == len) || omitted) { + if (output_pos) { + strcpy(dumpdata + 10+1+3*16+2+output_pos, "\r\n"); + fputs(dumpdata, ctx->lgfp); + output_pos = 0; + } + } + } + + /* Tidy up */ + if (omitted) + fprintf(ctx->lgfp, " (%d byte%s omitted)\r\n", + omitted, (omitted==1?"":"s")); fflush(ctx->lgfp); } } @@ -86,7 +169,6 @@ void logfopen(void *handle) { struct LogContext *ctx = (struct LogContext *)handle; char buf[256]; - time_t t; struct tm tm; char writemod[4]; @@ -94,45 +176,47 @@ void logfopen(void *handle) if (ctx->lgfp) return; - if (!cfg.logtype) + if (!ctx->cfg.logtype) return; - sprintf(writemod, "w"); /* default to rewrite */ + sprintf(writemod, "wb"); /* default to rewrite */ - time(&t); - tm = *localtime(&t); + tm = ltime(); /* substitute special codes in file name */ - xlatlognam(ctx->currlogfilename, cfg.logfilename,cfg.host, &tm); + xlatlognam(&ctx->currlogfilename, ctx->cfg.logfilename,ctx->cfg.host, &tm); - ctx->lgfp = fopen(ctx->currlogfilename, "r"); /* file already present? */ + ctx->lgfp = f_open(ctx->currlogfilename, "r"); /* file already present? */ if (ctx->lgfp) { int i; fclose(ctx->lgfp); - i = askappend(ctx->frontend, ctx->currlogfilename); + if (ctx->cfg.logxfovr != LGXF_ASK) { + i = ((ctx->cfg.logxfovr == LGXF_OVR) ? 2 : 1); + } else + i = askappend(ctx->frontend, ctx->currlogfilename); if (i == 1) writemod[0] = 'a'; /* set append mode */ else if (i == 0) { /* cancelled */ ctx->lgfp = NULL; - cfg.logtype = 0; /* disable logging */ + ctx->cfg.logtype = 0; /* disable logging */ return; } } - ctx->lgfp = fopen(ctx->currlogfilename, writemod); + ctx->lgfp = f_open(ctx->currlogfilename, writemod); if (ctx->lgfp) { /* enter into event log */ /* --- write header line into log file */ fputs("=~=~=~=~=~=~=~=~=~=~=~= PuTTY log ", ctx->lgfp); strftime(buf, 24, "%Y.%m.%d %H:%M:%S", &tm); fputs(buf, ctx->lgfp); - fputs(" =~=~=~=~=~=~=~=~=~=~=~=\n", ctx->lgfp); + fputs(" =~=~=~=~=~=~=~=~=~=~=~=\r\n", ctx->lgfp); sprintf(buf, "%s session log (%s mode) to file: ", (writemod[0] == 'a') ? "Appending" : "Writing new", - (cfg.logtype == LGTYP_ASCII ? "ASCII" : - cfg.logtype == LGTYP_DEBUG ? "raw" : - cfg.logtype == LGTYP_PACKETS ? "SSH packets" : "")); + (ctx->cfg.logtype == LGTYP_ASCII ? "ASCII" : + ctx->cfg.logtype == LGTYP_DEBUG ? "raw" : + ctx->cfg.logtype == LGTYP_PACKETS ? "SSH packets" : "")); /* Make sure we do not exceed the output buffer size */ - strncat(buf, ctx->currlogfilename, 128); + strncat(buf, filename_to_str(&ctx->currlogfilename), 128); buf[strlen(buf)] = '\0'; logevent(ctx->frontend, buf); } @@ -147,24 +231,60 @@ void logfclose(void *handle) } } -void *log_init(void *frontend) +void *log_init(void *frontend, Config *cfg) { - struct LogContext *ctx = smalloc(sizeof(struct LogContext)); + struct LogContext *ctx = snew(struct LogContext); ctx->lgfp = NULL; ctx->frontend = frontend; + ctx->cfg = *cfg; /* STRUCTURE COPY */ return ctx; } +void log_free(void *handle) +{ + struct LogContext *ctx = (struct LogContext *)handle; + + logfclose(ctx); + sfree(ctx); +} + +void log_reconfig(void *handle, Config *cfg) +{ + struct LogContext *ctx = (struct LogContext *)handle; + int reset_logging; + + if (!filename_equal(ctx->cfg.logfilename, cfg->logfilename) || + ctx->cfg.logtype != cfg->logtype) + reset_logging = TRUE; + else + reset_logging = FALSE; + + if (reset_logging) + logfclose(ctx); + + ctx->cfg = *cfg; /* STRUCTURE COPY */ + + if (reset_logging) + logfopen(ctx); +} + /* * translate format codes into time/date strings * and insert them into log file name * * "&Y":YYYY "&m":MM "&d":DD "&T":hhmm "&h": "&&":& */ -static void xlatlognam(char *d, char *s, char *hostname, struct tm *tm) { +static void xlatlognam(Filename *dest, Filename src, + char *hostname, struct tm *tm) { char buf[10], *bufp; int size; - int len = FILENAME_MAX-1; + char buffer[FILENAME_MAX]; + int len = sizeof(buffer)-1; + char *d; + const char *s; + + d = buffer; + s = filename_to_str(&src); while (*s) { /* Let (bufp, len) be the string to append. */ @@ -207,4 +327,6 @@ static void xlatlognam(char *d, char *s, char *hostname, struct tm *tm) { len -= size; } *d = '\0'; + + *dest = filename_from_str(buffer); }