Problem to send and receive SMS on playSMS-1.4-beta3 installed on Kubuntu 16.04 and coupled with kannel-1.4.4

playSMS-1.4-beta3 is installed on Kubuntu 16.04 and coupled with kannel-1.4.4

when doing a Test by sending a sms from playSMS (section: writing messages)
No message is received on the mobile (+22548588560)
Can you help me please ?

Below /var/log/playsms/playsms.log content:
Voici ci-dessous le contenu du /var/log/playsms/playsms.log

27.0.0.1 localhost 2016-07-04 18:49:36 PID577aafc05f335 admin L2 sendsms # start uid:1 sender_id:[0022577022714] smsc:[]
127.0.0.1 localhost 2016-07-04 18:49:36 PID577aafc05f335 admin L2 sendsms_queue_create # saving queue_code:90d521b9bdacadf373d79ec942393e4c src:0022577022714 scheduled:2016-07-04 18:49:36
127.0.0.1 localhost 2016-07-04 18:49:36 PID577aafc05f335 admin L2 sendsms_queue_create # saved queue_code:90d521b9bdacadf373d79ec942393e4c id:1
127.0.0.1 localhost 2016-07-04 18:49:36 PID577aafc05f335 admin L2 sendsms # dst_count:1 sms_count:1 total_charges:0
127.0.0.1 localhost 2016-07-04 18:49:36 PID577aafc05f335 admin L2 sendsms_queue_push # saving queue_code:90d521b9bdacadf373d79ec942393e4c dst:+22548588560
127.0.0.1 localhost 2016-07-04 18:49:36 PID577aafc05f335 admin L2 sendsms_queue_push # saved queue_code:90d521b9bdacadf373d79ec942393e4c smslog_id:1
127.0.0.1 localhost 2016-07-04 18:49:36 PID577aafc05f335 admin L2 sendsms # end queue_code:90d521b9bdacadf373d79ec942393e4c queue_count:1 sms_count:1 failed_queue:0 failed_sms:0
- - 2016-07-04 18:49:37 PID577aafc19c45c - L2 sendsmsd # start processing queue_code:90d521b9bdacadf373d79ec942393e4c chunk:0 queue_count:1 sms_count:1 scheduled:2016-07-04 18:49:36 uid:1 gpid:0 sender_id:0022577022714
- - 2016-07-04 18:49:37 PID577aafc19c45c - L2 sendsmsd # sending queue_code:90d521b9bdacadf373d79ec942393e4c smslog_id:1 to:+22548588560 sms_count:1 counter:1
- - 2016-07-04 18:49:37 PID577aafc19c45c - L2 recvsms_process # using default SMSC smsc:[kannel]
- - 2016-07-04 18:49:37 PID577aafc19c45c - L2 sendsms_process # start
- - 2016-07-04 18:49:37 PID577aafc19c45c - L2 simplerate_hook_rate_cansend # allowed user uid:1 sms_to:+22548588560 adhoc_credit:0 count:1 rate: charge:0 adhoc_balance:0
- - 2016-07-04 18:49:37 PID577aafc19c45c - L2 sendsms # saving smslog_id:1 u:1 parent_uid:0 g:0 gw:kannel smsc:kannel s:0022577022714 d:+22548588560 type:flash unicode:0 status:0
- - 2016-07-04 18:49:37 PID577aafc19c45c - L2 sendsms_process # saved smslog_id:1 id:1
- - 2016-07-04 18:49:37 PID577aafc19c45c - L2 simplerate_hook_rate_deduct # enter smslog_id:1
- - 2016-07-04 18:49:37 PID577aafc19c45c - L2 simplebilling_hook_billing_post # saving smslog_id:1 rate: count:1 charge:0
- - 2016-07-04 18:49:37 PID577aafc19c45c - L2 simplebilling_hook_billing_post # saved smslog_id:1 id:1
- - 2016-07-04 18:49:37 PID577aafc19c45c - L2 sendsms_process # end
- - 2016-07-04 18:49:37 PID577aafc19c45c - L2 sendsmsd # result queue_code:90d521b9bdacadf373d79ec942393e4c to:+22548588560 flag:1 smslog_id:1
- - 2016-07-04 18:49:37 PID577aafc19c45c - L2 sendsmsd # finish processing queue_code:90d521b9bdacadf373d79ec942393e4c uid:1 sender_id:0022577022714 queue_count:1 sms_count:1

