Operating system name and version: OpenWRT 10.03.1-rc5
Version of smsd: 3.1.14
Smsd installed from: Binary
Name and model of a modem / phone: Huawei E1550 (Reported by lsusb as E620)
Interface: USB

Hello there,

smsd seems to lock up after sending an sms.
After restarting smsd, it gets to

2010-04-06 03:31:01,6, huawei: Checking if modem is ready 2010-04-06 03:31:02,7, huawei: -> A

and then just stops doing anything.
Reffer to the bottom for the whole startup log after restart.



Log after reboot:
2010-04-06 03:18:12,2, smsd: Smsd v3.1.14 started. 2010-04-06 03:18:12,2, smsd: Running as smsd:smsd. 2010-04-06 03:18:12,7, smsd: Running startup_check (shell): /var/spool/sms/incoming/smsd_script.Kd2Z7d /tmp/smsd_data.aRal1V 2010-04-06 03:18:12,7, smsd: Done: startup_check (shell), execution time 0 sec., status: 0 (0) 2010-04-06 03:18:12,4, smsd: File mode creation mask: 022 (0644, rw-r--r--). 2010-04-06 03:18:12,5, smsd: Outgoing file checker has started. PID: 1496. 2010-04-06 03:18:12,7, smsd: All PID's: 1496,1498 2010-04-06 03:18:12,5, huawei: Modem handler 0 has started. PID: 1498. 2010-04-06 03:18:12,3, huawei: Couldn't open serial port /dev/ttyUSB0, error: Permission denied, waiting 30 sec. 2010-04-06 03:18:42,5, huawei: Using check_memory_method 1: CPMS is used. 2010-04-06 03:18:42,6, huawei: Checking device for incoming SMS 2010-04-06 03:18:42,6, huawei: Checking if modem is ready 2010-04-06 03:18:43,7, huawei: -> AT 2010-04-06 03:18:43,7, huawei: Command is sent, waiting for the answer 2010-04-06 03:18:43,7, huawei: <- OK 2010-04-06 03:18:43,6, huawei: Pre-initializing modem 2010-04-06 03:18:43,7, huawei: -> ATE0+CMEE=1;+CREG=2 2010-04-06 03:18:43,7, huawei: Command is sent, waiting for the answer 2010-04-06 03:18:43,7, huawei: <- OK 2010-04-06 03:18:43,6, huawei: Checking if modem needs PIN 2010-04-06 03:18:44,7, huawei: -> AT+CPIN? 2010-04-06 03:18:44,7, huawei: Command is sent, waiting for the answer 2010-04-06 03:18:44,7, huawei: <- +CPIN: READY OK 2010-04-06 03:18:44,6, huawei: Initializing modem 2010-04-06 03:18:44,7, huawei: -> AT+CPMS="sm","ME","" 2010-04-06 03:18:44,7, huawei: Command is sent, waiting for the answer 2010-04-06 03:18:44,7, huawei: <- +CPMS: 0,20,0,23,0,20 OK 2010-04-06 03:18:45,7, huawei: -> AT+CSQ 2010-04-06 03:18:45,7, huawei: Command is sent, waiting for the answer 2010-04-06 03:18:45,7, huawei: <- +CSQ: 8,99 OK 2010-04-06 03:18:45,6, huawei: Signal Strength Indicator: (8,99) -97 dBm (Marginal) 2010-04-06 03:18:45,6, huawei: Checking if Modem is registered to the network 2010-04-06 03:18:45,7, huawei: -> AT+CREG? 2010-04-06 03:18:45,7, huawei: Command is sent, waiting for the answer 2010-04-06 03:18:45,7, huawei: <- +CREG: 2,1,5277,37BE OK 2010-04-06 03:18:45,6, huawei: Modem is registered to the network 2010-04-06 03:18:45,6, huawei: Location area code: 5277, Cell ID: 37BE 2010-04-06 03:18:46,7, huawei: -> AT+CSQ 2010-04-06 03:18:46,7, huawei: Command is sent, waiting for the answer 2010-04-06 03:18:46,7, huawei: <- +CSQ: 8,99 OK 2010-04-06 03:18:46,6, huawei: Signal Strength Indicator: (8,99) -97 dBm (Marginal) 2010-04-06 03:18:46,6, huawei: Selecting PDU mode 2010-04-06 03:18:46,7, huawei: -> AT+CMGF=0 2010-04-06 03:18:46,7, huawei: Command is sent, waiting for the answer 2010-04-06 03:18:46,7, huawei: <- OK 2010-04-06 03:18:43,6, huawei: Checking if modem needs PIN 2010-04-06 03:18:44,7, huawei: -> AT+CPIN? 2010-04-06 03:18:44,7, huawei: Command is sent, waiting for the answer 2010-04-06 03:18:44,7, huawei: <- +CPIN: READY OK 2010-04-06 03:18:44,6, huawei: Initializing modem 2010-04-06 03:18:44,7, huawei: -> AT+CPMS="sm","ME","" 2010-04-06 03:18:44,7, huawei: Command is sent, waiting for the answer 2010-04-06 03:18:44,7, huawei: <- +CPMS: 0,20,0,23,0,20 OK 2010-04-06 03:18:45,7, huawei: -> AT+CSQ 2010-04-06 03:18:45,7, huawei: Command is sent, waiting for the answer 2010-04-06 03:18:45,7, huawei: <- +CSQ: 8,99 OK 2010-04-06 03:18:45,6, huawei: Signal Strength Indicator: (8,99) -97 dBm (Marginal) 2010-04-06 03:18:45,6, huawei: Checking if Modem is registered to the network 2010-04-06 03:18:45,7, huawei: -> AT+CREG? 2010-04-06 03:18:45,7, huawei: Command is sent, waiting for the answer 2010-04-06 03:18:45,7, huawei: <- +CREG: 2,1,5277,37BE OK 2010-04-06 03:18:45,6, huawei: Modem is registered to the network 2010-04-06 03:18:45,6, huawei: Location area code: 5277, Cell ID: 37BE 2010-04-06 03:18:46,7, huawei: -> AT+CSQ 2010-04-06 03:18:46,7, huawei: Command is sent, waiting for the answer 2010-04-06 03:18:46,7, huawei: <- +CSQ: 8,99 OK 2010-04-06 03:18:46,6, huawei: Signal Strength Indicator: (8,99) -97 dBm (Marginal) 2010-04-06 03:18:46,6, huawei: Selecting PDU mode 2010-04-06 03:18:46,7, huawei: -> AT+CMGF=0 2010-04-06 03:18:46,7, huawei: Command is sent, waiting for the answer 2010-04-06 03:18:46,7, huawei: <- OK 2010-04-06 03:18:47,7, huawei: -> AT+CIMI 2010-04-06 03:18:47,7, huawei: Command is sent, waiting for the answer 2010-04-06 03:18:47,7, huawei: <- xxxxxxxxxxxxx OK 2010-04-06 03:18:47,7, huawei: -> AT+CGSN 2010-04-06 03:18:47,7, huawei: Command is sent, waiting for the answer 2010-04-06 03:18:47,7, huawei: <- xxxxxxxxx OK 2010-04-06 03:18:47,5, huawei: CGSN: xxxxxxxxxxxxxxx 2010-04-06 03:18:47,5, huawei: IMSI: xxxxxxxxxxxxxx 2010-04-06 03:18:47,6, huawei: Checking if reading of messages is supported 2010-04-06 03:18:48,7, huawei: -> AT+CPMS? 2010-04-06 03:18:48,7, huawei: Command is sent, waiting for the answer 2010-04-06 03:18:48,7, huawei: <- +CPMS: "SM",0,20,"ME",0,23,"SM",0,20 OK 2010-04-06 03:18:48,6, huawei: Checking memory size 2010-04-06 03:18:48,7, huawei: -> AT+CPMS? 2010-04-06 03:18:48,7, huawei: Command is sent, waiting for the answer 2010-04-06 03:18:48,7, huawei: <- +CPMS: "SM",0,20,"ME",0,23,"SM",0,20 OK 2010-04-06 03:18:48,6, huawei: Used memory is 0 of 20 2010-04-06 03:18:48,6, huawei: No SMS received *snip* 2010-04-06 03:23:03,5, smsd: Moved file /var/spool/sms/outgoing/send_J5jdrq to /var/spool/sms/checked 2010-04-06 03:23:04,6, huawei: I have to send 1 short message for /var/spool/sms/checked/send_J5jdrq 2010-04-06 03:23:04,6, huawei: Sending SMS from to xxxxxxxxxxxxx 2010-04-06 03:23:04,6, huawei: Checking if modem is ready 2010-04-06 03:23:04,7, huawei: -> AT 2010-04-06 03:23:04,7, huawei: Command is sent, waiting for the answer 2010-04-06 03:23:04,7, huawei: <- OK 2010-04-06 03:23:04,6, huawei: Pre-initializing modem 2010-04-06 03:23:05,7, huawei: -> ATE0+CMEE=1;+CREG=2 2010-04-06 03:23:05,7, huawei: Command is sent, waiting for the answer 2010-04-06 03:23:05,7, huawei: <- OK 2010-04-06 03:23:05,6, huawei: Checking if modem needs PIN 2010-04-06 03:23:05,7, huawei: -> AT+CPIN? 2010-04-06 03:23:05,7, huawei: Command is sent, waiting for the answer 2010-04-06 03:23:05,7, huawei: <- +CPIN: READY OK 2010-04-06 03:23:05,6, huawei: Initializing modem 2010-04-06 03:23:06,7, huawei: -> AT+CPMS="sm","ME","" 2010-04-06 03:23:06,7, huawei: Command is sent, waiting for the answer 2010-04-06 03:23:06,7, huawei: <- +CPMS: 0,20,0,23,0,20 OK 2010-04-06 03:23:06,7, huawei: -> AT+CSQ 2010-04-06 03:23:06,7, huawei: Command is sent, waiting for the answer 2010-04-06 03:23:06,7, huawei: <- +CSQ: 8,99 OK 2010-04-06 03:23:06,6, huawei: Signal Strength Indicator: (8,99) -97 dBm (Marginal) 2010-04-06 03:23:06,6, huawei: Checking if Modem is registered to the network 2010-04-06 03:23:07,7, huawei: -> AT+CREG? 2010-04-06 03:23:07,7, huawei: Command is sent, waiting for the answer 2010-04-06 03:23:07,7, huawei: <- +CREG: 2,1,5277,37BE OK 2010-04-06 03:23:07,6, huawei: Modem is registered to the network 2010-04-06 03:23:07,6, huawei: Selecting PDU mode 2010-04-06 03:23:07,7, huawei: -> AT+CMGF=0 2010-04-06 03:23:07,7, huawei: Command is sent, waiting for the answer 2010-04-06 03:23:07,7, huawei: <- OK 2010-04-06 03:23:08,7, huawei: -> AT+CMGS=23 2010-04-06 03:23:08,7, huawei: Command is sent, waiting for the answer 2010-04-06 03:23:08,7, huawei: <- > 2010-04-06 03:23:08,7, huawei: -> xxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxx. 2010-04-06 03:23:08,7, huawei: Command is sent, waiting for the answer 2010-04-06 03:24:08,7, huawei: [b]put_command expected (OK)|(ERROR), timeout occurred. 1.[/b] 2010-04-06 03:24:08,7, huawei: <- 2010-04-06 03:24:08,3, huawei: The modem answer was not OK: 2010-04-06 03:24:08,5, huawei: Waiting 10 sec. before retrying 2010-04-06 03:24:18,6, huawei: Checking if modem is ready 2010-04-06 03:24:19,7, huawei: -> AT

