New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

gammu-smsd - unexpected behaviour when wrong phone number is given #381

Closed
melones opened this Issue Jan 11, 2018 · 8 comments

Comments

Projects
None yet
3 participants
@melones

melones commented Jan 11, 2018

Gammu version: 1.39.0

Important gammu-smsdrc settings:
commtimeout = 5
sendtimeout = 30
maxretries = 2

I have encountered unexpected behaviour of smsd when I have a queue of messages and some of them countain phone number which is out of service (disabled). There are 2 problems:

  1. after message with bad phone number is processed, SMSD waits 1 minute (and does nothing) before moving to next task
  2. SMSD doesn' take next message in queue and come back to problematic one after SendingTimeOut time, but works several minutes (depending on maxretries) to process problematic message.

I attach a sample log where 2 messages wait in a queue:
number text
12345 test-bad1
123456 test-bad2

Please check the following timestamps in the log below:

Thu 2018/01/11 15:07:17 gammu-smsd[30351]: Execute SQL: UPDATE outbox SET "StatusCode"=38 WHERE "ID"='1297'
Thu 2018/01/11 15:08:17 gammu-smsd[30351]: gammu: Entering GSM_GetSecurityStatus

Thu 2018/01/11 15:08:22 gammu-smsd[30351]: Execute SQL: UPDATE outbox SET "StatusCode"=38 WHERE "ID"='1297'
Thu 2018/01/11 15:09:22 gammu-smsd[30351]: gammu: Entering GSM_GetSecurityStatus

Thu 2018/01/11 15:09:27 gammu-smsd[30351]: Execute SQL: UPDATE outbox SET "StatusCode"=38 WHERE "ID"='1297'
Thu 2018/01/11 15:10:27 gammu-smsd[30351]: gammu: Entering GSM_GetSecurityStatus

Exactly 1 minute waits SMSD before taking any step.

I even tried to put a custom sql in [sql] section of gammu-smsdrc
update_retries = UPDATE outbox SET "SendingTimeOut" = now() + interval '30 seconds', "Retries" = %2 WHERE "ID" = %1;
But changing SendingTimeOut this way didn't work.

Log content:

