Armadilloフォーラム

Armadillo-IoTでのusb1接続エラー(LTE)

kaiyodai

2018年10月18日 20時40分

以下の環境で不明なことが起こっています。

・Armadillo-IoT G3L
・Linux 3.14から4.9に変更(install_disk_sd_20180730_iotg3l.imgを使用)
・SIMはIIJのものを利用

libcurlを使って外部サーバへPOSTする自作アプリを動作させています。
システムを再起動してから12時間も立たないうちに以下のエラーが出ます。

USB1が切られてしまいます。
いろいろ検索した結果、電波が弱いときに通信できないのかと思ったら、
USBがそもそも切断されてしまうので、デバイス状態も確認できないでいます。

しばらく放おって置くと(30分以内)接続されるようです。
数日前は同じ状況でも全然繋がりませんでした。

以下は抜粋なのですが、ここで良いのかわかりませんので、必要な情報があれば
載せたいと思います。

わかる方がいらっしゃいましたらお願い致します。

Oct 18 07:46:35 armadillo kernel: usb 2-1: USB disconnect, device number 6
Oct 18 07:46:35 armadillo kernel: cdc_ether 2-1:1.0 usb1: unregister 'cdc_ether' usb-ci_hdrc.1-1, CDC Ethernet Device
Oct 18 07:46:35 armadillo avahi-daemon[877]: Interface usb1.IPv6 no longer relevant for mDNS.
Oct 18 07:46:35 armadillo avahi-daemon[877]: Leaving mDNS multicast group on interface usb1.IPv6 with address 2001:240:2400:5a0d:3304:653e:b7dc:8ded.
Oct 18 07:46:35 armadillo dhclient[2475]: receive_packet failed on usb1: Network is down
Oct 18 07:46:35 armadillo avahi-daemon[877]: Interface usb1.IPv4 no longer relevant for mDNS.
Oct 18 07:46:35 armadillo avahi-daemon[877]: Leaving mDNS multicast group on interface usb1.IPv4 with address 192.168.15.218.
Oct 18 07:46:35 armadillo avahi-daemon[877]: Withdrawing address record for 2001:240:2400:5a0d:3304:653e:b7dc:8ded on usb1.
Oct 18 07:46:35 armadillo avahi-daemon[877]: Withdrawing address record for 192.168.15.218 on usb1.
Oct 18 07:46:35 armadillo ModemManager[867]: (net/usb1): released by modem /sys/devices/soc0/soc/30800000.aips-bus/30b20000.usb/ci_hdrc.1/usb2/2-1
Oct 18 07:46:35 armadillo NetworkManager[863]: [1539816395.6218] devices removed (path: /sys/devices/soc0/soc/30800000.aips-bus/30b20000.usb/ci_hdrc.1/usb2/2-1/2-1:1.0/net/usb1, iface: usb1)
Oct 18 07:46:35 armadillo kernel: cdc_acm 2-1:1.2: failed to set dtr/rts
Oct 18 07:46:35 armadillo ModemManager[867]: (tty/ttyACM0): released by modem /sys/devices/soc0/soc/30800000.aips-bus/30b20000.usb/ci_hdrc.1/usb2/2-1
Oct 18 07:46:35 armadillo NetworkManager[863]: [1539816395.7082] device (ttyACM0): state change: activated -> unmanaged (reason 'removed') [100 10 36]
Oct 18 07:46:35 armadillo NetworkManager[863]: [1539816395.7749] dhcp4 (usb1): canceled DHCP transaction, DHCP client pid 2475
Oct 18 07:46:35 armadillo NetworkManager[863]: [1539816395.7750] dhcp4 (usb1): state changed bound -> done
Oct 18 07:46:35 armadillo NetworkManager[863]: [1539816395.7826] manager: NetworkManager state is now CONNECTED_LOCAL
Oct 18 07:46:35 armadillo dbus[765]: [system] Activating via systemd: service name='org.freedesktop.nm_dispatcher' unit='dbus-org.freedesktop.nm-dispatcher.service'
Oct 18 07:46:35 armadillo NetworkManager[863]: [1539816395.7989] modem-broadband[ttyACM0]: failed to disconnect modem: GDBus.Error:org.freedesktop.DBus.Error.UnknownMethod: No such interface 'org.freedesktop.ModemManager1.Modem.Simple' on object at path /org/freedesktop/ModemManager1/Modem/1
Oct 18 07:46:35 armadillo systemd[1]: Starting Network Manager Script Dispatcher Service...
Oct 18 07:46:35 armadillo dbus[765]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher'
Oct 18 07:46:35 armadillo systemd[1]: Started Network Manager Script Dispatcher Service.
Oct 18 07:46:35 armadillo nm-dispatcher: req:1 'down' [ttyACM0]: new request (2 scripts)
Oct 18 07:46:35 armadillo nm-dispatcher: req:1 'down' [ttyACM0]: start running ordered scripts...

コメント

> 以下の環境で不明なことが起こっています。

今日は調子いいかなと思ったら、つい今しがたコンソールに以下のメッセージが出ていました。
device numberが増えていっています。

どこから手を出してよいのかわかりません。
なにか解決の糸口でも教えていただければと思います。
そこからまた調べていこうと思います。

よろしくお願いします。

まずはLinux 3.14に戻してみようと思います。