I suspect that the "Couldn't open serial port /dev/ttyUSB0, error: Permission denied, waiting 30 sec." line ist from slow device settling.

After restarting smsd, the following can be found in the log file:

2010-04-06 03:29:47,2, smsd: Smsd v3.1.14 started. 2010-04-06 03:29:47,2, smsd: Running as smsd:smsd. 2010-04-06 03:29:47,7, smsd: Running startup_check (shell): /var/spool/sms/incoming/smsd_script.5GTPJX /tmp/smsd_data.gvkAE3 2010-04-06 03:29:47,7, smsd: Done: startup_check (shell), execution time 0 sec., status: 0 (0) 2010-04-06 03:29:47,4, smsd: File mode creation mask: 022 (0644, rw-r--r--). 2010-04-06 03:29:47,5, smsd: Outgoing file checker has started. PID: 1861. 2010-04-06 03:29:47,7, smsd: All PID's: 1861,1862 2010-04-06 03:29:47,5, huawei: Modem handler 0 has started. PID: 1862. 2010-04-06 03:30:16,2, huawei: Modem handler 0 terminated. PID: 1498, was started 10-04-06 03:18:12. 2010-04-06 03:30:16,2, smsd: Smsd mainprocess terminated. PID 1496, was started 10-04-06 03:18:12. 2010-04-06 03:30:16,3, huawei: Couldn't open serial port /dev/ttyUSB0, error: Input/output error, waiting 30 sec. 2010-04-06 03:31:01,5, huawei: Using check_memory_method 1: CPMS is used. 2010-04-06 03:31:01,6, huawei: Checking device for incoming SMS 2010-04-06 03:31:01,6, huawei: Checking if modem is ready 2010-04-06 03:31:02,7, huawei: -> AT

Nothing happens from then on.
There are no error messages in the syslog.

Addendum:
smsd actually DOES send the sms, it just freezes afterwards.
It works with a different stick. (e220)
The bug exists on two similar systems (same host, same stick) though, which should rule out hardware failure.

Correction:
Bug occurs with both sticks, just takes longer to manifest.
Sorry for spamming the thread.

Couldn't open serial port /dev/ttyUSB0, error: Input/output error, waiting 30 sec.

Maybe you have to change the port, USB0,1,2,3.

You should have more ports. The higher number should be the right port.