Dismiss Notice
We would like to remind you that we’re updating our login process for all 3CX forums whereby you will be able to login with the same credentials you use for the Partner or Customer Portal. Click here to read more.

V3.1 hangs up on me when I try to record a greeting

Discussion in '3CX Phone System - General' started by matthias, Nov 26, 2007.

Thread Status:
Not open for further replies.
  1. matthias

    Joined:
    Nov 26, 2007
    Messages:
    4
    Likes Received:
    0
    Just starting out with 3cx .
    I am running "I test mode on a VM"
    Voice Quality is good but every time I get to the recording prompt 3cx drops the call.
    Any ideas?
     
    Stop hovering to collapse... Click to collapse... Hover to expand... Click to expand...
  2. iang

    Joined:
    Nov 18, 2007
    Messages:
    13
    Likes Received:
    0
    Hi Matthias

    Can you post any logs from 3cx? What softphone or hardphone are you using to call the 3cx's voicemail?
     
    Stop hovering to collapse... Click to collapse... Hover to expand... Click to expand...
  3. matthias

    Joined:
    Nov 26, 2007
    Messages:
    4
    Likes Received:
    0
    x-lite , 3cx softphone and Linksys 942 doe not seem to make a difference
    I'll look for the logs and upload....
     
    Stop hovering to collapse... Click to collapse... Hover to expand... Click to expand...
  4. matthias

    Joined:
    Nov 26, 2007
    Messages:
    4
    Likes Received:
    0
    I assuem teh not found message is a hint ?

    14:57:58.235|MSEndPoint.cpp(733)|Trace5||??:DTMF detected on EP:00000020@payload #101 seqNo=8976 timestamp=3082180
    14:57:58.255|MSEndPoint.cpp(733)|Trace5||??:DTMF detected on EP:00000020@payload #101 seqNo=8977 timestamp=3082180
    14:57:58.275|MSEndPoint.cpp(733)|Trace5||??:DTMF detected on EP:00000020@payload #101 seqNo=8978 timestamp=3082180
    14:57:58.295|MSEndPoint.cpp(733)|Trace5||??:DTMF detected on EP:00000020@payload #101 seqNo=8979 timestamp=3082180
    14:57:58.315|MSEndPoint.cpp(733)|Trace5||??:DTMF detected on EP:00000020@payload #101 seqNo=8980 timestamp=3082180
    14:57:58.315|MSEndPoint.cpp(733)|Trace5||??:DTMF detected on EP:00000020@payload #101 seqNo=8980 timestamp=3082180
    14:57:58.315|MSEndPoint.cpp(733)|Trace5||??:DTMF detected on EP:00000020@payload #101 seqNo=8980 timestamp=3082180
    14:57:58.365|MediaServer.cpp(604)|Trace5||??:EP 00000020@. Stop to play file C:\Program Files\3CX PhoneSystem\Bin\..\Data\Ivr\Prompts\Sets\8210986B-9412-497f-AD77-3A554F4A9BDB\toexit_presspnd.wav
    14:57:58.446|MediaServer.cpp(607)|Trace5||??:EP 00000020@. RTP stream is stopped
    14:57:58.446|MediaServer.cpp(509)|Trace5||??:EP 00000020@. RTP stream is resumed
    14:57:58.446|MediaServer.cpp(604)|Trace5||??:EP 00000020@. Stop to play file C:\Program Files\3CX PhoneSystem\Bin\..\Data\Ivr\Prompts\Sets\8210986B-9412-497f-AD77-3A554F4A9BDB\toexit_presspnd.wav
    14:57:58.446|MediaServer.cpp(607)|Trace5||??:EP 00000020@. RTP stream is stopped
    14:57:58.446|MediaServer.cpp(509)|Trace5||??:EP 00000020@. RTP stream is resumed
    14:57:58.486|MediaServer.cpp(643)|Trace5||??:EP 00000020@.Start to play file C:\Program Files\3CX PhoneSystem\Bin\..\Data\Ivr\Prompts\Sets\8210986B-9412-497f-AD77-3A554F4A9BDB\OPTMNU.mp3
    14:58:00.639|MSEndPoint.cpp(566)|Trace5||??:
    RTCP packet len=176:
    V=2
    P=0
    RC=1
    type=200
    length=12
    (length+1)*4=52
    sender Report:
    SSRC=715984741
    NTP=3405027179.625
    sender RTP timestamp=3102340
    Sender packets count=1070
    Sender octet sent=172808

    14:58:03.623|MSEndPoint.cpp(566)|Trace5||??:
    RTCP packet len=176:
    V=2
    P=0
    RC=1
    type=200
    length=12
    (length+1)*4=52
    sender Report:
    SSRC=715984741
    NTP=3405027182.686
    sender RTP timestamp=3126820
    Sender packets count=1223
    Sender octet sent=199124

    14:58:06.988|MSEndPoint.cpp(566)|Trace5||??:
    RTCP packet len=176:
    V=2
    P=0
    RC=1
    type=200
    length=12
    (length+1)*4=52
    sender Report:
    SSRC=715984741
    NTP=3405027185.750
    sender RTP timestamp=3151300
    Sender packets count=1376
    Sender octet sent=225440

    14:58:09.942|MSEndPoint.cpp(566)|Trace5||??:
    RTCP packet len=176:
    V=2
    P=0
    RC=1
    type=200
    length=12
    (length+1)*4=52
    sender Report:
    SSRC=715984741
    NTP=3405027188.811
    sender RTP timestamp=3175780
    Sender packets count=1529
    Sender octet sent=251756

    14:58:10.483|MSEndPoint.cpp(733)|Trace5||??:DTMF detected on EP:00000020@payload #101 seqNo=9585 timestamp=3180260
    14:58:10.483|MSEndPoint.cpp(733)|Trace5||??:DTMF detected on EP:00000020@payload #101 seqNo=9585 timestamp=3180260
    14:58:10.483|MSEndPoint.cpp(733)|Trace5||??:DTMF detected on EP:00000020@payload #101 seqNo=9585 timestamp=3180260
    14:58:10.493|MSEndPoint.cpp(733)|Trace5||??:DTMF detected on EP:00000020@payload #101 seqNo=9586 timestamp=3180260
    14:58:10.503|MSEndPoint.cpp(733)|Trace5||??:DTMF detected on EP:00000020@payload #101 seqNo=9587 timestamp=3180260
    14:58:10.523|MSEndPoint.cpp(733)|Trace5||??:DTMF detected on EP:00000020@payload #101 seqNo=9588 timestamp=3180260
    14:58:10.543|MSEndPoint.cpp(733)|Trace5||??:DTMF detected on EP:00000020@payload #101 seqNo=9589 timestamp=3180260
    14:58:10.563|MSEndPoint.cpp(733)|Trace5||??:DTMF detected on EP:00000020@payload #101 seqNo=9590 timestamp=3180260
    14:58:10.563|MSEndPoint.cpp(733)|Trace5||??:DTMF detected on EP:00000020@payload #101 seqNo=9591 timestamp=3180260
    14:58:10.593|MSEndPoint.cpp(733)|Trace5||??:DTMF detected on EP:00000020@payload #101 seqNo=9592 timestamp=3180260
    14:58:10.593|MSEndPoint.cpp(733)|Trace5||??:DTMF detected on EP:00000020@payload #101 seqNo=9592 timestamp=3180260
    14:58:10.593|MSEndPoint.cpp(733)|Trace5||??:DTMF detected on EP:00000020@payload #101 seqNo=9592 timestamp=3180260
    14:58:10.613|MediaServer.cpp(604)|Trace5||??:EP 00000020@. Stop to play file C:\Program Files\3CX PhoneSystem\Bin\..\Data\Ivr\Prompts\Sets\8210986B-9412-497f-AD77-3A554F4A9BDB\OPTMNU.mp3
    14:58:10.623|MediaServer.cpp(607)|Trace5||??:EP 00000020@. RTP stream is stopped
    14:58:10.623|MediaServer.cpp(509)|Trace5||??:EP 00000020@. RTP stream is resumed
    14:58:10.903|MediaServer.cpp(604)|Trace5||??:EP 00000020@. Stop to play file C:\Program Files\3CX PhoneSystem\Bin\..\Data\Ivr\Prompts\Sets\8210986B-9412-497f-AD77-3A554F4A9BDB\OPTMNU.mp3
    14:58:10.903|MediaServer.cpp(607)|Trace5||??:EP 00000020@. RTP stream is stopped
    14:58:10.903|MediaServer.cpp(509)|Trace5||??:EP 00000020@. RTP stream is resumed
    14:58:11.054|MediaServer.cpp(643)|Trace5||??:EP 00000020@.Start to play file C:\Program Files\3CX PhoneSystem\Bin\..\Data\Ivr\Prompts\Sets\8210986B-9412-497f-AD77-3A554F4A9BDB\record_your.wav
    14:58:11.625|MSCallConf.cpp(353)|Trace5||??:played File on 00000020@ closed
    14:58:11.625|MediaServer.cpp(604)|Trace5||??:EP 00000020@. Stop to play file C:\Program Files\3CX PhoneSystem\Bin\..\Data\Ivr\Prompts\Sets\8210986B-9412-497f-AD77-3A554F4A9BDB\record_your.wav
    14:58:11.625|MediaServer.cpp(607)|Trace5||??:EP 00000020@. RTP stream is stopped
    14:58:11.635|MediaServer.cpp(643)|Trace5||??:EP 00000020@.Start to play file C:\Program Files\3CX PhoneSystem\Bin\..\Data\Ivr\Prompts\Sets\8210986B-9412-497f-AD77-3A554F4A9BDB\greeting_message.wav
    14:58:11.635|MediaServer.cpp(854)|Trace5||??:EndPoint 00000020@ removed from call 24
    14:58:11.695|MSEndPoint.cpp(566)|Trace5||??:
    RTCP packet len=160:
    V=2
    P=0
    RC=0
    type=200
    length=6
    (length+1)*4=28
    sender Report:
    SSRC=715984741
    NTP=3405027190.608
    sender RTP timestamp=3190180
    Sender packets count=1619
    Sender octet sent=265988

    14:58:12.075|MediaServer.cpp(714)|Trace5||??:EP00000020@ start to record file C:\Program Files\3CX PhoneSystem\Bin\..\Data\Ivr\Temp\ivr\RWVafaa5f.tmp
    14:58:12.075|MediaServer.cpp(678)|Trace5||??:EP 00000020@. Stop to record file C:\Program Files\3CX PhoneSystem\Bin\..\Data\Ivr\Temp\ivr\RWVafaa5f.tmp
    14:58:12.105|MediaServer.cpp(821)|Trace5||??:EP 00000020@ not found in call 24
    14:58:12.105|MediaServer.cpp(882)|Trace5||??:references to call 24 were removed
    14:58:12.105|MSCallConf.cpp(31)|Trace5||??:Call: 24 destroyed
    14:58:12.105|MediaServer.cpp(579)|Trace5||??:references to EndPoint 00000020@ were removed
    14:58:12.105|RTPReceiver.cpp(141)|Trace5||??:Endpoint for socket 800 is not found!
    18:21:37.325|MSEndPoint.cpp(331)|Trace5||??:xptemplate addr(0)=192.168.0.200
    18:21:37.325|MSEndPoint.cpp(344)|Trace5||??:EP 00000021@: choose IP address - 192.168.0.200
    18:21:37.335|MediaServer.cpp(223)|Trace5||??:EndPoint created:
    EndPoint: ID=00000021@(LOCAL)
    Status: MSEP_LOCAL
    RTP:192.168.0.200:7064
    RTCP:192.168.0.200:7065
    STUN RTP:0.0.0.0:0
    STUN RTCP:0.0.0.0:0
    Coder:
    NOT SET
    101:telephony-event
    Party ptime:20
    Party RTP:0.0.0.0:0
    Party RTCP:0.0.0.0:0
    Decoders:
    <empty>

    18:21:37.376|MediaServer.cpp(772)|Trace5||??:EP 00000021@ joined to call 25
    18:21:37.376|MediaServer.cpp(781)|Trace5||??:starting send on new call 25
    18:21:37.376|MediaServer.cpp(470)|Trace5||??:EP 00000021@. RTP stream is stopped
    18:21:37.396|MediaServer.cpp(854)|Trace5||??:EndPoint 00000021@ removed from call 25
    18:21:37.396|MediaServer.cpp(821)|Trace5||??:EP 00000021@ not found in call 25
    18:21:37.396|MediaServer.cpp(882)|Trace5||??:references to call 25 were removed
    18:21:37.396|MSCallConf.cpp(31)|Trace5||??:Call: 25 destroyed
    18:21:37.396|MediaServer.cpp(579)|Trace5||??:references to EndPoint 00000021@ were removed
    18:21:37.396|RTPReceiver.cpp(141)|Trace5||??:Endpoint for socket 800 is not found!
    18:21:48.552|MSEndPoint.cpp(331)|Trace5||??:xptemplate addr(0)=192.168.0.200
    18:21:48.552|MSEndPoint.cpp(344)|Trace5||??:EP 00000022@: choose IP address - 192.168.0.200
    18:21:48.562|MediaServer.cpp(223)|Trace5||??:EndPoint created:
    EndPoint: ID=00000022@(LOCAL)
    Status: MSEP_LOCAL
    RTP:192.168.0.200:7066
    RTCP:192.168.0.200:7067
    STUN RTP:0.0.0.0:0
    STUN RTCP:0.0.0.0:0
    Coder:
    NOT SET
    101:telephony-event
    Party ptime:20
    Party RTP:0.0.0.0:0
    Party RTCP:0.0.0.0:0
    Decoders:
    <empty>

    18:21:48.562|MediaServer.cpp(772)|Trace5||??:EP 00000022@ joined to call 26
    18:21:48.562|MediaServer.cpp(781)|Trace5||??:starting send on new call 26
    18:21:48.562|MediaServer.cpp(470)|Trace5||??:EP 00000022@. RTP stream is stopped
    18:21:48.592|MediaServer.cpp(854)|Trace5||??:EndPoint 00000022@ removed from call 26
    18:21:48.592|MediaServer.cpp(821)|Trace5||??:EP 00000022@ not found in call 26
    18:21:48.592|MediaServer.cpp(882)|Trace5||??:references to call 26 were removed
    18:21:48.592|MSCallConf.cpp(31)|Trace5||??:Call: 26 destroyed
    18:21:48.592|MediaServer.cpp(579)|Trace5||??:references to EndPoint 00000022@ were removed
    18:21:48.592|RTPReceiver.cpp(141)|Trace5||??:Endpoint for socket 800 is not found!
    18:21:58.546|MSEndPoint.cpp(331)|Trace5||??:xptemplate addr(0)=192.168.0.200
    18:21:58.546|MSEndPoint.cpp(344)|Trace5||??:EP 00000023@: choose IP address - 192.168.0.200
    18:21:58.556|MediaServer.cpp(223)|Trace5||??:EndPoint created:
    EndPoint: ID=00000023@(LOCAL)
    Status: MSEP_LOCAL
    RTP:192.168.0.200:7068
    RTCP:192.168.0.200:7069
    STUN RTP:0.0.0.0:0
    STUN RTCP:0.0.0.0:0
    Coder:
    NOT SET
    101:telephony-event
    Party ptime:20
    Party RTP:0.0.0.0:0
    Party RTCP:0.0.0.0:0
    Decoders:
    <empty>

    18:21:58.576|MediaServer.cpp(772)|Trace5||??:EP 00000023@ joined to call 27
    18:21:58.576|MediaServer.cpp(781)|Trace5||??:starting send on new call 27
    18:21:58.586|MediaServer.cpp(470)|Trace5||??:EP 00000023@. RTP stream is stopped
    18:21:58.586|MSEndPoint.cpp(331)|Trace5||??:xptemplate addr(0)=192.168.0.200
    18:21:58.586|MSEndPoint.cpp(344)|Trace5||??:EP 00000024@: choose IP address - 192.168.0.200
    18:21:58.586|MediaServer.cpp(223)|Trace5||??:EndPoint created:
    EndPoint: ID=00000024@(LOCAL)
    Status: MSEP_LOCAL
    RTP:192.168.0.200:7070
    RTCP:192.168.0.200:7071
    STUN RTP:0.0.0.0:0
    STUN RTCP:0.0.0.0:0
    Coder:
    NOT SET
    101:telephony-event
    Party ptime:20
    Party RTP:0.0.0.0:0
    Party RTCP:0.0.0.0:0
    Decoders:
    <empty>

    18:21:58.596|MediaServer.cpp(772)|Trace5||??:EP 00000024@ joined to call 27
    18:21:58.596|MediaServer.cpp(470)|Trace5||??:EP 00000024@. RTP stream is stopped
    18:21:58.596|MediaServer.cpp(412)|Trace5||??:party changed on Endpoint
    EndPoint: ID=00000023@(LOCAL)
    Status: MSEP_LOCAL
    RTP:192.168.0.200:7068
    RTCP:192.168.0.200:7069
    STUN RTP:0.0.0.0:0
    STUN RTCP:0.0.0.0:0
    Coder:
    0:pCMU
    101:telephony-event
    Party ptime:30
    Party RTP:192.168.0.2:16450
    Party RTCP:192.168.0.2:16451
    Decoders:
    0:pCMU
    8:pCMA
    101:telephony-event

    18:22:06.487|MediaServer.cpp(412)|Trace5||??:party changed on Endpoint
    EndPoint: ID=00000024@(LOCAL)
    Status: MSEP_LOCAL
    RTP:192.168.0.200:7070
    RTCP:192.168.0.200:7071
    STUN RTP:0.0.0.0:0
    STUN RTCP:0.0.0.0:0
    Coder:
    0:pCMU
    101:telephony-event
    Party ptime:20
    Party RTP:192.168.0.225:55046
    Party RTCP:192.168.0.225:55047
    Decoders:
    0:pCMU
    3:GSM
    8:pCMA
    13:CN
    99:SPEEX
    110:iLBC
    101:telephony-event

    18:22:38.553|MediaServer.cpp(854)|Trace5||??:EndPoint 00000023@ removed from call 27
    18:22:38.553|MediaServer.cpp(854)|Trace5||??:EndPoint 00000024@ removed from call 27
    18:22:38.553|MediaServer.cpp(821)|Trace5||??:EP 00000024@ not found in call 27
    18:22:38.553|MediaServer.cpp(579)|Trace5||??:references to EndPoint 00000024@ were removed
    18:22:38.553|RTPReceiver.cpp(141)|Trace5||??:Endpoint for socket 816 is not found!
    18:22:38.563|MediaServer.cpp(821)|Trace5||??:EP 00000023@ not found in call 27
    18:22:38.563|MediaServer.cpp(882)|Trace5||??:references to call 27 were removed
    18:22:38.563|MSCallConf.cpp(31)|Trace5||??:Call: 27 destroyed
    18:22:38.563|MediaServer.cpp(579)|Trace5||??:references to EndPoint 00000023@ were removed
    18:22:38.563|RTPReceiver.cpp(141)|Trace5||??:Endpoint for socket 800 is not found!
     
    Stop hovering to collapse... Click to collapse... Hover to expand... Click to expand...
  5. matthias

    Joined:
    Nov 26, 2007
    Messages:
    4
    Likes Received:
    0
    3xdPhone system.trace

    09:02:25.858|TuSelector.cxx(70)|Trace5|Resip|>>:Stats message
    09:02:27.140|.\CAHandler.cpp(252)|Trace5||CAHandler::setStatus:[CM102005] CA request setStatus(dn=1112, status=0)
    09:02:27.140|.\CAHandler.cpp(252)|Trace5||CAHandler::setStatus:[CM102005] CA request setStatus(dn=2000, status=0)
    09:02:27.150|.\CAHandler.cpp(252)|Trace5||CAHandler::setStatus:[CM102005] CA request setStatus(dn=2001, status=0)
    09:03:25.904|TuSelector.cxx(70)|Trace5|Resip|>>:Stats message
    09:04:25.860|TuSelector.cxx(70)|Trace5|Resip|>>:Stats message
    09:05:25.817|TuSelector.cxx(70)|Trace5|Resip|>>:Stats message
    09:06:25.863|TuSelector.cxx(70)|Trace5|Resip|>>:Stats message
    09:07:25.819|TuSelector.cxx(70)|Trace5|Resip|>>:Stats message
    09:08:25.886|TuSelector.cxx(70)|Trace5|Resip|>>:Stats message
    09:09:03.490|ServerAuthManager.cxx(307)|Trace5|Resip|>>:Requesting credential for 2000 @ 3CXPhoneSystem
    09:09:03.500|Helper.cxx(865)|Trace5|Resip|>>: username=2000 password=2000 realm=3CXPhoneSystem method=REGISTER uri=sip:192.168.0.200 nonce=12840501147:04a231d51cf416880d2fc787057ad705
    09:09:03.500|ServerAuthManager.cxx(47)|Trace5|Resip|>>:ServerAuth requested credentials SipReq: REGISTER 192.168.0.200 tid=8971cb111e6e790a cseq=REGISTER contact=2000@192.168.0.99:45568 / 26 from(wire)
    09:09:03.500|ServerAuthManager.cxx(125)|Trace5|Resip|>>:Checking for auth result in realm=3CXPhoneSystem A1=
    09:09:03.500|ServerAuthManager.cxx(210)|Trace5|Resip|>>:Authorized request for 3CXPhoneSystem
    09:09:03.500|.\Authorization.cpp(294)|Trace5|Authorization|AuthMgr::eek:nAuthSuccess:Caller "3cx at Home"<sip:2000@192.168.0.200>;tag=2455e77d has been authenticated successfully
    09:09:03.500|DialogUsageManager.cxx(1190)|Trace5|Resip|>>:Got: SipReq: REGISTER 192.168.0.200 tid=8971cb111e6e790a cseq=REGISTER contact=2000@192.168.0.99:45568 / 26 from(wire)
    09:09:03.500|ServerRegistration.cxx(214)|Trace5|Resip|>>:Adding sip:2000@192.168.0.200 -> <sip:2000@192.168.0.99:45568;rinstance=a153743e3540bf1f>
    09:09:03.590|.\Registrar.cpp(669)|Trace5|Registrar|RegistrarDB::updateContact:Updated registrar contact: aor=sip:2000@192.168.0.200; contact=sip:2000@192.168.0.99:45568;rinstance=a153743e3540bf1f;expires in 3600 sec.
    09:09:03.590|ServerRegistration.cxx(42)|Trace5|Resip|>>:accepted a registration sip:2000@192.168.0.200
    09:09:03.590|.\Registrar.cpp(98)|Trace5||VoiceBoxForceNotify::execute:Forced out of dialog NOTIFY for DN 2000
    09:09:25.862|TuSelector.cxx(70)|Trace5|Resip|>>:Stats message
    09:09:27.214|ServerAuthManager.cxx(307)|Trace5|Resip|>>:Requesting credential for 2000 @ 3CXPhoneSystem
    09:09:27.214|Helper.cxx(865)|Trace5|Resip|>>: username=2000 password=2000 realm=3CXPhoneSystem method=REGISTER uri=sip:192.168.0.200 nonce=12840501147:04a231d51cf416880d2fc787057ad705
    09:09:27.214|ServerAuthManager.cxx(47)|Trace5|Resip|>>:ServerAuth requested credentials SipReq: REGISTER 192.168.0.200 tid=4b686b7670041304 cseq=REGISTER contact=2000@192.168.0.99:45568 / 27 from(wire)
    09:09:27.214|ServerAuthManager.cxx(125)|Trace5|Resip|>>:Checking for auth result in realm=3CXPhoneSystem A1=
    09:09:27.214|ServerAuthManager.cxx(210)|Trace5|Resip|>>:Authorized request for 3CXPhoneSystem
    09:09:27.214|.\Authorization.cpp(294)|Trace5|Authorization|AuthMgr::eek:nAuthSuccess:Caller "3cx at Home"<sip:2000@192.168.0.200>;tag=2455e77d has been authenticated successfully
    09:09:27.214|DialogUsageManager.cxx(1190)|Trace5|Resip|>>:Got: SipReq: REGISTER 192.168.0.200 tid=4b686b7670041304 cseq=REGISTER contact=2000@192.168.0.99:45568 / 27 from(wire)
    09:09:27.224|ServerRegistration.cxx(214)|Trace5|Resip|>>:Adding sip:2000@192.168.0.200 -> <sip:2000@192.168.0.99:45568;rinstance=a153743e3540bf1f>
    09:09:27.224|.\Registrar.cpp(669)|Trace5|Registrar|RegistrarDB::updateContact:Updated registrar contact: aor=sip:2000@192.168.0.200; contact=sip:2000@192.168.0.99:45568;rinstance=a153743e3540bf1f;expires in 3600 sec.
    09:09:27.224|ServerRegistration.cxx(42)|Trace5|Resip|>>:accepted a registration sip:2000@192.168.0.200
    09:09:27.234|.\Registrar.cpp(98)|Trace5||VoiceBoxForceNotify::execute:Forced out of dialog NOTIFY for DN 2000
    09:10:25.868|TuSelector.cxx(70)|Trace5|Resip|>>:Stats message
    09:10:30.365|ServerAuthManager.cxx(307)|Trace5|Resip|>>:Requesting credential for 2000 @ 3CXPhoneSystem
    09:10:30.365|Helper.cxx(865)|Trace5|Resip|>>: username=2000 password=2000 realm=3CXPhoneSystem method=REGISTER uri=sip:192.168.0.200 nonce=12840501147:04a231d51cf416880d2fc787057ad705
    09:10:30.365|ServerAuthManager.cxx(47)|Trace5|Resip|>>:ServerAuth requested credentials SipReq: REGISTER 192.168.0.200 tid=8903dd21f748a036 cseq=REGISTER contact=2000@192.168.0.99:45568 / 28 from(wire)
    09:10:30.365|ServerAuthManager.cxx(125)|Trace5|Resip|>>:Checking for auth result in realm=3CXPhoneSystem A1=
    09:10:30.365|ServerAuthManager.cxx(210)|Trace5|Resip|>>:Authorized request for 3CXPhoneSystem
    09:10:30.365|.\Authorization.cpp(294)|Trace5|Authorization|AuthMgr::eek:nAuthSuccess:Caller "3cx at Home"<sip:2000@192.168.0.200>;tag=2455e77d has been authenticated successfully
    09:10:30.365|DialogUsageManager.cxx(1190)|Trace5|Resip|>>:Got: SipReq: REGISTER 192.168.0.200 tid=8903dd21f748a036 cseq=REGISTER contact=2000@192.168.0.99:45568 / 28 from(wire)
    09:10:30.365|ServerRegistration.cxx(214)|Trace5|Resip|>>:Adding sip:2000@192.168.0.200 -> <sip:2000@192.168.0.99:45568;rinstance=a153743e3540bf1f>
    09:10:30.375|.\Registrar.cpp(669)|Trace5|Registrar|RegistrarDB::updateContact:Updated registrar contact: aor=sip:2000@192.168.0.200; contact=sip:2000@192.168.0.99:45568;rinstance=a153743e3540bf1f;expires in 3600 sec.
    09:10:30.375|ServerRegistration.cxx(42)|Trace5|Resip|>>:accepted a registration sip:2000@192.168.0.200
    09:10:30.375|.\Registrar.cpp(98)|Trace5||VoiceBoxForceNotify::execute:Forced out of dialog NOTIFY for DN 2000
    09:11:05.245|ServerAuthManager.cxx(307)|Trace5|Resip|>>:Requesting credential for 2000 @ 3CXPhoneSystem
    09:11:05.255|Helper.cxx(865)|Trace5|Resip|>>: username=2000 password=2000 realm=3CXPhoneSystem method=REGISTER uri=sip:192.168.0.200 nonce=12840501147:04a231d51cf416880d2fc787057ad705
    09:11:05.255|ServerAuthManager.cxx(47)|Trace5|Resip|>>:ServerAuth requested credentials SipReq: REGISTER 192.168.0.200 tid=ae475f18ad3aea32 cseq=REGISTER contact=2000@192.168.0.99:45568 / 29 from(wire)
    09:11:05.255|ServerAuthManager.cxx(125)|Trace5|Resip|>>:Checking for auth result in realm=3CXPhoneSystem A1=
    09:11:05.255|ServerAuthManager.cxx(210)|Trace5|Resip|>>:Authorized request for 3CXPhoneSystem
    09:11:05.255|.\Authorization.cpp(294)|Trace5|Authorization|AuthMgr::eek:nAuthSuccess:Caller "3cx at Home"<sip:2000@192.168.0.200>;tag=2455e77d has been authenticated successfully
    09:11:05.255|DialogUsageManager.cxx(1190)|Trace5|Resip|>>:Got: SipReq: REGISTER 192.168.0.200 tid=ae475f18ad3aea32 cseq=REGISTER contact=2000@192.168.0.99:45568 / 29 from(wire)
    09:11:05.265|ServerRegistration.cxx(214)|Trace5|Resip|>>:Adding sip:2000@192.168.0.200 -> <sip:2000@192.168.0.99:45568;rinstance=a153743e3540bf1f>
    09:11:05.275|.\Registrar.cpp(669)|Trace5|Registrar|RegistrarDB::updateContact:Updated registrar contact: aor=sip:2000@192.168.0.200; contact=sip:2000@192.168.0.99:45568;rinstance=a153743e3540bf1f;expires in 3600 sec.
    09:11:05.275|ServerRegistration.cxx(42)|Trace5|Resip|>>:accepted a registration sip:2000@192.168.0.200
    09:11:05.275|.\Registrar.cpp(98)|Trace5||VoiceBoxForceNotify::execute:Forced out of dialog NOTIFY for DN 2000
    09:11:25.844|TuSelector.cxx(70)|Trace5|Resip|>>:Stats message
    09:12:00.474|ServerAuthManager.cxx(307)|Trace5|Resip|>>:Requesting credential for 2000 @ 3CXPhoneSystem
    09:12:00.474|Helper.cxx(865)|Trace5|Resip|>>: username=2000 password=2000 realm=3CXPhoneSystem method=REGISTER uri=sip:192.168.0.200 nonce=12840501147:04a231d51cf416880d2fc787057ad705
    09:12:00.474|ServerAuthManager.cxx(47)|Trace5|Resip|>>:ServerAuth requested credentials SipReq: REGISTER 192.168.0.200 tid=7c2f6a26ba6eb312 cseq=REGISTER contact=2000@192.168.0.99:45568 / 30 from(wire)
    09:12:00.474|ServerAuthManager.cxx(125)|Trace5|Resip|>>:Checking for auth result in realm=3CXPhoneSystem A1=
    09:12:00.474|ServerAuthManager.cxx(210)|Trace5|Resip|>>:Authorized request for 3CXPhoneSystem
    09:12:00.474|.\Authorization.cpp(294)|Trace5|Authorization|AuthMgr::eek:nAuthSuccess:Caller "3cx at Home"<sip:2000@192.168.0.200>;tag=2455e77d has been authenticated successfully
    09:12:00.474|DialogUsageManager.cxx(1190)|Trace5|Resip|>>:Got: SipReq: REGISTER 192.168.0.200 tid=7c2f6a26ba6eb312 cseq=REGISTER contact=2000@192.168.0.99:45568 / 30 from(wire)
    09:12:00.474|ServerRegistration.cxx(214)|Trace5|Resip|>>:Adding sip:2000@192.168.0.200 -> <sip:2000@192.168.0.99:45568;rinstance=a153743e3540bf1f>
    09:12:00.494|.\Registrar.cpp(669)|Trace5|Registrar|RegistrarDB::updateContact:Updated registrar contact: aor=sip:2000@192.168.0.200; contact=sip:2000@192.168.0.99:45568;rinstance=a153743e3540bf1f;expires in 3600 sec.
    09:12:00.494|ServerRegistration.cxx(42)|Trace5|Resip|>>:accepted a registration sip:2000@192.168.0.200
    09:12:00.494|.\Registrar.cpp(98)|Trace5||VoiceBoxForceNotify::execute:Forced out of dialog NOTIFY for DN 2000
    09:12:12.802|ServerAuthManager.cxx(307)|Trace5|Resip|>>:Requesting credential for 2000 @ 3CXPhoneSystem
    09:12:12.802|Helper.cxx(865)|Trace5|Resip|>>: username=2000 password=2000 realm=3CXPhoneSystem method=REGISTER uri=sip:192.168.0.200 nonce=12840501147:04a231d51cf416880d2fc787057ad705
    09:12:12.802|ServerAuthManager.cxx(47)|Trace5|Resip|>>:ServerAuth requested credentials SipReq: REGISTER 192.168.0.200 tid=a72beb08f45ba931 cseq=REGISTER contact=2000@192.168.0.99:45568 / 31 from(wire)
    09:12:12.802|ServerAuthManager.cxx(125)|Trace5|Resip|>>:Checking for auth result in realm=3CXPhoneSystem A1=
    09:12:12.802|ServerAuthManager.cxx(210)|Trace5|Resip|>>:Authorized request for 3CXPhoneSystem
    09:12:12.802|.\Authorization.cpp(294)|Trace5|Authorization|AuthMgr::eek:nAuthSuccess:Caller "3cx at Home"<sip:2000@192.168.0.200>;tag=2455e77d has been authenticated successfully
    09:12:12.802|DialogUsageManager.cxx(1190)|Trace5|Resip|>>:Got: SipReq: REGISTER 192.168.0.200 tid=a72beb08f45ba931 cseq=REGISTER contact=2000@192.168.0.99:45568 / 31 from(wire)
    09:12:12.802|ServerRegistration.cxx(214)|Trace5|Resip|>>:Adding sip:2000@192.168.0.200 -> <sip:2000@192.168.0.99:45568;rinstance=a153743e3540bf1f>
    09:12:12.812|.\Registrar.cpp(669)|Trace5|Registrar|RegistrarDB::updateContact:Updated registrar contact: aor=sip:2000@192.168.0.200; contact=sip:2000@192.168.0.99:45568;rinstance=a153743e3540bf1f;expires in 3600 sec.
    09:12:12.812|ServerRegistration.cxx(42)|Trace5|Resip|>>:accepted a registration sip:2000@192.168.0.200
    09:12:12.812|.\Registrar.cpp(98)|Trace5||VoiceBoxForceNotify::execute:Forced out of dialog NOTIFY for DN 2000
    09:12:25.841|TuSelector.cxx(70)|Trace5|Resip|>>:Stats message
    09:12:29.326|.\CAHandler.cpp(252)|Trace5||CAHandler::setStatus:[CM102005] CA request setStatus(dn=1112, status=0)
    09:12:29.356|.\CAHandler.cpp(252)|Trace5||CAHandler::setStatus:[CM102005] CA request setStatus(dn=2000, status=0)
    09:12:29.386|.\CAHandler.cpp(252)|Trace5||CAHandler::setStatus:[CM102005] CA request setStatus(dn=2001, status=0)
    09:13:25.887|TuSelector.cxx(70)|Trace5|Resip|>>:Stats message
    09:14:25.843|TuSelector.cxx(70)|Trace5|Resip|>>:Stats message
    09:15:25.900|TuSelector.cxx(70)|Trace5|Resip|>>:Stats message
    09:16:04.295|ServerAuthManager.cxx(307)|Trace5|Resip|>>:Requesting credential for 2000 @ 3CXPhoneSystem
    09:16:04.295|Helper.cxx(865)|Trace5|Resip|>>: username=2000 password=2000 realm=3CXPhoneSystem method=REGISTER uri=sip:192.168.0.200 nonce=12840501147:04a231d51cf416880d2fc787057ad705
    09:16:04.295|ServerAuthManager.cxx(47)|Trace5|Resip|>>:ServerAuth requested credentials SipReq: REGISTER 192.168.0.200 tid=b86e10330d26760c cseq=REGISTER contact=2000@192.168.0.99:45568 / 32 from(wire)
    09:16:04.295|ServerAuthManager.cxx(125)|Trace5|Resip|>>:Checking for auth result in realm=3CXPhoneSystem A1=
    09:16:04.295|ServerAuthManager.cxx(210)|Trace5|Resip|>>:Authorized request for 3CXPhoneSystem
    09:16:04.295|.\Authorization.cpp(294)|Trace5|Authorization|AuthMgr::eek:nAuthSuccess:Caller "3cx at Home"<sip:2000@192.168.0.200>;tag=2455e77d has been authenticated successfully
    09:16:04.295|DialogUsageManager.cxx(1190)|Trace5|Resip|>>:Got: SipReq: REGISTER 192.168.0.200 tid=b86e10330d26760c cseq=REGISTER contact=2000@192.168.0.99:45568 / 32 from(wire)
    09:16:04.305|ServerRegistration.cxx(214)|Trace5|Resip|>>:Adding sip:2000@192.168.0.200 -> <sip:2000@192.168.0.99:45568;rinstance=a153743e3540bf1f>
    09:16:04.315|.\Registrar.cpp(669)|Trace5|Registrar|RegistrarDB::updateContact:Updated registrar contact: aor=sip:2000@192.168.0.200; contact=sip:2000@192.168.0.99:45568;rinstance=a153743e3540bf1f;expires in 3600 sec.
    09:16:04.315|ServerRegistration.cxx(42)|Trace5|Resip|>>:accepted a registration sip:2000@192.168.0.200
    09:16:04.315|.\Registrar.cpp(98)|Trace5||VoiceBoxForceNotify::execute:Forced out of dialog NOTIFY for DN 2000
    09:16:25.906|TuSelector.cxx(70)|Trace5|Resip|>>:Stats message
    09:16:28.970|ServerAuthManager.cxx(307)|Trace5|Resip|>>:Requesting credential for 2000 @ 3CXPhoneSystem
    09:16:28.980|Helper.cxx(865)|Trace5|Resip|>>: username=2000 password=2000 realm=3CXPhoneSystem method=REGISTER uri=sip:192.168.0.200 nonce=12840501147:04a231d51cf416880d2fc787057ad705
    09:16:28.980|ServerAuthManager.cxx(47)|Trace5|Resip|>>:ServerAuth requested credentials SipReq: REGISTER 192.168.0.200 tid=e5691b306062c447 cseq=REGISTER contact=2000@192.168.0.99:45568 / 33 from(wire)
    09:16:28.980|ServerAuthManager.cxx(125)|Trace5|Resip|>>:Checking for auth result in realm=3CXPhoneSystem A1=
    09:16:28.980|ServerAuthManager.cxx(210)|Trace5|Resip|>>:Authorized request for 3CXPhoneSystem
    09:16:28.980|.\Authorization.cpp(294)|Trace5|Authorization|AuthMgr::eek:nAuthSuccess:Caller "3cx at Home"<sip:2000@192.168.0.200>;tag=2455e77d has been authenticated successfully
    09:16:28.980|DialogUsageManager.cxx(1190)|Trace5|Resip|>>:Got: SipReq: REGISTER 192.168.0.200 tid=e5691b306062c447 cseq=REGISTER contact=2000@192.168.0.99:45568 / 33 from(wire)
    09:16:28.980|ServerRegistration.cxx(214)|Trace5|Resip|>>:Adding sip:2000@192.168.0.200 -> <sip:2000@192.168.0.99:45568;rinstance=a153743e3540bf1f>
    09:16:28.990|.\Registrar.cpp(669)|Trace5|Registrar|RegistrarDB::updateContact:Updated registrar contact: aor=sip:2000@192.168.0.200; contact=sip:2000@192.168.0.99:45568;rinstance=a153743e3540bf1f;expires in 3600 sec.
    09:16:28.990|ServerRegistration.cxx(42)|Trace5|Resip|>>:accepted a registration sip:2000@192.168.0.200
    09:16:28.990|.\Registrar.cpp(98)|Trace5||VoiceBoxForceNotify::execute:Forced out of dialog NOTIFY for DN 2000
    09:17:01.347|.\StunClient.cpp(79)|Trace5|STUN|StunClient::process:STUN response received from 64.69.76.23
    09:17:01.447|.\StunClient.cpp(79)|Trace5|STUN|StunClient::process:STUN response received from 64.69.76.23
    09:17:25.872|TuSelector.cxx(70)|Trace5|Resip|>>:Stats message
    09:18:25.898|TuSelector.cxx(70)|Trace5|Resip|>>:Stats message
    09:19:25.855|TuSelector.cxx(70)|Trace5|Resip|>>:Stats message
    09:20:25.911|TuSelector.cxx(70)|Trace5|Resip|>>:Stats message
    09:21:25.897|TuSelector.cxx(70)|Trace5|Resip|>>:Stats message
    09:22:25.833|TuSelector.cxx(70)|Trace5|Resip|>>:Stats message
    09:22:31.802|.\CAHandler.cpp(252)|Trace5||CAHandler::setStatus:[CM102005] CA request setStatus(dn=1112, status=0)
    09:22:31.802|.\CAHandler.cpp(252)|Trace5||CAHandler::setStatus:[CM102005] CA request setStatus(dn=2000, status=0)
    09:22:31.812|.\CAHandler.cpp(252)|Trace5||CAHandler::setStatus:[CM102005] CA request setStatus(dn=2001, status=0)
    09:23:25.890|TuSelector.cxx(70)|Trace5|Resip|>>:Stats message
    09:24:25.846|TuSelector.cxx(70)|Trace5|Resip|>>:Stats message
    09:25:25.892|TuSelector.cxx(70)|Trace5|Resip|>>:Stats message
    09:25:26.513|ServerAuthManager.cxx(307)|Trace5|Resip|>>:Requesting credential for 2000 @ 3CXPhoneSystem
    09:25:26.513|Helper.cxx(865)|Trace5|Resip|>>: username=2000 password=2000 realm=3CXPhoneSystem method=REGISTER uri=sip:192.168.0.200 nonce=12840501147:04a231d51cf416880d2fc787057ad705
    09:25:26.513|ServerAuthManager.cxx(47)|Trace5|Resip|>>:ServerAuth requested credentials SipReq: REGISTER 192.168.0.200 tid=7865823ca00fb363 cseq=REGISTER contact=2000@192.168.0.99:45568 / 34 from(wire)
    09:25:26.513|ServerAuthManager.cxx(125)|Trace5|Resip|>>:Checking for auth result in realm=3CXPhoneSystem A1=
    09:25:26.513|ServerAuthManager.cxx(210)|Trace5|Resip|>>:Authorized request for 3CXPhoneSystem
    09:25:26.513|.\Authorization.cpp(294)|Trace5|Authorization|AuthMgr::eek:nAuthSuccess:Caller "3cx at Home"<sip:2000@192.168.0.200>;tag=2455e77d has been authenticated successfully
    09:25:26.513|DialogUsageManager.cxx(1190)|Trace5|Resip|>>:Got: SipReq: REGISTER 192.168.0.200 tid=7865823ca00fb363 cseq=REGISTER contact=2000@192.168.0.99:45568 / 34 from(wire)
    09:25:26.513|ServerRegistration.cxx(214)|Trace5|Resip|>>:Adding sip:2000@192.168.0.200 -> <sip:2000@192.168.0.99:45568;rinstance=a153743e3540bf1f>
    09:25:26.533|.\Registrar.cpp(669)|Trace5|Registrar|RegistrarDB::updateContact:Updated registrar contact: aor=sip:2000@192.168.0.200; contact=sip:2000@192.168.0.99:45568;rinstance=a153743e3540bf1f;expires in 3600 sec.
    09:25:26.533|ServerRegistration.cxx(42)|Trace5|Resip|>>:accepted a registration sip:2000@192.168.0.200
    09:25:26.543|.\Registrar.cpp(98)|Trace5||VoiceBoxForceNotify::execute:Forced out of dialog NOTIFY for DN 2000
    09:25:35.967|ServerAuthManager.cxx(307)|Trace5|Resip|>>:Requesting credential for 2000 @ 3CXPhoneSystem
    09:25:35.977|Helper.cxx(865)|Trace5|Resip|>>: username=2000 password=2000 realm=3CXPhoneSystem method=REGISTER uri=sip:192.168.0.200 nonce=12840501147:04a231d51cf416880d2fc787057ad705
    09:25:35.987|ServerAuthManager.cxx(47)|Trace5|Resip|>>:ServerAuth requested credentials SipReq: REGISTER 192.168.0.200 tid=637fbb00c164b878 cseq=REGISTER contact=2000@192.168.0.99:45568 / 35 from(wire)
    09:25:35.987|ServerAuthManager.cxx(125)|Trace5|Resip|>>:Checking for auth result in realm=3CXPhoneSystem A1=
    09:25:35.987|ServerAuthManager.cxx(210)|Trace5|Resip|>>:Authorized request for 3CXPhoneSystem
    09:25:35.987|.\Authorization.cpp(294)|Trace5|Authorization|AuthMgr::eek:nAuthSuccess:Caller "3cx at Home"<sip:2000@192.168.0.200>;tag=2455e77d has been authenticated successfully
    09:25:35.987|DialogUsageManager.cxx(1190)|Trace5|Resip|>>:Got: SipReq: REGISTER 192.168.0.200 tid=637fbb00c164b878 cseq=REGISTER contact=2000@192.168.0.99:45568 / 35 from(wire)
    09:25:35.987|ServerRegistration.cxx(214)|Trace5|Resip|>>:Adding sip:2000@192.168.0.200 -> <sip:2000@192.168.0.99:45568;rinstance=a153743e3540bf1f>
    09:25:35.987|.\Registrar.cpp(669)|Trace5|Registrar|RegistrarDB::updateContact:Updated registrar contact: aor=sip:2000@192.168.0.200; contact=sip:2000@192.168.0.99:45568;rinstance=a153743e3540bf1f;expires in 3600 sec.
    09:25:35.997|ServerRegistration.cxx(42)|Trace5|Resip|>>:accepted a registration sip:2000@192.168.0.200
    09:25:35.997|.\Registrar.cpp(98)|Trace5||VoiceBoxForceNotify::execute:Forced out of dialog NOTIFY for DN 2000
    09:26:25.869|TuSelector.cxx(70)|Trace5|Resip|>>:Stats message
    09:27:25.875|TuSelector.cxx(70)|Trace5|Resip|>>:Stats message
    09:28:25.861|TuSelector.cxx(70)|Trace5|Resip|>>:Stats message
    09:29:25.817|TuSelector.cxx(70)|Trace5|Resip|>>:Stats message
    09:30:25.864|TuSelector.cxx(70)|Trace5|Resip|>>:Stats message
    09:31:25.840|TuSelector.cxx(70)|Trace5|Resip|>>:Stats message
    09:32:25.896|TuSelector.cxx(70)|Trace5|Resip|>>:Stats message
    09:32:34.088|.\CAHandler.cpp(252)|Trace5||CAHandler::setStatus:[CM102005] CA request setStatus(dn=1112, status=0)
    09:32:34.088|.\CAHandler.cpp(252)|Trace5||CAHandler::setStatus:[CM102005] CA request setStatus(dn=2000, status=0)
    09:32:34.088|.\CAHandler.cpp(252)|Trace5||CAHandler::setStatus:[CM102005] CA request setStatus(dn=2001, status=0)
    09:33:25.862|TuSelector.cxx(70)|Trace5|Resip|>>:Stats message
    09:34:25.899|TuSelector.cxx(70)|Trace5|Resip|>>:Stats message
    09:35:25.895|TuSelector.cxx(70)|Trace5|Resip|>>:Stats message
    09:36:25.871|TuSelector.cxx(70)|Trace5|Resip|>>:Stats message
    09:37:01.733|.\StunClient.cpp(79)|Trace5|STUN|StunClient::process:STUN response received from 64.69.76.23
    09:37:01.823|.\StunClient.cpp(79)|Trace5|STUN|StunClient::process:STUN response received from 64.69.76.23
    09:37:03.155|ServerAuthManager.cxx(307)|Trace5|Resip|>>:Requesting credential for 1112 @ 3CXPhoneSystem
    09:37:03.165|Helper.cxx(865)|Trace5|Resip|>>: username=1112 password=1112 realm=3CXPhoneSystem method=REGISTER uri=sip:192.168.0.200 nonce=12840540539:a48341190096b23aa74f4639512bb118
    09:37:03.165|ServerAuthManager.cxx(47)|Trace5|Resip|>>:ServerAuth requested credentials SipReq: REGISTER 192.168.0.200 tid=615f1802387cef4a cseq=REGISTER contact=1112@192.168.0.225:8250 / 14 from(wire)
    09:37:03.165|ServerAuthManager.cxx(125)|Trace5|Resip|>>:Checking for auth result in realm=3CXPhoneSystem A1=
    09:37:03.165|ServerAuthManager.cxx(210)|Trace5|Resip|>>:Authorized request for 3CXPhoneSystem
    09:37:03.165|.\Authorization.cpp(294)|Trace5|Authorization|AuthMgr::eek:nAuthSuccess:Caller "bci Home Office"<sip:1112@192.168.0.200>;tag=31207a1d has been authenticated successfully
    09:37:03.165|DialogUsageManager.cxx(1190)|Trace5|Resip|>>:Got: SipReq: REGISTER 192.168.0.200 tid=615f1802387cef4a cseq=REGISTER contact=1112@192.168.0.225:8250 / 14 from(wire)
    09:37:03.165|ServerRegistration.cxx(214)|Trace5|Resip|>>:Adding sip:1112@192.168.0.200 -> <sip:1112@192.168.0.225:8250;rinstance=e923b6ce96f7739d>
    09:37:03.245|.\Registrar.cpp(669)|Trace5|Registrar|RegistrarDB::updateContact:Updated registrar contact: aor=sip:1112@192.168.0.200; contact=sip:1112@192.168.0.225:8250;rinstance=e923b6ce96f7739d;expires in 3600 sec.
    09:37:03.245|ServerRegistration.cxx(42)|Trace5|Resip|>>:accepted a registration sip:1112@192.168.0.200
    09:37:03.255|.\Registrar.cpp(98)|Trace5||VoiceBoxForceNotify::execute:Forced out of dialog NOTIFY for DN 1112
    09:37:25.888|TuSelector.cxx(70)|Trace5|Resip|>>:Stats message
    09:38:25.854|TuSelector.cxx(70)|Trace5|Resip|>>:Stats message
    09:39:25.840|TuSelector.cxx(70)|Trace5|Resip|>>:Stats message
    09:40:25.886|TuSelector.cxx(70)|Trace5|Resip|>>:Stats message
    09:41:25.833|TuSelector.cxx(70)|Trace5|Resip|>>:Stats message
    09:42:25.929|TuSelector.cxx(70)|Trace5|Resip|>>:Stats message
    09:42:36.664|.\CAHandler.cpp(252)|Trace5||CAHandler::setStatus:[CM102005] CA request setStatus(dn=1112, status=0)
    09:42:36.674|.\CAHandler.cpp(252)|Trace5||CAHandler::setStatus:[CM102005] CA request setStatus(dn=2000, status=0)
    09:42:36.674|.\CAHandler.cpp(252)|Trace5||CAHandler::setStatus:[CM102005] CA request setStatus(dn=2001, status=0)
    09:42:55.732|ServerAuthManager.cxx(307)|Trace5|Resip|>>:Requesting credential for 2001 @ 3CXPhoneSystem
    09:42:55.732|Helper.cxx(865)|Trace5|Resip|>>: username=2001 password=2001 realm=3CXPhoneSystem method=REGISTER uri=sip:192.168.0.200 nonce=12840511941:8056fe8e647f67a25e8d318a4786df41
    09:42:55.732|ServerAuthManager.cxx(47)|Trace5|Resip|>>:ServerAuth requested credentials SipReq: REGISTER 192.168.0.200 tid=-ae0c1a7c cseq=REGISTER contact=2001@192.168.0.2:5060 / 26784 from(wire)
    09:42:55.732|ServerAuthManager.cxx(125)|Trace5|Resip|>>:Checking for auth result in realm=3CXPhoneSystem A1=
    09:42:55.732|ServerAuthManager.cxx(210)|Trace5|Resip|>>:Authorized request for 3CXPhoneSystem
    09:42:55.732|.\Authorization.cpp(294)|Trace5|Authorization|AuthMgr::eek:nAuthSuccess:Caller "2001 Test Extension"<sip:2001@192.168.0.200>;tag=a645e06c4b5cf0fco0 has been authenticated successfully
    09:42:55.742|DialogUsageManager.cxx(1190)|Trace5|Resip|>>:Got: SipReq: REGISTER 192.168.0.200 tid=-ae0c1a7c cseq=REGISTER contact=2001@192.168.0.2:5060 / 26784 from(wire)
    09:42:55.742|ServerRegistration.cxx(214)|Trace5|Resip|>>:Adding sip:2001@192.168.0.200 -> "2001 Test Extension"<sip:2001@192.168.0.2:5060>;expires=3600
    09:42:55.752|.\Registrar.cpp(669)|Trace5|Registrar|RegistrarDB::updateContact:Updated registrar contact: aor=sip:2001@192.168.0.200; contact=sip:2001@192.168.0.2:5060;expires in 3600 sec.
    09:42:55.752|ServerRegistration.cxx(42)|Trace5|Resip|>>:accepted a registration sip:2001@192.168.0.200
    09:42:55.752|.\Registrar.cpp(98)|Trace5||VoiceBoxForceNotify::execute:Forced out of dialog NOTIFY for DN 2001
    09:43:25.855|TuSelector.cxx(70)|Trace5|Resip|>>:Stats message
    09:44:25.912|TuSelector.cxx(70)|Trace5|Resip|>>:Stats message
    09:45:25.848|TuSelector.cxx(70)|Trace5|Resip|>>:Stats message
    09:46:25.904|TuSelector.cxx(70)|Trace5|Resip|>>:Stats message
    09:47:25.830|TuSelector.cxx(70)|Trace5|Resip|>>:Stats message
    09:48:25.817|TuSelector.cxx(70)|Trace5|Resip|>>:Stats message
    09:48:41.509|ServerAuthManager.cxx(363)|Trace5|Resip|>>:Sending challenge to SipReq: REGISTER 192.168.0.200 tid=ce4996103a382a04 cseq=REGISTER contact=2000@192.168.0.99:44254 / 1 from(wire)
    09:48:41.509|ServerAuthManager.cxx(41)|Trace5|Resip|>>:ServerAuth challenged request SipReq: REGISTER 192.168.0.200 tid=ce4996103a382a04 cseq=REGISTER contact=2000@192.168.0.99:44254 / 1 from(wire)
    09:48:41.900|ServerAuthManager.cxx(307)|Trace5|Resip|>>:Requesting credential for 2000 @ 3CXPhoneSystem
    09:48:41.900|Helper.cxx(865)|Trace5|Resip|>>: username=2000 password=2000 realm=3CXPhoneSystem method=REGISTER uri=sip:192.168.0.200 nonce=12840580121:c37152c9cf3ed199e767df823f3651e3
    09:48:41.900|ServerAuthManager.cxx(47)|Trace5|Resip|>>:ServerAuth requested credentials SipReq: REGISTER 192.168.0.200 tid=d14b135b971d841a cseq=REGISTER contact=2000@192.168.0.99:44254 / 2 from(wire)
    09:48:41.900|ServerAuthManager.cxx(125)|Trace5|Resip|>>:Checking for auth result in realm=3CXPhoneSystem A1=
    09:48:41.900|ServerAuthManager.cxx(210)|Trace5|Resip|>>:Authorized request for 3CXPhoneSystem
    09:48:41.900|.\Authorization.cpp(294)|Trace5|Authorization|AuthMgr::eek:nAuthSuccess:Caller "3cx at Home"<sip:2000@192.168.0.200>;tag=df28412d has been authenticated successfully
    09:48:41.900|DialogUsageManager.cxx(1190)|Trace5|Resip|>>:Got: SipReq: REGISTER 192.168.0.200 tid=d14b135b971d841a cseq=REGISTER contact=2000@192.168.0.99:44254 / 2 from(wire)
    09:48:41.910|ServerRegistration.cxx(214)|Trace5|Resip|>>:Adding sip:2000@192.168.0.200 -> <sip:2000@192.168.0.99:44254;rinstance=6cc479e5ed49a57e>
    09:48:41.930|.\Registrar.cpp(669)|Trace5|Registrar|RegistrarDB::updateContact:Updated registrar contact: aor=sip:2000@192.168.0.200; contact=sip:2000@192.168.0.99:44254;rinstance=6cc479e5ed49a57e;expires in 3600 sec.
    09:48:41.960|.\Registrar.cpp(116)|Trace5|Registrar|ServRegs::eek:nAdd:Got registration from Ext.2000;
    Contacts: [<sip:2000@192.168.0.99:44254;rinstance=6cc479e5ed49a57e>]
    09:48:41.960|.\CallEvents.cpp(78)|Trace5||FireStatusEvent:Fire event: OnHook; DN 2000
    09:48:41.960|.\Registrar.cpp(141)|Log2|Registrar|ServRegs::eek:nAdd:[CM113002] Registered: Ext.2000
    09:48:41.960|ServerRegistration.cxx(42)|Trace5|Resip|>>:accepted a registration sip:2000@192.168.0.200
    09:48:41.960|.\Registrar.cpp(98)|Trace5||VoiceBoxForceNotify::execute:Forced out of dialog NOTIFY for DN 2000
    09:48:42.240|ServerAuthManager.cxx(363)|Trace5|Resip|>>:Sending challenge to SipReq: SUBSCRIBE 2000@192.168.0.200 tid=df08971fea451843 cseq=SUBSCRIBE contact=2000@192.168.0.99:44254 / 1 from(wire)
    09:48:42.240|ServerAuthManager.cxx(41)|Trace5|Resip|>>:ServerAuth challenged request SipReq: SUBSCRIBE 2000@192.168.0.200 tid=df08971fea451843 cseq=SUBSCRIBE contact=2000@192.168.0.99:44254 / 1 from(wire)
    09:48:42.450|ServerAuthManager.cxx(307)|Trace5|Resip|>>:Requesting credential for 2000 @ 3CXPhoneSystem
    09:48:42.450|Helper.cxx(865)|Trace5|Resip|>>: username=2000 password=2000 realm=3CXPhoneSystem method=SUBSCRIBE uri=sip:2000@192.168.0.200 nonce=12840580122:4227d05e9d58bc3476a5dab9a394c61d
    09:48:42.450|ServerAuthManager.cxx(47)|Trace5|Resip|>>:ServerAuth requested credentials SipReq: SUBSCRIBE 2000@192.168.0.200 tid=17722077d41b3170 cseq=SUBSCRIBE contact=2000@192.168.0.99:44254 / 2 from(wire)
    09:48:42.450|ServerAuthManager.cxx(125)|Trace5|Resip|>>:Checking for auth result in realm=3CXPhoneSystem A1=
    09:48:42.450|ServerAuthManager.cxx(210)|Trace5|Resip|>>:Authorized request for 3CXPhoneSystem
    09:48:42.450|.\Authorization.cpp(294)|Trace5|Authorization|AuthMgr::eek:nAuthSuccess:Caller "3cx at Home"<sip:2000@192.168.0.200>;tag=4b7c0a73 has been authenticated successfully
    09:48:42.450|DialogUsageManager.cxx(1190)|Trace5|Resip|>>:Got: SipReq: SUBSCRIBE 2000@192.168.0.200 tid=17722077d41b3170 cseq=SUBSCRIBE contact=2000@192.168.0.99:44254 / 2 from(wire)
    09:48:42.450|c:\svn\src\pbxserver\ServerSubscr.h(188)|Trace5|MessageSubscription|MessageSubscribeHandler::eek:nNewSubscription:eek:nNewSubscription(h=385)
    09:48:42.450|c:\svn\src\pbxserver\ServerSubscr.h(189)|Trace5|MessageSubscription|MessageSubscribeHandler::eek:nNewSubscription:msg:SUBSCRIBE sip:2000@192.168.0.200 SIP/2.0
    Via: SIP/2.0/UDP 192.168.0.99:44254;branch=z9hG4bK-d87543-17722077d41b3170-1--d87543-;rport=44254
    Max-Forwards: 70
    Contact: <sip:2000@192.168.0.99:44254>
    To: "3cx at Home"<sip:2000@192.168.0.200>
    From: "3cx at Home"<sip:2000@192.168.0.200>;tag=4b7c0a73
    Call-ID: YzNkYTlhZjg3OGY5ZDRiMGFhYjcyYzQxYzMxZjdjZjI.
    CSeq: 2 SUBSCRIBE
    Expires: 300
    Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, SUBSCRIBE, INFO
    Proxy-Authorization: Digest username="2000",realm="3CXPhoneSystem",nonce="12840580122:4227d05e9d58bc3476a5dab9a394c61d",uri="sip:2000@192.168.0.200",response="9a06f14039e06784904455ba6724246f",algorithm=MD5
    User-Agent: X-Lite release 1011s stamp 41150
    Event: message-summary
    Content-Length: 0


    09:48:42.450|c:\svn\src\pbxserver\ServerSubscr.h(162)|Trace5|MessageSubscription|MessageSubscribeHandler::eek:nReadyToSend:eek:nReadyToSend
    09:48:42.450|c:\svn\src\pbxserver\ServerSubscr.h(222)|Trace5|MessageSubscription|MessageSubscribeHandler::eek:nTerminated:eek:nTerminated(hSub=385)
    2007/11/27 >>
    08:11:41.129|TuSelector.cxx(70)|Trace5|Resip|>>:Stats message
    08:11:41.229|TuSelector.cxx(70)|Trace5|Resip|>>:Stats message
    08:11:41.289|.\Registrar.cpp(647)|Trace5|Registrar|RegistrarDB::removeAor:Removed registrar entry: aor=sip:1112@192.168.0.200
    08:11:41.289|TuSelector.cxx(70)|Trace5|Resip|>>:Stats message
    08:11:41.289|.\Registrar.cpp(684)|Trace5|Registrar|RegistrarDB::removeContact:Removed registrar contact: aor=sip:1112@192.168.0.200; contact=sip:1112@192.168.0.225:8250;rinstance=e923b6ce96f7739d
    08:11:41.289|.\Registrar.cpp(42)|Log2|Registrar|ServRegs::checkExpiration:[CM113000] Registration for sip:1112@192.168.0.200 has expired
    08:11:41.299|.\Extension.cpp(69)|Trace5|Endpoints|Extension::Extension:Extension Ext.1112 is not registered!
    08:11:41.299|.\CallEvents.cpp(78)|Trace5||FireStatusEvent:Fire event: Undefined; DN 1112
    08:11:41.309|.\Registrar.cpp(647)|Trace5|Registrar|RegistrarDB::removeAor:Removed registrar entry: aor=sip:1112@192.168.0.200
    08:11:41.329|.\Registrar.cpp(684)|Trace5|Registrar|RegistrarDB::removeContact:Removed registrar contact: aor=sip:2000@192.168.0.200; contact=sip:2000@192.168.0.99:45568;rinstance=a153743e3540bf1f
    08:11:41.389|TuSelector.cxx(70)|Trace5|Resip|>>:Stats message
    08:11:41.399|TuSelector.cxx(70)|Trace5|Resip|>>:Stats message
    08:11:41.399|.\StunClient.cpp(79)|Trace5|STUN|StunClient::process:STUN response received from 64.69.76.23
    08:11:41.519|.\Registrar.cpp(647)|Trace5|Registrar|RegistrarDB::removeAor:Removed registrar entry: aor=sip:2000@192.168.0.200
    08:11:41.569|TuSelector.cxx(70)|Trace5|Resip|>>:Stats message
    08:11:41.569|.\Registrar.cpp(684)|Trace5|Registrar|RegistrarDB::removeContact:Removed registrar contact: aor=sip:2000@192.168.0.200; contact=sip:2000@192.168.0.99:44254;rinstance=6cc479e5ed49a57e
    08:11:41.629|.\Registrar.cpp(42)|Log2|Registrar|ServRegs::checkExpiration:[CM113000] Registration for sip:2000@192.168.0.200 has expired
    08:11:41.639|.\Extension.cpp(69)|Trace5|Endpoints|Extension::Extension:Extension Ext.2000 is not registered!
    08:11:41.639|.\CallEvents.cpp(78)|Trace5||FireStatusEvent:Fire event: Undefined; DN 2000
    08:11:41.639|.\Registrar.cpp(647)|Trace5|Registrar|RegistrarDB::removeAor:Removed registrar entry: aor=sip:2000@192.168.0.200
    08:11:41.669|TuSelector.cxx(70)|Trace5|Resip|>>:Stats message
    08:11:41.679|TuSelector.cxx(70)|Trace5|Resip|>>:Stats message
    08:11:41.679|.\StunClient.cpp(79)|Trace5|STUN|StunClient::process:STUN response received from 64.69.76.23
    08:11:41.840|.\Registrar.cpp(647)|Trace5|Registrar|RegistrarDB::removeAor:Removed registrar entry: aor=sip:2001@192.168.0.200
    08:11:41.850|.\Registrar.cpp(684)|Trace5|Registrar|RegistrarDB::removeContact:Removed registrar contact: aor=sip:2001@192.168.0.200; contact=sip:2001@192.168.0.2:5060
    08:11:41.850|.\Registrar.cpp(42)|Log2|Registrar|ServRegs::checkExpiration:[CM113000] Registration for sip:2001@192.168.0.200 has expired
    08:11:41.860|.\Extension.cpp(69)|Trace5|Endpoints|Extension::Extension:Extension Ext.2001 is not registered!
    08:11:41.860|.\CallEvents.cpp(78)|Trace5||FireStatusEvent:Fire event: Undefined; DN 2001
    08:11:41.860|.\Registrar.cpp(647)|Trace5|Registrar|RegistrarDB::removeAor:Removed registrar entry: aor=sip:2001@192.168.0.200
    08:11:41.950|TuSelector.cxx(70)|Trace5|Resip|>>:Stats message
    08:11:42.050|TuSelector.cxx(70)|Trace5|Resip|>>:Stats message
    08:11:42.150|TuSelector.cxx(70)|Trace5|Resip|>>:Stats message
     
    Stop hovering to collapse... Click to collapse... Hover to expand... Click to expand...
Thread Status:
Not open for further replies.