[Openswan dev] odd behaviour in new test, deleted conn to OE?

[Paul Wouters]

On Tue, 10 Feb 2004, Paul Wouters wrote:

> I have a conn for the bofh-fedoratest connection. bofh is my desktop, on
> 193.110.157.17, and the fedorabox is on 193.110.157.22. bofh is also doing OE,
> while the fedorabox can't do OE, since it has no key in the DNS. Yet, after
> deleting the fedoratets conn on bofh, I got an OE connection from bofh to
> fedoratest:

So then I thought to be evil and get the normal tunnel up and see what would
happen. Fire and brimstone!

 Feb 10 12:23:59 bofh pluto[850]: "fedoratest": deleting connection
Feb 10 12:23:59 bofh pluto[850]: "fedoratest" #91: deleting state (STATE_MAIN_I1)
Feb 10 12:23:59 bofh pluto[850]: "fedoratest" #93: deleting state (STATE_QUICK_R2)
Feb 10 12:24:00 bofh pluto[850]: "fedoratest" #92: deleting state (STATE_MAIN_R3)
Feb 10 12:24:00 bofh pluto[850]: packet from 193.110.157.22:500: Informational Exchange is for an unknown (expired?) SA
Feb 10 12:24:09 bofh pluto[850]: "packetdefault"[2] 0.0.0.0/0=== ...193.110.157.22===? #94: responding to Main Mode from unknown peer 193.110.157.22
Feb 10 12:24:09 bofh pluto[850]: "packetdefault"[2] 0.0.0.0/0=== ...193.110.157.22===? #94: transition from state (null) to state STATE_MAIN_R1
Feb 10 12:24:09 bofh pluto[850]: "packetdefault"[2] 0.0.0.0/0=== ...193.110.157.22===? #94: transition from state STATE_MAIN_R1 to state STATE_MAIN_R2
Feb 10 12:24:10 bofh pluto[850]: "packetdefault"[2] 0.0.0.0/0=== ...193.110.157.22===? #94: Peer ID is ID_IPV4_ADDR: '193.110.157.22'
Feb 10 12:24:10 bofh pluto[850]: "packetdefault"[2] 0.0.0.0/0=== ...193.110.157.22===? #94: transition from state STATE_MAIN_R2 to state STATE_MAIN_R3
Feb 10 12:24:10 bofh pluto[850]: "packetdefault"[2] 0.0.0.0/0=== ...193.110.157.22===? #94: sent MR3, ISAKMP SA established
Feb 10 12:24:10 bofh pluto[850]: "private-or-clear#0.0.0.0/0"[4] ...193.110.157.22 #95: responding to Quick Mode
Feb 10 12:24:10 bofh pluto[850]: "private-or-clear#0.0.0.0/0"[4] ...193.110.157.22 #95: transition from state (null) to state STATE_QUICK_R1
Feb 10 12:24:10 bofh pluto[850]: "private-or-clear#0.0.0.0/0"[4] ...193.110.157.22 #96: responding to Quick Mode
Feb 10 12:24:10 bofh pluto[850]: "private-or-clear#0.0.0.0/0"[4] ...193.110.157.22 #96: transition from state (null) to state STATE_QUICK_R1
Feb 10 12:24:10 bofh pluto[850]: "private-or-clear#0.0.0.0/0"[4] ...193.110.157.22 #95: transition from state STATE_QUICK_R1 to state STATE_QUICK_R2
Feb 10 12:24:10 bofh pluto[850]: "private-or-clear#0.0.0.0/0"[4] ...193.110.157.22 #95: IPsec SA established {ESP=>0x150999c8 <0xdbc6d513}
Feb 10 12:24:11 bofh pluto[850]: ERROR: "private-or-clear#0.0.0.0/0"[4] ...193.110.157.22 #96: pfkey write() of SADB_ADD message 694 for Add SA esp.150999c8 at 193.110.157.22 failed. Errno 17: File exists
Feb 10 12:24:11 bofh pluto[850]: |   02 03 00 03  12 00 00 00  b6 02 00 00  52 03 00 00
Feb 10 12:24:11 bofh pluto[850]: |   03 00 01 00  15 09 99 c8  40 01 02 03  00 00 00 00
Feb 10 12:24:11 bofh pluto[850]: |   ff ff ff ff  00 00 00 00  03 00 05 00  00 00 00 00
Feb 10 12:24:11 bofh pluto[850]: |   02 00 00 00  c1 6e 9d 11  00 00 00 00  00 00 00 00
Feb 10 12:24:11 bofh pluto[850]: |   03 00 06 00  00 00 00 00  02 00 00 00  c1 6e 9d 16
Feb 10 12:24:11 bofh pluto[850]: |   00 00 00 00  00 00 00 00  03 00 08 00  80 00 00 00
Feb 10 12:24:11 bofh pluto[850]: |   ad 81 26 e5  0a bc f1 62  4b 06 54 e9  1c 95 07 93
Feb 10 12:24:11 bofh pluto[850]: |   04 00 09 00  c0 00 00 00  cf c8 51 7f  f1 35 9c ec
Feb 10 12:24:11 bofh pluto[850]: |   e6 9b d0 86  6b 99 fb 4c  c1 a3 39 e3  82 a4 e3 38
Feb 10 12:24:11 bofh pluto[850]: | pfkey_lib_debug:pfkey_msg_parse: satype 0 conversion to proto failed for msg_type 4 (delete).
Feb 10 12:24:11 bofh pluto[850]: | pfkey_lib_debug:pfkey_msg_build: Trouble parsing newly built pfkey message, error=-22.
Feb 10 12:24:11 bofh pluto[850]: "private-or-clear#0.0.0.0/0"[4] ...193.110.157.22 #96: pfkey_msg_build of Delete SA unk0.1055 at 193.110.157.22 failed, code -22
Feb 10 12:24:20 bofh pluto[850]: ERROR: "private-or-clear#0.0.0.0/0"[4] ...193.110.157.22 #96: pfkey write() of SADB_ADD message 697 for Add SA esp.150999c8 at 193.110.157.22 failed. Errno 17: File exists
Feb 10 12:24:20 bofh pluto[850]: |   02 03 00 03  12 00 00 00  b9 02 00 00  52 03 00 00
Feb 10 12:24:20 bofh pluto[850]: |   03 00 01 00  15 09 99 c8  40 01 02 03  00 00 00 00
Feb 10 12:24:20 bofh pluto[850]: |   ff ff ff ff  00 00 00 00  03 00 05 00  00 00 00 00
Feb 10 12:24:20 bofh pluto[850]: |   02 00 00 00  c1 6e 9d 11  00 00 00 00  00 00 00 00
Feb 10 12:24:20 bofh pluto[850]: |   03 00 06 00  00 00 00 00  02 00 00 00  c1 6e 9d 16
Feb 10 12:24:20 bofh pluto[850]: |   00 00 00 00  00 00 00 00  03 00 08 00  80 00 00 00
Feb 10 12:24:20 bofh pluto[850]: |   ad 81 26 e5  0a bc f1 62  4b 06 54 e9  1c 95 07 93
Feb 10 12:24:20 bofh pluto[850]: |   04 00 09 00  c0 00 00 00  cf c8 51 7f  f1 35 9c ec
Feb 10 12:24:20 bofh pluto[850]: |   e6 9b d0 86  6b 99 fb 4c  c1 a3 39 e3  82 a4 e3 38
Feb 10 12:24:20 bofh pluto[850]: | pfkey_lib_debug:pfkey_msg_parse: satype 0 conversion to proto failed for msg_type 4 (delete).
Feb 10 12:24:20 bofh pluto[850]: | pfkey_lib_debug:pfkey_msg_build: Trouble parsing newly built pfkey message, error=-22.
Feb 10 12:24:20 bofh pluto[850]: "private-or-clear#0.0.0.0/0"[4] ...193.110.157.22 #96: pfkey_msg_build of Delete SA unk0.1056 at 193.110.157.22 failed, code -22
Feb 10 12:24:20 bofh pluto[850]: "packetdefault"[2] 0.0.0.0/0=== ...193.110.157.22===? #94: ignoring Delete SA payload: PROTO_IPSEC_ESP SA(0xbc1d8216) not found (maybe expired)

Paul