https://osmocom.org/https://osmocom.org/favicon.ico?16647414092017-05-05T13:31:13ZOpen Source Mobile CommunicationsOsmoGSMTester - Bug #2239: ofono: USSD is not implemented for any modemhttps://osmocom.org/issues/2239?journal_id=37872017-05-05T13:31:13Zneelsnhofmeyr@sysmocom.de
<ul></ul><p>EC20 and Sierra say:</p>
<pre>
# mdbus2 -s org.ofono /gobi_0 org.ofono.SupplementaryServices.Initiate "*#100#"
[ERR]: GDBus.Error:org.ofono.Error.NotImplemented: Implementation not provided
# mdbus2 -s org.ofono /sierra_1 org.ofono.SupplementaryServices.Initiate "*#100#"
[ERR]: GDBus.Error:org.ofono.Error.NotImplemented: Implementation not provided
</pre>
<p>Gobi has no such interface to begin with, says:</p>
<pre>
# mdbus2 -s org.ofono /gobi_3 org.ofono.SupplementaryServices.Initiate "*#100#"
[ERR]: There is no method with name org.ofono.SupplementaryServices.Initiate on path /gobi_3!
</pre> OsmoGSMTester - Bug #2239: ofono: USSD is not implemented for any modemhttps://osmocom.org/issues/2239?journal_id=37882017-05-05T13:32:45Zneelsnhofmeyr@sysmocom.de
<ul></ul><p>see also <a class="external" href="https://git.sysmocom.de/ofono/tree/test/send-ussd">https://git.sysmocom.de/ofono/tree/test/send-ussd</a> as verification that this is the proper ofono interface.<br />If I pick other arguments I also get:</p>
<pre>
root@osmo-gsm-tester-rnd:~# mdbus2 -s org.ofono /gobi_0 org.ofono.SupplementaryServices.Initiate "*#100#"
[ERR]: GDBus.Error:org.ofono.Error.NotImplemented: Implementation not provided
root@osmo-gsm-tester-rnd:~# mdbus2 -s org.ofono /gobi_0 org.ofono.SupplementaryServices.Initiate "1234"
[ERR]: GDBus.Error:org.ofono.Error.NotRecognized: String not recognized as USSD/SS
root@osmo-gsm-tester-rnd:~# mdbus2 -s org.ofono /gobi_0 org.ofono.SupplementaryServices.Initiate "100"
[ERR]: GDBus.Error:org.ofono.Error.NotRecognized: String not recognized as USSD/SS
root@osmo-gsm-tester-rnd:~# mdbus2 -s org.ofono /gobi_0 org.ofono.SupplementaryServices.Initiate "#100"
[ERR]: GDBus.Error:org.ofono.Error.NotRecognized: String not recognized as USSD/SS
root@osmo-gsm-tester-rnd:~# mdbus2 -s org.ofono /gobi_0 org.ofono.SupplementaryServices.Initiate "*100"
[ERR]: GDBus.Error:org.ofono.Error.NotRecognized: String not recognized as USSD/SS
root@osmo-gsm-tester-rnd:~# mdbus2 -s org.ofono /gobi_0 org.ofono.SupplementaryServices.Initiate "*100#"
[ERR]: GDBus.Error:org.ofono.Error.NotImplemented: Implementation not provided
root@osmo-gsm-tester-rnd:~# mdbus2 -s org.ofono /gobi_0 org.ofono.SupplementaryServices.Initiate "*#100#"
[ERR]: GDBus.Error:org.ofono.Error.NotImplemented: Implementation not provided
</pre> OsmoGSMTester - Bug #2239: ofono: USSD is not implemented for any modemhttps://osmocom.org/issues/2239?journal_id=38142017-05-08T10:40:31Zneelsnhofmeyr@sysmocom.de
<ul><li><strong>Priority</strong> changed from <i>Normal</i> to <i>High</i></li></ul> OsmoGSMTester - Bug #2239: ofono: USSD is not implemented for any modemhttps://osmocom.org/issues/2239?journal_id=38722017-05-14T11:18:01Zlaforge
<ul><li><strong>Assignee</strong> deleted (<del><i>118</i></del>)</li></ul> OsmoGSMTester - Bug #2239: ofono: USSD is not implemented for any modemhttps://osmocom.org/issues/2239?journal_id=39072017-05-15T12:58:54Zlaforge
<ul><li><strong>Assignee</strong> set to <i>55360</i></li></ul> OsmoGSMTester - Bug #2239: ofono: USSD is not implemented for any modemhttps://osmocom.org/issues/2239?journal_id=39812017-05-16T17:52:50Zlynxis
<ul></ul><p>it's missing completely just the register + remove is implemented.</p> OsmoGSMTester - Bug #2239: ofono: USSD is not implemented for any modemhttps://osmocom.org/issues/2239?journal_id=40522017-05-24T12:37:19Zneelsnhofmeyr@sysmocom.de
<ul><li><strong>Assignee</strong> changed from <i>55360</i> to <i>lynxis</i></li></ul> OsmoGSMTester - Bug #2239: ofono: USSD is not implemented for any modemhttps://osmocom.org/issues/2239?journal_id=42442017-06-06T10:21:57Zlynxis
<ul></ul><p>MO USSD works now. I've pushed it to git://git.sysmocom.de/ofono branch ussd.</p>
<p>Missing: push it to upstream (rework coding style, naming defines).</p> OsmoGSMTester - Bug #2239: ofono: USSD is not implemented for any modemhttps://osmocom.org/issues/2239?journal_id=42452017-06-06T10:22:08Zlynxis
<ul><li><strong>Status</strong> changed from <i>New</i> to <i>In Progress</i></li><li><strong>% Done</strong> changed from <i>0</i> to <i>90</i></li></ul> OsmoGSMTester - Bug #2239: ofono: USSD is not implemented for any modemhttps://osmocom.org/issues/2239?journal_id=42462017-06-06T10:39:27Zpespin
<ul></ul><p>Working example:<br /><pre>
mdbus2 -s -i org.ofono $MODEM org.ofono.SupplementaryServices.Initiate "*#100#" => ('USSD', <'Your extension is 21101\r\r'>)
</pre></p>
<p>Or in the ofono test repo:<br /><pre>
ofono/initiate-ussd /gobi_0 '*#100#'
</pre></p> OsmoGSMTester - Bug #2239: ofono: USSD is not implemented for any modemhttps://osmocom.org/issues/2239?journal_id=42632017-06-12T14:46:46Zpespin
<ul></ul><p>I added some code to test the USSD '*#100#' feature. It sometimes works correctly, but sometimes the Initiate method fails with:<br /><pre>
GLib.Error: g-io-error-quark: GDBus.Error:org.ofono.Error.Terminated: Operation was terminated by the network (36)
</pre></p>
<p>When that failure occurs, I cannot see any related messages in wireshark (filter: gsm_a.dtap.protocol_discriminator == 11).<br />Output from ofono -d:<br /><pre>
ofonod[22411]: drivers/qmimodem/network-registration.c:scan_nets_cb()
ofonod[22411]: drivers/qmimodem/network-registration.c:scan_nets_cb() found 10 operators
ofonod[22411]: drivers/qmimodem/network-registration.c:scan_nets_cb() 901-70 (901:70) status 1
ofonod[22411]: drivers/qmimodem/network-registration.c:scan_nets_cb() E-Plus (262:03) status 3
ofonod[22411]: drivers/qmimodem/network-registration.c:scan_nets_cb() TDG (262:01) status 3
ofonod[22411]: drivers/qmimodem/network-registration.c:scan_nets_cb() TDG (262:01) status 3
ofonod[22411]: drivers/qmimodem/network-registration.c:scan_nets_cb() E-Plus (262:03) status 3
ofonod[22411]: drivers/qmimodem/network-registration.c:scan_nets_cb() Vodafone (262:02) status 3
ofonod[22411]: drivers/qmimodem/network-registration.c:scan_nets_cb() TDG (262:01) status 3
ofonod[22411]: drivers/qmimodem/network-registration.c:scan_nets_cb() Vodafone (262:02) status 3
ofonod[22411]: drivers/qmimodem/network-registration.c:scan_nets_cb() E-Plus (262:03) status 3
ofonod[22411]: drivers/qmimodem/network-registration.c:scan_nets_cb() Vodafone (262:02) status 3
ofonod[22411]: drivers/qmimodem/network-registration.c:scan_nets_cb() 901:70 4
ofonod[22411]: drivers/qmimodem/network-registration.c:scan_nets_cb() 262:03 5
ofonod[22411]: drivers/qmimodem/network-registration.c:scan_nets_cb() 262:01 8
ofonod[22411]: drivers/qmimodem/network-registration.c:scan_nets_cb() 262:01 4
ofonod[22411]: drivers/qmimodem/network-registration.c:scan_nets_cb() 262:03 4
ofonod[22411]: drivers/qmimodem/network-registration.c:scan_nets_cb() 262:02 4
ofonod[22411]: drivers/qmimodem/network-registration.c:scan_nets_cb() 262:01 5
ofonod[22411]: drivers/qmimodem/network-registration.c:scan_nets_cb() 262:02 5
ofonod[22411]: drivers/qmimodem/network-registration.c:scan_nets_cb() 262:03 8
ofonod[22411]: drivers/qmimodem/network-registration.c:scan_nets_cb() 262:02 8
ofonod[22411]: drivers/qmimodem/network-registration.c:qmi_register_manual()
ofonod[22411]: drivers/qmimodem/network-registration.c:register_net_cb()
ofonod[22411]: drivers/qmimodem/network-registration.c:qmi_registration_status()
ofonod[22411]: drivers/qmimodem/network-registration.c:ss_info_notify()
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info()
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() serving system status 3
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() radio in use 0
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() lac -1 cellid -1 tech -1
ofonod[22411]: src/network.c:ofono_netreg_status_notify() /sierra_1 status 3 tech -1
ofonod[22411]: src/network.c:current_operator_callback() 0x26f3710, (nil)
ofonod[22411]: src/gprs.c:netreg_status_changed() 3
ofonod[22411]: src/gprs.c:gprs_netreg_update() attach: 0, driver_attached: 0
ofonod[22411]: drivers/qmimodem/gprs.c:ss_info_notify()
ofonod[22411]: drivers/qmimodem/gprs.c:handle_ss_info()
ofonod[22411]: drivers/qmimodem/gprs.c:extract_ss_info()
ofonod[22411]: drivers/qmimodem/gprs.c:extract_ss_info() radio in use 0
ofonod[22411]: src/gprs.c:ofono_gprs_status_notify() /sierra_1 status 0
ofonod[22411]: drivers/qmimodem/network-registration.c:get_ss_info_cb()
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info()
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() serving system status 3
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() radio in use 0
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() lac -1 cellid -1 tech -1
ofonod[22411]: src/network.c:ofono_netreg_status_notify() /sierra_1 status 3 tech -1
ofonod[22411]: src/network.c:current_operator_callback() 0x26f3710, (nil)
ofonod[22411]: src/gprs.c:netreg_status_changed() 3
ofonod[22411]: src/gprs.c:gprs_netreg_update() attach: 0, driver_attached: 0
ofonod[22411]: drivers/qmimodem/network-registration.c:event_notify()
ofonod[22411]: drivers/qmimodem/network-registration.c:event_notify() signal with -86 dBm on 4
ofonod[22411]: drivers/qmimodem/network-registration.c:ss_info_notify()
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info()
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() serving system status 0
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() radio in use 4
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() osmo-gsm-tester-nitb (901:70)
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() lac -1 cellid -1 tech 0
ofonod[22411]: src/network.c:ofono_netreg_status_notify() /sierra_1 status 0 tech 0
ofonod[22411]: src/network.c:current_operator_callback() 0x26f3710, (nil)
ofonod[22411]: src/gprs.c:netreg_status_changed() 0
ofonod[22411]: src/gprs.c:gprs_netreg_update() attach: 0, driver_attached: 0
ofonod[22411]: drivers/qmimodem/gprs.c:ss_info_notify()
ofonod[22411]: drivers/qmimodem/gprs.c:handle_ss_info()
ofonod[22411]: drivers/qmimodem/gprs.c:extract_ss_info()
ofonod[22411]: drivers/qmimodem/gprs.c:extract_ss_info() radio in use 4
ofonod[22411]: src/gprs.c:ofono_gprs_status_notify() /sierra_1 status 0
ofonod[22411]: drivers/qmimodem/network-registration.c:event_notify()
ofonod[22411]: drivers/qmimodem/network-registration.c:event_notify() rat 0 band 0 channel 0
ofonod[22411]: drivers/qmimodem/network-registration.c:event_notify() rat 4 band 47 channel 868
ofonod[22411]: drivers/qmimodem/network-registration.c:ss_info_notify()
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info()
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() serving system status 1
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() radio in use 4
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() osmo-gsm-tester-nitb (901:70)
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() lac 23 cellid 0 tech 0
ofonod[22411]: src/network.c:ofono_netreg_status_notify() /sierra_1 status 1 tech 0
ofonod[22411]: drivers/qmimodem/network-registration.c:qmi_current_operator()
ofonod[22411]: src/network.c:current_operator_callback() 0x26f3710, (nil)
ofonod[22411]: src/gprs.c:netreg_status_changed() 1
ofonod[22411]: src/gprs.c:gprs_netreg_update() attach: 1, driver_attached: 0
ofonod[22411]: drivers/qmimodem/gprs.c:qmi_set_attached() attached 1
ofonod[22411]: drivers/qmimodem/network-registration.c:qmi_signal_strength()
ofonod[22411]: src/gprs.c:netreg_status_changed() 1
ofonod[22411]: src/gprs.c:gprs_netreg_update() attach: 1, driver_attached: 1
ofonod[22411]: drivers/qmimodem/gprs.c:ss_info_notify()
ofonod[22411]: drivers/qmimodem/gprs.c:handle_ss_info()
ofonod[22411]: drivers/qmimodem/gprs.c:extract_ss_info()
ofonod[22411]: drivers/qmimodem/gprs.c:extract_ss_info() radio in use 4
ofonod[22411]: src/gprs.c:ofono_gprs_status_notify() /sierra_1 status 0
ofonod[22411]: drivers/qmimodem/network-registration.c:event_notify()
ofonod[22411]: drivers/qmimodem/network-registration.c:event_notify() rat 0 band 0 channel 0
ofonod[22411]: drivers/qmimodem/network-registration.c:event_notify() rat 4 band 47 channel 868
ofonod[22411]: drivers/qmimodem/network-registration.c:ss_info_notify()
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info()
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() serving system status 1
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() radio in use 4
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() osmo-gsm-tester-nitb (901:70)
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() lac -1 cellid -1 tech 0
ofonod[22411]: src/network.c:ofono_netreg_status_notify() /sierra_1 status 1 tech 0
ofonod[22411]: drivers/qmimodem/network-registration.c:qmi_current_operator()
ofonod[22411]: src/network.c:current_operator_callback() 0x26f3710, 0x26dcaf0
ofonod[22411]: drivers/qmimodem/network-registration.c:qmi_signal_strength()
ofonod[22411]: src/gprs.c:netreg_status_changed() 1
ofonod[22411]: src/gprs.c:gprs_netreg_update() attach: 1, driver_attached: 1
ofonod[22411]: drivers/qmimodem/gprs.c:ss_info_notify()
ofonod[22411]: drivers/qmimodem/gprs.c:handle_ss_info()
ofonod[22411]: drivers/qmimodem/gprs.c:extract_ss_info()
ofonod[22411]: drivers/qmimodem/gprs.c:extract_ss_info() radio in use 4
ofonod[22411]: src/gprs.c:ofono_gprs_status_notify() /sierra_1 status 0
ofonod[22411]: drivers/qmimodem/network-registration.c:ss_info_notify()
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info()
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() serving system status 1
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() radio in use 4
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() osmo-gsm-tester-nitb (901:70)
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() lac -1 cellid -1 tech 0
ofonod[22411]: src/network.c:ofono_netreg_status_notify() /sierra_1 status 1 tech 0
ofonod[22411]: drivers/qmimodem/network-registration.c:qmi_current_operator()
ofonod[22411]: src/network.c:current_operator_callback() 0x26f3710, 0x26dcaf0
ofonod[22411]: drivers/qmimodem/network-registration.c:qmi_signal_strength()
ofonod[22411]: src/gprs.c:netreg_status_changed() 1
ofonod[22411]: src/gprs.c:gprs_netreg_update() attach: 1, driver_attached: 1
ofonod[22411]: drivers/qmimodem/gprs.c:ss_info_notify()
ofonod[22411]: drivers/qmimodem/gprs.c:handle_ss_info()
ofonod[22411]: drivers/qmimodem/gprs.c:extract_ss_info()
ofonod[22411]: drivers/qmimodem/gprs.c:extract_ss_info() radio in use 4
ofonod[22411]: src/gprs.c:ofono_gprs_status_notify() /sierra_1 status 0
ofonod[22411]: drivers/qmimodem/network-registration.c:ss_info_notify()
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info()
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() serving system status 1
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() radio in use 4
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() 901-70 (901:70)
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() lac -1 cellid -1 tech 0
ofonod[22411]: src/network.c:ofono_netreg_status_notify() /sierra_1 status 1 tech 0
ofonod[22411]: drivers/qmimodem/network-registration.c:qmi_current_operator()
ofonod[22411]: src/network.c:current_operator_callback() 0x26f3710, 0x26dcaf0
ofonod[22411]: drivers/qmimodem/network-registration.c:qmi_signal_strength()
ofonod[22411]: src/gprs.c:netreg_status_changed() 1
ofonod[22411]: src/gprs.c:gprs_netreg_update() attach: 1, driver_attached: 1
ofonod[22411]: drivers/qmimodem/gprs.c:ss_info_notify()
ofonod[22411]: drivers/qmimodem/gprs.c:handle_ss_info()
ofonod[22411]: drivers/qmimodem/gprs.c:extract_ss_info()
ofonod[22411]: drivers/qmimodem/gprs.c:extract_ss_info() radio in use 4
ofonod[22411]: src/gprs.c:ofono_gprs_status_notify() /sierra_1 status 0
ofonod[22411]: drivers/qmimodem/gprs.c:attach_detach_cb()
ofonod[22411]: src/gprs.c:gprs_attach_callback() /sierra_1 error = 0
ofonod[22411]: drivers/qmimodem/gprs.c:qmi_attached_status()
ofonod[22411]: drivers/qmimodem/network-registration.c:ss_info_notify()
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info()
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() serving system status 1
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() radio in use 4
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() 901-70 (901:70)
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() lac -1 cellid -1 tech 0
ofonod[22411]: src/network.c:ofono_netreg_status_notify() /sierra_1 status 1 tech 0
ofonod[22411]: drivers/qmimodem/network-registration.c:qmi_current_operator()
ofonod[22411]: src/network.c:current_operator_callback() 0x26f3710, 0x26dcaf0
ofonod[22411]: drivers/qmimodem/network-registration.c:qmi_signal_strength()
ofonod[22411]: src/gprs.c:netreg_status_changed() 1
ofonod[22411]: src/gprs.c:gprs_netreg_update() attach: 1, driver_attached: 1
ofonod[22411]: drivers/qmimodem/gprs.c:ss_info_notify()
ofonod[22411]: drivers/qmimodem/gprs.c:handle_ss_info()
ofonod[22411]: drivers/qmimodem/gprs.c:extract_ss_info()
ofonod[22411]: drivers/qmimodem/gprs.c:extract_ss_info() radio in use 4
ofonod[22411]: src/gprs.c:ofono_gprs_status_notify() /sierra_1 status 0
ofonod[22411]: drivers/qmimodem/network-registration.c:ss_info_notify()
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info()
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() serving system status 1
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() radio in use 4
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() 901-70 (901:70)
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() lac -1 cellid -1 tech 0
ofonod[22411]: src/network.c:ofono_netreg_status_notify() /sierra_1 status 1 tech 0
ofonod[22411]: drivers/qmimodem/network-registration.c:qmi_current_operator()
ofonod[22411]: src/network.c:current_operator_callback() 0x26f3710, 0x26dcaf0
ofonod[22411]: drivers/qmimodem/network-registration.c:qmi_signal_strength()
ofonod[22411]: src/gprs.c:netreg_status_changed() 1
ofonod[22411]: src/gprs.c:gprs_netreg_update() attach: 1, driver_attached: 1
ofonod[22411]: drivers/qmimodem/gprs.c:ss_info_notify()
ofonod[22411]: drivers/qmimodem/gprs.c:handle_ss_info()
ofonod[22411]: drivers/qmimodem/gprs.c:extract_ss_info()
ofonod[22411]: drivers/qmimodem/gprs.c:extract_ss_info() radio in use 4
ofonod[22411]: src/gprs.c:ofono_gprs_status_notify() /sierra_1 status 0
ofonod[22411]: drivers/qmimodem/network-registration.c:get_rssi_cb()
ofonod[22411]: drivers/qmimodem/network-registration.c:get_rssi_cb() signal with -86 dBm on 4
ofonod[22411]: src/network.c:ofono_netreg_strength_notify() strength 20
ofonod[22411]: drivers/qmimodem/network-registration.c:get_rssi_cb()
ofonod[22411]: drivers/qmimodem/network-registration.c:get_rssi_cb() signal with -86 dBm on 4
ofonod[22411]: drivers/qmimodem/network-registration.c:get_rssi_cb()
ofonod[22411]: drivers/qmimodem/network-registration.c:get_rssi_cb() signal with -86 dBm on 4
ofonod[22411]: drivers/qmimodem/network-registration.c:get_rssi_cb()
ofonod[22411]: drivers/qmimodem/network-registration.c:get_rssi_cb() signal with -86 dBm on 4
ofonod[22411]: drivers/qmimodem/gprs.c:get_ss_info_cb()
ofonod[22411]: drivers/qmimodem/gprs.c:handle_ss_info()
ofonod[22411]: drivers/qmimodem/gprs.c:extract_ss_info()
ofonod[22411]: drivers/qmimodem/gprs.c:extract_ss_info() radio in use 4
ofonod[22411]: src/gprs.c:registration_status_cb() /sierra_1 error 0 status 0
ofonod[22411]: src/gprs.c:ofono_gprs_status_notify() /sierra_1 status 0
ofonod[22411]: drivers/qmimodem/network-registration.c:get_rssi_cb()
ofonod[22411]: drivers/qmimodem/network-registration.c:get_rssi_cb() signal with -86 dBm on 4
ofonod[22411]: drivers/qmimodem/network-registration.c:get_rssi_cb()
ofonod[22411]: drivers/qmimodem/network-registration.c:get_rssi_cb() signal with -86 dBm on 4
ofonod[22411]: src/ussd.c:ussd_initiate() checking if this is a recognized control string
ofonod[22411]: src/ussd.c:recognized_control_string() parsing control string
ofonod[22411]: src/ussd.c:recognized_control_string() Got parse result: 2, 100, , , , ,
ofonod[22411]: src/ussd.c:ussd_initiate() No.., checking if this is a USSD string
ofonod[22411]: src/ussd.c:ussd_initiate() OK, running USSD request
ofonod[22411]: drivers/qmimodem/ussd.c:qmi_ussd_request()
ofonod[22411]: drivers/qmimodem/network-registration.c:ss_info_notify()
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info()
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() serving system status 1
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() radio in use 4
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() 901-70 (901:70)
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() lac -1 cellid -1 tech 0
ofonod[22411]: src/network.c:ofono_netreg_status_notify() /sierra_1 status 1 tech 0
ofonod[22411]: drivers/qmimodem/network-registration.c:qmi_current_operator()
ofonod[22411]: src/network.c:current_operator_callback() 0x26f3710, 0x26dcaf0
ofonod[22411]: drivers/qmimodem/network-registration.c:qmi_signal_strength()
ofonod[22411]: src/gprs.c:netreg_status_changed() 1
ofonod[22411]: src/gprs.c:gprs_netreg_update() attach: 1, driver_attached: 1
ofonod[22411]: drivers/qmimodem/gprs.c:ss_info_notify()
ofonod[22411]: drivers/qmimodem/gprs.c:handle_ss_info()
ofonod[22411]: drivers/qmimodem/gprs.c:extract_ss_info()
ofonod[22411]: drivers/qmimodem/gprs.c:extract_ss_info() radio in use 4
ofonod[22411]: src/gprs.c:ofono_gprs_status_notify() /sierra_1 status 0
ofonod[22411]: drivers/qmimodem/network-registration.c:ss_info_notify()
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info()
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() serving system status 1
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() radio in use 4
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() osmo-gsm-tester-nitb (901:70)
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() lac -1 cellid -1 tech 0
ofonod[22411]: src/network.c:ofono_netreg_status_notify() /sierra_1 status 1 tech 0
ofonod[22411]: drivers/qmimodem/network-registration.c:qmi_current_operator()
ofonod[22411]: src/network.c:current_operator_callback() 0x26f3710, 0x26dcaf0
ofonod[22411]: drivers/qmimodem/network-registration.c:qmi_signal_strength()
ofonod[22411]: src/gprs.c:netreg_status_changed() 1
ofonod[22411]: src/gprs.c:gprs_netreg_update() attach: 1, driver_attached: 1
ofonod[22411]: drivers/qmimodem/gprs.c:ss_info_notify()
ofonod[22411]: drivers/qmimodem/gprs.c:handle_ss_info()
ofonod[22411]: drivers/qmimodem/gprs.c:extract_ss_info()
ofonod[22411]: drivers/qmimodem/gprs.c:extract_ss_info() radio in use 4
ofonod[22411]: src/gprs.c:ofono_gprs_status_notify() /sierra_1 status 0
ofonod[22411]: drivers/qmimodem/ussd.c:qmi_ussd_request_cb()
ofonod[22411]: drivers/qmimodem/qmi.c:qmi_result_print_tlvs() tlv: 0x02 len 0x0004
ofonod[22411]: drivers/qmimodem/ussd.c:async_orig_ind()
ofonod[22411]: drivers/qmimodem/ussd.c:async_orig_ind() Failure Cause: 0x0019
ofonod[22411]: src/ussd.c:ofono_ussd_notify() status: 2 TERMINATED, state: 1 ACTIVE
ofonod[22411]: drivers/qmimodem/network-registration.c:get_rssi_cb()
ofonod[22411]: drivers/qmimodem/network-registration.c:get_rssi_cb() signal with -86 dBm on 4
ofonod[22411]: drivers/qmimodem/network-registration.c:get_rssi_cb()
ofonod[22411]: drivers/qmimodem/network-registration.c:get_rssi_cb() signal with -86 dBm on 4
ofonod[22411]: drivers/qmimodem/network-registration.c:ss_info_notify()
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info()
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() serving system status 1
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() radio in use 4
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() osmo-gsm-tester-nitb (901:70)
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() lac -1 cellid -1 tech 0
ofonod[22411]: src/network.c:ofono_netreg_status_notify() /sierra_1 status 1 tech 0
ofonod[22411]: drivers/qmimodem/network-registration.c:qmi_current_operator()
ofonod[22411]: src/network.c:current_operator_callback() 0x26f3710, 0x26dcaf0
ofonod[22411]: drivers/qmimodem/network-registration.c:qmi_signal_strength()
ofonod[22411]: src/gprs.c:netreg_status_changed() 1
ofonod[22411]: src/gprs.c:gprs_netreg_update() attach: 1, driver_attached: 1
ofonod[22411]: drivers/qmimodem/gprs.c:ss_info_notify()
ofonod[22411]: drivers/qmimodem/gprs.c:handle_ss_info()
ofonod[22411]: drivers/qmimodem/gprs.c:extract_ss_info()
ofonod[22411]: drivers/qmimodem/gprs.c:extract_ss_info() radio in use 4
ofonod[22411]: src/gprs.c:ofono_gprs_status_notify() /sierra_1 status 0
ofonod[22411]: drivers/qmimodem/network-registration.c:get_rssi_cb()
ofonod[22411]: drivers/qmimodem/network-registration.c:get_rssi_cb() signal with -86 dBm on 4
</pre></p> OsmoGSMTester - Bug #2239: ofono: USSD is not implemented for any modemhttps://osmocom.org/issues/2239?journal_id=42662017-06-12T15:20:54Zpespin
<ul></ul><p>Exactly same issue with EC20 modem (before I tested with a Sierra one).</p>
<pre>
ofonod[22411]: drivers/qmimodem/network-registration.c:scan_nets_cb()
ofonod[22411]: drivers/qmimodem/network-registration.c:scan_nets_cb() found 10 operators
ofonod[22411]: drivers/qmimodem/network-registration.c:scan_nets_cb() 90170 (901:70) status 1
ofonod[22411]: drivers/qmimodem/network-registration.c:scan_nets_cb() E-Plus (262:03) status 3
ofonod[22411]: drivers/qmimodem/network-registration.c:scan_nets_cb() TDG (262:01) status 3
ofonod[22411]: drivers/qmimodem/network-registration.c:scan_nets_cb() TDG (262:01) status 3
ofonod[22411]: drivers/qmimodem/network-registration.c:scan_nets_cb() E-Plus (262:03) status 3
ofonod[22411]: drivers/qmimodem/network-registration.c:scan_nets_cb() Vodafone.de (262:02) statu
s 3
ofonod[22411]: drivers/qmimodem/network-registration.c:scan_nets_cb() Vodafone.de (262:02) statu
s 3
ofonod[22411]: drivers/qmimodem/network-registration.c:scan_nets_cb() TDG (262:01) status 3
ofonod[22411]: drivers/qmimodem/network-registration.c:scan_nets_cb() E-Plus (262:03) status 3
ofonod[22411]: drivers/qmimodem/network-registration.c:scan_nets_cb() Vodafone.de (262:02) statu
s 3
ofonod[22411]: drivers/qmimodem/network-registration.c:scan_nets_cb() 901:70 4
ofonod[22411]: drivers/qmimodem/network-registration.c:scan_nets_cb() 262:03 5
ofonod[22411]: drivers/qmimodem/network-registration.c:scan_nets_cb() 262:01 4
ofonod[22411]: drivers/qmimodem/network-registration.c:scan_nets_cb() 262:01 5
ofonod[22411]: drivers/qmimodem/network-registration.c:scan_nets_cb() 262:03 4
ofonod[22411]: drivers/qmimodem/network-registration.c:scan_nets_cb() 262:02 4
ofonod[22411]: drivers/qmimodem/network-registration.c:scan_nets_cb() 262:02 5
ofonod[22411]: drivers/qmimodem/network-registration.c:scan_nets_cb() 262:01 8
ofonod[22411]: drivers/qmimodem/network-registration.c:scan_nets_cb() 262:03 8
ofonod[22411]: drivers/qmimodem/network-registration.c:scan_nets_cb() 262:02 8
ofonod[22411]: drivers/qmimodem/network-registration.c:qmi_register_manual()
ofonod[22411]: drivers/qmimodem/network-registration.c:register_net_cb()
ofonod[22411]: drivers/qmimodem/network-registration.c:qmi_registration_status()
ofonod[22411]: drivers/qmimodem/network-registration.c:ss_info_notify()
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info()
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() serving system status 3
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() radio in use 0
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() lac -1 cellid -1 tech -
1
ofonod[22411]: src/network.c:ofono_netreg_status_notify() /gobi_0 status 3 tech -1
ofonod[22411]: src/network.c:current_operator_callback() 0x2708c00, (nil)
ofonod[22411]: src/gprs.c:netreg_status_changed() 3
ofonod[22411]: src/gprs.c:gprs_netreg_update() attach: 0, driver_attached: 0
ofonod[22411]: drivers/qmimodem/gprs.c:ss_info_notify()
ofonod[22411]: drivers/qmimodem/gprs.c:handle_ss_info()
ofonod[22411]: drivers/qmimodem/gprs.c:extract_ss_info()
ofonod[22411]: drivers/qmimodem/gprs.c:extract_ss_info() radio in use 0
ofonod[22411]: src/gprs.c:ofono_gprs_status_notify() /gobi_0 status 0
ofonod[22411]: drivers/qmimodem/network-registration.c:get_ss_info_cb()
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info()
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() serving system status 3
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() radio in use 0
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() lac -1 cellid -1 tech -
1
ofonod[22411]: src/network.c:ofono_netreg_status_notify() /gobi_0 status 3 tech -1
ofonod[22411]: src/network.c:current_operator_callback() 0x2708c00, (nil)
ofonod[22411]: src/gprs.c:netreg_status_changed() 3
ofonod[22411]: src/gprs.c:gprs_netreg_update() attach: 0, driver_attached: 0
ofonod[22411]: drivers/qmimodem/network-registration.c:event_notify()
ofonod[22411]: drivers/qmimodem/network-registration.c:event_notify() rat 0 band 0 channel 0
ofonod[22411]: drivers/qmimodem/network-registration.c:event_notify() rat 8 band 145 channel 620
0
ofonod[22411]: drivers/qmimodem/network-registration.c:ss_info_notify()
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info()
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() serving system status 3
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() radio in use 5
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() lac -1 cellid -1 tech 2
ofonod[22411]: src/network.c:ofono_netreg_status_notify() /sierra_1 status 3 tech 2
ofonod[22411]: src/network.c:current_operator_callback() 0x2700940, (nil)
ofonod[22411]: src/gprs.c:netreg_status_changed() 3
ofonod[22411]: src/gprs.c:gprs_netreg_update() attach: 0, driver_attached: 0
ofonod[22411]: drivers/qmimodem/gprs.c:ss_info_notify()
ofonod[22411]: drivers/qmimodem/gprs.c:handle_ss_info()
ofonod[22411]: drivers/qmimodem/gprs.c:extract_ss_info()
ofonod[22411]: drivers/qmimodem/gprs.c:extract_ss_info() radio in use 5
ofonod[22411]: src/gprs.c:ofono_gprs_status_notify() /sierra_1 status 0
ofonod[22411]: drivers/qmimodem/network-registration.c:event_notify()
ofonod[22411]: drivers/qmimodem/network-registration.c:event_notify() rat 0 band 0 channel 0
ofonod[22411]: drivers/qmimodem/network-registration.c:event_notify() rat 5 band 80 channel 6553
5
ofonod[22411]: drivers/qmimodem/network-registration.c:ss_info_notify()
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info()
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() serving system status 3
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() radio in use 5
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() lac -1 cellid -1 tech 2
ofonod[22411]: src/network.c:ofono_netreg_status_notify() /sierra_1 status 3 tech 2
ofonod[22411]: src/network.c:current_operator_callback() 0x2700940, (nil)
ofonod[22411]: src/gprs.c:netreg_status_changed() 3
ofonod[22411]: src/gprs.c:gprs_netreg_update() attach: 0, driver_attached: 0
ofonod[22411]: drivers/qmimodem/gprs.c:ss_info_notify()
ofonod[22411]: drivers/qmimodem/gprs.c:handle_ss_info()
ofonod[22411]: drivers/qmimodem/gprs.c:extract_ss_info()
ofonod[22411]: drivers/qmimodem/gprs.c:extract_ss_info() radio in use 5
ofonod[22411]: src/gprs.c:ofono_gprs_status_notify() /sierra_1 status 0
ofonod[22411]: drivers/qmimodem/network-registration.c:event_notify()
ofonod[22411]: drivers/qmimodem/network-registration.c:event_notify() signal with -83 dBm on 4
ofonod[22411]: drivers/qmimodem/network-registration.c:ss_info_notify()
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info()
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() serving system status 0
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() radio in use 4
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() (901:70)
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() lac -1 cellid -1 tech 0
ofonod[22411]: src/network.c:ofono_netreg_status_notify() /gobi_0 status 0 tech 0
ofonod[22411]: src/network.c:current_operator_callback() 0x2708c00, (nil)
ofonod[22411]: src/gprs.c:netreg_status_changed() 0
ofonod[22411]: src/gprs.c:gprs_netreg_update() attach: 0, driver_attached: 0
ofonod[22411]: drivers/qmimodem/gprs.c:ss_info_notify()
ofonod[22411]: drivers/qmimodem/gprs.c:handle_ss_info()
ofonod[22411]: drivers/qmimodem/gprs.c:extract_ss_info()
ofonod[22411]: drivers/qmimodem/gprs.c:extract_ss_info() radio in use 4
ofonod[22411]: src/gprs.c:ofono_gprs_status_notify() /gobi_0 status 0
ofonod[22411]: drivers/qmimodem/network-registration.c:event_notify()
ofonod[22411]: drivers/qmimodem/network-registration.c:event_notify() rat 4 band 47 channel 868
ofonod[22411]: drivers/qmimodem/network-registration.c:ss_info_notify()
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info()
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() serving system status 1
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() radio in use 4
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() lac 23 cellid 0 tech 0
ofonod[22411]: src/network.c:ofono_netreg_status_notify() /gobi_0 status 1 tech 0
ofonod[22411]: drivers/qmimodem/network-registration.c:qmi_current_operator()
ofonod[22411]: src/network.c:current_operator_callback() 0x2708c00, (nil)
ofonod[22411]: src/gprs.c:netreg_status_changed() 1
ofonod[22411]: src/gprs.c:gprs_netreg_update() attach: 1, driver_attached: 0
ofonod[22411]: drivers/qmimodem/gprs.c:qmi_set_attached() attached 1
ofonod[22411]: drivers/qmimodem/network-registration.c:qmi_signal_strength()
ofonod[22411]: src/gprs.c:netreg_status_changed() 1
ofonod[22411]: src/gprs.c:gprs_netreg_update() attach: 1, driver_attached: 1
ofonod[22411]: drivers/qmimodem/gprs.c:ss_info_notify()
ofonod[22411]: drivers/qmimodem/gprs.c:handle_ss_info()
ofonod[22411]: drivers/qmimodem/gprs.c:extract_ss_info()
ofonod[22411]: drivers/qmimodem/gprs.c:extract_ss_info() radio in use 4
ofonod[22411]: src/gprs.c:ofono_gprs_status_notify() /gobi_0 status 0
ofonod[22411]: drivers/qmimodem/network-registration.c:event_notify()
ofonod[22411]: drivers/qmimodem/network-registration.c:event_notify() rat 4 band 47 channel 868
ofonod[22411]: drivers/qmimodem/gprs.c:attach_detach_cb()
ofonod[22411]: src/gprs.c:gprs_attach_callback() /gobi_0 error = 0
ofonod[22411]: drivers/qmimodem/gprs.c:qmi_attached_status()
ofonod[22411]: drivers/qmimodem/network-registration.c:ss_info_notify()
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info()
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() serving system status 1
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() radio in use 4
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() lac -1 cellid -1 tech 0
ofonod[22411]: src/network.c:ofono_netreg_status_notify() /gobi_0 status 1 tech 0
ofonod[22411]: drivers/qmimodem/network-registration.c:qmi_current_operator()
ofonod[22411]: src/network.c:current_operator_callback() 0x2708c00, 0x2702a90
ofonod[22411]: drivers/qmimodem/network-registration.c:qmi_signal_strength()
ofonod[22411]: src/gprs.c:netreg_status_changed() 1
ofonod[22411]: src/gprs.c:gprs_netreg_update() attach: 1, driver_attached: 1
ofonod[22411]: drivers/qmimodem/gprs.c:ss_info_notify()
ofonod[22411]: drivers/qmimodem/gprs.c:handle_ss_info()
ofonod[22411]: drivers/qmimodem/gprs.c:extract_ss_info()
ofonod[22411]: drivers/qmimodem/gprs.c:extract_ss_info() radio in use 4
ofonod[22411]: src/gprs.c:ofono_gprs_status_notify() /gobi_0 status 0
ofonod[22411]: drivers/qmimodem/network-registration.c:get_rssi_cb()
ofonod[22411]: drivers/qmimodem/network-registration.c:get_rssi_cb() signal with -83 dBm on 4
ofonod[22411]: src/network.c:ofono_netreg_strength_notify() strength 40
ofonod[22411]: drivers/qmimodem/gprs.c:get_ss_info_cb()
ofonod[22411]: drivers/qmimodem/gprs.c:handle_ss_info()
ofonod[22411]: drivers/qmimodem/gprs.c:extract_ss_info()
ofonod[22411]: drivers/qmimodem/gprs.c:extract_ss_info() radio in use 4
ofonod[22411]: src/gprs.c:registration_status_cb() /gobi_0 error 0 status 0
ofonod[22411]: src/gprs.c:ofono_gprs_status_notify() /gobi_0 status 0
ofonod[22411]: drivers/qmimodem/network-registration.c:get_rssi_cb()
ofonod[22411]: drivers/qmimodem/network-registration.c:get_rssi_cb() signal with -83 dBm on 4
ofonod[22411]: src/ussd.c:ussd_initiate() checking if this is a recognized control string
ofonod[22411]: src/ussd.c:recognized_control_string() parsing control string
ofonod[22411]: src/ussd.c:recognized_control_string() Got parse result: 2, 100, , , , ,
ofonod[22411]: src/ussd.c:ussd_initiate() No.., checking if this is a USSD string
ofonod[22411]: src/ussd.c:ussd_initiate() OK, running USSD request
ofonod[22411]: drivers/qmimodem/ussd.c:qmi_ussd_request()
ofonod[22411]: drivers/qmimodem/ussd.c:qmi_ussd_request_cb()
ofonod[22411]: drivers/qmimodem/qmi.c:qmi_result_print_tlvs() tlv: 0x02 len 0x0004
ofonod[22411]: drivers/qmimodem/ussd.c:async_orig_ind()
ofonod[22411]: drivers/qmimodem/ussd.c:async_orig_ind() Failure Cause: 0x0019
ofonod[22411]: src/ussd.c:ofono_ussd_notify() status: 2 TERMINATED, state: 1 ACTIVE
ofonod[22411]: drivers/qmimodem/network-registration.c:ss_info_notify()
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info()
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() serving system status 1
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() radio in use 4
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() lac -1 cellid -1 tech 0
ofonod[22411]: src/network.c:ofono_netreg_status_notify() /gobi_0 status 1 tech 0
ofonod[22411]: drivers/qmimodem/network-registration.c:qmi_current_operator()
ofonod[22411]: src/network.c:current_operator_callback() 0x2708c00, 0x2702a90
ofonod[22411]: drivers/qmimodem/network-registration.c:qmi_signal_strength()
ofonod[22411]: src/gprs.c:netreg_status_changed() 1
ofonod[22411]: src/gprs.c:gprs_netreg_update() attach: 1, driver_attached: 1
ofonod[22411]: drivers/qmimodem/gprs.c:ss_info_notify()
ofonod[22411]: drivers/qmimodem/gprs.c:handle_ss_info()
ofonod[22411]: drivers/qmimodem/gprs.c:extract_ss_info()
ofonod[22411]: drivers/qmimodem/gprs.c:extract_ss_info() radio in use 4
ofonod[22411]: src/gprs.c:ofono_gprs_status_notify() /gobi_0 status 0
ofonod[22411]: drivers/qmimodem/network-registration.c:get_rssi_cb()
ofonod[22411]: drivers/qmimodem/network-registration.c:get_rssi_cb() signal with -83 dBm on 4
ofonod[22411]: drivers/qmimodem/network-registration.c:event_notify()
ofonod[22411]: drivers/qmimodem/network-registration.c:event_notify() signal with -94 dBm on 4
ofonod[22411]: src/network.c:ofono_netreg_strength_notify() strength 20
ofonod[22411]: drivers/qmimodem/network-registration.c:event_notify()
ofonod[22411]: drivers/qmimodem/network-registration.c:event_notify() signal with -109 dBm on 4
ofonod[22411]: src/network.c:ofono_netreg_strength_notify() strength -1
ofonod[22411]: drivers/qmimodem/network-registration.c:event_notify()
ofonod[22411]: drivers/qmimodem/network-registration.c:event_notify() rat 8 band 145 channel 620
0
ofonod[22411]: drivers/qmimodem/network-registration.c:event_notify()
ofonod[22411]: drivers/qmimodem/network-registration.c:event_notify() signal with -104 dBm on 5
ofonod[22411]: drivers/qmimodem/network-registration.c:ss_info_notify()
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info()
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() serving system status 3
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() radio in use 5
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() lac -1 cellid -1 tech 2
ofonod[22411]: src/network.c:ofono_netreg_status_notify() /sierra_2 status 3 tech 2
ofonod[22411]: src/network.c:current_operator_callback() 0x2711e60, (nil)
ofonod[22411]: src/gprs.c:netreg_status_changed() 3
ofonod[22411]: src/gprs.c:gprs_netreg_update() attach: 0, driver_attached: 0
ofonod[22411]: drivers/qmimodem/gprs.c:ss_info_notify()
ofonod[22411]: drivers/qmimodem/gprs.c:handle_ss_info()
ofonod[22411]: drivers/qmimodem/gprs.c:extract_ss_info()
ofonod[22411]: drivers/qmimodem/gprs.c:extract_ss_info() radio in use 5
ofonod[22411]: src/gprs.c:ofono_gprs_status_notify() /sierra_2 status 0
ofonod[22411]: drivers/qmimodem/network-registration.c:event_notify()
ofonod[22411]: drivers/qmimodem/network-registration.c:event_notify() rat 5 band 80 channel 6553
5
ofonod[22411]: drivers/qmimodem/network-registration.c:ss_info_notify()
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info()
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() serving system status 3
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() radio in use 5
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() lac -1 cellid -1 tech 2
ofonod[22411]: src/network.c:ofono_netreg_status_notify() /sierra_2 status 3 tech 2
ofonod[22411]: src/network.c:current_operator_callback() 0x2711e60, (nil)
ofonod[22411]: src/gprs.c:netreg_status_changed() 3
ofonod[22411]: src/gprs.c:gprs_netreg_update() attach: 0, driver_attached: 0
ofonod[22411]: drivers/qmimodem/gprs.c:ss_info_notify()
ofonod[22411]: drivers/qmimodem/gprs.c:handle_ss_info()
ofonod[22411]: drivers/qmimodem/gprs.c:extract_ss_info()
ofonod[22411]: drivers/qmimodem/gprs.c:extract_ss_info() radio in use 5
ofonod[22411]: src/gprs.c:ofono_gprs_status_notify() /sierra_2 status 0
ofonod[22411]: drivers/qmimodem/network-registration.c:event_notify()
ofonod[22411]: drivers/qmimodem/network-registration.c:event_notify() rat 4 band 47 channel 868
ofonod[22411]: drivers/qmimodem/network-registration.c:ss_info_notify()
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info()
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() serving system status 0
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() radio in use 0
ofonod[22411]: drivers/qmimodem/network-registration.c:extract_ss_info() lac -1 cellid -1 tech -
1
ofonod[22411]: src/network.c:ofono_netreg_status_notify() /gobi_0 status 0 tech -1
ofonod[22411]: src/network.c:current_operator_callback() 0x2708c00, 0x2702a90
ofonod[22411]: src/gprs.c:netreg_status_changed() 0
ofonod[22411]: src/gprs.c:gprs_netreg_update() attach: 0, driver_attached: 1
ofonod[22411]: drivers/qmimodem/gprs.c:qmi_set_attached() attached 0
ofonod[22411]: src/gprs.c:netreg_status_changed() 0
ofonod[22411]: src/gprs.c:gprs_netreg_update() attach: 0, driver_attached: 0
ofonod[22411]: drivers/qmimodem/gprs.c:ss_info_notify()
ofonod[22411]: drivers/qmimodem/gprs.c:handle_ss_info()
ofonod[22411]: drivers/qmimodem/gprs.c:extract_ss_info()
ofonod[22411]: drivers/qmimodem/gprs.c:extract_ss_info() radio in use 0
ofonod[22411]: src/gprs.c:ofono_gprs_status_notify() /gobi_0 status 0
ofonod[22411]: drivers/qmimodem/gprs.c:attach_detach_cb()
ofonod[22411]: src/gprs.c:gprs_attach_callback() /gobi_0 error = 0
ofonod[22411]: drivers/qmimodem/gprs.c:qmi_attached_status()
ofonod[22411]: drivers/qmimodem/gprs.c:get_ss_info_cb()
ofonod[22411]: drivers/qmimodem/gprs.c:handle_ss_info()
ofonod[22411]: drivers/qmimodem/gprs.c:extract_ss_info()
ofonod[22411]: drivers/qmimodem/gprs.c:extract_ss_info() radio in use 0
ofonod[22411]: src/gprs.c:registration_status_cb() /gobi_0 error 0 status 0
ofonod[22411]: src/gprs.c:ofono_gprs_status_notify() /gobi_0 status 0
</pre> OsmoGSMTester - Bug #2239: ofono: USSD is not implemented for any modemhttps://osmocom.org/issues/2239?journal_id=42712017-06-13T13:37:16Zlynxis
<ul></ul><p>I would guess, you're not yet connected to any network.<br />Since ofono has only the following codes,<br />I'm not sure which one I should use, if qmi reports an error:</p>
<pre>
/* 3GPP TS 27.007 section 7.15, values for <m> */
enum ofono_ussd_status {
OFONO_USSD_STATUS_NOTIFY = 0,
OFONO_USSD_STATUS_ACTION_REQUIRED = 1,
OFONO_USSD_STATUS_TERMINATED = 2,
OFONO_USSD_STATUS_LOCAL_CLIENT_RESPONDED = 3,
OFONO_USSD_STATUS_NOT_SUPPORTED = 4,
OFONO_USSD_STATUS_TIMED_OUT = 5,
};
</pre> OsmoGSMTester - Bug #2239: ofono: USSD is not implemented for any modemhttps://osmocom.org/issues/2239?journal_id=42732017-06-13T13:55:26Zlynxis
<ul></ul><p>I can see, you're somehow connected to a network.<br />Can you try to send a sms before calling ussd?<br />The failure code 0x19 means QMI_FAILURE_CAUSE_REL_NORMAL. Do you see anything on the pcap on the bts?</p> OsmoGSMTester - Bug #2239: ofono: USSD is not implemented for any modemhttps://osmocom.org/issues/2239?journal_id=43012017-06-16T13:41:15Zpespin
<ul><li><strong>File</strong> <a href="/attachments/2691">ofono.log.txt</a> <a class="icon-only icon-download" title="Download" href="/attachments/download/2691/ofono.log.txt">ofono.log.txt</a> added</li><li><strong>File</strong> <a href="/attachments/2692">log</a> <a class="icon-only icon-download" title="Download" href="/attachments/download/2692/log">log</a> added</li><li><strong>File</strong> <a href="/attachments/2693">pcap-recorder_eth1(filters=_host 10.42.42.2 and port not 22_).pcap</a> <a class="icon-only icon-download" title="Download" href="/attachments/download/2693/pcap-recorder_eth1(filters=_host%2010.42.42.2%20and%20port%20not%2022_).pcap">pcap-recorder_eth1(filters=_host 10.42.42.2 and port not 22_).pcap</a> added</li></ul><p>Sending sms before doesn't help.</p>
<p>I modified the test to loop (while true) until it succeeds 10 times to do the USSD transaction (with failures in between). I attach the log of osmo-gsm-tester, the log of ofono (started + stopped for time scope of this test) + pcap file containing traces of NITB iface + GSMTAP from BTS.</p>
<p>Interestingly, sometimes fails too with another error code inside ofono: QMI_FAILURE_CAUSE_RADIO_LINK_LOST=225 (0xe1)</p> OsmoGSMTester - Bug #2239: ofono: USSD is not implemented for any modemhttps://osmocom.org/issues/2239?journal_id=43022017-06-16T20:49:45Zlynxis
<ul><li><strong>File</strong> <a href="/attachments/2694">colorscheme_supservice</a> <a class="icon-only icon-download" title="Download" href="/attachments/download/2694/colorscheme_supservice">colorscheme_supservice</a> added</li></ul> OsmoGSMTester - Bug #2239: ofono: USSD is not implemented for any modemhttps://osmocom.org/issues/2239?journal_id=43032017-06-16T20:55:10Zlynxis
<ul></ul><p>when you apply the colorscheme (use wireshark: Views -> Coloring Rules -> Import). Some of them have doublicated CM Service Request/Response.</p> OsmoGSMTester - Bug #2239: ofono: USSD is not implemented for any modemhttps://osmocom.org/issues/2239?journal_id=43242017-06-22T15:50:12Zlynxis
<ul></ul><p><a class="user active" href="https://osmocom.org/users/30187">pespin</a>: do you tested the ofono stuff with a minipcie breakout board using usb-bus power? I've noticed problems with the modem if I'm using only the usb-bus powre instead of an external power supply.</p> OsmoGSMTester - Bug #2239: ofono: USSD is not implemented for any modemhttps://osmocom.org/issues/2239?journal_id=43602017-06-27T09:40:16Zpespin
<ul></ul><p>TODO:<br />- Provide again logs, this time running ofonod inside systemd service to have timestamps in there.<br />- Test again the USSD loop test with a sleep(1) and see if it still fails from time to time.</p> OsmoGSMTester - Bug #2239: ofono: USSD is not implemented for any modemhttps://osmocom.org/issues/2239?journal_id=45592017-07-14T09:01:43Zlynxis
<ul><li><strong>Assignee</strong> changed from <i>lynxis</i> to <i>pespin</i></li></ul> OsmoGSMTester - Bug #2239: ofono: USSD is not implemented for any modemhttps://osmocom.org/issues/2239?journal_id=46402017-07-20T10:38:59Zpespin
<ul><li><strong>File</strong> <a href="/attachments/2718">run.2017-07-20_12-01-05.tar.gz</a> <a class="icon-only icon-download" title="Download" href="/attachments/download/2718/run.2017-07-20_12-01-05.tar.gz">run.2017-07-20_12-01-05.tar.gz</a> added</li><li><strong>Assignee</strong> changed from <i>pespin</i> to <i>lynxis</i></li></ul><p>Attached new test, this time running ofonod -d with systemd to have subsecond logging info (retrieved with "journalctl -u ofono -o short-precise").</p>
<p>In run.2017-07-20_12-01-05.tar.gz, you can find:<br />- log: osmo-gsm-tester log with debug enabled. Should give you an idea together with the timestamps on when it fails and when it succeeds.<br />- ofono-log.txt: ofono output from journalctl during the duration of the test.<br />- run.2017-07-20_12-01-05/ussd/assert_extension.py/osmo-nitb_10.42.42.2/pcap/*.pcap: pcap file with all GSMTAP + Abis traffic.</p> OsmoGSMTester - Bug #2239: ofono: USSD is not implemented for any modemhttps://osmocom.org/issues/2239?journal_id=46552017-07-20T21:41:14Zlynxis
<ul><li><strong>Assignee</strong> changed from <i>lynxis</i> to <i>pespin</i></li></ul><p>The logfile tarball is empty.</p> OsmoGSMTester - Bug #2239: ofono: USSD is not implemented for any modemhttps://osmocom.org/issues/2239?journal_id=46562017-07-21T08:49:38Zpespin
<ul><li><strong>File</strong> <a href="/attachments/2719">run.2017-07-21_10-41-02.tar.gz</a> <a class="icon-only icon-download" title="Download" href="/attachments/download/2719/run.2017-07-21_10-41-02.tar.gz">run.2017-07-21_10-41-02.tar.gz</a> added</li><li><strong>Assignee</strong> changed from <i>pespin</i> to <i>lynxis</i></li></ul><p>I guess something went wrong during upload, I remember opening the targz to write about the file contents in the ticket. Unfortunately, I had that file in my tmpfs, so it got lost. I did re-run the test now and I provide a new tar.gz attached here.</p> OsmoGSMTester - Bug #2239: ofono: USSD is not implemented for any modemhttps://osmocom.org/issues/2239?journal_id=47372017-07-27T00:44:27Zlynxis
<ul><li><strong>Assignee</strong> changed from <i>lynxis</i> to <i>pespin</i></li></ul><p>The ussd looks much better now. No failures except at the beginning.<br />So the tester tries to send ussd to early, because of</p>
<pre>
10:41:51.526962 tst /sierra_1: DBG: status: registered [trial↪ussd↪/sierra_1] [ofono_client.py:408]
</pre><br />This is before the network send <strong>Location Updating Accept</strong>.<br />So the problems lies in ofono or the trigger when to start sending ussd.
<p>Looking more into ofono, when exactly the signal <strong>network registered</strong> is created.<br /><pre>
10:41:51.038730 osmo-gsm-tester-rnd ofonod[28097]: src/network.c:ofono_netreg_status_notify() /sierra_1 status 1 tech 0
</pre><br />But this is just after the modem requested the <strong>Location Update Request</strong>.<br />The qmimodem driver direct reports the network status from QMI which doesn't mean CS or PS is attached...</p>
<p>I'm also not sure when ofono should emit the `network registered` state.<br />How should we continue here?</p> OsmoGSMTester - Bug #2239: ofono: USSD is not implemented for any modemhttps://osmocom.org/issues/2239?journal_id=47402017-07-27T08:55:32Zpespin
<ul></ul><blockquote>
<p>The ussd looks much better now. No failures except at the beginning.<br />So the tester tries to send ussd to early, because of</p>
<p>10:41:51.526962 tst /sierra_1: DBG: status: registered [trial↪ussd↪/sierra_1] [ofono_client.py:408]</p>
<p>This is before the network send Location Updating Accept.<br />So the problems lies in ofono or the trigger when to start sending ussd.</p>
<p>Looking more into ofono, when exactly the signal network registered is created.</p>
<p>10:41:51.038730 osmo-gsm-tester-rnd ofonod<sup><a href="#fn28097">28097</a></sup>: src/network.c:ofono_netreg_status_notify() /sierra_1 status 1 tech 0</p>
<p>But this is just after the modem requested the Location Update Request.<br />The qmimodem driver direct reports the network status from QMI which doesn't mean CS or PS is attached...</p>
<p>I'm also not sure when ofono should emit the `network registered` state.<br />How should we continue here?</p>
</blockquote>
<p>Well, from my point of view when using ofono we should not care whether the network already sent us "Location Updating Accept" or not, basically because there's no way to know that from ofono's API and that's probably too low level anyway.</p>
<p>I don't know the protocol specifics, but AFAIK this "Location Update Request/Accept" is done from time to time, so does that mean USSD will fail every time we are in the middle of that process? In that case I guess the code handling the USSD should account for that and sleep until Accept is received or timeout after a while with an error.</p>
<p>Harald, do you have a clearer view on this?</p> OsmoGSMTester - Bug #2239: ofono: USSD is not implemented for any modemhttps://osmocom.org/issues/2239?journal_id=47412017-07-27T12:09:29Zlaforge
<ul></ul><p>On Thu, Jul 27, 2017 at 08:55:32AM +0000, pespin [REDMINE] wrote:</p>
<blockquote>
<p>I don't know the protocol specifics, but AFAIK this "Location Update<br />Request/Accept" is done from time to time, so does that mean USSD will<br />fail every time we are in the middle of that process? In that case I<br />guess the code handling the USSD should account for that and sleep<br />until Accept is received or timeout after a while with an error.</p>
</blockquote>
<p>"not attached" from a GSM protocol level can only happen before the<br />initial Location Update (i.e. an "IMSI Attach" type LU). The state<br />before/during a periodic LU, or a subsequent LU in a new cell is<br />already "attached".</p> OsmoGSMTester - Bug #2239: ofono: USSD is not implemented for any modemhttps://osmocom.org/issues/2239?journal_id=47592017-07-31T14:37:12Zpespin
<ul></ul><p>Is any service available while in "not attached state"? If that's not the case, then I'd suggest sending a patch to ofono which sets the status to "registered" once we successfully received the Location Accept.</p>
<p>Otherwise it may be worth sharing your founding on ofono ML and see if somebody with a better knowledge on ofono API has some strong belief regarding this?</p> OsmoGSMTester - Bug #2239: ofono: USSD is not implemented for any modemhttps://osmocom.org/issues/2239?journal_id=47762017-07-31T20:57:09Zlynxis
<ul></ul><p>I think the question is: Is there an QMI event which is emitted after the modem received the Location Update Accept?     </p>
<p>I'ven't looked yet into it.</p> OsmoGSMTester - Bug #2239: ofono: USSD is not implemented for any modemhttps://osmocom.org/issues/2239?journal_id=47972017-08-02T11:56:43Zpespin
<ul><li><strong>Assignee</strong> changed from <i>pespin</i> to <i>lynxis</i></li></ul><p>For now I pushed to gerrit 2 commits, one adding the USSD support and a a second patch adding a sleep() to workaround the issue now that we know better the failure cause.<br /><a class="external" href="https://gerrit.osmocom.org/#/c/3401/">https://gerrit.osmocom.org/#/c/3401/</a><br /><a class="external" href="https://gerrit.osmocom.org/#/c/3402/">https://gerrit.osmocom.org/#/c/3402/</a></p>
<p>Next steps (assign to lynxis):<br />- Check if we can assert somewhere in ofono/qmi to send status=registered event only after we are attached, or if we are not attached when Supplementaryservices.Init(), then start/wait until we are attached or timeout after a while.<br />- Testing the issue can be done easily reverting the second patch and running the test several times. For testing purposes, it can be changed by using this loop:<br /><pre>
-response = ms.ussd_send(USSD_COMMAND_GET_EXTENSION)
-assert ' ' + ms.msisdn + '\r' in response
+cont = 10
+while cont:
+ try:
+ #log('send sms')
+ #ms.sms_send('123456', 'bla')
+ log('send ussd')
+ response = ms.ussd_send(USSD_COMMAND_GET_EXTENSION)
+ log('success!')
+ assert ' ' + ms.msisdn + '\r' in response
+ cont = cont - 1
+ except Exception as e:
+ print('failed:', repr(e))
</pre></p>
<p>A branch without the sleep() workaround and with that loop can be found in origin branch name "pespin/ussd-test". This way you can use it easily with the run-manual-all jenkins job. For the test suite parameter, you can pass "-s ussd".</p> OsmoGSMTester - Bug #2239: ofono: USSD is not implemented for any modemhttps://osmocom.org/issues/2239?journal_id=51522017-08-23T09:11:34Zpespin
<ul><li><strong>Blocked by</strong> <i><a class="issue tracker-1 status-3 priority-2 priority-default closed" href="/issues/2458">Bug #2458</a>: ofono: status=registered signal sent to ofono users before being attached</i> added</li></ul> OsmoGSMTester - Bug #2239: ofono: USSD is not implemented for any modemhttps://osmocom.org/issues/2239?journal_id=51532017-08-23T09:11:48Zpespin
<ul><li><strong>Status</strong> changed from <i>In Progress</i> to <i>Stalled</i></li></ul> OsmoGSMTester - Bug #2239: ofono: USSD is not implemented for any modemhttps://osmocom.org/issues/2239?journal_id=63152017-11-21T14:24:23Zlynxis
<ul></ul><p>I don't know how this can be done at the moment, because the original problem lies IMHO in the baseband firmware.</p> OsmoGSMTester - Bug #2239: ofono: USSD is not implemented for any modemhttps://osmocom.org/issues/2239?journal_id=81562018-03-11T22:06:17Zlynxis
<ul><li><strong>Status</strong> changed from <i>Stalled</i> to <i>Feedback</i></li><li><strong>Assignee</strong> changed from <i>lynxis</i> to <i>pespin</i></li></ul><p><a class="user active" href="https://osmocom.org/users/30187">pespin</a>: Please close this issue. I don't think I can not do anything here further. If you think otherwise, please explain, what I should do here.</p> OsmoGSMTester - Bug #2239: ofono: USSD is not implemented for any modemhttps://osmocom.org/issues/2239?journal_id=81722018-03-12T09:44:02Zpespin
<ul><li><strong>Status</strong> changed from <i>Feedback</i> to <i>In Progress</i></li><li><strong>% Done</strong> changed from <i>90</i> to <i>100</i></li></ul> OsmoGSMTester - Bug #2239: ofono: USSD is not implemented for any modemhttps://osmocom.org/issues/2239?journal_id=81742018-03-12T10:04:39Zpespin
<ul><li><strong>Status</strong> changed from <i>In Progress</i> to <i>Closed</i></li></ul>