<div dir="ltr"><div>Hi Daniele,</div><div> </div><div>I am able to reproduce the issue using different SIM cards (especially from different operators).</div><div> </div><div>I have attached a line, arriving in dmesg when the issue occurs, in my first email:</div><div> </div><div>On the kernel 2.6.37:</div><div>"[ 1674.800000] tty_port_close_start: tty->count = 1 port count = 0."</div><div> </div><div>Additionally there are logs from kernel 3.18.11:</div><div>"[10702.144550] cdc_acm 1-1.4:1.0: failed to set dtr/rts"</div><div>"[10707.154565] cdc_acm 1-1.4:1.0: failed to set dtr/rts"</div><div> </div><div>Only the lines above arrive when the issue happens.</div><div> </div><div>Regards,</div><div> Jaroslaw </div></div><div class="gmail_extra"> <div class="gmail_quote">2016-05-13 10:48 GMT+02:00 Daniele Palmas <<a href="mailto:dnlplm@gmail.com" target="_blank">dnlplm@gmail.com</a>>: <blockquote class="gmail_quote" style="margin:0 0 0 .8ex;border-left:1px #ccc solid;padding-left:1ex">Hi Jaroslaw, <div><div class="h5"> 2016-05-13 9:18 GMT+02:00 Jarosław Bielski <<a href="mailto:bielski.j@gmail.com">bielski.j@gmail.com</a>>: > Hi, > > To have additional information and capabilities regarding to the modem > (pin/puk tries perform/remain count, supported network modes (2G/3G/4G)) I > have checked the newer version of ModemManager-1.5.992. Unfortunately I have > found a regression with unlocking of PIN locked SIM. Unlocking procedure > takes a lot of time (about 5 seconds), finishes with success but modem > remains in "initializing" state (never changed to other one). There is no > possibility to configure/connect the modem from client side. Note that all > thinks works fine if I insert not PIN locked SIM card into the modem. > Previous one version of ModemManager (1.4.12) was this bug/behaviour free. > > Use case (step-by-step): > 1. Start ModemManager > 2. Plug modem into USB port > 3. Check modem status using mmcli tool (mmcli -L, mmcli -m X) > 4. provide PIN to unlock the SIM (mmcli -m X -i Y --pin ABCD) > > During performing step 4 the following message is displayed on kernel > console: > > [ 2635.412000] tty_port_close_start: tty->count = 1 port count = 0. > > Environment: > - Modem MTD-H5 (Telit HE910-D) > - SIM card with PIN lock enabled > - Linux 2.6.37/3.18.11 (both versions was checked) > - udev-182 > - glib-2.38.2 > - dbus-1.4.20 > - libmbim-1.12.4 > - libqmi-1.14.2 > > > Please find the following logs from the use cases steps: > >> 3. Check modem status using mmcli tool. > > # mmcli -m 7 > > /org/freedesktop/ModemManager1/Modem/7 (device id > 'd085b4f507a00fb98af1e3e35a70c4e00b451b14') > ------------------------- > Hardware | manufacturer: 'Telit' > | model: 'HE910-D' > | revision: '12.00.026' > | supported: 'gsm-umts' > | current: 'gsm-umts' > | equipment id: '351579057922930' > ------------------------- > System | device: '/sys/devices/platform/ehci-brcm.0/usb1/1-1' > | drivers: 'cdc_acm' > | plugin: 'Telit' > | primary port: 'ttyACM0' > | ports: 'ttyACM3 (at), ttyACM4 (unknown), ttyACM5 > (unknown), ttyACM0 (at), ttyACM1 (unknown), ttyACM2 (unknown)' > ------------------------- > Numbers | own : 'unknown' > ------------------------- > Status | lock: 'sim-pin' > | unlock retries: 'sim-pin (3), sim-pin2 (3), sim-puk (10), > sim-puk2 (10)' > | state: 'locked' > | power state: 'on' > | access tech: 'unknown' > | signal quality: '0' (cached) > ------------------------- > Modes | supported: 'allowed: 2g; preferred: none > | allowed: 3g; preferred: none > | allowed: 2g, 3g; preferred: none' > | current: 'allowed: 2g, 3g; preferred: none' > ------------------------- > Bands | supported: 'egsm, dcs, pcs, g850, u2100, u1900, u850, > u900, u17iv' > | current: 'egsm, dcs, u900' > ------------------------- > IP | supported: 'none' > ------------------------- > SIM | path: '/org/freedesktop/ModemManager1/SIM/7' > > ------------------------- > Bearers | paths: 'none' > > >> 4. provide PIN to unlock the SIM (mmcli -m X -i Y --pin ABCD) > > // mmcli hangs on 3/4 seconds > > successfully sent PIN code to the SIM > > // mmcli hangs on ~2 seconds > // on kernel console the following line is visible: > > [ 1674.800000] tty_port_close_start: tty->count = 1 port count = 0. > > > >> 3. Check modem status using mmcli tool. > > # mmcli -m 0 > > /org/freedesktop/ModemManager1/Modem/0 (device id > 'd085b4f507a00fb98af1e3e35a70c4e00b451b14') > ------------------------- > Hardware | manufacturer: 'Telit' > | model: 'HE910-D' > | revision: '12.00.026' > | supported: 'gsm-umts' > | current: 'gsm-umts' > | equipment id: '351579057922930' > ------------------------- > System | device: '/sys/devices/platform/ehci-brcm.0/usb1/1-1' > | drivers: 'cdc_acm' > | plugin: 'Telit' > | primary port: 'ttyACM0' > | ports: 'ttyACM3 (at), ttyACM4 (unknown), ttyACM5 > (unknown), ttyACM0 (at), ttyACM1 (unknown), ttyACM2 (unknown)' > ------------------------- > Numbers | own : 'unknown' > ------------------------- > Status | lock: 'none' > | unlock retries: 'sim-pin (3), sim-pin2 (3), sim-puk (10), > sim-puk2 (10)' > | state: 'initializing' > | power state: 'on' > | access tech: 'unknown' > | signal quality: '0' (cached) > ------------------------- > Modes | supported: 'allowed: 2g; preferred: none > | allowed: 3g; preferred: none > | allowed: 2g, 3g; preferred: none' > | current: 'allowed: 2g, 3g; preferred: none' > ------------------------- > Bands | supported: 'egsm, dcs, pcs, g850, u2100, u1900, u850, > u900, u17iv' > | current: 'egsm, dcs, u900' > ------------------------- > IP | supported: 'none' > ------------------------- > SIM | path: '/org/freedesktop/ModemManager1/SIM/0' > > ------------------------- > Bearers | paths: 'none' > > > Debug messages from ModemManager on step 4. > > <debug> (ttyACM0) opening serial port... > <debug> (ttyACM0) device open count is 1 (open) > <debug> (ttyACM0): --> 'AT+CPIN="1234"<CR>' > <debug> (ttyACM0): <-- '<CR><LF>OK<CR><LF>' > <debug> checking if unlock required... > <debug> (ttyACM0) device open count is 2 (open) > <debug> (ttyACM0) device open count is 1 (close) > <debug> (ttyACM0): --> 'AT+CPIN?<CR>' > <debug> (ttyACM0): <-- '<CR><LF>' > <debug> (ttyACM0): <-- '+CPIN: READY<CR><LF><CR><LF>OK<CR><LF>' > <debug> (ttyACM0) device open count is 0 (close) > <debug> (ttyACM0) closing serial port... > <debug> (ttyACM0) serial port closed > <debug> (ttyACM0) opening serial port... > <debug> (ttyACM0) device open count is 1 (open) > <debug> (ttyACM0): --> 'AT+CSIM=10,0020000100<CR>' > <warn> No respose for step 1: Serial command timed out > <debug> (ttyACM0) device open count is 2 (open) > <debug> (ttyACM0) device open count is 1 (close) > <debug> (ttyACM0): --> 'AT+CSIM=10,002C000100<CR>' > <warn> No respose for step 2: Serial command timed out > <debug> (ttyACM0) device open count is 2 (open) > <debug> (ttyACM0) device open count is 1 (close) > <debug> (ttyACM0): --> 'AT+CSIM=10,0020008100<CR>' > <warn> No respose for step 3: Sending command failed: 'Resource temporarily > unavailable' > <debug> (ttyACM0) device open count is 2 (open) > <debug> (ttyACM0) device open count is 1 (close) > <debug> (ttyACM0): --> 'AT+CSIM=10,002C008100<CR>' > <warn> No respose for step 4: Sending command failed: 'Resource temporarily > unavailable' </div></div>Looks like the modem got stuck. Are you able to reproduce the issue with other SIM cards? Can you please send also dmesg output when the problem happens? We saw a different behaviour with some specific SIM cards: Carlo is working on a patch for this, that can probably help also with your situation. Please see thread <a href="https://lists.freedesktop.org/archives/modemmanager-devel/2016-May/002953.html" rel="noreferrer" target="_blank">https://lists.freedesktop.org/archives/modemmanager-devel/2016-May/002953.html</a> Regards, Daniele <div><div class="h5"> > <warn> Couldn't load unlock retries: 'Could not get any of the SIM unlock > retries values' > <debug> SIM is ready, and no need for the after SIM unlock step... > <debug> (ttyACM0) device open count is 0 (close) > <debug> (ttyACM0) closing serial port... > <debug> (ttyACM0) serial port closed > <info> Modem /org/freedesktop/ModemManager1/Modem/0: state changed (locked > -> initializing) > <debug> (ttyACM0) opening serial port... > <warn> (ttyACM0) could not open serial device (5) > <warn> Couldn't start initialization: Couldn't open ports during modem > initialization: Couldn't open primary port: Could not open serial device > ttyACM0: Input/output error > <warn> Modem reinitialization failed: 'Modem is unusable, cannot fully > initialize' > > > Debug messages from ModemManager on step 2. > > <debug> [plugin manager] task 0: new support task for device: > /sys/devices/platform/ehci-brcm.0/usb1 > <debug> [plugin manager] task 0: port grabbed: ttyACM0 > <debug> [plugin manager] task 0,ttyACM0: new support task for port > <debug> [plugin manager) task 0,ttyACM0: deferred until min wait time > elapsed > <info> (tty/ttyACM0): released by modem > /sys/devices/platform/ehci-brcm.0/usb1 > <debug> [plugin manager] task 0: port released: ttyACM0 > <debug> Removing empty device '/sys/devices/platform/ehci-brcm.0/usb1' > <debug> [plugin manager) task 0: cancellation requested > <debug> [plugin manager] task 0: no more ports to probe > <debug> [plugin manager] task 0: finished in '0.031896' seconds > <info> Couldn't check support for device at > '/sys/devices/platform/ehci-brcm.0/usb1': Operation was cancelled > <debug> Device support check has been cancelled > <debug> [plugin manager] task 1: new support task for device: > /sys/devices/platform/ehci-brcm.0/usb1/1-1 > <debug> [plugin manager] task 1: port grabbed: ttyACM0 > <debug> [plugin manager] task 1,ttyACM0: new support task for port > <debug> [plugin manager) task 1,ttyACM0: deferred until min wait time > elapsed > <debug> [plugin manager] task 1: port grabbed: ttyACM1 > <debug> [plugin manager] task 1,ttyACM1: new support task for port > <debug> [plugin manager) task 1,ttyACM1: deferred until min wait time > elapsed > <debug> [plugin manager] task 1: port grabbed: ttyACM3 > <debug> [plugin manager] task 1,ttyACM3: new support task for port > <debug> [plugin manager) task 1,ttyACM3: deferred until min wait time > elapsed > <debug> [plugin manager] task 1: port grabbed: ttyACM4 > <debug> [plugin manager] task 1,ttyACM4: new support task for port > <debug> [plugin manager) task 1,ttyACM4: deferred until min wait time > elapsed > <debug> [plugin manager] task 1: port grabbed: ttyACM2 > <debug> [plugin manager] task 1,ttyACM2: new support task for port > <debug> [plugin manager) task 1,ttyACM2: deferred until min wait time > elapsed > <debug> [plugin manager] task 1: port grabbed: ttyACM5 > <debug> [plugin manager] task 1,ttyACM5: new support task for port > <debug> [plugin manager) task 1,ttyACM5: deferred until min wait time > elapsed > <debug> [plugin manager] task 1: min wait time elapsed > <debug> (Haier) [ttyACM5] filtered by vendor/product IDs > <debug> (MTK) [ttyACM5] filtered by udev tags > <debug> (Sierra (legacy)) [ttyACM5] filtered by drivers > <debug> (Altair LTE) [ttyACM5] filtered by vendor/product IDs > <debug> (X22X) [ttyACM5] filtered by vendor/product IDs > <debug> (Linktop) [ttyACM5] filtered by vendor/product IDs > <debug> (Novatel) [ttyACM5] filtered by vendor/product IDs > <debug> (Wavecom) [ttyACM5] filtered by vendor/product IDs > <debug> (Dell) [ttyACM5] filtered by vendor/product IDs > <debug> (Ericsson MBM) [ttyACM5] filtered by udev tags > <debug> (Novatel LTE) [ttyACM5] filtered by vendor/product IDs > <debug> (Huawei) [ttyACM5] filtered by vendor/product IDs > <debug> (AnyDATA) [ttyACM5] filtered by vendor/product IDs > <debug> (Samsung) [ttyACM5] filtered by vendor/product IDs > <debug> (Option High-Speed) [ttyACM5] filtered by drivers > <debug> (ZTE) [ttyACM5] filtered by vendor/product IDs > <debug> (Thuraya) [ttyACM5] filtered by vendor/product IDs > <debug> (Nokia (Icera)) [ttyACM5] filtered by vendor/product IDs > <debug> (Pantech) [ttyACM5] filtered by vendor/product IDs > <debug> (Longcheer) [ttyACM5] filtered by vendor/product IDs > <debug> (Sierra) [ttyACM5] filtered by drivers > <debug> (SimTech) [ttyACM5] filtered by vendor/product IDs > <debug> (Motorola) [ttyACM5] filtered by vendor/product IDs > <debug> (Option) [ttyACM5] filtered by drivers > <debug> [plugin manager] task 1,ttyACM5: found '6' plugins to try > <debug> [plugin manager] task 1,ttyACM5: will try with plugin 'Telit' > <debug> [plugin manager] task 1,ttyACM5: will try with plugin 'Via CBP7' > <debug> [plugin manager] task 1,ttyACM5: will try with plugin 'Iridium' > <debug> [plugin manager] task 1,ttyACM5: will try with plugin 'Cinterion' > <debug> [plugin manager] task 1,ttyACM5: will try with plugin 'Nokia' > <debug> [plugin manager] task 1,ttyACM5: will try with plugin 'Generic' > <debug> [plugin manager) task 1,ttyACM5: started > <debug> [plugin manager] task 1,ttyACM5: checking with plugin 'Telit' > <debug> (Telit) [ttyACM5] probe required: 'at' > <debug> (tty/ttyACM5) launching port probing: 'at' > <debug> (Haier) [ttyACM2] filtered by vendor/product IDs > <debug> (MTK) [ttyACM2] filtered by udev tags > <debug> (Sierra (legacy)) [ttyACM2] filtered by drivers > <debug> (Altair LTE) [ttyACM2] filtered by vendor/product IDs > <debug> (X22X) [ttyACM2] filtered by vendor/product IDs > <debug> (Linktop) [ttyACM2] filtered by vendor/product IDs > <debug> (Novatel) [ttyACM2] filtered by vendor/product IDs > <debug> (Wavecom) [ttyACM2] filtered by vendor/product IDs > <debug> (Dell) [ttyACM2] filtered by vendor/product IDs > <debug> (Ericsson MBM) [ttyACM2] filtered by udev tags > <debug> (Novatel LTE) [ttyACM2] filtered by vendor/product IDs > <debug> (Huawei) [ttyACM2] filtered by vendor/product IDs > <debug> (AnyDATA) [ttyACM2] filtered by vendor/product IDs > <debug> (Samsung) [ttyACM2] filtered by vendor/product IDs > <debug> (Option High-Speed) [ttyACM2] filtered by drivers > <debug> (ZTE) [ttyACM2] filtered by vendor/product IDs > <debug> (Thuraya) [ttyACM2] filtered by vendor/product IDs > <debug> (Nokia (Icera)) [ttyACM2] filtered by vendor/product IDs > <debug> (Pantech) [ttyACM2] filtered by vendor/product IDs > <debug> (Longcheer) [ttyACM2] filtered by vendor/product IDs > <debug> (Sierra) [ttyACM2] filtered by drivers > <debug> (SimTech) [ttyACM2] filtered by vendor/product IDs > <debug> (Motorola) [ttyACM2] filtered by vendor/product IDs > <debug> (Option) [ttyACM2] filtered by drivers > <debug> [plugin manager] task 1,ttyACM2: found '6' plugins to try > <debug> [plugin manager] task 1,ttyACM2: will try with plugin 'Telit' > <debug> [plugin manager] task 1,ttyACM2: will try with plugin 'Via CBP7' > <debug> [plugin manager] task 1,ttyACM2: will try with plugin 'Iridium' > <debug> [plugin manager] task 1,ttyACM2: will try with plugin 'Cinterion' > <debug> [plugin manager] task 1,ttyACM2: will try with plugin 'Nokia' > <debug> [plugin manager] task 1,ttyACM2: will try with plugin 'Generic' > <debug> [plugin manager) task 1,ttyACM2: started > <debug> [plugin manager] task 1,ttyACM2: checking with plugin 'Telit' > <debug> (Telit) [ttyACM2] probe required: 'at' > <debug> (tty/ttyACM2) launching port probing: 'at' > <debug> (Haier) [ttyACM4] filtered by vendor/product IDs > <debug> (MTK) [ttyACM4] filtered by udev tags > <debug> (Sierra (legacy)) [ttyACM4] filtered by drivers > <debug> (Altair LTE) [ttyACM4] filtered by vendor/product IDs > <debug> (X22X) [ttyACM4] filtered by vendor/product IDs > <debug> (Linktop) [ttyACM4] filtered by vendor/product IDs > <debug> (Novatel) [ttyACM4] filtered by vendor/product IDs > <debug> (Wavecom) [ttyACM4] filtered by vendor/product IDs > <debug> (Dell) [ttyACM4] filtered by vendor/product IDs > <debug> (Ericsson MBM) [ttyACM4] filtered by udev tags > <debug> (Novatel LTE) [ttyACM4] filtered by vendor/product IDs > <debug> (Huawei) [ttyACM4] filtered by vendor/product IDs > <debug> (AnyDATA) [ttyACM4] filtered by vendor/product IDs > <debug> (Samsung) [ttyACM4] filtered by vendor/product IDs > <debug> (Option High-Speed) [ttyACM4] filtered by drivers > <debug> (ZTE) [ttyACM4] filtered by vendor/product IDs > <debug> (Thuraya) [ttyACM4] filtered by vendor/product IDs > <debug> (Nokia (Icera)) [ttyACM4] filtered by vendor/product IDs > <debug> (Pantech) [ttyACM4] filtered by vendor/product IDs > <debug> (Longcheer) [ttyACM4] filtered by vendor/product IDs > <debug> (Sierra) [ttyACM4] filtered by drivers > <debug> (SimTech) [ttyACM4] filtered by vendor/product IDs > <debug> (Motorola) [ttyACM4] filtered by vendor/product IDs > <debug> (Option) [ttyACM4] filtered by drivers > <debug> [plugin manager] task 1,ttyACM4: found '6' plugins to try > <debug> [plugin manager] task 1,ttyACM4: will try with plugin 'Telit' > <debug> [plugin manager] task 1,ttyACM4: will try with plugin 'Via CBP7' > <debug> [plugin manager] task 1,ttyACM4: will try with plugin 'Iridium' > <debug> [plugin manager] task 1,ttyACM4: will try with plugin 'Cinterion' > <debug> [plugin manager] task 1,ttyACM4: will try with plugin 'Nokia' > <debug> [plugin manager] task 1,ttyACM4: will try with plugin 'Generic' > <debug> [plugin manager) task 1,ttyACM4: started > <debug> [plugin manager] task 1,ttyACM4: checking with plugin 'Telit' > <debug> (Telit) [ttyACM4] probe required: 'at' > <debug> (tty/ttyACM4) launching port probing: 'at' > <debug> (Haier) [ttyACM3] filtered by vendor/product IDs > <debug> (MTK) [ttyACM3] filtered by udev tags > <debug> (Sierra (legacy)) [ttyACM3] filtered by drivers > <debug> (Altair LTE) [ttyACM3] filtered by vendor/product IDs > <debug> (X22X) [ttyACM3] filtered by vendor/product IDs > <debug> (Linktop) [ttyACM3] filtered by vendor/product IDs > <debug> (Novatel) [ttyACM3] filtered by vendor/product IDs > <debug> (Wavecom) [ttyACM3] filtered by vendor/product IDs > <debug> (Dell) [ttyACM3] filtered by vendor/product IDs > <debug> (Ericsson MBM) [ttyACM3] filtered by udev tags > <debug> (Novatel LTE) [ttyACM3] filtered by vendor/product IDs > <debug> (Huawei) [ttyACM3] filtered by vendor/product IDs > <debug> (AnyDATA) [ttyACM3] filtered by vendor/product IDs > <debug> (Samsung) [ttyACM3] filtered by vendor/product IDs > <debug> (Option High-Speed) [ttyACM3] filtered by drivers > <debug> (ZTE) [ttyACM3] filtered by vendor/product IDs > <debug> (Thuraya) [ttyACM3] filtered by vendor/product IDs > <debug> (Nokia (Icera)) [ttyACM3] filtered by vendor/product IDs > <debug> (Pantech) [ttyACM3] filtered by vendor/product IDs > <debug> (Longcheer) [ttyACM3] filtered by vendor/product IDs > <debug> (Sierra) [ttyACM3] filtered by drivers > <debug> (SimTech) [ttyACM3] filtered by vendor/product IDs > <debug> (Motorola) [ttyACM3] filtered by vendor/product IDs > <debug> (Option) [ttyACM3] filtered by drivers > <debug> [plugin manager] task 1,ttyACM3: found '6' plugins to try > <debug> [plugin manager] task 1,ttyACM3: will try with plugin 'Telit' > <debug> [plugin manager] task 1,ttyACM3: will try with plugin 'Via CBP7' > <debug> [plugin manager] task 1,ttyACM3: will try with plugin 'Iridium' > <debug> [plugin manager] task 1,ttyACM3: will try with plugin 'Cinterion' > <debug> [plugin manager] task 1,ttyACM3: will try with plugin 'Nokia' > <debug> [plugin manager] task 1,ttyACM3: will try with plugin 'Generic' > <debug> [plugin manager) task 1,ttyACM3: started > <debug> [plugin manager] task 1,ttyACM3: checking with plugin 'Telit' > <debug> (Telit) [ttyACM3] probe required: 'at' > <debug> (tty/ttyACM3) launching port probing: 'at' > <debug> (Haier) [ttyACM1] filtered by vendor/product IDs > <debug> (MTK) [ttyACM1] filtered by udev tags > <debug> (Sierra (legacy)) [ttyACM1] filtered by drivers > <debug> (Altair LTE) [ttyACM1] filtered by vendor/product IDs > <debug> (X22X) [ttyACM1] filtered by vendor/product IDs > <debug> (Linktop) [ttyACM1] filtered by vendor/product IDs > <debug> (Novatel) [ttyACM1] filtered by vendor/product IDs > <debug> (Wavecom) [ttyACM1] filtered by vendor/product IDs > <debug> (Dell) [ttyACM1] filtered by vendor/product IDs > <debug> (Ericsson MBM) [ttyACM1] filtered by udev tags > <debug> (Novatel LTE) [ttyACM1] filtered by vendor/product IDs > <debug> (Huawei) [ttyACM1] filtered by vendor/product IDs > <debug> (AnyDATA) [ttyACM1] filtered by vendor/product IDs > <debug> (Samsung) [ttyACM1] filtered by vendor/product IDs > <debug> (Option High-Speed) [ttyACM1] filtered by drivers > <debug> (ZTE) [ttyACM1] filtered by vendor/product IDs > <debug> (Thuraya) [ttyACM1] filtered by vendor/product IDs > <debug> (Nokia (Icera)) [ttyACM1] filtered by vendor/product IDs > <debug> (Pantech) [ttyACM1] filtered by vendor/product IDs > <debug> (Longcheer) [ttyACM1] filtered by vendor/product IDs > <debug> (Sierra) [ttyACM1] filtered by drivers > <debug> (SimTech) [ttyACM1] filtered by vendor/product IDs > <debug> (Motorola) [ttyACM1] filtered by vendor/product IDs > <debug> (Option) [ttyACM1] filtered by drivers > <debug> [plugin manager] task 1,ttyACM1: found '6' plugins to try > <debug> [plugin manager] task 1,ttyACM1: will try with plugin 'Telit' > <debug> [plugin manager] task 1,ttyACM1: will try with plugin 'Via CBP7' > <debug> [plugin manager] task 1,ttyACM1: will try with plugin 'Iridium' > <debug> [plugin manager] task 1,ttyACM1: will try with plugin 'Cinterion' > <debug> [plugin manager] task 1,ttyACM1: will try with plugin 'Nokia' > <debug> [plugin manager] task 1,ttyACM1: will try with plugin 'Generic' > <debug> [plugin manager) task 1,ttyACM1: started > <debug> [plugin manager] task 1,ttyACM1: checking with plugin 'Telit' > <debug> (Telit) [ttyACM1] probe required: 'at' > <debug> (tty/ttyACM1) launching port probing: 'at' > <debug> (Haier) [ttyACM0] filtered by vendor/product IDs > <debug> (MTK) [ttyACM0] filtered by udev tags > <debug> (Sierra (legacy)) [ttyACM0] filtered by drivers > <debug> (Altair LTE) [ttyACM0] filtered by vendor/product IDs > <debug> (X22X) [ttyACM0] filtered by vendor/product IDs > <debug> (Linktop) [ttyACM0] filtered by vendor/product IDs > <debug> (Novatel) [ttyACM0] filtered by vendor/product IDs > <debug> (Wavecom) [ttyACM0] filtered by vendor/product IDs > <debug> (Dell) [ttyACM0] filtered by vendor/product IDs > <debug> (Ericsson MBM) [ttyACM0] filtered by udev tags > <debug> (Novatel LTE) [ttyACM0] filtered by vendor/product IDs > <debug> (Huawei) [ttyACM0] filtered by vendor/product IDs > <debug> (AnyDATA) [ttyACM0] filtered by vendor/product IDs > <debug> (Samsung) [ttyACM0] filtered by vendor/product IDs > <debug> (Option High-Speed) [ttyACM0] filtered by drivers > <debug> (ZTE) [ttyACM0] filtered by vendor/product IDs > <debug> (Thuraya) [ttyACM0] filtered by vendor/product IDs > <debug> (Nokia (Icera)) [ttyACM0] filtered by vendor/product IDs > <debug> (Pantech) [ttyACM0] filtered by vendor/product IDs > <debug> (Longcheer) [ttyACM0] filtered by vendor/product IDs > <debug> (Sierra) [ttyACM0] filtered by drivers > <debug> (SimTech) [ttyACM0] filtered by vendor/product IDs > <debug> (Motorola) [ttyACM0] filtered by vendor/product IDs > <debug> (Option) [ttyACM0] filtered by drivers > <debug> [plugin manager] task 1,ttyACM0: found '6' plugins to try > <debug> [plugin manager] task 1,ttyACM0: will try with plugin 'Telit' > <debug> [plugin manager] task 1,ttyACM0: will try with plugin 'Via CBP7' > <debug> [plugin manager] task 1,ttyACM0: will try with plugin 'Iridium' > <debug> [plugin manager] task 1,ttyACM0: will try with plugin 'Cinterion' > <debug> [plugin manager] task 1,ttyACM0: will try with plugin 'Nokia' > <debug> [plugin manager] task 1,ttyACM0: will try with plugin 'Generic' > <debug> [plugin manager) task 1,ttyACM0: started > <debug> [plugin manager] task 1,ttyACM0: checking with plugin 'Telit' > <debug> (Telit) [ttyACM0] probe required: 'at' > <debug> (tty/ttyACM0) launching port probing: 'at' > <debug> [plugin manager] task 1: min probing time elapsed > <debug> [plugin Manager] task 1: still 6 running probes (6 active): ttyACM5, > ttyACM2, ttyACM4, ttyACM3, ttyACM1, ttyACM0 > <debug> (ttyACM5) opening serial port... > <debug> (ttyACM5) device open count is 1 (open) > <debug> (ttyACM2) opening serial port... > <debug> (ttyACM2) device open count is 1 (open) > <debug> (ttyACM4) opening serial port... > <debug> (ttyACM4) device open count is 1 (open) > <debug> (ttyACM3) opening serial port... > <debug> (ttyACM3) device open count is 1 (open) > <debug> (ttyACM1) opening serial port... > <debug> (ttyACM1) device open count is 1 (open) > <debug> (ttyACM0) opening serial port... > <debug> (ttyACM0) device open count is 1 (open) > <debug> (ttyACM5): --> 'AT<CR>' > <debug> (ttyACM2): --> 'AT<CR>' > <debug> (ttyACM4): --> 'AT<CR>' > <debug> (ttyACM3): --> 'AT<CR>' > <debug> (ttyACM3): <-- 'AT' > <debug> (ttyACM0): --> 'AT#PORTCFG?<CR>' > <debug> (ttyACM1): --> 'AT<CR>' > <debug> (ttyACM3): <-- '<CR><CR><LF>OK<CR><LF>' > <debug> (tty/ttyACM3) port is AT-capable > <debug> [plugin manager] task 1,ttyACM3: found best plugin for port (Telit) > <debug> [plugin manager] task 1,ttyACM3: finished in '3.358319' seconds > <debug> [plugin manager] task 1,ttyACM3: found best plugin: Telit > <debug> [plugin manager] task 1,ttyACM5: got suggested plugin (Telit) > <debug> [plugin manager] task 1,ttyACM2: got suggested plugin (Telit) > <debug> [plugin manager] task 1,ttyACM4: got suggested plugin (Telit) > <debug> [plugin manager] task 1,ttyACM1: got suggested plugin (Telit) > <debug> [plugin manager] task 1,ttyACM0: got suggested plugin (Telit) > <debug> [plugin Manager] task 1: still 5 running probes (5 active): ttyACM5, > ttyACM2, ttyACM4, ttyACM1, ttyACM0 > <debug> (ttyACM3) device open count is 0 (close) > <debug> (ttyACM3) closing serial port... > <debug> (ttyACM3) serial port closed > <debug> (ttyACM3) forced to close port > <debug> (ttyACM0): <-- 'AT#PORTCFG?' > <debug> (ttyACM0): <-- '<CR><CR><LF>#PORTCFG: 1,1<CR><LF><CR><LF>OK<CR><LF>' > <debug> telit: retrieving port mode layout > <debug> (tty/ttyACM0) port is AT-capable > <debug> [plugin manager] task 1,ttyACM0: found best plugin for port (Telit) > <debug> [plugin manager] task 1,ttyACM0: finished in '4.527071' seconds > <debug> [plugin manager] task 1,ttyACM0: best plugin matches device reported > one: Telit > <debug> [plugin Manager] task 1: still 4 running probes (4 active): ttyACM5, > ttyACM2, ttyACM4, ttyACM1 > <debug> (ttyACM0) device open count is 0 (close) > <debug> (ttyACM0) closing serial port... > <debug> (ttyACM0) serial port closed > <debug> (ttyACM0) forced to close port > <debug> Parsing AT got: 'Serial command timed out' > <debug> Parsing AT got: 'Serial command timed out' > <debug> Parsing AT got: 'Serial command timed out' > <debug> Parsing AT got: 'Serial command timed out' > <debug> (ttyACM5): --> 'AT<CR>' > <debug> (ttyACM2): --> 'AT<CR>' > <debug> (ttyACM4): --> 'AT<CR>' > <debug> (ttyACM1): --> 'AT<CR>' > <debug> Parsing AT got: 'Serial command timed out' > <debug> Parsing AT got: 'Serial command timed out' > <debug> Parsing AT got: 'Serial command timed out' > <debug> Parsing AT got: 'Serial command timed out' > <debug> (ttyACM5): --> 'AT<CR>' > <debug> (ttyACM2): --> 'AT<CR>' > <debug> (ttyACM4): --> 'AT<CR>' > <debug> (ttyACM1): --> 'AT<CR>' > <debug> Parsing AT got: 'Serial command timed out' > <debug> (tty/ttyACM5) port is not AT-capable > <debug> [plugin manager] task 1,ttyACM5: found best plugin for port (Telit) > <debug> [plugin manager] task 1,ttyACM5: finished in '12.780406' seconds > <debug> [plugin manager] task 1,ttyACM5: best plugin matches device reported > one: Telit > <debug> [plugin Manager] task 1: still 3 running probes (3 active): ttyACM2, > ttyACM4, ttyACM1 > <debug> (ttyACM5) device open count is 0 (close) > <debug> (ttyACM5) closing serial port... > <debug> (ttyACM5) serial port closed > <debug> (ttyACM5) forced to close port > <debug> Parsing AT got: 'Serial command timed out' > <debug> (tty/ttyACM2) port is not AT-capable > <debug> [plugin manager] task 1,ttyACM2: found best plugin for port (Telit) > <debug> [plugin manager] task 1,ttyACM2: finished in '12.825877' seconds > <debug> [plugin manager] task 1,ttyACM2: best plugin matches device reported > one: Telit > <debug> [plugin Manager] task 1: still 2 running probes (2 active): ttyACM4, > ttyACM1 > <debug> (ttyACM2) device open count is 0 (close) > <debug> (ttyACM2) closing serial port... > <debug> (ttyACM2) serial port closed > <debug> (ttyACM2) forced to close port > <debug> Parsing AT got: 'Serial command timed out' > <debug> (tty/ttyACM4) port is not AT-capable > <debug> [plugin manager] task 1,ttyACM4: found best plugin for port (Telit) > <debug> [plugin manager] task 1,ttyACM4: finished in '12.869475' seconds > <debug> [plugin manager] task 1,ttyACM4: best plugin matches device reported > one: Telit > <debug> [plugin Manager] task 1: still 1 running probes (1 active): ttyACM1 > <debug> (ttyACM4) device open count is 0 (close) > <debug> (ttyACM4) closing serial port... > <debug> (ttyACM4) serial port closed > <debug> (ttyACM4) forced to close port > <debug> Parsing AT got: 'Serial command timed out' > <debug> (tty/ttyACM1) port is not AT-capable > <debug> [plugin manager] task 1,ttyACM1: found best plugin for port (Telit) > <debug> [plugin manager] task 1,ttyACM1: finished in '12.925920' seconds > <debug> [plugin manager] task 1,ttyACM1: best plugin matches device reported > one: Telit > <debug> [plugin manager] task 1: no more ports to probe > <debug> [plugin manager] task 1: finished in '12.974674' seconds > <info> Creating modem with plugin 'Telit' and '6' ports > <debug> (ttyACM5) type 'ignored' claimed by > /sys/devices/platform/ehci-brcm.0/usb1/1-1 > <debug> (ttyACM2) type 'ignored' claimed by > /sys/devices/platform/ehci-brcm.0/usb1/1-1 > <debug> (ttyACM4) type 'ignored' claimed by > /sys/devices/platform/ehci-brcm.0/usb1/1-1 > <debug> telit: AT port 'tty/ttyACM3' flagged as secondary > <debug> (ttyACM3) type 'at' claimed by > /sys/devices/platform/ehci-brcm.0/usb1/1-1 > <debug> (ttyACM1) type 'ignored' claimed by > /sys/devices/platform/ehci-brcm.0/usb1/1-1 > <debug> telit: AT port 'tty/ttyACM0' flagged as primary > <debug> (ttyACM0) type 'at' claimed by > /sys/devices/platform/ehci-brcm.0/usb1/1-1 > <debug> (/sys/devices/platform/ehci-brcm.0/usb1/1-1) tty/ttyACM0 at > (primary) > <debug> (/sys/devices/platform/ehci-brcm.0/usb1/1-1) tty/ttyACM3 at > (secondary) > <debug> (/sys/devices/platform/ehci-brcm.0/usb1/1-1) tty/ttyACM0 data > (primary) > <debug> (ttyACM0) opening serial port... > <debug> (ttyACM0) device open count is 1 (open) > <debug> (ttyACM0): running init sequence... > <debug> (ttyACM0) device open count is 2 (open) > <debug> (ttyACM0) device open count is 3 (open) > <info> Modem for device at '/sys/devices/platform/ehci-brcm.0/usb1/1-1' > successfully created > <debug> (ttyACM1) device open count is 0 (close) > <debug> (ttyACM1) closing serial port... > <debug> (ttyACM1) serial port closed > <debug> (ttyACM1) forced to close port > <debug> loading current capabilities... > <debug> (ttyACM0) device open count is 4 (open) > <debug> (ttyACM0): --> 'ATE0<CR>' > <debug> (ttyACM0): <-- 'ATE0<CR><CR><LF>OK<CR><LF>' > <debug> (ttyACM0): --> 'ATV1<CR>' > <debug> (ttyACM0): <-- '<CR><LF>OK<CR><LF>' > <debug> (ttyACM0): --> 'AT+CMEE=1<CR>' > <debug> (ttyACM0): <-- '<CR><LF>OK<CR><LF>' > <debug> (ttyACM0): --> 'ATX4<CR>' > <debug> (ttyACM0): <-- '<CR><LF>OK<CR><LF>' > <debug> (ttyACM0): --> 'AT&C1<CR>' > <debug> (ttyACM0): <-- '<CR><LF>OK<CR><LF>' > <debug> (ttyACM0): --> 'ATE0<CR>' > <debug> (ttyACM0): <-- '<CR><LF>OK<CR><LF>' > <debug> (ttyACM0) device open count is 3 (close) > <debug> (ttyACM0): --> 'AT+CMEE=1<CR>' > <debug> (ttyACM0): <-- '<CR><LF>OK<CR><LF>' > <debug> (ttyACM0) device open count is 2 (close) > <debug> (ttyACM0): --> 'AT+GCAP<CR>' > <debug> (ttyACM0): <-- '<CR><LF>' > <debug> (ttyACM0): <-- '+GCAP: > +CGSM,+DS,+FCLASS,+MS,+ES<CR><LF><CR><LF>OK<CR><LF>' > <debug> (ttyACM0) device open count is 3 (open) > <debug> (ttyACM0) device open count is 2 (close) > <debug> (ttyACM0): --> 'AT+WS46=?<CR>' > <debug> (ttyACM0): <-- '<CR><LF>' > <debug> (ttyACM0): <-- '+WS46: (12,22,25)<CR><LF><CR><LF>OK<CR><LF>' > <debug> loaded current capabilities: gsm-umts > <debug> Modem allows up to 1 bearers > <debug> Creating bearer list (max: 1, max active: 1) > <debug> loading manufacturer... > <debug> (ttyACM0) device open count is 3 (open) > <debug> (ttyACM0) device open count is 2 (close) > <debug> (ttyACM0): --> 'AT+CGMI<CR>' > <debug> (ttyACM0): <-- '<CR><LF>' > <debug> (ttyACM0): <-- 'Telit<CR><LF><CR><LF>OK<CR><LF>' > <debug> loaded manufacturer: Telit > <debug> loading model... > <debug> (ttyACM0) device open count is 3 (open) > <debug> (ttyACM0) device open count is 2 (close) > <debug> (ttyACM0): --> 'AT+CGMM<CR>' > <debug> (ttyACM0): <-- '<CR><LF>HE910-D<CR><LF><CR><LF>OK<CR><LF>' > <debug> loaded model: HE910-D > <debug> loading revision... > <debug> (ttyACM0) device open count is 3 (open) > <debug> (ttyACM0) device open count is 2 (close) > <debug> (ttyACM0): --> 'AT+CGMR<CR>' > <debug> (ttyACM0): <-- '<CR><LF>12.00.026<CR><LF><CR><LF>OK<CR><LF>' > <debug> loaded revision: 12.00.026 > <debug> loading equipment identifier... > <debug> (ttyACM0) device open count is 3 (open) > <debug> (ttyACM0) device open count is 2 (close) > <debug> (ttyACM0): --> 'AT+CGSN<CR>' > <debug> (ttyACM0): <-- '<CR><LF>351579057922930<CR><LF><CR><LF>OK<CR><LF>' > <debug> loaded equipment identifier: 351579057922930 > <debug> loading device identifier... > <debug> (ttyACM0) device open count is 3 (open) > <debug> (ttyACM0) device open count is 2 (close) > <debug> (ttyACM0): --> 'ATI<CR>' > <debug> (ttyACM0): <-- '<CR><LF>' > <debug> (ttyACM0): <-- '332<CR><LF><CR><LF>OK<CR><LF>' > <debug> Device ID source > '00001bc70000002133235157905792293012.00.026HE910-DTelit' > <debug> Device ID 'd085b4f507a00fb98af1e3e35a70c4e00b451b14' > <debug> loaded device identifier: d085b4f507a00fb98af1e3e35a70c4e00b451b14 > <debug> loading supported modes... > <debug> (ttyACM0) device open count is 3 (open) > <debug> (ttyACM0) device open count is 2 (close) > <debug> (ttyACM0): --> 'AT*CNTI=2<CR>' > <debug> (ttyACM0): <-- '<CR><LF>ERROR<CR><LF>' > <debug> Got failure code 100: Unknown error > <debug> Generic query of supported 3GPP networks with *CNTI failed: 'Unknown > error' > <debug> (ttyACM0) device open count is 3 (open) > <debug> (ttyACM0) device open count is 2 (close) > <debug> Device allows (3GPP) 2G-only network mode > <debug> Device allows (3GPP) 3G-only network mode > <debug> Device allows every supported 3GPP network mode (2G/3G) > <debug> (ttyACM0) device open count is 3 (open) > <debug> (ttyACM0) device open count is 2 (close) > <debug> (ttyACM0): --> 'AT#BND=?<CR>' > <debug> (ttyACM0): <-- '<CR><LF>' > <debug> (ttyACM0): <-- '#BND: (0,3),(0-7)<CR><LF><CR><LF>OK<CR><LF>' > <debug> loading supported IP families... > <debug> (ttyACM0) device open count is 3 (open) > <debug> (ttyACM0) device open count is 2 (close) > <debug> (ttyACM0): --> 'AT+CGDCONT=?<CR>' > <debug> (ttyACM0): <-- '<CR><LF>+CME ERROR: 11<CR><LF>' > <debug> Got failure code 11: SIM PIN required > <warn> couldn't load Supported IP families: 'SIM PIN required' > <debug> loading power state... > <debug> (ttyACM0) device open count is 3 (open) > <debug> (ttyACM0) device open count is 2 (close) > <debug> (ttyACM0): --> 'AT+CFUN?<CR>' > <debug> (ttyACM0): <-- '<CR><LF>' > <debug> (ttyACM0): <-- '+CFUN: 1<CR><LF><CR><LF>OK<CR><LF>' > <debug> checking if unlock required... > <debug> (ttyACM0) device open count is 3 (open) > <debug> (ttyACM0) device open count is 2 (close) > <debug> (ttyACM0): --> 'AT+CPIN?<CR>' > <debug> (ttyACM0): <-- '<CR><LF>+CPIN: SIM PIN<CR><LF><CR><LF>OK<CR><LF>' > <debug> (ttyACM0) device open count is 1 (close) > <debug> (ttyACM0) device open count is 2 (open) > <debug> (ttyACM0): --> 'AT+CSIM=10,0020000100<CR>' > <debug> (ttyACM0): <-- '<CR><LF>+CSIM: 4,"63C3"<CR><LF><CR><LF>OK<CR><LF>' > <debug> PIN unlock retries left: 3 > <debug> (ttyACM0) device open count is 3 (open) > <debug> (ttyACM0) device open count is 2 (close) > <debug> (ttyACM0): --> 'AT+CSIM=10,002C000100<CR>' > <debug> (ttyACM0): <-- '<CR><LF>+CSIM: 4,"63CA"<CR><LF><CR><LF>OK<CR><LF>' > <debug> PUK unlock retries left: 10 > <debug> (ttyACM0) device open count is 3 (open) > <debug> (ttyACM0) device open count is 2 (close) > <debug> (ttyACM0): --> 'AT+CSIM=10,0020008100<CR>' > <debug> (ttyACM0): <-- '<CR><LF>+CSIM: 4,"63C3"<CR><LF><CR><LF>OK<CR><LF>' > <debug> PIN2 unlock retries left: 3 > <debug> (ttyACM0) device open count is 3 (open) > <debug> (ttyACM0) device open count is 2 (close) > <debug> (ttyACM0): --> 'AT+CSIM=10,002C008100<CR>' > <debug> (ttyACM0): <-- '<CR><LF>+CSIM: 4,"63CA"<CR><LF><CR><LF>OK<CR><LF>' > <debug> PUK2 unlock retries left: 10 > <info> Modem: state changed (unknown -> locked) > <debug> (ttyACM0) device open count is 1 (close) > <debug> loading SIM identifier... > <debug> (ttyACM0) device open count is 2 (open) > <debug> (ttyACM0): --> 'AT+CRSM=176,12258,0,0,10<CR>' > <debug> (ttyACM0): <-- '<CR><LF>+CRSM: > 145,11,988430512583766500F6<CR><LF><CR><LF>OK<CR><LF>' > <debug> loaded SIM identifier: 8948031552386756006 > <debug> loading IMSI... > <debug> (ttyACM0) device open count is 3 (open) > <debug> (ttyACM0) device open count is 2 (close) > <debug> (ttyACM0): --> 'AT+CIMI<CR>' > <debug> (ttyACM0): <-- '<CR><LF>+CME ERROR: 11<CR><LF>' > <debug> Got failure code 11: SIM PIN required > <warn> couldn't load IMSI: 'SIM PIN required' > <debug> loading Operator ID... > <debug> (ttyACM0) device open count is 3 (open) > <debug> (ttyACM0) device open count is 2 (close) > <debug> (ttyACM0): --> 'AT+CRSM=176,28589,0,0,4<CR>' > <debug> (ttyACM0): <-- '<CR><LF>+CRSM: > 145,11,00FFFF02<CR><LF><CR><LF>OK<CR><LF>' > <warn> couldn't load Operator identifier: 'Cannot load Operator ID without > IMSI' > <debug> loading Operator Name... > <debug> (ttyACM0) device open count is 3 (open) > <debug> (ttyACM0) device open count is 2 (close) > <debug> (ttyACM0): --> 'AT+CRSM=176,28486,0,0,17<CR>' > <debug> (ttyACM0): <-- '<CR><LF>' > <debug> (ttyACM0): <-- '+CRSM: > 145,11,026E6A75FFFFFFFFFFFFFFFFFFFFFFFFFF<CR><LF><CR><LF>OK<CR><LF>' > <debug> (ttyACM0) device open count is 1 (close) > <debug> loading own numbers... > <debug> (ttyACM0) device open count is 2 (open) > <debug> (ttyACM0): --> 'AT+CNUM<CR>' > <debug> (ttyACM0): <-- '<CR><LF>+CME ERROR: 11<CR><LF>' > <debug> Got failure code 11: SIM PIN required > <warn> couldn't load list of Own Numbers: 'SIM PIN required' > <debug> (ttyACM0) device open count is 3 (open) > <debug> (ttyACM0) device open count is 2 (close) > <debug> (ttyACM0): --> 'AT+WS46?<CR>' > <debug> (ttyACM0): <-- '<CR><LF>+WS46: 25<CR><LF><CR><LF>OK<CR><LF>' > <debug> (ttyACM0) device open count is 3 (open) > <debug> (ttyACM0) device open count is 2 (close) > <debug> (ttyACM0): --> 'AT#BND?<CR>' > <debug> (ttyACM0): <-- '<CR><LF>' > <debug> (ttyACM0): <-- '#BND: 0,5<CR><LF><CR><LF>OK<CR><LF>' > <debug> (ttyACM0) device open count is 1 (close) > <debug> Couldn't initialize interface: 'Firmware not supported' > <debug> (ttyACM0) device open count is 0 (close) > <debug> (ttyACM0) closing serial port... > <debug> (ttyACM0) serial port closed > <debug> Couldn't finish initialization in the current state: 'Modem is > currently locked, cannot fully initialize' > <debug> Exported modem '/sys/devices/platform/ehci-brcm.0/usb1/1-1' at path > '/org/freedesktop/ModemManager1/Modem/0' > <debug> (/org/freedesktop/ModemManager1/Modem/0): 'Telit' modem, VID 0x1BC7 > PID 0x0021 (usb) > > Cheers, > Jaroslaw Bielski > </div></div>> _______________________________________________ > ModemManager-devel mailing list > <a href="mailto:ModemManager-devel@lists.freedesktop.org">ModemManager-devel@lists.freedesktop.org</a> > <a href="https://lists.freedesktop.org/mailman/listinfo/modemmanager-devel" rel="noreferrer" target="_blank">https://lists.freedesktop.org/mailman/listinfo/modemmanager-devel</a> > </blockquote></div> </div>