LINEBOTで謎のエラー

※初投稿なので見にくいかもしれませんが、お願いします。
足りない情報などありましたら、すぐにお知らせください。

前提・実現したいこと

LINE Messaging API で送信されたメッセージをオウム返しするBOTをheroku + Pythonで作ろうとしています。
ネットから情報をかき集め、なんとかBOTを建てれたのはいいですが、logを確認してみると数個
エラーが出ています。
ソースコードに問題があるのか、Herokuの環境設定などに問題があるのかわかりません。
また、LINEをPC版で登録したので動作確認も今のところできない状況です。
どうすればいいのか、ご教授をお願いします。

発生している問題・エラーメッセージ

2019-09-21T07:56:37.698118+00:00 app[web.1]: Traceback (most recent call last):
2019-09-21T07:56:37.698121+00:00 app[web.1]: File "/app/.heroku/python/lib/python3.7/site-packages/flask/app.py", line 2446, in wsgi_app
2019-09-21T07:56:37.698123+00:00 app[web.1]: response = self.full_dispatch_request()
2019-09-21T07:56:37.698126+00:00 app[web.1]: File "/app/.heroku/python/lib/python3.7/site-packages/flask/app.py", line 1951, in full_dispatch_request
2019-09-21T07:56:37.698128+00:00 app[web.1]: rv = self.handle_user_exception(e)
2019-09-21T07:56:37.698130+00:00 app[web.1]: File "/app/.heroku/python/lib/python3.7/site-packages/flask/app.py", line 1820, in handle_user_exception
2019-09-21T07:56:37.698132+00:00 app[web.1]: reraise(exc_type, exc_value, tb)
2019-09-21T07:56:37.698135+00:00 app[web.1]: File "/app/.heroku/python/lib/python3.7/site-packages/flask/_compat.py", line 39, in reraise
2019-09-21T07:56:37.698137+00:00 app[web.1]: raise value
2019-09-21T07:56:37.698139+00:00 app[web.1]: File "/app/.heroku/python/lib/python3.7/site-packages/flask/app.py", line 1949, in full_dispatch_request
2019-09-21T07:56:37.698141+00:00 app[web.1]: rv = self.dispatch_request()
2019-09-21T07:56:37.698144+00:00 app[web.1]: File "/app/.heroku/python/lib/python3.7/site-packages/flask/app.py", line 1935, in dispatch_request
2019-09-21T07:56:37.698146+00:00 app[web.1]: return self.view_functions[rule.endpoint](**req.view_args)
2019-09-21T07:56:37.698149+00:00 app[web.1]: File "LINEbot.py", line 34, in callback
2019-09-21T07:56:37.698151+00:00 app[web.1]: handler.handle(body, signature)
2019-09-21T07:56:37.698153+00:00 app[web.1]: File "/app/.heroku/python/lib/python3.7/site-packages/linebot/webhook.py", line 260, in handle
2019-09-21T07:56:37.698155+00:00 app[web.1]: func(event)
2019-09-21T07:56:37.698157+00:00 app[web.1]: File "LINEbot.py", line 45, in handle_message
2019-09-21T07:56:37.698159+00:00 app[web.1]: TextSendMessage(text=event.message.text))
2019-09-21T07:56:37.698162+00:00 app[web.1]: File "/app/.heroku/python/lib/python3.7/site-packages/linebot/api.py", line 102, in reply_message
2019-09-21T07:56:37.698164+00:00 app[web.1]: '/v2/bot/message/reply', data=json.dumps(data), timeout=timeout
2019-09-21T07:56:37.698166+00:00 app[web.1]: File "/app/.heroku/python/lib/python3.7/site-packages/linebot/api.py", line 961, in _post
2019-09-21T07:56:37.698168+00:00 app[web.1]: self.__check_error(response)
2019-09-21T07:56:37.698170+00:00 app[web.1]: File "/app/.heroku/python/lib/python3.7/site-packages/linebot/api.py", line 984, in __check_error
2019-09-21T07:56:37.698173+00:00 app[web.1]: raise LineBotApiError(response.status_code, error)
2019-09-21T07:56:37.698175+00:00 app[web.1]: linebot.exceptions.LineBotApiError: LineBotApiError: status_code=400, error_response={"details": [], "message": "Invalid reply token"}
2019-09-21T07:56:37.699231+00:00 app[web.1]: 10.138.162.166 - - [21/Sep/2019 07:56:37] "POST /callback HTTP/1.1" 500 -

