search

opentelecoms-org / jscommunicator

http://jscommunicator.org
88 stars 48 forks source link

ERROR: SIP Registration failure. #70

Closed soundart closed 5 years ago

soundart commented 9 years ago

Hi,

I spent the day trying to get webrtc going, but now I am stuck.

my setup: Basically I followed http://www.rtcquickstart.org/ with small variations. I skipped however the DNS setup stuff. I am using repro as sip proxy. I can make calls with jitsi and empathy.

jsscommunicator does not seem to work for me. I always get the SIP Registration on the phone.shtml pagefailure.

I have increased the log level of repro and it complains too:

REGISTER sip:spirou.hh.de SIP/2.0
Via: SIP/2.0/WS c4nuv9hulu9f.invalid;branch=z9hG4bK9564909;received=192.168.168.97
Max-Forwards: 69
Contact: <sip:89gn6a0i@c4nuv9hulu9f.invalid;transport=ws>;+sip.ice;reg-id=1;+sip.instance="<urn:uuid:722f588d-e0de-43a4-a72b-2c9973011dc7>";expires=3600
To: <sip:web@spirou.hh.de>
From: <sip:web@spirou.hh.de>;tag=qivdl4evkp
Call-ID: 1mopiqpdgdrucf1td56cq6
CSeq: 1 REGISTER
Expires: 3600
Allow: INVITE, ACK, CANCEL, BYE, UPDATE, MESSAGE, OPTIONS
Supported: path, gruu, outbound
User-Agent: JsSIP 0.5.0
Content-Length: 0

DEBUG | 20141218-165938.945 | repro | RESIP:TRANSACTION | 140341293410048 | TransactionUser.cxx:87 | Match!
DEBUG | 20141218-165938.945 | repro | RESIP | 140341293410048 | Helper.cxx:374 | Helper::makeResponse(SipReq:  REGISTER spirou.hh.de tid=9564909 cseq=1 REGISTER contact=89gn6a0i@c4nuv9hulu9f.invalid / 1 from(wire) code=100 reason=
DEBUG | 20141218-165938.945 | repro | RESIP:TRANSACTION | 140341293410048 | TimerQueue.cxx:50 | Adding timer: Timer Trying tid=9564909 ms=3500
DEBUG | 20141218-165938.945 | repro | RESIP:TRANSACTION | 140341293410048 | TuSelector.cxx:70 | Send to TU: TU: DialogUsageManager size=0

REGISTER sip:spirou.hh.de SIP/2.0
Via: SIP/2.0/WS c4nuv9hulu9f.invalid;branch=z9hG4bK9564909;received=192.168.168.97
Max-Forwards: 69
Contact: <sip:89gn6a0i@c4nuv9hulu9f.invalid;transport=ws>;+sip.ice;reg-id=1;+sip.instance="<urn:uuid:722f588d-e0de-43a4-a72b-2c9973011dc7>";expires=3600
To: <sip:web@spirou.hh.de>
From: <sip:web@spirou.hh.de>;tag=qivdl4evkp
Call-ID: 1mopiqpdgdrucf1td56cq6
CSeq: 1 REGISTER
Expires: 3600
Allow: INVITE, ACK, CANCEL, BYE, UPDATE, MESSAGE, OPTIONS
Supported: path, gruu, outbound
User-Agent: JsSIP 0.5.0
Content-Length: 0

INFO | 20141218-165938.945 | repro | REPRO:APP | 140341268231936 | AclStore.cxx:558 | AclStore - source address NOT trusted: 192.168.168.97:47721 WS
DEBUG | 20141218-165938.945 | repro | RESIP | 140341268231936 | Helper.cxx:374 | Helper::makeResponse(SipReq:  REGISTER spirou.hh.de tid=9564909 cseq=1 REGISTER contact=89gn6a0i@c4nuv9hulu9f.invalid / 1 from(wire) code=407 reason=
INFO | 20141218-165938.945 | repro | RESIP:DUM | 140341268231936 | ServerAuthManager.cxx:460 | Sending challenge to SipReq:  REGISTER spirou.hh.de tid=9564909 cseq=1 REGISTER contact=89gn6a0i@c4nuv9hulu9f.invalid / 1 from(wire)
DEBUG | 20141218-165938.945 | repro | RESIP:DUM | 140341268231936 | DialogUsageManager.cxx:983 | SEND:

SIP/2.0 407 Proxy Authentication Required
Via: SIP/2.0/WS c4nuv9hulu9f.invalid;branch=z9hG4bK9564909;received=192.168.168.97
Proxy-Authenticate: Digest nonce="1418918378:24df2c666f01f1bccd6c9d526229c961",algorithm=MD5,realm="spirou.hh.de",qop="auth,auth-int"
To: <sip:web@spirou.hh.de>;tag=8310bf65
From: <sip:web@spirou.hh.de>;tag=qivdl4evkp
Call-ID: 1mopiqpdgdrucf1td56cq6
CSeq: 1 REGISTER
User-Agent: repro 1.9.7
Content-Length: 0

DEBUG | 20141218-165938.945 | repro | RESIP | 140341268231936 | SipStack.cxx:594 | SEND: SipResp: 407 tid=9564909 cseq=1 REGISTER / 1 from(tu)
INFO | 20141218-165938.945 | repro | RESIP:DUM | 140341268231936 | ServerAuthManager.cxx:47 | ServerAuth challenged request SipReq:  REGISTER spirou.hh.de tid=9564909 cseq=1 REGISTER contact=89gn6a0i@c4nuv9hulu9f.invalid / 1 from(wire)
DEBUG | 20141218-165938.945 | repro | RESIP:TRANSPORT | 140341293410048 | TransportSelector.cxx:1178 | Transmitting to [ V4 192.168.168.97:47721 WS target domain=unspecified mFlowKey=32 ] tlsDomain= via [ V4 192.168.168.21:5062 WS target domain=unspecified mFlowKey=0 ]

SIP/2.0 407 Proxy Authentication Required
Via: SIP/2.0/WS c4nuv9hulu9f.invalid;branch=z9hG4bK9564909;received=192.168.168.97
Proxy-Authenticate: Digest nonce="1418918378:24df2c666f01f1bccd6c9d526229c961",algorithm=MD5,realm="spirou.hh.de",qop="auth,auth-int"
To: <sip:web@spirou.hh.de>;tag=8310bf65
From: <sip:web@spirou.hh.de>;tag=qivdl4evkp
Call-ID: 1mopiqpdgdrucf1td56cq6
CSeq: 1 REGISTER
User-Agent: repro 1.9.7
Content-Length: 0

sigcomp id=
DEBUG | 20141218-165938.946 | repro | RESIP:TRANSPORT | 140341285017344 | TcpBaseTransport.cxx:283 | Processing write for [ V4 192.168.168.97:47721 WS target domain=unspecified mFlowKey=32 ]
DEBUG | 20141218-165938.946 | repro | RESIP:TRANSPORT | 140341285017344 | ConnectionManager.cxx:65 | Found fd 32
DEBUG | 20141218-165938.961 | repro | RESIP:TRANSPORT | 140341285017344 | Transport.cxx:382 | incoming from: [ V4 192.168.168.97:47721 WS target domain=unspecified mFlowKey=32 ]
DEBUG | 20141218-165938.961 | repro | RESIP:TRANSPORT | 140341285017344 | Connection.cxx:387 | Connection::performReads()  read=812
DEBUG | 20141218-165938.961 | repro | RESIP:TRANSACTION | 140341293410048 | TransactionUser.cxx:79 | Checking if SipReq:  REGISTER spirou.hh.de tid=5578936 cseq=2 REGISTER contact=89gn6a0i@c4nuv9hulu9f.invalid / 2 from(wire) is for me
DEBUG | 20141218-165938.962 | repro | RESIP:TRANSACTION | 140341293410048 | TransactionUser.cxx:84 | Checking rule...
DEBUG | 20141218-165938.962 | repro | RESIP:TRANSACTION | 140341293410048 | MessageFilterRule.cxx:45 | Matching rule for:

REGISTER sip:spirou.hh.de SIP/2.0
Via: SIP/2.0/WS c4nuv9hulu9f.invalid;branch=z9hG4bK5578936;received=192.168.168.97
Max-Forwards: 69
Contact: <sip:89gn6a0i@c4nuv9hulu9f.invalid;transport=ws>;+sip.ice;reg-id=1;+sip.instance="<urn:uuid:722f588d-e0de-43a4-a72b-2c9973011dc7>";expires=3600
To: <sip:web@spirou.hh.de>
From: <sip:web@spirou.hh.de>;tag=qivdl4evkp
Call-ID: 1mopiqpdgdrucf1td56cq6
CSeq: 2 REGISTER
Expires: 3600
Allow: INVITE, ACK, CANCEL, BYE, UPDATE, MESSAGE, OPTIONS
Proxy-Authorization: Digest algorithm=MD5, username="web@spirou.hh.de", realm="spirou.hh.de", nonce="1418918378:24df2c666f01f1bccd6c9d526229c961", uri="sip:spirou.hh.de", response="106f41f6aee674371a89c9b6b6571e34", qop=auth, cnonce="hqrhaad85lcv", nc=00000001
Supported: path, gruu, outbound
User-Agent: JsSIP 0.5.0
Content-Length: 0

DEBUG | 20141218-165938.962 | repro | RESIP:TRANSACTION | 140341293410048 | TransactionUser.cxx:87 | Match!
DEBUG | 20141218-165938.962 | repro | RESIP | 140341293410048 | Helper.cxx:374 | Helper::makeResponse(SipReq:  REGISTER spirou.hh.de tid=5578936 cseq=2 REGISTER contact=89gn6a0i@c4nuv9hulu9f.invalid / 2 from(wire) code=100 reason=
DEBUG | 20141218-165938.962 | repro | RESIP:TRANSACTION | 140341293410048 | TimerQueue.cxx:50 | Adding timer: Timer Trying tid=5578936 ms=3500
DEBUG | 20141218-165938.962 | repro | RESIP:TRANSACTION | 140341293410048 | TuSelector.cxx:70 | Send to TU: TU: DialogUsageManager size=0

REGISTER sip:spirou.hh.de SIP/2.0
Via: SIP/2.0/WS c4nuv9hulu9f.invalid;branch=z9hG4bK5578936;received=192.168.168.97
Max-Forwards: 69
Contact: <sip:89gn6a0i@c4nuv9hulu9f.invalid;transport=ws>;+sip.ice;reg-id=1;+sip.instance="<urn:uuid:722f588d-e0de-43a4-a72b-2c9973011dc7>";expires=3600
To: <sip:web@spirou.hh.de>
From: <sip:web@spirou.hh.de>;tag=qivdl4evkp
Call-ID: 1mopiqpdgdrucf1td56cq6
CSeq: 2 REGISTER
Expires: 3600
Allow: INVITE, ACK, CANCEL, BYE, UPDATE, MESSAGE, OPTIONS
Proxy-Authorization: Digest algorithm=MD5, username="web@spirou.hh.de", realm="spirou.hh.de", nonce="1418918378:24df2c666f01f1bccd6c9d526229c961", uri="sip:spirou.hh.de", response="106f41f6aee674371a89c9b6b6571e34", qop=auth, cnonce="hqrhaad85lcv", nc=00000001
Supported: path, gruu, outbound
User-Agent: JsSIP 0.5.0
Content-Length: 0

INFO | 20141218-165938.962 | repro | RESIP:DUM | 140341268231936 | ServerAuthManager.cxx:402 | Requesting credential for web@spirou.hh.de @ spirou.hh.de
INFO | 20141218-165938.962 | repro | RESIP:DUM | 140341268231936 | ServerAuthManager.cxx:53 | ServerAuth requested credentials SipReq:  REGISTER spirou.hh.de tid=5578936 cseq=2 REGISTER contact=89gn6a0i@c4nuv9hulu9f.invalid / 2 from(wire)
DEBUG | 20141218-165938.962 | repro | REPRO:APP | 140341335373568 | UserAuthGrabber.hxx:48 | Grabbed user info for web@spirou.hh.de@spirou.hh.de :
DEBUG | 20141218-165938.962 | repro | RESIP:TRANSACTION | 140341335373568 | TuSelector.cxx:70 | Send to TU: TU: DialogUsageManager size=0

UserAuthInfo web@spirou.hh.de @ spirou.hh.de A1=
INFO | 20141218-165938.962 | repro | RESIP:DUM | 140341268231936 | ServerAuthManager.cxx:131 | Checking for auth result in realm=spirou.hh.de A1=
INFO | 20141218-165938.962 | repro | RESIP:DUM | 140341268231936 | ServerAuthManager.cxx:136 | User unknown web@spirou.hh.de in spirou.hh.de
DEBUG | 20141218-165938.962 | repro | RESIP | 140341268231936 | Helper.cxx:374 | Helper::makeResponse(SipReq:  REGISTER spirou.hh.de tid=5578936 cseq=2 REGISTER contact=89gn6a0i@c4nuv9hulu9f.invalid / 2 from(wire) code=404 reason=User unknown.
DEBUG | 20141218-165938.962 | repro | RESIP:DUM | 140341268231936 | DialogUsageManager.cxx:983 | SEND:

SIP/2.0 404 User unknown.
Via: SIP/2.0/WS c4nuv9hulu9f.invalid;branch=z9hG4bK5578936;received=192.168.168.97
To: <sip:web@spirou.hh.de>;tag=a53ad358
From: <sip:web@spirou.hh.de>;tag=qivdl4evkp
Call-ID: 1mopiqpdgdrucf1td56cq6
CSeq: 2 REGISTER
User-Agent: repro 1.9.7
Content-Length: 0

DEBUG | 20141218-165938.962 | repro | RESIP | 140341268231936 | SipStack.cxx:594 | SEND: SipResp: 404 tid=5578936 cseq=2 REGISTER / 2 from(tu)
INFO | 20141218-165938.962 | repro | RESIP:DUM | 140341268231936 | ServerAuthManager.cxx:112 | ServerAuth rejected request UserAuthInfo web@spirou.hh.de @ spirou.hh.de A1=
DEBUG | 20141218-165938.962 | repro | RESIP:TRANSPORT | 140341293410048 | TransportSelector.cxx:1178 | Transmitting to [ V4 192.168.168.97:47721 WS target domain=unspecified mFlowKey=32 ] tlsDomain= via [ V4 192.168.168.21:5062 WS target domain=unspecified mFlowKey=0 ]

SIP/2.0 404 User unknown.
Via: SIP/2.0/WS c4nuv9hulu9f.invalid;branch=z9hG4bK5578936;received=192.168.168.97
To: <sip:web@spirou.hh.de>;tag=a53ad358
From: <sip:web@spirou.hh.de>;tag=qivdl4evkp
Call-ID: 1mopiqpdgdrucf1td56cq6
CSeq: 2 REGISTER
User-Agent: repro 1.9.7
Content-Length: 0

sigcomp id=
DEBUG | 20141218-165938.962 | repro | RESIP:TRANSPORT | 140341285017344 | TcpBaseTransport.cxx:283 | Processing write for [ V4 192.168.168.97:47721 WS target domain=unspecified mFlowKey=32 ]
DEBUG | 20141218-165938.962 | repro | RESIP:TRANSPORT | 140341285017344 | ConnectionManager.cxx:65 | Found fd 32

´´´

However I have a user "web" added to the repro-webinterface. Users "win" and "lin" work in jitsi and empathy. The line UserAuthInfo web@spirou.hh.de @ spirou.hh.de looks funny...

but I have no idea howto fix this.
soundart commented 9 years ago

Hi,

I got the authentication working: There is a settings in the javascript part influencing the auth name. Still calling is not possible.

I have setup a bind9 instance in the meantime which serves the settings from rtcquickstart.org.

Debugging this is really hard :)