./walktest -relight -verbose=-scf -console 2>&1 | cat > ./tmp.log

CR Warning(delta:8477): the OpenGL faker was loaded without crappfaker!
Defaulting to an application id of -1!
This won't work if you're debugging a parallel application!
In this case, set the CR_APPLICATION_ID_NUMBER environment
variable to the right thing (see opengl_stub/load.c)
CR Debug(delta:8477): In crNetConnectToServer( "localhost", port=10000, mtu=8096, broker=0 )
CR Debug(delta:8477): Connecting to delta on port 10000, with protocol tcpip
CR Debug(delta:8477): crNetConnectToServer() failed, freeing the connection
CR Warning(delta:8477): Using Chromium configuration for * from /home/arrummzen/.crconfigs
CR Debug(delta:8477): Spawning mothership with argv:
CR Debug(delta:8477): argv[0] = 'python'
CR Debug(delta:8477): argv[1] = '-E'
CR Debug(delta:8477): argv[2] = '/home/arrummzen/cr/autodmx.conf'
CR Debug(delta:8477): argv[3] = '10043'
CR Debug(delta:8477): argv[4] = 'walktest'
This is Chromium, Version 1.9
Start a crappfaker on delta
Mothership signalling spawning process 8477
CR Debug(delta:8477): Got signal 10: mothership is awake!
CR Debug(delta:8477): Mothership is awake!
CR Debug(delta:8477): In crNetConnectToServer( "delta:10043", port=10000, mtu=8096, broker=0 )
CR Debug(delta:8477): Connecting to delta on port 10043, with protocol tcpip
CR Debug(delta:8477): Done connecting to delta:10043 (swapping=0)
CR Debug(delta:8477): SPU 1/2: (0) "dmxdirect"
CR Debug(delta:8477): SPU 2/2: (1) "render"
CR Debug(delta:8477): Initializing error SPU
CR Debug(delta:8477): Initializing render SPU
CR Debug(delta:8477): Render SPU: thread-safe
CR Debug(delta:8477): In crNetConnectToServer( "delta:10043", port=10000, mtu=8096, broker=0 )
CR Debug(delta:8477): Connecting to delta on port 10043, with protocol tcpip
CR Debug(delta:8477): Done connecting to delta:10043 (swapping=0)
CR Debug(delta:8477): Looking for the system's OpenGL library...
CR Debug(delta:8477): Found it in default path.
CR Debug(delta:8477): Render SPU: Creating default window (visBits=0x25, id=0)
CR Debug(delta:8477): Render SPU: Opening display 192.168.10.103:0.0
CR Debug(delta:8477): Render SPU: Chose visual id=0x26: RGBA=(8,8,8,0) Z=24 stencil=0 double=1 stereo=0 accum=(16,16,16,16)
CR Debug(delta:8477): Render SPU: Created window 0x400001 on display 192.168.10.103:0.0, Xvisual 0x26
CR Debug(delta:8477): Render SPU: actual window x, y, width, height: 0, 0, 256, 256
CR Debug(delta:8477): Render SPU: WindowCreate returned 0 (0=normal)
CR Debug(delta:8477): Render SPU: Creating default context, visBits=0x25
CR Debug(delta:8477): GLX_VERSION_1_3
CR Debug(delta:8477): doing glXCreateContext, VisualID: 0x26
CR Debug(delta:8477): Render SPU: Created DIRECT context (0) on display 192.168.10.103:0.0 for visAttribs 0x25
CR Debug(delta:8477): Render SPU: GL_VENDOR:   NVIDIA Corporation
CR Debug(delta:8477): Render SPU: GL_RENDERER: GeForce 6800 GT/AGP/SSE2
CR Debug(delta:8477): Render SPU: GL_VERSION:  2.0.2 NVIDIA 87.62
CR Debug(delta:8477): Render SPU: ---------- End of Init -------------
CR Debug(delta:8477): Initializing error SPU
CR Debug(delta:8477): Initializing passthrough SPU
CR Debug(delta:8477): Initializing dmxdirect SPU
CR Debug(delta:8477): dmxdirect SPU: init start
CR Debug(delta:8477): In crNetConnectToServer( "delta:10043", port=10000, mtu=8096, broker=0 )
CR Debug(delta:8477): Connecting to delta on port 10043, with protocol tcpip
CR Debug(delta:8477): Done connecting to delta:10043 (swapping=0)
CR Debug(delta:8477): Looking for the system's OpenGL library...
CR Debug(delta:8477): Found it in default path.
CR Debug(delta:8477): dmxdirect SPU: init finished
CR Debug(delta:8477): Looking for the system's OpenGL library...
CR Debug(delta:8477): Found it in default path.
Info: Using render cleanup parameters 8/20/23/24/25/26.
Info: Using image cleanup parameters 0/0/0/0.
CR Debug(delta:8477): GLX_VERSION_1_3
CR Debug(delta:8477): doing glXCreateContext, VisualID: 0x26
CR Debug(delta:8477): Render SPU: Created DIRECT context (1) on display 192.168.10.103:0.0 for visAttribs 0x25
CR Debug(delta:8477): dmxdirectWindowCreate
CR Debug(delta:8477): Render SPU: Created window 0x400004 on display 192.168.10.103:0.0, Xvisual 0x26
CR Debug(delta:8477): Render SPU: actual window x, y, width, height: 0, 0, 256, 256
CR Debug(delta:8477): Render SPU: GL_VENDOR:   NVIDIA Corporation
CR Debug(delta:8477): Render SPU: GL_RENDERER: GeForce 6800 GT/AGP/SSE2
CR Debug(delta:8477): Render SPU: GL_VERSION:  2.0.2 NVIDIA 87.62
CR Debug(delta:8477): WindowSize
CR Debug(delta:8477): WindowPosition
VFS_NOTIFY: loaded configuration file: /home/arrummzen/devel/cs/crystal/./vfs.cfg
VFS_NOTIFY: merged configuration file: /home/arrummzen/devel/cs/crystal/vfs.cfg
DEBUG: Sound System Software Renderer Initializing...

