blade243: Operating system name and version: RHEL7 (CentOS7)
Version of smsd: smstools-3.1.15-12.el7.x86_64
Smsd installed from: sources / package repository / from elsewhere... yum, local repository (mirrored epel)
Name and model of a modem / phone: CEP CT63
Interface: serial / USB / some adapter... USB
Hello guys,
right now im trying to figure out, why my server stops sending sms. Somehow it worked earlier. After a few days - sometimes a few weeks - the service stops.
I hope you can help me :)
Configuration of smsd:
# Example smsd.conf. Read the manual for a description
devices = GSM1
logfile = /var/log/smsd/smsd.log
loglevel = 7
user = root
# 3.1.5 introduced smart logging
# once your configuration is OK, set log level lower (5 is good in most cases)
smart_logging = yes
infofile = /run/smsd/smsd.working
pidfile = /run/smsd/smsd.pid
[GSM1]
device = /dev/ttyACM1
incoming = yes
pin = 9530
outgoing = yes
report_device_details = yes
check_network = 1 #not sure if this is necessary, found in community
Output of the smsd.log when service stops running:
2018-07-16 13:55:58,7, GSM1: Command is sent, waiting for the answer
2018-07-16 13:55:58,7, GSM1: <- OK
2018-07-16 13:55:58,6, GSM1: Pre-initializing modem
2018-07-16 13:55:58,7, GSM1: -> ATE0+CMEE=1;+CREG=2
2018-07-16 13:55:58,7, GSM1: Command is sent, waiting for the answer
2018-07-16 13:55:59,7, GSM1: <- OK
2018-07-16 13:55:59,6, GSM1: Checking if modem needs PIN
2018-07-16 13:55:59,7, GSM1: -> AT+CPIN?
2018-07-16 13:55:59,7, GSM1: Command is sent, waiting for the answer
2018-07-16 13:55:59,7, GSM1: <- +CPIN: READY OK
2018-07-16 13:55:59,7, GSM1: -> AT+CSQ
2018-07-16 13:55:59,7, GSM1: Command is sent, waiting for the answer
2018-07-16 13:56:00,7, GSM1: <- +CSQ: 21,99 OK
2018-07-16 13:56:00,6, GSM1: Signal Strength Indicator: (21,99) -71 dBm (Excellent), Bit Error Rate: not known or not detectable
2018-07-16 13:56:00,6, GSM1: Checking if Modem is registered to the network
2018-07-16 13:56:00,7, GSM1: -> AT+CREG?
2018-07-16 13:56:00,7, GSM1: Command is sent, waiting for the answer
2018-07-16 13:56:00,7, GSM1: <- +CREG: 2,1,"524E","00000D44" OK
2018-07-16 13:56:00,6, GSM1: Modem is registered to the network
2018-07-16 13:56:00,6, GSM1: Selecting PDU mode
2018-07-16 13:56:00,7, GSM1: -> AT+CMGF=0
2018-07-16 13:56:00,7, GSM1: Command is sent, waiting for the answer
2018-07-16 13:56:01,7, GSM1: <- OK
2018-07-16 13:56:01,6, GSM1: Checking memory size
2018-07-16 13:56:01,7, GSM1: -> AT+CPMS?
2018-07-16 13:56:01,7, GSM1: Command is sent, waiting for the answer
2018-07-16 13:56:01,7, GSM1: <- +CPMS: "SM",0,20,"SM",0,20,"SM",0,20 OK
2018-07-16 13:56:01,6, GSM1: Used memory is 0 of 20
2018-07-16 13:56:01,6, GSM1: No SMS received
2018-07-16 13:56:11,6, GSM1: Checking device for incoming SMS
2018-07-16 13:56:11,6, GSM1: Checking if modem is ready
2018-07-16 13:56:11,7, GSM1: -> AT
2018-07-16 13:56:11,7, GSM1: Command is sent, waiting for the answer
2018-07-16 13:56:12,7, GSM1: <- OK
2018-07-16 13:56:12,6, GSM1: Pre-initializing modem
2018-07-16 13:56:12,7, GSM1: -> ATE0+CMEE=1;+CREG=2
2018-07-16 13:56:12,7, GSM1: Command is sent, waiting for the answer
2018-07-16 13:56:12,7, GSM1: <- OK
2018-07-16 13:56:12,6, GSM1: Checking if modem needs PIN
2018-07-16 13:56:12,7, GSM1: -> AT+CPIN?
2018-07-16 13:56:12,7, GSM1: Command is sent, waiting for the answer
2018-07-16 13:56:13,7, GSM1: <- +CPIN: READY OK
2018-07-16 13:56:13,7, GSM1: -> AT+CSQ
2018-07-16 13:56:13,7, GSM1: Command is sent, waiting for the answer
2018-07-16 13:56:13,7, GSM1: <- +CSQ: 21,99 OK
2018-07-16 13:56:13,6, GSM1: Signal Strength Indicator: (21,99) -71 dBm (Excellent), Bit Error Rate: not known or not detectable
2018-07-16 13:56:13,6, GSM1: Checking if Modem is registered to the network
2018-07-16 13:56:13,7, GSM1: -> AT+CREG?
2018-07-16 13:56:13,7, GSM1: Command is sent, waiting for the answer
2018-07-16 13:56:14,7, GSM1: <- +CREG: 2,1,"524E","00000D44" OK
2018-07-16 13:56:14,6, GSM1: Modem is registered to the network
2018-07-16 13:56:14,6, GSM1: Selecting PDU mode
2018-07-16 13:56:14,7, GSM1: -> AT+CMGF=0
2018-07-16 13:56:14,7, GSM1: Command is sent, waiting for the answer
2018-07-16 13:56:14,7, GSM1: <- OK
2018-07-16 13:56:14,6, GSM1: Checking memory size
2018-07-16 13:56:14,7, GSM1: -> AT+CPMS?
2018-07-16 13:56:14,7, GSM1: Command is sent, waiting for the answer
2018-07-16 13:56:15,7, GSM1: <- +CPMS: "SM",0,20,"SM",0,20,"SM",0,20 OK
2018-07-16 13:56:15,6, GSM1: Used memory is 0 of 20
2018-07-16 13:56:15,6, GSM1: No SMS received
2018-07-16 13:56:25,6, GSM1: Checking device for incoming SMS
2018-07-16 13:56:25,6, GSM1: Checking if modem is ready
2018-07-16 13:56:25,7, GSM1: -> AT
2018-07-16 13:56:25,7, GSM1: Command is sent, waiting for the answer
2018-07-16 13:56:25,7, GSM1: <- OK
2018-07-16 13:56:25,6, GSM1: Pre-initializing modem
2018-07-16 13:56:25,7, GSM1: -> ATE0+CMEE=1;+CREG=2
2018-07-16 13:56:25,7, GSM1: Command is sent, waiting for the answer
2018-07-16 13:56:26,7, GSM1: <- OK
2018-07-16 13:56:26,6, GSM1: Checking if modem needs PIN
2018-07-16 13:56:26,7, GSM1: -> AT+CPIN?
2018-07-16 13:56:26,7, GSM1: Command is sent, waiting for the answer
2018-07-16 13:56:26,7, GSM1: <- +CPIN: READY OK
2018-07-16 13:56:26,7, GSM1: -> AT+CSQ
2018-07-16 13:56:26,7, GSM1: Command is sent, waiting for the answer
2018-07-16 13:56:27,7, GSM1: <- +CSQ: 22,99 OK
2018-07-16 13:56:27,6, GSM1: Signal Strength Indicator: (22,99) -69 dBm (Excellent), Bit Error Rate: not known or not detectable
2018-07-16 13:56:27,6, GSM1: Checking if Modem is registered to the network
2018-07-16 13:56:27,7, GSM1: -> AT+CREG?
2018-07-16 13:56:27,7, GSM1: Command is sent, waiting for the answer
2018-07-16 13:56:27,7, GSM1: <- +CREG: 2,1,"524E","00000D44" OK
2018-07-16 13:56:27,6, GSM1: Modem is registered to the network
2018-07-16 13:56:27,6, GSM1: Selecting PDU mode
2018-07-16 13:56:27,7, GSM1: -> AT+CMGF=0
2018-07-16 13:56:27,7, GSM1: Command is sent, waiting for the answer
2018-07-16 13:56:28,7, GSM1: <- OK
2018-07-16 13:56:28,6, GSM1: Checking memory size
2018-07-16 13:56:28,7, GSM1: -> AT+CPMS?
2018-07-16 13:56:28,7, GSM1: Command is sent, waiting for the answer
2018-07-16 13:56:28,7, GSM1: <- +CPMS: "SM",0,20,"SM",0,20,"SM",0,20 OK
2018-07-16 13:56:28,6, GSM1: Used memory is 0 of 20
2018-07-16 13:56:28,6, GSM1: No SMS received
2018-07-16 13:56:38,6, GSM1: Checking device for incoming SMS
2018-07-16 13:56:38,6, GSM1: Checking if modem is ready
2018-07-16 13:56:38,7, GSM1: -> AT
2018-07-16 13:56:38,7, GSM1: Command is sent, waiting for the answer
2018-07-16 13:56:39,7, GSM1: <- OK
2018-07-16 13:56:39,6, GSM1: Pre-initializing modem
2018-07-16 13:56:39,7, GSM1: -> ATE0+CMEE=1;+CREG=2
2018-07-16 13:56:39,7, GSM1: Command is sent, waiting for the answer
2018-07-16 13:56:39,7, GSM1: <- OK
2018-07-16 13:56:39,6, GSM1: Checking if modem needs PIN
2018-07-16 13:56:39,7, GSM1: -> AT+CPIN?
2018-07-16 13:56:39,7, GSM1: Command is sent, waiting for the answer
2018-07-16 13:56:40,7, GSM1: <- +CPIN: READY OK
2018-07-16 13:56:40,7, GSM1: -> AT+CSQ
2018-07-16 13:56:40,7, GSM1: Command is sent, waiting for the answer
2018-07-16 13:56:40,7, GSM1: <- +CSQ: 22,99 OK
2018-07-16 13:56:40,6, GSM1: Signal Strength Indicator: (22,99) -69 dBm (Excellent), Bit Error Rate: not known or not detectable
2018-07-16 13:56:40,6, GSM1: Checking if Modem is registered to the network
2018-07-16 13:56:40,7, GSM1: -> AT+CREG?
2018-07-16 13:56:40,7, GSM1: Command is sent, waiting for the answer
2018-07-16 13:56:41,7, GSM1: <- +CREG: 2,1,"524E","00000D44" OK
2018-07-16 13:56:41,6, GSM1: Modem is registered to the network
2018-07-16 13:56:41,6, GSM1: Selecting PDU mode
2018-07-16 13:56:41,7, GSM1: -> AT+CMGF=0
2018-07-16 13:56:41,7, GSM1: Command is sent, waiting for the answer
2018-07-16 13:56:41,7, GSM1: <- OK
2018-07-16 13:56:41,6, GSM1: Checking memory size
2018-07-16 13:56:41,7, GSM1: -> AT+CPMS?
2018-07-16 13:56:41,7, GSM1: Command is sent, waiting for the answer
2018-07-16 13:56:42,7, GSM1: <- +CPMS: "SM",0,20,"SM",0,20,"SM",0,20 OK
2018-07-16 13:56:42,6, GSM1: Used memory is 0 of 20
2018-07-16 13:56:42,6, GSM1: No SMS received
2018-07-16 13:56:52,6, GSM1: Checking device for incoming SMS
2018-07-16 13:56:52,6, GSM1: Checking if modem is ready
2018-07-16 13:56:52,7, GSM1: -> AT
2018-07-16 13:56:52,7, GSM1: Command is sent, waiting for the answer
2018-07-16 13:56:52,7, GSM1: <- OK +CREG: 1,"524E","00001EAE"
2018-07-16 13:56:52,6, GSM1: Pre-initializing modem
2018-07-16 13:56:52,7, GSM1: -> ATE0+CMEE=1;+CREG=2
2018-07-16 13:56:52,7, GSM1: Command is sent, waiting for the answer
2018-07-16 13:57:02,7, GSM1: put_command expected (OK)|(ERROR), timeout occurred. 1.
2018-07-16 13:57:02,7, GSM1: <-
2018-07-16 13:57:02,3, GSM1: Modem did not accept the pre-init string
2018-07-16 13:57:02,6, GSM1: Checking if modem needs PIN
2018-07-16 13:57:02,7, GSM1: -> AT+CPIN?
2018-07-16 13:57:02,7, GSM1: Command is sent, waiting for the answer
2018-07-16 13:57:12,7, GSM1: put_command expected (READY)|( PIN)|( PUK)|(ERROR), timeout occurred. 2.
2018-07-16 13:57:12,7, GSM1: <-
2018-07-16 13:57:12,2, GSM1: PIN handling: expected READY, modem answered
2018-07-16 13:57:12,2, GSM1: Modem handler 0 terminated abnormally. PID: 8204.
2018-07-17 12:00:02,5, smsd: Moved file /var/spool/sms/outgoing/send_IhY7zq to /var/spool/sms/checked
2018-07-17 12:00:02,5, smsd: Moved file /var/spool/sms/outgoing/send_bMnlrI to /var/spool/sms/checked
2018-07-17 12:00:03,5, smsd: Moved file /var/spool/sms/outgoing/send_ds5Imm to /var/spool/sms/checked
2018-07-17 12:00:03,5, smsd: Moved file /var/spool/sms/outgoing/send_xIgX6k to /var/spool/sms/checked
2018-07-17 13:01:50,2, smsd: Smsd mainprocess is awaiting the termination of all modem handlers. PID: 8203.
2018-07-17 13:01:50,2, smsd: Smsd mainprocess terminated. PID 8203, was started 18-07-16 10:39:57.
2018-07-17 13:01:50,2, smsd: Smsd v3.1.15 started.
2018-07-17 13:01:50,2, smsd: Running as root:root.
2018-07-17 13:01:50,7, smsd: Running startup_check (shell): /var/spool/sms/incoming/smsd_script.lU2n8E /tmp/smsd_data.A3Qs2E
2018-07-17 13:01:50,7, smsd: Done: startup_check (shell), execution time 0 sec., status: 0 (0)
2018-07-17 13:01:50,4, smsd: File mode creation mask: 022 (0644, rw-r--r--).
2018-07-17 13:01:50,5, smsd: Outgoing file checker has started. PID: 29831.
2018-07-17 13:01:50,7, smsd: All PID's: 29831,29832
2018-07-17 13:01:50,5, GSM1: Modem handler 0 has started. PID: 29832.
2018-07-17 13:01:50,5, GSM1: Using check_memory_method 1: CPMS is used.
2018-07-17 13:01:50,6, GSM1: Checking device for incoming SMS
2018-07-17 13:01:50,6, GSM1: Checking if modem is ready
2018-07-17 13:01:50,7, GSM1: -> AT
2018-07-17 13:01:50,7, GSM1: Command is sent, waiting for the answer
2018-07-17 13:01:55,7, GSM1: put_command expected (OK)|(ERROR), timeout occurred. 1.
2018-07-17 13:01:55,7, GSM1: <-
2018-07-17 13:01:56,7, GSM1: ->
2018-07-17 13:01:56,7, GSM1: Command is sent, waiting for the answer
2018-07-17 13:02:01,7, GSM1: put_command expected (OK)|(ERROR), timeout occurred. 2.
After a reboot of the sms-gateway the service works normally.
Do you guys have an idea? Been searching for hours..
PS: The card is activated, pin is correct - since the system is running after reboot. Its a Vodafone sms-flat-card.
Thanks a lot in advance!
Best regards,
Steffen ;)
|
