Fail with "[3gpp] multiple-connection-to-same-pdn-not-allowed"
I'm switching from qmicli to modemmanager control so I know the modem and SIM card work fine.
- mmcli 1.12.12
- qmicli 1.30.8
Using a Sierra Wireless RC7611 and a Verizon SIM. I add the connection with:
nmcli connection add type gsm ifname 'cdc-wdm0' con-name 'sierra' connection.autoconnect yes
The log shows:
Sep 20 10:44:02 60100-60027 ModemManager[471]: <info> ModemManager (version 1.18.12) starting in system bus...
Sep 20 10:44:35 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] Opening device with flags 'version-info, proxy'...
Sep 20 10:44:35 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] created endpoint
Sep 20 10:44:35 60100-60027 ModemManager[471]: cannot connect to proxy: Could not connect: Connection refused
Sep 20 10:44:35 60100-60027 ModemManager[471]: spawning new qmi-proxy (try 1)...
Sep 20 10:44:35 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] Checking version info (45 retries)...
Sep 20 10:44:35 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] QMI Device supports 39 services:
Sep 20 10:44:35 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] ctl (1.5)
Sep 20 10:44:35 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] wds (1.67)
Sep 20 10:44:35 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] dms (1.0)
Sep 20 10:44:35 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] nas (1.25)
Sep 20 10:44:35 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] qos (1.12)
Sep 20 10:44:35 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] wms (1.10)
Sep 20 10:44:35 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] auth (1.3)
Sep 20 10:44:35 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] at (1.4)
Sep 20 10:44:35 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] voice (2.1)
Sep 20 10:44:35 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] cat2 (2.24)
Sep 20 10:44:35 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] uim (1.87)
Sep 20 10:44:35 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] pbm (1.4)
Sep 20 10:44:35 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] test (1.0)
Sep 20 10:44:35 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] loc (2.0)
Sep 20 10:44:35 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] sar (1.0)
Sep 20 10:44:35 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] ims (1.0)
Sep 20 10:44:35 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] csd (1.0)
Sep 20 10:44:35 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] ts (1.0)
Sep 20 10:44:35 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] tmd (1.0)
Sep 20 10:44:35 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] wda (1.16)
Sep 20 10:44:35 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] csvt (1.1)
Sep 20 10:44:35 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] imsp (1.0)
Sep 20 10:44:35 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] imsa (1.0)
Sep 20 10:44:35 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] coex (1.0)
Sep 20 10:44:35 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] pdc (1.0)
Sep 20 10:44:35 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] rfrpe (1.0)
Sep 20 10:44:35 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] dsd (1.0)
Sep 20 10:44:35 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] unknown [0x2d] (1.0)
Sep 20 10:44:35 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] unknown [0x30] (1.0)
Sep 20 10:44:35 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] unknown [0x32] (1.0)
Sep 20 10:44:35 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] unknown [0x36] (1.0)
Sep 20 10:44:35 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] rms (1.0)
Sep 20 10:44:35 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] unknown [0xf2] (1.0)
Sep 20 10:44:35 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] unknown [0xf3] (1.0)
Sep 20 10:44:35 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] unknown [0xf5] (1.0)
Sep 20 10:44:35 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] unknown [0xf6] (1.0)
Sep 20 10:44:35 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] unknown [0xf8] (1.0)
Sep 20 10:44:35 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] unknown [0xf9] (1.0)
Sep 20 10:44:35 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] unknown [0xfe] (1.0)
Sep 20 10:44:50 60100-60027 ModemManager[471]: <info> [device /sys/devices/platform/e0000000.n_ahb/e001f000.ehci/usb1/1-1] creating modem with plugin 'sierra' and '5' ports
Sep 20 10:44:50 60100-60027 ModemManager[471]: <warn> [plugin/sierra] could not grab port ttyUSB1: Cannot add port 'tty/ttyUSB1', unhandled port type
Sep 20 10:44:50 60100-60027 ModemManager[471]: <info> [base-manager] modem for device '/sys/devices/platform/e0000000.n_ahb/e001f000.ehci/usb1/1-1' successfully created
Sep 20 10:44:50 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] Opening device with flags 'version-info, proxy'...
Sep 20 10:44:50 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] created endpoint
Sep 20 10:44:50 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] Checking version info (45 retries)...
Sep 20 10:44:50 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] QMI Device supports 39 services:
Sep 20 10:44:50 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] ctl (1.5)
Sep 20 10:44:50 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] wds (1.67)
Sep 20 10:44:50 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] dms (1.0)
Sep 20 10:44:50 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] nas (1.25)
Sep 20 10:44:50 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] qos (1.12)
Sep 20 10:44:50 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] wms (1.10)
Sep 20 10:44:50 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] auth (1.3)
Sep 20 10:44:50 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] at (1.4)
Sep 20 10:44:50 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] voice (2.1)
Sep 20 10:44:50 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] cat2 (2.24)
Sep 20 10:44:50 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] uim (1.87)
Sep 20 10:44:50 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] pbm (1.4)
Sep 20 10:44:50 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] test (1.0)
Sep 20 10:44:50 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] loc (2.0)
Sep 20 10:44:50 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] sar (1.0)
Sep 20 10:44:50 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] ims (1.0)
Sep 20 10:44:50 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] csd (1.0)
Sep 20 10:44:50 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] ts (1.0)
Sep 20 10:44:50 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] tmd (1.0)
Sep 20 10:44:50 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] wda (1.16)
Sep 20 10:44:50 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] csvt (1.1)
Sep 20 10:44:50 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] imsp (1.0)
Sep 20 10:44:50 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] imsa (1.0)
Sep 20 10:44:50 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] coex (1.0)
Sep 20 10:44:50 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] pdc (1.0)
Sep 20 10:44:50 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] rfrpe (1.0)
Sep 20 10:44:50 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] dsd (1.0)
Sep 20 10:44:50 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] unknown [0x2d] (1.0)
Sep 20 10:44:50 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] unknown [0x30] (1.0)
Sep 20 10:44:50 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] unknown [0x32] (1.0)
Sep 20 10:44:50 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] unknown [0x36] (1.0)
Sep 20 10:44:50 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] rms (1.0)
Sep 20 10:44:50 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] unknown [0xf2] (1.0)
Sep 20 10:44:50 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] unknown [0xf3] (1.0)
Sep 20 10:44:50 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] unknown [0xf5] (1.0)
Sep 20 10:44:50 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] unknown [0xf6] (1.0)
Sep 20 10:44:50 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] unknown [0xf8] (1.0)
Sep 20 10:44:50 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] unknown [0xf9] (1.0)
Sep 20 10:44:50 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] unknown [0xfe] (1.0)
Sep 20 10:44:50 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] Allocating new client ID...
Sep 20 10:44:50 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] Registered 'wda' (version 1.16) client with ID '1'
Sep 20 10:44:50 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] Allocating new client ID...
Sep 20 10:44:50 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] Releasing 'wda' client with flags 'release-cid'...
Sep 20 10:44:50 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] Unregistered 'wda' client with ID '1'
Sep 20 10:44:50 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] Registered 'dms' (version 1.0) client with ID '2'
Sep 20 10:44:50 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] Allocating new client ID...
Sep 20 10:44:50 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] Registered 'nas' (version 1.25) client with ID '3'
Sep 20 10:44:50 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] Allocating new client ID...
Sep 20 10:44:50 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] Registered 'wds' (version 1.67) client with ID '3'
Sep 20 10:44:50 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] Allocating new client ID...
Sep 20 10:44:50 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] Registered 'wms' (version 1.10) client with ID '2'
Sep 20 10:44:50 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] Allocating new client ID...
Sep 20 10:44:50 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] Registered 'uim' (version 1.87) client with ID '2'
Sep 20 10:44:50 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] Allocating new client ID...
Sep 20 10:44:50 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] Registered 'loc' (version 2.0) client with ID '2'
Sep 20 10:44:50 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] Allocating new client ID...
Sep 20 10:44:50 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] Registered 'pdc' (version 1.0) client with ID '2'
Sep 20 10:44:50 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] Allocating new client ID...
Sep 20 10:44:50 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] Registered 'voice' (version 2.1) client with ID '2'
Sep 20 10:44:51 60100-60027 ModemManager[471]: <info> [modem0] state changed (unknown -> disabled)
Sep 20 10:44:51 60100-60027 ModemManager[471]: <info> [modem0] state changed (disabled -> enabling)
Sep 20 10:44:51 60100-60027 ModemManager[471]: <info> [modem0] power state updated: on
Sep 20 10:44:51 60100-60027 ModemManager[471]: <info> [modem0] simple connect started...
Sep 20 10:44:51 60100-60027 ModemManager[471]: <info> [modem0] simple connect state (4/8): wait to get fully enabled
Sep 20 10:44:51 60100-60027 ModemManager[471]: <info> [modem0] state changed (enabling -> enabled)
Sep 20 10:44:51 60100-60027 ModemManager[471]: <info> [modem0] simple connect state (5/8): register
Sep 20 10:44:51 60100-60027 ModemManager[471]: <info> [modem0] 3GPP registration state changed (unknown -> registering)
Sep 20 10:44:51 60100-60027 ModemManager[471]: <info> [modem0] 3GPP registration state changed (registering -> home)
Sep 20 10:44:51 60100-60027 ModemManager[471]: <info> [modem0] state changed (enabled -> registered)
Sep 20 10:44:51 60100-60027 ModemManager[471]: <info> [modem0] simple connect state (6/8): bearer
Sep 20 10:44:51 60100-60027 ModemManager[471]: <info> [modem0] simple connect state (7/8): connect
Sep 20 10:44:51 60100-60027 ModemManager[471]: <info> [modem0] state changed (registered -> connecting)
Sep 20 10:44:51 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] Allocating new client ID...
Sep 20 10:44:51 60100-60027 ModemManager[471]: [/dev/cdc-wdm0] Registered 'wds' (version 1.67) client with ID '4'
Sep 20 10:44:51 60100-60027 ModemManager[471]: <info> [modem0/bearer1] couldn't start network: QMI protocol error (14): 'CallFailed'
Sep 20 10:44:51 60100-60027 ModemManager[471]: <info> [modem0/bearer1] verbose call end reason (6,55): [3gpp] multiple-connection-to-same-pdn-not-allowed
Sep 20 10:44:51 60100-60027 ModemManager[471]: <warn> [modem0/bearer1] connection attempt #1 failed: Multiple PDN connection to same APN not allowed
Sep 20 10:44:51 60100-60027 ModemManager[471]: <info> [modem0] state changed (connecting -> registered)
Sep 20 10:44:51 60100-60027 ModemManager[471]: <info> [modem0/bearer1] connection #1 finished: duration 0s, tx: 0 bytes, rx: 0 bytes
Sep 20 10:44:51 60100-60027 ModemManager[471]: <info> [modem0] simple connect started...
Sep 20 10:44:51 60100-60027 ModemManager[471]: <info> [modem0] simple connect state (4/8): wait to get fully enabled
Sep 20 10:44:51 60100-60027 ModemManager[471]: <info> [modem0] simple connect state (5/8): register
Sep 20 10:44:51 60100-60027 ModemManager[471]: <info> [modem0] simple connect state (6/8): bearer
Sep 20 10:44:51 60100-60027 ModemManager[471]: <info> [modem0] simple connect state (7/8): connect
Sep 20 10:44:51 60100-60027 ModemManager[471]: <info> [modem0] state changed (registered -> connecting)
Sep 20 10:44:51 60100-60027 ModemManager[471]: <info> [modem0/bearer1] couldn't start network: QMI protocol error (14): 'CallFailed'
Sep 20 10:44:51 60100-60027 ModemManager[471]: <info> [modem0/bearer1] verbose call end reason (6,55): [3gpp] multiple-connection-to-same-pdn-not-allowed
Sep 20 10:44:51 60100-60027 ModemManager[471]: <warn> [modem0/bearer1] connection attempt #2 failed: Multiple PDN connection to same APN not allowed
Sep 20 10:44:51 60100-60027 ModemManager[471]: <info> [modem0] state changed (connecting -> registered)
Sep 20 10:44:51 60100-60027 ModemManager[471]: <info> [modem0/bearer1] connection #2 finished: duration 0s, tx: 0 bytes, rx: 0 bytes
Sep 20 10:44:51 60100-60027 ModemManager[471]: <info> [modem0] simple connect started...
Sep 20 10:44:51 60100-60027 ModemManager[471]: <info> [modem0] simple connect state (4/8): wait to get fully enabled
Sep 20 10:44:51 60100-60027 ModemManager[471]: <info> [modem0] simple connect state (5/8): register
Sep 20 10:44:51 60100-60027 ModemManager[471]: <info> [modem0] simple connect state (6/8): bearer
Sep 20 10:44:51 60100-60027 ModemManager[471]: <info> [modem0] simple connect state (7/8): connect
Sep 20 10:44:51 60100-60027 ModemManager[471]: <info> [modem0] state changed (registered -> connecting)
Sep 20 10:44:51 60100-60027 ModemManager[471]: <info> [modem0/bearer1] couldn't start network: QMI protocol error (14): 'CallFailed'
Sep 20 10:44:51 60100-60027 ModemManager[471]: <info> [modem0/bearer1] verbose call end reason (6,55): [3gpp] multiple-connection-to-same-pdn-not-allowed
Sep 20 10:44:51 60100-60027 ModemManager[471]: <warn> [modem0/bearer1] connection attempt #3 failed: Multiple PDN connection to same APN not allowed
Sep 20 10:44:51 60100-60027 ModemManager[471]: <info> [modem0] state changed (connecting -> registered)
Sep 20 10:44:51 60100-60027 ModemManager[471]: <info> [modem0/bearer1] connection #3 finished: duration 0s, tx: 0 bytes, rx: 0 bytes
Sep 20 10:44:51 60100-60027 ModemManager[471]: <info> [modem0] simple connect started...
Sep 20 10:44:51 60100-60027 ModemManager[471]: <info> [modem0] simple connect state (4/8): wait to get fully enabled
Sep 20 10:44:51 60100-60027 ModemManager[471]: <info> [modem0] simple connect state (5/8): register
Sep 20 10:44:51 60100-60027 ModemManager[471]: <info> [modem0] simple connect state (6/8): bearer
Sep 20 10:44:51 60100-60027 ModemManager[471]: <info> [modem0] simple connect state (7/8): connect
Sep 20 10:44:51 60100-60027 ModemManager[471]: <info> [modem0] state changed (registered -> connecting)
Sep 20 10:44:51 60100-60027 ModemManager[471]: <info> [modem0/bearer1] couldn't start network: QMI protocol error (14): 'CallFailed'
Sep 20 10:44:51 60100-60027 ModemManager[471]: <info> [modem0/bearer1] verbose call end reason (6,55): [3gpp] multiple-connection-to-same-pdn-not-allowed
Sep 20 10:44:51 60100-60027 ModemManager[471]: <warn> [modem0/bearer1] connection attempt #4 failed: Multiple PDN connection to same APN not allowed
Sep 20 10:44:51 60100-60027 ModemManager[471]: <info> [modem0] state changed (connecting -> registered)
Sep 20 10:44:51 60100-60027 ModemManager[471]: <info> [modem0/bearer1] connection #4 finished: duration 0s, tx: 0 bytes, rx: 0 bytes
Strangely this works if I do:
# qmicli -d /dev/cdc-wdm0 --device-open-qmi --wds-start-network="ip-type=4" --client-no-release-cid
[/dev/cdc-wdm0] Network started
Packet data handle: '2248401152'
[/dev/cdc-wdm0] Client ID not released:
Service: 'wds'
CID: '5'
Edited by Tom Isaacson