Hi!
kannel PANIC then i using DLR.. I got this all the time (then
sending SMS):
2010-02-17 16:59:41 [23948] [4] DEBUG:
SMSC[SMPP:server2.msgtoolbox.com:2775/2775:ICITG1_1:G1]: creating DLR
message
2010-02-17 16:59:41 [23948] [4] DEBUG:
SMSC[SMPP:server2.msgtoolbox.com:2775/2775:ICITG1_1:G1]: DLR = http://127.0.0.1/dlr.php?msgid=1&state=
%d&msisdn=%p
2010-02-17 16:59:43 [23948] [4] PANIC: gwlib/gw-rwlock.c:137:
gw_rwlock_rdlock: Assertion `lock != NULL' failed.
2010-02-17 16:59:45 [23948] [4] PANIC: ./bearerbox(gw_panic+0x16d)
[0x48660d]
2010-02-17 16:59:45 [23948] [4] PANIC: ./bearerbox(gw_rwlock_rdlock
+0x4d) [0x47c13d]
2010-02-17 16:59:45 [23948] [4] PANIC: ./
bearerbox(route_incoming_to_boxc+0x58) [0x4119a8]
2010-02-17 16:59:45 [23948] [4] PANIC: ./bearerbox(bb_smscconn_receive
+0x57c) [0x41805c]
2010-02-17 16:59:45 [23948] [4] PANIC: ./bearerbox(bb_smscconn_sent
+0xf2) [0x418cc2]
2010-02-17 16:59:45 [23948] [4] PANIC: ./bearerbox [0x454e38]
2010-02-17 16:59:45 [23948] [4] PANIC: ./bearerbox [0x45639c]
2010-02-17 16:59:45 [23948] [4] PANIC: ./bearerbox [0x47d495]
2010-02-17 16:59:45 [23948] [4] PANIC: /lib/libpthread.so.0
[0x2b09842023f7]
2010-02-17 16:59:45 [23948] [4] PANIC: /lib/libc.so.6(clone+0x6d)
[0x2b0984bb7b2d]
I got the same PANIC then i receive the DLR message from SMPP. Here
is full logg:
2010-02-17 16:59:24 [23948] [4] DEBUG: SMPP PDU 0x7835c0 dump:
2010-02-17 16:59:24 [23948] [4] DEBUG: type_name: bind_transceiver
2010-02-17 16:59:24 [23948] [4] DEBUG: command_id: 9 = 0x00000009
2010-02-17 16:59:24 [23948] [4] DEBUG: command_status: 0 = 0x00000000
2010-02-17 16:59:24 [23948] [4] DEBUG: sequence_number: 1 = 0x00000001
2010-02-17 16:59:24 [23948] [4] DEBUG: system_id: "USER"
2010-02-17 16:59:24 [23948] [4] DEBUG: password: "PASS"
2010-02-17 16:59:24 [23948] [4] DEBUG: system_type: "G1"
2010-02-17 16:59:24 [23948] [4] DEBUG: interface_version: 52 =
0x00000034
2010-02-17 16:59:24 [23948] [4] DEBUG: addr_ton: 0 = 0x00000000
2010-02-17 16:59:24 [23948] [4] DEBUG: addr_npi: 0 = 0x00000000
2010-02-17 16:59:24 [23948] [4] DEBUG: address_range: ""
2010-02-17 16:59:24 [23948] [4] DEBUG: SMPP PDU dump ends.
2010-02-17 16:59:29 [23948] [4] DEBUG: Optional parameter tag (0x0210)
2010-02-17 16:59:29 [23948] [4] DEBUG: Optional parameter length read
as 1
2010-02-17 16:59:29 [23948] [4] DEBUG:
SMPP[SMPP:server2.msgtoolbox.com:2775/2775:USER:G1]: Got PDU:
2010-02-17 16:59:29 [23948] [4] DEBUG: SMPP PDU 0x783640 dump:
2010-02-17 16:59:29 [23948] [4] DEBUG: type_name:
bind_transceiver_resp
2010-02-17 16:59:29 [23948] [4] DEBUG: command_id: 2147483657 =
0x80000009
2010-02-17 16:59:29 [23948] [4] DEBUG: command_status: 0 = 0x00000000
2010-02-17 16:59:29 [23948] [4] DEBUG: sequence_number: 1 = 0x00000001
2010-02-17 16:59:29 [23948] [4] DEBUG: system_id: "42IT-SMPP"
2010-02-17 16:59:29 [23948] [4] DEBUG: sc_interface_version: 52 =
0x00000034
2010-02-17 16:59:29 [23948] [4] DEBUG: SMPP PDU dump ends.
2010-02-17 16:59:29 [23948] [4] DEBUG:
SMPP[SMPP:server2.msgtoolbox.com:2775/2775:USER:G1]: throughput
(0.00,0.00)
2010-02-17 16:59:33 [23948] [11] INFO: Client connected from <127.0.0.1>
2010-02-17 16:59:33 [23948] [11] DEBUG: Started thread 13 (gw/
bb_boxc.c:function)
2010-02-17 16:59:33 [23948] [13] DEBUG: Thread 13 (gw/
bb_boxc.c:function) maps to pid 23948.
2010-02-17 16:59:33 [23948] [13] DEBUG: setting up systems for new
wapbox
2010-02-17 16:59:33 [23948] [13] DEBUG: Started thread 14 (gw/
bb_boxc.c:boxc_sender)
2010-02-17 16:59:33 [23948] [14] DEBUG: Thread 14 (gw/
bb_boxc.c:boxc_sender) maps to pid 23948.
2010-02-17 16:59:41 [23948] [13] DEBUG: boxc_receiver: got sms from
wapbox
2010-02-17 16:59:41 [23948] [13] DEBUG: send_msg: sending msg to box:
<127.0.0.1>
2010-02-17 16:59:41 [23948] [4] DEBUG:
SMPP[SMPP:server2.msgtoolbox.com:2775/2775:USER:G1]: throughput
(0.00,0.00)
2010-02-17 16:59:41 [23948] [4] DEBUG:
SMPP[SMPP:server2.msgtoolbox.com:2775/2775:USER:G1]: Sending PDU:
2010-02-17 16:59:41 [23948] [4] DEBUG: SMPP PDU 0x77dae0 dump:
2010-02-17 16:59:41 [23948] [4] DEBUG: type_name: submit_sm
2010-02-17 16:59:41 [23948] [4] DEBUG: command_id: 4 = 0x00000004
2010-02-17 16:59:41 [23948] [4] DEBUG: command_status: 0 = 0x00000000
2010-02-17 16:59:41 [23948] [4] DEBUG: sequence_number: 2 = 0x00000002
2010-02-17 16:59:41 [23948] [4] DEBUG: service_type: NULL
2010-02-17 16:59:41 [23948] [4] DEBUG: source_addr_ton: 2 = 0x00000002
2010-02-17 16:59:41 [23948] [4] DEBUG: source_addr_npi: 1 = 0x00000001
2010-02-17 16:59:41 [23948] [4] DEBUG: source_addr: "123"
2010-02-17 16:59:41 [23948] [4] DEBUG: dest_addr_ton: 2 = 0x00000002
2010-02-17 16:59:41 [23948] [4] DEBUG: dest_addr_npi: 1 = 0x00000001
2010-02-17 16:59:41 [23948] [4] DEBUG: destination_addr: "4670xxxxxxx"
2010-02-17 16:59:41 [23948] [4] DEBUG: esm_class: 3 = 0x00000003
2010-02-17 16:59:41 [23948] [4] DEBUG: protocol_id: 0 = 0x00000000
2010-02-17 16:59:41 [23948] [4] DEBUG: priority_flag: 0 = 0x00000000
2010-02-17 16:59:41 [23948] [4] DEBUG: schedule_delivery_time: NULL
2010-02-17 16:59:41 [23948] [4] DEBUG: validity_period: NULL
2010-02-17 16:59:41 [23948] [4] DEBUG: registered_delivery: 1 =
0x00000001
2010-02-17 16:59:41 [23948] [4] DEBUG: replace_if_present_flag: 0 =
0x00000000
2010-02-17 16:59:41 [23948] [4] DEBUG: data_coding: 0 = 0x00000000
2010-02-17 16:59:41 [23948] [4] DEBUG: sm_default_msg_id: 0 =
0x00000000
2010-02-17 16:59:41 [23948] [4] DEBUG: sm_length: 8 = 0x00000008
2010-02-17 16:59:41 [23948] [4] DEBUG: short_message: "test sms"
2010-02-17 16:59:41 [23948] [4] DEBUG: SMPP PDU dump ends.
2010-02-17 16:59:41 [23948] [4] DEBUG:
SMPP[SMPP:server2.msgtoolbox.com:2775/2775:ICITG1_1:G1]: throughput
(1.00,0.00)
2010-02-17 16:59:41 [23948] [4] DEBUG:
SMPP[SMPP:server2.msgtoolbox.com:2775/2775:ICITG1_1:G1]: throughput
(1.00,0.00)
2010-02-17 16:59:41 [23948] [4] DEBUG:
SMPP[SMPP:server2.msgtoolbox.com:2775/2775:ICITG1_1:G1]: Got PDU:
2010-02-17 16:59:41 [23948] [4] DEBUG: SMPP PDU 0x77dae0 dump:
2010-02-17 16:59:41 [23948] [4] DEBUG: type_name: submit_sm_resp
2010-02-17 16:59:41 [23948] [4] DEBUG: command_id: 2147483652 =
0x80000004
2010-02-17 16:59:41 [23948] [4] DEBUG: command_status: 0 = 0x00000000
2010-02-17 16:59:41 [23948] [4] DEBUG: sequence_number: 2 = 0x00000002
2010-02-17 16:59:41 [23948] [4] DEBUG: message_id:
2010-02-17 16:59:41 [23948] [4] DEBUG: Octet string at 0x784100:
2010-02-17 16:59:41 [23948] [4] DEBUG: len: 20
2010-02-17 16:59:41 [23948] [4] DEBUG: size: 21
2010-02-17 16:59:41 [23948] [4] DEBUG: immutable: 0
2010-02-17 16:59:41 [23948] [4] DEBUG: data: 31 32 36 36 34 32 32
33 39 37 30 35 33 39 35 30 1266422397053950
2010-02-17 16:59:41 [23948] [4] DEBUG: data: 30 32 30
32 0202
2010-02-17 16:59:41 [23948] [4] DEBUG: Octet string dump ends.
2010-02-17 16:59:41 [23948] [4] DEBUG: SMPP PDU dump ends.
2010-02-17 16:59:41 [23948] [4] DEBUG: DLR[mysql]: Adding DLR
smsc=SMPP:server2.msgtoolbox.com:2775/2775:USER:G1,
ts=9223372036854775807, src=123, dst=4670xxxxxxx, mask=31, boxc=
2010-02-17 16:59:41 [23948] [4] DEBUG: adding DLR entry into database
2010-02-17 16:59:41 [23948] [4] DEBUG: sql: INSERT INTO `dlr` (`smsc`,
`ts`, `source`, `destination`, `service`, `url`, `mask`, `boxc`,
`status`) VALUES (?, ?, ?, ?, ?, ?, ?, ?, 0)
2010-02-17 16:59:41 [23948] [4] DEBUG:
SMSC[SMPP:server2.msgtoolbox.com:2775/2775:ICITG1_1:G1]: creating DLR
message
2010-02-17 16:59:41 [23948] [4] DEBUG:
SMSC[SMPP:server2.msgtoolbox.com:2775/2775:ICITG1_1:G1]: DLR = http://127.0.0.1/dlr.php?msgid=1&state=
%d&msisdn=%p
2010-02-17 16:59:43 [23948] [4] PANIC: gwlib/gw-rwlock.c:137:
gw_rwlock_rdlock: Assertion `lock != NULL' failed.
2010-02-17 16:59:45 [23948] [4] PANIC: ./bearerbox(gw_panic+0x16d)
[0x48660d]
2010-02-17 16:59:45 [23948] [4] PANIC: ./bearerbox(gw_rwlock_rdlock
+0x4d) [0x47c13d]
2010-02-17 16:59:45 [23948] [4] PANIC: ./
bearerbox(route_incoming_to_boxc+0x58) [0x4119a8]
2010-02-17 16:59:45 [23948] [4] PANIC: ./bearerbox(bb_smscconn_receive
+0x57c) [0x41805c]
2010-02-17 16:59:45 [23948] [4] PANIC: ./bearerbox(bb_smscconn_sent
+0xf2) [0x418cc2]
2010-02-17 16:59:45 [23948] [4] PANIC: ./bearerbox [0x454e38]
2010-02-17 16:59:45 [23948] [4] PANIC: ./bearerbox [0x45639c]
2010-02-17 16:59:45 [23948] [4] PANIC: ./bearerbox [0x47d495]
2010-02-17 16:59:45 [23948] [4] PANIC: /lib/libpthread.so.0
[0x2b09842023f7]
2010-02-17 16:59:45 [23948] [4] PANIC: /lib/libc.so.6(clone+0x6d)
[0x2b0984bb7b2d]
*RESTART bearerbox*
2010-02-17 16:59:52 [23973] [4] DEBUG: Optional parameter tag (0x0210)
2010-02-17 16:59:52 [23973] [4] DEBUG: Optional parameter length read
as 1
2010-02-17 16:59:52 [23973] [4] DEBUG:
SMPP[SMPP:server2.msgtoolbox.com:2775/2775:USER:G1]: Got PDU:
2010-02-17 16:59:52 [23973] [4] DEBUG: SMPP PDU 0x78ca10 dump:
2010-02-17 16:59:52 [23973] [4] DEBUG: type_name:
bind_transceiver_resp
2010-02-17 16:59:52 [23973] [4] DEBUG: command_id: 2147483657 =
0x80000009
2010-02-17 16:59:52 [23973] [4] DEBUG: command_status: 0 = 0x00000000
2010-02-17 16:59:52 [23973] [4] DEBUG: sequence_number: 1 = 0x00000001
2010-02-17 16:59:52 [23973] [4] DEBUG: system_id: "42IT-SMPP"
2010-02-17 16:59:52 [23973] [4] DEBUG: sc_interface_version: 52 =
0x00000034
2010-02-17 16:59:52 [23973] [4] DEBUG: SMPP PDU dump ends.
2010-02-17 16:59:52 [23973] [4] DEBUG:
SMPP[SMPP:server2.msgtoolbox.com:2775/2775:USER:G1]: throughput
(0.00,0.00)
2010-02-17 16:59:54 [23973] [4] DEBUG:
SMPP[SMPP:server2.msgtoolbox.com:2775/2775:USER:G1]: throughput
(0.00,0.00)
2010-02-17 16:59:54 [23973] [4] DEBUG:
SMPP[SMPP:server2.msgtoolbox.com:2775/2775:USER:G1]: Got PDU:
2010-02-17 16:59:54 [23973] [4] DEBUG: SMPP PDU 0x78ca10 dump:
2010-02-17 16:59:54 [23973] [4] DEBUG: type_name: deliver_sm
2010-02-17 16:59:54 [23973] [4] DEBUG: command_id: 5 = 0x00000005
2010-02-17 16:59:54 [23973] [4] DEBUG: command_status: 0 = 0x00000000
2010-02-17 16:59:54 [23973] [4] DEBUG: sequence_number: 1 = 0x00000001
2010-02-17 16:59:54 [23973] [4] DEBUG: service_type: NULL
2010-02-17 16:59:54 [23973] [4] DEBUG: source_addr_ton: 0 = 0x00000000
2010-02-17 16:59:54 [23973] [4] DEBUG: source_addr_npi: 0 = 0x00000000
2010-02-17 16:59:54 [23973] [4] DEBUG: source_addr: "4670xxxxxxx"
2010-02-17 16:59:54 [23973] [4] DEBUG: dest_addr_ton: 0 = 0x00000000
2010-02-17 16:59:54 [23973] [4] DEBUG: dest_addr_npi: 0 = 0x00000000
2010-02-17 16:59:54 [23973] [4] DEBUG: destination_addr: "123"
2010-02-17 16:59:54 [23973] [4] DEBUG: esm_class: 4 = 0x00000004
2010-02-17 16:59:54 [23973] [4] DEBUG: protocol_id: 0 = 0x00000000
2010-02-17 16:59:54 [23973] [4] DEBUG: priority_flag: 0 = 0x00000000
2010-02-17 16:59:54 [23973] [4] DEBUG: schedule_delivery_time: NULL
2010-02-17 16:59:54 [23973] [4] DEBUG: validity_period: NULL
2010-02-17 16:59:54 [23973] [4] DEBUG: registered_delivery: 0 =
0x00000000
2010-02-17 16:59:54 [23973] [4] DEBUG: replace_if_present_flag: 0 =
0x00000000
2010-02-17 16:59:54 [23973] [4] DEBUG: data_coding: 0 = 0x00000000
2010-02-17 16:59:54 [23973] [4] DEBUG: sm_default_msg_id: 0 =
0x00000000
2010-02-17 16:59:54 [23973] [4] DEBUG: sm_length: 150 = 0x00000096
2010-02-17 16:59:54 [23973] [4] DEBUG: short_message:
2010-02-17 16:59:54 [23973] [4] DEBUG: Octet string at 0x78ccd0:
2010-02-17 16:59:54 [23973] [4] DEBUG: len: 150
2010-02-17 16:59:54 [23973] [4] DEBUG: size: 151
2010-02-17 16:59:54 [23973] [4] DEBUG: immutable: 0
2010-02-17 16:59:54 [23973] [4] DEBUG: data: 69 64 3a 31 32 36 36
34 32 32 33 39 37 30 35 33 id:1266422397053
2010-02-17 16:59:54 [23973] [4] DEBUG: data: 39 35 30 30 32 30 32
20 73 75 62 3a 30 30 31 20 9500202 sub:001
2010-02-17 16:59:54 [23973] [4] DEBUG: data: 64 6c 76 72 64 3a 30
30 31 20 73 75 62 6d 69 74 dlvrd:001 submit
2010-02-17 16:59:54 [23973] [4] DEBUG: data: 20 64 61 74 65 3a 31
30 30 32 31 37 31 37 30 30 date:1002171700
2010-02-17 16:59:54 [23973] [4] DEBUG: data: 20 64 6f 6e 65 20 64
61 74 65 3a 31 30 30 32 31 done date:10021
2010-02-17 16:59:54 [23973] [4] DEBUG: data: 37 31 37 30 30 20 73
74 61 74 3a 52 45 4a 45 43 71700 stat:REJEC
2010-02-17 16:59:54 [23973] [4] DEBUG: data: 54 44 20 65 72 72 3a
30 30 30 20 74 65 78 74 3a TD err:000 text:
2010-02-17 16:59:54 [23973] [4] DEBUG: data: 0a 53 4d 53 43 52 65
63 65 69 70 74 4d 73 67 49 .SMSCReceiptMsgI
2010-02-17 16:59:54 [23973] [4] DEBUG: data: 64 3a 31 32 36 36 34
32 32 33 39 37 30 35 33 39 d:12664223970539
2010-02-17 16:59:54 [23973] [4] DEBUG: data: 35 30 30 32 30
32 500202
2010-02-17 16:59:54 [23973] [4] DEBUG: Octet string dump ends.
2010-02-17 16:59:54 [23973] [4] DEBUG: SMPP PDU dump ends.
2010-02-17 16:59:54 [23973] [4] DEBUG:
SMPP[SMPP:server2.msgtoolbox.com:2775/2775:USER:G1] handle_pdu, got DLR
2010-02-17 16:59:54 [23973] [4] DEBUG: DLR[mysql]: Looking for DLR
smsc=SMPP:server2.msgtoolbox.com:2775/2775:USER:G1,
ts=9223372036854775807, dst=4670xxxxxxx, type=2
2010-02-17 16:59:54 [23973] [4] DEBUG: sql: SELECT `mask`, `service`,
`url`, `source`, `destination`, `bind_transceiver_respoxc` FROM `dlr`
WHERE `smsc`=? AND `ts`=? LIMIT 1
2010-02-17 16:59:54 [23973] [4] DEBUG: column=mask buffer_type=2
max_length=0 length=6
2010-02-17 16:59:54 [23973] [4] DEBUG: column=service buffer_type=253
max_length=0 length=40
2010-02-17 16:59:54 [23973] [4] DEBUG: column=url buffer_type=253
max_length=0 length=255
2010-02-17 16:59:54 [23973] [4] DEBUG: column=source buffer_type=253
max_length=0 length=40
2010-02-17 16:59:54 [23973] [4] DEBUG: column=destination
buffer_type=253 max_length=0 length=40
2010-02-17 16:59:54 [23973] [4] DEBUG: column=boxc buffer_type=253
max_length=0 length=40
2010-02-17 16:59:54 [23973] [4] DEBUG: DLR[mysql]: created DLR message
for URL <http://127.0.0.1/dlr.php?msgid=1&state=%d&msisdn=%p>
2010-02-17 16:59:54 [23973] [4] DEBUG: removing DLR from database
2010-02-17 16:59:54 [23973] [4] DEBUG: sql: DELETE FROM `dlr` WHERE
`smsc`=? AND `ts`=? LIMIT 1
2010-02-17 16:59:54 [23973] [4] DEBUG: new group created `smpp'
2010-02-17 16:59:54 [23973] [4] DEBUG: group=`smpp' key=`dlr_err'
value=`000'
2010-02-17 16:59:56 [23973] [4] PANIC: gwlib/gw-rwlock.c:137:
gw_rwlock_rdlock: Assertion `lock != NULL' failed.
2010-02-17 16:59:56 [23973] [4] PANIC: ./bearerbox(gw_panic+0x16d)
[0x48660d]
2010-02-17 16:59:56 [23973] [4] PANIC: ./bearerbox(gw_rwlock_rdlock
+0x4d) [0x47c13d]
2010-02-17 16:59:56 [23973] [4] PANIC: ./
bearerbox(route_incoming_to_boxc+0x58) [0x4119a8]
2010-02-17 16:59:56 [23973] [4] PANIC: ./bearerbox(bb_smscconn_receive
+0x57c) [0x41805c]
2010-02-17 16:59:56 [23973] [4] PANIC: ./bearerbox [0x45535d]
2010-02-17 16:59:56 [23973] [4] PANIC: ./bearerbox [0x45639c]
2010-02-17 16:59:56 [23973] [4] PANIC: ./bearerbox [0x47d495]
2010-02-17 16:59:56 [23973] [4] PANIC: /lib/libpthread.so.0
[0x2ad8100b23f7]
2010-02-17 16:59:56 [23973] [4] PANIC: /lib/libc.so.6(clone+0x6d)
[0x2ad810a67b2d]
Here is my conf:
group = core
admin-port = 13000
admin-password = bar
admin-deny-ip = ""
admin-allow-ip = "127.0.0.1"
wapbox-port = 13001
wdp-interface-name = "*"
log-file = "/var/log/kannel/bearerbox.log"
box-deny-ip = "*.*.*.*"
box-allow-ip = "127.0.0.1"
dlr-storage = mysql
#dlr-storage = internal
group = mysql-connection
id = mydlr
host = localhost
username = dlr
password = dlr
database = dlr
max-connections = 1
group = dlr-db
id = mydlr
table = dlr
field-smsc = smsc
field-timestamp = ts
field-destination = destination
field-source = source
field-service = service
field-url = url
field-mask = mask
field-status = status
field-boxc-id = boxc
group = wapbox
bearerbox-host = localhost
log-file = "/var/log/kannel/wapbox.log"
group = smsc
smsc = smpp
host = server2.msgtoolbox.com
port = 2775
receive-port = 0
smsc-username = "USER"
smsc-password = PASS
system-type = "G1"
address-range = ""
transceiver-mode = 1
msg-id-type=0x01
group = smsbox
bearerbox-host = 127.0.0.1
sendsms-port = 13013
global-sender = 123
log-file = "smsbox.log"
group = sms-service
keyword = default
text = "No service specified"
catch-all = true
get-url = "http://localhost/sms/?seq=%I&from=%p&to=%P&text=%a";
max-messages = 0
group = sendsms-user
username = paymms
password = paymms
#max-messages = 10
concatenation = true
Im have tryed stable, dev release and log is from CVS
//Jens Haag
