Dell 5570 (Sierra) supported?

Manuel Lauss manuel.lauss at gmail.com
Mon Dec 1 12:14:52 PST 2014


On Mon, Dec 1, 2014 at 8:15 PM, Dan Williams <dcbw at redhat.com> wrote:
> On Mon, 2014-12-01 at 18:31 +0100, Manuel Lauss wrote:
>> On Wed, Nov 26, 2014 at 9:41 AM, Bjørn Mork <bjorn at mork.no> wrote:
>> > Dan Williams <dcbw at redhat.com> writes:
>> >> On Tue, 2014-11-25 at 20:03 +0100, Manuel Lauss wrote:
>> >>> > On Tue, 2014-11-25 at 19:54 +0100, Manuel Lauss wrote:
>> >>> >
>> >>> >>            |    power state: 'low'
>> >
>> > Ouch.  Now I remembered where I last heard about this modem...
>> > http://ubuntuforums.org/showthread.php?t=2195299&p=12886034#post12886034
>> >
>> > And it most likely does not have anything to do with the modem at all.
>> > It is some Dell laptop rfkill feature we just don't know how to
>> > enable/use.
>> >
>> >>> Well, rfkill list shows only bluetooth and wlan (and nfc card reader).
>> >>> wwan is enabled in BIOS; the dell airplane mode switch acpi device node
>> >>> doesn't do anything (tried to poke all methods with acpi_call).
>> >>
>> >> One more thing to double-check: is the SIM slot under the battery, and
>> >> if so is the battery inserted and correctly seated?  My laptop (an HP,
>> >> not a dell) has some kind of BIOS interlock so that when the battery is
>> >> removed (or poorly secured) it will rfkill the WWAN card automatically
>> >> to prevent SIM hotswapping.
>> >
>> > Smart :-)  Yes, that sounds like something to verify.
>> >
>> > But the fact that there is no wwan switch in the "rfkill list" output is
>> > really a strong indication that we lack support for the wwan switch in
>> > the dell laptop driver (for this laptop variant - it obviously works for
>> > older Dell laptops).
>>
>> I got it semi-working (after disabling airplane mode in windows) in that
>> I can now enable the modem, but it just stays in "looking for network"
>> mode forever, so rfkill is not entirely disabled.
>
> Try:
>
> mmcli -m 0 --3gpp-scan
>
> and wait about 2 or 3 minutes and see what gets printed out.  It may be
> "looking for network" because it can't find one that the SIM is allowed
> to register with.  But doing the scan I show above will at least tell us
> if it can see anything at all.


# mmcli -i 0 --pin=1234
successfully sent PIN code to the SIM
# mmcli -m 0 --enable
successfully enabled the modem
# mmcli -m 0 --3gpp-scan
error: couldn't scan networks in the modem:
'GDBus.Error:org.freedesktop.libmbim.Error.Status.Busy: Busy'

it basically stays in that state forever, on windows it finds the home
network is found almost immediately.

/org/freedesktop/ModemManager1/Modem/0 (device id
'c386bccb7e069b97a8454b1162857416e44ccff6')
  -------------------------
  Hardware |   manufacturer: 'Generic'
           |          model: 'MBIM [413C:81A3]'
           |       revision: 'SWI9X15C_05.05'
           |      supported: 'gsm-umts'
           |        current: 'gsm-umts'
  -------------------------
  System   |         device: '/sys/devices/pci0000:00/0000:00:14.0/usb1/1-10'
           |        drivers: 'cdc_mbim'
           |         plugin: 'Generic'
           |   primary port: 'cdc-wdm0'
           |          ports: 'cdc-wdm0 (mbim), wwan0 (net)'
  -------------------------
  Numbers  |           own : 'unknown'
  -------------------------
  Status   |           lock: 'none'
           | unlock retries: 'sim-pin2 (2)'
           |          state: 'searching'
           |    power state: 'on'
           |    access tech: 'unknown'
           | signal quality: '0' (cached)
  -------------------------
  Modes    |      supported: 'allowed: 2g, 3g; preferred: none'
           |        current: 'allowed: 2g, 3g; preferred: none'
  -------------------------
  Bands    |      supported: 'unknown'
           |        current: 'unknown'
  -------------------------
  IP       |      supported: 'ipv4, ipv6, ipv4v6'
  -------------------------
  3GPP     |  enabled locks: 'sim, fixed-dialing'
           |    operator id: 'unknown'
           |  operator name: 'unknown'
           |   subscription: 'unknown'
           |   registration: 'searching'
  -------------------------
  SIM      |           path: '/org/freedesktop/ModemManager1/SIM/0'

  -------------------------
  Bearers  |          paths: 'none'



