2024-04-19 07:39 CEST
  

View Issue Details [ Jump to Notes ] [ Issue History ] [ Print ]
IDProjectCategoryView StatusDate SubmittedLast Update
0004171Spring engineGeneralpublic2013-11-27 01:272013-12-04 21:02
ReporterBeherith 
Assigned ToKloot 
PrioritynormalSeveritymajorReproducibilityalways
StatusresolvedResolutionfixed 
Product Version95.0 
Target Version96.0Fixed in Version 
Summary0004171: CTO assert and jittering
DescriptionSpring stutters (unit movement) when playing online, and the stutters coincide with CTO >1 assertion errors. It happens very frequently, often more than once per second.

Silentwings and I have been doing some very extensive testing on how the frame jitter occurs in online games.

The error occurs iff someone is spectating or playing a live game (not catching up to online game, not watching from replay) and he is not the host, he is just a client. Here are our findings:

Spring 95.0 has heavy random jitter, the frame times are printed in the infolog.
Units seem to stop for a frame then jump forward a bit. Fast fourier tranformation of the delta times between two simframes show a minor peak at 6.66hz, but nothing very apparent.

Spring 94.1 has a periodic jitter, where it seems that every 30th frame (but not nessessarily those that where simframe%30==0) is shorter than the others, and it looks like units 'jump' forward a small amount each frame. Especially visible on planes, nano particles, and other smoothly moving units and projectiles. Fast fourier transformation of the delta times between two sim frames (as measured by the attached widget) show a marked peak at 1hz.

Spring 91 is just like spring 94.1, with periodic (about 1hz) jumps forward.

We do not think that this is a new issue, only its nature has changed in 95.0, and I do not think it is the same as GoogleFrog's issue with 15 missed frames and a DT of 500, I'm sure those can happen from time to time, but this is happening every second, making a game that is running at 100+ fps seem very laggy and slow indeed.
Steps To ReproduceJoin a game as a client (online), and watch as units stutter very frequently, and watch as cto assert errors pile up in debug view. Compare it to running spring locally, or just hosting a game.

Maybe even try the dbg_frame_jitter.lua script to see the delta times line up with cto assert errors.
Additional InformationMy ping is pretty OK, 0000179:0000200 ms as measured by spring, on a fat pipe.

Im not running out of GPU ram, it is not some GL call being very slow, I tested extensively with gDEBugger.

I have plenty of ram, not much besides a browser running in the background. Freshly restarted system.

The stutters are directly associated with CTO assertion fails. Each time there is a stutter, I get a CTO assertion fail (I have logflush off).

/luaui disable, /luarules disable and disabling advmapshading and advmodelshading have no effect on the visual stuttering, as does disabling deferred rendering.

Sim CPU use was below 25% during all tests. It happens from game start, not just heavy endgame.

We tested on 3 computers, my i5-750 +gtx560ti + win7 x64, one i3-3217U + win8.1 x64 laptop, and Silentwings's pc, which I believe is similar to my PC (nvidia). It was reproducible on all 3 pcs. I disabled intel speedstep and turbo boost on mine to make sure it was not the cause.

Using high precision timers has no effect on my pc.

Frame time recordings are obviously flawed because of collection from widget:GameFrame(), but all our tests were carried out at at least 100 FPS

To isolate network lag, I tested this between two PCs on a LAN, and the results are identical.
TagsNo tags attached.
Checked infolog.txt for Errors
Attached Files
  • ? file icon dbg_frame_jitter.lua (715 bytes) 2013-11-27 01:27
  • txt file icon infolog.2.txt (622,412 bytes) 2013-11-27 01:28
  • txt file icon infolog.3.txt (521,579 bytes) 2013-11-27 01:29
  • txt file icon infolog.4.txt (582,784 bytes) 2013-11-27 01:29
  • txt file icon infolog_95.0.1-99_client.txt (712,725 bytes) 2013-11-27 11:50
  • txt file icon infolog_95.0.1-99_host.txt (406,567 bytes) 2013-11-27 11:51
  • 7z file icon infolog_95_112_host.7z (181,372 bytes) 2013-11-27 21:58
  • txt file icon infolog_95_112_client.txt (735,182 bytes) 2013-11-27 21:59
  • txt file icon infolog_95_115_host.txt (3,081,236 bytes) 2013-11-28 01:56
  • txt file icon infolog_95_115_client.txt (344,493 bytes) 2013-11-28 01:56
  • txt file icon infolog_wierd_run1_client.txt (304,662 bytes) 2013-11-28 19:31
  • txt file icon infolog_wierd_run1_host.txt (42,467 bytes) 2013-11-28 19:36 - 
    [ParseCmdLine] command-line args: "S:\spring-87.0\spring.exe S:\spring-87.0\script.txt"
Using configuration source: "S:\spring-87.0\springsettings.cfg"
Using additional configuration source: "C:\Users\Peti\AppData\Local\springsettings.cfg"
Available log sections: KeyBindings, AutohostInterface, Net, CSMFGroundTextures, RoamMeshDrawer, BumpWater, DynWater, SkyBox, DecalsDrawerGL4, FarTextureHandler, Model, Piece, ModelDrawer, OBJParser, WorldObjectModelRenderer, Shader, Texture, Font, GroundMoveType, Path, UnitScript, CregSerializer, ArchiveScanner, VFS, Sound, LuaSocket
Enabled log sections: Sound(LOG_LEVEL_INFO)
Enable or disable log sections using the LogSections configuration key
  or the SPRING_LOG_SECTIONS environment variable (both comma separated).
  Use "none" to disable the default log sections.
LogOutput initialized.
Spring 95.0
Build date/time: Nov  5 2013 05:02:50
Build environment: boost-105300, GNU libstdc++ version 20130531
Compiler: gcc-4.8.1
OS: Microsoft Windows
Microsoft Windows 7 Ultimate Edition, 64-bit (build 7600)
Intel(R) Core(TM) i5 CPU         750  @ 2.67GHz; 8190MB RAM, 16378MB pagefile
OS: emulated 32bit mode
[CMyMath::Init] CPU SSE mask: 127, flags:
	SSE 1.0:  1,  SSE 2.0:  1
	SSE 3.0:  1, SSSE 3.0:  1
	SSE 4.1:  1,  SSE 4.2:  1
	SSE 4.0A: 0,  SSE 5.0A: 0
	using streflop SSE FP-math mode, CPU supports SSE instructions
Supported Video modes: 2560x1440, 1920x1440, 1920x1200, 1920x1080, 1680x1050, 1600x1200, 1600x1024, 1600x900, 1366x768, 1360x768, 1280x1024, 1280x960, 1280x800, 1280x768, 1280x720, 1152x864, 1024x768, 800x600, 720x576, 720x480, 640x480
[SetSDLVideoMode] video mode set to 2560x1440/32bit (windowed)
[Watchdog] Installed (HangTimeout: 600sec)
[DataDirs] Portable Mode!
Using read-write data directory: S:\spring-87.0\
Using read-only data directory: C:\Users\Peti\Documents\My Games\Spring\
Using read-only data directory: C:\Users\Peti\Documents\Spring\
Using read-only data directory: C:\ProgramData\Spring\
Scanning: C:\Users\Peti\Documents\My Games\Spring\maps
Scanning: C:\Users\Peti\Documents\My Games\Spring\games
Scanning: C:\Users\Peti\Documents\My Games\Spring\packages
Warning: Failed to scan C:\Users\Peti\Documents\My Games\Spring\packages\320add17abb0b1a81e6c62f5f39533c3.sdp (missing modinfo.lua/mapinfo.lua)
Scanning: S:\spring-87.0\maps
Error: Error opening S:\spring-87.0\maps\GreenCometBasic.sd7: Archive not found
Unable to open archive: S:\spring-87.0\maps\GreenCometBasic.sd7
Error: Error opening S:\spring-87.0\maps\GreenFields_Island.sd7: Archive not found
Unable to open archive: S:\spring-87.0\maps\GreenFields_Island.sd7
Error: Error opening S:\spring-87.0\maps\GreenHaven Remake.sd7: Archive not found
Unable to open archive: S:\spring-87.0\maps\GreenHaven Remake.sd7
Error: Error opening S:\spring-87.0\maps\Hills_and_Valleys-v09.sd7: Archive not found
Unable to open archive: S:\spring-87.0\maps\Hills_and_Valleys-v09.sd7
Error: Error opening S:\spring-87.0\maps\Islands_In_War_1.0.SDZ
Unable to open archive: S:\spring-87.0\maps\Islands_In_War_1.0.SDZ
Error: Error opening S:\spring-87.0\maps\Karst.sd7: Archive not found
Unable to open archive: S:\spring-87.0\maps\Karst.sd7
Error: Error opening S:\spring-87.0\maps\Koth-v03.sd7: Archive not found
Unable to open archive: S:\spring-87.0\maps\Koth-v03.sd7
Error: Error opening S:\spring-87.0\maps\Marrow.sd7: Unknown error
Unable to open archive: S:\spring-87.0\maps\Marrow.sd7
Error: Error opening S:\spring-87.0\maps\MoonQ10x.sd7: Archive not found
Unable to open archive: S:\spring-87.0\maps\MoonQ10x.sd7
Error: Error opening S:\spring-87.0\maps\MoonQ20x.sd7: Archive not found
Unable to open archive: S:\spring-87.0\maps\MoonQ20x.sd7
Error: Error opening S:\spring-87.0\maps\NoMetal_SpeedMetal.sd7: Archive not found
Unable to open archive: S:\spring-87.0\maps\NoMetal_SpeedMetal.sd7
Error: Error opening S:\spring-87.0\maps\Plains_and_passes.sd7: Archive not found
Unable to open archive: S:\spring-87.0\maps\Plains_and_passes.sd7
Error: Error opening S:\spring-87.0\maps\Real_Mars.sd7: Archive not found
Unable to open archive: S:\spring-87.0\maps\Real_Mars.sd7
Error: Error opening S:\spring-87.0\maps\RedComet.sd7: Archive not found
Unable to open archive: S:\spring-87.0\maps\RedComet.sd7
Error: Error opening S:\spring-87.0\maps\Sands of War v2.sd7: Archive not found
Unable to open archive: S:\spring-87.0\maps\Sands of War v2.sd7
Error: Error opening S:\spring-87.0\maps\Shining_Islands.sd7: Archive not found
Unable to open archive: S:\spring-87.0\maps\Shining_Islands.sd7
Error: Error opening S:\spring-87.0\maps\Shore2Shore_Remake-v01.sd7: Archive not found
Unable to open archive: S:\spring-87.0\maps\Shore2Shore_Remake-v01.sd7
Error: Error opening S:\spring-87.0\maps\Supreme Battlefield.sd7: Archive not found
Unable to open archive: S:\spring-87.0\maps\Supreme Battlefield.sd7
Error: Error opening S:\spring-87.0\maps\Tactical_Divide_v2.sd7: Archive not found
Unable to open archive: S:\spring-87.0\maps\Tactical_Divide_v2.sd7
Error: Error opening S:\spring-87.0\maps\Terra.sd7: Archive not found
Unable to open archive: S:\spring-87.0\maps\Terra.sd7
Error: Error opening S:\spring-87.0\maps\TornIslands_V2.sd7: Archive not found
Unable to open archive: S:\spring-87.0\maps\TornIslands_V2.sd7
Error: Error opening S:\spring-87.0\maps\Tropical.sd7: Archive not found
Unable to open archive: S:\spring-87.0\maps\Tropical.sd7
Scanning: S:\spring-87.0\base
Scanning: S:\spring-87.0\games
Scanning: S:\spring-87.0\packages
Warning: Failed to scan S:\spring-87.0\packages\320add17abb0b1a81e6c62f5f39533c3.sdp (missing modinfo.lua/mapinfo.lua)
[Threading] Main thread CPU affinity not set
[f=0000000] SDL version:  1.2.10
[f=0000000] GL version:   4.3.0
[f=0000000] GL vendor:    NVIDIA Corporation
[f=0000000] GL renderer:  GeForce GTX 560 Ti/PCIe/SSE2
[f=0000000] GLSL version: 4.30 NVIDIA via Cg compiler
[f=0000000] GLEW version: 1.5.8
[f=0000000] Video RAM:    total 1023MB, available 778MB
[f=0000000] FBO::maxSamples: 32
[f=0000000] GL info:
	haveARB: 1, haveGLSL: 1, ATI hacks: 0
	FBO support: 1, NPOT-texture support: 1, 24bit Z-buffer support: 1
	maximum texture size: 16384, compress MIP-map textures: 0
	maximum SmoothPointSize: 63, maximum vec4 varying/attributes: 31/16
	maximum drawbuffers: 8, maximum recommended indices/vertices: 1048576/1048576
	number of UniformBufferBindings: 84 (64kB)
[f=0000000] VSync disabled
[f=0000000] [Sound] OpenAL info:
[f=0000000] [Sound]   Available Devices:
[f=0000000] [Sound]               DirectSound Software
[f=0000000] [Sound]   Device:     DirectSound Software
[f=0000000] [Sound]   Vendor:         OpenAL Community
[f=0000000] [Sound]   Version:        1.1 ALSOFT 1.11.753
[f=0000000] [Sound]   Renderer:       OpenAL Soft
[f=0000000] [Sound]   AL Extensions:  AL_EXTX_buffer_sub_data AL_EXT_EXPONENT_DISTANCE AL_EXT_FLOAT32 AL_EXT_IMA4 AL_EXT_LINEAR_DISTANCE AL_EXT_MCFORMATS AL_EXT_OFFSET AL_EXTX_sample_buffer_object AL_EXT_source_distance_model AL_LOKI_quadriphonic
[f=0000000] [Sound]   ALC Extensions: ALC_ENUMERATE_ALL_EXT ALC_ENUMERATION_EXT ALC_EXT_CAPTURE ALC_EXT_disconnect ALC_EXT_EFX ALC_EXTX_thread_local_context
[f=0000000] [Sound]   EFX Enabled: yes
[f=0000000] [Sound]   Max Sounds: 128
[f=0000000] Joysticks found: 0
[f=0000000] Warning: Joystick 0 not found
[f=0000000] [Initialize] CPU Clock: win32::QueryPerformanceCounter
[f=0000000] [Initialize] CPU Cores: 4
[f=0000000] [Startup] loading startscript from: S:\spring-87.0\script.txt
[f=0000000] Connecting to local server
[f=0000000] Binding UDP socket to IP (v4) 192.168.1.100 port 8452
[f=0000000] [UDPListener] successfully bound socket on port 8452
[f=0000000] PreGame::StartServer: 32 ms
[f=0000000] Using map: DeltaSiegeDry
[f=0000000] Using game: Balanced Annihilation V7.84
[f=0000000] Using game archive: 09d1b87af38a003cf01e4b8d19c35d9c.sdp
[f=0000000] recording demo: demos/20131128_131214_DeltaSiegeDry_95.sdf
[f=0000000] PreGame::GameDataReceived: 16 ms
[f=0000000] [PG::UpdateClientNet] user number 0 (team 0, allyteam 0)
[f=0000000] Allowing pushing enemy units
[f=0000000] [Threading] Main thread CPU affinity not set
[f=0000000] [LuaIntro] Searching for new Widgets
[f=0000000] [LuaIntro] Scanning: LuaIntro/Addons/
[f=0000000] [LuaIntro] Scanning: LuaIntro/Widgets/
[f=0000000] [LuaIntro] Scanning: LuaIntro/SystemAddons/
[f=0000000] [LuaIntro] Scanning: LuaIntro/SystemWidgets/
[f=0000000] [LuaIntro] Scanning: LuaIntro/chili/
[f=0000000] [LuaIntro] Found new widget "SpringLogo"
[f=0000000] [LuaIntro] Found new widget "LoadTexture"
[f=0000000] [LuaIntro] Found new widget "LoadProgress"
[f=0000000] [LuaIntro] Found new widget "Main"
[f=0000000] [LuaIntro] Found new widget "Music"
[f=0000000] [LuaIntro] Loading widgets   <>=vfs  **=raw  ()=unknown
[f=0000000] [LuaIntro] Loading widget:      LoadProgress           <loadprogress.lua>
[f=0000000] [LuaIntro] Loading widget:      Main                   <main.lua>
[f=0000000] [LuaIntro] Loading widget:      Music                  <music.lua>
[f=0000000] [LuaIntro] Loading widget:      LoadTexture            <bg_texture.lua>
[f=0000000] [LuaIntro] LuaIntro v1.0 (Lua 5.1)
[f=0000000] Parsing Map Information
[f=0000000] Loading SMF
[f=0000000] Loading Map (80 MB)
[f=0000000] Loading Radar Icons
[f=0000000] Loading GameData Definitions
[f=0000000] Loading all definitions:  4.325000
[f=0000000] Game::LoadDefs (GameData): 4374 ms
[f=0000000] Loading Sound Definitions
[f=0000000] [Sound]  parsed 27 sounds from gamedata/sounds.lua
[f=0000000] [Sound] Error: Unable to open audio file: IncomingChat
[f=0000000] [Sound] Error: CSound::GetSoundId: could not find sound: IncomingChat
[f=0000000] Game::LoadDefs (Sound): 0 ms
[f=0000000] Creating Smooth Height Mesh
[f=0000000] SmoothHeightMesh::MakeSmoothMesh: 49 ms
[f=0000000] Creating QuadField & CEGs
[f=0000000] [CDamageArrayHandler] number of ArmorDefs: 11
[f=0000000] [RegisterAssimpModelFormats] supported Assimp model formats: *.3d;*.3ds;*.ac;*.ac3d;*.acc;*.ase;*.ask;*.b3d;*.blend;*.bvh;*.cob;*.csm;*.dae;*.dxf;*.enff;*.hmp;*.ifc;*.irr;*.irrmesh;*.lwo;*.lws;*.lxo;*.m3;*.md2;*.md3;*.md5anim;*.md5camera;*.md5mesh;*.mdc;*.mdl;*.mesh.xml;*.mot;*.ms3d;*.ndo;*.nff;*.obj;*.off;*.pk3;*.ply;*.prj;*.q3o;*.q3s;*.raw;*.scn;*.smd;*.stl;*.ter;*.uc;*.vta;*.x;*.xgl;*.xml;*.zgl;
[f=0000000] Creating Unit Textures
[f=0000000] Creating Sky
[f=0000000] Loading Weapon Definitions
[f=0000000] Loading Unit Definitions
[f=0000000] Loading Feature Definitions
[f=0000000] Reading Estimate PathCosts [8]
[f=0000000] Reading Estimate PathCosts [32]
[f=0000000] [CPathManager] pathing data checksum: 1bcf8474
[f=0000000] [IPathManager::GetInstance] using DEFAULT path-manager
[f=0000000] Initializing Map Features
[f=0000000] Error: [LoadFeaturesFromMap] unknown map feature type ""
[f=0000000] Creating ShadowHandler & DecalHandler
[f=0000000] Creating GroundDrawer
[f=0000000] Loading Map Tiles
[f=0000000] Loading Square Textures
[f=0000000] CSMFGroundTextures::ConvolveHeightMap: 0 ms
[f=0000000] Switching to ROAM Mesh Rendering
[f=0000000] Creating TreeDrawer
[f=0000000] Creating ProjectileDrawer & UnitDrawer
[f=0000000] Creating Projectile Textures
[f=0000000] Warning: [CCEG::Load] krogtaarblaster: Unknown tag CSimpleParticleSystem::size
[f=0000000] Creating Water
[f=0000000] Game::LoadInterface (Camera&Mouse): 409 ms
[f=0000000] Game::LoadInterface (Console): 16 ms
[f=0000000] Loading LuaRules
[f=0000000] Loaded synced gadget:  Metalspot Finder Gadget  <mex_spot_finder.lua>
[f=0000000] Loaded synced gadget:  Rez Exp             <unit_rez_exp.lua>
[f=0000000] Loaded synced gadget:  ranks api           <api_ranks.lua>
[f=0000000] Loaded synced gadget:  No Self-D           <unit_prevent_share_selfd.lua>
[f=0000000] Loaded synced gadget:  CameraBroadcast     <camera_lockcamera.lua>
[f=0000000] Loaded synced gadget:  Awards              <gui_awards.lua>
[f=0000000] Loaded synced gadget:  Air Release         <unit_air_release_manager.lua>
[f=0000000] Loaded synced gadget:  AirPlantParents     <unit_air_plants.lua>
[f=0000000] Loaded synced gadget:  Bomber Control      <unit_bomber_control.lua>
[f=0000000] Loaded synced gadget:  Commando Watch      <unit_commando_watch.lua>
[f=0000000] Loaded synced gadget:  Cursor Broadcast    <cmd_mouse_pos_broadcast.lua>
[f=0000000] Loaded synced gadget:  DGun CmdType Fix    <unit_dgun_cmdtype_fix.lua>
[f=0000000] Loaded synced gadget:  Death Messages      <game_death_messages.lua>
[f=0000000] Loaded synced gadget:  DirectControl       <unit_direct_control.lua>
[f=0000000] Loaded synced gadget:  DragonsDisguise     <unit_set_neutral.lua>
[f=0000000] Loaded synced gadget:  Dynamic collision volume & Hitsphere Scaledown  <unit_dynamic_collision_volume.lua>
[f=0000000] Loaded synced gadget:  Energy Conversion   <game_energy_conversion.lua>
[f=0000000] Loaded synced gadget:  FinishedBuilding    <unit_finished_building.lua>
[f=0000000] Loaded synced gadget:  Game End            <game_end.lua>
[f=0000000] Loaded synced gadget:  Initial Spawn       <game_initial_spawn.lua>
[f=0000000] Loaded synced gadget:  Juno Damage         <unit_juno_damage.lua>
[f=0000000] Loaded synced gadget:  Lightning Spash Damage  <unit_lightning_splash_dmg.lua>
[f=0000000] Loaded synced gadget:  Lua unit script framework  <unit_script.lua>
[f=0000000] Loaded synced gadget:  Maverick Exp        <unit_maverick_exp.lua>
[f=0000000] Loaded synced gadget:  Merc/Scr stockpile control  <unit_mercscr_stockpile_limit.lua>
[f=0000000] Loaded synced gadget:  Napalm              <lups_napalm.lua>
[f=0000000] Loaded synced gadget:  No Land Damage      <unit_no_land_damage.lua>
[f=0000000] Loaded synced gadget:  No Self Pwn         <unit_noselfpwn.lua>
[f=0000000] Loaded synced gadget:  NoCost              <cmd_nocost.lua>
[f=0000000] Loaded synced gadget:  Nonblocking mines   <unit_nonblocking_mines.lua>
[f=0000000] Loaded synced gadget:  Paralyse Multiplier  <unit_paralyze_multiplier.lua>
[f=0000000] Loaded synced gadget:  Passive Builders II  <unit_passive_builders_ii.lua>
[f=0000000] Loaded synced gadget:  PopUpWaterStructures  <unit_pop_up_water_structures.lua>
[f=0000000] Loaded synced gadget:  Prevent Excessive Share  <game_prevent_excessive_share.lua>
[f=0000000] Loaded synced gadget:  Prevent Lab Hax     <unit_prevent_lab_hax.lua>
[f=0000000] Loaded synced gadget:  Prevent Load Hax    <unit_prevent_load_hax.lua>
[f=0000000] Loaded synced gadget:  Prevent Outside Aircraft hacks  <unit_prevent_aircraft_hax.lua>
[f=0000000] Loaded synced gadget:  Prevent Range Hax   <unit_prevent_range_hax.lua>
[f=0000000] Loaded synced gadget:  Prevent Strange Orders  <unit_prevent_strange_orders.lua>
[f=0000000] Loaded synced gadget:  Prevent Unload Hax  <unit_prevent_unload_hax.lua>
[f=0000000] Loaded synced gadget:  Reclaim Fix         <unit_reclaim_fix.lua>
[f=0000000] Loaded synced gadget:  Reclaim flash       <gfx_reclaim_flash.lua>
[f=0000000] Loaded synced gadget:  ShieldDrain         <unit_shield_watch.lua>
[f=0000000] Loaded synced gadget:  Shockwaves          <lups_shockwaves.lua>
[f=0000000] Loaded synced gadget:  Start Point Remover Gadget  <init_start_point_remover_gadget.lua>
[f=0000000] Loaded synced gadget:  Stealthy Passengers  <unit_stealthy_passengers.lua>
[f=0000000] Loaded synced gadget:  Target on the move  <unit_target_on_the_move.lua>
[f=0000000] Loaded synced gadget:  Team Resourcing     <game_team_resources.lua>
[f=0000000] Loaded synced gadget:  Transportee Hider   <unit_transportee_hider.lua>
[f=0000000] Loaded synced gadget:  Unit transportable nanos  <unit_transportable_nanos.lua>
[f=0000000] Loaded synced gadget:  Watereffects        <fx_watersplash.lua>
[f=0000000] Loaded synced gadget:  fx_reclaim_shards   <fx_reclaim_shards.lua>
[f=0000000] Loaded synced gadget:  fx_wreck_shards     <fx_wreck_shards.lua>
[f=0000000] Loaded synced gadget:  gfx_dynamic_lighting.lua  <gfx_dynamic_lighting.lua>
[f=0000000] Loaded synced gadget:  lups_wrapper.lua    <lups_wrapper.lua>
[f=0000000] Loaded synced gadget:  mo_combomb_full_damage  <mo_combomb_full_damage.lua>
[f=0000000] Loaded synced gadget:  mo_enemywrecks      <mo_enemywrecks.lua>
[f=0000000] Loaded synced gadget:  mo_noshare          <mo_noshare.lua>
[f=0000000] Loaded synced gadget:  transportfix        <unit_transportfix.lua>
[f=0000000] Loaded synced gadget:  Area Attack         <areaattack.lua>
[f=0000000] Loaded synced gadget:  C Is For Control    <comiscontrol.lua>
[f=0000000] Loaded synced gadget:  Coop II             <mo_coop_ii.lua>
[f=0000000] Loaded synced gadget:  CustomUnitShaders   <gfx_customunitshaders.lua>
[f=0000000] Loaded synced gadget:  Take Manager        <cmd_idle_players.lua>
[f=0000000] Loaded synced gadget:  Team Com Ends       <teamcomends.lua>
[f=0000000] Loaded synced gadget:  LupsSyncedManager   <lups_manager.lua>
[f=0000000] Loaded synced gadget:  Mex Upgrader Gadget  <unit_mex_upgrader.lua>
[f=0000000] Loaded synced gadget:  Crashing Aircraft   <unit_crashing_aircraft.lua>
[f=0000000] <LockCamera>: Sorry for the camera switch spam, but this is the only reliable way to list camera states other than hardcoding them
[f=0000000] Switching to Overview style camera
[f=0000000] Switching to Smooth style camera
[f=0000000] Switching to Overhead (TA) style camera
[f=0000000] Switching to Free style camera
[f=0000000] Switching to Total War style camera
[f=0000000] Switching to Rotatable overhead camera
[f=0000000] Switching to Orbit style camera
[f=0000000] Switching to FPS style camera
[f=0000000] Switching to Smooth style camera
[f=0000000] Loaded unsynced gadget:  Engine Taskbar Stuff  <engine_taskbar_stuff.lua>
[f=0000000] Loaded unsynced gadget:  Metalspot Finder Gadget  <mex_spot_finder.lua>
[f=0000000] Loaded unsynced gadget:  ranks api           <api_ranks.lua>
[f=0000000] Loaded unsynced gadget:  CustomIcons         <unit_customicons.lua>
[f=0000000] Loaded unsynced gadget:  CameraBroadcast     <camera_lockcamera.lua>
[f=0000000] Loaded unsynced gadget:  Awards              <gui_awards.lua>
[f=0000000] Loaded unsynced gadget:  Air Release         <unit_air_release_manager.lua>
[f=0000000] Loaded unsynced gadget:  AirPlantParents     <unit_air_plants.lua>
[f=0000000] Loaded unsynced gadget:  Cursor Broadcast    <cmd_mouse_pos_broadcast.lua>
[f=0000000] Loaded unsynced gadget:  DragonsDisguise     <unit_set_neutral.lua>
[f=0000000] Loaded unsynced gadget:  Dynamic collision volume & Hitsphere Scaledown  <unit_dynamic_collision_volume.lua>
[f=0000000] Loaded unsynced gadget:  FinishedBuilding    <unit_finished_building.lua>
[f=0000000] Loaded unsynced gadget:  Initial Spawn       <game_initial_spawn.lua>
[f=0000000] Loaded unsynced gadget:  Juno Damage         <unit_juno_damage.lua>
[f=0000000] Loaded unsynced gadget:  Merc/Scr stockpile control  <unit_mercscr_stockpile_limit.lua>
[f=0000000] Loaded unsynced gadget:  Napalm              <lups_napalm.lua>
[f=0000000] Loaded unsynced gadget:  NoCost              <cmd_nocost.lua>
[f=0000000] Loaded unsynced gadget:  PopUpWaterStructures  <unit_pop_up_water_structures.lua>
[f=0000000] Loaded unsynced gadget:  Prevent Unload Hax  <unit_prevent_unload_hax.lua>
[f=0000000] Loaded unsynced gadget:  Reclaim Fix         <unit_reclaim_fix.lua>
[f=0000000] Loaded unsynced gadget:  Reclaim flash       <gfx_reclaim_flash.lua>
[f=0000000] Loaded unsynced gadget:  ShieldDrain         <unit_shield_watch.lua>
[f=0000000] Loaded unsynced gadget:  Shockwaves          <lups_shockwaves.lua>
[f=0000000] Loaded unsynced gadget:  Start Point Remover Gadget  <init_start_point_remover_gadget.lua>
[f=0000000] Loaded unsynced gadget:  Target on the move  <unit_target_on_the_move.lua>
[f=0000000] Loaded unsynced gadget:  Transportee Hider   <unit_transportee_hider.lua>
[f=0000000] Loaded unsynced gadget:  Watereffects        <fx_watersplash.lua>
[f=0000000] Loaded unsynced gadget:  fx_reclaim_shards   <fx_reclaim_shards.lua>
[f=0000000] Loaded unsynced gadget:  fx_wreck_shards     <fx_wreck_shards.lua>
[f=0000000] Loaded unsynced gadget:  gfx_dynamic_lighting.lua  <gfx_dynamic_lighting.lua>
[f=0000000] Loaded unsynced gadget:  mo_enemywrecks      <mo_enemywrecks.lua>
[f=0000000] Loaded unsynced gadget:  mo_greenfields      <mo_greenfields.lua>
[f=0000000] Loaded unsynced gadget:  mo_noowner          <mo_noowner.lua>
[f=0000000] Loaded unsynced gadget:  mo_noshare          <mo_noshare.lua>
[f=0000000] Loaded unsynced gadget:  mo_nowrecks         <mo_nowrecks.lua>
[f=0000000] Loaded unsynced gadget:  transportfix        <unit_transportfix.lua>
[f=0000000] Loaded unsynced gadget:  Area Attack         <areaattack.lua>
[f=0000000] Loaded unsynced gadget:  C Is For Control    <comiscontrol.lua>
[f=0000000] Loaded unsynced gadget:  Coop II             <mo_coop_ii.lua>
[f=0000000] Loaded unsynced gadget:  CustomUnitShaders   <gfx_customunitshaders.lua>
[f=0000000] Loaded unsynced gadget:  Take Manager        <cmd_idle_players.lua>
[f=0000000] Loaded unsynced gadget:  LupsSyncedManager   <lups_manager.lua>
[f=0000000] Loaded unsynced gadget:  Mex Upgrader Gadget  <unit_mex_upgrader.lua>
[f=0000000] Loaded unsynced gadget:  Crashing Aircraft   <unit_crashing_aircraft.lua>
[f=0000000] Loaded unsynced gadget:  Lups                <lups_wrapper.lua>
[f=0000000] Loading LuaGaia
[f=0000000] Loading LuaUI
[f=0000000] LuaSocketEnabled: yes
[f=0000000] This game has locked LuaUI access
[f=0000000] This game has locked LuaUI access
[f=0000000] Using LUAUI_DIRNAME = LuaUI/
[f=0000000] Reloaded ctrlpanel from file: LuaUI/ctrlpanel.txt
[f=0000000] LuaUI: bound F11 to the widget selector
[f=0000000] LuaUI: bound CTRL+F11 to tweak mode
[f=0000000] Failed to load: camera_smooth_move.lua  ([string "LuaUI\Widgets\camera_smooth_move.lua"]:232: unexpected symbol near 'local')
[f=0000000] Failed to load: gui_fastswitch.lua  (duplicate name)
[f=0000000] Failed to load: camera_smooth_move.lua  ([string "LuaUI/Widgets/camera_smooth_move.lua"]:232: unexpected symbol near 'local')
[f=0000000] Failed to load: gfx_projectile_lights.lua  (duplicate name)
[f=0000000] Failed to load: gui_advplayerslist.lua  (duplicate name)
[f=0000000] Loading widget from mod:   Metalspot Finder    <wg_metalspot_finder.lua> ...
[f=0000000] Loading widget from mod:   MexUpg Helper       <cmd_mex_upgrade_helper.lua> ...
[f=0000000] Loading widget from mod:   Faction Change      <gui_faction_change.lua> ...
[f=0000000] Loading widget from user:  Wisse Layout        <gui_transparent.lua> ...
[f=0000000] Loading widget from mod:   HealthBars          <unit_healthbars.lua> ...
[f=0000000] Loading widget from mod:   LockCamera          <camera_lockcamera.lua> ...
[f=0000000] Loading widget from user:  AdvPlayersList      <gui_advplayerslist.lua> ...
[f=0000000] Loading widget from user:  Projectile lights   <gfx_projectile_lights.lua> ...
[f=0000000] Loading widget from mod:   Initial Queue       <unit_initial_queue.lua> ...
[f=0000000] Loading widget from mod:   Anti Range          <gui_anti_range.lua> ...
[f=0000000] Loading widget from mod:   Auto First Build Facing  <autofirstbuildfacing.lua> ...
[f=0000000] Loading widget from mod:   Autoquit            <autoquit.lua> ...
[f=0000000] Loading widget from mod:   Highlight Geos      <gui_highlight_geos.lua> ...
[f=0000000] Loading widget from mod:   Build Split         <cmd_buildsplit.lua> ...
[f=0000000] Loading widget from mod:   DontMove            <unit_dontmove.lua> ...
[f=0000000] Loading widget from mod:   Group Label         <gui_group_label.lua> ...
[f=0000000] Loading widget from mod:   Holdfire Fix        <unit_holdfire_fix.lua> ...
[f=0000000] Loading widget from mod:   MoreSounds          <unit_more_sounds.lua> ...
[f=0000000] Loading widget from mod:   Point Tracker       <gui_point_tracker.lua> ...
[f=0000000] Loading widget from mod:   RelativeMinimap     <minimap_relative.lua> ...
[f=0000000] Loading widget from mod:   ReclaimInfo         <gui_reclaiminfo.lua> ...
[f=0000000] Loading widget from mod:   SelectionButtons    <gui_selbuttons.lua> ...
[f=0000000] Loading widget from mod:   Share Tracker       <unit_share_tracker.lua> ...
[f=0000000] Loading widget from mod:   Spectate Selected   <gui_spectate_selected.lua> ...
[f=0000000] Loading widget from mod:   State Reverse Toggle  <cmd_state_reverse_toggle.lua> ...
[f=0000000] Loading widget from mod:   Persistent Build Spacing  <gui_persistent_build_spacing.lua> ...
[f=0000000] Loading widget from mod:   Load Own Moving     <unit_load_own_moving.lua> ...
[f=0000000] Loading widget from mod:   Mex Snap            <cmd_mex_snap.lua> ...
[f=0000000] Loading widget from mod:   SmoothCam           <camera_smoothcam.lua> ...
[f=0000000] Loading widget from mod:   Adv. Unit Marker    <gui_adv_unit_marker.lua> ...
[f=0000000] Loading widget from user:  SoundVolume         <snd_volume.lua> ...
[f=0000000] Loading widget from mod:   Take Proxy          <cmd_take_proxy.lua> ...
[f=0000000] Loading widget from mod:   Volume OSD          <snd_volume_osd.lua> ...
[f=0000000] Loading widget from mod:   CameraFlip          <camera_flip.lua> ...
[f=0000000] Loading widget from mod:   BA_AllyCursors      <gui_ba_ally_cursors.lua> ...
[f=0000000] Loading widget from mod:   Com Counter         <gui_comcounter.lua> ...
[f=0000000] Loading widget from mod:   Ghost Radar         <unit_ghostradar.lua> ...
[f=0000000] Loading widget from mod:   Auto group          <unit_auto_group.lua> ...
[f=0000000] Loading widget from mod:   Easy Facing         <gui_easyfacing.lua> ...
[f=0000000] Loading widget from mod:   Ghost Site          <unit_ghostsite.lua> ...
[f=0000000] Loading widget from mod:   NoDuplicateOrders   <cmd_no_duplicate_orders.lua> ...
[f=0000000] Loading widget from mod:   Com DontBreakCloak  <unit_com_dontbreakcloak.lua> ...
[f=0000000] Loading widget from mod:   DGun Stall Assist   <unit_dgun_stall_assist.lua> ...
[f=0000000] Loading widget from mod:   ImmobileBuilder     <unit_immobile_builder.lua> ...
[f=0000000] Loading widget from mod:   Stockpiler (dynamic)  <unit_stockpile_dynamic.lua> ...
[f=0000000] Loading widget from mod:   Wait reclaim        <cmd_wait_reclaim.lua> ...
[f=0000000] Loading widget from mod:   Specific Unit Reclaimer  <unit_specific_unit_reclaimer.lua> ...
[f=0000000] Loading widget from mod:   GameTypeInfo        <gui_game_type_info.lua> ...
[f=0000000] Loading widget from mod:   Building Hotkeys    <cmd_building_hotkeys.lua> ...
[f=0000000] Loading widget from mod:   Attack and Move Notification  <unit_attackmovenotification.lua> ...
[f=0000000] Loading widget from mod:   Prospector          <gui_prospector.lua> ...
[f=0000000] Loading widget from mod:   Attack AoE          <gui_attack_aoe.lua> ...
[f=0000000] Loading widget from mod:   Context Build       <cmd_context_build.lua> ...
[f=0000000] Loading widget from mod:   Set Target Hotkeys  <cmd_target_on_the_move_hotkeys.lua> ...
[f=0000000] Loading widget from user:  AutoRepair          <unit_autorepair.lua> ...
[f=0000000] Loading widget from mod:   BA Waypoint Dragger  <unit_waypoint_dragger_2.lua> ...
[f=0000000] Loading widget from mod:   CommandInsert       <gui_commandinsert.lua> ...
[f=0000000] Loading widget from user:  FastSwitch v2.1     <give_custom.lua> ...
[f=0000000] Loading widget from mod:   Select n Center!    <gui_center_n_select.lua> ...
[f=0000000] Loading widget from mod:   Mouse Buildspacing  <gui_buildspacing.lua> ...
[f=0000000] Loading widget from mod:   CustomFormations2   <unit_customformations2.lua> ...
[f=0000000] LuaUI v0.3
[f=0000000] Initializing PathCache
[f=0000000] Finalizing
[f=0000000] Loaded DecalsDrawer: Legacy
[f=0000000] Connection attempt from [teh]Beherith[PiRO]
[f=0000000]  -> Version: 95.0
[f=0000000]  -> Connection established (given id 0)
[f=0000000] Connection attempt from [teh]Beherith[PiRO]2
[f=0000000]  -> Version: 95.0
[f=0000000]  -> Address: [192.168.1.108]:65439
[f=0000000]  -> Connection established (given id 1)
[f=0000000] Player [teh]Beherith[PiRO]2 finished loading and is now ingame
[f=0000000] Player [teh]Beherith[PiRO] finished loading and is now ingame
[f=0000000] GameID: 34339752a7ffbd21f81b9b4c83885d71
[f=0000373] Cheating is enabled!
[f=0000499] [GiveUnits] spawned 10 corvamp unit(s) for team 0
[f=0000701] debug-info rendering mode is enabled!
[f=0000727] Error: assert(CTO <= 1.0f) failed (SF=727 : DF=8794 : CTO=1.500000 : WSF=0.030518 : DT=49.152000ms : NP=1)
[f=0000727] Error: assert(CTO <= 1.0f) failed (SF=727 : DF=8795 : CTO=1.500000 : WSF=0.030518 : DT=49.152000ms : NP=1)
[f=0000756] Error: assert(CTO <= 1.0f) failed (SF=756 : DF=9063 : CTO=1.451613 : WSF=0.029533 : DT=49.152000ms : NP=1)
[f=0000756] Error: assert(CTO <= 1.0f) failed (SF=756 : DF=9064 : CTO=1.451613 : WSF=0.029533 : DT=49.152000ms : NP=1)
[f=0000785] Error: assert(CTO <= 1.0f) failed (SF=785 : DF=9326 : CTO=1.500000 : WSF=0.030518 : DT=49.152000ms : NP=1)
[f=0000814] Error: assert(CTO <= 1.0f) failed (SF=814 : DF=9591 : CTO=1.500000 : WSF=0.030518 : DT=49.152000ms : NP=1)
[f=0000814] Error: assert(CTO <= 1.0f) failed (SF=814 : DF=9592 : CTO=1.500000 : WSF=0.030518 : DT=49.152000ms : NP=1)
[f=0000843] Error: assert(CTO <= 1.0f) failed (SF=843 : DF=9857 : CTO=1.451613 : WSF=0.029533 : DT=49.152000ms : NP=1)
[f=0000843] Error: assert(CTO <= 1.0f) failed (SF=843 : DF=9858 : CTO=1.451613 : WSF=0.029533 : DT=49.152000ms : NP=1)
[f=0000843] Error: assert(CTO <= 1.0f) failed (SF=843 : DF=9859 : CTO=1.451613 : WSF=0.029533 : DT=49.152000ms : NP=1)
[f=0000872] Error: assert(CTO <= 1.0f) failed (SF=872 : DF=10113 : CTO=1.500000 : WSF=0.030518 : DT=49.152000ms : NP=1)
[f=0000872] Error: assert(CTO <= 1.0f) failed (SF=872 : DF=10114 : CTO=1.500000 : WSF=0.030518 : DT=49.152000ms : NP=1)
[f=0000872] Error: assert(CTO <= 1.0f) failed (SF=872 : DF=10115 : CTO=1.500000 : WSF=0.030518 : DT=49.152000ms : NP=1)
[f=0000901] Error: assert(CTO <= 1.0f) failed (SF=901 : DF=10369 : CTO=1.451613 : WSF=0.029533 : DT=49.152000ms : NP=1)
[f=0000901] Error: assert(CTO <= 1.0f) failed (SF=901 : DF=10370 : CTO=1.451613 : WSF=0.029533 : DT=49.152000ms : NP=1)
[f=0000901] Error: assert(CTO <= 1.0f) failed (SF=901 : DF=10371 : CTO=1.451613 : WSF=0.029533 : DT=49.152000ms : NP=1)
[f=0000959] Error: assert(CTO <= 1.0f) failed (SF=959 : DF=10863 : CTO=1.500000 : WSF=0.030518 : DT=49.152000ms : NP=1)
[f=0001046] Error: assert(CTO <= 1.0f) failed (SF=1046 : DF=11618 : CTO=1.451613 : WSF=0.029533 : DT=49.152000ms : NP=1)
[f=0001133] Error: assert(CTO <= 1.0f) failed (SF=1133 : DF=12362 : CTO=1.500000 : WSF=0.030518 : DT=49.152000ms : NP=1)
[f=0001133] Error: assert(CTO <= 1.0f) failed (SF=1133 : DF=12363 : CTO=1.500000 : WSF=0.030518 : DT=49.152000ms : NP=1)
[f=0001162] Error: assert(CTO <= 1.0f) failed (SF=1162 : DF=12603 : CTO=1.451613 : WSF=0.029533 : DT=49.152000ms : NP=1)
[f=0001248] Error: assert(CTO <= 1.0f) failed (SF=1248 : DF=13321 : CTO=1.500000 : WSF=0.030518 : DT=49.152000ms : NP=1)
[f=0001277] Error: assert(CTO <= 1.0f) failed (SF=1277 : DF=13563 : CTO=1.500000 : WSF=0.030518 : DT=49.152000ms : NP=1)
[f=0001335] Error: assert(CTO <= 1.0f) failed (SF=1335 : DF=14056 : CTO=1.451613 : WSF=0.029533 : DT=49.152000ms : NP=1)
[f=0001364] Error: assert(CTO <= 1.0f) failed (SF=1364 : DF=14307 : CTO=1.500000 : WSF=0.030518 : DT=49.152000ms : NP=0)
[f=0001393] Error: assert(CTO <= 1.0f) failed (SF=1393 : DF=14547 : CTO=1.451613 : WSF=0.029533 : DT=49.152000ms : NP=1)
[f=0001422] Error: assert(CTO <= 1.0f) failed (SF=1422 : DF=14785 : CTO=1.500000 : WSF=0.030518 : DT=49.152000ms : NP=1)
[f=0001451] Error: assert(CTO <= 1.0f) failed (SF=1451 : DF=15032 : CTO=1.451613 : WSF=0.029533 : DT=49.152000ms : NP=1)
[f=0001451] Error: assert(CTO <= 1.0f) failed (SF=1451 : DF=15033 : CTO=1.451613 : WSF=0.029533 : DT=49.152000ms : NP=1)
[f=0001480] Error: assert(CTO <= 1.0f) failed (SF=1480 : DF=15287 : CTO=1.500000 : WSF=0.030518 : DT=49.152000ms : NP=1)
[f=0001509] Error: assert(CTO <= 1.0f) failed (SF=1509 : DF=15539 : CTO=1.500000 : WSF=0.030518 : DT=49.152000ms : NP=1)
[f=0001509] Error: assert(CTO <= 1.0f) failed (SF=1509 : DF=15540 : CTO=1.500000 : WSF=0.030518 : DT=49.152000ms : NP=1)
[f=0001509] Error: assert(CTO <= 1.0f) failed (SF=1509 : DF=15541 : CTO=1.500000 : WSF=0.030518 : DT=49.152000ms : NP=1)
[f=0001538] Error: assert(CTO <= 1.0f) failed (SF=1538 : DF=15794 : CTO=1.451613 : WSF=0.029533 : DT=49.152000ms : NP=1)
[f=0001538] Error: assert(CTO <= 1.0f) failed (SF=1538 : DF=15795 : CTO=1.451613 : WSF=0.029533 : DT=49.152000ms : NP=1)
[f=0001538] Error: assert(CTO <= 1.0f) failed (SF=1538 : DF=15796 : CTO=1.451613 : WSF=0.029533 : DT=49.152000ms : NP=0)
[f=0001567] Error: assert(CTO <= 1.0f) failed (SF=1567 : DF=16045 : CTO=1.500000 : WSF=0.030518 : DT=49.152000ms : NP=1)
[f=0001567] Error: assert(CTO <= 1.0f) failed (SF=1567 : DF=16046 : CTO=1.500000 : WSF=0.030518 : DT=49.152000ms : NP=1)
[f=0001712] Error: assert(CTO <= 1.0f) failed (SF=1712 : DF=17185 : CTO=1.500000 : WSF=0.030518 : DT=49.152000ms : NP=1)
[f=0001741] Error: assert(CTO <= 1.0f) failed (SF=1741 : DF=17438 : CTO=1.451613 : WSF=0.029533 : DT=49.152000ms : NP=1)
[f=0001799] Error: assert(CTO <= 1.0f) failed (SF=1799 : DF=17943 : CTO=1.500000 : WSF=0.030518 : DT=49.152000ms : NP=1)
[f=0001799] Error: assert(CTO <= 1.0f) failed (SF=1799 : DF=17944 : CTO=1.500000 : WSF=0.030518 : DT=49.152000ms : NP=1)
[f=0001828] Error: assert(CTO <= 1.0f) failed (SF=1828 : DF=18194 : CTO=1.451613 : WSF=0.029533 : DT=49.152000ms : NP=1)
[f=0001828] Error: assert(CTO <= 1.0f) failed (SF=1828 : DF=18195 : CTO=1.451613 : WSF=0.029533 : DT=49.152000ms : NP=1)
[f=0001857] Error: assert(CTO <= 1.0f) failed (SF=1857 : DF=18448 : CTO=1.500000 : WSF=0.030518 : DT=49.152000ms : NP=1)
[f=0001886] Error: assert(CTO <= 1.0f) failed (SF=1886 : DF=18698 : CTO=1.451613 : WSF=0.029533 : DT=49.152000ms : NP=1)
[f=0001886] Error: assert(CTO <= 1.0f) failed (SF=1886 : DF=18699 : CTO=1.451613 : WSF=0.029533 : DT=49.152000ms : NP=1)
[f=0001915] Error: assert(CTO <= 1.0f) failed (SF=1915 : DF=18954 : CTO=1.451613 : WSF=0.029533 : DT=49.152000ms : NP=1)
[f=0001915] Error: assert(CTO <= 1.0f) failed (SF=1915 : DF=18955 : CTO=1.451613 : WSF=0.029533 : DT=49.152000ms : NP=1)
[f=0001944] Error: assert(CTO <= 1.0f) failed (SF=1944 : DF=19207 : CTO=1.500000 : WSF=0.030518 : DT=49.152000ms : NP=1)
[f=0001973] Error: assert(CTO <= 1.0f) failed (SF=1973 : DF=19460 : CTO=1.451613 : WSF=0.029533 : DT=49.152000ms : NP=1)
[f=0001973] Error: assert(CTO <= 1.0f) failed (SF=1973 : DF=19461 : CTO=1.451613 : WSF=0.029533 : DT=49.152000ms : NP=1)
[f=0001973] Error: assert(CTO <= 1.0f) failed (SF=1973 : DF=19462 : CTO=1.451613 : WSF=0.029533 : DT=49.152000ms : NP=1)
[f=0002002] Error: assert(CTO <= 1.0f) failed (SF=2002 : DF=19704 : CTO=1.500000 : WSF=0.030518 : DT=49.152000ms : NP=1)
[f=0002002] Error: assert(CTO <= 1.0f) failed (SF=2002 : DF=19705 : CTO=1.500000 : WSF=0.030518 : DT=49.152000ms : NP=1)
[f=0002002] Error: assert(CTO <= 1.0f) failed (SF=2002 : DF=19706 : CTO=1.500000 : WSF=0.030518 : DT=49.152000ms : NP=1)
[f=0002234] Error: assert(CTO <= 1.0f) failed (SF=2234 : DF=21703 : CTO=1.500000 : WSF=0.030518 : DT=49.152000ms : NP=1)
[f=0002263] Error: assert(CTO <= 1.0f) failed (SF=2263 : DF=21953 : CTO=1.451613 : WSF=0.029533 : DT=49.152000ms : NP=1)
[f=0002263] Error: assert(CTO <= 1.0f) failed (SF=2263 : DF=21954 : CTO=1.451613 : WSF=0.029533 : DT=49.152000ms : NP=1)
[f=0002292] Error: assert(CTO <= 1.0f) failed (SF=2292 : DF=22209 : CTO=1.500000 : WSF=0.030518 : DT=49.152000ms : NP=1)
[f=0002292] Error: assert(CTO <= 1.0f) failed (SF=2292 : DF=22210 : CTO=1.500000 : WSF=0.030518 : DT=49.152000ms : NP=0)
[f=0002408] Error: assert(CTO <= 1.0f) failed (SF=2408 : DF=23218 : CTO=1.451613 : WSF=0.029533 : DT=49.152000ms : NP=1)
[f=0002437] Error: assert(CTO <= 1.0f) failed (SF=2437 : DF=23485 : CTO=1.451613 : WSF=0.029533 : DT=49.152000ms : NP=1)
[f=0002437] Error: assert(CTO <= 1.0f) failed (SF=2437 : DF=23486 : CTO=1.451613 : WSF=0.029533 : DT=49.152000ms : NP=1)
[f=0002466] Error: assert(CTO <= 1.0f) failed (SF=2466 : DF=23746 : CTO=1.500000 : WSF=0.030518 : DT=49.152000ms : NP=1)
[f=0002495] Error: assert(CTO <= 1.0f) failed (SF=2495 : DF=23991 : CTO=1.451613 : WSF=0.029533 : DT=49.152000ms : NP=1)
[f=0002495] Error: assert(CTO <= 1.0f) failed (SF=2495 : DF=23992 : CTO=1.451613 : WSF=0.029533 : DT=49.152000ms : NP=1)
[f=0002524] Error: assert(CTO <= 1.0f) failed (SF=2524 : DF=24249 : CTO=1.500000 : WSF=0.030518 : DT=49.152000ms : NP=1)
[f=0002524] Error: assert(CTO <= 1.0f) failed (SF=2524 : DF=24250 : CTO=1.500000 : WSF=0.030518 : DT=49.152000ms : NP=1)
[f=0002524] Error: assert(CTO <= 1.0f) failed (SF=2524 : DF=24251 : CTO=1.500000 : WSF=0.030518 : DT=49.152000ms : NP=1)
[f=0002553] Error: assert(CTO <= 1.0f) failed (SF=2553 : DF=24503 : CTO=1.451613 : WSF=0.029533 : DT=49.152000ms : NP=1)
[f=0002582] Error: assert(CTO <= 1.0f) failed (SF=2582 : DF=24751 : CTO=1.500000 : WSF=0.030518 : DT=49.152000ms : NP=1)
[f=0002582] Error: assert(CTO <= 1.0f) failed (SF=2582 : DF=24752 : CTO=1.500000 : WSF=0.030518 : DT=49.152000ms : NP=1)
[f=0002582] Error: assert(CTO <= 1.0f) failed (SF=2582 : DF=24753 : CTO=1.500000 : WSF=0.030518 : DT=49.152000ms : NP=1)
[f=0002611] Error: assert(CTO <= 1.0f) failed (SF=2611 : DF=25007 : CTO=1.451613 : WSF=0.029533 : DT=49.152000ms : NP=1)
[f=0002611] Error: assert(CTO <= 1.0f) failed (SF=2611 : DF=25008 : CTO=1.451613 : WSF=0.029533 : DT=49.152000ms : NP=1)
[f=0002640] Error: assert(CTO <= 1.0f) failed (SF=2640 : DF=25261 : CTO=1.500000 : WSF=0.030518 : DT=49.152000ms : NP=1)
[f=0002640] Error: assert(CTO <= 1.0f) failed (SF=2640 : DF=25262 : CTO=1.500000 : WSF=0.030518 : DT=49.152000ms : NP=1)
[f=0002669] Error: assert(CTO <= 1.0f) failed (SF=2669 : DF=25515 : CTO=1.451613 : WSF=0.029533 : DT=49.152000ms : NP=1)
[f=0002669] Error: assert(CTO <= 1.0f) failed (SF=2669 : DF=25516 : CTO=1.451613 : WSF=0.029533 : DT=49.152000ms : NP=1)
[f=0002784] Error: assert(CTO <= 1.0f) failed (SF=2784 : DF=26481 : CTO=1.451613 : WSF=0.029533 : DT=49.152000ms : NP=1)
[f=0002784] Error: assert(CTO <= 1.0f) failed (SF=2784 : DF=26482 : CTO=1.451613 : WSF=0.029533 : DT=49.152000ms : NP=0)
[f=0002813] Error: assert(CTO <= 1.0f) failed (SF=2813 : DF=26725 : CTO=1.500000 : WSF=0.030518 : DT=49.152000ms : NP=1)
[f=0002813] Error: assert(CTO <= 1.0f) failed (SF=2813 : DF=26726 : CTO=1.500000 : WSF=0.030518 : DT=49.152000ms : NP=1)
[f=0002842] Error: assert(CTO <= 1.0f) failed (SF=2842 : DF=26978 : CTO=1.500000 : WSF=0.030518 : DT=49.152000ms : NP=1)
[f=0002871] Error: assert(CTO <= 1.0f) failed (SF=2871 : DF=27228 : CTO=1.451613 : WSF=0.029533 : DT=49.152000ms : NP=1)
[f=0002871] Error: assert(CTO <= 1.0f) failed (SF=2871 : DF=27229 : CTO=1.451613 : WSF=0.029533 : DT=49.152000ms : NP=1)
[f=0002871] Error: assert(CTO <= 1.0f) failed (SF=2871 : DF=27230 : CTO=1.451613 : WSF=0.029533 : DT=49.152000ms : NP=1)
[f=0002900] Error: assert(CTO <= 1.0f) failed (SF=2900 : DF=27478 : CTO=1.451613 : WSF=0.029533 : DT=49.152000ms : NP=1)
[f=0002900] Error: assert(CTO <= 1.0f) failed (SF=2900 : DF=27479 : CTO=1.451613 : WSF=0.029533 : DT=49.152000ms : NP=1)
[f=0002900] Error: assert(CTO <= 1.0f) failed (SF=2900 : DF=27480 : CTO=1.451613 : WSF=0.029533 : DT=49.152000ms : NP=1)
[f=0003045] Error: assert(CTO <= 1.0f) failed (SF=3045 : DF=28738 : CTO=1.451613 : WSF=0.029533 : DT=49.152000ms : NP=1)
[f=0003074] Error: assert(CTO <= 1.0f) failed (SF=3074 : DF=28993 : CTO=1.500000 : WSF=0.030518 : DT=49.152000ms : NP=1)
[f=0003132] Error: assert(CTO <= 1.0f) failed (SF=3132 : DF=29502 : CTO=1.500000 : WSF=0.030518 : DT=49.152000ms : NP=1)
[f=0003132] Error: assert(CTO <= 1.0f) failed (SF=3132 : DF=29503 : CTO=1.500000 : WSF=0.030518 : DT=49.152000ms : NP=1)
[f=0003219] Error: assert(CTO <= 1.0f) failed (SF=3219 : DF=30261 : CTO=1.500000 : WSF=0.030518 : DT=49.152000ms : NP=1)
[f=0003219] Error: assert(CTO <= 1.0f) failed (SF=3219 : DF=30262 : CTO=1.500000 : WSF=0.030518 : DT=49.152000ms : NP=1)
[f=0003248] Error: assert(CTO <= 1.0f) failed (SF=3248 : DF=30516 : CTO=1.451613 : WSF=0.029533 : DT=49.152000ms : NP=1)
[f=0003248] Error: assert(CTO <= 1.0f) failed (SF=3248 : DF=30517 : CTO=1.451613 : WSF=0.029533 : DT=49.152000ms : NP=1)
[f=0003277] Error: assert(CTO <= 1.0f) failed (SF=3277 : DF=30775 : CTO=1.500000 : WSF=0.030518 : DT=49.152000ms : NP=1)
[f=0003277] Error: assert(CTO <= 1.0f) failed (SF=3277 : DF=30776 : CTO=1.500000 : WSF=0.030518 : DT=49.152000ms : NP=1)
[f=0003306] Error: assert(CTO <= 1.0f) failed (SF=3306 : DF=31037 : CTO=1.451613 : WSF=0.029533 : DT=49.152000ms : NP=1)
[f=0003306] Error: assert(CTO <= 1.0f) failed (SF=3306 : DF=31038 : CTO=1.451613 : WSF=0.029533 : DT=49.152000ms : NP=1)
[f=0003306] Error: assert(CTO <= 1.0f) failed (SF=3306 : DF=31039 : CTO=1.451613 : WSF=0.029533 : DT=49.152000ms : NP=1)
[f=0003335] Error: assert(CTO <= 1.0f) failed (SF=3335 : DF=31287 : CTO=1.500000 : WSF=0.030518 : DT=49.152000ms : NP=1)
[f=0003393] Error: assert(CTO <= 1.0f) failed (SF=3393 : DF=31791 : CTO=1.500000 : WSF=0.030518 : DT=49.152000ms : NP=1)
[f=0003422] Error: assert(CTO <= 1.0f) failed (SF=3422 : DF=32051 : CTO=1.500000 : WSF=0.030518 : DT=49.152000ms : NP=0)
[f=0003456] Statistics for RectangleOptimizer: 0%
[f=0003456] [CCollisionHandler] dis-/continuous tests: 0/338056
[f=0003456] [~CPathCache(40x20)] cacheHits=0 hitPercentage=0% numHashColls=0 maxCacheSize=0
[f=0003456] [~CPathCache(40x20)] cacheHits=0 hitPercentage=0% numHashColls=0 maxCacheSize=0
[f=0003456] [~CPathCache(160x80)] cacheHits=0 hitPercentage=0% numHashColls=0 maxCacheSize=0
[f=0003456] [~CPathCache(160x80)] cacheHits=0 hitPercentage=0% numHashColls=0 maxCacheSize=0
[f=0003456] Statistics for RectangleOptimizer: 0%
[f=0003456] Statistics for RectangleOptimizer: 0%
[f=0003456] Statistics for local connection:
Received: 10093 bytes
Sent: 39346 bytes