failed to set dtr/rts
cdc_acm 2-1:1.2: failed to set dtr/rts
cdc_acm 2-1:1.2: failed to set dtr/rts
usb 2-1: USB disconnect, device number 7
cdc_ether 2-1:1.0 usb1: unregister 'cdc_ether' usb-ci_hdrc.1-1, CDC Ethernet Device
cdc_acm 2-1:1.2: failed to set dtr/rts
cdc_acm 2-1:1.2: failed to set dtr/rts
usb 2-1: new high-speed USB device number 8 using ci_hdrc
cdc_ether 2-1:1.0 usb1: register 'cdc_ether' at usb-ci_hdrc.1-1, CDC Ethernet Device, 02:80:70:06:61:10
cdc_acm 2-1:1.2: ttyACM0: USB ACM device
IPv6: ADDRCONF(NETDEV_UP): usb1: link is not ready
dc_ether 2-1:1.0 usb1: kevent 12 may have been dropped
usb 2-1: USB disconnect, device number 8
cdc_ether 2-1:1.0 usb1: unregister 'cdc_ether' usb-ci_hdrc.1-1, CDC Ethernet Device
cdc_acm 2-1:1.2: failed to set dtr/rts
usb 2-1: new high-speed USB device number 9 using ci_hdrc
cdc_ether 2-1:1.0 usb1: register 'cdc_ether' at usb-ci_hdrc.1-1, CDC Ethernet Device, 02:80:70:06:61:10
alloc_contig_range: [8c0c8, 8c0cb) PFNs busy
alloc_contig_range: [8c0c8, 8c0cb) PFNs busy
alloc_contig_range: [8c0c8, 8c0cb) PFNs busy
cdc_acm 2-1:1.2: ttyACM0: USB ACM device
IPv6: ADDRCONF(NETDEV_UP): usb1: link is not ready
cdc_ether 2-1:1.0 usb1: kevent 12 may have been dropped
usb 2-1: USB disconnect, device number 9
cdc_ether 2-1:1.0 usb1: unregister 'cdc_ether' usb-ci_hdrc.1-1, CDC Ethernet Device
cdc_acm 2-1:1.2: failed to set dtr/rts
usb 2-1: new high-speed USB device number 10 using ci_hdrc
cdc_ether 2-1:1.0 usb1: register 'cdc_ether' at usb-ci_hdrc.1-1, CDC Ethernet Device, 02:80:70:06:61:10
cdc_acm 2-1:1.2: ttyACM0: USB ACM device
IPv6: ADDRCONF(NETDEV_UP): usb1: link is not ready
cdc_ether 2-1:1.0 usb1: kevent 12 may have been dropped

> まずはLinux 3.14に戻してみようと思います。

戻してみたのですが、いきなり4.9のときと同じエラーで、全くLTEが繋がりません。
購入状態ではLTEに接続せず、Wi-FiとEtherだけだったので、USBに問題があったかは不明です。

以下は「6.2.2. インストールの実行」で行った結果で気になったログです。
SDにはinstall_disk_sd_jessie_20180921_iotg3l.imgを使っています。

ハードが故障したのでしょうか?

=== Step.2 Setup Bootloader ===
/images/u-boot-x1-at17.bin: OK
(stk) : timed out waiting for ldisc to be un-installed
(stk) :ldisc_install = 1(stk) :ldisc installation timeout
(stk) :ldisc_install = 0(stk) : timed out waiting for ldisc to be un-installed
(stk) :ldisc_install = 1usb 2-1: new high-speed USB device number 2 using ci_hdrc
cdc_ether 2-1:1.0 usb1: register 'cdc_ether' at usb-ci_hdrc.1-1, CDC Ethernet Device, 02:80:70:06:61:10
cdc_acm 2-1:1.2: This device cannot do calls on its own. It is not a modem.
(stk) :ldisc installation timeout
(stk) :ldisc_install = 0cdc_acm 2-1:1.2: ttyACM0: USB ACM device
(stk) : timed out waiting for ldisc to be un-installed
(stk) :ldisc_install = 1(stk) :ldisc installation timeout
(stk) :ldisc_install = 0(stk) : timed out waiting for ldisc to be un-installed
(stk) :ldisc_install = 1(stk) :ldisc installation timeout
(stk) :ldisc_install = 0(stk) : timed out waiting for ldisc to be un-installed
Bluetooth: st_register failed -22
usb 2-1: USB disconnect, device number 2
cdc_ether 2-1:1.0 usb1: unregister 'cdc_ether' usb-ci_hdrc.1-1, CDC Ethernet Device

> > まずはLinux 3.14に戻してみようと思います。
>
> 戻してみたのですが、いきなり4.9のときと同じエラーで、全くLTEが繋がりません。
> 購入状態ではLTEに接続せず、Wi-FiとEtherだけだったので、USBに問題があったかは不明です。

現状では上記の接続失敗と21日の朝に一度USBのエラーになり、15分程度で自動に復旧していました。
それから24時間はエラー無しで動作しています。
24時間エラー無しはLTEにしてから初です。
Wi-Fi/優先接続のときはまったくエラーなく何日も動いていました。

Linux 4.9に問題があったのでしょうか?
USBのエラーになる理由が全くわかりません。

返信がないということは私の情報や質問がおかしいのでしょうか?
不安になっています。