Can't figure out the cause of CMS Error 310 on Telit GM862

Can't figure out the cause of CMS Error 310 on Telit GM862#80816

By BillyBobJoe - Fri Sep 11, 2009 8:50 am

- Fri Sep 11, 2009 8:50 am #80816

I have a bunch of Telit GM862 modules and 2 of them are giving me a "CMS Error 310" when I send the command "AT+CMGF?". The error indicates "SIM not inserted" (the SIM card is inserted).

Only this command gives me an error, and I'm able to read the phone number, etc. from the SIM card. I can connect to the network and I can send and receive SMS messages. I've tried several SIM cards and I get the same message. I've tried delaying between power-up and issuing the command (several minutes) and I still get the error - so it's not that the module hasn't recognized the SIM card.

Again, I have several modules and only these 2 exhibit the problem. Anybody else seen anything like this on these modules?

#80935

By BillyBobJoe - Sat Sep 12, 2009 7:32 pm

- Sat Sep 12, 2009 7:32 pm #80935

Nobody has any suggestions? I thought there'd be a lot of Telit experts here!

Telit GM 862 Unable to locate the network#87998

By protrackon - Sat Dec 26, 2009 8:47 am

- Sat Dec 26, 2009 8:47 am #87998

Hello,

I am working on GM 862 Telit GSM and Sparkfun evl kit. The GSM is responding for the AT commands, when i try to use the AT+COPS i am getting error.

Also i got the same CMS Error 310 on Telit GM862

Can some one help me what i am missing?
Appreciated your advice/help.

Reg,
PTN

#88005

By leon_heller - Sat Dec 26, 2009 9:30 am

- Sat Dec 26, 2009 9:30 am #88005

A pure guess - are you using the correct delays in your code?

Leon

Leon Heller
G1HSM

Re: Can't figure out the cause of CMS Error 310 on Telit GM862#127273

By kzar - Mon May 16, 2011 8:23 am

- Mon May 16, 2011 8:23 am #127273

You guys ever figure this one out?

Sometimes AT+CMGF=1 is giving me the +CMS ERROR: 310 error, sometimes not.

If I reboot the unit sometimes it fixes it but ideally I would like to understand what's happening.

Cheers, Dave.

Re: Can't figure out the cause of CMS Error 310 on Telit GM862#128136

By liqdfire - Wed Jun 01, 2011 5:34 pm

- Wed Jun 01, 2011 5:34 pm #128136

According to this site:
http://www.developershome.com/sms/resultCodes2.asp

310 means it cannot read the sim card

Re: Can't figure out the cause of CMS Error 310 on Telit GM862#128204

By f1fan3584 - Thu Jun 02, 2011 7:52 pm

- Thu Jun 02, 2011 7:52 pm #128204

I had this same problem on my GE865 after updating firmware and posted this to the GE865 eval product page. Here is my post. Hope it helps.

"If anyone updates the firmware, you may have to do an "AT#SIMDET=1" if you have a SIM not inserted error +CME 310. Thanks to scoy on the SFE forum for this tip. I updated firmware and kablammo, AT+CPIN? returned ERROR. Now all is well."

Re: Can't figure out the cause of CMS Error 310 on Telit GM8#171340

By Krystian - Wed May 21, 2014 2:34 am

- Wed May 21, 2014 2:34 am #171340

I have similar problem. When I try configure huawei E122 to send SMS by kannel. When i give wrong PIN kannel (bearerbox) receive an error "incorrect password"

2014-05-21 11:15:38 [8419] [6] DEBUG: AT2[modem1]: <-- +CPIN: SIM PIN
2014-05-21 11:15:38 [8419] [6] DEBUG: AT2[modem1]: --> AT+CPIN="1234"^M
2014-05-21 11:15:38 [8419] [6] DEBUG: AT2[modem1]: <-- OK
2014-05-21 11:15:38 [8419] [6] DEBUG: AT2[modem1]: <-- +CME ERROR: incorrect password
2014-05-21 11:15:38 [8419] [6] ERROR: AT2[modem1]: Generic error: +CME ERROR: incorrect password
2014-05-21 11:15:38 [8419] [6] DEBUG: AT2[modem1]: --> AT+CPIN?^M
2014-05-21 11:15:38 [8419] [6] DEBUG: AT2[modem1]: <-- +CPIN: SIM PIN
2014-05-21 11:15:38 [8419] [6] ERROR: AT2[modem1]: Initialization of device failed.

