SMS inbound/outbound not workig with Telnyx

Module sender ID should be a phone number, something in the API doc that matched with from variable:

anton

OK, great thanks for the quick reply!

I changed it to the phone number, but here is the log and I’m not seeing the Telnyx hook calls: (I replaced the To number with xxxyyyzzzz)

192.168.x.x sms.example.com 2020-05-19 21:27:30 PID5ec44f4210a24 admin L2 sendsms # start uid:1 sender_id:[1xxxxxxx452] smsc:[]
192.168.x.x sms.example.com 2020-05-19 21:27:30 PID5ec44f4210a24 admin L3 sendsms # maxlen:459 footerlen:7 footer:[ @admin] msglen:51 message:[Hi sweetheart, good night and have a sweet dream :*]
192.168.x.x sms.example.com 2020-05-19 21:27:30 PID5ec44f4210a24 admin L2 sendsms_queue_create # saving queue_code:ef11b8d24ab847028bd9294968f8f221 src:1xxxxxxx452 scheduled:2020-05-19 21:27:30
192.168.x.x sms.example.com 2020-05-19 21:27:30 PID5ec44f4210a24 admin L2 sendsms_queue_create # saved queue_code:ef11b8d24ab847028bd9294968f8f221 id:17
192.168.x.x sms.example.com 2020-05-19 21:27:30 PID5ec44f4210a24 admin L3 sendsms_manipulate_prefix # before prefix manipulation:[1xxxyyyzzzz]
192.168.x.x sms.example.com 2020-05-19 21:27:30 PID5ec44f4210a24 admin L3 sendsms_manipulate_prefix # after prefix manipulation:[+1xxxyyyzzzz]
192.168.x.x sms.example.com 2020-05-19 21:27:30 PID5ec44f4210a24 admin L3 simplerate_hook_rate_getbyprefix # rate not found to:+1xxxyyyzzzz default_rate:0
192.168.x.x sms.example.com 2020-05-19 21:27:30 PID5ec44f4210a24 admin L3 simplerate_hook_rate_getcharges # uid:1 u:admin len:58 unicode:0 to:+1xxxyyyzzzz enable_credit_unicode:0 count:1 rate: charge:0
192.168.x.x sms.example.com 2020-05-19 21:27:30 PID5ec44f4210a24 admin L2 sendsms # dst_count:1 sms_count:1 total_charges:0
192.168.x.x sms.example.com 2020-05-19 21:27:30 PID5ec44f4210a24 admin L2 sendsms_queue_push # saving queue_code:ef11b8d24ab847028bd9294968f8f221 dst:+1xxxyyyzzzz
192.168.x.x sms.example.com 2020-05-19 21:27:30 PID5ec44f4210a24 admin L2 sendsms_queue_push # saved queue_code:ef11b8d24ab847028bd9294968f8f221 smslog_id:17
192.168.x.x sms.example.com 2020-05-19 21:27:30 PID5ec44f4210a24 admin L2 sendsms # end queue_code:ef11b8d24ab847028bd9294968f8f221 queue_count:1 sms_count:1 failed_queue:0 failed_sms:0

See Settings->Route outgoing SMS make sure 1xxx (to your destination) use your Telnyx-based SMSC.

And, since you have a working Twilio you said, you can try comparing the log between them. sendsmsd must be included when sending with the working SMSC. If not but SMS sent then maybe your webserver cannot write to log file playsms.log, for this set file ownership to webserver’s users, just the log file.

anton

So on this log entry:

192.168.x.x sms.example.com 2020-05-19 21:42:17 PID5ec452b918c90 admin L2 sendsms # start uid:1 sender_id:[1xxxxxxx452] smsc:[]

smsc:[] -should contain a value, correct?

You can, but dont have to, playSMS daemon (the sendsmsd part in log) will try to look for it, will use default etc

Anton

I do see that. In the previous Twilio log of a successful send, it did not have the smsc either.

However, when I compare a successful Twilio send log and a failed Telnyx send log, they seem pretty identical as far as the playSMS calls made. No errors are obvious. When I check the Telnyx log, they do not show receiving the send request. So, I’m still doing something wrong…

In your pasted log they dont have sendsmsd. If you sent via Twilio did you see it? If not, try setting the log file permission to 666 so that regular user running playsmsd have access to write on it too, the we can sde what happen

Anton

