God of War 2 Flight Scene Bug?

[gowarian]

Hi there.

If I play the sequence with Pegasus, flying to the Island of Fate, I get just a white screen, where normally you should see the island in the background.
This guy has the same issue exactly here: WTF! Why we are not able to post a simple youtube video to SHOW the problem??? So annoying.

I tried to use Vulkan, D3D, SW & OpenGL but it did not help. I'm running on Nightly v1.73314. Can someone help?

My specs:

i9900
rtx2070
64GB Ram
SSD
W10

[jesalvein]

Please post the contents of the emulog.txt file after the problem occurs. The file can be found in "My Documents\PCSX2\logs" for the installer version or in "PCSX2\logs" for the portable/binary version.

Please make sure to enclose your emulog in code tags like so (remove the empty space on the closing code tag!):
[code]
Pasted emulog goes here
[ /code]

[gowarian]

Code:

[  16.2876] Allocating memory map...
[  16.2880] Opening CDVD...
[  16.2886] isoFile open ok: T:\PCSX2\Roms\God of War II.iso
[  16.2886] Image type  = DVD
[  16.2887] isoFile: second layer found at sector 0x001fcc30
[  16.2887]  * CDVD Disk Open: DVD, Double layer:
[  16.2887]  * * Track 1: Data (Mode 1) (4166832 sectors)
[  16.2889] Opening GS...
[  16.3265] Vsync is ON
[  16.4850] No GPU requested, using first (NVIDIA GeForce RTX 2070)
[  16.4851] 3 vulkan queue families
[  16.5746] VK_EXT_provoking_vertex is supported
[  16.5746] VK_ARM_rasterization_order_attachment_access is NOT supported
[  16.6213] Read 1504 entries from 'T:\PCSX2\cache\vulkan_shaders.idx'
[  16.6400] Vulkan Graphics Driver Info:
[  16.6400] Driver 516.236.0
[  16.6400] Vulkan 1.3.205
[  16.6400] Conformance Version 1.3.1.0
[  16.6400] 516.59
[  16.6400] NVIDIA
[  16.6400] NVIDIA GeForce RTX 2070
[  16.6401] Using hardware for point expansion and hardware for line expansion.
[  16.6899] Vsync is ON
[  16.6901] Opening SPU2...
[  16.6910] Initializing SndBuffer at sample rate of 48000...
[  16.7027] (Cubeb) 5.1 speaker expansion enabled.
[  16.7186] (Cubeb) Minimum latency: 10.00 ms (480 audio frames)
[  16.8128] Opening PAD...
[  16.8128] Opening DEV9...
[  16.8168] Opening USB...
[  16.8169] Opening FW...
[  16.8169] McdSlot 0 [File]: T:\PCSX2\memcards\Mcd001.ps2
[  16.8171] McdSlot 1 [File]: [disabled]
[  16.8191] EE/iR5900-32 Recompiler Reset
[  16.8576] Refresh rate: Host=59.940059hz Guest=60.000000hz Ratio=0.999000 - can sync and using vsync for pacing
[  16.8640] Initializing SndBuffer at sample rate of 47952...
[  16.8725] (Cubeb) 5.1 speaker expansion enabled.
[  16.8813] (Cubeb) Minimum latency: 10.01 ms (480 audio frames)
[  16.9547] Bios Found: USA    v02.00(14/06/2004)  Console
[  16.9561] BIOS rom1 module not found, skipping...
[  16.9562] BIOS rom2 module not found, skipping...
[  16.9562] BIOS erom module not found, skipping...
[  16.9575] Refresh rate: Host=59.940059hz Guest=60.000000hz Ratio=0.999000 - can sync and using vsync for pacing
[  16.9759] VM subsystems initialized in 689.08 ms
[  16.9760] [GameDB] Has not been initialized yet, initializing...
[  17.0263] [GameDB] 11322 games on record (loaded in 50.32ms)
[  17.0263] [GameDB] Searching for '' in GameDB
[  17.0263] [GameDB] Could not find '' in GameDB
[  17.0263] Applying settings...
[  17.0266] [GameDB] Searching for '' in GameDB
[  17.0266] [GameDB] Could not find '' in GameDB
[  17.0267] Processor count: 8 cores, 16 processors
[  17.0267] Cluster count: 1
[  17.0267] Ordered processor list: 0, 2, 4, 6, 8, 10, 12, 14, 1[SMT 1], 3[SMT 1], 5[SMT 1], 7[SMT 1], 9[SMT 1], 11[SMT 1], 13[SMT 1], 15[SMT 1]
[  17.1511] (SYSTEM.CNF) Detected PS2 Disc = cdrom0:\SCUS_974.81;1
[  17.1511] (SYSTEM.CNF) Software version = 1.01
[  17.1511] (SYSTEM.CNF) Disc region type = NTSC
[  17.1564] ELF (cdrom0:\SCUS_974.81;1) Game CRC = 0x2F123FD8, EntryPoint = 0x00100008
[  17.1565] (SYSTEM.CNF) Detected PS2 Disc = cdrom0:\SCUS_974.81;1
[  17.1565] (SYSTEM.CNF) Software version = 1.01
[  17.1565] (SYSTEM.CNF) Disc region type = NTSC
[  18.5805] Elf entry point @ 0x00100008 about to get recompiled. Load patches first.
[  18.5805] [GameDB] Searching for 'scus-97481' in GameDB
[  18.5805] [GameDB] Found 'scus-97481' in GameDB
[  18.5805] [GameDB] Searching for patch with CRC '2F123FD8'
[  18.5805] [GameDB] No CRC-specific patch or default patch found
[  18.5807] [GameDB] Searching for 'scus-97481' in GameDB
[  18.5807] [GameDB] Found 'scus-97481' in GameDB
[  18.5808] Applying settings...
[  18.5813] [GameDB] Searching for 'scus-97481' in GameDB
[  18.5813] [GameDB] Found 'scus-97481' in GameDB
[  18.5813] [GameDB] Enabled GS Hardware Fix: alignSprite to [mode=1]
[  18.5813] [GameDB] Enabled GS Hardware Fix: halfPixelOffset to [mode=2]
[  18.5813] [GameDB] Enabled GS Hardware Fix: roundSprite to [mode=1]
[  18.5813] [GameDB] Enabled GS Hardware Fix: autoFlush to [mode=1]
[  18.5813] Updating GS configuration...
[  18.5814] Refresh rate: Host=59.940059hz Guest=60.000000hz Ratio=0.999000 - can sync and using vsync for pacing
[  18.5814] Refresh rate: Host=59.940059hz Guest=60.000000hz Ratio=0.999000 - can sync and using vsync for pacing
[  18.5814] Vsync is ON
[  18.6135] Refresh rate: Host=59.940059hz Guest=59.939998hz Ratio=1.000001 - can sync and using vsync for pacing
[  18.6212] Initializing SndBuffer at sample rate of 48000...
[  18.6319] (Cubeb) 5.1 speaker expansion enabled.
[  18.6408] (Cubeb) Minimum latency: 10.00 ms (480 audio frames)
[  18.7296] (UpdateVSyncRate) Mode Changed to NTSC.
[  19.3360] Refresh rate: Host=59.940059hz Guest=59.939998hz Ratio=1.000001 - can sync and using vsync for pacing
[  22.6411] MTVU speedhack is enabled, saved states may not be stable
[  22.7647] Loading SPU2
[  22.7732] Loading PAD
[  22.7734] Loading GS
[  22.7853] Refresh rate: Host=59.940059hz Guest=59.939999hz Ratio=1.000000 - can sync and using vsync for pacing
[  22.7854] (SYSTEM.CNF) Detected PS2 Disc = cdrom0:\SCUS_974.81;1
[  22.7854] (SYSTEM.CNF) Software version = 1.01
[  22.7854] (SYSTEM.CNF) Disc region type = NTSC
[  22.7867] EE/iR5900-32 Recompiler Reset
[  23.1124] Auto-ejecting memcard [port:0, slot:0]
[  26.6895] Re-inserting auto-ejected memcard [port:0, slot:0]
[  59.3137] (VMManager) Pausing...
[  80.7347] (VMManager) Resuming...
[  88.6341] Skipping updating pipeline cache 'T:\PCSX2\cache\vulkan_pipelines.bin' due to no changes.
[  88.6957] Decommitting host memory for virtual systems...
[  94.8372] Releasing host memory maps for virtual systems...
[  94.8373] Releasing host memory maps for virtual systems...

[jesalvein]

hm. tried directly from your orignal dvd in the DVD drive ?

[gowarian]

hm. tried directly from your orignal dvd in the DVD drive ?

Was not easy to find my USB-DVD drive in the basement now but yes, it's the same.
And as I wanted to show via Youtube in my original post, other people have this problem as well. It's not a failure from the game.

Also in later levels, the emulator has problems correctly displaying the light rays that appear in the game.. But that's another topic maybe.

[gowarian]

So? You want to tell me that all that work was for nothing? 

[jesalvein]

I wanna tell you I have no idea of how to fix this.
Can you post a screenshot, please ?

[gowarian]

.... Just wanted to post them but I have to upload them elsewhere? Seriously? What kind of forum is this? People can't directly post pictures or even a simple link to a youtube video which would demonstrate everything so much better than all these words. I just don't get it. It's 2022, not 2002!

Anyway... here we go.



The following two pics are pretty much self explanatory:







Here we can see, how the emulator sometimes cannot show light rays correctly. Happens not that often though:







Many times light rays are simply not shown or are displayed wrong (comparison pics are from ps2):













