Re: Network manager auto-upgraded, ppp no longer connects.

["A. F. Cano" <afc shibaya lonestar org>]

On Thu, Jan 05, 2017 at 11:51:54AM -0600, Dan Williams wrote:
> ...
> If you're able, could you downgrade NetworkManager to make sure the
> problem is certainly with the update?  If downgrading starts things
> working again, then it's a lot easier to find the regression.

I'll keep looking into doing this.  The system in question is a
FreedomBox running on an APU1D4 (headless) whose set of tools is
limited and whose only access is ssh and the limited web interface.

> Could you also double-check that ModemManager was or was not updated at
> the same time?

ModemManager was not updated at the same time.

> > Before this latest upgrade (a few days ago) network-manager worked
> > just
> > fine with ppp.  The cdma phone got plugged in, the usb system
> > recognized
> > it, network manager set up the connection and I used to get a
> > CONNECTED_GLOBAL message.  Now I only get the CONNECTED_LOCAL one.
>
> > I think the relevant log lines are:
> >
> > Dec 31 13:12:33 fbx NetworkManager[370]: <warn>  [1483207953.9875]
> > modem-broadband[ttyACM0]: failed to connect modem: Network timeout
> > ...
>
> This error is actually coming from ModemManager, not NetworkManager,
> indicating that MM wasn't able to connect to the network within a
> certain timeout.  One thing that could help narrow it down is to check
> the system log output of ModemManager too.  You can enable verbose
> debugging of MM with:
>
> mmcli -G DEBUG

Ok, did that and now ModemManager is writing thousands of lines to
syslog.  What seems relevant is this:

Jan 12 13:33:56 fbx ModemManager[315]: <debug> Got failure code 100:
Unknown error

These also seem relevant:

Jan 12 13:34:10 fbx ModemManager[315]: <debug>    User: unspecified
Jan 12 13:34:10 fbx ModemManager[315]: <debug>    Password: unspecified
Jan 12 13:34:10 fbx ModemManager[315]: <debug>    Number: #777

Not sure how/why the user and password are unspecified, they are set in
the connection description (qnc).

The following seem contradictory, it seems that the regiestration checks
don't stick.

Jan 12 13:34:22 fbx ModemManager[315]: <debug> Not registered in any CDMA network
Jan 12 13:34:22 fbx ModemManager[315]: <debug> All CDMA registration state checks done
Jan 12 13:34:22 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 1 (close)
Jan 12 13:34:22 fbx ModemManager[315]: <debug> Modem not yet registered in a CDMA network... will recheck soon
Jan 12 13:34:25 fbx ModemManager[315]: <debug> Running registration checks (CDMA1x: 'yes', EV-DO: 'yes')
Jan 12 13:34:25 fbx ModemManager[315]: <debug> Will skip all QCDM-based registration checks

Keep in mind that if I start the ppp connection via "sudo pon cell" it
works fine.

I append the full log at the end, from the moment the phone is plugged
in and the usb system recognizes it until it is unplugged.

> and it'll dump to whatever normal log location your system uses.  For
> systemd-based distros, that's "journalctl -b -u ModemManager" and for
> other distros that might be /var/log/messages or
> /var/log/ModemManager.log depending on your distros syslog setup. 

/var/log/syslog it seems to be.

> That'll probably tell us a lot more about what's happening.

Indeed.  I hope we don't drown in log entries :-)

Thanks for replying.

Augustine


The full log:

Jan 12 13:33:53 fbx kernel: [246133.875824] usb 4-1: new full-speed USB device number 7 using ohci-pci
Jan 12 13:33:54 fbx kernel: [246134.063010] usb 4-1: New USB device found, idVendor=22b8, idProduct=2a62
Jan 12 13:33:54 fbx kernel: [246134.063020] usb 4-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0
Jan 12 13:33:54 fbx kernel: [246134.063025] usb 4-1: Product: Motorola E815
Jan 12 13:33:54 fbx kernel: [246134.063030] usb 4-1: Manufacturer: Motorola, Inc.
Jan 12 13:33:54 fbx kernel: [246134.070594] cdc_acm 4-1:1.0: ttyACM0: USB ACM device
Jan 12 13:33:54 fbx ModemManager[315]: <debug> [plugin manager] task 8: new support task for device: 
/sys/devices/pci0000:00/0000:00:12.0/usb4/4-1
Jan 12 13:33:54 fbx ModemManager[315]: <debug> [plugin manager] task 8: port grabbed: ttyACM0
Jan 12 13:33:54 fbx ModemManager[315]: <debug> [plugin manager] task 8,ttyACM0: new support task for port
Jan 12 13:33:54 fbx ModemManager[315]: <debug> [plugin manager) task 8,ttyACM0: deferred until min wait time 
elapsed
Jan 12 13:33:55 fbx ModemManager[315]: <debug> [plugin manager] task 8: min wait time elapsed
Jan 12 13:33:55 fbx ModemManager[315]: <debug> (Altair LTE) [ttyACM0] filtered by vendor/product IDs
Jan 12 13:33:55 fbx ModemManager[315]: <debug> (AnyDATA) [ttyACM0] filtered by vendor/product IDs
Jan 12 13:33:55 fbx ModemManager[315]: <debug> (Dell) [ttyACM0] filtered by vendor/product IDs
Jan 12 13:33:55 fbx ModemManager[315]: <debug> (Ericsson MBM) [ttyACM0] filtered by udev tags
Jan 12 13:33:55 fbx ModemManager[315]: <debug> (Haier) [ttyACM0] filtered by vendor/product IDs
Jan 12 13:33:55 fbx ModemManager[315]: <debug> (Huawei) [ttyACM0] filtered by vendor/product IDs
Jan 12 13:33:55 fbx ModemManager[315]: <debug> (Linktop) [ttyACM0] filtered by vendor/product IDs
Jan 12 13:33:55 fbx ModemManager[315]: <debug> (Longcheer) [ttyACM0] filtered by vendor/product IDs
Jan 12 13:33:55 fbx ModemManager[315]: <debug> (Motorola) [ttyACM0] filtered by vendor/product IDs
Jan 12 13:33:55 fbx ModemManager[315]: <debug> (MTK) [ttyACM0] filtered by udev tags
Jan 12 13:33:55 fbx ModemManager[315]: <debug> (Nokia (Icera)) [ttyACM0] filtered by vendor/product IDs
Jan 12 13:33:55 fbx ModemManager[315]: <debug> (Novatel) [ttyACM0] filtered by vendor/product IDs
Jan 12 13:33:55 fbx ModemManager[315]: <debug> (Novatel LTE) [ttyACM0] filtered by vendor/product IDs
Jan 12 13:33:55 fbx ModemManager[315]: <debug> (Option High-Speed) [ttyACM0] filtered by drivers
Jan 12 13:33:55 fbx ModemManager[315]: <debug> (Option) [ttyACM0] filtered by drivers
Jan 12 13:33:55 fbx ModemManager[315]: <debug> (Pantech) [ttyACM0] filtered by vendor/product IDs
Jan 12 13:33:55 fbx ModemManager[315]: <debug> (Samsung) [ttyACM0] filtered by vendor/product IDs
Jan 12 13:33:55 fbx ModemManager[315]: <debug> (Sierra (legacy)) [ttyACM0] filtered by drivers
Jan 12 13:33:55 fbx ModemManager[315]: <debug> (Sierra) [ttyACM0] filtered by drivers
Jan 12 13:33:55 fbx ModemManager[315]: <debug> (SimTech) [ttyACM0] filtered by vendor/product IDs
Jan 12 13:33:55 fbx ModemManager[315]: <debug> (Telit) [ttyACM0] filtered by vendor/product IDs
Jan 12 13:33:55 fbx ModemManager[315]: <debug> (Thuraya) [ttyACM0] filtered by vendor/product IDs
Jan 12 13:33:55 fbx ModemManager[315]: <debug> (Wavecom) [ttyACM0] filtered by vendor/product IDs
Jan 12 13:33:55 fbx ModemManager[315]: <debug> (X22X) [ttyACM0] filtered by vendor/product IDs
Jan 12 13:33:55 fbx ModemManager[315]: <debug> (ZTE) [ttyACM0] filtered by vendor/product IDs
Jan 12 13:33:55 fbx ModemManager[315]: <debug> [plugin manager] task 8,ttyACM0: found '5' plugins to try
Jan 12 13:33:55 fbx ModemManager[315]: <debug> [plugin manager] task 8,ttyACM0: will try with plugin 
'Cinterion'
Jan 12 13:33:55 fbx ModemManager[315]: <debug> [plugin manager] task 8,ttyACM0: will try with plugin 'Iridium'
Jan 12 13:33:55 fbx ModemManager[315]: <debug> [plugin manager] task 8,ttyACM0: will try with plugin 'Nokia'
Jan 12 13:33:55 fbx ModemManager[315]: <debug> [plugin manager] task 8,ttyACM0: will try with plugin 'Via 
CBP7'
Jan 12 13:33:55 fbx ModemManager[315]: <debug> [plugin manager] task 8,ttyACM0: will try with plugin 'Generic'
Jan 12 13:33:55 fbx ModemManager[315]: <debug> [plugin manager) task 8,ttyACM0: started
Jan 12 13:33:55 fbx ModemManager[315]: <debug> [plugin manager] task 8,ttyACM0: checking with plugin 
'Cinterion'
Jan 12 13:33:55 fbx ModemManager[315]: <debug> (Cinterion) [ttyACM0] probe required: 'at, at-vendor'
Jan 12 13:33:55 fbx ModemManager[315]: <debug> (tty/ttyACM0) launching port probing: 'at, at-vendor'
Jan 12 13:33:55 fbx ModemManager[315]: <debug> (ttyACM0) opening serial port...
Jan 12 13:33:55 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 1 (open)
Jan 12 13:33:55 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT^SQPORT?<CR>'
Jan 12 13:33:56 fbx ModemManager[315]: <debug> [plugin manager] task 8: min probing time elapsed
Jan 12 13:33:56 fbx ModemManager[315]: <debug> [plugin Manager] task 8: still 1 running probes (1 active): 
ttyACM0
Jan 12 13:33:56 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>ERROR<CR><LF>'
Jan 12 13:33:56 fbx ModemManager[315]: <debug> Got failure code 100: Unknown error
Jan 12 13:33:56 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT<CR>'
Jan 12 13:33:56 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
Jan 12 13:33:56 fbx ModemManager[315]: <debug> (tty/ttyACM0) port is AT-capable
Jan 12 13:33:56 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CGMI<CR>'
Jan 12 13:33:57 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>ERROR<CR><LF>'
Jan 12 13:33:57 fbx ModemManager[315]: <debug> Got failure code 100: Unknown error
Jan 12 13:33:57 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+GMI<CR>'
Jan 12 13:33:58 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+GMI: Motorola CE, Copyright 
2000<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:33:58 fbx ModemManager[315]: <debug> (tty/ttyACM0) vendor probing finished
Jan 12 13:33:58 fbx ModemManager[315]: <debug> (Cinterion) [ttyACM0] filtered by vendor strings
Jan 12 13:33:58 fbx ModemManager[315]: <debug> [plugin manager] task 8,ttyACM0: checking with plugin 'Iridium'
Jan 12 13:33:58 fbx ModemManager[315]: <debug> (Iridium) [ttyACM0] probe required: 'at, at-vendor, at-product'
Jan 12 13:33:58 fbx ModemManager[315]: <debug> (tty/ttyACM0) launching port probing: 'at-product'
Jan 12 13:33:58 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 0 (close)
Jan 12 13:33:58 fbx ModemManager[315]: <debug> (ttyACM0) closing serial port...
Jan 12 13:33:58 fbx ModemManager[315]: <debug> (ttyACM0) serial port closed
Jan 12 13:33:58 fbx ModemManager[315]: <debug> (ttyACM0) forced to close port
Jan 12 13:33:58 fbx ModemManager[315]: <debug> (ttyACM0) opening serial port...
Jan 12 13:33:58 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 1 (open)
Jan 12 13:33:58 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CGMM<CR>'
Jan 12 13:33:59 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>ERROR<CR><LF>'
Jan 12 13:33:59 fbx ModemManager[315]: <debug> Got failure code 100: Unknown error
Jan 12 13:33:59 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+GMM<CR>'
Jan 12 13:33:59 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+GMM: Motorola CDMA e815 
Phone<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:33:59 fbx ModemManager[315]: <debug> (tty/ttyACM0) product probing finished
Jan 12 13:33:59 fbx ModemManager[315]: <debug> (Iridium) [ttyACM0] filtered by vendor/product strings
Jan 12 13:33:59 fbx ModemManager[315]: <debug> [plugin manager] task 8,ttyACM0: checking with plugin 'Nokia'
Jan 12 13:33:59 fbx ModemManager[315]: <debug> (Nokia) [ttyACM0] probe required: 'at, at-vendor, at-icera'
Jan 12 13:33:59 fbx ModemManager[315]: <debug> (tty/ttyACM0) launching port probing: 'at-icera'
Jan 12 13:33:59 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 0 (close)
Jan 12 13:33:59 fbx ModemManager[315]: <debug> (ttyACM0) closing serial port...
Jan 12 13:33:59 fbx ModemManager[315]: <debug> (ttyACM0) serial port closed
Jan 12 13:33:59 fbx ModemManager[315]: <debug> (ttyACM0) forced to close port
Jan 12 13:33:59 fbx ModemManager[315]: <debug> (ttyACM0) opening serial port...
Jan 12 13:33:59 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 1 (open)
Jan 12 13:33:59 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT%IPSYS?<CR>'
Jan 12 13:34:00 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>ERROR<CR><LF>'
Jan 12 13:34:00 fbx ModemManager[315]: <debug> Got failure code 100: Unknown error
Jan 12 13:34:00 fbx ModemManager[315]: <debug> (tty/ttyACM0) re-scheduling next command in probing group in 2 
seconds...
Jan 12 13:34:02 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT%IPSYS?<CR>'
Jan 12 13:34:03 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>ERROR<CR><LF>'
Jan 12 13:34:03 fbx ModemManager[315]: <debug> Got failure code 100: Unknown error
Jan 12 13:34:03 fbx ModemManager[315]: <debug> (tty/ttyACM0) re-scheduling next command in probing group in 2 
seconds...
Jan 12 13:34:05 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT%IPSYS?<CR>'
Jan 12 13:34:06 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>ERROR<CR><LF>'
Jan 12 13:34:06 fbx ModemManager[315]: <debug> Got failure code 100: Unknown error
Jan 12 13:34:06 fbx ModemManager[315]: <debug> (tty/ttyACM0) Modem is probably not Icera-based
Jan 12 13:34:06 fbx ModemManager[315]: <debug> (Nokia) [ttyACM0] filtered by vendor strings
Jan 12 13:34:06 fbx ModemManager[315]: <debug> [plugin manager] task 8,ttyACM0: checking with plugin 'Via 
CBP7'
Jan 12 13:34:06 fbx ModemManager[315]: <debug> (Via CBP7) [ttyACM0] probe required: 'at, at-vendor, 
at-product'
Jan 12 13:34:06 fbx ModemManager[315]: <debug> (tty/ttyACM0) port probing finished: no more probings needed
Jan 12 13:34:06 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 0 (close)
Jan 12 13:34:06 fbx ModemManager[315]: <debug> (ttyACM0) closing serial port...
Jan 12 13:34:06 fbx ModemManager[315]: <debug> (ttyACM0) serial port closed
Jan 12 13:34:06 fbx ModemManager[315]: <debug> (ttyACM0) forced to close port
Jan 12 13:34:06 fbx ModemManager[315]: <debug> (Via CBP7) [ttyACM0] filtered by vendor/product strings
Jan 12 13:34:06 fbx ModemManager[315]: <debug> [plugin manager] task 8,ttyACM0: checking with plugin 'Generic'
Jan 12 13:34:06 fbx ModemManager[315]: <debug> (Generic) [ttyACM0] probe required: 'at, qcdm'
Jan 12 13:34:06 fbx ModemManager[315]: <debug> (tty/ttyACM0) port probing finished: no more probings needed
Jan 12 13:34:06 fbx ModemManager[315]: <debug> [plugin manager] task 8,ttyACM0: found best plugin for port 
(Generic)
Jan 12 13:34:06 fbx ModemManager[315]: <debug> [plugin manager] task 8,ttyACM0: finished in '12.704416' 
seconds
Jan 12 13:34:06 fbx ModemManager[315]: <debug> [plugin manager] task 8: no more ports to probe
Jan 12 13:34:06 fbx ModemManager[315]: <debug> [plugin manager] task 8: finished in '12.704798' seconds
Jan 12 13:34:06 fbx ModemManager[315]: <info>  Creating modem with plugin 'Generic' and '1' ports
Jan 12 13:34:06 fbx ModemManager[315]: <debug> (ttyACM0) type 'at' claimed by 
/sys/devices/pci0000:00/0000:00:12.0/usb4/4-1
Jan 12 13:34:06 fbx ModemManager[315]: <debug> (/sys/devices/pci0000:00/0000:00:12.0/usb4/4-1) tty/ttyACM0 at 
(primary)
Jan 12 13:34:06 fbx ModemManager[315]: <debug> (/sys/devices/pci0000:00/0000:00:12.0/usb4/4-1) tty/ttyACM0 
data (primary)
Jan 12 13:34:06 fbx ModemManager[315]: <debug> (ttyACM0) opening serial port...
Jan 12 13:34:06 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 1 (open)
Jan 12 13:34:06 fbx ModemManager[315]: <debug> (ttyACM0): running init sequence...
Jan 12 13:34:06 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (open)
Jan 12 13:34:06 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 3 (open)
Jan 12 13:34:06 fbx ModemManager[315]: <info>  Modem for device at 
'/sys/devices/pci0000:00/0000:00:12.0/usb4/4-1' successfully created
Jan 12 13:34:06 fbx ModemManager[315]: <debug> loading current capabilities...
Jan 12 13:34:06 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 4 (open)
Jan 12 13:34:06 fbx ModemManager[315]: <debug> (ttyACM0): --> 'ATE0<CR>'
Jan 12 13:34:06 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
Jan 12 13:34:06 fbx ModemManager[315]: <debug> (ttyACM0): --> 'ATV1<CR>'
Jan 12 13:34:06 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
Jan 12 13:34:06 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CMEE=1<CR>'
Jan 12 13:34:06 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>ERROR<CR><LF>'
Jan 12 13:34:06 fbx ModemManager[315]: <debug> Got failure code 100: Unknown error
Jan 12 13:34:06 fbx ModemManager[315]: <debug> (ttyACM0): --> 'ATX4<CR>'
Jan 12 13:34:06 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
Jan 12 13:34:06 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT&C1<CR>'
Jan 12 13:34:06 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
Jan 12 13:34:06 fbx ModemManager[315]: <debug> (ttyACM0): --> 'ATE0<CR>'
Jan 12 13:34:06 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
Jan 12 13:34:06 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 3 (close)
Jan 12 13:34:06 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CMEE=1<CR>'
Jan 12 13:34:06 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>ERROR<CR><LF>'
Jan 12 13:34:06 fbx ModemManager[315]: <debug> Got failure code 100: Unknown error
Jan 12 13:34:06 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (close)
Jan 12 13:34:06 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+GCAP<CR>'
Jan 12 13:34:06 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+GCAP: +GCAP: +CIS707-A, CIS-856, +MS, 
+ES, +DS, +FCLASS<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:34:06 fbx ModemManager[315]: <debug> loaded current capabilities: cdma-evdo
Jan 12 13:34:06 fbx ModemManager[315]: <debug> Modem allows up to 1 bearers
Jan 12 13:34:06 fbx ModemManager[315]: <debug> Creating bearer list (max: 1, max active: 1)
Jan 12 13:34:06 fbx ModemManager[315]: <debug> loading manufacturer...
Jan 12 13:34:06 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 3 (open)
Jan 12 13:34:06 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (close)
Jan 12 13:34:06 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CGMI<CR>'
Jan 12 13:34:06 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>ERROR<CR><LF>'
Jan 12 13:34:06 fbx ModemManager[315]: <debug> Got failure code 100: Unknown error
Jan 12 13:34:06 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+GMI<CR>'
Jan 12 13:34:06 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+GMI: Motorola CE, Copyright 
2000<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:34:06 fbx ModemManager[315]: <debug> loaded manufacturer: Motorola CE, Copyright 2000
Jan 12 13:34:06 fbx ModemManager[315]: <debug> loading model...
Jan 12 13:34:06 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 3 (open)
Jan 12 13:34:06 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (close)
Jan 12 13:34:06 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CGMM<CR>'
Jan 12 13:34:06 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>ERROR<CR><LF>'
Jan 12 13:34:06 fbx ModemManager[315]: <debug> Got failure code 100: Unknown error
Jan 12 13:34:06 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+GMM<CR>'
Jan 12 13:34:06 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+GMM: Motorola CDMA e815 
Phone<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:34:06 fbx ModemManager[315]: <debug> loaded model: Motorola CDMA e815 Phone
Jan 12 13:34:06 fbx ModemManager[315]: <debug> loading revision...
Jan 12 13:34:06 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 3 (open)
Jan 12 13:34:06 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (close)
Jan 12 13:34:06 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CGMR<CR>'
Jan 12 13:34:06 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>ERROR<CR><LF>'
Jan 12 13:34:06 fbx ModemManager[315]: <debug> Got failure code 100: Unknown error
Jan 12 13:34:06 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+GMR<CR>'
Jan 12 13:34:06 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+GMR: 
8720_01.17.03<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:34:06 fbx ModemManager[315]: <debug> loaded revision: 8720_01.17.03
Jan 12 13:34:06 fbx ModemManager[315]: <debug> loading equipment identifier...
Jan 12 13:34:06 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 3 (open)
Jan 12 13:34:06 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (close)
Jan 12 13:34:06 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+GSN<CR>'
Jan 12 13:34:06 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+GSN: 
0x24F5BB43<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:34:06 fbx ModemManager[315]: <debug> loaded equipment identifier: 24F5BB43
Jan 12 13:34:06 fbx ModemManager[315]: <debug> loading device identifier...
Jan 12 13:34:06 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 3 (open)
Jan 12 13:34:06 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (close)
Jan 12 13:34:06 fbx ModemManager[315]: <debug> (ttyACM0): --> 'ATI<CR>'
Jan 12 13:34:06 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>Manufacturer: I: Motorola CE, 
Copyright 2000<CR><LF>Model: I: Motorola CDMA e815 Phone<CR><LF>Revision: I: 8720_01.17.03<CR><LF>ESN: I: 
0x24F5BB'
Jan 12 13:34:07 fbx ntpd[838]: error resolving pool 3.debian.pool.ntp.org: Name or service not known (-2)
Jan 12 13:34:09 fbx ModemManager[315]: <debug> Device ID source 
'000022b800002a6224F5BB438720_01.17.03MotorolaCDMAe815PhoneMotorolaCE,Copyright2000'
Jan 12 13:34:09 fbx ModemManager[315]: <debug> Device ID '74820f1ab30275b22f4f7be80762890e1c5cd2df'
Jan 12 13:34:09 fbx ModemManager[315]: <debug> loaded device identifier: 
74820f1ab30275b22f4f7be80762890e1c5cd2df
Jan 12 13:34:09 fbx ModemManager[315]: <debug> loading supported modes...
Jan 12 13:34:09 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 3 (open)
Jan 12 13:34:09 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (close)
Jan 12 13:34:09 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+GCAP<CR>'
Jan 12 13:34:09 fbx ModemManager[315]: <debug> (ttyACM0): <-- '43<CR><LF>I: +GCAP: +CIS707-A, CIS-856, +MS, 
+ES, +DS, +FCLASS<CR><LF><CR><LF>OK<CR><LF><CR><LF>+GCAP: +GCAP: +CIS707-A, CIS-856, +MS, +ES, +DS, 
+FCLASS<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:34:09 fbx ModemManager[315]: <debug> Device allows (CDMA) 3G network mode
Jan 12 13:34:09 fbx ModemManager[315]: <debug> Device allows (CDMA) 2G network mode
Jan 12 13:34:09 fbx ModemManager[315]: <debug> loading supported IP families...
Jan 12 13:34:09 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 1 (close)
Jan 12 13:34:09 fbx ModemManager[315]: <debug> Assuming full power state in CDMA-only modem...
Jan 12 13:34:09 fbx ModemManager[315]: <debug> Skipping unlock check in CDMA-only modem...
Jan 12 13:34:09 fbx ModemManager[315]: <debug> loading own numbers...
Jan 12 13:34:09 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (open)
Jan 12 13:34:09 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CNUM<CR>'
Jan 12 13:34:09 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>ERROR<CR><LF>'
Jan 12 13:34:09 fbx ModemManager[315]: <debug> Got failure code 100: Unknown error
Jan 12 13:34:09 fbx ModemManager[315]: <warn>  couldn't load list of Own Numbers: 'Unknown error'
Jan 12 13:34:09 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 1 (close)
Jan 12 13:34:09 fbx ModemManager[315]: <debug> loading MEID...
Jan 12 13:34:09 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (open)
Jan 12 13:34:09 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+GSN<CR>'
Jan 12 13:34:09 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+GSN: 
0x24F5BB43<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:34:09 fbx ModemManager[315]: <debug> loaded MEID: (null)
Jan 12 13:34:09 fbx ModemManager[315]: <debug> loading ESN...
Jan 12 13:34:09 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 3 (open)
Jan 12 13:34:09 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (close)
Jan 12 13:34:09 fbx ModemManager[315]: <debug> loaded ESN: 24F5BB43
Jan 12 13:34:09 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 1 (close)
Jan 12 13:34:09 fbx ModemManager[315]: <debug> Couldn't initialize interface: 'The modem doesn't have 
location capabilities'
Jan 12 13:34:09 fbx ModemManager[315]: <debug> Messaging support check failed: 'CDMA-only modems don't have 
messaging capabilities'
Jan 12 13:34:09 fbx ModemManager[315]: <debug> Couldn't initialize interface: 'Messaging not supported'
Jan 12 13:34:09 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (open)
Jan 12 13:34:09 fbx ModemManager[315]: <debug> (ttyACM0): --> 'ATH<CR>'
Jan 12 13:34:09 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
Jan 12 13:34:09 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 1 (close)
Jan 12 13:34:09 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (open)
Jan 12 13:34:09 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CTZU=1<CR>'
Jan 12 13:34:09 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>ERROR<CR><LF>'
Jan 12 13:34:09 fbx ModemManager[315]: <debug> Got failure code 100: Unknown error
Jan 12 13:34:09 fbx ModemManager[315]: <debug> Time support check failed: 'Unknown error'
Jan 12 13:34:09 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 1 (close)
Jan 12 13:34:09 fbx ModemManager[315]: <debug> Couldn't initialize interface: 'Time not supported'
Jan 12 13:34:09 fbx ModemManager[315]: <debug> Couldn't initialize interface: 'Extended Signal information 
not supported'
Jan 12 13:34:09 fbx ModemManager[315]: <debug> Couldn't initialize interface: 'OMA not supported'
Jan 12 13:34:09 fbx ModemManager[315]: <debug> Couldn't initialize interface: 'Firmware interface not 
available'
Jan 12 13:34:09 fbx ModemManager[315]: <info>  Modem: state changed (unknown -> disabled)
Jan 12 13:34:09 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 0 (close)
Jan 12 13:34:09 fbx ModemManager[315]: <debug> (ttyACM0) closing serial port...
Jan 12 13:34:09 fbx ModemManager[315]: <debug> (ttyACM0) serial port closed
Jan 12 13:34:09 fbx ModemManager[315]: <debug> modem properly initialized
Jan 12 13:34:09 fbx ModemManager[315]: <debug> Exported modem '/sys/devices/pci0000:00/0000:00:12.0/usb4/4-1' 
at path '/org/freedesktop/ModemManager1/Modem/5'
Jan 12 13:34:09 fbx ModemManager[315]: <debug> (/org/freedesktop/ModemManager1/Modem/5): 'Generic' modem, VID 
0x22B8 PID 0x2A62 (usb)
Jan 12 13:34:09 fbx NetworkManager[379]: <info>  [1484246049.9537] manager: (ttyACM0): new Broadband device 
(/org/freedesktop/NetworkManager/Devices/13)
Jan 12 13:34:09 fbx NetworkManager[379]: <info>  [1484246049.9546] device (ttyACM0): state change: unmanaged 
-> unavailable (reason 'managed') [10 20 2]
Jan 12 13:34:09 fbx ModemManager[315]: <info>  Modem /org/freedesktop/ModemManager1/Modem/5: state changed 
(disabled -> enabling)
Jan 12 13:34:09 fbx NetworkManager[379]: <info>  [1484246049.9556] device (ttyACM0): modem state 'enabling'
Jan 12 13:34:09 fbx ModemManager[315]: <debug> Skipping modem initialization: device hotplugged
Jan 12 13:34:09 fbx NetworkManager[379]: <info>  [1484246049.9560] modem-broadband[ttyACM0]: failed to 
retrieve SIM object: No SIM object available
Jan 12 13:34:09 fbx ModemManager[315]: <debug> (ttyACM0) opening serial port...
Jan 12 13:34:09 fbx NetworkManager[379]: <info>  [1484246049.9572] device (ttyACM0): state change: 
unavailable -> disconnected (reason 'none') [20 30 0]
Jan 12 13:34:09 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 1 (open)
Jan 12 13:34:09 fbx NetworkManager[379]: <info>  [1484246049.9586] policy: auto-activating connection 'ppp'
Jan 12 13:34:09 fbx ModemManager[315]: <debug> (ttyACM0): running init sequence...
Jan 12 13:34:09 fbx NetworkManager[379]: <info>  [1484246049.9643] device (ttyACM0): Activation: starting 
connection 'ppp' (f2cc6f30-1726-42c2-b580-3ac8a98a21ec)
Jan 12 13:34:09 fbx ModemManager[315]: <debug> Flashing primary AT port before enabling...
Jan 12 13:34:09 fbx NetworkManager[379]: <info>  [1484246049.9651] device (ttyACM0): state change: 
disconnected -> prepare (reason 'none') [30 40 0]
Jan 12 13:34:09 fbx ModemManager[315]: <debug> (ttyACM0): --> 'ATE0<CR>'
Jan 12 13:34:09 fbx NetworkManager[379]: <info>  [1484246049.9712] device (ttyACM0): state change: prepare -> 
need-auth (reason 'none') [40 60 0]
Jan 12 13:34:09 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
Jan 12 13:34:10 fbx NetworkManager[379]: <info>  [1484246049.9841] device (ttyACM0): state change: need-auth 
-> prepare (reason 'none') [60 40 0]
Jan 12 13:34:10 fbx ModemManager[315]: <debug> (ttyACM0): --> 'ATV1<CR>'
Jan 12 13:34:10 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
Jan 12 13:34:10 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CMEE=1<CR>'
Jan 12 13:34:10 fbx ModemManager[315]: <info>  Simple connect started...
Jan 12 13:34:10 fbx ModemManager[315]: <debug>    PIN: unspecified
Jan 12 13:34:10 fbx ModemManager[315]: <debug>    Operator ID: unspecified
Jan 12 13:34:10 fbx ModemManager[315]: <debug>    Allowed roaming: yes
Jan 12 13:34:10 fbx ModemManager[315]: <debug>    APN: unspecified
Jan 12 13:34:10 fbx ModemManager[315]: <debug>    IP family: ipv4
Jan 12 13:34:10 fbx ModemManager[315]: <debug>    Allowed authentication: unspecified
Jan 12 13:34:10 fbx ModemManager[315]: <debug>    User: unspecified
Jan 12 13:34:10 fbx ModemManager[315]: <debug>    Password: unspecified
Jan 12 13:34:10 fbx ModemManager[315]: <debug>    Number: #777
Jan 12 13:34:10 fbx ModemManager[315]: <info>  Simple connect state (4/8): Wait to get fully enabled
Jan 12 13:34:10 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>ERROR<CR><LF>'
Jan 12 13:34:10 fbx ModemManager[315]: <debug> Got failure code 100: Unknown error
Jan 12 13:34:10 fbx ModemManager[315]: <debug> (ttyACM0): --> 'ATX4<CR>'
Jan 12 13:34:10 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
Jan 12 13:34:10 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT&C1<CR>'
Jan 12 13:34:10 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
Jan 12 13:34:10 fbx ModemManager[315]: <debug> Assuming full power state in CDMA-only modem...
Jan 12 13:34:10 fbx ModemManager[315]: <debug> No need to change power state: already in 'on' power state
Jan 12 13:34:10 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (open)
Jan 12 13:34:10 fbx ModemManager[315]: <debug> Skipping supported charset loading in CDMA-only modem...
Jan 12 13:34:10 fbx ModemManager[315]: <debug> Modem has CDMA capabilities, enabling the Modem CDMA 
interface...
Jan 12 13:34:10 fbx ModemManager[315]: <debug> Periodic CDMA registration checks enabled
Jan 12 13:34:10 fbx ModemManager[315]: <debug> Modem has voice capabilities, enabling the Voice interface...
Jan 12 13:34:10 fbx ModemManager[315]: <debug> (ttyACM0) Setting voice unsolicited events handlers
Jan 12 13:34:10 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 3 (open)
Jan 12 13:34:10 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+IFC=1,1<CR>'
Jan 12 13:34:10 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>OK<CR><LF>'
Jan 12 13:34:10 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (close)
Jan 12 13:34:10 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CLIP=1<CR>'
Jan 12 13:34:10 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>ERROR<CR><LF>'
Jan 12 13:34:10 fbx ModemManager[315]: <debug> Got failure code 100: Unknown error
Jan 12 13:34:10 fbx ModemManager[315]: <debug> Couldn't enable unsolicited events: 'Unknown error'
Jan 12 13:34:10 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 1 (close)
Jan 12 13:34:10 fbx ModemManager[315]: <info>  Modem /org/freedesktop/ModemManager1/Modem/5: state changed 
(enabling -> enabled)
Jan 12 13:34:10 fbx ModemManager[315]: <info>  Simple connect state (5/8): Register
Jan 12 13:34:10 fbx ModemManager[315]: <debug> Running registration checks (CDMA1x: 'yes', EV-DO: 'yes')
Jan 12 13:34:10 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (open)
Jan 12 13:34:10 fbx ModemManager[315]: <debug> Running registration checks (CDMA1x: 'yes', EV-DO: 'yes')
Jan 12 13:34:10 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 3 (open)
Jan 12 13:34:10 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+SPSERVICE?<CR>'
Jan 12 13:34:10 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>ERROR<CR><LF>'
Jan 12 13:34:10 fbx ModemManager[315]: <debug> Got failure code 100: Unknown error
Jan 12 13:34:10 fbx ModemManager[315]: <debug> Will skip all QCDM-based registration checks
Jan 12 13:34:10 fbx ModemManager[315]: <debug> Will skip generic detailed registration check, we don't have 
Sprint commands
Jan 12 13:34:10 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (close)
Jan 12 13:34:10 fbx ModemManager[315]: <debug> Starting QCDM-based registration checks
Jan 12 13:34:10 fbx ModemManager[315]: <debug>   Skipping all QCDM-based checks and falling back to AT-based 
checks
Jan 12 13:34:10 fbx ModemManager[315]: <debug> Starting AT-based registration checks
Jan 12 13:34:10 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 3 (open)
Jan 12 13:34:10 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+SPSERVICE?<CR>'
Jan 12 13:34:10 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>ERROR<CR><LF>'
Jan 12 13:34:10 fbx ModemManager[315]: <debug> Got failure code 100: Unknown error
Jan 12 13:34:10 fbx ModemManager[315]: <debug> Will skip all QCDM-based registration checks
Jan 12 13:34:10 fbx ModemManager[315]: <debug> Will skip generic detailed registration check, we don't have 
Sprint commands
Jan 12 13:34:10 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (close)
Jan 12 13:34:10 fbx ModemManager[315]: <debug> Starting QCDM-based registration checks
Jan 12 13:34:10 fbx ModemManager[315]: <debug>   Skipping all QCDM-based checks and falling back to AT-based 
checks
Jan 12 13:34:10 fbx ModemManager[315]: <debug> Starting AT-based registration checks
Jan 12 13:34:10 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 3 (open)
Jan 12 13:34:10 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CAD?<CR>'
Jan 12 13:34:10 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+CAD: 1<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:34:10 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 4 (open)
Jan 12 13:34:10 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 3 (close)
Jan 12 13:34:10 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CAD?<CR>'
Jan 12 13:34:10 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+CAD: 1<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:34:10 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 4 (open)
Jan 12 13:34:10 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 3 (close)
Jan 12 13:34:10 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CSS?<CR>'
Jan 12 13:34:10 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+CSS: ?, 0<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:34:10 fbx ModemManager[315]: <debug> Not registered in any CDMA network
Jan 12 13:34:10 fbx ModemManager[315]: <debug> All CDMA registration state checks done
Jan 12 13:34:10 fbx ModemManager[315]: <debug> Will start keeping track of state for subsystem 'cdma1x'
Jan 12 13:34:10 fbx ModemManager[315]: <debug> Will start keeping track of state for subsystem 'evdo'
Jan 12 13:34:10 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (close)
Jan 12 13:34:10 fbx ModemManager[315]: <debug> Modem not yet registered in a CDMA network... will recheck soon
Jan 12 13:34:10 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CSS?<CR>'
Jan 12 13:34:10 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+CSS: ?, 0<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:34:10 fbx ModemManager[315]: <debug> Not registered in any CDMA network
Jan 12 13:34:10 fbx ModemManager[315]: <debug> All CDMA registration state checks done
Jan 12 13:34:10 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 1 (close)
Jan 12 13:34:10 fbx ModemManager[315]: <debug> Initial CDMA registration checks finished
Jan 12 13:34:13 fbx ModemManager[315]: <debug> Running registration checks (CDMA1x: 'yes', EV-DO: 'yes')
Jan 12 13:34:13 fbx ModemManager[315]: <debug> Will skip all QCDM-based registration checks
Jan 12 13:34:13 fbx ModemManager[315]: <debug> Will skip generic detailed registration check, we don't have 
Sprint commands
Jan 12 13:34:13 fbx ModemManager[315]: <debug> Starting QCDM-based registration checks
Jan 12 13:34:13 fbx ModemManager[315]: <debug>   Skipping all QCDM-based checks and falling back to AT-based 
checks
Jan 12 13:34:13 fbx ModemManager[315]: <debug> Starting AT-based registration checks
Jan 12 13:34:13 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (open)
Jan 12 13:34:13 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CAD?<CR>'
Jan 12 13:34:13 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+CAD: 1<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:34:13 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 3 (open)
Jan 12 13:34:13 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (close)
Jan 12 13:34:13 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CSS?<CR>'
Jan 12 13:34:13 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+CSS: ?, 0<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:34:13 fbx ModemManager[315]: <debug> Not registered in any CDMA network
Jan 12 13:34:13 fbx ModemManager[315]: <debug> All CDMA registration state checks done
Jan 12 13:34:13 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 1 (close)
Jan 12 13:34:13 fbx ModemManager[315]: <debug> Modem not yet registered in a CDMA network... will recheck soon
Jan 12 13:34:16 fbx ModemManager[315]: <debug> Running registration checks (CDMA1x: 'yes', EV-DO: 'yes')
Jan 12 13:34:16 fbx ModemManager[315]: <debug> Will skip all QCDM-based registration checks
Jan 12 13:34:16 fbx ModemManager[315]: <debug> Will skip generic detailed registration check, we don't have 
Sprint commands
Jan 12 13:34:16 fbx ModemManager[315]: <debug> Starting QCDM-based registration checks
Jan 12 13:34:16 fbx ModemManager[315]: <debug>   Skipping all QCDM-based checks and falling back to AT-based 
checks
Jan 12 13:34:16 fbx ModemManager[315]: <debug> Starting AT-based registration checks
Jan 12 13:34:16 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (open)
Jan 12 13:34:16 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CAD?<CR>'
Jan 12 13:34:16 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+CAD: 1<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:34:16 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 3 (open)
Jan 12 13:34:16 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (close)
Jan 12 13:34:16 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CSS?<CR>'
Jan 12 13:34:16 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+CSS: ?, 0<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:34:16 fbx ModemManager[315]: <debug> Not registered in any CDMA network
Jan 12 13:34:16 fbx ModemManager[315]: <debug> All CDMA registration state checks done
Jan 12 13:34:16 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 1 (close)
Jan 12 13:34:16 fbx ModemManager[315]: <debug> Modem not yet registered in a CDMA network... will recheck soon
Jan 12 13:34:19 fbx ModemManager[315]: <debug> Running registration checks (CDMA1x: 'yes', EV-DO: 'yes')
Jan 12 13:34:19 fbx ModemManager[315]: <debug> Will skip all QCDM-based registration checks
Jan 12 13:34:19 fbx ModemManager[315]: <debug> Will skip generic detailed registration check, we don't have 
Sprint commands
Jan 12 13:34:19 fbx ModemManager[315]: <debug> Starting QCDM-based registration checks
Jan 12 13:34:19 fbx ModemManager[315]: <debug>   Skipping all QCDM-based checks and falling back to AT-based 
checks
Jan 12 13:34:19 fbx ModemManager[315]: <debug> Starting AT-based registration checks
Jan 12 13:34:19 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (open)
Jan 12 13:34:19 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CAD?<CR>'
Jan 12 13:34:19 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+CAD: 1<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:34:19 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 3 (open)
Jan 12 13:34:19 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (close)
Jan 12 13:34:19 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CSS?<CR>'
Jan 12 13:34:19 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+CSS: ?, 0<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:34:19 fbx ModemManager[315]: <debug> Not registered in any CDMA network
Jan 12 13:34:19 fbx ModemManager[315]: <debug> All CDMA registration state checks done
Jan 12 13:34:19 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 1 (close)
Jan 12 13:34:19 fbx ModemManager[315]: <debug> Modem not yet registered in a CDMA network... will recheck soon
Jan 12 13:34:21 fbx ntpd[838]: error resolving pool 1.debian.pool.ntp.org: Name or service not known (-2)
Jan 12 13:34:22 fbx ModemManager[315]: <debug> Running registration checks (CDMA1x: 'yes', EV-DO: 'yes')
Jan 12 13:34:22 fbx ModemManager[315]: <debug> Will skip all QCDM-based registration checks
Jan 12 13:34:22 fbx ModemManager[315]: <debug> Will skip generic detailed registration check, we don't have 
Sprint commands
Jan 12 13:34:22 fbx ModemManager[315]: <debug> Starting QCDM-based registration checks
Jan 12 13:34:22 fbx ModemManager[315]: <debug>   Skipping all QCDM-based checks and falling back to AT-based 
checks
Jan 12 13:34:22 fbx ModemManager[315]: <debug> Starting AT-based registration checks
Jan 12 13:34:22 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (open)
Jan 12 13:34:22 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CAD?<CR>'
Jan 12 13:34:22 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+CAD: 1<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:34:22 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 3 (open)
Jan 12 13:34:22 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (close)
Jan 12 13:34:22 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CSS?<CR>'
Jan 12 13:34:22 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+CSS: ?, 0<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:34:22 fbx ModemManager[315]: <debug> Not registered in any CDMA network
Jan 12 13:34:22 fbx ModemManager[315]: <debug> All CDMA registration state checks done
Jan 12 13:34:22 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 1 (close)
Jan 12 13:34:22 fbx ModemManager[315]: <debug> Modem not yet registered in a CDMA network... will recheck soon
Jan 12 13:34:25 fbx ModemManager[315]: <debug> Running registration checks (CDMA1x: 'yes', EV-DO: 'yes')
Jan 12 13:34:25 fbx ModemManager[315]: <debug> Will skip all QCDM-based registration checks
Jan 12 13:34:25 fbx ModemManager[315]: <debug> Will skip generic detailed registration check, we don't have 
Sprint commands
Jan 12 13:34:25 fbx ModemManager[315]: <debug> Starting QCDM-based registration checks
Jan 12 13:34:25 fbx ModemManager[315]: <debug>   Skipping all QCDM-based checks and falling back to AT-based 
checks
Jan 12 13:34:25 fbx ModemManager[315]: <debug> Starting AT-based registration checks
Jan 12 13:34:25 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (open)
Jan 12 13:34:25 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CAD?<CR>'
Jan 12 13:34:25 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+CAD: 1<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:34:25 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 3 (open)
Jan 12 13:34:25 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (close)
Jan 12 13:34:25 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CSS?<CR>'
Jan 12 13:34:25 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+CSS: ?, 0<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:34:25 fbx ModemManager[315]: <debug> Not registered in any CDMA network
Jan 12 13:34:25 fbx ModemManager[315]: <debug> All CDMA registration state checks done
Jan 12 13:34:25 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 1 (close)
Jan 12 13:34:25 fbx ModemManager[315]: <debug> Modem not yet registered in a CDMA network... will recheck soon
Jan 12 13:34:28 fbx ModemManager[315]: <debug> Running registration checks (CDMA1x: 'yes', EV-DO: 'yes')
Jan 12 13:34:28 fbx ModemManager[315]: <debug> Will skip all QCDM-based registration checks
Jan 12 13:34:28 fbx ModemManager[315]: <debug> Will skip generic detailed registration check, we don't have 
Sprint commands
Jan 12 13:34:28 fbx ModemManager[315]: <debug> Starting QCDM-based registration checks
Jan 12 13:34:28 fbx ModemManager[315]: <debug>   Skipping all QCDM-based checks and falling back to AT-based 
checks
Jan 12 13:34:28 fbx ModemManager[315]: <debug> Starting AT-based registration checks
Jan 12 13:34:28 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (open)
Jan 12 13:34:28 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CAD?<CR>'
Jan 12 13:34:28 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+CAD: 1<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:34:28 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 3 (open)
Jan 12 13:34:28 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (close)
Jan 12 13:34:28 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CSS?<CR>'
Jan 12 13:34:28 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+CSS: ?, 0<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:34:28 fbx ModemManager[315]: <debug> Not registered in any CDMA network
Jan 12 13:34:28 fbx ModemManager[315]: <debug> All CDMA registration state checks done
Jan 12 13:34:28 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 1 (close)
Jan 12 13:34:28 fbx ModemManager[315]: <debug> Modem not yet registered in a CDMA network... will recheck soon
Jan 12 13:34:31 fbx ntpd[838]: error resolving pool 2.debian.pool.ntp.org: Name or service not known (-2)
Jan 12 13:34:31 fbx ModemManager[315]: <debug> Running registration checks (CDMA1x: 'yes', EV-DO: 'yes')
Jan 12 13:34:31 fbx ModemManager[315]: <debug> Will skip all QCDM-based registration checks
Jan 12 13:34:31 fbx ModemManager[315]: <debug> Will skip generic detailed registration check, we don't have 
Sprint commands
Jan 12 13:34:31 fbx ModemManager[315]: <debug> Starting QCDM-based registration checks
Jan 12 13:34:31 fbx ModemManager[315]: <debug>   Skipping all QCDM-based checks and falling back to AT-based 
checks
Jan 12 13:34:31 fbx ModemManager[315]: <debug> Starting AT-based registration checks
Jan 12 13:34:31 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (open)
Jan 12 13:34:31 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CAD?<CR>'
Jan 12 13:34:31 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+CAD: 1<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:34:31 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 3 (open)
Jan 12 13:34:31 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (close)
Jan 12 13:34:31 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CSS?<CR>'
Jan 12 13:34:31 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+CSS: ?, 0<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:34:31 fbx ModemManager[315]: <debug> Not registered in any CDMA network
Jan 12 13:34:31 fbx ModemManager[315]: <debug> All CDMA registration state checks done
Jan 12 13:34:31 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 1 (close)
Jan 12 13:34:31 fbx ModemManager[315]: <debug> Modem not yet registered in a CDMA network... will recheck soon
Jan 12 13:34:34 fbx ModemManager[315]: <debug> Running registration checks (CDMA1x: 'yes', EV-DO: 'yes')
Jan 12 13:34:34 fbx ModemManager[315]: <debug> Will skip all QCDM-based registration checks
Jan 12 13:34:34 fbx ModemManager[315]: <debug> Will skip generic detailed registration check, we don't have 
Sprint commands
Jan 12 13:34:34 fbx ModemManager[315]: <debug> Starting QCDM-based registration checks
Jan 12 13:34:34 fbx ModemManager[315]: <debug>   Skipping all QCDM-based checks and falling back to AT-based 
checks
Jan 12 13:34:34 fbx ModemManager[315]: <debug> Starting AT-based registration checks
Jan 12 13:34:34 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (open)
Jan 12 13:34:34 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CAD?<CR>'
Jan 12 13:34:34 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+CAD: 1<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:34:34 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 3 (open)
Jan 12 13:34:34 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (close)
Jan 12 13:34:34 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CSS?<CR>'
Jan 12 13:34:34 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+CSS: ?, 0<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:34:34 fbx ModemManager[315]: <debug> Not registered in any CDMA network
Jan 12 13:34:34 fbx ModemManager[315]: <debug> All CDMA registration state checks done
Jan 12 13:34:34 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 1 (close)
Jan 12 13:34:34 fbx ModemManager[315]: <debug> Modem not yet registered in a CDMA network... will recheck soon
Jan 12 13:34:37 fbx ModemManager[315]: <debug> Running registration checks (CDMA1x: 'yes', EV-DO: 'yes')
Jan 12 13:34:37 fbx ModemManager[315]: <debug> Will skip all QCDM-based registration checks
Jan 12 13:34:37 fbx ModemManager[315]: <debug> Will skip generic detailed registration check, we don't have 
Sprint commands
Jan 12 13:34:37 fbx ModemManager[315]: <debug> Starting QCDM-based registration checks
Jan 12 13:34:37 fbx ModemManager[315]: <debug>   Skipping all QCDM-based checks and falling back to AT-based 
checks
Jan 12 13:34:37 fbx ModemManager[315]: <debug> Starting AT-based registration checks
Jan 12 13:34:37 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (open)
Jan 12 13:34:37 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CAD?<CR>'
Jan 12 13:34:37 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+CAD: 1<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:34:37 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 3 (open)
Jan 12 13:34:37 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (close)
Jan 12 13:34:37 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CSS?<CR>'
Jan 12 13:34:37 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+CSS: ?, 0<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:34:37 fbx ModemManager[315]: <debug> Not registered in any CDMA network
Jan 12 13:34:37 fbx ModemManager[315]: <debug> All CDMA registration state checks done
Jan 12 13:34:37 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 1 (close)
Jan 12 13:34:37 fbx ModemManager[315]: <debug> Modem not yet registered in a CDMA network... will recheck soon
Jan 12 13:34:39 fbx ModemManager[315]: <debug> Running registration checks (CDMA1x: 'yes', EV-DO: 'yes')
Jan 12 13:34:39 fbx ModemManager[315]: <debug> Will skip all QCDM-based registration checks
Jan 12 13:34:39 fbx ModemManager[315]: <debug> Will skip generic detailed registration check, we don't have 
Sprint commands
Jan 12 13:34:39 fbx ModemManager[315]: <debug> Starting QCDM-based registration checks
Jan 12 13:34:39 fbx ModemManager[315]: <debug>   Skipping all QCDM-based checks and falling back to AT-based 
checks
Jan 12 13:34:39 fbx ModemManager[315]: <debug> Starting AT-based registration checks
Jan 12 13:34:39 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (open)
Jan 12 13:34:39 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CAD?<CR>'
Jan 12 13:34:39 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+CAD: 1<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:34:39 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 3 (open)
Jan 12 13:34:39 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (close)
Jan 12 13:34:39 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CSS?<CR>'
Jan 12 13:34:39 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+CSS: ?, 0<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:34:39 fbx ModemManager[315]: <debug> Not registered in any CDMA network
Jan 12 13:34:39 fbx ModemManager[315]: <debug> All CDMA registration state checks done
Jan 12 13:34:39 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 1 (close)
Jan 12 13:34:40 fbx ModemManager[315]: <debug> Running registration checks (CDMA1x: 'yes', EV-DO: 'yes')
Jan 12 13:34:40 fbx ModemManager[315]: <debug> Will skip all QCDM-based registration checks
Jan 12 13:34:40 fbx ModemManager[315]: <debug> Will skip generic detailed registration check, we don't have 
Sprint commands
Jan 12 13:34:40 fbx ModemManager[315]: <debug> Starting QCDM-based registration checks
Jan 12 13:34:40 fbx ModemManager[315]: <debug>   Skipping all QCDM-based checks and falling back to AT-based 
checks
Jan 12 13:34:40 fbx ModemManager[315]: <debug> Starting AT-based registration checks
Jan 12 13:34:40 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (open)
Jan 12 13:34:40 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CAD?<CR>'
Jan 12 13:34:40 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+CAD: 1<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:34:40 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 3 (open)
Jan 12 13:34:40 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (close)
Jan 12 13:34:40 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CSS?<CR>'
Jan 12 13:34:40 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+CSS: ?, 0<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:34:40 fbx ModemManager[315]: <debug> Not registered in any CDMA network
Jan 12 13:34:40 fbx ModemManager[315]: <debug> All CDMA registration state checks done
Jan 12 13:34:40 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 1 (close)
Jan 12 13:34:40 fbx ModemManager[315]: <debug> Modem not yet registered in a CDMA network... will recheck soon
Jan 12 13:34:41 fbx ntpd[838]: error resolving pool 0.debian.pool.ntp.org: Name or service not known (-2)
Jan 12 13:34:43 fbx ModemManager[315]: <debug> Running registration checks (CDMA1x: 'yes', EV-DO: 'yes')
Jan 12 13:34:43 fbx ModemManager[315]: <debug> Will skip all QCDM-based registration checks
Jan 12 13:34:43 fbx ModemManager[315]: <debug> Will skip generic detailed registration check, we don't have 
Sprint commands
Jan 12 13:34:43 fbx ModemManager[315]: <debug> Starting QCDM-based registration checks
Jan 12 13:34:43 fbx ModemManager[315]: <debug>   Skipping all QCDM-based checks and falling back to AT-based 
checks
Jan 12 13:34:43 fbx ModemManager[315]: <debug> Starting AT-based registration checks
Jan 12 13:34:43 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (open)
Jan 12 13:34:43 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CAD?<CR>'
Jan 12 13:34:43 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+CAD: 1<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:34:43 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 3 (open)
Jan 12 13:34:43 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (close)
Jan 12 13:34:43 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CSS?<CR>'
Jan 12 13:34:43 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+CSS: ?, 0<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:34:43 fbx ModemManager[315]: <debug> Not registered in any CDMA network
Jan 12 13:34:43 fbx ModemManager[315]: <debug> All CDMA registration state checks done
Jan 12 13:34:43 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 1 (close)
Jan 12 13:34:43 fbx ModemManager[315]: <debug> Modem not yet registered in a CDMA network... will recheck soon
Jan 12 13:34:46 fbx ModemManager[315]: <debug> Running registration checks (CDMA1x: 'yes', EV-DO: 'yes')
Jan 12 13:34:46 fbx ModemManager[315]: <debug> Will skip all QCDM-based registration checks
Jan 12 13:34:46 fbx ModemManager[315]: <debug> Will skip generic detailed registration check, we don't have 
Sprint commands
Jan 12 13:34:46 fbx ModemManager[315]: <debug> Starting QCDM-based registration checks
Jan 12 13:34:46 fbx ModemManager[315]: <debug>   Skipping all QCDM-based checks and falling back to AT-based 
checks
Jan 12 13:34:46 fbx ModemManager[315]: <debug> Starting AT-based registration checks
Jan 12 13:34:46 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (open)
Jan 12 13:34:46 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CAD?<CR>'
Jan 12 13:34:46 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+CAD: 1<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:34:46 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 3 (open)
Jan 12 13:34:46 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (close)
Jan 12 13:34:46 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CSS?<CR>'
Jan 12 13:34:46 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+CSS: ?, 0<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:34:46 fbx ModemManager[315]: <debug> Not registered in any CDMA network
Jan 12 13:34:46 fbx ModemManager[315]: <debug> All CDMA registration state checks done
Jan 12 13:34:46 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 1 (close)
Jan 12 13:34:46 fbx ModemManager[315]: <debug> Modem not yet registered in a CDMA network... will recheck soon
Jan 12 13:34:49 fbx ModemManager[315]: <debug> Running registration checks (CDMA1x: 'yes', EV-DO: 'yes')
Jan 12 13:34:49 fbx ModemManager[315]: <debug> Will skip all QCDM-based registration checks
Jan 12 13:34:49 fbx ModemManager[315]: <debug> Will skip generic detailed registration check, we don't have 
Sprint commands
Jan 12 13:34:49 fbx ModemManager[315]: <debug> Starting QCDM-based registration checks
Jan 12 13:34:49 fbx ModemManager[315]: <debug>   Skipping all QCDM-based checks and falling back to AT-based 
checks
Jan 12 13:34:49 fbx ModemManager[315]: <debug> Starting AT-based registration checks
Jan 12 13:34:49 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (open)
Jan 12 13:34:49 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CAD?<CR>'
Jan 12 13:34:49 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+CAD: 1<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:34:49 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 3 (open)
Jan 12 13:34:49 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (close)
Jan 12 13:34:49 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CSS?<CR>'
Jan 12 13:34:49 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+CSS: ?, 0<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:34:49 fbx ModemManager[315]: <debug> Not registered in any CDMA network
Jan 12 13:34:49 fbx ModemManager[315]: <debug> All CDMA registration state checks done
Jan 12 13:34:49 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 1 (close)
Jan 12 13:34:49 fbx ModemManager[315]: <debug> Modem not yet registered in a CDMA network... will recheck soon
Jan 12 13:34:52 fbx ModemManager[315]: <debug> Running registration checks (CDMA1x: 'yes', EV-DO: 'yes')
Jan 12 13:34:52 fbx ModemManager[315]: <debug> Will skip all QCDM-based registration checks
Jan 12 13:34:52 fbx ModemManager[315]: <debug> Will skip generic detailed registration check, we don't have 
Sprint commands
Jan 12 13:34:52 fbx ModemManager[315]: <debug> Starting QCDM-based registration checks
Jan 12 13:34:52 fbx ModemManager[315]: <debug>   Skipping all QCDM-based checks and falling back to AT-based 
checks
Jan 12 13:34:52 fbx ModemManager[315]: <debug> Starting AT-based registration checks
Jan 12 13:34:52 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (open)
Jan 12 13:34:52 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CAD?<CR>'
Jan 12 13:34:52 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+CAD: 1<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:34:52 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 3 (open)
Jan 12 13:34:52 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (close)
Jan 12 13:34:52 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CSS?<CR>'
Jan 12 13:34:52 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+CSS: ?, 0<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:34:52 fbx ModemManager[315]: <debug> Not registered in any CDMA network
Jan 12 13:34:52 fbx ModemManager[315]: <debug> All CDMA registration state checks done
Jan 12 13:34:52 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 1 (close)
Jan 12 13:34:52 fbx ModemManager[315]: <debug> Modem not yet registered in a CDMA network... will recheck soon
Jan 12 13:34:55 fbx ModemManager[315]: <debug> Running registration checks (CDMA1x: 'yes', EV-DO: 'yes')
Jan 12 13:34:55 fbx ModemManager[315]: <debug> Will skip all QCDM-based registration checks
Jan 12 13:34:55 fbx ModemManager[315]: <debug> Will skip generic detailed registration check, we don't have 
Sprint commands
Jan 12 13:34:55 fbx ModemManager[315]: <debug> Starting QCDM-based registration checks
Jan 12 13:34:55 fbx ModemManager[315]: <debug>   Skipping all QCDM-based checks and falling back to AT-based 
checks
Jan 12 13:34:55 fbx ModemManager[315]: <debug> Starting AT-based registration checks
Jan 12 13:34:55 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (open)
Jan 12 13:34:55 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CAD?<CR>'
Jan 12 13:34:55 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+CAD: 1<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:34:55 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 3 (open)
Jan 12 13:34:55 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (close)
Jan 12 13:34:55 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CSS?<CR>'
Jan 12 13:34:55 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+CSS: ?, 0<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:34:55 fbx ModemManager[315]: <debug> Not registered in any CDMA network
Jan 12 13:34:55 fbx ModemManager[315]: <debug> All CDMA registration state checks done
Jan 12 13:34:55 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 1 (close)
Jan 12 13:34:55 fbx ModemManager[315]: <debug> Modem not yet registered in a CDMA network... will recheck soon
Jan 12 13:34:58 fbx ModemManager[315]: <debug> Running registration checks (CDMA1x: 'yes', EV-DO: 'yes')
Jan 12 13:34:58 fbx ModemManager[315]: <debug> Will skip all QCDM-based registration checks
Jan 12 13:34:58 fbx ModemManager[315]: <debug> Will skip generic detailed registration check, we don't have 
Sprint commands
Jan 12 13:34:58 fbx ModemManager[315]: <debug> Starting QCDM-based registration checks
Jan 12 13:34:58 fbx ModemManager[315]: <debug>   Skipping all QCDM-based checks and falling back to AT-based 
checks
Jan 12 13:34:58 fbx ModemManager[315]: <debug> Starting AT-based registration checks
Jan 12 13:34:58 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (open)
Jan 12 13:34:58 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CAD?<CR>'
Jan 12 13:34:58 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+CAD: 1<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:34:58 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 3 (open)
Jan 12 13:34:58 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (close)
Jan 12 13:34:58 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CSS?<CR>'
Jan 12 13:34:58 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+CSS: ?, 0<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:34:58 fbx ModemManager[315]: <debug> Not registered in any CDMA network
Jan 12 13:34:58 fbx ModemManager[315]: <debug> All CDMA registration state checks done
Jan 12 13:34:58 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 1 (close)
Jan 12 13:34:58 fbx ModemManager[315]: <debug> Modem not yet registered in a CDMA network... will recheck soon
Jan 12 13:35:01 fbx CRON[20282]: (root) CMD (/usr/share/plinth/actions/dynamicdns update)
Jan 12 13:35:01 fbx ModemManager[315]: <debug> Running registration checks (CDMA1x: 'yes', EV-DO: 'yes')
Jan 12 13:35:01 fbx ModemManager[315]: <debug> Will skip all QCDM-based registration checks
Jan 12 13:35:01 fbx ModemManager[315]: <debug> Will skip generic detailed registration check, we don't have 
Sprint commands
Jan 12 13:35:01 fbx ModemManager[315]: <debug> Starting QCDM-based registration checks
Jan 12 13:35:01 fbx ModemManager[315]: <debug>   Skipping all QCDM-based checks and falling back to AT-based 
checks
Jan 12 13:35:01 fbx ModemManager[315]: <debug> Starting AT-based registration checks
Jan 12 13:35:01 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (open)
Jan 12 13:35:01 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CAD?<CR>'
Jan 12 13:35:01 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+CAD: 1<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:35:01 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 3 (open)
Jan 12 13:35:01 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (close)
Jan 12 13:35:01 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CSS?<CR>'
Jan 12 13:35:01 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+CSS: ?, 0<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:35:01 fbx ModemManager[315]: <debug> Not registered in any CDMA network
Jan 12 13:35:01 fbx ModemManager[315]: <debug> All CDMA registration state checks done
Jan 12 13:35:01 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 1 (close)
Jan 12 13:35:01 fbx ModemManager[315]: <debug> Modem not yet registered in a CDMA network... will recheck soon
Jan 12 13:35:04 fbx ModemManager[315]: <debug> Running registration checks (CDMA1x: 'yes', EV-DO: 'yes')
Jan 12 13:35:04 fbx ModemManager[315]: <debug> Will skip all QCDM-based registration checks
Jan 12 13:35:04 fbx ModemManager[315]: <debug> Will skip generic detailed registration check, we don't have 
Sprint commands
Jan 12 13:35:04 fbx ModemManager[315]: <debug> Starting QCDM-based registration checks
Jan 12 13:35:04 fbx ModemManager[315]: <debug>   Skipping all QCDM-based checks and falling back to AT-based 
checks
Jan 12 13:35:04 fbx ModemManager[315]: <debug> Starting AT-based registration checks
Jan 12 13:35:04 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (open)
Jan 12 13:35:04 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CAD?<CR>'
Jan 12 13:35:04 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+CAD: 1<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:35:04 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 3 (open)
Jan 12 13:35:04 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (close)
Jan 12 13:35:04 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CSS?<CR>'
Jan 12 13:35:04 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+CSS: ?, 0<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:35:04 fbx ModemManager[315]: <debug> Not registered in any CDMA network
Jan 12 13:35:04 fbx ModemManager[315]: <debug> All CDMA registration state checks done
Jan 12 13:35:04 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 1 (close)
Jan 12 13:35:04 fbx ModemManager[315]: <debug> Modem not yet registered in a CDMA network... will recheck soon
Jan 12 13:35:07 fbx ModemManager[315]: <debug> Running registration checks (CDMA1x: 'yes', EV-DO: 'yes')
Jan 12 13:35:07 fbx ModemManager[315]: <debug> Will skip all QCDM-based registration checks
Jan 12 13:35:07 fbx ModemManager[315]: <debug> Will skip generic detailed registration check, we don't have 
Sprint commands
Jan 12 13:35:07 fbx ModemManager[315]: <debug> Starting QCDM-based registration checks
Jan 12 13:35:07 fbx ModemManager[315]: <debug>   Skipping all QCDM-based checks and falling back to AT-based 
checks
Jan 12 13:35:07 fbx ModemManager[315]: <debug> Starting AT-based registration checks
Jan 12 13:35:07 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (open)
Jan 12 13:35:07 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CAD?<CR>'
Jan 12 13:35:07 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+CAD: 1<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:35:07 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 3 (open)
Jan 12 13:35:07 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (close)
Jan 12 13:35:07 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CSS?<CR>'
Jan 12 13:35:07 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+CSS: ?, 0<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:35:07 fbx ModemManager[315]: <debug> Not registered in any CDMA network
Jan 12 13:35:07 fbx ModemManager[315]: <debug> All CDMA registration state checks done
Jan 12 13:35:07 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 1 (close)
Jan 12 13:35:07 fbx ModemManager[315]: <debug> Modem not yet registered in a CDMA network... will recheck soon
Jan 12 13:35:09 fbx ModemManager[315]: <debug> Running registration checks (CDMA1x: 'yes', EV-DO: 'yes')
Jan 12 13:35:09 fbx ModemManager[315]: <debug> Will skip all QCDM-based registration checks
Jan 12 13:35:09 fbx ModemManager[315]: <debug> Will skip generic detailed registration check, we don't have 
Sprint commands
Jan 12 13:35:09 fbx ModemManager[315]: <debug> Starting QCDM-based registration checks
Jan 12 13:35:09 fbx ModemManager[315]: <debug>   Skipping all QCDM-based checks and falling back to AT-based 
checks
Jan 12 13:35:09 fbx ModemManager[315]: <debug> Starting AT-based registration checks
Jan 12 13:35:09 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (open)
Jan 12 13:35:09 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CAD?<CR>'
Jan 12 13:35:09 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+CAD: 1<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:35:09 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 3 (open)
Jan 12 13:35:09 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (close)
Jan 12 13:35:09 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CSS?<CR>'
Jan 12 13:35:09 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+CSS: ?, 0<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:35:09 fbx ModemManager[315]: <debug> Not registered in any CDMA network
Jan 12 13:35:09 fbx ModemManager[315]: <debug> All CDMA registration state checks done
Jan 12 13:35:09 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 1 (close)
Jan 12 13:35:10 fbx ModemManager[315]: <debug> Running registration checks (CDMA1x: 'yes', EV-DO: 'yes')
Jan 12 13:35:10 fbx ModemManager[315]: <debug> Will skip all QCDM-based registration checks
Jan 12 13:35:10 fbx ModemManager[315]: <debug> Will skip generic detailed registration check, we don't have 
Sprint commands
Jan 12 13:35:10 fbx ModemManager[315]: <debug> Starting QCDM-based registration checks
Jan 12 13:35:10 fbx ModemManager[315]: <debug>   Skipping all QCDM-based checks and falling back to AT-based 
checks
Jan 12 13:35:10 fbx ModemManager[315]: <debug> Starting AT-based registration checks
Jan 12 13:35:10 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (open)
Jan 12 13:35:10 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CAD?<CR>'
Jan 12 13:35:10 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+CAD: 1<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:35:10 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 3 (open)
Jan 12 13:35:10 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (close)
Jan 12 13:35:10 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CSS?<CR>'
Jan 12 13:35:10 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+CSS: ?, 0<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:35:10 fbx ModemManager[315]: <debug> Not registered in any CDMA network
Jan 12 13:35:10 fbx ModemManager[315]: <debug> All CDMA registration state checks done
Jan 12 13:35:10 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 1 (close)
Jan 12 13:35:10 fbx NetworkManager[379]: <warn>  [1484246110.8850] modem-broadband[ttyACM0]: failed to 
connect modem: Network timeout
Jan 12 13:35:10 fbx ModemManager[315]: <debug> CDMA registration check timed out
Jan 12 13:35:10 fbx NetworkManager[379]: <info>  [1484246110.8852] device (ttyACM0): state change: prepare -> 
failed (reason 'gsm-registration-timeout') [40 120 32]
Jan 12 13:35:10 fbx NetworkManager[379]: <warn>  [1484246110.8882] device (ttyACM0): Activation: failed for 
connection 'ppp'
Jan 12 13:35:10 fbx NetworkManager[379]: <info>  [1484246110.8917] device (ttyACM0): state change: failed -> 
disconnected (reason 'none') [120 30 0]
Jan 12 13:35:10 fbx NetworkManager[379]: <info>  [1484246110.8962] policy: auto-activating connection 'ppp'
Jan 12 13:35:10 fbx NetworkManager[379]: <info>  [1484246110.9016] device (ttyACM0): Activation: starting 
connection 'ppp' (f2cc6f30-1726-42c2-b580-3ac8a98a21ec)
Jan 12 13:35:10 fbx NetworkManager[379]: <info>  [1484246110.9024] device (ttyACM0): state change: 
disconnected -> prepare (reason 'none') [30 40 0]
Jan 12 13:35:10 fbx NetworkManager[379]: <info>  [1484246110.9046] device (ttyACM0): state change: prepare -> 
need-auth (reason 'none') [40 60 0]
Jan 12 13:35:10 fbx NetworkManager[379]: <info>  [1484246110.9222] device (ttyACM0): state change: need-auth 
-> prepare (reason 'none') [60 40 0]
Jan 12 13:35:10 fbx firewalld[334]: ERROR: UNKNOWN_INTERFACE: 'ttyACM0' is not in any zone
Jan 12 13:35:10 fbx NetworkManager[379]: <warn>  [1484246110.9287] firewall: 
[0x55b1803cad30,remove:"ttyACM0"]: complete: request failed (UNKNOWN_INTERFACE: 'ttyACM0' is not in any zone)

... Another 3 cycles of "Simple connect started..." deleted.

Jan 12 13:43:19 fbx ModemManager[315]: <info>  Simple connect started...
Jan 12 13:43:19 fbx ModemManager[315]: <debug>    PIN: unspecified
Jan 12 13:43:19 fbx ModemManager[315]: <debug>    Operator ID: unspecified
Jan 12 13:43:19 fbx ModemManager[315]: <debug>    Allowed roaming: yes
Jan 12 13:43:19 fbx ModemManager[315]: <debug>    APN: unspecified
Jan 12 13:43:19 fbx ModemManager[315]: <debug>    IP family: ipv4
Jan 12 13:43:19 fbx ModemManager[315]: <debug>    Allowed authentication: unspecified
Jan 12 13:43:19 fbx ModemManager[315]: <debug>    User: unspecified
Jan 12 13:43:19 fbx ModemManager[315]: <debug>    Password: unspecified
Jan 12 13:43:19 fbx ModemManager[315]: <debug>    Number: #777
Jan 12 13:43:19 fbx ModemManager[315]: <info>  Simple connect state (4/8): Wait to get fully enabled
Jan 12 13:43:19 fbx ModemManager[315]: <info>  Simple connect state (5/8): Register
Jan 12 13:43:19 fbx ModemManager[315]: <debug> Running registration checks (CDMA1x: 'yes', EV-DO: 'yes')
Jan 12 13:43:19 fbx ModemManager[315]: <debug> Will skip all QCDM-based registration checks
Jan 12 13:43:19 fbx ModemManager[315]: <debug> Will skip generic detailed registration check, we don't have 
Sprint commands
Jan 12 13:43:19 fbx ModemManager[315]: <debug> Starting QCDM-based registration checks
Jan 12 13:43:19 fbx ModemManager[315]: <debug>   Skipping all QCDM-based checks and falling back to AT-based 
checks
Jan 12 13:43:19 fbx ModemManager[315]: <debug> Starting AT-based registration checks
Jan 12 13:43:19 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (open)
Jan 12 13:43:19 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CAD?<CR>'
Jan 12 13:43:19 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+CAD: 1<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:43:19 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 3 (open)
Jan 12 13:43:19 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (close)
Jan 12 13:43:19 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CSS?<CR>'
Jan 12 13:43:19 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+CSS: ?, 0<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:43:19 fbx ModemManager[315]: <debug> Not registered in any CDMA network
Jan 12 13:43:19 fbx ModemManager[315]: <debug> All CDMA registration state checks done
Jan 12 13:43:19 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 1 (close)
Jan 12 13:43:19 fbx ModemManager[315]: <debug> Modem not yet registered in a CDMA network... will recheck soon
Jan 12 13:43:22 fbx ModemManager[315]: <debug> Running registration checks (CDMA1x: 'yes', EV-DO: 'yes')
Jan 12 13:43:22 fbx ModemManager[315]: <debug> Will skip all QCDM-based registration checks
Jan 12 13:43:22 fbx ModemManager[315]: <debug> Will skip generic detailed registration check, we don't have 
Sprint commands
Jan 12 13:43:22 fbx ModemManager[315]: <debug> Starting QCDM-based registration checks
Jan 12 13:43:22 fbx ModemManager[315]: <debug>   Skipping all QCDM-based checks and falling back to AT-based 
checks
Jan 12 13:43:22 fbx ModemManager[315]: <debug> Starting AT-based registration checks
Jan 12 13:43:22 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (open)
Jan 12 13:43:22 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CAD?<CR>'
Jan 12 13:43:22 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+CAD: 1<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:43:22 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 3 (open)
Jan 12 13:43:22 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (close)
Jan 12 13:43:22 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CSS?<CR>'
Jan 12 13:43:22 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+CSS: ?, 0<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:43:22 fbx ModemManager[315]: <debug> Not registered in any CDMA network
Jan 12 13:43:22 fbx ModemManager[315]: <debug> All CDMA registration state checks done
Jan 12 13:43:22 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 1 (close)
Jan 12 13:43:22 fbx ModemManager[315]: <debug> Modem not yet registered in a CDMA network... will recheck soon
Jan 12 13:43:25 fbx ModemManager[315]: <debug> Running registration checks (CDMA1x: 'yes', EV-DO: 'yes')
Jan 12 13:43:25 fbx ModemManager[315]: <debug> Will skip all QCDM-based registration checks
Jan 12 13:43:25 fbx ModemManager[315]: <debug> Will skip generic detailed registration check, we don't have 
Sprint commands
Jan 12 13:43:25 fbx ModemManager[315]: <debug> Starting QCDM-based registration checks
Jan 12 13:43:25 fbx ModemManager[315]: <debug>   Skipping all QCDM-based checks and falling back to AT-based 
checks
Jan 12 13:43:25 fbx ModemManager[315]: <debug> Starting AT-based registration checks
Jan 12 13:43:25 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (open)
Jan 12 13:43:25 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CAD?<CR>'
Jan 12 13:43:25 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+CAD: 1<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:43:25 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 3 (open)
Jan 12 13:43:25 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (close)
Jan 12 13:43:25 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CSS?<CR>'
Jan 12 13:43:25 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+CSS: ?, 0<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:43:25 fbx ModemManager[315]: <debug> Not registered in any CDMA network
Jan 12 13:43:25 fbx ModemManager[315]: <debug> All CDMA registration state checks done
Jan 12 13:43:25 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 1 (close)
Jan 12 13:43:25 fbx ModemManager[315]: <debug> Modem not yet registered in a CDMA network... will recheck soon
Jan 12 13:43:28 fbx ntpd[838]: error resolving pool 0.debian.pool.ntp.org: Name or service not known (-2)
Jan 12 13:43:28 fbx ModemManager[315]: <debug> Running registration checks (CDMA1x: 'yes', EV-DO: 'yes')
Jan 12 13:43:28 fbx ModemManager[315]: <debug> Will skip all QCDM-based registration checks
Jan 12 13:43:28 fbx ModemManager[315]: <debug> Will skip generic detailed registration check, we don't have 
Sprint commands
Jan 12 13:43:28 fbx ModemManager[315]: <debug> Starting QCDM-based registration checks
Jan 12 13:43:28 fbx ModemManager[315]: <debug>   Skipping all QCDM-based checks and falling back to AT-based 
checks
Jan 12 13:43:28 fbx ModemManager[315]: <debug> Starting AT-based registration checks
Jan 12 13:43:28 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (open)
Jan 12 13:43:28 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CAD?<CR>'
Jan 12 13:43:28 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+CAD: 1<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:43:28 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 3 (open)
Jan 12 13:43:28 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (close)
Jan 12 13:43:28 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CSS?<CR>'
Jan 12 13:43:28 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+CSS: ?, 0<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:43:28 fbx ModemManager[315]: <debug> Not registered in any CDMA network
Jan 12 13:43:28 fbx ModemManager[315]: <debug> All CDMA registration state checks done
Jan 12 13:43:28 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 1 (close)
Jan 12 13:43:28 fbx ModemManager[315]: <debug> Modem not yet registered in a CDMA network... will recheck soon
Jan 12 13:43:31 fbx ModemManager[315]: <debug> Running registration checks (CDMA1x: 'yes', EV-DO: 'yes')
Jan 12 13:43:31 fbx ModemManager[315]: <debug> Will skip all QCDM-based registration checks
Jan 12 13:43:31 fbx ModemManager[315]: <debug> Will skip generic detailed registration check, we don't have 
Sprint commands
Jan 12 13:43:31 fbx ModemManager[315]: <debug> Starting QCDM-based registration checks
Jan 12 13:43:31 fbx ModemManager[315]: <debug>   Skipping all QCDM-based checks and falling back to AT-based 
checks
Jan 12 13:43:31 fbx ModemManager[315]: <debug> Starting AT-based registration checks
Jan 12 13:43:31 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (open)
Jan 12 13:43:31 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CAD?<CR>'
Jan 12 13:43:31 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+CAD: 1<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:43:31 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 3 (open)
Jan 12 13:43:31 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (close)
Jan 12 13:43:31 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CSS?<CR>'
Jan 12 13:43:31 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+CSS: ?, 0<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:43:31 fbx ModemManager[315]: <debug> Not registered in any CDMA network
Jan 12 13:43:31 fbx ModemManager[315]: <debug> All CDMA registration state checks done
Jan 12 13:43:31 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 1 (close)
Jan 12 13:43:31 fbx ModemManager[315]: <debug> Modem not yet registered in a CDMA network... will recheck soon
Jan 12 13:43:34 fbx ModemManager[315]: <debug> Running registration checks (CDMA1x: 'yes', EV-DO: 'yes')
Jan 12 13:43:34 fbx ModemManager[315]: <debug> Will skip all QCDM-based registration checks
Jan 12 13:43:34 fbx ModemManager[315]: <debug> Will skip generic detailed registration check, we don't have 
Sprint commands
Jan 12 13:43:34 fbx ModemManager[315]: <debug> Starting QCDM-based registration checks
Jan 12 13:43:34 fbx ModemManager[315]: <debug>   Skipping all QCDM-based checks and falling back to AT-based 
checks
Jan 12 13:43:34 fbx ModemManager[315]: <debug> Starting AT-based registration checks
Jan 12 13:43:34 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (open)
Jan 12 13:43:34 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CAD?<CR>'
Jan 12 13:43:34 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+CAD: 1<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:43:34 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 3 (open)
Jan 12 13:43:34 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (close)
Jan 12 13:43:34 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CSS?<CR>'
Jan 12 13:43:34 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+CSS: ?, 0<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:43:34 fbx ModemManager[315]: <debug> Not registered in any CDMA network
Jan 12 13:43:34 fbx ModemManager[315]: <debug> All CDMA registration state checks done
Jan 12 13:43:34 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 1 (close)
Jan 12 13:43:34 fbx ModemManager[315]: <debug> Modem not yet registered in a CDMA network... will recheck soon
Jan 12 13:43:37 fbx ModemManager[315]: <debug> Running registration checks (CDMA1x: 'yes', EV-DO: 'yes')
Jan 12 13:43:37 fbx ModemManager[315]: <debug> Will skip all QCDM-based registration checks
Jan 12 13:43:37 fbx ModemManager[315]: <debug> Will skip generic detailed registration check, we don't have 
Sprint commands
Jan 12 13:43:37 fbx ModemManager[315]: <debug> Starting QCDM-based registration checks
Jan 12 13:43:37 fbx ModemManager[315]: <debug>   Skipping all QCDM-based checks and falling back to AT-based 
checks
Jan 12 13:43:37 fbx ModemManager[315]: <debug> Starting AT-based registration checks
Jan 12 13:43:37 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (open)
Jan 12 13:43:37 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CAD?<CR>'
Jan 12 13:43:37 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+CAD: 1<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:43:37 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 3 (open)
Jan 12 13:43:37 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (close)
Jan 12 13:43:37 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CSS?<CR>'
Jan 12 13:43:37 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+CSS: ?, 0<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:43:37 fbx ModemManager[315]: <debug> Not registered in any CDMA network
Jan 12 13:43:37 fbx ModemManager[315]: <debug> All CDMA registration state checks done
Jan 12 13:43:37 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 1 (close)
Jan 12 13:43:37 fbx ModemManager[315]: <debug> Modem not yet registered in a CDMA network... will recheck soon
Jan 12 13:43:39 fbx ModemManager[315]: <debug> Running registration checks (CDMA1x: 'yes', EV-DO: 'yes')
Jan 12 13:43:39 fbx ModemManager[315]: <debug> Will skip all QCDM-based registration checks
Jan 12 13:43:39 fbx ModemManager[315]: <debug> Will skip generic detailed registration check, we don't have 
Sprint commands
Jan 12 13:43:39 fbx ModemManager[315]: <debug> Starting QCDM-based registration checks
Jan 12 13:43:39 fbx ModemManager[315]: <debug>   Skipping all QCDM-based checks and falling back to AT-based 
checks
Jan 12 13:43:39 fbx ModemManager[315]: <debug> Starting AT-based registration checks
Jan 12 13:43:39 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (open)
Jan 12 13:43:39 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CAD?<CR>'
Jan 12 13:43:39 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+CAD: 1<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:43:39 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 3 (open)
Jan 12 13:43:39 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (close)
Jan 12 13:43:39 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CSS?<CR>'
Jan 12 13:43:39 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+CSS: ?, 0<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:43:39 fbx ModemManager[315]: <debug> Not registered in any CDMA network
Jan 12 13:43:39 fbx ModemManager[315]: <debug> All CDMA registration state checks done
Jan 12 13:43:39 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 1 (close)
Jan 12 13:43:40 fbx ModemManager[315]: <debug> Running registration checks (CDMA1x: 'yes', EV-DO: 'yes')
Jan 12 13:43:40 fbx ModemManager[315]: <debug> Will skip all QCDM-based registration checks
Jan 12 13:43:40 fbx ModemManager[315]: <debug> Will skip generic detailed registration check, we don't have 
Sprint commands
Jan 12 13:43:40 fbx ModemManager[315]: <debug> Starting QCDM-based registration checks
Jan 12 13:43:40 fbx ModemManager[315]: <debug>   Skipping all QCDM-based checks and falling back to AT-based 
checks
Jan 12 13:43:40 fbx ModemManager[315]: <debug> Starting AT-based registration checks
Jan 12 13:43:40 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (open)
Jan 12 13:43:40 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CAD?<CR>'
Jan 12 13:43:40 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+CAD: 1<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:43:40 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 3 (open)
Jan 12 13:43:40 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 2 (close)
Jan 12 13:43:40 fbx ModemManager[315]: <debug> (ttyACM0): --> 'AT+CSS?<CR>'
Jan 12 13:43:40 fbx ModemManager[315]: <debug> (ttyACM0): <-- '<CR><LF>+CSS: ?, 0<CR><LF><CR><LF>OK<CR><LF>'
Jan 12 13:43:40 fbx ModemManager[315]: <debug> Not registered in any CDMA network
Jan 12 13:43:40 fbx ModemManager[315]: <debug> All CDMA registration state checks done
Jan 12 13:43:40 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 1 (close)
Jan 12 13:43:40 fbx ModemManager[315]: <debug> Modem not yet registered in a CDMA network... will recheck soon
Jan 12 13:43:42 fbx ModemManager[315]: <debug> (ttyACM0) unexpected port hangup!
Jan 12 13:43:42 fbx kernel: [246722.127789] usb 4-1: USB disconnect, device number 7
Jan 12 13:43:42 fbx kernel: [246722.129398] cdc_acm 4-1:1.0: failed to set dtr/rts
Jan 12 13:43:42 fbx ModemManager[315]: <debug> (ttyACM0) forced to close port
Jan 12 13:43:42 fbx ModemManager[315]: <debug> (ttyACM0) device open count is 0 (close)
Jan 12 13:43:42 fbx ModemManager[315]: <debug> (ttyACM0) closing serial port...
Jan 12 13:43:42 fbx ModemManager[315]: <debug> (ttyACM0) serial port closed
Jan 12 13:43:42 fbx ModemManager[315]: <info>  (tty/ttyACM0): released by modem 
/sys/devices/pci0000:00/0000:00:12.0/usb4/4-1
Jan 12 13:43:42 fbx ModemManager[315]: <debug> Removing empty device 
'/sys/devices/pci0000:00/0000:00:12.0/usb4/4-1'
Jan 12 13:43:42 fbx ModemManager[315]: <debug> Unexported modem 
'/sys/devices/pci0000:00/0000:00:12.0/usb4/4-1' from path '/org/freedesktop/ModemManager1/Modem/5'
Jan 12 13:43:42 fbx NetworkManager[379]: <info>  [1484246622.2023] device (ttyACM0): state change: prepare -> 
unmanaged (reason 'removed') [40 10 36]
Jan 12 13:43:42 fbx NetworkManager[379]: <warn>  [1484246622.2113] modem-broadband[ttyACM0]: failed to 
disconnect modem: GDBus.Error:org.freedesktop.DBus.Error.UnknownMethod: No such interface 
'org.freedesktop.ModemManager1.Modem.Simple' on object at path /org/freedesktop/ModemManager1/Modem/5
Jan 12 13:43:43 fbx ModemManager[315]: <debug> Running registration checks (CDMA1x: 'yes', EV-DO: 'yes')
Jan 12 13:43:43 fbx ModemManager[315]: <debug> Will skip all QCDM-based registration checks
Jan 12 13:43:43 fbx ModemManager[315]: <debug> Will skip generic detailed registration check, we don't have 
Sprint commands
Jan 12 13:43:43 fbx ModemManager[315]: <debug> Starting QCDM-based registration checks
Jan 12 13:43:43 fbx ModemManager[315]: <debug>   Skipping all QCDM-based checks and falling back to AT-based 
checks
Jan 12 13:43:43 fbx ModemManager[315]: <debug> Starting AT-based registration checks
Jan 12 13:43:43 fbx ModemManager[315]: <warn>  Could not get service status: No AT port available to run 
command
Jan 12 13:43:43 fbx ModemManager[315]: <debug> CDMA registration check failed: 'No AT port available to run 
command'
Jan 12 13:43:43 fbx ModemManager[315]: <debug> Modem (Generic) 
'/sys/devices/pci0000:00/0000:00:12.0/usb4/4-1' completely disposed