Hello,

I am using Telit HE910 modem, the version of firmware is 12.00.03.

Sometimes, the modem port got stuck after sending AT+CGDCONT=1.
(Such as AT+CGDCONT=1,"IP","internet.tele2.se").

When this problem happened, I could not get any information from the modem port
after this command..


The following was the situation when this problem happened
 Aux: > AT+CRSM=192,28621\r
 Modem: > AT+CGDCONT=1,"IP","internet.tele2.se"\r
 Modem: < AT+CGDCONT=1,"IP","internet.tele2.se"\r
 Aux: < \r\n+CME ERROR: 4\r\n

According to Telit AT Commands Reference Guide:
/3.2.5. Command Issuing Timing/

/The chain Command -> Response shall always be respected and a new command must not be// //issued before the module has terminated all the sending of its response result code (whatever it//
//may be)./

It seems that this problem is caused by "Command Issuing TIming"

Since there were alway some pending responses on the AUX port when this problem happened.
and there was no pending response on the AUX port when it worked.

when it worked:
 Aux: > AT+CRSM=192,28621\r
 Aux: < \r\n+CME ERROR: 4\r\n
 Aux: > AT+CRSM=192,28437\r
 Aux: < \r\n+CRSM: 148,4\r\n\r\nOK\r\n
 drivers/atmodem/gprs-context.c:at_gprs_activate_primary() cid 1
 Modem: > AT+CGDCONT=1,"IP","internet.tele2.se"\r
 Modem: < AT+CGDCONT=1,"IP","internet.tele2.se"\r\r\nOK\r\n

I added sleep(1) just before sending out AT+CGDCONT=1,"IP","internet.tele2.se command.
It worked well. I know this is a bad idea.

If this problem is really caused by "Command Issuing TIming", How should we solve or work around this problem?


Thanks.

Mingli

The following is trace log.


 Aux: > ATE0 +CMEE=1\r
 Aux: < ATE0 +CMEE=1\r\r\nOK\r\n
 Aux: > AT#QSS=0\r
 Aux: < \r\nOK\r\n
 Aux: > AT+CFUN=1\r
 Aux: < \r\nOK\r\n
 plugins/telit.c:cfun_enable_cb() 0x9b6af8
 src/modem.c:modem_change_state() old state: 0, new state: 1
 plugins/telit.c:telit_pre_sim() 0x9b6af8
 Aux: > AT&C0\r
 src/sim.c:ofono_sim_add_state_watch() 0x9afc98
 src/sim.c:ofono_sim_add_state_watch() 0x9afc98
 src/sim.c:ofono_sim_add_state_watch() 0x9afc98
 Aux: < \r\nOK\r\n
 Aux: > AT+GCAP\r
 Aux: < \r\n+GCAP: +CGSM,+DS,+FCLASS,+MS,+ES\r\n\r\nOK\r\n
 Aux: > AT+CRC=1\r
 Aux: < \r\nOK\r\n
 Aux: > AT+CLIP=1\r
 Aux: < \r\nOK\r\n
 Aux: > AT+CDIP=1\r
 Aux: < \r\nERROR\r\n
 Aux: > AT+CNAP=1\r
 Aux: < \r\nERROR\r\n
 Aux: > AT+COLP=1\r
 Aux: < \r\nOK\r\n
 Aux: > AT+CSSN=1,1\r
 Aux: < \r\nOK\r\n
 Aux: > AT+VTD?\r
 Aux: < \r\n0\r\n\r\nOK\r\n
 Aux: > AT+CCWA=1\r
 Aux: < \r\nOK\r\n
drivers/atmodem/voicecall.c:at_voicecall_initialized() voicecall_init: registering to notifications
 src/sim.c:ofono_sim_add_state_watch() 0x9afc98
 Aux: > AT#AUTOATT=0\r
 Aux: < \r\nOK\r\n
 Aux: > AT#QSS=2\r
 Aux: < \r\nOK\r\n
 Aux: > AT#QSS?\r
 Aux: < \r\n#QSS: 2,1\r\n\r\nOK\r\n
 plugins/telit.c:telit_qss_notify() 0x9b6af8