Reminder: The light rays ARE there in the game. They just disappear randomly or screw up while the camera moves (for example: In the first two comparisons the camera moves automatically because it's an ingame cutscene).



Last but not least, there are spiderwebs in this stage. If you just step back and forth, they (dis)appear:







If someone wants to check for themselves, I can provide savestates on some of these scenes.

[jesalvein]

Can you please post the full emulog.txt ?
You only posted a part of it

---

.... Just wanted to post them but I have to upload them elsewhere? Seriously? What kind of forum is this? People can't directly post pictures or even a simple link to a youtube video which would demonstrate everything so much better than all these words. I just don't get it. It's 2022, not 2002!

You probably wouldn't understand why, so let's not lose time explaining

[gowarian]

You probably wouldn't understand why, so let's not lose time explaining

Rude comment actually. You see, I also didn't claim before that someone probably can't explain it with their intelligence, right? So maybe give it a try?

Code:

[    0.0206] PCSX2 Nightly - v1.7.3314 Compiled on Sep 16 2022
[    0.0206] Savestate version: 0x9a2e0000
[    0.0206]
[    0.0206] Host Machine Init:
[    0.0206] Operating System =  Microsoft Windows 10
[    0.0206] Physical RAM    =  65450 MB
[    0.0427] CPU name        =  Intel(R) Core(TM) i9-9900K CPU @ 3.60GHz
[    0.0427] Vendor/Model    =  GenuineIntel (stepping 0C)
[    0.0427] CPU speed        =  3.599 ghz (16 logical threads)
[    0.0427] x86PType        =  Standard OEM
[    0.0427] x86Flags        =  bfebfbff 7ffafbff
[    0.0427] x86EFlags        =  2c100800
[    0.0427]
[    0.0427] x86 Features Detected:
[    0.0427] SSE2 SSE3 SSSE3 SSE4.1 SSE4.2 AVX AVX2 FMA
[    0.0427]
[    0.0431] Main Memory Manager              @ 0x00007FF6D0000000 -> 0x00007FF6F8000000 [640mb]
[    0.0432] Reserving memory for recompilers...
[    0.0434] Micro VU0 Recompiler Cache      @ 0x00007FF6EC000000 -> 0x00007FF6F0000000 [64mb]
[    0.0438] Micro VU1 Recompiler Cache      @ 0x00007FF6F0000000 -> 0x00007FF6F4000000 [64mb]
[    0.0441] R5900-32 Recompiler Cache        @ 0x00007FF6E0000000 -> 0x00007FF6E4000000 [64mb]
[    0.0442] R3000A Recompiler Cache          @ 0x00007FF6E4000000 -> 0x00007FF6E6000000 [32mb]
[    0.0443] VIF0 Unpack Recompiler Cache    @ 0x00007FF6E6000000 -> 0x00007FF6E6800000 [8mb]
[    0.0443] VIF1 Unpack Recompiler Cache    @ 0x00007FF6E8000000 -> 0x00007FF6E8800000 [8mb]
[    0.0443] Mapping host memory for virtual systems...
[    0.0444] EE Main Memory                  @ 0x00007FF6D0000000 -> 0x00007FF6D2884000 [40mb]
[    0.0444] IOP Main Memory (2mb)            @ 0x00007FF6D4000000 -> 0x00007FF6D4211000 [2mb]
[    0.0444] VU0/1 on-chip memory            @ 0x00007FF6D8000000 -> 0x00007FF6D800A000 [40kb]
[    0.2632] (SDLInputSource) Controller 0 inserted
[    0.2651] (SDLInputSource) Opened controller 0 (instance id 0, player id 0): Xbox 360 Controller
[    0.2651] (SDLInputSource) Rumble is supported on 'Xbox 360 Controller' via gamecontroller
[    0.3413] Scanning T:\PS2\Roms
[    0.3413] Scanning T:\PCSX2\Roms
[  85.3330] Allocating memory map...
[  85.3330] Allocating host memory for virtual systems...
[  85.3331] Opening CDVD...
[  85.3335] isoFile open ok: T:\PS2\Roms\God of War II.iso
[  85.3335] Image type  = DVD
[  85.3335] blocks      = 4166832
[  85.3335] offset      = 0
[  85.3335] blocksize  = 2048
[  85.3335] blockoffset = 24
[  85.3336] isoFile: second layer found at sector 0x001fcc30
[  85.3336]  * CDVD Disk Open: DVD, Double layer:
[  85.3336]  * * Track 1: Data (Mode 1) (4166832 sectors)
[  85.3336] (IsoFS) Block 0x10: Primary partition info.
[  85.3336] (IsoFS) Filesystem is ISO9660
[  85.3337] Opening GS...
[  85.3380] createDisplay(1, 1)
[  85.3561] Vsync is ON
[  85.3758] Enabling extension: VK_KHR_surface
[  85.3758] Enabling extension: VK_KHR_win32_surface
[  85.5078] No GPU requested, using first (NVIDIA GeForce RTX 2070)
[  85.5079] 3 vulkan queue families
[  85.5088] Enabling extension: VK_KHR_swapchain
[  85.5088] Enabling extension: VK_EXT_provoking_vertex
[  85.5088] Enabling extension: VK_EXT_memory_budget
[  85.5088] Enabling extension: VK_KHR_driver_properties
[  85.5915] GPU timing is supported (TS=1 TS valid bits=64, TS period=1.000000)
[  85.5915] VK_EXT_provoking_vertex is supported
[  85.5915] VK_ARM_rasterization_order_attachment_access is NOT supported
[  85.6073] (SwapChain) Preferred present mode: VK_PRESENT_MODE_FIFO_KHR, selected: VK_PRESENT_MODE_FIFO_KHR
[  85.6321] Read 1517 entries from 'T:\PS2\cache\vulkan_shaders.idx'
[  85.6490] Vulkan Graphics Driver Info:
[  85.6490] Driver 516.236.0
[  85.6490] Vulkan 1.3.205
[  85.6490] Conformance Version 1.3.1.0
[  85.6490] 516.59
[  85.6490] NVIDIA
[  85.6490] NVIDIA GeForce RTX 2070
[  85.6491] Using hardware for point expansion and hardware for line expansion.
[  85.6675] Vsync is ON
[  85.6677] Opening SPU2...
[  85.6682] Initializing SndBuffer at sample rate of 48000...
[  85.6784] (Cubeb) 5.1 speaker expansion enabled.
[  85.6948] (Cubeb) Minimum latency: 10.00 ms (480 audio frames)
[  85.7849] Opening PAD...
[  85.7849] Opening DEV9...
[  85.7849] DEV9: DEV9init
[  85.7849] DEV9: DEV9init2
[  85.7849] DEV9: DEV9init3
[  85.7888] DEV9: DEV9init ok
[  85.7888] DEV9: DEV9open
[  85.7888] DEV9: open r+: DEV9hdd.raw
[  85.7888] Opening USB...
[  85.7888] Opening FW...
[  85.7889] McdSlot 0 [File]: T:\PS2\memcards\Mcd001.ps2
[  85.7890] McdSlot 1 [File]: [disabled]
[  85.7910] EE/iR5900-32 Recompiler Reset
[  85.8130] iR3000A Recompiler reset.
[  85.8160] mVU Reset
[  85.8171] mVU Reset
[  85.8181] mVU Reset
[  85.8318] Refresh rate: Host=59.940059hz Guest=60.000000hz Ratio=0.999000 - can sync and using vsync for pacing
[  85.8374] Initializing SndBuffer at sample rate of 47952...
[  85.8455] (Cubeb) 5.1 speaker expansion enabled.
[  85.8541] (Cubeb) Minimum latency: 10.01 ms (480 audio frames)
[  85.9072] Resetting host memory for virtual systems...
[  85.9330] Bios Found: USA    v02.00(14/06/2004)  Console
[  85.9343] BIOS rom1 module not found, skipping...
[  85.9344] BIOS rom2 module not found, skipping...
[  85.9344] BIOS erom module not found, skipping...
[  85.9355] Close virtual disk tray
[  85.9355] Media already loaded (fast boot)
[  85.9355] Generating SSE-optimized unpacking functions for VIF interpreters...
[  85.9355] VIF SSE-optimized Unpacking Functions @ 0x00007FF6F4800000 -> 0x00007FF6F4810000 [64kb]
[  85.9356] Unpack function generation complete.  Generated function statistics:
[  85.9356] Reserved buffer    : 65536 bytes @ 0x00007FF6F4800000
[  85.9356] x86 code generated : 7016 bytes
[  85.9356]
[  85.9357] Refresh rate: Host=59.940059hz Guest=60.000000hz Ratio=0.999000 - can sync and using vsync for pacing
[  85.9545] VM subsystems initialized in 621.94 ms
[  85.9546] [GameDB] Has not been initialized yet, initializing...
[  86.0008] [GameDB] 11322 games on record (loaded in 46.27ms)
[  86.0009] [GameDB] Searching for '' in GameDB
[  86.0009] [GameDB] Could not find '' in GameDB
[  86.0009] Applying settings...
[  86.0011] [GameDB] Searching for '' in GameDB
[  86.0011] [GameDB] Could not find '' in GameDB
[  86.0012] Processor count: 8 cores, 16 processors
[  86.0012] Cluster count: 1
[  86.0013] Ordered processor list: 0, 2, 4, 6, 8, 10, 12, 14, 1[SMT 1], 3[SMT 1], 5[SMT 1], 7[SMT 1], 9[SMT 1], 11[SMT 1], 13[SMT 1], 15[SMT 1]
[  86.0085] FW: read mem 0x1f80847c: 0x10000001
[  86.0085] FW: write mem 0x1f808414: 0x417f0000
[  86.0085] FW: read mem 0x1f808400: 0xffc00001
[  86.0085] FW: write mem 0x1f80844c: 0xffffffff
[  86.0085] FW: write mem 0x1f808420: 0xffffffff
[  86.0085] FW: write mem 0x1f808428: 0xffffffff
[  86.0085] FW: write mem 0x1f808430: 0xffffffff
[  86.1121] Reload ELF
[  86.1122] (IsoFS) Block 0x10: Primary partition info.
[  86.1122] (IsoFS) Filesystem is ISO9660
[  86.1122] (SYSTEM.CNF) Detected PS2 Disc = cdrom0:\SCUS_974.81;1
[  86.1122] (SYSTEM.CNF) Software version = 1.01
[  86.1122] (SYSTEM.CNF) Disc region type = NTSC
[  86.1122] (IsoFS) Block 0x10: Primary partition info.
[  86.1122] (IsoFS) Filesystem is ISO9660
[  86.1189] Initializing Elf: 2125688 bytes
[  86.1194] ELF (cdrom0:\SCUS_974.81;1) Game CRC = 0x2F123FD8, EntryPoint = 0x00100008
[  86.1196] (IsoFS) Block 0x10: Primary partition info.
[  86.1196] (IsoFS) Filesystem is ISO9660
[  86.1196] (SYSTEM.CNF) Detected PS2 Disc = cdrom0:\SCUS_974.81;1
[  86.1196] (SYSTEM.CNF) Software version = 1.01
[  86.1196] (SYSTEM.CNF) Disc region type = NTSC
[  86.5537] updateDisplay() fullscreen=false render_to_main=true surfaceless=false
[  86.6659] (SwapChain) Preferred present mode: VK_PRESENT_MODE_FIFO_KHR, selected: VK_PRESENT_MODE_FIFO_KHR
[  86.6702] Refresh rate: Host=59.940059hz Guest=60.000000hz Ratio=0.999000 - can sync and using vsync for pacing
[  87.6675] Elf entry point @ 0x00100008 about to get recompiled. Load patches first.
[  87.6675] [GameDB] Searching for 'scus-97481' in GameDB
[  87.6675] [GameDB] Found 'scus-97481' in GameDB
[  87.6675] [GameDB] Searching for patch with CRC '2F123FD8'
[  87.6676] [GameDB] No CRC-specific patch or default patch found
[  87.6677] [GameDB] Searching for 'scus-97481' in GameDB
[  87.6677] [GameDB] Found 'scus-97481' in GameDB
[  87.6678] No game settings found (tried 'T:\PS2\gamesettings\2F123FD8.ini')
[  87.6678] Applying settings...
[  87.6682] [GameDB] Searching for 'scus-97481' in GameDB
[  87.6682] [GameDB] Found 'scus-97481' in GameDB
[  87.6682] [GameDB] Enabled GS Hardware Fix: alignSprite to [mode=1]
[  87.6682] [GameDB] Enabled GS Hardware Fix: halfPixelOffset to [mode=2]
[  87.6682] [GameDB] Enabled GS Hardware Fix: roundSprite to [mode=1]
[  87.6682] [GameDB] Enabled GS Hardware Fix: autoFlush to [mode=1]
[  87.6682] Updating GS configuration...
[  87.6682] Refresh rate: Host=59.940059hz Guest=60.000000hz Ratio=0.999000 - can sync and using vsync for pacing
[  87.6682] Refresh rate: Host=59.940059hz Guest=60.000000hz Ratio=0.999000 - can sync and using vsync for pacing
[  87.6682] Vsync is ON
[  87.6698] BIOS: Successfully found the instruction pattern. Assuming the thread list is here: 8001a640
[  87.7007] Refresh rate: Host=59.940059hz Guest=59.939998hz Ratio=1.000001 - can sync and using vsync for pacing
[  87.7062] Initializing SndBuffer at sample rate of 48000...
[  87.7146] (Cubeb) 5.1 speaker expansion enabled.
[  87.7231] (Cubeb) Minimum latency: 10.00 ms (480 audio frames)
[  87.8102] (UpdateVSyncRate) Mode Changed to NTSC.
[  87.8102] Set GS CRTC configuration. NTSC 640x448 @ 59.940 (59.82) Interlaced (FIELD)
[  88.2689] CDGetToc Param[0]=0, Param[1]=5
[  89.4368] (VMManager) Pausing...
[  115.0900]  ... found 'PCSX2 Internal Structures.dat'
[  115.0900]  ... found 'eeMemory.bin'
[  115.0900]  ... found 'iopMemory.bin'
[  115.0900]  ... found 'eeHwRegs.bin'
[  115.0900]  ... found 'iopHwRegs.bin'
[  115.0900]  ... found 'Scratchpad.bin'
[  115.0900]  ... found 'vu0Memory.bin'
[  115.0900]  ... found 'vu1Memory.bin'
[  115.0900]  ... found 'vu0MicroMem.bin'
[  115.0900]  ... found 'vu1MicroMem.bin'
[  115.0900]  ... found 'SPU2.bin'
[  115.0900]  ... found 'PAD.bin'
[  115.0900]  ... found 'GS.bin'
[  115.0901] EE/iR5900-32 Recompiler Reset
[  115.0970] iR3000A Recompiler reset.
[  115.0992] mVU Reset
[  115.1002] mVU Reset
[  115.1012] mVU Reset
[  115.1371] MTVU speedhack is enabled, saved states may not be stable
[  115.1385] iR3000A Recompiler reset.
[  115.1396] mVU Reset
[  115.1407] mVU Reset
[  115.1417] mVU Reset
[  115.2717] Loading SPU2
[  115.2814] Loading PAD
[  115.2815] Loading GS
[  115.2931] Refresh rate: Host=59.940059hz Guest=59.939998hz Ratio=1.000001 - can sync and using vsync for pacing
[  115.2932] Reload ELF
[  115.2932] (IsoFS) Block 0x10: Primary partition info.
[  115.2932] (IsoFS) Filesystem is ISO9660
[  115.2932] (SYSTEM.CNF) Detected PS2 Disc = cdrom0:\SCUS_974.81;1
[  115.2933] (SYSTEM.CNF) Software version = 1.01
[  115.2933] (SYSTEM.CNF) Disc region type = NTSC
[  115.2933] (VMManager) Resuming...
[  115.3048] microVU1: Cached Prog = [000] [PC=0000] [List=01] (Cache=0.000%) [0.0mb]
[  115.3048] microVU1: Cached Prog = [001] [PC=38b8] [List=01] (Cache=0.000%) [0.0mb]
[  115.3049] microVU1: Cached Prog = [002] [PC=00d8] [List=01] (Cache=0.000%) [0.0mb]
[  115.3053] microVU1: 2 cycle stall on branch instruction [03b0]
[  115.3053] microVU1: 1 cycle stall on branch instruction [0538]
[  115.3053] microVU1: 3 cycle stall on branch instruction [0588]
[  115.3058] microVU1: 1 cycle stall on branch instruction [0538]
[  115.3058] microVU1: 2 cycle stall on branch instruction [03b0]
[  115.3072] microVU1: 2 cycle stall on branch instruction [03b0]
[  115.3073] microVU1: 1 cycle stall on branch instruction [0538]
[  115.3073] microVU1: 3 cycle stall on branch instruction [0588]
[  115.3074] microVU1: 1 cycle stall on branch instruction [0538]
[  115.3075] microVU1: 2 cycle stall on branch instruction [03b0]
[  115.3075] microVU1: Cached Prog = [003] [PC=38d0] [List=01] (Cache=0.000%) [0.0mb]
[  115.3076] microVU1: Cached Prog = [004] [PC=1658] [List=01] (Cache=0.000%) [0.0mb]
[  115.3077] microVU1: Cached Prog = [005] [PC=3928] [List=01] (Cache=0.000%) [0.0mb]
[  115.3077] microVU1: Cached Prog = [006] [PC=1678] [List=01] (Cache=0.000%) [0.0mb]
[  115.3078] microVU1: Cached Prog = [007] [PC=0018] [List=01] (Cache=0.387%) [0.2mb]
[  115.3078] microVU1: Cached Prog = [008] [PC=0030] [List=01] (Cache=0.389%) [0.2mb]
[  115.3079] microVU1: Cached Prog = [009] [PC=3990] [List=01] (Cache=0.392%) [0.2mb]
[  115.3079] microVU1: Cached Prog = [010] [PC=3980] [List=01] (Cache=0.392%) [0.2mb]
[  115.3080] microVU1: Cached Prog = [011] [PC=02e8] [List=01] (Cache=0.392%) [0.2mb]
[  115.3080] microVU1: Cached Prog = [012] [PC=38c0] [List=01] (Cache=0.392%) [0.2mb]
[  115.3080] microVU1: Cached Prog = [013] [PC=0308] [List=01] (Cache=0.392%) [0.2mb]
[  115.3083] microVU1: 2 cycle stall on branch instruction [03b0]
[  115.3084] microVU1: 1 cycle stall on branch instruction [0538]
[  115.3084] microVU1: 3 cycle stall on branch instruction [0588]
[  115.3088] microVU1: 1 cycle stall on branch instruction [0538]
[  115.3088] microVU1: 2 cycle stall on branch instruction [03b0]
[  115.3096] microVU1: Cached Prog = [014] [PC=0bf0] [List=01] (Cache=0.593%) [0.3mb]
[  115.3097] microVU1: Cached Prog = [015] [PC=0c10] [List=01] (Cache=0.593%) [0.3mb]
[  115.3097] microVU1: 2 cycle stall on branch instruction [03b0]
[  115.3098] microVU1: 1 cycle stall on branch instruction [0538]
[  115.3098] microVU1: 3 cycle stall on branch instruction [0588]
[  115.3102] microVU1: 1 cycle stall on branch instruction [0538]
[  115.3102] microVU1: 2 cycle stall on branch instruction [03b0]
[  115.3110] microVU1: Cached Prog = [016] [PC=39a8] [List=01] (Cache=0.683%) [0.4mb]
[  115.3113] microVU1: Cached Prog = [017] [PC=1618] [List=01] (Cache=0.683%) [0.4mb]
[  115.3113] microVU1: Cached Prog = [018] [PC=1638] [List=01] (Cache=0.683%) [0.4mb]
[  115.3120] microVU1: Cached Prog = [019] [PC=1d40] [List=01] (Cache=0.683%) [0.4mb]
[  115.3121] microVU1: Cached Prog = [020] [PC=1d68] [List=01] (Cache=0.683%) [0.4mb]
[  115.3121] microVU1: Cached Prog = [021] [PC=1968] [List=01] (Cache=0.683%) [0.4mb]
[  115.3129] microVU1: Cached Prog = [022] [PC=1978] [List=01] (Cache=0.683%) [0.4mb]
[  115.3136] microVU1: Cached Prog = [023] [PC=1988] [List=01] (Cache=0.683%) [0.4mb]
[  115.3143] microVU1: Cached Prog = [024] [PC=1998] [List=01] (Cache=0.683%) [0.4mb]
[  115.3151] microVU1: Cached Prog = [025] [PC=19a8] [List=01] (Cache=0.683%) [0.4mb]
[  115.3158] microVU1: Cached Prog = [026] [PC=19b8] [List=01] (Cache=0.683%) [0.4mb]
[  115.3158] microVU1: 1 cycle stall on branch instruction [19f0]
[  115.3159] microVU1: 3 cycle stall on branch instruction [1b20]
[  115.3160] microVU1: 3 cycle stall on branch instruction [1b20]
[  115.3160] microVU1: 3 cycle stall on branch instruction [1b20]
[  115.3160] microVU1: 3 cycle stall on branch instruction [1b20]
[  115.3161] microVU1: Cached Prog = [027] [PC=20d8] [List=01] (Cache=0.683%) [0.4mb]
[  115.3162] microVU1: Cached Prog = [028] [PC=20e8] [List=01] (Cache=0.683%) [0.4mb]
[  115.3164] microVU1: Cached Prog = [029] [PC=1518] [List=01] (Cache=0.683%) [0.4mb]
[  115.3164] microVU1: Cached Prog = [030] [PC=1538] [List=01] (Cache=0.683%) [0.4mb]
[  115.3172] microVU1: Cached Prog = [031] [PC=20c8] [List=01] (Cache=0.683%) [0.4mb]
[  115.3173] microVU1: Cached Prog = [032] [PC=2320] [List=01] (Cache=0.683%) [0.4mb]
[  115.3174] microVU1: Cached Prog = [033] [PC=15a0] [List=01] (Cache=0.683%) [0.4mb]
[  115.3174] microVU1: Cached Prog = [034] [PC=15c0] [List=01] (Cache=0.683%) [0.4mb]
[  115.3175] microVU1: Cached Prog = [035] [PC=13c0] [List=01] (Cache=0.683%) [0.4mb]
[  115.3175] microVU1: Cached Prog = [036] [PC=13e0] [List=01] (Cache=0.683%) [0.4mb]
[  115.3178] microVU1: 2 cycle stall on branch instruction [03b0]
[  115.3179] microVU1: 1 cycle stall on branch instruction [0538]
[  115.3179] microVU1: 3 cycle stall on branch instruction [0588]
[  115.3183] microVU1: 1 cycle stall on branch instruction [0538]
[  115.3183] microVU1: 2 cycle stall on branch instruction [03b0]
[  115.3197] microVU1: 2 cycle stall on branch instruction [03b0]
[  115.3197] microVU1: 1 cycle stall on branch instruction [0538]
[  115.3198] microVU1: 3 cycle stall on branch instruction [0588]
[  115.3199] microVU1: 1 cycle stall on branch instruction [0538]
[  115.3199] microVU1: 2 cycle stall on branch instruction [03b0]
[  115.3222] microVU1: Cached Prog = [037] [PC=2c20] [List=01] (Cache=1.846%) [1.1mb]
[  115.3225] microVU1: Cached Prog = [038] [PC=00e0] [List=01] (Cache=1.846%) [1.1mb]
[  115.3229] microVU1: 2 cycle stall on branch instruction [03b0]
[  115.3230] microVU1: 1 cycle stall on branch instruction [0538]
[  115.3230] microVU1: 3 cycle stall on branch instruction [0588]
[  115.3234] microVU1: 1 cycle stall on branch instruction [0538]
[  115.3234] microVU1: 2 cycle stall on branch instruction [03b0]
[  115.3247] microVU1: 2 cycle stall on branch instruction [03b0]
[  115.3248] microVU1: 1 cycle stall on branch instruction [0538]
[  115.3248] microVU1: 3 cycle stall on branch instruction [0588]
[  115.3249] microVU1: 1 cycle stall on branch instruction [0538]
[  115.3250] microVU1: 2 cycle stall on branch instruction [03b0]
[  115.3250] microVU1: Cached Prog = [039] [PC=2c38] [List=01] (Cache=1.846%) [1.1mb]
[  115.3251] microVU1: Cached Prog = [040] [PC=1238] [List=01] (Cache=1.846%) [1.1mb]
[  115.3252] microVU1: Cached Prog = [041] [PC=1258] [List=01] (Cache=1.846%) [1.1mb]
[  115.3286] microVU1: Cached Prog = [042] [PC=2ec8] [List=01] (Cache=2.378%) [1.4mb]
[  115.3286] microVU1: Cached Prog = [043] [PC=2ee0] [List=01] (Cache=2.378%) [1.4mb]
[  115.3322] microVU1: Cached Prog = [044] [PC=32d8] [List=01] (Cache=2.425%) [1.4mb]
[  115.3322] microVU1: Cached Prog = [045] [PC=32c8] [List=01] (Cache=2.425%) [1.4mb]
[  115.3326] microVU1: Cached Prog = [046] [PC=3220] [List=01] (Cache=2.425%) [1.4mb]
[  115.3327] microVU1: Cached Prog = [047] [PC=3230] [List=01] (Cache=2.425%) [1.4mb]
[  115.3329] microVU1: Cached Prog = [048] [PC=3628] [List=01] (Cache=2.442%) [1.4mb]
[  115.3330] microVU1: Cached Prog = [049] [PC=3618] [List=01] (Cache=2.442%) [1.4mb]
[  115.3330] microVU1: Cached Prog = [050] [PC=3570] [List=01] (Cache=2.442%) [1.4mb]
[  115.3331] microVU1: Cached Prog = [051] [PC=3580] [List=01] (Cache=2.442%) [1.4mb]
[  115.3333] microVU1: Cached Prog = [052] [PC=2828] [List=01] (Cache=2.457%) [1.4mb]
[  115.3334] microVU1: Cached Prog = [053] [PC=2840] [List=01] (Cache=2.457%) [1.4mb]
[  115.3336] microVU1: Cached Prog = [054] [PC=2b78] [List=01] (Cache=2.473%) [1.5mb]
[  115.3337] microVU1: Cached Prog = [055] [PC=2b90] [List=01] (Cache=2.473%) [1.5mb]
[  115.3339] microVU1: Cached Prog = [056] [PC=1420] [List=01] (Cache=2.491%) [1.5mb]
[  115.3340] microVU1: Cached Prog = [057] [PC=1440] [List=01] (Cache=2.491%) [1.5mb]
[  115.3365] microVU1: Cached Prog = [058] [PC=2ec8] [List=02] (Cache=2.656%) [1.6mb]
[  115.3366] microVU1: Cached Prog = [059] [PC=2ee0] [List=02] (Cache=2.656%) [1.6mb]
[  115.3374] microVU1: Cached Prog = [060] [PC=0000] [List=02] (Cache=2.673%) [1.6mb]
[  115.3374] microVU1: Cached Prog = [061] [PC=1d08] [List=01] (Cache=2.673%) [1.6mb]
[  115.3375] microVU1: Cached Prog = [062] [PC=1d18] [List=01] (Cache=2.673%) [1.6mb]
[  115.3376] microVU1: Cached Prog = [063] [PC=1d48] [List=01] (Cache=2.673%) [1.6mb]
[  115.3376] microVU1: Cached Prog = [064] [PC=0070] [List=01] (Cache=2.673%) [1.6mb]
[  115.3382] microVU1: Cached Prog = [065] [PC=06e8] [List=01] (Cache=2.673%) [1.6mb]
[  115.3383] microVU1: Cached Prog = [066] [PC=0350] [List=01] (Cache=2.673%) [1.6mb]
[  115.3384] microVU1: Cached Prog = [067] [PC=0530] [List=01] (Cache=2.673%) [1.6mb]
[  115.3385] microVU1: Cached Prog = [068] [PC=07d8] [List=01] (Cache=2.673%) [1.6mb]
[  115.3385] microVU1: Cached Prog = [069] [PC=05a0] [List=01] (Cache=2.673%) [1.6mb]
[  115.3385] microVU1: Cached Prog = [070] [PC=1db0] [List=01] (Cache=2.673%) [1.6mb]
[  115.3394] microVU1: Cached Prog = [071] [PC=0458] [List=01] (Cache=2.673%) [1.6mb]
[  115.3400] microVU1: Cached Prog = [072] [PC=0018] [List=02] (Cache=3.026%) [1.8mb]
[  115.3401] microVU1: Cached Prog = [073] [PC=13d0] [List=01] (Cache=3.028%) [1.8mb]
[  115.3403] microVU1: Cached Prog = [074] [PC=13e0] [List=02] (Cache=3.028%) [1.8mb]
[  115.3404] microVU1: Cached Prog = [075] [PC=1450] [List=01] (Cache=3.028%) [1.8mb]
[  115.3405] microVU1: Cached Prog = [076] [PC=0240] [List=01] (Cache=3.028%) [1.8mb]
[  115.3412] microVU1: Cached Prog = [077] [PC=0668] [List=01] (Cache=3.028%) [1.8mb]
[  115.3412] microVU1: Cached Prog = [078] [PC=1488] [List=01] (Cache=3.028%) [1.8mb]
[  115.3421] microVU1: Cached Prog = [079] [PC=10b8] [List=01] (Cache=3.258%) [1.9mb]
[  115.3421] microVU1: Cached Prog = [080] [PC=10c8] [List=01] (Cache=3.258%) [1.9mb]
[  115.3422] microVU1: Cached Prog = [081] [PC=10f0] [List=01] (Cache=3.258%) [1.9mb]
[  115.3422] microVU1: Cached Prog = [082] [PC=0600] [List=01] (Cache=3.258%) [1.9mb]
[  115.3423] microVU1: Cached Prog = [083] [PC=1128] [List=01] (Cache=3.258%) [1.9mb]
[  115.3431] microVU1: Cached Prog = [084] [PC=3218] [List=01] (Cache=3.394%) [2.0mb]
[  115.3432] microVU1: Cached Prog = [085] [PC=3230] [List=02] (Cache=3.394%) [2.0mb]
[  115.3433] microVU1: Cached Prog = [086] [PC=3288] [List=01] (Cache=3.394%) [2.0mb]
[  115.3433] recVifUnpk: Bucket 0x0d12 has 4 micro-programs
[  115.3434] microVU1: Cached Prog = [087] [PC=3568] [List=01] (Cache=3.417%) [2.0mb]
[  115.3434] microVU1: Cached Prog = [088] [PC=3580] [List=02] (Cache=3.417%) [2.0mb]
[  115.3442] microVU1: Cached Prog = [089] [PC=3990] [List=02] (Cache=3.431%) [2.0mb]
[  115.3442] microVU1: Cached Prog = [090] [PC=38d0] [List=02] (Cache=3.431%) [2.0mb]
[  115.3443] microVU1: Cached Prog = [091] [PC=3928] [List=02] (Cache=3.431%) [2.0mb]
[  115.3447] microVU1: Cached Prog = [092] [PC=3608] [List=01] (Cache=3.455%) [2.1mb]
[  115.3447] microVU1: Cached Prog = [093] [PC=35f8] [List=01] (Cache=3.455%) [2.1mb]
[  115.3448] microVU1: Cached Prog = [094] [PC=3570] [List=02] (Cache=3.455%) [2.1mb]
[  115.3830] microVU1: Cached Prog = [095] [PC=32f0] [List=01] (Cache=3.462%) [2.1mb]
[  115.3830] microVU1: Cached Prog = [096] [PC=32e0] [List=01] (Cache=3.462%) [2.1mb]
[  115.3837] microVU1: Cached Prog = [097] [PC=3308] [List=01] (Cache=3.464%) [2.1mb]
[  115.3855] microVU1: Cached Prog = [098] [PC=3cb0] [List=01] (Cache=3.472%) [2.1mb]
[  115.3855] microVU1: Cached Prog = [099] [PC=3cc8] [List=01] (Cache=3.472%) [2.1mb]
[  115.3874] microVU1: Cached Prog = [100] [PC=2828] [List=02] (Cache=3.484%) [2.1mb]
[  115.3875] microVU1: Cached Prog = [101] [PC=2840] [List=02] (Cache=3.484%) [2.1mb]
[  115.3902] microVU1: Cached Prog = [102] [PC=2c38] [List=02] (Cache=3.497%) [2.1mb]
[  115.3904] microVU1: Cached Prog = [103] [PC=2c28] [List=01] (Cache=3.497%) [2.1mb]
[  115.3905] microVU1: Cached Prog = [104] [PC=2b80] [List=01] (Cache=3.497%) [2.1mb]
[  115.3905] microVU1: Cached Prog = [105] [PC=2b90] [List=02] (Cache=3.497%) [2.1mb]
[  115.3908] microVU1: Cached Prog = [106] [PC=2f88] [List=01] (Cache=3.512%) [2.1mb]
[  115.3908] microVU1: Cached Prog = [107] [PC=2f78] [List=01] (Cache=3.512%) [2.1mb]
[  115.3909] microVU1: Cached Prog = [108] [PC=2ed0] [List=01] (Cache=3.512%) [2.1mb]
[  115.3909] microVU1: Cached Prog = [109] [PC=2ee0] [List=03] (Cache=3.512%) [2.1mb]
[  115.3911] microVU1: Cached Prog = [110] [PC=38b8] [List=02] (Cache=3.527%) [2.1mb]
[  115.3912] microVU1: Cached Prog = [111] [PC=38d0] [List=03] (Cache=3.527%) [2.1mb]
[  115.3913] microVU1: Cached Prog = [112] [PC=3c08] [List=01] (Cache=3.540%) [2.1mb]
[  115.3914] microVU1: Cached Prog = [113] [PC=3c20] [List=01] (Cache=3.540%) [2.1mb]
[  115.3927] microVU1: Cached Prog = [114] [PC=2840] [List=03] (Cache=3.556%) [2.1mb]
[  115.3936] microVU1: Cached Prog = [115] [PC=2b78] [List=02] (Cache=3.569%) [2.1mb]
[  115.3936] microVU1: Cached Prog = [116] [PC=2b90] [List=03] (Cache=3.569%) [2.1mb]
[  115.3937] microVU1: Cached Prog = [117] [PC=2be8] [List=01] (Cache=3.569%) [2.1mb]
[  115.3938] microVU1: Cached Prog = [118] [PC=2ec8] [List=03] (Cache=3.591%) [2.1mb]
[  115.3939] microVU1: Cached Prog = [119] [PC=2ee0] [List=04] (Cache=3.591%) [2.1mb]
[  115.3946] microVU1: Cached Prog = [120] [PC=32f0] [List=02] (Cache=3.603%) [2.1mb]
[  115.3947] microVU1: Cached Prog = [121] [PC=3230] [List=03] (Cache=3.603%) [2.1mb]
[  115.3948] microVU1: Cached Prog = [122] [PC=3288] [List=02] (Cache=3.603%) [2.1mb]
[  115.3951] microVU1: Cached Prog = [123] [PC=2f68] [List=01] (Cache=3.626%) [2.2mb]
[  115.3951] microVU1: Cached Prog = [124] [PC=2f58] [List=01] (Cache=3.626%) [2.2mb]
[  115.3952] microVU1: Cached Prog = [125] [PC=2ed0] [List=02] (Cache=3.626%) [2.2mb]
[  115.3962] microVU1: Cached Prog = [126] [PC=2c50] [List=01] (Cache=3.632%) [2.2mb]
[  115.3963] microVU1: Cached Prog = [127] [PC=2c40] [List=01] (Cache=3.632%) [2.2mb]
[  115.3969] microVU1: Cached Prog = [128] [PC=2c68] [List=01] (Cache=3.635%) [2.2mb]
[  115.3981] microVU1: Cached Prog = [129] [PC=3610] [List=01] (Cache=3.643%) [2.2mb]
[  115.3982] microVU1: Cached Prog = [130] [PC=3628] [List=02] (Cache=3.643%) [2.2mb]
[  115.3997] microVU1: Cached Prog = [131] [PC=38b8] [List=03] (Cache=3.654%) [2.2mb]
[  115.3998] microVU1: Cached Prog = [132] [PC=38d0] [List=04] (Cache=3.654%) [2.2mb]
[  115.4020] microVU1: Cached Prog = [133] [PC=3cc8] [List=02] (Cache=3.668%) [2.2mb]
[  115.4022] microVU1: Cached Prog = [134] [PC=3cb8] [List=01] (Cache=3.668%) [2.2mb]
[  115.4022] microVU1: Cached Prog = [135] [PC=3c10] [List=01] (Cache=3.668%) [2.2mb]
[  115.4023] microVU1: Cached Prog = [136] [PC=3c20] [List=02] (Cache=3.668%) [2.2mb]
[  115.4025] microVU1: Cached Prog = [137] [PC=28e8] [List=01] (Cache=3.683%) [2.2mb]
[  115.4025] microVU1: Cached Prog = [138] [PC=28d8] [List=01] (Cache=3.683%) [2.2mb]
[  115.4026] microVU1: Cached Prog = [139] [PC=2830] [List=01] (Cache=3.683%) [2.2mb]
[  115.4026] microVU1: Cached Prog = [140] [PC=2840] [List=04] (Cache=3.683%) [2.2mb]
[  115.4028] microVU1: Cached Prog = [141] [PC=3218] [List=02] (Cache=3.697%) [2.2mb]
[  115.4029] microVU1: Cached Prog = [142] [PC=3230] [List=04] (Cache=3.697%) [2.2mb]
[  115.4031] microVU1: Cached Prog = [143] [PC=3568] [List=02] (Cache=3.711%) [2.2mb]
[  115.4031] microVU1: Cached Prog = [144] [PC=3580] [List=03] (Cache=3.711%) [2.2mb]
[  115.4042] microVU1: Cached Prog = [145] [PC=38d0] [List=05] (Cache=3.726%) [2.2mb]
[  115.4049] microVU1: Cached Prog = [146] [PC=3c08] [List=02] (Cache=3.739%) [2.2mb]
[  115.4050] microVU1: Cached Prog = [147] [PC=3c20] [List=03] (Cache=3.739%) [2.2mb]
[  115.4051] microVU1: Cached Prog = [148] [PC=3c78] [List=01] (Cache=3.739%) [2.2mb]
[  115.4052] microVU1: Cached Prog = [149] [PC=2828] [List=03] (Cache=3.762%) [2.2mb]
[  115.4052] microVU1: Cached Prog = [150] [PC=2840] [List=05] (Cache=3.762%) [2.2mb]
[  115.4058] microVU1: Cached Prog = [151] [PC=2c50] [List=02] (Cache=3.774%) [2.3mb]
[  115.4059] microVU1: Cached Prog = [152] [PC=2b90] [List=04] (Cache=3.774%) [2.3mb]
[  115.4060] microVU1: Cached Prog = [153] [PC=2be8] [List=02] (Cache=3.774%) [2.3mb]
[  115.4063] microVU1: Cached Prog = [154] [PC=28c8] [List=01] (Cache=3.796%) [2.3mb]
[  115.4064] microVU1: Cached Prog = [155] [PC=28b8] [List=01] (Cache=3.796%) [2.3mb]
[  115.4064] microVU1: Cached Prog = [156] [PC=2830] [List=02] (Cache=3.796%) [2.3mb]
[  115.4118] microVU1: Cached Prog = [157] [PC=3ce0] [List=01] (Cache=3.803%) [2.3mb]
[  115.4118] microVU1: Cached Prog = [158] [PC=3cd0] [List=01] (Cache=3.803%) [2.3mb]
[  115.4125] microVU1: Cached Prog = [159] [PC=3cf8] [List=01] (Cache=3.805%) [2.3mb]
[  115.4136] microVU1: Cached Prog = [160] [PC=2f70] [List=01] (Cache=3.814%) [2.3mb]
[  115.4139] microVU1: Cached Prog = [161] [PC=2f88] [List=02] (Cache=3.814%) [2.3mb]
[  115.4158] microVU1: Cached Prog = [162] [PC=3218] [List=03] (Cache=3.825%) [2.3mb]
[  115.4159] microVU1: Cached Prog = [163] [PC=3230] [List=05] (Cache=3.825%) [2.3mb]
[  115.4187] microVU1: Cached Prog = [164] [PC=3580] [List=04] (Cache=3.839%) [2.3mb]
[  115.4192] microVU1: Cached Prog = [165] [PC=3978] [List=01] (Cache=3.849%) [2.3mb]
[  115.4192] microVU1: Cached Prog = [166] [PC=3968] [List=01] (Cache=3.849%) [2.3mb]
[  115.4193] microVU1: Cached Prog = [167] [PC=38d0] [List=06] (Cache=3.849%) [2.3mb]
[  115.4197] microVU1: Cached Prog = [168] [PC=2b90] [List=05] (Cache=3.862%) [2.3mb]
[  115.4199] microVU1: Cached Prog = [169] [PC=2ee0] [List=05] (Cache=3.874%) [2.3mb]
[  115.4214] microVU1: Cached Prog = [170] [PC=3230] [List=06] (Cache=3.889%) [2.3mb]
[  115.4225] microVU1: Cached Prog = [171] [PC=3568] [List=03] (Cache=3.902%) [2.3mb]
[  115.4226] microVU1: Cached Prog = [172] [PC=3580] [List=05] (Cache=3.902%) [2.3mb]
[  115.4227] microVU1: Cached Prog = [173] [PC=35d8] [List=01] (Cache=3.902%) [2.3mb]
[  115.4228] microVU1: Cached Prog = [174] [PC=38b8] [List=04] (Cache=3.924%) [2.3mb]
[  115.4228] microVU1: Cached Prog = [175] [PC=38d0] [List=07] (Cache=3.924%) [2.3mb]
[  115.4234] microVU1: Cached Prog = [176] [PC=3ce0] [List=02] (Cache=3.936%) [2.4mb]
[  115.4235] microVU1: Cached Prog = [177] [PC=3c20] [List=04] (Cache=3.936%) [2.4mb]
[  115.4236] microVU1: Cached Prog = [178] [PC=3c78] [List=02] (Cache=3.936%) [2.4mb]
[  115.4239] microVU1: Cached Prog = [179] [PC=3958] [List=01] (Cache=3.959%) [2.4mb]
[  115.4239] microVU1: Cached Prog = [180] [PC=3948] [List=01] (Cache=3.959%) [2.4mb]
[  115.4241] microVU1: Cached Prog = [181] [PC=38c0] [List=02] (Cache=3.959%) [2.4mb]
[  115.4285] microVU1: Cached Prog = [182] [PC=3640] [List=01] (Cache=3.965%) [2.4mb]
[  115.4286] microVU1: Cached Prog = [183] [PC=3630] [List=01] (Cache=3.965%) [2.4mb]
[  115.4292] microVU1: Cached Prog = [184] [PC=3658] [List=01] (Cache=3.968%) [2.4mb]
[  115.4304] microVU1: Cached Prog = [185] [PC=28d0] [List=01] (Cache=3.976%) [2.4mb]
[  115.4304] microVU1: Cached Prog = [186] [PC=28e8] [List=02] (Cache=3.976%) [2.4mb]
[  115.4321] microVU1: Cached Prog = [187] [PC=2b78] [List=03] (Cache=3.988%) [2.4mb]
[  115.4321] microVU1: Cached Prog = [188] [PC=2b90] [List=06] (Cache=3.988%) [2.4mb]
[  115.4347] microVU1: Cached Prog = [189] [PC=2ee0] [List=06] (Cache=4.001%) [2.4mb]
[  115.4351] microVU1: Cached Prog = [190] [PC=3230] [List=07] (Cache=4.012%) [2.4mb]
[  115.4353] microVU1: Cached Prog = [191] [PC=3c20] [List=05] (Cache=4.022%) [2.4mb]
[  115.4357] microVU1: Cached Prog = [192] [PC=2840] [List=06] (Cache=4.034%) [2.4mb]
[  115.4369] microVU1: Cached Prog = [193] [PC=2b90] [List=07] (Cache=4.049%) [2.4mb]
[  115.4380] microVU1: Cached Prog = [194] [PC=2ec8] [List=04] (Cache=4.062%) [2.4mb]
[  115.4381] microVU1: Cached Prog = [195] [PC=2ee0] [List=07] (Cache=4.062%) [2.4mb]
[  115.4382] microVU1: Cached Prog = [196] [PC=2f38] [List=01] (Cache=4.062%) [2.4mb]
[  115.4383] microVU1: Cached Prog = [197] [PC=3218] [List=04] (Cache=4.084%) [2.4mb]
[  115.4383] microVU1: Cached Prog = [198] [PC=3230] [List=08] (Cache=4.084%) [2.4mb]
[  115.4389] microVU1: Cached Prog = [199] [PC=3640] [List=02] (Cache=4.096%) [2.4mb]
[  115.4390] microVU1: Cached Prog = [200] [PC=3580] [List=06] (Cache=4.096%) [2.4mb]
[  115.4391] microVU1: Cached Prog = [201] [PC=35d8] [List=02] (Cache=4.096%) [2.4mb]
[  115.4393] microVU1: Cached Prog = [202] [PC=32b8] [List=01] (Cache=4.118%) [2.5mb]
[  115.4394] microVU1: Cached Prog = [203] [PC=32a8] [List=01] (Cache=4.118%) [2.5mb]
[  115.4394] microVU1: Cached Prog = [204] [PC=3220] [List=02] (Cache=4.118%) [2.5mb]
[  115.4451] microVU1: Cached Prog = [205] [PC=2fa0] [List=01] (Cache=4.125%) [2.5mb]
[  115.4452] microVU1: Cached Prog = [206] [PC=2f90] [List=01] (Cache=4.125%) [2.5mb]
[  115.4459] microVU1: Cached Prog = [207] [PC=2fb8] [List=01] (Cache=4.128%) [2.5mb]
[  115.4472] microVU1: Cached Prog = [208] [PC=3960] [List=01] (Cache=4.136%) [2.5mb]
[  115.4475] microVU1: Cached Prog = [209] [PC=3978] [List=02] (Cache=4.136%) [2.5mb]
[  115.4493] microVU1: Cached Prog = [210] [PC=3c08] [List=03] (Cache=4.147%) [2.5mb]
[  115.4494] microVU1: Cached Prog = [211] [PC=3c20] [List=06] (Cache=4.147%) [2.5mb]
[  115.4521] microVU1: Cached Prog = [212] [PC=2840] [List=07] (Cache=4.161%) [2.5mb]
[  115.4526] microVU1: Cached Prog = [213] [PC=2b90] [List=08] (Cache=4.172%) [2.5mb]
[  115.4528] microVU1: Cached Prog = [214] [PC=3580] [List=07] (Cache=4.182%) [2.5mb]
[  115.4532] microVU1: Cached Prog = [215] [PC=38d0] [List=08] (Cache=4.194%) [2.5mb]
[  115.4548] microVU1: Cached Prog = [216] [PC=3c20] [List=07] (Cache=4.208%) [2.5mb]
[  115.4559] microVU1: Cached Prog = [217] [PC=2828] [List=04] (Cache=4.221%) [2.5mb]
[  115.4559] microVU1: Cached Prog = [218] [PC=2840] [List=08] (Cache=4.221%) [2.5mb]
[  115.4560] microVU1: Cached Prog = [219] [PC=2898] [List=01] (Cache=4.221%) [2.5mb]
[  115.4561] microVU1: Cached Prog = [220] [PC=2b78] [List=04] (Cache=4.244%) [2.5mb]
[  115.4562] microVU1: Cached Prog = [221] [PC=2b90] [List=09] (Cache=4.244%) [2.5mb]
[  115.4568] microVU1: Cached Prog = [222] [PC=2fa0] [List=02] (Cache=4.256%) [2.5mb]
[  115.4568] microVU1: Cached Prog = [223] [PC=2ee0] [List=08] (Cache=4.256%) [2.5mb]
[  115.4569] microVU1: Cached Prog = [224] [PC=2f38] [List=02] (Cache=4.256%) [2.5mb]
[  115.4572] microVU1: Cached Prog = [225] [PC=2c18] [List=01] (Cache=4.278%) [2.6mb]
[  115.4573] microVU1: Cached Prog = [226] [PC=2c08] [List=01] (Cache=4.278%) [2.6mb]
[  115.4573] microVU1: Cached Prog = [227] [PC=2b80] [List=02] (Cache=4.278%) [2.6mb]
[  115.4619] microVU1: Cached Prog = [228] [PC=2900] [List=01] (Cache=4.285%) [2.6mb]
[  115.4619] microVU1: Cached Prog = [229] [PC=28f0] [List=01] (Cache=4.285%) [2.6mb]
[  115.4627] microVU1: Cached Prog = [230] [PC=2918] [List=01] (Cache=4.288%) [2.6mb]
[  115.4640] microVU1: Cached Prog = [231] [PC=32c0] [List=01] (Cache=4.296%) [2.6mb]
[  115.4641] microVU1: Cached Prog = [232] [PC=32d8] [List=02] (Cache=4.296%) [2.6mb]
[  115.4658] microVU1: Cached Prog = [233] [PC=3568] [List=04] (Cache=4.307%) [2.6mb]
[  115.4659] microVU1: Cached Prog = [234] [PC=3580] [List=08] (Cache=4.307%) [2.6mb]
[  115.4686] microVU1: Cached Prog = [235] [PC=38d0] [List=09] (Cache=4.321%) [2.6mb]
[  115.4691] microVU1: Cached Prog = [236] [PC=3c20] [List=08] (Cache=4.331%) [2.6mb]
[  115.4693] microVU1: Cached Prog = [237] [PC=2ee0] [List=09] (Cache=4.342%) [2.6mb]
[  115.4698] microVU1: Cached Prog = [238] [PC=3230] [List=09] (Cache=4.354%) [2.6mb]
[  115.4715] microVU1: Cached Prog = [239] [PC=3580] [List=09] (Cache=4.368%) [2.6mb]
[  115.4727] microVU1: Cached Prog = [240] [PC=3c08] [List=04] (Cache=4.381%) [2.6mb]
[  115.4728] microVU1: Cached Prog = [241] [PC=3c20] [List=09] (Cache=4.381%) [2.6mb]
[  115.4735] microVU1: Cached Prog = [242] [PC=2900] [List=02] (Cache=4.393%) [2.6mb]
[  115.4735] microVU1: Cached Prog = [243] [PC=2840] [List=09] (Cache=4.393%) [2.6mb]
[  115.4737] microVU1: Cached Prog = [244] [PC=2898] [List=02] (Cache=4.393%) [2.6mb]
[  115.4740] microVU1: Cached Prog = [245] [PC=3ca8] [List=01] (Cache=4.416%) [2.6mb]
[  115.4740] microVU1: Cached Prog = [246] [PC=3c98] [List=01] (Cache=4.416%) [2.6mb]
[  115.4741] microVU1: Cached Prog = [247] [PC=3c10] [List=02] (Cache=4.416%) [2.6mb]
[  115.8484] Auto-ejecting memcard [port:0, slot:0]
[  118.5122] recVifUnpk: Bucket 0x0d12 has 5 micro-programs
[  118.5122] microVU1: Cached Prog = [248] [PC=2ec8] [List=05] (Cache=4.421%) [2.6mb]
[  118.5232] microVU1: Cached Prog = [249] [PC=2b78] [List=05] (Cache=4.422%) [2.6mb]
[  118.5406] microVU1: Cached Prog = [250] [PC=2828] [List=05] (Cache=4.424%) [2.6mb]
[  118.5577] microVU1: Cached Prog = [251] [PC=3c08] [List=05] (Cache=4.425%) [2.6mb]
[  118.5750] microVU1: Cached Prog = [252] [PC=38b8] [List=05] (Cache=4.426%) [2.7mb]
[  118.5915] microVU1: Cached Prog = [253] [PC=3568] [List=05] (Cache=4.428%) [2.7mb]
[  118.6078] microVU1: Cached Prog = [254] [PC=3218] [List=05] (Cache=4.429%) [2.7mb]
[  119.4011] Auto-eject: Timeout reached after mcd was accessed 19 times [port:0, slot:0]
[  119.4012] Re-inserting auto-ejected memcard [port:0, slot:0]
[  121.7615] recVifUnpk: Bucket 0x0d0f has 4 micro-programs
[  121.7954] microVU1: Cached Prog = [255] [PC=0f28] [List=01] (Cache=4.442%) [2.7mb]
[  121.7954] microVU1: Cached Prog = [256] [PC=0f38] [List=01] (Cache=4.442%) [2.7mb]
[  121.7955] microVU1: Cached Prog = [257] [PC=0f60] [List=01] (Cache=4.442%) [2.7mb]
[  121.7956] microVU1: Cached Prog = [258] [PC=0698] [List=01] (Cache=4.442%) [2.7mb]
[  121.7956] microVU1: Cached Prog = [259] [PC=0f88] [List=01] (Cache=4.442%) [2.7mb]
[  124.0929] recVifUnpk: Bucket 0x0d0f has 5 micro-programs
[  124.0929] recVifUnpk: Bucket 0x2e0f has 4 micro-programs
[  125.5336] microVU1: Cached Prog = [260] [PC=2c50] [List=03] (Cache=4.552%) [2.7mb]
[  125.5340] microVU1: Cached Prog = [261] [PC=2180] [List=01] (Cache=4.552%) [2.7mb]
[  125.5341] microVU1: Cached Prog = [262] [PC=2190] [List=01] (Cache=4.552%) [2.7mb]
[  125.5341] microVU1: 2 cycle stall on branch instruction [21c8]
[  125.5341] microVU1: 2 cycle stall on branch instruction [21c8]
[  125.5342] microVU1: Cached Prog = [263] [PC=2170] [List=01] (Cache=4.552%) [2.7mb]
[  125.5343] microVU1: Cached Prog = [264] [PC=2438] [List=01] (Cache=4.552%) [2.7mb]
[  125.5346] microVU1: Cached Prog = [265] [PC=2fa0] [List=03] (Cache=4.601%) [2.8mb]
[  126.5736] recVifUnpk: Bucket 0x0d0c has 4 micro-programs
[  127.2499] recVifUnpk: Bucket 0x0d08 has 4 micro-programs
[  129.4173] recVifUnpk: Bucket 0x0d07 has 4 micro-programs
[  130.5523] recVifUnpk: Bucket 0x0d06 has 4 micro-programs
[  134.7325] recVifUnpk: Bucket 0x0d0c has 5 micro-programs
[  134.7326] recVifUnpk: Bucket 0x2e0c has 4 micro-programs
[  152.9363] recVifUnpk: Bucket 0x0520 has 4 micro-programs
[  152.9363] recVifUnpk: Bucket 0x0d20 has 4 micro-programs
[  153.4514] recVifUnpk: Bucket 0x0537 has 4 micro-programs
[  153.4542] recVifUnpk: Bucket 0x0538 has 4 micro-programs
[  153.4729] microVU1: Cached Prog = [266] [PC=3970] [List=01] (Cache=4.625%) [2.8mb]
[  153.4838] microVU1: Cached Prog = [267] [PC=2f80] [List=01] (Cache=4.626%) [2.8mb]
[  153.5007] microVU1: Cached Prog = [268] [PC=3cc0] [List=01] (Cache=4.627%) [2.8mb]
[  153.5174] microVU1: Cached Prog = [269] [PC=32d0] [List=01] (Cache=4.629%) [2.8mb]
[  153.5343] microVU1: Cached Prog = [270] [PC=28e0] [List=01] (Cache=4.630%) [2.8mb]
[  153.5507] microVU1: Cached Prog = [271] [PC=3620] [List=01] (Cache=4.632%) [2.8mb]
[  153.5672] microVU1: Cached Prog = [272] [PC=2c30] [List=01] (Cache=4.633%) [2.8mb]
[  155.6698] recVifUnpk: Bucket 0x0d0e has 4 micro-programs
[  155.6884] recVifUnpk: Bucket 0x0d27 has 4 micro-programs
[  155.9928] recVifUnpk: Bucket 0x0517 has 4 micro-programs
[  156.0555] recVifUnpk: Bucket 0x0d0b has 4 micro-programs
[  167.4661] Bios Found: Europe  v01.60(04/10/2001)  Console
[  167.4723] Bios Found: Japan  v01.00(17/01/2000)  Console
[  167.4777] Bios Found: Europe  v01.60(04/10/2001)  Console
[  167.4892] Bios Found: Europe  v02.00(14/06/2004)  Console
[  167.5193] Bios Found: USA    v02.00(14/06/2004)  Console
[  167.5248] Bios Found: Japan  v01.00(17/01/2000)  Console
[  167.5302] Bios Found: Europe  v01.60(04/10/2001)  Console
[  167.5401] Bios Found: USA    v01.60(07/02/2002)  Console
[  170.7562] Applying settings...
[  170.7597] [GameDB] Searching for 'scus-97481' in GameDB
[  170.7597] [GameDB] Found 'scus-97481' in GameDB
[  170.7597] [GameDB] Enabled GS Hardware Fix: alignSprite to [mode=1]
[  170.7597] [GameDB] Enabled GS Hardware Fix: halfPixelOffset to [mode=2]
[  170.7597] [GameDB] Enabled GS Hardware Fix: roundSprite to [mode=1]
[  170.7597] [GameDB] Enabled GS Hardware Fix: autoFlush to [mode=1]
[  171.6689] FMV started
[  171.9240] FMV ended
[  173.3597] recVifUnpk: Bucket 0x0535 has 4 micro-programs
[  173.3601] recVifUnpk: Bucket 0x0520 has 5 micro-programs
[  173.9042] microVU1: Cached Prog = [273] [PC=2c30] [List=02] (Cache=4.634%) [2.8mb]
[  173.9208] microVU1: Cached Prog = [274] [PC=3620] [List=02] (Cache=4.646%) [2.8mb]
[  173.9372] microVU1: Cached Prog = [275] [PC=28e0] [List=02] (Cache=4.654%) [2.8mb]
[  173.9543] microVU1: Cached Prog = [276] [PC=32d0] [List=02] (Cache=4.663%) [2.8mb]
[  173.9708] microVU1: Cached Prog = [277] [PC=3cc0] [List=02] (Cache=4.672%) [2.8mb]
[  173.9876] microVU1: Cached Prog = [278] [PC=2f80] [List=02] (Cache=4.681%) [2.8mb]
[  174.0042] microVU1: Cached Prog = [279] [PC=3970] [List=02] (Cache=4.689%) [2.8mb]
[  179.8367] Applying settings...
[  179.8374] [GameDB] Searching for 'scus-97481' in GameDB
[  179.8374] [GameDB] Found 'scus-97481' in GameDB
[  179.8376] [GameDB] Enabled GS Hardware Fix: alignSprite to [mode=1]
[  179.8376] [GameDB] Enabled GS Hardware Fix: halfPixelOffset to [mode=2]
[  179.8376] [GameDB] Enabled GS Hardware Fix: roundSprite to [mode=1]
[  179.8376] [GameDB] Enabled GS Hardware Fix: autoFlush to [mode=1]
[  182.1781] Refresh rate: Host=59.940059hz Guest=59.939998hz Ratio=1.000001 - can sync and using vsync for pacing
[  182.1781] Set GS CRTC configuration. NTSC 640x448 @ 59.940 (59.82) Interlaced (FIELD)
[  182.1793] microVU1: Cached Prog = [280] [PC=0400] [List=01] (Cache=4.698%) [2.8mb]
[  182.1877] FMV started
[  225.5227] recVifUnpk: Bucket 0x0d04 has 4 micro-programs
[  225.5261] microVU1: Cached Prog = [281] [PC=2f58] [List=02] (Cache=4.700%) [2.8mb]
[  225.5262] microVU1: Cached Prog = [282] [PC=2f48] [List=01] (Cache=4.700%) [2.8mb]
[  225.5262] microVU1: Cached Prog = [283] [PC=2ee0] [List=10] (Cache=4.700%) [2.8mb]
[  225.5264] recVifUnpk: Bucket 0x0d14 has 4 micro-programs
[  225.5264] recVifUnpk: Bucket 0x2e14 has 4 micro-programs
[  225.5583] recVifUnpk: Bucket 0x0d09 has 4 micro-programs
[  225.5583] recVifUnpk: Bucket 0x0527 has 4 micro-programs
[  225.5583] recVifUnpk: Bucket 0x0d27 has 5 micro-programs
[  225.5584] recVifUnpk: Bucket 0x0d2b has 4 micro-programs
[  225.5585] recVifUnpk: Bucket 0x0d04 has 5 micro-programs
[  225.5603] recVifUnpk: Bucket 0x0d0a has 4 micro-programs
[  225.5793] FMV ended
[  233.3886] microVU1: Cached Prog = [284] [PC=0728] [List=01] (Cache=4.712%) [2.8mb]
[  234.5832] recVifUnpk: Bucket 0x0525 has 4 micro-programs
[  234.8013] microVU1: Cached Prog = [285] [PC=3300] [List=01] (Cache=4.716%) [2.8mb]
[  234.8014] microVU1: Cached Prog = [286] [PC=32f0] [List=03] (Cache=4.717%) [2.8mb]
[  234.8015] microVU1: Cached Prog = [287] [PC=3220] [List=03] (Cache=4.717%) [2.8mb]
[  234.8037] microVU1: Cached Prog = [288] [PC=3698] [List=01] (Cache=4.720%) [2.8mb]
[  234.8038] microVU1: Cached Prog = [289] [PC=36b0] [List=01] (Cache=4.720%) [2.8mb]
[  241.8057] microVU1: Cached Prog = [290] [PC=32a8] [List=02] (Cache=4.737%) [2.8mb]
[  241.8058] microVU1: Cached Prog = [291] [PC=3298] [List=01] (Cache=4.737%) [2.8mb]
[  241.8058] microVU1: Cached Prog = [292] [PC=3230] [List=10] (Cache=4.737%) [2.8mb]
[  241.8554] microVU1: Cached Prog = [293] [PC=35f8] [List=02] (Cache=4.750%) [2.8mb]
[  241.8554] microVU1: Cached Prog = [294] [PC=35e8] [List=01] (Cache=4.750%) [2.8mb]
[  241.8555] microVU1: Cached Prog = [295] [PC=3580] [List=10] (Cache=4.750%) [2.8mb]
[  241.8736] microVU1: Cached Prog = [296] [PC=2958] [List=01] (Cache=4.763%) [2.9mb]
[  241.8737] microVU1: Cached Prog = [297] [PC=2970] [List=01] (Cache=4.763%) [2.9mb]
[  241.9056] microVU1: Cached Prog = [298] [PC=3948] [List=02] (Cache=4.777%) [2.9mb]
[  241.9056] microVU1: Cached Prog = [299] [PC=3938] [List=01] (Cache=4.777%) [2.9mb]
[  241.9057] microVU1: Cached Prog = [300] [PC=38d0] [List=10] (Cache=4.777%) [2.9mb]
[  241.9555] microVU1: Cached Prog = [301] [PC=3c98] [List=02] (Cache=4.790%) [2.9mb]
[  241.9555] microVU1: Cached Prog = [302] [PC=3c88] [List=01] (Cache=4.790%) [2.9mb]
[  241.9556] microVU1: Cached Prog = [303] [PC=3c20] [List=10] (Cache=4.790%) [2.9mb]
[  242.0057] microVU1: Cached Prog = [304] [PC=28b8] [List=02] (Cache=4.803%) [2.9mb]
[  242.0058] microVU1: Cached Prog = [305] [PC=28a8] [List=01] (Cache=4.803%) [2.9mb]
[  242.0058] microVU1: Cached Prog = [306] [PC=2840] [List=10] (Cache=4.803%) [2.9mb]
[  242.0557] microVU1: Cached Prog = [307] [PC=2c08] [List=02] (Cache=4.815%) [2.9mb]
[  242.0558] microVU1: Cached Prog = [308] [PC=2bf8] [List=01] (Cache=4.815%) [2.9mb]
[  242.0558] microVU1: Cached Prog = [309] [PC=2b90] [List=10] (Cache=4.815%) [2.9mb]
[  253.4699] microVU1: Cached Prog = [310] [PC=3348] [List=01] (Cache=4.828%) [2.9mb]
[  253.4700] microVU1: Cached Prog = [311] [PC=3360] [List=01] (Cache=4.828%) [2.9mb]
[  253.4702] microVU1: Cached Prog = [312] [PC=2fb0] [List=01] (Cache=4.843%) [2.9mb]
[  253.4703] microVU1: Cached Prog = [313] [PC=2fa0] [List=04] (Cache=4.843%) [2.9mb]
[  253.4703] microVU1: Cached Prog = [314] [PC=2ed0] [List=03] (Cache=4.843%) [2.9mb]
[  255.0383] microVU1: Cached Prog = [315] [PC=39e8] [List=01] (Cache=4.847%) [2.9mb]
[  255.0384] microVU1: Cached Prog = [316] [PC=3a00] [List=01] (Cache=4.847%) [2.9mb]
[  255.0386] microVU1: Cached Prog = [317] [PC=3650] [List=01] (Cache=4.862%) [2.9mb]
[  255.0387] microVU1: Cached Prog = [318] [PC=3640] [List=03] (Cache=4.862%) [2.9mb]
[  255.0387] microVU1: Cached Prog = [319] [PC=3570] [List=03] (Cache=4.862%) [2.9mb]
[  255.0545] microVU1: Cached Prog = [320] [PC=3d38] [List=01] (Cache=4.866%) [2.9mb]
[  255.0545] microVU1: Cached Prog = [321] [PC=3d50] [List=01] (Cache=4.866%) [2.9mb]
[  255.0548] microVU1: Cached Prog = [322] [PC=39a0] [List=01] (Cache=4.880%) [2.9mb]
[  255.0548] microVU1: Cached Prog = [323] [PC=3990] [List=03] (Cache=4.880%) [2.9mb]
[  255.0549] microVU1: Cached Prog = [324] [PC=38c0] [List=03] (Cache=4.880%) [2.9mb]
[  265.0534] microVU1: Cached Prog = [325] [PC=1ed0] [List=01] (Cache=4.884%) [2.9mb]
[  265.0534] microVU1: Cached Prog = [326] [PC=1ee0] [List=01] (Cache=4.884%) [2.9mb]
[  265.0535] microVU1: Cached Prog = [327] [PC=1f08] [List=01] (Cache=4.884%) [2.9mb]
[  265.0536] microVU1: Cached Prog = [328] [PC=0580] [List=01] (Cache=4.884%) [2.9mb]
[  265.0536] microVU1: Cached Prog = [329] [PC=1f78] [List=01] (Cache=4.884%) [2.9mb]
[  267.7532] microVU1: Cached Prog = [330] [PC=01d0] [List=01] (Cache=5.027%) [3.0mb]
[  269.0957] microVU1: Cached Prog = [331] [PC=2c60] [List=01] (Cache=5.117%) [3.1mb]
[  269.0959] microVU1: Cached Prog = [332] [PC=2c50] [List=04] (Cache=5.117%) [3.1mb]
[  269.0961] microVU1: Cached Prog = [333] [PC=2b80] [List=03] (Cache=5.117%) [3.1mb]
[  269.1325] microVU1: Cached Prog = [334] [PC=2ca8] [List=01] (Cache=5.121%) [3.1mb]
[  269.1326] microVU1: Cached Prog = [335] [PC=2cc0] [List=01] (Cache=5.121%) [3.1mb]
[  269.1338] microVU1: Cached Prog = [336] [PC=3cf0] [List=01] (Cache=5.135%) [3.1mb]
[  269.1340] microVU1: Cached Prog = [337] [PC=3ce0] [List=03] (Cache=5.135%) [3.1mb]
[  269.1342] microVU1: Cached Prog = [338] [PC=3c10] [List=03] (Cache=5.135%) [3.1mb]
[  269.1882] microVU1: Cached Prog = [339] [PC=2ff8] [List=01] (Cache=5.139%) [3.1mb]
[  269.1883] microVU1: Cached Prog = [340] [PC=3010] [List=01] (Cache=5.139%) [3.1mb]
[  269.1886] microVU1: Cached Prog = [341] [PC=2910] [List=01] (Cache=5.154%) [3.1mb]
[  269.1886] microVU1: Cached Prog = [342] [PC=2900] [List=03] (Cache=5.154%) [3.1mb]
[  269.1887] microVU1: Cached Prog = [343] [PC=2830] [List=03] (Cache=5.154%) [3.1mb]

It would be helpful to know which settings have to be used for a proper log-file, please tell me which ones (assuming I can manage to understand of course).
I checked "verbose logging" in the Debug menu for this one, so hopefully it gives more info.
*edit: The message was now too long lol, so I had to again cut the half of the code. Great! So will post this in the next message. This makes a lot of sense...




One more thing:
In that scene with the pool, this guy used to look "invisible", like in the first predator movie. Not black.