ptxdist-2013.12.0 + ModemManager + Cinterion PLS8 rel.1

Raul Suarez Moreno raul.suarez at blue-tc.com
Mon Aug 31 05:17:06 PDT 2015


Finally, ModemManager detected my modem. Problem was the udev startup
script, udevd was not being correctly initiated.

Now, "mmcli -L" shows my modem device correctly. I could enable it and even
send a text SMS, but I am not being successful at using "mmcli -m 0
--simple-connect", always getting:

*error: couldn't connect the modem: 'Timeout was reached'*

And if I use the command with "--timeout=300", the error returned is
because of Network timeout. I've enabled --debug mode in ModemManager and
here it is the log file extract when trying the --simple-connect:

*<info>  [947188221.002169] [mm-iface-modem-simple.c:641]
connect_auth_ready(): Simple connect started...*
*<debug> [947188221.022600] [mm-iface-modem-simple.c:651]
connect_auth_ready():    PIN: unspecified*
*<debug> [947188221.030484] [mm-iface-modem-simple.c:653]
connect_auth_ready():    Operator ID: unspecified*
*<debug> [947188221.038286] [mm-iface-modem-simple.c:655]
connect_auth_ready():    Allowed roaming: yes*
*<debug> [947188221.047354] [mm-iface-modem-simple.c:657]
connect_auth_ready():    APN: airtelnet.es <http://airtelnet.es>*
*<debug> [947188221.056593] [mm-iface-modem-simple.c:665]
connect_auth_ready():    IP family: unspecified*
*<debug> [947188221.064477] [mm-iface-modem-simple.c:673]
connect_auth_ready():    Allowed authentication: unspecified*
*<debug> [947188221.073221] [mm-iface-modem-simple.c:675]
connect_auth_ready():    User: vodafone*
*<debug> [947188221.081010] [mm-iface-modem-simple.c:677]
connect_auth_ready():    Password: vodafone*
*<debug> [947188221.088754] [mm-iface-modem-simple.c:679]
connect_auth_ready():    Number: unspecified*
*<info>  [947188221.097630] [mm-iface-modem-simple.c:469]
connection_step(): Simple connect state (4/8): Wait to get fully enabled*
*<info>  [947188221.107283] [mm-iface-modem-simple.c:478]
connection_step(): Simple connect state (5/8): Register*
*<debug> [947188221.115731] [mm-iface-modem-3gpp.c:397]
mm_iface_modem_3gpp_register_in_network(): Launching automatic network
registration...*
*[/dev/cdc-wdm0] Sent message...*
*<<<<<< RAW:*
*<<<<<<   length = 17*
*<<<<<<   data   = 01:10:00:00:03:04:00:35:00:22:00:04:00:01:01:00:01*
*[/dev/cdc-wdm0] Sent message (translated)...*
*<<<<<< QMUX:*
*<<<<<<   length  = 16*
*<<<<<<   flags   = 0x00*
*<<<<<<   service = "nas"*
*<<<<<<   client  = 4*
*<<<<<< QMI:*
*<<<<<<   flags       = "none"*
*<<<<<<   transaction = 53*
*<<<<<<   tlv_length  = 4*
*<<<<<<   message     = "Initiate Network Register" (0x0022)*
*<<<<<< TLV:*
*<<<<<<   type       = "Action" (0x01)*
*<<<<<<   length     = 1*
*<<<<<<   value      = 01*
*<<<<<<   translated = automatic*
*[/dev/cdc-wdm0] Received message...*
*>>>>>> RAW:*
*>>>>>>   length = 20*
*>>>>>>   data   =
01:13:00:80:03:04:02:35:00:22:00:07:00:02:04:00:00:00:00:00*
*[/dev/cdc-wdm0] Received message (translated)...*
*>>>>>> QMUX:*
*>>>>>>   length  = 19*
*>>>>>>   flags   = 0x80*
*>>>>>>   service = "nas"*
*>>>>>>   client  = 4*
*>>>>>> QMI:*
*>>>>>>   flags       = "response"*
*>>>>>>   transaction = 53*
*>>>>>>   tlv_length  = 7*
*>>>>>>   message     = "Initiate Network Register" (0x0022)*
*>>>>>> TLV:*
*>>>>>>   type       = "Result" (0x02)*
*>>>>>>   length     = 4*
*>>>>>>   value      = 00:00:00:00*
*>>>>>>   translated = SUCCESS*
*<debug> [947188221.161321] [mm-iface-modem-3gpp.c:751]
mm_iface_modem_3gpp_run_registration_checks(): Running registration checks
(CS: 'yes', PS: 'yes', EPS: 'no')*
*[/dev/cdc-wdm0] Sent message...*
*<<<<<< RAW:*
*<<<<<<   length = 13*
*<<<<<<   data   = 01:0C:00:00:03:04:00:36:00:4D:00:00:00*
*[/dev/cdc-wdm0] Sent message (translated)...*
*<<<<<< QMUX:*
*<<<<<<   length  = 12*
*<<<<<<   flags   = 0x00*
*<<<<<<   service = "nas"*
*<<<<<<   client  = 4*
*<<<<<< QMI:*
*<<<<<<   flags       = "none"*
*<<<<<<   transaction = 54*
*<<<<<<   tlv_length  = 0*
*<<<<<<   message     = "Get System Info" (0x004D)*
*[/dev/cdc-wdm0] Received message...*
*>>>>>> RAW:*
*>>>>>>   length = 97*
*>>>>>>   data   =
01:60:00:80:03:04:02:36:00:4D:00:54:00:02:04:00:00:00:00:00:12:03:00:00:00:00:13:03:00:00:00:00:14:03:00:02:02:00:19:1D:00:01:03:01:03:01:00:01:00:00:FF:FF:01:02:0B:66:05:00:00:00:01:32:31*
*:34:30:31:FF:01:02:11:1E:02:00:FF:FF:21:01:00:01:27:04:00:01:00:00:00:29:01:00:00:2A:04:00:00:00:00:00*
*[/dev/cdc-wdm0] Received message (translated)...*
*>>>>>> QMUX:*
*>>>>>>   length  = 96*
*>>>>>>   flags   = 0x80*
*>>>>>>   service = "nas"*
*>>>>>>   client  = 4*
*>>>>>> QMI:*
*>>>>>>   flags       = "response"*
*>>>>>>   transaction = 54*
*>>>>>>   tlv_length  = 84*
*>>>>>>   message     = "Get System Info" (0x004D)*
*>>>>>> TLV:*
*>>>>>>   type       = "Result" (0x02)*
*>>>>>>   length     = 4*
*>>>>>>   value      = 00:00:00:00*
*>>>>>>   translated = SUCCESS*
*>>>>>> TLV:*
*>>>>>>   type       = "GSM Service Status" (0x12)*
*>>>>>>   length     = 3*
*>>>>>>   value      = 00:00:00*
*>>>>>>   translated = [ service_status = 'none' true_service_status =
'none' preferred_data_path = 'no' ]*
*>>>>>> TLV:*
*>>>>>>   type       = "WCDMA Service Status" (0x13)*
*>>>>>>   length     = 3*
*>>>>>>   value      = 00:00:00*
*>>>>>>   translated = [ service_status = 'none' true_service_status =
'none' preferred_data_path = 'no' ]*
*>>>>>> TLV:*
*>>>>>>   type       = "LTE Service Status" (0x14)*
*>>>>>>   length     = 3*
*>>>>>>   value      = 02:02:00*
*>>>>>>   translated = [ service_status = 'available' true_service_status =
'available' preferred_data_path = 'no' ]*
*>>>>>> TLV:*
*>>>>>>   type       = "LTE System Info" (0x19)*
*>>>>>>   length     = 29*
*>>>>>>   value      =
01:03:01:03:01:00:01:00:00:FF:FF:01:02:0B:66:05:00:00:00:01:32:31:34:30:31:FF:01:02:11*
*>>>>>>   translated = [ domain_valid = 'yes' domain = 'cs-ps'
service_capability_valid = 'yes' service_capability = 'cs-ps'
roaming_status_valid = 'yes' roaming_status = 'off' forbidden_valid = 'yes'
forbid*
*den = 'no' lac_valid = 'no' lac = '65535' cid_valid = 'yes' cid =
'90573570' registration_reject_info_valid = 'no' registration_reject_domain
= 'none' registration_reject_cause = '0' network_id_valid = 'yes*
*' mcc = '214' mnc = '01�' tac_valid = 'yes' tac = '4354' ]*
*>>>>>> TLV:*
*>>>>>>   type       = "Additional LTE System Info" (0x1e)*
*>>>>>>   length     = 2*
*>>>>>>   value      = FF:FF*
*>>>>>>   translated = [ geo_system_index = '65535' ]*
*>>>>>> TLV:*
*>>>>>>   type       = "LTE Voice Support" (0x21)*
*>>>>>>   length     = 1*
*>>>>>>   value      = 01*
*>>>>>>   translated = yes*
*>>>>>> TLV:*
*>>>>>>   type       = "SIM Reject Info" (0x27)*
*>>>>>>   length     = 4*
*>>>>>>   value      = 01:00:00:00*
*>>>>>>   translated = vailable*
*>>>>>> TLV:*
*>>>>>>   type   = 0x29*
*>>>>>>   length = 1*
*>>>>>>   value  = 00*
*>>>>>> TLV:*
*>>>>>>   type   = 0x2a*
*>>>>>>   length = 4*
*>>>>>>   value  = 00:00:00:00*
*<info>  [947188221.227560] [mm-iface-modem-3gpp.c:1169]
update_registration_state(): Modem /org/freedesktop/ModemManager1/Modem/0:
3GPP Registration state changed (idle -> unknown)*
*<debug> [947188221.239038] [mm-iface-modem-3gpp.c:287]
run_registration_checks_ready(): Modem not yet registered in a 3GPP
network... will recheck soon*
*<debug> [947188224.081628] [mm-iface-modem-3gpp.c:751]
mm_iface_modem_3gpp_run_registration_checks(): Running registration checks
(CS: 'yes', PS: 'yes', EPS: 'no')*
*[...]*

And it continues that way until timeout. It seems that modem is not
registered, however if I run "mmcli -m 0 --3gpp-scan --timeout=300", next
is returned:

*Found 12 networks:*
*21407 - Movistar (umts, forbidden)*
*21404 - YOIGO (gsm, forbidden)*
*21404 - YOIGO (umts, forbidden)*
*21403 - Orange (umts, forbidden)*
*21407 - Movistar (gsm, forbidden)*
*21403 - Orange (lte, forbidden)*
*21404 - YOIGO (lte, forbidden)*
*21403 - Orange (gsm, forbidden)*
*21407 - Movistar (lte, forbidden)*
*21401 - vodafone ES (lte, current)*
*21401 - Voda ES (umts, available)*
*21401 - Voda ES (gsm, available)*

And if "mmcli -m 0 --3gpp-register-home --timeout=300", same as with
connect:

*error: couldn't register the modem:
'GDBus.Error:org.freedesktop.ModemManager1.Error.MobileEquipment.NetworkTimeout:
Network timeout'*

Maybe some previous settings config missing??

On Thu, Aug 27, 2015 at 3:29 PM, Aleksander Morgado <
aleksander at aleksander.es> wrote:

> On Thu, Aug 27, 2015 at 4:26 PM, Raul Suarez Moreno
> <raul.suarez at blue-tc.com> wrote:
> > Ok, thinks are clearer now.
> >
> > Indeed, I did it. I attached the ModemManager log to this message.
>
> Ah, I see it now in the other email.
>
> Do you have udev setup in your system? Looks like ModemManager wasn't
> notified of any port via udev.
>
> --
> Aleksander
> https://aleksander.es
>



-- 
Saludos / Best regards

Raúl Suárez
Blue TC
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.freedesktop.org/archives/modemmanager-devel/attachments/20150831/f13db041/attachment.html>


More information about the ModemManager-devel mailing list