I am using X-Lite as my softphone connected to our server (Asterisk v1.4.18 & FreePBX v2.7.0.4) and it works great. The server and my computer are in the US. My computer is running Win XP Pro SP3.
We have a small office in Australia, so I had them install X-Lite on their Vista computer, and have setup their extension identical to my extension, but whenever they call me, if I answer it hangs up immediately. If I do not answer, and let it go to voicemail, it will hang up immediately on going to voicemail as well. If I call them, and they answer, it hangs up immediately.
Their X-Lite settings are the same as mine as well.
Any ideas? Any hints appreciated.
Thanks
Here is the Asterisk log file… it’s starts with them calling me, and then after it hangs up I try to call them:
[Jul 5 11:11:52] VERBOSE[24658] logger.c: -- Executing [1077@from-internal:1] Macro("SIP/1161-b7706b40", "exten-vm|1077|1077") in new stack
[Jul 5 11:11:52] VERBOSE[24658] logger.c: -- Executing [s@macro-exten-vm:1] Macro("SIP/1161-b7706b40", "user-callerid|") in new stack
[Jul 5 11:11:52] VERBOSE[24658] logger.c: -- Executing [s@macro-user-callerid:1] Set("SIP/1161-b7706b40", "AMPUSER=1161") in new stack
[Jul 5 11:11:52] DEBUG[24658] app_macro.c: Executed application: Set
[Jul 5 11:11:52] VERBOSE[24658] logger.c: -- Executing [s@macro-user-callerid:2] GotoIf("SIP/1161-b7706b40", "0?report") in new stack
[Jul 5 11:11:52] DEBUG[24658] app_macro.c: Executed application: GotoIf
[Jul 5 11:11:52] VERBOSE[24658] logger.c: -- Executing [s@macro-user-callerid:3] ExecIf("SIP/1161-b7706b40", "1|Set|REALCALLERIDNUM=1161") in new stack
[Jul 5 11:11:52] DEBUG[24658] app_macro.c: Executed application: ExecIf
[Jul 5 11:11:52] VERBOSE[24658] logger.c: -- Executing [s@macro-user-callerid:4] Set("SIP/1161-b7706b40", "AMPUSER=1161") in new stack
[Jul 5 11:11:52] DEBUG[24658] app_macro.c: Executed application: Set
[Jul 5 11:11:52] VERBOSE[24658] logger.c: -- Executing [s@macro-user-callerid:5] Set("SIP/1161-b7706b40", "AMPUSERCIDNAME=x1161-GRAHAM") in new stack
[Jul 5 11:11:52] DEBUG[24658] app_macro.c: Executed application: Set
[Jul 5 11:11:52] VERBOSE[24658] logger.c: -- Executing [s@macro-user-callerid:6] GotoIf("SIP/1161-b7706b40", "0?report") in new stack
[Jul 5 11:11:52] DEBUG[24658] app_macro.c: Executed application: GotoIf
[Jul 5 11:11:52] VERBOSE[24658] logger.c: -- Executing [s@macro-user-callerid:7] Set("SIP/1161-b7706b40", "AMPUSERCID=1161") in new stack
[Jul 5 11:11:52] DEBUG[24658] app_macro.c: Executed application: Set
[Jul 5 11:11:52] VERBOSE[24658] logger.c: -- Executing [s@macro-user-callerid:8] Set("SIP/1161-b7706b40", "CALLERID(all)="x1161-GRAHAM" <1161>") in new stack
[Jul 5 11:11:52] DEBUG[24658] app_macro.c: Executed application: Set
[Jul 5 11:11:52] VERBOSE[24658] logger.c: -- Executing [s@macro-user-callerid:9] GotoIf("SIP/1161-b7706b40", "0?continue") in new stack
[Jul 5 11:11:52] DEBUG[24658] app_macro.c: Executed application: GotoIf
[Jul 5 11:11:52] VERBOSE[24658] logger.c: -- Executing [s@macro-user-callerid:10] Set("SIP/1161-b7706b40", "__TTL=64") in new stack
[Jul 5 11:11:52] DEBUG[24658] app_macro.c: Executed application: Set
[Jul 5 11:11:52] VERBOSE[24658] logger.c: -- Executing [s@macro-user-callerid:11] GotoIf("SIP/1161-b7706b40", "1?continue") in new stack
[Jul 5 11:11:52] VERBOSE[24658] logger.c: -- Goto (macro-user-callerid,s,18)
[Jul 5 11:11:52] DEBUG[24658] app_macro.c: Executed application: GotoIf
[Jul 5 11:11:52] VERBOSE[24658] logger.c: -- Executing [s@macro-user-callerid:18] NoOp("SIP/1161-b7706b40", "Using CallerID "x1161-GRAHAM" <1161>") in new stack
[Jul 5 11:11:52] DEBUG[24658] app_macro.c: Executed application: Noop
[Jul 5 11:11:52] DEBUG[24658] app_macro.c: Executed application: Macro
[Jul 5 11:11:52] VERBOSE[24658] logger.c: -- Executing [s@macro-exten-vm:2] Set("SIP/1161-b7706b40", "RingGroupMethod=none") in new stack
[Jul 5 11:11:52] DEBUG[24658] app_macro.c: Executed application: Set
[Jul 5 11:11:52] VERBOSE[24658] logger.c: -- Executing [s@macro-exten-vm:3] Set("SIP/1161-b7706b40", "VMBOX=1077") in new stack
[Jul 5 11:11:52] DEBUG[24658] app_macro.c: Executed application: Set
[Jul 5 11:11:52] VERBOSE[24658] logger.c: -- Executing [s@macro-exten-vm:4] Set("SIP/1161-b7706b40", "EXTTOCALL=1077") in new stack
[Jul 5 11:11:52] DEBUG[24658] app_macro.c: Executed application: Set
[Jul 5 11:11:52] DEBUG[24658] func_db.c: DB: CFU/1077 not found in database.
[Jul 5 11:11:52] VERBOSE[24658] logger.c: -- Executing [s@macro-exten-vm:5] Set("SIP/1161-b7706b40", "CFUEXT=") in new stack
[Jul 5 11:11:52] DEBUG[24658] app_macro.c: Executed application: Set
[Jul 5 11:11:52] DEBUG[24658] func_db.c: DB: CFB/1077 not found in database.
[Jul 5 11:11:52] VERBOSE[24658] logger.c: -- Executing [s@macro-exten-vm:6] Set("SIP/1161-b7706b40", "CFBEXT=") in new stack
[Jul 5 11:11:52] DEBUG[24658] app_macro.c: Executed application: Set
[Jul 5 11:11:52] VERBOSE[24658] logger.c: -- Executing [s@macro-exten-vm:7] Set("SIP/1161-b7706b40", "RT=15") in new stack
[Jul 5 11:11:52] DEBUG[24658] app_macro.c: Executed application: Set
[Jul 5 11:11:52] VERBOSE[24658] logger.c: -- Executing [s@macro-exten-vm:8] Macro("SIP/1161-b7706b40", "record-enable|1077|IN") in new stack
[Jul 5 11:11:52] VERBOSE[24658] logger.c: -- Executing [s@macro-record-enable:1] GotoIf("SIP/1161-b7706b40", "1?check") in new stack
[Jul 5 11:11:52] VERBOSE[24658] logger.c: -- Goto (macro-record-enable,s,4)
[Jul 5 11:11:52] DEBUG[24658] app_macro.c: Executed application: GotoIf
[Jul 5 11:11:52] VERBOSE[24658] logger.c: -- Executing [s@macro-record-enable:4] ExecIf("SIP/1161-b7706b40", "0|MacroExit|") in new stack
[Jul 5 11:11:52] DEBUG[24658] app_macro.c: Executed application: ExecIf
[Jul 5 11:11:52] VERBOSE[24658] logger.c: -- Executing [s@macro-record-enable:5] GotoIf("SIP/1161-b7706b40", "0?Group:OUT") in new stack
[Jul 5 11:11:52] VERBOSE[24658] logger.c: -- Goto (macro-record-enable,s,15)
[Jul 5 11:11:52] DEBUG[24658] app_macro.c: Executed application: GotoIf
[Jul 5 11:11:52] VERBOSE[24658] logger.c: -- Executing [s@macro-record-enable:15] GotoIf("SIP/1161-b7706b40", "1?IN") in new stack
[Jul 5 11:11:52] VERBOSE[24658] logger.c: -- Goto (macro-record-enable,s,20)
[Jul 5 11:11:52] DEBUG[24658] app_macro.c: Executed application: GotoIf
[Jul 5 11:11:52] VERBOSE[24658] logger.c: -- Executing [s@macro-record-enable:20] ExecIf("SIP/1161-b7706b40", "1|MacroExit|") in new stack
[Jul 5 11:11:52] DEBUG[24658] app_macro.c: Executed application: Macro
[Jul 5 11:11:52] VERBOSE[24658] logger.c: -- Executing [s@macro-exten-vm:9] Macro("SIP/1161-b7706b40", "dial|15|Ttr|1077") in new stack
[Jul 5 11:11:52] VERBOSE[24658] logger.c: -- Executing [s@macro-dial:1] GotoIf("SIP/1161-b7706b40", "1?dial") in new stack
[Jul 5 11:11:52] VERBOSE[24658] logger.c: -- Goto (macro-dial,s,3)
[Jul 5 11:11:52] DEBUG[24658] app_macro.c: Executed application: GotoIf
[Jul 5 11:11:52] VERBOSE[24658] logger.c: -- Executing [s@macro-dial:3] AGI("SIP/1161-b7706b40", "dialparties.agi") in new stack
[Jul 5 11:11:52] VERBOSE[24658] logger.c: -- Launched AGI Script /var/lib/asterisk/agi-bin/dialparties.agi
[Jul 5 11:11:52] VERBOSE[24658] logger.c: dialparties.agi: Starting New Dialparties.agi
[Jul 5 11:11:52] VERBOSE[24660] logger.c: == Parsing '/etc/asterisk/manager.conf': [Jul 5 11:11:52] VERBOSE[24660] logger.c: Found
[Jul 5 11:11:52] VERBOSE[24660] logger.c: == Parsing '/etc/asterisk/manager_additional.conf': [Jul 5 11:11:52] VERBOSE[24660] logger.c: Found
[Jul 5 11:11:52] VERBOSE[24660] logger.c: == Parsing '/etc/asterisk/manager_custom.conf': [Jul 5 11:11:52] VERBOSE[24660] logger.c: Found
[Jul 5 11:11:52] VERBOSE[24660] logger.c: == Manager 'admin' logged on from 127.0.0.1
[Jul 5 11:11:52] VERBOSE[24658] logger.c: dialparties.agi: Caller ID name is 'x1161-GRAHAM' number is '1161'
[Jul 5 11:11:52] VERBOSE[24658] logger.c: dialparties.agi: Methodology of ring is 'none'
[Jul 5 11:11:52] VERBOSE[24658] logger.c: -- dialparties.agi: Added extension 1077 to extension map
[Jul 5 11:11:52] VERBOSE[24658] logger.c: -- dialparties.agi: Extension 1077 cf is disabled
[Jul 5 11:11:52] VERBOSE[24658] logger.c: -- dialparties.agi: Extension 1077 do not disturb is disabled
[Jul 5 11:11:52] VERBOSE[24658] logger.c: dialparties.agi: ExtensionState: 0
[Jul 5 11:11:52] VERBOSE[24658] logger.c: dialparties.agi: Extension 1077 has ExtensionState: 0
[Jul 5 11:11:52] VERBOSE[24658] logger.c: -- dialparties.agi: Checking CW and CFB status for extension 1077
[Jul 5 11:11:52] VERBOSE[24658] logger.c: -- dialparties.agi: dbset CALLTRACE/1077 to 1161
[Jul 5 11:11:52] VERBOSE[24658] logger.c: -- dialparties.agi: Filtered ARG3: 1077
[Jul 5 11:11:52] VERBOSE[24660] logger.c: == Manager 'admin' logged off from 127.0.0.1
[Jul 5 11:11:52] VERBOSE[24658] logger.c: -- AGI Script dialparties.agi completed, returning 0
[Jul 5 11:11:52] DEBUG[24658] app_macro.c: Executed application: AGI
[Jul 5 11:11:52] VERBOSE[24658] logger.c: -- Executing [s@macro-dial:7] Dial("SIP/1161-b7706b40", "SIP/1077|15|Ttr") in new stack
[Jul 5 11:11:52] VERBOSE[24658] logger.c: -- Called 1077
[Jul 5 11:11:53] VERBOSE[24658] logger.c: -- SIP/1077-08d16f18 is ringing
[Jul 5 11:11:55] VERBOSE[24658] logger.c: -- SIP/1077-08d16f18 answered SIP/1161-b7706b40
[Jul 5 11:11:55] VERBOSE[24658] logger.c: == Spawn extension (macro-dial, s, 7) exited non-zero on 'SIP/1161-b7706b40' in macro 'dial'
[Jul 5 11:11:55] VERBOSE[24658] logger.c: == Spawn extension (macro-dial, s, 7) exited non-zero on 'SIP/1161-b7706b40' in macro 'exten-vm'
[Jul 5 11:11:55] VERBOSE[24658] logger.c: == Spawn extension (macro-dial, s, 7) exited non-zero on 'SIP/1161-b7706b40'
[Jul 5 11:11:55] VERBOSE[24658] logger.c: -- Executing [h@macro-dial:1] Macro("SIP/1161-b7706b40", "hangupcall") in new stack
[Jul 5 11:11:55] VERBOSE[24658] logger.c: -- Executing [s@macro-hangupcall:1] GotoIf("SIP/1161-b7706b40", "1?skiprg") in new stack
[Jul 5 11:11:55] VERBOSE[24658] logger.c: -- Goto (macro-hangupcall,s,4)
[Jul 5 11:11:55] DEBUG[24658] app_macro.c: Executed application: GotoIf
[Jul 5 11:11:55] VERBOSE[24658] logger.c: -- Executing [s@macro-hangupcall:4] GotoIf("SIP/1161-b7706b40", "1?skipblkvm") in new stack
[Jul 5 11:11:55] VERBOSE[24658] logger.c: -- Goto (macro-hangupcall,s,7)
[Jul 5 11:11:55] DEBUG[24658] app_macro.c: Executed application: GotoIf
[Jul 5 11:11:55] VERBOSE[24658] logger.c: -- Executing [s@macro-hangupcall:7] GotoIf("SIP/1161-b7706b40", "1?theend") in new stack
[Jul 5 11:11:55] VERBOSE[24658] logger.c: -- Goto (macro-hangupcall,s,9)
[Jul 5 11:11:55] DEBUG[24658] app_macro.c: Executed application: GotoIf
[Jul 5 11:11:55] VERBOSE[24658] logger.c: -- Executing [s@macro-hangupcall:9] Hangup("SIP/1161-b7706b40", "") in new stack
[Jul 5 11:11:55] VERBOSE[24658] logger.c: == Spawn extension (macro-hangupcall, s, 9) exited non-zero on 'SIP/1161-b7706b40' in macro 'hangupcall'
[Jul 5 11:11:55] VERBOSE[24658] logger.c: == Spawn extension (macro-hangupcall, s, 9) exited non-zero on 'SIP/1161-b7706b40'
[Jul 5 11:11:59] VERBOSE[24661] logger.c: -- Executing [1161@from-internal:1] Macro("SIP/1077-b7706b40", "exten-vm|1161|1161") in new stack
[Jul 5 11:11:59] VERBOSE[24661] logger.c: -- Executing [s@macro-exten-vm:1] Macro("SIP/1077-b7706b40", "user-callerid|") in new stack
[Jul 5 11:11:59] VERBOSE[24661] logger.c: -- Executing [s@macro-user-callerid:1] Set("SIP/1077-b7706b40", "AMPUSER=1077") in new stack
[Jul 5 11:11:59] DEBUG[24661] app_macro.c: Executed application: Set
[Jul 5 11:11:59] VERBOSE[24661] logger.c: -- Executing [s@macro-user-callerid:2] GotoIf("SIP/1077-b7706b40", "0?report") in new stack
[Jul 5 11:11:59] DEBUG[24661] app_macro.c: Executed application: GotoIf
[Jul 5 11:11:59] VERBOSE[24661] logger.c: -- Executing [s@macro-user-callerid:3] ExecIf("SIP/1077-b7706b40", "1|Set|REALCALLERIDNUM=1077") in new stack
[Jul 5 11:11:59] DEBUG[24661] app_macro.c: Executed application: ExecIf
[Jul 5 11:11:59] VERBOSE[24661] logger.c: -- Executing [s@macro-user-callerid:4] Set("SIP/1077-b7706b40", "AMPUSER=1077") in new stack
[Jul 5 11:11:59] DEBUG[24661] app_macro.c: Executed application: Set
[Jul 5 11:11:59] VERBOSE[24661] logger.c: -- Executing [s@macro-user-callerid:5] Set("SIP/1077-b7706b40", "AMPUSERCIDNAME=x1077-JEFF") in new stack
[Jul 5 11:11:59] DEBUG[24661] app_macro.c: Executed application: Set
[Jul 5 11:11:59] VERBOSE[24661] logger.c: -- Executing [s@macro-user-callerid:6] GotoIf("SIP/1077-b7706b40", "0?report") in new stack
[Jul 5 11:11:59] DEBUG[24661] app_macro.c: Executed application: GotoIf
[Jul 5 11:11:59] VERBOSE[24661] logger.c: -- Executing [s@macro-user-callerid:7] Set("SIP/1077-b7706b40", "AMPUSERCID=1077") in new stack
[Jul 5 11:11:59] DEBUG[24661] app_macro.c: Executed application: Set
[Jul 5 11:11:59] VERBOSE[24661] logger.c: -- Executing [s@macro-user-callerid:8] Set("SIP/1077-b7706b40", "CALLERID(all)="x1077-JEFF" <1077>") in new stack
[Jul 5 11:11:59] DEBUG[24661] app_macro.c: Executed application: Set
[Jul 5 11:11:59] VERBOSE[24661] logger.c: -- Executing [s@macro-user-callerid:9] GotoIf("SIP/1077-b7706b40", "0?continue") in new stack
[Jul 5 11:11:59] DEBUG[24661] app_macro.c: Executed application: GotoIf
[Jul 5 11:11:59] VERBOSE[24661] logger.c: -- Executing [s@macro-user-callerid:10] Set("SIP/1077-b7706b40", "__TTL=64") in new stack
[Jul 5 11:11:59] DEBUG[24661] app_macro.c: Executed application: Set
[Jul 5 11:11:59] VERBOSE[24661] logger.c: -- Executing [s@macro-user-callerid:11] GotoIf("SIP/1077-b7706b40", "1?continue") in new stack
[Jul 5 11:11:59] VERBOSE[24661] logger.c: -- Goto (macro-user-callerid,s,18)
[Jul 5 11:11:59] DEBUG[24661] app_macro.c: Executed application: GotoIf
[Jul 5 11:11:59] VERBOSE[24661] logger.c: -- Executing [s@macro-user-callerid:18] NoOp("SIP/1077-b7706b40", "Using CallerID "x1077-JEFF" <1077>") in new stack
[Jul 5 11:11:59] DEBUG[24661] app_macro.c: Executed application: Noop
[Jul 5 11:11:59] DEBUG[24661] app_macro.c: Executed application: Macro
[Jul 5 11:11:59] VERBOSE[24661] logger.c: -- Executing [s@macro-exten-vm:2] Set("SIP/1077-b7706b40", "RingGroupMethod=none") in new stack
[Jul 5 11:11:59] DEBUG[24661] app_macro.c: Executed application: Set
[Jul 5 11:11:59] VERBOSE[24661] logger.c: -- Executing [s@macro-exten-vm:3] Set("SIP/1077-b7706b40", "VMBOX=1161") in new stack
[Jul 5 11:11:59] DEBUG[24661] app_macro.c: Executed application: Set
[Jul 5 11:11:59] VERBOSE[24661] logger.c: -- Executing [s@macro-exten-vm:4] Set("SIP/1077-b7706b40", "EXTTOCALL=1161") in new stack
[Jul 5 11:11:59] DEBUG[24661] app_macro.c: Executed application: Set
[Jul 5 11:11:59] DEBUG[24661] func_db.c: DB: CFU/1161 not found in database.
[Jul 5 11:11:59] VERBOSE[24661] logger.c: -- Executing [s@macro-exten-vm:5] Set("SIP/1077-b7706b40", "CFUEXT=") in new stack
[Jul 5 11:11:59] DEBUG[24661] app_macro.c: Executed application: Set
[Jul 5 11:11:59] DEBUG[24661] func_db.c: DB: CFB/1161 not found in database.
[Jul 5 11:11:59] VERBOSE[24661] logger.c: -- Executing [s@macro-exten-vm:6] Set("SIP/1077-b7706b40", "CFBEXT=") in new stack
[Jul 5 11:11:59] DEBUG[24661] app_macro.c: Executed application: Set
[Jul 5 11:11:59] VERBOSE[24661] logger.c: -- Executing [s@macro-exten-vm:7] Set("SIP/1077-b7706b40", "RT=15") in new stack
[Jul 5 11:11:59] DEBUG[24661] app_macro.c: Executed application: Set
[Jul 5 11:11:59] VERBOSE[24661] logger.c: -- Executing [s@macro-exten-vm:8] Macro("SIP/1077-b7706b40", "record-enable|1161|IN") in new stack
[Jul 5 11:11:59] VERBOSE[24661] logger.c: -- Executing [s@macro-record-enable:1] GotoIf("SIP/1077-b7706b40", "1?check") in new stack
[Jul 5 11:11:59] VERBOSE[24661] logger.c: -- Goto (macro-record-enable,s,4)
[Jul 5 11:11:59] DEBUG[24661] app_macro.c: Executed application: GotoIf
[Jul 5 11:11:59] VERBOSE[24661] logger.c: -- Executing [s@macro-record-enable:4] ExecIf("SIP/1077-b7706b40", "0|MacroExit|") in new stack
[Jul 5 11:11:59] DEBUG[24661] app_macro.c: Executed application: ExecIf
[Jul 5 11:11:59] VERBOSE[24661] logger.c: -- Executing [s@macro-record-enable:5] GotoIf("SIP/1077-b7706b40", "0?Group:OUT") in new stack
[Jul 5 11:11:59] VERBOSE[24661] logger.c: -- Goto (macro-record-enable,s,15)
[Jul 5 11:11:59] DEBUG[24661] app_macro.c: Executed application: GotoIf
[Jul 5 11:11:59] VERBOSE[24661] logger.c: -- Executing [s@macro-record-enable:15] GotoIf("SIP/1077-b7706b40", "1?IN") in new stack
[Jul 5 11:11:59] VERBOSE[24661] logger.c: -- Goto (macro-record-enable,s,20)
[Jul 5 11:11:59] DEBUG[24661] app_macro.c: Executed application: GotoIf
[Jul 5 11:11:59] VERBOSE[24661] logger.c: -- Executing [s@macro-record-enable:20] ExecIf("SIP/1077-b7706b40", "1|MacroExit|") in new stack
[Jul 5 11:11:59] DEBUG[24661] app_macro.c: Executed application: Macro
[Jul 5 11:11:59] VERBOSE[24661] logger.c: -- Executing [s@macro-exten-vm:9] Macro("SIP/1077-b7706b40", "dial|15|Ttr|1161") in new stack
[Jul 5 11:11:59] VERBOSE[24661] logger.c: -- Executing [s@macro-dial:1] GotoIf("SIP/1077-b7706b40", "1?dial") in new stack
[Jul 5 11:11:59] VERBOSE[24661] logger.c: -- Goto (macro-dial,s,3)
[Jul 5 11:11:59] DEBUG[24661] app_macro.c: Executed application: GotoIf
[Jul 5 11:11:59] VERBOSE[24661] logger.c: -- Executing [s@macro-dial:3] AGI("SIP/1077-b7706b40", "dialparties.agi") in new stack
[Jul 5 11:11:59] VERBOSE[24661] logger.c: -- Launched AGI Script /var/lib/asterisk/agi-bin/dialparties.agi
[Jul 5 11:11:59] VERBOSE[24661] logger.c: dialparties.agi: Starting New Dialparties.agi
[Jul 5 11:12:00] VERBOSE[24663] logger.c: == Parsing '/etc/asterisk/manager.conf': [Jul 5 11:12:00] VERBOSE[24663] logger.c: Found
[Jul 5 11:12:00] VERBOSE[24663] logger.c: == Parsing '/etc/asterisk/manager_additional.conf': [Jul 5 11:12:00] VERBOSE[24663] logger.c: Found
[Jul 5 11:12:00] VERBOSE[24663] logger.c: == Parsing '/etc/asterisk/manager_custom.conf': [Jul 5 11:12:00] VERBOSE[24663] logger.c: Found
[Jul 5 11:12:00] VERBOSE[24663] logger.c: == Manager 'admin' logged on from 127.0.0.1
[Jul 5 11:12:00] VERBOSE[24661] logger.c: dialparties.agi: Caller ID name is 'x1077-JEFF' number is '1077'
[Jul 5 11:12:00] VERBOSE[24661] logger.c: dialparties.agi: Methodology of ring is 'none'
[Jul 5 11:12:00] VERBOSE[24661] logger.c: -- dialparties.agi: Added extension 1161 to extension map
[Jul 5 11:12:00] VERBOSE[24661] logger.c: -- dialparties.agi: Extension 1161 cf is disabled
[Jul 5 11:12:00] VERBOSE[24661] logger.c: -- dialparties.agi: Extension 1161 do not disturb is disabled
[Jul 5 11:12:00] VERBOSE[24661] logger.c: dialparties.agi: ExtensionState: 0
[Jul 5 11:12:00] VERBOSE[24661] logger.c: dialparties.agi: Extension 1161 has ExtensionState: 0
[Jul 5 11:12:00] VERBOSE[24661] logger.c: -- dialparties.agi: Checking CW and CFB status for extension 1161
[Jul 5 11:12:00] VERBOSE[24661] logger.c: -- dialparties.agi: dbset CALLTRACE/1161 to 1077
[Jul 5 11:12:00] VERBOSE[24661] logger.c: -- dialparties.agi: Filtered ARG3: 1161
[Jul 5 11:12:00] VERBOSE[24663] logger.c: == Manager 'admin' logged off from 127.0.0.1
[Jul 5 11:12:00] VERBOSE[24661] logger.c: -- AGI Script dialparties.agi completed, returning 0
[Jul 5 11:12:00] DEBUG[24661] app_macro.c: Executed application: AGI
[Jul 5 11:12:00] VERBOSE[24661] logger.c: -- Executing [s@macro-dial:7] Dial("SIP/1077-b7706b40", "SIP/1161|15|Ttr") in new stack
[Jul 5 11:12:00] VERBOSE[24661] logger.c: -- Called 1161
[Jul 5 11:12:00] VERBOSE[24661] logger.c: -- SIP/1161-08d16f18 is ringing
[Jul 5 11:12:02] VERBOSE[24661] logger.c: -- SIP/1161-08d16f18 answered SIP/1077-b7706b40
[Jul 5 11:12:03] VERBOSE[24661] logger.c: == Spawn extension (macro-dial, s, 7) exited non-zero on 'SIP/1077-b7706b40' in macro 'dial'
[Jul 5 11:12:03] VERBOSE[24661] logger.c: == Spawn extension (macro-dial, s, 7) exited non-zero on 'SIP/1077-b7706b40' in macro 'exten-vm'
[Jul 5 11:12:03] VERBOSE[24661] logger.c: == Spawn extension (macro-dial, s, 7) exited non-zero on 'SIP/1077-b7706b40'
[Jul 5 11:12:03] VERBOSE[24661] logger.c: -- Executing [h@macro-dial:1] Macro("SIP/1077-b7706b40", "hangupcall") in new stack
[Jul 5 11:12:03] VERBOSE[24661] logger.c: -- Executing [s@macro-hangupcall:1] GotoIf("SIP/1077-b7706b40", "1?skiprg") in new stack
[Jul 5 11:12:03] VERBOSE[24661] logger.c: -- Goto (macro-hangupcall,s,4)
[Jul 5 11:12:03] DEBUG[24661] app_macro.c: Executed application: GotoIf
[Jul 5 11:12:03] VERBOSE[24661] logger.c: -- Executing [s@macro-hangupcall:4] GotoIf("SIP/1077-b7706b40", "1?skipblkvm") in new stack
[Jul 5 11:12:03] VERBOSE[24661] logger.c: -- Goto (macro-hangupcall,s,7)
[Jul 5 11:12:03] DEBUG[24661] app_macro.c: Executed application: GotoIf
[Jul 5 11:12:03] VERBOSE[24661] logger.c: -- Executing [s@macro-hangupcall:7] GotoIf("SIP/1077-b7706b40", "1?theend") in new stack
[Jul 5 11:12:03] VERBOSE[24661] logger.c: -- Goto (macro-hangupcall,s,9)
[Jul 5 11:12:03] DEBUG[24661] app_macro.c: Executed application: GotoIf
[Jul 5 11:12:03] VERBOSE[24661] logger.c: -- Executing [s@macro-hangupcall:9] Hangup("SIP/1077-b7706b40", "") in new stack
[Jul 5 11:12:03] VERBOSE[24661] logger.c: == Spawn extension (macro-hangupcall, s, 9) exited non-zero on 'SIP/1077-b7706b40' in macro 'hangupcall'
[Jul 5 11:12:03] VERBOSE[24661] logger.c: == Spawn extension (macro-hangupcall, s, 9) exited non-zero on 'SIP/1077-b7706b40'