[08 Mar 2018, 13:16:09] [Debug] [qfu-udev] sysfs path for 'cdc-wdm1' found: /sys/devices/pci0000:00/0000:00:14.0/usb2/2-6
[08 Mar 2018, 13:16:09] [Debug] [qfu-udev] peer port for '/sys/devices/pci0000:00/0000:00:14.0/usb2/2-6' found: /sys/devices/pci0000:00/0000:00:14.0/usb1/1-0:1.0/usb1-port6
[08 Mar 2018, 13:16:09] [Debug] [qfu-utils] couldn't ping ModemManager: GDBus.Error:org.freedesktop.DBus.Error.NameHasNoOwner: Name "org.freedesktop.ModemManager1" does not exist
[08 Mar 2018, 13:16:09] [Debug] [qfu-image] loading file info...
[08 Mar 2018, 13:16:09] [Debug] [qfu-image] opening file for reading...
[08 Mar 2018, 13:16:09] [Debug] [qfu-image-cwe] reading image headers...
[08 Mar 2018, 13:16:09] [Debug] [qfu-image-cwe] image offset range: [0,83306532]
[08 Mar 2018, 13:16:09] [Debug] [qfu-image-cwe]   image offset range: [400,360304]
[08 Mar 2018, 13:16:09] [Debug] [qfu-image-cwe]     image offset range: [800,360304]
[08 Mar 2018, 13:16:09] [Debug] [qfu-image-cwe]   image at offset 800 is valid
[08 Mar 2018, 13:16:09] [Debug] [qfu-image-cwe] image at offset 400 is valid
[08 Mar 2018, 13:16:09] [Debug] [qfu-image-cwe]   image offset range: [360304,43216086]
[08 Mar 2018, 13:16:09] [Debug] [qfu-image-cwe]     image offset range: [360704,784652]
[08 Mar 2018, 13:16:09] [Debug] [qfu-image-cwe]   image at offset 360704 is valid
[08 Mar 2018, 13:16:09] [Debug] [qfu-image-cwe]     image offset range: [784652,952240]
[08 Mar 2018, 13:16:09] [Debug] [qfu-image-cwe]   image at offset 784652 is valid
[08 Mar 2018, 13:16:09] [Debug] [qfu-image-cwe]     image offset range: [952240,43216086]
[08 Mar 2018, 13:16:09] [Debug] [qfu-image-cwe]   image at offset 952240 is valid
[08 Mar 2018, 13:16:09] [Debug] [qfu-image-cwe] image at offset 360304 is valid
[08 Mar 2018, 13:16:09] [Debug] [qfu-image-cwe]   image offset range: [43216086,83306532]
[08 Mar 2018, 13:16:09] [Debug] [qfu-image-cwe]     image offset range: [43216486,43665530]
[08 Mar 2018, 13:16:09] [Debug] [qfu-image-cwe]   image at offset 43216486 is valid
[08 Mar 2018, 13:16:09] [Debug] [qfu-image-cwe]     image offset range: [43665530,75943802]
[08 Mar 2018, 13:16:09] [Debug] [qfu-image-cwe]   image at offset 43665530 is valid
[08 Mar 2018, 13:16:09] [Debug] [qfu-image-cwe]     image offset range: [75943802,83306532]
[08 Mar 2018, 13:16:09] [Debug] [qfu-image-cwe]   image at offset 75943802 is valid
[08 Mar 2018, 13:16:09] [Debug] [qfu-image-cwe] image at offset 43216086 is valid
[08 Mar 2018, 13:16:09] [Debug] [qfu-image-cwe] validating data size...
[08 Mar 2018, 13:16:09] [Debug] [qfu-image-cwe] preloading firmware/config/carrier...
[08 Mar 2018, 13:16:09] [Debug] [qfu-image-cwe]   firmware version: 01.02.01.00
[08 Mar 2018, 13:16:09] [Debug] [qfu-image-cwe]   config version:   unknown
[08 Mar 2018, 13:16:09] [Debug] [qfu-image-cwe]   carrier:          unknown
[08 Mar 2018, 13:16:09] [Debug] [qfu-image] loading file info...
[08 Mar 2018, 13:16:09] [Debug] [qfu-image] opening file for reading...
[08 Mar 2018, 13:16:09] [Debug] [qfu-image-cwe] reading image headers...
[08 Mar 2018, 13:16:09] [Debug] [qfu-image-cwe] image offset range: [0,3757]
[08 Mar 2018, 13:16:09] [Debug] [qfu-image-cwe]   image offset range: [400,3757]
[08 Mar 2018, 13:16:09] [Debug] [qfu-image-cwe]     image offset range: [800,3757]
[08 Mar 2018, 13:16:09] [Debug] [qfu-image-cwe]       image offset range: [1200,3757]
[08 Mar 2018, 13:16:09] [Debug] [qfu-image-cwe]     image at offset 1200 is valid
[08 Mar 2018, 13:16:09] [Debug] [qfu-image-cwe]   image at offset 800 is valid
[08 Mar 2018, 13:16:09] [Debug] [qfu-image-cwe] image at offset 400 is valid
[08 Mar 2018, 13:16:09] [Debug] [qfu-image-cwe] validating data size...
[08 Mar 2018, 13:16:09] [Debug] [qfu-image-cwe] preloading firmware/config/carrier...
[08 Mar 2018, 13:16:09] [Debug] [qfu-image-cwe]   firmware version: 01.02.01.00
[08 Mar 2018, 13:16:09] [Debug] [qfu-image-cwe]   config version:   001.015_000
[08 Mar 2018, 13:16:09] [Debug] [qfu-image-cwe]   carrier:          GENERIC
[08 Mar 2018, 13:16:09] [Debug] [qfu,device-selection] single cdc-wdm device requested in sysfs path '/sys/devices/pci0000:00/0000:00:14.0/usb2/2-6'
[08 Mar 2018, 13:16:09] [Debug] [qfu,device-selection]   device found: /dev/cdc-wdm1
[08 Mar 2018, 13:16:09] [Debug] [qfu,device-selection]   using preferred device: /dev/cdc-wdm1
loading device information before the update...
[08 Mar 2018, 13:16:09] [Debug] [qfu-updater] creating QMI DMS client...
[08 Mar 2018, 13:16:09] [Debug] [qfu,utils] creating QMI device...
[08 Mar 2018, 13:16:09] [Debug] [qfu,utils] QMI device created
[08 Mar 2018, 13:16:09] [Debug] [qfu,utils] opening QMI device (with proxy, qmi mode)...
[08 Mar 2018, 13:16:09] [Debug] [/dev/cdc-wdm1] Opening device with flags 'sync, proxy, auto'...
[08 Mar 2018, 13:16:09] [Debug] [/dev/cdc-wdm1] loaded driver of cdc-wdm port: qmi_wwan
[08 Mar 2018, 13:16:09] [Debug] [/dev/cdc-wdm1] automatically selecting QMI mode
[08 Mar 2018, 13:16:09] [Debug] cannot connect to proxy: Could not connect: Connection refused
[08 Mar 2018, 13:16:09] [Debug] spawning new qmi-proxy (try 1)...
[08 Mar 2018, 13:16:10] [Debug] [/dev/cdc-wdm1] sent message...
<<<<<< RAW:
<<<<<<   length = 28
<<<<<<   data   = 01:1B:00:00:00:00:00:01:00:FF:10:00:01:0D:00:2F:64:65:76:2F:63:64:63:2D:77:64:6D:31

[08 Mar 2018, 13:16:10] [Debug] [/dev/cdc-wdm1] sent generic request (translated)...
<<<<<< QMUX:
<<<<<<   length  = 27
<<<<<<   flags   = 0x00
<<<<<<   service = "ctl"
<<<<<<   client  = 0
<<<<<< QMI:
<<<<<<   flags       = "none"
<<<<<<   transaction = 1
<<<<<<   tlv_length  = 16
<<<<<<   message     = "Internal Proxy Open" (0xFF00)
<<<<<< TLV:
<<<<<<   type       = "Device Path" (0x01)
<<<<<<   length     = 13
<<<<<<   value      = 2F:64:65:76:2F:63:64:63:2D:77:64:6D:31
<<<<<<   translated = /dev/cdc-wdm1

[08 Mar 2018, 13:16:10] [Debug] [/dev/cdc-wdm1] received message...
<<<<<< RAW:
<<<<<<   length = 19
<<<<<<   data   = 01:12:00:80:00:00:01:01:00:FF:07:00:02:04:00:00:00:00:00

[08 Mar 2018, 13:16:10] [Debug] [/dev/cdc-wdm1] received generic response (translated)...
<<<<<< QMUX:
<<<<<<   length  = 18
<<<<<<   flags   = 0x80
<<<<<<   service = "ctl"
<<<<<<   client  = 0
<<<<<< QMI:
<<<<<<   flags       = "response"
<<<<<<   transaction = 1
<<<<<<   tlv_length  = 7
<<<<<<   message     = "Internal Proxy Open" (0xFF00)
<<<<<< TLV:
<<<<<<   type       = "Result" (0x02)
<<<<<<   length     = 4
<<<<<<   value      = 00:00:00:00
<<<<<<   translated = SUCCESS

[08 Mar 2018, 13:16:10] [Debug] [/dev/cdc-wdm1] Running sync...
[08 Mar 2018, 13:16:10] [Debug] [/dev/cdc-wdm1] sent message...
<<<<<< RAW:
<<<<<<   length = 12
<<<<<<   data   = 01:0B:00:00:00:00:00:02:27:00:00:00

[08 Mar 2018, 13:16:10] [Debug] [/dev/cdc-wdm1] sent generic request (translated)...
<<<<<< QMUX:
<<<<<<   length  = 11
<<<<<<   flags   = 0x00
<<<<<<   service = "ctl"
<<<<<<   client  = 0
<<<<<< QMI:
<<<<<<   flags       = "none"
<<<<<<   transaction = 2
<<<<<<   tlv_length  = 0
<<<<<<   message     = "Sync" (0x0027)

[08 Mar 2018, 13:16:10] [Debug] [/dev/cdc-wdm1] received message...
<<<<<< RAW:
<<<<<<   length = 19
<<<<<<   data   = 01:12:00:80:00:00:01:02:27:00:07:00:02:04:00:00:00:00:00

