[Serusers] radius issue

'Jan Janak' jan at iptel.org
Wed Mar 31 16:32:23 CEST 2004


According to the logs ser even did not try to contact the radius server,
beucase there are no digest credentials in the message. When a UA gets
401 Unauthorized it should resend the same request with digest
credentials. This did not happen, according to the logs.

  Jan.

On 31-03 09:28, Morris, Scott wrote:
> So it would then be a radiusclient problem?  We checked the radius server,
> and the logs don't show that the SER server is communicating at all with it.
> 
> Scott Morris
> Enterprise Network Engineer
> DOE - ORAU / ORISE
> 865-576-4672
> 
> 
> -----Original Message-----
> From: 'Jan Janak' [mailto:jan at iptel.org] 
> Sent: Wednesday, March 31, 2004 8:25 AM
> To: Morris, Scott
> Cc: serusers at lists.iptel.org
> Subject: Re: [Serusers] radius issue
> 
> 
> It does not show anything wrong. SER gets a REGISTER message and because
> there are no digest credentials it sends 401.
> 
>  Jan.
> 
> On 30-03 16:33, Morris, Scott wrote:
> > Message Dump - See below
> > 
> > Scott Morris
> > Enterprise Network Engineer
> > DOE - ORAU / ORISE
> > 865-576-4672
> > 
> > 
> > 
> > [root at comm01 ser]# ser restart
> >  0(9050) loading module /usr/lib/ser/modules/sl.so
> >  0(9050) loading module /usr/lib/ser/modules/tm.so
> >  0(9050) loading module /usr/lib/ser/modules/rr.so
> >  0(9050) loading module /usr/lib/ser/modules/maxfwd.so
> >  0(9050) loading module /usr/lib/ser/modules/usrloc.so
> >  0(9050) loading module /usr/lib/ser/modules/registrar.so
> >  0(9050) loading module /usr/lib/ser/modules/auth.so
> >  0(9050) loading module /usr/lib/ser/modules/auth_radius.so
> >  0(9050) set_mod_param_regex: usrloc matches module usrloc
> >  0(9050) set_mod_param_regex: found <db_mode> in module usrloc 
> > [/usr/lib/ser/modules/usrloc.so]
> >  0(9050) set_mod_param_regex: rr matches module rr
> >  0(9050) set_mod_param_regex: found <enable_full_lr> in module rr 
> > [/usr/lib/ser/modules/rr.so]
> >  0(9050) set_mod_param_regex: auth_radius matches module auth_radius
> >  0(9050) set_mod_param_regex: found <radius_config> in module 
> > auth_radius [/usr/lib/ser/modules/auth_radius.so]
> >  0(9050) set_mod_param_regex: auth_radius matches module auth_radius
> >  0(9050) set_mod_param_regex: found <service_type> in module 
> > auth_radius [/usr/lib/ser/modules/auth_radius.so]
> >  0(9050) find_export: found <mf_process_maxfwd_header> in module 
> > maxfwd_module [/usr/lib/ser/modules/maxfwd.so]
> >  0(9050) find_export: found <sl_send_reply> in module sl_module 
> > [/usr/lib/ser/modules/sl.so]
> >  0(9050) find_export: found <sl_send_reply> in module sl_module 
> > [/usr/lib/ser/modules/sl.so]
> >  0(9050) find_export: found <record_route> in module rr 
> > [/usr/lib/ser/modules/rr.so]
> >  0(9050) find_export: found <loose_route> in module rr 
> > [/usr/lib/ser/modules/rr.so]
> >  0(9050) find_export: found <t_relay> in module tm 
> > [/usr/lib/ser/modules/tm.so]
> >  0(9050) find_export: found <radius_www_authorize> in module 
> > auth_radius [/usr/lib/ser/modules/auth_radius.so]
> >  0(9050) find_export: found <www_challenge> in module auth 
> > [/usr/lib/ser/modules/auth.so]
> >  0(9050) find_export: found <save> in module registrar 
> > [/usr/lib/ser/modules/registrar.so]
> >  0(9050) find_export: found <lookup> in module registrar 
> > [/usr/lib/ser/modules/registrar.so]
> >  0(9050) find_export: found <sl_send_reply> in module sl_module 
> > [/usr/lib/ser/modules/sl.so]
> >  0(9050) find_export: found <t_relay> in module tm 
> > [/usr/lib/ser/modules/tm.so]
> >  0(9050) find_export: found <sl_reply_error> in module sl_module 
> > [/usr/lib/ser/modules/sl.so]
> >  0(9050) routing table 0:
> >  0(9050) if ( 0(9050) NOT(  0(9050)  external_module_call( 0(9050) 
> > f_ptr<0xb544ac10> 0(9050) , "10" 0(9050) );  0(9050)  
> > external_module_call(
> > 0(9050) f_ptr<0xb544ac10> 0(9050) , "10" 0(9050) );  0(9050)  ) 0(9050) )
> {
> > 0(9050)  external_module_call( 0(9050) f_ptr<0xb54897b0> 0(9050) , "483"
> > 0(9050) , "Too Many Hops" 0(9050) );  0(9050) drop( 0(9050) type<0>
> 0(9050)
> > );  0(9050) } else { 0(9050) };  0(9050) if ( 0(9050) UNKNOWN 0(9050)
> > <UNKNOWN> 0(9050) 65535 0(9050) ) { 0(9050)  external_module_call( 0(9050)
> > f_ptr<0xb54897b0> 0(9050) , "513" 0(9050) , "Message too big" 0(9050) );
> > 0(9050) drop( 0(9050) type<0> 0(9050) );  0(9050) } else { 0(9050) };
> > 0(9050)  external_module_call( 0(9050) f_ptr<0xb544fa00> 0(9050) );
> 0(9050)
> > if ( 0(9050)  external_module_call( 0(9050) f_ptr<0xb544de40> 0(9050) );
> > 0(9050)  external_module_call( 0(9050) f_ptr<0xb544de40> 0(9050) );
> 0(9050)
> > ) { 0(9050)  external_module_call( 0(9050) f_ptr<0xb546a600> 0(9050) );
> > 0(9050) drop( 0(9050) type<0> 0(9050) );  0(9050) } else { 0(9050) };
> > 0(9050) if ( 0(9050) uri 0(9050) == 0(9050) _myself_ 0(9050) ) { 0(9050)
> if
> > ( 0(9050) method 0(9050) == 0(9050) "REGISTER" 0(9050) ) { 0(9050) if (
> > 0(9050) NOT(  0(9050)  external_module_call( 0(9050) f_ptr<0xb5428e50>
> > 0(9050) , "orau.gov" 0(9050) );  0(9050)  external_module_call( 0(9050)
> > f_ptr<0xb5428e50> 0(9050) , "orau.gov" 0(9050) );  0(9050)  ) 0(9050) ) {
> > 0(9050)  external_module_call( 0(9050) f_ptr<0xb542f500> 0(9050) ,
> > "orau.gov" 0(9050) , "0" 0(9050) );  0(9050) drop( 0(9050) type<0> 0(9050)
> > );  0(9050) } else { 0(9050) };  0(9050)  external_module_call( 0(9050)
> > f_ptr<0xb54358b0> 0(9050) , "location" 0(9050) );  0(9050) drop( 0(9050)
> > type<0> 0(9050) );  0(9050) } else { 0(9050) };  0(9050) if ( 0(9050) NOT(
> > 0(9050)  external_module_call( 0(9050) f_ptr<0xb5434a40> 0(9050) ,
> > "location" 0(9050) );  0(9050)  external_module_call( 0(9050)
> > f_ptr<0xb5434a40> 0(9050) , "location" 0(9050) );  0(9050)  ) 0(9050) ) {
> > 0(9050)  external_module_call( 0(9050) f_ptr<0xb54897b0> 0(9050) , "404"
> > 0(9050) , "Not Found" 0(9050) );  0(9050) drop( 0(9050) type<0> 0(9050) );
> > 0(9050) } else { 0(9050) };  0(9050) } else { 0(9050) };  0(9050) if (
> > 0(9050) NOT(  0(9050)  external_module_call( 0(9050) f_ptr<0xb546a600>
> > 0(9050) );  0(9050)  external_module_call( 0(9050) f_ptr<0xb546a600>
> 0(9050)
> > );  0(9050)  ) 0(9050) ) { 0(9050)  external_module_call( 0(9050)
> > f_ptr<0xb54897f0> 0(9050) );  0(9050) } else { 0(9050) };  0(9050) if (
> > 0(9050) UNKNOWN 0(9050) <UNKNOWN> 0(9050) 65535 0(9050) ) { 0(9050)
> > external_module_call( 0(9050) f_ptr<0xb54897b0> 0(9050) , "513" 0(9050) ,
> > "Message too big" 0(9050) );  0(9050) drop( 0(9050) type<0> 0(9050) );
> > 0(9050) } else { 0(9050) };  0(9050)  external_module_call( 0(9050)
> > f_ptr<0xb544fa00> 0(9050) );  0(9050) if ( 0(9050)  external_module_call(
> > 0(9050) f_ptr<0xb544de40> 0(9050) );  0(9050)  external_module_call(
> 0(9050)
> > f_ptr<0xb544de40> 0(9050) );  0(9050) ) { 0(9050)  external_module_call(
> > 0(9050) f_ptr<0xb546a600> 0(9050) );  0(9050) drop( 0(9050) type<0>
> 0(9050)
> > );  0(9050) } else { 0(9050) };  0(9050) if ( 0(9050) uri 0(9050) ==
> 0(9050)
> > _myself_ 0(9050) ) { 0(9050) if ( 0(9050) method 0(9050) == 0(9050)
> > "REGISTER" 0(9050) ) { 0(9050) if ( 0(9050) NOT(  0(9050)
> > external_module_call( 0(9050) f_ptr<0xb5428e50> 0(9050) , "orau.gov"
> 0(9050)
> > );  0(9050)  external_module_call( 0(9050) f_ptr<0xb5428e50> 0(9050) ,
> > "orau.gov" 0(9050) );  0(9050)  ) 0(9050) ) { 0(9050)
> external_module_call(
> > 0(9050) f_ptr<0xb542f500> 0(9050) , "orau.gov" 0(9050) , "0" 0(9050) );
> > 0(9050) drop( 0(9050) type<0> 0(9050) );  0(9050) } else { 0(9050) };
> > 0(9050)  external_module_call( 0(9050) f_ptr<0xb54358b0> 0(9050) ,
> > "location" 0(9050) );  0(9050) drop( 0(9050) type<0> 0(9050) );  0(9050) }
> > else { 0(9050) };  0(9050) if ( 0(9050) NOT(  0(9050)
> external_module_call(
> > 0(9050) f_ptr<0xb5434a40> 0(9050) , "location" 0(9050) );  0(9050)
> > external_module_call( 0(9050) f_ptr<0xb5434a40> 0(9050) , "location"
> 0(9050)
> > );  0(9050)  ) 0(9050) ) { 0(9050)  external_module_call( 0(9050)
> > f_ptr<0xb54897b0> 0(9050) , "404" 0(9050) , "Not Found" 0(9050) );
> 0(9050)
> > drop( 0(9050) type<0> 0(9050) );  0(9050) } else { 0(9050) };  0(9050) }
> > else { 0(9050) };  0(9050) if ( 0(9050) NOT(  0(9050)
> external_module_call(
> > 0(9050) f_ptr<0xb546a600> 0(9050) );  0(9050)  external_module_call(
> 0(9050)
> > f_ptr<0xb546a600> 0(9050) );  0(9050)  ) 0(9050) ) { 0(9050)
> > external_module_call( 0(9050) f_ptr<0xb54897f0> 0(9050) );  0(9050) } else
> {
> > 0(9050) };  0(9050)  external_module_call( 0(9050) f_ptr<0xb544fa00>
> 0(9050)
> > );  0(9050) if ( 0(9050)  external_module_call( 0(9050) f_ptr<0xb544de40>
> > 0(9050) );  0(9050)  external_module_call( 0(9050) f_ptr<0xb544de40>
> 0(9050)
> > );  0(9050) ) { 0(9050)  external_module_call( 0(9050) f_ptr<0xb546a600>
> > 0(9050) );  0(9050) drop( 0(9050) type<0> 0(9050) );  0(9050) } else {
> > 0(9050) };  0(9050) if ( 0(9050) uri 0(9050) == 0(9050) _myself_ 0(9050) )
> {
> > 0(9050) if ( 0(9050) method 0(9050) == 0(9050) "REGISTER" 0(9050) ) {
> > 0(9050) if ( 0(9050) NOT(  0(9050)  external_module_call( 0(9050)
> > f_ptr<0xb5428e50> 0(9050) , "orau.gov" 0(9050) );  0(9050)
> > external_module_call( 0(9050) f_ptr<0xb5428e50> 0(9050) , "orau.gov"
> 0(9050)
> > );  0(9050)  ) 0(9050) ) { 0(9050)  external_module_call( 0(9050)
> > f_ptr<0xb542f500> 0(9050) , "orau.gov" 0(9050) , "0" 0(9050) );  0(9050)
> > drop( 0(9050) type<0> 0(9050) );  0(9050) } else { 0(9050) };  0(9050)
> > external_module_call( 0(9050) f_ptr<0xb54358b0> 0(9050) , "location"
> 0(9050)
> > );  0(9050) drop( 0(9050) type<0> 0(9050) );  0(9050) } else { 0(9050) };
> > 0(9050) if ( 0(9050) NOT(  0(9050)  external_module_call( 0(9050)
> > f_ptr<0xb5434a40> 0(9050) , "location" 0(9050) );  0(9050)
> > external_module_call( 0(9050) f_ptr<0xb5434a40> 0(9050) , "location"
> 0(9050)
> > );  0(9050)  ) 0(9050) ) { 0(9050)  external_module_call( 0(9050)
> > f_ptr<0xb54897b0> 0(9050) , "404" 0(9050) , "Not Found" 0(9050) );
> 0(9050)
> > drop( 0(9050) type<0> 0(9050) );  0(9050) } else { 0(9050) };  0(9050) }
> > else { 0(9050) };  0(9050) if ( 0(9050) NOT(  0(9050)
> external_module_call(
> > 0(9050) f_ptr<0xb546a600> 0(9050) );  0(9050)  external_module_call(
> 0(9050)
> > f_ptr<0xb546a600> 0(9050) );  0(9050)  ) 0(9050) ) { 0(9050)
> > external_module_call( 0(9050) f_ptr<0xb54897f0> 0(9050) );  0(9050) } else
> {
> > 0(9050) };  0(9050) if ( 0(9050)  external_module_call( 0(9050)
> > f_ptr<0xb544de40> 0(9050) );  0(9050)  external_module_call( 0(9050)
> > f_ptr<0xb544de40> 0(9050) );  0(9050) ) { 0(9050)  external_module_call(
> > 0(9050) f_ptr<0xb546a600> 0(9050) );  0(9050) drop( 0(9050) type<0>
> 0(9050)
> > );  0(9050) } else { 0(9050) };  0(9050) if ( 0(9050) uri 0(9050) ==
> 0(9050)
> > _myself_ 0(9050) ) { 0(9050) if ( 0(9050) method 0(9050) == 0(9050)
> > "REGISTER" 0(9050) ) { 0(9050) if ( 0(9050) NOT(  0(9050)
> > external_module_call( 0(9050) f_ptr<0xb5428e50> 0(9050) , "orau.gov"
> 0(9050)
> > );  0(9050)  external_module_call( 0(9050) f_ptr<0xb5428e50> 0(9050) ,
> > "orau.gov" 0(9050) );  0(9050)  ) 0(9050) ) { 0(9050)
> external_module_call(
> > 0(9050) f_ptr<0xb542f500> 0(9050) , "orau.gov" 0(9050) , "0" 0(9050) );
> > 0(9050) drop( 0(9050) type<0> 0(9050) );  0(9050) } else { 0(9050) };
> > 0(9050)  external_module_call( 0(9050) f_ptr<0xb54358b0> 0(9050) ,
> > "location" 0(9050) );  0(9050) drop( 0(9050) type<0> 0(9050) );  0(9050) }
> > else { 0(9050) };  0(9050) if ( 0(9050) NOT(  0(9050)
> external_module_call(
> > 0(9050) f_ptr<0xb5434a40> 0(9050) , "location" 0(9050) );  0(9050)
> > external_module_call( 0(9050) f_ptr<0xb5434a40> 0(9050) , "location"
> 0(9050)
> > );  0(9050)  ) 0(9050) ) { 0(9050)  external_module_call( 0(9050)
> > f_ptr<0xb54897b0> 0(9050) , "404" 0(9050) , "Not Found" 0(9050) );
> 0(9050)
> > drop( 0(9050) type<0> 0(9050) );  0(9050) } else { 0(9050) };  0(9050) }
> > else { 0(9050) };  0(9050) if ( 0(9050) NOT(  0(9050)
> external_module_call(
> > 0(9050) f_ptr<0xb546a600> 0(9050) );  0(9050)  external_module_call(
> 0(9050)
> > f_ptr<0xb546a600> 0(9050) );  0(9050)  ) 0(9050) ) { 0(9050)
> > external_module_call( 0(9050) f_ptr<0xb54897f0> 0(9050) );  0(9050) } else
> {
> > 0(9050) };  0(9050) if ( 0(9050) uri 0(9050) == 0(9050) _myself_ 0(9050) )
> {
> > 0(9050) if ( 0(9050) method 0(9050) == 0(9050) "REGISTER" 0(9050) ) {
> > 0(9050) if ( 0(9050) NOT(  0(9050)  external_module_call( 0(9050)
> > f_ptr<0xb5428e50> 0(9050) , "orau.gov" 0(9050) );  0(9050)
> > external_module_call( 0(9050) f_ptr<0xb5428e50> 0(9050) , "orau.gov"
> 0(9050)
> > );  0(9050)  ) 0(9050) ) { 0(9050)  external_module_call( 0(9050)
> > f_ptr<0xb542f500> 0(9050) , "orau.gov" 0(9050) , "0" 0(9050) );  0(9050)
> > drop( 0(9050) type<0> 0(9050) );  0(9050) } else { 0(9050) };  0(9050)
> > external_module_call( 0(9050) f_ptr<0xb54358b0> 0(9050) , "location"
> 0(9050)
> > );  0(9050) drop( 0(9050) type<0> 0(9050) );  0(9050) } else { 0(9050) };
> > 0(9050) if ( 0(9050) NOT(  0(9050)  external_module_call( 0(9050)
> > f_ptr<0xb5434a40> 0(9050) , "location" 0(9050) );  0(9050)
> > external_module_call( 0(9050) f_ptr<0xb5434a40> 0(9050) , "location"
> 0(9050)
> > );  0(9050)  ) 0(9050) ) { 0(9050)  external_module_call( 0(9050)
> > f_ptr<0xb54897b0> 0(9050) , "404" 0(9050) , "Not Found" 0(9050) );
> 0(9050)
> > drop( 0(9050) type<0> 0(9050) );  0(9050) } else { 0(9050) };  0(9050) }
> > else { 0(9050) };  0(9050) if ( 0(9050) NOT(  0(9050)
> external_module_call(
> > 0(9050) f_ptr<0xb546a600> 0(9050) );  0(9050)  external_module_call(
> 0(9050)
> > f_ptr<0xb546a600> 0(9050) );  0(9050)  ) 0(9050) ) { 0(9050)
> > external_module_call( 0(9050) f_ptr<0xb54897f0> 0(9050) );  0(9050) } else
> {
> > 0(9050) };  0(9050) if ( 0(9050) NOT(  0(9050)  external_module_call(
> > 0(9050) f_ptr<0xb546a600> 0(9050) );  0(9050)  external_module_call(
> 0(9050)
> > f_ptr<0xb546a600> 0(9050) );  0(9050)  ) 0(9050) ) { 0(9050)
> > external_module_call( 0(9050) f_ptr<0xb54897f0> 0(9050) );  0(9050) } else
> {
> > 0(9050) };  0(9050) 
> > Listening on 
> >               127.0.0.1 [127.0.0.1]:5060
> >               10.0.2.1 [10.0.2.1]:5060
> > Aliases: comm01.orau.gov:5060 localhost:5060 localhost.localdomain:5060
> > comm01:5060 orau.gov:* 
> >  0(9052) DEBUG: init_mod: sl_module
> > stateless - initializing
> >  0(9052) DEBUG: register_fifo_cmd: new command (sl_stats) registered
> >  0(9052) DEBUG: MD5 calculated: b27e1a1d33761e85846fc98f5f3a7e58
> >  0(9052) DEBUG: init_mod: tm
> >  0(9052) TM - initializing...
> >  0(9052) Call-ID initialization: '4fff2ca9'
> >  0(9052) DEBUG: register_fifo_cmd: new command (t_uac_dlg) registered
> >  0(9052) DEBUG: register_fifo_cmd: new command (t_hash) registered
> > [root at comm01 ser]#  0(9052) DEBUG: lock_initialize: lock initialization
> > started
> >  0(9052) DEBUG: register_fifo_cmd: new command (t_stats) registered
> >  0(9052) DEBUG: MD5 calculated: 533cb9e91f4b999cf76861cbb9ed54ed
> >  0(9052) DEBUG: MD5 calculated: a6a1c5f60faecf035a1ae5b6e96e979a
> >  0(9052) DEBUG: init_mod: rr
> >  0(9052) rr - initializing
> >  0(9052) DEBUG: init_mod: maxfwd_module
> > Maxfwd module- initializing
> >  0(9052) DEBUG: init_mod: usrloc
> >  0(9052) usrloc - initializing
> >  0(9052) DEBUG: register_fifo_cmd: new command (ul_stats) registered
> >  0(9052) DEBUG: register_fifo_cmd: new command (ul_rm) registered
> >  0(9052) DEBUG: register_fifo_cmd: new command (ul_rm_contact) registered
> >  0(9052) DEBUG: register_fifo_cmd: new command (ul_dump) registered
> >  0(9052) DEBUG: register_fifo_cmd: new command (ul_flush) registered
> >  0(9052) DEBUG: register_fifo_cmd: new command (ul_add) registered
> >  0(9052) DEBUG: register_fifo_cmd: new command (ul_show_contact)
> registered
> >  0(9052) DEBUG: init_mod: registrar
> >  0(9052) registrar - initializing
> >  0(9052) find_export: found <sl_send_reply> in module sl_module
> > [/usr/lib/ser/modules/sl.so]
> >  0(9052) find_export: found <ul_bind_usrloc> in module usrloc
> > [/usr/lib/ser/modules/usrloc.so]
> >  0(9052) find_export: found <ul_register_udomain> in module usrloc
> > [/usr/lib/ser/modules/usrloc.so]
> >  0(9052) find_export: found <ul_get_all_ucontacts> in module usrloc
> > [/usr/lib/ser/modules/usrloc.so]
> >  0(9052) find_export: found <ul_insert_urecord> in module usrloc
> > [/usr/lib/ser/modules/usrloc.so]
> >  0(9052) find_export: found <ul_delete_urecord> in module usrloc
> > [/usr/lib/ser/modules/usrloc.so]
> >  0(9052) find_export: found <ul_get_urecord> in module usrloc
> > [/usr/lib/ser/modules/usrloc.so]
> >  0(9052) find_export: found <ul_lock_udomain> in module usrloc
> > [/usr/lib/ser/modules/usrloc.so]
> >  0(9052) find_export: found <ul_unlock_udomain> in module usrloc
> > [/usr/lib/ser/modules/usrloc.so]
> >  0(9052) find_export: found <ul_release_urecord> in module usrloc
> > [/usr/lib/ser/modules/usrloc.so]
> >  0(9052) find_export: found <ul_insert_ucontact> in module usrloc
> > [/usr/lib/ser/modules/usrloc.so]
> >  0(9052) find_export: found <ul_delete_ucontact> in module usrloc
> > [/usr/lib/ser/modules/usrloc.so]
> >  0(9052) find_export: found <ul_get_ucontact> in module usrloc
> > [/usr/lib/ser/modules/usrloc.so]
> >  0(9052) find_export: found <ul_update_ucontact> in module usrloc
> > [/usr/lib/ser/modules/usrloc.so]
> >  0(9052) DEBUG: init_mod: auth
> >  0(9052) auth module - initializing
> >  0(9052) find_export: found <sl_send_reply> in module sl_module
> > [/usr/lib/ser/modules/sl.so]
> >  0(9052) DEBUG: init_mod: auth_radius
> >  0(9052) auth_radius - Initializing
> >  0(9052) find_export: found <pre_auth> in module auth
> > [/usr/lib/ser/modules/auth.so]
> >  0(9052) find_export: found <post_auth> in module auth
> > [/usr/lib/ser/modules/auth.so]
> >  0(0) fixing /usr/lib/ser/modules/maxfwd.so mf_process_maxfwd_header
> >  0(0) fixing /usr/lib/ser/modules/sl.so sl_send_reply
> >  0(0) fixing /usr/lib/ser/modules/sl.so sl_send_reply
> >  0(0) fixing /usr/lib/ser/modules/rr.so record_route
> >  0(0) fixing /usr/lib/ser/modules/rr.so loose_route
> >  0(0) fixing /usr/lib/ser/modules/tm.so t_relay
> >  0(0) fixing /usr/lib/ser/modules/auth_radius.so radius_www_authorize
> >  0(0) fixing /usr/lib/ser/modules/auth.so www_challenge
> >  0(0) fixing /usr/lib/ser/modules/registrar.so save
> >  0(0) fixing /usr/lib/ser/modules/registrar.so lookup
> >  0(0) fixing /usr/lib/ser/modules/sl.so sl_send_reply
> >  0(0) fixing /usr/lib/ser/modules/tm.so t_relay
> >  0(0) fixing /usr/lib/ser/modules/sl.so sl_reply_error
> >  0(0) INFO: udp_init: SO_RCVBUF is initially 65535
> >  0(0) DEBUG: udp_init: trying SO_RCVBUF: 131070
> >  0(0) DEBUG: setting SO_RCVBUF; set=131070,verify=262140
> >  0(0) DEBUG: udp_init: trying SO_RCVBUF: 262140
> >  0(0) DEBUG: setting SO_RCVBUF; set=262140,verify=262142
> >  0(0) INFO: udp_init: SO_RCVBUF is finally 262142
> >  0(0) ERROR: tcp_init: bind(4, 0x80be120, 16) on 127.0.0.1: Address
> already
> > in use
> >  0(0) INFO: signal 15 received
> >  0(0) Memory status (pkg):
> >  0(0) fm_status (0x80bf5e0):
> >  0(0)  heap size= 1047440
> >  0(0) dumping free list:
> >  0(0) hash =   1 fragments no.:     3,
> >                  bucket size:         8 -         8 (first         8)
> >  0(0) hash =  23 fragments no.:     1,
> >                  bucket size:       184 -       184 (first       184)
> >  0(0) hash =  80 fragments no.:     1,
> >                  bucket size:       640 -       640 (first       640)
> >  0(0) hash = 265 fragments no.:     1,
> >                  bucket size:    524288 -   1048576 (first   1042696)
> >  0(0) TOTAL:      6 free fragments = 1043544 free bytes
> >  0(0) -----------------------------
> >  6(9033) SIP Request:
> >  6(9033)  method:  <REGISTER>
> >  6(9033)  uri:     <sip:orau.gov>
> >  6(9033)  version: <SIP/2.0>
> >  6(9033) parse_headers: flags=1
> >  6(9033) end of header reached, state=5
> >  6(9033) parse_headers: Via found, flags=1
> >  6(9033) parse_headers: this is the first via
> >  6(9033) After parse_msg...
> >  6(9033) preparing to run routing scripts...
> >  6(9033) DEBUG : is_maxfwd_present: searching for max_forwards header
> >  6(9033) parse_headers: flags=128
> >  6(9033) end of header reached, state=9
> >  6(9033) DEBUG: get_hdr_field: <To> [24]; uri=[sip:morriss at orau.gov] 
> >  6(9033) DEBUG: to body [<sip:morriss at orau.gov>
> > ]
> >  6(9033) get_hdr_field: cseq <CSeq>: <1> <REGISTER>
> >  6(9033) DEBUG: get_hdr_body : content_length=0
> >  6(9033) found end of header
> >  6(9033) DEBUG: is_maxfwd_present: max_forwards header not found!
> >  6(9033) DEBUG: add_param: tag=1ee64889-d819-44da-a3fe-1be0c929195e
> >  6(9033) end of header reached, state=29
> >  6(9033) parse_headers: flags=256
> >  6(9033) find_first_route(): No Route headers found
> >  6(9033) loose_route(): There is no Route HF
> >  6(9033) check_self - checking if host==us: 8==9 &&  [orau.gov] ==
> > [127.0.0.1]
> >  6(9033) check_self - checking if port 5060 matches port 5060
> >  6(9033) check_self - checking if host==us: 8==8 &&  [orau.gov] ==
> > [10.0.2.1]
> >  6(9033) check_self - checking if port 5060 matches port 5060
> >  6(9033) parse_headers: flags=4096
> >  6(9033) pre_auth(): Credentials with given realm not found
> >  6(9033) build_auth_hf(): 'WWW-Authenticate: Digest realm="iptel.org",
> > nonce="4069e8834e8f663a3a3b0a4ff7911a7dc32ff3f4"
> > '
> >  6(9033) parse_headers: flags=-1
> >  6(9033) check_via_address(198.125.67.127, 198.125.67.127, 0)
> >  6(9033) receive_msg: cleaning up
> >  8(9035) SIP Request:
> >  8(9035)  method:  <SUBSCRIBE>
> >  8(9035)  uri:     <sip:coxt at orau.gov>
> >  8(9035)  version: <SIP/2.0>
> >  8(9035) parse_headers: flags=1
> >  8(9035) end of header reached, state=5
> >  8(9035) parse_headers: Via found, flags=1
> >  8(9035) parse_headers: this is the first via
> >  8(9035) After parse_msg...
> >  8(9035) preparing to run routing scripts...
> >  8(9035) DEBUG : is_maxfwd_present: searching for max_forwards header
> >  8(9035) parse_headers: flags=128
> >  8(9035) end of header reached, state=9
> >  8(9035) DEBUG: get_hdr_field: <To> [21]; uri=[sip:coxt at orau.gov] 
> >  7(9034)  8(9035) DEBUG: to body [<sip:coxt at orau.gov>
> > ]
> > SIP Request:
> >  8(9035)  7(9034) get_hdr_field: cseq <CSeq>: <1> <SUBSCRIBE>
> >  method:  <SUBSCRIBE>
> >  8(9035)  7(9034) DEBUG: get_hdr_body : content_length=0
> >  uri:     <sip:coxt at orau.gov>
> >  8(9035) found end of header
> >  7(9034)  8(9035) DEBUG: is_maxfwd_present: max_forwards header not found!
> >  version: <SIP/2.0>
> >  8(9035) DEBUG: add_param: tag=818e6bae-eeb7-4320-991b-1da176371e3b
> >  8(9035)  7(9034) end of header reached, state=29
> > parse_headers: flags=1
> >  8(9035) parse_headers: flags=256
> >  8(9035) find_first_route(): No Route headers found
> >  8(9035)  7(9034) loose_route(): There is no Route HF
> > end of header reached, state=5
> >  8(9035) check_self - checking if host==us: 8==9 &&  [orau.gov] ==
> > [127.0.0.1]
> >  8(9035)  7(9034) check_self - checking if port 5060 matches port 5060
> > parse_headers: Via found, flags=1
> >  8(9035)  7(9034) check_self - checking if host==us: 8==8 &&  [orau.gov]
> ==
> > [10.0.2.1]
> > parse_headers: this is the first via
> >  8(9035)  7(9034) check_self - checking if port 5060 matches port 5060
> > After parse_msg...
> >  8(9035) lookup(): 'coxt' Not found in usrloc
> >  8(9035) parse_headers: flags=-1
> >  7(9034)  8(9035) preparing to run routing scripts...
> > check_via_address(198.125.67.127, 198.125.67.127, 0)
> >  7(9034) DEBUG : is_maxfwd_present: searching for max_forwards header
> >  7(9034) parse_headers: flags=128
> >  8(9035) receive_msg: cleaning up
> >  7(9034) end of header reached, state=9
> >  7(9034) DEBUG: get_hdr_field: <To> [21]; uri=[sip:coxt at orau.gov] 
> >  7(9034) DEBUG: to body [<sip:coxt at orau.gov>
> > ]
> >  7(9034) get_hdr_field: cseq <CSeq>: <2> <SUBSCRIBE>
> >  7(9034) DEBUG: get_hdr_body : content_length=0
> >  7(9034) found end of header
> >  7(9034) DEBUG: is_maxfwd_present: max_forwards header not found!
> >  7(9034) DEBUG: add_param: tag=818e6bae-eeb7-4320-991b-1da176371e3b
> >  7(9034) end of header reached, state=29
> >  7(9034) parse_headers: flags=256
> >  7(9034) find_first_route(): No Route headers found
> >  7(9034) loose_route(): There is no Route HF
> >  7(9034) check_self - checking if host==us: 8==9 &&  [orau.gov] ==
> > [127.0.0.1]
> >  7(9034) check_self - checking if port 5060 matches port 5060
> >  7(9034) check_self - checking if host==us: 8==8 &&  [orau.gov] ==
> > [10.0.2.1]
> >  7(9034) check_self - checking if port 5060 matches port 5060
> >  7(9034) lookup(): 'coxt' Not found in usrloc
> >  7(9034) parse_headers: flags=-1
> >  7(9034) check_via_address(198.125.67.127, 198.125.67.127, 0)
> >  7(9034) receive_msg: cleaning up
> >  8(9035) SIP Request:
> >  8(9035)  method:  <REGISTER>
> >  8(9035)  uri:     <sip:orau.gov>
> >  8(9035)  version: <SIP/2.0>
> >  8(9035) parse_headers: flags=1
> >  8(9035) end of header reached, state=5
> >  8(9035) parse_headers: Via found, flags=1
> >  8(9035) parse_headers: this is the first via
> >  8(9035) After parse_msg...
> >  8(9035) preparing to run routing scripts...
> >  8(9035) DEBUG : is_maxfwd_present: searching for max_forwards header
> >  8(9035) parse_headers: flags=128
> >  8(9035) end of header reached, state=9
> >  8(9035) DEBUG: get_hdr_field: <To> [24]; uri=[sip:morriss at orau.gov] 
> >  8(9035) DEBUG: to body [<sip:morriss at orau.gov>
> > ]
> >  8(9035) get_hdr_field: cseq <CSeq>: <1> <REGISTER>
> >  8(9035) DEBUG: get_hdr_body : content_length=0
> >  8(9035) found end of header
> >  8(9035) DEBUG: is_maxfwd_present: max_forwards header not found!
> >  8(9035) DEBUG: add_param: tag=1ebe80cd-4dc0-461a-b8f7-95706727a94f
> >  8(9035) end of header reached, state=29
> >  8(9035) parse_headers: flags=256
> >  8(9035) find_first_route(): No Route headers found
> >  8(9035) loose_route(): There is no Route HF
> >  8(9035) check_self - checking if host==us: 8==9 &&  [orau.gov] ==
> > [127.0.0.1]
> >  8(9035) check_self - checking if port 5060 matches port 5060
> >  8(9035) check_self - checking if host==us: 8==8 &&  [orau.gov] ==
> > [10.0.2.1]
> >  8(9035) check_self - checking if port 5060 matches port 5060
> >  8(9035) parse_headers: flags=4096
> >  8(9035) pre_auth(): Credentials with given realm not found
> >  8(9035) build_auth_hf(): 'WWW-Authenticate: Digest realm="iptel.org",
> > nonce="4069e88db5d3350346984ceaf3882651163ce302"
> > '
> >  8(9035) parse_headers: flags=-1
> >  8(9035) check_via_address(198.125.67.127, 198.125.67.127, 0)
> >  8(9035) receive_msg: cleaning up
> >  7(9034) SIP Request:
> >  7(9034)  method:  <SUBSCRIBE>
> >  7(9034)  uri:     <sip:coxt at orau.gov>
> >  7(9034)  version: <SIP/2.0>
> >  7(9034) parse_headers: flags=1
> >  7(9034) end of header reached, state=5
> >  7(9034) parse_headers: Via found, flags=1
> >  7(9034) parse_headers: this is the first via
> >  7(9034) After parse_msg...
> >  7(9034) preparing to run routing scripts...
> >  5(9032)  7(9034) SIP Request:
> >  5(9032) DEBUG : is_maxfwd_present: searching for max_forwards header
> >  method:  <SUBSCRIBE>
> >  7(9034)  5(9032)  uri:     <sip:coxt at orau.gov>
> > parse_headers: flags=128
> >  5(9032)  7(9034)  version: <SIP/2.0>
> >  5(9032) end of header reached, state=9
> > parse_headers: flags=1
> >  7(9034)  5(9032) DEBUG: get_hdr_field: <To> [21]; uri=[sip:coxt at orau.gov]
> 
> > end of header reached, state=5
> >  7(9034) DEBUG: to body [<sip:coxt at orau.gov>
> > ]
> >  5(9032)  7(9034) parse_headers: Via found, flags=1
> > get_hdr_field: cseq <CSeq>: <1> <SUBSCRIBE>
> >  5(9032) parse_headers: this is the first via
> >  5(9032)  7(9034) After parse_msg...
> > DEBUG: get_hdr_body : content_length=0
> >  5(9032) preparing to run routing scripts...
> >  7(9034)  5(9032) DEBUG : is_maxfwd_present: searching for max_forwards
> > header
> > found end of header
> >  5(9032)  7(9034) parse_headers: flags=128
> > DEBUG: is_maxfwd_present: max_forwards header not found!
> >  5(9032) end of header reached, state=9
> >  5(9032) DEBUG: get_hdr_field: <To> [21]; uri=[sip:coxt at orau.gov] 
> >  5(9032) DEBUG: to body [<sip:coxt at orau.gov>
> > ]
> >  7(9034)  5(9032) DEBUG: add_param:
> tag=62a46ccd-f1fc-4b62-9907-9847cb0c34af
> > get_hdr_field: cseq <CSeq>: <2> <SUBSCRIBE>
> >  7(9034)  5(9032) DEBUG: get_hdr_body : content_length=0
> > end of header reached, state=29
> >  5(9032) found end of header
> >  7(9034) parse_headers: flags=256
> >  5(9032) DEBUG: is_maxfwd_present: max_forwards header not found!
> >  7(9034)  5(9032) DEBUG: add_param:
> tag=62a46ccd-f1fc-4b62-9907-9847cb0c34af
> > find_first_route(): No Route headers found
> >  5(9032) end of header reached, state=29
> >  7(9034)  5(9032) parse_headers: flags=256
> > loose_route(): There is no Route HF
> >  5(9032)  7(9034) find_first_route(): No Route headers found
> >  5(9032) loose_route(): There is no Route HF
> >  5(9032) check_self - checking if host==us: 8==9 &&  [orau.gov] ==
> > [127.0.0.1]
> > check_self - checking if host==us: 8==9 &&  [orau.gov] == [127.0.0.1]
> >  7(9034)  5(9032) check_self - checking if port 5060 matches port 5060
> > check_self - checking if port 5060 matches port 5060
> >  7(9034)  5(9032) check_self - checking if host==us: 8==8 &&  [orau.gov]
> ==
> > [10.0.2.1]
> >  5(9032) check_self - checking if port 5060 matches port 5060
> > check_self - checking if host==us: 8==8 &&  [orau.gov] == [10.0.2.1]
> >  5(9032) lookup(): 'coxt' Not found in usrloc
> >  7(9034)  5(9032) check_self - checking if port 5060 matches port 5060
> > parse_headers: flags=-1
> >  5(9032) check_via_address(198.125.67.127, 198.125.67.127, 0)
> >  7(9034) lookup(): 'coxt' Not found in usrloc
> >  5(9032)  7(9034) receive_msg: cleaning up
> > parse_headers: flags=-1
> >  7(9034) check_via_address(198.125.67.127, 198.125.67.127, 0)
> >  7(9034) receive_msg: cleaning up
> > 
> > [root at comm01 ser]#
> 
> _______________________________________________
> Serusers mailing list
> serusers at lists.iptel.org http://lists.iptel.org/mailman/listinfo/serusers




More information about the sr-users mailing list