Startup Time 1.79

For test results, bug reports, announcements of new builds etc.

Moderators: winston, another_commander, Getafix

User avatar
Eric Walch
Slightly Grand Rear Admiral
Slightly Grand Rear Admiral
Posts: 5536
Joined: Sat Jun 16, 2007 3:48 pm
Location: Netherlands

Startup Time 1.79

Post by Eric Walch »

To avoid spamming the Random Hits topic I continue from here
cim wrote:
Thargoid wrote:
At the moment it's set up with 113 OXZs plus a couple of dozen OXPs. The full list is below, from my latest.log. It's more the massively increased start-up time, when it gets running I think the FPS is roughly the same (from just observation, but I haven't played much with the OXZs installed).
What's the difference in start-up time between a cached and uncached start? If the slowness is what I think it is, startup from the cache should be pretty fast.
I also have over the 100 oxp's and have a startup time of > 1 minute. With Oolite 1.77.1 is was about 10 seconds with the same oxp set and both with building the cache. I have the option "always-flush-cache" on in my preferences. I just accepted the additional 10 seconds startup time, to prevent tens of minutes of search for unexpected behaviour when accidentally forgetting to press shift during start.

With this long times of over a minute, I switched the setting off. And indeed, with a build cache, the startup is only a few seconds < 10 sec). Other that Thargoid, I only have a few files in the new oxz format.
How does the new format effect png files. The textures are never cached for a long time and regularly have to be reloaded and unzipped from disk.

On two of my iMacs, this works, but on my MacBook, the option to "always-flush-cache" seems to stay active somehow. The first few times, after switching it off in the preferences, it was on again in the preferences after quitting Oolite. Now the boolean stays off in the preferences, but in the log, I keep seeing:

Code: Select all

00:31:32.572 [dataCache.rebuild.explicitFlush]: Cache explicitly flushed with always-flush-cache preference. Rebuilding from scratch.
Okay, I am sure it will stay off, when completely deleting te "always-flush-cache" in the preferences. Maybe it is not correctly recognising the boolean. I'll look in the code if I can find a reason there.
User avatar
Eric Walch
Slightly Grand Rear Admiral
Slightly Grand Rear Admiral
Posts: 5536
Joined: Sat Jun 16, 2007 3:48 pm
Location: Netherlands

Re: Startup Time 1.79

Post by Eric Walch »

Eric Walch wrote:
Okay, I am sure it will stay off, when completely deleting the "always-flush-cache" in the preferences.
I could get rid of the setting by restarting the system. Apparently the settings are also cached somewhere in memory and reads it from there on startup, rather than from the preference file. Strange.
User avatar
Thargoid
Thargoid
Thargoid
Posts: 5528
Joined: Thu Jun 12, 2008 6:55 pm

Re: Startup Time 1.79

Post by Thargoid »

