24:36:770 EmuThread.cpp:122 I[BOOT]: Done.
24:42:377 Config.cpp:698 I[LOAD]: Config saved: H:\Downloads\ppsspp-v0.9.6-691-g4f2f8f0-windows-x86\ppsspp\memstick/PSP/SYSTEM/ppsspp.ini
24:42:378 Config.cpp:710 I[LOAD]: Controller config saved: H:\Downloads\ppsspp-v0.9.6-691-g4f2f8f0-windows-x86\ppsspp\memstick/PSP/SYSTEM/controls.ini
24:53:512 System.cpp:315 I[BOOT]: PPSSPP v0.9.6-691-g4f2f8f0 Windows 32 bit
24:53:528 MemArena.cpp:379 I[MM]: Found valid memory base at 09800000 after 35 tries.
24:53:528 MemMap.cpp:125 I[MM]: Memory system initialized. RAM at 0AC20000 (mirror at 0 @ 11800000, uncached @ 11800000)
24:53:697 PSPLoaders.cpp:120 I[LOAD]: ULJM05186 : HEAVEN'S WILL
24:53:697 PSPLoaders.cpp:190 I[LOAD]: Loading disc0:/PSP_GAME/SYSDIR/EBOOT.BIN...
24:53:697 HLE\sceKernelMemory.cpp:215 I[KERNEL]: Kernel and user memory pools initialized
24:53:757 HLE\sceKernel.cpp:141 I[KERNEL]: Kernel initialized.
24:53:813 Util\BlockAllocator.cpp:381 I[HLE]: -----------
24:53:813 Util\BlockAllocator.cpp:385 I[HLE]: Block: 08800000 - 08804000 size 00004000 taken=0 tag=(untitled)
24:53:813 Util\BlockAllocator.cpp:385 I[HLE]: Block: 08804000 - 08a82700 size 0027e700 taken=1 tag=ELF
24:53:813 Util\BlockAllocator.cpp:385 I[HLE]: Block: 08a82700 - 0c000000 size 0357d900 taken=0 tag=(untitled)
24:53:813 Util\BlockAllocator.cpp:387 I[HLE]: -----------
24:53:835 HLE\sceKernelModule.cpp:871 I[LOAD]: Module mini: 08a0fce0 088ab7bc 088ab7d4
24:53:835 HLE\sceKernelModule.cpp:1069 I[LOAD]: Exporting ent 0 named mini, 2 funcs, 3 vars, resident 088abb60
24:53:836 HLE\sceKernelModule.cpp:1354 I[LOAD]: Module entry: 0882c4bc
24:54:261 root         N[BOOT]: EmuScreen.cpp:127 Loading H:/ISO/PSP-Heavens_Will_JPN.ISO...
24:54:360 root         I[KERNEL]: HLE\sceKernelThread.cpp:2137 276=sceKernelCreateThread(name=user_main, entry=0882c5c8, prio=20, stacksize=262144)
24:54:360 root         I[KERNEL]: HLE\sceKernelThread.cpp:2188 sceKernelStartThread(thread=276, argSize=33, argPtr=0bfffed0)
24:54:360 root         I[KERNEL]: HLE\sceKernelThread.cpp:2268 __KernelReturnFromThread: 0
24:54:362 user_main    I[IO]: HLE\sceIo.cpp:842 stdout: load data.dat...
24:54:362 user_main    I[IO]: HLE\sceIo.cpp:842 stdout: [psp]  <<--- ( in ) ---  [ms] 
24:54:362 user_main    W[KERNEL]: HLE\sceKernelThread.cpp:1715 UNTESTED - waiting within a callback, probably bad mojo.
24:54:362 user_main    I[IO]: HLE\sceIo.cpp:842 stdout: load data.dat finish
24:54:362 user_main    I[IO]: HLE\sceIo.cpp:842 stdout: load module
24:54:469 user_main    I[MODULE]: HLE\sceKernelModule.cpp:731 ~SCE module, skipping header
24:54:469 user_main    I[HLE]: ELF\PrxDecrypter.cpp:300 Missing key 5B, cannot decrypt module
24:54:469 user_main    I[MODULE]: HLE\sceKernelModule.cpp:1906 283=sceKernelLoadModuleByID(4,flag=00000000,00000014,00000002,00000002,position = 00000000)
24:54:469 user_main    I[MODULE]: HLE\sceKernelModule.cpp:1526 sceKernelStartModule(283,asize=00000000,aptr=00000000,retptr=0bfff668,00000000): faked (undecryptable module)
24:54:469 user_main    E[NET]: HLE\sceNet.cpp:118 UNIMPL sceNetInit(poolsize=131072, calloutpri=40, calloutstack=0, netintrpri=40, netintrstack=0)
24:54:469 user_main    W[NET]: HLE\sceNetAdhoc.cpp:817 UNTESTED sceNetAdhocctlAddHandler(88333dc, 0): added handler 0
24:54:469 user_main    W[NET]: HLE\sceNetAdhoc.cpp:817 UNTESTED sceNetAdhocctlAddHandler(88a0b00, 8a810b4): added handler 1
24:54:469 user_main    I[SCESAS]: HLE\sceSas.cpp:99 sceSasInit(08a109c0, 2048, 32, 0, 44100)
24:54:469 user_main    I[KERNEL]: HLE\sceKernelThread.cpp:2137 285=sceKernelCreateThread(name=ATRAC3 play thread, entry=0882d0c8, prio=10, stacksize=32768)
24:54:469 user_main    I[KERNEL]: HLE\sceKernelThread.cpp:2188 sceKernelStartThread(thread=285, argSize=8, argPtr=0bfff694)
24:54:469 user_main    I[KERNEL]: HLE\sceKernelThread.cpp:2137 286=sceKernelCreateThread(name=file io thread, entry=0882ee60, prio=15, stacksize=2048)
24:54:469 user_main    I[KERNEL]: HLE\sceKernelThread.cpp:2188 sceKernelStartThread(thread=286, argSize=4, argPtr=08a1ebcc)
24:54:470 user_main    I[ME]: HLE\sceMpeg.cpp:365 sceMpegInit()
24:54:470 user_main    I[IO]: HLE\sceIo.cpp:842 stdout: movie buffer size = 0x21a000
24:54:470 user_main    I[IO]: HLE\sceIo.cpp:842 stdout: ring buffer size=2203648
24:54:470 user_main    I[IO]: HLE\sceIo.cpp:842 stdout: lib buffer size=65536
24:54:470 user_main    I[IO]: HLE\sceIo.cpp:842 stdout: ring buffer construct
24:54:470 user_main    I[ME]: HLE\sceMpeg.cpp:466 09b83490=sceMpegCreate(08a34330, 09b83460, 65536, 08a3429c, 512, 0, 0)
24:54:470 user_main    I[ME]: HLE\sceMpeg.cpp:584 sceMpegRegistStream(08a34330, 0, 0)
24:54:470 user_main    I[ME]: HLE\sceMpeg.cpp:584 sceMpegRegistStream(08a34330, 1, 0)
24:54:470 user_main    I[IO]: HLE\sceIo.cpp:842 stdout: audio buffer size=2112 -- 8192 
24:54:471 user_main    I[IO]: HLE\sceIo.cpp:842 stdout: display buffer size=40
24:54:471 user_main    E[ME]: HLE\sceMpeg.cpp:1426 UNIMPL sceMpegAvcInitYCbCr(08a34330, 1, 480, 272, 09b93d20)
24:54:471 user_main    E[ME]: HLE\sceMpeg.cpp:1426 UNIMPL sceMpegAvcInitYCbCr(08a34330, 1, 480, 272, 09bc3ab0)
24:54:471 user_main    E[ME]: HLE\sceMpeg.cpp:1426 UNIMPL sceMpegAvcInitYCbCr(08a34330, 1, 480, 272, 09bf3840)
24:54:471 user_main    E[ME]: HLE\sceMpeg.cpp:1426 UNIMPL sceMpegAvcInitYCbCr(08a34330, 1, 480, 272, 09c235d0)
24:54:471 user_main    I[IO]: HLE\sceIo.cpp:842 stdout: sound buffer size=40
24:54:472 ATRAC3 play  E[ME]: HLE\sceAtrac.cpp:894 sceAtracGetRemainFrame(0, 0bfbfa8c): bad atrac ID
24:54:496 user_main    I[SCEGE]: GLES\Framebuffer.cpp:794 Creating FBO for 00000000 : 480 x 272 x 1
24:54:507 user_main    I[G3D]: GLES\ShaderManager.cpp:146 Linked shader: vs 13 fs 14
24:54:542 user_main    I[G3D]: GLES\ShaderManager.cpp:146 Linked shader: vs 16 fs 17
24:54:566 idle0        W[HLE]: HLE\HLE.cpp:83 Someone else woke up HLE-blocked thread?
24:54:585 user_main    I[SCEGE]: GLES\Framebuffer.cpp:794 Creating FBO for 00044000 : 480 x 272 x 1
24:56:179 user_main    I[UTIL]: Dialog\PSPSaveDialog.cpp:61 sceUtilitySavedataInitStart(08a71520) : Mode = 0
24:56:218 user_main    I[UTIL]: Dialog\SavedataParam.cpp:543 Loading file with size 14336 in ms0:/PSP/SAVEDATA/ULJM05186DATA00/DATA.BIN
24:56:233 user_main    E[FileSys]: FileSystems\DirectoryFileSystem.cpp:462 DirectoryFileSystem::OpenFile: FAILED, 3 - access = 1
24:56:233 user_main    E[UTIL]: Dialog\SavedataParam.cpp:547 Error reading file ms0:/PSP/SAVEDATA/ULJM05186DATA00/DATA.BIN
24:56:379 user_main    I[UTIL]: Dialog\PSPSaveDialog.cpp:61 sceUtilitySavedataInitStart(08a71520) : Mode = 8
24:56:512 user_main    I[IO]: HLE\sceIo.cpp:842 stdout: ms-free-size        = 1048576
24:56:512 user_main    I[IO]: HLE\sceIo.cpp:842 stdout: ms-clust-size       = 32768
24:56:512 user_main    I[IO]: HLE\sceIo.cpp:842 stdout: save-structure-size = 12124
24:56:512 user_main    I[IO]: HLE\sceIo.cpp:842 stdout: save-data-size(ms)  = 96
24:56:512 user_main    I[IO]: HLE\sceIo.cpp:842 stdout: save-data-size(32)  = 96
24:57:146 user_main    I[IO]: HLE\sceIo.cpp:842 stdout: ********** PlayMovie **********
24:57:151 user_main    I[ME]: HLE\sceMpeg.cpp:302 Stream offset: 2048, Stream size: 0x10C800
24:57:151 user_main    I[ME]: HLE\sceMpeg.cpp:303 First timestamp: 90000, Last timestamp: 900810
24:57:234 user_main    I[ME]: HW\MediaEngine.cpp:84 FF: No accelerated colorspace conversion found from yuv420p to rgba.
24:57:298 user_main    I[G3D]: GLES\ShaderManager.cpp:146 Linked shader: vs 19 fs 20
24:57:350 user_main    I[G3D]: GLES\ShaderManager.cpp:146 Linked shader: vs 16 fs 22
25:05:991 user_main    I[ME]: HLE\sceMpeg.cpp:1177 Audio end reach. pts: 900920 dts: 810810
25:06:023 user_main    I[ME]: HLE\sceMpeg.cpp:1177 Audio end reach. pts: 900920 dts: 810810
25:06:058 user_main    I[ME]: HLE\sceMpeg.cpp:1177 Audio end reach. pts: 900920 dts: 810810
25:06:091 user_main    I[ME]: HLE\sceMpeg.cpp:1177 Audio end reach. pts: 900920 dts: 810810
25:06:123 user_main    I[ME]: HLE\sceMpeg.cpp:1177 Audio end reach. pts: 900920 dts: 810810
25:06:156 user_main    I[ME]: HLE\sceMpeg.cpp:1177 Audio end reach. pts: 900920 dts: 810810
25:06:223 user_main    E[ME]: HLE\sceMpeg.cpp:821 UNIMPL sceMpegAvcDecodeStopYCbCr(08a34330, 08a301c4, 0bfff634)
25:06:223 user_main    W[ME]: HLE\sceMpeg.cpp:1305 UNIMPL sceMpegFlushAllStream(08a34330)
25:06:289 user_main    I[IO]: HLE\sceIo.cpp:842 stdout: ********** PlayMovie **********
25:06:296 user_main    I[ME]: HLE\sceMpeg.cpp:302 Stream offset: 2048, Stream size: 0x10C800
25:06:296 user_main    I[ME]: HLE\sceMpeg.cpp:303 First timestamp: 90000, Last timestamp: 900810
25:06:311 user_main    I[ME]: HW\MediaEngine.cpp:84 FF: deprecated pixel format used, make sure you did set range correctly
25:06:311 user_main    I[ME]: HW\MediaEngine.cpp:84 FF: No accelerated colorspace conversion found from yuv420p to rgba.
25:14:164 user_main    I[ME]: HLE\sceMpeg.cpp:1177 Audio end reach. pts: 813140 dts: 810810
25:14:198 user_main    I[ME]: HLE\sceMpeg.cpp:1177 Audio end reach. pts: 813140 dts: 810810
25:14:231 user_main    I[ME]: HLE\sceMpeg.cpp:1177 Audio end reach. pts: 813140 dts: 810810
25:14:265 user_main    I[ME]: HLE\sceMpeg.cpp:1177 Audio end reach. pts: 813140 dts: 810810
25:14:298 user_main    I[ME]: HLE\sceMpeg.cpp:1177 Audio end reach. pts: 813140 dts: 810810
25:14:363 user_main    E[ME]: HLE\sceMpeg.cpp:821 UNIMPL sceMpegAvcDecodeStopYCbCr(08a34330, 08a301c4, 0bfff634)
25:14:363 user_main    W[ME]: HLE\sceMpeg.cpp:1305 UNIMPL sceMpegFlushAllStream(08a34330)
25:14:964 user_main    I[IO]: HLE\sceIo.cpp:842 stdout: ********** PlayMovie **********
25:14:980 user_main    I[ME]: HLE\sceMpeg.cpp:302 Stream offset: 2048, Stream size: 0x10C800
25:14:980 user_main    I[ME]: HLE\sceMpeg.cpp:303 First timestamp: 90000, Last timestamp: 900810
25:14:990 user_main    I[ME]: HW\MediaEngine.cpp:84 FF: No accelerated colorspace conversion found from yuv420p to rgba.
26:23:600 user_main    I[ME]: HLE\sceMpeg.cpp:1177 Audio end reach. pts: 6280580 dts: 810810
26:23:634 user_main    I[ME]: HLE\sceMpeg.cpp:1177 Audio end reach. pts: 6280580 dts: 810810
26:23:667 user_main    I[ME]: HLE\sceMpeg.cpp:1177 Audio end reach. pts: 6280580 dts: 810810
26:23:700 user_main    I[ME]: HLE\sceMpeg.cpp:1177 Audio end reach. pts: 6280580 dts: 810810
26:23:734 user_main    I[ME]: HLE\sceMpeg.cpp:1177 Audio end reach. pts: 6280580 dts: 810810
26:23:767 user_main    I[ME]: HLE\sceMpeg.cpp:1177 Audio end reach. pts: 6280580 dts: 810810
26:23:801 user_main    I[ME]: HLE\sceMpeg.cpp:1177 Audio end reach. pts: 6280580 dts: 810810
26:23:833 user_main    I[ME]: HLE\sceMpeg.cpp:1177 Audio end reach. pts: 6280580 dts: 810810
26:23:900 user_main    E[ME]: HLE\sceMpeg.cpp:821 UNIMPL sceMpegAvcDecodeStopYCbCr(08a34330, 08a301c4, 0bfff634)
26:23:900 user_main    W[ME]: HLE\sceMpeg.cpp:1305 UNIMPL sceMpegFlushAllStream(08a34330)
26:24:536 user_main    I[G3D]: GLES\ShaderManager.cpp:146 Linked shader: vs 24 fs 20
26:24:569 user_main    I[ME]: HLE\sceAtrac.cpp:1272 0=sceAtracSetDataAndGetID(09983040, 00100000)
26:24:569 user_main    W[ME]: HLE\sceAtrac.cpp:1162 This is an atrac3+ stereo audio
26:24:680 ATRAC3 play  E[ME]: HLE\sceAtrac.cpp:618 WARNING: Remaining data in packet - we currently only decode one frame/packet
26:28:487 user_main    I[IO]: HLE\sceIo.cpp:842 stdout: ********** PlayMovie **********
26:28:514 user_main    I[ME]: HLE\sceMpeg.cpp:302 Stream offset: 2048, Stream size: 0x10C800
26:28:514 user_main    I[ME]: HLE\sceMpeg.cpp:303 First timestamp: 90000, Last timestamp: 900810
26:28:524 user_main    I[ME]: HW\MediaEngine.cpp:84 FF: No accelerated colorspace conversion found from yuv420p to rgba.
34:45:435 user_main    I[ME]: HLE\sceMpeg.cpp:1177 Audio end reach. pts: 44824360 dts: 810810
34:45:469 user_main    I[ME]: HLE\sceMpeg.cpp:1177 Audio end reach. pts: 44824360 dts: 810810
34:45:503 user_main    I[ME]: HLE\sceMpeg.cpp:1177 Audio end reach. pts: 44824360 dts: 810810
34:45:535 user_main    I[ME]: HLE\sceMpeg.cpp:1177 Audio end reach. pts: 44824360 dts: 810810
34:45:569 user_main    I[ME]: HLE\sceMpeg.cpp:1177 Audio end reach. pts: 44824360 dts: 810810
34:45:603 user_main    I[ME]: HLE\sceMpeg.cpp:1177 Audio end reach. pts: 44824360 dts: 810810
34:45:636 user_main    I[ME]: HLE\sceMpeg.cpp:1177 Audio end reach. pts: 44824360 dts: 810810
34:45:701 user_main    E[ME]: HLE\sceMpeg.cpp:821 UNIMPL sceMpegAvcDecodeStopYCbCr(08a34330, 08a301c4, 0bfff634)
34:45:701 user_main    W[ME]: HLE\sceMpeg.cpp:1305 UNIMPL sceMpegFlushAllStream(08a34330)
34:48:488 user_main    I[G3D]: GLES\ShaderManager.cpp:146 Linked shader: vs 26 fs 27
34:48:657 user_main    I[G3D]: GLES\ShaderManager.cpp:146 Linked shader: vs 29 fs 30
34:48:688 user_main    I[G3D]: GLES\ShaderManager.cpp:146 Linked shader: vs 32 fs 30
34:48:764 user_main    I[G3D]: GLES\ShaderManager.cpp:146 Linked shader: vs 34 fs 30
34:48:874 user_main    I[G3D]: GLES\ShaderManager.cpp:146 Linked shader: vs 36 fs 37
34:48:886 user_main    I[G3D]: GLES\ShaderManager.cpp:146 Linked shader: vs 39 fs 14
34:48:919 user_main    I[ME]: HLE\sceAtrac.cpp:1227 sceAtracSetData(0, 09983040, 00100000)
34:48:919 user_main    W[ME]: HLE\sceAtrac.cpp:1162 This is an atrac3+ stereo audio
35:39:426 user_main    I[ME]: HLE\sceAtrac.cpp:1227 sceAtracSetData(0, 09983040, 00100000)
35:39:426 user_main    W[ME]: HLE\sceAtrac.cpp:1162 This is an atrac3+ stereo audio
36:27:908 user_main    I[ME]: HLE\sceAtrac.cpp:1227 sceAtracSetData(0, 09983040, 00100000)
36:27:908 user_main    W[ME]: HLE\sceAtrac.cpp:1162 This is an atrac3+ stereo audio
36:51:315 user_main    I[G3D]: GLES\ShaderManager.cpp:146 Linked shader: vs 41 fs 30
36:51:329 user_main    I[G3D]: GLES\ShaderManager.cpp:146 Linked shader: vs 43 fs 30
37:09:119 user_main    I[G3D]: GLES\ShaderManager.cpp:146 Linked shader: vs 45 fs 46
37:18:390 user_main    I[G3D]: GLES\ShaderManager.cpp:146 Linked shader: vs 48 fs 17
39:08:603 user_main    I[G3D]: GLES\ShaderManager.cpp:146 Linked shader: vs 50 fs 30
41:17:564 user_main    I[ME]: HLE\sceAtrac.cpp:1227 sceAtracSetData(0, 09983040, 00100000)
41:17:564 user_main    W[ME]: HLE\sceAtrac.cpp:1162 This is an atrac3+ stereo audio
41:39:452 user_main    I[ME]: HLE\sceAtrac.cpp:1227 sceAtracSetData(0, 09983040, 00100000)
41:39:452 user_main    W[ME]: HLE\sceAtrac.cpp:1162 This is an atrac3+ stereo audio
41:58:737 idle0        I[G3D]: GLES\TextureCache.cpp:91 Texture cached cleared from 8 textures
41:58:737 idle0        I[SCEGE]: GLES\Framebuffer.cpp:1632 Destroying FBO for 00000000 : 480 x 272 x 1
41:58:737 idle0        I[SCEGE]: GLES\Framebuffer.cpp:1632 Destroying FBO for 00044000 : 480 x 272 x 1
41:58:762 idle0        I[LOAD]: Config.cpp:698 Config saved: H:\Downloads\ppsspp-v0.9.6-691-g4f2f8f0-windows-x86\ppsspp\memstick/PSP/SYSTEM/ppsspp.ini
41:58:763 idle0        I[LOAD]: Config.cpp:710 Controller config saved: H:\Downloads\ppsspp-v0.9.6-691-g4f2f8f0-windows-x86\ppsspp\memstick/PSP/SYSTEM/controls.ini
41:58:907 idle0        I[LOAD]: Config.cpp:698 Config saved: H:\Downloads\ppsspp-v0.9.6-691-g4f2f8f0-windows-x86\ppsspp\memstick/PSP/SYSTEM/ppsspp.ini
41:58:907 idle0        I[LOAD]: Config.cpp:710 Controller config saved: H:\Downloads\ppsspp-v0.9.6-691-g4f2f8f0-windows-x86\ppsspp\memstick/PSP/SYSTEM/controls.ini