Actions
Bug #2713
openofono: chosen pdp type (v4, v6, dual) not strictly followed in ofono qmi
Status:
New
Priority:
Normal
Assignee:
-
Target version:
-
Start date:
12/06/2017
Due date:
% Done:
0%
Spec Reference:
Description
I am able to run -s sms -t ping.py fine with a SierraWireless modem in R&D setup, but /sierra_2 modem seems to fail systematically to achieve it during tests in PROD.
That's the issue from osmo-gsm-tester point of view (test failure):
14:23:28.448014 tst /sierra_2: DBG: status: searching [trial-4116↪gprs:trx-b200↪/sierra_2] [modem.py:449]
14:23:29.531629 tst /sierra_2: DBG: 'org.ofono.NetworkRegistration'.PropertyChanged() -> Status=registered [trial-4116↪gprs:trx-b200↪/sierra_2] [modem.py:443]
14:23:29.629196 tst /sierra_2: DBG: 'org.ofono.NetworkRegistration'.PropertyChanged() -> LocationAreaCode=12165 [trial-4116↪gprs:trx-b200↪/sierra_2] [modem.py:443]
14:23:29.729500 tst /sierra_2: DBG: 'org.ofono.NetworkRegistration'.PropertyChanged() -> CellId=12165 [trial-4116↪gprs:trx-b200↪/sierra_2] [modem.py:443]
14:23:29.828394 tst /sierra_2: DBG: 'org.ofono.NetworkRegistration'.PropertyChanged() -> Name=osmo-gsm-tester-nitb [trial-4116↪gprs:trx-b200↪/sierra_2] [modem.py:443]
14:23:29.920381 tst /sierra_2: DBG: 'org.ofono.NetworkRegistration'.PropertyChanged() -> MobileCountryCode=901 [trial-4116↪gprs:trx-b200↪/sierra_2] [modem.py:443]
14:23:30.005776 tst /sierra_2: DBG: 'org.ofono.NetworkRegistration'.PropertyChanged() -> MobileNetworkCode=70 [trial-4116↪gprs:trx-b200↪/sierra_2] [modem.py:443]
14:23:30.066072 tst /sierra_2: DBG: 'org.ofono.NetworkRegistration'.PropertyChanged() -> Strength=40 [trial-4116↪gprs:trx-b200↪/sierra_2] [modem.py:443]
14:23:30.140646 tst /sierra_2: DBG: status: registered [trial-4116↪gprs:trx-b200↪/sierra_2] [modem.py:449]
14:23:30.212708 bus Ctrl(host='10.42.42.8', port=4255): DBG: Connecting [trial-4116↪gprs:trx-b200↪osmo-msc_10.42.42.8↪CTRL(10.42.42.8:4255)↪Ctrl(host='10.42.42.8', port=4255)] [osmo_ctrl.py:54]
14:23:30.281244 bus Ctrl(host='10.42.42.8', port=4255): DBG: Sending {data='GET 0 subscriber-list-active-v1'} [trial-4116↪gprs:trx-b200↪osmo-msc_10.42.42.8↪CTRL(10.42.42.8:4255)↪Ctrl(host='10.42.42.8', port=4255)] [osmo_ctrl.py:65]
14:23:30.366858 bus Ctrl(host='10.42.42.8', port=4255): DBG: Receiving {data=b'\x00=\xee\x00GET_REPLY 0 subscriber-list-active-v1 901700000015252,21439\n'} [trial-4116↪gprs:trx-b200↪osmo-msc_10.42.42.8↪CTRL(10.42.42.8:4255)↪Ctrl(host='10.42.42.8', port=4255)] [osmo_ctrl.py:71]
14:23:30.471581 bus Ctrl(host='10.42.42.8', port=4255): DBG: Disconnecting [trial-4116↪gprs:trx-b200↪osmo-msc_10.42.42.8↪CTRL(10.42.42.8:4255)↪Ctrl(host='10.42.42.8', port=4255)] [osmo_ctrl.py:60]
14:23:30.583918 run osmo-msc_10.42.42.8: DBG: attached: GET_REPLY 0 subscriber-list-active-v1 901700000015252,21439 [trial-4116↪gprs:trx-b200↪osmo-msc_10.42.42.8] [osmo_msc.py:129]
14:23:30.846131 tst ping.py:45: waiting for modems to attach to data services... [trial-4116↪gprs:trx-b200↪ping.py:45] [ping.py:45]
14:23:31.223555 tst /sierra_2: DBG: attached: False [trial-4116↪gprs:trx-b200↪/sierra_2] [modem.py:579]
14:23:32.291954 tst /sierra_2: DBG: attached: False [trial-4116↪gprs:trx-b200↪/sierra_2] [modem.py:579]
14:23:33.363160 tst /sierra_2: DBG: 'org.ofono.ConnectionManager'.PropertyChanged() -> Attached=True [trial-4116↪gprs:trx-b200↪/sierra_2] [modem.py:723]
14:23:33.432808 tst /sierra_2: DBG: attached: True [trial-4116↪gprs:trx-b200↪/sierra_2] [modem.py:579]
14:23:33.499989 tst /sierra_2: DBG: activate_context {apn='internet', user='ogt'} [trial-4116↪gprs:trx-b200↪/sierra_2] [modem.py:599]
14:23:36.999938 tst ping.py:47: ERR: Error: g-io-error-quark: GDBus.Error:org.ofono.Error.Failed: Operation failed (36) [trial-4116↪gprs:trx-b200↪ping.py:47] [proxy_method.py:75: 0, timeout_to_glib(timeout), None).unpack()]
14:23:37.007427 tst ping.py:47: TRACEBACK: Traceback (most recent call last):
File "/home/jenkins/workspace/osmo-gsm-tester_run/osmo-gsm-tester/src/osmo_gsm_tester/test.py", line 61, in run
self.path)
File "/home/jenkins/workspace/osmo-gsm-tester_run/osmo-gsm-tester/src/osmo_gsm_tester/util.py", line 308, in run_python_file
SourceFileLoader(module_name, path).load_module()
File "<frozen importlib._bootstrap>", line 539, in _check_name_wrapper
File "<frozen importlib._bootstrap>", line 1614, in load_module
File "<frozen importlib._bootstrap>", line 596, in _load_module_shim
File "<frozen importlib._bootstrap>", line 1220, in load
File "<frozen importlib._bootstrap>", line 1200, in _load_unlocked
File "<frozen importlib._bootstrap>", line 1129, in _exec
File "<frozen importlib._bootstrap>", line 1471, in exec_module
File "<frozen importlib._bootstrap>", line 321, in _call_with_frames_removed
File "/home/jenkins/workspace/osmo-gsm-tester_run/osmo-gsm-tester/suites/gprs/ping.py", line 47, in <module>
ctx_id_v4 = ms.activate_context(apn='internet', protocol=ms.CTX_PROT_IPv4)
File "/home/jenkins/workspace/osmo-gsm-tester_run/osmo-gsm-tester/src/osmo_gsm_tester/modem.py", line 611, in activate_context
ctx.SetProperty('Active', Variant('b', True))
File "/usr/local/lib/python3.4/dist-packages/pydbus/proxy_method.py", line 75, in __call__
0, timeout_to_glib(timeout), None).unpack()
GLib.Error: g-io-error-quark: GDBus.Error:org.ofono.Error.Failed: Operation failed (36)
During that time, ofono.log shows:
Dec 06 14:23:31.583936 testbed-production ofonod[25802]: drivers/qmimodem/network-registration.c:get_rssi_cb()
Dec 06 14:23:36.991841 testbed-production ofonod[25802]: drivers/qmimodem/qmibridge.c:ask_qmi() READ: QMI QMUX:
QMI length = 31
QMI flags = 0x80
QMI service = "wds"
QMI client = 9
QMI QMI:
QMI flags = "response"
QMI transaction = 358
QMI tlv_length = 19
QMI message = "Start Network" (0x0020)
QMI TLV:
QMI type = "Result" (0x02)
QMI length = 4
QMI value = 01:00:0E:00
QMI translated = FAILURE: CallFailed
QMI TLV:
QMI type = "Call End Reason" (0x10)
QMI length = 2
QMI value = F5:03
QMI translated = gsm-wcdma-unknown-apn
QMI TLV:
QMI type = "Verbose Call End Reason" (0x11)
QMI length = 4
QMI value = 06:00:1B:00
QMI translated = [ type = '3gpp' reason = '27' ]
Dec 06 14:23:36.991897 testbed-production ofonod[25802]: drivers/qmimodem/gprs-context.c:start_net_cb()
Dec 06 14:23:36.991922 testbed-production ofonod[25802]: src/gprs.c:pri_activate_callback() 0x6fed140
Dec 06 14:23:36.991944 testbed-production ofonod[25802]: src/gprs.c:pri_activate_callback() Activating context failed with error: Unknown error type
Dec 06 14:23:50.401621 testbed-production ofonod[25802]: src/gprs.c:gprs_netreg_update() attach: 0, driver_attached: 1
Dec 06 14:23:50.401676 testbed-production ofonod[25802]: drivers/qmimodem/gprs.c:qmi_set_attached() attached 0
Files
Related issues
Actions