plugins/telit.c:switch_sim_state_status() 0x9b6af8, SIM status: 1
 Aux: > AT+CGMI\r
 Aux: < \r\nTelit\r\n\r\nOK\r\n
 Aux: > AT+CLCC\r
 Aux: < \r\nOK\r\n
 Aux: > AT+CPIN?\r
 Aux: < \r\n+CPIN: READY\r\n\r\nOK\r\n
 Aux: > AT+CGMM\r
 Aux: < \r\nHE910\r\n\r\nOK\r\n
 Aux: > AT+CPMS?\r
 Aux: < \r\n+CPMS: "SM",0,25,"SM",0,25,"SM",0,25\r\n\r\nOK\r\n
 Aux: > AT+CGMR\r
 Aux: < \r\n12.00.002\r\n\r\nOK\r\n
 Aux: > AT+CSCS=?\r
 Aux: < \r\n+CSCS: ("GSM","IRA","8859-1","PCCP437","UCS2")\r\n\r\nOK\r\n
 Aux: > AT+CSMS=?\r
 Aux: < \r\n+CSMS: (0,1)\r\n\r\nOK\r\n
 drivers/atmodem/sms.c:at_csms_query_cb() CSMS query parsed successfully
 Aux: > AT+CRSM=192,28599\r
 Aux: < \r\n+CRSM: 148,4\r\n\r\nOK\r\n
 src/voicecall.c:ecc_g2_read_cb() 0
 Aux: > AT+CGSN\r
 Aux: < \r\n357164045019588\r\n\r\nOK\r\n
 Aux: > AT+CPBS=?\r
 Aux: < \r\n+CPBS: ("SM","FD","LD","MC","RC","DC","ME","ON")\r\n\r\nOK\r\n
 Aux: > AT+CSMS=1\r
 Aux: < \r\n+CSMS: 1,1,1\r\n\r\nOK\r\n
 Aux: > AT+CRSM=192,28599\r
 Aux: < \r\n+CRSM: 148,4\r\n\r\nOK\r\n
 src/voicecall.c:ecc_g3_read_cb() 0
 Aux: > AT+CSMS?\r
 Aux: < \r\n
 Aux: < +CSMS: 1,1,1,1\r\n\r\nOK\r\n
 Aux: > AT+CRSM=192,12258\r
 Aux: < \r\n+CRSM: 144,0,0000000A2FE204000EFFEE01020000\r\n\r\nOK\r\n
 drivers/atmodem/sim.c:at_crsm_info_cb() crsm_info_cb: 90, 00, 15
 Aux: > AT+CMGF=?\r
 Aux: < \r\n+CMGF: (0,1)\r\n\r\nOK\r\n
 Aux: > AT+CRSM=176,12258,0,0,10\r
 Aux: < \r\n+CRSM: 144,0,98640244020000105139\r\n\r\nOK\r\n
 drivers/atmodem/sim.c:at_crsm_read_cb() crsm_read_cb: 90, 00, 10
 src/simfs.c:sim_fs_op_read_block_cb() bufoff: 0, dataoff: 0, tocopy: 10
 Aux: > AT+CPMS=?\r
 Aux: < \r\n+CPMS: ("SM"),("SM"),("SM")\r\n\r\nOK\r\n
 Aux: > AT+CRSM=192,28421\r
 Aux: < \r\n+CME ERROR: 4\r\n
 Aux: > AT+CMGF=0\r
 Aux: < \r\nOK\r\n
 Aux: > AT+CRSM=192,12037\r
 Aux: < \r\n+CME ERROR: 4\r\n
 Aux: > AT+CPMS="SM","SM","SM"\r
 Aux: < \r\n+CPMS: 0,25,0,25,0,25\r\n\r\nOK\r\n
 Aux: > AT+CPIN?\r
 Aux: < \r\n+CPIN: READY\r\n\r\nOK\r\n
 drivers/atmodem/sim.c:at_cpin_cb() crsm_pin_cb: READY
 drivers/atmodem/sim.c:at_pin_retries_query()
 Aux: > AT+CNMI=?\r
 Aux: < \r\n+CNMI: (0-3),(0-3),(0,2),(0-2),(0,1)\r\n\r\nOK\r\n
 drivers/atmodem/sms.c:build_cnmi_string()
 drivers/atmodem/sms.c:construct_ack_pdu()
 Aux: > AT#PCT\r
 Aux: < \r\n#PCT: 3\r\n\r\nOK\r\n
