x5-snapdragon-linux icon indicating copy to clipboard operation
x5-snapdragon-linux copied to clipboard

Modem unresponsive after resuming

Open chriskuipers opened this issue 6 years ago • 0 comments

Hi guys,

Anyone having the same issue as I'm having? Modem works just fine after when I 'cold' boot my machine, but as soon as I suspend my laptop for a decent amount of time, the modem becomes unresponsive, shows up as Mobile Network Unavailable. But if I suspend my laptop just temporarily (say, for troubleshooting) it keeps on working...

Below the last part of the syslog output:

cat /var/log/syslog | grep 'modem\|cdc-wdm0'
...
Nov  7 14:28:18 horizonbox NetworkManager[1439]: <info>  [1510061298.1935] device (cdc-wdm0): state change: activated -> deactivating (reason 'user-requested', internal state 'managed')
Nov  7 14:28:18 horizonbox NetworkManager[1439]: <info>  [1510061298.2467] (cdc-wdm0): modem state changed, 'connected' --> 'disconnecting' (reason: user-requested)
Nov  7 14:28:18 horizonbox NetworkManager[1439]: <info>  [1510061298.2916] (cdc-wdm0): modem state changed, 'disconnecting' --> 'registered' (reason: user-requested)
Nov  7 14:28:18 horizonbox NetworkManager[1439]: <info>  [1510061298.2917] device (cdc-wdm0): state change: deactivating -> disconnected (reason 'user-requested', internal state 'managed')
Nov  7 14:28:18 horizonbox nm-dispatcher: req:2 'down' [cdc-wdm0]: new request (1 scripts)
Nov  7 14:28:18 horizonbox nm-dispatcher: req:2 'down' [cdc-wdm0]: start running ordered scripts...
Nov  7 15:00:30 horizonbox NetworkManager[1439]: <info>  [1510063230.7828] device (cdc-wdm0): state change: disconnected -> unmanaged (reason 'sleeping', internal state 'managed')
Nov  7 19:03:13 horizonbox kernel: [ 5146.369303] qcserial 1-3:3.2: Qualcomm USB modem converter detected
Nov  7 19:03:15 horizonbox ModemManager[1466]: [/dev/cdc-wdm0] Read max control message size from descriptors file: 4096
Nov  7 19:03:15 horizonbox ModemManager[1466]: <info>  Creating modem with plugin 'Generic' and '2' ports
Nov  7 19:03:15 horizonbox ModemManager[1466]: [/dev/cdc-wdm0] Read max control message size from descriptors file: 4096
Nov  7 19:03:15 horizonbox NetworkManager[1439]: <info>  [1510077795.8158] manager: (cdc-wdm0): new Broadband device (/org/freedesktop/NetworkManager/Devices/5)
Nov  7 19:03:15 horizonbox NetworkManager[1439]: <info>  [1510077795.8171] device (cdc-wdm0): state change: unmanaged -> unavailable (reason 'managed', internal state 'external')
Nov  7 19:03:15 horizonbox NetworkManager[1439]: <info>  [1510077795.8185] device (cdc-wdm0): modem state 'failed'
Nov  7 19:03:15 horizonbox NetworkManager[1439]: <info>  [1510077795.8190] modem-broadband[cdc-wdm0]: failed to retrieve SIM object: No SIM object available
Nov  7 19:03:36 horizonbox NetworkManager[1439]: <info>  [1510077816.3495] audit: op="connection-activate" uuid="XXXXXXXXXXXXXXXXXXXXXXXXXX" name="Vodafone Non-business" pid=2171 uid=1000 result="fail" reason="Connection 'Vodafone Non-business' is not available on the device cdc-wdm0 at this time."
Nov  7 19:03:36 horizonbox gnome-shell[2171]: Device activation failed: Connection 'Vodafone Non-business' is not available on the device cdc-wdm0 at this time.
Nov  7 19:03:44 horizonbox NetworkManager[1439]: <info>  [1510077824.1918] audit: op="connection-activate" uuid="XXXXXXXXXXXXXXXXXXXXXXXXXX" name="Vodafone Non-business" pid=2171 uid=1000 result="fail" reason="Connection 'Vodafone Non-business' is not available on the device cdc-wdm0 at this time."
Nov  7 19:03:44 horizonbox gnome-shell[2171]: Device activation failed: Connection 'Vodafone Non-business' is not available on the device cdc-wdm0 at this time.
Nov  7 19:07:24 horizonbox kernel: [   24.806959] usbserial: USB Serial support registered for Qualcomm USB modem
Nov  7 19:07:24 horizonbox kernel: [   24.900719] cdc_mbim 1-3:3.0: cdc-wdm0: USB WDM device
Nov  7 19:07:24 horizonbox kernel: [   24.949342] qcserial 1-3:3.2: Qualcomm USB modem converter detected
Nov  7 19:07:26 horizonbox ModemManager[1414]: [/dev/cdc-wdm0] Read max control message size from descriptors file: 4096
Nov  7 19:07:26 horizonbox ModemManager[1414]: <info>  Creating modem with plugin 'Generic' and '2' ports
Nov  7 19:07:26 horizonbox ModemManager[1414]: [/dev/cdc-wdm0] Read max control message size from descriptors file: 4096
Nov  7 19:07:26 horizonbox NetworkManager[1444]: <info>  [1510078046.8398] (cdc-wdm0): modem state changed, 'disabled' --> 'enabling' (reason: user preference)
Nov  7 19:07:26 horizonbox NetworkManager[1444]: <info>  [1510078046.8405] manager: (cdc-wdm0): new Broadband device (/org/freedesktop/NetworkManager/Devices/4)
Nov  7 19:07:26 horizonbox NetworkManager[1444]: <info>  [1510078046.8409] device (cdc-wdm0): state change: unmanaged -> unavailable (reason 'managed', internal state 'external')
Nov  7 19:07:26 horizonbox NetworkManager[1444]: <info>  [1510078046.8412] device (cdc-wdm0): modem state 'enabling'
Nov  7 19:07:26 horizonbox NetworkManager[1444]: <info>  [1510078046.8416] device (cdc-wdm0): state change: unavailable -> disconnected (reason 'none', internal state 'managed')
Nov  7 19:07:26 horizonbox NetworkManager[1444]: <info>  [1510078046.9337] (cdc-wdm0): modem state changed, 'enabling' --> 'registered' (reason: user-requested)
Nov  7 19:13:55 horizonbox NetworkManager[1444]: <info>  [1510078435.1357] device (cdc-wdm0): Activation: starting connection 'Vodafone Non-business' (XXXXXXXXXXXXXXXXXXXXXXXXXX)
Nov  7 19:13:55 horizonbox NetworkManager[1444]: <info>  [1510078435.1364] device (cdc-wdm0): state change: disconnected -> prepare (reason 'none', internal state 'managed')
Nov  7 19:13:55 horizonbox NetworkManager[1444]: <info>  [1510078435.1379] device (cdc-wdm0): state change: prepare -> need-auth (reason 'none', internal state 'managed')
Nov  7 19:13:55 horizonbox NetworkManager[1444]: <info>  [1510078435.1431] device (cdc-wdm0): state change: need-auth -> prepare (reason 'none', internal state 'managed')
Nov  7 19:13:55 horizonbox NetworkManager[1444]: <info>  [1510078435.1622] (cdc-wdm0): modem state changed, 'registered' --> 'connecting' (reason: user-requested)
Nov  7 19:13:55 horizonbox NetworkManager[1444]: <info>  [1510078435.3218] (cdc-wdm0): modem state changed, 'connecting' --> 'connected' (reason: user-requested)
Nov  7 19:13:55 horizonbox NetworkManager[1444]: <info>  [1510078435.3325] device (cdc-wdm0): state change: prepare -> config (reason 'none', internal state 'managed')
Nov  7 19:13:55 horizonbox NetworkManager[1444]: <info>  [1510078435.3340] device (cdc-wdm0): state change: config -> ip-config (reason 'none', internal state 'managed')
Nov  7 19:13:55 horizonbox NetworkManager[1444]: <info>  [1510078435.3353] modem-broadband[cdc-wdm0]: IPv4 static configuration:
Nov  7 19:13:55 horizonbox NetworkManager[1444]: <info>  [1510078435.3355] modem-broadband[cdc-wdm0]:   address 10.102.73.10/30
Nov  7 19:13:55 horizonbox NetworkManager[1444]: <info>  [1510078435.3356] modem-broadband[cdc-wdm0]:   gateway 10.102.73.9
Nov  7 19:13:55 horizonbox NetworkManager[1444]: <info>  [1510078435.3356] modem-broadband[cdc-wdm0]:   DNS 62.140.140.251
Nov  7 19:13:55 horizonbox NetworkManager[1444]: <info>  [1510078435.3357] modem-broadband[cdc-wdm0]:   DNS 62.140.138.233
Nov  7 19:13:55 horizonbox NetworkManager[1444]: <info>  [1510078435.3574] device (cdc-wdm0): state change: ip-config -> ip-check (reason 'none', internal state 'managed')
Nov  7 19:13:55 horizonbox NetworkManager[1444]: <info>  [1510078435.3589] device (cdc-wdm0): state change: ip-check -> secondaries (reason 'none', internal state 'managed')
Nov  7 19:13:55 horizonbox NetworkManager[1444]: <info>  [1510078435.3594] device (cdc-wdm0): state change: secondaries -> activated (reason 'none', internal state 'managed')
Nov  7 19:13:55 horizonbox NetworkManager[1444]: <info>  [1510078435.3644] device (cdc-wdm0): Activation: successful, device activated.
Nov  7 19:17:42 horizonbox NetworkManager[1444]: <info>  [1510078662.5776] device (cdc-wdm0): state change: activated -> deactivating (reason 'sleeping', internal state 'managed')
Nov  7 19:17:42 horizonbox NetworkManager[1444]: <info>  [1510078662.5904] device (cdc-wdm0): state change: deactivating -> unmanaged (reason 'removed', internal state 'removed')
Nov  7 19:17:42 horizonbox NetworkManager[1444]: <warn>  [1510078662.6183] modem-broadband[cdc-wdm0]: 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/0
Nov  7 19:17:42 horizonbox nm-dispatcher: req:2 'down' [cdc-wdm0]: new request (1 scripts)
Nov  7 19:17:42 horizonbox nm-dispatcher: req:2 'down' [cdc-wdm0]: start running ordered scripts...
Nov  7 19:17:59 horizonbox kernel: [  738.367605] qcserial 1-3:3.2: Qualcomm USB modem converter detected
Nov  7 19:18:02 horizonbox ModemManager[1414]: [/dev/cdc-wdm0] Read max control message size from descriptors file: 4096
Nov  7 19:18:02 horizonbox ModemManager[1414]: <info>  Creating modem with plugin 'Generic' and '2' ports
Nov  7 19:18:02 horizonbox ModemManager[1414]: [/dev/cdc-wdm0] Read max control message size from descriptors file: 4096
Nov  7 19:18:02 horizonbox NetworkManager[1444]: <info>  [1510078682.6566] (cdc-wdm0): modem state changed, 'disabled' --> 'enabling' (reason: user preference)
Nov  7 19:18:02 horizonbox NetworkManager[1444]: <info>  [1510078682.6606] manager: (cdc-wdm0): new Broadband device (/org/freedesktop/NetworkManager/Devices/5)
Nov  7 19:18:02 horizonbox NetworkManager[1444]: <info>  [1510078682.6624] device (cdc-wdm0): state change: unmanaged -> unavailable (reason 'managed', internal state 'external')
Nov  7 19:18:02 horizonbox NetworkManager[1444]: <info>  [1510078682.6637] device (cdc-wdm0): modem state 'enabling'
Nov  7 19:18:02 horizonbox NetworkManager[1444]: <info>  [1510078682.6659] device (cdc-wdm0): state change: unavailable -> disconnected (reason 'none', internal state 'managed')
Nov  7 19:18:02 horizonbox NetworkManager[1444]: <info>  [1510078682.7798] (cdc-wdm0): modem state changed, 'enabling' --> 'registered' (reason: user-requested)
Nov  7 19:18:13 horizonbox NetworkManager[1444]: <info>  [1510078693.4184] device (cdc-wdm0): Activation: starting connection 'Vodafone Non-business' (XXXXXXXXXXXXXXXXXXXXXXXXX)
Nov  7 19:18:13 horizonbox NetworkManager[1444]: <info>  [1510078693.4215] device (cdc-wdm0): state change: disconnected -> prepare (reason 'none', internal state 'managed')
Nov  7 19:18:13 horizonbox NetworkManager[1444]: <info>  [1510078693.4250] device (cdc-wdm0): state change: prepare -> need-auth (reason 'none', internal state 'managed')
Nov  7 19:18:13 horizonbox NetworkManager[1444]: <info>  [1510078693.4385] device (cdc-wdm0): state change: need-auth -> prepare (reason 'none', internal state 'managed')
Nov  7 19:18:13 horizonbox NetworkManager[1444]: <info>  [1510078693.4629] (cdc-wdm0): modem state changed, 'registered' --> 'connecting' (reason: user-requested)
Nov  7 19:18:13 horizonbox NetworkManager[1444]: <info>  [1510078693.6289] (cdc-wdm0): modem state changed, 'connecting' --> 'connected' (reason: user-requested)
Nov  7 19:18:13 horizonbox NetworkManager[1444]: <info>  [1510078693.6338] device (cdc-wdm0): state change: prepare -> config (reason 'none', internal state 'managed')
Nov  7 19:18:13 horizonbox NetworkManager[1444]: <info>  [1510078693.6348] device (cdc-wdm0): state change: config -> ip-config (reason 'none', internal state 'managed')
Nov  7 19:18:13 horizonbox NetworkManager[1444]: <info>  [1510078693.6361] modem-broadband[cdc-wdm0]: IPv4 static configuration:
Nov  7 19:18:13 horizonbox NetworkManager[1444]: <info>  [1510078693.6362] modem-broadband[cdc-wdm0]:   address 10.102.73.10/30
Nov  7 19:18:13 horizonbox NetworkManager[1444]: <info>  [1510078693.6363] modem-broadband[cdc-wdm0]:   gateway 10.102.73.9
Nov  7 19:18:13 horizonbox NetworkManager[1444]: <info>  [1510078693.6363] modem-broadband[cdc-wdm0]:   DNS 62.140.140.251
Nov  7 19:18:13 horizonbox NetworkManager[1444]: <info>  [1510078693.6363] modem-broadband[cdc-wdm0]:   DNS 62.140.138.233
Nov  7 19:18:13 horizonbox NetworkManager[1444]: <info>  [1510078693.6464] device (cdc-wdm0): state change: ip-config -> ip-check (reason 'none', internal state 'managed')
Nov  7 19:18:13 horizonbox NetworkManager[1444]: <info>  [1510078693.6480] device (cdc-wdm0): state change: ip-check -> secondaries (reason 'none', internal state 'managed')
Nov  7 19:18:13 horizonbox NetworkManager[1444]: <info>  [1510078693.6492] device (cdc-wdm0): state change: secondaries -> activated (reason 'none', internal state 'managed')
Nov  7 19:18:13 horizonbox NetworkManager[1444]: <info>  [1510078693.6590] device (cdc-wdm0): Activation: successful, device activated

chriskuipers avatar Nov 07 '17 18:11 chriskuipers