[f=0003456] Writing demo: demos/20131128_131214_DeltaSiegeDry_95.sdf
    txt file icon infolog_wierd_run1_host.txt (42,467 bytes) 2013-11-28 19:36 +
  • txt file icon infolog_msvc11_client.txt (277,453 bytes) 2013-11-30 19:52
  • txt file icon infolog_msvc11_host.txt (1,951,396 bytes) 2013-12-01 18:40
  • txt file icon infolog_client_147.txt (295,443 bytes) 2013-12-02 19:31
  • 7z file icon infolog_host_147.7z (259,497 bytes) 2013-12-02 19:32
  • txt file icon infolog_151_client_dirty_pc.txt (70,829 bytes) 2013-12-03 12:03 - 
    [ParseCmdLine] command-line args: "C:\Users\Peti\Documents\My Games\Spring\engine\95.0.1-151-ge073c88\spring.exe C:\Users\Peti\Documents\My Games\Spring\engine\95.0.1-151-ge073c88\script.txt"
Using configuration source: "C:\Users\Peti\Documents\My Games\Spring\engine\95.0.1-151-ge073c88\springsettings.cfg"
Using additional configuration source: "C:\Users\Peti\AppData\Local\springsettings.cfg"
Available log sections: KeyBindings, AutohostInterface, Net, CSMFGroundTextures, RoamMeshDrawer, BumpWater, DynWater, SkyBox, DecalsDrawerGL4, FarTextureHandler, Model, Piece, ModelDrawer, OBJParser, WorldObjectModelRenderer, Shader, Texture, Font, GroundMoveType, Path, UnitScript, CregSerializer, ArchiveScanner, VFS, Sound, LuaSocket
Enabled log sections: Sound(LOG_LEVEL_INFO)
Enable or disable log sections using the LogSections configuration key
  or the SPRING_LOG_SECTIONS environment variable (both comma separated).
  Use "none" to disable the default log sections.
LogOutput initialized.
Spring 95.0.1-151-ge073c88 develop
Build date/time: Dec  2 2013 22:21:47
Build environment: boost-105300, GNU libstdc++ version 20130531
Compiler: gcc-4.8.1
OS: Microsoft Windows
Microsoft Windows 7 Ultimate Edition, 64-bit (build 7600)
Intel(R) Core(TM) i5 CPU         750  @ 2.67GHz; 8190MB RAM, 16378MB pagefile
OS: emulated 32bit mode
[CMyMath::Init] CPU SSE mask: 127, flags:
	SSE 1.0:  1,  SSE 2.0:  1
	SSE 3.0:  1, SSSE 3.0:  1
	SSE 4.1:  1,  SSE 4.2:  1
	SSE 4.0A: 0,  SSE 5.0A: 0
	using streflop SSE FP-math mode, CPU supports SSE instructions
Supported Video modes: 2560x1440, 1920x1440, 1920x1200, 1920x1080, 1680x1050, 1600x1200, 1600x1024, 1600x900, 1366x768, 1360x768, 1280x1024, 1280x960, 1280x800, 1280x768, 1280x720, 1152x864, 1024x768, 800x600, 720x576, 720x480, 640x480
[SetSDLVideoMode] video mode set to 2560x1440/32bit (windowed)
[WatchDogInstall] Installed (HangTimeout: 10sec)
[ThreadPool::SetThreadCount][1] #wanted=4 #current=1
[ThreadPool::SetThreadCount][2] #threads=3
[DataDirs] Portable Mode!
Using read-write data directory: C:\Users\Peti\Documents\My Games\Spring\engine\95.0.1-151-ge073c88\
Using read-only data directory: C:\Users\Peti\Documents\My Games\Spring\
Using read-only data directory: C:\Users\Peti\Documents\Spring\
Using read-only data directory: C:\ProgramData\Spring\
Scanning: C:\Users\Peti\Documents\My Games\Spring\maps
Scanning: C:\Users\Peti\Documents\My Games\Spring\games
Scanning: C:\Users\Peti\Documents\My Games\Spring\packages
Scanning: C:\Users\Peti\Documents\My Games\Spring\engine\95.0.1-151-ge073c88\base
[ThreadPool::SetThreadCount][1] #wanted=3 #current=4
[ThreadPool::SetThreadCount][2] #threads=2
[Threading] Main thread CPU affinity not set
[f=0000000] SDL version:  1.2.10
[f=0000000] GL version:   4.3.0
[f=0000000] GL vendor:    NVIDIA Corporation
[f=0000000] GL renderer:  GeForce GTX 560 Ti/PCIe/SSE2
[f=0000000] GLSL version: 4.30 NVIDIA via Cg compiler
[f=0000000] GLEW version: 1.5.8
[f=0000000] Video RAM:    total 1023MB, available 741MB
[f=0000000] FBO::maxSamples: 32
[f=0000000] GL info:
	haveARB: 1, haveGLSL: 1, ATI hacks: 0
	FBO support: 1, NPOT-texture support: 1, 24bit Z-buffer support: 1
	maximum texture size: 16384, compress MIP-map textures: 0
	maximum SmoothPointSize: 63, maximum vec4 varying/attributes: 31/16
	maximum drawbuffers: 8, maximum recommended indices/vertices: 1048576/1048576
	number of UniformBufferBindings: 84 (64kB)
