LE910 connection with custom APN on AT&T SIM
Nate Pleasant
nate.pleasant at accelerated.com
Wed Jan 24 21:45:04 UTC 2018
Hello,
I have a Telit LE910 modem that ModemManager doesn't seem to be able to connect with when using an AT&T SIM card with a custom APN. See output and debug messages below for reference. If I connect this same SIM card with a Sierra MC7354 or Sierra MC7455 modem, it's able to connect with ModemManager just fine. Is there something I'm missing when connecting with this Telit LE910 modem?
# mmcli --version
mmcli 1.5.993
Copyright (2011) Aleksander Morgado
License GPLv2+: GNU GPL version 2 or later <http://gnu.org/licenses/gpl-2.0.html>
This is free software: you are free to change and redistribute it.
There is NO WARRANTY, to the extent permitted by law.
# mmcli -m 0
/org/freedesktop/ModemManager1/Modem/0 (device id '6e2428cafbad03b44f8a815cd9bd831057a34462')
-------------------------
Hardware | manufacturer: 'Telit'
| model: 'MBIM [1BC7:0032]'
| revision: '20.00.504'
| supported: 'gsm-umts, lte'
| current: 'gsm-umts, lte'
| equipment id: '358148060217853'
-------------------------
System | device: '/sys/devices/platform/soc/soc:internal-regs/d0051000.usb/usb2/2-1'
| drivers: 'cdc_acm, cdc_mbim'
| plugin: 'Telit'
| primary port: 'cdc-wdm0'
| ports: 'ttyACM3 (at), cdc-wdm0 (mbim), wwan0 (net), ttyACM0 (at)'
-------------------------
Numbers | own : '15003130047'
-------------------------
Status | lock: 'none'
| unlock retries: 'sim-pin2 (3)'
| state: 'disabled'
| power state: 'on'
| access tech: 'unknown'
| signal quality: '0' (cached)
-------------------------
Modes | supported: 'allowed: 2g, 3g, 4g; preferred: none'
| current: 'allowed: 2g, 3g, 4g; preferred: none'
-------------------------
Bands | supported: 'unknown'
| current: 'unknown'
-------------------------
IP | supported: 'ipv4, ipv6, ipv4v6'
-------------------------
3GPP | imei: '358148060217853'
| enabled locks: 'fixed-dialing'
| operator id: 'unknown'
| operator name: 'unknown'
| subscription: 'unknown'
| registration: 'unknown'
-------------------------
SIM | path: '/org/freedesktop/ModemManager1/SIM/0'
-------------------------
Bearers | paths: 'none'
# mmcli -m 0 -e
[F03:P06] Jan 23 13:24:34 6355-SR syslog[364]: <info> Modem /org/freedesktop/ModemManager1/Modem/0: state changed (disabled -> enabling)
[F03:P06] Jan 23 13:24:34 6355-SR syslog[364]: <debug> Skipping modem initialization: not required
[F03:P06] Jan 23 13:24:34 6355-SR syslog[364]: <debug> (ttyACM0) opening serial port...
[F03:P06] Jan 23 13:24:34 6355-SR syslog[364]: <debug> (ttyACM0) device open count is 1 (open)
[F03:P06] Jan 23 13:24:34 6355-SR syslog[364]: <debug> (ttyACM0): running init sequence...
[F03:P06] Jan 23 13:24:34 6355-SR syslog[364]: <debug> (ttyACM3) opening serial port...
[F03:P06] Jan 23 13:24:34 6355-SR syslog[364]: <debug> (ttyACM3) device open count is 1 (open)
[F03:P06] Jan 23 13:24:34 6355-SR syslog[364]: <debug> (ttyACM3): running init sequence...
[F03:P06] Jan 23 13:24:34 6355-SR syslog[364]: <debug> Flashing primary AT port before enabling...
[F03:P06] Jan 23 13:24:34 6355-SR syslog[364]: <debug> (ttyACM0): --> 'ATE0<CR>'
[F03:P06] Jan 23 13:24:34 6355-SR syslog[364]: <debug> (ttyACM3): --> 'ATE0<CR>'
[F03:P06] Jan 23 13:24:34 6355-SR syslog[364]: <debug> (ttyACM3): <-- '<CR><LF>OK<CR><LF>'
[F03:P07] Jan 23 13:24:34 6355-SR syslog[364]: [/dev/cdc-wdm0] Sent message... <<<<<< RAW: <<<<<< length = 48 <<<<<< data = 03:00:00:00:30:00:00:00:3B:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:03:00:00:00:00:00:00:00:00:00:00:00
[F03:P07] Jan 23 13:24:34 6355-SR syslog[364]: [/dev/cdc-wdm0] Sent message (translated)... <<<<<< Header: <<<<<< length = 48 <<<<<< type = command (0x00000003) <<<<<< transaction = 59 <<<<<< Fragment header: <<<<<< total = 1 <<<<<< current = 0 <<<<<< Contents: <<<<<< service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df) <<<<<< cid = 'radio-state' (0x00000003) <<<<<< type = 'query' (0x00000000)
[F03:P06] Jan 23 13:24:34 6355-SR syslog[364]: <debug> (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
[F03:P06] Jan 23 13:24:34 6355-SR syslog[364]: <debug> (ttyACM0): --> 'ATV1<CR>'
[F03:P07] Jan 23 13:24:34 6355-SR syslog[364]: [/dev/cdc-wdm0] Received message... >>>>>> RAW: >>>>>> length = 56 >>>>>> data = 03:00:00:80:38:00:00:00:3B:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:03:00:00:00:00:00:00:00:08:00:00:00:01:00:00:00:01:00:00:00
[F03:P07] Jan 23 13:24:34 6355-SR syslog[364]: [/dev/cdc-wdm0] Received message (translated)... >>>>>> Header: >>>>>> length = 56 >>>>>> type = command-done (0x80000003) >>>>>> transaction = 59 >>>>>> Fragment header: >>>>>> total = 1 >>>>>> current = 0 >>>>>> Contents: >>>>>> status error = 'None' (0x00000000) >>>>>> service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df) >>>>>> cid = 'radio-state' (0x00000003)
[F03:P06] Jan 23 13:24:34 6355-SR syslog[364]: <debug> No need to change power state: already in 'on' power state
[F03:P06] Jan 23 13:24:34 6355-SR syslog[364]: <debug> Modem has 3GPP capabilities, enabling the Modem 3GPP interface...
[F03:P06] Jan 23 13:24:34 6355-SR syslog[364]: <debug> Supported notifications: signal (yes), registration (no), sms (no), connect (yes), subscriber (yes), packet (yes)
[F03:P06] Jan 23 13:24:34 6355-SR syslog[364]: <debug> Enabled notifications: signal (yes), registration (no), sms (no), connect (yes), subscriber (yes), packet (yes)
[F03:P07] Jan 23 13:24:34 6355-SR syslog[364]: [/dev/cdc-wdm0] Sent message... <<<<<< RAW: <<<<<< length = 96 <<<<<< data = 03:00:00:00:60:00:00:00:3C:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:13:00:00:00:01:00:00:00:30:00:00:00:01:00:00:00:0C:00:00:00:24:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:04:00:00:00:0B:00:00:00:0C:00:00:00:02:00:00:00:0A:00:00:00
[F03:P07] Jan 23 13:24:34 6355-SR syslog[364]: [/dev/cdc-wdm0] Sent message (translated)... <<<<<< Header: <<<<<< length = 96 <<<<<< type = command (0x00000003) <<<<<< transaction = 60 <<<<<< Fragment header: <<<<<< total = 1 <<<<<< current = 0 <<<<<< Contents: <<<<<< service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df) <<<<<< cid = 'device-service-subscribe-list' (0x00000013) <<<<<< type = 'set' (0x00000001)
[F03:P07] Jan 23 13:24:34 6355-SR syslog[364]: [/dev/cdc-wdm0] Received message... >>>>>> RAW: >>>>>> length = 96 >>>>>> data = 03:00:00:80:60:00:00:00:3C:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:13:00:00:00:00:00:00:00:30:00:00:00:01:00:00:00:0C:00:00:00:24:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:04:00:00:00:0B:00:00:00:0C:00:00:00:02:00:00:00:0A:00:00:00
[F03:P07] Jan 23 13:24:34 6355-SR syslog[364]: [/dev/cdc-wdm0] Received message (translated)... >>>>>> Header: >>>>>> length = 96 >>>>>> type = command-done (0x80000003) >>>>>> transaction = 60 >>>>>> Fragment header: >>>>>> total = 1 >>>>>> current = 0 >>>>>> Contents: >>>>>> status error = 'None' (0x00000000) >>>>>> service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df) >>>>>> cid = 'device-service-subscribe-list' (0x00000013)
[F03:P06] Jan 23 13:24:34 6355-SR syslog[364]: <debug> Supported notifications: signal (yes), registration (yes), sms (no), connect (yes), subscriber (yes), packet (yes)
[F03:P06] Jan 23 13:24:34 6355-SR syslog[364]: <debug> Enabled notifications: signal (yes), registration (yes), sms (no), connect (yes), subscriber (yes), packet (yes)
[F03:P07] Jan 23 13:24:34 6355-SR syslog[364]: [/dev/cdc-wdm0] Sent message... <<<<<< RAW: <<<<<< length = 100 <<<<<< data = 03:00:00:00:64:00:00:00:3D:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:13:00:00:00:01:00:00:00:34:00:00:00:01:00:00:00:0C:00:00:00:28:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:05:00:00:00:0B:00:00:00:09:00:00:00:0C:00:00:00:02:00:00:00:0A:00:00:00
[F03:P07] Jan 23 13:24:34 6355-SR syslog[364]: [/dev/cdc-wdm0] Sent message (translated)... <<<<<< Header: <<<<<< length = 100 <<<<<< type = command (0x00000003) <<<<<< transaction = 61 <<<<<< Fragment header: <<<<<< total = 1 <<<<<< current = 0 <<<<<< Contents: <<<<<< service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df) <<<<<< cid = 'device-service-subscribe-list' (0x00000013) <<<<<< type = 'set' (0x00000001)
[F03:P07] Jan 23 13:24:34 6355-SR syslog[364]: [/dev/cdc-wdm0] Received message... >>>>>> RAW: >>>>>> length = 100 >>>>>> data = 03:00:00:80:64:00:00:00:3D:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:13:00:00:00:00:00:00:00:34:00:00:00:01:00:00:00:0C:00:00:00:28:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:05:00:00:00:0B:00:00:00:09:00:00:00:0C:00:00:00:02:00:00:00:0A:00:00:00
[F03:P07] Jan 23 13:24:34 6355-SR syslog[364]: [/dev/cdc-wdm0] Received message (translated)... >>>>>> Header: >>>>>> length = 100 >>>>>> type = command-done (0x80000003) >>>>>> transaction = 61 >>>>>> Fragment header: >>>>>> total = 1 >>>>>> current = 0 >>>>>> Contents: >>>>>> status error = 'None' (0x00000000) >>>>>> service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df) >>>>>> cid = 'device-service-subscribe-list' (0x00000013)
[F03:P06] Jan 23 13:24:34 6355-SR syslog[364]: <debug> (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
[F03:P06] Jan 23 13:24:34 6355-SR syslog[364]: <debug> Modem has 3GPP/USSD capabilities, enabling the Modem 3GPP/USSD interface...
[F03:P06] Jan 23 13:24:34 6355-SR syslog[364]: <debug> (ttyACM0) Setting unsolicited result code handlers
[F03:P06] Jan 23 13:24:34 6355-SR syslog[364]: <debug> (ttyACM3) Setting unsolicited result code handlers
[F03:P06] Jan 23 13:24:34 6355-SR syslog[364]: <debug> (ttyACM0) device open count is 2 (open)
[F03:P06] Jan 23 13:24:34 6355-SR syslog[364]: <debug> (ttyACM0): --> 'AT+CMEE=1<CR>'
[F03:P06] Jan 23 13:24:34 6355-SR syslog[364]: <debug> (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
[F03:P06] Jan 23 13:24:34 6355-SR syslog[364]: <debug> (ttyACM0): --> 'ATX4<CR>'
[F03:P06] Jan 23 13:24:34 6355-SR syslog[364]: <debug> (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
successfully enabled the modem
#
[F03:P06] Jan 23 13:24:34 6355-SR syslog[364]: <debug> (ttyACM0): --> 'AT&C1<CR>'
[F03:P06] Jan 23 13:24:34 6355-SR syslog[364]: <debug> (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
[F03:P06] Jan 23 13:24:34 6355-SR syslog[364]: <debug> (ttyACM0) device open count is 1 (close)
[F03:P06] Jan 23 13:24:34 6355-SR syslog[364]: <debug> Modem has location capabilities, enabling the Location interface...
[F03:P06] Jan 23 13:24:34 6355-SR syslog[364]: <debug> Need to enable the following location sources: '3gpp-lac-ci'
[F03:P06] Jan 23 13:24:34 6355-SR syslog[364]: <debug> Running registration checks (CS: 'yes', PS: 'yes', EPS: 'no')
[F03:P07] Jan 23 13:24:34 6355-SR syslog[364]: [/dev/cdc-wdm0] Sent message... <<<<<< RAW: <<<<<< length = 48 <<<<<< data = 03:00:00:00:30:00:00:00:3E:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:09:00:00:00:00:00:00:00:00:00:00:00
[F03:P07] Jan 23 13:24:34 6355-SR syslog[364]: [/dev/cdc-wdm0] Sent message (translated)... <<<<<< Header: <<<<<< length = 48 <<<<<< type = command (0x00000003) <<<<<< transaction = 62 <<<<<< Fragment header: <<<<<< total = 1 <<<<<< current = 0 <<<<<< Contents: <<<<<< service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df) <<<<<< cid = 'register-state' (0x00000009) <<<<<< type = 'query' (0x00000000)
[F03:P06] Jan 23 13:24:34 6355-SR syslog[364]: <debug> Modem has messaging capabilities, enabling the Messaging interface...
[F03:P06] Jan 23 13:24:34 6355-SR syslog[364]: <debug> loading SMS parts...
[F03:P07] Jan 23 13:24:34 6355-SR syslog[364]: [/dev/cdc-wdm0] Sent message... <<<<<< RAW: <<<<<< length = 60 <<<<<< data = 03:00:00:00:3C:00:00:00:3F:00:00:00:01:00:00:00:00:00:00:00:53:3F:BE:EB:14:FE:44:67:9F:90:33:A2:23:E5:6C:3F:02:00:00:00:00:00:00:00:0C:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00
[F03:P07] Jan 23 13:24:34 6355-SR syslog[364]: [/dev/cdc-wdm0] Sent message (translated)... <<<<<< Header: <<<<<< length = 60 <<<<<< type = command (0x00000003) <<<<<< transaction = 63 <<<<<< Fragment header: <<<<<< total = 1 <<<<<< current = 0 <<<<<< Contents: <<<<<< service = 'sms' (533fbeeb-14fe-4467-9f90-33a223e56c3f) <<<<<< cid = 'read' (0x00000002) <<<<<< type = 'query' (0x00000000)
[F03:P07] Jan 23 13:24:34 6355-SR syslog[364]: [/dev/cdc-wdm0] Received message... >>>>>> RAW: >>>>>> length = 116 >>>>>> data = 03:00:00:80:74:00:00:00:3E:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:09:00:00:00:00:00:00:00:44:00:00:00:FF:00:00:00:03:00:00:00:01:00:00:00:20:00:00:00:01:00:00:00:30:00:00:00:0C:00:00:00:3C:00:00:00:08:00:00:00:00:00:00:00:00:00:00:00:02:00:00:00:33:00:31:00:30:00:34:00:31:00:30:00:41:00:54:00:26:00:54:00
[F03:P07] Jan 23 13:24:34 6355-SR syslog[364]: [/dev/cdc-wdm0] Received message (translated)... >>>>>> Header: >>>>>> length = 116 >>>>>> type = command-done (0x80000003) >>>>>> transaction = 62 >>>>>> Fragment header: >>>>>> total = 1 >>>>>> current = 0 >>>>>> Contents: >>>>>> status error = 'None' (0x00000000) >>>>>> service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df) >>>>>> cid = 'register-state' (0x00000009)
[F03:P06] Jan 23 13:24:34 6355-SR syslog[364]: <info> Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP Registration state changed (unknown -> registering)
[F03:P06] Jan 23 13:24:34 6355-SR syslog[364]: <debug> Modem /org/freedesktop/ModemManager1/Modem/0: access technology changed (unknown -> lte)
[F03:P06] Jan 23 13:24:34 6355-SR syslog[364]: <debug> Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP location updated (MCC: '310', MNC: '410', Location area code: '0', Cell ID: '0')
[F03:P06] Jan 23 13:24:34 6355-SR syslog[364]: <info> Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP Registration state changed (registering -> home)
[F03:P07] Jan 23 13:24:34 6355-SR syslog[364]: [/dev/cdc-wdm0] Received message... >>>>>> RAW: >>>>>> length = 56 >>>>>> data = 03:00:00:80:38:00:00:00:3F:00:00:00:01:00:00:00:00:00:00:00:53:3F:BE:EB:14:FE:44:67:9F:90:33:A2:23:E5:6C:3F:02:00:00:00:00:00:00:00:08:00:00:00:00:00:00:00:00:00:00:00
[F03:P07] Jan 23 13:24:34 6355-SR syslog[364]: [/dev/cdc-wdm0] Received message (translated)... >>>>>> Header: >>>>>> length = 56 >>>>>> type = command-done (0x80000003) >>>>>> transaction = 63 >>>>>> Fragment header: >>>>>> total = 1 >>>>>> current = 0 >>>>>> Contents: >>>>>> status error = 'None' (0x00000000) >>>>>> service = 'sms' (533fbeeb-14fe-4467-9f90-33a223e56c3f) >>>>>> cid = 'read' (0x00000002)
[F03:P06] Jan 23 13:24:34 6355-SR syslog[364]: <debug> Supported notifications: signal (yes), registration (yes), sms (yes), connect (yes), subscriber (yes), packet (yes)
[F03:P06] Jan 23 13:24:34 6355-SR syslog[364]: <debug> Enabled notifications: signal (yes), registration (yes), sms (yes), connect (yes), subscriber (yes), packet (yes)
[F03:P07] Jan 23 13:24:34 6355-SR syslog[364]: [/dev/cdc-wdm0] Sent message... <<<<<< RAW: <<<<<< length = 136 <<<<<< data = 03:00:00:00:88:00:00:00:40:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:13:00:00:00:01:00:00:00:58:00:00:00:02:00:00:00:14:00:00:00:28:00:00:00:3C:00:00:00:1C:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:05:00:00:00:0B:00:00:00:09:00:00:00:0C:00:00:00:02:00:00:00:0A:00:00:00:53:3F:BE:EB:14:FE:44:67:9F:90:33:A2:23:E5:6C:3F:02:00:00:00:02:00:00:00:05:00:00:00
[F03:P07] Jan 23 13:24:34 6355-SR syslog[364]: [/dev/cdc-wdm0] Sent message (translated)... <<<<<< Header: <<<<<< length = 136 <<<<<< type = command (0x00000003) <<<<<< transaction = 64 <<<<<< Fragment header: <<<<<< total = 1 <<<<<< current = 0 <<<<<< Contents: <<<<<< service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df) <<<<<< cid = 'device-service-subscribe-list' (0x00000013) <<<<<< type = 'set' (0x00000001)
[F03:P07] Jan 23 13:24:34 6355-SR syslog[364]: [/dev/cdc-wdm0] Received message... >>>>>> RAW: >>>>>> length = 136 >>>>>> data = 03:00:00:80:88:00:00:00:40:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:13:00:00:00:00:00:00:00:58:00:00:00:02:00:00:00:14:00:00:00:28:00:00:00:3C:00:00:00:1C:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:05:00:00:00:0B:00:00:00:09:00:00:00:0C:00:00:00:02:00:00:00:0A:00:00:00:53:3F:BE:EB:14:FE:44:67:9F:90:33:A2:23:E5:6C:3F:02:00:00:00:02:00:00:00:05:00:00:00
[F03:P07] Jan 23 13:24:34 6355-SR syslog[364]: [/dev/cdc-wdm0] Received message (translated)... >>>>>> Header: >>>>>> length = 136 >>>>>> type = command-done (0x80000003) >>>>>> transaction = 64 >>>>>> Fragment header: >>>>>> total = 1 >>>>>> current = 0 >>>>>> Contents: >>>>>> status error = 'None' (0x00000000) >>>>>> service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df) >>>>>> cid = 'device-service-subscribe-list' (0x00000013)
[F03:P06] Jan 23 13:24:34 6355-SR syslog[364]: <debug> Modem has voice capabilities, enabling the Voice interface...
[F03:P06] Jan 23 13:24:34 6355-SR syslog[364]: <debug> (ttyACM0) Setting voice unsolicited events handlers
[F03:P06] Jan 23 13:24:34 6355-SR syslog[364]: <debug> (ttyACM3) Setting voice unsolicited events handlers
[F03:P06] Jan 23 13:24:34 6355-SR syslog[364]: <debug> (ttyACM0) device open count is 2 (open)
[F03:P06] Jan 23 13:24:34 6355-SR syslog[364]: <debug> (ttyACM0): --> 'AT+CLIP=1<CR>'
[F03:P06] Jan 23 13:24:34 6355-SR syslog[364]: <debug> (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
[F03:P06] Jan 23 13:24:34 6355-SR syslog[364]: <debug> (ttyACM0): --> 'AT+CRC=1<CR>'
[F03:P06] Jan 23 13:24:34 6355-SR syslog[364]: <debug> (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
[F03:P06] Jan 23 13:24:34 6355-SR syslog[364]: <debug> (ttyACM0) device open count is 1 (close)
[F03:P06] Jan 23 13:24:34 6355-SR syslog[364]: <debug> Modem has time capabilities, enabling the Time interface...
[F03:P06] Jan 23 13:24:34 6355-SR syslog[364]: <info> Modem /org/freedesktop/ModemManager1/Modem/0: state cherror: command failed: 'GDBus.Error:org.freedesktop.ModemManager1.Error.MobileEquipment.Unknown: Unknown error'
anged (enabling -> registered)
[F03:P06] Jan 23 13:24:34 6355-SR syslog[364]: <debug> Periodic access technology checks enabled
[F03:P06] Jan 23 13:24:34 6355-SR syslog[364]: <debug> Running registration checks (CS: 'yes', PS: 'yes', EPS: 'no')
[F03:P07] Jan 23 13:24:34 6355-SR syslog[364]: [/dev/cdc-wdm0] Sent message... <<<<<< RAW: <<<<<< length = 48 <<<<<< data = 03:00:00:00:30:00:00:00:41:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:09:00:00:00:00:00:00:00:00:00:00:00
[F03:P07] Jan 23 13:24:34 6355-SR syslog[364]: [/dev/cdc-wdm0] Sent message (translated)... <<<<<< Header: <<<<<< length = 48 <<<<<< type = command (0x00000003) <<<<<< transaction = 65 <<<<<< Fragment header: <<<<<< total = 1 <<<<<< current = 0 <<<<<< Contents: <<<<<< service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df) <<<<<< cid = 'register-state' (0x00000009) <<<<<< type = 'query' (0x00000000)
[F03:P07] Jan 23 13:24:34 6355-SR syslog[364]: [/dev/cdc-wdm0] Received message... >>>>>> RAW: >>>>>> length = 116 >>>>>> data = 03:00:00:80:74:00:00:00:41:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:09:00:00:00:00:00:00:00:44:00:00:00:FF:00:00:00:03:00:00:00:01:00:00:00:20:00:00:00:01:00:00:00:30:00:00:00:0C:00:00:00:3C:00:00:00:08:00:00:00:00:00:00:00:00:00:00:00:02:00:00:00:33:00:31:00:30:00:34:00:31:00:30:00:41:00:54:00:26:00:54:00
[F03:P07] Jan 23 13:24:34 6355-SR syslog[364]: [/dev/cdc-wdm0] Received message (translated)... >>>>>> Header: >>>>>> length = 116 >>>>>> type = command-done (0x80000003) >>>>>> transaction = 65 >>>>>> Fragment header: >>>>>> total = 1 >>>>>> current = 0 >>>>>> Contents: >>>>>> status error = 'None' (0x00000000) >>>>>> service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df) >>>>>> cid = 'register-state' (0x00000009)
[F03:P06] Jan 23 13:24:34 6355-SR syslog[364]: <debug> Initial 3GPP registration checks finished
[F03:P06] Jan 23 13:24:35 6355-SR syslog[364]: <debug> (ttyACM0) device open count is 2 (open)
[F03:P06] Jan 23 13:24:35 6355-SR syslog[364]: <debug> (ttyACM0): --> 'AT!gstatus?<CR>'
[F03:P06] Jan 23 13:24:35 6355-SR syslog[364]: <debug> (ttyACM0): <-- '<CR><LF>ERROR<CR><LF>'
[F03:P06] Jan 23 13:24:35 6355-SR syslog[364]: <debug> Got failure code 100: Unknown error
[F03:P06] Jan 23 13:24:35 6355-SR syslog[364]: <debug> (ttyACM0) device open count is 1 (close)
#
#
#
#
# [F03:P06] Jan 23 13:24:39 6355-SR syslog[364]: <debug> (ttyACM0) device open count is 2 (open)
[F03:P06] Jan 23 13:24:39 6355-SR syslog[364]: <debug> (ttyACM0): --> 'AT+CCLK?<CR>'
[F03:P06] Jan 23 13:24:39 6355-SR syslog[364]: <debug> (ttyACM0): <-- '<CR><LF>'
[F03:P06] Jan 23 13:24:39 6355-SR syslog[364]: <debug> (ttyACM0): <-- '+CCLK: "18/01/23,13:24:39-20"<CR><LF><CR><LF>OK<CR><LF>'
[F03:P06] Jan 23 13:24:39 6355-SR syslog[364]: <debug> (ttyACM0) device open count is 1 (close)
#
#
#
# mmcli -m 0 --simple-connect="apn=11904.mcs"
error: couldn't connect the modem: 'GDBus.Error:org.freedesktop.libmbim.Error.Status.Failure: Failure'
# [F03:P06] Jan 23 13:25:05 6355-SR syslog[364]: <info> Simple connect started...
[F03:P06] Jan 23 13:25:05 6355-SR syslog[364]: <debug> PIN: unspecified
[F03:P06] Jan 23 13:25:05 6355-SR syslog[364]: <debug> Operator ID: unspecified
[F03:P06] Jan 23 13:25:05 6355-SR syslog[364]: <debug> Allowed roaming: yes
[F03:P06] Jan 23 13:25:05 6355-SR syslog[364]: <debug> APN: 11904.mcs
[F03:P06] Jan 23 13:25:05 6355-SR syslog[364]: <debug> IP family: unspecified
[F03:P06] Jan 23 13:25:05 6355-SR syslog[364]: <debug> Allowed authentication: unspecified
[F03:P06] Jan 23 13:25:05 6355-SR syslog[364]: <debug> User: unspecified
[F03:P06] Jan 23 13:25:05 6355-SR syslog[364]: <debug> Password: unspecified
[F03:P06] Jan 23 13:25:05 6355-SR syslog[364]: <debug> Number: unspecified
[F03:P06] Jan 23 13:25:05 6355-SR syslog[364]: <info> Simple connect state (4/8): Wait to get fully enabled
[F03:P06] Jan 23 13:25:05 6355-SR syslog[364]: <info> Simple connect state (5/8): Register
[F03:P06] Jan 23 13:25:05 6355-SR syslog[364]: <debug> Already registered in network '310410', automatic registration not launched...
[F03:P06] Jan 23 13:25:05 6355-SR syslog[364]: <info> Simple connect state (6/8): Bearer
[F03:P06] Jan 23 13:25:05 6355-SR syslog[364]: <debug> Creating new bearer...
[F03:P06] Jan 23 13:25:05 6355-SR syslog[364]: <debug> Creating MBIM bearer in MBIM modem
[F03:P06] Jan 23 13:25:05 6355-SR syslog[364]: <debug> New bearer created at DBus path '/org/freedesktop/ModemManager1/Bearer/1'
[F03:P06] Jan 23 13:25:05 6355-SR syslog[364]: <info> Simple connect state (7/8): Connect
[F03:P06] Jan 23 13:25:05 6355-SR syslog[364]: <debug> Connecting bearer '/org/freedesktop/ModemManager1/Bearer/1'
[F03:P06] Jan 23 13:25:05 6355-SR syslog[364]: <info> Modem /org/freedesktop/ModemManager1/Modem/0: state changed (registered -> connecting)
[F03:P06] Jan 23 13:25:05 6355-SR syslog[364]: <debug> Launching connection with data port (net/wwan0)
[F03:P06] Jan 23 13:25:05 6355-SR syslog[364]: <debug> Activating packet service...
[F03:P07] Jan 23 13:25:05 6355-SR syslog[364]: [/dev/cdc-wdm0] Sent message... <<<<<< RAW: <<<<<< length = 52 <<<<<< data = 03:00:00:00:34:00:00:00:42:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:0A:00:00:00:01:00:00:00:04:00:00:00:00:00:00:00
[F03:P07] Jan 23 13:25:05 6355-SR syslog[364]: [/dev/cdc-wdm0] Sent message (translated)... <<<<<< Header: <<<<<< length = 52 <<<<<< type = command (0x00000003) <<<<<< transaction = 66 <<<<<< Fragment header: <<<<<< total = 1 <<<<<< current = 0 <<<<<< Contents: <<<<<< service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df) <<<<<< cid = 'packet-service' (0x0000000a) <<<<<< type = 'set' (0x00000001)
[F03:P07] Jan 23 13:25:05 6355-SR syslog[364]: [/dev/cdc-wdm0] Received message... >>>>>> RAW: >>>>>> length = 76 >>>>>> data = 03:00:00:80:4C:00:00:00:42:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:0A:00:00:00:00:00:00:00:1C:00:00:00:00:00:00:00:02:00:00:00:20:00:00:00:80:F0:FA:02:00:00:00:00:80:D1:F0:08:00:00:00:00
[F03:P07] Jan 23 13:25:05 6355-SR syslog[364]: [/dev/cdc-wdm0] Received message (translated)... >>>>>> Header: >>>>>> length = 76 >>>>>> type = command-done (0x80000003) >>>>>> transaction = 66 >>>>>> Fragment header: >>>>>> total = 1 >>>>>> current = 0 >>>>>> Contents: >>>>>> status error = 'None' (0x00000000) >>>>>> service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df) >>>>>> cid = 'packet-service' (0x0000000a)
[F03:P06] Jan 23 13:25:05 6355-SR syslog[364]: <debug> Packet service update:
[F03:P06] Jan 23 13:25:05 6355-SR syslog[364]: <debug> state: 'attached'
[F03:P06] Jan 23 13:25:05 6355-SR syslog[364]: <debug> data class: 'lte'
[F03:P06] Jan 23 13:25:05 6355-SR syslog[364]: <debug> uplink: '50000000' bps
[F03:P06] Jan 23 13:25:05 6355-SR syslog[364]: <debug> downlink: '150000000' bps
[F03:P06] Jan 23 13:25:05 6355-SR syslog[364]: <debug> Listing provisioned contexts...
[F03:P07] Jan 23 13:25:05 6355-SR syslog[364]: [/dev/cdc-wdm0] Sent message... <<<<<< RAW: <<<<<< length = 48 <<<<<< data = 03:00:00:00:30:00:00:00:43:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:0D:00:00:00:00:00:00:00:00:00:00:00
[F03:P07] Jan 23 13:25:05 6355-SR syslog[364]: [/dev/cdc-wdm0] Sent message (translated)... <<<<<< Header: <<<<<< length = 48 <<<<<< type = command (0x00000003) <<<<<< transaction = 67 <<<<<< Fragment header: <<<<<< total = 1 <<<<<< current = 0 <<<<<< Contents: <<<<<< service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df) <<<<<< cid = 'provisioned-contexts' (0x0000000d) <<<<<< type = 'query' (0x00000000)
[F03:P07] Jan 23 13:25:05 6355-SR syslog[364]: [/dev/cdc-wdm0] Received message... >>>>>> RAW: >>>>>> length = 52 >>>>>> data = 03:00:00:80:34:00:00:00:43:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:0D:00:00:00:00:00:00:00:04:00:00:00:00:00:00:00
[F03:P07] Jan 23 13:25:05 6355-SR syslog[364]: [/dev/cdc-wdm0] Received message (translated)... >>>>>> Header: >>>>>> length = 52 >>>>>> type = command-done (0x80000003) >>>>>> transaction = 67 >>>>>> Fragment header: >>>>>> total = 1 >>>>>> current = 0 >>>>>> Contents: >>>>>> status error = 'None' (0x00000000) >>>>>> service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df) >>>>>> cid = 'provisioned-contexts' (0x0000000d)
[F03:P06] Jan 23 13:25:05 6355-SR syslog[364]: <debug> Provisioned contexts found (0):
[F03:P06] Jan 23 13:25:05 6355-SR syslog[364]: <debug> No specific IP family requested, defaulting to ipv4
[F03:P06] Jan 23 13:25:05 6355-SR syslog[364]: <debug> Launching ipv4 connection with APN '11904.mcs'...
[F03:P07] Jan 23 13:25:05 6355-SR syslog[364]: [/dev/cdc-wdm0] Sent message... <<<<<< RAW: <<<<<< length = 128 <<<<<< data = 03:00:00:00:80:00:00:00:44:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:0C:00:00:00:01:00:00:00:50:00:00:00:00:00:00:00:01:00:00:00:3C:00:00:00:12:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:01:00:00:00:7E:5E:2A:7E:4E:6F:72:72:73:6B:65:6E:7E:5E:2A:7E:31:00:31:00:39:00:30:00:34:00:2E:00:6D:00:63:00:73:00:00:00
[F03:P07] Jan 23 13:25:05 6355-SR syslog[364]: [/dev/cdc-wdm0] Sent message (translated)... <<<<<< Header: <<<<<< length = 128 <<<<<< type = command (0x00000003) <<<<<< transaction = 68 <<<<<< Fragment header: <<<<<< total = 1 <<<<<< current = 0 <<<<<< Contents: <<<<<< service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df) <<<<<< cid = 'connect' (0x0000000c) <<<<<< type = 'set' (0x00000001)
[F03:P07] Jan 23 13:25:05 6355-SR syslog[364]: [/dev/cdc-wdm0] Received message... >>>>>> RAW: >>>>>> length = 84 >>>>>> data = 03:00:00:80:54:00:00:00:44:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:0C:00:00:00:02:00:00:00:24:00:00:00:00:00:00:00:03:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00
[F03:P07] Jan 23 13:25:05 6355-SR syslog[364]: [/dev/cdc-wdm0] Received message (translated)... >>>>>> Header: >>>>>> length = 84 >>>>>> type = command-done (0x80000003) >>>>>> transaction = 68 >>>>>> Fragment header: >>>>>> total = 1 >>>>>> current = 0 >>>>>> Contents: >>>>>> status error = 'Failure' (0x00000002) >>>>>> service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df) >>>>>> cid = 'connect' (0x0000000c)
[F03:P06] Jan 23 13:25:05 6355-SR syslog[364]: <debug> Session ID '0': deactivated (IP type: ipv4)
[F03:P06] Jan 23 13:25:05 6355-SR syslog[364]: <debug> Couldn't connect bearer '/org/freedesktop/ModemManager1/Bearer/1': 'Failure'
[F03:P06] Jan 23 13:25:05 6355-SR syslog[364]: <info> Modem /org/freedesktop/ModemManager1/Modem/0: state changed (connecting -> registered)
[F03:P06] Jan 23 13:25:05 6355-SR syslog[364]: <debug> Couldn't connect bearer: 'Failure'
Nate Pleasant
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <https://lists.freedesktop.org/archives/modemmanager-devel/attachments/20180124/4fa985e3/attachment-0001.html>
More information about the ModemManager-devel
mailing list