but when I give correct PIN I receive "+CMS ERROR: (U)SIM not inserted"

2014-05-21 10:56:17 [7980] [6] DEBUG: AT2[modem1]: --> AT+CSCA="+48501200777"^M
2014-05-21 10:56:17 [7980] [6] DEBUG: AT2[modem1]: <-- +CMS ERROR: (U)SIM not inserted
2014-05-21 10:56:17 [7980] [6] ERROR: AT2[modem1]: CMS ERROR: +CMS ERROR: (U)SIM not inserted
2014-05-21 10:56:17 [7980] [6] INFO: AT2[modem1]: Cannot set SMS message center, continuing

When I try send sms from Windows XP it works correct.

Logs from this two samples below

Code: Select all

# bearerbox -v 0 /etc/kannel/kannel.conf
2014-05-21 11:15:20 [8419] [0] INFO: Debug_lvl = 0, log_file = <none>, log_lvl = 0
2014-05-21 11:15:20 [8419] [0] WARNING: DLR: using default 'internal' for storage type.
2014-05-21 11:15:20 [8419] [0] INFO: DLR using storage type: internal
2014-05-21 11:15:20 [8419] [0] DEBUG: Kannel bearerbox version `1.4.3'.
Build `Mar 19 2010 03:53:52', compiler `4.4.3'.
System Linux, release 2.6.32-5-686, version #1 SMP Wed Jan 12 04:01:41 UTC 2011, machine i686.
Hostname files.inf, IP 10.10.81.100.
Libxml version 2.7.6.
Using OpenSSL 0.9.8m 25 Feb 2010.
Compiled with MySQL 5.1.45, using MySQL 5.1.49.
Using SQLite 3.6.23.
Using native malloc.

