[Debian-on-mobile-maintainers] Bug#1094012: modemmanager: LTE modem automatically acticates after suspend, despite disabled manually before
Tobias Frost
tobi at debian.org
Fri Jan 24 16:12:50 GMT 2025
Package: modemmanager
Version: 1.22.0-3+b2
Severity: important
(Important as this is problematic in locations where automatically enabling a
GSM/LTE radio can cause security issues, like airplanes)
(not sure of network-manager, modemmanager or r gnome issue, please reassign if needed.
Observation: On every suspend, ModemManager increments the number after "modem", e.g [modem3] -> [modem4]
This might be a hint that this is a ModemManager issue redecting the same hardware as different modem on resume,
though the device name (wwan0mbim0) stays the same.
I'm using gnome-shell to deactivate the modem by clicking the icon for the mobil connection,
and I see that the connection is disabled. syslog:
If using the gnome-shell button to disable the complete mobile network stack,
gnome will tell "no wwan adapter found" but in this case the disable state
survives the suspend to ram.
Observation2: When stopping ModemManager manually before systemctl suspend, the state is correctly retained,
so I think this is a ModemManager thinking this is a new modem and enable it by default issue.
When re-starting modemmanager manually, it will "reset" the number after modem to 0.
Jan 24 16:31:47 gondor NetworkManager[19551]: <info> [1737732707.0179] device (wwan0mbim0): state change: activated -> deactivating (reason 'user-requested', managed-type: 'full')
Jan 24 16:31:47 gondor NetworkManager[19551]: <info> [1737732707.0195] audit: op="device-disconnect" interface="wwan0" ifindex=3 pid=2678 uid=1000 result="success"
Jan 24 16:31:47 gondor dbus-daemon[1018]: [system] Activating via systemd: service name='org.freedesktop.nm_dispatcher' unit='dbus-org.freedesktop.nm-dispatcher.service' requested by ':1.166' (uid=0 pid=19551 comm="/usr/sbin/NetworkManager --no-daemon")
Jan 24 16:31:47 gondor systemd[1]: Starting NetworkManager-dispatcher.service - Network Manager Script Dispatcher Service...
Jan 24 16:31:47 gondor dbus-daemon[1018]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher'
Jan 24 16:31:47 gondor systemd[1]: Started NetworkManager-dispatcher.service - Network Manager Script Dispatcher Service.
Jan 24 16:31:47 gondor ModemManager[1224]: <msg> [modem3] state changed (connected -> disconnecting)
Jan 24 16:31:47 gondor ModemManager[1224]: <msg> [modem3] state changed (disconnecting -> registered)
Jan 24 16:31:47 gondor ModemManager[1224]: <msg> [modem3/bearer8] connection #1 finished: duration 116s, tx: 31909 bytes, rx: 0 bytes
Jan 24 16:31:47 gondor NetworkManager[19551]: <info> [1737732707.3808] device (wwan0mbim0): state change: deactivating -> disconnected (reason 'user-requested', managed-type: 'full')
Jan 24 16:31:47 gondor NetworkManager[19551]: <info> [1737732707.3813] dns-mgr: Writing DNS information to /usr/sbin/resolvconf
When then suspensing to RAM and waking up the laptop again, the LTE modem gets activated automatically again:
Jan 24 16:43:09 gondor systemd-logind[1069]: The system will suspend now!
Jan 24 16:43:09 gondor NetworkManager[19551]: <info> [1737733389.0410] manager: sleep: sleep requested (sleeping: no enabled: yes)
Jan 24 16:43:09 gondor NetworkManager[19551]: <info> [1737733389.0421] device (p2p-dev-wlp0s20f3): state change: disconnected -> unmanaged (reason 'unmanaged-sleeping', managed-type: 'full')
Jan 24 16:43:09 gondor ModemManager[1224]: <msg> [sleep-monitor-systemd] system is about to suspend
Jan 24 16:43:09 gondor NetworkManager[19551]: <info> [1737733389.0429] device (wwan0mbim0): state change: disconnected -> unmanaged (reason 'unmanaged-sleeping', managed-type: 'full')
Jan 24 16:43:09 gondor NetworkManager[19551]: <info> [1737733389.0435] manager: NetworkManager state is now ASLEEP
(waking up system)
Jan 24 16:43:14 gondor systemd-logind[1069]: Operation 'suspend' finished.)
(...)
Jan 24 16:43:14 gondor ModemManager[1224]: <wrn> [/dev/wwan0mbim0] MBIM error: Transaction timed out
Jan 24 16:43:14 gondor ModemManager[1224]: <wrn> [/dev/wwan0mbim0] MBIM error: Transaction timed out
Jan 24 16:43:14 gondor ModemManager[1224]: <wrn> [/dev/wwan0mbim0] MBIM error: Transaction timed out
Jan 24 16:43:14 gondor ModemManager[1224]: <wrn> [/dev/wwan0mbim0] MBIM error: Transaction timed out
Jan 24 16:43:14 gondor ModemManager[1224]: <wrn> [/dev/wwan0mbim0] MBIM error: Transaction timed out
(Ethernet and WiFi activating not shown)
Jan 24 16:43:16 gondor ModemManager[1224]: <msg> [wwan0mbim0/mbim] MBIM device is not QMI capable
Jan 24 16:43:18 gondor ModemManager[1224]: <msg> [device /sys/devices/pci0000:00/0000:00:1c.0/0000:08:00.0] creating modem with plugin 'quectel' and '4' ports
Jan 24 16:43:18 gondor ModemManager[1224]: <msg> [base-manager] modem for device '/sys/devices/pci0000:00/0000:00:1c.0/0000:08:00.0' successfully created
Jan 24 16:43:18 gondor ModemManager[1224]: <msg> [base-manager] couldn't check support for device '/sys/devices/pci0000:00/0000:00:1f.6': not supported by any plugin
Jan 24 16:43:18 gondor ModemManager[1224]: <msg> [modem4/wwan0mbim0/mbim] MBIM device is QMI capable
Jan 24 16:43:18 gondor ModemManager[1224]: <wrn> Left '1' bytes unread when getting the 'Slot EID' TLV
Jan 24 16:43:18 gondor ModemManager[1224]: <wrn> Left '1' bytes unread when getting the 'Slot EID' TLV
Jan 24 16:43:19 gondor ModemManager[1224]: <msg> [modem4] state changed (unknown -> disabled)
Jan 24 16:43:19 gondor NetworkManager[19551]: <info> [1737733399.0170] manager: (wwan0mbim0): new Broadband device (/org/freedesktop/NetworkManager/Devices/16)
Jan 24 16:43:19 gondor NetworkManager[19551]: <info> [1737733399.0175] device (wwan0mbim0): state change: unmanaged -> unavailable (reason 'managed', managed-type: 'external')
Jan 24 16:43:19 gondor NetworkManager[19551]: <info> [1737733399.0180] device (wwan0mbim0): modem state 'enabling'
Jan 24 16:43:19 gondor NetworkManager[19551]: <info> [1737733399.0187] device (wwan0mbim0): state change: unavailable -> disconnected (reason 'none', managed-type: 'full')
Jan 24 16:43:19 gondor NetworkManager[19551]: <info> [1737733399.0193] policy: auto-activating connection '1und1' (340dd63f-84f6-4c17-ba8e-161305afadfa)
Jan 24 16:43:19 gondor NetworkManager[19551]: <info> [1737733399.0203] device (wwan0mbim0): Activation: starting connection '1und1' (340dd63f-84f6-4c17-ba8e-161305afadfa)
Jan 24 16:43:19 gondor NetworkManager[19551]: <info> [1737733399.0205] device (wwan0mbim0): state change: disconnected -> prepare (reason 'none', managed-type: 'full')
Jan 24 16:43:19 gondor ModemManager[1224]: <msg> [modem4] state changed (disabled -> enabling)
Jan 24 16:43:19 gondor ModemManager[1224]: <msg> [modem4] simple connect started...
Jan 24 16:43:19 gondor ModemManager[1224]: <msg> [modem4] simple connect state (4/10): wait to get fully enabled
Jan 24 16:43:19 gondor ModemManager[1224]: <msg> [modem4] power state updated: on
Jan 24 16:43:19 gondor ModemManager[1224]: <msg> [modem4] 3GPP packet service state changed (unknown -> attached)
Jan 24 16:43:19 gondor ModemManager[1224]: <msg> [modem4] state changed (enabling -> enabled)
Jan 24 16:43:19 gondor ModemManager[1224]: <msg> [modem4] simple connect state (5/10): wait after enabled
Jan 24 16:43:19 gondor ModemManager[1224]: <msg> [modem4] 3GPP registration state changed (unknown -> registering)
Jan 24 16:43:19 gondor ModemManager[1224]: <msg> [modem4] 3GPP registration state changed (registering -> home)
Jan 24 16:43:19 gondor ModemManager[1224]: <msg> [modem4] state changed (enabled -> registered)
Jan 24 16:43:19 gondor ModemManager[1224]: <msg> [modem4] simple connect state (6/10): register
Jan 24 16:43:19 gondor ModemManager[1224]: <msg> [modem4] simple connect state (7/10): wait to get packet service state attached
Jan 24 16:43:19 gondor ModemManager[1224]: <msg> [modem4] simple connect state (8/10): bearer
Jan 24 16:43:19 gondor ModemManager[1224]: <msg> [modem4] simple connect state (9/10): connect
Jan 24 16:43:19 gondor ModemManager[1224]: <msg> [modem4] state changed (registered -> connecting)
Jan 24 16:43:19 gondor ModemManager[1224]: <msg> [modem4] state changed (connecting -> connected)
Jan 24 16:43:19 gondor ModemManager[1224]: <msg> [modem4] simple connect state (10/10): all done
Jan 24 16:43:19 gondor NetworkManager[19551]: <info> [1737733399.3347] device (wwan0mbim0): state change: prepare -> config (reason 'none', managed-type: 'full')
Jan 24 16:43:19 gondor NetworkManager[19551]: <info> [1737733399.3357] device (wwan0mbim0): state change: config -> ip-config (reason 'none', managed-type: 'full')
Jan 24 16:43:19 gondor NetworkManager[19551]: <info> [1737733399.3371] modem-broadband[wwan0mbim0]: IPv4 static configuration:
Jan 24 16:43:19 gondor NetworkManager[19551]: <info> [1737733399.3371] modem-broadband[wwan0mbim0]: address 10.200.52.141/30 brd* 10.200.52.143 lft forever pref forever lifetime 31100-0[0,0] src wwan
Jan 24 16:43:19 gondor NetworkManager[19551]: <info> [1737733399.3372] modem-broadband[wwan0mbim0]: gateway 10.200.52.142
Jan 24 16:43:19 gondor NetworkManager[19551]: <info> [1737733399.3372] modem-broadband[wwan0mbim0]: DNS 61.8.132.52
Jan 24 16:43:19 gondor NetworkManager[19551]: <info> [1737733399.3372] modem-broadband[wwan0mbim0]: DNS 8.8.8.8
Jan 24 16:43:19 gondor NetworkManager[19551]: <info> [1737733399.3372] modem-broadband[wwan0mbim0]: MTU 1500
Jan 24 16:43:19 gondor NetworkManager[19551]: <info> [1737733399.3373] modem-broadband[wwan0mbim0]: IPv6 base configuration:
Jan 24 16:43:19 gondor NetworkManager[19551]: <info> [1737733399.3373] modem-broadband[wwan0mbim0]: address 2a00:fbc:ee58:9fd0:68c7:e22e:cee6:2784/64 lft forever pref forever lifetime 31100-0[0,0] src unknown
Jan 24 16:43:19 gondor NetworkManager[19551]: <info> [1737733399.3373] modem-broadband[wwan0mbim0]: slaac disabled
Jan 24 16:43:19 gondor NetworkManager[19551]: <info> [1737733399.3373] modem-broadband[wwan0mbim0]: gateway 2a00:fbc:ee58:9fd0:e99b:c0ef:6092:d730
Jan 24 16:43:19 gondor NetworkManager[19551]: <info> [1737733399.3373] modem-broadband[wwan0mbim0]: DNS 2a00:fbc:2200:a999:110:3634:2:1
Jan 24 16:43:19 gondor NetworkManager[19551]: <info> [1737733399.3374] modem-broadband[wwan0mbim0]: DNS 2001:4860:4860::8888
Jan 24 16:43:19 gondor NetworkManager[19551]: <info> [1737733399.3381] dns-mgr: Writing DNS information to /usr/sbin/resolvconf
Jan 24 16:43:19 gondor NetworkManager[19551]: <info> [1737733399.3895] device (wwan0mbim0): state change: ip-config -> ip-check (reason 'none', managed-type: 'full')
Jan 24 16:43:19 gondor NetworkManager[19551]: <info> [1737733399.3944] device (wwan0mbim0): state change: ip-check -> secondaries (reason 'none', managed-type: 'full')
Jan 24 16:43:19 gondor NetworkManager[19551]: <info> [1737733399.3946] device (wwan0mbim0): state change: secondaries -> activated (reason 'none', managed-type: 'full')
Jan 24 16:43:19 gondor NetworkManager[19551]: <info> [1737733399.3953] device (wwan0mbim0): Activation: successful, device activated.
-- System Information:
Debian Release: trixie/sid
APT prefers unstable
APT policy: (500, 'unstable'), (500, 'testing')
Architecture: amd64 (x86_64)
Kernel: Linux 6.12.10-amd64 (SMP w/8 CPU threads; PREEMPT)
Kernel taint flags: TAINT_OOT_MODULE, TAINT_UNSIGNED_MODULE
Locale: LANG=de_DE.UTF-8, LC_CTYPE=de_DE.UTF-8 (charmap=UTF-8), LANGUAGE=de_DE:de
Shell: /bin/sh linked to /usr/bin/dash
Init: systemd (via /run/systemd/system)
LSM: AppArmor: enabled
Versions of packages modemmanager depends on:
ii libc6 2.40-6
ii libglib2.0-0t64 2.82.4-2
ii libgudev-1.0-0 238-6
ii libmbim-glib4 1.30.0-1+b2
ii libmbim-proxy 1.30.0-1+b2
ii libmm-glib0 1.22.0-3+b2
ii libpolkit-gobject-1-0 126-2
ii libqmi-glib5 1.34.0-2+b2
ii libqmi-proxy 1.34.0-2+b2
ii libqrtr-glib0 1.2.2-1+b2
ii libsystemd0 257.2-3
ii polkitd 126-2
Versions of packages modemmanager recommends:
ii libmbim-utils 1.30.0-1+b2
ii libqmi-utils 1.34.0-2+b2
ii usb-modeswitch 2.6.1-4+b1
modemmanager suggests no packages.
-- no debconf information
More information about the Debian-on-mobile-maintainers
mailing list