drivers/atmodem/sim.c:at_pct_cb() Note: No password required, returning maximum retries:
 drivers/atmodem/sim.c:at_pct_cb() retry counter id=1, val=3
 drivers/atmodem/sim.c:at_pct_cb() retry counter id=4, val=3
 drivers/atmodem/sim.c:at_pct_cb() retry counter id=9, val=10
 drivers/atmodem/sim.c:at_pct_cb() retry counter id=11, val=10
 Aux: > AT+CRSM=192,28590\r
 Aux: < \r\n+CME ERROR: 4\r\n
 Aux: > AT+CNMI=2,2,2,1,0\r
 Aux: < \r\nOK\r\n
 src/sms.c:sms_restore_tx_queue()
 plugins/push-notification.c:sms_watch() registered
 plugins/smart-messaging.c:sms_watch() registered
 Aux: > AT+CRSM=192,28589\r
 Aux: < \r\n+CRSM: 144,0,000000036FAD04000EFFEE01020000\r\n\r\nOK\r\n
 drivers/atmodem/sim.c:at_crsm_info_cb() crsm_info_cb: 90, 00, 15
 Aux: > AT+CMGL=4\r
 Aux: < \r\nOK\r\n
 drivers/atmodem/sms.c:at_cmgl_done()
 Aux: > AT+CGSMS=3\r
 Aux: < \r\nOK\r\n
 Aux: > AT+CRSM=176,28589,0,0,3\r
 Aux: < \r\n
 Aux: < +CRSM: 144,0,00FFFF\r\n\r\nOK\r\n
 drivers/atmodem/sim.c:at_crsm_read_cb() crsm_read_cb: 90, 00, 3
 src/simfs.c:sim_fs_op_read_block_cb() bufoff: 0, dataoff: 0, tocopy: 3
 EFad does not specify (optional) MNC length, defaulting to 2
 Aux: > AT+CRSM=192,28438\r
 Aux: < \r\n+CRSM: 148,4\r\n\r\nOK\r\n
 Aux: > AT+CRSM=192,28472\r
 Aux: < \r\n+CRSM: 144,0,0000000E6F3804001EFFEE01020000\r\n\r\nOK\r\n
 drivers/atmodem/sim.c:at_crsm_info_cb() crsm_info_cb: 90, 00, 15
 Aux: > AT+CRSM=176,28472,0,0,14\r
 Aux: < \r\n+CRSM: 144,0,FF3FFF0F0300FC03000CC300F0C0\r\n\r\nOK\r\n
 drivers/atmodem/sim.c:at_crsm_read_cb() crsm_read_cb: 90, 00, 14
 src/simfs.c:sim_fs_op_read_block_cb() bufoff: 0, dataoff: 0, tocopy: 14
 Aux: > AT+CRSM=192,28502\r
 Aux: < \r\n+CME ERROR: 4\r\n
 Aux: > AT+CIMI\r
 Aux: < \r\n240075990001159\r\n\r\nOK\r\n
 drivers/atmodem/sim.c:at_cimi_cb() cimi_cb: 240075990001159
 src/modem.c:modem_change_state() old state: 1, new state: 2
 plugins/telit.c:telit_post_sim() 0x9b6af8
 drivers/atmodem/gprs-context.c:at_gprs_context_probe()
 Aux: > AT+CGDCONT=?\r
 plugins/telit.c:telit_set_online() modem 0x9b6af8 online
 Aux: < \r\n+CGDCONT: (1-5),"IP",,,(0,1),(0,1)\r\n\r\nOK\r\n
 Aux: > AT+CFUN=1,0\r
 Aux: < \r\nOK\r\n
 src/modem.c:modem_change_state() old state: 2, new state: 3
 plugins/telit.c:telit_post_online() 0x9b6af8
 Aux: > AT#QSS?\r
 Aux: < \r\n#QSS: 2,1\r\n\r\nOK\r\n
 plucins/telit.c:telit_qss_notify() 0x9b6af8
 plugins/telit.c:switch_sim_state_status() 0x9b6af8, SIM status: 1
 Aux: > AT+CRSM=192,28480\r
 Aux: < \r\n+CRSM: 144,0,000000386F40040011FFEE0102011C\r\n\r\nOK\r\n
 drivers/atmodem/sim.c:at_crsm_info_cb() crsm_info_cb: 90, 00, 15
 Aux: > AT+CGREG=?\r
 Aux: < \r\n+CGREG: (0-2)\r\n\r\nOK\r\n
 Aux: > AT+CREG=?\r
 Aux: < \r\n
 Aux: < +CREG: (0-2)\r\n\r\nOK\r\n
 Aux: > AT+CSCS?\r
 Aux: < \r\n+CSCS: "IRA"\r\n\r\nOK\r\n
 Aux: > AT+CUSD=1\r
 Aux: < \r\nOK\r\n
 Aux: > AT+CAOC=2\r
 Aux: < \r\nOK\r\n
 Aux: > AT+CCWE=1\r
 Aux: < \r\nOK\r\n
 Aux: > AT+CPIN?\r
 Aux: < \r\n+CPIN: READY\r\n\r\nOK\r\n
 Aux: > AT+CRSM=178,28480,1,4,28\r