[08 Mar 2018, 13:16:10] [Debug] [/dev/cdc-wdm1] received generic response (translated)...
<<<<<< QMUX:
<<<<<<   length  = 18
<<<<<<   flags   = 0x80
<<<<<<   service = "ctl"
<<<<<<   client  = 0
<<<<<< QMI:
<<<<<<   flags       = "response"
<<<<<<   transaction = 2
<<<<<<   tlv_length  = 7
<<<<<<   message     = "Sync" (0x0027)
<<<<<< TLV:
<<<<<<   type       = "Result" (0x02)
<<<<<<   length     = 4
<<<<<<   value      = 00:00:00:00
<<<<<<   translated = SUCCESS

[08 Mar 2018, 13:16:10] [Debug] [/dev/cdc-wdm1] Sync operation finished
[08 Mar 2018, 13:16:10] [Debug] [qfu,utils] QMI device open
[08 Mar 2018, 13:16:10] [Debug] [qfu,utils] allocating new DMS QMI client...
[08 Mar 2018, 13:16:10] [Debug] [/dev/cdc-wdm1] Assuming service 'dms' is supported...
[08 Mar 2018, 13:16:10] [Debug] [/dev/cdc-wdm1] Allocating new client ID...
[08 Mar 2018, 13:16:10] [Debug] [/dev/cdc-wdm1] sent message...
<<<<<< RAW:
<<<<<<   length = 16
<<<<<<   data   = 01:0F:00:00:00:00:00:03:22:00:04:00:01:01:00:02

[08 Mar 2018, 13:16:10] [Debug] [/dev/cdc-wdm1] sent generic request (translated)...
<<<<<< QMUX:
<<<<<<   length  = 15
<<<<<<   flags   = 0x00
<<<<<<   service = "ctl"
<<<<<<   client  = 0
<<<<<< QMI:
<<<<<<   flags       = "none"
<<<<<<   transaction = 3
<<<<<<   tlv_length  = 4
<<<<<<   message     = "Allocate CID" (0x0022)
<<<<<< TLV:
<<<<<<   type       = "Service" (0x01)
<<<<<<   length     = 1
<<<<<<   value      = 02
<<<<<<   translated = dms

[08 Mar 2018, 13:16:10] [Debug] [/dev/cdc-wdm1] received message...
<<<<<< RAW:
<<<<<<   length = 24
<<<<<<   data   = 01:17:00:80:00:00:01:03:22:00:0C:00:02:04:00:00:00:00:00:01:02:00:02:01

[08 Mar 2018, 13:16:10] [Debug] [/dev/cdc-wdm1] received generic response (translated)...
<<<<<< QMUX:
<<<<<<   length  = 23
<<<<<<   flags   = 0x80
<<<<<<   service = "ctl"
<<<<<<   client  = 0
<<<<<< QMI:
<<<<<<   flags       = "response"
<<<<<<   transaction = 3
<<<<<<   tlv_length  = 12
<<<<<<   message     = "Allocate CID" (0x0022)
<<<<<< TLV:
<<<<<<   type       = "Result" (0x02)
<<<<<<   length     = 4
<<<<<<   value      = 00:00:00:00
<<<<<<   translated = SUCCESS
<<<<<< TLV:
<<<<<<   type       = "Allocation Info" (0x01)
<<<<<<   length     = 2
<<<<<<   value      = 02:01
<<<<<<   translated = [ service = 'dms' cid = '1' ]

[08 Mar 2018, 13:16:10] [Debug] [/dev/cdc-wdm1] Registered 'dms' (version unknown) client with ID '1'
[08 Mar 2018, 13:16:10] [Debug] [qfu,utils] DMS QMI client allocated
[08 Mar 2018, 13:16:10] [Debug] [/dev/cdc-wdm1] sent message...
<<<<<< RAW:
<<<<<<   length = 13
<<<<<<   data   = 01:0C:00:00:02:01:00:01:00:23:00:00:00

[08 Mar 2018, 13:16:10] [Debug] [/dev/cdc-wdm1] sent generic request (translated)...
<<<<<< QMUX:
<<<<<<   length  = 12
<<<<<<   flags   = 0x00
<<<<<<   service = "dms"
<<<<<<   client  = 1
<<<<<< QMI:
<<<<<<   flags       = "none"
<<<<<<   transaction = 1
<<<<<<   tlv_length  = 0
<<<<<<   message     = "Get Revision" (0x0023)

[08 Mar 2018, 13:16:10] [Debug] [/dev/cdc-wdm1] sent message...
<<<<<< RAW:
<<<<<<   length = 13
<<<<<<   data   = 01:0C:00:00:02:01:00:02:00:49:00:00:00

[08 Mar 2018, 13:16:10] [Debug] [/dev/cdc-wdm1] sent generic request (translated)...
<<<<<< QMUX:
<<<<<<   length  = 12
<<<<<<   flags   = 0x00
<<<<<<   service = "dms"
<<<<<<   client  = 1
<<<<<< QMI:
<<<<<<   flags       = "none"
<<<<<<   transaction = 2
<<<<<<   tlv_length  = 0
<<<<<<   message     = "List Stored Images" (0x0049)

[08 Mar 2018, 13:16:10] [Debug] [/dev/cdc-wdm1] sent message...
<<<<<< RAW:
<<<<<<   length = 13
<<<<<<   data   = 01:0C:00:00:02:01:00:03:00:47:00:00:00