crystalspace.system:
  World saving enabled.
  Crystal Space version 1.1dev [Unix-x86-GCC] (Mon 30-Aug-2006).
  Created by Jorrit Tyberghein and others...

crystalspace.graphics3d.opengl:
  Texture LOD bias -0.3

crystalspace.canvas.glx2d:
  Opening GLX2D
  Creating Context
  Probing pixel format: Color: 32 Alpha: 8 Depth: 32 Stencil: 8 AccumColor: 0
  AccumAlpha: 0 MultiSamples: 0 
  Video driver GL/X version (direct renderer)
  Visual ID: 0x00000021, 24bit TrueColor
  R8:G8:B8:A8, 
  level 1, double buffered

crystalspace.canvas.openglcommon:
  OpenGL renderer: Chromium (GeForce 6800 GT/AGP/SSE2) (vendor: Humper)
  version 2.0.2 NVIDIA 87.62
  Using windowed mode at resolution 640x480.
  Pixel format: Color: 24 Alpha: 8 Depth: 16 Stencil: 8 AccumColor: 48
  AccumAlpha: 16 MultiSamples: 0 

crystalspace.canvas.opengl.extmgr:
  GL Extension 'GL_ARB_multitexture' found and used.
  GL Extension 'GL_ARB_texture_env_combine' found and used.
  GL Extension 'GL_ARB_multisample' found and used.

crystalspace.canvas.openglcommon:
  Multisample: disabled

crystalspace.canvas.opengl.extmgr:
  GL Extension 'GL_ARB_fragment_program' found and used.

crystalspace.canvas.openglcommon.fontcache:
  Text drawing method: Multitexturing

