Nonce is not taken in Authorization header of REGISTER about doubango

[GoogleCodeExporter]

Hi,
As you are using IMSDroid I have transferred the issue to that tracker.
Here is the link: http://code.google.com/p/imsdroid/issues/detail?id=43
Could you please attach the capture trace (Wireshark)? 

Original comment by [email protected] on 25 Aug 2010 at 11:15

• Changed state: Accepted

[GoogleCodeExporter]

BTW, I have the same issue on some commercial deployments. They are using 
Alcatel-Lucent servers. Are you using the same server?

Original comment by [email protected] on 25 Aug 2010 at 11:19

[GoogleCodeExporter]

Hi, Thank you very much for the quick response!

See attachment for the wireshark trace for this scenario.

Thanks,

Original comment by [email protected] on 25 Aug 2010 at 11:29

Attachments:

• imsdroid.dump

[GoogleCodeExporter]

[deleted comment]

[GoogleCodeExporter]

OK. You are using ALU servers. See comment 2.
I'm already working on the issue.
Could you please test this version: 
http://imsdroid.googlecode.com/svn/trunk/debug/imsdroid-debug-1.0.214.apk

Original comment by [email protected] on 25 Aug 2010 at 11:45

[GoogleCodeExporter]

Hi,

Thanks again!

It is still failed, I find following errors in the log file:

08-25 20:20:24.439: ERROR/tinyWRAP(7102): MSG: Failed to parse header -    
nonce="b4c750abe7c9036dbf3054aea940e9703dc8f84c0108",
08-25 20:20:24.439: ERROR/tinyWRAP(7102):    
opaque="Lss:scsf-stdn.imsgroup0-000.lcp.sd.ctcims.cn:5061",
08-25 20:20:24.439: ERROR/tinyWRAP(7102):    algorithm=MD5,
08-25 20:20:24.439: ERROR/tinyWRAP(7102):    qop="auth"
08-25 20:20:24.439: ERROR/tinyWRAP(7102): Content-Length: 0
08-25 20:20:24.439: ERROR/tinyWRAP(7102): 
08-25 20:20:24.439: ERROR/tinyWRAP(7102): p�
08-25 20:20:24.449: ERROR/tinyWRAP(7102): ***ERROR: function: 
"tsip_message_parser_execute()" 
08-25 20:20:24.449: ERROR/tinyWRAP(7102): file: 
"src/parsers/tsip_parser_message.c" 
08-25 20:20:24.449: ERROR/tinyWRAP(7102): line: "401" 
08-25 20:20:24.449: ERROR/tinyWRAP(7102): MSG: Failed to parse header -    
opaque="Lss:scsf-stdn.imsgroup0-000.lcp.sd.ctcims.cn:5061",
08-25 20:20:24.449: ERROR/tinyWRAP(7102):    algorithm=MD5,
08-25 20:20:24.449: ERROR/tinyWRAP(7102):    qop="auth"
08-25 20:20:24.449: ERROR/tinyWRAP(7102): Content-Length: 0
08-25 20:20:24.449: ERROR/tinyWRAP(7102): 
08-25 20:20:24.449: ERROR/tinyWRAP(7102): p�
08-25 20:20:24.449: ERROR/tinyWRAP(7102): ***ERROR: function: 
"tsip_message_parser_execute()" 
08-25 20:20:24.449: ERROR/tinyWRAP(7102): file: 
"src/parsers/tsip_parser_message.c" 
08-25 20:20:24.449: ERROR/tinyWRAP(7102): line: "401" 
08-25 20:20:24.449: ERROR/tinyWRAP(7102): MSG: Failed to parse header -    
algorithm=MD5,
08-25 20:20:24.449: ERROR/tinyWRAP(7102):    qop="auth"
08-25 20:20:24.449: ERROR/tinyWRAP(7102): Content-Length: 0
08-25 20:20:24.449: ERROR/tinyWRAP(7102): 
08-25 20:20:24.449: ERROR/tinyWRAP(7102): p�
08-25 20:20:24.449: ERROR/tinyWRAP(7102): ***ERROR: function: 
"tsip_message_parser_execute()" 
08-25 20:20:24.449: ERROR/tinyWRAP(7102): file: 
"src/parsers/tsip_parser_message.c" 
08-25 20:20:24.449: ERROR/tinyWRAP(7102): line: "401" 
08-25 20:20:24.449: ERROR/tinyWRAP(7102): MSG: Failed to parse header -    
qop="auth"
08-25 20:20:24.449: ERROR/tinyWRAP(7102): Content-Length: 0
08-25 20:20:24.449: ERROR/tinyWRAP(7102): 
08-25 20:20:24.449: ERROR/tinyWRAP(7102): p�
08-25 20:20:24.459: DEBUG/org.doubango.imsdroid.Services.Impl.SipService(7102): 
OnDialogEvent ((un)REGISTER request successfully sent.)
08-25 20:20:24.650: INFO/tinyWRAP(7102): *INFO: === REGISTER Dialog terminated 
===
08-25 20:20:24.650: INFO/tinyWRAP(7102): *INFO: == Shutting down - Phase-1 
completed ==
08-25 20:20:24.659: DEBUG/org.doubango.imsdroid.Services.Impl.SipService(7102): 
OnDialogEvent (Forbidden)
08-25 20:20:24.669: INFO/org.doubango.imsdroid.Main(7102): onRegistrationEvent
08-25 20:20:24.679: INFO/org.doubango.imsdroid.Screens.ScreenHome(7102): 
onRegistrationEvent
08-25 20:20:24.699: 
INFO/org.doubango.imsdroid.Services.Impl.ServiceManager(7102): 
onRegistrationEvent
08-25 20:20:24.699: 
DEBUG/org.doubango.imsdroid.Services.Impl.ServiceManager(7102): 
showRegistartionNotif
08-25 20:20:24.709: DEBUG/WifiService(101): releaseWifiLockLocked: 
WifiLock{org.doubango.imsdroid.Services.Impl.NetworkService type=1 
binder=android.os.BinderProxy@465e5e80}
08-25 20:20:24.709: INFO/tinyWRAP(7102): *INFO: Timer manager run()::exit
08-25 20:20:24.719: INFO/tinyWRAP(7102): *INFO: TIMER MANAGER -- STOP
08-25 20:20:24.729: INFO/tinyWRAP(7102): *INFO: Transport::run() - exit
08-25 20:20:24.729: INFO/tinyWRAP(7102): *INFO: Stopped [SIP transport] server 
with IP {192.168.1.5} on port {50004}...
08-25 20:20:24.729: INFO/tinyWRAP(7102): *INFO: Socket removed
08-25 20:20:24.729: INFO/tinyWRAP(7102): *INFO: Socket removed
08-25 20:20:24.729: DEBUG/org.doubango.imsdroid.Services.Impl.SipService(7102): 
Stack stoped
08-25 20:20:24.729: INFO/tinyWRAP(7102): *INFO: SIP STACK::run -- STOP
08-25 20:20:24.729: INFO/tinyWRAP(7102): *INFO: SIP STACK -- STOP

Original comment by [email protected] on 25 Aug 2010 at 12:22

[GoogleCodeExporter]

Is it possible to have the trace with this version (264)?

Original comment by [email protected] on 25 Aug 2010 at 12:28

[GoogleCodeExporter]

I will get the trace tomorrow, I can only get it in another lab.

Original comment by [email protected] on 25 Aug 2010 at 12:31

[GoogleCodeExporter]

The 'nonce' is still not in second REGISTER base on the dump.

See attachment for the new dump file.

Original comment by [email protected] on 26 Aug 2010 at 12:52

Attachments:

• imsdroid.264.dump

