log4js-node/test/tap/dateFileAppender-test.js

'use strict';

const test = require('tap').test;
const path = require('path');
const fs = require('fs');
const sandbox = require('sandboxed-module');
const log4js = require('../../lib/log4js');
const EOL = require('os').EOL || '\n';

function removeFile(filename) {
  try {
    fs.unlinkSync(path.join(__dirname, filename));
  } catch (e) {
    // doesn't matter
  }
}

test('../../lib/appenders/dateFile', (batch) => {
  batch.test('adding multiple dateFileAppenders', (t) => {
    const listenersCount = process.listeners('exit').length;

    log4js.configure({
      appenders: {
        date0: { type: 'dateFile', filename: 'datefa-default-test0.log' },
        date1: { type: 'dateFile', filename: 'datefa-default-test1.log' },
        date2: { type: 'dateFile', filename: 'datefa-default-test2.log' },
        date3: { type: 'dateFile', filename: 'datefa-default-test3.log' },
        date4: { type: 'dateFile', filename: 'datefa-default-test4.log' }
      },
      categories: { default: { appenders: ['date0', 'date1', 'date2', 'date3', 'date4'], level: 'debug' } }
    });

    t.teardown(() => {
      removeFile('datefa-default-test0.log');
      removeFile('datefa-default-test1.log');
      removeFile('datefa-default-test2.log');
      removeFile('datefa-default-test3.log');
      removeFile('datefa-default-test4.log');
    });

    t.equal(process.listeners('exit').length, listenersCount + 1, 'should only add one exit listener');
    t.end();
  });

  batch.test('exit listener', (t) => {
    let exitListener;
    const openedFiles = [];

    const dateFileAppender = sandbox.require(
      '../../lib/appenders/dateFile',
      {
        globals: {
          process: {
            on: function (evt, listener) {
              exitListener = listener;
            }
          }
        },
        requires: {
          streamroller: {
            DateRollingFileStream: function (filename) {
              openedFiles.push(filename);

              this.end = function () {
                openedFiles.shift();
              };

              this.write = function () {
                return true;
              };
            }
          }
        }
      }
    );

    for (let i = 0; i < 5; i += 1) {
      dateFileAppender.configure({ filename: `test${i}` }, { basicLayout: function () {} });
    }
    t.equal(openedFiles.length, 5);
    exitListener();
    t.equal(openedFiles.length, 0, 'should close all opened files');
    t.end();
  });

  batch.test('with default settings', (t) => {
    const testFile = path.join(__dirname, 'date-appender-default.log');
    log4js.configure({
      appenders: { date: { type: 'dateFile', filename: testFile } },
      categories: { default: { appenders: ['date'], level: 'DEBUG' } }
    });

    const logger = log4js.getLogger('default-settings');

    logger.info('This should be in the file.');
    t.teardown(() => { removeFile('date-appender-default.log'); });

    setTimeout(() => {
      fs.readFile(testFile, 'utf8', (err, contents) => {
        t.include(contents, 'This should be in the file');
        t.match(
          contents,
          /\[\d{4}-\d{2}-\d{2}\s\d{2}:\d{2}:\d{2}\.\d{3}] \[INFO] default-settings - /
        );
        t.end();
      });
    }, 100);
  });

  batch.test('configure with dateFileAppender', (t) => {
    log4js.configure({
      appenders: {
        date: {
          type: 'dateFile',
          filename: 'test/tap/date-file-test.log',
          pattern: '-from-MM-dd',
          layout: { type: 'messagePassThrough' }
        }
      },
      categories: { default: { appenders: ['date'], level: 'WARN' } }
    });
    const logger = log4js.getLogger('tests');
    logger.info('this should not be written to the file');
    logger.warn('this should be written to the file');

    t.teardown(() => { removeFile('date-file-test.log'); });

    fs.readFile(path.join(__dirname, 'date-file-test.log'), 'utf8', (err, contents) => {
      t.include(contents, `this should be written to the file${EOL}`);
      t.equal(contents.indexOf('this should not be written to the file'), -1);
      t.end();
    });
  });

  batch.test('configure with options.alwaysIncludePattern', (t) => {
    const format = require('date-format');

    const options = {
      appenders: {
        date: {
          category: 'tests',
          type: 'dateFile',
          filename: 'test/tap/date-file-test',
          pattern: '-from-MM-dd.log',
          alwaysIncludePattern: true,
          layout: {
            type: 'messagePassThrough'
          }
        }
      },
      categories: { default: { appenders: ['date'], level: 'debug' } }
    };

    const thisTime = format.asString(options.appenders.date.pattern, new Date());
    fs.writeFileSync(
      path.join(__dirname, `date-file-test${thisTime}`),
      `this is existing data${EOL}`,
      'utf8'
    );
    log4js.configure(options);
    const logger = log4js.getLogger('tests');
    logger.warn('this should be written to the file with the appended date');

    t.teardown(() => { removeFile(`date-file-test${thisTime}`); });

    // wait for filesystem to catch up
    setTimeout(() => {
      fs.readFile(path.join(__dirname, `date-file-test${thisTime}`), 'utf8', (err, contents) => {
        t.include(contents, 'this should be written to the file with the appended date');
        t.include(contents, 'this is existing data', 'should not overwrite the file on open (issue #132)');
        t.end();
      });
    }, 100);
  });

  batch.end();
});