CANDY Pi Lite+ でのSoftBankへの接続時の設定について

y-Hiroishi · February 9, 2021, 1:52am

CANDY Pi Lite＋を使用してSoftBankの４G回線に接続しようとしています。

ソフトウェア的には、ディスクイメージの13.1をダウンロードした後、Githubのシェルをデフォルトで設定した後、設定済みのSoftbankAPNを利用して設定（m2m4biz.softbank)をapn.txtに設定してリブートしました。

リブート後は、つながらなかったので、WEBを調べたあと、SoftbankのAPNは、"plus.4g"であるようなので、このエントリーを、apn-list.jsonに追加し、設定的には、うまくいっていると思われますが、PPP接続が失敗しています。
(ppp0 でmodem hangup のログが残され、start_pppd.sh がエラー番号16で終了する）

どのように設定すると、いいか、ご教示いただけないでしょうか？
よろしくお願いします。

dbaba · February 9, 2021, 4:52am

ご質問ありがとうございます。

ログの情報がありませんので原因はわかりませんが、

とのことでAPNの追加は直接apn-list.jsonを変更されたとのことですが、このapn-list.jsonファイルはちょっとした文字列の間違いで接続ができなくなります。apn-list.jsonを元に戻してから以下のページにある正しい手順で、apn.txtファイルへAPNの情報（APN、ユーザー、パスワード）を指定していただけますか。

github.com

CANDY-LINE/candy-pi-lite-info/blob/master/configuration/apn.md#apnの簡易追加

<!-- toc -->

# APN設定

CANDY Pi Liteの携帯電話ネットワークへの接続先(APN)は、インストール時に指定することができます。この宛先は、インストール後に変更することが可能です。異なるMVNOのSIMカードを変更したときには、APNの変更も行うようにしましょう。

[`candy-pi-lite-service v1.7.0`](https://forums.candy-line.io/t/v1-7-0/63)からAPNの指定方法が簡単になりました。以前のバージョンをご利用の場合は、本章の後半をご覧ください。

## APNの指定

**👉[`candy-pi-lite-service v6.2.0`](https://forums.candy-line.io/t/candy-pi-lite-v6-2-0/238)以降で対応しています**

APNを指定するには、パソコンなどでマイクロSDカードの`/boot`ディレクトリーに`apn`または`apn.txt`という名前のファイルを作成します。ファイルの中身は、APNの名称または設定名を指定します。初期状態では、[プリセットされたAPNの一覧](apn-list.md)に記載された名称を利用可能です。


例えば、IIJモバイル／タイプIのSIMをご利用の場合は、メモ帳やテキストエディターなどで`iijmobile.biz-ipv6`とだけ入力し保存します。

> ### <👉補足説明>
>
> 上記の例では、`apn`（または`apn.txt`）ファイルの値に`iijmobile.biz-ipv6`を設定すると記載しています。本来IIJモバイル／タイプIの標準的なAPN名は`iijmobile.biz`ですが、同じAPNでも異なる設定で接続できるようにするため、別名を設定名としてつけることが可能です。このため、`iijmobile.biz-ipv6`を`/boot/apn`（または`/boot/apn.txt`）ファイルに指定しても、その値がAPN名となることはありません。

This file has been truncated. show original

APN指定時によくある問題は、一度WordなどにAPNの情報を書いてからその内容をコピペしたときに発生します。ダブルクォーテーションなどの文字列がWordによって置き換わったり、全角スペースなどが意図せず紛れたりするためです。APN情報を編集される場合は、メモ帳などテキストエディターをご利用ください。

なお、元のape-list.jsonファイルがすでにない場合は、アンインストールをして再度インストールしていただくか、こちらからダウンロードして中身を変更せずそのまま元の場所のape-list.jsonファイルを上書きしてご利用ください。

また、上記方法でうまく動かない場合は、apn.txtに指定した内容と、/var/log/syslogのエラーと思われる部分を投稿していただければと思います。

y-Hiroishi · February 9, 2021, 5:52am

apn.txt には、 plus.4g を入れ、
apn-list.json に
,“plus.4g”:{“user”:“plus”,“password”:“4g”,“nw”:“lte”}
を追加しています。
それぞれのファイルは、nanoで編集しています。

ログを添付します

Feb  9 14:33:58 raspberrypi candy-pi-lite: [INFO] USB Serial Ports are found => /dev/QWS.EC25.MODEM, /dev/QWS.EC25.AT

Feb 9 14:33:58 raspberrypi candy-pi-lite: [INFO] New USB serial ports are detected
Feb 9 14:33:58 raspberrypi candy-pi-lite: [INFO] Looking for a Modem Serial port at Barudrate: 115200…
Feb 9 14:33:58 raspberrypi candy-pi-lite: [INFO] Result: /dev/QWS.EC25.MODEM
Feb 9 14:33:58 raspberrypi candy-pi-lite: [INFO] Modem Serial port: /dev/QWS.EC25.MODEM and AT Serial port: /dev/QWS.EC25.AT are selected
Feb 9 14:33:58 raspberrypi candy-pi-lite: [INFO] Initialization Done. Modem Serial Port => /dev/QWS.EC25.MODEM
Feb 9 14:33:59 raspberrypi candy-pi-lite: server_main.candy_command: candy_command() : modem:init => {“status”: “OK”, “result”: {“counter_reset”: “N/A”, “baudrate”: “N/A”}}
Feb 9 14:34:00 raspberrypi candy-pi-lite: server_main.candy_command: candy_command() : modem:show => {“status”: “OK”, “result”: {“manufacturer”: “Quectel”, “model”: “EC25”, “revision”: “EC25JFAR06A05M4G”, “imei”: “865036041045277”, “datetime”: “21/02/09,05:34:00”, “timezone”: 9.0, “functionality”: “Full”, “counter”: {“tx”: “0”, “rx”: “0”}}}
Feb 9 14:34:00 raspberrypi candy-pi-lite: [INFO] EC25 Phone Functionality => Full
Feb 9 14:34:01 raspberrypi candy-pi-lite: server_main.candy_command: candy_command() : apn:set => {“status”: “OK”, “result”: “”}
Feb 9 14:34:01 raspberrypi candy-pi-lite: [INFO] Saved APN => plus.4g
Feb 9 14:34:02 raspberrypi candy-pi-lite: server_main.candy_command: candy_command() : network:show => {“status”: “OK”, “result”: {“rssi”: “-117”, “rssiDesc”: “”, “network”: “N/A”, “operator”: “N/A”, “registration”: {“cs”: “Searching”, “ps”: “Searching”, “eps”: “Searching”}, “access”: “No Service”, “band”: “N/A”}}
Feb 9 14:34:02 raspberrypi candy-pi-lite: [INFO] Operator => N/A
Feb 9 14:34:02 raspberrypi candy-pi-lite: [INFO] Waiting for network registration => Status:Searching
Feb 9 14:34:02 raspberrypi dhcpcd[865]: wwan0: probing for an IPv4LL address
Feb 9 14:34:04 raspberrypi candy-pi-lite: server_main.candy_command: candy_command() : network:show => {“status”: “OK”, “result”: {“rssi”: “-117”, “rssiDesc”: “”, “network”: “N/A”, “operator”: “N/A”, “registration”: {“cs”: “Searching”, “ps”: “Searching”, “eps”: “Searching”}, “access”: “No Service”, “band”: “N/A”}}
Feb 9 14:34:04 raspberrypi candy-pi-lite: [INFO] Operator => N/A
Feb 9 14:34:04 raspberrypi candy-pi-lite: [INFO] Waiting for network registration => Status:Searching
Feb 9 14:34:06 raspberrypi candy-pi-lite: server_main.candy_command: candy_command() : network:show => {“status”: “OK”, “result”: {“rssi”: “-117”, “rssiDesc”: “”, “network”: “N/A”, “operator”: “N/A”, “registration”: {“cs”: “Searching”, “ps”: “Searching”, “eps”: “Searching”}, “access”: “No Service”, “band”: “N/A”}}
Feb 9 14:34:07 raspberrypi candy-pi-lite: [INFO] Operator => N/A
Feb 9 14:34:07 raspberrypi candy-pi-lite: [INFO] Waiting for network registration => Status:Searching
Feb 9 14:34:08 raspberrypi dhcpcd[865]: wwan0: using IPv4LL address 169.254.56.184
Feb 9 14:34:08 raspberrypi avahi-daemon[519]: Joining mDNS multicast group on interface wwan0.IPv4 with address 169.254.56.184.
Feb 9 14:34:08 raspberrypi avahi-daemon[519]: New relevant interface wwan0.IPv4 for mDNS.
Feb 9 14:34:08 raspberrypi avahi-daemon[519]: Registering new address record for 169.254.56.184 on wwan0.IPv4.
Feb 9 14:34:08 raspberrypi dhcpcd[865]: wwan0: adding route to 169.254.0.0/16
Feb 9 14:34:09 raspberrypi candy-pi-lite: server_main.candy_command: candy_command() : network:show => {“status”: “OK”, “result”: {“rssi”: “-59”, “rssiDesc”: “”, “network”: “N/A”, “operator”: “SoftBank SoftBank”, “registration”: {“cs”: “Registered”, “ps”: “Registered”, “eps”: “Unknown”}, “access”: “No Service”, “band”: “N/A”}}
Feb 9 14:34:09 raspberrypi candy-pi-lite: [INFO] Operator => SoftBank SoftBank
Feb 9 14:34:09 raspberrypi candy-pi-lite: [INFO] OK. Registered in the home ps network
Feb 9 14:34:10 raspberrypi candy-pi-lite: server_main.candy_command: candy_command() : modem:show => {“status”: “OK”, “result”: {“manufacturer”: “Quectel”, “model”: “EC25”, “revision”: “EC25JFAR06A05M4G”, “imei”: “865036041045277”, “datetime”: “21/02/09,05:34:10”, “timezone”: 9.0, “functionality”: “Full”, “counter”: {“tx”: “0”, “rx”: “0”}}}
Feb 9 14:34:10 raspberrypi candy-pi-lite: [INFO] Module Model: EC25
Feb 9 14:34:10 raspberrypi candy-pi-lite: [INFO] Network Timezone: 9.0
Feb 9 14:34:10 raspberrypi candy-pi-lite: [INFO] Skipped to adjust time
Feb 9 14:34:10 raspberrypi candy-pi-lite: [INFO] Trying to establish a connection…
Feb 9 14:34:10 raspberrypi dhcpcd[865]: eth0: pid 2160 deleted default route via 10.252.204.1
Feb 9 14:34:10 raspberrypi candy-pi-lite: [INFO] Trying to connect…(Trial:1/3, Timeout:5sec)
Feb 9 14:34:10 raspberrypi candy-pi-lite: [INFO] Starting PPP: /dev/QWS.EC25.MODEM
Feb 9 14:34:10 raspberrypi pppd[2174]: pppd 2.4.7 started by root, uid 0
Feb 9 14:34:11 raspberrypi dhcpcd[865]: wwan0: no IPv6 Routers available
Feb 9 14:34:12 raspberrypi pppd[2174]: Serial connection established.
Feb 9 14:34:12 raspberrypi pppd[2174]: Using interface ppp0
Feb 9 14:34:12 raspberrypi pppd[2174]: Connect: ppp0 <–> /dev/QWS.EC25.MODEM
Feb 9 14:34:13 raspberrypi pppd[2174]: CHAP authentication succeeded
Feb 9 14:34:13 raspberrypi pppd[2174]: CHAP authentication succeeded
Feb 9 14:34:13 raspberrypi pppd[2174]: Modem hangup
Feb 9 14:34:13 raspberrypi pppd[2174]: Connection terminated.
Feb 9 14:34:14 raspberrypi pppd[2174]: Exit.
Feb 9 14:34:14 raspberrypi candy-pi-lite: [INFO] start_pppd.sh terminated: Exit Code => 16
Feb 9 14:34:15 raspberrypi candy-pi-lite: [ERROR] PPP cannot be online
Feb 9 14:34:15 raspberrypi candy-pi-lite: [INFO] Trying to connect…(Trial:2/3, Timeout:35sec)
Feb 9 14:34:15 raspberrypi candy-pi-lite: [INFO] Starting PPP: /dev/QWS.EC25.MODEM
Feb 9 14:34:15 raspberrypi pppd[2242]: pppd 2.4.7 started by root, uid 0

よろしくお願いします。

y-Hiroishi · February 9, 2021, 6:00am

すみませんでした。お礼も言わずに書き込んでしまいました。また、添付も醜くて申し訳ありません。

前述のように,apn-list.jsonとapn.txtの両方を書き換えたうえで行っています。pppのところも、認証は旨くいっているといいっているのにもかかわらず、即座に切られていることも気になります。

質問ばかりで申し訳ありませんが、よろしくお願いします。

dbaba · February 9, 2021, 7:13am

ご返信ありがとうございます。

ログからは入力ミスの様子はありませんので、設定の不足と思われます。
元のSoftbank向けAPNについていた設定（"cs":true,"pu":true）をplus.4gの箇所に追加してお試しいただけますでしょうか。

github.com

CANDY-LINE/candy-pi-lite-service/blob/master/systemd/apn-list.json#L17


  ,"iijmio.jp-ipv4v6":{"user":"mio@iij","password":"iij","apn":"iijmio.jp","pdp":"ipv4v6","ipv6dns1":"2001:240::13","ipv6dns2":"2001:240::14"}
  ,"iijmio.jp-ipv6":{"user":"mio@iij","password":"iij","apn":"iijmio.jp","pdp":"ipv6","ipv6dns1":"2001:240::13","ipv6dns2":"2001:240::14"}
  ,"iijmobile.jp":{"user":"mobile@iij","password":"iij"}
  ,"iijmobile.jp-ipv4v6":{"user":"mobile@iij","password":"iij","apn":"iijmobile.jp","pdp":"ipv4v6","ipv6dns1":"2001:240::13","ipv6dns2":"2001:240::14"}
  ,"iijmobile.jp-ipv6":{"user":"mobile@iij","password":"iij","apn":"iijmobile.jp","pdp":"ipv6","ipv6dns1":"2001:240::13","ipv6dns2":"2001:240::14"}
  ,"iijmobile.biz":{"user":"biz@iij","password":"iij","ops":true}
  ,"iijmobile.biz-ipv4v6":{"user":"biz@iij","password":"iij","ops":true,"apn":"iijmobile.biz","pdp":"ipv4v6","ipv6dns1":"2001:240::13","ipv6dns2":"2001:240::14"}
  ,"iijmobile.biz-ipv6":{"user":"biz@iij","password":"iij","ops":true,"apn":"iijmobile.biz","pdp":"ipv6","ipv6dns1":"2001:240::13","ipv6dns2":"2001:240::14"}
  ,"internet4gd.gdsp":{"user":"web","password":"web","cs":true}
  ,"sd.iijmobile.jp":{"user":"mobile@iij","password":"iij"}
  ,"m2m4biz.softbank":{"user":"m2mbiz","password":"m2mbiz","cs":true,"pu":true}
  ,"isp.docomoiot.net":{"user":"web","password":"web"}
  ,"ipsim.net":{"user":"sim@with","password":"sim","apn":"4gn.jp"}
  ,"rokemoba":{"user":"roke@moba","password":"roke@moba","apn":"4gn.jp"}
  ,"au.au-net.ne.jp":{"user":"user@au.au-net.ne.jp","password":"au"}
  ,"uqmobile.jp":{"user":"uq@uqmobile.jp","password":"uq"}
  ,"sakura-kddi":{"user":"","password":"","apn":"sakura","ops":true,"mcc":"440","mnc":"51"}
  ,"sakura-docomo":{"user":"","password":"","apn":"sakura","ops":true,"mcc":"440","mnc":"10"}
  ,"sakura-softbank":{"user":"","password":"","apn":"sakura","ops":true,"mcc":"440","mnc":"20"}
  ,"spmode.ne.jp":{"user":"","password":"","apn":"spmode.ne.jp"}
}

y-Hiroishi · February 9, 2021, 7:14am

ご回答いただきありがとうございます。
了解しました。

やってみます。
本日は、ためせないと思うので、結果はお時間をいただくかもしれません。
まずは、ありがとうございました。

y-Hiroishi · February 10, 2021, 12:57am

試してみました。
状況はかわらないように見えます。
設定した部分が有効になっていることを確認するためのログの方法とかありますでしょうか？
system_pppd.shをデバッグ設定してみたログでも”ｃｓ”等が聞いている部分が見当たりません。
動き自体は、IPCPを送った後に即座に切られているように見えます。

この辺りを調べてみて、こんな対処をしてみたらとかのアイデアがあれば、お知らせください。
よろしくお願いします。

dbaba · February 10, 2021, 4:07am

実際に設定された内容（全体または抜粋）や、結果（ログの情報）がないとこちらからも的確な情報提供ができませんので、可能な範囲でご提供いただければと思います。

また、設定値については書式に問題がなければ設定されます。

念のための確認ですが、ソフトバンクAPNに対応しているか以下の点もご確認ください。

CANDY Pi Lite+マルチキャリア版またはCANDY Pi Lite+ Sを利用していること（投稿ではCANDY Pi Lite+と記載されていましたので具体的に合致するかどうかの確認。これら以外の機種ではどのような設定であっても接続できません）
お使いのAPNの設定とお使いのSIMカードで、SIMフリーのスマートフォンにて接続が確認できていること（回線の契約とAPN設定があっているかどうかの確認）
データ通信のみかどうか（SMS・音声付きのプランかどうか）→cs="true"は以下のページにあるようにデータ通信のみの契約では使えません。

github.com

CANDY-LINE/candy-pi-lite-info/blob/master/configuration/apn.md#音声sms回線向けの設定

<!-- toc -->

# APN設定

CANDY Pi Liteの携帯電話ネットワークへの接続先(APN)は、インストール時に指定することができます。この宛先は、インストール後に変更することが可能です。異なるMVNOのSIMカードを変更したときには、APNの変更も行うようにしましょう。

[`candy-pi-lite-service v1.7.0`](https://forums.candy-line.io/t/v1-7-0/63)からAPNの指定方法が簡単になりました。以前のバージョンをご利用の場合は、本章の後半をご覧ください。

## APNの指定

**👉[`candy-pi-lite-service v6.2.0`](https://forums.candy-line.io/t/candy-pi-lite-v6-2-0/238)以降で対応しています**

APNを指定するには、パソコンなどでマイクロSDカードの`/boot`ディレクトリーに`apn`または`apn.txt`という名前のファイルを作成します。ファイルの中身は、APNの名称または設定名を指定します。初期状態では、[プリセットされたAPNの一覧](apn-list.md)に記載された名称を利用可能です。


例えば、IIJモバイル／タイプIのSIMをご利用の場合は、メモ帳やテキストエディターなどで`iijmobile.biz-ipv6`とだけ入力し保存します。

> ### <👉補足説明>
>
> 上記の例では、`apn`（または`apn.txt`）ファイルの値に`iijmobile.biz-ipv6`を設定すると記載しています。本来IIJモバイル／タイプIの標準的なAPN名は`iijmobile.biz`ですが、同じAPNでも異なる設定で接続できるようにするため、別名を設定名としてつけることが可能です。このため、`iijmobile.biz-ipv6`を`/boot/apn`（または`/boot/apn.txt`）ファイルに指定しても、その値がAPN名となることはありません。

This file has been truncated. show original

y-Hiroishi · February 10, 2021, 4:26am

ご回答頂き、ありがとうございます。
apn.txtとかの設定内容は、全て出していいものかどうかよくわからなかったので、出しませんでした。申し訳ありません。

apn.txt (追加した行付近)です
,“spmode.ne.jp”:{“user”:"",“password”:"",“apn”:“spmode.ne.jp”}
,“plus.4g”:{“user”:“plus”,“password”:“4g”,“nw”:“lte”,“cs”:true,“pu”:true}
}

CANDY PI の種類。
CANDY Pi Lite+ (マルチキャリア版）です。
EC25J-MINIPCIE のバーコード上にシールは貼られていません。
SIMカードは、PocketWiFiでの動作を確認しております。
（確かに、ユーザ名等はWebから検索したものです）
データ通信飲みかどうか、
PocketWiFI用であるので、データ通信のみの契約だと思われます。

y-Hiroishi · February 10, 2021, 4:27am

APN設定に関して、SIMの契約者に確認したところ、上記であっています。

y-Hiroishi · February 10, 2021, 4:42am

ログの添付を忘れてました。以下に添付します。

Feb 10 13:34:52 raspberrypi systemd[1]: Started CANDY Pi Lite Service, version:10.2.1.
Feb 10 13:34:53 raspberrypi candy-pi-lite: [INFO] Initializing CANDY Pi Lite Board…
Feb 10 13:34:53 raspberrypi kernel: [13605.437250] usb 1-1.1: USB disconnect, device number 18
Feb 10 13:34:53 raspberrypi kernel: [13605.437665] option1 ttyUSB0: GSM modem (1-port) converter now disconnected from ttyUSB0
Feb 10 13:34:53 raspberrypi kernel: [13605.437725] option 1-1.1:1.0: device disconnected
Feb 10 13:34:53 raspberrypi kernel: [13605.438133] option1 ttyUSB1: GSM modem (1-port) converter now disconnected from ttyUSB1
Feb 10 13:34:53 raspberrypi kernel: [13605.438192] option 1-1.1:1.1: device disconnected
Feb 10 13:34:53 raspberrypi kernel: [13605.438595] option1 ttyUSB2: GSM modem (1-port) converter now disconnected from ttyUSB2
Feb 10 13:34:53 raspberrypi kernel: [13605.438650] option 1-1.1:1.2: device disconnected
Feb 10 13:34:53 raspberrypi avahi-daemon[460]: Interface wwan0.IPv6 no longer relevant for mDNS.
Feb 10 13:34:53 raspberrypi avahi-daemon[460]: Leaving mDNS multicast group on interface wwan0.IPv6 with address fe80::e215:9139:d800:edf7.
Feb 10 13:34:53 raspberrypi dhcpcd[8853]: wwan0: carrier lost
Feb 10 13:34:53 raspberrypi kernel: [13605.453199] option1 ttyUSB3: GSM modem (1-port) converter now disconnected from ttyUSB3
Feb 10 13:34:53 raspberrypi kernel: [13605.453267] option 1-1.1:1.3: device disconnected
Feb 10 13:34:53 raspberrypi kernel: [13605.453474] qmi_wwan 1-1.1:1.4 wwan0: unregister ‘qmi_wwan’ usb-0000:01:00.0-1.1, WWAN/QMI device
Feb 10 13:34:53 raspberrypi avahi-daemon[460]: Interface wwan0.IPv4 no longer relevant for mDNS.
Feb 10 13:34:53 raspberrypi avahi-daemon[460]: Leaving mDNS multicast group on interface wwan0.IPv4 with address 169.254.156.75.
Feb 10 13:34:53 raspberrypi avahi-daemon[460]: Withdrawing address record for fe80::e215:9139:d800:edf7 on wwan0.
Feb 10 13:34:53 raspberrypi avahi-daemon[460]: Withdrawing address record for 169.254.156.75 on wwan0.
Feb 10 13:34:53 raspberrypi dhcpcd[8853]: wwan0: deleting route to 169.254.0.0/16
Feb 10 13:34:53 raspberrypi dhcpcd[8853]: wwan0: removing interface
Feb 10 13:34:54 raspberrypi candy-pi-lite: [INFO] Looking for a Modem Serial port at Barudrate: 115200…
Feb 10 13:34:55 raspberrypi candy-pi-lite: [INFO] Result: None
Feb 10 13:34:55 raspberrypi candy-pi-lite: [INFO] Looking for a Modem Serial port at Barudrate: 460800…
Feb 10 13:34:56 raspberrypi candy-pi-lite: [INFO] Result: None
Feb 10 13:34:56 raspberrypi candy-pi-lite: [INFO] Looking for a Modem Serial port at Barudrate: 115200…
Feb 10 13:34:57 raspberrypi candy-pi-lite: [INFO] Result: None
Feb 10 13:34:57 raspberrypi candy-pi-lite: [INFO] Looking for a Modem Serial port at Barudrate: 460800…
Feb 10 13:34:58 raspberrypi candy-pi-lite: [INFO] Result: None
Feb 10 13:34:59 raspberrypi candy-pi-lite: [INFO] Looking for a Modem Serial port at Barudrate: 115200…
Feb 10 13:35:00 raspberrypi candy-pi-lite: [INFO] Result: None
Feb 10 13:35:00 raspberrypi candy-pi-lite: [INFO] Looking for a Modem Serial port at Barudrate: 460800…
Feb 10 13:35:01 raspberrypi candy-pi-lite: [INFO] Result: None
Feb 10 13:35:02 raspberrypi candy-pi-lite: [INFO] Looking for a Modem Serial port at Barudrate: 115200…
Feb 10 13:35:03 raspberrypi candy-pi-lite: [INFO] Result: None
Feb 10 13:35:03 raspberrypi candy-pi-lite: [INFO] Looking for a Modem Serial port at Barudrate: 460800…
Feb 10 13:35:04 raspberrypi candy-pi-lite: [INFO] Result: None
Feb 10 13:35:05 raspberrypi candy-pi-lite: [INFO] Looking for a Modem Serial port at Barudrate: 115200…
Feb 10 13:35:05 raspberrypi candy-pi-lite: [INFO] Result: /dev/ttySC1
Feb 10 13:35:05 raspberrypi candy-pi-lite: [INFO] Modem Serial port: /dev/ttySC1 and AT Serial port: /dev/ttySC1 are selected
Feb 10 13:35:06 raspberrypi candy-pi-lite: [INFO] Initializing modem with baudrate:460800
Feb 10 13:35:06 raspberrypi kernel: [13619.049341] usb 1-1.1: new high-speed USB device number 19 using xhci_hcd
Feb 10 13:35:07 raspberrypi kernel: [13619.189484] usb 1-1.1: New USB device found, idVendor=2c7c, idProduct=0125, bcdDevice= 3.18
Feb 10 13:35:07 raspberrypi kernel: [13619.189501] usb 1-1.1: New USB device strings: Mfr=1, Product=2, SerialNumber=0
Feb 10 13:35:07 raspberrypi kernel: [13619.189516] usb 1-1.1: Product: Android
Feb 10 13:35:07 raspberrypi kernel: [13619.189529] usb 1-1.1: Manufacturer: Android
Feb 10 13:35:07 raspberrypi kernel: [13619.202424] option 1-1.1:1.0: GSM modem (1-port) converter detected
Feb 10 13:35:07 raspberrypi kernel: [13619.208009] usb 1-1.1: GSM modem (1-port) converter now attached to ttyUSB0
Feb 10 13:35:07 raspberrypi kernel: [13619.208523] option 1-1.1:1.1: GSM modem (1-port) converter detected
Feb 10 13:35:07 raspberrypi kernel: [13619.210941] usb 1-1.1: GSM modem (1-port) converter now attached to ttyUSB1
Feb 10 13:35:07 raspberrypi kernel: [13619.211512] option 1-1.1:1.2: GSM modem (1-port) converter detected
Feb 10 13:35:07 raspberrypi kernel: [13619.213405] usb 1-1.1: GSM modem (1-port) converter now attached to ttyUSB2
Feb 10 13:35:07 raspberrypi kernel: [13619.213959] option 1-1.1:1.3: GSM modem (1-port) converter detected
Feb 10 13:35:07 raspberrypi kernel: [13619.215691] usb 1-1.1: GSM modem (1-port) converter now attached to ttyUSB3
Feb 10 13:35:07 raspberrypi kernel: [13619.217676] qmi_wwan 1-1.1:1.4: cdc-wdm0: USB WDM device
Feb 10 13:35:07 raspberrypi kernel: [13619.219157] qmi_wwan 1-1.1:1.4 wwan0: register ‘qmi_wwan’ at usb-0000:01:00.0-1.1, WWAN/QMI device, 82:e6:2e:cf:c7:5b
Feb 10 13:35:07 raspberrypi mtp-probe: checking bus 1, device 19: “/sys/devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb1/1-1/1-1.1”
Feb 10 13:35:07 raspberrypi mtp-probe: bus: 1, device: 19 was not an MTP device
Feb 10 13:35:07 raspberrypi systemd-udevd[9152]: Using default interface naming scheme ‘v240’.
Feb 10 13:35:07 raspberrypi mtp-probe: checking bus 1, device 19: “/sys/devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb1/1-1/1-1.1”
Feb 10 13:35:07 raspberrypi mtp-probe: bus: 1, device: 19 was not an MTP device
Feb 10 13:35:07 raspberrypi candy-pi-lite: server_main.candy_command: candy_command() : modem:init => {“status”: “OK”, “result”: {“counter_reset”: “N/A”, “baudrate”: “OK”}}
Feb 10 13:35:07 raspberrypi dhcpcd[8853]: wwan0: waiting for carrier
Feb 10 13:35:07 raspberrypi dhcpcd[8853]: wwan0: carrier acquired
Feb 10 13:35:07 raspberrypi dhcpcd[8853]: wwan0: IAID 2e:cf:c7:5b
Feb 10 13:35:07 raspberrypi dhcpcd[8853]: wwan0: adding address fe80::e215:9139:d800:edf7
Feb 10 13:35:07 raspberrypi avahi-daemon[460]: Joining mDNS multicast group on interface wwan0.IPv6 with address fe80::e215:9139:d800:edf7.
Feb 10 13:35:07 raspberrypi avahi-daemon[460]: New relevant interface wwan0.IPv6 for mDNS.
Feb 10 13:35:07 raspberrypi avahi-daemon[460]: Registering new address record for fe80::e215:9139:d800:edf7 on wwan0.*.
Feb 10 13:35:07 raspberrypi candy-pi-lite: [INFO] Modem baudrate changed: 115200 => 460800
Feb 10 13:35:07 raspberrypi candy-pi-lite: [INFO] Initialization Done. Modem Serial Port => /dev/ttySC1 Modem baudrate => 460800
Feb 10 13:35:07 raspberrypi dhcpcd[8853]: wwan0: soliciting an IPv6 router
Feb 10 13:35:07 raspberrypi dhcpcd[8853]: wwan0: soliciting a DHCP lease
Feb 10 13:35:08 raspberrypi candy-pi-lite: server_main.candy_command: candy_command() : sim:show => {“status”: “OK”, “result”: {“msisdn”: “07015148381”, “imsi”: “440209183272362”, “state”: “SIM_STATE_READY”}}
Feb 10 13:35:08 raspberrypi candy-pi-lite: [INFO] SIM card state => SIM_STATE_READY
Feb 10 13:35:08 raspberrypi dbus-daemon[522]: [system] Activating via systemd: service name=‘org.freedesktop.timedate1’ unit=‘dbus-org.freedesktop.timedate1.service’ requested by ‘:1.345’ (uid=0 pid=9186 comm="timedatectl set-ntp false ")
Feb 10 13:35:08 raspberrypi systemd[1]: Starting Time & Date Service…
Feb 10 13:35:08 raspberrypi dbus-daemon[522]: [system] Successfully activated service 'org.freedesktop.timedate1’Feb 10 13:35:08 raspberrypi systemd[1]: Started Time & Date Service.
Feb 10 13:35:08 raspberrypi systemd[1]: Reloading.
Feb 10 13:35:08 raspberrypi systemd[1]: Stopping Network Time Synchronization…
Feb 10 13:35:08 raspberrypi systemd-timedated[9187]: Set NTP to disabled
Feb 10 13:35:08 raspberrypi systemd[1]: systemd-timesyncd.service: Succeeded.
Feb 10 13:35:08 raspberrypi systemd[1]: Stopped Network Time Synchronization.
Feb 10 13:35:08 raspberrypi candy-pi-lite: [INFO] USB Serial Ports are found => /dev/QWS.EC25.MODEM, /dev/QWS.EC25.AT
Feb 10 13:35:08 raspberrypi candy-pi-lite: [INFO] New USB serial ports are detected
Feb 10 13:35:08 raspberrypi candy-pi-lite: [INFO] Looking for a Modem Serial port at Barudrate: 115200…
Feb 10 13:35:09 raspberrypi candy-pi-lite: [INFO] Result: /dev/QWS.EC25.MODEM
Feb 10 13:35:09 raspberrypi candy-pi-lite: [INFO] Modem Serial port: /dev/QWS.EC25.MODEM and AT Serial port: /dev/QWS.EC25.AT are selected
Feb 10 13:35:09 raspberrypi candy-pi-lite: [INFO] Initialization Done. Modem Serial Port => /dev/QWS.EC25.MODEM
Feb 10 13:35:10 raspberrypi candy-pi-lite: server_main.candy_command: candy_command() : modem:init => {“status”: “OK”, “result”: {“counter_reset”: “N/A”, “baudrate”: “N/A”}}
Feb 10 13:35:11 raspberrypi candy-pi-lite: server_main.candy_command: candy_command() : modem:show => {“status”: “OK”, “result”: {“manufacturer”: “Quectel”, “model”: “EC25”, “revision”: “EC25JFAR06A05M4G”, “imei”: “865036041045277”, “datetime”: “21/02/10,04:35:10”, “timezone”: 9.0, “functionality”: “Full”, “counter”: {“tx”: “0”, “rx”: “0”}}}
Feb 10 13:35:11 raspberrypi candy-pi-lite: [INFO] EC25 Phone Functionality => Full
Feb 10 13:35:11 raspberrypi candy-pi-lite: server_main.candy_command: candy_command() : apn:set => {“status”: “OK”, “result”: “”}
Feb 10 13:35:11 raspberrypi candy-pi-lite: [INFO] Saved APN => plus.4g
Feb 10 13:35:12 raspberrypi dhcpcd[8853]: wwan0: probing for an IPv4LL address
Feb 10 13:35:12 raspberrypi candy-pi-lite: server_main.candy_command: candy_command() : network:show => {“status”: “OK”, “result”: {“rssi”: “-117”, “rssiDesc”: “”, “network”: “N/A”, “operator”: “N/A”, “registration”: {“cs”: “Searching”, “ps”: “Searching”, “eps”: “Searching”}, “access”: “No Service”, “band”: “N/A”}}
Feb 10 13:35:13 raspberrypi candy-pi-lite: [INFO] Operator => N/A
Feb 10 13:35:13 raspberrypi candy-pi-lite: [INFO] Waiting for network registration => Status:Searching
Feb 10 13:35:15 raspberrypi candy-pi-lite: server_main.candy_command: candy_command() : network:show => {“status”: “OK”, “result”: {“rssi”: “-117”, “rssiDesc”: “”, “network”: “N/A”, “operator”: “N/A”, “registration”: {“cs”: “Searching”, “ps”: “Searching”, “eps”: “Searching”}, “access”: “No Service”, “band”: “N/A”}}
Feb 10 13:35:15 raspberrypi candy-pi-lite: [INFO] Operator => N/A
Feb 10 13:35:15 raspberrypi candy-pi-lite: [INFO] Waiting for network registration => Status:Searching
Feb 10 13:35:15 raspberrypi candy-pi-lite: server_main.candy_command: candy_command() : network:show => {“status”: “OK”, “result”: {“rssi”: “-117”, “rssiDesc”: “”, “network”: “N/A”, “operator”: “N/A”, “registration”: {“cs”: “Searching”, “ps”: “Searching”, “eps”: “Searching”}, “access”: “No Service”, “band”: “N/A”}}
Feb 10 13:35:15 raspberrypi candy-pi-lite: [INFO] Operator => N/A
Feb 10 13:35:15 raspberrypi candy-pi-lite: [INFO] Waiting for network registration => Status:Searching
Feb 10 13:35:17 raspberrypi candy-pi-lite: server_main.candy_command: candy_command() : network:show => {“status”: “OK”, “result”: {“rssi”: “-69”, “rssiDesc”: “”, “network”: “N/A”, “operator”: “N/A”, “registration”: {“cs”: “Searching”, “ps”: “Searching”, “eps”: “Denied”}, “access”: “WCDMA”, “band”: “WCDMA 2100”}}
Feb 10 13:35:17 raspberrypi candy-pi-lite: [INFO] Operator => N/A
Feb 10 13:35:17 raspberrypi candy-pi-lite: [INFO] Waiting for network registration => Status:Searching
Feb 10 13:35:18 raspberrypi dhcpcd[8853]: wwan0: using IPv4LL address 169.254.156.75
Feb 10 13:35:18 raspberrypi dhcpcd[8853]: wwan0: adding route to 169.254.0.0/16
Feb 10 13:35:18 raspberrypi avahi-daemon[460]: Joining mDNS multicast group on interface wwan0.IPv4 with address 169.254.156.75.
Feb 10 13:35:18 raspberrypi avahi-daemon[460]: New relevant interface wwan0.IPv4 for mDNS.
Feb 10 13:35:18 raspberrypi avahi-daemon[460]: Registering new address record for 169.254.156.75 on wwan0.IPv4.
Feb 10 13:35:19 raspberrypi candy-pi-lite: server_main.candy_command: candy_command() : network:show => {“status”: “OK”, “result”: {“rssi”: “-69”, “rssiDesc”: “”, “network”: “N/A”, “operator”: “SoftBank SoftBank”, “registration”: {“cs”: “Registered”, “ps”: “Registered”, “eps”: “Unknown”}, “access”: “WCDMA”, “band”: “WCDMA 2100”}}
Feb 10 13:35:19 raspberrypi candy-pi-lite: [INFO] Operator => SoftBank SoftBank
Feb 10 13:35:19 raspberrypi candy-pi-lite: [INFO] OK. Registered in the home ps network
Feb 10 13:35:20 raspberrypi dhcpcd[8853]: wwan0: no IPv6 Routers available
Feb 10 13:35:20 raspberrypi candy-pi-lite: server_main.candy_command: candy_command() : modem:show => {“status”: “OK”, “result”: {“manufacturer”: “Quectel”, “model”: “EC25”, “revision”: “EC25JFAR06A05M4G”, “imei”: “865036041045277”, “datetime”: “21/02/10,04:35:19”, “timezone”: 9.0, “functionality”: “Full”, “counter”: {“tx”: “0”, “rx”: “0”}}}
Feb 10 13:35:20 raspberrypi candy-pi-lite: [INFO] Module Model: EC25
Feb 10 13:35:20 raspberrypi candy-pi-lite: [INFO] Network Timezone: 9.0
Feb 10 13:35:20 raspberrypi candy-pi-lite: [INFO] Skipped to adjust time
Feb 10 13:35:20 raspberrypi candy-pi-lite: [INFO] Trying to establish a connection…
Feb 10 13:35:20 raspberrypi dhcpcd[8853]: eth0: pid 9313 deleted default route via 10.252.204.1
Feb 10 13:35:20 raspberrypi candy-pi-lite: [INFO] Trying to connect…(Trial:1/3, Timeout:5sec)
Feb 10 13:35:20 raspberrypi candy-pi-lite: [INFO] Starting PPP: /dev/QWS.EC25.MODEM
Feb 10 13:35:20 raspberrypi pppd[9326]: pppd 2.4.7 started by root, uid 0
Feb 10 13:35:22 raspberrypi pppd[9326]: Serial connection established.
Feb 10 13:35:22 raspberrypi pppd[9326]: Using interface ppp0
Feb 10 13:35:22 raspberrypi pppd[9326]: Connect: ppp0 <–> /dev/QWS.EC25.MODEM
Feb 10 13:35:23 raspberrypi pppd[9326]: CHAP authentication succeeded
Feb 10 13:35:23 raspberrypi pppd[9326]: CHAP authentication succeeded
Feb 10 13:35:23 raspberrypi pppd[9326]: Modem hangup
Feb 10 13:35:23 raspberrypi pppd[9326]: Connection terminated.
Feb 10 13:35:24 raspberrypi pppd[9326]: Exit.
Feb 10 13:35:24 raspberrypi candy-pi-lite: [INFO] start_pppd.sh terminated: Exit Code => 16
Feb 10 13:35:25 raspberrypi candy-pi-lite: [ERROR] PPP cannot be online
Feb 10 13:35:25 raspberrypi candy-pi-lite: [INFO] Trying to connect…(Trial:2/3, Timeout:35sec)
Feb 10 13:35:25 raspberrypi candy-pi-lite: [INFO] Starting PPP: /dev/QWS.EC25.MODEM
Feb 10 13:35:25 raspberrypi pppd[9385]: pppd 2.4.7 started by root, uid 0
Feb 10 13:35:26 raspberrypi pppd[9385]: Serial connection established.
Feb 10 13:35:26 raspberrypi pppd[9385]: Using interface ppp0
Feb 10 13:35:26 raspberrypi pppd[9385]: Connect: ppp0 <–> /dev/QWS.EC25.MODEM
Feb 10 13:35:27 raspberrypi pppd[9385]: CHAP authentication succeeded
Feb 10 13:35:27 raspberrypi pppd[9385]: CHAP authentication succeeded
Feb 10 13:35:27 raspberrypi pppd[9385]: Modem hangup
Feb 10 13:35:27 raspberrypi pppd[9385]: Connection terminated.
Feb 10 13:35:29 raspberrypi pppd[9385]: Exit.
Feb 10 13:35:29 raspberrypi candy-pi-lite: [INFO] start_pppd.sh terminated: Exit Code => 16
Feb 10 13:35:29 raspberrypi candy-pi-lite: [ERROR] PPP cannot be online
Feb 10 13:35:29 raspberrypi candy-pi-lite: [INFO] Trying to connect…(Trial:3/3, Timeout:65sec)
Feb 10 13:35:29 raspberrypi candy-pi-lite: [INFO] Starting PPP: /dev/QWS.EC25.MODEM
Feb 10 13:35:29 raspberrypi pppd[9441]: pppd 2.4.7 started by root, uid 0
Feb 10 13:35:31 raspberrypi pppd[9441]: Serial connection established.
Feb 10 13:35:31 raspberrypi pppd[9441]: Using interface ppp0
Feb 10 13:35:31 raspberrypi pppd[9441]: Connect: ppp0 <–> /dev/QWS.EC25.MODEM
Feb 10 13:35:32 raspberrypi pppd[9441]: CHAP authentication succeeded
Feb 10 13:35:32 raspberrypi pppd[9441]: CHAP authentication succeeded
Feb 10 13:35:32 raspberrypi pppd[9441]: Modem hangup
Feb 10 13:35:32 raspberrypi pppd[9441]: Connection terminated.
Feb 10 13:35:33 raspberrypi pppd[9441]: Exit.
Feb 10 13:35:33 raspberrypi candy-pi-lite: [INFO] start_pppd.sh terminated: Exit Code => 16
Feb 10 13:35:33 raspberrypi candy-pi-lite: [ERROR] PPP cannot be online
Feb 10 13:35:33 raspberrypi candy-pi-lite: [WARN] Failed to establishing a connection. Retry after 30 seconds…
Feb 10 13:35:38 raspberrypi systemd[1]: systemd-timedated.service: Succeeded.

こんな感じです。
よろしくお願いします。

dbaba · February 10, 2021, 5:23am

ログを拝見する限り、ソフトバンクの網を掴めているようです。

Feb 10 13:35:19 raspberrypi candy-pi-lite: [INFO] Operator => SoftBank SoftBank
Feb 10 13:35:19 raspberrypi candy-pi-lite: [INFO] OK. Registered in the home ps network

PocketWifiでAPNを閲覧できるのか存じ上げませんが、Pocket WiFiですと通常自動でAPNを設定すると思います。今回指定されたAPNが使用されているか確認できているのでしょうか？それとも、APNをご自身で入力されて動作を確認されたのでしょうか？

APNの情報をWebから検索されたとありますので、PocketWifiが自動でAPNを設定したものを使用されて疎通できているとご判断されていると思われます。そうすると、やはりAPNがご契約のSIMに合っていないと考えられます。

こちらから申し上げられることは、Softbankの網をつかめているもののPPPができていないということで、APNの情報がご契約のSIMと一致していない可能性が高いというものです。
キャリアからのAPN情報が確かなSIMカードにてお試しいただければと思います。

y-Hiroishi · February 10, 2021, 5:31am

ご回答いただきありがとうございます。

もう一度、APN情報の確認をしたいと思います。
ちなみに、こんな聞き方をしたらまずいとも思いますが、DOCOMOの通常契約中のSIMをこれに使うとするとAPNとして何を使用したらいいかとかわかりますか？

dbaba · February 10, 2021, 5:47am

ご契約中のSIMとそれに使用可能なAPNの設定については、当社では回答しかねますのでご契約のキャリアへお尋ねください。