[GoogleCodeExporter]

I'm investigating the issue.
The problem is that the "WWW-Authenticate" header sent from your server is 
incorrect according to its ABNF.

Original comment by [email protected] on 26 Aug 2010 at 4:29

[GoogleCodeExporter]

could you share what's wrong with the "WWW-Authenticate" in 401?

We have no interworking issues for a lot of SIP soft phones including another 
Android client SipDroid.

Thanks,

Original comment by [email protected] on 26 Aug 2010 at 5:27

[GoogleCodeExporter]

The stack (doubango) has also been tested against several IMS Cores. I only 
have problems with ALU servers.
Here is the ABNF for the header (same as RFC 3261): 
http://www.tech-invite.com/Ti-abnf-sip-hf.html#WWW-Authenticate
Challenge is defined like this: challenge   =   ("Digest" LWS  digest-cln  
*(COMMA  digest-cln)) / other-challenge
This means that you cannot have CRLF between "digest-cln", only COMMA should be 
used as separator.
If you have Eclipse and can rebuild the source code it could help me to resolve 
the issue. Off course I will send you some patches.

Original comment by [email protected] on 26 Aug 2010 at 5:36

[GoogleCodeExporter]

According to RFC 3261 Section 7.3.1., Header fields can be extended over 
multiple lines by preceding each extra line with at least one SP or horizontal 
tab (HT). The line break and the whitespace at the beginning of the next line 
are
treated as a single SP character.

if we look at 20.44 WWW-Authenticate

   A WWW-Authenticate header field value contains an authentication
   challenge.  See Section 22.2 for further details on its usage.

   Example:

      WWW-Authenticate: Digest realm="atlanta.com",
        domain="sip:boxesbybob.com", qop="auth",
        nonce="f84f1cec41e6cbe5aea9c8e88d359",
        opaque="", stale=FALSE, algorithm=MD5

it is also possible to have 0X0D0A after ","

Thanks

Original comment by [email protected] on 26 Aug 2010 at 7:36

[GoogleCodeExporter]

Hi,

My Exlipse is ready for imsdroid, could you send me the patches to solve this 
issue.

Thanks a lot!

Original comment by [email protected] on 27 Aug 2010 at 12:40

[GoogleCodeExporter]

any update?

Original comment by [email protected] on 30 Aug 2010 at 10:15

[GoogleCodeExporter]

Pushed new version (1.0.271). Could you please try with it and send me both 
Eclipse and network traces?
Thanks

Original comment by [email protected] on 30 Aug 2010 at 10:18

[GoogleCodeExporter]

Hi, Thank you very much for the fix! 

The register is successful now.

See attachment for network trace and android trace as following:

08-31 12:01:49.084: INFO/org.doubango.imsdroid.Services.Impl.SipService(254): 
realm=sip:gll03.lucentlab.com, impu=sip:[email protected], 
[email protected]
08-31 12:01:49.123: INFO/org.doubango.imsdroid.Services.Impl.SipService(254): 
pcscf-host=135.2.121.85, pcscf-port=5060, transport=UDP, ipversion=ipv4
08-31 12:01:49.142: INFO/NotificationService(65): enqueueToast 
pkg=org.doubango.imsdroid 
callback=android.app.ITransientNotification$Stub$Proxy@43c03228 duration=0
08-31 12:01:49.175: DEBUG/org.doubango.imsdroid.Services.Impl.SipService(254): 
Stack started
08-31 12:01:49.182: DEBUG/org.doubango.imsdroid.Services.Impl.SipService(254): 
OnDialogEvent (Dialog connecting)
08-31 12:01:49.222: 
INFO/org.doubango.imsdroid.Services.Impl.ServiceManager(254): 
onRegistrationEvent
08-31 12:01:49.232: 
DEBUG/org.doubango.imsdroid.Services.Impl.ServiceManager(254): 
showRegistartionNotif
08-31 12:01:49.253: INFO/org.doubango.imsdroid.Main(254): onRegistrationEvent
08-31 12:01:49.283: DEBUG/org.doubango.imsdroid.Services.Impl.SipService(254): 
OnDialogEvent ((un)REGISTER request successfully sent.)
08-31 12:01:49.283: INFO/org.doubango.imsdroid.Screens.ScreenHome(254): 
onRegistrationEvent
08-31 12:01:49.573: ERROR/tinyWRAP(254): ***ERROR: function: 
"tsip_header_Dummy_parse()" 
08-31 12:01:49.573: ERROR/tinyWRAP(254): file: 
"src/headers/tsip_header_Dummy.c" 
08-31 12:01:49.573: ERROR/tinyWRAP(254): line: "271" 
08-31 12:01:49.573: ERROR/tinyWRAP(254): MSG: Failed to parse 'Dummy' header.
08-31 12:01:49.593: DEBUG/org.doubango.imsdroid.Services.Impl.SipService(254): 
OnDialogEvent ((un)REGISTER request successfully sent.)
08-31 12:01:49.993: DEBUG/org.doubango.imsdroid.Services.Impl.SipService(254): 
OnDialogEvent (Dialog connected)
08-31 12:01:50.002: DEBUG/org.doubango.imsdroid.Services.Impl.SipService(254): 
Doing post registration operations
08-31 12:01:50.023: 
DEBUG/org.doubango.imsdroid.Services.Impl.HistoryService(254): Loading history
08-31 12:01:50.033: 
DEBUG/org.doubango.imsdroid.Services.Impl.ContactService(254): Loading contacts 
(local)
08-31 12:01:50.234: DEBUG/dalvikvm(254): GC freed 11500 objects / 588952 bytes 
in 155ms
08-31 12:01:50.234: 
INFO/org.doubango.imsdroid.Services.Impl.ServiceManager(254): 
onRegistrationEvent
08-31 12:01:50.234: 
DEBUG/org.doubango.imsdroid.Services.Impl.ServiceManager(254): 
showRegistartionNotif
08-31 12:01:50.283: 
DEBUG/org.doubango.imsdroid.Services.Impl.ContactService(254): Contacts 
loaded(local)
08-31 12:01:50.325: INFO/org.doubango.imsdroid.Main(254): onRegistrationEvent
08-31 12:01:50.364: DEBUG/org.doubango.imsdroid.Services.Impl.SipService(254): 
OnDialogEvent (Dialog connecting)
08-31 12:01:50.364: INFO/org.doubango.imsdroid.Screens.ScreenHome(254): 
onRegistrationEvent
08-31 12:01:50.404: DEBUG/org.doubango.imsdroid.Services.Impl.SipService(254): 
OnDialogEvent (Dialog terminated)
08-31 12:01:50.432: 
DEBUG/org.doubango.imsdroid.Services.Impl.HistoryService(254): History loaded
08-31 12:01:50.632: DEBUG/dalvikvm(254): +++ not scanning 
'/system/lib/libwebcore.so' for 'delete_CallSession' (wrong CL)
08-31 12:01:50.642: DEBUG/dalvikvm(254): +++ not scanning 
'/system/lib/libmedia_jni.so' for 'delete_CallSession' (wrong CL)
08-31 12:01:50.642: DEBUG/dalvikvm(254): +++ not scanning 
'/system/lib/libexif.so' for 'delete_CallSession' (wrong CL)
08-31 12:01:50.642: DEBUG/dalvikvm(254): +++ not scanning 
'/system/lib/libsrec_jni.so' for 'delete_CallSession' (wrong CL)

Original comment by [email protected] on 31 Aug 2010 at 5:13

Attachments:

• imsdroid.good.dump

[GoogleCodeExporter]

Original comment by [email protected] on 1 Sep 2010 at 6:57

• Changed state: Fixed