Thu 2018/01/11 15:06:52 gammu-smsd[30350]: Using SQL service
Thu 2018/01/11 15:06:52 gammu-smsd[30350]: Configuring Gammu SMSD...
Thu 2018/01/11 15:06:52 gammu-smsd[30350]: SHM token: 0x10208c2 (16910530)
Thu 2018/01/11 15:06:52 gammu-smsd[30350]: Warning: No PIN code in /etc/gammu-smsdrc1 file
Thu 2018/01/11 15:06:52 gammu-smsd[30350]: CommTimeout=5, SendTimeout=30, ReceiveFrequency=15, ResetFrequency=0, HardResetFrequency=0
Thu 2018/01/11 15:06:52 gammu-smsd[30350]: checks: CheckSecurity=1, CheckBattery=0, CheckSignal=1, CheckNetwork=1
Thu 2018/01/11 15:06:52 gammu-smsd[30350]: mode: Send=1, Receive=1
Thu 2018/01/11 15:06:52 gammu-smsd[30350]: deliveryreport = sms
Thu 2018/01/11 15:06:52 gammu-smsd[30350]: phoneid = phone1
Thu 2018/01/11 15:06:52 gammu-smsd[30351]: Connected to database: myhost on 127.0.0.1. Server version: 90415 Protocol: 3
Thu 2018/01/11 15:06:52 gammu-smsd[30351]: Execute SQL: SELECT  * FROM gammu  LIMIT 1
Thu 2018/01/11 15:06:52 gammu-smsd[30351]: Execute SQL: SELECT  * FROM inbox  LIMIT 1
Thu 2018/01/11 15:06:52 gammu-smsd[30351]: Execute SQL: SELECT  * FROM sentitems  LIMIT 1
Thu 2018/01/11 15:06:52 gammu-smsd[30351]: Execute SQL: SELECT  * FROM outbox  LIMIT 1
Thu 2018/01/11 15:06:52 gammu-smsd[30351]: Execute SQL: SELECT  * FROM outbox_multipart  LIMIT 1
Thu 2018/01/11 15:06:52 gammu-smsd[30351]: Execute SQL: SELECT  * FROM phones  LIMIT 1
Thu 2018/01/11 15:06:52 gammu-smsd[30351]: Execute SQL: SELECT "Version" FROM gammu
Thu 2018/01/11 15:06:52 gammu-smsd[30351]: Database structures version: 17, SMSD current version: 17
Thu 2018/01/11 15:06:52 gammu-smsd[30351]: Connected to Database native_pgsql: myhost on 127.0.0.1
Thu 2018/01/11 15:06:52 gammu-smsd[30351]: Created POSIX RW shared memory at 0x76fed000
Thu 2018/01/11 15:06:52 gammu-smsd[30351]: Starting phone communication...
Thu 2018/01/11 15:06:52 gammu-smsd[30351]: gammu: [Gammu            - 1.39.0]
...
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Leaving GSM_GetSMSStatus
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: Execute SQL: SELECT "ID", "InsertIntoDB", "SendingDateTime", "SenderID" FROM outbox WHERE "SendingDateTime" < now() AND "SendingTimeOut" < now() AND "SendBefore" >= localtime AND "SendAfter" <= localtime AND ( "SenderID" is NULL OR "SenderID" = '' OR "SenderID" = 'phone1' ) ORDER BY "Priority" DESC, "InsertIntoDB" ASC LIMIT 1
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: Execute SQL: UPDATE outbox SET "SendingTimeOut" = now() + interval '60 seconds' WHERE "ID" = '1297' AND ("SendingTimeOut" < now() OR "SendingTimeOut" IS NULL)
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: Execute SQL: SELECT "Text", "Coding", "UDH", "Class", "TextDecoded", "ID", "DestinationNumber", "MultiPart", "RelativeValidity", "DeliveryReport", "CreatorID", "Retries", "Status", "StatusCode" FROM outbox WHERE "ID"='1297'
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: Message: test-bad1
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: New message to send: 1297
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: Message without SMSC, assuming you want to use the one from phone
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Entering GSM_GetSMSC
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Getting SMSC
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: SENDING frame type 0x00/length 0x09/9
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|53S|43C|41A|3F?|0D                              AT+CSCA?.       
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 1 "AT+CSCA?"
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 2 "+CSCA: "+48790998250",145"
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 3 "OK"
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Checking line: OK
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: AT reply state: 1
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: RECEIVED frame type 0x00/length 0x2C/44
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|53S|43C|41A|3F?|0D |0D |0A |2B+|43C|53S|43C|41A AT+CSCA?...+CSCA
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 3A:|20 |22"|2B+|344|388|377|399|300|399|399|388|322|355|300|22" : "+48790998250"
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 2C,|311|344|355|0D |0A |0D |0A |4FO|4BK|0D |0A                  ,145....OK..    
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: SMSC info received
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Parsing +CSCA: "+48790998250",145 with +CSCA: @p, @i
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Grabbed string from reply: "+48790998250" (parsed 14 bytes)
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Parsed phone string "+48790998250"
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Phone string decoded as "+48790998250"
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Parsed int 145
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Leaving GSM_GetSMSC
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Entering GSM_GetSignalQuality
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Getting signal quality info
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: SENDING frame type 0x00/length 0x07/7
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|53S|51Q|0D                                      AT+CSQ.         
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 1 "AT+CSQ"
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 2 "+CSQ: 15,2"
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 3 "OK"
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Checking line: OK
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: AT reply state: 1
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: RECEIVED frame type 0x00/length 0x1B/27
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|53S|51Q|0D |0D |0A |2B+|43C|53S|51Q|3A:|20 |311 AT+CSQ...+CSQ: 1
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 355|2C,|322|0D |0A |0D |0A |4FO|4BK|0D |0A                      5,2....OK..     
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Signal quality info received
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Parsing +CSQ: 15,2 with +CSQ: @i, @i
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Parsed int 15
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Parsed int 2
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Leaving GSM_GetSignalQuality
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Entering GSM_GetNetworkInfo
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Enable full network info
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: SENDING frame type 0x00/length 0x0A/10
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|52R|45E|47G|3D=|322|0D                          AT+CREG=2.      
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 1 "AT+CREG=2"
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 2 "OK"
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Checking line: OK
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: AT reply state: 1
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: RECEIVED frame type 0x00/length 0x10/16
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|52R|45E|47G|3D=|322|0D |0D |0A |4FO|4BK|0D |0A  AT+CREG=2...OK..
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Enable full packet network info
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: SENDING frame type 0x00/length 0x0B/11
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|47G|52R|45E|47G|3D=|322|0D                      AT+CGREG=2.     
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 1 "AT+CGREG=2"
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 2 "OK"
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Checking line: OK
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: AT reply state: 1
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: RECEIVED frame type 0x00/length 0x11/17
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|47G|52R|45E|47G|3D=|322|0D |0D |0A |4FO|4BK|0D  AT+CGREG=2...OK.
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 0A                                                              .               
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Getting GPRS state
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: SENDING frame type 0x00/length 0x0A/10
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|47G|41A|54T|54T|3F?|0D                          AT+CGATT?.      
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 1 "AT+CGATT?"
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 2 "+CGATT: 1"
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 3 "OK"
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Checking line: OK
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: AT reply state: 1
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: RECEIVED frame type 0x00/length 0x1D/29
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|47G|41A|54T|54T|3F?|0D |0D |0A |2B+|43C|47G|41A AT+CGATT?...+CGA
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 54T|54T|3A:|20 |311|0D |0A |0D |0A |4FO|4BK|0D |0A              TT: 1....OK..   
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: GPRS state received
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Parsing +CGATT: 1 with +CGATT: @i
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Parsed int 1
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Getting network LAC and CID and state
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: SENDING frame type 0x00/length 0x09/9
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|52R|45E|47G|3F?|0D                              AT+CREG?.       
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 1 "AT+CREG?"
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 2 "+CREG: 2,1,"001F","0219038",2"
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 3 "OK"
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Checking line: OK
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: AT reply state: 1
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: RECEIVED frame type 0x00/length 0x30/48
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|52R|45E|47G|3F?|0D |0D |0A |2B+|43C|52R|45E|47G AT+CREG?...+CREG
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 3A:|20 |322|2C,|311|2C,|22"|300|300|311|46F|22"|2C,|22"|300|322 : 2,1,"001F","02
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 311|399|300|333|388|22"|2C,|322|0D |0A |0D |0A |4FO|4BK|0D |0A  19038",2....OK..
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Network LAC & CID & state received
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Parsing +CREG: 2,1,"001F","0219038",2 with +CREG: @i, @i, @r, @r, @i
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Parsed int 2
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Parsed int 1
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Grabbed string from reply: "001F" (parsed 6 bytes)
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Parsed raw string "001F"
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Grabbed string from reply: "0219038" (parsed 9 bytes)
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Parsed raw string "0219038"
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Parsed int 2
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Home network
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Getting packet network LAC and CID and state
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: SENDING frame type 0x00/length 0x0A/10
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|47G|52R|45E|47G|3F?|0D                          AT+CGREG?.      
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 1 "AT+CGREG?"
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 2 "+CGREG: 2,1,"001F","0219038",2,"1F""
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 3 "OK"
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Checking line: OK
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: AT reply state: 1
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: RECEIVED frame type 0x00/length 0x37/55
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|47G|52R|45E|47G|3F?|0D |0D |0A |2B+|43C|47G|52R AT+CGREG?...+CGR
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 45E|47G|3A:|20 |322|2C,|311|2C,|22"|300|300|311|46F|22"|2C,|22" EG: 2,1,"001F","
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 300|322|311|399|300|333|388|22"|2C,|322|2C,|22"|311|46F|22"|0D  0219038",2,"1F".
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 0A |0D |0A |4FO|4BK|0D |0A                                      ...OK..         
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Network LAC & CID & state received
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Parsing +CGREG: 2,1,"001F","0219038",2,"1F" with +CGREG: @i, @i, @r, @r, @i, @r
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Parsed int 2
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Parsed int 1
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Grabbed string from reply: "001F" (parsed 6 bytes)
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Parsed raw string "001F"
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Grabbed string from reply: "0219038" (parsed 9 bytes)
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Parsed raw string "0219038"
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Parsed int 2
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Grabbed string from reply: "1F" (parsed 4 bytes)
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Parsed raw string "1F"
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Home network
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Setting short network name format
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: SENDING frame type 0x00/length 0x0C/12
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|4FO|50P|53S|3D=|333|2C,|322|0D                  AT+COPS=3,2.    
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 1 "AT+COPS=3,2"
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 2 "OK"
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Checking line: OK
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: AT reply state: 1
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: RECEIVED frame type 0x00/length 0x12/18
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|4FO|50P|53S|3D=|333|2C,|322|0D |0D |0A |4FO|4BK AT+COPS=3,2...OK
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 0D |0A                                                          ..              
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Getting network code
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: SENDING frame type 0x00/length 0x09/9
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|4FO|50P|53S|3F?|0D                              AT+COPS?.       
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 1 "AT+COPS?"
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 2 "+COPS: 0,2,"26006",2"
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 3 "OK"
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Checking line: OK
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: AT reply state: 1
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: RECEIVED frame type 0x00/length 0x27/39
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|4FO|50P|53S|3F?|0D |0D |0A |2B+|43C|4FO|50P|53S AT+COPS?...+COPS
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 3A:|20 |300|2C,|322|2C,|22"|322|366|300|300|366|22"|2C,|322|0D  : 0,2,"26006",2.
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 0A |0D |0A |4FO|4BK|0D |0A                                      ...OK..         
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Network code received
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Parsing +COPS: 0,2,"26006",2 with +COPS: @i, @i, @r
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Parsed int 0
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Parsed int 2
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Grabbed string from reply: "26006" (parsed 7 bytes)
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Parsed raw string "26006"
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: String do not end same!
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Parsing +COPS: 0,2,"26006",2 with +COPS: @i, @i, @r, @i
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Parsed int 0
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Parsed int 2
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Grabbed string from reply: "26006" (parsed 7 bytes)
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Parsed raw string "26006"
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Parsed int 2
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu:    Network code              : 260 06
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu:    Network name for Gammu    : Play (Poland)
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Setting long string network name format
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: SENDING frame type 0x00/length 0x0C/12
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|4FO|50P|53S|3D=|333|2C,|300|0D                  AT+COPS=3,0.    
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 1 "AT+COPS=3,0"
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 2 "OK"
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Checking line: OK
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: AT reply state: 1
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: RECEIVED frame type 0x00/length 0x12/18
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|4FO|50P|53S|3D=|333|2C,|300|0D |0D |0A |4FO|4BK AT+COPS=3,0...OK
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 0D |0A                                                          ..              
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Getting network code
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: SENDING frame type 0x00/length 0x09/9
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|4FO|50P|53S|3F?|0D                              AT+COPS?.       
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 1 "AT+COPS?"
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 2 "+COPS: 0,0,"PLAY",2"
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 3 "OK"
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Checking line: OK
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: AT reply state: 1
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: RECEIVED frame type 0x00/length 0x26/38
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|4FO|50P|53S|3F?|0D |0D |0A |2B+|43C|4FO|50P|53S AT+COPS?...+COPS
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 3A:|20 |300|2C,|300|2C,|22"|50P|4CL|41A|59Y|22"|2C,|322|0D |0A  : 0,0,"PLAY",2..
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 0D |0A |4FO|4BK|0D |0A                                          ..OK..          
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Network name received
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Parsing +COPS: 0,0,"PLAY",2 with +COPS: @i, @i, @s
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Parsed int 0
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Parsed int 0
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Grabbed string from reply: "PLAY" (parsed 6 bytes)
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Parsed generic string "PLAY"
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Generic string decoded as "PLAY"
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: String do not end same!
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Parsing +COPS: 0,0,"PLAY",2 with +COPS: @i, @i, @s, @i
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Parsed int 0
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Parsed int 0
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Grabbed string from reply: "PLAY" (parsed 6 bytes)
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Parsed generic string "PLAY"
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Generic string decoded as "PLAY"
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Parsed int 2
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Leaving GSM_GetNetworkInfo
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Entering GSM_SendSMS
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Trying SMS PDU mode
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: SENDING frame type 0x00/length 0x0A/10
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|4DM|47G|46F|3D=|300|0D                          AT+CMGF=0.      
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 1 "AT+CMGF=0"
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 2 "OK"
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Checking line: OK
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: AT reply state: 1
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: RECEIVED frame type 0x00/length 0x10/16
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|4DM|47G|46F|3D=|300|0D |0D |0A |4FO|4BK|0D |0A  AT+CMGF=0...OK..
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: SMS Submit
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Recipient number "12345"
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: SMSC number "+48790998250"
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: SMS class -1
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: SMS validity ff
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: TPMR: 00 0
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 7 bit SMS, length 8, 9
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: test-bad1
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Waiting for modem prompt
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: SENDING frame type 0x00/length 0x0B/11
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|4DM|47G|53S|3D=|311|399|0D                      AT+CMGS=19.     
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 1 "AT+CMGS=19"
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 2 "> "
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Checking line: > 
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: AT reply state: 7
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: RECEIVED frame type 0x00/length 0x0F/15
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|4DM|47G|53S|3D=|311|399|0D |0D |0A |3E>|20      AT+CMGS=19...>  
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Sending SMS
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: SENDING frame type 0x00/length 0x36/54
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 300|377|399|311|388|344|399|377|399|300|388|399|355|322|46F|300 07918497908952F0
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 333|311|300|300|300|355|388|311|322|311|344|333|46F|355|300|300 310005812143F500
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 300|300|46F|46F|300|399|46F|344|46F|322|399|43C|44D|45E|311|322 00FF09F4F29CDE12
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 388|377|43C|399|333|311                                         87C931          
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: SENDING frame type 0x00/length 0x01/1
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: 1A                                                              .               
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: gammu: Leaving GSM_SendSMS
Thu 2018/01/11 15:07:13 gammu-smsd[30351]: Execute SQL: UPDATE outbox SET "SendingTimeOut" = now() + interval '60 seconds' WHERE "ID" = '1297' AND ("SendingTimeOut" < now() OR "SendingTimeOut" IS NULL)
Thu 2018/01/11 15:07:14 gammu-smsd[30351]: Execute SQL: UPDATE outbox SET "SendingTimeOut" = now() + interval '60 seconds' WHERE "ID" = '1297' AND ("SendingTimeOut" < now() OR "SendingTimeOut" IS NULL)
Thu 2018/01/11 15:07:16 gammu-smsd[30351]: Execute SQL: UPDATE outbox SET "SendingTimeOut" = now() + interval '60 seconds' WHERE "ID" = '1297' AND ("SendingTimeOut" < now() OR "SendingTimeOut" IS NULL)
Thu 2018/01/11 15:07:17 gammu-smsd[30351]: gammu: 1 "AT+CMGS=19"
Thu 2018/01/11 15:07:17 gammu-smsd[30351]: gammu: 2 "> 07918497908952F0310005812143F50000FF09F4F29CDE1287C931�"
Thu 2018/01/11 15:07:17 gammu-smsd[30351]: gammu: 3 "+CMS ERROR: 38"
Thu 2018/01/11 15:07:17 gammu-smsd[30351]: gammu: Checking line: +CMS ERROR: 38
Thu 2018/01/11 15:07:17 gammu-smsd[30351]: gammu: AT reply state: 5
Thu 2018/01/11 15:07:17 gammu-smsd[30351]: gammu: RECEIVED frame type 0x00/length 0x58/88
Thu 2018/01/11 15:07:17 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|4DM|47G|53S|3D=|311|399|0D |0D |0A |3E>|20 |300 AT+CMGS=19...> 0
Thu 2018/01/11 15:07:17 gammu-smsd[30351]: gammu: 377|399|311|388|344|399|377|399|300|388|399|355|322|46F|300|333 7918497908952F03
Thu 2018/01/11 15:07:17 gammu-smsd[30351]: gammu: 311|300|300|300|355|388|311|322|311|344|333|46F|355|300|300|300 10005812143F5000
Thu 2018/01/11 15:07:17 gammu-smsd[30351]: gammu: 300|46F|46F|300|399|46F|344|46F|322|399|43C|44D|45E|311|322|388 0FF09F4F29CDE128
Thu 2018/01/11 15:07:17 gammu-smsd[30351]: gammu: 377|43C|399|333|311|1A |0D |0A |2B+|43C|4DM|53S|20 |45E|52R|52R 7C931...+CMS ERR
Thu 2018/01/11 15:07:17 gammu-smsd[30351]: gammu: 4FO|52R|3A:|20 |333|388|0D |0A                                  OR: 38..        
Thu 2018/01/11 15:07:17 gammu-smsd[30351]: gammu: Error 38
Thu 2018/01/11 15:07:17 gammu-smsd[30351]: SMS sent on device: "/dev/ttyACM0" status=38, reference=-1
Thu 2018/01/11 15:07:17 gammu-smsd[30351]: gammu: CMS Error 38: "Network out of order"
Thu 2018/01/11 15:07:17 gammu-smsd[30351]: Error getting send status of message: Unknown error. (UNKNOWN[27])
Thu 2018/01/11 15:07:17 gammu-smsd[30351]: Execute SQL: UPDATE outbox SET "SendingTimeOut" = now() + interval '30 seconds', "Retries" = 1 WHERE "ID" = '1297';
Thu 2018/01/11 15:07:17 gammu-smsd[30351]: Execute SQL: UPDATE outbox SET "StatusCode"=38 WHERE "ID"='1297'
Thu 2018/01/11 15:08:17 gammu-smsd[30351]: gammu: Entering GSM_GetSecurityStatus
Thu 2018/01/11 15:08:17 gammu-smsd[30351]: gammu: Getting security code status
Thu 2018/01/11 15:08:17 gammu-smsd[30351]: gammu: SENDING frame type 0x00/length 0x09/9
Thu 2018/01/11 15:08:17 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|50P|49I|4EN|3F?|0D                              AT+CPIN?.       
Thu 2018/01/11 15:08:17 gammu-smsd[30351]: gammu: 1 "AT+CPIN?"
Thu 2018/01/11 15:08:17 gammu-smsd[30351]: gammu: 2 "+CPIN: READY"
Thu 2018/01/11 15:08:17 gammu-smsd[30351]: gammu: 3 "OK"
Thu 2018/01/11 15:08:17 gammu-smsd[30351]: gammu: Checking line: OK
Thu 2018/01/11 15:08:17 gammu-smsd[30351]: gammu: AT reply state: 1
Thu 2018/01/11 15:08:17 gammu-smsd[30351]: gammu: RECEIVED frame type 0x00/length 0x1F/31
Thu 2018/01/11 15:08:17 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|50P|49I|4EN|3F?|0D |0D |0A |2B+|43C|50P|49I|4EN AT+CPIN?...+CPIN
Thu 2018/01/11 15:08:17 gammu-smsd[30351]: gammu: 3A:|20 |52R|45E|41A|44D|59Y|0D |0A |0D |0A |4FO|4BK|0D |0A      : READY....OK.. 
Thu 2018/01/11 15:08:17 gammu-smsd[30351]: gammu: Parsing +CPIN: READY with +CPIN: @r
Thu 2018/01/11 15:08:17 gammu-smsd[30351]: gammu: Grabbed string from reply: "READY" (parsed 5 bytes)
Thu 2018/01/11 15:08:17 gammu-smsd[30351]: gammu: Parsed raw string "READY"
Thu 2018/01/11 15:08:17 gammu-smsd[30351]: gammu: Security status received - nothing to enter
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Leaving GSM_GetSecurityStatus
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Entering GSM_GetSMSStatus
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Getting SIM SMS status
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: SENDING frame type 0x00/length 0x12/18
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|50P|4DM|53S|3D=|22"|53S|4DM|22"|2C,|22"|53S|4DM AT+CPMS="SM","SM
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 22"|0D                                                          ".              
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 1 "AT+CPMS="SM","SM""
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 2 "+CPMS: 0,25,0,25,0,25"
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 3 "OK"
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Checking line: OK
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: AT reply state: 1
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: RECEIVED frame type 0x00/length 0x31/49
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|50P|4DM|53S|3D=|22"|53S|4DM|22"|2C,|22"|53S|4DM AT+CPMS="SM","SM
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 22"|0D |0D |0A |2B+|43C|50P|4DM|53S|3A:|20 |300|2C,|322|355|2C, "...+CPMS: 0,25,
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 300|2C,|322|355|2C,|300|2C,|322|355|0D |0A |0D |0A |4FO|4BK|0D  0,25,0,25....OK.
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 0A                                                              .               
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: SMS status received
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Parsing +CPMS: 0,25,0,25,0,25 with +CPMS: @i, @i, @0
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Parsed int 0
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Parsed int 25
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Used : 0
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Size : 25
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Getting phone SMS status
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: SENDING frame type 0x00/length 0x12/18
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|50P|4DM|53S|3D=|22"|4DM|45E|22"|2C,|22"|4DM|45E AT+CPMS="ME","ME
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 22"|0D                                                          ".              
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 1 "AT+CPMS="ME","ME""
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 2 "+CPMS: "ME",0,100,"ME",0,100,"ME",0,100"
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 3 "OK"
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Checking line: OK
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: AT reply state: 1
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: RECEIVED frame type 0x00/length 0x43/67
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|50P|4DM|53S|3D=|22"|4DM|45E|22"|2C,|22"|4DM|45E AT+CPMS="ME","ME
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 22"|0D |0D |0A |2B+|43C|50P|4DM|53S|3A:|20 |22"|4DM|45E|22"|2C, "...+CPMS: "ME",
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 300|2C,|311|300|300|2C,|22"|4DM|45E|22"|2C,|300|2C,|311|300|300 0,100,"ME",0,100
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 2C,|22"|4DM|45E|22"|2C,|300|2C,|311|300|300|0D |0A |0D |0A |4FO ,"ME",0,100....O
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 4BK|0D |0A                                                      K..             
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: SMS status received
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Parsing +CPMS: "ME",0,100,"ME",0,100,"ME",0,100 with +CPMS: @i, @i, @0
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Parsing +CPMS: "ME",0,100,"ME",0,100,"ME",0,100 with +CPMS: @s, @i, @i, @0
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Grabbed string from reply: "ME" (parsed 4 bytes)
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Parsed generic string "ME"
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Generic string decoded as "ME"
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Parsed int 0
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Parsed int 100
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Used : 0
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Size : 100
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Leaving GSM_GetSMSStatus
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: Execute SQL: SELECT "ID", "InsertIntoDB", "SendingDateTime", "SenderID" FROM outbox WHERE "SendingDateTime" < now() AND "SendingTimeOut" < now() AND "SendBefore" >= localtime AND "SendAfter" <= localtime AND ( "SenderID" is NULL OR "SenderID" = '' OR "SenderID" = 'phone1' ) ORDER BY "Priority" DESC, "InsertIntoDB" ASC LIMIT 1
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: Execute SQL: UPDATE outbox SET "SendingTimeOut" = now() + interval '60 seconds' WHERE "ID" = '1297' AND ("SendingTimeOut" < now() OR "SendingTimeOut" IS NULL)
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: Execute SQL: SELECT "Text", "Coding", "UDH", "Class", "TextDecoded", "ID", "DestinationNumber", "MultiPart", "RelativeValidity", "DeliveryReport", "CreatorID", "Retries", "Status", "StatusCode" FROM outbox WHERE "ID"='1297'
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: Message: test-bad1
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: New message to send: 1297
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: Message without SMSC, assuming you want to use the one from phone
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Entering GSM_GetSignalQuality
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Getting signal quality info
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: SENDING frame type 0x00/length 0x07/7
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|53S|51Q|0D                                      AT+CSQ.         
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 1 "AT+CSQ"
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 2 "+CSQ: 15,2"
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 3 "OK"
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Checking line: OK
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: AT reply state: 1
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: RECEIVED frame type 0x00/length 0x1B/27
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|53S|51Q|0D |0D |0A |2B+|43C|53S|51Q|3A:|20 |311 AT+CSQ...+CSQ: 1
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 355|2C,|322|0D |0A |0D |0A |4FO|4BK|0D |0A                      5,2....OK..     
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Signal quality info received
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Parsing +CSQ: 15,2 with +CSQ: @i, @i
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Parsed int 15
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Parsed int 2
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Leaving GSM_GetSignalQuality
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Entering GSM_GetNetworkInfo
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Enable full network info
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: SENDING frame type 0x00/length 0x0A/10
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|52R|45E|47G|3D=|322|0D                          AT+CREG=2.      
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 1 "AT+CREG=2"
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 2 "OK"
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Checking line: OK
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: AT reply state: 1
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: RECEIVED frame type 0x00/length 0x10/16
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|52R|45E|47G|3D=|322|0D |0D |0A |4FO|4BK|0D |0A  AT+CREG=2...OK..
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Enable full packet network info
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: SENDING frame type 0x00/length 0x0B/11
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|47G|52R|45E|47G|3D=|322|0D                      AT+CGREG=2.     
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 1 "AT+CGREG=2"
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 2 "OK"
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Checking line: OK
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: AT reply state: 1
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: RECEIVED frame type 0x00/length 0x11/17
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|47G|52R|45E|47G|3D=|322|0D |0D |0A |4FO|4BK|0D  AT+CGREG=2...OK.
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 0A                                                              .               
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Getting GPRS state
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: SENDING frame type 0x00/length 0x0A/10
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|47G|41A|54T|54T|3F?|0D                          AT+CGATT?.      
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 1 "AT+CGATT?"
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 2 "+CGATT: 1"
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 3 "OK"
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Checking line: OK
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: AT reply state: 1
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: RECEIVED frame type 0x00/length 0x1D/29
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|47G|41A|54T|54T|3F?|0D |0D |0A |2B+|43C|47G|41A AT+CGATT?...+CGA
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 54T|54T|3A:|20 |311|0D |0A |0D |0A |4FO|4BK|0D |0A              TT: 1....OK..   
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: GPRS state received
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Parsing +CGATT: 1 with +CGATT: @i
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Parsed int 1
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Getting network LAC and CID and state
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: SENDING frame type 0x00/length 0x09/9
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|52R|45E|47G|3F?|0D                              AT+CREG?.       
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 1 "AT+CREG?"
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 2 "+CREG: 2,1,"001F","0219038",2"
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 3 "OK"
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Checking line: OK
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: AT reply state: 1
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: RECEIVED frame type 0x00/length 0x30/48
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|52R|45E|47G|3F?|0D |0D |0A |2B+|43C|52R|45E|47G AT+CREG?...+CREG
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 3A:|20 |322|2C,|311|2C,|22"|300|300|311|46F|22"|2C,|22"|300|322 : 2,1,"001F","02
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 311|399|300|333|388|22"|2C,|322|0D |0A |0D |0A |4FO|4BK|0D |0A  19038",2....OK..
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Network LAC & CID & state received
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Parsing +CREG: 2,1,"001F","0219038",2 with +CREG: @i, @i, @r, @r, @i
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Parsed int 2
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Parsed int 1
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Grabbed string from reply: "001F" (parsed 6 bytes)
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Parsed raw string "001F"
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Grabbed string from reply: "0219038" (parsed 9 bytes)
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Parsed raw string "0219038"
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Parsed int 2
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Home network
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Getting packet network LAC and CID and state
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: SENDING frame type 0x00/length 0x0A/10
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|47G|52R|45E|47G|3F?|0D                          AT+CGREG?.      
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 1 "AT+CGREG?"
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 2 "+CGREG: 2,1,"001F","0219038",2,"1F""
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 3 "OK"
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Checking line: OK
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: AT reply state: 1
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: RECEIVED frame type 0x00/length 0x37/55
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|47G|52R|45E|47G|3F?|0D |0D |0A |2B+|43C|47G|52R AT+CGREG?...+CGR
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 45E|47G|3A:|20 |322|2C,|311|2C,|22"|300|300|311|46F|22"|2C,|22" EG: 2,1,"001F","
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 300|322|311|399|300|333|388|22"|2C,|322|2C,|22"|311|46F|22"|0D  0219038",2,"1F".
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 0A |0D |0A |4FO|4BK|0D |0A                                      ...OK..         
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Network LAC & CID & state received
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Parsing +CGREG: 2,1,"001F","0219038",2,"1F" with +CGREG: @i, @i, @r, @r, @i, @r
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Parsed int 2
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Parsed int 1
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Grabbed string from reply: "001F" (parsed 6 bytes)
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Parsed raw string "001F"
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Grabbed string from reply: "0219038" (parsed 9 bytes)
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Parsed raw string "0219038"
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Parsed int 2
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Grabbed string from reply: "1F" (parsed 4 bytes)
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Parsed raw string "1F"
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Home network
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Setting short network name format
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: SENDING frame type 0x00/length 0x0C/12
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|4FO|50P|53S|3D=|333|2C,|322|0D                  AT+COPS=3,2.    
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 1 "AT+COPS=3,2"
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 2 "OK"
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Checking line: OK
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: AT reply state: 1
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: RECEIVED frame type 0x00/length 0x12/18
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|4FO|50P|53S|3D=|333|2C,|322|0D |0D |0A |4FO|4BK AT+COPS=3,2...OK
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 0D |0A                                                          ..              
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Getting network code
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: SENDING frame type 0x00/length 0x09/9
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|4FO|50P|53S|3F?|0D                              AT+COPS?.       
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 1 "AT+COPS?"
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 2 "+COPS: 0,2,"26006",2"
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 3 "OK"
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Checking line: OK
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: AT reply state: 1
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: RECEIVED frame type 0x00/length 0x27/39
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|4FO|50P|53S|3F?|0D |0D |0A |2B+|43C|4FO|50P|53S AT+COPS?...+COPS
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 3A:|20 |300|2C,|322|2C,|22"|322|366|300|300|366|22"|2C,|322|0D  : 0,2,"26006",2.
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 0A |0D |0A |4FO|4BK|0D |0A                                      ...OK..         
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Network code received
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Parsing +COPS: 0,2,"26006",2 with +COPS: @i, @i, @r
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Parsed int 0
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Parsed int 2
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Grabbed string from reply: "26006" (parsed 7 bytes)
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Parsed raw string "26006"
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: String do not end same!
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Parsing +COPS: 0,2,"26006",2 with +COPS: @i, @i, @r, @i
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Parsed int 0
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Parsed int 2
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Grabbed string from reply: "26006" (parsed 7 bytes)
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Parsed raw string "26006"
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Parsed int 2
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu:    Network code              : 260 06
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu:    Network name for Gammu    : Play (Poland)
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Setting long string network name format
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: SENDING frame type 0x00/length 0x0C/12
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|4FO|50P|53S|3D=|333|2C,|300|0D                  AT+COPS=3,0.    
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 1 "AT+COPS=3,0"
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 2 "OK"
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Checking line: OK
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: AT reply state: 1
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: RECEIVED frame type 0x00/length 0x12/18
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|4FO|50P|53S|3D=|333|2C,|300|0D |0D |0A |4FO|4BK AT+COPS=3,0...OK
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 0D |0A                                                          ..              
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Getting network code
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: SENDING frame type 0x00/length 0x09/9
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|4FO|50P|53S|3F?|0D                              AT+COPS?.       
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 1 "AT+COPS?"
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 2 "+COPS: 0,0,"PLAY",2"
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 3 "OK"
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Checking line: OK
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: AT reply state: 1
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: RECEIVED frame type 0x00/length 0x26/38
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|4FO|50P|53S|3F?|0D |0D |0A |2B+|43C|4FO|50P|53S AT+COPS?...+COPS
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 3A:|20 |300|2C,|300|2C,|22"|50P|4CL|41A|59Y|22"|2C,|322|0D |0A  : 0,0,"PLAY",2..
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 0D |0A |4FO|4BK|0D |0A                                          ..OK..          
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Network name received
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Parsing +COPS: 0,0,"PLAY",2 with +COPS: @i, @i, @s
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Parsed int 0
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Parsed int 0
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Grabbed string from reply: "PLAY" (parsed 6 bytes)
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Parsed generic string "PLAY"
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Generic string decoded as "PLAY"
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: String do not end same!
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Parsing +COPS: 0,0,"PLAY",2 with +COPS: @i, @i, @s, @i
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Parsed int 0
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Parsed int 0
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Grabbed string from reply: "PLAY" (parsed 6 bytes)
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Parsed generic string "PLAY"
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Generic string decoded as "PLAY"
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Parsed int 2
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Leaving GSM_GetNetworkInfo
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Entering GSM_SendSMS
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: SMS Submit
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Recipient number "12345"
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: SMSC number "+48790998250"
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: SMS class -1
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: SMS validity ff
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: TPMR: 00 0
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 7 bit SMS, length 8, 9
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: test-bad1
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Waiting for modem prompt
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: SENDING frame type 0x00/length 0x0B/11
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|4DM|47G|53S|3D=|311|399|0D                      AT+CMGS=19.     
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 1 "AT+CMGS=19"
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 2 "> "
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Checking line: > 
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: AT reply state: 7
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: RECEIVED frame type 0x00/length 0x0F/15
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|4DM|47G|53S|3D=|311|399|0D |0D |0A |3E>|20      AT+CMGS=19...>  
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Sending SMS
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: SENDING frame type 0x00/length 0x36/54
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 300|377|399|311|388|344|399|377|399|300|388|399|355|322|46F|300 07918497908952F0
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 333|311|300|300|300|355|388|311|322|311|344|333|46F|355|300|300 310005812143F500
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 300|300|46F|46F|300|399|46F|344|46F|322|399|43C|44D|45E|311|322 00FF09F4F29CDE12
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 388|377|43C|399|333|311                                         87C931          
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: SENDING frame type 0x00/length 0x01/1
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: 1A                                                              .               
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: gammu: Leaving GSM_SendSMS
Thu 2018/01/11 15:08:18 gammu-smsd[30351]: Execute SQL: UPDATE outbox SET "SendingTimeOut" = now() + interval '60 seconds' WHERE "ID" = '1297' AND ("SendingTimeOut" < now() OR "SendingTimeOut" IS NULL)
Thu 2018/01/11 15:08:20 gammu-smsd[30351]: Execute SQL: UPDATE outbox SET "SendingTimeOut" = now() + interval '60 seconds' WHERE "ID" = '1297' AND ("SendingTimeOut" < now() OR "SendingTimeOut" IS NULL)
Thu 2018/01/11 15:08:21 gammu-smsd[30351]: gammu: 1 "AT+CMGS=19"
Thu 2018/01/11 15:08:21 gammu-smsd[30351]: gammu: 2 "> 07918497908952F0310005812143F50000FF09F4F29CDE1287C931�"
Thu 2018/01/11 15:08:22 gammu-smsd[30351]: gammu: 3 "+CMS ERROR: 38"
Thu 2018/01/11 15:08:22 gammu-smsd[30351]: gammu: Checking line: +CMS ERROR: 38
Thu 2018/01/11 15:08:22 gammu-smsd[30351]: gammu: AT reply state: 5
Thu 2018/01/11 15:08:22 gammu-smsd[30351]: gammu: RECEIVED frame type 0x00/length 0x58/88
Thu 2018/01/11 15:08:22 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|4DM|47G|53S|3D=|311|399|0D |0D |0A |3E>|20 |300 AT+CMGS=19...> 0
Thu 2018/01/11 15:08:22 gammu-smsd[30351]: gammu: 377|399|311|388|344|399|377|399|300|388|399|355|322|46F|300|333 7918497908952F03
Thu 2018/01/11 15:08:22 gammu-smsd[30351]: gammu: 311|300|300|300|355|388|311|322|311|344|333|46F|355|300|300|300 10005812143F5000
Thu 2018/01/11 15:08:22 gammu-smsd[30351]: gammu: 300|46F|46F|300|399|46F|344|46F|322|399|43C|44D|45E|311|322|388 0FF09F4F29CDE128
Thu 2018/01/11 15:08:22 gammu-smsd[30351]: gammu: 377|43C|399|333|311|1A |0D |0A |2B+|43C|4DM|53S|20 |45E|52R|52R 7C931...+CMS ERR
Thu 2018/01/11 15:08:22 gammu-smsd[30351]: gammu: 4FO|52R|3A:|20 |333|388|0D |0A                                  OR: 38..        
Thu 2018/01/11 15:08:22 gammu-smsd[30351]: gammu: Error 38
Thu 2018/01/11 15:08:22 gammu-smsd[30351]: SMS sent on device: "/dev/ttyACM0" status=38, reference=-1
Thu 2018/01/11 15:08:22 gammu-smsd[30351]: gammu: CMS Error 38: "Network out of order"
Thu 2018/01/11 15:08:22 gammu-smsd[30351]: Error getting send status of message: Unknown error. (UNKNOWN[27])
Thu 2018/01/11 15:08:22 gammu-smsd[30351]: Execute SQL: UPDATE outbox SET "SendingTimeOut" = now() + interval '30 seconds', "Retries" = 2 WHERE "ID" = '1297';
Thu 2018/01/11 15:08:22 gammu-smsd[30351]: Execute SQL: UPDATE outbox SET "StatusCode"=38 WHERE "ID"='1297'
Thu 2018/01/11 15:09:22 gammu-smsd[30351]: gammu: Entering GSM_GetSecurityStatus
Thu 2018/01/11 15:09:22 gammu-smsd[30351]: gammu: Getting security code status
Thu 2018/01/11 15:09:22 gammu-smsd[30351]: gammu: SENDING frame type 0x00/length 0x09/9
Thu 2018/01/11 15:09:22 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|50P|49I|4EN|3F?|0D                              AT+CPIN?.       
Thu 2018/01/11 15:09:22 gammu-smsd[30351]: gammu: 1 "AT+CPIN?"
Thu 2018/01/11 15:09:22 gammu-smsd[30351]: gammu: 2 "+CPIN: READY"
Thu 2018/01/11 15:09:22 gammu-smsd[30351]: gammu: 3 "OK"
...
Thu 2018/01/11 15:09:23 gammu-smsd[30351]: gammu: Leaving GSM_GetNetworkInfo
Thu 2018/01/11 15:09:23 gammu-smsd[30351]: gammu: Entering GSM_SendSMS
Thu 2018/01/11 15:09:23 gammu-smsd[30351]: gammu: SMS Submit
Thu 2018/01/11 15:09:23 gammu-smsd[30351]: gammu: Recipient number "12345"
Thu 2018/01/11 15:09:23 gammu-smsd[30351]: gammu: SMSC number "+48790998250"
Thu 2018/01/11 15:09:23 gammu-smsd[30351]: gammu: SMS class -1
Thu 2018/01/11 15:09:23 gammu-smsd[30351]: gammu: SMS validity ff
Thu 2018/01/11 15:09:23 gammu-smsd[30351]: gammu: TPMR: 00 0
Thu 2018/01/11 15:09:23 gammu-smsd[30351]: gammu: 7 bit SMS, length 8, 9
Thu 2018/01/11 15:09:23 gammu-smsd[30351]: gammu: test-bad1
Thu 2018/01/11 15:09:23 gammu-smsd[30351]: gammu: Waiting for modem prompt
Thu 2018/01/11 15:09:23 gammu-smsd[30351]: gammu: SENDING frame type 0x00/length 0x0B/11
Thu 2018/01/11 15:09:23 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|4DM|47G|53S|3D=|311|399|0D                      AT+CMGS=19.     
Thu 2018/01/11 15:09:23 gammu-smsd[30351]: gammu: 1 "AT+CMGS=19"
Thu 2018/01/11 15:09:23 gammu-smsd[30351]: gammu: 2 "> "
Thu 2018/01/11 15:09:23 gammu-smsd[30351]: gammu: Checking line: > 
Thu 2018/01/11 15:09:23 gammu-smsd[30351]: gammu: AT reply state: 7
Thu 2018/01/11 15:09:23 gammu-smsd[30351]: gammu: RECEIVED frame type 0x00/length 0x0F/15
Thu 2018/01/11 15:09:23 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|4DM|47G|53S|3D=|311|399|0D |0D |0A |3E>|20      AT+CMGS=19...>  
Thu 2018/01/11 15:09:23 gammu-smsd[30351]: gammu: Sending SMS
Thu 2018/01/11 15:09:23 gammu-smsd[30351]: gammu: SENDING frame type 0x00/length 0x36/54
Thu 2018/01/11 15:09:23 gammu-smsd[30351]: gammu: 300|377|399|311|388|344|399|377|399|300|388|399|355|322|46F|300 07918497908952F0
Thu 2018/01/11 15:09:23 gammu-smsd[30351]: gammu: 333|311|300|300|300|355|388|311|322|311|344|333|46F|355|300|300 310005812143F500
Thu 2018/01/11 15:09:23 gammu-smsd[30351]: gammu: 300|300|46F|46F|300|399|46F|344|46F|322|399|43C|44D|45E|311|322 00FF09F4F29CDE12
Thu 2018/01/11 15:09:23 gammu-smsd[30351]: gammu: 388|377|43C|399|333|311                                         87C931          
Thu 2018/01/11 15:09:23 gammu-smsd[30351]: gammu: SENDING frame type 0x00/length 0x01/1
Thu 2018/01/11 15:09:23 gammu-smsd[30351]: gammu: 1A                                                              .               
Thu 2018/01/11 15:09:23 gammu-smsd[30351]: gammu: Leaving GSM_SendSMS
Thu 2018/01/11 15:09:23 gammu-smsd[30351]: Execute SQL: UPDATE outbox SET "SendingTimeOut" = now() + interval '60 seconds' WHERE "ID" = '1297' AND ("SendingTimeOut" < now() OR "SendingTimeOut" IS NULL)
Thu 2018/01/11 15:09:24 gammu-smsd[30351]: Execute SQL: UPDATE outbox SET "SendingTimeOut" = now() + interval '60 seconds' WHERE "ID" = '1297' AND ("SendingTimeOut" < now() OR "SendingTimeOut" IS NULL)
Thu 2018/01/11 15:09:26 gammu-smsd[30351]: Execute SQL: UPDATE outbox SET "SendingTimeOut" = now() + interval '60 seconds' WHERE "ID" = '1297' AND ("SendingTimeOut" < now() OR "SendingTimeOut" IS NULL)
Thu 2018/01/11 15:09:27 gammu-smsd[30351]: gammu: 1 "AT+CMGS=19"
Thu 2018/01/11 15:09:27 gammu-smsd[30351]: gammu: 2 "> 07918497908952F0310005812143F50000FF09F4F29CDE1287C931�"
Thu 2018/01/11 15:09:27 gammu-smsd[30351]: gammu: 3 "+CMS ERROR: 38"
Thu 2018/01/11 15:09:27 gammu-smsd[30351]: gammu: Checking line: +CMS ERROR: 38
Thu 2018/01/11 15:09:27 gammu-smsd[30351]: gammu: AT reply state: 5
Thu 2018/01/11 15:09:27 gammu-smsd[30351]: gammu: RECEIVED frame type 0x00/length 0x58/88
Thu 2018/01/11 15:09:27 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|4DM|47G|53S|3D=|311|399|0D |0D |0A |3E>|20 |300 AT+CMGS=19...> 0
Thu 2018/01/11 15:09:27 gammu-smsd[30351]: gammu: 377|399|311|388|344|399|377|399|300|388|399|355|322|46F|300|333 7918497908952F03
Thu 2018/01/11 15:09:27 gammu-smsd[30351]: gammu: 311|300|300|300|355|388|311|322|311|344|333|46F|355|300|300|300 10005812143F5000
Thu 2018/01/11 15:09:27 gammu-smsd[30351]: gammu: 300|46F|46F|300|399|46F|344|46F|322|399|43C|44D|45E|311|322|388 0FF09F4F29CDE128
Thu 2018/01/11 15:09:27 gammu-smsd[30351]: gammu: 377|43C|399|333|311|1A |0D |0A |2B+|43C|4DM|53S|20 |45E|52R|52R 7C931...+CMS ERR
Thu 2018/01/11 15:09:27 gammu-smsd[30351]: gammu: 4FO|52R|3A:|20 |333|388|0D |0A                                  OR: 38..        
Thu 2018/01/11 15:09:27 gammu-smsd[30351]: gammu: Error 38
Thu 2018/01/11 15:09:27 gammu-smsd[30351]: SMS sent on device: "/dev/ttyACM0" status=38, reference=-1
Thu 2018/01/11 15:09:27 gammu-smsd[30351]: gammu: CMS Error 38: "Network out of order"
Thu 2018/01/11 15:09:27 gammu-smsd[30351]: Error getting send status of message: Unknown error. (UNKNOWN[27])
Thu 2018/01/11 15:09:27 gammu-smsd[30351]: Execute SQL: UPDATE outbox SET "SendingTimeOut" = now() + interval '30 seconds', "Retries" = 3 WHERE "ID" = '1297';
Thu 2018/01/11 15:09:27 gammu-smsd[30351]: Execute SQL: UPDATE outbox SET "StatusCode"=38 WHERE "ID"='1297'
Thu 2018/01/11 15:10:27 gammu-smsd[30351]: gammu: Entering GSM_GetSecurityStatus
Thu 2018/01/11 15:10:27 gammu-smsd[30351]: gammu: Getting security code status
Thu 2018/01/11 15:10:27 gammu-smsd[30351]: gammu: SENDING frame type 0x00/length 0x09/9
Thu 2018/01/11 15:10:27 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|50P|49I|4EN|3F?|0D                              AT+CPIN?.       
Thu 2018/01/11 15:10:27 gammu-smsd[30351]: gammu: 1 "AT+CPIN?"
Thu 2018/01/11 15:10:27 gammu-smsd[30351]: gammu: 2 "+CPIN: READY"
Thu 2018/01/11 15:10:27 gammu-smsd[30351]: gammu: 3 "OK"
Thu 2018/01/11 15:10:27 gammu-smsd[30351]: gammu: Checking line: OK
Thu 2018/01/11 15:10:27 gammu-smsd[30351]: gammu: AT reply state: 1
Thu 2018/01/11 15:10:27 gammu-smsd[30351]: gammu: RECEIVED frame type 0x00/length 0x1F/31
Thu 2018/01/11 15:10:27 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|50P|49I|4EN|3F?|0D |0D |0A |2B+|43C|50P|49I|4EN AT+CPIN?...+CPIN
Thu 2018/01/11 15:10:27 gammu-smsd[30351]: gammu: 3A:|20 |52R|45E|41A|44D|59Y|0D |0A |0D |0A |4FO|4BK|0D |0A      : READY....OK.. 
Thu 2018/01/11 15:10:27 gammu-smsd[30351]: gammu: Parsing +CPIN: READY with +CPIN: @r
Thu 2018/01/11 15:10:27 gammu-smsd[30351]: gammu: Grabbed string from reply: "READY" (parsed 5 bytes)
Thu 2018/01/11 15:10:27 gammu-smsd[30351]: gammu: Parsed raw string "READY"
Thu 2018/01/11 15:10:27 gammu-smsd[30351]: gammu: Security status received - nothing to enter
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: Leaving GSM_GetSecurityStatus
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: Entering GSM_GetSMSStatus
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: Getting SIM SMS status
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: SENDING frame type 0x00/length 0x12/18
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|50P|4DM|53S|3D=|22"|53S|4DM|22"|2C,|22"|53S|4DM AT+CPMS="SM","SM
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: 22"|0D                                                          ".              
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: 1 "AT+CPMS="SM","SM""
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: 2 "+CPMS: 0,25,0,25,0,25"
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: 3 "OK"
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: Checking line: OK
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: AT reply state: 1
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: RECEIVED frame type 0x00/length 0x31/49
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|50P|4DM|53S|3D=|22"|53S|4DM|22"|2C,|22"|53S|4DM AT+CPMS="SM","SM
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: 22"|0D |0D |0A |2B+|43C|50P|4DM|53S|3A:|20 |300|2C,|322|355|2C, "...+CPMS: 0,25,
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: 300|2C,|322|355|2C,|300|2C,|322|355|0D |0A |0D |0A |4FO|4BK|0D  0,25,0,25....OK.
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: 0A                                                              .               
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: SMS status received
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: Parsing +CPMS: 0,25,0,25,0,25 with +CPMS: @i, @i, @0
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: Parsed int 0
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: Parsed int 25
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: Used : 0
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: Size : 25
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: Getting phone SMS status
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: SENDING frame type 0x00/length 0x12/18
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|50P|4DM|53S|3D=|22"|4DM|45E|22"|2C,|22"|4DM|45E AT+CPMS="ME","ME
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: 22"|0D                                                          ".              
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: 1 "AT+CPMS="ME","ME""
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: 2 "+CPMS: "ME",0,100,"ME",0,100,"ME",0,100"
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: 3 "OK"
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: Checking line: OK
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: AT reply state: 1
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: RECEIVED frame type 0x00/length 0x43/67
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|50P|4DM|53S|3D=|22"|4DM|45E|22"|2C,|22"|4DM|45E AT+CPMS="ME","ME
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: 22"|0D |0D |0A |2B+|43C|50P|4DM|53S|3A:|20 |22"|4DM|45E|22"|2C, "...+CPMS: "ME",
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: 300|2C,|311|300|300|2C,|22"|4DM|45E|22"|2C,|300|2C,|311|300|300 0,100,"ME",0,100
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: 2C,|22"|4DM|45E|22"|2C,|300|2C,|311|300|300|0D |0A |0D |0A |4FO ,"ME",0,100....O
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: 4BK|0D |0A                                                      K..             
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: SMS status received
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: Parsing +CPMS: "ME",0,100,"ME",0,100,"ME",0,100 with +CPMS: @i, @i, @0
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: Parsing +CPMS: "ME",0,100,"ME",0,100,"ME",0,100 with +CPMS: @s, @i, @i, @0
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: Grabbed string from reply: "ME" (parsed 4 bytes)
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: Parsed generic string "ME"
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: Generic string decoded as "ME"
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: Parsed int 0
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: Parsed int 100
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: Used : 0
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: Size : 100
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: Leaving GSM_GetSMSStatus
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: Execute SQL: SELECT "ID", "InsertIntoDB", "SendingDateTime", "SenderID" FROM outbox WHERE "SendingDateTime" < now() AND "SendingTimeOut" < now() AND "SendBefore" >= localtime AND "SendAfter" <= localtime AND ( "SenderID" is NULL OR "SenderID" = '' OR "SenderID" = 'phone1' ) ORDER BY "Priority" DESC, "InsertIntoDB" ASC LIMIT 1
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: Execute SQL: UPDATE outbox SET "SendingTimeOut" = now() + interval '60 seconds' WHERE "ID" = '1297' AND ("SendingTimeOut" < now() OR "SendingTimeOut" IS NULL)
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: Execute SQL: SELECT "Text", "Coding", "UDH", "Class", "TextDecoded", "ID", "DestinationNumber", "MultiPart", "RelativeValidity", "DeliveryReport", "CreatorID", "Retries", "Status", "StatusCode" FROM outbox WHERE "ID"='1297'
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: Message: test-bad1
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: Moved to errorbox, reached MaxRetries: 1297
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: Execute SQL: SELECT "Text", "Coding", "UDH", "Class", "TextDecoded", "ID", "DestinationNumber", "MultiPart", "RelativeValidity", "DeliveryReport", "CreatorID", "Retries", "Status", "StatusCode" FROM outbox WHERE "ID"='1297'
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: Execute SQL: INSERT INTO sentitems ("CreatorID", "ID", "SequencePosition", "Status", "SendingDateTime", "SMSCNumber", "TPMR", "SenderID", "Text", "DestinationNumber", "Coding", "UDH", "Class", "TextDecoded", "InsertIntoDB", "RelativeValidity", "StatusCode")  VALUES ('admin', '1297', 1, 'SendingError', now(), '', -1, 'phone1', '0074006500730074002D0062006100640031', '12345', 'Default_No_Compression', '', -1, 'test-bad1', '2018-01-11 15:07:10 GMT', 255, 38)
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: Execute SQL: UPDATE phones SET "Sent"= "Sent" + 1 WHERE "IMEI" = '356136076375619'
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: Execute SQL: DELETE FROM outbox WHERE "ID"='1297';INSERT INTO user_sentitems (id_sentitems, id_user) (SELECT id_outbox, id_user FROM user_outbox WHERE id_outbox = '1297');DELETE FROM user_outbox WHERE id_outbox = '1297';
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: Execute SQL: DELETE FROM outbox_multipart WHERE "ID"='1297'
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: Entering GSM_GetSignalQuality
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: Getting signal quality info
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: SENDING frame type 0x00/length 0x07/7
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|53S|51Q|0D                                      AT+CSQ.         
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: 1 "AT+CSQ"
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: 2 "+CSQ: 15,2"
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: 3 "OK"
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: Checking line: OK
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: AT reply state: 1
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: RECEIVED frame type 0x00/length 0x1B/27
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|53S|51Q|0D |0D |0A |2B+|43C|53S|51Q|3A:|20 |311 AT+CSQ...+CSQ: 1
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: 355|2C,|322|0D |0A |0D |0A |4FO|4BK|0D |0A                      5,2....OK..     
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: Signal quality info received
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: Parsing +CSQ: 15,2 with +CSQ: @i, @i
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: Parsed int 15
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: Parsed int 2
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: Leaving GSM_GetSignalQuality
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: Entering GSM_GetNetworkInfo
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: Enable full network info
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: SENDING frame type 0x00/length 0x0A/10
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|52R|45E|47G|3D=|322|0D                          AT+CREG=2.      
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: 1 "AT+CREG=2"
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: 2 "OK"
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: Checking line: OK
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: AT reply state: 1
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: RECEIVED frame type 0x00/length 0x10/16
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|52R|45E|47G|3D=|322|0D |0D |0A |4FO|4BK|0D |0A  AT+CREG=2...OK..
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: Enable full packet network info
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: SENDING frame type 0x00/length 0x0B/11
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|47G|52R|45E|47G|3D=|322|0D                      AT+CGREG=2.     
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: 1 "AT+CGREG=2"
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: 2 "OK"
Thu 2018/01/11 15:10:28 gammu-smsd[30351]: gammu: Checking line: OK
...
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Leaving GSM_GetSMSStatus
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: Execute SQL: SELECT "ID", "InsertIntoDB", "SendingDateTime", "SenderID" FROM outbox WHERE "SendingDateTime" < now() AND "SendingTimeOut" < now() AND "SendBefore" >= localtime AND "SendAfter" <= localtime AND ( "SenderID" is NULL OR "SenderID" = '' OR "SenderID" = 'phone1' ) ORDER BY "Priority" DESC, "InsertIntoDB" ASC LIMIT 1
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: Execute SQL: UPDATE outbox SET "SendingTimeOut" = now() + interval '60 seconds' WHERE "ID" = '1298' AND ("SendingTimeOut" < now() OR "SendingTimeOut" IS NULL)
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: Execute SQL: SELECT "Text", "Coding", "UDH", "Class", "TextDecoded", "ID", "DestinationNumber", "MultiPart", "RelativeValidity", "DeliveryReport", "CreatorID", "Retries", "Status", "StatusCode" FROM outbox WHERE "ID"='1298'
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: Message: test-bad2
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: New message to send: 1298
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: Message without SMSC, assuming you want to use the one from phone
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Entering GSM_GetSignalQuality
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Getting signal quality info
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: SENDING frame type 0x00/length 0x07/7
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|53S|51Q|0D                                      AT+CSQ.         
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 1 "AT+CSQ"
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 2 "+CSQ: 15,2"
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 3 "OK"
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Checking line: OK
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: AT reply state: 1
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: RECEIVED frame type 0x00/length 0x1B/27
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|53S|51Q|0D |0D |0A |2B+|43C|53S|51Q|3A:|20 |311 AT+CSQ...+CSQ: 1
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 355|2C,|322|0D |0A |0D |0A |4FO|4BK|0D |0A                      5,2....OK..     
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Signal quality info received
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Parsing +CSQ: 15,2 with +CSQ: @i, @i
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Parsed int 15
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Parsed int 2
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Leaving GSM_GetSignalQuality
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Entering GSM_GetNetworkInfo
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Enable full network info
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: SENDING frame type 0x00/length 0x0A/10
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|52R|45E|47G|3D=|322|0D                          AT+CREG=2.      
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 1 "AT+CREG=2"
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 2 "OK"
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Checking line: OK
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: AT reply state: 1
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: RECEIVED frame type 0x00/length 0x10/16
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|52R|45E|47G|3D=|322|0D |0D |0A |4FO|4BK|0D |0A  AT+CREG=2...OK..
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Enable full packet network info
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: SENDING frame type 0x00/length 0x0B/11
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|47G|52R|45E|47G|3D=|322|0D                      AT+CGREG=2.     
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 1 "AT+CGREG=2"
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 2 "OK"
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Checking line: OK
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: AT reply state: 1
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: RECEIVED frame type 0x00/length 0x11/17
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|47G|52R|45E|47G|3D=|322|0D |0D |0A |4FO|4BK|0D  AT+CGREG=2...OK.
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 0A                                                              .               
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Getting GPRS state
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: SENDING frame type 0x00/length 0x0A/10
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|47G|41A|54T|54T|3F?|0D                          AT+CGATT?.      
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 1 "AT+CGATT?"
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 2 "+CGATT: 1"
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 3 "OK"
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Checking line: OK
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: AT reply state: 1
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: RECEIVED frame type 0x00/length 0x1D/29
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|47G|41A|54T|54T|3F?|0D |0D |0A |2B+|43C|47G|41A AT+CGATT?...+CGA
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 54T|54T|3A:|20 |311|0D |0A |0D |0A |4FO|4BK|0D |0A              TT: 1....OK..   
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: GPRS state received
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Parsing +CGATT: 1 with +CGATT: @i
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Parsed int 1
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Getting network LAC and CID and state
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: SENDING frame type 0x00/length 0x09/9
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|52R|45E|47G|3F?|0D                              AT+CREG?.       
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 1 "AT+CREG?"
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 2 "+CREG: 2,1,"001F","0219038",2"
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 3 "OK"
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Checking line: OK
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: AT reply state: 1
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: RECEIVED frame type 0x00/length 0x30/48
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|52R|45E|47G|3F?|0D |0D |0A |2B+|43C|52R|45E|47G AT+CREG?...+CREG
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 3A:|20 |322|2C,|311|2C,|22"|300|300|311|46F|22"|2C,|22"|300|322 : 2,1,"001F","02
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 311|399|300|333|388|22"|2C,|322|0D |0A |0D |0A |4FO|4BK|0D |0A  19038",2....OK..
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Network LAC & CID & state received
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Parsing +CREG: 2,1,"001F","0219038",2 with +CREG: @i, @i, @r, @r, @i
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Parsed int 2
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Parsed int 1
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Grabbed string from reply: "001F" (parsed 6 bytes)
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Parsed raw string "001F"
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Grabbed string from reply: "0219038" (parsed 9 bytes)
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Parsed raw string "0219038"
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Parsed int 2
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Home network
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Getting packet network LAC and CID and state
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: SENDING frame type 0x00/length 0x0A/10
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|47G|52R|45E|47G|3F?|0D                          AT+CGREG?.      
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 1 "AT+CGREG?"
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 2 "+CGREG: 2,1,"001F","0219038",2,"1F""
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 3 "OK"
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Checking line: OK
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: AT reply state: 1
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: RECEIVED frame type 0x00/length 0x37/55
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|47G|52R|45E|47G|3F?|0D |0D |0A |2B+|43C|47G|52R AT+CGREG?...+CGR
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 45E|47G|3A:|20 |322|2C,|311|2C,|22"|300|300|311|46F|22"|2C,|22" EG: 2,1,"001F","
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 300|322|311|399|300|333|388|22"|2C,|322|2C,|22"|311|46F|22"|0D  0219038",2,"1F".
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 0A |0D |0A |4FO|4BK|0D |0A                                      ...OK..         
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Network LAC & CID & state received
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Parsing +CGREG: 2,1,"001F","0219038",2,"1F" with +CGREG: @i, @i, @r, @r, @i, @r
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Parsed int 2
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Parsed int 1
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Grabbed string from reply: "001F" (parsed 6 bytes)
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Parsed raw string "001F"
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Grabbed string from reply: "0219038" (parsed 9 bytes)
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Parsed raw string "0219038"
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Parsed int 2
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Grabbed string from reply: "1F" (parsed 4 bytes)
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Parsed raw string "1F"
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Home network
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Setting short network name format
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: SENDING frame type 0x00/length 0x0C/12
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|4FO|50P|53S|3D=|333|2C,|322|0D                  AT+COPS=3,2.    
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 1 "AT+COPS=3,2"
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 2 "OK"
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Checking line: OK
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: AT reply state: 1
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: RECEIVED frame type 0x00/length 0x12/18
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|4FO|50P|53S|3D=|333|2C,|322|0D |0D |0A |4FO|4BK AT+COPS=3,2...OK
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 0D |0A                                                          ..              
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Getting network code
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: SENDING frame type 0x00/length 0x09/9
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|4FO|50P|53S|3F?|0D                              AT+COPS?.       
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 1 "AT+COPS?"
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 2 "+COPS: 0,2,"26006",2"
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 3 "OK"
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Checking line: OK
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: AT reply state: 1
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: RECEIVED frame type 0x00/length 0x27/39
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|4FO|50P|53S|3F?|0D |0D |0A |2B+|43C|4FO|50P|53S AT+COPS?...+COPS
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 3A:|20 |300|2C,|322|2C,|22"|322|366|300|300|366|22"|2C,|322|0D  : 0,2,"26006",2.
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 0A |0D |0A |4FO|4BK|0D |0A                                      ...OK..         
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Network code received
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Parsing +COPS: 0,2,"26006",2 with +COPS: @i, @i, @r
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Parsed int 0
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Parsed int 2
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Grabbed string from reply: "26006" (parsed 7 bytes)
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Parsed raw string "26006"
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: String do not end same!
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Parsing +COPS: 0,2,"26006",2 with +COPS: @i, @i, @r, @i
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Parsed int 0
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Parsed int 2
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Grabbed string from reply: "26006" (parsed 7 bytes)
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Parsed raw string "26006"
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Parsed int 2
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu:    Network code              : 260 06
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu:    Network name for Gammu    : Play (Poland)
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Setting long string network name format
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: SENDING frame type 0x00/length 0x0C/12
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|4FO|50P|53S|3D=|333|2C,|300|0D                  AT+COPS=3,0.    
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 1 "AT+COPS=3,0"
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 2 "OK"
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Checking line: OK
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: AT reply state: 1
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: RECEIVED frame type 0x00/length 0x12/18
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|4FO|50P|53S|3D=|333|2C,|300|0D |0D |0A |4FO|4BK AT+COPS=3,0...OK
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 0D |0A                                                          ..              
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Getting network code
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: SENDING frame type 0x00/length 0x09/9
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|4FO|50P|53S|3F?|0D                              AT+COPS?.       
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 1 "AT+COPS?"
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 2 "+COPS: 0,0,"PLAY",2"
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 3 "OK"
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Checking line: OK
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: AT reply state: 1
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: RECEIVED frame type 0x00/length 0x26/38
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|4FO|50P|53S|3F?|0D |0D |0A |2B+|43C|4FO|50P|53S AT+COPS?...+COPS
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 3A:|20 |300|2C,|300|2C,|22"|50P|4CL|41A|59Y|22"|2C,|322|0D |0A  : 0,0,"PLAY",2..
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 0D |0A |4FO|4BK|0D |0A                                          ..OK..          
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Network name received
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Parsing +COPS: 0,0,"PLAY",2 with +COPS: @i, @i, @s
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Parsed int 0
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Parsed int 0
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Grabbed string from reply: "PLAY" (parsed 6 bytes)
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Parsed generic string "PLAY"
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Generic string decoded as "PLAY"
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: String do not end same!
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Parsing +COPS: 0,0,"PLAY",2 with +COPS: @i, @i, @s, @i
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Parsed int 0
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Parsed int 0
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Grabbed string from reply: "PLAY" (parsed 6 bytes)
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Parsed generic string "PLAY"
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Generic string decoded as "PLAY"
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Parsed int 2
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Leaving GSM_GetNetworkInfo
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Entering GSM_SendSMS
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: SMS Submit
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Recipient number "123456"
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: SMSC number "+48790998250"
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: SMS class -1
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: SMS validity ff
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: TPMR: 00 0
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 7 bit SMS, length 8, 9
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: test-bad2
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Waiting for modem prompt
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: SENDING frame type 0x00/length 0x0B/11
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|4DM|47G|53S|3D=|311|399|0D                      AT+CMGS=19.     
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 1 "AT+CMGS=19"
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 2 "> "
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Checking line: > 
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: AT reply state: 7
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: RECEIVED frame type 0x00/length 0x0F/15
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|4DM|47G|53S|3D=|311|399|0D |0D |0A |3E>|20      AT+CMGS=19...>  
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Sending SMS
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: SENDING frame type 0x00/length 0x36/54
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 300|377|399|311|388|344|399|377|399|300|388|399|355|322|46F|300 07918497908952F0
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 333|311|300|300|300|366|388|311|322|311|344|333|366|355|300|300 3100068121436500
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 300|300|46F|46F|300|399|46F|344|46F|322|399|43C|44D|45E|311|322 00FF09F4F29CDE12
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 388|377|43C|399|333|322                                         87C932          
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: SENDING frame type 0x00/length 0x01/1
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: 1A                                                              .               
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: gammu: Leaving GSM_SendSMS
Thu 2018/01/11 15:10:29 gammu-smsd[30351]: Execute SQL: UPDATE outbox SET "SendingTimeOut" = now() + interval '60 seconds' WHERE "ID" = '1298' AND ("SendingTimeOut" < now() OR "SendingTimeOut" IS NULL)
Thu 2018/01/11 15:10:31 gammu-smsd[30351]: Execute SQL: UPDATE outbox SET "SendingTimeOut" = now() + interval '60 seconds' WHERE "ID" = '1298' AND ("SendingTimeOut" < now() OR "SendingTimeOut" IS NULL)
Thu 2018/01/11 15:10:32 gammu-smsd[30351]: gammu: 1 "AT+CMGS=19"
Thu 2018/01/11 15:10:32 gammu-smsd[30351]: gammu: 2 "> 07918497908952F0310006812143650000FF09F4F29CDE1287C932�"
Thu 2018/01/11 15:10:32 gammu-smsd[30351]: gammu: 3 "+CMS ERROR: 38"
Thu 2018/01/11 15:10:32 gammu-smsd[30351]: gammu: Checking line: +CMS ERROR: 38
Thu 2018/01/11 15:10:32 gammu-smsd[30351]: gammu: AT reply state: 5
Thu 2018/01/11 15:10:32 gammu-smsd[30351]: gammu: RECEIVED frame type 0x00/length 0x58/88
Thu 2018/01/11 15:10:32 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|4DM|47G|53S|3D=|311|399|0D |0D |0A |3E>|20 |300 AT+CMGS=19...> 0
Thu 2018/01/11 15:10:32 gammu-smsd[30351]: gammu: 377|399|311|388|344|399|377|399|300|388|399|355|322|46F|300|333 7918497908952F03
Thu 2018/01/11 15:10:32 gammu-smsd[30351]: gammu: 311|300|300|300|366|388|311|322|311|344|333|366|355|300|300|300 1000681214365000
Thu 2018/01/11 15:10:32 gammu-smsd[30351]: gammu: 300|46F|46F|300|399|46F|344|46F|322|399|43C|44D|45E|311|322|388 0FF09F4F29CDE128
Thu 2018/01/11 15:10:32 gammu-smsd[30351]: gammu: 377|43C|399|333|322|1A |0D |0A |2B+|43C|4DM|53S|20 |45E|52R|52R 7C932...+CMS ERR
Thu 2018/01/11 15:10:32 gammu-smsd[30351]: gammu: 4FO|52R|3A:|20 |333|388|0D |0A                                  OR: 38..        
Thu 2018/01/11 15:10:32 gammu-smsd[30351]: gammu: Error 38
Thu 2018/01/11 15:10:32 gammu-smsd[30351]: SMS sent on device: "/dev/ttyACM0" status=38, reference=-1
Thu 2018/01/11 15:10:32 gammu-smsd[30351]: gammu: CMS Error 38: "Network out of order"
Thu 2018/01/11 15:10:32 gammu-smsd[30351]: Error getting send status of message: Unknown error. (UNKNOWN[27])
Thu 2018/01/11 15:10:32 gammu-smsd[30351]: Execute SQL: UPDATE outbox SET "SendingTimeOut" = now() + interval '30 seconds', "Retries" = 1 WHERE "ID" = '1298';
Thu 2018/01/11 15:10:32 gammu-smsd[30351]: Execute SQL: UPDATE outbox SET "StatusCode"=38 WHERE "ID"='1298'
Thu 2018/01/11 15:11:32 gammu-smsd[30351]: gammu: Entering GSM_GetSecurityStatus
Thu 2018/01/11 15:11:32 gammu-smsd[30351]: gammu: Getting security code status
Thu 2018/01/11 15:11:32 gammu-smsd[30351]: gammu: SENDING frame type 0x00/length 0x09/9
Thu 2018/01/11 15:11:32 gammu-smsd[30351]: gammu: 41A|54T|2B+|43C|50P|49I|4EN|3F?|0D                              AT+CPIN?.       
Thu 2018/01/11 15:11:33 gammu-smsd[30351]: gammu: 1 "AT+CPIN?"
Thu 2018/01/11 15:11:33 gammu-smsd[30351]: gammu: 2 "+CPIN: READY"
Thu 2018/01/11 15:11:33 gammu-smsd[30351]: gammu: 3 "OK"

