#30489 – ModemManager подключает мобильный интернет только после передергивания модема

Bug 30489 - ModemManager подключает мобильный интернет только после передергивания модема

Summary: ModemManager подключает мобильный интернет только после передергивания модема

Status:	CLOSED WONTFIX

Alias:	None

Product:	Branch p7
Classification:	Distributions
Component:	ModemManager (show other bugs)
Version:	не указана
Hardware:	all Linux

Importance:	P3 normal
Assignee:	Mikhail Efremov
QA Contact:	qa-p7@altlinux.org

URL:
Keywords:

Depends on:
Blocks:

Reported:	2014-11-20 03:17 MSK by Эрик
Modified:	2023-10-25 22:34 MSK (History)
CC List:	2 users (show)

See Also:

Attachments
journalctl -b --full -u ModemManager (9.25 KB, text/plain) 2015-04-27 11:25 MSK, Эрик	no flags	Details
View All Add an attachment (proposed patch, testcase, etc.)

Note You need to log in before you can comment on or make changes to this bug.

Description

Эрик 2014-11-20 03:17:02 MSK

После одного из последних обновлений ModemManager'а, в системе стоит самая новая версия пакета: ModemManager-1.4.0-alt0.M70P.1, модем стал определятся только после передергивания.

Что довольно интересно, но мобильное подключение определяется

ноя 19 18:38:02 notebook.localdomain NetworkManager[1678]: keyfile:     read
connection 'Beeline По умолчанию'

Но попытка подключится обрывается. И только передернув модем, я завожу сеть,
да, и еще если кликнуть правой мышкой по апплету NetworkManager'а, то как я уже
отписывался, нет даже упоминания на мобильное подключение.

Система определяет модем, вывод lsusb:Bus 002 Device 004: ID 12d1:1446 Huawei Technologies Co., Ltd. E1552/E1800/E173
(HSPA modem)

Comment 1

Эрик 2014-11-20 04:38:58 MSK

Статус ModemManager после перезагрузки:

$ systemctl status ModemManager.service
ModemManager.service - Modem Manager
   Loaded: loaded (/lib/systemd/system/ModemManager.service; enabled)
   Active: active (running) since Чт 2014-11-20 07:33:04 KGT; 1min 8s ago
 Main PID: 448 (ModemManager)
   CGroup: name=systemd:/system/ModemManager.service
           └─448 /usr/sbin/ModemManager

ноя 20 07:33:03 notebook.localdomain ModemManager[448]: <info>  ModemManager (version 1.4.0) starting i......
ноя 20 07:33:04 notebook.localdomain systemd[1]: Started Modem Manager.
ноя 20 07:33:06 notebook.localdomain ModemManager[448]: <warn>  Couldn't find support for device at '/s...gin
ноя 20 07:33:06 notebook.localdomain ModemManager[448]: <warn>  Couldn't find support for device at '/s...gin

Comment 2

Andrey Cherepanov 2014-11-20 11:05:13 MSK

На пакет.

Comment 3

Mikhail Efremov 2014-11-20 21:07:51 MSK

Т.е. с MM-1.2.0 все работало? Модем не виден сразу после загрузки или не работает повторное подключение?

Comment 4

Эрик 2014-11-21 02:58:00 MSK

(В ответ на комментарий №3)
> Т.е. с MM-1.2.0 все работало? 

Совершенно верно, работало без нареканий.

Comment 5

Эрик 2014-11-21 03:06:47 MSK

(В ответ на комментарий №3)
> Модем не виден сразу после загрузки или не
> работает повторное подключение?

Если перезагрузиться с модемом, то, хотя система его видит, он не виден ModemManager'у. 


