Hi all. I'm currently using a Nokia 9500 as a GSM modem. I have
sucessfully used this phone with gnokii to send out a few SMS. Now I'm
working with kannel to get it working as a HTTP SMS service. I thought
i had my conf file perfect until i recieved the following message.
2005-08-02 15:28:20 [1209] [6] DEBUG: AT2[/dev/ttyACM0]: <-- Nokia
2005-08-02 15:28:20 [1209] [6] DEBUG: AT2[/dev/ttyACM0]: <-- OK
2005-08-02 15:28:20 [1209] [6] PANIC: Where are the modem definitions ?!?!
2005-08-02 15:28:20 [1209] [6] PANIC: ./bearerbox(gw_panic+0x174)
[0x80c9178]
So i read a little more about the 'modem definitions' and I setup a
simple definition.
group = modems
id = 9500
detect-string = Nokia
Now when I start bearerbox it seems to get stuck in an endless loop of
initazing the modem. The error seems to be "CMS ERROR: +CMS ERROR: 301
(SMS service of ME reserved)" I'm not sure what I'm doing wrong, and
where to go from here. Any help would be appreciated.
The following is the output of the loop.
2005-08-02 15:32:18 [1247] [0] INFO: HTTP: Opening server at port 13000.
2005-08-02 15:32:18 [1247] [0] DEBUG: Started thread 1
(gwlib/fdset.c:poller)
2005-08-02 15:32:18 [1247] [0] DEBUG: Started thread 2
(gwlib/http.c:server_thread)
2005-08-02 15:32:18 [1247] [0] DEBUG: Started thread 3
(gw/bb_http.c:httpadmin_run)
2005-08-02 15:32:18 [1247] [0] DEBUG: starting smsbox connection module
2005-08-02 15:32:18 [1247] [0] INFO: BOXC: 'smsbox-max-pending' not set,
using default (100).
2005-08-02 15:32:18 [1247] [0] DEBUG: Started thread 4
(gw/bb_boxc.c:sms_to_smsboxes)
2005-08-02 15:32:18 [1247] [0] DEBUG: Started thread 5
(gw/bb_boxc.c:smsboxc_run)
2005-08-02 15:32:18 [1247] [0] INFO: DLR rerouting for smsc id <(null)>
disabled.
2005-08-02 15:32:18 [1247] [0] INFO: AT2[/dev/ttyACM0]: configuration
doesn't show modemtype. will autodetect
2005-08-02 15:32:18 [1247] [1] DEBUG: Thread 1 (gwlib/fdset.c:poller)
maps to pid 1247.
2005-08-02 15:32:18 [1247] [2] DEBUG: Thread 2
(gwlib/http.c:server_thread) maps to pid 1247.
2005-08-02 15:32:18 [1247] [3] DEBUG: Thread 3
(gw/bb_http.c:httpadmin_run) maps to pid 1247.
2005-08-02 15:32:18 [1247] [4] DEBUG: Thread 4
(gw/bb_boxc.c:sms_to_smsboxes) maps to pid 1247.
2005-08-02 15:32:18 [1247] [5] DEBUG: Thread 5
(gw/bb_boxc.c:smsboxc_run) maps to pid 1247.
2005-08-02 15:32:18 [1247] [0] DEBUG: Started thread 6
(gw/smsc/smsc_at.c:at2_device_thread)
2005-08-02 15:32:18 [1247] [0] DEBUG: Started thread 7
(gw/bb_smscconn.c:sms_router)
2005-08-02 15:32:18 [1247] [0] INFO:
----------------------------------------
2005-08-02 15:32:18 [1247] [0] INFO: Kannel bearerbox II version 1.4.0
starting
2005-08-02 15:32:18 [1247] [0] INFO: MAIN: Start-up done, entering mainloop
2005-08-02 15:32:18 [1247] [0] DEBUG: AT2[/dev/ttyACM0]: start called
2005-08-02 15:32:18 [1247] [6] DEBUG: Thread 6
(gw/smsc/smsc_at.c:at2_device_thread) maps to pid 1247.
2005-08-02 15:32:18 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: detecting modem
speed.
2005-08-02 15:32:18 [1247] [6] INFO: AT2[/dev/ttyACM0]: opening device
2005-08-02 15:32:18 [1247] [7] DEBUG: Thread 7
(gw/bb_smscconn.c:sms_router) maps to pid 1247.
2005-08-02 15:32:18 [1247] [7] DEBUG: sms_router: time to sleep
2005-08-02 15:32:18 [1247] [7] DEBUG: sms_router: list_len = 0
2005-08-02 15:32:18 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: device opened
2005-08-02 15:32:19 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: device opened
2005-08-02 15:32:19 [1247] [6] INFO: AT2[/dev/ttyACM0]: speed set to 115200
2005-08-02 15:32:19 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: --> ^M
2005-08-02 15:32:21 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: --> AT^M
2005-08-02 15:32:21 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: <-- OK
2005-08-02 15:32:21 [1247] [6] INFO: AT2[/dev/ttyACM0]: closing device
2005-08-02 15:32:21 [1247] [6] INFO: AT2[/dev/ttyACM0]: detect speed is
115200
2005-08-02 15:32:21 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: detecting modem
type
2005-08-02 15:32:21 [1247] [6] INFO: AT2[/dev/ttyACM0]: opening device
2005-08-02 15:32:21 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: device opened
2005-08-02 15:32:22 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: device opened
2005-08-02 15:32:22 [1247] [6] INFO: AT2[/dev/ttyACM0]: speed set to 115200
2005-08-02 15:32:22 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: --> ^M
2005-08-02 15:32:24 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: --> AT^M
2005-08-02 15:32:24 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: <-- OK
2005-08-02 15:32:24 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: --> AT&F^M
2005-08-02 15:32:24 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: <-- OK
2005-08-02 15:32:24 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: --> ATE0^M
2005-08-02 15:32:24 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: <-- ATE0
2005-08-02 15:32:24 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: <-- OK
2005-08-02 15:32:24 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: --> ATI^M
2005-08-02 15:32:24 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: <-- Nokia
2005-08-02 15:32:24 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: <-- OK
2005-08-02 15:32:24 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: found string
<Nokia>, using modem definition <9500>
2005-08-02 15:32:24 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: --> AT+CSMS=?^M
2005-08-02 15:32:24 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: <-- +CSMS: (0,1)
2005-08-02 15:32:24 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: <-- OK
2005-08-02 15:32:24 [1247] [6] INFO: AT2[/dev/ttyACM0]: Phase 2+ is
supported
2005-08-02 15:32:24 [1247] [6] INFO: AT2[/dev/ttyACM0]: closing device
2005-08-02 15:32:24 [1247] [6] INFO: AT2[/dev/ttyACM0]: opening device
2005-08-02 15:32:24 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: device opened
2005-08-02 15:32:24 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: device opened
2005-08-02 15:32:24 [1247] [6] INFO: AT2[/dev/ttyACM0]: init device
2005-08-02 15:32:24 [1247] [6] INFO: AT2[/dev/ttyACM0]: speed set to 115200
2005-08-02 15:32:24 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: --> ATZ^M
2005-08-02 15:32:24 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: <-- OK
2005-08-02 15:32:24 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: --> AT^M
2005-08-02 15:32:24 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: <-- AT
2005-08-02 15:32:24 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: <-- OK
2005-08-02 15:32:24 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: --> AT&F^M
2005-08-02 15:32:24 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: <-- AT&F
2005-08-02 15:32:24 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: <-- OK
2005-08-02 15:32:24 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: --> ATE0^M
2005-08-02 15:32:25 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: <-- ATE0
2005-08-02 15:32:25 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: <-- OK
2005-08-02 15:32:25 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: --> AT+IFC=2,2^M
2005-08-02 15:32:25 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: <-- OK
2005-08-02 15:32:25 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: --> AT+CPIN?^M
2005-08-02 15:32:25 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: <-- +CPIN: READY
2005-08-02 15:32:25 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: <-- OK
2005-08-02 15:32:25 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: --> AT+CMGF=0^M
2005-08-02 15:32:25 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: <-- OK
2005-08-02 15:32:25 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: --> AT+CSMS=?^M
2005-08-02 15:32:25 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: <-- +CSMS: (0,1)
2005-08-02 15:32:25 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: <-- OK
2005-08-02 15:32:25 [1247] [6] INFO: AT2[/dev/ttyACM0]: Phase 2+ is
supported
2005-08-02 15:32:25 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: --> AT+CSMS=1^M
2005-08-02 15:32:25 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: <-- +CSMS: 1,1,1
2005-08-02 15:32:25 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: <-- OK
2005-08-02 15:32:25 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: -->
AT+CNMI=1,2,0,1,0^M
2005-08-02 15:32:25 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: <-- +CMS ERROR: 301
2005-08-02 15:32:25 [1247] [6] ERROR: AT2[/dev/ttyACM0]: CMS ERROR: +CMS
ERROR: 301 (SMS service of ME reserved)
2005-08-02 15:32:25 [1247] [6] ERROR: AT2[/dev/ttyACM0]: Opening failed.
Terminating
2005-08-02 15:32:25 [1247] [6] INFO: AT2[/dev/ttyACM0]: closing device
2005-08-02 15:32:25 [1247] [6] INFO: AT2[/dev/ttyACM0]: opening device
2005-08-02 15:32:25 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: device opened
2005-08-02 15:32:25 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: device opened
2005-08-02 15:32:25 [1247] [6] INFO: AT2[/dev/ttyACM0]: init device
2005-08-02 15:32:25 [1247] [6] INFO: AT2[/dev/ttyACM0]: speed set to 115200
2005-08-02 15:32:25 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: --> ATZ^M
2005-08-02 15:32:25 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: <-- OK
2005-08-02 15:32:25 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: --> AT^M
2005-08-02 15:32:25 [1247] [0] WARNING: Killing signal or HTTP admin
command received, shutting down...
2005-08-02 15:32:25 [1247] [0] DEBUG: Shutting down Kannel...
2005-08-02 15:32:25 [1247] [0] DEBUG: shutting down smsc
2005-08-02 15:32:25 [1247] [0] DEBUG: AT2[/dev/ttyACM0]: Shutting down
SMSCConn, slow
2005-08-02 15:32:25 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: <-- AT
2005-08-02 15:32:25 [1247] [0] DEBUG: shutting down udp
2005-08-02 15:32:25 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: <-- OK
2005-08-02 15:32:25 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: --> AT&F^M
2005-08-02 15:32:26 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: <-- AT&F
2005-08-02 15:32:26 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: <-- OK
2005-08-02 15:32:26 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: --> ATE0^M
2005-08-02 15:32:26 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: <-- ATE0
2005-08-02 15:32:26 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: <-- OK
2005-08-02 15:32:26 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: --> AT+IFC=2,2^M
2005-08-02 15:32:26 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: <-- OK
2005-08-02 15:32:26 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: --> AT+CPIN?^M
2005-08-02 15:32:26 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: <-- +CPIN: READY
2005-08-02 15:32:26 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: <-- OK
2005-08-02 15:32:26 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: --> AT+CMGF=0^M
2005-08-02 15:32:26 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: <-- OK
2005-08-02 15:32:26 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: --> AT+CSMS=?^M
2005-08-02 15:32:26 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: <-- +CSMS: (0,1)
2005-08-02 15:32:26 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: <-- OK
2005-08-02 15:32:26 [1247] [6] INFO: AT2[/dev/ttyACM0]: Phase 2+ is
supported
2005-08-02 15:32:26 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: --> AT+CSMS=1^M
2005-08-02 15:32:26 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: <-- +CSMS: 1,1,1
2005-08-02 15:32:26 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: <-- OK
2005-08-02 15:32:26 [1247] [6] DEBUG: AT2[/dev/ttyACM0]: -->
AT+CNMI=1,2,0,1,0^M
2005-08-02 15:32:26 [1247] [0] PANIC: Cannot die by its own will
2005-08-02 15:32:26 [1247] [0] PANIC: ./bearerbox(gw_panic+0x174)
[0x80c9178]
2005-08-02 15:32:26 [1247] [0] PANIC: ./bearerbox [0x8051d54]
2005-08-02 15:32:26 [1247] [0] PANIC: /lib/tls/libpthread.so.0 [0x88c8a8]
2005-08-02 15:32:26 [1247] [0] PANIC: ./bearerbox(main+0x3b5) [0x8052d92]
2005-08-02 15:32:26 [1247] [0] PANIC:
/lib/tls/libc.so.6(__libc_start_main+0xe3) [0x666e33]
2005-08-02 15:32:26 [1247] [0] PANIC: ./bearerbox [0x8051be9]