TEST 1 - OK Really destroying SIP dialog '1802442009@87.247.224.6' Method: OPTIONS -- Executing [800098420@from-internal:1] AGI("SIP/87.247.224.19-09780370", "agi://127.0.0.1/enswitch?stype=internal") in new stack AGI Tx >> agi_network: yes AGI Tx >> agi_network_script: enswitch?stype=internal AGI Tx >> agi_request: agi://127.0.0.1/enswitch?stype=internal AGI Tx >> agi_channel: SIP/87.247.224.19-09780370 AGI Tx >> agi_language: en AGI Tx >> agi_type: SIP AGI Tx >> agi_uniqueid: 1199457392.161 AGI Tx >> agi_callerid: 0793079000 AGI Tx >> agi_calleridname: unknown AGI Tx >> agi_callingpres: 0 AGI Tx >> agi_callingani2: 0 AGI Tx >> agi_callington: 0 AGI Tx >> agi_callingtns: 0 AGI Tx >> agi_dnid: 800098420 AGI Tx >> agi_rdnis: unknown AGI Tx >> agi_context: from-internal AGI Tx >> agi_extension: 800098420 AGI Tx >> agi_priority: 1 AGI Tx >> agi_enhanced: 0.0 AGI Tx >> agi_accountcode: AGI Tx >> AGI Rx << SET VARIABLE LANGUAGE() it_IT AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE ENSWITCH-CALLID AGI Tx >> 200 result=0 AGI Rx << SET VARIABLE __ENSWITCH-CALLID "1199457392.161" AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE ENSWITCH-CUTOFF AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE ENSWITCH-SCREEN AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE ENSWITCH-DIVERTED AGI Tx >> 200 result=0 AGI Rx << SET VARIABLE TIMEOUT(absolute) 86400 -- Channel will hangup at 2008-01-05 14:36:32 UTC. AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE ENSWITCH-SCUSTOMER AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE SIP_HEADER(X-Enswitch-Source) AGI Tx >> 200 result=1 (87.247.224.19:52569) AGI Rx << GET VARIABLE SIP_HEADER(X-Enswitch-External) AGI Tx >> 200 result=1 (yes) AGI Rx << GET VARIABLE ENSWITCH-TRANSFER-PHONE AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE ENSWITCH-TRANSFER-CUSTOMER AGI Tx >> 200 result=0 AGI Rx << VERBOSE "Resolving type '', number '800098420'." 5 AGI Tx >> 200 result=1 AGI Rx << VERBOSE "Customer 17 has 86400 inbound seconds available." 9 AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __SIPADDHEADER06 "Diversion: " AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __ENSWITCH-MUSIC default AGI Tx >> 200 result=1 AGI Rx << EXEC SetMusicOnHold default -- AGI Script Executing Application: (SetMusicOnHold) Options: (default) AGI Tx >> 200 result=0 AGI Rx << VERBOSE "Resolving type 'cardlogin', number ''." 5 AGI Tx >> 200 result=1 AGI Rx << VERBOSE "Writing entry to active table for 1199457392.161, external:0793079000 - cardlogin:." 9 AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE TIMEOUT(absolute) 86400 -- Channel will hangup at 2008-01-05 14:36:32 UTC. AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __ENSWITCH-DCUSTOMER "17" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __ENSWITCH-DTYPE "cardlogin" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __ENSWITCH-DNUMBER "" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE CALLERID(number) "0793079000" AGI Tx >> 200 result=1 AGI Rx << EXEC SetCallerPres allowed_not_screened -- AGI Script Executing Application: (SetCallerPres) Options: (allowed_not_screened) AGI Tx >> 200 result=0 AGI Rx << STREAM FILE /opt/enswitch/current/sounds/local/it_IT/enter-pin-hash 1234567890*# -- Playing '/opt/enswitch/current/sounds/local/it_IT/enter-pin-hash' (escape_digits=1234567890*#) (sample_offset 0) [Jan 4 15:36:35] NOTICE[2724]: rtp.c:787 process_rfc3389: Comfort noise support incomplete in Asterisk (RFC 3389). Please turn off on client if possible. Client IP: 87.247.224.19 AGI Tx >> 200 result=50 endpos=25120 AGI Rx << GET DATA /opt/enswitch/current/sounds/local/it_IT/silence/1 5000 99 -- Playing '/opt/enswitch/current/sounds/local/it_IT/silence/1' (language 'it_IT') Really destroying SIP dialog '1759803049@87.247.224.6' Method: OPTIONS AGI Tx >> 200 result=7716123823 AGI Rx << STREAM FILE /opt/enswitch/current/sounds/local/it_IT/enter-destination-hash 1234567890*# -- Playing '/opt/enswitch/current/sounds/local/it_IT/enter-destination-hash' (escape_digits=1234567890*#) (sample_offset 0) Really destroying SIP dialog '1593825526@87.247.224.6' Method: OPTIONS AGI Tx >> 200 result=-1 endpos=78720 == Spawn extension (from-internal, 800098420, 1) exited non-zero on 'SIP/87.247.224.19-09780370' -- Executing [h@from-internal:1] DeadAGI("SIP/87.247.224.19-09780370", "agi://127.0.0.1/end") in new stack AGI Tx >> agi_network: yes AGI Tx >> agi_network_script: end AGI Tx >> agi_request: agi://127.0.0.1/end AGI Tx >> agi_channel: SIP/87.247.224.19-09780370 AGI Tx >> agi_language: it_IT AGI Tx >> agi_type: SIP AGI Tx >> agi_uniqueid: 1199457392.161 AGI Tx >> agi_callerid: 0793079000 AGI Tx >> agi_calleridname: unknown AGI Tx >> agi_callingpres: 0 AGI Tx >> agi_callingani2: 0 AGI Tx >> agi_callington: 0 AGI Tx >> agi_callingtns: 0 AGI Tx >> agi_dnid: 800098420 AGI Tx >> agi_rdnis: unknown AGI Tx >> agi_context: from-internal AGI Tx >> agi_extension: h AGI Tx >> agi_priority: 1 AGI Tx >> agi_enhanced: 0.0 AGI Tx >> agi_accountcode: AGI Tx >> CLI> AGI Rx << SET VARIABLE LANGUAGE() it_IT AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE ENSWITCH-CALLID AGI Tx >> 200 result=1 (1199457392.161) AGI Rx << HANGUP AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE ANSWEREDTIME AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE DIALSTATUS AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE ENSWITCH-FAX-FILE AGI Tx >> 200 result=0 -- AGI Script agi://127.0.0.1/end completed, returning 0 Really destroying SIP dialog '46F809CD-BA0911DC-8487C139-774A8CFB@87.247.224.19' Method: ACK Really destroying SIP dialog '832447228@87.247.224.6' Method: OPTIONS TEST 2 - OK Really destroying SIP dialog '1105783428@87.247.224.6' Method: OPTIONS -- Executing [800098420@from-internal:1] AGI("SIP/87.247.224.19-09500820", "agi://127.0.0.1/enswitch?stype=internal") in new stack AGI Tx >> agi_network: yes AGI Tx >> agi_network_script: enswitch?stype=internal AGI Tx >> agi_request: agi://127.0.0.1/enswitch?stype=internal AGI Tx >> agi_channel: SIP/87.247.224.19-09500820 AGI Tx >> agi_language: en AGI Tx >> agi_type: SIP AGI Tx >> agi_uniqueid: 1199457643.136 AGI Tx >> agi_callerid: 079293939 AGI Tx >> agi_calleridname: unknown AGI Tx >> agi_callingpres: 0 AGI Tx >> agi_callingani2: 0 AGI Tx >> agi_callington: 0 AGI Tx >> agi_callingtns: 0 AGI Tx >> agi_dnid: 800098420 AGI Tx >> agi_rdnis: unknown AGI Tx >> agi_context: from-internal AGI Tx >> agi_extension: 800098420 AGI Tx >> agi_priority: 1 AGI Tx >> agi_enhanced: 0.0 AGI Tx >> agi_accountcode: AGI Tx >> CLI> AGI Rx << SET VARIABLE LANGUAGE() it_IT AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE ENSWITCH-CALLID AGI Tx >> 200 result=0 AGI Rx << SET VARIABLE __ENSWITCH-CALLID "1199457643.136" AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE ENSWITCH-CUTOFF AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE ENSWITCH-SCREEN AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE ENSWITCH-DIVERTED AGI Tx >> 200 result=0 AGI Rx << SET VARIABLE TIMEOUT(absolute) 86400 -- Channel will hangup at 2008-01-05 14:40:43 UTC. AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE ENSWITCH-SCUSTOMER AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE SIP_HEADER(X-Enswitch-Source) AGI Tx >> 200 result=1 (87.247.224.19:57783) AGI Rx << GET VARIABLE SIP_HEADER(X-Enswitch-External) AGI Tx >> 200 result=1 (yes) AGI Rx << GET VARIABLE ENSWITCH-TRANSFER-PHONE AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE ENSWITCH-TRANSFER-CUSTOMER AGI Tx >> 200 result=0 AGI Rx << VERBOSE "Resolving type '', number '800098420'." 5 AGI Tx >> 200 result=1 AGI Rx << VERBOSE "Customer 17 has 86400 inbound seconds available." 9 AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __SIPADDHEADER06 "Diversion: " AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __ENSWITCH-MUSIC default AGI Tx >> 200 result=1 AGI Rx << EXEC SetMusicOnHold default -- AGI Script Executing Application: (SetMusicOnHold) Options: (default) AGI Tx >> 200 result=0 AGI Rx << VERBOSE "Resolving type 'cardlogin', number ''." 5 AGI Tx >> 200 result=1 AGI Rx << VERBOSE "Writing entry to active table for 1199457643.136, external:079293939 - cardlogin:." 9 AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE TIMEOUT(absolute) 86400 -- Channel will hangup at 2008-01-05 14:40:43 UTC. AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __ENSWITCH-DCUSTOMER "17" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __ENSWITCH-DTYPE "cardlogin" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __ENSWITCH-DNUMBER "" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE CALLERID(number) "079293939" AGI Tx >> 200 result=1 AGI Rx << EXEC SetCallerPres allowed_not_screened -- AGI Script Executing Application: (SetCallerPres) Options: (allowed_not_screened) AGI Tx >> 200 result=0 AGI Rx << STREAM FILE /opt/enswitch/current/sounds/local/it_IT/enter-pin-hash 1234567890*# -- Playing '/opt/enswitch/current/sounds/local/it_IT/enter-pin-hash' (escape_digits=1234567890*#) (sample_offset 0) [Jan 4 15:40:45] NOTICE[6806]: rtp.c:787 process_rfc3389: Comfort noise support incomplete in Asterisk (RFC 3389). Please turn off on client if possible. Client IP: 87.247.224.19 AGI Tx >> 200 result=50 endpos=16640 AGI Rx << GET DATA /opt/enswitch/current/sounds/local/it_IT/silence/1 5000 99 -- Playing '/opt/enswitch/current/sounds/local/it_IT/silence/1' (language 'it_IT') Really destroying SIP dialog '2056955578@87.247.224.6' Method: OPTIONS AGI Tx >> 200 result=7716123823 AGI Rx << STREAM FILE /opt/enswitch/current/sounds/local/it_IT/enter-destination-hash 1234567890*# -- Playing '/opt/enswitch/current/sounds/local/it_IT/enter-destination-hash' (escape_digits=1234567890*#) (sample_offset 0) Really destroying SIP dialog '1802442066@87.247.224.6' Method: OPTIONS == Parsing '/etc/asterisk/manager.conf': Found AGI Tx >> 200 result=-1 endpos=56800 == Spawn extension (from-internal, 800098420, 1) exited non-zero on 'SIP/87.247.224.19-09500820' -- Executing [h@from-internal:1] DeadAGI("SIP/87.247.224.19-09500820", "agi://127.0.0.1/end") in new stack AGI Tx >> agi_network: yes AGI Tx >> agi_network_script: end AGI Tx >> agi_request: agi://127.0.0.1/end AGI Tx >> agi_channel: SIP/87.247.224.19-09500820 AGI Tx >> agi_language: it_IT AGI Tx >> agi_type: SIP AGI Tx >> agi_uniqueid: 1199457643.136 AGI Tx >> agi_callerid: 079293939 AGI Tx >> agi_calleridname: unknown AGI Tx >> agi_callingpres: 0 AGI Tx >> agi_callingani2: 0 AGI Tx >> agi_callington: 0 AGI Tx >> agi_callingtns: 0 AGI Tx >> agi_dnid: 800098420 AGI Tx >> agi_rdnis: unknown AGI Tx >> agi_context: from-internal AGI Tx >> agi_extension: h AGI Tx >> agi_priority: 1 AGI Tx >> agi_enhanced: 0.0 AGI Tx >> agi_accountcode: AGI Tx >> AGI Rx << SET VARIABLE LANGUAGE() it_IT AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE ENSWITCH-CALLID AGI Tx >> 200 result=1 (1199457643.136) AGI Rx << HANGUP AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE ANSWEREDTIME AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE DIALSTATUS AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE ENSWITCH-FAX-FILE AGI Tx >> 200 result=0 -- AGI Script agi://127.0.0.1/end completed, returning 0 Really destroying SIP dialog 'DCD0C46B-BA0911DC-8493C139-774A8CFB@87.247.224.19' Method: ACK TEST 3 - NO OK IT'S THE SECOND LINE OF ISDN 079293939 -- Executing [800098420@from-internal:1] AGI("SIP/87.247.224.19-0977d988", "agi://127.0.0.1/enswitch?stype=internal") in new stack AGI Tx >> agi_network: yes AGI Tx >> agi_network_script: enswitch?stype=internal AGI Tx >> agi_request: agi://127.0.0.1/enswitch?stype=internal AGI Tx >> agi_channel: SIP/87.247.224.19-0977d988 AGI Tx >> agi_language: en AGI Tx >> agi_type: SIP AGI Tx >> agi_uniqueid: 1199457565.162 AGI Tx >> agi_callerid: 079293939 AGI Tx >> agi_calleridname: unknown AGI Tx >> agi_callingpres: 0 AGI Tx >> agi_callingani2: 0 AGI Tx >> agi_callington: 0 AGI Tx >> agi_callingtns: 0 AGI Tx >> agi_dnid: 800098420 AGI Tx >> agi_rdnis: unknown AGI Tx >> agi_context: from-internal AGI Tx >> agi_extension: 800098420 AGI Tx >> agi_priority: 1 AGI Tx >> agi_enhanced: 0.0 AGI Tx >> agi_accountcode: AGI Tx >> CLI> AGI Rx << SET VARIABLE LANGUAGE() it_IT AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE ENSWITCH-CALLID AGI Tx >> 200 result=0 AGI Rx << SET VARIABLE __ENSWITCH-CALLID "1199457565.162" AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE ENSWITCH-CUTOFF AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE ENSWITCH-SCREEN AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE ENSWITCH-DIVERTED AGI Tx >> 200 result=0 AGI Rx << SET VARIABLE TIMEOUT(absolute) 86400 -- Channel will hangup at 2008-01-05 14:39:25 UTC. AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE ENSWITCH-SCUSTOMER AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE SIP_HEADER(X-Enswitch-Source) AGI Tx >> 200 result=1 (87.247.224.19:50239) AGI Rx << GET VARIABLE SIP_HEADER(X-Enswitch-External) AGI Tx >> 200 result=1 (yes) AGI Rx << GET VARIABLE ENSWITCH-TRANSFER-PHONE AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE ENSWITCH-TRANSFER-CUSTOMER AGI Tx >> 200 result=0 AGI Rx << VERBOSE "Resolving type '', number '800098420'." 5 AGI Tx >> 200 result=1 AGI Rx << VERBOSE "Customer 17 has 86400 inbound seconds available." 9 AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __SIPADDHEADER06 "Diversion: " AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __ENSWITCH-MUSIC default AGI Tx >> 200 result=1 AGI Rx << EXEC SetMusicOnHold default -- AGI Script Executing Application: (SetMusicOnHold) Options: (default) AGI Tx >> 200 result=0 AGI Rx << VERBOSE "Resolving type 'cardlogin', number ''." 5 AGI Tx >> 200 result=1 AGI Rx << VERBOSE "Writing entry to active table for 1199457565.162, external:079293939 - cardlogin:." 9 AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE TIMEOUT(absolute) 86400 -- Channel will hangup at 2008-01-05 14:39:25 UTC. AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __ENSWITCH-DCUSTOMER "17" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __ENSWITCH-DTYPE "cardlogin" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __ENSWITCH-DNUMBER "" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE CALLERID(number) "079293939" AGI Tx >> 200 result=1 AGI Rx << EXEC SetCallerPres allowed_not_screened -- AGI Script Executing Application: (SetCallerPres) Options: (allowed_not_screened) AGI Tx >> 200 result=0 AGI Rx << STREAM FILE /opt/enswitch/current/sounds/local/it_IT/enter-pin-hash 1234567890*# -- Playing '/opt/enswitch/current/sounds/local/it_IT/enter-pin-hash' (escape_digits=1234567890*#) (sample_offset 0) Really destroying SIP dialog '1831882273@87.247.224.6' Method: OPTIONS [Jan 4 15:39:28] NOTICE[2742]: rtp.c:787 process_rfc3389: Comfort noise support incomplete in Asterisk (RFC 3389). Please turn off on client if possible. Client IP: 87.247.224.19 AGI Tx >> 200 result=50 endpos=22240 AGI Rx << GET DATA /opt/enswitch/current/sounds/local/it_IT/silence/1 5000 99 -- Playing '/opt/enswitch/current/sounds/local/it_IT/silence/1' (language 'it_IT') Really destroying SIP dialog '1831882274@87.247.224.6' Method: OPTIONS AGI Tx >> 200 result=77161282 AGI Rx << STREAM FILE /opt/enswitch/current/sounds/local/it_IT/enter-pin-hash 1234567890*# -- Playing '/opt/enswitch/current/sounds/local/it_IT/enter-pin-hash' (escape_digits=1234567890*#) (sample_offset 0) AGI Tx >> 200 result=50 endpos=51040 AGI Rx << GET DATA /opt/enswitch/current/sounds/local/it_IT/silence/1 5000 99 -- Playing '/opt/enswitch/current/sounds/local/it_IT/silence/1' (language 'it_IT') Really destroying SIP dialog '1033352814@87.247.224.6' Method: OPTIONS AGI Tx >> 200 result=77161282 AGI Rx << STREAM FILE /opt/enswitch/current/sounds/local/it_IT/enter-pin-hash 1234567890*# -- Playing '/opt/enswitch/current/sounds/local/it_IT/enter-pin-hash' (escape_digits=1234567890*#) (sample_offset 0) AGI Tx >> 200 result=-1 endpos=16320 == Spawn extension (from-internal, 800098420, 1) exited non-zero on 'SIP/87.247.224.19-0977d988' -- Executing [h@from-internal:1] DeadAGI("SIP/87.247.224.19-0977d988", "agi://127.0.0.1/end") in new stack AGI Tx >> agi_network: yes AGI Tx >> agi_network_script: end AGI Tx >> agi_request: agi://127.0.0.1/end AGI Tx >> agi_channel: SIP/87.247.224.19-0977d988 AGI Tx >> agi_language: it_IT AGI Tx >> agi_type: SIP AGI Tx >> agi_uniqueid: 1199457565.162 AGI Tx >> agi_callerid: 079293939 AGI Tx >> agi_calleridname: unknown AGI Tx >> agi_callingpres: 0 AGI Tx >> agi_callingani2: 0 AGI Tx >> agi_callington: 0 AGI Tx >> agi_callingtns: 0 AGI Tx >> agi_dnid: 800098420 AGI Tx >> agi_rdnis: unknown AGI Tx >> agi_context: from-internal AGI Tx >> agi_extension: h AGI Tx >> agi_priority: 1 AGI Tx >> agi_enhanced: 0.0 AGI Tx >> agi_accountcode: AGI Tx >> CLI> AGI Rx << SET VARIABLE LANGUAGE() it_IT AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE ENSWITCH-CALLID AGI Tx >> 200 result=1 (1199457565.162) AGI Rx << HANGUP AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE ANSWEREDTIME AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE DIALSTATUS AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE ENSWITCH-FAX-FILE AGI Tx >> 200 result=0 -- AGI Script agi://127.0.0.1/end completed, returning 0 Really destroying SIP dialog 'AE80A45C-BA0911DC-848FC139-774A8CFB@87.247.224.19' Method: ACK Really destroying SIP dialog '1788220835@87.247.224.6' Method: OPTIONS == Parsing '/etc/