(В ответ на комментарий №1)
> Статус ModemManager после перезагрузки:
> 
> $ systemctl status ModemManager.service
> ModemManager.service - Modem Manager
>    Loaded: loaded (/lib/systemd/system/ModemManager.service; enabled)
>    Active: active (running) since Чт 2014-11-20 07:33:04 KGT; 1min 8s ago
>  Main PID: 448 (ModemManager)
>    CGroup: name=systemd:/system/ModemManager.service
>            └─448 /usr/sbin/ModemManager
> 
> ноя 20 07:33:03 notebook.localdomain ModemManager[448]: <info>  ModemManager
> (version 1.4.0) starting i......
> ноя 20 07:33:04 notebook.localdomain systemd[1]: Started Modem Manager.
> ноя 20 07:33:06 notebook.localdomain ModemManager[448]: <warn>  Couldn't find
> support for device at '/s...gin
> ноя 20 07:33:06 notebook.localdomain ModemManager[448]: <warn>  Couldn't find
> support for device at '/s...gin

Такая картинка наблюдается при загрузке и с модемом, и без него.

(В ответ на комментарий №3)
>  или не
> работает повторное подключение?

После передергивания модема, до ближайшей перезагрузки все работает, можно хоть бесконечно переподключать интернет-соединение.

Comment 6

Эрик 2014-11-21 05:33:14 MSK

Сегодня словил такую любопытную вещь: если отправить машину в ребут не отключая интернет, то после запуска системы MM видит модем нормально

$ systemctl status ModemManager.service
ModemManager.service - Modem Manager
   Loaded: loaded (/lib/systemd/system/ModemManager.service; enabled)
   Active: active (running) since Пт 2014-11-21 08:22:10 KGT; 59s ago
 Main PID: 450 (ModemManager)
   CGroup: name=systemd:/system/ModemManager.service
           ├─ 450 /usr/sbin/ModemManager
           └─1701 /usr/lib/qmi-proxy

ноя 21 08:22:23 notebook.localdomain ModemManager[450]: [/dev/cdc-wdm0] Allocating new client ID...
ноя 21 08:22:23 notebook.localdomain ModemManager[450]: [/dev/cdc-wdm0] Registered 'nas' (version 1.0) ...'3'
ноя 21 08:22:23 notebook.localdomain ModemManager[450]: <warn>  (ttyUSB2): port attributes not fully set
ноя 21 08:22:24 notebook.localdomain ModemManager[450]: <warn>  couldn't load Supported Bands: 'QMI ope...2''
ноя 21 08:22:24 notebook.localdomain ModemManager[450]: <warn>  couldn't load SIM identifier: 'QMI oper...2''
ноя 21 08:22:24 notebook.localdomain ModemManager[450]: <warn>  couldn't load IMSI: 'QMI operation fail...2''
ноя 21 08:22:24 notebook.localdomain ModemManager[450]: <warn>  couldn't load list of Own Numbers: 'Cou...d''
ноя 21 08:22:24 notebook.localdomain ModemManager[450]: <warn>  couldn't load current allowed/preferred...ce'
ноя 21 08:22:24 notebook.localdomain ModemManager[450]: <warn>  couldn't load current Bands: 'QMI opera...0''
ноя 21 08:22:24 notebook.localdomain ModemManager[450]: <info>  Modem: state changed (unknown -> disabled)


Если же просто выключить машину, то проблема повторяется так, как уже было сказано.

Comment 7

Mikhail Efremov 2015-01-20 19:55:02 MSK

Попробуйте установить пакеты из задания #138910. Я не помню в changelog чего-то обнадеживающего, но все же там некоторое количество багфиксов, вдруг поможет.

Comment 8

Эрик 2015-01-21 01:01:04 MSK

(В ответ на комментарий №7)
> Попробуйте установить пакеты из задания #138910. Я не помню в changelog чего-то
> обнадеживающего, но все же там некоторое количество багфиксов, вдруг поможет.

Сделал
$ rpm -qa ModemManager
ModemManager-1.4.2-alt0.M70P.1

К сожалению, пока с теми же самыми результатами.

Comment 9

Mikhail Efremov 2015-03-23 21:10:17 MSK

Имеет смысл проверить пакеты из задания #142228. На этот раз в changelog есть нечто обнадеживающее. Я не вижу полного лога, но если там было 'failed to connect modem: Cannot recover from a power off', то это точно исправлено.

Comment 10

Эрик 2015-03-24 02:32:04 MSK

