webik: Operating system name and version: CentOS 7.7
Version of smsd: 3.1.15-12
Smsd installed from: EPEL
Name and model of a modem / phone: Teltonika TRM250
Interface: USB
Hi,
we have replaced old HIT-B GPRS with Teltonika TRM250 and changed to Vodafone operator but I'm struggling with config. I have added (init = AT+CPMS="MT" and memory_start=0) and I get incomming sms. But I'm having problem with sending. SMS is always sent but it sends that same sms up to three times and then mark is FAILED. Only sometimes it works as expected and send that same sms only once without FAILED.
/etc/smsd.conf:
devices = GSM1
logfile = /var/log/smsd/smsd.log
loglevel = 7
user = smstools
smart_logging = yes
infofile = /run/smsd/smsd.working
pidfile = /run/smsd/smsd.pid
failed = /var/spool/sms/failed
[GSM1]
device = /dev/ttyUSB3
init = AT+CPMS="MT"
signal_quality_ber_ignore = yes
incoming = yes
memory_start=0
eventhandler = /usr/local/bin/sms/eventhandler
When sending sms /var/log/smsd/smsd.log:
2 sms in row (phone number and PDU obfuscated for spam):
First is sent in 2021-06-23 14:42:52,6 and is sent three times with FAILED status
Second sms is sent in 2021-06-23 14:46:36,6 and everything is ok
2021-06-23 14:42:52,6, GSM1: I have to send 1 short message for /var/spool/sms/checked/sms.JVwOKA
2021-06-23 14:42:52,6, GSM1: Sending SMS from to 420XXXXXXXXX
2021-06-23 14:42:52,6, GSM1: Checking if Modem is registered to the network
2021-06-23 14:42:52,7, GSM1: -> AT+CREG?
2021-06-23 14:42:52,7, GSM1: Command is sent, waiting for the answer
2021-06-23 14:43:02,7, GSM1: put_command expected (\+CREG:.*OK)|(ERROR), timeout occurred. 1.
2021-06-23 14:43:02,7, GSM1: <-
2021-06-23 14:43:02,3, GSM1: Error: Unexpected answer from Modem after +CREG?, waiting 1 sec. before retrying
2021-06-23 14:43:03,7, GSM1: -> AT+CSQ
2021-06-23 14:43:03,7, GSM1: Command is sent, waiting for the answer
2021-06-23 14:43:03,7, GSM1: <- +CSQ: 21,99 OK
2021-06-23 14:43:03,5, GSM1: Signal Strength Indicator: (21,99) -71 dBm (Excellent)
2021-06-23 14:43:04,7, GSM1: -> AT+CREG?
2021-06-23 14:43:04,7, GSM1: Command is sent, waiting for the answer
2021-06-23 14:43:04,7, GSM1: <- +CREG: 2,1,"947D","91F3",0 OK
2021-06-23 14:43:04,6, GSM1: Modem is registered to the network
2021-06-23 14:43:04,7, GSM1: -> AT+CMGS=27
2021-06-23 14:43:04,7, GSM1: Command is sent, waiting for the answer
2021-06-23 14:43:04,7, GSM1: <- >
2021-06-23 14:43:05,7, GSM1: -> PDU_OBFUSCATED_BY_ME
2021-06-23 14:43:05,7, GSM1: Command is sent, waiting for the answer
2021-06-23 14:44:05,7, GSM1: put_command expected (OK)|(ERROR), timeout occurred. 1.
2021-06-23 14:44:05,7, GSM1: <-
2021-06-23 14:44:05,3, GSM1: The modem did not answer (expected OK).
2021-06-23 14:44:05,5, GSM1: Waiting 10 sec. before retrying
2021-06-23 14:44:15,6, GSM1: Checking if modem is ready
2021-06-23 14:44:15,7, GSM1: -> AT
2021-06-23 14:44:15,7, GSM1: Command is sent, waiting for the answer
2021-06-23 14:44:15,7, GSM1: <- OK
2021-06-23 14:44:15,6, GSM1: Pre-initializing modem
2021-06-23 14:44:15,7, GSM1: -> ATE0+CMEE=1;+CREG=2
2021-06-23 14:44:15,7, GSM1: Command is sent, waiting for the answer
2021-06-23 14:44:16,7, GSM1: <- OK
2021-06-23 14:44:16,6, GSM1: Initializing modem
2021-06-23 14:44:16,7, GSM1: -> AT+CPMS="MT"
2021-06-23 14:44:16,7, GSM1: Command is sent, waiting for the answer
2021-06-23 14:44:16,7, GSM1: <- +CPMS: 0,23,0,23,0,23 OK
2021-06-23 14:44:16,7, GSM1: -> AT+CSQ
2021-06-23 14:44:16,7, GSM1: Command is sent, waiting for the answer
2021-06-23 14:44:17,7, GSM1: <- +CSQ: 21,99 OK
2021-06-23 14:44:17,6, GSM1: Signal Strength Indicator: (21,99) -71 dBm (Excellent)
2021-06-23 14:44:17,6, GSM1: Checking if Modem is registered to the network
2021-06-23 14:44:17,7, GSM1: -> AT+CREG?
2021-06-23 14:44:17,7, GSM1: Command is sent, waiting for the answer
2021-06-23 14:44:17,7, GSM1: <- +CREG: 2,1,"947D","91F3",0 OK
2021-06-23 14:44:17,6, GSM1: Modem is registered to the network
2021-06-23 14:44:17,6, GSM1: Selecting PDU mode
2021-06-23 14:44:17,7, GSM1: -> AT+CMGF=0
2021-06-23 14:44:17,7, GSM1: Command is sent, waiting for the answer
2021-06-23 14:44:18,7, GSM1: <- OK
2021-06-23 14:44:18,7, GSM1: -> AT+CMGS=27
2021-06-23 14:44:18,7, GSM1: Command is sent, waiting for the answer
2021-06-23 14:44:18,7, GSM1: <- >
2021-06-23 14:44:18,7, GSM1: -> PDU_OBFUSCATED_BY_ME
2021-06-23 14:44:18,7, GSM1: Command is sent, waiting for the answer
2021-06-23 14:45:18,7, GSM1: put_command expected (OK)|(ERROR), timeout occurred. 1.
2021-06-23 14:45:18,7, GSM1: <-
2021-06-23 14:45:18,3, GSM1: The modem did not answer (expected OK).
2021-06-23 14:45:18,5, GSM1: Waiting 10 sec. before retrying
2021-06-23 14:45:28,6, GSM1: Checking if modem is ready
2021-06-23 14:45:29,7, GSM1: -> AT
2021-06-23 14:45:29,7, GSM1: Command is sent, waiting for the answer
2021-06-23 14:45:30,7, GSM1: <- OK
2021-06-23 14:45:30,6, GSM1: Pre-initializing modem
2021-06-23 14:45:30,7, GSM1: -> ATE0+CMEE=1;+CREG=2
2021-06-23 14:45:30,7, GSM1: Command is sent, waiting for the answer
2021-06-23 14:45:30,7, GSM1: <- OK
2021-06-23 14:45:30,6, GSM1: Initializing modem
2021-06-23 14:45:30,7, GSM1: -> AT+CPMS="MT"
2021-06-23 14:45:30,7, GSM1: Command is sent, waiting for the answer
2021-06-23 14:45:31,7, GSM1: <- +CPMS: 0,23,0,23,0,23 OK
2021-06-23 14:45:31,7, GSM1: -> AT+CSQ
2021-06-23 14:45:31,7, GSM1: Command is sent, waiting for the answer
2021-06-23 14:45:31,7, GSM1: <- +CSQ: 21,99 OK
2021-06-23 14:45:31,6, GSM1: Signal Strength Indicator: (21,99) -71 dBm (Excellent)
2021-06-23 14:45:31,6, GSM1: Checking if Modem is registered to the network
2021-06-23 14:45:31,7, GSM1: -> AT+CREG?
2021-06-23 14:45:31,7, GSM1: Command is sent, waiting for the answer
2021-06-23 14:45:32,7, GSM1: <- +CREG: 2,1,"947D","91F3",0 OK
2021-06-23 14:45:32,6, GSM1: Modem is registered to the network
2021-06-23 14:45:32,6, GSM1: Selecting PDU mode
2021-06-23 14:45:32,7, GSM1: -> AT+CMGF=0
2021-06-23 14:45:32,7, GSM1: Command is sent, waiting for the answer
2021-06-23 14:45:32,7, GSM1: <- OK
2021-06-23 14:45:32,7, GSM1: -> AT+CMGS=27
2021-06-23 14:45:32,7, GSM1: Command is sent, waiting for the answer
2021-06-23 14:45:33,7, GSM1: <- >
2021-06-23 14:45:33,7, GSM1: -> PDU_OBFUSCATED_BY_ME
2021-06-23 14:45:33,7, GSM1: Command is sent, waiting for the answer
2021-06-23 14:46:33,7, GSM1: put_command expected (OK)|(ERROR), timeout occurred. 1.
2021-06-23 14:46:33,7, GSM1: <-
2021-06-23 14:46:33,3, GSM1: The modem did not answer (expected OK).
2021-06-23 14:46:33,4, GSM1: Sending SMS to 420XXXXXXXXX failed, trying time 221 sec. Retries: 2.
2021-06-23 14:46:33,6, GSM1: Moved file /var/spool/sms/checked/sms.JVwOKA to /var/spool/sms/failed/sms.JVwOKA
2021-06-23 14:46:33,7, GSM1: Running eventhandler: /usr/local/bin/sms/eventhandler FAILED /var/spool/sms/failed/sms.JVwOKA
2021-06-23 14:46:33,7, GSM1: Done: eventhandler, execution time 0 sec., status: 0 (0)
2021-06-23 14:46:33,6, GSM1: Checking device for incoming SMS
2021-06-23 14:46:33,6, GSM1: Checking if modem is ready
2021-06-23 14:46:33,7, GSM1: -> AT
2021-06-23 14:46:33,7, GSM1: Command is sent, waiting for the answer
2021-06-23 14:46:33,7, GSM1: <- OK
2021-06-23 14:46:33,6, GSM1: Pre-initializing modem
2021-06-23 14:46:34,7, GSM1: -> ATE0+CMEE=1;+CREG=2
2021-06-23 14:46:34,7, GSM1: Command is sent, waiting for the answer
2021-06-23 14:46:34,7, GSM1: <- OK
2021-06-23 14:46:34,6, GSM1: Initializing modem
2021-06-23 14:46:34,7, GSM1: -> AT+CPMS="MT"
2021-06-23 14:46:34,7, GSM1: Command is sent, waiting for the answer
2021-06-23 14:46:34,7, GSM1: <- +CPMS: 0,23,0,23,0,23 OK
2021-06-23 14:46:35,7, GSM1: -> AT+CSQ
2021-06-23 14:46:35,7, GSM1: Command is sent, waiting for the answer
2021-06-23 14:46:35,7, GSM1: <- +CSQ: 21,99 OK
2021-06-23 14:46:35,6, GSM1: Signal Strength Indicator: (21,99) -71 dBm (Excellent)
2021-06-23 14:46:35,6, GSM1: Checking if Modem is registered to the network
2021-06-23 14:46:35,7, GSM1: -> AT+CREG?
2021-06-23 14:46:35,7, GSM1: Command is sent, waiting for the answer
2021-06-23 14:46:35,7, GSM1: <- +CREG: 2,1,"947D","91F3",0 OK
2021-06-23 14:46:35,6, GSM1: Modem is registered to the network
2021-06-23 14:46:35,6, GSM1: Selecting PDU mode
2021-06-23 14:46:36,7, GSM1: -> AT+CMGF=0
2021-06-23 14:46:36,7, GSM1: Command is sent, waiting for the answer
2021-06-23 14:46:36,7, GSM1: <- OK
2021-06-23 14:46:36,6, GSM1: Checking memory size
2021-06-23 14:46:36,7, GSM1: -> AT+CPMS?
2021-06-23 14:46:36,7, GSM1: Command is sent, waiting for the answer
2021-06-23 14:46:36,7, GSM1: <- +CPMS: "MT",0,23,"MT",0,23,"MT",0,23 OK
2021-06-23 14:46:36,6, GSM1: Used memory is 0 of 23
2021-06-23 14:46:36,6, GSM1: No SMS received
2021-06-23 14:46:36,6, GSM1: I have to send 1 short message for /var/spool/sms/checked/sms.V5AiES
2021-06-23 14:46:36,6, GSM1: Sending SMS from to 420XXXXXXXXX
2021-06-23 14:46:36,6, GSM1: Checking if modem is ready
2021-06-23 14:46:37,7, GSM1: -> AT
2021-06-23 14:46:37,7, GSM1: Command is sent, waiting for the answer
2021-06-23 14:46:37,7, GSM1: <- OK
2021-06-23 14:46:37,6, GSM1: Pre-initializing modem
2021-06-23 14:46:37,7, GSM1: -> ATE0+CMEE=1;+CREG=2
2021-06-23 14:46:37,7, GSM1: Command is sent, waiting for the answer
2021-06-23 14:46:37,7, GSM1: <- OK
2021-06-23 14:46:37,6, GSM1: Initializing modem
2021-06-23 14:46:38,7, GSM1: -> AT+CPMS="MT"
2021-06-23 14:46:38,7, GSM1: Command is sent, waiting for the answer
2021-06-23 14:46:38,7, GSM1: <- +CPMS: 0,23,0,23,0,23 OK
2021-06-23 14:46:38,7, GSM1: -> AT+CSQ
2021-06-23 14:46:38,7, GSM1: Command is sent, waiting for the answer
2021-06-23 14:46:38,7, GSM1: <- +CSQ: 21,99 OK
2021-06-23 14:46:38,6, GSM1: Signal Strength Indicator: (21,99) -71 dBm (Excellent)
2021-06-23 14:46:38,6, GSM1: Checking if Modem is registered to the network
2021-06-23 14:46:39,7, GSM1: -> AT+CREG?
2021-06-23 14:46:39,7, GSM1: Command is sent, waiting for the answer
2021-06-23 14:46:39,7, GSM1: <- +CREG: 2,1,"947D","91F3",0 OK
2021-06-23 14:46:39,6, GSM1: Modem is registered to the network
2021-06-23 14:46:39,6, GSM1: Selecting PDU mode
2021-06-23 14:46:39,7, GSM1: -> AT+CMGF=0
2021-06-23 14:46:39,7, GSM1: Command is sent, waiting for the answer
2021-06-23 14:46:39,7, GSM1: <- OK
2021-06-23 14:46:40,7, GSM1: -> AT+CMGS=27
2021-06-23 14:46:40,7, GSM1: Command is sent, waiting for the answer
2021-06-23 14:46:40,7, GSM1: <- >
2021-06-23 14:46:40,7, GSM1: -> PDU_OBFUSCATED_BY_ME
2021-06-23 14:46:40,7, GSM1: Command is sent, waiting for the answer
2021-06-23 14:46:44,7, GSM1: <- +CMGS: 35 OK
2021-06-23 14:46:44,5, GSM1: SMS sent, Message_id: 35, To: 420XXXXXXXXX, sending time 8 sec.
2021-06-23 14:46:44,7, GSM1: Running eventhandler: /usr/local/bin/sms/eventhandler SENT /var/spool/sms/checked/sms.V5AiES 35
2021-06-23 14:46:44,7, GSM1: Done: eventhandler, execution time 0 sec., status: 0 (0)
2021-06-23 14:46:44,6, GSM1: Deleted file /var/spool/sms/checked/sms.V5AiES
Any ideas please? Thank you
|