[f=0000000] VSync disabled
[f=0000000] [Sound] OpenAL info:
[f=0000000] [Sound]   Available Devices:
[f=0000000] [Sound]               DirectSound Software
[f=0000000] [Sound]   Device:     DirectSound Software
[f=0000000] [Sound]   Vendor:         OpenAL Community
[f=0000000] [Sound]   Version:        1.1 ALSOFT 1.11.753
[f=0000000] [Sound]   Renderer:       OpenAL Soft
[f=0000000] [Sound]   AL Extensions:  AL_EXTX_buffer_sub_data AL_EXT_EXPONENT_DISTANCE AL_EXT_FLOAT32 AL_EXT_IMA4 AL_EXT_LINEAR_DISTANCE AL_EXT_MCFORMATS AL_EXT_OFFSET AL_EXTX_sample_buffer_object AL_EXT_source_distance_model AL_LOKI_quadriphonic
[f=0000000] [Sound]   ALC Extensions: ALC_ENUMERATE_ALL_EXT ALC_ENUMERATION_EXT ALC_EXT_CAPTURE ALC_EXT_disconnect ALC_EXT_EFX ALC_EXTX_thread_local_context
[f=0000000] [Sound]   EFX Enabled: yes
[f=0000000] [Sound]   Max Sounds: 128
[f=0000000] Joysticks found: 0
[f=0000000] Warning: Joystick 0 not found
[f=0000000] [Initialize] CPU Clock: win32::TimeGetTime
[f=0000000] [Initialize] CPU Cores: 4
[f=0000000] [Startup] loading startscript from: C:\Users\Peti\Documents\My Games\Spring\engine\95.0.1-151-ge073c88\script.txt
[f=0000000] Connecting to 192.168.1.108:8453 using name [teh]Beherith[PiRO]
[f=0000000] Using map: DeltaSiegeDry
[f=0000000] Using game: Balanced Annihilation V7.84
[f=0000000] Using game archive: 09d1b87af38a003cf01e4b8d19c35d9c.sdp
[f=0000000] recording demo: demos/20131203_114748_DeltaSiegeDry_95.0.1-151-ge073c88 develop.sdf
[f=0000000] PreGame::GameDataReceived: 22 ms
[f=0000000] [PreGame::UpdateClientNet] user number 0 (team 0, allyteam 1)
[f=0000000] Allowing pushing enemy units
[f=0000000] [LuaIntro] Searching for new Widgets
[f=0000000] [LuaIntro] Scanning: LuaIntro/Addons/
[f=0000000] [LuaIntro] Scanning: LuaIntro/Widgets/
[f=0000000] [LuaIntro] Scanning: LuaIntro/SystemAddons/
[f=0000000] [LuaIntro] Scanning: LuaIntro/SystemWidgets/
[f=0000000] [LuaIntro] Scanning: LuaIntro/chili/
[f=0000000] [LuaIntro] Found new widget "SpringLogo"
[f=0000000] [LuaIntro] Found new widget "LoadTexture"
[f=0000000] [LuaIntro] Found new widget "LoadProgress"
[f=0000000] [LuaIntro] Found new widget "Main"
[f=0000000] [LuaIntro] Found new widget "Music"
[f=0000000] [LuaIntro] Loading widgets   <>=vfs  **=raw  ()=unknown
[f=0000000] [LuaIntro] Loading widget:      LoadProgress           <loadprogress.lua>
[f=0000000] [LuaIntro] Loading widget:      Main                   <main.lua>
[f=0000000] [LuaIntro] Loading widget:      Music                  <music.lua>
[f=0000000] [LuaIntro] Loading widget:      LoadTexture            <bg_texture.lua>
[f=0000000] [LuaIntro] LuaIntro v1.0 (Lua 5.1)
[f=0000000] Parsing Map Information
[f=0000000] Loading SMF
[f=0000000] Loading Map (80 MB)
[f=0000000] Loading Radar Icons
[f=0000000] Loading GameData Definitions
[f=0000000] Loading all definitions:  0.159000
[f=0000000] Game::LoadDefs (GameData): 194 ms
[f=0000000] Loading Sound Definitions
[f=0000000] [Sound]  parsed 27 sounds from gamedata/sounds.lua
[f=0000000] [Sound] Error: Unable to open audio file: IncomingChat
[f=0000000] [Sound] Error: CSound::GetSoundId: could not find sound: IncomingChat
[f=0000000] Game::LoadDefs (Sound): 1 ms
[f=0000000] Creating Smooth Height Mesh
[f=0000000] SmoothHeightMesh::MakeSmoothMesh: 58 ms
[f=0000000] Creating QuadField & CEGs
[f=0000000] [CDamageArrayHandler] number of ArmorDefs: 11
[f=0000000] [UDPConnection::ProcessRawPacket] 0 NETMSG_*FRAME packets received (1232.999878ms)
[f=0000000] [RegisterAssimpModelFormats] supported Assimp model formats: *.3ds;*.blend;*.dae;*.lwo;
[f=0000000] Creating Unit Textures
[f=0000000] Creating Sky
[f=0000000] Loading Weapon Definitions
[f=0000000] Loading Unit Definitions
[f=0000000] Loading Feature Definitions
[f=0000000] Reading Estimate PathCosts [8]
[f=0000000] Reading Estimate PathCosts [32]
[f=0000000] [CPathManager] pathing data checksum: 1bcf8474
[f=0000000] [IPathManager::GetInstance] using DEFAULT path-manager
[f=0000000] Initializing Map Features
[f=0000000] Error: [LoadFeaturesFromMap] unknown map feature type ""
[f=0000000] Creating ShadowHandler & DecalHandler
[f=0000000] Creating GroundDrawer
[f=0000000] Loading Map Tiles
[f=0000000] [UDPConnection::ProcessRawPacket] 0 NETMSG_*FRAME packets received (1200.000000ms)
[f=0000000] [UDPConnection::ProcessRawPacket] 0 NETMSG_*FRAME packets received (1200.000000ms)
[f=0000000] Loading Square Textures
[f=0000000] CSMFGroundTextures::ConvolveHeightMap: 4 ms
[f=0000000] Switching to ROAM Mesh Rendering
[f=0000000] Creating TreeDrawer
[f=0000000] Creating ProjectileDrawer & UnitDrawer
[f=0000000] Creating Projectile Textures
[f=0000000] Warning: [CCEG::Load] krogtaarblaster: Unknown tag CSimpleParticleSystem::size
[f=0000000] Creating Water
[f=0000000] Game::LoadInterface (Camera&Mouse): 101 ms
[f=0000000] Game::LoadInterface (Console): 10 ms
[f=0000000] Loading LuaRules
[f=0000000] Loaded synced gadget:  Metalspot Finder Gadget  <mex_spot_finder.lua>
[f=0000000] Loaded synced gadget:  Rez Exp             <unit_rez_exp.lua>
[f=0000000] Loaded synced gadget:  ranks api           <api_ranks.lua>
[f=0000000] Loaded synced gadget:  No Self-D           <unit_prevent_share_selfd.lua>
[f=0000000] Loaded synced gadget:  CameraBroadcast     <camera_lockcamera.lua>
[f=0000000] Loaded synced gadget:  Awards              <gui_awards.lua>
[f=0000000] Loaded synced gadget:  Air Release         <unit_air_release_manager.lua>
[f=0000000] Loaded synced gadget:  AirPlantParents     <unit_air_plants.lua>
[f=0000000] Loaded synced gadget:  Bomber Control      <unit_bomber_control.lua>
[f=0000000] Loaded synced gadget:  Commando Watch      <unit_commando_watch.lua>
[f=0000000] Loaded synced gadget:  Cursor Broadcast    <cmd_mouse_pos_broadcast.lua>
[f=0000000] Loaded synced gadget:  DGun CmdType Fix    <unit_dgun_cmdtype_fix.lua>
[f=0000000] Loaded synced gadget:  Death Messages      <game_death_messages.lua>
[f=0000000] Loaded synced gadget:  DirectControl       <unit_direct_control.lua>
[f=0000000] Loaded synced gadget:  DragonsDisguise     <unit_set_neutral.lua>
[f=0000000] Loaded synced gadget:  Dynamic collision volume & Hitsphere Scaledown  <unit_dynamic_collision_volume.lua>
[f=0000000] Loaded synced gadget:  Energy Conversion   <game_energy_conversion.lua>
[f=0000000] Loaded synced gadget:  FinishedBuilding    <unit_finished_building.lua>
[f=0000000] Loaded synced gadget:  Game End            <game_end.lua>
[f=0000000] Loaded synced gadget:  Initial Spawn       <game_initial_spawn.lua>
[f=0000000] Loaded synced gadget:  Juno Damage         <unit_juno_damage.lua>
[f=0000000] Loaded synced gadget:  Lightning Spash Damage  <unit_lightning_splash_dmg.lua>
[f=0000000] Loaded synced gadget:  Lua unit script framework  <unit_script.lua>
[f=0000000] Loaded synced gadget:  Maverick Exp        <unit_maverick_exp.lua>
[f=0000000] Loaded synced gadget:  Merc/Scr stockpile control  <unit_mercscr_stockpile_limit.lua>
[f=0000000] Loaded synced gadget:  Napalm              <lups_napalm.lua>
[f=0000000] Loaded synced gadget:  No Land Damage      <unit_no_land_damage.lua>
[f=0000000] Loaded synced gadget:  No Self Pwn         <unit_noselfpwn.lua>
[f=0000000] Loaded synced gadget:  NoCost              <cmd_nocost.lua>
[f=0000000] Loaded synced gadget:  Nonblocking mines   <unit_nonblocking_mines.lua>
[f=0000000] Loaded synced gadget:  Paralyse Multiplier  <unit_paralyze_multiplier.lua>
[f=0000000] Loaded synced gadget:  Passive Builders II  <unit_passive_builders_ii.lua>
[f=0000000] Loaded synced gadget:  PopUpWaterStructures  <unit_pop_up_water_structures.lua>
[f=0000000] Loaded synced gadget:  Prevent Excessive Share  <game_prevent_excessive_share.lua>
[f=0000000] Loaded synced gadget:  Prevent Lab Hax     <unit_prevent_lab_hax.lua>
[f=0000000] Loaded synced gadget:  Prevent Load Hax    <unit_prevent_load_hax.lua>
[f=0000000] Loaded synced gadget:  Prevent Outside Aircraft hacks  <unit_prevent_aircraft_hax.lua>
[f=0000000] Loaded synced gadget:  Prevent Range Hax   <unit_prevent_range_hax.lua>
[f=0000000] Loaded synced gadget:  Prevent Strange Orders  <unit_prevent_strange_orders.lua>
[f=0000000] Loaded synced gadget:  Prevent Unload Hax  <unit_prevent_unload_hax.lua>
[f=0000000] Loaded synced gadget:  Reclaim Fix         <unit_reclaim_fix.lua>
[f=0000000] Loaded synced gadget:  Reclaim flash       <gfx_reclaim_flash.lua>
[f=0000000] Loaded synced gadget:  ShieldDrain         <unit_shield_watch.lua>
[f=0000000] Loaded synced gadget:  Shockwaves          <lups_shockwaves.lua>
[f=0000000] Loaded synced gadget:  Start Point Remover Gadget  <init_start_point_remover_gadget.lua>
[f=0000000] Loaded synced gadget:  Stealthy Passengers  <unit_stealthy_passengers.lua>
[f=0000000] Loaded synced gadget:  Target on the move  <unit_target_on_the_move.lua>
[f=0000000] Loaded synced gadget:  Team Resourcing     <game_team_resources.lua>
[f=0000000] Loaded synced gadget:  Transportee Hider   <unit_transportee_hider.lua>
[f=0000000] Loaded synced gadget:  Unit transportable nanos  <unit_transportable_nanos.lua>
[f=0000000] Loaded synced gadget:  Watereffects        <fx_watersplash.lua>
[f=0000000] Loaded synced gadget:  fx_reclaim_shards   <fx_reclaim_shards.lua>
[f=0000000] Loaded synced gadget:  fx_wreck_shards     <fx_wreck_shards.lua>
[f=0000000] Loaded synced gadget:  gfx_dynamic_lighting.lua  <gfx_dynamic_lighting.lua>
[f=0000000] Loaded synced gadget:  lups_wrapper.lua    <lups_wrapper.lua>
[f=0000000] Loaded synced gadget:  mo_combomb_full_damage  <mo_combomb_full_damage.lua>
[f=0000000] Loaded synced gadget:  mo_enemywrecks      <mo_enemywrecks.lua>
[f=0000000] Loaded synced gadget:  mo_noshare          <mo_noshare.lua>
[f=0000000] Loaded synced gadget:  transportfix        <unit_transportfix.lua>
[f=0000000] Loaded synced gadget:  Area Attack         <areaattack.lua>
[f=0000000] Loaded synced gadget:  C Is For Control    <comiscontrol.lua>
[f=0000000] Loaded synced gadget:  Coop II             <mo_coop_ii.lua>
[f=0000000] Loaded synced gadget:  CustomUnitShaders   <gfx_customunitshaders.lua>
[f=0000000] Loaded synced gadget:  Take Manager        <cmd_idle_players.lua>
[f=0000000] Loaded synced gadget:  Team Com Ends       <teamcomends.lua>
[f=0000000] Loaded synced gadget:  LupsSyncedManager   <lups_manager.lua>
[f=0000000] Loaded synced gadget:  Mex Upgrader Gadget  <unit_mex_upgrader.lua>
[f=0000000] Loaded synced gadget:  Crashing Aircraft   <unit_crashing_aircraft.lua>
[f=0000000] <LockCamera>: Sorry for the camera switch spam, but this is the only reliable way to list camera states other than hardcoding them
[f=0000000] Switching to Overview style camera
[f=0000000] Switching to Smooth style camera
[f=0000000] Switching to Overhead (TA) style camera
[f=0000000] Switching to Free style camera
[f=0000000] Switching to Total War style camera
[f=0000000] Switching to Rotatable overhead camera
[f=0000000] Switching to Orbit style camera
[f=0000000] Switching to FPS style camera
[f=0000000] Switching to Smooth style camera
[f=0000000] Loaded unsynced gadget:  Engine Taskbar Stuff  <engine_taskbar_stuff.lua>
[f=0000000] [UDPConnection::ProcessRawPacket] 0 NETMSG_*FRAME packets received (1200.999878ms)
[f=0000000] Loaded unsynced gadget:  Metalspot Finder Gadget  <mex_spot_finder.lua>
[f=0000000] Loaded unsynced gadget:  ranks api           <api_ranks.lua>
[f=0000000] Loaded unsynced gadget:  CustomIcons         <unit_customicons.lua>
[f=0000000] Loaded unsynced gadget:  CameraBroadcast     <camera_lockcamera.lua>
[f=0000000] Loaded unsynced gadget:  Awards              <gui_awards.lua>
[f=0000000] Loaded unsynced gadget:  Air Release         <unit_air_release_manager.lua>
[f=0000000] Loaded unsynced gadget:  AirPlantParents     <unit_air_plants.lua>
[f=0000000] Loaded unsynced gadget:  Cursor Broadcast    <cmd_mouse_pos_broadcast.lua>
[f=0000000] Loaded unsynced gadget:  DragonsDisguise     <unit_set_neutral.lua>
[f=0000000] Loaded unsynced gadget:  Dynamic collision volume & Hitsphere Scaledown  <unit_dynamic_collision_volume.lua>
[f=0000000] Loaded unsynced gadget:  FinishedBuilding    <unit_finished_building.lua>
[f=0000000] Loaded unsynced gadget:  Initial Spawn       <game_initial_spawn.lua>
[f=0000000] Loaded unsynced gadget:  Juno Damage         <unit_juno_damage.lua>
[f=0000000] Loaded unsynced gadget:  Merc/Scr stockpile control  <unit_mercscr_stockpile_limit.lua>
[f=0000000] Loaded unsynced gadget:  Napalm              <lups_napalm.lua>
[f=0000000] Loaded unsynced gadget:  NoCost              <cmd_nocost.lua>
[f=0000000] Loaded unsynced gadget:  PopUpWaterStructures  <unit_pop_up_water_structures.lua>
[f=0000000] Loaded unsynced gadget:  Prevent Unload Hax  <unit_prevent_unload_hax.lua>
[f=0000000] Loaded unsynced gadget:  Reclaim Fix         <unit_reclaim_fix.lua>
[f=0000000] Loaded unsynced gadget:  Reclaim flash       <gfx_reclaim_flash.lua>
[f=0000000] Loaded unsynced gadget:  ShieldDrain         <unit_shield_watch.lua>
[f=0000000] Loaded unsynced gadget:  Shockwaves          <lups_shockwaves.lua>
[f=0000000] Loaded unsynced gadget:  Start Point Remover Gadget  <init_start_point_remover_gadget.lua>
[f=0000000] Loaded unsynced gadget:  Target on the move  <unit_target_on_the_move.lua>
[f=0000000] Loaded unsynced gadget:  Transportee Hider   <unit_transportee_hider.lua>
[f=0000000] Loaded unsynced gadget:  Watereffects        <fx_watersplash.lua>
[f=0000000] Loaded unsynced gadget:  fx_reclaim_shards   <fx_reclaim_shards.lua>
[f=0000000] Loaded unsynced gadget:  fx_wreck_shards     <fx_wreck_shards.lua>
[f=0000000] Loaded unsynced gadget:  gfx_dynamic_lighting.lua  <gfx_dynamic_lighting.lua>
[f=0000000] Loaded unsynced gadget:  mo_enemywrecks      <mo_enemywrecks.lua>
[f=0000000] Loaded unsynced gadget:  mo_greenfields      <mo_greenfields.lua>
[f=0000000] Loaded unsynced gadget:  mo_noowner          <mo_noowner.lua>
[f=0000000] Loaded unsynced gadget:  mo_noshare          <mo_noshare.lua>
[f=0000000] Loaded unsynced gadget:  mo_nowrecks         <mo_nowrecks.lua>
[f=0000000] Loaded unsynced gadget:  transportfix        <unit_transportfix.lua>
[f=0000000] Loaded unsynced gadget:  Area Attack         <areaattack.lua>
[f=0000000] Loaded unsynced gadget:  C Is For Control    <comiscontrol.lua>
[f=0000000] Loaded unsynced gadget:  Coop II             <mo_coop_ii.lua>
[f=0000000] Loaded unsynced gadget:  CustomUnitShaders   <gfx_customunitshaders.lua>
[f=0000000] Loaded unsynced gadget:  Take Manager        <cmd_idle_players.lua>
[f=0000000] Loaded unsynced gadget:  LupsSyncedManager   <lups_manager.lua>
[f=0000000] Loaded unsynced gadget:  Mex Upgrader Gadget  <unit_mex_upgrader.lua>
[f=0000000] Loaded unsynced gadget:  Crashing Aircraft   <unit_crashing_aircraft.lua>
[f=0000000] Loaded unsynced gadget:  Lups                <lups_wrapper.lua>
[f=0000000] Loading LuaGaia
[f=0000000] Loading LuaUI
[f=0000000] LuaSocketEnabled: yes
[f=0000000] This game has locked LuaUI access
[f=0000000] This game has locked LuaUI access
[f=0000000] Using LUAUI_DIRNAME = LuaUI/
[f=0000000] Reloaded ctrlpanel from file: LuaUI/ctrlpanel.txt
[f=0000000] LuaUI: bound F11 to the widget selector
[f=0000000] LuaUI: bound CTRL+F11 to tweak mode
[f=0000000] Loading widget from mod:   Red_UI_Framework    <red_ui_framework.lua> ...
[f=0000000] Loading widget from mod:   Metalspot Finder    <wg_metalspot_finder.lua> ...
[f=0000000] Loading widget from mod:   Faction Change      <gui_faction_change.lua> ...
[f=0000000] Loading widget from mod:   MexUpg Helper       <cmd_mex_upgrade_helper.lua> ...
[f=0000000] Loading widget from mod:   Red Tooltip         <gui_red_tooltip.lua> ...
[f=0000000] Loading widget from mod:   HealthBars          <unit_healthbars.lua> ...
[f=0000000] Loading widget from mod:   LockCamera          <camera_lockcamera.lua> ...
[f=0000000] Loading widget from mod:   AdvPlayersList      <gui_advplayerslist.lua> ...
[f=0000000] Loading widget from mod:   BuildETA            <gui_build_eta.lua> ...
[f=0000000] Loading widget from mod:   Projectile lights   <gfx_projectile_lights.lua> ...
[f=0000000] Loading widget from mod:   Initial Queue       <unit_initial_queue.lua> ...
[f=0000000] Loading widget from mod:   Anti Range          <gui_anti_range.lua> ...
[f=0000000] Loading widget from mod:   Auto First Build Facing  <autofirstbuildfacing.lua> ...
[f=0000000] Loading widget from mod:   Auto group          <unit_auto_group.lua> ...
[f=0000000] Loading widget from mod:   Autoquit            <autoquit.lua> ...
[f=0000000] Loading widget from mod:   BA_AllyCursors      <gui_ba_ally_cursors.lua> ...
[f=0000000] Loading widget from mod:   Build Split         <cmd_buildsplit.lua> ...
[f=0000000] Loading widget from mod:   BuildBar            <gui_buildbar.lua> ...
[f=0000000] Loading widget from mod:   CameraFlip          <camera_flip.lua> ...
[f=0000000] Loading widget from mod:   Com DontBreakCloak  <unit_com_dontbreakcloak.lua> ...
[f=0000000] Loading widget from mod:   Com Counter         <gui_comcounter.lua> ...
[f=0000000] Loading widget from mod:   Defense Range       <gui_defenserange.lua> ...
[f=0000000] Loading widget from mod:   DontMove            <unit_dontmove.lua> ...
[f=0000000] Loading widget from mod:   Easy Facing         <gui_easyfacing.lua> ...
[f=0000000] Loading widget from mod:   Energy Conversion Info  <gui_energy_conversion.lua> ...
[f=0000000] Loading widget from mod:   Ghost Radar         <unit_ghostradar.lua> ...
[f=0000000] Loading widget from mod:   Ghost Site          <unit_ghostsite.lua> ...
[f=0000000] Loading widget from mod:   Group Label         <gui_group_label.lua> ...
[f=0000000] Loading widget from mod:   GameTypeInfo        <gui_game_type_info.lua> ...
[f=0000000] Loading widget from mod:   Highlight Geos      <gui_highlight_geos.lua> ...
[f=0000000] Loading widget from mod:   Holdfire Fix        <unit_holdfire_fix.lua> ...
[f=0000000] Loading widget from mod:   Load Own Moving     <unit_load_own_moving.lua> ...
[f=0000000] Loading widget from mod:   Loop Select         <unit_loop_select.lua> ...
[f=0000000] Loading widget from mod:   Mex Snap            <cmd_mex_snap.lua> ...
[f=0000000] Loading widget from mod:   MoreSounds          <unit_more_sounds.lua> ...
[f=0000000] Loading widget from mod:   NoDuplicateOrders   <cmd_no_duplicate_orders.lua> ...
[f=0000000] Loading widget from mod:   ImmobileBuilder     <unit_immobile_builder.lua> ...
[f=0000000] Loading widget from mod:   Pause Screen        <gui_pausescreen.lua> ...
[f=0000000] Loading widget from mod:   Persistent Build Spacing  <gui_persistent_build_spacing.lua> ...
[f=0000000] Loading widget from mod:   Point Tracker       <gui_point_tracker.lua> ...
[f=0000000] Loading widget from mod:   ReclaimInfo         <gui_reclaiminfo.lua> ...
[f=0000000] Loading widget from mod:   Red Build/Order Menu  <gui_red_buildordermenu.lua> ...
[f=0000000] Loading widget from mod:   Red Console         <gui_red_console.lua> ...
[f=0000000] Loading widget from mod:   Red Resource Bars   <gui_red_resourcebars.lua> ...
[f=0000000] Loading widget from mod:   Red_Drawing         <red_ui_framework_drawing.lua> ...
[f=0000000] Loading widget from mod:   RelativeMinimap     <minimap_relative.lua> ...
[f=0000000] Loading widget from mod:   SelectionButtons    <gui_selbuttons.lua> ...
[f=0000000] Loading widget from mod:   Share Tracker       <unit_share_tracker.lua> ...
[f=0000000] Loading widget from mod:   SmoothCam           <camera_smoothcam.lua> ...
[f=0000000] Loading widget from mod:   Spectate Selected   <gui_spectate_selected.lua> ...
[f=0000000] Loading widget from mod:   State Reverse Toggle  <cmd_state_reverse_toggle.lua> ...
[f=0000000] Loading widget from mod:   Take Proxy          <cmd_take_proxy.lua> ...
[f=0000000] Loading widget from mod:   Transport AI        <unit_transport_ai.lua> ...
[f=0000000] Loading widget from mod:   Volume OSD          <snd_volume_osd.lua> ...
[f=0000000] Loading widget from mod:   Wait reclaim        <cmd_wait_reclaim.lua> ...
[f=0000000] Loading widget from mod:   Specific Unit Reclaimer  <unit_specific_unit_reclaimer.lua> ...
[f=0000000] Loading widget from mod:   Stockpiler (dynamic)  <unit_stockpile_dynamic.lua> ...
[f=0000000] Loading widget from mod:   Attack AoE          <gui_attack_aoe.lua> ...
[f=0000000] Loading widget from mod:   Attack and Move Notification  <unit_attackmovenotification.lua> ...
[f=0000000] Loading widget from mod:   Building Hotkeys    <cmd_building_hotkeys.lua> ...
[f=0000000] Loading widget from mod:   Context Build       <cmd_context_build.lua> ...
[f=0000000] Loading widget from mod:   Prospector          <gui_prospector.lua> ...
[f=0000000] Loading widget from mod:   Red Minimap         <gui_red_minimap.lua> ...
[f=0000000] Loading widget from mod:   Set Target Hotkeys  <cmd_target_on_the_move_hotkeys.lua> ...
[f=0000000] Loading widget from mod:   BA Waypoint Dragger  <unit_waypoint_dragger_2.lua> ...
[f=0000000] Loading widget from mod:   Bomber control      <unit_bomber_control.lua> ...
[f=0000000] Loading widget from mod:   CommandInsert       <gui_commandinsert.lua> ...
[f=0000000] Loading widget from mod:   Rank Icons          <gui_xp.lua> ...
[f=0000000] Loading widget from mod:   Select n Center!    <gui_center_n_select.lua> ...
[f=0000000] Loading widget from mod:   LupsManager         <gfx_lups_manager.lua> ...
[f=0000000] Loading widget from mod:   Mouse Buildspacing  <gui_buildspacing.lua> ...
[f=0000000] Loading widget from mod:   Lups                <lups_wrapper.lua> ...
[f=0000000] Loading widget from mod:   CustomFormations2   <unit_customformations2.lua> ...
[f=0000000] Loading widget from user:  Frame jitter        <dbg_frame_jitter.lua> ...
[f=0000000] LuaUI v0.3
[f=0000000] Initializing PathCache
[f=0000000] Finalizing
[f=0000000] Loaded DecalsDrawer: Legacy
[f=0000000] Connection attempt from [teh]Beherith[PiRO]2
[f=0000000]  -> Version: 95.0.1-151-ge073c88 develop
[f=0000000]  -> Connection established (given id 1)
[f=0000000] Connection attempt from [teh]Beherith[PiRO]
[f=0000000]  -> Version: 95.0.1-151-ge073c88 develop
[f=0000000]  -> Connection established (given id 0)
[f=0000000] [UDPConnection::ProcessRawPacket] 0 NETMSG_*FRAME packets received (1016.000000ms)
[f=0000000] [UDPConnection::ProcessRawPacket] 0 NETMSG_*FRAME packets received (1055.000000ms)
[f=0000000] [UDPConnection::ProcessRawPacket] 0 NETMSG_*FRAME packets received (1034.000000ms)
[f=0000000] [UDPConnection::ProcessRawPacket] 0 NETMSG_*FRAME packets received (1167.000122ms)
[f=0000000] GameID: e2b69d52b4348fdcaaa6130797174d8b
[f=0000002] [UDPConnection::ProcessRawPacket] 4 NETMSG_*FRAME packets received (1029.000000ms)
[f=0000006] gameframe, 6, delta time, 0.15699999034405, percent bad frames=, 16.666666030884
[f=0000010] gameframe, 10, delta time, 0.076999999582767, percent bad frames=, 20
[f=0000024] gameframe, 24, delta time, 0.063000001013279, percent bad frames=, 12.5
[f=0000031] [UDPConnection::ProcessRawPacket] 30 NETMSG_*FRAME packets received (1030.000000ms)
[f=0000035] gameframe, 35, delta time, 0.085999995470047, percent bad frames=, 11.42857170105
[f=0000049] gameframe, 49, delta time, 0.050999999046326, percent bad frames=, 10.204081535339
[f=0000053] gameframe, 53, delta time, 0.10399999469519, percent bad frames=, 11.320755004883
[f=0000062] [UDPConnection::ProcessRawPacket] 32 NETMSG_*FRAME packets received (1054.000000ms)
[f=0000082] gameframe, 82, delta time, 0.058999996632338, percent bad frames=, 8.5365858078003
[f=0000087] gameframe, 87, delta time, 0.058999996632338, percent bad frames=, 9.1954021453857
[f=0000091] gameframe, 91, delta time, 0.070000000298023, percent bad frames=, 9.8901100158691
[f=0000092] [UDPConnection::ProcessRawPacket] 30 NETMSG_*FRAME packets received (1001.000000ms)
[f=0000123] [UDPConnection::ProcessRawPacket] 32 NETMSG_*FRAME packets received (1051.000000ms)
[f=0000124] gameframe, 124, delta time, 0.06700000166893, percent bad frames=, 8.0645160675049
[f=0000134] gameframe, 134, delta time, 0.05799999833107, percent bad frames=, 8.2089548110962
[f=0000144] gameframe, 144, delta time, 0.059999998658895, percent bad frames=, 8.3333330154419
[f=0000148] gameframe, 148, delta time, 0.092000000178814, percent bad frames=, 8.7837839126587
[f=0000153] gameframe, 153, delta time, 0.054999999701977, percent bad frames=, 9.1503267288208
[f=0000156] [UDPConnection::ProcessRawPacket] 32 NETMSG_*FRAME packets received (1078.000000ms)
[f=0000161] gameframe, 161, delta time, 0.071999996900558, percent bad frames=, 9.3167705535889
[f=0000170] gameframe, 170, delta time, 0.063999995589256, percent bad frames=, 9.4117650985718
[f=0000185] gameframe, 185, delta time, 0.079999998211861, percent bad frames=, 9.1891889572144
[f=0000188] [UDPConnection::ProcessRawPacket] 32 NETMSG_*FRAME packets received (1071.000000ms)
[f=0000193] gameframe, 193, delta time, 0.052999999374151, percent bad frames=, 9.3264245986938
[f=0000197] gameframe, 197, delta time, 0.07599999755621, percent bad frames=, 9.6446704864502
[f=0000203] gameframe, 203, delta time, 0.071999996900558, percent bad frames=, 9.8522167205811
[f=0000217] gameframe, 217, delta time, 0.065999999642372, percent bad frames=, 9.6774196624756
[f=0000221] [UDPConnection::ProcessRawPacket] 33 NETMSG_*FRAME packets received (1083.000122ms)
[f=0000235] gameframe, 235, delta time, 0.076999999582767, percent bad frames=, 9.361701965332
[f=0000246] gameframe, 246, delta time, 0.061999998986721, percent bad frames=, 9.3495931625366
[f=0000252] [UDPConnection::ProcessRawPacket] 31 NETMSG_*FRAME packets received (1034.000000ms)
[f=0000262] gameframe, 262, delta time, 0.079999998211861, percent bad frames=, 9.1603050231934
[f=0000284] [UDPConnection::ProcessRawPacket] 32 NETMSG_*FRAME packets received (1082.000000ms)
[f=0000295] gameframe, 295, delta time, 0.071999996900558, percent bad frames=, 8.4745759963989
[f=0000307] gameframe, 307, delta time, 0.058999996632338, percent bad frames=, 8.4690551757813
[f=0000312] gameframe, 312, delta time, 0.05799999833107, percent bad frames=, 8.6538457870483
[f=0000316] [UDPConnection::ProcessRawPacket] 32 NETMSG_*FRAME packets received (1069.000000ms)
[f=0000317] gameframe, 317, delta time, 0.051999997347593, percent bad frames=, 8.8328075408936
[f=0000325] gameframe, 325, delta time, 0.10199999809265, percent bad frames=, 8.9230766296387
[f=0000334] gameframe, 334, delta time, 0.057000000029802, percent bad frames=, 8.9820356369019
[f=0000338] gameframe, 338, delta time, 0.050999999046326, percent bad frames=, 9.1715974807739
[f=0000343] gameframe, 343, delta time, 0.054999999701977, percent bad frames=, 9.3294458389282
[f=0000346] [UDPConnection::ProcessRawPacket] 31 NETMSG_*FRAME packets received (1030.000000ms)
[f=0000347] gameframe, 347, delta time, 0.076999999582767, percent bad frames=, 9.5100860595703
[f=0000353] gameframe, 353, delta time, 0.07599999755621, percent bad frames=, 9.6317281723022
[f=0000380] [UDPConnection::ProcessRawPacket] 34 NETMSG_*FRAME packets received (1119.000122ms)
[f=0000401] gameframe, 401, delta time, 0.067999996244907, percent bad frames=, 8.7281799316406
[f=0000410] gameframe, 410, delta time, 0.071999996900558, percent bad frames=, 8.7804880142212
[f=0000414] [UDPConnection::ProcessRawPacket] 33 NETMSG_*FRAME packets received (1099.000122ms)
[f=0000426] gameframe, 426, delta time, 0.078999996185303, percent bad frames=, 8.6854457855225
[f=0000433] gameframe, 433, delta time, 0.067999996244907, percent bad frames=, 8.7759819030762
[f=0000446] [UDPConnection::ProcessRawPacket] 31 NETMSG_*FRAME packets received (1067.000000ms)
[f=0000450] gameframe, 450, delta time, 0.077999994158745, percent bad frames=, 8.6666669845581
[f=0000475] gameframe, 475, delta time, 0.054999999701977, percent bad frames=, 8.4210529327393
[f=0000477] [UDPConnection::ProcessRawPacket] 31 NETMSG_*FRAME packets received (1020.000000ms)
[f=0000485] gameframe, 485, delta time, 0.059999998658895, percent bad frames=, 8.4536085128784
[f=0000489] gameframe, 489, delta time, 0.082999996840954, percent bad frames=, 8.5889568328857
[f=0000506] gameframe, 506, delta time, 0.083999998867512, percent bad frames=, 8.4980239868164
[f=0000510] [UDPConnection::ProcessRawPacket] 33 NETMSG_*FRAME packets received (1110.000000ms)
[f=0000514] gameframe, 514, delta time, 0.07599999755621, percent bad frames=, 8.5603113174438
[f=0000536] gameframe, 536, delta time, 0.053999997675419, percent bad frames=, 8.3955221176147
[f=0000541] [UDPConnection::ProcessRawPacket] 31 NETMSG_*FRAME packets received (1024.000000ms)
[f=0000545] gameframe, 545, delta time, 0.077999994158745, percent bad frames=, 8.4403667449951
[f=0000550] gameframe, 550, delta time, 0.054999999701977, percent bad frames=, 8.5454549789429
[f=0000554] gameframe, 554, delta time, 0.081999994814396, percent bad frames=, 8.6642599105835
[f=0000571] [UDPConnection::ProcessRawPacket] 32 NETMSG_*FRAME packets received (1045.000000ms)
[f=0000578] gameframe, 578, delta time, 0.06700000166893, percent bad frames=, 8.4775085449219
[f=0000583] gameframe, 583, delta time, 0.051999997347593, percent bad frames=, 8.5763292312622
[f=0000604] [UDPConnection::ProcessRawPacket] 32 NETMSG_*FRAME packets received (1074.000000ms)
[f=0000626] gameframe, 626, delta time, 0.083999998867512, percent bad frames=, 8.1469650268555
[f=0000634] [UDPConnection::ProcessRawPacket] 31 NETMSG_*FRAME packets received (1040.000000ms)
[f=0000635] gameframe, 635, delta time, 0.071999996900558, percent bad frames=, 8.1889762878418
[f=0000664] gameframe, 664, delta time, 0.064999997615814, percent bad frames=, 7.9819278717041
[f=0000668] [UDPConnection::ProcessRawPacket] 33 NETMSG_*FRAME packets received (1096.000000ms)
[f=0000699] [UDPConnection::ProcessRawPacket] 32 NETMSG_*FRAME packets received (1057.000000ms)
[f=0000709] gameframe, 709, delta time, 0.054999999701977, percent bad frames=, 7.6163611412048
[f=0000714] gameframe, 714, delta time, 0.072999998927116, percent bad frames=, 7.7030811309814
[f=0000729] [UDPConnection::ProcessRawPacket] 30 NETMSG_*FRAME packets received (1013.000000ms)
[f=0000730] gameframe, 730, delta time, 0.053999997675419, percent bad frames=, 7.6712327003479
[f=0000764] [UDPConnection::ProcessRawPacket] 34 NETMSG_*FRAME packets received (1120.000000ms)
[f=0000773] gameframe, 773, delta time, 0.050999999046326, percent bad frames=, 7.3738679885864
[f=0000795] [UDPConnection::ProcessRawPacket] 32 NETMSG_*FRAME packets received (1069.000000ms)
[f=0000827] [UDPConnection::ProcessRawPacket] 31 NETMSG_*FRAME packets received (1048.000000ms)
[f=0000836] gameframe, 836, delta time, 0.065999999642372, percent bad frames=, 6.9377989768982
[f=0000845] gameframe, 845, delta time, 0.060999996960163, percent bad frames=, 6.9822483062744
[f=0000849] gameframe, 849, delta time, 0.083999998867512, percent bad frames=, 7.0671377182007
[f=0000857] [UDPConnection::ProcessRawPacket] 30 NETMSG_*FRAME packets received (1008.000000ms)
[f=0000868] gameframe, 868, delta time, 0.11499999463558, percent bad frames=, 7.0276498794556
[f=0000881] gameframe, 881, delta time, 0.063999995589256, percent bad frames=, 7.0374574661255
[f=0000886] gameframe, 886, delta time, 0.05799999833107, percent bad frames=, 7.1106095314026
[f=0000890] [UDPConnection::ProcessRawPacket] 33 NETMSG_*FRAME packets received (1108.999878ms)
[f=0000891] gameframe, 891, delta time, 0.059999998658895, percent bad frames=, 7.1829404830933
[f=0000904] gameframe, 904, delta time, 0.092999994754791, percent bad frames=, 7.1902656555176
[f=0000917] gameframe, 917, delta time, 0.074999995529652, percent bad frames=, 7.1973829269409
[f=0000922] [UDPConnection::ProcessRawPacket] 33 NETMSG_*FRAME packets received (1071.000000ms)
[f=0000931] gameframe, 931, delta time, 0.082999996840954, percent bad frames=, 7.1965627670288
[f=0000953] [UDPConnection::ProcessRawPacket] 31 NETMSG_*FRAME packets received (1029.000000ms)
[f=0000954] gameframe, 954, delta time, 0.054999999701977, percent bad frames=, 7.1278824806213
[f=0000965] gameframe, 965, delta time, 0.057000000029802, percent bad frames=, 7.1502590179443
[f=0000970] gameframe, 970, delta time, 0.053999997675419, percent bad frames=, 7.2164950370789
[f=0000977] gameframe, 977, delta time, 0.06700000166893, percent bad frames=, 7.267144203186
[f=0000983] gameframe, 983, delta time, 0.061999998986721, percent bad frames=, 7.3245167732239
[f=0000987] gameframe, 987, delta time, 0.058999996632338, percent bad frames=, 7.3961501121521
[f=0000987] [UDPConnection::ProcessRawPacket] 33 NETMSG_*FRAME packets received (1128.000000ms)
[f=0000996] gameframe, 996, delta time, 0.060999996960163, percent bad frames=, 7.4297189712524
[f=0001001] gameframe, 1001, delta time, 0.052999999374151, percent bad frames=, 7.4925074577332
[f=0001009] gameframe, 1009, delta time, 0.067999996244907, percent bad frames=, 7.5322098731995
[f=0001015] gameframe, 1015, delta time, 0.089999996125698, percent bad frames=, 7.5862069129944
[f=0001020] [UDPConnection::ProcessRawPacket] 32 NETMSG_*FRAME packets received (1071.000000ms)
[f=0001028] gameframe, 1028, delta time, 0.12399999797344, percent bad frames=, 7.5875487327576
[f=0001051] [UDPConnection::ProcessRawPacket] 33 NETMSG_*FRAME packets received (1122.000000ms)
[f=0001052] gameframe, 1052, delta time, 0.092000000178814, percent bad frames=, 7.5095057487488
[f=0001066] gameframe, 1066, delta time, 0.052999999374151, percent bad frames=, 7.5046906471252
[f=0001074] gameframe, 1074, delta time, 0.071999996900558, percent bad frames=, 7.5418992042542
[f=0001081] gameframe, 1081, delta time, 0.055999998003244, percent bad frames=, 7.5855689048767
[f=0001084] [UDPConnection::ProcessRawPacket] 32 NETMSG_*FRAME packets received (1029.000000ms)
[f=0001106] gameframe, 1106, delta time, 0.13799999654293, percent bad frames=, 7.5045208930969
[f=0001114] [UDPConnection::ProcessRawPacket] 31 NETMSG_*FRAME packets received (1036.000000ms)
[f=0001147] [UDPConnection::ProcessRawPacket] 33 NETMSG_*FRAME packets received (1080.000000ms)
[f=0001163] gameframe, 1163, delta time, 0.068999998271465, percent bad frames=, 7.2227001190186
[f=0001176] gameframe, 1176, delta time, 0.060999996960163, percent bad frames=, 7.2278909683228
[f=0001180] [UDPConnection::ProcessRawPacket] 32 NETMSG_*FRAME packets received (1070.000000ms)
[f=0001189] gameframe, 1189, delta time, 0.061999998986721, percent bad frames=, 7.2329688072205
[f=0001205] gameframe, 1205, delta time, 0.058999996632338, percent bad frames=, 7.2199168205261
[f=0001209] [UDPConnection::ProcessRawPacket] 29 NETMSG_*FRAME packets received (1068.000000ms)
[f=0001210] gameframe, 1210, delta time, 0.1330000013113, percent bad frames=, 7.2727274894714
[f=0001238] gameframe, 1238, delta time, 0.14399999380112, percent bad frames=, 7.1890144348145
[f=0001241] [UDPConnection::ProcessRawPacket] 33 NETMSG_*FRAME packets received (1033.000000ms)
[f=0001266] gameframe, 1266, delta time, 0.12600000202656, percent bad frames=, 7.1090049743652
[f=0001274] [UDPConnection::ProcessRawPacket] 34 NETMSG_*FRAME packets received (1098.000000ms)
[f=0001303] gameframe, 1303, delta time, 0.077999994158745, percent bad frames=, 6.9838833808899
[f=0001307] [UDPConnection::ProcessRawPacket] 31 NETMSG_*FRAME packets received (1064.000000ms)
[f=0001308] gameframe, 1308, delta time, 0.053999997675419, percent bad frames=, 7.0336389541626
[f=0001313] gameframe, 1313, delta time, 0.083999998867512, percent bad frames=, 7.0830159187317
[f=0001337] [UDPConnection::ProcessRawPacket] 30 NETMSG_*FRAME packets received (1001.000000ms)
[f=0001350] gameframe, 1350, delta time, 0.071999996900558, percent bad frames=, 6.962963104248
[f=0001368] gameframe, 1368, delta time, 0.051999997347593, percent bad frames=, 6.9444446563721
[f=0001371] [UDPConnection::ProcessRawPacket] 33 NETMSG_*FRAME packets received (1087.000122ms)
[f=0001386] gameframe, 1386, delta time, 0.071999996900558, percent bad frames=, 6.9264068603516
[f=0001402] [UDPConnection::ProcessRawPacket] 32 NETMSG_*FRAME packets received (1078.000000ms)
[f=0001412] gameframe, 1412, delta time, 0.071999996900558, percent bad frames=, 6.8696885108948
[f=0001427] gameframe, 1427, delta time, 0.067999996244907, percent bad frames=, 6.8675541877747
[f=0001436] [UDPConnection::ProcessRawPacket] 34 NETMSG_*FRAME packets received (1104.999878ms)
[f=0001447] gameframe, 1447, delta time, 0.087999999523163, percent bad frames=, 6.8417415618896
[f=0001452] gameframe, 1452, delta time, 0.051999997347593, percent bad frames=, 6.8870525360107
[f=0001463] gameframe, 1463, delta time, 0.057000000029802, percent bad frames=, 6.9036226272583
[f=0001466] [UDPConnection::ProcessRawPacket] 31 NETMSG_*FRAME packets received (1048.000000ms)
[f=0001467] gameframe, 1467, delta time, 0.11199999600649, percent bad frames=, 6.952965259552
[f=0001492] gameframe, 1492, delta time, 0.059999998658895, percent bad frames=, 6.9034852981567
[f=0001500] [UDPConnection::ProcessRawPacket] 32 NETMSG_*FRAME packets received (1064.000000ms)
[f=0001508] gameframe, 1508, delta time, 0.06700000166893, percent bad frames=, 6.8965516090393
[f=0001512] gameframe, 1512, delta time, 0.060999996960163, percent bad frames=, 6.9444446563721
[f=0001523] gameframe, 1523, delta time, 0.057000000029802, percent bad frames=, 6.9599475860596
[f=0001527] gameframe, 1527, delta time, 0.081000000238419, percent bad frames=, 7.007203578949
[f=0001530] [UDPConnection::ProcessRawPacket] 31 NETMSG_*FRAME packets received (1032.000000ms)
[f=0001543] gameframe, 1543, delta time, 0.059999998658895, percent bad frames=, 6.999351978302
[f=0001548] gameframe, 1548, delta time, 0.051999997347593, percent bad frames=, 7.0413436889648
[f=0001556] gameframe, 1556, delta time, 0.090999998152256, percent bad frames=, 7.0694088935852
[f=0001561] [UDPConnection::ProcessRawPacket] 30 NETMSG_*FRAME packets received (1015.000000ms)
[f=0001571] gameframe, 1571, delta time, 0.070000000298023, percent bad frames=, 7.0655632019043
[f=0001576] gameframe, 1576, delta time, 0.060999996960163, percent bad frames=, 7.1065988540649
[f=0001587] gameframe, 1587, delta time, 0.05799999833107, percent bad frames=, 7.1203527450562
[f=0001592] [UDPConnection::ProcessRawPacket] 33 NETMSG_*FRAME packets received (1071.000000ms)
[f=0001593] gameframe, 1593, delta time, 0.067999996244907, percent bad frames=, 7.1563086509705
[f=0001601] gameframe, 1601, delta time, 0.067999996244907, percent bad frames=, 7.1830105781555
[f=0001609] gameframe, 1609, delta time, 0.057000000029802, percent bad frames=, 7.2094469070435
[f=0001617] gameframe, 1617, delta time, 0.065999999642372, percent bad frames=, 7.2356214523315
[f=0001623] [UDPConnection::ProcessRawPacket] 30 NETMSG_*FRAME packets received (1030.000000ms)
[f=0001624] gameframe, 1624, delta time, 0.061999998986721, percent bad frames=, 7.2660098075867
[f=0001628] gameframe, 1628, delta time, 0.072999998927116, percent bad frames=, 7.309582233429
[f=0001637] gameframe, 1637, delta time, 0.059999998658895, percent bad frames=, 7.3304824829102
[f=0001646] gameframe, 1646, delta time, 0.052999999374151, percent bad frames=, 7.3511543273926
[f=0001650] gameframe, 1650, delta time, 0.082999996840954, percent bad frames=, 7.3939394950867
[f=0001653] [UDPConnection::ProcessRawPacket] 31 NETMSG_*FRAME packets received (1019.000000ms)
[f=0001654] gameframe, 1654, delta time, 0.070000000298023, percent bad frames=, 7.4365177154541
[f=0001659] gameframe, 1659, delta time, 0.059999998658895, percent bad frames=, 7.4743819236755
[f=0001665] gameframe, 1665, delta time, 0.057000000029802, percent bad frames=, 7.5075073242188
[f=0001670] gameframe, 1670, delta time, 0.051999997347593, percent bad frames=, 7.544909954071
[f=0001674] gameframe, 1674, delta time, 0.068999998271465, percent bad frames=, 7.5866189002991
[f=0001684] [UDPConnection::ProcessRawPacket] 31 NETMSG_*FRAME packets received (1019.000000ms)
[f=0001685] gameframe, 1685, delta time, 0.051999997347593, percent bad frames=, 7.5964393615723
[f=0001708] gameframe, 1708, delta time, 0.079999998211861, percent bad frames=, 7.5526933670044
[f=0001715] [UDPConnection::ProcessRawPacket] 30 NETMSG_*FRAME packets received (1008.000000ms)
[f=0001720] gameframe, 1720, delta time, 0.064999997615814, percent bad frames=, 7.5581393241882
[f=0001729] gameframe, 1729, delta time, 0.070000000298023, percent bad frames=, 7.5766339302063
[f=0001733] gameframe, 1733, delta time, 0.052999999374151, percent bad frames=, 7.6168494224548
[f=0001741] gameframe, 1741, delta time, 0.05799999833107, percent bad frames=, 7.6392879486084
[f=0001746] [UDPConnection::ProcessRawPacket] 32 NETMSG_*FRAME packets received (1061.000000ms)
[f=0001747] gameframe, 1747, delta time, 0.093999996781349, percent bad frames=, 7.6702919006348
[f=0001752] gameframe, 1752, delta time, 0.060999996960163, percent bad frames=, 7.7054796218872
[f=0001757] gameframe, 1757, delta time, 0.055999998003244, percent bad frames=, 7.740466594696
[f=0001763] gameframe, 1763, delta time, 0.079999998211861, percent bad frames=, 7.7708449363708
[f=0001768] gameframe, 1768, delta time, 0.08500000089407, percent bad frames=, 7.8054299354553
[f=0001777] [UDPConnection::ProcessRawPacket] 30 NETMSG_*FRAME packets received (1027.000000ms)
[f=0001778] gameframe, 1778, delta time, 0.052999999374151, percent bad frames=, 7.8177728652954
[f=0001782] gameframe, 1782, delta time, 0.076999999582767, percent bad frames=, 7.8563413619995
[f=0001809] [UDPConnection::ProcessRawPacket] 33 NETMSG_*FRAME packets received (1084.000000ms)
[f=0001810] gameframe, 1810, delta time, 0.05799999833107, percent bad frames=, 7.7900552749634
[f=0001827] gameframe, 1827, delta time, 0.055999998003244, percent bad frames=, 7.7723045349121
[f=0001831] gameframe, 1831, delta time, 0.078999996185303, percent bad frames=, 7.8099398612976
[f=0001842] [UDPConnection::ProcessRawPacket] 31 NETMSG_*FRAME packets received (1033.000000ms)
[f=0001846] gameframe, 1846, delta time, 0.063000001013279, percent bad frames=, 7.8006501197815
[f=0001851] gameframe, 1851, delta time, 0.065999999642372, percent bad frames=, 7.8336033821106
[f=0001855] gameframe, 1855, delta time, 0.063000001013279, percent bad frames=, 7.8706197738647
[f=0001861] gameframe, 1861, delta time, 0.085999995470047, percent bad frames=, 7.8989791870117
[f=0001872] [UDPConnection::ProcessRawPacket] 31 NETMSG_*FRAME packets received (1048.000000ms)
[f=0001891] gameframe, 1891, delta time, 0.063999995589256, percent bad frames=, 7.8265466690063
[f=0001896] gameframe, 1896, delta time, 0.058999996632338, percent bad frames=, 7.8586497306824
[f=0001905] [UDPConnection::ProcessRawPacket] 33 NETMSG_*FRAME packets received (1102.000000ms)
[f=0001906] gameframe, 1906, delta time, 0.072999998927116, percent bad frames=, 7.8698844909668
[f=0001910] gameframe, 1910, delta time, 0.068999998271465, percent bad frames=, 7.9057593345642
[f=0001924] gameframe, 1924, delta time, 0.089999996125698, percent bad frames=, 7.9002079963684
[f=0001936] [UDPConnection::ProcessRawPacket] 32 NETMSG_*FRAME packets received (1057.000000ms)
[f=0001937] gameframe, 1937, delta time, 0.074999995529652, percent bad frames=, 7.8988127708435
[f=0001948] gameframe, 1948, delta time, 0.064999997615814, percent bad frames=, 7.9055442810059
[f=0001955] gameframe, 1955, delta time, 0.07599999755621, percent bad frames=, 7.9283885955811
[f=0001964] gameframe, 1964, delta time, 0.050999999046326, percent bad frames=, 7.942973613739
[f=0001968] [UDPConnection::ProcessRawPacket] 31 NETMSG_*FRAME packets received (1040.000000ms)
[f=0001973] gameframe, 1973, delta time, 0.071999996900558, percent bad frames=, 7.9574251174927
[f=0001985] gameframe, 1985, delta time, 0.064999997615814, percent bad frames=, 7.9596977233887
[f=0001991] gameframe, 1991, delta time, 0.077999994158745, percent bad frames=, 7.9859366416931
[f=0002002] [UDPConnection::ProcessRawPacket] 35 NETMSG_*FRAME packets received (1139.000122ms)
[f=0002003] gameframe, 2003, delta time, 0.055999998003244, percent bad frames=, 7.9880180358887
[f=0002008] gameframe, 2008, delta time, 0.087999999523163, percent bad frames=, 8.0179281234741
[f=0002012] gameframe, 2012, delta time, 0.063000001013279, percent bad frames=, 8.0516901016235
[f=0002018] gameframe, 2018, delta time, 0.068999998271465, percent bad frames=, 8.0773038864136
[f=0002022] gameframe, 2022, delta time, 0.058999996632338, percent bad frames=, 8.1107816696167
[f=0002028] gameframe, 2028, delta time, 0.050999999046326, percent bad frames=, 8.1360950469971
[f=0002036] [UDPConnection::ProcessRawPacket] 33 NETMSG_*FRAME packets received (1118.000000ms)
[f=0002041] gameframe, 2041, delta time, 0.063999995589256, percent bad frames=, 8.1332683563232
[f=0002054] gameframe, 2054, delta time, 0.076999999582767, percent bad frames=, 8.1304769515991
[f=0002067] [UDPConnection::ProcessRawPacket] 32 NETMSG_*FRAME packets received (1053.000000ms)
[f=0002068] gameframe, 2068, delta time, 0.070000000298023, percent bad frames=, 8.1237907409668
[f=0002086] gameframe, 2086, delta time, 0.050999999046326, percent bad frames=, 8.1016302108765
[f=0002091] gameframe, 2091, delta time, 0.06700000166893, percent bad frames=, 8.1300811767578
[f=0002099] [UDPConnection::ProcessRawPacket] 30 NETMSG_*FRAME packets received (1017.000000ms)
[f=0002105] gameframe, 2105, delta time, 0.070000000298023, percent bad frames=, 8.1235151290894
[f=0002128] [UDPConnection::ProcessRawPacket] 30 NETMSG_*FRAME packets received (1008.000000ms)
[f=0002129] gameframe, 2129, delta time, 0.053999997675419, percent bad frames=, 8.0789098739624
[f=0002136] gameframe, 2136, delta time, 0.070999994874001, percent bad frames=, 8.099250793457
[f=0002145] gameframe, 2145, delta time, 0.053999997675419, percent bad frames=, 8.1118879318237
[f=0002149] gameframe, 2149, delta time, 0.081000000238419, percent bad frames=, 8.1433229446411
[f=0002160] [UDPConnection::ProcessRawPacket] 31 NETMSG_*FRAME packets received (1004.000000ms)
[f=0002165] gameframe, 2165, delta time, 0.099999994039536, percent bad frames=, 8.1293306350708
[f=0002191] [UDPConnection::ProcessRawPacket] 32 NETMSG_*FRAME packets received (1088.999878ms)
[f=0002196] gameframe, 2196, delta time, 0.061999998986721, percent bad frames=, 8.0601091384888
[f=0002202] gameframe, 2202, delta time, 0.07599999755621, percent bad frames=, 8.0835599899292
[f=0002222] [UDPConnection::ProcessRawPacket] 31 NETMSG_*FRAME packets received (1028.000000ms)
[f=0002223] gameframe, 2223, delta time, 0.071999996900558, percent bad frames=, 8.0521821975708
[f=0002227] gameframe, 2227, delta time, 0.057000000029802, percent bad frames=, 8.0826225280762
[f=0002232] gameframe, 2232, delta time, 0.059999998658895, percent bad frames=, 8.1093187332153
[f=0002239] gameframe, 2239, delta time, 0.055999998003244, percent bad frames=, 8.1286287307739
[f=0002245] gameframe, 2245, delta time, 0.077999994158745, percent bad frames=, 8.1514472961426
[f=0002253] [UDPConnection::ProcessRawPacket] 31 NETMSG_*FRAME packets received (1033.000000ms)
[f=0002267] gameframe, 2267, delta time, 0.053999997675419, percent bad frames=, 8.1164531707764
[f=0002283] [UDPConnection::ProcessRawPacket] 31 NETMSG_*FRAME packets received (1020.000000ms)
[f=0002284] gameframe, 2284, delta time, 0.057000000029802, percent bad frames=, 8.0998249053955
[f=0002289] gameframe, 2289, delta time, 0.050999999046326, percent bad frames=, 8.1258192062378
[f=0002293] gameframe, 2293, delta time, 0.076999999582767, percent bad frames=, 8.155255317688
[f=0002307] gameframe, 2307, delta time, 0.096999995410442, percent bad frames=, 8.1491117477417
[f=0002317] [UDPConnection::ProcessRawPacket] 32 NETMSG_*FRAME packets received (1096.999878ms)
[f=0002321] gameframe, 2321, delta time, 0.05799999833107, percent bad frames=, 8.1430416107178
[f=0002341] gameframe, 2341, delta time, 0.068999998271465, percent bad frames=, 8.116189956665
[f=0002348] [UDPConnection::ProcessRawPacket] 32 NETMSG_*FRAME packets received (1044.000000ms)
[f=0002358] gameframe, 2358, delta time, 0.054999999701977, percent bad frames=, 8.1000852584839
[f=0002363] gameframe, 2363, delta time, 0.081999994814396, percent bad frames=, 8.1252641677856
[f=0002372] gameframe, 2372, delta time, 0.07599999755621, percent bad frames=, 8.1365938186646
[f=0002376] gameframe, 2376, delta time, 0.064999997615814, percent bad frames=, 8.1649827957153
[f=0002380] [UDPConnection::ProcessRawPacket] 32 NETMSG_*FRAME packets received (1061.000000ms)
[f=0002391] Player [teh]Beherith[PiRO] went AFK
[f=0002392] gameframe, 2392, delta time, 0.072999998927116, percent bad frames=, 8.1521739959717
[f=0002405] gameframe, 2405, delta time, 0.085999995470047, percent bad frames=, 8.1496877670288
[f=0002413] [UDPConnection::ProcessRawPacket] 33 NETMSG_*FRAME packets received (1127.000122ms)
[f=0002418] gameframe, 2418, delta time, 0.051999997347593, percent bad frames=, 8.1472291946411
[f=0002434] gameframe, 2434, delta time, 0.058999996632338, percent bad frames=, 8.1347579956055
[f=0002443] [UDPConnection::ProcessRawPacket] 30 NETMSG_*FRAME packets received (1000.000000ms)
[f=0002451] Player [teh]Beherith[PiRO] came back
[f=0002464] gameframe, 2464, delta time, 0.053999997675419, percent bad frames=, 8.0762987136841
[f=0002468] gameframe, 2468, delta time, 0.081000000238419, percent bad frames=, 8.1037273406982
[f=0002476] [UDPConnection::ProcessRawPacket] 32 NETMSG_*FRAME packets received (1067.000000ms)
[f=0002483] gameframe, 2483, delta time, 0.067999996244907, percent bad frames=, 8.095046043396
[f=0002488] gameframe, 2488, delta time, 0.094999998807907, percent bad frames=, 8.1189708709717
[f=0002499] gameframe, 2499, delta time, 0.063000001013279, percent bad frames=, 8.1232490539551
[f=0002503] gameframe, 2503, delta time, 0.081000000238419, percent bad frames=, 8.1502199172974
[f=0002508] [UDPConnection::ProcessRawPacket] 34 NETMSG_*FRAME packets received (1104.999878ms)
[f=0002524] gameframe, 2524, delta time, 0.077999994158745, percent bad frames=, 8.1220283508301
[f=0002534] gameframe, 2534, delta time, 0.063000001013279, percent bad frames=, 8.1294393539429
[f=0002542] [UDPConnection::ProcessRawPacket] 33 NETMSG_*FRAME packets received (1112.000000ms)
[f=0002547] gameframe, 2547, delta time, 0.06700000166893, percent bad frames=, 8.1272087097168
[f=0002552] gameframe, 2552, delta time, 0.058999996632338, percent bad frames=, 8.1504697799683
[f=0002556] gameframe, 2556, delta time, 0.055999998003244, percent bad frames=, 8.1768388748169
[f=0002561] gameframe, 2561, delta time, 0.060999996960163, percent bad frames=, 8.1999216079712
[f=0002565] gameframe, 2565, delta time, 0.076999999582767, percent bad frames=, 8.2261209487915
[f=0002576] [UDPConnection::ProcessRawPacket] 34 NETMSG_*FRAME packets received (1136.000000ms)
[f=0002584] gameframe, 2584, delta time, 0.061999998986721, percent bad frames=, 8.2043342590332
[f=0002593] gameframe, 2593, delta time, 0.05799999833107, percent bad frames=, 8.2144231796265
[f=0002610] [UDPConnection::ProcessRawPacket] 35 NETMSG_*FRAME packets received (1154.000000ms)
[f=0002611] gameframe, 2611, delta time, 0.06700000166893, percent bad frames=, 8.1960935592651
[f=0002616] gameframe, 2616, delta time, 0.058999996632338, percent bad frames=, 8.2186546325684
[f=0002620] gameframe, 2620, delta time, 0.059999998658895, percent bad frames=, 8.2442750930786
[f=0002625] gameframe, 2625, delta time, 0.058999996632338, percent bad frames=, 8.2666664123535
[f=0002630] gameframe, 2630, delta time, 0.07599999755621, percent bad frames=, 8.2889738082886
[f=0002645] [UDPConnection::ProcessRawPacket] 34 NETMSG_*FRAME packets received (1160.999878ms)
[f=0002646] gameframe, 2646, delta time, 0.076999999582767, percent bad frames=, 8.2766437530518
[f=0002650] gameframe, 2650, delta time, 0.074999995529652, percent bad frames=, 8.3018865585327
[f=0002663] gameframe, 2663, delta time, 0.059999998658895, percent bad frames=, 8.2989110946655
[f=0002668] gameframe, 2668, delta time, 0.063000001013279, percent bad frames=, 8.320839881897
[f=0002673] gameframe, 2673, delta time, 0.063000001013279, percent bad frames=, 8.3426856994629
[f=0002678] [UDPConnection::ProcessRawPacket] 32 NETMSG_*FRAME packets received (1043.000000ms)
[f=0002682] gameframe, 2682, delta time, 0.081000000238419, percent bad frames=, 8.3519763946533
[f=0002691] gameframe, 2691, delta time, 0.068999998271465, percent bad frames=, 8.3612041473389
[f=0002705] gameframe, 2705, delta time, 0.06700000166893, percent bad frames=, 8.3548984527588
[f=0002709] [UDPConnection::ProcessRawPacket] 32 NETMSG_*FRAME packets received (1088.999878ms)
[f=0002710] gameframe, 2710, delta time, 0.053999997675419, percent bad frames=, 8.3763837814331
[f=0002714] gameframe, 2714, delta time, 0.050999999046326, percent bad frames=, 8.4008846282959
[f=0002724] gameframe, 2724, delta time, 0.065999999642372, percent bad frames=, 8.4067544937134
[f=0002729] gameframe, 2729, delta time, 0.085999995470047, percent bad frames=, 8.4279956817627
[f=0002737] gameframe, 2737, delta time, 0.074999995529652, percent bad frames=, 8.4398975372314
[f=0002741] [UDPConnection::ProcessRawPacket] 32 NETMSG_*FRAME packets received (1068.000000ms)
[f=0002756] gameframe, 2756, delta time, 0.051999997347593, percent bad frames=, 8.4179973602295
[f=0002769] gameframe, 2769, delta time, 0.052999999374151, percent bad frames=, 8.414589881897
[f=0002773] [UDPConnection::ProcessRawPacket] 32 NETMSG_*FRAME packets received (1065.000000ms)
[f=0002774] gameframe, 2774, delta time, 0.051999997347593, percent bad frames=, 8.4354724884033
[f=0002787] gameframe, 2787, delta time, 0.054999999701977, percent bad frames=, 8.4320058822632
[f=0002794] gameframe, 2794, delta time, 0.068999998271465, percent bad frames=, 8.4466714859009
[f=0002803] gameframe, 2803, delta time, 0.051999997347593, percent bad frames=, 8.4552268981934
[f=0002805] [UDPConnection::ProcessRawPacket] 32 NETMSG_*FRAME packets received (1041.000000ms)
[f=0002810] gameframe, 2810, delta time, 0.050999999046326, percent bad frames=, 8.4697513580322
[f=0002823] gameframe, 2823, delta time, 0.096999995410442, percent bad frames=, 8.4661703109741
[f=0002833] gameframe, 2833, delta time, 0.06700000166893, percent bad frames=, 8.4715852737427
[f=0002835] [UDPConnection::ProcessRawPacket] 30 NETMSG_*FRAME packets received (1001.000000ms)
[f=0002843] gameframe, 2843, delta time, 0.059999998658895, percent bad frames=, 8.4769611358643
[f=0002853] gameframe, 2853, delta time, 0.096999995410442, percent bad frames=, 8.4822998046875
[f=0002866] [UDPConnection::ProcessRawPacket] 32 NETMSG_*FRAME packets received (1065.000000ms)
[f=0002867] gameframe, 2867, delta time, 0.050999999046326, percent bad frames=, 8.4757585525513
[f=0002898] [UDPConnection::ProcessRawPacket] 31 NETMSG_*FRAME packets received (1046.000000ms)
[f=0002914] gameframe, 2914, delta time, 0.076999999582767, percent bad frames=, 8.3733701705933
[f=0002918] gameframe, 2918, delta time, 0.063000001013279, percent bad frames=, 8.3961620330811
[f=0002923] gameframe, 2923, delta time, 0.058999996632338, percent bad frames=, 8.4160108566284
[f=0002931] [UDPConnection::ProcessRawPacket] 34 NETMSG_*FRAME packets received (1134.000000ms)
[f=0002932] gameframe, 2932, delta time, 0.083999998867512, percent bad frames=, 8.4242839813232
[f=0002945] gameframe, 2945, delta time, 0.077999994158745, percent bad frames=, 8.4210529327393
[f=0002949] gameframe, 2949, delta time, 0.074999995529652, percent bad frames=, 8.4435405731201
[f=0002962] [UDPConnection::ProcessRawPacket] 31 NETMSG_*FRAME packets received (1024.000000ms)
[f=0002968] gameframe, 2968, delta time, 0.063999995589256, percent bad frames=, 8.4231805801392
[f=0002978] gameframe, 2978, delta time, 0.063000001013279, percent bad frames=, 8.4284753799438
[f=0002982] gameframe, 2982, delta time, 0.074999995529652, percent bad frames=, 8.450704574585
[f=0002994] [UDPConnection::ProcessRawPacket] 32 NETMSG_*FRAME packets received (1073.000000ms)
[f=0003004] gameframe, 3004, delta time, 0.072999998927116, percent bad frames=, 8.4221038818359
[f=0003014] gameframe, 3014, delta time, 0.065999999642372, percent bad frames=, 8.427339553833
[f=0003019] gameframe, 3019, delta time, 0.057000000029802, percent bad frames=, 8.4465055465698
[f=0003026] [UDPConnection::ProcessRawPacket] 32 NETMSG_*FRAME packets received (1059.000000ms)
[f=0003027] gameframe, 3027, delta time, 0.072999998927116, percent bad frames=, 8.457218170166
[f=0003060] [UDPConnection::ProcessRawPacket] 33 NETMSG_*FRAME packets received (1104.000000ms)
[f=0003089] gameframe, 3089, delta time, 0.060999996960163, percent bad frames=, 8.3198442459106
[f=0003093] [UDPConnection::ProcessRawPacket] 33 NETMSG_*FRAME packets received (1120.000000ms)
[f=0003094] gameframe, 3094, delta time, 0.064999997615814, percent bad frames=, 8.3387203216553
[f=0003098] gameframe, 3098, delta time, 0.092000000178814, percent bad frames=, 8.3602323532104
[f=0003113] gameframe, 3113, delta time, 0.063999995589256, percent bad frames=, 8.352071762085
[f=0003125] [UDPConnection::ProcessRawPacket] 33 NETMSG_*FRAME packets received (1069.000000ms)
[f=0003126] gameframe, 3126, delta time, 0.089999996125698, percent bad frames=, 8.3493280410767
[f=0003131] gameframe, 3131, delta time, 0.050999999046326, percent bad frames=, 8.3679332733154
[f=0003139] gameframe, 3139, delta time, 0.05799999833107, percent bad frames=, 8.3784646987915
[f=0003144] gameframe, 3144, delta time, 0.053999997675419, percent bad frames=, 8.3969469070435
[f=0003150] gameframe, 3150, delta time, 0.05799999833107, percent bad frames=, 8.4126987457275
[f=0003154] gameframe, 3154, delta time, 0.086999997496605, percent bad frames=, 8.4337348937988
[f=0003157] [UDPConnection::ProcessRawPacket] 31 NETMSG_*FRAME packets received (1057.000000ms)
[f=0003158] gameframe, 3158, delta time, 0.054999999701977, percent bad frames=, 8.4547185897827
[f=0003162] gameframe, 3162, delta time, 0.076999999582767, percent bad frames=, 8.4756479263306
[f=0003185] gameframe, 3185, delta time, 0.086999997496605, percent bad frames=, 8.445839881897
[f=0003189] [UDPConnection::ProcessRawPacket] 32 NETMSG_*FRAME packets received (1074.000000ms)
[f=0003194] gameframe, 3194, delta time, 0.067999996244907, percent bad frames=, 8.4533500671387
[f=0003208] gameframe, 3208, delta time, 0.065999999642372, percent bad frames=, 8.4476308822632
[f=0003217] gameframe, 3217, delta time, 0.051999997347593, percent bad frames=, 8.4550819396973
[f=0003221] [UDPConnection::ProcessRawPacket] 33 NETMSG_*FRAME packets received (1086.000000ms)
[f=0003222] gameframe, 3222, delta time, 0.068999998271465, percent bad frames=, 8.4729976654053
[f=0003252] [UDPConnection::ProcessRawPacket] 30 NETMSG_*FRAME packets received (1015.000000ms)
[f=0003257] gameframe, 3257, delta time, 0.071999996900558, percent bad frames=, 8.4126501083374
[f=0003273] gameframe, 3273, delta time, 0.063999995589256, percent bad frames=, 8.4020776748657
[f=0003285] [UDPConnection::ProcessRawPacket] 34 NETMSG_*FRAME packets received (1118.000000ms)
[f=0003286] gameframe, 3286, delta time, 0.064999997615814, percent bad frames=, 8.3992700576782
[f=0003303] gameframe, 3303, delta time, 0.096000000834465, percent bad frames=, 8.3863153457642
[f=0003314] gameframe, 3314, delta time, 0.067999996244907, percent bad frames=, 8.388653755188
[f=0003319] [UDPConnection::ProcessRawPacket] 33 NETMSG_*FRAME packets received (1087.000122ms)
[f=0003330] gameframe, 3330, delta time, 0.096000000834465, percent bad frames=, 8.3783779144287
[f=0003335] gameframe, 3335, delta time, 0.057000000029802, percent bad frames=, 8.3958024978638
[f=0003340] gameframe, 3340, delta time, 0.051999997347593, percent bad frames=, 8.4131736755371
[f=0003352] [UDPConnection::ProcessRawPacket] 34 NETMSG_*FRAME packets received (1208.000000ms)
[f=0003353] gameframe, 3353, delta time, 0.15199999511242, percent bad frames=, 8.4103784561157
[f=0003371] gameframe, 3371, delta time, 0.090999998152256, percent bad frames=, 8.3951349258423
[f=0003384] gameframe, 3384, delta time, 0.054999999701977, percent bad frames=, 8.3924350738525
[f=0003388] [UDPConnection::ProcessRawPacket] 35 NETMSG_*FRAME packets received (1092.000000ms)
[f=0003393] gameframe, 3393, delta time, 0.087999999523163, percent bad frames=, 8.3996467590332
[f=0003397] gameframe, 3397, delta time, 0.061999998986721, percent bad frames=, 8.4191932678223
[f=0003421] [UDPConnection::ProcessRawPacket] 32 NETMSG_*FRAME packets received (1066.000000ms)
[f=0003425] gameframe, 3425, delta time, 0.16399998962879, percent bad frames=, 8.3795623779297
[f=0003452] [UDPConnection::ProcessRawPacket] 32 NETMSG_*FRAME packets received (1111.000122ms)
[f=0003456] gameframe, 3456, delta time, 0.052999999374151, percent bad frames=, 8.3333330154419
[f=0003467] gameframe, 3467, delta time, 0.098999999463558, percent bad frames=, 8.3357372283936
[f=0003480] gameframe, 3480, delta time, 0.061999998986721, percent bad frames=, 8.3333330154419
[f=0003482] [UDPConnection::ProcessRawPacket] 31 NETMSG_*FRAME packets received (1007.000000ms)
[f=0003494] gameframe, 3494, delta time, 0.058999996632338, percent bad frames=, 8.3285636901855
[f=0003495] gameframe, 3495, delta time, 0.070999994874001, percent bad frames=, 8.3547925949097
[f=0003509] gameframe, 3509, delta time, 0.076999999582767, percent bad frames=, 8.3499574661255
[f=0003516] [UDPConnection::ProcessRawPacket] 34 NETMSG_*FRAME packets received (1118.000000ms)
[f=0003537] gameframe, 3537, delta time, 0.083999998867512, percent bad frames=, 8.3121290206909
[f=0003548] [UDPConnection::ProcessRawPacket] 31 NETMSG_*FRAME packets received (1096.000000ms)
[f=0003584] [UDPConnection::ProcessRawPacket] 36 NETMSG_*FRAME packets received (1162.000000ms)
[f=0003605] gameframe, 3605, delta time, 0.064999997615814, percent bad frames=, 8.1830787658691
[f=0003610] gameframe, 3610, delta time, 0.065999999642372, percent bad frames=, 8.1994457244873
[f=0003617] [UDPConnection::ProcessRawPacket] 33 NETMSG_*FRAME packets received (1071.000000ms)
[f=0003624] gameframe, 3624, delta time, 0.050999999046326, percent bad frames=, 8.1953639984131
[f=0003633] gameframe, 3633, delta time, 0.083999998867512, percent bad frames=, 8.2025871276855
[f=0003637] gameframe, 3637, delta time, 0.070000000298023, percent bad frames=, 8.221061706543
[f=0003646] [UDPConnection::ProcessRawPacket] 29 NETMSG_*FRAME packets received (1000.000000ms)
[f=0003667] gameframe, 3667, delta time, 0.061999998986721, percent bad frames=, 8.1810741424561
[f=0003672] gameframe, 3672, delta time, 0.061999998986721, percent bad frames=, 8.1971673965454
[f=0003678] [UDPConnection::ProcessRawPacket] 32 NETMSG_*FRAME packets received (1035.000000ms)
[f=0003684] gameframe, 3684, delta time, 0.081999994814396, percent bad frames=, 8.1976108551025
[f=0003698] gameframe, 3698, delta time, 0.055999998003244, percent bad frames=, 8.1936178207397
[f=0003703] gameframe, 3703, delta time, 0.050999999046326, percent bad frames=, 8.2095594406128
[f=0003707] gameframe, 3707, delta time, 0.068999998271465, percent bad frames=, 8.2276773452759
[f=0003710] [UDPConnection::ProcessRawPacket] 33 NETMSG_*FRAME packets received (1106.000000ms)
[f=0003724] gameframe, 3724, delta time, 0.060999996960163, percent bad frames=, 8.2169713973999
[f=0003730] gameframe, 3730, delta time, 0.065999999642372, percent bad frames=, 8.2305631637573
[f=0003739] gameframe, 3739, delta time, 0.055999998003244, percent bad frames=, 8.2374963760376
[f=0003744] [UDPConnection::ProcessRawPacket] 34 NETMSG_*FRAME packets received (1127.000122ms)
[f=0003753] gameframe, 3753, delta time, 0.090999998152256, percent bad frames=, 8.2334136962891
[f=0003765] gameframe, 3765, delta time, 0.058999996632338, percent bad frames=, 8.2337312698364
[f=0003776] [UDPConnection::ProcessRawPacket] 31 NETMSG_*FRAME packets received (1033.000000ms)
[f=0003782] [UDPConnection::ProcessRawPacket] 6 NETMSG_*FRAME packets received (1224.999878ms)
[f=0003783] gameframe, 3783, delta time, 1.0779999494553, percent bad frames=, 8.2209882736206
[f=0003786] Server shutdown
[f=0003786] <autoquit> Automatically exiting in 8 seconds. Move mouse to cancel.
[f=0003786] <autoquit> Autoquit canceled.
[f=0003786] User exited
[f=0003786] [SpringApp::ShutDown][1]
[f=0003786] [ThreadPool::SetThreadCount][1] #wanted=0 #current=3
[f=0003786] [ThreadPool::SetThreadCount][2] #threads=0
[f=0003786] [SpringApp::ShutDown][2]
[f=0003786] [~CGame][1]
[f=0003786] [~CGame][2]
[f=0003786] [~CGame][3]
[f=0003786] [~CGame][4]
[f=0003786] [~CGame][5]
[f=0003786] [~CGame][6]
[f=0003786] Red_UI_Framework>> last processed widget was "Red Tooltip"
[f=0003786] Red_Drawing>> last processed widget was "Red Tooltip"
[f=0003786] [~CGame][7]
[f=0003786] [~CGame][8]
[f=0003786] [CCollisionHandler] dis-/continuous tests: 0/61802
[f=0003786] [~CGame][9]
[f=0003786] [~CGame][10]
[f=0003786] [~CPathCache(40x20)] cacheHits=0 hitPercentage=0% numHashColls=0 maxCacheSize=0
[f=0003786] [~CPathCache(40x20)] cacheHits=0 hitPercentage=0% numHashColls=0 maxCacheSize=1
[f=0003786] [~CPathCache(160x80)] cacheHits=0 hitPercentage=0% numHashColls=0 maxCacheSize=0
[f=0003786] [~CPathCache(160x80)] cacheHits=0 hitPercentage=0% numHashColls=0 maxCacheSize=10
[f=0003786] Statistics for RectangleOptimizer: 0%
[f=0003786] Statistics for RectangleOptimizer: 0%
[f=0003786] [~CGame][11]
[f=0003786] [~CGame][12]
[f=0003786] [~CGame][13]
[f=0003786] [~CGame][14]
[f=0003786] [Sound] [~CSound][1] soundThread=02FB22B0
[f=0003786] [Sound] [~CSound][2]
[f=0003786] [Sound] [~CSound][3]
[f=0003786] [~CGame][15]
[f=0003786] [SpringApp::ShutDown][3]
[f=0003786] [SpringApp::ShutDown][4]
[f=0003786] Statistics for UDP connection:
Received: 25889 bytes in 1107 packets (23.3866 bytes/package)
Sent: 66117 bytes in 2089 packets (31.6501 bytes/package)
Relative protocol overhead: 0 up, 0.256557 down
1 incoming chunks dropped, 1 outgoing chunks resent

[f=0003786] Writing demo: demos/20131203_114748_DeltaSiegeDry_95.0.1-151-ge073c88 develop.sdf
[f=0003786] [SpringApp::ShutDown][5]
[f=0003786] [SpringApp::ShutDown][6]
[f=0003786] [SpringApp::ShutDown][7]
[f=0003786] [SpringApp::ShutDown][8]
[f=0003786] [SpringApp::ShutDown][9]
[SpringApp::ShutDown][10]
[SpringApp::ShutDown][11]
[WatchDog::Uninstall][1] hangDetectorThread=02FB1ED0
[WatchDog::Uninstall][2]
[WatchDog::Uninstall][3]
[SpringApp::ShutDown][12]
[SpringApp::Run] exitCode=0
    txt file icon infolog_151_client_dirty_pc.txt (70,829 bytes) 2013-12-03 12:03 +
  • txt file icon infolog_154_client.txt (59,264 bytes) 2013-12-03 21:13 - 
    [ParseCmdLine] command-line args: "C:\Users\Peti\Documents\My Games\Spring\engine\95.0.1-154-g240a8b9\spring.exe C:\Users\Peti\Documents\My Games\Spring\engine\95.0.1-154-g240a8b9\script.txt"
Using configuration source: "C:\Users\Peti\Documents\My Games\Spring\engine\95.0.1-154-g240a8b9\springsettings.cfg"
Using additional configuration source: "C:\Users\Peti\AppData\Local\springsettings.cfg"
Available log sections: KeyBindings, AutohostInterface, Net, CSMFGroundTextures, RoamMeshDrawer, BumpWater, DynWater, SkyBox, DecalsDrawerGL4, FarTextureHandler, Model, Piece, ModelDrawer, OBJParser, WorldObjectModelRenderer, Shader, Texture, Font, GroundMoveType, Path, UnitScript, CregSerializer, ArchiveScanner, VFS, Sound, LuaSocket
Enabled log sections: Sound(LOG_LEVEL_INFO)
Enable or disable log sections using the LogSections configuration key
  or the SPRING_LOG_SECTIONS environment variable (both comma separated).
  Use "none" to disable the default log sections.
LogOutput initialized.
Spring 95.0.1-154-g240a8b9 develop
Build date/time: Dec  3 2013 16:41:18
Build environment: boost-105300, GNU libstdc++ version 20130531
Compiler: gcc-4.8.1
OS: Microsoft Windows
Microsoft Windows 7 Ultimate Edition, 64-bit (build 7600)
Intel(R) Core(TM) i5 CPU         750  @ 2.67GHz; 8190MB RAM, 16378MB pagefile
OS: emulated 32bit mode
[CMyMath::Init] CPU SSE mask: 127, flags:
	SSE 1.0:  1,  SSE 2.0:  1
	SSE 3.0:  1, SSSE 3.0:  1
	SSE 4.1:  1,  SSE 4.2:  1
	SSE 4.0A: 0,  SSE 5.0A: 0
	using streflop SSE FP-math mode, CPU supports SSE instructions
Supported Video modes: 2560x1440, 1920x1440, 1920x1200, 1920x1080, 1680x1050, 1600x1200, 1600x1024, 1600x900, 1366x768, 1360x768, 1280x1024, 1280x960, 1280x800, 1280x768, 1280x720, 1152x864, 1024x768, 800x600, 720x576, 720x480, 640x480
[SetSDLVideoMode] video mode set to 2560x1440/32bit (windowed)
[WatchDogInstall] Installed (HangTimeout: 10sec)
[ThreadPool::SetThreadCount][1] #wanted=4 #current=1
[ThreadPool::SetThreadCount][2] #threads=3
[DataDirs] Portable Mode!
Using read-write data directory: C:\Users\Peti\Documents\My Games\Spring\engine\95.0.1-154-g240a8b9\
Using read-only data directory: C:\Users\Peti\Documents\My Games\Spring\
Using read-only data directory: C:\Users\Peti\Documents\Spring\
Using read-only data directory: C:\ProgramData\Spring\
Scanning: C:\Users\Peti\Documents\My Games\Spring\maps
Scanning: C:\Users\Peti\Documents\My Games\Spring\games
Scanning: C:\Users\Peti\Documents\My Games\Spring\packages
Scanning: C:\Users\Peti\Documents\My Games\Spring\engine\95.0.1-154-g240a8b9\base
[ThreadPool::SetThreadCount][1] #wanted=3 #current=4
[ThreadPool::SetThreadCount][2] #threads=2
[Threading] Main thread CPU affinity not set
[f=0000000] SDL version:  1.2.10
[f=0000000] GL version:   4.3.0
[f=0000000] GL vendor:    NVIDIA Corporation
[f=0000000] GL renderer:  GeForce GTX 560 Ti/PCIe/SSE2
[f=0000000] GLSL version: 4.30 NVIDIA via Cg compiler
[f=0000000] GLEW version: 1.5.8
[f=0000000] Video RAM:    total 1023MB, available 402MB
[f=0000000] FBO::maxSamples: 32
[f=0000000] GL info:
	haveARB: 1, haveGLSL: 1, ATI hacks: 0
	FBO support: 1, NPOT-texture support: 1, 24bit Z-buffer support: 1
	maximum texture size: 16384, compress MIP-map textures: 0
	maximum SmoothPointSize: 63, maximum vec4 varying/attributes: 31/16
	maximum drawbuffers: 8, maximum recommended indices/vertices: 1048576/1048576
	number of UniformBufferBindings: 84 (64kB)
[f=0000000] VSync disabled
[f=0000000] Joysticks found: 0
[f=0000000] Warning: Joystick 0 not found
[f=0000000] [Initialize] CPU Clock: win32::TimeGetTime
[f=0000000] [Initialize] CPU Cores: 4
[f=0000000] [Startup] loading startscript from: C:\Users\Peti\Documents\My Games\Spring\engine\95.0.1-154-g240a8b9\script.txt
[f=0000000] Connecting to 192.168.1.108:8453 using name [teh]Beherith[PiRO]
[f=0000000] [Sound] OpenAL info:
[f=0000000] [Sound]   Available Devices:
[f=0000000] [Sound]               DirectSound Software
[f=0000000] [Sound]   Device:     DirectSound Software
[f=0000000] [Sound]   Vendor:         OpenAL Community
[f=0000000] [Sound]   Version:        1.1 ALSOFT 1.11.753
[f=0000000] [Sound]   Renderer:       OpenAL Soft
[f=0000000] [Sound]   AL Extensions:  AL_EXTX_buffer_sub_data AL_EXT_EXPONENT_DISTANCE AL_EXT_FLOAT32 AL_EXT_IMA4 AL_EXT_LINEAR_DISTANCE AL_EXT_MCFORMATS AL_EXT_OFFSET AL_EXTX_sample_buffer_object AL_EXT_source_distance_model AL_LOKI_quadriphonic
[f=0000000] [Sound]   ALC Extensions: ALC_ENUMERATE_ALL_EXT ALC_ENUMERATION_EXT ALC_EXT_CAPTURE ALC_EXT_disconnect ALC_EXT_EFX ALC_EXTX_thread_local_context
[f=0000000] [Sound]   EFX Enabled: yes
[f=0000000] [Sound]   Max Sounds: 128
[f=0000000] [UDPConnection::ProcessRawPacket] 0 NETMSG_*FRAME packets received (1228.000000ms : 0.000000p/ms)
[f=0000000] Using map: DeltaSiegeDry
[f=0000000] Using game: Balanced Annihilation V7.84
[f=0000000] Using game archive: 09d1b87af38a003cf01e4b8d19c35d9c.sdp
[f=0000000] recording demo: demos/20131203_211136_DeltaSiegeDry_95.0.1-154-g240a8b9 develop.sdf
[f=0000000] PreGame::GameDataReceived: 24 ms
[f=0000000] [PreGame::UpdateClientNet] user number 0 (team 0, allyteam 1)
[f=0000000] Allowing pushing enemy units
[f=0000000] [LuaIntro] Searching for new Widgets
[f=0000000] [LuaIntro] Scanning: LuaIntro/Addons/
[f=0000000] [LuaIntro] Scanning: LuaIntro/Widgets/
[f=0000000] [LuaIntro] Scanning: LuaIntro/SystemAddons/
[f=0000000] [LuaIntro] Scanning: LuaIntro/SystemWidgets/
[f=0000000] [LuaIntro] Scanning: LuaIntro/chili/
[f=0000000] [LuaIntro] Found new widget "SpringLogo"
[f=0000000] [LuaIntro] Found new widget "LoadTexture"
[f=0000000] [LuaIntro] Found new widget "LoadProgress"
[f=0000000] [LuaIntro] Found new widget "Main"
[f=0000000] [LuaIntro] Found new widget "Music"
[f=0000000] [LuaIntro] Loading widgets   <>=vfs  **=raw  ()=unknown
[f=0000000] [LuaIntro] Loading widget:      LoadProgress           <loadprogress.lua>
[f=0000000] [LuaIntro] Loading widget:      Main                   <main.lua>
[f=0000000] [LuaIntro] Loading widget:      Music                  <music.lua>
[f=0000000] [LuaIntro] Loading widget:      LoadTexture            <bg_texture.lua>
[f=0000000] [LuaIntro] LuaIntro v1.0 (Lua 5.1)
[f=0000000] Parsing Map Information
[f=0000000] Loading SMF
[f=0000000] Loading Map (80 MB)
[f=0000000] Loading Radar Icons
[f=0000000] [UDPConnection::ProcessRawPacket] 0 NETMSG_*FRAME packets received (1224.000000ms : 0.000000p/ms)
[f=0000000] Loading GameData Definitions
[f=0000000] Loading all definitions:  0.600000
[f=0000000] Game::LoadDefs (GameData): 635 ms
[f=0000000] Loading Sound Definitions
[f=0000000] [Sound]  parsed 27 sounds from gamedata/sounds.lua
[f=0000000] [Sound] Error: Unable to open audio file: IncomingChat
[f=0000000] [Sound] Error: CSound::GetSoundId: could not find sound: IncomingChat
[f=0000000] Game::LoadDefs (Sound): 2 ms
[f=0000000] Creating Smooth Height Mesh
[f=0000000] SmoothHeightMesh::MakeSmoothMesh: 58 ms
[f=0000000] Creating QuadField & CEGs
[f=0000000] [CDamageArrayHandler] number of ArmorDefs: 11
[f=0000000] [RegisterAssimpModelFormats] supported Assimp model formats: *.3ds;*.blend;*.dae;*.lwo;
[f=0000000] Creating Unit Textures
[f=0000000] [UDPConnection::ProcessRawPacket] 0 NETMSG_*FRAME packets received (1200.000000ms : 0.000000p/ms)
[f=0000000] Creating Sky
[f=0000000] Loading Weapon Definitions
[f=0000000] Loading Unit Definitions
[f=0000000] [UDPConnection::ProcessRawPacket] 0 NETMSG_*FRAME packets received (1200.000000ms : 0.000000p/ms)
[f=0000000] [UDPConnection::ProcessRawPacket] 0 NETMSG_*FRAME packets received (1200.000000ms : 0.000000p/ms)
[f=0000000] Loading Feature Definitions
[f=0000000] PathCosts: creating PE8 cache with 4 PF threads (43 MB)
[f=0000000] [UDPConnection::ProcessRawPacket] 0 NETMSG_*FRAME packets received (1200.000000ms : 0.000000p/ms)
[f=0000000] PathCosts: precached 1 of 12800 blocks
[f=0000000] PathCosts: precached 812 of 12800 blocks
[f=0000000] PathCosts: precached 1615 of 12800 blocks
[f=0000000] PathCosts: precached 2434 of 12800 blocks
[f=0000000] PathCosts: precached 3255 of 12800 blocks
[f=0000000] PathCosts: precached 4055 of 12800 blocks
[f=0000000] [UDPConnection::ProcessRawPacket] 0 NETMSG_*FRAME packets received (1200.000000ms : 0.000000p/ms)
[f=0000000] PathCosts: precached 4855 of 12800 blocks
[f=0000000] PathCosts: precached 5657 of 12800 blocks
[f=0000000] PathCosts: precached 6462 of 12800 blocks
[f=0000000] PathCosts: precached 7263 of 12800 blocks
[f=0000000] PathCosts: precached 8090 of 12800 blocks
[f=0000000] PathCosts: precached 8890 of 12800 blocks
[f=0000000] PathCosts: precached 9718 of 12800 blocks
[f=0000000] PathCosts: precached 10520 of 12800 blocks
[f=0000000] [UDPConnection::ProcessRawPacket] 0 NETMSG_*FRAME packets received (1200.000000ms : 0.000000p/ms)
[f=0000000] PathCosts: precached 11322 of 12800 blocks
[f=0000000] PathCosts: precached 12136 of 12800 blocks
[f=0000000] PathCosts: writing
[f=0000000] [UDPConnection::ProcessRawPacket] 0 NETMSG_*FRAME packets received (1200.000000ms : 0.000000p/ms)
[f=0000000] PathCosts: written
[f=0000000] PathCosts: creating PE32 cache with 4 PF threads (43 MB)
[f=0000000] [UDPConnection::ProcessRawPacket] 0 NETMSG_*FRAME packets received (1200.000000ms : 0.000000p/ms)
[f=0000000] PathCosts: precached 1 of 800 blocks
[f=0000000] PathCosts: precached 51 of 800 blocks
[f=0000000] PathCosts: precached 101 of 800 blocks
[f=0000000] PathCosts: precached 154 of 800 blocks
[f=0000000] PathCosts: precached 204 of 800 blocks
[f=0000000] PathCosts: precached 257 of 800 blocks
[f=0000000] PathCosts: precached 310 of 800 blocks
[f=0000000] PathCosts: precached 361 of 800 blocks
[f=0000000] PathCosts: precached 411 of 800 blocks
[f=0000000] [UDPConnection::ProcessRawPacket] 0 NETMSG_*FRAME packets received (1200.000000ms : 0.000000p/ms)
[f=0000000] PathCosts: precached 461 of 800 blocks
[f=0000000] PathCosts: precached 511 of 800 blocks
[f=0000000] PathCosts: precached 562 of 800 blocks
[f=0000000] PathCosts: precached 612 of 800 blocks
[f=0000000] PathCosts: precached 662 of 800 blocks
[f=0000000] PathCosts: precached 712 of 800 blocks
[f=0000000] PathCosts: precached 762 of 800 blocks
[f=0000000] PathCosts: writing
[f=0000000] PathCosts: written
[f=0000000] [CPathManager] pathing data checksum: 1bcf8474
[f=0000000] [IPathManager::GetInstance] using DEFAULT path-manager
[f=0000000] Initializing Map Features
[f=0000000] Error: [LoadFeaturesFromMap] unknown map feature type ""
[f=0000000] Creating ShadowHandler & DecalHandler
[f=0000000] Creating GroundDrawer
[f=0000000] Loading Map Tiles
[f=0000000] [UDPConnection::ProcessRawPacket] 0 NETMSG_*FRAME packets received (1200.000000ms : 0.000000p/ms)
[f=0000000] Loading Square Textures
[f=0000000] CSMFGroundTextures::ConvolveHeightMap: 5 ms
[f=0000000] Switching to ROAM Mesh Rendering
[f=0000000] Creating TreeDrawer
[f=0000000] [UDPConnection::ProcessRawPacket] 0 NETMSG_*FRAME packets received (1200.000000ms : 0.000000p/ms)
[f=0000000] Creating ProjectileDrawer & UnitDrawer
[f=0000000] Creating Projectile Textures
[f=0000000] Warning: [CCEG::Load] krogtaarblaster: Unknown tag CSimpleParticleSystem::size
[f=0000000] Creating Water
[f=0000000] Game::LoadInterface (Camera&Mouse): 148 ms
[f=0000000] Game::LoadInterface (Console): 17 ms
[f=0000000] Loading LuaRules
[f=0000000] Loaded synced gadget:  Metalspot Finder Gadget  <mex_spot_finder.lua>
[f=0000000] Loaded synced gadget:  Rez Exp             <unit_rez_exp.lua>
[f=0000000] Loaded synced gadget:  ranks api           <api_ranks.lua>
[f=0000000] Loaded synced gadget:  No Self-D           <unit_prevent_share_selfd.lua>
[f=0000000] Loaded synced gadget:  CameraBroadcast     <camera_lockcamera.lua>
[f=0000000] Loaded synced gadget:  Awards              <gui_awards.lua>
[f=0000000] Loaded synced gadget:  Air Release         <unit_air_release_manager.lua>
[f=0000000] Loaded synced gadget:  AirPlantParents     <unit_air_plants.lua>
[f=0000000] Loaded synced gadget:  Bomber Control      <unit_bomber_control.lua>
[f=0000000] Loaded synced gadget:  Commando Watch      <unit_commando_watch.lua>
[f=0000000] Loaded synced gadget:  Cursor Broadcast    <cmd_mouse_pos_broadcast.lua>
[f=0000000] Loaded synced gadget:  DGun CmdType Fix    <unit_dgun_cmdtype_fix.lua>
[f=0000000] Loaded synced gadget:  Death Messages      <game_death_messages.lua>
[f=0000000] Loaded synced gadget:  DirectControl       <unit_direct_control.lua>
[f=0000000] Loaded synced gadget:  DragonsDisguise     <unit_set_neutral.lua>
[f=0000000] Loaded synced gadget:  Dynamic collision volume & Hitsphere Scaledown  <unit_dynamic_collision_volume.lua>
[f=0000000] Loaded synced gadget:  Energy Conversion   <game_energy_conversion.lua>
[f=0000000] Loaded synced gadget:  FinishedBuilding    <unit_finished_building.lua>
[f=0000000] Loaded synced gadget:  Game End            <game_end.lua>
[f=0000000] Loaded synced gadget:  Initial Spawn       <game_initial_spawn.lua>
[f=0000000] Loaded synced gadget:  Juno Damage         <unit_juno_damage.lua>
[f=0000000] Loaded synced gadget:  Lightning Spash Damage  <unit_lightning_splash_dmg.lua>
[f=0000000] Loaded synced gadget:  Lua unit script framework  <unit_script.lua>
[f=0000000] Loaded synced gadget:  Maverick Exp        <unit_maverick_exp.lua>
[f=0000000] Loaded synced gadget:  Merc/Scr stockpile control  <unit_mercscr_stockpile_limit.lua>
[f=0000000] Loaded synced gadget:  Napalm              <lups_napalm.lua>
[f=0000000] Loaded synced gadget:  No Land Damage      <unit_no_land_damage.lua>
[f=0000000] Loaded synced gadget:  No Self Pwn         <unit_noselfpwn.lua>
[f=0000000] Loaded synced gadget:  NoCost              <cmd_nocost.lua>
[f=0000000] Loaded synced gadget:  Nonblocking mines   <unit_nonblocking_mines.lua>
[f=0000000] Loaded synced gadget:  Paralyse Multiplier  <unit_paralyze_multiplier.lua>
[f=0000000] Loaded synced gadget:  Passive Builders II  <unit_passive_builders_ii.lua>
[f=0000000] Loaded synced gadget:  PopUpWaterStructures  <unit_pop_up_water_structures.lua>
[f=0000000] Loaded synced gadget:  Prevent Excessive Share  <game_prevent_excessive_share.lua>
[f=0000000] Loaded synced gadget:  Prevent Lab Hax     <unit_prevent_lab_hax.lua>
[f=0000000] Loaded synced gadget:  Prevent Load Hax    <unit_prevent_load_hax.lua>
[f=0000000] Loaded synced gadget:  Prevent Outside Aircraft hacks  <unit_prevent_aircraft_hax.lua>
[f=0000000] Loaded synced gadget:  Prevent Range Hax   <unit_prevent_range_hax.lua>
[f=0000000] Loaded synced gadget:  Prevent Strange Orders  <unit_prevent_strange_orders.lua>
[f=0000000] Loaded synced gadget:  Prevent Unload Hax  <unit_prevent_unload_hax.lua>
[f=0000000] Loaded synced gadget:  Reclaim Fix         <unit_reclaim_fix.lua>
[f=0000000] Loaded synced gadget:  Reclaim flash       <gfx_reclaim_flash.lua>
[f=0000000] Loaded synced gadget:  ShieldDrain         <unit_shield_watch.lua>
[f=0000000] Loaded synced gadget:  Shockwaves          <lups_shockwaves.lua>
[f=0000000] Loaded synced gadget:  Start Point Remover Gadget  <init_start_point_remover_gadget.lua>
[f=0000000] Loaded synced gadget:  Stealthy Passengers  <unit_stealthy_passengers.lua>
[f=0000000] Loaded synced gadget:  Target on the move  <unit_target_on_the_move.lua>
[f=0000000] Loaded synced gadget:  Team Resourcing     <game_team_resources.lua>
[f=0000000] Loaded synced gadget:  Transportee Hider   <unit_transportee_hider.lua>
[f=0000000] Loaded synced gadget:  Unit transportable nanos  <unit_transportable_nanos.lua>
[f=0000000] Loaded synced gadget:  Watereffects        <fx_watersplash.lua>
[f=0000000] Loaded synced gadget:  fx_reclaim_shards   <fx_reclaim_shards.lua>
[f=0000000] Loaded synced gadget:  fx_wreck_shards     <fx_wreck_shards.lua>
[f=0000000] Loaded synced gadget:  gfx_dynamic_lighting.lua  <gfx_dynamic_lighting.lua>
[f=0000000] Loaded synced gadget:  lups_wrapper.lua    <lups_wrapper.lua>
[f=0000000] Loaded synced gadget:  mo_combomb_full_damage  <mo_combomb_full_damage.lua>
[f=0000000] Loaded synced gadget:  mo_enemywrecks      <mo_enemywrecks.lua>
[f=0000000] Loaded synced gadget:  mo_noshare          <mo_noshare.lua>
[f=0000000] Loaded synced gadget:  transportfix        <unit_transportfix.lua>
[f=0000000] Loaded synced gadget:  Area Attack         <areaattack.lua>
[f=0000000] Loaded synced gadget:  C Is For Control    <comiscontrol.lua>
[f=0000000] Loaded synced gadget:  Coop II             <mo_coop_ii.lua>
[f=0000000] Loaded synced gadget:  CustomUnitShaders   <gfx_customunitshaders.lua>
[f=0000000] Loaded synced gadget:  Take Manager        <cmd_idle_players.lua>
[f=0000000] Loaded synced gadget:  Team Com Ends       <teamcomends.lua>
[f=0000000] Loaded synced gadget:  LupsSyncedManager   <lups_manager.lua>
[f=0000000] Loaded synced gadget:  Mex Upgrader Gadget  <unit_mex_upgrader.lua>
[f=0000000] Loaded synced gadget:  Crashing Aircraft   <unit_crashing_aircraft.lua>
[f=0000000] <LockCamera>: Sorry for the camera switch spam, but this is the only reliable way to list camera states other than hardcoding them
[f=0000000] Switching to Overview style camera
[f=0000000] Switching to Smooth style camera
[f=0000000] Switching to Overhead (TA) style camera
[f=0000000] Switching to Free style camera
[f=0000000] Switching to Total War style camera
[f=0000000] Switching to Rotatable overhead camera
[f=0000000] Switching to Orbit style camera
[f=0000000] Switching to FPS style camera
[f=0000000] Switching to Smooth style camera
[f=0000000] Loaded unsynced gadget:  Engine Taskbar Stuff  <engine_taskbar_stuff.lua>
[f=0000000] Loaded unsynced gadget:  Metalspot Finder Gadget  <mex_spot_finder.lua>
[f=0000000] Loaded unsynced gadget:  ranks api           <api_ranks.lua>
[f=0000000] Loaded unsynced gadget:  CustomIcons         <unit_customicons.lua>
[f=0000000] Loaded unsynced gadget:  CameraBroadcast     <camera_lockcamera.lua>
[f=0000000] Loaded unsynced gadget:  Awards              <gui_awards.lua>
[f=0000000] Loaded unsynced gadget:  Air Release         <unit_air_release_manager.lua>
[f=0000000] Loaded unsynced gadget:  AirPlantParents     <unit_air_plants.lua>
[f=0000000] Loaded unsynced gadget:  Cursor Broadcast    <cmd_mouse_pos_broadcast.lua>
[f=0000000] Loaded unsynced gadget:  DragonsDisguise     <unit_set_neutral.lua>
[f=0000000] Loaded unsynced gadget:  Dynamic collision volume & Hitsphere Scaledown  <unit_dynamic_collision_volume.lua>
[f=0000000] Loaded unsynced gadget:  FinishedBuilding    <unit_finished_building.lua>
[f=0000000] Loaded unsynced gadget:  Initial Spawn       <game_initial_spawn.lua>
[f=0000000] Loaded unsynced gadget:  Juno Damage         <unit_juno_damage.lua>
[f=0000000] Loaded unsynced gadget:  Merc/Scr stockpile control  <unit_mercscr_stockpile_limit.lua>
[f=0000000] Loaded unsynced gadget:  Napalm              <lups_napalm.lua>
[f=0000000] Loaded unsynced gadget:  NoCost              <cmd_nocost.lua>
[f=0000000] Loaded unsynced gadget:  PopUpWaterStructures  <unit_pop_up_water_structures.lua>
[f=0000000] Loaded unsynced gadget:  Prevent Unload Hax  <unit_prevent_unload_hax.lua>
[f=0000000] Loaded unsynced gadget:  Reclaim Fix         <unit_reclaim_fix.lua>
[f=0000000] Loaded unsynced gadget:  Reclaim flash       <gfx_reclaim_flash.lua>
[f=0000000] Loaded unsynced gadget:  ShieldDrain         <unit_shield_watch.lua>
[f=0000000] Loaded unsynced gadget:  Shockwaves          <lups_shockwaves.lua>
[f=0000000] Loaded unsynced gadget:  Start Point Remover Gadget  <init_start_point_remover_gadget.lua>
[f=0000000] Loaded unsynced gadget:  Target on the move  <unit_target_on_the_move.lua>
[f=0000000] Loaded unsynced gadget:  Transportee Hider   <unit_transportee_hider.lua>
[f=0000000] Loaded unsynced gadget:  Watereffects        <fx_watersplash.lua>
[f=0000000] Loaded unsynced gadget:  fx_reclaim_shards   <fx_reclaim_shards.lua>
[f=0000000] Loaded unsynced gadget:  fx_wreck_shards     <fx_wreck_shards.lua>
[f=0000000] Loaded unsynced gadget:  gfx_dynamic_lighting.lua  <gfx_dynamic_lighting.lua>
[f=0000000] Loaded unsynced gadget:  mo_enemywrecks      <mo_enemywrecks.lua>
[f=0000000] Loaded unsynced gadget:  mo_greenfields      <mo_greenfields.lua>
[f=0000000] Loaded unsynced gadget:  mo_noowner          <mo_noowner.lua>
[f=0000000] Loaded unsynced gadget:  mo_noshare          <mo_noshare.lua>
[f=0000000] Loaded unsynced gadget:  mo_nowrecks         <mo_nowrecks.lua>
[f=0000000] Loaded unsynced gadget:  transportfix        <unit_transportfix.lua>
[f=0000000] Loaded unsynced gadget:  Area Attack         <areaattack.lua>
[f=0000000] Loaded unsynced gadget:  C Is For Control    <comiscontrol.lua>
[f=0000000] Loaded unsynced gadget:  Coop II             <mo_coop_ii.lua>
[f=0000000] Loaded unsynced gadget:  CustomUnitShaders   <gfx_customunitshaders.lua>
[f=0000000] Loaded unsynced gadget:  Take Manager        <cmd_idle_players.lua>
[f=0000000] Loaded unsynced gadget:  LupsSyncedManager   <lups_manager.lua>
[f=0000000] Loaded unsynced gadget:  Mex Upgrader Gadget  <unit_mex_upgrader.lua>
[f=0000000] Loaded unsynced gadget:  Crashing Aircraft   <unit_crashing_aircraft.lua>
[f=0000000] Loaded unsynced gadget:  Lups                <lups_wrapper.lua>
[f=0000000] Loading LuaGaia
[f=0000000] Loading LuaUI
[f=0000000] LuaSocketEnabled: yes
[f=0000000] This game has locked LuaUI access
[f=0000000] This game has locked LuaUI access
[f=0000000] Using LUAUI_DIRNAME = LuaUI/
[f=0000000] Reloaded ctrlpanel from file: LuaUI/ctrlpanel.txt
[f=0000000] LuaUI: bound F11 to the widget selector
[f=0000000] LuaUI: bound CTRL+F11 to tweak mode
[f=0000000] Loading widget from mod:   Red_UI_Framework    <red_ui_framework.lua> ...
[f=0000000] Loading widget from mod:   Metalspot Finder    <wg_metalspot_finder.lua> ...
[f=0000000] Loading widget from mod:   Faction Change      <gui_faction_change.lua> ...
[f=0000000] Loading widget from mod:   MexUpg Helper       <cmd_mex_upgrade_helper.lua> ...
[f=0000000] Loading widget from mod:   Red Tooltip         <gui_red_tooltip.lua> ...
[f=0000000] Loading widget from mod:   HealthBars          <unit_healthbars.lua> ...
[f=0000000] [UDPConnection::ProcessRawPacket] 0 NETMSG_*FRAME packets received (1200.999878ms : 0.000000p/ms)
[f=0000000] Loading widget from mod:   LockCamera          <camera_lockcamera.lua> ...
[f=0000000] Loading widget from mod:   AdvPlayersList      <gui_advplayerslist.lua> ...
[f=0000000] Loading widget from mod:   BuildETA            <gui_build_eta.lua> ...
[f=0000000] Loading widget from mod:   Initial Queue       <unit_initial_queue.lua> ...
[f=0000000] Loading widget from mod:   Projectile lights   <gfx_projectile_lights.lua> ...
[f=0000000] Loading widget from mod:   Anti Range          <gui_anti_range.lua> ...
[f=0000000] Loading widget from mod:   Auto First Build Facing  <autofirstbuildfacing.lua> ...
[f=0000000] Loading widget from mod:   Auto group          <unit_auto_group.lua> ...
[f=0000000] Loading widget from mod:   Autoquit            <autoquit.lua> ...
[f=0000000] Loading widget from mod:   BA_AllyCursors      <gui_ba_ally_cursors.lua> ...
[f=0000000] Loading widget from mod:   Build Split         <cmd_buildsplit.lua> ...
[f=0000000] Loading widget from mod:   BuildBar            <gui_buildbar.lua> ...
[f=0000000] Loading widget from mod:   CameraFlip          <camera_flip.lua> ...
[f=0000000] Loading widget from mod:   Com Counter         <gui_comcounter.lua> ...
[f=0000000] Loading widget from mod:   Com DontBreakCloak  <unit_com_dontbreakcloak.lua> ...
[f=0000000] Loading widget from mod:   Defense Range       <gui_defenserange.lua> ...
[f=0000000] Loading widget from mod:   DontMove            <unit_dontmove.lua> ...
[f=0000000] Loading widget from mod:   Easy Facing         <gui_easyfacing.lua> ...
[f=0000000] Loading widget from mod:   Energy Conversion Info  <gui_energy_conversion.lua> ...
[f=0000000] Loading widget from mod:   GameTypeInfo        <gui_game_type_info.lua> ...
[f=0000000] Loading widget from mod:   Ghost Radar         <unit_ghostradar.lua> ...
[f=0000000] Loading widget from mod:   Ghost Site          <unit_ghostsite.lua> ...
[f=0000000] Loading widget from mod:   Group Label         <gui_group_label.lua> ...
[f=0000000] Loading widget from mod:   Highlight Geos      <gui_highlight_geos.lua> ...
[f=0000000] Loading widget from mod:   Holdfire Fix        <unit_holdfire_fix.lua> ...
[f=0000000] Loading widget from mod:   ImmobileBuilder     <unit_immobile_builder.lua> ...
[f=0000000] Loading widget from mod:   Load Own Moving     <unit_load_own_moving.lua> ...
[f=0000000] Loading widget from mod:   Loop Select         <unit_loop_select.lua> ...
[f=0000000] Loading widget from mod:   Mex Snap            <cmd_mex_snap.lua> ...
[f=0000000] Loading widget from mod:   MoreSounds          <unit_more_sounds.lua> ...
[f=0000000] Loading widget from mod:   NoDuplicateOrders   <cmd_no_duplicate_orders.lua> ...
[f=0000000] Loading widget from mod:   Pause Screen        <gui_pausescreen.lua> ...
[f=0000000] Loading widget from mod:   Persistent Build Spacing  <gui_persistent_build_spacing.lua> ...
[f=0000000] Loading widget from mod:   Point Tracker       <gui_point_tracker.lua> ...
[f=0000000] Loading widget from mod:   ReclaimInfo         <gui_reclaiminfo.lua> ...
[f=0000000] Loading widget from mod:   Red Build/Order Menu  <gui_red_buildordermenu.lua> ...
[f=0000000] Loading widget from mod:   Red Console         <gui_red_console.lua> ...
[f=0000000] Loading widget from mod:   Red Resource Bars   <gui_red_resourcebars.lua> ...
[f=0000000] Loading widget from mod:   Red_Drawing         <red_ui_framework_drawing.lua> ...
[f=0000000] Loading widget from mod:   RelativeMinimap     <minimap_relative.lua> ...
[f=0000000] Loading widget from mod:   SelectionButtons    <gui_selbuttons.lua> ...
[f=0000000] Loading widget from mod:   Share Tracker       <unit_share_tracker.lua> ...
[f=0000000] Loading widget from mod:   SmoothCam           <camera_smoothcam.lua> ...
[f=0000000] Loading widget from mod:   Specific Unit Reclaimer  <unit_specific_unit_reclaimer.lua> ...
[f=0000000] Loading widget from mod:   Spectate Selected   <gui_spectate_selected.lua> ...
[f=0000000] Loading widget from mod:   State Reverse Toggle  <cmd_state_reverse_toggle.lua> ...
[f=0000000] Loading widget from mod:   Stockpiler (dynamic)  <unit_stockpile_dynamic.lua> ...
[f=0000000] Loading widget from mod:   Take Proxy          <cmd_take_proxy.lua> ...
[f=0000000] Loading widget from mod:   Transport AI        <unit_transport_ai.lua> ...
[f=0000000] Loading widget from mod:   Volume OSD          <snd_volume_osd.lua> ...
[f=0000000] Loading widget from mod:   Wait reclaim        <cmd_wait_reclaim.lua> ...
[f=0000000] Loading widget from mod:   Attack AoE          <gui_attack_aoe.lua> ...
[f=0000000] Loading widget from mod:   Attack and Move Notification  <unit_attackmovenotification.lua> ...
[f=0000000] Loading widget from mod:   Building Hotkeys    <cmd_building_hotkeys.lua> ...
[f=0000000] Loading widget from mod:   Context Build       <cmd_context_build.lua> ...
[f=0000000] Loading widget from mod:   Prospector          <gui_prospector.lua> ...
[f=0000000] Loading widget from mod:   Red Minimap         <gui_red_minimap.lua> ...
[f=0000000] Loading widget from mod:   Set Target Hotkeys  <cmd_target_on_the_move_hotkeys.lua> ...
[f=0000000] Loading widget from mod:   BA Waypoint Dragger  <unit_waypoint_dragger_2.lua> ...
[f=0000000] Loading widget from mod:   Bomber control      <unit_bomber_control.lua> ...
[f=0000000] Loading widget from mod:   CommandInsert       <gui_commandinsert.lua> ...
[f=0000000] Loading widget from mod:   Rank Icons          <gui_xp.lua> ...
[f=0000000] Loading widget from mod:   Select n Center!    <gui_center_n_select.lua> ...
[f=0000000] Loading widget from mod:   LupsManager         <gfx_lups_manager.lua> ...
[f=0000000] Loading widget from mod:   Mouse Buildspacing  <gui_buildspacing.lua> ...
[f=0000000] Loading widget from mod:   Lups                <lups_wrapper.lua> ...
[f=0000000] Loading widget from mod:   CustomFormations2   <unit_customformations2.lua> ...
[f=0000000] Loading widget from user:  Frame jitter        <dbg_frame_jitter.lua> ...
[f=0000000] LuaUI v0.3
[f=0000000] Initializing PathCache
[f=0000000] Finalizing
[f=0000000] Loaded DecalsDrawer: Legacy
[f=0000000] Connection attempt from [teh]Beherith[PiRO]2
[f=0000000]  -> Version: 95.0.1-154-g240a8b9 develop
[f=0000000]  -> Connection established (given id 1)
[f=0000000] Connection attempt from [teh]Beherith[PiRO]
[f=0000000]  -> Version: 95.0.1-154-g240a8b9 develop
[f=0000000]  -> Connection established (given id 0)
[f=0000000] [UDPConnection::ProcessRawPacket] 0 NETMSG_*FRAME packets received (1026.000000ms : 0.000000p/ms)
[f=0000000] [UDPConnection::ProcessRawPacket] 0 NETMSG_*FRAME packets received (1160.000000ms : 0.000000p/ms)
[f=0000000] [UDPConnection::ProcessRawPacket] 0 NETMSG_*FRAME packets received (1032.000000ms : 0.000000p/ms)
[f=0000000] [UDPConnection::ProcessRawPacket] 0 NETMSG_*FRAME packets received (1112.000000ms : 0.000000p/ms)
[f=0000000] [UDPConnection::ProcessRawPacket] 0 NETMSG_*FRAME packets received (1116.999878ms : 0.000000p/ms)
[f=0000000] [UDPConnection::ProcessRawPacket] 0 NETMSG_*FRAME packets received (1148.000000ms : 0.000000p/ms)
[f=0000000] GameID: 0f3b9e5211d2222a1b2f769079b8f899
[f=0000005] [UDPConnection::ProcessRawPacket] 10 NETMSG_*FRAME packets received (1034.000000ms : 0.009671p/ms)
[f=0000006] gameframe, 6, delta time 0.05<, 0.13699999451637, percent bad frames=, 16.666666030884
[f=0000039] [UDPConnection::ProcessRawPacket] 33 NETMSG_*FRAME packets received (1131.000122ms : 0.029178p/ms)
[f=0000071] [UDPConnection::ProcessRawPacket] 33 NETMSG_*FRAME packets received (1080.000000ms : 0.030556p/ms)
[f=0000072] gameframe, 72, delta time 0.05<, 0.055999998003244, percent bad frames=, 2.777777671814
[f=0000090] gameframe, 90, delta time 0.05<, 0.052999999374151, percent bad frames=, 3.3333332538605
[f=0000101] [UDPConnection::ProcessRawPacket] 30 NETMSG_*FRAME packets received (987.000000ms : 0.030395p/ms)
[f=0000102] gameframe, 102, delta time 0.05<, 0.074999995529652, percent bad frames=, 3.9215686321259
[f=0000115] gameframe, 115, delta time 0.05<, 0.05799999833107, percent bad frames=, 4.3478260040283
[f=0000130] gameframe, 130, delta time 0.05<, 0.096999995410442, percent bad frames=, 4.6153845787048
[f=0000133] [UDPConnection::ProcessRawPacket] 32 NETMSG_*FRAME packets received (1067.000000ms : 0.029991p/ms)
[f=0000134] gameframe, 134, delta time 0.05<, 0.07599999755621, percent bad frames=, 5.2238807678223
[f=0000145] gameframe, 145, delta time 0.05<, 0.068999998271465, percent bad frames=, 5.5172414779663
[f=0000162] gameframe, 162, delta time 0.05<, 0.067999996244907, percent bad frames=, 5.5555553436279
[f=0000166] [UDPConnection::ProcessRawPacket] 32 NETMSG_*FRAME packets received (1095.000122ms : 0.029224p/ms)
[f=0000184] gameframe, 184, delta time 0.05<, 0.064999997615814, percent bad frames=, 5.4347825050354
[f=0000189] gameframe, 189, delta time 0.05<, 0.061999998986721, percent bad frames=, 5.8201060295105
[f=0000193] gameframe, 193, delta time 0.05<, 0.096000000834465, percent bad frames=, 6.217616558075
[f=0000198] [UDPConnection::ProcessRawPacket] 31 NETMSG_*FRAME packets received (1007.000000ms : 0.030785p/ms)
[f=0000202] gameframe, 202, delta time 0.05<, 0.077999994158745, percent bad frames=, 6.4356436729431
[f=0000211] gameframe, 211, delta time 0.05<, 0.070000000298023, percent bad frames=, 6.6350712776184
[f=0000225] gameframe, 225, delta time 0.05<, 0.054999999701977, percent bad frames=, 6.6666665077209
[f=0000228] [UDPConnection::ProcessRawPacket] 32 NETMSG_*FRAME packets received (1079.000122ms : 0.029657p/ms)
[f=0000229] gameframe, 229, delta time 0.05<, 0.074999995529652, percent bad frames=, 6.9868993759155
[f=0000248] gameframe, 248, delta time 0.05<, 0.059999998658895, percent bad frames=, 6.854838848114
[f=0000257] gameframe, 257, delta time 0.05<, 0.061999998986721, percent bad frames=, 7.0038909912109
[f=0000261] [UDPConnection::ProcessRawPacket] 33 NETMSG_*FRAME packets received (1100.999878ms : 0.029973p/ms)
[f=0000262] gameframe, 262, delta time 0.05<, 0.08899999409914, percent bad frames=, 7.2519083023071
[f=0000274] gameframe, 274, delta time 0.05<, 0.064999997615814, percent bad frames=, 7.2992701530457
[f=0000279] gameframe, 279, delta time 0.05<, 0.061999998986721, percent bad frames=, 7.5268816947937
[f=0000289] gameframe, 289, delta time 0.05<, 0.065999999642372, percent bad frames=, 7.6124567985535
[f=0000292] [UDPConnection::ProcessRawPacket] 31 NETMSG_*FRAME packets received (1030.000000ms : 0.030097p/ms)
[f=0000293] gameframe, 293, delta time 0.05<, 0.051999997347593, percent bad frames=, 7.8498291969299
[f=0000307] gameframe, 307, delta time 0.05<, 0.070000000298023, percent bad frames=, 7.8175897598267
[f=0000312] gameframe, 312, delta time 0.05<, 0.059999998658895, percent bad frames=, 8.0128202438354
[f=0000323] gameframe, 323, delta time 0.05<, 0.057000000029802, percent bad frames=, 8.0495357513428
[f=0000326] [UDPConnection::ProcessRawPacket] 34 NETMSG_*FRAME packets received (1138.000000ms : 0.029877p/ms)
[f=0000327] gameframe, 327, delta time 0.05<, 0.072999998927116, percent bad frames=, 8.2568807601929
[f=0000360] [UDPConnection::ProcessRawPacket] 32 NETMSG_*FRAME packets received (1076.000000ms : 0.029740p/ms)
[f=0000364] gameframe, 364, delta time 0.05<, 0.057000000029802, percent bad frames=, 7.692307472229
[f=0000369] gameframe, 369, delta time 0.05<, 0.081999994814396, percent bad frames=, 7.8590784072876
[f=0000373] gameframe, 373, delta time 0.05<, 0.07599999755621, percent bad frames=, 8.0428953170776
[f=0000389] [UDPConnection::ProcessRawPacket] 30 NETMSG_*FRAME packets received (982.000000ms : 0.030550p/ms)
[f=0000394] gameframe, 394, delta time 0.05<, 0.050999999046326, percent bad frames=, 7.8680205345154
[f=0000399] gameframe, 399, delta time 0.05<, 0.051999997347593, percent bad frames=, 8.0200500488281
[f=0000402] gameframe, 402, delta time 0.05<, 0.10399999469519, percent bad frames=, 8.2089548110962
[f=0000420] [UDPConnection::ProcessRawPacket] 30 NETMSG_*FRAME packets received (1022.000000ms : 0.029354p/ms)
[f=0000424] gameframe, 424, delta time 0.05<, 0.064999997615814, percent bad frames=, 8.0188674926758
[f=0000434] gameframe, 434, delta time 0.05<, 0.059999998658895, percent bad frames=, 8.0645160675049
[f=0000442] gameframe, 442, delta time 0.05<, 0.070999994874001, percent bad frames=, 8.14479637146
[f=0000451] [UDPConnection::ProcessRawPacket] 33 NETMSG_*FRAME packets received (1071.000000ms : 0.030812p/ms)
[f=0000476] gameframe, 476, delta time 0.05<, 0.051999997347593, percent bad frames=, 7.7731094360352
[f=0000483] [UDPConnection::ProcessRawPacket] 31 NETMSG_*FRAME packets received (1038.000000ms : 0.029865p/ms)
[f=0000488] gameframe, 488, delta time 0.05<, 0.077999994158745, percent bad frames=, 7.7868852615356
[f=0000503] gameframe, 503, delta time 0.05<, 0.059999998658895, percent bad frames=, 7.7534790039063
[f=0000508] gameframe, 508, delta time 0.05<, 0.050999999046326, percent bad frames=, 7.8740158081055
[f=0000516] [UDPConnection::ProcessRawPacket] 34 NETMSG_*FRAME packets received (1143.000122ms : 0.029746p/ms)
[f=0000517] gameframe, 517, delta time 0.05<, 0.063999995589256, percent bad frames=, 7.9303674697876
[f=0000533] gameframe, 533, delta time 0.05<, 0.060999996960163, percent bad frames=, 7.8799247741699
[f=0000548] [UDPConnection::ProcessRawPacket] 32 NETMSG_*FRAME packets received (1065.000000ms : 0.030047p/ms)
[f=0000549] gameframe, 549, delta time 0.05<, 0.093999996781349, percent bad frames=, 7.8324227333069
[f=0000554] gameframe, 554, delta time 0.05<, 0.050999999046326, percent bad frames=, 7.9422383308411
[f=0000562] gameframe, 562, delta time 0.05<, 0.063000001013279, percent bad frames=, 8.0071172714233
[f=0000567] gameframe, 567, delta time 0.05<, 0.067999996244907, percent bad frames=, 8.1128749847412
[f=0000571] gameframe, 571, delta time 0.05<, 0.090999998152256, percent bad frames=, 8.2311735153198
[f=0000581] [UDPConnection::ProcessRawPacket] 32 NETMSG_*FRAME packets received (1084.000000ms : 0.029520p/ms)
[f=0000586] gameframe, 586, delta time 0.05<, 0.061999998986721, percent bad frames=, 8.191125869751
[f=0000609] gameframe, 609, delta time 0.05<, 0.081999994814396, percent bad frames=, 8.0459766387939
[f=0000612] [UDPConnection::ProcessRawPacket] 32 NETMSG_*FRAME packets received (1057.000000ms : 0.030274p/ms)
[f=0000613] gameframe, 613, delta time 0.05<, 0.072999998927116, percent bad frames=, 8.1566066741943
[f=0000641] gameframe, 641, delta time 0.05<, 0.071999996900558, percent bad frames=, 7.9563183784485
[f=0000645] [UDPConnection::ProcessRawPacket] 32 NETMSG_*FRAME packets received (1071.000000ms : 0.029879p/ms)
[f=0000650] gameframe, 650, delta time 0.05<, 0.050999999046326, percent bad frames=, 8
[f=0000673] gameframe, 673, delta time 0.05<, 0.070000000298023, percent bad frames=, 7.8751859664917
[f=0000676] [UDPConnection::ProcessRawPacket] 32 NETMSG_*FRAME packets received (1053.000000ms : 0.030389p/ms)
[f=0000677] gameframe, 677, delta time 0.05<, 0.058999996632338, percent bad frames=, 7.976366519928
[f=0000682] gameframe, 682, delta time 0.05<, 0.053999997675419, percent bad frames=, 8.0645160675049
[f=0000692] gameframe, 692, delta time 0.05<, 0.063999995589256, percent bad frames=, 8.0924854278564
[f=0000696] gameframe, 696, delta time 0.05<, 0.081999994814396, percent bad frames=, 8.1896553039551
[f=0000710] [UDPConnection::ProcessRawPacket] 33 NETMSG_*FRAME packets received (1115.000122ms : 0.029596p/ms)
[f=0000730] gameframe, 730, delta time 0.05<, 0.081000000238419, percent bad frames=, 7.9452056884766
[f=0000741] [UDPConnection::ProcessRawPacket] 32 NETMSG_*FRAME packets received (1044.000000ms : 0.030651p/ms)
[f=0000742] gameframe, 742, delta time 0.05<, 0.054999999701977, percent bad frames=, 7.95148229599
[f=0000747] gameframe, 747, delta time 0.05<, 0.053999997675419, percent bad frames=, 8.0321283340454
[f=0000755] gameframe, 755, delta time 0.05<, 0.068999998271465, percent bad frames=, 8.0794706344604
[f=0000761] gameframe, 761, delta time 0.05<, 0.063999995589256, percent bad frames=, 8.1471748352051
[f=0000765] gameframe, 765, delta time 0.05<, 0.054999999701977, percent bad frames=, 8.235294342041
[f=0000769] gameframe, 769, delta time 0.05<, 0.077999994158745, percent bad frames=, 8.3224964141846
[f=0000773] [UDPConnection::ProcessRawPacket] 30 NETMSG_*FRAME packets received (1028.000000ms : 0.029183p/ms)
[f=0000787] gameframe, 787, delta time 0.05<, 0.064999997615814, percent bad frames=, 8.2592124938965
[f=0000792] gameframe, 792, delta time 0.05<, 0.052999999374151, percent bad frames=, 8.3333330154419
[f=0000796] gameframe, 796, delta time 0.05<, 0.063000001013279, percent bad frames=, 8.417085647583
[f=0000801] [UDPConnection::ProcessRawPacket] 30 NETMSG_*FRAME packets received (966.000000ms : 0.031056p/ms)
[f=0000802] gameframe, 802, delta time 0.05<, 0.057000000029802, percent bad frames=, 8.4788026809692
[f=0000807] gameframe, 807, delta time 0.05<, 0.059999998658895, percent bad frames=, 8.5501861572266
[f=0000817] gameframe, 817, delta time 0.05<, 0.061999998986721, percent bad frames=, 8.5679311752319
[f=0000822] gameframe, 822, delta time 0.05<, 0.055999998003244, percent bad frames=, 8.637469291687
[f=0000826] gameframe, 826, delta time 0.05<, 0.072999998927116, percent bad frames=, 8.7167072296143
[f=0000832] [UDPConnection::ProcessRawPacket] 31 NETMSG_*FRAME packets received (1039.000000ms : 0.029836p/ms)
[f=0000850] gameframe, 850, delta time 0.05<, 0.065999999642372, percent bad frames=, 8.5882349014282
[f=0000855] gameframe, 855, delta time 0.05<, 0.06700000166893, percent bad frames=, 8.6549711227417
[f=0000865] [UDPConnection::ProcessRawPacket] 32 NETMSG_*FRAME packets received (1062.000000ms : 0.030132p/ms)
[f=0000870] gameframe, 870, delta time 0.05<, 0.078999996185303, percent bad frames=, 8.6206893920898
[f=0000874] gameframe, 874, delta time 0.05<, 0.068999998271465, percent bad frames=, 8.6956520080566
[f=0000886] gameframe, 886, delta time 0.05<, 0.058999996632338, percent bad frames=, 8.6907453536987
[f=0000891] gameframe, 891, delta time 0.05<, 0.06700000166893, percent bad frames=, 8.7542085647583
[f=0000895] gameframe, 895, delta time 0.05<, 0.061999998986721, percent bad frames=, 8.8268156051636
[f=0000897] [UDPConnection::ProcessRawPacket] 31 NETMSG_*FRAME packets received (1048.000000ms : 0.029580p/ms)
[f=0000906] gameframe, 906, delta time 0.05<, 0.094999998807907, percent bad frames=, 8.8300218582153
[f=0000915] gameframe, 915, delta time 0.05<, 0.068999998271465, percent bad frames=, 8.8524589538574
[f=0000923] gameframe, 923, delta time 0.05<, 0.058999996632338, percent bad frames=, 8.8840732574463
[f=0000927] [UDPConnection::ProcessRawPacket] 30 NETMSG_*FRAME packets received (1019.000000ms : 0.029441p/ms)
[f=0000931] gameframe, 931, delta time 0.05<, 0.092000000178814, percent bad frames=, 8.9151449203491
[f=0000936] gameframe, 936, delta time 0.05<, 0.052999999374151, percent bad frames=, 8.9743585586548
[f=0000943] gameframe, 943, delta time 0.05<, 0.052999999374151, percent bad frames=, 9.0137853622437
[f=0000947] gameframe, 947, delta time 0.05<, 0.087999999523163, percent bad frames=, 9.0813093185425
[f=0000951] gameframe, 951, delta time 0.05<, 0.077999994158745, percent bad frames=, 9.1482648849487
[f=0000956] [UDPConnection::ProcessRawPacket] 30 NETMSG_*FRAME packets received (970.000000ms : 0.030928p/ms)
[f=0000965] gameframe, 965, delta time 0.05<, 0.055999998003244, percent bad frames=, 9.1191711425781
[f=0000970] gameframe, 970, delta time 0.05<, 0.059999998658895, percent bad frames=, 9.1752576828003
[f=0000982] gameframe, 982, delta time 0.05<, 0.070000000298023, percent bad frames=, 9.1649694442749
[f=0000986] [UDPConnection::ProcessRawPacket] 30 NETMSG_*FRAME packets received (1028.000000ms : 0.029183p/ms)
[f=0000994] gameframe, 994, delta time 0.05<, 0.064999997615814, percent bad frames=, 9.1549291610718
[f=0000999] gameframe, 999, delta time 0.05<, 0.08500000089407, percent bad frames=, 9.2092094421387
[f=0001015] [UDPConnection::ProcessRawPacket] 30 NETMSG_*FRAME packets received (971.000000ms : 0.030896p/ms)
[f=0001016] gameframe, 1016, delta time 0.05<, 0.052999999374151, percent bad frames=, 9.15354347229
[f=0001031] gameframe, 1031, delta time 0.05<, 0.092999994754791, percent bad frames=, 9.1173620223999
[f=0001036] gameframe, 1036, delta time 0.05<, 0.051999997347593, percent bad frames=, 9.1698837280273
[f=0001042] gameframe, 1042, delta time 0.05<, 0.051999997347593, percent bad frames=, 9.2130517959595
[f=0001046] [UDPConnection::ProcessRawPacket] 30 NETMSG_*FRAME packets received (1032.000000ms : 0.029070p/ms)
[f=0001061] gameframe, 1061, delta time 0.05<, 0.055999998003244, percent bad frames=, 9.1423187255859
[f=0001067] gameframe, 1067, delta time 0.05<, 0.057000000029802, percent bad frames=, 9.1846294403076
[f=0001078] [UDPConnection::ProcessRawPacket] 32 NETMSG_*FRAME packets received (1032.000000ms : 0.031008p/ms)
[f=0001090] gameframe, 1090, delta time 0.05<, 0.074999995529652, percent bad frames=, 9.0825691223145
[f=0001094] gameframe, 1094, delta time 0.05<, 0.063000001013279, percent bad frames=, 9.1407680511475
[f=0001107] gameframe, 1107, delta time 0.05<, 0.063000001013279, percent bad frames=, 9.12375831604
[f=0001111] [UDPConnection::ProcessRawPacket] 33 NETMSG_*FRAME packets received (1132.000000ms : 0.029152p/ms)
[f=0001112] gameframe, 1112, delta time 0.05<, 0.063000001013279, percent bad frames=, 9.172661781311
[f=0001116] gameframe, 1116, delta time 0.05<, 0.072999998927116, percent bad frames=, 9.2293910980225
[f=0001127] gameframe, 1127, delta time 0.05<, 0.057000000029802, percent bad frames=, 9.2280387878418
[f=0001132] gameframe, 1132, delta time 0.05<, 0.064999997615814, percent bad frames=, 9.2756185531616
[f=0001136] gameframe, 1136, delta time 0.05<, 0.050999999046326, percent bad frames=, 9.3309860229492
[f=0001143] [UDPConnection::ProcessRawPacket] 33 NETMSG_*FRAME packets received (1087.000122ms : 0.030359p/ms)
[f=0001144] gameframe, 1144, delta time 0.05<, 0.11499999463558, percent bad frames=, 9.3531465530396
[f=0001153] gameframe, 1153, delta time 0.05<, 0.071999996900558, percent bad frames=, 9.3668689727783
[f=0001157] gameframe, 1157, delta time 0.05<, 0.052999999374151, percent bad frames=, 9.420916557312
[f=0001175] [UDPConnection::ProcessRawPacket] 32 NETMSG_*FRAME packets received (1050.000000ms : 0.030476p/ms)
[f=0001185] gameframe, 1185, delta time 0.05<, 0.070000000298023, percent bad frames=, 9.2827005386353
[f=0001189] gameframe, 1189, delta time 0.05<, 0.059999998658895, percent bad frames=, 9.3355760574341
[f=0001194] gameframe, 1194, delta time 0.05<, 0.054999999701977, percent bad frames=, 9.3802347183228
[f=0001204] gameframe, 1204, delta time 0.05<, 0.070000000298023, percent bad frames=, 9.3853816986084
[f=0001208] [UDPConnection::ProcessRawPacket] 31 NETMSG_*FRAME packets received (1044.000000ms : 0.029693p/ms)
[f=0001212] gameframe, 1212, delta time 0.05<, 0.068999998271465, percent bad frames=, 9.4059410095215
[f=0001222] gameframe, 1222, delta time 0.05<, 0.050999999046326, percent bad frames=, 9.4108018875122
[f=0001238] [UDPConnection::ProcessRawPacket] 31 NETMSG_*FRAME packets received (1053.000000ms : 0.029440p/ms)
[f=0001239] gameframe, 1239, delta time 0.05<, 0.060999996960163, percent bad frames=, 9.3623886108398
[f=0001243] gameframe, 1243, delta time 0.05<, 0.060999996960163, percent bad frames=, 9.4127111434937
[f=0001251] gameframe, 1251, delta time 0.05<, 0.061999998986721, percent bad frames=, 9.4324541091919
[f=0001256] gameframe, 1256, delta time 0.05<, 0.065999999642372, percent bad frames=, 9.4745225906372
[f=0001265] gameframe, 1265, delta time 0.05<, 0.05799999833107, percent bad frames=, 9.4861660003662
[f=0001268] [UDPConnection::ProcessRawPacket] 31 NETMSG_*FRAME packets received (1016.000000ms : 0.030512p/ms)
[f=0001269] gameframe, 1269, delta time 0.05<, 0.078999996185303, percent bad frames=, 9.5350666046143
[f=0001297] gameframe, 1297, delta time 0.05<, 0.070000000298023, percent bad frames=, 9.406322479248
[f=0001300] [UDPConnection::ProcessRawPacket] 32 NETMSG_*FRAME packets received (1067.000000ms : 0.029991p/ms)
[f=0001313] gameframe, 1313, delta time 0.05<, 0.059999998658895, percent bad frames=, 9.3678598403931
[f=0001325] gameframe, 1325, delta time 0.05<, 0.07599999755621, percent bad frames=, 9.3584909439087
[f=0001329] gameframe, 1329, delta time 0.05<, 0.07599999755621, percent bad frames=, 9.4055681228638
[f=0001333] [UDPConnection::ProcessRawPacket] 32 NETMSG_*FRAME packets received (1091.000122ms : 0.029331p/ms)
[f=0001334] gameframe, 1334, delta time 0.05<, 0.063000001013279, percent bad frames=, 9.4452772140503
[f=0001350] gameframe, 1350, delta time 0.05<, 0.063000001013279, percent bad frames=, 9.4074077606201
[f=0001361] gameframe, 1361, delta time 0.05<, 0.089999996125698, percent bad frames=, 9.4048490524292
[f=0001365] [UDPConnection::ProcessRawPacket] 32 NETMSG_*FRAME packets received (1066.000000ms : 0.030019p/ms)
[f=0001370] gameframe, 1370, delta time 0.05<, 0.061999998986721, percent bad frames=, 9.4160585403442
[f=0001388] gameframe, 1388, delta time 0.05<, 0.051999997347593, percent bad frames=, 9.3659944534302
[f=0001394] gameframe, 1394, delta time 0.05<, 0.083999998867512, percent bad frames=, 9.3974170684814
[f=0001398] [UDPConnection::ProcessRawPacket] 32 NETMSG_*FRAME packets received (1056.000000ms : 0.030303p/ms)
[f=0001402] gameframe, 1402, delta time 0.05<, 0.06700000166893, percent bad frames=, 9.4151210784912
[f=0001430] [UDPConnection::ProcessRawPacket] 34 NETMSG_*FRAME packets received (1108.999878ms : 0.030658p/ms)
[f=0001431] gameframe, 1431, delta time 0.05<, 0.070000000298023, percent bad frames=, 9.2941999435425
[f=0001461] [UDPConnection::ProcessRawPacket] 30 NETMSG_*FRAME packets received (1033.000000ms : 0.029042p/ms)
[f=0001462] gameframe, 1462, delta time 0.05<, 0.070000000298023, percent bad frames=, 9.1655263900757
[f=0001466] gameframe, 1466, delta time 0.05<, 0.08500000089407, percent bad frames=, 9.2087316513062
[f=0001481] gameframe, 1481, delta time 0.05<, 0.053999997675419, percent bad frames=, 9.1829843521118
[f=0001489] gameframe, 1489, delta time 0.05<, 0.064999997615814, percent bad frames=, 9.2008056640625
[f=0001493] [UDPConnection::ProcessRawPacket] 32 NETMSG_*FRAME packets received (1045.000000ms : 0.030622p/ms)
[f=0001505] gameframe, 1505, delta time 0.05<, 0.063999995589256, percent bad frames=, 9.1694355010986
[f=0001510] gameframe, 1510, delta time 0.05<, 0.05799999833107, percent bad frames=, 9.2052984237671
[f=0001514] gameframe, 1514, delta time 0.05<, 0.071999996900558, percent bad frames=, 9.2470273971558
[f=0001526] [UDPConnection::ProcessRawPacket] 34 NETMSG_*FRAME packets received (1124.999878ms : 0.030222p/ms)
[f=0001544] gameframe, 1544, delta time 0.05<, 0.059999998658895, percent bad frames=, 9.1321239471436
[f=0001548] gameframe, 1548, delta time 0.05<, 0.074999995529652, percent bad frames=, 9.1731262207031
[f=0001560] [UDPConnection::ProcessRawPacket] 32 NETMSG_*FRAME packets received (1067.000000ms : 0.029991p/ms)
[f=0001564] gameframe, 1564, delta time 0.05<, 0.07599999755621, percent bad frames=, 9.1432228088379
[f=0001575] gameframe, 1575, delta time 0.05<, 0.096999995410442, percent bad frames=, 9.1428575515747
[f=0001586] gameframe, 1586, delta time 0.05<, 0.072999998927116, percent bad frames=, 9.1424970626831
[f=0001590] [UDPConnection::ProcessRawPacket] 32 NETMSG_*FRAME packets received (1061.000000ms : 0.030160p/ms)
[f=0001604] gameframe, 1604, delta time 0.05<, 0.05799999833107, percent bad frames=, 9.1022443771362
[f=0001611] gameframe, 1611, delta time 0.05<, 0.061999998986721, percent bad frames=, 9.1247673034668
[f=0001624] [UDPConnection::ProcessRawPacket] 34 NETMSG_*FRAME packets received (1144.999878ms : 0.029694p/ms)
[f=0001625] gameframe, 1625, delta time 0.05<, 0.064999997615814, percent bad frames=, 9.1076927185059
[f=0001633] gameframe, 1633, delta time 0.05<, 0.10799999535084, percent bad frames=, 9.1243114471436
[f=0001655] [UDPConnection::ProcessRawPacket] 31 NETMSG_*FRAME packets received (1037.000000ms : 0.029894p/ms)
[f=0001656] gameframe, 1656, delta time 0.05<, 0.063999995589256, percent bad frames=, 9.0579710006714
[f=0001665] gameframe, 1665, delta time 0.05<, 0.061999998986721, percent bad frames=, 9.0690689086914
[f=0001669] gameframe, 1669, delta time 0.05<, 0.092999994754791, percent bad frames=, 9.107250213623
[f=0001674] gameframe, 1674, delta time 0.05<, 0.052999999374151, percent bad frames=, 9.1397848129272
[f=0001686] [UDPConnection::ProcessRawPacket] 31 NETMSG_*FRAME packets received (1035.000000ms : 0.029952p/ms)
[f=0001692] gameframe, 1692, delta time 0.05<, 0.059999998658895, percent bad frames=, 9.1016550064087
[f=0001697] gameframe, 1697, delta time 0.05<, 0.081000000238419, percent bad frames=, 9.1337652206421
[f=0001703] gameframe, 1703, delta time 0.05<, 0.063999995589256, percent bad frames=, 9.1603050231934
[f=0001707] gameframe, 1707, delta time 0.05<, 0.092999994754791, percent bad frames=, 9.1974220275879
[f=0001717] [UDPConnection::ProcessRawPacket] 30 NETMSG_*FRAME packets received (1014.000000ms : 0.029586p/ms)
[f=0001735] gameframe, 1735, delta time 0.05<, 0.076999999582767, percent bad frames=, 9.1066284179688
[f=0001748] [UDPConnection::ProcessRawPacket] 32 NETMSG_*FRAME packets received (1055.000000ms : 0.030332p/ms)
[f=0001749] gameframe, 1749, delta time 0.05<, 0.063999995589256, percent bad frames=, 9.0909090042114
[f=0001758] gameframe, 1758, delta time 0.05<, 0.057000000029802, percent bad frames=, 9.1012516021729
[f=0001763] gameframe, 1763, delta time 0.05<, 0.092999994754791, percent bad frames=, 9.1321611404419
[f=0001767] gameframe, 1767, delta time 0.05<, 0.083999998867512, percent bad frames=, 9.1680812835693
[f=0001780] [UDPConnection::ProcessRawPacket] 32 NETMSG_*FRAME packets received (1062.000000ms : 0.030132p/ms)
[f=0001781] gameframe, 1781, delta time 0.05<, 0.061999998986721, percent bad frames=, 9.1521615982056
[f=0001812] [UDPConnection::ProcessRawPacket] 32 NETMSG_*FRAME packets received (1065.000000ms : 0.030047p/ms)
[f=0001831] gameframe, 1831, delta time 0.05<, 0.064999997615814, percent bad frames=, 8.9568538665771
[f=0001836] gameframe, 1836, delta time 0.05<, 0.061999998986721, percent bad frames=, 8.986927986145
[f=0001841] gameframe, 1841, delta time 0.05<, 0.059999998658895, percent bad frames=, 9.0168390274048
[f=0001844] [UDPConnection::ProcessRawPacket] 32 NETMSG_*FRAME packets received (1066.000000ms : 0.030019p/ms)
[f=0001845] gameframe, 1845, delta time 0.05<, 0.11099999397993, percent bad frames=, 9.0514907836914
[f=0001868] gameframe, 1868, delta time 0.05<, 0.061999998986721, percent bad frames=, 8.9935760498047
[f=0001873] gameframe, 1873, delta time 0.05<, 0.055999998003244, percent bad frames=, 9.0229578018188
[f=0001876] [UDPConnection::ProcessRawPacket] 32 NETMSG_*FRAME packets received (1068.000000ms : 0.029963p/ms)
[f=0001877] gameframe, 1877, delta time 0.05<, 0.07599999755621, percent bad frames=, 9.0570058822632
[f=0001906] gameframe, 1906, delta time 0.05<, 0.05799999833107, percent bad frames=, 8.9716682434082
[f=0001910] [UDPConnection::ProcessRawPacket] 33 NETMSG_*FRAME packets received (1116.000000ms : 0.029570p/ms)
[f=0001911] gameframe, 1911, delta time 0.05<, 0.059999998658895, percent bad frames=, 9.0005235671997
[f=0001915] gameframe, 1915, delta time 0.05<, 0.076999999582767, percent bad frames=, 9.0339422225952
[f=0001939] gameframe, 1939, delta time 0.05<, 0.11999999731779, percent bad frames=, 8.9736976623535
[f=0001943] [UDPConnection::ProcessRawPacket] 34 NETMSG_*FRAME packets received (1106.000000ms : 0.030741p/ms)
[f=0001970] gameframe, 1970, delta time 0.05<, 0.074999995529652, percent bad frames=, 8.8832483291626
[f=0001974] [UDPConnection::ProcessRawPacket] 31 NETMSG_*FRAME packets received (1070.000000ms : 0.028972p/ms)
[f=0001975] gameframe, 1975, delta time 0.05<, 0.063999995589256, percent bad frames=, 8.9113922119141
[f=0001986] gameframe, 1986, delta time 0.05<, 0.081000000238419, percent bad frames=, 8.9123868942261
[f=0002007] [UDPConnection::ProcessRawPacket] 31 NETMSG_*FRAME packets received (1016.000000ms : 0.030512p/ms)
[f=0002011] gameframe, 2011, delta time 0.05<, 0.070999994874001, percent bad frames=, 8.8513174057007
[f=0002017] gameframe, 2017, delta time 0.05<, 0.051999997347593, percent bad frames=, 8.874566078186
[f=0002022] gameframe, 2022, delta time 0.05<, 0.055999998003244, percent bad frames=, 8.9020767211914
[f=0002026] gameframe, 2026, delta time 0.05<, 0.092999994754791, percent bad frames=, 8.9338598251343
[f=0002036] [UDPConnection::ProcessRawPacket] 31 NETMSG_*FRAME packets received (1014.000000ms : 0.030572p/ms)
[f=0002048] gameframe, 2048, delta time 0.05<, 0.064999997615814, percent bad frames=, 8.88671875
[f=0002053] gameframe, 2053, delta time 0.05<, 0.061999998986721, percent bad frames=, 8.9137849807739
[f=0002058] gameframe, 2058, delta time 0.05<, 0.058999996632338, percent bad frames=, 8.9407196044922
[f=0002067] [UDPConnection::ProcessRawPacket] 30 NETMSG_*FRAME packets received (1028.000000ms : 0.029183p/ms)
[f=0002068] gameframe, 2068, delta time 0.05<, 0.052999999374151, percent bad frames=, 8.9458417892456
[f=0002074] gameframe, 2074, delta time 0.05<, 0.063000001013279, percent bad frames=, 8.9681777954102
[f=0002084] gameframe, 2084, delta time 0.05<, 0.06700000166893, percent bad frames=, 8.9731283187866
[f=0002100] [UDPConnection::ProcessRawPacket] 32 NETMSG_*FRAME packets received (1062.000000ms : 0.030132p/ms)
[f=0002111] gameframe, 2111, delta time 0.05<, 0.11299999803305, percent bad frames=, 8.9057321548462
[f=0002129] [UDPConnection::ProcessRawPacket] 32 NETMSG_*FRAME packets received (1046.000000ms : 0.030593p/ms)
[f=0002163] [UDPConnection::ProcessRawPacket] 31 NETMSG_*FRAME packets received (1051.000000ms : 0.029496p/ms)
[f=0002167] gameframe, 2167, delta time 0.05<, 0.076999999582767, percent bad frames=, 8.7217350006104
[f=0002184] gameframe, 2184, delta time 0.05<, 0.10199999809265, percent bad frames=, 8.6996335983276
[f=0002186] [SpringApp::ShutDown][1]
[f=0002186] [ThreadPool::SetThreadCount][1] #wanted=0 #current=3
[f=0002186] [ThreadPool::SetThreadCount][2] #threads=0
[f=0002186] [SpringApp::ShutDown][2]
[f=0002186] [~CGame][1]
[f=0002186] [~CGame][2]
[f=0002186] [~CGame][3]
[f=0002186] [~CGame][4]
[f=0002186] [~CGame][5]
[f=0002186] [~CGame][6]
[f=0002186] Red_UI_Framework>> last processed widget was "Red Tooltip"
[f=0002186] Red_Drawing>> last processed widget was "Red Tooltip"
[f=0002186] [~CGame][7]
[f=0002186] [~CGame][8]
[f=0002186] [CCollisionHandler] dis-/continuous tests: 0/59728
[f=0002186] [~CGame][9]
[f=0002186] [~CGame][10]
[f=0002186] [~CPathCache(40x20)] cacheHits=0 hitPercentage=0% numHashColls=0 maxCacheSize=0
[f=0002186] [~CPathCache(40x20)] cacheHits=0 hitPercentage=0% numHashColls=0 maxCacheSize=0
[f=0002186] [~CPathCache(160x80)] cacheHits=0 hitPercentage=0% numHashColls=0 maxCacheSize=0
[f=0002186] [~CPathCache(160x80)] cacheHits=0 hitPercentage=0% numHashColls=0 maxCacheSize=0
[f=0002186] Statistics for RectangleOptimizer: 0%
[f=0002186] Statistics for RectangleOptimizer: 0%
[f=0002186] [~CGame][11]
[f=0002186] [~CGame][12]
[f=0002186] [~CGame][13]
[f=0002186] [~CGame][14]
[f=0002186] [Sound] [~CSound][1] soundThread=031C1F70
[f=0002186] [Sound] [~CSound][2]
[f=0002186] [Sound] [~CSound][3]
[f=0002186] [~CGame][15]
[f=0002186] [SpringApp::ShutDown][3]
[f=0002186] [SpringApp::ShutDown][4]
[f=0002186] Statistics for UDP connection:
Received: 16309 bytes in 732 packets (22.2801 bytes/package)
Sent: 38622 bytes in 1245 packets (31.0217 bytes/package)
Relative protocol overhead: 0 up, 0.269299 down
1 incoming chunks dropped, 3 outgoing chunks resent

