[ previous ] [ next ] [ threads ]
 To :  Marian Podgoreanu <marian@v...>
 From :  Milan Rukavina <rukavinamilan@g...>
 Subject :  Re: [yate] Sangoma USBfxo analog card
 Date :  Wed, 02 Jun 2010 19:15:49 +0200
Hi Marian Podgoreanu,

Here are attached logs with answer-on-polarity yes/no and delay default/0.

Is there anything more I could configure?

Thanks,
Milan
> Hi,
>
> Please enable the message sniffer (yate.conf, msgsniff=on) to see all
> the messages sent by the analog channel.
> Let the call ringing, don't hangup, for at least twice the delay dial
> value (defaults to 2s).
>
> For tone detector: it seems the device does not support it.
> You can disable tone detection in zapcard.conf (yate will attach its
> own detector on incoming calls).
> [house]
> dtmfdetect=disable
>
> Marian
>
> Milan Rukavina wrote:
>> Hi Marian,
>>
>> When I set on answer-on-polarity I can make outgoing call - other party
>> rings, but when it picks up a call, yate doesn't make it answered, so
>> nothing happens. So as you explained seems like line polarity changes
>> are not supported.
>>
>> I tried to tweak delaydial but without success. If it's grater than 0
>> calls becomes answered and I can hear dialtone, if it's 0 call is
>> answered as well but no dialtone. In any case seems like no actual
>> dialing is done. I tried to change this parameter in analog and in route
>> in regexroute but no dialing is done.
>>
>> One more thing I noticed - on startup there's note:
>>
>>  ZapCircuit driver=zaptel type=FXO channel=1 cic=1
>> dtmfdetect=true echotaps=0 echotrain=400 buflen=255 readonly=false
>> idlevalue=255 priority=normal [0x6ad150]
>>  ZapSpan('') driver=zaptel section=span1 type=FXO channels=1
>> circuits=1 [0x6ac670]
>>  ZapCircuit driver=zaptel type=FXO channel=2 cic=2
>> dtmfdetect=true echotaps=0 echotrain=400 buflen=255 readonly=false
>> idlevalue=255 priority=normal [0x6ad6a0]
>>  ZapSpan('') driver=zaptel section=span2 type=FXO channels=2
>> circuits=2 [0x6ad540]
>> * ZapCircuit(1). IOCTL(SetToneDetect) failed on channel 1
>> (param=3). 38: Function not implemented [0x6ac100]
>>  ZapCircuit(1). IOCTL(SetToneDetect) failed on channel 1
>> (param=3). 38: Function not implemented [0x6ac100]
>>  ZapCircuit(2). IOCTL(SetToneDetect) failed on channel 2
>> (param=3). 38: Function not implemented [0x6ac100]
>>  ZapCircuit(2). IOCTL(SetToneDetect) failed on channel 2
>> (param=3). 38: Function not implemented [0x6ac100]*
>>
>> Does it have anything to do with this dialing problem?
>>
>> Thanks,
>> Milan
>>> Hi,
>>>
>>> Try to set
>>> delaydial=0
>>> in the line's group in analog.conf.
>>> This will send the called number just after the off hook notification.
>>>
>>> You should also test if your provider and device support line polarity
>>> changes.
>>> Set
>>> answer-on-polarity=yes
>>> hangup-on-polarity=yes
>>> in the line's group in analog.conf.
>>> If line polarity changes are not supported by your provider or device
>>> there is no way to detect when an outgoing call is answered so it will
>>> be declared answered as soon as the number is sent.
>>>
>>> Marian
>>>
>>> Milan Rukavina wrote:
>>>> Hi,
>>>>
>>>> I'm still not able to make outbound call. Soon after I try to call
>>>> - it
>>>> says "connected" and I hear dialtone from analog line but no actual
>>>> dialing is made. Any help or hint would be helpful. Here is console
>>>> output. I'm calling 995 - rewritten by regex to 95 - but just hear
>>>> dialtone. You can notice line where analog returned status 'answered'
>>>> where the call is not really answered. Disregard 'asterisk' word it's
>>>> just realm property:
>>>>
>>>>  Received 650 bytes SIP message from 192.168.1.2:5061
>>>> ------
>>>> INVITE sip:995@asterisk SIP/2.0
>>>> Via: SIP/2.0/UDP
>>>> 192.168.1.2:5061;rport;branch=z9hG4bK57F15274F410AB8CBFBAAB810E6EE6BA
>>>> From: 1001 ;tag=162244127
>>>> To: 
>>>> Contact: 
>>>> Call-ID: 0ADFB37B-86DF-983E-B4E9-EEE0D43A044D@1...
>>>> CSeq: 38311 INVITE
>>>> Max-Forwards: 70
>>>> Content-Type: application/sdp
>>>> User-Agent: X-Lite release 1105d
>>>> Content-Length: 231
>>>>
>>>> v=0
>>>> o=1001 3844635156 3844635208 IN IP4 192.168.1.2
>>>> s=X-Lite
>>>> c=IN IP4 192.168.1.2
>>>> t=0 0
>>>> m=audio 8000 RTP/AVP 0 8 101
>>>> a=rtpmap:0 pcmu/8000
>>>> a=rtpmap:8 pcma/8000
>>>> a=rtpmap:101 telephone-event/8000
>>>> a=fmtp:101 0-15
>>>> a=sendrecv
>>>> ------
>>>>  Sending code 100 0x6d0c20 to 192.168.1.2:5061
>>>> ------
>>>> SIP/2.0 100 Trying
>>>> Via: SIP/2.0/UDP
>>>> 192.168.1.2:5061;rport=5061;branch=z9hG4bK57F15274F410AB8CBFBAAB810E6EE6BA;received=192.168.1.2
>>>>
>>>>
>>>> From: 1001 ;tag=162244127
>>>> To: 
>>>> Call-ID: 0ADFB37B-86DF-983E-B4E9-EEE0D43A044D@1...
>>>> CSeq: 38311 INVITE
>>>> Server: YATE/2.2.0
>>>> Content-Length: 0
>>>>
>>>> ------
>>>>  Could not classify call from '1001', wasted 15563 usec
>>>>  Routing call to '995' in context 'default' via
>>>> 'analog/house' in
>>>> 2379 usec
>>>>  Executing call. caller=1001 called=95 line=house/1
>>>>  Outgoing call on line house/1 caller=1001 called=95
>>>> [0x6e6200]
>>>>  status=answered [0x6e6200]
>>>>  Guessed local IP '192.168.1.2' for remote '192.168.1.2'
>>>>  Session 'yrtp/2118801173' 0x6eba60 bound to
>>>> 192.168.1.2:27750 +RTCP [0x6eaf10]
>>>>  DataTranslator::attachChain [0x697080] '(null)' -> [0x6a8c80]
>>>> 'mulaw' not possible
>>>>  DataTranslator::attachChain [0x6d14f0] 'mulaw' -> [0x6971b0]
>>>> '(null)' not possible
>>>>  Sending code 200 0x6a3c10 to 192.168.1.2:5061
>>>> ------
>>>> SIP/2.0 200 OK
>>>> Via: SIP/2.0/UDP
>>>> 192.168.1.2:5061;rport=5061;branch=z9hG4bK57F15274F410AB8CBFBAAB810E6EE6BA;received=192.168.1.2
>>>>
>>>>
>>>> From: 1001 ;tag=162244127
>>>> To: ;tag=610486506
>>>> Call-ID: 0ADFB37B-86DF-983E-B4E9-EEE0D43A044D@1...
>>>> CSeq: 38311 INVITE
>>>> Server: YATE/2.2.0
>>>> Contact: 
>>>> Allow: ACK, INVITE, BYE, CANCEL, REGISTER, REFER, OPTIONS, INFO
>>>> Content-Type: application/sdp
>>>> Content-Length: 205
>>>>
>>>> v=0
>>>> o=yate 1275154956 1275154956 IN IP4 192.168.1.2
>>>> s=SIP Call
>>>> c=IN IP4 192.168.1.2
>>>> t=0 0
>>>> m=audio 27750 RTP/AVP 0 8 101
>>>> a=rtpmap:0 PCMU/8000
>>>> a=rtpmap:8 PCMA/8000
>>>> a=rtpmap:101 telephone-event/8000
>>>> ------
>>>>  Received 368 bytes SIP message from 192.168.1.2:5061
>>>> ------
>>>> ACK sip:995@1...:5060 SIP/2.0
>>>> Via: SIP/2.0/UDP
>>>> 192.168.1.2:5061;rport;branch=z9hG4bK101D604D5CAD0E8D0C67398D76A77330
>>>> From: 1001 ;tag=162244127
>>>> To: ;tag=610486506
>>>> Contact: 
>>>> Call-ID: 0ADFB37B-86DF-983E-B4E9-EEE0D43A044D@1...
>>>> CSeq: 38311 ACK
>>>> Max-Forwards: 70
>>>> Content-Length: 0
>>>>
>>>> ------
>>>>  RTP starting format 'mulaw' payload 0 [0x6eaf10]
>>>>  Choosing started 'audio' format 'mulaw' [0x6e8490]
>>>>  ZapCircuit(1). Buffer overrun old=640 channel=1 (11:
>>>> Resource temporarily unavailable) [0x6ace20]
>>>>  ZapCircuit(1). Buffer overrun old=640 channel=1 (11:
>>>> Resource temporarily unavailable) [0x6ace20]
>>>>  ZapCircuit(1). Buffer overrun old=640 channel=1 (11:
>>>> Resource temporarily unavailable) [0x6ace20]
>>>>  Received 402 bytes SIP message from 192.168.1.2:5061
>>>> ------
>>>> BYE sip:995@1...:5060 SIP/2.0
>>>> Via: SIP/2.0/UDP
>>>> 192.168.1.2:5061;rport;branch=z9hG4bK12D4A5734F21B3C36B3D464960A4DE45
>>>> From: 1001 ;tag=162244127
>>>> To: ;tag=610486506
>>>> Contact: 
>>>> Call-ID: 0ADFB37B-86DF-983E-B4E9-EEE0D43A044D@1...
>>>> CSeq: 38312 BYE
>>>> Max-Forwards: 70
>>>> User-Agent: X-Lite release 1105d
>>>> Content-Length: 0
>>>>
>>>> ------
>>>>  Sending code 100 0x6d0c20 to 192.168.1.2:5061
>>>> ------
>>>> SIP/2.0 100 Trying
>>>> Via: SIP/2.0/UDP
>>>> 192.168.1.2:5061;rport=5061;branch=z9hG4bK12D4A5734F21B3C36B3D464960A4DE45;received=192.168.1.2
>>>>
>>>>
>>>> From: 1001 ;tag=162244127
>>>> To: ;tag=610486506
>>>> Call-ID: 0ADFB37B-86DF-983E-B4E9-EEE0D43A044D@1...
>>>> CSeq: 38312 BYE
>>>> Server: YATE/2.2.0
>>>> Content-Length: 0
>>>>
>>>> ------
>>>>  YRTPWrapper::terminate() [0x6eaf10]
>>>>  status=disconnected reason=normal [0x6e6200]
>>>>  status=hangup reason=normal [0x6e6200]
>>>>  Sending code 200 0x6a3c10 to 192.168.1.2:5061
>>>> ------
>>>> SIP/2.0 200 OK
>>>> Via: SIP/2.0/UDP
>>>> 192.168.1.2:5061;rport=5061;branch=z9hG4bK12D4A5734F21B3C36B3D464960A4DE45;received=192.168.1.2
>>>>
>>>>
>>>> From: 1001 ;tag=162244127
>>>> To: ;tag=610486506
>>>> Call-ID: 0ADFB37B-86DF-983E-B4E9-EEE0D43A044D@1...
>>>> CSeq: 38312 BYE
>>>> P-RTP-Stat: PS=1116,OS=178560,PR=1116,OR=178560,PL=0
>>>> Server: YATE/2.2.0
>>>> Allow: ACK, INVITE, BYE, CANCEL, REGISTER, REFER, OPTIONS, INFO
>>>> Content-Length: 0
>>>>
>>>> ------
>>>>  ZapCircuit(1). Consumer errors: 3. Lost: 1920/178560
>>>> [0x6ace20]
>>>>  status=destroyed reason=normal [0x6e6200]
>>>>
>>>>> Hi
>>>>>
>>>>> This is an FXO card so in zapcard.conf type must be FXO not FXS.
>>>>>
>>>>> Marian
>>>>>
>>>>> Milan Rukavina wrote:
>>>>>> Hi All,
>>>>>>
>>>>>> I bought recently Sangoma USBfxo device
>>>>>> http://wiki.sangoma.com/sangoma-wanpipe-usbfxo.I succeeded to
>>>>>> install
>>>>>> drivers /zaptel and run USBfxo with Asterisk, but my target
>>>>>> platform is
>>>>>> Yate with zapcard/analog modules. The only thing I made to work for
>>>>>> now
>>>>>> is to make my SIP phone ring on incoming calls, but when I pick up a
>>>>>> call nothing happens. Also, when caller hangs up - sip still rings.
>>>>>> Caller ID is not present, but it works with Asterisk.
>>>>>>
>>>>>> Also, I'm not able to make outgoing call - it's routed well to
>>>>>> analog
>>>>>> module but it freezes in status trying.
>>>>>>
>>>>>> Is there anything particular I should look at and change in
>>>>>> configuration files:
>>>>>>
>>>>>> *zapcard.conf:*
>>>>>> [span1]
>>>>>> type=FXS
>>>>>> offset=0
>>>>>> voicechans=1
>>>>>>
>>>>>> [span2]
>>>>>> type=FXS
>>>>>> offset=1
>>>>>> voicechans=1
>>>>>>
>>>>>> *analog.conf:*
>>>>>> [house-fxs]
>>>>>> type=FXS
>>>>>> spans=span1,span2
>>>>>>
>>>>>> *regexroute.conf:*
>>>>>> ;outbound calls
>>>>>> ^9\(.*\)$=analog/house-fxs;called=
>>>>>> ;inbound calls
>>>>>> ${address}^house-fxs/\(.*\)$=;called=1001
>>>>>>
>>>>>> Thanks,
>>>>>> Milan
>>
>>
>




Yate (10250) is starting Wed Jun  2 19:10:33 2010
Loaded module WaveFile
Loaded module ExtModule
Loaded module RManager
Loaded module OpenSSL - based on OpenSSL 0.9.8h 28 May 2008
Loaded module YSOCKS
Loaded module File Transfer
Loaded module Call Generator
Loaded module PBX
Loaded module YSTUN
Loaded module SIP Channel
Loaded module CdrFile
Loaded module Call Forker
Loaded module iLBC - based on iLBC library
Loaded module ToneDetector
Loaded module Analyzer
Loaded module MUX
Loaded module ToneGen
Loaded module MsgSniffer
Loaded module DumbChannel
Loaded module RegexRoute
Loaded module YRTP
Loaded module Conference
Loaded module MOH
Loaded module YIAX
Loaded module YJingle
Loaded module CdrBuild
Loaded module Radius client
Loaded module Accounts from file
Loaded module Analog Channel
Loaded module Queues Notify
Loaded module Zaptel
Loaded module SIP Features
Loaded module Late Router
Loaded module PBX for database
Loaded module DbWave
Loaded module CallCounters
Loaded module Call Parking
Loaded module Queues
Loaded module Signalling Channel
Loaded module Heartbeat
Loaded module Register for database
Loaded module MGCP-CA
Loaded module Cisco SM
Loaded module MRCP
Loaded module MGCP-GW
Loaded module Registration from file
Loaded module Clustering
Loaded module Analog Detector
Loaded module Jingle Features
Initializing plugins
Initializing module Analog Detector
Initializing module Clustering
Initializing module Cisco SM
Initializing module MGCP Call Agent
Initializing module DbWave
Initializing module Zaptel
Initializing module MUX
Initializing module CdrFile
Initializing module YSOCKS
Initializing module OpenSSL
Initializing module WaveFile
Initializing module ExtModule
Initializing module RManager
Initializing module File Transfer
Initializing module Call Generator
Initializing module PBX
Initializing module YSTUN
Initializing module SIP Channel
Initializing module Call Forker
Initializing module ToneDetector
Initializing module Analyzer
Initializing module ToneGen
Initializing module MsgSniffer
Initializing module DumbChannel
DumbChannel initialized
Initializing module RegexRoute
Initializing module YRTP
Initializing module Conference
Initializing module MOH
Initializing module YIAX
Initializing module YJingle
Initializing module CdrBuild
Initializing module Radius client
Initializing module Accounts from file
Initializing module Analog Channel
 ZapCircuit driver=zaptel type=FXO channel=1 cic=1 dtmfdetectúlse echotaps=0 echotrain@0 buflen%5 readonlyúlse idlevalue%5 priority=normal [0x7fcd6c001450]
 ZapSpan('') driver=zaptel section=span1 type=FXO channels=1 circuits=1 [0x7fcd6c001320]
 ZapCircuit driver=zaptel type=FXO channel=2 cic=2 dtmfdetectúlse echotaps=0 echotrain@0 buflen%5 readonlyúlse idlevalue%5 priority=normal [0x7fcd6c001db0]
 ZapSpan('') driver=zaptel section=span2 type=FXO channels=2 circuits=2 [0x7fcd6c001ab0]
 ZapCircuit(1). IOCTL(SetToneDetect) failed on channel 1 (param=0). 38: Function not implemented [0x6ac150]
 ZapCircuit(2). IOCTL(SetToneDetect) failed on channel 2 (param=0). 38: Function not implemented [0x6ac150]
Initializing module Queues Notify
Initializing module SIP Features
Initializing module Late Router
Initializing module PBX for database
Initializing module Call Parking
Initializing module Queues for database
Initializing module Signalling Channel
Initializing module Register for database
Initializing module MrcpSpeech
Initializing module MGCP Gateway
 Could not set remote endpoint for 'PUT_NAME_HERE'
Initializing module Register for file
Initializing module Jingle Features
Initialization complete
Sniffed 'engine.start' time75498633.672991
  thread=(nil) '(null)'
  data=(nil)
  retval='(null)'
Returned false 'engine.start' delay=0.000820
  thread=(nil) '(null)'
  data=(nil)
  retval='(null)'
Yate engine is initialized and starting up on linux
Sniffed 'user.auth' time75498645.979756
  thread=0x6c7570 'YSIP Register'
  data=(nil)
  retval='(null)'
  param['protocol'] = 'sip'
  param['method'] = 'REGISTER'
  param['uri'] = 'sip:asterisk'
  param['ip_host'] = '192.168.1.101'
  param['ip_port'] = '5060'
  param['address'] = '192.168.1.101:5060'
  param['newcall'] = 'false'