cim wrote:
What's the difference in start-up time between a cached and uncached start? If the slowness is what I think it is, startup from the cache should be pretty fast.
Hmm, I thought I had always clear cache set, but seemingly I don't for trunk (at least the .GNUstepDefaults file looks quite vanilla). So from a quick test it looks like a start without a cache clear doesn't make a significant difference to how long it takes (absolutely ages between the splash screen and the cobbie3 - enough for windows to think it's stopped responding if I click on the splash screen).

From looking at latest log - from first entry to a bunch of errors which seem to appear when the game is on spinning cobbie3 it takes almost exactly 10 minutes (without any cache clearing) :shock:

The full log up to spinning cobbie3 (without leaving that initial screen) is below.

Code: Select all

Opening log for Oolite development version 1.79.0.5735-140510-c8843ed (x86-32 test release) under Windows 6.1.7601 Service Pack 1 64-bit at 2014-05-17 18:23:59 +0100.
2 processors detected.
Build options: OpenAL, new planets, JavaScript console support, OXP verifier, localization tools, debug GraphViz support, JavaScript profiling.

Note that the contents of the log file can be adjusted by editing logcontrol.plist.

18:24:04.781 [paths.debug]: (Resources, "C:\\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns", ../AddOns)
18:24:04.781 [paths.debug]: (Resources, "C:\\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns", ../AddOns)
18:24:22.245 [oxp.message]: ../AddOns/Workbench.oxp/Ring Demo.oxp: Planetary Ring Demo by Thargoid. Just a proof of concept, not for standard gameplay usage.
18:24:31.295 [display.mode.list.native]: Windows native resolution detected: 1024 x 600
18:24:37.555 [joystick.init]: Number of joysticks detected: 1
18:24:37.957 [rendering.opengl.version]: OpenGL renderer version: 4.2.12002 ("4.2.12002 Compatibility Profile Context 9.12.0.0"). Vendor: "ATI Technologies Inc.". Renderer: "AMD Radeon HD 6250 Graphics".
18:24:37.958 [rendering.opengl.extensions]: OpenGL extensions (216):
GL_ARB_draw_instanced, GL_NV_float_buffer, GL_ARB_occlusion_query, GL_EXT_texture_env_add, GL_ARB_texture_storage, GL_ARB_texture_env_dot3, GL_ARB_sync, GL_AMD_vertex_shader_viewport_index, GL_ARB_texture_multisample, GL_ARB_point_parameters, GL_ARB_vertex_array_object, GL_ARB_blend_func_extended, GL_AMD_shader_trace, GL_NV_explicit_multisample, GL_EXT_provoking_vertex, GL_EXT_blend_equation_separate, GL_ARB_compressed_texture_pixel_storage, GL_EXT_texture_snorm, GL_ARB_texture_non_power_of_two, GL_ARB_texture_mirrored_repeat, GL_EXT_multi_draw_arrays, GL_ARB_timer_query, GL_ARB_texture_buffer_object, GL_ARB_texture_buffer_range, GL_SGIS_texture_edge_clamp, GL_EXT_abgr, GL_ARB_vertex_program, GL_ATI_texture_float, GL_ARB_draw_buffers_blend, GL_AMD_sample_positions, GL_ARB_viewport_array, GL_KTX_buffer_region, GL_ARB_shadow, GL_EXT_texture_cube_map, GL_ARB_shader_atomic_counters, GL_NV_primitive_restart, GL_EXT_framebuffer_object, GL_EXT_texture_sRGB, GL_ARB_conservative_depth, GL_ARB_get_program_binary, GL_ARB_multitexture, GL_NV_half_float, GL_NV_copy_image, GL_AMD_seamless_cubemap_per_texture, GL_SUN_multi_draw_arrays, GL_EXT_texture_compression_rgtc, GL_AMD_pinned_memory, GL_ARB_shader_objects, GL_EXT_blend_func_separate, GL_EXT_bgra, GL_ARB_pixel_buffer_object, GL_ARB_vertex_attrib_64bit, GL_ARB_draw_buffers, GL_NV_texgen_reflection, GL_ARB_texture_env_crossbar, GL_ARB_fragment_shader, GL_EXT_texture_swizzle, GL_EXT_fog_coord, GL_EXT_vertex_array_bgra, GL_EXT_framebuffer_blit, GL_NV_copy_depth_to_color, GL_ARB_texture_compression_rgtc, GL_EXT_transform_feedback, GL_ARB_sample_shading, GL_ARB_seamless_cube_map, GL_WIN_swap_hint, GL_EXT_texture_shared_exponent, GL_ARB_shading_language_420pack, GL_AMD_depth_clamp_separate, GL_ARB_shader_subroutine, GL_EXT_copy_buffer, GL_AMD_shader_stencil_export, GL_AMD_name_gen_delete, GL_EXT_geometry_shader4, GL_EXT_direct_state_access, GL_EXT_compiled_vertex_array, GL_ARB_shader_image_load_store, GL_EXT_texture_storage, GL_EXT_shader_image_load_store, GL_EXT_separate_specular_color, GL_ARB_vertex_type_2_10_10_10_rev, GL_EXT_vertex_array, GL_ARB_shading_language_100, GL_EXT_rescale_normal, GL_ARB_texture_float, GL_EXT_packed_depth_stencil, GL_EXT_bindable_uniform, GL_ARB_half_float_pixel, GL_EXT_texture_compression_s3tc, GL_EXT_draw_instanced, GL_ARB_occlusion_query2, GL_AMD_draw_buffers_blend, GL_ARB_texture_rgb10_a2ui, GL_SGIS_texture_lod, WGL_EXT_swap_control, GL_ARB_geometry_shader4, GL_AMD_transform_feedback3_lines_triangles, GL_ARB_framebuffer_object, GL_AMD_debug_output, GL_NV_conditional_render, GL_ARB_texture_rg, GL_AMD_conservative_depth, GL_ARB_color_buffer_float, GL_EXT_blend_color, GL_EXT_texture_rectangle, GL_ARB_vertex_array_bgra, GL_EXT_texture_integer, GL_EXT_texture_array, GL_ARB_base_instance, GL_EXT_texture_compression_bptc, GL_EXT_histogram, GL_ARB_shading_language_packing, GL_ARB_fragment_program_shadow, GL_EXT_texture_buffer_object, GL_ARB_texture_snorm, GL_ARB_map_buffer_range, GL_ARB_fragment_program, GL_ARB_copy_buffer, GL_ARB_shadow_ambient, GL_ARB_tessellation_shader, GL_EXT_texture_lod_bias, GL_EXT_texture_filter_anisotropic, GL_EXT_draw_buffers2, GL_EXT_secondary_color, GL_ARB_transform_feedback2, GL_ARB_transform_feedback3, GL_EXT_framebuffer_multisample, GL_ARB_window_pos, GL_EXT_texture_env_combine, GL_ARB_vertex_shader, GL_ARB_texture_compression_bptc, GL_SGIS_generate_mipmap, GL_ATI_texture_mirror_once, GL_EXT_packed_float, GL_ARB_texture_border_clamp, GL_ARB_explicit_attrib_location, GL_NV_blend_square, GL_ARB_internalformat_query, GL_EXT_texture3D, GL_ARB_ES2_compatibility, GL_ARB_texture_query_lod, GL_AMD_texture_cube_map_array, GL_AMDX_vertex_shader_tessellator, GL_EXT_texture_mirror_clamp, GL_EXT_texture_sRGB_decode, GL_ARB_texture_compression, GL_ARB_texture_env_add, GL_ARB_imaging, GL_ARB_provoking_vertex, GL_EXT_gpu_shader4, GL_ARB_texture_rectangle, GL_EXT_texture_edge_clamp, GL_ARB_draw_elements_base_vertex, GL_ARB_fragment_coord_conventions, GL_ARB_shader_stencil_export, GL_ATI_envmap_bumpmap, GL_ARB_separate_shader_objects, GL_ARB_texture_cube_map, GL_EXT_framebuffer_sRGB, GL_EXT_texture_compression_latc, GL_EXT_texgen_reflection, GL_ATI_fragment_shader, GL_ARB_point_sprite, GL_ARB_texture_gather, GL_ARB_texture_buffer_object_rgb32, GL_ARB_depth_texture, GL_EXT_texture_object, GL_ARB_instanced_arrays, GL_EXT_blend_minmax, GL_AMD_vertex_shader_layer, GL_ATI_draw_buffers, GL_ARB_framebuffer_sRGB, GL_EXT_blend_subtract, GL_EXT_packed_pixels, GL_IBM_texture_mirrored_repeat, GL_AMD_texture_texture4, GL_EXT_draw_range_elements, GL_ARB_texture_cube_map_array, GL_ARB_sampler_objects, GL_ARB_half_float_vertex, GL_AMDX_debug_output, GL_ARB_shader_precision, GL_ARB_gpu_shader5, GL_ARB_depth_clamp, GL_AMD_vertex_shader_tessellator, GL_ARB_texture_storage_multisample, GL_ARB_transpose_matrix, GL_ARB_vertex_buffer_object, GL_ARB_draw_indirect, GL_AMD_multi_draw_indirect, GL_EXT_pixel_buffer_object, GL_EXT_vertex_attrib_64bit, GL_ARB_transform_feedback_instanced, GL_ATI_texture_env_combine3, GL_ARB_texture_env_combine, GL_ATI_texture_compression_3dc, GL_ARB_shader_bit_encoding, GL_EXT_timer_query, GL_EXT_gpu_program_parameters, GL_ARB_shader_texture_lod, GL_ARB_uniform_buffer_object, GL_ARB_multisample, GL_EXT_texture_env_dot3, GL_AMD_query_buffer_object, GL_EXT_shadow_funcs, GL_EXT_texture_lod, GL_ARB_depth_buffer_float, GL_ARB_map_buffer_alignment, GL_EXT_copy_texture, GL_ARB_gpu_shader_fp64, GL_EXT_stencil_wrap, GL_EXT_point_parameters, GL_ATI_separate_stencil, GL_EXT_subtexture, GL_AMD_performance_monitor, GL_NV_texture_barrier
18:24:40.322 [rendering.opengl.shader.support]: Shaders are supported.
18:24:42.992 [searchPaths.dumpAll]: Unrestricted mode - resource paths:
    Resources
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns
    ../AddOns
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.ArexackHeretic.att1.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.ArexackHeretic.CargoWreck.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.ArexackHeretic.ThargornThreat.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.CaptMurphy.ShipStorageHelper.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.cim.camera-drones.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.cim.combat-simulator.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.cim.comms-pack-a.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.cim.cotbs.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.cim.energy-bomb.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.cim.escort-formations.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.cim.extracts-tre-clan.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.cim.new-cargoes.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.cim.ships-library.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.cim.shipset-compatibility.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.cim.systemfeatures.rings.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.cim.systemfeatures.sunspots.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.ClymAngus.Kirin.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.ClymAngus.KirinSport.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.ClymAngus.NeoCaduceus.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.CmdrWombat.ThargoidWars.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.CommonSenseOTB.CustomShields.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.DrNil.Commies.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.DrNil.YAH-SetA.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.DrNil.YAH-SetB.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.DrNil.YAH-SetC.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.DrNil.YAH-SetD.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.DrNil.YAH-SetE.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.DrNil.YAH-SetF.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.DrNil.YAH-SetG.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.DrNil.YAH.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.EricWalch.MissileAnalyser.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.EricWalch.TionislaReporter.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.EricWalch.UPSCourier.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.LittleBear.AsteroidStorm.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Lone_Wolf.ETTHomingBeacon.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Murgh.HoOpyCasino.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Murgh.MilitaryFiasco.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Murgh.NuVipers.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Norby.Gallery.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Norby.ShipVersion.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Pagroove.FamousPlanets.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Pagroove.Superhub.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Pleb.TaxiGalactica.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Ramirez.BlOombergMarkets.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Ramirez.Dictators.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Ramirez.ExecutiveSpaceWays.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Ramirez.FeudalStates.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Ramirez.FuelTank.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Ramirez.IronRaven.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Ramirez.MissilesandBombs.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Ramirez.ResistanceCommander.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Ramirez.SalezaAeronautics.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.RobertTodd.Taranis.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.smivs.aliens.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.spara.behemoth.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.spara.navigation_mfd.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.spara.ore_processor.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.spara.random_hits.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.spara.start_choices.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Svengali.BGS.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Svengali.CCL.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Svengali.Eric.BuoyRepair.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Svengali.Hyperradio.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Svengali.HyperradioHH01.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Svengali.OXPConfig.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Svengali.Pagroove.BGSSoundset.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Svengali.Snoopers.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Svengali.Vector.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Thargoid.APRIL.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Thargoid.Aquatics.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Thargoid.Armoury.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Thargoid.Bigships.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Thargoid.CargoShepherd.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Thargoid.CargoSpotter.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Thargoid.CommandersLog.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Thargoid.EnergyEquipment.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Thargoid.FlightLog.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Thargoid.FuelStation.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Thargoid.Gates.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Thargoid.HiredGuns.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Thargoid.HyperCargo.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Thargoid.IronHide.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Thargoid.LaserBooster.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Thargoid.LaveAcademy.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Thargoid.MilFuelInj.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Thargoid.NavalGrid.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Thargoid.Neo-Docklights.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Thargoid.OoCheat.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Thargoid.PlanetaryCompass.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Thargoid.PlanetaryCompassPackA.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Thargoid.PlanetaryCompassPackB.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Thargoid.PlanetaryCompassPackC.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Thargoid.PlanetaryCompassPackD.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Thargoid.Planetfall-OoHaul.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Thargoid.Planetfall.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Thargoid.Pods.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Thargoid.RealisticDamage.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Thargoid.RepairBots.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Thargoid.RetroRockets.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Thargoid.RingRacer.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Thargoid.SecondWave.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Thargoid.Stealth.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Thargoid.StellarSerpents.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Thargoid.Swarm.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Thargoid.TAP.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Thargoid.TCAT.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Thargoid.Tracker.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Thargoid.TrackerCam.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Thargoid.TrafficControl.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Thargoid.Vortex.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Thargoid.WelcomeMat.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/oolite.oxp.Thargoid.Wildships.oxz
    C:\Oolite/Trunk/oolite.app/GNUstep/Library/ApplicationSupport/Oolite/ManagedAddOns/uk.org.rockthehalo.oolite.oxp.Tricky.Jaguar_Company.oxz
    ../AddOns/Basic-debug.oxp
    ../AddOns/External.oxp
    ../AddOns/External.oxp/BountyScannerv2.0.oxp
    ../AddOns/External.oxp/BountyStatus 1.00.oxp
    ../AddOns/External.oxp/Coluber_0_6_0_2011-12-17.oxp
    ../AddOns/External.oxp/Constitution Class Heavy Cruiser.oxp
    ../AddOns/External.oxp/default_Jameson_ship_is_griff_cobra3.oxp
    ../AddOns/External.oxp/EnhancedMisjump_1.1.oxp
    ../AddOns/External.oxp/ExternalLazer.oxp
    ../AddOns/External.oxp/Freighttrain1.00.oxp
    ../AddOns/External.oxp/Fruitbat1.01.oxp
    ../AddOns/External.oxp/Generation Ships.oxp
    ../AddOns/External.oxp/griff_cobraIII_subent_missiles.oxp
    ../AddOns/External.oxp/griff_ico_normalmapped_fullsize_tex_v1.0.oxp
    ../AddOns/External.oxp/griff_missile_normalmapped.oxp
    ../AddOns/External.oxp/Griff_Shipset_Addition_v1.0.oxp
    ../AddOns/External.oxp/Griff_Shipset_Resources_v1.2.22.oxp
    ../AddOns/External.oxp/LongRangeScanner v0.1.oxp
    ../AddOns/External.oxp/MilitaryTargettingSystemv1.oxp
    ../AddOns/External.oxp/railgun.oxp
    ../AddOns/External.oxp/randomshipnames1.3.oxp
    ../AddOns/External.oxp/SIRF20.oxp
    ../AddOns/External.oxp/System_Redux.oxp
    ../AddOns/External.oxp/TalkativeCompass_1.0.4.oxp
    ../AddOns/External.oxp/TCA 1.01.oxp
    ../AddOns/External.oxp/Tianve1.3.oxp
    ../AddOns/External.oxp/Transports 2.52.oxp
    ../AddOns/External.oxp/Universal Turret Switcher.oxp
    ../AddOns/Stable.oxp
    ../AddOns/Stable.oxp/Butterflies_Kaks.oxp
    ../AddOns/Stable.oxp/liners_v1.5.oxp
    ../AddOns/Toolbox.oxp
    ../AddOns/Toolbox.oxp/BETA-MissionTextTools 0.1.oxp
    ../AddOns/Workbench.oxp
    ../AddOns/Workbench.oxp/Goliath.oxp
    ../AddOns/Workbench.oxp/planetFall-Backdrops.oxp
    ../AddOns/Workbench.oxp/Ring Demo.oxp
    ../AddOns/Workbench.oxp/Temple.oxp
    ../AddOns/Workbench.oxp/Tester.oxp
    ../AddOns/Workbench.oxp/thirdWave.oxp
    ../AddOns/Workbench.oxp/toughMissiles.oxp
18:24:48.989 [shipData.load.begin]: Loading ship data.
18:26:54.673 [script.load.world.listAll]: Loaded 196 world scripts:
    aliens_world_script 1.0
    ams_system 2.02
    april_worldScript.js 1.03
    aquatics_equipment 1.1
    aquatics_FX.js 1.00
    aquatics_populator 2.28
    armoury_machineScript.js 1.00
    armoury_trackerWorldScript.js 1.00
    AsteroidStorm 4.03
    behemoth 3.0
    BGS-M 1.9
    BGS-PAGsoundsetv2 2.3
    BGS-XMapping 1.9
    bigShips_populator 1.0.2
    Bounty Scanner 2.0 2.00
    Bounty Status Display 1.00
    buoyRepair 1.3.2
    Cabal_Common_Briefing 1.7
    Cabal_Common_Comms 1.7
    Cabal_Common_Functions 1.7
    Cabal_Common_Keyboard 1.7
    Cabal_Common_MissionHandling 1.7
    Cabal_Common_Music 1.7
    Cabal_Common_Overlay 1.7
    Cabal_Common_OXPStrength 1.7
    Cabal_Common_SpecialMarkets 1.7
    Caduceus Damage Control Node 2.0
    Camera Drones 1.3
    Cargo_Wreck_Teaser 1.7.1
    cargoSpotter_worldScript.js 1.01
    CargoTypeExtension 1.2.3
    CargoTypeExtension-Auctions 1.1.1
    CargoTypeExtension-Base 1.2.3
    CargoTypeExtension-DefaultMarket 1.2.3
    CargoTypeExtension-Dynamic 1.2.3
    CargoTypeExtension-FetchContracts 1.2.3
    CargoTypeExtension-OpenContract 1.2.3
    CargoTypeExtension-Permits 1.2.3
    CargoTypeExtension-Regional 1.2.3
    CargoTypeExtension-Scavenger 1.2.3
    CargoTypeExtension-Station-Astrofactory 1.2.3
    CargoTypeExtension-Station-ConStore 1.2.3
    CargoTypeExtension-Station-Galnavy 1.2.3
    CargoTypeExtension-Station-GRS 1.2.3
    CargoTypeExtension-Station-HoopyCasino 1.2.3
    CargoTypeExtension-Station-KiotaBiosphere 1.2.3
    CargoTypeExtension-Station-KiotaFactory 1.2.3
    CargoTypeExtension-Station-KiotaHabitat 1.2.3
    CargoTypeExtension-Station-KiotaRelay 1.2.3
    CargoTypeExtension-Station-KiotaResearch 1.2.3
    CargoTypeExtension-Station-KiotaSolar 1.2.3
    CargoTypeExtension-Station-PlanetFall 1.2.3
    CargoTypeExtension-Station-RockHermit 1.2.3
    CargoTypeExtension-Station-RRSWaystation 1.2.3
    CargoTypeExtension-Station-SalvageGang 1.2.3
    CargoTypeExtension-Station-SpaceBar 1.2.3
    CargoTypeExtension-Station-SuperHub 1.2.3
    CargoTypeExtension-Station-ZGF 1.2.3
    CargoTypeExtension-TraderNet 1.2.3
    Combat Simulator 1.1
    commandersLog 1.00
    Comms Pack A 0.2
    communist_population 2.12
    COTBS 1.0.2
    CT_Script 2.0
    customshields 0.83
    dictators.js 1.0
    ECM_jammerScript 1.00
    Emergency Energy Unit 2.1
    Enhanced Misjumps 1.1
    Escort Formations Randomiser 1.1
    executivespaceways.js 1.0
    exhibitions 1.14
    feudal-challenge.js 9.0
    feudal-mission.js 9.0
    feudal-planetfall.js 3.0
    feudal-promotion.js 6.0
    feudal-ranks.js 5.0
    feudal-tournament.js 10.0
    FlightLog 1.07
    Freighttrain 1.0
    FuelStation-Setup 2.02
    gallery 1.14
    gates_masterScript 1.13
    Generation Ships 1.3
    Goliath Populator 1.0
    GWcontrolpanel 1.0
    GWmain 0.4
    GWpromotions 0.1
    GWunitstatus 1.0
    hiredGuns_system 1.0
    hoopy_casino 1.2.1
    HyperCargo 1.10
    hyperradio 1.26.1
    hyperRadioHH01 1.01
    IR-defences.js 1.0
    IR-finance.js 1.0
    IR-main-script.js 7.0
    IR-SDF.js 1.0
    IR-shipment.js 1.0
    IronHide Armour Script 2.00
    Jaguar Company 2.5
    Jaguar Company Ships 1.4
    laserBooster_worldScript.js 1.02
    LaveAcademy 1.33
    Library book: EFTTCAOIL 1.2
    liners_populator_script.js 1.5
    LongRangeScanner 0.1
    mil_injectors.js 1.03
    military_fiasco 2.5.3
    militarytargettingsystem 1.0
    missile_analyser 1.2
    Missiles & Bombs 1.0
    missionTextTools 0.10
    navi_mfd 0.2
    neoDockLights_worldScript.js 0.10
    ooCheat 1.11
    oolite-cloaking-device 1.79
    oolite-constrictor-hunt 1.79
    oolite-contracts-cargo 1.79
    oolite-contracts-helpers 1.79
    oolite-contracts-parcels 1.79
    oolite-contracts-passengers 1.79
    oolite-libPriorityAI 1.79
    oolite-nova 1.79
    oolite-populator 1.79
    oolite-primable-equipment-register 1.79
    oolite-registership 1.79
    oolite-thargoid-plans 1.79
    oolite-tianve 1.41
    oolite-trumbles 1.79
    oolite-tutorial 1.79
    oreProcessor 2.1
    OXPConfig 2.3.1
    PAGroove_superhubPopulator 1.1
    Pi-Forty-Two Con stores 4.1.7
    planetaryCompass_namePack-A 1.00
    planetaryCompass_namePack-B 1.00
    planetaryCompass_namePack-C 1.00
    planetaryCompass_namePack-D 1.00
    planetaryCompass_worldScript.js 1.01
    PlanetFall 1.51
    planetFall-Backdrops.js 1.0
    PlanetFall_Oohaul 1.10
    railgun 1.3
    Random_Hits 1.8
    randomshipnames 1.3
    realisticDamage.js 1.00
    Repair system 2.10
    Ring Station Test 1.04
    RingRacer 1.20
    saleza.js 1.0
    SE-main-script 2.5
    Ship_Storage_Helper.js 0.21
    Ships Library 0.8
    shipversion 1.21
    SIRF_populator.js 1.00
    snoopers 2.5
    start_choices 1.7
    stealth_missionScript 1.05
    stellarSerpents_masterScript.js 1.21
    System Features: Rings 1.2
    System Features: Sunspots 1.5
    System Redux 1.2 1.2
    Talkative Space Compass 1.0.4
    taranis_one 1.3
    targetAutolock 1.11
    taxi_galactica_main 1.0
    TCAT_masterScript 1.0
    TCAT_missionScript 1.0
    tester_WS.js 1.00
    thargoid_wars 4.6
    Thargorn_Witchspace_Battle 1.5.2
    Tionisla Chronicle Array OXP 1.0.1
    Tionisla Reporter 1.2.0
    tracker_worldScript.js 1.00
    TrafficControl 1.1
    transportSchedule 2.52
    uni_turret_switcher.js 0.01
    ups_container 1.8.4
    ups_docs 1.8.4
    ups_parcel 1.8.4
    ups_slaves 1.8.3
    ups_sun 1.8.4
    vector 1.7.1
    vector_areidis 1.7.1
    vector_cubes 1.7.1
    vector_insp 1.7.1
    vector_missionArn 1.7.1
    vector_news 1.7.1
    vector_pad 1.7.1
    vector_updater 1.7.1
    vortex_maelstrom.js 1.27
    vortex_player.js 1.30
    Welcome Information Script 1.13
    wildShips_populator.js 1.02
18:27:48.459 [debugTCP.disconnect]: No connection to debug console: "Connection to debug console failed: 'No connection could be made because the target machine actively refused it.

' (outStream status: 7, inStream status: 7)."
18:27:48.459 [debugTCP.send.warning]: Error sending packet header, retrying.
18:27:48.509 [debugTCP.send.error]: The following packet could not be sent: {"Oolite version" = 1.79; "packet type" = "Request Connection"; "protocol version" = 65792; }
18:27:51.205 [debugTCP.disconnect]: No connection to debug console: "Connection to debug console failed: 'bad stream.' (outStream status: 0, inStream status: 0)."
18:27:51.205 [debugTCP.connect.failed]: Failed to connect to debug console at address 127.0.0.1:8563.
18:28:48.052 [script.load.notFound]: ***** ERROR: Could not find script file oolite-missile.js.
18:29:07.966 [script.load.notFound]: ***** ERROR: Could not find script file oolite-missile.js.
18:33:43.592 [script.javaScript.timeLimit]: ***** ERROR: Script "Cabal_Common_OXPStrength" ran for 5.19157 seconds and has been terminated.
18:33:43.593 [script.javaScript.stackTrace]:  0 (Cabal_Common_OXPStrength.js:26) <anonymous function>
18:33:43.593 [script.javaScript.stackTrace]:     this: [Script "Cabal_Common_OXPStrength" version 1.7]
18:33:43.594 [script.javaScript.stackTrace]:     temp: "function () {\n    \"use strict\";\n    if (!player.ship.docked ||\n        this.hasShown || !player.ship.dockedStation.isMainStation) {\n        return;\n    }\n    if (!missionVariables.vector_arn) {\n      ..."
18:33:43.595 [script.javaScript.stackTrace]:     prop: "missionOffers"
18:33:43.595 [script.javaScript.stackTrace]:     w: "vector_missionArn"
18:33:48.598 [startup.complete]: ========== Loading complete in 563.42 seconds. ==========
18:34:09.457 [script.javaScript.timeLimit]: ***** ERROR: Script "Null AI" ran for 3.28605 seconds and has been terminated.
18:34:09.457 [script.javaScript.stackTrace]:  0 (oolite-nullAI.js:1) <not a function frame>
18:34:09.458 [script.javaScript.stackTrace]:     this: [Script "Null AI" version (nil)]
18:34:09.458 [script.javaScript.stackTrace]:     name: "Null AI"
18:34:09.458 [script.javaScript.stackTrace]:     ship: [Ship "Duma" position: (0, 0, 0) scanClass: CLASS_POLICE status: STATUS_IN_FLIGHT] [read-only]
18:34:09.459 [script.javaScript.stackTrace]:     version: "1.79"
18:34:09.459 [script.javaScript.stackTrace]:     author: "Giles Williams, Jens Ayton and contributors"
18:34:09.459 [script.javaScript.stackTrace]:     license: "GPL 2+ / CC-BY-NC-SA 3.0 - see LICENSE.TXT for details"
18:34:09.460 [script.javaScript.load.failed]: ***** Error loading JavaScript script Resources/AIs/oolite-nullAI.js -- could not run script
18:34:09.460 [ai.load.failed.unknownAI]: Unable to load JS AI oolite-nullAI.js for ship <ShipEntity 0x17092130>{"Duma" position: (0, 0, 0) scanClass: CLASS_POLICE status: STATUS_IN_FLIGHT} (wildShips_tribalDuma for role trader)
18:34:14.723 [script.javaScript.timeLimit]: ***** ERROR: Script "Oolite Police AI" ran for 8.55196 seconds and has been terminated.
18:34:14.723 [script.javaScript.stackTrace]:  0 (oolite-policeAI.js:208) <not a function frame>
18:34:14.724 [script.javaScript.stackTrace]:     this: [Script "Oolite Police AI" version (nil)]
18:34:14.725 [script.javaScript.stackTrace]:     aiStarted: function
18:34:14.725 [script.javaScript.stackTrace]:     name: "Oolite Police AI"
18:34:14.730 [script.javaScript.stackTrace]:     ship: [Ship "Duma" position: (0, 0, 0) scanClass: CLASS_POLICE status: STATUS_IN_FLIGHT] [read-only]
18:34:14.731 [script.javaScript.stackTrace]:     version: "1.79"
18:34:14.732 [script.javaScript.stackTrace]:     author: "Giles Williams, Jens Ayton and contributors"
18:34:14.732 [script.javaScript.stackTrace]:     license: "GPL 2+ / CC-BY-NC-SA 3.0 - see LICENSE.TXT for details"
18:34:14.733 [script.javaScript.load.failed]: ***** Error loading JavaScript script Resources/AIs/oolite-policeAI.js -- could not run script
18:34:14.733 [ai.load.failed.unknownAI]: Unable to load JS AI oolite-policeAI.js for ship <ShipEntity 0x17092130>{"Duma" position: (0, 0, 0) scanClass: CLASS_POLICE status: STATUS_IN_FLIGHT} (wildShips_tribalDuma for role police)
18:34:17.345 [script.javaScript.timeLimit]: ***** ERROR: Script "Oolite Police AI" ran for 11.1732 seconds and has been terminated.
18:34:17.346 [script.javaScript.stackTrace]:  0 (oolite-policeAI.js:208) <not a function frame>
18:34:17.346 [script.javaScript.stackTrace]:     this: [Script "Oolite Police AI" version (nil)]
18:34:17.346 [script.javaScript.stackTrace]:     aiStarted: function
18:34:17.347 [script.javaScript.stackTrace]:     name: "Oolite Police AI"
18:34:17.347 [script.javaScript.stackTrace]:     ship: [Ship "Duma" position: (0, 0, 0) scanClass: CLASS_POLICE status: STATUS_IN_FLIGHT] [read-only]
18:34:17.348 [script.javaScript.stackTrace]:     version: "1.79"
18:34:17.348 [script.javaScript.stackTrace]:     author: "Giles Williams, Jens Ayton and contributors"
18:34:17.348 [script.javaScript.stackTrace]:     license: "GPL 2+ / CC-BY-NC-SA 3.0 - see LICENSE.TXT for details"
18:34:17.349 [script.javaScript.load.failed]: ***** Error loading JavaScript script Resources/AIs/oolite-policeAI.js -- could not run script
18:34:17.349 [ai.load.failed.unknownAI]: Unable to load JS AI oolite-policeAI.js for ship <ShipEntity 0x17092130>{"Duma" position: (0, 0, 0) scanClass: CLASS_POLICE status: STATUS_IN_FLIGHT} (wildShips_tribalDuma for role police-station-patrol)
18:34:19.476 [script.javaScript.timeLimit]: ***** ERROR: Script "(nil)" ran for 0.13158 seconds and has been terminated.
18:34:19.477 [script.javaScript.stackTrace]:  0 (ingame-manual.js:720) <anonymous function>
18:34:19.478 [script.javaScript.stackTrace]:     this: [Script "Ships Library" version 0.8]
18:34:19.478 [script.javaScript.stackTrace]:     linewidth: 32
18:34:19.478 [script.javaScript.stackTrace]:     lines: 15
18:34:19.479 [script.javaScript.stackTrace]:     offset: 1068
18:34:19.479 [script.javaScript.stackTrace]:     chapternum: 17
18:34:19.479 [script.javaScript.stackTrace]:     wordwidth: 0
18:34:19.479 [script.javaScript.stackTrace]:     word: ""
18:34:19.479 [script.javaScript.stackTrace]:     j: 0
18:34:19.480 [script.javaScript.stackTrace]:     wl: 34
18:34:19.480 [script.javaScript.stackTrace]:     widthuse: 0
18:34:19.480 [script.javaScript.stackTrace]:     words: ["The", "right", "block", "of", ... <34 items total>]
18:34:19.481 [script.javaScript.stackTrace]:     i: 2
18:34:19.481 [script.javaScript.stackTrace]:     pl: 7
18:34:19.481 [script.javaScript.stackTrace]:     lineuse: 2
18:34:19.481 [script.javaScript.stackTrace]:     accum: "above the nearest major body. Below these gauges are your missile mounts.\n\n"
18:34:19.483 [script.javaScript.stackTrace]:     paras: ["above the nearest major body. Below these gauges are your missile mounts.", "", "The right block of gauges, from top to bottom, shows: flight speed as a proportion of maximum flight speed, current roll and pitch rates, and the charge levels of your 4 primary capacitor banks.", "", ... <7 items total>]
18:34:19.483 [script.javaScript.stackTrace]:     text: "above the nearest major body. Below these gauges are your missile mounts.\n\nThe right block of gauges, from top to bottom, shows: flight speed as a proportion of maximum flight speed, current roll and ..."
18:34:19.484 [script.javaScript.stackTrace]:     fulltext: "The main screen in all in-flight views contains a head-up display (HUD) to give you instant access to important status information. This section of the manual assumes you are using the classic B&B Gen..."
18:34:19.485 [script.javaScript.stackTrace]:     pagebreak: ""
18:34:19.485 [script.javaScript.stackTrace]:  1 (ingame-manual.js:799) <anonymous function>
18:34:19.485 [script.javaScript.stackTrace]:     this: [Script "Ships Library" version 0.8]
18:34:19.486 [script.javaScript.stackTrace]:     chapternum: 17
18:34:19.486 [script.javaScript.stackTrace]:     block: undefined
18:34:19.486 [script.javaScript.stackTrace]:     offset: 1068
18:34:19.487 [script.javaScript.stackTrace]:     fulltext: "The main screen in all in-flight views contains a head-up display (HUD) to give you instant access to important status information. This section of the manual assumes you are using the classic B&B Gen..."
18:34:19.488 [script.javaScript.stackTrace]:     chapter: {...}
18:34:19.488 [script.javaScript.stackTrace]:  2 (ingame-manual.js:777) <anonymous function>
18:34:19.489 [script.javaScript.stackTrace]:     this: [Script "Ships Library" version 0.8]
18:34:19.489 [script.javaScript.stackTrace]:     i: 17
[/color]
User avatar
Eric Walch
Slightly Grand Rear Admiral
Slightly Grand Rear Admiral
Posts: 5536
Joined: Sat Jun 16, 2007 3:48 pm
Location: Netherlands

Re: Startup Time 1.79

Post by Eric Walch »

Thargoid: could t be a memory problem? I notice that my browser becomes very slow when Oolite is open in the background. Starting up is slow and even typing has a delay. I had noticed before and I now experience it again. Looking at the used memory, it is 3.98 GB on an iMac with 4 GB build in. So it heavy starts swapping memory by using virtual memory.

On closing most of my programs, including Oolite, memory used dropped down to 1.5 GB. Than starting Oolite and launching, rocketed my used memory to 3.96 GB again. That explains why Oolite is slow and regularly freezes. It uses way to much memory.

With only my mail program, browser, memory viewer and Oolite (development version) open, all my 4GB is used up.
User avatar
Cody
Sharp Shooter Spam Assassin
Sharp Shooter Spam Assassin
Posts: 16081
Joined: Sat Jul 04, 2009 9:31 pm
Location: The Lizard's Claw
Contact:

Re: Startup Time 1.79

Post by Cody »

Eric Walch wrote:
On closing most of my programs, including Oolite, memory used dropped down to 1.5 GB. Than starting Oolite and launching, rocketed my used memory to 3.96 GB again. That explains why Oolite is slow and regularly freezes. It uses way to much memory.
For reference, Oolite 1.79 uses about 1GB of memory on my machine (if I read my numbers right, that is).
I would advise stilts for the quagmires, and camels for the snowy hills
And any survivors, their debts I will certainly pay. There's always a way!
User avatar
Eric Walch
Slightly Grand Rear Admiral
Slightly Grand Rear Admiral
Posts: 5536
Joined: Sat Jun 16, 2007 3:48 pm
Location: Netherlands

Re: Startup Time 1.79

Post by Eric Walch »

For reference:

Memory without oolite:

Image

and with oolite running

Image

The arrow points to the amount of memory in use. No memory left of my 4 GB and the iMac (with OSX 10.6) is becoming slow with everything. That also explains why things run much smoother on my laptop with 8 GB memory.

Now a test on my other iMac, also 4GB memory but running OSX 10.9 (Mavericks). There is about 3.0 MB in use without Oolite and Oolite uses 950 MB after launch from the same saved game and with the same OXP set installed.
Last edited by Eric Walch on Sat May 17, 2014 9:03 pm, edited 1 time in total.
User avatar
Thargoid
Thargoid
Thargoid
Posts: 5528
Joined: Thu Jun 12, 2008 6:55 pm

Re: Startup Time 1.79

Post by Thargoid »

Eric, I think your hypothesis is on the money.

My machine is also 4GB, and before starting Oolite (with basically nothing running up-front, just the usual background stuff) it's at about 50% memory usage. With debug console running and Oolite starting up, that usage creeps up to about 63%.

I say starting up, as I added a few more OXZs earlier, and it's now been starting up for half an hour and hasn't even connected to the console yet. So sadly I think it's the OXZ overhead that is killing things for me, it's probably going to make using 1.80 with OXZs impossible. What I'll try next (sometime next week if I get time) is to take the same load-out but will back-convert the same OXZs to OXPs and see if removing that overhead restores things again (I'm fairly certain it will, based on how the game ran before I packaged things up and made the switch).

