On Mon, 2015-08-31 at 13:17 +0100, Raul Suarez Moreno wrote: > 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'*
From the traces, I can't figure out why MM thinks the modem isn't registered. Are you able to rebuild MM with some small patches to further debug the issue? Dan > 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 < > aleksan...@aleksander.es> wrote: > > > On Thu, Aug 27, 2015 at 4:26 PM, Raul Suarez Moreno > > <raul.sua...@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 > > > > > > _______________________________________________ > ModemManager-devel mailing list > ModemManager-devel@lists.freedesktop.org > http://lists.freedesktop.org/mailman/listinfo/modemmanager-devel _______________________________________________ ModemManager-devel mailing list ModemManager-devel@lists.freedesktop.org http://lists.freedesktop.org/mailman/listinfo/modemmanager-devel