kannel configuration:

# CORE
group = core
admin-port = 13133
admin-password = kannel
status-password = kannel
log-file = /var/log/kannel/kannel.log
log-level = 0
access-log = /var/log/kannel/access.log
smsbox-port = 13134
store-type = spool
store-location = /var/spool/kannel/store
smsbox-max-pending = 100

# SMSBOX
group = smsbox
bearerbox-host = localhost
#bearerbox-port = 13132
sendsms-port = 13131
global-sender = 13131
sendsms-chars = "0123456789+- "
log-file = /var/log/kannel/smsbox.log
log-level = 0
access-log = /var/log/kannel/access.log
mo-recode = true
sendsms-url = "/cgi-bin/sendsms"

## SMSC smpp1
#smsc = smpp
#smsc-id = smpp1
#allowed-smsc-id = smpp1
#preferred-smsc-id = smpp1
#host = SMPP_SERVER_ADDRESS_CHANGE_THIS
#port = SMPP_SERVER_PORT_NUMBER_CHANGE_THIS
#transceiver-mode = yes
#smsc-username = SMPP_USERNAME_CHANGE_THIS
#smsc-password = SMPP_PASSWORD_CHANGE_THIS
#system-type = "VMA"
#log-file = /var/log/kannel/smsc-smpp1.log
#log-level = 0

## SMSC gsm1
group = smsc
smsc = at
port = 13013
smsc-id = Huawei
allowed-smsc-id = huawei
preferred-smsc-id = Huawei
my-number = 0022577022714
sms-center = 0022507070002
#allowed-prefix = "+62;62;0"
unified-prefix = "-,+,00"
modemtype = huawei
device = /dev/ttyUSB2
speed = 9600
#validityperiod = 143
my-number = +22577022714
sim-buffering = true
max-error-count = 5
log-file = /var/log/kannel/smsc-gsm1.log
log-level = 0

## SMSC gsm2
#group = smsc
#smsc = at
#smsc-id = gsm2
#allowed-smsc-id = gsm2
#preferred-smsc-id = gsm2
#my-number = 102
##allowed-prefix = "+62;62;0"
#unified-prefix = "+62,62,0;+,00"
#modemtype = wavecom
#device = /dev/ttyUSB1
#speed = 115200
##validityperiod = 143
#sim-buffering = true
#max-error-count = 5
#log-file = /var/log/kannel/smsc-gsm2.log
#log-level = 0

group = modems
id = huawei
message-storage = "SM"
need-sleep = true
sendline-sleep = 200
detect-string = "huawei"
init-string = "ATQ0 V1 E1 S0=0"
speed = 9600
#reset-string = "AT+CFUN=1"

#group = modems
#id = huawei
#message-storage = SM
#need-sleep = true
#sendline-sleep = 200
#init-string = "AT+CNMI=2,2,0,1,0;+CMEE=1"
#reset-string = "AT+CFUN=1"

# SENDSMS-USER
group = sendsms-user
default-smsc = none
username = kannel
password = kannel
max-messages = 1000
concatenation = true

# SMS SERVICE
group = sms-service
keyword = default
assume-plain-text = true
catch-all = true
accepted-smsc = huawei
#keyword = lamb
omit-empty = true
max-messages = 99
accept-x-kannel-headers = true
#get-url = "http://localhost/kannel/receivesms.php?sender=%p&text=%b"
get-url = "http://localhost/playsms/index.php?app=call&cat=gateway&plugin=kannel&access=geturl&t=%t&q=%q&a=%a&Q=%Q&smsc=%i"
#get-url = http://localhost/kannel/testlamb.php?t=%t&q=%q&a=%a 
concatenation = true
#text = "Galaxy ROBOT by Zaib"
omit-empty = true