Here is the successful Twilio Send log
192.168.0.38 sms.example.com 2020-05-19 19:50:33 PID5ec438894aa0c admin L2 sendsms # start uid:1 sender_id:[1234] smsc:[]
192.168.0.38 sms.example.com 2020-05-19 19:50:33 PID5ec438894aa0c admin L3 sendsms # maxlen:459 footerlen:7 footer:[ @admin] msglen:16 message:[Test from DV SMS]
192.168.0.38 sms.example.com 2020-05-19 19:50:33 PID5ec438894aa0c admin L2 sendsms_queue_create # saving queue_code:25b0b6c68a7478334354f4c6e3332f17 src:1234 scheduled:2020-05-19 19:50:33
192.168.0.38 sms.example.com 2020-05-19 19:50:33 PID5ec438894aa0c admin L2 sendsms_queue_create # saved queue_code:25b0b6c68a7478334354f4c6e3332f17 id:6
192.168.0.38 sms.example.com 2020-05-19 19:50:33 PID5ec438894aa0c admin L3 sendsms_manipulate_prefix # before prefix manipulation:[1xxxyyyzzzz]
192.168.0.38 sms.example.com 2020-05-19 19:50:33 PID5ec438894aa0c admin L3 sendsms_manipulate_prefix # after prefix manipulation:[+1xxxyyyzzzz]
192.168.0.38 sms.example.com 2020-05-19 19:50:33 PID5ec438894aa0c admin L3 simplerate_hook_rate_getbyprefix # rate not found to:+1xxxyyyzzzz default_rate:0
192.168.0.38 sms.example.com 2020-05-19 19:50:33 PID5ec438894aa0c admin L3 simplerate_hook_rate_getcharges # uid:1 u:admin len:23 unicode:0 to:+1xxxyyyzzzz enable_credit_unicode:0 count:1 rate: charge:0
192.168.0.38 sms.example.com 2020-05-19 19:50:33 PID5ec438894aa0c admin L2 sendsms # dst_count:1 sms_count:1 total_charges:0
192.168.0.38 sms.example.com 2020-05-19 19:50:33 PID5ec438894aa0c admin L2 sendsms_queue_push # saving queue_code:25b0b6c68a7478334354f4c6e3332f17 dst:+1xxxyyyzzzz
192.168.0.38 sms.example.com 2020-05-19 19:50:33 PID5ec438894aa0c admin L2 sendsms_queue_push # saved queue_code:25b0b6c68a7478334354f4c6e3332f17 smslog_id:6
192.168.0.38 sms.example.com 2020-05-19 19:50:33 PID5ec438894aa0c admin L2 sendsms # end queue_code:25b0b6c68a7478334354f4c6e3332f17 queue_count:1 sms_count:1 failed_queue:0 failed_sms:0

Here is the failed Telnyx send log
192.168.0.38 sms.example.com 2020-05-19 21:46:25 PID5ec453b1201c2 admin L2 sendsms # start uid:1 sender_id:[19722934452] smsc:[]
192.168.0.38 sms.example.com 2020-05-19 21:46:25 PID5ec453b1201c2 admin L3 sendsms # maxlen:459 footerlen:7 footer:[ @admin] msglen:26 message:[Hi u there, good morning!!]
192.168.0.38 sms.example.com 2020-05-19 21:46:25 PID5ec453b1201c2 admin L2 sendsms_queue_create # saving queue_code:c033c597cd3275d72ffabd558c724dd3 src:19722934452 scheduled:2020-05-19 21:46:25
192.168.0.38 sms.example.com 2020-05-19 21:46:25 PID5ec453b1201c2 admin L2 sendsms_queue_create # saved queue_code:c033c597cd3275d72ffabd558c724dd3 id:19
192.168.0.38 sms.example.com 2020-05-19 21:46:25 PID5ec453b1201c2 admin L3 sendsms_manipulate_prefix # before prefix manipulation:[14692334105]
192.168.0.38 sms.example.com 2020-05-19 21:46:25 PID5ec453b1201c2 admin L3 sendsms_manipulate_prefix # after prefix manipulation:[+1xxxyyyzzzz]
192.168.0.38 sms.example.com 2020-05-19 21:46:25 PID5ec453b1201c2 admin L3 simplerate_hook_rate_getbyprefix # rate not found to:+1xxxyyyzzzz default_rate:0
192.168.0.38 sms.example.com 2020-05-19 21:46:25 PID5ec453b1201c2 admin L3 simplerate_hook_rate_getcharges # uid:1 u:admin len:33 unicode:0 to:+1xxxyyyzzzz enable_credit_unicode:0 count:1 rate: charge:0
192.168.0.38 sms.example.com 2020-05-19 21:46:25 PID5ec453b1201c2 admin L2 sendsms # dst_count:1 sms_count:1 total_charges:0
192.168.0.38 sms.example.com 2020-05-19 21:46:25 PID5ec453b1201c2 admin L2 sendsms_queue_push # saving queue_code:c033c597cd3275d72ffabd558c724dd3 dst:+1xxxyyyzzzz
192.168.0.38 sms.example.com 2020-05-19 21:46:25 PID5ec453b1201c2 admin L2 sendsms_queue_push # saved queue_code:c033c597cd3275d72ffabd558c724dd3 smslog_id:19
192.168.0.38 sms.example.com 2020-05-19 21:46:25 PID5ec453b1201c2 admin L2 sendsms # end queue_code:c033c597cd3275d72ffabd558c724dd3 queue_count:1 sms_count:1 failed_queue:0 failed_sms:0

