[support] McoA Failed to add policy

Luis Campo Giralte lcg223 at tid.es
Mon Nov 5 21:53:02 JST 2007


Hi romain, i send you the complete log of the Mobile router, also with
the DEBUG on the libnetlink, i think the problem its there, the kernel i
used its 2.6.23 and nothing worng happends(on dmesg).

mobile-router:/home/mipv6-daemon-umip-0.4/src# ./mip6d
-c /root/nemod.conf 
RTNETLINK answers: Cannot assign requested address
mip6d[10091]: MIPL Mobile IPv6 for Linux v2.0.2-umip-0.4 started (Mobile
Node)
Mon Nov  5 13:47:44 main: MIPL Mobile IPv6 for Linux started in debug
mode, not detaching from terminal
Mon Nov  5 13:47:44 conf_show: config_file = /root/nemod.conf
Mon Nov  5 13:47:44 conf_show: mip6_entity = 1
Mon Nov  5 13:47:44 conf_show: debug_level = 10
Mon Nov  5 13:47:44 conf_show: debug_log_file = stderr
Mon Nov  5 13:47:44 conf_show: PolicyModulePath = [internal]
Mon Nov  5 13:47:44 conf_show: DefaultBindingAclPolicy = 0
Mon Nov  5 13:47:44 conf_show: NonVolatileBindingCache = disabled
Mon Nov  5 13:47:44 conf_show: KeyMngMobCapability = disabled
Mon Nov  5 13:47:44 conf_show: UseMnHaIPsec = disabled
Mon Nov  5 13:47:44 conf_show: MnMaxHaBindingLife = 20
Mon Nov  5 13:47:44 conf_show: MnMaxCnBindingLife = 420
Mon Nov  5 13:47:44 conf_show: MnRouterProbes = 1
Mon Nov  5 13:47:44 conf_show: MnRouterProbeTimeout = 0.000000
Mon Nov  5 13:47:44 conf_show: InitialBindackTimeoutFirstReg = 1.500000
Mon Nov  5 13:47:44 conf_show: InitialBindackTimeoutReReg = 1.000000
Mon Nov  5 13:47:44 conf_show: UseCnBuAck = disabled
Mon Nov  5 13:47:44 conf_show: DoRouteOptimizationMN = disabled
Mon Nov  5 13:47:44 conf_show: MnUseAllInterfaces = disabled
Mon Nov  5 13:47:44 conf_show: MnDiscardHaParamProb = disabled
Mon Nov  5 13:47:44 conf_show: SendMobPfxSols = disabled
Mon Nov  5 13:47:44 conf_show: OptimisticHandoff = enabled
Mon Nov  5 13:47:44 conf_show: SendMobPfxAdvs = enabled
Mon Nov  5 13:47:44 conf_show: SendUnsolMobPfxAdvs = enabled
Mon Nov  5 13:47:44 conf_show: MaxMobPfxAdvInterval = 86400
Mon Nov  5 13:47:44 conf_show: MinMobPfxAdvInterval = 600
Mon Nov  5 13:47:44 conf_show: HaMaxBindingLife = 262140
Mon Nov  5 13:47:44 conf_show: HaAcceptMobRtr = 0
Mon Nov  5 13:47:44 conf_show: HaAcceptMCoAReg = 0
Mon Nov  5 13:47:44 conf_show: DoRouteOptimizationCN = disabled
Mon Nov  5 13:47:44 xfrm_cn_init: Adding policies and states for CN
Mon Nov  5 13:47:44 xfrm_mn_init: Adding policies and states for MN
Mon Nov  5 13:47:44 xfrm_mn_init: Adding RTHdr type 2 handling 2 state
for MN
Mon Nov  5 13:47:44 conf_home_addr_info: HoA address
2007:106:2700:0:0:0:0:10
Mon Nov  5 13:47:44 conf_home_addr_info: is Mobile Router
Mon Nov  5 13:47:44 conf_home_addr_info: Mobile Network Prefix
2007:aaaa:bbbb:0:0:0:0:0/64
Mon Nov  5 13:47:44 conf_home_addr_info: HA address
2007:106:2700:0:0:0:0:2
Mon Nov  5 13:47:44 conf_home_addr_info: Home address
2007:106:2700:0:0:0:0:10
Mon Nov  5 13:47:44 conf_home_addr_info: Added new home_addr_info
successfully
!!!Deficit 4, rta_len=640
Mon Nov  5 13:47:44 __md_discover_router: discover link on iface eth1
(4)
!!!Deficit 4, rta_len=0
Mon Nov  5 13:47:44 __md_discover_router: discover link on iface eth0
(6)
Mon Nov  5 13:47:45 md_change_default_router: add new router
fe80:0:0:0:2a0:24ff:fe8c:cfde on interface eth0 (6)
Mon Nov  5 13:47:45 md_update_router_stats: add coa
2007:106:1300:0:200:e2ff:fe3a:226d on interface (6)
Mon Nov  5 13:47:46 md_change_default_router: add new router
fe80:0:0:0:218:f8ff:fedb:a03d on interface eth1 (4)
Mon Nov  5 13:47:46 md_update_router_stats: add coa
2007:106:2222:0:250:4ff:fe07:5085 on interface (4)
Mon Nov  5 13:47:47 mn_move: 2353
Mon Nov  5 13:47:47 mn_move: in foreign net
Mon Nov  5 13:47:47 mn_block_rule_add: blackhole is already set.
RTNETLINK answers: No such file or directory
Mon Nov  5 13:47:47 mn_send_home_bu: 1021
Mon Nov  5 13:47:47 mn_get_home_lifetime: CoA lifetime 2591998 s, HoA
lifetime 4294967295 s, BU lifetime 20 s
Mon Nov  5 13:47:47 process_first_home_bu: Creating new tunnel for iface
6 (BID 200)
Mon Nov  5 13:47:47 __tunnel_add: created tunnel ip6tnl1 (146) from
2007:106:2700:0:0:0:0:10 to 2007:106:2700:0:0:0:0:2 user count 1
Mon Nov  5 13:47:47 process_first_home_bu: MN-HA tunnel created (iface
tnl = 146)
RTNETLINK answers: Cannot assign requested address
Mon Nov  5 13:47:47 flag_hoa: set HoA 2007:106:2700:0:0:0:0:10/128 iif
146 flags 12 preferred_time 4294967295 valid_time 4294967295
Mon Nov  5 13:47:47 process_first_home_bu: New bule for HA
Mon Nov  5 13:47:47 bul_add: Adding bule
== BUL_ENTRY ==
Home address    2007:106:2700:0:0:0:0:10
Care-of address 2007:106:1300:0:200:e2ff:fe3a:226d
CN address      2007:106:2700:0:0:0:0:2
 lifetime = 20,  delay = 1500
 BID = 200, Priority = 100
 flags: IP6_MH_BU_HOME IP6_MH_BU_ACK 
