On Wed, 2013-10-02 at 08:05 -0700, Kenneth Berland wrote: > List, > > Trying to get a Sierra Wireless MC8355 - Gobi 3000 working on the AT&T > network here in the Bay Area. It works on T-Mobile (see my earlier post > to this list). > > NM moves along well until it errors-out with these lines (I think): > > Oct 2 07:35:50 ken-x230 ModemManager[1811]: <info> error: couldn't start > network: QMI protocol error (14): 'CallFailed' > Oct 2 07:35:50 ken-x230 ModemManager[1811]: <info> call end reason (1018): > 'gsm-wcdma-option-unsubscribed' > Oct 2 07:35:50 ken-x230 ModemManager[1811]: <info> verbose call end reason > (6,33): [3gpp] option-unsubscribed > Oct 2 07:35:50 ken-x230 ModemManager[1811]: <info> error: couldn't get > current settings: QMI protocol error (15): 'OutOfCall' > > Is anyone running on AT&T who can share their configs?
Unsubscribed may mean your SIM has not been activated with AT&T or has been *de*activated due to lack of use or something like that. Does it work in other devices, or in a phone? Dan > Here is what I think the relevant sysinfo might be, and below that are my > full logs for the time of the failure. > > TIA, > Ken > > ken@ken-x230: ~$ grep ModemManager /var/log/syslog* | grep starting | tail -1 > /var/log/syslog.1:Oct 1 17:31:14 ken-x230 ModemManager[15881]: <info> > ModemManager (version 0.7.990) starting... > ken@ken-x230: ~$ NetworkManager --version > 0.9.9.0 > ken@ken-x230: ~$ mmcli -L > > Found 1 modems: > /org/freedesktop/ModemManager1/Modem/4 [Sierra Wireless Inc] Sierra > Wireless MC8355 - Gobi 3000(TM) Module > > ken@ken-x230: ~$ mmcli -m 4 > > /org/freedesktop/ModemManager1/Modem/4 (device id > '48e19cdd7c73e6030ba12406b9c0bd7cc283d929') > ------------------------- > Hardware | manufacturer: 'Sierra Wireless Inc' > | model: 'Sierra Wireless MC8355 - Gobi 3000(TM) Module' > | revision: 'D3200-STSUGN-1580 1 [Jul 08 2011 18:00:00]' > | capabilities: 'gsm-umts' > | current: 'gsm-umts' > | equipment id: '35x569x423x602x' > ------------------------- > System | device: '/sys/devices/pci0000:00/0000:00:14.0/usb3/3-4' > | drivers: 'qcserial, qmi_wwan' > | plugin: 'Gobi' > | primary port: 'cdc-wdm0' > ------------------------- > Numbers | own : '1xxx693x3xx' > ------------------------- > Status | lock: 'sim-pin2' > | unlock retries: 'sim-pin (3), sim-pin2 (3), sim-puk (10), > sim-puk2 (10)' > | state: 'registered' > | access tech: 'umts' > | signal quality: '92' (cached) > ------------------------- > Modes | supported: '2g, 3g' > | allowed: '2g, 3g' > | preferred: 'none' > ------------------------- > Bands | supported: 'cdma-bc15-aws, dcs, egsm, pcs, g850, u2100, > u1900, u800, u850, u900' > | current: 'cdma-bc15-aws, dcs, egsm, pcs, g850, u2100, > u1900, u800, u850, u900' > ------------------------- > 3GPP | imei: '35xx6x04x34x02x' > | enabled locks: 'none' > | operator id: '310410' > | operator name: 'AT&T' > | registration: 'home' > ------------------------- > SIM | path: '/org/freedesktop/ModemManager1/SIM/4' > > > > Oct 2 07:35:33 ken-x230 ModemManager[1811]: <info> Modem enabling... > Oct 2 07:35:33 ken-x230 ModemManager[1811]: <info> Modem > /org/freedesktop/ModemManager1/Modem/4: state changed (disabled -> enabling) > Oct 2 07:35:33 ken-x230 ModemManager[1811]: <info> (ttyUSB1) opening serial > port... > Oct 2 07:35:33 ken-x230 ModemManager[1811]: <warn> (ttyUSB1): port > attributes not fully set > Oct 2 07:35:33 ken-x230 ModemManager[1811]: <info> (ttyUSB0) opening serial > port... > Oct 2 07:35:33 ken-x230 NetworkManager[15840]: <info> (cdc-wdm0) modem state > changed, 'disabled' --> 'enabling' (reason: user-requested) > Oct 2 07:35:34 ken-x230 ModemManager[1811]: <info> Falling back to previous > state 'disabled' > Oct 2 07:35:34 ken-x230 ModemManager[1811]: <info> Modem > /org/freedesktop/ModemManager1/Modem/4: state changed (enabling -> disabled) > Oct 2 07:35:34 ken-x230 NetworkManager[15840]: <info> (cdc-wdm0) modem state > changed, 'enabling' --> 'disabled' (reason: unknown) > Oct 2 07:35:34 ken-x230 NetworkManager[15840]: <warn> (cdc-wdm0) failed to > enable modem: > GDBus.Error:org.freedesktop.libqmi.Error.Protocol.InformationUnavailable: > Couldn't get serving system: QMI protocol error (74): 'InformationUnavailable' > Oct 2 07:35:37 ken-x230 ModemManager[1811]: <info> Modem > /org/freedesktop/ModemManager1/Modem/4: signal quality updated (91) > Oct 2 07:35:37 ken-x230 ModemManager[1811]: <info> Modem > /org/freedesktop/ModemManager1/Modem/4: access technology changed (unknown -> > umts) > Oct 2 07:35:46 ken-x230 ModemManager[1811]: <info> Modem enabling... > Oct 2 07:35:46 ken-x230 ModemManager[1811]: <info> Modem > /org/freedesktop/ModemManager1/Modem/4: state changed (disabled -> enabling) > Oct 2 07:35:46 ken-x230 NetworkManager[15840]: <info> (cdc-wdm0) modem state > changed, 'disabled' --> 'enabling' (reason: user-requested) > Oct 2 07:35:46 ken-x230 ModemManager[1811]: <info> Modem > /org/freedesktop/ModemManager1/Modem/4: 3GPP Registration state changed > (unknown -> registering) > Oct 2 07:35:46 ken-x230 ModemManager[1811]: <info> Modem > /org/freedesktop/ModemManager1/Modem/4: 3GPP Registration state changed > (registering -> home) > Oct 2 07:35:47 ken-x230 ModemManager[1811]: <info> Modem fully enabled... > Oct 2 07:35:47 ken-x230 ModemManager[1811]: <info> Modem > /org/freedesktop/ModemManager1/Modem/4: state changed (enabling -> registered) > Oct 2 07:35:47 ken-x230 NetworkManager[15840]: <info> (cdc-wdm0) modem state > changed, 'enabling' --> 'registered' (reason: user-requested) > Oct 2 07:35:47 ken-x230 NetworkManager[15840]: <info> WWAN now enabled by > management service > Oct 2 07:35:47 ken-x230 NetworkManager[15840]: <info> Auto-activating > connection 'att'. > Oct 2 07:35:47 ken-x230 NetworkManager[15840]: <info> Activation (cdc-wdm0) > starting connection 'att' > Oct 2 07:35:47 ken-x230 NetworkManager[15840]: <info> (cdc-wdm0): device > state change: disconnected -> prepare (reason 'none') [30 40 0] > Oct 2 07:35:47 ken-x230 NetworkManager[15840]: <info> Activation (cdc-wdm0) > Stage 1 of 5 (Device Prepare) scheduled... > Oct 2 07:35:47 ken-x230 ModemManager[1811]: <info> Modem > /org/freedesktop/ModemManager1/Modem/4: signal quality updated (91) > Oct 2 07:35:47 ken-x230 NetworkManager[15840]: <info> Activation (cdc-wdm0) > Stage 1 of 5 (Device Prepare) started... > Oct 2 07:35:47 ken-x230 NetworkManager[15840]: <info> Activation (cdc-wdm0) > Stage 1 of 5 (Device Prepare) complete. > Oct 2 07:35:47 ken-x230 ModemManager[1811]: <info> Simple connect started... > Oct 2 07:35:47 ken-x230 ModemManager[1811]: <info> Simple connect state > (4/10): Wait to get fully enabled > Oct 2 07:35:47 ken-x230 ModemManager[1811]: <info> Simple connect state > (5/10): Allowed mode > Oct 2 07:35:49 ken-x230 ModemManager[1811]: <info> Simple connect state > (6/10): Bands > Oct 2 07:35:49 ken-x230 ModemManager[1811]: <info> Simple connect state > (7/10): Register > Oct 2 07:35:49 ken-x230 ModemManager[1811]: <info> Simple connect state > (8/10): Bearer > Oct 2 07:35:49 ken-x230 ModemManager[1811]: <info> Simple connect state > (9/10): Connect > Oct 2 07:35:49 ken-x230 ModemManager[1811]: <info> Modem > /org/freedesktop/ModemManager1/Modem/4: state changed (registered -> > connecting) > Oct 2 07:35:49 ken-x230 ModemManager[1811]: [/dev/cdc-wdm0] Allocating new > client ID... > Oct 2 07:35:49 ken-x230 NetworkManager[15840]: <info> (cdc-wdm0) modem state > changed, 'registered' --> 'connecting' (reason: user-requested) > Oct 2 07:35:49 ken-x230 ModemManager[1811]: [/dev/cdc-wdm0] Registered 'wds' > (version 1.8) client with ID '1' > Oct 2 07:35:50 ken-x230 ModemManager[1811]: <info> error: couldn't start > network: QMI protocol error (14): 'CallFailed' > Oct 2 07:35:50 ken-x230 ModemManager[1811]: <info> call end reason (1018): > 'gsm-wcdma-option-unsubscribed' > Oct 2 07:35:50 ken-x230 ModemManager[1811]: <info> verbose call end reason > (6,33): [3gpp] option-unsubscribed > Oct 2 07:35:50 ken-x230 ModemManager[1811]: <info> error: couldn't get > current settings: QMI protocol error (15): 'OutOfCall' > Oct 2 07:35:50 ken-x230 ModemManager[1811]: <info> Modem > /org/freedesktop/ModemManager1/Modem/4: state changed (connecting -> > registered) > Oct 2 07:35:50 ken-x230 NetworkManager[15840]: <info> (cdc-wdm0) modem state > changed, 'connecting' --> 'registered' (reason: user-requested) > Oct 2 07:35:50 ken-x230 NetworkManager[15840]: <warn> (cdc-wdm0) failed to > connect modem: QMI protocol error (14): 'CallFailed' > Oct 2 07:35:50 ken-x230 NetworkManager[15840]: <info> (cdc-wdm0): device > state change: prepare -> failed (reason 'unknown') [40 120 1] > Oct 2 07:35:50 ken-x230 NetworkManager[15840]: <warn> Activation (cdc-wdm0) > failed for connection 'att' > Oct 2 07:35:50 ken-x230 NetworkManager[15840]: <info> (cdc-wdm0): device > state change: failed -> disconnected (reason 'none') [120 30 0] > Oct 2 07:35:50 ken-x230 NetworkManager[15840]: <info> (cdc-wdm0): > deactivating device (reason 'none') [0] > Oct 2 07:35:54 ken-x230 NetworkManager[15840]: <info> Auto-activating > connection 'att'. > Oct 2 07:35:54 ken-x230 NetworkManager[15840]: <info> Activation (cdc-wdm0) > starting connection 'att' > Oct 2 07:35:54 ken-x230 NetworkManager[15840]: <info> (cdc-wdm0): device > state change: disconnected -> prepare (reason 'none') [30 40 0] > Oct 2 07:35:54 ken-x230 NetworkManager[15840]: <info> Activation (cdc-wdm0) > Stage 1 of 5 (Device Prepare) scheduled... > Oct 2 07:35:54 ken-x230 NetworkManager[15840]: <info> Activation (cdc-wdm0) > Stage 1 of 5 (Device Prepare) started... > Oct 2 07:35:54 ken-x230 NetworkManager[15840]: <info> Activation (cdc-wdm0) > Stage 1 of 5 (Device Prepare) complete. > Oct 2 07:35:54 ken-x230 ModemManager[1811]: <info> Simple connect started... > Oct 2 07:35:54 ken-x230 ModemManager[1811]: <info> Simple connect state > (4/10): Wait to get fully enabled > Oct 2 07:35:54 ken-x230 ModemManager[1811]: <info> Simple connect state > (5/10): Allowed mode > Oct 2 07:35:56 ken-x230 ModemManager[1811]: <info> Simple connect state > (6/10): Bands > Oct 2 07:35:56 ken-x230 ModemManager[1811]: <info> Simple connect state > (7/10): Register > Oct 2 07:35:56 ken-x230 ModemManager[1811]: <info> Simple connect state > (8/10): Bearer > Oct 2 07:35:56 ken-x230 ModemManager[1811]: <info> Simple connect state > (9/10): Connect > Oct 2 07:35:56 ken-x230 ModemManager[1811]: <info> Modem > /org/freedesktop/ModemManager1/Modem/4: state changed (registered -> > connecting) > Oct 2 07:35:56 ken-x230 NetworkManager[15840]: <info> (cdc-wdm0) modem state > changed, 'registered' --> 'connecting' (reason: user-requested) > Oct 2 07:35:57 ken-x230 ModemManager[1811]: <info> error: couldn't start > network: QMI protocol error (14): 'CallFailed' > Oct 2 07:35:57 ken-x230 ModemManager[1811]: <info> call end reason (1018): > 'gsm-wcdma-option-unsubscribed' > Oct 2 07:35:57 ken-x230 ModemManager[1811]: <info> verbose call end reason > (6,33): [3gpp] option-unsubscribed > Oct 2 07:35:57 ken-x230 ModemManager[1811]: <info> error: couldn't get > current settings: QMI protocol error (15): 'OutOfCall' > Oct 2 07:35:57 ken-x230 ModemManager[1811]: <info> Modem > /org/freedesktop/ModemManager1/Modem/4: state changed (connecting -> > registered) > Oct 2 07:35:57 ken-x230 NetworkManager[15840]: <info> (cdc-wdm0) modem state > changed, 'connecting' --> 'registered' (reason: user-requested) > Oct 2 07:35:57 ken-x230 NetworkManager[15840]: <warn> (cdc-wdm0) failed to > connect modem: QMI protocol error (14): 'CallFailed' > Oct 2 07:35:57 ken-x230 NetworkManager[15840]: <info> (cdc-wdm0): device > state change: prepare -> failed (reason 'unknown') [40 120 1] > Oct 2 07:35:57 ken-x230 NetworkManager[15840]: <warn> Activation (cdc-wdm0) > failed for connection 'att' > Oct 2 07:35:57 ken-x230 NetworkManager[15840]: <info> (cdc-wdm0): device > state change: failed -> disconnected (reason 'none') [120 30 0] > Oct 2 07:35:57 ken-x230 NetworkManager[15840]: <info> (cdc-wdm0): > deactivating device (reason 'none') [0] > Oct 2 07:35:57 ken-x230 NetworkManager[15840]: <info> WWAN now disabled by > management service > Oct 2 07:35:57 ken-x230 ModemManager[1811]: <info> Modem disabling... > Oct 2 07:35:57 ken-x230 ModemManager[1811]: <info> Modem > /org/freedesktop/ModemManager1/Modem/4: state changed (registered -> > disabling) > Oct 2 07:35:57 ken-x230 ModemManager[1811]: <info> Modem > /org/freedesktop/ModemManager1/Modem/4: signal quality updated (0) > Oct 2 07:35:57 ken-x230 ModemManager[1811]: <info> Modem > /org/freedesktop/ModemManager1/Modem/4: access technology changed (umts -> > unknown) > Oct 2 07:35:57 ken-x230 NetworkManager[15840]: <info> (cdc-wdm0) modem state > changed, 'registered' --> 'disabling' (reason: user-requested) > Oct 2 07:35:57 ken-x230 ModemManager[1811]: <info> Modem > /org/freedesktop/ModemManager1/Modem/4: 3GPP Registration state changed (home > -> unknown) > Oct 2 07:35:57 ken-x230 ModemManager[1811]: <info> Modem fully disabled... > Oct 2 07:35:57 ken-x230 ModemManager[1811]: <info> Modem > /org/freedesktop/ModemManager1/Modem/4: state changed (disabling -> disabled) > Oct 2 07:35:57 ken-x230 NetworkManager[15840]: <info> (cdc-wdm0) modem state > changed, 'disabling' --> 'disabled' (reason: user-requested) > Oct 2 07:35:59 ken-x230 anacron[22871]: Job `cron.daily' started > Oct 2 07:35:59 ken-x230 anacron[22968]: Updated timestamp for job > `cron.daily' to 2013-10-02 > Oct 2 07:35:59 ken-x230 cracklib: no dictionary update necessary. > Oct 2 07:36:01 ken-x230 NetworkManager[15840]: <info> Auto-activating > connection 'att'. > Oct 2 07:36:01 ken-x230 NetworkManager[15840]: <info> Activation (cdc-wdm0) > starting connection 'att' > Oct 2 07:36:01 ken-x230 NetworkManager[15840]: <info> (cdc-wdm0): device > state change: disconnected -> prepare (reason 'none') [30 40 0] > Oct 2 07:36:01 ken-x230 NetworkManager[15840]: <info> Activation (cdc-wdm0) > Stage 1 of 5 (Device Prepare) scheduled... > Oct 2 07:36:01 ken-x230 NetworkManager[15840]: <info> Activation (cdc-wdm0) > Stage 1 of 5 (Device Prepare) started... > Oct 2 07:36:01 ken-x230 NetworkManager[15840]: <info> Activation (cdc-wdm0) > Stage 1 of 5 (Device Prepare) complete. > Oct 2 07:36:01 ken-x230 ModemManager[1811]: <info> Simple connect started... > Oct 2 07:36:01 ken-x230 ModemManager[1811]: <info> Simple connect state > (3/10): Enable > Oct 2 07:36:01 ken-x230 ModemManager[1811]: <info> Modem enabling... > Oct 2 07:36:01 ken-x230 ModemManager[1811]: <info> Modem > /org/freedesktop/ModemManager1/Modem/4: state changed (disabled -> enabling) > Oct 2 07:36:01 ken-x230 NetworkManager[15840]: <info> (cdc-wdm0) modem state > changed, 'disabled' --> 'enabling' (reason: user-requested) > Oct 2 07:36:01 ken-x230 ModemManager[1811]: <info> Modem > /org/freedesktop/ModemManager1/Modem/4: 3GPP Registration state changed > (unknown -> registering) > Oct 2 07:36:01 ken-x230 ModemManager[1811]: <info> Modem > /org/freedesktop/ModemManager1/Modem/4: 3GPP Registration state changed > (unknown -> searching) > Oct 2 07:36:01 ken-x230 ModemManager[1811]: <warn> Couldn't load Operator > Code: 'Current operator MCC/MNC is still unknown' > Oct 2 07:36:01 ken-x230 ModemManager[1811]: <warn> Couldn't load Operator > Name: 'Current operator description is still unknown' > Oct 2 07:36:01 ken-x230 ModemManager[1811]: <info> Modem > /org/freedesktop/ModemManager1/Modem/4: 3GPP Registration state changed > (registering -> home) > Oct 2 07:36:01 ken-x230 ModemManager[1811]: <info> Modem > /org/freedesktop/ModemManager1/Modem/4: 3GPP Registration state changed (home > -> searching) > Oct 2 07:36:01 ken-x230 ModemManager[1811]: <info> Modem fully enabled... > Oct 2 07:36:01 ken-x230 ModemManager[1811]: <info> Modem > /org/freedesktop/ModemManager1/Modem/4: state changed (enabling -> searching) > Oct 2 07:36:01 ken-x230 ModemManager[1811]: <info> Simple connect state > (4/10): Wait to get fully enabled > Oct 2 07:36:01 ken-x230 ModemManager[1811]: <info> Simple connect state > (5/10): Allowed mode > Oct 2 07:36:01 ken-x230 NetworkManager[15840]: <info> (cdc-wdm0) modem state > changed, 'enabling' --> 'searching' (reason: user-requested) > Oct 2 07:36:01 ken-x230 NetworkManager[15840]: <info> WWAN now enabled by > management service > Oct 2 07:36:03 ken-x230 ModemManager[1811]: <info> Modem > /org/freedesktop/ModemManager1/Modem/4: signal quality updated (92) > Oct 2 07:36:03 ken-x230 ModemManager[1811]: <info> Modem > /org/freedesktop/ModemManager1/Modem/4: access technology changed (unknown -> > umts) > Oct 2 07:36:04 ken-x230 ModemManager[1811]: <info> Simple connect state > (6/10): Bands > Oct 2 07:36:04 ken-x230 ModemManager[1811]: <info> Simple connect state > (7/10): Register > Oct 2 07:36:04 ken-x230 ModemManager[1811]: <info> Modem > /org/freedesktop/ModemManager1/Modem/4: 3GPP Registration state changed > (searching -> registering) > Oct 2 07:36:04 ken-x230 ModemManager[1811]: <info> Modem > /org/freedesktop/ModemManager1/Modem/4: 3GPP location updated (MCC: '310', > MNC: '410', Location area code: '0', Cell ID: '0') > Oct 2 07:36:04 ken-x230 ModemManager[1811]: <info> Simple connect state > (8/10): Bearer > Oct 2 07:36:04 ken-x230 ModemManager[1811]: <info> Simple connect state > (9/10): Connect > Oct 2 07:36:04 ken-x230 ModemManager[1811]: <info> Modem > /org/freedesktop/ModemManager1/Modem/4: state changed (searching -> > connecting) > Oct 2 07:36:04 ken-x230 ModemManager[1811]: <info> Modem > /org/freedesktop/ModemManager1/Modem/4: 3GPP Registration state changed > (registering -> home) > Oct 2 07:36:04 ken-x230 ModemManager[1811]: <info> Modem > /org/freedesktop/ModemManager1/Modem/4: state changed (connecting -> > registered) > Oct 2 07:36:04 ken-x230 NetworkManager[15840]: <info> (cdc-wdm0) modem state > changed, 'searching' --> 'connecting' (reason: user-requested) > Oct 2 07:36:04 ken-x230 NetworkManager[15840]: <info> (cdc-wdm0) modem state > changed, 'connecting' --> 'registered' (reason: unknown) > > _______________________________________________ > networkmanager-list mailing list > networkmanager-list@gnome.org > https://mail.gnome.org/mailman/listinfo/networkmanager-list _______________________________________________ networkmanager-list mailing list networkmanager-list@gnome.org https://mail.gnome.org/mailman/listinfo/networkmanager-list