Mar 19 13:11:47 VERBOSE[24593]: Asterisk Event Logger Started /var/log/asterisk/event_log Mar 19 13:11:47 VERBOSE[24593]: == Manager registered action Ping Mar 19 13:11:47 VERBOSE[24593]: == Manager registered action Events Mar 19 13:11:47 VERBOSE[24593]: == Manager registered action Logoff Mar 19 13:11:47 VERBOSE[24593]: == Manager registered action Hangup Mar 19 13:11:47 VERBOSE[24593]: == Manager registered action Status Mar 19 13:11:47 VERBOSE[24593]: == Manager registered action Setvar Mar 19 13:11:47 VERBOSE[24593]: == Manager registered action Getvar Mar 19 13:11:47 VERBOSE[24593]: == Manager registered action Redirect Mar 19 13:11:47 VERBOSE[24593]: == Manager registered action Originate Mar 19 13:11:47 VERBOSE[24593]: == Manager registered action Command Mar 19 13:11:47 VERBOSE[24593]: == Manager registered action ExtensionState Mar 19 13:11:47 VERBOSE[24593]: == Manager registered action AbsoluteTimeout Mar 19 13:11:47 VERBOSE[24593]: == Manager registered action MailboxStatus Mar 19 13:11:47 VERBOSE[24593]: == Manager registered action MailboxCount Mar 19 13:11:47 VERBOSE[24593]: == Manager registered action ListCommands Mar 19 13:11:47 VERBOSE[24593]: == Parsing '/etc/asterisk/manager.conf': Mar 19 13:11:47 VERBOSE[24593]: == Parsing '/etc/asterisk/manager.conf': Found Mar 19 13:11:47 VERBOSE[24593]: == Parsing '/etc/asterisk/rtp.conf': Mar 19 13:11:47 VERBOSE[24593]: == Parsing '/etc/asterisk/rtp.conf': Found Mar 19 13:11:47 VERBOSE[24593]: == RTP Allocating from port range 10000 -> 20000 Mar 19 13:11:47 VERBOSE[24593]: Asterisk PBX Core Initializing Mar 19 13:11:47 VERBOSE[24593]: Registering builtin applications: Mar 19 13:11:47 VERBOSE[24593]: Registered custom function regex Mar 19 13:11:47 VERBOSE[24593]: Registered custom function isnull Mar 19 13:11:47 VERBOSE[24593]: Registered custom function exists Mar 19 13:11:47 VERBOSE[24593]: Registered custom function if Mar 19 13:11:47 VERBOSE[24593]: [AbsoluteTimeout] Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'AbsoluteTimeout' Mar 19 13:11:47 VERBOSE[24593]: [Answer] Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'Answer' Mar 19 13:11:47 VERBOSE[24593]: [BackGround] Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'BackGround' Mar 19 13:11:47 VERBOSE[24593]: [Busy] Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'Busy' Mar 19 13:11:47 VERBOSE[24593]: [Congestion] Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'Congestion' Mar 19 13:11:47 VERBOSE[24593]: [DigitTimeout] Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'DigitTimeout' Mar 19 13:11:47 VERBOSE[24593]: [Goto] Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'Goto' Mar 19 13:11:47 VERBOSE[24593]: [GotoIf] Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'GotoIf' Mar 19 13:11:47 VERBOSE[24593]: [GotoIfTime] Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'GotoIfTime' Mar 19 13:11:47 VERBOSE[24593]: [ExecIfTime] Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'ExecIfTime' Mar 19 13:11:47 VERBOSE[24593]: [Hangup] Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'Hangup' Mar 19 13:11:47 VERBOSE[24593]: [NoOp] Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'NoOp' Mar 19 13:11:47 VERBOSE[24593]: [Prefix] Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'Prefix' Mar 19 13:11:47 VERBOSE[24593]: [Progress] Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'Progress' Mar 19 13:11:47 VERBOSE[24593]: [ResetCDR] Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'ResetCDR' Mar 19 13:11:47 VERBOSE[24593]: [ResponseTimeout] Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'ResponseTimeout' Mar 19 13:11:47 VERBOSE[24593]: [Ringing] Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'Ringing' Mar 19 13:11:47 VERBOSE[24593]: [SayNumber] Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'SayNumber' Mar 19 13:11:47 VERBOSE[24593]: [SayDigits] Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'SayDigits' Mar 19 13:11:47 VERBOSE[24593]: [SayAlpha] Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'SayAlpha' Mar 19 13:11:47 VERBOSE[24593]: [SayPhonetic] Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'SayPhonetic' Mar 19 13:11:47 VERBOSE[24593]: [SetAccount] Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'SetAccount' Mar 19 13:11:47 VERBOSE[24593]: [SetAMAFlags] Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'SetAMAFlags' Mar 19 13:11:47 VERBOSE[24593]: [SetGlobalVar] Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'SetGlobalVar' Mar 19 13:11:47 VERBOSE[24593]: [SetLanguage] Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'SetLanguage' Mar 19 13:11:47 VERBOSE[24593]: [SetVar] Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'SetVar' Mar 19 13:11:47 VERBOSE[24593]: [ImportVar] Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'ImportVar' Mar 19 13:11:47 VERBOSE[24593]: [StripMSD] Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'StripMSD' Mar 19 13:11:47 VERBOSE[24593]: [Suffix] Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'Suffix' Mar 19 13:11:47 VERBOSE[24593]: [Wait] Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'Wait' Mar 19 13:11:47 VERBOSE[24593]: [WaitExten] Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'WaitExten' Mar 19 13:11:47 VERBOSE[24593]: Asterisk Dynamic Loader Starting: Mar 19 13:11:47 VERBOSE[24593]: == Parsing '/etc/asterisk/modules.conf': Mar 19 13:11:47 VERBOSE[24593]: == Parsing '/etc/asterisk/modules.conf': Found Mar 19 13:11:47 VERBOSE[24593]: [res_musiconhold.so]Mar 19 13:11:47 VERBOSE[24593]: [res_musiconhold.so] => (Music On Hold Resource) Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'MusicOnHold' Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'WaitMusicOnHold' Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'SetMusicOnHold' Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'StartMusicOnHold' Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'StopMusicOnHold' Mar 19 13:11:47 VERBOSE[24593]: == Parsing '/etc/asterisk/musiconhold.conf': Mar 19 13:11:47 VERBOSE[24593]: == Parsing '/etc/asterisk/musiconhold.conf': Found Mar 19 13:11:47 VERBOSE[24593]: [res_features.so]Mar 19 13:11:47 VERBOSE[24593]: [res_features.so] => (Call Parking Resource) Mar 19 13:11:47 VERBOSE[24593]: == Parsing '/etc/asterisk/features.conf': Mar 19 13:11:47 VERBOSE[24593]: == Parsing '/etc/asterisk/features.conf': Found Mar 19 13:11:47 VERBOSE[24593]: -- Registered extension context 'parkedcalls' Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '7000' priority 1 to parkedcalls Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'ParkedCall' Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'Park' Mar 19 13:11:47 VERBOSE[24593]: == Manager registered action ParkedCalls Mar 19 13:11:47 VERBOSE[24593]: [res_monitor.so]Mar 19 13:11:47 VERBOSE[24593]: [res_monitor.so] => (Call Monitoring Resource) Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'Monitor' Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'StopMonitor' Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'ChangeMonitor' Mar 19 13:11:47 VERBOSE[24593]: == Manager registered action Monitor Mar 19 13:11:47 VERBOSE[24593]: == Manager registered action StopMonitor Mar 19 13:11:47 VERBOSE[24593]: == Manager registered action ChangeMonitor Mar 19 13:11:47 VERBOSE[24593]: [res_indications.so]Mar 19 13:11:47 VERBOSE[24593]: [res_indications.so] => (Indications Configuration) Mar 19 13:11:47 VERBOSE[24593]: == Parsing '/etc/asterisk/indications.conf': Mar 19 13:11:47 VERBOSE[24593]: == Parsing '/etc/asterisk/indications.conf': Found Mar 19 13:11:47 VERBOSE[24593]: -- Registered indication country 'cl' Mar 19 13:11:47 VERBOSE[24593]: -- Registered indication country 'tw' Mar 19 13:11:47 VERBOSE[24593]: -- Registered indication country 'us' Mar 19 13:11:47 VERBOSE[24593]: -- Registered indication country 'au' Mar 19 13:11:47 VERBOSE[24593]: -- Registered indication country 'fr' Mar 19 13:11:47 VERBOSE[24593]: -- Registered indication country 'de' Mar 19 13:11:47 VERBOSE[24593]: -- Registered indication country 'nl' Mar 19 13:11:47 VERBOSE[24593]: -- Registered indication country 'uk' Mar 19 13:11:47 VERBOSE[24593]: -- Registered indication country 'fi' Mar 19 13:11:47 VERBOSE[24593]: -- Registered indication country 'no' Mar 19 13:11:47 VERBOSE[24593]: -- Registered indication country 'br' Mar 19 13:11:47 VERBOSE[24593]: -- Registered indication country 'za' Mar 19 13:11:47 VERBOSE[24593]: -- Registered indication country 'it' Mar 19 13:11:47 VERBOSE[24593]: -- Registered indication country 'us-o' Mar 19 13:11:47 VERBOSE[24593]: -- Registered indication country 'gr' Mar 19 13:11:47 VERBOSE[24593]: -- Registered indication country 'ru' Mar 19 13:11:47 VERBOSE[24593]: -- Registered indication country 'nz' Mar 19 13:11:47 VERBOSE[24593]: -- Setting default indication country to 'us' Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'Playtones' Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'StopPlaytones' Mar 19 13:11:47 VERBOSE[24593]: [res_adsi.so]Mar 19 13:11:47 VERBOSE[24593]: [res_adsi.so] => (ADSI Resource) Mar 19 13:11:47 VERBOSE[24593]: == Parsing '/etc/asterisk/adsi.conf': Mar 19 13:11:47 VERBOSE[24593]: == Parsing '/etc/asterisk/adsi.conf': Found Mar 19 13:11:47 VERBOSE[24593]: [res_agi.so]Mar 19 13:11:47 VERBOSE[24593]: [res_agi.so] => (Asterisk Gateway Interface (AGI)) Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'DeadAGI' Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'EAGI' Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'AGI' Mar 19 13:11:47 VERBOSE[24593]: [res_crypto.so]Mar 19 13:11:47 VERBOSE[24593]: [res_crypto.so] => (Cryptographic Digital Signatures) Mar 19 13:11:47 VERBOSE[24593]: -- Loaded PUBLIC key 'freeworlddialup' Mar 19 13:11:47 VERBOSE[24593]: -- Loaded PUBLIC key 'iaxtel' Mar 19 13:11:47 VERBOSE[24593]: [chan_sip.so]Mar 19 13:11:47 VERBOSE[24593]: [chan_sip.so] => (Session Initiation Protocol (SIP)) Mar 19 13:11:47 VERBOSE[24593]: == Parsing '/etc/asterisk/sip.conf': Mar 19 13:11:47 VERBOSE[24593]: == Parsing '/etc/asterisk/sip.conf': Found Mar 19 13:11:47 VERBOSE[24593]: -- SIP Seeding peers from Astdb: 'wilson' at wilson@10.1.1.100:5060 for 1800 Mar 19 13:11:47 DEBUG[24593]: Unable to find key 'slehman' in family 'SIP/Registry' Mar 19 13:11:47 VERBOSE[24593]: -- SIP Seeding peers from Astdb: 'wilson-polycom' at wilson-polycom@10.1.1.200:5060 for 3600 Mar 19 13:11:47 DEBUG[24593]: Unable to find key 'wilson-room-polycom' in family 'SIP/Registry' Mar 19 13:11:47 DEBUG[24593]: Unable to find key 'scott-polycom' in family 'SIP/Registry' Mar 19 13:11:47 DEBUG[24593]: Unable to find key 'scott-room-polycom' in family 'SIP/Registry' Mar 19 13:11:47 DEBUG[24593]: Unable to find key 'guest-room-polycom' in family 'SIP/Registry' Mar 19 13:11:47 DEBUG[24593]: Unable to find key 'theater-polycom' in family 'SIP/Registry' Mar 19 13:11:47 VERBOSE[24593]: == SIP Listening on 0.0.0.0:5060 Mar 19 13:11:47 VERBOSE[24593]: == Using TOS bits 24 Mar 19 13:11:47 VERBOSE[24593]: == Parsing '/etc/asterisk/sip_notify.conf': Mar 19 13:11:47 VERBOSE[24593]: == Parsing '/etc/asterisk/sip_notify.conf': Not found (No such file or directory) Mar 19 13:11:47 VERBOSE[24593]: == Registered channel type 'SIP' (Session Initiation Protocol (SIP)) Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'SIPDtmfMode' Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'SIPAddHeader' Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'SIPGetHeader' Mar 19 13:11:47 VERBOSE[24593]: [skipping chan_modem.so] Mar 19 13:11:47 VERBOSE[24593]: [skipping chan_phone.so] Mar 19 13:11:47 VERBOSE[24593]: [skipping chan_skinny.so] Mar 19 13:11:47 VERBOSE[24593]: [skipping chan_oss.so] Mar 19 13:11:47 VERBOSE[24593]: [skipping chan_agent.so] Mar 19 13:11:47 VERBOSE[24593]: [skipping chan_iax2.so] Mar 19 13:11:47 VERBOSE[24593]: [chan_zap.so]Mar 19 13:11:47 VERBOSE[24593]: [chan_zap.so] => (Zapata Telephony w/PRI) Mar 19 13:11:47 VERBOSE[24593]: == Parsing '/etc/asterisk/zapata.conf': Mar 19 13:11:47 VERBOSE[24593]: == Parsing '/etc/asterisk/zapata.conf': Found Mar 19 13:11:47 DEBUG[24593]: Updated conferencing on 1, with 0 conference users Mar 19 13:11:47 VERBOSE[24593]: -- Registered channel 1, FXO Kewlstart signalling Mar 19 13:11:47 DEBUG[24593]: Updated conferencing on 2, with 0 conference users Mar 19 13:11:47 VERBOSE[24593]: -- Registered channel 2, FXO Kewlstart signalling Mar 19 13:11:47 DEBUG[24593]: Updated conferencing on 3, with 0 conference users Mar 19 13:11:47 VERBOSE[24593]: -- Registered channel 3, FXS Kewlstart signalling Mar 19 13:11:47 DEBUG[24593]: Updated conferencing on 4, with 0 conference users Mar 19 13:11:47 VERBOSE[24593]: -- Registered channel 4, FXS Kewlstart signalling Mar 19 13:11:47 VERBOSE[24593]: -- Automatically generated pseudo channel Mar 19 13:11:47 VERBOSE[24593]: == Registered channel type 'Zap' (Zapata Telephony Driver w/PRI) Mar 19 13:11:47 VERBOSE[24593]: == Manager registered action ZapTransfer Mar 19 13:11:47 VERBOSE[24593]: == Manager registered action ZapHangup Mar 19 13:11:47 VERBOSE[24593]: == Manager registered action ZapDialOffhook Mar 19 13:11:47 VERBOSE[24593]: == Manager registered action ZapDNDon Mar 19 13:11:47 VERBOSE[24593]: == Manager registered action ZapDNDoff Mar 19 13:11:47 VERBOSE[24593]: == Manager registered action ZapShowChannels Mar 19 13:11:47 VERBOSE[24593]: [skipping chan_modem_i4l.so] Mar 19 13:11:47 VERBOSE[24593]: [chan_features.so]Mar 19 13:11:47 VERBOSE[24593]: [chan_features.so] => (Feature Proxy Channel) Mar 19 13:11:47 VERBOSE[24593]: == Registered channel type 'Feature' (Feature Proxy Channel Driver) Mar 19 13:11:47 VERBOSE[24593]: [skipping chan_modem_aopen.so] Mar 19 13:11:47 VERBOSE[24593]: [skipping chan_mgcp.so] Mar 19 13:11:47 VERBOSE[24593]: [chan_local.so]Mar 19 13:11:47 VERBOSE[24593]: [chan_local.so] => (Local Proxy Channel) Mar 19 13:11:47 VERBOSE[24593]: == Registered channel type 'Local' (Local Proxy Channel Driver) Mar 19 13:11:47 VERBOSE[24593]: [skipping chan_modem_bestdata.so] Mar 19 13:11:47 VERBOSE[24593]: [pbx_spool.so]Mar 19 13:11:47 VERBOSE[24593]: [pbx_spool.so] => (Outgoing Spool Support) Mar 19 13:11:47 VERBOSE[24593]: [pbx_config.so]Mar 19 13:11:47 VERBOSE[24593]: [pbx_config.so] => (Text Extension Configuration) Mar 19 13:11:47 VERBOSE[24593]: == Parsing '/etc/asterisk/extensions.conf': Mar 19 13:11:47 VERBOSE[24593]: == Parsing '/etc/asterisk/extensions.conf': Found Mar 19 13:11:47 VERBOSE[24593]: -- Setting global variable 'CONSOLE' to 'Console/dsp' Mar 19 13:11:47 VERBOSE[24593]: -- Registered extension context 'directdial' Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '9' priority 1 to directdial Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '9' priority 2 to directdial Mar 19 13:11:47 VERBOSE[24593]: -- Registered extension context 'analog' Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '_9.' priority 1 to analog Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '_9.' priority 2 to analog Mar 19 13:11:47 VERBOSE[24593]: -- Registered extension context 'home-incoming' Mar 19 13:11:47 VERBOSE[24593]: -- Added extension 's' priority 1 to home-incoming Mar 19 13:11:47 VERBOSE[24593]: -- Added extension 's' priority 2 to home-incoming Mar 19 13:11:47 VERBOSE[24593]: -- Added extension 's' priority 3 to home-incoming Mar 19 13:11:47 VERBOSE[24593]: -- Added extension 's' priority 4 to home-incoming Mar 19 13:11:47 VERBOSE[24593]: -- Added extension 's' priority 5 to home-incoming Mar 19 13:11:47 VERBOSE[24593]: -- Added extension 's' priority 6 to home-incoming Mar 19 13:11:47 VERBOSE[24593]: -- Added extension 's' priority 105 to home-incoming Mar 19 13:11:47 VERBOSE[24593]: -- Added extension 's' priority 106 to home-incoming Mar 19 13:11:47 VERBOSE[24593]: -- Registered extension context 'default' Mar 19 13:11:47 VERBOSE[24593]: -- Including context 'home' in context 'default' Mar 19 13:11:47 VERBOSE[24593]: -- Including context 'sip' in context 'default' Mar 19 13:11:47 VERBOSE[24593]: -- Including context 'x11' in context 'default' Mar 19 13:11:47 VERBOSE[24593]: -- Including context 'directdial' in context 'default' Mar 19 13:11:47 VERBOSE[24593]: -- Including context 'parkedcalls' in context 'default' Mar 19 13:11:47 VERBOSE[24593]: -- Registered extension context 'home' Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '100' priority 1 to home Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '100' priority 2 to home Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '1000' priority 1 to home Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '1000' priority 2 to home Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '1000' priority 3 to home Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '1000' priority 102 to home Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '1000' priority 103 to home Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '2000' priority 1 to home Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '2000' priority 2 to home Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '2000' priority 3 to home Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '2000' priority 4 to home Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '2000' priority 5 to home Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '2000' priority 102 to home Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '5000' priority 1 to home Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '5000' priority 2 to home Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '5000' priority 3 to home Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '5000' priority 102 to home Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '5000' priority 103 to home Mar 19 13:11:47 VERBOSE[24593]: -- Registered extension context 'office-incoming' Mar 19 13:11:47 VERBOSE[24593]: -- Added extension 's' priority 1 to office-incoming Mar 19 13:11:47 VERBOSE[24593]: -- Added extension 's' priority 2 to office-incoming Mar 19 13:11:47 VERBOSE[24593]: -- Added extension 's' priority 3 to office-incoming Mar 19 13:11:47 VERBOSE[24593]: -- Added extension 's' priority 4 to office-incoming Mar 19 13:11:47 VERBOSE[24593]: -- Added extension 's' priority 5 to office-incoming Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '1' priority 1 to office-incoming Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '1' priority 2 to office-incoming Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '2' priority 1 to office-incoming Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '2' priority 2 to office-incoming Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '3' priority 1 to office-incoming Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '3' priority 2 to office-incoming Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '3' priority 3 to office-incoming Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '3' priority 4 to office-incoming Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '3' priority 5 to office-incoming Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '3' priority 102 to office-incoming Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '3' priority 103 to office-incoming Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '8' priority 1 to office-incoming Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '8' priority 2 to office-incoming Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '*' priority 1 to office-incoming Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '*' priority 2 to office-incoming Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '#' priority 1 to office-incoming Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '#' priority 2 to office-incoming Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '9' priority 1 to office-incoming Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '9' priority 2 to office-incoming Mar 19 13:11:47 VERBOSE[24593]: -- Registered extension context 'sip' Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '3000' priority 1 to sip Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '3000' priority 2 to sip Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '3000' priority 3 to sip Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '3000' priority 103 to sip Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '3000' priority 104 to sip Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '3002' priority 1 to sip Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '3002' priority 2 to sip Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '3002' priority 3 to sip Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '3002' priority 103 to sip Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '3002' priority 104 to sip Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '4000' priority 1 to sip Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '4000' priority 2 to sip Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '4000' priority 3 to sip Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '4000' priority 103 to sip Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '4000' priority 104 to sip Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '4002' priority 1 to sip Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '4002' priority 2 to sip Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '4002' priority 3 to sip Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '4002' priority 103 to sip Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '4002' priority 104 to sip Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '5001' priority 1 to sip Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '5001' priority 2 to sip Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '5001' priority 3 to sip Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '5001' priority 4 to sip Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '5001' priority 5 to sip Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '5001' priority 102 to sip Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '5002' priority 1 to sip Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '5002' priority 2 to sip Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '5002' priority 3 to sip Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '5002' priority 4 to sip Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '5002' priority 5 to sip Mar 19 13:11:47 VERBOSE[24593]: -- Added extension '5002' priority 102 to sip Mar 19 13:11:47 VERBOSE[24593]: -- Registered extension context 'from-sip' Mar 19 13:11:47 VERBOSE[24593]: -- Including context 'sip' in context 'from-sip' Mar 19 13:11:47 VERBOSE[24593]: -- Including context 'analog' in context 'from-sip' Mar 19 13:11:47 VERBOSE[24593]: -- Including context 'home' in context 'from-sip' Mar 19 13:11:47 VERBOSE[24593]: -- Including context 'x11' in context 'from-sip' Mar 19 13:11:47 VERBOSE[24593]: -- Including context 'parkedcalls' in context 'from-sip' Mar 19 13:11:47 VERBOSE[24593]: -- Registered extension context 'x11' Mar 19 13:11:47 VERBOSE[24593]: [pbx_loopback.so]Mar 19 13:11:47 VERBOSE[24593]: [pbx_loopback.so] => (Loopback Switch) Mar 19 13:11:47 VERBOSE[24593]: [pbx_realtime.so]Mar 19 13:11:47 VERBOSE[24593]: [pbx_realtime.so] => (Realtime Switch) Mar 19 13:11:47 VERBOSE[24593]: [pbx_dundi.so]Mar 19 13:11:47 VERBOSE[24593]: [pbx_dundi.so] => (Distributed Universal Number Discovery (DUNDi)) Mar 19 13:11:47 VERBOSE[24593]: == Parsing '/etc/asterisk/dundi.conf': Mar 19 13:11:47 VERBOSE[24593]: == Parsing '/etc/asterisk/dundi.conf': Not found (No such file or directory) Mar 19 13:11:47 DEBUG[24593]: Seeding global EID '00:90:27:de:28:e0' from 'eth0' Mar 19 13:11:47 VERBOSE[24593]: == Using TOS bits 0 Mar 19 13:11:47 VERBOSE[24593]: == DUNDi Ready and Listening on 0.0.0.0 port 4520 Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'DUNDiLookup' Mar 19 13:11:47 VERBOSE[24593]: [app_waitforsilence.so]Mar 19 13:11:47 VERBOSE[24593]: [app_waitforsilence.so] => (Wait For Silence) Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'WaitForSilence' Mar 19 13:11:47 VERBOSE[24593]: [format_wav_gsm.so]Mar 19 13:11:47 VERBOSE[24593]: [format_wav_gsm.so] => (Microsoft WAV format (Proprietary GSM)) Mar 19 13:11:47 VERBOSE[24593]: == Registered file format wav49, extension(s) WAV|wav49 Mar 19 13:11:47 VERBOSE[24593]: [codec_ulaw.so]Mar 19 13:11:47 VERBOSE[24593]: [codec_ulaw.so] => (Mu-law Coder/Decoder) Mar 19 13:11:47 VERBOSE[24593]: == Parsing '/etc/asterisk/codecs.conf': Mar 19 13:11:47 VERBOSE[24593]: == Parsing '/etc/asterisk/codecs.conf': Not found (No such file or directory) Mar 19 13:11:47 VERBOSE[24593]: == Registered translator 'ulawtolin' from format ulaw to slin, cost 1 Mar 19 13:11:47 VERBOSE[24593]: == Registered translator 'lintoulaw' from format slin to ulaw, cost 1 Mar 19 13:11:47 VERBOSE[24593]: [app_realtime.so]Mar 19 13:11:47 VERBOSE[24593]: [app_realtime.so] => (Realtime Data Lookup/Rewrite) Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'RealTimeUpdate' Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'RealTime' Mar 19 13:11:47 VERBOSE[24593]: [app_exec.so]Mar 19 13:11:47 VERBOSE[24593]: [app_exec.so] => (Executes applications) Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'Exec' Mar 19 13:11:47 VERBOSE[24593]: [app_setcidname.so]Mar 19 13:11:47 VERBOSE[24593]: [app_setcidname.so] => (Set CallerID Name) Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'SetCIDName' Mar 19 13:11:47 VERBOSE[24593]: [app_sms.so]Mar 19 13:11:47 VERBOSE[24593]: [app_sms.so] => (SMS/PSTN handler) Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'SMS' Mar 19 13:11:47 VERBOSE[24593]: [skipping chan_modem.so] Mar 19 13:11:47 VERBOSE[24593]: [app_curl.so]Mar 19 13:11:47 VERBOSE[24593]: [app_curl.so] => (Load external URL) Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'Curl' Mar 19 13:11:47 VERBOSE[24593]: [app_groupcount.so]Mar 19 13:11:47 VERBOSE[24593]: [app_groupcount.so] => (Group Management Routines) Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'GetGroupCount' Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'SetGroup' Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'CheckGroup' Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'GetGroupMatchCount' Mar 19 13:11:47 VERBOSE[24593]: [app_substring.so]Mar 19 13:11:47 VERBOSE[24593]: [app_substring.so] => ((Deprecated) Save substring digits in a given variable) Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'SubString' Mar 19 13:11:47 VERBOSE[24593]: [format_wav.so]Mar 19 13:11:47 VERBOSE[24593]: [format_wav.so] => (Microsoft WAV format (8000hz Signed Linear)) Mar 19 13:11:47 VERBOSE[24593]: == Registered file format wav, extension(s) wav Mar 19 13:11:47 VERBOSE[24593]: [app_striplsd.so]Mar 19 13:11:47 VERBOSE[24593]: [app_striplsd.so] => (Strip trailing digits) Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'StripLSD' Mar 19 13:11:47 VERBOSE[24593]: [skipping app_zapbarge.so] Mar 19 13:11:47 VERBOSE[24593]: [app_controlplayback.so]Mar 19 13:11:47 VERBOSE[24593]: [app_controlplayback.so] => (Control Playback Application) Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'ControlPlayback' Mar 19 13:11:47 VERBOSE[24593]: [app_transfer.so]Mar 19 13:11:47 VERBOSE[24593]: [app_transfer.so] => (Transfer) Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'Transfer' Mar 19 13:11:47 VERBOSE[24593]: [app_cut.so]Mar 19 13:11:47 VERBOSE[24593]: [app_cut.so] => (Cuts up variables) Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'Cut' Mar 19 13:11:47 VERBOSE[24593]: [app_lookupcidname.so]Mar 19 13:11:47 VERBOSE[24593]: [app_lookupcidname.so] => (Look up CallerID Name from local database) Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'LookupCIDName' Mar 19 13:11:47 VERBOSE[24593]: [skipping chan_phone.so] Mar 19 13:11:47 VERBOSE[24593]: [format_gsm.so]Mar 19 13:11:47 VERBOSE[24593]: [format_gsm.so] => (Raw GSM data) Mar 19 13:11:47 VERBOSE[24593]: == Registered file format gsm, extension(s) gsm Mar 19 13:11:47 VERBOSE[24593]: [format_jpeg.so]Mar 19 13:11:47 VERBOSE[24593]: [format_jpeg.so] => (JPEG (Joint Picture Experts Group) Image Format) Mar 19 13:11:47 VERBOSE[24593]: == Registered format 'jpg' (JPEG (Joint Picture Experts Group)) Mar 19 13:11:47 VERBOSE[24593]: [app_senddtmf.so]Mar 19 13:11:47 VERBOSE[24593]: [app_senddtmf.so] => (Send DTMF digits Application) Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'SendDTMF' Mar 19 13:11:47 VERBOSE[24593]: [app_softhangup.so]Mar 19 13:11:47 VERBOSE[24593]: [app_softhangup.so] => (Hangs up the requested channel) Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'SoftHangup' Mar 19 13:11:47 VERBOSE[24593]: [skipping app_image.so] Mar 19 13:11:47 VERBOSE[24593]: [skipping cdr_csv.so] Mar 19 13:11:47 VERBOSE[24593]: [skipping chan_skinny.so] Mar 19 13:11:47 VERBOSE[24593]: [skipping app_meetme.so] Mar 19 13:11:47 VERBOSE[24593]: [app_voicemail.so]Mar 19 13:11:47 VERBOSE[24593]: [app_voicemail.so] => (Comedian Mail (Voicemail System)) Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'VoiceMail' Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'VoiceMailMain' Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'MailboxExists' Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'VMAuthenticate' Mar 19 13:11:47 VERBOSE[24593]: == Parsing '/etc/asterisk/voicemail.conf': Mar 19 13:11:47 VERBOSE[24593]: == Parsing '/etc/asterisk/voicemail.conf': Found Mar 19 13:11:47 DEBUG[24593]: VM Review Option disabled globally Mar 19 13:11:47 DEBUG[24593]: VM Operator break disabled globally Mar 19 13:11:47 DEBUG[24593]: VM CID Info before msg disabled globally Mar 19 13:11:47 DEBUG[24593]: ENVELOPE before msg enabled globally Mar 19 13:11:47 DEBUG[24593]: Duration info before msg enabled globally Mar 19 13:11:47 DEBUG[24593]: We are not going to skip to the next msg after save/delete Mar 19 13:11:47 VERBOSE[24593]: [skipping chan_oss.so] Mar 19 13:11:47 VERBOSE[24593]: [skipping chan_agent.so] Mar 19 13:11:47 VERBOSE[24593]: [skipping app_talkdetect.so] Mar 19 13:11:47 VERBOSE[24593]: [format_g723.so]Mar 19 13:11:47 VERBOSE[24593]: [format_g723.so] => (G.723.1 Simple Timestamp File Format) Mar 19 13:11:47 VERBOSE[24593]: == Registered file format g723sf, extension(s) g723|g723sf Mar 19 13:11:47 VERBOSE[24593]: [app_lookupblacklist.so]Mar 19 13:11:47 VERBOSE[24593]: [app_lookupblacklist.so] => (Look up Caller*ID name/number from blacklist database) Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'LookupBlacklist' Mar 19 13:11:47 VERBOSE[24593]: [codec_adpcm.so]Mar 19 13:11:47 VERBOSE[24593]: [codec_adpcm.so] => (Adaptive Differential PCM Coder/Decoder) Mar 19 13:11:47 VERBOSE[24593]: == Parsing '/etc/asterisk/codecs.conf': Mar 19 13:11:47 VERBOSE[24593]: == Parsing '/etc/asterisk/codecs.conf': Not found (No such file or directory) Mar 19 13:11:47 VERBOSE[24593]: == Registered translator 'adpcmtolin' from format adpcm to slin, cost 1 Mar 19 13:11:47 VERBOSE[24593]: == Registered translator 'lintoadpcm' from format slin to adpcm, cost 1 Mar 19 13:11:47 VERBOSE[24593]: [skipping chan_iax2.so] Mar 19 13:11:47 VERBOSE[24593]: [app_macro.so]Mar 19 13:11:47 VERBOSE[24593]: [app_macro.so] => (Extension Macros) Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'MacroExit' Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'MacroIf' Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'Macro' Mar 19 13:11:47 VERBOSE[24593]: [format_pcm.so]Mar 19 13:11:47 VERBOSE[24593]: [format_pcm.so] => (Raw uLaw 8khz Audio support (PCM)) Mar 19 13:11:47 VERBOSE[24593]: == Registered file format pcm, extension(s) pcm|ulaw|ul|mu Mar 19 13:11:47 VERBOSE[24593]: [app_sendtext.so]Mar 19 13:11:47 VERBOSE[24593]: [app_sendtext.so] => (Send Text Applications) Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'SendText' Mar 19 13:11:47 VERBOSE[24593]: [skipping app_queue.so] Mar 19 13:11:47 VERBOSE[24593]: [app_md5.so]Mar 19 13:11:47 VERBOSE[24593]: [app_md5.so] => (MD5 checksum applications) Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'MD5Check' Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'MD5' Mar 19 13:11:47 VERBOSE[24593]: [app_nbscat.so]Mar 19 13:11:47 VERBOSE[24593]: [app_nbscat.so] => (Silly NBS Stream Application) Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'NBScat' Mar 19 13:11:47 VERBOSE[24593]: [app_while.so]Mar 19 13:11:47 VERBOSE[24593]: [app_while.so] => (While Loops and Conditional Execution) Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'While' Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'ExecIf' Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'EndWhile' Mar 19 13:11:47 VERBOSE[24593]: [app_test.so]Mar 19 13:11:47 VERBOSE[24593]: [app_test.so] => (Interface Test Application) Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'TestClient' Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'TestServer' Mar 19 13:11:47 VERBOSE[24593]: [skipping app_flash.so] Mar 19 13:11:47 VERBOSE[24593]: [skipping chan_modem_i4l.so] Mar 19 13:11:47 VERBOSE[24593]: [app_enumlookup.so]Mar 19 13:11:47 VERBOSE[24593]: [app_enumlookup.so] => (ENUM Lookup) Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'EnumLookup' Mar 19 13:11:47 VERBOSE[24593]: == Parsing '/etc/asterisk/enum.conf': Mar 19 13:11:47 VERBOSE[24593]: == Parsing '/etc/asterisk/enum.conf': Found Mar 19 13:11:47 VERBOSE[24593]: [app_eval.so]Mar 19 13:11:47 VERBOSE[24593]: [app_eval.so] => (Reevaluates strings) Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'Eval' Mar 19 13:11:47 VERBOSE[24593]: [app_math.so]Mar 19 13:11:47 VERBOSE[24593]: [app_math.so] => (Basic Math Functions) Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'Math' Mar 19 13:11:47 VERBOSE[24593]: [app_readfile.so]Mar 19 13:11:47 VERBOSE[24593]: [app_readfile.so] => (Stores output of file into a variable) Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'ReadFile' Mar 19 13:11:47 VERBOSE[24593]: [app_milliwatt.so]Mar 19 13:11:47 VERBOSE[24593]: [app_milliwatt.so] => (Digital Milliwatt (mu-law) Test Application) Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'Milliwatt' Mar 19 13:11:47 VERBOSE[24593]: [skipping app_festival.so] Mar 19 13:11:47 VERBOSE[24593]: [app_zapateller.so]Mar 19 13:11:47 VERBOSE[24593]: [app_zapateller.so] => (Block Telemarketers with Special Information Tone) Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'Zapateller' Mar 19 13:11:47 VERBOSE[24593]: [format_pcm_alaw.so]Mar 19 13:11:47 VERBOSE[24593]: [format_pcm_alaw.so] => (Raw aLaw 8khz PCM Audio support) Mar 19 13:11:47 VERBOSE[24593]: == Registered file format alaw, extension(s) alaw|al Mar 19 13:11:47 VERBOSE[24593]: [app_dumpchan.so]Mar 19 13:11:47 VERBOSE[24593]: [app_dumpchan.so] => (Dump Info About The Calling Channel) Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'DumpChan' Mar 19 13:11:47 VERBOSE[24593]: [app_setrdnis.so]Mar 19 13:11:47 VERBOSE[24593]: [app_setrdnis.so] => (Set RDNIS Number) Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'SetRDNIS' Mar 19 13:11:47 VERBOSE[24593]: [skipping chan_modem_aopen.so] Mar 19 13:11:47 VERBOSE[24593]: [app_dial.so]Mar 19 13:11:47 VERBOSE[24593]: [app_dial.so] => (Dialing Application) Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'Dial' Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'RetryDial' Mar 19 13:11:47 VERBOSE[24593]: [codec_ilbc.so]Mar 19 13:11:47 VERBOSE[24593]: [codec_ilbc.so] => (iLBC/PCM16 (signed linear) Codec Translator) Mar 19 13:11:47 VERBOSE[24593]: == Registered translator 'ilbctolin' from format ilbc to slin, cost 4 Mar 19 13:11:47 VERBOSE[24593]: == Registered translator 'lintoilbc' from format slin to ilbc, cost 23 Mar 19 13:11:47 VERBOSE[24593]: [app_userevent.so]Mar 19 13:11:47 VERBOSE[24593]: [app_userevent.so] => (Custom User Event Application) Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'UserEvent' Mar 19 13:11:47 VERBOSE[24593]: [skipping app_ices.so] Mar 19 13:11:47 VERBOSE[24593]: [skipping app_alarmreceiver.so] Mar 19 13:11:47 VERBOSE[24593]: [skipping app_intercom.so] Mar 19 13:11:47 VERBOSE[24593]: [app_echo.so]Mar 19 13:11:47 VERBOSE[24593]: [app_echo.so] => (Simple Echo Application) Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'Echo' Mar 19 13:11:47 VERBOSE[24593]: [skipping cdr_manager.so] Mar 19 13:11:47 VERBOSE[24593]: [codec_lpc10.so]Mar 19 13:11:47 VERBOSE[24593]: [codec_lpc10.so] => (LPC10 2.4kbps (signed linear) Voice Coder) Mar 19 13:11:47 VERBOSE[24593]: == Parsing '/etc/asterisk/codecs.conf': Mar 19 13:11:47 VERBOSE[24593]: == Parsing '/etc/asterisk/codecs.conf': Not found (No such file or directory) Mar 19 13:11:47 VERBOSE[24593]: == Registered translator 'lpc10tolin' from format lpc10 to slin, cost 4 Mar 19 13:11:47 VERBOSE[24593]: == Registered translator 'lintolpc10' from format slin to lpc10, cost 8 Mar 19 13:11:47 VERBOSE[24593]: [skipping app_zapras.so] Mar 19 13:11:47 VERBOSE[24593]: [app_db.so]Mar 19 13:11:47 VERBOSE[24593]: [app_db.so] => (Database access functions for Asterisk extension logic) Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'DBget' Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'DBput' Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'DBdel' Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'DBdeltree' Mar 19 13:11:47 VERBOSE[24593]: [app_cdr.so]Mar 19 13:11:47 VERBOSE[24593]: [app_cdr.so] => (Make sure asterisk doesn't save CDR for a certain call) Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'NoCDR' Mar 19 13:11:47 VERBOSE[24593]: [skipping chan_mgcp.so] Mar 19 13:11:47 VERBOSE[24593]: [app_forkcdr.so]Mar 19 13:11:47 VERBOSE[24593]: [app_forkcdr.so] => (Fork The CDR into 2 separate entities.) Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'ForkCDR' Mar 19 13:11:47 VERBOSE[24593]: [app_setcdruserfield.so]Mar 19 13:11:47 VERBOSE[24593]: [app_setcdruserfield.so] => (CDR user field apps) Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'SetCDRUserField' Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'AppendCDRUserField' Mar 19 13:11:47 VERBOSE[24593]: == Manager registered action SetCDRUserField Mar 19 13:11:47 VERBOSE[24593]: [app_record.so]Mar 19 13:11:47 VERBOSE[24593]: [app_record.so] => (Trivial Record Application) Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'Record' Mar 19 13:11:47 VERBOSE[24593]: [app_setcallerid.so]Mar 19 13:11:47 VERBOSE[24593]: [app_setcallerid.so] => (Set CallerID Application) Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'SetCallerPres' Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'SetCallerID' Mar 19 13:11:47 VERBOSE[24593]: [format_ilbc.so]Mar 19 13:11:47 VERBOSE[24593]: [format_ilbc.so] => (Raw iLBC data) Mar 19 13:11:47 VERBOSE[24593]: == Registered file format iLBC, extension(s) ilbc Mar 19 13:11:47 VERBOSE[24593]: [app_directory.so]Mar 19 13:11:47 VERBOSE[24593]: [app_directory.so] => (Extension Directory) Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'Directory' Mar 19 13:11:47 VERBOSE[24593]: [app_system.so]Mar 19 13:11:47 VERBOSE[24593]: [app_system.so] => (Generic System() application) Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'TrySystem' Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'System' Mar 19 13:11:47 VERBOSE[24593]: [codec_a_mu.so]Mar 19 13:11:47 VERBOSE[24593]: [codec_a_mu.so] => (A-law and Mulaw direct Coder/Decoder) Mar 19 13:11:47 VERBOSE[24593]: == Registered translator 'alawtoulaw' from format alaw to ulaw, cost 1 Mar 19 13:11:47 VERBOSE[24593]: == Registered translator 'ulawtoalaw' from format ulaw to alaw, cost 1 Mar 19 13:11:47 VERBOSE[24593]: [app_read.so]Mar 19 13:11:47 VERBOSE[24593]: [app_read.so] => (Read Variable Application) Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'Read' Mar 19 13:11:47 VERBOSE[24593]: [codec_gsm.so]Mar 19 13:11:47 VERBOSE[24593]: [codec_gsm.so] => (GSM/PCM16 (signed linear) Codec Translator) Mar 19 13:11:47 VERBOSE[24593]: == Parsing '/etc/asterisk/codecs.conf': Mar 19 13:11:47 VERBOSE[24593]: == Parsing '/etc/asterisk/codecs.conf': Not found (No such file or directory) Mar 19 13:11:47 VERBOSE[24593]: == Registered translator 'gsmtolin' from format gsm to slin, cost 1 Mar 19 13:11:47 VERBOSE[24593]: == Registered translator 'lintogsm' from format slin to gsm, cost 5 Mar 19 13:11:47 VERBOSE[24593]: [app_mp3.so]Mar 19 13:11:47 VERBOSE[24593]: [app_mp3.so] => (Silly MP3 Application) Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'MP3Player' Mar 19 13:11:47 VERBOSE[24593]: [format_vox.so]Mar 19 13:11:47 VERBOSE[24593]: [format_vox.so] => (Dialogic VOX (ADPCM) File Format) Mar 19 13:11:47 VERBOSE[24593]: == Registered file format vox, extension(s) vox Mar 19 13:11:47 VERBOSE[24593]: [skipping app_zapscan.so] Mar 19 13:11:47 VERBOSE[24593]: [skipping app_adsiprog.so] Mar 19 13:11:47 VERBOSE[24593]: [app_playback.so]Mar 19 13:11:47 VERBOSE[24593]: [app_playback.so] => (Sound File Playback Application) Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'Playback' Mar 19 13:11:47 VERBOSE[24593]: [app_sayunixtime.so]Mar 19 13:11:47 VERBOSE[24593]: [app_sayunixtime.so] => (Say time) Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'SayUnixTime' Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'DateTime' Mar 19 13:11:47 VERBOSE[24593]: [skipping app_url.so] Mar 19 13:11:47 VERBOSE[24593]: [app_chanisavail.so]Mar 19 13:11:47 VERBOSE[24593]: [app_chanisavail.so] => (Check if channel is available) Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'ChanIsAvail' Mar 19 13:11:47 VERBOSE[24593]: [codec_alaw.so]Mar 19 13:11:47 VERBOSE[24593]: [codec_alaw.so] => (A-law Coder/Decoder) Mar 19 13:11:47 VERBOSE[24593]: == Parsing '/etc/asterisk/codecs.conf': Mar 19 13:11:47 VERBOSE[24593]: == Parsing '/etc/asterisk/codecs.conf': Not found (No such file or directory) Mar 19 13:11:47 VERBOSE[24593]: == Registered translator 'alawtolin' from format alaw to slin, cost 1 Mar 19 13:11:47 VERBOSE[24593]: == Registered translator 'lintoalaw' from format slin to alaw, cost 1 Mar 19 13:11:47 VERBOSE[24593]: [format_g726.so]Mar 19 13:11:47 VERBOSE[24593]: [format_g726.so] => (Raw G.726 (16/24/32/40kbps) data) Mar 19 13:11:47 VERBOSE[24593]: == Registered file format g726-40, extension(s) g726-40 Mar 19 13:11:47 VERBOSE[24593]: == Registered file format g726-32, extension(s) g726-32 Mar 19 13:11:47 VERBOSE[24593]: == Registered file format g726-24, extension(s) g726-24 Mar 19 13:11:47 VERBOSE[24593]: == Registered file format g726-16, extension(s) g726-16 Mar 19 13:11:47 VERBOSE[24593]: [format_g729.so]Mar 19 13:11:47 VERBOSE[24593]: [format_g729.so] => (Raw G729 data) Mar 19 13:11:47 VERBOSE[24593]: == Registered file format g729, extension(s) g729 Mar 19 13:11:47 VERBOSE[24593]: [format_h263.so]Mar 19 13:11:47 VERBOSE[24593]: [format_h263.so] => (Raw h263 data) Mar 19 13:11:47 VERBOSE[24593]: == Registered file format h263, extension(s) h263 Mar 19 13:11:47 VERBOSE[24593]: [app_getcpeid.so]Mar 19 13:11:47 VERBOSE[24593]: [app_getcpeid.so] => (Get ADSI CPE ID) Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'GetCPEID' Mar 19 13:11:47 VERBOSE[24593]: [app_setcidnum.so]Mar 19 13:11:47 VERBOSE[24593]: [app_setcidnum.so] => (Set CallerID Number) Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'SetCIDNum' Mar 19 13:11:47 VERBOSE[24593]: [app_hasnewvoicemail.so]Mar 19 13:11:47 VERBOSE[24593]: [app_hasnewvoicemail.so] => (Indicator for whether a voice mailbox has messages in a given folder.[) Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'HasVoicemail' Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'HasNewVoicemail' Mar 19 13:11:47 VERBOSE[24593]: [skipping app_disa.so] Mar 19 13:11:47 VERBOSE[24593]: [app_privacy.so]Mar 19 13:11:47 VERBOSE[24593]: [app_privacy.so] => (Require phone number to be entered, if no CallerID sent) Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'PrivacyManager' Mar 19 13:11:47 VERBOSE[24593]: [app_verbose.so]Mar 19 13:11:47 VERBOSE[24593]: [app_verbose.so] => (Send verbose output) Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'Verbose' Mar 19 13:11:47 VERBOSE[24593]: [app_authenticate.so]Mar 19 13:11:47 VERBOSE[24593]: [app_authenticate.so] => (Authentication Application) Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'Authenticate' Mar 19 13:11:47 VERBOSE[24593]: [app_parkandannounce.so]Mar 19 13:11:47 VERBOSE[24593]: [app_parkandannounce.so] => (Call Parking and Announce Application) Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'ParkAndAnnounce' Mar 19 13:11:47 VERBOSE[24593]: [app_waitforring.so]Mar 19 13:11:47 VERBOSE[24593]: [app_waitforring.so] => (Waits until first ring after time) Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'WaitForRing' Mar 19 13:11:47 VERBOSE[24593]: [format_sln.so]Mar 19 13:11:47 VERBOSE[24593]: [format_sln.so] => (Raw Signed Linear Audio support (SLN)) Mar 19 13:11:47 VERBOSE[24593]: == Registered file format sln, extension(s) sln|raw Mar 19 13:11:47 VERBOSE[24593]: [skipping chan_modem_bestdata.so] Mar 19 13:11:47 VERBOSE[24593]: [codec_g726.so]Mar 19 13:11:47 VERBOSE[24593]: [codec_g726.so] => (ITU G.726-32kbps G726 Transcoder) Mar 19 13:11:47 VERBOSE[24593]: == Parsing '/etc/asterisk/codecs.conf': Mar 19 13:11:47 VERBOSE[24593]: == Parsing '/etc/asterisk/codecs.conf': Not found (No such file or directory) Mar 19 13:11:47 VERBOSE[24593]: == Registered translator 'g726tolin' from format g726 to slin, cost 4 Mar 19 13:11:47 VERBOSE[24593]: == Registered translator 'lintog726' from format slin to g726, cost 2 Mar 19 13:11:47 VERBOSE[24593]: [app_random.so]Mar 19 13:11:47 VERBOSE[24593]: [app_random.so] => (Random goto) Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'Random' Mar 19 13:11:47 VERBOSE[24593]: [app_txtcidname.so]Mar 19 13:11:47 VERBOSE[24593]: [app_txtcidname.so] => (TXTCIDName) Mar 19 13:11:47 VERBOSE[24593]: == Registered application 'TXTCIDName' Mar 19 13:11:47 VERBOSE[24593]: == Parsing '/etc/asterisk/enum.conf': Mar 19 13:11:47 VERBOSE[24593]: == Parsing '/etc/asterisk/enum.conf': Found Mar 19 13:11:47 VERBOSE[24593]: == Manager registered action DBGet Mar 19 13:11:47 VERBOSE[24593]: == Manager registered action DBPut Mar 19 13:11:47 VERBOSE[24593]: == Parsing '/etc/asterisk/enum.conf': Mar 19 13:11:47 VERBOSE[24593]: == Parsing '/etc/asterisk/enum.conf': Found Mar 19 13:11:47 VERBOSE[24593]: Asterisk Ready. Mar 19 13:11:48 DEBUG[24593]: Setting NAT on RTP to 0 Mar 19 13:11:48 DEBUG[24593]: Setting NAT on RTP to 0 Mar 19 13:11:48 DEBUG[24593]: Setting NAT on RTP to 0 Mar 19 13:11:48 DEBUG[24593]: Setting NAT on RTP to 0 Mar 19 13:11:48 DEBUG[24593]: Stopping retransmission on '36451b547e5310c0318280bc1aae4666@10.1.1.48' of Request 102: Found Mar 19 13:11:53 VERBOSE[24593]: Asterisk Ready. Retransmitting #5 (no NAT) to 10.1.1.201:5060: NOTIFY sip:10.1.1.201 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK443017b3 From: "asterisk" ;tag=as30922cd6 To: Contact: Call-ID: 2f8d50b71922bb640e39d1805fb722f4@10.1.1.48 CSeq: 102 NOTIFY User-Agent: Asterisk PBX Event: message-summary Content-Type: application/simple-message-summary Content-Length: 42 Messages-Waiting: no Voice-Message: 0/0 --- Mar 19 13:11:53 VERBOSE[24593]: Retransmitting #5 (no NAT) to 10.1.1.201:5060: NOTIFY sip:10.1.1.201 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK3a2c527a From: "asterisk" ;tag=as3c22a782 To: Contact: Call-ID: 54e121444a19135a008927c64aee94d9@10.1.1.48 CSeq: 102 NOTIFY User-Agent: Asterisk PBX Event: message-summary Content-Type: application/simple-message-summary Content-Length: 42 Messages-Waiting: no Voice-Message: 0/0 --- Mar 19 13:11:53 VERBOSE[24593]: Retransmitting #5 (no NAT) to 10.1.1.202:5060: NOTIFY sip:10.1.1.202 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK02cc9882 From: "asterisk" ;tag=as0c0dd51d To: Contact: Call-ID: 6f925656117f840c361b814c44886428@10.1.1.48 CSeq: 102 NOTIFY User-Agent: Asterisk PBX Event: message-summary Content-Type: application/simple-message-summary Content-Length: 42 Messages-Waiting: no Voice-Message: 0/0 --- Mar 19 13:11:54 WARNING[24593]: Maximum retries exceeded on call 2f8d50b71922bb640e39d1805fb722f4@10.1.1.48 for seqno 102 (Non-critical Request) Mar 19 13:11:54 WARNING[24593]: Maximum retries exceeded on call 54e121444a19135a008927c64aee94d9@10.1.1.48 for seqno 102 (Non-critical Request) Mar 19 13:11:54 WARNING[24593]: Maximum retries exceeded on call 6f925656117f840c361b814c44886428@10.1.1.48 for seqno 102 (Non-critical Request) Mar 19 13:12:00 VERBOSE[24593]: <-- SIP read from 10.1.1.100:5060: INVITE sip:3000@10.1.1.48 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.100:5060;rport;branch=z9hG4bKFA54490F069543C39149D37851B4B143 From: Wilson Chan ;tag=3068364725 To: Contact: Call-ID: D2C51A2F-3593-49C2-B274-43598EB65FB0@10.1.1.100 CSeq: 35515 INVITE Max-Forwards: 70 Content-Type: application/sdp User-Agent: X-Lite release 1103m Content-Length: 293 v=0 o=wilson 181902281 181902291 IN IP4 10.1.1.100 s=X-Lite c=IN IP4 10.1.1.100 t=0 0 m=audio 8000 RTP/AVP 0 8 3 98 97 101 a=rtpmap:0 pcmu/8000 a=rtpmap:8 pcma/8000 a=rtpmap:3 gsm/8000 a=rtpmap:98 iLBC/8000 a=rtpmap:97 speex/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-15 Mar 19 13:12:00 VERBOSE[24593]: --- (11 headers 13 lines)Mar 19 13:12:00 VERBOSE[24593]: --- (11 headers 13 lines)--- Mar 19 13:12:00 DEBUG[24593]: Allocating new SIP call for D2C51A2F-3593-49C2-B274-43598EB65FB0@10.1.1.100 Mar 19 13:12:00 DEBUG[24593]: **** Received INVITE (4) - Command in SIP INVITE Mar 19 13:12:00 VERBOSE[24593]: Using latest request as basis request Mar 19 13:12:00 VERBOSE[24593]: Sending to 10.1.1.100 : 5060 (non-NAT) Mar 19 13:12:00 DEBUG[24593]: Setting NAT on RTP to 0 Mar 19 13:12:00 VERBOSE[24593]: Reliably Transmitting (no NAT) to 10.1.1.100:5060: SIP/2.0 407 Proxy Authentication Required Via: SIP/2.0/UDP 10.1.1.100:5060;branch=z9hG4bKFA54490F069543C39149D37851B4B143 From: Wilson Chan ;tag=3068364725 To: ;tag=as515236d9 Call-ID: D2C51A2F-3593-49C2-B274-43598EB65FB0@10.1.1.100 CSeq: 35515 INVITE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER Contact: Proxy-Authenticate: Digest realm="asterisk", nonce="558d5b43" Content-Length: 0 --- Mar 19 13:12:00 VERBOSE[24593]: Scheduling destruction of call 'D2C51A2F-3593-49C2-B274-43598EB65FB0@10.1.1.100' in 15000 ms Mar 19 13:12:00 VERBOSE[24593]: Found user 'wilson' Mar 19 13:12:00 VERBOSE[24593]: <-- SIP read from 10.1.1.100:5060: ACK sip:3000@10.1.1.48 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.100:5060;rport;branch=z9hG4bKFA54490F069543C39149D37851B4B143 From: Wilson Chan ;tag=3068364725 To: ;tag=as515236d9 Contact: Call-ID: D2C51A2F-3593-49C2-B274-43598EB65FB0@10.1.1.100 CSeq: 35515 ACK Max-Forwards: 70 Content-Length: 0 Mar 19 13:12:00 VERBOSE[24593]: --- (9 headers 0 lines)Mar 19 13:12:00 VERBOSE[24593]: --- (9 headers 0 lines)--- Mar 19 13:12:00 DEBUG[24593]: **** Received ACK (5) - Command in SIP ACK Mar 19 13:12:00 DEBUG[24593]: Stopping retransmission on 'D2C51A2F-3593-49C2-B274-43598EB65FB0@10.1.1.100' of Response 35515: Found Mar 19 13:12:00 VERBOSE[24593]: <-- SIP read from 10.1.1.100:5060: INVITE sip:3000@10.1.1.48 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.100:5060;rport;branch=z9hG4bK001D07F0B29C4AF4878F0BFD14718923 From: Wilson Chan ;tag=3068364725 To: Contact: Call-ID: D2C51A2F-3593-49C2-B274-43598EB65FB0@10.1.1.100 CSeq: 35516 INVITE Proxy-Authorization: Digest username="wilson",realm="asterisk",nonce="558d5b43",response="ddd90075c5be1b49959f57f1503808e0",uri="sip:3000@10.1.1.48" Max-Forwards: 70 Content-Type: application/sdp User-Agent: X-Lite release 1103m Content-Length: 293 v=0 o=wilson 181902281 181902291 IN IP4 10.1.1.100 s=X-Lite c=IN IP4 10.1.1.100 t=0 0 m=audio 8000 RTP/AVP 0 8 3 98 97 101 a=rtpmap:0 pcmu/8000 a=rtpmap:8 pcma/8000 a=rtpmap:3 gsm/8000 a=rtpmap:98 iLBC/8000 a=rtpmap:97 speex/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-15 Mar 19 13:12:00 VERBOSE[24593]: --- (12 headers 13 lines)Mar 19 13:12:00 VERBOSE[24593]: --- (12 headers 13 lines)--- Mar 19 13:12:00 DEBUG[24593]: **** Received INVITE (4) - Command in SIP INVITE Mar 19 13:12:00 VERBOSE[24593]: Using latest request as basis request Mar 19 13:12:00 VERBOSE[24593]: Sending to 10.1.1.100 : 5060 (non-NAT) Mar 19 13:12:00 DEBUG[24593]: Setting NAT on RTP to 0 Mar 19 13:12:00 VERBOSE[24593]: Found user 'wilson' Mar 19 13:12:00 VERBOSE[24593]: Found RTP audio format 0 Mar 19 13:12:00 VERBOSE[24593]: Found RTP audio format 8 Mar 19 13:12:00 VERBOSE[24593]: Found RTP audio format 3 Mar 19 13:12:00 VERBOSE[24593]: Found RTP audio format 98 Mar 19 13:12:00 VERBOSE[24593]: Found RTP audio format 97 Mar 19 13:12:00 VERBOSE[24593]: Found RTP audio format 101 Mar 19 13:12:00 VERBOSE[24593]: Peer audio RTP is at port 10.1.1.100:8000 Mar 19 13:12:00 DEBUG[24593]: Peer audio RTP is at port 10.1.1.100:8000 Mar 19 13:12:00 VERBOSE[24593]: Found description format pcmu Mar 19 13:12:00 VERBOSE[24593]: Found description format pcma Mar 19 13:12:00 VERBOSE[24593]: Found description format gsm Mar 19 13:12:00 VERBOSE[24593]: Found description format iLBC Mar 19 13:12:00 VERBOSE[24593]: Found description format speex Mar 19 13:12:00 VERBOSE[24593]: Found description format telephone-event Mar 19 13:12:00 VERBOSE[24593]: Capabilities: us - 0xe (gsm|ulaw|alaw), peer - audio=0x60e (gsm|ulaw|alaw|speex|ilbc)/video=0x0 (nothing), combined - 0xe (gsm|ulaw|alaw) Mar 19 13:12:00 VERBOSE[24593]: Non-codec capabilities: us - 0x1 (g723), peer - 0x1 (g723), combined - 0x1 (g723) Mar 19 13:12:00 DEBUG[24593]: Check for res for wilson Mar 19 13:12:00 VERBOSE[24593]: Looking for 3000 in from-sip Mar 19 13:12:00 DEBUG[24593]: build_route: Contact hop: Mar 19 13:12:00 VERBOSE[24593]: list_route: hop: Mar 19 13:12:00 VERBOSE[24593]: Transmitting (no NAT) to 10.1.1.100:5060: SIP/2.0 100 Trying Via: SIP/2.0/UDP 10.1.1.100:5060;branch=z9hG4bK001D07F0B29C4AF4878F0BFD14718923 From: Wilson Chan ;tag=3068364725 To: ;tag=as62bd4a12 Call-ID: D2C51A2F-3593-49C2-B274-43598EB65FB0@10.1.1.100 CSeq: 35516 INVITE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER Contact: Content-Length: 0 --- Mar 19 13:12:00 DEBUG[24593]: Changing state for SIP/wilson Mar 19 13:12:00 DEBUG[24593]: Launching 'Dial' Mar 19 13:12:00 VERBOSE[24593]: -- Executing Dial("SIP/wilson-de2a", "SIP/wilson-polycom|20|tT") in new stack Mar 19 13:12:00 DEBUG[24593]: SIMPLE DIAL (NO URL) Mar 19 13:12:00 DEBUG[24593]: Allocating new SIP call for (null) Mar 19 13:12:00 DEBUG[24593]: Setting NAT on RTP to 0 Mar 19 13:12:00 DEBUG[24593]: Not copying variable STACK-from-sip-3000-1. Mar 19 13:12:00 DEBUG[24593]: Not copying variable SIPCALLID. Mar 19 13:12:00 DEBUG[24593]: Not copying variable SIPUSERAGENT. Mar 19 13:12:00 DEBUG[24593]: Not copying variable SIPDOMAIN. Mar 19 13:12:00 DEBUG[24593]: Not copying variable SIPURI. Mar 19 13:12:00 DEBUG[24593]: Outgoing Call for wilson-polycom Mar 19 13:12:00 VERBOSE[24593]: We're at 10.1.1.48 port 14170 Mar 19 13:12:00 VERBOSE[24593]: Answering/Requesting with root capability 0x2 (gsm) Mar 19 13:12:00 VERBOSE[24593]: Answering with capability 0x4 (ulaw) Mar 19 13:12:00 VERBOSE[24593]: Answering with capability 0x8 (alaw) Mar 19 13:12:00 VERBOSE[24593]: Answering with non-codec capability 0x1 (telephone-event) Mar 19 13:12:00 VERBOSE[24593]: 12 headers, 12 lines Mar 19 13:12:00 VERBOSE[24593]: Reliably Transmitting (no NAT) to 10.1.1.200:5060: INVITE sip:wilson-polycom@10.1.1.200:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK287a69e2 From: "Wilson's Computer" ;tag=as2daf3dc1 To: Contact: Call-ID: 4b74d7c54598bc1a79c07fac291ff752@10.1.1.48 CSeq: 102 INVITE User-Agent: Asterisk PBX Date: Sat, 19 Mar 2005 21:12:00 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER Content-Type: application/sdp Content-Length: 257 v=0 o=root 24593 24593 IN IP4 10.1.1.48 s=session c=IN IP4 10.1.1.48 t=0 0 m=audio 14170 RTP/AVP 3 0 8 101 a=rtpmap:3 GSM/8000 a=rtpmap:0 PCMU/8000 a=rtpmap:8 PCMA/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=silenceSupp:off - - - - --- Mar 19 13:12:00 VERBOSE[24593]: -- Called wilson-polycom Mar 19 13:12:00 DEBUG[24593]: Set channel SIP/wilson-polycom-87e7 to read format gsm Mar 19 13:12:00 DEBUG[24593]: Set channel SIP/wilson-de2a to write format gsm Mar 19 13:12:00 DEBUG[24593]: Set channel SIP/wilson-polycom-87e7 to write format ulaw Mar 19 13:12:00 DEBUG[24593]: Set channel SIP/wilson-de2a to read format ulaw Mar 19 13:12:00 VERBOSE[24593]: <-- SIP read from 10.1.1.200:5060: SIP/2.0 100 Trying Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK287a69e2 From: "Wilson's Computer" ;tag=as2daf3dc1 To: ;tag=78A41951-A00C255E CSeq: 102 INVITE Call-ID: 4b74d7c54598bc1a79c07fac291ff752@10.1.1.48 Contact: User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.4.1 Content-Length: 0 Mar 19 13:12:00 VERBOSE[24593]: --- (9 headers 0 lines)Mar 19 13:12:00 VERBOSE[24593]: --- (9 headers 0 lines)--- Mar 19 13:12:00 DEBUG[24593]: (Provisional) Stopping retransmission (but retaining packet) on '4b74d7c54598bc1a79c07fac291ff752@10.1.1.48' Request 102: Found Mar 19 13:12:00 VERBOSE[24593]: <-- SIP read from 10.1.1.200:5060: SIP/2.0 180 Ringing Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK287a69e2 From: "Wilson's Computer" ;tag=as2daf3dc1 To: ;tag=78A41951-A00C255E CSeq: 102 INVITE Call-ID: 4b74d7c54598bc1a79c07fac291ff752@10.1.1.48 Contact: User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.4.1 Allow-Events: talk,hold,conference Content-Length: 0 Mar 19 13:12:00 VERBOSE[24593]: --- (10 headers 0 lines)Mar 19 13:12:00 VERBOSE[24593]: --- (10 headers 0 lines)--- Mar 19 13:12:00 DEBUG[24593]: (Provisional) Stopping retransmission (but retaining packet) on '4b74d7c54598bc1a79c07fac291ff752@10.1.1.48' Request 102: Found Mar 19 13:12:00 DEBUG[24593]: Changing state for SIP/wilson Mar 19 13:12:00 VERBOSE[24593]: -- SIP/wilson-polycom-87e7 is ringing Mar 19 13:12:00 VERBOSE[24593]: Transmitting (no NAT) to 10.1.1.100:5060: SIP/2.0 180 Ringing Via: SIP/2.0/UDP 10.1.1.100:5060;branch=z9hG4bK001D07F0B29C4AF4878F0BFD14718923 From: Wilson Chan ;tag=3068364725 To: ;tag=as62bd4a12 Call-ID: D2C51A2F-3593-49C2-B274-43598EB65FB0@10.1.1.100 CSeq: 35516 INVITE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER Contact: Content-Length: 0 --- Mar 19 13:12:02 VERBOSE[24593]: <-- SIP read from 10.1.1.200:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK287a69e2 From: "Wilson's Computer" ;tag=as2daf3dc1 To: ;tag=78A41951-A00C255E CSeq: 102 INVITE Call-ID: 4b74d7c54598bc1a79c07fac291ff752@10.1.1.48 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.4.1 Content-Type: application/sdp Content-Length: 183 v=0 o=- 1111266718 1111266718 IN IP4 10.1.1.200 s=Polycom IP Phone c=IN IP4 10.1.1.200 t=0 0 m=audio 2248 RTP/AVP 0 101 a=rtpmap:0 PCMU/8000 a=rtpmap:101 telephone-event/8000 Mar 19 13:12:02 VERBOSE[24593]: --- (11 headers 8 lines)Mar 19 13:12:02 VERBOSE[24593]: --- (11 headers 8 lines)--- Mar 19 13:12:02 DEBUG[24593]: Acked pending invite 102 Mar 19 13:12:02 DEBUG[24593]: Stopping retransmission on '4b74d7c54598bc1a79c07fac291ff752@10.1.1.48' of Request 102: Found Mar 19 13:12:02 VERBOSE[24593]: Found RTP audio format 0 Mar 19 13:12:02 VERBOSE[24593]: Found RTP audio format 101 Mar 19 13:12:02 VERBOSE[24593]: Peer audio RTP is at port 10.1.1.200:2248 Mar 19 13:12:02 DEBUG[24593]: Peer audio RTP is at port 10.1.1.200:2248 Mar 19 13:12:02 VERBOSE[24593]: Found description format PCMU Mar 19 13:12:02 VERBOSE[24593]: Found description format telephone-event Mar 19 13:12:02 VERBOSE[24593]: Capabilities: us - 0x8000e (gsm|ulaw|alaw|h263), peer - audio=0x4 (ulaw)/video=0x0 (nothing), combined - 0x4 (ulaw) Mar 19 13:12:02 VERBOSE[24593]: Non-codec capabilities: us - 0x1 (g723), peer - 0x1 (g723), combined - 0x1 (g723) Mar 19 13:12:02 DEBUG[24593]: build_route: Contact hop: Mar 19 13:12:02 VERBOSE[24593]: list_route: hop: Mar 19 13:12:02 VERBOSE[24593]: set_destination: Parsing for address/port to send to Mar 19 13:12:02 VERBOSE[24593]: set_destination: set destination to 10.1.1.200, port 5060 Mar 19 13:12:02 VERBOSE[24593]: Transmitting (no NAT) to 10.1.1.200:5060: ACK sip:wilson-polycom@10.1.1.200:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK2907cbe2 From: "Wilson's Computer" ;tag=as2daf3dc1 To: ;tag=78A41951-A00C255E Contact: Call-ID: 4b74d7c54598bc1a79c07fac291ff752@10.1.1.48 CSeq: 102 ACK User-Agent: Asterisk PBX Content-Length: 0 --- Mar 19 13:12:02 VERBOSE[24593]: -- SIP/wilson-polycom-87e7 answered SIP/wilson-de2a Mar 19 13:12:02 DEBUG[24593]: Set channel SIP/wilson-de2a to read format ulaw Mar 19 13:12:02 DEBUG[24593]: Set channel SIP/wilson-polycom-87e7 to write format ulaw Mar 19 13:12:02 DEBUG[24593]: Set channel SIP/wilson-de2a to write format gsm Mar 19 13:12:02 DEBUG[24593]: Set channel SIP/wilson-polycom-87e7 to read format gsm Mar 19 13:12:02 DEBUG[24593]: sip_answer(SIP/wilson-de2a) Mar 19 13:12:02 VERBOSE[24593]: We're at 10.1.1.48 port 16240 Mar 19 13:12:02 VERBOSE[24593]: Answering with preferred capability 0x2 (gsm) Mar 19 13:12:02 VERBOSE[24593]: Answering with preferred capability 0x4 (ulaw) Mar 19 13:12:02 VERBOSE[24593]: Answering with preferred capability 0x8 (alaw) Mar 19 13:12:02 VERBOSE[24593]: Answering with non-codec capability 0x1 (telephone-event) Mar 19 13:12:02 VERBOSE[24593]: Reliably Transmitting (no NAT) to 10.1.1.100:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.100:5060;branch=z9hG4bK001D07F0B29C4AF4878F0BFD14718923 From: Wilson Chan ;tag=3068364725 To: ;tag=as62bd4a12 Call-ID: D2C51A2F-3593-49C2-B274-43598EB65FB0@10.1.1.100 CSeq: 35516 INVITE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER Contact: Content-Type: application/sdp Content-Length: 257 v=0 o=root 24593 24593 IN IP4 10.1.1.48 s=session c=IN IP4 10.1.1.48 t=0 0 m=audio 16240 RTP/AVP 3 0 8 101 a=rtpmap:3 GSM/8000 a=rtpmap:0 PCMU/8000 a=rtpmap:8 PCMA/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=silenceSupp:off - - - - --- Mar 19 13:12:02 VERBOSE[24593]: -- Attempting native bridge of SIP/wilson-de2a and SIP/wilson-polycom-87e7 Mar 19 13:12:02 VERBOSE[24593]: <-- SIP read from 10.1.1.100:5060: ACK sip:3000@10.1.1.48 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.100:5060;rport;branch=z9hG4bK7C0640A17C134B608F1D3E164A90607B From: Wilson Chan ;tag=3068364725 To: ;tag=as62bd4a12 Contact: Call-ID: D2C51A2F-3593-49C2-B274-43598EB65FB0@10.1.1.100 CSeq: 35516 ACK Max-Forwards: 70 Content-Length: 0 Mar 19 13:12:02 VERBOSE[24593]: --- (9 headers 0 lines)Mar 19 13:12:02 VERBOSE[24593]: --- (9 headers 0 lines)--- Mar 19 13:12:02 DEBUG[24593]: **** Received ACK (5) - Command in SIP ACK Mar 19 13:12:02 DEBUG[24593]: Stopping retransmission on 'D2C51A2F-3593-49C2-B274-43598EB65FB0@10.1.1.100' of Response 35516: Found Mar 19 13:12:02 DEBUG[24593]: Ooh, format changed from unknown to ulaw Mar 19 13:12:02 DEBUG[24593]: Got RTCP report of 84 bytes Mar 19 13:12:02 DEBUG[24593]: Ooh, format changed from unknown to gsm Mar 19 13:12:02 DEBUG[24593]: Got RTCP report of 114 bytes Mar 19 13:12:03 DEBUG[24593]: Auto destroying call '2f8d50b71922bb640e39d1805fb722f4@10.1.1.48' Mar 19 13:12:03 VERBOSE[24593]: Destroying call '2f8d50b71922bb640e39d1805fb722f4@10.1.1.48' Mar 19 13:12:03 DEBUG[24593]: Auto destroying call '54e121444a19135a008927c64aee94d9@10.1.1.48' Mar 19 13:12:03 VERBOSE[24593]: Destroying call '54e121444a19135a008927c64aee94d9@10.1.1.48' Mar 19 13:12:03 DEBUG[24593]: Auto destroying call '6f925656117f840c361b814c44886428@10.1.1.48' Mar 19 13:12:03 VERBOSE[24593]: Destroying call '6f925656117f840c361b814c44886428@10.1.1.48' Mar 19 13:12:04 DEBUG[24593]: Got RTCP report of 76 bytes Mar 19 13:12:05 VERBOSE[24593]: <-- SIP read from 10.1.1.200:5060: BYE sip:3002@10.1.1.48 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.200:5060;branch=z9hG4bK555eb9f46E3E6A47 From: ;tag=78A41951-A00C255E To: "Wilson's Computer" ;tag=as2daf3dc1 CSeq: 1 BYE Call-ID: 4b74d7c54598bc1a79c07fac291ff752@10.1.1.48 Contact: User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.4.1 Max-Forwards: 70 Content-Length: 0 Mar 19 13:12:05 VERBOSE[24593]: --- (10 headers 0 lines)Mar 19 13:12:05 VERBOSE[24593]: --- (10 headers 0 lines)--- Mar 19 13:12:05 DEBUG[24593]: **** Received BYE (7) - Command in SIP BYE Mar 19 13:12:05 DEBUG[24593]: Ignoring too old SIP packet packet 1 (expecting >= 102) Mar 19 13:12:06 VERBOSE[24593]: <-- SIP read from 10.1.1.200:5060: BYE sip:3002@10.1.1.48 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.200:5060;branch=z9hG4bK555eb9f46E3E6A47 From: ;tag=78A41951-A00C255E To: "Wilson's Computer" ;tag=as2daf3dc1 CSeq: 1 BYE Call-ID: 4b74d7c54598bc1a79c07fac291ff752@10.1.1.48 Contact: User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.4.1 Max-Forwards: 70 Content-Length: 0 Mar 19 13:12:06 VERBOSE[24593]: --- (10 headers 0 lines)Mar 19 13:12:06 VERBOSE[24593]: --- (10 headers 0 lines)--- Mar 19 13:12:06 DEBUG[24593]: **** Received BYE (7) - Command in SIP BYE Mar 19 13:12:06 DEBUG[24593]: Ignoring too old SIP packet packet 1 (expecting >= 102) Mar 19 13:12:06 VERBOSE[24593]: <-- SIP read from 10.1.1.200:5060: BYE sip:3002@10.1.1.48 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.200:5060;branch=z9hG4bK555eb9f46E3E6A47 From: ;tag=78A41951-A00C255E To: "Wilson's Computer" ;tag=as2daf3dc1 CSeq: 1 BYE Call-ID: 4b74d7c54598bc1a79c07fac291ff752@10.1.1.48 Contact: User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.4.1 Max-Forwards: 70 Content-Length: 0 Mar 19 13:12:06 VERBOSE[24593]: --- (10 headers 0 lines)Mar 19 13:12:06 VERBOSE[24593]: --- (10 headers 0 lines)--- Mar 19 13:12:06 DEBUG[24593]: **** Received BYE (7) - Command in SIP BYE Mar 19 13:12:06 DEBUG[24593]: Ignoring too old SIP packet packet 1 (expecting >= 102) Mar 19 13:12:07 DEBUG[24593]: Got RTCP report of 84 bytes Mar 19 13:12:07 VERBOSE[24593]: <-- SIP read from 10.1.1.200:5060: BYE sip:3002@10.1.1.48 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.200:5060;branch=z9hG4bK555eb9f46E3E6A47 From: ;tag=78A41951-A00C255E To: "Wilson's Computer" ;tag=as2daf3dc1 CSeq: 1 BYE Call-ID: 4b74d7c54598bc1a79c07fac291ff752@10.1.1.48 Contact: User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.4.1 Max-Forwards: 70 Content-Length: 0 Mar 19 13:12:07 VERBOSE[24593]: --- (10 headers 0 lines)Mar 19 13:12:07 VERBOSE[24593]: --- (10 headers 0 lines)--- Mar 19 13:12:07 DEBUG[24593]: **** Received BYE (7) - Command in SIP BYE Mar 19 13:12:07 DEBUG[24593]: Ignoring too old SIP packet packet 1 (expecting >= 102) Mar 19 13:12:08 VERBOSE[24593]: <-- SIP read from 10.1.1.100:5060: BYE sip:3000@10.1.1.48 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.100:5060;rport;branch=z9hG4bK699165232BB64B2A8D2AF6087EB0FA75 From: Wilson Chan ;tag=3068364725 To: ;tag=as62bd4a12 Contact: Call-ID: D2C51A2F-3593-49C2-B274-43598EB65FB0@10.1.1.100 CSeq: 35517 BYE Max-Forwards: 70 User-Agent: X-Lite release 1103m Content-Length: 0 Mar 19 13:12:08 VERBOSE[24593]: --- (10 headers 0 lines)Mar 19 13:12:08 VERBOSE[24593]: --- (10 headers 0 lines)--- Mar 19 13:12:08 DEBUG[24593]: **** Received BYE (7) - Command in SIP BYE Mar 19 13:12:08 VERBOSE[24593]: Sending to 10.1.1.100 : 5060 (non-NAT) Mar 19 13:12:08 VERBOSE[24593]: Transmitting (no NAT) to 10.1.1.100:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.100:5060;branch=z9hG4bK699165232BB64B2A8D2AF6087EB0FA75 From: Wilson Chan ;tag=3068364725 To: ;tag=as62bd4a12 Call-ID: D2C51A2F-3593-49C2-B274-43598EB65FB0@10.1.1.100 CSeq: 35517 BYE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER Contact: Content-Length: 0 --- Mar 19 13:12:08 DEBUG[24593]: Didn't get a frame from channel: SIP/wilson-de2a Mar 19 13:12:08 DEBUG[24593]: Bridge stops bridging channels SIP/wilson-de2a and SIP/wilson-polycom-87e7 Mar 19 13:12:08 DEBUG[24593]: Hanging up channel 'SIP/wilson-polycom-87e7' Mar 19 13:12:08 DEBUG[24593]: sip_hangup(SIP/wilson-polycom-87e7) Mar 19 13:12:08 DEBUG[24593]: update_user_counter(wilson-polycom) - decrement outUse counter Mar 19 13:12:08 VERBOSE[24593]: set_destination: Parsing for address/port to send to Mar 19 13:12:08 VERBOSE[24593]: set_destination: set destination to 10.1.1.200, port 5060 Mar 19 13:12:08 VERBOSE[24593]: Reliably Transmitting (no NAT) to 10.1.1.200:5060: BYE sip:wilson-polycom@10.1.1.200:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK7d59305b From: "Wilson's Computer" ;tag=as2daf3dc1 To: ;tag=78A41951-A00C255E Contact: Call-ID: 4b74d7c54598bc1a79c07fac291ff752@10.1.1.48 CSeq: 103 BYE User-Agent: Asterisk PBX Content-Length: 0 --- Mar 19 13:12:08 DEBUG[24593]: Changing state for SIP/wilson Mar 19 13:12:08 DEBUG[24593]: Exiting with DIALSTATUS=ANSWER. Mar 19 13:12:08 DEBUG[24593]: Spawn extension (from-sip,3000,1) exited non-zero on 'SIP/wilson-de2a' Mar 19 13:12:08 DEBUG[24593]: Hanging up channel 'SIP/wilson-de2a' Mar 19 13:12:08 DEBUG[24593]: sip_hangup(SIP/wilson-de2a) Mar 19 13:12:08 DEBUG[24593]: update_user_counter(wilson) - decrement inUse counter Mar 19 13:12:08 DEBUG[24593]: Changing state for SIP/wilson Mar 19 13:12:09 VERBOSE[24593]: <-- SIP read from 10.1.1.200:5060: SIP/2.0 500 Internal Server Error Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK7d59305b From: "Wilson's Computer" ;tag=as2daf3dc1 To: ;tag=78A41951-A00C255E CSeq: 103 BYE Call-ID: 4b74d7c54598bc1a79c07fac291ff752@10.1.1.48 Contact: User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.4.1 Content-Length: 0 Mar 19 13:12:09 VERBOSE[24593]: --- (9 headers 0 lines)Mar 19 13:12:09 VERBOSE[24593]: --- (9 headers 0 lines)--- Mar 19 13:12:09 DEBUG[24593]: Stopping retransmission on '4b74d7c54598bc1a79c07fac291ff752@10.1.1.48' of Request 103: Found Mar 19 13:12:09 VERBOSE[24593]: -- Got SIP response 500 "Internal Server Error" back from 10.1.1.200 Mar 19 13:12:09 VERBOSE[24593]: Destroying call '4b74d7c54598bc1a79c07fac291ff752@10.1.1.48' Mar 19 13:12:09 VERBOSE[24593]: Destroying call 'D2C51A2F-3593-49C2-B274-43598EB65FB0@10.1.1.100' Mar 19 13:12:09 VERBOSE[24593]: <-- SIP read from 10.1.1.200:5060: BYE sip:3002@10.1.1.48 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.200:5060;branch=z9hG4bK555eb9f46E3E6A47 From: ;tag=78A41951-A00C255E To: "Wilson's Computer" ;tag=as2daf3dc1 CSeq: 1 BYE Call-ID: 4b74d7c54598bc1a79c07fac291ff752@10.1.1.48 Contact: User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.4.1 Max-Forwards: 70 Content-Length: 0 Mar 19 13:12:09 VERBOSE[24593]: --- (10 headers 0 lines)Mar 19 13:12:09 VERBOSE[24593]: --- (10 headers 0 lines)--- Mar 19 13:12:09 DEBUG[24593]: Allocating new SIP call for 4b74d7c54598bc1a79c07fac291ff752@10.1.1.48 Mar 19 13:12:09 DEBUG[24593]: **** Received BYE (7) - Command in SIP BYE Mar 19 13:12:09 VERBOSE[24593]: Sending to 10.1.1.200 : 5060 (non-NAT) Mar 19 13:12:09 VERBOSE[24593]: Transmitting (no NAT) to 10.1.1.200:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.200:5060;branch=z9hG4bK555eb9f46E3E6A47 From: ;tag=78A41951-A00C255E To: "Wilson's Computer" ;tag=as2daf3dc1 Call-ID: 4b74d7c54598bc1a79c07fac291ff752@10.1.1.48 CSeq: 1 BYE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER Contact: Content-Length: 0 --- Mar 19 13:12:09 VERBOSE[24593]: Destroying call '4b74d7c54598bc1a79c07fac291ff752@10.1.1.48'