[Aug 3 14:48:10] DEBUG[28102] chan_zap.c: Queuing frame from PRI_EVENT_PROCEEDING on channel 0/4 span 2 [Aug 3 14:48:10] VERBOSE[28944] logger.c: -- Zap/28-1 is proceeding passing it to SIP/271-098d49a8 [Aug 3 14:48:10] VERBOSE[28944] logger.c: -- Zap/28-1 is ringing [Aug 3 14:48:13] VERBOSE[28935] logger.c: -- Nobody picked up in 20000 ms [Aug 3 14:48:13] DEBUG[28935] cdr_addon_mysql.c: cdr_mysql: inserting a CDR record. [Aug 3 14:48:13] DEBUG[28935] app_macro.c: Executed application: Dial [Aug 3 14:48:13] DEBUG[28935] db.c: Unable to find key '212' in family 'CFB' [Aug 3 14:48:13] VERBOSE[28935] logger.c: -- Executing [s@macro-stdexten:4] GotoIf("Zap/27-1", "0?s|5:s|6") in new stack [Aug 3 14:48:13] VERBOSE[28935] logger.c: -- Goto (macro-stdexten,s,6) [Aug 3 14:48:13] DEBUG[28935] app_macro.c: Executed application: GotoIf [Aug 3 14:48:13] VERBOSE[28935] logger.c: -- Executing [s@macro-stdexten:6] VoiceMail("Zap/27-1", "212|u") in new stack [Aug 3 14:48:13] VERBOSE[28935] logger.c: -- Playing '/var/spool/asterisk/voicemail/default/212/temp' (language 'en') [Aug 3 14:48:19] VERBOSE[28935] logger.c: -- Playing 'vm-intro' (language 'en') [Aug 3 14:48:19] DEBUG[28943] chan_zap.c: Set option AUDIO MODE, value: ON(1) on Zap/26-1 [Aug 3 14:48:19] DEBUG[28943] chan_zap.c: Not yet hungup... Calling hangup once with icause, and clearing call [Aug 3 14:48:19] DEBUG[28943] chan_zap.c: Set option AUDIO MODE, value: OFF(0) on Zap/26-1 [Aug 3 14:48:19] VERBOSE[28943] logger.c: -- Hungup 'Zap/26-1' [Aug 3 14:48:19] DEBUG[28943] cdr_addon_mysql.c: cdr_mysql: inserting a CDR record. [Aug 3 14:48:19] VERBOSE[28943] logger.c: == Spawn extension (international, 15153620751, 2) exited non-zero on 'SIP/249-0997e7d0' [Aug 3 14:48:19] DEBUG[28943] cdr_addon_mysql.c: cdr_mysql: inserting a CDR record. [Aug 3 14:48:22] DEBUG[28102] chan_zap.c: Echo cancellation already on [Aug 3 14:48:22] VERBOSE[28944] logger.c: -- Zap/28-1 answered SIP/271-098d49a8 [Aug 3 14:48:24] VERBOSE[28935] logger.c: -- Playing 'beep' (language 'en') [Aug 3 14:48:25] VERBOSE[28935] logger.c: -- Recording the message [Aug 3 14:48:25] VERBOSE[28935] logger.c: -- x=0, open writing: /var/spool/asterisk/voicemail/default/212/tmp/ajQewV format: wav49, 0x98eaba0 [Aug 3 14:48:25] VERBOSE[28935] logger.c: -- x=1, open writing: /var/spool/asterisk/voicemail/default/212/tmp/ajQewV format: gsm, 0x98dae38 [Aug 3 14:48:25] VERBOSE[28945] logger.c: -- Executing [200@international:1] Dial("SIP/289-098f8dd8", "SIP/206|240") in new stack [Aug 3 14:48:25] VERBOSE[28945] logger.c: -- Called 206 [Aug 3 14:48:25] VERBOSE[28945] logger.c: -- SIP/206-b75023a8 is ringing [Aug 3 14:48:26] VERBOSE[28945] logger.c: -- SIP/206-b75023a8 is ringing [Aug 3 14:48:27] VERBOSE[28945] logger.c: -- SIP/206-b75023a8 is ringing [Aug 3 14:48:27] VERBOSE[28945] logger.c: -- SIP/206-b75023a8 answered SIP/289-098f8dd8 [Aug 3 14:48:27] VERBOSE[28945] logger.c: -- Native bridging SIP/289-098f8dd8 and SIP/206-b75023a8 [Aug 3 14:48:34] VERBOSE[28945] logger.c: == Spawn extension (international, 200, 1) exited non-zero on 'SIP/289-098f8dd8' [Aug 3 14:48:34] DEBUG[28945] cdr_addon_mysql.c: cdr_mysql: inserting a CDR record. [Aug 3 14:48:46] VERBOSE[28102] logger.c: -- Channel 0/3, span 2 got hangup request, cause 16 [Aug 3 14:48:46] VERBOSE[28935] logger.c: -- User hung up [Aug 3 14:48:46] VERBOSE[28935] logger.c: == Spawn extension (macro-stdexten, s, 6) exited non-zero on 'Zap/27-1' in macro 'stdexten' [Aug 3 14:48:46] VERBOSE[28935] logger.c: == Spawn extension (macro-stdexten, s, 6) exited non-zero on 'Zap/27-1' [Aug 3 14:48:46] DEBUG[28935] chan_zap.c: Set option AUDIO MODE, value: ON(1) on Zap/27-1 [Aug 3 14:48:46] DEBUG[28935] chan_zap.c: Not yet hungup... Calling hangup once with icause, and clearing call [Aug 3 14:48:46] DEBUG[28935] chan_zap.c: Set option AUDIO MODE, value: OFF(0) on Zap/27-1 [Aug 3 14:48:46] VERBOSE[28935] logger.c: -- Hungup 'Zap/27-1' [Aug 3 14:48:46] DEBUG[28935] cdr_addon_mysql.c: cdr_mysql: inserting a CDR record. [Aug 3 14:48:10] VERBOSE[28944] logger.c: -- Zap/28-1 is proceeding passing it to SIP/271-098d49a8 [Aug 3 14:48:10] VERBOSE[28944] logger.c: -- Zap/28-1 is ringing [Aug 3 14:48:13] VERBOSE[28935] logger.c: -- Nobody picked up in 20000 ms [Aug 3 14:48:13] DEBUG[28935] cdr_addon_mysql.c: cdr_mysql: inserting a CDR record. [Aug 3 14:48:13] DEBUG[28935] app_macro.c: Executed application: Dial [Aug 3 14:48:13] DEBUG[28935] db.c: Unable to find key '212' in family 'CFB' [Aug 3 14:48:13] VERBOSE[28935] logger.c: -- Executing [s@macro-stdexten:4] GotoIf("Zap/27-1", "0?s|5:s|6") in new stack [Aug 3 14:48:13] VERBOSE[28935] logger.c: -- Goto (macro-stdexten,s,6) [Aug 3 14:48:13] DEBUG[28935] app_macro.c: Executed application: GotoIf [Aug 3 14:48:13] VERBOSE[28935] logger.c: -- Executing [s@macro-stdexten:6] VoiceMail("Zap/27-1", "212|u") in new stack [Aug 3 14:48:13] VERBOSE[28935] logger.c: -- Playing '/var/spool/asterisk/voicemail/default/212/temp' (language 'en') [Aug 3 14:48:19] VERBOSE[28935] logger.c: -- Playing 'vm-intro' (language 'en') [Aug 3 14:48:19] DEBUG[28943] chan_zap.c: Set option AUDIO MODE, value: ON(1) on Zap/26-1 [Aug 3 14:48:19] DEBUG[28943] chan_zap.c: Not yet hungup... Calling hangup once with icause, and clearing call [Aug 3 14:48:19] DEBUG[28943] chan_zap.c: Set option AUDIO MODE, value: OFF(0) on Zap/26-1 [Aug 3 14:48:19] VERBOSE[28943] logger.c: -- Hungup 'Zap/26-1' [Aug 3 14:48:19] DEBUG[28943] cdr_addon_mysql.c: cdr_mysql: inserting a CDR record. [Aug 3 14:48:19] VERBOSE[28943] logger.c: == Spawn extension (international, 15153620751, 2) exited non-zero on 'SIP/249-0997e7d0' [Aug 3 14:48:19] DEBUG[28943] cdr_addon_mysql.c: cdr_mysql: inserting a CDR record. [Aug 3 14:48:22] DEBUG[28102] chan_zap.c: Echo cancellation already on [Aug 3 14:48:22] VERBOSE[28944] logger.c: -- Zap/28-1 answered SIP/271-098d49a8 [Aug 3 14:48:24] VERBOSE[28935] logger.c: -- Playing 'beep' (language 'en') [Aug 3 14:48:25] VERBOSE[28935] logger.c: -- Recording the message [Aug 3 14:48:25] VERBOSE[28935] logger.c: -- x=0, open writing: /var/spool/asterisk/voicemail/default/212/tmp/ajQewV format: wav49, 0x98eaba0 [Aug 3 14:48:25] VERBOSE[28935] logger.c: -- x=1, open writing: /var/spool/asterisk/voicemail/default/212/tmp/ajQewV format: gsm, 0x98dae38 [Aug 3 14:48:25] VERBOSE[28945] logger.c: -- Executing [200@international:1] Dial("SIP/289-098f8dd8", "SIP/206|240") in new stack [Aug 3 14:48:25] VERBOSE[28945] logger.c: -- Called 206 [Aug 3 14:48:25] VERBOSE[28945] logger.c: -- SIP/206-b75023a8 is ringing [Aug 3 14:48:26] VERBOSE[28945] logger.c: -- SIP/206-b75023a8 is ringing [Aug 3 14:48:27] VERBOSE[28945] logger.c: -- SIP/206-b75023a8 is ringing [Aug 3 14:48:27] VERBOSE[28945] logger.c: -- SIP/206-b75023a8 answered SIP/289-098f8dd8 [Aug 3 14:48:27] VERBOSE[28945] logger.c: -- Native bridging SIP/289-098f8dd8 and SIP/206-b75023a8 [Aug 3 14:48:34] VERBOSE[28945] logger.c: == Spawn extension (international, 200, 1) exited non-zero on 'SIP/289-098f8dd8' [Aug 3 14:48:34] DEBUG[28945] cdr_addon_mysql.c: cdr_mysql: inserting a CDR record. [Aug 3 14:48:46] VERBOSE[28102] logger.c: -- Channel 0/3, span 2 got hangup request, cause 16 [Aug 3 14:48:46] VERBOSE[28935] logger.c: -- User hung up [Aug 3 14:48:46] VERBOSE[28935] logger.c: == Spawn extension (macro-stdexten, s, 6) exited non-zero on 'Zap/27-1' in macro 'stdexten' [Aug 3 14:48:46] VERBOSE[28935] logger.c: == Spawn extension (macro-stdexten, s, 6) exited non-zero on 'Zap/27-1' [Aug 3 14:48:46] DEBUG[28935] chan_zap.c: Set option AUDIO MODE, value: ON(1) on Zap/27-1 [Aug 3 14:48:46] DEBUG[28935] chan_zap.c: Not yet hungup... Calling hangup once with icause, and clearing call [Aug 3 14:48:46] DEBUG[28935] chan_zap.c: Set option AUDIO MODE, value: OFF(0) on Zap/27-1 [Aug 3 14:48:46] VERBOSE[28935] logger.c: -- Hungup 'Zap/27-1' [Aug 3 14:48:46] DEBUG[28935] cdr_addon_mysql.c: cdr_mysql: inserting a CDR record. [Aug 3 14:49:39] VERBOSE[28946] logger.c: -- Executing [xxxxxxxxxx@international:1] Set("SIP/242-098c0178", "CALLERID(all)=Advance Packaging") in new stack [Aug 3 14:49:39] VERBOSE[28946] logger.c: -- Executing [xxxxxxxxxx@international:2] Dial("SIP/242-098c0178", "ZAP/g1/xxxxxxxxxx") in new stack [Aug 3 14:49:39] VERBOSE[28946] logger.c: -- Requested transfer capability: 0x00 - SPEECH [Aug 3 14:49:39] VERBOSE[28946] logger.c: -- Called g1/xxxxxxxxxx [Aug 3 14:49:39] DEBUG[28102] chan_zap.c: Queuing frame from PRI_EVENT_PROCEEDING on channel 0/2 span 2 [Aug 3 14:49:39] VERBOSE[28946] logger.c: -- Zap/26-1 is proceeding passing it to SIP/242-098c0178 [Aug 3 14:49:39] VERBOSE[28946] logger.c: -- Zap/26-1 is ringing [Aug 3 14:49:42] DEBUG[28102] chan_zap.c: Echo cancellation already on [Aug 3 14:49:42] VERBOSE[28946] logger.c: -- Zap/26-1 answered SIP/242-098c0178 [Aug 3 14:49:45] VERBOSE[28102] logger.c: -- Accepting call from 'xxxxxxxxxx' to 'xxxxxxxxxx' on channel 0/3, span 2 [Aug 3 14:49:45] VERBOSE[28947] logger.c: -- Executing [xxxxxxxxxx@incoming:1] Set("Zap/27-1", "aa=1") in new stack [Aug 3 14:49:45] VERBOSE[28947] logger.c: -- Executing [xxxxxxxxxx@incoming:2] GotoIf("Zap/27-1", "1 = "1"?incoming-open|s|1") in new stack [Aug 3 14:49:45] VERBOSE[28947] logger.c: -- Goto (incoming-open,s,1) [Aug 3 14:49:45] VERBOSE[28947] logger.c: -- Executing [s@incoming-open:1] Answer("Zap/27-1", "") in new stack [Aug 3 14:49:45] VERBOSE[28947] logger.c: -- Executing [s@incoming-open:2] Goto("Zap/27-1", "inside|200|1") in new stack [Aug 3 14:49:45] VERBOSE[28947] logger.c: -- Goto (inside,200,1) [Aug 3 14:49:45] VERBOSE[28947] logger.c: -- Executing [200@inside:1] Dial("Zap/27-1", "SIP/206|240") in new stack [Aug 3 14:49:45] VERBOSE[28947] logger.c: -- Called 206 [Aug 3 14:49:45] DEBUG[28102] chan_zap.c: Echo cancellation already on [Aug 3 14:49:45] VERBOSE[28947] logger.c: -- SIP/206-098f8c70 is ringing [Aug 3 14:49:45] VERBOSE[28947] logger.c: -- SIP/206-098f8c70 is ringing [Aug 3 14:49:46] VERBOSE[28947] logger.c: -- SIP/206-098f8c70 is ringing [Aug 3 14:49:48] VERBOSE[28947] logger.c: -- SIP/206-098f8c70 answered Zap/27-1 [Aug 3 14:49:52] DEBUG[28944] chan_zap.c: Set option AUDIO MODE, value: ON(1) on Zap/28-1 [Aug 3 14:49:52] DEBUG[28944] chan_zap.c: Not yet hungup... Calling hangup once with icause, and clearing call [Aug 3 14:49:52] DEBUG[28944] chan_zap.c: Set option AUDIO MODE, value: OFF(0) on Zap/28-1 [Aug 3 14:49:52] VERBOSE[28944] logger.c: -- Hungup 'Zap/28-1' [Aug 3 14:49:52] VERBOSE[28944] logger.c: == Spawn extension (international, xxxxxxxxxx, 2) exited non-zero on 'SIP/271-098d49a8' [Aug 3 14:49:52] DEBUG[28944] cdr_addon_mysql.c: cdr_mysql: inserting a CDR record. [Aug 3 14:49:53] DEBUG[28946] chan_zap.c: Set option AUDIO MODE, value: ON(1) on Zap/26-1 [Aug 3 14:49:53] DEBUG[28946] chan_zap.c: Not yet hungup... Calling hangup once with icause, and clearing call [Aug 3 14:49:53] DEBUG[28946] chan_zap.c: Set option AUDIO MODE, value: OFF(0) on Zap/26-1 [Aug 3 14:49:53] VERBOSE[28946] logger.c: -- Hungup 'Zap/26-1' [Aug 3 14:49:53] VERBOSE[28946] logger.c: == Spawn extension (international, xxxxxxxxxx, 2) exited non-zero on 'SIP/242-098c0178' [Aug 3 14:49:53] DEBUG[28946] cdr_addon_mysql.c: cdr_mysql: inserting a CDR record. [Aug 3 14:49:55] VERBOSE[28947] logger.c: -- Started music on hold, class 'default', on Zap/27-1 [Aug 3 14:50:35] VERBOSE[28102] logger.c: -- Channel 0/1, span 2 got hangup request, cause 16 [Aug 3 14:50:35] DEBUG[28892] chan_zap.c: Set option AUDIO MODE, value: ON(1) on Zap/25-1 [Aug 3 14:50:35] DEBUG[28892] chan_zap.c: Not yet hungup... Calling hangup once with icause, and clearing call [Aug 3 14:50:35] DEBUG[28892] chan_zap.c: Set option AUDIO MODE, value: OFF(0) on Zap/25-1 [Aug 3 14:50:35] VERBOSE[28892] logger.c: -- Hungup 'Zap/25-1' [Aug 3 14:50:35] VERBOSE[28892] logger.c: == Spawn extension (international, 701, 1) exited non-zero on 'SIP/272-09967930' [Aug 3 14:50:35] DEBUG[28892] cdr_addon_mysql.c: cdr_mysql: inserting a CDR record. [Aug 3 14:53:08] VERBOSE[28102] logger.c: -- Accepting call from 'xxxxxxxxxx' to 'xxxxxxxxx' on channel 0/1, span 2 [Aug 3 14:53:08] VERBOSE[28960] logger.c: -- Executing [xxxxxxxxxx@incoming:1] SIPAddHeader("Zap/25-1", "Alert-Info:EXTERNAL") in new stack [Aug 3 14:53:08] VERBOSE[28960] logger.c: -- Executing [xxxxxxxxxx@incoming:2] Goto("Zap/25-1", "inside|212|1") in new stack [Aug 3 14:53:08] VERBOSE[28960] logger.c: -- Goto (inside,212,1) [Aug 3 14:53:08] VERBOSE[28960] logger.c: -- Executing [212@inside:1] Macro("Zap/25-1", "stdexten|212|SIP/212") in new stack [Aug 3 14:53:08] DEBUG[28102] chan_zap.c: Echo cancellation already on [Aug 3 14:53:08] DEBUG[28960] db.c: Unable to find key '212' in family 'CFI' [Aug 3 14:53:08] VERBOSE[28960] logger.c: -- Executing [s@macro-stdexten:1] GotoIf("Zap/25-1", "0?s|2:s|3") in new stack [Aug 3 14:53:08] VERBOSE[28960] logger.c: -- Goto (macro-stdexten,s,3) [Aug 3 14:53:08] DEBUG[28960] app_macro.c: Executed application: GotoIf [Aug 3 14:53:08] VERBOSE[28960] logger.c: -- Executing [s@macro-stdexten:3] Dial("Zap/25-1", "SIP/212|20|t") in new stack [Aug 3 14:53:08] VERBOSE[28960] logger.c: -- Called 212 [Aug 3 14:53:18] VERBOSE[28102] logger.c: -- Channel 0/1, span 2 got hangup request, cause 102 [Aug 3 14:53:18] DEBUG[28960] cdr_addon_mysql.c: cdr_mysql: inserting a CDR record. [Aug 3 14:53:18] VERBOSE[28960] logger.c: == Spawn extension (macro-stdexten, s, 3) exited non-zero on 'Zap/25-1' in macro 'stdexten' [Aug 3 14:53:18] VERBOSE[28960] logger.c: == Spawn extension (macro-stdexten, s, 3) exited non-zero on 'Zap/25-1' [Aug 3 14:53:18] DEBUG[28960] chan_zap.c: Set option AUDIO MODE, value: ON(1) on Zap/25-1 [Aug 3 14:53:18] DEBUG[28960] chan_zap.c: Not yet hungup... Calling hangup once with icause, and clearing call [Aug 3 14:53:18] DEBUG[28960] chan_zap.c: Set option AUDIO MODE, value: OFF(0) on Zap/25-1 [Aug 3 14:53:18] VERBOSE[28960] logger.c: -- Hungup 'Zap/25-1' [Aug 3 14:53:18] DEBUG[28960] cdr_addon_mysql.c: cdr_mysql: inserting a CDR record. [Aug 3 14:49:39] VERBOSE[28946] logger.c: -- Executing [xxxxxxxxxx@international:1] Set("SIP/242-098c0178", "CALLERID(all)=Advance Packaging") in new stack [Aug 3 14:49:39] VERBOSE[28946] logger.c: -- Executing [xxxxxxxxxx@international:2] Dial("SIP/242-098c0178", "ZAP/g1/xxxxxxxxxx") in new stack [Aug 3 14:49:39] VERBOSE[28946] logger.c: -- Requested transfer capability: 0x00 - SPEECH [Aug 3 14:49:39] VERBOSE[28946] logger.c: -- Called g1/xxxxxxxxxx [Aug 3 14:49:39] DEBUG[28102] chan_zap.c: Queuing frame from PRI_EVENT_PROCEEDING on channel 0/2 span 2 [Aug 3 14:49:39] VERBOSE[28946] logger.c: -- Zap/26-1 is proceeding passing it to SIP/242-098c0178 [Aug 3 14:49:39] VERBOSE[28946] logger.c: -- Zap/26-1 is ringing [Aug 3 14:49:42] DEBUG[28102] chan_zap.c: Echo cancellation already on [Aug 3 14:49:42] VERBOSE[28946] logger.c: -- Zap/26-1 answered SIP/242-098c0178 [Aug 3 14:49:45] VERBOSE[28102] logger.c: -- Accepting call from 'xxxxxxxxxx' to 'xxxxxxxxxx' on channel 0/3, span 2 [Aug 3 14:49:45] VERBOSE[28947] logger.c: -- Executing [xxxxxxxxxx@incoming:1] Set("Zap/27-1", "aa=1") in new stack [Aug 3 14:49:45] VERBOSE[28947] logger.c: -- Executing [xxxxxxxxxx@incoming:2] GotoIf("Zap/27-1", "1 = "1"?incoming-open|s|1") in new stack [Aug 3 14:49:45] VERBOSE[28947] logger.c: -- Goto (incoming-open,s,1) [Aug 3 14:49:45] VERBOSE[28947] logger.c: -- Executing [s@incoming-open:1] Answer("Zap/27-1", "") in new stack [Aug 3 14:49:45] VERBOSE[28947] logger.c: -- Executing [s@incoming-open:2] Goto("Zap/27-1", "inside|200|1") in new stack [Aug 3 14:49:45] VERBOSE[28947] logger.c: -- Goto (inside,200,1) [Aug 3 14:49:45] VERBOSE[28947] logger.c: -- Executing [200@inside:1] Dial("Zap/27-1", "SIP/206|240") in new stack [Aug 3 14:49:45] VERBOSE[28947] logger.c: -- Called 206 [Aug 3 14:49:45] DEBUG[28102] chan_zap.c: Echo cancellation already on [Aug 3 14:49:45] VERBOSE[28947] logger.c: -- SIP/206-098f8c70 is ringing [Aug 3 14:49:45] VERBOSE[28947] logger.c: -- SIP/206-098f8c70 is ringing [Aug 3 14:49:46] VERBOSE[28947] logger.c: -- SIP/206-098f8c70 is ringing [Aug 3 14:49:48] VERBOSE[28947] logger.c: -- SIP/206-098f8c70 answered Zap/27-1 [Aug 3 14:49:52] DEBUG[28944] chan_zap.c: Set option AUDIO MODE, value: ON(1) on Zap/28-1 [Aug 3 14:49:52] DEBUG[28944] chan_zap.c: Not yet hungup... Calling hangup once with icause, and clearing call [Aug 3 14:49:52] DEBUG[28944] chan_zap.c: Set option AUDIO MODE, value: OFF(0) on Zap/28-1 [Aug 3 14:49:52] VERBOSE[28944] logger.c: -- Hungup 'Zap/28-1' [Aug 3 14:49:52] VERBOSE[28944] logger.c: == Spawn extension (international, xxxxxxxxxx, 2) exited non-zero on 'SIP/271-098d49a8' [Aug 3 14:49:52] DEBUG[28944] cdr_addon_mysql.c: cdr_mysql: inserting a CDR record. [Aug 3 14:49:53] DEBUG[28946] chan_zap.c: Set option AUDIO MODE, value: ON(1) on Zap/26-1 [Aug 3 14:49:53] DEBUG[28946] chan_zap.c: Not yet hungup... Calling hangup once with icause, and clearing call [Aug 3 14:49:53] DEBUG[28946] chan_zap.c: Set option AUDIO MODE, value: OFF(0) on Zap/26-1 [Aug 3 14:49:53] VERBOSE[28946] logger.c: -- Hungup 'Zap/26-1' [Aug 3 14:49:53] VERBOSE[28946] logger.c: == Spawn extension (international, 9572120, 2) exited non-zero on 'SIP/242-098c0178' [Aug 3 14:49:53] DEBUG[28946] cdr_addon_mysql.c: cdr_mysql: inserting a CDR record. [Aug 3 14:49:55] VERBOSE[28947] logger.c: -- Started music on hold, class 'default', on Zap/27-1 [Aug 3 14:50:35] VERBOSE[28102] logger.c: -- Channel 0/1, span 2 got hangup request, cause 16 [Aug 3 14:50:35] DEBUG[28892] chan_zap.c: Set option AUDIO MODE, value: ON(1) on Zap/25-1 [Aug 3 14:50:35] DEBUG[28892] chan_zap.c: Not yet hungup... Calling hangup once with icause, and clearing call [Aug 3 14:50:35] DEBUG[28892] chan_zap.c: Set option AUDIO MODE, value: OFF(0) on Zap/25-1 [Aug 3 14:50:35] VERBOSE[28892] logger.c: -- Hungup 'Zap/25-1' [Aug 3 14:50:35] VERBOSE[28892] logger.c: == Spawn extension (international, 701, 1) exited non-zero on 'SIP/272-09967930' [Aug 3 14:50:35] DEBUG[28892] cdr_addon_mysql.c: cdr_mysql: inserting a CDR record. [Aug 3 14:53:08] VERBOSE[28102] logger.c: -- Accepting call from 'xxxxxxxxxx' to 'xxxxxxxxxx' on channel 0/1, span 2 [Aug 3 14:53:08] VERBOSE[28960] logger.c: -- Executing [xxxxxxxxxx@incoming:1] SIPAddHeader("Zap/25-1", "Alert-Info:EXTERNAL") in new stack [Aug 3 14:53:08] VERBOSE[28960] logger.c: -- Executing [xxxxxxxxxx@incoming:2] Goto("Zap/25-1", "inside|212|1") in new stack [Aug 3 14:53:08] VERBOSE[28960] logger.c: -- Goto (inside,212,1) [Aug 3 14:53:08] VERBOSE[28960] logger.c: -- Executing [212@inside:1] Macro("Zap/25-1", "stdexten|212|SIP/212") in new stack [Aug 3 14:53:08] DEBUG[28102] chan_zap.c: Echo cancellation already on [Aug 3 14:53:08] DEBUG[28960] db.c: Unable to find key '212' in family 'CFI' [Aug 3 14:53:08] VERBOSE[28960] logger.c: -- Executing [s@macro-stdexten:1] GotoIf("Zap/25-1", "0?s|2:s|3") in new stack [Aug 3 14:53:08] VERBOSE[28960] logger.c: -- Goto (macro-stdexten,s,3) [Aug 3 14:53:08] DEBUG[28960] app_macro.c: Executed application: GotoIf [Aug 3 14:53:08] VERBOSE[28960] logger.c: -- Executing [s@macro-stdexten:3] Dial("Zap/25-1", "SIP/212|20|t") in new stack [Aug 3 14:53:08] VERBOSE[28960] logger.c: -- Called 212 [Aug 3 14:53:18] VERBOSE[28102] logger.c: -- Channel 0/1, span 2 got hangup request, cause 102 [Aug 3 14:53:18] DEBUG[28960] cdr_addon_mysql.c: cdr_mysql: inserting a CDR record. [Aug 3 14:53:18] VERBOSE[28960] logger.c: == Spawn extension (macro-stdexten, s, 3) exited non-zero on 'Zap/25-1' in macro 'stdexten' [Aug 3 14:53:18] VERBOSE[28960] logger.c: == Spawn extension (macro-stdexten, s, 3) exited non-zero on 'Zap/25-1' [Aug 3 14:53:18] DEBUG[28960] chan_zap.c: Set option AUDIO MODE, value: ON(1) on Zap/25-1 [Aug 3 14:53:18] DEBUG[28960] chan_zap.c: Not yet hungup... Calling hangup once with icause, and clearing call [Aug 3 14:53:18] DEBUG[28960] chan_zap.c: Set option AUDIO MODE, value: OFF(0) on Zap/25-1 [Aug 3 14:53:18] VERBOSE[28960] logger.c: -- Hungup 'Zap/25-1' [Aug 3 14:53:18] DEBUG[28960] cdr_addon_mysql.c: cdr_mysql: inserting a CDR record.