[08 Mar 2018, 13:16:10] [Debug] [/dev/cdc-wdm1] sent generic request (translated)...
<<<<<< QMUX:
<<<<<<   length  = 12
<<<<<<   flags   = 0x00
<<<<<<   service = "dms"
<<<<<<   client  = 1
<<<<<< QMI:
<<<<<<   flags       = "none"
<<<<<<   transaction = 3
<<<<<<   tlv_length  = 0
<<<<<<   message     = "Get Firmware Preference" (0x0047)

[08 Mar 2018, 13:16:10] [Debug] [/dev/cdc-wdm1] sent message...
<<<<<< RAW:
<<<<<<   length = 13
<<<<<<   data   = 01:0C:00:00:02:01:00:04:00:56:55:00:00

[08 Mar 2018, 13:16:10] [Debug] [/dev/cdc-wdm1] sent vendor-specific (0x1199) request (translated)...
<<<<<< QMUX:
<<<<<<   length  = 12
<<<<<<   flags   = 0x00
<<<<<<   service = "dms"
<<<<<<   client  = 1
<<<<<< QMI:
<<<<<<   flags       = "none"
<<<<<<   transaction = 4
<<<<<<   tlv_length  = 0
<<<<<<   message     = "Swi Get Current Firmware" (0x5556)

[08 Mar 2018, 13:16:10] [Debug] [/dev/cdc-wdm1] received message...
<<<<<< RAW:
<<<<<<   length = 78
<<<<<<   data   = 01:4D:00:80:02:01:02:01:00:23:00:41:00:02:04:00:00:00:00:00:01:37:00:53:57:49:39:58:35:30:43:5F:30:31:2E:30:30:2E:30:32:2E:30:30:20:36:66:66:34:38:61:20:6A:65:6E:6B:69:6E:73:20:32:30:31:37:2F:30:39:2F:32:39:20:30:35:3A:35:34:3A:32:36

[08 Mar 2018, 13:16:10] [Debug] [/dev/cdc-wdm1] received generic response (translated)...
<<<<<< QMUX:
<<<<<<   length  = 77
<<<<<<   flags   = 0x80
<<<<<<   service = "dms"
<<<<<<   client  = 1
<<<<<< QMI:
<<<<<<   flags       = "response"
<<<<<<   transaction = 1
<<<<<<   tlv_length  = 65
<<<<<<   message     = "Get Revision" (0x0023)
<<<<<< TLV:
<<<<<<   type       = "Result" (0x02)
<<<<<<   length     = 4
<<<<<<   value      = 00:00:00:00
<<<<<<   translated = SUCCESS
<<<<<< TLV:
<<<<<<   type       = "Revision" (0x01)
<<<<<<   length     = 55
<<<<<<   value      = 53:57:49:39:58:35:30:43:5F:30:31:2E:30:30:2E:30:32:2E:30:30:20:36:66:66:34:38:61:20:6A:65:6E:6B:69:6E:73:20:32:30:31:37:2F:30:39:2F:32:39:20:30:35:3A:35:34:3A:32:36
<<<<<<   translated = SWI9X50C_01.00.02.00 6ff48a jenkins 2017/09/29 05:54:26

[08 Mar 2018, 13:16:10] [Debug] [qfu,utils] current revision loaded: SWI9X50C_01.00.02.00 6ff48a jenkins 2017/09/29 05:54:26
[08 Mar 2018, 13:16:10] [Debug] [/dev/cdc-wdm1] received message...
<<<<<< RAW:
<<<<<<   length = 102
<<<<<<   data   = 01:65:00:80:02:01:02:02:00:49:00:59:00:02:04:00:00:00:00:00:01:4F:00:02:00:04:01:01:01:00:3F:5F:3F:00:00:00:00:00:00:00:00:00:00:00:00:00:0D:30:31:2E:30:30:2E:30:32:2E:30:30:5F:3F:01:32:00:01:FF:FF:30:30:31:2E:30:31:32:5F:30:30:30:00:00:00:00:00:13:30:31:2E:30:30:2E:30:32:2E:30:30:5F:47:45:4E:45:52:49:43