Returned false 'user.auth' delay=0.000333
  thread=0x6c7570 'YSIP Register'
  data=(nil)
  retval='(null)'
  param['protocol'] = 'sip'
  param['method'] = 'REGISTER'
  param['uri'] = 'sip:asterisk'
  param['ip_host'] = '192.168.1.101'
  param['ip_port'] = '5060'
  param['address'] = '192.168.1.101:5060'
  param['newcall'] = 'false'
Sniffed 'user.auth' time75498647.020049
  thread=0x6c9cd0 'YSIP Register'
  data=(nil)
  retval='(null)'
  param['protocol'] = 'sip'
  param['username'] = '1002'
  param['realm'] = 'asterisk'
  param['nonce'] = 'e94fc3321541741c7cd9135c2eb7975a.1275498645'
  param['response'] = '91e932ee938486a1e2540b7ea19f875a'
  param['method'] = 'REGISTER'
  param['uri'] = 'sip:asterisk'
  param['ip_host'] = '192.168.1.101'
  param['ip_port'] = '5060'
  param['address'] = '192.168.1.101:5060'
  param['newcall'] = 'false'
Returned true 'user.auth' delay=0.000207
  thread=0x6c9cd0 'YSIP Register'
  data=(nil)
  retval='1002'
  param['protocol'] = 'sip'
  param['username'] = '1002'
  param['realm'] = 'asterisk'
  param['nonce'] = 'e94fc3321541741c7cd9135c2eb7975a.1275498645'
  param['response'] = '91e932ee938486a1e2540b7ea19f875a'
  param['method'] = 'REGISTER'
  param['uri'] = 'sip:asterisk'
  param['ip_host'] = '192.168.1.101'
  param['ip_port'] = '5060'
  param['address'] = '192.168.1.101:5060'
  param['newcall'] = 'false'
Sniffed 'user.register' time75498647.020009
  thread=0x6c9cd0 'YSIP Register'
  data=(nil)
  retval='(null)'
  param['sip_uri'] = 'sip:asterisk'
  param['sip_callid'] = '138C17CC496E4D0A99FCC120B600AB430xc0a80165'
  param['username'] = '1002'
  param['realm'] = 'asterisk'
  param['newcall'] = 'false'
  param['number'] = '1002'
  param['driver'] = 'sip'
  param['data'] = 'sip/sip:1002@1...'
  param['ip_host'] = '192.168.1.101'
  param['ip_port'] = '5060'
  param['expires'] = '600'
  param['sip_to'] = 'sip:1002@1...'
  param['device'] = 'SJphone/1.65.377a (SJ Labs)'
Returned true 'user.register' delay=0.000669
  thread=0x6c9cd0 'YSIP Register'
  data=(nil)
  retval='(null)'
  param['sip_uri'] = 'sip:asterisk'
  param['sip_callid'] = '138C17CC496E4D0A99FCC120B600AB430xc0a80165'
  param['username'] = '1002'
  param['realm'] = 'asterisk'
  param['newcall'] = 'false'
  param['number'] = '1002'
  param['driver'] = 'sip'
  param['data'] = 'sip/sip:1002@1...'
  param['ip_host'] = '192.168.1.101'
  param['ip_port'] = '5060'
  param['expires'] = '600'
  param['sip_to'] = 'sip:1002@1...'
  param['device'] = 'SJphone/1.65.377a (SJ Labs)'
Sniffed 'user.auth' time75498668.987777
  thread=0x691a70 'YSIP EndPoint'
  data=(nil)
  retval='(null)'
  param['protocol'] = 'sip'
  param['method'] = 'INVITE'
  param['uri'] = 'sip:9063456568@asterisk'
  param['ip_host'] = '192.168.1.101'
  param['ip_port'] = '5060'
  param['address'] = '192.168.1.101:5060'
  param['newcall'] = 'true'
  param['caller'] = '1002'
  param['called'] = '9063456568'
Returned false 'user.auth' delay=0.000208
  thread=0x691a70 'YSIP EndPoint'
  data=(nil)
  retval='(null)'
  param['protocol'] = 'sip'
  param['method'] = 'INVITE'
  param['uri'] = 'sip:9063456568@asterisk'
  param['ip_host'] = '192.168.1.101'
  param['ip_port'] = '5060'
  param['address'] = '192.168.1.101:5060'
  param['newcall'] = 'true'
  param['caller'] = '1002'
  param['called'] = '9063456568'
Sniffed 'call.preroute' time75498668.987697
  thread=0x6d9e90 'Call Router'
  data=(nil)
  retval='(null)'
  param['id'] = 'sip/1'
  param['module'] = 'sip'
  param['status'] = 'incoming'
  param['address'] = '192.168.1.101:5060'
  param['billid'] = '1275498633-1'
  param['answered'] = 'false'
  param['callid'] = 'sip/AD3AD8167CDA4D7DA5DFD72B8434E1E30xc0a80165/59c0407bd/'
  param['caller'] = '1002'
  param['called'] = '9063456568'
  param['callername'] = 'Milan Rukavina'
  param['antiloop'] = '19'
  param['ip_host'] = '192.168.1.101'
  param['ip_port'] = '5060'
  param['sip_uri'] = 'sip:9063456568@asterisk'
  param['sip_from'] = 'sip:1002@asterisk'
  param['sip_to'] = ''
  param['sip_callid'] = 'AD3AD8167CDA4D7DA5DFD72B8434E1E30xc0a80165'
  param['device'] = 'SJphone/1.65.377a (SJ Labs)'
  param['sip_contact'] = ''
  param['sip_user-agent'] = 'SJphone/1.65.377a (SJ Labs)'
  param['sip_content-type'] = 'application/sdp'
  param['sip_supported'] = 'replaces,norefersub,timer'
  param['rtp_addr'] = '192.168.1.101'
  param['media'] = 'yes'
  param['formats'] = 'ilbc30,ilbc20,alaw,mulaw'
  param['transport'] = 'RTP/AVP'
  param['rtp_mapping'] = 'ilbc30—'
  param['rtp_rfc2833'] = '101'
  param['rtp_port'] = '49152'
  param['sdp_setup'] = 'active'
  param['sdp_sendrecv'] = ''
  param['rtp_forward'] = 'possible'
Returned false 'call.preroute' delay=0.001296
  thread=0x6d9e90 'Call Router'
  data=(nil)
  retval='(null)'
  param['id'] = 'sip/1'
  param['module'] = 'sip'
  param['status'] = 'incoming'
  param['address'] = '192.168.1.101:5060'
  param['billid'] = '1275498633-1'
  param['answered'] = 'false'
  param['callid'] = 'sip/AD3AD8167CDA4D7DA5DFD72B8434E1E30xc0a80165/59c0407bd/'
  param['caller'] = '1002'
  param['called'] = '9063456568'
  param['callername'] = 'Milan Rukavina'
  param['antiloop'] = '19'
  param['ip_host'] = '192.168.1.101'
  param['ip_port'] = '5060'
  param['sip_uri'] = 'sip:9063456568@asterisk'
  param['sip_from'] = 'sip:1002@asterisk'
  param['sip_to'] = ''
  param['sip_callid'] = 'AD3AD8167CDA4D7DA5DFD72B8434E1E30xc0a80165'
  param['device'] = 'SJphone/1.65.377a (SJ Labs)'
  param['sip_contact'] = ''
  param['sip_user-agent'] = 'SJphone/1.65.377a (SJ Labs)'
  param['sip_content-type'] = 'application/sdp'
  param['sip_supported'] = 'replaces,norefersub,timer'
  param['rtp_addr'] = '192.168.1.101'
  param['media'] = 'yes'
  param['formats'] = 'ilbc30,ilbc20,alaw,mulaw'
  param['transport'] = 'RTP/AVP'
  param['rtp_mapping'] = 'ilbc30—'
  param['rtp_rfc2833'] = '101'
  param['rtp_port'] = '49152'
  param['sdp_setup'] = 'active'
  param['sdp_sendrecv'] = ''
  param['rtp_forward'] = 'possible'
Sniffed 'call.route' time75498668.987697
  thread=0x6d9e90 'Call Router'
  data=(nil)
  retval='(null)'
  param['id'] = 'sip/1'
  param['module'] = 'sip'
  param['status'] = 'incoming'
  param['address'] = '192.168.1.101:5060'
  param['billid'] = '1275498633-1'
  param['answered'] = 'false'
  param['callid'] = 'sip/AD3AD8167CDA4D7DA5DFD72B8434E1E30xc0a80165/59c0407bd/'
  param['caller'] = '1002'
  param['called'] = '9063456568'
  param['callername'] = 'Milan Rukavina'
  param['antiloop'] = '19'
  param['ip_host'] = '192.168.1.101'
  param['ip_port'] = '5060'
  param['sip_uri'] = 'sip:9063456568@asterisk'
  param['sip_from'] = 'sip:1002@asterisk'
  param['sip_to'] = ''
  param['sip_callid'] = 'AD3AD8167CDA4D7DA5DFD72B8434E1E30xc0a80165'
  param['device'] = 'SJphone/1.65.377a (SJ Labs)'
  param['sip_contact'] = ''
  param['sip_user-agent'] = 'SJphone/1.65.377a (SJ Labs)'
  param['sip_content-type'] = 'application/sdp'
  param['sip_supported'] = 'replaces,norefersub,timer'
  param['rtp_addr'] = '192.168.1.101'
  param['media'] = 'yes'
  param['formats'] = 'ilbc30,ilbc20,alaw,mulaw'
  param['transport'] = 'RTP/AVP'
  param['rtp_mapping'] = 'ilbc30—'
  param['rtp_rfc2833'] = '101'
  param['rtp_port'] = '49152'
  param['sdp_setup'] = 'active'
  param['sdp_sendrecv'] = ''
  param['rtp_forward'] = 'possible'
Returned true 'call.route' delay=0.002643
  thread=0x6d9e90 'Call Router'
  data=(nil)
  retval='analog/house/1'
  param['id'] = 'sip/1'
  param['module'] = 'sip'
  param['status'] = 'incoming'
  param['address'] = '192.168.1.101:5060'
  param['billid'] = '1275498633-1'
  param['answered'] = 'false'
  param['callid'] = 'sip/AD3AD8167CDA4D7DA5DFD72B8434E1E30xc0a80165/59c0407bd/'
  param['caller'] = '1002'
  param['called'] = '063456568'
  param['callername'] = 'Milan Rukavina'
  param['antiloop'] = '19'
  param['ip_host'] = '192.168.1.101'
  param['ip_port'] = '5060'
  param['sip_uri'] = 'sip:9063456568@asterisk'
  param['sip_from'] = 'sip:1002@asterisk'
  param['sip_to'] = ''
  param['sip_callid'] = 'AD3AD8167CDA4D7DA5DFD72B8434E1E30xc0a80165'
  param['device'] = 'SJphone/1.65.377a (SJ Labs)'
  param['sip_contact'] = ''
  param['sip_user-agent'] = 'SJphone/1.65.377a (SJ Labs)'
  param['sip_content-type'] = 'application/sdp'
  param['sip_supported'] = 'replaces,norefersub,timer'
  param['rtp_addr'] = '192.168.1.101'
  param['media'] = 'yes'
  param['formats'] = 'ilbc30,ilbc20,alaw,mulaw'
  param['transport'] = 'RTP/AVP'
  param['rtp_mapping'] = 'ilbc30—'
  param['rtp_rfc2833'] = '101'
  param['rtp_port'] = '49152'
  param['sdp_setup'] = 'active'
  param['sdp_sendrecv'] = ''
  param['rtp_forward'] = 'possible'
Sniffed 'call.execute' time75498668.987697
  thread=0x6d9e90 'Call Router'
  data=0x6d1820
  retval='(null)'
  param['id'] = 'sip/1'
  param['module'] = 'sip'
  param['status'] = 'incoming'
  param['address'] = '192.168.1.101:5060'
  param['billid'] = '1275498633-1'
  param['answered'] = 'false'
  param['callid'] = 'sip/AD3AD8167CDA4D7DA5DFD72B8434E1E30xc0a80165/59c0407bd/'
  param['caller'] = '1002'
  param['called'] = '063456568'
  param['callername'] = 'Milan Rukavina'
  param['antiloop'] = '19'
  param['ip_host'] = '192.168.1.101'
  param['ip_port'] = '5060'
  param['sip_uri'] = 'sip:9063456568@asterisk'
  param['sip_from'] = 'sip:1002@asterisk'
  param['sip_to'] = ''
  param['sip_callid'] = 'AD3AD8167CDA4D7DA5DFD72B8434E1E30xc0a80165'
  param['device'] = 'SJphone/1.65.377a (SJ Labs)'
  param['sip_contact'] = ''
  param['sip_user-agent'] = 'SJphone/1.65.377a (SJ Labs)'
  param['sip_content-type'] = 'application/sdp'
  param['sip_supported'] = 'replaces,norefersub,timer'
  param['rtp_addr'] = '192.168.1.101'
  param['media'] = 'yes'
  param['formats'] = 'ilbc30,ilbc20,alaw,mulaw'
  param['transport'] = 'RTP/AVP'
  param['rtp_mapping'] = 'ilbc30—'
  param['rtp_rfc2833'] = '101'
  param['rtp_port'] = '49152'
  param['sdp_setup'] = 'active'
  param['sdp_sendrecv'] = ''
  param['rtp_forward'] = 'possible'
  param['callto'] = 'analog/house/1'
Sniffed 'chan.startup' time75498668.988286
  thread=0x7fcd6c00aba0 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['id'] = 'sip/1'
  param['module'] = 'sip'
  param['status'] = 'incoming'
  param['address'] = '192.168.1.101:5060'
  param['billid'] = '1275498633-1'
  param['answered'] = 'false'
  param['callid'] = 'sip/AD3AD8167CDA4D7DA5DFD72B8434E1E30xc0a80165/59c0407bd/'
  param['caller'] = '1002'
  param['called'] = '9063456568'
Returned false 'chan.startup' delay=0.006827
  thread=0x7fcd6c00aba0 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['id'] = 'sip/1'
  param['module'] = 'sip'
  param['status'] = 'incoming'
  param['address'] = '192.168.1.101:5060'
  param['billid'] = '1275498633-1'
  param['answered'] = 'false'
  param['callid'] = 'sip/AD3AD8167CDA4D7DA5DFD72B8434E1E30xc0a80165/59c0407bd/'
  param['caller'] = '1002'
  param['called'] = '9063456568'
Sniffed 'call.cdr' time75498668.994684
  thread=0x7fcd6c00aba0 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['time'] = '1275498668.988'
  param['chan'] = 'sip/1'
  param['cdrid'] = '1'
  param['runid'] = '1275498633'
  param['operation'] = 'initialize'
  param['direction'] = 'incoming'
  param['duration'] = '0.007'
  param['billtime'] = '0.000'
  param['ringtime'] = '0.007'
  param['status'] = 'incoming'
  param['external'] = '1002'
  param['cdrwrite'] = 'true'
  param['address'] = '192.168.1.101:5060'
  param['billid'] = '1275498633-1'
  param['caller'] = '1002'
  param['called'] = '063456568'
Returned false 'call.cdr' delay=0.000758
  thread=0x7fcd6c00aba0 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['time'] = '1275498668.988'
  param['chan'] = 'sip/1'
  param['cdrid'] = '1'
  param['runid'] = '1275498633'
  param['operation'] = 'initialize'
  param['direction'] = 'incoming'
  param['duration'] = '0.007'
  param['billtime'] = '0.000'
  param['ringtime'] = '0.007'
  param['status'] = 'incoming'
  param['external'] = '1002'
  param['cdrwrite'] = 'true'
  param['address'] = '192.168.1.101:5060'
  param['billid'] = '1275498633-1'
  param['caller'] = '1002'
  param['called'] = '063456568'
Sniffed 'call.cdr' time75498668.995046
  thread=0x7fcd6c00aba0 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['time'] = '1275498668.988'
  param['chan'] = 'sip/1'
  param['cdrid'] = '1'
  param['runid'] = '1275498633'
  param['operation'] = 'update'
  param['direction'] = 'incoming'
  param['duration'] = '0.007'
  param['billtime'] = '0.000'
  param['ringtime'] = '0.007'
  param['status'] = 'incoming'
  param['external'] = '1002'
  param['cdrwrite'] = 'true'
  param['address'] = '192.168.1.101:5060'
  param['billid'] = '1275498633-1'
  param['caller'] = '1002'
  param['called'] = '063456568'
Returned false 'call.cdr' delay=0.000684
  thread=0x7fcd6c00aba0 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['time'] = '1275498668.988'
  param['chan'] = 'sip/1'
  param['cdrid'] = '1'
  param['runid'] = '1275498633'
  param['operation'] = 'update'
  param['direction'] = 'incoming'
  param['duration'] = '0.007'
  param['billtime'] = '0.000'
  param['ringtime'] = '0.007'
  param['status'] = 'incoming'
  param['external'] = '1002'
  param['cdrwrite'] = 'true'
  param['address'] = '192.168.1.101:5060'
  param['billid'] = '1275498633-1'
  param['caller'] = '1002'
  param['called'] = '063456568'
Returned true 'call.execute' delay=0.008550
  thread=0x6d9e90 'Call Router'
  data=0x6d1820
  retval='(null)'
  param['id'] = 'sip/1'
  param['module'] = 'sip'
  param['status'] = 'incoming'
  param['address'] = '192.168.1.101:5060'
  param['billid'] = '1275498633-1'
  param['answered'] = 'false'
  param['callid'] = 'sip/AD3AD8167CDA4D7DA5DFD72B8434E1E30xc0a80165/59c0407bd/'
  param['caller'] = '1002'
  param['called'] = '063456568'
  param['callername'] = 'Milan Rukavina'
  param['antiloop'] = '19'
  param['ip_host'] = '192.168.1.101'
  param['ip_port'] = '5060'
  param['sip_uri'] = 'sip:9063456568@asterisk'
  param['sip_from'] = 'sip:1002@asterisk'
  param['sip_to'] = ''
  param['sip_callid'] = 'AD3AD8167CDA4D7DA5DFD72B8434E1E30xc0a80165'
  param['device'] = 'SJphone/1.65.377a (SJ Labs)'
  param['sip_contact'] = ''
  param['sip_user-agent'] = 'SJphone/1.65.377a (SJ Labs)'
  param['sip_content-type'] = 'application/sdp'
  param['sip_supported'] = 'replaces,norefersub,timer'
  param['rtp_addr'] = '192.168.1.101'
  param['media'] = 'yes'
  param['formats'] = 'ilbc30,ilbc20,alaw,mulaw'
  param['transport'] = 'RTP/AVP'
  param['rtp_mapping'] = 'ilbc30—'
  param['rtp_rfc2833'] = '101'
  param['rtp_port'] = '49152'
  param['sdp_setup'] = 'active'
  param['sdp_sendrecv'] = ''
  param['rtp_forward'] = 'possible'
  param['callto'] = 'analog/house/1'
  param['peerid'] = 'analog/1'
  param['targetid'] = 'analog/1'
