Добрый день! Включение отладки правил в вкладке “Устройства” сильно в логе ничего не изменила. Утилита Journalctl в лог после отправки вообще ничего не отдает.
modemlog.log (1,3 КБ)
Да, это я недостаточно понятно описал.
Отладка, после нажатия на кнопку включается публикацией в /devices/wbrules/controls/Rule debugging/on значения “1”.
То есть когда она включена debug сообщения пишутся в топик /wbrules/log/debug и в журналы не пишутся.
Ну да ладно, попробуем обойтись.
Точно ли включена отладка для MM?
Я ожидаю в логе увидеть:
journalctl -u ModemManager -f
-- Journal begins at Wed 2026-03-25 06:46:17 UTC. --
Apr 01 11:47:40 wirenboard-AWI3MCGC ModemManager[25481]: <debug> [1775044060.200196] [modem0/bearer0] ignoring disconnection report
Apr 01 11:47:40 wirenboard-AWI3MCGC ModemManager[25481]: <debug> [1775044060.200294] [ttyUSB1/at] device open count is 1 (close)
Apr 01 11:47:45 wirenboard-AWI3MCGC ModemManager[25481]: <debug> [1775044065.186651] [ttyUSB1/at] device open count is 2 (open)
Apr 01 11:47:45 wirenboard-AWI3MCGC ModemManager[25481]: <debug> [1775044065.186979] [ttyUSB1/at] --> 'AT+CGACT?<CR>'
Apr 01 11:47:45 wirenboard-AWI3MCGC ModemManager[25481]: <debug> [1775044065.200832] [ttyUSB1/at] <-- '<CR><LF>+CGACT: 1,1<CR><LF>'
Apr 01 11:47:45 wirenboard-AWI3MCGC ModemManager[25481]: <debug> [1775044065.201581] [ttyUSB1/at] <-- '<CR><LF>+CGACT: 2,0<CR><LF><CR><LF>+CGACT: 3,0<CR><LF><CR><LF>+CGACT: 4,0<CR><LF><CR><LF>+CGACT: 5,0<CR><LF><CR><LF>+CGACT: 6,0<CR><LF><CR><LF>+CGACT: 7,0<CR><LF><CR><LF>+CGACT: 8,1<CR><LF>'
Apr 01 11:47:45 wirenboard-AWI3MCGC ModemManager[25481]: <debug> [1775044065.202304] [ttyUSB1/at] <-- '<CR><LF>+CGACT: 9,0<CR><LF><CR><LF>+CGACT: 10,0<CR><LF><CR><LF>OK<CR><LF>'
Apr 01 11:47:45 wirenboard-AWI3MCGC ModemManager[25481]: <debug> [1775044065.203029] [modem0/bearer0] connection status loaded: disconnected
Apr 01 11:47:45 wirenboard-AWI3MCGC ModemManager[25481]: <debug> [1775044065.203103] [modem0/bearer0] ignoring disconnection report
Apr 01 11:47:45 wirenboard-AWI3MCGC ModemManager[25481]: <debug> [1775044065.203190] [ttyUSB1/at] device open count is 1 (close)
Apr 01 11:47:50 wirenboard-AWI3MCGC ModemManager[25481]: <debug> [1775044070.186310] [ttyUSB1/at] device open count is 2 (open)
Apr 01 11:47:50 wirenboard-AWI3MCGC ModemManager[25481]: <debug> [1775044070.187167] [ttyUSB1/at] --> 'AT+CGACT?<CR>'
Apr 01 11:47:50 wirenboard-AWI3MCGC ModemManager[25481]: <debug> [1775044070.199413] [ttyUSB1/at] <-- '<CR><LF>+CGACT: 1,1<CR><LF>'
Apr 01 11:47:50 wirenboard-AWI3MCGC ModemManager[25481]: <debug> [1775044070.199864] [ttyUSB1/at] <-- '<CR><LF>+CGACT: 2,0<CR><LF><CR><LF>+CGACT: 3,0<CR><LF><CR><LF>+CGACT: 4,0<CR><LF><CR><LF>+CGACT: 5,0<CR><LF>'
Apr 01 11:47:50 wirenboard-AWI3MCGC ModemManager[25481]: <debug> [1775044070.200375] [ttyUSB1/at] <-- '<CR><LF>+CGACT: 6,0<CR><LF><CR><LF>+CGACT: 7,0<CR><LF><CR><LF>+CGACT: 8,1<CR><LF><CR><LF>+CGACT: 9,0<CR><LF><CR><LF>+CGACT: 10,0<CR><LF>'
Apr 01 11:47:50 wirenboard-AWI3MCGC ModemManager[25481]: <debug> [1775044070.201386] [ttyUSB1/at] <-- '<CR><LF>OK<CR><LF>'
Apr 01 11:47:50 wirenboard-AWI3MCGC ModemManager[25481]: <debug> [1775044070.202177] [modem0/bearer0] connection status loaded: disconnected
Apr 01 11:47:50 wirenboard-AWI3MCGC ModemManager[25481]: <debug> [1775044070.202274] [modem0/bearer0] ignoring disconnection report
Apr 01 11:47:50 wirenboard-AWI3MCGC ModemManager[25481]: <debug> [1775044070.202370] [ttyUSB1/at] device open count is 1 (close)
На всякий случай - включаю так:
cat > /etc/systemd/system/ModemManager.service.d/10-debug-execstart.conf <<"EOF"
[Service]
ExecStart=
ExecStart=/usr/sbin/ModemManager --debug
EOF
systemctl daemon-reload
systemctl restart ModemManager
Как-то очень медленно и мудрёно процесс у нас идет. Может быть, Вы сами в облаке к контроллеру подключитесь и посмотрите сразу все, что необходимо? А то, боюсь, мы так полдня переписываться еще будем 
Вполне могу, да. Добавляйте, пользователя support@wirenboard.com в организацию на облачном сервисе.
Логин, пароль от SSH пришлите личным сообщением, если они нестандартные.
Для этого в настройках организации нажмите кнопку “Пригласить”
После этого поддержка получит доступ к вашему контроллеру для диагностики.
Не забудьте удалить потом доступ.
Зайду, проверю, отправив несколько SMS на свой номер.
Я не вижу пока проблем с отправкой.
По крайней мене модем отправляет. Для примера
root@wirenboard-AXCFBMYW:~# journalctl -u ModemManager --since "5 min ago" |grep sms
Apr 01 19:14:32 wirenboard-AXCFBMYW ModemManager[38657]: <debug> [1775060072.593829] [modem0/sms3] processing chunk '0' of text with '53' bytes
Apr 01 19:14:32 wirenboard-AXCFBMYW ModemManager[38657]: <debug> [1775060072.594010] [modem0/sms3] created SMS part for singlepart SMS
Apr 01 19:14:32 wirenboard-AXCFBMYW ModemManager[38657]: <debug> [1775060072.594057] [modem0/sms3] creating PDU for part...
Apr 01 19:14:32 wirenboard-AXCFBMYW ModemManager[38657]: <debug> [1775060072.594087] [modem0/sms3] using UCS2 encoding...
Apr 01 19:14:32 wirenboard-AXCFBMYW ModemManager[38657]: <debug> [1775060072.594169] [modem0/sms3] user data length is 72 octets (without UDH)
root@wirenboard-AXCFBMYW:~# journalctl -u ModemManager --since "2 min ago" |grep sms
Apr 01 19:16:26 wirenboard-AXCFBMYW ModemManager[38657]: <debug> [1775060186.216926] [modem0/sms4] processing chunk '0' of text with '126' bytes
Apr 01 19:16:26 wirenboard-AXCFBMYW ModemManager[38657]: <debug> [1775060186.217174] [modem0/sms4] created SMS part '1' for multipart SMS ('3' parts expected)
Apr 01 19:16:26 wirenboard-AXCFBMYW ModemManager[38657]: <debug> [1775060186.217204] [modem0/sms4] processing chunk '1' of text with '120' bytes
Apr 01 19:16:26 wirenboard-AXCFBMYW ModemManager[38657]: <debug> [1775060186.217236] [modem0/sms4] created SMS part '2' for multipart SMS ('3' parts expected)
Apr 01 19:16:26 wirenboard-AXCFBMYW ModemManager[38657]: <debug> [1775060186.217261] [modem0/sms4] processing chunk '2' of text with '12' bytes
Apr 01 19:16:26 wirenboard-AXCFBMYW ModemManager[38657]: <debug> [1775060186.217291] [modem0/sms4] created SMS part '3' for multipart SMS ('3' parts expected)
Apr 01 19:16:26 wirenboard-AXCFBMYW ModemManager[38657]: <debug> [1775060186.217423] [modem0/sms4] creating PDU for part...
Apr 01 19:16:26 wirenboard-AXCFBMYW ModemManager[38657]: <debug> [1775060186.217450] [modem0/sms4] adding UDHI to PDU...
Apr 01 19:16:26 wirenboard-AXCFBMYW ModemManager[38657]: <debug> [1775060186.217475] [modem0/sms4] using UCS2 encoding...
Apr 01 19:16:26 wirenboard-AXCFBMYW ModemManager[38657]: <debug> [1775060186.217497] [modem0/sms4] adding UDH header in PDU... (reference: 100, max: 3, sequence: 1)
Apr 01 19:16:26 wirenboard-AXCFBMYW ModemManager[38657]: <debug> [1775060186.217582] [modem0/sms4] user data length is 140 octets (with UDH)
Apr 01 19:16:27 wirenboard-AXCFBMYW ModemManager[38657]: <debug> [1775060187.233191] [modem0/sms4] creating PDU for part...
Apr 01 19:16:27 wirenboard-AXCFBMYW ModemManager[38657]: <debug> [1775060187.233331] [modem0/sms4] adding UDHI to PDU...
Apr 01 19:16:27 wirenboard-AXCFBMYW ModemManager[38657]: <debug> [1775060187.233445] [modem0/sms4] using UCS2 encoding...
Apr 01 19:16:27 wirenboard-AXCFBMYW ModemManager[38657]: <debug> [1775060187.233550] [modem0/sms4] adding UDH header in PDU... (reference: 100, max: 3, sequence: 2)
Apr 01 19:16:27 wirenboard-AXCFBMYW ModemManager[38657]: <debug> [1775060187.233778] [modem0/sms4] user data length is 140 octets (with UDH)
Apr 01 19:16:28 wirenboard-AXCFBMYW ModemManager[38657]: <debug> [1775060188.169888] [modem0/sms4] creating PDU for part...
Apr 01 19:16:28 wirenboard-AXCFBMYW ModemManager[38657]: <debug> [1775060188.169929] [modem0/sms4] adding UDHI to PDU...
Apr 01 19:16:28 wirenboard-AXCFBMYW ModemManager[38657]: <debug> [1775060188.169958] [modem0/sms4] using UCS2 encoding...
Apr 01 19:16:28 wirenboard-AXCFBMYW ModemManager[38657]: <debug> [1775060188.169981] [modem0/sms4] adding UDH header in PDU... (reference: 100, max: 3, sequence: 3)
Apr 01 19:16:28 wirenboard-AXCFBMYW ModemManager[38657]: <debug> [1775060188.170086] [modem0/sms4] user data length is 30 octets (with UDH)
И “короткую” и “длинную”.
Это, скорее всего, связано с тем, что сервис wb-rules перестартовал. Так и было. А вот через пару-тройку часов - перестает уходить все
Да? Ну, отлично, проверю тогда завтра.
Доброе утро. Судя по тому, что спустя 12 часов SMS уходят нормально, это - или мистика какая-то была, или последними обновлениями apt update && apt upgrade какое-то узкое место закрыли. Иного предположить не могу
Ну, да, вижу
journalctl -u ModemManager --since "25 min ago" |grep sms
Apr 02 08:11:02 wirenboard-AXCFBMYW ModemManager[38657]: <debug> [1775106662.418557] [modem0/sms8] processing chunk '0' of text with '53' bytes
Apr 02 08:11:02 wirenboard-AXCFBMYW ModemManager[38657]: <debug> [1775106662.418780] [modem0/sms8] created SMS part for singlepart SMS
Apr 02 08:11:02 wirenboard-AXCFBMYW ModemManager[38657]: <debug> [1775106662.418830] [modem0/sms8] creating PDU for part...
Apr 02 08:11:02 wirenboard-AXCFBMYW ModemManager[38657]: <debug> [1775106662.418859] [modem0/sms8] using UCS2 encoding...
Apr 02 08:11:02 wirenboard-AXCFBMYW ModemManager[38657]: <debug> [1775106662.418973] [modem0/sms8] user data length is 72 octets (without UDH)
Apr 02 08:11:42 wirenboard-AXCFBMYW ModemManager[38657]: <debug> [1775106702.599984] [modem0/sms9] processing chunk '0' of text with '126' bytes
Apr 02 08:11:42 wirenboard-AXCFBMYW ModemManager[38657]: <debug> [1775106702.600137] [modem0/sms9] created SMS part '1' for multipart SMS ('3' parts expected)
Apr 02 08:11:42 wirenboard-AXCFBMYW ModemManager[38657]: <debug> [1775106702.600167] [modem0/sms9] processing chunk '1' of text with '120' bytes
Apr 02 08:11:42 wirenboard-AXCFBMYW ModemManager[38657]: <debug> [1775106702.600200] [modem0/sms9] created SMS part '2' for multipart SMS ('3' parts expected)
Apr 02 08:11:42 wirenboard-AXCFBMYW ModemManager[38657]: <debug> [1775106702.600228] [modem0/sms9] processing chunk '2' of text with '12' bytes
Apr 02 08:11:42 wirenboard-AXCFBMYW ModemManager[38657]: <debug> [1775106702.600261] [modem0/sms9] created SMS part '3' for multipart SMS ('3' parts expected)
Apr 02 08:11:42 wirenboard-AXCFBMYW ModemManager[38657]: <debug> [1775106702.600313] [modem0/sms9] creating PDU for part...
Apr 02 08:11:42 wirenboard-AXCFBMYW ModemManager[38657]: <debug> [1775106702.600341] [modem0/sms9] adding UDHI to PDU...
Apr 02 08:11:42 wirenboard-AXCFBMYW ModemManager[38657]: <debug> [1775106702.600367] [modem0/sms9] using UCS2 encoding...
Apr 02 08:11:42 wirenboard-AXCFBMYW ModemManager[38657]: <debug> [1775106702.600391] [modem0/sms9] adding UDH header in PDU... (reference: 159, max: 3, sequence: 1)
Apr 02 08:11:42 wirenboard-AXCFBMYW ModemManager[38657]: <debug> [1775106702.600518] [modem0/sms9] user data length is 140 octets (with UDH)
Apr 02 08:11:45 wirenboard-AXCFBMYW ModemManager[38657]: <debug> [1775106705.370543] [modem0/sms9] creating PDU for part...
Apr 02 08:11:45 wirenboard-AXCFBMYW ModemManager[38657]: <debug> [1775106705.370727] [modem0/sms9] adding UDHI to PDU...
Apr 02 08:11:45 wirenboard-AXCFBMYW ModemManager[38657]: <debug> [1775106705.370802] [modem0/sms9] using UCS2 encoding...
Apr 02 08:11:45 wirenboard-AXCFBMYW ModemManager[38657]: <debug> [1775106705.370867] [modem0/sms9] adding UDH header in PDU... (reference: 159, max: 3, sequence: 2)
Apr 02 08:11:45 wirenboard-AXCFBMYW ModemManager[38657]: <debug> [1775106705.371031] [modem0/sms9] user data length is 140 octets (with UDH)
Apr 02 08:11:47 wirenboard-AXCFBMYW ModemManager[38657]: <debug> [1775106707.289659] [modem0/sms9] creating PDU for part...
Apr 02 08:11:47 wirenboard-AXCFBMYW ModemManager[38657]: <debug> [1775106707.289704] [modem0/sms9] adding UDHI to PDU...
Apr 02 08:11:47 wirenboard-AXCFBMYW ModemManager[38657]: <debug> [1775106707.289731] [modem0/sms9] using UCS2 encoding...
Apr 02 08:11:47 wirenboard-AXCFBMYW ModemManager[38657]: <debug> [1775106707.289754] [modem0/sms9] adding UDH header in PDU... (reference: 159, max: 3, sequence: 3)
Apr 02 08:11:47 wirenboard-AXCFBMYW ModemManager[38657]: <debug> [1775106707.289825] [modem0/sms9] user data length is 30 octets (with UDH)
Предлагаю пока вопрос закрыть и помониторить. Выключите только, пожалуйста, отладку, где включали
Да. Выполнил
rm /etc/systemd/system/ModemManager.service.d/10-debug-execstart.conf
systemctl daemon-reload
systemctl restart ModemManager
Доброе утро! Увы, вчерашний оптимизм оказался преждевременным. Сегодня опять SMS не уходят
Пожалуйста покажите лог…
Приложено. Доступ открыт
log_20260403T123630.log (8,1 КБ)
Вчера вечером не уходили SMS. Сегодня - уходят, хотя с тех пор ничего не менялось, wb-rules не перезапускался. Допустимо ли отладку в ModemManager оставить на несколько суток включенной?
Ничего, кстити, не менял.
Да, вполне.
Включил в конфигурации отладку MM. Больше ничего не нужно?
Нет, просто проверьте что в лог MM падают <debug>
Воспроизвести ситуацию с включенной отладкой пока так и не удалось. Предлагаю пока закрыть тему.
Ну, вот это как раз плохо, то есть то что не воспроизводится - и починить не получится…
Да, закроем, но если получится воспроизвести - напишите пожалуйста.