Pythonによる制御について

ご連絡ありがとうございます。

3月 17 18:25:05 raspberrypi candy-pi-lite[6446]: [INFO] Operator => N/A
3月 17 18:25:05 raspberrypi candy-pi-lite[6449]: [INFO] Waiting for network registration => Status:Searching

このようなログが出ていることから判断しますと、通信ができていないようです。
APN設定がご利用中のSIMに対応しているかどうか、また、アンテナが接続されているかご確認いただければと思います。

度々申し訳ありません。
candyコマンドが使えない状態で、apn設定の確認する方法を教えてください。
よろしくお願いします。

実際に検出されたAPNは、/var/log/syslogにて、以下の2行目のように「Saved APN => 設定されたAPN」という形で表示されます。

(省略)
Mar 17 17:45:08 raspberrypi candy-pi-lite: [INFO] EC25 Phone Functionality => Full
Mar 17 17:45:08 raspberrypi candy-pi-lite: [INFO] Saved APN => lte-d.ocn.ne.jp
Mar 17 17:45:09 raspberrypi candy-pi-lite: [INFO] Operator => N/A
Mar 17 17:45:09 raspberrypi candy-pi-lite: [INFO] Waiting for network registration => Status:Searching
Mar 17 17:45:11 raspberrypi candy-pi-lite: [INFO] Operator => N/A
(省略)

ご確認ください。

/var/log/syslogには教えていただいた表示がなかったので、下記の手順でAPN設定をやり直してみました。
$ sudo /opt/candy-line/candy-pi-lite/uninstall.sh
リブート実行
$ curl -sL https://git.io/v7bXx | sudo bash
リブート実行

すると、CANDYのステータスメッセージが下記のように変わりました。
起動がうまくいかず、起動を繰り返しているようです。
どう対応すればいいでしょうか?
ご教授お願いします。

@raspberrypi:~ $ sudo candy service status
● candy-pi-lite.service - CANDY Pi Lite Service, version:7.1.0
Loaded: loaded (/lib/systemd/system/candy-pi-lite.service; enabled; vendor preset: enabled)
Active: active (running) since Wed 2020-03-18 13:58:58 JST; 21s ago
Main PID: 1365 (bash)
Tasks: 2 (limit: 2200)
Memory: 1.4M
CGroup: /system.slice/candy-pi-lite.service
tq1365 bash /opt/candy-line/candy-pi-lite/start_systemd.sh
mq1484 sleep 1

3月 18 13:58:58 raspberrypi systemd[1]: Started CANDY Pi Lite Service, version:7.1.0.

pi@raspberrypi:~ $ sudo journalctl -f -u candy-pi-lite -o cat
candy-pi-lite.service: Scheduled restart job, restart counter is at 1.
Stopped CANDY Pi Lite Service, version:7.1.0.
Started CANDY Pi Lite Service, version:7.1.0.
[INFO] Initializing CANDY Pi Lite Board…
candy-pi-lite.service: Main process exited, code=exited, status=1/FAILURE
candy-pi-lite.service: Failed with result ‘exit-code’.
candy-pi-lite.service: Service RestartSec=100ms expired, scheduling restart.
candy-pi-lite.service: Scheduled restart job, restart counter is at 2.
Stopped CANDY Pi Lite Service, version:7.1.0.
Started CANDY Pi Lite Service, version:7.1.0.

ご連絡ありがとうございます。

起動がうまくいっていない箇所のログの情報を見ないと状況がわからないため、以下のコマンドでログの取得をお試しいただけますか。

$ sudo candy service restart && tail -f /var/log/syslog

こちらで、ターミナルに流れるログを見続けていただき、CANDY Pi Liteサービスの動作を見たいと思いますので、出てくるログを教えていただければと思います。

例えば上記コマンドの結果は以下のようになります(以下はGPIO接続の例)。

Mar 18 06:54:06 raspberrypi candy-pi-lite: [INFO] CANDY Pi Lite Board is inactivated successfully!
Mar 18 06:54:06 raspberrypi systemd[1]: candy-pi-lite.service: Succeeded.
Mar 18 06:54:06 raspberrypi systemd[1]: Stopped CANDY Pi Lite Service, version:7.1.0.
Mar 18 06:54:07 raspberrypi systemd[1]: dhcpcd.service: Succeeded.
Mar 18 06:54:07 raspberrypi systemd[1]: Stopped dhcpcd on all interfaces.
Mar 18 06:54:07 raspberrypi systemd[1]: Started CANDY Pi Lite Service, version:7.1.0.
Mar 18 06:54:07 raspberrypi systemd[1]: Starting dhcpcd on all interfaces...
(省略)
Mar 18 06:54:19 raspberrypi candy-pi-lite: [INFO] Modem Serial port: /dev/ttySC1 and AT Serial port: /dev/ttySC1 are selected
Mar 18 06:54:19 raspberrypi candy-pi-lite: [INFO] Initializing modem with baudrate:460800
Mar 18 06:54:20 raspberrypi dhcpcd[3342]: eth0: no IPv6 Routers available
Mar 18 06:54:20 raspberrypi candy-pi-lite: [INFO] Modem baudrate changed: 115200 => 460800
Mar 18 06:54:20 raspberrypi candy-pi-lite: [INFO] Initialization Done. Modem Serial Port => /dev/ttySC1 Modem baudrate => 460800
Mar 18 06:54:21 raspberrypi candy-pi-lite: [INFO] SIM card state => SIM_STATE_READY
Mar 18 06:54:21 raspberrypi systemd[1]: Reloading.
Mar 18 06:54:21 raspberrypi systemd-timedated[3260]: Set NTP to disabled
Mar 18 06:54:21 raspberrypi systemd[1]: Stopping Network Time Synchronization...
Mar 18 06:54:21 raspberrypi systemd[1]: systemd-timesyncd.service: Succeeded.
Mar 18 06:54:22 raspberrypi systemd[1]: Stopped Network Time Synchronization.
Mar 18 06:54:22 raspberrypi candy-pi-lite: [INFO] EC25 Phone Functionality => Full
Mar 18 06:54:23 raspberrypi candy-pi-lite: [INFO] Saved APN => lte-d.ocn.ne.jp
Mar 18 06:54:24 raspberrypi candy-pi-lite: [INFO] Operator => N/A
(以下略)

ご連絡ありがとうございます。ログをお送りします。
一部、伏せさせていただきました。解析上問題があればお知らせ下さい。
よろしくお願いします。

