[App_rpt-users] asterisk segfault!

Fri Jul 22 06:38:07 UTC 2016

Same thing happens to me, it crashes with echolink users being connected.

On 7/21/2016 4:24 PM, Bryan Fields wrote:
> On 6/24/16 7:18 PM, Bryan Fields wrote:
>> On 6/15/16 3:59 PM, Bryan Fields wrote:
>>> I've had asterisk crash twice over the past few weeks.  I can't see any
>>> obvious problems in the logging.  I've enabled debug logging and will see what
>>> I can find out when/if it happens again.
>> It crashed last night!  The only common theme I see is Echolink connected and
>> then it had an error of sorts.
>
> It crashed again, and it's an echolink issue.  I had just linked to a friend
> on echo link and we were talking.  He keyed up, spoke about 15 seconds, and (i
> was mobile) I saw both 220, 440 and 902 mhz repeaters drop out.   The system
> restarted in 10 seconds due to me using the systemd scripts to manage it.
>
> When it restarted echolink came back up and we started talking for the next 20
> min without issue.
>
> In kern.log
> Jul 21 16:58:25 Itchy kernel: [8036215.908665] asterisk[31495]: segfault at
> 192ec ip b7010840 sp b5001f60 error 4 in chan_echolink.so[b700b000+e000]
>
> In my asterisk log
>> [Jul 21 16:57:50] DEBUG[31471] devicestate.c: No provider found, checking channel drivers for DAHDI - pseudo
>> [Jul 21 16:57:50] DEBUG[31471] devicestate.c: Changing state for DAHDI/pseudo - state 2 (In use)
>> [Jul 21 16:57:50] DEBUG[32708] channel.c: Hanging up channel 'DAHDI/pseudo-1112987678'
>> [Jul 21 16:57:50] DEBUG[32708] chan_dahdi.c: dahdi_hangup(DAHDI/pseudo-1112987678)
>> [Jul 21 16:57:50] DEBUG[32708] chan_dahdi.c: Hangup: channel: -2 index = 0, normal = 78, callwait = -1, thirdcall = -1
>> [Jul 21 16:57:50] DEBUG[32708] chan_dahdi.c: Set option TDD MODE, value: OFF(0) on DAHDI/pseudo-1112987678
>> [Jul 21 16:57:50] DEBUG[32708] chan_dahdi.c: Updated conferencing on -2, with 0 conference users
>> [Jul 21 16:57:50] VERBOSE[32708] logger.c:     -- Hungup 'DAHDI/pseudo-1112987678'
>> [Jul 21 16:57:50] DEBUG[32708] devicestate.c: Notification of state change to be queued on device/channel DAHDI/pseudo
>> [Jul 21 16:57:50] DEBUG[31471] devicestate.c: No provider found, checking channel drivers for DAHDI - pseudo
>> [Jul 21 16:57:50] DEBUG[31471] devicestate.c: Changing state for DAHDI/pseudo - state 2 (In use)
>> [Jul 21 16:57:55] DEBUG[31489] chan_iax2.c: Received iseqno 234 not within window 235->235
>> [Jul 21 16:57:57] DEBUG[31491] chan_iax2.c: ip callno count decremented to 3 for 67.215.233.178
>> [Jul 21 16:57:59] WARNING[31485] chan_iax2.c: REGISTER-LOG: Sending registration request for '41618'
>> [Jul 21 16:57:59] DEBUG[31485] chan_iax2.c: Allocate call number
>> [Jul 21 16:57:59] DEBUG[31485] chan_iax2.c: ip callno count incremented to 4 for 67.215.233.178
>> [Jul 21 16:57:59] DEBUG[31485] chan_iax2.c: Registration created on call 3312
>> [Jul 21 16:57:59] WARNING[31484] chan_iax2.c: REGISTER-LOG: registry rereqquest
>> [Jul 21 16:57:59] DEBUG[31487] chan_iax2.c: schedule decrement of callno used for 67.215.233.178 in 60 seconds
>> [Jul 21 16:58:01] VERBOSE[31480] logger.c:     -- Received OK from Echolink server nawest.echolink.org
>> [Jul 21 16:58:01] VERBOSE[31480] logger.c:     -- Directory pgm done downloading(partial,compressed), 482 records
>> [Jul 21 16:58:02] DEBUG[31490] chan_iax2.c: Received iseqno 249 not within window 250->250
>> [Jul 21 16:58:09] DEBUG[31491] chan_iax2.c: ip callno count decremented to 3 for 67.215.233.178
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c: Node Variable dump for node 40821:
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c:    RPT_NUMLINKS=2
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c:    RPT_LINKS=2,T41618,T3316305
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c:    RPT_NUMALINKS=2
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c:    RPT_ALINKS=2,41618TU,3316305TU
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c:    RPT_ETXKEYED=0
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c:    RPT_RXKEYED=0
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c:    RPT_TXKEYED=1
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c:    RPT_AUTOPATCHUP=0
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c:     -- 8 variables
>> [Jul 21 16:58:19] DEBUG[32712] chan_dahdi.c: Using channel -2
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Prodding channel 'DAHDI/pseudo-960634253'
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Set channel DAHDI/pseudo-960634253 to write format slin
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Scheduling timer at 160 sample intervals
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Generator got voice, switching to phase locked mode
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Auto-deactivating generator
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Set channel DAHDI/pseudo-960634253 to write format ulaw
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:57:40] VERBOSE[31496] logger.c:    RPT_ETXKEYED=0
>> [Jul 21 16:57:40] VERBOSE[31496] logger.c:    RPT_RXKEYED=0
>> [Jul 21 16:57:40] VERBOSE[31496] logger.c:    RPT_AUTOPATCHUP=0
>> [Jul 21 16:57:40] VERBOSE[31496] logger.c:    TRANSFERCAPABILITY=SPEECH
>> [Jul 21 16:57:40] VERBOSE[31496] logger.c:     -- 9 variables
>> [Jul 21 16:57:40] DEBUG[32702] chan_dahdi.c: Using channel -2
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Prodding channel 'DAHDI/pseudo-827327442'
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Set channel DAHDI/pseudo-827327442 to write format slin
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Scheduling timer at 160 sample intervals
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Generator got voice, switching to phase locked mode
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Auto-deactivating generator
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Set channel DAHDI/pseudo-827327442 to write format ulaw
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Prodding channel 'DAHDI/pseudo-827327442'
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Set channel DAHDI/pseudo-827327442 to write format slin
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Scheduling timer at 160 sample intervals
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Generator got voice, switching to phase locked mode
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:30] DEBUG[32699] channel.c: Auto-deactivating generator
>> [Jul 21 16:57:30] DEBUG[32699] channel.c: Set channel DAHDI/pseudo-1312874724 to write format ulaw
>> [Jul 21 16:57:30] DEBUG[32699] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:57:30] DEBUG[32699] channel.c: Hanging up channel 'DAHDI/pseudo-1312874724'
>> [Jul 21 16:57:30] DEBUG[32699] chan_dahdi.c: dahdi_hangup(DAHDI/pseudo-1312874724)
>> [Jul 21 16:57:30] DEBUG[32699] chan_dahdi.c: Hangup: channel: -2 index = 0, normal = 77, callwait = -1, thirdcall = -1
>> [Jul 21 16:57:30] DEBUG[32699] chan_dahdi.c: Set option TDD MODE, value: OFF(0) on DAHDI/pseudo-1312874724
>> [Jul 21 16:57:30] DEBUG[32699] chan_dahdi.c: Updated conferencing on -2, with 0 conference users
>> [Jul 21 16:57:30] VERBOSE[32699] logger.c:     -- Hungup 'DAHDI/pseudo-1312874724'
>> [Jul 21 16:57:30] DEBUG[32699] devicestate.c: Notification of state change to be queued on device/channel DAHDI/pseudo
>> [Jul 21 16:57:30] DEBUG[31471] devicestate.c: No provider found, checking channel drivers for DAHDI - pseudo
>> [Jul 21 16:57:30] DEBUG[31471] devicestate.c: Changing state for DAHDI/pseudo - state 2 (In use)
>> [Jul 21 16:57:33] DEBUG[31498] chan_dahdi.c: Requested indication 13 on channel DAHDI/2-1
>> [Jul 21 16:57:33] VERBOSE[31498] logger.c: Node Variable dump for node 42032:
>> [Jul 21 16:57:33] VERBOSE[31498] logger.c:    RPT_TXKEYED=0
>> [Jul 21 16:57:33] VERBOSE[31498] logger.c:    RPT_NUMLINKS=46
>> [Jul 21 16:57:33] VERBOSE[31498] logger.c:    RPT_LINKS=46,T41170,T27714,T41599,T29902,T42462,T29826,T29901,T29771,T27455,T29827,T29772,T41508,T28183,T4151
>> 0,T41629,T28073,T2578,T41535,T29227,T29474,T29475,T42978,T41385,TN7GLV,T42610,T29659,T41373,T42574,T29658,T41538,T27654,T29521,T29522,T41688,T41525,T1980,T
>> 3630564,T42393,T1976,T42205,T41237,T40603,T42947,T40696,T42215,T40562
>> [Jul 21 16:57:33] VERBOSE[31498] logger.c:    RPT_NUMALINKS=1
>> [Jul 21 16:57:33] VERBOSE[31498] logger.c:    RPT_ALINKS=1,41170TU
>> [Jul 21 16:57:33] VERBOSE[31498] logger.c:    RPT_ETXKEYED=0
>> [Jul 21 16:57:33] VERBOSE[31498] logger.c:    RPT_RXKEYED=0
>> [Jul 21 16:57:33] VERBOSE[31498] logger.c:    RPT_AUTOPATCHUP=0
>> [Jul 21 16:57:33] VERBOSE[31498] logger.c:    TRANSFERCAPABILITY=SPEECH
>> [Jul 21 16:57:33] VERBOSE[31498] logger.c:     -- 9 variables
>> [Jul 21 16:57:34] DEBUG[31487] chan_iax2.c: Received iseqno 238 not within window 239->239
>> [Jul 21 16:57:39] WARNING[31482] chan_iax2.c: REGISTER-LOG: Sending registration request for '40821'
>> [Jul 21 16:57:39] DEBUG[31482] chan_iax2.c: Allocate call number
>> [Jul 21 16:57:39] DEBUG[31482] chan_iax2.c: ip callno count incremented to 4 for 67.215.233.178
>> [Jul 21 16:57:39] DEBUG[31482] chan_iax2.c: Registration created on call 12318
>> [Jul 21 16:57:39] WARNING[31484] chan_iax2.c: REGISTER-LOG: registry rereqquest
>> [Jul 21 16:57:40] DEBUG[31489] chan_iax2.c: schedule decrement of callno used for 67.215.233.178 in 60 seconds
>> [Jul 21 16:57:40] VERBOSE[31495] logger.c: Node Variable dump for node 40821:
>> [Jul 21 16:57:40] DEBUG[32701] chan_dahdi.c: Using channel -2
>> [Jul 21 16:57:40] VERBOSE[31495] logger.c:    RPT_RXKEYED=0
>> [Jul 21 16:57:40] VERBOSE[31495] logger.c:    RPT_ETXKEYED=1
>> [Jul 21 16:57:40] VERBOSE[31495] logger.c:    RPT_NUMLINKS=2
>> [Jul 21 16:57:40] VERBOSE[31495] logger.c:    RPT_LINKS=2,T41618,T3316305
>> [Jul 21 16:57:40] VERBOSE[31495] logger.c:    RPT_NUMALINKS=2
>> [Jul 21 16:57:40] VERBOSE[31495] logger.c:    RPT_ALINKS=2,41618TU,3316305TU
>> [Jul 21 16:57:40] VERBOSE[31495] logger.c:    RPT_TXKEYED=1
>> [Jul 21 16:57:40] VERBOSE[31495] logger.c:    RPT_AUTOPATCHUP=0
>> [Jul 21 16:57:40] VERBOSE[31495] logger.c:     -- 8 variables
>> [Jul 21 16:57:40] VERBOSE[31495] logger.c: Node Variable dump for node 40821:
>> [Jul 21 16:57:40] VERBOSE[31495] logger.c:    RPT_ETXKEYED=0
>> [Jul 21 16:57:40] VERBOSE[31495] logger.c:    RPT_RXKEYED=0
>> [Jul 21 16:57:40] VERBOSE[31495] logger.c:    RPT_NUMLINKS=2
>> [Jul 21 16:57:40] VERBOSE[31495] logger.c:    RPT_LINKS=2,T41618,T3316305
>> [Jul 21 16:57:40] VERBOSE[31495] logger.c:    RPT_NUMALINKS=2
>> [Jul 21 16:57:40] VERBOSE[31495] logger.c:    RPT_ALINKS=2,41618TU,3316305TU
>> [Jul 21 16:57:40] VERBOSE[31495] logger.c:    RPT_TXKEYED=1
>> [Jul 21 16:57:40] VERBOSE[31495] logger.c:    RPT_AUTOPATCHUP=0
>> [Jul 21 16:57:40] VERBOSE[31495] logger.c:     -- 8 variables
>> [Jul 21 16:57:40] VERBOSE[31496] logger.c: Node Variable dump for node 41618:
>> [Jul 21 16:57:40] VERBOSE[31496] logger.c:    RPT_NUMLINKS=2
>> [Jul 21 16:57:40] VERBOSE[31496] logger.c:    RPT_LINKS=2,T40821,T3316305
>> [Jul 21 16:57:40] VERBOSE[31496] logger.c:    RPT_NUMALINKS=1
>> [Jul 21 16:57:40] VERBOSE[31496] logger.c:    RPT_ALINKS=1,40821TU
>> [Jul 21 16:57:40] VERBOSE[31496] logger.c:    RPT_TXKEYED=1
>> [Jul 21 16:57:40] VERBOSE[31496] logger.c:    RPT_ETXKEYED=0
>> [Jul 21 16:57:40] VERBOSE[31496] logger.c:    RPT_RXKEYED=0
>> [Jul 21 16:57:40] VERBOSE[31496] logger.c:    RPT_AUTOPATCHUP=0
>> [Jul 21 16:57:40] VERBOSE[31496] logger.c:    TRANSFERCAPABILITY=SPEECH
>> [Jul 21 16:57:40] VERBOSE[31496] logger.c:     -- 9 variables
>> [Jul 21 16:57:40] DEBUG[32702] chan_dahdi.c: Using channel -2
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Prodding channel 'DAHDI/pseudo-827327442'
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Set channel DAHDI/pseudo-827327442 to write format slin
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Scheduling timer at 160 sample intervals
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Generator got voice, switching to phase locked mode
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Auto-deactivating generator
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Set channel DAHDI/pseudo-827327442 to write format ulaw
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Prodding channel 'DAHDI/pseudo-827327442'
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Set channel DAHDI/pseudo-827327442 to write format slin
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Scheduling timer at 160 sample intervals
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Generator got voice, switching to phase locked mode
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:30] DEBUG[32699] channel.c: Auto-deactivating generator
>> [Jul 21 16:57:30] DEBUG[32699] channel.c: Set channel DAHDI/pseudo-1312874724 to write format ulaw
>> [Jul 21 16:57:30] DEBUG[32699] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:57:30] DEBUG[32699] channel.c: Hanging up channel 'DAHDI/pseudo-1312874724'
>> [Jul 21 16:57:30] DEBUG[32699] chan_dahdi.c: dahdi_hangup(DAHDI/pseudo-1312874724)
>> [Jul 21 16:57:30] DEBUG[32699] chan_dahdi.c: Hangup: channel: -2 index = 0, normal = 77, callwait = -1, thirdcall = -1
>> [Jul 21 16:57:30] DEBUG[32699] chan_dahdi.c: Set option TDD MODE, value: OFF(0) on DAHDI/pseudo-1312874724
>> [Jul 21 16:57:30] DEBUG[32699] chan_dahdi.c: Updated conferencing on -2, with 0 conference users
>> [Jul 21 16:57:30] VERBOSE[32699] logger.c:     -- Hungup 'DAHDI/pseudo-1312874724'
>> [Jul 21 16:57:30] DEBUG[32699] devicestate.c: Notification of state change to be queued on device/channel DAHDI/pseudo
>> [Jul 21 16:57:30] DEBUG[31471] devicestate.c: No provider found, checking channel drivers for DAHDI - pseudo
>> [Jul 21 16:57:30] DEBUG[31471] devicestate.c: Changing state for DAHDI/pseudo - state 2 (In use)
>> [Jul 21 16:57:33] DEBUG[31498] chan_dahdi.c: Requested indication 13 on channel DAHDI/2-1
>> [Jul 21 16:57:33] VERBOSE[31498] logger.c: Node Variable dump for node 42032:
>> [Jul 21 16:57:33] VERBOSE[31498] logger.c:    RPT_TXKEYED=0
>> [Jul 21 16:57:33] VERBOSE[31498] logger.c:    RPT_NUMLINKS=46
>> [Jul 21 16:57:33] VERBOSE[31498] logger.c:    RPT_LINKS=46,T41170,T27714,T41599,T29902,T42462,T29826,T29901,T29771,T27455,T29827,T29772,T41508,T28183,T4151
>> 0,T41629,T28073,T2578,T41535,T29227,T29474,T29475,T42978,T41385,TN7GLV,T42610,T29659,T41373,T42574,T29658,T41538,T27654,T29521,T29522,T41688,T41525,T1980,T
>> 3630564,T42393,T1976,T42205,T41237,T40603,T42947,T40696,T42215,T40562
>> [Jul 21 16:57:33] VERBOSE[31498] logger.c:    RPT_NUMALINKS=1
>> [Jul 21 16:57:33] VERBOSE[31498] logger.c:    RPT_ALINKS=1,41170TU
>> [Jul 21 16:57:33] VERBOSE[31498] logger.c:    RPT_ETXKEYED=0
>> [Jul 21 16:57:33] VERBOSE[31498] logger.c:    RPT_RXKEYED=0
>> [Jul 21 16:57:33] VERBOSE[31498] logger.c:    RPT_AUTOPATCHUP=0
>> [Jul 21 16:57:33] VERBOSE[31498] logger.c:    TRANSFERCAPABILITY=SPEECH
>> [Jul 21 16:57:33] VERBOSE[31498] logger.c:     -- 9 variables
>> [Jul 21 16:57:34] DEBUG[31487] chan_iax2.c: Received iseqno 238 not within window 239->239
>> [Jul 21 16:57:39] WARNING[31482] chan_iax2.c: REGISTER-LOG: Sending registration request for '40821'
>> [Jul 21 16:57:39] DEBUG[31482] chan_iax2.c: Allocate call number
>> [Jul 21 16:57:39] DEBUG[31482] chan_iax2.c: ip callno count incremented to 4 for 67.215.233.178
>> [Jul 21 16:57:39] DEBUG[31482] chan_iax2.c: Registration created on call 12318
>> [Jul 21 16:57:39] WARNING[31484] chan_iax2.c: REGISTER-LOG: registry rereqquest
>> [Jul 21 16:57:40] DEBUG[31489] chan_iax2.c: schedule decrement of callno used for 67.215.233.178 in 60 seconds
>> [Jul 21 16:57:40] VERBOSE[31495] logger.c: Node Variable dump for node 40821:
>> [Jul 21 16:57:40] DEBUG[32701] chan_dahdi.c: Using channel -2
>> [Jul 21 16:57:40] VERBOSE[31495] logger.c:    RPT_RXKEYED=0
>> [Jul 21 16:57:40] VERBOSE[31495] logger.c:    RPT_ETXKEYED=1
>> [Jul 21 16:57:40] VERBOSE[31495] logger.c:    RPT_NUMLINKS=2
>> [Jul 21 16:57:40] VERBOSE[31495] logger.c:    RPT_LINKS=2,T41618,T3316305
>> [Jul 21 16:57:40] VERBOSE[31495] logger.c:    RPT_NUMALINKS=2
>> [Jul 21 16:57:40] VERBOSE[31495] logger.c:    RPT_ALINKS=2,41618TU,3316305TU
>> [Jul 21 16:57:40] VERBOSE[31495] logger.c:    RPT_TXKEYED=1
>> [Jul 21 16:57:40] VERBOSE[31495] logger.c:    RPT_AUTOPATCHUP=0
>> [Jul 21 16:57:40] VERBOSE[31495] logger.c:     -- 8 variables
>> [Jul 21 16:57:40] VERBOSE[31495] logger.c: Node Variable dump for node 40821:
>> [Jul 21 16:57:40] VERBOSE[31495] logger.c:    RPT_ETXKEYED=0
>> [Jul 21 16:57:40] VERBOSE[31495] logger.c:    RPT_RXKEYED=0
>> [Jul 21 16:57:40] VERBOSE[31495] logger.c:    RPT_NUMLINKS=2
>> [Jul 21 16:57:40] VERBOSE[31495] logger.c:    RPT_LINKS=2,T41618,T3316305
>> [Jul 21 16:57:40] VERBOSE[31495] logger.c:    RPT_NUMALINKS=2
>> [Jul 21 16:57:40] VERBOSE[31495] logger.c:    RPT_ALINKS=2,41618TU,3316305TU
>> [Jul 21 16:57:40] VERBOSE[31495] logger.c:    RPT_TXKEYED=1
>> [Jul 21 16:57:40] VERBOSE[31495] logger.c:    RPT_AUTOPATCHUP=0
>> [Jul 21 16:57:40] VERBOSE[31495] logger.c:     -- 8 variables
>> [Jul 21 16:57:40] VERBOSE[31496] logger.c: Node Variable dump for node 41618:
>> [Jul 21 16:57:40] VERBOSE[31496] logger.c:    RPT_NUMLINKS=2
>> [Jul 21 16:57:40] VERBOSE[31496] logger.c:    RPT_LINKS=2,T40821,T3316305
>> [Jul 21 16:57:40] VERBOSE[31496] logger.c:    RPT_NUMALINKS=1
>> [Jul 21 16:57:40] VERBOSE[31496] logger.c:    RPT_ALINKS=1,40821TU
>> [Jul 21 16:57:40] VERBOSE[31496] logger.c:    RPT_TXKEYED=1
>> [Jul 21 16:57:40] VERBOSE[31496] logger.c:    RPT_ETXKEYED=0
>> [Jul 21 16:57:40] VERBOSE[31496] logger.c:    RPT_RXKEYED=0
>> [Jul 21 16:57:40] VERBOSE[31496] logger.c:    RPT_AUTOPATCHUP=0
>> [Jul 21 16:57:40] VERBOSE[31496] logger.c:    TRANSFERCAPABILITY=SPEECH
>> [Jul 21 16:57:40] VERBOSE[31496] logger.c:     -- 9 variables
>> [Jul 21 16:57:40] DEBUG[32702] chan_dahdi.c: Using channel -2
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Prodding channel 'DAHDI/pseudo-827327442'
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Set channel DAHDI/pseudo-827327442 to write format slin
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Scheduling timer at 160 sample intervals
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Generator got voice, switching to phase locked mode
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Auto-deactivating generator
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Set channel DAHDI/pseudo-827327442 to write format ulaw
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Prodding channel 'DAHDI/pseudo-827327442'
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Set channel DAHDI/pseudo-827327442 to write format slin
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Scheduling timer at 160 sample intervals
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Generator got voice, switching to phase locked mode
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Auto-deactivating generator
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Set channel DAHDI/pseudo-827327442 to write format ulaw
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Hanging up channel 'DAHDI/pseudo-827327442'
>> [Jul 21 16:57:40] DEBUG[32702] chan_dahdi.c: dahdi_hangup(DAHDI/pseudo-827327442)
>> [Jul 21 16:57:40] DEBUG[32702] chan_dahdi.c: Hangup: channel: -2 index = 0, normal = 78, callwait = -1, thirdcall = -1
>> [Jul 21 16:57:40] DEBUG[32702] chan_dahdi.c: Set option TDD MODE, value: OFF(0) on DAHDI/pseudo-827327442
>> [Jul 21 16:57:40] DEBUG[32702] chan_dahdi.c: Updated conferencing on -2, with 0 conference users
>> [Jul 21 16:57:40] VERBOSE[32702] logger.c:     -- Hungup 'DAHDI/pseudo-827327442'
>> [Jul 21 16:57:40] DEBUG[32702] devicestate.c: Notification of state change to be queued on device/channel DAHDI/pseudo
>> [Jul 21 16:57:40] DEBUG[31471] devicestate.c: No provider found, checking channel drivers for DAHDI - pseudo
>> [Jul 21 16:57:40] DEBUG[31471] devicestate.c: Changing state for DAHDI/pseudo - state 2 (In use)
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Prodding channel 'DAHDI/pseudo-1742131875'
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Set channel DAHDI/pseudo-1742131875 to write format slin
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Scheduling timer at 160 sample intervals
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Generator got voice, switching to phase locked mode
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Auto-deactivating generator
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Set channel DAHDI/pseudo-1742131875 to write format ulaw
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Prodding channel 'DAHDI/pseudo-1742131875'
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Set channel DAHDI/pseudo-1742131875 to write format slin
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Scheduling timer at 160 sample intervals
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Generator got voice, switching to phase locked mode
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Auto-deactivating generator
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Set channel DAHDI/pseudo-1742131875 to write format ulaw
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Prodding channel 'DAHDI/pseudo-1742131875'
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Set channel DAHDI/pseudo-1742131875 to write format slin
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Scheduling timer at 160 sample intervals
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Generator got voice, switching to phase locked mode
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Auto-deactivating generator
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Set channel DAHDI/pseudo-1742131875 to write format ulaw
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Prodding channel 'DAHDI/pseudo-1742131875'
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Set channel DAHDI/pseudo-1742131875 to write format slin
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Scheduling timer at 160 sample intervals
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Generator got voice, switching to phase locked mode
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:57:41] VERBOSE[31495] logger.c: Node Variable dump for node 40821:
>> [Jul 21 16:57:41] VERBOSE[31495] logger.c:    RPT_NUMLINKS=2
>> [Jul 21 16:57:41] VERBOSE[31495] logger.c:    RPT_LINKS=2,T41618,T3316305
>> [Jul 21 16:57:41] VERBOSE[31495] logger.c:    RPT_NUMALINKS=2
>> [Jul 21 16:57:41] VERBOSE[31495] logger.c:    RPT_ALINKS=2,41618TU,3316305TK
>> [Jul 21 16:57:41] VERBOSE[31495] logger.c:    RPT_ETXKEYED=0
>> [Jul 21 16:57:41] VERBOSE[31495] logger.c:    RPT_RXKEYED=0
>> [Jul 21 16:57:41] VERBOSE[31495] logger.c:    RPT_TXKEYED=1
>> [Jul 21 16:57:41] VERBOSE[31495] logger.c:    RPT_AUTOPATCHUP=0
>> [Jul 21 16:57:41] VERBOSE[31495] logger.c:     -- 8 variables
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Auto-deactivating generator
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Set channel DAHDI/pseudo-1742131875 to write format ulaw
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Hanging up channel 'DAHDI/pseudo-1742131875'
>> [Jul 21 16:57:41] DEBUG[32701] chan_dahdi.c: dahdi_hangup(DAHDI/pseudo-1742131875)
>> [Jul 21 16:57:41] DEBUG[32701] chan_dahdi.c: Hangup: channel: -2 index = 0, normal = 76, callwait = -1, thirdcall = -1
>> [Jul 21 16:57:41] DEBUG[32701] chan_dahdi.c: Set option TDD MODE, value: OFF(0) on DAHDI/pseudo-1742131875
>> [Jul 21 16:57:41] DEBUG[32701] chan_dahdi.c: Updated conferencing on -2, with 0 conference users
>> [Jul 21 16:57:41] VERBOSE[32701] logger.c:     -- Hungup 'DAHDI/pseudo-1742131875'
>> [Jul 21 16:57:41] DEBUG[32701] devicestate.c: Notification of state change to be queued on device/channel DAHDI/pseudo
>> [Jul 21 16:57:41] DEBUG[31471] devicestate.c: No provider found, checking channel drivers for DAHDI - pseudo
>> [Jul 21 16:57:41] DEBUG[31471] devicestate.c: Changing state for DAHDI/pseudo - state 2 (In use)
>> [Jul 21 16:57:41] VERBOSE[31496] logger.c: Node Variable dump for node 41618:
>> [Jul 21 16:57:41] VERBOSE[31496] logger.c:    RPT_NUMLINKS=2
>> [Jul 21 16:57:41] VERBOSE[31496] logger.c:    RPT_LINKS=2,T40821,T3316305
>> [Jul 21 16:57:41] VERBOSE[31496] logger.c:    RPT_NUMALINKS=1
>> [Jul 21 16:57:41] VERBOSE[31496] logger.c:    RPT_ALINKS=1,40821TK
>> [Jul 21 16:57:41] VERBOSE[31496] logger.c:    RPT_TXKEYED=1
>> [Jul 21 16:57:41] VERBOSE[31496] logger.c:    RPT_ETXKEYED=0
>> [Jul 21 16:57:41] VERBOSE[31496] logger.c:    RPT_RXKEYED=0
>> [Jul 21 16:57:41] VERBOSE[31496] logger.c:    RPT_AUTOPATCHUP=0
>> [Jul 21 16:57:41] VERBOSE[31496] logger.c:    TRANSFERCAPABILITY=SPEECH
>> [Jul 21 16:57:41] VERBOSE[31496] logger.c:     -- 9 variables
>> [Jul 21 16:57:41] DEBUG[31496] chan_dahdi.c: Write returned -1 (Resource temporarily unavailable) on channel -2
>> [Jul 21 16:57:47] WARNING[31487] chan_iax2.c: REGISTER-LOG: Sending registration request for '42032'
>> [Jul 21 16:57:47] DEBUG[31487] chan_iax2.c: Allocate call number
>> [Jul 21 16:57:47] DEBUG[31487] chan_iax2.c: ip callno count incremented to 5 for 67.215.233.178
>> [Jul 21 16:57:47] DEBUG[31487] chan_iax2.c: Registration created on call 10837
>> [Jul 21 16:57:47] WARNING[31488] chan_iax2.c: REGISTER-LOG: registry rereqquest
>> [Jul 21 16:57:47] DEBUG[31490] chan_iax2.c: schedule decrement of callno used for 67.215.233.178 in 60 seconds
>> [Jul 21 16:57:49] DEBUG[31491] chan_iax2.c: ip callno count decremented to 4 for 67.215.233.178
>> [Jul 21 16:57:50] VERBOSE[31495] logger.c: Node Variable dump for node 40821:
>> [Jul 21 16:57:50] VERBOSE[31495] logger.c:    RPT_NUMLINKS=2
>> [Jul 21 16:57:50] VERBOSE[31495] logger.c:    RPT_LINKS=2,T41618,T3316305
>> [Jul 21 16:57:50] VERBOSE[31495] logger.c:    RPT_NUMALINKS=2
>> [Jul 21 16:57:50] VERBOSE[31495] logger.c:    RPT_ALINKS=2,41618TU,3316305TU
>> [Jul 21 16:57:50] VERBOSE[31495] logger.c:    RPT_ETXKEYED=0
>> [Jul 21 16:57:50] VERBOSE[31495] logger.c:    RPT_RXKEYED=0
>> [Jul 21 16:57:50] VERBOSE[31495] logger.c:    RPT_TXKEYED=1
>> [Jul 21 16:57:50] VERBOSE[31495] logger.c:    RPT_AUTOPATCHUP=0
>> [Jul 21 16:57:50] VERBOSE[31495] logger.c:     -- 8 variables
>> [Jul 21 16:57:50] DEBUG[32707] chan_dahdi.c: Using channel -2
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Prodding channel 'DAHDI/pseudo-1431047561'
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Set channel DAHDI/pseudo-1431047561 to write format slin
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Scheduling timer at 160 sample intervals
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Generator got voice, switching to phase locked mode
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Auto-deactivating generator
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Set channel DAHDI/pseudo-1431047561 to write format ulaw
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Prodding channel 'DAHDI/pseudo-1431047561'
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Set channel DAHDI/pseudo-1431047561 to write format slin
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Scheduling timer at 160 sample intervals
>> [Jul 21 16:57:50] VERBOSE[31496] logger.c: Node Variable dump for node 41618:
>> [Jul 21 16:57:50] VERBOSE[31496] logger.c:    RPT_NUMLINKS=2
>> [Jul 21 16:57:50] VERBOSE[31496] logger.c:    RPT_LINKS=2,T40821,T3316305
>> [Jul 21 16:57:50] VERBOSE[31496] logger.c:    RPT_NUMALINKS=1
>> [Jul 21 16:57:50] VERBOSE[31496] logger.c:    RPT_ALINKS=1,40821TU
>> [Jul 21 16:57:50] VERBOSE[31496] logger.c:    RPT_TXKEYED=1
>> [Jul 21 16:57:50] VERBOSE[31496] logger.c:    RPT_ETXKEYED=0
>> [Jul 21 16:57:50] VERBOSE[31496] logger.c:    RPT_RXKEYED=0
>> [Jul 21 16:57:50] VERBOSE[31496] logger.c:    RPT_AUTOPATCHUP=0
>> [Jul 21 16:57:50] VERBOSE[31496] logger.c:    TRANSFERCAPABILITY=SPEECH
>> [Jul 21 16:57:50] VERBOSE[31496] logger.c:     -- 9 variables
>> [Jul 21 16:57:50] DEBUG[32708] chan_dahdi.c: Using channel -2
>> [Jul 21 16:57:50] DEBUG[32708] channel.c: Prodding channel 'DAHDI/pseudo-1112987678'
>> [Jul 21 16:57:50] DEBUG[32708] channel.c: Set channel DAHDI/pseudo-1112987678 to write format slin
>> [Jul 21 16:57:50] DEBUG[32708] channel.c: Scheduling timer at 160 sample intervals
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Generator got voice, switching to phase locked mode
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:57:50] DEBUG[32708] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:50] DEBUG[32708] channel.c: Generator got voice, switching to phase locked mode
>> [Jul 21 16:57:50] DEBUG[32708] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:57:50] DEBUG[32708] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:57:50] DEBUG[32708] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Auto-deactivating generator
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Set channel DAHDI/pseudo-1431047561 to write format ulaw
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Prodding channel 'DAHDI/pseudo-1431047561'
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Set channel DAHDI/pseudo-1431047561 to write format slin
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Scheduling timer at 160 sample intervals
>> [Jul 21 16:57:50] DEBUG[32708] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Generator got voice, switching to phase locked mode
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:57:50] DEBUG[32708] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:57:50] DEBUG[32708] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Auto-deactivating generator
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Set channel DAHDI/pseudo-1431047561 to write format ulaw
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Prodding channel 'DAHDI/pseudo-1431047561'
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Set channel DAHDI/pseudo-1431047561 to write format slin
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Scheduling timer at 160 sample intervals
>> [Jul 21 16:57:50] DEBUG[32708] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Generator got voice, switching to phase locked mode
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:57:50] DEBUG[32708] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:50] DEBUG[32708] channel.c: Auto-deactivating generator
>> [Jul 21 16:57:50] DEBUG[32708] channel.c: Set channel DAHDI/pseudo-1112987678 to write format ulaw
>> [Jul 21 16:57:50] DEBUG[32708] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:57:50] DEBUG[32708] channel.c: Prodding channel 'DAHDI/pseudo-1112987678'
>> [Jul 21 16:57:50] DEBUG[32708] channel.c: Set channel DAHDI/pseudo-1112987678 to write format slin
>> [Jul 21 16:57:50] DEBUG[32708] channel.c: Scheduling timer at 160 sample intervals
>> [Jul 21 16:57:50] VERBOSE[31495] logger.c: Node Variable dump for node 40821:
>> [Jul 21 16:57:50] VERBOSE[31495] logger.c:    RPT_NUMLINKS=2
>> [Jul 21 16:57:50] VERBOSE[31495] logger.c:    RPT_LINKS=2,T41618,T3316305
>> [Jul 21 16:57:50] VERBOSE[31495] logger.c:    RPT_NUMALINKS=2
>> [Jul 21 16:57:50] VERBOSE[31495] logger.c:    RPT_ALINKS=2,41618TU,3316305TK
>> [Jul 21 16:57:50] VERBOSE[31495] logger.c:    RPT_ETXKEYED=0
>> [Jul 21 16:57:50] VERBOSE[31495] logger.c:    RPT_RXKEYED=0
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:57:50] VERBOSE[31495] logger.c:    RPT_TXKEYED=1
>> [Jul 21 16:57:50] VERBOSE[31495] logger.c:    RPT_AUTOPATCHUP=0
>> [Jul 21 16:57:50] VERBOSE[31495] logger.c:     -- 8 variables
>> [Jul 21 16:57:50] DEBUG[32708] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:50] DEBUG[32708] channel.c: Generator got voice, switching to phase locked mode
>> [Jul 21 16:57:50] DEBUG[32708] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:57:50] DEBUG[32708] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:57:50] DEBUG[32708] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Auto-deactivating generator
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Set channel DAHDI/pseudo-1431047561 to write format ulaw
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:57:50] VERBOSE[31496] logger.c: Node Variable dump for node 41618:
>> [Jul 21 16:57:50] VERBOSE[31496] logger.c:    RPT_NUMLINKS=2
>> [Jul 21 16:57:50] VERBOSE[31496] logger.c:    RPT_LINKS=2,T40821,T3316305
>> [Jul 21 16:57:50] VERBOSE[31496] logger.c:    RPT_NUMALINKS=1
>> [Jul 21 16:57:50] VERBOSE[31496] logger.c:    RPT_ALINKS=1,40821TK
>> [Jul 21 16:57:50] DEBUG[32708] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:50] VERBOSE[31496] logger.c:    RPT_TXKEYED=1
>> [Jul 21 16:57:50] VERBOSE[31496] logger.c:    RPT_ETXKEYED=0
>> [Jul 21 16:57:50] VERBOSE[31496] logger.c:    RPT_RXKEYED=0
>> [Jul 21 16:57:50] VERBOSE[31496] logger.c:    RPT_AUTOPATCHUP=0
>> [Jul 21 16:57:50] VERBOSE[31496] logger.c:    TRANSFERCAPABILITY=SPEECH
>> [Jul 21 16:57:50] VERBOSE[31496] logger.c:     -- 9 variables
>> [Jul 21 16:57:50] DEBUG[32708] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:50] DEBUG[32708] channel.c: Auto-deactivating generator
>> [Jul 21 16:57:50] DEBUG[32708] channel.c: Set channel DAHDI/pseudo-1112987678 to write format ulaw
>> [Jul 21 16:57:50] DEBUG[32708] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Hanging up channel 'DAHDI/pseudo-1431047561'
>> [Jul 21 16:57:50] DEBUG[32707] chan_dahdi.c: dahdi_hangup(DAHDI/pseudo-1431047561)
>> [Jul 21 16:57:50] DEBUG[32707] chan_dahdi.c: Hangup: channel: -2 index = 0, normal = 76, callwait = -1, thirdcall = -1
>> [Jul 21 16:57:50] DEBUG[32707] chan_dahdi.c: Set option TDD MODE, value: OFF(0) on DAHDI/pseudo-1431047561
>> [Jul 21 16:57:50] DEBUG[32707] chan_dahdi.c: Updated conferencing on -2, with 0 conference users
>> [Jul 21 16:57:50] VERBOSE[32707] logger.c:     -- Hungup 'DAHDI/pseudo-1431047561'
>> [Jul 21 16:57:50] DEBUG[32707] devicestate.c: Notification of state change to be queued on device/channel DAHDI/pseudo
>> [Jul 21 16:57:50] DEBUG[31471] devicestate.c: No provider found, checking channel drivers for DAHDI - pseudo
>> [Jul 21 16:57:50] DEBUG[31471] devicestate.c: Changing state for DAHDI/pseudo - state 2 (In use)
>> [Jul 21 16:57:50] DEBUG[32708] channel.c: Hanging up channel 'DAHDI/pseudo-1112987678'
>> [Jul 21 16:57:50] DEBUG[32708] chan_dahdi.c: dahdi_hangup(DAHDI/pseudo-1112987678)
>> [Jul 21 16:57:50] DEBUG[32708] chan_dahdi.c: Hangup: channel: -2 index = 0, normal = 78, callwait = -1, thirdcall = -1
>> [Jul 21 16:57:50] DEBUG[32708] chan_dahdi.c: Set option TDD MODE, value: OFF(0) on DAHDI/pseudo-1112987678
>> [Jul 21 16:57:50] DEBUG[32708] chan_dahdi.c: Updated conferencing on -2, with 0 conference users
>> [Jul 21 16:57:50] VERBOSE[32708] logger.c:     -- Hungup 'DAHDI/pseudo-1112987678'
>> [Jul 21 16:57:50] DEBUG[32708] devicestate.c: Notification of state change to be queued on device/channel DAHDI/pseudo
>> [Jul 21 16:57:50] DEBUG[31471] devicestate.c: No provider found, checking channel drivers for DAHDI - pseudo
>> [Jul 21 16:57:50] DEBUG[31471] devicestate.c: Changing state for DAHDI/pseudo - state 2 (In use)
>> [Jul 21 16:57:55] DEBUG[31489] chan_iax2.c: Received iseqno 234 not within window 235->235
>> [Jul 21 16:57:57] DEBUG[31491] chan_iax2.c: ip callno count decremented to 3 for 67.215.233.178
>> [Jul 21 16:57:59] WARNING[31485] chan_iax2.c: REGISTER-LOG: Sending registration request for '41618'
>> [Jul 21 16:57:59] DEBUG[31485] chan_iax2.c: Allocate call number
>> [Jul 21 16:57:59] DEBUG[31485] chan_iax2.c: ip callno count incremented to 4 for 67.215.233.178
>> [Jul 21 16:57:59] DEBUG[31485] chan_iax2.c: Registration created on call 3312
>> [Jul 21 16:57:59] WARNING[31484] chan_iax2.c: REGISTER-LOG: registry rereqquest
>> [Jul 21 16:57:59] DEBUG[31487] chan_iax2.c: schedule decrement of callno used for 67.215.233.178 in 60 seconds
>> [Jul 21 16:58:01] VERBOSE[31480] logger.c:     -- Received OK from Echolink server nawest.echolink.org
>> [Jul 21 16:58:01] VERBOSE[31480] logger.c:     -- Directory pgm done downloading(partial,compressed), 482 records
>> [Jul 21 16:58:02] DEBUG[31490] chan_iax2.c: Received iseqno 249 not within window 250->250
>> [Jul 21 16:58:09] DEBUG[31491] chan_iax2.c: ip callno count decremented to 3 for 67.215.233.178
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c: Node Variable dump for node 40821:
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c:    RPT_NUMLINKS=2
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c:    RPT_LINKS=2,T41618,T3316305
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c:    RPT_NUMALINKS=2
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c:    RPT_ALINKS=2,41618TU,3316305TU
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c:    RPT_ETXKEYED=0
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c:    RPT_RXKEYED=0
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c:    RPT_TXKEYED=1
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c:    RPT_AUTOPATCHUP=0
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c:     -- 8 variables
>> [Jul 21 16:58:19] DEBUG[32712] chan_dahdi.c: Using channel -2
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Prodding channel 'DAHDI/pseudo-960634253'
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Set channel DAHDI/pseudo-960634253 to write format slin
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Scheduling timer at 160 sample intervals
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Generator got voice, switching to phase locked mode
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Auto-deactivating generator
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Set channel DAHDI/pseudo-960634253 to write format ulaw
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Prodding channel 'DAHDI/pseudo-960634253'
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Set channel DAHDI/pseudo-960634253 to write format slin
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Scheduling timer at 160 sample intervals
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c: Node Variable dump for node 41618:
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_NUMLINKS=2
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_LINKS=2,T40821,T3316305
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_NUMALINKS=1
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_ALINKS=1,40821TU
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_TXKEYED=1
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_ETXKEYED=0
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_RXKEYED=0
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_AUTOPATCHUP=0
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    TRANSFERCAPABILITY=SPEECH
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:     -- 9 variables
>> [Jul 21 16:58:19] DEBUG[32713] chan_dahdi.c: Using channel -2
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Prodding channel 'DAHDI/pseudo-1502252132'
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Set channel DAHDI/pseudo-1502252132 to write format slin
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Scheduling timer at 160 sample intervals
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Generator got voice, switching to phase locked mode
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Generator got voice, switching to phase locked mode
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c: Node Variable dump for node 40821:
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c:    RPT_NUMLINKS=2
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c:    RPT_LINKS=2,T41618,T3316305
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c:    RPT_NUMALINKS=2
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c:    RPT_ALINKS=2,41618TU,3316305TK
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c:    RPT_ETXKEYED=0
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c:    RPT_RXKEYED=0
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c:    RPT_TXKEYED=1
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c:    RPT_AUTOPATCHUP=0
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c:     -- 8 variables
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Auto-deactivating generator
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Set channel DAHDI/pseudo-960634253 to write format ulaw
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Prodding channel 'DAHDI/pseudo-960634253'
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Set channel DAHDI/pseudo-960634253 to write format slin
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Scheduling timer at 160 sample intervals
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Generator got voice, switching to phase locked mode
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Auto-deactivating generator
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Set channel DAHDI/pseudo-960634253 to write format ulaw
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Prodding channel 'DAHDI/pseudo-960634253'
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Set channel DAHDI/pseudo-960634253 to write format slin
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Scheduling timer at 160 sample intervals
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Generator got voice, switching to phase locked mode
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Auto-deactivating generator
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Set channel DAHDI/pseudo-1502252132 to write format ulaw
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Prodding channel 'DAHDI/pseudo-1502252132'
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Set channel DAHDI/pseudo-1502252132 to write format slin
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Scheduling timer at 160 sample intervals
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Generator got voice, switching to phase locked mode
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Auto-deactivating generator
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Set channel DAHDI/pseudo-960634253 to write format ulaw
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c: Node Variable dump for node 41618:
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_NUMLINKS=2
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_LINKS=2,T40821,T3316305
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_NUMALINKS=1
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_ALINKS=1,40821TK
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_TXKEYED=1
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_ETXKEYED=0
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_RXKEYED=0
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_AUTOPATCHUP=0
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    TRANSFERCAPABILITY=SPEECH
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:     -- 9 variables
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Auto-deactivating generator
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Set channel DAHDI/pseudo-1502252132 to write format ulaw
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Hanging up channel 'DAHDI/pseudo-960634253'
>> [Jul 21 16:58:19] DEBUG[32712] chan_dahdi.c: dahdi_hangup(DAHDI/pseudo-960634253)
>> [Jul 21 16:58:19] DEBUG[32712] chan_dahdi.c: Hangup: channel: -2 index = 0, normal = 76, callwait = -1, thirdcall = -1
>> [Jul 21 16:58:19] DEBUG[32712] chan_dahdi.c: Set option TDD MODE, value: OFF(0) on DAHDI/pseudo-960634253
>> [Jul 21 16:58:19] DEBUG[32712] chan_dahdi.c: Updated conferencing on -2, with 0 conference users
>> [Jul 21 16:58:19] VERBOSE[32712] logger.c:     -- Hungup 'DAHDI/pseudo-960634253'
>> [Jul 21 16:58:19] DEBUG[32712] devicestate.c: Notification of state change to be queued on device/channel DAHDI/pseudo
>> [Jul 21 16:58:19] DEBUG[31471] devicestate.c: No provider found, checking channel drivers for DAHDI - pseudo
>> [Jul 21 16:58:19] DEBUG[31471] devicestate.c: Changing state for DAHDI/pseudo - state 2 (In use)
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Hanging up channel 'DAHDI/pseudo-1502252132'
>> [Jul 21 16:58:19] DEBUG[32713] chan_dahdi.c: dahdi_hangup(DAHDI/pseudo-1502252132)
>> [Jul 21 16:58:19] DEBUG[32713] chan_dahdi.c: Hangup: channel: -2 index = 0, normal = 78, callwait = -1, thirdcall = -1
>> [Jul 21 16:58:19] DEBUG[32713] chan_dahdi.c: Set option TDD MODE, value: OFF(0) on DAHDI/pseudo-1502252132
>> [Jul 21 16:58:19] DEBUG[32713] chan_dahdi.c: Updated conferencing on -2, with 0 conference users
>> [Jul 21 16:58:19] VERBOSE[32713] logger.c:     -- Hungup 'DAHDI/pseudo-1502252132'
>> [Jul 21 16:58:19] DEBUG[32713] devicestate.c: Notification of state change to be queued on device/channel DAHDI/pseudo
>> [Jul 21 16:58:19] DEBUG[31471] devicestate.c: No provider found, checking channel drivers for DAHDI - pseudo
>> [Jul 21 16:58:19] DEBUG[31471] devicestate.c: Changing state for DAHDI/pseudo - state 2 (In use)
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c: Node Variable dump for node 41618:
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_NUMLINKS=2
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_LINKS=2,T40821,T3316305
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_NUMALINKS=1
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_ALINKS=1,40821TU
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_TXKEYED=1
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_ETXKEYED=0
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_RXKEYED=0
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_AUTOPATCHUP=0
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    TRANSFERCAPABILITY=SPEECH
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:     -- 9 variables
>> [Jul 21 16:58:19] DEBUG[32714] chan_dahdi.c: Using channel -2
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Prodding channel 'DAHDI/pseudo-1050151101'
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Set channel DAHDI/pseudo-1050151101 to write format slin
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Scheduling timer at 160 sample intervals
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c: Node Variable dump for node 41618:
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_NUMLINKS=2
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_LINKS=2,T40821,T3316305
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_NUMALINKS=1
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_ALINKS=1,40821TK
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_TXKEYED=1
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_ETXKEYED=0
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_RXKEYED=0
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_AUTOPATCHUP=0
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    TRANSFERCAPABILITY=SPEECH
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:     -- 9 variables
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Generator got voice, switching to phase locked mode
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Auto-deactivating generator
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Set channel DAHDI/pseudo-1050151101 to write format ulaw
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Prodding channel 'DAHDI/pseudo-1050151101'
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Set channel DAHDI/pseudo-1050151101 to write format slin
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Scheduling timer at 160 sample intervals
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Generator got voice, switching to phase locked mode
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Auto-deactivating generator
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Set channel DAHDI/pseudo-1050151101 to write format ulaw
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:58:20] DEBUG[32714] channel.c: Hanging up channel 'DAHDI/pseudo-1050151101'
>> [Jul 21 16:58:20] DEBUG[32714] chan_dahdi.c: dahdi_hangup(DAHDI/pseudo-1050151101)
>> [Jul 21 16:58:20] DEBUG[32714] chan_dahdi.c: Hangup: channel: -2 index = 0, normal = 76, callwait = -1, thirdcall = -1
>> [Jul 21 16:58:20] DEBUG[32714] chan_dahdi.c: Set option TDD MODE, value: OFF(0) on DAHDI/pseudo-1050151101
>> [Jul 21 16:58:20] DEBUG[32714] chan_dahdi.c: Updated conferencing on -2, with 0 conference users
>> [Jul 21 16:58:20] VERBOSE[32714] logger.c:     -- Hungup 'DAHDI/pseudo-1050151101'
>> [Jul 21 16:58:20] DEBUG[32714] devicestate.c: Notification of state change to be queued on device/channel DAHDI/pseudo
>> [Jul 21 16:58:20] DEBUG[31471] devicestate.c: No provider found, checking channel drivers for DAHDI - pseudo
>> [Jul 21 16:58:20] DEBUG[31471] devicestate.c: Changing state for DAHDI/pseudo - state 2 (In use)
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c: Asterisk Event Logger Started /var/log/asterisk/event_log
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c: Asterisk Dynamic Loader Starting:
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Parsing '/etc/asterisk/modules.conf': [Jul 21 16:58:35] DEBUG[32727] config.c: Parsing /etc/asterisk/modules.conf
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c: Found
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Parsing '/etc/asterisk/dnsmgr.conf': [Jul 21 16:58:35] DEBUG[32727] config.c: Parsing /etc/asterisk/dnsmgr.conf
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c: Found
>> [Jul 21 16:58:35] NOTICE[32727] dnsmgr.c: Managed DNS entries will be refreshed every 300 seconds.
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Manager registered action Ping
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Manager registered action Events
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Manager registered action Logoff
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Manager registered action Hangup
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Manager registered action Status
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Manager registered action Setvar
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Manager registered action Getvar
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Manager registered action GetConfig
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Manager registered action UpdateConfig
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Manager registered action Redirect
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Manager registered action Originate
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Manager registered action Command
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Manager registered action ExtensionState
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Manager registered action AbsoluteTimeout
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Manager registered action MailboxStatus
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Manager registered action MailboxCount
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Manager registered action ListCommands
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Manager registered action UserEvent
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Manager registered action WaitEvent
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Parsing '/etc/asterisk/manager.conf': [Jul 21 16:58:35] DEBUG[32727] config.c: Parsing /etc/asterisk/manager.conf
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c: Found
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c: Asterisk Management interface listening on port 5038
>> [Jul 21 16:58:35] NOTICE[32727] cdr.c: CDR simple logging enabled.
>> [Jul 21 16:57:50] VERBOSE[31496] logger.c:    RPT_ETXKEYED=0
>> [Jul 21 16:57:50] VERBOSE[31496] logger.c:    RPT_RXKEYED=0
>> [Jul 21 16:57:50] VERBOSE[31496] logger.c:    RPT_AUTOPATCHUP=0
>> [Jul 21 16:57:50] VERBOSE[31496] logger.c:    TRANSFERCAPABILITY=SPEECH
>> [Jul 21 16:57:50] VERBOSE[31496] logger.c:     -- 9 variables
>> [Jul 21 16:57:50] DEBUG[32708] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:50] DEBUG[32708] channel.c: Auto-deactivating generator
>> [Jul 21 16:57:50] DEBUG[32708] channel.c: Set channel DAHDI/pseudo-1112987678 to write format ulaw
>> [Jul 21 16:57:50] DEBUG[32708] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Hanging up channel 'DAHDI/pseudo-1431047561'
>> [Jul 21 16:57:50] DEBUG[32707] chan_dahdi.c: dahdi_hangup(DAHDI/pseudo-1431047561)
>> [Jul 21 16:57:50] DEBUG[32707] chan_dahdi.c: Hangup: channel: -2 index = 0, normal = 76, callwait = -1, thirdcall = -1
>> [Jul 21 16:57:50] DEBUG[32707] chan_dahdi.c: Set option TDD MODE, value: OFF(0) on DAHDI/pseudo-1431047561
>> [Jul 21 16:57:50] DEBUG[32707] chan_dahdi.c: Updated conferencing on -2, with 0 conference users
>> [Jul 21 16:57:50] VERBOSE[32707] logger.c:     -- Hungup 'DAHDI/pseudo-1431047561'
>> [Jul 21 16:57:50] DEBUG[32707] devicestate.c: Notification of state change to be queued on device/channel DAHDI/pseudo
>> [Jul 21 16:57:50] DEBUG[31471] devicestate.c: No provider found, checking channel drivers for DAHDI - pseudo
>> [Jul 21 16:57:50] DEBUG[31471] devicestate.c: Changing state for DAHDI/pseudo - state 2 (In use)
>> [Jul 21 16:57:50] DEBUG[32708] channel.c: Hanging up channel 'DAHDI/pseudo-1112987678'
>> [Jul 21 16:57:50] DEBUG[32708] chan_dahdi.c: dahdi_hangup(DAHDI/pseudo-1112987678)
>> [Jul 21 16:57:50] DEBUG[32708] chan_dahdi.c: Hangup: channel: -2 index = 0, normal = 78, callwait = -1, thirdcall = -1
>> [Jul 21 16:57:50] DEBUG[32708] chan_dahdi.c: Set option TDD MODE, value: OFF(0) on DAHDI/pseudo-1112987678
>> [Jul 21 16:57:50] DEBUG[32708] chan_dahdi.c: Updated conferencing on -2, with 0 conference users
>> [Jul 21 16:57:50] VERBOSE[32708] logger.c:     -- Hungup 'DAHDI/pseudo-1112987678'
>> [Jul 21 16:57:50] DEBUG[32708] devicestate.c: Notification of state change to be queued on device/channel DAHDI/pseudo
>> [Jul 21 16:57:50] DEBUG[31471] devicestate.c: No provider found, checking channel drivers for DAHDI - pseudo
>> [Jul 21 16:57:50] DEBUG[31471] devicestate.c: Changing state for DAHDI/pseudo - state 2 (In use)
>> [Jul 21 16:57:55] DEBUG[31489] chan_iax2.c: Received iseqno 234 not within window 235->235
>> [Jul 21 16:57:57] DEBUG[31491] chan_iax2.c: ip callno count decremented to 3 for 67.215.233.178
>> [Jul 21 16:57:59] WARNING[31485] chan_iax2.c: REGISTER-LOG: Sending registration request for '41618'
>> [Jul 21 16:57:59] DEBUG[31485] chan_iax2.c: Allocate call number
>> [Jul 21 16:57:59] DEBUG[31485] chan_iax2.c: ip callno count incremented to 4 for 67.215.233.178
>> [Jul 21 16:57:59] DEBUG[31485] chan_iax2.c: Registration created on call 3312
>> [Jul 21 16:57:59] WARNING[31484] chan_iax2.c: REGISTER-LOG: registry rereqquest
>> [Jul 21 16:57:59] DEBUG[31487] chan_iax2.c: schedule decrement of callno used for 67.215.233.178 in 60 seconds
>> [Jul 21 16:58:01] VERBOSE[31480] logger.c:     -- Received OK from Echolink server nawest.echolink.org
>> [Jul 21 16:58:01] VERBOSE[31480] logger.c:     -- Directory pgm done downloading(partial,compressed), 482 records
>> [Jul 21 16:58:02] DEBUG[31490] chan_iax2.c: Received iseqno 249 not within window 250->250
>> [Jul 21 16:58:09] DEBUG[31491] chan_iax2.c: ip callno count decremented to 3 for 67.215.233.178
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c: Node Variable dump for node 40821:
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c:    RPT_NUMLINKS=2
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c:    RPT_LINKS=2,T41618,T3316305
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c:    RPT_NUMALINKS=2
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c:    RPT_ALINKS=2,41618TU,3316305TU
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c:    RPT_ETXKEYED=0
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c:    RPT_RXKEYED=0
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c:    RPT_TXKEYED=1
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c:    RPT_AUTOPATCHUP=0
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c:     -- 8 variables
>> [Jul 21 16:58:19] DEBUG[32712] chan_dahdi.c: Using channel -2
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Prodding channel 'DAHDI/pseudo-960634253'
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Set channel DAHDI/pseudo-960634253 to write format slin
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Scheduling timer at 160 sample intervals
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Generator got voice, switching to phase locked mode
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Auto-deactivating generator
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Set channel DAHDI/pseudo-960634253 to write format ulaw
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Prodding channel 'DAHDI/pseudo-960634253'
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Set channel DAHDI/pseudo-960634253 to write format slin
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Scheduling timer at 160 sample intervals
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c: Node Variable dump for node 41618:
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_NUMLINKS=2
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_LINKS=2,T40821,T3316305
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_NUMALINKS=1
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_ALINKS=1,40821TU
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_TXKEYED=1
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_ETXKEYED=0
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_RXKEYED=0
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_AUTOPATCHUP=0
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    TRANSFERCAPABILITY=SPEECH
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:     -- 9 variables
>> [Jul 21 16:58:19] DEBUG[32713] chan_dahdi.c: Using channel -2
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Prodding channel 'DAHDI/pseudo-1502252132'
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Set channel DAHDI/pseudo-1502252132 to write format slin
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Scheduling timer at 160 sample intervals
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Generator got voice, switching to phase locked mode
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Generator got voice, switching to phase locked mode
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c: Node Variable dump for node 40821:
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c:    RPT_NUMLINKS=2
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c:    RPT_LINKS=2,T41618,T3316305
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c:    RPT_NUMALINKS=2
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c:    RPT_ALINKS=2,41618TU,3316305TK
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c:    RPT_ETXKEYED=0
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c:    RPT_RXKEYED=0
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c:    RPT_TXKEYED=1
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c:    RPT_AUTOPATCHUP=0
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c:     -- 8 variables
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Auto-deactivating generator
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Set channel DAHDI/pseudo-960634253 to write format ulaw
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Prodding channel 'DAHDI/pseudo-960634253'
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Set channel DAHDI/pseudo-960634253 to write format slin
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Scheduling timer at 160 sample intervals
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Generator got voice, switching to phase locked mode
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Auto-deactivating generator
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Set channel DAHDI/pseudo-960634253 to write format ulaw
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Prodding channel 'DAHDI/pseudo-960634253'
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Set channel DAHDI/pseudo-960634253 to write format slin
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Scheduling timer at 160 sample intervals
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Generator got voice, switching to phase locked mode
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Auto-deactivating generator
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Set channel DAHDI/pseudo-1502252132 to write format ulaw
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Prodding channel 'DAHDI/pseudo-1502252132'
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Set channel DAHDI/pseudo-1502252132 to write format slin
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Scheduling timer at 160 sample intervals
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Generator got voice, switching to phase locked mode
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Auto-deactivating generator
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Set channel DAHDI/pseudo-960634253 to write format ulaw
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c: Node Variable dump for node 41618:
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_NUMLINKS=2
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_LINKS=2,T40821,T3316305
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_NUMALINKS=1
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_ALINKS=1,40821TK
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_TXKEYED=1
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_ETXKEYED=0
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_RXKEYED=0
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_AUTOPATCHUP=0
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    TRANSFERCAPABILITY=SPEECH
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:     -- 9 variables
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Auto-deactivating generator
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Set channel DAHDI/pseudo-1502252132 to write format ulaw
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Hanging up channel 'DAHDI/pseudo-960634253'
>> [Jul 21 16:58:19] DEBUG[32712] chan_dahdi.c: dahdi_hangup(DAHDI/pseudo-960634253)
>> [Jul 21 16:58:19] DEBUG[32712] chan_dahdi.c: Hangup: channel: -2 index = 0, normal = 76, callwait = -1, thirdcall = -1
>> [Jul 21 16:58:19] DEBUG[32712] chan_dahdi.c: Set option TDD MODE, value: OFF(0) on DAHDI/pseudo-960634253
>> [Jul 21 16:58:19] DEBUG[32712] chan_dahdi.c: Updated conferencing on -2, with 0 conference users
>> [Jul 21 16:58:19] VERBOSE[32712] logger.c:     -- Hungup 'DAHDI/pseudo-960634253'
>> [Jul 21 16:58:19] DEBUG[32712] devicestate.c: Notification of state change to be queued on device/channel DAHDI/pseudo
>> [Jul 21 16:58:19] DEBUG[31471] devicestate.c: No provider found, checking channel drivers for DAHDI - pseudo
>> [Jul 21 16:58:19] DEBUG[31471] devicestate.c: Changing state for DAHDI/pseudo - state 2 (In use)
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Hanging up channel 'DAHDI/pseudo-1502252132'
>> [Jul 21 16:58:19] DEBUG[32713] chan_dahdi.c: dahdi_hangup(DAHDI/pseudo-1502252132)
>> [Jul 21 16:58:19] DEBUG[32713] chan_dahdi.c: Hangup: channel: -2 index = 0, normal = 78, callwait = -1, thirdcall = -1
>> [Jul 21 16:58:19] DEBUG[32713] chan_dahdi.c: Set option TDD MODE, value: OFF(0) on DAHDI/pseudo-1502252132
>> [Jul 21 16:58:19] DEBUG[32713] chan_dahdi.c: Updated conferencing on -2, with 0 conference users
>> [Jul 21 16:58:19] VERBOSE[32713] logger.c:     -- Hungup 'DAHDI/pseudo-1502252132'
>> [Jul 21 16:58:19] DEBUG[32713] devicestate.c: Notification of state change to be queued on device/channel DAHDI/pseudo
>> [Jul 21 16:58:19] DEBUG[31471] devicestate.c: No provider found, checking channel drivers for DAHDI - pseudo
>> [Jul 21 16:58:19] DEBUG[31471] devicestate.c: Changing state for DAHDI/pseudo - state 2 (In use)
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c: Node Variable dump for node 41618:
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_NUMLINKS=2
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_LINKS=2,T40821,T3316305
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_NUMALINKS=1
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_ALINKS=1,40821TU
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_TXKEYED=1
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_ETXKEYED=0
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_RXKEYED=0
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_AUTOPATCHUP=0
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    TRANSFERCAPABILITY=SPEECH
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:     -- 9 variables
>> [Jul 21 16:58:19] DEBUG[32714] chan_dahdi.c: Using channel -2
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Prodding channel 'DAHDI/pseudo-1050151101'
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Set channel DAHDI/pseudo-1050151101 to write format slin
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Scheduling timer at 160 sample intervals
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c: Node Variable dump for node 41618:
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_NUMLINKS=2
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_LINKS=2,T40821,T3316305
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_NUMALINKS=1
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_ALINKS=1,40821TK
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_TXKEYED=1
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_ETXKEYED=0
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_RXKEYED=0
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_AUTOPATCHUP=0
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    TRANSFERCAPABILITY=SPEECH
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:     -- 9 variables
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Generator got voice, switching to phase locked mode
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Auto-deactivating generator
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Set channel DAHDI/pseudo-1050151101 to write format ulaw
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Prodding channel 'DAHDI/pseudo-1050151101'
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Set channel DAHDI/pseudo-1050151101 to write format slin
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Scheduling timer at 160 sample intervals
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Generator got voice, switching to phase locked mode
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Auto-deactivating generator
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Set channel DAHDI/pseudo-1050151101 to write format ulaw
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:58:20] DEBUG[32714] channel.c: Hanging up channel 'DAHDI/pseudo-1050151101'
>> [Jul 21 16:58:20] DEBUG[32714] chan_dahdi.c: dahdi_hangup(DAHDI/pseudo-1050151101)
>> [Jul 21 16:58:20] DEBUG[32714] chan_dahdi.c: Hangup: channel: -2 index = 0, normal = 76, callwait = -1, thirdcall = -1
>> [Jul 21 16:58:20] DEBUG[32714] chan_dahdi.c: Set option TDD MODE, value: OFF(0) on DAHDI/pseudo-1050151101
>> [Jul 21 16:58:20] DEBUG[32714] chan_dahdi.c: Updated conferencing on -2, with 0 conference users
>> [Jul 21 16:58:20] VERBOSE[32714] logger.c:     -- Hungup 'DAHDI/pseudo-1050151101'
>> [Jul 21 16:58:20] DEBUG[32714] devicestate.c: Notification of state change to be queued on device/channel DAHDI/pseudo
>> [Jul 21 16:58:20] DEBUG[31471] devicestate.c: No provider found, checking channel drivers for DAHDI - pseudo
>> [Jul 21 16:58:20] DEBUG[31471] devicestate.c: Changing state for DAHDI/pseudo - state 2 (In use)
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c: Asterisk Event Logger Started /var/log/asterisk/event_log
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c: Asterisk Dynamic Loader Starting:
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Parsing '/etc/asterisk/modules.conf': [Jul 21 16:58:35] DEBUG[32727] config.c: Parsing /etc/asterisk/modules.conf
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c: Found
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Parsing '/etc/asterisk/dnsmgr.conf': [Jul 21 16:58:35] DEBUG[32727] config.c: Parsing /etc/asterisk/dnsmgr.conf
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c: Found
>> [Jul 21 16:58:35] NOTICE[32727] dnsmgr.c: Managed DNS entries will be refreshed every 300 seconds.
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Manager registered action Ping
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Manager registered action Events
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Manager registered action Logoff
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Manager registered action Hangup
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Manager registered action Status
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Manager registered action Setvar
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Manager registered action Getvar
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Manager registered action GetConfig
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Manager registered action UpdateConfig
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Manager registered action Redirect
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Manager registered action Originate
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Manager registered action Command
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Manager registered action ExtensionState
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Manager registered action AbsoluteTimeout
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Manager registered action MailboxStatus
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Manager registered action MailboxCount
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Manager registered action ListCommands
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Manager registered action UserEvent
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Manager registered action WaitEvent
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Parsing '/etc/asterisk/manager.conf': [Jul 21 16:58:35] DEBUG[32727] config.c: Parsing /etc/asterisk/manager.conf
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c: Found
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c: Asterisk Management interface listening on port 5038
>> [Jul 21 16:58:35] NOTICE[32727] cdr.c: CDR simple logging enabled.
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == RTP Allocating from port range 5000 -> 31000
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == UDPTL allocating from port range 4500 -> 4999
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c: Asterisk PBX Core Initializing
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c: Registering builtin applications:
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:  [Answer]
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Registered application 'Answer'
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:  [BackGround]
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Registered application 'BackGround'
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:  [Busy]
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Registered application 'Busy'
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:  [Congestion]
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Registered application 'Congestion'
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:  [Goto]
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Registered application 'Goto'
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:  [GotoIf]
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Registered application 'GotoIf'
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:  [GotoIfTime]
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Registered application 'GotoIfTime'
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:  [ExecIfTime]
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Registered application 'ExecIfTime'
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:  [Hangup]
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Registered application 'Hangup'
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:  [NoOp]
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Registered application 'NoOp'
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:  [Progress]
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Registered application 'Progress'
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:  [ResetCDR]
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Registered application 'ResetCDR'
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:  [Ringing]
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Registered application 'Ringing'
>> [Jul 21 16:57:40] VERBOSE[31496] logger.c:    RPT_ETXKEYED=0
>> [Jul 21 16:57:40] VERBOSE[31496] logger.c:    RPT_RXKEYED=0
>> [Jul 21 16:57:40] VERBOSE[31496] logger.c:    RPT_AUTOPATCHUP=0
>> [Jul 21 16:57:40] VERBOSE[31496] logger.c:    TRANSFERCAPABILITY=SPEECH
>> [Jul 21 16:57:40] VERBOSE[31496] logger.c:     -- 9 variables
>> [Jul 21 16:57:40] DEBUG[32702] chan_dahdi.c: Using channel -2
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Prodding channel 'DAHDI/pseudo-827327442'
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Set channel DAHDI/pseudo-827327442 to write format slin
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Scheduling timer at 160 sample intervals
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Generator got voice, switching to phase locked mode
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Auto-deactivating generator
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Set channel DAHDI/pseudo-827327442 to write format ulaw
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Prodding channel 'DAHDI/pseudo-827327442'
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Set channel DAHDI/pseudo-827327442 to write format slin
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Scheduling timer at 160 sample intervals
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Generator got voice, switching to phase locked mode
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Auto-deactivating generator
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Set channel DAHDI/pseudo-827327442 to write format ulaw
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:57:40] DEBUG[32702] channel.c: Hanging up channel 'DAHDI/pseudo-827327442'
>> [Jul 21 16:57:40] DEBUG[32702] chan_dahdi.c: dahdi_hangup(DAHDI/pseudo-827327442)
>> [Jul 21 16:57:40] DEBUG[32702] chan_dahdi.c: Hangup: channel: -2 index = 0, normal = 78, callwait = -1, thirdcall = -1
>> [Jul 21 16:57:40] DEBUG[32702] chan_dahdi.c: Set option TDD MODE, value: OFF(0) on DAHDI/pseudo-827327442
>> [Jul 21 16:57:40] DEBUG[32702] chan_dahdi.c: Updated conferencing on -2, with 0 conference users
>> [Jul 21 16:57:40] VERBOSE[32702] logger.c:     -- Hungup 'DAHDI/pseudo-827327442'
>> [Jul 21 16:57:40] DEBUG[32702] devicestate.c: Notification of state change to be queued on device/channel DAHDI/pseudo
>> [Jul 21 16:57:40] DEBUG[31471] devicestate.c: No provider found, checking channel drivers for DAHDI - pseudo
>> [Jul 21 16:57:40] DEBUG[31471] devicestate.c: Changing state for DAHDI/pseudo - state 2 (In use)
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Prodding channel 'DAHDI/pseudo-1742131875'
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Set channel DAHDI/pseudo-1742131875 to write format slin
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Scheduling timer at 160 sample intervals
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Generator got voice, switching to phase locked mode
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Auto-deactivating generator
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Set channel DAHDI/pseudo-1742131875 to write format ulaw
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Prodding channel 'DAHDI/pseudo-1742131875'
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Set channel DAHDI/pseudo-1742131875 to write format slin
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Scheduling timer at 160 sample intervals
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Generator got voice, switching to phase locked mode
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Auto-deactivating generator
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Set channel DAHDI/pseudo-1742131875 to write format ulaw
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Prodding channel 'DAHDI/pseudo-1742131875'
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Set channel DAHDI/pseudo-1742131875 to write format slin
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Scheduling timer at 160 sample intervals
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Generator got voice, switching to phase locked mode
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Auto-deactivating generator
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Set channel DAHDI/pseudo-1742131875 to write format ulaw
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Prodding channel 'DAHDI/pseudo-1742131875'
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Set channel DAHDI/pseudo-1742131875 to write format slin
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Scheduling timer at 160 sample intervals
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Generator got voice, switching to phase locked mode
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:57:41] VERBOSE[31495] logger.c: Node Variable dump for node 40821:
>> [Jul 21 16:57:41] VERBOSE[31495] logger.c:    RPT_NUMLINKS=2
>> [Jul 21 16:57:41] VERBOSE[31495] logger.c:    RPT_LINKS=2,T41618,T3316305
>> [Jul 21 16:57:41] VERBOSE[31495] logger.c:    RPT_NUMALINKS=2
>> [Jul 21 16:57:41] VERBOSE[31495] logger.c:    RPT_ALINKS=2,41618TU,3316305TK
>> [Jul 21 16:57:41] VERBOSE[31495] logger.c:    RPT_ETXKEYED=0
>> [Jul 21 16:57:41] VERBOSE[31495] logger.c:    RPT_RXKEYED=0
>> [Jul 21 16:57:41] VERBOSE[31495] logger.c:    RPT_TXKEYED=1
>> [Jul 21 16:57:41] VERBOSE[31495] logger.c:    RPT_AUTOPATCHUP=0
>> [Jul 21 16:57:41] VERBOSE[31495] logger.c:     -- 8 variables
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Auto-deactivating generator
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Set channel DAHDI/pseudo-1742131875 to write format ulaw
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:57:41] DEBUG[32701] channel.c: Hanging up channel 'DAHDI/pseudo-1742131875'
>> [Jul 21 16:57:41] DEBUG[32701] chan_dahdi.c: dahdi_hangup(DAHDI/pseudo-1742131875)
>> [Jul 21 16:57:41] DEBUG[32701] chan_dahdi.c: Hangup: channel: -2 index = 0, normal = 76, callwait = -1, thirdcall = -1
>> [Jul 21 16:57:41] DEBUG[32701] chan_dahdi.c: Set option TDD MODE, value: OFF(0) on DAHDI/pseudo-1742131875
>> [Jul 21 16:57:41] DEBUG[32701] chan_dahdi.c: Updated conferencing on -2, with 0 conference users
>> [Jul 21 16:57:41] VERBOSE[32701] logger.c:     -- Hungup 'DAHDI/pseudo-1742131875'
>> [Jul 21 16:57:41] DEBUG[32701] devicestate.c: Notification of state change to be queued on device/channel DAHDI/pseudo
>> [Jul 21 16:57:41] DEBUG[31471] devicestate.c: No provider found, checking channel drivers for DAHDI - pseudo
>> [Jul 21 16:57:41] DEBUG[31471] devicestate.c: Changing state for DAHDI/pseudo - state 2 (In use)
>> [Jul 21 16:57:41] VERBOSE[31496] logger.c: Node Variable dump for node 41618:
>> [Jul 21 16:57:41] VERBOSE[31496] logger.c:    RPT_NUMLINKS=2
>> [Jul 21 16:57:41] VERBOSE[31496] logger.c:    RPT_LINKS=2,T40821,T3316305
>> [Jul 21 16:57:41] VERBOSE[31496] logger.c:    RPT_NUMALINKS=1
>> [Jul 21 16:57:41] VERBOSE[31496] logger.c:    RPT_ALINKS=1,40821TK
>> [Jul 21 16:57:41] VERBOSE[31496] logger.c:    RPT_TXKEYED=1
>> [Jul 21 16:57:41] VERBOSE[31496] logger.c:    RPT_ETXKEYED=0
>> [Jul 21 16:57:41] VERBOSE[31496] logger.c:    RPT_RXKEYED=0
>> [Jul 21 16:57:41] VERBOSE[31496] logger.c:    RPT_AUTOPATCHUP=0
>> [Jul 21 16:57:41] VERBOSE[31496] logger.c:    TRANSFERCAPABILITY=SPEECH
>> [Jul 21 16:57:41] VERBOSE[31496] logger.c:     -- 9 variables
>> [Jul 21 16:57:41] DEBUG[31496] chan_dahdi.c: Write returned -1 (Resource temporarily unavailable) on channel -2
>> [Jul 21 16:57:47] WARNING[31487] chan_iax2.c: REGISTER-LOG: Sending registration request for '42032'
>> [Jul 21 16:57:47] DEBUG[31487] chan_iax2.c: Allocate call number
>> [Jul 21 16:57:47] DEBUG[31487] chan_iax2.c: ip callno count incremented to 5 for 67.215.233.178
>> [Jul 21 16:57:47] DEBUG[31487] chan_iax2.c: Registration created on call 10837
>> [Jul 21 16:57:47] WARNING[31488] chan_iax2.c: REGISTER-LOG: registry rereqquest
>> [Jul 21 16:57:47] DEBUG[31490] chan_iax2.c: schedule decrement of callno used for 67.215.233.178 in 60 seconds
>> [Jul 21 16:57:49] DEBUG[31491] chan_iax2.c: ip callno count decremented to 4 for 67.215.233.178
>> [Jul 21 16:57:50] VERBOSE[31495] logger.c: Node Variable dump for node 40821:
>> [Jul 21 16:57:50] VERBOSE[31495] logger.c:    RPT_NUMLINKS=2
>> [Jul 21 16:57:50] VERBOSE[31495] logger.c:    RPT_LINKS=2,T41618,T3316305
>> [Jul 21 16:57:50] VERBOSE[31495] logger.c:    RPT_NUMALINKS=2
>> [Jul 21 16:57:50] VERBOSE[31495] logger.c:    RPT_ALINKS=2,41618TU,3316305TU
>> [Jul 21 16:57:50] VERBOSE[31495] logger.c:    RPT_ETXKEYED=0
>> [Jul 21 16:57:50] VERBOSE[31495] logger.c:    RPT_RXKEYED=0
>> [Jul 21 16:57:50] VERBOSE[31495] logger.c:    RPT_TXKEYED=1
>> [Jul 21 16:57:50] VERBOSE[31495] logger.c:    RPT_AUTOPATCHUP=0
>> [Jul 21 16:57:50] VERBOSE[31495] logger.c:     -- 8 variables
>> [Jul 21 16:57:50] DEBUG[32707] chan_dahdi.c: Using channel -2
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Prodding channel 'DAHDI/pseudo-1431047561'
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Set channel DAHDI/pseudo-1431047561 to write format slin
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Scheduling timer at 160 sample intervals
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Generator got voice, switching to phase locked mode
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Auto-deactivating generator
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Set channel DAHDI/pseudo-1431047561 to write format ulaw
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Prodding channel 'DAHDI/pseudo-1431047561'
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Set channel DAHDI/pseudo-1431047561 to write format slin
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Scheduling timer at 160 sample intervals
>> [Jul 21 16:57:50] VERBOSE[31496] logger.c: Node Variable dump for node 41618:
>> [Jul 21 16:57:50] VERBOSE[31496] logger.c:    RPT_NUMLINKS=2
>> [Jul 21 16:57:50] VERBOSE[31496] logger.c:    RPT_LINKS=2,T40821,T3316305
>> [Jul 21 16:57:50] VERBOSE[31496] logger.c:    RPT_NUMALINKS=1
>> [Jul 21 16:57:50] VERBOSE[31496] logger.c:    RPT_ALINKS=1,40821TU
>> [Jul 21 16:57:50] VERBOSE[31496] logger.c:    RPT_TXKEYED=1
>> [Jul 21 16:57:50] VERBOSE[31496] logger.c:    RPT_ETXKEYED=0
>> [Jul 21 16:57:50] VERBOSE[31496] logger.c:    RPT_RXKEYED=0
>> [Jul 21 16:57:50] VERBOSE[31496] logger.c:    RPT_AUTOPATCHUP=0
>> [Jul 21 16:57:50] VERBOSE[31496] logger.c:    TRANSFERCAPABILITY=SPEECH
>> [Jul 21 16:57:50] VERBOSE[31496] logger.c:     -- 9 variables
>> [Jul 21 16:57:50] DEBUG[32708] chan_dahdi.c: Using channel -2
>> [Jul 21 16:57:50] DEBUG[32708] channel.c: Prodding channel 'DAHDI/pseudo-1112987678'
>> [Jul 21 16:57:50] DEBUG[32708] channel.c: Set channel DAHDI/pseudo-1112987678 to write format slin
>> [Jul 21 16:57:50] DEBUG[32708] channel.c: Scheduling timer at 160 sample intervals
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Generator got voice, switching to phase locked mode
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:57:50] DEBUG[32708] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:50] DEBUG[32708] channel.c: Generator got voice, switching to phase locked mode
>> [Jul 21 16:57:50] DEBUG[32708] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:57:50] DEBUG[32708] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:57:50] DEBUG[32708] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Auto-deactivating generator
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Set channel DAHDI/pseudo-1431047561 to write format ulaw
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Prodding channel 'DAHDI/pseudo-1431047561'
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Set channel DAHDI/pseudo-1431047561 to write format slin
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Scheduling timer at 160 sample intervals
>> [Jul 21 16:57:50] DEBUG[32708] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Generator got voice, switching to phase locked mode
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:57:50] DEBUG[32708] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:57:50] DEBUG[32708] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Auto-deactivating generator
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Set channel DAHDI/pseudo-1431047561 to write format ulaw
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Prodding channel 'DAHDI/pseudo-1431047561'
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Set channel DAHDI/pseudo-1431047561 to write format slin
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Scheduling timer at 160 sample intervals
>> [Jul 21 16:57:50] DEBUG[32708] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Generator got voice, switching to phase locked mode
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:57:50] DEBUG[32708] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:50] DEBUG[32708] channel.c: Auto-deactivating generator
>> [Jul 21 16:57:50] DEBUG[32708] channel.c: Set channel DAHDI/pseudo-1112987678 to write format ulaw
>> [Jul 21 16:57:50] DEBUG[32708] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:57:50] DEBUG[32708] channel.c: Prodding channel 'DAHDI/pseudo-1112987678'
>> [Jul 21 16:57:50] DEBUG[32708] channel.c: Set channel DAHDI/pseudo-1112987678 to write format slin
>> [Jul 21 16:57:50] DEBUG[32708] channel.c: Scheduling timer at 160 sample intervals
>> [Jul 21 16:57:50] VERBOSE[31495] logger.c: Node Variable dump for node 40821:
>> [Jul 21 16:57:50] VERBOSE[31495] logger.c:    RPT_NUMLINKS=2
>> [Jul 21 16:57:50] VERBOSE[31495] logger.c:    RPT_LINKS=2,T41618,T3316305
>> [Jul 21 16:57:50] VERBOSE[31495] logger.c:    RPT_NUMALINKS=2
>> [Jul 21 16:57:50] VERBOSE[31495] logger.c:    RPT_ALINKS=2,41618TU,3316305TK
>> [Jul 21 16:57:50] VERBOSE[31495] logger.c:    RPT_ETXKEYED=0
>> [Jul 21 16:57:50] VERBOSE[31495] logger.c:    RPT_RXKEYED=0
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:57:50] VERBOSE[31495] logger.c:    RPT_TXKEYED=1
>> [Jul 21 16:57:50] VERBOSE[31495] logger.c:    RPT_AUTOPATCHUP=0
>> [Jul 21 16:57:50] VERBOSE[31495] logger.c:     -- 8 variables
>> [Jul 21 16:57:50] DEBUG[32708] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:50] DEBUG[32708] channel.c: Generator got voice, switching to phase locked mode
>> [Jul 21 16:57:50] DEBUG[32708] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:57:50] DEBUG[32708] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:57:50] DEBUG[32708] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Auto-deactivating generator
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Set channel DAHDI/pseudo-1431047561 to write format ulaw
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:57:50] VERBOSE[31496] logger.c: Node Variable dump for node 41618:
>> [Jul 21 16:57:50] VERBOSE[31496] logger.c:    RPT_NUMLINKS=2
>> [Jul 21 16:57:50] VERBOSE[31496] logger.c:    RPT_LINKS=2,T40821,T3316305
>> [Jul 21 16:57:50] VERBOSE[31496] logger.c:    RPT_NUMALINKS=1
>> [Jul 21 16:57:50] VERBOSE[31496] logger.c:    RPT_ALINKS=1,40821TK
>> [Jul 21 16:57:50] DEBUG[32708] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:50] VERBOSE[31496] logger.c:    RPT_TXKEYED=1
>> [Jul 21 16:57:50] VERBOSE[31496] logger.c:    RPT_ETXKEYED=0
>> [Jul 21 16:57:50] VERBOSE[31496] logger.c:    RPT_RXKEYED=0
>> [Jul 21 16:57:50] VERBOSE[31496] logger.c:    RPT_AUTOPATCHUP=0
>> [Jul 21 16:57:50] VERBOSE[31496] logger.c:    TRANSFERCAPABILITY=SPEECH
>> [Jul 21 16:57:50] VERBOSE[31496] logger.c:     -- 9 variables
>> [Jul 21 16:57:50] DEBUG[32708] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:57:50] DEBUG[32708] channel.c: Auto-deactivating generator
>> [Jul 21 16:57:50] DEBUG[32708] channel.c: Set channel DAHDI/pseudo-1112987678 to write format ulaw
>> [Jul 21 16:57:50] DEBUG[32708] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:57:50] DEBUG[32707] channel.c: Hanging up channel 'DAHDI/pseudo-1431047561'
>> [Jul 21 16:57:50] DEBUG[32707] chan_dahdi.c: dahdi_hangup(DAHDI/pseudo-1431047561)
>> [Jul 21 16:57:50] DEBUG[32707] chan_dahdi.c: Hangup: channel: -2 index = 0, normal = 76, callwait = -1, thirdcall = -1
>> [Jul 21 16:57:50] DEBUG[32707] chan_dahdi.c: Set option TDD MODE, value: OFF(0) on DAHDI/pseudo-1431047561
>> [Jul 21 16:57:50] DEBUG[32707] chan_dahdi.c: Updated conferencing on -2, with 0 conference users
>> [Jul 21 16:57:50] VERBOSE[32707] logger.c:     -- Hungup 'DAHDI/pseudo-1431047561'
>> [Jul 21 16:57:50] DEBUG[32707] devicestate.c: Notification of state change to be queued on device/channel DAHDI/pseudo
>> [Jul 21 16:57:50] DEBUG[31471] devicestate.c: No provider found, checking channel drivers for DAHDI - pseudo
>> [Jul 21 16:57:50] DEBUG[31471] devicestate.c: Changing state for DAHDI/pseudo - state 2 (In use)
>> [Jul 21 16:57:50] DEBUG[32708] channel.c: Hanging up channel 'DAHDI/pseudo-1112987678'
>> [Jul 21 16:57:50] DEBUG[32708] chan_dahdi.c: dahdi_hangup(DAHDI/pseudo-1112987678)
>> [Jul 21 16:57:50] DEBUG[32708] chan_dahdi.c: Hangup: channel: -2 index = 0, normal = 78, callwait = -1, thirdcall = -1
>> [Jul 21 16:57:50] DEBUG[32708] chan_dahdi.c: Set option TDD MODE, value: OFF(0) on DAHDI/pseudo-1112987678
>> [Jul 21 16:57:50] DEBUG[32708] chan_dahdi.c: Updated conferencing on -2, with 0 conference users
>> [Jul 21 16:57:50] VERBOSE[32708] logger.c:     -- Hungup 'DAHDI/pseudo-1112987678'
>> [Jul 21 16:57:50] DEBUG[32708] devicestate.c: Notification of state change to be queued on device/channel DAHDI/pseudo
>> [Jul 21 16:57:50] DEBUG[31471] devicestate.c: No provider found, checking channel drivers for DAHDI - pseudo
>> [Jul 21 16:57:50] DEBUG[31471] devicestate.c: Changing state for DAHDI/pseudo - state 2 (In use)
>> [Jul 21 16:57:55] DEBUG[31489] chan_iax2.c: Received iseqno 234 not within window 235->235
>> [Jul 21 16:57:57] DEBUG[31491] chan_iax2.c: ip callno count decremented to 3 for 67.215.233.178
>> [Jul 21 16:57:59] WARNING[31485] chan_iax2.c: REGISTER-LOG: Sending registration request for '41618'
>> [Jul 21 16:57:59] DEBUG[31485] chan_iax2.c: Allocate call number
>> [Jul 21 16:57:59] DEBUG[31485] chan_iax2.c: ip callno count incremented to 4 for 67.215.233.178
>> [Jul 21 16:57:59] DEBUG[31485] chan_iax2.c: Registration created on call 3312
>> [Jul 21 16:57:59] WARNING[31484] chan_iax2.c: REGISTER-LOG: registry rereqquest
>> [Jul 21 16:57:59] DEBUG[31487] chan_iax2.c: schedule decrement of callno used for 67.215.233.178 in 60 seconds
>> [Jul 21 16:58:01] VERBOSE[31480] logger.c:     -- Received OK from Echolink server nawest.echolink.org
>> [Jul 21 16:58:01] VERBOSE[31480] logger.c:     -- Directory pgm done downloading(partial,compressed), 482 records
>> [Jul 21 16:58:02] DEBUG[31490] chan_iax2.c: Received iseqno 249 not within window 250->250
>> [Jul 21 16:58:09] DEBUG[31491] chan_iax2.c: ip callno count decremented to 3 for 67.215.233.178
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c: Node Variable dump for node 40821:
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c:    RPT_NUMLINKS=2
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c:    RPT_LINKS=2,T41618,T3316305
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c:    RPT_NUMALINKS=2
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c:    RPT_ALINKS=2,41618TU,3316305TU
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c:    RPT_ETXKEYED=0
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c:    RPT_RXKEYED=0
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c:    RPT_TXKEYED=1
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c:    RPT_AUTOPATCHUP=0
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c:     -- 8 variables
>> [Jul 21 16:58:19] DEBUG[32712] chan_dahdi.c: Using channel -2
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Prodding channel 'DAHDI/pseudo-960634253'
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Set channel DAHDI/pseudo-960634253 to write format slin
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Scheduling timer at 160 sample intervals
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Generator got voice, switching to phase locked mode
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Auto-deactivating generator
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Set channel DAHDI/pseudo-960634253 to write format ulaw
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Prodding channel 'DAHDI/pseudo-960634253'
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Set channel DAHDI/pseudo-960634253 to write format slin
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Scheduling timer at 160 sample intervals
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c: Node Variable dump for node 41618:
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_NUMLINKS=2
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_LINKS=2,T40821,T3316305
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_NUMALINKS=1
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_ALINKS=1,40821TU
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_TXKEYED=1
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_ETXKEYED=0
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_RXKEYED=0
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_AUTOPATCHUP=0
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    TRANSFERCAPABILITY=SPEECH
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:     -- 9 variables
>> [Jul 21 16:58:19] DEBUG[32713] chan_dahdi.c: Using channel -2
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Prodding channel 'DAHDI/pseudo-1502252132'
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Set channel DAHDI/pseudo-1502252132 to write format slin
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Scheduling timer at 160 sample intervals
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Generator got voice, switching to phase locked mode
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Generator got voice, switching to phase locked mode
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c: Node Variable dump for node 40821:
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c:    RPT_NUMLINKS=2
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c:    RPT_LINKS=2,T41618,T3316305
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c:    RPT_NUMALINKS=2
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c:    RPT_ALINKS=2,41618TU,3316305TK
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c:    RPT_ETXKEYED=0
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c:    RPT_RXKEYED=0
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c:    RPT_TXKEYED=1
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c:    RPT_AUTOPATCHUP=0
>> [Jul 21 16:58:19] VERBOSE[31495] logger.c:     -- 8 variables
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Auto-deactivating generator
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Set channel DAHDI/pseudo-960634253 to write format ulaw
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Prodding channel 'DAHDI/pseudo-960634253'
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Set channel DAHDI/pseudo-960634253 to write format slin
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Scheduling timer at 160 sample intervals
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Generator got voice, switching to phase locked mode
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Auto-deactivating generator
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Set channel DAHDI/pseudo-960634253 to write format ulaw
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Prodding channel 'DAHDI/pseudo-960634253'
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Set channel DAHDI/pseudo-960634253 to write format slin
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Scheduling timer at 160 sample intervals
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Generator got voice, switching to phase locked mode
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Auto-deactivating generator
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Set channel DAHDI/pseudo-1502252132 to write format ulaw
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Prodding channel 'DAHDI/pseudo-1502252132'
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Set channel DAHDI/pseudo-1502252132 to write format slin
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Scheduling timer at 160 sample intervals
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Generator got voice, switching to phase locked mode
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Auto-deactivating generator
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Set channel DAHDI/pseudo-960634253 to write format ulaw
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c: Node Variable dump for node 41618:
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_NUMLINKS=2
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_LINKS=2,T40821,T3316305
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_NUMALINKS=1
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_ALINKS=1,40821TK
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_TXKEYED=1
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_ETXKEYED=0
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_RXKEYED=0
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_AUTOPATCHUP=0
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    TRANSFERCAPABILITY=SPEECH
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:     -- 9 variables
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=79)
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Auto-deactivating generator
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Set channel DAHDI/pseudo-1502252132 to write format ulaw
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:58:19] DEBUG[32712] channel.c: Hanging up channel 'DAHDI/pseudo-960634253'
>> [Jul 21 16:58:19] DEBUG[32712] chan_dahdi.c: dahdi_hangup(DAHDI/pseudo-960634253)
>> [Jul 21 16:58:19] DEBUG[32712] chan_dahdi.c: Hangup: channel: -2 index = 0, normal = 76, callwait = -1, thirdcall = -1
>> [Jul 21 16:58:19] DEBUG[32712] chan_dahdi.c: Set option TDD MODE, value: OFF(0) on DAHDI/pseudo-960634253
>> [Jul 21 16:58:19] DEBUG[32712] chan_dahdi.c: Updated conferencing on -2, with 0 conference users
>> [Jul 21 16:58:19] VERBOSE[32712] logger.c:     -- Hungup 'DAHDI/pseudo-960634253'
>> [Jul 21 16:58:19] DEBUG[32712] devicestate.c: Notification of state change to be queued on device/channel DAHDI/pseudo
>> [Jul 21 16:58:19] DEBUG[31471] devicestate.c: No provider found, checking channel drivers for DAHDI - pseudo
>> [Jul 21 16:58:19] DEBUG[31471] devicestate.c: Changing state for DAHDI/pseudo - state 2 (In use)
>> [Jul 21 16:58:19] DEBUG[32713] channel.c: Hanging up channel 'DAHDI/pseudo-1502252132'
>> [Jul 21 16:58:19] DEBUG[32713] chan_dahdi.c: dahdi_hangup(DAHDI/pseudo-1502252132)
>> [Jul 21 16:58:19] DEBUG[32713] chan_dahdi.c: Hangup: channel: -2 index = 0, normal = 78, callwait = -1, thirdcall = -1
>> [Jul 21 16:58:19] DEBUG[32713] chan_dahdi.c: Set option TDD MODE, value: OFF(0) on DAHDI/pseudo-1502252132
>> [Jul 21 16:58:19] DEBUG[32713] chan_dahdi.c: Updated conferencing on -2, with 0 conference users
>> [Jul 21 16:58:19] VERBOSE[32713] logger.c:     -- Hungup 'DAHDI/pseudo-1502252132'
>> [Jul 21 16:58:19] DEBUG[32713] devicestate.c: Notification of state change to be queued on device/channel DAHDI/pseudo
>> [Jul 21 16:58:19] DEBUG[31471] devicestate.c: No provider found, checking channel drivers for DAHDI - pseudo
>> [Jul 21 16:58:19] DEBUG[31471] devicestate.c: Changing state for DAHDI/pseudo - state 2 (In use)
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c: Node Variable dump for node 41618:
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_NUMLINKS=2
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_LINKS=2,T40821,T3316305
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_NUMALINKS=1
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_ALINKS=1,40821TU
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_TXKEYED=1
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_ETXKEYED=0
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_RXKEYED=0
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_AUTOPATCHUP=0
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    TRANSFERCAPABILITY=SPEECH
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:     -- 9 variables
>> [Jul 21 16:58:19] DEBUG[32714] chan_dahdi.c: Using channel -2
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Prodding channel 'DAHDI/pseudo-1050151101'
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Set channel DAHDI/pseudo-1050151101 to write format slin
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Scheduling timer at 160 sample intervals
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c: Node Variable dump for node 41618:
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_NUMLINKS=2
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_LINKS=2,T40821,T3316305
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_NUMALINKS=1
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_ALINKS=1,40821TK
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_TXKEYED=1
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_ETXKEYED=0
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_RXKEYED=0
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    RPT_AUTOPATCHUP=0
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:    TRANSFERCAPABILITY=SPEECH
>> [Jul 21 16:58:19] VERBOSE[31496] logger.c:     -- 9 variables
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Generator got voice, switching to phase locked mode
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Auto-deactivating generator
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Set channel DAHDI/pseudo-1050151101 to write format ulaw
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Prodding channel 'DAHDI/pseudo-1050151101'
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Set channel DAHDI/pseudo-1050151101 to write format slin
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Scheduling timer at 160 sample intervals
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Generator got voice, switching to phase locked mode
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Internal timing is disabled (option_internal_timing=0 chan->timingfd=77)
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Auto-deactivating generator
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Set channel DAHDI/pseudo-1050151101 to write format ulaw
>> [Jul 21 16:58:19] DEBUG[32714] channel.c: Scheduling timer at 0 sample intervals
>> [Jul 21 16:58:20] DEBUG[32714] channel.c: Hanging up channel 'DAHDI/pseudo-1050151101'
>> [Jul 21 16:58:20] DEBUG[32714] chan_dahdi.c: dahdi_hangup(DAHDI/pseudo-1050151101)
>> [Jul 21 16:58:20] DEBUG[32714] chan_dahdi.c: Hangup: channel: -2 index = 0, normal = 76, callwait = -1, thirdcall = -1
>> [Jul 21 16:58:20] DEBUG[32714] chan_dahdi.c: Set option TDD MODE, value: OFF(0) on DAHDI/pseudo-1050151101
>> [Jul 21 16:58:20] DEBUG[32714] chan_dahdi.c: Updated conferencing on -2, with 0 conference users
>> [Jul 21 16:58:20] VERBOSE[32714] logger.c:     -- Hungup 'DAHDI/pseudo-1050151101'
>> [Jul 21 16:58:20] DEBUG[32714] devicestate.c: Notification of state change to be queued on device/channel DAHDI/pseudo
>> [Jul 21 16:58:20] DEBUG[31471] devicestate.c: No provider found, checking channel drivers for DAHDI - pseudo
>> [Jul 21 16:58:20] DEBUG[31471] devicestate.c: Changing state for DAHDI/pseudo - state 2 (In use)
> Last log message before segfault
>
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c: Asterisk Event Logger Started /var/log/asterisk/event_log
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c: Asterisk Dynamic Loader Starting:
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Parsing '/etc/asterisk/modules.conf': [Jul 21 16:58:35] DEBUG[32727] config.c: Parsing /etc/asterisk/modules.conf
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c: Found
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Parsing '/etc/asterisk/dnsmgr.conf': [Jul 21 16:58:35] DEBUG[32727] config.c: Parsing /etc/asterisk/dnsmgr.conf
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c: Found
>> [Jul 21 16:58:35] NOTICE[32727] dnsmgr.c: Managed DNS entries will be refreshed every 300 seconds.
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Manager registered action Ping
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Manager registered action Events
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Manager registered action Logoff
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Manager registered action Hangup
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Manager registered action Status
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Manager registered action Setvar
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Manager registered action Getvar
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Manager registered action GetConfig
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Manager registered action UpdateConfig
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Manager registered action Redirect
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Manager registered action Originate
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Manager registered action Command
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Manager registered action ExtensionState
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Manager registered action AbsoluteTimeout
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Manager registered action MailboxStatus
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Manager registered action MailboxCount
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Manager registered action ListCommands
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Manager registered action UserEvent
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Manager registered action WaitEvent
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == Parsing '/etc/asterisk/manager.conf': [Jul 21 16:58:35] DEBUG[32727] config.c: Parsing /etc/asterisk/manager.conf
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c: Found
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c: Asterisk Management interface listening on port 5038
>> [Jul 21 16:58:35] NOTICE[32727] cdr.c: CDR simple logging enabled.
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == RTP Allocating from port range 5000 -> 31000
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c:   == UDPTL allocating from port range 4500 -> 4999
>> [Jul 21 16:58:35] VERBOSE[32727] logger.c: Asterisk PBX Core Initializing
> Any ideas?  It did not write a coredump, so I need to fix that for next time.
>
>