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

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?

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

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 :frowning:

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

Leon

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.

According to this site:

http://www.developershome.com/sms/resultCodes2.asp

310 means it cannot read the sim card

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.”

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

# 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).
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