RTNETLINK answers: No such file or directory
RTNETLINK answers: No such file or directory
Mon Nov  5 13:47:47 mcoa_iface_rules_add: MNP and HoA Rules added for
interface 6.
Mon Nov  5 13:47:47 mn_send_home_bu: New bule for HA
Mon Nov  5 13:47:47 mh_create_opt_bid: BUI sub-option created with BID =
200 and priority 100
Mon Nov  5 13:47:47 mh_send: sending MH type 5
from 2007:106:2700:0:0:0:0:10
to 2007:106:2700:0:0:0:0:2
Mon Nov  5 13:47:47 mh_send: local CoA
2007:106:1300:0:200:e2ff:fe3a:226d
Mon Nov  5 13:47:47 bul_update_timer: Updating timer
== BUL_ENTRY ==
Home address    2007:106:2700:0:0:0:0:10
Care-of address 2007:106:1300:0:200:e2ff:fe3a:226d
CN address      2007:106:2700:0:0:0:0:2
 lifetime = 20,  delay = 1500
 BID = 200, Priority = 100
 flags: IP6_MH_BU_HOME IP6_MH_BU_ACK 
Mon Nov  5 13:47:47 tunnel_mod: modifying tunnel 146 end points with
from 2007:106:1300:0:200:e2ff:fe3a:226d to 2007:106:2700:0:0:0:0:2
Mon Nov  5 13:47:47 __tunnel_mod: modified tunnel iface ip6tnl1
(146)from 2007:106:1300:0:200:e2ff:fe3a:226d to 2007:106:2700:0:0:0:0:2
Mon Nov  5 13:47:48 mn_move: 2353
Mon Nov  5 13:47:48 mn_move: in foreign net
Mon Nov  5 13:47:48 mn_block_rule_add: blackhole is already set.
RTNETLINK answers: No such file or directory
Mon Nov  5 13:47:48 mn_send_home_bu: 1021
Mon Nov  5 13:47:48 mn_get_home_lifetime: CoA lifetime 2591998 s, HoA
lifetime 4294967295 s, BU lifetime 20 s
Mon Nov  5 13:47:48 process_first_home_bu: Creating new tunnel for iface
4 (BID 202)
Mon Nov  5 13:47:48 __tunnel_add: created tunnel ip6tnl2 (147) from
2007:106:2700:0:0:0:0:10 to 2007:106:2700:0:0:0:0:2 user count 1
Mon Nov  5 13:47:48 process_first_home_bu: MN-HA tunnel created (iface
tnl = 147)
RTNETLINK answers: Cannot assign requested address
Mon Nov  5 13:47:48 flag_hoa: set HoA 2007:106:2700:0:0:0:0:10/128 iif
147 flags 12 preferred_time 4294967295 valid_time 4294967295
Mon Nov  5 13:47:48 process_first_home_bu: New bule for HA
RTNETLINK answers: File exists
Mon Nov  5 13:47:48 Failed to add policy:
Mon Nov  5 13:47:48 nlmsg_flags 405
nlmsg_type 19
Mon Nov  5 13:47:48 sel.daddr 2007:106:2700:0:0:0:0:2
sel.saddr 2007:106:2700:0:0:0:0:10
sel.dport 0
sel.dport_mask 0
sel.sport 0
sel.sport_mask 0
sel.prefixlen_d 128
sel.prefixlen_s 128
sel.proto 0
sel.ifindex 0
Mon Nov  5 13:47:48 priority 4
dir 1
action 1
type 1
Mon Nov  5 13:47:48 mn_pol_ext_cleanup: 
Mon Nov  5 13:47:48 __tunnel_del: tunnel ip6tnl2 (147) from
2007:106:2700:0:0:0:0:10 to 2007:106:2700:0:0:0:0:2 user count decreased
to 0
Mon Nov  5 13:47:48 __tunnel_del: tunnel deleted
Mon Nov  5 13:47:48 bul_delete: Deleting bule
== BUL_ENTRY ==
Home address    2007:106:2700:0:0:0:0:10
Care-of address 2007:106:2700:0:0:0:0:10
CN address      2007:106:2700:0:0:0:0:2
 lifetime = 20,  delay = 1500
 BID = 202, Priority = 200
 flags: IP6_MH_BU_HOME IP6_MH_BU_ACK 
