troubleshooting Chatty / modem? no SMS outbound
#1
Big Grin 
Any pointers on troubleshooting a modem that keeps unregistering?

I switched to USMobile SIM and cannot send SMS / MMS.  SMS & MMS _inbound_ does work (Yes, MMS in Chatty! Big Grin ) and calls _do_ work inbound & outbound (voice is loud & clear!). 

Just SMS / MMS outbound is NOT working.  And when I try outbound, the modem goes back to "Unregistered", searching, and re-registers; but the "sent" SMS is never received ... logs make it sound like the modem is being rejected.

When I put this USMobile SIM into my daily driver (a MotoG8 running stock Android), everything works.  So it's not a borked SIM. 

One odd thing: my Moto8G modem detects this SIM's cellular network as "T-Mobile", but the APN & MMSC details in Android do indeed match USMobile's website for Androids.  Those APN & MMSC details are what I have setup in Mobian Bookworm.

I've put ModemManager into debug mode but don't really know what to look for ... and perhaps debug is overkill.  Did I miss something obvious in setting up USMobile?

Logs that repeat are below that have rejects in them:


Code:
Feb 13 10:07:12 mobian ModemManager[604]: <info>  [modem0] power state updated: on
Feb 13 10:07:12 mobian eg25manager[505]: Response: [+QIND: SMS DONE]
Feb 13 10:07:12 mobian eg25manager[505]: Executed soft sleep sequence
Feb 13 10:07:13 mobian ModemManager[604]: <info>  [modem0] 3GPP registration state changed (unknown -> searching)
Feb 13 10:07:13 mobian ModemManager[604]: <warn>  [modem0] couldn't load operator code: Current operator MCC/MNC is still unknown
Feb 13 10:07:13 mobian ModemManager[604]: <warn>  [modem0] couldn't load operator name: Current operator id is still unknown
Feb 13 10:07:13 mobian ModemManager[604]: <info>  [modem0] state changed (enabling -> searching)
Feb 13 10:07:13 mobian mmsdtng[2272]: ../plugins/modemmanager.c:modem_state_changed_cb() State Change: Old State: 5 New State: 7, Reason: 1
Feb 13 10:07:13 mobian mmsdtng[2272]: ../plugins/modemmanager.c:mmsd_mm_get_modem_state() MM_MODEM_GOOD_STATE: 7
Feb 13 10:07:13 mobian mmsdtng[2272]: ../plugins/modemmanager.c:mmsd_mm_state() MMSD_MM_STATE_READY
Feb 13 10:07:13 mobian mmsdtng[2272]: ../plugins/modemmanager.c:mmsd_mm_state() Setting Bearer Handler
Feb 13 10:07:13 mobian mmsdtng[2272]: ../src/service.c:mms_service_set_bearer_handler() service 0x55928f13d0 handler 0x5568a66820
Feb 13 10:07:13 mobian NetworkManager[500]: <info>  [1644768433.5067] modem["cdc-wdm0"]: modem state changed, 'enabling' --> 'searching' (reason: user-requested)
Feb 13 10:07:52 mobian ModemManager[604]: <info>  [modem0] 3GPP registration state changed (searching -> idle)
Feb 13 10:07:52 mobian ModemManager[604]: <info>  [modem0] state changed (searching -> enabled)
Feb 13 10:07:52 mobian NetworkManager[500]: <info>  [1644768472.1250] modem["cdc-wdm0"]: modem state changed, 'searching' --> 'enabled' (reason: unknown)
Feb 13 10:07:52 mobian mmsdtng[2272]: ../plugins/modemmanager.c:modem_state_changed_cb() State Change: Old State: 7 New State: 6, Reason: 0
Feb 13 10:07:52 mobian mmsdtng[2272]: ../plugins/modemmanager.c:mmsd_mm_get_modem_state() MM_MODEM_GOOD_STATE: 6
Feb 13 10:07:52 mobian ModemManager[604]: <warn>  [modem0] network reject indication received
Feb 13 10:07:52 mobian mmsdtng[2272]: ../plugins/modemmanager.c:mmsd_mm_state() MMSD_MM_STATE_READY
Feb 13 10:07:52 mobian ModemManager[604]: <warn>  [modem0]   service domain: ps
Feb 13 10:07:52 mobian mmsdtng[2272]: ../plugins/modemmanager.c:mmsd_mm_state() Setting Bearer Handler
Feb 13 10:07:52 mobian ModemManager[604]: <warn>  [modem0]   radio interface: lte
Feb 13 10:07:52 mobian mmsdtng[2272]: ../src/service.c:mms_service_set_bearer_handler() service 0x55928f13d0 handler 0x5568a66820
Feb 13 10:07:52 mobian ModemManager[604]: <warn>  [modem0]   reject cause: ps-services-in-location-area-not-allowed
Feb 13 10:07:52 mobian ModemManager[604]: <warn>  [modem0] network reject indication received
Feb 13 10:07:52 mobian ModemManager[604]: <warn>  [modem0]   service domain: ps
Feb 13 10:07:52 mobian ModemManager[604]: <warn>  [modem0]   radio interface: lte
Feb 13 10:07:52 mobian ModemManager[604]: <warn>  [modem0]   reject cause: ps-services-in-location-area-not-allowed
Feb 13 10:07:53 mobian ModemManager[604]: <warn>  [modem0] network reject indication received
Feb 13 10:07:53 mobian ModemManager[604]: <warn>  [modem0]   service domain: cs-ps
Feb 13 10:07:53 mobian ModemManager[604]: <warn>  [modem0]   radio interface: lte
Feb 13 10:07:53 mobian ModemManager[604]: <warn>  [modem0]   reject cause: plmn-not-allowed
Feb 13 10:07:53 mobian ModemManager[604]: <warn>  [modem0] network reject indication received
Feb 13 10:07:53 mobian ModemManager[604]: <warn>  [modem0]   service domain: cs-ps
Feb 13 10:07:53 mobian ModemManager[604]: <warn>  [modem0]   radio interface: lte
Feb 13 10:07:53 mobian ModemManager[604]: <warn>  [modem0]   reject cause: roaming-in-location-area-not-allowed
Feb 13 10:07:54 mobian ModemManager[604]: <info>  [modem0] 3GPP registration state changed (idle -> registering)
Feb 13 10:07:54 mobian ModemManager[604]: <info>  [modem0] 3GPP registration state changed (registering -> home)
Feb 13 10:07:54 mobian ModemManager[604]: <info>  [modem0] state changed (enabled -> registered)
Feb 13 10:07:55 mobian mmsdtng[2272]: ../plugins/modemmanager.c:modem_state_changed_cb() State Change: Old State: 6 New State: 8, Reason: 0
Feb 13 10:07:55 mobian mmsdtng[2272]: ../plugins/modemmanager.c:mmsd_mm_get_modem_state() MM_MODEM_GOOD_STATE: 8
Feb 13 10:07:55 mobian mmsdtng[2272]: ../plugins/modemmanager.c:mmsd_mm_state() MMSD_MM_STATE_READY
Feb 13 10:07:55 mobian mmsdtng[2272]: ../plugins/modemmanager.c:mmsd_mm_state() Setting Bearer Handler
Feb 13 10:07:55 mobian mmsdtng[2272]: ../src/service.c:mms_service_set_bearer_handler() service 0x55928f13d0 handler 0x5568a66820
Feb 13 10:08:47 mobian NetworkManager[500]: <info>  [1644768527.4008] modem["cdc-wdm0"]: modem state changed, 'enabled' --> 'searching' (reason: unknown)
Feb 13 10:08:49 mobian ModemManager[604]: <warn>  [modem0] network reject indication received
Feb 13 10:08:49 mobian ModemManager[604]: <warn>  [modem0]   service domain: cs-ps
Feb 13 10:08:49 mobian ModemManager[604]: <warn>  [modem0]   radio interface: lte
Feb 13 10:08:49 mobian ModemManager[604]: <warn>  [modem0]   reject cause: plmn-not-allowed
  Reply
#2
(02-13-2022, 11:26 AM)vap0rtranz Wrote: Any pointers on troubleshooting a modem that keeps unregistering?

I switched to USMobile SIM and cannot send SMS / MMS.  SMS & MMS _inbound_ does work (Yes, MMS in Chatty! Big Grin ) and calls _do_ work inbound & outbound (voice is loud & clear!). 

Just SMS / MMS outbound is NOT working.  And when I try outbound, the modem goes back to "Unregistered", searching, and re-registers; but the "sent" SMS is never received ... logs make it sound like the modem is being rejected.

When I put this USMobile SIM into my daily driver (a MotoG8 running stock Android), everything works.  So it's not a borked SIM. 

One odd thing: my Moto8G modem detects this SIM's cellular network as "T-Mobile", but the APN & MMSC details in Android do indeed match USMobile's website for Androids.  Those APN & MMSC details are what I have setup in Mobian Bookworm.

I've put ModemManager into debug mode but don't really know what to look for ... and perhaps debug is overkill.  Did I miss something obvious in setting up USMobile?

Logs that repeat are below that have rejects in them:


Code:
Feb 13 10:07:12 mobian ModemManager[604]: <info>  [modem0] power state updated: on
Feb 13 10:07:12 mobian eg25manager[505]: Response: [+QIND: SMS DONE]
Feb 13 10:07:12 mobian eg25manager[505]: Executed soft sleep sequence
Feb 13 10:07:13 mobian ModemManager[604]: <info>  [modem0] 3GPP registration state changed (unknown -> searching)
Feb 13 10:07:13 mobian ModemManager[604]: <warn>  [modem0] couldn't load operator code: Current operator MCC/MNC is still unknown
Feb 13 10:07:13 mobian ModemManager[604]: <warn>  [modem0] couldn't load operator name: Current operator id is still unknown
Feb 13 10:07:13 mobian ModemManager[604]: <info>  [modem0] state changed (enabling -> searching)
Feb 13 10:07:13 mobian mmsdtng[2272]: ../plugins/modemmanager.c:modem_state_changed_cb() State Change: Old State: 5 New State: 7, Reason: 1
Feb 13 10:07:13 mobian mmsdtng[2272]: ../plugins/modemmanager.c:mmsd_mm_get_modem_state() MM_MODEM_GOOD_STATE: 7
Feb 13 10:07:13 mobian mmsdtng[2272]: ../plugins/modemmanager.c:mmsd_mm_state() MMSD_MM_STATE_READY
Feb 13 10:07:13 mobian mmsdtng[2272]: ../plugins/modemmanager.c:mmsd_mm_state() Setting Bearer Handler
Feb 13 10:07:13 mobian mmsdtng[2272]: ../src/service.c:mms_service_set_bearer_handler() service 0x55928f13d0 handler 0x5568a66820
Feb 13 10:07:13 mobian NetworkManager[500]: <info>  [1644768433.5067] modem["cdc-wdm0"]: modem state changed, 'enabling' --> 'searching' (reason: user-requested)
Feb 13 10:07:52 mobian ModemManager[604]: <info>  [modem0] 3GPP registration state changed (searching -> idle)
Feb 13 10:07:52 mobian ModemManager[604]: <info>  [modem0] state changed (searching -> enabled)
Feb 13 10:07:52 mobian NetworkManager[500]: <info>  [1644768472.1250] modem["cdc-wdm0"]: modem state changed, 'searching' --> 'enabled' (reason: unknown)
Feb 13 10:07:52 mobian mmsdtng[2272]: ../plugins/modemmanager.c:modem_state_changed_cb() State Change: Old State: 7 New State: 6, Reason: 0
Feb 13 10:07:52 mobian mmsdtng[2272]: ../plugins/modemmanager.c:mmsd_mm_get_modem_state() MM_MODEM_GOOD_STATE: 6
Feb 13 10:07:52 mobian ModemManager[604]: <warn>  [modem0] network reject indication received
Feb 13 10:07:52 mobian mmsdtng[2272]: ../plugins/modemmanager.c:mmsd_mm_state() MMSD_MM_STATE_READY
Feb 13 10:07:52 mobian ModemManager[604]: <warn>  [modem0]   service domain: ps
Feb 13 10:07:52 mobian mmsdtng[2272]: ../plugins/modemmanager.c:mmsd_mm_state() Setting Bearer Handler
Feb 13 10:07:52 mobian ModemManager[604]: <warn>  [modem0]   radio interface: lte
Feb 13 10:07:52 mobian mmsdtng[2272]: ../src/service.c:mms_service_set_bearer_handler() service 0x55928f13d0 handler 0x5568a66820
Feb 13 10:07:52 mobian ModemManager[604]: <warn>  [modem0]   reject cause: ps-services-in-location-area-not-allowed
Feb 13 10:07:52 mobian ModemManager[604]: <warn>  [modem0] network reject indication received
Feb 13 10:07:52 mobian ModemManager[604]: <warn>  [modem0]   service domain: ps
Feb 13 10:07:52 mobian ModemManager[604]: <warn>  [modem0]   radio interface: lte
Feb 13 10:07:52 mobian ModemManager[604]: <warn>  [modem0]   reject cause: ps-services-in-location-area-not-allowed
Feb 13 10:07:53 mobian ModemManager[604]: <warn>  [modem0] network reject indication received
Feb 13 10:07:53 mobian ModemManager[604]: <warn>  [modem0]   service domain: cs-ps
Feb 13 10:07:53 mobian ModemManager[604]: <warn>  [modem0]   radio interface: lte
Feb 13 10:07:53 mobian ModemManager[604]: <warn>  [modem0]   reject cause: plmn-not-allowed
Feb 13 10:07:53 mobian ModemManager[604]: <warn>  [modem0] network reject indication received
Feb 13 10:07:53 mobian ModemManager[604]: <warn>  [modem0]   service domain: cs-ps
Feb 13 10:07:53 mobian ModemManager[604]: <warn>  [modem0]   radio interface: lte
Feb 13 10:07:53 mobian ModemManager[604]: <warn>  [modem0]   reject cause: roaming-in-location-area-not-allowed
Feb 13 10:07:54 mobian ModemManager[604]: <info>  [modem0] 3GPP registration state changed (idle -> registering)
Feb 13 10:07:54 mobian ModemManager[604]: <info>  [modem0] 3GPP registration state changed (registering -> home)
Feb 13 10:07:54 mobian ModemManager[604]: <info>  [modem0] state changed (enabled -> registered)
Feb 13 10:07:55 mobian mmsdtng[2272]: ../plugins/modemmanager.c:modem_state_changed_cb() State Change: Old State: 6 New State: 8, Reason: 0
Feb 13 10:07:55 mobian mmsdtng[2272]: ../plugins/modemmanager.c:mmsd_mm_get_modem_state() MM_MODEM_GOOD_STATE: 8
Feb 13 10:07:55 mobian mmsdtng[2272]: ../plugins/modemmanager.c:mmsd_mm_state() MMSD_MM_STATE_READY
Feb 13 10:07:55 mobian mmsdtng[2272]: ../plugins/modemmanager.c:mmsd_mm_state() Setting Bearer Handler
Feb 13 10:07:55 mobian mmsdtng[2272]: ../src/service.c:mms_service_set_bearer_handler() service 0x55928f13d0 handler 0x5568a66820
Feb 13 10:08:47 mobian NetworkManager[500]: <info>  [1644768527.4008] modem["cdc-wdm0"]: modem state changed, 'enabled' --> 'searching' (reason: unknown)
Feb 13 10:08:49 mobian ModemManager[604]: <warn>  [modem0] network reject indication received
Feb 13 10:08:49 mobian ModemManager[604]: <warn>  [modem0]   service domain: cs-ps
Feb 13 10:08:49 mobian ModemManager[604]: <warn>  [modem0]   radio interface: lte
Feb 13 10:08:49 mobian ModemManager[604]: <warn>  [modem0]   reject cause: plmn-not-allowed

