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