Project

General

Profile

Bug #3046

ofono: SierraW modem fails to power on

Added by pespin 9 months ago. Updated 9 months ago.

Status:
New
Priority:
Normal
Assignee:
Target version:
-
Start date:
03/09/2018
Due date:
% Done:

0%

Spec Reference:

Description

SierraW (/sierra2 in prod) modem started to fail all the time in tests when powering on:

I run the following and I took an ofono log trace at the same time:

root@osmo-gsm-tester-prod:~# mdbus2  -s org.ofono /sierra_2  org.ofono.Modem.SetProperty Powered true
[ERR]: GDBus.Error:org.ofono.Error.Failed: Operation failed

Mar 09 11:52:55 osmo-gsm-tester-prod ofonod[23376]: plugins/gobi.c:gobi_enable() 0x555f9e6459f0
Mar 09 11:52:55 osmo-gsm-tester-prod ofonod[23376]: src/modem.c:get_modem_property() modem 0x555f9e6459f0 property Device
Mar 09 11:52:55 osmo-gsm-tester-prod ofonod[23376]: drivers/qmimodem/qmibridge.c:ask_qmi() _REQ: QMI QMUX:
                                                    QMI   length  = 11
                                                    QMI   flags   = 0x00
                                                    QMI   service = "ctl" 
                                                    QMI   client  = 0
                                                    QMI QMI:
                                                    QMI   flags       = "none" 
                                                    QMI   transaction = 1
                                                    QMI   tlv_length  = 0
                                                    QMI   message     = "Get Version Info" (0x0021)
Mar 09 11:52:55 osmo-gsm-tester-prod ofonod[23376]: drivers/qmimodem/qmibridge.c:ask_qmi() READ: QMI QMUX:
                                                    QMI   length  = 191
                                                    QMI   flags   = 0x80
                                                    QMI   service = "ctl" 
                                                    QMI   client  = 0
                                                    QMI QMI:
                                                    QMI   flags       = "response" 
                                                    QMI   transaction = 1
                                                    QMI   tlv_length  = 180
                                                    QMI   message     = "Get Version Info" (0x0021)
                                                    QMI TLV:
                                                    QMI   type       = "Result" (0x02)
                                                    QMI   length     = 4
                                                    QMI   value      = 00:00:00:00
                                                    QMI   translated = SUCCESS
                                                    QMI TLV:
                                                    QMI   type       = "Service list" (0x01)
                                                    QMI   length     = 156
                                                    QMI   value      = 1F:00:01:00:05:00:01:01:00:24:00:02:01:00:0E:00:03:01:00:19:00:04:01:00:03:00:05:01:00:0A:00:06:01:00:00:00:07:01:00:02:00:08:01:00:02:00:09:02:00:01:00:0A:02:00:10:00:0B:01:00:19:00:0C:01:00:04:00:11:01:00:00:00:12:01:00:00:00:17:01:00:00:00:18:01:00:00:00:1A:01:00:0A:00:1D:01:00:00:00:1E:01:00:00:00:1F:01:00:00:00:21:01:00:00:00:22:01:00:00:00:29:01:00:00:00:2A:01:00:00:00:E1:01:00:00:00:F0:01:00:00:00:F2:01:00:00:00:F3:01:00:00:00:F5:01:00:00:00:F6:01:00:00:00
                                                    QMI   translated = { [0] = '[ service = 'ctl' major_version = '1' minor_version = '5' ] ' [1] = '[ service = 'wds' major_version = '1' minor_version = '36' ] ' [2] = '[ service = 'dms' major_version = '1' minor_version = '14' ] ' [3] = '[ service = 'nas' major_version = '1' minor_version = '25' ] ' [4] = '[ service = 'qos' major_version = '1' minor_version = '3' ] ' [5] = '[ service = 'wms' major_version = '1' minor_version = '10' ] ' [6] = '[ service = 'pds' major_version = '1' minor_version = '0' ] ' [7] = '[ service = 'auth' major_version = '1' minor_version = '2' ] ' [8] = '[ service = 'at' major_version = '1' minor_version = '2' ] ' [9] = '[ service = 'voice' major_version = '2' minor_version = '1' ] ' [10] = '[ service = 'cat2' major_version = '2' minor_version = '16' ] ' [11] = '[ service = 'uim' major_version = '1' minor_version = '25' ] ' [12] = '[ service = 'pbm' major_version = '1' minor_version = '4' ] ' [13] = '[ service = 'sar' major_version = '1' minor_version = '0' ] ' [14] = '[ service = 'ims' major_version = '1' minor_version = '0' ] ' [15] = '[ service = 'ts' major_version = '1' minor_version = '0' ] ' [16] = '[ service = 'tmd' major_version = '1' minor_version = '0' ] ' [17] = '[ service = 'wda' major_version = '1' minor_version = '10' ] ' [18] = '[ service = 'csvt' major_version = '1' minor_version = '0' ] ' [19] = '[ service = 'qcmap' major_version = '1' minor_version = '0' ] ' [20] = '[ service = 'imsp' major_version = '1' minor_version = '0' ] ' [21] = '[ service = 'imsa' major_version = '1' minor_version = '0' ] ' [22] = '[ service = 'coex' major_version = '1' minor_version = '0' ] ' [23] = '[ service = 'rfrpe' major_version = '1' minor_version = '0' ] ' [24] = '[ service = 'dsd' major_version = '1' minor_version = '0' ] ' [25] = '[ service = 'rms' major_version = '1' minor_version = '0' ] ' [26] = '[ service = '(null)' major_version = '1' minor_version = '0' ] ' [27] = '[ service = '(null)' major_version = '1' minor_version = '0' ] ' [28] = '[ service = '(null)' major_version = '1' minor_version = '0' ] ' [29] = '[ service = '(null)' major_version = '1' minor_version = '0' ] ' [30] = '[ service = '(null)' major_version = '1' minor_version = '0' ] '}
                                                    QMI TLV:
                                                    QMI   type   = 0x10
                                                    QMI   length = 11
                                                    QMI   value  = 04:4E:49:4C:4C:01:E1:03:00:00:00
