[hipl-dev] [Bug 795231] Re: mobility and echo request problem

  • From: Miika Komu <795231@xxxxxxxxxxxxxxxxxx>
  • To: hipl-dev@xxxxxxxxxxxxx
  • Date: Tue, 21 Jun 2011 13:57:29 -0000

On my LAN, the additional delay seems to be roughly 90 seconds. This
will have drastic effect on TCP connectivity.

-- 
You received this bug notification because you are a member of HIPL core
team, which is subscribed to HIPL.
https://bugs.launchpad.net/bugs/795231

Title:
  mobility and echo request problem

Status in Host Identity Protocol for Linux:
  Confirmed

Bug description:
  As noted in bug report #789327, mobility code suffers from a strange
  echo request problem. In the first handover, the mobile node seems to
  forget to include an echo request to the UPDATE packet and the
  correspondent node gives the error below. Correspondent node fails to
  set up SAs correctly until few minutes retransmissions after which
  there's probably a successful handover.

  Stefan tested the problem with IPv4 and I tested it with IPv6. Here's
  my log from the CN:

  debug(modules/heartbeat/hipd/heartbeat.c:180@hip_send_icmp): Sent heartbeat 
to: 2001:0019:11ac:e3af:2367:11a4:1a36:36ec
  debug(modules/heartbeat/hipd/heartbeat.c:379@hip_send_heartbeat: 
heartbeat_counter: 1
  debug(hipd/hip_socket.c:69@hip_handle_raw_input_v6): received on: 
hip_raw_sock_input_v6
  debug(lib/core/message.c:672@hip_read_control_msg_v6): Receiving a message on 
raw HIP from IPv6/HIP socket  (file descriptor: 9).
  debug(lib/core/message.c:562@hip_read_control_msg_all): 
hip_read_control_msg_all() invoked.
  debug(lib/core/builder.c:1920@hip_verify_network_header): Received a 
connection to HIT: 2001:0015:e156:8a78:3226:dbaa:f2ff:ed06
  debug(lib/core/builder.c:1924@hip_verify_network_header): dst port is 0  
  debug(lib/tool/checksum.c:278@hip_checksum_packet): Checksumming 304 bytes of 
data.
  debug(lib/core/message.c:652@hip_read_control_msg_all): src: 
3ffe:0000:0000:0000:0000:0000:0000:0012
  debug(lib/core/message.c:653@hip_read_control_msg_all): dst: 
3ffe:0000:0000:0000:0000:0000:0000:0001
  debug(hipd/hidb.c:326@hip_get_hostid_entry_by_lhi_and_algo): Failed to find a 
host ID entry.
  info(hipd/input.c:530@hip_receive_control_packet): Src IP: 
3ffe:0000:0000:0000:0000:0000:0000:0012
  info(hipd/input.c:531@hip_receive_control_packet): Dst IP: 
3ffe:0000:0000:0000:0000:0000:0000:0001
  debug(hipd/input.c:532@hip_receive_control_packet): Src port: 0
  debug(hipd/input.c:533@hip_receive_control_packet): Dst port: 0
  debug(hipd/input.c:534@hip_receive_control_packet):  dump: 
  debug(lib/core/builder.c:1263@hip_dump_msg): --------------- MSG START 
------------------
  debug(lib/core/builder.c:1264@hip_dump_msg): HIT Sender  : 
2001:0019:11ac:e3af:2367:11a4:1a36:36ec
  debug(lib/core/builder.c:1265@hip_dump_msg): HIT Receiver: 
2001:0015:e156:8a78:3226:dbaa:f2ff:ed06
  debug(lib/core/builder.c:1268@hip_dump_msg): Msg type :      HIP_UPDATE (16)
  debug(lib/core/builder.c:1269@hip_dump_msg): Msg length:     304
  debug(lib/core/builder.c:1270@hip_dump_msg): Msg err:        31599
  debug(lib/core/builder.c:1271@hip_dump_msg): Msg controls:   0x0000
  debug(lib/core/builder.c:1286@hip_dump_msg): Parameter 
type:HIP_PARAM_ESP_INFO (65). Total length: 16 (4 type+length, 12 content, 0 
padding).
  debug(lib/core/builder.c:1287@hip_dump_msg): 
Contents:0x00000090CFEF6E53CFEF6E53
  debug(lib/core/builder.c:1286@hip_dump_msg): Parameter type:HIP_PARAM_LOCATOR 
(193). Total length: 80 (4 type+length, 72 content, 4 padding).
  debug(lib/core/builder.c:1287@hip_dump_msg): 
Contents:0x000104000000000000000000000000000000FFFFC0A800A500010400000000003FFE000000000000000000000000001200010400000000002001000053AA064C14E53F92AD4A59A7
  debug(lib/core/builder.c:1288@hip_dump_msg): Padding:0x00000000
  debug(lib/core/builder.c:1286@hip_dump_msg): Parameter type:HIP_PARAM_SEQ 
(385). Total length: 8 (4 type+length, 4 content, 0 padding).
  debug(lib/core/builder.c:1287@hip_dump_msg): Contents:0x00000004
  debug(lib/core/builder.c:1286@hip_dump_msg): Parameter type:HIP_PARAM_HMAC 
(61505). Total length: 24 (4 type+length, 20 content, 0 padding).
  debug(lib/core/builder.c:1287@hip_dump_msg): 
Contents:0xD9BBA76DDDCBDFE033624CC6B3381857DCB87327
  debug(lib/core/builder.c:1286@hip_dump_msg): Parameter 
type:HIP_PARAM_HIP_SIGNATURE (61697). Total length: 136 (4 type+length, 129 
content, 3 padding).
  debug(lib/core/builder.c:1287@hip_dump_msg): 
Contents:0x058AB5B82DE33567F5107BD08C21B6D14B27EC808AE3655205D98CEDE5D7E8163FFDD867269F70B32E710A0C1ED87F3A5BB16E2A3BE6EE4A9F2C49E22D2BA434DEB918F1FFBA6C4561BCC48E4A73B1E58804B94865C697CCBAE5A5528211EC115D98A1673AEC6BF9DD8C89DF08249F70E2C9D4DA8CF396105538BC38D5CD911064
  debug(lib/core/builder.c:1288@hip_dump_msg): Padding:0x000000
  debug(lib/core/builder.c:1290@hip_dump_msg): ---------------- MSG END 
--------------------
  debug(hipd/hadb.c:249@hip_hadb_find_byhits): Local HIT: 
2001:0019:11ac:e3af:2367:11a4:1a36:36ec
  debug(hipd/hadb.c:250@hip_hadb_find_byhits): Remote HIT: 
2001:0015:e156:8a78:3226:dbaa:f2ff:ed06
  debug(hipd/input.c:565@hip_receive_control_packet): HIP association state 
ESTABLISHED
  debug(hipd/input.c:573@hip_receive_control_packet): handle relay to failed, 
continue the bex handler
  debug(modules/update/hipd/update.c:190@hip_check_update_freshne: previous 
incoming update id=2
  debug(modules/update/hipd/update.c:192@hip_check_update_freshne: previous 
outgoing update id=2
  debug(modules/update/hipd/update.c:198@hip_check_update_freshne: SEQ 
parameter found with Update ID 4.
  debug(hipd/input.c:144@hip_verify_packet_hmac_general): 
hip_verify_packet_hmac() invoked.
  debug(hipd/input.c:111@hip_verify_hmac): HMAC 
data0x3B111011000000002001001911ACE3AF236711A41A3636EC20010015E1568A783226DBAAF2FFED060041000C00000090CFEF6E53CFEF6E5300C10048000104000000000000000000000000000000FFFFC0A800A500010400000000003FFE000000000000000000000000001200010400000000002001000053AA064C14E53F92AD4A59A7000000000181000400000004
  debug(lib/core/crypto.c:378@hip_write_hmac): HMAC 
key:0xBBC7D71516BEAB599DF37DB0D690F0323BEFB76B
  debug(lib/core/crypto.c:379@hip_write_hmac): HMAC 
in:0x3B111011000000002001001911ACE3AF236711A41A3636EC20010015E1568A783226DBAAF2FFED060041000C00000090CFEF6E53CFEF6E5300C10048000104000000000000000000000000000000FFFFC0A800A500010400000000003FFE000000000000000000000000001200010400000000002001000053AA064C14E53F92AD4A59A7000000000181000400000004
  debug(lib/core/crypto.c:380@hip_write_hmac): HMAC 
out:0xD9BBA76DDDCBDFE033624CC6B3381857DCB87327
  debug(hipd/input.c:117@hip_verify_hmac): 
HMAC0xD9BBA76DDDCBDFE033624CC6B3381857DCB87327
  debug(modules/update/hipd/update_param_handling.c:342@hip_handl: LOCATOR has 
3 address(es), loc param len=80
  debug(modules/update/hipd/update_param_handling.c:349@hip_handl: 
hip_get_state_item returned localstate: 0x21fa290
  debug(modules/update/hipd/update_param_handling.c:363@hip_handl: Comparing: 
3ffe:0000:0000:0000:0000:0000:0000:0012
  debug(modules/update/hipd/update_param_handling.c:364@hip_handl: to : 
192.168.0.165
  debug(modules/update/hipd/update_param_handling.c:363@hip_handl: Comparing: 
3ffe:0000:0000:0000:0000:0000:0000:0012
  debug(modules/update/hipd/update_param_handling.c:364@hip_handl: to : 
3ffe:0000:0000:0000:0000:0000:0000:0012
  debug(modules/update/hipd/update_param_handling.c:363@hip_handl: Comparing: 
3ffe:0000:0000:0000:0000:0000:0000:0012
  debug(modules/update/hipd/update_param_handling.c:364@hip_handl: to : 
2001:0000:53aa:064c:14e5:3f92:ad4a:59a7
  debug(modules/update/hipd/update_param_handling.c:85@hip_print_: Addresses to 
send update:
  debug(modules/update/hipd/update_param_handling.c:87@hip_print_: : 
192.168.0.165
  debug(modules/update/hipd/update_param_handling.c:87@hip_print_: : 
3ffe:0000:0000:0000:0000:0000:0000:0012
  debug(modules/update/hipd/update_param_handling.c:87@hip_print_: : 
2001:0000:53aa:064c:14e5:3f92:ad4a:59a7
  debug(modules/update/hipd/update_param_handling.c:178@hip_add_s: outgoing 
UPDATE ID=3
  debug(modules/update/hipd/update_param_handling.c:259@hip_add_e: ECHO_REQUEST 
in the host association0x479820C7
  error(modules/update/hipd/update_param_handling.c:293@hip_handl: ECHO_REQUEST 
parameter not found!
  debug(lib/core/crypto.c:378@hip_write_hmac): HMAC 
key:0x7C4E5670709642AC20AE3806E8DB7473217CD036
  debug(lib/core/crypto.c:379@hip_write_hmac): HMAC 
in:0x3B0910110000000020010015E1568A783226DBAAF2FFED062001001911ACE3AF236711A41A3636EC0041000C00000090D5F95E22D5F95E22018100040000000301C100040000000403810004479820C7
  debug(lib/core/crypto.c:380@hip_write_hmac): HMAC 
out:0x502D543C55343C2E15630F9A66DA204409BF01DF
  debug(modules/update/hipd/update.c:307@hip_send_update_packet): Sending echo 
requests from: 3ffe:0000:0000:0000:0000:0000:0000:0001
  debug(modules/update/hipd/update.c:308@hip_send_update_packet): to: 
3ffe:0000:0000:0000:0000:0000:0000:0012
  debug(hipd/output.c:1200@hip_send_raw_from_one_src): Sending HIP_UPDATE packet
  debug(hipd/output.c:1201@hip_send_raw_from_one_src): hip_send_raw(): 
local_addr: 3ffe:0000:0000:0000:0000:0000:0000:0001
  debug(hipd/output.c:1202@hip_send_raw_from_one_src): hip_send_raw(): 
peer_addr: 3ffe:0000:0000:0000:0000:0000:0000:0012
  debug(hipd/output.c:1203@hip_send_raw_from_one_src): Source port=0, 
destination port=0
  debug(hipd/output.c:1204@hip_send_raw_from_one_src):  dump: 
  debug(lib/core/builder.c:1263@hip_dump_msg): --------------- MSG START 
------------------
  debug(lib/core/builder.c:1264@hip_dump_msg): HIT Sender  : 
2001:0015:e156:8a78:3226:dbaa:f2ff:ed06
  debug(lib/core/builder.c:1265@hip_dump_msg): HIT Receiver: 
2001:0019:11ac:e3af:2367:11a4:1a36:36ec
  debug(lib/core/builder.c:1268@hip_dump_msg): Msg type :      HIP_UPDATE (16)
  debug(lib/core/builder.c:1269@hip_dump_msg): Msg length:     240
  debug(lib/core/builder.c:1270@hip_dump_msg): Msg err:        0
  debug(lib/core/builder.c:1271@hip_dump_msg): Msg controls:   0x0000
  debug(lib/core/builder.c:1286@hip_dump_msg): Parameter 
type:HIP_PARAM_ESP_INFO (65). Total length: 16 (4 type+length, 12 content, 0 
padding).
  debug(lib/core/builder.c:1287@hip_dump_msg): 
Contents:0x00000090D5F95E22D5F95E22
  debug(lib/core/builder.c:1286@hip_dump_msg): Parameter type:HIP_PARAM_SEQ 
(385). Total length: 8 (4 type+length, 4 content, 0 padding).
  debug(lib/core/builder.c:1287@hip_dump_msg): Contents:0x00000003
  debug(lib/core/builder.c:1286@hip_dump_msg): Parameter type:HIP_PARAM_ACK 
(449). Total length: 8 (4 type+length, 4 content, 0 padding).
  debug(lib/core/builder.c:1287@hip_dump_msg): Contents:0x00000004
  debug(lib/core/builder.c:1286@hip_dump_msg): Parameter 
type:HIP_PARAM_ECHO_REQUEST_SIGN (897). Total length: 8 (4 type+length, 4 
content, 0 padding).
  debug(lib/core/builder.c:1287@hip_dump_msg): Contents:0x479820C7
  debug(lib/core/builder.c:1286@hip_dump_msg): Parameter type:HIP_PARAM_HMAC 
(61505). Total length: 24 (4 type+length, 20 content, 0 padding).
  debug(lib/core/builder.c:1287@hip_dump_msg): 
Contents:0x502D543C55343C2E15630F9A66DA204409BF01DF
  debug(lib/core/builder.c:1286@hip_dump_msg): Parameter 
type:HIP_PARAM_HIP_SIGNATURE (61697). Total length: 136 (4 type+length, 129 
content, 3 padding).
  debug(lib/core/builder.c:1287@hip_dump_msg): 
Contents:0x0593FA2C2ED22BFB5B9A9A0C871597BAFD3309C66F348454A60549DEF87C5697C58DB3E05069E1225CCD94D5475CF696CC4626F35873A664FB53D2F4D762D041511FDF15D113B754367E37A22F6239E8A7B45E27B151F9F691DCB5329E601ECD6354D5334FAA2885FBDD452554C48CC89BA8120281A0DC8FF694B924DC35B39569
  debug(lib/core/builder.c:1288@hip_dump_msg): Padding:0x000000
  debug(lib/core/builder.c:1290@hip_dump_msg): ---------------- MSG END 
--------------------
  debug(hipd/output.c:1233@hip_send_raw_from_one_src): Using IPv6 raw socket
  debug(hipd/output.c:1239@hip_send_raw_from_one_src): local address given
  debug(hipd/output.c:1256@hip_send_raw_from_one_src): src6: 
3ffe:0000:0000:0000:0000:0000:0000:0001
  debug(hipd/output.c:1267@hip_send_raw_from_one_src): dst6: 
3ffe:0000:0000:0000:0000:0000:0000:0012
  debug(lib/tool/checksum.c:278@hip_checksum_packet): Checksumming 240 bytes of 
data.
  debug(hipd/output.c:1344@hip_send_raw_from_one_src): sent=240/240 ipv4=0
  debug(hipd/output.c:1345@hip_send_raw_from_one_src): Packet sent ok
  debug(modules/update/hipd/update.c:307@hip_send_update_packet): Sending echo 
requests from: 3ffe:0000:0000:0000:0000:0000:0000:0001
  debug(modules/update/hipd/update.c:308@hip_send_update_packet): to: 
2001:0000:53aa:064c:14e5:3f92:ad4a:59a7
  debug(hipd/output.c:1200@hip_send_raw_from_one_src): Sending HIP_UPDATE packet
  debug(hipd/output.c:1201@hip_send_raw_from_one_src): hip_send_raw(): 
local_addr: 3ffe:0000:0000:0000:0000:0000:0000:0001
  debug(hipd/output.c:1202@hip_send_raw_from_one_src): hip_send_raw(): 
peer_addr: 2001:0000:53aa:064c:14e5:3f92:ad4a:59a7
  debug(hipd/output.c:1203@hip_send_raw_from_one_src): Source port=0, 
destination port=0
  debug(hipd/output.c:1204@hip_send_raw_from_one_src):  dump: 
  debug(lib/core/builder.c:1263@hip_dump_msg): --------------- MSG START 
------------------
  debug(lib/core/builder.c:1264@hip_dump_msg): HIT Sender  : 
2001:0015:e156:8a78:3226:dbaa:f2ff:ed06
  debug(lib/core/builder.c:1265@hip_dump_msg): HIT Receiver: 
2001:0019:11ac:e3af:2367:11a4:1a36:36ec
  debug(lib/core/builder.c:1268@hip_dump_msg): Msg type :      HIP_UPDATE (16)
  debug(lib/core/builder.c:1269@hip_dump_msg): Msg length:     240
  debug(lib/core/builder.c:1270@hip_dump_msg): Msg err:        6590
  debug(lib/core/builder.c:1271@hip_dump_msg): Msg controls:   0x0000
  debug(lib/core/builder.c:1286@hip_dump_msg): Parameter 
type:HIP_PARAM_ESP_INFO (65). Total length: 16 (4 type+length, 12 content, 0 
padding).
  debug(lib/core/builder.c:1287@hip_dump_msg): 
Contents:0x00000090D5F95E22D5F95E22
  debug(lib/core/builder.c:1286@hip_dump_msg): Parameter type:HIP_PARAM_SEQ 
(385). Total length: 8 (4 type+length, 4 content, 0 padding).
  debug(lib/core/builder.c:1287@hip_dump_msg): Contents:0x00000003
  debug(lib/core/builder.c:1286@hip_dump_msg): Parameter type:HIP_PARAM_ACK 
(449). Total length: 8 (4 type+length, 4 content, 0 padding).
  debug(lib/core/builder.c:1287@hip_dump_msg): Contents:0x00000004
  debug(lib/core/builder.c:1286@hip_dump_msg): Parameter 
type:HIP_PARAM_ECHO_REQUEST_SIGN (897). Total length: 8 (4 type+length, 4 
content, 0 padding).
  debug(lib/core/builder.c:1287@hip_dump_msg): Contents:0x479820C7
  debug(lib/core/builder.c:1286@hip_dump_msg): Parameter type:HIP_PARAM_HMAC 
(61505). Total length: 24 (4 type+length, 20 content, 0 padding).
  debug(lib/core/builder.c:1287@hip_dump_msg): 
Contents:0x502D543C55343C2E15630F9A66DA204409BF01DF
  debug(lib/core/builder.c:1286@hip_dump_msg): Parameter 
type:HIP_PARAM_HIP_SIGNATURE (61697). Total length: 136 (4 type+length, 129 
content, 3 padding).
  debug(lib/core/builder.c:1287@hip_dump_msg): 
Contents:0x0593FA2C2ED22BFB5B9A9A0C871597BAFD3309C66F348454A60549DEF87C5697C58DB3E05069E1225CCD94D5475CF696CC4626F35873A664FB53D2F4D762D041511FDF15D113B754367E37A22F6239E8A7B45E27B151F9F691DCB5329E601ECD6354D5334FAA2885FBDD452554C48CC89BA8120281A0DC8FF694B924DC35B39569
  debug(lib/core/builder.c:1288@hip_dump_msg): Padding:0x000000
  debug(lib/core/builder.c:1290@hip_dump_msg): ---------------- MSG END 
--------------------
  debug(hipd/output.c:1233@hip_send_raw_from_one_src): Using IPv6 raw socket
  debug(hipd/output.c:1239@hip_send_raw_from_one_src): local address given
  debug(hipd/output.c:1256@hip_send_raw_from_one_src): src6: 
3ffe:0000:0000:0000:0000:0000:0000:0001
  debug(hipd/output.c:1267@hip_send_raw_from_one_src): dst6: 
2001:0000:53aa:064c:14e5:3f92:ad4a:59a7
  debug(lib/tool/checksum.c:278@hip_checksum_packet): Checksumming 240 bytes of 
data.
  debug(hipd/output.c:1344@hip_send_raw_from_one_src): sent=240/240 ipv4=0
  debug(hipd/output.c:1345@hip_send_raw_from_one_src): Packet sent ok
  debug(hipd/input.c:591@hip_receive_control_packet): Done with control packet, 
err is 0.
  debug(hipd/hip_socket.c:308@hip_run_socket_handles): result: 0
  debug(modules/heartbeat/hipd/heartbeat.c:180@hip_send_icmp): Sent heartbeat 
to: 2001:0019:11ac:e3af:2367:11a4:1a36:36ec
  debug(modules/heartbeat/hipd/heartbeat.c:379@hip_send_heartbeat: 
heartbeat_counter: 2
  ^Cerror(hipd/init.c:996@hip_close): Caught signal: 2
  debug(hipd/close.c:172@hip_send_close): msg=(nil)
  debug(hipd/close.c:83@hip_xmit_close): Peer HIT to be closed: 
0000:0000:0000:0000:0000:0000:0000:0000
  debug(hipd/close.c:106@hip_xmit_close): State is ESTABLISHED in current host 
association, sending CLOSE message to peer.
  debug(hipd/hidb.c:326@hip_get_hostid_entry_by_lhi_and_algo): Failed to find a 
host ID entry.
  debug(hipd/maintenance.c:374@hip_firewall_set_bex_data): BEX DATA Send to 
firewall OK.
  debug(lib/core/crypto.c:378@hip_write_hmac): HMAC 
key:0x7C4E5670709642AC20AE3806E8DB7473217CD036
  debug(lib/core/crypto.c:379@hip_write_hmac): HMAC 
in:0x3B0512110000000020010015E1568A783226DBAAF2FFED062001001911ACE3AF236711A41A3636EC038100044FBF41C7
  debug(lib/core/crypto.c:380@hip_write_hmac): HMAC 
out:0xBA8C40354F0FDCA733C52DA225BFD1BE0F84FD38
  debug(hipd/output.c:1200@hip_send_raw_from_one_src): Sending HIP_CLOSE packet
  debug(lib/core/debug.c:741@hip_print_hit): hip_send_raw(): local_addr: NULL
  debug(hipd/output.c:1202@hip_send_raw_from_one_src): hip_send_raw(): 
peer_addr: 3ffe:0000:0000:0000:0000:0000:0000:0011
  debug(hipd/output.c:1203@hip_send_raw_from_one_src): Source port=0, 
destination port=0
  debug(hipd/output.c:1204@hip_send_raw_from_one_src):  dump: 
  debug(lib/core/builder.c:1263@hip_dump_msg): --------------- MSG START 
------------------
  debug(lib/core/builder.c:1264@hip_dump_msg): HIT Sender  : 
2001:0015:e156:8a78:3226:dbaa:f2ff:ed06
  debug(lib/core/builder.c:1265@hip_dump_msg): HIT Receiver: 
2001:0019:11ac:e3af:2367:11a4:1a36:36ec
  debug(lib/core/builder.c:1268@hip_dump_msg): Msg type :      HIP_CLOSE (18)
  debug(lib/core/builder.c:1269@hip_dump_msg): Msg length:     208
  debug(lib/core/builder.c:1270@hip_dump_msg): Msg err:        0
  debug(lib/core/builder.c:1271@hip_dump_msg): Msg controls:   0x0000
  debug(lib/core/builder.c:1286@hip_dump_msg): Parameter 
type:HIP_PARAM_ECHO_REQUEST_SIGN (897). Total length: 8 (4 type+length, 4 
content, 0 padding).
  debug(lib/core/builder.c:1287@hip_dump_msg): Contents:0x4FBF41C7
  debug(lib/core/builder.c:1286@hip_dump_msg): Parameter type:HIP_PARAM_HMAC 
(61505). Total length: 24 (4 type+length, 20 content, 0 padding).
  debug(lib/core/builder.c:1287@hip_dump_msg): 
Contents:0xBA8C40354F0FDCA733C52DA225BFD1BE0F84FD38
  debug(lib/core/builder.c:1286@hip_dump_msg): Parameter 
type:HIP_PARAM_HIP_SIGNATURE (61697). Total length: 136 (4 type+length, 129 
content, 3 padding).
  debug(lib/core/builder.c:1287@hip_dump_msg): 
Contents:0x051FCD73A5979207D77B3193B7F8FAB65ED576CB24A549BFF6978A559538C32D5D209795E9D015B58A35B3D1C89FC22A1E1BC4829C40C06881F0DED3169F26FD264305EB7C032F25BD02F1BCE18F6386B779FF9D1E84AA18422E64D198CFD6A7232E63F8A9FF6EB04DA4346FA7C67F087A0A5DEF401EA5D787C8C22585D8EF0B75
  debug(lib/core/builder.c:1288@hip_dump_msg): Padding:0x000000
  debug(lib/core/builder.c:1290@hip_dump_msg): ---------------- MSG END 
--------------------
  debug(hipd/output.c:1233@hip_send_raw_from_one_src): Using IPv6 raw socket
  debug(hipd/output.c:1242@hip_send_raw_from_one_src): no local address, 
selecting one
  debug(hipd/netdev.c:1404@hip_select_source_address): dst: 
3ffe:0000:0000:0000:0000:0000:0000:0011
  debug(lib/tool/nlink.c:1109@hip_iproute_get): Getting route for destination 
address: 3ffe:0000:0000:0000:0000:0000:0000:0011
  error(lib/tool/nlink.c:882@parse_rtattr): Deficit len 28, rta_len=0
  debug(hipd/netdev.c:1432@hip_select_source_address): src: 
3ffe:0000:0000:0000:0000:0000:0000:0001
  debug(hipd/output.c:1256@hip_send_raw_from_one_src): src6: 
3ffe:0000:0000:0000:0000:0000:0000:0001
  debug(hipd/output.c:1267@hip_send_raw_from_one_src): dst6: 
3ffe:0000:0000:0000:0000:0000:0000:0011
  debug(lib/tool/checksum.c:278@hip_checksum_packet): Checksumming 208 bytes of 
data.
  debug(hipd/output.c:1344@hip_send_raw_from_one_src): sent=208/208 ipv4=0
  debug(hipd/output.c:1345@hip_send_raw_from_one_src): Packet sent ok
  debug(hipd/user.c:228@hip_sendto_user): Sending msg type 98
  debug(hipd/close.c:210@hip_send_close): resetof  firewall db ok (sent 40 
bytes)
  debug(hipd/init.c:1003@hip_close): Starting to close HIP daemon...
  error(hipd/hipd.c:396@hipd_main): select() error: Interrupted system call.
  error(hipd/hipd.c:409@hipd_main): Error (1) ignoring. Interrupted system call
  error(hipd/hipd.c:409@hipd_main): Error (1) ignoring. Interrupted system call
  error(hipd/hipd.c:409@hipd_main): Error (1) ignoring. Interrupted system call
  error(hipd/hipd.c:409@hipd_main): Error (1) ignoring. Interrupted system call
  error(hipd/hipd.c:409@hipd_main): Error (1) ignoring. Interrupted system call
  debug(hipd/hadb.c:1159@hip_delete_all_sp): 
  debug(hipd/hadb.c:1161@hip_delete_all_sp): DEBUG: DUMP SPI LISTS
  debug(hipd/hadb.c:1163@hip_delete_all_sp): DELETING HA HT
  debug(hipd/netdev.c:513@hip_delete_all_addresses): address to be deleted
  : 3ffe:0000:0000:0000:0000:0000:0000:0001
  debug(hipd/netdev.c:513@hip_delete_all_addresses): address to be deleted
  : 2001:0000:53aa:064c:248a:3aa6:ad4a:59a7
  debug(hipd/netdev.c:513@hip_delete_all_addresses): address to be deleted
  : 192.168.0.2
  error(lib/tool/nlink.c:1325@do_chflags): SIOCSIFFLAGSCannot assign requested 
address
  debug(hipd/hidb.c:710@hip_for_each_hi): Found HIT: 
2001:0015:e156:8a78:3226:dbaa:f2ff:ed06
  debug(hipd/hidb.c:711@hip_for_each_hi): Found LSI: 1.0.0.1
  debug(hipd/netdev.c:1294@hip_manage_iface_local_hit): Removing HIT: 
2001:0015:e156:8a78:3226:dbaa:f2ff:ed06/28
  debug(lib/tool/nlink.c:1253@hip_ipaddr_modify): IFA INDEX IS 6
  debug(lib/tool/nlink.c:1257@hip_ipaddr_modify): value exit function 
netlink_talk 0
  info(hipd/init.c:911@hip_exit): Uninitializing RVS / HIP relay database and 
whitelist.
  debug(hipd/hiprelay.c:613@hip_relwl_hit_free_doall): HIT deleted from the 
relay whitelist.
  info(hipd/init.c:916@hip_exit): hip_raw_sock_input_v6
  info(hipd/init.c:921@hip_exit): hip_raw_sock_output_v6
  info(hipd/init.c:926@hip_exit): hip_raw_sock_input_v4
  info(hipd/init.c:931@hip_exit): hip_raw_sock_output_v4
  info(hipd/init.c:936@hip_exit): hip_nat_sock_input_udp
  info(hipd/init.c:941@hip_exit): hip_nat_sock_output_udp
  debug(hipd/hadb.c:927@hip_del_peer_info_entry): our HIT: 
2001:0015:e156:8a78:3226:dbaa:f2ff:ed06
  debug(hipd/hadb.c:928@hip_del_peer_info_entry): peer HIT: 
2001:0019:11ac:e3af:2367:11a4:1a36:36ec
  debug(hipd/hadb.c:1483@hip_delete_security_associations_and_sp): Previous SPI 
out =0xcfef6e53
  debug(hipd/hadb.c:1484@hip_delete_security_associations_and_sp): Previous SPI 
in =0xd5f95e22
  debug(hipd/hadb.c:1486@hip_delete_security_associations_and_sp): Our current 
active addr: 3ffe:0000:0000:0000:0000:0000:0000:0001
  debug(hipd/hadb.c:1487@hip_delete_security_associations_and_sp): Peer's 
current active addr: 3ffe:0000:0000:0000:0000:0000:0000:0011
  debug(lib/tool/xfrmapi.c:543@hip_xfrm_state_delete): IPV6 SA deletion
  debug(lib/tool/xfrmapi.c:548@hip_xfrm_state_delete): sport 0, dport 0
  debug(lib/tool/xfrmapi.c:567@hip_xfrm_state_delete): deleting xfrm state with 
spi 0xcfef6e53
  debug(lib/tool/xfrmapi.c:568@hip_xfrm_state_delete): SA peer addr: 
0x3FFE0000000000000000000000000011
  debug(lib/tool/xfrmapi.c:678@hip_delete_sa): outbound IPsec SA deleted
  debug(lib/tool/xfrmapi.c:543@hip_xfrm_state_delete): IPV6 SA deletion
  debug(lib/tool/xfrmapi.c:548@hip_xfrm_state_delete): sport 0, dport 0
  debug(lib/tool/xfrmapi.c:567@hip_xfrm_state_delete): deleting xfrm state with 
spi 0xd5f95e22
  debug(lib/tool/xfrmapi.c:568@hip_xfrm_state_delete): SA peer addr: 
0x3FFE0000000000000000000000000001
  debug(lib/tool/xfrmapi.c:685@hip_delete_sa): inbound IPsec SA deleted
  debug(hipd/hadb.c:866@hip_hadb_delete_state): ha=0x0x21f8890

To manage notifications about this bug go to:
https://bugs.launchpad.net/hipl/+bug/795231/+subscriptions

Other related posts: