Rx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: NEW Timestamp: 00003ms SCall: 00005 DCall: 00000 [217.14.132.185:4569] VERSION : 2 CALLED NUMBER : 01225808485 CODEC_PREFS : (ilbc|gsm|ulaw|alaw|g729) CALLING NUMBER : 07921464106 CALLING PRESNTN : 0 CALLING TYPEOFN : 0 CALLING TRANSIT : 0 CALLING NAME : 07921464106 LANGUAGE : en USERNAME : 01225808485 FORMAT : 8 CAPABILITY : 64782 ADSICPE : 2 DATE TIME : 2007-06-23 14:35:02 -- Accepting UNAUTHENTICATED call from 217.14.132.185: > requested format = alaw, > requested prefs = (ilbc|gsm|ulaw|alaw|g729), > actual format = ulaw, > host prefs = (ulaw|alaw|gsm), > priority = mine Tx-Frame Retry[000] -- OSeqno: 000 ISeqno: 001 Type: IAX Subclass: ACCEPT Timestamp: 00001ms SCall: 00002 DCall: 00005 [217.14.132.185:4569] FORMAT : 4 -- Executing Set("IAX2/217.14.132.185:4569-2", "FROM_DID=01225808485") in new stack -- Executing Goto("IAX2/217.14.132.185:4569-2", "from-did-direct|200|1") in new stack -- Goto (from-did-direct,200,1) -- Executing Macro("IAX2/217.14.132.185:4569-2", "exten-vm|200|200") in new stack -- Executing Macro("IAX2/217.14.132.185:4569-2", "user-callerid") in new stack -- Executing NoOp("IAX2/217.14.132.185:4569-2", "user-callerid: 07921464106 07921464106") in new stack -- Executing GotoIf("IAX2/217.14.132.185:4569-2", "0?report") in new stack -- Executing GotoIf("IAX2/217.14.132.185:4569-2", "0?start") in new stack -- Executing Set("IAX2/217.14.132.185:4569-2", "REALCALLERIDNUM=07921464106") in new stack -- Executing NoOp("IAX2/217.14.132.185:4569-2", "REALCALLERIDNUM is 07921464106") in new stack -- Executing Set("IAX2/217.14.132.185:4569-2", "AMPUSER=") in new stack -- Executing Set("IAX2/217.14.132.185:4569-2", "AMPUSERCIDNAME=") in new stack -- Executing GotoIf("IAX2/217.14.132.185:4569-2", "1?report") in new stack -- Goto (macro-user-callerid,s,11) -- Executing NoOp("IAX2/217.14.132.185:4569-2", "TTL: ARG1: 200") in new stack -- Executing GotoIf("IAX2/217.14.132.185:4569-2", "0?continue") in new stack -- Executing Set("IAX2/217.14.132.185:4569-2", "_TTL=64") in new stack -- Executing GotoIf("IAX2/217.14.132.185:4569-2", "1?continue") in new stack -- Goto (macro-user-callerid,s,21) -- Executing NoOp("IAX2/217.14.132.185:4569-2", "Using CallerID "07921464106" <07921464106>") in new stack -- Executing Set("IAX2/217.14.132.185:4569-2", "FROMCONTEXT=exten-vm") in new stack -- Executing Set("IAX2/217.14.132.185:4569-2", "VMBOX=200") in new stack -- Executing Set("IAX2/217.14.132.185:4569-2", "EXTTOCALL=200") in new stack -- Executing Set("IAX2/217.14.132.185:4569-2", "CFUEXT=") in new stack -- Executing Set("IAX2/217.14.132.185:4569-2", "CFBEXT=") in new stack -- Executing Set("IAX2/217.14.132.185:4569-2", "RT=15") in new stack -- Executing Macro("IAX2/217.14.132.185:4569-2", "record-enable|200|IN") in new stack -- Executing GotoIf("IAX2/217.14.132.185:4569-2", "0?2:4") in new stack -- Goto (macro-record-enable,s,4) -- Executing DeadAGI("IAX2/217.14.132.185:4569-2", "recordingcheck|20070623-143402|1182605642.97") in new stack -- Launched AGI Script /var/lib/asterisk/agi-bin/recordingcheck Rx-Frame Retry[ No] -- OSeqno: 001 ISeqno: 001 Type: IAX Subclass: ACK Timestamp: 00001ms SCall: 00005 DCall: 00002 [217.14.132.185:4569] recordingcheck|20070623-143402|1182605642.97: Inbound recording enabled. recordingcheck|20070623-143402|1182605642.97: CALLFILENAME=20070623-143402-1182605642.97 -- AGI Script recordingcheck completed, returning 0 -- Executing MixMonitor("IAX2/217.14.132.185:4569-2", "20070623-143402-1182605642.97.wav") in new stack -- Executing Macro("IAX2/217.14.132.185:4569-2", "dial|15|tr|200") in new stack -- Executing DeadAGI("IAX2/217.14.132.185:4569-2", "dialparties.agi") in new stack -- Launched AGI Script /var/lib/asterisk/agi-bin/dialparties.agi == Begin MixMonitor Recording IAX2/217.14.132.185:4569-2 dialparties.agi: Starting New Dialparties.agi dialparties.agi: priority is 1 dialparties.agi: Caller ID name is '07921464106' number is '07921464106' dialparties.agi: Methodology of ring is 'none' > dialparties.agi: USE_CONFIRMATION: 'FALSE' > dialparties.agi: RINGGROUP_INDEX: '' -- dialparties.agi: Added extension 200 to extension map -- dialparties.agi: Extension 200 cf is disabled -- dialparties.agi: Extension 200 do not disturb is disabled > dialparties.agi: extnum: 200 > dialparties.agi: exthascw: 1 > dialparties.agi: exthascfb: 0 > dialparties.agi: extcfb: > dialparties.agi: exthascfu: 0 > dialparties.agi: extcfu: -- dialparties.agi: dbset CALLTRACE/200 to 07921464106 -- AGI Script dialparties.agi completed, returning 0 -- Executing Dial("IAX2/217.14.132.185:4569-2", "SIP/200|15|tr") in new stack -- Called 200 Tx-Frame Retry[000] -- OSeqno: 001 ISeqno: 001 Type: CONTROL Subclass: RINGING Timestamp: 00193ms SCall: 00002 DCall: 00005 [217.14.132.185:4569] -- Got SIP response 486 "Busy Here" back from 192.168.0.8 -- SIP/200-09e664c0 is busy == Everyone is busy/congested at this time (1:1/0/0) -- Executing GosubIf("IAX2/217.14.132.185:4569-2", "0?docfu|1") in new stack -- Executing GosubIf("IAX2/217.14.132.185:4569-2", "0?docfb|1") in new stack -- Executing NoOp("IAX2/217.14.132.185:4569-2", "Voicemail is 200") in new stack -- Executing GotoIf("IAX2/217.14.132.185:4569-2", "0?s-BUSY|1") in new stack -- Executing NoOp("IAX2/217.14.132.185:4569-2", "Sending to Voicemail box 200") in new stack -- Executing Macro("IAX2/217.14.132.185:4569-2", "vm|200|BUSY") in new stack -- Executing Macro("IAX2/217.14.132.185:4569-2", "user-callerid|SKIPTTL") in new stack -- Executing NoOp("IAX2/217.14.132.185:4569-2", "user-callerid: 07921464106 07921464106") in new stack -- Executing GotoIf("IAX2/217.14.132.185:4569-2", "0?report") in new stack -- Executing GotoIf("IAX2/217.14.132.185:4569-2", "1?start") in new stack -- Goto (macro-user-callerid,s,5) -- Executing NoOp("IAX2/217.14.132.185:4569-2", "REALCALLERIDNUM is 07921464106") in new stack -- Executing Set("IAX2/217.14.132.185:4569-2", "AMPUSER=") in new stack -- Executing Set("IAX2/217.14.132.185:4569-2", "AMPUSERCIDNAME=") in new stack -- Executing GotoIf("IAX2/217.14.132.185:4569-2", "1?report") in new stack -- Goto (macro-user-callerid,s,11) -- Executing NoOp("IAX2/217.14.132.185:4569-2", "TTL: 64 ARG1: SKIPTTL") in new stack -- Executing GotoIf("IAX2/217.14.132.185:4569-2", "1?continue") in new stack -- Goto (macro-user-callerid,s,21) -- Executing NoOp("IAX2/217.14.132.185:4569-2", "Using CallerID "07921464106" <07921464106>") in new stack -- Executing Set("IAX2/217.14.132.185:4569-2", "VMGAIN=") in new stack -- Executing GotoIf("IAX2/217.14.132.185:4569-2", "1?s-BUSY|1") in new stack -- Goto (macro-vm,s-BUSY,1) -- Executing NoOp("IAX2/217.14.132.185:4569-2", "BUSY voicemail") in new stack -- Executing Macro("IAX2/217.14.132.185:4569-2", "get-vmcontext|200") in new stack -- Executing Set("IAX2/217.14.132.185:4569-2", "VMCONTEXT=default") in new stack -- Executing GotoIf("IAX2/217.14.132.185:4569-2", "0?200:300") in new stack -- Goto (macro-get-vmcontext,s,300) -- Executing NoOp("IAX2/217.14.132.185:4569-2", "") in new stack -- Executing VoiceMail("IAX2/217.14.132.185:4569-2", "200@default|b") in new stack -- Playing 'vm-theperson' (language 'en') Tx-Frame Retry[000] -- OSeqno: 002 ISeqno: 001 Type: CONTROL Subclass: (255?) Timestamp: 00196ms SCall: 00002 DCall: 00005 [217.14.132.185:4569] Tx-Frame Retry[000] -- OSeqno: 003 ISeqno: 001 Type: CONTROL Subclass: ANSWER Timestamp: 00199ms SCall: 00002 DCall: 00005 [217.14.132.185:4569] Tx-Frame Retry[000] -- OSeqno: 004 ISeqno: 001 Type: VOICE Subclass: 4 Timestamp: 00220ms SCall: 00002 DCall: 00005 [217.14.132.185:4569] Rx-Frame Retry[ No] -- OSeqno: 001 ISeqno: 002 Type: IAX Subclass: ACK Timestamp: 00193ms SCall: 00005 DCall: 00002 [217.14.132.185:4569] Rx-Frame Retry[ No] -- OSeqno: 001 ISeqno: 003 Type: IAX Subclass: ACK Timestamp: 00196ms SCall: 00005 DCall: 00002 [217.14.132.185:4569] Rx-Frame Retry[ No] -- OSeqno: 001 ISeqno: 004 Type: IAX Subclass: ACK Timestamp: 00199ms SCall: 00005 DCall: 00002 [217.14.132.185:4569] Rx-Frame Retry[ No] -- OSeqno: 001 ISeqno: 005 Type: IAX Subclass: ACK Timestamp: 00220ms SCall: 00005 DCall: 00002 [217.14.132.185:4569] Rx-Frame Retry[ No] -- OSeqno: 001 ISeqno: 005 Type: VOICE Subclass: 4 Timestamp: 00534ms SCall: 00005 DCall: 00002 [217.14.132.185:4569] Tx-Frame Retry[-01] -- OSeqno: 005 ISeqno: 002 Type: IAX Subclass: ACK Timestamp: 00534ms SCall: 00002 DCall: 00005 [217.14.132.185:4569] -- Playing 'digits/2' (language 'en') Rx-Frame Retry[ No] -- OSeqno: 002 ISeqno: 005 Type: IAX Subclass: HANGUP Timestamp: 02104ms SCall: 00005 DCall: 00002 [217.14.132.185:4569] CAUSE CODE : 16 Tx-Frame Retry[-01] -- OSeqno: 005 ISeqno: 003 Type: IAX Subclass: ACK Timestamp: 02104ms SCall: 00002 DCall: 00005 [217.14.132.185:4569] == Spawn extension (macro-vm, s-BUSY, 3) exited non-zero on 'IAX2/217.14.132.185:4569-2' in macro 'vm' == Spawn extension (macro-vm, s-BUSY, 3) exited non-zero on 'IAX2/217.14.132.185:4569-2' in macro 'exten-vm' == Spawn extension (macro-vm, s-BUSY, 3) exited non-zero on 'IAX2/217.14.132.185:4569-2' == End MixMonitor Recording IAX2/217.14.132.185:4569-2 -- Hungup 'IAX2/217.14.132.185:4569-2'