2019-09-21T07:56:44.307326+00:00 app[web.1]: [2019-09-21 07:56:44,306] ERROR in app: Exception on /callback [POST]
2019-09-21T07:56:44.307340+00:00 app[web.1]: Traceback (most recent call last):
2019-09-21T07:56:44.307343+00:00 app[web.1]: File "/app/.heroku/python/lib/python3.7/site-packages/flask/app.py", line 2446, in wsgi_app
2019-09-21T07:56:44.307345+00:00 app[web.1]: response = self.full_dispatch_request()
2019-09-21T07:56:44.307347+00:00 app[web.1]: File "/app/.heroku/python/lib/python3.7/site-packages/flask/app.py", line 1951, in full_dispatch_request
2019-09-21T07:56:44.307349+00:00 app[web.1]: rv = self.handle_user_exception(e)
2019-09-21T07:56:44.307351+00:00 app[web.1]: File "/app/.heroku/python/lib/python3.7/site-packages/flask/app.py", line 1820, in handle_user_exception
2019-09-21T07:56:44.307357+00:00 app[web.1]: reraise(exc_type, exc_value, tb)
2019-09-21T07:56:44.307359+00:00 app[web.1]: File "/app/.heroku/python/lib/python3.7/site-packages/flask/_compat.py", line 39, in reraise
2019-09-21T07:56:44.307361+00:00 app[web.1]: raise value
2019-09-21T07:56:44.307363+00:00 app[web.1]: File "/app/.heroku/python/lib/python3.7/site-packages/flask/app.py", line 1949, in full_dispatch_request
2019-09-21T07:56:44.307365+00:00 app[web.1]: rv = self.dispatch_request()
2019-09-21T07:56:44.307367+00:00 app[web.1]: File "/app/.heroku/python/lib/python3.7/site-packages/flask/app.py", line 1935, in dispatch_request
2019-09-21T07:56:44.307369+00:00 app[web.1]: return self.view_functions[rule.endpoint](**req.view_args)
2019-09-21T07:56:44.307372+00:00 app[web.1]: File "LINEbot.py", line 34, in callback
2019-09-21T07:56:44.307374+00:00 app[web.1]: handler.handle(body, signature)
2019-09-21T07:56:44.307375+00:00 app[web.1]: File "/app/.heroku/python/lib/python3.7/site-packages/linebot/webhook.py", line 260, in handle
2019-09-21T07:56:44.307378+00:00 app[web.1]: func(event)
2019-09-21T07:56:44.307380+00:00 app[web.1]: File "LINEbot.py", line 45, in handle_message
2019-09-21T07:56:44.307382+00:00 app[web.1]: TextSendMessage(text=event.message.text))
2019-09-21T07:56:44.307384+00:00 app[web.1]: File "/app/.heroku/python/lib/python3.7/site-packages/linebot/api.py", line 102, in reply_message
2019-09-21T07:56:44.307386+00:00 app[web.1]: '/v2/bot/message/reply', data=json.dumps(data), timeout=timeout
2019-09-21T07:56:44.307389+00:00 app[web.1]: File "/app/.heroku/python/lib/python3.7/site-packages/linebot/api.py", line 961, in _post
2019-09-21T07:56:44.307391+00:00 app[web.1]: self.__check_error(response)
2019-09-21T07:56:44.307393+00:00 app[web.1]: File "/app/.heroku/python/lib/python3.7/site-packages/linebot/api.py", line 984, in __check_error
2019-09-21T07:56:44.307395+00:00 app[web.1]: raise LineBotApiError(response.status_code, error)
2019-09-21T07:56:44.307397+00:00 app[web.1]: linebot.exceptions.LineBotApiError: LineBotApiError: status_code=400, error_response={"details": [], "message": "Invalid reply token"}

