Reactivating context after SIM reinsertion fails sometimes (telit UC864G modem)

All of lore.kernel.org
 help / color / mirror / Atom feed

* Reactivating context after SIM reinsertion fails sometimes (telit UC864G modem)
@ 2012-08-24 10:10 Christopher Vogl
  0 siblings, 0 replies; only message in thread
From: Christopher Vogl @ 2012-08-24 10:10 UTC (permalink / raw)
  To: ofono

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

Hi,

when I remove the SIM after a valid ppp connection and insert it again, 
the activation of the primary context often fails. The data port seems 
to be inactive at that time and AT+CGDCONT=1,"IP","gprswap" is not sent. 
The ppp connection seems to get shut down properly though.

I compared the output after removing the SIM with the output when it 
worked and I can't see any difference. Could this be a "timing problem"? 
How can I tell if the modem is ready for +CGDCONT again, i.e. which URC 
would tell me that? In that case I could defer the sending of+CGDCONT.  
I'm lacking knowledge and experience to solve this.



Valid ppp connection

...
...
Aug 22 09:13:13 mx31tt01 daemon.info ofonod[969]: Aux: < \r\n+CRSM: 
106,130\r\n\r\nOK\r\n
Aug 22 09:13:13 mx31tt01 daemon.info ofonod[969]: Aux: > AT+CRSM=192,28618\r
Aug 22 09:13:13 mx31tt01 daemon.info ofonod[969]: Aux: < \r\n+CRSM: 
144,0,62218205022100050183026FCAA5038001318A01058B036F060B800200058800F10100\r\n\r\nOK\r\n
Aug 22 09:13:13 mx31tt01 daemon.debug ofonod[969]: 
drivers/atmodem/sim.c:at_crsm_info_cb() crsm_info_cb: 90, 00, 35
Aug 22 09:13:13 mx31tt01 daemon.info ofonod[969]: Aux: > 
AT+CRSM=178,28618,1,4,5\r
Aug 22 09:13:13 mx31tt01 daemon.debug ofonod[969]: 
drivers/atmodem/gprs-context.c:at_gprs_activate_primary() cid 1
Aug 22 09:13:13 mx31tt01 daemon.info ofonod[969]: Modem: > 
AT+CGDCONT=1,"IP","gprswap"\r
Aug 22 09:13:13 mx31tt01 daemon.info ofonod[969]: Aux: < \r\n+CRSM: 
144,0,0000000000\r\n\r\nOK\r\n
Aug 22 09:13:13 mx31tt01 daemon.debug ofonod[969]: 
drivers/atmodem/sim.c:at_crsm_read_cb() crsm_read_cb: 90, 00, 5
Aug 22 09:13:13 mx31tt01 daemon.info ofonod[969]: Aux: > AT+CRSM=192,28617\r
Aug 22 09:13:13 mx31tt01 daemon.info ofonod[969]: Modem: < \r\nOK\r\n
Aug 22 09:13:13 mx31tt01 daemon.debug ofonod[969]: 
drivers/atmodem/gprs-context.c:at_cgdcont_cb() ok 1
Aug 22 09:13:13 mx31tt01 daemon.info ofonod[969]: Modem: > 
AT+CGDATA="PPP",1\r
Aug 22 09:13:14 mx31tt01 daemon.info ofonod[969]: Aux: < \r\n+CRSM: 
144,0,62218205022100040183026FC9A5038001318A01058B036F060B800200048800F10100\r\n\r\nOK\r\n
Aug 22 09:13:14 mx31tt01 daemon.debug ofonod[969]: 
drivers/atmodem/sim.c:at_crsm_info_cb() crsm_info_cb: 90, 00, 35
Aug 22 09:13:14 mx31tt01 daemon.info ofonod[969]: Aux: > 
AT+CRSM=178,28617,1,4,4\r
Aug 22 09:13:14 mx31tt01 daemon.info ofonod[969]: Modem: < \r\nCONNECT\r\n
Aug 22 09:13:14 mx31tt01 daemon.debug ofonod[969]: 
drivers/atmodem/gprs-context.c:at_cgdata_cb() ok 1
Aug 22 09:13:14 mx31tt01 daemon.debug ofonod[969]: 
drivers/atmodem/gprs-context.c:setup_ppp()
Aug 22 09:13:14 mx31tt01 daemon.info ofonod[969]: PPP: lcp: 
pppcp_generate_event: current state 0:INITIAL
Aug 22 09:13:14 mx31tt01 daemon.info ofonod[969]: PPP: event: 0 (Up), 
action: 2, new_state: 2 (CLOSED)
Aug 22 09:13:14 mx31tt01 daemon.info ofonod[969]: PPP: lcp: 
pppcp_generate_event: current state 2:CLOSED
Aug 22 09:13:14 mx31tt01 daemon.info ofonod[969]: PPP: event: 2 (Open), 
action: 1026, new_state: 6 (REQSENT)
Aug 22 09:13:14 mx31tt01 daemon.info ofonod[969]: PPP: lcp: 
pppcp_initialize_restart_count: current state 2:CLOSED
Aug 22 09:13:14 mx31tt01 daemon.info ofonod[969]: PPP: lcp: 
pppcp_send_configure_request: current state 2:CLOSED
Aug 22 09:13:14 mx31tt01 daemon.info ofonod[969]: PPP: 
gatchat/gatppp.c:ppp_enter_phase() 1
Aug 22 09:13:14 mx31tt01 daemon.info ofonod[969]: PPP: lcp: 
pppcp_process_configure_request: current state 6:REQSENT
Aug 22 09:13:14 mx31tt01 daemon.info ofonod[969]: PPP: lcp: 
pppcp_generate_event: current state 6:REQSENT
Aug 22 09:13:14 mx31tt01 daemon.info ofonod[969]: PPP: event: 6 (RCR+), 
action: 2008, new_state: 8 (ACKSENT)
Aug 22 09:13:14 mx31tt01 daemon.info ofonod[969]: PPP: lcp: 
pppcp_send_configure_ack: current state 6:REQSENT
Aug 22 09:13:14 mx31tt01 daemon.info ofonod[969]: PPP: lcp: 
pppcp_process_configure_ack: current state 8:ACKSENT
Aug 22 09:13:14 mx31tt01 daemon.info ofonod[969]: PPP: lcp: 
pppcp_generate_event: current state 8:ACKSENT
Aug 22 09:13:14 mx31tt01 daemon.info ofonod[969]: PPP: event: 8 (RCA), 
action: 129, new_state: 9 (OPENED)
Aug 22 09:13:14 mx31tt01 daemon.info ofonod[969]: PPP: lcp: 
pppcp_initialize_restart_count: current state 8:ACKSENT
Aug 22 09:13:14 mx31tt01 daemon.info ofonod[969]: PPP: 
gatchat/gatppp.c:ppp_enter_phase() 2
Aug 22 09:13:14 mx31tt01 daemon.info ofonod[969]: PPP: 
gatchat/gatppp.c:ppp_enter_phase() 3
Aug 22 09:13:14 mx31tt01 daemon.info ofonod[969]: PPP: ipcp: 
pppcp_generate_event: current state 0:INITIAL
Aug 22 09:13:14 mx31tt01 daemon.info ofonod[969]: PPP: event: 2 (Open), 
action: 401, new_state: 1 (STARTING)
Aug 22 09:13:14 mx31tt01 daemon.info ofonod[969]: PPP: ipcp: 
pppcp_generate_event: current state 1:STARTING
Aug 22 09:13:14 mx31tt01 daemon.info ofonod[969]: PPP: event: 0 (Up), 
action: 1026, new_state: 6 (REQSENT)
Aug 22 09:13:14 mx31tt01 daemon.info ofonod[969]: PPP: ipcp: 
pppcp_initialize_restart_count: current state 1:STARTING
Aug 22 09:13:14 mx31tt01 daemon.info ofonod[969]: PPP: ipcp: 
pppcp_send_configure_request: current state 1:STARTING
Aug 22 09:13:14 mx31tt01 daemon.info ofonod[969]: Aux: < \r\n+CRSM: 
144,0,01000000\r\n\r\nOK\r\n
Aug 22 09:13:14 mx31tt01 daemon.debug ofonod[969]: 
drivers/atmodem/sim.c:at_crsm_read_cb() crsm_read_cb: 90, 00, 4
Aug 22 09:13:14 mx31tt01 daemon.info ofonod[969]: Aux: > AT+CRSM=192,28433\r
Aug 22 09:13:14 mx31tt01 daemon.info ofonod[969]: Aux: < \r\n+CRSM: 
106,130\r\n\r\nOK\r\n
Aug 22 09:13:14 mx31tt01 daemon.debug ofonod[969]: 
src/message-waiting.c:mw_cphs_mwis_read_cb() No CPHS MWIS on SIM
Aug 22 09:13:14 mx31tt01 daemon.info ofonod[969]: Aux: > AT+CRSM=192,28435\r
Aug 22 09:13:15 mx31tt01 daemon.info ofonod[969]: Aux: < \r\n+CRSM: 
106,130\r\n\r\nOK\r\n
Aug 22 09:13:15 mx31tt01 daemon.debug ofonod[969]: 
src/simfs.c:sim_fs_op_read_block() bufoff: 0, seekoff: 39, toread: 17
Aug 22 09:13:15 mx31tt01 daemon.info ofonod[969]: Aux: > AT+CRSM=192,28437\r
Aug 22 09:13:15 mx31tt01 daemon.info ofonod[969]: PPP: ipcp: 
pppcp_process_configure_request: current state 6:REQSENT
Aug 22 09:13:15 mx31tt01 daemon.info ofonod[969]: PPP: ipcp: 
pppcp_generate_event: current state 6:REQSENT
Aug 22 09:13:15 mx31tt01 daemon.info ofonod[969]: PPP: event: 6 (RCR+), 
action: 2008, new_state: 8 (ACKSENT)
Aug 22 09:13:15 mx31tt01 daemon.info ofonod[969]: PPP: ipcp: 
pppcp_send_configure_ack: current state 6:REQSENT
Aug 22 09:13:15 mx31tt01 daemon.info ofonod[969]: PPP: ipcp: 
pppcp_process_configure_reject: current state 8:ACKSENT
Aug 22 09:13:15 mx31tt01 daemon.info ofonod[969]: PPP: ipcp: 
pppcp_generate_event: current state 8:ACKSENT
Aug 22 09:13:15 mx31tt01 daemon.info ofonod[969]: PPP: event: 9 (RCN), 
action: 1028, new_state: 8 (ACKSENT)
Aug 22 09:13:15 mx31tt01 daemon.info ofonod[969]: PPP: ipcp: 
pppcp_initialize_restart_count: current state 8:ACKSENT
Aug 22 09:13:15 mx31tt01 daemon.info ofonod[969]: PPP: ipcp: 
pppcp_send_configure_request: current state 8:ACKSENT
Aug 22 09:13:15 mx31tt01 daemon.info ofonod[969]: PPP: ipcp: 
pppcp_process_configure_nak: current state 8:ACKSENT
Aug 22 09:13:15 mx31tt01 daemon.info ofonod[969]: PPP: ipcp: 
pppcp_generate_event: current state 8:ACKSENT
Aug 22 09:13:15 mx31tt01 daemon.info ofonod[969]: PPP: event: 9 (RCN), 
action: 1028, new_state: 8 (ACKSENT)
Aug 22 09:13:15 mx31tt01 daemon.info ofonod[969]: PPP: ipcp: 
pppcp_initialize_restart_count: current state 8:ACKSENT
Aug 22 09:13:15 mx31tt01 daemon.info ofonod[969]: PPP: ipcp: 
pppcp_send_configure_request: current state 8:ACKSENT
Aug 22 09:13:15 mx31tt01 daemon.info ofonod[969]: PPP: ipcp: 
pppcp_process_configure_ack: current state 8:ACKSENT
Aug 22 09:13:15 mx31tt01 daemon.info ofonod[969]: PPP: ipcp: 
pppcp_generate_event: current state 8:ACKSENT
Aug 22 09:13:15 mx31tt01 daemon.info ofonod[969]: PPP: event: 8 (RCA), 
action: 129, new_state: 9 (OPENED)
Aug 22 09:13:15 mx31tt01 daemon.info ofonod[969]: PPP: ipcp: 
pppcp_initialize_restart_count: current state 8:ACKSENT
Aug 22 09:13:15 mx31tt01 daemon.info ofonod[969]: PPP: 
gatchat/gatppp.c:ppp_enter_phase() 4
Aug 22 09:13:15 mx31tt01 daemon.debug ofonod[969]: 
drivers/atmodem/gprs-context.c:ppp_connect()
Aug 22 09:13:15 mx31tt01 daemon.info ofonod[969]: IP: 10.146.191.130
Aug 22 09:13:15 mx31tt01 daemon.info ofonod[969]: DNS: 213.162.69.169, 
213.162.69.170
Aug 22 09:13:15 mx31tt01 daemon.debug ofonod[969]: 
src/gprs.c:pri_activate_callback() 0x198af48
Aug 22 09:13:15 mx31tt01 daemon.debug ofonod[969]: 
plugins/udev.c:udev_event() subsystem net add
Aug 22 09:13:15 mx31tt01 daemon.debug ofonod[969]: 
plugins/udev.c:udev_event() subsystem net finished
Aug 22 09:13:15 mx31tt01 daemon.info ofonod[969]: Aux: < \r\n+CRSM: 
106,130\r\n\r\nOK\r\n
Aug 22 09:13:15 mx31tt01 daemon.info ofonod[969]: Aux: > AT+CRSM=192,28615\r
Aug 22 09:13:15 mx31tt01 daemon.info ofonod[969]: Aux: < \r\n+CRSM: 
144,0,622182050221001E0183026FC7A5038001318A01058B036F060B8002001E8800F10100\r\n\r\nOK\r\n
Aug 22 09:13:15 mx31tt01 daemon.debug ofonod[969]: 
drivers/atmodem/sim.c:at_crsm_info_cb() crsm_info_cb: 90, 00, 35
Aug 22 09:13:15 mx31tt01 daemon.info ofonod[969]: Aux: > 
AT+CRSM=178,28615,1,4,30\r
Aug 22 09:13:15 mx31tt01 daemon.info ofonod[969]: Aux: < \r\n+CRSM: 
144,0,542D4D6F62696C6520426F78FFFFFFFF069134762602F0FFFFFFFFFFFFFF\r\n\r\nOK\r\n
Aug 22 09:13:15 mx31tt01 daemon.debug ofonod[969]: 
drivers/atmodem/sim.c:at_crsm_read_cb() crsm_read_cb: 90, 00, 30
Aug 22 09:13:16 mx31tt01 daemon.debug ofonod[969]: 
plugins/udevng.c:check_modem_list()


