Console 模块解读及简单实现

Console 模块提供了简单的调试功能，这在一些测试调试中有时也是使用最方便、用的最多的，它和浏览器中的 console 类似，但是在浏览器中它是同步的，在 Node.js 中，就有个疑问了是同步还是异步？

本文主要参考了官方源码，实现了一个简单版的 Console 模块，介绍了一些基本使用，同时提出了一些常见的问题，供大家学习参考，具体看以下正文介绍。

快速导航

Logger 模块实现

实现步骤

  1. 初始化 Logger 对象
  2. 对参数进行检验，当前对象是否为 Logger 实例，是否为一个可写流实例
  3. 为 Logger 对象定义 _stdout，_stderr 等属性
  4. 将原型方法上的属性绑定到 Logger 实例上
  5. 实现 log、error、warning、trace、clear 等方法

创建logger文件

  1. const util = require('util');
  3. /**
  4.  * 初始化Logger对象
  5.  * @param {*} stdout
  6.  * @param {*} stderr 
  7.  */
  8. function Logger(stdout, stderr){
  9.     // step1 检查当前对象是否为Logger实例
  10.     if(!(this instanceof Logger)){
  11.         return new Logger(stdout, stderr);
  12.     }
  14.     //检查是否是一个可写流实例
  15.     if(!stdout || !(stdout.write instanceof Function)){
  16.         throw new Error('Logger expects a writable stream instance');
  17.     }
  19.     // 如果stderr未指定，使用stdout
  20.     if(!stderr){
  21.         stderr = stdout;
  22.     }
  24.     //设置js Object的属性
  25.     let props = {
  26.         writable: true, // 对象属性是否可修改,flase为不可修改，默认值为true
  27.         enumerable: false, // 对象属性是否可通过for-in循环，flase为不可循环，默认值为true
  28.         configurable: false, // 能否使用delete、能否需改属性特性、或能否修改访问器属性、，false为不可重新定义，默认值为true
  29.     }
  31.     // Logger对象定义_stdout属性
  32.     Object.defineProperty(this, '_stdout', Object.assign(props, {
  33.         value: stdout,
  34.     }));
  36.     // Logger对象定义_stderr属性
  37.     Object.defineProperty(this, '_stderr', Object.assign(props, {
  38.         value: stderr,
  39.     }));
  41.     // Logger对象定义_times属性
  42.     Object.defineProperty(this, '_times', Object.assign(props, {
  43.         value: new Map(),
  44.     }));
  46.     // 将原型方法上的属性绑定到Logger实例上
  47.     const keys = Object.keys(Logger.prototype);
  49.     for(let k in keys){
  50.         this[keys[k]] = this[keys[k]].bind(this);
  51.     }
  52. }
  54. //定义原型Logger的log方法
  55. Logger.prototype.log = function(){
  56.     this._stdout.write(util.format.apply(this, arguments) + '\n');
  57. }
  59. Logger.prototype.info = Logger.prototype.log;
  61. // 定义原型Logger的warn方法
  62. Logger.prototype.warn = function(){
  63.     this._stderr.write(util.format.apply(this, arguments) + `\n`);
  64. }
  66. Logger.prototype.error = Logger.prototype.warn;
  68. // 返回当前调用堆栈信息
  69. Logger.prototype.trace = function trace(...args){
  70.     const err = {
  71.         name: 'Trace',
  72.         message: util.format.apply(null, args)
  73.     }
  75.     // 源自V8引擎的Stack Trace API https://github.com/v8/v8/wiki/Stack-Trace-API
  76.     Error.captureStackTrace(err, trace);
  78.     this.error(err.stack);
  79. }
  81. // 清除控制台信息
  82. Logger.prototype.clear = function(){
  84.     // 如果stdout输出是一个控制台，进行clear 否则不进行处理
  85.     if(this._stdout.isTTY){
  86.         const { cursorTo, clearScreenDown } = require('readline');
  87.         cursorTo(this._stdout, 0, 0); // 移动光标到给定的 TTY stream 中指定的位置。
  88.         clearScreenDown(this._stdout); // 方法会从光标的当前位置向下清除给定的 TTY 流
  89.     }
  90. }
  92. //直接输出某个对象
  93. Logger.prototype.dir = function(object, options){
  94.     options = Object.assign({ customInspect: false }, options);
  96.     /**
  97.      * util.inspect(object,[showHidden],[depth],[colors])是一个将任意对象转换为字符串的方法，通常用于调试和错误的输出。
  98.      * showhidden - 是一个可选参数，如果值为true，将会输出更多隐藏信息。
  99.      * depth - 表示最大递归的层数。如果对象很复杂，可以指定层数控制输出信息的多少。
  100.      * 如果不指定depth,默认会递归3层，指定为null表示不限递归层数完整遍历对象。
  101.      * 如果color = true，输出格式将会以ansi颜色编码，通常用于在终端显示更漂亮的效果。
  102.      */
  103.     this._stdout.write(util.inspect(object, options) + '\n');
  104. }
  106. // 计时器开始时间
  107. Logger.prototype.time = function(label){
  109.     // process.hrtime()方法返回当前时间以[seconds, nanoseconds] tuple Array表示的高精度解析值， nanoseconds是当前时间无法使用秒的精度表示的剩余部分。
  110.     this._times.set(label, process.hrtime())
  111. }
  113. // 计时器结束时间
  114. Logger.prototype.timeEnd = function(label){
  115.     const time = this._times.get(label);
  117.     if (!time) {
  118.         process.emitWarning(`No such label '${label}' for console.timeEnd()`);
  119.         return;
  120.     }
  122.     const duration = process.hrtime(time);
  123.     const ms = duration[0] * 1000 + duration[1] / 1e6; // 1e6 = 1000000.0 1e6表示1*10^6
  124.     this.log('%s: %sms', label, ms.toFixed(3));
  125.     this._times.delete(label);
  126. }
  128. module.exports = new Logger(process.stdout, process.stderr);
  130. module.exports.Logger = Logger;

