I use ModemManager 1.18.6 on OpenWRT 22.03.0-rc4. I run it:
root@OpenWrt:~# ModemManager
[6778]: <info> ModemManager (version 1.18.6) starting in system bus...
Report kernel events:
root@OpenWrt:~# mmcli
--report-kernel-event=action=add,name=ttyACM2,subsystem=tty
successfully reported kernel event
root@OpenWrt:~# mmcli --report-kernel-event=action=add,name=wwan0,subsystem=net
successfully reported kernel event
Modem is found:
root@OpenWrt:~# mmcli -m any
--------------------------------
General | path: /org/freedesktop/ModemManager1/Modem/0
| device id: <REDACTED>
--------------------------------
Hardware | manufacturer: Cinterion
| model: PLAS9-W
| firmware revision: REVISION 01.004
| supported: gsm-umts, lte
| current: gsm-umts, lte
| equipment id: <REDACTED>
--------------------------------
System | device:
/sys/devices/platform/soc/8af8800.usb3/8a00000.dwc3/xhci-hcd.0.auto/usb2/2-1
| drivers: cdc_acm, cdc_ether
| plugin: cinterion
| primary port: ttyACM2
| ports: ttyACM2 (at), wwan0 (net)
--------------------------------
Status | unlock retries: ph-fsim-pin (0), sim-puk2 (10), sim-puk
(10), sim-pin2 (3),
| ph-net-puk (0), sim-pin (3), ph-net-pin (0),
ph-fsim-puk (0)
| state: disabled
| power state: on
| signal quality: 0% (cached)
--------------------------------
Modes | supported: allowed: 2g; preferred: none
| allowed: 3g; preferred: none
| allowed: 4g; preferred: none
| allowed: 2g, 3g, 4g; preferred: none
| current: allowed: any; preferred: none
--------------------------------
Bands | supported: egsm, dcs, utran-1, utran-3, utran-6,
utran-5, utran-8,
| eutran-1, eutran-3, eutran-5, eutran-7,
eutran-8, eutran-18,
| eutran-19, eutran-20, eutran-26, eutran-28,
eutran-38, eutran-39,
| eutran-40, eutran-41
| current: egsm, dcs, utran-1, utran-3, utran-6,
utran-5, utran-8,
| eutran-1, eutran-3, eutran-5, eutran-7,
eutran-8, eutran-18,
| eutran-19, eutran-20, eutran-26, eutran-28,
eutran-38, eutran-39,
| eutran-40, eutran-41
--------------------------------
IP | supported: ipv4, ipv6, ipv4v6
--------------------------------
3GPP | imei: <REDACTED>
--------------------------------
3GPP EPS | ue mode of operation: csps-2
| initial bearer apn: internet
--------------------------------
SIM | primary sim path: /org/freedesktop/ModemManager1/SIM/0
I'm using Telenor card in international roaming and I get the
following error with --simple-connect:
root@OpenWrt:~# mmcli -m any --timeout 120
--simple-connect=apn=telenor.smart,ip-type=ipv4
error: couldn't connect the modem:
'GDBus.Error:org.freedesktop.ModemManager1.Error.MobileEquipment.GprsUnknown:
Unspecified GPRS error'
And a few seconds later mmcli reports 'state: searching'. But if I
kill ModemManager, start it and report kernel events again and enable
the modem and wait a few seconds before connecting like that:
root@OpenWrt:~# mmcli -m any -e && sleep 1 && mmcli -m any --timeout 120
--simple-connect=apn=telenor.smart,ip-type=ipv4
successfully enabled the modem
successfully connected the modem
it works (or at least worked every time so far). To my untrained eye
it looks like modem has to be in registered state for at least 1
second before it can connect to non-default bearer. Have you seen
anything like that before? What could it be - ModemManager issue,
buggy modem fw (I saw this
https://gitlab.freedesktop.org/mobile-broadband/ModemManager/-/issues/639),
network issue?
I attach debug log for unsuccessful connection attempt:
root@OpenWrt:~# ModemManager --debug
[7273]: <info> [1666700572.304968] ModemManager (version 1.18.6) starting in
system bus...
[7273]: <debug> [1666700572.305278] [charsets] detecting platform iconv()
support...
[7273]: <debug> [1666700572.305525] [charsets] UTF-8: iconv conversion
to/from charset is supported
[7273]: <debug> [1666700572.305778] [charsets] UCS-2BE: iconv conversion to
charset not supported
[7273]: <debug> [1666700572.306048] [charsets] ASCII: iconv conversion
to/from charset is supported
[7273]: <debug> [1666700572.306263] [charsets] ISO8859-1: iconv conversion to
charset not supported
[7273]: <debug> [1666700572.306462] [charsets] CP437: iconv conversion to
charset not supported
[7273]: <debug> [1666700572.306648] [charsets] CP850: iconv conversion to
charset not supported
[7273]: <debug> [1666700572.306822] [charsets] UTF-16BE: iconv conversion
to/from charset is supported
[7273]: <debug> [1666700572.318939] bus acquired, creating manager...
[7273]: <debug> [1666700572.320476] [auth-provider] singleton created
[7273]: <debug> [1666700572.321640] [filter] created
[7273]: <debug> [1666700572.321871] [filter] explicit whitelist: yes
[7273]: <debug> [1666700572.322046] [filter] explicit blacklist: yes
[7273]: <debug> [1666700572.322219] [filter] plugin whitelist: yes
[7273]: <debug> [1666700572.322382] [filter] qrtr devices allowed: yes
[7273]: <debug> [1666700572.322547] [filter] virtual devices forbidden: yes
[7273]: <debug> [1666700572.322709] [filter] net devices allowed: yes
[7273]: <debug> [1666700572.322869] [filter] usbmisc devices allowed: yes
[7273]: <debug> [1666700572.323028] [filter] rpmsg devices allowed: yes
[7273]: <debug> [1666700572.323184] [filter] wwan devices allowed: yes
[7273]: <debug> [1666700572.323390] [filter] tty devices:
[7273]: <debug> [1666700572.323597] [filter] platform driver check: yes
[7273]: <debug> [1666700572.323822] [filter] driver check: yes
[7273]: <debug> [1666700572.324113] [filter] cdc-acm interface check: yes
[7273]: <debug> [1666700572.324345] [filter] with net check: yes
[7273]: <debug> [1666700572.324575] [filter] default:
forbidden
[7273]: <debug> [1666700572.325327] [plugin-manager] looking for plugins in
'/usr/lib/ModemManager'
[7273]: <debug> [1666700572.327681] [plugin-manager] loaded shared 'Xmm' utils
from '/usr/lib/ModemManager/libmm-shared-xmm.so'
[7273]: <debug> [1666700572.329388] [plugin-manager] loaded shared 'Telit'
utils from '/usr/lib/ModemManager/libmm-shared-telit.so'
[7273]: <debug> [1666700572.331094] [plugin-manager] loaded shared 'Sierra'
utils from '/usr/lib/ModemManager/libmm-shared-sierra.so'
[7273]: <debug> [1666700572.332393] [plugin-manager] loaded shared 'Option'
utils from '/usr/lib/ModemManager/libmm-shared-option.so'
[7273]: <debug> [1666700572.333723] [plugin-manager] loaded shared 'Novatel'
utils from '/usr/lib/ModemManager/libmm-shared-novatel.so'
[7273]: <debug> [1666700572.335551] [plugin-manager] loaded shared 'Icera'
utils from '/usr/lib/ModemManager/libmm-shared-icera.so'
[7273]: <debug> [1666700572.336928] [plugin-manager] loaded shared 'Foxconn'
utils from '/usr/lib/ModemManager/libmm-shared-foxconn.so'
[7273]: <debug> [1666700572.339954] [plugin-manager] loaded plugin 'zte' from
'/usr/lib/ModemManager/libmm-plugin-zte.so'
[7273]: <debug> [1666700572.340314] [filter] registered plugin whitelist vendor
id: 19d2
[7273]: <debug> [1666700572.342003] [plugin-manager] loaded plugin 'x22x' from
'/usr/lib/ModemManager/libmm-plugin-x22x.so'
[7273]: <debug> [1666700572.342332] [filter] registered plugin whitelist tag:
ID_MM_X22X_TAGGED
[7273]: <debug> [1666700572.342765] [filter] registered plugin whitelist vendor
id: 1bbb
[7273]: <debug> [1666700572.342997] [filter] registered plugin whitelist vendor
id: 0b3c
[7273]: <debug> [1666700572.344509] [plugin-manager] loaded plugin 'wavecom'
from '/usr/lib/ModemManager/libmm-plugin-wavecom.so'
[7273]: <debug> [1666700572.344775] [filter] registered plugin whitelist vendor
id: 114f
[7273]: <debug> [1666700572.345988] [plugin-manager] loaded plugin 'via' from
'/usr/lib/ModemManager/libmm-plugin-via.so'
[7273]: <debug> [1666700572.347677] [plugin-manager] loaded plugin 'u-blox'
from '/usr/lib/ModemManager/libmm-plugin-ublox.so'
[7273]: <debug> [1666700572.347947] [filter] registered plugin whitelist vendor
id: 1546
[7273]: <debug> [1666700572.349087] [plugin-manager] loaded plugin 'tp-link'
from '/usr/lib/ModemManager/libmm-plugin-tplink.so'
[7273]: <debug> [1666700572.349345] [filter] registered plugin whitelist vendor
id: 2357
[7273]: <debug> [1666700572.350582] [plugin-manager] loaded plugin 'thuraya'
from '/usr/lib/ModemManager/libmm-plugin-thuraya.so'
[7273]: <debug> [1666700572.350844] [filter] registered plugin whitelist vendor
id: 1a26
[7273]: <debug> [1666700572.351990] [plugin-manager] loaded plugin 'telit' from
'/usr/lib/ModemManager/libmm-plugin-telit.so'
[7273]: <debug> [1666700572.352252] [filter] registered plugin whitelist vendor
id: 1bc7
[7273]: <debug> [1666700572.353671] [plugin-manager] loaded plugin 'simtech'
from '/usr/lib/ModemManager/libmm-plugin-simtech.so'
[7273]: <debug> [1666700572.353969] [filter] registered plugin whitelist vendor
id: 1e0e
[7273]: <debug> [1666700572.355127] [plugin-manager] loaded plugin 'sierra'
from '/usr/lib/ModemManager/libmm-plugin-sierra.so'
[7273]: <debug> [1666700572.355387] [filter] registered plugin whitelist vendor
id: 1199
[7273]: <debug> [1666700572.356649] [plugin-manager] loaded plugin
'sierra-legacy' from '/usr/lib/ModemManager/libmm-plugin-sierra-legacy.so'
[7273]: <debug> [1666700572.357814] [plugin-manager] loaded plugin 'samsung'
from '/usr/lib/ModemManager/libmm-plugin-samsung.so'
[7273]: <debug> [1666700572.358076] [filter] registered plugin whitelist
product id: 04e8:6872
[7273]: <debug> [1666700572.358260] [filter] registered plugin whitelist
product id: 04e8:6906
[7273]: <debug> [1666700572.359627] [plugin-manager] loaded plugin 'quectel'
from '/usr/lib/ModemManager/libmm-plugin-quectel.so'
[7273]: <debug> [1666700572.359896] [filter] registered plugin whitelist vendor
id: 2c7c
[7273]: <debug> [1666700572.360078] [filter] registered plugin whitelist vendor
id: 1eac
[7273]: <debug> [1666700572.361215] [plugin-manager] loaded plugin 'qcom-soc'
from '/usr/lib/ModemManager/libmm-plugin-qcom-soc.so'
[7273]: <debug> [1666700572.361480] [filter] registered plugin whitelist tag:
ID_MM_QCOM_SOC
[7273]: <debug> [1666700572.362675] [plugin-manager] loaded plugin 'pantech'
from '/usr/lib/ModemManager/libmm-plugin-pantech.so'
[7273]: <debug> [1666700572.362939] [filter] registered plugin whitelist vendor
id: 106c
[7273]: <debug> [1666700572.364109] [plugin-manager] loaded plugin 'option'
from '/usr/lib/ModemManager/libmm-plugin-option.so'
[7273]: <debug> [1666700572.364366] [filter] registered plugin whitelist vendor
id: 0af0
[7273]: <debug> [1666700572.364549] [filter] registered plugin whitelist vendor
id: 1931
[7273]: <debug> [1666700572.366084] [plugin-manager] loaded plugin 'option-hso'
from '/usr/lib/ModemManager/libmm-plugin-option-hso.so'
[7273]: <debug> [1666700572.367292] [plugin-manager] loaded plugin 'novatel'
from '/usr/lib/ModemManager/libmm-plugin-novatel.so'
[7273]: <debug> [1666700572.367551] [filter] registered plugin whitelist vendor
id: 1410
[7273]: <debug> [1666700572.368893] [plugin-manager] loaded plugin
'novatel-lte' from '/usr/lib/ModemManager/libmm-plugin-novatel-lte.so'
[7273]: <debug> [1666700572.369156] [filter] registered plugin whitelist
product id: 1410:9010
[7273]: <debug> [1666700572.370475] [plugin-manager] loaded plugin 'nokia' from
'/usr/lib/ModemManager/libmm-plugin-nokia.so'
[7273]: <debug> [1666700572.370739] [filter] registered plugin whitelist vendor
id: 0421
[7273]: <debug> [1666700572.371863] [plugin-manager] loaded plugin
'nokia-icera' from '/usr/lib/ModemManager/libmm-plugin-nokia-icera.so'
[7273]: <debug> [1666700572.373245] [plugin-manager] loaded plugin 'mtk' from
'/usr/lib/ModemManager/libmm-plugin-mtk.so'
[7273]: <debug> [1666700572.373507] [filter] registered plugin whitelist tag:
ID_MM_MTK_TAGGED
[7273]: <debug> [1666700572.374704] [plugin-manager] loaded plugin 'motorola'
from '/usr/lib/ModemManager/libmm-plugin-motorola.so'
[7273]: <debug> [1666700572.374968] [filter] registered plugin whitelist
product id: 22b8:3802
[7273]: <debug> [1666700572.375156] [filter] registered plugin whitelist
product id: 22b8:4902
[7273]: <debug> [1666700572.376429] [plugin-manager] loaded plugin 'longcheer'
from '/usr/lib/ModemManager/libmm-plugin-longcheer.so'
[7273]: <debug> [1666700572.376691] [filter] registered plugin whitelist tag:
ID_MM_LONGCHEER_TAGGED
[7273]: <debug> [1666700572.376883] [filter] registered plugin whitelist vendor
id: 1c9e
[7273]: <debug> [1666700572.378168] [plugin-manager] loaded plugin 'linktop'
from '/usr/lib/ModemManager/libmm-plugin-linktop.so'
[7273]: <debug> [1666700572.378430] [filter] registered plugin whitelist vendor
id: 230d
[7273]: <debug> [1666700572.379752] [plugin-manager] loaded plugin 'iridium'
from '/usr/lib/ModemManager/libmm-plugin-iridium.so'
[7273]: <debug> [1666700572.380011] [filter] registered plugin whitelist vendor
id: 1edd
[7273]: <debug> [1666700572.381944] [plugin-manager] loaded plugin 'huawei'
from '/usr/lib/ModemManager/libmm-plugin-huawei.so'
[7273]: <debug> [1666700572.382219] [filter] registered plugin whitelist vendor
id: 12d1
[7273]: <debug> [1666700572.383338] [plugin-manager] loaded plugin 'haier' from
'/usr/lib/ModemManager/libmm-plugin-haier.so'
[7273]: <debug> [1666700572.383599] [filter] registered plugin whitelist vendor
id: 201e
[7273]: <debug> [1666700572.384815] [plugin-manager] loaded plugin 'gosuncn'
from '/usr/lib/ModemManager/libmm-plugin-gosuncn.so'
[7273]: <debug> [1666700572.385081] [filter] registered plugin whitelist vendor
id: 305a
[7273]: <debug> [1666700572.386211] [plugin-manager] loaded plugin 'generic'
from '/usr/lib/ModemManager/libmm-plugin-generic.so'
[7273]: <debug> [1666700572.387458] [plugin-manager] loaded plugin 'foxconn'
from '/usr/lib/ModemManager/libmm-plugin-foxconn.so'
[7273]: <debug> [1666700572.387717] [filter] registered plugin whitelist vendor
id: 0489
[7273]: <debug> [1666700572.387904] [filter] registered plugin whitelist vendor
id: 105b
[7273]: <debug> [1666700572.389077] [plugin-manager] loaded plugin 'fibocom'
from '/usr/lib/ModemManager/libmm-plugin-fibocom.so'
[7273]: <debug> [1666700572.389339] [filter] registered plugin whitelist vendor
id: 2cb7
[7273]: <debug> [1666700572.391015] [plugin-manager] loaded plugin
'ericsson-mbm' from '/usr/lib/ModemManager/libmm-plugin-ericsson-mbm.so'
[7273]: <debug> [1666700572.391291] [filter] registered plugin whitelist tag:
ID_MM_ERICSSON_MBM
[7273]: <debug> [1666700572.392445] [plugin-manager] loaded plugin 'd-link'
from '/usr/lib/ModemManager/libmm-plugin-dlink.so'
[7273]: <debug> [1666700572.392710] [filter] registered plugin whitelist vendor
id: 2001
[7273]: <debug> [1666700572.394206] [plugin-manager] loaded plugin 'dell' from
'/usr/lib/ModemManager/libmm-plugin-dell.so'
[7273]: <debug> [1666700572.394505] [filter] registered plugin whitelist vendor
id: 413c
[7273]: <debug> [1666700572.396331] [plugin-manager] loaded plugin 'cinterion'
from '/usr/lib/ModemManager/libmm-plugin-cinterion.so'
[7273]: <debug> [1666700572.396604] [filter] registered plugin whitelist vendor
id: 1e2d
[7273]: <debug> [1666700572.396790] [filter] registered plugin whitelist vendor
id: 0681
[7273]: <debug> [1666700572.397942] [plugin-manager] loaded plugin 'broadmobi'
from '/usr/lib/ModemManager/libmm-plugin-broadmobi.so'
[7273]: <debug> [1666700572.398207] [filter] registered plugin whitelist vendor
id: 2020
[7273]: <debug> [1666700572.399526] [plugin-manager] loaded plugin 'anydata'
from '/usr/lib/ModemManager/libmm-plugin-anydata.so'
[7273]: <debug> [1666700572.399800] [filter] registered plugin whitelist vendor
id: 16d5
[7273]: <debug> [1666700572.401334] [plugin-manager] loaded plugin 'altair-lte'
from '/usr/lib/ModemManager/libmm-plugin-altair-lte.so'
[7273]: <debug> [1666700572.401604] [filter] registered plugin whitelist
product id: 216f:0047
[7273]: <debug> [1666700572.401807] [plugin-manager] successfully loaded 39
plugins registering 6 subsystems: tty, net, usbmisc, wwan, rpmsg, qrtr
[7273]: <debug> [1666700572.446767] service name
'org.freedesktop.ModemManager1' was acquired
[7273]: <debug> [1666700572.446940] [base-manager] unsupported automatic device
scan...
[7273]: <debug> [1666700574.630031] [base-manager] kernel event reported:
[7273]: <debug> [1666700574.630264] [base-manager] action: add
[7273]: <debug> [1666700574.630433] [base-manager] subsystem: tty
[7273]: <debug> [1666700574.630580] [base-manager] name: ttyACM2
[7273]: <debug> [1666700574.630734] [base-manager] uid: n/a
[7273]: <debug> [1666700574.686416] [ttyACM2] preloading contents and
properties...
[7273]: <debug> [1666700574.686991] [ttyACM2] sysfs path:
/sys/devices/platform/soc/8af8800.usb3/8a00000.dwc3/xhci-hcd.0.auto/usb2/2-1/2-1:1.2/tty/ttyACM2
[7273]: <debug> [1666700574.691560] [ttyACM2] port contents loaded:
[7273]: <debug> [1666700574.691738] [ttyACM2] bus: usb
[7273]: <debug> [1666700574.691967] [ttyACM2] interface:
/sys/devices/platform/soc/8af8800.usb3/8a00000.dwc3/xhci-hcd.0.auto/usb2/2-1/2-1:1.2
[7273]: <debug> [1666700574.692103] [ttyACM2] interface class: 02
[7273]: <debug> [1666700574.692325] [ttyACM2] interface subclass: 02
[7273]: <debug> [1666700574.692456] [ttyACM2] interface protocol: 01
[7273]: <debug> [1666700574.692581] [ttyACM2] interface number: 02
[7273]: <debug> [1666700574.692700] [ttyACM2] interface description: CDC
Abstract Control Model (ACM)
[7273]: <debug> [1666700574.692812] [ttyACM2] device:
/sys/devices/platform/soc/8af8800.usb3/8a00000.dwc3/xhci-hcd.0.auto/usb2/2-1
[7273]: <debug> [1666700574.692931] [ttyACM2] subsystems: tty, usb
[7273]: <debug> [1666700574.693041] [ttyACM2] drivers: cdc_acm, usb
[7273]: <debug> [1666700574.693144] [ttyACM2] vendor: 1e2d
[7273]: <debug> [1666700574.693246] [ttyACM2] product: 0061
[7273]: <debug> [1666700574.693366] [ttyACM2] revision: 0232
[7273]: <debug> [1666700574.693481] [ttyACM2] manufacturer: Cinterion
[7273]: <debug> [1666700574.693598] [ttyACM2] product: LTE Modem
[7273]: <debug> [1666700574.693714] [ttyACM2] ID_USB_INTERFACE_NUM: 0x02
[7273]: <debug> [1666700574.693920] [ttyACM2] ID_MODEL: LTE Modem
[7273]: <debug> [1666700574.694069] [ttyACM2] ID_VENDOR: Cinterion
[7273]: <debug> [1666700574.694206] [ttyACM2] ID_VENDOR_ID: 0x1e2d
[7273]: <debug> [1666700574.694342] [ttyACM2] ID_MODEL_ID: 0x0061
[7273]: <debug> [1666700574.694477] [ttyACM2] ID_REVISION: 0x0232
[7273]: <debug> [1666700574.694673] [ttyACM2] property added: .MM_USBIFNUM=02
[7273]: <debug> [1666700574.694889] [ttyACM2] property added:
ID_MM_PORT_TYPE_AT_SECONDARY=1
[7273]: <debug> [1666700574.695844] [ttyACM2] property added: ID_MM_CANDIDATE=1
[7273]: <debug> [1666700574.696125] [base-manager] adding port ttyACM2 at sysfs
path:
/sys/devices/platform/soc/8af8800.usb3/8a00000.dwc3/xhci-hcd.0.auto/usb2/2-1/2-1:1.2/tty/ttyACM2
[7273]: <debug> [1666700574.696344] [filter] (tty/ttyACM2) port allowed: device
is whitelisted by plugin (vid)
[7273]: <debug> [1666700574.696495] [base-manager] port ttyACM2 is first in
device
/sys/devices/platform/soc/8af8800.usb3/8a00000.dwc3/xhci-hcd.0.auto/usb2/2-1
[7273]: <debug> [1666700574.697197] [plugin-manager] task 0: new support task
for device:
/sys/devices/platform/soc/8af8800.usb3/8a00000.dwc3/xhci-hcd.0.auto/usb2/2-1
[7273]: <debug> [1666700574.697801] [plugin-manager] task 0: port grabbed:
ttyACM2
[7273]: <debug> [1666700574.698008] [plugin-manager] task 0,ttyACM2: new
support task for port
[7273]: <debug> [1666700574.698146] [plugin-manager] task 0,ttyACM2: deferred
until min wait time elapsed
[7273]: <debug> [1666700574.752912] [base-manager] kernel event reported:
[7273]: <debug> [1666700574.753140] [base-manager] action: add
[7273]: <debug> [1666700574.753316] [base-manager] subsystem: net
[7273]: <debug> [1666700574.753473] [base-manager] name: wwan0
[7273]: <debug> [1666700574.753647] [base-manager] uid: n/a
[7273]: <debug> [1666700574.754032] [wwan0] preloading contents and
properties...
[7273]: <debug> [1666700574.754735] [wwan0] sysfs path:
/sys/devices/platform/soc/8af8800.usb3/8a00000.dwc3/xhci-hcd.0.auto/usb2/2-1/2-1:1.10/net/wwan0
[7273]: <debug> [1666700574.761098] [wwan0] port contents loaded:
[7273]: <debug> [1666700574.761322] [wwan0] bus: usb
[7273]: <debug> [1666700574.761499] [wwan0] interface:
/sys/devices/platform/soc/8af8800.usb3/8a00000.dwc3/xhci-hcd.0.auto/usb2/2-1/2-1:1.10
[7273]: <debug> [1666700574.761682] [wwan0] interface class: 02
[7273]: <debug> [1666700574.761841] [wwan0] interface subclass: 06
[7273]: <debug> [1666700574.761999] [wwan0] interface protocol: 00
[7273]: <debug> [1666700574.762159] [wwan0] interface number: 0a
[7273]: <debug> [1666700574.762307] [wwan0] interface description: CDC
Ethernet Control Model (ECM) for RmNet
[7273]: <debug> [1666700574.762490] [wwan0] device:
/sys/devices/platform/soc/8af8800.usb3/8a00000.dwc3/xhci-hcd.0.auto/usb2/2-1
[7273]: <debug> [1666700574.762670] [wwan0] subsystems: net, usb
[7273]: <debug> [1666700574.762844] [wwan0] drivers: cdc_ether, usb
[7273]: <debug> [1666700574.763008] [wwan0] vendor: 1e2d
[7273]: <debug> [1666700574.763170] [wwan0] product: 0061
[7273]: <debug> [1666700574.763328] [wwan0] revision: 0232
[7273]: <debug> [1666700574.763489] [wwan0] manufacturer: Cinterion
[7273]: <debug> [1666700574.763646] [wwan0] product: LTE Modem
[7273]: <debug> [1666700574.763802] [wwan0] ID_USB_INTERFACE_NUM: 0x0a
[7273]: <debug> [1666700574.764083] [wwan0] ID_MODEL: LTE Modem
[7273]: <debug> [1666700574.764267] [wwan0] ID_VENDOR: Cinterion
[7273]: <debug> [1666700574.764449] [wwan0] ID_VENDOR_ID: 0x1e2d
[7273]: <debug> [1666700574.764623] [wwan0] ID_MODEL_ID: 0x0061
[7273]: <debug> [1666700574.764797] [wwan0] ID_REVISION: 0x0232
[7273]: <debug> [1666700574.765211] [wwan0] property added: .MM_USBIFNUM=0a
[7273]: <debug> [1666700574.766279] [wwan0] property added: ID_MM_CANDIDATE=1
[7273]: <debug> [1666700574.766614] [base-manager] adding port wwan0 at sysfs
path:
/sys/devices/platform/soc/8af8800.usb3/8a00000.dwc3/xhci-hcd.0.auto/usb2/2-1/2-1:1.10/net/wwan0
[7273]: <debug> [1666700574.766904] [filter] (net/wwan0) port allowed: device
is whitelisted by plugin (vid)
[7273]: <debug> [1666700574.767110] [base-manager] additional port wwan0 in
device
/sys/devices/platform/soc/8af8800.usb3/8a00000.dwc3/xhci-hcd.0.auto/usb2/2-1
[7273]: <debug> [1666700574.767478] [plugin-manager] task 0: port grabbed: wwan0
[7273]: <debug> [1666700574.767755] [plugin-manager] task 0,wwan0: new support
task for port
[7273]: <debug> [1666700574.767945] [plugin-manager] task 0,wwan0: deferred
until min wait time elapsed
[7273]: <debug> [1666700576.200205] [plugin-manager] task 0: min wait time
elapsed
[7273]: <debug> [1666700576.202244] [plugin/zte] port wwan0 filtered by
vendor/product IDs
[7273]: <debug> [1666700576.204676] [plugin/x22x] port wwan0 filtered by
vendor/product IDs
[7273]: <debug> [1666700576.206819] [plugin/wavecom] port wwan0 filtered by
subsystem
[7273]: <debug> [1666700576.208785] [plugin/via] port wwan0 filtered by
subsystem
[7273]: <debug> [1666700576.210685] [plugin/u-blox] port wwan0 filtered by
vendor/product IDs
[7273]: <debug> [1666700576.212711] [plugin/tp-link] port wwan0 filtered by
vendor/product IDs
[7273]: <debug> [1666700576.214922] [plugin/thuraya] port wwan0 filtered by
subsystem
[7273]: <debug> [1666700576.216836] [plugin/telit] port wwan0 filtered by
vendor/product IDs
[7273]: <debug> [1666700576.217918] [plugin/simtech] port wwan0 filtered by
vendor/product IDs
[7273]: <debug> [1666700576.218080] [plugin/sierra] port wwan0 filtered by
drivers
[7273]: <debug> [1666700576.218242] [plugin/sierra-legacy] port wwan0 filtered
by drivers
[7273]: <debug> [1666700576.218401] [plugin/samsung] port wwan0 filtered by
vendor/product IDs
[7273]: <debug> [1666700576.218553] [plugin/quectel] port wwan0 filtered by
vendor/product IDs
[7273]: <debug> [1666700576.218709] [plugin/qcom-soc] port wwan0 filtered by
udev tags
[7273]: <debug> [1666700576.218869] [plugin/pantech] port wwan0 filtered by
vendor/product IDs
[7273]: <debug> [1666700576.219260] [plugin/option] port wwan0 filtered by
subsystem
[7273]: <debug> [1666700576.219431] [plugin/option-hso] port wwan0 filtered by
drivers
[7273]: <debug> [1666700576.219714] [plugin/novatel] port wwan0 filtered by
vendor/product IDs
[7273]: <debug> [1666700576.219886] [plugin/novatel-lte] port wwan0 filtered by
vendor/product IDs
[7273]: <debug> [1666700576.220077] [plugin/nokia] port wwan0 filtered by
subsystem
[7273]: <debug> [1666700576.220463] [plugin/nokia-icera] port wwan0 filtered by
vendor/product IDs
[7273]: <debug> [1666700576.220633] [plugin/mtk] port wwan0 filtered by
subsystem
[7273]: <debug> [1666700576.220793] [plugin/motorola] port wwan0 filtered by
subsystem
[7273]: <debug> [1666700576.220944] [plugin/longcheer] port wwan0 filtered by
subsystem
[7273]: <debug> [1666700576.221087] [plugin/linktop] port wwan0 filtered by
subsystem
[7273]: <debug> [1666700576.221238] [plugin/iridium] port wwan0 filtered by
subsystem
[7273]: <debug> [1666700576.221388] [plugin/huawei] port wwan0 filtered by
vendor/product IDs
[7273]: <debug> [1666700576.221547] [plugin/haier] port wwan0 filtered by
subsystem
[7273]: <debug> [1666700576.221709] [plugin/gosuncn] port wwan0 filtered by
drivers
[7273]: <debug> [1666700576.221873] [plugin/foxconn] port wwan0 filtered by
vendor/product IDs
[7273]: <debug> [1666700576.222026] [plugin/fibocom] port wwan0 filtered by
drivers
[7273]: <debug> [1666700576.222188] [plugin/ericsson-mbm] port wwan0 filtered
by udev tags
[7273]: <debug> [1666700576.222345] [plugin/d-link] port wwan0 filtered by
vendor/product IDs
[7273]: <debug> [1666700576.222503] [plugin/dell] port wwan0 filtered by
vendor/product IDs
[7273]: <debug> [1666700576.222668] [plugin/broadmobi] port wwan0 filtered by
vendor/product IDs
[7273]: <debug> [1666700576.222826] [plugin/anydata] port wwan0 filtered by
vendor/product IDs
[7273]: <debug> [1666700576.222983] [plugin/altair-lte] port wwan0 filtered by
vendor/product IDs
[7273]: <debug> [1666700576.223146] [plugin-manager] task 0,wwan0: found '2'
plugins to try
[7273]: <debug> [1666700576.223284] [plugin-manager] task 0,wwan0: will try
with plugin 'cinterion'
[7273]: <debug> [1666700576.223411] [plugin-manager] task 0,wwan0: will try
with plugin 'generic'
[7273]: <debug> [1666700576.223572] [plugin-manager] task 0,wwan0: started
[7273]: <debug> [1666700576.223703] [plugin-manager] task 0,wwan0: checking
with plugin 'cinterion'
[7273]: <debug> [1666700576.223919] [plugin/cinterion] probing of port wwan0
deferred until result suggested
[7273]: <debug> [1666700576.224165] [plugin/zte] port ttyACM2 filtered by
vendor/product IDs
[7273]: <debug> [1666700576.224321] [plugin/x22x] port ttyACM2 filtered by
vendor/product IDs
[7273]: <debug> [1666700576.224462] [plugin/wavecom] port ttyACM2 filtered by
vendor/product IDs
[7273]: <debug> [1666700576.224613] [plugin/tp-link] port ttyACM2 filtered by
vendor/product IDs
[7273]: <debug> [1666700576.224750] [plugin/thuraya] port ttyACM2 filtered by
vendor/product IDs
[7273]: <debug> [1666700576.224897] [plugin/simtech] port ttyACM2 filtered by
vendor/product IDs
[7273]: <debug> [1666700576.225028] [plugin/sierra] port ttyACM2 filtered by
drivers
[7273]: <debug> [1666700576.225162] [plugin/sierra-legacy] port ttyACM2
filtered by drivers
[7273]: <debug> [1666700576.225290] [plugin/samsung] port ttyACM2 filtered by
vendor/product IDs
[7273]: <debug> [1666700576.225430] [plugin/qcom-soc] port ttyACM2 filtered by
subsystem
[7273]: <debug> [1666700576.225566] [plugin/pantech] port ttyACM2 filtered by
vendor/product IDs
[7273]: <debug> [1666700576.225706] [plugin/option] port ttyACM2 filtered by
drivers
[7273]: <debug> [1666700576.225836] [plugin/option-hso] port ttyACM2 filtered
by drivers
[7273]: <debug> [1666700576.225967] [plugin/novatel] port ttyACM2 filtered by
vendor/product IDs
[7273]: <debug> [1666700576.226097] [plugin/novatel-lte] port ttyACM2 filtered
by vendor/product IDs
[7273]: <debug> [1666700576.226243] [plugin/nokia-icera] port ttyACM2 filtered
by vendor/product IDs
[7273]: <debug> [1666700576.226383] [plugin/mtk] port ttyACM2 filtered by udev
tags
[7273]: <debug> [1666700576.226519] [plugin/motorola] port ttyACM2 filtered by
vendor/product IDs
[7273]: <debug> [1666700576.226654] [plugin/longcheer] port ttyACM2 filtered by
vendor/product IDs
[7273]: <debug> [1666700576.226789] [plugin/linktop] port ttyACM2 filtered by
vendor/product IDs
[7273]: <debug> [1666700576.226933] [plugin/huawei] port ttyACM2 filtered by
vendor/product IDs
[7273]: <debug> [1666700576.227070] [plugin/haier] port ttyACM2 filtered by
vendor/product IDs
[7273]: <debug> [1666700576.227208] [plugin/gosuncn] port ttyACM2 filtered by
drivers
[7273]: <debug> [1666700576.227340] [plugin/foxconn] port ttyACM2 filtered by
vendor/product IDs
[7273]: <debug> [1666700576.227468] [plugin/fibocom] port ttyACM2 filtered by
drivers
[7273]: <debug> [1666700576.227604] [plugin/ericsson-mbm] port ttyACM2 filtered
by udev tags
[7273]: <debug> [1666700576.227738] [plugin/d-link] port ttyACM2 filtered by
vendor/product IDs
[7273]: <debug> [1666700576.227872] [plugin/dell] port ttyACM2 filtered by
vendor/product IDs
[7273]: <debug> [1666700576.228004] [plugin/broadmobi] port ttyACM2 filtered by
vendor/product IDs
[7273]: <debug> [1666700576.228140] [plugin/anydata] port ttyACM2 filtered by
vendor/product IDs
[7273]: <debug> [1666700576.228274] [plugin/altair-lte] port ttyACM2 filtered
by vendor/product IDs
[7273]: <debug> [1666700576.228412] [plugin-manager] task 0,ttyACM2: found '8'
plugins to try
[7273]: <debug> [1666700576.228552] [plugin-manager] task 0,ttyACM2: will try
with plugin 'cinterion'
[7273]: <debug> [1666700576.228680] [plugin-manager] task 0,ttyACM2: will try
with plugin 'via'
[7273]: <debug> [1666700576.228925] [plugin-manager] task 0,ttyACM2: will try
with plugin 'u-blox'
[7273]: <debug> [1666700576.229060] [plugin-manager] task 0,ttyACM2: will try
with plugin 'telit'
[7273]: <debug> [1666700576.229299] [plugin-manager] task 0,ttyACM2: will try
with plugin 'quectel'
[7273]: <debug> [1666700576.229426] [plugin-manager] task 0,ttyACM2: will try
with plugin 'nokia'
[7273]: <debug> [1666700576.229548] [plugin-manager] task 0,ttyACM2: will try
with plugin 'iridium'
[7273]: <debug> [1666700576.229679] [plugin-manager] task 0,ttyACM2: will try
with plugin 'generic'
[7273]: <debug> [1666700576.229858] [plugin-manager] task 0,ttyACM2: started
[7273]: <debug> [1666700576.229993] [plugin-manager] task 0,ttyACM2: checking
with plugin 'cinterion'
[7273]: <debug> [1666700576.230182] [plugin/cinterion] probes required for port
ttyACM2: 'at'
[7273]: <debug> [1666700576.230352] [ttyACM2/probe] no QCDM/QMI/MBIM probing in
possible AT port
[7273]: <debug> [1666700576.230504] [ttyACM2/probe] port is not QCDM-capable
[7273]: <debug> [1666700576.230622] [ttyACM2/probe] port is not QMI-capable
[7273]: <debug> [1666700576.230735] [ttyACM2/probe] port is not MBIM-capable
[7273]: <debug> [1666700576.230857] [ttyACM2/probe] launching port probing: 'at'
[7273]: <debug> [1666700576.231126] [plugin-manager] task 0,wwan0: deferring
support check until result suggested
[7273]: <debug> [1666700576.232821] [ttyACM2/at] opening serial port...
[7273]: <debug> [1666700576.233777] [ttyACM2/at] setting up baudrate: 57600
[7273]: <debug> [1666700576.234013] [ttyACM2/at] no flow control explicitly
requested for device
[7273]: <debug> [1666700576.234299] [ttyACM2/at] device open count is 1 (open)
[7273]: <debug> [1666700576.234821] [ttyACM2/at] --> 'AT^SQPORT?<CR>'
[7273]: <debug> [1666700577.198353] [plugin-manager] task 0: min probing time
elapsed
[7273]: <debug> [1666700577.201116] [plugin-manager] task 0: still 2 running
probes (1 active): wwan0, ttyACM2
[7273]: <debug> [1666700577.256819] [ttyACM2/at] <-- '<CR><LF>^SQPORT:
Application<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700577.260129] [ttyACM2/probe] port is AT-capable
[7273]: <debug> [1666700577.262711] [plugin-manager] task 0,ttyACM2: found best
plugin for port (cinterion)
[7273]: <debug> [1666700577.265187] [plugin-manager] task 0,ttyACM2: finished
in '2.567171' seconds
[7273]: <debug> [1666700577.265485] [plugin-manager] task 0,ttyACM2: found best
plugin: cinterion
[7273]: <debug> [1666700577.265727] [plugin-manager] task 0,wwan0: deferred
task completed, got suggested plugin (cinterion)
[7273]: <debug> [1666700577.266016] [plugin-manager] task 0: still 1 running
probes (1 active): wwan0
[7273]: <debug> [1666700577.266403] [ttyACM2/at] device open count is 0 (close)
[7273]: <debug> [1666700577.266657] [ttyACM2/at] closing serial port...
[7273]: <debug> [1666700577.268964] [ttyACM2/at] serial port closed
[7273]: <debug> [1666700577.269398] [ttyACM2/at] forced to close port
[7273]: <debug> [1666700577.269750] [plugin-manager] task 0,wwan0: checking
with plugin 'cinterion'
[7273]: <debug> [1666700577.270073] [plugin/cinterion] probing of port wwan0
deferred until result suggested
[7273]: <debug> [1666700577.270430] [plugin-manager] task 0,wwan0: completed,
got suggested plugin (cinterion)
[7273]: <debug> [1666700577.270682] [plugin-manager] task 0,wwan0: finished in
'2.502938' seconds
[7273]: <debug> [1666700577.270947] [plugin-manager] task 0,wwan0: best plugin
matches device reported one: cinterion
[7273]: <debug> [1666700577.271195] [plugin-manager] task 0: no more ports to
probe
[7273]: <debug> [1666700577.271430] [plugin-manager] task 0: all port probings
completed, but not reached extra probing time yet
[7273]: <debug> [1666700577.768461] [plugin-manager] task 0: extra probing time
elapsed
[7273]: <debug> [1666700577.769063] [plugin-manager] task 0: no more ports to
probe
[7273]: <debug> [1666700577.769613] [plugin-manager] task 0: finished in
'3.072394' seconds
[7273]: <info> [1666700577.770397] [device
/sys/devices/platform/soc/8af8800.usb3/8a00000.dwc3/xhci-hcd.0.auto/usb2/2-1]
creating modem with plugin 'cinterion' and '2' ports
[7273]: <debug> [1666700577.803253] [modem0] port 'net/wwan0' grabbed
[7273]: <debug> [1666700577.803918] [plugin/cinterion] (cinterion) port
'tty/ttyACM2' flagged as primary
[7273]: <debug> [1666700577.804735] [modem0] port 'tty/ttyACM2' grabbed
[7273]: <debug> [1666700577.804979] [modem0] tty/ttyACM2 at (primary)
[7273]: <debug> [1666700577.805160] [modem0] tty/ttyACM2 at (data primary)
[7273]: <debug> [1666700577.805330] [modem0] net/wwan0 net (data)
[7273]: <debug> [1666700577.807568] [modem0/ttyACM2/at] opening serial port...
[7273]: <debug> [1666700577.808586] [modem0/ttyACM2/at] setting up baudrate:
57600
[7273]: <debug> [1666700577.808807] [modem0/ttyACM2/at] no flow control
explicitly requested for device
[7273]: <debug> [1666700577.809124] [modem0/ttyACM2/at] device open count is 1
(open)
[7273]: <debug> [1666700577.809325] [modem0/ttyACM2/at] running init sequence...
[7273]: <info> [1666700577.809665] [base-manager] modem for device
'/sys/devices/platform/soc/8af8800.usb3/8a00000.dwc3/xhci-hcd.0.auto/usb2/2-1'
successfully created
[7273]: <debug> [1666700577.813764] [modem0] loading current capabilities...
[7273]: <debug> [1666700577.814243] [modem0/ttyACM2/at] device open count is 2
(open)
[7273]: <debug> [1666700577.814675] [modem0/ttyACM2/at] --> 'ATE0<CR>'
[7273]: <debug> [1666700577.829465] [modem0/ttyACM2/at] <-- '<CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700577.830124] [modem0/ttyACM2/at] --> 'ATV1<CR>'
[7273]: <debug> [1666700577.845909] [modem0/ttyACM2/at] <-- '<CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700577.846564] [modem0/ttyACM2/at] --> 'AT+CMEE=1<CR>'
[7273]: <debug> [1666700577.868269] [modem0/ttyACM2/at] <-- '<CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700577.869645] [modem0/ttyACM2/at] --> 'ATX4<CR>'
[7273]: <debug> [1666700577.884784] [modem0/ttyACM2/at] <-- '<CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700577.886139] [modem0/ttyACM2/at] --> 'AT&C1<CR>'
[7273]: <debug> [1666700577.902969] [modem0/ttyACM2/at] <-- '<CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700577.904449] [modem0/ttyACM2/at] --> 'AT+GCAP<CR>'
[7273]: <debug> [1666700577.924814] [modem0/ttyACM2/at] <-- '<CR><LF>+GCAP:
+CGSM<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700577.926284] [modem0/ttyACM2/at] device open count is 3
(open)
[7273]: <debug> [1666700577.927123] [modem0/ttyACM2/at] device open count is 2
(close)
[7273]: <debug> [1666700577.927961] [modem0/ttyACM2/at] --> 'AT+WS46=?<CR>'
[7273]: <debug> [1666700577.947221] [modem0/ttyACM2/at] <-- '<CR><LF>+WS46:
(12,22,25,28,29)<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700577.949010] [modem0] setting EPS network as supported
[7273]: <debug> [1666700577.949686] [modem0] setting CDMA1x/EVDO networks as
unsupported
[7273]: <debug> [1666700577.950957] [modem0/ttyACM2/at] device open count is 3
(open)
[7273]: <debug> [1666700577.951830] [modem0/ttyACM2/at] device open count is 2
(close)
[7273]: <debug> [1666700577.952677] [modem0/ttyACM2/at] --> 'AT+CSCS=?<CR>'
[7273]: <debug> [1666700577.974872] [modem0/ttyACM2/at] <-- '<CR><LF>+CSCS:
("IRA","GSM","UCS2")<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700577.976883] [modem0/ttyACM2/at] device open count is 3
(open)
[7273]: <debug> [1666700577.977761] [modem0/ttyACM2/at] device open count is 2
(close)
[7273]: <debug> [1666700577.978607] [modem0/ttyACM2/at] --> 'AT+CSCS="UCS2"<CR>'
[7273]: <debug> [1666700578.008206] [modem0/ttyACM2/at] <-- '<CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700578.009479] [modem0/ttyACM2/at] device open count is 3
(open)
[7273]: <debug> [1666700578.010317] [modem0/ttyACM2/at] device open count is 2
(close)
[7273]: <debug> [1666700578.011151] [modem0/ttyACM2/at] --> 'AT+CSCS?<CR>'
[7273]: <debug> [1666700578.032276] [modem0/ttyACM2/at] <-- '<CR><LF>+CSCS:
"UCS2"<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700578.033680] [modem0] allowed up to 2 active bearers
[7273]: <debug> [1666700578.035198] [modem0] loading manufacturer...
[7273]: <debug> [1666700578.035856] [modem0/ttyACM2/at] device open count is 3
(open)
[7273]: <debug> [1666700578.036728] [modem0/ttyACM2/at] device open count is 2
(close)
[7273]: <debug> [1666700578.037569] [modem0/ttyACM2/at] --> 'AT+CGMI<CR>'
[7273]: <debug> [1666700578.056519] [modem0/ttyACM2/at] <--
'<CR><LF>Cinterion<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700578.057829] [modem0] loaded manufacturer: Cinterion
[7273]: <debug> [1666700578.058634] [modem0] loading model...
[7273]: <debug> [1666700578.059298] [modem0/ttyACM2/at] device open count is 3
(open)
[7273]: <debug> [1666700578.060087] [modem0/ttyACM2/at] device open count is 2
(close)
[7273]: <debug> [1666700578.060916] [modem0/ttyACM2/at] --> 'AT+CGMM<CR>'
[7273]: <debug> [1666700578.079494] [modem0/ttyACM2/at] <--
'<CR><LF>PLAS9-W<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700578.080820] [modem0] loaded model: PLAS9-W
[7273]: <debug> [1666700578.081617] [modem0] loading revision...
[7273]: <debug> [1666700578.082268] [modem0/ttyACM2/at] device open count is 3
(open)
[7273]: <debug> [1666700578.083049] [modem0/ttyACM2/at] device open count is 2
(close)
[7273]: <debug> [1666700578.083979] [modem0/ttyACM2/at] --> 'AT+CGMR<CR>'
[7273]: <debug> [1666700578.103770] [modem0/ttyACM2/at] <-- '<CR><LF>REVISION
01.004<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700578.105210] [modem0] loaded revision: REVISION 01.004
[7273]: <debug> [1666700578.106030] [modem0] loading equipment identifier...
[7273]: <debug> [1666700578.106709] [modem0/ttyACM2/at] device open count is 3
(open)
[7273]: <debug> [1666700578.107577] [modem0/ttyACM2/at] device open count is 2
(close)
[7273]: <debug> [1666700578.108300] [modem0/ttyACM2/at] --> 'AT+CGSN<CR>'
[7273]: <debug> [1666700578.125563] [modem0/ttyACM2/at] <--
'<CR><LF>357176090983831<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700578.126831] [modem0] loaded equipment identifier:
357176090983831
[7273]: <debug> [1666700578.127531] [modem0] loading device identifier...
[7273]: <debug> [1666700578.128086] [modem0/ttyACM2/at] device open count is 3
(open)
[7273]: <debug> [1666700578.128778] [modem0/ttyACM2/at] device open count is 2
(close)
[7273]: <debug> [1666700578.129513] [modem0/ttyACM2/at] --> 'ATI<CR>'
[7273]: <debug> [1666700578.139786] [modem0/ttyACM2/at] <--
'<CR><LF>Cinterion<CR><LF>PLAS9-W<CR><LF>REVISION
01.004<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700578.141589] [modem0] device identifier built:
00001e2d00000061CinterionPLAS9-WREVISION01.004357176090983831REVISION01.004PLAS9-WCinterion
-> 0c0a44f8812505a27a6ede95dee0d447ac9fb067
[7273]: <debug> [1666700578.142139] [modem0] loaded device identifier:
0c0a44f8812505a27a6ede95dee0d447ac9fb067
[7273]: <debug> [1666700578.142922] [modem0] loading supported modes...
[7273]: <debug> [1666700578.143599] [modem0/ttyACM2/at] device open count is 3
(open)
[7273]: <debug> [1666700578.144407] [modem0/ttyACM2/at] device open count is 2
(close)
[7273]: <debug> [1666700578.144782] [modem0/ttyACM2/at] --> 'AT*CNTI=2<CR>'
[7273]: <debug> [1666700578.163605] [modem0/ttyACM2/at] <-- '<CR><LF>*CNTI: 2,
GSM, GPRS, EDGE, UMTS, HSDPA, HSUPA<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700578.164238] [modem0] device allows (3GPP) 2G networks
[7273]: <debug> [1666700578.164443] [modem0] device allows (3GPP) 3G networks
[7273]: <debug> [1666700578.164692] [modem0/ttyACM2/at] device open count is 3
(open)
[7273]: <debug> [1666700578.165163] [modem0/ttyACM2/at] device open count is 2
(close)
[7273]: <debug> [1666700578.166471] [modem0] device allows (3GPP) mode
combination: 2g
[7273]: <debug> [1666700578.166949] [modem0] device allows (3GPP) mode
combination: 3g
[7273]: <debug> [1666700578.167367] [modem0] device allows (3GPP) mode
combination: 4g
[7273]: <debug> [1666700578.167855] [modem0] device allows (3GPP) mode
combination: 2g, 3g
[7273]: <debug> [1666700578.168363] [modem0] device allows (3GPP) mode
combination: 2g, 3g, 4g
[7273]: <debug> [1666700578.168972] [modem0] filtering 4 supported mode
combinations with 1 modes
[7273]: <debug> [1666700578.169441] [modem0] device supports 4 different mode
combinations
[7273]: <debug> [1666700578.170516] [modem0] (cinterion) Using cinterion
default modem family
[7273]: <debug> [1666700578.171183] [modem0/ttyACM2/at] device open count is 3
(open)
[7273]: <debug> [1666700578.172091] [modem0/ttyACM2/at] device open count is 2
(close)
[7273]: <debug> [1666700578.172913] [modem0/ttyACM2/at] --> 'AT^SCFG=?<CR>'
[7273]: <debug> [1666700578.197188] [modem0/ttyACM2/at] <-- '<CR><LF>^SCFG:
"GPRS/Auth",("0","1","2")<CR><LF>^SCFG:
"GPRS/AutoAttach",("disabled","enabled")<CR><LF>^SCFG:
"MEopMode/CFUN",("0","1")<CR><LF>^SCFG:
"MEopMode/CregRoam",("0","1")<CR><LF>^SCFG:
"MEopMode/DTM/Mode",("0","1","2")<CR><LF>^SCFG:
"MEopMode/ExpectDTR",("current","powerup"),("acm1","acm2","acm3","acm4","rmnet0","rmnet1")<CR><LF>^SCFG:
"MEopMode/FGI/Split",("0","1")<CR><LF>^SCFG:
"MEopMode/IMS",("0","1")<CR><LF>^SCFG:
"MEopMode/NonBlock/Cops",("0","1")<CR><LF>^SCFG:
"MEopMode/PowerMgmt/LCI",("disabled","enabled"),("GPIO1","GPIO2","GPIO3","GPIO4","GPIO5","GPIO6","GPIO7","GPIO8","GPIO9","GPIO10")<CR><LF>^SCFG:
"MEopMode/Prov/AutoSelect",("on","off")<CR><LF>^SCFG:
"MEopMode/Prov/Cfg",("fallbdceu*","cmcgdccn")<CR><LF>^SCFG:
"MEopMode/PwrSave",("disabled","enabled"),("0-36000"),("0-36000"),("CPU-A","CPU-M"),("powerup","current")<CR><LF>^SCFG:
"MEopMode/SRPOM",("0","1","99")<CR><LF>^SCFG:
"MEopMode/USB/KeepData",("current","p
[7273]: <debug> [1666700578.199848] [modem0/ttyACM2/at] <--
'et1")<CR><LF>^SCFG: "RemoteWakeUp/Pulse",("1"-"100")<CR><LF>^SCFG:
"SIM/CS",("NO_SIM","SIM_1","SIM_2")<CR><LF>^SCFG:
"SMS/AutoAck",("0","1")<CR><LF>^SCFG: "SMS/Retrm",(1-45)<CR><LF>^SCFG:
"Trace/SIM",("none","raw","decoded")<CR><LF>^SCFG:
"URC/DstIfc",("mdm","app")<CR><LF>^SCFG:
"URC/Ringline",("off","local","asc0")<CR><LF>^SCFG:
"URC/Ringline/ActiveTime",("2","on","off")<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700578.202903] [modem0] loading supported IP families...
[7273]: <debug> [1666700578.203299] [modem0/ttyACM2/at] device open count is 3
(open)
[7273]: <debug> [1666700578.203719] [modem0/ttyACM2/at] device open count is 2
(close)
[7273]: <debug> [1666700578.204194] [modem0/ttyACM2/at] --> 'AT+CGDCONT=?<CR>'
[7273]: <debug> [1666700578.235179] [modem0/ttyACM2/at] <-- '<CR><LF>+CGDCONT:
(1-16),"IP",,,(0-2),(0-4),(0),(0,1),(0-2),(0,1)<CR><LF>+CGDCONT:
(1-16),"PPP",,,(0-2),(0-4),(0),(0,1),(0-2),(0,1)<CR><LF>+CGDCONT:
(1-16),"IPV6",,,(0-2),(0-4),(0),(0,1),(0-2),(0,1)<CR><LF>+CGDCONT:
(1-16),"IPV4V6",,,(0-2),(0-4),(0),(0,1),(0-2),(0,1)<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700578.237587] [modem0] unhandled PDP type in CGDCONT=?
reply: 'PPP'
[7273]: <debug> [1666700578.238823] [modem0] loading power state...
[7273]: <debug> [1666700578.239500] [modem0/ttyACM2/at] device open count is 3
(open)
[7273]: <debug> [1666700578.240365] [modem0/ttyACM2/at] device open count is 2
(close)
[7273]: <debug> [1666700578.241234] [modem0/ttyACM2/at] --> 'AT+CFUN?<CR>'
[7273]: <debug> [1666700578.259106] [modem0/ttyACM2/at] <-- '<CR><LF>+CFUN:
1<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700578.260964] [modem0] (cinterion) Enabling SCKS URCs for
SIM hot swap detection
[7273]: <debug> [1666700578.261760] [modem0/ttyACM2/at] device open count is 3
(open)
[7273]: <debug> [1666700578.262645] [modem0/ttyACM2/at] device open count is 2
(close)
[7273]: <debug> [1666700578.263510] [modem0/ttyACM2/at] --> 'AT^SCKS=1<CR>'
[7273]: <debug> [1666700578.285454] [modem0/ttyACM2/at] <-- '<CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700578.286644] [modem0] (cinterion) SIM hot swap detect
successfully enabled
[7273]: <debug> [1666700578.287307] [modem0] SIM hot swap setup succeeded
[7273]: <debug> [1666700578.288183] [modem0] checking if unlock required...
[7273]: <debug> [1666700578.288847] [modem0/ttyACM2/at] device open count is 3
(open)
[7273]: <debug> [1666700578.289713] [modem0/ttyACM2/at] device open count is 2
(close)
[7273]: <debug> [1666700578.290550] [modem0/ttyACM2/at] --> 'AT+CPIN?<CR>'
[7273]: <debug> [1666700578.309058] [modem0/ttyACM2/at] <-- '<CR><LF>+CPIN:
READY<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700578.310506] [modem0] SIM is ready, running after SIM
unlock step...
[7273]: <debug> [1666700578.311287] [modem0/ttyACM2/at] device open count is 3
(open)
[7273]: <debug> [1666700578.312206] [modem0/ttyACM2/at] device open count is 2
(close)
[7273]: <debug> [1666700578.313054] [modem0/ttyACM2/at] --> 'AT^SIND=?<CR>'
[7273]: <debug> [1666700578.333657] [modem0/ttyACM2/at] <-- '<CR><LF>^SIND:
((signal,(99)),(service,(0-1)),(message,(0-1)),(roam,(0-1)),(smsfull,(0-1)),(simstatus,(0,1,3-5)),(simdata),(eons,(0-6)),(nitz,(17)),(sendsms,(0-1)),(psinfo,(0-10,16,17)),(simlocal,(0-1)),(lsta,(0-2)),(pacsp,(0-1,99)),(steerroam),(pagingcoor,(0-2,4,8,16,99)),(ceer,(0-8,99)),(iccid,(20)),(euiccid,(16)),(imsi,(15)),(ltebot,(0-1)),(prov,(63)),(simread,(0-7,255))),(0-2)<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700578.335996] [modem0] (cinterion) psinfo support? yes
[7273]: <debug> [1666700578.336854] [modem0] (cinterion) simstatus support? yes
[7273]: <debug> [1666700578.337574] [modem0/ttyACM2/at] device open count is 3
(open)
[7273]: <debug> [1666700578.338383] [modem0/ttyACM2/at] device open count is 2
(close)
[7273]: <debug> [1666700578.339236] [modem0/ttyACM2/at] -->
'AT^SIND="simstatus",2<CR>'
[7273]: <debug> [1666700578.376063] [modem0/ttyACM2/at] <-- '<CR><LF>^SIND:
simstatus,0,5<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700578.378470] [modem0/ttyACM2/at] device open count is 3
(open)
[7273]: <debug> [1666700578.379414] [modem0/ttyACM2/at] device open count is 2
(close)
[7273]: <debug> [1666700578.380283] [modem0/ttyACM2/at] --> 'AT^SPIC="SC"<CR>'
[7273]: <debug> [1666700578.405264] [modem0/ttyACM2/at] <-- '<CR><LF>^SPIC:
3<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700578.407110] [modem0/ttyACM2/at] device open count is 3
(open)
[7273]: <debug> [1666700578.408346] [modem0/ttyACM2/at] device open count is 2
(close)
[7273]: <debug> [1666700578.409587] [modem0/ttyACM2/at] --> 'AT^SPIC="SC",1<CR>'
[7273]: <debug> [1666700578.437800] [modem0/ttyACM2/at] <-- '<CR><LF>^SPIC:
10<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700578.439606] [modem0/ttyACM2/at] device open count is 3
(open)
[7273]: <debug> [1666700578.440814] [modem0/ttyACM2/at] device open count is 2
(close)
[7273]: <debug> [1666700578.442067] [modem0/ttyACM2/at] --> 'AT^SPIC="P2"<CR>'
[7273]: <debug> [1666700578.470479] [modem0/ttyACM2/at] <-- '<CR><LF>^SPIC:
3<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700578.472296] [modem0/ttyACM2/at] device open count is 3
(open)
[7273]: <debug> [1666700578.473539] [modem0/ttyACM2/at] device open count is 2
(close)
[7273]: <debug> [1666700578.474905] [modem0/ttyACM2/at] --> 'AT^SPIC="P2",1<CR>'
[7273]: <debug> [1666700578.502760] [modem0/ttyACM2/at] <-- '<CR><LF>^SPIC:
10<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700578.504277] [modem0/ttyACM2/at] device open count is 3
(open)
[7273]: <debug> [1666700578.505154] [modem0/ttyACM2/at] device open count is 2
(close)
[7273]: <debug> [1666700578.506014] [modem0/ttyACM2/at] --> 'AT^SPIC="PS"<CR>'
[7273]: <debug> [1666700578.539265] [modem0/ttyACM2/at] <-- '<CR><LF>^SPIC:
0<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700578.540659] [modem0/ttyACM2/at] device open count is 3
(open)
[7273]: <debug> [1666700578.541516] [modem0/ttyACM2/at] device open count is 2
(close)
[7273]: <debug> [1666700578.542358] [modem0/ttyACM2/at] --> 'AT^SPIC="PS",1<CR>'
[7273]: <debug> [1666700578.579419] [modem0/ttyACM2/at] <-- '<CR><LF>^SPIC:
0<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700578.585104] [modem0/ttyACM2/at] device open count is 3
(open)
[7273]: <debug> [1666700578.588202] [modem0/ttyACM2/at] device open count is 2
(close)
[7273]: <debug> [1666700578.591419] [modem0/ttyACM2/at] --> 'AT^SPIC="PN"<CR>'
[7273]: <debug> [1666700578.629686] [modem0/ttyACM2/at] <-- '<CR><LF>^SPIC:
0<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700578.635388] [modem0/ttyACM2/at] device open count is 3
(open)
[7273]: <debug> [1666700578.638562] [modem0/ttyACM2/at] device open count is 2
(close)
[7273]: <debug> [1666700578.641364] [modem0/ttyACM2/at] --> 'AT^SPIC="PN",1<CR>'
[7273]: <debug> [1666700578.679151] [modem0/ttyACM2/at] <-- '<CR><LF>^SPIC:
0<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700578.702372] [modem0/sim0] loading SIM identifier...
[7273]: <debug> [1666700578.704880] [modem0/ttyACM2/at] device open count is 3
(open)
[7273]: <debug> [1666700578.705200] [modem0/ttyACM2/at] device open count is 2
(close)
[7273]: <debug> [1666700578.705476] [modem0/ttyACM2/at] -->
'AT+CRSM=176,12258,0,0,10<CR>'
[7273]: <debug> [1666700578.771309] [modem0/ttyACM2/at] <-- '<CR><LF>+CRSM:
144,0,"98740000814021362191"<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700578.776642] [modem0/sim0] loaded SIM identifier:
89470000180412631219
[7273]: <debug> [1666700578.777360] [modem0/sim0] loading IMSI...
[7273]: <debug> [1666700578.777940] [modem0/ttyACM2/at] device open count is 3
(open)
[7273]: <debug> [1666700578.778678] [modem0/ttyACM2/at] device open count is 2
(close)
[7273]: <debug> [1666700578.779399] [modem0/ttyACM2/at] --> 'AT+CIMI<CR>'
[7273]: <debug> [1666700578.799145] [modem0/ttyACM2/at] <--
'<CR><LF>242013082365094<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700578.800334] [modem0/sim0] loaded IMSI: 242013082365094
[7273]: <debug> [1666700578.801014] [modem0/sim0] loading operator ID...
[7273]: <debug> [1666700578.801597] [modem0/ttyACM2/at] device open count is 3
(open)
[7273]: <debug> [1666700578.802328] [modem0/ttyACM2/at] device open count is 2
(close)
[7273]: <debug> [1666700578.803051] [modem0/ttyACM2/at] -->
'AT+CRSM=176,28589,0,0,4<CR>'
[7273]: <debug> [1666700578.875019] [modem0/ttyACM2/at] <-- '<CR><LF>+CRSM:
144,0,"00000002"<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700578.876954] [modem0/sim0] loading operator name...
[7273]: <debug> [1666700578.877569] [modem0/ttyACM2/at] device open count is 3
(open)
[7273]: <debug> [1666700578.878297] [modem0/ttyACM2/at] device open count is 2
(close)
[7273]: <debug> [1666700578.879027] [modem0/ttyACM2/at] -->
'AT+CRSM=176,28486,0,0,17<CR>'
[7273]: <debug> [1666700578.951395] [modem0/ttyACM2/at] <-- '<CR><LF>+CRSM:
144,0,"0054656C656E6F72FFFFFFFFFFFFFFFFFF"<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700578.959338] [modem0/sim0] loading emergency numbers...
[7273]: <debug> [1666700578.961653] [modem0/ttyACM2/at] device open count is 3
(open)
[7273]: <debug> [1666700578.965240] [modem0/ttyACM2/at] device open count is 2
(close)
[7273]: <debug> [1666700578.965618] [modem0/ttyACM2/at] -->
'AT+CRSM=176,28599,0,0,15<CR>'
[7273]: <debug> [1666700579.034053] [modem0/ttyACM2/at] <-- '<CR><LF>+CRSM:
105,129,""<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <warn> [1666700579.035740] [modem0/sim0] couldn't load list of
emergency numbers: Failed to parse CRSM query result '+CRSM: 105,129,""'
[7273]: <debug> [1666700579.036372] [modem0/sim0] selecting user-defined
preferred network list...
[7273]: <debug> [1666700579.036905] [modem0/ttyACM2/at] device open count is 3
(open)
[7273]: <debug> [1666700579.037600] [modem0/ttyACM2/at] device open count is 2
(close)
[7273]: <debug> [1666700579.038306] [modem0/ttyACM2/at] --> 'AT+CPLS=0<CR>'
[7273]: <debug> [1666700579.057874] [modem0/ttyACM2/at] <-- '<CR><LF>+CME
ERROR: 111<CR><LF>'
[7273]: <debug> [1666700579.058965] [modem0/ttyACM2/at] operation failure: 111
(PLMN not allowed)
[7273]: <debug> [1666700579.059577] [modem0/sim0] selecting user-defined
preferred network list failed: 'PLMN not allowed'
[7273]: <debug> [1666700579.060043] [modem0/sim0] setting preferred networks
format...
[7273]: <debug> [1666700579.060573] [modem0/ttyACM2/at] device open count is 3
(open)
[7273]: <debug> [1666700579.061235] [modem0/ttyACM2/at] device open count is 2
(close)
[7273]: <debug> [1666700579.061948] [modem0/ttyACM2/at] --> 'AT+CPOL=,2<CR>'
[7273]: <debug> [1666700579.084232] [modem0/ttyACM2/at] <-- '<CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700579.085282] [modem0/sim0] loading preferred networks...
[7273]: <debug> [1666700579.085837] [modem0/ttyACM2/at] device open count is 3
(open)
[7273]: <debug> [1666700579.086511] [modem0/ttyACM2/at] device open count is 2
(close)
[7273]: <debug> [1666700579.087223] [modem0/ttyACM2/at] --> 'AT+CPOL?<CR>'
[7273]: <debug> [1666700579.110840] [modem0/ttyACM2/at] <-- '<CR><LF>+CPOL:
1,2,"24201",1,0,1,1<CR><LF><CR><LF><CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700579.113200] [modem0/sim0] loaded 1 preferred networks
[7273]: <debug> [1666700579.115063] [modem0] loading own numbers...
[7273]: <debug> [1666700579.115635] [modem0/ttyACM2/at] device open count is 3
(open)
[7273]: <debug> [1666700579.116407] [modem0/ttyACM2/at] device open count is 2
(close)
[7273]: <debug> [1666700579.117146] [modem0/ttyACM2/at] --> 'AT+CNUM<CR>'
[7273]: <debug> [1666700579.136483] [modem0/ttyACM2/at] <-- '<CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700579.137915] [modem0/ttyACM2/at] device open count is 3
(open)
[7273]: <debug> [1666700579.138684] [modem0/ttyACM2/at] device open count is 2
(close)
[7273]: <debug> [1666700579.139408] [modem0/ttyACM2/at] --> 'AT^SCFG?<CR>'
[7273]: <debug> [1666700579.166145] [modem0/ttyACM2/at] <-- '<CR><LF>^SCFG:
"GPRS/Auth","2"<CR><LF>^SCFG: "GPRS/AutoAttach","enabled"<CR><LF>^SCFG:
"MEopMode/CFUN","1","1"<CR><LF>^SCFG: "MEopMode/CregRoam","0"<CR><LF>^SCFG:
"MEopMode/DTM/Mode","0"<CR><LF>^SCFG:
"MEopMode/ExpectDTR","current","acm1","acm2","acm3","acm4","rmnet0","rmnet1"<CR><LF>^SCFG:
"MEopMode/ExpectDTR","powerup","acm1","acm2","acm3","acm4","rmnet0","rmnet1"<CR><LF>^SCFG:
"MEopMode/FGI/Split","1"<CR><LF>^SCFG: "MEopMode/IMS","0"<CR><LF>^SCFG:
"MEopMode/NonBlock/Cops","0"<CR><LF>^SCFG:
"MEopMode/PowerMgmt/LCI","disabled"<CR><LF>^SCFG:
"MEopMode/Prov/AutoSelect","on"<CR><LF>^SCFG:
"MEopMode/Prov/Cfg","cmcgdccn"<CR><LF>^SCFG:
"MEopMode/PwrSave","enabled","0","0","CPU-A","powerup"<CR><LF>^SCFG:
"MEopMode/PwrSave","enabled","0","0","CPU-A","current"<CR><LF>^SCFG:
"MEopMode/PwrSave","enabled","0","0","CPU-M","powerup"<CR><LF>^SCFG:
"MEopMode/PwrSave","enabled","0","0","CPU-M","current"<CR><LF>^SCFG:
"MEopMode/SRPOM","0"<CR><LF
[7273]: <debug> [1666700579.178747] [modem0] loading enabled facility locks...
[7273]: <debug> [1666700579.179343] [modem0/ttyACM2/at] device open count is 3
(open)
[7273]: <debug> [1666700579.180125] [modem0/ttyACM2/at] device open count is 2
(close)
[7273]: <debug> [1666700579.181050] [modem0/ttyACM2/at] --> 'AT+CLCK=?<CR>'
[7273]: <debug> [1666700579.201092] [modem0/ttyACM2/at] <-- '<CR><LF>+CLCK:
("AB","AC","AG","AI","AO","IR","OI","OX","SC","FD","PS","PN")<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700579.201991] [modem0/ttyACM2/at] device open count is 3
(open)
[7273]: <debug> [1666700579.202275] [modem0/ttyACM2/at] device open count is 2
(close)
[7273]: <debug> [1666700579.202554] [modem0/ttyACM2/at] --> 'AT+CLCK="SC",2<CR>'
[7273]: <debug> [1666700579.231106] [modem0/ttyACM2/at] <-- '<CR><LF>+CLCK:
0<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700579.232728] [modem0/ttyACM2/at] device open count is 3
(open)
[7273]: <debug> [1666700579.233426] [modem0/ttyACM2/at] device open count is 2
(close)
[7273]: <debug> [1666700579.234278] [modem0/ttyACM2/at] --> 'AT+CLCK="FD",2<CR>'
[7273]: <debug> [1666700579.258765] [modem0/ttyACM2/at] <-- '<CR><LF>+CLCK:
0<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700579.260386] [modem0/ttyACM2/at] device open count is 3
(open)
[7273]: <debug> [1666700579.261093] [modem0/ttyACM2/at] device open count is 2
(close)
[7273]: <debug> [1666700579.261829] [modem0/ttyACM2/at] --> 'AT+CLCK="PS",2<CR>'
[7273]: <debug> [1666700579.301368] [modem0/ttyACM2/at] <-- '<CR><LF>+CLCK:
0<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700579.307920] [modem0/ttyACM2/at] device open count is 3
(open)
[7273]: <debug> [1666700579.310549] [modem0/ttyACM2/at] device open count is 2
(close)
[7273]: <debug> [1666700579.315670] [modem0/ttyACM2/at] --> 'AT+CLCK="PN",2<CR>'
[7273]: <debug> [1666700579.349297] [modem0/ttyACM2/at] <-- '<CR><LF>+CLCK:
0<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700579.356419] [modem0] loading IMEI...
[7273]: <debug> [1666700579.358566] [modem0/ttyACM2/at] device open count is 3
(open)
[7273]: <debug> [1666700579.361352] [modem0/ttyACM2/at] device open count is 2
(close)
[7273]: <debug> [1666700579.362718] [modem0] loaded IMEI: 357176090983831
[7273]: <debug> [1666700579.363039] [modem0] loading UE mode of operation for
EPS...
[7273]: <debug> [1666700579.363304] [modem0/ttyACM2/at] device open count is 3
(open)
[7273]: <debug> [1666700579.363670] [modem0/ttyACM2/at] device open count is 2
(close)
[7273]: <debug> [1666700579.364120] [modem0/ttyACM2/at] --> 'AT+CEMODE?<CR>'
[7273]: <debug> [1666700579.385338] [modem0/ttyACM2/at] <-- '<CR><LF>+CEMODE:
2<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700579.387338] [modem0/ttyACM2/at] device open count is 3
(open)
[7273]: <debug> [1666700579.388177] [modem0/ttyACM2/at] device open count is 2
(close)
[7273]: <debug> [1666700579.389039] [modem0/ttyACM2/at] -->
'AT^SCFG="MEopMode/Prov/Cfg"<CR>'
[7273]: <debug> [1666700579.432066] [modem0/ttyACM2/at] <-- '<CR><LF>^SCFG:
"MEopMode/Prov/Cfg","cmcgdccn"<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700579.433685] [modem0] (cinterion) current mno: cmcgdccn
[7273]: <debug> [1666700579.434456] [modem0] (cinterion) loaded EPS bearer
context id from list of MNO profiles: 1
[7273]: <debug> [1666700579.435236] [modem0/ttyACM2/at] device open count is 3
(open)
[7273]: <debug> [1666700579.436124] [modem0/ttyACM2/at] device open count is 2
(close)
[7273]: <debug> [1666700579.436962] [modem0/ttyACM2/at] --> 'AT+CGCONTRDP<CR>'
[7273]: <debug> [1666700579.463931] [modem0/ttyACM2/at] <--
'<CR><LF>+CGCONTRDP:
1,5,"internet","176.75.17.155","","193.213.112.4","130.67.15.198"<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700579.466062] [modem0/ttyACM2/at] device open count is 3
(open)
[7273]: <debug> [1666700579.466900] [modem0/ttyACM2/at] device open count is 2
(close)
[7273]: <debug> [1666700579.467775] [modem0/ttyACM2/at] --> 'AT^SGAUTH?<CR>'
[7273]: <debug> [1666700579.494744] [modem0/ttyACM2/at] <-- '<CR><LF>^SGAUTH:
1,0<CR><LF>^SGAUTH: 2,0<CR><LF>^SGAUTH: 3,0<CR><LF>^SGAUTH: 4,0<CR><LF>^SGAUTH:
5,0<CR><LF>^SGAUTH: 6,2,"internet"<CR><LF>^SGAUTH: 7,0<CR><LF>^SGAUTH:
8,0<CR><LF>^SGAUTH: 9,0<CR><LF>^SGAUTH: 10,2,"internet"<CR><LF>^SGAUTH:
11,2,"internet"<CR><LF>^SGAUTH: 12,0<CR><LF>^SGAUTH: 13,0<CR><LF>^SGAUTH:
14,0<CR><LF>^SGAUTH: 15,0<CR><LF>^SGAUTH: 16,0<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700579.501130] [modem0/ttyACM2/at] device open count is 3
(open)
[7273]: <debug> [1666700579.502104] [modem0/ttyACM2/at] device open count is 2
(close)
[7273]: <debug> [1666700579.505816] [modem0/ttyACM2/at] device open count is 1
(close)
[7273]: <debug> [1666700579.510103] [modem0] (cinterion) no GPS data port
found: no GPS capabilities
[7273]: <debug> [1666700579.513611] [modem0/ttyACM2/at] device open count is 2
(open)
[7273]: <debug> [1666700579.514546] [modem0/ttyACM2/at] --> 'AT+CNMI=?<CR>'
[7273]: <debug> [1666700579.533378] [modem0/ttyACM2/at] <-- '<CR><LF>+CNMI:
(0,1,2),(0,1),(0,2),(0),(1)<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700579.534210] [modem0/ttyACM2/at] device open count is 3
(open)
[7273]: <debug> [1666700579.534750] [modem0/ttyACM2/at] device open count is 2
(close)
[7273]: <debug> [1666700579.535616] [modem0/ttyACM2/at] --> 'AT+CPMS=?<CR>'
[7273]: <debug> [1666700579.559138] [modem0/ttyACM2/at] <-- '<CR><LF>+CPMS:
("ME","MT","SM","SR"),("ME","MT","SM","SR"),("ME","MT","SM","SR")<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700579.561549] [modem0] supported storages loaded:
[7273]: <debug> [1666700579.562116] [modem0] mem1 (list/read/delete)
storages: 'me, mt, sm, sr'
[7273]: <debug> [1666700579.562648] [modem0] mem2 (write/send) storages:
'me, mt, sm, sr'
[7273]: <debug> [1666700579.563173] [modem0] mem3 (reception) storages:
'me, mt, sm, sr'
[7273]: <debug> [1666700579.564284] [modem0/ttyACM2/at] device open count is 3
(open)
[7273]: <debug> [1666700579.565160] [modem0/ttyACM2/at] device open count is 2
(close)
[7273]: <debug> [1666700579.566008] [modem0/ttyACM2/at] --> 'AT+CPMS?<CR>'
[7273]: <debug> [1666700579.586752] [modem0/ttyACM2/at] <-- '<CR><LF>+CPMS:
"SR",0,0,"MT",1,255,"MT",1,255<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700579.588602] [modem0] current storages initialized:
[7273]: <debug> [1666700579.589224] [modem0] mem1 (list/read/delete)
storages: 'sr'
[7273]: <debug> [1666700579.589802] [modem0] mem2 (write/send) storages:
'mt'
[7273]: <debug> [1666700579.590371] [modem0] current storages initialized
[7273]: <debug> [1666700579.592527] [modem0/ttyACM2/at] device open count is 3
(open)
[7273]: <debug> [1666700579.593570] [modem0/ttyACM2/at] device open count is 2
(close)
[7273]: <debug> [1666700579.594605] [modem0/ttyACM2/at] --> 'AT+CTZU=1<CR>'
[7273]: <debug> [1666700579.618121] [modem0/ttyACM2/at] <-- '<CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700579.619036] [modem0/ttyACM2/at] --> 'AT+CCLK?<CR>'
[7273]: <debug> [1666700579.651950] [modem0/ttyACM2/at] <-- '<CR><LF>+CCLK:
"22/10/25,12:23:03+08"<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700579.667305] [modem0/ttyACM2/at] device open count is 3
(open)
[7273]: <debug> [1666700579.670266] [modem0/ttyACM2/at] device open count is 2
(close)
[7273]: <debug> [1666700579.672477] [modem0/ttyACM2/at] --> 'AT^SMONI=?<CR>'
[7273]: <debug> [1666700579.694816] [modem0/ttyACM2/at] <-- '<CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700579.695965] [modem0] (cinterion) SMONI supported
[7273]: <debug> [1666700579.698915] [modem0/ttyACM2/at] device open count is 1
(close)
[7273]: <debug> [1666700579.699679] [modem0] couldn't initialize interface:
'OMA not supported'
[7273]: <debug> [1666700579.702719] [modem0/ttyACM2/at] device open count is 2
(open)
[7273]: <debug> [1666700579.703706] [modem0/ttyACM2/at] --> 'ATH<CR>'
[7273]: <debug> [1666700579.718201] [modem0/ttyACM2/at] <-- '<CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700579.718777] [modem0/ttyACM2/at] device open count is 3
(open)
[7273]: <debug> [1666700579.719119] [modem0/ttyACM2/at] device open count is 2
(close)
[7273]: <debug> [1666700579.719468] [modem0/ttyACM2/at] --> 'AT+CLCC=?<CR>'
[7273]: <debug> [1666700579.739356] [modem0/ttyACM2/at] <-- '<CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700579.740608] [modem0/ttyACM2/at] device open count is 3
(open)
[7273]: <debug> [1666700579.741359] [modem0/ttyACM2/at] device open count is 2
(close)
[7273]: <debug> [1666700579.742092] [modem0/ttyACM2/at] --> 'AT^SLCC=?<CR>'
[7273]: <debug> [1666700579.762518] [modem0/ttyACM2/at] <-- '<CR><LF>^SLCC:
(0-1)<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700579.766630] [modem0/ttyACM2/at] device open count is 1
(close)
[7273]: <debug> [1666700579.767451] [modem0] creating ports context for SIM hot
swap
[7273]: <debug> [1666700579.767928] [modem0/ttyACM2/at] device open count is 2
(open)
[7273]: <info> [1666700579.769745] [modem0] state changed (unknown -> disabled)
[7273]: <debug> [1666700579.771054] [modem0] modem initialized
[7273]: <debug> [1666700579.786476] [device
/sys/devices/platform/soc/8af8800.usb3/8a00000.dwc3/xhci-hcd.0.auto/usb2/2-1]
exported modem at path '/org/freedesktop/ModemManager1/Modem/0'
[7273]: <debug> [1666700579.786681] [device
/sys/devices/platform/soc/8af8800.usb3/8a00000.dwc3/xhci-hcd.0.auto/usb2/2-1]
plugin: cinterion
[7273]: <debug> [1666700579.786835] [device
/sys/devices/platform/soc/8af8800.usb3/8a00000.dwc3/xhci-hcd.0.auto/usb2/2-1]
vid:pid: 0x1E2D:0x0061
[7273]: <debug> [1666700579.787047] [modem0/ttyACM2/at] device open count is 1
(close)
[7273]: <debug> [1666700587.178189] [modem0] user request to connect modem
[7273]: <info> [1666700587.178795] [modem0] simple connect started...
[7273]: <debug> [1666700587.179012] [modem0] profile ID: unspecified
[7273]: <debug> [1666700587.179191] [modem0] PIN: unspecified
[7273]: <debug> [1666700587.179368] [modem0] operator ID: unspecified
[7273]: <debug> [1666700587.179544] [modem0] allowed roaming: yes
[7273]: <debug> [1666700587.179709] [modem0] APN: telenor.smart
[7273]: <debug> [1666700587.179887] [modem0] APN type: unspecified
[7273]: <debug> [1666700587.180068] [modem0] IP family: ipv4
[7273]: <debug> [1666700587.180240] [modem0] allowed authentication:
unspecified
[7273]: <debug> [1666700587.180421] [modem0] user: unspecified
[7273]: <debug> [1666700587.180560] [modem0] password: unspecified
[7273]: <debug> [1666700587.180676] [modem0] multiplex: unspecified
[7273]: <info> [1666700587.180809] [modem0] simple connect state (3/8): enable
[7273]: <info> [1666700587.181175] [modem0] state changed (disabled ->
enabling)
[7273]: <debug> [1666700587.182336] [modem0] skipping initialization: device
hotplugged
[7273]: <debug> [1666700587.182550] [modem0/ttyACM2/at] device open count is 2
(open)
[7273]: <debug> [1666700587.182706] [modem0] flashing primary AT port before
enabling...
[7273]: <debug> [1666700587.183550] [modem0] loading power state...
[7273]: <debug> [1666700587.183889] [modem0/ttyACM2/at] device open count is 3
(open)
[7273]: <debug> [1666700587.184970] [modem0/ttyACM2/at] --> 'AT+CFUN?<CR>'
[7273]: <debug> [1666700587.202052] [modem0/ttyACM2/at] <-- '<CR><LF>+CFUN:
1<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700587.203677] [modem0] no need to change power state:
already 'on'
[7273]: <info> [1666700587.204440] [modem0] power state updated: on
[7273]: <debug> [1666700587.205174] [modem0] checking if SIM was swapped...
[7273]: <debug> [1666700587.205857] [modem0/sim0] loading SIM identifier...
[7273]: <debug> [1666700587.206605] [modem0/ttyACM2/at] device open count is 4
(open)
[7273]: <debug> [1666700587.207524] [modem0/ttyACM2/at] device open count is 3
(close)
[7273]: <debug> [1666700587.208375] [modem0/ttyACM2/at] -->
'AT+CRSM=176,12258,0,0,10<CR>'
[7273]: <debug> [1666700587.269646] [modem0/ttyACM2/at] <-- '<CR><LF>+CRSM:
144,0,"98740000814021362191"<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700587.271504] [modem0/sim0] loaded SIM identifier:
89470000180412631219
[7273]: <debug> [1666700587.272395] [modem0/ttyACM2/at] device open count is 4
(open)
[7273]: <debug> [1666700587.273306] [modem0/ttyACM2/at] device open count is 3
(close)
[7273]: <debug> [1666700587.274244] [modem0/ttyACM2/at] --> 'AT\Q3<CR>'
[7273]: <debug> [1666700587.289697] [modem0/ttyACM2/at] <-- '<CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700587.290286] [modem0] modem has 3GPP capabilities,
enabling the Modem 3GPP interface...
[7273]: <debug> [1666700587.290658] [modem0] checking indicator support...
[7273]: <debug> [1666700587.290999] [modem0/ttyACM2/at] device open count is 4
(open)
[7273]: <debug> [1666700587.291382] [modem0/ttyACM2/at] device open count is 3
(close)
[7273]: <debug> [1666700587.291735] [modem0/ttyACM2/at] --> 'AT+CIND=?<CR>'
[7273]: <debug> [1666700587.311875] [modem0/ttyACM2/at] <-- '<CR><LF>+CIND:
("battchg",(0-5)),("signal",(0-5)),("service",(0-1)),("call",(0-1)),("roam",(0-1)),("smsfull",(0-1)),("GPRS
coverage",(0-1)),("callsetup",(0-3))<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700587.314149] [modem0] signal quality indications via
CIND are supported at index '2' (min: 0, max: 5)
[7273]: <debug> [1666700587.314669] [modem0] roaming indications via CIND are
supported at index '5'
[7273]: <debug> [1666700587.315091] [modem0] service indications via CIND are
supported at index '3'
[7273]: <debug> [1666700587.315716] [modem0/ttyACM2/at] device open count is 4
(open)
[7273]: <debug> [1666700587.316386] [modem0/ttyACM2/at] device open count is 3
(close)
[7273]: <debug> [1666700587.317133] [modem0/ttyACM2/at] --> 'AT+CMER=?<CR>'
[7273]: <debug> [1666700587.340733] [modem0/ttyACM2/at] <-- '<CR><LF>+CMER:
(0-3),(0),(0),(0-1),(0-1)<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700587.342222] [modem0] supported +CMER modes:
discard-urcs, discard-urcs-if-link-reserved, buffer-urcs-if-link-reserved,
forward-urcs
[7273]: <debug> [1666700587.342797] [modem0] supported +CMER indication
settings: disable, enable-not-caused-by-cind
[7273]: <debug> [1666700587.343238] [modem0] +CMER enable mode: forward-urcs
[7273]: <debug> [1666700587.343650] [modem0] +CMER disable mode: discard-urcs
[7273]: <debug> [1666700587.344181] [modem0] +CMER indication setting:
enable-not-caused-by-cind
[7273]: <debug> [1666700587.344612] [modem0] checking packet domain event
reporting...
[7273]: <debug> [1666700587.345160] [modem0/ttyACM2/at] device open count is 4
(open)
[7273]: <debug> [1666700587.345828] [modem0/ttyACM2/at] device open count is 3
(close)
[7273]: <debug> [1666700587.346554] [modem0/ttyACM2/at] --> 'AT+CGEREP=?<CR>'
[7273]: <debug> [1666700587.370544] [modem0/ttyACM2/at] <-- '<CR><LF>+CGEREP:
(0-2),(0-1)<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700587.371134] [modem0] packet domain event reporting is
supported
[7273]: <debug> [1666700587.371466] [modem0] setting 3GPP +CIEV unsolicited
events handlers in ttyACM2
[7273]: <debug> [1666700587.371774] [modem0] setting 3GPP +CGEV unsolicited
events handlers in ttyACM2
[7273]: <debug> [1666700587.372128] [modem0] enabling +CIND event reporting in
primary port...
[7273]: <debug> [1666700587.372407] [modem0/ttyACM2/at] device open count is 4
(open)
[7273]: <debug> [1666700587.372770] [modem0/ttyACM2/at] device open count is 3
(close)
[7273]: <debug> [1666700587.373139] [modem0/ttyACM2/at] -->
'AT+CMER=3,0,0,1<CR>'
[7273]: <debug> [1666700587.400937] [modem0/ttyACM2/at] <-- '<CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700587.402025] [modem0] enabling +CGEV event reporting in
primary port...
[7273]: <debug> [1666700587.402615] [modem0/ttyACM2/at] device open count is 4
(open)
[7273]: <debug> [1666700587.403282] [modem0/ttyACM2/at] device open count is 3
(close)
[7273]: <debug> [1666700587.404152] [modem0/ttyACM2/at] --> 'AT+CGEREP=2<CR>'
[7273]: <debug> [1666700587.429391] [modem0/ttyACM2/at] <-- '<CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700587.430625] [modem0/ttyACM2/at] device open count is 4
(open)
[7273]: <debug> [1666700587.431392] [modem0/ttyACM2/at] device open count is 3
(close)
[7273]: <debug> [1666700587.432119] [modem0/ttyACM2/at] -->
'AT^SCFG="URC/DstIfc","app"<CR>'
[7273]: <debug> [1666700587.475376] [modem0/ttyACM2/at] <-- '<CR><LF>^SCFG:
"URC/DstIfc","app"<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700587.476701] [modem0/ttyACM2/at] device open count is 4
(open)
[7273]: <debug> [1666700587.477402] [modem0/ttyACM2/at] device open count is 3
(close)
[7273]: <debug> [1666700587.478145] [modem0/ttyACM2/at] -->
'AT^SIND="psinfo",1<CR>'
[7273]: <debug> [1666700587.511459] [modem0/ttyACM2/at] <-- '<CR><LF>^SIND:
psinfo,1,17<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700587.513045] [modem0] (cinterion) reporting initial
access technologies...
[7273]: <debug> [1666700587.514078] [modem0] access technology changed (unknown
-> lte)
[7273]: <debug> [1666700587.520407] [modem0] setting up 3GPP unsolicited
registration messages handlers in ttyACM2
[7273]: <debug> [1666700587.521460] [modem0/ttyACM2/at] device open count is 2
(close)
[7273]: <debug> [1666700587.526680] [modem0/ttyACM2/at] device open count is 3
(open)
[7273]: <debug> [1666700587.527590] [modem0/ttyACM2/at] --> 'AT+CREG=2<CR>'
[7273]: <debug> [1666700587.549473] [modem0/ttyACM2/at] <-- '<CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700587.550741] [modem0/ttyACM2/at] device open count is 4
(open)
[7273]: <debug> [1666700587.553417] [modem0/ttyACM2/at] device open count is 3
(close)
[7273]: <debug> [1666700587.556600] [modem0/ttyACM2/at] --> 'AT+CGREG=2<CR>'
[7273]: <debug> [1666700587.587687] [modem0/ttyACM2/at] <-- '<CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700587.588164] [modem0/ttyACM2/at] device open count is 4
(open)
[7273]: <debug> [1666700587.588436] [modem0/ttyACM2/at] device open count is 3
(close)
[7273]: <debug> [1666700587.588712] [modem0/ttyACM2/at] --> 'AT+CEREG=2<CR>'
[7273]: <debug> [1666700587.611964] [modem0/ttyACM2/at] <-- '<CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700587.613365] [modem0/ttyACM2/at] device open count is 4
(open)
[7273]: <debug> [1666700587.614384] [modem0/ttyACM2/at] device open count is 3
(close)
[7273]: <debug> [1666700587.615134] [modem0/ttyACM2/at] --> 'AT+CGDCONT?<CR>'
[7273]: <debug> [1666700587.765133] [modem0/ttyACM2/at] <-- '<CR><LF>+CGDCONT:
1,"IP","internet","0.0.0.0",0,0,0,0,0,0<CR><LF>+CGDCONT:
2,"IP","telenor.smart","0.0.0.0",0,0,0,0,0,0<CR><LF>+CGDCONT:
3,"IP","internet","0.0.0.0",0,0,0,0,0,0<CR><LF>+CGDCONT:
4,"IP","plus","0.0.0.0",0,0,0,0,0,0<CR><LF>+CGDCONT:
5,"IP","IMS","0.0.0.0",0,0,0,0,0,0<CR><LF>+CGDCONT:
6,"IP","internetipv6","0.0.0.0",0,0,0,0,0,0<CR><LF>+CGDCONT:
7,"IP","something","0.0.0.0",0,0,0,0,0,0<CR><LF>+CGDCONT:
8,"IPV6","internetipv6","0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0",0,0,0,0,0,0<CR><LF>+CGDCONT:
9,"IPV6","internet","0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0",0,0,0,0,0,0<CR><LF>+CGDCONT:
10,"IPV6","internetipv6WRONG","0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0",0,0,0,0,0,0<CR><LF>+CGDCONT:
11,"IPV6","IMS","0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0",0,0,0,0,0,0<CR><LF>+CGDCONT:
12,"IPV4V6","internet","0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0",0,0,0,0,0,0<CR><LF>+CGDCONT:
13,"IP","hos","0.0.0.0",0,0,0,0,0,0<CR><LF>+CGDCONT:
14,"IP","Hos12","0.0.0.0",0,0,0,0,0,0<CR><L
[7273]: <debug> [1666700587.784955] [modem0/ttyACM2/at] device open count is 4
(open)
[7273]: <debug> [1666700587.785246] [modem0/ttyACM2/at] device open count is 3
(close)
[7273]: <debug> [1666700587.785627] [modem0/ttyACM2/at] --> 'AT^SGAUTH?<CR>'
[7273]: <debug> [1666700587.808475] [modem0/ttyACM2/at] <-- '<CR><LF>^SGAUTH:
1,0<CR><LF>^SGAUTH: 2,0<CR><LF>^SGAUTH: 3,0<CR><LF>^SGAUTH: 4,0<CR><LF>^SGAUTH:
5,0<CR><LF>^SGAUTH: 6,2,"internet"<CR><LF>^SGAUTH: 7,0<CR><LF>^SGAUTH:
8,0<CR><LF>^SGAUTH: 9,0<CR><LF>^SGAUTH: 10,2,"internet"<CR><LF>^SGAUTH:
11,2,"internet"<CR><LF>^SGAUTH: 12,0<CR><LF>^SGAUTH: 13,0<CR><LF>^SGAUTH:
14,0<CR><LF>^SGAUTH: 15,0<CR><LF>^SGAUTH: 16,0<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700587.811488] [modem0] updating initial EPS bearer...
[7273]: <debug> [1666700587.817469] [modem0/bearer0] bearer not allowed to
connect, not registered in 3GPP network
[7273]: <debug> [1666700587.820539] [modem0] modem has 3GPP profile management
capabilities, enabling the Modem 3GPP Profile Manager interface...
[7273]: <debug> [1666700587.821339] [modem0/ttyACM2/at] device open count is 2
(close)
[7273]: <debug> [1666700587.824198] [modem0] modem has 3GPP/USSD capabilities,
enabling the Modem 3GPP/USSD interface...
[7273]: <debug> [1666700587.825646] [modem0] setting unsolicited result code
handlers in ttyACM2
[7273]: <debug> [1666700587.826891] [modem0/ttyACM2/at] device open count is 3
(open)
[7273]: <debug> [1666700587.827797] [modem0/ttyACM2/at] --> 'AT+CUSD=1<CR>'
[7273]: <debug> [1666700587.847853] [modem0/ttyACM2/at] <-- '<CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700587.848403] [modem0] modem has location capabilities,
enabling the Location interface...
[7273]: <debug> [1666700587.849045] [modem0] need to enable the following
location sources: '3gpp-lac-ci'
[7273]: <debug> [1666700587.855399] [modem0] running registration checks (CS:
'yes', PS: 'yes', EPS: 'yes', 5GS: 'no')
[7273]: <debug> [1666700587.860216] [modem0/ttyACM2/at] device open count is 4
(open)
[7273]: <debug> [1666700587.866020] [modem0/ttyACM2/at] device open count is 3
(close)
[7273]: <debug> [1666700587.870633] [modem0] modem has messaging capabilities,
enabling the Messaging interface...
[7273]: <debug> [1666700587.871520] [modem0/ttyACM2/at] device open count is 4
(open)
[7273]: <debug> [1666700587.872765] [modem0/ttyACM2/at] --> 'AT+CREG?<CR>'
[7273]: <debug> [1666700587.893327] [modem0/ttyACM2/at] <-- '<CR><LF>+CREG:
2,5,"2AF9","02C5901",7<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700587.895249] [modem0] 3GPP registration state change
ignored as modem isn't enabled
[7273]: <debug> [1666700587.897003] [modem0/ttyACM2/at] device open count is 5
(open)
[7273]: <debug> [1666700587.898201] [modem0/ttyACM2/at] device open count is 4
(close)
[7273]: <debug> [1666700587.899491] [modem0/ttyACM2/at] --> 'AT+CMGF=?<CR>'
[7273]: <debug> [1666700587.920727] [modem0/ttyACM2/at] <-- '<CR><LF>+CMGF:
(0-1)<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700587.923056] [modem0/ttyACM2/at] device open count is 5
(open)
[7273]: <debug> [1666700587.924371] [modem0/ttyACM2/at] device open count is 4
(close)
[7273]: <debug> [1666700587.925675] [modem0/ttyACM2/at] --> 'AT+CGREG?<CR>'
[7273]: <debug> [1666700587.947293] [modem0/ttyACM2/at] <-- '<CR><LF>+CGREG:
2,5,"2AF9","02C5901",7<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700587.949048] [modem0] 3GPP registration state change
ignored as modem isn't enabled
[7273]: <debug> [1666700587.950756] [modem0/ttyACM2/at] device open count is 5
(open)
[7273]: <debug> [1666700587.951939] [modem0/ttyACM2/at] device open count is 4
(close)
[7273]: <debug> [1666700587.953211] [modem0/ttyACM2/at] --> 'AT+CMGF=0<CR>'
[7273]: <debug> [1666700587.975093] [modem0/ttyACM2/at] <-- '<CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700587.976693] [modem0] successfully set preferred SMS
mode: 'PDU'
[7273]: <debug> [1666700587.978365] [modem0/ttyACM2/at] device open count is 5
(open)
[7273]: <debug> [1666700587.979650] [modem0/ttyACM2/at] device open count is 4
(close)
[7273]: <debug> [1666700587.982228] [modem0/ttyACM2/at] --> 'AT+CEREG?<CR>'
[7273]: <debug> [1666700588.006073] [modem0/ttyACM2/at] <-- '<CR><LF>+CEREG:
2,5,"2AF9","002C5901",7<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700588.006611] [modem0] 3GPP registration state change
ignored as modem isn't enabled
[7273]: <debug> [1666700588.007200] [modem0/ttyACM2/at] device open count is 3
(close)
[7273]: <debug> [1666700588.007587] [modem0/ttyACM2/at] -->
'AT+CPMS="SR","MT","MT"<CR>'
[7273]: <debug> [1666700588.043693] [modem0/ttyACM2/at] <-- '<CR><LF>+CPMS:
0,0,1,255,1,255<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700588.045123] [modem0] listing SMS parts in storage 'me'
[7273]: <debug> [1666700588.045659] [modem0] locking SMS storages to: mem1
(ME), mem2 (none)...
[7273]: <debug> [1666700588.046255] [modem0/ttyACM2/at] device open count is 4
(open)
[7273]: <debug> [1666700588.046966] [modem0/ttyACM2/at] device open count is 3
(close)
[7273]: <debug> [1666700588.047678] [modem0/ttyACM2/at] --> 'AT+CPMS="ME"<CR>'
[7273]: <debug> [1666700588.073746] [modem0/ttyACM2/at] <-- '<CR><LF>+CPMS:
1,255,1,255,1,255<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700588.075242] [modem0/ttyACM2/at] device open count is 4
(open)
[7273]: <debug> [1666700588.076016] [modem0/ttyACM2/at] device open count is 3
(close)
[7273]: <debug> [1666700588.076737] [modem0/ttyACM2/at] --> 'AT+CMGL=4<CR>'
[7273]: <debug> [1666700588.102041] [modem0/ttyACM2/at] <-- '<CR><LF>+CMGL:
0,1,,121<CR><LF>07918405210077F7040B918496114388F3000022014190351580744BFA7B0E22EAEF6F779AED023D41E73759EF02C172BADA0C54D7E7E9EBF7DD9D5E83E8E5F31BE4AEB7CBF23A082E7F8BDFF7301B344F97417A10F52D0E83E6EBB79B1E5ED3DFF7F0D8050A8AF3203DC89D6E83E06FF95BDF0EDFD3E1310BF42693F5F7B7DB05<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700588.104259] [modem0] parsing PDU (0)...
[7273]: <debug> [1666700588.104727] [modem0] SMSC address parsed:
'+48501200777'
[7273]: <debug> [1666700588.105146] [modem0] deliver type PDU detected
[7273]: <debug> [1666700588.105534] [modem0] number parsed: +48691134883
[7273]: <debug> [1666700588.106050] [modem0] PID: 0
[7273]: <debug> [1666700588.106443] [modem0] user data encoding is GSM7
[7273]: <debug> [1666700588.106826] [modem0] user data length: 116 elements
[7273]: <debug> [1666700588.107241] [modem0] user data length: 102 bytes
[7273]: <debug> [1666700588.107640] [modem0] decoding SMS text with 116 elements
[7273]: <debug> [1666700588.108252] [modem0] converted SMS part text from GSM-7
to UTF-8: Ktos Dzwonil. O godz. 09:53 uzytkownik tego numeru probowal sie z
Toba skontaktowac. Aby z nim porozmawiac, oddzwon.
[7273]: <debug> [1666700588.108730] [modem0] correctly parsed PDU (0)
[7273]: <debug> [1666700588.109162] [modem0/sms-list] SMS part at 'me/0' is
from a singlepart SMS
[7273]: <debug> [1666700588.116650] [modem0] listing SMS parts in storage 'sm'
[7273]: <debug> [1666700588.116936] [modem0] locking SMS storages to: mem1
(SM), mem2 (none)...
[7273]: <debug> [1666700588.118182] [modem0/ttyACM2/at] device open count is 4
(open)
[7273]: <debug> [1666700588.118656] [modem0/ttyACM2/at] device open count is 3
(close)
[7273]: <debug> [1666700588.119445] [modem0/ttyACM2/at] --> 'AT+CPMS="SM"<CR>'
[7273]: <debug> [1666700588.144095] [modem0/ttyACM2/at] <-- '<CR><LF>+CPMS:
0,20,1,255,1,255<CR><LF><CR><LF>OK<CR><LF><CR><LF>+CIEV: 5,0<CR><LF>'
[7273]: <debug> [1666700588.146068] [modem0/ttyACM2/at] device open count is 4
(open)
[7273]: <debug> [1666700588.146844] [modem0/ttyACM2/at] device open count is 3
(close)
[7273]: <debug> [1666700588.148015] [modem0/ttyACM2/at] --> 'AT+CMGL=4<CR>'
[7273]: <debug> [1666700588.171131] [modem0/ttyACM2/at] <-- '<CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700588.171958] [modem0] listing SMS parts in storage 'sr'
[7273]: <debug> [1666700588.172414] [modem0] locking SMS storages to: mem1
(SR), mem2 (none)...
[7273]: <debug> [1666700588.172736] [modem0/ttyACM2/at] device open count is 4
(open)
[7273]: <debug> [1666700588.173455] [modem0/ttyACM2/at] device open count is 3
(close)
[7273]: <debug> [1666700588.174245] [modem0/ttyACM2/at] --> 'AT+CPMS="SR"<CR>'
[7273]: <debug> [1666700588.199749] [modem0/ttyACM2/at] <-- '<CR><LF>+CPMS:
0,0,1,255,1,255<CR><LF><CR><LF>OK<CR><LF><CR><LF>+CIEV: 5,1<CR><LF>'
[7273]: <debug> [1666700588.201733] [modem0/ttyACM2/at] device open count is 4
(open)
[7273]: <debug> [1666700588.202518] [modem0/ttyACM2/at] device open count is 3
(close)
[7273]: <debug> [1666700588.203610] [modem0/ttyACM2/at] --> 'AT+CMGL=4<CR>'
[7273]: <debug> [1666700588.229075] [modem0/ttyACM2/at] <-- '<CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700588.231828] [modem0] setting messaging unsolicited
events handlers in ttyACM2
[7273]: <debug> [1666700588.233411] [modem0/ttyACM2/at] device open count is 2
(close)
[7273]: <debug> [1666700588.235373] [modem0/ttyACM2/at] device open count is 3
(open)
[7273]: <debug> [1666700588.237033] [modem0/ttyACM2/at] -->
'AT+CNMI=2,1,2,0,1<CR>'
[7273]: <debug> [1666700588.271506] [modem0/ttyACM2/at] <-- '<CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700588.280397] [modem0] modem has time capabilities,
enabling the Time interface...
[7273]: <debug> [1666700588.283573] [modem0] (cinterion) setting up time
unsolicited events...
[7273]: <debug> [1666700588.288089] [modem0/ttyACM2/at] device open count is 2
(close)
[7273]: <debug> [1666700588.289184] [modem0] modem has extended signal
reporting capabilities, enabling the Signal interface...
[7273]: <debug> [1666700588.289489] [modem0] extended signal information
reporting disabled (rate: 0 seconds)
[7273]: <debug> [1666700588.290131] [modem0] modem has voice capabilities,
enabling the Voice interface...
[7273]: <debug> [1666700588.290824] [modem0] setting voice unsolicited events
handlers in ttyACM2
[7273]: <debug> [1666700588.291362] [modem0] enabling +CLIP calling line
reporting in primary port...
[7273]: <debug> [1666700588.291627] [modem0/ttyACM2/at] device open count is 3
(open)
[7273]: <debug> [1666700588.292048] [modem0/ttyACM2/at] --> 'AT+CLIP=1<CR>'
[7273]: <debug> [1666700588.314651] [modem0/ttyACM2/at] <-- '<CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700588.315875] [modem0] enabling +CRC extended format of
incoming call indications in primary port...
[7273]: <debug> [1666700588.316484] [modem0/ttyACM2/at] device open count is 4
(open)
[7273]: <debug> [1666700588.317156] [modem0/ttyACM2/at] device open count is 3
(close)
[7273]: <debug> [1666700588.317889] [modem0/ttyACM2/at] --> 'AT+CRC=1<CR>'
[7273]: <debug> [1666700588.338300] [modem0/ttyACM2/at] <-- '<CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700588.339519] [modem0] enabling +CCWA call waiting
indications in primary port...
[7273]: <debug> [1666700588.340113] [modem0/ttyACM2/at] device open count is 4
(open)
[7273]: <debug> [1666700588.340793] [modem0/ttyACM2/at] device open count is 3
(close)
[7273]: <debug> [1666700588.341534] [modem0/ttyACM2/at] --> 'AT+CCWA=1<CR>'
[7273]: <debug> [1666700588.364019] [modem0/ttyACM2/at] <-- '<CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700588.365335] [modem0] (cinterion) enabling ^SLCC
extended list of current calls reporting in primary port...
[7273]: <debug> [1666700588.365955] [modem0/ttyACM2/at] device open count is 4
(open)
[7273]: <debug> [1666700588.366708] [modem0/ttyACM2/at] device open count is 3
(close)
[7273]: <debug> [1666700588.367433] [modem0/ttyACM2/at] --> 'AT^SLCC=1<CR>'
[7273]: <debug> [1666700588.387859] [modem0/ttyACM2/at] <-- '<CR><LF>OK<CR><LF>'
[7273]: <info> [1666700588.389210] [modem0] simple connect state (4/8): wait
to get fully enabled
[7273]: <info> [1666700588.390080] [modem0] state changed (enabling -> enabled)
[7273]: <debug> [1666700588.393733] [modem0/ttyACM2/at] device open count is 2
(close)
[7273]: <info> [1666700588.395509] [modem0] simple connect state (5/8):
register
[7273]: <debug> [1666700588.397129] [modem0] launching automatic network
registration...
[7273]: <debug> [1666700588.398653] [modem0/ttyACM2/at] device open count is 3
(open)
[7273]: <debug> [1666700588.400490] [modem0] running registration checks (CS:
'yes', PS: 'yes', EPS: 'yes', 5GS: 'no')
[7273]: <debug> [1666700588.401978] [modem0/ttyACM2/at] device open count is 4
(open)
[7273]: <debug> [1666700588.403496] [modem0/ttyACM2/at] --> 'AT+COPS=0<CR>'
[7273]: <debug> [1666700588.429641] [modem0/ttyACM2/at] <-- '<CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700588.436820] [modem0] running registration checks (CS:
'yes', PS: 'yes', EPS: 'yes', 5GS: 'no')
[7273]: <debug> [1666700588.441320] [modem0/ttyACM2/at] device open count is 5
(open)
[7273]: <debug> [1666700588.448352] [modem0/ttyACM2/at] device open count is 4
(close)
[7273]: <debug> [1666700588.450839] [modem0/ttyACM2/at] --> 'AT+CREG?<CR>'
[7273]: <debug> [1666700588.468529] [modem0/ttyACM2/at] <-- '<CR><LF>+CREG:
2,5,"2AF9","02C5901",7<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <info> [1666700588.469375] [modem0] 3GPP registration state changed
(unknown -> registering)
[7273]: <debug> [1666700588.469860] [modem0] loading Operator Code...
[7273]: <debug> [1666700588.470301] [modem0/ttyACM2/at] device open count is 5
(open)
[7273]: <debug> [1666700588.471433] [modem0/ttyACM2/at] device open count is 6
(open)
[7273]: <debug> [1666700588.472584] [modem0] 3GPP tracking area code updated:
'000000->002AF9'
[7273]: <debug> [1666700588.473492] [modem0] 3GPP cell id updated:
'00000000->002C5901'
[7273]: <debug> [1666700588.474452] [modem0] 3GPP location updated (MCCMNC:
'<none>', location area code: '0000', tracking area code: '002AF9', cell ID:
'002C5901')
[7273]: <debug> [1666700588.476133] [modem0/ttyACM2/at] device open count is 7
(open)
[7273]: <debug> [1666700588.477218] [modem0/ttyACM2/at] device open count is 6
(close)
[7273]: <debug> [1666700588.478432] [modem0/ttyACM2/at] --> 'AT+CREG?<CR>'
[7273]: <debug> [1666700588.497493] [modem0/ttyACM2/at] <-- '<CR><LF>+CREG:
2,5,"2AF9","02C5901",7<CR><LF><CR><LF>OK<CR><LF><CR><LF>+CIEV: psinfo,0<CR><LF>'
[7273]: <debug> [1666700588.498129] [modem0] (cinterion) received indicator
'psinfo' update: 0
[7273]: <debug> [1666700588.498795] [modem0] access technology changed (lte ->
unknown)
[7273]: <debug> [1666700588.499895] [modem0/ttyACM2/at] device open count is 7
(open)
[7273]: <debug> [1666700588.500425] [modem0/ttyACM2/at] device open count is 6
(close)
[7273]: <debug> [1666700588.501568] [modem0/ttyACM2/at] --> 'AT+COPS=3,2<CR>'
[7273]: <debug> [1666700588.523810] [modem0/ttyACM2/at] <-- '<CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700588.525570] [modem0/ttyACM2/at] device open count is 5
(close)
[7273]: <debug> [1666700588.526773] [modem0/ttyACM2/at] --> 'AT+COPS?<CR>'
[7273]: <debug> [1666700588.544554] [modem0/ttyACM2/at] <-- '<CR><LF>+COPS:
0,2,"26001",7<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700588.546874] [modem0] couldn't convert operator string
'26001' from charset 'UCS2': Hex conversion failed: invalid input length
[7273]: <debug> [1666700588.547970] [modem0] operator normalized
'26001'->'26001'
[7273]: <debug> [1666700588.548810] [modem0] loaded Operator Code: 26001
[7273]: <debug> [1666700588.550083] [modem0] 3GPP location updated (MCCMNC:
'26001', location area code: '0000', tracking area code: '002AF9', cell ID:
'002C5901')
[7273]: <debug> [1666700588.551303] [modem0] loading Operator Name...
[7273]: <debug> [1666700588.552218] [modem0/ttyACM2/at] device open count is 6
(open)
[7273]: <debug> [1666700588.553330] [modem0/ttyACM2/at] device open count is 7
(open)
[7273]: <debug> [1666700588.554646] [modem0/ttyACM2/at] device open count is 6
(close)
[7273]: <debug> [1666700588.557114] [modem0/ttyACM2/at] --> 'AT+CGREG?<CR>'
[7273]: <debug> [1666700588.578456] [modem0/ttyACM2/at] <-- '<CR><LF>+CGREG:
2,5,"2AF9","02C5901",7<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700588.579913] [modem0] 3GPP location area code updated:
'0000->2AF9'
[7273]: <debug> [1666700588.580402] [modem0] 3GPP tracking area code cleared:
'002AF9->000000'
[7273]: <debug> [1666700588.580860] [modem0] 3GPP location updated (MCCMNC:
'26001', location area code: '2AF9', tracking area code: '000000', cell ID:
'002C5901')
[7273]: <debug> [1666700588.581990] [modem0/ttyACM2/at] device open count is 7
(open)
[7273]: <debug> [1666700588.582686] [modem0/ttyACM2/at] device open count is 6
(close)
[7273]: <debug> [1666700588.583815] [modem0/ttyACM2/at] --> 'AT+CGREG?<CR>'
[7273]: <debug> [1666700588.601725] [modem0/ttyACM2/at] <-- '<CR><LF>+CGREG:
2,5,"2AF9","02C5901",7<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700588.603968] [modem0/ttyACM2/at] device open count is 7
(open)
[7273]: <debug> [1666700588.604772] [modem0/ttyACM2/at] device open count is 6
(close)
[7273]: <debug> [1666700588.605637] [modem0/ttyACM2/at] --> 'AT+COPS=3,0<CR>'
[7273]: <debug> [1666700588.627085] [modem0/ttyACM2/at] <-- '<CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700588.628394] [modem0/ttyACM2/at] device open count is 5
(close)
[7273]: <debug> [1666700588.629303] [modem0/ttyACM2/at] --> 'AT+COPS?<CR>'
[7273]: <debug> [1666700588.648043] [modem0/ttyACM2/at] <-- '<CR><LF>+COPS:
0,0,"0050006C00750073",7<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700588.650285] [modem0] couldn't convert operator string
'0050006C00750073' from charset 'UCS2': Invalid conversion from UCS2 to UTF-8:
Couldn't convert from UCS2 to UTF-8 with translit: Could not open converter
from “UCS-2BE” to “UTF-8”
[7273]: <debug> [1666700588.650990] [modem0] operator normalized
'0050006C00750073'->'0050006C00750073'
[7273]: <debug> [1666700588.651499] [modem0] loaded Operator Name:
0050006C00750073
[7273]: <info> [1666700588.652396] [modem0] 3GPP registration state changed
(registering -> roaming)
[7273]: <debug> [1666700588.652963] [modem0] consolidated registration state:
cs 'roaming', ps 'roaming', eps 'roaming', 5gs 'unknown' --> 'roaming'
[7273]: <debug> [1666700588.654147] [modem0] will start keeping track of state
for subsystem '3gpp'
[7273]: <info> [1666700588.654791] [modem0] state changed (enabled ->
registered)
[7273]: <debug> [1666700588.655956] [modem0] network timezone polling started
[7273]: <debug> [1666700588.658915] [modem0] periodic signal checks enabled
[7273]: <debug> [1666700588.660600] [modem0] periodic signal check refresh
requested
[7273]: <debug> [1666700588.662344] [modem0] loading signal quality...
[7273]: <debug> [1666700588.664105] [modem0/ttyACM2/at] device open count is 6
(open)
[7273]: <debug> [1666700588.665301] [modem0/ttyACM2/at] device open count is 5
(close)
[7273]: <debug> [1666700588.667001] [modem0/ttyACM2/at] --> 'AT+CEREG?<CR>'
[7273]: <debug> [1666700588.684535] [modem0/ttyACM2/at] <-- '<CR><LF>+CEREG:
2,5,"2AF9","002C5901",7<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700588.685683] [modem0] 3GPP tracking area code updated:
'000000->002AF9'
[7273]: <debug> [1666700588.686662] [modem0] 3GPP location area code cleared:
'2AF9->0000'
[7273]: <debug> [1666700588.687588] [modem0] 3GPP location updated (MCCMNC:
'26001', location area code: '0000', tracking area code: '002AF9', cell ID:
'002C5901')
[7273]: <debug> [1666700588.689287] [modem0] initial 3GPP registration checks
finished
[7273]: <debug> [1666700588.690299] [modem0/ttyACM2/at] device open count is 4
(close)
[7273]: <debug> [1666700588.691501] [modem0/ttyACM2/at] --> 'AT+CEREG?<CR>'
[7273]: <debug> [1666700588.711729] [modem0/ttyACM2/at] <-- '<CR><LF>+CEREG:
2,5,"2AF9","002C5901",7<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700588.714301] [modem0] periodic signal check refresh
ignored: check already running
[7273]: <debug> [1666700588.715238] [modem0] currently registered in a 3GPP
network
[7273]: <info> [1666700588.716115] [modem0] simple connect state (6/8): bearer
[7273]: <debug> [1666700588.716967] [modem0] creating new bearer...
[7273]: <debug> [1666700588.717914] [modem0] (cinterion) checking ^SWWAN
support...
[7273]: <debug> [1666700588.718904] [modem0/ttyACM2/at] device open count is 5
(open)
[7273]: <debug> [1666700588.720151] [modem0/ttyACM2/at] device open count is 4
(close)
[7273]: <debug> [1666700588.721703] [modem0/ttyACM2/at] --> 'AT+CIND?<CR>'
[7273]: <debug> [1666700588.739114] [modem0/ttyACM2/at] <-- '<CR><LF>+CIND:
0,3,1,1,1,1,1,0<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700588.740460] [modem0] signal quality updated (60)
[7273]: <debug> [1666700588.741035] [modem0/ttyACM2/at] device open count is 3
(close)
[7273]: <debug> [1666700588.742239] [modem0] polling to refresh access
technologies is unsupported
[7273]: <debug> [1666700588.742699] [modem0] periodic signal quality and access
technology checks scheduled
[7273]: <debug> [1666700588.743268] [modem0/ttyACM2/at] --> 'AT^SWWAN=?<CR>'
[7273]: <debug> [1666700588.767755] [modem0/ttyACM2/at] <-- '<CR><LF>^SWWAN:
(0,1),(1-16),(1,2)<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700588.769656] [modem0] (cinterion) SWWAN supported
[7273]: <debug> [1666700588.770542] [modem0] (cinterion) ^SWWAN supported,
creating cinterion bearer...
[7273]: <debug> [1666700588.775520] [modem0/ttyACM2/at] device open count is 4
(open)
[7273]: <debug> [1666700588.776620] [modem0/ttyACM2/at] device open count is 3
(close)
[7273]: <info> [1666700588.779835] [modem0] simple connect state (7/8): connect
[7273]: <debug> [1666700588.782412] [modem0/bearer1] connecting...
[7273]: <info> [1666700588.784271] [modem0] state changed (registered ->
connecting)
[7273]: <debug> [1666700588.787736] [modem0/bearer1] launching 3GPP connection
attempt
[7273]: <debug> [1666700588.788956] [modem0] set profile state (1/8): check
format
[7273]: <debug> [1666700588.791654] [modem0/ttyACM2/at] device open count is 4
(open)
[7273]: <debug> [1666700588.793100] [modem0/ttyACM2/at] device open count is 3
(close)
[7273]: <debug> [1666700588.796239] [modem0] unhandled PDP type in CGDCONT=?
reply: 'PPP'
[7273]: <debug> [1666700588.796621] [modem0] +CGDCONT format details for PDP
type 'ipv4': minimum 1, maximum 16
[7273]: <debug> [1666700588.796882] [modem0] context definition format: minimum
1, maximum 16
[7273]: <debug> [1666700588.797082] [modem0] set profile state (2/8): list
before
[7273]: <debug> [1666700588.797535] [modem0/ttyACM2/at] device open count is 4
(open)
[7273]: <debug> [1666700588.797914] [modem0/ttyACM2/at] device open count is 3
(close)
[7273]: <debug> [1666700588.798256] [modem0/ttyACM2/at] --> 'AT+CGDCONT?<CR>'
[7273]: <debug> [1666700588.870757] [modem0/ttyACM2/at] <-- '<CR><LF>+CGDCONT:
1,"IP","internet","0.0.0.0",0,0,0,0,0,0<CR><LF>+CGDCONT:
2,"IP","telenor.smart","0.0.0.0",0,0,0,0,0,0<CR><LF>+CGDCONT:
3,"IP","internet","0.0.0.0",0,0,0,0,0,0<CR><LF>+CGDCONT:
4,"IP","plus","0.0.0.0",0,0,0,0,0,0<CR><LF>+CGDCONT:
5,"IP","IMS","0.0.0.0",0,0,0,0,0,0<CR><LF>+CGDCONT:
6,"IP","internetipv6","0.0.0.0",0,0,0,0,0,0<CR><LF>+CGDCONT:
7,"IP","something","0.0.0.0",0,0,0,0,0,0<CR><LF>+CGDCONT:
8,"IPV6","internetipv6","0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0",0,0,0,0,0,0<CR><LF>+CGDCONT:
9,"IPV6","internet","0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0",0,0,0,0,0,0<CR><LF>+CGDCONT:
10,"IPV6","internetipv6WRONG","0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0",0,0,0,0,0,0<CR><LF>+CGDCONT:
11,"IPV6","IMS","0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0",0,0,0,0,0,0<CR><LF>+CGDCONT:
12,"IPV4V6","internet","0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0",0,0,0,0,0,0<CR><LF>+CGDCONT:
13,"IP","hos","0.0.0.0",0,0,0,0,0,0<CR><LF>+CGDCONT:
14,"IP","Hos12","0.0.0.0",0,0,0,0,0,0<CR><L
[7273]: <debug> [1666700588.876748] [modem0] set profile state (3/8): select
profile (best)
[7273]: <debug> [1666700588.877271] [modem0] found exact context at profile 2
[7273]: <debug> [1666700588.877683] [modem0] reusing profile '2'
[7273]: <debug> [1666700588.878076] [modem0] set profile state (4/8): check
activated profile
[7273]: <debug> [1666700588.878637] [modem0] checking if profile with id '2' is
already activated...
[7273]: <debug> [1666700588.879198] [modem0/ttyACM2/at] device open count is 4
(open)
[7273]: <debug> [1666700588.879979] [modem0/ttyACM2/at] device open count is 3
(close)
[7273]: <debug> [1666700588.880880] [modem0/ttyACM2/at] --> 'AT+CGACT?<CR>'
[7273]: <debug> [1666700588.899942] [modem0/ttyACM2/at] <-- '<CR><LF>+CGACT:
1,1<CR><LF>+CGACT: 2,0<CR><LF>+CGACT: 3,0<CR><LF>+CGACT: 4,0<CR><LF>+CGACT:
5,0<CR><LF>+CGACT: 6,0<CR><LF>+CGACT: 7,0<CR><LF>+CGACT: 8,0<CR><LF>+CGACT:
9,0<CR><LF>+CGACT: 10,0<CR><LF>+CGACT: 11,0<CR><LF>+CGACT: 12,0<CR><LF>+CGACT:
13,0<CR><LF>+CGACT: 14,0<CR><LF>+CGACT: 15,0<CR><LF>+CGACT:
16,0<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700588.903787] [modem0] profile '2' is not activated
[7273]: <debug> [1666700588.904399] [modem0] set profile state (6/8): profile
already stored
[7273]: <debug> [1666700588.904823] [modem0] set profile state (8/8): all done
[7273]: <debug> [1666700588.905395] [modem0/bearer1] (cinterion) dial step 1/4:
authentication not required
[7273]: <debug> [1666700588.905861] [modem0/bearer1] (cinterion) dial step 2/4:
starting SWWAN interface 1 connection...
[7273]: <debug> [1666700588.906488] [modem0/ttyACM2/at] device open count is 4
(open)
[7273]: <debug> [1666700588.907642] [modem0/ttyACM2/at] device open count is 3
(close)
[7273]: <debug> [1666700588.908397] [modem0/ttyACM2/at] --> 'AT^SWWAN=1,2,1<CR>'
[7273]: <debug> [1666700588.957899] [modem0/ttyACM2/at] <-- '<CR><LF>+CME
ERROR: 148<CR><LF>'
[7273]: <debug> [1666700588.962765] [modem0/ttyACM2/at] operation failure: 148
(Unspecified GPRS error)
[7273]: <warn> [1666700588.965711] [modem0/bearer1] connection attempt #1
failed: Unspecified GPRS error
[7273]: <info> [1666700588.972453] [modem0] state changed (connecting ->
registered)
[7273]: <info> [1666700588.974904] [modem0/bearer1] connection #1 finished:
duration 0s, tx: 0 bytes, rx: 0 bytes
[7273]: <debug> [1666700588.975114] [modem0] couldn't connect bearer:
Unspecified GPRS error
[7273]: <debug> [1666700588.976114] [modem0/ttyACM2/at] device open count is 2
(close)
[7273]: <debug> [1666700593.510670] [modem0/ttyACM2/at] device open count is 3
(open)
[7273]: <debug> [1666700593.514288] [modem0/ttyACM2/at] --> 'AT+CCLK?<CR>'
[7273]: <debug> [1666700593.541624] [modem0/ttyACM2/at] <-- '<CR><LF>+CCLK:
"22/10/25,12:23:17+08"<CR><LF><CR><LF>OK<CR><LF>'
[7273]: <debug> [1666700593.544349] [modem0/ttyACM2/at] device open count is 2
(close)
[7273]: <debug> [1666700605.122239] [modem0/ttyACM2/at] <-- '<CR><LF>+CIEV:
1,0<CR><LF><CR><LF>+CIEV: 2,0<CR><LF><CR><LF>+CIEV: 6,0<CR><LF><CR><LF>+CIEV:
4,0<CR><LF>'
[7273]: <debug> [1666700605.124021] [modem0] signal quality updated (0)
[7273]: <debug> [1666700605.127759] [modem0/ttyACM2/at] <-- '<CR><LF>+CGEV: NW
DETACH<CR><LF><CR><LF>+CREG: 2<CR><LF><CR><LF>+CGREG: 2<CR><LF><CR><LF>+CEREG:
2<CR><LF><CR><LF>+CIEV: psinfo,16<CR><LF><CR><LF>+CIEV:
psinfo,0<CR><LF><CR><LF>+CIEV: psinfo,17<CR><LF>'
[7273]: <debug> [1666700605.128761] [modem0] (cinterion) received indicator
'psinfo' update: 16
[7273]: <debug> [1666700605.129648] [modem0] access technology changed (unknown
-> lte)
[7273]: <debug> [1666700605.130225] [modem0] (cinterion) received indicator
'psinfo' update: 0
[7273]: <debug> [1666700605.131041] [modem0] access technology changed (lte ->
unknown)
[7273]: <debug> [1666700605.131586] [modem0] (cinterion) received indicator
'psinfo' update: 17
[7273]: <debug> [1666700605.132368] [modem0] access technology changed (unknown
-> lte)
[7273]: <info> [1666700605.133052] [modem0] network forced PS detach: all
contexts have been deactivated
[7273]: <info> [1666700605.134936] [modem0] 3GPP registration state changed
(roaming -> searching)
[7273]: <debug> [1666700605.135416] [modem0] consolidated registration state:
cs 'searching', ps 'searching', eps 'searching', 5gs 'unknown' --> 'searching'
[7273]: <debug> [1666700605.136538] [modem0] 3GPP location updated (MCCMNC:
'<none>', location area code: '0000', tracking area code: '002AF9', cell ID:
'002C5901')
[7273]: <info> [1666700605.137593] [modem0] state changed (registered ->
searching)
[7273]: <debug> [1666700605.142844] [modem0] signal quality updated (0)
[7273]: <debug> [1666700605.143240] [modem0] access technology changed (lte ->
unknown)
[7273]: <debug> [1666700605.143479] [modem0] periodic signal checks disabled
[7273]: <debug> [1666700605.143726] [modem0] 3GPP location updated (MCCMNC:
'<none>', location area code: '0000', tracking area code: '000000', cell ID:
'00000000')
--
Arkadiusz Drabczyk <arkadi...@drabczyk.org>