2014-05-21 11:15:20 [8419] [0] INFO: Added logfile `/var/log/kannel/bearerbox.log' with level `0'.
2014-05-21 11:15:20 [8419] [0] INFO: HTTP: Opening server at port 13000.
2014-05-21 11:15:20 [8419] [0] DEBUG: Started thread 1 (gwlib/fdset.c:poller)
2014-05-21 11:15:20 [8419] [1] DEBUG: Thread 1 (gwlib/fdset.c:poller) maps to pid 8419.
2014-05-21 11:15:20 [8419] [0] DEBUG: Started thread 2 (gwlib/http.c:server_thread)
2014-05-21 11:15:20 [8419] [2] DEBUG: Thread 2 (gwlib/http.c:server_thread) maps to pid 8419.
2014-05-21 11:15:20 [8419] [0] DEBUG: Started thread 3 (gw/bb_http.c:httpadmin_run)
2014-05-21 11:15:20 [8419] [3] DEBUG: Thread 3 (gw/bb_http.c:httpadmin_run) maps to pid 8419.
2014-05-21 11:15:20 [8419] [0] DEBUG: starting smsbox connection module
2014-05-21 11:15:20 [8419] [0] INFO: BOXC: 'smsbox-max-pending' not set, using default (100).
2014-05-21 11:15:20 [8419] [0] DEBUG: Started thread 4 (gw/bb_boxc.c:sms_to_smsboxes)
2014-05-21 11:15:20 [8419] [4] DEBUG: Thread 4 (gw/bb_boxc.c:sms_to_smsboxes) maps to pid 8419.
2014-05-21 11:15:20 [8419] [0] DEBUG: Started thread 5 (gw/bb_boxc.c:smsboxc_run)
2014-05-21 11:15:20 [8419] [5] DEBUG: Thread 5 (gw/bb_boxc.c:smsboxc_run) maps to pid 8419.
2014-05-21 11:15:20 [8419] [0] INFO: Set SMS resend frequency to 60 seconds.
2014-05-21 11:15:20 [8419] [0] INFO: SMS resend retry set to unlimited.
2014-05-21 11:15:20 [8419] [0] DEBUG: smsbox MO concatenated message handling enabled
2014-05-21 11:15:20 [8419] [0] INFO: DLR rerouting for smsc id <modem1> disabled.
2014-05-21 11:15:20 [8419] [0] INFO: AT2[modem1]: configuration doesn't show modemtype. will autodetect
2014-05-21 11:15:20 [8419] [0] DEBUG: Started thread 6 (gw/smsc/smsc_at.c:at2_device_thread)
2014-05-21 11:15:20 [8419] [6] DEBUG: Thread 6 (gw/smsc/smsc_at.c:at2_device_thread) maps to pid 8419.
2014-05-21 11:15:20 [8419] [6] DEBUG: AT2[modem1]: detecting modem speed.
2014-05-21 11:15:20 [8419] [0] DEBUG: Started thread 7 (gw/bb_smscconn.c:sms_router)
2014-05-21 11:15:20 [8419] [6] INFO: AT2[modem1]: opening device
2014-05-21 11:15:20 [8419] [0] DEBUG: starting UDP sender/receiver module
2014-05-21 11:15:20 [8419] [0] INFO: Adding interface *
2014-05-21 11:15:20 [8419] [7] DEBUG: Thread 7 (gw/bb_smscconn.c:sms_router) maps to pid 8419.
2014-05-21 11:15:20 [8419] [0] DEBUG: udpc_create: Bound to UDP <0.0.0.0:9200>
2014-05-21 11:15:20 [8419] [0] DEBUG: Started thread 8 (gw/bb_udp.c:udp_receiver)
2014-05-21 11:15:20 [8419] [8] DEBUG: Thread 8 (gw/bb_udp.c:udp_receiver) maps to pid 8419.
2014-05-21 11:15:20 [8419] [6] DEBUG: AT2[modem1]: device opened. Telnet mode = 0
2014-05-21 11:15:20 [8419] [0] DEBUG: Started thread 9 (gw/bb_udp.c:udp_sender)
2014-05-21 11:15:20 [8419] [0] DEBUG: udpc_create: Bound to UDP <0.0.0.0:9201>
2014-05-21 11:15:20 [8419] [9] DEBUG: Thread 9 (gw/bb_udp.c:udp_sender) maps to pid 8419.
2014-05-21 11:15:20 [8419] [0] DEBUG: Started thread 10 (gw/bb_udp.c:udp_receiver)
2014-05-21 11:15:20 [8419] [10] DEBUG: Thread 10 (gw/bb_udp.c:udp_receiver) maps to pid 8419.
2014-05-21 11:15:20 [8419] [0] DEBUG: Started thread 11 (gw/bb_udp.c:udp_sender)
2014-05-21 11:15:20 [8419] [11] DEBUG: Thread 11 (gw/bb_udp.c:udp_sender) maps to pid 8419.
2014-05-21 11:15:20 [8419] [0] DEBUG: starting wapbox connection module
2014-05-21 11:15:20 [8419] [0] DEBUG: Started thread 12 (gw/bb_boxc.c:wdp_to_wapboxes)
2014-05-21 11:15:20 [8419] [0] DEBUG: Started thread 13 (gw/bb_boxc.c:wapboxc_run)
2014-05-21 11:15:20 [8419] [0] DEBUG: starting WDP router
2014-05-21 11:15:20 [8419] [0] DEBUG: Started thread 14 (gw/bearerbox.c:wdp_router)
2014-05-21 11:15:20 [8419] [0] INFO: ----------------------------------------
2014-05-21 11:15:20 [8419] [0] INFO: Kannel bearerbox II version 1.4.3 starting
2014-05-21 11:15:20 [8419] [0] INFO: MAIN: Start-up done, entering mainloop
2014-05-21 11:15:20 [8419] [0] DEBUG: AT2[modem1]: start called
2014-05-21 11:15:20 [8419] [13] DEBUG: Thread 13 (gw/bb_boxc.c:wapboxc_run) maps to pid 8419.
2014-05-21 11:15:20 [8419] [12] DEBUG: Thread 12 (gw/bb_boxc.c:wdp_to_wapboxes) maps to pid 8419.
2014-05-21 11:15:20 [8419] [14] DEBUG: Thread 14 (gw/bearerbox.c:wdp_router) maps to pid 8419.
2014-05-21 11:15:21 [8419] [6] DEBUG: AT2[modem1]: device opened
2014-05-21 11:15:21 [8419] [6] INFO: AT2[modem1]: speed set to 115200
2014-05-21 11:15:21 [8419] [6] DEBUG: AT2[modem1]: --> ^M
2014-05-21 11:15:23 [8419] [6] DEBUG: AT2[modem1]: --> AT^M
2014-05-21 11:15:23 [8419] [6] DEBUG: AT2[modem1]: <-- OK
2014-05-21 11:15:23 [8419] [6] INFO: AT2[modem1]: Closing device
2014-05-21 11:15:23 [8419] [6] INFO: AT2[modem1]: detect speed is 115200
2014-05-21 11:15:23 [8419] [6] DEBUG: AT2[modem1]: detecting modem type
2014-05-21 11:15:23 [8419] [6] INFO: AT2[modem1]: opening device
2014-05-21 11:15:23 [8419] [6] DEBUG: AT2[modem1]: device opened. Telnet mode = 0
2014-05-21 11:15:24 [8419] [6] DEBUG: AT2[modem1]: device opened
2014-05-21 11:15:24 [8419] [6] INFO: AT2[modem1]: speed set to 115200
2014-05-21 11:15:24 [8419] [6] DEBUG: AT2[modem1]: --> ^M
2014-05-21 11:15:26 [8419] [6] DEBUG: AT2[modem1]: --> AT^M
2014-05-21 11:15:26 [8419] [6] DEBUG: AT2[modem1]: <-- OK
2014-05-21 11:15:26 [8419] [6] DEBUG: AT2[modem1]: --> AT&F^M
2014-05-21 11:15:26 [8419] [6] DEBUG: AT2[modem1]: <-- OK
2014-05-21 11:15:26 [8419] [6] DEBUG: AT2[modem1]: --> ATE0^M
2014-05-21 11:15:26 [8419] [6] DEBUG: AT2[modem1]: <-- OK
2014-05-21 11:15:26 [8419] [6] DEBUG: AT2[modem1]: --> ATI^M
2014-05-21 11:15:26 [8419] [6] DEBUG: AT2[modem1]: <-- Manufacturer: huawei
2014-05-21 11:15:26 [8419] [6] DEBUG: AT2[modem1]: <-- Model: E122
2014-05-21 11:15:26 [8419] [6] DEBUG: AT2[modem1]: <-- Revision: 11.009.01.00.55
2014-05-21 11:15:26 [8419] [6] DEBUG: AT2[modem1]: <-- IMEI: 356881037088864
2014-05-21 11:15:26 [8419] [6] DEBUG: AT2[modem1]: <-- +GCAP: +CGSM,+DS,+ES
2014-05-21 11:15:26 [8419] [6] DEBUG: AT2[modem1]: <-- OK
2014-05-21 11:15:26 [8419] [6] DEBUG: AT2[modem1]: Cannot detect modem, using generic
2014-05-21 11:15:26 [8419] [6] DEBUG: AT2[modem1]: Reading modem definitions from </etc/kannel/kannel.conf>
2014-05-21 11:15:26 [8419] [6] DEBUG: AT2[modem1]: Found <1> modems in config
2014-05-21 11:15:26 [8419] [6] DEBUG: AT2[modem1]: --> AT+CSMS=?^M
2014-05-21 11:15:26 [8419] [6] DEBUG: AT2[modem1]: <-- +CME ERROR: SIM PIN required
2014-05-21 11:15:26 [8419] [6] INFO: AT2[modem1]: Closing device
2014-05-21 11:15:26 [8419] [6] INFO: AT2[modem1]: opening device
2014-05-21 11:15:26 [8419] [6] DEBUG: AT2[modem1]: device opened. Telnet mode = 0
2014-05-21 11:15:26 [8419] [6] DEBUG: AT2[modem1]: device opened
2014-05-21 11:15:26 [8419] [6] INFO: AT2[modem1]: Logging in
2014-05-21 11:15:27 [8419] [6] INFO: AT2[modem1]: init device
2014-05-21 11:15:27 [8419] [6] INFO: AT2[modem1]: speed set to 115200
2014-05-21 11:15:27 [8419] [6] DEBUG: AT2[modem1]: --> ATZ^M
2014-05-21 11:15:27 [8419] [6] DEBUG: AT2[modem1]: <-- OK
2014-05-21 11:15:27 [8419] [6] DEBUG: AT2[modem1]: --> AT^M
2014-05-21 11:15:27 [8419] [6] DEBUG: AT2[modem1]: <-- OK
2014-05-21 11:15:27 [8419] [6] DEBUG: AT2[modem1]: --> AT&F^M
2014-05-21 11:15:27 [8419] [6] DEBUG: AT2[modem1]: <-- OK
2014-05-21 11:15:27 [8419] [6] DEBUG: AT2[modem1]: --> ATE0^M
2014-05-21 11:15:27 [8419] [6] DEBUG: AT2[modem1]: <-- OK
2014-05-21 11:15:27 [8419] [6] DEBUG: AT2[modem1]: --> AT+IFC=2,2^M
2014-05-21 11:15:27 [8419] [6] DEBUG: AT2[modem1]: <-- COMMAND NOT SUPPORT
2014-05-21 11:15:31 [8419] [6] INFO: AT2[modem1]: cannot enable hardware handshake
2014-05-21 11:15:31 [8419] [6] DEBUG: AT2[modem1]: --> AT+CPIN?^M
2014-05-21 11:15:31 [8419] [6] DEBUG: AT2[modem1]: <-- +CPIN: SIM PIN
2014-05-21 11:15:31 [8419] [6] DEBUG: AT2[modem1]: --> AT+CPIN="1234"^M
2014-05-21 11:15:31 [8419] [6] DEBUG: AT2[modem1]: <-- OK
2014-05-21 11:15:31 [8419] [6] DEBUG: AT2[modem1]: <-- +CME ERROR: incorrect password
2014-05-21 11:15:31 [8419] [6] ERROR: AT2[modem1]: Generic error: +CME ERROR: incorrect password
2014-05-21 11:15:31 [8419] [6] DEBUG: AT2[modem1]: --> AT+CPIN?^M
2014-05-21 11:15:31 [8419] [6] DEBUG: AT2[modem1]: <-- +CPIN: SIM PIN
2014-05-21 11:15:31 [8419] [6] ERROR: AT2[modem1]: Initialization of device failed.
2014-05-21 11:15:31 [8419] [6] INFO: AT2[modem1]: Closing device
2014-05-21 11:15:31 [8419] [6] ERROR: AT2[modem1]: Couldn't connect (retrying in 10 seconds).

