временные метки исчезают при добавлении конфигурации номера строки в node.js winston для ведения журнала

Я использую winston для создания самописца, который позволяет мне добавлять метки времени и номер строки в ведение журнала. Каждый из кодов может выполнять свои функции, но в сочетании они работают не так, как ожидалось.

// **help to add timestamp**
var logger = new (winston.Logger)({
  transports : [new (winston.transports.Console)({
    json : false,
    timestamp : true,
    colorize: true
  }), new winston.transports.File({
    filename : __dirname + '/debug.log',
    json : true
  })]
  ,exitOnError : false
});

// **help me to add line number**
var logger_info_old = winston.info;
logger.info = function(msg) {
    var fileAndLine = traceCaller(1);
    return logger_info_old.call(this, fileAndLine + ":" + msg);
}

Однако при добавлении конфигурации номера строки отметка времени для регистрации исчезнет.

Например, перед добавлением конфигурации номера строки.

logger.info("abc");
2013-11-24T09:49:15.914Z - info:339:abc

при добавлении конфигурации номера строки

logger.info("abc");
info: (H:\Dropbox\node\fablab\utils\logging.js:85:abc

Оптимальный результат, который я хочу, похож на

logger.info("abc");
2013-11-24T09:49:15.914Z - info: (H:\Dropbox\node\fablab\app.js:339:abc

Могу ли я исправить это?


node.js logging winston
person user824624    schedule 24.11.2013    source источник

Ответы (2)


arrow_upward
3
arrow_downward

Я заставил это работать, и вот как я это сделал.

var transports = [
  new(winston.transports.Console)({
    colorize: true,
    prettyPrint: true,
    timestamp : true,
    level: 'debug',
  })
];

var log = new(winston.Logger)({
  "transports": transports
});

for (var func in winston.levels) {
  var oldFunc = log[func];

  log[func] = function() {
    var args = Array.prototype.slice.call(arguments);
    args.unshift(traceCaller(1));
    oldFunc.apply(log, args);
  }
}

При этом я получил и метку времени, и файл. (обратите внимание, что traceCaller (1) взят из этого вопроса о стеке: Я хочу отобразить имя файла в операторе журнала). Я выполнил цикл for над winston.levels, чтобы получить все функции, а не только информацию.

Причина, по которой у вас не сработало, заключалась в том, что ваш logger_info_old был от winston, а не от logger. Так

var logger_info_old = winston.info;

должны были быть

var logger_info_old = logger.info;
person Jeff Whiting    schedule 06.12.2013
comment
Только что сделал бенчмарк. Имейте в виду, что добавление трассировки стека происходит намного медленнее. При обработке 10 000 журналов время увеличилось с 71 мс без файла и номера строки до 4666 мс. Это в 65 раз медленнее. traceCaller может быть неэффективным, но я предполагаю, что большая часть времени фактически уходит на создание трассировки стека: (новая ошибка).stack - person Jeff Whiting; 06.12.2013
comment
согласен, traceCaller неэффективен, но он будет использоваться для отладки, так что ничего страшного. Большое спасибо, Джефф - person user824624; 07.12.2013
comment
Должно быть замыкание для захвата oldFunc, иначе все функции журнала будут заменены на последнюю (error() в настройках по умолчанию). Кроме того, почему вы используете winston.levels вместо logger.levels? - person leesei; 12.09.2014

arrow_upward
3
arrow_downward

Я обновил ответ @jeff-whiting (используйте закрытие и исправление для интерполяции строк) и сделал его одной функцией.
Передайте существующий регистратор, чтобы добавить информацию о месте вызова в его функции уровня.
Примечание logger.log() не изменено, только logger.{level}() изменены.

// add callsite info to winston logger instance
function addCallSite(logger) {
  // WARNING: traceCaller is slow
  // http://stackoverflow.com/a/20431861/665507
  // http://stackoverflow.com/a/13411499/665507
  /**
  * examines the call stack and returns a string indicating
  * the file and line number of the n'th previous ancestor call.
  * this works in chrome, and should work in nodejs as well.
  *
  * @param n : int (default: n=1) - the number of calls to trace up the
  *   stack from the current call.  `n=0` gives you your current file/line.
  *  `n=1` gives the file/line that called you.
  */
  function traceCaller(n) {
    if( isNaN(n) || n<0) n=1;
    n+=1;
    var s = (new Error()).stack
      , a=s.indexOf('\n',5);
    while(n--) {
      a=s.indexOf('\n',a+1);
      if( a<0 ) { a=s.lastIndexOf('\n',s.length); break;}
    }
    b=s.indexOf('\n',a+1); if( b<0 ) b=s.length;
    a=Math.max(s.lastIndexOf(' ',b), s.lastIndexOf('/',b));
    b=s.lastIndexOf(':',b);
    s=s.substring(a+1,b);
    return s;
  }

  // assign to `logger.{level}()`
  for (var func in logger.levels) {
    (function (oldFunc) {
      logger[func] = function() {
        var args = Array.prototype.slice.call(arguments);
        if (typeof args[0] === 'string') {
          args[0] = traceCaller(1) + ' ' + args[0];
        }
        else {
          args.unshift(traceCaller(1));
        }
        oldFunc.apply(logger, args);
      };
    })(logger[func]);
  };
}
person leesei    schedule 12.09.2014