Armin Schindler wrote:
I have a different setup. One side is ISDN (alaw) and the other side is SIP
with a Grandstream BT100.
1) sip.conf: gsm only
a) SIP -> CAPI: refused with 'No compatible codecs'
This seems to be right, because Grandstream does not support GSM!?
b) CAPI-> SIP : voice connection is made, but no sound. 'sip show
channels' reports ulaw !!!
2) sip.conf: ilbc only
a) SIP -> CAPI: voice works, but console reports some warnings about
ilbctoslin gets wrong frame size.
b) CAPI-> SIP : voice doesn't work and the ilbctoslin warnings don't
stop.
3) sip.conf: allow alaw as well
Voice works in one direction only. I didn't test the transfer, since
the problem is there from the beginning.
Any hint where to dig?
I will try to find out more, maybe with some more debug...
Here is the debug from our PBX (apologies to anybody who doesn't like
receiving this, but hopefully the more pairs of eyes on this problem,
the better).
I don't know the channel stuff well enough to determine exactly where it
is going wrong, but to my untrained eye, it appears to be setting one of
the CAPI channel to format 'slin', even after it's come off MoH.
Shouldn't this be setting it to the codec of the call, ie. alaw, at this
point?
Dec 20 13:54:35 DEBUG[3055983536] channel.c: Hanging up channel
'CAPI/ISDN2/5251713-1b'
Dec 20 13:54:35 DEBUG[3077995440] devicestate.c: Changing state for
CAPI/ISDN2/5251713 - state 0 (Unknown)
Dec 20 13:54:35 DEBUG[3052211120] app_queue.c: Device 'CAPI/ISDN2/5251713'
changed to state '0' (Unknown)
Dec 20 13:54:43 DEBUG[3055479728] chan_sip.c: = No match Their Call ID: [EMAIL
PROTECTED] Their Tag extc4jadty Our tag: as4155d6a8
Dec 20 13:54:43 DEBUG[3055479728] chan_sip.c: = No match Their Call ID: [EMAIL
PROTECTED] Their Tag 866qhvi8ay Our tag: as35bb2f8f
Dec 20 13:54:43 DEBUG[3055479728] chan_sip.c: = No match Their Call ID: [EMAIL
PROTECTED] Their Tag t1nrnaibpc Our tag: as06d10c1f
Dec 20 13:54:43 DEBUG[3055479728] chan_sip.c: = No match Their Call ID: [EMAIL
PROTECTED] Their Tag ba7wlg3keb Our tag: as4d554dea
Dec 20 13:54:43 DEBUG[3055479728] chan_sip.c: = No match Their Call ID: [EMAIL
PROTECTED] Their Tag 088464lv9q Our tag: as2fe26821
Dec 20 13:54:43 DEBUG[3055479728] chan_sip.c: = No match Their Call ID: [EMAIL
PROTECTED] Their Tag 5bkbwa4hv1 Our tag: as24aee1eb
Dec 20 13:54:43 DEBUG[3055479728] chan_sip.c: Allocating new SIP dialog for
[EMAIL PROTECTED] - SUBSCRIBE (No RTP)
Dec 20 13:54:43 DEBUG[3055479728] chan_sip.c: **** Received SUBSCRIBE (10) -
Command in SIP SUBSCRIBE
Dec 20 13:54:43 DEBUG[3055479728] chan_sip.c: Adding subscription for extension
*22 context all-users for peer 590
Dec 20 13:54:48 DEBUG[3055479728] chan_sip.c: = No match Their Call ID: [EMAIL
PROTECTED] Their Tag extc4jadty Our tag: as4155d6a8
Dec 20 13:54:48 DEBUG[3055479728] chan_sip.c: = No match Their Call ID: [EMAIL
PROTECTED] Their Tag 866qhvi8ay Our tag: as35bb2f8f
Dec 20 13:54:48 DEBUG[3055479728] chan_sip.c: = No match Their Call ID: [EMAIL
PROTECTED] Their Tag t1nrnaibpc Our tag: as06d10c1f
Dec 20 13:54:48 DEBUG[3055479728] chan_sip.c: = No match Their Call ID: [EMAIL
PROTECTED] Their Tag ba7wlg3keb Our tag: as4d554dea
Dec 20 13:54:48 DEBUG[3055479728] chan_sip.c: = No match Their Call ID: [EMAIL
PROTECTED] Their Tag 088464lv9q Our tag: as2fe26821
Dec 20 13:54:48 DEBUG[3055479728] chan_sip.c: = No match Their Call ID: [EMAIL
PROTECTED] Their Tag 5bkbwa4hv1 Our tag: as24aee1eb
Dec 20 13:54:48 DEBUG[3055479728] chan_sip.c: Allocating new SIP dialog for
[EMAIL PROTECTED] - SUBSCRIBE (No RTP)
Dec 20 13:54:48 DEBUG[3055479728] chan_sip.c: **** Received SUBSCRIBE (10) -
Command in SIP SUBSCRIBE
Dec 20 13:54:57 DEBUG[3055983536] channel.c: Hanging up channel
'CAPI/ISDN2/5251713-1d'
Dec 20 13:54:57 DEBUG[3077995440] devicestate.c: Changing state for
CAPI/ISDN2/5251713 - state 0 (Unknown)
Dec 20 13:54:57 DEBUG[3052211120] app_queue.c: Device 'CAPI/ISDN2/5251713'
changed to state '0' (Unknown)
Dec 20 13:55:00 DEBUG[3055479728] chan_sip.c: = No match Their Call ID: [EMAIL
PROTECTED] Their Tag extc4jadty Our tag: as4155d6a8
Dec 20 13:55:00 DEBUG[3055479728] chan_sip.c: = No match Their Call ID: [EMAIL
PROTECTED] Their Tag 866qhvi8ay Our tag: as35bb2f8f
Dec 20 13:55:00 DEBUG[3055479728] chan_sip.c: = No match Their Call ID: [EMAIL
PROTECTED] Their Tag t1nrnaibpc Our tag: as06d10c1f
Dec 20 13:55:00 DEBUG[3055479728] chan_sip.c: = No match Their Call ID: [EMAIL
PROTECTED] Their Tag ba7wlg3keb Our tag: as4d554dea
Dec 20 13:55:00 DEBUG[3055479728] chan_sip.c: = No match Their Call ID: [EMAIL
PROTECTED] Their Tag 088464lv9q Our tag: as2fe26821
Dec 20 13:55:00 DEBUG[3055479728] chan_sip.c: = No match Their Call ID: [EMAIL
PROTECTED] Their Tag 5bkbwa4hv1 Our tag: as24aee1eb
Dec 20 13:55:00 DEBUG[3055479728] chan_sip.c: Allocating new SIP dialog for
[EMAIL PROTECTED] - SUBSCRIBE (No RTP)
Dec 20 13:55:00 DEBUG[3055479728] chan_sip.c: **** Received SUBSCRIBE (10) -
Command in SIP SUBSCRIBE
Dec 20 13:55:01 DEBUG[3055983536] channel.c: Hanging up channel
'CAPI/ISDN2/5251713-1f'
Dec 20 13:55:01 DEBUG[3077995440] devicestate.c: Changing state for
CAPI/ISDN2/5251713 - state 0 (Unknown)
Dec 20 13:55:01 DEBUG[3052211120] app_queue.c: Device 'CAPI/ISDN2/5251713'
changed to state '0' (Unknown)
Dec 20 13:55:18 DEBUG[3055479728] chan_sip.c: = No match Their Call ID: [EMAIL
PROTECTED] Their Tag extc4jadty Our tag: as4155d6a8
Dec 20 13:55:18 DEBUG[3055479728] chan_sip.c: = No match Their Call ID: [EMAIL
PROTECTED] Their Tag 866qhvi8ay Our tag: as35bb2f8f
Dec 20 13:55:18 DEBUG[3055479728] chan_sip.c: = No match Their Call ID: [EMAIL
PROTECTED] Their Tag t1nrnaibpc Our tag: as06d10c1f
Dec 20 13:55:18 DEBUG[3055479728] chan_sip.c: = No match Their Call ID: [EMAIL
PROTECTED] Their Tag ba7wlg3keb Our tag: as4d554dea
Dec 20 13:55:18 DEBUG[3055479728] chan_sip.c: = No match Their Call ID: [EMAIL
PROTECTED] Their Tag 088464lv9q Our tag: as2fe26821
Dec 20 13:55:18 DEBUG[3055479728] chan_sip.c: = No match Their Call ID: [EMAIL
PROTECTED] Their Tag 5bkbwa4hv1 Our tag: as24aee1eb
Dec 20 13:55:18 DEBUG[3055479728] chan_sip.c: Allocating new SIP dialog for
[EMAIL PROTECTED] - SUBSCRIBE (No RTP)
Dec 20 13:55:18 DEBUG[3055479728] chan_sip.c: **** Received SUBSCRIBE (10) -
Command in SIP SUBSCRIBE
Dec 20 13:55:26 DEBUG[3055983536] channel.c: Hanging up channel
'CAPI/ISDN3/5251775-21'
Dec 20 13:55:26 DEBUG[3077995440] devicestate.c: Changing state for
CAPI/ISDN3/5251775 - state 0 (Unknown)
Dec 20 13:55:26 DEBUG[3052735408] app_queue.c: Device 'CAPI/ISDN3/5251775'
changed to state '0' (Unknown)
Dec 20 13:55:30 DEBUG[3055983536] channel.c: Hanging up channel
'CAPI/ISDN3/5251775-23'
Dec 20 13:55:30 DEBUG[3077995440] devicestate.c: Changing state for
CAPI/ISDN3/5251775 - state 0 (Unknown)
Dec 20 13:55:30 DEBUG[3052735408] app_queue.c: Device 'CAPI/ISDN3/5251775'
changed to state '0' (Unknown)
Dec 20 13:55:31 DEBUG[3055479728] chan_sip.c: = No match Their Call ID: [EMAIL
PROTECTED] Their Tag extc4jadty Our tag: as4155d6a8
Dec 20 13:55:31 DEBUG[3055479728] chan_sip.c: = No match Their Call ID: [EMAIL
PROTECTED] Their Tag 866qhvi8ay Our tag: as35bb2f8f
Dec 20 13:55:31 DEBUG[3055479728] chan_sip.c: = No match Their Call ID: [EMAIL
PROTECTED] Their Tag t1nrnaibpc Our tag: as06d10c1f
Dec 20 13:55:31 DEBUG[3055479728] chan_sip.c: = No match Their Call ID: [EMAIL
PROTECTED] Their Tag ba7wlg3keb Our tag: as4d554dea
Dec 20 13:55:31 DEBUG[3055479728] chan_sip.c: = No match Their Call ID: [EMAIL
PROTECTED] Their Tag 088464lv9q Our tag: as2fe26821
Dec 20 13:55:31 DEBUG[3055479728] chan_sip.c: = No match Their Call ID: [EMAIL
PROTECTED] Their Tag 5bkbwa4hv1 Our tag: as24aee1eb
Dec 20 13:55:31 DEBUG[3055479728] chan_sip.c: Allocating new SIP dialog for
[EMAIL PROTECTED] - SUBSCRIBE (No RTP)
Dec 20 13:55:31 DEBUG[3055479728] chan_sip.c: **** Received SUBSCRIBE (10) -
Command in SIP SUBSCRIBE
Dec 20 13:55:48 DEBUG[3055479728] chan_sip.c: = No match Their Call ID: [EMAIL
PROTECTED] Their Tag extc4jadty Our tag: as4155d6a8
Dec 20 13:55:48 DEBUG[3055479728] chan_sip.c: = No match Their Call ID: [EMAIL
PROTECTED] Their Tag 866qhvi8ay Our tag: as35bb2f8f
Dec 20 13:55:48 DEBUG[3055479728] chan_sip.c: = No match Their Call ID: [EMAIL
PROTECTED] Their Tag t1nrnaibpc Our tag: as06d10c1f
Dec 20 13:55:48 DEBUG[3055479728] chan_sip.c: = No match Their Call ID: [EMAIL
PROTECTED] Their Tag ba7wlg3keb Our tag: as4d554dea
Dec 20 13:55:48 DEBUG[3055479728] chan_sip.c: = No match Their Call ID: [EMAIL
PROTECTED] Their Tag 088464lv9q Our tag: as2fe26821
Dec 20 13:55:48 DEBUG[3055479728] chan_sip.c: = No match Their Call ID: [EMAIL
PROTECTED] Their Tag 5bkbwa4hv1 Our tag: as24aee1eb
Dec 20 13:55:48 DEBUG[3055479728] chan_sip.c: Allocating new SIP dialog for
[EMAIL PROTECTED] - SUBSCRIBE (No RTP)
Dec 20 13:55:48 DEBUG[3055479728] chan_sip.c: **** Received SUBSCRIBE (10) -
Command in SIP SUBSCRIBE
Dec 20 13:55:50 DEBUG[3052735408] res_features.c: Removed old parking extension
[EMAIL PROTECTED]
Dec 20 13:55:50 DEBUG[3052735408] pbx_dundi.c: Seeding global EID
'00:13:20:5e:ac:0c' from 'eth0'
Dec 20 13:55:50 DEBUG[3052735408] chan_sip.c: Checking device state for peer 500
Dec 20 13:55:50 DEBUG[3052735408] chan_sip.c: Bah, we're expired
(5447/1135034703/1135040150)!
Dec 20 13:55:50 DEBUG[3052735408] chan_sip.c: Checking device state for peer 570
Dec 20 13:55:50 DEBUG[3052735408] chan_sip.c: Checking device state for peer 578
Dec 20 13:55:50 DEBUG[3052735408] chan_sip.c: Checking device state for peer 580
Dec 20 13:55:50 DEBUG[3052735408] chan_sip.c: Bah, we're expired
(170399/1134869751/1135040150)!
Dec 20 13:55:50 DEBUG[3052735408] chan_sip.c: Checking device state for peer 581
Dec 20 13:55:50 DEBUG[3052735408] chan_sip.c: Bah, we're expired
(170403/1134869747/1135040150)!
Dec 20 13:55:50 DEBUG[3052735408] chan_sip.c: Checking device state for peer 582
Dec 20 13:55:50 DEBUG[3052735408] chan_sip.c: Bah, we're expired
(170406/1134869744/1135040150)!
Dec 20 13:55:50 DEBUG[3052735408] chan_sip.c: Checking device state for peer 583
Dec 20 13:55:50 DEBUG[3052735408] chan_sip.c: Checking device state for peer 584
Dec 20 13:55:50 DEBUG[3052735408] chan_sip.c: Bah, we're expired
(170403/1134869747/1135040150)!
Dec 20 13:55:50 DEBUG[3052735408] chan_sip.c: Checking device state for peer 585
Dec 20 13:55:50 DEBUG[3052735408] chan_sip.c: Checking device state for peer 586
Dec 20 13:55:50 DEBUG[3052735408] chan_sip.c: Checking device state for peer 587
Dec 20 13:55:50 DEBUG[3052735408] chan_sip.c: Checking device state for peer 588
Dec 20 13:55:50 DEBUG[3052735408] chan_sip.c: Checking device state for peer 589
Dec 20 13:55:50 DEBUG[3052735408] chan_sip.c: Checking device state for peer 590
Dec 20 13:55:50 DEBUG[3052735408] chan_sip.c: Checking device state for peer 591
Dec 20 13:55:50 DEBUG[3052735408] chan_sip.c: Checking device state for peer 592
Dec 20 13:55:50 DEBUG[3052735408] chan_sip.c: Checking device state for peer 594
Dec 20 13:55:50 DEBUG[3052735408] chan_sip.c: Bah, we're expired
(170406/1134869744/1135040150)!
Dec 20 13:55:50 DEBUG[3052735408] chan_sip.c: Checking device state for peer 595
Dec 20 13:55:50 DEBUG[3055479728] chan_sip.c: = No match Their Call ID: [EMAIL
PROTECTED] Their Tag extc4jadty Our tag: as4155d6a8
Dec 20 13:55:50 DEBUG[3055479728] chan_sip.c: = No match Their Call ID: [EMAIL
PROTECTED] Their Tag 866qhvi8ay Our tag: as35bb2f8f
Dec 20 13:55:50 DEBUG[3055479728] chan_sip.c: = Found Their Call ID: [EMAIL
PROTECTED] Their Tag t1nrnaibpc Our tag: as06d10c1f
Dec 20 13:55:50 DEBUG[3055479728] chan_sip.c: Stopping retransmission on
'[EMAIL PROTECTED]' of Request 105: Match Found
Dec 20 13:55:50 DEBUG[3052735408] chan_sip.c: Checking device state for peer 596
Dec 20 13:55:50 DEBUG[3055479728] chan_sip.c: = No match Their Call ID: [EMAIL
PROTECTED] Their Tag extc4jadty Our tag: as4155d6a8
Dec 20 13:55:50 DEBUG[3055479728] chan_sip.c: = No match Their Call ID: [EMAIL
PROTECTED] Their Tag 866qhvi8ay Our tag: as35bb2f8f
Dec 20 13:55:50 DEBUG[3055479728] chan_sip.c: = No match Their Call ID: [EMAIL
PROTECTED] Their Tag t1nrnaibpc Our tag: as06d10c1f
Dec 20 13:55:50 DEBUG[3055479728] chan_sip.c: = No match Their Call ID: [EMAIL
PROTECTED] Their Tag ba7wlg3keb Our tag: as4d554dea
Dec 20 13:55:50 DEBUG[3055479728] chan_sip.c: = No match Their Call ID: [EMAIL
PROTECTED] Their Tag 088464lv9q Our tag: as2fe26821
Dec 20 13:55:50 DEBUG[3055479728] chan_sip.c: = Found Their Call ID: [EMAIL
PROTECTED] Their Tag 5bkbwa4hv1 Our tag: as24aee1eb
Dec 20 13:55:50 DEBUG[3055479728] chan_sip.c: Stopping retransmission on
'[EMAIL PROTECTED]' of Request 105: Match Found
Dec 20 13:55:50 DEBUG[3052735408] chan_sip.c: Bah, we're expired
(170406/1134869744/1135040150)!
Dec 20 13:55:50 DEBUG[3052735408] chan_sip.c: Checking device state for peer 597
Dec 20 13:55:50 DEBUG[3055479728] chan_sip.c: = No match Their Call ID: [EMAIL
PROTECTED] Their Tag extc4jadty Our tag: as4155d6a8
Dec 20 13:55:50 DEBUG[3055479728] chan_sip.c: = Found Their Call ID: [EMAIL
PROTECTED] Their Tag 866qhvi8ay Our tag: as35bb2f8f
Dec 20 13:55:50 DEBUG[3055479728] chan_sip.c: Stopping retransmission on
'[EMAIL PROTECTED]' of Request 107: Match Found
Dec 20 13:55:50 DEBUG[3055479728] chan_sip.c: = No match Their Call ID: [EMAIL
PROTECTED] Their Tag extc4jadty Our tag: as4155d6a8
Dec 20 13:55:50 DEBUG[3055479728] chan_sip.c: = No match Their Call ID: [EMAIL
PROTECTED] Their Tag 866qhvi8ay Our tag: as35bb2f8f
Dec 20 13:55:50 DEBUG[3055479728] chan_sip.c: = No match Their Call ID: [EMAIL
PROTECTED] Their Tag t1nrnaibpc Our tag: as06d10c1f
Dec 20 13:55:50 DEBUG[3055479728] chan_sip.c: = No match Their Call ID: [EMAIL
PROTECTED] Their Tag ba7wlg3keb Our tag: as4d554dea
Dec 20 13:55:50 DEBUG[3055479728] chan_sip.c: = Found Their Call ID: [EMAIL
PROTECTED] Their Tag 088464lv9q Our tag: as2fe26821
Dec 20 13:55:50 DEBUG[3055479728] chan_sip.c: Stopping retransmission on
'[EMAIL PROTECTED]' of Request 137: Match Found
Dec 20 13:55:50 DEBUG[3055479728] chan_sip.c: = Found Their Call ID: [EMAIL
PROTECTED] Their Tag extc4jadty Our tag: as4155d6a8
Dec 20 13:55:50 DEBUG[3055479728] chan_sip.c: Stopping retransmission on
'[EMAIL PROTECTED]' of Request 107: Match Found
Dec 20 13:55:50 DEBUG[3055479728] chan_sip.c: = No match Their Call ID: [EMAIL
PROTECTED] Their Tag extc4jadty Our tag: as4155d6a8
Dec 20 13:55:50 DEBUG[3055479728] chan_sip.c: = No match Their Call ID: [EMAIL
PROTECTED] Their Tag 866qhvi8ay Our tag: as35bb2f8f
Dec 20 13:55:50 DEBUG[3055479728] chan_sip.c: = No match Their Call ID: [EMAIL
PROTECTED] Their Tag t1nrnaibpc Our tag: as06d10c1f
Dec 20 13:55:50 DEBUG[3055479728] chan_sip.c: = Found Their Call ID: [EMAIL
PROTECTED] Their Tag ba7wlg3keb Our tag: as4d554dea
Dec 20 13:55:50 DEBUG[3055479728] chan_sip.c: Stopping retransmission on
'[EMAIL PROTECTED]' of Request 107: Match Found
Dec 20 13:56:01 DEBUG[3055479728] chan_sip.c: = No match Their Call ID: [EMAIL
PROTECTED] Their Tag extc4jadty Our tag: as4155d6a8
Dec 20 13:56:01 DEBUG[3055479728] chan_sip.c: = No match Their Call ID: [EMAIL
PROTECTED] Their Tag 866qhvi8ay Our tag: as35bb2f8f
Dec 20 13:56:01 DEBUG[3055479728] chan_sip.c: = No match Their Call ID: [EMAIL
PROTECTED] Their Tag t1nrnaibpc Our tag: as06d10c1f
Dec 20 13:56:01 DEBUG[3055479728] chan_sip.c: = No match Their Call ID: [EMAIL
PROTECTED] Their Tag ba7wlg3keb Our tag: as4d554dea
Dec 20 13:56:01 DEBUG[3055479728] chan_sip.c: = No match Their Call ID: [EMAIL
PROTECTED] Their Tag 088464lv9q Our tag: as2fe26821
Dec 20 13:56:01 DEBUG[3055479728] chan_sip.c: = No match Their Call ID: [EMAIL
PROTECTED] Their Tag 5bkbwa4hv1 Our tag: as24aee1eb
Dec 20 13:56:01 DEBUG[3055479728] chan_sip.c: Allocating new SIP dialog for
[EMAIL PROTECTED] - SUBSCRIBE (No RTP)
Dec 20 13:56:01 DEBUG[3055479728] chan_sip.c: **** Received SUBSCRIBE (10) -
Command in SIP SUBSCRIBE
Dec 20 13:56:05 DEBUG[3055479728] chan_sip.c: Auto destroying call '[EMAIL
PROTECTED]'
Dec 20 13:56:05 DEBUG[3055479728] chan_sip.c: Auto destroying call '[EMAIL
PROTECTED]'
Dec 20 13:56:05 DEBUG[3055479728] chan_sip.c: Auto destroying call '[EMAIL
PROTECTED]'
Dec 20 13:56:05 DEBUG[3055479728] chan_sip.c: Auto destroying call '[EMAIL
PROTECTED]'
Dec 20 13:56:05 DEBUG[3055479728] chan_sip.c: Auto destroying call '[EMAIL
PROTECTED]'
Dec 20 13:56:05 DEBUG[3055479728] chan_sip.c: Auto destroying call '[EMAIL
PROTECTED]'
Dec 20 13:56:06 DEBUG[3077995440] devicestate.c: Changing state for
CAPI/ISDN2/5251713 - state 2 (In use)
Dec 20 13:56:06 DEBUG[3052211120] pbx.c: Launching 'Dial'
Dec 20 13:56:06 DEBUG[3052211120] chan_sip.c: Allocating new SIP dialog for (No
Call-ID) - INVITE (With RTP)
Dec 20 13:56:06 DEBUG[3052473264] app_queue.c: Device 'CAPI/ISDN2/5251713'
changed to state '2' (In use)
Dec 20 13:56:06 DEBUG[3052211120] chan_sip.c: Setting NAT on RTP to 0
Dec 20 13:56:06 DEBUG[3052211120] chan_sip.c: Setting NAT on VRTP to 0
Dec 20 13:56:06 DEBUG[3052211120] channel.c: Not copying variable
STACK-default-5251713-1.
Dec 20 13:56:06 DEBUG[3052211120] channel.c: Not copying variable CALLEDTON.
Dec 20 13:56:06 DEBUG[3052211120] channel.c: Not copying variable BCHANNELINFO.
Dec 20 13:56:06 DEBUG[3052211120] channel.c: Not copying variable
TRANSFERCAPABILITY.
Dec 20 13:56:06 DEBUG[3052211120] chan_sip.c: Outgoing Call for 570
Dec 20 13:56:06 DEBUG[3052211120] chan_sip.c: Updating call counter for
outgoing call
Dec 20 13:56:06 DEBUG[3052211120] channel.c: Set channel SIP/570-2f5b to read
format slin
Dec 20 13:56:06 DEBUG[3052211120] channel.c: Set channel CAPI/ISDN2/5251713-25
to write format slin
Dec 20 13:56:06 DEBUG[3052211120] channel.c: Set channel CAPI/ISDN2/5251713-25
to read format slin
Dec 20 13:56:06 DEBUG[3052211120] channel.c: Set channel SIP/570-2f5b to write
format slin
Dec 20 13:56:06 DEBUG[3055479728] chan_sip.c: = Found Their Call ID: [EMAIL
PROTECTED] Their Tag Our tag: as10a4821d
Dec 20 13:56:06 DEBUG[3055479728] chan_sip.c: (Provisional) Stopping
retransmission (but retaining packet) on '[EMAIL PROTECTED]' Request 102: Found
Dec 20 13:56:06 DEBUG[3055479728] chan_sip.c: SIP response 180 to standard
invite
Dec 20 13:56:06 DEBUG[3077995440] chan_sip.c: Checking device state for peer 570
Dec 20 13:56:06 DEBUG[3077995440] devicestate.c: Changing state for SIP/570 -
state 6 (Ringing)
Dec 20 13:56:06 DEBUG[3077995440] chan_sip.c: Checking device state for peer 570
Dec 20 13:56:06 DEBUG[3052473264] app_queue.c: Device 'SIP/570' changed to
state '6' (Ringing)
Dec 20 13:56:07 DEBUG[3055479728] chan_sip.c: = Found Their Call ID: [EMAIL
PROTECTED] Their Tag fit4eu6umm Our tag: as10a4821d
Dec 20 13:56:07 DEBUG[3055479728] chan_sip.c: (Provisional) Stopping
retransmission (but retaining packet) on '[EMAIL PROTECTED]' Request 102: Found
Dec 20 13:56:07 DEBUG[3055479728] chan_sip.c: SIP response 180 to standard
invite
Dec 20 13:56:08 DEBUG[3055479728] chan_sip.c: = Found Their Call ID: [EMAIL
PROTECTED] Their Tag fit4eu6umm Our tag: as10a4821d
Dec 20 13:56:08 DEBUG[3055479728] chan_sip.c: (Provisional) Stopping
retransmission (but retaining packet) on '[EMAIL PROTECTED]' Request 102: Found
Dec 20 13:56:08 DEBUG[3055479728] chan_sip.c: SIP response 180 to standard
invite
Dec 20 13:56:10 DEBUG[3055479728] chan_sip.c: = Found Their Call ID: [EMAIL
PROTECTED] Their Tag fit4eu6umm Our tag: as10a4821d
Dec 20 13:56:10 DEBUG[3055479728] chan_sip.c: (Provisional) Stopping
retransmission (but retaining packet) on '[EMAIL PROTECTED]' Request 102: Found
Dec 20 13:56:10 DEBUG[3055479728] chan_sip.c: SIP response 180 to standard
invite
Dec 20 13:56:11 DEBUG[3055479728] chan_sip.c: = Found Their Call ID: [EMAIL
PROTECTED] Their Tag fit4eu6umm Our tag: as10a4821d
Dec 20 13:56:11 DEBUG[3055479728] chan_sip.c: Acked pending invite 102
Dec 20 13:56:11 DEBUG[3055479728] chan_sip.c: Stopping retransmission on
'[EMAIL PROTECTED]' of Request 102: Match Found
Dec 20 13:56:11 DEBUG[3055479728] chan_sip.c: SIP response 200 to standard
invite
Dec 20 13:56:11 DEBUG[3055479728] chan_sip.c: Oooh, we need to change our
formats since our peer supports only 0x8 (alaw) and not 0x4 (ulaw)
Dec 20 13:56:11 DEBUG[3055479728] channel.c: Set channel SIP/570-2f5b to read
format slin
Dec 20 13:56:11 DEBUG[3055479728] channel.c: Set channel SIP/570-2f5b to write
format slin
Dec 20 13:56:11 DEBUG[3055479728] chan_sip.c: build_route: Contact hop:
<sip:[EMAIL PROTECTED]:5060;line=m42d4329>
Dec 20 13:56:11 DEBUG[3052211120] channel.c: Set channel CAPI/ISDN2/5251713-25
to read format alaw
Dec 20 13:56:11 DEBUG[3052211120] channel.c: Set channel SIP/570-2f5b to write
format alaw
Dec 20 13:56:11 DEBUG[3052211120] channel.c: Set channel SIP/570-2f5b to read
format alaw
Dec 20 13:56:11 DEBUG[3052211120] channel.c: Set channel CAPI/ISDN2/5251713-25
to write format alaw
Dec 20 13:56:11 DEBUG[3077995440] chan_sip.c: Checking device state for peer 570
Dec 20 13:56:11 DEBUG[3077995440] devicestate.c: Changing state for SIP/570 -
state 2 (In use)
Dec 20 13:56:11 DEBUG[3077995440] chan_sip.c: Checking device state for peer 570
Dec 20 13:56:11 DEBUG[3052473264] app_queue.c: Device 'SIP/570' changed to
state '2' (In use)
Dec 20 13:56:11 DEBUG[3077995440] devicestate.c: Changing state for
CAPI/ISDN2/5251713 - state 2 (In use)
Dec 20 13:56:11 DEBUG[3052473264] app_queue.c: Device 'CAPI/ISDN2/5251713'
changed to state '2' (In use)
Dec 20 13:56:11 DEBUG[3052211120] channel.c: Dropping duplicate answer!
Dec 20 13:56:11 DEBUG[3052211120] rtp.c: Ooh, format changed from unknown to
alaw
Dec 20 13:56:14 DEBUG[3055479728] chan_sip.c: = Found Their Call ID: [EMAIL
PROTECTED] Their Tag fit4eu6umm Our tag: as10a4821d
Dec 20 13:56:14 DEBUG[3055479728] chan_sip.c: **** Received INVITE (5) -
Command in SIP INVITE
Dec 20 13:56:14 DEBUG[3055479728] chan_sip.c: * SIP extension value: 7 for call
[EMAIL PROTECTED]
Dec 20 13:56:14 DEBUG[3055479728] channel.c: Set channel CAPI/ISDN2/5251713-25
to write format slin
Dec 20 13:56:14 DEBUG[3052473264] generator.c: Generator thread started.
Dec 20 13:56:14 DEBUG[3052473264] channel.c: Set channel CAPI/ISDN2/5251713-25
to write format slin
Dec 20 13:56:14 DEBUG[3052473264] channel.c: Set channel CAPI/ISDN2/5251713-25
to write format slin
Dec 20 13:56:14 DEBUG[3052473264] res_musiconhold.c: CAPI/ISDN2/5251713-25
Opened file 6 '/usr/share/openpbx.org/moh/track07'
Dec 20 13:56:14 DEBUG[3055479728] chan_sip.c: = Found Their Call ID: [EMAIL
PROTECTED] Their Tag fit4eu6umm Our tag: as10a4821d
Dec 20 13:56:14 DEBUG[3055479728] chan_sip.c: **** Received ACK (6) - Command
in SIP ACK
Dec 20 13:56:14 DEBUG[3055479728] chan_sip.c: Stopping retransmission on
'[EMAIL PROTECTED]' of Response 1: Match Found
Dec 20 13:56:18 DEBUG[3055479728] chan_sip.c: = No match Their Call ID: [EMAIL
PROTECTED] Their Tag fit4eu6umm Our tag: as10a4821d
Dec 20 13:56:18 DEBUG[3055479728] chan_sip.c: Allocating new SIP dialog for
[EMAIL PROTECTED] - SUBSCRIBE (No RTP)
Dec 20 13:56:18 DEBUG[3055479728] chan_sip.c: **** Received SUBSCRIBE (10) -
Command in SIP SUBSCRIBE
Dec 20 13:56:19 DEBUG[3055479728] chan_sip.c: = Found Their Call ID: [EMAIL
PROTECTED] Their Tag fit4eu6umm Our tag: as10a4821d
Dec 20 13:56:19 DEBUG[3055479728] chan_sip.c: **** Received REFER (9) - Command
in SIP REFER
Dec 20 13:56:19 DEBUG[3055479728] chan_sip.c: SIP call transfer received for
call [EMAIL PROTECTED] (REFER)!
Dec 20 13:56:19 DEBUG[3055479728] chan_sip.c: Unsupervised transfer to
(Refer-To): 578
Dec 20 13:56:19 DEBUG[3055479728] chan_sip.c: Transferred by (Referred-by: )
570
Dec 20 13:56:19 DEBUG[3055479728] chan_sip.c: Transfer Contact Info <sip:[EMAIL
PROTECTED]:5060;line=m42d4329> (REFER_CONTACT)
Dec 20 13:56:19 DEBUG[3055479728] chan_sip.c: 202 Accepted (blind)
Dec 20 13:56:19 DEBUG[3055479728] chan_sip.c: Got SIP blind transfer, applying
to 'CAPI/ISDN2/5251713-25'
Dec 20 13:56:19 DEBUG[3055479728] channel.c: Soft-Hanging up channel
'CAPI/ISDN2/5251713-25'
Dec 20 13:56:19 DEBUG[3052473264] channel.c: Set channel CAPI/ISDN2/5251713-25
to write format alaw
Dec 20 13:56:19 DEBUG[3052211120] channel.c: Nobody there, continuing...
Dec 20 13:56:19 DEBUG[3052211120] channel.c: Didn't get a frame from channel:
CAPI/ISDN2/5251713-25
Dec 20 13:56:19 DEBUG[3052211120] channel.c: Bridge stops bridging channels
CAPI/ISDN2/5251713-25 and SIP/570-2f5b
Dec 20 13:56:19 DEBUG[3052211120] channel.c: Hanging up channel 'SIP/570-2f5b'
Dec 20 13:56:19 DEBUG[3052211120] chan_sip.c: Hangup call SIP/570-2f5b, SIP
callid [EMAIL PROTECTED])
Dec 20 13:56:19 DEBUG[3052211120] chan_sip.c: update_call_counter(570) -
decrement call limit counter
Dec 20 13:56:19 DEBUG[3052211120] chan_sip.c: Updating call counter for
incoming call
Dec 20 13:56:19 DEBUG[3052211120] app_dial.c: Exiting with DIALSTATUS=ANSWER.
Dec 20 13:56:19 DEBUG[3052211120] pbx.c: Spawn extension (all-users,578,0)
exited non-zero on 'CAPI/ISDN2/5251713-25'
Dec 20 13:56:19 DEBUG[3052211120] pbx.c: Launching 'Macro'
Dec 20 13:56:19 DEBUG[3052211120] pbx.c: Function result is ''
Dec 20 13:56:19 DEBUG[3052211120] pbx.c: Launching 'Set'
Dec 20 13:56:19 DEBUG[3052211120] pbx.c: Expression result is '1'
Dec 20 13:56:19 DEBUG[3052211120] pbx.c: Launching 'GotoIf'
Dec 20 13:56:19 DEBUG[3052211120] pbx.c: Launching 'Dial'
Dec 20 13:56:19 DEBUG[3052211120] app_dial.c: SIMPLE DIAL (NO URL)
Dec 20 13:56:19 DEBUG[3052211120] chan_sip.c: Allocating new SIP dialog for (No
Call-ID) - INVITE (With RTP)
Dec 20 13:56:19 DEBUG[3077995440] chan_sip.c: Checking device state for peer 570
Dec 20 13:56:19 DEBUG[3052211120] chan_sip.c: Setting NAT on RTP to 0
Dec 20 13:56:19 DEBUG[3052211120] chan_sip.c: Setting NAT on VRTP to 0
Dec 20 13:56:19 DEBUG[3052211120] channel.c: Not copying variable
STACK-macro-pbx-extn-vmail-s-3.
Dec 20 13:56:19 DEBUG[3052211120] channel.c: Not copying variable MACRO_DEPTH.
Dec 20 13:56:19 DEBUG[3052211120] channel.c: Not copying variable
STACK-macro-pbx-extn-vmail-s-2.
Dec 20 13:56:19 DEBUG[3052211120] channel.c: Not copying variable CFIM.
Dec 20 13:56:19 DEBUG[3052211120] channel.c: Not copying variable
STACK-macro-pbx-extn-vmail-s-1.
Dec 20 13:56:19 DEBUG[3052211120] channel.c: Not copying variable ARG2.
Dec 20 13:56:19 DEBUG[3052211120] channel.c: Not copying variable ARG1.
Dec 20 13:56:19 DEBUG[3052211120] channel.c: Not copying variable
MACRO_PRIORITY.
Dec 20 13:56:19 DEBUG[3052211120] channel.c: Not copying variable MACRO_CONTEXT.
Dec 20 13:56:19 DEBUG[3052211120] channel.c: Not copying variable MACRO_EXTEN.
Dec 20 13:56:19 DEBUG[3052211120] channel.c: Not copying variable
STACK-all-users-578-1.
Dec 20 13:56:19 DEBUG[3052211120] channel.c: Not copying variable DIALSTATUS.
Dec 20 13:56:19 DEBUG[3052211120] channel.c: Not copying variable ANSWEREDTIME.
Dec 20 13:56:19 DEBUG[3052211120] channel.c: Not copying variable DIALEDTIME.
Dec 20 13:56:19 DEBUG[3052211120] channel.c: Not copying variable BLINDTRANSFER.
Dec 20 13:56:19 DEBUG[3052211120] channel.c: Not copying variable BRIDGEPEER.
Dec 20 13:56:19 DEBUG[3052211120] channel.c: Not copying variable
DIALEDPEERNUMBER.
Dec 20 13:56:19 DEBUG[3052211120] channel.c: Not copying variable
DIALEDPEERNAME.
Dec 20 13:56:19 DEBUG[3052211120] channel.c: Not copying variable
STACK-default-5251713-1.
Dec 20 13:56:19 DEBUG[3052211120] channel.c: Not copying variable CALLEDTON.
Dec 20 13:56:19 DEBUG[3052211120] channel.c: Not copying variable BCHANNELINFO.
Dec 20 13:56:19 DEBUG[3052211120] channel.c: Not copying variable
TRANSFERCAPABILITY.
Dec 20 13:56:19 DEBUG[3052211120] chan_sip.c: Outgoing Call for 578
Dec 20 13:56:19 DEBUG[3052211120] chan_sip.c: Updating call counter for
outgoing call
Dec 20 13:56:19 DEBUG[3052211120] channel.c: Set channel SIP/578-b426 to read
format slin
Dec 20 13:56:19 DEBUG[3052211120] channel.c: Set channel CAPI/ISDN2/5251713-25
to write format slin
Dec 20 13:56:19 DEBUG[3052211120] channel.c: Set channel CAPI/ISDN2/5251713-25
to read format slin
Dec 20 13:56:19 DEBUG[3052211120] channel.c: Set channel SIP/578-b426 to write
format slin
Dec 20 13:56:19 DEBUG[3077995440] devicestate.c: Changing state for SIP/570 -
state 1 (Not in use)
Dec 20 13:56:19 DEBUG[3077995440] chan_sip.c: Checking device state for peer 570
Dec 20 13:56:19 DEBUG[3051883440] app_queue.c: Device 'SIP/570' changed to
state '1' (Not in use)
Dec 20 13:56:19 DEBUG[3055479728] chan_sip.c: = Found Their Call ID: [EMAIL
PROTECTED] Their Tag Our tag: as12296aed
Dec 20 13:56:19 DEBUG[3055479728] chan_sip.c: (Provisional) Stopping
retransmission (but retaining packet) on '[EMAIL PROTECTED]' Request 102: Found
Dec 20 13:56:19 DEBUG[3055479728] chan_sip.c: SIP response 100 to standard
invite
Dec 20 13:56:19 DEBUG[3055479728] chan_sip.c: = Found Their Call ID: [EMAIL
PROTECTED] Their Tag Our tag: as12296aed
Dec 20 13:56:19 DEBUG[3055479728] chan_sip.c: (Provisional) Stopping
retransmission (but retaining packet) on '[EMAIL PROTECTED]' Request 102: Found
Dec 20 13:56:19 DEBUG[3055479728] chan_sip.c: SIP response 180 to standard
invite
Dec 20 13:56:19 DEBUG[3052211120] channel.c: Driver for channel
'CAPI/ISDN2/5251713-25' does not support indication 3, emulating it
Dec 20 13:56:19 DEBUG[3052211120] channel.c: Set channel CAPI/ISDN2/5251713-25
to write format slin
Dec 20 13:56:19 DEBUG[3077995440] chan_sip.c: Checking device state for peer 578
Dec 20 13:56:19 DEBUG[3077995440] devicestate.c: Changing state for SIP/578 -
state 6 (Ringing)
Dec 20 13:56:19 DEBUG[3077995440] chan_sip.c: Checking device state for peer 578
Dec 20 13:56:19 DEBUG[3051883440] app_queue.c: Device 'SIP/578' changed to
state '6' (Ringing)
Dec 20 13:56:20 DEBUG[3055479728] chan_sip.c: = No match Their Call ID: [EMAIL
PROTECTED] Their Tag 876cba726342e2c6 Our tag: as12296aed
Dec 20 13:56:20 DEBUG[3055479728] chan_sip.c: = Found Their Call ID: [EMAIL
PROTECTED] Their Tag fit4eu6umm Our tag: as10a4821d
Dec 20 13:56:20 DEBUG[3055479728] chan_sip.c: Stopping retransmission on
'[EMAIL PROTECTED]' of Request 103: Match Found
Dec 20 13:56:20 DEBUG[3055479728] chan_sip.c: = No match Their Call ID: [EMAIL
PROTECTED] Their Tag 876cba726342e2c6 Our tag: as12296aed
Dec 20 13:56:20 DEBUG[3055479728] chan_sip.c: = Found Their Call ID: [EMAIL
PROTECTED] Their Tag fit4eu6umm Our tag: as10a4821d
Dec 20 13:56:20 DEBUG[3055479728] chan_sip.c: **** Received BYE (8) - Command
in SIP BYE
Dec 20 13:56:20 DEBUG[3055479728] chan_sip.c: = No match Their Call ID: [EMAIL
PROTECTED] Their Tag 876cba726342e2c6 Our tag: as12296aed
Dec 20 13:56:20 DEBUG[3055479728] chan_sip.c: = Found Their Call ID: [EMAIL
PROTECTED] Their Tag fit4eu6umm Our tag: as10a4821d
Dec 20 13:56:20 DEBUG[3055479728] chan_sip.c: Stopping retransmission on
'[EMAIL PROTECTED]' of Request 104: Match Found
Dec 20 13:56:22 DEBUG[3055479728] chan_sip.c: = Found Their Call ID: [EMAIL
PROTECTED] Their Tag 876cba726342e2c6 Our tag: as12296aed
Dec 20 13:56:22 DEBUG[3055479728] chan_sip.c: Acked pending invite 102
Dec 20 13:56:22 DEBUG[3055479728] chan_sip.c: Stopping retransmission on
'[EMAIL PROTECTED]' of Request 102: Match Found
Dec 20 13:56:22 DEBUG[3055479728] chan_sip.c: SIP response 200 to standard
invite
Dec 20 13:56:22 DEBUG[3055479728] chan_sip.c: Oooh, we need to change our
formats since our peer supports only 0x8 (alaw) and not 0x4 (ulaw)
Dec 20 13:56:22 DEBUG[3055479728] channel.c: Set channel SIP/578-b426 to read
format slin
Dec 20 13:56:22 DEBUG[3055479728] channel.c: Set channel SIP/578-b426 to write
format slin
Dec 20 13:56:22 DEBUG[3055479728] chan_sip.c: build_route: Contact hop:
<sip:[EMAIL PROTECTED]>
Dec 20 13:56:22 DEBUG[3052211120] channel.c: Set channel CAPI/ISDN2/5251713-25
to read format alaw
Dec 20 13:56:22 DEBUG[3052211120] channel.c: Set channel SIP/578-b426 to write
format alaw
Dec 20 13:56:22 DEBUG[3052211120] channel.c: Set channel SIP/578-b426 to read
format alaw
Dec 20 13:56:22 DEBUG[3052211120] channel.c: Set channel CAPI/ISDN2/5251713-25
to write format alaw
Dec 20 13:56:22 DEBUG[3077995440] chan_sip.c: Checking device state for peer 578
Dec 20 13:56:22 DEBUG[3052473264] channel.c: Set channel CAPI/ISDN2/5251713-25
to write format slin
Dec 20 13:56:22 DEBUG[3077995440] devicestate.c: Changing state for SIP/578 -
state 2 (In use)
Dec 20 13:56:22 DEBUG[3077995440] chan_sip.c: Checking device state for peer 578
Dec 20 13:56:22 DEBUG[3051883440] app_queue.c: Device 'SIP/578' changed to
state '2' (In use)
Dec 20 13:56:22 DEBUG[3052211120] rtp.c: Ooh, format changed from unknown to
alaw
Dec 20 13:56:31 DEBUG[3055479728] chan_sip.c: = No match Their Call ID: [EMAIL
PROTECTED] Their Tag 876cba726342e2c6 Our tag: as12296aed
Dec 20 13:56:31 DEBUG[3055479728] chan_sip.c: Allocating new SIP dialog for
[EMAIL PROTECTED] - SUBSCRIBE (No RTP)
Dec 20 13:56:31 DEBUG[3055479728] chan_sip.c: **** Received SUBSCRIBE (10) -
Command in SIP SUBSCRIBE
Dec 20 13:56:36 DEBUG[3052211120] channel.c: Got a FRAME_CONTROL (14) frame on
channel CAPI/ISDN2/5251713-25
Dec 20 13:56:36 DEBUG[3052211120] channel.c: Bridge stops bridging channels
CAPI/ISDN2/5251713-25 and SIP/578-b426
Dec 20 13:56:36 DEBUG[3052211120] channel.c: Set channel CAPI/ISDN2/5251713-25
to read format alaw
Dec 20 13:56:36 DEBUG[3052211120] channel.c: Set channel SIP/578-b426 to write
format alaw
Dec 20 13:56:36 DEBUG[3052211120] channel.c: Set channel SIP/578-b426 to read
format alaw
Dec 20 13:56:36 DEBUG[3052211120] channel.c: Set channel CAPI/ISDN2/5251713-25
to write format alaw
Dec 20 13:56:36 DEBUG[3052211120] channel.c: Didn't get a frame from channel:
CAPI/ISDN2/5251713-25
Dec 20 13:56:36 DEBUG[3052211120] channel.c: Bridge stops bridging channels
CAPI/ISDN2/5251713-25 and SIP/578-b426
Dec 20 13:56:36 DEBUG[3052211120] channel.c: Hanging up channel 'SIP/578-b426'
Dec 20 13:56:36 DEBUG[3052211120] chan_sip.c: Hangup call SIP/578-b426, SIP
callid [EMAIL PROTECTED])
Dec 20 13:56:36 DEBUG[3052211120] chan_sip.c: update_call_counter(578) -
decrement call limit counter
Dec 20 13:56:36 DEBUG[3052211120] chan_sip.c: Updating call counter for
outgoing call
Dec 20 13:56:36 DEBUG[3052211120] app_dial.c: Exiting with DIALSTATUS=ANSWER.
Dec 20 13:56:36 DEBUG[3052211120] app_macro.c: Spawn extension
(macro-pbx-extn-vmail,s,3) exited non-zero on 'CAPI/ISDN2/5251713-25' in macro
'pbx-extn-vmail'
Dec 20 13:56:36 DEBUG[3052211120] pbx.c: Spawn extension (all-users,578,1)
exited non-zero on 'CAPI/ISDN2/5251713-25'
Dec 20 13:56:36 DEBUG[3052211120] cdr_pgsql.c: Inserting a CDR record.
Dec 20 13:56:36 DEBUG[3052211120] cdr_pgsql.c: SQL command executed: INSERT
INTO cdr
(calldate,clid,src,dst,dcontext,channel,dstchannel,lastapp,lastdata,duration,billsec,disposition,amaflags,accountcode,uniqueid,userfield)
VALUES ('2005-12-20 13:56:06','021539556','021539556','578','all-users',
'CAPI/ISDN2/5251713-25','SIP/578-b426','Dial','SIP/578|20|Tt',30,25,'ANSWERED',3,'','1135040166.71','')
Dec 20 13:56:36 DEBUG[3077995440] chan_sip.c: Checking device state for peer 578
Dec 20 13:56:36 DEBUG[3077995440] devicestate.c: Changing state for SIP/578 -
state 1 (Not in use)
Dec 20 13:56:36 DEBUG[3077995440] chan_sip.c: Checking device state for peer 578
Dec 20 13:56:36 DEBUG[3051883440] app_queue.c: Device 'SIP/578' changed to
state '1' (Not in use)
Dec 20 13:56:36 DEBUG[3052211120] pbx.c: Function result is '021539556'
Dec 20 13:56:36 DEBUG[3052211120] pbx.c: Function result is '021539556'
Dec 20 13:56:36 DEBUG[3052211120] pbx.c: Function result is '578'
Dec 20 13:56:36 DEBUG[3052211120] pbx.c: Function result is 'all-users'
Dec 20 13:56:36 DEBUG[3052211120] pbx.c: Function result is
'CAPI/ISDN2/5251713-25'
Dec 20 13:56:36 DEBUG[3052211120] pbx.c: Function result is 'SIP/578-b426'
Dec 20 13:56:36 DEBUG[3052211120] pbx.c: Function result is 'Dial'
Dec 20 13:56:36 DEBUG[3052211120] pbx.c: Function result is 'SIP/578|20|Tt'
Dec 20 13:56:36 DEBUG[3052211120] pbx.c: Function result is '2005-12-20
13:56:06'
Dec 20 13:56:36 DEBUG[3052211120] pbx.c: Function result is '2005-12-20
13:56:11'
Dec 20 13:56:36 DEBUG[3052211120] pbx.c: Function result is '2005-12-20
13:56:36'
Dec 20 13:56:36 DEBUG[3052211120] pbx.c: Function result is '30'
Dec 20 13:56:36 DEBUG[3052211120] pbx.c: Function result is '25'
Dec 20 13:56:36 DEBUG[3052211120] pbx.c: Function result is 'ANSWERED'
Dec 20 13:56:36 DEBUG[3052211120] pbx.c: Function result is 'DOCUMENTATION'
Dec 20 13:56:36 DEBUG[3052211120] pbx.c: Function result is '(null)'
Dec 20 13:56:36 DEBUG[3052211120] pbx.c: Function result is '1135040166.71'
Dec 20 13:56:36 DEBUG[3052211120] pbx.c: Function result is '(null)'
Dec 20 13:56:36 DEBUG[3052211120] channel.c: Hanging up channel
'CAPI/ISDN2/5251713-25'
Dec 20 13:56:36 DEBUG[3052473264] generator.c: Generator thread shut down.
Dec 20 13:56:36 DEBUG[3077995440] devicestate.c: Changing state for
CAPI/ISDN2/5251713 - state 0 (Unknown)
Dec 20 13:56:36 DEBUG[3077995440] devicestate.c: Changing state for
CAPI/ISDN2/5251713 - state 0 (Unknown)
Dec 20 13:56:36 DEBUG[3052211120] app_queue.c: Device 'CAPI/ISDN2/5251713'
changed to state '0' (Unknown)
Dec 20 13:56:36 DEBUG[3052473264] app_queue.c: Device 'CAPI/ISDN2/5251713'
changed to state '0' (Unknown)
Dec 20 13:56:36 DEBUG[3055479728] chan_sip.c: = Found Their Call ID: [EMAIL
PROTECTED] Their Tag 876cba726342e2c6 Our tag: as12296aed
Dec 20 13:56:36 DEBUG[3055479728] chan_sip.c: Stopping retransmission on
'[EMAIL PROTECTED]' of Request 103: Match Found
Dec 20 13:56:48 DEBUG[3055479728] chan_sip.c: Allocating new SIP dialog for
[EMAIL PROTECTED] - SUBSCRIBE (No RTP)
Dec 20 13:56:48 DEBUG[3055479728] chan_sip.c: **** Received SUBSCRIBE (10) -
Command in SIP SUBSCRIBE
Dec 20 13:57:01 DEBUG[3055479728] chan_sip.c: Allocating new SIP dialog for
[EMAIL PROTECTED] - SUBSCRIBE (No RTP)
Dec 20 13:57:01 DEBUG[3055479728] chan_sip.c: **** Received SUBSCRIBE (10) -
Command in SIP SUBSCRIBE
Dec 20 13:57:05 DEBUG[3055479728] chan_sip.c: Allocating new SIP dialog for
[EMAIL PROTECTED] - SUBSCRIBE (No RTP)
Dec 20 13:57:05 DEBUG[3055479728] chan_sip.c: **** Received SUBSCRIBE (10) -
Command in SIP SUBSCRIBE
Dec 20 13:57:05 DEBUG[3055479728] chan_sip.c: Adding subscription for extension
*22 context all-users for peer 570
Dec 20 13:57:19 DEBUG[3055479728] chan_sip.c: Allocating new SIP dialog for
[EMAIL PROTECTED] - SUBSCRIBE (No RTP)
Dec 20 13:57:19 DEBUG[3055479728] chan_sip.c: **** Received SUBSCRIBE (10) -
Command in SIP SUBSCRIBE
Dec 20 13:57:31 DEBUG[3055479728] chan_sip.c: Allocating new SIP dialog for
[EMAIL PROTECTED] - SUBSCRIBE (No RTP)
Dec 20 13:57:31 DEBUG[3055479728] chan_sip.c: **** Received SUBSCRIBE (10) -
Command in SIP SUBSCRIBE
Dec 20 13:57:33 DEBUG[3055479728] chan_sip.c: Allocating new SIP dialog for
[EMAIL PROTECTED] - REGISTER (No RTP)
Dec 20 13:57:33 DEBUG[3055479728] chan_sip.c: **** Received REGISTER (2) -
Command in SIP REGISTER
Dec 20 13:57:34 DEBUG[3077995440] chan_sip.c: Checking device state for peer 586
Dec 20 13:57:34 DEBUG[3077995440] devicestate.c: Changing state for SIP/586 -
state 1 (Not in use)
Dec 20 13:57:34 DEBUG[3077995440] chan_sip.c: Checking device state for peer 586
Dec 20 13:57:34 DEBUG[3052473264] app_queue.c: Device 'SIP/586' changed to
state '1' (Not in use)
Dec 20 13:57:49 DEBUG[3055479728] chan_sip.c: Auto destroying call '[EMAIL
PROTECTED]'
Dec 20 13:57:49 DEBUG[3055479728] chan_sip.c: Allocating new SIP dialog for
[EMAIL PROTECTED] - SUBSCRIBE (No RTP)
Dec 20 13:57:49 DEBUG[3055479728] chan_sip.c: **** Received SUBSCRIBE (10) -
Command in SIP SUBSCRIBE
Dec 20 13:58:01 DEBUG[3055479728] chan_sip.c: Allocating new SIP dialog for
[EMAIL PROTECTED] - SUBSCRIBE (No RTP)
Dec 20 13:58:01 DEBUG[3055479728] chan_sip.c: **** Received SUBSCRIBE (10) -
Command in SIP SUBSCRIBE
Dec 20 13:58:19 DEBUG[3055479728] chan_sip.c: Allocating new SIP dialog for
[EMAIL PROTECTED] - SUBSCRIBE (No RTP)
Dec 20 13:58:19 DEBUG[3055479728] chan_sip.c: **** Received SUBSCRIBE (10) -
Command in SIP SUBSCRIBE
Dec 20 13:58:31 DEBUG[3055479728] chan_sip.c: Allocating new SIP dialog for
[EMAIL PROTECTED] - SUBSCRIBE (No RTP)
Dec 20 13:58:31 DEBUG[3055479728] chan_sip.c: **** Received SUBSCRIBE (10) -
Command in SIP SUBSCRIBE
Dec 20 13:58:49 DEBUG[3055479728] chan_sip.c: Allocating new SIP dialog for
[EMAIL PROTECTED] - SUBSCRIBE (No RTP)
Dec 20 13:58:49 DEBUG[3055479728] chan_sip.c: **** Received SUBSCRIBE (10) -
Command in SIP SUBSCRIBE
Dec 20 13:59:00 DEBUG[3077995440] devicestate.c: Changing state for
CAPI/ISDN2/5251713 - state 2 (In use)
Dec 20 13:59:00 DEBUG[3052473264] pbx.c: Launching 'Dial'
Dec 20 13:59:00 DEBUG[3052473264] chan_sip.c: Allocating new SIP dialog for (No
Call-ID) - INVITE (With RTP)
Dec 20 13:59:00 DEBUG[3052211120] app_queue.c: Device 'CAPI/ISDN2/5251713'
changed to state '2' (In use)
Dec 20 13:59:00 DEBUG[3052473264] chan_sip.c: Setting NAT on RTP to 0
Dec 20 13:59:00 DEBUG[3052473264] chan_sip.c: Setting NAT on VRTP to 0
Dec 20 13:59:00 DEBUG[3052473264] channel.c: Not copying variable
STACK-default-5251713-1.
Dec 20 13:59:00 DEBUG[3052473264] channel.c: Not copying variable CALLEDTON.
Dec 20 13:59:00 DEBUG[3052473264] channel.c: Not copying variable BCHANNELINFO.
Dec 20 13:59:00 DEBUG[3052473264] channel.c: Not copying variable
TRANSFERCAPABILITY.
Dec 20 13:59:00 DEBUG[3052473264] chan_sip.c: Outgoing Call for 570
Dec 20 13:59:00 DEBUG[3052473264] chan_sip.c: Updating call counter for
outgoing call
Dec 20 13:59:00 DEBUG[3052473264] channel.c: Set channel SIP/570-6823 to read
format slin
Dec 20 13:59:00 DEBUG[3052473264] channel.c: Set channel CAPI/ISDN2/5251713-27
to write format slin
Dec 20 13:59:00 DEBUG[3052473264] channel.c: Set channel CAPI/ISDN2/5251713-27
to read format slin
Dec 20 13:59:00 DEBUG[3052473264] channel.c: Set channel SIP/570-6823 to write
format slin
Dec 20 13:59:00 DEBUG[3055479728] chan_sip.c: = Found Their Call ID: [EMAIL
PROTECTED] Their Tag Our tag: as6bc38574
Dec 20 13:59:00 DEBUG[3055479728] chan_sip.c: (Provisional) Stopping
retransmission (but retaining packet) on '[EMAIL PROTECTED]' Request 102: Found
Dec 20 13:59:00 DEBUG[3055479728] chan_sip.c: SIP response 180 to standard
invite
Dec 20 13:59:00 DEBUG[3077995440] chan_sip.c: Checking device state for peer 570
Dec 20 13:59:00 DEBUG[3077995440] devicestate.c: Changing state for SIP/570 -
state 6 (Ringing)
Dec 20 13:59:00 DEBUG[3077995440] chan_sip.c: Checking device state for peer 570
Dec 20 13:59:00 DEBUG[3052211120] app_queue.c: Device 'SIP/570' changed to
state '6' (Ringing)
Dec 20 13:59:01 DEBUG[3055479728] chan_sip.c: = Found Their Call ID: [EMAIL
PROTECTED] Their Tag f09dtfpe2b Our tag: as6bc38574
Dec 20 13:59:01 DEBUG[3055479728] chan_sip.c: (Provisional) Stopping
retransmission (but retaining packet) on '[EMAIL PROTECTED]' Request 102: Found
Dec 20 13:59:01 DEBUG[3055479728] chan_sip.c: SIP response 180 to standard
invite
Dec 20 13:59:01 DEBUG[3055479728] chan_sip.c: = No match Their Call ID: [EMAIL
PROTECTED] Their Tag f09dtfpe2b Our tag: as6bc38574
Dec 20 13:59:01 DEBUG[3055479728] chan_sip.c: Allocating new SIP dialog for
[EMAIL PROTECTED] - SUBSCRIBE (No RTP)
Dec 20 13:59:01 DEBUG[3055479728] chan_sip.c: **** Received SUBSCRIBE (10) -
Command in SIP SUBSCRIBE
Dec 20 13:59:02 DEBUG[3055479728] chan_sip.c: = Found Their Call ID: [EMAIL
PROTECTED] Their Tag f09dtfpe2b Our tag: as6bc38574
Dec 20 13:59:02 DEBUG[3055479728] chan_sip.c: (Provisional) Stopping
retransmission (but retaining packet) on '[EMAIL PROTECTED]' Request 102: Found
Dec 20 13:59:02 DEBUG[3055479728] chan_sip.c: SIP response 180 to standard
invite
Dec 20 13:59:04 DEBUG[3055479728] chan_sip.c: = Found Their Call ID: [EMAIL
PROTECTED] Their Tag f09dtfpe2b Our tag: as6bc38574
Dec 20 13:59:04 DEBUG[3055479728] chan_sip.c: (Provisional) Stopping
retransmission (but retaining packet) on '[EMAIL PROTECTED]' Request 102: Found
Dec 20 13:59:04 DEBUG[3055479728] chan_sip.c: SIP response 180 to standard
invite
Dec 20 13:59:07 DEBUG[3055479728] chan_sip.c: = No match Their Call ID: [EMAIL
PROTECTED] Their Tag f09dtfpe2b Our tag: as6bc38574
Dec 20 13:59:07 DEBUG[3055479728] chan_sip.c: Allocating new SIP dialog for
[EMAIL PROTECTED] - INVITE (With RTP)
Dec 20 13:59:07 DEBUG[3055479728] chan_sip.c: **** Received INVITE (5) -
Command in SIP INVITE
Dec 20 13:59:07 DEBUG[3055479728] chan_sip.c: * SIP extension value: 5 for call
[EMAIL PROTECTED]
Dec 20 13:59:07 DEBUG[3055479728] chan_sip.c: Setting NAT on RTP to 0
Dec 20 13:59:07 DEBUG[3055479728] chan_sip.c: Setting NAT on VRTP to 0
Dec 20 13:59:07 DEBUG[3055479728] chan_sip.c: Checking SIP call limits for
device 578
Dec 20 13:59:07 DEBUG[3055479728] chan_sip.c: Updating call counter for
incoming call
Dec 20 13:59:07 DEBUG[3055479728] chan_sip.c: build_route: Contact hop:
<sip:[EMAIL PROTECTED]>
Dec 20 13:59:07 DEBUG[3055479728] res_features.c: Call pickup on chan
'SIP/570-6823' by 'SIP/578-2c2e'
Dec 20 13:59:07 DEBUG[3055479728] chan_sip.c: sip_answer(SIP/578-2c2e)
Dec 20 13:59:07 DEBUG[3055479728] channel.c: Planning to masquerade channel
SIP/578-2c2e into the structure of SIP/570-6823
Dec 20 13:59:07 DEBUG[3055479728] channel.c: Done planning to masquerade
channel SIP/578-2c2e into the structure of SIP/570-6823
Dec 20 13:59:07 DEBUG[3077995440] chan_sip.c: Checking device state for peer 578
Dec 20 13:59:07 DEBUG[3052473264] channel.c: Actually Masquerading
SIP/578-2c2e(0) into the structure of SIP/570-6823(5)
Dec 20 13:59:07 DEBUG[3052473264] channel.c: Got clone lock for masquerade on
'SIP/578-2c2e' at 0x824c56c
Dec 20 13:59:07 DEBUG[3052473264] chan_sip.c: Hangup call SIP/578-2c2e<MASQ>,
SIP callid [EMAIL PROTECTED])
Dec 20 13:59:07 DEBUG[3052473264] chan_sip.c: update_call_counter(570) -
decrement call limit counter
Dec 20 13:59:07 DEBUG[3052473264] chan_sip.c: Updating call counter for
outgoing call
Dec 20 13:59:07 DEBUG[3052473264] chan_sip.c: Acked pending invite 102
Dec 20 13:59:07 DEBUG[3052473264] chan_sip.c: Stopping retransmission on
'[EMAIL PROTECTED]' of Request 102: Match Found
Dec 20 13:59:07 DEBUG[3052473264] chan_sip.c: Stopping retransmission on
'[EMAIL PROTECTED]' of Request 102: Match Found
Dec 20 13:59:07 DEBUG[3052473264] channel.c: Set channel SIP/578-2c2e to write
format slin
Dec 20 13:59:07 DEBUG[3052473264] channel.c: Set channel SIP/578-2c2e to read
format slin
Dec 20 13:59:07 DEBUG[3052473264] channel.c: Putting channel SIP/578-2c2e in
64/64 formats
Dec 20 13:59:07 DEBUG[3052473264] channel.c: Destroying channel clone
'SIP/570-6823<ZOMBIE>'
Dec 20 13:59:07 DEBUG[3052473264] channel.c: Done Masquerading SIP/578-2c2e (0)
Dec 20 13:59:07 DEBUG[3052473264] channel.c: Set channel CAPI/ISDN2/5251713-27
to read format slin
Dec 20 13:59:07 DEBUG[3052473264] channel.c: Set channel SIP/578-2c2e to write
format slin
Dec 20 13:59:07 DEBUG[3052473264] channel.c: Set channel SIP/578-2c2e to read
format slin
Dec 20 13:59:07 DEBUG[3052473264] channel.c: Set channel CAPI/ISDN2/5251713-27
to write format slin
Dec 20 13:59:07 DEBUG[3077995440] devicestate.c: Changing state for SIP/578 -
state 2 (In use)
Dec 20 13:59:07 DEBUG[3077995440] chan_sip.c: Checking device state for peer 578
Dec 20 13:59:07 DEBUG[3052211120] app_queue.c: Device 'SIP/578' changed to
state '2' (In use)
Dec 20 13:59:07 DEBUG[3077995440] chan_sip.c: Checking device state for peer 578
Dec 20 13:59:07 DEBUG[3077995440] devicestate.c: Changing state for SIP/578 -
state 2 (In use)
Dec 20 13:59:07 DEBUG[3077995440] chan_sip.c: Checking device state for peer 578
Dec 20 13:59:07 DEBUG[3052211120] app_queue.c: Device 'SIP/578' changed to
state '2' (In use)
Dec 20 13:59:07 DEBUG[3077995440] chan_sip.c: Checking device state for peer 578
Dec 20 13:59:07 DEBUG[3077995440] devicestate.c: Changing state for SIP/578 -
state 2 (In use)
Dec 20 13:59:07 DEBUG[3077995440] chan_sip.c: Checking device state for peer 578
Dec 20 13:59:07 DEBUG[3052211120] app_queue.c: Device 'SIP/578' changed to
state '2' (In use)
Dec 20 13:59:07 DEBUG[3077995440] chan_sip.c: Checking device state for peer 570
Dec 20 13:59:07 DEBUG[3077995440] devicestate.c: Changing state for SIP/570 -
state 1 (Not in use)
Dec 20 13:59:07 DEBUG[3077995440] chan_sip.c: Checking device state for peer 570
Dec 20 13:59:07 DEBUG[3052211120] app_queue.c: Device 'SIP/570' changed to
state '1' (Not in use)
Dec 20 13:59:07 DEBUG[3077995440] chan_sip.c: Checking device state for peer 578
Dec 20 13:59:07 DEBUG[3077995440] devicestate.c: Changing state for SIP/578 -
state 2 (In use)
Dec 20 13:59:07 DEBUG[3077995440] chan_sip.c: Checking device state for peer 578
Dec 20 13:59:07 DEBUG[3052211120] app_queue.c: Device 'SIP/578' changed to
state '2' (In use)
Dec 20 13:59:07 DEBUG[3077995440] devicestate.c: Changing state for
CAPI/ISDN2/5251713 - state 2 (In use)
Dec 20 13:59:07 DEBUG[3052211120] app_queue.c: Device 'CAPI/ISDN2/5251713'
changed to state '2' (In use)
Dec 20 13:59:07 DEBUG[3055479728] chan_sip.c: = Found Their Call ID: [EMAIL
PROTECTED] Their Tag 0e459349556fcb75 Our tag: as22a99407
Dec 20 13:59:07 DEBUG[3055479728] chan_sip.c: **** Received ACK (6) - Command
in SIP ACK
Dec 20 13:59:07 DEBUG[3055479728] chan_sip.c: Stopping retransmission on
'[EMAIL PROTECTED]' of Response 19312: Match Found
Dec 20 13:59:07 DEBUG[3052473264] channel.c: Dropping duplicate answer!
Dec 20 13:59:07 DEBUG[3052473264] rtp.c: Ooh, format changed from unknown to
ulaw
Dec 20 13:59:07 DEBUG[3052473264] rtp.c: Had to change frame MS from 0 to 20
Dec 20 13:59:07 DEBUG[3052473264] rtp.c: Able to create smoother :) ms: 20 len
160
Dec 20 13:59:07 DEBUG[3055479728] chan_sip.c: = No match Their Call ID: [EMAIL
PROTECTED] Their Tag 0e459349556fcb75 Our tag: as22a99407
Dec 20 13:59:07 DEBUG[3055479728] chan_sip.c: = Found Their Call ID: [EMAIL
PROTECTED] Their Tag f09dtfpe2b Our tag: as6bc38574
Dec 20 13:59:07 DEBUG[3055479728] chan_sip.c: Stopping retransmission on
'[EMAIL PROTECTED]' of Request 102: Match Not Found
Dec 20 13:59:07 DEBUG[3055479728] chan_sip.c: = No match Their Call ID: [EMAIL
PROTECTED] Their Tag 0e459349556fcb75 Our tag: as22a99407
Dec 20 13:59:07 DEBUG[3055479728] chan_sip.c: = Found Their Call ID: [EMAIL
PROTECTED] Their Tag f09dtfpe2b Our tag: as6bc38574
Dec 20 13:59:07 DEBUG[3055479728] chan_sip.c: Stopping retransmission on
'[EMAIL PROTECTED]' of Request 102: Match Not Found
Dec 20 13:59:07 DEBUG[3055479728] chan_sip.c: Updating call counter for
outgoing call
Dec 20 13:59:19 DEBUG[3055479728] chan_sip.c: = No match Their Call ID: [EMAIL
PROTECTED] Their Tag 0e459349556fcb75 Our tag: as22a99407
Dec 20 13:59:19 DEBUG[3055479728] chan_sip.c: Allocating new SIP dialog for
[EMAIL PROTECTED] - SUBSCRIBE (No RTP)
Dec 20 13:59:19 DEBUG[3055479728] chan_sip.c: **** Received SUBSCRIBE (10) -
Command in SIP SUBSCRIBE
Dec 20 13:59:20 DEBUG[3055479728] chan_sip.c: = Found Their Call ID: [EMAIL
PROTECTED] Their Tag 0e459349556fcb75 Our tag: as22a99407
Dec 20 13:59:20 DEBUG[3055479728] chan_sip.c: **** Received BYE (8) - Command
in SIP BYE
Dec 20 13:59:20 DEBUG[3052473264] channel.c: Didn't get a frame from channel:
SIP/578-2c2e
Dec 20 13:59:20 DEBUG[3052473264] channel.c: Bridge stops bridging channels
CAPI/ISDN2/5251713-27 and SIP/578-2c2e
Dec 20 13:59:20 DEBUG[3052473264] channel.c: Hanging up channel 'SIP/578-2c2e'
Dec 20 13:59:20 DEBUG[3052473264] chan_sip.c: Hangup call SIP/578-2c2e, SIP
callid [EMAIL PROTECTED])
Dec 20 13:59:20 DEBUG[3052473264] chan_sip.c: update_call_counter(578) -
decrement call limit counter
Dec 20 13:59:20 DEBUG[3052473264] chan_sip.c: Updating call counter for
incoming call
Dec 20 13:59:20 DEBUG[3052473264] app_dial.c: Exiting with DIALSTATUS=ANSWER.
Dec 20 13:59:20 DEBUG[3052473264] pbx.c: Spawn extension (default,5251713,1)
exited non-zero on 'CAPI/ISDN2/5251713-27'
Dec 20 13:59:20 DEBUG[3052473264] cdr_pgsql.c: Inserting a CDR record.
Dec 20 13:59:20 DEBUG[3052473264] cdr_pgsql.c: SQL command executed: INSERT
INTO cdr
(calldate,clid,src,dst,dcontext,channel,dstchannel,lastapp,lastdata,duration,billsec,disposition,amaflags,accountcode,uniqueid,userfield)
VALUES ('2005-12-20 13:59:00','021539556','021539556','5251713','default',
'CAPI/ISDN2/5251713-27','SIP/578-2c2e','Dial','SIP/570',20,13,'ANSWERED',3,'','1135040340.74','')
Dec 20 13:59:20 DEBUG[3077995440] chan_sip.c: Checking device state for peer 578
Dec 20 13:59:20 DEBUG[3077995440] devicestate.c: Changing state for SIP/578 -
state 1 (Not in use)
Dec 20 13:59:20 DEBUG[3077995440] chan_sip.c: Checking device state for peer 578
Dec 20 13:59:20 DEBUG[3052211120] app_queue.c: Device 'SIP/578' changed to
state '1' (Not in use)
Dec 20 13:59:20 DEBUG[3052473264] pbx.c: Function result is '021539556'
Dec 20 13:59:20 DEBUG[3052473264] pbx.c: Function result is '021539556'
Dec 20 13:59:20 DEBUG[3052473264] pbx.c: Function result is '5251713'
Dec 20 13:59:20 DEBUG[3052473264] pbx.c: Function result is 'default'
Dec 20 13:59:20 DEBUG[3052473264] pbx.c: Function result is
'CAPI/ISDN2/5251713-27'
Dec 20 13:59:20 DEBUG[3052473264] pbx.c: Function result is 'SIP/578-2c2e'
Dec 20 13:59:20 DEBUG[3052473264] pbx.c: Function result is 'Dial'
Dec 20 13:59:20 DEBUG[3052473264] pbx.c: Function result is 'SIP/570'
Dec 20 13:59:20 DEBUG[3052473264] pbx.c: Function result is '2005-12-20
13:59:00'
Dec 20 13:59:20 DEBUG[3052473264] pbx.c: Function result is '2005-12-20
13:59:07'
Dec 20 13:59:20 DEBUG[3052473264] pbx.c: Function result is '2005-12-20
13:59:20'
Dec 20 13:59:20 DEBUG[3052473264] pbx.c: Function result is '20'
Dec 20 13:59:20 DEBUG[3052473264] pbx.c: Function result is '13'
Dec 20 13:59:20 DEBUG[3052473264] pbx.c: Function result is 'ANSWERED'
Dec 20 13:59:20 DEBUG[3052473264] pbx.c: Function result is 'DOCUMENTATION'
Dec 20 13:59:20 DEBUG[3052473264] pbx.c: Function result is '(null)'
Dec 20 13:59:20 DEBUG[3052473264] pbx.c: Function result is '1135040340.74'
Dec 20 13:59:20 DEBUG[3052473264] pbx.c: Function result is '(null)'
Dec 20 13:59:20 DEBUG[3052473264] channel.c: Hanging up channel
'CAPI/ISDN2/5251713-27'
Dec 20 13:59:20 DEBUG[3077995440] devicestate.c: Changing state for
CAPI/ISDN2/5251713 - state 0 (Unknown)
Dec 20 13:59:20 DEBUG[3077995440] devicestate.c: Changing state for
CAPI/ISDN2/5251713 - state 0 (Unknown)
Dec 20 13:59:20 DEBUG[3052473264] app_queue.c: Device 'CAPI/ISDN2/5251713'
changed to state '0' (Unknown)
Dec 20 13:59:20 DEBUG[3052211120] app_queue.c: Device 'CAPI/ISDN2/5251713'
changed to state '0' (Unknown)
_______________________________________________
Openpbx-dev mailing list
[email protected]
http://lists.openpbx.org/mailman/listinfo/openpbx-dev
