[02 Jul 2015, 19:02:36] [Debug] opening device... [02 Jul 2015, 19:02:36] [Debug] [/dev/cdc-wdm0] Queried max control message size: 4096 [02 Jul 2015, 19:02:36] [Debug] [/dev/cdc-wdm0] Sent message... <<<<<< RAW: <<<<<< length = 16 <<<<<< data = 01:00:00:00:10:00:00:00:01:00:00:00:00:10:00:00 [02 Jul 2015, 19:02:36] [Debug] [/dev/cdc-wdm0] Sent message (translated)... <<<<<< Header: <<<<<< length = 16 <<<<<< type = open (0x00000001) <<<<<< transaction = 1 <<<<<< Contents: <<<<<< max_control_transfer = 4096 [02 Jul 2015, 19:02:37] [Debug] [/dev/cdc-wdm0] Sent message... <<<<<< RAW: <<<<<< length = 16 <<<<<< data = 01:00:00:00:10:00:00:00:02:00:00:00:00:10:00:00 [02 Jul 2015, 19:02:37] [Debug] [/dev/cdc-wdm0] Sent message (translated)... <<<<<< Header: <<<<<< length = 16 <<<<<< type = open (0x00000001) <<<<<< transaction = 2 <<<<<< Contents: <<<<<< max_control_transfer = 4096 [02 Jul 2015, 19:02:38] [Debug] [/dev/cdc-wdm0] Sent message... <<<<<< RAW: <<<<<< length = 16 <<<<<< data = 01:00:00:00:10:00:00:00:03:00:00:00:00:10:00:00 [02 Jul 2015, 19:02:38] [Debug] [/dev/cdc-wdm0] Sent message (translated)... <<<<<< Header: <<<<<< length = 16 <<<<<< type = open (0x00000001) <<<<<< transaction = 3 <<<<<< Contents: <<<<<< max_control_transfer = 4096 [02 Jul 2015, 19:02:39] [Debug] [/dev/cdc-wdm0] Sent message... <<<<<< RAW: <<<<<< length = 16 <<<<<< data = 01:00:00:00:10:00:00:00:04:00:00:00:00:10:00:00 [02 Jul 2015, 19:02:39] [Debug] [/dev/cdc-wdm0] Sent message (translated)... <<<<<< Header: <<<<<< length = 16 <<<<<< type = open (0x00000001) <<<<<< transaction = 4 <<<<<< Contents: <<<<<< max_control_transfer = 4096 [02 Jul 2015, 19:02:40] [Debug] [/dev/cdc-wdm0] Sent message... <<<<<< RAW: <<<<<< length = 16 <<<<<< data = 01:00:00:00:10:00:00:00:05:00:00:00:00:10:00:00 [02 Jul 2015, 19:02:40] [Debug] [/dev/cdc-wdm0] Sent message (translated)... <<<<<< Header: <<<<<< length = 16 <<<<<< type = open (0x00000001) <<<<<< transaction = 5 <<<<<< Contents: <<<<<< max_control_transfer = 4096 [02 Jul 2015, 19:02:41] [Debug] [/dev/cdc-wdm0] Sent message... <<<<<< RAW: <<<<<< length = 16 <<<<<< data = 01:00:00:00:10:00:00:00:06:00:00:00:00:10:00:00 [02 Jul 2015, 19:02:41] [Debug] [/dev/cdc-wdm0] Sent message (translated)... <<<<<< Header: <<<<<< length = 16 <<<<<< type = open (0x00000001) <<<<<< transaction = 6 <<<<<< Contents: <<<<<< max_control_transfer = 4096 [02 Jul 2015, 19:02:42] [Debug] [/dev/cdc-wdm0] Sent message... <<<<<< RAW: <<<<<< length = 16 <<<<<< data = 01:00:00:00:10:00:00:00:07:00:00:00:00:10:00:00 [02 Jul 2015, 19:02:42] [Debug] [/dev/cdc-wdm0] Sent message (translated)... <<<<<< Header: <<<<<< length = 16 <<<<<< type = open (0x00000001) <<<<<< transaction = 7 <<<<<< Contents: <<<<<< max_control_transfer = 4096 [02 Jul 2015, 19:02:43] [Debug] [/dev/cdc-wdm0] Sent message... <<<<<< RAW: <<<<<< length = 16 <<<<<< data = 01:00:00:00:10:00:00:00:08:00:00:00:00:10:00:00 [02 Jul 2015, 19:02:43] [Debug] [/dev/cdc-wdm0] Sent message (translated)... <<<<<< Header: <<<<<< length = 16 <<<<<< type = open (0x00000001) <<<<<< transaction = 8 <<<<<< Contents: <<<<<< max_control_transfer = 4096 [02 Jul 2015, 19:02:44] [Debug] [/dev/cdc-wdm0] Sent message... <<<<<< RAW: <<<<<< length = 16 <<<<<< data = 01:00:00:00:10:00:00:00:09:00:00:00:00:10:00:00 [02 Jul 2015, 19:02:44] [Debug] [/dev/cdc-wdm0] Sent message (translated)... <<<<<< Header: <<<<<< length = 16 <<<<<< type = open (0x00000001) <<<<<< transaction = 9 <<<<<< Contents: <<<<<< max_control_transfer = 4096 [02 Jul 2015, 19:02:45] [Debug] [/dev/cdc-wdm0] Sent message... <<<<<< RAW: <<<<<< length = 16 <<<<<< data = 01:00:00:00:10:00:00:00:0A:00:00:00:00:10:00:00 [02 Jul 2015, 19:02:45] [Debug] [/dev/cdc-wdm0] Sent message (translated)... <<<<<< Header: <<<<<< length = 16 <<<<<< type = open (0x00000001) <<<<<< transaction = 10 <<<<<< Contents: <<<<<< max_control_transfer = 4096 [02 Jul 2015, 19:02:46] [Debug] [/dev/cdc-wdm0] Sent message... <<<<<< RAW: <<<<<< length = 16 <<<<<< data = 01:00:00:00:10:00:00:00:0B:00:00:00:00:10:00:00 [02 Jul 2015, 19:02:46] [Debug] [/dev/cdc-wdm0] Sent message (translated)... <<<<<< Header: <<<<<< length = 16 <<<<<< type = open (0x00000001) <<<<<< transaction = 11 <<<<<< Contents: <<<<<< max_control_transfer = 4096 [02 Jul 2015, 19:02:47] [Debug] [/dev/cdc-wdm0] Sent message... <<<<<< RAW: <<<<<< length = 16 <<<<<< data = 01:00:00:00:10:00:00:00:0C:00:00:00:00:10:00:00 [02 Jul 2015, 19:02:47] [Debug] [/dev/cdc-wdm0] Sent message (translated)... <<<<<< Header: <<<<<< length = 16 <<<<<< type = open (0x00000001) <<<<<< transaction = 12 <<<<<< Contents: <<<<<< max_control_transfer = 4096 [02 Jul 2015, 19:02:48] [Debug] [/dev/cdc-wdm0] Sent message... <<<<<< RAW: <<<<<< length = 16 <<<<<< data = 01:00:00:00:10:00:00:00:0D:00:00:00:00:10:00:00 [02 Jul 2015, 19:02:48] [Debug] [/dev/cdc-wdm0] Sent message (translated)... <<<<<< Header: <<<<<< length = 16 <<<<<< type = open (0x00000001) <<<<<< transaction = 13 <<<<<< Contents: <<<<<< max_control_transfer = 4096 [02 Jul 2015, 19:02:49] [Debug] [/dev/cdc-wdm0] Sent message... <<<<<< RAW: <<<<<< length = 16 <<<<<< data = 01:00:00:00:10:00:00:00:0E:00:00:00:00:10:00:00 [02 Jul 2015, 19:02:49] [Debug] [/dev/cdc-wdm0] Sent message (translated)... <<<<<< Header: <<<<<< length = 16 <<<<<< type = open (0x00000001) <<<<<< transaction = 14 <<<<<< Contents: <<<<<< max_control_transfer = 4096 [02 Jul 2015, 19:02:50] [Debug] [/dev/cdc-wdm0] Sent message... <<<<<< RAW: <<<<<< length = 16 <<<<<< data = 01:00:00:00:10:00:00:00:0F:00:00:00:00:10:00:00 [02 Jul 2015, 19:02:50] [Debug] [/dev/cdc-wdm0] Sent message (translated)... <<<<<< Header: <<<<<< length = 16 <<<<<< type = open (0x00000001) <<<<<< transaction = 15 <<<<<< Contents: <<<<<< max_control_transfer = 4096 [02 Jul 2015, 19:02:51] [Debug] [/dev/cdc-wdm0] Sent message... <<<<<< RAW: <<<<<< length = 16 <<<<<< data = 01:00:00:00:10:00:00:00:10:00:00:00:00:10:00:00 [02 Jul 2015, 19:02:51] [Debug] [/dev/cdc-wdm0] Sent message (translated)... <<<<<< Header: <<<<<< length = 16 <<<<<< type = open (0x00000001) <<<<<< transaction = 16 <<<<<< Contents: <<<<<< max_control_transfer = 4096 [02 Jul 2015, 19:02:52] [Debug] [/dev/cdc-wdm0] Sent message... <<<<<< RAW: <<<<<< length = 16 <<<<<< data = 01:00:00:00:10:00:00:00:11:00:00:00:00:10:00:00 [02 Jul 2015, 19:02:52] [Debug] [/dev/cdc-wdm0] Sent message (translated)... <<<<<< Header: <<<<<< length = 16 <<<<<< type = open (0x00000001) <<<<<< transaction = 17 <<<<<< Contents: <<<<<< max_control_transfer = 4096 [02 Jul 2015, 19:02:53] [Debug] [/dev/cdc-wdm0] Sent message... <<<<<< RAW: <<<<<< length = 16 <<<<<< data = 01:00:00:00:10:00:00:00:12:00:00:00:00:10:00:00 [02 Jul 2015, 19:02:53] [Debug] [/dev/cdc-wdm0] Sent message (translated)... <<<<<< Header: <<<<<< length = 16 <<<<<< type = open (0x00000001) <<<<<< transaction = 18 <<<<<< Contents: <<<<<< max_control_transfer = 4096 [02 Jul 2015, 19:02:54] [Debug] [/dev/cdc-wdm0] Sent message... <<<<<< RAW: <<<<<< length = 16 <<<<<< data = 01:00:00:00:10:00:00:00:13:00:00:00:00:10:00:00 [02 Jul 2015, 19:02:54] [Debug] [/dev/cdc-wdm0] Sent message (translated)... <<<<<< Header: <<<<<< length = 16 <<<<<< type = open (0x00000001) <<<<<< transaction = 19 <<<<<< Contents: <<<<<< max_control_transfer = 4096 [02 Jul 2015, 19:02:55] [Debug] [/dev/cdc-wdm0] Sent message... <<<<<< RAW: <<<<<< length = 16 <<<<<< data = 01:00:00:00:10:00:00:00:14:00:00:00:00:10:00:00 [02 Jul 2015, 19:02:55] [Debug] [/dev/cdc-wdm0] Sent message (translated)... <<<<<< Header: <<<<<< length = 16 <<<<<< type = open (0x00000001) <<<<<< transaction = 20 <<<<<< Contents: <<<<<< max_control_transfer = 4096 [02 Jul 2015, 19:02:56] [Debug] [/dev/cdc-wdm0] Sent message... <<<<<< RAW: <<<<<< length = 16 <<<<<< data = 01:00:00:00:10:00:00:00:15:00:00:00:00:10:00:00 [02 Jul 2015, 19:02:56] [Debug] [/dev/cdc-wdm0] Sent message (translated)... <<<<<< Header: <<<<<< length = 16 <<<<<< type = open (0x00000001) <<<<<< transaction = 21 <<<<<< Contents: <<<<<< max_control_transfer = 4096 [02 Jul 2015, 19:02:57] [Debug] [/dev/cdc-wdm0] Sent message... <<<<<< RAW: <<<<<< length = 16 <<<<<< data = 01:00:00:00:10:00:00:00:16:00:00:00:00:10:00:00 [02 Jul 2015, 19:02:57] [Debug] [/dev/cdc-wdm0] Sent message (translated)... <<<<<< Header: <<<<<< length = 16 <<<<<< type = open (0x00000001) <<<<<< transaction = 22 <<<<<< Contents: <<<<<< max_control_transfer = 4096 [02 Jul 2015, 19:02:58] [Debug] [/dev/cdc-wdm0] Sent message... <<<<<< RAW: <<<<<< length = 16 <<<<<< data = 01:00:00:00:10:00:00:00:17:00:00:00:00:10:00:00 [02 Jul 2015, 19:02:58] [Debug] [/dev/cdc-wdm0] Sent message (translated)... <<<<<< Header: <<<<<< length = 16 <<<<<< type = open (0x00000001) <<<<<< transaction = 23 <<<<<< Contents: <<<<<< max_control_transfer = 4096 [02 Jul 2015, 19:02:59] [Debug] [/dev/cdc-wdm0] Sent message... <<<<<< RAW: <<<<<< length = 16 <<<<<< data = 01:00:00:00:10:00:00:00:18:00:00:00:00:10:00:00 [02 Jul 2015, 19:02:59] [Debug] [/dev/cdc-wdm0] Sent message (translated)... <<<<<< Header: <<<<<< length = 16 <<<<<< type = open (0x00000001) <<<<<< transaction = 24 <<<<<< Contents: <<<<<< max_control_transfer = 4096 [02 Jul 2015, 19:03:00] [Debug] [/dev/cdc-wdm0] Sent message... <<<<<< RAW: <<<<<< length = 16 <<<<<< data = 01:00:00:00:10:00:00:00:19:00:00:00:00:10:00:00 [02 Jul 2015, 19:03:00] [Debug] [/dev/cdc-wdm0] Sent message (translated)... <<<<<< Header: <<<<<< length = 16 <<<<<< type = open (0x00000001) <<<<<< transaction = 25 <<<<<< Contents: <<<<<< max_control_transfer = 4096 [02 Jul 2015, 19:03:01] [Debug] [/dev/cdc-wdm0] Sent message... <<<<<< RAW: <<<<<< length = 16 <<<<<< data = 01:00:00:00:10:00:00:00:1A:00:00:00:00:10:00:00 [02 Jul 2015, 19:03:01] [Debug] [/dev/cdc-wdm0] Sent message (translated)... <<<<<< Header: <<<<<< length = 16 <<<<<< type = open (0x00000001) <<<<<< transaction = 26 <<<<<< Contents: <<<<<< max_control_transfer = 4096 [02 Jul 2015, 19:03:02] [Debug] [/dev/cdc-wdm0] Sent message... <<<<<< RAW: <<<<<< length = 16 <<<<<< data = 01:00:00:00:10:00:00:00:1B:00:00:00:00:10:00:00 [02 Jul 2015, 19:03:02] [Debug] [/dev/cdc-wdm0] Sent message (translated)... <<<<<< Header: <<<<<< length = 16 <<<<<< type = open (0x00000001) <<<<<< transaction = 27 <<<<<< Contents: <<<<<< max_control_transfer = 4096 [02 Jul 2015, 19:03:03] [Debug] [/dev/cdc-wdm0] Sent message... <<<<<< RAW: <<<<<< length = 16 <<<<<< data = 01:00:00:00:10:00:00:00:1C:00:00:00:00:10:00:00 [02 Jul 2015, 19:03:03] [Debug] [/dev/cdc-wdm0] Sent message (translated)... <<<<<< Header: <<<<<< length = 16 <<<<<< type = open (0x00000001) <<<<<< transaction = 28 <<<<<< Contents: <<<<<< max_control_transfer = 4096 [02 Jul 2015, 19:03:04] [Debug] [/dev/cdc-wdm0] Sent message... <<<<<< RAW: <<<<<< length = 16 <<<<<< data = 01:00:00:00:10:00:00:00:1D:00:00:00:00:10:00:00 [02 Jul 2015, 19:03:04] [Debug] [/dev/cdc-wdm0] Sent message (translated)... <<<<<< Header: <<<<<< length = 16 <<<<<< type = open (0x00000001) <<<<<< transaction = 29 <<<<<< Contents: <<<<<< max_control_transfer = 4096 [02 Jul 2015, 19:03:05] [Debug] [/dev/cdc-wdm0] Sent message... <<<<<< RAW: <<<<<< length = 16 <<<<<< data = 01:00:00:00:10:00:00:00:1E:00:00:00:00:10:00:00 [02 Jul 2015, 19:03:05] [Debug] [/dev/cdc-wdm0] Sent message (translated)... <<<<<< Header: <<<<<< length = 16 <<<<<< type = open (0x00000001) <<<<<< transaction = 30 <<<<<< Contents: <<<<<< max_control_transfer = 4096 [02 Jul 2015, 19:03:06] [Debug] open operation timed out: closed error: couldn't open the MbimDevice: Transaction timed out