Mon Nov  5 13:47:48 mn_recv_ba: 1359
Mon Nov  5 13:47:48 mn_recv_ba: Got BA from 2007:106:2700:0:0:0:0:2 to
home address 2007:106:2700:0:0:0:0:10 with coa
2007:106:1300:0:200:e2ff:fe3a:226d, bid 200 and status 0
Mon Nov  5 13:47:48 mn_recv_ba: Dumping corresponding BULE
== BUL_ENTRY ==
Home address    2007:106:2700:0:0:0:0:10
Care-of address 2007:106:1300:0:200:e2ff:fe3a:226d
CN address      2007:106:2700:0:0:0:0:2
 lifetime = 20,  delay = 1500
 BID = 200, Priority = 100
 flags: IP6_MH_BU_HOME IP6_MH_BU_ACK 
Mon Nov  5 13:47:48 set_bule_lifetime: Set bule lifetime to 20 (s) and
resend to bule->delay 19 (s)
Mon Nov  5 13:47:48 mn_recv_ba: Callback to bu_refresh after 19 seconds
Mon Nov  5 13:47:48 bul_update_timer: Updating timer
== BUL_ENTRY ==
Home address    2007:106:2700:0:0:0:0:10
Care-of address 2007:106:1300:0:200:e2ff:fe3a:226d
CN address      2007:106:2700:0:0:0:0:2
 lifetime = 20,  delay = 19000
 BID = 200, Priority = 100
 flags: IP6_MH_BU_HOME IP6_MH_BU_ACK 
mip6d[10091]: terminated (SIGINT)
Mon Nov  5 13:47:49 terminate: got SIGINT, exiting
Mon Nov  5 13:47:50 mh_send: sending MH type 5
from 2007:106:2700:0:0:0:0:10
to 2007:106:2700:0:0:0:0:2
Mon Nov  5 13:47:50 mh_send: local CoA
2007:106:1300:0:200:e2ff:fe3a:226d
Mon Nov  5 13:47:50 _xfrm_del_bule_data: Last entry for the peer,
deleting XFRM states
Mon Nov  5 13:47:50 xfrm_del_bule: Last entry for the peer, deleting
XFRM policies
Mon Nov  5 13:47:50 mn_pol_ext_cleanup: 
Mon Nov  5 13:47:50 __tunnel_del: tunnel ip6tnl1 (146) from
2007:106:1300:0:200:e2ff:fe3a:226d to 2007:106:2700:0:0:0:0:2 user count
decreased to 0
Mon Nov  5 13:47:50 __tunnel_del: tunnel deleted
Mon Nov  5 13:47:50 bul_delete: Deleting bule
== BUL_ENTRY ==
Home address    2007:106:2700:0:0:0:0:10
Care-of address 2007:106:2700:0:0:0:0:10
CN address      2007:106:2700:0:0:0:0:2
 lifetime = 0,  delay = 19000
 BID = 200, Priority = 100
 flags: IP6_MH_BU_HOME IP6_MH_BU_ACK 
