[Asterisk-Users] cannot set outgoing cid

Tom Vile tvile at baldwintechsolutions.com
Fri Mar 31 08:25:16 MST 2006


Are you allowed to set your callerid with your provider?  Do you have
a PRI or is it a POTS line?

On 3/31/06, Sebastian Reitenbach <itlistuser at rapideye.de> wrote:
> Hi,
>
> sorry for the long debug output below. I configured Asterisk with AMP to send
> the whole number including the extensions of the callers to the called party.
> Whatever I configure in AMP it looks like it is used, In my eyes it is ok, but
> doesn't seem to work.
>
> 033811234451 is the call id i configured, and it seems to use them, but the
> caller will only see a 0338189040 instead of my extension.
>
> any hint to what could be wrong is greatly appreciated.
>
> kind regards
> Sebastian
>
> Mar 31 16:53:56 DEBUG[24358] chan_sip.c: = No match Their Call ID:
> 3c336898975e-udfiigp7a38i at 192-168-11-189 Their Tag 5jd9htv3rz Our tag:
> as1e957ca5
> Mar 31 16:53:56 DEBUG[24358] chan_sip.c: Allocating new SIP dialog for
> ipixsmdwtxqusdu at 192.168.11.79 - INVITE (With RTP)
> Mar 31 16:53:56 DEBUG[24358] chan_sip.c: **** Received INVITE (5) - Command in
> SIP INVITE
> Mar 31 16:53:56 DEBUG[24358] chan_sip.c: * SIP extension value: 2 for call
> ipixsmdwtxqusdu at 192.168.11.79
> Mar 31 16:53:56 DEBUG[24358] chan_sip.c: Setting NAT on RTP to 0
> Mar 31 16:53:56 DEBUG[24358] chan_sip.c: = Found Their Call ID:
> ipixsmdwtxqusdu at 192.168.11.79 Their Tag fzxtk Our tag: as33b84ae6
> Mar 31 16:53:56 DEBUG[24358] chan_sip.c: **** Received ACK (6) - Command in
> SIP ACK
> Mar 31 16:53:56 DEBUG[24358] chan_sip.c: Stopping retransmission on
> 'ipixsmdwtxqusdu at 192.168.11.79' of Response 830: Match Found
> Mar 31 16:53:56 DEBUG[24358] chan_sip.c: = Found Their Call ID:
> ipixsmdwtxqusdu at 192.168.11.79 Their Tag fzxtk Our tag: as33b84ae6
> Mar 31 16:53:56 DEBUG[24358] chan_sip.c: **** Received INVITE (5) - Command in
> SIP INVITE
> Mar 31 16:53:56 DEBUG[24358] chan_sip.c: Setting NAT on RTP to 0
> Mar 31 16:53:56 DEBUG[24358] chan_sip.c: Checking SIP call limits for device
> 451
> Mar 31 16:53:56 DEBUG[24358] chan_sip.c: Updating call counter for incoming
> call
> Mar 31 16:53:56 DEBUG[24358] chan_sip.c: build_route: Contact hop:
> <sip:451_asterisk_intern at 192.168.11.79;user=phone>
> Mar 31 16:53:56 DEBUG[24349] chan_sip.c: Checking device state for peer 451
> Mar 31 16:53:56 DEBUG[24349] channel.c: Avoiding initial deadlock for
> 'SIP/451-0e31'
> Mar 31 16:53:56 DEBUG[24349] channel.c: Avoiding initial deadlock for
> 'SIP/451-0e31'
> Mar 31 16:53:56 DEBUG[11747] pbx.c: Launching 'Macro'
> Mar 31 16:53:56 VERBOSE[11747] logger.c:     -- Executing
> Macro("SIP/451-0e31", "dialout-trunk|1|03381765432|") in new stack
> Mar 31 16:53:56 DEBUG[24349] devicestate.c: Changing state for SIP/451 - state
> 2 (In use)
> Mar 31 16:53:56 DEBUG[24349] chan_sip.c: Checking device state for peer 451
> Mar 31 16:53:56 DEBUG[11748] app_queue.c: Device 'SIP/451' changed to state
> '2' (In use)
> Mar 31 16:53:56 DEBUG[24349] chan_sip.c: Checking device state for peer 451
> Mar 31 16:53:56 DEBUG[11747] pbx.c: Expression result is '1'
> Mar 31 16:53:56 DEBUG[11747] pbx.c: Launching 'GotoIf'
> Mar 31 16:53:56 VERBOSE[11747] logger.c:     -- Executing
> GotoIf("SIP/451-0e31", "1?3:2)") in new stack
> Mar 31 16:53:56 VERBOSE[11747] logger.c:     -- Goto (macro-dialout-trunk,s,3)
> Mar 31 16:53:56 DEBUG[11747] pbx.c: Launching 'Macro'
> Mar 31 16:53:56 VERBOSE[11747] logger.c:     -- Executing
> Macro("SIP/451-0e31", "user-callerid") in new stack
> Mar 31 16:53:56 DEBUG[11747] pbx.c: Launching 'DBget'
> Mar 31 16:53:56 VERBOSE[11747] logger.c:     -- Executing
> DBget("SIP/451-0e31", "AMPUSER=DEVICE/451/user") in new stack
> Mar 31 16:53:56 DEBUG[11688] chan_zap.c: Write returned -1 (Resource
> temporarily unavailable) on channel 2
> Mar 31 16:53:56 VERBOSE[11747] logger.c:     -- DBget: varname=AMPUSER,
> family=DEVICE, key=451/user
> Mar 31 16:53:56 VERBOSE[11747] logger.c:     -- DBget: set variable AMPUSER to
> 451
> Mar 31 16:53:56 DEBUG[11747] pbx.c: Launching 'DBget'
> Mar 31 16:53:56 VERBOSE[11747] logger.c:     -- Executing
> DBget("SIP/451-0e31", "AMPUSERCIDNAME=AMPUSER/451/cidname") in new stack
> Mar 31 16:53:56 VERBOSE[11747] logger.c:     -- DBget: varname=AMPUSERCIDNAME,
> family=AMPUSER, key=451/cidname
> Mar 31 16:53:56 VERBOSE[11747] logger.c:     -- DBget: set variable
> AMPUSERCIDNAME to Sebastian Reitenbach
> Mar 31 16:53:56 DEBUG[11747] pbx.c: Expression result is '0'
> Mar 31 16:53:56 DEBUG[11747] pbx.c: Launching 'GotoIf'
> Mar 31 16:53:56 VERBOSE[11747] logger.c:     -- Executing
> GotoIf("SIP/451-0e31", "0?5") in new stack
> Mar 31 16:53:56 DEBUG[11747] pbx.c: Not taking any branch
> Mar 31 16:53:56 DEBUG[11747] pbx.c: Launching 'SetCallerID'
> Mar 31 16:53:56 VERBOSE[11747] logger.c:     -- Executing
> SetCallerID("SIP/451-0e31", ""Sebastian Reitenbach" <451>") in new stack
> Mar 31 16:53:56 DEBUG[11747] pbx.c: Launching 'NoOp'
> Mar 31 16:53:56 VERBOSE[11747] logger.c:     -- Executing NoOp("SIP/451-0e31",
> "Using CallerID "Sebastian Reitenbach" <451>") in new stack
> Mar 31 16:53:56 DEBUG[11747] pbx.c: Launching 'Macro'
> Mar 31 16:53:56 VERBOSE[11747] logger.c:     -- Executing
> Macro("SIP/451-0e31", "record-enable|451|OUT") in new stack
> Mar 31 16:53:56 DEBUG[11747] pbx.c: Function result is '0'
> Mar 31 16:53:56 DEBUG[11747] pbx.c: Launching 'GotoIf'
> Mar 31 16:53:56 VERBOSE[11747] logger.c:     -- Executing
> GotoIf("SIP/451-0e31", "0 > 0?2:4") in new stack
> Mar 31 16:53:56 VERBOSE[11747] logger.c:     -- Goto (macro-record-enable,s,4)
> Mar 31 16:53:56 DEBUG[11747] pbx.c: Launching 'AGI'
> Mar 31 16:53:56 VERBOSE[11747] logger.c:     -- Executing AGI("SIP/451-0e31",
> "recordingcheck|20060331-165356|1143816836.643") in new stack
> Mar 31 16:53:56 VERBOSE[11747] logger.c:     -- Launched AGI
> Script /var/lib/asterisk/agi-bin/recordingcheck
> Mar 31 16:53:57 VERBOSE[11747] logger.c:   recordingcheck|20060331-165356|
> 1143816836.643: Outbound recording not enabled
> Mar 31 16:53:57 VERBOSE[11747] logger.c:     -- AGI Script recordingcheck
> completed, returning 0
> Mar 31 16:53:57 DEBUG[11747] pbx.c: Launching 'NoOp'
> Mar 31 16:53:57 VERBOSE[11747] logger.c:     -- Executing NoOp("SIP/451-0e31",
> "No recording needed") in new stack
> Mar 31 16:53:57 DEBUG[11747] pbx.c: Launching 'Macro'
> Mar 31 16:53:57 VERBOSE[11747] logger.c:     -- Executing
> Macro("SIP/451-0e31", "outbound-callerid|1") in new stack
> Mar 31 16:53:57 DEBUG[11747] pbx.c: Launching 'DBget'
> Mar 31 16:53:57 VERBOSE[11747] logger.c:     -- Executing
> DBget("SIP/451-0e31", "USEROUTCID=AMPUSER/451/outboundcid") in new stack
> Mar 31 16:53:57 VERBOSE[11747] logger.c:     -- DBget: varname=USEROUTCID,
> family=AMPUSER, key=451/outboundcid
> Mar 31 16:53:57 VERBOSE[11747] logger.c:     -- DBget: set variable USEROUTCID
> to 033811234451
> Mar 31 16:53:57 DEBUG[11747] pbx.c: Expression result is '0'
> Mar 31 16:53:57 DEBUG[11747] pbx.c: Launching 'GotoIf'
> Mar 31 16:53:57 VERBOSE[11747] logger.c:     -- Executing
> GotoIf("SIP/451-0e31", "0?4") in new stack
> Mar 31 16:53:57 DEBUG[11747] pbx.c: Not taking any branch
> Mar 31 16:53:57 DEBUG[11747] pbx.c: Launching 'SetCallerID'
> Mar 31 16:53:57 VERBOSE[11747] logger.c:     -- Executing
> SetCallerID("SIP/451-0e31", "033811234100") in new stack
> Mar 31 16:53:57 DEBUG[11747] pbx.c: Expression result is '0'
> Mar 31 16:53:57 DEBUG[11747] pbx.c: Launching 'GotoIf'
> Mar 31 16:53:57 VERBOSE[11747] logger.c:     -- Executing
> GotoIf("SIP/451-0e31", "0?6") in new stack
> Mar 31 16:53:57 DEBUG[11747] pbx.c: Not taking any branch
> Mar 31 16:53:57 DEBUG[11747] pbx.c: Launching 'SetCallerID'
> Mar 31 16:53:57 VERBOSE[11747] logger.c:     -- Executing
> SetCallerID("SIP/451-0e31", "033811234451") in new stack
> Mar 31 16:53:57 DEBUG[11747] pbx.c: Launching 'NoOp'
> Mar 31 16:53:57 VERBOSE[11747] logger.c:     -- Executing NoOp("SIP/451-0e31",
> "CallerID set to 033811234451") in new stack
> Mar 31 16:53:57 DEBUG[11747] pbx.c: Launching 'SetGroup'
> Mar 31 16:53:57 VERBOSE[11747] logger.c:     -- Executing
> SetGroup("SIP/451-0e31", "OUT_1") in new stack
> Mar 31 16:53:57 DEBUG[11747] pbx.c: Function result is '1'
> Mar 31 16:53:57 DEBUG[11747] pbx.c: Expression result is '0'
> Mar 31 16:53:57 DEBUG[11747] pbx.c: Launching 'GotoIf'
> Mar 31 16:53:57 VERBOSE[11747] logger.c:     -- Executing
> GotoIf("SIP/451-0e31", "0?108") in new stack
> Mar 31 16:53:57 DEBUG[11747] pbx.c: Not taking any branch
> Mar 31 16:53:57 DEBUG[11747] pbx.c: Launching 'SetVar'
> Mar 31 16:53:57 VERBOSE[11747] logger.c:     -- Executing
> SetVar("SIP/451-0e31", "DIAL_NUMBER=03381765432") in new stack
> Mar 31 16:53:57 DEBUG[11747] pbx.c: Launching 'SetVar'
> Mar 31 16:53:57 VERBOSE[11747] logger.c:     -- Executing
> SetVar("SIP/451-0e31", "DIAL_TRUNK=1") in new stack
> Mar 31 16:53:57 DEBUG[11747] pbx.c: Launching 'AGI'
> Mar 31 16:53:57 VERBOSE[11747] logger.c:     -- Executing AGI("SIP/451-0e31",
> "fixlocalprefix") in new stack
> Mar 31 16:53:57 VERBOSE[11747] logger.c:     -- Launched AGI
> Script /var/lib/asterisk/agi-bin/fixlocalprefix
> Mar 31 16:53:57 VERBOSE[11747] logger.c:   fixlocalprefix: Removed prefix. New
> number: 3381765432
> Mar 31 16:53:57 VERBOSE[11747] logger.c:     -- AGI Script fixlocalprefix
> completed, returning 0
> Mar 31 16:53:57 DEBUG[11747] pbx.c: Launching 'SetVar'
> Mar 31 16:53:57 VERBOSE[11747] logger.c:     -- Executing
> SetVar("SIP/451-0e31", "OUTNUM=3381765432") in new stack
> Mar 31 16:53:57 DEBUG[11747] pbx.c: Launching 'Cut'
> Mar 31 16:53:57 VERBOSE[11747] logger.c:     -- Executing Cut("SIP/451-0e31",
> "custom=OUT_1|:|1") in new stack
> Mar 31 16:53:57 WARNING[11747] ast_expr2.y: non-numeric argument
> Mar 31 16:53:57 DEBUG[11747] pbx.c: Expression result is '0'
> Mar 31 16:53:57 DEBUG[11747] pbx.c: Launching 'GotoIf'
> Mar 31 16:53:57 VERBOSE[11747] logger.c:     -- Executing
> GotoIf("SIP/451-0e31", "0?16") in new stack
> Mar 31 16:53:57 DEBUG[11747] pbx.c: Not taking any branch
> Mar 31 16:53:57 DEBUG[11747] pbx.c: Launching 'Dial'
> Mar 31 16:53:57 VERBOSE[11747] logger.c:     -- Executing Dial("SIP/451-0e31",
> "ZAP/g1/3381765432") in new stack
> Mar 31 16:53:57 DEBUG[11747] chan_zap.c: Using channel 1
> Mar 31 16:53:57 DEBUG[11747] channel.c: Not copying variable
> STACK-macro-dialout-trunk-s-14.
> Mar 31 16:53:57 DEBUG[11747] channel.c: Not copying variable MACRO_DEPTH.
> Mar 31 16:53:57 DEBUG[11747] channel.c: Not copying variable
> STACK-macro-dialout-trunk-s-13.
> Mar 31 16:53:57 DEBUG[11747] channel.c: Not copying variable custom.
> Mar 31 16:53:57 DEBUG[11747] channel.c: Not copying variable
> STACK-macro-dialout-trunk-s-12.
> Mar 31 16:53:57 DEBUG[11747] channel.c: Not copying variable OUTNUM.
> Mar 31 16:53:57 DEBUG[11747] channel.c: Not copying variable
> STACK-macro-dialout-trunk-s-11.
> Mar 31 16:53:57 DEBUG[11747] channel.c: Not copying variable DIAL_NUMBER.
> Mar 31 16:53:57 DEBUG[11747] channel.c: Not copying variable
> STACK-macro-dialout-trunk-s-10.
> Mar 31 16:53:57 DEBUG[11747] channel.c: Not copying variable DIAL_TRUNK.
> Mar 31 16:53:57 DEBUG[11747] channel.c: Not copying variable
> STACK-macro-dialout-trunk-s-9.
> Mar 31 16:53:57 DEBUG[11747] channel.c: Not copying variable
> STACK-macro-dialout-trunk-s-8.
> Mar 31 16:53:57 DEBUG[11747] channel.c: Not copying variable
> STACK-macro-dialout-trunk-s-7.
> Mar 31 16:53:57 DEBUG[11747] channel.c: Not copying variable GROUP.
> Mar 31 16:53:57 DEBUG[11747] channel.c: Not copying variable
> STACK-macro-dialout-trunk-s-6.
> Mar 31 16:53:57 DEBUG[11747] channel.c: Not copying variable MACRO_PRIORITY.
> Mar 31 16:53:57 DEBUG[11747] channel.c: Not copying variable MACRO_CONTEXT.
> Mar 31 16:53:57 DEBUG[11747] channel.c: Not copying variable MACRO_EXTEN.
> Mar 31 16:53:57 DEBUG[11747] channel.c: Not copying variable ARG1.
> Mar 31 16:53:57 DEBUG[11747] channel.c: Not copying variable
> STACK-macro-outbound-callerid-s-6.
> Mar 31 16:53:57 DEBUG[11747] channel.c: Not copying variable
> STACK-macro-outbound-callerid-s-5.
> Mar 31 16:53:57 DEBUG[11747] channel.c: Not copying variable
> STACK-macro-outbound-callerid-s-4.
> Mar 31 16:53:57 DEBUG[11747] channel.c: Not copying variable
> STACK-macro-outbound-callerid-s-3.
> Mar 31 16:53:57 DEBUG[11747] channel.c: Not copying variable
> STACK-macro-outbound-callerid-s-2.
> Mar 31 16:53:57 DEBUG[11747] channel.c: Not copying variable DBGETSTATUS.
> Mar 31 16:53:57 DEBUG[11747] channel.c: Not copying variable USEROUTCID.
> Mar 31 16:53:57 DEBUG[11747] channel.c: Not copying variable
> STACK-macro-outbound-callerid-s-1.
> Mar 31 16:53:57 DEBUG[11747] channel.c: Not copying variable
> STACK-macro-dialout-trunk-s-5.
> Mar 31 16:53:57 DEBUG[11747] channel.c: Not copying variable ARG2.
> Mar 31 16:53:57 DEBUG[11747] channel.c: Not copying variable
> STACK-macro-record-enable-s-5.
> Mar 31 16:53:57 DEBUG[11747] channel.c: Not copying variable
> STACK-macro-record-enable-s-4.
> Mar 31 16:53:57 DEBUG[11747] channel.c: Not copying variable
> STACK-macro-record-enable-s-1.
> Mar 31 16:53:57 DEBUG[11747] channel.c: Not copying variable
> STACK-macro-dialout-trunk-s-4.
> Mar 31 16:53:57 DEBUG[11747] channel.c: Not copying variable
> STACK-macro-user-callerid-s-5.
> Mar 31 16:53:57 DEBUG[11747] channel.c: Not copying variable
> STACK-macro-user-callerid-s-4.
> Mar 31 16:53:57 DEBUG[11747] channel.c: Not copying variable
> STACK-macro-user-callerid-s-3.
> Mar 31 16:53:57 DEBUG[11747] channel.c: Not copying variable AMPUSERCIDNAME.
> Mar 31 16:53:57 DEBUG[11747] channel.c: Not copying variable
> STACK-macro-user-callerid-s-2.
> Mar 31 16:53:57 DEBUG[11747] channel.c: Not copying variable AMPUSER.
> Mar 31 16:53:57 DEBUG[11747] channel.c: Not copying variable
> STACK-macro-user-callerid-s-1.
> Mar 31 16:53:57 DEBUG[11747] channel.c: Not copying variable
> STACK-macro-dialout-trunk-s-3.
> Mar 31 16:53:57 DEBUG[11747] channel.c: Not copying variable
> STACK-macro-dialout-trunk-s-1.
> Mar 31 16:53:57 DEBUG[11747] channel.c: Not copying variable ARG3.
> Mar 31 16:53:57 DEBUG[11747] channel.c: Not copying variable
> STACK-from-internal-003381765432-1.
> Mar 31 16:53:57 DEBUG[11747] channel.c: Not copying variable SIPCALLID.
> Mar 31 16:53:57 DEBUG[11747] channel.c: Not copying variable SIPUSERAGENT.
> Mar 31 16:53:57 DEBUG[11747] channel.c: Not copying variable SIPDOMAIN.
> Mar 31 16:53:57 DEBUG[11747] channel.c: Not copying variable SIPURI.
> Mar 31 16:53:57 DEBUG[24349] devicestate.c: Changing state for Zap/1 - state 2
> (In use)
> Mar 31 16:53:57 VERBOSE[11747] logger.c:     -- Requested transfer capability:
> 0x00 - SPEECH
> Mar 31 16:53:57 DEBUG[11751] app_queue.c: Device 'Zap/1' changed to state
> '2' (In use)
> Mar 31 16:53:57 DEBUG[24349] channel.c: Avoiding initial deadlock for
> 'Zap/1-1'
> Mar 31 16:53:57 VERBOSE[11747] logger.c:     -- Called g1/3381765432
> Mar 31 16:53:57 DEBUG[11747] channel.c: Set channel Zap/1-1 to read format
> slin
> Mar 31 16:53:57 DEBUG[11747] channel.c: Set channel SIP/451-0e31 to write
> format slin
> Mar 31 16:53:57 DEBUG[11747] channel.c: Set channel SIP/451-0e31 to read
> format slin
> Mar 31 16:53:57 DEBUG[11747] channel.c: Set channel Zap/1-1 to write format
> slin
> Mar 31 16:53:57 DEBUG[24349] devicestate.c: Changing state for Zap/1 - state 2
> (In use)
> Mar 31 16:53:57 DEBUG[11752] app_queue.c: Device 'Zap/1' changed to state
> '2' (In use)
> Mar 31 16:53:57 DEBUG[11747] rtp.c: Ooh, format changed from unknown to ulaw
> Mar 31 16:53:57 DEBUG[11747] rtp.c: Got RTCP report of 36 bytes
> Mar 31 16:53:57 DEBUG[24364] chan_zap.c: Queuing frame from
> PRI_EVENT_PROCEEDING on channel 0/1 span 1
> Mar 31 16:53:57 VERBOSE[11747] logger.c:     -- Zap/1-1 is proceeding passing
> it to SIP/451-0e31
> Mar 31 16:54:01 DEBUG[24364] chan_zap.c: Enabled echo cancellation on channel
> 1
> Mar 31 16:54:01 VERBOSE[11747] logger.c:     -- Zap/1-1 answered SIP/451-0e31
> Mar 31 16:54:01 DEBUG[11747] channel.c: Set channel SIP/451-0e31 to read
> format slin
> Mar 31 16:54:01 DEBUG[11747] channel.c: Set channel Zap/1-1 to write format
> slin
> Mar 31 16:54:01 DEBUG[11747] channel.c: Set channel Zap/1-1 to read format
> slin
> Mar 31 16:54:01 DEBUG[11747] channel.c: Set channel SIP/451-0e31 to write
> format slin
> Mar 31 16:54:01 DEBUG[11747] chan_sip.c: sip_answer(SIP/451-0e31)
> Mar 31 16:54:01 DEBUG[24349] devicestate.c: Changing state for Zap/1 - state 2
> (In use)
> Mar 31 16:54:01 DEBUG[24349] chan_sip.c: Checking device state for peer 451
> Mar 31 16:54:01 DEBUG[24349] devicestate.c: Changing state for SIP/451 - state
> 2 (In use)
> Mar 31 16:54:01 DEBUG[24349] chan_sip.c: Checking device state for peer 451
> Mar 31 16:54:01 DEBUG[24349] chan_sip.c: Checking device state for peer 451
> Mar 31 16:54:01 DEBUG[24358] chan_sip.c: = Found Their Call ID:
> ipixsmdwtxqusdu at 192.168.11.79 Their Tag fzxtk Our tag: as5ce7b16c
> Mar 31 16:54:01 DEBUG[24358] chan_sip.c: **** Received ACK (6) - Command in
> SIP ACK
> Mar 31 16:54:01 DEBUG[24358] chan_sip.c: Stopping retransmission on
> 'ipixsmdwtxqusdu at 192.168.11.79' of Response 831: Match Found
> Mar 31 16:54:01 DEBUG[11753] app_queue.c: Device 'Zap/1' changed to state
> '2' (In use)
> Mar 31 16:54:01 DEBUG[11754] app_queue.c: Device 'SIP/451' changed to state
> '2' (In use)
> Mar 31 16:54:03 DEBUG[11747] rtp.c: Got RTCP report of 80 bytes
> Mar 31 16:54:06 DEBUG[11688] chan_zap.c: Write returned -1 (Resource
> temporarily unavailable) on channel 2
> Mar 31 16:54:10 DEBUG[11747] rtp.c: Got RTCP report of 80 bytes
> Mar 31 16:54:14 DEBUG[24358] chan_sip.c: = Found Their Call ID:
> ipixsmdwtxqusdu at 192.168.11.79 Their Tag fzxtk Our tag: as5ce7b16c
> Mar 31 16:54:14 DEBUG[24358] chan_sip.c: **** Received BYE (8) - Command in
> SIP BYE
> Mar 31 16:54:14 DEBUG[11747] channel.c: Didn't get a frame from channel:
> SIP/451-0e31
> Mar 31 16:54:14 DEBUG[11747] channel.c: Bridge stops bridging channels
> SIP/451-0e31 and Zap/1-1
> Mar 31 16:54:14 DEBUG[11747] channel.c: Hanging up channel 'Zap/1-1'
> Mar 31 16:54:14 DEBUG[11747] chan_zap.c: zt_hangup(Zap/1-1)
> Mar 31 16:54:14 DEBUG[11747] chan_zap.c: Set option AUDIO MODE, value: ON(1)
> on Zap/1-1
> Mar 31 16:54:14 DEBUG[11747] chan_zap.c: Hangup: channel: 1 index = 0, normal
> = 20, callwait = -1, thirdcall = -1
> Mar 31 16:54:14 DEBUG[11747] chan_zap.c: Not yet hungup...  Calling hangup
> once with icause, and clearing call
> Mar 31 16:54:14 DEBUG[11747] chan_zap.c: disabled echo cancellation on channel
> 1
> Mar 31 16:54:14 DEBUG[11747] chan_zap.c: Set option TDD MODE, value: OFF(0) on
> Zap/1-1
> Mar 31 16:54:14 DEBUG[11747] chan_zap.c: Updated conferencing on 1, with 0
> conference users
> Mar 31 16:54:14 DEBUG[11747] chan_zap.c: Set option AUDIO MODE, value: OFF(0)
> on Zap/1-1
> Mar 31 16:54:14 DEBUG[11747] chan_zap.c: disabled echo cancellation on channel
> 1
> Mar 31 16:54:14 VERBOSE[11747] logger.c:     -- Hungup 'Zap/1-1'
> Mar 31 16:54:14 DEBUG[11747] app_dial.c: Exiting with DIALSTATUS=ANSWER.
> Mar 31 16:54:14 DEBUG[11747] app_macro.c: Spawn extension
> (macro-dialout-trunk,s,14) exited non-zero on 'SIP/451-0e31' in macro
> 'dialout-trunk'
> Mar 31 16:54:14 DEBUG[11747] pbx.c: Spawn extension (macro-dialout-trunk,s,14)
> exited non-zero on 'SIP/451-0e31'
> Mar 31 16:54:14 DEBUG[24349] devicestate.c: Changing state for Zap/1 - state 0
> (Unknown)
> Mar 31 16:54:14 DEBUG[11755] app_queue.c: Device 'Zap/1' changed to state
> '0' (Unknown)
> Mar 31 16:54:14 DEBUG[11747] cdr_addon_mysql.c: cdr_mysql: inserting a CDR
> record.
> Mar 31 16:54:14 DEBUG[11747] cdr_addon_mysql.c: cdr_mysql: SQL command as
> follows: INSERT INTO cdr
> (calldate,clid,src,dst,dcontext,channel,dstchannel,lastapp,lastdata,duration,bil
> lsec,disposition,amaflags,accountcode,uniqueid)
> VALUES ('2006-03-31
> 16:53:56','033811234451','033811234451','003381765432','from-internal',
> 'SIP/451-0e31','Zap/1-1','Dial','ZAP/g1/3381765432',18,13,'ANSWERED',3,'','11438
> 16836.643')
> Mar 31 16:54:14 DEBUG[11747] channel.c: Hanging up channel 'SIP/451-0e31'
> Mar 31 16:54:14 DEBUG[11747] chan_sip.c: Hangup call SIP/451-0e31, SIP callid
> ipixsmdwtxqusdu at 192.168.11.79)
> Mar 31 16:54:14 DEBUG[11747] chan_sip.c: update_call_counter(451) - decrement
> call limit counter
> Mar 31 16:54:14 DEBUG[11747] chan_sip.c: Updating call counter for incoming
> call
> Mar 31 16:54:14 DEBUG[24349] chan_sip.c: Checking device state for peer 451
> Mar 31 16:54:14 DEBUG[24349] devicestate.c: Changing state for SIP/451 - state
> 1 (Not in use)
> Mar 31 16:54:14 DEBUG[24349] chan_sip.c: Checking device state for peer 451
> Mar 31 16:54:14 DEBUG[24349] chan_sip.c: Checking device state for peer 451
> Mar 31 16:54:14 DEBUG[11756] app_queue.c: Device 'SIP/451' changed to state
> '1' (Not in use)
>
>
>
>
> _______________________________________________
> --Bandwidth and Colocation provided by Easynews.com --
>
> Asterisk-Users mailing list
> To UNSUBSCRIBE or update options visit:
>    http://lists.digium.com/mailman/listinfo/asterisk-users
>


--
Tom Vile
Baldwin Technology Solutions, Inc
Consulting - Web Design - VoIP Telephony
www.baldwintechsolutions.com
Phone: 518-631-2855 x205
Fax:     518-631-2856



More information about the asterisk-users mailing list