Il-2 Dedicated Server mission load problems

TheGrunch · #1 02-17-2014, 12:07 AM

Hi guys,
Would really appreciate some help on an issue I am having getting missions to load with the Il-2 DS.

Free Saitek Aviator (PS3 version, postage paid) to the person who finds the solution to this issue, no matter how stupid or trivial it turns out to be.

I am writing a server controller in Clojure and Java using the JavaFX toolkit as the UI (original thread here).

The problem is that missions entered manually by the user into a text field seem to load fine all the time, however:

Missions selected by a file chooser dialog fail every time, but only the first time. Then they work every time, until you select a different mission with the file chooser dialog, whereupon they fail again, but only the first time. YouTube video here.

I just cannot find the solution to this bug! It's driving me insane! I have compared the two LOAD commands using the same mission from the text field and from the file chooser with a huge variety of different methods.

I've tried searching for hidden characters (both Unicode and ASCII non-printable, hidden or whitespace), changing the new line separator from \r\n to \n and even to \n\r\n, explicitly flushing my Writer even though I use a writer with autoflush on newline characters, and a number of different path normalisation, canonisation and relativisation methods.

Java String comparison shows that the LOAD commands I am using are the same, Wireshark TCP data is the same, logs on the server side show that the characters received are the same:

Manual
File Chooser

Code:

[Feb 17, 2014 12:29:15 AM] ------------ BEGIN log session -------------
[12:29:18 AM]	1>server NAME IL-2 Dedicated Server Linux 4.12m PWD 
[12:29:18 AM]	1>difficulty SeparateEStart 1
[12:29:18 AM]	1>difficulty ComplexEManagement 1
[12:29:18 AM]	1>difficulty EngineOverheat 1
[12:29:18 AM]	1>difficulty TorqueGyroEffects 1
[12:29:18 AM]	1>difficulty FlutterEffect 1
[12:29:18 AM]	1>difficulty WindTurbulence 1
[12:29:18 AM]	1>difficulty StallsSpins 1
[12:29:18 AM]	1>difficulty Vulnerability 1
[12:29:18 AM]	1>difficulty BlackoutsRedouts 1
[12:29:18 AM]	1>difficulty RealisticGunnery 1
[12:29:18 AM]	1>difficulty LimitedFuel 1
[12:29:18 AM]	1>difficulty LimitedAmmo 1
[12:29:18 AM]	1>difficulty HeadShake 1
[12:29:18 AM]	1>difficulty CockpitAlwaysOn 1
[12:29:18 AM]	1>difficulty NoInstantSuccess 1
[12:29:18 AM]	1>difficulty Clouds 1
[12:29:18 AM]	1>difficulty RealisticLandings 1
[12:29:18 AM]	1>difficulty TakeoffLanding 1
[12:29:18 AM]	1>difficulty NoPadlock 1
[12:29:18 AM]	1>difficulty NoMapIcons 1
[12:29:18 AM]	1>difficulty NoMinimapPath 1
[12:29:18 AM]	1>difficulty NoSpeedBar 0
[12:29:18 AM]	1>difficulty NoOutsideViews 0
[12:29:18 AM]	1>difficulty NoIcons 0
[12:29:18 AM]	1>maxping 9999 DELAY 9999 WARNINGS 9999
[12:29:18 AM]	1>mp_dotrange FOE COLOR 100 DOT 100 RANGE 100 TYPE 100 ID 100 NAME 100
[12:29:18 AM]	1>mp_dotrange FRIENDLY COLOR 100 DOT 100 RANGE 100 TYPE 100 ID 100 NAME 100
[12:29:18 AM]	33>[12:30:39 AM]	server
[12:30:39 AM]	Type: Local server
[12:30:39 AM]	Name: IL-2 Dedicated Server Linux 4.12m
[12:30:39 AM]	Description: 
[12:30:39 AM]	34>[12:30:39 AM]	mission
[12:30:39 AM]	Mission NOT loaded
[12:30:39 AM]	35>[12:31:04 AM]	mission LOAD Net/dogfight/DCG/dcgmission.mis
[12:31:04 AM]	Loading mission Net/dogfight/DCG/dcgmission.mis...
[12:31:04 AM]	Load bridges
[12:31:04 AM]	Load static objects
[12:31:08 AM]	Mission: Net/dogfight/DCG/dcgmission.mis is Loaded
[12:31:08 AM]	36>[12:31:17 AM]	mission DESTROY
[12:31:18 AM]	37>[12:31:18 AM]	mission
[12:31:18 AM]	Mission NOT loaded
[12:31:18 AM]	38>[12:31:19 AM]	mission LOAD FBDj/dcgmission.mis
[12:31:19 AM]	SectFile load failed: null
[12:31:19 AM]	java.io.FileNotFoundException
[12:31:19 AM]		at com.maddox.rts.SFSInputStream.<init>(SFSInputStream.java:65)
[12:31:19 AM]		at com.maddox.rts.SFSReader.<init>(SFSReader.java:19)
[12:31:19 AM]		at com.maddox.rts.SectFile.loadFile(SectFile.java:227)
[12:31:19 AM]		at com.maddox.rts.SectFile.loadFile(SectFile.java:154)
[12:31:19 AM]		at com.maddox.rts.SectFile.<init>(SectFile.java:126)
[12:31:19 AM]		at com.maddox.rts.SectFile.<init>(SectFile.java:86)
[12:31:19 AM]		at com.maddox.il2.game.Mission.load(Mission.java:333)
[12:31:19 AM]		at com.maddox.il2.game.Mission.load(Mission.java:321)
[12:31:19 AM]		at com.maddox.il2.game.Mission.load(Mission.java:318)
[12:31:19 AM]		at com.maddox.il2.game.cmd.CmdMission.exec(CmdMission.java:65)
[12:31:19 AM]		at com.maddox.rts.CmdEnv.exec(CmdEnv.java:601)
[12:31:19 AM]		at com.maddox.il2.game.DServer.loopApp(DServer.java:172)
[12:31:19 AM]		at com.maddox.il2.game.Main.exec(Main.java:439)
[12:31:19 AM]		at com.maddox.il2.game.DServer.main(DServer.java:436)
[12:31:19 AM]	Loading mission FBDj/dcgmission.mis...
[12:31:19 AM]	No MAP in mission file 
[12:31:19 AM]	java.lang.Exception: No MAP in mission file 
[12:31:19 AM]		at com.maddox.il2.game.Mission.loadMain(Mission.java:765)
[12:31:19 AM]		at com.maddox.il2.game.Mission._load(Mission.java:476)
[12:31:19 AM]		at com.maddox.il2.game.Mission.load(Mission.java:426)
[12:31:19 AM]		at com.maddox.il2.game.Mission.load(Mission.java:334)
[12:31:19 AM]		at com.maddox.il2.game.Mission.load(Mission.java:321)
[12:31:19 AM]		at com.maddox.il2.game.Mission.load(Mission.java:318)
[12:31:19 AM]		at com.maddox.il2.game.cmd.CmdMission.exec(CmdMission.java:65)
[12:31:19 AM]		at com.maddox.rts.CmdEnv.exec(CmdEnv.java:601)
[12:31:19 AM]		at com.maddox.il2.game.DServer.loopApp(DServer.java:172)
[12:31:19 AM]		at com.maddox.il2.game.Main.exec(Main.java:439)
[12:31:19 AM]		at com.maddox.il2.game.DServer.main(DServer.java:436)
[12:31:19 AM]	No MAP in mission file 
[12:31:19 AM]	java.lang.Exception: No MAP in mission file 
[12:31:19 AM]		at com.maddox.il2.game.Mission.loadMain(Mission.java:765)
[12:31:19 AM]		at com.maddox.il2.game.Mission._load(Mission.java:476)
[12:31:19 AM]		at com.maddox.il2.game.Mission.load(Mission.java:426)
[12:31:19 AM]		at com.maddox.il2.game.Mission.load(Mission.java:334)
[12:31:19 AM]		at com.maddox.il2.game.Mission.load(Mission.java:321)
[12:31:19 AM]		at com.maddox.il2.game.Mission.load(Mission.java:318)
[12:31:19 AM]		at com.maddox.il2.game.cmd.CmdMission.exec(CmdMission.java:65)
[12:31:19 AM]		at com.maddox.rts.CmdEnv.exec(CmdEnv.java:601)
[12:31:19 AM]		at com.maddox.il2.game.DServer.loopApp(DServer.java:172)
[12:31:19 AM]		at com.maddox.il2.game.Main.exec(Main.java:439)
[12:31:19 AM]		at com.maddox.il2.game.DServer.main(DServer.java:436)
[12:31:19 AM]	ERROR mission: FBDj/dcgmission.mis  NOT loaded [java.lang.Exception: No MAP in mission file ]
[12:31:19 AM]	39>[12:31:29 AM]	mission LOAD FBDj/dcgmission.mis
[12:31:29 AM]	Loading mission FBDj/dcgmission.mis...
[12:31:29 AM]	Load bridges
[12:31:29 AM]	Load static objects
[12:31:32 AM]	Mission: FBDj/dcgmission.mis is Loaded
[12:31:32 AM]	40>[12:31:57 AM]	mission DESTROY
[12:31:57 AM]	41>[12:31:57 AM]	mission
[12:31:57 AM]	Mission NOT loaded
[12:31:57 AM]	42>[12:31:58 AM]	mission LOAD Net/dogfight/DCG/dcgmission.mis
[12:31:58 AM]	SectFile load failed: null
[12:31:58 AM]	java.io.FileNotFoundException
[12:31:58 AM]		at com.maddox.rts.SFSInputStream.<init>(SFSInputStream.java:65)
[12:31:58 AM]		at com.maddox.rts.SFSReader.<init>(SFSReader.java:19)
[12:31:58 AM]		at com.maddox.rts.SectFile.loadFile(SectFile.java:227)
[12:31:58 AM]		at com.maddox.rts.SectFile.loadFile(SectFile.java:154)
[12:31:58 AM]		at com.maddox.rts.SectFile.<init>(SectFile.java:126)
[12:31:58 AM]		at com.maddox.rts.SectFile.<init>(SectFile.java:86)
[12:31:58 AM]		at com.maddox.il2.game.Mission.load(Mission.java:333)
[12:31:58 AM]		at com.maddox.il2.game.Mission.load(Mission.java:321)
[12:31:58 AM]		at com.maddox.il2.game.Mission.load(Mission.java:318)
[12:31:58 AM]		at com.maddox.il2.game.cmd.CmdMission.exec(CmdMission.java:65)
[12:31:58 AM]		at com.maddox.rts.CmdEnv.exec(CmdEnv.java:601)
[12:31:58 AM]		at com.maddox.il2.game.DServer.loopApp(DServer.java:172)
[12:31:58 AM]		at com.maddox.il2.game.Main.exec(Main.java:439)
[12:31:58 AM]		at com.maddox.il2.game.DServer.main(DServer.java:436)
[12:31:58 AM]	Loading mission Net/dogfight/DCG/dcgmission.mis...
[12:31:58 AM]	No MAP in mission file 
[12:31:58 AM]	java.lang.Exception: No MAP in mission file 
[12:31:58 AM]		at com.maddox.il2.game.Mission.loadMain(Mission.java:765)
[12:31:58 AM]		at com.maddox.il2.game.Mission._load(Mission.java:476)
[12:31:58 AM]		at com.maddox.il2.game.Mission.load(Mission.java:426)
[12:31:58 AM]		at com.maddox.il2.game.Mission.load(Mission.java:334)
[12:31:58 AM]		at com.maddox.il2.game.Mission.load(Mission.java:321)
[12:31:58 AM]		at com.maddox.il2.game.Mission.load(Mission.java:318)
[12:31:58 AM]		at com.maddox.il2.game.cmd.CmdMission.exec(CmdMission.java:65)
[12:31:58 AM]		at com.maddox.rts.CmdEnv.exec(CmdEnv.java:601)
[12:31:58 AM]		at com.maddox.il2.game.DServer.loopApp(DServer.java:172)
[12:31:58 AM]		at com.maddox.il2.game.Main.exec(Main.java:439)
[12:31:58 AM]		at com.maddox.il2.game.DServer.main(DServer.java:436)
[12:31:58 AM]	No MAP in mission file 
[12:31:58 AM]	java.lang.Exception: No MAP in mission file 
[12:31:58 AM]		at com.maddox.il2.game.Mission.loadMain(Mission.java:765)
[12:31:58 AM]		at com.maddox.il2.game.Mission._load(Mission.java:476)
[12:31:58 AM]		at com.maddox.il2.game.Mission.load(Mission.java:426)
[12:31:58 AM]		at com.maddox.il2.game.Mission.load(Mission.java:334)
[12:31:58 AM]		at com.maddox.il2.game.Mission.load(Mission.java:321)
[12:31:58 AM]		at com.maddox.il2.game.Mission.load(Mission.java:318)
[12:31:58 AM]		at com.maddox.il2.game.cmd.CmdMission.exec(CmdMission.java:65)
[12:31:58 AM]		at com.maddox.rts.CmdEnv.exec(CmdEnv.java:601)
[12:31:58 AM]		at com.maddox.il2.game.DServer.loopApp(DServer.java:172)
[12:31:58 AM]		at com.maddox.il2.game.Main.exec(Main.java:439)
[12:31:58 AM]		at com.maddox.il2.game.DServer.main(DServer.java:436)
[12:31:58 AM]	ERROR mission: Net/dogfight/DCG/dcgmission.mis  NOT loaded [java.lang.Exception: No MAP in mission file ]
[12:31:58 AM]	43>[12:32:02 AM]	mission LOAD Net/dogfight/DCG/dcgmission.mis
[12:32:03 AM]	Loading mission Net/dogfight/DCG/dcgmission.mis...
[12:32:03 AM]	Load bridges
[12:32:03 AM]	Load static objects
[12:32:05 AM]	Mission: Net/dogfight/DCG/dcgmission.mis is Loaded
[12:32:05 AM]	44>[12:33:29 AM]	mission DESTROY
[12:33:30 AM]	45>[12:33:30 AM]	mission
[12:33:30 AM]	Mission NOT loaded
[12:33:30 AM]	46>[12:33:31 AM]	mission LOAD FBDj/dcgmission.mis
[12:33:31 AM]	Loading mission FBDj/dcgmission.mis...
[12:33:31 AM]	Load bridges
[12:33:31 AM]	Load static objects
[12:33:33 AM]	Mission: FBDj/dcgmission.mis is Loaded
[12:33:33 AM]	47>[12:33:41 AM]	mission DESTROY
[12:33:42 AM]	48>[12:33:42 AM]	mission
[12:33:42 AM]	Mission NOT loaded
[12:33:42 AM]	49>[12:33:42 AM]	mission LOAD Net/dogfight/DCG/dcgmission.mis
[12:33:43 AM]	Loading mission Net/dogfight/DCG/dcgmission.mis...
[12:33:43 AM]	Load bridges
[12:33:43 AM]	Load static objects
[12:33:45 AM]	Mission: Net/dogfight/DCG/dcgmission.mis is Loaded
[12:33:45 AM]	50>

As you can see, the commands that were sent in the blue highlighted section were to all appearances the same. However, the response of the server was completely different.

What can possibly cause sending the same command to the IL-2 DS and getting different results? Could this be a character encoding issue?

How is it possible to send the same LOAD command to the server and it will fail the first time, every time, then succeed the second and all subsequent times until another mission is chosen?

Would really appreciate any help or advice with this problem as I'd love to continue with this development.