I dont see sendsmsd log in both of them, looks like your playsmsd dont have write access to playsms.log

chmod 666 playsms.log and then restart playsmsd, then re-test

Anton

OK, will do. Thanks!

Hi again,

Now I’m getting this error:

- - 2020-05-20 21:57:28 PID5ec5a7c874742 - L2 sendsms # saving smslog_id:25 u:1 parent_uid:0 g:0 gw:telnyx smsc:telnyx1 s:+19722934452 d:+1xxxyyyzzzz type:text unicode:0 status:0
- - 2020-05-20 21:57:28 PID5ec5a7c874742 - L2 sendsms_process # saved smslog_id:25 id:25
- - 2020-05-20 21:57:28 PID5ec5a7c874742 - L3 sendsms # final smslog_id:25 gw:telnyx smsc:telnyx1 message:Hello , please hurry up, boss summons us ! @admin len:49
- - 2020-05-20 21:57:28 PID5ec5a7c874742 - L3 telnyx_hook_sendsms # enter smsc:telnyx1 smslog_id:25 uid:1 to:+1xxxyyyzzzz
- - 2020-05-20 21:57:28 PID5ec5a7c874742 - L2 3 # sendsms url:[https://sms.telnyx.com/messages] callback:[https://sms.example.com//plugin/gateway/telnyx/callback.php
- - 2020-05-20 21:57:28 PID5ec5a7c874742 - L2 telnyx_hook_sendsms # failed smslog_id:25 message_id: error_code:400error_messageThe 'from' address should be string containing a valid phone number associated with the sending messaging profile or a valid alphanumeric sender ID smsc:telnyx1
- - 2020-05-20 21:57:28 PID5ec5a7c874742 - L3 dlr # isdlrd:1 smslog_id:25 p_status:2 uid:1
- - 2020-05-20 21:57:28 PID5ec5a7c874742 - L3 telnyx_hook_sendsms # sendsms end
- - 2020-05-20 21:57:28 PID5ec5a7c874742 - L2 sendsms_process # fail no hook for sendsms
- - 2020-05-20 21:57:28 PID5ec5a7c874742 - L2 sendsms_process # end

I fixed it! In the SMSC for Telnyx, it required the Module sender ID to be +1xxxxxxxxxx. It was missing the +

Can you also share your test on incoming SMS ? Thanks

Anton

I’m still new to reading this log, but I believe the excerpts below are the correct segments. If this doesn’t look right, let me know and I will look again.

Here is a log of the failure after enabling data [" . $data_string ."]