Not certain it will apply here & now,
But an issue that sounded like your description -- from the Brave Heart days,
Is "Regions & Languages" completely filled in,  in the settings ?
      LINUX = CHOICES
         **BCnAZ**
               Idea
   Donate to $upport
your favorite OS Team
  Reply
#3
(02-13-2022, 10:54 PM)bcnaz Wrote: Not certain it will apply here & now,
But an issue that sounded like your description -- from the Brave Heart days,
Is "Regions & Languages" completely filled in,  in the settings ?

I checked Region & Languages and they're filled in.

You may be onto something about history / from back in the Brave Heart days.  2 users described the same symptom on USMobile back in 2020, but different log messages, and evidently new Brave Heart builds fixed their issue:

https://forum.pine64.org/showthread.php?...546&page=2

So, I should file a bug? or chat devs on Matrix?
  Reply
#4
(02-14-2022, 06:36 AM)vap0rtranz Wrote:
(02-13-2022, 10:54 PM)bcnaz Wrote: Not certain it will apply here & now,
But an issue that sounded like your description -- from the Brave Heart days,
Is "Regions & Languages" completely filled in,  in the settings ?

I checked Region & Languages and they're filled in.

You may be onto something about history / from back in the Brave Heart days.  2 users described the same symptom on USMobile back in 2020, but different log messages, and evidently new Brave Heart builds fixed their issue:

https://forum.pine64.org/showthread.php?...546&page=2

So, I should file a bug? or chat devs on Matrix?

What operating system and which desktop are you using.?
      LINUX = CHOICES
         **BCnAZ**
               Idea
   Donate to $upport
your favorite OS Team
  Reply
#5
(02-14-2022, 08:41 AM)bcnaz Wrote: What operating system and which desktop are you using.?

I've tested:
Mobian Bookworm
PostmarketOS (v21.12.1).

I've also tested 2 MVNOs via 2 SIM cards:
USMobile (running off T-Mobile in my location)
Cellcom (running off Verizon)

Combos of the above all yield the same symptom: no outbound SMS.

Poking around a lot on this, I found this Issue already filed SMS send don't work in 4G-mode:
https://github.com/Biktorgj/pinephone_mo.../issues/40

I tried the 2 workarounds in that ^ issue:
Code:
{ cmd = "QCFG", subcmd = "ims", expect = "2" },

and (separately):

Code:
AT+CGSMS=3
... # retest
AT+CGSMS=1
... # retest

And another issue filed in Mobian about configuring the modem settings to be compatible with various carriers:
https://gitlab.com/mobian1/issues/-/issues/254

I'll retry to double check that I didn't fat finger a reconfig.

FWIW: the modem is more stable on Cellcom; on USMobile, the modem frequently unregisters & re-registers whether 4G|3G|2G preferred, and does that consistently on SMS send. So do folks think a newer modem firmware would stabilize USMobile ??  I'm on stock original for PPv1.2a (the PostmarketOS CE).

