Re: Large delay between receiving and transmitting SMS with run on receive

gilberto dos santos alves <[email protected]> Thu, 16 Feb 2017 09:44:05 -0200
Newsgroups gmane.linux.drivers.gammu
Message-ID <CAP9G-NL_cOwoaUwDzhZRyU5PhoAjD66FP4RJDrp0+03U_S3j+Q@mail.gmail.com>
hi. great debug and analysis. i keep one eye on that but this line
Wed 2017/02/15 11:13:17 gammu-smsd[3004]: Message without SMSC, assuming
you want to use the one from phone
drove my attention.
regards.

--
gilberto dos santos alves
+55(11)9-8646-5049
sao paulo - sp - brasil





2017-02-15 16:34 GMT-02:00 IT Manager <[email protected]>:

> Hi,
>
> We have been able to determine the problem area more accurately. However,
> we have still been unable to solve it.
>
> Below is the log snippet as an example:
>
> Wed 2017/02/15 11:12:27 python-gammu[19021]: Using FILES service
> Wed 2017/02/15 11:12:27 python-gammu[19021]: Configuring Gammu SMSD...
> Wed 2017/02/15 11:12:27 python-gammu[19021]: SHM token: 0xffffffffce0207ea
> (-838727702)
> Wed 2017/02/15 11:12:27 python-gammu[19021]: Warning: No PIN code in
> /etc/gammu-smsdrc file
> Wed 2017/02/15 11:12:27 python-gammu[19021]: CommTimeout=30,
> SendTimeout=30, ReceiveFrequency=30, ResetFrequency=0, HardResetFrequency=0
> Wed 2017/02/15 11:12:27 python-gammu[19021]: checks: CheckSecurity=0,
> CheckBattery=0, CheckSignal=1
> Wed 2017/02/15 11:12:27 python-gammu[19021]: mode: Send=1, Receive=1
> Wed 2017/02/15 11:12:27 python-gammu[19021]: deliveryreport = no
> Wed 2017/02/15 11:12:27 python-gammu[19021]: phoneid =
> Wed 2017/02/15 11:12:27 python-gammu[19021]: Inbox is
> "/var/lib/samba/gammu/inbox/" with format "standard"
> Wed 2017/02/15 11:12:27 python-gammu[19021]: Outbox is
> "/var/lib/samba/gammu/outbox/" with format "detail" and transmission format
> "7bit"
> Wed 2017/02/15 11:12:27 python-gammu[19021]: Sent SMS moved to
> "/var/lib/samba/gammu/sent/"
> Wed 2017/02/15 11:12:27 python-gammu[19021]: SMS with errors moved to
> "/var/lib/samba/gammu/error/"
> Wed 2017/02/15 11:12:27 python-gammu[19021]: Created outbox message
> OUTC20170215_111227_00_+316########_sms0.smsbackup
>
> Wed 2017/02/15 11:12:36 gammu-smsd[3004]: gammu: Entering
> GSM_GetSignalQuality
> Wed 2017/02/15 11:12:36 gammu-smsd[3004]: gammu: Getting signal quality
> info
> Wed 2017/02/15 11:12:36 gammu-smsd[3004]: gammu: SENDING frame type
> 0x00/length 0x07/7
> Wed 2017/02/15 11:12:36 gammu-smsd[3004]: gammu:
> 41A|54T|2B+|43C|53S|51Q|0D
>    AT+CSQ.
> Wed 2017/02/15 11:12:36 gammu-smsd[3004]: gammu: 1 "AT+CSQ"
> Wed 2017/02/15 11:12:36 gammu-smsd[3004]: gammu: 2 "+CSQ: 26,99"
> Wed 2017/02/15 11:12:36 gammu-smsd[3004]: gammu: 3 "OK"
> Wed 2017/02/15 11:12:36 gammu-smsd[3004]: gammu: Checking line: OK
> Wed 2017/02/15 11:12:36 gammu-smsd[3004]: gammu: AT reply state: 1
> Wed 2017/02/15 11:12:36 gammu-smsd[3004]: gammu: RECEIVED frame type
> 0x00/length 0x1C/28
> Wed 2017/02/15 11:12:36 gammu-smsd[3004]: gammu:
> 41A|54T|2B+|43C|53S|51Q|0D |0D |0A |2B+|43C|53S|51Q|3A:|20 |322
> AT+CSQ...+CSQ: 2
> Wed 2017/02/15 11:12:36 gammu-smsd[3004]: gammu: 366|2C,|399|399|0D |0A
> |0D |0A |4FO|4BK|0D |0A                  6,99....OK..
> Wed 2017/02/15 11:12:36 gammu-smsd[3004]: gammu: Signal quality info
> received
> Wed 2017/02/15 11:12:36 gammu-smsd[3004]: gammu: Parsing +CSQ: 26,99 with
> +CSQ: @i, @i
> Wed 2017/02/15 11:12:36 gammu-smsd[3004]: gammu: Parsed int 26
> Wed 2017/02/15 11:12:36 gammu-smsd[3004]: gammu: Parsed int 99
> Wed 2017/02/15 11:12:36 gammu-smsd[3004]: gammu: Leaving
> GSM_GetSignalQuality
> Wed 2017/02/15 11:12:36 gammu-smsd[3004]: gammu: Entering
> GSM_GetNetworkInfo
> Wed 2017/02/15 11:12:36 gammu-smsd[3004]: gammu: Enable full network info
> Wed 2017/02/15 11:12:36 gammu-smsd[3004]: gammu: SENDING frame type
> 0x00/length 0x0A/10
> Wed 2017/02/15 11:12:36 gammu-smsd[3004]: gammu:
> 41A|54T|2B+|43C|52R|45E|47G|3D=|322|0D
> AT+CREG=2.
>
> Wed 2017/02/15 11:13:16 gammu-smsd[3004]: gammu: [Retrying 1 type 0x00]
> Wed 2017/02/15 11:13:16 gammu-smsd[3004]: gammu: SENDING frame type
> 0x00/length 0x0A/10
> Wed 2017/02/15 11:13:16 gammu-smsd[3004]: gammu:
> 41A|54T|2B+|43C|52R|45E|47G|3D=|322|0D
> AT+CREG=2.
> Wed 2017/02/15 11:13:16 gammu-smsd[3004]: gammu: 1 "AT+CREG=2"
> Wed 2017/02/15 11:13:16 gammu-smsd[3004]: gammu: 2 "OK"
> Wed 2017/02/15 11:13:16 gammu-smsd[3004]: gammu: Checking line: OK
> Wed 2017/02/15 11:13:16 gammu-smsd[3004]: gammu: AT reply state: 1
> Wed 2017/02/15 11:13:16 gammu-smsd[3004]: gammu: RECEIVED frame type
> 0x00/length 0x10/16
> Wed 2017/02/15 11:13:16 gammu-smsd[3004]: gammu:
> 41A|54T|2B+|43C|52R|45E|47G|3D=|322|0D |0D |0A |4FO|4BK|0D |0A
> AT+CREG=2...OK..
> Wed 2017/02/15 11:13:16 gammu-smsd[3004]: gammu: Enable full packet
> network info
> Wed 2017/02/15 11:13:16 gammu-smsd[3004]: gammu: SENDING frame type
> 0x00/length 0x0B/11
> Wed 2017/02/15 11:13:16 gammu-smsd[3004]: gammu:
> 41A|54T|2B+|43C|47G|52R|45E|47G|3D=|322|0D
> AT+CGREG=2.
> Wed 2017/02/15 11:13:16 gammu-smsd[3004]: gammu: 1 "AT+CGREG=2"
> Wed 2017/02/15 11:13:16 gammu-smsd[3004]: gammu: 2 "+CME ERROR: 21"
> Wed 2017/02/15 11:13:16 gammu-smsd[3004]: gammu: Checking line: +CME
> ERROR: 21
> Wed 2017/02/15 11:13:16 gammu-smsd[3004]: gammu: AT reply state: 6
> Wed 2017/02/15 11:13:16 gammu-smsd[3004]: gammu: RECEIVED frame type
> 0x00/length 0x1D/29
> Wed 2017/02/15 11:13:16 gammu-smsd[3004]: gammu:
> 41A|54T|2B+|43C|47G|52R|45E|47G|3D=|322|0D |0D |0A |2B+|43C|4DM
> AT+CGREG=2...+CM
> Wed 2017/02/15 11:13:16 gammu-smsd[3004]: gammu: 45E|20
> |45E|52R|52R|4FO|52R|3A:|20 |322|311|0D |0A              E ERROR: 21..
> Wed 2017/02/15 11:13:16 gammu-smsd[3004]: gammu: CME Error 21: "invalid
> index"
> Wed 2017/02/15 11:13:16 gammu-smsd[3004]: gammu: GSM_GetNetworkInfo failed
> with error INVALIDLOCATION[24]: Invalid location. Maybe too high?
> Wed 2017/02/15 11:13:16 gammu-smsd[3004]: gammu: Leaving GSM_GetNetworkInfo
>
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: Entering GSM_GetSMSStatus
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: Getting SIM SMS status
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: SENDING frame type
> 0x00/length 0x12/18
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu:
> 41A|54T|2B+|43C|50P|4DM|53S|3D=|22"|53S|4DM|22"|2C,|22"|53S|4DM
> AT+CPMS="SM","SM
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu:
> 22"|0D
> ".
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: 1 "AT+CPMS="SM","SM""
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: 2 "+CPMS: 0,20,0,20,0,45"
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: 3 "OK"
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: Checking line: OK
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: AT reply state: 1
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: RECEIVED frame type
> 0x00/length 0x31/49
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu:
> 41A|54T|2B+|43C|50P|4DM|53S|3D=|22"|53S|4DM|22"|2C,|22"|53S|4DM
> AT+CPMS="SM","SM
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: 22"|0D |0D |0A
> |2B+|43C|50P|4DM|53S|3A:|20 |300|2C,|322|300|2C, "...+CPMS: 0,20,
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu:
> 300|2C,|322|300|2C,|300|2C,|344|355|0D |0A |0D |0A |4FO|4BK|0D
> 0,20,0,45....OK.
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: 0A
>                                                          .
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: SMS status received
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: Parsing +CPMS:
> 0,20,0,20,0,45 with +CPMS: @i, @i, @0
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: Parsed int 0
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: Parsed int 20
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: Used : 0
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: Size : 20
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: Getting phone SMS status
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: SENDING frame type
> 0x00/length 0x12/18
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu:
> 41A|54T|2B+|43C|50P|4DM|53S|3D=|22"|4DM|45E|22"|2C,|22"|4DM|45E
> AT+CPMS="ME","ME
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu:
> 22"|0D
> ".
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: 1 "AT+CPMS="ME","ME""
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: 2 "+CPMS: 0,25,0,25,0,45"
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: 3 "OK"
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: Checking line: OK
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: AT reply state: 1
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: RECEIVED frame type
> 0x00/length 0x31/49
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu:
> 41A|54T|2B+|43C|50P|4DM|53S|3D=|22"|4DM|45E|22"|2C,|22"|4DM|45E
> AT+CPMS="ME","ME
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: 22"|0D |0D |0A
> |2B+|43C|50P|4DM|53S|3A:|20 |300|2C,|322|355|2C, "...+CPMS: 0,25,
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu:
> 300|2C,|322|355|2C,|300|2C,|344|355|0D |0A |0D |0A |4FO|4BK|0D
> 0,25,0,45....OK.
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu:
> 0A
> .
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: SMS status received
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: Parsing +CPMS:
> 0,25,0,25,0,45 with +CPMS: @i, @i, @0
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: Parsed int 0
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: Parsed int 25
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: Used : 0
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: Size : 25
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: Leaving GSM_GetSMSStatus
> *50 second gap til message is found*
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: Found 1 sms to "+316########"
> with text "Wed Feb 15 11:12:27 2017" cod 3 lgt 24 udh: t 1 l 0 dlr: -1 fls:
> -1
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: New message to send:
> OUTC20170215_111227_00_+316########_sms0.smsbackup
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: Message without SMSC, assuming
> you want to use the one from phone
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: Entering GSM_GetSMSC
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: Getting SMSC
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: SENDING frame type
> 0x00/length 0x09/9
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu:
> 41A|54T|2B+|43C|53S|43C|41A|3F?|0D
>                   AT+CSCA?.
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: 1 "AT+CSCA?"
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: 2 "+CSCA: "+316########
> ",145"
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: 3 "OK"
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: Checking line: OK
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: AT reply state: 1
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: RECEIVED frame type
> 0x00/length 0x2D/45
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu:
> 41A|54T|2B+|43C|53S|43C|41A|3F?|0D |0D |0A |2B+|43C|53S|43C|41A
> AT+CSCA?...+CSCA
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: 3A:|20
> |22"|2B+|333|311|366|355|344|300|388|388|311|300|300|300 : "+316########
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: 22"|2C,|311|344|355|0D
> |0A |0D |0A |4FO|4BK|0D |0A              ",145....OK..
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: SMSC info received
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: Parsing +CSCA: "+316
> ########",145 with +CSCA: @p, @i
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: Grabbed string from
> reply: "+316########" (parsed 15 bytes)
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: Parsed phone string "+316
> ########"
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: Phone string decoded as
> "+316########"
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: Parsed int 145
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: Leaving GSM_GetSMSC
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: Entering
> GSM_GetSignalQuality
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: Getting signal quality
> info
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: SENDING frame type
> 0x00/length 0x07/7
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu:
> 41A|54T|2B+|43C|53S|51Q|0D
> AT+CSQ.
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: 1 "AT+CSQ"
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: 2 "+CSQ: 26,99"
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: 3 "OK"
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: Checking line: OK
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: AT reply state: 1
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: RECEIVED frame type
> 0x00/length 0x1C/28
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu:
> 41A|54T|2B+|43C|53S|51Q|0D |0D |0A |2B+|43C|53S|51Q|3A:|20 |322
> AT+CSQ...+CSQ: 2
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: 366|2C,|399|399|0D |0A
> |0D |0A |4FO|4BK|0D |0A                  6,99....OK..
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: Signal quality info
> received
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: Parsing +CSQ: 26,99 with
> +CSQ: @i, @i
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: Parsed int 26
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: Parsed int 99
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: Leaving
> GSM_GetSignalQuality
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: Entering
> GSM_GetNetworkInfo
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: Enable full network info
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: SENDING frame type
> 0x00/length 0x0A/10
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu:
> 41A|54T|2B+|43C|52R|45E|47G|3D=|322|0D
> AT+CREG=2.
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: 1 "AT+CREG=2"
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: 2 "OK"
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: Checking line: OK
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: AT reply state: 1
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: RECEIVED frame type
> 0x00/length 0x10/16
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu:
> 41A|54T|2B+|43C|52R|45E|47G|3D=|322|0D |0D |0A |4FO|4BK|0D |0A
> AT+CREG=2...OK..
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: Enable full packet
> network info
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: SENDING frame type
> 0x00/length 0x0B/11
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu:
> 41A|54T|2B+|43C|47G|52R|45E|47G|3D=|322|0D
> AT+CGREG=2.
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: 1 "AT+CGREG=2"
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: 2 "+CME ERROR: 21"
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: Checking line: +CME
> ERROR: 21
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: AT reply state: 6
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: RECEIVED frame type
> 0x00/length 0x1D/29
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu:
> 41A|54T|2B+|43C|47G|52R|45E|47G|3D=|322|0D |0D |0A |2B+|43C|4DM
> AT+CGREG=2...+CM
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: 45E|20
> |45E|52R|52R|4FO|52R|3A:|20 |322|311|0D |0A              E ERROR: 21..
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: CME Error 21: "invalid
> index"
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: GSM_GetNetworkInfo failed
> with error INVALIDLOCATION[24]: Invalid location. Maybe too high?
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: Leaving GSM_GetNetworkInfo
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: Entering GSM_SendSMS
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: Trying SMS PDU mode
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: SENDING frame type
> 0x00/length 0x0A/10
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu:
> 41A|54T|2B+|43C|4DM|47G|46F|3D=|300|0D
> AT+CMGF=0.
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: 1 "AT+CMGF=0"
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: 2 "OK"
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: Checking line: OK
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: AT reply state: 1
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: RECEIVED frame type
> 0x00/length 0x10/16
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu:
> 41A|54T|2B+|43C|4DM|47G|46F|3D=|300|0D |0D |0A |4FO|4BK|0D |0A
> AT+CMGF=0...OK..
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: SMS Submit
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: Recipient number "+316
> ########"
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: SMSC number "+316########
> "
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: SMS class -1
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: SMS validity ff
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: TPMR: 00 0
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: 7 bit SMS, length 21, 24
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: Wed Feb 15 11:12:27 2017
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: Waiting for modem prompt
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: SENDING frame type
> 0x00/length 0x0B/11
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu:
> 41A|54T|2B+|43C|4DM|47G|53S|3D=|333|355|0D
> AT+CMGS=35.
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: 1 "AT+CMGS=35"
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: 2 "> "
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: Checking line: >
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: AT reply state: 7
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: RECEIVED frame type
> 0x00/length 0x0F/15
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu:
> 41A|54T|2B+|43C|4DM|47G|53S|3D=|333|355|0D |0D |0A |3E>|20
> AT+CMGS=35...>
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: Sending SMS
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu: SENDING frame type
> 0x00/length 0x56/86
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu:
> 300|377|399|311|311|333|355|366|300|344|388|388|300|311|300|300
> 0791135604880100
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu:
> 311|311|300|300|300|42B|399|311|311|333|344|366|300|377|300|388
> 11000B9113460708
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu:
> 399|355|46F|333|300|300|300|300|46F|46F|311|388|44D|377|333|322
> 95F30000FF18D732
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu:
> 311|399|366|344|322|43C|388|42B|344|311|42B|311|311|41A|322|388
> 19642C8B41B11A28
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu:
> 311|366|44D|333|43C|355|366|344|333|41A|44D|399|300|44D|322|344
> 16D3C5643AD90D24
> Wed 2017/02/15 11:13:17 gammu-smsd[3004]: gammu:
> 388|333|43C|355|366|45E
> 83C56E
>
> Wed 2017/02/15 11:13:18 gammu-smsd[3004]: gammu: SENDING frame type
> 0x00/length 0x01/1
> Wed 2017/02/15 11:13:18 gammu-smsd[3004]: gammu:
> 1A
> .
> Wed 2017/02/15 11:13:18 gammu-smsd[3004]: gammu: Leaving GSM_SendSMS
>
> Wed 2017/02/15 11:13:21 gammu-smsd[3004]: gammu: 1 "AT+CMGS=35"
> Wed 2017/02/15 11:13:21 gammu-smsd[3004]: gammu: 2 ">
> 079113560488010011000B911346070895F30000FF18D73219642C8B41B1
> 1A2816D3C5643AD90D2483C56E"
> Wed 2017/02/15 11:13:21 gammu-smsd[3004]: gammu: 3 "+CMGS: 127"
> Wed 2017/02/15 11:13:21 gammu-smsd[3004]: gammu: 4 "OK"
> Wed 2017/02/15 11:13:21 gammu-smsd[3004]: gammu: Checking line: OK
> Wed 2017/02/15 11:13:21 gammu-smsd[3004]: gammu: AT reply state: 1
> Wed 2017/02/15 11:13:21 gammu-smsd[3004]: gammu: RECEIVED frame type
> 0x00/length 0x7A/122
> Wed 2017/02/15 11:13:21 gammu-smsd[3004]: gammu:
> 41A|54T|2B+|43C|4DM|47G|53S|3D=|333|355|0D |0D |0A |3E>|20 |300
> AT+CMGS=35...> 0
> Wed 2017/02/15 11:13:21 gammu-smsd[3004]: gammu:
> 377|399|311|311|333|355|366|300|344|388|388|300|311|300|300|311
> 7911356048801001
> Wed 2017/02/15 11:13:21 gammu-smsd[3004]: gammu:
> 311|300|300|300|42B|399|311|311|333|344|366|300|377|300|388|399
> 1000B91134607089
> Wed 2017/02/15 11:13:21 gammu-smsd[3004]: gammu:
> 355|46F|333|300|300|300|300|46F|46F|311|388|44D|377|333|322|311
> 5F30000FF18D7321
> Wed 2017/02/15 11:13:21 gammu-smsd[3004]: gammu:
> 399|366|344|322|43C|388|42B|344|311|42B|311|311|41A|322|388|311
> 9642C8B41B11A281
> Wed 2017/02/15 11:13:21 gammu-smsd[3004]: gammu:
> 366|44D|333|43C|355|366|344|333|41A|44D|399|300|44D|322|344|388
> 6D3C5643AD90D248
> Wed 2017/02/15 11:13:21 gammu-smsd[3004]: gammu: 333|43C|355|366|45E|1A
> |0D |0A |2B+|43C|4DM|47G|53S|3A:|20 |311 3C56E...+CMGS: 1
> Wed 2017/02/15 11:13:21 gammu-smsd[3004]: gammu: 322|377|0D |0A |0D |0A
> |4FO|4BK|0D |0A                          27....OK..
> Wed 2017/02/15 11:13:21 gammu-smsd[3004]: gammu: SMS sent OK
> Wed 2017/02/15 11:13:21 gammu-smsd[3004]: gammu: Parsing +CMGS: 127 with
> +CMGS: @i
> Wed 2017/02/15 11:13:21 gammu-smsd[3004]: gammu: Parsed int 127
> *4 second gap until message is sent (after being found)*
> Wed 2017/02/15 11:13:21 gammu-smsd[3004]: SMS sent on device: "/dev/ttyS0"
> status=0, reference=127
> Wed 2017/02/15 11:13:21 gammu-smsd[3004]: Transmitted
> OUTC20170215_111227_00_+316########_sms0.smsbackup (total: 1) to +316
> ########, message reference 0x7f
> Wed 2017/02/15 11:13:21 gammu-smsd[3004]: Renamed
> /var/lib/samba/gammu/outbox/OUTC20170215_111227_00_+316########_sms0.smsbackup
> to /var/lib/samba/gammu/sent/OUTC20170215_111227_00_+316########
> _sms0.smsbackup
> Wed 2017/02/15 11:13:21 gammu-smsd[3004]: gammu: Entering
> GSM_GetSignalQuality
> Wed 2017/02/15 11:13:21 gammu-smsd[3004]: gammu: Getting signal quality
> info
> Wed 2017/02/15 11:13:21 gammu-smsd[3004]: gammu: SENDING frame type
> 0x00/length 0x07/7
> Wed 2017/02/15 11:13:21 gammu-smsd[3004]: gammu:
> 41A|54T|2B+|43C|53S|51Q|0D
>   AT+CSQ.
> Wed 2017/02/15 11:13:21 gammu-smsd[3004]: gammu: 1 "AT+CSQ"
> Wed 2017/02/15 11:13:21 gammu-smsd[3004]: gammu: 2 "+CSQ: 26,0"
> Wed 2017/02/15 11:13:21 gammu-smsd[3004]: gammu: 3 "OK"
> Wed 2017/02/15 11:13:21 gammu-smsd[3004]: gammu: Checking line: OK
> Wed 2017/02/15 11:13:21 gammu-smsd[3004]: gammu: AT reply state: 1
> Wed 2017/02/15 11:13:21 gammu-smsd[3004]: gammu: RECEIVED frame type
> 0x00/length 0x1B/27
> Wed 2017/02/15 11:13:21 gammu-smsd[3004]: gammu:
> 41A|54T|2B+|43C|53S|51Q|0D |0D |0A |2B+|43C|53S|51Q|3A:|20 |322
> AT+CSQ...+CSQ: 2
> Wed 2017/02/15 11:13:21 gammu-smsd[3004]: gammu: 366|2C,|300|0D |0A |0D
> |0A |4FO|4BK|0D |0A                      6,0....OK..
> Wed 2017/02/15 11:13:21 gammu-smsd[3004]: gammu: Signal quality info
> received
> Wed 2017/02/15 11:13:21 gammu-smsd[3004]: gammu: Parsing +CSQ: 26,0 with
> +CSQ: @i, @i
> Wed 2017/02/15 11:13:21 gammu-smsd[3004]: gammu: Parsed int 26
> Wed 2017/02/15 11:13:21 gammu-smsd[3004]: gammu: Parsed int 0
> Wed 2017/02/15 11:13:21 gammu-smsd[3004]: gammu: Leaving
> GSM_GetSignalQuality
> Wed 2017/02/15 11:13:21 gammu-smsd[3004]: gammu: Entering
> GSM_GetNetworkInfo
> Wed 2017/02/15 11:13:21 gammu-smsd[3004]: gammu: Enable full network info
> Wed 2017/02/15 11:13:21 gammu-smsd[3004]: gammu: SENDING frame type
> 0x00/length 0x0A/10
> Wed 2017/02/15 11:13:21 gammu-smsd[3004]: gammu:
> 41A|54T|2B+|43C|52R|45E|47G|3D=|322|0D
> AT+CREG=2.
>
>
> The problem location can be indicated in the workflow diagram:
>
>
>
> It seems the problem lies in the *FindOutboxSMS*. We have tried changing
> the *commtimeout* (and *receivefrequency*) with no luck. We have also
> tried to change the AT to automatic or other bitrates in gammu-smsdrc.
>
> Hopefully this will help you in solving this issue.
>
> Best regards,
>
> Gertjan
>
> Op 14-2-2017 om 12:37 schreef gilberto dos santos alves:
>
> yes . i am too agree with your suspects? but if necessary use tools like
> nmap or zenmap or shark for more details about your device status lines and
> protocols packages ... data comming from your telecom to your device like
> signal streght power and status.
> ussd are assincron from other events
>
> Em 14/02/2017 04:31, "IT Manager" <[email protected]> escreveu:
>
>>
>> Hi Gilberto,
>>
>> I am not sure I understand what you mean.
>> Which code should I give for the USSD command? Is requesting a status
>> update enough for this? I.e. gammu --getussd *#21# (the status of call
>> forwarding here in The Netherlands)
>> I have found the gateway number from our telecom provider (Vodafone),
>> do I need to put it in the configuration file or is there an option in
>> gammu-smsd to specify it together with the message?
>>
>> I noticed in the log file that the location gives an error:
>>
>> - LOGFILE snippet:
>> 2 "+CME ERROR: 21"
>> Checking line: +CME ERROR: 21
>> AT reply state: 6
>> RECEIVED frame type 0x00/length 0x1D/29
>> 45E|20 |45E|52R|52R|4FO|52R|3A:|20 |322|311|0D |0A              E ERROR:
>> 21..
>> CME Error 21: "invalid index"
>> GSM_GetNetworkInfo failed with error INVALIDLOCATION[24]: Invalid
>> location. Maybe too high?
>>
>> The strange thing is, I specify the location as being "1" in the script.
>>
>> - SCRIPT snippet:
>> # Translating the code to text and creating the message
>> message = {'Text': smstext, 'SMSC': {'Location': 1}, 'Number': number}
>> # Sending the actual messages
>> smsd = gammu.SMSD('/etc/gammu-smsdrc')
>> smsd.InjectSMS([message])
>>
>> Might this introduce a problem in sending the messages?
>>
>> Thanks in advance.
>>
>> Regards,
>> Gertjan
>>
>> Citeren gilberto dos santos alves <[email protected]>:
>>
>> > hi. this smell like your telecom company.
>> > insert ussd command before any sms for make shure that line is
>> ready for
>> > send .
>> > see what is your "gateway" number inside  telecom for  send sms.
>> > i keep looking for details inside your log.
>> >
>> > Em 08/02/2017 07:12, "IT Manager" <[email protected]> escreveu:
>> >
>> > L.S.,
>> >
>> > I have a script which is run on receive that checks the contents of
>> the
>> > text message (or actually the "IN" text file) and subsequently
>> sends
>> > messages to several other mobile numbers.
>> > However in the gammu.log I see that there is a very large delay
>> between
>> > receiving the message/calling the script and actually sending the
>> new
>> > messages.
>> >
>> > I can see in the log that Gammu is ready to send the new message 1
>> second
>> > after receiving the message but it does not send it until about 45
>> seconds
>> > later. This is for the first number, the message to the second
>> number takes
>> > about 5 minutes after the first message (so almost 6 minutes after
>> the
>> > message is received) until it is send.
>> >
>> > I have attached a snippet of the log with the times highlighted.
>> >
>> > Can you see what is going on?
>> > Please let me know if you require additional information.
>> >
>> > Thanks in advance.
>> >
>> > Regards,
>> > Gertjan
>> >
>> >
>> > ------------------------------------------------------------
>> > ------------------
>> > Check out the vibrant tech community on one of the world's most
>> > engaging tech sites, SlashDot.org! http://sdm.link/slashdot[1]
>> > _______________________________________________
>> > Gammu-users mailing list - https://lists.sourceforge.net/[2]
>> > lists/listinfo/gammu-users
>> >
>>
>> IT Manager
>>
>> Global Technics BV
>> Bargelaan 6
>> 2333 CT Leiden
>> The Netherlands
>> Tel: +31 (0)71 71 00 224
>> E-mail: [email protected]
>>
>> Links:
>> ------
>> [1] http://sdm.link/slashdot
>> [2] https://lists.sourceforge.net/
>>
>>
>> ------------------------------------------------------------
>> ------------------
>> Check out the vibrant tech community on one of the world's most
>> engaging tech sites, SlashDot.org! http://sdm.link/slashdot
>> _______________________________________________
>> Gammu-users mailing list - https://lists.sourceforge.net/
>> lists/listinfo/gammu-users
>>
>
>
> ------------------------------------------------------------------------------
> Check out the vibrant tech community on one of the world's most
> engaging tech sites, SlashDot.org! http://sdm.link/slashdot
>
>
>
> _______________________________________________
> Gammu-users mailing list - https://lists.sourceforge.net/lists/listinfo/gammu-users
>
>
>
>
> ------------------------------------------------------------
> ------------------
> Check out the vibrant tech community on one of the world's most
> engaging tech sites, SlashDot.org! http://sdm.link/slashdot
> _______________________________________________
> Gammu-users mailing list - https://lists.sourceforge.net/
> lists/listinfo/gammu-users
>
>

------------------------------------------------------------------------------
Check out the vibrant tech community on one of the world's most
engaging tech sites, SlashDot.org! http://sdm.link/slashdot

_______________________________________________
Gammu-users mailing list - https://lists.sourceforge.net/lists/listinfo/gammu-users
(unnamed) (image/png, 1.9 KB) - not displayed
(unnamed) (image/png, 914 B) - not displayed
(unnamed) (image/png, 574 B) - not displayed
(unnamed) (image/png, 114.3 KB) - not displayed