2019-09-21T08:09:00.638323+00:00 app[web.1]: 10.13.136.43 - - [21/Sep/2019 08:09:00] "GET / HTTP/1.1" 404 -
2019-09-21T08:09:00.639562+00:00 heroku[router]: at=info method=GET path="/" host=dslineboo.herokuapp.com request_id=741fbbe9-0b8f-4dd2-9b47-0026ea12972c fwd="118.111.148.31" dyno=web.1 connect=1ms service=6ms status=404 bytes=379 protocol=https

どこを切り取ればいいかわからないのでめぼしいところを適当に切り取りました...すいません...
主に
・ステータスコード400,404,500
・LINEApiエラー
を吐いているようです。

該当のソースコード

LINEbot.py

python
1from flask import Flask, request, abort
2
3from linebot import (
4    LineBotApi, WebhookHandler
5)
6from linebot.exceptions import (
7    InvalidSignatureError
8)
9from linebot.models import (
10    MessageEvent, TextMessage, TextSendMessage,
11)
12import os
13
14app = Flask(__name__)
15
16#環境変数取得
17YOUR_CHANNEL_ACCESS_TOKEN = os.environ["YOUR_CHANNEL_ACCESS_TOKEN"]
18YOUR_CHANNEL_SECRET = os.environ["YOUR_CHANNEL_SECRET"]
19
20line_bot_api = LineBotApi(YOUR_CHANNEL_ACCESS_TOKEN)
21handler = WebhookHandler(YOUR_CHANNEL_SECRET)
22
23@app.route("/callback", methods=['POST'])
24def callback():
25    # get X-Line-Signature header value
26    signature = request.headers['X-Line-Signature']
27
28    # get request body as text
29    body = request.get_data(as_text=True)
30    app.logger.info("Request body: " + body)
31
32    # handle webhook body
33    try:
34        handler.handle(body, signature)
35    except InvalidSignatureError:
36        abort(400)
37
38    return 'OK'
39
40
41@handler.add(MessageEvent, message=TextMessage)
42def handle_message(event):
43    line_bot_api.reply_message(
44        event.reply_token,
45        TextSendMessage(text=event.message.text))
46
47
48if __name__ == "__main__":
49#    app.run()
50    port = int(os.getenv("PORT", 5000))
51    app.run(host="0.0.0.0", port=port)

requiments.txt

Flask==1.1.1
line-bot-sdk==1.14.0

runtime.txt

python-3.7.4

Procfile

web: python LINEbot.py

試したこと

heroku restartやheroku ps:scale web=1など
結果：変わりなし

補足情報（FW/ツールのバージョンなど）

Python本体やライブラリなどのバージョンはrequiments.txt, runtime.txtの通りです。

追記

・LINE DevelopersのWebhookの「接続確認」ボタンを押すと、「無効なステータスコードが返されました」と出ます。

行動規範の内容に同意します

回答2件

ベストアンサー

Flask は、正常終了で200を返しているようですね。すみません見当違いでした。

エラーメッセージは、二つに分かれていますが、どちらがどのログでしょうか？
API 自体（callbackメソッド）が正常に完了しているのかが気になります。

投稿2019/09/22 07:33

shaw

総合スコア209

daima3629

2019/09/22 07:47 編集

2019-09-21T07:56:37.701468+00:00 heroku[router]: at=info method=POST path="/callback" host=dslineboo.herokuapp.com request_id=2e75c062-fe9f-4397-808a-41035f71705a fwd="203.104.156.76" dyno=web.1 connect=1ms service=553ms status=500 bytes=449 protocol=https こちらが上のほうのエラーコードの一行上についていたもので 2019-09-21T07:56:44.310115+00:00 heroku[router]: at=info method=POST path="/callback" host=dslineboo.herokuapp.com request_id=797c8391-1cf4-4d9d-9b6a-f29cdc206ab6 fwd="203.104.156.76" dyno=web.1 connect=0ms service=568ms status=500 bytes=449 protocol=https こちらが下の方のエラーコードの一行上についていたものになります。すいません、これで合ってますかね...?