Code: Select all

2014-05-21 10:56:06 [7980] [0] INFO: Debug_lvl = 0, log_file = <none>, log_lvl = 0
2014-05-21 10:56:06 [7980] [0] WARNING: DLR: using default 'internal' for storage type.
2014-05-21 10:56:06 [7980] [0] INFO: DLR using storage type: internal
2014-05-21 10:56:06 [7980] [0] DEBUG: Kannel bearerbox version `1.4.3'.
Build `Mar 19 2010 03:53:52', compiler `4.4.3'.
System Linux, release 2.6.32-5-686, version #1 SMP Wed Jan 12 04:01:41 UTC 2011, machine i686.
Hostname xxxxxxxxxxxxxxx
Libxml version 2.7.6.
Using OpenSSL 0.9.8m 25 Feb 2010.
Compiled with MySQL 5.1.45, using MySQL 5.1.49.
Using SQLite 3.6.23.
Using native malloc.

2014-05-21 10:56:06 [7980] [0] INFO: Added logfile `/var/log/kannel/bearerbox.log' with level `0'.
2014-05-21 10:56:06 [7980] [0] INFO: HTTP: Opening server at port 13000.
2014-05-21 10:56:06 [7980] [0] DEBUG: Started thread 1 (gwlib/fdset.c:poller)
2014-05-21 10:56:06 [7980] [1] DEBUG: Thread 1 (gwlib/fdset.c:poller) maps to pid 7980.
2014-05-21 10:56:06 [7980] [0] DEBUG: Started thread 2 (gwlib/http.c:server_thread)
2014-05-21 10:56:06 [7980] [2] DEBUG: Thread 2 (gwlib/http.c:server_thread) maps to pid 7980.
2014-05-21 10:56:06 [7980] [0] DEBUG: Started thread 3 (gw/bb_http.c:httpadmin_run)
2014-05-21 10:56:06 [7980] [3] DEBUG: Thread 3 (gw/bb_http.c:httpadmin_run) maps to pid 7980.
2014-05-21 10:56:06 [7980] [0] DEBUG: starting smsbox connection module
2014-05-21 10:56:06 [7980] [0] INFO: BOXC: 'smsbox-max-pending' not set, using default (100).
2014-05-21 10:56:06 [7980] [0] DEBUG: Started thread 4 (gw/bb_boxc.c:sms_to_smsboxes)
2014-05-21 10:56:06 [7980] [4] DEBUG: Thread 4 (gw/bb_boxc.c:sms_to_smsboxes) maps to pid 7980.
2014-05-21 10:56:06 [7980] [0] DEBUG: Started thread 5 (gw/bb_boxc.c:smsboxc_run)
2014-05-21 10:56:06 [7980] [0] INFO: Set SMS resend frequency to 60 seconds.
2014-05-21 10:56:06 [7980] [0] INFO: SMS resend retry set to unlimited.
2014-05-21 10:56:06 [7980] [0] DEBUG: smsbox MO concatenated message handling enabled
2014-05-21 10:56:06 [7980] [0] INFO: DLR rerouting for smsc id <modem1> disabled.
2014-05-21 10:56:06 [7980] [0] INFO: AT2[modem1]: configuration doesn't show modemtype. will autodetect
2014-05-21 10:56:06 [7980] [0] DEBUG: Started thread 6 (gw/smsc/smsc_at.c:at2_device_thread)
2014-05-21 10:56:06 [7980] [6] DEBUG: Thread 6 (gw/smsc/smsc_at.c:at2_device_thread) maps to pid 7980.
2014-05-21 10:56:06 [7980] [6] DEBUG: AT2[modem1]: detecting modem speed.
2014-05-21 10:56:06 [7980] [0] DEBUG: Started thread 7 (gw/bb_smscconn.c:sms_router)
2014-05-21 10:56:06 [7980] [6] INFO: AT2[modem1]: opening device
2014-05-21 10:56:06 [7980] [0] DEBUG: starting UDP sender/receiver module
2014-05-21 10:56:06 [7980] [5] DEBUG: Thread 5 (gw/bb_boxc.c:smsboxc_run) maps to pid 7980.
2014-05-21 10:56:06 [7980] [7] DEBUG: Thread 7 (gw/bb_smscconn.c:sms_router) maps to pid 7980.
2014-05-21 10:56:06 [7980] [0] INFO: Adding interface *
2014-05-21 10:56:06 [7980] [0] DEBUG: udpc_create: Bound to UDP <0.0.0.0:9200>
2014-05-21 10:56:06 [7980] [0] DEBUG: Started thread 8 (gw/bb_udp.c:udp_receiver)
2014-05-21 10:56:06 [7980] [0] DEBUG: Started thread 9 (gw/bb_udp.c:udp_sender)
2014-05-21 10:56:06 [7980] [6] DEBUG: AT2[modem1]: device opened. Telnet mode = 0
2014-05-21 10:56:06 [7980] [0] DEBUG: udpc_create: Bound to UDP <0.0.0.0:9201>
2014-05-21 10:56:06 [7980] [0] DEBUG: Started thread 10 (gw/bb_udp.c:udp_receiver)
2014-05-21 10:56:06 [7980] [0] DEBUG: Started thread 11 (gw/bb_udp.c:udp_sender)
2014-05-21 10:56:06 [7980] [0] DEBUG: starting wapbox connection module
2014-05-21 10:56:06 [7980] [11] DEBUG: Thread 11 (gw/bb_udp.c:udp_sender) maps to pid 7980.
2014-05-21 10:56:06 [7980] [0] DEBUG: Started thread 12 (gw/bb_boxc.c:wdp_to_wapboxes)
2014-05-21 10:56:06 [7980] [12] DEBUG: Thread 12 (gw/bb_boxc.c:wdp_to_wapboxes) maps to pid 7980.
2014-05-21 10:56:06 [7980] [9] DEBUG: Thread 9 (gw/bb_udp.c:udp_sender) maps to pid 7980.
2014-05-21 10:56:06 [7980] [8] DEBUG: Thread 8 (gw/bb_udp.c:udp_receiver) maps to pid 7980.
2014-05-21 10:56:06 [7980] [10] DEBUG: Thread 10 (gw/bb_udp.c:udp_receiver) maps to pid 7980.
2014-05-21 10:56:06 [7980] [0] DEBUG: Started thread 13 (gw/bb_boxc.c:wapboxc_run)
2014-05-21 10:56:06 [7980] [0] DEBUG: starting WDP router
2014-05-21 10:56:06 [7980] [0] DEBUG: Started thread 14 (gw/bearerbox.c:wdp_router)
2014-05-21 10:56:06 [7980] [13] DEBUG: Thread 13 (gw/bb_boxc.c:wapboxc_run) maps to pid 7980.
2014-05-21 10:56:06 [7980] [0] INFO: ----------------------------------------
2014-05-21 10:56:06 [7980] [0] INFO: Kannel bearerbox II version 1.4.3 starting
2014-05-21 10:56:06 [7980] [0] INFO: MAIN: Start-up done, entering mainloop
2014-05-21 10:56:06 [7980] [14] DEBUG: Thread 14 (gw/bearerbox.c:wdp_router) maps to pid 7980.
2014-05-21 10:56:06 [7980] [0] DEBUG: AT2[modem1]: start called
2014-05-21 10:56:07 [7980] [6] DEBUG: AT2[modem1]: device opened
2014-05-21 10:56:07 [7980] [6] INFO: AT2[modem1]: speed set to 115200
2014-05-21 10:56:07 [7980] [6] DEBUG: AT2[modem1]: --> ^M
2014-05-21 10:56:09 [7980] [6] DEBUG: AT2[modem1]: --> AT^M
2014-05-21 10:56:09 [7980] [6] DEBUG: AT2[modem1]: <-- OK
2014-05-21 10:56:09 [7980] [6] INFO: AT2[modem1]: Closing device
2014-05-21 10:56:09 [7980] [6] INFO: AT2[modem1]: detect speed is 115200
2014-05-21 10:56:09 [7980] [6] DEBUG: AT2[modem1]: detecting modem type
2014-05-21 10:56:09 [7980] [6] INFO: AT2[modem1]: opening device
2014-05-21 10:56:09 [7980] [6] DEBUG: AT2[modem1]: device opened. Telnet mode = 0
2014-05-21 10:56:10 [7980] [6] DEBUG: AT2[modem1]: device opened
2014-05-21 10:56:10 [7980] [6] INFO: AT2[modem1]: speed set to 115200
2014-05-21 10:56:10 [7980] [6] DEBUG: AT2[modem1]: --> ^M
2014-05-21 10:56:12 [7980] [6] DEBUG: AT2[modem1]: --> AT^M
2014-05-21 10:56:12 [7980] [6] DEBUG: AT2[modem1]: <-- OK
2014-05-21 10:56:12 [7980] [6] DEBUG: AT2[modem1]: --> AT&F^M
2014-05-21 10:56:12 [7980] [6] DEBUG: AT2[modem1]: <-- OK
2014-05-21 10:56:12 [7980] [6] DEBUG: AT2[modem1]: --> ATE0^M
2014-05-21 10:56:12 [7980] [6] DEBUG: AT2[modem1]: <-- OK
2014-05-21 10:56:12 [7980] [6] DEBUG: AT2[modem1]: --> ATI^M
2014-05-21 10:56:12 [7980] [6] DEBUG: AT2[modem1]: <-- Manufacturer: huawei
2014-05-21 10:56:12 [7980] [6] DEBUG: AT2[modem1]: <-- Model: E122
2014-05-21 10:56:12 [7980] [6] DEBUG: AT2[modem1]: <-- Revision: 11.009.01.00.55
2014-05-21 10:56:12 [7980] [6] DEBUG: AT2[modem1]: <-- IMEI: xxxxxxxxxxxxxx
2014-05-21 10:56:12 [7980] [6] DEBUG: AT2[modem1]: <-- +GCAP: +CGSM,+DS,+ES
2014-05-21 10:56:12 [7980] [6] DEBUG: AT2[modem1]: <-- OK
2014-05-21 10:56:12 [7980] [6] DEBUG: AT2[modem1]: Cannot detect modem, using generic
2014-05-21 10:56:12 [7980] [6] DEBUG: AT2[modem1]: Reading modem definitions from </etc/kannel/kannel.conf>
2014-05-21 10:56:12 [7980] [6] DEBUG: AT2[modem1]: Found <1> modems in config
2014-05-21 10:56:12 [7980] [6] DEBUG: AT2[modem1]: --> AT+CSMS=?^M
2014-05-21 10:56:12 [7980] [6] DEBUG: AT2[modem1]: <-- +CSMS: (0,1)
2014-05-21 10:56:12 [7980] [6] DEBUG: AT2[modem1]: <-- OK
2014-05-21 10:56:12 [7980] [6] INFO: AT2[modem1]: Phase 2+ is supported
2014-05-21 10:56:12 [7980] [6] INFO: AT2[modem1]: Closing device
2014-05-21 10:56:12 [7980] [6] INFO: AT2[modem1]: opening device
2014-05-21 10:56:12 [7980] [6] DEBUG: AT2[modem1]: device opened. Telnet mode = 0
2014-05-21 10:56:12 [7980] [6] DEBUG: AT2[modem1]: device opened
2014-05-21 10:56:12 [7980] [6] INFO: AT2[modem1]: Logging in
2014-05-21 10:56:13 [7980] [6] INFO: AT2[modem1]: init device
2014-05-21 10:56:13 [7980] [6] INFO: AT2[modem1]: speed set to 115200
2014-05-21 10:56:13 [7980] [6] DEBUG: AT2[modem1]: --> ATZ^M
2014-05-21 10:56:13 [7980] [6] DEBUG: AT2[modem1]: <-- OK
2014-05-21 10:56:13 [7980] [6] DEBUG: AT2[modem1]: --> AT^M
2014-05-21 10:56:13 [7980] [6] DEBUG: AT2[modem1]: <-- OK
2014-05-21 10:56:13 [7980] [6] DEBUG: AT2[modem1]: --> AT&F^M
2014-05-21 10:56:13 [7980] [6] DEBUG: AT2[modem1]: <-- OK
2014-05-21 10:56:13 [7980] [6] DEBUG: AT2[modem1]: --> ATE0^M
2014-05-21 10:56:13 [7980] [6] DEBUG: AT2[modem1]: <-- OK
2014-05-21 10:56:13 [7980] [6] DEBUG: AT2[modem1]: --> AT+IFC=2,2^M
2014-05-21 10:56:13 [7980] [6] DEBUG: AT2[modem1]: <-- COMMAND NOT SUPPORT
2014-05-21 10:56:17 [7980] [6] INFO: AT2[modem1]: cannot enable hardware handshake
2014-05-21 10:56:17 [7980] [6] DEBUG: AT2[modem1]: --> AT+CPIN?^M
2014-05-21 10:56:17 [7980] [6] DEBUG: AT2[modem1]: <-- +CPIN: READY
2014-05-21 10:56:17 [7980] [6] DEBUG: AT2[modem1]: <-- OK
2014-05-21 10:56:17 [7980] [6] DEBUG: AT2[modem1]: --> AT+CSCA="+48501200777"^M
2014-05-21 10:56:17 [7980] [6] DEBUG: AT2[modem1]: <-- +CMS ERROR: (U)SIM not inserted
2014-05-21 10:56:17 [7980] [6] ERROR: AT2[modem1]: CMS ERROR: +CMS ERROR: (U)SIM not inserted
2014-05-21 10:56:17 [7980] [6] INFO: AT2[modem1]: Cannot set SMS message center, continuing
2014-05-21 10:56:17 [7980] [6] DEBUG: AT2[modem1]: --> AT+CMGF=0^M
2014-05-21 10:56:17 [7980] [6] DEBUG: AT2[modem1]: <-- OK
2014-05-21 10:56:17 [7980] [6] DEBUG: AT2[modem1]: --> AT+CSMS=?^M
2014-05-21 10:56:17 [7980] [6] DEBUG: AT2[modem1]: <-- +CSMS: (0,1)
2014-05-21 10:56:17 [7980] [6] DEBUG: AT2[modem1]: <-- OK
2014-05-21 10:56:17 [7980] [6] INFO: AT2[modem1]: Phase 2+ is supported
2014-05-21 10:56:17 [7980] [6] DEBUG: AT2[modem1]: --> AT+CSMS=1^M
2014-05-21 10:56:17 [7980] [6] DEBUG: AT2[modem1]: <-- +CSMS: 1,1,0
2014-05-21 10:56:17 [7980] [6] DEBUG: AT2[modem1]: <-- OK
2014-05-21 10:56:17 [7980] [6] DEBUG: AT2[modem1]: --> AT+CNMI=1,2,0,1,0^M
2014-05-21 10:56:17 [7980] [6] DEBUG: AT2[modem1]: <-- OK
2014-05-21 10:56:17 [7980] [6] INFO: AT2[modem1]: AT SMSC successfully opened.
2014-05-21 10:56:19 [7980] [6] DEBUG: AT2[modem1]: --> AT+CPMS?^M
2014-05-21 10:56:19 [7980] [6] DEBUG: AT2[modem1]: <-- +CPMS: "SM",0,0,"SM",0,0,"SM",0,0
2014-05-21 10:56:19 [7980] [6] DEBUG: AT2[modem1]: <-- OK

Any help will be greatly appreciated.

Best Regards,
Krystian

SparkFun Forums