Mar 09 11:53:00 osmo-gsm-tester-prod ofonod[23376]: plugins/gobi.c:discover_cb()
Mar 09 11:53:00 osmo-gsm-tester-prod ofonod[23376]: drivers/qmimodem/qmibridge.c:ask_qmi() _REQ: QMI QMUX:
                                                    QMI   length  = 11
                                                    QMI   flags   = 0x00
                                                    QMI   service = "ctl" 
                                                    QMI   client  = 0
                                                    QMI QMI:
                                                    QMI   flags       = "none" 
                                                    QMI   transaction = 2
                                                    QMI   tlv_length  = 0
                                                    QMI   message     = "Get Version Info" (0x0021)
Mar 09 11:53:00 osmo-gsm-tester-prod ofonod[23376]: drivers/qmimodem/qmibridge.c:ask_qmi() READ: QMI QMUX:
                                                    QMI   length  = 191
                                                    QMI   flags   = 0x80
                                                    QMI   service = "ctl" 
                                                    QMI   client  = 0
                                                    QMI QMI:
                                                    QMI   flags       = "response" 
                                                    QMI   transaction = 2
                                                    QMI   tlv_length  = 180
                                                    QMI   message     = "Get Version Info" (0x0021)
                                                    QMI TLV:
                                                    QMI   type       = "Result" (0x02)
                                                    QMI   length     = 4
                                                    QMI   value      = 00:00:00:00
                                                    QMI   translated = SUCCESS
                                                    QMI TLV:
                                                    QMI   type       = "Service list" (0x01)
                                                    QMI   length     = 156
                                                    QMI   value      = 1F:00:01:00:05:00:01:01:00:24:00:02:01:00:0E:00:03:01:00:19:00:04:01:00:03:00:05:01:00:0A:00:06:01:00:00:00:07:01:00:02:00:08:01:00:02:00:09:02:00:01:00:0A:02:00:10:00:0B:01:00:19:00:0C:01:00:04:00:11:01:00:00:00:12:01:00:00:00:17:01:00:00:00:18:01:00:00:00:1A:01:00:0A:00:1D:01:00:00:00:1E:01:00:00:00:1F:01:00:00:00:21:01:00:00:00:22:01:00:00:00:29:01:00:00:00:2A:01:00:00:00:E1:01:00:00:00:F0:01:00:00:00:F2:01:00:00:00:F3:01:00:00:00:F5:01:00:00:00:F6:01:00:00:00
                                                    QMI   translated = { [0] = '[ service = 'ctl' major_version = '1' minor_version = '5' ] ' [1] = '[ service = 'wds' major_version = '1' minor_version = '36' ] ' [2] = '[ service = 'dms' major_version = '1' minor_version = '14' ] ' [3] = '[ service = 'nas' major_version = '1' minor_version = '25' ] ' [4] = '[ service = 'qos' major_version = '1' minor_version = '3' ] ' [5] = '[ service = 'wms' major_version = '1' minor_version = '10' ] ' [6] = '[ service = 'pds' major_version = '1' minor_version = '0' ] ' [7] = '[ service = 'auth' major_version = '1' minor_version = '2' ] ' [8] = '[ service = 'at' major_version = '1' minor_version = '2' ] ' [9] = '[ service = 'voice' major_version = '2' minor_version = '1' ] ' [10] = '[ service = 'cat2' major_version = '2' minor_version = '16' ] ' [11] = '[ service = 'uim' major_version = '1' minor_version = '25' ] ' [12] = '[ service = 'pbm' major_version = '1' minor_version = '4' ] ' [13] = '[ service = 'sar' major_version = '1' minor_version = '0' ] ' [14] = '[ service = 'ims' major_version = '1' minor_version = '0' ] ' [15] = '[ service = 'ts' major_version = '1' minor_version = '0' ] ' [16] = '[ service = 'tmd' major_version = '1' minor_version = '0' ] ' [17] = '[ service = 'wda' major_version = '1' minor_version = '10' ] ' [18] = '[ service = 'csvt' major_version = '1' minor_version = '0' ] ' [19] = '[ service = 'qcmap' major_version = '1' minor_version = '0' ] ' [20] = '[ service = 'imsp' major_version = '1' minor_version = '0' ] ' [21] = '[ service = 'imsa' major_version = '1' minor_version = '0' ] ' [22] = '[ service = 'coex' major_version = '1' minor_version = '0' ] ' [23] = '[ service = 'rfrpe' major_version = '1' minor_version = '0' ] ' [24] = '[ service = 'dsd' major_version = '1' minor_version = '0' ] ' [25] = '[ service = 'rms' major_version = '1' minor_version = '0' ] ' [26] = '[ service = '(null)' major_version = '1' minor_version = '0' ] ' [27] = '[ service = '(null)' major_version = '1' minor_version = '0' ] ' [28] = '[ service = '(null)' major_version = '1' minor_version = '0' ] ' [29] = '[ service = '(null)' major_version = '1' minor_version = '0' ] ' [30] = '[ service = '(null)' major_version = '1' minor_version = '0' ] '}
                                                    QMI TLV:
                                                    QMI   type   = 0x10
                                                    QMI   length = 11
                                                    QMI   value  = 04:4E:49:4C:4C:01:E1:03:00:00:00