[08 Mar 2018, 13:16:10] [Debug] [/dev/cdc-wdm1] received generic response (translated)...
<<<<<< QMUX:
<<<<<<   length  = 101
<<<<<<   flags   = 0x80
<<<<<<   service = "dms"
<<<<<<   client  = 1
<<<<<< QMI:
<<<<<<   flags       = "response"
<<<<<<   transaction = 2
<<<<<<   tlv_length  = 89
<<<<<<   message     = "List Stored Images" (0x0049)
<<<<<< TLV:
<<<<<<   type       = "Result" (0x02)
<<<<<<   length     = 4
<<<<<<   value      = 00:00:00:00
<<<<<<   translated = SUCCESS
<<<<<< TLV:
<<<<<<   type       = "List" (0x01)
<<<<<<   length     = 79
<<<<<<   value      = 02:00:04:01:01:01:00:3F:5F:3F:00:00:00:00:00:00:00:00:00:00:00:00:00:0D:30:31:2E:30:30:2E:30:32:2E:30:30:5F:3F:01:32:00:01:FF:FF:30:30:31:2E:30:31:32:5F:30:30:30:00:00:00:00:00:13:30:31:2E:30:30:2E:30:32:2E:30:30:5F:47:45:4E:45:52:49:43
<<<<<<   translated = { [0] = '[ type = 'modem' maximum_images = '4' index_of_running_image = '1' sublist = '{ [0] = '[ storage_index = '1' failure_count = '0' unique_id = '{ [0] = '63 ' [1] = '95 ' [2] = '63 ' [3] = '0 ' [4] = '0 ' [5] = '0 ' [6] = '0 ' [7] = '0 ' [8] = '0 ' [9] = '0 ' [10] = '0 ' [11] = '0 ' [12] = '0 ' [13] = '0 ' [14] = '0 ' [15] = '0 '}' build_id = '01.00.02.00_?' ] '}' ] ' [1] = '[ type = 'pri' maximum_images = '50' index_of_running_image = '0' sublist = '{ [0] = '[ storage_index = '255' failure_count = '255' unique_id = '{ [0] = '48 ' [1] = '48 ' [2] = '49 ' [3] = '46 ' [4] = '48 ' [5] = '49 ' [6] = '50 ' [7] = '95 ' [8] = '48 ' [9] = '48 ' [10] = '48 ' [11] = '0 ' [12] = '0 ' [13] = '0 ' [14] = '0 ' [15] = '0 '}' build_id = '01.00.02.00_GENERIC' ] '}' ] '}

[08 Mar 2018, 13:16:10] [Debug] [/dev/cdc-wdm1] received message...
<<<<<< RAW:
<<<<<<   length = 98
<<<<<<   data   = 01:61:00:80:02:01:02:03:00:47:00:55:00:02:04:00:00:00:00:00:01:4B:00:02:00:30:30:31:2E:30:31:32:5F:30:30:30:00:00:00:00:00:13:30:31:2E:30:30:2E:30:32:2E:30:30:5F:47:45:4E:45:52:49:43:01:30:30:31:2E:30:31:32:5F:30:30:30:00:00:00:00:00:13:30:31:2E:30:30:2E:30:32:2E:30:30:5F:47:45:4E:45:52:49:43

[08 Mar 2018, 13:16:10] [Debug] [/dev/cdc-wdm1] received generic response (translated)...
<<<<<< QMUX:
<<<<<<   length  = 97
<<<<<<   flags   = 0x80
<<<<<<   service = "dms"
<<<<<<   client  = 1
<<<<<< QMI:
<<<<<<   flags       = "response"
<<<<<<   transaction = 3
<<<<<<   tlv_length  = 85
<<<<<<   message     = "Get Firmware Preference" (0x0047)
<<<<<< TLV:
<<<<<<   type       = "Result" (0x02)
<<<<<<   length     = 4
<<<<<<   value      = 00:00:00:00
<<<<<<   translated = SUCCESS
<<<<<< TLV:
<<<<<<   type       = "List" (0x01)
<<<<<<   length     = 75
<<<<<<   value      = 02:00:30:30:31:2E:30:31:32:5F:30:30:30:00:00:00:00:00:13:30:31:2E:30:30:2E:30:32:2E:30:30:5F:47:45:4E:45:52:49:43:01:30:30:31:2E:30:31:32:5F:30:30:30:00:00:00:00:00:13:30:31:2E:30:30:2E:30:32:2E:30:30:5F:47:45:4E:45:52:49:43
<<<<<<   translated = { [0] = '[ type = 'modem' unique_id = '{ [0] = '48 ' [1] = '48 ' [2] = '49 ' [3] = '46 ' [4] = '48 ' [5] = '49 ' [6] = '50 ' [7] = '95 ' [8] = '48 ' [9] = '48 ' [10] = '48 ' [11] = '0 ' [12] = '0 ' [13] = '0 ' [14] = '0 ' [15] = '0 '}' build_id = '01.00.02.00_GENERIC' ] ' [1] = '[ type = 'pri' unique_id = '{ [0] = '48 ' [1] = '48 ' [2] = '49 ' [3] = '46 ' [4] = '48 ' [5] = '49 ' [6] = '50 ' [7] = '95 ' [8] = '48 ' [9] = '48 ' [10] = '48 ' [11] = '0 ' [12] = '0 ' [13] = '0 ' [14] = '0 ' [15] = '0 '}' build_id = '01.00.02.00_GENERIC' ] '}