Removing the SIM:

Aug 22 09:13:28 mx31tt01 daemon.info ofonod[969]: Aux: < \r\n#QSS: 0\r\n
Aug 22 09:13:28 mx31tt01 daemon.debug ofonod[969]: 
plugins/telit.c:telit_qss_notify() 0x19812d8
Aug 22 09:13:28 mx31tt01 daemon.debug ofonod[969]: 
plugins/telit.c:switch_sim_state_status() 0x19812d8, SIM status: 0
Aug 22 09:13:28 mx31tt01 daemon.debug ofonod[969]: 
src/modem.c:modem_change_state() old state: 3, new state: 1
Aug 22 09:13:28 mx31tt01 daemon.debug ofonod[969]: 
src/modem.c:flush_atoms()
Aug 22 09:13:28 mx31tt01 daemon.debug ofonod[969]: 
src/message-waiting.c:mw_remove() atom: 0x198bf58
Aug 22 09:13:28 mx31tt01 daemon.debug ofonod[969]: 
src/call-barring.c:call_barring_remove() atom: 0x198bcc0
Aug 22 09:13:28 mx31tt01 daemon.debug ofonod[969]: 
src/call-meter.c:call_meter_remove() atom: 0x198bbb8
Aug 22 09:13:28 mx31tt01 daemon.debug ofonod[969]: 
src/call-settings.c:call_settings_remove() atom: 0x198baf8
Aug 22 09:13:28 mx31tt01 daemon.debug ofonod[969]: 
src/call-forwarding.c:call_forwarding_remove() atom: 0x198ba20
Aug 22 09:13:28 mx31tt01 daemon.debug ofonod[969]: 
src/ussd.c:ussd_remove() atom: 0x198b900
Aug 22 09:13:28 mx31tt01 daemon.debug ofonod[969]: 
drivers/atmodem/gprs-context.c:at_gprs_detach_shutdown() cid 1
Aug 22 09:13:28 mx31tt01 daemon.info ofonod[969]: PPP: lcp: 
pppcp_generate_event: current state 9:OPENED
Aug 22 09:13:28 mx31tt01 daemon.info ofonod[969]: PPP: event: 3 (Close), 
action: 8224, new_state: 4 (CLOSING)
Aug 22 09:13:28 mx31tt01 daemon.info ofonod[969]: PPP: lcp: 
pppcp_initialize_restart_count: current state 9:OPENED
Aug 22 09:13:28 mx31tt01 daemon.info ofonod[969]: PPP: lcp: 
pppcp_send_terminate_request: current state 9:OPENED
Aug 22 09:13:28 mx31tt01 daemon.info ofonod[969]: PPP: ipcp: 
pppcp_generate_event: current state 9:OPENED
Aug 22 09:13:28 mx31tt01 daemon.info ofonod[969]: PPP: event: 1 (Down), 
action: 201, new_state: 1 (STARTING)
Aug 22 09:13:28 mx31tt01 user.debug kernel: [ 2980.301385] PM: Removing 
info for No Bus:ppp0
Aug 22 09:13:28 mx31tt01 daemon.info ofonod[969]: PPP: 
gatchat/gatppp.c:ppp_enter_phase() 5
Aug 22 09:13:28 mx31tt01 daemon.debug ofonod[969]: 
src/sim.c:ofono_sim_remove_spn_watch() 0x195eba8
Aug 22 09:13:28 mx31tt01 daemon.debug ofonod[969]: 
src/network.c:netreg_remove() atom: 0x198b7f0
Aug 22 09:13:28 mx31tt01 daemon.debug ofonod[969]: 
src/gprs.c:gprs_context_unregister() 0x198e7e8, 0x198e528
Aug 22 09:13:28 mx31tt01 daemon.debug ofonod[969]: 
src/gprs.c:gprs_context_remove() atom: 0x198e808
Aug 22 09:13:28 mx31tt01 daemon.debug ofonod[969]: 
drivers/atmodem/gprs-context.c:at_gprs_context_remove()
Aug 22 09:13:28 mx31tt01 daemon.debug ofonod[969]: 
src/gprs.c:gprs_unregister() 0x198e528
Aug 22 09:13:28 mx31tt01 daemon.debug ofonod[969]: 
src/gprs.c:gprs_remove() atom: 0x197c680
Aug 22 09:13:28 mx31tt01 daemon.debug ofonod[969]: 
plugins/udevng.c:remove_device() /sys/devices/virtual/net/ppp0
Aug 22 09:13:28 mx31tt01 daemon.debug ofonod[969]: 
plugins/udev.c:udev_event() subsystem net remove
Aug 22 09:13:28 mx31tt01 daemon.debug ofonod[969]: 
plugins/udev.c:remove_modem() /devices/virtual/net/ppp0
Aug 22 09:13:28 mx31tt01 daemon.debug ofonod[969]: 
plugins/udev.c:udev_event() subsystem net finished
Aug 22 09:13:28 mx31tt01 daemon.info ofonod[969]: Modem: < 
~\377}#\300!}%}6} }$\255\316~
Aug 22 09:13:28 mx31tt01 daemon.info ofonod[969]: Aux: < \r\n+CGEV: NW 
DEACT IP, 10.146.191.130, 1\r\n
Aug 22 09:13:29 mx31tt01 daemon.info ofonod[969]: Aux: < \r\n#PSNT: 4\r\n
Aug 22 09:13:29 mx31tt01 daemon.info ofonod[969]: Aux: < \r\n+CIEV: 
service,0\r\n
Aug 22 09:13:29 mx31tt01 daemon.info ofonod[969]: Aux: < \r\n+CREG: 0\r\n
Aug 22 09:13:29 mx31tt01 daemon.info ofonod[969]: Aux: < \r\n+CGREG: 0\r\n
Aug 22 09:13:29 mx31tt01 daemon.info ofonod[969]: Aux: < \r\n+CIEV: 
roam,1\r\n
Aug 22 09:13:31 mx31tt01 daemon.info ofonod[969]: Modem: < 
~\377}#\300!}%}7} }$q\224~
Aug 22 09:13:34 mx31tt01 daemon.info ofonod[969]: Modem: < \r\nNO 
CARRIER\r\n
Aug 22 09:13:34 mx31tt01 daemon.info ofonod[969]: Modem: < \r\n+CIEV: 
service,0\r\n
Aug 22 09:13:34 mx31tt01 daemon.info ofonod[969]: Modem: < \r\n+CIEV: 
roam,1\r\n
Aug 22 09:13:34 mx31tt01 daemon.info ofonod[969]: Modem: < \r\n+CGEV: NW 
DEACT IP, 10.146.191.130, 1\r\n