Mar 09 11:53:05 osmo-gsm-tester-prod ofonod[23376]: drivers/qmimodem/qmibridge.c:ask_qmi() _REQ: QMI QMUX:
                                                    QMI   length  = 15
                                                    QMI   flags   = 0x00
                                                    QMI   service = "ctl" 
                                                    QMI   client  = 0
                                                    QMI QMI:
                                                    QMI   flags       = "none" 
                                                    QMI   transaction = 3
                                                    QMI   tlv_length  = 4
                                                    QMI   message     = "Allocate CID" (0x0022)
                                                    QMI TLV:
                                                    QMI   type       = "Service" (0x01)
                                                    QMI   length     = 1
                                                    QMI   value      = 02
                                                    QMI   translated = dms
Mar 09 11:53:05 osmo-gsm-tester-prod ofonod[23376]: drivers/qmimodem/qmibridge.c:ask_qmi() READ: QMI QMUX:
                                                    QMI   length  = 18
                                                    QMI   flags   = 0x80
                                                    QMI   service = "ctl" 
                                                    QMI   client  = 0
                                                    QMI QMI:
                                                    QMI   flags       = "response" 
                                                    QMI   transaction = 3
                                                    QMI   tlv_length  = 7
                                                    QMI   message     = "Allocate CID" (0x0022)
                                                    QMI TLV:
                                                    QMI   type       = "Result" (0x02)
                                                    QMI   length     = 4
                                                    QMI   value      = 01:00:03:00
                                                    QMI   translated = FAILURE: Internal
Mar 09 11:53:08 osmo-gsm-tester-prod ofonod[23376]: plugins/gobi.c:create_dms_cb()
Mar 09 11:53:08 osmo-gsm-tester-prod ofonod[23376]: plugins/gobi.c:shutdown_device() 0x555f9e6459f0
Mar 09 11:53:08 osmo-gsm-tester-prod ofonod[23376]: plugins/gobi.c:shutdown_cb()

History

#1 Updated by pespin 9 months ago

As expected, restart ofono fixes the issue. So it seems SierraW also runs out of CIDs at some point.

Also available in: Atom PDF

Add picture from clipboard (Maximum size: 48.8 MB)