Nov 6 13:01:38 VERBOSE[17384] logger.c: -- Starting simple switch on 'Zap/1-1'
Nov 6 13:01:38 NOTICE[17384] chan_zap.c: Got event 18 (Ring Begin)...
Nov 6 13:01:38 NOTICE[17384] chan_zap.c: Got event 17 (Polarity Reversal)...
Nov 6 13:01:38 ERROR[17384] callerid.c: fsk_serie made mylen < 0 (-9)
Nov 6 13:01:38 WARNING[17384] chan_zap.c: CallerID feed failed: Success
Nov 6 13:01:38 WARNING[17384] chan_zap.c: CallerID returned with error on channel 'Zap/1-1'
Nov 6 13:01:38 VERBOSE[17384] logger.c: -- Executing Set("Zap/1-1", "FROM_DID=s") in new stack
Nov 6 13:01:38 VERBOSE[17384] logger.c: -- Executing Goto("Zap/1-1", "timeconditions|1|1") in new stack
Nov 6 13:01:38 VERBOSE[17384] logger.c: -- Goto (timeconditions,1,1)
Nov 6 13:01:38 VERBOSE[17384] logger.c: -- Executing GotoIfTime("Zap/1-1", "08:00-18:00|mon-fri|*|*?ivr-2|s|1") in new stack
Nov 6 13:01:38 VERBOSE[17384] logger.c: -- Goto (ivr-2,s,1)
Nov 6 13:01:38 VERBOSE[17384] logger.c: -- Executing Set("Zap/1-1", "LOOPCOUNT=0") in new stack
Nov 6 13:01:38 VERBOSE[17384] logger.c: -- Executing Set("Zap/1-1", "__DIR-CONTEXT=default") in new stack
Nov 6 13:01:38 VERBOSE[17384] logger.c: -- Executing Answer("Zap/1-1", "") in new stack
Nov 6 13:01:38 DEBUG[17384] chan_zap.c: Took Zap/1-1 off hook
Nov 6 13:01:38 DEBUG[17384] chan_zap.c: Enabled echo cancellation on channel 1
Nov 6 13:01:38 DEBUG[17384] chan_zap.c: Engaged echo training on channel 1
Nov 6 13:01:38 VERBOSE[17384] logger.c: -- Executing Wait("Zap/1-1", "1") in new stack
Nov 6 13:01:38 DEBUG[17384] chan_zap.c: Exception on 16, channel 1
Nov 6 13:01:38 DEBUG[17384] chan_zap.c: Got event Polarity Reversal(17) on channel 1 (index 0)
Nov 6 13:01:38 DEBUG[17384] chan_zap.c: Ignore switch to REVERSED Polarity on channel 1, state 6
Nov 6 13:01:38 DEBUG[17384] chan_zap.c: Ignoring Polarity switch to IDLE on channel 1, state 6
Nov 6 13:01:38 DEBUG[17384] chan_zap.c: Polarity Reversal event occured - DEBUG 2: channel 1, state 6, pol= 0, aonp= 0, honp= 0, pdelay= 600, tv= -1100038567
Nov 6 13:01:39 VERBOSE[17384] logger.c: -- Executing Set("Zap/1-1", "TIMEOUT(digit)=3") in new stack
Nov 6 13:01:39 VERBOSE[17384] logger.c: -- Digit timeout set to 3
Nov 6 13:01:39 VERBOSE[17384] logger.c: -- Executing Set("Zap/1-1", "TIMEOUT(response)=30") in new stack
Nov 6 13:01:39 VERBOSE[17384] logger.c: -- Response timeout set to 30
Nov 6 13:01:39 VERBOSE[17384] logger.c: -- Executing BackGround("Zap/1-1", "custom/Timedata") in new stack
Nov 6 13:01:39 DEBUG[17384] channel.c: Scheduling timer at 160 sample intervals
Nov 6 13:01:39 VERBOSE[17384] logger.c: -- Playing 'custom/Timedata' (language 'en')
Nov 6 13:01:43 DEBUG[910] chan_sip.c: Stopping retransmission on '7603557a7fc6cb58275545c20e1e2f4b@10.9.0.1' of Request 102: Match Found
Nov 6 13:01:44 DEBUG[910] chan_sip.c: Auto destroying call '83227f7f-d4d21dc@10.12.13.8'
Nov 6 13:01:48 DEBUG[910] chan_sip.c: Stopping retransmission on '04a18da45bd6334949eddbe16bdc33e9@10.9.0.1' of Request 102: Match Found
Nov 6 13:01:52 DEBUG[910] chan_sip.c: Stopping retransmission on '50ca0fe13f610c5978faea377a6cd2ce@10.9.0.1' of Request 102: Match Found
Nov 6 13:01:58 DEBUG[17384] chan_zap.c: DTMF digit: 2 on Zap/1-1
Nov 6 13:01:58 DEBUG[17384] channel.c: Scheduling timer at 0 sample intervals
Nov 6 13:01:58 DEBUG[17384] pbx.c: Oooh, got something to jump out with ('2')!
Nov 6 13:01:58 DEBUG[17384] chan_zap.c: DTMF digit: 1 on Zap/1-1
Nov 6 13:01:59 DEBUG[17384] chan_zap.c: DTMF digit: 0 on Zap/1-1
Nov 6 13:02:00 DEBUG[17384] chan_zap.c: DTMF digit: 0 on Zap/1-1
Nov 6 13:02:00 VERBOSE[17384] logger.c: == CDR updated on Zap/1-1
Nov 6 13:02:00 VERBOSE[17384] logger.c: -- Executing Macro("Zap/1-1", "user-callerid|") in new stack
Nov 6 13:02:00 DEBUG[17384] pbx.c: Expression result is '0'
Nov 6 13:02:00 VERBOSE[17384] logger.c: -- Executing GotoIf("Zap/1-1", "0?report") in new stack
Nov 6 13:02:00 DEBUG[17384] pbx.c: Not taking any branch
Nov 6 13:02:00 DEBUG[17384] pbx.c: Expression result is '0'
Nov 6 13:02:00 VERBOSE[17384] logger.c: -- Executing GotoIf("Zap/1-1", "0?start") in new stack
Nov 6 13:02:00 DEBUG[17384] pbx.c: Not taking any branch
Nov 6 13:02:00 DEBUG[17384] pbx.c: Function result is ''
Nov 6 13:02:00 VERBOSE[17384] logger.c: -- Executing Set("Zap/1-1", "REALCALLERIDNUM=") in new stack
Nov 6 13:02:00 VERBOSE[17384] logger.c: -- Executing NoOp("Zap/1-1", "REALCALLERIDNUM is ") in new stack
Nov 6 13:02:00 DEBUG[17384] db.c: Unable to find key '/user' in family 'DEVICE'
Nov 6 13:02:00 DEBUG[17384] func_db.c: DB: DEVICE//user not found in database.
Nov 6 13:02:00 DEBUG[17384] pbx.c: Function result is ''
Nov 6 13:02:00 VERBOSE[17384] logger.c: -- Executing Set("Zap/1-1", "AMPUSER=") in new stack
Nov 6 13:02:00 DEBUG[17384] db.c: Unable to find key '/cidname' in family 'AMPUSER'
Nov 6 13:02:00 DEBUG[17384] func_db.c: DB: AMPUSER//cidname not found in database.
Nov 6 13:02:00 DEBUG[17384] pbx.c: Function result is ''
Nov 6 13:02:00 VERBOSE[17384] logger.c: -- Executing Set("Zap/1-1", "AMPUSERCIDNAME=") in new stack
Nov 6 13:02:00 DEBUG[17384] pbx.c: Expression result is '1'
Nov 6 13:02:00 VERBOSE[17384] logger.c: -- Executing GotoIf("Zap/1-1", "1?report") in new stack
Nov 6 13:02:00 VERBOSE[17384] logger.c: -- Goto (macro-user-callerid,s,9)
Nov 6 13:02:00 DEBUG[17384] pbx.c: Function result is '"" <>'
Nov 6 13:02:00 VERBOSE[17384] logger.c: -- Executing NoOp("Zap/1-1", "Using CallerID "" <>") in new stack
Nov 6 13:02:00 DEBUG[17384] pbx.c: Function result is '0'
Nov 6 13:02:00 DEBUG[17384] pbx.c: Function result is ''
Nov 6 13:02:00 DEBUG[17384] pbx.c: Expression result is '0'
Nov 6 13:02:00 VERBOSE[17384] logger.c: -- Executing GotoIf("Zap/1-1", "0?NEWPREFIX") in new stack
Nov 6 13:02:00 DEBUG[17384] pbx.c: Not taking any branch
Nov 6 13:02:00 DEBUG[17384] pbx.c: Function result is '0'
Nov 6 13:02:00 DEBUG[17384] pbx.c: Function result is ''
Nov 6 13:02:00 VERBOSE[17384] logger.c: -- Executing Set("Zap/1-1", "CALLERID(name)=") in new stack
Nov 6 13:02:00 VERBOSE[17384] logger.c: -- Executing Set("Zap/1-1", "RGPREFIX=") in new stack
Nov 6 13:02:00 DEBUG[17384] pbx.c: Function result is ''
Nov 6 13:02:00 VERBOSE[17384] logger.c: -- Executing Set("Zap/1-1", "CALLERID(name)=") in new stack
Nov 6 13:02:00 VERBOSE[17384] logger.c: -- Executing Set("Zap/1-1", "RecordMethod=Group") in new stack
Nov 6 13:02:00 VERBOSE[17384] logger.c: -- Executing Macro("Zap/1-1", "record-enable|2100-2101-2102|Group") in new stack
Nov 6 13:02:00 DEBUG[17384] pbx.c: Function result is '0'
Nov 6 13:02:00 VERBOSE[17384] logger.c: -- Executing GotoIf("Zap/1-1", "0 > 0?2:4") in new stack
Nov 6 13:02:00 VERBOSE[17384] logger.c: -- Goto (macro-record-enable,s,4)
Nov 6 13:02:00 VERBOSE[17384] logger.c: -- Executing AGI("Zap/1-1", "recordingcheck|20061106-130200|1162836098.120") in new stack
Nov 6 13:02:00 VERBOSE[17384] logger.c: -- Launched AGI Script /var/lib/asterisk/agi-bin/recordingcheck
Nov 6 13:02:00 VERBOSE[17384] logger.c: -- AGI Script recordingcheck completed, returning 0
Nov 6 13:02:00 VERBOSE[17384] logger.c: -- Executing NoOp("Zap/1-1", "No recording needed") in new stack
Nov 6 13:02:00 VERBOSE[17384] logger.c: -- Executing Set("Zap/1-1", "RingGroupMethod=ringall") in new stack
Nov 6 13:02:00 VERBOSE[17384] logger.c: -- Executing Macro("Zap/1-1", "dial|20|tr|2100-2101-2102") in new stack
Nov 6 13:02:00 VERBOSE[17384] logger.c: -- Executing AGI("Zap/1-1", "dialparties.agi") in new stack
Nov 6 13:02:00 VERBOSE[17384] logger.c: -- Launched AGI Script /var/lib/asterisk/agi-bin/dialparties.agi
Nov 6 13:02:00 VERBOSE[17384] logger.c: dialparties.agi: Starting New Dialparties.agi
Nov 6 13:02:00 VERBOSE[17384] logger.c: -- dialparties.agi: priority is 1
Nov 6 13:02:00 VERBOSE[17384] logger.c: dialparties.agi: Caller ID name is 'unknown' number is 'unknown'
Nov 6 13:02:00 VERBOSE[17384] logger.c: dialparties.agi: Methodology of ring is 'ringall'
Nov 6 13:02:00 VERBOSE[17384] logger.c: -- dialparties.agi: Added extension 2100 to extension map
Nov 6 13:02:00 VERBOSE[17384] logger.c: -- dialparties.agi: Added extension 2101 to extension map
Nov 6 13:02:00 VERBOSE[17384] logger.c: -- dialparties.agi: Added extension 2102 to extension map
Nov 6 13:02:00 DEBUG[17384] db.c: Unable to find key '2100' in family 'CF'
Nov 6 13:02:00 VERBOSE[17384] logger.c: -- dialparties.agi: Extension 2100 cf is disabled
Nov 6 13:02:00 DEBUG[17384] db.c: Unable to find key '2101' in family 'CF'
Nov 6 13:02:00 VERBOSE[17384] logger.c: -- dialparties.agi: Extension 2101 cf is disabled
Nov 6 13:02:00 DEBUG[17384] db.c: Unable to find key '2102' in family 'CF'
Nov 6 13:02:00 VERBOSE[17384] logger.c: -- dialparties.agi: Extension 2102 cf is disabled
Nov 6 13:02:00 DEBUG[17384] db.c: Unable to find key '2100' in family 'DND'
Nov 6 13:02:00 VERBOSE[17384] logger.c: -- dialparties.agi: Extension 2100 do not disturb is disabled
Nov 6 13:02:00 DEBUG[17384] db.c: Unable to find key '2101' in family 'DND'
Nov 6 13:02:00 VERBOSE[17384] logger.c: -- dialparties.agi: Extension 2101 do not disturb is disabled
Nov 6 13:02:00 DEBUG[17384] db.c: Unable to find key '2102' in family 'DND'
Nov 6 13:02:00 VERBOSE[17384] logger.c: -- dialparties.agi: Extension 2102 do not disturb is disabled
Nov 6 13:02:00 DEBUG[17384] db.c: Unable to find key '2100' in family 'CW'
Nov 6 13:02:00 DEBUG[17384] db.c: Unable to find key '2100' in family 'CFB'
Nov 6 13:02:00 DEBUG[17384] db.c: Unable to find key '2100' in family 'CFU'
Nov 6 13:02:00 VERBOSE[17384] logger.c: > dialparties.agi: extnum: 2100
Nov 6 13:02:00 VERBOSE[17384] logger.c: > dialparties.agi: exthascw: 0
Nov 6 13:02:00 VERBOSE[17384] logger.c: > dialparties.agi: exthascfb: 0
Nov 6 13:02:00 VERBOSE[17384] logger.c: > dialparties.agi: extcfb:
Nov 6 13:02:00 VERBOSE[17384] logger.c: > dialparties.agi: exthascfu: 0
Nov 6 13:02:00 VERBOSE[17384] logger.c: > dialparties.agi: extcfu:
Nov 6 13:02:00 DEBUG[17389] manager.c: Manager received command 'login'
Nov 6 13:02:00 VERBOSE[17389] logger.c: == Parsing '/etc/asterisk/manager.conf': Nov 6 13:02:00 VERBOSE[17389] logger.c: == Parsing '/etc/asterisk/manager.conf': Found
Nov 6 13:02:00 VERBOSE[17389] logger.c: == Parsing '/etc/asterisk/manager_custom.conf': Nov 6 13:02:00 VERBOSE[17389] logger.c: == Parsing '/etc/asterisk/manager_custom.conf': Found
Nov 6 13:02:00 WARNING[17389] config.c: Unknown directive 'permit=192.168.1.0/255.255.255.0' at line 18 of manager_custom.conf
Nov 6 13:02:00 DEBUG[17389] acl.c: 0.0.0.0/0.0.0.0/0.0.0.0 appended to acl for peer
Nov 6 13:02:00 DEBUG[17389] acl.c: 127.0.0.1/255.255.255.0/255.255.255.0 appended to acl for peer
Nov 6 13:02:00 DEBUG[17389] acl.c: ##### Testing 127.0.0.1 with 0.0.0.0
Nov 6 13:02:00 DEBUG[17389] acl.c: ##### Testing 127.0.0.1 with 127.0.0.0
Nov 6 13:02:00 VERBOSE[17389] logger.c: == Manager 'admin' logged on from 127.0.0.1
Nov 6 13:02:00 DEBUG[17389] manager.c: Manager received command 'ExtensionState'
Nov 6 13:02:00 DEBUG[17389] manager.c: Manager received command 'Logoff'
Nov 6 13:02:00 VERBOSE[17389] logger.c: == Manager 'admin' logged off from 127.0.0.1
Nov 6 13:02:00 VERBOSE[17384] logger.c: > dialparties.agi: ExtensionState: 0
Nov 6 13:02:00 VERBOSE[17384] logger.c: -- dialparties.agi: Checking CW and CFB status for extension 2100
Nov 6 13:02:00 VERBOSE[17384] logger.c: -- dialparties.agi: DbSet CALLTRACE/2100 to unknown
Nov 6 13:02:00 DEBUG[17384] db.c: Unable to find key '2101' in family 'CFB'
Nov 6 13:02:00 DEBUG[17384] db.c: Unable to find key '2101' in family 'CFU'
Nov 6 13:02:00 VERBOSE[17384] logger.c: > dialparties.agi: extnum: 2101
Nov 6 13:02:00 VERBOSE[17384] logger.c: > dialparties.agi: exthascw: 1
Nov 6 13:02:00 VERBOSE[17384] logger.c: > dialparties.agi: exthascfb: 0
Nov 6 13:02:00 VERBOSE[17384] logger.c: > dialparties.agi: extcfb:
Nov 6 13:02:00 VERBOSE[17384] logger.c: > dialparties.agi: exthascfu: 0
Nov 6 13:02:00 VERBOSE[17384] logger.c: > dialparties.agi: extcfu:
Nov 6 13:02:00 VERBOSE[17384] logger.c: -- dialparties.agi: DbSet CALLTRACE/2101 to unknown
Nov 6 13:02:00 DEBUG[17384] db.c: Unable to find key '2102' in family 'CW'
Nov 6 13:02:00 DEBUG[17384] db.c: Unable to find key '2102' in family 'CFB'
Nov 6 13:02:00 DEBUG[17384] db.c: Unable to find key '2102' in family 'CFU'
Nov 6 13:02:00 VERBOSE[17384] logger.c: > dialparties.agi: extnum: 2102
Nov 6 13:02:00 VERBOSE[17384] logger.c: > dialparties.agi: exthascw: 0
Nov 6 13:02:00 VERBOSE[17384] logger.c: > dialparties.agi: exthascfb: 0
Nov 6 13:02:00 VERBOSE[17384] logger.c: > dialparties.agi: extcfb:
Nov 6 13:02:00 VERBOSE[17384] logger.c: > dialparties.agi: exthascfu: 0
Nov 6 13:02:00 VERBOSE[17384] logger.c: > dialparties.agi: extcfu:
Nov 6 13:02:00 DEBUG[17390] manager.c: Manager received command 'login'
Nov 6 13:02:00 VERBOSE[17390] logger.c: == Parsing '/etc/asterisk/manager.conf': Nov 6 13:02:00 VERBOSE[17390] logger.c: == Parsing '/etc/asterisk/manager.conf': Found
Nov 6 13:02:00 VERBOSE[17390] logger.c: == Parsing '/etc/asterisk/manager_custom.conf': Nov 6 13:02:00 VERBOSE[17390] logger.c: == Parsing '/etc/asterisk/manager_custom.conf': Found
Nov 6 13:02:00 WARNING[17390] config.c: Unknown directive 'permit=192.168.1.0/255.255.255.0' at line 18 of manager_custom.conf
Nov 6 13:02:00 DEBUG[17390] acl.c: 0.0.0.0/0.0.0.0/0.0.0.0 appended to acl for peer
Nov 6 13:02:00 DEBUG[17390] acl.c: 127.0.0.1/255.255.255.0/255.255.255.0 appended to acl for peer
Nov 6 13:02:00 DEBUG[17390] acl.c: ##### Testing 127.0.0.1 with 0.0.0.0
Nov 6 13:02:00 DEBUG[17390] acl.c: ##### Testing 127.0.0.1 with 127.0.0.0
Nov 6 13:02:00 VERBOSE[17390] logger.c: == Manager 'admin' logged on from 127.0.0.1
Nov 6 13:02:00 DEBUG[17390] manager.c: Manager received command 'ExtensionState'
Nov 6 13:02:00 DEBUG[17390] manager.c: Manager received command 'Logoff'
Nov 6 13:02:00 VERBOSE[17390] logger.c: == Manager 'admin' logged off from 127.0.0.1
Nov 6 13:02:00 VERBOSE[17384] logger.c: > dialparties.agi: ExtensionState: 4
Nov 6 13:02:00 VERBOSE[17384] logger.c: -- dialparties.agi: Checking CW and CFB status for extension 2102
Nov 6 13:02:00 VERBOSE[17384] logger.c: -- dialparties.agi: DbSet CALLTRACE/2102 to unknown
Nov 6 13:02:00 VERBOSE[17384] logger.c: -- AGI Script dialparties.agi completed, returning 0
Nov 6 13:02:00 VERBOSE[17384] logger.c: -- Executing Dial("Zap/1-1", "SIP/2100&SIP/2101&SIP/2102|20|tr") in new stack
Nov 6 13:02:00 DEBUG[17384] chan_sip.c: Setting NAT on RTP to 0
Nov 6 13:02:00 DEBUG[17384] chan_sip.c: Outgoing Call for 2100
Nov 6 13:02:00 VERBOSE[17384] logger.c: -- Called 2100
Nov 6 13:02:00 DEBUG[17384] chan_sip.c: Setting NAT on RTP to 524288
Nov 6 13:02:00 DEBUG[17384] chan_sip.c: Outgoing Call for 2101
Nov 6 13:02:00 VERBOSE[17384] logger.c: -- Called 2101
Nov 6 13:02:00 NOTICE[17384] app_dial.c: Unable to create channel of type 'SIP' (cause 3 - No route to destination)
Nov 6 13:02:00 DEBUG[17384] chan_zap.c: Requested indication 3 on channel Zap/1-1
Nov 6 13:02:00 DEBUG[910] chan_sip.c: (Provisional) Stopping retransmission (but retaining packet) on '78bb0fe330d8f6902d206aa73599e141@192.168.38.1' Request 102: Found
Nov 6 13:02:00 DEBUG[910] chan_sip.c: (Provisional) Stopping retransmission (but retaining packet) on '78bb0fe330d8f6902d206aa73599e141@192.168.38.1' Request 102: Found
Nov 6 13:02:00 VERBOSE[17384] logger.c: -- SIP/2100-0835e3b0 is ringing
Nov 6 13:02:00 DEBUG[910] chan_sip.c: (Provisional) Stopping retransmission (but retaining packet) on '12c4db1840ae596130c098d0773cdd80@10.9.0.1' Request 102: Found
Nov 6 13:02:00 DEBUG[910] chan_sip.c: (Provisional) Stopping retransmission (but retaining packet) on '12c4db1840ae596130c098d0773cdd80@10.9.0.1' Request 102: Found
Nov 6 13:02:00 VERBOSE[17384] logger.c: -- SIP/2101-082d9cc0 is ringing
Nov 6 13:02:06 DEBUG[17384] chan_zap.c: Exception on 16, channel 1
Nov 6 13:02:06 DEBUG[17384] chan_zap.c: Got event On hook(1) on channel 1 (index 0)
Nov 6 13:02:06 DEBUG[17384] chan_zap.c: disabled echo cancellation on channel 1
Nov 6 13:02:06 DEBUG[17384] chan_sip.c: update_call_counter(2101) - decrement call limit counter
Nov 6 13:02:06 DEBUG[17384] chan_sip.c: Acked pending invite 102
Nov 6 13:02:06 DEBUG[17384] chan_sip.c: Stopping retransmission on '12c4db1840ae596130c098d0773cdd80@10.9.0.1' of Request 102: Match Found
Nov 6 13:02:06 DEBUG[17384] chan_sip.c: update_call_counter(2100) - decrement call limit counter
Nov 6 13:02:06 DEBUG[17384] chan_sip.c: Acked pending invite 102
Nov 6 13:02:06 DEBUG[17384] chan_sip.c: Stopping retransmission on '78bb0fe330d8f6902d206aa73599e141@192.168.38.1' of Request 102: Match Found
Nov 6 13:02:06 DEBUG[17384] app_dial.c: Exiting with DIALSTATUS=CANCEL.
Nov 6 13:02:06 VERBOSE[17384] logger.c: == Spawn extension (macro-dial, s, 10) exited non-zero on 'Zap/1-1' in macro 'dial'
Nov 6 13:02:06 VERBOSE[17384] logger.c: == Spawn extension (macro-dial, s, 10) exited non-zero on 'Zap/1-1'
Nov 6 13:02:06 DEBUG[17384] cdr_addon_mysql.c: cdr_mysql: inserting a CDR record.
Nov 6 13:02:06 DEBUG[17384] 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,uniqueid) VALUES ('2006-11-06 13:01:38','','','2100','ivr-2', 'Zap/1-1','SIP/2101-082d9cc0','Dial','SIP/2100&SIP/2101&SIP/2102|20|tr',28,28,'ANSWERED',3,'','1162836098.120')
Nov 6 13:02:06 DEBUG[17384] chan_zap.c: Hangup: channel: 1 index = 0, normal = 16, callwait = -1, thirdcall = -1
Nov 6 13:02:06 DEBUG[17384] chan_zap.c: disabled echo cancellation on channel 1
Nov 6 13:02:06 DEBUG[17384] chan_zap.c: Set option TDD MODE, value: OFF(0) on Zap/1-1
Nov 6 13:02:06 DEBUG[17384] chan_zap.c: Updated conferencing on 1, with 0 conference users
Nov 6 13:02:06 VERBOSE[17384] logger.c: -- Hungup 'Zap/1-1'