Inserting the SIM again:

Aug 22 09:13:52 mx31tt01 daemon.info ofonod[969]: Modem: < \r\n#QSS: 1\r\n
Aug 22 09:13:52 mx31tt01 daemon.info ofonod[969]: Aux: < \r\n#QSS: 1\r\n
Aug 22 09:13:52 mx31tt01 daemon.debug ofonod[969]: 
plugins/telit.c:telit_qss_notify() 0x19812d8
Aug 22 09:13:52 mx31tt01 daemon.debug ofonod[969]: 
plugins/telit.c:switch_sim_state_status() 0x19812d8, SIM status: 1
Aug 22 09:13:52 mx31tt01 daemon.info ofonod[969]: Aux: > AT+CRSM=192,28599\r
Aug 22 09:13:52 mx31tt01 daemon.info ofonod[969]: Aux: < \r\n+CRSM: 
144,0,62228205022100100383026FB7A5038001318A01058B036F060680020030880108F10100\r\n\r\nOK\r\n
Aug 22 09:13:52 mx31tt01 daemon.debug ofonod[969]: 
drivers/atmodem/sim.c:at_crsm_info_cb() crsm_info_cb: 90, 00, 36
Aug 22 09:13:52 mx31tt01 daemon.err ofonod[969]: Requested file 
structure differs from SIM: 6fb7
Aug 22 09:13:52 mx31tt01 daemon.debug ofonod[969]: 
src/voicecall.c:ecc_g2_read_cb() 0
Aug 22 09:13:52 mx31tt01 daemon.info ofonod[969]: Aux: > AT+CRSM=192,28599\r
Aug 22 09:13:52 mx31tt01 daemon.info ofonod[969]: Aux: < \r\n+CRSM: 
144,0,62228205022100100383026FB7A5038001318A01058B036F060680020030880108F10100\r\n\r\nOK\r\n
Aug 22 09:13:52 mx31tt01 daemon.debug ofonod[969]: 
drivers/atmodem/sim.c:at_crsm_info_cb() crsm_info_cb: 90, 00, 36
Aug 22 09:13:52 mx31tt01 daemon.info ofonod[969]: Aux: > 
AT+CRSM=178,28599,1,4,16\r
Aug 22 09:13:53 mx31tt01 daemon.info ofonod[969]: Aux: < \r\n+CRSM: 
144,0,FFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFF\r\n\r\nOK\r\n
Aug 22 09:13:53 mx31tt01 daemon.debug ofonod[969]: 
drivers/atmodem/sim.c:at_crsm_read_cb() crsm_read_cb: 90, 00, 16
Aug 22 09:13:53 mx31tt01 daemon.debug ofonod[969]: 
src/voicecall.c:ecc_g3_read_cb() 1
Aug 22 09:13:53 mx31tt01 daemon.info ofonod[969]: Aux: > 
AT+CRSM=178,28599,2,4,16\r
Aug 22 09:13:53 mx31tt01 daemon.info ofonod[969]: Aux: < \r\n+CRSM: 
144,0,FFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFF\r\n\r\nOK\r\n
Aug 22 09:13:53 mx31tt01 daemon.debug ofonod[969]: 
drivers/atmodem/sim.c:at_crsm_read_cb() crsm_read_cb: 90, 00, 16
Aug 22 09:13:53 mx31tt01 daemon.debug ofonod[969]: 
src/voicecall.c:ecc_g3_read_cb() 1
Aug 22 09:13:53 mx31tt01 daemon.info ofonod[969]: Aux: > 
AT+CRSM=178,28599,3,4,16\r
Aug 22 09:13:53 mx31tt01 daemon.info ofonod[969]: Aux: < \r\n+CRSM: 
144,0,FFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFF\r\n\r\nOK\r\n
Aug 22 09:13:53 mx31tt01 daemon.debug ofonod[969]: 
drivers/atmodem/sim.c:at_crsm_read_cb() crsm_read_cb: 90, 00, 16
Aug 22 09:13:53 mx31tt01 daemon.debug ofonod[969]: 
src/voicecall.c:ecc_g3_read_cb() 1
Aug 22 09:13:53 mx31tt01 daemon.info ofonod[969]: Aux: > AT+CRSM=192,12258\r
Aug 22 09:13:53 mx31tt01 daemon.info ofonod[969]: Aux: < \r\n+CRSM: 
144,0,621F8202012183022FE2A5038001318A01058B032F06038002000A880110F10100\r\n\r\nOK\r\n
Aug 22 09:13:53 mx31tt01 daemon.debug ofonod[969]: 
drivers/atmodem/sim.c:at_crsm_info_cb() crsm_info_cb: 90, 00, 33
Aug 22 09:13:53 mx31tt01 daemon.info ofonod[969]: Aux: > 
AT+CRSM=176,12258,0,0,10\r
Aug 22 09:13:53 mx31tt01 daemon.info ofonod[969]: Aux: < \r\n+CRSM: 
144,0,98343000000163500864\r\n\r\nOK\r\n
Aug 22 09:13:53 mx31tt01 daemon.debug ofonod[969]: 
drivers/atmodem/sim.c:at_crsm_read_cb() crsm_read_cb: 90, 00, 10
Aug 22 09:13:53 mx31tt01 daemon.debug ofonod[969]: 
src/simfs.c:sim_fs_op_read_block_cb() bufoff: 0, dataoff: 0, tocopy: 10
Aug 22 09:13:53 mx31tt01 daemon.info ofonod[969]: Aux: > AT+CRSM=192,28421\r
Aug 22 09:13:53 mx31tt01 daemon.info ofonod[969]: Aux: < \r\n+CRSM: 
106,130\r\n\r\nOK\r\n
Aug 22 09:13:53 mx31tt01 daemon.info ofonod[969]: Aux: > AT+CRSM=192,12037\r
Aug 22 09:13:53 mx31tt01 daemon.info ofonod[969]: Aux: < \r\n+CRSM: 
144,0,621F8202012183022F05A5038001318A01058B032F060480020008880128F10100\r\n\r\nOK\r\n
Aug 22 09:13:53 mx31tt01 daemon.debug ofonod[969]: 
drivers/atmodem/sim.c:at_crsm_info_cb() crsm_info_cb: 90, 00, 33
Aug 22 09:13:53 mx31tt01 daemon.info ofonod[969]: Aux: > 
AT+CRSM=176,12037,0,0,8\r
Aug 22 09:13:53 mx31tt01 daemon.info ofonod[969]: Aux: < \r\n+CRSM: 
144,0,6465656EFFFFFFFF\r\n\r\nOK\r\n
Aug 22 09:13:53 mx31tt01 daemon.debug ofonod[969]: 
drivers/atmodem/sim.c:at_crsm_read_cb() crsm_read_cb: 90, 00, 8
Aug 22 09:13:53 mx31tt01 daemon.debug ofonod[969]: 
src/simfs.c:sim_fs_op_read_block_cb() bufoff: 0, dataoff: 0, tocopy: 8
Aug 22 09:13:53 mx31tt01 daemon.info ofonod[969]: Aux: > AT+CPIN?\r
Aug 22 09:13:53 mx31tt01 daemon.info ofonod[969]: Aux: < \r\n+CPIN: SIM 
PIN\r\n\r\nOK\r\n
Aug 22 09:13:53 mx31tt01 daemon.debug ofonod[969]: 
drivers/atmodem/sim.c:at_cpin_cb() crsm_pin_cb: SIM PIN
Aug 22 09:13:53 mx31tt01 daemon.debug ofonod[969]: 
drivers/atmodem/sim.c:at_pin_retries_query()
Aug 22 09:13:53 mx31tt01 daemon.info ofonod[969]: Aux: > AT#PCT\r
Aug 22 09:13:53 mx31tt01 daemon.info ofonod[969]: Aux: < \r\n#PCT: 
3\r\n\r\nOK\r\n
Aug 22 09:13:53 mx31tt01 daemon.debug ofonod[969]: 
drivers/atmodem/sim.c:at_pct_cb() retry counter id=1, val=3
Aug 22 09:13:53 mx31tt01 daemon.info ofonod[969]: Aux: > AT+CPIN="2110"\r
Aug 22 09:13:53 mx31tt01 daemon.info ofonod[969]: Aux: < \r\nOK\r\n
Aug 22 09:13:55 mx31tt01 daemon.info ofonod[969]: Modem: < \r\n#QSS: 2\r\n
Aug 22 09:13:55 mx31tt01 daemon.info ofonod[969]: Aux: < \r\n#QSS: 2\r\n
Aug 22 09:13:55 mx31tt01 daemon.debug ofonod[969]: 
plugins/telit.c:telit_qss_notify() 0x19812d8
Aug 22 09:13:55 mx31tt01 daemon.debug ofonod[969]: 
plugins/telit.c:switch_sim_state_status() 0x19812d8, SIM status: 2
Aug 22 09:13:55 mx31tt01 daemon.info ofonod[969]: Aux: > AT+CPIN?\r
Aug 22 09:13:55 mx31tt01 daemon.info ofonod[969]: Aux: < \r\n+CPIN: 
READY\r\n\r\nOK\r\n
Aug 22 09:13:55 mx31tt01 daemon.debug ofonod[969]: 
drivers/atmodem/sim.c:at_cpin_cb() crsm_pin_cb: READY
Aug 22 09:13:55 mx31tt01 daemon.debug ofonod[969]: 
drivers/atmodem/sim.c:at_pin_retries_query()
Aug 22 09:13:55 mx31tt01 daemon.info ofonod[969]: Aux: > AT#PCT\r
Aug 22 09:13:55 mx31tt01 daemon.info ofonod[969]: Aux: < \r\n#PCT: 
3\r\n\r\nOK\r\n
Aug 22 09:13:55 mx31tt01 daemon.debug ofonod[969]: 
drivers/atmodem/sim.c:at_pct_cb() Note: No password required, returning 
maximum retries:
Aug 22 09:13:55 mx31tt01 daemon.debug ofonod[969]: 
drivers/atmodem/sim.c:at_pct_cb() retry counter id=1, val=3
Aug 22 09:13:55 mx31tt01 daemon.debug ofonod[969]: 
drivers/atmodem/sim.c:at_pct_cb() retry counter id=4, val=3
Aug 22 09:13:55 mx31tt01 daemon.debug ofonod[969]: 
drivers/atmodem/sim.c:at_pct_cb() retry counter id=9, val=10
Aug 22 09:13:55 mx31tt01 daemon.debug ofonod[969]: 
drivers/atmodem/sim.c:at_pct_cb() retry counter id=11, val=10
Aug 22 09:13:55 mx31tt01 daemon.info ofonod[969]: Aux: > AT+CRSM=192,28590\r
Aug 22 09:13:55 mx31tt01 daemon.info ofonod[969]: Aux: < \r\n+CME ERROR: 
22\r\n
Aug 22 09:13:55 mx31tt01 daemon.info ofonod[969]: Aux: > AT+CRSM=192,28589\r
Aug 22 09:13:56 mx31tt01 daemon.info ofonod[969]: Aux: < \r\n+CRSM: 
144,0,621F8202012183026FADA5038001318A01058B036F060680020004880118F10100\r\n\r\nOK\r\n
Aug 22 09:13:56 mx31tt01 daemon.debug ofonod[969]: 
drivers/atmodem/sim.c:at_crsm_info_cb() crsm_info_cb: 90, 00, 33
Aug 22 09:13:56 mx31tt01 daemon.info ofonod[969]: Aux: > 
AT+CRSM=176,28589,0,0,4\r
Aug 22 09:13:56 mx31tt01 daemon.info ofonod[969]: Modem: < \r\n+CREG: 2\r\n
Aug 22 09:13:56 mx31tt01 daemon.info ofonod[969]: Aux: < \r\n+CREG: 2\r\n
Aug 22 09:13:56 mx31tt01 daemon.info ofonod[969]: Aux: < \r\n+CGREG: 2\r\n
Aug 22 09:13:56 mx31tt01 daemon.info ofonod[969]: Modem: < \r\n+CGREG: 2\r\n
Aug 22 09:13:57 mx31tt01 daemon.info ofonod[969]: Modem: < \r\n+CIEV: 
service,1\r\n
Aug 22 09:13:57 mx31tt01 daemon.info ofonod[969]: Modem: < \r\n+CIEV: 
roam,0\r\n
Aug 22 09:13:59 mx31tt01 daemon.info ofonod[969]: Aux: < \r\n+CRSM: 
144,0,00FFFF02\r\n\r\nOK\r\n
Aug 22 09:13:59 mx31tt01 daemon.debug ofonod[969]: 
drivers/atmodem/sim.c:at_crsm_read_cb() crsm_read_cb: 90, 00, 4
Aug 22 09:13:59 mx31tt01 daemon.debug ofonod[969]: 
src/simfs.c:sim_fs_op_read_block_cb() bufoff: 0, dataoff: 0, tocopy: 4
Aug 22 09:13:59 mx31tt01 daemon.info ofonod[969]: Aux: > AT+CRSM=192,28438\r
Aug 22 09:13:59 mx31tt01 daemon.info ofonod[969]: Aux: < \r\n+CIEV: 
service,1\r\n
Aug 22 09:13:59 mx31tt01 daemon.info ofonod[969]: Aux: < \r\n+CIEV: 
roam,0\r\n
Aug 22 09:13:59 mx31tt01 daemon.info ofonod[969]: Aux: < \r\n+CREG: 
1,"EF10","022306B"\r\n
Aug 22 09:13:59 mx31tt01 daemon.info ofonod[969]: Aux: < \r\n#PSNT: 2\r\n
Aug 22 09:14:00 mx31tt01 daemon.info ofonod[969]: Aux: < \r\n+CRSM: 
106,130\r\n\r\nOK\r\n
Aug 22 09:14:00 mx31tt01 daemon.info ofonod[969]: Aux: > AT+CRSM=192,28472\r
Aug 22 09:14:00 mx31tt01 daemon.info ofonod[969]: Aux: < \r\n+CGREG: 
1,"EF10","022306B"\r\n
Aug 22 09:14:00 mx31tt01 daemon.info ofonod[969]: Aux: < \r\n+CRSM: 
144,0,621F8202012183026F38A5038001318A01058B036F060580020008880120F10100\r\n\r\nOK\r\n
Aug 22 09:14:00 mx31tt01 daemon.debug ofonod[969]: 
drivers/atmodem/sim.c:at_crsm_info_cb() crsm_info_cb: 90, 00, 33
Aug 22 09:14:00 mx31tt01 daemon.info ofonod[969]: Aux: > 
AT+CRSM=176,28472,0,0,8\r
Aug 22 09:14:01 mx31tt01 daemon.info ofonod[969]: Aux: < \r\n+CRSM: 
144,0,822B170C23460800\r\n\r\nOK\r\n
Aug 22 09:14:01 mx31tt01 daemon.debug ofonod[969]: 
drivers/atmodem/sim.c:at_crsm_read_cb() crsm_read_cb: 90, 00, 8
Aug 22 09:14:01 mx31tt01 daemon.debug ofonod[969]: 
src/simfs.c:sim_fs_op_read_block_cb() bufoff: 0, dataoff: 0, tocopy: 8
Aug 22 09:14:01 mx31tt01 daemon.info ofonod[969]: Aux: > AT+CRSM=192,28502\r
Aug 22 09:14:01 mx31tt01 daemon.info ofonod[969]: Aux: < \r\n+CRSM: 
144,0,621F8202012183026F56A5038001318A01058B036F061180020001880128F10100\r\n\r\nOK\r\n
Aug 22 09:14:01 mx31tt01 daemon.debug ofonod[969]: 
drivers/atmodem/sim.c:at_crsm_info_cb() crsm_info_cb: 90, 00, 33
Aug 22 09:14:01 mx31tt01 daemon.info ofonod[969]: Aux: > 
AT+CRSM=176,28502,0,0,1\r
Aug 22 09:14:02 mx31tt01 daemon.info ofonod[969]: Aux: < \r\n+CRSM: 
144,0,00\r\n\r\nOK\r\n
Aug 22 09:14:02 mx31tt01 daemon.debug ofonod[969]: 
drivers/atmodem/sim.c:at_crsm_read_cb() crsm_read_cb: 90, 00, 1
Aug 22 09:14:02 mx31tt01 daemon.debug ofonod[969]: 
src/simfs.c:sim_fs_op_read_block_cb() bufoff: 0, dataoff: 0, tocopy: 1
Aug 22 09:14:02 mx31tt01 daemon.info ofonod[969]: Aux: > AT+CIMI\r
Aug 22 09:14:02 mx31tt01 daemon.info ofonod[969]: Aux: < 
\r\n232033012792309\r\n\r\nOK\r\n
Aug 22 09:14:02 mx31tt01 daemon.debug ofonod[969]: 
drivers/atmodem/sim.c:at_cimi_cb() cimi_cb: 232033012792309
Aug 22 09:14:02 mx31tt01 daemon.debug ofonod[969]: 
src/modem.c:modem_change_state() old state: 1, new state: 2
Aug 22 09:14:02 mx31tt01 daemon.debug ofonod[969]: 
plugins/telit.c:telit_post_sim() 0x19812d8
Aug 22 09:14:02 mx31tt01 daemon.debug ofonod[969]: 
drivers/atmodem/gprs-context.c:at_gprs_context_probe()
Aug 22 09:14:02 mx31tt01 daemon.debug ofonod[969]: 
src/modem.c:modem_change_state() old state: 2, new state: 3
Aug 22 09:14:02 mx31tt01 daemon.debug ofonod[969]: 
plugins/telit.c:telit_post_online() 0x19812d8
Aug 22 09:14:02 mx31tt01 daemon.info ofonod[969]: Aux: > AT+CGDCONT=?\r
Aug 22 09:14:02 mx31tt01 daemon.info ofonod[969]: Aux: < \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
Aug 22 09:14:02 mx31tt01 daemon.info ofonod[969]: Aux: > AT+CREG=?\r
Aug 22 09:14:02 mx31tt01 daemon.info ofonod[969]: Aux: < \r\n+CREG: 
(0-2)\r\n\r\nOK\r\n
Aug 22 09:14:02 mx31tt01 daemon.info ofonod[969]: Aux: > AT+CSCS?\r
Aug 22 09:14:02 mx31tt01 daemon.info ofonod[969]: Aux: < \r\n+CSCS: 
"IRA"\r\n\r\nOK\r\n
Aug 22 09:14:02 mx31tt01 daemon.info ofonod[969]: Aux: > AT+CUSD=1\r
Aug 22 09:14:02 mx31tt01 daemon.info ofonod[969]: Aux: < \r\nOK\r\n
Aug 22 09:14:02 mx31tt01 daemon.info ofonod[969]: Aux: > AT+CAOC=2\r
Aug 22 09:14:02 mx31tt01 daemon.info ofonod[969]: Aux: < \r\nOK\r\n
Aug 22 09:14:02 mx31tt01 daemon.info ofonod[969]: Aux: > AT+CCWE=1\r
Aug 22 09:14:02 mx31tt01 daemon.info ofonod[969]: Aux: < \r\nERROR\r\n
Aug 22 09:14:02 mx31tt01 daemon.info ofonod[969]: Aux: > AT+CRSM=192,28480\r
Aug 22 09:14:03 mx31tt01 daemon.info ofonod[969]: Aux: < \r\n+CRSM: 
144,0,622182050221001E0483026F40A5038001318A01058B036F060B800200788800F10100\r\n\r\nOK\r\n
Aug 22 09:14:03 mx31tt01 daemon.debug ofonod[969]: 
drivers/atmodem/sim.c:at_crsm_info_cb() crsm_info_cb: 90, 00, 35
Aug 22 09:14:03 mx31tt01 daemon.info ofonod[969]: Aux: > AT+CGREG=?\r
Aug 22 09:14:03 mx31tt01 daemon.info ofonod[969]: Aux: < \r\n+CGREG: 
(0-2)\r\n\r\nOK\r\n
Aug 22 09:14:03 mx31tt01 daemon.info ofonod[969]: Aux: > AT+CREG=2\r
Aug 22 09:14:03 mx31tt01 daemon.info ofonod[969]: Aux: < \r\nOK\r\n
Aug 22 09:14:03 mx31tt01 daemon.info ofonod[969]: Aux: > 
AT+CRSM=178,28480,1,4,30\r
Aug 22 09:14:03 mx31tt01 daemon.info ofonod[969]: Aux: < \r\n+CRSM: 
144,0,456967656E65205275666E756D6D65720791347676086013FFFFFFFFFFFF\r\n\r\nOK\r\n
Aug 22 09:14:03 mx31tt01 daemon.debug ofonod[969]: 
drivers/atmodem/sim.c:at_crsm_read_cb() crsm_read_cb: 90, 00, 30
Aug 22 09:14:03 mx31tt01 daemon.info ofonod[969]: Aux: > AT+CGREG=2\r
Aug 22 09:14:03 mx31tt01 daemon.info ofonod[969]: Aux: < \r\nOK\r\n
Aug 22 09:14:03 mx31tt01 daemon.info ofonod[969]: Aux: > AT+CGAUTO=0\r
Aug 22 09:14:03 mx31tt01 daemon.info ofonod[969]: Aux: < \r\nERROR\r\n
Aug 22 09:14:03 mx31tt01 daemon.info ofonod[969]: Aux: > AT+CGEREP=2,1\r
Aug 22 09:14:03 mx31tt01 daemon.info ofonod[969]: Aux: < \r\nOK\r\n
Aug 22 09:14:03 mx31tt01 daemon.info ofonod[969]: Aux: > AT+CIND=?\r
Aug 22 09:14:03 mx31tt01 daemon.info ofonod[969]: Aux: < \r\n+CIND: 
(("battchg",(0-5,99)),("signal",(0-7,99)),("service",(0,1)),("sounder",(0,1)),("message",(0,1)),("call",(0,1)),("roam",(0,1)),("smsfull",(0,1)),("rssi",(0-5,99)))\r\n\r\nOK\r\n
Aug 22 09:14:03 mx31tt01 daemon.debug ofonod[969]: 
src/sim.c:ofono_sim_add_spn_watch() 0x195eba8
Aug 22 09:14:03 mx31tt01 daemon.debug ofonod[969]: 
src/network.c:__ofono_netreg_add_status_watch() 0x197cf38
Aug 22 09:14:03 mx31tt01 daemon.info ofonod[969]: Aux: > 
AT+CRSM=178,28480,2,4,30\r
Aug 22 09:14:04 mx31tt01 daemon.info ofonod[969]: Aux: < \r\n+CRSM: 
144,0,FFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFF\r\n\r\nOK\r\n
Aug 22 09:14:04 mx31tt01 daemon.debug ofonod[969]: 
drivers/atmodem/sim.c:at_crsm_read_cb() crsm_read_cb: 90, 00, 30
Aug 22 09:14:04 mx31tt01 daemon.info ofonod[969]: Aux: > AT#PSNT=1\r
Aug 22 09:14:04 mx31tt01 daemon.info ofonod[969]: Aux: < \r\nOK\r\n
Aug 22 09:14:04 mx31tt01 daemon.info ofonod[969]: Aux: > AT+CPSB=1\r
Aug 22 09:14:04 mx31tt01 daemon.info ofonod[969]: Aux: < \r\nERROR\r\n
Aug 22 09:14:04 mx31tt01 daemon.info ofonod[969]: Aux: > AT+CMER=3,0,0,2\r
Aug 22 09:14:04 mx31tt01 daemon.info ofonod[969]: Aux: < \r\nOK\r\n
Aug 22 09:14:04 mx31tt01 daemon.info ofonod[969]: Aux: > AT+CREG?\r
Aug 22 09:14:04 mx31tt01 daemon.info ofonod[969]: Aux: < \r\n+CIEV: 
battchg,4\r\n\r\n+CIEV: signal,0\r\n\r\n+CIEV: service,1\r\n\r\n+CIEV: 
sounder,0\r\n\r\n+CIEV: message,1\r\n\r\n+CIEV: call,0\r\n\r\n+CIEV: 
roam,0\r\n\r\n+CIEV: smsfull,0\r\n\r\n+CIEV: rssi,1\r\n
Aug 22 09:14:04 mx31tt01 daemon.debug ofonod[969]: 
drivers/atmodem/network-registration.c:ciev_notify() Strength: 20
Aug 22 09:14:04 mx31tt01 daemon.info ofonod[969]: Aux: < \r\n+CREG: 
2,1,"EF10","022306B"\r\n\r\nOK\r\n
Aug 22 09:14:04 mx31tt01 daemon.debug ofonod[969]: 
src/network.c:ofono_netreg_status_notify() /telit_0 status 1 tech -1
Aug 22 09:14:04 mx31tt01 daemon.debug ofonod[969]: 
src/gprs.c:netreg_status_changed() 1
Aug 22 09:14:04 mx31tt01 daemon.info ofonod[969]: Aux: > 
AT+CRSM=178,28480,3,4,30\r
Aug 22 09:14:04 mx31tt01 daemon.info ofonod[969]: Aux: < \r\n+CRSM: 
144,0,FFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFF\r\n\r\nOK\r\n
Aug 22 09:14:04 mx31tt01 daemon.debug ofonod[969]: 
drivers/atmodem/sim.c:at_crsm_read_cb() crsm_read_cb: 90, 00, 30
Aug 22 09:14:04 mx31tt01 daemon.info ofonod[969]: Aux: > AT+COPS=3,2\r
Aug 22 09:14:04 mx31tt01 daemon.info ofonod[969]: Aux: < \r\nOK\r\n
Aug 22 09:14:04 mx31tt01 daemon.info ofonod[969]: Aux: > AT+COPS?\r
Aug 22 09:14:04 mx31tt01 daemon.info ofonod[969]: Aux: < \r\n+COPS: 
0,2,"23203",2\r\n\r\nOK\r\n
Aug 22 09:14:04 mx31tt01 daemon.debug ofonod[969]: 
drivers/atmodem/network-registration.c:cops_numeric_cb() Cops numeric 
got mcc: 232, mnc: 03
Aug 22 09:14:04 mx31tt01 daemon.info ofonod[969]: Aux: > AT+CIND?\r
Aug 22 09:14:04 mx31tt01 daemon.info ofonod[969]: Aux: < \r\n+CIND: 
4,0,1,0,1,0,0,0,1\r\n\r\nOK\r\n
Aug 22 09:14:04 mx31tt01 daemon.debug ofonod[969]: 
src/network.c:ofono_netreg_strength_notify() strength 20
Aug 22 09:14:04 mx31tt01 daemon.info ofonod[969]: Aux: > AT+CGATT=1\r
Aug 22 09:14:04 mx31tt01 daemon.info ofonod[969]: Aux: < \r\nOK\r\n
Aug 22 09:14:04 mx31tt01 daemon.debug ofonod[969]: 
src/gprs.c:gprs_attach_callback() /telit_0 error = 0
Aug 22 09:14:04 mx31tt01 daemon.info ofonod[969]: Aux: > AT+CIND?\r
Aug 22 09:14:04 mx31tt01 daemon.info ofonod[969]: Aux: < \r\n+CIND: 
4,0,1,0,1,0,0,0,1\r\n\r\nOK\r\n
Aug 22 09:14:04 mx31tt01 daemon.info ofonod[969]: Aux: > 
AT+CRSM=178,28480,4,4,30\r
Aug 22 09:14:05 mx31tt01 daemon.info ofonod[969]: Aux: < \r\n+CRSM: 
144,0,FFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFF\r\n\r\nOK\r\n
Aug 22 09:14:05 mx31tt01 daemon.debug ofonod[969]: 
drivers/atmodem/sim.c:at_crsm_read_cb() crsm_read_cb: 90, 00, 30
Aug 22 09:14:05 mx31tt01 daemon.info ofonod[969]: Aux: > AT+COPS=3,0\r
Aug 22 09:14:05 mx31tt01 daemon.info ofonod[969]: Aux: < \r\nOK\r\n
Aug 22 09:14:05 mx31tt01 daemon.info ofonod[969]: Aux: > AT+COPS?\r
Aug 22 09:14:05 mx31tt01 daemon.info ofonod[969]: Aux: < \r\n+COPS: 
0,0,"T-Mobile A",2\r\n\r\nOK\r\n
Aug 22 09:14:05 mx31tt01 daemon.debug ofonod[969]: 
drivers/atmodem/network-registration.c:cops_cb() cops_cb: T-Mobile A, 
232 03 2
Aug 22 09:14:05 mx31tt01 daemon.debug ofonod[969]: 
src/network.c:current_operator_callback() 0x197cf38, (nil)
Aug 22 09:14:05 mx31tt01 daemon.debug ofonod[969]: 
src/gprs.c:netreg_status_changed() 1
Aug 22 09:14:05 mx31tt01 daemon.info ofonod[969]: Aux: > AT+CGREG?\r
Aug 22 09:14:05 mx31tt01 daemon.info ofonod[969]: Aux: < \r\n+CGREG: 
2,1,"EF10","022306B"\r\n\r\nOK\r\n
Aug 22 09:14:05 mx31tt01 daemon.debug ofonod[969]: 
src/gprs.c:registration_status_cb() /telit_0 error 0 status 1
Aug 22 09:14:05 mx31tt01 daemon.debug ofonod[969]: 
src/gprs.c:ofono_gprs_status_notify() /telit_0 status 1
Aug 22 09:14:05 mx31tt01 daemon.info ofonod[969]: Aux: > AT+CRSM=192,28489\r
Aug 22 09:14:05 mx31tt01 daemon.info ofonod[969]: Aux: < \r\n+CRSM: 
106,130\r\n\r\nOK\r\n
Aug 22 09:14:05 mx31tt01 daemon.info ofonod[969]: Aux: > AT+CRSM=192,28618\r
Aug 22 09:14:05 mx31tt01 daemon.info ofonod[969]: Aux: < \r\n+CRSM: 
144,0,62218205022100050183026FCAA5038001318A01058B036F060B800200058800F10100\r\n\r\nOK\r\n
Aug 22 09:14:05 mx31tt01 daemon.debug ofonod[969]: 
drivers/atmodem/sim.c:at_crsm_info_cb() crsm_info_cb: 90, 00, 35
Aug 22 09:14:05 mx31tt01 daemon.info ofonod[969]: Aux: > 
AT+CRSM=178,28618,1,4,5\r
Aug 22 09:14:05 mx31tt01 daemon.debug ofonod[969]: 
drivers/atmodem/gprs-context.c:at_gprs_activate_primary() cid 1
Aug 22 09:14:05 mx31tt01 daemon.debug ofonod[969]: 
src/gprs.c:pri_activate_callback() 0x198a948
Aug 22 09:14:05 mx31tt01 daemon.debug ofonod[969]: 
src/gprs.c:pri_activate_callback() Activating context failed with error: 
Unknown error type



Regards,
Christopher


--
Scanned by MailScanner.


^ permalink raw reply	[flat|nested] only message in thread

only message in thread, other threads:[~2012-08-24 10:10 UTC | newest]

Thread overview: (only message) (download: mbox.gz follow: Atom feed
-- links below jump to the message on this page --
2012-08-24 10:10 Reactivating context after SIM reinsertion fails sometimes (telit UC864G modem) Christopher Vogl

This is an external index of several public inboxes,
see mirroring instructions on how to clone and mirror
all data and code used by this external index.