關(guān)于 Lumen 無輸出 HTTP 狀態(tài)碼為 500 的詭異錯誤

dayday_up 發(fā)布于2019-07-01 12:23 / 1064人閱讀

摘要：關(guān)于無輸出錯誤最近接入支付寶支付時遇到一個問題，在做支付回調(diào)函數(shù)的時候我先是寫了一個用來記錄回調(diào)時的支付寶請求參數(shù)，但發(fā)現(xiàn)無論如何日志都沒有任何記錄，而且回調(diào)函數(shù)里面的東西也沒用執(zhí)行，于是我自己請求該回調(diào)地址，發(fā)現(xiàn)服務(wù)器上狀態(tài)碼為但是沒有

關(guān)于LUMEN無輸出500錯誤

最近接入支付寶支付時遇到一個問題，在做支付回調(diào)函數(shù)的時候我先是寫了一個 Log::info("alipay_notify_info",$request->all()) 用來記錄回調(diào)時的支付寶請求參數(shù)，但發(fā)現(xiàn)無論如何日志都沒有任何記錄，而且回調(diào)函數(shù)里面的東西也沒用執(zhí)行，于是我自己請求該回調(diào)地址，發(fā)現(xiàn)服務(wù)器上 HTTP 狀態(tài)碼為 500 但是沒有任何報錯信息和輸出，日志也沒有記錄，于是乎在本地再測試了一下，本地輸出正常，無報錯信息，日志也記錄了 HTTP 請求信息，繼續(xù)調(diào)試 N 次后無果。

我猜想是不是日志出了問題，于是注釋掉日志記錄，正常輸出，這就奇怪了，Lumen 自帶的日志記錄怎么可能有問題？也不是第一次用了，我也從來沒有改過框架內(nèi)的代碼，并且日志直到現(xiàn)在還記錄了今天的隊列異常信息，怎么可能有問題呢？而且本地也沒問題，就服務(wù)器有問題，代碼兩端都是保持完全一致的，那原因在哪？我回想這個類文件里還引用了其他包，會不會是其他包里重名的 Log 類，于是又把 Log 重命名，照樣不行，無輸出無日志記錄，當時已經(jīng)下班了，比較餓，看了一下想了想把自己一兩個月沒關(guān)的電腦關(guān)了，心想明早再來開機重新試試。

第二天，上班，開機，啟動服務(wù)，打開端口，開IDE開調(diào)試工具開各種亂七八糟的東西后再調(diào)試寫的支付寶回調(diào)接口，臥槽，好了？正常輸出，正常記錄日志，正常寫入支付信息更新賬單等業(yè)務(wù)操作，一切沒問題，我心想還真是萬能的重啟試試，于是再讓同事測試了一下支付寶支付，OK，沒問題，這問題也就撂下不管了。

過了大概七天左右，七天內(nèi)也斷斷續(xù)續(xù)測了幾次支付寶支付，沒有出現(xiàn)過問題，然而在一天早上，前端同事說他支付了賬單但狀態(tài)沒變，于是我開始看，數(shù)據(jù)庫里狀態(tài)未支付，看日志，沒有請求信息，我想難道支付寶出了問題？沒給我發(fā)回調(diào)？我又查看了我的 GIT 提交記錄和本地歷史，自從寫好之后支付寶這塊從來沒動過，然后又 DEBUG ，無果，心想上次重啟了好了，這次再試試，一邊重啟一邊想著如果真重啟就好那這就詭異了，我就只重啟了本地電腦，服務(wù)器動都沒動，如果這都能好這問題就更難排查了。

開機滿懷期待測試接口， GG, 還是不行，那這問題就有意思了，看來和我的電腦肯定無關(guān)。問題出在服務(wù)器上，而且
php 錯誤日志由于一些原因服務(wù)器上也沒用開啟，無法查看日志。會不會是硬盤滿了寫不進去？查看硬盤占用 used 17%，離滿還早得很。沒有寫入權(quán)限？也不可能，日志都寫入那么久了，天天都有寫入，直到幾分鐘前還記錄了消息隊列里的警告信息。那這種偶發(fā)性的問題關(guān)鍵就是要找到觸發(fā) BUG 的條件，于是我開始找日志里寫入的信息，這次 BUG 和上次 BUG 出現(xiàn)時日志都寫入了隊列里輸出的信息，而且第二天就好了，我的日志記錄都是 daliy 每天記錄一次，那會不會是這種可能？為了驗證猜想，我直接把 logs 目錄執(zhí)行了一次 chmod -R 777 , Ok, 沒問題。

那么原因就很簡單了：沒有日志寫入權(quán)限。

那為什么隊列任務(wù)的信息能寫入到日志呢？為什么平時都能寫入到日志呢？因為我的隊列任務(wù)是以 root 權(quán)限執(zhí)行的任務(wù)，而隊列任務(wù)作為當天第一次寫入日志時在創(chuàng)建的時候就會創(chuàng)建一個 655 權(quán)限的日志文件，而普通的執(zhí)行文件都是由 nginx 用戶來執(zhí)行，自然沒有權(quán)限對日志文件進行寫操作，隨即引發(fā)問題，導致錯誤。

這次問題雖然最后發(fā)現(xiàn)了原因了之后很好解決，但開始出現(xiàn)時確實讓人摸不著頭腦，又沒有任何錯誤信息無法準確 DEBUG 感覺身體被掏空，今天寫出來給自己加深印象，也希望給看到的朋友提供下思路，遇到類似問題不用再浪費時間。