Sniffed 'chan.startup' time75498668.996123
  thread=0x7fcd6c00aba0 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['id'] = 'analog/1'
  param['module'] = 'analog'
  param['status'] = 'outgoing'
  param['address'] = 'house/1'
  param['answered'] = 'false'
  param['direction'] = 'outgoing'
  param['caller'] = '1002'
  param['callername'] = 'Milan Rukavina'
  param['called'] = '063456568'
  param['billid'] = '1275498633-1'
Returned false 'chan.startup' delay=0.005022
  thread=0x7fcd6c00aba0 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['id'] = 'analog/1'
  param['module'] = 'analog'
  param['status'] = 'outgoing'
  param['address'] = 'house/1'
  param['answered'] = 'false'
  param['direction'] = 'outgoing'
  param['caller'] = '1002'
  param['callername'] = 'Milan Rukavina'
  param['called'] = '063456568'
  param['billid'] = '1275498633-1'
Sniffed 'call.cdr' time75498669.001050
  thread=0x7fcd6c00aba0 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['time'] = '1275498668.996'
  param['chan'] = 'analog/1'
  param['cdrid'] = '2'
  param['runid'] = '1275498633'
  param['operation'] = 'initialize'
  param['direction'] = 'outgoing'
  param['duration'] = '0.005'
  param['billtime'] = '0.000'
  param['ringtime'] = '0.005'
  param['status'] = 'outgoing'
  param['external'] = '063456568'
  param['cdrwrite'] = 'true'
  param['address'] = 'house/1'
  param['caller'] = '1002'
  param['called'] = '063456568'
  param['billid'] = '1275498633-1'
Returned false 'call.cdr' delay=0.000793
  thread=0x7fcd6c00aba0 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['time'] = '1275498668.996'
  param['chan'] = 'analog/1'
  param['cdrid'] = '2'
  param['runid'] = '1275498633'
  param['operation'] = 'initialize'
  param['direction'] = 'outgoing'
  param['duration'] = '0.005'
  param['billtime'] = '0.000'
  param['ringtime'] = '0.005'
  param['status'] = 'outgoing'
  param['external'] = '063456568'
  param['cdrwrite'] = 'true'
  param['address'] = 'house/1'
  param['caller'] = '1002'
  param['called'] = '063456568'
  param['billid'] = '1275498633-1'
Sniffed 'call.answered' time75498670.998720
  thread=0x7fcd6c00aba0 'Engine Worker'
  data=0x6da400
  retval='(null)'
  param['id'] = 'analog/1'
  param['module'] = 'analog'
  param['status'] = 'answered'
  param['address'] = 'house/1'
  param['targetid'] = 'sip/1'
  param['billid'] = '1275498633-1'
  param['peerid'] = 'sip/1'
  param['lastpeerid'] = 'sip/1'
  param['answered'] = 'true'
Sniffed 'chan.rtp' time75498671.004121
  thread=0x7fcd6c00aba0 'Engine Worker'
  data=0x6d1820
  retval='(null)'
  param['id'] = 'sip/1'
  param['module'] = 'sip'
  param['callid'] = 'sip/AD3AD8167CDA4D7DA5DFD72B8434E1E30xc0a80165/59c0407bd/'
  param['call_direction'] = 'incoming'
  param['call_address'] = '192.168.1.101:5060'
  param['call_status'] = 'accepted'
  param['call_billid'] = '1275498633-1'
  param['media'] = 'audio'
  param['transport'] = 'RTP/AVP'
  param['direction'] = 'bidir'
  param['format'] = 'ilbc30'
  param['remoteip'] = '192.168.1.101'
  param['sdp_setup'] = 'active'
  param['sdp_sendrecv'] = ''
Returned true 'chan.rtp' delay=0.000454
  thread=0x7fcd6c00aba0 'Engine Worker'
  data=0x6d1820
  retval='(null)'
  param['id'] = 'sip/1'
  param['module'] = 'sip'
  param['callid'] = 'sip/AD3AD8167CDA4D7DA5DFD72B8434E1E30xc0a80165/59c0407bd/'
  param['call_direction'] = 'incoming'
  param['call_address'] = '192.168.1.101:5060'
  param['call_status'] = 'accepted'
  param['call_billid'] = '1275498633-1'
  param['media'] = 'audio'
  param['transport'] = 'RTP/AVP'
  param['direction'] = 'bidir'
  param['format'] = 'ilbc30'
  param['remoteip'] = '192.168.1.101'
  param['sdp_setup'] = 'active'
  param['sdp_sendrecv'] = ''
  param['localip'] = '192.168.1.2'
  param['localport'] = '20452'
  param['rtpid'] = 'yrtp/987987334'
Returned true 'call.answered' delay=0.006439
  thread=0x7fcd6c00aba0 'Engine Worker'
  data=0x6da400
  retval='(null)'
  param['id'] = 'analog/1'
  param['module'] = 'analog'
  param['status'] = 'answered'
  param['address'] = 'house/1'
  param['targetid'] = 'sip/1'
  param['billid'] = '1275498633-1'
  param['peerid'] = 'sip/1'
  param['lastpeerid'] = 'sip/1'
  param['answered'] = 'true'
Sniffed 'call.cdr' time75498671.003937
  thread=0x7fcd6c00aba0 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['time'] = '1275498668.996'
  param['chan'] = 'analog/1'
  param['cdrid'] = '2'
  param['runid'] = '1275498633'
  param['operation'] = 'update'
  param['direction'] = 'outgoing'
  param['duration'] = '2.008'
  param['billtime'] = '0.005'
  param['ringtime'] = '2.003'
  param['status'] = 'answered'
  param['external'] = '063456568'
  param['cdrwrite'] = 'true'
  param['address'] = 'house/1'
  param['caller'] = '1002'
  param['called'] = '063456568'
  param['billid'] = '1275498633-1'
Returned false 'call.cdr' delay=0.002272
  thread=0x7fcd6c00aba0 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['time'] = '1275498668.996'
  param['chan'] = 'analog/1'
  param['cdrid'] = '2'
  param['runid'] = '1275498633'
  param['operation'] = 'update'
  param['direction'] = 'outgoing'
  param['duration'] = '2.008'
  param['billtime'] = '0.005'
  param['ringtime'] = '2.003'
  param['status'] = 'answered'
  param['external'] = '063456568'
  param['cdrwrite'] = 'true'
  param['address'] = 'house/1'
  param['caller'] = '1002'
  param['called'] = '063456568'
  param['billid'] = '1275498633-1'
Sniffed 'call.cdr' time75498671.003968
  thread=0x7fcd6c00aba0 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['time'] = '1275498668.988'
  param['chan'] = 'sip/1'
  param['cdrid'] = '1'
  param['runid'] = '1275498633'
  param['operation'] = 'update'
  param['direction'] = 'incoming'
  param['duration'] = '2.016'
  param['billtime'] = '0.005'
  param['ringtime'] = '2.011'
  param['status'] = 'incoming'
  param['external'] = '1002'
  param['cdrwrite'] = 'true'
  param['address'] = '192.168.1.101:5060'
  param['billid'] = '1275498633-1'
  param['caller'] = '1002'
  param['called'] = '063456568'
Returned false 'call.cdr' delay=0.002531
  thread=0x7fcd6c00aba0 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['time'] = '1275498668.988'
  param['chan'] = 'sip/1'
  param['cdrid'] = '1'
  param['runid'] = '1275498633'
  param['operation'] = 'update'
  param['direction'] = 'incoming'
  param['duration'] = '2.016'
  param['billtime'] = '0.005'
  param['ringtime'] = '2.011'
  param['status'] = 'incoming'
  param['external'] = '1002'
  param['cdrwrite'] = 'true'
  param['address'] = '192.168.1.101:5060'
  param['billid'] = '1275498633-1'
  param['caller'] = '1002'
  param['called'] = '063456568'
Sniffed 'call.update' time75498671.007066
  thread=0x7fcd6c00aba0 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['id'] = 'sip/1'
  param['module'] = 'sip'
  param['status'] = 'answered'
  param['address'] = '192.168.1.101:5060'
  param['targetid'] = 'analog/1'
  param['billid'] = '1275498633-1'
  param['peerid'] = 'analog/1'
  param['lastpeerid'] = 'analog/1'
  param['answered'] = 'true'
  param['callid'] = 'sip/AD3AD8167CDA4D7DA5DFD72B8434E1E30xc0a80165/59c0407bd/12548159'
  param['operation'] = 'cdrbuild'
Returned false 'call.update' delay=0.005130
  thread=0x7fcd6c00aba0 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['id'] = 'sip/1'
  param['module'] = 'sip'
  param['status'] = 'answered'
  param['address'] = '192.168.1.101:5060'
  param['targetid'] = 'analog/1'
  param['billid'] = '1275498633-1'
  param['peerid'] = 'analog/1'
  param['lastpeerid'] = 'analog/1'
  param['answered'] = 'true'
  param['callid'] = 'sip/AD3AD8167CDA4D7DA5DFD72B8434E1E30xc0a80165/59c0407bd/12548159'
  param['operation'] = 'cdrbuild'
Sniffed 'call.cdr' time75498671.012112
  thread=0x7fcd6c00aba0 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['time'] = '1275498668.988'
  param['chan'] = 'sip/1'
  param['cdrid'] = '1'
  param['runid'] = '1275498633'
  param['operation'] = 'update'
  param['direction'] = 'incoming'
  param['duration'] = '2.024'
  param['billtime'] = '0.013'
  param['ringtime'] = '2.011'
  param['status'] = 'answered'
  param['external'] = '1002'
  param['cdrwrite'] = 'true'
  param['address'] = '192.168.1.101:5060'
  param['billid'] = '1275498633-1'
  param['caller'] = '1002'
  param['called'] = '063456568'
Returned false 'call.cdr' delay=0.000330
  thread=0x7fcd6c00aba0 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['time'] = '1275498668.988'
  param['chan'] = 'sip/1'
  param['cdrid'] = '1'
  param['runid'] = '1275498633'
  param['operation'] = 'update'
  param['direction'] = 'incoming'
  param['duration'] = '2.024'
  param['billtime'] = '0.013'
  param['ringtime'] = '2.011'
  param['status'] = 'answered'
  param['external'] = '1002'
  param['cdrwrite'] = 'true'
  param['address'] = '192.168.1.101:5060'
  param['billid'] = '1275498633-1'
  param['caller'] = '1002'
  param['called'] = '063456568'
Sniffed 'chan.rtp' time75498671.035097
  thread=0x691a70 'YSIP EndPoint'
  data=0x6d1820
  retval='(null)'
  param['id'] = 'sip/1'
  param['module'] = 'sip'
  param['callid'] = 'sip/AD3AD8167CDA4D7DA5DFD72B8434E1E30xc0a80165/59c0407bd/12548159'
  param['call_direction'] = 'incoming'
  param['call_address'] = '192.168.1.101:5060'
  param['call_status'] = 'answered'
  param['call_billid'] = '1275498633-1'
  param['rtpid'] = 'yrtp/987987334'
  param['media'] = 'audio'
  param['transport'] = 'RTP/AVP'
  param['direction'] = 'bidir'
  param['format'] = 'ilbc30'
  param['localip'] = '192.168.1.2'
  param['remoteip'] = '192.168.1.101'
  param['remoteport'] = '49152'
  param['payload'] = '97'
  param['evpayload'] = '101'
  param['sdp_setup'] = 'active'
  param['sdp_sendrecv'] = ''
Returned true 'chan.rtp' delay=0.025839
  thread=0x691a70 'YSIP EndPoint'
  data=0x6d1820
  retval='(null)'
  param['id'] = 'sip/1'
  param['module'] = 'sip'
  param['callid'] = 'sip/AD3AD8167CDA4D7DA5DFD72B8434E1E30xc0a80165/59c0407bd/12548159'
  param['call_direction'] = 'incoming'
  param['call_address'] = '192.168.1.101:5060'
  param['call_status'] = 'answered'
  param['call_billid'] = '1275498633-1'
  param['rtpid'] = 'yrtp/987987334'
  param['media'] = 'audio'
  param['transport'] = 'RTP/AVP'
  param['direction'] = 'bidir'
  param['format'] = 'ilbc30'
  param['localip'] = '192.168.1.2'
  param['remoteip'] = '192.168.1.101'
  param['remoteport'] = '49152'
  param['payload'] = '97'
  param['evpayload'] = '101'
  param['sdp_setup'] = 'active'
  param['sdp_sendrecv'] = ''
  param['localport'] = '20452'
 ZapCircuit(1). Buffer overrun old—5 channel=1 (11: Resource temporarily unavailable) [0x7fcd6c001450]
 ZapCircuit(1). Buffer overrun old”5 channel=1 (11: Resource temporarily unavailable) [0x7fcd6c001450]
 ZapCircuit(1). Buffer overrun old„0 channel=1 (11: Resource temporarily unavailable) [0x7fcd6c001450]
 ZapCircuit(1). Buffer overrun old‘5 channel=1 (11: Resource temporarily unavailable) [0x7fcd6c001450]
Sniffed 'module.update' time75498674.005282
  thread=0x7fcd6c00aba0 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['module'] = 'sip'
  param['routed'] = '1'
  param['routing'] = '0'
  param['total'] = '1'
  param['chans'] = '1'
Returned false 'module.update' delay=0.000253
  thread=0x7fcd6c00aba0 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['module'] = 'sip'
  param['routed'] = '1'
  param['routing'] = '0'
  param['total'] = '1'
  param['chans'] = '1'
Sniffed 'module.update' time75498674.005350
  thread=0x7fcd6c00aba0 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['module'] = 'analog'
  param['routed'] = '0'
  param['routing'] = '0'
  param['total'] = '1'
  param['chans'] = '1'
Returned false 'module.update' delay=0.000269
  thread=0x7fcd6c00aba0 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['module'] = 'analog'
  param['routed'] = '0'
  param['routing'] = '0'
  param['total'] = '1'
  param['chans'] = '1'
 ZapCircuit(1). Buffer overrun old‘5 channel=1 (11: Resource temporarily unavailable) [0x7fcd6c001450]
 ZapCircuit(1). Buffer overrun old0 channel=1 (11: Resource temporarily unavailable) [0x7fcd6c001450]
 ZapCircuit(1). Buffer overrun old…5 channel=1 (11: Resource temporarily unavailable) [0x7fcd6c001450]
 ZapCircuit(1). Buffer overrun oldˆ5 channel=1 (11: Resource temporarily unavailable) [0x7fcd6c001450]
 ZapCircuit(1). Buffer overrun old‚5 channel=1 (11: Resource temporarily unavailable) [0x7fcd6c001450]
 ZapCircuit(1). Buffer overrun old0 channel=1 (11: Resource temporarily unavailable) [0x7fcd6c001450]
 ZapCircuit(1). Buffer overrun old‘5 channel=1 (11: Resource temporarily unavailable) [0x7fcd6c001450]
 ZapCircuit(1). Buffer overrun old‚5 channel=1 (11: Resource temporarily unavailable) [0x7fcd6c001450]
 ZapCircuit(1). Buffer overrun oldˆ5 channel=1 (11: Resource temporarily unavailable) [0x7fcd6c001450]
 ZapCircuit(1). Buffer overrun old„0 channel=1 (11: Resource temporarily unavailable) [0x7fcd6c001450]
 ZapCircuit(1). Buffer overrun old…5 channel=1 (11: Resource temporarily unavailable) [0x7fcd6c001450]
 ZapCircuit(1). Buffer overrun oldy5 channel=1 (11: Resource temporarily unavailable) [0x7fcd6c001450]
 ZapCircuit(1). Buffer overrun old‚5 channel=1 (11: Resource temporarily unavailable) [0x7fcd6c001450]
 ZapCircuit(1). Buffer overrun old„0 channel=1 (11: Resource temporarily unavailable) [0x7fcd6c001450]
 ZapCircuit(1). Buffer overrun oldˆ5 channel=1 (11: Resource temporarily unavailable) [0x7fcd6c001450]
 ZapCircuit(1). Buffer overrun old‚5 channel=1 (11: Resource temporarily unavailable) [0x7fcd6c001450]
 ZapCircuit(1). Buffer overrun old„0 channel=1 (11: Resource temporarily unavailable) [0x7fcd6c001450]
 ZapCircuit(1). Buffer overrun old…5 channel=1 (11: Resource temporarily unavailable) [0x7fcd6c001450]
 ZapCircuit(1). Buffer overrun old„0 channel=1 (11: Resource temporarily unavailable) [0x7fcd6c001450]
Sniffed 'chan.rtp' time75498695.311041
  thread=0x691a70 'YSIP EndPoint'
  data=(nil)
  retval='(null)'
  param['rtpid'] = 'yrtp/987987334'
  param['media'] = 'audio'
  param['transport'] = 'RTP/AVP'
  param['terminate'] = 'true'
  param['call_direction'] = 'incoming'
  param['call_address'] = '192.168.1.101:5060'
  param['call_status'] = 'answered'
  param['call_billid'] = '1275498633-1'
Returned true 'chan.rtp' delay=0.000191
  thread=0x691a70 'YSIP EndPoint'
  data=(nil)
  retval='(null)'
  param['rtpid'] = 'yrtp/987987334'
  param['media'] = 'audio'
  param['transport'] = 'RTP/AVP'
  param['terminate'] = 'true'
  param['call_direction'] = 'incoming'
  param['call_address'] = '192.168.1.101:5060'
  param['call_status'] = 'answered'
  param['call_billid'] = '1275498633-1'
  param['stats'] = 'PSv1,OS@400,PR€6,OR@300,PL=0'