[f=0002186] Writing demo: demos/20131203_211136_DeltaSiegeDry_95.0.1-154-g240a8b9 develop.sdf
[f=0002186] [SpringApp::ShutDown][5]
[f=0002186] [SpringApp::ShutDown][6]
[f=0002186] [SpringApp::ShutDown][7]
[f=0002186] [SpringApp::ShutDown][8]
[f=0002186] [SpringApp::ShutDown][9]
[SpringApp::ShutDown][10]
[SpringApp::ShutDown][11]
[WatchDog::Uninstall][1] hangDetectorThread=031C1ED0
[WatchDog::Uninstall][2]
[WatchDog::Uninstall][3]
[SpringApp::ShutDown][12]
[SpringApp::Run] exitCode=0
    txt file icon infolog_154_client.txt (59,264 bytes) 2013-12-03 21:13 +

-Relationships
+Relationships

-Notes

~0012221

Beherith (reporter)

2013-11-27 01:32

Last edited: 2013-11-27 01:40

View 3 revisions

 infolog.2.txt. is my PC (client) with the widget enabled and /debug on to show CTO assert failures
infolog.3.txt is the pc (laptop) that hosted the game, on same LAN as my pc. /debug and widget on.
infolog.4.txt is silentwing's pc (client) with the widget enabled and /debug on to show CTO assert failures

The test game considered of /cheat, /nocost, each player builds 2 labs on dsd and puts them on repeat to build fighters and kbots or vehicles, and we sent the units towards each other. Orders were not spammed at the units. Also tested with just 100 fighters patrolling in a circle, same results. Replays available on request, didnt want to clutter this report further.

All tests were done with BA 7.84, except on engine 91, where 7.76 was used. Map was DSD.

~0012223

Kloot (developer)

2013-11-27 03:00

 "The error occurs iff someone is spectating or playing a live game"

You really should have tested with 95+ which logs additional debugging info precisely to find out what the relation to live games is...

~0012224

Beherith (reporter)

2013-11-27 11:49

Last edited: 2013-11-27 11:53

View 2 revisions

 Sure! I attached the results of testing with 95.0.1-99
I tested on my LAN with two pcs, everything described above for 95.0 is applicable to these results. The host PC is still butter smooth, the client is pretty jittery. Need the replay file too? Need help in setting up a hosted test game? Ill help with anything you ask me to.

~0012225

Kloot (developer)

2013-11-27 18:33

Last edited: 2013-11-27 18:46

View 2 revisions

 Ok, please do the following:

1) grab build 112-g5b4d186
2) on the machine you use as host, open springsettings.cfg and add "ServerLogDebugMessages = 1" (this will FLOOD its infolog, so make sure to set LogFlush = 0)
3) run another LAN game (doesn't need to be long, just enough to catch some instances of serious jitter) and then upload the host's infolog

~0012226

Beherith (reporter)

2013-11-27 21:59

Last edited: 2013-11-27 22:00

View 2 revisions

 Done! Thanks :)

~0012229

Kloot (developer)

2013-11-27 23:06

Last edited: 2013-11-27 23:07

View 2 revisions

 Meh... server timings appear to check out, it consistently pushes simframe messages every 30 milliseconds (3 or 4 Update()'s which are spaced 10ms apart). So the problem is (unfortunately) in the network layer.

~0012230

Beherith (reporter)

2013-11-27 23:18

 Should I try hosting and playing on the same PC?

~0012231

Kloot (developer)

2013-11-27 23:39

Last edited: 2013-11-28 00:31

View 2 revisions

 Sure, just know that a client on the same machine as the server will still connect over UDP and latency/packet loss should be comparable to LAN conditions (as in none) so while you should do that test for the sake of completeness I don't expect the results to change.

edit: when you get around to it, please use build 115-g65dc8b4

~0012232

Beherith (reporter)

2013-11-28 00:59

Last edited: 2013-11-28 00:59

View 2 revisions

 You are seriously making my day brighter :) . Ok, ill test with 115. Also, if this the error is in the network layer, then is it completely out of our control?

~0012233

Beherith (reporter)

2013-11-28 01:55

 Ok tested, with ServerLogDebugMessages and two pc's (didnt have time to try it on one, ping me again if you still feel it is needed). Infologs attached.

~0012234

Kloot (developer)

2013-11-28 02:03

Last edited: 2013-11-28 02:16

View 2 revisions

 Players indeed can not do anything, unless it turns out to be caused by some obscure network config setting whose value got reset in the change from 94 to 95 (unlikely). The fact that there is no jitter in local games also rules out any other config option.

Logs now show definitively that the client packet queue dries up repeatedly.

~0012244

Beherith (reporter)

2013-11-28 13:29

 By the way, are you affected at all by this issue when playing/speccing online?

~0012245

Kloot (developer)

2013-11-28 14:16

Last edited: 2013-11-28 14:19

View 3 revisions

 Personally I have never seen this under normal online conditions no, but there are too many variables involved (differences in OS / hardware / routing / ...) to derive much from that.

The biggest WTF is that the low-level netcode (packet reassembly crap and the like) was barely touched between 94 and 95, so atm I am out of ideas.

~0012257

Beherith (reporter)

2013-11-28 19:40

Last edited: 2013-11-28 19:41

View 2 revisions

 Timeouted so retyping:

This morning I tested with my main PC as host, and laptop as client, and I got the CTO assert errors as the host too! But oddly they were almost all NP=1!
The client laptop had the usual NP=0 errors. 95.0 Infologs attached as infolog_wierd_run1_host.txt and infolog_wierd_run1_client.txt.

After that I tested just on the main PC by launching spring.exe, and I was having jitter errors with CTO assert errors without even playing online. Unfortunately I did not save the infolog. I restarted my computer (i usually only reboot weekly) and I could not reproduce this, nor could I reproduce the host spamming CTO errors. Unfortunately after the reboot I couldnt reproduce with 95.0.1-115.

Many others have CTO error spam, even people on linux (BrainDamage, Kixu)

I will keep trying to reproduce this host side error spam with 95-115.

~0012260

cleanrock (reporter)

2013-11-29 08:31

 This is probably a long shot but I wonder if the by default spinning threads can cause this by starvation, try if this make any difference:
WorkerThreadSpinTime=0
and perhaps reduce threads if you have "HT cores":
WorkerThreadCount=<less than the number of your "real cores">

~0012261

Beherith (reporter)

2013-11-29 09:22

 My default workerthreadcont was -1, default workerthreadspintime was 5.
A setting of (-1, 0), results in the same jitter. I have 4 real cores, no ht cores. A setting of (4,0) also results in jitter.
Setting the above on the host pc (2 core, 4 thread laptop) to (2, 0) also results in jitter.

~0012263

Kloot (developer)

2013-11-29 16:18

Last edited: 2013-11-29 16:29

View 3 revisions

 For completeness, what about (0, 0)?

Pure host-side jittering would imply netcode isn't a factor after all, so like cleanrock I'm considering if there is possible thread priority inversion going on.

Out of curiousity: do MSVS builds (if you can make them) jitter for you?

~0012264

Beherith (reporter)

2013-11-29 16:54

 Same with (0,0)

Ill try to build with msvc over the weekend.

~0012277

Beherith (reporter)

2013-11-30 19:44

Last edited: 2013-11-30 19:53

View 3 revisions

 MSVC 11 build: same results.

EDIT: Also, I was able to get the cto assert error while catching up to a replay (a very heavy 1500 unit FFA game).

What can I do to help test more?

Edit: added infolog_msvc*

~0012293

Beherith (reporter)

2013-12-02 13:22

Last edited: 2013-12-02 17:12

View 5 revisions

 Should I test with singlestep maybe?

EDIT: Tested with singlestepping (Alt+o) held down on host. The game runs relatively smoothly (though jitter is still visible), frame times are as expected (30fps sim), and no assert errors!

EDIT2: note https://github.com/spring/spring/blob/develop/rts/Net/GameServer.cpp#L2412
It says that the server should make a few frames in advance, but based on the numbers in the infolog printed by https://github.com/spring/spring/blob/develop/rts/Net/GameServer.cpp#L2427 it doesnt actually create any! simFrameBehind is always at 0, rarely 1.

~0012296

Kloot (developer)

2013-12-02 17:07

Last edited: 2013-12-02 17:13

View 2 revisions

 That bit of code doesn't play a role except when the host client (if there is one) experiences high CPU-lag.

Would you mind testing 145-g71e2e27?

~0012297

Beherith (reporter)

2013-12-02 17:24

Last edited: 2013-12-02 18:38

View 2 revisions

 Tested with 145-same results as usual. Need infolog?

Also, code says:
// Don't create new frames when localClient (:= host) isn't able to process them fast enough.
// Despite this still allow to create a few in advance to not lag other connected clients.

Can it be that the N jK was talking about in this thread ( http://springrts.com/phpbb/viewtopic.php?f=12&t=30652 ) is just too low? And network jitter just makes it worse?


EDIT: tested 146, same results too. Scream if you need infologs.

~0012302

Kloot (developer)

2013-12-02 18:38

 From your LAN test results it's more likely just the case that the server can't / doesn't always feed clients at their expected rate because it sleeps too long (sleep has an inherent inaccuracy) between updates and its thread gets shuffled around a lot. By singlestep-spamming (shoveling frames out the door with every keypress so clients have a backlog) you mask this.

For fun & games, set your keyboard repeat rate to a value smaller than 30Hz and you should experience the same jitter with singlestep.

new build: 147-g2bf5bc0

~0012303

Kloot (developer)

2013-12-02 19:01

 use 147, not 146

~0012304

Beherith (reporter)

2013-12-02 19:33

 Same with 147. Uploaded infologs (was testing on LAN, earlier today I was testing through internet (but in same country so ping= ~3ms).

It happens also when I play on online hosts, my ping is usually a couple of hundred ms. When we tested with silentwings, I recall our pings were about 200ms.

~0012309

Kloot (developer)

2013-12-02 22:18

 ok, I need another infolog of your client LAN machine with build 150-g31f8552.

add UDPConnectionLogDebugMessages=1 in springsettings, then do the usual.

~0012316

Beherith (reporter)

2013-12-03 15:32

Last edited: 2013-12-03 21:12

View 2 revisions

 Did it, infolog attached. Same jitter.

EDIT: did one with 154 too, same jitter, attached infolog.
+Notes

-Issue History
Date Modified Username Field Change
2013-11-27 01:27 Beherith New Issue
2013-11-27 01:27 Beherith File Added: dbg_frame_jitter.lua
2013-11-27 01:28 Beherith File Added: infolog.2.txt
2013-11-27 01:29 Beherith File Added: infolog.3.txt
2013-11-27 01:29 Beherith File Added: infolog.4.txt
2013-11-27 01:32 Beherith Note Added: 0012221
2013-11-27 01:39 Beherith Note Edited: 0012221 View Revisions
2013-11-27 01:40 Beherith Note Edited: 0012221 View Revisions
2013-11-27 03:00 Kloot Note Added: 0012223
2013-11-27 11:49 Beherith Note Added: 0012224
2013-11-27 11:50 Beherith File Added: infolog_95.0.1-99_client.txt
2013-11-27 11:51 Beherith File Added: infolog_95.0.1-99_host.txt
2013-11-27 11:53 Beherith Note Edited: 0012224 View Revisions
2013-11-27 18:33 Kloot Note Added: 0012225
2013-11-27 18:46 Kloot Note Edited: 0012225 View Revisions
2013-11-27 21:58 Beherith File Added: infolog_95_112_host.7z
2013-11-27 21:59 Beherith File Added: infolog_95_112_client.txt
2013-11-27 21:59 Beherith Note Added: 0012226
2013-11-27 22:00 Beherith Note Edited: 0012226 View Revisions
2013-11-27 23:06 Kloot Note Added: 0012229
2013-11-27 23:07 Kloot Note Edited: 0012229 View Revisions
2013-11-27 23:18 Beherith Note Added: 0012230
2013-11-27 23:39 Kloot Note Added: 0012231
2013-11-28 00:31 Kloot Note Edited: 0012231 View Revisions
2013-11-28 00:59 Beherith Note Added: 0012232
2013-11-28 00:59 Beherith Note Edited: 0012232 View Revisions
2013-11-28 01:55 Beherith Note Added: 0012233
2013-11-28 01:56 Beherith File Added: infolog_95_115_host.txt
2013-11-28 01:56 Beherith File Added: infolog_95_115_client.txt
2013-11-28 02:03 Kloot Note Added: 0012234
2013-11-28 02:16 Kloot Note Edited: 0012234 View Revisions
2013-11-28 13:29 Beherith Note Added: 0012244
2013-11-28 14:16 Kloot Note Added: 0012245
2013-11-28 14:16 Kloot Note Edited: 0012245 View Revisions
2013-11-28 14:19 Kloot Note Edited: 0012245 View Revisions
2013-11-28 19:31 Beherith File Added: infolog_wierd_run1_client.txt
2013-11-28 19:36 Beherith File Added: infolog_wierd_run1_host.txt
2013-11-28 19:40 Beherith Note Added: 0012257
2013-11-28 19:41 Beherith Note Edited: 0012257 View Revisions
2013-11-28 22:04 abma Target Version => 96.0
2013-11-29 08:31 cleanrock Note Added: 0012260
2013-11-29 09:22 Beherith Note Added: 0012261
2013-11-29 16:18 Kloot Note Added: 0012263
2013-11-29 16:28 Kloot Note Edited: 0012263 View Revisions
2013-11-29 16:29 Kloot Note Edited: 0012263 View Revisions
2013-11-29 16:54 Beherith Note Added: 0012264
2013-11-30 19:44 Beherith Note Added: 0012277
2013-11-30 19:44 Beherith Note Edited: 0012277 View Revisions
2013-11-30 19:52 Beherith File Added: infolog_msvc11_client.txt
2013-11-30 19:53 Beherith Note Edited: 0012277 View Revisions
2013-12-01 18:40 Beherith File Added: infolog_msvc11_host.txt
2013-12-02 13:22 Beherith Note Added: 0012293
2013-12-02 15:58 Beherith Note Edited: 0012293 View Revisions
2013-12-02 16:40 Beherith Note Edited: 0012293 View Revisions
2013-12-02 16:48 Beherith Note Edited: 0012293 View Revisions
2013-12-02 17:07 Kloot Note Added: 0012296
2013-12-02 17:12 Beherith Note Edited: 0012293 View Revisions
2013-12-02 17:13 Kloot Note Edited: 0012296 View Revisions
2013-12-02 17:24 Beherith Note Added: 0012297
2013-12-02 18:38 Kloot Note Added: 0012302
2013-12-02 18:38 Beherith Note Edited: 0012297 View Revisions
2013-12-02 19:01 Kloot Note Added: 0012303
2013-12-02 19:31 Beherith File Added: infolog_client_147.txt
2013-12-02 19:32 Beherith File Added: infolog_host_147.7z
2013-12-02 19:33 Beherith Note Added: 0012304
2013-12-02 22:18 Kloot Note Added: 0012309
2013-12-03 12:03 Beherith File Added: infolog_151_client_dirty_pc.txt
2013-12-03 15:32 Beherith Note Added: 0012316
2013-12-03 21:12 Beherith Note Edited: 0012316 View Revisions
2013-12-03 21:13 Beherith File Added: infolog_154_client.txt
2013-12-04 21:02 Kloot Changeset attached => spring develop 1b5a0d7a
2013-12-04 21:02 Kloot Assigned To => Kloot
2013-12-04 21:02 Kloot Status new => resolved
2013-12-04 21:02 Kloot Resolution open => fixed
+Issue History