crystalspace.canvas.opengl.extmgr:
  GL Extension 'GL_version_1_2' found and used.
  GL Extension 'GL_ARB_texture_cube_map' found and used.
  GL Extension 'GL_EXT_texture3D' found and used.
  GL Extension 'GL_ARB_vertex_buffer_object' found and used.
  GL Extension 'GL_SGIS_generate_mipmap' found and used.
  GL Extension 'GL_EXT_texture_filter_anisotropic' found and used.
  GL Extension 'GL_EXT_texture_lod_bias' found and used.
  GL Extension 'GL_ARB_point_parameters' found and used.
  GL Extension 'GL_ARB_point_sprite' found, but not used.
  GL Extension 'GL_EXT_framebuffer_object' not found.
  GL Extension 'GL_ARB_texture_non_power_of_two' found and used.
  GL Extension 'GL_ARB_vertex_program' found and used.
  GL Extension 'GL_EXT_secondary_color' found and used.
  GL Extension 'GL_GREMEDY_string_marker' not found.

crystalspace.graphics3d.opengl:
  Maximum texture size is 4096x4096

crystalspace.graphics3d.opengl.vbo:
  Setting up VBO buffers, VB: 32 MB IB: 16 MB

crystalspace.graphics3d.opengl:
  Stencil clipping is not available
  Clearing Z buffer when stencil clear is needed enabled

crystalspace.graphics3d.shadermgr:
  Loaded compiler plugin crystalspace.graphics3d.shadercompiler.xmlshader,
  compiler: XMLShader

crystalspace.canvas.opengl.extmgr:
  GL Extension 'GL_ARB_texture_compression' found and used.
  GL Extension 'GL_EXT_texture_compression_s3tc' not found.

crystalspace.graphics3d.opengl:
  Render-to-texture backend: framebuffer
  Delayed buffer swapping: disabled
  AFP DrawPixmap() workaround: disabled
  ?Forceful? fixed function enable: no

crystalspace.graphics3d.shadercompiler.xmlshader:
  Shader std_lighting_fixed: 8 variations, 5 ms
  Shader std_lighting: 48 variations, 79 ms
  Shader std_lighting_portal: unvarying, 0 ms

crystalspace.system:
  Loading map 'castle'.

crystalspace.graphics3d.shadercompiler.xmlshader:
  Shader light_bumpmap: unvarying, 37 ms
  Shader light_spec_bumpmap: 2 variations, 45 ms
  Shader parallaxAtt: 2 variations, 61 ms
  Shader ambient: 7 variations, 3 ms
  Shader std_lighting: 48 variations, 53 ms

crystalspace.mesh.object.thing:
  Lightmap quality=3
  Lightmapping enabled=1

crystalspace.engine.notify:
  Lightmaps are not up to date (no 'lm_precalc_info' found in cache).
  Recalculation of lightmaps forced.
  Initializing lighting (191 meshes).
  Shining lights (19 lights).
Doing light 0
WARNING! Object 'Cylinder.231' is not closed!
WARNING! Object 'Cylinder.025' is not closed!
WARNING! Object 'Cube.581' is not closed!
WARNING! Object 'Cube.579' is not closed!
WARNING! Object 'Cube.577' is not closed!
WARNING! Object 'Cube.483' is not closed!
...
Doing light 1
Doing light 2
Doing light 3
Doing light 4
Doing light 5
Doing light 6
Doing light 7
Doing light 8
Doing light 9
Doing light 10
Doing light 11
Doing light 12
Doing light 13
Doing light 14
Doing light 15
Doing light 16
Doing light 17
Doing light 18
  Time taken: 1.0510 seconds.
  Caching lighting (191 meshes).

crystalspace.system:
  Precaching all things...
  Precaching finished...
Total level load time: 7.464 seconds
CR Debug(delta:8477): Cleaning up SPU dmxdirect
CR Debug(delta:8477): Cleaning up SPU passthrough
CR Debug(delta:8477): Cleaning up SPU error