@nijel

This comment has been minimized.

Show comment
Hide comment
@nijel

nijel Jan 31, 2018

Member

What is your setting for LoopSleep?

Member

nijel commented Jan 31, 2018

What is your setting for LoopSleep?

@melones

This comment has been minimized.

Show comment
Hide comment
@melones

melones Jan 31, 2018

I don't have it set in my config. So it takes default value.
When smsd sends a message to a working phone number there is no such a 1 min pause. After sending it simply takes another message from the queue.

melones commented Jan 31, 2018

I don't have it set in my config. So it takes default value.
When smsd sends a message to a working phone number there is no such a 1 min pause. After sending it simply takes another message from the queue.

@nijel

This comment has been minimized.

Show comment
Hide comment
@nijel

nijel Jan 31, 2018

Member

Any chance you could run Gammu compiled with debug info and obtain backtrace using gdb when it is sleeping like this?

Member

nijel commented Jan 31, 2018

Any chance you could run Gammu compiled with debug info and obtain backtrace using gdb when it is sleeping like this?

@melones

This comment has been minimized.

Show comment
Hide comment
@melones

melones Jan 31, 2018

we will try :)

melones commented Jan 31, 2018

we will try :)

@yarmooh

This comment has been minimized.

Show comment
Hide comment
@yarmooh