But it doesn't bode well for the future, at least on similar low-spec processor kit to mine.
User avatar
cim
Quite Grand Sub-Admiral
Quite Grand Sub-Admiral
Posts: 4072
Joined: Fri Nov 11, 2011 6:19 pm

Re: Startup Time 1.79

Post by cim »

If it's that, then it should be easy enough to test here, since I only have 2GB and Oolite normally uses about 1.5GB of that. I'll download a bunch more OXZs and see what happens.
User avatar
Thargoid
Thargoid
Thargoid
Posts: 5528
Joined: Thu Jun 12, 2008 6:55 pm

Re: Startup Time 1.79

Post by Thargoid »

Hmm, maybe it is a bit more complex than that after all :? .

Finally got to the Cobbie3, and memory usage peaked at ~75%, then dropped back to about 63% whilst messing about with the OXZ manager (adding a few more for the moment, to try and test Planetary Compass with the OXZ additional planets as per Spara's post).

So memory-wise it's not too bad, but it took 45 minutes to start up, which is unusable. And certainly things do seem to slow down somewhat with Oolite running, but that could just be simple load-out.

@Cim - if needs be you've got my previous OXZ load-out in the latest.log above (about 110 or thereabouts) plus a few remaining OXPs if you want to replicate that.
User avatar
cim
Quite Grand Sub-Admiral
Quite Grand Sub-Admiral
Posts: 4072
Joined: Fri Nov 11, 2011 6:19 pm

Re: Startup Time 1.79

Post by cim »

I'm pretty sure it's not memory, at least. I've been downloading and got up to 80ish OXPs installed (130ish worldscripts), as OXZs where available, and a cold start takes ~35-40 seconds, from cache it takes 4-5 seconds.
2GB memory, which it definitely fits within
3.2GHz processor temporarily maxed out, but you'd expect that for startup.

I wonder if the problem may be the path resolver. If you ask Oolite for the file "Models/cobra3.dat" then it essentially searches every pack for a file with that name, until it finds one. That's O(n) on your number of OXPs to begin with, but with OXZs that's really inefficient, since it'll keep re-opening the same OXZ every time it wants to find out it doesn't have the file it's interested in.

Opening each OXZ once, and grabbing the filelist for their folders into the path resolver's cache first might solve the problem. It's slightly odd in that case that a cached start isn't fast, though - that should have the path resolver data anyway. There are some bits which don't use the path cache anyway, though - maybe that's a problem too? I shall have a closer look at this and see what can be improved over the next few days.
User avatar
Thargoid
Thargoid
Thargoid
Posts: 5528
Joined: Thu Jun 12, 2008 6:55 pm

Re: Startup Time 1.79

Post by Thargoid »

OK thanks - it makes sense too.

I'm travelling this week, but am ready to assist with testing as needed.

Do you want me to try decompressing the OXZs back to OXPs to see what effect that has (with an edited local manifest.plist in the library cache I presume?), or isn't that worth the effort?
User avatar
cim
Quite Grand Sub-Admiral
Quite Grand Sub-Admiral
Posts: 4072
Joined: Fri Nov 11, 2011 6:19 pm

Re: Startup Time 1.79

Post by cim »

Thargoid wrote:
Do you want me to try decompressing the OXZs back to OXPs to see what effect that has (with an edited local manifest.plist in the library cache I presume?), or isn't that worth the effort?
You could do - no need to edit manifest.plist files if you do - but it's probably only worth it if this idea doesn't fix the problem. I should have something working for that in time for tonight's build.
User avatar
cim
Quite Grand Sub-Admiral
Quite Grand Sub-Admiral
Posts: 4072
Joined: Fri Nov 11, 2011 6:19 pm

Re: Startup Time 1.79

Post by cim »

Okay - Oolite now preloads all the file locations before doing anything else with a new OXP set, and that gets an uncached start down from 35-40 seconds to 8 seconds here. It should also speed things up marginally in-game, since there are a lot of file types that weren't making it into the file location cache at all before.
User avatar
Thargoid
Thargoid
Thargoid
Posts: 5528
Joined: Thu Jun 12, 2008 6:55 pm

Re: Startup Time 1.79

Post by Thargoid »

It's brought my start-up time down from 45 minutes to about 10 or so. The debug console connects almost immediately (within about 30s), but after that it still has a sit down and think about it before getting to the Cobbie3.

I'll pull some of the OXZs out again to improve that a bit, but there's not too much more there now than I used to run under OXP format, so it's still a little disappointing.
another_commander
Quite Grand Sub-Admiral
Quite Grand Sub-Admiral
Posts: 6682
Joined: Wed Feb 28, 2007 7:54 am

Re: Startup Time 1.79

Post by another_commander »

Thargoid, what happens if you start up Oolite in Safe Mode? Just trying to ensure that it's not third-party program related.
Post Reply