[08 Mar 2018, 13:16:10] [Debug] [qfu,utils] current firmware preference loaded:
[08 Mar 2018, 13:16:10] [Debug] [qfu,utils] [image 0]
[08 Mar 2018, 13:16:10] [Debug] [qfu,utils] 	Image type: 'modem'
[08 Mar 2018, 13:16:10] [Debug] [qfu,utils] 	Unique ID:  '001.012_000'
[08 Mar 2018, 13:16:10] [Debug] [qfu,utils] 	Build ID:   '01.00.02.00_GENERIC'
[08 Mar 2018, 13:16:10] [Debug] [qfu,utils] [image 1]
[08 Mar 2018, 13:16:10] [Debug] [qfu,utils] 	Image type: 'pri'
[08 Mar 2018, 13:16:10] [Debug] [qfu,utils] 	Unique ID:  '001.012_000'
[08 Mar 2018, 13:16:10] [Debug] [qfu,utils] 	Build ID:   '01.00.02.00_GENERIC'
[08 Mar 2018, 13:16:10] [Debug] [/dev/cdc-wdm1] received message...
<<<<<< RAW:
<<<<<<   length = 99
<<<<<<   data   = 01:62:00:80:02:01:02:04:00:56:55:56:00:02:04:00:00:00:00:00:10:06:00:45:4D:37:35:36:35:11:14:00:53:57:49:39:58:35:30:43:5F:30:31:2E:30:30:2E:30:32:2E:30:30:12:14:00:53:57:49:39:58:35:30:43:5F:30:31:2E:30:30:2E:30:32:2E:30:30:13:07:00:31:31:30:33:35:32:30:15:01:00:31:16:07:00:30:30:31:2E:30:30:31

[08 Mar 2018, 13:16:10] [Debug] [/dev/cdc-wdm1] received vendor-specific (0x1199) response (translated)...
<<<<<< QMUX:
<<<<<<   length  = 98
<<<<<<   flags   = 0x80
<<<<<<   service = "dms"
<<<<<<   client  = 1
<<<<<< QMI:
<<<<<<   flags       = "response"
<<<<<<   transaction = 4
<<<<<<   tlv_length  = 86
<<<<<<   message     = "Swi Get Current Firmware" (0x5556)
<<<<<< TLV:
<<<<<<   type       = "Result" (0x02)
<<<<<<   length     = 4
<<<<<<   value      = 00:00:00:00
<<<<<<   translated = SUCCESS
<<<<<< TLV:
<<<<<<   type       = "Model" (0x10)
<<<<<<   length     = 6
<<<<<<   value      = 45:4D:37:35:36:35
<<<<<<   translated = EM7565
<<<<<< TLV:
<<<<<<   type       = "Boot version" (0x11)
<<<<<<   length     = 20
<<<<<<   value      = 53:57:49:39:58:35:30:43:5F:30:31:2E:30:30:2E:30:32:2E:30:30
<<<<<<   translated = SWI9X50C_01.00.02.00
<<<<<< TLV:
<<<<<<   type       = "AMSS version" (0x12)
<<<<<<   length     = 20
<<<<<<   value      = 53:57:49:39:58:35:30:43:5F:30:31:2E:30:30:2E:30:32:2E:30:30
<<<<<<   translated = SWI9X50C_01.00.02.00
<<<<<< TLV:
<<<<<<   type       = "SKU ID" (0x13)
<<<<<<   length     = 7
<<<<<<   value      = 31:31:30:33:35:32:30
<<<<<<   translated = 1103520
<<<<<< TLV:
<<<<<<   type       = "Carrier ID" (0x15)
<<<<<<   length     = 1
<<<<<<   value      = 31
<<<<<<   translated = 1
<<<<<< TLV:
<<<<<<   type       = "PRI version" (0x16)
<<<<<<   length     = 7
<<<<<<   value      = 30:30:31:2E:30:30:31
<<<<<<   translated = 001.001

setting firmware preference:
  firmware version: '01.02.01.00'
  config version:   '001.015_000'
  carrier:          'GENERIC'
[08 Mar 2018, 13:16:10] [Debug] [qfu-updater] setting firmware preference...
[08 Mar 2018, 13:16:10] [Debug] [qfu-updater]   modem image: unique id '?_?', build id '01.02.01.00_?'
[08 Mar 2018, 13:16:10] [Debug] [qfu-updater]   pri image:   unique id '001.015_000', build id '01.02.01.00_GENERIC'
[08 Mar 2018, 13:16:10] [Debug] [qfu-updater]   override download: no
[08 Mar 2018, 13:16:10] [Debug] [/dev/cdc-wdm1] sent message...
<<<<<< RAW:
<<<<<<   length = 89
<<<<<<   data   = 01:58:00:00:02:01:00:05:00:48:00:4C:00:11:01:00:02:01:45:00:02:00:3F:5F:3F:00:00:00:00:00:00:00:00:00:00:00:00:00:0D:30:31:2E:30:32:2E:30:31:2E:30:30:5F:3F:01:30:30:31:2E:30:31:35:5F:30:30:30:00:00:00:00:00:13:30:31:2E:30:32:2E:30:31:2E:30:30:5F:47:45:4E:45:52:49:43