Thanks!
-------------- next part --------------
<info>  [000000.000062] [main.c:140] main(): ModemManager (version 1.4.0) starting in system bus...
<debug> [000000.001689] [main.c:65] bus_acquired_cb(): Bus acquired, creating manager...
<debug> [000000.003859] [mm-plugin-manager.c:852] load_plugins(): Looking for plugins in '/usr/lib64/ModemManager'
<debug> [000000.004842] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'ZTE'
<debug> [000000.005056] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Generic'
<debug> [000000.005310] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Via CBP7'
<debug> [000000.005574] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Nokia'
<debug> [000000.005816] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Telit'
<debug> [000000.006188] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'X22X'
<debug> [000000.006569] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'MTK'
<debug> [000000.007301] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'AnyDATA'
<debug> [000000.007687] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'SimTech'
<debug> [000000.008365] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Huawei'
<debug> [000000.008750] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Iridium'
<debug> [000000.009004] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Pantech'
<debug> [000000.009530] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Nokia (Icera)'
<debug> [000000.009777] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Motorola'
<debug> [000000.010182] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Altair LTE'
<debug> [000000.010626] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Option High-Speed'
<debug> [000000.011020] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Wavecom'
<debug> [000000.011476] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Cinterion'
<debug> [000000.011738] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Gobi'
<debug> [000000.011996] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Linktop'
<debug> [000000.012658] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Sierra'
<debug> [000000.013001] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Longcheer'
<debug> [000000.013419] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Ericsson MBM'
<debug> [000000.013934] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Samsung'
<debug> [000000.014806] [mm-plugin-manager.c:877] load_plugins(): Loaded plugin 'Option'
<debug> [000000.014811] [mm-plugin-manager.c:902] load_plugins(): Successfully loaded 25 plugins
<debug> [000000.015174] [main.c:87] name_acquired_cb(): Service name 'org.freedesktop.ModemManager1' was acquired
<debug> [000000.015181] [mm-base-manager.c:479] mm_base_manager_start(): Starting automatic device scan...
<debug> [000000.016257] [mm-base-manager.c:518] mm_base_manager_start(): Finished device scan...
<debug> [000000.016454] [mm-plugin-manager.c:739] mm_plugin_manager_find_device_support(): (Plugin Manager) [/sys/devices/pci0000:00/0000:00:16.3] Checking device support...
<debug> [000000.016498] [mm-plugin.c:326] apply_pre_probing_filters(): (ZTE) [ttyS0] filtered by vendor/product IDs
<debug> [000000.016502] [mm-plugin.c:326] apply_pre_probing_filters(): (Telit) [ttyS0] filtered by vendor/product IDs
<debug> [000000.016503] [mm-plugin.c:326] apply_pre_probing_filters(): (X22X) [ttyS0] filtered by vendor/product IDs
<debug> [000000.016505] [mm-plugin.c:380] apply_pre_probing_filters(): (MTK) [ttyS0] filtered by udev tags
<debug> [000000.016506] [mm-plugin.c:326] apply_pre_probing_filters(): (AnyDATA) [ttyS0] filtered by vendor/product IDs
<debug> [000000.016508] [mm-plugin.c:326] apply_pre_probing_filters(): (SimTech) [ttyS0] filtered by vendor/product IDs
<debug> [000000.016509] [mm-plugin.c:326] apply_pre_probing_filters(): (Huawei) [ttyS0] filtered by vendor/product IDs
<debug> [000000.016511] [mm-plugin.c:326] apply_pre_probing_filters(): (Pantech) [ttyS0] filtered by vendor/product IDs
<debug> [000000.016512] [mm-plugin.c:326] apply_pre_probing_filters(): (Nokia (Icera)) [ttyS0] filtered by vendor/product IDs
<debug> [000000.016515] [mm-plugin.c:326] apply_pre_probing_filters(): (Motorola) [ttyS0] filtered by vendor/product IDs
<debug> [000000.016516] [mm-plugin.c:326] apply_pre_probing_filters(): (Altair LTE) [ttyS0] filtered by vendor/product IDs
<debug> [000000.016517] [mm-plugin.c:253] apply_pre_probing_filters(): (Option High-Speed) [ttyS0] filtered by drivers
<debug> [000000.016519] [mm-plugin.c:326] apply_pre_probing_filters(): (Wavecom) [ttyS0] filtered by vendor/product IDs
<debug> [000000.016521] [mm-plugin.c:253] apply_pre_probing_filters(): (Gobi) [ttyS0] filtered by drivers
<debug> [000000.016522] [mm-plugin.c:326] apply_pre_probing_filters(): (Linktop) [ttyS0] filtered by vendor/product IDs
<debug> [000000.016523] [mm-plugin.c:253] apply_pre_probing_filters(): (Sierra) [ttyS0] filtered by drivers
<debug> [000000.016525] [mm-plugin.c:326] apply_pre_probing_filters(): (Longcheer) [ttyS0] filtered by vendor/product IDs
<debug> [000000.016526] [mm-plugin.c:380] apply_pre_probing_filters(): (Ericsson MBM) [ttyS0] filtered by udev tags
<debug> [000000.016528] [mm-plugin.c:326] apply_pre_probing_filters(): (Samsung) [ttyS0] filtered by vendor/product IDs
<debug> [000000.016529] [mm-plugin.c:253] apply_pre_probing_filters(): (Option) [ttyS0] filtered by drivers
<debug> [000000.016530] [mm-plugin-manager.c:640] build_plugins_list(): (Plugin Manager) [ttyS0] Found '5' plugins to try...
<debug> [000000.016532] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [ttyS0]   Will try with plugin 'Via CBP7'
<debug> [000000.016533] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [ttyS0]   Will try with plugin 'Nokia'
<debug> [000000.016535] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [ttyS0]   Will try with plugin 'Iridium'
<debug> [000000.016536] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [ttyS0]   Will try with plugin 'Cinterion'
<debug> [000000.016537] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [ttyS0]   Will try with plugin 'Generic'
<debug> [000000.016918] [mm-plugin.c:767] mm_plugin_supports_port(): (Via CBP7) [ttyS0] probe required: 'at, at-vendor, at-product'
<debug> [000000.016928] [mm-port-probe.c:1353] mm_port_probe_run(): (tty/ttyS0) launching port probing: 'at, at-vendor, at-product'
<debug> [000000.017200] [mm-base-manager.c:290] device_added(): (tty/ttyprintk): could not get port's parent device
<debug> [000000.017279] [mm-plugin-manager.c:739] mm_plugin_manager_find_device_support(): (Plugin Manager) [/sys/devices/pci0000:00/0000:00:14.0/usb1/1-10] Checking device support...
<debug> [000000.017301] [mm-plugin.c:326] apply_pre_probing_filters(): (ZTE) [wwan0] filtered by vendor/product IDs
<debug> [000000.017303] [mm-plugin.c:212] apply_pre_probing_filters(): (Via CBP7) [wwan0] filtered by subsystem
<debug> [000000.017304] [mm-plugin.c:212] apply_pre_probing_filters(): (Nokia) [wwan0] filtered by subsystem
<debug> [000000.017306] [mm-plugin.c:212] apply_pre_probing_filters(): (Telit) [wwan0] filtered by subsystem
<debug> [000000.017307] [mm-plugin.c:326] apply_pre_probing_filters(): (X22X) [wwan0] filtered by vendor/product IDs
<debug> [000000.017309] [mm-plugin.c:212] apply_pre_probing_filters(): (MTK) [wwan0] filtered by subsystem
<debug> [000000.017310] [mm-plugin.c:326] apply_pre_probing_filters(): (AnyDATA) [wwan0] filtered by vendor/product IDs
<debug> [000000.017312] [mm-plugin.c:212] apply_pre_probing_filters(): (SimTech) [wwan0] filtered by subsystem
<debug> [000000.017313] [mm-plugin.c:326] apply_pre_probing_filters(): (Huawei) [wwan0] filtered by vendor/product IDs
<debug> [000000.017314] [mm-plugin.c:212] apply_pre_probing_filters(): (Iridium) [wwan0] filtered by subsystem
<debug> [000000.017316] [mm-plugin.c:326] apply_pre_probing_filters(): (Pantech) [wwan0] filtered by vendor/product IDs
<debug> [000000.017317] [mm-plugin.c:326] apply_pre_probing_filters(): (Nokia (Icera)) [wwan0] filtered by vendor/product IDs
<debug> [000000.017319] [mm-plugin.c:212] apply_pre_probing_filters(): (Motorola) [wwan0] filtered by subsystem
<debug> [000000.017321] [mm-plugin.c:326] apply_pre_probing_filters(): (Altair LTE) [wwan0] filtered by vendor/product IDs
<debug> [000000.017322] [mm-plugin.c:253] apply_pre_probing_filters(): (Option High-Speed) [wwan0] filtered by drivers
<debug> [000000.017324] [mm-plugin.c:212] apply_pre_probing_filters(): (Wavecom) [wwan0] filtered by subsystem
<debug> [000000.017325] [mm-plugin.c:326] apply_pre_probing_filters(): (Cinterion) [wwan0] filtered by vendor/product IDs
<debug> [000000.017326] [mm-plugin.c:253] apply_pre_probing_filters(): (Gobi) [wwan0] filtered by drivers
<debug> [000000.017328] [mm-plugin.c:212] apply_pre_probing_filters(): (Linktop) [wwan0] filtered by subsystem
<debug> [000000.017329] [mm-plugin.c:253] apply_pre_probing_filters(): (Sierra) [wwan0] filtered by drivers
<debug> [000000.017331] [mm-plugin.c:212] apply_pre_probing_filters(): (Longcheer) [wwan0] filtered by subsystem
<debug> [000000.017332] [mm-plugin.c:380] apply_pre_probing_filters(): (Ericsson MBM) [wwan0] filtered by udev tags
<debug> [000000.017334] [mm-plugin.c:326] apply_pre_probing_filters(): (Samsung) [wwan0] filtered by vendor/product IDs
<debug> [000000.017335] [mm-plugin.c:212] apply_pre_probing_filters(): (Option) [wwan0] filtered by subsystem
<debug> [000000.017336] [mm-plugin-manager.c:640] build_plugins_list(): (Plugin Manager) [wwan0] Found '1' plugins to try...
<debug> [000000.017338] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [wwan0]   Will try with plugin 'Generic'
<debug> [000000.017340] [mm-plugin.c:689] mm_plugin_supports_port(): (Generic) [wwan0] probing deferred until result suggested
<debug> [000000.017399] [mm-plugin-manager.c:739] mm_plugin_manager_find_device_support(): (Plugin Manager) [/sys/devices/pci0000:00/0000:00:19.0] Checking device support...
<debug> [000000.017416] [mm-plugin.c:326] apply_pre_probing_filters(): (ZTE) [eno1] filtered by vendor/product IDs
<debug> [000000.017418] [mm-plugin.c:212] apply_pre_probing_filters(): (Via CBP7) [eno1] filtered by subsystem
<debug> [000000.017419] [mm-plugin.c:212] apply_pre_probing_filters(): (Nokia) [eno1] filtered by subsystem
<debug> [000000.017421] [mm-plugin.c:212] apply_pre_probing_filters(): (Telit) [eno1] filtered by subsystem
<debug> [000000.017422] [mm-plugin.c:326] apply_pre_probing_filters(): (X22X) [eno1] filtered by vendor/product IDs
<debug> [000000.017424] [mm-plugin.c:212] apply_pre_probing_filters(): (MTK) [eno1] filtered by subsystem
<debug> [000000.017425] [mm-plugin.c:326] apply_pre_probing_filters(): (AnyDATA) [eno1] filtered by vendor/product IDs
<debug> [000000.017426] [mm-plugin.c:212] apply_pre_probing_filters(): (SimTech) [eno1] filtered by subsystem
<debug> [000000.017428] [mm-plugin.c:326] apply_pre_probing_filters(): (Huawei) [eno1] filtered by vendor/product IDs
<debug> [000000.017429] [mm-plugin.c:212] apply_pre_probing_filters(): (Iridium) [eno1] filtered by subsystem
<debug> [000000.017430] [mm-plugin.c:326] apply_pre_probing_filters(): (Pantech) [eno1] filtered by vendor/product IDs
<debug> [000000.017432] [mm-plugin.c:326] apply_pre_probing_filters(): (Nokia (Icera)) [eno1] filtered by vendor/product IDs
<debug> [000000.017433] [mm-plugin.c:212] apply_pre_probing_filters(): (Motorola) [eno1] filtered by subsystem
<debug> [000000.017434] [mm-plugin.c:326] apply_pre_probing_filters(): (Altair LTE) [eno1] filtered by vendor/product IDs
<debug> [000000.017436] [mm-plugin.c:253] apply_pre_probing_filters(): (Option High-Speed) [eno1] filtered by drivers
<debug> [000000.017437] [mm-plugin.c:212] apply_pre_probing_filters(): (Wavecom) [eno1] filtered by subsystem
<debug> [000000.017439] [mm-plugin.c:326] apply_pre_probing_filters(): (Cinterion) [eno1] filtered by vendor/product IDs
<debug> [000000.017440] [mm-plugin.c:253] apply_pre_probing_filters(): (Gobi) [eno1] filtered by drivers
<debug> [000000.017441] [mm-plugin.c:212] apply_pre_probing_filters(): (Linktop) [eno1] filtered by subsystem
<debug> [000000.017444] [mm-plugin.c:253] apply_pre_probing_filters(): (Sierra) [eno1] filtered by drivers
<debug> [000000.017445] [mm-plugin.c:212] apply_pre_probing_filters(): (Longcheer) [eno1] filtered by subsystem
<debug> [000000.017447] [mm-plugin.c:380] apply_pre_probing_filters(): (Ericsson MBM) [eno1] filtered by udev tags
<debug> [000000.017448] [mm-plugin.c:326] apply_pre_probing_filters(): (Samsung) [eno1] filtered by vendor/product IDs
<debug> [000000.017450] [mm-plugin.c:212] apply_pre_probing_filters(): (Option) [eno1] filtered by subsystem
<debug> [000000.017451] [mm-plugin-manager.c:640] build_plugins_list(): (Plugin Manager) [eno1] Found '1' plugins to try...
<debug> [000000.017452] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [eno1]   Will try with plugin 'Generic'
<debug> [000000.017454] [mm-plugin.c:689] mm_plugin_supports_port(): (Generic) [eno1] probing deferred until result suggested
<debug> [000000.017512] [mm-plugin-manager.c:739] mm_plugin_manager_find_device_support(): (Plugin Manager) [/sys/devices/pci0000:00/0000:00:1c.2/0000:03:00.0] Checking device support...
<debug> [000000.017528] [mm-plugin.c:326] apply_pre_probing_filters(): (ZTE) [wlp3s0] filtered by vendor/product IDs
<debug> [000000.017530] [mm-plugin.c:212] apply_pre_probing_filters(): (Via CBP7) [wlp3s0] filtered by subsystem
<debug> [000000.017531] [mm-plugin.c:212] apply_pre_probing_filters(): (Nokia) [wlp3s0] filtered by subsystem
<debug> [000000.017532] [mm-plugin.c:212] apply_pre_probing_filters(): (Telit) [wlp3s0] filtered by subsystem
<debug> [000000.017534] [mm-plugin.c:326] apply_pre_probing_filters(): (X22X) [wlp3s0] filtered by vendor/product IDs
<debug> [000000.017535] [mm-plugin.c:212] apply_pre_probing_filters(): (MTK) [wlp3s0] filtered by subsystem
<debug> [000000.017537] [mm-plugin.c:326] apply_pre_probing_filters(): (AnyDATA) [wlp3s0] filtered by vendor/product IDs
<debug> [000000.017538] [mm-plugin.c:212] apply_pre_probing_filters(): (SimTech) [wlp3s0] filtered by subsystem
<debug> [000000.017539] [mm-plugin.c:326] apply_pre_probing_filters(): (Huawei) [wlp3s0] filtered by vendor/product IDs
<debug> [000000.017541] [mm-plugin.c:212] apply_pre_probing_filters(): (Iridium) [wlp3s0] filtered by subsystem
<debug> [000000.017542] [mm-plugin.c:326] apply_pre_probing_filters(): (Pantech) [wlp3s0] filtered by vendor/product IDs
<debug> [000000.017543] [mm-plugin.c:326] apply_pre_probing_filters(): (Nokia (Icera)) [wlp3s0] filtered by vendor/product IDs
<debug> [000000.017545] [mm-plugin.c:212] apply_pre_probing_filters(): (Motorola) [wlp3s0] filtered by subsystem
<debug> [000000.017546] [mm-plugin.c:326] apply_pre_probing_filters(): (Altair LTE) [wlp3s0] filtered by vendor/product IDs
<debug> [000000.017547] [mm-plugin.c:253] apply_pre_probing_filters(): (Option High-Speed) [wlp3s0] filtered by drivers
<debug> [000000.017549] [mm-plugin.c:212] apply_pre_probing_filters(): (Wavecom) [wlp3s0] filtered by subsystem
<debug> [000000.017550] [mm-plugin.c:326] apply_pre_probing_filters(): (Cinterion) [wlp3s0] filtered by vendor/product IDs
<debug> [000000.017552] [mm-plugin.c:253] apply_pre_probing_filters(): (Gobi) [wlp3s0] filtered by drivers
<debug> [000000.017553] [mm-plugin.c:212] apply_pre_probing_filters(): (Linktop) [wlp3s0] filtered by subsystem
<debug> [000000.017554] [mm-plugin.c:253] apply_pre_probing_filters(): (Sierra) [wlp3s0] filtered by drivers
<debug> [000000.017556] [mm-plugin.c:212] apply_pre_probing_filters(): (Longcheer) [wlp3s0] filtered by subsystem
<debug> [000000.017557] [mm-plugin.c:380] apply_pre_probing_filters(): (Ericsson MBM) [wlp3s0] filtered by udev tags
<debug> [000000.017559] [mm-plugin.c:326] apply_pre_probing_filters(): (Samsung) [wlp3s0] filtered by vendor/product IDs
<debug> [000000.017560] [mm-plugin.c:212] apply_pre_probing_filters(): (Option) [wlp3s0] filtered by subsystem
<debug> [000000.017561] [mm-plugin-manager.c:640] build_plugins_list(): (Plugin Manager) [wlp3s0] Found '1' plugins to try...
<debug> [000000.017563] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [wlp3s0]   Will try with plugin 'Generic'
<debug> [000000.017566] [mm-plugin.c:689] mm_plugin_supports_port(): (Generic) [wlp3s0] probing deferred until result suggested
<debug> [000000.017590] [mm-base-manager.c:290] device_added(): (net/gre0): could not get port's parent device
<debug> [000000.017612] [mm-base-manager.c:290] device_added(): (net/gretap0): could not get port's parent device
<debug> [000000.017632] [mm-base-manager.c:290] device_added(): (net/ip6_vti0): could not get port's parent device
<debug> [000000.017653] [mm-base-manager.c:290] device_added(): (net/ip6gre0): could not get port's parent device
<debug> [000000.017673] [mm-base-manager.c:290] device_added(): (net/ip6tnl0): could not get port's parent device
<debug> [000000.017700] [mm-base-manager.c:290] device_added(): (net/ip_vti0): could not get port's parent device
<debug> [000000.017738] [mm-base-manager.c:290] device_added(): (net/sit0): could not get port's parent device
<debug> [000000.017761] [mm-base-manager.c:290] device_added(): (net/teql0): could not get port's parent device
<debug> [000000.017782] [mm-base-manager.c:290] device_added(): (net/tunl0): could not get port's parent device
<debug> [000000.017858] [mm-plugin.c:326] apply_pre_probing_filters(): (ZTE) [cdc-wdm0] filtered by vendor/product IDs
<debug> [000000.017860] [mm-plugin.c:212] apply_pre_probing_filters(): (Via CBP7) [cdc-wdm0] filtered by subsystem
<debug> [000000.017861] [mm-plugin.c:212] apply_pre_probing_filters(): (Nokia) [cdc-wdm0] filtered by subsystem
<debug> [000000.017863] [mm-plugin.c:212] apply_pre_probing_filters(): (Telit) [cdc-wdm0] filtered by subsystem
<debug> [000000.017864] [mm-plugin.c:326] apply_pre_probing_filters(): (X22X) [cdc-wdm0] filtered by vendor/product IDs
<debug> [000000.017865] [mm-plugin.c:212] apply_pre_probing_filters(): (MTK) [cdc-wdm0] filtered by subsystem
<debug> [000000.017867] [mm-plugin.c:326] apply_pre_probing_filters(): (AnyDATA) [cdc-wdm0] filtered by vendor/product IDs
<debug> [000000.017868] [mm-plugin.c:212] apply_pre_probing_filters(): (SimTech) [cdc-wdm0] filtered by subsystem
<debug> [000000.017869] [mm-plugin.c:326] apply_pre_probing_filters(): (Huawei) [cdc-wdm0] filtered by vendor/product IDs
<debug> [000000.017870] [mm-plugin.c:212] apply_pre_probing_filters(): (Iridium) [cdc-wdm0] filtered by subsystem
<debug> [000000.017872] [mm-plugin.c:326] apply_pre_probing_filters(): (Pantech) [cdc-wdm0] filtered by vendor/product IDs
<debug> [000000.017873] [mm-plugin.c:212] apply_pre_probing_filters(): (Nokia (Icera)) [cdc-wdm0] filtered by subsystem
<debug> [000000.017874] [mm-plugin.c:212] apply_pre_probing_filters(): (Motorola) [cdc-wdm0] filtered by subsystem
<debug> [000000.017875] [mm-plugin.c:212] apply_pre_probing_filters(): (Altair LTE) [cdc-wdm0] filtered by subsystem
<debug> [000000.017876] [mm-plugin.c:212] apply_pre_probing_filters(): (Option High-Speed) [cdc-wdm0] filtered by subsystem
<debug> [000000.017878] [mm-plugin.c:212] apply_pre_probing_filters(): (Wavecom) [cdc-wdm0] filtered by subsystem
<debug> [000000.017879] [mm-plugin.c:326] apply_pre_probing_filters(): (Cinterion) [cdc-wdm0] filtered by vendor/product IDs
<debug> [000000.017880] [mm-plugin.c:253] apply_pre_probing_filters(): (Gobi) [cdc-wdm0] filtered by drivers
<debug> [000000.017882] [mm-plugin.c:212] apply_pre_probing_filters(): (Linktop) [cdc-wdm0] filtered by subsystem
<debug> [000000.017883] [mm-plugin.c:253] apply_pre_probing_filters(): (Sierra) [cdc-wdm0] filtered by drivers
<debug> [000000.017884] [mm-plugin.c:212] apply_pre_probing_filters(): (Longcheer) [cdc-wdm0] filtered by subsystem
<debug> [000000.017886] [mm-plugin.c:380] apply_pre_probing_filters(): (Ericsson MBM) [cdc-wdm0] filtered by udev tags
<debug> [000000.017887] [mm-plugin.c:212] apply_pre_probing_filters(): (Samsung) [cdc-wdm0] filtered by subsystem
<debug> [000000.017888] [mm-plugin.c:212] apply_pre_probing_filters(): (Option) [cdc-wdm0] filtered by subsystem
<debug> [000000.017889] [mm-plugin-manager.c:640] build_plugins_list(): (Plugin Manager) [cdc-wdm0] Found '1' plugins to try...
<debug> [000000.017891] [mm-plugin-manager.c:644] build_plugins_list(): (Plugin Manager) [cdc-wdm0]   Will try with plugin 'Generic'
<debug> [000000.017896] [mm-plugin.c:767] mm_plugin_supports_port(): (Generic) [cdc-wdm0] probe required: 'mbim'
<debug> [000000.017898] [mm-port-probe.c:1353] mm_port_probe_run(): (usbmisc/cdc-wdm0) launching port probing: 'mbim'
<debug> [000000.017954] [mm-plugin-manager.c:569] plugin_supports_port_ready(): (Plugin Manager) [wwan0] deferring support check until result suggested
<debug> [000000.017959] [mm-plugin-manager.c:569] plugin_supports_port_ready(): (Plugin Manager) [eno1] deferring support check until result suggested
<debug> [000000.017961] [mm-plugin-manager.c:569] plugin_supports_port_ready(): (Plugin Manager) [wlp3s0] deferring support check until result suggested
<debug> [000000.018111] [mm-port-serial.c:1099] mm_port_serial_open(): (ttyS0) opening serial port...
<debug> [000000.018215] [mm-port-serial.c:1237] mm_port_serial_open(): (ttyS0) device open count is 1 (open)
<debug> [000000.018232] [mm-port-probe.c:523] wdm_probe_mbim(): (usbmisc/cdc-wdm0) probing MBIM...
opening device...[/dev/cdc-wdm0] Queried max control message size: 4096[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<<   length = 16
<<<<<<   data   = 01:00:00:00:10:00:00:00:01:00:00:00:00:10:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 16
<<<<<<   type        = open (0x00000001)
<<<<<<   transaction = 1
<<<<<< Contents:
<<<<<<   max_control_transfer = 4096
<debug> [000000.119208] [mm-port-serial-at.c:440] debug_log(): (ttyS0): --> 'AT<CR>'
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>>   length = 16
>>>>>>   data   = 01:00:00:80:10:00:00:00:01:00:00:00:00:00:00:00
<debug> [000000.444338] [mm-port-probe.c:301] mm_port_probe_set_result_mbim(): (usbmisc/cdc-wdm0) port is MBIM-capable
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<<   length = 12
<<<<<<   data   = 02:00:00:00:0C:00:00:00:02:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 12
<<<<<<   type        = close (0x00000002)
<<<<<<   transaction = 2
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>>   length = 16
>>>>>>   data   = 02:00:00:80:10:00:00:00:02:00:00:00:00:00:00:00
<debug> [000000.572352] [mm-plugin-manager.c:462] plugin_supports_port_ready(): (Plugin Manager) (Generic) [cdc-wdm0] found best plugin for port
<debug> [000000.572368] [mm-plugin-manager.c:361] suggest_single_port_probe_result(): (Plugin Manager) (Generic) [wwan0] deferred task completed, got suggested plugin
<debug> [000000.572378] [mm-plugin-manager.c:305] port_probe_context_finished(): (Plugin Manager) 'cdc-wdm0' port probe finished, still 1 running probes in this device (wwan0)
<debug> [000000.572392] [mm-plugin.c:689] mm_plugin_supports_port(): (Generic) [wwan0] probing deferred until result suggested
<debug> [000000.572398] [mm-plugin-manager.c:549] plugin_supports_port_ready(): (Plugin Manager) (Generic) [wwan0] task completed, got suggested plugin
<debug> [000000.572403] [mm-plugin-manager.c:313] port_probe_context_finished(): (Plugin Manager) 'wwan0' port probe finished, last one in device, but minimum probing time not consumed yet ('0.555119' seconds elapsed)
<debug> [000002.301217] [mm-plugin-manager.c:710] min_probing_timeout_cb(): (Plugin Manager) [/sys/devices/pci0000:00/0000:00:16.3] Minimum probing time consumed
<debug> [000002.301235] [mm-plugin-manager.c:703] min_probing_timeout_cb(): (Plugin Manager) [/sys/devices/pci0000:00/0000:00:14.0/usb1/1-10] Minimum probing time consumed and no more ports to probe
<debug> [000002.301240] [mm-plugin-manager.c:138] find_device_support_context_complete_and_free(): (Plugin Manager) [/sys/devices/pci0000:00/0000:00:14.0/usb1/1-10] device support check finished in '2.283956' seconds
<info>  [000002.301259] [mm-device.c:509] mm_device_create_modem(): Creating modem with plugin 'Generic' and '2' ports
<debug> [000002.301270] [generic/mm-plugin-generic.c:73] create_modem(): MBIM-powered generic modem found...
<debug> [000002.302032] [mm-base-modem.c:304] mm_base_modem_grab_port(): (cdc-wdm0) type 'mbim' claimed by /sys/devices/pci0000:00/0000:00:14.0/usb1/1-10
<debug> [000002.302046] [mm-base-modem.c:304] mm_base_modem_grab_port(): (wwan0) type 'net' claimed by /sys/devices/pci0000:00/0000:00:14.0/usb1/1-10
<debug> [000002.302051] [mm-base-modem.c:970] log_port(): (/sys/devices/pci0000:00/0000:00:14.0/usb1/1-10) net/wwan0 data (primary)
<debug> [000002.302054] [mm-base-modem.c:970] log_port(): (/sys/devices/pci0000:00/0000:00:14.0/usb1/1-10) usb/cdc-wdm0 mbim (primary)
<info>  [000002.302177] [mm-base-manager.c:162] find_device_support_ready(): Modem for device at '/sys/devices/pci0000:00/0000:00:14.0/usb1/1-10' successfully created
<debug> [000002.302189] [mm-plugin-manager.c:710] min_probing_timeout_cb(): (Plugin Manager) [/sys/devices/pci0000:00/0000:00:19.0] Minimum probing time consumed
<debug> [000002.302191] [mm-plugin-manager.c:368] suggest_single_port_probe_result(): (Plugin Manager) [eno1] deferred task cancelled, no suggested plugin
<debug> [000002.302196] [mm-plugin-manager.c:710] min_probing_timeout_cb(): (Plugin Manager) [/sys/devices/pci0000:00/0000:00:1c.2/0000:03:00.0] Minimum probing time consumed
<debug> [000002.302198] [mm-plugin-manager.c:368] suggest_single_port_probe_result(): (Plugin Manager) [wlp3s0] deferred task cancelled, no suggested plugin
<debug> [000002.302207] [mm-plugin-manager.c:195] port_probe_context_finished(): (Plugin Manager) [eno1] not supported by any plugin
<debug> [000002.302210] [mm-device.c:357] mm_device_ignore_port(): Fully ignoring port 'net/eno1' from now on
<debug> [000002.302213] [mm-plugin-manager.c:316] port_probe_context_finished(): (Plugin Manager) 'eno1' port probe finished, last one in device
<debug> [000002.302214] [mm-plugin-manager.c:138] find_device_support_context_complete_and_free(): (Plugin Manager) [/sys/devices/pci0000:00/0000:00:19.0] device support check finished in '2.284809' seconds
<warn>  [000002.302239] [mm-base-manager.c:153] find_device_support_ready(): Couldn't find support for device at '/sys/devices/pci0000:00/0000:00:19.0': not supported by any plugin
<debug> [000002.302248] [mm-plugin-manager.c:195] port_probe_context_finished(): (Plugin Manager) [wlp3s0] not supported by any plugin
<debug> [000002.302250] [mm-device.c:357] mm_device_ignore_port(): Fully ignoring port 'net/wlp3s0' from now on
<debug> [000002.302252] [mm-plugin-manager.c:316] port_probe_context_finished(): (Plugin Manager) 'wlp3s0' port probe finished, last one in device
<debug> [000002.302254] [mm-plugin-manager.c:138] find_device_support_context_complete_and_free(): (Plugin Manager) [/sys/devices/pci0000:00/0000:00:1c.2/0000:03:00.0] device support check finished in '2.284738' seconds
<warn>  [000002.302257] [mm-base-manager.c:153] find_device_support_ready(): Couldn't find support for device at '/sys/devices/pci0000:00/0000:00:1c.2/0000:03:00.0': not supported by any plugin
opening device...[/dev/cdc-wdm0] Queried max control message size: 4096[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<<   length = 16
<<<<<<   data   = 01:00:00:00:10:00:00:00:01:00:00:00:00:10:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 16
<<<<<<   type        = open (0x00000001)
<<<<<<   transaction = 1
<<<<<< Contents:
<<<<<<   max_control_transfer = 4096
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>>   length = 16
>>>>>>   data   = 01:00:00:80:10:00:00:00:01:00:00:00:00:00:00:00
<debug> [000002.620327] [mm-broadband-modem-mbim.c:1289] parent_initialization_started_ready(): Couldn't start parent initialization: Couldn't open ports during modem initialization: Couldn't get primary port
<debug> [000002.621083] [mm-broadband-modem-mbim.c:210] modem_load_current_capabilities(): loading current capabilities...
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<<   length = 48
<<<<<<   data   = 03:00:00:00:30:00:00:00:02:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:01:00:00:00:00:00:00:00:00:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 48
<<<<<<   type        = command (0x00000003)
<<<<<<   transaction = 2
<<<<<< Fragment header:
<<<<<<   total   = 1
<<<<<<   current = 0
<<<<<< Contents:
<<<<<<   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<<   cid     = 'device-caps' (0x00000001)
<<<<<<   type    = 'query' (0x00000000)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>>   length = 184
>>>>>>   data   = 03:00:00:80:B8:00:00:00:02:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:01:00:00:00:00:00:00:00:88:00:00:00:01:00:00:00:01:00:00:00:01:00:00:00:02:00:00:00:1F:00:00:00:03:00:00:00:11:00:00:00:08:00:00:00:00:00:00:00:00:00:00:00:40:00:00:00:1E:00:00:00:60:00:00:00:1C:00:00:00:7C:00:00:00:0C:00:00:00:33:00:35:00:35:00:36:00:30:00:35:00:30:00:35:00:35:00:36:00:34:00:38:00:32:00:32:00:31:00:00:00:53:00:57:00:49:00:39:00:58:00:31:00:35:00:43:00:5F:00:30:00:35:00:2E:00:30:00:35:00:4D:00:43:00:38:00:38:00:30:00:35:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 184
>>>>>>   type        = command-done (0x80000003)
>>>>>>   transaction = 2
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   status error = 'None' (0x00000000)
>>>>>>   service      = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>>   cid          = 'device-caps' (0x00000001)
<debug> [000002.652543] [mm-broadband-modem-mbim.c:140] modem_load_current_capabilities_finish(): loaded modem capabilities: gsm-umts
<debug> [000002.652646] [mm-iface-modem.c:4327] interface_initialization_step(): Modem allows up to 1 bearers
<debug> [000002.652651] [mm-bearer-list.c:276] mm_bearer_list_new(): Creating bearer list (max: 1, max active: 1)
<debug> [000002.652815] [mm-modem-helpers.c:148] mm_create_device_identifier(): Device ID source '0000413c000081a3355605055648221SWI9X15C_05.05MBIM[413C:81A3]Generic'
<debug> [000002.652818] [mm-modem-helpers.c:149] mm_create_device_identifier(): Device ID 'c386bccb7e069b97a8454b1162857416e44ccff6'
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<<   length = 48
<<<<<<   data   = 03:00:00:00:30:00:00:00:03:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:03:00:00:00:00:00:00:00:00:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 48
<<<<<<   type        = command (0x00000003)
<<<<<<   transaction = 3
<<<<<< Fragment header:
<<<<<<   total   = 1
<<<<<<   current = 0
<<<<<< Contents:
<<<<<<   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<<   cid     = 'radio-state' (0x00000003)
<<<<<<   type    = 'query' (0x00000000)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>>   length = 56
>>>>>>   data   = 03:00:00:80:38:00:00:00:03:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:03:00:00:00:00:00:00:00:08:00:00:00:01:00:00:00:01:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 56
>>>>>>   type        = command-done (0x80000003)
>>>>>>   transaction = 3
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   status error = 'None' (0x00000000)
>>>>>>   service      = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>>   cid          = 'radio-state' (0x00000003)
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<<   length = 48
<<<<<<   data   = 03:00:00:00:30:00:00:00:04:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:02:00:00:00:00:00:00:00:00:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 48
<<<<<<   type        = command (0x00000003)
<<<<<<   transaction = 4
<<<<<< Fragment header:
<<<<<<   total   = 1
<<<<<<   current = 0
<<<<<< Contents:
<<<<<<   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<<   cid     = 'subscriber-ready-status' (0x00000002)
<<<<<<   type    = 'query' (0x00000000)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>>   length = 112
>>>>>>   data   = 03:00:00:80:70:00:00:00:04:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:02:00:00:00:00:00:00:00:40:00:00:00:06:00:00:00:00:00:00:00:00:00:00:00:1C:00:00:00:24:00:00:00:00:00:00:00:00:00:00:00:38:00:39:00:34:00:39:00:32:00:31:00:30:00:30:00:34:00:31:00:35:00:35:00:30:00:33:00:34:00:38:00:38:00:31:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 112
>>>>>>   type        = command-done (0x80000003)
>>>>>>   transaction = 4
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   status error = 'None' (0x00000000)
>>>>>>   service      = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>>   cid          = 'subscriber-ready-status' (0x00000002)
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<<   length = 48
<<<<<<   data   = 03:00:00:00:30:00:00:00:05:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:04:00:00:00:00:00:00:00:00:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 48
<<<<<<   type        = command (0x00000003)
<<<<<<   transaction = 5
<<<<<< Fragment header:
<<<<<<   total   = 1
<<<<<<   current = 0
<<<<<< Contents:
<<<<<<   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<<   cid     = 'pin' (0x00000004)
<<<<<<   type    = 'query' (0x00000000)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>>   length = 60
>>>>>>   data   = 03:00:00:80:3C:00:00:00:05:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:04:00:00:00:00:00:00:00:0C:00:00:00:02:00:00:00:01:00:00:00:03:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 60
>>>>>>   type        = command-done (0x80000003)
>>>>>>   transaction = 5
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   status error = 'None' (0x00000000)
>>>>>>   service      = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>>   cid          = 'pin' (0x00000004)
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<<   length = 48
<<<<<<   data   = 03:00:00:00:30:00:00:00:06:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:04:00:00:00:00:00:00:00:00:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 48
<<<<<<   type        = command (0x00000003)
<<<<<<   transaction = 6
<<<<<< Fragment header:
<<<<<<   total   = 1
<<<<<<   current = 0
<<<<<< Contents:
<<<<<<   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<<   cid     = 'pin' (0x00000004)
<<<<<<   type    = 'query' (0x00000000)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>>   length = 60
>>>>>>   data   = 03:00:00:80:3C:00:00:00:06:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:04:00:00:00:00:00:00:00:0C:00:00:00:02:00:00:00:01:00:00:00:03:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 60
>>>>>>   type        = command-done (0x80000003)
>>>>>>   transaction = 6
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   status error = 'None' (0x00000000)
>>>>>>   service      = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>>   cid          = 'pin' (0x00000004)
<info>  [000002.780467] [mm-iface-modem.c:1392] __iface_modem_update_state_internal(): Modem: state changed (unknown -> locked)
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<<   length = 48
<<<<<<   data   = 03:00:00:00:30:00:00:00:07:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:02:00:00:00:00:00:00:00:00:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 48
<<<<<<   type        = command (0x00000003)
<<<<<<   transaction = 7
<<<<<< Fragment header:
<<<<<<   total   = 1
<<<<<<   current = 0
<<<<<< Contents:
<<<<<<   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<<   cid     = 'subscriber-ready-status' (0x00000002)
<<<<<<   type    = 'query' (0x00000000)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>>   length = 112
>>>>>>   data   = 03:00:00:80:70:00:00:00:07:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:02:00:00:00:00:00:00:00:40:00:00:00:06:00:00:00:00:00:00:00:00:00:00:00:1C:00:00:00:24:00:00:00:00:00:00:00:00:00:00:00:38:00:39:00:34:00:39:00:32:00:31:00:30:00:30:00:34:00:31:00:35:00:35:00:30:00:33:00:34:00:38:00:38:00:31:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 112
>>>>>>   type        = command-done (0x80000003)
>>>>>>   transaction = 7
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   status error = 'None' (0x00000000)
>>>>>>   service      = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>>   cid          = 'subscriber-ready-status' (0x00000002)
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<<   length = 48
<<<<<<   data   = 03:00:00:00:30:00:00:00:08:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:02:00:00:00:00:00:00:00:00:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 48
<<<<<<   type        = command (0x00000003)
<<<<<<   transaction = 8
<<<<<< Fragment header:
<<<<<<   total   = 1
<<<<<<   current = 0
<<<<<< Contents:
<<<<<<   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<<   cid     = 'subscriber-ready-status' (0x00000002)
<<<<<<   type    = 'query' (0x00000000)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>>   length = 112
>>>>>>   data   = 03:00:00:80:70:00:00:00:08:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:02:00:00:00:00:00:00:00:40:00:00:00:06:00:00:00:00:00:00:00:00:00:00:00:1C:00:00:00:24:00:00:00:00:00:00:00:00:00:00:00:38:00:39:00:34:00:39:00:32:00:31:00:30:00:30:00:34:00:31:00:35:00:35:00:30:00:33:00:34:00:38:00:38:00:31:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 112
>>>>>>   type        = command-done (0x80000003)
>>>>>>   transaction = 8
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   status error = 'None' (0x00000000)
>>>>>>   service      = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>>   cid          = 'subscriber-ready-status' (0x00000002)
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<<   length = 48
<<<<<<   data   = 03:00:00:00:30:00:00:00:09:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:06:00:00:00:00:00:00:00:00:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 48
<<<<<<   type        = command (0x00000003)
<<<<<<   transaction = 9
<<<<<< Fragment header:
<<<<<<   total   = 1
<<<<<<   current = 0
<<<<<< Contents:
<<<<<<   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<<   cid     = 'home-provider' (0x00000006)
<<<<<<   type    = 'query' (0x00000000)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>>   length = 48
>>>>>>   data   = 03:00:00:80:30:00:00:00:09:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:06:00:00:00:05:00:00:00:00:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 48
>>>>>>   type        = command-done (0x80000003)
>>>>>>   transaction = 9
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   status error = 'PinRequired' (0x00000005)
>>>>>>   service      = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>>   cid          = 'home-provider' (0x00000006)
<warn>  [000002.876403] [mm-base-sim.c:1465] load_operator_identifier_ready(): couldn't load Operator identifier: 'PinRequired'
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<<   length = 48
<<<<<<   data   = 03:00:00:00:30:00:00:00:0A:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:06:00:00:00:00:00:00:00:00:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 48
<<<<<<   type        = command (0x00000003)
<<<<<<   transaction = 10
<<<<<< Fragment header:
<<<<<<   total   = 1
<<<<<<   current = 0
<<<<<< Contents:
<<<<<<   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<<   cid     = 'home-provider' (0x00000006)
<<<<<<   type    = 'query' (0x00000000)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>>   length = 48
>>>>>>   data   = 03:00:00:80:30:00:00:00:0A:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:06:00:00:00:05:00:00:00:00:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 48
>>>>>>   type        = command-done (0x80000003)
>>>>>>   transaction = 10
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   status error = 'PinRequired' (0x00000005)
>>>>>>   service      = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>>   cid          = 'home-provider' (0x00000006)
<warn>  [000002.908115] [mm-base-sim.c:1466] load_operator_name_ready(): couldn't load Operator name: 'PinRequired'
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<<   length = 48
<<<<<<   data   = 03:00:00:00:30:00:00:00:0B:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:02:00:00:00:00:00:00:00:00:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 48
<<<<<<   type        = command (0x00000003)
<<<<<<   transaction = 11
<<<<<< Fragment header:
<<<<<<   total   = 1
<<<<<<   current = 0
<<<<<< Contents:
<<<<<<   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<<   cid     = 'subscriber-ready-status' (0x00000002)
<<<<<<   type    = 'query' (0x00000000)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>>   length = 112
>>>>>>   data   = 03:00:00:80:70:00:00:00:0B:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:02:00:00:00:00:00:00:00:40:00:00:00:06:00:00:00:00:00:00:00:00:00:00:00:1C:00:00:00:24:00:00:00:00:00:00:00:00:00:00:00:38:00:39:00:34:00:39:00:32:00:31:00:30:00:30:00:34:00:31:00:35:00:35:00:30:00:33:00:34:00:38:00:38:00:31:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 112
>>>>>>   type        = command-done (0x80000003)
>>>>>>   transaction = 11
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   status error = 'None' (0x00000000)
>>>>>>   service      = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>>   cid          = 'subscriber-ready-status' (0x00000002)
<debug> [000002.940556] [mm-broadband-modem.c:9005] iface_modem_firmware_initialize_ready(): Couldn't initialize interface: 'Firmware not supported'
<debug> [000002.940639] [mm-base-modem.c:950] initialize_ready(): Couldn't finish initialization in the current state: 'Modem is currently locked, cannot fully initialize'
<debug> [000002.941121] [mm-device.c:436] export_modem(): Exported modem '/sys/devices/pci0000:00/0000:00:14.0/usb1/1-10' at path '/org/freedesktop/ModemManager1/Modem/0'
<debug> [000002.941132] [mm-device.c:446] export_modem(): (/org/freedesktop/ModemManager1/Modem/0): 'Generic' modem, VID 0x413C PID 0x81A3 (usb)
<debug> [000003.299543] [mm-port-probe-at.c:43] mm_port_probe_response_processor_is_at(): Parsing AT got: 'Serial command timed out'
<debug> [000003.299589] [mm-port-serial-at.c:440] debug_log(): (ttyS0): --> 'AT<CR>'
<debug> [000006.301851] [mm-port-probe-at.c:43] mm_port_probe_response_processor_is_at(): Parsing AT got: 'Serial command timed out'
<debug> [000006.301902] [mm-port-serial-at.c:440] debug_log(): (ttyS0): --> 'AT<CR>'
<debug> [000009.302249] [mm-port-probe-at.c:43] mm_port_probe_response_processor_is_at(): Parsing AT got: 'Serial command timed out'
<debug> [000009.302272] [mm-port-probe.c:162] mm_port_probe_set_result_at(): (tty/ttyS0) port is not AT-capable
<debug> [000009.302303] [mm-port-serial.c:1296] mm_port_serial_close(): (ttyS0) device open count is 0 (close)
<debug> [000009.302309] [mm-port-serial.c:1312] mm_port_serial_close(): (ttyS0) closing serial port...
<debug> [000009.302386] [mm-port-serial.c:1361] mm_port_serial_close(): (ttyS0) serial port closed
<debug> [000009.302396] [mm-port-serial.c:1415] port_serial_close_force(): (ttyS0) forced to close port
<debug> [000009.302425] [mm-plugin.c:454] apply_post_probing_filters(): (Via CBP7) [ttyS0] filtered as no vendor/product strings given
<debug> [000009.302454] [mm-plugin.c:767] mm_plugin_supports_port(): (Nokia) [ttyS0] probe required: 'at, at-vendor, at-icera'
<debug> [000009.302467] [mm-plugin.c:429] apply_post_probing_filters(): (Nokia) [ttyS0] filtered by vendor strings
<debug> [000009.302481] [mm-plugin.c:767] mm_plugin_supports_port(): (Iridium) [ttyS0] probe required: 'at, at-vendor, at-product'
<debug> [000009.302491] [mm-plugin.c:454] apply_post_probing_filters(): (Iridium) [ttyS0] filtered as no vendor/product strings given
<debug> [000009.302503] [mm-plugin.c:767] mm_plugin_supports_port(): (Cinterion) [ttyS0] probe required: 'at, at-vendor'
<debug> [000009.302514] [mm-plugin.c:429] apply_post_probing_filters(): (Cinterion) [ttyS0] filtered by vendor strings
<debug> [000009.302527] [mm-plugin.c:767] mm_plugin_supports_port(): (Generic) [ttyS0] probe required: 'at, qcdm'
<debug> [000009.302532] [mm-port-probe.c:1353] mm_port_probe_run(): (tty/ttyS0) launching port probing: 'qcdm'
<debug> [000009.302542] [mm-port-probe.c:658] serial_probe_qcdm(): (tty/ttyS0) probing QCDM...
<debug> [000009.302582] [mm-port-serial.c:1099] mm_port_serial_open(): (ttyS0) opening serial port...
<debug> [000009.302670] [mm-port-serial.c:1237] mm_port_serial_open(): (ttyS0) device open count is 1 (open)
<debug> [000009.302718] [mm-port-serial-qcdm.c:201] debug_log(): (ttyS0): --> 7e 00 78 f0 7e
<debug> [000012.301776] [mm-port-serial-qcdm.c:201] debug_log(): (ttyS0): --> 7e 00 78 f0 7e
<debug> [000015.301904] [mm-port-probe.c:258] mm_port_probe_set_result_qcdm(): (tty/ttyS0) port is not QCDM-capable
<debug> [000015.301953] [mm-port-serial.c:1296] mm_port_serial_close(): (ttyS0) device open count is 0 (close)
<debug> [000015.301960] [mm-port-serial.c:1312] mm_port_serial_close(): (ttyS0) closing serial port...
<debug> [000015.302011] [mm-port-serial.c:1361] mm_port_serial_close(): (ttyS0) serial port closed
<debug> [000015.302018] [mm-port-serial.c:1415] port_serial_close_force(): (ttyS0) forced to close port
<debug> [000015.302041] [mm-plugin-manager.c:462] plugin_supports_port_ready(): (Plugin Manager) (Generic) [ttyS0] found best plugin for port
<debug> [000015.302057] [mm-plugin-manager.c:316] port_probe_context_finished(): (Plugin Manager) 'ttyS0' port probe finished, last one in device
<debug> [000015.302062] [mm-plugin-manager.c:138] find_device_support_context_complete_and_free(): (Plugin Manager) [/sys/devices/pci0000:00/0000:00:16.3] device support check finished in '15.285598' seconds
<info>  [000015.302074] [mm-device.c:509] mm_device_create_modem(): Creating modem with plugin 'Generic' and '1' ports
<warn>  [000015.302220] [mm-plugin.c:905] mm_plugin_create_modem(): Could not grab port (tty/ttyS0): 'Cannot add port 'tty/ttyS0', unhandled serial type'
<debug> [000015.302247] [mm-base-modem.c:1485] finalize(): Modem (Generic) '/sys/devices/pci0000:00/0000:00:16.3' completely disposed
<warn>  [000015.302252] [mm-base-manager.c:158] find_device_support_ready(): Couldn't create modem for device at '/sys/devices/pci0000:00/0000:00:16.3': Failed to find primary AT port
<debug> [000056.976771] [mm-sim-mbim.c:404] send_pin(): Sending PIN...
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<<   length = 80
<<<<<<   data   = 03:00:00:00:50:00:00:00:0C:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:04:00:00:00:01:00:00:00:20:00:00:00:02:00:00:00:00:00:00:00:18:00:00:00:08:00:00:00:00:00:00:00:00:00:00:00:37:00:38:00:37:00:31:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 80
<<<<<<   type        = command (0x00000003)
<<<<<<   transaction = 12
<<<<<< Fragment header:
<<<<<<   total   = 1
<<<<<<   current = 0
<<<<<< Contents:
<<<<<<   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<<   cid     = 'pin' (0x00000004)
<<<<<<   type    = 'set' (0x00000001)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>>   length = 60
>>>>>>   data   = 03:00:00:80:3C:00:00:00:0C:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:04:00:00:00:00:00:00:00:0C:00:00:00:03:00:00:00:01:00:00:00:02:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 60
>>>>>>   type        = command-done (0x80000003)
>>>>>>   transaction = 12
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   status error = 'None' (0x00000000)
>>>>>>   service      = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>>   cid          = 'pin' (0x00000004)
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<<   length = 48
<<<<<<   data   = 03:00:00:00:30:00:00:00:0D:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:02:00:00:00:00:00:00:00:00:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 48
<<<<<<   type        = command (0x00000003)
<<<<<<   transaction = 13
<<<<<< Fragment header:
<<<<<<   total   = 1
<<<<<<   current = 0
<<<<<< Contents:
<<<<<<   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<<   cid     = 'subscriber-ready-status' (0x00000002)
<<<<<<   type    = 'query' (0x00000000)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>>   length = 48
>>>>>>   data   = 03:00:00:80:30:00:00:00:0D:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:02:00:00:00:02:00:00:00:00:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 48
>>>>>>   type        = command-done (0x80000003)
>>>>>>   transaction = 13
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   status error = 'Failure' (0x00000002)
>>>>>>   service      = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>>   cid          = 'subscriber-ready-status' (0x00000002)
<debug> [000058.460580] [mm-iface-modem.c:266] load_unlock_required_ready(): Couldn't check if unlock required: 'Failure'
<debug> [000058.460660] [mm-iface-modem.c:290] load_unlock_required_ready(): Retrying (1) unlock required check
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>>   length = 92
>>>>>>   data   = 07:00:00:80:5C:00:00:00:00:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:09:00:00:00:30:00:00:00:00:00:00:00:02:00:00:00:01:00:00:00:00:00:00:00:01:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:02:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 92
>>>>>>   type        = indicate-status (0x80000007)
>>>>>>   transaction = 0
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>>   cid     = 'register-state' (0x00000009)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>>   length = 72
>>>>>>   data   = 07:00:00:80:48:00:00:00:00:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:0A:00:00:00:1C:00:00:00:00:00:00:00:04:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 72
>>>>>>   type        = indicate-status (0x80000007)
>>>>>>   transaction = 0
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>>   cid     = 'packet-service' (0x0000000a)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>>   length = 140
>>>>>>   data   = 07:00:00:80:8C:00:00:00:00:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:02:00:00:00:60:00:00:00:01:00:00:00:1C:00:00:00:1E:00:00:00:3C:00:00:00:24:00:00:00:00:00:00:00:00:00:00:00:32:00:36:00:32:00:30:00:33:00:32:00:34:00:34:00:33:00:33:00:33:00:36:00:35:00:30:00:38:00:00:00:38:00:39:00:34:00:39:00:32:00:31:00:30:00:30:00:34:00:31:00:35:00:35:00:30:00:33:00:34:00:38:00:38:00:31:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 140
>>>>>>   type        = indicate-status (0x80000007)
>>>>>>   transaction = 0
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>>   cid     = 'subscriber-ready-status' (0x00000002)
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<<   length = 48
<<<<<<   data   = 03:00:00:00:30:00:00:00:0E:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:02:00:00:00:00:00:00:00:00:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 48
<<<<<<   type        = command (0x00000003)
<<<<<<   transaction = 14
<<<<<< Fragment header:
<<<<<<   total   = 1
<<<<<<   current = 0
<<<<<< Contents:
<<<<<<   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<<   cid     = 'subscriber-ready-status' (0x00000002)
<<<<<<   type    = 'query' (0x00000000)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>>   length = 144
>>>>>>   data   = 03:00:00:80:90:00:00:00:0E:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:02:00:00:00:00:00:00:00:60:00:00:00:01:00:00:00:1C:00:00:00:1E:00:00:00:3C:00:00:00:24:00:00:00:00:00:00:00:00:00:00:00:32:00:36:00:32:00:30:00:33:00:32:00:34:00:34:00:33:00:33:00:33:00:36:00:35:00:30:00:38:00:00:00:38:00:39:00:34:00:39:00:32:00:31:00:30:00:30:00:34:00:31:00:35:00:35:00:30:00:33:00:34:00:38:00:38:00:31:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 144
>>>>>>   type        = command-done (0x80000003)
>>>>>>   transaction = 14
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   status error = 'None' (0x00000000)
>>>>>>   service      = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>>   cid          = 'subscriber-ready-status' (0x00000002)
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<<   length = 48
<<<<<<   data   = 03:00:00:00:30:00:00:00:0F:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:04:00:00:00:00:00:00:00:00:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 48
<<<<<<   type        = command (0x00000003)
<<<<<<   transaction = 15
<<<<<< Fragment header:
<<<<<<   total   = 1
<<<<<<   current = 0
<<<<<< Contents:
<<<<<<   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<<   cid     = 'pin' (0x00000004)
<<<<<<   type    = 'query' (0x00000000)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>>   length = 60
>>>>>>   data   = 03:00:00:80:3C:00:00:00:0F:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:04:00:00:00:00:00:00:00:0C:00:00:00:03:00:00:00:01:00:00:00:02:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 60
>>>>>>   type        = command-done (0x80000003)
>>>>>>   transaction = 15
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   status error = 'None' (0x00000000)
>>>>>>   service      = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>>   cid          = 'pin' (0x00000004)
<debug> [000060.508596] [mm-iface-modem.c:3076] update_lock_info_context_step(): SIM is ready, and no need for the after SIM unlock step...
<info>  [000060.508756] [mm-iface-modem.c:1392] __iface_modem_update_state_internal(): Modem /org/freedesktop/ModemManager1/Modem/0: state changed (locked -> initializing)
<debug> [000060.508949] [mm-broadband-modem-mbim.c:1289] parent_initialization_started_ready(): Couldn't start parent initialization: Couldn't open ports during modem initialization: Couldn't get primary port
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<<   length = 48
<<<<<<   data   = 03:00:00:00:30:00:00:00:10:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:02:00:00:00:00:00:00:00:00:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 48
<<<<<<   type        = command (0x00000003)
<<<<<<   transaction = 16
<<<<<< Fragment header:
<<<<<<   total   = 1
<<<<<<   current = 0
<<<<<< Contents:
<<<<<<   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<<   cid     = 'subscriber-ready-status' (0x00000002)
<<<<<<   type    = 'query' (0x00000000)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>>   length = 96
>>>>>>   data   = 07:00:00:80:60:00:00:00:00:00:00:00:01:00:00:00:00:00:00:00:53:3F:BE:EB:14:FE:44:67:9F:90:33:A2:23:E5:6C:3F:01:00:00:00:34:00:00:00:01:00:00:00:00:00:00:00:1D:01:00:00:00:00:00:00:18:00:00:00:1A:00:00:00:2B:00:34:00:39:00:31:00:37:00:37:00:30:00:36:00:31:00:30:00:30:00:30:00:30:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 96
>>>>>>   type        = indicate-status (0x80000007)
>>>>>>   transaction = 0
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   service = 'sms' (533fbeeb-14fe-4467-9f90-33a223e56c3f)
>>>>>>   cid     = 'configuration' (0x00000001)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>>   length = 144
>>>>>>   data   = 03:00:00:80:90:00:00:00:10:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:02:00:00:00:00:00:00:00:60:00:00:00:01:00:00:00:1C:00:00:00:1E:00:00:00:3C:00:00:00:24:00:00:00:00:00:00:00:00:00:00:00:32:00:36:00:32:00:30:00:33:00:32:00:34:00:34:00:33:00:33:00:33:00:36:00:35:00:30:00:38:00:00:00:38:00:39:00:34:00:39:00:32:00:31:00:30:00:30:00:34:00:31:00:35:00:35:00:30:00:33:00:34:00:38:00:38:00:31:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 144
>>>>>>   type        = command-done (0x80000003)
>>>>>>   transaction = 16
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   status error = 'None' (0x00000000)
>>>>>>   service      = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>>   cid          = 'subscriber-ready-status' (0x00000002)
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<<   length = 48
<<<<<<   data   = 03:00:00:00:30:00:00:00:11:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:06:00:00:00:00:00:00:00:00:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 48
<<<<<<   type        = command (0x00000003)
<<<<<<   transaction = 17
<<<<<< Fragment header:
<<<<<<   total   = 1
<<<<<<   current = 0
<<<<<< Contents:
<<<<<<   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<<   cid     = 'home-provider' (0x00000006)
<<<<<<   type    = 'query' (0x00000000)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>>   length = 104
>>>>>>   data   = 03:00:00:80:68:00:00:00:11:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:06:00:00:00:00:00:00:00:38:00:00:00:20:00:00:00:0A:00:00:00:01:00:00:00:2C:00:00:00:0C:00:00:00:01:00:00:00:63:00:00:00:63:00:00:00:32:00:36:00:32:00:30:00:33:00:00:00:45:00:2D:00:50:00:6C:00:75:00:73:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 104
>>>>>>   type        = command-done (0x80000003)
>>>>>>   transaction = 17
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   status error = 'None' (0x00000000)
>>>>>>   service      = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>>   cid          = 'home-provider' (0x00000006)
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<<   length = 48
<<<<<<   data   = 03:00:00:00:30:00:00:00:12:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:06:00:00:00:00:00:00:00:00:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 48
<<<<<<   type        = command (0x00000003)
<<<<<<   transaction = 18
<<<<<< Fragment header:
<<<<<<   total   = 1
<<<<<<   current = 0
<<<<<< Contents:
<<<<<<   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<<   cid     = 'home-provider' (0x00000006)
<<<<<<   type    = 'query' (0x00000000)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>>   length = 104
>>>>>>   data   = 03:00:00:80:68:00:00:00:12:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:06:00:00:00:00:00:00:00:38:00:00:00:20:00:00:00:0A:00:00:00:01:00:00:00:2C:00:00:00:0C:00:00:00:01:00:00:00:63:00:00:00:63:00:00:00:32:00:36:00:32:00:30:00:33:00:00:00:45:00:2D:00:50:00:6C:00:75:00:73:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 104
>>>>>>   type        = command-done (0x80000003)
>>>>>>   transaction = 18
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   status error = 'None' (0x00000000)
>>>>>>   service      = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>>   cid          = 'home-provider' (0x00000006)
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<<   length = 48
<<<<<<   data   = 03:00:00:00:30:00:00:00:13:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:02:00:00:00:00:00:00:00:00:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 48
<<<<<<   type        = command (0x00000003)
<<<<<<   transaction = 19
<<<<<< Fragment header:
<<<<<<   total   = 1
<<<<<<   current = 0
<<<<<< Contents:
<<<<<<   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<<   cid     = 'subscriber-ready-status' (0x00000002)
<<<<<<   type    = 'query' (0x00000000)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>>   length = 144
>>>>>>   data   = 03:00:00:80:90:00:00:00:13:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:02:00:00:00:00:00:00:00:60:00:00:00:01:00:00:00:1C:00:00:00:1E:00:00:00:3C:00:00:00:24:00:00:00:00:00:00:00:00:00:00:00:32:00:36:00:32:00:30:00:33:00:32:00:34:00:34:00:33:00:33:00:33:00:36:00:35:00:30:00:38:00:00:00:38:00:39:00:34:00:39:00:32:00:31:00:30:00:30:00:34:00:31:00:35:00:35:00:30:00:33:00:34:00:38:00:38:00:31:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 144
>>>>>>   type        = command-done (0x80000003)
>>>>>>   transaction = 19
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   status error = 'None' (0x00000000)
>>>>>>   service      = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>>   cid          = 'subscriber-ready-status' (0x00000002)
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<<   length = 48
<<<<<<   data   = 03:00:00:00:30:00:00:00:14:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:05:00:00:00:00:00:00:00:00:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 48
<<<<<<   type        = command (0x00000003)
<<<<<<   transaction = 20
<<<<<< Fragment header:
<<<<<<   total   = 1
<<<<<<   current = 0
<<<<<< Contents:
<<<<<<   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<<   cid     = 'pin-list' (0x00000005)
<<<<<<   type    = 'query' (0x00000000)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>>   length = 208
>>>>>>   data   = 03:00:00:80:D0:00:00:00:14:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:05:00:00:00:00:00:00:00:A0:00:00:00:01:00:00:00:01:00:00:00:04:00:00:00:08:00:00:00:01:00:00:00:01:00:00:00:04:00:00:00:08:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 208
>>>>>>   type        = command-done (0x80000003)
>>>>>>   transaction = 20
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   status error = 'None' (0x00000000)
>>>>>>   service      = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>>   cid          = 'pin-list' (0x00000005)
<debug> [000062.300941] [mm-iface-modem-3gpp-ussd.c:786] check_support_ready(): USSD support check failed: 'No AT port available to run command'
<debug> [000062.300956] [mm-broadband-modem.c:8998] iface_modem_3gpp_ussd_initialize_ready(): Couldn't initialize interface: 'USSD not supported'
<debug> [000062.301223] [mm-broadband-modem-mbim.c:2592] messaging_check_support(): Messaging capabilities supported
<debug> [000062.301255] [mm-iface-modem-messaging.c:1148] load_supported_storages_ready(): Supported storages loaded:
<debug> [000062.301258] [mm-iface-modem-messaging.c:1149] load_supported_storages_ready():   mem1 (list/read/delete) storages: 'mt'
<debug> [000062.301260] [mm-iface-modem-messaging.c:1150] load_supported_storages_ready():   mem2 (write/send) storages:       'mt'
<debug> [000062.301264] [mm-iface-modem-messaging.c:1151] load_supported_storages_ready():   mem3 (reception) storages:        'mt'
<debug> [000062.301404] [mm-broadband-modem.c:9002] iface_modem_time_initialize_ready(): Couldn't initialize interface: 'Time not supported'
<debug> [000062.301470] [mm-broadband-modem.c:9003] iface_modem_signal_initialize_ready(): Couldn't initialize interface: 'Extended Signal information not supported'
<debug> [000062.301577] [mm-broadband-modem.c:9004] iface_modem_oma_initialize_ready(): Couldn't initialize interface: 'OMA not supported'
<debug> [000062.301608] [mm-broadband-modem.c:9005] iface_modem_firmware_initialize_ready(): Couldn't initialize interface: 'Firmware not supported'
<info>  [000062.301627] [mm-iface-modem.c:1392] __iface_modem_update_state_internal(): Modem /org/freedesktop/ModemManager1/Modem/0: state changed (initializing -> disabled)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>>   length = 140
>>>>>>   data   = 07:00:00:80:8C:00:00:00:00:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:02:00:00:00:60:00:00:00:01:00:00:00:1C:00:00:00:1E:00:00:00:3C:00:00:00:24:00:00:00:00:00:00:00:00:00:00:00:32:00:36:00:32:00:30:00:33:00:32:00:34:00:34:00:33:00:33:00:33:00:36:00:35:00:30:00:38:00:00:00:38:00:39:00:34:00:39:00:32:00:31:00:30:00:30:00:34:00:31:00:35:00:35:00:30:00:33:00:34:00:38:00:38:00:31:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 140
>>>>>>   type        = indicate-status (0x80000007)
>>>>>>   transaction = 0
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>>   cid     = 'subscriber-ready-status' (0x00000002)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>>   length = 64
>>>>>>   data   = 07:00:00:80:40:00:00:00:00:00:00:00:01:00:00:00:00:00:00:00:4B:F3:84:76:1E:6A:41:DB:B1:D8:BE:D2:89:C2:5B:DB:01:00:00:00:14:00:00:00:01:00:00:00:FA:00:00:00:1B:00:00:00:50:00:00:00:11:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 64
>>>>>>   type        = indicate-status (0x80000007)
>>>>>>   transaction = 0
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   service = 'phonebook' (4bf38476-1e6a-41db-b1d8-bed289c25bdb)
>>>>>>   cid     = 'configuration' (0x00000001)
<info>  [000075.158510] [mm-iface-modem.c:1392] __iface_modem_update_state_internal(): Modem /org/freedesktop/ModemManager1/Modem/0: state changed (disabled -> enabling)
<debug> [000075.158739] [mm-broadband-modem.c:8003] enabling_started(): Skipping modem initialization: not required
<debug> [000075.158753] [mm-broadband-modem-mbim.c:1216] parent_enabling_started_ready(): Couldn't start parent enabling: Couldn't open ports during modem enabling: Couldn't get primary port
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<<   length = 48
<<<<<<   data   = 03:00:00:00:30:00:00:00:15:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:03:00:00:00:00:00:00:00:00:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 48
<<<<<<   type        = command (0x00000003)
<<<<<<   transaction = 21
<<<<<< Fragment header:
<<<<<<   total   = 1
<<<<<<   current = 0
<<<<<< Contents:
<<<<<<   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<<   cid     = 'radio-state' (0x00000003)
<<<<<<   type    = 'query' (0x00000000)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>>   length = 56
>>>>>>   data   = 03:00:00:80:38:00:00:00:15:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:03:00:00:00:00:00:00:00:08:00:00:00:01:00:00:00:01:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 56
>>>>>>   type        = command-done (0x80000003)
>>>>>>   transaction = 21
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   status error = 'None' (0x00000000)
>>>>>>   service      = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>>   cid          = 'radio-state' (0x00000003)
<debug> [000075.228574] [mm-iface-modem.c:3259] set_power_state(): No need to change power state: already in 'on' power state
<debug> [000075.228606] [mm-broadband-modem.c:8592] enabling_step(): Modem has 3GPP capabilities, enabling the Modem 3GPP interface...
<debug> [000075.228623] [mm-broadband-modem-mbim.c:1976] common_setup_cleanup_unsolicited_events(): Supported notifications: signal (yes), registration (no), sms (no), connect (yes), subscriber (yes), packet (yes)
<debug> [000075.228642] [mm-broadband-modem-mbim.c:2115] common_enable_disable_unsolicited_events(): Enabled notifications: signal (yes), registration (no), sms (no), connect (yes), subscriber (yes), packet (yes)
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<<   length = 96
<<<<<<   data   = 03:00:00:00:60:00:00:00:16:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:13:00:00:00:01:00:00:00:30:00:00:00:01:00:00:00:0C:00:00:00:24:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:04:00:00:00:0B:00:00:00:0C:00:00:00:02:00:00:00:0A:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 96
<<<<<<   type        = command (0x00000003)
<<<<<<   transaction = 22
<<<<<< Fragment header:
<<<<<<   total   = 1
<<<<<<   current = 0
<<<<<< Contents:
<<<<<<   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<<   cid     = 'device-service-subscribe-list' (0x00000013)
<<<<<<   type    = 'set' (0x00000001)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>>   length = 96
>>>>>>   data   = 03:00:00:80:60:00:00:00:16:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:13:00:00:00:00:00:00:00:30:00:00:00:01:00:00:00:0C:00:00:00:24:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:04:00:00:00:0B:00:00:00:0C:00:00:00:02:00:00:00:0A:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 96
>>>>>>   type        = command-done (0x80000003)
>>>>>>   transaction = 22
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   status error = 'None' (0x00000000)
>>>>>>   service      = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>>   cid          = 'device-service-subscribe-list' (0x00000013)
<debug> [000075.260518] [mm-broadband-modem-mbim.c:1976] common_setup_cleanup_unsolicited_events(): Supported notifications: signal (yes), registration (yes), sms (no), connect (yes), subscriber (yes), packet (yes)
<debug> [000075.260553] [mm-broadband-modem-mbim.c:2115] common_enable_disable_unsolicited_events(): Enabled notifications: signal (yes), registration (yes), sms (no), connect (yes), subscriber (yes), packet (yes)
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<<   length = 100
<<<<<<   data   = 03:00:00:00:64:00:00:00:17:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:13:00:00:00:01:00:00:00:34:00:00:00:01:00:00:00:0C:00:00:00:28:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:05:00:00:00:0B:00:00:00:09:00:00:00:0C:00:00:00:02:00:00:00:0A:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 100
<<<<<<   type        = command (0x00000003)
<<<<<<   transaction = 23
<<<<<< Fragment header:
<<<<<<   total   = 1
<<<<<<   current = 0
<<<<<< Contents:
<<<<<<   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<<   cid     = 'device-service-subscribe-list' (0x00000013)
<<<<<<   type    = 'set' (0x00000001)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>>   length = 100
>>>>>>   data   = 03:00:00:80:64:00:00:00:17:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:13:00:00:00:00:00:00:00:34:00:00:00:01:00:00:00:0C:00:00:00:28:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:05:00:00:00:0B:00:00:00:09:00:00:00:0C:00:00:00:02:00:00:00:0A:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 100
>>>>>>   type        = command-done (0x80000003)
>>>>>>   transaction = 23
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   status error = 'None' (0x00000000)
>>>>>>   service      = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>>   cid          = 'device-service-subscribe-list' (0x00000013)
<debug> [000075.292592] [mm-iface-modem-3gpp.c:751] mm_iface_modem_3gpp_run_registration_checks(): Running registration checks (CS: 'yes', PS: 'yes', EPS: 'no')
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<<   length = 48
<<<<<<   data   = 03:00:00:00:30:00:00:00:18:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:09:00:00:00:00:00:00:00:00:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 48
<<<<<<   type        = command (0x00000003)
<<<<<<   transaction = 24
<<<<<< Fragment header:
<<<<<<   total   = 1
<<<<<<   current = 0
<<<<<< Contents:
<<<<<<   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<<   cid     = 'register-state' (0x00000009)
<<<<<<   type    = 'query' (0x00000000)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>>   length = 96
>>>>>>   data   = 03:00:00:80:60:00:00:00:18:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:09:00:00:00:00:00:00:00:30:00:00:00:00:00:00:00:02:00:00:00:01:00:00:00:00:00:00:00:01:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:02:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 96
>>>>>>   type        = command-done (0x80000003)
>>>>>>   transaction = 24
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   status error = 'None' (0x00000000)
>>>>>>   service      = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>>   cid          = 'register-state' (0x00000009)
<info>  [000075.324640] [mm-iface-modem-3gpp.c:1169] update_registration_state(): Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP Registration state changed (unknown -> searching)
<debug> [000075.324735] [mm-iface-modem.c:1561] get_updated_consolidated_state(): Will start keeping track of state for subsystem '3gpp'
<debug> [000075.324834] [mm-broadband-modem.c:8633] enabling_step(): Modem has location capabilities, enabling the Location interface...
<debug> [000075.324847] [mm-iface-modem-location.c:759] setup_gathering(): Need to enable the following location sources: '3gpp-lac-ci'
<debug> [000075.324881] [mm-iface-modem-3gpp.c:751] mm_iface_modem_3gpp_run_registration_checks(): Running registration checks (CS: 'yes', PS: 'yes', EPS: 'no')
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<<   length = 48
<<<<<<   data   = 03:00:00:00:30:00:00:00:19:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:09:00:00:00:00:00:00:00:00:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 48
<<<<<<   type        = command (0x00000003)
<<<<<<   transaction = 25
<<<<<< Fragment header:
<<<<<<   total   = 1
<<<<<<   current = 0
<<<<<< Contents:
<<<<<<   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<<   cid     = 'register-state' (0x00000009)
<<<<<<   type    = 'query' (0x00000000)
<debug> [000075.324989] [mm-broadband-modem.c:8646] enabling_step(): Modem has messaging capabilities, enabling the Messaging interface...
<debug> [000075.325033] [mm-broadband-modem-mbim.c:2747] load_initial_sms_parts(): loading SMS parts...
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<<   length = 60
<<<<<<   data   = 03:00:00:00:3C:00:00:00:1A:00:00:00:01:00:00:00:00:00:00:00:53:3F:BE:EB:14:FE:44:67:9F:90:33:A2:23:E5:6C:3F:02:00:00:00:00:00:00:00:0C:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 60
<<<<<<   type        = command (0x00000003)
<<<<<<   transaction = 26
<<<<<< Fragment header:
<<<<<<   total   = 1
<<<<<<   current = 0
<<<<<< Contents:
<<<<<<   service = 'sms' (533fbeeb-14fe-4467-9f90-33a223e56c3f)
<<<<<<   cid     = 'read' (0x00000002)
<<<<<<   type    = 'query' (0x00000000)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>>   length = 96
>>>>>>   data   = 03:00:00:80:60:00:00:00:19:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:09:00:00:00:00:00:00:00:30:00:00:00:00:00:00:00:02:00:00:00:01:00:00:00:00:00:00:00:01:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:02:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 96
>>>>>>   type        = command-done (0x80000003)
>>>>>>   transaction = 25
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   status error = 'None' (0x00000000)
>>>>>>   service      = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>>   cid          = 'register-state' (0x00000009)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>>   length = 56
>>>>>>   data   = 03:00:00:80:38:00:00:00:1A:00:00:00:01:00:00:00:00:00:00:00:53:3F:BE:EB:14:FE:44:67:9F:90:33:A2:23:E5:6C:3F:02:00:00:00:00:00:00:00:08:00:00:00:00:00:00:00:00:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 56
>>>>>>   type        = command-done (0x80000003)
>>>>>>   transaction = 26
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   status error = 'None' (0x00000000)
>>>>>>   service      = 'sms' (533fbeeb-14fe-4467-9f90-33a223e56c3f)
>>>>>>   cid          = 'read' (0x00000002)
<debug> [000075.388478] [mm-broadband-modem-mbim.c:1976] common_setup_cleanup_unsolicited_events(): Supported notifications: signal (yes), registration (yes), sms (yes), connect (yes), subscriber (yes), packet (yes)
<debug> [000075.388503] [mm-broadband-modem-mbim.c:2115] common_enable_disable_unsolicited_events(): Enabled notifications: signal (yes), registration (yes), sms (yes), connect (yes), subscriber (yes), packet (yes)
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<<   length = 136
<<<<<<   data   = 03:00:00:00:88:00:00:00:1B:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:13:00:00:00:01:00:00:00:58:00:00:00:02:00:00:00:14:00:00:00:28:00:00:00:3C:00:00:00:1C:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:05:00:00:00:0B:00:00:00:09:00:00:00:0C:00:00:00:02:00:00:00:0A:00:00:00:53:3F:BE:EB:14:FE:44:67:9F:90:33:A2:23:E5:6C:3F:02:00:00:00:02:00:00:00:05:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 136
<<<<<<   type        = command (0x00000003)
<<<<<<   transaction = 27
<<<<<< Fragment header:
<<<<<<   total   = 1
<<<<<<   current = 0
<<<<<< Contents:
<<<<<<   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<<   cid     = 'device-service-subscribe-list' (0x00000013)
<<<<<<   type    = 'set' (0x00000001)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>>   length = 136
>>>>>>   data   = 03:00:00:80:88:00:00:00:1B:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:13:00:00:00:00:00:00:00:58:00:00:00:02:00:00:00:14:00:00:00:28:00:00:00:3C:00:00:00:1C:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:05:00:00:00:0B:00:00:00:09:00:00:00:0C:00:00:00:02:00:00:00:0A:00:00:00:53:3F:BE:EB:14:FE:44:67:9F:90:33:A2:23:E5:6C:3F:02:00:00:00:02:00:00:00:05:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 136
>>>>>>   type        = command-done (0x80000003)
>>>>>>   transaction = 27
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   status error = 'None' (0x00000000)
>>>>>>   service      = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>>   cid          = 'device-service-subscribe-list' (0x00000013)
<info>  [000075.420615] [mm-iface-modem.c:1392] __iface_modem_update_state_internal(): Modem /org/freedesktop/ModemManager1/Modem/0: state changed (enabling -> searching)
<debug> [000084.730343] [mm-broadband-modem-mbim.c:2553] modem_3gpp_scan_networks(): scanning networks...
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<<   length = 52
<<<<<<   data   = 03:00:00:00:34:00:00:00:1C:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:08:00:00:00:00:00:00:00:04:00:00:00:00:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 52
<<<<<<   type        = command (0x00000003)
<<<<<<   transaction = 28
<<<<<< Fragment header:
<<<<<<   total   = 1
<<<<<<   current = 0
<<<<<< Contents:
<<<<<<   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<<   cid     = 'visible-providers' (0x00000008)
<<<<<<   type    = 'query' (0x00000000)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>>   length = 48
>>>>>>   data   = 03:00:00:80:30:00:00:00:1C:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:08:00:00:00:01:00:00:00:00:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 48
>>>>>>   type        = command-done (0x80000003)
>>>>>>   transaction = 28
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   status error = 'Busy' (0x00000001)
>>>>>>   service      = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>>   cid          = 'visible-providers' (0x00000008)
<debug> [000233.070759] [mm-broadband-modem-mbim.c:2553] modem_3gpp_scan_networks(): scanning networks...
[/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<<   length = 52
<<<<<<   data   = 03:00:00:00:34:00:00:00:1D:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:08:00:00:00:00:00:00:00:04:00:00:00:00:00:00:00
[/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<<   length      = 52
<<<<<<   type        = command (0x00000003)
<<<<<<   transaction = 29
<<<<<< Fragment header:
<<<<<<   total   = 1
<<<<<<   current = 0
<<<<<< Contents:
<<<<<<   service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<<   cid     = 'visible-providers' (0x00000008)
<<<<<<   type    = 'query' (0x00000000)
[/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>>   length = 48
>>>>>>   data   = 03:00:00:80:30:00:00:00:1D:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:08:00:00:00:01:00:00:00:00:00:00:00
[/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>>   length      = 48
>>>>>>   type        = command-done (0x80000003)
>>>>>>   transaction = 29
>>>>>> Fragment header:
>>>>>>   total   = 1
>>>>>>   current = 0
>>>>>> Contents:
>>>>>>   status error = 'Busy' (0x00000001)
>>>>>>   service      = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>>   cid          = 'visible-providers' (0x00000008)


More information about the ModemManager-devel mailing list