All pastes #627013 Raw Edit

Anonymous

public text v1 · immutable
·published 2007-07-20 01:20 UTC
rendered paste body
[root@pbx asterisk]# grep "\[5789\]" full
Jul 20 11:16:23 VERBOSE[5789] logger.c:     -- Executing Macro("SIP/325-b7905e28", "dialout-trunk|1|96784806||") in new stack
Jul 20 11:16:23 VERBOSE[5789] logger.c:     -- Executing Set("SIP/325-b7905e28", "DIAL_TRUNK=1") in new stack
Jul 20 11:16:23 DEBUG[5789] app_macro.c: Executed application: Set
Jul 20 11:16:23 VERBOSE[5789] logger.c:     -- Executing Set("SIP/325-b7905e28", "_NODEST=") in new stack
Jul 20 11:16:23 DEBUG[5789] app_macro.c: Executed application: Set
Jul 20 11:16:23 VERBOSE[5789] logger.c:     -- Executing Set("SIP/325-b7905e28", "DIAL_NUMBER=96784806") in new stack
Jul 20 11:16:23 DEBUG[5789] app_macro.c: Executed application: Set
Jul 20 11:16:23 VERBOSE[5789] logger.c:     -- Executing Set("SIP/325-b7905e28", "ROUTE_PASSWD=") in new stack
Jul 20 11:16:23 DEBUG[5789] app_macro.c: Executed application: Set
Jul 20 11:16:23 VERBOSE[5789] logger.c:     -- Executing Set("SIP/325-b7905e28", "DIAL_TRUNK_OPTIONS=tr") in new stack
Jul 20 11:16:23 DEBUG[5789] app_macro.c: Executed application: Set
Jul 20 11:16:23 DEBUG[5789] pbx.c: Expression result is '1'
Jul 20 11:16:23 VERBOSE[5789] logger.c:     -- Executing GotoIf("SIP/325-b7905e28", "1?noauth") in new stack
Jul 20 11:16:23 VERBOSE[5789] logger.c:     -- Goto (macro-dialout-trunk,s,8)
Jul 20 11:16:23 DEBUG[5789] app_macro.c: Executed application: GotoIf
Jul 20 11:16:23 VERBOSE[5789] logger.c:     -- Executing Set("SIP/325-b7905e28", "GROUP()=OUT_1") in new stack
Jul 20 11:16:23 DEBUG[5789] app_macro.c: Executed application: Set
Jul 20 11:16:23 VERBOSE[5789] logger.c:     -- Executing Macro("SIP/325-b7905e28", "user-callerid|SKIPTTL") in new stack
Jul 20 11:16:23 DEBUG[5789] pbx.c: Function result is 'device'
Jul 20 11:16:23 DEBUG[5789] pbx.c: Function result is '325'
Jul 20 11:16:23 VERBOSE[5789] logger.c:     -- Executing NoOp("SIP/325-b7905e28", "user-callerid: device 325") in new stack
Jul 20 11:16:23 DEBUG[5789] app_macro.c: Executed application: Noop
Jul 20 11:16:23 DEBUG[5789] pbx.c: Expression result is '0'
Jul 20 11:16:23 VERBOSE[5789] logger.c:     -- Executing GotoIf("SIP/325-b7905e28", "0?report") in new stack
Jul 20 11:16:23 DEBUG[5789] pbx.c: Not taking any branch
Jul 20 11:16:23 DEBUG[5789] app_macro.c: Executed application: GotoIf
Jul 20 11:16:23 DEBUG[5789] pbx.c: Expression result is '0'
Jul 20 11:16:23 VERBOSE[5789] logger.c:     -- Executing GotoIf("SIP/325-b7905e28", "0?start") in new stack
Jul 20 11:16:23 DEBUG[5789] pbx.c: Not taking any branch
Jul 20 11:16:23 DEBUG[5789] app_macro.c: Executed application: GotoIf
Jul 20 11:16:23 DEBUG[5789] pbx.c: Function result is '325'
Jul 20 11:16:23 VERBOSE[5789] logger.c:     -- Executing Set("SIP/325-b7905e28", "REALCALLERIDNUM=325") in new stack
Jul 20 11:16:23 DEBUG[5789] app_macro.c: Executed application: Set
Jul 20 11:16:23 VERBOSE[5789] logger.c:     -- Executing NoOp("SIP/325-b7905e28", "REALCALLERIDNUM is 325") in new stack
Jul 20 11:16:23 DEBUG[5789] app_macro.c: Executed application: NoOp
Jul 20 11:16:23 DEBUG[5789] pbx.c: Function result is '325'
Jul 20 11:16:23 VERBOSE[5789] logger.c:     -- Executing Set("SIP/325-b7905e28", "AMPUSER=325") in new stack
Jul 20 11:16:23 DEBUG[5789] app_macro.c: Executed application: Set
Jul 20 11:16:23 DEBUG[5789] pbx.c: Function result is 'Ryan Williams'
Jul 20 11:16:23 VERBOSE[5789] logger.c:     -- Executing Set("SIP/325-b7905e28", "AMPUSERCIDNAME=Ryan Williams") in new stack
Jul 20 11:16:23 DEBUG[5789] app_macro.c: Executed application: Set
Jul 20 11:16:23 DEBUG[5789] pbx.c: Expression result is '0'
Jul 20 11:16:23 VERBOSE[5789] logger.c:     -- Executing GotoIf("SIP/325-b7905e28", "0?report") in new stack
Jul 20 11:16:23 DEBUG[5789] pbx.c: Not taking any branch
Jul 20 11:16:23 DEBUG[5789] app_macro.c: Executed application: GotoIf
Jul 20 11:16:23 VERBOSE[5789] logger.c:     -- Executing Set("SIP/325-b7905e28", "CALLERID(all)=Ryan Williams <325>") in new stack
Jul 20 11:16:23 DEBUG[5789] app_macro.c: Executed application: Set
Jul 20 11:16:23 DEBUG[5789] pbx.c: Function result is '325'
Jul 20 11:16:23 VERBOSE[5789] logger.c:     -- Executing Set("SIP/325-b7905e28", "REALCALLERIDNUM=325") in new stack
Jul 20 11:16:23 DEBUG[5789] app_macro.c: Executed application: Set
Jul 20 11:16:23 VERBOSE[5789] logger.c:     -- Executing NoOp("SIP/325-b7905e28", "TTL:  ARG1: SKIPTTL") in new stack
Jul 20 11:16:23 DEBUG[5789] app_macro.c: Executed application: Noop
Jul 20 11:16:23 DEBUG[5789] pbx.c: Expression result is '1'
Jul 20 11:16:23 VERBOSE[5789] logger.c:     -- Executing GotoIf("SIP/325-b7905e28", "1?continue") in new stack
Jul 20 11:16:23 VERBOSE[5789] logger.c:     -- Goto (macro-user-callerid,s,21)
Jul 20 11:16:23 DEBUG[5789] app_macro.c: Executed application: GotoIf
Jul 20 11:16:23 DEBUG[5789] pbx.c: Function result is '"Ryan Williams" <325>'
Jul 20 11:16:23 VERBOSE[5789] logger.c:     -- Executing NoOp("SIP/325-b7905e28", "Using CallerID "Ryan Williams" <325>") in new stack
Jul 20 11:16:23 DEBUG[5789] app_macro.c: Executed application: NoOp
Jul 20 11:16:23 DEBUG[5789] app_macro.c: Executed application: Macro
Jul 20 11:16:23 DEBUG[5789] pbx.c: Function result is '325'
Jul 20 11:16:23 VERBOSE[5789] logger.c:     -- Executing Macro("SIP/325-b7905e28", "record-enable|325|OUT") in new stack
Jul 20 11:16:23 DEBUG[5789] pbx.c: Function result is '0'
Jul 20 11:16:23 DEBUG[5789] pbx.c: Expression result is '0'
Jul 20 11:16:23 VERBOSE[5789] logger.c:     -- Executing GotoIf("SIP/325-b7905e28", "0?2:4") in new stack
Jul 20 11:16:23 VERBOSE[5789] logger.c:     -- Goto (macro-record-enable,s,4)
Jul 20 11:16:23 DEBUG[5789] app_macro.c: Executed application: GotoIf
Jul 20 11:16:23 VERBOSE[5789] logger.c:     -- Executing DeadAGI("SIP/325-b7905e28", "recordingcheck|20070720-111623|1184894183.224") in new stack
Jul 20 11:16:23 VERBOSE[5789] logger.c:     -- Launched AGI Script /var/lib/asterisk/agi-bin/recordingcheck
Jul 20 11:16:23 VERBOSE[5789] logger.c:   recordingcheck|20070720-111623|1184894183.224: Outbound recording not enabled
Jul 20 11:16:23 VERBOSE[5789] logger.c:     -- AGI Script recordingcheck completed, returning 0
Jul 20 11:16:23 DEBUG[5789] app_macro.c: Executed application: DeadAGI
Jul 20 11:16:23 VERBOSE[5789] logger.c:     -- Executing NoOp("SIP/325-b7905e28", "No recording needed") in new stack
Jul 20 11:16:23 DEBUG[5789] app_macro.c: Executed application: Noop
Jul 20 11:16:23 DEBUG[5789] app_macro.c: Executed application: Macro
Jul 20 11:16:23 DEBUG[5789] pbx.c: Expression result is '0'
Jul 20 11:16:23 VERBOSE[5789] logger.c:     -- Executing GotoIf("SIP/325-b7905e28", "0?skipoutcid") in new stack
Jul 20 11:16:23 DEBUG[5789] pbx.c: Not taking any branch
Jul 20 11:16:23 DEBUG[5789] app_macro.c: Executed application: GotoIf
Jul 20 11:16:23 VERBOSE[5789] logger.c:     -- Executing Set("SIP/325-b7905e28", "DIAL_TRUNK_OPTIONS=") in new stack
Jul 20 11:16:23 DEBUG[5789] app_macro.c: Executed application: Set
Jul 20 11:16:23 VERBOSE[5789] logger.c:     -- Executing Macro("SIP/325-b7905e28", "outbound-callerid|1") in new stack
Jul 20 11:16:23 DEBUG[5789] pbx.c: Expression result is '1'
Jul 20 11:16:23 VERBOSE[5789] logger.c:     -- Executing GotoIf("SIP/325-b7905e28", "1?start") in new stack
Jul 20 11:16:23 VERBOSE[5789] logger.c:     -- Goto (macro-outbound-callerid,s,3)
Jul 20 11:16:23 DEBUG[5789] app_macro.c: Executed application: GotoIf
Jul 20 11:16:23 VERBOSE[5789] logger.c:     -- Executing NoOp("SIP/325-b7905e28", "REALCALLERIDNUM is 325") in new stack
Jul 20 11:16:23 DEBUG[5789] app_macro.c: Executed application: NoOp
Jul 20 11:16:23 DEBUG[5789] pbx.c: Expression result is '1'
Jul 20 11:16:23 VERBOSE[5789] logger.c:     -- Executing GotoIf("SIP/325-b7905e28", "1?normcid") in new stack
Jul 20 11:16:23 VERBOSE[5789] logger.c:     -- Goto (macro-outbound-callerid,s,9)
Jul 20 11:16:23 DEBUG[5789] app_macro.c: Executed application: GotoIf
Jul 20 11:16:23 DEBUG[5789] pbx.c: Function result is '243200325'
Jul 20 11:16:23 VERBOSE[5789] logger.c:     -- Executing Set("SIP/325-b7905e28", "USEROUTCID=243200325") in new stack
Jul 20 11:16:23 DEBUG[5789] app_macro.c: Executed application: Set
Jul 20 11:16:23 DEBUG[5789] db.c: Unable to find key '325/emergency_cid' in family 'DEVICE'
Jul 20 11:16:23 DEBUG[5789] func_db.c: DB: DEVICE/325/emergency_cid not found in database.
Jul 20 11:16:23 DEBUG[5789] pbx.c: Function result is ''
Jul 20 11:16:23 VERBOSE[5789] logger.c:     -- Executing Set("SIP/325-b7905e28", "EMERGENCYCID=") in new stack
Jul 20 11:16:23 DEBUG[5789] app_macro.c: Executed application: Set
Jul 20 11:16:23 VERBOSE[5789] logger.c:     -- Executing Set("SIP/325-b7905e28", "TRUNKOUTCID=243200300") in new stack
Jul 20 11:16:23 DEBUG[5789] app_macro.c: Executed application: Set
Jul 20 11:16:23 DEBUG[5789] pbx.c: Expression result is '1'
Jul 20 11:16:23 VERBOSE[5789] logger.c:     -- Executing GotoIf("SIP/325-b7905e28", "1?trunkcid") in new stack
Jul 20 11:16:23 VERBOSE[5789] logger.c:     -- Goto (macro-outbound-callerid,s,16)
Jul 20 11:16:23 DEBUG[5789] app_macro.c: Executed application: GotoIf
Jul 20 11:16:23 DEBUG[5789] pbx.c: Expression result is '0'
Jul 20 11:16:23 VERBOSE[5789] logger.c:     -- Executing GotoIf("SIP/325-b7905e28", "0?usercid") in new stack
Jul 20 11:16:23 DEBUG[5789] pbx.c: Not taking any branch
Jul 20 11:16:23 DEBUG[5789] app_macro.c: Executed application: GotoIf
Jul 20 11:16:23 VERBOSE[5789] logger.c:     -- Executing Set("SIP/325-b7905e28", "CALLERID(all)=243200300") in new stack
Jul 20 11:16:23 DEBUG[5789] app_macro.c: Executed application: Set
Jul 20 11:16:23 DEBUG[5789] pbx.c: Expression result is '0'
Jul 20 11:16:23 VERBOSE[5789] logger.c:     -- Executing GotoIf("SIP/325-b7905e28", "0?report") in new stack
Jul 20 11:16:23 DEBUG[5789] pbx.c: Not taking any branch
Jul 20 11:16:23 DEBUG[5789] app_macro.c: Executed application: GotoIf
Jul 20 11:16:23 VERBOSE[5789] logger.c:     -- Executing Set("SIP/325-b7905e28", "CALLERID(all)=243200325") in new stack
Jul 20 11:16:23 DEBUG[5789] app_macro.c: Executed application: Set
Jul 20 11:16:23 DEBUG[5789] pbx.c: Function result is ''
Jul 20 11:16:23 DEBUG[5789] pbx.c: Expression result is '1'
Jul 20 11:16:23 VERBOSE[5789] logger.c:     -- Executing GotoIf("SIP/325-b7905e28", "1?report:hidecid") in new stack
Jul 20 11:16:23 VERBOSE[5789] logger.c:     -- Goto (macro-outbound-callerid,s,22)
Jul 20 11:16:23 DEBUG[5789] app_macro.c: Executed application: GotoIf
Jul 20 11:16:23 DEBUG[5789] pbx.c: Function result is '"" <243200325>'
Jul 20 11:16:23 VERBOSE[5789] logger.c:     -- Executing NoOp("SIP/325-b7905e28", "CallerID set to "" <243200325>") in new stack
Jul 20 11:16:23 DEBUG[5789] app_macro.c: Executed application: NoOp
Jul 20 11:16:23 DEBUG[5789] app_macro.c: Executed application: Macro
Jul 20 11:16:23 DEBUG[5789] pbx.c: Expression result is '1'
Jul 20 11:16:23 VERBOSE[5789] logger.c:     -- Executing GotoIf("SIP/325-b7905e28", "1?nomax") in new stack
Jul 20 11:16:23 VERBOSE[5789] logger.c:     -- Goto (macro-dialout-trunk,s,16)
Jul 20 11:16:23 DEBUG[5789] app_macro.c: Executed application: GotoIf
Jul 20 11:16:23 VERBOSE[5789] logger.c:     -- Executing DeadAGI("SIP/325-b7905e28", "fixlocalprefix") in new stack
Jul 20 11:16:23 VERBOSE[5789] logger.c:     -- Launched AGI Script /var/lib/asterisk/agi-bin/fixlocalprefix
Jul 20 11:16:23 VERBOSE[5789] logger.c:   ==  fixlocalprefix: Dialpattern XXXXXXXX matched. 96784806 -> 96784806
Jul 20 11:16:23 VERBOSE[5789] logger.c:     -- AGI Script fixlocalprefix completed, returning 0
Jul 20 11:16:23 DEBUG[5789] app_macro.c: Executed application: DeadAGI
Jul 20 11:16:23 VERBOSE[5789] logger.c:     -- Executing Set("SIP/325-b7905e28", "OUTNUM=96784806") in new stack
Jul 20 11:16:23 DEBUG[5789] app_macro.c: Executed application: Set
Jul 20 11:16:23 DEBUG[5789] pbx.c: Function result is 'ZAP/g0'
Jul 20 11:16:23 VERBOSE[5789] logger.c:     -- Executing Set("SIP/325-b7905e28", "custom=ZAP/g0") in new stack
Jul 20 11:16:23 DEBUG[5789] app_macro.c: Executed application: Set
Jul 20 11:16:23 DEBUG[5789] pbx.c: Expression result is '0'
Jul 20 11:16:23 VERBOSE[5789] logger.c:     -- Executing GotoIf("SIP/325-b7905e28", "0?customtrunk") in new stack
Jul 20 11:16:23 DEBUG[5789] pbx.c: Not taking any branch
Jul 20 11:16:23 DEBUG[5789] app_macro.c: Executed application: GotoIf
Jul 20 11:16:23 VERBOSE[5789] logger.c:     -- Executing Dial("SIP/325-b7905e28", "ZAP/g0/96784806|300|") in new stack
Jul 20 11:16:23 VERBOSE[5789] logger.c:     -- Requested transfer capability: 0x00 - SPEECH
Jul 20 11:16:23 VERBOSE[5789] logger.c:
Jul 20 11:16:23 VERBOSE[5789] logger.c:
Jul 20 11:16:23 VERBOSE[5789] logger.c: > SAPI: 00  C/R: 0 EA: 0
Jul 20 11:16:23 VERBOSE[5789] logger.c: > N(S): 017   0: 0
Jul 20 11:16:23 VERBOSE[5789] logger.c: -- Restarting T203 counter
Jul 20 11:16:23 VERBOSE[5789] logger.c: Stopping T_203 timer
Jul 20 11:16:23 VERBOSE[5789] logger.c: Starting T_200 timer
Jul 20 11:16:23 VERBOSE[5789] logger.c: > Protocol Discriminator: Q.931 (8)  len=40
Jul 20 11:16:23 VERBOSE[5789] logger.c: > Call Ref: len= 2 (reference 33/0x21) (Originator)
Jul 20 11:16:23 VERBOSE[5789] logger.c: > Message type: SETUP (5)
Jul 20 11:16:23 VERBOSE[5789] logger.c: > [04 03 80 90 a3]
Jul 20 11:16:23 VERBOSE[5789] logger.c: > Bearer Capability (len= 5) [ Ext: 1  Q.931 Std: 0  Info transfer capability: Speech (0)
Jul 20 11:16:23 VERBOSE[5789] logger.c: >                              Ext: 1  Trans mode/rate: 64kbps, circuit-mode (16)
Jul 20 11:16:23 VERBOSE[5789] logger.c: >                              Ext: 1  User information layer 1: A-Law (35)
Jul 20 11:16:23 VERBOSE[5789] logger.c: > [18 03 a9 83 81]
Jul 20 11:16:23 VERBOSE[5789] logger.c: > Channel ID (len= 5) [ Ext: 1  IntID: Implicit  PRI  Spare: 0  Exclusive  Dchan: 0
Jul 20 11:16:23 VERBOSE[5789] logger.c: >                        ChanSel: Reserved
Jul 20 11:16:23 VERBOSE[5789] logger.c: >                       Ext: 1  Coding: 0  Number Specified  Channel Type: 3
Jul 20 11:16:23 VERBOSE[5789] logger.c: >                       Ext: 1  Channel: 1 ]
Jul 20 11:16:23 VERBOSE[5789] logger.c: > [6c 0b 21 80 32 34 33 32 30 30 33 32 35]
Jul 20 11:16:23 VERBOSE[5789] logger.c: > Calling Number (len=13) [ Ext: 0  TON: National Number (2)  NPI: ISDN/Telephony Numbering Plan (E.164/E.163) (1)
Jul 20 11:16:23 VERBOSE[5789] logger.c: >                           Presentation: Presentation permitted, user number not screened (0)  '243200325' ]
Jul 20 11:16:23 VERBOSE[5789] logger.c: > [70 09 c1 39 36 37 38 34 38 30 36]
Jul 20 11:16:23 VERBOSE[5789] logger.c: > Called Number (len=11) [ Ext: 1  TON: Subscriber Number (4)  NPI: ISDN/Telephony Numbering Plan (E.164/E.163) (1)  '96784806' ]
Jul 20 11:16:23 VERBOSE[5789] logger.c: > [a1]
Jul 20 11:16:23 VERBOSE[5789] logger.c: > Sending Complete (len= 1)
Jul 20 11:16:23 VERBOSE[5789] logger.c:     -- Called g0/96784806
Jul 20 11:16:23 VERBOSE[5789] logger.c:     -- Zap/1-1 is proceeding passing it to SIP/325-b7905e28
Jul 20 11:16:25 VERBOSE[5789] logger.c:     -- Zap/1-1 is ringing
Jul 20 11:16:31 VERBOSE[5789] logger.c:     -- Zap/1-1 answered SIP/325-b7905e28
Jul 20 11:16:37 DEBUG[5789] channel.c: Got a FRAME_CONTROL (5) frame on channel Zap/1-1
Jul 20 11:16:37 DEBUG[5789] channel.c: Bridge stops bridging channels SIP/325-b7905e28 and Zap/1-1
Jul 20 11:16:37 DEBUG[5789] chan_zap.c: Set option AUDIO MODE, value: ON(1) on Zap/1-1
Jul 20 11:16:37 DEBUG[5789] chan_zap.c: Hangup: channel: 1 index = 0, normal = 15, callwait = -1, thirdcall = -1
Jul 20 11:16:37 DEBUG[5789] chan_zap.c: Not yet hungup...  Calling hangup once with icause, and clearing call
Jul 20 11:16:37 VERBOSE[5789] logger.c:
Jul 20 11:16:37 VERBOSE[5789] logger.c:
Jul 20 11:16:37 VERBOSE[5789] logger.c: > SAPI: 00  C/R: 0 EA: 0
Jul 20 11:16:37 VERBOSE[5789] logger.c: > N(S): 019   0: 0
Jul 20 11:16:37 VERBOSE[5789] logger.c: -- Restarting T203 counter
Jul 20 11:16:37 VERBOSE[5789] logger.c: Stopping T_203 timer
Jul 20 11:16:37 VERBOSE[5789] logger.c: Starting T_200 timer
Jul 20 11:16:37 VERBOSE[5789] logger.c: > Protocol Discriminator: Q.931 (8)  len=9
Jul 20 11:16:37 VERBOSE[5789] logger.c: > Call Ref: len= 2 (reference 33/0x21) (Originator)
Jul 20 11:16:37 VERBOSE[5789] logger.c: > Message type: DISCONNECT (69)
Jul 20 11:16:37 VERBOSE[5789] logger.c: > [08 02 81 90]
Jul 20 11:16:37 VERBOSE[5789] logger.c: > Cause (len= 4) [ Ext: 1  Coding: CCITT (ITU) standard (0)  Spare: 0  Location: Private network serving the local user (1)
Jul 20 11:16:37 VERBOSE[5789] logger.c: >                  Ext: 1  Cause: Normal Clearing (16), class = Normal Event (1) ]
Jul 20 11:16:37 DEBUG[5789] chan_zap.c: disabled echo cancellation on channel 1
Jul 20 11:16:37 DEBUG[5789] chan_zap.c: Set option TDD MODE, value: OFF(0) on Zap/1-1
Jul 20 11:16:37 DEBUG[5789] chan_zap.c: Updated conferencing on 1, with 0 conference users
Jul 20 11:16:37 DEBUG[5789] chan_zap.c: Set option AUDIO MODE, value: OFF(0) on Zap/1-1
Jul 20 11:16:37 DEBUG[5789] chan_zap.c: disabled echo cancellation on channel 1
Jul 20 11:16:37 VERBOSE[5789] logger.c:     -- Hungup 'Zap/1-1'
Jul 20 11:16:37 DEBUG[5789] app_dial.c: Exiting with DIALSTATUS=ANSWER.
Jul 20 11:16:37 VERBOSE[5789] logger.c:   == Spawn extension (macro-dialout-trunk, s, 20) exited non-zero on 'SIP/325-b7905e28' in macro 'dialout-trunk'
Jul 20 11:16:37 VERBOSE[5789] logger.c:   == Spawn extension (macro-dialout-trunk, s, 20) exited non-zero on 'SIP/325-b7905e28'
Jul 20 11:16:37 VERBOSE[5789] logger.c:     -- Executing Macro("SIP/325-b7905e28", "hangupcall") in new stack
Jul 20 11:16:37 VERBOSE[5789] logger.c:     -- Executing ResetCDR("SIP/325-b7905e28", "w") in new stack
Jul 20 11:16:37 DEBUG[5789] cdr_addon_mysql.c: cdr_mysql: inserting a CDR record.
Jul 20 11:16:37 DEBUG[5789] cdr_addon_mysql.c: cdr_mysql: SQL command as follows: INSERT INTO cdr (calldate,clid,src,dst,dcontext,channel,dstchannel,lastapp,lastdata,duration,billsec,disposition,amaflags,accountcode) VALUES ('2007-07-20 11:16:23','243200325','243200325','96784806','from-internal', 'SIP/325-b7905e28','Zap/1-1','ResetCDR','w',14,6,'ANSWERED',3,'')
Jul 20 11:16:37 DEBUG[5789] pbx.c: Function result is '243200325'
Jul 20 11:16:37 DEBUG[5789] pbx.c: Function result is '243200325'
Jul 20 11:16:37 DEBUG[5789] pbx.c: Function result is '96784806'
Jul 20 11:16:37 DEBUG[5789] pbx.c: Function result is 'from-internal'
Jul 20 11:16:37 DEBUG[5789] pbx.c: Function result is 'SIP/325-b7905e28'
Jul 20 11:16:37 DEBUG[5789] pbx.c: Function result is 'Zap/1-1'
Jul 20 11:16:37 DEBUG[5789] pbx.c: Function result is 'ResetCDR'
Jul 20 11:16:37 DEBUG[5789] pbx.c: Function result is 'w'
Jul 20 11:16:37 DEBUG[5789] pbx.c: Function result is '2007-07-20 11:16:23'
Jul 20 11:16:37 DEBUG[5789] pbx.c: Function result is '2007-07-20 11:16:31'
Jul 20 11:16:37 DEBUG[5789] pbx.c: Function result is '2007-07-20 11:16:37'
Jul 20 11:16:37 DEBUG[5789] pbx.c: Function result is '14'
Jul 20 11:16:37 DEBUG[5789] pbx.c: Function result is '6'
Jul 20 11:16:37 DEBUG[5789] pbx.c: Function result is 'ANSWERED'
Jul 20 11:16:37 DEBUG[5789] pbx.c: Function result is 'DOCUMENTATION'
Jul 20 11:16:37 DEBUG[5789] pbx.c: Function result is '(null)'
Jul 20 11:16:37 DEBUG[5789] pbx.c: Function result is '1184894183.224'
Jul 20 11:16:37 DEBUG[5789] pbx.c: Function result is '(null)'
Jul 20 11:16:37 DEBUG[5789] app_macro.c: Executed application: ResetCDR
Jul 20 11:16:37 VERBOSE[5789] logger.c:     -- Executing NoCDR("SIP/325-b7905e28", "") in new stack
Jul 20 11:16:37 NOTICE[5789] cdr.c: CDR on channel 'SIP/325-b7905e28' not posted
Jul 20 11:16:37 NOTICE[5789] cdr.c: CDR on channel 'SIP/325-b7905e28' lacks end
Jul 20 11:16:37 DEBUG[5789] app_macro.c: Executed application: NoCDR
Jul 20 11:16:37 DEBUG[5789] pbx.c: Expression result is '1'
Jul 20 11:16:37 VERBOSE[5789] logger.c:     -- Executing GotoIf("SIP/325-b7905e28", "1?skiprg") in new stack
Jul 20 11:16:37 VERBOSE[5789] logger.c:     -- Goto (macro-hangupcall,s,6)
Jul 20 11:16:37 DEBUG[5789] app_macro.c: Executed application: GotoIf
Jul 20 11:16:37 DEBUG[5789] pbx.c: Expression result is '1'
Jul 20 11:16:37 VERBOSE[5789] logger.c:     -- Executing GotoIf("SIP/325-b7905e28", "1?theend") in new stack
Jul 20 11:16:37 VERBOSE[5789] logger.c:     -- Goto (macro-hangupcall,s,9)
Jul 20 11:16:37 DEBUG[5789] app_macro.c: Executed application: GotoIf
Jul 20 11:16:37 VERBOSE[5789] logger.c:     -- Executing Wait("SIP/325-b7905e28", "5") in new stack
Jul 20 11:16:42 DEBUG[5789] app_macro.c: Executed application: Wait
Jul 20 11:16:42 VERBOSE[5789] logger.c:     -- Executing Hangup("SIP/325-b7905e28", "") in new stack
Jul 20 11:16:42 VERBOSE[5789] logger.c:   == Spawn extension (macro-hangupcall, s, 10) exited non-zero on 'SIP/325-b7905e28' in macro 'hangupcall'
Jul 20 11:16:42 VERBOSE[5789] logger.c:   == Spawn extension (macro-hangupcall, s, 10) exited non-zero on 'SIP/325-b7905e28'
Jul 20 11:16:42 DEBUG[5789] chan_sip.c: update_call_counter(325) - decrement call limit counter
[root@pbx asterisk]#