[08 Mar 2018, 13:16:10] [Debug] [/dev/cdc-wdm1] sent generic request (translated)...
<<<<<< QMUX:
<<<<<<   length  = 88
<<<<<<   flags   = 0x00
<<<<<<   service = "dms"
<<<<<<   client  = 1
<<<<<< QMI:
<<<<<<   flags       = "none"
<<<<<<   transaction = 5
<<<<<<   tlv_length  = 76
<<<<<<   message     = "Set Firmware Preference" (0x0048)
<<<<<< TLV:
<<<<<<   type       = "Modem Storage Index" (0x11)
<<<<<<   length     = 1
<<<<<<   value      = 02
<<<<<<   translated = 2
<<<<<< TLV:
<<<<<<   type       = "List" (0x01)
<<<<<<   length     = 69
<<<<<<   value      = 02:00:3F:5F:3F:00:00:00:00:00:00:00:00:00:00:00:00:00:0D:30:31:2E:30:32:2E:30:31:2E:30:30:5F:3F:01:30:30:31:2E:30:31:35:5F:30:30:30:00:00:00:00:00:13:30:31:2E:30:32:2E:30:31:2E:30:30:5F:47:45:4E:45:52:49:43
<<<<<<   translated = { [0] = '[ type = 'modem' unique_id = '{ [0] = '63 ' [1] = '95 ' [2] = '63 ' [3] = '0 ' [4] = '0 ' [5] = '0 ' [6] = '0 ' [7] = '0 ' [8] = '0 ' [9] = '0 ' [10] = '0 ' [11] = '0 ' [12] = '0 ' [13] = '0 ' [14] = '0 ' [15] = '0 '}' build_id = '01.02.01.00_?' ] ' [1] = '[ type = 'pri' unique_id = '{ [0] = '48 ' [1] = '48 ' [2] = '49 ' [3] = '46 ' [4] = '48 ' [5] = '49 ' [6] = '53 ' [7] = '95 ' [8] = '48 ' [9] = '48 ' [10] = '48 ' [11] = '0 ' [12] = '0 ' [13] = '0 ' [14] = '0 ' [15] = '0 '}' build_id = '01.02.01.00_GENERIC' ] '}

[08 Mar 2018, 13:16:10] [Debug] [/dev/cdc-wdm1] received message...
<<<<<< RAW:
<<<<<<   length = 26
<<<<<<   data   = 01:19:00:80:02:01:02:05:00:48:00:0D:00:02:04:00:00:00:00:00:01:03:00:02:00:01

[08 Mar 2018, 13:16:10] [Debug] [/dev/cdc-wdm1] received generic response (translated)...
<<<<<< QMUX:
<<<<<<   length  = 25
<<<<<<   flags   = 0x80
<<<<<<   service = "dms"
<<<<<<   client  = 1
<<<<<< QMI:
<<<<<<   flags       = "response"
<<<<<<   transaction = 5
<<<<<<   tlv_length  = 13
<<<<<<   message     = "Set Firmware Preference" (0x0048)
<<<<<< TLV:
<<<<<<   type       = "Result" (0x02)
<<<<<<   length     = 4
<<<<<<   value      = 00:00:00:00
<<<<<<   translated = SUCCESS
<<<<<< TLV:
<<<<<<   type       = "Image Download List" (0x01)
<<<<<<   length     = 3
<<<<<<   value      = 02:00:01
<<<<<<   translated = { [0] = 'modem ' [1] = 'pri '}

[08 Mar 2018, 13:16:10] [Debug] [qfu-updater] need to download the following images: modem, pri
[08 Mar 2018, 13:16:10] [Debug] [qfu-updater] power cycling...
[08 Mar 2018, 13:16:10] [Debug] [/dev/cdc-wdm1] sent message...
<<<<<< RAW:
<<<<<<   length = 17
<<<<<<   data   = 01:10:00:00:02:01:00:06:00:2E:00:04:00:01:01:00:03

[08 Mar 2018, 13:16:10] [Debug] [/dev/cdc-wdm1] sent generic request (translated)...
<<<<<< QMUX:
<<<<<<   length  = 16
<<<<<<   flags   = 0x00
<<<<<<   service = "dms"
<<<<<<   client  = 1
<<<<<< QMI:
<<<<<<   flags       = "none"
<<<<<<   transaction = 6
<<<<<<   tlv_length  = 4
<<<<<<   message     = "Set Operating Mode" (0x002E)
<<<<<< TLV:
<<<<<<   type       = "Mode" (0x01)
<<<<<<   length     = 1
<<<<<<   value      = 03
<<<<<<   translated = offline

[08 Mar 2018, 13:16:10] [Debug] [/dev/cdc-wdm1] received message...
<<<<<< RAW:
<<<<<<   length = 20
<<<<<<   data   = 01:13:00:80:02:01:02:06:00:2E:00:07:00:02:04:00:00:00:00:00

[08 Mar 2018, 13:16:10] [Debug] [/dev/cdc-wdm1] received generic response (translated)...
<<<<<< QMUX:
<<<<<<   length  = 19
<<<<<<   flags   = 0x80
<<<<<<   service = "dms"
<<<<<<   client  = 1
<<<<<< QMI:
<<<<<<   flags       = "response"
<<<<<<   transaction = 6
<<<<<<   tlv_length  = 7
<<<<<<   message     = "Set Operating Mode" (0x002E)
<<<<<< TLV:
<<<<<<   type       = "Result" (0x02)
<<<<<<   length     = 4
<<<<<<   value      = 00:00:00:00
<<<<<<   translated = SUCCESS

[08 Mar 2018, 13:16:10] [Debug] [qfu,utils] operating mode set successfully...
[08 Mar 2018, 13:16:10] [Debug] [/dev/cdc-wdm1] sent message...
<<<<<< RAW:
<<<<<<   length = 17
<<<<<<   data   = 01:10:00:00:02:01:00:07:00:2E:00:04:00:01:01:00:04

