maemo.org - Talk - View Single Post - N900 Cant access the modem.

Dimand	2011-09-19 , 13:10
Posts: 18 \| Thanked: 2 times \| Joined on Aug 2010	#5

Ok, fairly sure this is a case of same symptoms different problem.

I removed the cellular antena and booted the device. NO ERRORS! This is not actually surprising. The phone simply assumed that I had no signal, there is no difference to the modem if it sends a request and either a, there is no one to reply or b the request never made it. Obviously the modem doesn't check radiation impedance to make sure there is an antenna there, that would be mostly useless.

Anyway, I reinsert the antenna with device still powered on. About 5 seconds later i have signal. Here is the syslog of this event:

Code:

Sep 19 22:29:10 Nokia-N900 kernel: [  258.118194] ******
Sep 19 22:29:10 Nokia-N900 kernel: [  258.118225] * CMT rst line change detected (0)
Sep 19 22:29:10 Nokia-N900 kernel: [  258.118225] *****
Sep 19 22:29:10 Nokia-N900 kernel: [  258.118347] McSAAB: ACWake line 00000000
Sep 19 22:29:10 Nokia-N900 kernel: [  258.118347] McSAAB: CAWake line 0
Sep 19 22:29:10 Nokia-N900 kernel: [  258.118347] McSAAB: Main state: 2
Sep 19 22:29:10 Nokia-N900 kernel: [  258.118377] McSAAB: RX state:00
Sep 19 22:29:10 Nokia-N900 kernel: [  258.118377] McSAAB: TX state:00
Sep 19 22:29:10 Nokia-N900 kernel: [  258.118408] McSAAB: CMT was ONLINE
Sep 19 22:29:10 Nokia-N900 kernel: [  258.118408] McSAAB: FLAGS: 0001
Sep 19 22:29:10 Nokia-N900 kernel: [  258.118408] McSAAB: Last RX control msg 00000000
Sep 19 22:29:10 Nokia-N900 kernel: [  258.118438] McSAAB: Last TX control msg 50000000
Sep 19 22:29:10 Nokia-N900 kernel: [  258.118438] McSAAB: TX C queue head 2 tail 2
Sep 19 22:29:10 Nokia-N900 kernel: [  258.118469] McSAAB: Data RX ID: 225
Sep 19 22:29:10 Nokia-N900 kernel: [  258.118469] McSAAB: Data TX ID: 105
Sep 19 22:29:10 Nokia-N900 kernel: [  258.118469] McSAAB: TX queue len: 0
Sep 19 22:29:10 Nokia-N900 kernel: [  258.118499] McSAAB: RX queue len: 0
Sep 19 22:29:10 Nokia-N900 cellular: csd[789]: com.nokia.csd.GPRS: Phonet down - resetting
Sep 19 22:29:10 Nokia-N900 cellular: ssc[747]: SSI connection DOWN
Sep 19 22:29:10 Nokia-N900 cellular: ssc[747]: Unexpected modem reset, waiting for modem reboot
Sep 19 22:29:10 Nokia-N900 cellular: ssc[747]: Starting cmt restart timeout
Sep 19 22:29:10 Nokia-N900 cellular: csd[789]: com.nokia.phone.net: net_phonet_link_status: link DOWN
Sep 19 22:29:10 Nokia-N900 cellular: csd[789]: com.nokia.phone.SIM: phonebook_phonet_link_status: link DOWN
Sep 19 22:29:10 Nokia-N900 kernel: [  258.510162] McSAAB: ACWAKE DOWN
Sep 19 22:29:10 Nokia-N900 kernel: [  258.510345] McSAAB: ACWAKE UP
Sep 19 22:29:10 Nokia-N900 kernel: [  258.510589] McSAAB: WAKELINES TEST OK
Sep 19 22:29:10 Nokia-N900 cellular: csd[789]: com.nokia.csd.GPRS: Phonet up - activating
Sep 19 22:29:10 Nokia-N900 cellular: csd[789]: com.nokia.phone.net: net_phonet_link_status: link UP
Sep 19 22:29:10 Nokia-N900 cellular: csd[789]: com.nokia.phone.SIM: phonebook_phonet_link_status: link UP
Sep 19 22:29:10 Nokia-N900 cellular: csd[789]: com.nokia.phone.SIM: phonebook_phonet_link_status: status of isi_router_start: 0x1
Sep 19 22:29:10 Nokia-N900 cellular: csd[789]: ISI_SMS .645385> isi_sms_restart(): self:0x1ea90
Sep 19 22:29:10 Nokia-N900 cellular: csd[789]: com.nokia.phone.SIM: phonebook_sim_pb_get_conf_resp_phase1 failed: status: 0xFB
Sep 19 22:29:10 Nokia-N900 cellular: ssc[747]: CMT self tests passed.
Sep 19 22:29:11 Nokia-N900 cellular: csd[789]: com.nokia.phone.SIM: SIM_IND - default case, cause: 151
Sep 19 22:29:11 Nokia-N900 cellular: csd[789]: com.nokia.phone.SIM: SIM_IND - default case, cause: 1
Sep 19 22:29:11 Nokia-N900 cellular: csd[789]: com.nokia.phone.SIM: SIM_IND - default case, cause: 1
Sep 19 22:29:11 Nokia-N900 cellular: csd[789]: com.nokia.phone.SIM: SIM_IND - default case, cause: 42
Sep 19 22:29:12 Nokia-N900 cellular: csd[789]: com.nokia.phone.SIM: SIM_IND - default case, cause: 11
Sep 19 22:29:12 Nokia-N900 cellular: csd[789]: com.nokia.phone.SIM: SIM_IND - default case, cause: 31
Sep 19 22:29:12 Nokia-N900 cellular: csd[789]: com.nokia.phone.SIM: fdn disabled: 0x1
Sep 19 22:29:12 Nokia-N900 cellular: csd[789]: com.nokia.phone.SIM: SIM_IND - default case, cause: 79
Sep 19 22:29:12 Nokia-N900 cellular: csd[789]: com.nokia.phone.SIM: SIM_IND - default case, cause: 31
Sep 19 22:29:12 Nokia-N900 cellular: csd[789]: com.nokia.phone.SIM: fdn disabled: 0x1
Sep 19 22:29:12 Nokia-N900 cellular: csd[789]: com.nokia.phone.SIM: SIM_IND - default case, cause: 79
Sep 19 22:29:12 Nokia-N900 cellular: csd[789]: com.nokia.phone.SIM: fdn disabled: 0x1
Sep 19 22:29:12 Nokia-N900 location-proxy[1159]: GLIB DEBUG default - Socket registration ok
Sep 19 22:29:12 Nokia-N900 location-proxy[1159]: GLIB DEBUG default - LAS configured for supl-server
Sep 19 22:29:12 Nokia-N900 location-proxy[1159]: GLIB DEBUG default - LAS privacy registration ok
Sep 19 22:29:12 Nokia-N900 cellular: ssc[747]: change to normal mode, ape ready, sim ready
Sep 19 22:29:12 Nokia-N900 cellular: ssc[747]: change mode to MTC_NORMAL
Sep 19 22:29:20 Nokia-N900 cellular: csd[789]: ISI_SMS .761017> isiclient_sms_timeout(): TIMEOUT in SMS_STATE_INITIAL
Sep 19 22:29:20 Nokia-N900 cellular: csd[789]: ISI_SMS .761658> isiclient_sms_run(): SMS_STATE_INITIAL
Sep 19 22:29:20 Nokia-N900 cellular: csd[789]: ISI_SMS .763794> resp_sim_refresh_register(): rc:0
Sep 19 22:29:20 Nokia-N900 cellular: csd[789]: ISI_SMS .764313> common_message(): SMS ISI Version = 4.1
Sep 19 22:29:20 Nokia-N900 cellular: csd[789]: ISI_SMS .764709> isiclient_sms_run(): SMS_STATE_START_CS_STATE (get cs & reg status)
Sep 19 22:29:20 Nokia-N900 cellular: csd[789]: ISI_SMS .766113> resp_cs_state(): Net state rc:0 cs state:1, mode:0
Sep 19 22:29:20 Nokia-N900 cellular: csd[789]: ISI_SMS .766571> resp_reg_status(): Net registration (req) status: 0, rc:4
Sep 19 22:29:20 Nokia-N900 cellular: csd[789]: ISI_SMS .804077> resp_sim_get_parameters(): rc:0 tr_id:0x00, validity:0xfd
Sep 19 22:29:20 Nokia-N900 cellular: csd[789]: ISI_SMS .804870> resp_sim_get_parameters(): Service centre:'+61411990001'
Sep 19 22:29:20 Nokia-N900 cellular: csd[789]: ISI_SMS .805542> resp_sim_get_parameters(): Alpha:'+614119'
Sep 19 22:29:20 Nokia-N900 cellular: csd[789]: ISI_SMS .806335> resp_sim_get_parameters(): Service centre:'+61411990001' read from the sim
Sep 19 22:29:21 Nokia-N900 cellular: csd[789]: ISI_SMS .186401> ind_reg_status(): Net registration (ind) status:1 rc:0
Sep 19 22:29:21 Nokia-N900 cellular: csd[789]: ISI_SMS .190521> isiclient_sms_run(): SMS_STATE_START (sms_pp_routing_req, sms_gsm_cb_routing_req, [sms_storage_status_update_req], sim_sms_req_read_parameter)
Sep 19 22:29:21 Nokia-N900 cellular: csd[789]: ISI_SMS .192901> resp_cell_broadcast_subscription(): Incoming cell broadcast receive status:0 OK
Sep 19 22:29:21 Nokia-N900 cellular: csd[789]: ISI_SMS .193847> resp_sim_get_parameters(): rc:0 tr_id:0x00, validity:0xfd
Sep 19 22:29:21 Nokia-N900 cellular: csd[789]: ISI_SMS .194488> resp_sim_get_parameters(): Service centre:'+61411990001'
Sep 19 22:29:21 Nokia-N900 cellular: csd[789]: ISI_SMS .195129> resp_sim_get_parameters(): Alpha:'+614119'
Sep 19 22:29:21 Nokia-N900 cellular: csd[789]: ISI_SMS .195678> resp_sim_get_parameters(): Service centre:'+61411990001' read from the sim
Sep 19 22:29:21 Nokia-N900 cellular: csd[789]: ISI_SMS .196441> resp_sms_subscription(): Incoming sms receive status:0 OK
Sep 19 22:29:21 Nokia-N900 cellular: csd[789]: ISI_SMS .197143> resp_sms_resume(): ok internal resume request
Sep 19 22:29:21 Nokia-N900 cellular: csd[789]: ISI_SMS .197754> set_timeout(): Timeout 3479 s event type:-1
Sep 19 22:29:21 Nokia-N900 wlancond[1157]: Country changed to: 505
Sep 19 22:29:21 Nokia-N900 cellular: csd[789]: com.nokia.phone.net: get_network_time_info returned: y:11 m:9 d:19 h:12 m:29 s:21 tz:40 dl:0
Sep 19 22:29:21 Nokia-N900 clockd: Date now is 2011-09-19 22:29:21 (DST OFF), TZ=/Australia/Brisbane, offset -36000/-36000, timezone=-36000, tzname=EST/EST
Sep 19 22:29:21 Nokia-N900 clockd: Date now is 2011-09-19 22:29:21 (DST OFF), TZ=/Australia/Brisbane, offset -36000/-36000, timezone=-36000, tzname=EST/EST
Sep 19 22:29:24 Nokia-N900 cellular: csd[789]: ISI_SMS .855926> incoming_cell_broadcast(): Incoming cell broadcast