Aux: < \r\n+CRSM: 144,0,FFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFF\r\n\r\nOK\r\n
 drivers/atmodem/sim.c:at_crsm_read_cb() crsm_read_cb: 90, 00, 28
 Aux: > AT+CGREG=2\r
 Aux: < \r\nOK\r\n
 Aux: > AT+CGAUTO=0\r
 Aux: < \r\nERROR\r\n
 Aux: > AT+CGEREP=2,1\r
 Aux: < \r\nOK\r\n
 Aux: > AT+CREG=2\r
 Aux: < \r\nOK\r\n
 Aux: > AT+CPMS?\r
 Aux: < \r\n+CPMS: "SM",0,25,"SM",0,25,"SM",0,25\r\n\r\nOK\r\n
 Aux: > AT+CRSM=178,28480,2,4,28\r
Aux: < \r\n+CRSM: 144,0,FFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFF\r\n\r\nOK\r\n
 drivers/atmodem/sim.c:at_crsm_read_cb() crsm_read_cb: 90, 00, 28
 Aux: > AT#PSNT=1\r
 Aux: < \r\nOK\r\n
 Aux: > AT+CPSB=1\r
 Aux: < \r\nERROR\r\n
 Aux: > AT+CIND=?\r
Aux: < \r\n+CIND: (("battchg",(0-5,99)),("signal",(0-7,99)),("service",(0,1)),("sounder",(0,1)),("messn
 Aux: > AT+CRSM=192,28489\r
 Aux: < \r\n+CRSM: 148,4\r\n\r\nOK\r\n
 Aux: > AT+CMER=?\r
 Aux: < \r\n+CMER: (0-3),(0),(0),(0,2),(0,1)\r\n\r\nOK\r\n
 drivers/atmodem/network-registration.c:build_cmer_string()
 Aux: > AT+CRSM=192,20256\r
 Aux: < \r\n+CME ERROR: 4\r\n
 Aux: > AT+CMER=3,0,0,2\r
 Aux: < \r\nOK\r\n
Aux: < \r\n+CIEV: battchg,0\r\n\r\n+CIEV: signal,7\r\n\r\n+CIEV: service,1\r\n\r\n+CIEV: sounder,0\r\nn
 src/sim.c:ofono_sim_add_spn_watch() 0x9afc98
 src/network.c:__ofono_netreg_add_status_watch() 0x9b9ff0
 src/network.c:__ofono_netreg_add_status_watch() 0x9b9ff0
 Aux: > AT+CRSM=192,28618\r
 Aux: < \r\n+CRSM: 148,4\r\n\r\nOK\r\n
 Unable to read waiting messages numbers from SIM
 Aux: > AT+CREG?\r
 Aux: < \r\n+CREG: 2,1,"00D4","0D45D96",2\r\n\r\nOK\r\n
 src/network.c:ofono_netreg_status_notify() /telit_0 status 1 tech 2
 src/gprs.c:netreg_status_changed() 1
 Aux: > AT+CRSM=192,28617\r
 Aux: < \r\n+CRSM: 148,4\r\n\r\nOK\r\n
 Unable to read mailbox identifies from SIM
 Aux: > AT+COPS=3,2\r
 Aux: < \r\nOK\r\n
 Aux: > AT+COPS?\r
 Aux: < \r\n+COPS: 0,2,"24005",2\r\n\r\nOK\r\n
drivers/atmodem/network-registration.c:cops_numeric_cb() Cops numeric got mcc: 240, mnc: 05
 Aux: > AT+CIND?\r
 Aux: < \r\n+CIND: 0,7,1,0,0,0,0,0,5\r\n\r\nOK\r\n
 src/network.c:ofono_netreg_strength_notify() strength 100
 Aux: > AT+CGATT=1\r
 Aux: < \r\nOK\r\n
 Aux: < \r\n+CGREG: 1,"00D4","0D45D96",2,"01"\r\n
 src/gprs.c:gprs_attach_callback() /telit_0 error = 0
 src/gprs.c:ofono_gprs_status_notify() /telit_0 status 1
 Aux: > AT+CIND?\r
 Aux: < \r\n+CIND: 0,7,1,0,0,0,0,0,5\r\n\r\nOK\r\n
 Aux: > AT+CRSM=192,28433\r
 Aux: < \r\n+CRSM: 148,4\r\n\r\nOK\r\n
 src/message-waiting.c:mw_cphs_mwis_read_cb() No CPHS MWIS on SIM
 Aux: > AT+COPS=3,0\r
 Aux: < \r\nOK\r\n
 Aux: > AT+COPS?\r
 Aux: < \r\n+COPS: 0,0,"S 05",2\r\n\r\nOK\r\n
 drivers/atmodem/network-registration.c:cops_cb() cops_cb: S 05, 240 05 2
 src/network.c:current_operator_callback() 0x9b9ff0, (nil)
 src/gprs.c:netreg_status_changed() 1
 Aux: > AT+CGREG?\r
 Aux: < \r\n
 Aux: < +CGREG: 2,1,"00D4","0D45D96",2,"01"\r\n\r\nOK\r\n
 src/gprs.c:registration_status_cb() /telit_0 error 0 status 1
 src/gprs.c:ofono_gprs_status_notify() /telit_0 status 1
 Aux: > AT+CRSM=192,28435\r
 Aux: < \r\n+CRSM: 148,4\r\n\r\nOK\r\n
 src/simfs.c:sim_fs_op_read_block() bufoff: 0, seekoff: 39, toread: 17
 Aux: > AT+CRSM=192,28621\r
 drivers/atmodem/gprs-context.c:at_gprs_activate_primary() cid 1
 Modem: > AT+CGDCONT=1,"IP","internet.tele2.se"\r
 Modem: < AT+CGDCONT=1,"IP","internet.tele2.se"\r
 Aux: < \r\n+CME ERROR: 4\r\n
 Aux: > AT+CRSM=192,28437\r






_______________________________________________
ofono mailing list
[email protected]
http://lists.ofono.org/listinfo/ofono

Reply via email to