Fwd: Re: OpenWRT - MC7455 (MBIM) not working as expected.
Mark Wahlert
mark.wahlert at gmail.com
Tue Jan 24 12:24:36 UTC 2017
>
>
>
> Debug output at boot for MBIM.
>
>
>
> <info> [1485259199.714111] [main.c:159] main(): ModemManager (version 1.7.0) starting in system bus...
>
> <debug> [1485259199.849765] [main.c:83] bus_acquired_cb(): Bus acquired, creating manager...
>
> <debug> [1485259199.851739] [mm-plugin-manager.c:1559] load_plugins(): [plugin manager] looking for plugins in '/usr/lib/ModemManager'
>
> <debug> [1485259200.361607] [mm-plugin-manager.c:1584] load_plugins(): [plugin manager] loaded plugin 'Altair LTE'
>
> <debug> [1485259200.363372] [mm-plugin-manager.c:1584] load_plugins(): [plugin manager] loaded plugin 'AnyDATA'
>
> <debug> [1485259200.365770] [mm-plugin-manager.c:1584] load_plugins(): [plugin manager] loaded plugin 'Cinterion'
>
> <debug> [1485259200.369385] [mm-plugin-manager.c:1584] load_plugins(): [plugin manager] loaded plugin 'Dell'
>
> <debug> [1485259200.372011] [mm-plugin-manager.c:1584] load_plugins(): [plugin manager] loaded plugin 'Ericsson MBM'
>
> <debug> [1485259200.373391] [mm-plugin-manager.c:1584] load_plugins(): [plugin manager] loaded plugin 'Generic'
>
> <debug> [1485259200.374781] [mm-plugin-manager.c:1584] load_plugins(): [plugin manager] loaded plugin 'Haier'
>
> <debug> [1485259200.526779] [mm-plugin-manager.c:1584] load_plugins(): [plugin manager] loaded plugin 'Huawei'
>
> <debug> [1485259200.528818] [mm-plugin-manager.c:1584] load_plugins(): [plugin manager] loaded plugin 'Iridium'
>
> <debug> [1485259200.530663] [mm-plugin-manager.c:1584] load_plugins(): [plugin manager] loaded plugin 'Linktop'
>
> <debug> [1485259200.532596] [mm-plugin-manager.c:1584] load_plugins(): [plugin manager] loaded plugin 'Longcheer'
>
> <debug> [1485259200.534019] [mm-plugin-manager.c:1584] load_plugins(): [plugin manager] loaded plugin 'Motorola'
>
> <debug> [1485259200.535992] [mm-plugin-manager.c:1584] load_plugins(): [plugin manager] loaded plugin 'MTK'
>
> <debug> [1485259200.539318] [mm-plugin-manager.c:1584] load_plugins(): [plugin manager] loaded plugin 'Nokia (Icera)'
>
> <debug> [1485259200.541243] [mm-plugin-manager.c:1584] load_plugins(): [plugin manager] loaded plugin 'Nokia'
>
> <debug> [1485259200.543680] [mm-plugin-manager.c:1584] load_plugins(): [plugin manager] loaded plugin 'Novatel'
>
> <debug> [1485259200.546015] [mm-plugin-manager.c:1584] load_plugins(): [plugin manager] loaded plugin 'Novatel LTE'
>
> <debug> [1485259200.548854] [mm-plugin-manager.c:1584] load_plugins(): [plugin manager] loaded plugin 'Option High-Speed'
>
> <debug> [1485259200.652838] [mm-plugin-manager.c:1584] load_plugins(): [plugin manager] loaded plugin 'Option'
>
> <debug> [1485259200.654647] [mm-plugin-manager.c:1584] load_plugins(): [plugin manager] loaded plugin 'Pantech'
>
> <debug> [1485259200.657865] [mm-plugin-manager.c:1584] load_plugins(): [plugin manager] loaded plugin 'Samsung'
>
> <debug> [1485259200.661559] [mm-plugin-manager.c:1584] load_plugins(): [plugin manager] loaded plugin 'Sierra (legacy)'
>
> <debug> [1485259200.663163] [mm-plugin-manager.c:1584] load_plugins(): [plugin manager] loaded plugin 'Sierra'
>
> <debug> [1485259200.665166] [mm-plugin-manager.c:1584] load_plugins(): [plugin manager] loaded plugin 'SimTech'
>
> <debug> [1485259200.667746] [mm-plugin-manager.c:1584] load_plugins(): [plugin manager] loaded plugin 'Telit'
>
> <debug> [1485259200.669801] [mm-plugin-manager.c:1584] load_plugins(): [plugin manager] loaded plugin 'Thuraya'
>
> <debug> [1485259200.672655] [mm-plugin-manager.c:1584] load_plugins(): [plugin manager] loaded plugin 'u-blox'
>
> <debug> [1485259200.674574] [mm-plugin-manager.c:1584] load_plugins(): [plugin manager] loaded plugin 'Via CBP7'
>
> <debug> [1485259200.676868] [mm-plugin-manager.c:1584] load_plugins(): [plugin manager] loaded plugin 'Wavecom'
>
> <debug> [1485259200.728333] [mm-plugin-manager.c:1584] load_plugins(): [plugin manager] loaded plugin 'X22X'
>
> <debug> [1485259200.731781] [mm-plugin-manager.c:1584] load_plugins(): [plugin manager] loaded plugin 'ZTE'
>
> <debug> [1485259200.731927] [mm-plugin-manager.c:1609] load_plugins(): [plugin manager] successfully loaded 31 plugins
>
> <debug> [1485259200.737048] [main.c:106] name_acquired_cb(): Service name 'org.freedesktop.ModemManager1' was acquired
>
> <debug> [1485259201.354188] [mm-base-manager.c:352] handle_kernel_event(): Kernel event reported:
>
> <debug> [1485259201.354307] [mm-base-manager.c:353] handle_kernel_event(): action: add
>
> <debug> [1485259201.354371] [mm-base-manager.c:354] handle_kernel_event(): subsystem: tty
>
> <debug> [1485259201.354430] [mm-base-manager.c:355] handle_kernel_event(): name: tty
>
> <debug> [1485259201.354487] [mm-base-manager.c:356] handle_kernel_event(): uid: n/a
>
> <debug> [1485259201.354547] [kerneldevice/mm-kernel-device-generic-rules.c:408] mm_kernel_device_generic_rules_load(): [rules] rules directory set to '/lib/udev/rules.d'...
>
> <debug> [1485259201.366782] [kerneldevice/mm-kernel-device-generic-rules.c:318] load_rules_from_file(): [rules] loading rules from: /lib/udev/rules.d/77-mm-cinterion-port-types.rules
>
> <debug> [1485259201.447695] [kerneldevice/mm-kernel-device-generic-rules.c:318] load_rules_from_file(): [rules] loading rules from: /lib/udev/rules.d/77-mm-dell-port-types.rules
>
> <debug> [1485259201.448530] [kerneldevice/mm-kernel-device-generic-rules.c:318] load_rules_from_file(): [rules] loading rules from: /lib/udev/rules.d/77-mm-ericsson-mbm.rules
>
> <debug> [1485259201.454008] [kerneldevice/mm-kernel-device-generic-rules.c:318] load_rules_from_file(): [rules] loading rules from: /lib/udev/rules.d/77-mm-haier-port-types.rules
>
> <debug> [1485259201.454770] [kerneldevice/mm-kernel-device-generic-rules.c:318] load_rules_from_file(): [rules] loading rules from: /lib/udev/rules.d/77-mm-huawei-net-port-types.rules
>
> <debug> [1485259201.456175] [kerneldevice/mm-kernel-device-generic-rules.c:318] load_rules_from_file(): [rules] loading rules from: /lib/udev/rules.d/77-mm-longcheer-port-types.rules
>
> <debug> [1485259201.485854] [kerneldevice/mm-kernel-device-generic-rules.c:318] load_rules_from_file(): [rules] loading rules from: /lib/udev/rules.d/77-mm-mtk-port-types.rules
>
> <debug> [1485259201.506711] [kerneldevice/mm-kernel-device-generic-rules.c:318] load_rules_from_file(): [rules] loading rules from: /lib/udev/rules.d/77-mm-nokia-port-types.rules
>
> <debug> [1485259201.513947] [kerneldevice/mm-kernel-device-generic-rules.c:318] load_rules_from_file(): [rules] loading rules from: /lib/udev/rules.d/77-mm-pcmcia-device-blacklist.rules
>
> <debug> [1485259201.514647] [kerneldevice/mm-kernel-device-generic-rules.c:318] load_rules_from_file(): [rules] loading rules from: /lib/udev/rules.d/77-mm-platform-serial-whitelist.rules
>
> <debug> [1485259201.515302] [kerneldevice/mm-kernel-device-generic-rules.c:318] load_rules_from_file(): [rules] loading rules from: /lib/udev/rules.d/77-mm-simtech-port-types.rules
>
> <debug> [1485259201.516895] [kerneldevice/mm-kernel-device-generic-rules.c:318] load_rules_from_file(): [rules] loading rules from: /lib/udev/rules.d/77-mm-telit-port-types.rules
>
> <debug> [1485259201.539594] [kerneldevice/mm-kernel-device-generic-rules.c:318] load_rules_from_file(): [rules] loading rules from: /lib/udev/rules.d/77-mm-usb-device-blacklist.rules
>
> <debug> [1485259201.543874] [kerneldevice/mm-kernel-device-generic-rules.c:318] load_rules_from_file(): [rules] loading rules from: /lib/udev/rules.d/77-mm-usb-serial-adapters-greylist.rules
>
> <debug> [1485259201.545604] [kerneldevice/mm-kernel-device-generic-rules.c:318] load_rules_from_file(): [rules] loading rules from: /lib/udev/rules.d/77-mm-x22x-port-types.rules
>
> <debug> [1485259201.563409] [kerneldevice/mm-kernel-device-generic-rules.c:318] load_rules_from_file(): [rules] loading rules from: /lib/udev/rules.d/77-mm-zte-port-types.rules
>
> <debug> [1485259201.582251] [kerneldevice/mm-kernel-device-generic-rules.c:318] load_rules_from_file(): [rules] loading rules from: /lib/udev/rules.d/80-mm-candidate.rules
>
> <debug> [1485259201.583105] [kerneldevice/mm-kernel-device-generic-rules.c:433] mm_kernel_device_generic_rules_load(): [rules] 621 loaded
>
> <debug> [1485259201.583527] [kerneldevice/mm-kernel-device-generic.c:828] check_preload(): (tty/tty) preloading contents and properties...
>
> <debug> [1485259201.583813] [kerneldevice/mm-kernel-device-generic.c:136] preload_sysfs_path(): (tty/tty) sysfs path: /sys/devices/virtual/tty/tty
>
> <debug> [1485259201.584014] [kerneldevice/mm-kernel-device-generic.c:345] preload_interface_class(): (tty/tty) interface class: 0x00
>
> <debug> [1485259201.584106] [kerneldevice/mm-kernel-device-generic.c:355] preload_interface_subclass(): (tty/tty) interface subclass: 0x00
>
> <debug> [1485259201.584186] [kerneldevice/mm-kernel-device-generic.c:365] preload_interface_protocol(): (tty/tty) interface protocol: 0x00
>
> <debug> [1485259201.584264] [kerneldevice/mm-kernel-device-generic.c:375] preload_interface_number(): (tty/tty) interface number (ID_USB_INTERFACE_NUM): 0x00
>
> <debug> [1485259201.584370] [kerneldevice/mm-kernel-device-generic.c:316] preload_manufacturer(): (tty/tty) manufacturer: unknown
>
> <debug> [1485259201.584442] [kerneldevice/mm-kernel-device-generic.c:334] preload_product(): (tty/tty) product: unknown
>
> <debug> [1485259201.584512] [kerneldevice/mm-kernel-device-generic.c:274] preload_physdev_vid(): (tty/tty) vid: unknown
>
> <debug> [1485259201.584579] [kerneldevice/mm-kernel-device-generic.c:298] preload_physdev_pid(): (tty/tty) pid: unknown
>
> <debug> [1485259201.584735] [kerneldevice/mm-kernel-device-generic.c:758] check_rule(): (tty/tty) property added: ID_MM_CANDIDATE=1
>
> <debug> [1485259201.584903] [mm-base-manager.c:256] device_added(): (tty/tty): adding device at sysfs path: /sys/devices/virtual/tty/tty
>
> <debug> [1485259201.585011] [kerneldevice/mm-kernel-device-generic.c:510] kernel_device_is_candidate(): (tty/tty) device without physdev sysfs path
>
> <debug> [1485259201.585099] [mm-base-manager.c:265] device_added(): (tty/tty): port not candidate
>
> <debug> [1485259201.622537] [mm-base-manager.c:352] handle_kernel_event(): Kernel event reported:
>
> <debug> [1485259201.622637] [mm-base-manager.c:353] handle_kernel_event(): action: add
>
> <debug> [1485259201.622696] [mm-base-manager.c:354] handle_kernel_event(): subsystem: tty
>
> <debug> [1485259201.622754] [mm-base-manager.c:355] handle_kernel_event(): name: console
>
> <debug> [1485259201.622813] [mm-base-manager.c:356] handle_kernel_event(): uid: n/a
>
> <debug> [1485259201.622935] [kerneldevice/mm-kernel-device-generic.c:828] check_preload(): (tty/console) preloading contents and properties...
>
> <debug> [1485259201.623191] [kerneldevice/mm-kernel-device-generic.c:136] preload_sysfs_path(): (tty/console) sysfs path: /sys/devices/virtual/tty/console
>
> <debug> [1485259201.623366] [kerneldevice/mm-kernel-device-generic.c:345] preload_interface_class(): (tty/console) interface class: 0x00
>
> <debug> [1485259201.623455] [kerneldevice/mm-kernel-device-generic.c:355] preload_interface_subclass(): (tty/console) interface subclass: 0x00
>
> <debug> [1485259201.623534] [kerneldevice/mm-kernel-device-generic.c:365] preload_interface_protocol(): (tty/console) interface protocol: 0x00
>
> <debug> [1485259201.623611] [kerneldevice/mm-kernel-device-generic.c:375] preload_interface_number(): (tty/console) interface number (ID_USB_INTERFACE_NUM): 0x00
>
> <debug> [1485259201.623714] [kerneldevice/mm-kernel-device-generic.c:316] preload_manufacturer(): (tty/console) manufacturer: unknown
>
> <debug> [1485259201.623785] [kerneldevice/mm-kernel-device-generic.c:334] preload_product(): (tty/console) product: unknown
>
> <debug> [1485259201.623856] [kerneldevice/mm-kernel-device-generic.c:274] preload_physdev_vid(): (tty/console) vid: unknown
>
> <debug> [1485259201.623925] [kerneldevice/mm-kernel-device-generic.c:298] preload_physdev_pid(): (tty/console) pid: unknown
>
> <debug> [1485259201.624083] [kerneldevice/mm-kernel-device-generic.c:758] check_rule(): (tty/console) property added: ID_MM_CANDIDATE=1
>
> <debug> [1485259201.624248] [mm-base-manager.c:256] device_added(): (tty/console): adding device at sysfs path: /sys/devices/virtual/tty/console
>
> <debug> [1485259201.624350] [kerneldevice/mm-kernel-device-generic.c:510] kernel_device_is_candidate(): (tty/console) device without physdev sysfs path
>
> <debug> [1485259201.624439] [mm-base-manager.c:265] device_added(): (tty/console): port not candidate
>
> <debug> [1485259201.729538] [mm-base-manager.c:352] handle_kernel_event(): Kernel event reported:
>
> <debug> [1485259201.729635] [mm-base-manager.c:353] handle_kernel_event(): action: add
>
> <debug> [1485259201.729714] [mm-base-manager.c:354] handle_kernel_event(): subsystem: tty
>
> <debug> [1485259201.729774] [mm-base-manager.c:355] handle_kernel_event(): name: ttyS0
>
> <debug> [1485259201.729831] [mm-base-manager.c:356] handle_kernel_event(): uid: n/a
>
> <debug> [1485259201.729955] [kerneldevice/mm-kernel-device-generic.c:828] check_preload(): (tty/ttyS0) preloading contents and properties...
>
> <debug> [1485259201.730213] [kerneldevice/mm-kernel-device-generic.c:136] preload_sysfs_path(): (tty/ttyS0) sysfs path: /sys/devices/platform/serial8250.0/tty/ttyS0
>
> <debug> [1485259201.732206] [kerneldevice/mm-kernel-device-generic.c:345] preload_interface_class(): (tty/ttyS0) interface class: 0x00
>
> <debug> [1485259201.732323] [kerneldevice/mm-kernel-device-generic.c:355] preload_interface_subclass(): (tty/ttyS0) interface subclass: 0x00
>
> <debug> [1485259201.732402] [kerneldevice/mm-kernel-device-generic.c:365] preload_interface_protocol(): (tty/ttyS0) interface protocol: 0x00
>
> <debug> [1485259201.732480] [kerneldevice/mm-kernel-device-generic.c:375] preload_interface_number(): (tty/ttyS0) interface number (ID_USB_INTERFACE_NUM): 0x00
>
> <debug> [1485259201.732589] [kerneldevice/mm-kernel-device-generic.c:316] preload_manufacturer(): (tty/ttyS0) manufacturer: unknown
>
> <debug> [1485259201.732660] [kerneldevice/mm-kernel-device-generic.c:334] preload_product(): (tty/ttyS0) product: unknown
>
> <debug> [1485259201.732730] [kerneldevice/mm-kernel-device-generic.c:274] preload_physdev_vid(): (tty/ttyS0) vid: unknown
>
> <debug> [1485259201.732797] [kerneldevice/mm-kernel-device-generic.c:298] preload_physdev_pid(): (tty/ttyS0) pid: unknown
>
> <debug> [1485259201.732967] [kerneldevice/mm-kernel-device-generic.c:758] check_rule(): (tty/ttyS0) property added: ID_MM_CANDIDATE=1
>
> <debug> [1485259201.733140] [mm-base-manager.c:256] device_added(): (tty/ttyS0): adding device at sysfs path: /sys/devices/platform/serial8250.0/tty/ttyS0
>
> <debug> [1485259201.733248] [kerneldevice/mm-kernel-device-generic.c:510] kernel_device_is_candidate(): (tty/ttyS0) device without physdev sysfs path
>
> <debug> [1485259201.733335] [mm-base-manager.c:265] device_added(): (tty/ttyS0): port not candidate
>
> <debug> [1485259201.873405] [mm-base-manager.c:352] handle_kernel_event(): Kernel event reported:
>
> <debug> [1485259201.873502] [mm-base-manager.c:353] handle_kernel_event(): action: add
>
> <debug> [1485259201.873562] [mm-base-manager.c:354] handle_kernel_event(): subsystem: net
>
> <debug> [1485259201.873619] [mm-base-manager.c:355] handle_kernel_event(): name: wlan0
>
> <debug> [1485259201.873676] [mm-base-manager.c:356] handle_kernel_event(): uid: n/a
>
> <debug> [1485259201.873797] [kerneldevice/mm-kernel-device-generic.c:828] check_preload(): (net/wlan0) preloading contents and properties...
>
> <debug> [1485259201.874056] [kerneldevice/mm-kernel-device-generic.c:136] preload_sysfs_path(): (net/wlan0) sysfs path: /sys/devices/pci0000:01/0000:01:00.0/net/wlan0
>
> <debug> [1485259201.874571] [kerneldevice/mm-kernel-device-generic.c:345] preload_interface_class(): (net/wlan0) interface class: 0x00
>
> <debug> [1485259201.874670] [kerneldevice/mm-kernel-device-generic.c:355] preload_interface_subclass(): (net/wlan0) interface subclass: 0x00
>
> <debug> [1485259201.874751] [kerneldevice/mm-kernel-device-generic.c:365] preload_interface_protocol(): (net/wlan0) interface protocol: 0x00
>
> <debug> [1485259201.874830] [kerneldevice/mm-kernel-device-generic.c:375] preload_interface_number(): (net/wlan0) interface number (ID_USB_INTERFACE_NUM): 0x00
>
> <debug> [1485259201.874934] [kerneldevice/mm-kernel-device-generic.c:316] preload_manufacturer(): (net/wlan0) manufacturer: unknown
>
> <debug> [1485259201.875006] [kerneldevice/mm-kernel-device-generic.c:334] preload_product(): (net/wlan0) product: unknown
>
> <debug> [1485259201.875075] [kerneldevice/mm-kernel-device-generic.c:274] preload_physdev_vid(): (net/wlan0) vid: unknown
>
> <debug> [1485259201.875144] [kerneldevice/mm-kernel-device-generic.c:298] preload_physdev_pid(): (net/wlan0) pid: unknown
>
> <debug> [1485259201.875332] [kerneldevice/mm-kernel-device-generic.c:758] check_rule(): (net/wlan0) property added: ID_MM_CANDIDATE=1
>
> <debug> [1485259201.875503] [mm-base-manager.c:256] device_added(): (net/wlan0): adding device at sysfs path: /sys/devices/pci0000:01/0000:01:00.0/net/wlan0
>
> <debug> [1485259201.875609] [kerneldevice/mm-kernel-device-generic.c:510] kernel_device_is_candidate(): (net/wlan0) device without physdev sysfs path
>
> <debug> [1485259201.875699] [mm-base-manager.c:265] device_added(): (net/wlan0): port not candidate
>
> <debug> [1485259202.016295] [mm-base-manager.c:352] handle_kernel_event(): Kernel event reported:
>
> <debug> [1485259202.016394] [mm-base-manager.c:353] handle_kernel_event(): action: add
>
> <debug> [1485259202.016455] [mm-base-manager.c:354] handle_kernel_event(): subsystem: net
>
> <debug> [1485259202.016512] [mm-base-manager.c:355] handle_kernel_event(): name: wlan1
>
> <debug> [1485259202.016569] [mm-base-manager.c:356] handle_kernel_event(): uid: n/a
>
> <debug> [1485259202.016693] [kerneldevice/mm-kernel-device-generic.c:828] check_preload(): (net/wlan1) preloading contents and properties...
>
> <debug> [1485259202.016954] [kerneldevice/mm-kernel-device-generic.c:136] preload_sysfs_path(): (net/wlan1) sysfs path: /sys/devices/platform/qca955x_wmac/net/wlan1
>
> <debug> [1485259202.017601] [kerneldevice/mm-kernel-device-generic.c:345] preload_interface_class(): (net/wlan1) interface class: 0x00
>
> <debug> [1485259202.017708] [kerneldevice/mm-kernel-device-generic.c:355] preload_interface_subclass(): (net/wlan1) interface subclass: 0x00
>
> <debug> [1485259202.017789] [kerneldevice/mm-kernel-device-generic.c:365] preload_interface_protocol(): (net/wlan1) interface protocol: 0x00
>
> <debug> [1485259202.017868] [kerneldevice/mm-kernel-device-generic.c:375] preload_interface_number(): (net/wlan1) interface number (ID_USB_INTERFACE_NUM): 0x00
>
> <debug> [1485259202.017976] [kerneldevice/mm-kernel-device-generic.c:316] preload_manufacturer(): (net/wlan1) manufacturer: unknown
>
> <debug> [1485259202.018049] [kerneldevice/mm-kernel-device-generic.c:334] preload_product(): (net/wlan1) product: unknown
>
> <debug> [1485259202.018120] [kerneldevice/mm-kernel-device-generic.c:274] preload_physdev_vid(): (net/wlan1) vid: unknown
>
> <debug> [1485259202.018189] [kerneldevice/mm-kernel-device-generic.c:298] preload_physdev_pid(): (net/wlan1) pid: unknown
>
> <debug> [1485259202.018363] [kerneldevice/mm-kernel-device-generic.c:758] check_rule(): (net/wlan1) property added: ID_MM_CANDIDATE=1
>
> <debug> [1485259202.018534] [mm-base-manager.c:256] device_added(): (net/wlan1): adding device at sysfs path: /sys/devices/platform/qca955x_wmac/net/wlan1
>
> <debug> [1485259202.018641] [kerneldevice/mm-kernel-device-generic.c:510] kernel_device_is_candidate(): (net/wlan1) device without physdev sysfs path
>
> <debug> [1485259202.018729] [mm-base-manager.c:265] device_added(): (net/wlan1): port not candidate
>
> <debug> [1485259202.164604] [mm-base-manager.c:352] handle_kernel_event(): Kernel event reported:
>
> <debug> [1485259202.164701] [mm-base-manager.c:353] handle_kernel_event(): action: add
>
> <debug> [1485259202.164759] [mm-base-manager.c:354] handle_kernel_event(): subsystem: net
>
> <debug> [1485259202.164817] [mm-base-manager.c:355] handle_kernel_event(): name: wwan0
>
> <debug> [1485259202.164873] [mm-base-manager.c:356] handle_kernel_event(): uid: n/a
>
> <debug> [1485259202.164996] [kerneldevice/mm-kernel-device-generic.c:828] check_preload(): (net/wwan0) preloading contents and properties...
>
> <debug> [1485259202.165272] [kerneldevice/mm-kernel-device-generic.c:136] preload_sysfs_path(): (net/wwan0) sysfs path: /sys/devices/platform/ehci-platform.1/usb2/2-1/2-1:1.12/net/wwan0
>
> <debug> [1485259202.165674] [kerneldevice/mm-kernel-device-generic.c:210] preload_interface_sysfs_path(): (net/wwan0) interface sysfs path: /sys/devices/platform/ehci-platform.1/usb2/2-1/2-1:1.12
>
> <debug> [1485259202.165917] [kerneldevice/mm-kernel-device-generic.c:345] preload_interface_class(): (net/wwan0) interface class: 0x02
>
> <debug> [1485259202.166141] [kerneldevice/mm-kernel-device-generic.c:355] preload_interface_subclass(): (net/wwan0) interface subclass: 0x0e
>
> <debug> [1485259202.166398] [kerneldevice/mm-kernel-device-generic.c:365] preload_interface_protocol(): (net/wwan0) interface protocol: 0x00
>
> <debug> [1485259202.166623] [kerneldevice/mm-kernel-device-generic.c:375] preload_interface_number(): (net/wwan0) interface number (ID_USB_INTERFACE_NUM): 0x0c
>
> <debug> [1485259202.166754] [kerneldevice/mm-kernel-device-generic.c:229] preload_physdev_sysfs_path(): (net/wwan0) physdev sysfs path: /sys/devices/platform/ehci-platform.1/usb2/2-1
>
> <debug> [1485259202.166951] [kerneldevice/mm-kernel-device-generic.c:311] preload_manufacturer(): (net/wwan0) manufacturer (ID_VENDOR): Sierra Wireless, Incorporated
>
> <debug> [1485259202.167470] [kerneldevice/mm-kernel-device-generic.c:329] preload_product(): (net/wwan0) product (ID_MODEL): Sierra Wireless MC7455 Qualcomm® Snapdragon™ X7 LTE-A
>
> <debug> [1485259202.167841] [kerneldevice/mm-kernel-device-generic.c:251] preload_driver(): (net/wwan0) driver: cdc_mbim
>
> <debug> [1485259202.168066] [kerneldevice/mm-kernel-device-generic.c:269] preload_physdev_vid(): (net/wwan0) vid (ID_VENDOR_ID): 0x1199
>
> <debug> [1485259202.168299] [kerneldevice/mm-kernel-device-generic.c:293] preload_physdev_pid(): (net/wwan0) pid (ID_MODEL_ID): 0x9071
>
> <debug> [1485259202.170036] [kerneldevice/mm-kernel-device-generic.c:758] check_rule(): (net/wwan0) property added: ID_MM_CANDIDATE=1
>
> <debug> [1485259202.170217] [mm-base-manager.c:256] device_added(): (net/wwan0): adding device at sysfs path: /sys/devices/platform/ehci-platform.1/usb2/2-1/2-1:1.12/net/wwan0
>
> <debug> [1485259202.170327] [kerneldevice/mm-kernel-device-generic.c:526] kernel_device_is_candidate(): (net/wwan0) device is candidate
>
> <debug> [1485259202.170424] [mm-base-manager.c:290] device_added(): (net/wwan0): first port in device /sys/devices/platform/ehci-platform.1/usb2/2-1
>
> <debug> [1485259202.171155] [mm-plugin-manager.c:1442] mm_plugin_manager_device_support_check(): [plugin manager] task 0: new support task for device: /sys/devices/platform/ehci-platform.1/usb2/2-1
>
> <debug> [1485259202.171657] [mm-plugin-manager.c:1167] device_context_port_grabbed(): [plugin manager] task 0: port grabbed: wwan0
>
> <debug> [1485259202.171802] [mm-plugin-manager.c:1192] device_context_port_grabbed(): [plugin manager] task 0,wwan0: new support task for port
>
> <debug> [1485259202.171869] [mm-plugin-manager.c:1197] device_context_port_grabbed(): [plugin manager) task 0,wwan0: deferred until min wait time elapsed
>
> <debug> [1485259202.412479] [mm-base-manager.c:352] handle_kernel_event(): Kernel event reported:
>
> <debug> [1485259202.412575] [mm-base-manager.c:353] handle_kernel_event(): action: add
>
> <debug> [1485259202.412635] [mm-base-manager.c:354] handle_kernel_event(): subsystem: usbmisc
>
> <debug> [1485259202.412692] [mm-base-manager.c:355] handle_kernel_event(): name: cdc-wdm0
>
> <debug> [1485259202.412749] [mm-base-manager.c:356] handle_kernel_event(): uid: n/a
>
> <debug> [1485259202.412870] [kerneldevice/mm-kernel-device-generic.c:828] check_preload(): (usbmisc/cdc-wdm0) preloading contents and properties...
>
> <debug> [1485259202.413174] [kerneldevice/mm-kernel-device-generic.c:136] preload_sysfs_path(): (usbmisc/cdc-wdm0) sysfs path: /sys/devices/platform/ehci-platform.1/usb2/2-1/2-1:1.12/usbmisc/cdc-wdm0
>
> <debug> [1485259202.413588] [kerneldevice/mm-kernel-device-generic.c:210] preload_interface_sysfs_path(): (usbmisc/cdc-wdm0) interface sysfs path: /sys/devices/platform/ehci-platform.1/usb2/2-1/2-1:1.12
>
> <debug> [1485259202.413867] [kerneldevice/mm-kernel-device-generic.c:345] preload_interface_class(): (usbmisc/cdc-wdm0) interface class: 0x02
>
> <debug> [1485259202.414092] [kerneldevice/mm-kernel-device-generic.c:355] preload_interface_subclass(): (usbmisc/cdc-wdm0) interface subclass: 0x0e
>
> <debug> [1485259202.414298] [kerneldevice/mm-kernel-device-generic.c:365] preload_interface_protocol(): (usbmisc/cdc-wdm0) interface protocol: 0x00
>
> <debug> [1485259202.414504] [kerneldevice/mm-kernel-device-generic.c:375] preload_interface_number(): (usbmisc/cdc-wdm0) interface number (ID_USB_INTERFACE_NUM): 0x0c
>
> <debug> [1485259202.414662] [kerneldevice/mm-kernel-device-generic.c:229] preload_physdev_sysfs_path(): (usbmisc/cdc-wdm0) physdev sysfs path: /sys/devices/platform/ehci-platform.1/usb2/2-1
>
> <debug> [1485259202.414855] [kerneldevice/mm-kernel-device-generic.c:311] preload_manufacturer(): (usbmisc/cdc-wdm0) manufacturer (ID_VENDOR): Sierra Wireless, Incorporated
>
> <debug> [1485259202.415064] [kerneldevice/mm-kernel-device-generic.c:329] preload_product(): (usbmisc/cdc-wdm0) product (ID_MODEL): Sierra Wireless MC7455 Qualcomm® Snapdragon™ X7 LTE-A
>
> <debug> [1485259202.415330] [kerneldevice/mm-kernel-device-generic.c:251] preload_driver(): (usbmisc/cdc-wdm0) driver: cdc_mbim
>
> <debug> [1485259202.415599] [kerneldevice/mm-kernel-device-generic.c:269] preload_physdev_vid(): (usbmisc/cdc-wdm0) vid (ID_VENDOR_ID): 0x1199
>
> <debug> [1485259202.415848] [kerneldevice/mm-kernel-device-generic.c:293] preload_physdev_pid(): (usbmisc/cdc-wdm0) pid (ID_MODEL_ID): 0x9071
>
> <debug> [1485259202.419211] [kerneldevice/mm-kernel-device-generic.c:758] check_rule(): (usbmisc/cdc-wdm0) property added: ID_MM_CANDIDATE=1
>
> <debug> [1485259202.419372] [kerneldevice/mm-kernel-device-generic.c:758] check_rule(): (usbmisc/cdc-wdm0) property added: ID_MM_CANDIDATE=1
>
> <debug> [1485259202.419525] [mm-base-manager.c:256] device_added(): (usbmisc/cdc-wdm0): adding device at sysfs path: /sys/devices/platform/ehci-platform.1/usb2/2-1/2-1:1.12/usbmisc/cdc-wdm0
>
> <debug> [1485259202.419640] [kerneldevice/mm-kernel-device-generic.c:526] kernel_device_is_candidate(): (usbmisc/cdc-wdm0) device is candidate
>
> <debug> [1485259202.419750] [mm-base-manager.c:311] device_added(): (usbmisc/cdc-wdm0): additional port in device /sys/devices/platform/ehci-platform.1/usb2/2-1
>
> <debug> [1485259202.419964] [mm-plugin-manager.c:1167] device_context_port_grabbed(): [plugin manager] task 0: port grabbed: cdc-wdm0
>
> <debug> [1485259202.420101] [mm-plugin-manager.c:1192] device_context_port_grabbed(): [plugin manager] task 0,cdc-wdm0: new support task for port
>
> <debug> [1485259202.420170] [mm-plugin-manager.c:1197] device_context_port_grabbed(): [plugin manager) task 0,cdc-wdm0: deferred until min wait time elapsed
>
> <debug> [1485259202.557463] [mm-base-manager.c:352] handle_kernel_event(): Kernel event reported:
>
> <debug> [1485259202.557561] [mm-base-manager.c:353] handle_kernel_event(): action: add
>
> <debug> [1485259202.557620] [mm-base-manager.c:354] handle_kernel_event(): subsystem: tty
>
> <debug> [1485259202.557677] [mm-base-manager.c:355] handle_kernel_event(): name: ttyUSB0
>
> <debug> [1485259202.557734] [mm-base-manager.c:356] handle_kernel_event(): uid: n/a
>
> <debug> [1485259202.557856] [kerneldevice/mm-kernel-device-generic.c:828] check_preload(): (tty/ttyUSB0) preloading contents and properties...
>
> <debug> [1485259202.558161] [kerneldevice/mm-kernel-device-generic.c:136] preload_sysfs_path(): (tty/ttyUSB0) sysfs path: /sys/devices/platform/ehci-platform.1/usb2/2-1/2-1:1.0/ttyUSB0/tty/ttyUSB0
>
> <debug> [1485259202.558765] [kerneldevice/mm-kernel-device-generic.c:210] preload_interface_sysfs_path(): (tty/ttyUSB0) interface sysfs path: /sys/devices/platform/ehci-platform.1/usb2/2-1/2-1:1.0
>
> <debug> [1485259202.559017] [kerneldevice/mm-kernel-device-generic.c:345] preload_interface_class(): (tty/ttyUSB0) interface class: 0xff
>
> <debug> [1485259202.559242] [kerneldevice/mm-kernel-device-generic.c:355] preload_interface_subclass(): (tty/ttyUSB0) interface subclass: 0xff
>
> <debug> [1485259202.559491] [kerneldevice/mm-kernel-device-generic.c:365] preload_interface_protocol(): (tty/ttyUSB0) interface protocol: 0xff
>
> <debug> [1485259202.559717] [kerneldevice/mm-kernel-device-generic.c:375] preload_interface_number(): (tty/ttyUSB0) interface number (ID_USB_INTERFACE_NUM): 0x00
>
> <debug> [1485259202.559849] [kerneldevice/mm-kernel-device-generic.c:229] preload_physdev_sysfs_path(): (tty/ttyUSB0) physdev sysfs path: /sys/devices/platform/ehci-platform.1/usb2/2-1
>
> <debug> [1485259202.560038] [kerneldevice/mm-kernel-device-generic.c:311] preload_manufacturer(): (tty/ttyUSB0) manufacturer (ID_VENDOR): Sierra Wireless, Incorporated
>
> <debug> [1485259202.560278] [kerneldevice/mm-kernel-device-generic.c:329] preload_product(): (tty/ttyUSB0) product (ID_MODEL): Sierra Wireless MC7455 Qualcomm® Snapdragon™ X7 LTE-A
>
> <debug> [1485259202.560573] [kerneldevice/mm-kernel-device-generic.c:251] preload_driver(): (tty/ttyUSB0) driver: qcserial
>
> <debug> [1485259202.560845] [kerneldevice/mm-kernel-device-generic.c:269] preload_physdev_vid(): (tty/ttyUSB0) vid (ID_VENDOR_ID): 0x1199
>
> <debug> [1485259202.561096] [kerneldevice/mm-kernel-device-generic.c:293] preload_physdev_pid(): (tty/ttyUSB0) pid (ID_MODEL_ID): 0x9071
>
> <debug> [1485259202.562736] [kerneldevice/mm-kernel-device-generic.c:758] check_rule(): (tty/ttyUSB0) property added: ID_MM_CANDIDATE=1
>
> <debug> [1485259202.562921] [mm-base-manager.c:256] device_added(): (tty/ttyUSB0): adding device at sysfs path: /sys/devices/platform/ehci-platform.1/usb2/2-1/2-1:1.0/ttyUSB0/tty/ttyUSB0
>
> <debug> [1485259202.563036] [kerneldevice/mm-kernel-device-generic.c:526] kernel_device_is_candidate(): (tty/ttyUSB0) device is candidate
>
> <debug> [1485259202.563153] [mm-base-manager.c:311] device_added(): (tty/ttyUSB0): additional port in device /sys/devices/platform/ehci-platform.1/usb2/2-1
>
> <debug> [1485259202.563379] [mm-plugin-manager.c:1167] device_context_port_grabbed(): [plugin manager] task 0: port grabbed: ttyUSB0
>
> <debug> [1485259202.563522] [mm-plugin-manager.c:1192] device_context_port_grabbed(): [plugin manager] task 0,ttyUSB0: new support task for port
>
> <debug> [1485259202.563591] [mm-plugin-manager.c:1197] device_context_port_grabbed(): [plugin manager) task 0,ttyUSB0: deferred until min wait time elapsed
>
> <debug> [1485259202.722714] [mm-base-manager.c:352] handle_kernel_event(): Kernel event reported:
>
> <debug> [1485259202.722810] [mm-base-manager.c:353] handle_kernel_event(): action: add
>
> <debug> [1485259202.722870] [mm-base-manager.c:354] handle_kernel_event(): subsystem: tty
>
> <debug> [1485259202.722927] [mm-base-manager.c:355] handle_kernel_event(): name: ttyUSB1
>
> <debug> [1485259202.722984] [mm-base-manager.c:356] handle_kernel_event(): uid: n/a
>
> <debug> [1485259202.723105] [kerneldevice/mm-kernel-device-generic.c:828] check_preload(): (tty/ttyUSB1) preloading contents and properties...
>
> <debug> [1485259202.723409] [kerneldevice/mm-kernel-device-generic.c:136] preload_sysfs_path(): (tty/ttyUSB1) sysfs path: /sys/devices/platform/ehci-platform.1/usb2/2-1/2-1:1.3/ttyUSB1/tty/ttyUSB1
>
> <debug> [1485259202.724001] [kerneldevice/mm-kernel-device-generic.c:210] preload_interface_sysfs_path(): (tty/ttyUSB1) interface sysfs path: /sys/devices/platform/ehci-platform.1/usb2/2-1/2-1:1.3
>
> <debug> [1485259202.724254] [kerneldevice/mm-kernel-device-generic.c:345] preload_interface_class(): (tty/ttyUSB1) interface class: 0xff
>
> <debug> [1485259202.724476] [kerneldevice/mm-kernel-device-generic.c:355] preload_interface_subclass(): (tty/ttyUSB1) interface subclass: 0x00
>
> <debug> [1485259202.724702] [kerneldevice/mm-kernel-device-generic.c:365] preload_interface_protocol(): (tty/ttyUSB1) interface protocol: 0x00
>
> <debug> [1485259202.724930] [kerneldevice/mm-kernel-device-generic.c:375] preload_interface_number(): (tty/ttyUSB1) interface number (ID_USB_INTERFACE_NUM): 0x03
>
> <debug> [1485259202.725063] [kerneldevice/mm-kernel-device-generic.c:229] preload_physdev_sysfs_path(): (tty/ttyUSB1) physdev sysfs path: /sys/devices/platform/ehci-platform.1/usb2/2-1
>
> <debug> [1485259202.725250] [kerneldevice/mm-kernel-device-generic.c:311] preload_manufacturer(): (tty/ttyUSB1) manufacturer (ID_VENDOR): Sierra Wireless, Incorporated
>
> <debug> [1485259202.725456] [kerneldevice/mm-kernel-device-generic.c:329] preload_product(): (tty/ttyUSB1) product (ID_MODEL): Sierra Wireless MC7455 Qualcomm® Snapdragon™ X7 LTE-A
>
> <debug> [1485259202.725739] [kerneldevice/mm-kernel-device-generic.c:251] preload_driver(): (tty/ttyUSB1) driver: qcserial
>
> <debug> [1485259202.726008] [kerneldevice/mm-kernel-device-generic.c:269] preload_physdev_vid(): (tty/ttyUSB1) vid (ID_VENDOR_ID): 0x1199
>
> <debug> [1485259202.726286] [kerneldevice/mm-kernel-device-generic.c:293] preload_physdev_pid(): (tty/ttyUSB1) pid (ID_MODEL_ID): 0x9071
>
> <debug> [1485259202.732189] [kerneldevice/mm-kernel-device-generic.c:758] check_rule(): (tty/ttyUSB1) property added: ID_MM_CANDIDATE=1
>
> <debug> [1485259202.732409] [mm-base-manager.c:256] device_added(): (tty/ttyUSB1): adding device at sysfs path: /sys/devices/platform/ehci-platform.1/usb2/2-1/2-1:1.3/ttyUSB1/tty/ttyUSB1
>
> <debug> [1485259202.732526] [kerneldevice/mm-kernel-device-generic.c:526] kernel_device_is_candidate(): (tty/ttyUSB1) device is candidate
>
> <debug> [1485259202.732657] [mm-base-manager.c:311] device_added(): (tty/ttyUSB1): additional port in device /sys/devices/platform/ehci-platform.1/usb2/2-1
>
> <debug> [1485259202.732893] [mm-plugin-manager.c:1167] device_context_port_grabbed(): [plugin manager] task 0: port grabbed: ttyUSB1
>
> <debug> [1485259202.733041] [mm-plugin-manager.c:1192] device_context_port_grabbed(): [plugin manager] task 0,ttyUSB1: new support task for port
>
> <debug> [1485259202.733109] [mm-plugin-manager.c:1197] device_context_port_grabbed(): [plugin manager) task 0,ttyUSB1: deferred until min wait time elapsed
>
> <debug> [1485259202.858265] [mm-base-manager.c:352] handle_kernel_event(): Kernel event reported:
>
> <debug> [1485259202.858365] [mm-base-manager.c:353] handle_kernel_event(): action: add
>
> <debug> [1485259202.858425] [mm-base-manager.c:354] handle_kernel_event(): subsystem: net
>
> <debug> [1485259202.858482] [mm-base-manager.c:355] handle_kernel_event(): name: br-lan
>
> <debug> [1485259202.858539] [mm-base-manager.c:356] handle_kernel_event(): uid: n/a
>
> <debug> [1485259202.858660] [kerneldevice/mm-kernel-device-generic.c:828] check_preload(): (net/br-lan) preloading contents and properties...
>
> <debug> [1485259202.858913] [kerneldevice/mm-kernel-device-generic.c:136] preload_sysfs_path(): (net/br-lan) sysfs path: /sys/devices/virtual/net/br-lan
>
> <debug> [1485259202.859092] [kerneldevice/mm-kernel-device-generic.c:345] preload_interface_class(): (net/br-lan) interface class: 0x00
>
> <debug> [1485259202.859184] [kerneldevice/mm-kernel-device-generic.c:355] preload_interface_subclass(): (net/br-lan) interface subclass: 0x00
>
> <debug> [1485259202.859264] [kerneldevice/mm-kernel-device-generic.c:365] preload_interface_protocol(): (net/br-lan) interface protocol: 0x00
>
> <debug> [1485259202.859343] [kerneldevice/mm-kernel-device-generic.c:375] preload_interface_number(): (net/br-lan) interface number (ID_USB_INTERFACE_NUM): 0x00
>
> <debug> [1485259202.859445] [kerneldevice/mm-kernel-device-generic.c:316] preload_manufacturer(): (net/br-lan) manufacturer: unknown
>
> <debug> [1485259202.859518] [kerneldevice/mm-kernel-device-generic.c:334] preload_product(): (net/br-lan) product: unknown
>
> <debug> [1485259202.859590] [kerneldevice/mm-kernel-device-generic.c:274] preload_physdev_vid(): (net/br-lan) vid: unknown
>
> <debug> [1485259202.859661] [kerneldevice/mm-kernel-device-generic.c:298] preload_physdev_pid(): (net/br-lan) pid: unknown
>
> <debug> [1485259202.859823] [kerneldevice/mm-kernel-device-generic.c:758] check_rule(): (net/br-lan) property added: ID_MM_CANDIDATE=1
>
> <debug> [1485259202.859987] [mm-base-manager.c:256] device_added(): (net/br-lan): adding device at sysfs path: /sys/devices/virtual/net/br-lan
>
> <debug> [1485259202.860093] [kerneldevice/mm-kernel-device-generic.c:510] kernel_device_is_candidate(): (net/br-lan) device without physdev sysfs path
>
> <debug> [1485259202.860220] [mm-base-manager.c:265] device_added(): (net/br-lan): port not candidate
>
> <debug> [1485259203.672838] [mm-plugin-manager.c:1110] device_context_min_wait_time_elapsed(): [plugin manager] task 0: min wait time elapsed
>
> <debug> [1485259203.672986] [mm-plugin.c:310] apply_pre_probing_filters(): (Altair LTE) [ttyUSB1] filtered by implicit MBIM driver
>
> <debug> [1485259203.673076] [mm-plugin.c:310] apply_pre_probing_filters(): (AnyDATA) [ttyUSB1] filtered by implicit MBIM driver
>
> <debug> [1485259203.673162] [mm-plugin.c:310] apply_pre_probing_filters(): (Cinterion) [ttyUSB1] filtered by implicit MBIM driver
>
> <debug> [1485259203.673272] [mm-plugin.c:376] apply_pre_probing_filters(): (Dell) [ttyUSB1] filtered by vendor/product IDs
>
> <debug> [1485259203.673368] [mm-plugin.c:429] apply_pre_probing_filters(): (Ericsson MBM) [ttyUSB1] filtered by udev tags
>
> <debug> [1485259203.673450] [mm-plugin.c:310] apply_pre_probing_filters(): (Haier) [ttyUSB1] filtered by implicit MBIM driver
>
> <debug> [1485259203.673532] [mm-plugin.c:376] apply_pre_probing_filters(): (Huawei) [ttyUSB1] filtered by vendor/product IDs
>
> <debug> [1485259203.673617] [mm-plugin.c:310] apply_pre_probing_filters(): (Iridium) [ttyUSB1] filtered by implicit MBIM driver
>
> <debug> [1485259203.673700] [mm-plugin.c:310] apply_pre_probing_filters(): (Linktop) [ttyUSB1] filtered by implicit MBIM driver
>
> <debug> [1485259203.673786] [mm-plugin.c:310] apply_pre_probing_filters(): (Longcheer) [ttyUSB1] filtered by implicit MBIM driver
>
> <debug> [1485259203.673872] [mm-plugin.c:310] apply_pre_probing_filters(): (Motorola) [ttyUSB1] filtered by implicit MBIM driver
>
> <debug> [1485259203.673957] [mm-plugin.c:310] apply_pre_probing_filters(): (MTK) [ttyUSB1] filtered by implicit MBIM driver
>
> <debug> [1485259203.674041] [mm-plugin.c:310] apply_pre_probing_filters(): (Nokia (Icera)) [ttyUSB1] filtered by implicit MBIM driver
>
> <debug> [1485259203.674126] [mm-plugin.c:310] apply_pre_probing_filters(): (Nokia) [ttyUSB1] filtered by implicit MBIM driver
>
> <debug> [1485259203.674209] [mm-plugin.c:310] apply_pre_probing_filters(): (Novatel) [ttyUSB1] filtered by implicit MBIM driver
>
> <debug> [1485259203.674292] [mm-plugin.c:310] apply_pre_probing_filters(): (Novatel LTE) [ttyUSB1] filtered by implicit MBIM driver
>
> <debug> [1485259203.674378] [mm-plugin.c:264] apply_pre_probing_filters(): (Option High-Speed) [ttyUSB1] filtered by drivers
>
> <debug> [1485259203.674461] [mm-plugin.c:264] apply_pre_probing_filters(): (Option) [ttyUSB1] filtered by drivers
>
> <debug> [1485259203.674541] [mm-plugin.c:310] apply_pre_probing_filters(): (Pantech) [ttyUSB1] filtered by implicit MBIM driver
>
> <debug> [1485259203.674624] [mm-plugin.c:310] apply_pre_probing_filters(): (Samsung) [ttyUSB1] filtered by implicit MBIM driver
>
> <debug> [1485259203.674708] [mm-plugin.c:264] apply_pre_probing_filters(): (Sierra (legacy)) [ttyUSB1] filtered by drivers
>
> <debug> [1485259203.674805] [mm-plugin-manager.c:599] port_context_run(): [plugin manager] task 0,ttyUSB1: found '2' plugins to try
>
> <debug> [1485259203.674881] [mm-plugin-manager.c:622] port_context_run(): [plugin manager] task 0,ttyUSB1: will try with plugin 'Sierra'
>
> <debug> [1485259203.674951] [mm-plugin-manager.c:622] port_context_run(): [plugin manager] task 0,ttyUSB1: will try with plugin 'Generic'
>
> <debug> [1485259203.675059] [mm-plugin-manager.c:635] port_context_run(): [plugin manager) task 0,ttyUSB1: started
>
> <debug> [1485259203.675131] [mm-plugin-manager.c:519] port_context_next(): [plugin manager] task 0,ttyUSB1: checking with plugin 'Sierra'
>
> <debug> [1485259203.675346] [mm-plugin.c:803] mm_plugin_supports_port(): (Sierra) [ttyUSB1] probe required: 'at, qcdm'
>
> <debug> [1485259203.675519] [mm-port-probe.c:1385] mm_port_probe_run(): (tty/ttyUSB1) launching port probing: 'at, qcdm'
>
> <debug> [1485259203.675682] [mm-plugin.c:310] apply_pre_probing_filters(): (Altair LTE) [ttyUSB0] filtered by implicit MBIM driver
>
> <debug> [1485259203.675780] [mm-plugin.c:310] apply_pre_probing_filters(): (AnyDATA) [ttyUSB0] filtered by implicit MBIM driver
>
> <debug> [1485259203.675866] [mm-plugin.c:310] apply_pre_probing_filters(): (Cinterion) [ttyUSB0] filtered by implicit MBIM driver
>
> <debug> [1485259203.675950] [mm-plugin.c:376] apply_pre_probing_filters(): (Dell) [ttyUSB0] filtered by vendor/product IDs
>
> <debug> [1485259203.676040] [mm-plugin.c:429] apply_pre_probing_filters(): (Ericsson MBM) [ttyUSB0] filtered by udev tags
>
> <debug> [1485259203.676123] [mm-plugin.c:310] apply_pre_probing_filters(): (Haier) [ttyUSB0] filtered by implicit MBIM driver
>
> <debug> [1485259203.676205] [mm-plugin.c:376] apply_pre_probing_filters(): (Huawei) [ttyUSB0] filtered by vendor/product IDs
>
> <debug> [1485259203.676311] [mm-plugin.c:310] apply_pre_probing_filters(): (Iridium) [ttyUSB0] filtered by implicit MBIM driver
>
> <debug> [1485259203.676399] [mm-plugin.c:310] apply_pre_probing_filters(): (Linktop) [ttyUSB0] filtered by implicit MBIM driver
>
> <debug> [1485259203.676484] [mm-plugin.c:310] apply_pre_probing_filters(): (Longcheer) [ttyUSB0] filtered by implicit MBIM driver
>
> <debug> [1485259203.676571] [mm-plugin.c:310] apply_pre_probing_filters(): (Motorola) [ttyUSB0] filtered by implicit MBIM driver
>
> <debug> [1485259203.676658] [mm-plugin.c:310] apply_pre_probing_filters(): (MTK) [ttyUSB0] filtered by implicit MBIM driver
>
> <debug> [1485259203.676743] [mm-plugin.c:310] apply_pre_probing_filters(): (Nokia (Icera)) [ttyUSB0] filtered by implicit MBIM driver
>
> <debug> [1485259203.676830] [mm-plugin.c:310] apply_pre_probing_filters(): (Nokia) [ttyUSB0] filtered by implicit MBIM driver
>
> <debug> [1485259203.676915] [mm-plugin.c:310] apply_pre_probing_filters(): (Novatel) [ttyUSB0] filtered by implicit MBIM driver
>
> <debug> [1485259203.676999] [mm-plugin.c:310] apply_pre_probing_filters(): (Novatel LTE) [ttyUSB0] filtered by implicit MBIM driver
>
> <debug> [1485259203.677085] [mm-plugin.c:264] apply_pre_probing_filters(): (Option High-Speed) [ttyUSB0] filtered by drivers
>
> <debug> [1485259203.677169] [mm-plugin.c:264] apply_pre_probing_filters(): (Option) [ttyUSB0] filtered by drivers
>
> <debug> [1485259203.681221] [mm-plugin.c:310] apply_pre_probing_filters(): (Pantech) [ttyUSB0] filtered by implicit MBIM driver
>
> <debug> [1485259203.681314] [mm-plugin.c:310] apply_pre_probing_filters(): (Samsung) [ttyUSB0] filtered by implicit MBIM driver
>
> <debug> [1485259203.681398] [mm-plugin.c:264] apply_pre_probing_filters(): (Sierra (legacy)) [ttyUSB0] filtered by drivers
>
> <debug> [1485259203.681496] [mm-plugin-manager.c:599] port_context_run(): [plugin manager] task 0,ttyUSB0: found '2' plugins to try
>
> <debug> [1485259203.681572] [mm-plugin-manager.c:622] port_context_run(): [plugin manager] task 0,ttyUSB0: will try with plugin 'Sierra'
>
> <debug> [1485259203.681642] [mm-plugin-manager.c:622] port_context_run(): [plugin manager] task 0,ttyUSB0: will try with plugin 'Generic'
>
> <debug> [1485259203.681752] [mm-plugin-manager.c:635] port_context_run(): [plugin manager) task 0,ttyUSB0: started
>
> <debug> [1485259203.681824] [mm-plugin-manager.c:519] port_context_next(): [plugin manager] task 0,ttyUSB0: checking with plugin 'Sierra'
>
> <debug> [1485259203.682020] [mm-plugin.c:803] mm_plugin_supports_port(): (Sierra) [ttyUSB0] probe required: 'at, qcdm'
>
> <debug> [1485259203.682180] [mm-port-probe.c:1385] mm_port_probe_run(): (tty/ttyUSB0) launching port probing: 'at, qcdm'
>
> <debug> [1485259203.682334] [mm-plugin.c:212] apply_pre_probing_filters(): (Altair LTE) [cdc-wdm0] filtered by subsystem
>
> <debug> [1485259203.682430] [mm-plugin.c:310] apply_pre_probing_filters(): (AnyDATA) [cdc-wdm0] filtered by implicit MBIM driver
>
> <debug> [1485259203.682519] [mm-plugin.c:310] apply_pre_probing_filters(): (Cinterion) [cdc-wdm0] filtered by implicit MBIM driver
>
> <debug> [1485259203.682604] [mm-plugin.c:376] apply_pre_probing_filters(): (Dell) [cdc-wdm0] filtered by vendor/product IDs
>
> <debug> [1485259203.682697] [mm-plugin.c:429] apply_pre_probing_filters(): (Ericsson MBM) [cdc-wdm0] filtered by udev tags
>
> <debug> [1485259203.682775] [mm-plugin.c:212] apply_pre_probing_filters(): (Haier) [cdc-wdm0] filtered by subsystem
>
> <debug> [1485259203.682853] [mm-plugin.c:376] apply_pre_probing_filters(): (Huawei) [cdc-wdm0] filtered by vendor/product IDs
>
> <debug> [1485259203.682933] [mm-plugin.c:212] apply_pre_probing_filters(): (Iridium) [cdc-wdm0] filtered by subsystem
>
> <debug> [1485259203.683009] [mm-plugin.c:212] apply_pre_probing_filters(): (Linktop) [cdc-wdm0] filtered by subsystem
>
> <debug> [1485259203.683085] [mm-plugin.c:212] apply_pre_probing_filters(): (Longcheer) [cdc-wdm0] filtered by subsystem
>
> <debug> [1485259203.683161] [mm-plugin.c:212] apply_pre_probing_filters(): (Motorola) [cdc-wdm0] filtered by subsystem
>
> <debug> [1485259203.683236] [mm-plugin.c:212] apply_pre_probing_filters(): (MTK) [cdc-wdm0] filtered by subsystem
>
> <debug> [1485259203.683335] [mm-plugin.c:212] apply_pre_probing_filters(): (Nokia (Icera)) [cdc-wdm0] filtered by subsystem
>
> <debug> [1485259203.683416] [mm-plugin.c:212] apply_pre_probing_filters(): (Nokia) [cdc-wdm0] filtered by subsystem
>
> <debug> [1485259203.683495] [mm-plugin.c:310] apply_pre_probing_filters(): (Novatel) [cdc-wdm0] filtered by implicit MBIM driver
>
> <debug> [1485259203.683575] [mm-plugin.c:212] apply_pre_probing_filters(): (Novatel LTE) [cdc-wdm0] filtered by subsystem
>
> <debug> [1485259203.683651] [mm-plugin.c:212] apply_pre_probing_filters(): (Option High-Speed) [cdc-wdm0] filtered by subsystem
>
> <debug> [1485259203.683729] [mm-plugin.c:212] apply_pre_probing_filters(): (Option) [cdc-wdm0] filtered by subsystem
>
> <debug> [1485259203.683807] [mm-plugin.c:310] apply_pre_probing_filters(): (Pantech) [cdc-wdm0] filtered by implicit MBIM driver
>
> <debug> [1485259203.683888] [mm-plugin.c:212] apply_pre_probing_filters(): (Samsung) [cdc-wdm0] filtered by subsystem
>
> <debug> [1485259203.683963] [mm-plugin.c:212] apply_pre_probing_filters(): (Sierra (legacy)) [cdc-wdm0] filtered by subsystem
>
> <debug> [1485259203.684059] [mm-plugin-manager.c:599] port_context_run(): [plugin manager] task 0,cdc-wdm0: found '2' plugins to try
>
> <debug> [1485259203.684131] [mm-plugin-manager.c:622] port_context_run(): [plugin manager] task 0,cdc-wdm0: will try with plugin 'Sierra'
>
> <debug> [1485259203.684198] [mm-plugin-manager.c:622] port_context_run(): [plugin manager] task 0,cdc-wdm0: will try with plugin 'Generic'
>
> <debug> [1485259203.684323] [mm-plugin-manager.c:635] port_context_run(): [plugin manager) task 0,cdc-wdm0: started
>
> <debug> [1485259203.684396] [mm-plugin-manager.c:519] port_context_next(): [plugin manager] task 0,cdc-wdm0: checking with plugin 'Sierra'
>
> <debug> [1485259203.684558] [mm-plugin.c:803] mm_plugin_supports_port(): (Sierra) [cdc-wdm0] probe required: 'mbim'
>
> <debug> [1485259203.684685] [mm-port-probe.c:1385] mm_port_probe_run(): (usbmisc/cdc-wdm0) launching port probing: 'mbim'
>
> <debug> [1485259203.684809] [mm-plugin.c:310] apply_pre_probing_filters(): (Altair LTE) [wwan0] filtered by implicit MBIM driver
>
> <debug> [1485259203.684899] [mm-plugin.c:310] apply_pre_probing_filters(): (AnyDATA) [wwan0] filtered by implicit MBIM driver
>
> <debug> [1485259203.684982] [mm-plugin.c:310] apply_pre_probing_filters(): (Cinterion) [wwan0] filtered by implicit MBIM driver
>
> <debug> [1485259203.685061] [mm-plugin.c:376] apply_pre_probing_filters(): (Dell) [wwan0] filtered by vendor/product IDs
>
> <debug> [1485259203.685149] [mm-plugin.c:429] apply_pre_probing_filters(): (Ericsson MBM) [wwan0] filtered by udev tags
>
> <debug> [1485259203.685226] [mm-plugin.c:212] apply_pre_probing_filters(): (Haier) [wwan0] filtered by subsystem
>
> <debug> [1485259203.685303] [mm-plugin.c:376] apply_pre_probing_filters(): (Huawei) [wwan0] filtered by vendor/product IDs
>
> <debug> [1485259203.685377] [mm-plugin.c:212] apply_pre_probing_filters(): (Iridium) [wwan0] filtered by subsystem
>
> <debug> [1485259203.685453] [mm-plugin.c:212] apply_pre_probing_filters(): (Linktop) [wwan0] filtered by subsystem
>
> <debug> [1485259203.685529] [mm-plugin.c:212] apply_pre_probing_filters(): (Longcheer) [wwan0] filtered by subsystem
>
> <debug> [1485259203.685603] [mm-plugin.c:212] apply_pre_probing_filters(): (Motorola) [wwan0] filtered by subsystem
>
> <debug> [1485259203.685677] [mm-plugin.c:212] apply_pre_probing_filters(): (MTK) [wwan0] filtered by subsystem
>
> <debug> [1485259203.685756] [mm-plugin.c:310] apply_pre_probing_filters(): (Nokia (Icera)) [wwan0] filtered by implicit MBIM driver
>
> <debug> [1485259203.685834] [mm-plugin.c:212] apply_pre_probing_filters(): (Nokia) [wwan0] filtered by subsystem
>
> <debug> [1485259203.685913] [mm-plugin.c:310] apply_pre_probing_filters(): (Novatel) [wwan0] filtered by implicit MBIM driver
>
> <debug> [1485259203.685995] [mm-plugin.c:310] apply_pre_probing_filters(): (Novatel LTE) [wwan0] filtered by implicit MBIM driver
>
> <debug> [1485259203.686078] [mm-plugin.c:264] apply_pre_probing_filters(): (Option High-Speed) [wwan0] filtered by drivers
>
> <debug> [1485259203.686174] [mm-plugin.c:212] apply_pre_probing_filters(): (Option) [wwan0] filtered by subsystem
>
> <debug> [1485259203.686257] [mm-plugin.c:310] apply_pre_probing_filters(): (Pantech) [wwan0] filtered by implicit MBIM driver
>
> <debug> [1485259203.686340] [mm-plugin.c:310] apply_pre_probing_filters(): (Samsung) [wwan0] filtered by implicit MBIM driver
>
> <debug> [1485259203.686423] [mm-plugin.c:264] apply_pre_probing_filters(): (Sierra (legacy)) [wwan0] filtered by drivers
>
> <debug> [1485259203.686514] [mm-plugin-manager.c:599] port_context_run(): [plugin manager] task 0,wwan0: found '2' plugins to try
>
> <debug> [1485259203.686588] [mm-plugin-manager.c:622] port_context_run(): [plugin manager] task 0,wwan0: will try with plugin 'Sierra'
>
> <debug> [1485259203.686658] [mm-plugin-manager.c:622] port_context_run(): [plugin manager] task 0,wwan0: will try with plugin 'Generic'
>
> <debug> [1485259203.686759] [mm-plugin-manager.c:635] port_context_run(): [plugin manager) task 0,wwan0: started
>
> <debug> [1485259203.686831] [mm-plugin-manager.c:519] port_context_next(): [plugin manager] task 0,wwan0: checking with plugin 'Sierra'
>
> <debug> [1485259203.686977] [mm-plugin.c:729] mm_plugin_supports_port(): (Sierra) [wwan0] probing deferred until result suggested
>
> <debug> [1485259203.687144] [mm-plugin-manager.c:453] port_context_defer_until_suggested(): [plugin manager] task 0,wwan0: deferring support check until result suggested
>
> <debug> [1485259203.695411] [mm-port-serial.c:1158] mm_port_serial_open(): (ttyUSB1) opening serial port...
>
> <warn> [1485259203.698637] [mm-port-serial.c:513] real_config_fd(): (ttyUSB1): port attributes not fully set
>
> <debug> [1485259203.698842] [mm-port-serial.c:1288] mm_port_serial_open(): (ttyUSB1) device open count is 1 (open)
>
> <debug> [1485259203.699556] [mm-port-serial.c:1158] mm_port_serial_open(): (ttyUSB0) opening serial port...
>
> <warn> [1485259203.699905] [mm-port-serial.c:513] real_config_fd(): (ttyUSB0): port attributes not fully set
>
> <debug> [1485259203.700099] [mm-port-serial.c:1288] mm_port_serial_open(): (ttyUSB0) device open count is 1 (open)
>
> <debug> [1485259203.700305] [mm-port-probe.c:550] wdm_probe_mbim(): (usbmisc/cdc-wdm0) probing MBIM...
>
> opening device...cannot connect to proxy: Could not connect: Connection refusedspawning new mbim-proxy (try 1)...<debug> [1485259203.859417] [mm-port-serial-at.c:459] debug_log(): (ttyUSB1): --> 'AT<CR>'
>
> <debug> [1485259203.859624] [mm-port-serial-at.c:459] debug_log(): (ttyUSB0): --> 'AT<CR>'
>
> [/dev/cdc-wdm0] Read max control message size from descriptors file: 4096[/dev/cdc-wdm0] Sent message...
>
> <<<<<< RAW:
>
> <<<<<< length = 88
>
> <<<<<< data = 03:00:00:00:58:00:00:00:01:00:00:00:01:00:00:00:00:00:00:00:83:8C:F7:FB:8D:0D:4D:7F:87:1E:D7:1D:BE:FB:B3:9B:01:00:00:00:01:00:00:00:28:00:00:00:0C:00:00:00:1A:00:00:00:1E:00:00:00:2F:00:64:00:65:00:76:00:2F:00:63:00:64:00:63:00:2D:00:77:00:64:00:6D:00:30:00:00:00
>
> [/dev/cdc-wdm0] Sent message (translated)...
>
> <<<<<< Header:
>
> <<<<<< length = 88
>
> <<<<<< type = command (0x00000003)
>
> <<<<<< transaction = 1
>
> <<<<<< Fragment header:
>
> <<<<<< total = 1
>
> <<<<<< current = 0
>
> <<<<<< Contents:
>
> <<<<<< service = 'proxy-control' (838cf7fb-8d0d-4d7f-871e-d71dbefbb39b)
>
> <<<<<< cid = 'configuration' (0x00000001)
>
> <<<<<< type = 'set' (0x00000001)
>
> <debug> [1485259204.107666] [mm-port-serial-at.c:459] debug_log(): (ttyUSB1): <-- 'AT'
>
> <debug> [1485259204.112423] [mm-port-serial-at.c:459] debug_log(): (ttyUSB1): <-- '<CR>'
>
> <debug> [1485259204.112818] [mm-port-serial-at.c:459] debug_log(): (ttyUSB1): <-- '<CR><LF>OK<CR><LF>'
>
> <debug> [1485259204.113125] [mm-port-probe.c:154] mm_port_probe_set_result_at(): (tty/ttyUSB1) port is AT-capable
>
> <debug> [1485259204.113284] [mm-plugin-manager.c:283] port_context_supported(): [plugin manager] task 0,ttyUSB1: found best plugin for port (Sierra)
>
> <debug> [1485259204.113391] [mm-plugin-manager.c:265] port_context_complete(): [plugin manager] task 0,ttyUSB1: finished in '1.380362' seconds
>
> <debug> [1485259204.113534] [mm-plugin-manager.c:913] device_context_set_best_plugin(): [plugin manager] task 0,ttyUSB1: found best plugin: Sierra
>
> <debug> [1485259204.113670] [mm-plugin-manager.c:366] port_context_set_suggestion(): [plugin manager] task 0,ttyUSB0: got suggested plugin (Sierra)
>
> <debug> [1485259204.113765] [mm-plugin-manager.c:366] port_context_set_suggestion(): [plugin manager] task 0,cdc-wdm0: got suggested plugin (Sierra)
>
> <debug> [1485259204.113841] [mm-plugin-manager.c:326] port_context_set_suggestion(): [plugin manager] task 0,wwan0: deferred task completed, got suggested plugin (Sierra)
>
> <debug> [1485259204.114033] [mm-plugin-manager.c:1005] device_context_continue(): [plugin Manager] task 0: still 3 running probes (3 active): ttyUSB0, cdc-wdm0, wwan0
>
> <debug> [1485259204.114273] [mm-port-serial.c:1345] _close_internal(): (ttyUSB1) device open count is 0 (close)
>
> <debug> [1485259204.114375] [mm-port-serial.c:1361] _close_internal(): (ttyUSB1) closing serial port...
>
> <debug> [1485259204.117488] [mm-port-serial.c:1409] _close_internal(): (ttyUSB1) serial port closed
>
> <debug> [1485259204.117808] [mm-port-serial.c:1471] port_serial_close_force(): (ttyUSB1) forced to close port
>
> <debug> [1485259204.118011] [mm-plugin-manager.c:519] port_context_next(): [plugin manager] task 0,wwan0: checking with plugin 'Sierra'
>
> <debug> [1485259204.118204] [mm-plugin.c:729] mm_plugin_supports_port(): (Sierra) [wwan0] probing deferred until result suggested
>
> <debug> [1485259204.118381] [mm-plugin-manager.c:434] port_context_defer_until_suggested(): [plugin manager] task 0,wwan0: completed, got suggested plugin (Sierra)
>
> <debug> [1485259204.118482] [mm-plugin-manager.c:265] port_context_complete(): [plugin manager] task 0,wwan0: finished in '1.946700' seconds
>
> <debug> [1485259204.118594] [mm-plugin-manager.c:966] device_context_set_best_plugin(): [plugin manager] task 0,wwan0: best plugin matches device reported one: Sierra
>
> <debug> [1485259204.118716] [mm-plugin-manager.c:1005] device_context_continue(): [plugin Manager] task 0: still 2 running probes (2 active): ttyUSB0, cdc-wdm0
>
> <debug> [1485259204.672539] [mm-plugin-manager.c:1058] device_context_min_probing_time_elapsed(): [plugin manager] task 0: min probing time elapsed
>
> <debug> [1485259204.672706] [mm-plugin-manager.c:1005] device_context_continue(): [plugin Manager] task 0: still 2 running probes (2 active): ttyUSB0, cdc-wdm0
>
> [/dev/cdc-wdm0] Received message...
>
> >>>>>> RAW:
>
> >>>>>> length = 48
>
> >>>>>> data = 03:00:00:80:30:00:00:00:01:00:00:00:01:00:00:00:00:00:00:00:83:8C:F7:FB:8D:0D:4D:7F:87:1E:D7:1D:BE:FB:B3:9B:01:00:00:00:00:00:00:00:00:00:00:00
>
> [/dev/cdc-wdm0] Received message (translated)...
>
> >>>>>> Header:
>
> >>>>>> length = 48
>
> >>>>>> type = command-done (0x80000003)
>
> >>>>>> transaction = 1
>
> >>>>>> Fragment header:
>
> >>>>>> total = 1
>
> >>>>>> current = 0
>
> >>>>>> Contents:
>
> >>>>>> status error = 'None' (0x00000000)
>
> >>>>>> service = 'proxy-control' (838cf7fb-8d0d-4d7f-871e-d71dbefbb39b)
>
> >>>>>> cid = 'configuration' (0x00000001)
>
> [/dev/cdc-wdm0] Sent message...
>
> <<<<<< RAW:
>
> <<<<<< length = 16
>
> <<<<<< data = 01:00:00:00:10:00:00:00:02:00:00:00:00:10:00:00
>
> [/dev/cdc-wdm0] Sent message (translated)...
>
> <<<<<< Header:
>
> <<<<<< length = 16
>
> <<<<<< type = open (0x00000001)
>
> <<<<<< transaction = 2
>
> <<<<<< Contents:
>
> <<<<<< max_control_transfer = 4096
>
> [/dev/cdc-wdm0] Received message...
>
> >>>>>> RAW:
>
> >>>>>> length = 16
>
> >>>>>> data = 01:00:00:80:10:00:00:00:02:00:00:00:00:00:00:00
>
> <debug> [1485259206.155705] [mm-port-probe.c:303] 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:03:00:00:00
>
> [/dev/cdc-wdm0] Sent message (translated)...
>
> <<<<<< Header:
>
> <<<<<< length = 12
>
> <<<<<< type = close (0x00000002)
>
> <<<<<< transaction = 3
>
> [/dev/cdc-wdm0] Received message...
>
> >>>>>> RAW:
>
> >>>>>> length = 16
>
> >>>>>> data = 02:00:00:80:10:00:00:00:03:00:00:00:00:00:00:00
>
> <debug> [1485259206.158100] [mm-plugin-manager.c:283] port_context_supported(): [plugin manager] task 0,cdc-wdm0: found best plugin for port (Sierra)
>
> <debug> [1485259206.158251] [mm-plugin-manager.c:265] port_context_complete(): [plugin manager] task 0,cdc-wdm0: finished in '3.738168' seconds
>
> <debug> [1485259206.158367] [mm-plugin-manager.c:966] device_context_set_best_plugin(): [plugin manager] task 0,cdc-wdm0: best plugin matches device reported one: Sierra
>
> <debug> [1485259206.158471] [mm-plugin-manager.c:1005] device_context_continue(): [plugin Manager] task 0: still 1 running probes (1 active): ttyUSB0
>
> <debug> [1485259206.948750] [mm-port-probe-at.c:43] mm_port_probe_response_processor_is_at(): Parsing AT got: 'Serial command timed out'
>
> <debug> [1485259206.949106] [mm-port-serial-at.c:459] debug_log(): (ttyUSB0): --> 'AT<CR>'
>
> <debug> [1485259209.950621] [mm-port-probe-at.c:43] mm_port_probe_response_processor_is_at(): Parsing AT got: 'Serial command timed out'
>
> <debug> [1485259209.950966] [mm-port-serial-at.c:459] debug_log(): (ttyUSB0): --> 'AT<CR>'
>
> <debug> [1485259212.948214] [mm-port-probe-at.c:43] mm_port_probe_response_processor_is_at(): Parsing AT got: 'Serial command timed out'
>
> <debug> [1485259212.948345] [mm-port-probe.c:164] mm_port_probe_set_result_at(): (tty/ttyUSB0) port is not AT-capable
>
> <debug> [1485259212.948559] [mm-port-probe.c:690] serial_probe_qcdm(): (tty/ttyUSB0) probing QCDM...
>
> <debug> [1485259212.948671] [mm-port-serial.c:1345] _close_internal(): (ttyUSB0) device open count is 0 (close)
>
> <debug> [1485259212.948757] [mm-port-serial.c:1361] _close_internal(): (ttyUSB0) closing serial port...
>
> <debug> [1485259212.949107] [mm-port-serial.c:1409] _close_internal(): (ttyUSB0) serial port closed
>
> <debug> [1485259212.949310] [mm-port-serial.c:1471] port_serial_close_force(): (ttyUSB0) forced to close port
>
> <debug> [1485259212.949668] [mm-port-serial.c:1158] mm_port_serial_open(): (ttyUSB0) opening serial port...
>
> <debug> [1485259212.950067] [mm-port-serial.c:1288] mm_port_serial_open(): (ttyUSB0) device open count is 1 (open)
>
> <debug> [1485259212.950373] [mm-port-serial-qcdm.c:221] debug_log(): (ttyUSB0): --> 7e 00 78 f0 7e
>
> <debug> [1485259212.953240] [mm-port-serial-qcdm.c:221] debug_log(): (ttyUSB0): <-- 00 4a 75 6e 20 33 30 20 32 30 31 (tel:20%2033%2030%2020%2032%2030%2031) 36 31 31 3a 31 31 3a 32 31 4a 75 6e 20 31 37 20 32 30 31 (tel:20%2031%2037%2020%2032%2030%2031) 36 30 36 3a 30 30 3a 30 30 43 32 32 30 30 (tel:30%2030%2043%2032%2032%2030%2030) 33 30 30 3a 06 ff 64 00 02 09 22 (tel:64%2000%2002%2009%2022) f4 d4 7e
>
> <debug> [1485259212.953481] [mm-port-probe.c:242] mm_port_probe_set_result_qcdm(): (tty/ttyUSB0) port is QCDM-capable
>
> <debug> [1485259212.953604] [mm-plugin-manager.c:283] port_context_supported(): [plugin manager] task 0,ttyUSB0: found best plugin for port (Sierra)
>
> <debug> [1485259212.953692] [mm-plugin-manager.c:265] port_context_complete(): [plugin manager] task 0,ttyUSB0: finished in '10.390190' seconds
>
> <debug> [1485259212.953800] [mm-plugin-manager.c:966] device_context_set_best_plugin(): [plugin manager] task 0,ttyUSB0: best plugin matches device reported one: Sierra
>
> <debug> [1485259212.953886] [mm-plugin-manager.c:979] device_context_continue(): [plugin manager] task 0: no more ports to probe
>
> <debug> [1485259212.953961] [mm-plugin-manager.c:813] device_context_complete(): [plugin manager] task 0: finished in '10.782835' seconds
>
> <info> [1485259212.954154] [mm-device.c:366] mm_device_create_modem(): [device /sys/devices/platform/ehci-platform.1/usb2/2-1] creating modem with plugin 'Sierra' and '4' ports
>
> <debug> [1485259212.954299] [sierra/mm-plugin-sierra.c:66] create_modem(): MBIM-powered Sierra modem found...
>
> <debug> [1485259212.973163] [mm-base-modem.c:286] mm_base_modem_grab_port(): (ttyUSB1) type 'at' claimed by /sys/devices/platform/ehci-platform.1/usb2/2-1
>
> <debug> [1485259212.973593] [mm-base-modem.c:286] mm_base_modem_grab_port(): (ttyUSB0) type 'qcdm' claimed by /sys/devices/platform/ehci-platform.1/usb2/2-1
>
> <debug> [1485259212.973885] [mm-base-modem.c:286] mm_base_modem_grab_port(): (cdc-wdm0) type 'mbim' claimed by /sys/devices/platform/ehci-platform.1/usb2/2-1
>
> <debug> [1485259212.974149] [mm-base-modem.c:286] mm_base_modem_grab_port(): (wwan0) type 'net' claimed by /sys/devices/platform/ehci-platform.1/usb2/2-1
>
> <debug> [1485259212.974337] [mm-base-modem.c:887] log_port(): (/sys/devices/platform/ehci-platform.1/usb2/2-1) tty/ttyUSB1 at (primary)
>
> <debug> [1485259212.974440] [mm-base-modem.c:887] log_port(): (/sys/devices/platform/ehci-platform.1/usb2/2-1) net/wwan0 data (primary)
>
> <debug> [1485259212.974524] [mm-base-modem.c:887] log_port(): (/sys/devices/platform/ehci-platform.1/usb2/2-1) tty/ttyUSB0 qcdm
>
> <debug> [1485259212.974610] [mm-base-modem.c:887] log_port(): (/sys/devices/platform/ehci-platform.1/usb2/2-1) usb/cdc-wdm0 mbim (primary)
>
> <info> [1485259212.987547] [mm-base-manager.c:187] device_support_check_ready(): Modem for device '/sys/devices/platform/ehci-platform.1/usb2/2-1' successfully created
>
> <debug> [1485259212.987838] [mm-port-serial.c:1345] _close_internal(): (ttyUSB0) device open count is 0 (close)
>
> <debug> [1485259212.987938] [mm-port-serial.c:1361] _close_internal(): (ttyUSB0) closing serial port...
>
> <debug> [1485259212.988275] [mm-port-serial.c:1409] _close_internal(): (ttyUSB0) serial port closed
>
> <debug> [1485259212.988497] [mm-port-serial.c:1471] port_serial_close_force(): (ttyUSB0) forced to close port
>
> opening device...[/dev/cdc-wdm0] Read max control message size from descriptors file: 4096[/dev/cdc-wdm0] Sent message...
>
> <<<<<< RAW:
>
> <<<<<< length = 88
>
> <<<<<< data = 03:00:00:00:58:00:00:00:01:00:00:00:01:00:00:00:00:00:00:00:83:8C:F7:FB:8D:0D:4D:7F:87:1E:D7:1D:BE:FB:B3:9B:01:00:00:00:01:00:00:00:28:00:00:00:0C:00:00:00:1A:00:00:00:1E:00:00:00:2F:00:64:00:65:00:76:00:2F:00:63:00:64:00:63:00:2D:00:77:00:64:00:6D:00:30:00:00:00
>
> [/dev/cdc-wdm0] Sent message (translated)...
>
> <<<<<< Header:
>
> <<<<<< length = 88
>
> <<<<<< type = command (0x00000003)
>
> <<<<<< transaction = 1
>
> <<<<<< Fragment header:
>
> <<<<<< total = 1
>
> <<<<<< current = 0
>
> <<<<<< Contents:
>
> <<<<<< service = 'proxy-control' (838cf7fb-8d0d-4d7f-871e-d71dbefbb39b)
>
> <<<<<< cid = 'configuration' (0x00000001)
>
> <<<<<< type = 'set' (0x00000001)
>
> [/dev/cdc-wdm0] Received message...
>
> >>>>>> RAW:
>
> >>>>>> length = 48
>
> >>>>>> data = 03:00:00:80:30:00:00:00:01:00:00:00:01:00:00:00:00:00:00:00:83:8C:F7:FB:8D:0D:4D:7F:87:1E:D7:1D:BE:FB:B3:9B:01:00:00:00:00:00:00:00:00:00:00:00
>
> [/dev/cdc-wdm0] Received message (translated)...
>
> >>>>>> Header:
>
> >>>>>> length = 48
>
> >>>>>> type = command-done (0x80000003)
>
> >>>>>> transaction = 1
>
> >>>>>> Fragment header:
>
> >>>>>> total = 1
>
> >>>>>> current = 0
>
> >>>>>> Contents:
>
> >>>>>> status error = 'None' (0x00000000)
>
> >>>>>> service = 'proxy-control' (838cf7fb-8d0d-4d7f-871e-d71dbefbb39b)
>
> >>>>>> cid = 'configuration' (0x00000001)
>
> [/dev/cdc-wdm0] Sent message...
>
> <<<<<< RAW:
>
> <<<<<< length = 16
>
> <<<<<< data = 01:00:00:00:10:00:00:00:02:00:00:00:00:10:00:00
>
> [/dev/cdc-wdm0] Sent message (translated)...
>
> <<<<<< Header:
>
> <<<<<< length = 16
>
> <<<<<< type = open (0x00000001)
>
> <<<<<< transaction = 2
>
> <<<<<< Contents:
>
> <<<<<< max_control_transfer = 4096
>
> [/dev/cdc-wdm0] Received message...
>
> >>>>>> RAW:
>
> >>>>>> length = 16
>
> >>>>>> data = 01:00:00:80:10:00:00:00:02:00:00:00:00:00:00:00
>
> <debug> [1485259213.035466] [mm-port-serial.c:1158] mm_port_serial_open(): (ttyUSB1) opening serial port...
>
> <warn> [1485259213.036085] [mm-port-serial.c:513] real_config_fd(): (ttyUSB1): port attributes not fully set
>
> <debug> [1485259213.036284] [mm-port-serial.c:1288] mm_port_serial_open(): (ttyUSB1) device open count is 1 (open)
>
> <debug> [1485259213.036377] [mm-port-serial-at.c:495] mm_port_serial_at_run_init_sequence(): (ttyUSB1): running init sequence...
>
> <debug> [1485259213.036726] [mm-port-serial.c:1288] mm_port_serial_open(): (ttyUSB1) device open count is 2 (open)
>
> <debug> [1485259213.036953] [mm-port-serial.c:1288] mm_port_serial_open(): (ttyUSB1) device open count is 3 (open)
>
> <debug> [1485259213.042475] [mm-broadband-modem-mbim.c:221] modem_load_current_capabilities(): loading current capabilities...
>
> [/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: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 = 3
>
> <<<<<< Fragment header:
>
> <<<<<< total = 1
>
> <<<<<< current = 0
>
> <<<<<< Contents:
>
> <<<<<< service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>
> <<<<<< cid = 'device-caps' (0x00000001)
>
> <<<<<< type = 'query' (0x00000000)
>
> <debug> [1485259213.057351] [mm-port-serial-at.c:459] debug_log(): (ttyUSB1): --> 'ATE0<CR>'
>
> <debug> [1485259213.062050] [mm-port-serial-at.c:459] debug_log(): (ttyUSB1): <-- 'ATE'
>
> <debug> [1485259213.064738] [mm-port-serial-at.c:459] debug_log(): (ttyUSB1): <-- '0<CR>'
>
> <debug> [1485259213.065724] [mm-port-serial-at.c:459] debug_log(): (ttyUSB1): <-- '<CR><LF>OK<CR><LF>'
>
> <debug> [1485259213.066144] [mm-port-serial-at.c:459] debug_log(): (ttyUSB1): --> 'ATV1<CR>'
>
> <debug> [1485259213.073080] [mm-port-serial-at.c:459] debug_log(): (ttyUSB1): <-- '<CR><LF>OK<CR><LF>'
>
> <debug> [1485259213.073508] [mm-port-serial-at.c:459] debug_log(): (ttyUSB1): --> 'AT+CMEE=1<CR>'
>
> <debug> [1485259213.088460] [mm-port-serial-at.c:459] debug_log(): (ttyUSB1): <-- '<CR><LF>OK<CR><LF>'
>
> <debug> [1485259213.088887] [mm-port-serial-at.c:459] debug_log(): (ttyUSB1): --> 'ATX4<CR>'
>
> [/dev/cdc-wdm0] Received message...
>
> >>>>>> RAW:
>
> >>>>>> length = 196
>
> >>>>>> data = 03:00:00:80:C4: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:01:00:00:00:00:00:00:00:94:00:00:00:03:00:00:00:01:00:00:00:01:00:00:00:02:00:00:00:3C:00:00:00:03:00:00:00:01: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:28:00:00:00:88:00:00:00:0C:00:00:00:33:00:35:00:39:00:30:00:37:00:32:00:30:00:36:00:30:00:32:00:39:00:32:00:36:00:35:00:39:00:00:00:53:00:57:00:49:00:39:00:58:00:33:00:30:00:43:00:5F:00:30:00:32:00:2E:00:32:00:30:00:2E:00:30:00:33:00:2E:00:30:00:30:00:4D:00:43:00:37:00:34:00:35:00:35:00
>
> [/dev/cdc-wdm0] Received message (translated)...
>
> >>>>>> Header:
>
> >>>>>> length = 196
>
> >>>>>> 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 = 'device-caps' (0x00000001)
>
> <debug> [1485259213.098415] [mm-port-serial-at.c:459] debug_log(): (ttyUSB1): <-- '<CR><LF>OK<CR><LF>'
>
> <debug> [1485259213.098887] [mm-broadband-modem-mbim.c:147] modem_load_current_capabilities_finish(): loaded modem capabilities: gsm-umts, lte
>
> <debug> [1485259213.099251] [mm-iface-modem.c:4372] interface_initialization_step(): Modem allows up to 1 bearers
>
> <debug> [1485259213.099346] [mm-bearer-list.c:270] mm_bearer_list_new(): Creating bearer list (max: 1, max active: 1)
>
> <debug> [1485259213.100664] [mm-modem-helpers.c:310] mm_create_device_identifier(): Device ID source '0000119900009071359072060292659SWI9X30C_02.20.03.00MBIM[1199:9071]Sierra'
>
> <debug> [1485259213.100759] [mm-modem-helpers.c:311] mm_create_device_identifier(): Device ID '1404de2498fc8078e94bc55ab5ac5e4872bbf081'
>
> [/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: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 = 4
>
> <<<<<< Fragment header:
>
> <<<<<< total = 1
>
> <<<<<< current = 0
>
> <<<<<< Contents:
>
> <<<<<< service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>
> <<<<<< cid = 'radio-state' (0x00000003)
>
> <<<<<< type = 'query' (0x00000000)
>
> <debug> [1485259213.107389] [mm-port-serial-at.c:459] debug_log(): (ttyUSB1): --> 'AT&C1<CR>'
>
> <debug> [1485259213.118711] [mm-port-serial-at.c:459] debug_log(): (ttyUSB1): <-- '<CR><LF>OK<CR><LF>'
>
> <debug> [1485259213.119152] [mm-port-serial-at.c:459] debug_log(): (ttyUSB1): --> 'ATE0<CR>'
>
> <debug> [1485259213.125083] [mm-port-serial-at.c:459] debug_log(): (ttyUSB1): <-- '<CR><LF>OK<CR><LF>'
>
> <debug> [1485259213.125420] [mm-port-serial.c:1345] _close_internal(): (ttyUSB1) device open count is 2 (close)
>
> <debug> [1485259213.125654] [mm-port-serial-at.c:459] debug_log(): (ttyUSB1): --> 'AT+CMEE=1<CR>'
>
> <debug> [1485259213.140378] [mm-port-serial-at.c:459] debug_log(): (ttyUSB1): <-- '<CR><LF>OK<CR><LF>'
>
> <debug> [1485259213.140844] [mm-port-serial.c:1345] _close_internal(): (ttyUSB1) device open count is 1 (close)
>
> [/dev/cdc-wdm0] Received message...
>
> >>>>>> RAW:
>
> >>>>>> length = 56
>
> >>>>>> data = 03:00:00:80:38: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: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 = 4
>
> >>>>>> 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: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: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 = 5
>
> <<<<<< 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 = 148
>
> >>>>>> data = 03:00:00:80:94: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:02:00:00:00:00:00:00:00:64:00:00:00:01:00:00:00:1C:00:00:00:1E:00:00:00:3C:00:00:00:28:00:00:00:00:00:00:00:00:00:00:00:33:00:31:00:30:00:31:00:32:00:30:00:31:00:32:00:31:00:36:00:38:00:33:00:36:00:37:00:36:00:00:00:38:00:39:00:30:00:31:00:31:00:32:00:30:00:31:00:30:00:30:00:30:00:32:00:31:00:36:00:38:00:33:00:36:00:37:00:36:00:35:00
>
> [/dev/cdc-wdm0] Received message (translated)...
>
> >>>>>> Header:
>
> >>>>>> length = 148
>
> >>>>>> 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 = 'subscriber-ready-status' (0x00000002)
>
> <debug> [1485259213.226274] [mm-iface-modem.c:3099] update_lock_info_context_step(): SIM is ready, and no need for the after SIM unlock step...
>
> [/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:03: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)
>
> [/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 = 148
>
> >>>>>> data = 03:00:00:80:94: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:64:00:00:00:01:00:00:00:1C:00:00:00:1E:00:00:00:3C:00:00:00:28:00:00:00:00:00:00:00:00:00:00:00:33:00:31:00:30:00:31:00:32:00:30:00:31:00:32:00:31:00:36:00:38:00:33:00:36:00:37:00:36:00:00:00:38:00:39:00:30:00:31:00:31:00:32:00:30:00:31:00:30:00:30:00:30:00:32:00:31:00:36:00:38:00:33:00:36:00:37:00:36:00:35:00
>
> [/dev/cdc-wdm0] Received message (translated)...
>
> >>>>>> Header:
>
> >>>>>> length = 148
>
> >>>>>> 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 = 148
>
> >>>>>> data = 03:00:00:80:94: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:64:00:00:00:01:00:00:00:1C:00:00:00:1E:00:00:00:3C:00:00:00:28:00:00:00:00:00:00:00:00:00:00:00:33:00:31:00:30:00:31:00:32:00:30:00:31:00:32:00:31:00:36:00:38:00:33:00:36:00:37:00:36:00:00:00:38:00:39:00:30:00:31:00:31:00:32:00:30:00:31:00:30:00:30:00:30:00:32:00:31:00:36:00:38:00:33:00:36:00:37:00:36:00:35:00
>
> [/dev/cdc-wdm0] Received message (translated)...
>
> >>>>>> Header:
>
> >>>>>> length = 148
>
> >>>>>> 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 = 104
>
> >>>>>> data = 03:00:00:80:68: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:38:00:00:00:20:00:00:00:0C: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:33:00:31:00:30:00:31:00:32:00:30:00:53:00:70:00:72:00:69:00:6E:00:74:00
>
> [/dev/cdc-wdm0] Received message (translated)...
>
> >>>>>> Header:
>
> >>>>>> length = 104
>
> >>>>>> type = command-done (0x80000003)
>
> >>>>>> transaction = 9
>
> >>>>>> 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: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 = 104
>
> >>>>>> data = 03:00:00:80:68: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:38:00:00:00:20:00:00:00:0C: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:33:00:31:00:30:00:31:00:32:00:30:00:53:00:70:00:72:00:69:00:6E:00:74:00
>
> [/dev/cdc-wdm0] Received message (translated)...
>
> >>>>>> Header:
>
> >>>>>> length = 104
>
> >>>>>> type = command-done (0x80000003)
>
> >>>>>> transaction = 10
>
> >>>>>> 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: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 = 148
>
> >>>>>> data = 03:00:00:80:94: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:64:00:00:00:01:00:00:00:1C:00:00:00:1E:00:00:00:3C:00:00:00:28:00:00:00:00:00:00:00:00:00:00:00:33:00:31:00:30:00:31:00:32:00:30:00:31:00:32:00:31:00:36:00:38:00:33:00:36:00:37:00:36:00:00:00:38:00:39:00:30:00:31:00:31:00:32:00:30:00:31:00:30:00:30:00:30:00:32:00:31:00:36:00:38:00:33:00:36:00:37:00:36:00:35:00
>
> [/dev/cdc-wdm0] Received message (translated)...
>
> >>>>>> Header:
>
> >>>>>> length = 148
>
> >>>>>> 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)
>
> [/dev/cdc-wdm0] Sent message...
>
> <<<<<< RAW:
>
> <<<<<< length = 48
>
> <<<<<< data = 03:00:00:00:30: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: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 = 12
>
> <<<<<< 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: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:05:00:00:00:00:00:00:00:A0:00:00:00:02: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 = 12
>
> >>>>>> Fragment header:
>
> >>>>>> total = 1
>
> >>>>>> current = 0
>
> >>>>>> Contents:
>
> >>>>>> status error = 'None' (0x00000000)
>
> >>>>>> service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>
> >>>>>> cid = 'pin-list' (0x00000005)
>
> <debug> [1485259213.676117] [mm-port-serial.c:1288] mm_port_serial_open(): (ttyUSB1) device open count is 2 (open)
>
> <debug> [1485259213.676439] [mm-port-serial-at.c:459] debug_log(): (ttyUSB1): --> 'AT+CUSD=?<CR>'
>
> <debug> [1485259213.690847] [mm-port-serial-at.c:459] debug_log(): (ttyUSB1): <-- '<CR><LF>+CUSD: (0-2)<CR><LF><CR><LF>OK<CR><LF>'
>
> <debug> [1485259213.691645] [mm-port-serial.c:1345] _close_internal(): (ttyUSB1) device open count is 1 (close)
>
> <debug> [1485259213.694147] [mm-broadband-modem-mbim.c:2914] messaging_check_support(): Messaging capabilities supported
>
> <debug> [1485259213.694540] [mm-iface-modem-messaging.c:1149] load_supported_storages_ready(): Supported storages loaded:
>
> <debug> [1485259213.694613] [mm-iface-modem-messaging.c:1150] load_supported_storages_ready(): mem1 (list/read/delete) storages: 'mt'
>
> <debug> [1485259213.694679] [mm-iface-modem-messaging.c:1151] load_supported_storages_ready(): mem2 (write/send) storages: 'mt'
>
> <debug> [1485259213.694743] [mm-iface-modem-messaging.c:1152] load_supported_storages_ready(): mem3 (reception) storages: 'mt'
>
> <debug> [1485259213.695021] [mm-port-serial.c:1288] mm_port_serial_open(): (ttyUSB1) device open count is 2 (open)
>
> <debug> [1485259213.695315] [mm-port-serial-at.c:459] debug_log(): (ttyUSB1): --> 'AT+CPMS?<CR>'
>
> <debug> [1485259213.710848] [mm-port-serial-at.c:459] debug_log(): (ttyUSB1): <-- '<CR><LF>+CPMS: "SM",0,0,"SM",0,0,"SR",0,0<CR><LF><CR><LF>OK<CR><LF>'
>
> <debug> [1485259213.711420] [mm-broadband-modem.c:5337] cpms_query_ready(): Current storages initialized:
>
> <debug> [1485259213.711543] [mm-broadband-modem.c:5339] cpms_query_ready(): mem1 (list/read/delete) storages: 'sm'
>
> <debug> [1485259213.711632] [mm-broadband-modem.c:5341] cpms_query_ready(): mem2 (write/send) storages: 'sm'
>
> <debug> [1485259213.711714] [mm-iface-modem-messaging.c:1232] init_current_storages_ready(): Current storages initialized
>
> <debug> [1485259213.712059] [mm-port-serial.c:1345] _close_internal(): (ttyUSB1) device open count is 1 (close)
>
> <debug> [1485259213.712858] [mm-port-serial.c:1288] mm_port_serial_open(): (ttyUSB1) device open count is 2 (open)
>
> <debug> [1485259213.713175] [mm-port-serial-at.c:459] debug_log(): (ttyUSB1): --> 'ATH<CR>'
>
> <debug> [1485259213.719456] [mm-port-serial-at.c:459] debug_log(): (ttyUSB1): <-- '<CR><LF>OK<CR><LF>'
>
> <debug> [1485259213.720103] [mm-port-serial.c:1345] _close_internal(): (ttyUSB1) device open count is 1 (close)
>
> <debug> [1485259213.720803] [mm-port-serial.c:1288] mm_port_serial_open(): (ttyUSB1) device open count is 2 (open)
>
> <debug> [1485259213.721138] [mm-port-serial-at.c:459] debug_log(): (ttyUSB1): --> 'AT+CTZU=1<CR>'
>
> <debug> [1485259213.736212] [mm-port-serial-at.c:459] debug_log(): (ttyUSB1): <-- '<CR><LF>OK<CR><LF>'
>
> <debug> [1485259213.736722] [mm-port-serial-at.c:459] debug_log(): (ttyUSB1): --> 'AT+CCLK?<CR>'
>
> <debug> [1485259213.749597] [mm-port-serial-at.c:459] debug_log(): (ttyUSB1): <-- '<CR><LF>+CCLK: "17/01/24,12:04:29-20"<CR><LF><CR><LF>OK<CR><LF>'
>
> <debug> [1485259213.750254] [mm-port-serial.c:1345] _close_internal(): (ttyUSB1) device open count is 1 (close)
>
> <debug> [1485259213.751386] [mm-broadband-modem.c:9919] iface_modem_signal_initialize_ready(): Couldn't initialize interface: 'Extended Signal information not supported'
>
> <debug> [1485259213.752635] [mm-broadband-modem.c:9920] iface_modem_oma_initialize_ready(): Couldn't initialize interface: 'OMA not supported'
>
> <debug> [1485259213.753314] [mm-broadband-modem.c:9921] iface_modem_firmware_initialize_ready(): Couldn't initialize interface: 'Firmware interface not available'
>
> <info> [1485259213.754112] [mm-iface-modem.c:1431] __iface_modem_update_state_internal(): Modem: state changed (unknown -> disabled)
>
> <debug> [1485259213.754630] [mm-port-serial.c:1345] _close_internal(): (ttyUSB1) device open count is 0 (close)
>
> <debug> [1485259213.754750] [mm-port-serial.c:1361] _close_internal(): (ttyUSB1) closing serial port...
>
> <debug> [1485259213.755325] [mm-port-serial.c:1409] _close_internal(): (ttyUSB1) serial port closed
>
> <debug> [1485259213.755538] [mm-base-modem.c:856] initialize_ready(): modem properly initialized
>
> <debug> [1485259213.763735] [mm-device.c:282] export_modem(): [device /sys/devices/platform/ehci-platform.1/usb2/2-1] exported modem at path '/org/freedesktop/ModemManager1/Modem/0'
>
> <debug> [1485259213.763859] [mm-device.c:283] export_modem(): [device /sys/devices/platform/ehci-platform.1/usb2/2-1] plugin: Sierra
>
> <debug> [1485259213.763934] [mm-device.c:287] export_modem(): [device /sys/devices/platform/ehci-platform.1/usb2/2-1] vid:pid: 0x1199:0x9071
>
> <info> [1485259216.668116] [mm-iface-modem-simple.c:641] connect_auth_ready(): Simple connect started...
>
> <debug> [1485259216.668220] [mm-iface-modem-simple.c:651] connect_auth_ready(): PIN: unspecified
>
> <debug> [1485259216.668283] [mm-iface-modem-simple.c:653] connect_auth_ready(): Operator ID: unspecified
>
> <debug> [1485259216.668347] [mm-iface-modem-simple.c:655] connect_auth_ready(): Allowed roaming: yes
>
> <debug> [1485259216.668411] [mm-iface-modem-simple.c:657] connect_auth_ready(): APN: n.ij.ispsn
>
> <debug> [1485259216.668473] [mm-iface-modem-simple.c:665] connect_auth_ready(): IP family: unspecified
>
> <debug> [1485259216.668537] [mm-iface-modem-simple.c:673] connect_auth_ready(): Allowed authentication: unspecified
>
> <debug> [1485259216.668600] [mm-iface-modem-simple.c:675] connect_auth_ready(): User: unspecified
>
> <debug> [1485259216.668661] [mm-iface-modem-simple.c:677] connect_auth_ready(): Password: unspecified
>
> <debug> [1485259216.668725] [mm-iface-modem-simple.c:679] connect_auth_ready(): Number: unspecified
>
> <info> [1485259216.668784] [mm-iface-modem-simple.c:461] connection_step(): Simple connect state (3/8): Enable
>
> <info> [1485259216.669035] [mm-iface-modem.c:1431] __iface_modem_update_state_internal(): Modem /org/freedesktop/ModemManager1/Modem/0: state changed (disabled -> enabling)
>
> <debug> [1485259216.675080] [mm-broadband-modem.c:8821] enabling_started(): Skipping modem initialization: device hotplugged
>
> <debug> [1485259216.675194] [mm-port-serial.c:1158] mm_port_serial_open(): (ttyUSB1) opening serial port...
>
> <warn> [1485259216.675843] [mm-port-serial.c:513] real_config_fd(): (ttyUSB1): port attributes not fully set
>
> <debug> [1485259216.676039] [mm-port-serial.c:1288] mm_port_serial_open(): (ttyUSB1) device open count is 1 (open)
>
> <debug> [1485259216.676129] [mm-port-serial-at.c:495] mm_port_serial_at_run_init_sequence(): (ttyUSB1): running init sequence...
>
> <debug> [1485259216.676424] [mm-port-serial.c:1158] mm_port_serial_open(): (ttyUSB0) opening serial port...
>
> <debug> [1485259216.676812] [mm-port-serial.c:1288] mm_port_serial_open(): (ttyUSB0) device open count is 1 (open)
>
> <debug> [1485259216.676937] [mm-broadband-modem.c:8837] enabling_started(): Flashing primary AT port before enabling...
>
> <debug> [1485259216.677175] [mm-port-serial-at.c:459] debug_log(): (ttyUSB1): --> 'ATE0<CR>'
>
> <debug> [1485259216.683080] [mm-port-serial-at.c:459] debug_log(): (ttyUSB1): <-- '<CR><LF>OK<CR><LF>'
>
> <debug> [1485259216.683516] [mm-port-serial-at.c:459] debug_log(): (ttyUSB1): --> 'ATV1<CR>'
>
> <debug> [1485259216.690580] [mm-port-serial-at.c:459] debug_log(): (ttyUSB1): <-- '<CR><LF>OK<CR><LF>'
>
> <debug> [1485259216.691005] [mm-port-serial-at.c:459] debug_log(): (ttyUSB1): --> 'AT+CMEE=1<CR>'
>
> <debug> [1485259216.705833] [mm-port-serial-at.c:459] debug_log(): (ttyUSB1): <-- '<CR><LF>OK<CR><LF>'
>
> <debug> [1485259216.706257] [mm-port-serial-at.c:459] debug_log(): (ttyUSB1): --> 'ATX4<CR>'
>
> <debug> [1485259216.714451] [mm-port-serial-at.c:459] debug_log(): (ttyUSB1): <-- '<CR><LF>OK<CR><LF>'
>
> <debug> [1485259216.714874] [mm-port-serial-at.c:459] debug_log(): (ttyUSB1): --> 'AT&C1<CR>'
>
> <debug> [1485259216.740344] [mm-port-serial-at.c:459] debug_log(): (ttyUSB1): <-- '<CR><LF>OK<CR><LF>'
>
> [/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: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 = 13
>
> <<<<<< 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: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: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 = 13
>
> >>>>>> Fragment header:
>
> >>>>>> total = 1
>
> >>>>>> current = 0
>
> >>>>>> Contents:
>
> >>>>>> status error = 'None' (0x00000000)
>
> >>>>>> service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>
> >>>>>> cid = 'radio-state' (0x00000003)
>
> <debug> [1485259216.809903] [mm-iface-modem.c:3296] set_power_state(): No need to change power state: already in 'on' power state
>
> <debug> [1485259216.810186] [mm-broadband-modem.c:9482] enabling_step(): Modem has 3GPP capabilities, enabling the Modem 3GPP interface...
>
> <debug> [1485259216.810334] [mm-broadband-modem-mbim.c:2298] common_setup_cleanup_unsolicited_events(): Supported notifications: signal (yes), registration (no), sms (no), connect (yes), subscriber (yes), packet (yes)
>
> <debug> [1485259216.810591] [mm-broadband-modem-mbim.c:2437] 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: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: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 = 14
>
> <<<<<< 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: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: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 = 14
>
> >>>>>> 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> [1485259216.813111] [mm-broadband-modem-mbim.c:2298] common_setup_cleanup_unsolicited_events(): Supported notifications: signal (yes), registration (yes), sms (no), connect (yes), subscriber (yes), packet (yes)
>
> <debug> [1485259216.813410] [mm-broadband-modem-mbim.c:2437] 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: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: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 = 15
>
> <<<<<< 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: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: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 = 15
>
> >>>>>> 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> [1485259216.816056] [mm-broadband-modem.c:9495] enabling_step(): Modem has 3GPP/USSD capabilities, enabling the Modem 3GPP/USSD interface...
>
> <debug> [1485259216.816261] [mm-broadband-modem.c:4974] set_unsolicited_result_code_handlers(): (ttyUSB1) Setting unsolicited result code handlers
>
> <debug> [1485259216.816570] [mm-port-serial.c:1288] mm_port_serial_open(): (ttyUSB1) device open count is 2 (open)
>
> <debug> [1485259216.816868] [mm-port-serial-at.c:459] debug_log(): (ttyUSB1): --> 'AT+CUSD=1<CR>'
>
> <debug> [1485259216.832214] [mm-port-serial-at.c:459] debug_log(): (ttyUSB1): <-- '<CR><LF>OK<CR><LF>'
>
> <debug> [1485259216.832788] [mm-port-serial.c:1345] _close_internal(): (ttyUSB1) device open count is 1 (close)
>
> <debug> [1485259216.836027] [mm-broadband-modem.c:9523] enabling_step(): Modem has location capabilities, enabling the Location interface...
>
> <debug> [1485259216.836225] [mm-iface-modem-location.c:762] setup_gathering(): Need to enable the following location sources: '3gpp-lac-ci'
>
> <debug> [1485259216.836571] [mm-iface-modem-3gpp.c:798] 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: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: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 = 16
>
> <<<<<< Fragment header:
>
> <<<<<< total = 1
>
> <<<<<< current = 0
>
> <<<<<< Contents:
>
> <<<<<< service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>
> <<<<<< cid = 'register-state' (0x00000009)
>
> <<<<<< type = 'query' (0x00000000)
>
> <debug> [1485259216.841076] [mm-broadband-modem.c:9536] enabling_step(): Modem has messaging capabilities, enabling the Messaging interface...
>
> <debug> [1485259216.841526] [mm-broadband-modem-mbim.c:3069] load_initial_sms_parts(): loading SMS parts...
>
> [/dev/cdc-wdm0] Sent message...
>
> <<<<<< RAW:
>
> <<<<<< length = 60
>
> <<<<<< data = 03:00:00:00:3C:00:00:00:11: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 = 17
>
> <<<<<< 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 = 120
>
> >>>>>> data = 03:00:00:80:78: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:09:00:00:00:00:00:00:00:48:00:00:00:00:00:00:00:03:00:00:00:01:00:00:00:20:00:00:00:01:00:00:00:30:00:00:00:0C:00:00:00:3C:00:00:00:0C:00:00:00:00:00:00:00:00:00:00:00:02:00:00:00:33:00:31:00:30:00:31:00:32:00:30:00:53:00:70:00:72:00:69:00:6E:00:74:00
>
> [/dev/cdc-wdm0] Received message (translated)...
>
> >>>>>> Header:
>
> >>>>>> length = 120
>
> >>>>>> 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 = 'register-state' (0x00000009)
>
> <info> [1485259216.874167] [mm-iface-modem-3gpp.c:1224] update_registration_state(): Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP Registration state changed (unknown -> registering)
>
> <debug> [1485259216.874537] [mm-iface-modem.c:933] mm_iface_modem_update_access_technologies(): Modem /org/freedesktop/ModemManager1/Modem/0: access technology changed (unknown -> lte)
>
> <debug> [1485259216.874972] [mm-iface-modem-location.c:297] notify_3gpp_location_update(): Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP location updated (MCC: '310', MNC: '120', Location area code: '0', Cell ID: '0')
>
> <info> [1485259216.884982] [mm-iface-modem-3gpp.c:1141] update_registration_reload_current_registration_info_ready(): Modem /org/freedesktop/ModemManager1/Modem/0: 3GPP Registration state changed (registering -> home)
>
> <debug> [1485259216.885354] [mm-iface-modem.c:1600] get_updated_consolidated_state(): Will start keeping track of state for subsystem '3gpp'
>
> [/dev/cdc-wdm0] Received message...
>
> >>>>>> RAW:
>
> >>>>>> length = 56
>
> >>>>>> data = 03:00:00:80:38:00:00:00:11: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 = 17
>
> >>>>>> Fragment header:
>
> >>>>>> total = 1
>
> >>>>>> current = 0
>
> >>>>>> Contents:
>
> >>>>>> status error = 'None' (0x00000000)
>
> >>>>>> service = 'sms' (533fbeeb-14fe-4467-9f90-33a223e56c3f)
>
> >>>>>> cid = 'read' (0x00000002)
>
> <debug> [1485259216.937981] [mm-broadband-modem-mbim.c:2298] common_setup_cleanup_unsolicited_events(): Supported notifications: signal (yes), registration (yes), sms (yes), connect (yes), subscriber (yes), packet (yes)
>
> <debug> [1485259216.938243] [mm-broadband-modem-mbim.c:2437] 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: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: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 = 18
>
> <<<<<< 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: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: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 = 18
>
> >>>>>> 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> [1485259216.941083] [mm-broadband-modem.c:9549] enabling_step(): Modem has voice capabilities, enabling the Voice interface...
>
> <debug> [1485259216.941641] [mm-broadband-modem.c:6579] set_voice_unsolicited_events_handlers(): (ttyUSB1) Setting voice unsolicited events handlers
>
> <debug> [1485259216.941990] [mm-port-serial.c:1288] mm_port_serial_open(): (ttyUSB1) device open count is 2 (open)
>
> <debug> [1485259216.942320] [mm-port-serial-at.c:459] debug_log(): (ttyUSB1): --> 'AT+CLIP=1<CR>'
>
> <debug> [1485259216.954710] [mm-port-serial-at.c:459] debug_log(): (ttyUSB1): <-- '<CR><LF>OK<CR><LF>'
>
> <debug> [1485259216.955271] [mm-port-serial-at.c:459] debug_log(): (ttyUSB1): --> 'AT+CRC=1<CR>'
>
> <debug> [1485259216.968964] [mm-port-serial-at.c:459] debug_log(): (ttyUSB1): <-- '<CR><LF>OK<CR><LF>'
>
> <debug> [1485259216.969385] [mm-port-serial.c:1345] _close_internal(): (ttyUSB1) device open count is 1 (close)
>
> <debug> [1485259216.969602] [mm-broadband-modem.c:9562] enabling_step(): Modem has time capabilities, enabling the Time interface...
>
> <info> [1485259216.969990] [mm-iface-modem.c:1431] __iface_modem_update_state_internal(): Modem /org/freedesktop/ModemManager1/Modem/0: state changed (enabling -> registered)
>
> <debug> [1485259216.976257] [mm-iface-modem.c:1075] periodic_access_technologies_check_enable(): Periodic access technology checks enabled
>
> <debug> [1485259216.976419] [mm-broadband-modem.c:2475] modem_load_access_technologies(): loading access technologies via QCDM...
>
> <info> [1485259216.976702] [mm-iface-modem-simple.c:469] connection_step(): Simple connect state (4/8): Wait to get fully enabled
>
> <info> [1485259216.976936] [mm-iface-modem-simple.c:478] connection_step(): Simple connect state (5/8): Register
>
> <debug> [1485259216.977120] [mm-iface-modem-3gpp.c:437] mm_iface_modem_3gpp_register_in_network(): Already registered in network '310120', automatic registration not launched...
>
> <info> [1485259216.977472] [mm-iface-modem-simple.c:501] connection_step(): Simple connect state (6/8): Bearer
>
> <debug> [1485259216.977593] [mm-iface-modem-simple.c:521] connection_step(): Creating new bearer...
>
> <debug> [1485259216.977738] [mm-broadband-modem-mbim.c:1481] modem_create_bearer(): Creating MBIM bearer in MBIM modem
>
> <debug> [1485259216.980008] [mm-broadband-modem-mbim.c:1395] modem_create_bearer_finish(): New bearer created at DBus path '/org/freedesktop/ModemManager1/Bearer/0'
>
> <info> [1485259216.983502] [mm-iface-modem-simple.c:583] connection_step(): Simple connect state (7/8): Connect
>
> <debug> [1485259216.983675] [mm-base-bearer.c:801] mm_base_bearer_connect(): Connecting bearer '/org/freedesktop/ModemManager1/Bearer/0'
>
> <info> [1485259216.983856] [mm-iface-modem.c:1431] __iface_modem_update_state_internal(): Modem /org/freedesktop/ModemManager1/Modem/0: state changed (registered -> connecting)
>
> <debug> [1485259216.990139] [mm-bearer-mbim.c:1026] _connect(): Launching connection with data port (net/wwan0)
>
> <debug> [1485259216.990298] [mm-bearer-mbim.c:785] connect_context_step(): Activating packet service...
>
> [/dev/cdc-wdm0] Sent message...
>
> <<<<<< RAW:
>
> <<<<<< length = 52
>
> <<<<<< data = 03:00:00:00:34: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:0A:00:00:00:01:00:00:00:04:00:00:00:00:00:00:00
>
> [/dev/cdc-wdm0] Sent message (translated)...
>
> <<<<<< Header:
>
> <<<<<< length = 52
>
> <<<<<< type = command (0x00000003)
>
> <<<<<< transaction = 19
>
> <<<<<< Fragment header:
>
> <<<<<< total = 1
>
> <<<<<< current = 0
>
> <<<<<< Contents:
>
> <<<<<< service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>
> <<<<<< cid = 'packet-service' (0x0000000a)
>
> <<<<<< type = 'set' (0x00000001)
>
> <debug> [1485259216.991420] [mm-iface-modem-3gpp.c:798] 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: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: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 = 20
>
> <<<<<< Fragment header:
>
> <<<<<< total = 1
>
> <<<<<< current = 0
>
> <<<<<< Contents:
>
> <<<<<< service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>
> <<<<<< cid = 'register-state' (0x00000009)
>
> <<<<<< type = 'query' (0x00000000)
>
> <debug> [1485259216.992623] [mm-port-serial-qcdm.c:221] debug_log(): (ttyUSB0): --> 4b 08 01 00 66 (tel:08%2001%2000%2066) f5 7e
>
> <debug> [1485259216.997167] [mm-port-serial-qcdm.c:221] debug_log(): (ttyUSB0): <-- 4b 08 01 00 08 (tel:08%2001%2000%2008) 3a 95 70 02 06 92 62 95 (tel:95%2070%2002%2006%2092%2062%2095) 00 00 00 00 00 00 00 (tel:00%2000%2000%2000%2000%2000%2000) 00 00 6e 20 31 37 20 32 30 05 (tel:20%2031%2037%2020%2032%2030%2005) 05 09 8e 52 7e
>
> <debug> [1485259216.997684] [mm-port-serial-qcdm.c:221] debug_log(): (ttyUSB0): --> 4b 04 0f 00 d5 ca 7e
>
> <debug> [1485259217.000999] [mm-port-serial-qcdm.c:221] debug_log(): (ttyUSB0): <-- 4b 04 0f 00 08 3a 95 70 02 06 92 62 95 (tel:95%2070%2002%2006%2092%2062%2095) 08 39 01 21 10 12 86 (tel:08%2039%2001%2021%2010%2012%2086) 63 67 0a ff 15 7e
>
> <debug> [1485259217.001215] [mm-broadband-modem.c:2174] access_tech_context_complete_and_free(): QCDM operating mode: 5
>
> <debug> [1485259217.001296] [mm-broadband-modem.c:2175] access_tech_context_complete_and_free(): QCDM system mode: 9
>
> <debug> [1485259217.001364] [mm-broadband-modem.c:2176] access_tech_context_complete_and_free(): QCDM hybrid pref: 0
>
> <debug> [1485259217.001430] [mm-broadband-modem.c:2177] access_tech_context_complete_and_free(): QCDM WCDMA open: 0
>
> <debug> [1485259217.001496] [mm-broadband-modem.c:2178] access_tech_context_complete_and_free(): QCDM EVDO open: 0
>
> [/dev/cdc-wdm0] Received message...
>
> >>>>>> RAW:
>
> >>>>>> length = 76
>
> >>>>>> data = 03:00:00:80:4C: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:0A:00:00:00:00:00:00:00:1C:00:00:00:00:00:00:00:02:00:00:00:20:00:00:00:80:F0:FA:02:00:00:00:00:00:A3:E1:11:00:00:00:00
>
> [/dev/cdc-wdm0] Received message (translated)...
>
> >>>>>> Header:
>
> >>>>>> length = 76
>
> >>>>>> 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 = 'packet-service' (0x0000000a)
>
> <debug> [1485259217.002588] [mm-bearer-mbim.c:724] packet_service_set_ready(): Packet service update:
>
> <debug> [1485259217.002678] [mm-bearer-mbim.c:725] packet_service_set_ready(): state: 'attached'
>
> <debug> [1485259217.002741] [mm-bearer-mbim.c:726] packet_service_set_ready(): data class: 'lte'
>
> <debug> [1485259217.002803] [mm-bearer-mbim.c:727] packet_service_set_ready(): uplink: '50000000 (tel:50000000)' bps
>
> <debug> [1485259217.002866] [mm-bearer-mbim.c:728] packet_service_set_ready(): downlink: '300000000 (tel:300000000)' bps
>
> <debug> [1485259217.002931] [mm-bearer-mbim.c:806] connect_context_step(): Listing provisioned contexts...
>
> [/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:0D: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 = 'provisioned-contexts' (0x0000000d)
>
> <<<<<< type = 'query' (0x00000000)
>
> [/dev/cdc-wdm0] Received message...
>
> >>>>>> RAW:
>
> >>>>>> length = 120
>
> >>>>>> data = 03:00:00:80:78: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:09:00:00:00:00:00:00:00:48:00:00:00:00:00:00:00:03:00:00:00:01:00:00:00:20:00:00:00:01:00:00:00:30:00:00:00:0C:00:00:00:3C:00:00:00:0C:00:00:00:00:00:00:00:00:00:00:00:02:00:00:00:33:00:31:00:30:00:31:00:32:00:30:00:53:00:70:00:72:00:69:00:6E:00:74:00
>
> [/dev/cdc-wdm0] Received message (translated)...
>
> >>>>>> Header:
>
> >>>>>> length = 120
>
> >>>>>> 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 = 'register-state' (0x00000009)
>
> <debug> [1485259217.066201] [mm-broadband-modem.c:8859] modem_3gpp_run_registration_checks_ready(): Initial 3GPP registration checks finished
>
> [/dev/cdc-wdm0] Received message...
>
> >>>>>> RAW:
>
> >>>>>> length = 132
>
> >>>>>> data = 03:00:00:80:84: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:0D:00:00:00:00:00:00:00:54:00:00:00:01:00:00:00:0C:00:00:00:48:00:00:00:01:00:00:00:7E:5E:2A:7E:4E:6F:72:72:73:6B:65:6E:7E:5E:2A:7E:34:00:00:00:14: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:6E:00:2E:00:69:00:6A:00:2E:00:69:00:73:00:70:00:73:00:6E:00
>
> [/dev/cdc-wdm0] Received message (translated)...
>
> >>>>>> Header:
>
> >>>>>> length = 132
>
> >>>>>> 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 = 'provisioned-contexts' (0x0000000d)
>
> <debug> [1485259217.130137] [mm-bearer-mbim.c:659] provisioned_contexts_query_ready(): Provisioned contexts found (1):
>
> <debug> [1485259217.130330] [mm-bearer-mbim.c:665] provisioned_contexts_query_ready(): [1] context type: internet
>
> <debug> [1485259217.130399] [mm-bearer-mbim.c:666] provisioned_contexts_query_ready(): uuid: 7e5e2a7e-4e6f-7272-736b-656e7e5e2a7e
>
> <debug> [1485259217.130464] [mm-bearer-mbim.c:667] provisioned_contexts_query_ready(): access string: n.ij.ispsn
>
> <debug> [1485259217.130526] [mm-bearer-mbim.c:668] provisioned_contexts_query_ready(): username:
>
> <debug> [1485259217.130588] [mm-bearer-mbim.c:669] provisioned_contexts_query_ready(): password:
>
> <debug> [1485259217.130651] [mm-bearer-mbim.c:670] provisioned_contexts_query_ready(): compression: none
>
> <debug> [1485259217.130737] [mm-bearer-mbim.c:671] provisioned_contexts_query_ready(): auth: none
>
> <debug> [1485259217.130825] [mm-bearer-mbim.c:870] connect_context_step(): No specific IP family requested, defaulting to ipv4
>
> <debug> [1485259217.130891] [mm-bearer-mbim.c:901] connect_context_step(): Launching ipv4 connection with APN 'n.ij.ispsn'...
>
> [/dev/cdc-wdm0] Sent message...
>
> <<<<<< RAW:
>
> <<<<<< length = 128
>
> <<<<<< data = 03:00:00:00:80: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:0C:00:00:00:01:00:00:00:50:00:00:00:00:00:00:00:01:00:00:00:3C:00:00:00:14: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:01:00:00:00:7E:5E:2A:7E:4E:6F:72:72:73:6B:65:6E:7E:5E:2A:7E:6E:00:2E:00:69:00:6A:00:2E:00:69:00:73:00:70:00:73:00:6E:00
>
> [/dev/cdc-wdm0] Sent message (translated)...
>
> <<<<<< Header:
>
> <<<<<< length = 128
>
> <<<<<< type = command (0x00000003)
>
> <<<<<< transaction = 22
>
> <<<<<< Fragment header:
>
> <<<<<< total = 1
>
> <<<<<< current = 0
>
> <<<<<< Contents:
>
> <<<<<< service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>
> <<<<<< cid = 'connect' (0x0000000c)
>
> <<<<<< type = 'set' (0x00000001)
>
> [/dev/cdc-wdm0] Received message...
>
> >>>>>> RAW:
>
> >>>>>> length = 80
>
> >>>>>> data = 07:00:00:80:50: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:0C:00:00:00:24:00:00:00:00:00:00:00:02:00:00:00:00:00:00:00:01:00:00:00:7E:5E:2A:7E:4E:6F:72:72:73:6B:65:6E:7E:5E:2A:7E:00:00:00:00
>
> [/dev/cdc-wdm0] Received message (translated)...
>
> >>>>>> Header:
>
> >>>>>> length = 80
>
> >>>>>> type = indicate-status (0x80000007)
>
> >>>>>> transaction = 0
>
> >>>>>> Fragment header:
>
> >>>>>> total = 1
>
> >>>>>> current = 0
>
> >>>>>> Contents:
>
> >>>>>> service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>
> >>>>>> cid = 'connect' (0x0000000c)
>
> <debug> [1485259217.193984] [mm-broadband-modem-mbim.c:2252] device_notification_cb(): Received notification (service 'basic-connect', command 'connect')
>
> [/dev/cdc-wdm0] Received message...
>
> >>>>>> RAW:
>
> >>>>>> length = 84
>
> >>>>>> data = 03:00:00:80:54: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:0C:00:00:00:00:00:00:00:24:00:00:00:00:00:00:00:01:00:00:00:00:00:00:00:01:00:00:00:7E:5E:2A:7E:4E:6F:72:72:73:6B:65:6E:7E:5E:2A:7E:00:00:00:00
>
> [/dev/cdc-wdm0] Received message (translated)...
>
> >>>>>> Header:
>
> >>>>>> length = 84
>
> >>>>>> 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 = 'connect' (0x0000000c)
>
> <debug> [1485259217.258020] [mm-bearer-mbim.c:614] connect_set_ready(): Session ID '0': activated (IP type: ipv4)
>
> <debug> [1485259217.258125] [mm-bearer-mbim.c:932] connect_context_step(): Querying IP configuration...
>
> [/dev/cdc-wdm0] Sent message...
>
> <<<<<< RAW:
>
> <<<<<< length = 108
>
> <<<<<< data = 03:00:00:00:6C: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:0F:00:00:00:00:00:00:00:3C: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] Sent message (translated)...
>
> <<<<<< Header:
>
> <<<<<< length = 108
>
> <<<<<< type = command (0x00000003)
>
> <<<<<< transaction = 23
>
> <<<<<< Fragment header:
>
> <<<<<< total = 1
>
> <<<<<< current = 0
>
> <<<<<< Contents:
>
> <<<<<< service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>
> <<<<<< cid = 'ip-configuration' (0x0000000f)
>
> <<<<<< type = 'query' (0x00000000)
>
> [/dev/cdc-wdm0] Received message...
>
> >>>>>> RAW:
>
> >>>>>> length = 128
>
> >>>>>> data = 03:00:00:80:80: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:0F:00:00:00:00:00:00:00:50:00:00:00:00:00:00:00:0F:00:00:00:00:00:00:00:01:00:00:00:3C:00:00:00:00:00:00:00:00:00:00:00:44:00:00:00:00:00:00:00:02:00:00:00:48:00:00:00:00:00:00:00:00:00:00:00:DC:05:00:00:00:00:00:00:1D:00:00:00:19:20:10:64:19:20:10:65:44:1C:68:84:44:1C:69:84
>
> [/dev/cdc-wdm0] Received message (translated)...
>
> >>>>>> Header:
>
> >>>>>> length = 128
>
> >>>>>> 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 = 'ip-configuration' (0x0000000f)
>
> <debug> [1485259217.322211] [mm-bearer-mbim.c:319] ip_configuration_query_ready(): IPv4 configuration available: 'address, gateway, dns, mtu'
>
> <debug> [1485259217.322293] [mm-bearer-mbim.c:325] ip_configuration_query_ready(): IP addresses (1)
>
> <debug> [1485259217.322813] [mm-bearer-mbim.c:329] ip_configuration_query_ready(): IP [0]: '25.32.16.100/29 (http://25.32.16.100/29)'
>
> <debug> [1485259217.322992] [mm-bearer-mbim.c:338] ip_configuration_query_ready(): Gateway: '25.32.16.101'
>
> <debug> [1485259217.323082] [mm-bearer-mbim.c:346] ip_configuration_query_ready(): DNS addresses (2)
>
> <debug> [1485259217.323212] [mm-bearer-mbim.c:351] ip_configuration_query_ready(): DNS [0]: '68.28.104.132'
>
> <debug> [1485259217.323363] [mm-bearer-mbim.c:351] ip_configuration_query_ready(): DNS [1]: '68.28.105.132'
>
> <debug> [1485259217.323455] [mm-bearer-mbim.c:359] ip_configuration_query_ready(): MTU: '1500'
>
> <debug> [1485259217.323524] [mm-bearer-mbim.c:365] ip_configuration_query_ready(): IPv6 configuration available: 'none'
>
> <debug> [1485259217.323961] [mm-port.c:94] mm_port_set_connected(): (wwan0): port now connected
>
> <debug> [1485259217.324191] [mm-base-bearer.c:699] connect_ready(): Connected bearer '/org/freedesktop/ModemManager1/Bearer/0'
>
> [/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:14: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 = 'packet-statistics' (0x00000014)
>
> <<<<<< type = 'query' (0x00000000)
>
> <info> [1485259217.326225] [mm-iface-modem.c:1431] __iface_modem_update_state_internal(): Modem /org/freedesktop/ModemManager1/Modem/0: state changed (connecting -> connected)
>
> <info> [1485259217.332575] [mm-iface-modem-simple.c:602] connection_step(): Simple connect state (8/8): All done
>
> [/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:14:00:00:00:00:00:00:00:30: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 = 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 = 'packet-statistics' (0x00000014)
>
> <debug> [1485259221.951116] [mm-port-serial.c:1288] mm_port_serial_open(): (ttyUSB1) device open count is 2 (open)
>
> <debug> [1485259221.951447] [mm-port-serial-at.c:459] debug_log(): (ttyUSB1): --> 'AT+CCLK?<CR>'
>
> <debug> [1485259221.962840] [mm-port-serial-at.c:459] debug_log(): (ttyUSB1): <-- '<CR><LF>+CCLK: "17/01/24,12:04:37-20"<CR><LF><CR><LF>OK<CR><LF>'
>
> <debug> [1485259221.963742] [mm-port-serial.c:1345] _close_internal(): (ttyUSB1) device open count is 1 (close)
>
> <debug> [1485259246.967313] [mm-broadband-modem.c:2475] modem_load_access_technologies(): loading access technologies via QCDM...
>
> <debug> [1485259246.967666] [mm-port-serial-qcdm.c:221] debug_log(): (ttyUSB0): --> 4b 08 01 00 66 (tel:08%2001%2000%2066) f5 7e
>
> <debug> [1485259246.969023] [mm-port-serial-qcdm.c:221] debug_log(): (ttyUSB0): <-- 4b 08 01 00 08 (tel:08%2001%2000%2008) 3a 95 70 02 06 92 62 95 (tel:95%2070%2002%2006%2092%2062%2095) 00 00 00 00 00 00 00 (tel:00%2000%2000%2000%2000%2000%2000) 00 00 0a de ad 00 00 00 00 05 05 09 (tel:00%2000%2000%2000%2005%2005%2009) 71 5f 7e
>
> <debug> [1485259246.969479] [mm-port-serial-qcdm.c:221] debug_log(): (ttyUSB0): --> 4b 04 0f 00 d5 ca 7e
>
> <debug> [1485259246.970567] [mm-port-serial-qcdm.c:221] debug_log(): (ttyUSB0): <-- 4b 04 0f 00 08 3a 95 70 02 06 92 62 95 (tel:95%2070%2002%2006%2092%2062%2095) 08 39 01 21 10 12 86 (tel:08%2039%2001%2021%2010%2012%2086) 63 67 0a ff 15 7e
>
> <debug> [1485259246.970762] [mm-broadband-modem.c:2174] access_tech_context_complete_and_free(): QCDM operating mode: 5
>
> <debug> [1485259246.970840] [mm-broadband-modem.c:2175] access_tech_context_complete_and_free(): QCDM system mode: 9
>
> <debug> [1485259246.970904] [mm-broadband-modem.c:2176] access_tech_context_complete_and_free(): QCDM hybrid pref: 0
>
> <debug> [1485259246.970967] [mm-broadband-modem.c:2177] access_tech_context_complete_and_free(): QCDM WCDMA open: 0
>
> <debug> [1485259246.971030] [mm-broadband-modem.c:2178] access_tech_context_complete_and_free(): QCDM EVDO open: 0
>
> [/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:14: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 = 'packet-statistics' (0x00000014)
>
> <<<<<< 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:14:00:00:00:00:00:00:00:30: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 = 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 = 'packet-statistics' (0x00000014)
>
> <debug> [1485259276.955330] [mm-broadband-modem.c:2475] modem_load_access_technologies(): loading access technologies via QCDM...
>
> <debug> [1485259276.955682] [mm-port-serial-qcdm.c:221] debug_log(): (ttyUSB0): --> 4b 08 01 00 66 (tel:08%2001%2000%2066) f5 7e
>
> <debug> [1485259276.957032] [mm-port-serial-qcdm.c:221] debug_log(): (ttyUSB0): <-- 4b 08 01 00 08 (tel:08%2001%2000%2008) 3a 95 70 02 06 92 62 95 (tel:95%2070%2002%2006%2092%2062%2095) 00 00 00 00 00 00 00 (tel:00%2000%2000%2000%2000%2000%2000) 00 00 0a de ad 00 00 00 00 05 05 09 (tel:00%2000%2000%2000%2005%2005%2009) 71 5f 7e
>
> <debug> [1485259276.957578] [mm-port-serial-qcdm.c:221] debug_log(): (ttyUSB0): --> 4b 04 0f 00 d5 ca 7e
>
> <debug> [1485259276.958698] [mm-port-serial-qcdm.c:221] debug_log(): (ttyUSB0): <-- 4b 04 0f 00 08 3a 95 70 02 06 92 62 95 (tel:95%2070%2002%2006%2092%2062%2095) 08 39 01 21 10 12 86 (tel:08%2039%2001%2021%2010%2012%2086) 63 67 0a ff 15 7e
>
> <debug> [1485259276.958894] [mm-broadband-modem.c:2174] access_tech_context_complete_and_free(): QCDM operating mode: 5
>
> <debug> [1485259276.958972] [mm-broadband-modem.c:2175] access_tech_context_complete_and_free(): QCDM system mode: 9
>
> <debug> [1485259276.959037] [mm-broadband-modem.c:2176] access_tech_context_complete_and_free(): QCDM hybrid pref: 0
>
> <debug> [1485259276.959103] [mm-broadband-modem.c:2177] access_tech_context_complete_and_free(): QCDM WCDMA open: 0
>
> <debug> [1485259276.959166] [mm-broadband-modem.c:2178] access_tech_context_complete_and_free(): QCDM EVDO open: 0
>
> [/dev/cdc-wdm0] Sent message...
>
> <<<<<< RAW:
>
> <<<<<< length = 48
>
> <<<<<< data = 03:00:00:00:30:00:00:00:1A: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:14:00:00:00:00:00:00:00:00:00:00:00
>
> [/dev/cdc-wdm0] Sent message (translated)...
>
> <<<<<< Header:
>
> <<<<<< length = 48
>
> <<<<<< type = command (0x00000003)
>
> <<<<<< transaction = 26
>
> <<<<<< Fragment header:
>
> <<<<<< total = 1
>
> <<<<<< current = 0
>
> <<<<<< Contents:
>
> <<<<<< service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>
> <<<<<< cid = 'packet-statistics' (0x00000014)
>
> <<<<<< type = 'query' (0x00000000)
>
> [/dev/cdc-wdm0] Received message...
>
> >>>>>> RAW:
>
> >>>>>> length = 96
>
> >>>>>> data = 03:00:00:80:60:00:00:00:1A: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:14:00:00:00:00:00:00:00:30: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 = 96
>
> >>>>>> type = command-done (0x80000003)
>
> >>>>>> transaction = 26
>
> >>>>>> Fragment header:
>
> >>>>>> total = 1
>
> >>>>>> current = 0
>
> >>>>>> Contents:
>
> >>>>>> status error = 'None' (0x00000000)
>
> >>>>>> service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>
> >>>>>> cid = 'packet-statistics' (0x00000014)
>
> <debug> [1485259306.954886] [mm-broadband-modem.c:2475] modem_load_access_technologies(): loading access technologies via QCDM...
>
> <debug> [1485259306.955245] [mm-port-serial-qcdm.c:221] debug_log(): (ttyUSB0): --> 4b 08 01 00 66 (tel:08%2001%2000%2066) f5 7e
>
> <debug> [1485259306.958304] [mm-port-serial-qcdm.c:221] debug_log(): (ttyUSB0): <-- 4b 08 01 00 08 (tel:08%2001%2000%2008) 3a 95 70 02 06 92 62 95 (tel:95%2070%2002%2006%2092%2062%2095) 00 00 00 00 00 00 00 (tel:00%2000%2000%2000%2000%2000%2000) 00 00 0a de ad 00 00 00 00 05 05 09 (tel:00%2000%2000%2000%2005%2005%2009) 71 5f 7e
>
> <debug> [1485259306.958768] [mm-port-serial-qcdm.c:221] debug_log(): (ttyUSB0): --> 4b 04 0f 00 d5 ca 7e
>
> <debug> [1485259306.961572] [mm-port-serial-qcdm.c:221] debug_log(): (ttyUSB0): <-- 4b 04 0f 00 08 3a 95 70 02 06 92 62 95 (tel:95%2070%2002%2006%2092%2062%2095) 08 39 01 21 10 12 86 (tel:08%2039%2001%2021%2010%2012%2086) 63 67 0a ff 15 7e
>
> <debug> [1485259306.961764] [mm-broadband-modem.c:2174] access_tech_context_complete_and_free(): QCDM operating mode: 5
>
> <debug> [1485259306.961845] [mm-broadband-modem.c:2175] access_tech_context_complete_and_free(): QCDM system mode: 9
>
> <debug> [1485259306.961912] [mm-broadband-modem.c:2176] access_tech_context_complete_and_free(): QCDM hybrid pref: 0
>
> <debug> [1485259306.961979] [mm-broadband-modem.c:2177] access_tech_context_complete_and_free(): QCDM WCDMA open: 0
>
> <debug> [1485259306.962045] [mm-broadband-modem.c:2178] access_tech_context_complete_and_free(): QCDM EVDO open: 0
>
> [/dev/cdc-wdm0] Sent message...
>
> <<<<<< RAW:
>
> <<<<<< length = 48
>
> <<<<<< data = 03:00:00:00:30: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:14:00:00:00:00:00:00:00:00:00:00:00
>
> [/dev/cdc-wdm0] Sent message (translated)...
>
> <<<<<< Header:
>
> <<<<<< length = 48
>
> <<<<<< type = command (0x00000003)
>
> <<<<<< transaction = 27
>
> <<<<<< Fragment header:
>
> <<<<<< total = 1
>
> <<<<<< current = 0
>
> <<<<<< Contents:
>
> <<<<<< service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>
> <<<<<< cid = 'packet-statistics' (0x00000014)
>
> <<<<<< type = 'query' (0x00000000)
>
> [/dev/cdc-wdm0] Received message...
>
> >>>>>> RAW:
>
> >>>>>> length = 96
>
> >>>>>> data = 03:00:00:80:60: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:14:00:00:00:00:00:00:00:30: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 = 96
>
> >>>>>> 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 = 'packet-statistics' (0x00000014)
>
>
>
>
>
> On Tue, Jan 24, 2017 at 4:22 AM, Aleksander Morgado <aleksander at aleksander.es (mailto:aleksander at aleksander.es)> wrote:
>
> > On Mon, Jan 23, 2017 at 3:10 PM, Aleksander Morgado
> > <aleksander at aleksander.es (mailto:aleksander at aleksander.es)> wrote:
> > > It would also be a good idea to retrieve ModemManager debug logs; you
> > > can modify the MM daemon init file and add --debug
> > > --log-file=/var/log/mm.log to get them.
> >
> > I realize this may not be very clear. In the case of the procd init
> > file, adding the options is done with "procd_append_param" as follows:
> >
> > # vim /etc/init.d/modemmanager
> > ...
> > procd_set_param command /usr/sbin/ModemManager
> > procd_append_param command --log-file=/var/log/mm.log
> > procd_append_param command --debug
> > ....
> >
> > --
> > Aleksander
> > https://aleksander.es
>
>
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <https://lists.freedesktop.org/archives/modemmanager-devel/attachments/20170124/abe48da2/attachment-0001.html>
More information about the ModemManager-devel
mailing list