(В ответ на комментарий №9)
> Имеет смысл проверить пакеты из задания #142228. На этот раз в changelog есть
> нечто обнадеживающее. Я не вижу полного лога, но если там было 'failed to
> connect modem: Cannot recover from a power off', то это точно исправлено.

Да, обязательно. Сегодня проверю и отпишусь к вечеру.

Comment 11

Эрик 2015-03-28 10:51:57 MSK

К сожалению ничего не изменилось. При холодной загрузке юсб-свисток не стартует.

Comment 12

Mikhail Efremov 2015-04-03 16:53:16 MSK

Покажите все-таки весь лог от MM:
journalctl -b --full -u ModemManager

Comment 13

Эрик 2015-04-27 11:25:31 MSK

Created attachment 6278 [details]
journalctl -b --full -u ModemManager

Прошу прощения за поздний ответ, не было возможности.

Comment 14

Mikhail Efremov 2015-04-29 16:14:23 MSK

Хм, вообще лог закнчивается
Modem /org/freedesktop/ModemManager1/Modem/0: state changed (connecting -> connected)
Simple connect state (8/8): All done
Т.е. выглядит как будто все хорошо. Ошибки в логе не должны быть фатальными.
Это точно лог случая, когда модем не работает? Если да, то покажите для сранения лог, когда он нормально работает, что ли.
Можно еще попробовать сказать
mmcli -m 0 --set-power-state-on

Comment 15

Эрик 2015-04-29 17:15:56 MSK

(В ответ на комментарий №14)
> Хм, вообще лог закнчивается
> Modem /org/freedesktop/ModemManager1/Modem/0: state changed (connecting ->
> connected)
> Simple connect state (8/8): All done
> Т.е. выглядит как будто все хорошо. Ошибки в логе не должны быть фатальными.
> Это точно лог случая, когда модем не работает? Если да, то покажите для
> сранения лог, когда он нормально работает, что ли.
> Можно еще попробовать сказать
> mmcli -m 0 --set-power-state-on

Чтобы было понятней, выложу кусочки лога по порядку: 

1) Выключил ноут. Лог:
апр 29 19:48:45 notebook.localdomain systemd[1]: Stopped Modem Manager.
-- Reboot --
апр 29 19:49:20 notebook.localdomain ModemManager[482]: <info>  ModemManager (version 1.4.6) starting in system bus...                                                                
апр 29 19:49:20 notebook.localdomain systemd[1]: Started Modem Manager.                                                                                                               
апр 29 19:49:22 notebook.localdomain ModemManager[482]: <warn>  Couldn't find support for device at '/sys/devices/pci0000:00/0000:00:1c.0/0000:01:00.0': not supported by any plugin  
апр 29 19:49:22 notebook.localdomain ModemManager[482]: <warn>  Couldn't find support for device at '/sys/devices/pci0000:00/0000:00:1c.2/0000:02:00.0': not supported by any plugin 

Ноут запустился, но как писал в начале, теперь в NM отсутствует созданное мобильное соединение. 
 
$ lsusb
 
Bus 002 Device 004: ID 12d1:1446 Huawei Technologies Co., Ltd. E1552/E1800/E173 (HSPA modem)

Модем определяетcz, а подключение отсутствует.

$ mmcli -m 0 --set-power-state-on
error: couldn't find modem at '/org/freedesktop/ModemManager1/Modem/0'

Comment 16

Эрик 2015-04-29 17:16:40 MSK

(В ответ на комментарий №14)
> Хм, вообще лог закнчивается
> Modem /org/freedesktop/ModemManager1/Modem/0: state changed (connecting ->
> connected)
> Simple connect state (8/8): All done
> Т.е. выглядит как будто все хорошо. Ошибки в логе не должны быть фатальными.
> Это точно лог случая, когда модем не работает? Если да, то покажите для
> сранения лог, когда он нормально работает, что ли.
> Можно еще попробовать сказать
> mmcli -m 0 --set-power-state-on

Передергиваю модем, подключение появилось.

2) Перезагружаю ноут. Вот кусочек лога после перезагрузки