$ sudo candy service restart && tail -f /var/log/syslog
Service Restarted
Mar 18 16:16:14 raspberrypi systemd[1]: candy-pi-lite.service: Main process exited, code=killed, status=15/TERM
Mar 18 16:16:14 raspberrypi systemd[1]: candy-pi-lite.service: Succeeded.
Mar 18 16:16:14 raspberrypi systemd[1]: Stopped CANDY Pi Lite Service, version:7.1.0.
Mar 18 16:16:14 raspberrypi systemd[1]: dhcpcd.service: Succeeded.
Mar 18 16:16:14 raspberrypi systemd[1]: Stopped dhcpcd on all interfaces.
Mar 18 16:16:14 raspberrypi systemd[1]: Started CANDY Pi Lite Service, version:7.1.0.
Mar 18 16:16:14 raspberrypi systemd[1]: Starting dhcpcd on all interfaces…
Mar 18 16:16:14 raspberrypi dhcpcd[9067]: dev: loaded udev
Mar 18 16:16:14 raspberrypi dhcpcd[9067]: wlan0: starting wpa_supplicant
Mar 18 16:16:14 raspberrypi dhcpcd-run-hooks[9083]: wlan0: starting wpa_supplicant
Mar 18 16:16:14 raspberrypi kernel: [ 2269.681635] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready
Mar 18 16:16:14 raspberrypi kernel: [ 2269.681699] brcmfmac: power management disabled
Mar 18 16:16:15 raspberrypi candy-pi-lite: [INFO] Initializing CANDY Pi Lite Board…
Mar 18 16:16:15 raspberrypi dhcpcd[9067]: wlan0: connected to Access Point `’
Mar 18 16:16:15 raspberrypi dhcpcd[9067]: DUID (省略)
Mar 18 16:16:15 raspberrypi dhcpcd[9067]: eth0: IAID (省略)
Mar 18 16:16:15 raspberrypi dhcpcd[9067]: wlan0: waiting for carrier
Mar 18 16:16:15 raspberrypi dhcpcd[9067]: eth0: rebinding lease of (省略)
Mar 18 16:16:15 raspberrypi dhcpcd[9067]: eth0: leased (省略) for 86400 seconds
Mar 18 16:16:15 raspberrypi dhcpcd[9067]: eth0: adding route to (省略)
Mar 18 16:16:15 raspberrypi dhcpcd[9067]: eth0: adding default route via (省略)
Mar 18 16:16:15 raspberrypi dhcpcd[9067]: forked to background, child pid 9126
Mar 18 16:16:15 raspberrypi systemd[1]: Started dhcpcd on all interfaces.
Mar 18 16:16:15 raspberrypi dhcpcd[9126]: eth0: soliciting an IPv6 router
Mar 18 16:16:15 raspberrypi dhcpcd[9126]: eth0: Router Advertisement from (省略)
Mar 18 16:16:19 raspberrypi kernel: [ 2274.715186] Bluetooth: hci0: Frame reassembly failed (-84)
Mar 18 16:16:19 raspberrypi kernel: [ 2274.715256] Bluetooth: hci0: Frame reassembly failed (-84)
Mar 18 16:16:19 raspberrypi kernel: [ 2274.715483] Bluetooth: hci0: Frame reassembly failed (-84)
Mar 18 16:16:27 raspberrypi kernel: [ 2281.997245] Bluetooth: hci0: Frame reassembly failed (-84)
Mar 18 16:16:27 raspberrypi kernel: [ 2281.997342] Bluetooth: hci0: Frame reassembly failed (-84)
Mar 18 16:16:29 raspberrypi kernel: [ 2283.888012] Bluetooth: hci0: Frame reassembly failed (-84)
Mar 18 16:16:29 raspberrypi kernel: [ 2283.888082] Bluetooth: hci0: Frame reassembly failed (-84)
Mar 18 16:16:29 raspberrypi kernel: [ 2283.888162] Bluetooth: hci0: Frame reassembly failed (-84)
Mar 18 16:16:29 raspberrypi kernel: [ 2283.888249] Bluetooth: hci0: Frame reassembly failed (-84)
Mar 18 16:16:29 raspberrypi kernel: [ 2283.888335] Bluetooth: hci0: Frame reassembly failed (-84)
Mar 18 16:16:29 raspberrypi kernel: [ 2283.888423] Bluetooth: hci0: Frame reassembly failed (-84)
Mar 18 16:16:29 raspberrypi kernel: [ 2283.997561] Bluetooth: hci0: Frame reassembly failed (-90)
Mar 18 16:16:29 raspberrypi kernel: [ 2283.997586] Bluetooth: hci0: Frame reassembly failed (-84)
Mar 18 16:16:29 raspberrypi kernel: [ 2283.997662] Bluetooth: hci0: Frame reassembly failed (-84)
Mar 18 16:16:29 raspberrypi kernel: [ 2283.997725] Bluetooth: hci0: Frame reassembly failed (-84)
Mar 18 16:16:29 raspberrypi kernel: [ 2283.997813] Bluetooth: hci0: Frame reassembly failed (-84)
Mar 18 16:16:29 raspberrypi kernel: [ 2283.997910] Bluetooth: hci0: Frame reassembly failed (-84)
Mar 18 16:16:29 raspberrypi kernel: [ 2284.190740] Bluetooth: hci0: Frame reassembly failed (-84)
Mar 18 16:16:29 raspberrypi kernel: [ 2284.190835] Bluetooth: hci0: Frame reassembly failed (-84)
Mar 18 16:16:29 raspberrypi kernel: [ 2284.190890] Bluetooth: hci0: Frame reassembly failed (-84)
Mar 18 16:16:29 raspberrypi kernel: [ 2284.190971] Bluetooth: hci0: Frame reassembly failed (-84)
Mar 18 16:16:29 raspberrypi kernel: [ 2284.191011] Bluetooth: hci0: Frame reassembly failed (-84)
Mar 18 16:16:29 raspberrypi kernel: [ 2284.631884] Bluetooth: hci0: Frame reassembly failed (-84)
Mar 18 16:16:29 raspberrypi kernel: [ 2284.631969] Bluetooth: hci0: Frame reassembly failed (-84)
Mar 18 16:16:29 raspberrypi kernel: [ 2284.632081] Bluetooth: hci0: Frame reassembly failed (-84)
Mar 18 16:16:29 raspberrypi kernel: [ 2284.632149] Bluetooth: hci0: Frame reassembly failed (-84)
Mar 18 16:16:29 raspberrypi kernel: [ 2284.632236] Bluetooth: hci0: Frame reassembly failed (-84)
Mar 18 16:16:29 raspberrypi kernel: [ 2284.632290] Bluetooth: hci0: Frame reassembly failed (-84)
Mar 18 16:16:30 raspberrypi kernel: [ 2284.963194] Bluetooth: hci0: Frame reassembly failed (-84)
Mar 18 16:16:30 raspberrypi kernel: [ 2284.963284] Bluetooth: hci0: Frame reassembly failed (-84)
Mar 18 16:16:30 raspberrypi kernel: [ 2285.378102] Bluetooth: hci0: Frame reassembly failed (-90)
Mar 18 16:16:30 raspberrypi kernel: [ 2285.378167] Bluetooth: hci0: Frame reassembly failed (-84)
Mar 18 16:16:30 raspberrypi kernel: [ 2285.378247] Bluetooth: hci0: Frame reassembly failed (-84)
Mar 18 16:16:30 raspberrypi kernel: [ 2285.378334] Bluetooth: hci0: Frame reassembly failed (-84)
Mar 18 16:16:30 raspberrypi kernel: [ 2285.378422] Bluetooth: hci0: Frame reassembly failed (-84)
Mar 18 16:16:30 raspberrypi kernel: [ 2285.378521] Bluetooth: hci0: Frame reassembly failed (-84)
Mar 18 16:16:31 raspberrypi kernel: [ 2285.919597] Bluetooth: hci0: Frame reassembly failed (-84)
Mar 18 16:16:31 raspberrypi kernel: [ 2285.919660] Bluetooth: hci0: Frame reassembly failed (-84)
Mar 18 16:16:31 raspberrypi kernel: [ 2285.919750] Bluetooth: hci0: Frame reassembly failed (-90)
Mar 18 16:16:31 raspberrypi kernel: [ 2285.919838] Bluetooth: hci0: Frame reassembly failed (-90)
Mar 18 16:16:31 raspberrypi kernel: [ 2285.919933] Bluetooth: hci0: Frame reassembly failed (-84)
Mar 18 16:16:31 raspberrypi kernel: [ 2286.033025] Bluetooth: hci0: Frame reassembly failed (-84)
Mar 18 16:16:31 raspberrypi kernel: [ 2286.033091] Bluetooth: hci0: Frame reassembly failed (-84)
Mar 18 16:16:31 raspberrypi kernel: [ 2286.033173] Bluetooth: hci0: Frame reassembly failed (-84)
Mar 18 16:16:31 raspberrypi kernel: [ 2286.033277] Bluetooth: hci0: Frame reassembly failed (-84)
Mar 18 16:16:31 raspberrypi kernel: [ 2286.033350] Bluetooth: hci0: Frame reassembly failed (-84)
Mar 18 16:16:31 raspberrypi kernel: [ 2286.033445] Bluetooth: hci0: Frame reassembly failed (-84)
Mar 18 16:16:31 raspberrypi kernel: [ 2286.055588] Bluetooth: hci0: Frame reassembly failed (-84)
Mar 18 16:16:31 raspberrypi kernel: [ 2286.055656] Bluetooth: hci0: Frame reassembly failed (-84)
Mar 18 16:16:31 raspberrypi kernel: [ 2286.055750] Bluetooth: hci0: Frame reassembly failed (-84)
Mar 18 16:16:31 raspberrypi kernel: [ 2286.055835] Bluetooth: hci0: Frame reassembly failed (-84)
Mar 18 16:16:31 raspberrypi kernel: [ 2286.055915] Bluetooth: hci0: Frame reassembly failed (-84)
Mar 18 16:16:31 raspberrypi kernel: [ 2286.055990] Bluetooth: hci0: Frame reassembly failed (-84)
以降、変わらず

追加で報告します。
この後、syslogを見ていたら、下記のログがbulutoothのエラーの間に出ていました。
ご検討のほど、よろしくお願いします。

Mar 18 16:22:34 raspberrypi candy-pi-lite: [ERROR] No serialport is available
Mar 18 16:22:34 raspberrypi systemd[1]: candy-pi-lite.service: Main process exited, code=exited, status=1/FAILURE
Mar 18 16:22:34 raspberrypi systemd[1]: candy-pi-lite.service: Failed with result ‘exit-code’.
Mar 18 16:22:34 raspberrypi systemd[1]: candy-pi-lite.service: Service RestartSec=100ms expired, scheduling restart.
Mar 18 16:22:34 raspberrypi systemd[1]: candy-pi-lite.service: Scheduled restart job, restart counter is at 2.
Mar 18 16:22:34 raspberrypi systemd[1]: Stopped CANDY Pi Lite Service, version:7.1.0.
Mar 18 16:22:34 raspberrypi systemd[1]: Started CANDY Pi Lite Service, version:7.1.0.
Mar 18 16:22:34 raspberrypi candy-pi-lite: [INFO] Initializing CANDY Pi Lite Board…

[ERROR] No serialport is available
と出ておりますので、シリアルポートの接続がうまくいっていないようです。ただ、以前の投稿を見ますと問題なくシリアルポートは見えているので、インストールがうまくいっていないかもしれません。もし、/boot/config.txtの内容を書き換えている場合は、dtoverlay=sc16is752-spi0-ce1が有効になっているかどうかご確認ください。

$ ls /dev/ttySC1

として結果(/dev/ttySC1)が出ていなければ、インストールし直していただくか、新しいOSイメージからインストールしていただく方が良いかもしれません。
また、インストール済みのOSイメージもありますのでお試しいただければと思います。

ご回答ありがとうございます。
こちらの確認結果ですが、
・config.txtは変更しておらず、dtoverlay=sc16is752-spi0-ce1の記述がありました。
・ls /dev/ttySC1は見えました。
・OSイメージは2月14日版を使っておりました。
なので、最新のOSイメージで試してみます。

以上、よろしくお願いします。

連絡が遅くなり申し訳ありません。
新しいOSイメージを使いましたが、現象は変わりませんでした。
APN設定をやり直した時、sudo apt-get update -yも行ったのですが、
このあたりでファームウエアを書き換えてしまったのが原因ではないかと考えています。
現在使用している環境が下記の場合、動作確認済みのハード、OS、ファームウエアの組合せを教えていただけますでしょうか?
よろしくお願いします。

pi@raspberrypi:/proc/device-tree $ more model
Raspberry Pi 3 Model B Rev 1.2
pi@raspberrypi:/proc/device-tree $ lsb_release -a
No LSB modules are available.
Distributor ID: Raspbian
Description: Raspbian GNU/Linux 10 (buster)
Release: 10
Codename: buster
pi@raspberrypi:~$ uname -a
Linux raspberrypi 4.19.97-v7+ #1294 SMP Thu Jan 30 13:15:58 GMT 2020 armv7l GNU/Linux

ご連絡ありがとうございます。

新しいOSイメージを使いましたが、現象は変わりませんでした。

こちらは、No serial port is availableのままということでしょうか?
APNは設定済みで、[INFO] Waiting for network registration => Status:Searchingがで続けているということでしょうか?

現在使用している環境が下記の場合、動作確認済みのハード、OS、ファームウエアの組合せを教えていただけますでしょうか?

こちらも、同様の環境でも動作させております。

pi@raspberrypi:~ $ more /proc/device-tree/model
Raspberry Pi 3 Model B Rev 1.2
pi@raspberrypi:~ $ lsb_release -a
No LSB modules are available.
Distributor ID:	Raspbian
Description:	Raspbian GNU/Linux 10 (buster)
Release:	10
Codename:	buster
pi@raspberrypi:~ $ uname -a
Linux raspberrypi 4.19.97-v7+ #1294 SMP Thu Jan 30 13:15:58 GMT 2020 armv7l GNU/Linux

他に気になる点としては、

  1. 電源→5V3A~4Aを利用されているかどうか。瞬間的に電力不足が起きている可能性を考慮しています(モジュールは電力不足になるとリセットされるため、Raspberry Piからシリアル通信ができなくなります)。なお、5V4AとなるとRaspberry Pi本体のUSBでは供給できないため、CANDY Pi Lite側へ供給が必要となります(利用ガイド「 DCジャック用ACアダプター」参照)。
  2. GPIO経由またはUSB経由でなんらかの機器を取り付けられているかどうか。何が干渉しているか不明であるため、何か取り付けていればそれを外して動作確認。
  3. USB接続での動作確認→USB通信ケーブル(電源ケーブルではなく)でRaspberryPiとCANDY Pi Liteを接続していただき、動作確認(利用ガイド「USB接続を利用する場合の準備」参照)。

ご確認のほどよろしくお願いいたします。

説明不足で申し訳ありません。

現象は下記のとおりです。
pi@raspberrypi:~ $ sudo candy service restart && tail -f /var/log/syslog |grep serial
Service Restarted
Mar 19 11:58:06 raspberrypi candy-pi-lite: [ERROR] No serialport is available

動作確認済みの
ハード:同じ個体
OS:Linux raspberrypi 4.19.93-v7+ #1290 SMP Fri Jan 10 16:39:50 GMT 2020 armv7l GNU/Linux
ファームウエア:記録がありません。申し訳ありません。
ちなみに下記を行っても現象は変わりませんでした。
$ sudo rpi-update b2b5f9eeb552788317ff3c6a0005c88ae88b8924

その他、
1.電源はCANDY Pi Liteの電源ジャックから供給しています。
2.本体に接続しているものは、
・HDMIケーブル
・USBケーブル
・イーサケーブル
・USB拡張ボード(ケーブル接続なし)
3.USB拡張ボードを使って、RaspberryPiとCANDY Pi Liteを接続したら
Mar 19 12:41:17 raspberrypi candy-pi-lite: [INFO] OK. Registered in the home eps network
がでて、オレンジのLEDが点滅しだしたので、soracomで接続できたようです。
ただ、/var/log/syslogには、
ar 19 12:43:20 raspberrypi kernel: [ 499.783295] Bluetooth: hci0: Frame reassembly failed (-84)
が出続けています。

ログから考えると、CANDYpiとbluetoothで同じシリアルポートを使おうとしてエラーがでていると思われます。
御社で動作確認していただいている環境では、buluetoothは動いていますか?
こちらでは、一度bluetoothを止めて試してみようと思います。

今後のため、USB接続なしでもsoracomに接続できる状態に戻したいので、ご協力をお願いします。

詳細なご確認ありがとうございます。

いただいた情報から、シリアル部分の挙動について詳細な調査が必要と思われますので、恐れ入りますが下記のページをご確認の上、指定の宛先までお送りいただけますでしょうか。

https://www.candy-line.io/お問い合わせ/初期不良センドバック対応/

製品到着後、調査の上回答いたします。
お手数をおかけしますが、よろしくお願いいたします。

丁寧なご対応ありがとうございます。
本日送付させていただきます。
よろしくお願いします。

ご送付いただきありがとうございました。
CANDY Pi Lite LTE-M版をご利用とのことで、SORACOM Air SIM(Plan-D)にて動作確認の調査を行います。
明日には結果をお知らせできると思いますので、今しばらくお待ちくださいませ。

解析ありがとうございます。
お手数をおかけしますが、よろしくお願いします。

大変お待たせいたしました。

調査の結果、接続を行うソフトウェア側において、モジュールの状態(具体的には、シリアルポートのボーレート)が想定と異なっていたため接続処理に失敗しておりました。
この点、修正したバージョンをリリースいたしましたのでそちらをご利用いただければと思います。すでに動作は確認し、問題ないことを実機で確認しております。

機器については本日発送予定です。なお、機器および付属品側に問題はございませんでした。

この度は不具合によりご迷惑をおかけしました。また、調査にご協力いただきまして誠にありがとうございました。

迅速なご解析、ありがとうございました。
以後、気をつけます。
今後とも、よろしくお願いします。

いえいえ、こちらの不具合ですのでお気になさらず、また何かありましたらお気軽にご投稿いただければと思います。
よろしくお願いいたします。

機器到着しました。
ソフトウエアアップデートにてサービスソフトウエアをv7.1.1にすることで、CANDYでppp接続できることを確認できました。
ありがとうございました。

1 Like