- - 2020-05-20 22:27:34 PID5ec5aed641c61 - L2 sendsmsd # start processing queue_code:427393e2ae035040796e8c52af1a605f chunk:0 queue_count:1 sms_count:1 scheduled:2020-05-20 22:27:34 uid:1 gpid:0 sender_id:+1xxxyyyzzzz
- - 2020-05-20 22:27:34 PID5ec5aed641c61 - L2 sendsmsd # sending queue_code:427393e2ae035040796e8c52af1a605f smslog_id:28 to:+1xxxyyyzzzz sms_count:1 counter:1
- - 2020-05-20 22:27:34 PID5ec5aed641c61 - L3 sendsms_intercept # msgtemplate modified sms_sender:[+1xxxyyyzzzz] sms_footer:[@admin] sms_to:[+1xxxyyyzzzz] sms_msg:[Hello , please hurry up, boss summons us !] uid:[1] gpid:[0] sms_type:[text] unicode:[0] queue_code:[427393e2ae035040796e8c52af1a605f] smsc:[]
- - 2020-05-20 22:27:34 PID5ec5aed641c61 - L3 outgoing_hook_sendsms_intercept # found SMSCs:[telnyx1]
- - 2020-05-20 22:27:34 PID5ec5aed641c61 - L3 outgoing_hook_sendsms_intercept # using prefix based smsc smsc:[telnyx1] uid:1 parent_uid:0 from:+1xxxyyyzzzz to:+1xxxyyyzzzz
- - 2020-05-20 22:27:34 PID5ec5aed641c61 - L3 sendsms_intercept # outgoing modified sms_sender:[+1xxxyyyzzzz] sms_footer:[@admin] sms_to:[+1xxxyyyzzzz] sms_msg:[Hello , please hurry up, boss summons us !] uid:[1] gpid:[0] sms_type:[text] unicode:[0] queue_code:[427393e2ae035040796e8c52af1a605f] smsc:[telnyx1]
- - 2020-05-20 22:27:34 PID5ec5aed641c61 - L2 sendsms_process # start
- - 2020-05-20 22:27:34 PID5ec5aed641c61 - L3 simplerate_hook_rate_getbyprefix # rate not found to:+1xxxyyyzzzz default_rate:0
- - 2020-05-20 22:27:34 PID5ec5aed641c61 - L3 simplerate_hook_rate_getcharges # uid:1 u:admin len:49 unicode:0 to:+1xxxyyyzzzz enable_credit_unicode:0 count:1 rate: charge:0
- - 2020-05-20 22:27:34 PID5ec5aed641c61 - L2 simplerate_hook_rate_cansend # allowed user uid:1 sms_to:+1xxxyyyzzzz adhoc_credit:0 count:1 rate: charge:0 adhoc_balance:0
- - 2020-05-20 22:27:34 PID5ec5aed641c61 - L2 sendsms # saving smslog_id:28 u:1 parent_uid:0 g:0 gw:telnyx smsc:telnyx1 s:+1xxxyyyzzzz d:+1xxxyyyzzzz type:text unicode:0 status:0
- - 2020-05-20 22:27:34 PID5ec5aed641c61 - L2 sendsms_process # saved smslog_id:28 id:28
- - 2020-05-20 22:27:34 PID5ec5aed641c61 - L3 sendsms # final smslog_id:28 gw:telnyx smsc:telnyx1 message:Hello , please hurry up, boss summons us ! @admin len:49
- - 2020-05-20 22:27:34 PID5ec5aed641c61 - L3 telnyx_hook_sendsms # enter smsc:telnyx1 smslog_id:28 uid:1 to:+1xxxyyyzzzz
- - 2020-05-20 22:27:34 PID5ec5aed641c61 - L2 3 # sendsms url:[https://sms.telnyx.com/messages] data:[{"to":"+1xxxyyyzzzz","from":"1xxxyyyzzzz","body":"Hello , please hurry up, boss summons us ! @admin","delivery_status_webhook_url":"https://sms.example.com//plugin/gateway/telnyx/callback.php"}] callback:[https://sms.example.com//plugin/gateway/telnyx/callback.php
- - 2020-05-20 22:27:34 PID5ec5aed641c61 - L2 telnyx_hook_sendsms # failed smslog_id:28 message_id: error_code:400error_messageThe 'from' address should be string containing a valid phone number associated with the sending messaging profile or a valid alphanumeric sender ID smsc:telnyx1
- - 2020-05-20 22:27:34 PID5ec5aed641c61 - L3 dlr # isdlrd:1 smslog_id:28 p_status:2 uid:1
- - 2020-05-20 22:27:34 PID5ec5aed641c61 - L3 telnyx_hook_sendsms # sendsms end
- - 2020-05-20 22:27:34 PID5ec5aed641c61 - L2 sendsms_process # fail no hook for sendsms
- - 2020-05-20 22:27:34 PID5ec5aed641c61 - L2 sendsms_process # end
- - 2020-05-20 22:27:34 PID5ec5aed641c61 - L2 sendsmsd # result queue_code:427393e2ae035040796e8c52af1a605f to:+1xxxyyyzzzz flag:2 smslog_id:28
- - 2020-05-20 22:27:34 PID5ec5aed641c61 - L2 sendsmsd # finish processing queue_code:427393e2ae035040796e8c52af1a605f uid:1 sender_id:+1xxxyyyzzzz queue_count:1 sms_count:1
- - 2020-05-20 22:27:35 PID5ec4667241646 - L3 dlrd # id:28 smslog_id:28 p_status:2 uid:1

