java的Exception方法printStackTrace()不打印日志？

小鱼儿 2022-10-16 09:43 181阅读 0赞

#### 背景 ####

*  记录java的Sytem.out与System.err区别
 *  e.printStackTrace()与Sytem.err的关系
 *  在生产环境在捕获到异常的时候调用e.printStackTrace()，然后又立即调用log.info()打印日志，可能会出现什么问题？是顺序输出日志的吗？
 *  e.printStackTrace()一定会打印日志吗？

#### 过程 ####

*  **现象**

1.  测试代码

public class JsonTest { 
        public static void main(String[] args) { 
    
            for (int i = 0; i < 20 ; i++) { 
                try{ 
                    parseJson();
                }catch (Exception e){ 
                    System.out.println("Loop:"+(i+1));
                    e.printStackTrace();
                }
            }
        }
    
        public static Message parseJson() { 
            String aa = "{\"rspCode\":\"0000\",\"rspDesc\":\"操作成功\",\"uuid\":\"ec6865ca-7a1d-41ad-a9f2-23b792417f1\",\"body\":\"{\\\"id\\\":\\\"17610522126516\\\",\\\"preNumber\\\":\\\"1760032825\\\",\\\"shortUrl\\\":\\\"https://uc.g.cn/AkxXrTi9\\\"}\"}";
            Message jsonObject = JSON.parseObject(aa, Message.class);
            return jsonObject;
        }
    }

1.  测试结果  
    ![在这里插入图片描述][watermark_type_ZmFuZ3poZW5naGVpdGk_shadow_10_text_aHR0cHM6Ly9ibG9nLmNzZG4ubmV0L291dHNhbmRpbmc_size_16_color_FFFFFF_t_70]
2.  结果分析：按照我们的思路是打印循环标识Loop：index然后打印堆栈，但是实际测试结果并不是按照顺序输出的。

*  **Sytem.out与System.err区别？ 是不同的流**  
    ![在这里插入图片描述][watermark_type_ZmFuZ3poZW5naGVpdGk_shadow_10_text_aHR0cHM6Ly9ibG9nLmNzZG4ubmV0L291dHNhbmRpbmc_size_16_color_FFFFFF_t_70 1]
 *  **e.printStackTrace() 打印的时候加锁了吗？** 加锁了的  
    ![在这里插入图片描述][watermark_type_ZmFuZ3poZW5naGVpdGk_shadow_10_text_aHR0cHM6Ly9ibG9nLmNzZG4ubmV0L291dHNhbmRpbmc_size_16_color_FFFFFF_t_70 2]
 *  e.printStackTrace()用的是什么？System.err  
    ![在这里插入图片描述][watermark_type_ZmFuZ3poZW5naGVpdGk_shadow_10_text_aHR0cHM6Ly9ibG9nLmNzZG4ubmV0L291dHNhbmRpbmc_size_16_color_FFFFFF_t_70 3]
 *  实现e.printStackTrace(）和System.out顺序输出内容

1.  代码

public class JsonTest { 
        public static void main(String[] args) { 
    
            for (int i = 0; i < 20 ; i++) { 
                try{ 
                    parseJson();
                }catch (Exception e){ 
                    System.out.println("Loop:"+(i+1));
                    e.printStackTrace(System.out);
                }
            }
        }
    
        public static Message parseJson() { 
            String aa = "{\"rspCode\":\"0000\",\"rspDesc\":\"操作成功\",\"uuid\":\"ec6865ca-7a1d-41ad-a9f2-23b792417f1\",\"body\":\"{\\\"id\\\":\\\"17610522126516\\\",\\\"preNumber\\\":\\\"1760032825\\\",\\\"shortUrl\\\":\\\"https://uc.g.cn/AkxXrTi9\\\"}\"}";
            Message jsonObject = JSON.parseObject(aa, Message.class);
            return jsonObject;
        }
    }

*  测试结果：完全按照顺序进行输出。  
    ![在这里插入图片描述][watermark_type_ZmFuZ3poZW5naGVpdGk_shadow_10_text_aHR0cHM6Ly9ibG9nLmNzZG4ubmV0L291dHNhbmRpbmc_size_16_color_FFFFFF_t_70 4]
 *  在生产环境在捕获到异常的时候调用e.printStackTrace()，然后又立即调用log.info()打印日志，可能会出现什么问题？
    
    堆栈信息和日志内容，**很大一部分可能是不会顺序输出的**。
 *  **e.printStackTrace()一定会打印日志吗？**
    
    不一定。jvm进行了优化，如果出现非常频繁打印同一个堆栈信息的情况，后续将不会再打印堆栈信息了。

#### 小结 ####

*  System.err和System.out是不同的流
 *  System.err和System.out在打印的时候都加锁了的。但是加的都是自己本身类型的锁（一个是err类型，另一个是out类型）。
 *  想要顺序输出e.printStackTrace()和System.out的内容，则需要修改如下：e.printStackTrace(System.out)即可，这样就是加的是同一把锁了。
 *  **注意事项**

1.  生产环境如果出现e.printStackTrace和log.info()的情况，日志很大一部分可能是不会顺序输出的。
2.  如果是定时任务中出现异常，导致频繁执行e.printStackTrace()方法的话，jvm做了优化，刚开始将打印堆栈信息，后续就不再打印堆栈信息了，因此需要去日志文件的开始处找堆栈信息，然后定位问题。

[watermark_type_ZmFuZ3poZW5naGVpdGk_shadow_10_text_aHR0cHM6Ly9ibG9nLmNzZG4ubmV0L291dHNhbmRpbmc_size_16_color_FFFFFF_t_70]: /images/20221014/2f659e19327d4a1dbf5c3fe409a0a22b.png
[watermark_type_ZmFuZ3poZW5naGVpdGk_shadow_10_text_aHR0cHM6Ly9ibG9nLmNzZG4ubmV0L291dHNhbmRpbmc_size_16_color_FFFFFF_t_70 1]: /images/20221014/8212d10524df4495aa05dcbf7ca32ab0.png
[watermark_type_ZmFuZ3poZW5naGVpdGk_shadow_10_text_aHR0cHM6Ly9ibG9nLmNzZG4ubmV0L291dHNhbmRpbmc_size_16_color_FFFFFF_t_70 2]: /images/20221014/76a9386d6ee44a4d9f7a2fb942d82c52.png
[watermark_type_ZmFuZ3poZW5naGVpdGk_shadow_10_text_aHR0cHM6Ly9ibG9nLmNzZG4ubmV0L291dHNhbmRpbmc_size_16_color_FFFFFF_t_70 3]: /images/20221014/b1a4e76896e94ab2a408b0dcc6f1e3ea.png
[watermark_type_ZmFuZ3poZW5naGVpdGk_shadow_10_text_aHR0cHM6Ly9ibG9nLmNzZG4ubmV0L291dHNhbmRpbmc_size_16_color_FFFFFF_t_70 4]: /images/20221014/5cf748a6d296406e8a10790aae5b8e9a.png