[08 Mar 2018, 13:16:10] [Debug] [/dev/cdc-wdm1] sent generic request (translated)...
<<<<<< QMUX:
<<<<<<   length  = 16
<<<<<<   flags   = 0x00
<<<<<<   service = "dms"
<<<<<<   client  = 1
<<<<<< QMI:
<<<<<<   flags       = "none"
<<<<<<   transaction = 7
<<<<<<   tlv_length  = 4
<<<<<<   message     = "Set Operating Mode" (0x002E)
<<<<<< TLV:
<<<<<<   type       = "Mode" (0x01)
<<<<<<   length     = 1
<<<<<<   value      = 04
<<<<<<   translated = reset

[08 Mar 2018, 13:16:10] [Debug] [/dev/cdc-wdm1] received message...
<<<<<< RAW:
<<<<<<   length = 20
<<<<<<   data   = 01:13:00:80:02:01:02:07:00:2E:00:07:00:02:04:00:00:00:00:00

[08 Mar 2018, 13:16:10] [Debug] [/dev/cdc-wdm1] received generic response (translated)...
<<<<<< QMUX:
<<<<<<   length  = 19
<<<<<<   flags   = 0x80
<<<<<<   service = "dms"
<<<<<<   client  = 1
<<<<<< QMI:
<<<<<<   flags       = "response"
<<<<<<   transaction = 7
<<<<<<   tlv_length  = 7
<<<<<<   message     = "Set Operating Mode" (0x002E)
<<<<<< TLV:
<<<<<<   type       = "Result" (0x02)
<<<<<<   length     = 4
<<<<<<   value      = 00:00:00:00
<<<<<<   translated = SUCCESS

[08 Mar 2018, 13:16:10] [Debug] [qfu,utils] operating mode set successfully...
[08 Mar 2018, 13:16:10] [Debug] [qfu-updater] reset requested successfully...
[08 Mar 2018, 13:16:10] [Debug] [qfu-updater] cleaning up QMI device...
[08 Mar 2018, 13:16:10] [Debug] [/dev/cdc-wdm1] Releasing 'dms' client with flags 'none'...
[08 Mar 2018, 13:16:10] [Debug] [/dev/cdc-wdm1] Unregistered 'dms' client with ID '1'
rebooting in download mode...
[08 Mar 2018, 13:16:10] [Debug] [qfu-updater] reset requested, now waiting for TTY device...
[08 Mar 2018, 13:16:30] [Debug] [qfu-udev] event: remove ttyUSB3
[08 Mar 2018, 13:16:30] [Debug] [qfu-udev] event: remove ttyUSB4
[08 Mar 2018, 13:16:30] [Debug] [qfu-udev] event: remove ttyUSB5
[08 Mar 2018, 13:16:30] [Debug] [qfu-udev] event: unbind 2-6:1.0
[08 Mar 2018, 13:16:30] [Debug] [qfu-udev] event: unbind 2-6:1.2
[08 Mar 2018, 13:16:30] [Debug] [qfu-udev] event: remove 2-6:1.0
[08 Mar 2018, 13:16:30] [Debug] [qfu-udev] event: remove 2-6:1.2
[08 Mar 2018, 13:16:30] [Debug] [qfu-udev] event: unbind 2-6:1.3
[08 Mar 2018, 13:16:30] [Debug] [qfu-udev] event: remove 2-6:1.3
[08 Mar 2018, 13:16:30] [Debug] [qfu-udev] event: remove wwan1
[08 Mar 2018, 13:16:30] [Debug] [qfu-udev] event: remove cdc-wdm1
[08 Mar 2018, 13:16:30] [Debug] [qfu-udev] event: unbind 2-6:1.8
[08 Mar 2018, 13:16:30] [Debug] [qfu-udev] event: remove 2-6:1.8
[08 Mar 2018, 13:16:30] [Debug] [qfu-udev] event: unbind 2-6
[08 Mar 2018, 13:16:30] [Debug] [qfu-udev] event: remove 2-6
[08 Mar 2018, 13:16:33] [Debug] [qfu-udev] event: add 2-6
[08 Mar 2018, 13:16:33] [Debug] [qfu-udev] event: add 2-6:1.0
[08 Mar 2018, 13:16:33] [Debug] [qfu-udev] event: add ttyUSB3
[08 Mar 2018, 13:16:33] [Debug] [qfu-udev] waiting device (tty) matched: ttyUSB3
[08 Mar 2018, 13:16:33] [Debug] [qfu-updater] TTY device found: /dev/ttyUSB3
download mode detected
error: error creating device: HDLC trailing control character not found
[08 Mar 2018, 13:16:33] [Debug] [qfu-qdl-device] opening TTY: /dev/ttyUSB3
[08 Mar 2018, 13:16:33] [Debug] [qfu-qdl-device] setting terminal in raw mode...
[08 Mar 2018, 13:16:33] [Debug] [qfu,dload-message] sent sdp:
[08 Mar 2018, 13:16:33] [Debug] [qfu-qdl-device] >> 70:00:00 [3, unframed]
[08 Mar 2018, 13:16:33] [Debug] [qfu-qdl-device] >> 7E:70:00:00:14:46:7E [7]
[08 Mar 2018, 13:16:33] [Debug] [qfu-qdl-device] << 01:00:00:00:30:00:00:00:02:00:00:00:01:00:00:00:00:04:00:00:02:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00 [48]