# SMSBOX ROUTE
#group = smsbox-route
#smsbox-id = at
#smsc-id = Huawei

kannel status:

Kannel bearerbox version `1.4.4'. Build `Apr 5 2016 13:32:05', compiler `5.3.1 20160330'. System Linux, release 4.4.0-28-generic, version #47-Ubuntu SMP Fri Jun 24 10:09:13 UTC 2016, machine x86_64. Hostname tioteHP, IP 127.0.1.1. Libxml version 2.9.3. Using OpenSSL 1.0.2g 1 Mar 2016. Compiled with MySQL 5.7.11, using MySQL 5.7.12. Compiled with PostgreSQL 9.5.2. Using SQLite 3.11.0. Using hiredis API 0.13.3 Using native malloc.

Status: running, uptime 0d 0h 22m 52s

WDP: received 0 (0 queued), sent 0 (0 queued)

SMS: received 0 (0 queued), sent 0 (0 queued), store size 0
SMS: inbound (0.00,0.00,0.00) msg/sec, outbound (0.00,0.00,0.00) msg/sec

DLR: received 0, sent 0
DLR: inbound (0.00,0.00,0.00) msg/sec, outbound (0.00,0.00,0.00) msg/sec
DLR: 0 queued, using internal storage

Box connections:
    smsbox:(none), IP 127.0.0.1 (0 queued), (on-line 0d 0h 21m 28s)

SMSC connections:
    Huawei[Huawei]    AT2[Huawei] (connecting, rcvd: sms 0 (0.00,0.00,0.00) / dlr 0 (0.00,0.00,0.00), sent: sms 0 (0.00,0.00,0.00) / dlr 0 (0.00,0.00,0.00), failed 0, queued 0 msgs)

Please enable loglevel 3 from config.php and re-test to get new log with L3 entries.

And also check your Huawei config, it should be connected not connecting, see your kannel status.

anton

Thank you sir,
After re-testing:

playsms log file (/var/log/playsms/playsms.log):

127.0.0.1 localhost 2016-07-05 10:58:11 PID577b92c35ebea admin L2 sendsms # start uid:1 sender_id:[+22577022714] smsc:[]
127.0.0.1 localhost 2016-07-05 10:58:11 PID577b92c35ebea admin L3 sendsms # maxlen:1530 footerlen:7 footer:[ @admin] msglen:14 message:[Test 2 playsms]
127.0.0.1 localhost 2016-07-05 10:58:11 PID577b92c35ebea admin L2 sendsms_queue_create # saving queue_code:0866111c701d668089b7ce712a761832 src:+22577022714 scheduled:2016-07-05 10:58:11
127.0.0.1 localhost 2016-07-05 10:58:11 PID577b92c35ebea admin L2 sendsms_queue_create # saved queue_code:0866111c701d668089b7ce712a761832 id:5
127.0.0.1 localhost 2016-07-05 10:58:11 PID577b92c35ebea admin L3 sendsms_manipulate_prefix # before prefix manipulation:[+22548588560]
127.0.0.1 localhost 2016-07-05 10:58:11 PID577b92c35ebea admin L3 sendsms_manipulate_prefix # after prefix manipulation:[+22548588560]
127.0.0.1 localhost 2016-07-05 10:58:11 PID577b92c35ebea admin L3 simplerate_hook_rate_getbyprefix # rate not found to:+22548588560 default_rate:0
127.0.0.1 localhost 2016-07-05 10:58:11 PID577b92c35ebea admin L3 simplerate_hook_rate_getcharges # uid:1 u:admin len:21 unicode:0 to:+22548588560 enable_credit_unicode:0 count:1 rate: charge:0
127.0.0.1 localhost 2016-07-05 10:58:11 PID577b92c35ebea admin L2 sendsms # dst_count:1 sms_count:1 total_charges:0
127.0.0.1 localhost 2016-07-05 10:58:11 PID577b92c35ebea admin L2 sendsms_queue_push # saving queue_code:0866111c701d668089b7ce712a761832 dst:+22548588560
127.0.0.1 localhost 2016-07-05 10:58:11 PID577b92c35ebea admin L2 sendsms_queue_push # saved queue_code:0866111c701d668089b7ce712a761832 smslog_id:5
127.0.0.1 localhost 2016-07-05 10:58:11 PID577b92c35ebea admin L2 sendsms # end queue_code:0866111c701d668089b7ce712a761832 queue_count:1 sms_count:1 failed_queue:0 failed_sms:0

    • 2016-07-05 10:58:11 PID577b92c3d484d - L2 sendsmsd # start processing queue_code:0866111c701d668089b7ce712a761832 chunk:0 queue_count:1 sms_count:1 scheduled:2016-07-05 10:58:11 uid:1 gpid:0 sender_id:+22577022714
    • 2016-07-05 10:58:11 PID577b92c3d484d - L2 sendsmsd # sending queue_code:0866111c701d668089b7ce712a761832 smslog_id:5 to:+22548588560 sms_count:1 counter:1
    • 2016-07-05 10:58:11 PID577b92c3d484d - L3 sendsms_intercept # msgtemplate modified sms_sender:[+22577022714] sms_footer:[@admin] sms_to:[+22548588560] sms_msg:[Test 2 playsms] uid:[1] gpid:[0] sms_type:[flash] unicode:[0] queue_code:[0866111c701d668089b7ce712a761832] smsc:[]
    • 2016-07-05 10:58:11 PID577b92c3d484d - L3 outgoing_hook_sendsms_intercept # no SMSC found uid:1 parent_uid:0 from:+22577022714 to:+22548588560
    • 2016-07-05 10:58:11 PID577b92c3d484d - L2 recvsms_process # using default SMSC smsc:[kannel]
    • 2016-07-05 10:58:11 PID577b92c3d484d - L2 sendsms_process # start
    • 2016-07-05 10:58:11 PID577b92c3d484d - L3 simplerate_hook_rate_getbyprefix # rate not found to:+22548588560 default_rate:0
    • 2016-07-05 10:58:11 PID577b92c3d484d - L3 simplerate_hook_rate_getcharges # uid:1 u:admin len:21 unicode:0 to:+22548588560 enable_credit_unicode:0 count:1 rate: charge:0
    • 2016-07-05 10:58:11 PID577b92c3d484d - L2 simplerate_hook_rate_cansend # allowed user uid:1 sms_to:+22548588560 adhoc_credit:0 count:1 rate: charge:0 adhoc_balance:0
    • 2016-07-05 10:58:11 PID577b92c3d484d - L2 sendsms # saving smslog_id:5 u:1 parent_uid:0 g:0 gw:kannel smsc:kannel s:+22577022714 d:+22548588560 type:flash unicode:0 status:0
    • 2016-07-05 10:58:11 PID577b92c3d484d - L2 sendsms_process # saved smslog_id:5 id:5
    • 2016-07-05 10:58:11 PID577b92c3d484d - L3 sendsms # final smslog_id:5 gw:kannel smsc:kannel message:Test 2 playsms @admin len:21
    • 2016-07-05 10:58:11 PID577b92c3d484d - L3 kannel_hook_sendsms # enter smsc:kannel smslog_id:5 uid:1 to:+22548588560
    • 2016-07-05 10:58:12 PID577b92c3d484d - L3 dlr # isdlrd:1 smslog_id:5 p_status:2 uid:1
    • 2016-07-05 10:58:12 PID577b92c3d484d - L3 kannel__outgoing # end smslog_id:5 p_status:2
    • 2016-07-05 10:58:12 PID577b92c3d484d - L2 simplerate_hook_rate_deduct # enter smslog_id:5
    • 2016-07-05 10:58:12 PID577b92c3d484d - L3 simplerate_hook_rate_getbyprefix # rate not found to:+22548588560 default_rate:0
    • 2016-07-05 10:58:12 PID577b92c3d484d - L3 simplerate_hook_rate_getcharges # uid:1 u:admin len:21 unicode:0 to:+22548588560 enable_credit_unicode:0 count:1 rate: charge:0
    • 2016-07-05 10:58:12 PID577b92c3d484d - L2 simplebilling_hook_billing_post # saving smslog_id:5 rate: count:1 charge:0
    • 2016-07-05 10:58:12 PID577b92c3d484d - L2 simplebilling_hook_billing_post # saved smslog_id:5 id:5
    • 2016-07-05 10:58:12 PID577b92c3d484d - L3 simplerate_hook_rate_deduct # deduct successful uid:1 parent_uid:0 smslog_id:5
    • 2016-07-05 10:58:12 PID577b92c3d484d - L2 sendsms_process # end
    • 2016-07-05 10:58:12 PID577b92c3d484d - L2 sendsmsd # result queue_code:0866111c701d668089b7ce712a761832 to:+22548588560 flag:1 smslog_id:5
    • 2016-07-05 10:58:12 PID577b92c3d484d - L2 sendsmsd # finish processing queue_code:0866111c701d668089b7ce712a761832 uid:1 sender_id:+22577022714 queue_count:1 sms_count:1
    • 2016-07-05 10:58:12 PID577b8bc8efb3c - L3 dlrd # id:5 smslog_id:5 p_status:2 uid:1