daima3629

2019/09/22 07:49

どちらもLINE DevelopersのWebhookの接続確認ボタンを押したときのもののようです

daima3629

2019/09/22 07:54

今内容のほうにも編集を入れましたが、もう一個めぼしきエラーがありました。これはheroku openでページを確認した時のものです。かく乱させてしまってすいません...

shaw

2019/09/22 08:01 編集

なるほど、status が 500 となっていると言うことはプログラムにエラーがおきているようです。 webhook がそもそも通るかを確認するために、下記のようにしてプログラムエラーを無くして確認してみてください。 ```python @app.route("/callback", methods=['POST']) def callback(): # get X-Line-Signature header value #signature = request.headers['X-Line-Signature'] # get request body as text #body = request.get_data(as_text=True) #app.logger.info("Request body: " + body) # handle webhook body #try: # handler.handle(body, signature) #except InvalidSignatureError: # abort(400) return 'OK' ```

daima3629

2019/09/22 08:04

分かりました。すぐやってみます

daima3629

2019/09/22 08:09

ステータス200でました！

daima3629

2019/09/22 08:09

てことはやはりコメントアウトした部分にあるんですかね？

shaw

2019/09/22 08:15

webhook 自体も正常に「接続完了」になりましたか？？ 2019-09-21T07:56:37.698175+00:00 app[web.1]: linebot.exceptions.LineBotApiError: LineBotApiError: status_code=400, error_response={"details": [], "message": "Invalid reply token"} 上記から reply_tokoen に誤りがあるようなのでトークンを確認してもらう必要があると思います。

daima3629

2019/09/22 08:21

Webhookも200を返してます。トークンとは何のトークンですか？CHANNEL_ACCESS_TOKENですか？

shaw

2019/09/22 08:22

webhook の確認ではただの疎通確認でしかなく reply token が取得できなく、実際に LINEのトーク画面から実行したらうまく行くかもしれませんね。

shaw

2019/09/22 08:23

reply token なので、LINE からリクエストされる（送られて）ものです。

shaw

2019/09/22 08:24

一度 webhook に登録してしまえばおそらく heroku 側でプログラム変えても大丈夫なはずですので、トーク画面から試した方がよいと思います！

daima3629

2019/09/22 08:29

実はPC版からLINEを登録したので、スマホ版LINEで年齢認証をしないとBOTを友達追加できないんですよね...で今スマホやタブレットを持ってないんですよね...LINEの友達に手伝ってもらって何とかしてみます！

daima3629

2019/09/22 08:29

あ、 https://qiita.com/mochan_tk/items/db3fd4e4867dd3fb6540#%E8%BF%BD%E8%A8%98 こちらを見るとLINE Deveropersのボタンから送られるGETではInvalid reply tokenが表示されても大丈夫なようです。

daima3629

2019/09/22 08:30

ということはこれでトーク画面から実行してちゃんと返ってきたら問題ないってことですかね？

shaw

2019/09/22 08:33

諸々現在確認できる状況にないこと承知しました。 > webhook の確認ではただの疎通確認でしかなく reply token が取得できなく、実際に LINEのトーク画面から実行したらうまく行くかもしれませんね。やはり wenhook の疎通確認では reply token は連携されないようですね。トークからであれば　reply token が送信されるはずですのでうまく行くことを祈ってます！

daima3629

2019/09/22 08:36

ありがとうございます！初投稿で話がかく乱しましたが、そんな僕にも丁寧に対応していただきありがとうございました！

shaw

2019/09/22 08:39

いえいえ、こちらも勉強になる部分がありました！！ベストアンサーありがとうございます！！

行動規範の内容に同意します