Hi All, I have installed sipX today and all went well with the installation.. for hours and I have been trying to register a softphone and just can't make it to work. I have used Xlite, Zoiper and even Cisco 7940 phones...
the registration is just timing out... I installed wireshark on the server , I see Request: Register then Status: 100 Trying and then Status: 408 Request timeout. - I can ping the server just fine - server is listening on port 5060 - I disable NAT on the server - used both IP and Host to register with the server -intranet subnets are set -ICE disabled on the softphone and also forced to use port 5060 - Configuration Test was done on the server, all passed except DHCP test which is not running on the network there is one thing that I see in wireshark is when getting error 408, I see that source port is 5060 and destination port is 7991.. could that be the reason? I have also attached the softphone phone debug to this email (see something about "trying to add a native transport on port: 5060" binding 0.0.0.0) User Datagram Protocol, Src Port: sip (5060), Dst Port: 7991 (7991) Source port: sip (5060) Destination port: 7991 (7991) more info: @|fEH[4?REGISTER sip:192.168.3.154 SIP/2.0 Via: SIP/2.0/UDP 192.168.3.252:23423;branch=z9hG4bK-d8754z-f5703e6aaf3c5c48-1---d8754z-;rport Max-Forwards: 70 Contact: <sip:2...@192.168.3.252:23423;rinstance=1f80df743b5a4e76> To: "200"<sip:2...@192.168.3.154> From: "200"<sip:2...@192.168.3.154>;tag=1a6a4c42 Call-ID: MmNiN2Y2NGYxYmRhYjJiMTYwZDA5MTNlMTgwYWM0ZTk. CSeq: 1 REGISTER Expires: 3600 Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, SUBSCRIBE, INFO Supported: timer User-Agent: eyeBeam release 1104a stamp 54436 Content-Length: 0 @|e...@47<SIP/2.0 100 Trying From: "200"<sip:2...@192.168.3.154>;tag=e2302353 To: "200"<sip:2...@192.168.3.154> Call-Id: Njc1N2MxZWJkOGMzZDNiZGMyZDY5ZjE2MGVhMGM0NjQ. Cseq: 9 REGISTER Via: SIP/2.0/UDP 192.168.3.139:7991;branch=z9hG4bK-d8754z-92741d787c129a18-1---d8754z-;rport=7991 Content-Length: 0 @|e...@7sip/2.0 408 Request timeout From: "200"<sip:2...@192.168.3.154>;tag=e2302353 To: "200"<sip:2...@192.168.3.154>;tag=QrxaIm Call-Id: Njc1N2MxZWJkOGMzZDNiZGMyZDY5ZjE2MGVhMGM0NjQ. Cseq: 7 REGISTER Via: SIP/2.0/UDP 192.168.3.139:7991;branch=z9hG4bK-d8754z-b0763363264f5b11-1---d8754z-;rport=7991 Server: sipXecs/4.2.1 sipXecs/sipXproxy (Linux) Content-Length: 0 Thanks
eyeBeam 1.5.20 build 54436 label 1104a Processor:Intel(R) Core(TM)2 Duo CPU E4500 @ 2.20GHz Speed: 2200.000000, Class: High (state of the art machine) Operating System: WinXP, Patch: Service Pack 2 Supported features: MMX, High Resolution Counter, FPU, SSE, SSE2 [10-10-20]19:47:43.902 | Info | AbstractPhone | "[...@192.168.3.154]::EnableAccount" | AbPhone::CAccount::EnableAccount [10-10-20]19:47:43.902 | Debug | CCM | "Adding to pending... [id:135][workers:0][pending:0]" | sua::CResipProcessThread::Add [10-10-20]19:47:43.902 | Info | DNS | "DNS [query:192.168.3.154]" | sua::CDNS::StartTopologyLookup [10-10-20]19:47:43.902 | Info | DNS | "DNS-Lookup performed: '_sip._udp.' '192.168.3.154' [default-port:5060][fallback to A/QA:T] - Results:" | sua::CDNS::InternalShutdown [10-10-20]19:47:43.902 | Info | DNS | " 0 - [ip:192.168.3.154:5060][ttl:4294967295][P:0][W:0][query-name:192.168.3.154]" | sua::CDNS::InternalShutdown [10-10-20]19:47:43.902 | Info | DNS | "DNS [query:192.168.3.154]" | sua::CDNS::StartTopologyLookup [10-10-20]19:47:43.902 | Info | DNS | "DNS-Lookup performed: '_sip._tcp.' '192.168.3.154' [default-port:5060][fallback to A/QA:T] - Results:" | sua::CDNS::InternalShutdown [10-10-20]19:47:43.902 | Info | DNS | " 0 - [ip:192.168.3.154:5060][ttl:4294967295][P:0][W:0][query-name:192.168.3.154]" | sua::CDNS::InternalShutdown [10-10-20]19:47:43.902 | Debug | AbstractPhone | "[...@192.168.3.154]::OnDNSLookupPlusDiscoveryProcessResult" | AbPhone::CAccount::CCCMSink::OnDNSLookupPlusDiscoveryProcessResult [10-10-20]19:47:43.902 | Info | AbstractPhone | "Receiving notification about firewall IP address: 0.0.0.0, voip always possible: 0" | AbPhone::CAbstractPhone::OnFirewallInformation [10-10-20]19:47:43.902 | Debug | CCM | "CSIPAccess created, [handle:02583C30] [ENetworkUp]" | sua::CCallControlManager::CreateSIPAccess [10-10-20]19:47:43.902 | Debug | CCM | "[state:EState_CreatingTransport][T|F] [URI:2...@192.168.3.154]" | sua::CSIPAccess::CreateDUM [10-10-20]19:47:43.902 | Debug | RESIP | "BaseSecurity::BaseSecurity" | [10-10-20]19:47:43.910 | Info | RESIP:DNS | "DNS initialization: found 2 name servers" | [10-10-20]19:47:43.910 | Info | RESIP:DNS | " name server: 24.200.241.37" | [10-10-20]19:47:43.910 | Info | RESIP:DNS | " name server: 24.201.245.77" | [10-10-20]19:47:43.910 | Debug | RESIP | "COMPRESSION SUPPORT NOT COMPILED IN" | [10-10-20]19:47:43.910 | Debug | RESIP | "Compression configuration object created; algorithm = 0" | [10-10-20]19:47:43.911 | Debug | RESIP:TRANSPORT | "No compression library available" | [10-10-20]19:47:43.916 | Info | RESIP | "Root System Cert Store opened" | [10-10-20]19:47:43.988 | Info | RESIP | "118 certs loaded of type 1" | [10-10-20]19:47:43.990 | Info | RESIP | "My System Cert Store opened" | [10-10-20]19:47:43.991 | Debug | RESIP:DUM | "Adding credential: realm=192.168.3.154 user=200" | [10-10-20]19:47:43.991 | Debug | CCM | "[state:EInitial]" | sua::CSIPDUMWrapper::SetContainedObjects [10-10-20]19:47:43.991 | Debug | CCM | "Adding to pending... [id:184][workers:1][pending:0]" | sua::CResipProcessThread::Add [10-10-20]19:47:43.991 | Debug | CCM | "[state:EState_CreatingTransport][T|F] [URI:2...@192.168.3.154]" | sua::CSIPAccess::CreateTransport [10-10-20]19:47:43.991 | Info | CCM | "Creating transport... [URI:2...@192.168.3.154]" | sua::CSIPAccess::CTransportCreator::Start [10-10-20]19:47:43.991 | Debug | CCM | "Local IPs: <192.168.3.252 | 192.168.56.1>" | sua::CSIPAccess::CTransportCreator::Start [10-10-20]19:47:43.991 | Debug | CCM | "[port:5060 (5060->5062)] [URI:2...@192.168.3.154]" | sua::CSIPAccess::CTransportCreator::CreateNonTunnelingTransports [10-10-20]19:47:43.991 | Info | CCM | "Not using firewall SIP proxy. Reasons: [URI:2...@192.168.3.154]" | sua::CSIPAccess::CTransportCreator::UseFirewallSIPProxy [10-10-20]19:47:43.991 | Debug | CCM | "Not using SBC/Firewall proxy. [URI:2...@192.168.3.154]" | sua::CSIPAccess::CTransportCreator::CreateNonTunnelingTransports [10-10-20]19:47:43.991 | Debug | CCM | "Trying to add a NatNavigator on port: 5060" | sua::CResipTransportCreator::AddNATNavTransportTryNextOpenPort [10-10-20]19:47:43.991 | Info | RESIP:TRANSPORT | "Creating UDP transport host= port=5060 ipv4=1" | [10-10-20]19:47:43.991 | Debug | RESIP:TRANSPORT | "Creating fd=1664 V4/UDP" | [10-10-20]19:47:43.991 | Debug | RESIP:TRANSPORT | "Binding to 0.0.0.0" | [10-10-20]19:47:43.992 | Info | CCM | "DSCP marking is set for SIP or DNS signaling socket, where socket=1664, where transport type=3, where resip file is W:\Studio\trunk\Dev\UA\SDK\Contrib\sipfoundry\main\resip\stack\InternalTransport.cxx, where resip line # is 122, where DSCP value=40" | sua::CCMAfterSocketCreationFuncPtr [10-10-20]19:47:43.992 | Debug | RESIP:TRANSPORT | "No compression library available: Transport: [ V4 0.0.0.0:5060 UDP target domain=unspecified connectionId=0 ]" | [10-10-20]19:47:43.992 | Debug | RESIP:TRANSPORT | "Adding transport: [ V4 0.0.0.0:5060 UDP target domain=unspecified connectionId=0 ]" | [10-10-20]19:47:43.992 | Debug | CCM | "Trying to add a native transport on port: 5060" | sua::CResipTransportCreator::AddNativeTransportTryNextOpenPort [10-10-20]19:47:43.992 | Debug | RESIP:TRANSPORT | "ConnectionBase::ConnectionBase, no params: 02B5E958" | [10-10-20]19:47:43.992 | Debug | RESIP:TRANSPORT | "ConnectionManager::ConnectionManager() called " | [10-10-20]19:47:43.992 | Debug | RESIP:TRANSPORT | "Creating fd=1684 V4/TCP" | [10-10-20]19:47:43.992 | Debug | RESIP:TRANSPORT | "Binding to 0.0.0.0" | [10-10-20]19:47:43.994 | Info | RESIP:TRANSPORT | "Creating TCP transport host= port=5060 ipv4=1" | [10-10-20]19:47:43.994 | Debug | RESIP:TRANSPORT | "Adding transport: [ V4 0.0.0.0:5060 TCP target domain=unspecified connectionId=0 ]" | [10-10-20]19:47:43.994 | Debug | CCM | "Trying to add a native transport on port: 5061" | sua::CResipTransportCreator::AddNativeTransportTryNextOpenPort [10-10-20]19:47:43.994 | Debug | RESIP:TRANSPORT | "ConnectionBase::ConnectionBase, no params: 052E8EB8" | [10-10-20]19:47:43.994 | Debug | RESIP:TRANSPORT | "ConnectionManager::ConnectionManager() called " | [10-10-20]19:47:43.994 | Debug | RESIP:TRANSPORT | "Creating fd=1704 V4/TCP" | [10-10-20]19:47:43.994 | Debug | RESIP:TRANSPORT | "Binding to 0.0.0.0" | [10-10-20]19:47:43.996 | Info | RESIP:TRANSPORT | "Creating TLS transport for domain interface= port=5061" | [10-10-20]19:47:43.996 | Debug | CCM | "[state:EState_CreatingTransport][T|F] [URI:2...@192.168.3.154]" | sua::CSIPAccess::HandleTransportCreationSuccess [10-10-20]19:47:43.996 | Debug | CCM | "[state:EStarting]" | sua::CSIPDUMWrapper::NotifyDUMIsReady [10-10-20]19:47:43.997 | Debug | AbstractPhone | "[...@192.168.3.154]::OnSIPAccessCreationProgress" | AbPhone::CAccount::CCCMSink::OnSIPAccessCreationProgress [10-10-20]19:47:43.997 | Debug | AbstractPhone | "[...@192.168.3.154]::OnSIPAccessCreationProgress" | AbPhone::CAccount::CCCMSink::OnSIPAccessCreationProgress [10-10-20]19:47:43.997 | Debug | AbstractPhone | "[...@192.168.3.154]::OnSIPAccessReady" | AbPhone::CAccount::CCCMSink::OnSIPAccessReady [10-10-20]19:47:43.997 | Debug | CCM | " [URI:2...@192.168.3.154]" | sua::CSIPAccess::InstallIncomingCallSink [10-10-20]19:47:43.997 | Debug | CCM | " [URI:2...@192.168.3.154]" | sua::CSIPAccess::InstallServerIMPagerMessageSink [10-10-20]19:47:43.997 | Debug | CCM | "[event:message-summary] [URI:2...@192.168.3.154]" | sua::CSIPAccess::InstallOutOfDialogNotifySink [10-10-20]19:47:43.997 | Debug | CCM | "[event:message-summary]" | sua::CMyDUMOutOfDialogNotifyHandler::InstallSIPEventSink [10-10-20]19:47:43.998 | Debug | CCM | "[event:remote-diagnostic][assumed-expires:3600] [URI:2...@192.168.3.154]" | sua::CSIPAccess::InstallIncomingSubscriptionSink [10-10-20]19:47:43.998 | Debug | CCM | " [URI:2...@192.168.3.154]" | sua::CSIPAccess::SIPRegister [10-10-20]19:47:43.998 | Debug | CCM | " [URI:2...@192.168.3.154]" | sua::CTransportMonitorUsingRegistration::NotifyNewSIPClientRegistration [10-10-20]19:47:43.998 | Debug | CCM | "[URI:2...@192.168.3.154]" | sua::CSIPRegistration::Start [10-10-20]19:47:43.999 | Info | RESIP:DNS | "local hostname does not contain a domain part BlackBird" | [10-10-20]19:47:43.999 | Debug | RESIP:DUM | "BaseCreator::makeInitialRequest: 02B42838" | [10-10-20]19:47:43.999 | Debug | RESIP:DUM | "RegistrationCreator::RegistrationCreator: 02B42838" | [10-10-20]19:47:43.999 | Debug | RESIP:DUM | " ************* Created DialogSet(UAC) -- Y2VmZjVhMGI3Y2EwODc2MDVmNjU2M2U4MmM4ZDZjOTE.-2478bc24*************" | [10-10-20]19:47:43.999 | Debug | RESIP:DUM | "SEND: REGISTER sip:192.168.3.154 SIP/2.0 Via: SIP/2.0/ ;branch=z9hG4bK-d8754z-8e6bb76f9f20d26e-1---d8754z-;rport Max-Forwards: 70 Contact: <sip:200;rinstance=41aa8105bd4c2da2> To: ""200""<sip:2...@192.168.3.154> From: ""200""<sip:2...@192.168.3.154>;tag=2478bc24 Call-ID: Y2VmZjVhMGI3Y2EwODc2MDVmNjU2M2U4MmM4ZDZjOTE. CSeq: 1 REGISTER Expires: 3600 Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, SUBSCRIBE, INFO Supported: timer User-Agent: eyeBeam release 1104a stamp 54436 Content-Length: 0 " | [10-10-20]19:47:43.999 | Debug | RESIP:TRANSACTION | "Adding application timer: " | [10-10-20]19:47:44.009 | Info | USB Devices | "Realtek HD Audio output is selected as USB control device. Attempt to connect..." | cpsi::IVoipDevice::OpenDevice [10-10-20]19:47:44.009 | Info | USB Devices | "0012D7F0" | DBLOGGER [10-10-20]19:47:44.009 | Info | USB Devices | "0012D7D8" | DBLOGGER [10-10-20]19:47:44.009 | Info | USB Devices | "0012D7D0" | DBLOGGER [10-10-20]19:47:44.009 | Info | USB Devices | "0012D7D0" | DBLOGGER [10-10-20]19:47:44.009 | Info | USB Devices | "0012D7C8" | DBLOGGER [10-10-20]19:47:44.009 | Info | USB Devices | "0012D7D0" | DBLOGGER [10-10-20]19:47:44.009 | Info | USB Devices | "0012D7D0" | DBLOGGER [10-10-20]19:47:44.009 | Info | USB Devices | "0012D7D0" | DBLOGGER [10-10-20]19:47:44.009 | Info | USB Devices | "0012D3D8" | DBLOGGER [10-10-20]19:47:44.009 | Info | USB Devices | "0012D3C8" | DBLOGGER [10-10-20]19:47:44.009 | Info | USB Devices | "0012D3C0" | DBLOGGER [10-10-20]19:47:44.010 | Info | USB Devices | "0012D3B8" | DBLOGGER [10-10-20]19:47:44.010 | Info | USB Devices | "0012D3B0" | DBLOGGER [10-10-20]19:47:44.010 | Info | USB Devices | "0012D3A8" | DBLOGGER [10-10-20]19:47:44.010 | Info | USB Devices | "0012D3C8" | DBLOGGER [10-10-20]19:47:44.010 | Info | USB Devices | "0012D3C8" | DBLOGGER [10-10-20]19:47:44.010 | Info | USB Devices | "0012D3D0" | DBLOGGER [10-10-20]19:47:44.010 | Info | USB Devices | "0012D3D0" | DBLOGGER [10-10-20]19:47:44.010 | Info | USB Devices | "0012D3D0" | DBLOGGER [10-10-20]19:47:44.010 | Info | USB Devices | "0012D3D0" | DBLOGGER [10-10-20]19:47:44.010 | Info | USB Devices | "0012D3D0" | DBLOGGER [10-10-20]19:47:44.010 | Info | USB Devices | "0012D3D0" | DBLOGGER [10-10-20]19:47:44.010 | Info | USB Devices | "0012D3D0" | DBLOGGER [10-10-20]19:47:44.010 | Info | USB Devices | "0012D3D0" | DBLOGGER [10-10-20]19:47:44.010 | Info | USB Devices | "0012D7D8" | DBLOGGER [10-10-20]19:47:44.010 | Info | USB Devices | "0012D7F0" | DBLOGGER [10-10-20]19:47:44.010 | Info | USB Devices | "0012D7F0" | DBLOGGER [10-10-20]19:47:44.010 | Info | USB Devices | "0012D7E8" | DBLOGGER [10-10-20]19:47:44.010 | Info | USB Devices | "0012D7F0" | DBLOGGER [10-10-20]19:47:44.012 | Error | USB Devices | "PhonePort.dll is absent" | cpsi::LegerityVoipDevice::LegerityVoipDevice [10-10-20]19:47:44.017 | Debug | Utilities | "Removing timer 86, m_cTimers.size() 3" | sua::CTimerManager::CancelTimer [10-10-20]19:47:44.027 | Debug | Utilities | "Adding timer290, m_cTimers.size() 4" | sua::CTimerManager::CreateTimer [10-10-20]19:47:44.028 | Error | USB Devices | "Failed to connect device" | cpsi::CYealinkDevice::CYealinkDevice [10-10-20]19:47:44.164 | Info | RESIP:DUM | "Got a DumFeatureMessage02AECA10" | [10-10-20]19:47:44.164 | Debug | RESIP:DUM | "Next hop is 192.168.3.154" | [10-10-20]19:47:44.164 | Debug | RESIP:DUM | "DialogId::DialogId: Y2VmZjVhMGI3Y2EwODc2MDVmNjU2M2U4MmM4ZDZjOTE.-2478bc24-" | [10-10-20]19:47:44.164 | Debug | RESIP:DUM | "Send: SipReq: REGISTER 192.168.3.154 tid=8e6bb76f9f20d26e cseq=REGISTER contact=200 / 1 from(tu)" | [10-10-20]19:47:44.164 | Debug | RESIP | "SEND: SipReq: REGISTER 192.168.3.154 tid=8e6bb76f9f20d26e cseq=REGISTER contact=200 / 1 from(tu)" | [10-10-20]19:47:44.266 | Debug | RESIP:TRANSACTION | "Adding timer: Timer F tid=8e6bb76f9f20d26e ms=32000" | [10-10-20]19:47:44.266 | Debug | RESIP:TRANSPORT | "Looking up dns entries for sip:192.168.3.154" | [10-10-20]19:47:44.266 | Debug | RESIP:DNS | "DnsResult::lookup sip:192.168.3.154" | [10-10-20]19:47:44.266 | Debug | RESIP:DNS | "Numeric result so return immediately: [ V4 192.168.3.154:5060 UDP target domain=192.168.3.154 connectionId=0 ]" | [10-10-20]19:47:44.266 | Debug | RESIP:TRANSACTION | "Adding timer: Timer E1 tid=8e6bb76f9f20d26e ms=500" | [10-10-20]19:47:44.266 | Debug | RESIP:TRANSPORT | "Looked up source for destination: [ V4 192.168.3.154:5060 UDP target domain=192.168.3.154 connectionId=0 ] -> [ V4 192.168.3.252:0 UDP target domain=192.168.3.154 connectionId=0 ] sent-by= sent-port=0" | [10-10-20]19:47:44.266 | Debug | RESIP:TRANSPORT | "findTransportBySource([ V4 192.168.3.252:0 UDP target domain=192.168.3.154 connectionId=0 ])" | [10-10-20]19:47:44.266 | Debug | RESIP:TRANSPORT | "findTransport (any port, any interface) => Transport: [ V4 0.0.0.0:5060 UDP target domain=unspecified connectionId=0 ]" | [10-10-20]19:47:44.266 | Debug | RESIP:TRANSPORT | "Transmitting to [ V4 192.168.3.154:5060 UDP target domain=192.168.3.154 received on: Transport: [ V4 0.0.0.0:5060 UDP target domain=unspecified connectionId=0 ] connectionId=0 ] tlsDomain= via [ V4 192.168.3.252:5060 UDP target domain=192.168.3.154 connectionId=0 ] REGISTER sip:192.168.3.154 SIP/2.0 Via: SIP/2.0/UDP 192.168.3.252:5060;branch=z9hG4bK-d8754z-8e6bb76f9f20d26e-1---d8754z-;rport Max-Forwards: 70 Contact: <sip:2...@192.168.3.252:5060;rinstance=41aa8105bd4c2da2> To: ""200""<sip:2...@192.168.3.154> From: ""200""<sip:2...@192.168.3.154>;tag=2478bc24 Call-ID: Y2VmZjVhMGI3Y2EwODc2MDVmNjU2M2U4MmM4ZDZjOTE. CSeq: 1 REGISTER Expires: 3600 Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, SUBSCRIBE, INFO Supported: timer User-Agent: eyeBeam release 1104a stamp 54436 Content-Length: 0 " | [10-10-20]19:47:44.266 | Debug | RESIP:TRANSPORT | "Adding message to tx buffer to: [ V4 192.168.3.154:5060 UDP target domain=192.168.3.154 received on: Transport: [ V4 0.0.0.0:5060 UDP target domain=unspecified connectionId=0 ] connectionId=0 ]" | [10-10-20]19:47:44.773 | Debug | RESIP:TRANSACTION | "Adding timer: Timer E1 tid=8e6bb76f9f20d26e ms=1000" | [10-10-20]19:47:44.773 | Debug | RESIP:TRANSPORT | "Adding message to tx buffer to: [ V4 192.168.3.154:5060 UDP target domain=192.168.3.154 received on: Transport: [ V4 0.0.0.0:5060 UDP target domain=unspecified connectionId=0 ] connectionId=0 ]" | [10-10-20]19:47:44.781 | Debug | RESIP:TRANSPORT | "incoming from: [ V4 192.168.3.154:5060 UDP target domain=unspecified received on: Transport: [ V4 0.0.0.0:5060 UDP target domain=unspecified connectionId=0 ] connectionId=0 ]" | [10-10-20]19:47:44.781 | Debug | RESIP:TRANSACTION | "Adding timer: Timer E2 tid=8e6bb76f9f20d26e ms=4000" | [10-10-20]19:47:44.781 | Debug | RESIP:DNS | "Whitelisting 192.168.3.154(1): 192.168.3.154" | [10-10-20]19:47:44.781 | Debug | RESIP:TRANSACTION | "Send to TU: TU: DialogUsageManager size=0 SIP/2.0 100 Trying Via: SIP/2.0/UDP 192.168.3.252:5060;branch=z9hG4bK-d8754z-8e6bb76f9f20d26e-1---d8754z-;rport=5060 To: ""200""<sip:2...@192.168.3.154> From: ""200""<sip:2...@192.168.3.154>;tag=2478bc24 Call-ID: Y2VmZjVhMGI3Y2EwODc2MDVmNjU2M2U4MmM4ZDZjOTE. CSeq: 1 REGISTER Content-Length: 0 " | [10-10-20]19:47:44.781 | Info | RESIP:DUM | "Got: SipResp: 100 tid=8e6bb76f9f20d26e cseq=REGISTER / 1 from(wire)" | [10-10-20]19:47:44.781 | Debug | RESIP:DUM | "DialogUsageManager::processResponse: SipResp: 100 tid=8e6bb76f9f20d26e cseq=REGISTER / 1 from(wire)" | [10-10-20]19:47:45.029 | Debug | Utilities | "Removing timer 290, m_cTimers.size() 3" | sua::CTimerManager::CancelTimer [10-10-20]19:47:45.031 | Debug | Utilities | "Adding timer291, m_cTimers.size() 4" | sua::CTimerManager::CreateTimer [10-10-20]19:47:46.029 | Info | USB Devices | "The Yealink USB control is disabled" | cpsi::CYealinkDevice::Stop [10-10-20]19:47:46.035 | Debug | Utilities | "Adding timer295, m_cTimers.size() 5" | sua::CTimerManager::CreateTimer [10-10-20]19:47:46.035 | Debug | GUI | "AUTO_UPDATE: started" | eyeBeam::CAutoUpdateClient::OnAutoUpdateNotify [10-10-20]19:47:46.043 | Info | GUI | "Receiving notification about firewall IP address: 0.0.0.0, voip always possible: 0" | eyeBeam::CPhoneFrame::OnNetworkFirewallInformation [10-10-20]19:47:47.033 | Debug | Utilities | "Removing timer 291, m_cTimers.size() 4" | sua::CTimerManager::CancelTimer [10-10-20]19:47:47.036 | Debug | Utilities | "Adding timer297, m_cTimers.size() 5" | sua::CTimerManager::CreateTimer [10-10-20]19:47:48.844 | Debug | RESIP:TRANSACTION | "Adding timer: Timer E2 tid=8e6bb76f9f20d26e ms=4000" | [10-10-20]19:47:48.844 | Debug | RESIP:TRANSPORT | "Adding message to tx buffer to: [ V4 192.168.3.154:5060 UDP target domain=192.168.3.154 received on: Transport: [ V4 0.0.0.0:5060 UDP target domain=unspecified connectionId=0 ] connectionId=0 ]" | [10-10-20]19:47:48.849 | Debug | RESIP:TRANSPORT | "incoming from: [ V4 192.168.3.154:5060 UDP target domain=unspecified received on: Transport: [ V4 0.0.0.0:5060 UDP target domain=unspecified connectionId=0 ] connectionId=0 ]" | [10-10-20]19:47:48.849 | Debug | RESIP:DNS | "Whitelisting 192.168.3.154(1): 192.168.3.154" | [10-10-20]19:47:48.849 | Debug | RESIP:DNS | "updating an existing vip: 192.168.3.154 with 192.168.3.154" | [10-10-20]19:47:48.849 | Debug | RESIP:TRANSACTION | "Send to TU: TU: DialogUsageManager size=0 SIP/2.0 100 Trying Via: SIP/2.0/UDP 192.168.3.252:5060;branch=z9hG4bK-d8754z-8e6bb76f9f20d26e-1---d8754z-;rport=5060 To: ""200""<sip:2...@192.168.3.154> From: ""200""<sip:2...@192.168.3.154>;tag=2478bc24 Call-ID: Y2VmZjVhMGI3Y2EwODc2MDVmNjU2M2U4MmM4ZDZjOTE. CSeq: 1 REGISTER Content-Length: 0 " | [10-10-20]19:47:48.849 | Info | RESIP:DUM | "Got: SipResp: 100 tid=8e6bb76f9f20d26e cseq=REGISTER / 1 from(wire)" | [10-10-20]19:47:48.849 | Debug | RESIP:DUM | "DialogUsageManager::processResponse: SipResp: 100 tid=8e6bb76f9f20d26e cseq=REGISTER / 1 from(wire)" | [10-10-20]19:47:51.039 | Debug | Utilities | "Removing timer 297, m_cTimers.size() 4" | sua::CTimerManager::CancelTimer [10-10-20]19:47:51.041 | Debug | Utilities | "Adding timer298, m_cTimers.size() 5" | sua::CTimerManager::CreateTimer [10-10-20]19:47:52.284 | Debug | RESIP:TRANSPORT | "incoming from: [ V4 192.168.3.154:5060 UDP target domain=unspecified received on: Transport: [ V4 0.0.0.0:5060 UDP target domain=unspecified connectionId=0 ] connectionId=0 ]" | [10-10-20]19:47:52.284 | Debug | RESIP:TRANSACTION | "Send to TU: TU: DialogUsageManager size=0 SIP/2.0 408 Request timeout Via: SIP/2.0/UDP 192.168.3.252:5060;branch=z9hG4bK-d8754z-8e6bb76f9f20d26e-1---d8754z-;rport=5060 To: ""200""<sip:2...@192.168.3.154>;tag=S6jZBG From: ""200""<sip:2...@192.168.3.154>;tag=2478bc24 Call-ID: Y2VmZjVhMGI3Y2EwODc2MDVmNjU2M2U4MmM4ZDZjOTE. CSeq: 1 REGISTER Server: sipXecs/4.2.1 sipXecs/sipXproxy (Linux) Content-Length: 0 " | [10-10-20]19:47:52.284 | Debug | RESIP:TRANSACTION | "Adding timer: Timer K tid=8e6bb76f9f20d26e ms=5000" | [10-10-20]19:47:52.284 | Info | RESIP:DUM | "Got: SipResp: 408 tid=8e6bb76f9f20d26e cseq=REGISTER / 1 from(wire)" | [10-10-20]19:47:52.284 | Debug | RESIP:DUM | "DialogUsageManager::processResponse: SipResp: 408 tid=8e6bb76f9f20d26e cseq=REGISTER / 1 from(wire)" | [10-10-20]19:47:52.284 | Debug | RESIP:DUM | "DialogId::DialogId: Y2VmZjVhMGI3Y2EwODc2MDVmNjU2M2U4MmM4ZDZjOTE.-2478bc24-S6jZBG" | [10-10-20]19:47:52.284 | Debug | RESIP:DUM | "First keep alive for: [ V4 192.168.3.154:5060 UDP target domain=unspecified received on: Transport: [ V4 0.0.0.0:5060 UDP target domain=unspecified connectionId=0 ] connectionId=0 ]" | [10-10-20]19:47:52.284 | Debug | RESIP:DUM | "Keepalive interval 30 seconds" | [10-10-20]19:47:52.284 | Debug | RESIP:DUM | "Keepalive id 0" | [10-10-20]19:47:52.284 | Debug | RESIP:TRANSACTION | "Adding application timer: [ V4 192.168.3.154:5060 UDP target domain=unspecified received on: Transport: [ V4 0.0.0.0:5060 UDP target domain=unspecified connectionId=0 ] connectionId=0 ](0)" | [10-10-20]19:47:52.284 | Debug | RESIP:DUM | "Registration retry requestd for 192.168.3.154" | [10-10-20]19:47:52.284 | Debug | CCM | "SipResp: 408 tid=8e6bb76f9f20d26e cseq=REGISTER / 1 from(wire)[URI:2...@192.168.3.154]" | sua::CSIPRegistration::onRequestRetry [10-10-20]19:47:52.284 | Debug | CCM | "SipResp: 408 tid=8e6bb76f9f20d26e cseq=REGISTER / 1 from(wire) [URI:2...@192.168.3.154]" | sua::CTransportMonitorUsingRegistration::OnSIPRegistrationFailure [10-10-20]19:47:52.284 | Debug | RESIP:DUM | "Application requested delayed retry on 408: 32" | [10-10-20]19:47:52.284 | Debug | RESIP:TRANSACTION | "Adding application timer: DumTimeout::RegistrationRetry ClientRegistration sip:2...@192.168.3.154: duration=32 seq=1" | [10-10-20]19:47:52.285 | Debug | AbstractPhone | "[...@192.168.3.154]::OnSIPRegistrationAttemptFailed" | AbPhone::CAccount::CCCMSink::OnSIPRegistrationAttemptFailed [10-10-20]19:47:52.285 | Debug | CCM | "[state:EState_Ready][T|T] [URI:2...@192.168.3.154]" | sua::CSIPAccess::OnRegistrationTimedoutRecommendingDUMRestart [10-10-20]19:47:52.285 | Debug | CCM | "[state:EState_Ready][T|T] [URI:2...@192.168.3.154]" | sua::CSIPAccess::DoWorkForRestartDUMEvent [10-10-20]19:47:52.285 | Debug | CCM | "[state:ERunning]" | sua::CSIPDUMWrapper::ShutdownDUM [10-10-20]19:47:52.285 | Debug | Utilities | "Adding timer303, m_cTimers.size() 6" | sua::CTimerManager::CreateTimer [10-10-20]19:47:52.285 | Info | RESIP:DUM | "shutdown: dialogSets=1" | [10-10-20]19:47:52.285 | Debug | RESIP:DUM | "Shutdown waiting for all usages to be deleted (2)" | [10-10-20]19:47:52.285 | Debug | RESIP:DUM | "1 -> AppDialogSet 1" | [10-10-20]19:47:52.285 | Debug | RESIP:DUM | "2 -> ClientRegistration sip:2...@192.168.3.154" | [10-10-20]19:47:52.385 | Info | RESIP:TRANSACTION | "TransactionUserMessage::RequestShutdown TU: DialogUsageManager size=0" |
_______________________________________________ sipx-users mailing list sipx-users@list.sipfoundry.org List Archive: http://list.sipfoundry.org/archive/sipx-users/