[JDEV] Interesting AIM-Transport problem.

Wed Dec 13 13:58:08 CST 2000

I've run into a bit of a brick wall trying to get aim-transport 0.8.0
configured with jabber 1.2 on RH6.2.  Any insight anybody could offer
here would be appreciated.

I compiled jabberd and aim-transport to the letter of the instructions
here: http://home.nyc.ny.us/twiki/bin/view/Jabber/AimJabberInstallDoc

No errors were encountered on compilation, and jabberd itself starts
up without any problems.

In my jabber.xml file, the aim transport is defined as follows:

	<service id="aim.batcave.mspt.com">
	<accept>
	<ip/>
	<port>7009</port>
	<secret>test</secret>
	</accept>
	</service>

	<agent jid="aim.batcave.mspt.com">
	<name>AIM Transport</name>
	<description>This is the AIM Transport</description>
	<transport>AIM/AOL ScreenName</transport>
	<service>aim</service>
	<register/>
	</agent>

adnshost successfully resolves "aim.batcave.mspt.com":

	# adnshost aim.batcave.mspt.com
	aim.batcave.mspt.com A INET 10.0.0.30

aimtrans was invoked as follows:

	/aimtrans -n aim.batcave.mspt.com -e aim.batcave.mspt.com -D -s test

...but it dies with this trace:

Wed Dec 13 14:37:02 2000  debug/log.c:79 log_init
Wed Dec 13 14:37:02 2000  debug/main.c:59 Loading Transport
Wed Dec 13 14:37:02 2000  debug/ehandler.c:44 ehandler_new(aim.batcave.mspt.com,jabber:component:accept)
Wed Dec 13 14:37:02 2000  debug/ehlist.c:26 list_add(aim.batcave.mspt.com)
Wed Dec 13 14:37:02 2000  debug/etherxs.c:124 attempting socket connect to 127.0.0.1 for transport aim.batcave.mspt.com
Wed Dec 13 14:37:02 2000  debug/xmlstream.c:26 xmlstream_connect
Wed Dec 13 14:37:02 2000  debug/tstream.c:63 tstream_new
Wed Dec 13 14:37:02 2000  debug/xmlstream.c:101 head: <?xml version='1.0'?><stream:stream xmlns:stream='http://etherx.jabber.org/streams' id='3A37CFDE' xmlns='jabber:component:accept' to='127.0.0.1' from='aim.batcave.mspt.com' xmlns:etherx='http://etherx.jabber.org/' etherx:secret='c6f71f787ccb5f13d66eaffdd6fbfe91d1c6ccde'>
Wed Dec 13 14:37:02 2000  debug/tstream.c:133 tstream_write_buffer
Wed Dec 13 14:37:02 2000  debug/ehandler.c:72 spun off connection attempt
Wed Dec 13 14:37:02 2000  debug/external.c:23 [AIM] Loaded transport with aim.batcave.mspt.com as host alias 
Wed Dec 13 14:37:02 2000  debug/main.c:75 Main loop waiting
Wed Dec 13 14:37:02 2000  debug/unknown.c:11 THREAD:UNKNOWN starting
Wed Dec 13 14:37:02 2000  debug/tstream.c:212 tstream_main: startup
Wed Dec 13 14:37:02 2000  debug/xmlstream.c:222 xmlstream_main: startup
Wed Dec 13 14:37:02 2000  debug/tstream.c:335 tstream_connect: ADNS[127.0.0.1:5269]
Wed Dec 13 14:37:02 2000  debug/tstream.c:492 tstream_socket 5269 127.0.0.1
Wed Dec 13 14:37:02 2000  debug/tstream.c:263 tstream write event 0
Wed Dec 13 14:37:02 2000  debug/tstream.c:285 tstream_write 271 blocks
Wed Dec 13 14:37:02 2000  debug/tstream.c:285 tstream_write 0 blocks
Wed Dec 13 14:37:02 2000  debug/tstream.c:247 tstream read event
Wed Dec 13 14:37:02 2000  debug/xmlstream.c:222 xmlstream_main: startup
Wed Dec 13 14:37:02 2000  debug/etherxs.c:61 got root tag from etherx!
Wed Dec 13 14:37:02 2000  debug/tstream.c:188 tstream_oob_flush
Wed Dec 13 14:37:02 2000  debug/etherxs.c:91 got node from etherx!
Wed Dec 13 14:37:02 2000  error/etherxs connection to etherxd was rejected: Invalid Stream Header!
Terminated

Concurrently, I see in jabberd's output:

Wed Dec 13 14:54:05 2000  dialback.c:668 incoming conn 8101720 IO[2]
Wed Dec 13 14:54:05 2000  dialback.c:559 incoming conn 8101720 XML[0]: <stream:stream xmlns:stream='http://etherx.jabber.org/streams' id='3A37D3DD' xmlns='jabber:component:accept' to='aim.batcave.mspt.com' from='aim.batcave.mspt.com' xmlns:etherx='http://etherx.jabber.org/' etherx:secret='2b066da4a90bb8dd1fafba22d5147100c27139ec'/>
Wed Dec 13 14:54:05 2000  io_select.c:105 WRITE 13 len 214 of <?xml version='1.0'?><stream:stream xmlns:stream='http://etherx.jabber.org/streams' id='ce71738170f0b26b9d64c1dc19a29ce913106be3' xmlns='jabber:server' from='aim.batcave.mspt.com' xmlns:db='jabber:server:dialback'> 
Wed Dec 13 14:54:05 2000  io_select.c:105 WRITE 13 len 51 of <stream:error>Invalid Stream Header!</stream:error> 
Wed Dec 13 14:54:05 2000  dialback.c:668 incoming conn 8101720 IO[3]
Wed Dec 13 14:54:05 2000  io_select.c:199 freed socket

At this point, not knowing much about what etherx is expecting to
receive, I'm pretty much at a loss.  Any help (including pointers to
relevant docs to read) would be appreciated.

-n

------------------------------------------------------------<memory at blank.org>
"What a depressing, predictable arc.  YAY LOOK AT US FLYING UP INTO THE SKY!!!
HONK!!! THE TOILET.  HELP!!!!  HURKGLGHLGPTHGLHGLBHLGPTH  **FLUSH**  NEXT."
                                                      (--www.leisuretown.com)
http://www.blank.org/memory/>------------------------------------------------