yarmooh Jan 31, 2018

Hello Michal,
After I attach to the process with gdb, what should I do next?
I'm really not familiar with gdb debugging.

yarmooh commented Jan 31, 2018

Hello Michal,
After I attach to the process with gdb, what should I do next?
I'm really not familiar with gdb debugging.

@nijel

This comment has been minimized.

Show comment
Hide comment
@nijel

nijel Jan 31, 2018

Member

If it's already in desired state, backtrace should be good enough.

Member

nijel commented Jan 31, 2018

If it's already in desired state, backtrace should be good enough.

@yarmooh

This comment has been minimized.

Show comment
Hide comment
@yarmooh

yarmooh Feb 1, 2018

I believe this is that:

(gdb) backtrace
#0  0x76dbb338 in nanosleep () at ../sysdeps/unix/syscall-template.S:81
#1  0x76de71e0 in usleep (useconds=useconds@entry=500000) at ../sysdeps/unix/sysv/linux/usleep.c:32
#2  0x76f84bcc in SMSD_InterruptibleSleep (Config=Config@entry=0x39fc0, seconds=seconds@entry=60) at /mnt/nand-user/temp/source/gammu-1.39.0/smsd/core.c:119
#3  0x76f88960 in SMSD_SendSMS (Config=Config@entry=0x39fc0) at /mnt/nand-user/temp/source/gammu-1.39.0/smsd/core.c:1838
#4  0x76f89298 in SMSD_MainLoop (Config=0x39fc0, exit_on_failure=exit_on_failure@entry=0, max_failures=0) at /mnt/nand-user/temp/source/gammu-1.39.0/smsd/core.c:2195
#5  0x00011fa0 in main (argc=<optimized out>, argv=<optimized out>) at /mnt/nand-user/temp/source/gammu-1.39.0/smsd/main.c:517