Sniffed 'chan.hangup' time75498695.311556
  thread=0x7fcd6c00aba0 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['id'] = 'sip/1'
  param['module'] = 'sip'
  param['status'] = 'answered'
  param['address'] = '192.168.1.101:5060'
  param['targetid'] = 'analog/1'
  param['billid'] = '1275498633-1'
  param['peerid'] = 'analog/1'
  param['lastpeerid'] = 'analog/1'
  param['answered'] = 'true'
  param['callid'] = 'sip/AD3AD8167CDA4D7DA5DFD72B8434E1E30xc0a80165/59c0407bd/12548159'
  param['rtp_stats'] = 'PSv1,OS@400,PR€6,OR@300,PL=0'
Returned false 'chan.hangup' delay=0.004010
  thread=0x7fcd6c00aba0 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['id'] = 'sip/1'
  param['module'] = 'sip'
  param['status'] = 'answered'
  param['address'] = '192.168.1.101:5060'
  param['targetid'] = 'analog/1'
  param['billid'] = '1275498633-1'
  param['peerid'] = 'analog/1'
  param['lastpeerid'] = 'analog/1'
  param['answered'] = 'true'
  param['callid'] = 'sip/AD3AD8167CDA4D7DA5DFD72B8434E1E30xc0a80165/59c0407bd/12548159'
  param['rtp_stats'] = 'PSv1,OS@400,PR€6,OR@300,PL=0'
Sniffed 'chan.disconnected' time75498695.311599
  thread=0x7fcd6c00aba0 'Engine Worker'
  data=0x6da400
  retval='(null)'
  param['rtp_stats'] = 'PSv1,OS@400,PR€6,OR@300,PL=0'
  param['id'] = 'analog/1'
  param['module'] = 'analog'
  param['status'] = 'answered'
  param['address'] = 'house/1'
  param['targetid'] = 'sip/1'
  param['billid'] = '1275498633-1'
  param['lastpeerid'] = 'sip/1'
  param['answered'] = 'true'
Returned false 'chan.disconnected' delay=0.004117
  thread=0x7fcd6c00aba0 'Engine Worker'
  data=0x6da400
  retval='(null)'
  param['rtp_stats'] = 'PSv1,OS@400,PR€6,OR@300,PL=0'
  param['id'] = 'analog/1'
  param['module'] = 'analog'
  param['status'] = 'answered'
  param['address'] = 'house/1'
  param['targetid'] = 'sip/1'
  param['billid'] = '1275498633-1'
  param['lastpeerid'] = 'sip/1'
  param['answered'] = 'true'
Sniffed 'chan.hangup' time75498695.311636
  thread=0x7fcd6c00aba0 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['id'] = 'analog/1'
  param['module'] = 'analog'
  param['status'] = 'disconnected'
  param['reason'] = 'normal'
 ZapCircuit(1). Consumer errors: 23. Lost: 19800/193440 [0x7fcd6c001450]
Returned false 'chan.hangup' delay=0.004683
  thread=0x7fcd6c00aba0 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['id'] = 'analog/1'
  param['module'] = 'analog'
  param['status'] = 'disconnected'
  param['reason'] = 'normal'
Sniffed 'call.cdr' time75498695.315533
  thread=0x7fcd6c00aba0 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['time'] = '1275498668.988'
  param['chan'] = 'sip/1'
  param['cdrid'] = '1'
  param['runid'] = '1275498633'
  param['operation'] = 'finalize'
  param['direction'] = 'incoming'
  param['duration'] = '26.324'
  param['billtime'] = '24.313'
  param['ringtime'] = '2.011'
  param['status'] = 'answered'
  param['external'] = '1002'
  param['cdrwrite'] = 'true'
  param['address'] = '192.168.1.101:5060'
  param['billid'] = '1275498633-1'
  param['caller'] = '1002'
  param['called'] = '063456568'
Returned false 'call.cdr' delay=0.001174
  thread=0x7fcd6c00aba0 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['time'] = '1275498668.988'
  param['chan'] = 'sip/1'
  param['cdrid'] = '1'
  param['runid'] = '1275498633'
  param['operation'] = 'finalize'
  param['direction'] = 'incoming'
  param['duration'] = '26.324'
  param['billtime'] = '24.313'
  param['ringtime'] = '2.011'
  param['status'] = 'answered'
  param['external'] = '1002'
  param['cdrwrite'] = 'true'
  param['address'] = '192.168.1.101:5060'
  param['billid'] = '1275498633-1'
  param['caller'] = '1002'
  param['called'] = '063456568'
Sniffed 'call.cdr' time75498695.315881
  thread=0x7fcd6c00aba0 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['time'] = '1275498668.996'
  param['chan'] = 'analog/1'
  param['cdrid'] = '2'
  param['runid'] = '1275498633'
  param['operation'] = 'finalize'
  param['direction'] = 'outgoing'
  param['duration'] = '26.316'
  param['billtime'] = '24.313'
  param['ringtime'] = '2.003'
  param['status'] = 'disconnected'
  param['external'] = '063456568'
  param['cdrwrite'] = 'true'
  param['address'] = 'house/1'
  param['caller'] = '1002'
  param['called'] = '063456568'
  param['billid'] = '1275498633-1'
  param['reason'] = 'normal'
Returned false 'call.cdr' delay=0.001360
  thread=0x7fcd6c00aba0 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['time'] = '1275498668.996'
  param['chan'] = 'analog/1'
  param['cdrid'] = '2'
  param['runid'] = '1275498633'
  param['operation'] = 'finalize'
  param['direction'] = 'outgoing'
  param['duration'] = '26.316'
  param['billtime'] = '24.313'
  param['ringtime'] = '2.003'
  param['status'] = 'disconnected'
  param['external'] = '063456568'
  param['cdrwrite'] = 'true'
  param['address'] = 'house/1'
  param['caller'] = '1002'
  param['called'] = '063456568'
  param['billid'] = '1275498633-1'
  param['reason'] = 'normal'
Sniffed 'module.update' time75498701.000080
  thread=0x7fcd6c00aba0 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['module'] = 'sip'
  param['routed'] = '1'
  param['routing'] = '0'
  param['total'] = '1'
  param['chans'] = '0'
Returned false 'module.update' delay=0.000473
  thread=0x7fcd6c00aba0 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['module'] = 'sip'
  param['routed'] = '1'
  param['routing'] = '0'
  param['total'] = '1'
  param['chans'] = '0'
Sniffed 'module.update' time75498701.000188
  thread=0x7fcd6c00aba0 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['module'] = 'analog'
  param['routed'] = '0'
  param['routing'] = '0'
  param['total'] = '1'
  param['chans'] = '0'
Returned false 'module.update' delay=0.000507
  thread=0x7fcd6c00aba0 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['module'] = 'analog'
  param['routed'] = '0'
  param['routing'] = '0'
  param['total'] = '1'
  param['chans'] = '0'
Yate engine is shutting down with code 0
Sniffed 'engine.halt' time75498702.516064
  thread=(nil) '(null)'
  data=(nil)
  retval='(null)'
 Worker thread terminated [0x6ac150]
Returned false 'engine.halt' delay=0.103296
  thread=(nil) '(null)'
  data=(nil)
  retval='(null)'
Unloading module Jingle Features
Unloading module MGCP-GW
Unloading module MRCP
Unloading module Register for database
Unloading module Heartbeat
Unloading module Signalling Channel
Unloading module Queues
Unloading module Call Parking
Unloading module CallCounters
Unloading module PBX for database
Unloading module Late Router
Unloading module SIP Features
Unloading module Queues Notify
Unloaded module Radius client
Unloading module CdrBuild
Unloading module YJingle
Unloading module YIAX
Unloading module MOH
Unloading module Conference
Unloading module YRTP
Unloading module DumbChannel
Unloading module ToneGen
Unloading module Analyzer
Unloading module ToneDetector
Unloading module iLBC with 0 codecs still in use
Unloading module Call Forker
Unloading module YSTUN
Unloading module PBX
Unloading module Call Generator, clearing 0 calls
Unloading module RManager
Unloading module ExtModule
Unloading module OpenSSL
Unloading module File Transfer
Unloading module CdrFile
Unloading module MUX
Unloading module Zaptel
Unloading module MGCP-CA
Unloading module Analog Channel
Unloading module Cisco SM
Unloading module YSOCKS
Unloading module SIP Channel
Unloading module Clustering
Unloading module Analog Detector
Yate (10250) is stopping Wed Jun  2 19:11:42 2010

Yate (9381) is starting Wed Jun  2 19:05:37 2010
Loaded module WaveFile
Loaded module ExtModule
Loaded module RManager
Loaded module OpenSSL - based on OpenSSL 0.9.8h 28 May 2008
Loaded module YSOCKS
Loaded module File Transfer
Loaded module Call Generator
Loaded module PBX
Loaded module YSTUN
Loaded module SIP Channel
Loaded module CdrFile
Loaded module Call Forker
Loaded module iLBC - based on iLBC library
Loaded module ToneDetector
Loaded module Analyzer
Loaded module MUX
Loaded module ToneGen
Loaded module MsgSniffer
Loaded module DumbChannel
Loaded module RegexRoute
Loaded module YRTP
Loaded module Conference
Loaded module MOH
Loaded module YIAX
Loaded module YJingle
Loaded module CdrBuild
Loaded module Radius client
Loaded module Accounts from file
Loaded module Analog Channel
Loaded module Queues Notify
Loaded module Zaptel
Loaded module SIP Features
Loaded module Late Router
Loaded module PBX for database
Loaded module DbWave
Loaded module CallCounters
Loaded module Call Parking
Loaded module Queues
Loaded module Signalling Channel
Loaded module Heartbeat
Loaded module Register for database
Loaded module MGCP-CA
Loaded module Cisco SM
Loaded module MRCP
Loaded module MGCP-GW
Loaded module Registration from file
Loaded module Clustering
Loaded module Analog Detector
Loaded module Jingle Features
Initializing plugins
Initializing module Analog Detector
Initializing module Clustering
Initializing module Cisco SM
Initializing module MGCP Call Agent
Initializing module DbWave
Initializing module Zaptel
Initializing module MUX
Initializing module CdrFile
Initializing module YSOCKS
Initializing module OpenSSL
Initializing module WaveFile
Initializing module ExtModule
Initializing module RManager
Initializing module File Transfer
Initializing module Call Generator
Initializing module PBX
Initializing module YSTUN
Initializing module SIP Channel
Initializing module Call Forker
Initializing module ToneDetector
Initializing module Analyzer
Initializing module ToneGen
Initializing module MsgSniffer
Initializing module DumbChannel
DumbChannel initialized
Initializing module RegexRoute
Initializing module YRTP
Initializing module Conference
Initializing module MOH
Initializing module YIAX
Initializing module YJingle
Initializing module CdrBuild
Initializing module Radius client
Initializing module Accounts from file
Initializing module Analog Channel
 ZapCircuit driver=zaptel type=FXO channel=1 cic=1 dtmfdetectúlse echotaps=0 echotrain@0 buflen%5 readonlyúlse idlevalue%5 priority=normal [0x6ad3e0]
 ZapSpan('') driver=zaptel section=span1 type=FXO channels=1 circuits=1 [0x6ac780]
 ZapCircuit driver=zaptel type=FXO channel=2 cic=2 dtmfdetectúlse echotaps=0 echotrain@0 buflen%5 readonlyúlse idlevalue%5 priority=normal [0x6ad930]
 ZapSpan('') driver=zaptel section=span2 type=FXO channels=2 circuits=2 [0x6ad7d0]
 ZapCircuit(1). IOCTL(SetToneDetect) failed on channel 1 (param=0). 38: Function not implemented [0x6ac210]
 ZapCircuit(2). IOCTL(SetToneDetect) failed on channel 2 (param=0). 38: Function not implemented [0x6ac210]
Initializing module Queues Notify
Initializing module SIP Features
Initializing module Late Router
Initializing module PBX for database
Initializing module Call Parking
Initializing module Queues for database
Initializing module Signalling Channel
Initializing module Register for database
Initializing module MrcpSpeech
Initializing module MGCP Gateway
 Could not set remote endpoint for 'PUT_NAME_HERE'
Initializing module Register for file
Initializing module Jingle Features
Initialization complete
Sniffed 'engine.start' time75498337.821718
  thread=(nil) '(null)'
  data=(nil)
  retval='(null)'
Returned false 'engine.start' delay=0.000122
  thread=(nil) '(null)'
  data=(nil)
  retval='(null)'
Yate engine is initialized and starting up on linux
Sniffed 'user.auth' time75498362.553422
  thread=0x6cfdd0 'YSIP Register'
  data=(nil)
  retval='(null)'
  param['protocol'] = 'sip'
  param['method'] = 'REGISTER'
  param['uri'] = 'sip:asterisk'
  param['ip_host'] = '192.168.1.2'
  param['ip_port'] = '5061'
  param['address'] = '192.168.1.2:5061'
  param['newcall'] = 'false'
Returned false 'user.auth' delay=0.000764
  thread=0x6cfdd0 'YSIP Register'
  data=(nil)
  retval='(null)'
  param['protocol'] = 'sip'
  param['method'] = 'REGISTER'
  param['uri'] = 'sip:asterisk'
  param['ip_host'] = '192.168.1.2'
  param['ip_port'] = '5061'
  param['address'] = '192.168.1.2:5061'
  param['newcall'] = 'false'
Sniffed 'user.auth' time75498411.040055
  thread=0x6d0bf0 'YSIP Register'
  data=(nil)
  retval='(null)'
  param['protocol'] = 'sip'
  param['method'] = 'REGISTER'
  param['uri'] = 'sip:asterisk'
  param['ip_host'] = '192.168.1.2'
  param['ip_port'] = '5061'
  param['address'] = '192.168.1.2:5061'
  param['newcall'] = 'false'
Returned false 'user.auth' delay=0.000227
  thread=0x6d0bf0 'YSIP Register'
  data=(nil)
  retval='(null)'
  param['protocol'] = 'sip'
  param['method'] = 'REGISTER'
  param['uri'] = 'sip:asterisk'
  param['ip_host'] = '192.168.1.2'
  param['ip_port'] = '5061'
  param['address'] = '192.168.1.2:5061'
  param['newcall'] = 'false'
Sniffed 'user.auth' time75498411.055705
  thread=0x6d2640 'YSIP Register'
  data=(nil)
  retval='(null)'
  param['protocol'] = 'sip'
  param['username'] = '1001'
  param['realm'] = 'asterisk'
  param['nonce'] = 'd7c3f0917bf43148d40ac21a7337ebe4.1275498411'
  param['response'] = '3d7986ebd4bbbd3a3fcac2289a902b11'
  param['method'] = 'REGISTER'
  param['uri'] = 'sip:asterisk'
  param['ip_host'] = '192.168.1.2'
  param['ip_port'] = '5061'
  param['address'] = '192.168.1.2:5061'
  param['newcall'] = 'false'
Returned true 'user.auth' delay=0.000181
  thread=0x6d2640 'YSIP Register'
  data=(nil)
  retval='1001'
  param['protocol'] = 'sip'
  param['username'] = '1001'
  param['realm'] = 'asterisk'
  param['nonce'] = 'd7c3f0917bf43148d40ac21a7337ebe4.1275498411'
  param['response'] = '3d7986ebd4bbbd3a3fcac2289a902b11'
  param['method'] = 'REGISTER'
  param['uri'] = 'sip:asterisk'
  param['ip_host'] = '192.168.1.2'
  param['ip_port'] = '5061'
  param['address'] = '192.168.1.2:5061'
  param['newcall'] = 'false'
Sniffed 'user.register' time75498411.055669
  thread=0x6d2640 'YSIP Register'
  data=(nil)
  retval='(null)'
  param['sip_uri'] = 'sip:asterisk'
  param['sip_callid'] = '4CE053932DB1016EAA2BAC41F80847BC@asterisk'
  param['username'] = '1001'
  param['realm'] = 'asterisk'
  param['newcall'] = 'false'
  param['number'] = '1001'
  param['driver'] = 'sip'
  param['data'] = 'sip/sip:1001@1...:5061'
  param['ip_host'] = '192.168.1.2'
  param['ip_port'] = '5061'
  param['expires'] = '1800'
  param['sip_to'] = 'sip:1001@1...:5061'
  param['device'] = 'X-Lite release 1105d'
Returned true 'user.register' delay=0.000776
  thread=0x6d2640 'YSIP Register'
  data=(nil)
  retval='(null)'
  param['sip_uri'] = 'sip:asterisk'
  param['sip_callid'] = '4CE053932DB1016EAA2BAC41F80847BC@asterisk'
  param['username'] = '1001'
  param['realm'] = 'asterisk'
  param['newcall'] = 'false'
  param['number'] = '1001'
  param['driver'] = 'sip'
  param['data'] = 'sip/sip:1001@1...:5061'
  param['ip_host'] = '192.168.1.2'
  param['ip_port'] = '5061'
  param['expires'] = '1800'
  param['sip_to'] = 'sip:1001@1...:5061'
  param['device'] = 'X-Lite release 1105d'
Sniffed 'user.auth' time75498417.441384
  thread=0x691a70 'YSIP EndPoint'
  data=(nil)
  retval='(null)'
  param['protocol'] = 'sip'
  param['method'] = 'INVITE'
  param['uri'] = 'sip:9063456568@asterisk'
  param['ip_host'] = '192.168.1.2'
  param['ip_port'] = '5061'
  param['address'] = '192.168.1.2:5061'
  param['newcall'] = 'true'
  param['caller'] = '1001'
  param['called'] = '9063456568'
Returned false 'user.auth' delay=0.000272
  thread=0x691a70 'YSIP EndPoint'
  data=(nil)
  retval='(null)'
  param['protocol'] = 'sip'
  param['method'] = 'INVITE'
  param['uri'] = 'sip:9063456568@asterisk'
  param['ip_host'] = '192.168.1.2'
  param['ip_port'] = '5061'
  param['address'] = '192.168.1.2:5061'
  param['newcall'] = 'true'
  param['caller'] = '1001'
  param['called'] = '9063456568'
Sniffed 'call.preroute' time75498417.441296
  thread=0x6e5010 'Call Router'
  data=(nil)
  retval='(null)'
  param['id'] = 'sip/1'
  param['module'] = 'sip'
  param['status'] = 'incoming'
  param['address'] = '192.168.1.2:5061'
  param['billid'] = '1275498337-1'
  param['answered'] = 'false'
  param['callid'] = 'sip/020CADA4-19A6-E36D-5873-EC47A1DD1BB5@1.../1722027474/'
  param['caller'] = '1001'
  param['called'] = '9063456568'
  param['callername'] = '1001 '
  param['antiloop'] = '19'
  param['ip_host'] = '192.168.1.2'
  param['ip_port'] = '5061'
  param['sip_uri'] = 'sip:9063456568@asterisk'
  param['sip_from'] = 'sip:1001@asterisk:5061'
  param['sip_to'] = ''
  param['sip_callid'] = '020CADA4-19A6-E36D-5873-EC47A1DD1BB5@1...'
  param['device'] = 'X-Lite release 1105d'
  param['sip_contact'] = ''
  param['sip_content-type'] = 'application/sdp'
  param['sip_user-agent'] = 'X-Lite release 1105d'
  param['rtp_addr'] = '192.168.1.2'
  param['media'] = 'yes'
  param['formats'] = 'mulaw,alaw'
  param['transport'] = 'RTP/AVP'
  param['rtp_rfc2833'] = '101'
  param['rtp_port'] = '8000'
  param['sdp_sendrecv'] = ''
  param['rtp_forward'] = 'possible'
Sniffed 'chan.startup' time75498417.441873
  thread=0x6b4670 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['id'] = 'sip/1'
  param['module'] = 'sip'
  param['status'] = 'incoming'
  param['address'] = '192.168.1.2:5061'
  param['billid'] = '1275498337-1'
  param['answered'] = 'false'
  param['callid'] = 'sip/020CADA4-19A6-E36D-5873-EC47A1DD1BB5@1.../1722027474/'
  param['caller'] = '1001'
  param['called'] = '9063456568'
Returned false 'chan.startup' delay=0.004683
  thread=0x6b4670 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['id'] = 'sip/1'
  param['module'] = 'sip'
  param['status'] = 'incoming'
  param['address'] = '192.168.1.2:5061'
  param['billid'] = '1275498337-1'
  param['answered'] = 'false'
  param['callid'] = 'sip/020CADA4-19A6-E36D-5873-EC47A1DD1BB5@1.../1722027474/'
  param['caller'] = '1001'
  param['called'] = '9063456568'
Sniffed 'call.cdr' time75498417.446505
  thread=0x6b4670 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['time'] = '1275498417.442'
  param['chan'] = 'sip/1'
  param['cdrid'] = '1'
  param['runid'] = '1275498337'
  param['operation'] = 'initialize'
  param['direction'] = 'incoming'
  param['duration'] = '0.005'
  param['billtime'] = '0.000'
  param['ringtime'] = '0.005'
  param['status'] = 'incoming'
  param['external'] = '1001'
  param['cdrwrite'] = 'true'
  param['address'] = '192.168.1.2:5061'
  param['billid'] = '1275498337-1'
  param['caller'] = '1001'
  param['called'] = '9063456568'
Returned false 'call.cdr' delay=0.000296
  thread=0x6b4670 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['time'] = '1275498417.442'
  param['chan'] = 'sip/1'
  param['cdrid'] = '1'
  param['runid'] = '1275498337'
  param['operation'] = 'initialize'
  param['direction'] = 'incoming'
  param['duration'] = '0.005'
  param['billtime'] = '0.000'
  param['ringtime'] = '0.005'
  param['status'] = 'incoming'
  param['external'] = '1001'
  param['cdrwrite'] = 'true'
  param['address'] = '192.168.1.2:5061'
  param['billid'] = '1275498337-1'
  param['caller'] = '1001'
  param['called'] = '9063456568'
Returned false 'call.preroute' delay=0.032899
  thread=0x6e5010 'Call Router'
  data=(nil)
  retval='(null)'
  param['id'] = 'sip/1'
  param['module'] = 'sip'
  param['status'] = 'incoming'
  param['address'] = '192.168.1.2:5061'
  param['billid'] = '1275498337-1'
  param['answered'] = 'false'
  param['callid'] = 'sip/020CADA4-19A6-E36D-5873-EC47A1DD1BB5@1.../1722027474/'
  param['caller'] = '1001'
  param['called'] = '9063456568'
  param['callername'] = '1001 '
  param['antiloop'] = '19'
  param['ip_host'] = '192.168.1.2'
  param['ip_port'] = '5061'
  param['sip_uri'] = 'sip:9063456568@asterisk'
  param['sip_from'] = 'sip:1001@asterisk:5061'
  param['sip_to'] = ''
  param['sip_callid'] = '020CADA4-19A6-E36D-5873-EC47A1DD1BB5@1...'
  param['device'] = 'X-Lite release 1105d'
  param['sip_contact'] = ''
  param['sip_content-type'] = 'application/sdp'
  param['sip_user-agent'] = 'X-Lite release 1105d'
  param['rtp_addr'] = '192.168.1.2'
  param['media'] = 'yes'
  param['formats'] = 'mulaw,alaw'
  param['transport'] = 'RTP/AVP'
  param['rtp_rfc2833'] = '101'
  param['rtp_port'] = '8000'
  param['sdp_sendrecv'] = ''
  param['rtp_forward'] = 'possible'
Sniffed 'call.route' time75498417.441296
  thread=0x6e5010 'Call Router'
  data=(nil)
  retval='(null)'
  param['id'] = 'sip/1'
  param['module'] = 'sip'
  param['status'] = 'incoming'
  param['address'] = '192.168.1.2:5061'
  param['billid'] = '1275498337-1'
  param['answered'] = 'false'
  param['callid'] = 'sip/020CADA4-19A6-E36D-5873-EC47A1DD1BB5@1.../1722027474/'
  param['caller'] = '1001'
  param['called'] = '9063456568'
  param['callername'] = '1001 '
  param['antiloop'] = '19'
  param['ip_host'] = '192.168.1.2'
  param['ip_port'] = '5061'
  param['sip_uri'] = 'sip:9063456568@asterisk'
  param['sip_from'] = 'sip:1001@asterisk:5061'
  param['sip_to'] = ''
  param['sip_callid'] = '020CADA4-19A6-E36D-5873-EC47A1DD1BB5@1...'
  param['device'] = 'X-Lite release 1105d'
  param['sip_contact'] = ''
  param['sip_content-type'] = 'application/sdp'
  param['sip_user-agent'] = 'X-Lite release 1105d'
  param['rtp_addr'] = '192.168.1.2'
  param['media'] = 'yes'
  param['formats'] = 'mulaw,alaw'
  param['transport'] = 'RTP/AVP'
  param['rtp_rfc2833'] = '101'
  param['rtp_port'] = '8000'
  param['sdp_sendrecv'] = ''
  param['rtp_forward'] = 'possible'
Sniffed 'call.cdr' time75498417.475105
  thread=0x6b4670 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['time'] = '1275498417.442'
  param['chan'] = 'sip/1'
  param['cdrid'] = '1'
  param['runid'] = '1275498337'
  param['operation'] = 'update'
  param['direction'] = 'incoming'
  param['duration'] = '0.033'
  param['billtime'] = '0.000'
  param['ringtime'] = '0.033'
  param['status'] = 'incoming'
  param['external'] = '1001'
  param['cdrwrite'] = 'true'
  param['address'] = '192.168.1.2:5061'
  param['billid'] = '1275498337-1'
  param['caller'] = '1001'
  param['called'] = '9063456568'
Returned true 'call.route' delay=0.035078
  thread=0x6e5010 'Call Router'
  data=(nil)
  retval='analog/house/1'
  param['id'] = 'sip/1'
  param['module'] = 'sip'
  param['status'] = 'incoming'
  param['address'] = '192.168.1.2:5061'
  param['billid'] = '1275498337-1'
  param['answered'] = 'false'
  param['callid'] = 'sip/020CADA4-19A6-E36D-5873-EC47A1DD1BB5@1.../1722027474/'
  param['caller'] = '1001'
  param['called'] = '063456568'
  param['callername'] = '1001 '
  param['antiloop'] = '19'
  param['ip_host'] = '192.168.1.2'
  param['ip_port'] = '5061'
  param['sip_uri'] = 'sip:9063456568@asterisk'
  param['sip_from'] = 'sip:1001@asterisk:5061'
  param['sip_to'] = ''
  param['sip_callid'] = '020CADA4-19A6-E36D-5873-EC47A1DD1BB5@1...'
  param['device'] = 'X-Lite release 1105d'
  param['sip_contact'] = ''
  param['sip_content-type'] = 'application/sdp'
  param['sip_user-agent'] = 'X-Lite release 1105d'
  param['rtp_addr'] = '192.168.1.2'
  param['media'] = 'yes'
  param['formats'] = 'mulaw,alaw'
  param['transport'] = 'RTP/AVP'
  param['rtp_rfc2833'] = '101'
  param['rtp_port'] = '8000'
  param['sdp_sendrecv'] = ''
  param['rtp_forward'] = 'possible'
Returned false 'call.cdr' delay=0.002157
  thread=0x6b4670 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['time'] = '1275498417.442'
  param['chan'] = 'sip/1'
  param['cdrid'] = '1'
  param['runid'] = '1275498337'
  param['operation'] = 'update'
  param['direction'] = 'incoming'
  param['duration'] = '0.033'
  param['billtime'] = '0.000'
  param['ringtime'] = '0.033'
  param['status'] = 'incoming'
  param['external'] = '1001'
  param['cdrwrite'] = 'true'
  param['address'] = '192.168.1.2:5061'
  param['billid'] = '1275498337-1'
  param['caller'] = '1001'
  param['called'] = '9063456568'
Sniffed 'call.execute' time75498417.441296
  thread=0x6e5010 'Call Router'
  data=0x6defd0
  retval='(null)'
  param['id'] = 'sip/1'
  param['module'] = 'sip'
  param['status'] = 'incoming'
  param['address'] = '192.168.1.2:5061'
  param['billid'] = '1275498337-1'
  param['answered'] = 'false'
  param['callid'] = 'sip/020CADA4-19A6-E36D-5873-EC47A1DD1BB5@1.../1722027474/'
  param['caller'] = '1001'
  param['called'] = '063456568'
  param['callername'] = '1001 '
  param['antiloop'] = '19'
  param['ip_host'] = '192.168.1.2'
  param['ip_port'] = '5061'
  param['sip_uri'] = 'sip:9063456568@asterisk'
  param['sip_from'] = 'sip:1001@asterisk:5061'
  param['sip_to'] = ''
  param['sip_callid'] = '020CADA4-19A6-E36D-5873-EC47A1DD1BB5@1...'
  param['device'] = 'X-Lite release 1105d'
  param['sip_contact'] = ''
  param['sip_content-type'] = 'application/sdp'
  param['sip_user-agent'] = 'X-Lite release 1105d'
  param['rtp_addr'] = '192.168.1.2'
  param['media'] = 'yes'
  param['formats'] = 'mulaw,alaw'
  param['transport'] = 'RTP/AVP'
  param['rtp_rfc2833'] = '101'
  param['rtp_port'] = '8000'
  param['sdp_sendrecv'] = ''
  param['rtp_forward'] = 'possible'
  param['callto'] = 'analog/house/1'
Sniffed 'call.cdr' time75498417.478066
  thread=0x6b4670 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['time'] = '1275498417.442'
  param['chan'] = 'sip/1'
  param['cdrid'] = '1'
  param['runid'] = '1275498337'
  param['operation'] = 'update'
  param['direction'] = 'incoming'
  param['duration'] = '0.036'
  param['billtime'] = '0.000'
  param['ringtime'] = '0.037'
  param['status'] = 'incoming'
  param['external'] = '1001'
  param['cdrwrite'] = 'true'
  param['address'] = '192.168.1.2:5061'
  param['billid'] = '1275498337-1'
  param['caller'] = '1001'
  param['called'] = '9063456568'
Returned false 'call.cdr' delay=0.004574
  thread=0x6b4670 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['time'] = '1275498417.442'
  param['chan'] = 'sip/1'
  param['cdrid'] = '1'
  param['runid'] = '1275498337'
  param['operation'] = 'update'
  param['direction'] = 'incoming'
  param['duration'] = '0.036'
  param['billtime'] = '0.000'
  param['ringtime'] = '0.037'
  param['status'] = 'incoming'
  param['external'] = '1001'
  param['cdrwrite'] = 'true'
  param['address'] = '192.168.1.2:5061'
  param['billid'] = '1275498337-1'
  param['caller'] = '1001'
  param['called'] = '9063456568'
Returned true 'call.execute' delay=0.040974
  thread=0x6e5010 'Call Router'
  data=0x6defd0
  retval='(null)'
  param['id'] = 'sip/1'
  param['module'] = 'sip'
  param['status'] = 'incoming'
  param['address'] = '192.168.1.2:5061'
  param['billid'] = '1275498337-1'
  param['answered'] = 'false'
  param['callid'] = 'sip/020CADA4-19A6-E36D-5873-EC47A1DD1BB5@1.../1722027474/'
  param['caller'] = '1001'
  param['called'] = '063456568'
  param['callername'] = '1001 '
  param['antiloop'] = '19'
  param['ip_host'] = '192.168.1.2'
  param['ip_port'] = '5061'
  param['sip_uri'] = 'sip:9063456568@asterisk'
  param['sip_from'] = 'sip:1001@asterisk:5061'
  param['sip_to'] = ''
  param['sip_callid'] = '020CADA4-19A6-E36D-5873-EC47A1DD1BB5@1...'
  param['device'] = 'X-Lite release 1105d'
  param['sip_contact'] = ''
  param['sip_content-type'] = 'application/sdp'
  param['sip_user-agent'] = 'X-Lite release 1105d'
  param['rtp_addr'] = '192.168.1.2'
  param['media'] = 'yes'
  param['formats'] = 'mulaw,alaw'
  param['transport'] = 'RTP/AVP'
  param['rtp_rfc2833'] = '101'
  param['rtp_port'] = '8000'
  param['sdp_sendrecv'] = ''
  param['rtp_forward'] = 'possible'
  param['callto'] = 'analog/house/1'
  param['peerid'] = 'analog/1'
  param['targetid'] = 'analog/1'
Sniffed 'chan.startup' time75498417.481829
  thread=0x6b4670 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['id'] = 'analog/1'
  param['module'] = 'analog'
  param['status'] = 'outgoing'
  param['address'] = 'house/1'
  param['answered'] = 'false'
  param['direction'] = 'outgoing'
  param['caller'] = '1001'
  param['callername'] = '1001 '
  param['called'] = '063456568'
  param['billid'] = '1275498337-1'
Returned false 'chan.startup' delay=0.001120
  thread=0x6b4670 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['id'] = 'analog/1'
  param['module'] = 'analog'
  param['status'] = 'outgoing'
  param['address'] = 'house/1'
  param['answered'] = 'false'
  param['direction'] = 'outgoing'
  param['caller'] = '1001'
  param['callername'] = '1001 '
  param['called'] = '063456568'
  param['billid'] = '1275498337-1'
Sniffed 'call.cdr' time75498417.482919
  thread=0x6b4670 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['time'] = '1275498417.482'
  param['chan'] = 'analog/1'
  param['cdrid'] = '2'
  param['runid'] = '1275498337'
  param['operation'] = 'initialize'
  param['direction'] = 'outgoing'
  param['duration'] = '0.001'
  param['billtime'] = '0.000'
  param['ringtime'] = '0.001'
  param['status'] = 'outgoing'
  param['external'] = '063456568'
  param['cdrwrite'] = 'true'
  param['address'] = 'house/1'
  param['caller'] = '1001'
  param['called'] = '063456568'
  param['billid'] = '1275498337-1'
Returned false 'call.cdr' delay=0.000239
  thread=0x6b4670 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['time'] = '1275498417.482'
  param['chan'] = 'analog/1'
  param['cdrid'] = '2'
  param['runid'] = '1275498337'
  param['operation'] = 'initialize'
  param['direction'] = 'outgoing'
  param['duration'] = '0.001'
  param['billtime'] = '0.000'
  param['ringtime'] = '0.001'
  param['status'] = 'outgoing'
  param['external'] = '063456568'
  param['cdrwrite'] = 'true'
  param['address'] = 'house/1'
  param['caller'] = '1001'
  param['called'] = '063456568'
  param['billid'] = '1275498337-1'
Sniffed 'module.update' time75498423.000204
  thread=0x6b4670 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['module'] = 'sip'
  param['routed'] = '1'
  param['routing'] = '0'
  param['total'] = '1'
  param['chans'] = '1'
Returned false 'module.update' delay=0.000270
  thread=0x6b4670 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['module'] = 'sip'
  param['routed'] = '1'
  param['routing'] = '0'
  param['total'] = '1'
  param['chans'] = '1'
Sniffed 'module.update' time75498423.000266
  thread=0x6b4670 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['module'] = 'analog'
  param['routed'] = '0'
  param['routing'] = '0'
  param['total'] = '1'
  param['chans'] = '1'
Returned false 'module.update' delay=0.000298
  thread=0x6b4670 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['module'] = 'analog'
  param['routed'] = '0'
  param['routing'] = '0'
  param['total'] = '1'
  param['chans'] = '1'
Sniffed 'call.progress' time75498431.278979
  thread=0x6b4670 'Engine Worker'
  data=0x7f4dac005970
  retval='(null)'
  param['id'] = 'analog/1'
  param['module'] = 'analog'
Returned false 'call.progress' delay=0.002376
  thread=0x6b4670 'Engine Worker'
  data=0x7f4dac005970
  retval='(null)'
  param['id'] = 'analog/1'
  param['module'] = 'analog'
Sniffed 'chan.disconnected' time75498448.280406
  thread=0x6b4670 'Engine Worker'
  data=0x7f4dac005970
  retval='(null)'
  param['id'] = 'analog/1'
  param['module'] = 'analog'
  param['status'] = 'outgoing'
  param['address'] = 'house/1'
  param['targetid'] = 'sip/1'
  param['billid'] = '1275498337-1'
  param['lastpeerid'] = 'sip/1'
  param['answered'] = 'false'
Returned false 'chan.disconnected' delay=0.004541
  thread=0x6b4670 'Engine Worker'
  data=0x7f4dac005970
  retval='(null)'
  param['id'] = 'analog/1'
  param['module'] = 'analog'
  param['status'] = 'outgoing'
  param['address'] = 'house/1'
  param['targetid'] = 'sip/1'
  param['billid'] = '1275498337-1'
  param['lastpeerid'] = 'sip/1'
  param['answered'] = 'false'
Sniffed 'chan.hangup' time75498448.280444
  thread=0x6b4670 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['id'] = 'analog/1'
  param['module'] = 'analog'
  param['status'] = 'disconnected'
  param['reason'] = 'Cancelled'
Returned false 'chan.hangup' delay=0.014853
  thread=0x6b4670 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['id'] = 'analog/1'
  param['module'] = 'analog'
  param['status'] = 'disconnected'
  param['reason'] = 'Cancelled'
Sniffed 'chan.hangup' time75498448.280478
  thread=0x6b4670 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['id'] = 'sip/1'
  param['module'] = 'sip'
  param['status'] = 'accepted'
  param['address'] = '192.168.1.2:5061'
  param['targetid'] = 'analog/1'
  param['billid'] = '1275498337-1'
  param['lastpeerid'] = 'analog/1'
  param['answered'] = 'false'
  param['callid'] = 'sip/020CADA4-19A6-E36D-5873-EC47A1DD1BB5@1.../1722027474/'
  param['reason'] = 'Request Terminated'
Returned false 'chan.hangup' delay=0.015005
  thread=0x6b4670 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['id'] = 'sip/1'
  param['module'] = 'sip'
  param['status'] = 'accepted'
  param['address'] = '192.168.1.2:5061'
  param['targetid'] = 'analog/1'
  param['billid'] = '1275498337-1'
  param['lastpeerid'] = 'analog/1'
  param['answered'] = 'false'
  param['callid'] = 'sip/020CADA4-19A6-E36D-5873-EC47A1DD1BB5@1.../1722027474/'
  param['reason'] = 'Request Terminated'
Sniffed 'call.cdr' time75498448.295228
  thread=0x6b4670 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['time'] = '1275498417.482'
  param['chan'] = 'analog/1'
  param['cdrid'] = '2'
  param['runid'] = '1275498337'
  param['operation'] = 'finalize'
  param['direction'] = 'outgoing'
  param['duration'] = '30.799'
  param['billtime'] = '0.000'
  param['ringtime'] = '30.799'
  param['status'] = 'disconnected'
  param['external'] = '063456568'
  param['cdrwrite'] = 'true'
  param['address'] = 'house/1'
  param['caller'] = '1001'
  param['called'] = '063456568'
  param['billid'] = '1275498337-1'
  param['reason'] = 'Cancelled'
Returned false 'call.cdr' delay=0.000662
  thread=0x6b4670 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['time'] = '1275498417.482'
  param['chan'] = 'analog/1'
  param['cdrid'] = '2'
  param['runid'] = '1275498337'
  param['operation'] = 'finalize'
  param['direction'] = 'outgoing'
  param['duration'] = '30.799'
  param['billtime'] = '0.000'
  param['ringtime'] = '30.799'
  param['status'] = 'disconnected'
  param['external'] = '063456568'
  param['cdrwrite'] = 'true'
  param['address'] = 'house/1'
  param['caller'] = '1001'
  param['called'] = '063456568'
  param['billid'] = '1275498337-1'
  param['reason'] = 'Cancelled'
Sniffed 'call.cdr' time75498448.295446
  thread=0x6b4670 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['time'] = '1275498417.442'
  param['chan'] = 'sip/1'
  param['cdrid'] = '1'
  param['runid'] = '1275498337'
  param['operation'] = 'finalize'
  param['direction'] = 'incoming'
  param['duration'] = '30.839'
  param['billtime'] = '0.000'
  param['ringtime'] = '30.839'
  param['status'] = 'accepted'
  param['external'] = '1001'
  param['cdrwrite'] = 'true'
  param['address'] = '192.168.1.2:5061'
  param['billid'] = '1275498337-1'
  param['caller'] = '1001'
  param['called'] = '9063456568'
  param['reason'] = 'Request Terminated'
Returned false 'call.cdr' delay=0.000830
  thread=0x6b4670 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['time'] = '1275498417.442'
  param['chan'] = 'sip/1'
  param['cdrid'] = '1'
  param['runid'] = '1275498337'
  param['operation'] = 'finalize'
  param['direction'] = 'incoming'
  param['duration'] = '30.839'
  param['billtime'] = '0.000'
  param['ringtime'] = '30.839'
  param['status'] = 'accepted'
  param['external'] = '1001'
  param['cdrwrite'] = 'true'
  param['address'] = '192.168.1.2:5061'
  param['billid'] = '1275498337-1'
  param['caller'] = '1001'
  param['called'] = '9063456568'
  param['reason'] = 'Request Terminated'
Sniffed 'module.update' time75498454.005131
  thread=0x6b4670 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['module'] = 'sip'
  param['routed'] = '1'
  param['routing'] = '0'
  param['total'] = '1'
  param['chans'] = '0'
Returned false 'module.update' delay=0.026136
  thread=0x6b4670 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['module'] = 'sip'
  param['routed'] = '1'
  param['routing'] = '0'
  param['total'] = '1'
  param['chans'] = '0'
Sniffed 'module.update' time75498454.005807
  thread=0x6b4670 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['module'] = 'analog'
  param['routed'] = '0'
  param['routing'] = '0'
  param['total'] = '1'
  param['chans'] = '0'
Returned false 'module.update' delay=0.025610
  thread=0x6b4670 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['module'] = 'analog'
  param['routed'] = '0'
  param['routing'] = '0'
  param['total'] = '1'
  param['chans'] = '0'
Yate engine is shutting down with code 0
Sniffed 'engine.halt' time75498455.302813
  thread=(nil) '(null)'
  data=(nil)
  retval='(null)'
 Worker thread terminated [0x6ac210]
Returned false 'engine.halt' delay=0.065020
  thread=(nil) '(null)'
  data=(nil)
  retval='(null)'
Unloading module Jingle Features
Unloading module MGCP-GW
Unloading module MRCP
Unloading module Register for database
Unloading module Heartbeat
Unloading module Signalling Channel
Unloading module Queues
Unloading module Call Parking
Unloading module CallCounters
Unloading module PBX for database
Unloading module Late Router
Unloading module SIP Features
Unloading module Queues Notify
Unloaded module Radius client
Unloading module CdrBuild
Unloading module YJingle
Unloading module YIAX
Unloading module MOH
Unloading module Conference
Unloading module YRTP
Unloading module DumbChannel
Unloading module ToneGen
Unloading module Analyzer
Unloading module ToneDetector
Unloading module iLBC with 0 codecs still in use
Unloading module Call Forker
Unloading module YSTUN
Unloading module PBX
Unloading module Call Generator, clearing 0 calls
Unloading module RManager
Unloading module ExtModule
Unloading module OpenSSL
Unloading module File Transfer
Unloading module CdrFile
Unloading module MUX
Unloading module Zaptel
Unloading module MGCP-CA
Unloading module Analog Channel
Unloading module Cisco SM
Unloading module YSOCKS
Unloading module SIP Channel
Unloading module Clustering
Unloading module Analog Detector
Yate (9381) is stopping Wed Jun  2 19:07:35 2010

Yate (9091) is starting Wed Jun  2 18:58:26 2010
Loaded module WaveFile
Loaded module ExtModule
Loaded module RManager
Loaded module OpenSSL - based on OpenSSL 0.9.8h 28 May 2008
Loaded module YSOCKS
Loaded module File Transfer
Loaded module Call Generator
Loaded module PBX
Loaded module YSTUN
Loaded module SIP Channel
Loaded module CdrFile
Loaded module Call Forker
Loaded module iLBC - based on iLBC library
Loaded module ToneDetector
Loaded module Analyzer
Loaded module MUX
Loaded module ToneGen
Loaded module MsgSniffer
Loaded module DumbChannel
Loaded module RegexRoute
Loaded module YRTP
Loaded module Conference
Loaded module MOH
Loaded module YIAX
Loaded module YJingle
Loaded module CdrBuild
Loaded module Radius client
Loaded module Accounts from file
Loaded module Analog Channel
Loaded module Queues Notify
Loaded module Zaptel
Loaded module SIP Features
Loaded module Late Router
Loaded module PBX for database
Loaded module DbWave
Loaded module CallCounters
Loaded module Call Parking
Loaded module Queues
Loaded module Signalling Channel
Loaded module Heartbeat
Loaded module Register for database
Loaded module MGCP-CA
Loaded module Cisco SM
Loaded module MRCP
Loaded module MGCP-GW
Loaded module Registration from file
Loaded module Clustering
Loaded module Analog Detector
Loaded module Jingle Features
Initializing plugins
Initializing module Analog Detector
Initializing module Clustering
Initializing module Cisco SM
Initializing module MGCP Call Agent
Initializing module DbWave
Initializing module Zaptel
Initializing module MUX
Initializing module CdrFile
Initializing module YSOCKS
Initializing module OpenSSL
Initializing module WaveFile
Initializing module ExtModule
Initializing module RManager
Initializing module File Transfer
Initializing module Call Generator
Initializing module PBX
Initializing module YSTUN
Initializing module SIP Channel
Initializing module Call Forker
Initializing module ToneDetector
Initializing module Analyzer
Initializing module ToneGen
Initializing module MsgSniffer
Initializing module DumbChannel
DumbChannel initialized
Initializing module RegexRoute
Initializing module YRTP
Initializing module Conference
Initializing module MOH
Initializing module YIAX
Initializing module YJingle
Initializing module CdrBuild
Initializing module Radius client
Initializing module Accounts from file
Initializing module Analog Channel
 ZapCircuit driver=zaptel type=FXO channel=1 cic=1 dtmfdetectúlse echotaps=0 echotrain@0 buflen%5 readonlyúlse idlevalue%5 priority=normal [0x6ad260]
 ZapSpan('') driver=zaptel section=span1 type=FXO channels=1 circuits=1 [0x6ac600]
 ZapCircuit driver=zaptel type=FXO channel=2 cic=2 dtmfdetectúlse echotaps=0 echotrain@0 buflen%5 readonlyúlse idlevalue%5 priority=normal [0x6ad7b0]
 ZapSpan('') driver=zaptel section=span2 type=FXO channels=2 circuits=2 [0x6ad650]
 ZapCircuit(1). IOCTL(SetToneDetect) failed on channel 1 (param=0). 38: Function not implemented [0x6ac090]
 ZapCircuit(2). IOCTL(SetToneDetect) failed on channel 2 (param=0). 38: Function not implemented [0x6ac090]
Initializing module Queues Notify
Initializing module SIP Features
Initializing module Late Router
Initializing module PBX for database
Initializing module Call Parking
Initializing module Queues for database
Initializing module Signalling Channel
Initializing module Register for database
Initializing module MrcpSpeech
Initializing module MGCP Gateway
 Could not set remote endpoint for 'PUT_NAME_HERE'
Initializing module Register for file
Initializing module Jingle Features
Initialization complete
Sniffed 'engine.start' time75497906.831058
  thread=(nil) '(null)'
  data=(nil)
  retval='(null)'
Returned false 'engine.start' delay=0.001574
  thread=(nil) '(null)'
  data=(nil)
  retval='(null)'
Yate engine is initialized and starting up on linux
Sniffed 'user.auth' time75497923.519569
  thread=0x7febb8023020 'YSIP Register'
  data=(nil)
  retval='(null)'
  param['protocol'] = 'sip'
  param['method'] = 'REGISTER'
  param['uri'] = 'sip:asterisk'
  param['ip_host'] = '192.168.1.2'
  param['ip_port'] = '5061'
  param['address'] = '192.168.1.2:5061'
  param['newcall'] = 'false'
Returned false 'user.auth' delay=0.000381
  thread=0x7febb8023020 'YSIP Register'
  data=(nil)
  retval='(null)'
  param['protocol'] = 'sip'
  param['method'] = 'REGISTER'
  param['uri'] = 'sip:asterisk'
  param['ip_host'] = '192.168.1.2'
  param['ip_port'] = '5061'
  param['address'] = '192.168.1.2:5061'
  param['newcall'] = 'false'
Sniffed 'user.auth' time75497959.311111
  thread=0x7febb8023020 'YSIP Register'
  data=(nil)
  retval='(null)'
  param['protocol'] = 'sip'
  param['method'] = 'REGISTER'
  param['uri'] = 'sip:asterisk'
  param['ip_host'] = '192.168.1.2'
  param['ip_port'] = '5061'
  param['address'] = '192.168.1.2:5061'
  param['newcall'] = 'false'
Returned false 'user.auth' delay=0.000210
  thread=0x7febb8023020 'YSIP Register'
  data=(nil)
  retval='(null)'
  param['protocol'] = 'sip'
  param['method'] = 'REGISTER'
  param['uri'] = 'sip:asterisk'
  param['ip_host'] = '192.168.1.2'
  param['ip_port'] = '5061'
  param['address'] = '192.168.1.2:5061'
  param['newcall'] = 'false'
Sniffed 'user.auth' time75497959.319183
  thread=0x7febb8024b40 'YSIP Register'
  data=(nil)
  retval='(null)'
  param['protocol'] = 'sip'
  param['username'] = '1001'
  param['realm'] = 'asterisk'
  param['nonce'] = '4217db62e38d3d7afad486527b390398.1275497959'
  param['response'] = '13d41dd0b8d627947b9fa5c2ca204697'
  param['method'] = 'REGISTER'
  param['uri'] = 'sip:asterisk'
  param['ip_host'] = '192.168.1.2'
  param['ip_port'] = '5061'
  param['address'] = '192.168.1.2:5061'
  param['newcall'] = 'false'
Returned true 'user.auth' delay=0.000173
  thread=0x7febb8024b40 'YSIP Register'
  data=(nil)
  retval='1001'
  param['protocol'] = 'sip'
  param['username'] = '1001'
  param['realm'] = 'asterisk'
  param['nonce'] = '4217db62e38d3d7afad486527b390398.1275497959'
  param['response'] = '13d41dd0b8d627947b9fa5c2ca204697'
  param['method'] = 'REGISTER'
  param['uri'] = 'sip:asterisk'
  param['ip_host'] = '192.168.1.2'
  param['ip_port'] = '5061'
  param['address'] = '192.168.1.2:5061'
  param['newcall'] = 'false'
Sniffed 'user.register' time75497959.319152
  thread=0x7febb8024b40 'YSIP Register'
  data=(nil)
  retval='(null)'
  param['sip_uri'] = 'sip:asterisk'
  param['sip_callid'] = '1E4B26C0B8F7F8EF401B670D0AB18A22@asterisk'
  param['username'] = '1001'
  param['realm'] = 'asterisk'
  param['newcall'] = 'false'
  param['number'] = '1001'
  param['driver'] = 'sip'
  param['data'] = 'sip/sip:1001@1...:5061'
  param['ip_host'] = '192.168.1.2'
  param['ip_port'] = '5061'
  param['expires'] = '1800'
  param['sip_to'] = 'sip:1001@1...:5061'
  param['device'] = 'X-Lite release 1105d'
Returned true 'user.register' delay=0.000782
  thread=0x7febb8024b40 'YSIP Register'
  data=(nil)
  retval='(null)'
  param['sip_uri'] = 'sip:asterisk'
  param['sip_callid'] = '1E4B26C0B8F7F8EF401B670D0AB18A22@asterisk'
  param['username'] = '1001'
  param['realm'] = 'asterisk'
  param['newcall'] = 'false'
  param['number'] = '1001'
  param['driver'] = 'sip'
  param['data'] = 'sip/sip:1001@1...:5061'
  param['ip_host'] = '192.168.1.2'
  param['ip_port'] = '5061'
  param['expires'] = '1800'
  param['sip_to'] = 'sip:1001@1...:5061'
  param['device'] = 'X-Lite release 1105d'
Sniffed 'user.auth' time75497962.847217
  thread=0x691a70 'YSIP EndPoint'
  data=(nil)
  retval='(null)'
  param['protocol'] = 'sip'
  param['method'] = 'INVITE'
  param['uri'] = 'sip:9063456568@asterisk'
  param['ip_host'] = '192.168.1.2'
  param['ip_port'] = '5061'
  param['address'] = '192.168.1.2:5061'
  param['newcall'] = 'true'
  param['caller'] = '1001'
  param['called'] = '9063456568'
Returned false 'user.auth' delay=0.000218
  thread=0x691a70 'YSIP EndPoint'
  data=(nil)
  retval='(null)'
  param['protocol'] = 'sip'
  param['method'] = 'INVITE'
  param['uri'] = 'sip:9063456568@asterisk'
  param['ip_host'] = '192.168.1.2'
  param['ip_port'] = '5061'
  param['address'] = '192.168.1.2:5061'
  param['newcall'] = 'true'
  param['caller'] = '1001'
  param['called'] = '9063456568'
Sniffed 'call.preroute' time75497962.847138
  thread=0x6c1f70 'Call Router'
  data=(nil)
  retval='(null)'
  param['id'] = 'sip/1'
  param['module'] = 'sip'
  param['status'] = 'incoming'
  param['address'] = '192.168.1.2:5061'
  param['billid'] = '1275497906-1'
  param['answered'] = 'false'
  param['callid'] = 'sip/603677A5-834B-D37B-8106-3C1F1A415AA4@1.../1689164942/'
  param['caller'] = '1001'
  param['called'] = '9063456568'
  param['callername'] = '1001 '
  param['antiloop'] = '19'
  param['ip_host'] = '192.168.1.2'
  param['ip_port'] = '5061'
  param['sip_uri'] = 'sip:9063456568@asterisk'
  param['sip_from'] = 'sip:1001@asterisk:5061'
  param['sip_to'] = ''
  param['sip_callid'] = '603677A5-834B-D37B-8106-3C1F1A415AA4@1...'
  param['device'] = 'X-Lite release 1105d'
  param['sip_contact'] = ''
  param['sip_content-type'] = 'application/sdp'
  param['sip_user-agent'] = 'X-Lite release 1105d'
  param['rtp_addr'] = '192.168.1.2'
  param['media'] = 'yes'
  param['formats'] = 'mulaw,alaw'
  param['transport'] = 'RTP/AVP'
  param['rtp_rfc2833'] = '101'
  param['rtp_port'] = '8000'
  param['sdp_sendrecv'] = ''
  param['rtp_forward'] = 'possible'
Returned false 'call.preroute' delay=0.001499
  thread=0x6c1f70 'Call Router'
  data=(nil)
  retval='(null)'
  param['id'] = 'sip/1'
  param['module'] = 'sip'
  param['status'] = 'incoming'
  param['address'] = '192.168.1.2:5061'
  param['billid'] = '1275497906-1'
  param['answered'] = 'false'
  param['callid'] = 'sip/603677A5-834B-D37B-8106-3C1F1A415AA4@1.../1689164942/'
  param['caller'] = '1001'
  param['called'] = '9063456568'
  param['callername'] = '1001 '
  param['antiloop'] = '19'
  param['ip_host'] = '192.168.1.2'
  param['ip_port'] = '5061'
  param['sip_uri'] = 'sip:9063456568@asterisk'
  param['sip_from'] = 'sip:1001@asterisk:5061'
  param['sip_to'] = ''
  param['sip_callid'] = '603677A5-834B-D37B-8106-3C1F1A415AA4@1...'
  param['device'] = 'X-Lite release 1105d'
  param['sip_contact'] = ''
  param['sip_content-type'] = 'application/sdp'
  param['sip_user-agent'] = 'X-Lite release 1105d'
  param['rtp_addr'] = '192.168.1.2'
  param['media'] = 'yes'
  param['formats'] = 'mulaw,alaw'
  param['transport'] = 'RTP/AVP'
  param['rtp_rfc2833'] = '101'
  param['rtp_port'] = '8000'
  param['sdp_sendrecv'] = ''
  param['rtp_forward'] = 'possible'
Sniffed 'call.route' time75497962.847138
  thread=0x6c1f70 'Call Router'
  data=(nil)
  retval='(null)'
  param['id'] = 'sip/1'
  param['module'] = 'sip'
  param['status'] = 'incoming'
  param['address'] = '192.168.1.2:5061'
  param['billid'] = '1275497906-1'
  param['answered'] = 'false'
  param['callid'] = 'sip/603677A5-834B-D37B-8106-3C1F1A415AA4@1.../1689164942/'
  param['caller'] = '1001'
  param['called'] = '9063456568'
  param['callername'] = '1001 '
  param['antiloop'] = '19'
  param['ip_host'] = '192.168.1.2'
  param['ip_port'] = '5061'
  param['sip_uri'] = 'sip:9063456568@asterisk'
  param['sip_from'] = 'sip:1001@asterisk:5061'
  param['sip_to'] = ''
  param['sip_callid'] = '603677A5-834B-D37B-8106-3C1F1A415AA4@1...'
  param['device'] = 'X-Lite release 1105d'
  param['sip_contact'] = ''
  param['sip_content-type'] = 'application/sdp'
  param['sip_user-agent'] = 'X-Lite release 1105d'
  param['rtp_addr'] = '192.168.1.2'
  param['media'] = 'yes'
  param['formats'] = 'mulaw,alaw'
  param['transport'] = 'RTP/AVP'
  param['rtp_rfc2833'] = '101'
  param['rtp_port'] = '8000'
  param['sdp_sendrecv'] = ''
  param['rtp_forward'] = 'possible'
Returned true 'call.route' delay=0.002824
  thread=0x6c1f70 'Call Router'
  data=(nil)
  retval='analog/house/1'
  param['id'] = 'sip/1'
  param['module'] = 'sip'
  param['status'] = 'incoming'
  param['address'] = '192.168.1.2:5061'
  param['billid'] = '1275497906-1'
  param['answered'] = 'false'
  param['callid'] = 'sip/603677A5-834B-D37B-8106-3C1F1A415AA4@1.../1689164942/'
  param['caller'] = '1001'
  param['called'] = '063456568'
  param['callername'] = '1001 '
  param['antiloop'] = '19'
  param['ip_host'] = '192.168.1.2'
  param['ip_port'] = '5061'
  param['sip_uri'] = 'sip:9063456568@asterisk'
  param['sip_from'] = 'sip:1001@asterisk:5061'
  param['sip_to'] = ''
  param['sip_callid'] = '603677A5-834B-D37B-8106-3C1F1A415AA4@1...'
  param['device'] = 'X-Lite release 1105d'
  param['sip_contact'] = ''
  param['sip_content-type'] = 'application/sdp'
  param['sip_user-agent'] = 'X-Lite release 1105d'
  param['rtp_addr'] = '192.168.1.2'
  param['media'] = 'yes'
  param['formats'] = 'mulaw,alaw'
  param['transport'] = 'RTP/AVP'
  param['rtp_rfc2833'] = '101'
  param['rtp_port'] = '8000'
  param['sdp_sendrecv'] = ''
  param['rtp_forward'] = 'possible'
Sniffed 'call.execute' time75497962.847138
  thread=0x6c1f70 'Call Router'
  data=0x6bbdb0
  retval='(null)'
  param['id'] = 'sip/1'
  param['module'] = 'sip'
  param['status'] = 'incoming'
  param['address'] = '192.168.1.2:5061'
  param['billid'] = '1275497906-1'
  param['answered'] = 'false'
  param['callid'] = 'sip/603677A5-834B-D37B-8106-3C1F1A415AA4@1.../1689164942/'
  param['caller'] = '1001'
  param['called'] = '063456568'
  param['callername'] = '1001 '
  param['antiloop'] = '19'
  param['ip_host'] = '192.168.1.2'
  param['ip_port'] = '5061'
  param['sip_uri'] = 'sip:9063456568@asterisk'
  param['sip_from'] = 'sip:1001@asterisk:5061'
  param['sip_to'] = ''
  param['sip_callid'] = '603677A5-834B-D37B-8106-3C1F1A415AA4@1...'
  param['device'] = 'X-Lite release 1105d'
  param['sip_contact'] = ''
  param['sip_content-type'] = 'application/sdp'
  param['sip_user-agent'] = 'X-Lite release 1105d'
  param['rtp_addr'] = '192.168.1.2'
  param['media'] = 'yes'
  param['formats'] = 'mulaw,alaw'
  param['transport'] = 'RTP/AVP'
  param['rtp_rfc2833'] = '101'
  param['rtp_port'] = '8000'
  param['sdp_sendrecv'] = ''
  param['rtp_forward'] = 'possible'
  param['callto'] = 'analog/house/1'
Returned true 'call.execute' delay=0.004061
  thread=0x6c1f70 'Call Router'
  data=0x6bbdb0
  retval='(null)'
  param['id'] = 'sip/1'
  param['module'] = 'sip'
  param['status'] = 'incoming'
  param['address'] = '192.168.1.2:5061'
  param['billid'] = '1275497906-1'
  param['answered'] = 'false'
  param['callid'] = 'sip/603677A5-834B-D37B-8106-3C1F1A415AA4@1.../1689164942/'
  param['caller'] = '1001'
  param['called'] = '063456568'
  param['callername'] = '1001 '
  param['antiloop'] = '19'
  param['ip_host'] = '192.168.1.2'
  param['ip_port'] = '5061'
  param['sip_uri'] = 'sip:9063456568@asterisk'
  param['sip_from'] = 'sip:1001@asterisk:5061'
  param['sip_to'] = ''
  param['sip_callid'] = '603677A5-834B-D37B-8106-3C1F1A415AA4@1...'
  param['device'] = 'X-Lite release 1105d'
  param['sip_contact'] = ''
  param['sip_content-type'] = 'application/sdp'
  param['sip_user-agent'] = 'X-Lite release 1105d'
  param['rtp_addr'] = '192.168.1.2'
  param['media'] = 'yes'
  param['formats'] = 'mulaw,alaw'
  param['transport'] = 'RTP/AVP'
  param['rtp_rfc2833'] = '101'
  param['rtp_port'] = '8000'
  param['sdp_sendrecv'] = ''
  param['rtp_forward'] = 'possible'
  param['callto'] = 'analog/house/1'
  param['peerid'] = 'analog/1'
  param['targetid'] = 'analog/1'
Sniffed 'chan.startup' time75497962.847670
  thread=0x7febb8009760 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['id'] = 'sip/1'
  param['module'] = 'sip'
  param['status'] = 'incoming'
  param['address'] = '192.168.1.2:5061'
  param['billid'] = '1275497906-1'
  param['answered'] = 'false'
  param['callid'] = 'sip/603677A5-834B-D37B-8106-3C1F1A415AA4@1.../1689164942/'
  param['caller'] = '1001'
  param['called'] = '9063456568'
Returned false 'chan.startup' delay=0.004709
  thread=0x7febb8009760 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['id'] = 'sip/1'
  param['module'] = 'sip'
  param['status'] = 'incoming'
  param['address'] = '192.168.1.2:5061'
  param['billid'] = '1275497906-1'
  param['answered'] = 'false'
  param['callid'] = 'sip/603677A5-834B-D37B-8106-3C1F1A415AA4@1.../1689164942/'
  param['caller'] = '1001'
  param['called'] = '9063456568'
Sniffed 'call.cdr' time75497962.850894
  thread=0x7febb8009760 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['time'] = '1275497962.847'
  param['chan'] = 'sip/1'
  param['cdrid'] = '1'
  param['runid'] = '1275497906'
  param['operation'] = 'initialize'
  param['direction'] = 'incoming'
  param['duration'] = '0.004'
  param['billtime'] = '0.000'
  param['ringtime'] = '0.004'
  param['status'] = 'incoming'
  param['external'] = '1001'
  param['cdrwrite'] = 'true'
  param['address'] = '192.168.1.2:5061'
  param['billid'] = '1275497906-1'
  param['caller'] = '1001'
  param['called'] = '063456568'
Returned false 'call.cdr' delay=0.001730
  thread=0x7febb8009760 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['time'] = '1275497962.847'
  param['chan'] = 'sip/1'
  param['cdrid'] = '1'
  param['runid'] = '1275497906'
  param['operation'] = 'initialize'
  param['direction'] = 'incoming'
  param['duration'] = '0.004'
  param['billtime'] = '0.000'
  param['ringtime'] = '0.004'
  param['status'] = 'incoming'
  param['external'] = '1001'
  param['cdrwrite'] = 'true'
  param['address'] = '192.168.1.2:5061'
  param['billid'] = '1275497906-1'
  param['caller'] = '1001'
  param['called'] = '063456568'
Sniffed 'chan.startup' time75497962.851125
  thread=0x7febb8009760 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['id'] = 'analog/1'
  param['module'] = 'analog'
  param['status'] = 'outgoing'
  param['address'] = 'house/1'
  param['answered'] = 'false'
  param['direction'] = 'outgoing'
  param['caller'] = '1001'
  param['callername'] = '1001 '
  param['called'] = '063456568'
  param['billid'] = '1275497906-1'
Returned false 'chan.startup' delay=0.001791
  thread=0x7febb8009760 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['id'] = 'analog/1'
  param['module'] = 'analog'
  param['status'] = 'outgoing'
  param['address'] = 'house/1'
  param['answered'] = 'false'
  param['direction'] = 'outgoing'
  param['caller'] = '1001'
  param['callername'] = '1001 '
  param['called'] = '063456568'
  param['billid'] = '1275497906-1'
Sniffed 'call.cdr' time75497962.852297
  thread=0x7febb8009760 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['time'] = '1275497962.847'
  param['chan'] = 'sip/1'
  param['cdrid'] = '1'
  param['runid'] = '1275497906'
  param['operation'] = 'update'
  param['direction'] = 'incoming'
  param['duration'] = '0.005'
  param['billtime'] = '0.000'
  param['ringtime'] = '0.005'
  param['status'] = 'incoming'
  param['external'] = '1001'
  param['cdrwrite'] = 'true'
  param['address'] = '192.168.1.2:5061'
  param['billid'] = '1275497906-1'
  param['caller'] = '1001'
  param['called'] = '063456568'
Returned false 'call.cdr' delay=0.000930
  thread=0x7febb8009760 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['time'] = '1275497962.847'
  param['chan'] = 'sip/1'
  param['cdrid'] = '1'
  param['runid'] = '1275497906'
  param['operation'] = 'update'
  param['direction'] = 'incoming'
  param['duration'] = '0.005'
  param['billtime'] = '0.000'
  param['ringtime'] = '0.005'
  param['status'] = 'incoming'
  param['external'] = '1001'
  param['cdrwrite'] = 'true'
  param['address'] = '192.168.1.2:5061'
  param['billid'] = '1275497906-1'
  param['caller'] = '1001'
  param['called'] = '063456568'
Sniffed 'call.cdr' time75497962.852877
  thread=0x7febb8009760 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['time'] = '1275497962.851'
  param['chan'] = 'analog/1'
  param['cdrid'] = '2'
  param['runid'] = '1275497906'
  param['operation'] = 'initialize'
  param['direction'] = 'outgoing'
  param['duration'] = '0.002'
  param['billtime'] = '0.000'
  param['ringtime'] = '0.002'
  param['status'] = 'outgoing'
  param['external'] = '063456568'
  param['cdrwrite'] = 'true'
  param['address'] = 'house/1'
  param['caller'] = '1001'
  param['called'] = '063456568'
  param['billid'] = '1275497906-1'
Returned false 'call.cdr' delay=0.000681
  thread=0x7febb8009760 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['time'] = '1275497962.851'
  param['chan'] = 'analog/1'
  param['cdrid'] = '2'
  param['runid'] = '1275497906'
  param['operation'] = 'initialize'
  param['direction'] = 'outgoing'
  param['duration'] = '0.002'
  param['billtime'] = '0.000'
  param['ringtime'] = '0.002'
  param['status'] = 'outgoing'
  param['external'] = '063456568'
  param['cdrwrite'] = 'true'
  param['address'] = 'house/1'
  param['caller'] = '1001'
  param['called'] = '063456568'
  param['billid'] = '1275497906-1'
Sniffed 'call.answered' time75497964.851284
  thread=0x7febb8009760 'Engine Worker'
  data=0x6c5610
  retval='(null)'
  param['id'] = 'analog/1'
  param['module'] = 'analog'
  param['status'] = 'answered'
  param['address'] = 'house/1'
  param['targetid'] = 'sip/1'
  param['billid'] = '1275497906-1'
  param['peerid'] = 'sip/1'
  param['lastpeerid'] = 'sip/1'
  param['answered'] = 'true'
Sniffed 'chan.rtp' time75497964.854019
  thread=0x7febb8009760 'Engine Worker'
  data=0x6bbdb0
  retval='(null)'
  param['id'] = 'sip/1'
  param['module'] = 'sip'
  param['callid'] = 'sip/603677A5-834B-D37B-8106-3C1F1A415AA4@1.../1689164942/'
  param['call_direction'] = 'incoming'
  param['call_address'] = '192.168.1.2:5061'
  param['call_status'] = 'accepted'
  param['call_billid'] = '1275497906-1'
  param['media'] = 'audio'
  param['transport'] = 'RTP/AVP'
  param['direction'] = 'bidir'
  param['format'] = 'mulaw'
  param['remoteip'] = '192.168.1.2'
  param['sdp_sendrecv'] = ''
Returned true 'chan.rtp' delay=0.000448
  thread=0x7febb8009760 'Engine Worker'
  data=0x6bbdb0
  retval='(null)'
  param['id'] = 'sip/1'
  param['module'] = 'sip'
  param['callid'] = 'sip/603677A5-834B-D37B-8106-3C1F1A415AA4@1.../1689164942/'
  param['call_direction'] = 'incoming'
  param['call_address'] = '192.168.1.2:5061'
  param['call_status'] = 'accepted'
  param['call_billid'] = '1275497906-1'
  param['media'] = 'audio'
  param['transport'] = 'RTP/AVP'
  param['direction'] = 'bidir'
  param['format'] = 'mulaw'
  param['remoteip'] = '192.168.1.2'
  param['sdp_sendrecv'] = ''
  param['localip'] = '192.168.1.2'
  param['localport'] = '20452'
  param['rtpid'] = 'yrtp/987987334'
Returned true 'call.answered' delay=0.003655
  thread=0x7febb8009760 'Engine Worker'
  data=0x6c5610
  retval='(null)'
  param['id'] = 'analog/1'
  param['module'] = 'analog'
  param['status'] = 'answered'
  param['address'] = 'house/1'
  param['targetid'] = 'sip/1'
  param['billid'] = '1275497906-1'
  param['peerid'] = 'sip/1'
  param['lastpeerid'] = 'sip/1'
  param['answered'] = 'true'
Sniffed 'call.cdr' time75497964.853823
  thread=0x7febb8009760 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['time'] = '1275497962.851'
  param['chan'] = 'analog/1'
  param['cdrid'] = '2'
  param['runid'] = '1275497906'
  param['operation'] = 'update'
  param['direction'] = 'outgoing'
  param['duration'] = '2.003'
  param['billtime'] = '0.003'
  param['ringtime'] = '2.000'
  param['status'] = 'answered'
  param['external'] = '063456568'
  param['cdrwrite'] = 'true'
  param['address'] = 'house/1'
  param['caller'] = '1001'
  param['called'] = '063456568'
  param['billid'] = '1275497906-1'
Returned false 'call.cdr' delay=0.001386
  thread=0x7febb8009760 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['time'] = '1275497962.851'
  param['chan'] = 'analog/1'
  param['cdrid'] = '2'
  param['runid'] = '1275497906'
  param['operation'] = 'update'
  param['direction'] = 'outgoing'
  param['duration'] = '2.003'
  param['billtime'] = '0.003'
  param['ringtime'] = '2.000'
  param['status'] = 'answered'
  param['external'] = '063456568'
  param['cdrwrite'] = 'true'
  param['address'] = 'house/1'
  param['caller'] = '1001'
  param['called'] = '063456568'
  param['billid'] = '1275497906-1'
Sniffed 'call.cdr' time75497964.853853
  thread=0x7febb8009760 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['time'] = '1275497962.847'
  param['chan'] = 'sip/1'
  param['cdrid'] = '1'
  param['runid'] = '1275497906'
  param['operation'] = 'update'
  param['direction'] = 'incoming'
  param['duration'] = '2.007'
  param['billtime'] = '0.003'
  param['ringtime'] = '2.004'
  param['status'] = 'incoming'
  param['external'] = '1001'
  param['cdrwrite'] = 'true'
  param['address'] = '192.168.1.2:5061'
  param['billid'] = '1275497906-1'
  param['caller'] = '1001'
  param['called'] = '063456568'
Returned false 'call.cdr' delay=0.001696
  thread=0x7febb8009760 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['time'] = '1275497962.847'
  param['chan'] = 'sip/1'
  param['cdrid'] = '1'
  param['runid'] = '1275497906'
  param['operation'] = 'update'
  param['direction'] = 'incoming'
  param['duration'] = '2.007'
  param['billtime'] = '0.003'
  param['ringtime'] = '2.004'
  param['status'] = 'incoming'
  param['external'] = '1001'
  param['cdrwrite'] = 'true'
  param['address'] = '192.168.1.2:5061'
  param['billid'] = '1275497906-1'
  param['caller'] = '1001'
  param['called'] = '063456568'
Sniffed 'call.update' time75497964.859008
  thread=0x7febb8009760 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['id'] = 'sip/1'
  param['module'] = 'sip'
  param['status'] = 'answered'
  param['address'] = '192.168.1.2:5061'
  param['targetid'] = 'analog/1'
  param['billid'] = '1275497906-1'
  param['peerid'] = 'analog/1'
  param['lastpeerid'] = 'analog/1'
  param['answered'] = 'true'
  param['callid'] = 'sip/603677A5-834B-D37B-8106-3C1F1A415AA4@1.../1689164942/12548159'
  param['operation'] = 'cdrbuild'
Returned false 'call.update' delay=0.005206
  thread=0x7febb8009760 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['id'] = 'sip/1'
  param['module'] = 'sip'
  param['status'] = 'answered'
  param['address'] = '192.168.1.2:5061'
  param['targetid'] = 'analog/1'
  param['billid'] = '1275497906-1'
  param['peerid'] = 'analog/1'
  param['lastpeerid'] = 'analog/1'
  param['answered'] = 'true'
  param['callid'] = 'sip/603677A5-834B-D37B-8106-3C1F1A415AA4@1.../1689164942/12548159'
  param['operation'] = 'cdrbuild'
Sniffed 'call.cdr' time75497964.864068
  thread=0x7febb8009760 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['time'] = '1275497962.847'
  param['chan'] = 'sip/1'
  param['cdrid'] = '1'
  param['runid'] = '1275497906'
  param['operation'] = 'update'
  param['direction'] = 'incoming'
  param['duration'] = '2.017'
  param['billtime'] = '0.013'
  param['ringtime'] = '2.004'
  param['status'] = 'answered'
  param['external'] = '1001'
  param['cdrwrite'] = 'true'
  param['address'] = '192.168.1.2:5061'
  param['billid'] = '1275497906-1'
  param['caller'] = '1001'
  param['called'] = '063456568'
Returned false 'call.cdr' delay=0.000432
  thread=0x7febb8009760 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['time'] = '1275497962.847'
  param['chan'] = 'sip/1'
  param['cdrid'] = '1'
  param['runid'] = '1275497906'
  param['operation'] = 'update'
  param['direction'] = 'incoming'
  param['duration'] = '2.017'
  param['billtime'] = '0.013'
  param['ringtime'] = '2.004'
  param['status'] = 'answered'
  param['external'] = '1001'
  param['cdrwrite'] = 'true'
  param['address'] = '192.168.1.2:5061'
  param['billid'] = '1275497906-1'
  param['caller'] = '1001'
  param['called'] = '063456568'
Sniffed 'chan.rtp' time75497964.902020
  thread=0x691a70 'YSIP EndPoint'
  data=0x6bbdb0
  retval='(null)'
  param['id'] = 'sip/1'
  param['module'] = 'sip'
  param['callid'] = 'sip/603677A5-834B-D37B-8106-3C1F1A415AA4@1.../1689164942/12548159'
  param['call_direction'] = 'incoming'
  param['call_address'] = '192.168.1.2:5061'
  param['call_status'] = 'answered'
  param['call_billid'] = '1275497906-1'
  param['rtpid'] = 'yrtp/987987334'
  param['media'] = 'audio'
  param['transport'] = 'RTP/AVP'
  param['direction'] = 'bidir'
  param['format'] = 'mulaw'
  param['localip'] = '192.168.1.2'
  param['remoteip'] = '192.168.1.2'
  param['remoteport'] = '8000'
  param['evpayload'] = '101'
  param['sdp_sendrecv'] = ''
Returned true 'chan.rtp' delay=0.000579
  thread=0x691a70 'YSIP EndPoint'
  data=0x6bbdb0
  retval='(null)'
  param['id'] = 'sip/1'
  param['module'] = 'sip'
  param['callid'] = 'sip/603677A5-834B-D37B-8106-3C1F1A415AA4@1.../1689164942/12548159'
  param['call_direction'] = 'incoming'
  param['call_address'] = '192.168.1.2:5061'
  param['call_status'] = 'answered'
  param['call_billid'] = '1275497906-1'
  param['rtpid'] = 'yrtp/987987334'
  param['media'] = 'audio'
  param['transport'] = 'RTP/AVP'
  param['direction'] = 'bidir'
  param['format'] = 'mulaw'
  param['localip'] = '192.168.1.2'
  param['remoteip'] = '192.168.1.2'
  param['remoteport'] = '8000'
  param['evpayload'] = '101'
  param['sdp_sendrecv'] = ''
  param['localport'] = '20452'
Sniffed 'module.update' time75497968.004065
  thread=0x7febb8009760 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['module'] = 'sip'
  param['routed'] = '1'
  param['routing'] = '0'
  param['total'] = '1'
  param['chans'] = '1'
Returned false 'module.update' delay=0.000300
  thread=0x7febb8009760 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['module'] = 'sip'
  param['routed'] = '1'
  param['routing'] = '0'
  param['total'] = '1'
  param['chans'] = '1'
Sniffed 'module.update' time75497968.004175
  thread=0x7febb8009760 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['module'] = 'analog'
  param['routed'] = '0'
  param['routing'] = '0'
  param['total'] = '1'
  param['chans'] = '1'
Returned false 'module.update' delay=0.000271
  thread=0x7febb8009760 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['module'] = 'analog'
  param['routed'] = '0'
  param['routing'] = '0'
  param['total'] = '1'
  param['chans'] = '1'
Sniffed 'chan.rtp' time75497971.222889
  thread=0x691a70 'YSIP EndPoint'
  data=(nil)
  retval='(null)'
  param['rtpid'] = 'yrtp/987987334'
  param['media'] = 'audio'
  param['transport'] = 'RTP/AVP'
  param['terminate'] = 'true'
  param['call_direction'] = 'incoming'
  param['call_address'] = '192.168.1.2:5061'
  param['call_status'] = 'answered'
  param['call_billid'] = '1275497906-1'
Returned true 'chan.rtp' delay=0.000203
  thread=0x691a70 'YSIP EndPoint'
  data=(nil)
  retval='(null)'
  param['rtpid'] = 'yrtp/987987334'
  param['media'] = 'audio'
  param['transport'] = 'RTP/AVP'
  param['terminate'] = 'true'
  param['call_direction'] = 'incoming'
  param['call_address'] = '192.168.1.2:5061'
  param['call_status'] = 'answered'
  param['call_billid'] = '1275497906-1'
  param['stats'] = 'PS96,OSP490,PR&7,ORB720,PL=0'
Sniffed 'chan.hangup' time75497971.223344
  thread=0x7febb8009760 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['id'] = 'sip/1'
  param['module'] = 'sip'
  param['status'] = 'answered'
  param['address'] = '192.168.1.2:5061'
  param['targetid'] = 'analog/1'
  param['billid'] = '1275497906-1'
  param['peerid'] = 'analog/1'
  param['lastpeerid'] = 'analog/1'
  param['answered'] = 'true'
  param['callid'] = 'sip/603677A5-834B-D37B-8106-3C1F1A415AA4@1.../1689164942/12548159'
  param['rtp_stats'] = 'PS96,OSP490,PR&7,ORB720,PL=0'
Returned false 'chan.hangup' delay=0.003280
  thread=0x7febb8009760 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['id'] = 'sip/1'
  param['module'] = 'sip'
  param['status'] = 'answered'
  param['address'] = '192.168.1.2:5061'
  param['targetid'] = 'analog/1'
  param['billid'] = '1275497906-1'
  param['peerid'] = 'analog/1'
  param['lastpeerid'] = 'analog/1'
  param['answered'] = 'true'
  param['callid'] = 'sip/603677A5-834B-D37B-8106-3C1F1A415AA4@1.../1689164942/12548159'
  param['rtp_stats'] = 'PS96,OSP490,PR&7,ORB720,PL=0'
Sniffed 'chan.disconnected' time75497971.223384
  thread=0x7febb8009760 'Engine Worker'
  data=0x6c5610
  retval='(null)'
  param['rtp_stats'] = 'PS96,OSP490,PR&7,ORB720,PL=0'
  param['id'] = 'analog/1'
  param['module'] = 'analog'
  param['status'] = 'answered'
  param['address'] = 'house/1'
  param['targetid'] = 'sip/1'
  param['billid'] = '1275497906-1'
  param['lastpeerid'] = 'sip/1'
  param['answered'] = 'true'
Returned false 'chan.disconnected' delay=0.003475
  thread=0x7febb8009760 'Engine Worker'
  data=0x6c5610
  retval='(null)'
  param['rtp_stats'] = 'PS96,OSP490,PR&7,ORB720,PL=0'
  param['id'] = 'analog/1'
  param['module'] = 'analog'
  param['status'] = 'answered'
  param['address'] = 'house/1'
  param['targetid'] = 'sip/1'
  param['billid'] = '1275497906-1'
  param['lastpeerid'] = 'sip/1'
  param['answered'] = 'true'
Sniffed 'chan.hangup' time75497971.223409
  thread=0x7febb8009760 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['id'] = 'analog/1'
  param['module'] = 'analog'
  param['status'] = 'disconnected'
  param['reason'] = 'normal'
Returned false 'chan.hangup' delay=0.003643
  thread=0x7febb8009760 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['id'] = 'analog/1'
  param['module'] = 'analog'
  param['status'] = 'disconnected'
  param['reason'] = 'normal'
Sniffed 'call.cdr' time75497971.226587
  thread=0x7febb8009760 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['time'] = '1275497962.847'
  param['chan'] = 'sip/1'
  param['cdrid'] = '1'
  param['runid'] = '1275497906'
  param['operation'] = 'finalize'
  param['direction'] = 'incoming'
  param['duration'] = '8.376'
  param['billtime'] = '6.372'
  param['ringtime'] = '2.004'
  param['status'] = 'answered'
  param['external'] = '1001'
  param['cdrwrite'] = 'true'
  param['address'] = '192.168.1.2:5061'
  param['billid'] = '1275497906-1'
  param['caller'] = '1001'
  param['called'] = '063456568'
Returned false 'call.cdr' delay=0.000761
  thread=0x7febb8009760 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['time'] = '1275497962.847'
  param['chan'] = 'sip/1'
  param['cdrid'] = '1'
  param['runid'] = '1275497906'
  param['operation'] = 'finalize'
  param['direction'] = 'incoming'
  param['duration'] = '8.376'
  param['billtime'] = '6.372'
  param['ringtime'] = '2.004'
  param['status'] = 'answered'
  param['external'] = '1001'
  param['cdrwrite'] = 'true'
  param['address'] = '192.168.1.2:5061'
  param['billid'] = '1275497906-1'
  param['caller'] = '1001'
  param['called'] = '063456568'
Sniffed 'call.cdr' time75497971.227026
  thread=0x7febb8009760 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['time'] = '1275497962.851'
  param['chan'] = 'analog/1'
  param['cdrid'] = '2'
  param['runid'] = '1275497906'
  param['operation'] = 'finalize'
  param['direction'] = 'outgoing'
  param['duration'] = '8.372'
  param['billtime'] = '6.372'
  param['ringtime'] = '2.000'
  param['status'] = 'disconnected'
  param['external'] = '063456568'
  param['cdrwrite'] = 'true'
  param['address'] = 'house/1'
  param['caller'] = '1001'
  param['called'] = '063456568'
  param['billid'] = '1275497906-1'
  param['reason'] = 'normal'
Returned false 'call.cdr' delay=0.000664
  thread=0x7febb8009760 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['time'] = '1275497962.851'
  param['chan'] = 'analog/1'
  param['cdrid'] = '2'
  param['runid'] = '1275497906'
  param['operation'] = 'finalize'
  param['direction'] = 'outgoing'
  param['duration'] = '8.372'
  param['billtime'] = '6.372'
  param['ringtime'] = '2.000'
  param['status'] = 'disconnected'
  param['external'] = '063456568'
  param['cdrwrite'] = 'true'
  param['address'] = 'house/1'
  param['caller'] = '1001'
  param['called'] = '063456568'
  param['billid'] = '1275497906-1'
  param['reason'] = 'normal'
Sniffed 'module.update' time75497977.002393
  thread=0x7febb8009760 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['module'] = 'sip'
  param['routed'] = '1'
  param['routing'] = '0'
  param['total'] = '1'
  param['chans'] = '0'
Returned false 'module.update' delay=0.000333
  thread=0x7febb8009760 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['module'] = 'sip'
  param['routed'] = '1'
  param['routing'] = '0'
  param['total'] = '1'
  param['chans'] = '0'
Sniffed 'module.update' time75497977.002510
  thread=0x7febb8009760 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['module'] = 'analog'
  param['routed'] = '0'
  param['routing'] = '0'
  param['total'] = '1'
  param['chans'] = '0'
Returned false 'module.update' delay=0.000547
  thread=0x7febb8009760 'Engine Worker'
  data=(nil)
  retval='(null)'
  param['module'] = 'analog'
  param['routed'] = '0'
  param['routing'] = '0'
  param['total'] = '1'
  param['chans'] = '0'
Sniffed 'user.auth' time75498166.383164
  thread=0x6af5c0 'YSIP Register'
  data=(nil)
  retval='(null)'
  param['protocol'] = 'sip'
  param['method'] = 'REGISTER'
  param['uri'] = 'sip:asterisk'
  param['ip_host'] = '192.168.1.2'
  param['ip_port'] = '5061'
  param['address'] = '192.168.1.2:5061'
  param['newcall'] = 'false'
Returned false 'user.auth' delay=0.000485
  thread=0x6af5c0 'YSIP Register'
  data=(nil)
  retval='(null)'
  param['protocol'] = 'sip'
  param['method'] = 'REGISTER'
  param['uri'] = 'sip:asterisk'
  param['ip_host'] = '192.168.1.2'
  param['ip_port'] = '5061'
  param['address'] = '192.168.1.2:5061'
  param['newcall'] = 'false'
Sniffed 'user.auth' time75498166.404277
  thread=0x6c17f0 'YSIP Register'
  data=(nil)
  retval='(null)'
  param['protocol'] = 'sip'
  param['username'] = '1001'
  param['realm'] = 'asterisk'
  param['nonce'] = '6e12f65ce8f81518ae0083cdd88289d6.1275498166'
  param['response'] = 'e807792c38c2c3e2c28c9e0dcf7fac51'
  param['method'] = 'REGISTER'
  param['uri'] = 'sip:asterisk'
  param['ip_host'] = '192.168.1.2'
  param['ip_port'] = '5061'
  param['address'] = '192.168.1.2:5061'
  param['newcall'] = 'false'
Returned true 'user.auth' delay=0.000421
  thread=0x6c17f0 'YSIP Register'
  data=(nil)
  retval='1001'
  param['protocol'] = 'sip'
  param['username'] = '1001'
  param['realm'] = 'asterisk'
  param['nonce'] = '6e12f65ce8f81518ae0083cdd88289d6.1275498166'
  param['response'] = 'e807792c38c2c3e2c28c9e0dcf7fac51'
  param['method'] = 'REGISTER'
  param['uri'] = 'sip:asterisk'
  param['ip_host'] = '192.168.1.2'
  param['ip_port'] = '5061'
  param['address'] = '192.168.1.2:5061'
  param['newcall'] = 'false'
Sniffed 'user.unregister' time75498166.404249
  thread=0x6c17f0 'YSIP Register'
  data=(nil)
  retval='(null)'
  param['sip_uri'] = 'sip:asterisk'
  param['sip_callid'] = '1E4B26C0B8F7F8EF401B670D0AB18A22@asterisk'
  param['username'] = '1001'
  param['realm'] = 'asterisk'
  param['newcall'] = 'false'
  param['number'] = '1001'
  param['driver'] = 'sip'
  param['data'] = 'sip/sip:1001@1...:5061'
  param['ip_host'] = '192.168.1.2'
  param['ip_port'] = '5061'
  param['expires'] = '0'
  param['device'] = 'X-Lite release 1105d'
Returned true 'user.unregister' delay=0.000942
  thread=0x6c17f0 'YSIP Register'
  data=(nil)
  retval='(null)'
  param['sip_uri'] = 'sip:asterisk'
  param['sip_callid'] = '1E4B26C0B8F7F8EF401B670D0AB18A22@asterisk'
  param['username'] = '1001'
  param['realm'] = 'asterisk'
  param['newcall'] = 'false'
  param['number'] = '1001'
  param['driver'] = 'sip'
  param['data'] = 'sip/sip:1001@1...:5061'
  param['ip_host'] = '192.168.1.2'
  param['ip_port'] = '5061'
  param['expires'] = '0'
  param['device'] = 'X-Lite release 1105d'
Yate engine is shutting down with code 0
Sniffed 'engine.halt' time75498170.025789
  thread=(nil) '(null)'
  data=(nil)
  retval='(null)'
 Worker thread terminated [0x6ac090]
Returned false 'engine.halt' delay=0.055421
  thread=(nil) '(null)'
  data=(nil)
  retval='(null)'
 ThreadPrivate 'YSIP EndPoint' terminating pthread 0x691b30 [0x691b20]
Unloading module Jingle Features
Unloading module MGCP-GW
Unloading module MRCP
Unloading module Register for database
Unloading module Heartbeat
Unloading module Signalling Channel
Unloading module Queues
Unloading module Call Parking
Unloading module CallCounters
Unloading module PBX for database
Unloading module Late Router
Unloading module SIP Features
Unloading module Queues Notify
Unloaded module Radius client
Unloading module CdrBuild
Unloading module YJingle
Unloading module YIAX
Unloading module MOH
Unloading module Conference
Unloading module YRTP
Unloading module DumbChannel
Unloading module ToneGen
Unloading module Analyzer
Unloading module ToneDetector
Unloading module iLBC with 0 codecs still in use
Unloading module Call Forker
Unloading module YSTUN
Unloading module PBX
Unloading module Call Generator, clearing 0 calls
Unloading module RManager
Unloading module ExtModule
Unloading module OpenSSL
Unloading module File Transfer
Unloading module CdrFile
Unloading module MUX
Unloading module Zaptel
Unloading module MGCP-CA
Unloading module Analog Channel
Unloading module Cisco SM
Unloading module YSOCKS
Unloading module SIP Channel
Unloading module Clustering
Unloading module Analog Detector
Yate (9091) is stopping Wed Jun  2 19:02:50 2010