[Oct 27 18:11:50] VERBOSE[1924] config.c:   == Parsing '/etc/asterisk/logger.conf': [Oct 27 18:11:50] VERBOSE[1924] config.c:   == Found
[Oct 27 18:11:50] VERBOSE[1924] config.c:   == Parsing '/etc/asterisk/asterisk.conf': [Oct 27 18:11:50] DEBUG[1924] config.c: Parsing /etc/asterisk/asterisk.conf
[Oct 27 18:11:50] VERBOSE[1924] config.c:   == Found
[Oct 27 18:11:50] DEBUG[1924] xmldoc.c: gl_pathc 3
[Oct 27 18:11:50] VERBOSE[1924] manager.c:   == Manager registered action DataGet
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  Asterisk Dynamic Loader Starting:
[Oct 27 18:11:50] VERBOSE[1924] config.c:   == Parsing '/etc/asterisk/modules.conf': [Oct 27 18:11:50] DEBUG[1924] config.c: Parsing /etc/asterisk/modules.conf
[Oct 27 18:11:50] VERBOSE[1924] config.c:   == Found
[Oct 27 18:11:50] NOTICE[1924] loader.c: 1 modules will be loaded.
[Oct 27 18:11:50] VERBOSE[1924] config.c:   == Parsing '/etc/asterisk/res_mysql.conf': [Oct 27 18:11:50] DEBUG[1924] config.c: Parsing /etc/asterisk/res_mysql.conf
[Oct 27 18:11:50] VERBOSE[1924] config.c:   == Found
[Oct 27 18:11:50] WARNING[1924] res_config_mysql.c: MySQL realtime: no requirements setting found, using 'warn' as default.
[Oct 27 18:11:50] DEBUG[1924] res_config_mysql.c: MySQL RealTime host: localhost
[Oct 27 18:11:50] DEBUG[1924] res_config_mysql.c: MySQL RealTime port: 3306
[Oct 27 18:11:50] DEBUG[1924] res_config_mysql.c: MySQL RealTime database name: asterisk
[Oct 27 18:11:50] DEBUG[1924] res_config_mysql.c: MySQL RealTime user: asterisk
[Oct 27 18:11:50] DEBUG[1924] res_config_mysql.c: MySQL RealTime password: asterisk
[Oct 27 18:11:50] DEBUG[1924] res_config_mysql.c: MySQL RealTime charset: 
[Oct 27 18:11:50] NOTICE[1924] config.c: Registered Config Engine mysql
[Oct 27 18:11:50] VERBOSE[1924] res_config_mysql.c:   == MySQL RealTime driver loaded.
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  res_config_mysql.so => (MySQL RealTime Configuration Driver)
[Oct 27 18:11:50] VERBOSE[1924] manager.c:   == Manager registered action Ping
[Oct 27 18:11:50] VERBOSE[1924] manager.c:   == Manager registered action Events
[Oct 27 18:11:50] VERBOSE[1924] manager.c:   == Manager registered action Logoff
[Oct 27 18:11:50] VERBOSE[1924] manager.c:   == Manager registered action Login
[Oct 27 18:11:50] VERBOSE[1924] manager.c:   == Manager registered action Challenge
[Oct 27 18:11:50] VERBOSE[1924] manager.c:   == Manager registered action Hangup
[Oct 27 18:11:50] VERBOSE[1924] manager.c:   == Manager registered action Status
[Oct 27 18:11:50] VERBOSE[1924] manager.c:   == Manager registered action Setvar
[Oct 27 18:11:50] VERBOSE[1924] manager.c:   == Manager registered action Getvar
[Oct 27 18:11:50] VERBOSE[1924] manager.c:   == Manager registered action GetConfig
[Oct 27 18:11:50] VERBOSE[1924] manager.c:   == Manager registered action GetConfigJSON
[Oct 27 18:11:50] VERBOSE[1924] manager.c:   == Manager registered action UpdateConfig
[Oct 27 18:11:50] VERBOSE[1924] manager.c:   == Manager registered action CreateConfig
[Oct 27 18:11:50] VERBOSE[1924] manager.c:   == Manager registered action ListCategories
[Oct 27 18:11:50] VERBOSE[1924] manager.c:   == Manager registered action Redirect
[Oct 27 18:11:50] VERBOSE[1924] manager.c:   == Manager registered action Atxfer
[Oct 27 18:11:50] VERBOSE[1924] manager.c:   == Manager registered action Originate
[Oct 27 18:11:50] VERBOSE[1924] manager.c:   == Manager registered action Command
[Oct 27 18:11:50] VERBOSE[1924] manager.c:   == Manager registered action ExtensionState
[Oct 27 18:11:50] VERBOSE[1924] manager.c:   == Manager registered action AbsoluteTimeout
[Oct 27 18:11:50] VERBOSE[1924] manager.c:   == Manager registered action MailboxStatus
[Oct 27 18:11:50] VERBOSE[1924] manager.c:   == Manager registered action MailboxCount
[Oct 27 18:11:50] VERBOSE[1924] manager.c:   == Manager registered action ListCommands
[Oct 27 18:11:50] VERBOSE[1924] manager.c:   == Manager registered action SendText
[Oct 27 18:11:50] VERBOSE[1924] manager.c:   == Manager registered action UserEvent
[Oct 27 18:11:50] VERBOSE[1924] manager.c:   == Manager registered action WaitEvent
[Oct 27 18:11:50] VERBOSE[1924] manager.c:   == Manager registered action CoreSettings
[Oct 27 18:11:50] VERBOSE[1924] manager.c:   == Manager registered action CoreStatus
[Oct 27 18:11:50] VERBOSE[1924] manager.c:   == Manager registered action Reload
[Oct 27 18:11:50] VERBOSE[1924] manager.c:   == Manager registered action CoreShowChannels
[Oct 27 18:11:50] VERBOSE[1924] manager.c:   == Manager registered action ModuleLoad
[Oct 27 18:11:50] VERBOSE[1924] manager.c:   == Manager registered action ModuleCheck
[Oct 27 18:11:50] VERBOSE[1924] manager.c:   == Manager registered action AOCMessage
[Oct 27 18:11:50] VERBOSE[1924] manager.c:   == Manager registered action HangupAll
[Oct 27 18:11:50] VERBOSE[1924] config.c:   == Parsing '/etc/asterisk/manager.conf': [Oct 27 18:11:50] DEBUG[1924] config.c: Parsing /etc/asterisk/manager.conf
[Oct 27 18:11:50] VERBOSE[1924] config.c:   == Found
[Oct 27 18:11:50] VERBOSE[1924] config.c:   == Parsing '/etc/asterisk/cdr.conf': [Oct 27 18:11:50] DEBUG[1924] config.c: Parsing /etc/asterisk/cdr.conf
[Oct 27 18:11:50] VERBOSE[1924] config.c:   == Found
[Oct 27 18:11:50] NOTICE[1924] cdr.c: CDR simple logging enabled.
[Oct 27 18:11:50] VERBOSE[1924] cel.c:     -- CEL logging disabled.
[Oct 27 18:11:50] VERBOSE[1924] dsp.c:        > Can't find dsp config file dsp.conf. Assuming default silencethreshold of 256.
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:  Asterisk PBX Core Initializing
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:  Registering builtin applications:
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'EXCEPTION'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'TESTTIME'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:  [Answer]
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'Answer'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:  [BackGround]
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'BackGround'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:  [Busy]
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'Busy'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:  [Congestion]
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'Congestion'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:  [ExecIfTime]
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'ExecIfTime'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:  [Goto]
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'Goto'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:  [GotoIf]
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'GotoIf'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:  [GotoIfTime]
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'GotoIfTime'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:  [ImportVar]
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'ImportVar'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:  [Hangup]
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'Hangup'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:  [Incomplete]
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'Incomplete'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:  [NoOp]
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'NoOp'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:  [Proceeding]
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'Proceeding'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:  [Progress]
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'Progress'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:  [RaiseException]
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'RaiseException'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:  [ResetCDR]
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'ResetCDR'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:  [Ringing]
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'Ringing'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:  [SayAlpha]
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'SayAlpha'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:  [SayDigits]
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'SayDigits'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:  [SayNumber]
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'SayNumber'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:  [SayPhonetic]
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'SayPhonetic'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:  [Set]
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'Set'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:  [MSet]
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'MSet'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:  [SetAMAFlags]
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'SetAMAFlags'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:  [Wait]
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'Wait'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:  [WaitExten]
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'WaitExten'
[Oct 27 18:11:50] VERBOSE[1924] manager.c:   == Manager registered action ShowDialPlan
[Oct 27 18:11:50] VERBOSE[1924] config.c:   == Parsing '/etc/asterisk/indications.conf': [Oct 27 18:11:50] DEBUG[1924] config.c: Parsing /etc/asterisk/indications.conf
[Oct 27 18:11:50] VERBOSE[1924] config.c:   == Found
[Oct 27 18:11:50] VERBOSE[1924] indications.c:     -- Registered indication country 'ru'
[Oct 27 18:11:50] VERBOSE[1924] indications.c:     -- Registered indication country 'us'
[Oct 27 18:11:50] VERBOSE[1924] indications.c:     -- Setting default indication country to 'ru'
[Oct 27 18:11:50] DEBUG[1924] features.c: Building parking lot default
[Oct 27 18:11:50] DEBUG[1924] features.c: Multiparking: default refcount now 1
[Oct 27 18:11:50] DEBUG[1924] features.c: Configuration of default default parking lot done.
[Oct 27 18:11:50] DEBUG[1924] features.c: Multiparking: default refcount now 2
[Oct 27 18:11:50] VERBOSE[1924] config.c:   == Parsing '/etc/asterisk/features.conf': [Oct 27 18:11:50] DEBUG[1924] config.c: Parsing /etc/asterisk/features.conf
[Oct 27 18:11:50] VERBOSE[1924] config.c:   == Found
[Oct 27 18:11:50] DEBUG[1924] features.c: Found Parking lot: default
[Oct 27 18:11:50] DEBUG[1924] features.c: Building parking lot default
[Oct 27 18:11:50] DEBUG[1924] features.c: Multiparking: default refcount now 2
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Registered context 'parkedcalls'(0x84e6450) in table 0x84e6680 registrar: features
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Registered extension context 'parkedcalls'; registrar: features
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension '700' priority 1 to parkedcalls (0x84e6450)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension '700' priority 1 to parkedcalls
[Oct 27 18:11:50] DEBUG[1924] features.c: Notification of state change to metermaids 700@parkedcalls
 to state 'In use'[Oct 27 18:11:50] DEBUG[1924] devicestate.c: device 'park:700@parkedcalls' state '2'
[Oct 27 18:11:50] DEBUG[1924] features.c: Parking lot default now open for business. (parkpos 701-750)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'Bridge'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'ParkedCall'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'Park'
[Oct 27 18:11:50] VERBOSE[1924] manager.c:   == Manager registered action ParkedCalls
[Oct 27 18:11:50] VERBOSE[1924] manager.c:   == Manager registered action Park
[Oct 27 18:11:50] VERBOSE[1924] manager.c:   == Manager registered action Bridge
[Oct 27 18:11:50] VERBOSE[1924] manager.c:   == Manager registered action DBGet
[Oct 27 18:11:50] VERBOSE[1924] manager.c:   == Manager registered action DBPut
[Oct 27 18:11:50] VERBOSE[1924] manager.c:   == Manager registered action DBDel
[Oct 27 18:11:50] VERBOSE[1924] manager.c:   == Manager registered action DBDelTree
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'CallCompletionRequest'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'CallCompletionCancel'
[Oct 27 18:11:50] DEBUG[1924] logger.c: Registered dynamic logger level 'CC' with index 16.
[Oct 27 18:11:50] VERBOSE[1924] config.c:   == Parsing '/etc/asterisk/ccss.conf': [Oct 27 18:11:50] DEBUG[1924] config.c: Parsing /etc/asterisk/ccss.conf
[Oct 27 18:11:50] VERBOSE[1924] config.c:   == Found
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  Asterisk Dynamic Loader Starting:
[Oct 27 18:11:50] VERBOSE[1924] config.c:   == Parsing '/etc/asterisk/modules.conf': [Oct 27 18:11:50] DEBUG[1924] config.c: Parsing /etc/asterisk/modules.conf
[Oct 27 18:11:50] VERBOSE[1924] config.c:   == Found
[Oct 27 18:11:50] NOTICE[1924] loader.c: 107 modules will be loaded.
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  res_crypto.so => (Cryptographic Digital Signatures)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'Monitor'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'StopMonitor'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'ChangeMonitor'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'PauseMonitor'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'UnpauseMonitor'
[Oct 27 18:11:50] VERBOSE[1924] manager.c:   == Manager registered action Monitor
[Oct 27 18:11:50] VERBOSE[1924] manager.c:   == Manager registered action StopMonitor
[Oct 27 18:11:50] VERBOSE[1924] manager.c:   == Manager registered action ChangeMonitor
[Oct 27 18:11:50] VERBOSE[1924] manager.c:   == Manager registered action PauseMonitor
[Oct 27 18:11:50] VERBOSE[1924] manager.c:   == Manager registered action UnpauseMonitor
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  res_monitor.so => (Call Monitoring Resource)
[Oct 27 18:11:50] VERBOSE[1924] res_agi.c:   == AGI Command 'answer' registered
[Oct 27 18:11:50] VERBOSE[1924] res_agi.c:   == AGI Command 'asyncagi break' registered
[Oct 27 18:11:50] VERBOSE[1924] res_agi.c:   == AGI Command 'channel status' registered
[Oct 27 18:11:50] VERBOSE[1924] res_agi.c:   == AGI Command 'database del' registered
[Oct 27 18:11:50] VERBOSE[1924] res_agi.c:   == AGI Command 'database deltree' registered
[Oct 27 18:11:50] VERBOSE[1924] res_agi.c:   == AGI Command 'database get' registered
[Oct 27 18:11:50] VERBOSE[1924] res_agi.c:   == AGI Command 'database put' registered
[Oct 27 18:11:50] VERBOSE[1924] res_agi.c:   == AGI Command 'exec' registered
[Oct 27 18:11:50] VERBOSE[1924] res_agi.c:   == AGI Command 'get data' registered
[Oct 27 18:11:50] VERBOSE[1924] res_agi.c:   == AGI Command 'get full variable' registered
[Oct 27 18:11:50] VERBOSE[1924] res_agi.c:   == AGI Command 'get option' registered
[Oct 27 18:11:50] VERBOSE[1924] res_agi.c:   == AGI Command 'get variable' registered
[Oct 27 18:11:50] VERBOSE[1924] res_agi.c:   == AGI Command 'hangup' registered
[Oct 27 18:11:50] VERBOSE[1924] res_agi.c:   == AGI Command 'noop' registered
[Oct 27 18:11:50] VERBOSE[1924] res_agi.c:   == AGI Command 'receive char' registered
[Oct 27 18:11:50] VERBOSE[1924] res_agi.c:   == AGI Command 'receive text' registered
[Oct 27 18:11:50] VERBOSE[1924] res_agi.c:   == AGI Command 'record file' registered
[Oct 27 18:11:50] VERBOSE[1924] res_agi.c:   == AGI Command 'say alpha' registered
[Oct 27 18:11:50] VERBOSE[1924] res_agi.c:   == AGI Command 'say digits' registered
[Oct 27 18:11:50] VERBOSE[1924] res_agi.c:   == AGI Command 'say number' registered
[Oct 27 18:11:50] VERBOSE[1924] res_agi.c:   == AGI Command 'say phonetic' registered
[Oct 27 18:11:50] VERBOSE[1924] res_agi.c:   == AGI Command 'say date' registered
[Oct 27 18:11:50] VERBOSE[1924] res_agi.c:   == AGI Command 'say time' registered
[Oct 27 18:11:50] VERBOSE[1924] res_agi.c:   == AGI Command 'say datetime' registered
[Oct 27 18:11:50] VERBOSE[1924] res_agi.c:   == AGI Command 'send image' registered
[Oct 27 18:11:50] VERBOSE[1924] res_agi.c:   == AGI Command 'send text' registered
[Oct 27 18:11:50] VERBOSE[1924] res_agi.c:   == AGI Command 'set autohangup' registered
[Oct 27 18:11:50] VERBOSE[1924] res_agi.c:   == AGI Command 'set callerid' registered
[Oct 27 18:11:50] VERBOSE[1924] res_agi.c:   == AGI Command 'set context' registered
[Oct 27 18:11:50] VERBOSE[1924] res_agi.c:   == AGI Command 'set extension' registered
[Oct 27 18:11:50] VERBOSE[1924] res_agi.c:   == AGI Command 'set music' registered
[Oct 27 18:11:50] VERBOSE[1924] res_agi.c:   == AGI Command 'set priority' registered
[Oct 27 18:11:50] VERBOSE[1924] res_agi.c:   == AGI Command 'set variable' registered
[Oct 27 18:11:50] VERBOSE[1924] res_agi.c:   == AGI Command 'stream file' registered
[Oct 27 18:11:50] VERBOSE[1924] res_agi.c:   == AGI Command 'control stream file' registered
[Oct 27 18:11:50] VERBOSE[1924] res_agi.c:   == AGI Command 'tdd mode' registered
[Oct 27 18:11:50] VERBOSE[1924] res_agi.c:   == AGI Command 'verbose' registered
[Oct 27 18:11:50] VERBOSE[1924] res_agi.c:   == AGI Command 'wait for digit' registered
[Oct 27 18:11:50] VERBOSE[1924] res_agi.c:   == AGI Command 'speech create' registered
[Oct 27 18:11:50] VERBOSE[1924] res_agi.c:   == AGI Command 'speech set' registered
[Oct 27 18:11:50] VERBOSE[1924] res_agi.c:   == AGI Command 'speech destroy' registered
[Oct 27 18:11:50] VERBOSE[1924] res_agi.c:   == AGI Command 'speech load grammar' registered
[Oct 27 18:11:50] VERBOSE[1924] res_agi.c:   == AGI Command 'speech unload grammar' registered
[Oct 27 18:11:50] VERBOSE[1924] res_agi.c:   == AGI Command 'speech activate grammar' registered
[Oct 27 18:11:50] VERBOSE[1924] res_agi.c:   == AGI Command 'speech deactivate grammar' registered
[Oct 27 18:11:50] VERBOSE[1924] res_agi.c:   == AGI Command 'speech recognize' registered
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'DeadAGI'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'EAGI'
[Oct 27 18:11:50] VERBOSE[1924] manager.c:   == Manager registered action AGI
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'AGI'
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  res_agi.so => (Asterisk Gateway Interface (AGI))
[Oct 27 18:11:50] VERBOSE[1924] config.c:   == Parsing '/etc/asterisk/musiconhold.conf': [Oct 27 18:11:50] DEBUG[1924] config.c: Parsing /etc/asterisk/musiconhold.conf
[Oct 27 18:11:50] VERBOSE[1924] config.c:   == Found
[Oct 27 18:11:50] DEBUG[1924] res_musiconhold.c: Scanning '/var/lib/asterisk/moh' for files for class 'default'
[Oct 27 18:11:50] VERBOSE[1924] res_musiconhold.c:     -- Files not found in moh for moh class:default
[Oct 27 18:11:50] DEBUG[1924] res_musiconhold.c: Destroying MOH class 'default'
[Oct 27 18:11:50] DEBUG[1924] res_musiconhold.c: Scanning '/var/lib/asterisk/hold' for files for class 'hold'
[Oct 27 18:11:50] DEBUG[1924] res_musiconhold.c: Scanning '/var/lib/asterisk/speak' for files for class 'speak'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'MusicOnHold'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'WaitMusicOnHold'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'SetMusicOnHold'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'StartMusicOnHold'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'StopMusicOnHold'
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  res_musiconhold.so => (Music On Hold Resource)
[Oct 27 18:11:50] VERBOSE[1924] rtp_engine.c:   == Registered RTP engine 'asterisk'
[Oct 27 18:11:50] VERBOSE[1924] config.c:   == Parsing '/etc/asterisk/rtp.conf': [Oct 27 18:11:50] DEBUG[1924] config.c: Parsing /etc/asterisk/rtp.conf
[Oct 27 18:11:50] VERBOSE[1924] config.c:   == Found
[Oct 27 18:11:50] VERBOSE[1924] res_rtp_asterisk.c:   == RTP Allocating from port range 10000 -> 20000
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  res_rtp_asterisk.so => (Asterisk RTP Stack)
[Oct 27 18:11:50] VERBOSE[1924] rtp_engine.c:   == Registered RTP engine 'multicast'
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  res_rtp_multicast.so => (Multicast RTP Engine)
[Oct 27 18:11:50] DEBUG[1924] channel.c: Registered handler for 'Bridge' (Bridge Interaction Channel)
[Oct 27 18:11:50] VERBOSE[1924] channel.c:   == Registered channel type 'Bridge' (Bridge Interaction Channel)
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  chan_bridge.so => (Bridge Interaction Channel)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'DAHDISendKeypadFacility'
[Oct 27 18:11:50] VERBOSE[1924] config.c:   == Parsing '/etc/asterisk/chan_dahdi.conf': [Oct 27 18:11:50] DEBUG[1924] config.c: Parsing /etc/asterisk/chan_dahdi.conf
[Oct 27 18:11:50] VERBOSE[1924] config.c:   == Found
[Oct 27 18:11:50] VERBOSE[1924] chan_dahdi.c:     -- Automatically generated pseudo channel
[Oct 27 18:11:50] DEBUG[1924] channel.c: Registered handler for 'DAHDI' (DAHDI Telephony Driver w/PRI & SS7)
[Oct 27 18:11:50] VERBOSE[1924] channel.c:   == Registered channel type 'DAHDI' (DAHDI Telephony Driver w/PRI & SS7)
[Oct 27 18:11:50] VERBOSE[1924] manager.c:   == Manager registered action DAHDITransfer
[Oct 27 18:11:50] VERBOSE[1924] manager.c:   == Manager registered action DAHDIHangup
[Oct 27 18:11:50] VERBOSE[1924] manager.c:   == Manager registered action DAHDIDialOffhook
[Oct 27 18:11:50] VERBOSE[1924] manager.c:   == Manager registered action DAHDIDNDon
[Oct 27 18:11:50] VERBOSE[1924] manager.c:   == Manager registered action DAHDIDNDoff
[Oct 27 18:11:50] VERBOSE[1924] manager.c:   == Manager registered action DAHDIShowChannels
[Oct 27 18:11:50] VERBOSE[1924] manager.c:   == Manager registered action DAHDIRestart
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  chan_dahdi.so => (DAHDI Telephony Driver w/PRI & SS7)
[Oct 27 18:11:50] DEBUG[1924] channel.c: Registered handler for 'Local' (Local Proxy Channel Driver)
[Oct 27 18:11:50] VERBOSE[1924] channel.c:   == Registered channel type 'Local' (Local Proxy Channel Driver)
[Oct 27 18:11:50] VERBOSE[1924] manager.c:   == Manager registered action LocalOptimizeAway
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  chan_local.so => (Local Proxy Channel (Note: used internally by other modules))
[Oct 27 18:11:50] VERBOSE[1924] chan_sip.c: SIP channel loading...
[Oct 27 18:11:50] VERBOSE[1924] config.c:   == Parsing '/etc/asterisk/sip.conf': [Oct 27 18:11:50] DEBUG[1924] config.c: Parsing /etc/asterisk/sip.conf
[Oct 27 18:11:50] VERBOSE[1924] config.c:   == Found
[Oct 27 18:11:50] DEBUG[1924] netsock2.c: Splitting '0.0.0.0:0' into...
[Oct 27 18:11:50] DEBUG[1924] netsock2.c: ...host '0.0.0.0' and port '0'.
[Oct 27 18:11:50] DEBUG[1924] netsock2.c: Splitting '0.0.0.0' into...
[Oct 27 18:11:50] DEBUG[1924] netsock2.c: ...host '0.0.0.0' and port ''.
[Oct 27 18:11:50] DEBUG[1924] config.c: extract addr from 0.0.0.0 gives 0.0.0.0:0(0)
[Oct 27 18:11:50] DEBUG[1924] chan_sip.c: No context specified at line 19 for domain 'sop-korniychuk'
[Oct 27 18:11:50] DEBUG[1924] chan_sip.c: No context specified at line 20 for domain '172.30.8.13'
[Oct 27 18:11:50] DEBUG[1924] chan_sip.c: No context specified at line 21 for domain '172.30.8.13:5060'
[Oct 27 18:11:50] DEBUG[1924] chan_sip.c: Setting SIP channel User-Agent Name to Asterisk PBX
[Oct 27 18:11:50] DEBUG[1924] netsock2.c: Splitting 'sop-korniychuk' into...
[Oct 27 18:11:50] DEBUG[1924] netsock2.c: ...host 'sop-korniychuk' and port ''.
[Oct 27 18:11:50] VERBOSE[1924] chan_sip.c:   == SIP Listening on 0.0.0.0:5060
[Oct 27 18:11:50] VERBOSE[1924] netsock2.c:   == Using SIP CoS mark 4
[Oct 27 18:11:50] DEBUG[1924] tcptls.c: Nothing changed in SIP TCP server
[Oct 27 18:11:50] DEBUG[1924] chan_sip.c: SIP TCP server started
[Oct 27 18:11:50] VERBOSE[1924] config.c:   == Parsing '/etc/asterisk/sip_notify.conf': [Oct 27 18:11:50] DEBUG[1924] config.c: Parsing /etc/asterisk/sip_notify.conf
[Oct 27 18:11:50] VERBOSE[1924] config.c:   == Found
[Oct 27 18:11:50] DEBUG[1924] chan_sip.c: SIP reload_config done...Runtime= 0 sec
[Oct 27 18:11:50] DEBUG[1924] channel.c: Registered handler for 'SIP' (Session Initiation Protocol (SIP))
[Oct 27 18:11:50] VERBOSE[1924] channel.c:   == Registered channel type 'SIP' (Session Initiation Protocol (SIP))
[Oct 27 18:11:50] VERBOSE[1924] rtp_engine.c:   == Registered RTP glue 'SIP'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'SIPDtmfMode'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'SIPAddHeader'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'SIPRemoveHeader'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'SIP_HEADER'
[Oct 27 18:11:50] DEBUG[1924] xmldoc.c: Cannot find variable 'description' in tree 'SIPPEER'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'SIPPEER'
[Oct 27 18:11:50] DEBUG[1924] xmldoc.c: Cannot find variable 'description' in tree 'SIPCHANINFO'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'SIPCHANINFO'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'CHECKSIPDOMAIN'
[Oct 27 18:11:50] VERBOSE[1924] manager.c:   == Manager registered action SIPpeers
[Oct 27 18:11:50] VERBOSE[1924] manager.c:   == Manager registered action SIPshowpeer
[Oct 27 18:11:50] VERBOSE[1924] manager.c:   == Manager registered action SIPqualifypeer
[Oct 27 18:11:50] VERBOSE[1924] manager.c:   == Manager registered action SIPshowregistry
[Oct 27 18:11:50] VERBOSE[1924] manager.c:   == Manager registered action SIPnotify
[Oct 27 18:11:50] DEBUG[1924] res_config_mysql.c: MySQL RealTime: Successfully connected to database.
[Oct 27 18:11:50] VERBOSE[1924] res_config_mysql.c:        > Found column 'id' of type 'int(10) unsigned'
[Oct 27 18:11:50] VERBOSE[1924] res_config_mysql.c:        > Found column 'name' of type 'varchar(40)'
[Oct 27 18:11:50] VERBOSE[1924] res_config_mysql.c:        > Found column 'type' of type 'varchar(10)'
[Oct 27 18:11:50] VERBOSE[1924] res_config_mysql.c:        > Found column 'defaultuser' of type 'varchar(40)'
[Oct 27 18:11:50] VERBOSE[1924] res_config_mysql.c:        > Found column 'fromuser' of type 'varchar(40)'
[Oct 27 18:11:50] VERBOSE[1924] res_config_mysql.c:        > Found column 'fromdomain' of type 'varchar(40)'
[Oct 27 18:11:50] VERBOSE[1924] res_config_mysql.c:        > Found column 'secret' of type 'varchar(40)'
[Oct 27 18:11:50] VERBOSE[1924] res_config_mysql.c:        > Found column 'md5secret' of type 'varchar(40)'
[Oct 27 18:11:50] VERBOSE[1924] res_config_mysql.c:        > Found column 'auth' of type 'varchar(10)'
[Oct 27 18:11:50] VERBOSE[1924] res_config_mysql.c:        > Found column 'mailbox' of type 'varchar(20)'
[Oct 27 18:11:50] VERBOSE[1924] res_config_mysql.c:        > Found column 'subscribemwi' of type 'varchar(10)'
[Oct 27 18:11:50] VERBOSE[1924] res_config_mysql.c:        > Found column 'vmexten' of type 'varchar(20)'
[Oct 27 18:11:50] VERBOSE[1924] res_config_mysql.c:        > Found column 'callerid' of type 'varchar(40)'
[Oct 27 18:11:50] VERBOSE[1924] res_config_mysql.c:        > Found column 'cid_number' of type 'varchar(40)'
[Oct 27 18:11:50] VERBOSE[1924] res_config_mysql.c:        > Found column 'callingpres' of type 'varchar(20)'
[Oct 27 18:11:50] VERBOSE[1924] res_config_mysql.c:        > Found column 'usereqphone' of type 'varchar(10)'
[Oct 27 18:11:50] VERBOSE[1924] res_config_mysql.c:        > Found column 'language' of type 'varchar(10)'
[Oct 27 18:11:50] VERBOSE[1924] res_config_mysql.c:        > Found column 'incominglimit' of type 'varchar(10)'
[Oct 27 18:11:50] VERBOSE[1924] res_config_mysql.c:        > Found column 'context' of type 'varchar(40)'
[Oct 27 18:11:50] VERBOSE[1924] res_config_mysql.c:        > Found column 'subscribecontext' of type 'varchar(40)'
[Oct 27 18:11:50] VERBOSE[1924] res_config_mysql.c:        > Found column 'amaflags' of type 'varchar(20)'
[Oct 27 18:11:50] VERBOSE[1924] res_config_mysql.c:        > Found column 'accountcode' of type 'varchar(20)'
[Oct 27 18:11:50] VERBOSE[1924] res_config_mysql.c:        > Found column 'musicclass' of type 'varchar(20)'
[Oct 27 18:11:50] VERBOSE[1924] res_config_mysql.c:        > Found column 'mohsuggest' of type 'varchar(20)'
[Oct 27 18:11:50] VERBOSE[1924] res_config_mysql.c:        > Found column 'allowtransfer' of type 'varchar(20)'
[Oct 27 18:11:50] VERBOSE[1924] res_config_mysql.c:        > Found column 'callgroup' of type 'varchar(20)'
[Oct 27 18:11:50] VERBOSE[1924] res_config_mysql.c:        > Found column 'pickupgroup' of type 'varchar(20)'
[Oct 27 18:11:50] VERBOSE[1924] res_config_mysql.c:        > Found column 'autoframing' of type 'varchar(10)'
[Oct 27 18:11:50] VERBOSE[1924] res_config_mysql.c:        > Found column 'disallow' of type 'varchar(20)'
[Oct 27 18:11:50] VERBOSE[1924] res_config_mysql.c:        > Found column 'allow' of type 'varchar(20)'
[Oct 27 18:11:50] VERBOSE[1924] res_config_mysql.c:        > Found column 'maxcallbitrate' of type 'varchar(15)'
[Oct 27 18:11:50] VERBOSE[1924] res_config_mysql.c:        > Found column 'host' of type 'varchar(40)'
[Oct 27 18:11:50] VERBOSE[1924] res_config_mysql.c:        > Found column 'outboundproxy' of type 'varchar(40)'
[Oct 27 18:11:50] VERBOSE[1924] res_config_mysql.c:        > Found column 'ipaddr' of type 'varchar(45)'
[Oct 27 18:11:50] VERBOSE[1924] res_config_mysql.c:        > Found column 'defaultip' of type 'varchar(20)'
[Oct 27 18:11:50] VERBOSE[1924] res_config_mysql.c:        > Found column 'port' of type 'int(6)'
[Oct 27 18:11:50] VERBOSE[1924] res_config_mysql.c:        > Found column 'fullcontact' of type 'varchar(40)'
[Oct 27 18:11:50] VERBOSE[1924] res_config_mysql.c:        > Found column 'insecure' of type 'varchar(20)'
[Oct 27 18:11:50] VERBOSE[1924] res_config_mysql.c:        > Found column 'qualify' of type 'varchar(15)'
[Oct 27 18:11:50] VERBOSE[1924] res_config_mysql.c:        > Found column 'regseconds' of type 'int(11)'
[Oct 27 18:11:50] VERBOSE[1924] res_config_mysql.c:        > Found column 'regexten' of type 'varchar(20)'
[Oct 27 18:11:50] VERBOSE[1924] res_config_mysql.c:        > Found column 'regserver' of type 'varchar(20)'
[Oct 27 18:11:50] VERBOSE[1924] res_config_mysql.c:        > Found column 'rtptimeout' of type 'varchar(15)'
[Oct 27 18:11:50] VERBOSE[1924] res_config_mysql.c:        > Found column 'rtpholdtimeout' of type 'varchar(15)'
[Oct 27 18:11:50] VERBOSE[1924] res_config_mysql.c:        > Found column 'rtpkeepalive' of type 'varchar(15)'
[Oct 27 18:11:50] VERBOSE[1924] res_config_mysql.c:        > Found column 'lastms' of type 'int(11)'
[Oct 27 18:11:50] VERBOSE[1924] res_config_mysql.c:        > Found column 'setvar' of type 'varchar(200)'
[Oct 27 18:11:50] VERBOSE[1924] res_config_mysql.c:        > Found column 'useragent' of type 'varchar(20)'
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  chan_sip.so => (Session Initiation Protocol (SIP))
[Oct 27 18:11:50] VERBOSE[1924] file.c:   == Registered file format g723sf, extension(s) g723|g723sf
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  format_g723.so => (G.723.1 Simple Timestamp File Format)
[Oct 27 18:11:50] VERBOSE[1924] file.c:   == Registered file format g726-40, extension(s) g726-40
[Oct 27 18:11:50] VERBOSE[1924] file.c:   == Registered file format g726-32, extension(s) g726-32
[Oct 27 18:11:50] VERBOSE[1924] file.c:   == Registered file format g726-24, extension(s) g726-24
[Oct 27 18:11:50] VERBOSE[1924] file.c:   == Registered file format g726-16, extension(s) g726-16
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  format_g726.so => (Raw G.726 (16/24/32/40kbps) data)
[Oct 27 18:11:50] VERBOSE[1924] file.c:   == Registered file format g729, extension(s) g729
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  format_g729.so => (Raw G.729 data)
[Oct 27 18:11:50] VERBOSE[1924] file.c:   == Registered file format gsm, extension(s) gsm
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  format_gsm.so => (Raw GSM data)
[Oct 27 18:11:50] VERBOSE[1924] file.c:   == Registered file format h263, extension(s) h263
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  format_h263.so => (Raw H.263 data)
[Oct 27 18:11:50] VERBOSE[1924] file.c:   == Registered file format h264, extension(s) h264
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  format_h264.so => (Raw H.264 data)
[Oct 27 18:11:50] VERBOSE[1924] file.c:   == Registered file format iLBC, extension(s) ilbc
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  format_ilbc.so => (Raw iLBC data)
[Oct 27 18:11:50] VERBOSE[1924] image.c:   == Registered format 'jpg' (JPEG (Joint Picture Experts Group))
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  format_jpeg.so => (jpeg (joint picture experts group) image format)
[Oct 27 18:11:50] VERBOSE[1924] file.c:   == Registered file format ogg_vorbis, extension(s) ogg
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  format_ogg_vorbis.so => (OGG/Vorbis audio)
[Oct 27 18:11:50] VERBOSE[1924] file.c:   == Registered file format pcm, extension(s) pcm|ulaw|ul|mu|ulw
[Oct 27 18:11:50] VERBOSE[1924] file.c:   == Registered file format alaw, extension(s) alaw|al|alw
[Oct 27 18:11:50] VERBOSE[1924] file.c:   == Registered file format au, extension(s) au
[Oct 27 18:11:50] VERBOSE[1924] file.c:   == Registered file format g722, extension(s) g722
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  format_pcm.so => (Raw/Sun uLaw/ALaw 8KHz (PCM,PCMA,AU), G.722 16Khz)
[Oct 27 18:11:50] VERBOSE[1924] file.c:   == Registered file format siren14, extension(s) siren14
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  format_siren14.so => (ITU G.722.1 Annex C (Siren14, licensed from Polycom))
[Oct 27 18:11:50] VERBOSE[1924] file.c:   == Registered file format siren7, extension(s) siren7
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  format_siren7.so => (ITU G.722.1 (Siren7, licensed from Polycom))
[Oct 27 18:11:50] VERBOSE[1924] file.c:   == Registered file format sln, extension(s) sln|raw
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  format_sln.so => (Raw Signed Linear Audio support (SLN))
[Oct 27 18:11:50] VERBOSE[1924] file.c:   == Registered file format g719, extension(s) g719
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  format_g719.so => (ITU G.719)
[Oct 27 18:11:50] VERBOSE[1924] file.c:   == Registered file format sln16, extension(s) sln16
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  format_sln16.so => (Raw Signed Linear 16KHz Audio support (SLN16))
[Oct 27 18:11:50] VERBOSE[1924] file.c:   == Registered file format vox, extension(s) vox
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  format_vox.so => (Dialogic VOX (ADPCM) File Format)
[Oct 27 18:11:50] VERBOSE[1924] file.c:   == Registered file format wav, extension(s) wav
[Oct 27 18:11:50] VERBOSE[1924] file.c:   == Registered file format wav16, extension(s) wav16
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  format_wav.so => (Microsoft WAV/WAV16 format (8kHz/16kHz Signed Linear))
[Oct 27 18:11:50] VERBOSE[1924] file.c:   == Registered file format wav49, extension(s) WAV|wav49
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  format_wav_gsm.so => (Microsoft WAV format (Proprietary GSM))
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'DEVICE_STATE'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'HINT'
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  func_devstate.so => (Gets or sets a device state in the dialplan)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'ConfBridge'
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  app_confbridge.so => (Conference Bridge Application)
[Oct 27 18:11:50] VERBOSE[1924] config.c:   == Parsing '/etc/asterisk/meetme.conf': [Oct 27 18:11:50] DEBUG[1924] config.c: Parsing /etc/asterisk/meetme.conf
[Oct 27 18:11:50] VERBOSE[1924] config.c:   == Found
[Oct 27 18:11:50] VERBOSE[1924] manager.c:   == Manager registered action MeetmeMute
[Oct 27 18:11:50] VERBOSE[1924] manager.c:   == Manager registered action MeetmeUnmute
[Oct 27 18:11:50] VERBOSE[1924] manager.c:   == Manager registered action MeetmeList
[Oct 27 18:11:50] VERBOSE[1924] manager.c:   == Manager registered action MeetmeChannelAdmin
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'MeetMeChannelAdmin'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'MeetMeAdmin'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'MeetMeCount'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'MeetMe'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'SLAStation'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'SLATrunk'
[Oct 27 18:11:50] DEBUG[1924] xmldoc.c: Cannot find variable 'description' in tree 'MEETME_INFO'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'MEETME_INFO'
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  app_meetme.so => (MeetMe conference bridge)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'MATH'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'INC'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'DEC'
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  func_math.so => (Mathematical dialplan function)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'ISNULL'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'SET'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'EXISTS'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'IF'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'IFTIME'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'IMPORT'
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  func_logic.so => (Logical dialplan functions)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'LOCK'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'TRYLOCK'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'UNLOCK'
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  func_lock.so => (Dialplan mutexes)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'GROUP_COUNT'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'GROUP_MATCH_COUNT'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'GROUP_LIST'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'GROUP'
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  func_groupcount.so => (Channel group dialplan functions)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'GLOBAL'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'SHARED'
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  func_global.so => (Variable dialplan functions)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'FRAME_TRACE'
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  func_frame_trace.so => (Frame Trace for internal ast_frame debugging.)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'EXTENSION_STATE'
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  func_extstate.so => (Gets an extension's state in the dialplan)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'ENV'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'STAT'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'FILE'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'FILE_COUNT_LINE'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'FILE_FORMAT'
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  func_env.so => (Environment/filesystem dialplan functions)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'ENUMRESULT'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'ENUMQUERY'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'ENUMLOOKUP'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'TXTCIDNAME'
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  func_enum.so => (ENUM related dialplan functions)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'DIALPLAN_EXISTS'
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  func_dialplan.so => (Dialplan Context/Extension/Priority Checking Functions)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'DIALGROUP'
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  func_dialgroup.so => (Dialgroup dialplan function)
[Oct 27 18:11:50] VERBOSE[1924] translate.c:   == Registered translator 'g726tolin' from format g726 to slin, cost 1000
[Oct 27 18:11:50] DEBUG[1924] translate.c: Resetting translation matrix
[Oct 27 18:11:50] VERBOSE[1924] translate.c:   == Registered translator 'lintog726' from format slin to g726, cost 2999
[Oct 27 18:11:50] DEBUG[1924] translate.c: Resetting translation matrix
[Oct 27 18:11:50] VERBOSE[1924] translate.c:   == Registered translator 'g726aal2tolin' from format g726aal2 to slin, cost 1000
[Oct 27 18:11:50] DEBUG[1924] translate.c: Resetting translation matrix
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3999 cost path from g726aal2 to g726, via slin
[Oct 27 18:11:50] VERBOSE[1924] translate.c:   == Registered translator 'lintog726aal2' from format slin to g726aal2, cost 3000
[Oct 27 18:11:50] DEBUG[1924] translate.c: Resetting translation matrix
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3999 cost path from g726aal2 to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 4000 cost path from g726 to g726aal2, via slin
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  codec_g726.so => (ITU G.726-32kbps G726 Transcoder)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'DB'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'DB_EXISTS'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'DB_DELETE'
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  func_db.so => (Database (astdb) related dialplan functions)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'CUT'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'SORT'
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  func_cut.so => (Cut out information from a string)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'AST_CONFIG'
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  func_config.so => (Asterisk configuration file variable access)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'CHANNEL'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'CHANNELS'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'MASTER_CHANNEL'
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  func_channel.so => (Channel information dialplan functions)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'CDR'
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  func_cdr.so => (Call Detail Record (CDR) dialplan function)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'CALLERPRES'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'CALLERID'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'CONNECTEDLINE'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'REDIRECTING'
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  func_callerid.so => (Party ID related dialplan functions (Caller-ID, Connected-line, Redirecting))
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'CALLCOMPLETION'
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  func_callcompletion.so => (Call Control Configuration Function)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'BLACKLIST'
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  func_blacklist.so => (Look up Caller*ID name/number from blacklist database)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'BASE64_ENCODE'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'BASE64_DECODE'
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  func_base64.so => (base64 encode/decode dialplan functions)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'AUDIOHOOK_INHERIT'
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  func_audiohookinherit.so => (Audiohook inheritance function)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'AES_DECRYPT'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'AES_ENCRYPT'
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  func_aes.so => (AES dialplan functions)
[Oct 27 18:11:50] VERBOSE[1924] bridging.c:   == Registered bridge technology simple_bridge
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  bridge_simple.so => (Simple two channel bridging module)
[Oct 27 18:11:50] VERBOSE[1924] config.c:   == Parsing '/etc/asterisk/say.conf': [Oct 27 18:11:50] DEBUG[1924] config.c: Parsing /etc/asterisk/say.conf
[Oct 27 18:11:50] VERBOSE[1924] config.c:   == Found
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'Playback'
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  app_playback.so => (Sound File Playback Application)
[Oct 27 18:11:50] VERBOSE[1924] bridging.c:   == Registered bridge technology multiplexed_bridge
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  bridge_multiplexed.so => (Multiplexed two channel bridging module)
[Oct 27 18:11:50] VERBOSE[1924] res_agi.c:   == AGI Command 'aon' registered
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'AON'
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  app_aon.so => (AON Application)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'TIMEOUT'
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  func_timeout.so => (Channel timeout dialplan functions)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'While'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'EndWhile'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'ExitWhile'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'ContinueWhile'
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  app_while.so => (While Loops and Conditional Execution)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'Echo'
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  app_echo.so => (Simple Echo Application)
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  pbx_spool.so => (Outgoing Spool Support)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'Log'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'Verbose'
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  app_verbose.so => (Send verbose output)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'MYSQL'
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  app_mysql.so => (Simple Mysql Interface)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'UserEvent'
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  app_userevent.so => (Custom User Event Application)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'WaitUntil'
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  app_waituntil.so => (Wait until specified time)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'TrySystem'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'System'
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  app_system.so => (Generic System() application)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'MixMonitor'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'StopMixMonitor'
[Oct 27 18:11:50] VERBOSE[1924] manager.c:   == Manager registered action MixMonitorMute
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  app_mixmonitor.so => (Mixed Audio Monitoring Application)
[Oct 27 18:11:50] VERBOSE[1924] res_agi.c:   == AGI Command 'gosub' registered
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'StackPop'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'Return'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'GosubIf'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'Gosub'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'LOCAL'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'LOCAL_PEEK'
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  app_stack.so => (Dialplan subroutines (Gosub, Return, etc))
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'ChanIsAvail'
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  app_chanisavail.so => (Check channel availability)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'SoftHangup'
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  app_softhangup.so => (Hangs up the requested channel)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'SetCallerPres'
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  app_setcallerid.so => (Set CallerID Presentation Application)
[Oct 27 18:11:50] VERBOSE[1924] translate.c:   == Registered translator 'ulawtolin' from format ulaw to slin, cost 1
[Oct 27 18:11:50] DEBUG[1924] translate.c: Resetting translation matrix
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3001 cost path from ulaw to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from ulaw to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3999 cost path from g726aal2 to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 4000 cost path from g726 to g726aal2, via slin
[Oct 27 18:11:50] VERBOSE[1924] translate.c:   == Registered translator 'lintoulaw' from format slin to ulaw, cost 1
[Oct 27 18:11:50] DEBUG[1924] translate.c: Resetting translation matrix
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3001 cost path from ulaw to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from ulaw to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726aal2 to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3999 cost path from g726aal2 to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726 to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 4000 cost path from g726 to g726aal2, via slin
[Oct 27 18:11:50] VERBOSE[1924] translate.c:   == Registered translator 'lintotestlaw' from format slin to testlaw, cost 1
[Oct 27 18:11:50] DEBUG[1924] translate.c: Resetting translation matrix
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3001 cost path from ulaw to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from ulaw to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from ulaw to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726aal2 to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3999 cost path from g726aal2 to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726aal2 to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726 to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 4000 cost path from g726 to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726 to testlaw, via slin
[Oct 27 18:11:50] VERBOSE[1924] translate.c:   == Registered translator 'testlawtolin' from format testlaw to slin, cost 1
[Oct 27 18:11:50] DEBUG[1924] translate.c: Resetting translation matrix
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3001 cost path from ulaw to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from ulaw to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from ulaw to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726aal2 to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3999 cost path from g726aal2 to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726aal2 to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726 to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 4000 cost path from g726 to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726 to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from testlaw to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3001 cost path from testlaw to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from testlaw to g726, via slin
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  codec_ulaw.so => (mu-Law Coder/Decoder)
[Oct 27 18:11:50] VERBOSE[1924] translate.c:   == Registered translator 'lpc10tolin' from format lpc10 to slin, cost 2000
[Oct 27 18:11:50] DEBUG[1924] translate.c: Resetting translation matrix
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3001 cost path from ulaw to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from ulaw to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from ulaw to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726aal2 to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3999 cost path from g726aal2 to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726aal2 to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from lpc10 to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 5000 cost path from lpc10 to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 4999 cost path from lpc10 to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from lpc10 to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726 to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 4000 cost path from g726 to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726 to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from testlaw to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3001 cost path from testlaw to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from testlaw to g726, via slin
[Oct 27 18:11:50] VERBOSE[1924] translate.c:   == Registered translator 'lintolpc10' from format slin to lpc10, cost 2999
[Oct 27 18:11:50] DEBUG[1924] translate.c: Resetting translation matrix
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3001 cost path from ulaw to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from ulaw to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from ulaw to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from ulaw to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726aal2 to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3999 cost path from g726aal2 to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3999 cost path from g726aal2 to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726aal2 to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from lpc10 to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 5000 cost path from lpc10 to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 4999 cost path from lpc10 to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from lpc10 to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726 to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 4000 cost path from g726 to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3999 cost path from g726 to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726 to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from testlaw to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3001 cost path from testlaw to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from testlaw to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from testlaw to g726, via slin
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  codec_lpc10.so => (LPC10 2.4kbps Coder/Decoder)
[Oct 27 18:11:50] VERBOSE[1924] translate.c:   == Registered translator 'gsmtolin' from format gsm to slin, cost 1
[Oct 27 18:11:50] DEBUG[1924] translate.c: Resetting translation matrix
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from gsm to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3001 cost path from gsm to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from gsm to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from gsm to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from gsm to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3001 cost path from ulaw to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from ulaw to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from ulaw to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from ulaw to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726aal2 to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3999 cost path from g726aal2 to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3999 cost path from g726aal2 to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726aal2 to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from lpc10 to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 5000 cost path from lpc10 to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 4999 cost path from lpc10 to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from lpc10 to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726 to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 4000 cost path from g726 to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3999 cost path from g726 to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726 to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from testlaw to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3001 cost path from testlaw to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from testlaw to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from testlaw to g726, via slin
[Oct 27 18:11:50] VERBOSE[1924] translate.c:   == Registered translator 'lintogsm' from format slin to gsm, cost 1999
[Oct 27 18:11:50] DEBUG[1924] translate.c: Resetting translation matrix
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from gsm to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3001 cost path from gsm to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from gsm to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from gsm to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from gsm to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2000 cost path from ulaw to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3001 cost path from ulaw to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from ulaw to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from ulaw to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from ulaw to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2999 cost path from g726aal2 to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726aal2 to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3999 cost path from g726aal2 to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3999 cost path from g726aal2 to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726aal2 to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3999 cost path from lpc10 to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from lpc10 to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 5000 cost path from lpc10 to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 4999 cost path from lpc10 to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from lpc10 to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2999 cost path from g726 to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726 to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 4000 cost path from g726 to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3999 cost path from g726 to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726 to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2000 cost path from testlaw to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from testlaw to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3001 cost path from testlaw to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from testlaw to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from testlaw to g726, via slin
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  codec_gsm.so => (GSM Coder/Decoder)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'ReadFile'
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  app_readfile.so => (Stores output of file into a variable)
[Oct 27 18:11:50] VERBOSE[1924] translate.c:   == Registered translator 'g722tolin' from format g722 to slin, cost 1
[Oct 27 18:11:50] DEBUG[1924] translate.c: Resetting translation matrix
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from gsm to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3001 cost path from gsm to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from gsm to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from gsm to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from gsm to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2000 cost path from ulaw to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3001 cost path from ulaw to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from ulaw to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from ulaw to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from ulaw to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2999 cost path from g726aal2 to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726aal2 to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3999 cost path from g726aal2 to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3999 cost path from g726aal2 to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726aal2 to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3999 cost path from lpc10 to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from lpc10 to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 5000 cost path from lpc10 to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 4999 cost path from lpc10 to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from lpc10 to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2999 cost path from g726 to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726 to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 4000 cost path from g726 to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3999 cost path from g726 to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726 to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2000 cost path from g722 to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from g722 to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3001 cost path from g722 to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from g722 to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from g722 to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from g722 to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2000 cost path from testlaw to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from testlaw to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3001 cost path from testlaw to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from testlaw to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from testlaw to g726, via slin
[Oct 27 18:11:50] VERBOSE[1924] translate.c:   == Registered translator 'lintog722' from format slin to g722, cost 1000
[Oct 27 18:11:50] DEBUG[1924] translate.c: Resetting translation matrix
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from gsm to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3001 cost path from gsm to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from gsm to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from gsm to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from gsm to g722, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from gsm to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2000 cost path from ulaw to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3001 cost path from ulaw to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from ulaw to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from ulaw to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from ulaw to g722, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from ulaw to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2999 cost path from g726aal2 to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726aal2 to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3999 cost path from g726aal2 to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3999 cost path from g726aal2 to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2000 cost path from g726aal2 to g722, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726aal2 to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3999 cost path from lpc10 to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from lpc10 to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 5000 cost path from lpc10 to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 4999 cost path from lpc10 to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from lpc10 to g722, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from lpc10 to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2999 cost path from g726 to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726 to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 4000 cost path from g726 to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3999 cost path from g726 to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2000 cost path from g726 to g722, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726 to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2000 cost path from g722 to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from g722 to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3001 cost path from g722 to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from g722 to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from g722 to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from g722 to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2000 cost path from testlaw to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from testlaw to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3001 cost path from testlaw to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from testlaw to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from testlaw to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from testlaw to g722, via slin
[Oct 27 18:11:50] VERBOSE[1924] translate.c:   == Registered translator 'g722tolin16' from format g722 to slin16, cost 1000
[Oct 27 18:11:50] DEBUG[1924] translate.c: Resetting translation matrix
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from gsm to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3001 cost path from gsm to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from gsm to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from gsm to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from gsm to g722, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from gsm to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from gsm to slin16, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2000 cost path from ulaw to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3001 cost path from ulaw to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from ulaw to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from ulaw to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from ulaw to g722, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from ulaw to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from ulaw to slin16, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2999 cost path from g726aal2 to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726aal2 to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3999 cost path from g726aal2 to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3999 cost path from g726aal2 to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2000 cost path from g726aal2 to g722, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726aal2 to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from g726aal2 to slin16, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 4000 cost path from slin to slin16, via gsm
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2002 cost path from slin to slin16, via ulaw
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2000 cost path from slin to slin16, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3999 cost path from lpc10 to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from lpc10 to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 5000 cost path from lpc10 to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 4999 cost path from lpc10 to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from lpc10 to g722, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 4000 cost path from lpc10 to slin16, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from lpc10 to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2999 cost path from g726 to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726 to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 4000 cost path from g726 to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3999 cost path from g726 to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2000 cost path from g726 to g722, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from g726 to slin16, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726 to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2000 cost path from g722 to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from g722 to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3001 cost path from g722 to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from g722 to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from g722 to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from g722 to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2000 cost path from testlaw to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from testlaw to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3001 cost path from testlaw to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from testlaw to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from testlaw to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from testlaw to g722, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from testlaw to slin16, via slin
[Oct 27 18:11:50] VERBOSE[1924] translate.c:   == Registered translator 'lin16tog722' from format slin16 to g722, cost 2000
[Oct 27 18:11:50] DEBUG[1924] translate.c: Resetting translation matrix
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from gsm to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3001 cost path from gsm to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from gsm to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from gsm to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from gsm to g722, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from gsm to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from gsm to slin16, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2000 cost path from ulaw to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3001 cost path from ulaw to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from ulaw to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from ulaw to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from ulaw to g722, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from ulaw to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from ulaw to slin16, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2999 cost path from g726aal2 to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726aal2 to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3999 cost path from g726aal2 to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3999 cost path from g726aal2 to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2000 cost path from g726aal2 to g722, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726aal2 to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from g726aal2 to slin16, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 4000 cost path from slin to slin16, via gsm
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2002 cost path from slin to slin16, via ulaw
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2000 cost path from slin to slin16, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3999 cost path from lpc10 to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from lpc10 to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 5000 cost path from lpc10 to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 4999 cost path from lpc10 to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from lpc10 to g722, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 4000 cost path from lpc10 to slin16, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from lpc10 to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2999 cost path from g726 to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726 to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 4000 cost path from g726 to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3999 cost path from g726 to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2000 cost path from g726 to g722, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from g726 to slin16, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726 to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2000 cost path from g722 to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from g722 to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3001 cost path from g722 to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from g722 to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from g722 to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from g722 to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 4000 cost path from slin16 to gsm, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2002 cost path from slin16 to ulaw, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 5001 cost path from slin16 to g726aal2, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from slin16 to slin, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 5000 cost path from slin16 to lpc10, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 5000 cost path from slin16 to g726, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2002 cost path from slin16 to testlaw, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2000 cost path from testlaw to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from testlaw to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3001 cost path from testlaw to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from testlaw to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from testlaw to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from testlaw to g722, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from testlaw to slin16, via slin
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  codec_g722.so => (ITU G.722-64kbps G722 Transcoder)
[Oct 27 18:11:50] VERBOSE[1924] translate.c:   == Registered translator 'alawtolin' from format alaw to slin, cost 1
[Oct 27 18:11:50] DEBUG[1924] translate.c: Resetting translation matrix
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from gsm to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3001 cost path from gsm to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from gsm to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from gsm to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from gsm to g722, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from gsm to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from gsm to slin16, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2000 cost path from ulaw to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3001 cost path from ulaw to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from ulaw to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from ulaw to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from ulaw to g722, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from ulaw to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from ulaw to slin16, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2000 cost path from alaw to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from alaw to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3001 cost path from alaw to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from alaw to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from alaw to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from alaw to g722, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from alaw to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from alaw to slin16, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2999 cost path from g726aal2 to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726aal2 to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3999 cost path from g726aal2 to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3999 cost path from g726aal2 to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2000 cost path from g726aal2 to g722, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726aal2 to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from g726aal2 to slin16, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 4000 cost path from slin to slin16, via gsm
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2002 cost path from slin to slin16, via ulaw
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2000 cost path from slin to slin16, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3999 cost path from lpc10 to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from lpc10 to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 5000 cost path from lpc10 to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 4999 cost path from lpc10 to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from lpc10 to g722, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 4000 cost path from lpc10 to slin16, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from lpc10 to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2999 cost path from g726 to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726 to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 4000 cost path from g726 to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3999 cost path from g726 to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2000 cost path from g726 to g722, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from g726 to slin16, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726 to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2000 cost path from g722 to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from g722 to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3001 cost path from g722 to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from g722 to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from g722 to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from g722 to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 4000 cost path from slin16 to gsm, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2002 cost path from slin16 to ulaw, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 5001 cost path from slin16 to g726aal2, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from slin16 to slin, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 5000 cost path from slin16 to lpc10, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 5000 cost path from slin16 to g726, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2002 cost path from slin16 to testlaw, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2000 cost path from testlaw to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from testlaw to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3001 cost path from testlaw to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from testlaw to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from testlaw to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from testlaw to g722, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from testlaw to slin16, via slin
[Oct 27 18:11:50] VERBOSE[1924] translate.c:   == Registered translator 'lintoalaw' from format slin to alaw, cost 1
[Oct 27 18:11:50] DEBUG[1924] translate.c: Resetting translation matrix
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from gsm to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from gsm to alaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3001 cost path from gsm to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from gsm to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from gsm to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from gsm to g722, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from gsm to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from gsm to slin16, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2000 cost path from ulaw to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from ulaw to alaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3001 cost path from ulaw to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from ulaw to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from ulaw to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from ulaw to g722, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from ulaw to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from ulaw to slin16, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2000 cost path from alaw to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from alaw to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3001 cost path from alaw to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from alaw to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from alaw to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from alaw to g722, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from alaw to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from alaw to slin16, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2999 cost path from g726aal2 to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726aal2 to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726aal2 to alaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3999 cost path from g726aal2 to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3999 cost path from g726aal2 to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2000 cost path from g726aal2 to g722, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726aal2 to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from g726aal2 to slin16, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 4000 cost path from slin to slin16, via gsm
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2002 cost path from slin to slin16, via ulaw
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2000 cost path from slin to slin16, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3999 cost path from lpc10 to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from lpc10 to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from lpc10 to alaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 5000 cost path from lpc10 to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 4999 cost path from lpc10 to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from lpc10 to g722, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 4000 cost path from lpc10 to slin16, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from lpc10 to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2999 cost path from g726 to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726 to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726 to alaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 4000 cost path from g726 to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3999 cost path from g726 to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2000 cost path from g726 to g722, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from g726 to slin16, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726 to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2000 cost path from g722 to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from g722 to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from g722 to alaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3001 cost path from g722 to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from g722 to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from g722 to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from g722 to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 4000 cost path from slin16 to gsm, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2002 cost path from slin16 to ulaw, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2002 cost path from slin16 to alaw, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 5001 cost path from slin16 to g726aal2, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from slin16 to slin, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 5000 cost path from slin16 to lpc10, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 5000 cost path from slin16 to g726, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2002 cost path from slin16 to testlaw, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2000 cost path from testlaw to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from testlaw to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from testlaw to alaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3001 cost path from testlaw to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from testlaw to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from testlaw to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from testlaw to g722, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from testlaw to slin16, via slin
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  codec_alaw.so => (A-law Coder/Decoder)
[Oct 27 18:11:50] VERBOSE[1924] translate.c:   == Registered translator 'adpcmtolin' from format adpcm to slin, cost 1000
[Oct 27 18:11:50] DEBUG[1924] translate.c: Resetting translation matrix
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from gsm to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from gsm to alaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3001 cost path from gsm to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from gsm to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from gsm to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from gsm to g722, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from gsm to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from gsm to slin16, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2000 cost path from ulaw to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from ulaw to alaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3001 cost path from ulaw to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from ulaw to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from ulaw to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from ulaw to g722, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from ulaw to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from ulaw to slin16, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2000 cost path from alaw to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from alaw to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3001 cost path from alaw to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from alaw to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from alaw to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from alaw to g722, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from alaw to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from alaw to slin16, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2999 cost path from g726aal2 to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726aal2 to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726aal2 to alaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3999 cost path from g726aal2 to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3999 cost path from g726aal2 to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2000 cost path from g726aal2 to g722, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726aal2 to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from g726aal2 to slin16, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2999 cost path from adpcm to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from adpcm to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from adpcm to alaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 4000 cost path from adpcm to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3999 cost path from adpcm to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3999 cost path from adpcm to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2000 cost path from adpcm to g722, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from adpcm to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from adpcm to slin16, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 4000 cost path from slin to slin16, via gsm
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2002 cost path from slin to slin16, via ulaw
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2000 cost path from slin to slin16, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3999 cost path from lpc10 to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from lpc10 to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from lpc10 to alaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 5000 cost path from lpc10 to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 4999 cost path from lpc10 to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from lpc10 to g722, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 4000 cost path from lpc10 to slin16, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from lpc10 to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2999 cost path from g726 to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726 to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726 to alaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 4000 cost path from g726 to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3999 cost path from g726 to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2000 cost path from g726 to g722, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from g726 to slin16, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726 to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2000 cost path from g722 to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from g722 to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from g722 to alaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3001 cost path from g722 to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from g722 to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from g722 to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from g722 to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 4000 cost path from slin16 to gsm, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2002 cost path from slin16 to ulaw, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2002 cost path from slin16 to alaw, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 5001 cost path from slin16 to g726aal2, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from slin16 to slin, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 5000 cost path from slin16 to lpc10, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 5000 cost path from slin16 to g726, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2002 cost path from slin16 to testlaw, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2000 cost path from testlaw to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from testlaw to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from testlaw to alaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3001 cost path from testlaw to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from testlaw to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from testlaw to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from testlaw to g722, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from testlaw to slin16, via slin
[Oct 27 18:11:50] VERBOSE[1924] translate.c:   == Registered translator 'lintoadpcm' from format slin to adpcm, cost 1
[Oct 27 18:11:50] DEBUG[1924] translate.c: Resetting translation matrix
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from gsm to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from gsm to alaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3001 cost path from gsm to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from gsm to adpcm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from gsm to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from gsm to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from gsm to g722, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from gsm to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from gsm to slin16, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2000 cost path from ulaw to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from ulaw to alaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3001 cost path from ulaw to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from ulaw to adpcm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from ulaw to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from ulaw to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from ulaw to g722, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from ulaw to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from ulaw to slin16, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2000 cost path from alaw to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from alaw to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3001 cost path from alaw to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from alaw to adpcm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from alaw to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from alaw to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from alaw to g722, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from alaw to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from alaw to slin16, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2999 cost path from g726aal2 to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726aal2 to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726aal2 to alaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726aal2 to adpcm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3999 cost path from g726aal2 to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3999 cost path from g726aal2 to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2000 cost path from g726aal2 to g722, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726aal2 to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from g726aal2 to slin16, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2999 cost path from adpcm to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from adpcm to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from adpcm to alaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 4000 cost path from adpcm to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3999 cost path from adpcm to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3999 cost path from adpcm to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2000 cost path from adpcm to g722, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from adpcm to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from adpcm to slin16, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 4000 cost path from slin to slin16, via gsm
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2002 cost path from slin to slin16, via ulaw
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2000 cost path from slin to slin16, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3999 cost path from lpc10 to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from lpc10 to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from lpc10 to alaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 5000 cost path from lpc10 to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from lpc10 to adpcm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 4999 cost path from lpc10 to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from lpc10 to g722, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 4000 cost path from lpc10 to slin16, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from lpc10 to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2999 cost path from g726 to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726 to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726 to alaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 4000 cost path from g726 to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726 to adpcm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3999 cost path from g726 to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2000 cost path from g726 to g722, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from g726 to slin16, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726 to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2000 cost path from g722 to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from g722 to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from g722 to alaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3001 cost path from g722 to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from g722 to adpcm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from g722 to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from g722 to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from g722 to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 4000 cost path from slin16 to gsm, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2002 cost path from slin16 to ulaw, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2002 cost path from slin16 to alaw, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 5001 cost path from slin16 to g726aal2, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2002 cost path from slin16 to adpcm, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from slin16 to slin, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 5000 cost path from slin16 to lpc10, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 5000 cost path from slin16 to g726, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2002 cost path from slin16 to testlaw, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2000 cost path from testlaw to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from testlaw to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from testlaw to alaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3001 cost path from testlaw to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from testlaw to adpcm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from testlaw to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from testlaw to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from testlaw to g722, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from testlaw to slin16, via slin
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  codec_adpcm.so => (Adaptive Differential PCM Coder/Decoder)
[Oct 27 18:11:50] VERBOSE[1924] translate.c:   == Registered translator 'alawtoulaw' from format alaw to ulaw, cost 1
[Oct 27 18:11:50] DEBUG[1924] translate.c: Resetting translation matrix
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from gsm to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from gsm to alaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3001 cost path from gsm to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from gsm to adpcm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from gsm to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from gsm to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from gsm to g722, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from gsm to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from gsm to slin16, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2000 cost path from ulaw to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from ulaw to alaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3001 cost path from ulaw to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from ulaw to adpcm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from ulaw to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from ulaw to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from ulaw to g722, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from ulaw to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from ulaw to slin16, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from alaw to gsm, via ulaw
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3002 cost path from alaw to g726aal2, via ulaw
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3 cost path from alaw to adpcm, via ulaw
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3001 cost path from alaw to lpc10, via ulaw
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3001 cost path from alaw to g726, via ulaw
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1002 cost path from alaw to g722, via ulaw
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2002 cost path from alaw to slin16, via ulaw
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3 cost path from alaw to testlaw, via ulaw
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2000 cost path from alaw to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3001 cost path from alaw to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from alaw to adpcm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from alaw to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from alaw to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from alaw to g722, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from alaw to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from alaw to slin16, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2999 cost path from g726aal2 to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726aal2 to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726aal2 to alaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726aal2 to adpcm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3999 cost path from g726aal2 to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3999 cost path from g726aal2 to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2000 cost path from g726aal2 to g722, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726aal2 to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from g726aal2 to slin16, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2999 cost path from adpcm to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from adpcm to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from adpcm to alaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 4000 cost path from adpcm to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3999 cost path from adpcm to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3999 cost path from adpcm to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2000 cost path from adpcm to g722, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from adpcm to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from adpcm to slin16, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 4000 cost path from slin to slin16, via gsm
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2002 cost path from slin to slin16, via ulaw
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2000 cost path from slin to slin16, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3999 cost path from lpc10 to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from lpc10 to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from lpc10 to alaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 5000 cost path from lpc10 to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from lpc10 to adpcm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 4999 cost path from lpc10 to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from lpc10 to g722, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 4000 cost path from lpc10 to slin16, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from lpc10 to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2999 cost path from g726 to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726 to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726 to alaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 4000 cost path from g726 to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726 to adpcm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3999 cost path from g726 to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2000 cost path from g726 to g722, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from g726 to slin16, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726 to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2000 cost path from g722 to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from g722 to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from g722 to alaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3001 cost path from g722 to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from g722 to adpcm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from g722 to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from g722 to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from g722 to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 4000 cost path from slin16 to gsm, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2002 cost path from slin16 to ulaw, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2002 cost path from slin16 to alaw, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 5001 cost path from slin16 to g726aal2, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2002 cost path from slin16 to adpcm, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from slin16 to slin, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 5000 cost path from slin16 to lpc10, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 5000 cost path from slin16 to g726, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2002 cost path from slin16 to testlaw, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2000 cost path from testlaw to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from testlaw to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from testlaw to alaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3001 cost path from testlaw to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from testlaw to adpcm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from testlaw to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from testlaw to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from testlaw to g722, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from testlaw to slin16, via slin
[Oct 27 18:11:50] VERBOSE[1924] translate.c:   == Registered translator 'ulawtoalaw' from format ulaw to alaw, cost 1
[Oct 27 18:11:50] DEBUG[1924] translate.c: Resetting translation matrix
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from gsm to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from gsm to alaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3001 cost path from gsm to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from gsm to adpcm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from gsm to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from gsm to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from gsm to g722, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from gsm to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from gsm to slin16, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2000 cost path from ulaw to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3001 cost path from ulaw to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from ulaw to adpcm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from ulaw to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from ulaw to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from ulaw to g722, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from ulaw to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from ulaw to slin16, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from alaw to gsm, via ulaw
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3002 cost path from alaw to g726aal2, via ulaw
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3 cost path from alaw to adpcm, via ulaw
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3001 cost path from alaw to lpc10, via ulaw
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3001 cost path from alaw to g726, via ulaw
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1002 cost path from alaw to g722, via ulaw
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2002 cost path from alaw to slin16, via ulaw
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3 cost path from alaw to testlaw, via ulaw
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2000 cost path from alaw to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3001 cost path from alaw to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from alaw to adpcm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from alaw to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from alaw to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from alaw to g722, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from alaw to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from alaw to slin16, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2999 cost path from g726aal2 to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726aal2 to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726aal2 to alaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726aal2 to adpcm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3999 cost path from g726aal2 to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3999 cost path from g726aal2 to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2000 cost path from g726aal2 to g722, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726aal2 to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from g726aal2 to slin16, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2999 cost path from adpcm to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from adpcm to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from adpcm to alaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 4000 cost path from adpcm to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3999 cost path from adpcm to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3999 cost path from adpcm to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2000 cost path from adpcm to g722, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from adpcm to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from adpcm to slin16, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 4000 cost path from slin to slin16, via gsm
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2002 cost path from slin to slin16, via ulaw
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2000 cost path from slin to slin16, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3999 cost path from lpc10 to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from lpc10 to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from lpc10 to alaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 5000 cost path from lpc10 to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from lpc10 to adpcm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 4999 cost path from lpc10 to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from lpc10 to g722, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 4000 cost path from lpc10 to slin16, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from lpc10 to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2999 cost path from g726 to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726 to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726 to alaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 4000 cost path from g726 to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726 to adpcm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3999 cost path from g726 to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2000 cost path from g726 to g722, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from g726 to slin16, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from g726 to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2000 cost path from g722 to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from g722 to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from g722 to alaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3001 cost path from g722 to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from g722 to adpcm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from g722 to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from g722 to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from g722 to testlaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 4000 cost path from slin16 to gsm, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2002 cost path from slin16 to ulaw, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2002 cost path from slin16 to alaw, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 5001 cost path from slin16 to g726aal2, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2002 cost path from slin16 to adpcm, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from slin16 to slin, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 5000 cost path from slin16 to lpc10, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 5000 cost path from slin16 to g726, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2002 cost path from slin16 to testlaw, via g722
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2000 cost path from testlaw to gsm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from testlaw to ulaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from testlaw to alaw, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3001 cost path from testlaw to g726aal2, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2 cost path from testlaw to adpcm, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from testlaw to lpc10, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 3000 cost path from testlaw to g726, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 1001 cost path from testlaw to g722, via slin
[Oct 27 18:11:50] DEBUG[1924] translate.c: Discovered 2001 cost path from testlaw to slin16, via slin
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  codec_a_mu.so => (A-law and Mulaw direct Coder/Decoder)
[Oct 27 18:11:50] VERBOSE[1924] bridging.c:   == Registered bridge technology softmix
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  bridge_softmix.so => (Multi-party software based channel mixing)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'SPRINTF'
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  func_sprintf.so => (SPRINTF dialplan function)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'SRVQUERY'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'SRVRESULT'
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  func_srv.so => (SRV related dialplan functions)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'SYSINFO'
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  func_sysinfo.so => (System information related functions)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'NoCDR'
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  app_cdr.so => (Tell Asterisk to not maintain a CDR for the current call)
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  pbx_loopback.so => (Loopback Switch)
[Oct 27 18:11:50] VERBOSE[1924] config.c:   == Parsing '/etc/asterisk/cli_aliases.conf': [Oct 27 18:11:50] DEBUG[1924] config.c: Parsing /etc/asterisk/cli_aliases.conf
[Oct 27 18:11:50] VERBOSE[1924] config.c:   == Found
[Oct 27 18:11:50] VERBOSE[1924] res_clialiases.c:   == Aliased CLI command 'hangup request' to 'channel request hangup'
[Oct 27 18:11:50] VERBOSE[1924] res_clialiases.c:   == Aliased CLI command 'originate' to 'channel originate'
[Oct 27 18:11:50] VERBOSE[1924] res_clialiases.c:   == Aliased CLI command 'help' to 'core show help'
[Oct 27 18:11:50] VERBOSE[1924] res_clialiases.c:   == Aliased CLI command 'pri intense debug span' to 'pri set debug 2 span'
[Oct 27 18:11:50] VERBOSE[1924] res_clialiases.c:   == Aliased CLI command 'reload' to 'module reload'
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  res_clialiases.so => (CLI Aliases)
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  res_limit.so => (Resource limits)
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Registered context 'app_dial_gosub_virtual_context'(0x857c1c0) in table 0x84e6680 registrar: app_dial
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Registered extension context 'app_dial_gosub_virtual_context'; registrar: app_dial
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 1 to app_dial_gosub_virtual_context (0x857c1c0)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 1 to app_dial_gosub_virtual_context
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'Dial'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'RetryDial'
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  app_dial.so => (Dialing Application)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'VERSION'
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  func_version.so => (Get Asterisk Version/Build Info)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'DBdel'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'DBdeltree'
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  app_db.so => (Database Access Functions)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'Record'
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  app_record.so => (Trivial Record Application)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'GetCPEID'
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  app_getcpeid.so => (Get ADSI CPE ID)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'Read'
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  app_read.so => (Read Variable Application)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'PlayTones'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'StopPlayTones'
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  app_playtones.so => (Playtones Application)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'SHELL'
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  func_shell.so => (Returns the output of a shell command)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'FIELDQTY'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'FIELDNUM'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'FILTER'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'REPLACE'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'LISTFILTER'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'REGEX'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'ARRAY'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'QUOTE'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'CSV_QUOTE'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'LEN'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'STRFTIME'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'STRPTIME'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'EVAL'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'KEYPADHASH'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'HASHKEYS'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'HASH'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'ClearHash'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'TOUPPER'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'TOLOWER'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'SHIFT'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'POP'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'PUSH'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'UNSHIFT'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'PASSTHRU'
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  func_strings.so => (String handling dialplan functions)
[Oct 27 18:11:50] VERBOSE[1924] config.c:   == Parsing '/etc/asterisk/extensions.conf': [Oct 27 18:11:50] DEBUG[1924] config.c: Parsing /etc/asterisk/extensions.conf
[Oct 27 18:11:50] VERBOSE[1924] config.c:   == Found
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Setting global variable 'MYSQL_HOST' to 'localhost'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Setting global variable 'MYSQL_BASE' to 'asterisk'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Setting global variable 'MYSQL_USER' to 'asterisk'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Setting global variable 'MYSQL_PASS' to 'asterisk'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Setting global variable 'SERVER_HOST' to '172.30.8.16'
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Registered context 'default'(0x8594560) in local table 0x8587a38; registrar: pbx_config
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Registered extension context 'default'; registrar: pbx_config
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 1 to default (0x8594560)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 1 to default
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension '_X.' priority 1 to default (0x8594560)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension '_X.' priority 1 to default
[Oct 27 18:11:50] WARNING[1924] pbx_config.c: The use of '_.' for an extension is strongly discouraged and can have unexpected behavior.  Please use '_X.' instead at line 18 of extensions.conf
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension '_.' priority 1 to default (0x8594560)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension '_.' priority 1 to default
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Registered context 'line-context'(0x8599740) in local table 0x8587a38; registrar: pbx_config
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Registered extension context 'line-context'; registrar: pbx_config
[Oct 27 18:11:50] DEBUG[1924] devicestate.c: No provider found, checking channel drivers for SIP - ${EXTEN}
[Oct 27 18:11:50] DEBUG[1924] chan_sip.c: Checking device state for peer ${EXTEN}
[Oct 27 18:11:50] DEBUG[1924] res_config_mysql.c: MySQL RealTime: Connection okay.
[Oct 27 18:11:50] DEBUG[1924] res_config_mysql.c: MySQL RealTime: Retrieve SQL: SELECT * FROM sipfriends WHERE name = '${EXTEN}' AND host = 'dynamic'
[Oct 27 18:11:50] DEBUG[1924] res_config_mysql.c: MySQL RealTime: Connection okay.
[Oct 27 18:11:50] DEBUG[1924] res_config_mysql.c: MySQL RealTime: Retrieve SQL: SELECT * FROM sipfriends WHERE name = '${EXTEN}'
[Oct 27 18:11:50] DEBUG[1924] pbx.c: HINTS: Adding hint _RMT.: SIP/${EXTEN}
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension '_RMT.' priority -1 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension '_RMT.' priority -1 to line-context
[Oct 27 18:11:50] DEBUG[1924] devicestate.c: No provider found, checking channel drivers for SIP - ${EXTEN}
[Oct 27 18:11:50] DEBUG[1924] chan_sip.c: Checking device state for peer ${EXTEN}
[Oct 27 18:11:50] DEBUG[1924] res_config_mysql.c: MySQL RealTime: Connection okay.
[Oct 27 18:11:50] DEBUG[1924] res_config_mysql.c: MySQL RealTime: Retrieve SQL: SELECT * FROM sipfriends WHERE name = '${EXTEN}' AND host = 'dynamic'
[Oct 27 18:11:50] DEBUG[1924] res_config_mysql.c: MySQL RealTime: Connection okay.
[Oct 27 18:11:50] DEBUG[1924] res_config_mysql.c: MySQL RealTime: Retrieve SQL: SELECT * FROM sipfriends WHERE name = '${EXTEN}'
[Oct 27 18:11:50] DEBUG[1924] pbx.c: HINTS: Adding hint _L.: SIP/${EXTEN}
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension '_L.' priority -1 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension '_L.' priority -1 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 'failed' priority 1 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 'failed' priority 1 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 'failed' priority 2 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 'failed' priority 2 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 'h' priority 1 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 'h' priority 1 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 'h' priority 2 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 'h' priority 2 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension '_X.' priority 1 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension '_X.' priority 1 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension '_X.' priority 2 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension '_X.' priority 2 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension '_X.' priority 3 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension '_X.' priority 3 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 1 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 1 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 2 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 2 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 3 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 3 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 4 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 4 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 5 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 5 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 6 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 6 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 7 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 7 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 8 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 8 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 9 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 9 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 10 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 10 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 11 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 11 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 12 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 12 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 13 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 13 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 14 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 14 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 15 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 15 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 16 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 16 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 17 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 17 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 18 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 18 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 19 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 19 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 20 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 20 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 21 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 21 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 22 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 22 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 23 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 23 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 24 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 24 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 25 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 25 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 26 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 26 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 27 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 27 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 28 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 28 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 29 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 29 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 30 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 30 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 31 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 31 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 32 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 32 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 33 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 33 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 34 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 34 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 35 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 35 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 36 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 36 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 37 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 37 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 38 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 38 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 39 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 39 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 40 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 40 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 41 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 41 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 42 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 42 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 43 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 43 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 44 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 44 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 45 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 45 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 46 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 46 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 47 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 47 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 48 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 48 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 49 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 49 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 50 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 50 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 51 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 51 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 52 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 52 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 53 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 53 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 54 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 54 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 55 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 55 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 56 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 56 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 57 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 57 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 58 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 58 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 59 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 59 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 60 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 60 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 61 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 61 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 62 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 62 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 63 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 63 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 64 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 64 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 65 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 65 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 66 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 66 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 67 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 67 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 68 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 68 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 69 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 69 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 70 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 70 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 71 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 71 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 72 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 72 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 73 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 73 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 74 to line-context (0x8599740)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 74 to line-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Registered context 'rmt-context'(0x859d3f8) in local table 0x8587a38; registrar: pbx_config
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Registered extension context 'rmt-context'; registrar: pbx_config
[Oct 27 18:11:50] DEBUG[1924] devicestate.c: No provider found, checking channel drivers for SIP - ${EXTEN}
[Oct 27 18:11:50] DEBUG[1924] chan_sip.c: Checking device state for peer ${EXTEN}
[Oct 27 18:11:50] DEBUG[1924] res_config_mysql.c: MySQL RealTime: Connection okay.
[Oct 27 18:11:50] DEBUG[1924] res_config_mysql.c: MySQL RealTime: Retrieve SQL: SELECT * FROM sipfriends WHERE name = '${EXTEN}' AND host = 'dynamic'
[Oct 27 18:11:50] DEBUG[1924] res_config_mysql.c: MySQL RealTime: Connection okay.
[Oct 27 18:11:50] DEBUG[1924] res_config_mysql.c: MySQL RealTime: Retrieve SQL: SELECT * FROM sipfriends WHERE name = '${EXTEN}'
[Oct 27 18:11:50] DEBUG[1924] pbx.c: HINTS: Adding hint _RMT.: SIP/${EXTEN}
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension '_RMT.' priority -1 to rmt-context (0x859d3f8)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension '_RMT.' priority -1 to rmt-context
[Oct 27 18:11:50] DEBUG[1924] devicestate.c: No provider found, checking channel drivers for SIP - ${EXTEN}
[Oct 27 18:11:50] DEBUG[1924] chan_sip.c: Checking device state for peer ${EXTEN}
[Oct 27 18:11:50] DEBUG[1924] res_config_mysql.c: MySQL RealTime: Connection okay.
[Oct 27 18:11:50] DEBUG[1924] res_config_mysql.c: MySQL RealTime: Retrieve SQL: SELECT * FROM sipfriends WHERE name = '${EXTEN}' AND host = 'dynamic'
[Oct 27 18:11:50] DEBUG[1924] res_config_mysql.c: MySQL RealTime: Connection okay.
[Oct 27 18:11:50] DEBUG[1924] res_config_mysql.c: MySQL RealTime: Retrieve SQL: SELECT * FROM sipfriends WHERE name = '${EXTEN}'
[Oct 27 18:11:50] DEBUG[1924] pbx.c: HINTS: Adding hint _L.: SIP/${EXTEN}
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension '_L.' priority -1 to rmt-context (0x859d3f8)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension '_L.' priority -1 to rmt-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 1 to rmt-context (0x859d3f8)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 1 to rmt-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 2 to rmt-context (0x859d3f8)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 2 to rmt-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 3 to rmt-context (0x859d3f8)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 3 to rmt-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 4 to rmt-context (0x859d3f8)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 4 to rmt-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 5 to rmt-context (0x859d3f8)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 5 to rmt-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 6 to rmt-context (0x859d3f8)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 6 to rmt-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 7 to rmt-context (0x859d3f8)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 7 to rmt-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 8 to rmt-context (0x859d3f8)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 8 to rmt-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 9 to rmt-context (0x859d3f8)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 9 to rmt-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 10 to rmt-context (0x859d3f8)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 10 to rmt-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 11 to rmt-context (0x859d3f8)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 11 to rmt-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 12 to rmt-context (0x859d3f8)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 12 to rmt-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 13 to rmt-context (0x859d3f8)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 13 to rmt-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 14 to rmt-context (0x859d3f8)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 14 to rmt-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 15 to rmt-context (0x859d3f8)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 15 to rmt-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 16 to rmt-context (0x859d3f8)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 16 to rmt-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 17 to rmt-context (0x859d3f8)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 17 to rmt-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 18 to rmt-context (0x859d3f8)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 18 to rmt-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 19 to rmt-context (0x859d3f8)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 19 to rmt-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 20 to rmt-context (0x859d3f8)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 20 to rmt-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 21 to rmt-context (0x859d3f8)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 21 to rmt-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 22 to rmt-context (0x859d3f8)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 22 to rmt-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 23 to rmt-context (0x859d3f8)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 23 to rmt-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 24 to rmt-context (0x859d3f8)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 24 to rmt-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 25 to rmt-context (0x859d3f8)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 25 to rmt-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 26 to rmt-context (0x859d3f8)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 26 to rmt-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 27 to rmt-context (0x859d3f8)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 27 to rmt-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 28 to rmt-context (0x859d3f8)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 28 to rmt-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 29 to rmt-context (0x859d3f8)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 29 to rmt-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 30 to rmt-context (0x859d3f8)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 30 to rmt-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 31 to rmt-context (0x859d3f8)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 31 to rmt-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 32 to rmt-context (0x859d3f8)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 32 to rmt-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 33 to rmt-context (0x859d3f8)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 33 to rmt-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 34 to rmt-context (0x859d3f8)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 34 to rmt-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 35 to rmt-context (0x859d3f8)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 35 to rmt-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 36 to rmt-context (0x859d3f8)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 36 to rmt-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 37 to rmt-context (0x859d3f8)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 37 to rmt-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 38 to rmt-context (0x859d3f8)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 38 to rmt-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 39 to rmt-context (0x859d3f8)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 39 to rmt-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 40 to rmt-context (0x859d3f8)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 40 to rmt-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 41 to rmt-context (0x859d3f8)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 41 to rmt-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 42 to rmt-context (0x859d3f8)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 42 to rmt-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 43 to rmt-context (0x859d3f8)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 43 to rmt-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 'h' priority 1 to rmt-context (0x859d3f8)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 'h' priority 1 to rmt-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 'h' priority 2 to rmt-context (0x859d3f8)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 'h' priority 2 to rmt-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Registered context 'noop-context'(0x859f6f0) in local table 0x8587a38; registrar: pbx_config
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Registered extension context 'noop-context'; registrar: pbx_config
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 1 to noop-context (0x859f6f0)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 1 to noop-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension '_X.' priority 1 to noop-context (0x859f6f0)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension '_X.' priority 1 to noop-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 'i' priority 1 to noop-context (0x859f6f0)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 'i' priority 1 to noop-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 'h' priority 1 to noop-context (0x859f6f0)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 'h' priority 1 to noop-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 'failed' priority 1 to noop-context (0x859f6f0)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 'failed' priority 1 to noop-context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Registered context 'app_dial_gosub_virtual_context'(0x85a0028) in local table 0x8587a38; registrar: app_dial
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Registered extension context 'app_dial_gosub_virtual_context'; registrar: app_dial
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- merging incls/swits/igpats from old(app_dial_gosub_virtual_context) to new(app_dial_gosub_virtual_context) context, registrar = pbx_config
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension 's' priority 1 to app_dial_gosub_virtual_context (0x85a0028)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension 's' priority 1 to app_dial_gosub_virtual_context
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Registered context 'parkedcalls'(0x8594708) in local table 0x8587a38; registrar: features
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Registered extension context 'parkedcalls'; registrar: features
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- merging incls/swits/igpats from old(parkedcalls) to new(parkedcalls) context, registrar = pbx_config
[Oct 27 18:11:50] DEBUG[1924] pbx.c: Added extension '700' priority 1 to parkedcalls (0x8594708)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Added extension '700' priority 1 to parkedcalls
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Time to scan old dialplan and merge leftovers back into the new: 0.000604 sec
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Time to restore hints and swap in new dialplan: 0.000006 sec
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Time to delete the old dialplan: 0.000005 sec
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:     -- Total time merge_contexts_delete: 0.000615 sec
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  pbx_config.so => (Text Extension Configuration)
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  res_convert.so => (File format conversion CLI command)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'RAND'
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  func_rand.so => (Random number dialplan function)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'Originate'
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  app_originate.so => (Originate call)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'Exec'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'TryExec'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered application 'ExecIf'
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  app_exec.so => (Executes dialplan applications)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'SHA1'
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  func_sha1.so => (SHA-1 computation dialplan function)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'VOLUME'
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  func_volume.so => (Technology independent volume control)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'IFMODULE'
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  func_module.so => (Checks if Asterisk module is loaded in memory)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'REALTIME'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'REALTIME_STORE'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'REALTIME_DESTROY'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'REALTIME_FIELD'
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'REALTIME_HASH'
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  func_realtime.so => (Read/Write/Store/Destroy values from a RealTime repository)
[Oct 27 18:11:50] VERBOSE[1924] pbx.c:   == Registered custom function 'MD5'
[Oct 27 18:11:50] VERBOSE[1924] loader.c:  func_md5.so => (MD5 digest dialplan functions)
[Oct 27 18:11:50] VERBOSE[1924] config.c:   == Parsing '/etc/asterisk/cli_permissions.conf': [Oct 27 18:11:50] DEBUG[1924] config.c: Parsing /etc/asterisk/cli_permissions.conf
[Oct 27 18:11:50] VERBOSE[1924] config.c:   == Found
[Oct 27 18:11:50] VERBOSE[1924] asterisk.c: Asterisk Ready.
[Oct 27 18:11:50] VERBOSE[1924] config.c:   == Parsing '/etc/asterisk/cli.conf': [Oct 27 18:11:50] DEBUG[1924] config.c: Parsing /etc/asterisk/cli.conf
[Oct 27 18:11:50] VERBOSE[1924] config.c:   == Found
[Oct 27 18:11:53] VERBOSE[1938] chan_sip.c: 
<--- SIP read from UDP:172.30.8.18:5060 --->
REGISTER sip:172.30.8.13:5060 SIP/2.0
v:SIP/2.0/UDP 172.30.8.18:5060;branch=z9hG4bKd01b4ff29be63975
f:"L6" <sip:L6@172.30.8.13:5060>;tag=6b19d1aa-686550
t:"L6" <sip:L6@172.30.8.13:5060>
i:BD2F-1923-4668481755EB6C5442AE-001@SipHost
CSeq:225 REGISTER
m:<sip:L6@172.30.8.18:5060>
Expires:0
Max-Forwards:70
User-Agent:dlink 12-36-9924913
l:0

<------------->
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c:  Header  0 [ 37]: REGISTER sip:172.30.8.13:5060 SIP/2.0
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c:  Header  1 [ 61]: v:SIP/2.0/UDP 172.30.8.18:5060;branch=z9hG4bKd01b4ff29be63975
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c:  Header  2 [ 52]: f:"L6" <sip:L6@172.30.8.13:5060>;tag=6b19d1aa-686550
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c:  Header  3 [ 32]: t:"L6" <sip:L6@172.30.8.13:5060>
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c:  Header  4 [ 44]: i:BD2F-1923-4668481755EB6C5442AE-001@SipHost
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c:  Header  5 [ 17]: CSeq:225 REGISTER
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c:  Header  6 [ 27]: m:<sip:L6@172.30.8.18:5060>
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c:  Header  7 [  9]: Expires:0
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c:  Header  8 [ 15]: Max-Forwards:70
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c:  Header  9 [ 30]: User-Agent:dlink 12-36-9924913
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c:  Header 10 [  3]: l:0
[Oct 27 18:11:53] VERBOSE[1938] chan_sip.c: --- (11 headers 0 lines) ---
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c: = Looking for  Call ID: BD2F-1923-4668481755EB6C5442AE-001@SipHost (Checking From) --From tag 6b19d1aa-686550 --To-tag   
[Oct 27 18:11:53] DEBUG[1938] acl.c: For destination '172.30.8.18', our source address is '172.30.8.13'.
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c: Setting SIP_TRANSPORT_UDP with address 172.30.8.13:5060
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c: Allocating new SIP dialog for BD2F-1923-4668481755EB6C5442AE-001@SipHost - REGISTER (No RTP)
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c: **** Received REGISTER (2) - Command in SIP REGISTER
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c: Initializing initreq for method REGISTER - callid BD2F-1923-4668481755EB6C5442AE-001@SipHost
[Oct 27 18:11:53] DEBUG[1938] netsock2.c: Splitting '172.30.8.18:5060' into...
[Oct 27 18:11:53] DEBUG[1938] netsock2.c: ...host '172.30.8.18' and port '5060'.
[Oct 27 18:11:53] VERBOSE[1938] chan_sip.c: Sending to 172.30.8.18:5060 (no NAT)
[Oct 27 18:11:53] DEBUG[1938] res_config_mysql.c: MySQL RealTime: Connection okay.
[Oct 27 18:11:53] DEBUG[1938] res_config_mysql.c: MySQL RealTime: Retrieve SQL: SELECT * FROM sipfriends WHERE name = 'L6' AND host = 'dynamic'
[Oct 27 18:11:53] DEBUG[1938] netsock2.c: Splitting '(null)' into...
[Oct 27 18:11:53] DEBUG[1938] netsock2.c: ...host '(null)' and port ''.
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c: Not an IPv4 nor IPv6 address, cannot get port.
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c: Not an IPv4 nor IPv6 address, cannot set port.
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c: Not an IPv4 nor IPv6 address, cannot get port.
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c: Not an IPv4 nor IPv6 address, cannot set port.
[Oct 27 18:11:53] DEBUG[1938] db.c: Unable to find key 'L6' in family 'SIP/Registry'
[Oct 27 18:11:53] DEBUG[1938] db.c: Unable to find key 'L6' in family 'SIP/PeerMethods'
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c: Bah, we're expired (680/1319727633/1319728313)!
[Oct 27 18:11:53] DEBUG[1938] db.c: Unable to find key 'L6' in family 'SIP/Registry'
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c: -REALTIME- loading peer from database to memory. Name: L6. Peer objects: 0
[Oct 27 18:11:53] NOTICE[1938] chan_sip.c: NEW NONCE `2fb0cf42` FOR PVT `u:,p:,a:,n:`
[Oct 27 18:11:53] VERBOSE[1938] chan_sip.c: 
<--- Transmitting (no NAT) to 172.30.8.18:5060 --->
SIP/2.0 401 Unauthorized
Via: SIP/2.0/UDP 172.30.8.18:5060;branch=z9hG4bKd01b4ff29be63975;received=172.30.8.18
From: "L6" <sip:L6@172.30.8.13:5060>;tag=6b19d1aa-686550
To: "L6" <sip:L6@172.30.8.13:5060>;tag=as0d9e932c
Call-ID: BD2F-1923-4668481755EB6C5442AE-001@SipHost
CSeq: 225 REGISTER
Server: Asterisk PBX
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
WWW-Authenticate: Digest algorithm=MD5, realm="asterisk", nonce="2fb0cf42"
Content-Length: 0


<------------>
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c: Trying to put 'SIP/2.0 401' onto UDP socket destined for 172.30.8.18:5060
[Oct 27 18:11:53] VERBOSE[1938] chan_sip.c: Scheduling destruction of SIP dialog 'BD2F-1923-4668481755EB6C5442AE-001@SipHost' in 32000 ms (Method: REGISTER)
[Oct 27 18:11:53] VERBOSE[1938] chan_sip.c: 
<--- SIP read from UDP:172.30.8.18:5060 --->
REGISTER sip:172.30.8.13:5060 SIP/2.0
v:SIP/2.0/UDP 172.30.8.18:5060;branch=z9hG4bKab1567563bf3488b
f:"L6" <sip:L6@172.30.8.13:5060>;tag=6b19d1aa-686550
t:"L6" <sip:L6@172.30.8.13:5060>
i:BD2F-1923-4668481755EB6C5442AE-001@SipHost
CSeq:226 REGISTER
m:<sip:L6@172.30.8.18:5060>
Expires:0
Max-Forwards:70
Authorization:Digest username="L6",realm="asterisk",nonce="2fb0cf42",uri="sip:172.30.8.13:5060",response="d45194d84a25f3d7709c8f86d2e593e4",algorithm=MD5
User-Agent:dlink 12-36-9924913
l:0

<------------->
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c:  Header  0 [ 37]: REGISTER sip:172.30.8.13:5060 SIP/2.0
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c:  Header  1 [ 61]: v:SIP/2.0/UDP 172.30.8.18:5060;branch=z9hG4bKab1567563bf3488b
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c:  Header  2 [ 52]: f:"L6" <sip:L6@172.30.8.13:5060>;tag=6b19d1aa-686550
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c:  Header  3 [ 32]: t:"L6" <sip:L6@172.30.8.13:5060>
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c:  Header  4 [ 44]: i:BD2F-1923-4668481755EB6C5442AE-001@SipHost
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c:  Header  5 [ 17]: CSeq:226 REGISTER
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c:  Header  6 [ 27]: m:<sip:L6@172.30.8.18:5060>
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c:  Header  7 [  9]: Expires:0
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c:  Header  8 [ 15]: Max-Forwards:70
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c:  Header  9 [153]: Authorization:Digest username="L6",realm="asterisk",nonce="2fb0cf42",uri="sip:172.30.8.13:5060",response="d45194d84a25f3d7709c8f86d2e593e4",algorithm=MD5
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c:  Header 10 [ 30]: User-Agent:dlink 12-36-9924913
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c:  Header 11 [  3]: l:0
[Oct 27 18:11:53] VERBOSE[1938] chan_sip.c: --- (12 headers 0 lines) ---
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c: = Looking for  Call ID: BD2F-1923-4668481755EB6C5442AE-001@SipHost (Checking From) --From tag 6b19d1aa-686550 --To-tag   
[Oct 27 18:11:53] DEBUG[1938] netsock2.c: Splitting '172.30.8.13:5060' into...
[Oct 27 18:11:53] DEBUG[1938] netsock2.c: ...host '172.30.8.13' and port '5060'.
[Oct 27 18:11:53] DEBUG[1938] netsock2.c: Splitting '172.30.8.13:5060' into...
[Oct 27 18:11:53] DEBUG[1938] netsock2.c: ...host '172.30.8.13' and port '5060'.
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c: **** Received REGISTER (2) - Command in SIP REGISTER
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c: Initializing initreq for method REGISTER - callid BD2F-1923-4668481755EB6C5442AE-001@SipHost
[Oct 27 18:11:53] DEBUG[1938] netsock2.c: Splitting '172.30.8.18:5060' into...
[Oct 27 18:11:53] DEBUG[1938] netsock2.c: ...host '172.30.8.18' and port '5060'.
[Oct 27 18:11:53] VERBOSE[1938] chan_sip.c: Sending to 172.30.8.18:5060 (no NAT)
[Oct 27 18:11:53] WARNING[1938] chan_sip.c: MARKED NONCE `2fb0cf42` STALED(sip:172.30.8.13:5060)
[Oct 27 18:11:53] VERBOSE[1938] chan_sip.c:     -- Unregistered SIP 'L6'
[Oct 27 18:11:53] DEBUG[1938] db.c: Unable to find key 'L6' in family 'SIP/Registry'
[Oct 27 18:11:53] DEBUG[1938] db.c: Unable to find key 'L6' in family 'SIP/PeerMethods'
[Oct 27 18:11:53] DEBUG[1931] devicestate.c: No provider found, checking channel drivers for SIP - L6
[Oct 27 18:11:53] DEBUG[1931] chan_sip.c: Checking device state for peer L6
[Oct 27 18:11:53] DEBUG[1931] devicestate.c: Changing state for SIP/L6 - state 5 (Unavailable)
[Oct 27 18:11:53] DEBUG[1931] devicestate.c: device 'SIP/L6' state '5'
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c: -REALTIME- peer expired registration. Name: L6. Realtime peer objects now 0
[Oct 27 18:11:53] DEBUG[1938] res_config_mysql.c: MySQL RealTime: Connection okay.
[Oct 27 18:11:53] DEBUG[1938] res_config_mysql.c: MySQL RealTime: Update SQL: UPDATE sipfriends SET `ipaddr` = '(null)', `port` = '(null)', `regseconds` = '1319728313', `defaultuser` = 'L6', `useragent` = '', `lastms` = '-1', `fullcontact` = '' WHERE `name` = 'L6'
[Oct 27 18:11:53] DEBUG[1938] res_config_mysql.c: MySQL RealTime: Updated 1 rows on table: sipfriends
[Oct 27 18:11:53] VERBOSE[1938] chan_sip.c: 
<--- Transmitting (no NAT) to 172.30.8.18:5060 --->
SIP/2.0 200 OK
Via: SIP/2.0/UDP 172.30.8.18:5060;branch=z9hG4bKab1567563bf3488b;received=172.30.8.18
From: "L6" <sip:L6@172.30.8.13:5060>;tag=6b19d1aa-686550
To: "L6" <sip:L6@172.30.8.13:5060>;tag=as0d9e932c
Call-ID: BD2F-1923-4668481755EB6C5442AE-001@SipHost
CSeq: 226 REGISTER
Server: Asterisk PBX
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Expires: 0
Date: Thu, 27 Oct 2011 15:11:53 GMT
Content-Length: 0


<------------>
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c: Trying to put 'SIP/2.0 200' onto UDP socket destined for 172.30.8.18:5060
[Oct 27 18:11:53] DEBUG[1931] devicestate.c: No provider found, checking channel drivers for SIP - L6
[Oct 27 18:11:53] DEBUG[1931] chan_sip.c: Checking device state for peer L6
[Oct 27 18:11:53] DEBUG[1931] devicestate.c: Changing state for SIP/L6 - state 5 (Unavailable)
[Oct 27 18:11:53] DEBUG[1931] devicestate.c: device 'SIP/L6' state '5'
[Oct 27 18:11:53] VERBOSE[1938] chan_sip.c: Scheduling destruction of SIP dialog 'BD2F-1923-4668481755EB6C5442AE-001@SipHost' in 32000 ms (Method: REGISTER)
[Oct 27 18:11:53] VERBOSE[1938] chan_sip.c: 
<--- SIP read from UDP:172.30.8.18:5060 --->
REGISTER sip:172.30.8.13:5060 SIP/2.0
v:SIP/2.0/UDP 172.30.8.18:5060;branch=z9hG4bK246a52e0a6a9d7d0
f:"L6" <sip:L6@172.30.8.13:5060>;tag=9c8164ac-686558
t:"L6" <sip:L6@172.30.8.13:5060>
i:BD2F-1923-4668481755EB6C5442AE-001@SipHost
CSeq:227 REGISTER
m:<sip:L6@172.30.8.18:5060>
Expires:600
Max-Forwards:70
User-Agent:dlink 12-36-9924913
l:0

<------------->
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c:  Header  0 [ 37]: REGISTER sip:172.30.8.13:5060 SIP/2.0
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c:  Header  1 [ 61]: v:SIP/2.0/UDP 172.30.8.18:5060;branch=z9hG4bK246a52e0a6a9d7d0
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c:  Header  2 [ 52]: f:"L6" <sip:L6@172.30.8.13:5060>;tag=9c8164ac-686558
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c:  Header  3 [ 32]: t:"L6" <sip:L6@172.30.8.13:5060>
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c:  Header  4 [ 44]: i:BD2F-1923-4668481755EB6C5442AE-001@SipHost
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c:  Header  5 [ 17]: CSeq:227 REGISTER
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c:  Header  6 [ 27]: m:<sip:L6@172.30.8.18:5060>
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c:  Header  7 [ 11]: Expires:600
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c:  Header  8 [ 15]: Max-Forwards:70
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c:  Header  9 [ 30]: User-Agent:dlink 12-36-9924913
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c:  Header 10 [  3]: l:0
[Oct 27 18:11:53] VERBOSE[1938] chan_sip.c: --- (11 headers 0 lines) ---
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c: = Looking for  Call ID: BD2F-1923-4668481755EB6C5442AE-001@SipHost (Checking From) --From tag 9c8164ac-686558 --To-tag   
[Oct 27 18:11:53] DEBUG[1938] acl.c: For destination '172.30.8.18', our source address is '172.30.8.13'.
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c: Setting SIP_TRANSPORT_UDP with address 172.30.8.13:5060
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c: Allocating new SIP dialog for BD2F-1923-4668481755EB6C5442AE-001@SipHost - REGISTER (No RTP)
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c: **** Received REGISTER (2) - Command in SIP REGISTER
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c: Initializing initreq for method REGISTER - callid BD2F-1923-4668481755EB6C5442AE-001@SipHost
[Oct 27 18:11:53] DEBUG[1938] netsock2.c: Splitting '172.30.8.18:5060' into...
[Oct 27 18:11:53] DEBUG[1938] netsock2.c: ...host '172.30.8.18' and port '5060'.
[Oct 27 18:11:53] VERBOSE[1938] chan_sip.c: Sending to 172.30.8.18:5060 (no NAT)
[Oct 27 18:11:53] NOTICE[1938] chan_sip.c: NEW NONCE `4dbd1cf9` FOR PVT `u:,p:,a:,n:`
[Oct 27 18:11:53] VERBOSE[1938] chan_sip.c: 
<--- Transmitting (no NAT) to 172.30.8.18:5060 --->
SIP/2.0 401 Unauthorized
Via: SIP/2.0/UDP 172.30.8.18:5060;branch=z9hG4bK246a52e0a6a9d7d0;received=172.30.8.18
From: "L6" <sip:L6@172.30.8.13:5060>;tag=9c8164ac-686558
To: "L6" <sip:L6@172.30.8.13:5060>;tag=as3136358a
Call-ID: BD2F-1923-4668481755EB6C5442AE-001@SipHost
CSeq: 227 REGISTER
Server: Asterisk PBX
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
WWW-Authenticate: Digest algorithm=MD5, realm="asterisk", nonce="4dbd1cf9"
Content-Length: 0


<------------>
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c: Trying to put 'SIP/2.0 401' onto UDP socket destined for 172.30.8.18:5060
[Oct 27 18:11:53] VERBOSE[1938] chan_sip.c: Scheduling destruction of SIP dialog 'BD2F-1923-4668481755EB6C5442AE-001@SipHost' in 32000 ms (Method: REGISTER)
[Oct 27 18:11:53] VERBOSE[1938] chan_sip.c: 
<--- SIP read from UDP:172.30.8.18:5060 --->
REGISTER sip:172.30.8.13:5060 SIP/2.0
v:SIP/2.0/UDP 172.30.8.18:5060;branch=z9hG4bKd15b83a72b7dacf6
f:"L6" <sip:L6@172.30.8.13:5060>;tag=9c8164ac-686558
t:"L6" <sip:L6@172.30.8.13:5060>
i:BD2F-1923-4668481755EB6C5442AE-001@SipHost
CSeq:228 REGISTER
m:<sip:L6@172.30.8.18:5060>
Expires:600
Max-Forwards:70
Authorization:Digest username="L6",realm="asterisk",nonce="4dbd1cf9",uri="sip:172.30.8.13:5060",response="18bb45738ad3abc1b58c15a799797a09",algorithm=MD5
User-Agent:dlink 12-36-9924913
l:0

<------------->
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c:  Header  0 [ 37]: REGISTER sip:172.30.8.13:5060 SIP/2.0
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c:  Header  1 [ 61]: v:SIP/2.0/UDP 172.30.8.18:5060;branch=z9hG4bKd15b83a72b7dacf6
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c:  Header  2 [ 52]: f:"L6" <sip:L6@172.30.8.13:5060>;tag=9c8164ac-686558
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c:  Header  3 [ 32]: t:"L6" <sip:L6@172.30.8.13:5060>
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c:  Header  4 [ 44]: i:BD2F-1923-4668481755EB6C5442AE-001@SipHost
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c:  Header  5 [ 17]: CSeq:228 REGISTER
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c:  Header  6 [ 27]: m:<sip:L6@172.30.8.18:5060>
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c:  Header  7 [ 11]: Expires:600
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c:  Header  8 [ 15]: Max-Forwards:70
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c:  Header  9 [153]: Authorization:Digest username="L6",realm="asterisk",nonce="4dbd1cf9",uri="sip:172.30.8.13:5060",response="18bb45738ad3abc1b58c15a799797a09",algorithm=MD5
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c:  Header 10 [ 30]: User-Agent:dlink 12-36-9924913
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c:  Header 11 [  3]: l:0
[Oct 27 18:11:53] VERBOSE[1938] chan_sip.c: --- (12 headers 0 lines) ---
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c: = Looking for  Call ID: BD2F-1923-4668481755EB6C5442AE-001@SipHost (Checking From) --From tag 9c8164ac-686558 --To-tag   
[Oct 27 18:11:53] DEBUG[1938] netsock2.c: Splitting '172.30.8.13:5060' into...
[Oct 27 18:11:53] DEBUG[1938] netsock2.c: ...host '172.30.8.13' and port '5060'.
[Oct 27 18:11:53] DEBUG[1938] netsock2.c: Splitting '172.30.8.13:5060' into...
[Oct 27 18:11:53] DEBUG[1938] netsock2.c: ...host '172.30.8.13' and port '5060'.
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c: **** Received REGISTER (2) - Command in SIP REGISTER
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c: Initializing initreq for method REGISTER - callid BD2F-1923-4668481755EB6C5442AE-001@SipHost
[Oct 27 18:11:53] DEBUG[1938] netsock2.c: Splitting '172.30.8.18:5060' into...
[Oct 27 18:11:53] DEBUG[1938] netsock2.c: ...host '172.30.8.18' and port '5060'.
[Oct 27 18:11:53] VERBOSE[1938] chan_sip.c: Sending to 172.30.8.18:5060 (no NAT)
[Oct 27 18:11:53] ERROR[1938] chan_sip.c: WRONG NONCE: EXPECTED '2fb0cf42' BUT GOT '4dbd1cf9' stale=1
[Oct 27 18:11:53] NOTICE[1938] chan_sip.c: Correct auth, but based on stale nonce received from '"L6" <sip:L6@172.30.8.13:5060>;tag=9c8164ac-686558'
[Oct 27 18:11:53] NOTICE[1938] chan_sip.c: NEW NONCE `04d04d13` FOR PVT `u:,p:,a:,n:`
[Oct 27 18:11:53] ERROR[1938] chan_sip.c: NEW RANDDATA=`04d04d13`
[Oct 27 18:11:53] VERBOSE[1938] chan_sip.c: 
<--- Transmitting (no NAT) to 172.30.8.18:5060 --->
SIP/2.0 401 Unauthorized
Via: SIP/2.0/UDP 172.30.8.18:5060;branch=z9hG4bKd15b83a72b7dacf6;received=172.30.8.18
From: "L6" <sip:L6@172.30.8.13:5060>;tag=9c8164ac-686558
To: "L6" <sip:L6@172.30.8.13:5060>;tag=as0d9e932c
Call-ID: BD2F-1923-4668481755EB6C5442AE-001@SipHost
CSeq: 228 REGISTER
Server: Asterisk PBX
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
WWW-Authenticate: Digest algorithm=MD5, realm="asterisk", nonce="04d04d13", stale=true
Content-Length: 0


<------------>
[Oct 27 18:11:53] DEBUG[1938] chan_sip.c: Trying to put 'SIP/2.0 401' onto UDP socket destined for 172.30.8.18:5060
[Oct 27 18:11:53] VERBOSE[1938] chan_sip.c: Scheduling destruction of SIP dialog 'BD2F-1923-4668481755EB6C5442AE-001@SipHost' in 32000 ms (Method: REGISTER)
[Oct 27 18:12:14] VERBOSE[1938] chan_sip.c: 
<--- SIP read from UDP:172.30.8.18:5060 --->
REGISTER sip:172.30.8.13:5060 SIP/2.0
v:SIP/2.0/UDP 172.30.8.18:5060;branch=z9hG4bK93a797e7c8dc8a76
f:"L6" <sip:L6@172.30.8.13:5060>;tag=3cdbb650-686579
t:"L6" <sip:L6@172.30.8.13:5060>
i:BD2F-1923-4668481755EB6C5442AE-001@SipHost
CSeq:230 REGISTER
m:<sip:L6@172.30.8.18:5060>
Expires:0
Max-Forwards:70
User-Agent:dlink 12-36-9924913
l:0

<------------->
[Oct 27 18:12:14] DEBUG[1938] chan_sip.c:  Header  0 [ 37]: REGISTER sip:172.30.8.13:5060 SIP/2.0
[Oct 27 18:12:14] DEBUG[1938] chan_sip.c:  Header  1 [ 61]: v:SIP/2.0/UDP 172.30.8.18:5060;branch=z9hG4bK93a797e7c8dc8a76
[Oct 27 18:12:14] DEBUG[1938] chan_sip.c:  Header  2 [ 52]: f:"L6" <sip:L6@172.30.8.13:5060>;tag=3cdbb650-686579
[Oct 27 18:12:14] DEBUG[1938] chan_sip.c:  Header  3 [ 32]: t:"L6" <sip:L6@172.30.8.13:5060>
[Oct 27 18:12:14] DEBUG[1938] chan_sip.c:  Header  4 [ 44]: i:BD2F-1923-4668481755EB6C5442AE-001@SipHost
[Oct 27 18:12:14] DEBUG[1938] chan_sip.c:  Header  5 [ 17]: CSeq:230 REGISTER
[Oct 27 18:12:14] DEBUG[1938] chan_sip.c:  Header  6 [ 27]: m:<sip:L6@172.30.8.18:5060>
[Oct 27 18:12:14] DEBUG[1938] chan_sip.c:  Header  7 [  9]: Expires:0
[Oct 27 18:12:14] DEBUG[1938] chan_sip.c:  Header  8 [ 15]: Max-Forwards:70
[Oct 27 18:12:14] DEBUG[1938] chan_sip.c:  Header  9 [ 30]: User-Agent:dlink 12-36-9924913
[Oct 27 18:12:14] DEBUG[1938] chan_sip.c:  Header 10 [  3]: l:0
[Oct 27 18:12:14] VERBOSE[1938] chan_sip.c: --- (11 headers 0 lines) ---
[Oct 27 18:12:14] DEBUG[1938] chan_sip.c: = Looking for  Call ID: BD2F-1923-4668481755EB6C5442AE-001@SipHost (Checking From) --From tag 3cdbb650-686579 --To-tag   
[Oct 27 18:12:14] DEBUG[1938] acl.c: For destination '172.30.8.18', our source address is '172.30.8.13'.
[Oct 27 18:12:14] DEBUG[1938] chan_sip.c: Setting SIP_TRANSPORT_UDP with address 172.30.8.13:5060
[Oct 27 18:12:14] DEBUG[1938] chan_sip.c: Allocating new SIP dialog for BD2F-1923-4668481755EB6C5442AE-001@SipHost - REGISTER (No RTP)
[Oct 27 18:12:14] DEBUG[1938] chan_sip.c: **** Received REGISTER (2) - Command in SIP REGISTER
[Oct 27 18:12:14] DEBUG[1938] chan_sip.c: Initializing initreq for method REGISTER - callid BD2F-1923-4668481755EB6C5442AE-001@SipHost
[Oct 27 18:12:14] DEBUG[1938] netsock2.c: Splitting '172.30.8.18:5060' into...
[Oct 27 18:12:14] DEBUG[1938] netsock2.c: ...host '172.30.8.18' and port '5060'.
[Oct 27 18:12:14] VERBOSE[1938] chan_sip.c: Sending to 172.30.8.18:5060 (no NAT)
[Oct 27 18:12:14] NOTICE[1938] chan_sip.c: NEW NONCE `71c7792a` FOR PVT `u:,p:,a:,n:`
[Oct 27 18:12:14] VERBOSE[1938] chan_sip.c: 
<--- Transmitting (no NAT) to 172.30.8.18:5060 --->
SIP/2.0 401 Unauthorized
Via: SIP/2.0/UDP 172.30.8.18:5060;branch=z9hG4bK93a797e7c8dc8a76;received=172.30.8.18
From: "L6" <sip:L6@172.30.8.13:5060>;tag=3cdbb650-686579
To: "L6" <sip:L6@172.30.8.13:5060>;tag=as08034e83
Call-ID: BD2F-1923-4668481755EB6C5442AE-001@SipHost
CSeq: 230 REGISTER
Server: Asterisk PBX
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
WWW-Authenticate: Digest algorithm=MD5, realm="asterisk", nonce="71c7792a"
Content-Length: 0


<------------>
[Oct 27 18:12:14] DEBUG[1938] chan_sip.c: Trying to put 'SIP/2.0 401' onto UDP socket destined for 172.30.8.18:5060
[Oct 27 18:12:14] VERBOSE[1938] chan_sip.c: Scheduling destruction of SIP dialog 'BD2F-1923-4668481755EB6C5442AE-001@SipHost' in 32000 ms (Method: REGISTER)
[Oct 27 18:12:14] VERBOSE[1938] chan_sip.c: 
<--- SIP read from UDP:172.30.8.18:5060 --->
REGISTER sip:172.30.8.13:5060 SIP/2.0
v:SIP/2.0/UDP 172.30.8.18:5060;branch=z9hG4bK2dd42492c1b9ecdd
f:"L6" <sip:L6@172.30.8.13:5060>;tag=3cdbb650-686579
t:"L6" <sip:L6@172.30.8.13:5060>
i:BD2F-1923-4668481755EB6C5442AE-001@SipHost
CSeq:231 REGISTER
m:<sip:L6@172.30.8.18:5060>
Expires:0
Max-Forwards:70
Authorization:Digest username="L6",realm="asterisk",nonce="71c7792a",uri="sip:172.30.8.13:5060",response="4c870d221d0080a3887185b0ba7cd6c9",algorithm=MD5
User-Agent:dlink 12-36-9924913
l:0

<------------->
[Oct 27 18:12:14] DEBUG[1938] chan_sip.c:  Header  0 [ 37]: REGISTER sip:172.30.8.13:5060 SIP/2.0
[Oct 27 18:12:14] DEBUG[1938] chan_sip.c:  Header  1 [ 61]: v:SIP/2.0/UDP 172.30.8.18:5060;branch=z9hG4bK2dd42492c1b9ecdd
[Oct 27 18:12:14] DEBUG[1938] chan_sip.c:  Header  2 [ 52]: f:"L6" <sip:L6@172.30.8.13:5060>;tag=3cdbb650-686579
[Oct 27 18:12:14] DEBUG[1938] chan_sip.c:  Header  3 [ 32]: t:"L6" <sip:L6@172.30.8.13:5060>
[Oct 27 18:12:14] DEBUG[1938] chan_sip.c:  Header  4 [ 44]: i:BD2F-1923-4668481755EB6C5442AE-001@SipHost
[Oct 27 18:12:14] DEBUG[1938] chan_sip.c:  Header  5 [ 17]: CSeq:231 REGISTER
[Oct 27 18:12:14] DEBUG[1938] chan_sip.c:  Header  6 [ 27]: m:<sip:L6@172.30.8.18:5060>
[Oct 27 18:12:14] DEBUG[1938] chan_sip.c:  Header  7 [  9]: Expires:0
[Oct 27 18:12:14] DEBUG[1938] chan_sip.c:  Header  8 [ 15]: Max-Forwards:70
[Oct 27 18:12:14] DEBUG[1938] chan_sip.c:  Header  9 [153]: Authorization:Digest username="L6",realm="asterisk",nonce="71c7792a",uri="sip:172.30.8.13:5060",response="4c870d221d0080a3887185b0ba7cd6c9",algorithm=MD5
[Oct 27 18:12:14] DEBUG[1938] chan_sip.c:  Header 10 [ 30]: User-Agent:dlink 12-36-9924913
[Oct 27 18:12:14] DEBUG[1938] chan_sip.c:  Header 11 [  3]: l:0
[Oct 27 18:12:14] VERBOSE[1938] chan_sip.c: --- (12 headers 0 lines) ---
[Oct 27 18:12:14] DEBUG[1938] chan_sip.c: = Looking for  Call ID: BD2F-1923-4668481755EB6C5442AE-001@SipHost (Checking From) --From tag 3cdbb650-686579 --To-tag   
[Oct 27 18:12:14] DEBUG[1938] netsock2.c: Splitting '172.30.8.13:5060' into...
[Oct 27 18:12:14] DEBUG[1938] netsock2.c: ...host '172.30.8.13' and port '5060'.
[Oct 27 18:12:14] DEBUG[1938] netsock2.c: Splitting '172.30.8.13:5060' into...
[Oct 27 18:12:14] DEBUG[1938] netsock2.c: ...host '172.30.8.13' and port '5060'.
[Oct 27 18:12:14] DEBUG[1938] chan_sip.c: **** Received REGISTER (2) - Command in SIP REGISTER
[Oct 27 18:12:14] DEBUG[1938] chan_sip.c: Initializing initreq for method REGISTER - callid BD2F-1923-4668481755EB6C5442AE-001@SipHost
[Oct 27 18:12:14] DEBUG[1938] netsock2.c: Splitting '172.30.8.18:5060' into...
[Oct 27 18:12:14] DEBUG[1938] netsock2.c: ...host '172.30.8.18' and port '5060'.
[Oct 27 18:12:14] VERBOSE[1938] chan_sip.c: Sending to 172.30.8.18:5060 (no NAT)
[Oct 27 18:12:14] ERROR[1938] chan_sip.c: WRONG NONCE: EXPECTED '04d04d13' BUT GOT '71c7792a' stale=0
[Oct 27 18:12:14] NOTICE[1938] chan_sip.c: Correct auth, but based on stale nonce received from '"L6" <sip:L6@172.30.8.13:5060>;tag=3cdbb650-686579'
[Oct 27 18:12:14] ERROR[1938] chan_sip.c: NEW RANDDATA=`04d04d13`
[Oct 27 18:12:14] VERBOSE[1938] chan_sip.c: 
<--- Transmitting (no NAT) to 172.30.8.18:5060 --->
SIP/2.0 401 Unauthorized
Via: SIP/2.0/UDP 172.30.8.18:5060;branch=z9hG4bK2dd42492c1b9ecdd;received=172.30.8.18
From: "L6" <sip:L6@172.30.8.13:5060>;tag=3cdbb650-686579
To: "L6" <sip:L6@172.30.8.13:5060>;tag=as0d9e932c
Call-ID: BD2F-1923-4668481755EB6C5442AE-001@SipHost
CSeq: 231 REGISTER
Server: Asterisk PBX
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
WWW-Authenticate: Digest algorithm=MD5, realm="asterisk", nonce="04d04d13", stale=true
Content-Length: 0


<------------>
[Oct 27 18:12:14] DEBUG[1938] chan_sip.c: Trying to put 'SIP/2.0 401' onto UDP socket destined for 172.30.8.18:5060
[Oct 27 18:12:14] VERBOSE[1938] chan_sip.c: Scheduling destruction of SIP dialog 'BD2F-1923-4668481755EB6C5442AE-001@SipHost' in 32000 ms (Method: REGISTER)
[Oct 27 18:12:15] VERBOSE[1938] chan_sip.c: 
<--- SIP read from UDP:172.30.8.18:5060 --->
REGISTER sip:172.30.8.13:5060 SIP/2.0
v:SIP/2.0/UDP 172.30.8.18:5060;branch=z9hG4bKeb580103572c6030
f:"L6" <sip:L6@172.30.8.13:5060>;tag=cd602270-686579
t:"L6" <sip:L6@172.30.8.13:5060>
i:BD2F-1923-4668481755EB6C5442AE-001@SipHost
CSeq:233 REGISTER
m:<sip:L6@172.30.8.18:5060>
Expires:600
Max-Forwards:70
User-Agent:dlink 12-36-9924913
l:0

<------------->
[Oct 27 18:12:15] DEBUG[1938] chan_sip.c:  Header  0 [ 37]: REGISTER sip:172.30.8.13:5060 SIP/2.0
[Oct 27 18:12:15] DEBUG[1938] chan_sip.c:  Header  1 [ 61]: v:SIP/2.0/UDP 172.30.8.18:5060;branch=z9hG4bKeb580103572c6030
[Oct 27 18:12:15] DEBUG[1938] chan_sip.c:  Header  2 [ 52]: f:"L6" <sip:L6@172.30.8.13:5060>;tag=cd602270-686579
[Oct 27 18:12:15] DEBUG[1938] chan_sip.c:  Header  3 [ 32]: t:"L6" <sip:L6@172.30.8.13:5060>
[Oct 27 18:12:15] DEBUG[1938] chan_sip.c:  Header  4 [ 44]: i:BD2F-1923-4668481755EB6C5442AE-001@SipHost
[Oct 27 18:12:15] DEBUG[1938] chan_sip.c:  Header  5 [ 17]: CSeq:233 REGISTER
[Oct 27 18:12:15] DEBUG[1938] chan_sip.c:  Header  6 [ 27]: m:<sip:L6@172.30.8.18:5060>
[Oct 27 18:12:15] DEBUG[1938] chan_sip.c:  Header  7 [ 11]: Expires:600
[Oct 27 18:12:15] DEBUG[1938] chan_sip.c:  Header  8 [ 15]: Max-Forwards:70
[Oct 27 18:12:15] DEBUG[1938] chan_sip.c:  Header  9 [ 30]: User-Agent:dlink 12-36-9924913
[Oct 27 18:12:15] DEBUG[1938] chan_sip.c:  Header 10 [  3]: l:0
[Oct 27 18:12:15] VERBOSE[1938] chan_sip.c: --- (11 headers 0 lines) ---
[Oct 27 18:12:15] DEBUG[1938] chan_sip.c: = Looking for  Call ID: BD2F-1923-4668481755EB6C5442AE-001@SipHost (Checking From) --From tag cd602270-686579 --To-tag   
[Oct 27 18:12:15] DEBUG[1938] acl.c: For destination '172.30.8.18', our source address is '172.30.8.13'.
[Oct 27 18:12:15] DEBUG[1938] chan_sip.c: Setting SIP_TRANSPORT_UDP with address 172.30.8.13:5060
[Oct 27 18:12:15] DEBUG[1938] chan_sip.c: Allocating new SIP dialog for BD2F-1923-4668481755EB6C5442AE-001@SipHost - REGISTER (No RTP)
[Oct 27 18:12:15] DEBUG[1938] chan_sip.c: **** Received REGISTER (2) - Command in SIP REGISTER
[Oct 27 18:12:15] DEBUG[1938] chan_sip.c: Initializing initreq for method REGISTER - callid BD2F-1923-4668481755EB6C5442AE-001@SipHost
[Oct 27 18:12:15] DEBUG[1938] netsock2.c: Splitting '172.30.8.18:5060' into...
[Oct 27 18:12:15] DEBUG[1938] netsock2.c: ...host '172.30.8.18' and port '5060'.
[Oct 27 18:12:15] VERBOSE[1938] chan_sip.c: Sending to 172.30.8.18:5060 (no NAT)
[Oct 27 18:12:15] NOTICE[1938] chan_sip.c: NEW NONCE `4f8800d4` FOR PVT `u:,p:,a:,n:`
[Oct 27 18:12:15] VERBOSE[1938] chan_sip.c: 
<--- Transmitting (no NAT) to 172.30.8.18:5060 --->
SIP/2.0 401 Unauthorized
Via: SIP/2.0/UDP 172.30.8.18:5060;branch=z9hG4bKeb580103572c6030;received=172.30.8.18
From: "L6" <sip:L6@172.30.8.13:5060>;tag=cd602270-686579
To: "L6" <sip:L6@172.30.8.13:5060>;tag=as4db48720
Call-ID: BD2F-1923-4668481755EB6C5442AE-001@SipHost
CSeq: 233 REGISTER
Server: Asterisk PBX
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
WWW-Authenticate: Digest algorithm=MD5, realm="asterisk", nonce="4f8800d4"
Content-Length: 0


<------------>
[Oct 27 18:12:15] DEBUG[1938] chan_sip.c: Trying to put 'SIP/2.0 401' onto UDP socket destined for 172.30.8.18:5060
[Oct 27 18:12:15] VERBOSE[1938] chan_sip.c: Scheduling destruction of SIP dialog 'BD2F-1923-4668481755EB6C5442AE-001@SipHost' in 32000 ms (Method: REGISTER)
[Oct 27 18:12:15] VERBOSE[1938] chan_sip.c: 
<--- SIP read from UDP:172.30.8.18:5060 --->
REGISTER sip:172.30.8.13:5060 SIP/2.0
v:SIP/2.0/UDP 172.30.8.18:5060;branch=z9hG4bK984cf0c8e918ed7e
f:"L6" <sip:L6@172.30.8.13:5060>;tag=cd602270-686579
t:"L6" <sip:L6@172.30.8.13:5060>
i:BD2F-1923-4668481755EB6C5442AE-001@SipHost
CSeq:234 REGISTER
m:<sip:L6@172.30.8.18:5060>
Expires:600
Max-Forwards:70
Authorization:Digest username="L6",realm="asterisk",nonce="4f8800d4",uri="sip:172.30.8.13:5060",response="9302de6b0a92828667b9008ba194ba09",algorithm=MD5
User-Agent:dlink 12-36-9924913
l:0

<------------->
[Oct 27 18:12:15] DEBUG[1938] chan_sip.c:  Header  0 [ 37]: REGISTER sip:172.30.8.13:5060 SIP/2.0
[Oct 27 18:12:15] DEBUG[1938] chan_sip.c:  Header  1 [ 61]: v:SIP/2.0/UDP 172.30.8.18:5060;branch=z9hG4bK984cf0c8e918ed7e
[Oct 27 18:12:15] DEBUG[1938] chan_sip.c:  Header  2 [ 52]: f:"L6" <sip:L6@172.30.8.13:5060>;tag=cd602270-686579
[Oct 27 18:12:15] DEBUG[1938] chan_sip.c:  Header  3 [ 32]: t:"L6" <sip:L6@172.30.8.13:5060>
[Oct 27 18:12:15] DEBUG[1938] chan_sip.c:  Header  4 [ 44]: i:BD2F-1923-4668481755EB6C5442AE-001@SipHost
[Oct 27 18:12:15] DEBUG[1938] chan_sip.c:  Header  5 [ 17]: CSeq:234 REGISTER
[Oct 27 18:12:15] DEBUG[1938] chan_sip.c:  Header  6 [ 27]: m:<sip:L6@172.30.8.18:5060>
[Oct 27 18:12:15] DEBUG[1938] chan_sip.c:  Header  7 [ 11]: Expires:600
[Oct 27 18:12:15] DEBUG[1938] chan_sip.c:  Header  8 [ 15]: Max-Forwards:70
[Oct 27 18:12:15] DEBUG[1938] chan_sip.c:  Header  9 [153]: Authorization:Digest username="L6",realm="asterisk",nonce="4f8800d4",uri="sip:172.30.8.13:5060",response="9302de6b0a92828667b9008ba194ba09",algorithm=MD5
[Oct 27 18:12:15] DEBUG[1938] chan_sip.c:  Header 10 [ 30]: User-Agent:dlink 12-36-9924913
[Oct 27 18:12:15] DEBUG[1938] chan_sip.c:  Header 11 [  3]: l:0
[Oct 27 18:12:15] VERBOSE[1938] chan_sip.c: --- (12 headers 0 lines) ---
[Oct 27 18:12:15] DEBUG[1938] chan_sip.c: = Looking for  Call ID: BD2F-1923-4668481755EB6C5442AE-001@SipHost (Checking From) --From tag cd602270-686579 --To-tag   
[Oct 27 18:12:15] DEBUG[1938] netsock2.c: Splitting '172.30.8.13:5060' into...
[Oct 27 18:12:15] DEBUG[1938] netsock2.c: ...host '172.30.8.13' and port '5060'.
[Oct 27 18:12:15] DEBUG[1938] netsock2.c: Splitting '172.30.8.13:5060' into...
[Oct 27 18:12:15] DEBUG[1938] netsock2.c: ...host '172.30.8.13' and port '5060'.
[Oct 27 18:12:15] DEBUG[1938] chan_sip.c: **** Received REGISTER (2) - Command in SIP REGISTER
[Oct 27 18:12:15] DEBUG[1938] chan_sip.c: Initializing initreq for method REGISTER - callid BD2F-1923-4668481755EB6C5442AE-001@SipHost
[Oct 27 18:12:15] DEBUG[1938] netsock2.c: Splitting '172.30.8.18:5060' into...
[Oct 27 18:12:15] DEBUG[1938] netsock2.c: ...host '172.30.8.18' and port '5060'.
[Oct 27 18:12:15] VERBOSE[1938] chan_sip.c: Sending to 172.30.8.18:5060 (no NAT)
[Oct 27 18:12:15] ERROR[1938] chan_sip.c: WRONG NONCE: EXPECTED '04d04d13' BUT GOT '4f8800d4' stale=0
[Oct 27 18:12:15] NOTICE[1938] chan_sip.c: Correct auth, but based on stale nonce received from '"L6" <sip:L6@172.30.8.13:5060>;tag=cd602270-686579'
[Oct 27 18:12:15] ERROR[1938] chan_sip.c: NEW RANDDATA=`04d04d13`
[Oct 27 18:12:15] VERBOSE[1938] chan_sip.c: 
<--- Transmitting (no NAT) to 172.30.8.18:5060 --->
SIP/2.0 401 Unauthorized
Via: SIP/2.0/UDP 172.30.8.18:5060;branch=z9hG4bK984cf0c8e918ed7e;received=172.30.8.18
From: "L6" <sip:L6@172.30.8.13:5060>;tag=cd602270-686579
To: "L6" <sip:L6@172.30.8.13:5060>;tag=as0d9e932c
Call-ID: BD2F-1923-4668481755EB6C5442AE-001@SipHost
CSeq: 234 REGISTER
Server: Asterisk PBX
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
WWW-Authenticate: Digest algorithm=MD5, realm="asterisk", nonce="04d04d13", stale=true
Content-Length: 0


<------------>
[Oct 27 18:12:15] DEBUG[1938] chan_sip.c: Trying to put 'SIP/2.0 401' onto UDP socket destined for 172.30.8.18:5060
[Oct 27 18:12:15] VERBOSE[1938] chan_sip.c: Scheduling destruction of SIP dialog 'BD2F-1923-4668481755EB6C5442AE-001@SipHost' in 32000 ms (Method: REGISTER)