RTNETLINK answers: No such file or directory
RTNETLINK answers: No such file or directory
Mon Nov  5 13:47:50 md_expire_router: expiring router
fe80:0:0:0:218:f8ff:fedb:a03d on iface eth1 (4)
Mon Nov  5 13:47:50 md_expire_router: expiring router
fe80:0:0:0:2a0:24ff:fe8c:cfde on iface eth0 (6)
Mon Nov  5 13:47:50 xfrm_mn_cleanup: Deleting policies and states for MN
Mon Nov  5 13:47:50 xfrm_mn_cleanup: Deleting RTHdr type 2 handling 2
state for MN
Mon Nov  5 13:47:50 xfrm_cn_cleanup: Deleting policies and states for CN
mip6d[10091]: MIPL Mobile IPv6 for Linux v2.0.2-umip-0.4 stopped (Mobile
Node)
El lun, 05-11-2007 a las 13:38 +0100, Romain KUNTZ escribió:
> Hi again Luis,
> 
> I managed to reproduce the problem. I'm working on it now and will  
> try to provide a new patch ASAP.
> 
> romain
> 
> On 2007/11/05, at 13:13, Romain KUNTZ wrote:
> 
> > Hi Luis,
> >
> > On 2007/11/02, at 13:14, Luis Campo Giralte wrote:
> >> Hi! i have the next problem on the last version of McoA(Version 2.3
> >> released on October 22nd and also the small update of October 26th).
> >
> > Thank you for testing the last version and reporting your problems.  
> > Let's try to investigate what's wrong.
> > First, which kernel version are you using?
> >
> >> my mip6.conf on the mobile router side looks like:
> >
> > Your config looks fine.
> >
> >> when the mip6d start only one interface its register on the home- 
> >> agent
> >> and with the other interface on the debug terminal messages  
> >> appears the
> >> next messages:
> >
> > Could you send the full log from the MR? (from the beginning to  
> > this error). Maybe we can get more information from it. More  
> > comments inline:
> >
> >> Fri Nov  2 12:47:19 process_first_home_bu: Creating new tunnel for  
> >> iface
> >> 6 (BID 200)
> >> Fri Nov  2 12:47:19 __tunnel_add: created tunnel ip6tnl2 (11) from
> >> 2007:106:2700:0:0:0:0:10 to 2007:106:2700:0:0:0:0:2 user count 1
> >> Fri Nov  2 12:47:19 process_first_home_bu: MN-HA tunnel created  
> >> (iface
> >> tnl = 11)
> >> Fri Nov  2 12:47:19 flag_hoa: set HoA 2007:106:2700:0:0:0:0:10/128  
> >> iif
> >> 11 flags 12 preferred_time 4294967295 valid_time 4294967295
> >> Fri Nov  2 12:47:19 process_first_home_bu: New bule for HA
> >> Fri Nov  2 12:47:19 Failed to add policy:
> >
> > Here UMIP tries to install a policy that already exists.
> > In src/xfrm.c, in the xfrm_pre_bu_add_bule() function, could you  
> > add the following piece of code at the beginning:
> >
> > int count = mcoa_bule_count(bule);
> > XDBG("XXX mcoa_bule_count = %d\n", count);
> >
> > then recompile UMIP, test and send the logs here? That would help  
> > me to debug.
> >
> > Regards,
> > romain
> >
> >
> > _______________________________________________
> > Support mailing list
> > Support at ml.nautilus6.org
> > http://ml.nautilus6.org/mailman/listinfo/support
> 
> _______________________________________________
> Support mailing list
> Support at ml.nautilus6.org
> http://ml.nautilus6.org/mailman/listinfo/support
-- 
Luis Campo Giralte     e-mail: lcg223 at tid.es
TELEFÓNICA INVESTIGACIÓN Y DESARROLLO                                  
Protocolos y Nucleos de Red     
C/ Emilio Vargas 6 - 28043 Madrid - Spain



More information about the Support mailing list