P.S.  I've ordered a new Ting SM to teston them.
  Reply
#6
UPDATE:

I got SMS outbound working.  I had indeed fat fingered an recommended re-config, but for the benefit of anyone on a troublesome carrier, here's what it is:

Copy the Quectel modem daemon config to prevent updates from overriding:

Code:
sudo cp /usr/share/eg25-manager/pine64,pinephone-1.2.toml /etc/eg25-manager/

NOTE: there's several of these TOML files under /usr/share so copy the specific version of phone you have. I have a PPv1.2.

Reconfigure the modem to _disable_ IMS over 4G:

Code:
{ cmd = "QCFG", subcmd = "ims", value = "2" },

WARN: that ^ was where I'd fat fingered an earlier test.  The default config is '..., expect = "1"' and I had accidentally fat fingered to '..., expect = "2"'.  Notice 'expect' versus 'value'.

NOTE: this eg25-manager (Quectel modem "manager") has _nothing_ to do with ModemManager.  I had tried some reconfigs in ModemManager's configs (via NetworkManager) based on other suggestions but they had no affect on SMS issues. Also, there's no Chatty config that should affect plain txt SMS; just MMS, so I should probably change the subject? Testing via 'mmcli [...] -s [N] --send' makes that more clear.

Reboot and SMS outbound now works on USMobile.

Evidently this IMS setting has caused forum member's SMS frustration in the past: https://forum.pine64.org/showthread.php?...#pid101233
  Reply


Possibly Related Threads…
Thread Author Replies Views Last Post
  Modem white list aular 7 2,192 02-13-2024, 04:35 PM
Last Post: aular
  qcell modem id aular 6 2,096 01-15-2024, 10:05 PM
Last Post: aular
  Temporary fix for Modem Not Coming Back on in SXMO Postmarketos Pinephone kebab 2 2,643 07-16-2023, 11:14 AM
Last Post: kebab
  Modem gets disabled on every suspend jojuma 5 2,623 03-27-2023, 02:51 AM
Last Post: jojuma
  Troubleshooting and Understanding MMS epiii2 74 48,084 02-16-2023, 11:29 AM
Last Post: npesall
  Modem audio settings jack1 2 1,782 02-04-2023, 04:01 PM
Last Post: jack1
  The modem switch affects the connection to battery? JohnDoe 2 2,560 03-30-2022, 12:02 AM
Last Post: JohnDoe
  Modem disabled, can't enable: Invalid transition pac 4 4,458 03-23-2022, 01:08 PM
Last Post: Firewave
Question Modem problems with the distros I tried UltraBlack_ 9 6,502 02-21-2022, 01:57 PM
Last Post: KNERD
  PinePhone Beta 3GB modem not working hannescam 15 11,071 01-19-2022, 02:08 AM
Last Post: bcnaz

Forum Jump:


Users browsing this thread: 2 Guest(s)