апр 29 19:54:56 notebook.localdomain systemd[1]: Stopped Modem Manager.
-- Reboot --
апр 29 19:55:18 notebook.localdomain ModemManager[477]: <info>  ModemManager (version 1.4.6) starting in system bus...
апр 29 19:55:19 notebook.localdomain systemd[1]: Started Modem Manager.
апр 29 19:55:19 notebook.localdomain ModemManager[477]: <warn>  (ttyUSB0): port attributes not fully set
апр 29 19:55:19 notebook.localdomain ModemManager[477]: <warn>  (ttyUSB1): port attributes not fully set
апр 29 19:55:19 notebook.localdomain ModemManager[477]: <warn>  (ttyUSB2): port attributes not fully set
апр 29 19:55:19 notebook.localdomain ModemManager[477]: [/dev/cdc-wdm0] Opening device with flags 'version-info, proxy'...
апр 29 19:55:19 notebook.localdomain ModemManager[477]: cannot connect to proxy: Could not connect: Connection refused
апр 29 19:55:19 notebook.localdomain ModemManager[477]: spawning new qmi-proxy (try 1)...
апр 29 19:55:19 notebook.localdomain ModemManager[477]: [/dev/cdc-wdm0] Checking version info (10 retries)...
апр 29 19:55:19 notebook.localdomain ModemManager[477]: [/dev/cdc-wdm0] QMI Device supports 5 services:
апр 29 19:55:19 notebook.localdomain ModemManager[477]: [/dev/cdc-wdm0]    ctl (1.2)
апр 29 19:55:19 notebook.localdomain ModemManager[477]: [/dev/cdc-wdm0]    wds (1.3)
апр 29 19:55:19 notebook.localdomain ModemManager[477]: [/dev/cdc-wdm0]    dms (1.2)
апр 29 19:55:19 notebook.localdomain ModemManager[477]: [/dev/cdc-wdm0]    nas (1.0)
апр 29 19:55:19 notebook.localdomain ModemManager[477]: [/dev/cdc-wdm0]    cat (0.0)
апр 29 19:55:21 notebook.localdomain ModemManager[477]: <warn>  Couldn't find support for device at '/sys/devices/pci0000:00/0000:00:1c.0/0000:01:00.0': not supported by any plugin
апр 29 19:55:21 notebook.localdomain ModemManager[477]: <warn>  Couldn't find support for device at '/sys/devices/pci0000:00/0000:00:1c.2/0000:02:00.0': not supported by any plugin
апр 29 19:55:22 notebook.localdomain ModemManager[477]: <warn>  (ttyUSB1): port attributes not fully set
апр 29 19:55:22 notebook.localdomain ModemManager[477]: <warn>  (ttyUSB2): port attributes not fully set
апр 29 19:55:32 notebook.localdomain ModemManager[477]: <info>  Creating modem with plugin 'Huawei' and '5' ports
апр 29 19:55:32 notebook.localdomain ModemManager[477]: <info>  Modem for device at '/sys/devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1.3' successfully created
апр 29 19:55:32 notebook.localdomain ModemManager[477]: [/dev/cdc-wdm0] Opening device with flags 'version-info, net-802-3, net-no-qos-header, proxy'...
апр 29 19:55:32 notebook.localdomain ModemManager[477]: [/dev/cdc-wdm0] Checking version info (10 retries)...
апр 29 19:55:32 notebook.localdomain ModemManager[477]: [/dev/cdc-wdm0] QMI Device supports 5 services:
апр 29 19:55:32 notebook.localdomain ModemManager[477]: [/dev/cdc-wdm0]    ctl (1.2)
апр 29 19:55:32 notebook.localdomain ModemManager[477]: [/dev/cdc-wdm0]    wds (1.3)
апр 29 19:55:32 notebook.localdomain ModemManager[477]: [/dev/cdc-wdm0]    dms (1.2)
апр 29 19:55:32 notebook.localdomain ModemManager[477]: [/dev/cdc-wdm0]    nas (1.0)
апр 29 19:55:32 notebook.localdomain ModemManager[477]: [/dev/cdc-wdm0]    cat (0.0)
апр 29 19:55:32 notebook.localdomain ModemManager[477]: [/dev/cdc-wdm0] Setting network port data format...
апр 29 19:55:32 notebook.localdomain ModemManager[477]: [/dev/cdc-wdm0] Opening device with flags 'version-info, proxy'...
апр 29 19:55:32 notebook.localdomain ModemManager[477]: [/dev/cdc-wdm0] Checking version info (10 retries)...
апр 29 19:55:32 notebook.localdomain ModemManager[477]: [/dev/cdc-wdm0] QMI Device supports 5 services:
апр 29 19:55:32 notebook.localdomain ModemManager[477]: [/dev/cdc-wdm0]    ctl (1.2)
апр 29 19:55:32 notebook.localdomain ModemManager[477]: [/dev/cdc-wdm0]    wds (1.3)
апр 29 19:55:32 notebook.localdomain ModemManager[477]: [/dev/cdc-wdm0]    dms (1.2)
апр 29 19:55:32 notebook.localdomain ModemManager[477]: [/dev/cdc-wdm0]    nas (1.0)
апр 29 19:55:32 notebook.localdomain ModemManager[477]: [/dev/cdc-wdm0]    cat (0.0)
апр 29 19:55:32 notebook.localdomain ModemManager[477]: [/dev/cdc-wdm0] Allocating new client ID...
апр 29 19:55:32 notebook.localdomain ModemManager[477]: [/dev/cdc-wdm0] Registered 'dms' (version 1.2) client with ID '2'
апр 29 19:55:32 notebook.localdomain ModemManager[477]: [/dev/cdc-wdm0] Allocating new client ID...
апр 29 19:55:32 notebook.localdomain ModemManager[477]: [/dev/cdc-wdm0] Registered 'nas' (version 1.0) client with ID '2'
апр 29 19:55:32 notebook.localdomain ModemManager[477]: <warn>  (ttyUSB2): port attributes not fully set
апр 29 19:55:33 notebook.localdomain ModemManager[477]: <warn>  couldn't load Supported Bands: 'QMI operation failed: Cannot send message: QMI service 'dms' version '1.3' required, g
апр 29 19:55:33 notebook.localdomain ModemManager[477]: <warn>  couldn't load Power State: 'Unhandled power state: 'unknown' (255)'
апр 29 19:55:33 notebook.localdomain ModemManager[477]: <warn>  couldn't load SIM identifier: 'Couldn't get UIM ICCID: QMI protocol error (71): 'InvalidQmiCommand''
апр 29 19:55:33 notebook.localdomain ModemManager[477]: <warn>  couldn't load IMSI: 'Couldn't get UIM IMSI: QMI protocol error (71): 'InvalidQmiCommand''
апр 29 19:55:33 notebook.localdomain ModemManager[477]: <warn>  couldn't load list of Own Numbers: 'Couldn't get MSISDN: QMI protocol error (16): 'NotProvisioned''
апр 29 19:55:33 notebook.localdomain ModemManager[477]: <warn>  couldn't load current allowed/preferred modes: 'Loading current modes is not supported by this device'
апр 29 19:55:33 notebook.localdomain ModemManager[477]: <warn>  couldn't load current Bands: 'QMI operation failed: Cannot send message: QMI service 'nas' version '1.1' required, got
апр 29 19:55:33 notebook.localdomain ModemManager[477]: <info>  Modem: state changed (unknown -> disabled)

Подключение есть. 

$ mmcli -m 0 --set-power-state-on
error: couldn't set new power state in the modem: 'GDBus.Error:org.freedesktop.DBus.Error.AccessDenied: Rejected send message, 2 matched rules; type="method_call", sender=":1.40" (uid=500 pid=2298 comm="mmcli -m 0 --set-power-state-on ") interface="org.freedesktop.ModemManager1.Modem" member="SetPowerState" error name="(unset)" requested_reply="0" destination=":1.3" (uid=0 pid=472 comm="/usr/sbin/ModemManager ")'

Comment 17

Mikhail Efremov 2016-03-24 21:26:51 MSK

Опять имеет смысл проверить пакеты из задания #161980

Comment 18

Mikhail Efremov 2023-10-25 22:34:42 MSK

P7 уже не поддерживается.