Logger 模块基本使用

日志输出至终端

无特殊说明，日志都是默认打印到控制台，在一些代码调试中也是用的最多的。

  1. const logger = reuqire('logger');
  3. logger.log('hello world') // 普通日志打印
  4. logger.info('hello world') // 等同于logger.log
  5. logger.error('hello world') // 错误日志打印
  6. logger.warn('hello world') // 等同于logger.error
  7. logger.clear() // 清除控制台信息

日志输出至文件

定义要输出的日志文件，实例化我们自定义的 Logger 对象

  1. const fs = require('fs');
  2. const output = fs.createWriteStream('./stdout.txt');
  3. const errorOutput = fs.createWriteStream('./stderr.txt');
  4. const { Logger } = require('./logger');
  6. const logger = Logger(output, errorOutput);
  8. logger.info('hello world!'); // 内容输出到 stdout.txt 文件
  9. logger.error('错误日志记录'); // 内容输出到 stderr.txt 文件

版本问题

将日志信息打印到本地指定文件，这里要注意版本问题，以下代码示例在 nodev10.x 以下版本可以，nodev10.x 及以上的版本这块有改动，可能会报错如下，具体原因参见 https://github.com/nodejs/node/issues/21366

  1. TypeError: Console expects a writable stream instance
  2.     at new Console (console.js:35:11)
  3.     at Object.<anonymous> (/Users/ryzokuken/Code/temp/node/console/21366.js:11:16)
  4.     at Module._compile (module.js:652:30)
  5.     at Object.Module._extensions..js (module.js:663:10)
  6.     at Module.load (module.js:565:32)
  7.     at tryModuleLoad (module.js:505:12)
  8.     at Function.Module._load (module.js:497:3)
  9.     at Function.Module.runMain (module.js:693:10)
  10.     at startup (bootstrap_node.js:188:16)
  11.     at bootstrap_node.js:609:3

trace打印错误堆栈

  1. logger.trace('测试错误');
  1. Trace: 测试错误
  2.     at Object.<anonymous> (/Users/qufei/Documents/mycode/Summarize/test/console-test.js:7:8)
  3.     at Module._compile (module.js:624:30)
  4.     at Object.Module._extensions..js (module.js:635:10)
  5.     at Module.load (module.js:545:32)
  6.     at tryModuleLoad (module.js:508:12)
  7.     at Function.Module._load (module.js:500:3)
  8.     at Function.Module.runMain (module.js:665:10)
  9.     at startup (bootstrap_node.js:201:16)
  10.     at bootstrap_node.js:626:3

dir显示一个对象的所有属性和方法

depth - 表示最大递归的层数。如果对象很复杂，可以指定层数控制输出信息的多少。

  1. const family = {
  2.     name: 'Jack',
  3.     brother: {
  4.         hobby: ['篮球', '足球']
  5.     }
  6. }
  8. logger.dir(family, {depth: 3});
  10. // { name: 'Jack', brother: { hobby: [ '篮球', '足球' ] } }

计算程序执行消耗时间

logger.time 和 logger.timeEnd 用来测量一个 javascript 脚本程序执行消耗的时间，单位是毫秒

  1. // 启动计时器
  2. logger.time('计时器');
  4. // 中间写一些测试代码
  5. for(let i=0; i < 1000000000; i++){}
  7. // 停止计时器
  8. logger.timeEnd('计时器');
  10. // 计时器: 718.034ms

Interview1

console 是同步的还是异步的?

console 既不是总是同步的，也不总是异步的。是否为同步取决于链接的是什么流以及操作系统是 Windows 还是 POSIX:

注意: 同步写将会阻塞事件循环直到写完成。 有时可能一瞬间就能写到一个文件，但当系统处于高负载时，管道的接收端可能不会被读取、缓慢的终端或文件系统，因为事件循环被阻塞的足够频繁且足够长的时间，这些可能会给系统性能带来消极的影响。当你向一个交互终端会话写时这可能不是个问题，但当生产日志到进程的输出流时要特别留心。

  • 文件(Files): Windows 和 POSIX 平台下都是同步

  • 终端(TTYs): 在 Windows 平台下同步，在 POSIX 平台下异步

  • 管道(Pipes): 在 Windows 平台下同步，在 POSIX 平台下异步

Interview2

如何实现一个 console.log?

实现 console.log 在控制台打印，利用 process.stdout 将输入流数据输出到输出流(即输出到终端)，一个简单的例子输出 hello world

  1. process.stdout.write('hello world!' + '\n');

Interview3

为什么 console.log() 执行完后就退出?

这个问题第一次看到是来自于朴灵大神的一次演讲，涉及到 EventLoop 的执行机制，一旦产生事件循环，就会产生一个 While(true) 的死循环，例如定时器 setInterval，但是 console.log 它没有产生 watch、handlers 在事件循环中执行了一次就退出了。同时另一个疑问开启一个 http server 为什么进程没有退出？参考下文章 Node.js 为什么进程没有 exit？。

Reference