Modem configuration file:
[Dialer Defaults]
Init1 = ATZ
Init2 = ATQ0 V1 E1 &C1 &D2
Modem Type = Analog Modem
; Phone =
ISDN = 0
; Password =
New PPPD = yes
; Username =
Modem = /dev/ttyUSB2
Baud = 9600

Kannel status:
Kannel bearerbox version 1.4.4'. BuildApr 5 2016 13:32:05’, compiler `5.3.1 20160330’. System Linux, release 4.4.0-28-generic, version #47-Ubuntu SMP Fri Jun 24 10:09:13 UTC 2016, machine x86_64. Hostname tioteHP, IP 127.0.1.1. Libxml version 2.9.3. Using OpenSSL 1.0.2g 1 Mar 2016. Compiled with MySQL 5.7.11, using MySQL 5.7.12. Compiled with PostgreSQL 9.5.2. Using SQLite 3.11.0. Using hiredis API 0.13.3 Using native malloc.

Status: running, uptime 0d 0h 5m 35s

WDP: received 0 (0 queued), sent 0 (0 queued)

SMS: received 0 (0 queued), sent 0 (0 queued), store size 0
SMS: inbound (0.00,0.00,0.00) msg/sec, outbound (0.00,0.00,0.00) msg/sec

DLR: received 0, sent 0
DLR: inbound (0.00,0.00,0.00) msg/sec, outbound (0.00,0.00,0.00) msg/sec
DLR: 0 queued, using internal storage

Box connections:
smsbox:(none), IP 127.0.0.1 (0 queued), (on-line 0d 0h 5m 28s)

SMSC connections:
Huawei[Huawei] AT2[Huawei] (connecting, rcvd: sms 0 (0.00,0.00,0.00) / dlr 0 (0.00,0.00,0.00), sent: sms 0 (0.00,0.00,0.00) / dlr 0 (0.00,0.00,0.00), failed 0, queued 0 msgs)

Hi,
0. Based from yr status log, the modem is trying to connect (NOT YET ONLINE) which could be due to 1 or 2 below.

  1. What HUAWEI modem model are you using? Need to set the MODEM init string properly
  2. Check that it is connected to the right USB port