Now, I removed and reinserted the antenna multiple times, same thing, no issues. just like going in and out of signal. Here is the Syslog event of taking out the antena:

Code:

Sep 19 22:40:11 Nokia-N900 wlancond[1157]: Low signal
Sep 19 22:40:11 Nokia-N900 kernel: [  919.722717] wlan0: roaming signal from driver, sending LOWSIGNAL
Sep 19 22:40:11 Nokia-N900 browserd: New e:0x5b008, g:0x41640, ctx:(nil)
Sep 19 22:40:12 Nokia-N900 browserd: New e:0x5b1c0, g:0x416a0, ctx:(nil)
Sep 19 22:40:12 Nokia-N900 browserd: New e:0x5b378, g:0x41700, ctx:(nil)
Sep 19 22:40:12 Nokia-N900 kernel: [  920.951904] wlan0: roaming signal from driver, sending HIGHSIGNAL
Sep 19 22:40:12 Nokia-N900 wlancond[1157]: High signal
Sep 19 22:40:12 Nokia-N900 browserd[1613]: GLIB CRITICAL ** Gtk - gtk_widget_set_sensitive: assertion `GTK_IS_WIDGET (widget)' failed
Sep 19 22:40:24 Nokia-N900 cellular: csd[789]: ISI_SMS .857666> ind_reg_status(): Net registration (ind) status:0 rc:4
Sep 19 22:40:25 Nokia-N900 systemui-tklock[1025]: Method call received from: :1.10, iface: com.nokia.system_ui.request, method: tklock_open
Sep 19 22:40:29 Nokia-N900 systemui-tklock[1025]: Method call received from: :1.10, iface: com.nokia.system_ui.request, method: tklock_close
Sep 19 22:40:32 Nokia-N900 cellular: csd[789]: ISI_SMS .902130> ind_reg_status(): Net registration (ind) status:0 rc:10
Sep 19 22:40:32 Nokia-N900 bluetoothd[929]: get_operator_name failed with code 1000
Sep 19 22:40:32 Nokia-N900 iap_conndlg 2.88+0m5[1278]: Unable to show SIM registration failed dialog
Sep 19 22:40:32 Nokia-N900 iap_conndlg 2.88+0m5[1278]: Unable to show SIM registration failed dialog
Sep 19 22:40:37 Nokia-N900 wlancond[1157]: Low signal
Sep 19 22:40:37 Nokia-N900 kernel: [  945.732971] wlan0: roaming signal from driver, sending LOWSIGNAL
Sep 19 22:40:38 Nokia-N900 kernel: [  946.859161] wlan0: roaming signal from driver, sending HIGHSIGNAL
Sep 19 22:40:38 Nokia-N900 wlancond[1157]: High signal
Sep 19 22:41:00 Nokia-N900 systemui-tklock[1025]: Method call received from: :1.10, iface: com.nokia.system_ui.request, method: tklock_open

Apart from this. I have found a new set of error messages that seem to be related with this problem:

Code:

Sep 19 22:52:18 Nokia-N900 rtcom-call-ui[1507]: GLIB WARNING ** libebook - e_vcard_attribute_get_value called on multivalued attribute ADR
Sep 19 22:52:20 Nokia-N900 rtcom-call-ui[1507]: GLIB DEBUG mc-client - request_create_cb called with /com/nokia/MissionControl/requests/r1
Sep 19 22:52:20 Nokia-N900 rtcom-call-ui[1507]: GLIB DEBUG mc-client - on_request_succeeded called for /com/nokia/MissionControl/requests/r1
Sep 19 22:52:20 Nokia-N900 telepathy-ring[1083]: GLIB MESSAGE Modem-Call - trying to create call to "number removed for privacy"
Sep 19 22:52:22 Nokia-N900 kernel: [ 1651.359771] McSAAB: ------- TX WATCHDOG TIMER trigerred -----
Sep 19 22:52:22 Nokia-N900 kernel: [ 1651.359802] McSAAB: ACWake line 00000001
Sep 19 22:52:22 Nokia-N900 kernel: [ 1651.359802] McSAAB: CAWake line 0
Sep 19 22:52:22 Nokia-N900 kernel: [ 1651.359832] McSAAB: Main state: 2
Sep 19 22:52:22 Nokia-N900 kernel: [ 1651.359832] McSAAB: RX state:00
Sep 19 22:52:22 Nokia-N900 kernel: [ 1651.359832] McSAAB: TX state:01
Sep 19 22:52:22 Nokia-N900 kernel: [ 1651.359863] McSAAB: CMT was ONLINE
Sep 19 22:52:22 Nokia-N900 kernel: [ 1651.359863] McSAAB: FLAGS: 0001
Sep 19 22:52:22 Nokia-N900 kernel: [ 1651.359863] McSAAB: Last RX control msg 00000000
Sep 19 22:52:22 Nokia-N900 kernel: [ 1651.359893] McSAAB: Last TX control msg 50000000
Sep 19 22:52:22 Nokia-N900 kernel: [ 1651.359893] McSAAB: TX C queue head 0 tail 0
Sep 19 22:52:22 Nokia-N900 kernel: [ 1651.359893] McSAAB: Data RX ID: 209
Sep 19 22:52:22 Nokia-N900 kernel: [ 1651.359924] McSAAB: Data TX ID: 68
Sep 19 22:52:22 Nokia-N900 kernel: [ 1651.359924] McSAAB: TX queue len: 2
Sep 19 22:52:22 Nokia-N900 kernel: [ 1651.359924] McSAAB: TX HEAD packet:
Sep 19 22:52:22 Nokia-N900 kernel: [ 1651.359954] McSAAB: cbed2460: 15 00 6c 01 06 00 00 5d 00 a4 aa 00              ..l....]....
Sep 19 22:52:22 Nokia-N900 kernel: [ 1651.359954] McSAAB: END TX HEAD packet.
Sep 19 22:52:22 Nokia-N900 kernel: [ 1651.359985] McSAAB: RX queue len: 0
Sep 19 22:52:22 Nokia-N900 cellular: ssc[747]: SSI connection DOWN
Sep 19 22:52:22 Nokia-N900 cellular: ssc[747]: Unexpected modem reset, waiting for modem reboot
Sep 19 22:52:22 Nokia-N900 cellular: ssc[747]: Starting cmt restart timeout
Sep 19 22:52:23 Nokia-N900 cellular: csd[789]: com.nokia.csd.GPRS: Phonet down - resetting
Sep 19 22:52:23 Nokia-N900 cellular: csd[789]: com.nokia.phone.net: net_phonet_link_status: link DOWN
Sep 19 22:52:23 Nokia-N900 cellular: csd[789]: com.nokia.phone.SIM: phonebook_phonet_link_status: link DOWN
Sep 19 22:52:23 Nokia-N900 cellular: csd[789]: com.nokia.phone.net: net_read_oper_name_req completed: PHONE_MESSAGE_SEND_FAIL
Sep 19 22:52:23 Nokia-N900 bluetoothd[929]: get_operator_name failed with code 2
Sep 19 22:52:28 Nokia-N900 cellular: ssc[747]: Cold starting cmt
Sep 19 22:52:28 Nokia-N900 kernel: [ 1656.411743] ******
Sep 19 22:52:28 Nokia-N900 kernel: [ 1656.411773] * CMT rst line change detected (0)
Sep 19 22:52:28 Nokia-N900 kernel: [ 1656.411773] *****
Sep 19 22:52:28 Nokia-N900 kernel: [ 1656.411895] McSAAB: ACWake line 00000000
Sep 19 22:52:28 Nokia-N900 kernel: [ 1656.411895] McSAAB: CAWake line 0
Sep 19 22:52:28 Nokia-N900 kernel: [ 1656.411895] McSAAB: Main state: 0
Sep 19 22:52:28 Nokia-N900 kernel: [ 1656.411926] McSAAB: RX state:00
Sep 19 22:52:28 Nokia-N900 kernel: [ 1656.411926] McSAAB: TX state:00
Sep 19 22:52:28 Nokia-N900 kernel: [ 1656.411926] McSAAB: CMT was OFFLINE
Sep 19 22:52:28 Nokia-N900 kernel: [ 1656.411956] McSAAB: FLAGS: 0000
Sep 19 22:52:28 Nokia-N900 kernel: [ 1656.411956] McSAAB: Last RX control msg 00000000
Sep 19 22:52:28 Nokia-N900 kernel: [ 1656.411956] McSAAB: Last TX control msg 50000000
Sep 19 22:52:28 Nokia-N900 kernel: [ 1656.411987] McSAAB: TX C queue head 0 tail 0
Sep 19 22:52:28 Nokia-N900 kernel: [ 1656.411987] McSAAB: Data RX ID: 0
Sep 19 22:52:28 Nokia-N900 kernel: [ 1656.411987] McSAAB: Data TX ID: 0
Sep 19 22:52:28 Nokia-N900 kernel: [ 1656.412017] McSAAB: TX queue len: 0
Sep 19 22:52:28 Nokia-N900 kernel: [ 1656.412017] McSAAB: RX queue len: 0
Sep 19 22:52:33 Nokia-N900 cellular: ssc[747]: modem connection cannot be established, retry (1 of 10)

Still looking for as much help as possible and thank you Omkar for the suggestion, but I believe this is not my problem.

Quote & Reply |

The Following User Says Thank You to Dimand For This Useful Post:
reinob