yarmooh commented Feb 1, 2018

I believe this is that:

(gdb) backtrace
#0  0x76dbb338 in nanosleep () at ../sysdeps/unix/syscall-template.S:81
#1  0x76de71e0 in usleep (useconds=useconds@entry=500000) at ../sysdeps/unix/sysv/linux/usleep.c:32
#2  0x76f84bcc in SMSD_InterruptibleSleep (Config=Config@entry=0x39fc0, seconds=seconds@entry=60) at /mnt/nand-user/temp/source/gammu-1.39.0/smsd/core.c:119
#3  0x76f88960 in SMSD_SendSMS (Config=Config@entry=0x39fc0) at /mnt/nand-user/temp/source/gammu-1.39.0/smsd/core.c:1838
#4  0x76f89298 in SMSD_MainLoop (Config=0x39fc0, exit_on_failure=exit_on_failure@entry=0, max_failures=0) at /mnt/nand-user/temp/source/gammu-1.39.0/smsd/core.c:2195
#5  0x00011fa0 in main (argc=<optimized out>, argv=<optimized out>) at /mnt/nand-user/temp/source/gammu-1.39.0/smsd/main.c:517
@yarmooh

This comment has been minimized.

Show comment
Hide comment
@yarmooh

yarmooh Feb 12, 2018

@nijel any update? or should I try something else with gdb?

yarmooh commented Feb 12, 2018

@nijel any update? or should I try something else with gdb?

@nijel nijel closed this in 06d45bb Feb 21, 2018

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment