Connecting with Huawei E226

Connecting with Huawei E226

[Thiago Cangussu de Castro Gomes]

[-- Attachment #1: Type: text/plain, Size: 599 bytes --]

Hi all,

I'm trying to connect with a Huawei E226, but I'm getting
different behavior whether I start ofonod with the modem (USB) plugged in or
not:

Scenario 1:

1 - start ofonod
2 - plug the modem
3 - not working

Log: huawei-connected.log (attached)

Scenario 2:

1 - start ofonod
2 - plug the modem
3 - call disable-modem
4 - call enable-modem
5 - it works

Log: huawei-testscripts.log

Scenario 3:

1 - plug the modem
2 - start ofonod
3 - it works

Log file: huawei-not-connected.log

I'm testing with MeeGo, ofono from git and connman 0.57.

thanks,
Thiago

[-- Attachment #2: attachment.html --]
[-- Type: text/html, Size: 990 bytes --]

[-- Warning: decoded text below may be mangled, UTF-8 assumed --]
[-- Attachment #3: huawei-connected.log --]
[-- Type: text/x-log, Size: 15444 bytes --]

ofonod[2309]: oFono version 0.26
ofonod[2309]: src/plugin.c:__ofono_plugin_init() 
ofonod[2309]: src/modem.c:ofono_modem_driver_register() driver: 0x81047c0, name: ste
ofonod[2309]: src/modem.c:ofono_modem_driver_register() driver: 0x8104760, name: palmpre
ofonod[2309]: src/modem.c:ofono_modem_driver_register() driver: 0x8104680, name: hfp
ofonod[2309]: src/modem.c:ofono_modem_driver_register() driver: 0x8104600, name: novatel
ofonod[2309]: src/modem.c:ofono_modem_driver_register() driver: 0x81045a0, name: huawei
ofonod[2309]: src/modem.c:ofono_modem_driver_register() driver: 0x8104540, name: zte
ofonod[2309]: src/modem.c:ofono_modem_driver_register() driver: 0x81044e0, name: hso
ofonod[2309]: src/modem.c:ofono_modem_driver_register() driver: 0x8104480, name: mbm
ofonod[2309]: src/modem.c:ofono_modem_driver_register() driver: 0x8104420, name: calypso
ofonod[2309]: src/modem.c:ofono_modem_driver_register() driver: 0x81043c0, name: wavecom
ofonod[2309]: src/modem.c:ofono_modem_driver_register() driver: 0x8104360, name: g1
ofonod[2309]: src/modem.c:ofono_modem_driver_register() driver: 0x8104300, name: atgen
ofonod[2309]: src/modem.c:ofono_modem_driver_register() driver: 0x81042a0, name: phonesim
ofonod[2309]: src/voicecall.c:ofono_voicecall_driver_register() driver: 0x81041e0, name: stemodem
ofonod[2309]: src/gprs.c:ofono_gprs_context_driver_register() driver: 0x8104244, name: stemodem
ofonod[2309]: src/radio-settings.c:ofono_radio_settings_driver_register() driver: 0x8104228, name: stemodem
ofonod[2309]: src/gprs.c:ofono_gprs_context_driver_register() driver: 0x8104190, name: hsomodem
ofonod[2309]: src/radio-settings.c:ofono_radio_settings_driver_register() driver: 0x81041ac, name: hsomodem
ofonod[2309]: src/gprs.c:ofono_gprs_context_driver_register() driver: 0x8104138, name: mbm
ofonod[2309]: src/stk.c:ofono_stk_driver_register() driver: 0x810415c, name: mbmmodem
ofonod[2309]: src/voicecall.c:ofono_voicecall_driver_register() driver: 0x8104060, name: hfpmodem
ofonod[2309]: src/network.c:ofono_netreg_driver_register() driver: 0x81040c0, name: hfpmodem
ofonod[2309]: src/call-volume.c:ofono_call_volume_driver_register() driver: 0x81040f8, name: hfpmodem
ofonod[2309]: src/voicecall.c:ofono_voicecall_driver_register() driver: 0x8103fe0, name: calypsomodem
ofonod[2309]: src/stk.c:ofono_stk_driver_register() driver: 0x8104028, name: calypsomodem
ofonod[2309]: src/radio-settings.c:ofono_radio_settings_driver_register() driver: 0x8103fa0, name: nwmodem
ofonod[2309]: src/voicecall.c:ofono_voicecall_driver_register() driver: 0x8103e60, name: atmodem
ofonod[2309]: src/modem.c:ofono_devinfo_driver_register() driver: 0x8103f0c, name: atmodem
ofonod[2309]: src/call-barring.c:ofono_call_barring_driver_register() driver: 0x8103eb8, name: atmodem
ofonod[2309]: src/call-forwarding.c:ofono_call_forwarding_driver_register() driver: 0x8103cc0, name: atmodem
ofonod[2309]: src/call-meter.c:ofono_call_meter_driver_register() driver: 0x8103d00, name: atmodem
ofonod[2309]: src/call-settings.c:ofono_call_settings_driver_register() driver: 0x8103be0, name: atmodem
ofonod[2309]: src/phonebook.c:ofono_phonebook_driver_register() driver: 0x8103ed8, name: atmodem
ofonod[2309]: src/ssn.c:ofono_ssn_driver_register() driver: 0x8103f00, name: atmodem
ofonod[2309]: src/ussd.c:ofono_ussd_driver_register() driver: 0x8103e40, name: atmodem
ofonod[2309]: src/sms.c:ofono_sms_driver_register() driver: 0x8103c40, name: atmodem
ofonod[2309]: src/sim.c:ofono_sim_driver_register() driver: 0x8103dc0, name: atmodem
ofonod[2309]: src/stk.c:ofono_stk_driver_register() driver: 0x8103e1c, name: atmodem
ofonod[2309]: src/network.c:ofono_netreg_driver_register() driver: 0x8103d60, name: atmodem
ofonod[2309]: src/cbs.c:ofono_cbs_driver_register() driver: 0x8103ca0, name: atmodem
ofonod[2309]: src/call-volume.c:ofono_call_volume_driver_register() driver: 0x8103f28, name: atmodem
ofonod[2309]: src/gprs.c:ofono_gprs_driver_register() driver: 0x8103f50, name: atmodem
ofonod[2309]: src/gprs.c:ofono_gprs_context_driver_register() driver: 0x8103f74, name: atmodem
ofonod[2309]: src/modem.c:ofono_devinfo_driver_register() driver: 0x81037b4, name: isimodem
ofonod[2309]: src/phonebook.c:ofono_phonebook_driver_register() driver: 0x81037a4, name: isimodem
ofonod[2309]: src/network.c:ofono_netreg_driver_register() driver: 0x81037e0, name: isimodem
ofonod[2309]: src/voicecall.c:ofono_voicecall_driver_register() driver: 0x8103820, name: isimodem
ofonod[2309]: src/sms.c:ofono_sms_driver_register() driver: 0x8103880, name: isimodem
ofonod[2309]: src/cbs.c:ofono_cbs_driver_register() driver: 0x81038a0, name: isimodem
ofonod[2309]: src/sim.c:ofono_sim_driver_register() driver: 0x81038c0, name: isimodem
ofonod[2309]: src/ssn.c:ofono_ssn_driver_register() driver: 0x8103904, name: isimodem
ofonod[2309]: src/ussd.c:ofono_ussd_driver_register() driver: 0x8103910, name: isimodem
ofonod[2309]: src/call-forwarding.c:ofono_call_forwarding_driver_register() driver: 0x8103940, name: isimodem
ofonod[2309]: src/call-settings.c:ofono_call_settings_driver_register() driver: 0x8103960, name: isimodem
ofonod[2309]: src/call-barring.c:ofono_call_barring_driver_register() driver: 0x8103988, name: isimodem
ofonod[2309]: src/call-meter.c:ofono_call_meter_driver_register() driver: 0x81039a0, name: isimodem
ofonod[2309]: src/radio-settings.c:ofono_radio_settings_driver_register() driver: 0x81039c8, name: isimodem
ofonod[2309]: src/gprs.c:ofono_gprs_driver_register() driver: 0x81039dc, name: isimodem
ofonod[2309]: src/gprs.c:ofono_gprs_context_driver_register() driver: 0x81039f0, name: isimodem
ofonod[2309]: src/modem.c:ofono_modem_driver_register() driver: 0x8103780, name: isimodem
ofonod[2309]: src/modem.c:ofono_modem_create() name: (null), type: huawei
ofonod[2309]: src/modem.c:set_modem_property() modem 0x92c7f60 property Path
ofonod[2309]: src/modem.c:set_modem_property() modem 0x92c7f60 property Registered
ofonod[2309]: plugins/udev.c:add_modem() /devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1:1.0/ttyUSB0/tty/ttyUSB0 (huawei)
ofonod[2309]: plugins/udev.c:add_huawei() modem 0x92c7f60
ofonod[2309]: src/modem.c:get_modem_property() modem 0x92c7f60 property ModemRegistered
ofonod[2309]: src/modem.c:get_modem_property() modem 0x92c7f60 property PcuiRegistered
ofonod[2309]: src/modem.c:set_modem_property() modem 0x92c7f60 property Modem
ofonod[2309]: src/modem.c:set_modem_property() modem 0x92c7f60 property ModemRegistered
ofonod[2309]: src/modem.c:get_modem_property() modem 0x92c7f60 property Path
ofonod[2309]: plugins/udev.c:add_modem() /devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1:1.1/ttyUSB1/tty/ttyUSB1 (huawei)
ofonod[2309]: plugins/udev.c:add_huawei() modem 0x92c7f60
ofonod[2309]: src/modem.c:get_modem_property() modem 0x92c7f60 property ModemRegistered
ofonod[2309]: src/modem.c:get_modem_property() modem 0x92c7f60 property PcuiRegistered
ofonod[2309]: src/modem.c:set_modem_property() modem 0x92c7f60 property Pcui
ofonod[2309]: src/modem.c:set_modem_property() modem 0x92c7f60 property PcuiRegistered
ofonod[2309]: plugins/huawei.c:huawei_probe() 0x92c7f60
ofonod[2309]: plugins/bluetooth.c:manager_properties_cb() 
ofonod[2309]: plugins/bluetooth.c:parse_adapters() 
ofonod[2309]: plugins/bluetooth.c:parse_adapters() Calling GetProperties on /org/bluez/1447/hci0
ofonod[2309]: plugins/bluetooth.c:parse_devices() 
ofonod[2309]: plugins/bluetooth.c:adapter_properties_cb() Adapter Address: 00:25:D3:A1:3F:AD, Path: /org/bluez/1447/hci0
ofonod[2309]: plugins/huawei.c:huawei_enable() 0x92c7f60
ofonod[2309]: src/modem.c:get_modem_property() modem 0x92c7f60 property Modem
ofonod[2309]: plugins/huawei.c:open_device() Modem /dev/ttyUSB0
ofonod[2309]: src/modem.c:get_modem_property() modem 0x92c7f60 property Pcui
ofonod[2309]: plugins/huawei.c:open_device() Pcui /dev/ttyUSB1
ofonod[2309]: Pcui:> ATE0\r
ofonod[2309]: Pcui:< \r\nOK\r\n
ofonod[2309]: Pcui:> AT+CFUN=1\r
ofonod[2309]: Pcui:< \r\nOK\r\n
ofonod[2309]: plugins/huawei.c:cfun_enable() 
ofonod[2309]: plugins/huawei.c:huawei_pre_sim() 0x92c7f60
ofonod[2309]: Pcui:> AT^SYSINFO\r
ofonod[2309]: src/sim.c:ofono_sim_add_state_watch() 0x92c2740
ofonod[2309]: src/sim.c:ofono_sim_add_state_watch() 0x92c2740
ofonod[2309]: Pcui:< \r\n^SYSINFO:2,1,0,5,1,,4\r\n\r\nOK\r\n
ofonod[2309]: Pcui:> AT+CGMI\r
ofonod[2309]: Pcui:< \r\nhuawei\r\n\r\nOK\r\n
ofonod[2309]: Pcui:> AT+CRSM=176,28590,0,0,1\r
ofonod[2309]: Pcui:< \r\n+CME ERROR: not found\r\n
ofonod[2309]: Pcui:> AT+CGMM\r
ofonod[2309]: Pcui:< \r\nE226\r\n\r\nOK\r\n
ofonod[2309]: Pcui:> AT+CPIN?\r
ofonod[2309]: Pcui:< \r\n+CPIN: READY\r\n\r\nOK\r\n
ofonod[2309]: drivers/atmodem/sim.c:at_cpin_cb() crsm_pin_cb: READY
ofonod[2309]: Pcui:> AT+CRSM=192,12258\r
ofonod[2309]: Pcui:< \r\n+CRSM: 144,0,""\r\n\r\nOK\r\n
ofonod[2309]: drivers/atmodem/sim.c:at_crsm_info_cb() crsm_info_cb: 90, 00, 0
ofonod[2309]: Pcui:> AT+CGMR\r
ofonod[2309]: Pcui:< \r\n11.310.15.00.150\r\n\r\nOK\r\n
ofonod[2309]: Pcui:> AT+CIMI\r
ofonod[2309]: Pcui:< \r\n724053901216306\r\n\r\nOK\r\n
ofonod[2309]: drivers/atmodem/sim.c:at_cimi_cb() cimi_cb: 724053901216306
ofonod[2309]: Pcui:> AT+CRSM=192,28421\r
ofonod[2309]: Pcui:< \r\n+CRSM: 144,0,""\r\n\r\nOK\r\n
ofonod[2309]: drivers/atmodem/sim.c:at_crsm_info_cb() crsm_info_cb: 90, 00, 0
ofonod[2309]: Pcui:> AT+CGSN\r
ofonod[2309]: Pcui:< \r\n357650019586537\r\n\r\nOK\r\n
ofonod[2309]: Pcui:> AT+CRSM=192,12037\r
ofonod[2309]: Pcui:< \r\n+CRSM: 144,0,""\r\n\r\nOK\r\n
ofonod[2309]: drivers/atmodem/sim.c:at_crsm_info_cb() crsm_info_cb: 90, 00, 0
ofonod[2309]: Pcui:> AT+CRSM=192,28438\r
ofonod[2309]: Pcui:< \r\n+CRSM: 106,130,""\r\n\r\nOK\r\n
ofonod[2309]: plugins/huawei.c:huawei_post_sim() 0x92c7f60
ofonod[2309]: src/modem.c:get_modem_property() modem 0x92c7f60 property HasVoice
ofonod[2309]: Pcui:> AT+CREG=?\r
ofonod[2309]: Pcui:< \r\n+CREG: (0-2)\r\n\r\nOK\r\n
ofonod[2309]: Pcui:> AT+CSMS=?\r
ofonod[2309]: Pcui:< \r\n+CSMS: (0-1)\r\n\r\nOK\r\n
ofonod[2309]: drivers/atmodem/sms.c:at_csms_query_cb() CSMS query parsed successfully
ofonod[2309]: Pcui:> AT+CSCB=?\r
ofonod[2309]: Pcui:< \r\n+CSCB: (0-1)\r\n\r\nOK\r\n
ofonod[2309]: Pcui:> AT+CUSD=1\r
ofonod[2309]: Pcui:< \r\nOK\r\n
ofonod[2309]: Pcui:> AT+CSCS=?\r
ofonod[2309]: Pcui:< \r\n+CSCS: ("IRA","GSM","UCS2")\r\n\r\nOK\r\n
ofonod[2309]: Pcui:> AT+CGDCONT=?\r
ofonod[2309]: Pcui:< \r\n+CGDCONT: (1-16),"IP",,,(0-2),(0-4)\r\n+CGDCONT: (1-16),"PPP",,,(0-2),(0-4)\r\n+CGDCONT: (1-16),"IPV6",,,(0-2),(0-4)\r\n\r\nOK\r\n
ofonod[2309]: Pcui:> AT+CRSM=192,28480\r
ofonod[2309]: Pcui:< \r\n+CRSM: 144,0,""\r\n\r\nOK\r\n
ofonod[2309]: drivers/atmodem/sim.c:at_crsm_info_cb() crsm_info_cb: 90, 00, 0
ofonod[2309]: Pcui:> AT+CREG=2\r
ofonod[2309]: Pcui:< \r\nOK\r\n
ofonod[2309]: Pcui:> AT+CSMS=1\r
ofonod[2309]: Pcui:< \r\n+CSMS: 1,1,1\r\n\r\nOK\r\n
ofonod[2309]: Pcui:> AT+CSCB=1,"0-65535"\r
ofonod[2309]: Pcui:< \r\nOK\r\n
ofonod[2309]: src/cbs.c:cbs_got_imsi() Got IMSI: 724053901216306
ofonod[2309]: src/network.c:__ofono_netreg_add_status_watch() 0x92c7ba8
ofonod[2309]: Pcui:> AT+CPBS=?\r
ofonod[2309]: Pcui:< \r\n+CPBS: ("SM","DC","FD","LD","MC","ME","RC","EN","ON")\r\n\r\nOK\r\n
ofonod[2309]: Pcui:> AT+CGREG=?\r
ofonod[2309]: Pcui:< \r\n+CGREG: (0-2)\r\n\r\nOK\r\n
ofonod[2309]: Pcui:> AT+CRSM=192,28589\r
ofonod[2309]: Pcui:< \r\n+CRSM: 144,0,""\r\n\r\nOK\r\n
ofonod[2309]: drivers/atmodem/sim.c:at_crsm_info_cb() crsm_info_cb: 90, 00, 0
ofonod[2309]: Pcui:> AT+CREG?\r
ofonod[2309]: Pcui:< \r\n+CREG: 2,1,754F,830452\r\n\r\nOK\r\n
ofonod[2309]: src/cbs.c:cbs_location_changed() 1, 30031, 8586322, -1, (null)(null)
ofonod[2309]: Pcui:> AT+CSMS?\r
ofonod[2309]: Pcui:< \r\n+CSMS: ,1,1,1\r\n\r\nOK\r\n
ofonod[2309]: Pcui:> AT+CGREG=2\r
ofonod[2309]: Pcui:< \r\nOK\r\n
ofonod[2309]: Pcui:> AT+CGAUTO=0\r
ofonod[2309]: Pcui:< \r\nCOMMAND NOT SUPPORT\r\n
ofonod[2309]: Pcui:> AT+CGEREP=2,1\r
ofonod[2309]: Pcui:< \r\nOK\r\n
ofonod[2309]: src/network.c:__ofono_netreg_add_status_watch() 0x92c7ba8
ofonod[2309]: Pcui:> AT+CRSM=192,28489\r
ofonod[2309]: Pcui:< \r\n+CRSM: 144,0,""\r\n\r\nOK\r\n
ofonod[2309]: drivers/atmodem/sim.c:at_crsm_info_cb() crsm_info_cb: 90, 00, 0
ofonod[2309]: Pcui:> AT+COPS=3,2\r
ofonod[2309]: Pcui:< \r\nOK\r\n
ofonod[2309]: Pcui:> AT+COPS?\r
ofonod[2309]: Pcui:< \r\n+COPS: 0,2,"72405",2\r\n\r\nOK\r\n
ofonod[2309]: drivers/atmodem/network-registration.c:cops_numeric_cb() Cops numeric got mcc: 724, mnc: 05
ofonod[2309]: Pcui:> AT+CSQ\r
ofonod[2309]: Pcui:< \r\n+CSQ: 22,99\r\n\r\nOK\r\n
ofonod[2309]: drivers/atmodem/network-registration.c:csq_cb() csq_cb: 22
ofonod[2309]: Pcui:> AT+CMGF=?\r
ofonod[2309]: Pcui:< \r\n+CMGF: (0-1)\r\n\r\nOK\r\n
ofonod[2309]: Pcui:> AT+CGATT=1\r
ofonod[2309]: Pcui:< \r\n+CREG: 1,754F,830452\r\n\r\n+CGREG: 1,754F,830452\r\n
ofonod[2309]: src/gprs.c:netreg_status_changed() 1
ofonod[2309]: src/cbs.c:cbs_location_changed() 1, 30031, 8586322, -1, (null)(null)
ofonod[2309]: Pcui:< \r\nOK\r\n
ofonod[2309]: Pcui:> AT+CRSM=192,28613\r
ofonod[2309]: Pcui:< \r\n+CRSM: 144,0,""\r\n\r\nOK\r\n
ofonod[2309]: drivers/atmodem/sim.c:at_crsm_info_cb() crsm_info_cb: 90, 00, 0
ofonod[2309]: Pcui:> AT+COPS=3,0\r
ofonod[2309]: Pcui:< \r\nOK\r\n
ofonod[2309]: Pcui:> AT+COPS?\r
ofonod[2309]: Pcui:< \r\n+COPS: 0,0,"CLARO BR",2\r\n\r\nOK\r\n
ofonod[2309]: drivers/atmodem/network-registration.c:cops_cb() cops_cb: CLARO BR, 724 05 2
ofonod[2309]: src/network.c:current_operator_callback() 0x92c7ba8, (nil)
ofonod[2309]: src/gprs.c:netreg_status_changed() 1
ofonod[2309]: src/cbs.c:cbs_location_changed() 1, 30031, 8586322, -1, 72405
ofonod[2309]: src/cbs.c:cbs_location_changed() 1, 0, 0
ofonod[2309]: Pcui:> AT+CPMS=?\r
ofonod[2309]: Pcui:< \r\n+CPMS: ("ME","MT","SM","SR"),("ME","MT","SM","SR"),("ME","MT","SM","SR")\r\n\r\nOK\r\n
ofonod[2309]: Pcui:> AT+COPS=3,2\r
ofonod[2309]: Pcui:< \r\nOK\r\n
ofonod[2309]: Pcui:> AT+COPS?\r
ofonod[2309]: Pcui:< \r\n+COPS: 0,2,"72405",2\r\n\r\nOK\r\n
ofonod[2309]: drivers/atmodem/network-registration.c:cops_numeric_cb() Cops numeric got mcc: 724, mnc: 05
ofonod[2309]: Pcui:> AT+CGREG?\r
ofonod[2309]: Pcui:< \r\n+CGREG: 2,1,754F,830452\r\n\r\nOK\r\n
ofonod[2309]: Pcui:> AT+CRSM=192,28486\r
ofonod[2309]: Pcui:< \r\n+CRSM: 144,0,""\r\n\r\nOK\r\n
ofonod[2309]: drivers/atmodem/sim.c:at_crsm_info_cb() crsm_info_cb: 90, 00, 0
ofonod[2309]: Pcui:> AT+CMGF=0\r
ofonod[2309]: Pcui:< \r\nOK\r\n
ofonod[2309]: Pcui:> AT+COPS=3,0\r
ofonod[2309]: Pcui:< \r\nOK\r\n
ofonod[2309]: Pcui:> AT+COPS?\r
ofonod[2309]: Pcui:< \r\n+COPS: 0,0,"CLARO BR",2\r\n\r\nOK\r\n
ofonod[2309]: drivers/atmodem/network-registration.c:cops_cb() cops_cb: CLARO BR, 724 05 2
ofonod[2309]: src/network.c:current_operator_callback() 0x92c7ba8, 0x92c89e8
ofonod[2309]: Pcui:> AT+CRSM=192,28488\r
ofonod[2309]: Pcui:< \r\n+CRSM: 144,0,""\r\n\r\nOK\r\n
ofonod[2309]: drivers/atmodem/sim.c:at_crsm_info_cb() crsm_info_cb: 90, 00, 0
ofonod[2309]: Pcui:> AT+CPMS="ME","ME","ME"\r
ofonod[2309]: Pcui:< \r\n+CPMS: 0,255,0,255,0,255\r\n\r\nOK\r\n
ofonod[2309]: Pcui:> AT+CSCB=1\r
ofonod[2309]: Pcui:< \r\nOK\r\n
ofonod[2309]: Pcui:> AT+CSCB=0,"4352-4356"\r
ofonod[2309]: Pcui:< \r\nOK\r\n
ofonod[2309]: Pcui:> AT+CNMI=?\r
ofonod[2309]: Pcui:< \r\n+CNMI: (0,1,2),(0,1,2,3),(0,2),(0,1,2),(0,1)\r\n\r\nOK\r\n
ofonod[2309]: Pcui:> AT+CNMI=1,1,2,1,0\r
ofonod[2309]: Pcui:< \r\nOK\r\n
ofonod[2309]: Pcui:> AT+CMGL=4\r
ofonod[2309]: Pcui:< \r\nOK\r\n
ofonod[2309]: Pcui:> AT+CGSMS=3\r
ofonod[2309]: Pcui:< \r\nOK\r\n
ofonod[2309]: Pcui:< \r\n^BOOT:19586537,0,0,0,63\r\n

[-- Warning: decoded text below may be mangled, UTF-8 assumed --]
[-- Attachment #4: huawei-testscripts.log --]
[-- Type: text/x-log, Size: 17212 bytes --]

ofonod[2367]: oFono version 0.26
ofonod[2367]: src/plugin.c:__ofono_plugin_init() 
ofonod[2367]: src/modem.c:ofono_modem_driver_register() driver: 0x81047c0, name: ste
ofonod[2367]: src/modem.c:ofono_modem_driver_register() driver: 0x8104760, name: palmpre
ofonod[2367]: src/modem.c:ofono_modem_driver_register() driver: 0x8104680, name: hfp
ofonod[2367]: src/modem.c:ofono_modem_driver_register() driver: 0x8104600, name: novatel
ofonod[2367]: src/modem.c:ofono_modem_driver_register() driver: 0x81045a0, name: huawei
ofonod[2367]: src/modem.c:ofono_modem_driver_register() driver: 0x8104540, name: zte
ofonod[2367]: src/modem.c:ofono_modem_driver_register() driver: 0x81044e0, name: hso
ofonod[2367]: src/modem.c:ofono_modem_driver_register() driver: 0x8104480, name: mbm
ofonod[2367]: src/modem.c:ofono_modem_driver_register() driver: 0x8104420, name: calypso
ofonod[2367]: src/modem.c:ofono_modem_driver_register() driver: 0x81043c0, name: wavecom
ofonod[2367]: src/modem.c:ofono_modem_driver_register() driver: 0x8104360, name: g1
ofonod[2367]: src/modem.c:ofono_modem_driver_register() driver: 0x8104300, name: atgen
ofonod[2367]: src/modem.c:ofono_modem_driver_register() driver: 0x81042a0, name: phonesim
ofonod[2367]: src/voicecall.c:ofono_voicecall_driver_register() driver: 0x81041e0, name: stemodem
ofonod[2367]: src/gprs.c:ofono_gprs_context_driver_register() driver: 0x8104244, name: stemodem
ofonod[2367]: src/radio-settings.c:ofono_radio_settings_driver_register() driver: 0x8104228, name: stemodem
ofonod[2367]: src/gprs.c:ofono_gprs_context_driver_register() driver: 0x8104190, name: hsomodem
ofonod[2367]: src/radio-settings.c:ofono_radio_settings_driver_register() driver: 0x81041ac, name: hsomodem
ofonod[2367]: src/gprs.c:ofono_gprs_context_driver_register() driver: 0x8104138, name: mbm
ofonod[2367]: src/stk.c:ofono_stk_driver_register() driver: 0x810415c, name: mbmmodem
ofonod[2367]: src/voicecall.c:ofono_voicecall_driver_register() driver: 0x8104060, name: hfpmodem
ofonod[2367]: src/network.c:ofono_netreg_driver_register() driver: 0x81040c0, name: hfpmodem
ofonod[2367]: src/call-volume.c:ofono_call_volume_driver_register() driver: 0x81040f8, name: hfpmodem
ofonod[2367]: src/voicecall.c:ofono_voicecall_driver_register() driver: 0x8103fe0, name: calypsomodem
ofonod[2367]: src/stk.c:ofono_stk_driver_register() driver: 0x8104028, name: calypsomodem
ofonod[2367]: src/radio-settings.c:ofono_radio_settings_driver_register() driver: 0x8103fa0, name: nwmodem
ofonod[2367]: src/voicecall.c:ofono_voicecall_driver_register() driver: 0x8103e60, name: atmodem
ofonod[2367]: src/modem.c:ofono_devinfo_driver_register() driver: 0x8103f0c, name: atmodem
ofonod[2367]: src/call-barring.c:ofono_call_barring_driver_register() driver: 0x8103eb8, name: atmodem
ofonod[2367]: src/call-forwarding.c:ofono_call_forwarding_driver_register() driver: 0x8103cc0, name: atmodem
ofonod[2367]: src/call-meter.c:ofono_call_meter_driver_register() driver: 0x8103d00, name: atmodem
ofonod[2367]: src/call-settings.c:ofono_call_settings_driver_register() driver: 0x8103be0, name: atmodem
ofonod[2367]: src/phonebook.c:ofono_phonebook_driver_register() driver: 0x8103ed8, name: atmodem
ofonod[2367]: src/ssn.c:ofono_ssn_driver_register() driver: 0x8103f00, name: atmodem
ofonod[2367]: src/ussd.c:ofono_ussd_driver_register() driver: 0x8103e40, name: atmodem
ofonod[2367]: src/sms.c:ofono_sms_driver_register() driver: 0x8103c40, name: atmodem
ofonod[2367]: src/sim.c:ofono_sim_driver_register() driver: 0x8103dc0, name: atmodem
ofonod[2367]: src/stk.c:ofono_stk_driver_register() driver: 0x8103e1c, name: atmodem
ofonod[2367]: src/network.c:ofono_netreg_driver_register() driver: 0x8103d60, name: atmodem
ofonod[2367]: src/cbs.c:ofono_cbs_driver_register() driver: 0x8103ca0, name: atmodem
ofonod[2367]: src/call-volume.c:ofono_call_volume_driver_register() driver: 0x8103f28, name: atmodem
ofonod[2367]: src/gprs.c:ofono_gprs_driver_register() driver: 0x8103f50, name: atmodem
ofonod[2367]: src/gprs.c:ofono_gprs_context_driver_register() driver: 0x8103f74, name: atmodem
ofonod[2367]: src/modem.c:ofono_devinfo_driver_register() driver: 0x81037b4, name: isimodem
ofonod[2367]: src/phonebook.c:ofono_phonebook_driver_register() driver: 0x81037a4, name: isimodem
ofonod[2367]: src/network.c:ofono_netreg_driver_register() driver: 0x81037e0, name: isimodem
ofonod[2367]: src/voicecall.c:ofono_voicecall_driver_register() driver: 0x8103820, name: isimodem
ofonod[2367]: src/sms.c:ofono_sms_driver_register() driver: 0x8103880, name: isimodem
ofonod[2367]: src/cbs.c:ofono_cbs_driver_register() driver: 0x81038a0, name: isimodem
ofonod[2367]: src/sim.c:ofono_sim_driver_register() driver: 0x81038c0, name: isimodem
ofonod[2367]: src/ssn.c:ofono_ssn_driver_register() driver: 0x8103904, name: isimodem
ofonod[2367]: src/ussd.c:ofono_ussd_driver_register() driver: 0x8103910, name: isimodem
ofonod[2367]: src/call-forwarding.c:ofono_call_forwarding_driver_register() driver: 0x8103940, name: isimodem
ofonod[2367]: src/call-settings.c:ofono_call_settings_driver_register() driver: 0x8103960, name: isimodem
ofonod[2367]: src/call-barring.c:ofono_call_barring_driver_register() driver: 0x8103988, name: isimodem
ofonod[2367]: src/call-meter.c:ofono_call_meter_driver_register() driver: 0x81039a0, name: isimodem
ofonod[2367]: src/radio-settings.c:ofono_radio_settings_driver_register() driver: 0x81039c8, name: isimodem
ofonod[2367]: src/gprs.c:ofono_gprs_driver_register() driver: 0x81039dc, name: isimodem
ofonod[2367]: src/gprs.c:ofono_gprs_context_driver_register() driver: 0x81039f0, name: isimodem
ofonod[2367]: src/modem.c:ofono_modem_driver_register() driver: 0x8103780, name: isimodem
ofonod[2367]: plugins/bluetooth.c:manager_properties_cb() 
ofonod[2367]: plugins/bluetooth.c:parse_adapters() 
ofonod[2367]: plugins/bluetooth.c:parse_adapters() Calling GetProperties on /org/bluez/1447/hci0
ofonod[2367]: plugins/bluetooth.c:parse_devices() 
ofonod[2367]: plugins/bluetooth.c:adapter_properties_cb() Adapter Address: 00:25:D3:A1:3F:AD, Path: /org/bluez/1447/hci0
ofonod[2367]: src/modem.c:ofono_modem_create() name: (null), type: huawei
ofonod[2367]: src/modem.c:set_modem_property() modem 0x9ff42b8 property Path
ofonod[2367]: src/modem.c:set_modem_property() modem 0x9ff42b8 property Registered
ofonod[2367]: plugins/udev.c:add_modem() /devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1:1.1/ttyUSB1/tty/ttyUSB1 (huawei)
ofonod[2367]: plugins/udev.c:add_huawei() modem 0x9ff42b8
ofonod[2367]: src/modem.c:get_modem_property() modem 0x9ff42b8 property ModemRegistered
ofonod[2367]: src/modem.c:get_modem_property() modem 0x9ff42b8 property PcuiRegistered
ofonod[2367]: src/modem.c:set_modem_property() modem 0x9ff42b8 property Pcui
ofonod[2367]: src/modem.c:set_modem_property() modem 0x9ff42b8 property PcuiRegistered
ofonod[2367]: src/modem.c:get_modem_property() modem 0x9ff42b8 property Path
ofonod[2367]: plugins/udev.c:add_modem() /devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1:1.0/ttyUSB0/tty/ttyUSB0 (huawei)
ofonod[2367]: plugins/udev.c:add_huawei() modem 0x9ff42b8
ofonod[2367]: src/modem.c:get_modem_property() modem 0x9ff42b8 property ModemRegistered
ofonod[2367]: src/modem.c:get_modem_property() modem 0x9ff42b8 property PcuiRegistered
ofonod[2367]: src/modem.c:set_modem_property() modem 0x9ff42b8 property Modem
ofonod[2367]: src/modem.c:set_modem_property() modem 0x9ff42b8 property ModemRegistered
ofonod[2367]: plugins/huawei.c:huawei_probe() 0x9ff42b8
ofonod[2367]: plugins/huawei.c:huawei_enable() 0x9ff42b8
ofonod[2367]: src/modem.c:get_modem_property() modem 0x9ff42b8 property Modem
ofonod[2367]: plugins/huawei.c:open_device() Modem /dev/ttyUSB0
ofonod[2367]: src/modem.c:get_modem_property() modem 0x9ff42b8 property Pcui
ofonod[2367]: plugins/huawei.c:open_device() Pcui /dev/ttyUSB1
ofonod[2367]: Pcui:> ATE0\r
ofonod[2367]: Pcui:< ATE0\r\r\nOK\r\n
ofonod[2367]: Pcui:> AT+CFUN=1\r
ofonod[2367]: Pcui:< \r\nOK\r\n
ofonod[2367]: plugins/huawei.c:cfun_enable() 
ofonod[2367]: plugins/huawei.c:huawei_pre_sim() 0x9ff42b8
ofonod[2367]: Pcui:> AT^SYSINFO\r
ofonod[2367]: src/sim.c:ofono_sim_add_state_watch() 0x9ff4450
ofonod[2367]: src/sim.c:ofono_sim_add_state_watch() 0x9ff4450
ofonod[2367]: Pcui:< \r\n^SYSINFO:1,0,1,5,255,,4\r\n\r\nOK\r\n
ofonod[2367]: Pcui:> AT+CGMI\r
ofonod[2367]: Pcui:< \r\nhuawei\r\n\r\nOK\r\n
ofonod[2367]: Pcui:> AT+CGMM\r
ofonod[2367]: Pcui:< \r\nE226\r\n\r\nOK\r\n
ofonod[2367]: Pcui:> AT+CGMR\r
ofonod[2367]: Pcui:< \r\n11.310.15.00.150\r\n\r\nOK\r\n
ofonod[2367]: Pcui:> AT+CGSN\r
ofonod[2367]: Pcui:< \r\n357650019586537\r\n\r\nOK\r\n
ofonod[2367]: Pcui:< \r\n^RSSI:17\r\n
ofonod[2367]: src/sim.c:sim_remove() atom: 0x9ff44d8
ofonod[2367]: src/modem.c:devinfo_remove() atom: 0xa006840
ofonod[2367]: plugins/huawei.c:huawei_disable() 0x9ff42b8
ofonod[2367]: Pcui:> AT+CFUN=0\r
ofonod[2367]: Pcui:< \r\nOK\r\n
ofonod[2367]: plugins/huawei.c:cfun_disable() 
ofonod[2367]: plugins/huawei.c:huawei_enable() 0x9ff42b8
ofonod[2367]: src/modem.c:get_modem_property() modem 0x9ff42b8 property Modem
ofonod[2367]: plugins/huawei.c:open_device() Modem /dev/ttyUSB0
ofonod[2367]: src/modem.c:get_modem_property() modem 0x9ff42b8 property Pcui
ofonod[2367]: plugins/huawei.c:open_device() Pcui /dev/ttyUSB1
ofonod[2367]: Pcui:> ATE0\r
ofonod[2367]: Pcui:< \r\nOK\r\n
ofonod[2367]: Pcui:> AT+CFUN=1\r
ofonod[2367]: Pcui:< \r\nOK\r\n
ofonod[2367]: plugins/huawei.c:cfun_enable() 
ofonod[2367]: plugins/huawei.c:huawei_pre_sim() 0x9ff42b8
ofonod[2367]: Pcui:> AT^SYSINFO\r
ofonod[2367]: src/sim.c:ofono_sim_add_state_watch() 0x9feebf8
ofonod[2367]: src/sim.c:ofono_sim_add_state_watch() 0x9feebf8
ofonod[2367]: Pcui:< \r\n^SYSINFO:0,1,0,0,1,,0\r\n\r\nOK\r\n
ofonod[2367]: Pcui:> AT+CGMI\r
ofonod[2367]: Pcui:< \r\nhuawei\r\n\r\nOK\r\n
ofonod[2367]: Pcui:> AT+CRSM=176,28590,0,0,1\r
ofonod[2367]: Pcui:< \r\n+CME ERROR: not found\r\n
ofonod[2367]: Pcui:> AT+CGMM\r
ofonod[2367]: Pcui:< \r\nE226\r\n\r\nOK\r\n
ofonod[2367]: Pcui:> AT+CPIN?\r
ofonod[2367]: Pcui:< \r\n+CPIN: READY\r\n\r\nOK\r\n
ofonod[2367]: drivers/atmodem/sim.c:at_cpin_cb() crsm_pin_cb: READY
ofonod[2367]: Pcui:> AT+CRSM=192,12258\r
ofonod[2367]: Pcui:< \r\n+CRSM: 144,0,""\r\n\r\nOK\r\n
ofonod[2367]: drivers/atmodem/sim.c:at_crsm_info_cb() crsm_info_cb: 90, 00, 0
ofonod[2367]: Pcui:> AT+CGMR\r
ofonod[2367]: Pcui:< \r\n11.310.15.00.150\r\n\r\nOK\r\n
ofonod[2367]: Pcui:> AT+CIMI\r
ofonod[2367]: Pcui:< \r\n724053901216306\r\n\r\nOK\r\n
ofonod[2367]: drivers/atmodem/sim.c:at_cimi_cb() cimi_cb: 724053901216306
ofonod[2367]: Pcui:> AT+CRSM=192,28421\r
ofonod[2367]: Pcui:< \r\n^SRVST:1\r\n
ofonod[2367]: Pcui:< \r\n+CRSM: 144,0,""\r\n\r\nOK\r\n
ofonod[2367]: drivers/atmodem/sim.c:at_crsm_info_cb() crsm_info_cb: 90, 00, 0
ofonod[2367]: Pcui:> AT+CGSN\r
ofonod[2367]: Pcui:< \r\n357650019586537\r\n\r\nOK\r\n
ofonod[2367]: Pcui:> AT+CRSM=192,12037\r
ofonod[2367]: Pcui:< \r\n+CRSM: 144,0,""\r\n\r\nOK\r\n
ofonod[2367]: drivers/atmodem/sim.c:at_crsm_info_cb() crsm_info_cb: 90, 00, 0
ofonod[2367]: Pcui:> AT+CRSM=192,28438\r
ofonod[2367]: Pcui:< \r\n+CRSM: 106,130,""\r\n\r\nOK\r\n
ofonod[2367]: plugins/huawei.c:huawei_post_sim() 0x9ff42b8
ofonod[2367]: src/modem.c:get_modem_property() modem 0x9ff42b8 property HasVoice
ofonod[2367]: Pcui:> AT+CREG=?\r
ofonod[2367]: Pcui:< \r\n+CREG: (0-2)\r\n\r\nOK\r\n
ofonod[2367]: Pcui:> AT+CSMS=?\r
ofonod[2367]: Pcui:< \r\n+CSMS: (0-1)\r\n\r\nOK\r\n
ofonod[2367]: drivers/atmodem/sms.c:at_csms_query_cb() CSMS query parsed successfully
ofonod[2367]: Pcui:> AT+CSCB=?\r
ofonod[2367]: Pcui:< \r\n+CSCB: (0-1)\r\n\r\nOK\r\n
ofonod[2367]: Pcui:> AT+CUSD=1\r
ofonod[2367]: Pcui:< \r\nOK\r\n
ofonod[2367]: Pcui:> AT+CSCS=?\r
ofonod[2367]: Pcui:< \r\n+CSCS: ("IRA","GSM","UCS2")\r\n\r\nOK\r\n
ofonod[2367]: Pcui:> AT+CGDCONT=?\r
ofonod[2367]: Pcui:< \r\n+CGDCONT: (1-16),"IP",,,(0-2),(0-4)\r\n+CGDCONT: (1-16),"PPP",,,(0-2),(0-4)\r\n+CGDCONT: (1-16),"IPV6",,,(0-2),(0-4)\r\n\r\nOK\r\n
ofonod[2367]: Pcui:> AT+CRSM=192,28480\r
ofonod[2367]: Pcui:< \r\n^SRVST:1\r\n
ofonod[2367]: Pcui:< \r\n+CRSM: 144,0,""\r\n\r\nOK\r\n
ofonod[2367]: drivers/atmodem/sim.c:at_crsm_info_cb() crsm_info_cb: 90, 00, 0
ofonod[2367]: Pcui:> AT+CREG=2\r
ofonod[2367]: Pcui:< \r\nOK\r\n
ofonod[2367]: Pcui:> AT+CSMS=1\r
ofonod[2367]: Pcui:< \r\n+CSMS: 1,1,1\r\n\r\nOK\r\n
ofonod[2367]: Pcui:> AT+CSCB=1,"0-65535"\r
ofonod[2367]: Pcui:< \r\nOK\r\n
ofonod[2367]: src/cbs.c:cbs_got_imsi() Got IMSI: 724053901216306
ofonod[2367]: src/network.c:__ofono_netreg_add_status_watch() 0x9ff43a0
ofonod[2367]: Pcui:> AT+CPBS=?\r
ofonod[2367]: Pcui:< \r\n+CME ERROR: SIM busy\r\n
ofonod[2367]: Phonebook not supported by this modem.  If this is in error please submit patches to support this hardware
ofonod[2367]: src/phonebook.c:phonebook_remove() atom: 0x9ff49e0
ofonod[2367]: Pcui:> AT+CGREG=?\r
ofonod[2367]: Pcui:< \r\n+CGREG: (0-2)\r\n\r\nOK\r\n
ofonod[2367]: Pcui:> AT+CRSM=192,28589\r
ofonod[2367]: Pcui:< \r\n+CRSM: 144,0,""\r\n\r\nOK\r\n
ofonod[2367]: drivers/atmodem/sim.c:at_crsm_info_cb() crsm_info_cb: 90, 00, 0
ofonod[2367]: Pcui:> AT+CREG?\r
ofonod[2367]: Pcui:< \r\n+CREG: 2,2,754F,830452\r\n\r\nOK\r\n
ofonod[2367]: src/network.c:current_operator_callback() 0x9ff43a0, (nil)
ofonod[2367]: src/cbs.c:cbs_location_changed() 2, -1, -1, -1, (null)(null)
ofonod[2367]: Pcui:> AT+CSMS?\r
ofonod[2367]: Pcui:< \r\n+CSMS: ,1,1,1\r\n\r\nOK\r\n
ofonod[2367]: Pcui:> AT+CGREG=2\r
ofonod[2367]: Pcui:< \r\nOK\r\n
ofonod[2367]: Pcui:> AT+CGAUTO=0\r
ofonod[2367]: Pcui:< \r\nCOMMAND NOT SUPPORT\r\n
ofonod[2367]: Pcui:> AT+CGEREP=2,1\r
ofonod[2367]: Pcui:< \r\nOK\r\n
ofonod[2367]: src/network.c:__ofono_netreg_add_status_watch() 0x9ff43a0
ofonod[2367]: Pcui:> AT+CRSM=192,28489\r
ofonod[2367]: Pcui:< \r\n+CRSM: 144,0,""\r\n\r\nOK\r\n
ofonod[2367]: drivers/atmodem/sim.c:at_crsm_info_cb() crsm_info_cb: 90, 00, 0
ofonod[2367]: Pcui:> AT+CMGF=?\r
ofonod[2367]: Pcui:< \r\n+CMGF: (0-1)\r\n\r\nOK\r\n
ofonod[2367]: Pcui:> AT+CRSM=192,28613\r
ofonod[2367]: Pcui:< \r\n+CRSM: 144,0,""\r\n\r\nOK\r\n
ofonod[2367]: drivers/atmodem/sim.c:at_crsm_info_cb() crsm_info_cb: 90, 00, 0
ofonod[2367]: Pcui:> AT+CPMS=?\r
ofonod[2367]: Pcui:< \r\n+CPMS: ("ME","MT","SM","SR"),("ME","MT","SM","SR"),("ME","MT","SM","SR")\r\n\r\nOK\r\n
ofonod[2367]: Pcui:> AT+CRSM=192,28486\r
ofonod[2367]: Pcui:< \r\n+CRSM: 144,0,""\r\n\r\nOK\r\n
ofonod[2367]: drivers/atmodem/sim.c:at_crsm_info_cb() crsm_info_cb: 90, 00, 0
ofonod[2367]: Pcui:> AT+CMGF=0\r
ofonod[2367]: Pcui:< \r\nOK\r\n
ofonod[2367]: Pcui:> AT+CRSM=192,28488\r
ofonod[2367]: Pcui:< \r\n+CRSM: 144,0,""\r\n\r\nOK\r\n
ofonod[2367]: drivers/atmodem/sim.c:at_crsm_info_cb() crsm_info_cb: 90, 00, 0
ofonod[2367]: Pcui:> AT+CPMS="ME","ME","ME"\r
ofonod[2367]: Pcui:< \r\n+CPMS: 0,255,0,255,0,255\r\n\r\nOK\r\n
ofonod[2367]: Pcui:> AT+CSCB=1\r
ofonod[2367]: Pcui:< \r\nOK\r\n
ofonod[2367]: Pcui:> AT+CSCB=0,"4352-4356"\r
ofonod[2367]: Pcui:< \r\nOK\r\n
ofonod[2367]: Pcui:> AT+CNMI=?\r
ofonod[2367]: Pcui:< \r\n+CNMI: (0,1,2),(0,1,2,3),(0,2),(0,1,2),(0,1)\r\n\r\nOK\r\n
ofonod[2367]: Pcui:> AT+CNMI=1,1,2,1,0\r
ofonod[2367]: Pcui:< \r\nOK\r\n
ofonod[2367]: Pcui:> AT+CMGL=4\r
ofonod[2367]: Pcui:< \r\n^SRVST:2\r\n
ofonod[2367]: Pcui:< \r\n+CREG: 1,754F,830452\r\n\r\n+CGREG: 0,754F,830452\r\n
ofonod[2367]: src/gprs.c:netreg_status_changed() 1
ofonod[2367]: src/cbs.c:cbs_location_changed() 1, 30031, 8586322, -1, (null)(null)
ofonod[2367]: Pcui:< \r\nOK\r\n
ofonod[2367]: Pcui:> AT+CGSMS=3\r
ofonod[2367]: Pcui:< \r\nOK\r\n
ofonod[2367]: Pcui:> AT+COPS=3,2\r
ofonod[2367]: Pcui:< \r\nOK\r\n
ofonod[2367]: Pcui:> AT+COPS?\r
ofonod[2367]: Pcui:< \r\n+COPS: 0,2,"72405",2\r\n\r\nOK\r\n
ofonod[2367]: drivers/atmodem/network-registration.c:cops_numeric_cb() Cops numeric got mcc: 724, mnc: 05
ofonod[2367]: Pcui:> AT+CGATT=1\r
ofonod[2367]: Pcui:< \r\n+CREG: 1,754F,830452\r\n\r\n+CGREG: 1,754F,830452\r\n
ofonod[2367]: src/gprs.c:netreg_status_changed() 1
ofonod[2367]: src/cbs.c:cbs_location_changed() 1, 30031, 8586322, -1, (null)(null)
ofonod[2367]: Pcui:< \r\nOK\r\n
ofonod[2367]: Pcui:> AT+COPS=3,0\r
ofonod[2367]: Pcui:< \r\nOK\r\n
ofonod[2367]: Pcui:> AT+COPS?\r
ofonod[2367]: Pcui:< \r\n+COPS: 0,0,"Claro BR",2\r\n\r\nOK\r\n
ofonod[2367]: drivers/atmodem/network-registration.c:cops_cb() cops_cb: Claro BR, 724 05 2
ofonod[2367]: src/network.c:current_operator_callback() 0x9ff43a0, (nil)
ofonod[2367]: src/gprs.c:netreg_status_changed() 1
ofonod[2367]: src/cbs.c:cbs_location_changed() 1, 30031, 8586322, -1, 72405
ofonod[2367]: src/cbs.c:cbs_location_changed() 1, 0, 0
ofonod[2367]: Pcui:> AT+COPS=3,2\r
ofonod[2367]: Pcui:< \r\nOK\r\n
ofonod[2367]: Pcui:> AT+COPS?\r
ofonod[2367]: Pcui:< \r\n+COPS: 0,2,"72405",2\r\n\r\nOK\r\n
ofonod[2367]: drivers/atmodem/network-registration.c:cops_numeric_cb() Cops numeric got mcc: 724, mnc: 05
ofonod[2367]: Pcui:> AT+CGREG?\r
ofonod[2367]: Pcui:< \r\n+CGREG: 2,1,754F,830452\r\n\r\nOK\r\n
ofonod[2367]: Pcui:> AT+COPS=3,0\r
ofonod[2367]: Pcui:< \r\nOK\r\n
ofonod[2367]: Pcui:> AT+COPS?\r
ofonod[2367]: Pcui:< \r\n+COPS: 0,0,"Claro BR",2\r\n\r\nOK\r\n
ofonod[2367]: drivers/atmodem/network-registration.c:cops_cb() cops_cb: Claro BR, 724 05 2
ofonod[2367]: src/network.c:current_operator_callback() 0x9ff43a0, 0x9ff86d0

[-- Warning: decoded text below may be mangled, UTF-8 assumed --]
[-- Attachment #5: huawei-not-connected.log --]
[-- Type: text/x-log, Size: 8897 bytes --]

ofonod[2340]: oFono version 0.26
ofonod[2340]: src/plugin.c:__ofono_plugin_init() 
ofonod[2340]: src/modem.c:ofono_modem_driver_register() driver: 0x81047c0, name: ste
ofonod[2340]: src/modem.c:ofono_modem_driver_register() driver: 0x8104760, name: palmpre
ofonod[2340]: src/modem.c:ofono_modem_driver_register() driver: 0x8104680, name: hfp
ofonod[2340]: src/modem.c:ofono_modem_driver_register() driver: 0x8104600, name: novatel
ofonod[2340]: src/modem.c:ofono_modem_driver_register() driver: 0x81045a0, name: huawei
ofonod[2340]: src/modem.c:ofono_modem_driver_register() driver: 0x8104540, name: zte
ofonod[2340]: src/modem.c:ofono_modem_driver_register() driver: 0x81044e0, name: hso
ofonod[2340]: src/modem.c:ofono_modem_driver_register() driver: 0x8104480, name: mbm
ofonod[2340]: src/modem.c:ofono_modem_driver_register() driver: 0x8104420, name: calypso
ofonod[2340]: src/modem.c:ofono_modem_driver_register() driver: 0x81043c0, name: wavecom
ofonod[2340]: src/modem.c:ofono_modem_driver_register() driver: 0x8104360, name: g1
ofonod[2340]: src/modem.c:ofono_modem_driver_register() driver: 0x8104300, name: atgen
ofonod[2340]: src/modem.c:ofono_modem_driver_register() driver: 0x81042a0, name: phonesim
ofonod[2340]: src/voicecall.c:ofono_voicecall_driver_register() driver: 0x81041e0, name: stemodem
ofonod[2340]: src/gprs.c:ofono_gprs_context_driver_register() driver: 0x8104244, name: stemodem
ofonod[2340]: src/radio-settings.c:ofono_radio_settings_driver_register() driver: 0x8104228, name: stemodem
ofonod[2340]: src/gprs.c:ofono_gprs_context_driver_register() driver: 0x8104190, name: hsomodem
ofonod[2340]: src/radio-settings.c:ofono_radio_settings_driver_register() driver: 0x81041ac, name: hsomodem
ofonod[2340]: src/gprs.c:ofono_gprs_context_driver_register() driver: 0x8104138, name: mbm
ofonod[2340]: src/stk.c:ofono_stk_driver_register() driver: 0x810415c, name: mbmmodem
ofonod[2340]: src/voicecall.c:ofono_voicecall_driver_register() driver: 0x8104060, name: hfpmodem
ofonod[2340]: src/network.c:ofono_netreg_driver_register() driver: 0x81040c0, name: hfpmodem
ofonod[2340]: src/call-volume.c:ofono_call_volume_driver_register() driver: 0x81040f8, name: hfpmodem
ofonod[2340]: src/voicecall.c:ofono_voicecall_driver_register() driver: 0x8103fe0, name: calypsomodem
ofonod[2340]: src/stk.c:ofono_stk_driver_register() driver: 0x8104028, name: calypsomodem
ofonod[2340]: src/radio-settings.c:ofono_radio_settings_driver_register() driver: 0x8103fa0, name: nwmodem
ofonod[2340]: src/voicecall.c:ofono_voicecall_driver_register() driver: 0x8103e60, name: atmodem
ofonod[2340]: src/modem.c:ofono_devinfo_driver_register() driver: 0x8103f0c, name: atmodem
ofonod[2340]: src/call-barring.c:ofono_call_barring_driver_register() driver: 0x8103eb8, name: atmodem
ofonod[2340]: src/call-forwarding.c:ofono_call_forwarding_driver_register() driver: 0x8103cc0, name: atmodem
ofonod[2340]: src/call-meter.c:ofono_call_meter_driver_register() driver: 0x8103d00, name: atmodem
ofonod[2340]: src/call-settings.c:ofono_call_settings_driver_register() driver: 0x8103be0, name: atmodem
ofonod[2340]: src/phonebook.c:ofono_phonebook_driver_register() driver: 0x8103ed8, name: atmodem
ofonod[2340]: src/ssn.c:ofono_ssn_driver_register() driver: 0x8103f00, name: atmodem
ofonod[2340]: src/ussd.c:ofono_ussd_driver_register() driver: 0x8103e40, name: atmodem
ofonod[2340]: src/sms.c:ofono_sms_driver_register() driver: 0x8103c40, name: atmodem
ofonod[2340]: src/sim.c:ofono_sim_driver_register() driver: 0x8103dc0, name: atmodem
ofonod[2340]: src/stk.c:ofono_stk_driver_register() driver: 0x8103e1c, name: atmodem
ofonod[2340]: src/network.c:ofono_netreg_driver_register() driver: 0x8103d60, name: atmodem
ofonod[2340]: src/cbs.c:ofono_cbs_driver_register() driver: 0x8103ca0, name: atmodem
ofonod[2340]: src/call-volume.c:ofono_call_volume_driver_register() driver: 0x8103f28, name: atmodem
ofonod[2340]: src/gprs.c:ofono_gprs_driver_register() driver: 0x8103f50, name: atmodem
ofonod[2340]: src/gprs.c:ofono_gprs_context_driver_register() driver: 0x8103f74, name: atmodem
ofonod[2340]: src/modem.c:ofono_devinfo_driver_register() driver: 0x81037b4, name: isimodem
ofonod[2340]: src/phonebook.c:ofono_phonebook_driver_register() driver: 0x81037a4, name: isimodem
ofonod[2340]: src/network.c:ofono_netreg_driver_register() driver: 0x81037e0, name: isimodem
ofonod[2340]: src/voicecall.c:ofono_voicecall_driver_register() driver: 0x8103820, name: isimodem
ofonod[2340]: src/sms.c:ofono_sms_driver_register() driver: 0x8103880, name: isimodem
ofonod[2340]: src/cbs.c:ofono_cbs_driver_register() driver: 0x81038a0, name: isimodem
ofonod[2340]: src/sim.c:ofono_sim_driver_register() driver: 0x81038c0, name: isimodem
ofonod[2340]: src/ssn.c:ofono_ssn_driver_register() driver: 0x8103904, name: isimodem
ofonod[2340]: src/ussd.c:ofono_ussd_driver_register() driver: 0x8103910, name: isimodem
ofonod[2340]: src/call-forwarding.c:ofono_call_forwarding_driver_register() driver: 0x8103940, name: isimodem
ofonod[2340]: src/call-settings.c:ofono_call_settings_driver_register() driver: 0x8103960, name: isimodem
ofonod[2340]: src/call-barring.c:ofono_call_barring_driver_register() driver: 0x8103988, name: isimodem
ofonod[2340]: src/call-meter.c:ofono_call_meter_driver_register() driver: 0x81039a0, name: isimodem
ofonod[2340]: src/radio-settings.c:ofono_radio_settings_driver_register() driver: 0x81039c8, name: isimodem
ofonod[2340]: src/gprs.c:ofono_gprs_driver_register() driver: 0x81039dc, name: isimodem
ofonod[2340]: src/gprs.c:ofono_gprs_context_driver_register() driver: 0x81039f0, name: isimodem
ofonod[2340]: src/modem.c:ofono_modem_driver_register() driver: 0x8103780, name: isimodem
ofonod[2340]: plugins/bluetooth.c:manager_properties_cb() 
ofonod[2340]: plugins/bluetooth.c:parse_adapters() 
ofonod[2340]: plugins/bluetooth.c:parse_adapters() Calling GetProperties on /org/bluez/1447/hci0
ofonod[2340]: plugins/bluetooth.c:parse_devices() 
ofonod[2340]: plugins/bluetooth.c:adapter_properties_cb() Adapter Address: 00:25:D3:A1:3F:AD, Path: /org/bluez/1447/hci0
ofonod[2340]: src/modem.c:ofono_modem_create() name: (null), type: huawei
ofonod[2340]: src/modem.c:set_modem_property() modem 0x81ed2b8 property Path
ofonod[2340]: src/modem.c:set_modem_property() modem 0x81ed2b8 property Registered
ofonod[2340]: plugins/udev.c:add_modem() /devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1:1.1/ttyUSB1/tty/ttyUSB1 (huawei)
ofonod[2340]: plugins/udev.c:add_huawei() modem 0x81ed2b8
ofonod[2340]: src/modem.c:get_modem_property() modem 0x81ed2b8 property ModemRegistered
ofonod[2340]: src/modem.c:get_modem_property() modem 0x81ed2b8 property PcuiRegistered
ofonod[2340]: src/modem.c:set_modem_property() modem 0x81ed2b8 property Pcui
ofonod[2340]: src/modem.c:set_modem_property() modem 0x81ed2b8 property PcuiRegistered
ofonod[2340]: src/modem.c:get_modem_property() modem 0x81ed2b8 property Path
ofonod[2340]: plugins/udev.c:add_modem() /devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1:1.0/ttyUSB0/tty/ttyUSB0 (huawei)
ofonod[2340]: plugins/udev.c:add_huawei() modem 0x81ed2b8
ofonod[2340]: src/modem.c:get_modem_property() modem 0x81ed2b8 property ModemRegistered
ofonod[2340]: src/modem.c:get_modem_property() modem 0x81ed2b8 property PcuiRegistered
ofonod[2340]: src/modem.c:set_modem_property() modem 0x81ed2b8 property Modem
ofonod[2340]: src/modem.c:set_modem_property() modem 0x81ed2b8 property ModemRegistered
ofonod[2340]: plugins/huawei.c:huawei_probe() 0x81ed2b8
ofonod[2340]: plugins/huawei.c:huawei_enable() 0x81ed2b8
ofonod[2340]: src/modem.c:get_modem_property() modem 0x81ed2b8 property Modem
ofonod[2340]: plugins/huawei.c:open_device() Modem /dev/ttyUSB0
ofonod[2340]: src/modem.c:get_modem_property() modem 0x81ed2b8 property Pcui
ofonod[2340]: plugins/huawei.c:open_device() Pcui /dev/ttyUSB1
ofonod[2340]: Pcui:> ATE0\r
ofonod[2340]: Pcui:< ATE0\r\r\nOK\r\n
ofonod[2340]: Pcui:> AT+CFUN=1\r
ofonod[2340]: Pcui:< \r\nOK\r\n
ofonod[2340]: plugins/huawei.c:cfun_enable() 
ofonod[2340]: plugins/huawei.c:huawei_pre_sim() 0x81ed2b8
ofonod[2340]: Pcui:> AT^SYSINFO\r
ofonod[2340]: src/sim.c:ofono_sim_add_state_watch() 0x81ed450
ofonod[2340]: src/sim.c:ofono_sim_add_state_watch() 0x81ed450
ofonod[2340]: Pcui:< \r\n^SYSINFO:1,0,1,5,255,,4\r\n\r\nOK\r\n
ofonod[2340]: Pcui:> AT+CGMI\r
ofonod[2340]: Pcui:< \r\nhuawei\r\n\r\nOK\r\n
ofonod[2340]: Pcui:> AT+CGMM\r
ofonod[2340]: Pcui:< \r\nE226\r\n\r\nOK\r\n
ofonod[2340]: Pcui:> AT+CGMR\r
ofonod[2340]: Pcui:< \r\n11.310.15.00.150\r\n\r\nOK\r\n
ofonod[2340]: Pcui:> AT+CGSN\r
ofonod[2340]: Pcui:< \r\n357650019586537\r\n\r\nOK\r\n
ofonod[2340]: Pcui:< \r\n^RSSI:17\r\n
ofonod[2340]: Pcui:< \r\n^BOOT:19586537,0,0,0,63\r\n
ofonod[2340]: Pcui:< \r\n^BOOT:19586537,0,0,0,63\r\n
ofonod[2340]: Pcui:< \r\n^BOOT:19586537,0,0,0,63\r\n
ofonod[2340]: Pcui:< \r\n^BOOT:19586537,0,0,0,63\r\n
ofonod[2340]: Pcui:< \r\n^BOOT:19586537,0,0,0,63\r\n

Re: Connecting with Huawei E226

[Denis Kenzior]

[-- Attachment #1: Type: text/plain, Size: 1019 bytes --]

Hi Thiago,

On 08/17/2010 03:31 PM, Thiago Cangussu de Castro Gomes wrote:
> Hi all,
> 
> I'm trying to connect with a Huawei E226, but I'm getting
> different behavior whether I start ofonod with the modem (USB) plugged
> in or not:
> 
> Scenario 1:
> 
> 1 - start ofonod
> 2 - plug the modem
> 3 - not working
> 
> Log: huawei-connected.log (attached)
> 
> Scenario 2:
> 
> 1 - start ofonod
> 2 - plug the modem
> 3 - call disable-modem
> 4 - call enable-modem
> 5 - it works
> 
> Log: huawei-testscripts.log
> 
> Scenario 3:
> 
> 1 - plug the modem
> 2 - start ofonod
> 3 - it works
> 
> Log file: huawei-not-connected.log
> 
> I'm testing with MeeGo, ofono from git and connman 0.57.

The problem with the failed cases it that oFono / ConnMan combination is
simply too fast.  It tries to access the Modem before it had the chance
to properly initialize the SIM card.  We have pushed some fixes upstream
after the 0.26 release that should alleviate this.

Regards,
-Denis

Re: Connecting with Huawei E226

[Thiago Cangussu de Castro Gomes]

[-- Attachment #1: Type: text/plain, Size: 1411 bytes --]

On Tue, Aug 17, 2010 at 10:45 PM, Denis Kenzior <denkenz@gmail.com> wrote:
>
> > I'm trying to connect with a Huawei E226, but I'm getting
> > different behavior whether I start ofonod with the modem (USB) plugged
> > in or not:
> >
> > Scenario 1:
> >
> > 1 - start ofonod
> > 2 - plug the modem
> > 3 - not working
> >
> > Log: huawei-connected.log (attached)
> >
> > Scenario 2:
> >
> > 1 - start ofonod
> > 2 - plug the modem
> > 3 - call disable-modem
> > 4 - call enable-modem
> > 5 - it works
> >
> > Log: huawei-testscripts.log
> >
> > Scenario 3:
> >
> > 1 - plug the modem
> > 2 - start ofonod
> > 3 - it works
> >
> > Log file: huawei-not-connected.log
> >
> > I'm testing with MeeGo, ofono from git and connman 0.57.
>
> The problem with the failed cases it that oFono / ConnMan combination is
> simply too fast.  It tries to access the Modem before it had the chance
> to properly initialize the SIM card.  We have pushed some fixes upstream
> after the 0.26 release that should alleviate this.

Thanks for the response. You are right, I can reproduce the problem
even with connman turned off, by calling the test scripts before the
modem is ready.

I'm using both ofono and connman from git, with all the available
updates so far. Does it mean that the fixes didn't solved the issue in
my case? Could you point me to the patches?

Thanks,
Thiago

Re: Connecting with Huawei E226

[Denis Kenzior]

[-- Attachment #1: Type: text/plain, Size: 955 bytes --]

Hi Thiago,

>> The problem with the failed cases it that oFono / ConnMan combination is
>> simply too fast.  It tries to access the Modem before it had the chance
>> to properly initialize the SIM card.  We have pushed some fixes upstream
>> after the 0.26 release that should alleviate this.
> 
> Thanks for the response. You are right, I can reproduce the problem
> even with connman turned off, by calling the test scripts before the
> modem is ready.
> 
> I'm using both ofono and connman from git, with all the available
> updates so far. Does it mean that the fixes didn't solved the issue in
> my case? Could you point me to the patches?

For your particular case these patches from Kalle would be helpful:

[PATCH 1/2] huawei: poll sim state
[PATCH 2/2] huawei: postpone post_sim until SIM is ready

However, they weren't integrated upstream due to some concerns.  See the
entire thread for more details.

Regards,
-Denis

Re: Connecting with Huawei E226

[Thiago Cangussu de Castro Gomes]

[-- Attachment #1: Type: text/plain, Size: 1255 bytes --]

On Wed, Aug 18, 2010 at 2:02 PM, Denis Kenzior <denkenz@gmail.com> wrote:
> Hi Thiago,
>
>>> The problem with the failed cases it that oFono / ConnMan combination is
>>> simply too fast.  It tries to access the Modem before it had the chance
>>> to properly initialize the SIM card.  We have pushed some fixes upstream
>>> after the 0.26 release that should alleviate this.
>>
>> Thanks for the response. You are right, I can reproduce the problem
>> even with connman turned off, by calling the test scripts before the
>> modem is ready.
>>
>> I'm using both ofono and connman from git, with all the available
>> updates so far. Does it mean that the fixes didn't solved the issue in
>> my case? Could you point me to the patches?
>
> For your particular case these patches from Kalle would be helpful:
>
> [PATCH 1/2] huawei: poll sim state
> [PATCH 2/2] huawei: postpone post_sim until SIM is ready
>
> However, they weren't integrated upstream due to some concerns.  See the
> entire thread for more details.

I've applied the patches but unfortunately it didn't fixed the issue.
Still can't connect when the modem is plugged after ofonod is started.
I can send the logs if anyone thinks it's useful.

Regards,
Thiago

Re: Connecting with Huawei E226

[Denis Kenzior]

[-- Attachment #1: Type: text/plain, Size: 1526 bytes --]

Hi Thiago,

On 08/18/2010 05:26 PM, Thiago Cangussu de Castro Gomes wrote:
> On Wed, Aug 18, 2010 at 2:02 PM, Denis Kenzior <denkenz@gmail.com> wrote:
>> Hi Thiago,
>>
>>>> The problem with the failed cases it that oFono / ConnMan combination is
>>>> simply too fast.  It tries to access the Modem before it had the chance
>>>> to properly initialize the SIM card.  We have pushed some fixes upstream
>>>> after the 0.26 release that should alleviate this.
>>>
>>> Thanks for the response. You are right, I can reproduce the problem
>>> even with connman turned off, by calling the test scripts before the
>>> modem is ready.
>>>
>>> I'm using both ofono and connman from git, with all the available
>>> updates so far. Does it mean that the fixes didn't solved the issue in
>>> my case? Could you point me to the patches?
>>
>> For your particular case these patches from Kalle would be helpful:
>>
>> [PATCH 1/2] huawei: poll sim state
>> [PATCH 2/2] huawei: postpone post_sim until SIM is ready
>>
>> However, they weren't integrated upstream due to some concerns.  See the
>> entire thread for more details.
> 
> I've applied the patches but unfortunately it didn't fixed the issue.
> Still can't connect when the modem is plugged after ofonod is started.
> I can send the logs if anyone thinks it's useful.
> 

Sorry to hear you're having trouble.  Kalle reported similar issues were
fixed with his patches on the E1552.  Sending the logs would probably be
helpful.

Regards,
-Denis

Re: Connecting with Huawei E226

[Thiago Cangussu de Castro Gomes]

[-- Attachment #1: Type: text/plain, Size: 1312 bytes --]

On Wed, Aug 18, 2010 at 7:31 PM, Denis Kenzior <denkenz@gmail.com> wrote:
>>> For your particular case these patches from Kalle would be helpful:
>>>
>>> [PATCH 1/2] huawei: poll sim state
>>> [PATCH 2/2] huawei: postpone post_sim until SIM is ready
>>>
>>> However, they weren't integrated upstream due to some concerns.  See the
>>> entire thread for more details.
>>
>> I've applied the patches but unfortunately it didn't fixed the issue.
>> Still can't connect when the modem is plugged after ofonod is started.
>> I can send the logs if anyone thinks it's useful.
>>
>
> Sorry to hear you're having trouble.  Kalle reported similar issues were
> fixed with his patches on the E1552.  Sending the logs would probably be
> helpful.

Here are (attached) the logs. I turned off connman. The two tests scenarios are:

Test A (connect-modem-after-fast.log)

- start ofono
- plug the modem
- call enable-modem just after inserting the modem

Test B (connect-modem-after-slow.log)

- start ofono
- plug the modem
- wait until the modem led switches from green to blue
- call enable-modem after some seconds

The second scenario is what happens when connmand is running, and is
the most common use case: someone plugs in the modem with the system
running.

Regards,
Thiago

Re: Connecting with Huawei E226

[Denis Kenzior]

[-- Attachment #1: Type: text/plain, Size: 1494 bytes --]

Hi Thiago,

On 08/24/2010 03:25 PM, Thiago Cangussu de Castro Gomes wrote:
> On Wed, Aug 18, 2010 at 7:31 PM, Denis Kenzior <denkenz@gmail.com> wrote:
>>>> For your particular case these patches from Kalle would be helpful:
>>>>
>>>> [PATCH 1/2] huawei: poll sim state
>>>> [PATCH 2/2] huawei: postpone post_sim until SIM is ready
>>>>
>>>> However, they weren't integrated upstream due to some concerns.  See the
>>>> entire thread for more details.
>>>
>>> I've applied the patches but unfortunately it didn't fixed the issue.
>>> Still can't connect when the modem is plugged after ofonod is started.
>>> I can send the logs if anyone thinks it's useful.
>>>
>>
>> Sorry to hear you're having trouble.  Kalle reported similar issues were
>> fixed with his patches on the E1552.  Sending the logs would probably be
>> helpful.
> 
> Here are (attached) the logs. I turned off connman. The two tests scenarios are:
> 
> Test A (connect-modem-after-fast.log)
> 
> - start ofono
> - plug the modem
> - call enable-modem just after inserting the modem
> 
> Test B (connect-modem-after-slow.log)
> 
> - start ofono
> - plug the modem
> - wait until the modem led switches from green to blue
> - call enable-modem after some seconds
> 
> The second scenario is what happens when connmand is running, and is
> the most common use case: someone plugs in the modem with the system
> running.

It seems you forgot to include the actual logs.

Regards,
-Denis

Re: Connecting with Huawei E226

[Thiago Cangussu de Castro Gomes]

[-- Attachment #1: Type: text/plain, Size: 1764 bytes --]

On Tue, Aug 24, 2010 at 7:16 PM, Denis Kenzior <denkenz@gmail.com> wrote:
> Hi Thiago,
>
> On 08/24/2010 03:25 PM, Thiago Cangussu de Castro Gomes wrote:
>> On Wed, Aug 18, 2010 at 7:31 PM, Denis Kenzior <denkenz@gmail.com> wrote:
>>>>> For your particular case these patches from Kalle would be helpful:
>>>>>
>>>>> [PATCH 1/2] huawei: poll sim state
>>>>> [PATCH 2/2] huawei: postpone post_sim until SIM is ready
>>>>>
>>>>> However, they weren't integrated upstream due to some concerns.  See the
>>>>> entire thread for more details.
>>>>
>>>> I've applied the patches but unfortunately it didn't fixed the issue.
>>>> Still can't connect when the modem is plugged after ofonod is started.
>>>> I can send the logs if anyone thinks it's useful.
>>>>
>>>
>>> Sorry to hear you're having trouble.  Kalle reported similar issues were
>>> fixed with his patches on the E1552.  Sending the logs would probably be
>>> helpful.
>>
>> Here are (attached) the logs. I turned off connman. The two tests scenarios are:
>>
>> Test A (connect-modem-after-fast.log)
>>
>> - start ofono
>> - plug the modem
>> - call enable-modem just after inserting the modem
>>
>> Test B (connect-modem-after-slow.log)
>>
>> - start ofono
>> - plug the modem
>> - wait until the modem led switches from green to blue
>> - call enable-modem after some seconds
>>
>> The second scenario is what happens when connmand is running, and is
>> the most common use case: someone plugs in the modem with the system
>> running.
>
> It seems you forgot to include the actual logs.

Let me try again :)

I forgot also to mention that I used list-context to see if the
enable-modem was successful. The test B is the one that fails.

Regards,
Thiago

[-- Warning: decoded text below may be mangled, UTF-8 assumed --]
[-- Attachment #2: connect-modem-after-fast.log --]
[-- Type: text/x-log, Size: 10556 bytes --]

ofonod[2756]: oFono version 0.26
ofonod[2756]: src/plugin.c:__ofono_plugin_init() 
ofonod[2756]: src/modem.c:ofono_modem_driver_register() driver: 0x81047c0, name: ste
ofonod[2756]: src/modem.c:ofono_modem_driver_register() driver: 0x8104760, name: palmpre
ofonod[2756]: src/modem.c:ofono_modem_driver_register() driver: 0x8104680, name: hfp
ofonod[2756]: src/modem.c:ofono_modem_driver_register() driver: 0x8104600, name: novatel
ofonod[2756]: src/modem.c:ofono_modem_driver_register() driver: 0x81045a0, name: huawei
ofonod[2756]: src/modem.c:ofono_modem_driver_register() driver: 0x8104540, name: zte
ofonod[2756]: src/modem.c:ofono_modem_driver_register() driver: 0x81044e0, name: hso
ofonod[2756]: src/modem.c:ofono_modem_driver_register() driver: 0x8104480, name: mbm
ofonod[2756]: src/modem.c:ofono_modem_driver_register() driver: 0x8104420, name: calypso
ofonod[2756]: src/modem.c:ofono_modem_driver_register() driver: 0x81043c0, name: wavecom
ofonod[2756]: src/modem.c:ofono_modem_driver_register() driver: 0x8104360, name: g1
ofonod[2756]: src/modem.c:ofono_modem_driver_register() driver: 0x8104300, name: atgen
ofonod[2756]: src/modem.c:ofono_modem_driver_register() driver: 0x81042a0, name: phonesim
ofonod[2756]: src/voicecall.c:ofono_voicecall_driver_register() driver: 0x81041e0, name: stemodem
ofonod[2756]: src/gprs.c:ofono_gprs_context_driver_register() driver: 0x8104244, name: stemodem
ofonod[2756]: src/radio-settings.c:ofono_radio_settings_driver_register() driver: 0x8104228, name: stemodem
ofonod[2756]: src/gprs.c:ofono_gprs_context_driver_register() driver: 0x8104190, name: hsomodem
ofonod[2756]: src/radio-settings.c:ofono_radio_settings_driver_register() driver: 0x81041ac, name: hsomodem
ofonod[2756]: src/gprs.c:ofono_gprs_context_driver_register() driver: 0x8104138, name: mbm
ofonod[2756]: src/stk.c:ofono_stk_driver_register() driver: 0x810415c, name: mbmmodem
ofonod[2756]: src/voicecall.c:ofono_voicecall_driver_register() driver: 0x8104060, name: hfpmodem
ofonod[2756]: src/network.c:ofono_netreg_driver_register() driver: 0x81040c0, name: hfpmodem
ofonod[2756]: src/call-volume.c:ofono_call_volume_driver_register() driver: 0x81040f8, name: hfpmodem
ofonod[2756]: src/voicecall.c:ofono_voicecall_driver_register() driver: 0x8103fe0, name: calypsomodem
ofonod[2756]: src/stk.c:ofono_stk_driver_register() driver: 0x8104028, name: calypsomodem
ofonod[2756]: src/radio-settings.c:ofono_radio_settings_driver_register() driver: 0x8103fa0, name: nwmodem
ofonod[2756]: src/voicecall.c:ofono_voicecall_driver_register() driver: 0x8103e60, name: atmodem
ofonod[2756]: src/modem.c:ofono_devinfo_driver_register() driver: 0x8103f0c, name: atmodem
ofonod[2756]: src/call-barring.c:ofono_call_barring_driver_register() driver: 0x8103eb8, name: atmodem
ofonod[2756]: src/call-forwarding.c:ofono_call_forwarding_driver_register() driver: 0x8103cc0, name: atmodem
ofonod[2756]: src/call-meter.c:ofono_call_meter_driver_register() driver: 0x8103d00, name: atmodem
ofonod[2756]: src/call-settings.c:ofono_call_settings_driver_register() driver: 0x8103be0, name: atmodem
ofonod[2756]: src/phonebook.c:ofono_phonebook_driver_register() driver: 0x8103ed8, name: atmodem
ofonod[2756]: src/ssn.c:ofono_ssn_driver_register() driver: 0x8103f00, name: atmodem
ofonod[2756]: src/ussd.c:ofono_ussd_driver_register() driver: 0x8103e40, name: atmodem
ofonod[2756]: src/sms.c:ofono_sms_driver_register() driver: 0x8103c40, name: atmodem
ofonod[2756]: src/sim.c:ofono_sim_driver_register() driver: 0x8103dc0, name: atmodem
ofonod[2756]: src/stk.c:ofono_stk_driver_register() driver: 0x8103e1c, name: atmodem
ofonod[2756]: src/network.c:ofono_netreg_driver_register() driver: 0x8103d60, name: atmodem
ofonod[2756]: src/cbs.c:ofono_cbs_driver_register() driver: 0x8103ca0, name: atmodem
ofonod[2756]: src/call-volume.c:ofono_call_volume_driver_register() driver: 0x8103f28, name: atmodem
ofonod[2756]: src/gprs.c:ofono_gprs_driver_register() driver: 0x8103f50, name: atmodem
ofonod[2756]: src/gprs.c:ofono_gprs_context_driver_register() driver: 0x8103f74, name: atmodem
ofonod[2756]: src/modem.c:ofono_devinfo_driver_register() driver: 0x81037b4, name: isimodem
ofonod[2756]: src/phonebook.c:ofono_phonebook_driver_register() driver: 0x81037a4, name: isimodem
ofonod[2756]: src/network.c:ofono_netreg_driver_register() driver: 0x81037e0, name: isimodem
ofonod[2756]: src/voicecall.c:ofono_voicecall_driver_register() driver: 0x8103820, name: isimodem
ofonod[2756]: src/sms.c:ofono_sms_driver_register() driver: 0x8103880, name: isimodem
ofonod[2756]: src/cbs.c:ofono_cbs_driver_register() driver: 0x81038a0, name: isimodem
ofonod[2756]: src/sim.c:ofono_sim_driver_register() driver: 0x81038c0, name: isimodem
ofonod[2756]: src/ssn.c:ofono_ssn_driver_register() driver: 0x8103904, name: isimodem
ofonod[2756]: src/ussd.c:ofono_ussd_driver_register() driver: 0x8103910, name: isimodem
ofonod[2756]: src/call-forwarding.c:ofono_call_forwarding_driver_register() driver: 0x8103940, name: isimodem
ofonod[2756]: src/call-settings.c:ofono_call_settings_driver_register() driver: 0x8103960, name: isimodem
ofonod[2756]: src/call-barring.c:ofono_call_barring_driver_register() driver: 0x8103988, name: isimodem
ofonod[2756]: src/call-meter.c:ofono_call_meter_driver_register() driver: 0x81039a0, name: isimodem
ofonod[2756]: src/radio-settings.c:ofono_radio_settings_driver_register() driver: 0x81039c8, name: isimodem
ofonod[2756]: src/gprs.c:ofono_gprs_driver_register() driver: 0x81039dc, name: isimodem
ofonod[2756]: src/gprs.c:ofono_gprs_context_driver_register() driver: 0x81039f0, name: isimodem
ofonod[2756]: src/modem.c:ofono_modem_driver_register() driver: 0x8103780, name: isimodem
ofonod[2756]: plugins/bluetooth.c:manager_properties_cb() 
ofonod[2756]: plugins/bluetooth.c:parse_adapters() 
ofonod[2756]: plugins/bluetooth.c:parse_adapters() Calling GetProperties on /org/bluez/1195/hci0
ofonod[2756]: plugins/bluetooth.c:parse_devices() 
ofonod[2756]: plugins/bluetooth.c:adapter_properties_cb() Adapter Address: 00:25:D3:A1:3F:AD, Path: /org/bluez/1195/hci0
ofonod[2756]: src/modem.c:ofono_modem_create() name: (null), type: huawei
ofonod[2756]: src/modem.c:set_modem_property() modem 0x9ac9668 property Path
ofonod[2756]: src/modem.c:set_modem_property() modem 0x9ac9668 property Registered
ofonod[2756]: plugins/udev.c:add_modem() /devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1:1.1/ttyUSB1/tty/ttyUSB1 (huawei)
ofonod[2756]: plugins/udev.c:add_huawei() modem 0x9ac9668
ofonod[2756]: src/modem.c:get_modem_property() modem 0x9ac9668 property ModemRegistered
ofonod[2756]: src/modem.c:get_modem_property() modem 0x9ac9668 property PcuiRegistered
ofonod[2756]: src/modem.c:set_modem_property() modem 0x9ac9668 property Pcui
ofonod[2756]: src/modem.c:set_modem_property() modem 0x9ac9668 property PcuiRegistered
ofonod[2756]: src/modem.c:get_modem_property() modem 0x9ac9668 property Path
ofonod[2756]: plugins/udev.c:add_modem() /devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1:1.0/ttyUSB0/tty/ttyUSB0 (huawei)
ofonod[2756]: plugins/udev.c:add_huawei() modem 0x9ac9668
ofonod[2756]: src/modem.c:get_modem_property() modem 0x9ac9668 property ModemRegistered
ofonod[2756]: src/modem.c:get_modem_property() modem 0x9ac9668 property PcuiRegistered
ofonod[2756]: src/modem.c:set_modem_property() modem 0x9ac9668 property Modem
ofonod[2756]: src/modem.c:set_modem_property() modem 0x9ac9668 property ModemRegistered
ofonod[2756]: plugins/huawei.c:huawei_probe() 0x9ac9668
ofonod[2756]: plugins/huawei.c:huawei_enable() 0x9ac9668
ofonod[2756]: src/modem.c:get_modem_property() modem 0x9ac9668 property Modem
ofonod[2756]: plugins/huawei.c:open_device() Modem /dev/ttyUSB0
ofonod[2756]: src/modem.c:get_modem_property() modem 0x9ac9668 property Pcui
ofonod[2756]: plugins/huawei.c:open_device() Pcui /dev/ttyUSB1
ofonod[2756]: Pcui:> ATE0\r
ofonod[2756]: Pcui:< ATE0\r\r\nOK\r\n
ofonod[2756]: Pcui:> AT+CFUN=1\r
ofonod[2756]: Pcui:< \r\nOK\r\n
ofonod[2756]: plugins/huawei.c:cfun_enable() 
ofonod[2756]: plugins/huawei.c:huawei_pre_sim() 0x9ac9668
ofonod[2756]: plugins/huawei.c:query_sim_state() 
ofonod[2756]: Pcui:> AT^SYSINFO\r
ofonod[2756]: src/sim.c:ofono_sim_add_state_watch() 0x9ac9580
ofonod[2756]: src/sim.c:ofono_sim_add_state_watch() 0x9ac9580
ofonod[2756]: Pcui:< \r\n^SYSINFO:1,0,1,5,255,,4\r\n\r\nOK\r\n
ofonod[2756]: plugins/huawei.c:notify_sim_state() 255
ofonod[2756]: Pcui:> AT+CGMI\r
ofonod[2756]: Pcui:< \r\nhuawei\r\n\r\nOK\r\n
ofonod[2756]: Pcui:> AT+CGMM\r
ofonod[2756]: Pcui:< \r\nE226\r\n\r\nOK\r\n
ofonod[2756]: Pcui:> AT+CGMR\r
ofonod[2756]: Pcui:< \r\n11.310.15.00.150\r\n\r\nOK\r\n
ofonod[2756]: Pcui:> AT+CGSN\r
ofonod[2756]: Pcui:< \r\n357650019550426\r\n\r\nOK\r\n
ofonod[2756]: Pcui:< \r\n^RSSI:24\r\n
ofonod[2756]: plugins/huawei.c:query_sim_state() 
ofonod[2756]: Pcui:> AT^SYSINFO\r
ofonod[2756]: Pcui:< \r\n^SYSINFO:1,0,1,5,0,,4\r\n\r\nOK\r\n
ofonod[2756]: plugins/huawei.c:notify_sim_state() 0
ofonod[2756]: Pcui:> AT+CRSM=176,28590,0,0,1\r
ofonod[2756]: Pcui:< \r\n+CME ERROR: not found\r\n
ofonod[2756]: Pcui:> AT+CPIN?\r
ofonod[2756]: Pcui:< \r\n+CPIN: READY\r\n\r\nOK\r\n
ofonod[2756]: drivers/atmodem/sim.c:at_cpin_cb() crsm_pin_cb: READY
ofonod[2756]: Pcui:> AT+CRSM=192,12258\r
ofonod[2756]: Pcui:< \r\n+CRSM: 144,0,""\r\n\r\nOK\r\n
ofonod[2756]: drivers/atmodem/sim.c:at_crsm_info_cb() crsm_info_cb: 90, 00, 0
ofonod[2756]: Pcui:> AT+CIMI\r
ofonod[2756]: Pcui:< \r\n724053901897939\r\n\r\nOK\r\n
ofonod[2756]: drivers/atmodem/sim.c:at_cimi_cb() cimi_cb: 724053901897939
ofonod[2756]: Pcui:> AT+CRSM=192,28421\r
ofonod[2756]: Pcui:< \r\n+CRSM: 144,0,""\r\n\r\nOK\r\n
ofonod[2756]: drivers/atmodem/sim.c:at_crsm_info_cb() crsm_info_cb: 90, 00, 0
ofonod[2756]: Pcui:> AT+CRSM=192,12037\r
ofonod[2756]: Pcui:< \r\n+CRSM: 144,0,""\r\n\r\nOK\r\n
ofonod[2756]: drivers/atmodem/sim.c:at_crsm_info_cb() crsm_info_cb: 90, 00, 0
ofonod[2756]: Pcui:> AT+CRSM=192,28438\r
ofonod[2756]: Pcui:< \r\n+CRSM: 106,130,""\r\n\r\nOK\r\n
ofonod[2756]: plugins/huawei.c:huawei_post_sim() 0x9ac9668 sim_state 0
ofonod[2756]: Pcui:> AT+CRSM=192,28480\r
ofonod[2756]: Pcui:< \r\n+CRSM: 144,0,""\r\n\r\nOK\r\n
ofonod[2756]: drivers/atmodem/sim.c:at_crsm_info_cb() crsm_info_cb: 90, 00, 0
ofonod[2756]: Pcui:> AT+CRSM=192,28589\r
ofonod[2756]: Pcui:< \r\n+CRSM: 144,0,""\r\n\r\nOK\r\n
ofonod[2756]: drivers/atmodem/sim.c:at_crsm_info_cb() crsm_info_cb: 90, 00, 0
ofonod[2756]: Pcui:> AT+CRSM=192,28489\r
ofonod[2756]: Pcui:< \r\n+CRSM: 144,0,""\r\n\r\nOK\r\n
ofonod[2756]: drivers/atmodem/sim.c:at_crsm_info_cb() crsm_info_cb: 90, 00, 0

[-- Warning: decoded text below may be mangled, UTF-8 assumed --]
[-- Attachment #3: connect-modem-after-slow.log --]
[-- Type: text/x-log, Size: 15549 bytes --]

ofonod[2838]: oFono version 0.26
ofonod[2838]: src/plugin.c:__ofono_plugin_init() 
ofonod[2838]: src/modem.c:ofono_modem_driver_register() driver: 0x81047c0, name: ste
ofonod[2838]: src/modem.c:ofono_modem_driver_register() driver: 0x8104760, name: palmpre
ofonod[2838]: src/modem.c:ofono_modem_driver_register() driver: 0x8104680, name: hfp
ofonod[2838]: src/modem.c:ofono_modem_driver_register() driver: 0x8104600, name: novatel
ofonod[2838]: src/modem.c:ofono_modem_driver_register() driver: 0x81045a0, name: huawei
ofonod[2838]: src/modem.c:ofono_modem_driver_register() driver: 0x8104540, name: zte
ofonod[2838]: src/modem.c:ofono_modem_driver_register() driver: 0x81044e0, name: hso
ofonod[2838]: src/modem.c:ofono_modem_driver_register() driver: 0x8104480, name: mbm
ofonod[2838]: src/modem.c:ofono_modem_driver_register() driver: 0x8104420, name: calypso
ofonod[2838]: src/modem.c:ofono_modem_driver_register() driver: 0x81043c0, name: wavecom
ofonod[2838]: src/modem.c:ofono_modem_driver_register() driver: 0x8104360, name: g1
ofonod[2838]: src/modem.c:ofono_modem_driver_register() driver: 0x8104300, name: atgen
ofonod[2838]: src/modem.c:ofono_modem_driver_register() driver: 0x81042a0, name: phonesim
ofonod[2838]: src/voicecall.c:ofono_voicecall_driver_register() driver: 0x81041e0, name: stemodem
ofonod[2838]: src/gprs.c:ofono_gprs_context_driver_register() driver: 0x8104244, name: stemodem
ofonod[2838]: src/radio-settings.c:ofono_radio_settings_driver_register() driver: 0x8104228, name: stemodem
ofonod[2838]: src/gprs.c:ofono_gprs_context_driver_register() driver: 0x8104190, name: hsomodem
ofonod[2838]: src/radio-settings.c:ofono_radio_settings_driver_register() driver: 0x81041ac, name: hsomodem
ofonod[2838]: src/gprs.c:ofono_gprs_context_driver_register() driver: 0x8104138, name: mbm
ofonod[2838]: src/stk.c:ofono_stk_driver_register() driver: 0x810415c, name: mbmmodem
ofonod[2838]: src/voicecall.c:ofono_voicecall_driver_register() driver: 0x8104060, name: hfpmodem
ofonod[2838]: src/network.c:ofono_netreg_driver_register() driver: 0x81040c0, name: hfpmodem
ofonod[2838]: src/call-volume.c:ofono_call_volume_driver_register() driver: 0x81040f8, name: hfpmodem
ofonod[2838]: src/voicecall.c:ofono_voicecall_driver_register() driver: 0x8103fe0, name: calypsomodem
ofonod[2838]: src/stk.c:ofono_stk_driver_register() driver: 0x8104028, name: calypsomodem
ofonod[2838]: src/radio-settings.c:ofono_radio_settings_driver_register() driver: 0x8103fa0, name: nwmodem
ofonod[2838]: src/voicecall.c:ofono_voicecall_driver_register() driver: 0x8103e60, name: atmodem
ofonod[2838]: src/modem.c:ofono_devinfo_driver_register() driver: 0x8103f0c, name: atmodem
ofonod[2838]: src/call-barring.c:ofono_call_barring_driver_register() driver: 0x8103eb8, name: atmodem
ofonod[2838]: src/call-forwarding.c:ofono_call_forwarding_driver_register() driver: 0x8103cc0, name: atmodem
ofonod[2838]: src/call-meter.c:ofono_call_meter_driver_register() driver: 0x8103d00, name: atmodem
ofonod[2838]: src/call-settings.c:ofono_call_settings_driver_register() driver: 0x8103be0, name: atmodem
ofonod[2838]: src/phonebook.c:ofono_phonebook_driver_register() driver: 0x8103ed8, name: atmodem
ofonod[2838]: src/ssn.c:ofono_ssn_driver_register() driver: 0x8103f00, name: atmodem
ofonod[2838]: src/ussd.c:ofono_ussd_driver_register() driver: 0x8103e40, name: atmodem
ofonod[2838]: src/sms.c:ofono_sms_driver_register() driver: 0x8103c40, name: atmodem
ofonod[2838]: src/sim.c:ofono_sim_driver_register() driver: 0x8103dc0, name: atmodem
ofonod[2838]: src/stk.c:ofono_stk_driver_register() driver: 0x8103e1c, name: atmodem
ofonod[2838]: src/network.c:ofono_netreg_driver_register() driver: 0x8103d60, name: atmodem
ofonod[2838]: src/cbs.c:ofono_cbs_driver_register() driver: 0x8103ca0, name: atmodem
ofonod[2838]: src/call-volume.c:ofono_call_volume_driver_register() driver: 0x8103f28, name: atmodem
ofonod[2838]: src/gprs.c:ofono_gprs_driver_register() driver: 0x8103f50, name: atmodem
ofonod[2838]: src/gprs.c:ofono_gprs_context_driver_register() driver: 0x8103f74, name: atmodem
ofonod[2838]: src/modem.c:ofono_devinfo_driver_register() driver: 0x81037b4, name: isimodem
ofonod[2838]: src/phonebook.c:ofono_phonebook_driver_register() driver: 0x81037a4, name: isimodem
ofonod[2838]: src/network.c:ofono_netreg_driver_register() driver: 0x81037e0, name: isimodem
ofonod[2838]: src/voicecall.c:ofono_voicecall_driver_register() driver: 0x8103820, name: isimodem
ofonod[2838]: src/sms.c:ofono_sms_driver_register() driver: 0x8103880, name: isimodem
ofonod[2838]: src/cbs.c:ofono_cbs_driver_register() driver: 0x81038a0, name: isimodem
ofonod[2838]: src/sim.c:ofono_sim_driver_register() driver: 0x81038c0, name: isimodem
ofonod[2838]: src/ssn.c:ofono_ssn_driver_register() driver: 0x8103904, name: isimodem
ofonod[2838]: src/ussd.c:ofono_ussd_driver_register() driver: 0x8103910, name: isimodem
ofonod[2838]: src/call-forwarding.c:ofono_call_forwarding_driver_register() driver: 0x8103940, name: isimodem
ofonod[2838]: src/call-settings.c:ofono_call_settings_driver_register() driver: 0x8103960, name: isimodem
ofonod[2838]: src/call-barring.c:ofono_call_barring_driver_register() driver: 0x8103988, name: isimodem
ofonod[2838]: src/call-meter.c:ofono_call_meter_driver_register() driver: 0x81039a0, name: isimodem
ofonod[2838]: src/radio-settings.c:ofono_radio_settings_driver_register() driver: 0x81039c8, name: isimodem
ofonod[2838]: src/gprs.c:ofono_gprs_driver_register() driver: 0x81039dc, name: isimodem
ofonod[2838]: src/gprs.c:ofono_gprs_context_driver_register() driver: 0x81039f0, name: isimodem
ofonod[2838]: src/modem.c:ofono_modem_driver_register() driver: 0x8103780, name: isimodem
ofonod[2838]: plugins/bluetooth.c:manager_properties_cb() 
ofonod[2838]: plugins/bluetooth.c:parse_adapters() 
ofonod[2838]: plugins/bluetooth.c:parse_adapters() Calling GetProperties on /org/bluez/1195/hci0
ofonod[2838]: plugins/bluetooth.c:parse_devices() 
ofonod[2838]: plugins/bluetooth.c:adapter_properties_cb() Adapter Address: 00:25:D3:A1:3F:AD, Path: /org/bluez/1195/hci0
ofonod[2838]: src/modem.c:ofono_modem_create() name: (null), type: huawei
ofonod[2838]: src/modem.c:set_modem_property() modem 0x9bce1a8 property Path
ofonod[2838]: src/modem.c:set_modem_property() modem 0x9bce1a8 property Registered
ofonod[2838]: plugins/udev.c:add_modem() /devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1:1.0/ttyUSB0/tty/ttyUSB0 (huawei)
ofonod[2838]: plugins/udev.c:add_huawei() modem 0x9bce1a8
ofonod[2838]: src/modem.c:get_modem_property() modem 0x9bce1a8 property ModemRegistered
ofonod[2838]: src/modem.c:get_modem_property() modem 0x9bce1a8 property PcuiRegistered
ofonod[2838]: src/modem.c:set_modem_property() modem 0x9bce1a8 property Modem
ofonod[2838]: src/modem.c:set_modem_property() modem 0x9bce1a8 property ModemRegistered
ofonod[2838]: src/modem.c:get_modem_property() modem 0x9bce1a8 property Path
ofonod[2838]: plugins/udev.c:add_modem() /devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1:1.1/ttyUSB1/tty/ttyUSB1 (huawei)
ofonod[2838]: plugins/udev.c:add_huawei() modem 0x9bce1a8
ofonod[2838]: src/modem.c:get_modem_property() modem 0x9bce1a8 property ModemRegistered
ofonod[2838]: src/modem.c:get_modem_property() modem 0x9bce1a8 property PcuiRegistered
ofonod[2838]: src/modem.c:set_modem_property() modem 0x9bce1a8 property Pcui
ofonod[2838]: src/modem.c:set_modem_property() modem 0x9bce1a8 property PcuiRegistered
ofonod[2838]: plugins/huawei.c:huawei_probe() 0x9bce1a8
ofonod[2838]: plugins/huawei.c:huawei_enable() 0x9bce1a8
ofonod[2838]: src/modem.c:get_modem_property() modem 0x9bce1a8 property Modem
ofonod[2838]: plugins/huawei.c:open_device() Modem /dev/ttyUSB0
ofonod[2838]: src/modem.c:get_modem_property() modem 0x9bce1a8 property Pcui
ofonod[2838]: plugins/huawei.c:open_device() Pcui /dev/ttyUSB1
ofonod[2838]: Pcui:> ATE0\r
ofonod[2838]: Pcui:< ATE0\r\r\nOK\r\n
ofonod[2838]: Pcui:> AT+CFUN=1\r
ofonod[2838]: Pcui:< \r\nOK\r\n
ofonod[2838]: plugins/huawei.c:cfun_enable() 
ofonod[2838]: plugins/huawei.c:huawei_pre_sim() 0x9bce1a8
ofonod[2838]: plugins/huawei.c:query_sim_state() 
ofonod[2838]: Pcui:> AT^SYSINFO\r
ofonod[2838]: src/sim.c:ofono_sim_add_state_watch() 0x9be0410
ofonod[2838]: src/sim.c:ofono_sim_add_state_watch() 0x9be0410
ofonod[2838]: Pcui:< \r\n^SYSINFO:2,1,0,5,1,,4\r\n\r\nOK\r\n
ofonod[2838]: plugins/huawei.c:notify_sim_state() 1
ofonod[2838]: Pcui:> AT+CGMI\r
ofonod[2838]: Pcui:< \r\nhuawei\r\n\r\nOK\r\n
ofonod[2838]: Pcui:> AT+CRSM=176,28590,0,0,1\r
ofonod[2838]: Pcui:< \r\n+CME ERROR: not found\r\n
ofonod[2838]: Pcui:> AT+CGMM\r
ofonod[2838]: Pcui:< \r\nE226\r\n\r\nOK\r\n
ofonod[2838]: Pcui:> AT+CPIN?\r
ofonod[2838]: Pcui:< \r\n+CPIN: READY\r\n\r\nOK\r\n
ofonod[2838]: drivers/atmodem/sim.c:at_cpin_cb() crsm_pin_cb: READY
ofonod[2838]: Pcui:> AT+CRSM=192,12258\r
ofonod[2838]: Pcui:< \r\n+CRSM: 144,0,""\r\n\r\nOK\r\n
ofonod[2838]: drivers/atmodem/sim.c:at_crsm_info_cb() crsm_info_cb: 90, 00, 0
ofonod[2838]: Pcui:> AT+CGMR\r
ofonod[2838]: Pcui:< \r\n11.310.15.00.150\r\n\r\nOK\r\n
ofonod[2838]: Pcui:> AT+CIMI\r
ofonod[2838]: Pcui:< \r\n724053901897939\r\n\r\nOK\r\n
ofonod[2838]: drivers/atmodem/sim.c:at_cimi_cb() cimi_cb: 724053901897939
ofonod[2838]: Pcui:> AT+CRSM=192,28421\r
ofonod[2838]: Pcui:< \r\n+CRSM: 144,0,""\r\n\r\nOK\r\n
ofonod[2838]: drivers/atmodem/sim.c:at_crsm_info_cb() crsm_info_cb: 90, 00, 0
ofonod[2838]: Pcui:> AT+CGSN\r
ofonod[2838]: Pcui:< \r\n357650019550426\r\n\r\nOK\r\n
ofonod[2838]: Pcui:> AT+CRSM=192,12037\r
ofonod[2838]: Pcui:< \r\n+CRSM: 144,0,""\r\n\r\nOK\r\n
ofonod[2838]: drivers/atmodem/sim.c:at_crsm_info_cb() crsm_info_cb: 90, 00, 0
ofonod[2838]: Pcui:> AT+CRSM=192,28438\r
ofonod[2838]: Pcui:< \r\n+CRSM: 106,130,""\r\n\r\nOK\r\n
ofonod[2838]: plugins/huawei.c:huawei_post_sim() 0x9bce1a8 sim_state 1
ofonod[2838]: src/modem.c:get_modem_property() modem 0x9bce1a8 property HasVoice
ofonod[2838]: Pcui:> AT+CREG=?\r
ofonod[2838]: Pcui:< \r\n+CREG: (0-2)\r\n\r\nOK\r\n
ofonod[2838]: Pcui:> AT+CSMS=?\r
ofonod[2838]: Pcui:< \r\n+CSMS: (0-1)\r\n\r\nOK\r\n
ofonod[2838]: drivers/atmodem/sms.c:at_csms_query_cb() CSMS query parsed successfully
ofonod[2838]: Pcui:> AT+CSCB=?\r
ofonod[2838]: Pcui:< \r\n+CSCB: (0-1)\r\n\r\nOK\r\n
ofonod[2838]: Pcui:> AT+CUSD=1\r
ofonod[2838]: Pcui:< \r\nOK\r\n
ofonod[2838]: Pcui:> AT+CSCS=?\r
ofonod[2838]: Pcui:< \r\n+CSCS: ("IRA","GSM","UCS2")\r\n\r\nOK\r\n
ofonod[2838]: Pcui:> AT+CGDCONT=?\r
ofonod[2838]: Pcui:< \r\n+CGDCONT: (1-16),"IP",,,(0-2),(0-4)\r\n+CGDCONT: (1-16),"PPP",,,(0-2),(0-4)\r\n+CGDCONT: (1-16),"IPV6",,,(0-2),(0-4)\r\n\r\nOK\r\n
ofonod[2838]: Pcui:> AT+CRSM=192,28480\r
ofonod[2838]: Pcui:< \r\n+CRSM: 144,0,""\r\n\r\nOK\r\n
ofonod[2838]: drivers/atmodem/sim.c:at_crsm_info_cb() crsm_info_cb: 90, 00, 0
ofonod[2838]: Pcui:> AT+CREG=2\r
ofonod[2838]: Pcui:< \r\nOK\r\n
ofonod[2838]: Pcui:> AT+CSMS=1\r
ofonod[2838]: Pcui:< \r\n+CSMS: 1,1,1\r\n\r\nOK\r\n
ofonod[2838]: Pcui:> AT+CSCB=1,"0-65535"\r
ofonod[2838]: Pcui:< \r\nOK\r\n
ofonod[2838]: src/cbs.c:cbs_got_imsi() Got IMSI: 724053901897939
ofonod[2838]: src/network.c:__ofono_netreg_add_status_watch() 0x9bdff38
ofonod[2838]: Pcui:> AT+CPBS=?\r
ofonod[2838]: Pcui:< \r\n+CPBS: ("SM","DC","FD","LD","MC","ME","RC","EN","ON")\r\n\r\nOK\r\n
ofonod[2838]: Pcui:> AT+CGREG=?\r
ofonod[2838]: Pcui:< \r\n+CGREG: (0-2)\r\n\r\nOK\r\n
ofonod[2838]: Pcui:> AT+CRSM=192,28589\r
ofonod[2838]: Pcui:< \r\n+CRSM: 144,0,""\r\n\r\nOK\r\n
ofonod[2838]: drivers/atmodem/sim.c:at_crsm_info_cb() crsm_info_cb: 90, 00, 0
ofonod[2838]: Pcui:> AT+CREG?\r
ofonod[2838]: Pcui:< \r\n+CREG: 2,1,754F,830452\r\n\r\nOK\r\n
ofonod[2838]: src/cbs.c:cbs_location_changed() 1, 30031, 8586322, -1, (null)(null)
ofonod[2838]: Pcui:> AT+CSMS?\r
ofonod[2838]: Pcui:< \r\n+CSMS: ,1,1,1\r\n\r\nOK\r\n
ofonod[2838]: Pcui:> AT+CGREG=2\r
ofonod[2838]: Pcui:< \r\nOK\r\n
ofonod[2838]: Pcui:> AT+CGAUTO=0\r
ofonod[2838]: Pcui:< \r\nCOMMAND NOT SUPPORT\r\n
ofonod[2838]: Pcui:> AT+CGEREP=2,1\r
ofonod[2838]: Pcui:< \r\nOK\r\n
ofonod[2838]: src/network.c:__ofono_netreg_add_status_watch() 0x9bdff38
ofonod[2838]: Pcui:> AT+CRSM=192,28489\r
ofonod[2838]: Pcui:< \r\n+CRSM: 144,0,""\r\n\r\nOK\r\n
ofonod[2838]: drivers/atmodem/sim.c:at_crsm_info_cb() crsm_info_cb: 90, 00, 0
ofonod[2838]: Pcui:> AT+COPS=3,2\r
ofonod[2838]: Pcui:< \r\nOK\r\n
ofonod[2838]: Pcui:> AT+COPS?\r
ofonod[2838]: Pcui:< \r\n+COPS: 0,2,"72405",2\r\n\r\nOK\r\n
ofonod[2838]: drivers/atmodem/network-registration.c:cops_numeric_cb() Cops numeric got mcc: 724, mnc: 05
ofonod[2838]: Pcui:> AT+CSQ\r
ofonod[2838]: Pcui:< \r\n+CSQ: 22,99\r\n\r\nOK\r\n
ofonod[2838]: drivers/atmodem/network-registration.c:csq_cb() csq_cb: 22
ofonod[2838]: Pcui:> AT+CMGF=?\r
ofonod[2838]: Pcui:< \r\n+CMGF: (0-1)\r\n\r\nOK\r\n
ofonod[2838]: Pcui:> AT+CGATT=1\r
ofonod[2838]: Pcui:< \r\n+CREG: 1,754F,830452\r\n\r\n+CGREG: 1,754F,830452\r\n
ofonod[2838]: src/gprs.c:netreg_status_changed() 1
ofonod[2838]: src/cbs.c:cbs_location_changed() 1, 30031, 8586322, -1, (null)(null)
ofonod[2838]: Pcui:< \r\nOK\r\n
ofonod[2838]: Pcui:> AT+CRSM=192,28613\r
ofonod[2838]: Pcui:< \r\n+CRSM: 144,0,""\r\n\r\nOK\r\n
ofonod[2838]: drivers/atmodem/sim.c:at_crsm_info_cb() crsm_info_cb: 90, 00, 0
ofonod[2838]: Pcui:> AT+COPS=3,0\r
ofonod[2838]: Pcui:< \r\nOK\r\n
ofonod[2838]: Pcui:> AT+COPS?\r
ofonod[2838]: Pcui:< \r\n+COPS: 0,0,"Claro BR",2\r\n\r\nOK\r\n
ofonod[2838]: drivers/atmodem/network-registration.c:cops_cb() cops_cb: Claro BR, 724 05 2
ofonod[2838]: src/network.c:current_operator_callback() 0x9bdff38, (nil)
ofonod[2838]: src/gprs.c:netreg_status_changed() 1
ofonod[2838]: src/cbs.c:cbs_location_changed() 1, 30031, 8586322, -1, 72405
ofonod[2838]: src/cbs.c:cbs_location_changed() 1, 0, 0
ofonod[2838]: Pcui:> AT+CPMS=?\r
ofonod[2838]: Pcui:< \r\n+CPMS: ("ME","MT","SM","SR"),("ME","MT","SM","SR"),("ME","MT","SM","SR")\r\n\r\nOK\r\n
ofonod[2838]: Pcui:> AT+COPS=3,2\r
ofonod[2838]: Pcui:< \r\nOK\r\n
ofonod[2838]: Pcui:> AT+COPS?\r
ofonod[2838]: Pcui:< \r\n+COPS: 0,2,"72405",2\r\n\r\nOK\r\n
ofonod[2838]: drivers/atmodem/network-registration.c:cops_numeric_cb() Cops numeric got mcc: 724, mnc: 05
ofonod[2838]: Pcui:> AT+CGREG?\r
ofonod[2838]: Pcui:< \r\n+CGREG: 2,1,754F,830452\r\n\r\nOK\r\n
ofonod[2838]: Pcui:> AT+CRSM=192,28486\r
ofonod[2838]: Pcui:< \r\n+CRSM: 144,0,""\r\n\r\nOK\r\n
ofonod[2838]: drivers/atmodem/sim.c:at_crsm_info_cb() crsm_info_cb: 90, 00, 0
ofonod[2838]: Pcui:> AT+CMGF=0\r
ofonod[2838]: Pcui:< \r\nOK\r\n
ofonod[2838]: Pcui:> AT+COPS=3,0\r
ofonod[2838]: Pcui:< \r\nOK\r\n
ofonod[2838]: Pcui:> AT+COPS?\r
ofonod[2838]: Pcui:< \r\n+COPS: 0,0,"Claro BR",2\r\n\r\nOK\r\n
ofonod[2838]: drivers/atmodem/network-registration.c:cops_cb() cops_cb: Claro BR, 724 05 2
ofonod[2838]: src/network.c:current_operator_callback() 0x9bdff38, 0x9bce538
ofonod[2838]: Pcui:> AT+CRSM=192,28488\r
ofonod[2838]: Pcui:< \r\n+CRSM: 144,0,""\r\n\r\nOK\r\n
ofonod[2838]: drivers/atmodem/sim.c:at_crsm_info_cb() crsm_info_cb: 90, 00, 0
ofonod[2838]: Pcui:> AT+CPMS="ME","ME","ME"\r
ofonod[2838]: Pcui:< \r\n+CPMS: 0,255,0,255,0,255\r\n\r\nOK\r\n
ofonod[2838]: Pcui:> AT+CSCB=1\r
ofonod[2838]: Pcui:< \r\nOK\r\n
ofonod[2838]: Pcui:> AT+CSCB=0,"4352-4356"\r
ofonod[2838]: Pcui:< \r\nOK\r\n
ofonod[2838]: Pcui:> AT+CNMI=?\r
ofonod[2838]: Pcui:< \r\n+CNMI: (0,1,2),(0,1,2,3),(0,2),(0,1,2),(0,1)\r\n\r\nOK\r\n
ofonod[2838]: Pcui:> AT+CNMI=1,1,2,1,0\r
ofonod[2838]: Pcui:< \r\nOK\r\n
ofonod[2838]: Pcui:> AT+CMGL=4\r
ofonod[2838]: Pcui:< \r\nOK\r\n
ofonod[2838]: Pcui:> AT+CGSMS=3\r
ofonod[2838]: Pcui:< \r\nOK\r\n
ofonod[2838]: Pcui:< \r\n^RSSI:19\r\n

Re: Connecting with Huawei E226

[Denis Kenzior]

[-- Attachment #1: Type: text/plain, Size: 2394 bytes --]

Hi Thiago,

On 08/24/2010 05:58 PM, Thiago Cangussu de Castro Gomes wrote:
> On Tue, Aug 24, 2010 at 7:16 PM, Denis Kenzior <denkenz@gmail.com> wrote:
>> Hi Thiago,
>>
>> On 08/24/2010 03:25 PM, Thiago Cangussu de Castro Gomes wrote:
>>> On Wed, Aug 18, 2010 at 7:31 PM, Denis Kenzior <denkenz@gmail.com> wrote:
>>>>>> For your particular case these patches from Kalle would be helpful:
>>>>>>
>>>>>> [PATCH 1/2] huawei: poll sim state
>>>>>> [PATCH 2/2] huawei: postpone post_sim until SIM is ready
>>>>>>
>>>>>> However, they weren't integrated upstream due to some concerns.  See the
>>>>>> entire thread for more details.
>>>>>
>>>>> I've applied the patches but unfortunately it didn't fixed the issue.
>>>>> Still can't connect when the modem is plugged after ofonod is started.
>>>>> I can send the logs if anyone thinks it's useful.
>>>>>
>>>>
>>>> Sorry to hear you're having trouble.  Kalle reported similar issues were
>>>> fixed with his patches on the E1552.  Sending the logs would probably be
>>>> helpful.
>>>
>>> Here are (attached) the logs. I turned off connman. The two tests scenarios are:
>>>
>>> Test A (connect-modem-after-fast.log)
>>>
>>> - start ofono
>>> - plug the modem
>>> - call enable-modem just after inserting the modem
>>>
>>> Test B (connect-modem-after-slow.log)
>>>
>>> - start ofono
>>> - plug the modem
>>> - wait until the modem led switches from green to blue
>>> - call enable-modem after some seconds
>>>
>>> The second scenario is what happens when connmand is running, and is
>>> the most common use case: someone plugs in the modem with the system
>>> running.
>>
>> It seems you forgot to include the actual logs.
> 
> Let me try again :)
> 
> I forgot also to mention that I used list-context to see if the
> enable-modem was successful. The test B is the one that fails.

From the logs it seems Test A is what fails since we never add any atoms
in that one.  Basically the problem is that your modem firmware never
tells us that the SIM has been initialized by sending us a ^SIMST
notification.

Kalle's patch relies on SIMST being delivered eventually.  Since it
never does, oFono is under the impression that your SIM is invalid.  We
probably need to query SYSINFO a few more times in this case, but it
seems all Huawei firmwares act slightly differently here.

Regards,
-Denis

Re: Connecting with Huawei E226

[Thiago Cangussu de Castro Gomes]

[-- Attachment #1: Type: text/plain, Size: 1275 bytes --]

On Tue, Aug 24, 2010 at 8:45 PM, Denis Kenzior <denkenz@gmail.com> wrote:
>> Let me try again :)
>>
>> I forgot also to mention that I used list-context to see if the
>> enable-modem was successful. The test B is the one that fails.
>
> From the logs it seems Test A is what fails since we never add any atoms
> in that one.  Basically the problem is that your modem firmware never
> tells us that the SIM has been initialized by sending us a ^SIMST
> notification.
>
> Kalle's patch relies on SIMST being delivered eventually.  Since it
> never does, oFono is under the impression that your SIM is invalid.  We
> probably need to query SYSINFO a few more times in this case, but it
> seems all Huawei firmwares act slightly differently here.

Is there something else I can do to help solve this issue? I tried
another modem, a ZTE MF110, that is not working either. I installed
wvdial on my MeeGo machine and was able to connect using both the
Huawei and ZTE modems. I also tested the devices under Ubuntu Lucid
and Fedora 13 (both with Networkmanager) and they worked out of the
box.

Those devices are supplied by some of the major wireless carriers here
in Brazil, so it would be nice to have them working with ofono/MeeGo.

Thanks,
Thiago

Re: Connecting with Huawei E226

[Marcel Holtmann]

[-- Attachment #1: Type: text/plain, Size: 1556 bytes --]

Hi Thiago,

> >> I forgot also to mention that I used list-context to see if the
> >> enable-modem was successful. The test B is the one that fails.
> >
> > From the logs it seems Test A is what fails since we never add any atoms
> > in that one.  Basically the problem is that your modem firmware never
> > tells us that the SIM has been initialized by sending us a ^SIMST
> > notification.
> >
> > Kalle's patch relies on SIMST being delivered eventually.  Since it
> > never does, oFono is under the impression that your SIM is invalid.  We
> > probably need to query SYSINFO a few more times in this case, but it
> > seems all Huawei firmwares act slightly differently here.
> 
> Is there something else I can do to help solve this issue? I tried
> another modem, a ZTE MF110, that is not working either. I installed
> wvdial on my MeeGo machine and was able to connect using both the
> Huawei and ZTE modems. I also tested the devices under Ubuntu Lucid
> and Fedora 13 (both with Networkmanager) and they worked out of the
> box.

the problem is that neither wvdial nor NM are proper telephony stacks.
They are both in the end just dialers. So that comparison is not helping
us since oFono has to do way more work before we can just "dial" an
Internet connection.

We get this fixed, but not as quick as you might like us too. The Huawei
and ZTE modems are showing race condition behavior. And that is mainly
because oFono is just too fast and they can't initialize the SIM fast
enough for us.

Regards

Marcel

Re: Connecting with Huawei E226

[Thiago Cangussu de Castro Gomes]

[-- Attachment #1: Type: text/plain, Size: 2269 bytes --]

Hi Marcel,
On Fri, Aug 27, 2010 at 5:02 AM, Marcel Holtmann <marcel@holtmann.org> wrote:
> Hi Thiago,
>
>> >> I forgot also to mention that I used list-context to see if the
>> >> enable-modem was successful. The test B is the one that fails.
>> >
>> > From the logs it seems Test A is what fails since we never add any atoms
>> > in that one.  Basically the problem is that your modem firmware never
>> > tells us that the SIM has been initialized by sending us a ^SIMST
>> > notification.
>> >
>> > Kalle's patch relies on SIMST being delivered eventually.  Since it
>> > never does, oFono is under the impression that your SIM is invalid.  We
>> > probably need to query SYSINFO a few more times in this case, but it
>> > seems all Huawei firmwares act slightly differently here.
>>
>> Is there something else I can do to help solve this issue? I tried
>> another modem, a ZTE MF110, that is not working either. I installed
>> wvdial on my MeeGo machine and was able to connect using both the
>> Huawei and ZTE modems. I also tested the devices under Ubuntu Lucid
>> and Fedora 13 (both with Networkmanager) and they worked out of the
>> box.
>
> the problem is that neither wvdial nor NM are proper telephony stacks.
> They are both in the end just dialers. So that comparison is not helping
> us since oFono has to do way more work before we can just "dial" an
> Internet connection.
>
> We get this fixed, but not as quick as you might like us too. The Huawei
> and ZTE modems are showing race condition behavior. And that is mainly
> because oFono is just too fast and they can't initialize the SIM fast
> enough for us.

I understand. I mixed up two problems and that got confusing. The ZTE
modem is not showing the race condition issue. It didn't showed up
when I called list-modems. That is why I tested it with other
software, just to be sure it works with linux (MeeGo in this case). I
will test again with the ZTE modem and send the logs to the list.

I am reading the code and some specs from 3GPP, but it's all new stuff
to me and you will probably fix this before I can even understand what
is really going on :) For now I'll keep testing the new code and
sending the logs to the list.

Regards,
Thiago

Re: Connecting with Huawei E226

[Marcel Holtmann]

[-- Attachment #1: Type: text/plain, Size: 2096 bytes --]

Hi Thiago,

> >> >> I forgot also to mention that I used list-context to see if the
> >> >> enable-modem was successful. The test B is the one that fails.
> >> >
> >> > From the logs it seems Test A is what fails since we never add any atoms
> >> > in that one.  Basically the problem is that your modem firmware never
> >> > tells us that the SIM has been initialized by sending us a ^SIMST
> >> > notification.
> >> >
> >> > Kalle's patch relies on SIMST being delivered eventually.  Since it
> >> > never does, oFono is under the impression that your SIM is invalid.  We
> >> > probably need to query SYSINFO a few more times in this case, but it
> >> > seems all Huawei firmwares act slightly differently here.
> >>
> >> Is there something else I can do to help solve this issue? I tried
> >> another modem, a ZTE MF110, that is not working either. I installed
> >> wvdial on my MeeGo machine and was able to connect using both the
> >> Huawei and ZTE modems. I also tested the devices under Ubuntu Lucid
> >> and Fedora 13 (both with Networkmanager) and they worked out of the
> >> box.
> >
> > the problem is that neither wvdial nor NM are proper telephony stacks.
> > They are both in the end just dialers. So that comparison is not helping
> > us since oFono has to do way more work before we can just "dial" an
> > Internet connection.
> >
> > We get this fixed, but not as quick as you might like us too. The Huawei
> > and ZTE modems are showing race condition behavior. And that is mainly
> > because oFono is just too fast and they can't initialize the SIM fast
> > enough for us.
> 
> I understand. I mixed up two problems and that got confusing. The ZTE
> modem is not showing the race condition issue. It didn't showed up
> when I called list-modems. That is why I tested it with other
> software, just to be sure it works with linux (MeeGo in this case). I
> will test again with the ZTE modem and send the logs to the list.

my ZTE modem works, but you need the latest oFono and its udev rules to
make it detect.

Regards

Marcel

Re: Connecting with Huawei E226

[Thiago Cangussu de Castro Gomes]

[-- Attachment #1: Type: text/plain, Size: 2475 bytes --]

>> I understand. I mixed up two problems and that got confusing. The ZTE
>> modem is not showing the race condition issue. It didn't showed up
>> when I called list-modems. That is why I tested it with other
>> software, just to be sure it works with linux (MeeGo in this case). I
>> will test again with the ZTE modem and send the logs to the list.
>
> my ZTE modem works, but you need the latest oFono and its udev rules to
> make it detect.

I'm using ofono from git (last commit from yesterday) and the udev
rules are installed and loaded. The ZTE is a MF110.

When I plug the device, I need to call eject /dev/sr0, only after that
it is recognized correctly. After that, the following appears on ofono
log:

ofonod[1632]: src/modem.c:ofono_modem_create() name: P671A2VIVD010000, type: zte
ofonod[1632]: src/modem.c:set_modem_property() modem 0x87ca1b0 property Path
ofonod[1632]: src/modem.c:set_modem_property() modem 0x87ca1b0
property Registered
ofonod[1632]: plugins/udev.c:add_modem()
/devices/pci0000:00/0000:00:1d.7/usb1/1-1/1-1:1.0/ttyUSB0/tty/ttyUSB0
(zte)
ofonod[1632]: plugins/udev.c:add_zte() modem 0x87ca1b0
ofonod[1632]: src/modem.c:get_modem_property() modem 0x87ca1b0
property ModemRegistered
ofonod[1632]: src/modem.c:get_modem_property() modem 0x87ca1b0
property AuxRegistered
ofonod[1632]: src/modem.c:get_modem_property() modem 0x87ca1b0 property Path
ofonod[1632]: plugins/udev.c:add_modem()
/devices/pci0000:00/0000:00:1d.7/usb1/1-1/1-1:1.3/ttyUSB2/tty/ttyUSB2
(zte)
ofonod[1632]: plugins/udev.c:add_zte() modem 0x87ca1b0
ofonod[1632]: src/modem.c:get_modem_property() modem 0x87ca1b0
property ModemRegistered
ofonod[1632]: src/modem.c:get_modem_property() modem 0x87ca1b0
property AuxRegistered
ofonod[1632]: src/modem.c:get_modem_property() modem 0x87ca1b0 property Path
ofonod[1632]: plugins/udev.c:add_modem()
/devices/pci0000:00/0000:00:1d.7/usb1/1-1/1-1:1.1/ttyUSB1/tty/ttyUSB1
(zte)
ofonod[1632]: plugins/udev.c:add_zte() modem 0x87ca1b0
ofonod[1632]: src/modem.c:get_modem_property() modem 0x87ca1b0
property ModemRegistered
ofonod[1632]: src/modem.c:get_modem_property() modem 0x87ca1b0
property AuxRegistered

After that, if I run list-modems nothing happens.

I don't know if it is related, but I'm getting lots of error messages
from option driver:

option: option_instat_callback: error -2

They appear as soon as the modem is detected (after eject /dev/sr0).

Regards,
Thiago

Re: Connecting with Huawei E226

[Marcel Holtmann]

[-- Attachment #1: Type: text/plain, Size: 2794 bytes --]

Hi Thiago,

> >> I understand. I mixed up two problems and that got confusing. The ZTE
> >> modem is not showing the race condition issue. It didn't showed up
> >> when I called list-modems. That is why I tested it with other
> >> software, just to be sure it works with linux (MeeGo in this case). I
> >> will test again with the ZTE modem and send the logs to the list.
> >
> > my ZTE modem works, but you need the latest oFono and its udev rules to
> > make it detect.
> 
> I'm using ofono from git (last commit from yesterday) and the udev
> rules are installed and loaded. The ZTE is a MF110.
> 
> When I plug the device, I need to call eject /dev/sr0, only after that
> it is recognized correctly. After that, the following appears on ofono
> log:

just install usb_modeswitch package and it will do this for you.

> ofonod[1632]: src/modem.c:ofono_modem_create() name: P671A2VIVD010000, type: zte
> ofonod[1632]: src/modem.c:set_modem_property() modem 0x87ca1b0 property Path
> ofonod[1632]: src/modem.c:set_modem_property() modem 0x87ca1b0
> property Registered
> ofonod[1632]: plugins/udev.c:add_modem()
> /devices/pci0000:00/0000:00:1d.7/usb1/1-1/1-1:1.0/ttyUSB0/tty/ttyUSB0
> (zte)
> ofonod[1632]: plugins/udev.c:add_zte() modem 0x87ca1b0
> ofonod[1632]: src/modem.c:get_modem_property() modem 0x87ca1b0
> property ModemRegistered
> ofonod[1632]: src/modem.c:get_modem_property() modem 0x87ca1b0
> property AuxRegistered
> ofonod[1632]: src/modem.c:get_modem_property() modem 0x87ca1b0 property Path
> ofonod[1632]: plugins/udev.c:add_modem()
> /devices/pci0000:00/0000:00:1d.7/usb1/1-1/1-1:1.3/ttyUSB2/tty/ttyUSB2
> (zte)
> ofonod[1632]: plugins/udev.c:add_zte() modem 0x87ca1b0
> ofonod[1632]: src/modem.c:get_modem_property() modem 0x87ca1b0
> property ModemRegistered
> ofonod[1632]: src/modem.c:get_modem_property() modem 0x87ca1b0
> property AuxRegistered
> ofonod[1632]: src/modem.c:get_modem_property() modem 0x87ca1b0 property Path
> ofonod[1632]: plugins/udev.c:add_modem()
> /devices/pci0000:00/0000:00:1d.7/usb1/1-1/1-1:1.1/ttyUSB1/tty/ttyUSB1
> (zte)
> ofonod[1632]: plugins/udev.c:add_zte() modem 0x87ca1b0
> ofonod[1632]: src/modem.c:get_modem_property() modem 0x87ca1b0
> property ModemRegistered
> ofonod[1632]: src/modem.c:get_modem_property() modem 0x87ca1b0
> property AuxRegistered
> 
> After that, if I run list-modems nothing happens.
> 
> I don't know if it is related, but I'm getting lots of error messages
> from option driver:
> 
> option: option_instat_callback: error -2
> 
> They appear as soon as the modem is detected (after eject /dev/sr0).

Sounds like a kernel bug. Which one are you using?

However show us your /proc/bus/usb/devices content for this modem.

Regards

Marcel

Re: Connecting with Huawei E226

[Thiago Cangussu de Castro Gomes]

[-- Attachment #1: Type: text/plain, Size: 1362 bytes --]

>> I don't know if it is related, but I'm getting lots of error messages
>> from option driver:
>>
>> option: option_instat_callback: error -2
>>
>> They appear as soon as the modem is detected (after eject /dev/sr0).
>
> Sounds like a kernel bug. Which one are you using?

2.6.33.5

> However show us your /proc/bus/usb/devices content for this modem.

T:  Bus=01 Lev=01 Prnt=01 Port=00 Cnt=01 Dev#=  6 Spd=480 MxCh= 0
D:  Ver= 2.00 Cls=00(>ifc ) Sub=00 Prot=00 MxPS=64 #Cfgs=  1
P:  Vendor=19d2 ProdID=0031 Rev= 0.00
C:* #Ifs= 4 Cfg#= 1 Atr=e0 MxPwr=500mA
I:* If#= 0 Alt= 0 #EPs= 2 Cls=ff(vend.) Sub=ff Prot=ff Driver=option
E:  Ad=81(I) Atr=02(Bulk) MxPS= 512 Ivl=0ms
E:  Ad=01(O) Atr=02(Bulk) MxPS= 512 Ivl=4ms
I:* If#= 1 Alt= 0 #EPs= 2 Cls=ff(vend.) Sub=ff Prot=ff Driver=option
E:  Ad=82(I) Atr=02(Bulk) MxPS= 512 Ivl=0ms
E:  Ad=02(O) Atr=02(Bulk) MxPS= 512 Ivl=4ms
I:* If#= 2 Alt= 0 #EPs= 2 Cls=08(stor.) Sub=06 Prot=50 Driver=usb-storage
E:  Ad=03(O) Atr=02(Bulk) MxPS= 512 Ivl=0ms
E:  Ad=83(I) Atr=02(Bulk) MxPS= 512 Ivl=0ms
I:* If#= 3 Alt= 0 #EPs= 3 Cls=ff(vend.) Sub=ff Prot=ff Driver=option
E:  Ad=84(I) Atr=03(Int.) MxPS=  64 Ivl=2ms
E:  Ad=85(I) Atr=02(Bulk) MxPS= 512 Ivl=0ms
E:  Ad=04(O) Atr=02(Bulk) MxPS= 512 Ivl=4ms

From lsusb:

Bus 001 Device 006: ID 19d2:0031 ONDA Communication S.p.A.

Regards,
Thiago

Re: Connecting with Huawei E226

[Marcel Holtmann]

[-- Attachment #1: Type: text/plain, Size: 1658 bytes --]

Hi Thiago,

> >> I don't know if it is related, but I'm getting lots of error messages
> >> from option driver:
> >>
> >> option: option_instat_callback: error -2
> >>
> >> They appear as soon as the modem is detected (after eject /dev/sr0).
> >
> > Sounds like a kernel bug. Which one are you using?
> 
> 2.6.33.5
> 
> > However show us your /proc/bus/usb/devices content for this modem.
> 
> T:  Bus=01 Lev=01 Prnt=01 Port=00 Cnt=01 Dev#=  6 Spd=480 MxCh= 0
> D:  Ver= 2.00 Cls=00(>ifc ) Sub=00 Prot=00 MxPS=64 #Cfgs=  1
> P:  Vendor=19d2 ProdID=0031 Rev= 0.00
> C:* #Ifs= 4 Cfg#= 1 Atr=e0 MxPwr=500mA
> I:* If#= 0 Alt= 0 #EPs= 2 Cls=ff(vend.) Sub=ff Prot=ff Driver=option
> E:  Ad=81(I) Atr=02(Bulk) MxPS= 512 Ivl=0ms
> E:  Ad=01(O) Atr=02(Bulk) MxPS= 512 Ivl=4ms
> I:* If#= 1 Alt= 0 #EPs= 2 Cls=ff(vend.) Sub=ff Prot=ff Driver=option
> E:  Ad=82(I) Atr=02(Bulk) MxPS= 512 Ivl=0ms
> E:  Ad=02(O) Atr=02(Bulk) MxPS= 512 Ivl=4ms
> I:* If#= 2 Alt= 0 #EPs= 2 Cls=08(stor.) Sub=06 Prot=50 Driver=usb-storage
> E:  Ad=03(O) Atr=02(Bulk) MxPS= 512 Ivl=0ms
> E:  Ad=83(I) Atr=02(Bulk) MxPS= 512 Ivl=0ms
> I:* If#= 3 Alt= 0 #EPs= 3 Cls=ff(vend.) Sub=ff Prot=ff Driver=option
> E:  Ad=84(I) Atr=03(Int.) MxPS=  64 Ivl=2ms
> E:  Ad=85(I) Atr=02(Bulk) MxPS= 512 Ivl=0ms
> E:  Ad=04(O) Atr=02(Bulk) MxPS= 512 Ivl=4ms
> 
> From lsusb:
> 
> Bus 001 Device 006: ID 19d2:0031 ONDA Communication S.p.A.

so for sure the udev rule for your modem was missing. I added that one
now.

If the option driver is causing a problem, then I don't know. However I
am using a 2.6.33.6 F13 kernel without any problems.

Regards

Marcel