Toby-L201 connect failure Ubuntu 18.04 Modem Manager 1.10.6 Linux Kernel Version 4.20.7

Ulrich Mohr u.mohr at semex-engcon.com
Fri Dec 6 07:57:21 UTC 2019 

Hi,

I am not sure, but I think that this is a problem with the UBlox modems 
I was facing before with a TOBY 210.

The problem is that the modem does an automatic registration on the LTE 
network using its default APN (that it gets from the network, when I 
understand right). That is what you see 
(m2m.com.attz.mnc170.mcc310.gprs) as context 4:  (which is the default 
LTE bearer on TOBY). Unfortunately, that does not match the one your 
have given manually, so ModemManager tries to build up a connection 
using the secondary context with the APN settings you have given -- 
which fails, because the service provider does not allow a secondary 
connection while the first one is active.

What I am not completely clear about is, under which circumstances you 
get such a long default APN name (not matching the 'official' ones) from 
the network.

@Aleksander: See 
https://lists.freedesktop.org/archives/modemmanager-devel/2018-August/006633.html

I heavily change the ublox plugin to work around that -- unfortunately I 
never found the time to bring it to a deliverable state, and at the 
moment, I can't even remember what exactly I did. But I can provide the 
sources if needed....

Best regards,

Uli


Am 05.12.2019 um 19:24 schrieb Cale Collins:
> Aleksander,
>
> Thank you for looking into this.
>
> root at bionic-armhf:~# mmcli --modem 0 --simple-connect="apn=m2m.com.attz"
> ModemManager[680]: <info>  [1575569894.762006] Simple connect started...
> ModemManager[680]: <debug> [1575569894.762291]    PIN: unspecified
> ModemManager[680]: <debug> [1575569894.762401]    Operator ID: unspecified
> ModemManager[680]: <debug> [1575569894.762499]    Allowed roaming: yes
> ModemManager[680]: <debug> [1575569894.762594]    APN: m2m.com.attz
> ModemManager[680]: <debug> [1575569894.762686]    IP family: unspecified
> ModemManager[680]: <debug> [1575569894.762778]    Allowed 
> authentication: unspecified
> ModemManager[680]: <debug> [1575569894.762870]    User: unspecified
> ModemManager[680]: <debug> [1575569894.762961]  Password: unspecified
> ModemManager[680]: <info>  [1575569894.763051] Simple connect state 
> (4/8): Wait to get fully enabled
> ModemManager[680]: <info>  [1575569894.763537] Simple connect state 
> (5/8): Register
> ModemManager[680]: <debug> [1575569894.763752] Already registered in 
> network '310410', automatic registration not launched...
> ModemManager[680]: <info>  [1575569894.763951] Simple connect state 
> (6/8): Bearer
> ModemManager[680]: <debug> [1575569894.764072] Creating new bearer...
> ModemManager[680]: <debug> [1575569894.764238] u-blox: checking 
> current USB profile...
> ModemManager[680]: <debug> [1575569894.764388] (ttyACM0) device open 
> count is 2 (open)
> ModemManager[680]: <debug> [1575569894.764643] (ttyACM0): --> 
> 'AT+UUSBCONF?<CR>'
> ModemManager[680]: <debug> [1575569894.767565] (ttyACM0): <-- 
> '<CR><LF>+UUSBCONF: 3,"RNDIS",,"0x1146"<CR><LF>'
> ModemManager[680]: <debug> [1575569894.767977] (ttyACM0): <-- 
> '<CR><LF>OK<CR><LF>'
> ModemManager[680]: <debug> [1575569894.768349] u-blox: usb profile 
> loaded: rndis
> ModemManager[680]: <debug> [1575569894.768462] u-blox: checking 
> current networking mode...
> ModemManager[680]: <debug> [1575569894.768599] (ttyACM0) device open 
> count is 3 (open)
> ModemManager[680]: <debug> [1575569894.768765] (ttyACM0) device open 
> count is 2 (close)
> ModemManager[680]: <debug> [1575569894.768963] (ttyACM0): --> 
> 'AT+UBMCONF?<CR>'
> ModemManager[680]: <debug> [1575569894.778431] (ttyACM0): <-- 
> '<CR><LF>+UBMCONF: 1<CR><LF>'
> ModemManager[680]: <debug> [1575569894.778802] (ttyACM0): <-- 
> '<CR><LF>OK<CR><LF>'
> ModemManager[680]: <debug> [1575569894.779135] u-blox: networking mode 
> loaded: router
> ModemManager[680]: <debug> [1575569894.779251] u-blox: creating u-blox 
> broadband bearer (rndis profile, router mode)...
> ModemManager[680]: <debug> [1575569894.780871] (ttyACM0) device open 
> count is 3 (open)
> ModemManager[680]: <debug> [1575569894.781081] (ttyACM0) device open 
> count is 2 (close)
> ModemManager[680]: <debug> [1575569894.781452] u-blox: new u-blox 
> broadband bearer created at DBus path 
> '/org/freedesktop/ModemManager1/Bearer/0'
> ModemManager[680]: <info>  [1575569894.782125] Simple connect state 
> (7/8): Connect
> ModemManager[680]: <debug> [1575569894.782293] Connecting bearer 
> '/org/freedesktop/ModemManager1/Bearer/0'
> ModemManager[680]: <info>  [1575569894.782484] Modem 
> /org/freedesktop/ModemManager1/Modem/0: state changed (registered -> 
> connecting)
> ModemManager[680]: <debug> [1575569894.784225] Launching 3GPP 
> connection attempt with APN 'm2m.com.attz'
> ModemManager[680]: <debug> [1575569894.784392] No specific IP family 
> requested, defaulting to ipv4
> ModemManager[680]: <debug> [1575569894.784530] No specific IP family 
> requested, defaulting to ipv4
> ModemManager[680]: <debug> [1575569894.784657] Looking for best CID...
> ModemManager[680]: <debug> [1575569894.784804] (ttyACM0) device open 
> count is 3 (open)
> ModemManager[680]: <debug> [1575569894.785036] (ttyACM0) device open 
> count is 2 (close)
> ModemManager[680]: <debug> [1575569894.785237] (ttyACM0): --> 
> 'AT+CGDCONT?<CR>'
> ModemManager[680]: <debug> [1575569894.793937] (ttyACM0): <-- 
> '<CR><LF>+CGDCONT: 1,"IP","m2m.com.attz","",0,0,0,0,0,0<CR><LF>'
> ModemManager[680]: <debug> [1575569894.794405] (ttyACM0): <-- 
> '+CGDCONT: 
> 4,"IP","m2m.com.attz.mnc170.mcc310.gprs","10.246.2.90",0,0,0,0,0,0<CR><LF><CR><LF>OK<CR><LF>'
> ModemManager[680]: <debug> [1575569894.794845] Found '2' PDP contexts
> ModemManager[680]: <debug> [1575569894.794967]   PDP context [cid=1] 
> [type='ipv4'] [apn='m2m.com.attz']
> ModemManager[680]: <debug> [1575569894.795067]   PDP context [cid=4] 
> [type='ipv4'] [apn='m2m.com.attz.mnc170.mcc310.gprs']
> ModemManager[680]: <debug> [1575569894.795171] Found PDP context with 
> CID 1 and PDP type ipv4 for APN 'm2m.com.attz'
> ModemManager[680]: <debug> [1575569894.795349] checking supported 
> authentication methods...
> ModemManager[680]: <debug> [1575569895.126663] (ttyACM0) device open 
> count is 3 (open)
> ModemManager[680]: <debug> [1575569895.127067] (ttyACM0) device open 
> count is 2 (close)
> ModemManager[680]: <debug> [1575569895.127478] (ttyACM0): --> 
> 'AT+UAUTHREQ=?<CR>'
> ModemManager[680]: <debug> [1575569895.135088] (ttyACM0): <-- 
> '<CR><LF>+UAUTHREQ: (1-8),(0-2),,<CR><LF><CR><LF>OK<CR><LF>'
> ModemManager[680]: <debug> [1575569895.135773] Not using authentication
> ModemManager[680]: <debug> [1575569895.136019] setting up 
> authentication preferences in PDP context #1...
> ModemManager[680]: <debug> [1575569895.136291] (ttyACM0) device open 
> count is 3 (open)
> ModemManager[680]: <debug> [1575569895.136604] (ttyACM0) device open 
> count is 2 (close)
> ModemManager[680]: <debug> [1575569895.136992] (ttyACM0): --> 
> 'AT+UAUTHREQ=1,0,"",""<CR>'
> ModemManager[680]: <debug> [1575569895.146146] (ttyACM0): <-- 
> '<CR><LF>OK<CR><LF>'
> ModemManager[680]: <debug> [1575569895.146689] activating PDP context 
> #1...
> ModemManager[680]: <debug> [1575569895.146969] (ttyACM0) device open 
> count is 3 (open)
> ModemManager[680]: <debug> [1575569895.147284] (ttyACM0) device open 
> count is 2 (close)
> ModemManager[680]: <debug> [1575569895.147665] (ttyACM0): --> 
> 'AT+CGACT=1,1<CR>'
> ModemManager[680]: <debug> [1575569895.456167] (ttyACM0): <-- 
> '<CR><LF>+CME ERROR: 100<CR><LF>'
> ModemManager[680]: <debug> [1575569895.456747] Got failure code 100: 
> Unknown error
> ModemManager[680]: <debug> [1575569895.457081] Couldn't connect bearer 
> '/org/freedesktop/ModemManager1/Bearer/0': 'Unknown error'
> ModemManager[680]: <info>  [1575569895.457445] Modem 
> /org/freedesktop/ModemManager1/Modem/0: state changed (connecting -> 
> registered)
> ModemManager[680]: <debug> [1575569895.460077] Couldn't connect 
> bearer: 'Unknown error'
> ModemManager[680]: <debug> [1575569895.462356] (ttyACM0) device open 
> count is 1 (close)
> error: couldn't connect the modem: 
> 'GDBus.Error:org.freedesktop.ModemManager1.Error.MobileEquipment.Unknown: 
> Unknown error'
>
> Best regards,
>
> */Cale Collins/
> Field Applications Engineer
> Gateworks Corporation*
> (805)781-2000 x37*
> *
> 3026 S. Higuera, San Luis Obispo, CA 93401
> www.gateworks.com <http://www.gateworks.com/>
>
>
>
> On Thu, Dec 5, 2019 at 12:35 AM Aleksander Morgado 
> <aleksander at aleksander.es <mailto:aleksander at aleksander.es>> wrote:
>
>     Hey!
>
>     > root at bionic-armhf:~# mmcli -m 0 --enable
>     > successfully enabled the modem
>     > root at bionic-armhf:~# mmcli -m 0 --simple-connect="apn=m2m.com
>     <http://m2m.com>.attz"
>     > error: couldn't connect the modem:
>     >
>     'GDBus.Error:org.freedesktop.ModemManager1.Error.MobileEquipment.Unknown:
>     > Unknown error'
>
>     You need to setup ModemManager running with --debug so that we can
>     look at the debug logs produced, we need to know which specific AT
>     command was the one failing and triggering the simple connect error.
>
>     -- 
>     Aleksander
>     https://aleksander.es
>
>
> _______________________________________________
> ModemManager-devel mailing list
> ModemManager-devel at lists.freedesktop.org
> https://lists.freedesktop.org/mailman/listinfo/modemmanager-devel

-- 
Best regards / Mit freundlichen Grüßen / Salutations distinguées

Ulrich Mohr

SEMEX-EngCon GmbH
Carl-Merz-Strass 26
76275 Ettlingen
Phone: +49 (0) 7243 5143596
email:  u.mohr at semex-engcon.com
___________________________________________
Executive board: A. Stiegler, H.-J. Nitzpon
Commercial register: Mannheim, HRB 718881
Company domicile: Ettlingen

-------------- next part --------------
An HTML attachment was scrubbed...
URL: <https://lists.freedesktop.org/archives/modemmanager-devel/attachments/20191206/2baa556a/attachment-0001.html>

More information about the ModemManager-devel mailing list