Here is the log after making the change to the SMSC (adding +)

- - 2020-05-20 22:28:46 PID5ec5af1e83856 - L2 sendsmsd # start processing queue_code:d36d20dd29f5f826eda5161049ce9b53 chunk:0 queue_count:1 sms_count:1 scheduled:2020-05-20 22:28:45 uid:1 gpid:0 sender_id:+1xxxyyyzzzz
- - 2020-05-20 22:28:46 PID5ec5af1e83856 - L2 sendsmsd # sending queue_code:d36d20dd29f5f826eda5161049ce9b53 smslog_id:29 to:+1xxxyyyzzzz sms_count:1 counter:1
- - 2020-05-20 22:28:46 PID5ec5af1e83856 - L3 sendsms_intercept # msgtemplate modified sms_sender:[+1xxxyyyzzzz] sms_footer:[@admin] sms_to:[+1xxxyyyzzzz] sms_msg:[Hi sweetheart, good night and have a sweet dream :*] uid:[1] gpid:[0] sms_type:[text] unicode:[0] queue_code:[d36d20dd29f5f826eda5161049ce9b53] smsc:[]
- - 2020-05-20 22:28:46 PID5ec5af1e83856 - L3 outgoing_hook_sendsms_intercept # found SMSCs:[telnyx1]
- - 2020-05-20 22:28:46 PID5ec5af1e83856 - L3 outgoing_hook_sendsms_intercept # using prefix based smsc smsc:[telnyx1] uid:1 parent_uid:0 from:+1xxxyyyzzzz to:+1xxxyyyzzzz
- - 2020-05-20 22:28:46 PID5ec5af1e83856 - L3 sendsms_intercept # outgoing modified sms_sender:[+1xxxyyyzzzz] sms_footer:[@admin] sms_to:[+1xxxyyyzzzz] sms_msg:[Hi sweetheart, good night and have a sweet dream :*] uid:[1] gpid:[0] sms_type:[text] unicode:[0] queue_code:[d36d20dd29f5f826eda5161049ce9b53] smsc:[telnyx1]
- - 2020-05-20 22:28:46 PID5ec5af1e83856 - L2 sendsms_process # start
- - 2020-05-20 22:28:46 PID5ec5af1e83856 - L3 simplerate_hook_rate_getbyprefix # rate not found to:+1xxxyyyzzzz default_rate:0
- - 2020-05-20 22:28:46 PID5ec5af1e83856 - L3 simplerate_hook_rate_getcharges # uid:1 u:admin len:58 unicode:0 to:+1xxxyyyzzzz enable_credit_unicode:0 count:1 rate: charge:0
- - 2020-05-20 22:28:46 PID5ec5af1e83856 - L2 simplerate_hook_rate_cansend # allowed user uid:1 sms_to:+1xxxyyyzzzz adhoc_credit:0 count:1 rate: charge:0 adhoc_balance:0
- - 2020-05-20 22:28:46 PID5ec5af1e83856 - L2 sendsms # saving smslog_id:29 u:1 parent_uid:0 g:0 gw:telnyx smsc:telnyx1 s:+1xxxyyyzzzz d:+1xxxyyyzzzz type:text unicode:0 status:0
- - 2020-05-20 22:28:46 PID5ec5af1e83856 - L2 sendsms_process # saved smslog_id:29 id:29
- - 2020-05-20 22:28:46 PID5ec5af1e83856 - L3 sendsms # final smslog_id:29 gw:telnyx smsc:telnyx1 message:Hi sweetheart, good night and have a sweet dream :* @admin len:58
- - 2020-05-20 22:28:46 PID5ec5af1e83856 - L3 telnyx_hook_sendsms # enter smsc:telnyx1 smslog_id:29 uid:1 to:+1xxxyyyzzzz
- - 2020-05-20 22:28:47 PID5ec5af1e83856 - L2 3 # sendsms url:[https://sms.telnyx.com/messages] data:[{"to":"+1xxxyyyzzzz","from":"+1xxxyyyzzzz","body":"Hi sweetheart, good night and have a sweet dream :* @admin","delivery_status_webhook_url":"https://sms.example.com//plugin/gateway/telnyx/callback.php"}] callback:[https://sms.example.com//plugin/gateway/telnyx/callback.php
- - 2020-05-20 22:28:47 PID5ec5af1e83856 - L2 telnyx_hook_sendsms # sent smslog_id:29 message_id:40317234-3410-4e63-8068-b74ca3a20b86 smsc:telnyx1
- - 2020-05-20 22:28:47 PID5ec5af1e83856 - L3 dlr # isdlrd:1 smslog_id:29 p_status:2 uid:1
- - 2020-05-20 22:28:47 PID5ec5af1e83856 - L3 dlr # isdlrd:1 smslog_id:29 p_status:2 uid:1
- - 2020-05-20 22:28:47 PID5ec5af1e83856 - L3 telnyx_hook_sendsms # sendsms end
- - 2020-05-20 22:28:47 PID5ec5af1e83856 - L2 sendsms_process # fail no hook for sendsms
- - 2020-05-20 22:28:47 PID5ec5af1e83856 - L2 sendsms_process # end
- - 2020-05-20 22:28:47 PID5ec5af1e83856 - L2 sendsmsd # result queue_code:d36d20dd29f5f826eda5161049ce9b53 to:+1xxxyyyzzzz flag:2 smslog_id:29
- - 2020-05-20 22:28:47 PID5ec5af1e83856 - L2 sendsmsd # finish processing queue_code:d36d20dd29f5f826eda5161049ce9b53 uid:1 sender_id:+1xxxyyyzzzz queue_count:1 sms_count:1
192.76.120.192 sms.example.com 2020-05-20 22:28:47 PID5ec5af1f3e27c - L2 telnyx__callback # pushed sms_id:xxxxxxxx-3410-4e63-8068-b74ca3a20b86 sms_gw_id:xxxxxxxx-3410-4e63-8068-b74ca3a20b86 user_id:xxxxxxx-fa1b-4f68-a6e3-3b367f002d01 profile_id:xxxxxxxx-f86c-4f5e-bfd9-33e655dd5f48 status:sent delivery_status: date_created:2020-05-20T22:28:46.983000 date_updated:2020-05-20T22:28:47.064000 created:1590013726983 updated:1590013727064 body:Array from:+1xxxyyyzzzz to:+1xxxyyyzzzz direction:outbound on_net: cost: currency: type:SMS errors:Array carrier:T-MOBILE USA, INC. line_type:Wireless original_text:Hi sweetheart, good night and have a sweet dream :* @admin 
192.76.120.192 sms.example.com 2020-05-20 22:28:47 PID5ec5af1f3e27c - L2 telnyx__callback # dlr uid:1 smslog_id:29 messageid:xxxxxxxx-3410-4e63-8068-b74ca3a20b86 status:sent
192.76.120.192 sms.example.com 2020-05-20 22:28:47 PID5ec5af1f3e27c - L3 dlr # isdlrd:1 smslog_id:29 p_status:1 uid:1
- - 2020-05-20 22:28:47 PID5ec4667241646 - L3 dlrd # id:29 smslog_id:29 p_status:2 uid:1
- - 2020-05-20 22:28:47 PID5ec5a3f18badb - L3 dlrd # id:30 smslog_id:29 p_status:2 uid:1
- - 2020-05-20 22:28:47 PID5ec5a3f18badb - L3 dlrd # id:31 smslog_id:29 p_status:1 uid:1
192.76.120.192 sms.example.com 2020-05-20 22:28:47 PID5ec5af1fcdcff - L2 telnyx__callback # pushed sms_id:xxxxxxxx-3410-4e63-8068-b74ca3a20b86 sms_gw_id:xxxxxxxx-3410-4e63-8068-b74ca3a20b86 user_id:xxxxxxxx-fa1b-4f68-a6e3-3b367f002d01 profile_id:xxxxxxxx-f86c-4f5e-bfd9-33e655dd5f48 status:delivered delivery_status:success date_created:2020-05-20T22:28:46.983000 date_updated:2020-05-20T22:28:47.662000 created:1590013726983 updated:1590013727662 body:Array from:+1xxxyyyzzzz to:+1xxxyyyzzzz direction:outbound on_net: cost: currency: type:SMS errors:Array carrier:T-MOBILE USA, INC. line_type:Wireless original_text:Hi sweetheart, good night and have a sweet dream :* @admin 
192.76.120.192 sms.example.com 2020-05-20 22:28:47 PID5ec5af1fcdcff - L2 telnyx__callback # dlr uid:1 smslog_id:29 messageid:40317234-3410-4e63-8068-b74ca3a20b86 status:delivered
192.76.120.192 sms.example.com 2020-05-20 22:28:47 PID5ec5af1fcdcff - L3 dlr # isdlrd:1 smslog_id:29 p_status:3 uid:1
- - 2020-05-20 22:28:48 PID5ec5a3f18badb - L3 dlrd # id:32 smslog_id:29 p_status:3 uid:1

Hi,

Those looks like logs for outgoing SMS (entries with sendsms sendsmsd) and delivery reports (entries with dlr dlrd). Theres dlr logs there so incoming SMS should be no issue too as they both use the same callback handler.

Incoming SMS will have entries in logs containing recvsmsd.

Entries with telnyx__callback on the line are logs for push messages from Telnyx server to playSMS. Content received by playSMS will determine whether its delivery reports or incoming SMS.

anton

Looks like IB and OB are working. After a successful send, I see this log entry, but the credit count in the GUI does not update.

- - 2020-05-21 20:36:46 PID5ec6e65eaa5c0 - L2 sendsms_process # start
- - 2020-05-21 20:36:46 PID5ec6e65eaa5c0 - L3 simplerate_hook_rate_getbyprefix # rate not found to:+1xxxyyyzzzz default_rate:1
- - 2020-05-21 20:36:46 PID5ec6e65eaa5c0 - L3 simplerate_hook_rate_getcharges # uid:3 u:FathomRealty len:25 unicode:0 to:+1xxxyyyzzzz enable_credit_unicode:0 count:1 rate:1 charge:1
- - 2020-05-21 20:36:46 PID5ec6e65eaa5c0 - L2 simplerate_hook_rate_cansend # allowed user uid:3 sms_to:+1xxxyyyzzzz adhoc_credit:10 count:1 rate:1 charge:1 **adhoc_balance:9**
- - 2020-05-21 20:36:46 PID5ec6e65eaa5c0 - L2 sendsms # saving smslog_id:47 u:3 parent_uid:0 g:0 gw:telnyx smsc:telnyx2 s:+1xxxyyyzzzz d:+1xxxyyyzzzz type:text unicode:0 status:0
- - 2020-05-21 20:36:46 PID5ec6e65eaa5c0 - L2 sendsms_process # saved smslog_id:47 id:47
- - 2020-05-21 20:36:46 PID5ec6e65eaa5c0 - L3 sendsms # final smslog_id:47 gw:telnyx smsc:telnyx2 message:Test for U1 @FathomRealty len:25
- - 2020-05-21 20:36:46 PID5ec6e65eaa5c0 - L3 telnyx_hook_sendsms # enter smsc:telnyx2 smslog_id:47 uid:3 to:+1xxxyyyzzzz
- - 2020-05-21 20:36:47 PID5ec6e65eaa5c0 - L2 3 # sendsms url:[https://sms.telnyx.com/messages] data:[{"to":"+1xxxyyyzzzz","from":"+1xxxyyyzzzz","body":"Test for U1 @FathomRealty","delivery_status_webhook_url":"https://sms.example.com//plugin/gateway/telnyx/callback.php"}] callback:[https://sms.example.com//plugin/gateway/telnyx/callback.php
- - 2020-05-21 20:36:47 PID5ec6e65eaa5c0 - L2 telnyx_hook_sendsms # sent smslog_id:47 message_id:40317238-f3e3-45c9-880c-2ff6bc56b436 smsc:telnyx2
- - 2020-05-21 20:36:47 PID5ec6e65eaa5c0 - L3 dlr # isdlrd:1 smslog_id:47 p_status:2 uid:3
- - 2020-05-21 20:36:47 PID5ec6e65eaa5c0 - L3 dlr # isdlrd:1 smslog_id:47 p_status:2 uid:3
- - 2020-05-21 20:36:47 PID5ec6e65eaa5c0 - L3 telnyx_hook_sendsms # sendsms end
- - 2020-05-21 20:36:47 PID5ec6e65eaa5c0 - L2 sendsms_process # fail no hook for sendsms
- - 2020-05-21 20:36:47 PID5ec6e65eaa5c0 - L2 sendsms_process # end
- - 2020-05-21 20:36:47 PID5ec6e65eaa5c0 - L2 sendsmsd # result queue_code:e04708c2b8bb6bf6f7fbf95e32c0d52b to:+1xxxyyyzzzz flag:2 smslog_id:47
- - 2020-05-21 20:36:47 PID5ec6e65eaa5c0 - L2 sendsmsd # finish processing queue_code:e04708c2b8bb6bf6f7fbf95e32c0d52b uid:3 sender_id:+1xxxyyyzzzz queue_count:1 sms_count:1
- - 2020-05-21 20:36:47 PID5ec4667241646 - L3 dlrd # id:93 smslog_id:47 p_status:2 uid:3
- - 2020-05-21 20:36:47 PID5ec4667241646 - L3 dlrd # id:94 smslog_id:47 p_status:2 uid:3
192.76.120.192 sms.example.com 2020-05-21 20:36:47 PID5ec6e65f49c91 - L2 telnyx__callback # pushed sms_id:40317238-f3e3-45c9-880c-2ff6bc56b436 sms_gw_id:40317238-f3e3-45c9-880c-2ff6bc56b436 user_id:3970a154-fa1b-4f68-a6e3-3b367f002d01 profile_id:400171b3-f86c-4f5e-bfd9-33e655dd5f48 status:sent delivery_status: date_created:2020-05-21T20:36:47.070000 date_updated:2020-05-21T20:36:47.148000 created:1590093407070 updated:1590093407148 body:Array from:+1xxxyyyzzzz to:+1xxxyyyzzzz direction:outbound on_net: cost: currency: type:SMS errors:Array carrier:T-MOBILE USA, INC. line_type:Wireless original_text:Test for U1 @FathomRealty 
192.76.120.192 sms.example.com 2020-05-21 20:36:47 PID5ec6e65f49c91 - L2 telnyx__callback # dlr uid:3 smslog_id:47 messageid:40317238-f3e3-45c9-880c-2ff6bc56b436 status:sent
192.76.120.192 sms.example.com 2020-05-21 20:36:47 PID5ec6e65f49c91 - L3 dlr # isdlrd:1 smslog_id:47 p_status:1 uid:3
192.76.120.192 sms.example.com 2020-05-21 20:36:47 PID5ec6e65fb3482 - L2 telnyx__callback # pushed sms_id:40317238-f3e3-45c9-880c-2ff6bc56b436 sms_gw_id:40317238-f3e3-45c9-880c-2ff6bc56b436 user_id:3970a154-fa1b-4f68-a6e3-3b367f002d01 profile_id:400171b3-f86c-4f5e-bfd9-33e655dd5f48 status:delivered delivery_status:success date_created:2020-05-21T20:36:47.070000 date_updated:2020-05-21T20:36:47.716000 created:1590093407070 updated:1590093407716 body:Array from:+1xxxyyyzzzz to:+1xxxyyyzzzz direction:outbound on_net: cost: currency: type:SMS errors:Array carrier:T-MOBILE USA, INC. line_type:Wireless original_text:Test for U1 @FathomRealty 
192.76.120.192 sms.example.com 2020-05-21 20:36:47 PID5ec6e65fb3482 - L2 telnyx__callback # dlr uid:3 smslog_id:47 messageid:40317238-f3e3-45c9-880c-2ff6bc56b436 status:delivered
192.76.120.192 sms.example.com 2020-05-21 20:36:47 PID5ec6e65fb3482 - L3 dlr # isdlrd:1 smslog_id:47 p_status:3 uid:3
- - 2020-05-21 20:36:48 PID5ec4667241646 - L3 dlrd # id:95 smslog_id:47 p_status:1 uid:3
- - 2020-05-21 20:36:48 PID5ec5a3f18badb - L3 dlrd # id:96 smslog_id:47 p_status:3 uid:3

which part of GUI ?

anton

Any place where it shows the balance remaining, for example:

Thanks!

I’ve tested this just now and mine is working, not sure whats the issue yet.

anton

That’s good to know. Must be a setting or maybe path issue on my setup. Do you have a suggestion for troubleshooting?