Hi, I am trying to connect a QMI modem (u-blox SARA-R412M) using ModemManager 1.8.2 and libqmi 1.20.0. The modem transitions into the connected state which makes NetworkManager start the DHCP procedure. That, however, never succeeds. In the ModemManager logs, I can see that QMI reports IPv4 settings that seem correct (IP range checks out for my operator).
Do I need to configure this sort of setup in a special way to tell ModemManager/NetworkManager to use the QMI IP config? Thanks, Sven The info-level logs of NetworkManager and ModemManager follow (I can also provide the debug-level ones): [ 9.264447] systemd[1]: Starting Network Manager... [ 9.546962] NetworkManager[739]: <info> [1541687256.2166] NetworkManager (version 1.12.2) is starting... (for the first time) [ 9.548598] NetworkManager[739]: <info> [1541687256.2201] Read config: /etc/NetworkManager/NetworkManager.conf [ 9.595141] systemd[1]: Started Network Manager. [ 9.603148] NetworkManager[739]: <info> [1541687256.2745] bus-manager: acquired D-Bus service "org.freedesktop.NetworkManager" [ 9.624445] NetworkManager[739]: <info> [1541687256.2959] manager[0x56294030]: monitoring kernel firmware directory '/lib/firmware'. [ 10.193655] NetworkManager[739]: <info> [1541687256.8650] hostname: hostname: using hostnamed [ 10.194256] NetworkManager[739]: <info> [1541687256.8653] hostname: hostname changed from (none) to "0d92acf" [ 10.195000] NetworkManager[739]: <info> [1541687256.8665] dns-mgr[0x56289000]: init: dns=default, rc-manager=resolvconf [ 10.459734] NetworkManager[739]: <info> [1541687257.1312] settings: Loaded settings plugin: NMSKeyfilePlugin (internal) [ 10.468110] NetworkManager[739]: <info> [1541687257.1395] keyfile: new connection /etc/NetworkManager/system-connections/gprs (14e02637-0ffb-3a28-806f-ad60904afe7f,"gprsconnection") [ 10.478683] NetworkManager[739]: <info> [1541687257.1478] manager: rfkill: WiFi enabled by radio killswitch; enabled by state file [ 10.483116] NetworkManager[739]: <info> [1541687257.1539] manager: rfkill: WWAN enabled by radio killswitch; enabled by state file [ 10.486086] NetworkManager[739]: <info> [1541687257.1576] manager: Networking is enabled by state file [ 10.489089] NetworkManager[739]: <info> [1541687257.1606] dhcp-init: Using DHCP client 'internal' [ 10.499784] NetworkManager[739]: <info> [1541687257.1712] Loaded device plugin: NMWifiFactory (/usr/lib/NetworkManager/1.12.2/libnm-device-plugin-wifi.so) [ 10.565221] NetworkManager[739]: <info> [1541687257.2366] Loaded device plugin: NMBluezManager (/usr/lib/NetworkManager/1.12.2/libnm-device-plugin-bluetooth.so) [ 10.568262] NetworkManager[739]: <info> [1541687257.2397] Loaded device plugin: NMWwanFactory (/usr/lib/NetworkManager/1.12.2/libnm-device-plugin-wwan.so) [ 10.571322] NetworkManager[739]: <info> [1541687257.2428] Loaded device plugin: NMAtmManager (/usr/lib/NetworkManager/1.12.2/libnm-device-plugin-adsl.so) [ 10.576625] NetworkManager[739]: <info> [1541687257.2480] device (lo): carrier: link connected [ 10.579578] NetworkManager[739]: <info> [1541687257.2499] manager: (lo): new Generic device (/org/freedesktop/NetworkManager/Devices/1) [ 10.587938] NetworkManager[739]: <info> [1541687257.2581] manager: (eth0): new Ethernet device (/org/freedesktop/NetworkManager/Devices/2) [ 10.597294] NetworkManager[739]: <info> [1541687257.2687] keyfile: add connection in-memory (98f59fb7-21ae-33be-8f85-f4a77b8f1eb6,"Wired connection 1") [ 10.608476] NetworkManager[739]: <info> [1541687257.2795] settings: (eth0): created default wired connection 'Wired connection 1' [ 10.619876] NetworkManager[739]: <info> [1541687257.2913] device (eth0): state change: unmanaged -> unavailable (reason 'managed', sys-iface-state: 'external') [ 10.770121] NetworkManager[739]: <info> [1541687257.4414] manager: (resin-dns): new Bridge device (/org/freedesktop/NetworkManager/Devices/3) [ 11.804623] NetworkManager[739]: <info> [1541687258.4760] keyfile: add connection in-memory (cf7e0951-aed5-458d-9f75-9e05f7bb5cc3,"resin-dns") [ 11.812558] NetworkManager[739]: <info> [1541687258.4840] device (resin-dns): state change: unmanaged -> unavailable (reason 'connection-assumed', sys-iface-state: 'external') [ 11.828609] NetworkManager[739]: <info> [1541687258.5001] device (resin-dns): state change: unavailable -> disconnected (reason 'connection-assumed', sys-iface-state: 'external') [ 11.848185] NetworkManager[739]: <info> [1541687258.5196] device (resin-dns): Activation: starting connection 'resin-dns' (cf7e0951-aed5-458d-9f75-9e05f7bb5cc3) [ 11.852532] NetworkManager[739]: <info> [1541687258.5240] manager: (sit0): new IPTunnel device (/org/freedesktop/NetworkManager/Devices/4) [ 11.905717] NetworkManager[739]: <info> [1541687258.5716] device (resin-dns): state change: disconnected -> prepare (reason 'none', sys-iface-state: 'external') [ 11.925804] NetworkManager[739]: <info> [1541687258.5973] device (resin-dns): state change: prepare -> config (reason 'none', sys-iface-state: 'external') [ 11.931760] NetworkManager[739]: <info> [1541687258.6032] device (resin-dns): state change: config -> ip-config (reason 'none', sys-iface-state: 'external') [ 11.942712] NetworkManager[739]: <info> [1541687258.6141] device (resin-dns): state change: ip-config -> ip-check (reason 'none', sys-iface-state: 'external') [ 11.956276] NetworkManager[739]: <info> [1541687258.6277] device (resin-dns): state change: ip-check -> secondaries (reason 'none', sys-iface-state: 'external') [ 11.960852] NetworkManager[739]: <info> [1541687258.6323] device (resin-dns): state change: secondaries -> activated (reason 'none', sys-iface-state: 'external') [ 11.966920] NetworkManager[739]: <info> [1541687258.6384] manager: NetworkManager state is now CONNECTED_LOCAL [ 12.003457] NetworkManager[739]: <info> [1541687258.6749] device (resin-dns): Activation: successful, device activated. [ 13.740849] systemd[1]: Starting Modem Manager... [ 14.049659] ModemManager[841]: ModemManager (version 1.8.2) starting in system bus... [ 14.166600] systemd[1]: Started Modem Manager. [ 14.168922] NetworkManager[739]: <info> [1541687260.8392] modem-manager: ModemManager not available [ 14.322823] NetworkManager[739]: <info> [1541687260.9941] modem-manager: ModemManager now available [ 14.705270] NetworkManager[739]: <info> [1541687261.3766] device (eth0): carrier: link connected [ 14.707656] NetworkManager[739]: <info> [1541687261.3790] device (eth0): state change: unavailable -> disconnected (reason 'carrier-changed', sys-iface-state: 'managed') [ 14.714292] NetworkManager[739]: <info> [1541687261.3850] policy: auto-activating connection 'Wired connection 1' (98f59fb7-21ae-33be-8f85-f4a77b8f1eb6) [ 14.719563] NetworkManager[739]: <info> [1541687261.3906] device (eth0): Activation: starting connection 'Wired connection 1' (98f59fb7-21ae-33be-8f85-f4a77b8f1eb6) [ 14.720972] NetworkManager[739]: <info> [1541687261.3916] device (eth0): state change: disconnected -> prepare (reason 'none', sys-iface-state: 'managed') [ 14.724669] NetworkManager[739]: <info> [1541687261.3949] manager: NetworkManager state is now CONNECTING [ 14.726652] NetworkManager[739]: <info> [1541687261.3969] device (eth0): state change: prepare -> config (reason 'none', sys-iface-state: 'managed') [ 14.729027] NetworkManager[739]: <info> [1541687261.4003] device (eth0): state change: config -> ip-config (reason 'none', sys-iface-state: 'managed') [ 14.731955] NetworkManager[739]: <info> [1541687261.4034] dhcp4 (eth0): activation: beginning transaction (no timeout) [ 14.780911] NetworkManager[739]: <info> [1541687261.4523] dhcp4 (eth0): address a.b.c.d [ 14.781373] NetworkManager[739]: <info> [1541687261.4526] dhcp4 (eth0): plen 24 [ 14.781632] NetworkManager[739]: <info> [1541687261.4527] dhcp4 (eth0): expires in 85490 seconds [ 14.782122] NetworkManager[739]: <info> [1541687261.4528] dhcp4 (eth0): nameserver 'a.b.c.d' [ 14.782437] NetworkManager[739]: <info> [1541687261.4529] dhcp4 (eth0): nameserver 'a.b.c.d' [ 14.782668] NetworkManager[739]: <info> [1541687261.4530] dhcp4 (eth0): domain name 'domain.com' [ 14.782894] NetworkManager[739]: <info> [1541687261.4531] dhcp4 (eth0): gateway a.b.c.d [ 14.804401] NetworkManager[739]: <info> [1541687261.4755] dhcp4 (eth0): state changed unknown -> bound [ 14.826658] NetworkManager[739]: <info> [1541687261.4981] device (eth0): state change: ip-config -> ip-check (reason 'none', sys-iface-state: 'managed') [ 14.846121] NetworkManager[739]: <info> [1541687261.5176] device (eth0): state change: ip-check -> secondaries (reason 'none', sys-iface-state: 'managed') [ 14.853052] NetworkManager[739]: <info> [1541687261.5245] device (eth0): state change: secondaries -> activated (reason 'none', sys-iface-state: 'managed') [ 14.861285] NetworkManager[739]: <info> [1541687261.5328] manager: NetworkManager state is now CONNECTED_LOCAL [ 14.935356] NetworkManager[739]: <info> [1541687261.6065] manager: NetworkManager state is now CONNECTED_SITE [ 14.937194] NetworkManager[739]: <info> [1541687261.6085] policy: set 'Wired connection 1' (eth0) as default for IPv4 routing and DNS [ 14.939958] NetworkManager[739]: <info> [1541687261.6114] dns-mgr: Writing DNS information to /sbin/resolvconf [ 15.088794] NetworkManager[739]: <info> [1541687261.7602] device (eth0): Activation: successful, device activated. [ 15.103756] NetworkManager[739]: <info> [1541687261.7752] manager: NetworkManager state is now CONNECTED_GLOBAL [ 15.123486] NetworkManager[739]: <info> [1541687261.7949] manager: startup complete [ 15.795681] ModemManager[841]: [/dev/cdc-wdm0] Opening device with flags 'version-info, proxy'... [ 15.796793] ModemManager[841]: [/dev/cdc-wdm0] loaded driver of cdc-wdm port: qmi_wwan [ 15.797370] ModemManager[841]: cannot connect to proxy: Could not connect: Connection refused [ 15.797648] ModemManager[841]: spawning new qmi-proxy (try 1)... [ 15.925874] NetworkManager[739]: <info> [1541687262.5973] manager: (balena0): new Bridge device (/org/freedesktop/NetworkManager/Devices/5) [ 15.969311] ModemManager[841]: [/dev/cdc-wdm0] Checking version info (10 retries)... [ 15.982362] ModemManager[841]: [/dev/cdc-wdm0] QMI Device supports 20 services: [ 15.984107] ModemManager[841]: [/dev/cdc-wdm0] ctl (1.5) [ 15.991830] ModemManager[841]: [/dev/cdc-wdm0] wds (1.67) [ 15.993934] ModemManager[841]: [/dev/cdc-wdm0] dms (1.0) [ 15.994411] ModemManager[841]: [/dev/cdc-wdm0] nas (1.25) [ 15.994777] ModemManager[841]: [/dev/cdc-wdm0] wms (1.10) [ 16.002519] ModemManager[841]: [/dev/cdc-wdm0] at (1.4) [ 16.002832] ModemManager[841]: [/dev/cdc-wdm0] uim (1.46) [ 16.003082] ModemManager[841]: [/dev/cdc-wdm0] test (1.0) [ 16.003303] ModemManager[841]: [/dev/cdc-wdm0] sar (1.0) [ 16.003534] ModemManager[841]: [/dev/cdc-wdm0] csd (1.0) [ 16.003743] ModemManager[841]: [/dev/cdc-wdm0] ts (1.0) [ 16.003936] ModemManager[841]: [/dev/cdc-wdm0] tmd (1.0) [ 16.004152] ModemManager[841]: [/dev/cdc-wdm0] wda (1.16) [ 16.004362] ModemManager[841]: [/dev/cdc-wdm0] pdc (1.0) [ 16.004572] ModemManager[841]: [/dev/cdc-wdm0] rfrpe (1.0) [ 16.004782] ModemManager[841]: [/dev/cdc-wdm0] dsd (1.0) [ 16.005290] ModemManager[841]: [/dev/cdc-wdm0] unknown [0x2d] (1.0) [ 16.005489] ModemManager[841]: [/dev/cdc-wdm0] unknown [0x30] (1.0) [ 16.005687] ModemManager[841]: [/dev/cdc-wdm0] unknown [0x36] (1.0) [ 16.005874] ModemManager[841]: [/dev/cdc-wdm0] unknown [0x48] (1.0) [ 16.817076] ModemManager[841]: Couldn't check support for device '/sys/devices/platform/soc/30800000.aips-bus/30be0000.ethernet': not supported by any plugin [ 17.007527] NetworkManager[739]: <info> [1541687263.6789] dhcp6 (eth0): activation: beginning transaction (timeout in 45 seconds) [ 17.017051] NetworkManager[739]: <info> [1541687263.6885] dns-mgr: Writing DNS information to /sbin/resolvconf [ 17.594708] NetworkManager[739]: <info> [1541687264.2611] manager: (br-278f284c8dd0): new Bridge device (/org/freedesktop/NetworkManager/Devices/6) [ 17.998275] NetworkManager[739]: <info> [1541687264.6657] manager: (resin-vpn): new Tun device (/org/freedesktop/NetworkManager/Devices/7) [ 18.204019] NetworkManager[739]: <info> [1541687264.8755] manager: (supervisor0): new Bridge device (/org/freedesktop/NetworkManager/Devices/8) [ 18.540530] NetworkManager[739]: <info> [1541687265.2097] device (supervisor0): state change: unmanaged -> unavailable (reason 'connection-assumed', sys-iface-state: 'external') [ 18.566244] NetworkManager[739]: <info> [1541687265.2376] keyfile: add connection in-memory (e59eb4c2-1e6b-4378-bcd5-c0d8e7307f42,"supervisor0") [ 18.574585] NetworkManager[739]: <info> [1541687265.2460] device (supervisor0): state change: unavailable -> disconnected (reason 'connection-assumed', sys-iface-state: 'external') [ 18.585168] NetworkManager[739]: <info> [1541687265.2566] device (supervisor0): Activation: starting connection 'supervisor0' (e59eb4c2-1e6b-4378-bcd5-c0d8e7307f42) [ 18.590108] NetworkManager[739]: <info> [1541687265.2591] device (supervisor0): state change: disconnected -> prepare (reason 'none', sys-iface-state: 'external') [ 18.595494] NetworkManager[739]: <info> [1541687265.2669] device (supervisor0): state change: prepare -> config (reason 'none', sys-iface-state: 'external') [ 18.601745] NetworkManager[739]: <info> [1541687265.2732] device (supervisor0): state change: config -> ip-config (reason 'none', sys-iface-state: 'external') [ 18.607173] NetworkManager[739]: <info> [1541687265.2786] device (supervisor0): state change: ip-config -> ip-check (reason 'none', sys-iface-state: 'external') [ 18.620941] NetworkManager[739]: <info> [1541687265.2924] device (supervisor0): state change: ip-check -> secondaries (reason 'none', sys-iface-state: 'external') [ 18.625318] NetworkManager[739]: <info> [1541687265.2968] device (supervisor0): state change: secondaries -> activated (reason 'none', sys-iface-state: 'external') [ 18.665605] NetworkManager[739]: <info> [1541687265.3370] device (supervisor0): Activation: successful, device activated. [ 25.788990] ModemManager[841]: Couldn't check support for device '/sys/devices/platform/soc/30800000.aips-bus/30be0000.ethernet': not supported by any plugin [ 29.008348] ModemManager[841]: [device /sys/devices/platform/soc/30800000.aips-bus/30b20000.usb/ci_hdrc.1/usb2/2-1] creating modem with plugin 'Generic' and '4' ports [ 29.047392] ModemManager[841]: Modem for device '/sys/devices/platform/soc/30800000.aips-bus/30b20000.usb/ci_hdrc.1/usb2/2-1' successfully created [ 29.054719] ModemManager[841]: [/dev/cdc-wdm0] Opening device with flags 'version-info, proxy'... [ 29.055385] ModemManager[841]: [/dev/cdc-wdm0] loaded driver of cdc-wdm port: qmi_wwan [ 29.070063] ModemManager[841]: [/dev/cdc-wdm0] Checking version info (10 retries)... [ 29.085583] ModemManager[841]: [/dev/cdc-wdm0] QMI Device supports 20 services: [ 29.085974] ModemManager[841]: [/dev/cdc-wdm0] ctl (1.5) [ 29.086175] ModemManager[841]: [/dev/cdc-wdm0] wds (1.67) [ 29.086356] ModemManager[841]: [/dev/cdc-wdm0] dms (1.0) [ 29.086583] ModemManager[841]: [/dev/cdc-wdm0] nas (1.25) [ 29.086805] ModemManager[841]: [/dev/cdc-wdm0] wms (1.10) [ 29.087063] ModemManager[841]: [/dev/cdc-wdm0] at (1.4) [ 29.087278] ModemManager[841]: [/dev/cdc-wdm0] uim (1.46) [ 29.087523] ModemManager[841]: [/dev/cdc-wdm0] test (1.0) [ 29.087747] ModemManager[841]: [/dev/cdc-wdm0] sar (1.0) [ 29.087948] ModemManager[841]: [/dev/cdc-wdm0] csd (1.0) [ 29.088157] ModemManager[841]: [/dev/cdc-wdm0] ts (1.0) [ 29.088359] ModemManager[841]: [/dev/cdc-wdm0] tmd (1.0) [ 29.088551] ModemManager[841]: [/dev/cdc-wdm0] wda (1.16) [ 29.088775] ModemManager[841]: [/dev/cdc-wdm0] pdc (1.0) [ 29.089019] ModemManager[841]: [/dev/cdc-wdm0] rfrpe (1.0) [ 29.089224] ModemManager[841]: [/dev/cdc-wdm0] dsd (1.0) [ 29.089406] ModemManager[841]: [/dev/cdc-wdm0] unknown [0x2d] (1.0) [ 29.089590] ModemManager[841]: [/dev/cdc-wdm0] unknown [0x30] (1.0) [ 29.089792] ModemManager[841]: [/dev/cdc-wdm0] unknown [0x36] (1.0) [ 29.090117] ModemManager[841]: [/dev/cdc-wdm0] unknown [0x48] (1.0) [ 29.090368] ModemManager[841]: [/dev/cdc-wdm0] Reading expected data format from: /sys/class/net/wwan0/qmi/raw_ip [ 29.090624] ModemManager[841]: [/dev/cdc-wdm0] Opening device with flags 'version-info, net-802-3, net-no-qos-header, proxy'... [ 29.090854] ModemManager[841]: [/dev/cdc-wdm0] loaded driver of cdc-wdm port: qmi_wwan [ 29.093861] ModemManager[841]: [/dev/cdc-wdm0] Checking version info (10 retries)... [ 29.100826] ModemManager[841]: [/dev/cdc-wdm0] QMI Device supports 20 services: [ 29.101246] ModemManager[841]: [/dev/cdc-wdm0] ctl (1.5) [ 29.101456] ModemManager[841]: [/dev/cdc-wdm0] wds (1.67) [ 29.101686] ModemManager[841]: [/dev/cdc-wdm0] dms (1.0) [ 29.101888] ModemManager[841]: [/dev/cdc-wdm0] nas (1.25) [ 29.102101] ModemManager[841]: [/dev/cdc-wdm0] wms (1.10) [ 29.102319] ModemManager[841]: [/dev/cdc-wdm0] at (1.4) [ 29.102535] ModemManager[841]: [/dev/cdc-wdm0] uim (1.46) [ 29.102761] ModemManager[841]: [/dev/cdc-wdm0] test (1.0) [ 29.103007] ModemManager[841]: [/dev/cdc-wdm0] sar (1.0) [ 29.103235] ModemManager[841]: [/dev/cdc-wdm0] csd (1.0) [ 29.103439] ModemManager[841]: [/dev/cdc-wdm0] ts (1.0) [ 29.103629] ModemManager[841]: [/dev/cdc-wdm0] tmd (1.0) [ 29.103825] ModemManager[841]: [/dev/cdc-wdm0] wda (1.16) [ 29.104012] ModemManager[841]: [/dev/cdc-wdm0] pdc (1.0) [ 29.104215] ModemManager[841]: [/dev/cdc-wdm0] rfrpe (1.0) [ 29.104407] ModemManager[841]: [/dev/cdc-wdm0] dsd (1.0) [ 29.104611] ModemManager[841]: [/dev/cdc-wdm0] unknown [0x2d] (1.0) [ 29.104812] ModemManager[841]: [/dev/cdc-wdm0] unknown [0x30] (1.0) [ 29.104996] ModemManager[841]: [/dev/cdc-wdm0] unknown [0x36] (1.0) [ 29.105168] ModemManager[841]: [/dev/cdc-wdm0] unknown [0x48] (1.0) [ 29.105340] ModemManager[841]: [/dev/cdc-wdm0] Setting network port data format... [ 29.109190] ModemManager[841]: [/dev/cdc-wdm0] Network port data format operation finished [ 29.109937] ModemManager[841]: [/dev/cdc-wdm0] Allocating new client ID... [ 29.116971] ModemManager[841]: [/dev/cdc-wdm0] Registered 'dms' (version 1.0) client with ID '1' [ 29.122076] ModemManager[841]: [/dev/cdc-wdm0] Allocating new client ID... [ 29.129243] ModemManager[841]: [/dev/cdc-wdm0] Registered 'nas' (version 1.25) client with ID '2' [ 29.133134] ModemManager[841]: [/dev/cdc-wdm0] Allocating new client ID... [ 29.141103] ModemManager[841]: [/dev/cdc-wdm0] Registered 'wms' (version 1.10) client with ID '2' [ 29.144165] ModemManager[841]: [/dev/cdc-wdm0] Allocating new client ID... [ 29.152757] ModemManager[841]: [/dev/cdc-wdm0] Registered 'uim' (version 1.46) client with ID '1' [ 29.283730] ModemManager[841]: couldn't load SIM identifier: 'Couldn't get UIM ICCID: QMI protocol error (94): 'NotSupported'' [ 29.287661] ModemManager[841]: couldn't load IMSI: 'Couldn't get UIM IMSI: QMI protocol error (94): 'NotSupported'' [ 29.302016] ModemManager[841]: couldn't load Operator identifier: 'Couldn't get home network: QMI protocol error (16): 'NotProvisioned'' [ 29.309069] ModemManager[841]: couldn't load Operator name: 'Couldn't get home network: QMI protocol error (16): 'NotProvisioned'' [ 29.323978] ModemManager[841]: couldn't load list of Own Numbers: 'Couldn't get MSISDN: QMI protocol error (16): 'NotProvisioned'' [ 33.060095] ModemManager[841]: Modem: state changed (unknown -> disabled) [ 33.091942] NetworkManager[739]: <info> [1541687279.7630] modem["cdc-wdm0"]: modem state changed, 'disabled' --> 'enabling' (reason: user preference) [ 33.095020] NetworkManager[739]: <info> [1541687279.7660] manager: (cdc-wdm0): new Broadband device (/org/freedesktop/NetworkManager/Devices/9) [ 33.119886] NetworkManager[739]: <info> [1541687279.7913] device (cdc-wdm0): state change: unmanaged -> unavailable (reason 'managed', sys-iface-state: 'external') [ 33.138627] NetworkManager[739]: <info> [1541687279.8101] device (cdc-wdm0): modem state 'enabling' [ 33.163172] NetworkManager[739]: <info> [1541687279.8344] device (cdc-wdm0): state change: unavailable -> disconnected (reason 'none', sys-iface-state: 'managed') [ 33.181671] NetworkManager[739]: <info> [1541687279.8531] policy: auto-activating connection 'gprsconnection' (14e02637-0ffb-3a28-806f-ad60904afe7f) [ 33.189273] NetworkManager[739]: <info> [1541687279.8607] device (cdc-wdm0): Activation: starting connection 'gprsconnection' (14e02637-0ffb-3a28-806f-ad60904afe7f) [ 33.209102] NetworkManager[739]: <info> [1541687279.8805] device (cdc-wdm0): state change: disconnected -> prepare (reason 'none', sys-iface-state: 'managed') [ 33.246368] ModemManager[841]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (disabled -> enabling) [ 33.265389] ModemManager[841]: Simple connect started... [ 33.265841] ModemManager[841]: Simple connect state (4/8): Wait to get fully enabled [ 33.364708] ModemManager[841]: could not load SIM identifier: Couldn't get UIM ICCID: QMI protocol error (94): 'NotSupported' (3 retries left) [ 35.009012] ModemManager[841]: could not load SIM identifier: Couldn't get UIM ICCID: QMI protocol error (94): 'NotSupported' (2 retries left) [ 36.008526] ModemManager[841]: could not load SIM identifier: Couldn't get UIM ICCID: QMI protocol error (94): 'NotSupported' (1 retries left) [ 37.008866] ModemManager[841]: could not load SIM identifier: Couldn't get UIM ICCID: QMI protocol error (94): 'NotSupported' [ 37.009976] ModemManager[841]: Error checking if SIM was swapped: 'Couldn't get UIM ICCID: QMI protocol error (94): 'NotSupported'' [ 37.035727] ModemManager[841]: Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP Registration state changed (unknown -> idle) [ 37.153836] ModemManager[841]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (enabling -> enabled) [ 37.154317] ModemManager[841]: Simple connect state (5/8): Register [ 37.157534] NetworkManager[739]: <info> [1541687283.8288] modem["cdc-wdm0"]: modem state changed, 'enabling' --> 'enabled' (reason: user-requested) [ 53.010764] ModemManager[841]: Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP Registration state changed (idle -> searching) [ 53.012266] ModemManager[841]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (enabled -> searching) [ 53.017707] NetworkManager[739]: <info> [1541687300.8724] modem["cdc-wdm0"]: modem state changed, 'enabled' --> 'searching' (reason: unknown) [ 62.012920] NetworkManager[739]: <warn> [1541687309.8650] dhcp6 (eth0): request timed out [ 62.014356] NetworkManager[739]: <info> [1541687309.8653] dhcp6 (eth0): state changed unknown -> timeout [ 62.014725] NetworkManager[739]: <info> [1541687309.8656] dhcp6 (eth0): canceled DHCP transaction [ 62.015027] NetworkManager[739]: <info> [1541687309.8657] dhcp6 (eth0): state changed timeout -> done [ 72.118372] ModemManager[841]: Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP Registration state changed (searching -> idle) [ 75.038659] ModemManager[841]: Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP Registration state changed (idle -> registering) [ 75.043901] ModemManager[841]: Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP Registration state changed (registering -> home) [ 75.044423] ModemManager[841]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (searching -> registered) [ 75.049228] NetworkManager[739]: <info> [1541687322.9040] modem["cdc-wdm0"]: modem state changed, 'searching' --> 'registered' (reason: unknown) [ 76.012998] ModemManager[841]: Simple connect state (6/8): Bearer [ 76.015129] ModemManager[841]: Simple connect state (7/8): Connect [ 76.015857] ModemManager[841]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (registered -> connecting) [ 76.021750] NetworkManager[739]: <info> [1541687323.8756] modem["cdc-wdm0"]: modem state changed, 'registered' --> 'connecting' (reason: user-requested) [ 76.026784] ModemManager[841]: [/dev/cdc-wdm0] Allocating new client ID... [ 76.034600] ModemManager[841]: [/dev/cdc-wdm0] Registered 'wds' (version 1.67) client with ID '2' [ 77.123676] ModemManager[841]: QMI IPv4 Settings: [ 77.125930] ModemManager[841]: Address: a.b.c.d/29 [ 77.126327] ModemManager[841]: Gateway: a.b.c.d [ 77.126594] ModemManager[841]: DNS #1: a.b.c.d [ 77.126845] ModemManager[841]: DNS #2: a.b.c.d [ 77.127088] ModemManager[841]: MTU: 68 [ 77.127338] ModemManager[841]: [/dev/cdc-wdm0] Allocating new client ID... [ 77.134705] ModemManager[841]: [/dev/cdc-wdm0] Registered 'wds' (version 1.67) client with ID '3' [ 77.163151] ModemManager[841]: error: couldn't start network: QMI protocol error (14): 'CallFailed' [ 77.163733] ModemManager[841]: call end reason (1): 'generic-unspecified' [ 77.164138] ModemManager[841]: verbose call end reason (2,210): [internal] pdn-ipv6-call-disallowed [ 77.165411] ModemManager[841]: Modem /org/freedesktop/ModemManager1/Modem/0: state changed (connecting -> connected) [ 77.167966] ModemManager[841]: Simple connect state (8/8): All done [ 77.170573] NetworkManager[739]: <info> [1541687325.0254] modem["cdc-wdm0"]: modem state changed, 'connecting' --> 'connected' (reason: user-requested) [ 77.191357] NetworkManager[739]: <info> [1541687325.0462] device (cdc-wdm0): state change: prepare -> config (reason 'none', sys-iface-state: 'managed') [ 77.196246] NetworkManager[739]: <info> [1541687325.0512] device (cdc-wdm0): state change: config -> ip-config (reason 'none', sys-iface-state: 'managed') [ 77.200582] NetworkManager[739]: <info> [1541687325.0555] dhcp4 (wwan0): activation: beginning transaction (no timeout) [ 77.201303] NetworkManager[739]: <info> [1541687325.0562] modem["cdc-wdm0"]: IPv6 configuration disabled _______________________________________________ ModemManager-devel mailing list ModemManager-devel@lists.freedesktop.org https://lists.freedesktop.org/mailman/listinfo/modemmanager-devel