node js 處理時間分析

標籤：http   io   資料   問題   時間   伺服器   c   js   

結論： pm2日誌中請求時間包含串連建立時間到處理結束時間。

今天遇到一個詭異的問題。同樣的一個nodejs程式部署在兩個環境中， 一個環境的pm2列印的伺服器回應時間是幾個毫秒，另外一個環境的Pm2列印的伺服器回應時間是幾十/幾百甚至幾千毫秒不等。兩個環境的部署伺服器配置一致，軟體環境一致，唯一不同是A環境採用的是nginx做反向 Proxy，B環境採用的是青雲的負載平衡器做反向 Proxy。

最後定位到兩個日誌中回應時間不同的原因是，nginx作為反向 Proxy是會把HTTP請求全部收完之後再發送，而青雲的負載平衡是不斷的發送請求包到服務。

青雲的負載平衡代理的伺服器的日誌如下：

23:27:05.892857 IP 10.80.32.99.43129 > 192.168.10.5.3012: Flags [S], seq 3297605978, win 14600, op

23:27:05.977404 IP 192.168.10.5.3012 > 10.80.32.99.43129: Flags [.], ack 19498, win 326, options

23:27:05.991372 IP 192.168.10.5.3012 > 10.80.32.99.43129: Flags [P.], seq 26:208, ack 19498, win 32

這是抓包的時間，總共花了99ms。

892 - 977是接收資料， 一共花了85ms, 977 - 991是處理資料，花了14ms