51:26:343 EmuThread.cpp:120 I[BOOT]: Done.
51:32:731 Config.cpp:803 I[LOAD]: Config saved: E:\PPSSPP\ppsspp-v0.9.8-142-g36bdd99-windows-amd64\ppsspp\memstick/PSP/SYSTEM/ppsspp.ini
51:32:735 Config.cpp:815 I[LOAD]: Controller config saved: E:\PPSSPP\ppsspp-v0.9.8-142-g36bdd99-windows-amd64\ppsspp\memstick/PSP/SYSTEM/controls.ini
51:41:192 System.cpp:319 I[BOOT]: PPSSPP v0.9.8-142-g36bdd99 Windows 64 bit
51:41:193 PSPLoaders.cpp:102 D[LOAD]: HDRemaster mode is false
51:41:193 MemMap.cpp:126 I[MM]: Memory system initialized. RAM at 000000000CEC0000 (mirror at 0 @ 0000000087FF0000, uncached @ 00000000C7FF0000)
51:41:246 PSPLoaders.cpp:145 I[LOAD]: UCJS10106 : ＢＬＥＡＣＨ～ソウル・カーニバル２～
51:41:247 PSPLoaders.cpp:184 I[LOAD]: Loading disc0:/PSP_GAME/SYSDIR/EBOOT.BIN...
51:41:247 HLE\sceKernelMemory.cpp:429 I[KERNEL]: Kernel and user memory pools initialized
51:41:247 FileUtil.cpp:274 D[COMMON]: CreateFullPath: path E:\PPSSPP\ppsspp-v0.9.8-142-g36bdd99-windows-amd64\ppsspp\memstick/
51:41:248 FileUtil.cpp:278 D[COMMON]: CreateFullPath: path exists E:\PPSSPP\ppsspp-v0.9.8-142-g36bdd99-windows-amd64\ppsspp\memstick/
51:41:248 FileUtil.cpp:274 D[COMMON]: CreateFullPath: path E:\PPSSPP\ppsspp-v0.9.8-142-g36bdd99-windows-amd64\ppsspp\flash0/
51:41:248 FileUtil.cpp:278 D[COMMON]: CreateFullPath: path exists E:\PPSSPP\ppsspp-v0.9.8-142-g36bdd99-windows-amd64\ppsspp\flash0/
51:41:248 FileUtil.cpp:274 D[COMMON]: CreateFullPath: path E:\PPSSPP\ppsspp-v0.9.8-142-g36bdd99-windows-amd64\ppsspp\memstick/PSP\PPSSPP_STATE
51:41:248 FileUtil.cpp:278 D[COMMON]: CreateFullPath: path exists E:\PPSSPP\ppsspp-v0.9.8-142-g36bdd99-windows-amd64\ppsspp\memstick/PSP\PPSSPP_STATE
51:41:288 Util\PPGeDraw.cpp:208 D[SCEGE]: PPGe drawing library initialized. DL: 08000100 Data: 08010100 Atlas: 08020a00 (2097152) Args: 08020100
51:41:288 HLE\sceKernel.cpp:147 I[KERNEL]: Kernel initialized.
51:41:306 HLE\sceKernelModule.cpp:819 D[MODULE]: Decrypting ~PSP file
51:41:448 ELF\ElfReader.cpp:352 D[LOAD]: String section: 58
51:41:448 ELF\ElfReader.cpp:413 D[LOAD]: Relocatable module
51:41:448 ELF\ElfReader.cpp:419 D[LOAD]: 2 segments:
51:41:448 ELF\ElfReader.cpp:427 D[LOAD]: Type: 00000001 Vaddr: 00000000 Filesz: 00302388 Memsz: 00302388 
51:41:449 ELF\ElfReader.cpp:445 D[LOAD]: Loadable Segment Copied to 08804000, size 00302388
51:41:449 ELF\ElfReader.cpp:427 D[LOAD]: Type: 00000001 Vaddr: 00302388 Filesz: 00004d40 Memsz: 00078804 
51:41:450 ELF\ElfReader.cpp:445 D[LOAD]: Loadable Segment Copied to 08b06388, size 00078804
51:41:450 Util\BlockAllocator.cpp:381 I[HLE]: -----------
51:41:450 Util\BlockAllocator.cpp:385 I[HLE]: Block: 08800000 - 08804000 size 00004000 taken=0 tag=(untitled)
51:41:450 Util\BlockAllocator.cpp:385 I[HLE]: Block: 08804000 - 08b7ec00 size 0037ac00 taken=1 tag=ELF
51:41:450 Util\BlockAllocator.cpp:385 I[HLE]: Block: 08b7ec00 - 0c000000 size 03481400 taken=0 tag=(untitled)
51:41:450 Util\BlockAllocator.cpp:387 I[HLE]: -----------
51:41:450 ELF\ElfReader.cpp:450 D[LOAD]: 59 sections:
51:41:450 ELF\ElfReader.cpp:467 D[LOAD]: NonData Section found: (null)     Ignoring (size=00000000) (flags=00000000)
51:41:450 ELF\ElfReader.cpp:463 D[LOAD]: Data Section found: .text     Sitting at 08804000, size 002be5fc
51:41:450 ELF\ElfReader.cpp:467 D[LOAD]: NonData Section found: .rel.text     Ignoring (size=000a5bb0) (flags=00000000)
51:41:450 ELF\ElfReader.cpp:463 D[LOAD]: Data Section found: .sceStub.text.scePspNpDrm_user     Sitting at 08ac25fc, size 00000010
51:41:450 ELF\ElfReader.cpp:463 D[LOAD]: Data Section found: .sceStub.text.sceRtc     Sitting at 08ac260c, size 00000010
51:41:450 ELF\ElfReader.cpp:463 D[LOAD]: Data Section found: .sceStub.text.sceGe_user     Sitting at 08ac261c, size 00000060
51:41:450 ELF\ElfReader.cpp:463 D[LOAD]: Data Section found: .sceStub.text.sceDisplay     Sitting at 08ac267c, size 00000020
51:41:450 ELF\ElfReader.cpp:463 D[LOAD]: Data Section found: .sceStub.text.sceCtrl     Sitting at 08ac269c, size 00000010
51:41:450 ELF\ElfReader.cpp:463 D[LOAD]: Data Section found: .sceStub.text.sceSuspendForUser     Sitting at 08ac26ac, size 00000018
51:41:450 ELF\ElfReader.cpp:463 D[LOAD]: Data Section found: .sceStub.text.UtilsForUser     Sitting at 08ac26c4, size 00000028
51:41:450 ELF\ElfReader.cpp:463 D[LOAD]: Data Section found: .sceStub.text.ThreadManForUser     Sitting at 08ac26ec, size 00000100
51:41:450 ELF\ElfReader.cpp:463 D[LOAD]: Data Section found: .sceStub.text.SysMemUserForUser     Sitting at 08ac27ec, size 00000040
51:41:450 ELF\ElfReader.cpp:463 D[LOAD]: Data Section found: .sceStub.text.StdioForUser     Sitting at 08ac282c, size 00000018
51:41:450 ELF\ElfReader.cpp:463 D[LOAD]: Data Section found: .sceStub.text.LoadExecForUser     Sitting at 08ac2844, size 00000010
51:41:450 ELF\ElfReader.cpp:463 D[LOAD]: Data Section found: .sceStub.text.Kernel_Library     Sitting at 08ac2854, size 00000020
51:41:450 ELF\ElfReader.cpp:463 D[LOAD]: Data Section found: .sceStub.text.IoFileMgrForUser     Sitting at 08ac2874, size 00000058
51:41:450 ELF\ElfReader.cpp:463 D[LOAD]: Data Section found: .sceStub.text.sceLibFont     Sitting at 08ac28cc, size 00000048
51:41:450 ELF\ElfReader.cpp:463 D[LOAD]: Data Section found: .sceStub.text.sceWlanDrv     Sitting at 08ac2914, size 00000010
51:41:450 ELF\ElfReader.cpp:463 D[LOAD]: Data Section found: .sceStub.text.sceNetAdhocMatching     Sitting at 08ac2924, size 00000070
51:41:450 ELF\ElfReader.cpp:463 D[LOAD]: Data Section found: .sceStub.text.sceNetAdhocctl     Sitting at 08ac2994, size 00000050
51:41:450 ELF\ElfReader.cpp:463 D[LOAD]: Data Section found: .sceStub.text.sceNetAdhoc     Sitting at 08ac29e4, size 00000010
51:41:450 ELF\ElfReader.cpp:463 D[LOAD]: Data Section found: .sceStub.text.sceNet     Sitting at 08ac29f4, size 00000020
51:41:450 ELF\ElfReader.cpp:463 D[LOAD]: Data Section found: .sceStub.text.scePsmfPlayer     Sitting at 08ac2a14, size 00000070
51:41:450 ELF\ElfReader.cpp:463 D[LOAD]: Data Section found: .sceStub.text.ModuleMgrForUser     Sitting at 08ac2a84, size 00000038
51:41:450 ELF\ElfReader.cpp:463 D[LOAD]: Data Section found: .sceStub.text.sceImpose     Sitting at 08ac2abc, size 00000010
51:41:450 ELF\ElfReader.cpp:463 D[LOAD]: Data Section found: .sceStub.text.sceMpeg     Sitting at 08ac2acc, size 00000010
51:41:450 ELF\ElfReader.cpp:463 D[LOAD]: Data Section found: .sceStub.text.sceUtility     Sitting at 08ac2adc, size 00000068
51:41:450 ELF\ElfReader.cpp:463 D[LOAD]: Data Section found: .sceStub.text.sceAtrac3plus     Sitting at 08ac2b44, size 00000040
51:41:450 ELF\ElfReader.cpp:463 D[LOAD]: Data Section found: .sceStub.text.sceUmdUser     Sitting at 08ac2b84, size 00000040
51:41:450 ELF\ElfReader.cpp:463 D[LOAD]: Data Section found: .sceStub.text.scePower     Sitting at 08ac2bc4, size 00000010
51:41:450 ELF\ElfReader.cpp:463 D[LOAD]: Data Section found: .sceStub.text.sceSasCore     Sitting at 08ac2bd4, size 000000d8
51:41:450 ELF\ElfReader.cpp:463 D[LOAD]: Data Section found: .sceStub.text.sceAudio     Sitting at 08ac2cac, size 00000048
51:41:451 ELF\ElfReader.cpp:463 D[LOAD]: Data Section found: .lib.ent.top     Sitting at 08ac2cf4, size 00000004
51:41:451 ELF\ElfReader.cpp:463 D[LOAD]: Data Section found: .lib.ent     Sitting at 08ac2cf8, size 00000010
51:41:451 ELF\ElfReader.cpp:467 D[LOAD]: NonData Section found: .rel.lib.ent     Ignoring (size=00000008) (flags=00000000)
51:41:451 ELF\ElfReader.cpp:463 D[LOAD]: Data Section found: .lib.ent.btm     Sitting at 08ac2d08, size 00000004
51:41:451 ELF\ElfReader.cpp:463 D[LOAD]: Data Section found: .lib.stub.top     Sitting at 08ac2d0c, size 00000004
51:41:451 ELF\ElfReader.cpp:463 D[LOAD]: Data Section found: .lib.stub     Sitting at 08ac2d10, size 00000244
51:41:451 ELF\ElfReader.cpp:467 D[LOAD]: NonData Section found: .rel.lib.stub     Ignoring (size=000002b8) (flags=00000000)
51:41:451 ELF\ElfReader.cpp:463 D[LOAD]: Data Section found: .lib.stub.btm     Sitting at 08ac2f54, size 00000004
51:41:451 ELF\ElfReader.cpp:463 D[LOAD]: Data Section found: .rodata.sceModuleInfo     Sitting at 08ac2f58, size 00000034
51:41:451 ELF\ElfReader.cpp:467 D[LOAD]: NonData Section found: .rel.rodata.sceModuleInfo     Ignoring (size=00000020) (flags=00000000)
51:41:451 ELF\ElfReader.cpp:463 D[LOAD]: Data Section found: .rodata.sceResident     Sitting at 08ac2f8c, size 00000244
51:41:451 ELF\ElfReader.cpp:467 D[LOAD]: NonData Section found: .rel.rodata.sceResident     Ignoring (size=00000030) (flags=00000000)
51:41:451 ELF\ElfReader.cpp:463 D[LOAD]: Data Section found: .rodata.sceNid     Sitting at 08ac31d0, size 0000037c
51:41:451 ELF\ElfReader.cpp:463 D[LOAD]: Data Section found: .rodata     Sitting at 08ac3550, size 0000fbc0
51:41:451 ELF\ElfReader.cpp:467 D[LOAD]: NonData Section found: .rel.rodata     Ignoring (size=000116c8) (flags=00000000)
51:41:451 ELF\ElfReader.cpp:463 D[LOAD]: Data Section found: .data     Sitting at 08ad3110, size 000331f4
51:41:451 ELF\ElfReader.cpp:467 D[LOAD]: NonData Section found: .rel.data     Ignoring (size=00020d80) (flags=00000000)
51:41:451 ELF\ElfReader.cpp:463 D[LOAD]: Data Section found: .eh_frame     Sitting at 08b06304, size 00000074
51:41:451 ELF\ElfReader.cpp:467 D[LOAD]: NonData Section found: .rel.eh_frame     Ignoring (size=00000010) (flags=00000000)
51:41:451 ELF\ElfReader.cpp:463 D[LOAD]: Data Section found: .ctors     Sitting at 08b06378, size 00000008
51:41:451 ELF\ElfReader.cpp:463 D[LOAD]: Data Section found: .dtors     Sitting at 08b06380, size 00000008
51:41:451 ELF\ElfReader.cpp:463 D[LOAD]: Data Section found: .cplinit     Sitting at 08b06388, size 00000058
51:41:451 ELF\ElfReader.cpp:467 D[LOAD]: NonData Section found: .rel.cplinit     Ignoring (size=00000050) (flags=00000000)
51:41:451 ELF\ElfReader.cpp:463 D[LOAD]: Data Section found: .linkonce.d     Sitting at 08b063e0, size 00004ce8
51:41:451 ELF\ElfReader.cpp:467 D[LOAD]: NonData Section found: .rel.linkonce.d     Ignoring (size=00003fe8) (flags=00000000)
51:41:451 ELF\ElfReader.cpp:463 D[LOAD]: Data Section found: .bss     Sitting at 08b0b100, size 00073a8c
51:41:451 ELF\ElfReader.cpp:467 D[LOAD]: NonData Section found: .shstrtab     Ignoring (size=00000474) (flags=00000000)
51:41:451 ELF\ElfReader.cpp:471 D[LOAD]: Relocations:
51:41:451 ELF\ElfReader.cpp:495 D[LOAD]: .rel.text: Performing 84854 relocations on .text : offset = 00307eec
51:41:451 ELF\ElfReader.cpp:57 D[LOAD]: Loading 84854 relocations...
51:41:461 ELF\ElfReader.cpp:495 D[LOAD]: .rel.lib.ent: Performing 1 relocations on .lib.ent : offset = 003ada9c
51:41:461 ELF\ElfReader.cpp:57 D[LOAD]: Loading 1 relocations...
51:41:461 ELF\ElfReader.cpp:495 D[LOAD]: .rel.lib.stub: Performing 87 relocations on .lib.stub : offset = 003adaa4
51:41:461 ELF\ElfReader.cpp:57 D[LOAD]: Loading 87 relocations...
51:41:461 ELF\ElfReader.cpp:495 D[LOAD]: .rel.rodata.sceModuleInfo: Performing 4 relocations on .rodata.sceModuleInfo : offset = 003add5c
51:41:461 ELF\ElfReader.cpp:57 D[LOAD]: Loading 4 relocations...
51:41:461 ELF\ElfReader.cpp:495 D[LOAD]: .rel.rodata.sceResident: Performing 6 relocations on .rodata.sceResident : offset = 003add7c
51:41:461 ELF\ElfReader.cpp:57 D[LOAD]: Loading 6 relocations...
51:41:461 ELF\ElfReader.cpp:495 D[LOAD]: .rel.rodata: Performing 8921 relocations on .rodata : offset = 003addac
51:41:461 ELF\ElfReader.cpp:57 D[LOAD]: Loading 8921 relocations...
51:41:462 ELF\ElfReader.cpp:495 D[LOAD]: .rel.data: Performing 16816 relocations on .data : offset = 003bf474
51:41:462 ELF\ElfReader.cpp:57 D[LOAD]: Loading 16816 relocations...
51:41:464 ELF\ElfReader.cpp:495 D[LOAD]: .rel.eh_frame: Performing 2 relocations on .eh_frame : offset = 003e01f4
51:41:464 ELF\ElfReader.cpp:57 D[LOAD]: Loading 2 relocations...
51:41:464 ELF\ElfReader.cpp:495 D[LOAD]: .rel.cplinit: Performing 10 relocations on .cplinit : offset = 003e0204
51:41:464 ELF\ElfReader.cpp:57 D[LOAD]: Loading 10 relocations...
51:41:464 ELF\ElfReader.cpp:495 D[LOAD]: .rel.linkonce.d: Performing 2045 relocations on .linkonce.d : offset = 003e0254
51:41:464 ELF\ElfReader.cpp:57 D[LOAD]: Loading 2045 relocations...
51:42:158 HLE\sceKernelModule.cpp:982 I[LOAD]: Module mainTest: 00000000 08ac2cf8 08ac2d10
51:42:158 HLE\sceKernelModule.cpp:1012 D[LOAD]: ===================================================
51:42:159 HLE\sceKernelModule.cpp:1032 D[LOAD]: Importing Module sceAudio, stubs at 08ac2cac
51:42:159 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceAudioOutputBlocking : 08ac2cac
51:42:159 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceAudioOutputPannedBlocking : 08ac2cb4
51:42:159 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceAudioChReserve : 08ac2cbc
51:42:159 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceAudioChRelease : 08ac2cc4
51:42:159 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceAudioChangeChannelConfig : 08ac2ccc
51:42:159 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceAudioGetChannelRestLength : 08ac2cd4
51:42:159 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceAudioChangeChannelVolume : 08ac2cdc
51:42:159 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceAudioSetChannelDataLen : 08ac2ce4
51:42:159 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceAudioOutputPanned : 08ac2cec
51:42:159 HLE\sceKernelModule.cpp:1103 D[LOAD]: -------------------------------------------------------------
51:42:159 HLE\sceKernelModule.cpp:1032 D[LOAD]: Importing Module sceSasCore, stubs at 08ac2bd4
51:42:159 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing __sceSasSetADSR : 08ac2bd4
51:42:159 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing __sceSasGetAllEnvelopeHeights : 08ac2bdc
51:42:159 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing __sceSasRevParam : 08ac2be4
51:42:159 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing __sceSasGetPauseFlag : 08ac2bec
51:42:159 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing __sceSasRevType : 08ac2bf4
51:42:159 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing __sceSasInit : 08ac2bfc
51:42:159 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing __sceSasSetVolume : 08ac2c04
51:42:160 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing __sceSasCoreWithMix : 08ac2c0c
51:42:160 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing __sceSasSetSL : 08ac2c14
51:42:160 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing __sceSasGetEndFlag : 08ac2c1c
51:42:160 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing __sceSasGetEnvelopeHeight : 08ac2c24
51:42:160 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing __sceSasSetKeyOn : 08ac2c2c
51:42:160 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing __sceSasSetPause : 08ac2c34
51:42:160 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing __sceSasSetVoice : 08ac2c3c
51:42:160 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing __sceSasSetADSRmode : 08ac2c44
51:42:160 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing __sceSasSetKeyOff : 08ac2c4c
51:42:160 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing __sceSasCore : 08ac2c54
51:42:160 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing __sceSasSetPitch : 08ac2c5c
51:42:160 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing __sceSasSetNoise : 08ac2c64
51:42:160 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing __sceSasGetGrain : 08ac2c6c
51:42:160 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing __sceSasSetSimpleADSR : 08ac2c74
51:42:160 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing __sceSasSetGrain : 08ac2c7c
51:42:160 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing __sceSasRevEVOL : 08ac2c84
51:42:160 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing __sceSasGetOutputmode : 08ac2c8c
51:42:160 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing __sceSasSetVoicePCM : 08ac2c94
51:42:161 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing __sceSasSetOutputmode : 08ac2c9c
51:42:161 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing __sceSasRevVON : 08ac2ca4
51:42:161 HLE\sceKernelModule.cpp:1103 D[LOAD]: -------------------------------------------------------------
51:42:161 HLE\sceKernelModule.cpp:1032 D[LOAD]: Importing Module scePower, stubs at 08ac2bc4
51:42:161 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing scePowerRegisterCallback : 08ac2bc4
51:42:161 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing scePowerGetBatteryLifePercent : 08ac2bcc
51:42:161 HLE\sceKernelModule.cpp:1103 D[LOAD]: -------------------------------------------------------------
51:42:161 HLE\sceKernelModule.cpp:1032 D[LOAD]: Importing Module sceUmdUser, stubs at 08ac2b84
51:42:161 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceUmdGetErrorStat : 08ac2b84
51:42:161 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceUmdCheckMedium : 08ac2b8c
51:42:161 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceUmdWaitDriveStatCB : 08ac2b94
51:42:161 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceUmdCancelWaitDriveStat : 08ac2b9c
51:42:161 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceUmdGetDriveStat : 08ac2ba4
51:42:161 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceUmdWaitDriveStat : 08ac2bac
51:42:161 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceUmdRegisterUMDCallBack : 08ac2bb4
51:42:161 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceUmdActivate : 08ac2bbc
51:42:161 HLE\sceKernelModule.cpp:1103 D[LOAD]: -------------------------------------------------------------
51:42:161 HLE\sceKernelModule.cpp:1032 D[LOAD]: Importing Module sceAtrac3plus, stubs at 08ac2b44
51:42:161 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceAtracGetStreamDataInfo : 08ac2b44
51:42:161 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceAtracReleaseAtracID : 08ac2b4c
51:42:162 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceAtracDecodeData : 08ac2b54
51:42:162 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceAtracSetDataAndGetID : 08ac2b5c
51:42:162 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceAtracAddStreamData : 08ac2b64
51:42:162 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceAtracSetLoopNum : 08ac2b6c
51:42:162 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceAtracGetRemainFrame : 08ac2b74
51:42:162 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceAtracGetLoopStatus : 08ac2b7c
51:42:162 HLE\sceKernelModule.cpp:1103 D[LOAD]: -------------------------------------------------------------
51:42:162 HLE\sceKernelModule.cpp:1032 D[LOAD]: Importing Module sceUtility, stubs at 08ac2adc
51:42:162 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceUtilityLoadModule : 08ac2adc
51:42:162 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceUtilityMsgDialogInitStart : 08ac2ae4
51:42:162 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceUtilityGetSystemParamString : 08ac2aec
51:42:162 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceUtilityMsgDialogAbort : 08ac2af4
51:42:162 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceUtilitySavedataInitStart : 08ac2afc
51:42:162 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceUtilityMsgDialogShutdownStart : 08ac2b04
51:42:162 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceUtilitySavedataGetStatus : 08ac2b0c
51:42:162 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceUtilityMsgDialogUpdate : 08ac2b14
51:42:162 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceUtilitySavedataShutdownStart : 08ac2b1c
51:42:162 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceUtilityMsgDialogGetStatus : 08ac2b24
51:42:162 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceUtilityGetSystemParamInt : 08ac2b2c
51:42:163 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceUtilitySavedataUpdate : 08ac2b34
51:42:163 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceUtilityUnloadModule : 08ac2b3c
51:42:163 HLE\sceKernelModule.cpp:1103 D[LOAD]: -------------------------------------------------------------
51:42:163 HLE\sceKernelModule.cpp:1032 D[LOAD]: Importing Module sceMpeg, stubs at 08ac2acc
51:42:163 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceMpegInit : 08ac2acc
51:42:163 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceMpegFinish : 08ac2ad4
51:42:163 HLE\sceKernelModule.cpp:1103 D[LOAD]: -------------------------------------------------------------
51:42:163 HLE\sceKernelModule.cpp:1032 D[LOAD]: Importing Module sceImpose, stubs at 08ac2abc
51:42:163 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceImposeSetLanguageMode : 08ac2abc
51:42:163 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceImposeGetBatteryIconStatus : 08ac2ac4
51:42:163 HLE\sceKernelModule.cpp:1103 D[LOAD]: -------------------------------------------------------------
51:42:163 HLE\sceKernelModule.cpp:1032 D[LOAD]: Importing Module ModuleMgrForUser, stubs at 08ac2a84
51:42:163 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceKernelUnloadModule : 08ac2a84
51:42:163 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceKernelStartModule : 08ac2a8c
51:42:163 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceKernelStopUnloadSelfModuleWithStatus : 08ac2a94
51:42:163 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceKernelLoadModule : 08ac2a9c
51:42:163 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceKernelStopModule : 08ac2aa4
51:42:163 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceKernelGetModuleIdByAddress : 08ac2aac
51:42:163 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceKernelGetModuleId : 08ac2ab4
51:42:163 HLE\sceKernelModule.cpp:1103 D[LOAD]: -------------------------------------------------------------
51:42:163 HLE\sceKernelModule.cpp:1032 D[LOAD]: Importing Module scePsmfPlayer, stubs at 08ac2a14
51:42:163 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing scePsmfPlayerStop : 08ac2a14
51:42:164 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing scePsmfPlayerConfigPlayer : 08ac2a1c
51:42:164 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing scePsmfPlayerCreate : 08ac2a24
51:42:164 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing scePsmfPlayerSetPsmf : 08ac2a2c
51:42:164 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing scePsmfPlayerGetAudioOutSize : 08ac2a34
51:42:164 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing scePsmfPlayerGetVideoData : 08ac2a3c
51:42:164 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing scePsmfPlayerStart : 08ac2a44
51:42:164 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing scePsmfPlayerDelete : 08ac2a4c
51:42:164 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing scePsmfPlayerUpdate : 08ac2a54
51:42:164 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing scePsmfPlayerChangePlayMode : 08ac2a5c
51:42:164 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing scePsmfPlayerGetAudioData : 08ac2a64
51:42:164 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing scePsmfPlayerGetPsmfInfo : 08ac2a6c
51:42:164 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing scePsmfPlayerReleasePsmf : 08ac2a74
51:42:164 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing scePsmfPlayerGetCurrentStatus : 08ac2a7c
51:42:164 HLE\sceKernelModule.cpp:1103 D[LOAD]: -------------------------------------------------------------
51:42:164 HLE\sceKernelModule.cpp:1032 D[LOAD]: Importing Module sceNet, stubs at 08ac29f4
51:42:164 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceNetTerm : 08ac29f4
51:42:164 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceNetInit : 08ac29fc
51:42:164 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceNetFreeThreadinfo : 08ac2a04
51:42:164 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceNetEtherNtostr : 08ac2a0c
51:42:165 HLE\sceKernelModule.cpp:1103 D[LOAD]: -------------------------------------------------------------
51:42:165 HLE\sceKernelModule.cpp:1032 D[LOAD]: Importing Module sceNetAdhoc, stubs at 08ac29e4
51:42:165 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceNetAdhocTerm : 08ac29e4
51:42:165 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceNetAdhocInit : 08ac29ec
51:42:165 HLE\sceKernelModule.cpp:1103 D[LOAD]: -------------------------------------------------------------
51:42:165 HLE\sceKernelModule.cpp:1032 D[LOAD]: Importing Module sceNetAdhocctl, stubs at 08ac2994
51:42:165 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceNetAdhocctlConnect : 08ac2994
51:42:165 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceNetAdhocctlAddHandler : 08ac299c
51:42:165 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceNetAdhocctlDisconnect : 08ac29a4
51:42:165 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceNetAdhocctlDelHandler : 08ac29ac
51:42:165 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceNetAdhocctlGetState : 08ac29b4
51:42:165 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceNetAdhocctlGetNameByAddr : 08ac29bc
51:42:165 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceNetAdhocctlTerm : 08ac29c4
51:42:165 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceNetAdhocctlGetParameter : 08ac29cc
51:42:165 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceNetAdhocctlGetPeerList : 08ac29d4
51:42:165 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceNetAdhocctlInit : 08ac29dc
51:42:165 HLE\sceKernelModule.cpp:1103 D[LOAD]: -------------------------------------------------------------
51:42:165 HLE\sceKernelModule.cpp:1032 D[LOAD]: Importing Module sceNetAdhocMatching, stubs at 08ac2924
51:42:165 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceNetAdhocMatchingInit : 08ac2924
51:42:165 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceNetAdhocMatchingStop : 08ac292c
51:42:165 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceNetAdhocMatchingGetPoolMaxAlloc : 08ac2934
51:42:165 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceNetAdhocMatchingSelectTarget : 08ac293c
51:42:166 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceNetAdhocMatchingTerm : 08ac2944
51:42:166 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceNetAdhocMatchingCancelTargetWithOpt : 08ac294c
51:42:166 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceNetAdhocMatchingStart : 08ac2954
51:42:166 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceNetAdhocMatchingSetHelloOpt : 08ac295c
51:42:166 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceNetAdhocMatchingGetMembers : 08ac2964
51:42:166 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceNetAdhocMatchingCreate : 08ac296c
51:42:166 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceNetAdhocMatchingCancelTarget : 08ac2974
51:42:166 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceNetAdhocMatchingAbortSendData : 08ac297c
51:42:166 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceNetAdhocMatchingDelete : 08ac2984
51:42:166 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceNetAdhocMatchingSendData : 08ac298c
51:42:166 HLE\sceKernelModule.cpp:1103 D[LOAD]: -------------------------------------------------------------
51:42:166 HLE\sceKernelModule.cpp:1032 D[LOAD]: Importing Module sceWlanDrv, stubs at 08ac2914
51:42:166 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceWlanGetEtherAddr : 08ac2914
51:42:166 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceWlanGetSwitchState : 08ac291c
51:42:166 HLE\sceKernelModule.cpp:1103 D[LOAD]: -------------------------------------------------------------
51:42:166 HLE\sceKernelModule.cpp:1032 D[LOAD]: Importing Module sceLibFont, stubs at 08ac28cc
51:42:166 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceFontGetFontInfo : 08ac28cc
51:42:166 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceFontGetNumFontList : 08ac28d4
51:42:166 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceFontClose : 08ac28dc
51:42:166 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceFontDoneLib : 08ac28e4
51:42:166 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceFontNewLib : 08ac28ec
51:42:166 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceFontGetCharGlyphImage : 08ac28f4
51:42:167 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceFontOpen : 08ac28fc
51:42:167 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceFontGetFontList : 08ac2904
51:42:167 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceFontGetCharInfo : 08ac290c
51:42:167 HLE\sceKernelModule.cpp:1103 D[LOAD]: -------------------------------------------------------------
51:42:167 HLE\sceKernelModule.cpp:1032 D[LOAD]: Importing Module IoFileMgrForUser, stubs at 08ac2874
51:42:167 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceIoWrite : 08ac2874
51:42:167 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceIoDevctl : 08ac287c
51:42:167 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceIoRead : 08ac2884
51:42:167 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceIoRename : 08ac288c
51:42:167 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceIoClose : 08ac2894
51:42:167 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceIoReadAsync : 08ac289c
51:42:167 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceIoGetstat : 08ac28a4
51:42:167 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceIoWaitAsync : 08ac28ac
51:42:167 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceIoOpen : 08ac28b4
51:42:167 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceIoLseek : 08ac28bc
51:42:167 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceIoPollAsync : 08ac28c4
51:42:167 HLE\sceKernelModule.cpp:1103 D[LOAD]: -------------------------------------------------------------
51:42:167 HLE\sceKernelModule.cpp:1032 D[LOAD]: Importing Module Kernel_Library, stubs at 08ac2854
51:42:167 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceKernelCpuSuspendIntr : 08ac2854
51:42:167 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceKernelUnlockLwMutex : 08ac285c
51:42:167 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceKernelCpuResumeIntr : 08ac2864
51:42:168 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceKernelLockLwMutex : 08ac286c
51:42:168 HLE\sceKernelModule.cpp:1103 D[LOAD]: -------------------------------------------------------------
51:42:168 HLE\sceKernelModule.cpp:1032 D[LOAD]: Importing Module LoadExecForUser, stubs at 08ac2844
51:42:168 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceKernelExitGame : 08ac2844
51:42:168 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceKernelRegisterExitCallback : 08ac284c
51:42:168 HLE\sceKernelModule.cpp:1103 D[LOAD]: -------------------------------------------------------------
51:42:168 HLE\sceKernelModule.cpp:1032 D[LOAD]: Importing Module StdioForUser, stubs at 08ac282c
51:42:168 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceKernelStdin : 08ac282c
51:42:168 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceKernelStdout : 08ac2834
51:42:168 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceKernelStderr : 08ac283c
51:42:168 HLE\sceKernelModule.cpp:1103 D[LOAD]: -------------------------------------------------------------
51:42:168 HLE\sceKernelModule.cpp:1032 D[LOAD]: Importing Module SysMemUserForUser, stubs at 08ac27ec
51:42:168 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceKernelPrintf : 08ac27ec
51:42:168 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceKernelTotalFreeMemSize : 08ac27f4
51:42:168 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceKernelAllocPartitionMemory : 08ac27fc
51:42:168 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceKernelSetCompiledSdkVersion500_505 : 08ac2804
51:42:168 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceKernelGetBlockHeadAddr : 08ac280c
51:42:168 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceKernelMaxFreeMemSize : 08ac2814
51:42:168 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceKernelFreePartitionMemory : 08ac281c
51:42:168 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceKernelSetCompilerVersion : 08ac2824
51:42:168 HLE\sceKernelModule.cpp:1103 D[LOAD]: -------------------------------------------------------------
51:42:168 HLE\sceKernelModule.cpp:1032 D[LOAD]: Importing Module ThreadManForUser, stubs at 08ac26ec
51:42:168 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceKernelDelayThread : 08ac26ec
51:42:168 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceKernelCreateSema : 08ac26f4
51:42:169 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceKernelGetSystemTime : 08ac26fc
51:42:169 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceKernelSetEventFlag : 08ac2704
51:42:169 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceKernelCreateCallback : 08ac270c
51:42:169 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceKernelChangeCurrentThreadAttr : 08ac2714
51:42:169 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceKernelDeleteEventFlag : 08ac271c
51:42:169 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceKernelStartThread : 08ac2724
51:42:169 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceKernelWaitThreadEnd : 08ac272c
51:42:169 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceKernelDeleteSema : 08ac2734
51:42:169 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceKernelGetThreadId : 08ac273c
51:42:169 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceKernelGetSystemTimeLow : 08ac2744
51:42:169 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceKernelSignalSema : 08ac274c
51:42:169 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceKernelWaitEventFlag : 08ac2754
51:42:169 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceKernelCreateThread : 08ac275c
51:42:169 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceKernelWaitSema : 08ac2764
51:42:169 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceKernelCreateEventFlag : 08ac276c
51:42:169 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceKernelPollSema : 08ac2774
51:42:169 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceKernelDeleteLwMutex : 08ac277c
51:42:169 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceKernelDelayThreadCB : 08ac2784
51:42:170 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceKernelChangeThreadPriority : 08ac278c
51:42:170 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceKernelExitDeleteThread : 08ac2794
51:42:170 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceKernelClearEventFlag : 08ac279c
51:42:170 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceKernelGetSystemTimeWide : 08ac27a4
51:42:170 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceKernelWaitThreadEndCB : 08ac27ac
51:42:170 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceKernelGetThreadCurrentPriority : 08ac27b4
51:42:170 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceKernelSleepThread : 08ac27bc
51:42:170 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceKernelDeleteThread : 08ac27c4
51:42:170 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceKernelReferEventFlagStatus : 08ac27cc
51:42:170 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceKernelExitThread : 08ac27d4
51:42:170 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceKernelCreateLwMutex : 08ac27dc
51:42:170 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceKernelReferSemaStatus : 08ac27e4
51:42:170 HLE\sceKernelModule.cpp:1103 D[LOAD]: -------------------------------------------------------------
51:42:170 HLE\sceKernelModule.cpp:1032 D[LOAD]: Importing Module UtilsForUser, stubs at 08ac26c4
51:42:170 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceKernelLibcGettimeofday : 08ac26c4
51:42:170 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceKernelDcacheWritebackAll : 08ac26cc
51:42:170 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceKernelLibcClock : 08ac26d4
51:42:170 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceKernelLibcTime : 08ac26dc
51:42:170 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceKernelDcacheWritebackRange : 08ac26e4
51:42:171 HLE\sceKernelModule.cpp:1103 D[LOAD]: -------------------------------------------------------------
51:42:171 HLE\sceKernelModule.cpp:1032 D[LOAD]: Importing Module sceSuspendForUser, stubs at 08ac26ac
51:42:171 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceKernelPowerTick : 08ac26ac
51:42:171 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceKernelVolatileMemLock : 08ac26b4
51:42:171 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceKernelVolatileMemUnlock : 08ac26bc
51:42:171 HLE\sceKernelModule.cpp:1103 D[LOAD]: -------------------------------------------------------------
51:42:171 HLE\sceKernelModule.cpp:1032 D[LOAD]: Importing Module sceCtrl, stubs at 08ac269c
51:42:171 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceCtrlSetSamplingMode : 08ac269c
51:42:171 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceCtrlReadBufferPositive : 08ac26a4
51:42:171 HLE\sceKernelModule.cpp:1103 D[LOAD]: -------------------------------------------------------------
51:42:171 HLE\sceKernelModule.cpp:1032 D[LOAD]: Importing Module sceDisplay, stubs at 08ac267c
51:42:171 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceDisplaySetMode : 08ac267c
51:42:171 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceDisplaySetFrameBuf : 08ac2684
51:42:171 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceDisplayWaitVblankStartCB : 08ac268c
51:42:171 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceDisplayWaitVblankStart : 08ac2694
51:42:171 HLE\sceKernelModule.cpp:1103 D[LOAD]: -------------------------------------------------------------
51:42:171 HLE\sceKernelModule.cpp:1032 D[LOAD]: Importing Module sceGe_user, stubs at 08ac261c
51:42:171 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceGeListSync : 08ac261c
51:42:171 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceGeUnsetCallback : 08ac2624
51:42:171 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceGeListEnQueueHead : 08ac262c
51:42:171 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceGeEdramGetSize : 08ac2634
51:42:171 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceGeContinue : 08ac263c
51:42:171 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceGeSetCallback : 08ac2644
51:42:171 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceGeListEnQueue : 08ac264c
51:42:172 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceGeDrawSync : 08ac2654
51:42:172 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceGeBreak : 08ac265c
51:42:172 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceGeGetCmd : 08ac2664
51:42:172 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceGeListUpdateStallAddr : 08ac266c
51:42:172 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceGeEdramGetAddr : 08ac2674
51:42:172 HLE\sceKernelModule.cpp:1103 D[LOAD]: -------------------------------------------------------------
51:42:172 HLE\sceKernelModule.cpp:1032 D[LOAD]: Importing Module sceRtc, stubs at 08ac260c
51:42:172 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceRtcGetAccumulativeTime : 08ac260c
51:42:172 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceRtcGetCurrentClockLocalTime : 08ac2614
51:42:172 HLE\sceKernelModule.cpp:1103 D[LOAD]: -------------------------------------------------------------
51:42:172 HLE\sceKernelModule.cpp:1032 D[LOAD]: Importing Module scePspNpDrm_user, stubs at 08ac25fc
51:42:172 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceNpDrmEdataSetupKey : 08ac25fc
51:42:172 HLE\sceKernelModule.cpp:290 D[LOAD]: Importing sceNpDrmSetLicenseeKey : 08ac2604
51:42:172 HLE\sceKernelModule.cpp:1103 D[LOAD]: -------------------------------------------------------------
51:42:172 HLE\sceKernelModule.cpp:1180 I[LOAD]: Exporting ent 0 named mainTest, 2 funcs, 4 vars, resident 08ac31a0
51:42:172 HLE\sceKernelModule.cpp:1270 D[LOAD]: Module SDK: 05050010
51:42:175 HLE\sceKernelModule.cpp:1465 I[LOAD]: Module entry: 0882a5dc
51:42:379 root         N[BOOT]: EmuScreen.cpp:126 Loading E:/ISO/PSP-Bleach Soul Carnival 2 -JPN.iso...
51:42:379 root         D[G3D]: GPUCommon.cpp:935 DL Unknown: 26000000 @ 00000000
51:42:379 root         D[G3D]: GPUCommon.cpp:935 DL Unknown: 28000000 @ 00000000
51:42:379 root         D[G3D]: GPUCommon.cpp:935 DL Unknown: 5e000000 @ 00000000
51:42:379 root         D[G3D]: GPUCommon.cpp:935 DL Unknown: cc000000 @ 00000000
51:42:379 root         D[G3D]: GPUCommon.cpp:935 DL Unknown: e6000000 @ 00000000
51:42:380 root         D[KERNEL]: HLE\sceKernelMemory.cpp:1243 sceKernelSetCompiledSdkVersion500_505(05050010)
51:42:380 root         D[KERNEL]: HLE\sceKernelMemory.cpp:1307 sceKernelSetCompilerVersion(00030306)
51:42:381 root         I[KERNEL]: HLE\sceKernelThread.cpp:2136 276=sceKernelCreateThread(name=user_main, entry=0882a6f0, prio=20, stacksize=262144)
51:42:381 root         I[KERNEL]: HLE\sceKernelThread.cpp:2187 sceKernelStartThread(thread=276, argSize=33, argPtr=0bfffed0)
51:42:381 root         I[KERNEL]: HLE\sceKernelThread.cpp:2264 __KernelReturnFromThread: 0
51:42:381 root         D[KERNEL]: HLE\sceKernelThread.cpp:1589 sceKernelGetThreadExitStatus(275)
51:42:381 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: root -> user_main (275->276, pc: 08000034->0882a6f0, returned from module) +144us
51:42:381 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:2400 sceKernelDeleteThread(275)
51:42:381 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:439 Freeing thread stack root
51:42:381 user_main    D[HLE]: Util\BlockAllocator.cpp:224 Merging Blocks
51:42:381 user_main    I[HLE]: Util\BlockAllocator.cpp:381 -----------
51:42:381 user_main    I[HLE]: Util\BlockAllocator.cpp:385 Block: 08800000 - 08804000 size 00004000 taken=0 tag=(untitled)
51:42:381 user_main    I[HLE]: Util\BlockAllocator.cpp:385 Block: 08804000 - 08b7ec00 size 0037ac00 taken=1 tag=ELF
51:42:381 user_main    I[HLE]: Util\BlockAllocator.cpp:385 Block: 08b7ec00 - 09ef5800 size 01376c00 taken=1 tag=UserSbrk
51:42:381 user_main    I[HLE]: Util\BlockAllocator.cpp:385 Block: 09ef5800 - 0bfbfc00 size 020ca400 taken=0 tag=(untitled)
51:42:381 user_main    I[HLE]: Util\BlockAllocator.cpp:385 Block: 0bfbfc00 - 0bfffc00 size 00040000 taken=1 tag=stack/user_main
51:42:381 user_main    I[HLE]: Util\BlockAllocator.cpp:385 Block: 0bfffc00 - 0c000000 size 00000400 taken=0 tag=stack/root
51:42:381 user_main    I[HLE]: Util\BlockAllocator.cpp:387 -----------
51:42:381 user_main    D[KERNEL]: HLE\sceKernelMemory.cpp:1014 277 = sceKernelAllocPartitionMemory(partition = 2, UserSbrk, type= 3, size= 20408320, addr= 00001000)
51:42:381 user_main    D[KERNEL]: HLE\sceKernelMemory.cpp:1032 08b7f000 = sceKernelGetBlockHeadAddr(277)
51:42:386 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:2942 278=sceKernelCreateCallback(name=exit, entry=0880409c, callbackArg=00000000)
51:42:386 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:3677 sceKernelRegisterExitCallback(278)
51:42:386 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:2942 279=sceKernelCreateCallback(name=power, entry=088040f0, callbackArg=00000000)
51:42:386 user_main    D[HLE]: HLE\scePower.cpp:129 0=scePowerRegisterCallback(0, 279)
51:42:387 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:2942 280=sceKernelCreateCallback(name=SysUmd, entry=08821d4c, callbackArg=00000000)
51:42:387 user_main    D[IO]: HLE\sceUmd.cpp:290 0=sceUmdRegisterUMDCallback(id=00000118)
51:42:387 user_main    D[IO]: HLE\sceUmd.cpp:227 1=sceUmdCheckMedium()
51:42:387 user_main    D[IO]: HLE\sceUmd.cpp:254 0=sceUmdActivate(1, disc0:)
51:42:387 user_main    D[IO]: HLE\sceUmd.cpp:374 0=sceUmdWaitDriveStat(stat = 00000020)
51:42:387 user_main    D[UTIL]: HLE\sceImpose.cpp:70 sceImposeSetLanguageMode(00000000, 00000000)
51:42:387 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:2512 0 = sceKernelChangeCurrentThreadAttr(clear = 00000000, set = 00004000)
51:42:387 user_main    D[CTRL]: HLE\sceCtrl.cpp:399 sceCtrlSetSamplingMode(1)
51:42:387 user_main    I[KERNEL]: HLE\sceKernelThread.cpp:2136 281=sceKernelCreateThread(name=Sched, entry=0881f3f4, prio=15, stacksize=4096)
51:42:387 user_main    I[KERNEL]: HLE\sceKernelThread.cpp:2187 sceKernelStartThread(thread=281, argSize=0, argPtr=00000000)
51:42:387 Sched        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: user_main -> Sched (276->281, pc: 0881f4f8->0881f3f4, thread started) +159us
51:42:387 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: Sched -> user_main (281->276, pc: 0881f424->0881f4f8, vblank start waited) +0us
51:42:388 user_main    D[KERNEL]: HLE\sceKernelSemaphore.cpp:230 282=sceKernelCreateSema(fio Sema, 00000100, 0, 256, 00000000)
51:42:388 user_main    D[KERNEL]: HLE\sceKernelSemaphore.cpp:230 283=sceKernelCreateSema(fio_ReEnt Sema, 00000100, 1, 2, 00000000)
51:42:388 user_main    I[KERNEL]: HLE\sceKernelThread.cpp:2136 284=sceKernelCreateThread(name=fioThread, entry=08806834, prio=28, stacksize=8192)
51:42:388 user_main    I[KERNEL]: HLE\sceKernelThread.cpp:2187 sceKernelStartThread(thread=284, argSize=0, argPtr=00000000)
51:42:389 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:2551 sceKernelChangeThreadPriority(276, 50)
51:42:389 fioThread    D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: user_main -> fioThread (276->284, pc: 08804078->08806834, change thread priority) +148us
51:42:389 fioThread    D[KERNEL]: HLE\sceKernelSemaphore.cpp:230 285=sceKernelCreateSema(add client, 00000100, 0, 1, 00000000)
51:42:389 fioThread    D[KERNEL]: HLE\sceKernelSemaphore.cpp:414 0=sceKernelWaitSema(282, 1, 0)
51:42:389 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: fioThread -> user_main (284->276, pc: 088068ec->08804078, sema waited) +0us
51:42:389 user_main    I[UTIL]: HLE\sceUtility.cpp:216 sceUtilityLoadModule(769)
51:42:389 idle0        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: user_main -> idle0 (276->272, pc: 088168b0->08000000, utility module loaded) +0us
51:42:389 idle0        D[DISP]: HLE\sceDisplay.cpp:531 Enter VBlank 0
51:42:389 idle0        D[SCEGE]: GLES\Framebuffer.cpp:595 Finding no FBO matching address 00000000
51:42:389 idle0        D[SCEGE]: GLES\Framebuffer.cpp:595 Finding no FBO matching address 00000000
51:42:389 idle0        D[SCEGE]: GLES\Framebuffer.cpp:595 Finding no FBO matching address 00000000
51:42:389 idle0        D[SCEGE]: GLES\Framebuffer.cpp:1027 Found no FBO to display! displayFBPtr = 00000000
51:42:407 Sched        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: idle0 -> Sched (272->281, pc: 08000000->0881f424, idle) +15499us
51:42:407 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: 26000000 @ 00000000
51:42:407 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: 28000000 @ 00000000
51:42:407 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: 5e000000 @ 00000000
51:42:407 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: cc000000 @ 00000000
51:42:407 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: e6000000 @ 00000000
51:42:407 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:271 sceKernelReferSemaStatus(285, 0bfbfa70)
51:42:407 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:304 sceKernelSignalSema(285, 1) (count: 0 -> 1)
51:42:407 idle0        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: Sched -> idle0 (281->272, pc: 0881f424->08000000, vblank start waited) +0us
51:42:407 idle0        D[DISP]: HLE\sceDisplay.cpp:627 Leave VBlank 0
51:42:407 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: idle0 -> user_main (272->276, pc: 08000000->088168b0, idle) +9500us
51:42:407 user_main    I[UTIL]: HLE\sceUtility.cpp:216 sceUtilityLoadModule(768)
51:42:407 idle0        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: user_main -> idle0 (276->272, pc: 088168e4->08000000, utility module loaded) +0us
51:42:407 idle0        D[DISP]: HLE\sceDisplay.cpp:531 Enter VBlank 1
51:42:407 idle0        D[SCEGE]: GLES\Framebuffer.cpp:595 Finding no FBO matching address 00000000
51:42:407 idle0        D[SCEGE]: GLES\Framebuffer.cpp:595 Finding no FBO matching address 00000000
51:42:407 idle0        D[SCEGE]: GLES\Framebuffer.cpp:595 Finding no FBO matching address 00000000
51:42:407 idle0        D[SCEGE]: GLES\Framebuffer.cpp:1027 Found no FBO to display! displayFBPtr = 00000000
51:42:424 Sched        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: idle0 -> Sched (272->281, pc: 08000000->0881f424, idle) +7182us
51:42:424 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: 26000000 @ 00000000
51:42:424 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: 28000000 @ 00000000
51:42:424 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: 5e000000 @ 00000000
51:42:424 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: cc000000 @ 00000000
51:42:424 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: e6000000 @ 00000000
51:42:424 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:271 sceKernelReferSemaStatus(285, 0bfbfa70)
51:42:424 idle0        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: Sched -> idle0 (281->272, pc: 0881f424->08000000, vblank start waited) +0us
51:42:424 idle0        D[DISP]: HLE\sceDisplay.cpp:627 Leave VBlank 1
51:42:424 idle0        D[DISP]: HLE\sceDisplay.cpp:531 Enter VBlank 2
51:42:424 idle0        D[SCEGE]: GLES\Framebuffer.cpp:595 Finding no FBO matching address 00000000
51:42:424 idle0        D[SCEGE]: GLES\Framebuffer.cpp:595 Finding no FBO matching address 00000000
51:42:424 idle0        D[SCEGE]: GLES\Framebuffer.cpp:595 Finding no FBO matching address 00000000
51:42:424 idle0        D[SCEGE]: GLES\Framebuffer.cpp:1027 Found no FBO to display! displayFBPtr = 00000000
51:42:441 Sched        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: idle0 -> Sched (272->281, pc: 08000000->0881f424, idle) +16683us
51:42:441 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: 26000000 @ 00000000
51:42:441 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: 28000000 @ 00000000
51:42:441 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: 5e000000 @ 00000000
51:42:441 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: cc000000 @ 00000000
51:42:441 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: e6000000 @ 00000000
51:42:441 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:271 sceKernelReferSemaStatus(285, 0bfbfa70)
51:42:441 idle0        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: Sched -> idle0 (281->272, pc: 0881f424->08000000, vblank start waited) +0us
51:42:441 idle0        D[DISP]: HLE\sceDisplay.cpp:627 Leave VBlank 2
51:42:441 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: idle0 -> user_main (272->276, pc: 08000000->088168e4, idle) +1134us
51:42:441 user_main    I[UTIL]: HLE\sceUtility.cpp:216 sceUtilityLoadModule(770)
51:42:441 idle0        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: user_main -> idle0 (276->272, pc: 08816904->08000000, utility module loaded) +0us
51:42:441 idle0        D[DISP]: HLE\sceDisplay.cpp:531 Enter VBlank 3
51:42:441 idle0        D[SCEGE]: GLES\Framebuffer.cpp:595 Finding no FBO matching address 00000000
51:42:441 idle0        D[SCEGE]: GLES\Framebuffer.cpp:595 Finding no FBO matching address 00000000
51:42:441 idle0        D[SCEGE]: GLES\Framebuffer.cpp:595 Finding no FBO matching address 00000000
51:42:441 idle0        D[SCEGE]: GLES\Framebuffer.cpp:1027 Found no FBO to display! displayFBPtr = 00000000
51:42:457 Sched        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: idle0 -> Sched (272->281, pc: 08000000->0881f424, idle) +15548us
51:42:457 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: 26000000 @ 00000000
51:42:457 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: 28000000 @ 00000000
51:42:457 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: 5e000000 @ 00000000
51:42:457 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: cc000000 @ 00000000
51:42:457 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: e6000000 @ 00000000
51:42:457 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:271 sceKernelReferSemaStatus(285, 0bfbfa70)
51:42:457 idle0        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: Sched -> idle0 (281->272, pc: 0881f424->08000000, vblank start waited) +0us
51:42:457 idle0        D[DISP]: HLE\sceDisplay.cpp:627 Leave VBlank 3
51:42:457 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: idle0 -> user_main (272->276, pc: 08000000->08816904, idle) +9450us
51:42:457 user_main    I[UTIL]: HLE\sceUtility.cpp:216 sceUtilityLoadModule(771)
51:42:457 idle0        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: user_main -> idle0 (276->272, pc: 08816924->08000000, utility module loaded) +0us
51:42:457 idle0        D[DISP]: HLE\sceDisplay.cpp:531 Enter VBlank 4
51:42:457 idle0        D[SCEGE]: GLES\Framebuffer.cpp:595 Finding no FBO matching address 00000000
51:42:457 idle0        D[SCEGE]: GLES\Framebuffer.cpp:595 Finding no FBO matching address 00000000
51:42:457 idle0        D[SCEGE]: GLES\Framebuffer.cpp:595 Finding no FBO matching address 00000000
51:42:457 idle0        D[SCEGE]: GLES\Framebuffer.cpp:1027 Found no FBO to display! displayFBPtr = 00000000
51:42:474 Sched        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: idle0 -> Sched (272->281, pc: 08000000->0881f424, idle) +7232us
51:42:474 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: 26000000 @ 00000000
51:42:474 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: 28000000 @ 00000000
51:42:474 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: 5e000000 @ 00000000
51:42:474 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: cc000000 @ 00000000
51:42:474 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: e6000000 @ 00000000
51:42:474 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:271 sceKernelReferSemaStatus(285, 0bfbfa70)
51:42:474 idle0        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: Sched -> idle0 (281->272, pc: 0881f424->08000000, vblank start waited) +0us
51:42:474 idle0        D[DISP]: HLE\sceDisplay.cpp:627 Leave VBlank 4
51:42:474 idle0        D[DISP]: HLE\sceDisplay.cpp:531 Enter VBlank 5
51:42:474 idle0        D[SCEGE]: GLES\Framebuffer.cpp:595 Finding no FBO matching address 00000000
51:42:474 idle0        D[SCEGE]: GLES\Framebuffer.cpp:595 Finding no FBO matching address 00000000
51:42:474 idle0        D[SCEGE]: GLES\Framebuffer.cpp:595 Finding no FBO matching address 00000000
51:42:474 idle0        D[SCEGE]: GLES\Framebuffer.cpp:1027 Found no FBO to display! displayFBPtr = 00000000
51:42:491 Sched        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: idle0 -> Sched (272->281, pc: 08000000->0881f424, idle) +16683us
51:42:491 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: 26000000 @ 00000000
51:42:491 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: 28000000 @ 00000000
51:42:491 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: 5e000000 @ 00000000
51:42:491 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: cc000000 @ 00000000
51:42:491 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: e6000000 @ 00000000
51:42:491 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:271 sceKernelReferSemaStatus(285, 0bfbfa70)
51:42:491 idle0        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: Sched -> idle0 (281->272, pc: 0881f424->08000000, vblank start waited) +0us
51:42:491 idle0        D[DISP]: HLE\sceDisplay.cpp:627 Leave VBlank 5
51:42:491 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: idle0 -> user_main (272->276, pc: 08000000->08816924, idle) +1084us
51:42:491 user_main    I[UTIL]: HLE\sceUtility.cpp:216 sceUtilityLoadModule(256)
51:42:491 idle0        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: user_main -> idle0 (276->272, pc: 08816944->08000000, utility module loaded) +0us
51:42:491 idle0        D[DISP]: HLE\sceDisplay.cpp:531 Enter VBlank 6
51:42:491 idle0        D[SCEGE]: GLES\Framebuffer.cpp:595 Finding no FBO matching address 00000000
51:42:491 idle0        D[SCEGE]: GLES\Framebuffer.cpp:595 Finding no FBO matching address 00000000
51:42:491 idle0        D[SCEGE]: GLES\Framebuffer.cpp:595 Finding no FBO matching address 00000000
51:42:491 idle0        D[SCEGE]: GLES\Framebuffer.cpp:1027 Found no FBO to display! displayFBPtr = 00000000
51:42:507 Sched        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: idle0 -> Sched (272->281, pc: 08000000->0881f424, idle) +15598us
51:42:507 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: 26000000 @ 00000000
51:42:507 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: 28000000 @ 00000000
51:42:507 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: 5e000000 @ 00000000
51:42:507 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: cc000000 @ 00000000
51:42:507 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: e6000000 @ 00000000
51:42:507 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:271 sceKernelReferSemaStatus(285, 0bfbfa70)
51:42:507 idle0        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: Sched -> idle0 (281->272, pc: 0881f424->08000000, vblank start waited) +0us
51:42:507 idle0        D[DISP]: HLE\sceDisplay.cpp:627 Leave VBlank 6
51:42:507 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: idle0 -> user_main (272->276, pc: 08000000->08816944, idle) +9400us
51:42:507 user_main    I[UTIL]: HLE\sceUtility.cpp:216 sceUtilityLoadModule(257)
51:42:507 idle0        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: user_main -> idle0 (276->272, pc: 08816964->08000000, utility module loaded) +0us
51:42:507 idle0        D[DISP]: HLE\sceDisplay.cpp:531 Enter VBlank 7
51:42:507 idle0        D[SCEGE]: GLES\Framebuffer.cpp:595 Finding no FBO matching address 00000000
51:42:507 idle0        D[SCEGE]: GLES\Framebuffer.cpp:595 Finding no FBO matching address 00000000
51:42:507 idle0        D[SCEGE]: GLES\Framebuffer.cpp:595 Finding no FBO matching address 00000000
51:42:507 idle0        D[SCEGE]: GLES\Framebuffer.cpp:1027 Found no FBO to display! displayFBPtr = 00000000
51:42:524 Sched        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: idle0 -> Sched (272->281, pc: 08000000->0881f424, idle) +7282us
51:42:524 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: 26000000 @ 00000000
51:42:524 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: 28000000 @ 00000000
51:42:524 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: 5e000000 @ 00000000
51:42:524 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: cc000000 @ 00000000
51:42:524 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: e6000000 @ 00000000
51:42:524 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:271 sceKernelReferSemaStatus(285, 0bfbfa70)
51:42:524 idle0        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: Sched -> idle0 (281->272, pc: 0881f424->08000000, vblank start waited) +0us
51:42:524 idle0        D[DISP]: HLE\sceDisplay.cpp:627 Leave VBlank 7
51:42:524 idle0        D[DISP]: HLE\sceDisplay.cpp:531 Enter VBlank 8
51:42:524 idle0        D[SCEGE]: GLES\Framebuffer.cpp:595 Finding no FBO matching address 00000000
51:42:524 idle0        D[SCEGE]: GLES\Framebuffer.cpp:595 Finding no FBO matching address 00000000
51:42:524 idle0        D[SCEGE]: GLES\Framebuffer.cpp:595 Finding no FBO matching address 00000000
51:42:524 idle0        D[SCEGE]: GLES\Framebuffer.cpp:1027 Found no FBO to display! displayFBPtr = 00000000
51:42:541 Sched        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: idle0 -> Sched (272->281, pc: 08000000->0881f424, idle) +16683us
51:42:541 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: 26000000 @ 00000000
51:42:541 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: 28000000 @ 00000000
51:42:541 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: 5e000000 @ 00000000
51:42:541 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: cc000000 @ 00000000
51:42:541 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: e6000000 @ 00000000
51:42:541 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:271 sceKernelReferSemaStatus(285, 0bfbfa70)
51:42:541 idle0        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: Sched -> idle0 (281->272, pc: 0881f424->08000000, vblank start waited) +0us
51:42:541 idle0        D[DISP]: HLE\sceDisplay.cpp:627 Leave VBlank 8
51:42:541 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: idle0 -> user_main (272->276, pc: 08000000->08816964, idle) +1034us
51:42:541 user_main    D[IO]: HLE\sceUmd.cpp:254 0=sceUmdActivate(1, disc0:)
51:42:541 user_main    D[IO]: HLE\sceUmd.cpp:438 0=sceUmdWaitDriveStatCB(stat = 00000029, timeout = 500000)
51:42:541 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:3452 __KernelRunCallbackOnThread: Turning callback 279 into pending mipscall
51:42:541 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:3331 Executing mipscall 1
51:42:542 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:3378 __KernelReturnFromMipsCall(), returned 00000000
51:42:542 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:3452 __KernelRunCallbackOnThread: Turning callback 280 into pending mipscall
51:42:542 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:3306 Making mipscall pending on thread
51:42:542 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:3485 Left callback 279 - power
51:42:542 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:3331 Executing mipscall 2
51:42:545 user_main    D[IO]: HLE\sceIo.cpp:579 1=sceKernelStdout()
51:42:545 user_main    I[IO]: HLE\sceIo.cpp:863 stdout: UmdCallbackFunc() : count = 2, arg = 32 '
51:42:545 user_main    D[IO]: HLE\sceIo.cpp:934 29=sceIoWrite(1, 08b71fcc, 29)
51:42:545 user_main    W[KERNEL]: HLE\sceKernelThread.cpp:1714 UNTESTED - waiting within a callback, probably bad mojo.
51:42:545 user_main    D[IO]: HLE\sceIo.cpp:579 1=sceKernelStdout()
51:42:545 user_main    I[IO]: HLE\sceIo.cpp:863 stdout: MEDIA_IN 
51:42:545 user_main    D[IO]: HLE\sceIo.cpp:934 9=sceIoWrite(1, 08b71fcc, 9)
51:42:545 user_main    W[KERNEL]: HLE\sceKernelThread.cpp:1714 UNTESTED - waiting within a callback, probably bad mojo.
51:42:545 user_main    D[IO]: HLE\sceIo.cpp:579 1=sceKernelStdout()
51:42:545 user_main    I[IO]: HLE\sceIo.cpp:863 stdout: READABLE 
51:42:545 user_main    D[IO]: HLE\sceIo.cpp:934 9=sceIoWrite(1, 08b71fcc, 9)
51:42:545 user_main    W[KERNEL]: HLE\sceKernelThread.cpp:1714 UNTESTED - waiting within a callback, probably bad mojo.
51:42:546 user_main    D[IO]: HLE\sceIo.cpp:579 1=sceKernelStdout()
51:42:546 user_main    I[IO]: HLE\sceIo.cpp:863 stdout: '
51:42:546 user_main    D[IO]: HLE\sceIo.cpp:934 2=sceIoWrite(1, 08b71fcc, 2)
51:42:546 user_main    W[KERNEL]: HLE\sceKernelThread.cpp:1714 UNTESTED - waiting within a callback, probably bad mojo.
51:42:546 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:3378 __KernelReturnFromMipsCall(), returned 00000000
51:42:546 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:3485 Left callback 280 - SysUmd
51:42:546 user_main    D[IO]: HLE\sceUmd.cpp:316 0x32=sceUmdGetDriveStat()
51:42:546 user_main    D[LOAD]: HLE\sceKernelModule.cpp:1571 sceKernelLoadModule(disc0:/PSP_GAME/USRDIR/libpsmfplayer.prx, 00000000)
51:42:546 user_main    I[MODULE]: HLE\sceKernelModule.cpp:813 ~SCE module, skipping header
51:42:546 user_main    D[MODULE]: HLE\sceKernelModule.cpp:819 Decrypting ~PSP file
51:42:546 user_main    I[MODULE]: HLE\sceKernelModule.cpp:826 Loading module scePsmfP_library with version 0101
51:42:546 user_main    I[HLE]: ELF\PrxDecrypter.cpp:300 Missing key 5B, cannot decrypt module
51:42:546 user_main    I[MODULE]: HLE\sceKernelModule.cpp:1618 286=sceKernelLoadModule(name=disc0:/PSP_GAME/USRDIR/libpsmfplayer.prx,flag=00000000,(...))
51:42:546 idle0        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: user_main -> idle0 (276->272, pc: 0881680c->08000000, module loaded) +31us
51:42:546 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: idle0 -> user_main (272->276, pc: 08000000->0881680c, idle) +87us
51:42:546 user_main    I[MODULE]: HLE\sceKernelModule.cpp:1649 sceKernelStartModule(286,asize=00000000,aptr=00000000,retptr=00000000,00000000): faked (undecryptable module)
51:42:547 user_main    D[IO]: HLE\sceUmd.cpp:438 0=sceUmdWaitDriveStatCB(stat = 00000029, timeout = 500000)
51:42:547 user_main    D[IO]: HLE\sceUmd.cpp:316 0x32=sceUmdGetDriveStat()
51:42:547 user_main    D[LOAD]: HLE\sceKernelModule.cpp:1571 sceKernelLoadModule(disc0:/PSP_GAME/USRDIR/psmf.prx, 00000000)
51:42:547 user_main    I[MODULE]: HLE\sceKernelModule.cpp:813 ~SCE module, skipping header
51:42:547 user_main    D[MODULE]: HLE\sceKernelModule.cpp:819 Decrypting ~PSP file
51:42:547 user_main    I[MODULE]: HLE\sceKernelModule.cpp:826 Loading module scePsmf_library with version 0101
51:42:547 user_main    I[HLE]: ELF\PrxDecrypter.cpp:300 Missing key 5B, cannot decrypt module
51:42:547 user_main    I[MODULE]: HLE\sceKernelModule.cpp:1618 287=sceKernelLoadModule(name=disc0:/PSP_GAME/USRDIR/psmf.prx,flag=00000000,(...))
51:42:547 idle0        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: user_main -> idle0 (276->272, pc: 0881680c->08000000, module loaded) +0us
51:42:547 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: idle0 -> user_main (272->276, pc: 08000000->0881680c, idle) +4us
51:42:547 user_main    I[MODULE]: HLE\sceKernelModule.cpp:1649 sceKernelStartModule(287,asize=00000000,aptr=00000000,retptr=00000000,00000000): faked (undecryptable module)
51:42:547 user_main    D[IO]: HLE\sceUmd.cpp:438 0=sceUmdWaitDriveStatCB(stat = 00000029, timeout = 500000)
51:42:547 user_main    D[IO]: HLE\sceUmd.cpp:316 0x32=sceUmdGetDriveStat()
51:42:547 user_main    D[LOAD]: HLE\sceKernelModule.cpp:1571 sceKernelLoadModule(disc0:/PSP_GAME/USRDIR/libfont.prx, 00000000)
51:42:547 user_main    I[MODULE]: HLE\sceKernelModule.cpp:813 ~SCE module, skipping header
51:42:547 user_main    D[MODULE]: HLE\sceKernelModule.cpp:819 Decrypting ~PSP file
51:42:547 user_main    I[MODULE]: HLE\sceKernelModule.cpp:826 Loading module sceFont_Library with version 0101
51:42:547 user_main    I[HLE]: ELF\PrxDecrypter.cpp:300 Missing key 5B, cannot decrypt module
51:42:547 user_main    I[MODULE]: HLE\sceKernelModule.cpp:1618 288=sceKernelLoadModule(name=disc0:/PSP_GAME/USRDIR/libfont.prx,flag=00000000,(...))
51:42:548 idle0        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: user_main -> idle0 (276->272, pc: 0881680c->08000000, module loaded) +0us
51:42:548 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: idle0 -> user_main (272->276, pc: 08000000->0881680c, idle) +4us
51:42:548 user_main    I[MODULE]: HLE\sceKernelModule.cpp:1649 sceKernelStartModule(288,asize=00000000,aptr=00000000,retptr=00000000,00000000): faked (undecryptable module)
51:42:548 user_main    D[KERNEL]: HLE\sceKernelSemaphore.cpp:230 289=sceKernelCreateSema(add client, 00000100, 0, 16, 00000000)
51:42:548 user_main    I[KERNEL]: HLE\sceKernelThread.cpp:2136 290=sceKernelCreateThread(name=Global Pad, entry=088088f4, prio=2d, stacksize=8192)
51:42:548 user_main    W[HLE]: HLE\HLE.cpp:83 Someone else woke up HLE-blocked thread?
51:42:548 user_main    D[KERNEL]: HLE\sceKernelSemaphore.cpp:230 291=sceKernelCreateSema(add client, 00000100, 0, 45, 00000000)
51:42:548 user_main    I[KERNEL]: HLE\sceKernelThread.cpp:2187 sceKernelStartThread(thread=290, argSize=0, argPtr=00000000)
51:42:548 Global Pad   D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: user_main -> Global Pad (276->290, pc: 08808aa4->088088f4, thread started) +145us
51:42:548 Global Pad   D[KERNEL]: HLE\sceKernelSemaphore.cpp:414 0=sceKernelWaitSema(291, 1, 0)
51:42:548 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: Global Pad -> user_main (290->276, pc: 0881f5e0->08808aa4, sema waited) +0us
51:42:549 user_main    D[SCEGE]: HLE\sceGe.cpp:324 00200000 = sceGeEdramGetSize()
51:42:549 user_main    D[SCEGE]: HLE\sceGe.cpp:316 04000000 = sceGeEdramGetAddr
51:42:550 user_main    D[SCEGE]: HLE\sceGe.cpp:316 04000000 = sceGeEdramGetAddr
51:42:550 user_main    D[KERNEL]: HLE\sceKernelEventFlag.cpp:251 292=sceKernelCreateEventFlag("SceGuSignal", 00000200, 00000001, 00000000)
51:42:550 user_main    D[SCEGE]: HLE\sceGe.cpp:433 sceGeSetCallback(struct=0bfff5d0)
51:42:550 user_main    D[INTC]: HLE\sceKernelInterrupt.cpp:474 sceKernelRegisterSubIntrHandler(25, 1, 08aa5254, 08b758e4)
51:42:550 user_main    D[INTC]: HLE\sceKernelInterrupt.cpp:502 sceKernelEnableSubIntr(25, 1)
51:42:550 user_main    D[INTC]: HLE\sceKernelInterrupt.cpp:474 sceKernelRegisterSubIntrHandler(25, 0, 08aa51d4, 08b758e4)
51:42:550 user_main    D[INTC]: HLE\sceKernelInterrupt.cpp:502 sceKernelEnableSubIntr(25, 0)
51:42:551 user_main    D[SCEGE]: HLE\sceGe.cpp:338 sceGeListEnQueue(addr=08ad296c, stall=00000000, cbid=ffffffff, param=00000000)
51:42:551 user_main    D[G3D]: GPUCommon.cpp:662 Okay, starting DL execution at 08ad296c - stall = 00000000
51:42:551 user_main    D[SCEGE]: HLE\sceGe.cpp:345 List 889192448 enqueued.
51:42:551 idle0        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: user_main -> idle0 (276->272, pc: 08aa2b4c->08000000, interrupt) +8us
51:42:551 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: idle0 -> user_main (272->276, pc: 08000000->08aa2b4c, left interrupt) +0us
51:42:551 user_main    D[SCEGE]: HLE\sceGe.cpp:390 sceGeListSync(dlid=35000000, mode=00000000)
51:42:551 user_main    D[SCEGE]: HLE\sceGe.cpp:397 sceGeDrawSync(mode=0)  (0=wait for completion, 1=peek)
51:42:552 user_main    D[KERNEL]: HLE\sceKernelSemaphore.cpp:230 293=sceKernelCreateSema(disp Done Sema, 00000100, 0, 16, 00000000)
51:42:553 user_main    D[SCEGE]: HLE\sceGe.cpp:338 sceGeListEnQueue(addr=48b7f0c0, stall=48b7f0c0, cbid=00000000, param=08ad2cbc)
51:42:553 user_main    D[G3D]: GPUCommon.cpp:662 Okay, starting DL execution at 08b7f0c0 - stall = 08b7f0c0
51:42:553 user_main    D[SCEGE]: HLE\sceGe.cpp:345 List 889192449 enqueued.
51:42:555 user_main    D[DISP]: HLE\sceDisplay.cpp:640 sceDisplaySetMode(0, 480, 272)
51:42:559 user_main    D[SCEGE]: HLE\sceGe.cpp:384 sceGeListUpdateStallAddr(dlid=889192449, stalladdr=48b7f1d8)
51:42:559 user_main    D[G3D]: GPUCommon.cpp:662 Okay, starting DL execution at 08b7f0c0 - stall = 08b7f1d8
51:42:560 user_main    D[SCEGE]: HLE\sceGe.cpp:397 sceGeDrawSync(mode=0)  (0=wait for completion, 1=peek)
51:42:560 idle0        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: user_main -> idle0 (276->272, pc: 08aa3774->08000000, GeDrawSync) +14us
51:42:560 idle0        D[CPU]: HLE\sceGe.cpp:113 Entering interrupt handler 08aa5254
51:42:560 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: idle0 -> user_main (272->276, pc: 08000000->08aa3774, left interrupt) +0us
51:42:560 idle0        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: user_main -> idle0 (276->272, pc: 08809720->08000000, vblank start waited) +0us
51:42:560 idle0        W[HLE]: HLE\HLE.cpp:83 Someone else woke up HLE-blocked thread?
51:42:560 idle0        W[HLE]: HLE\HLE.cpp:83 Someone else woke up HLE-blocked thread?
51:42:560 idle0        W[HLE]: HLE\HLE.cpp:83 Someone else woke up HLE-blocked thread?
51:42:560 idle0        D[DISP]: HLE\sceDisplay.cpp:531 Enter VBlank 9
51:42:560 idle0        D[SCEGE]: GLES\Framebuffer.cpp:595 Finding no FBO matching address 00000000
51:42:560 idle0        D[SCEGE]: GLES\Framebuffer.cpp:595 Finding no FBO matching address 00000000
51:42:560 idle0        D[SCEGE]: GLES\Framebuffer.cpp:595 Finding no FBO matching address 00000000
51:42:560 idle0        D[SCEGE]: GLES\Framebuffer.cpp:1027 Found no FBO to display! displayFBPtr = 00000000
51:42:560 Sched        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: idle0 -> Sched (272->281, pc: 08000000->0881f424, idle) +15349us
51:42:560 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: 26000001 @ 00000000
51:42:560 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: 28000000 @ 00000000
51:42:560 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: 5e000000 @ 00000000
51:42:560 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: cc000000 @ 00000000
51:42:560 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: e6000000 @ 00000000
51:42:560 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:271 sceKernelReferSemaStatus(291, 0bfbfa70)
51:42:560 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:304 sceKernelSignalSema(291, 1) (count: 0 -> 1)
51:42:560 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:271 sceKernelReferSemaStatus(289, 0bfbfa70)
51:42:560 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:304 sceKernelSignalSema(289, 1) (count: 0 -> 1)
51:42:560 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:271 sceKernelReferSemaStatus(285, 0bfbfa70)
51:42:560 Global Pad   D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: Sched -> Global Pad (281->290, pc: 0881f424->0881f5e0, vblank start waited) +0us
51:42:561 Global Pad   D[CTRL]: HLE\sceCtrl.cpp:455 6=sceCtrlReadBufferPositive(08b2e310, 6)
51:42:561 Global Pad   D[KERNEL]: HLE\sceKernelSemaphore.cpp:414 0=sceKernelWaitSema(291, 1, 0)
51:42:561 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: Global Pad -> user_main (290->276, pc: 0881f5e0->08809720, sema waited) +1us
51:42:561 user_main    D[DISP]: HLE\sceDisplay.cpp:655 sceDisplaySetFramebuf(topaddr=04044000,linesize=512,pixelsize=1,sync=1)
51:42:562 user_main    D[KERNEL]: HLE\sceKernelSemaphore.cpp:230 294=sceKernelCreateSema(msg  Sema, 00000100, 0, 2, 00000000)
51:42:562 user_main    D[KERNEL]: HLE\sceKernelSemaphore.cpp:230 295=sceKernelCreateSema(wait Sema, 00000100, 0, 64, 00000000)
51:42:562 user_main    I[KERNEL]: HLE\sceKernelThread.cpp:2136 296=sceKernelCreateThread(name=dispThread, entry=0880901c, prio=23, stacksize=4096)
51:42:562 user_main    I[KERNEL]: HLE\sceKernelThread.cpp:2187 sceKernelStartThread(thread=296, argSize=0, argPtr=00000000)
51:42:562 dispThread   D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: user_main -> dispThread (276->296, pc: 088097cc->0880901c, thread started) +241us
51:42:562 dispThread   D[KERNEL]: HLE\sceKernelSemaphore.cpp:230 297=sceKernelCreateSema(add client, 00000100, 0, 1, 00000000)
51:42:563 dispThread   D[KERNEL]: HLE\sceKernelSemaphore.cpp:414 0=sceKernelWaitSema(297, 1, 0)
51:42:563 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: dispThread -> user_main (296->276, pc: 0881f5e0->088097cc, sema waited) +0us
51:42:563 user_main    D[KERNEL]: HLE\sceKernelSemaphore.cpp:230 298=sceKernelCreateSema(msg  Sema, 00000100, 0, 4, 00000000)
51:42:563 user_main    D[KERNEL]: HLE\sceKernelSemaphore.cpp:230 299=sceKernelCreateSema(wait Sema, 00000100, 0, 64, 00000000)
51:42:563 user_main    I[KERNEL]: HLE\sceKernelThread.cpp:2136 300=sceKernelCreateThread(name=drawThread, entry=0880914c, prio=24, stacksize=4096)
51:42:563 user_main    I[KERNEL]: HLE\sceKernelThread.cpp:2187 sceKernelStartThread(thread=300, argSize=0, argPtr=00000000)
51:42:563 drawThread   D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: user_main -> drawThread (276->300, pc: 08809820->0880914c, thread started) +144us
51:42:563 drawThread   D[KERNEL]: HLE\sceKernelSemaphore.cpp:230 301=sceKernelCreateSema(draw Done Sema, 00000100, 0, 16, 00000000)
51:42:563 drawThread   D[KERNEL]: HLE\sceKernelSemaphore.cpp:414 0=sceKernelWaitSema(298, 1, 0)
51:42:563 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: drawThread -> user_main (300->276, pc: 08819120->08809820, sema waited) +0us
51:42:563 user_main    D[KERNEL]: HLE\sceKernelSemaphore.cpp:230 302=sceKernelCreateSema(msg  Sema, 00000100, 0, 2, 00000000)
51:42:563 user_main    D[KERNEL]: HLE\sceKernelSemaphore.cpp:230 303=sceKernelCreateSema(wait Sema, 00000100, 0, 64, 00000000)
51:42:566 user_main    D[KERNEL]: HLE\sceKernelSemaphore.cpp:230 304=sceKernelCreateSema(fn Sema, 00000100, 0, 256, 00000000)
51:42:566 user_main    I[KERNEL]: HLE\sceKernelThread.cpp:2136 305=sceKernelCreateThread(name=fnThread, entry=08807858, prio=2e, stacksize=4096)
51:42:566 user_main    I[KERNEL]: HLE\sceKernelThread.cpp:2187 sceKernelStartThread(thread=305, argSize=0, argPtr=00000000)
51:42:566 fnThread     D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: user_main -> fnThread (276->305, pc: 08807278->08807858, thread started) +223us
51:42:566 fnThread     D[KERNEL]: HLE\sceKernelSemaphore.cpp:230 306=sceKernelCreateSema(fio Sema tmp, 00000100, 0, 256, 00000000)
51:42:566 fnThread     D[KERNEL]: HLE\sceKernelSemaphore.cpp:230 307=sceKernelCreateSema(fio Sema tmp, 00000100, 0, 256, 00000000)
51:42:566 fnThread     D[KERNEL]: HLE\sceKernelSemaphore.cpp:414 0=sceKernelWaitSema(304, 1, 0)
51:42:566 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: fnThread -> user_main (305->276, pc: 08807928->08807278, sema waited) +0us
51:42:566 user_main    D[KERNEL]: HLE\sceKernelSemaphore.cpp:230 308=sceKernelCreateSema(fn Decord Sema, 00000100, 0, 1, 00000000)
51:42:566 user_main    D[KERNEL]: HLE\sceKernelSemaphore.cpp:230 309=sceKernelCreateSema(fn Decord Sema End, 00000100, 0, 1, 00000000)
51:42:566 user_main    I[KERNEL]: HLE\sceKernelThread.cpp:2136 310=sceKernelCreateThread(name=fnDecordThread, entry=088075e8, prio=37, stacksize=4096)
51:42:566 user_main    D[DISP]: HLE\sceDisplay.cpp:627 Leave VBlank 9
51:42:566 user_main    I[KERNEL]: HLE\sceKernelThread.cpp:2187 sceKernelStartThread(thread=310, argSize=0, argPtr=00000000)
51:42:567 user_main    D[IO]: HLE\sceUmd.cpp:316 0x32=sceUmdGetDriveStat()
51:42:567 user_main    D[IO]: HLE\sceIo.cpp:663 sceIoGetstat(disc0:/PSP_GAME/USRDIR/cfc.dig, 0bfff5c0) : sector = 0006c0c0
51:42:567 fnDecordThre D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: user_main -> fnDecordThread (276->310, pc: 08821fc8->088075e8, io getstat) +147us
51:42:567 fnDecordThre D[KERNEL]: HLE\sceKernelSemaphore.cpp:414 0=sceKernelWaitSema(308, 1, 0)
51:42:567 idle0        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: fnDecordThread -> idle0 (310->272, pc: 08807648->08000000, sema waited) +0us
51:42:567 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: idle0 -> user_main (272->276, pc: 08000000->08821fc8, idle) +999us
51:42:568 user_main    D[KERNEL]: HLE\sceKernelSemaphore.cpp:304 sceKernelSignalSema(304, 1) (count: 0 -> 1)
51:42:568 fnThread     D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: user_main -> fnThread (276->305, pc: 0880734c->08807928, semaphore signaled) +0us
51:42:569 fnThread     D[KERNEL]: HLE\sceKernelSemaphore.cpp:414 0=sceKernelWaitSema(283, 1, 0)
51:42:569 fnThread     D[KERNEL]: HLE\sceKernelSemaphore.cpp:304 sceKernelSignalSema(282, 1) (count: 0 -> 1)
51:42:569 fioThread    D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: fnThread -> fioThread (305->284, pc: 08805864->088068ec, semaphore signaled) +3us
51:42:569 fioThread    D[IO]: HLE\sceIo.cpp:1222 4=sceIoOpen(umd0:umd0, 00000001, 000001ff)
51:42:569 fnThread     D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: fioThread -> fnThread (284->305, pc: 08805c18->08805864, file opened) +0us
51:42:569 fnThread     D[KERNEL]: HLE\sceKernelSemaphore.cpp:304 sceKernelSignalSema(283, 1) (count: 0 -> 1)
51:42:570 fnThread     D[KERNEL]: HLE\sceKernelSemaphore.cpp:414 0=sceKernelWaitSema(307, 1, 0)
51:42:570 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: fnThread -> user_main (305->276, pc: 088058f4->0880734c, sema waited) +0us
51:42:570 user_main    D[KERNEL]: HLE\sceKernelSemaphore.cpp:447 0=sceKernelPollSema(289, 1)
51:42:570 user_main    D[KERNEL]: HLE\sceKernelSemaphore.cpp:453 SCE_KERNEL_ERROR_SEMA_ZERO=sceKernelPollSema(289, 1)
51:42:570 user_main    D[KERNEL]: HLE\sceKernelSemaphore.cpp:453 SCE_KERNEL_ERROR_SEMA_ZERO=sceKernelPollSema(289, 1)
51:42:570 user_main    D[KERNEL]: HLE\sceKernelSemaphore.cpp:414 0=sceKernelWaitSema(289, 1, 0)
51:42:570 idle0        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: user_main -> idle0 (276->272, pc: 0881f5e0->08000000, sema waited) +0us
51:42:570 fioThread    D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: idle0 -> fioThread (272->284, pc: 08000000->08805c18, idle) +99us
51:42:570 fioThread    D[IO]: HLE\sceIo.cpp:1865 SCE_KERNEL_ERROR_NOASYNC = sceIoPollAsync(4, 0bfbea70)
51:42:571 fioThread    D[KERNEL]: HLE\sceKernelSemaphore.cpp:304 sceKernelSignalSema(307, 1) (count: 0 -> 1)
51:42:571 fioThread    D[KERNEL]: HLE\sceKernelSemaphore.cpp:414 0=sceKernelWaitSema(282, 1, 0)
51:42:571 fnThread     D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: fioThread -> fnThread (284->305, pc: 088068ec->088058f4, sema waited) +0us
51:42:571 fnThread     D[KERNEL]: HLE\sceKernelSemaphore.cpp:414 0=sceKernelWaitSema(304, 1, 0)
51:42:571 idle0        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: fnThread -> idle0 (305->272, pc: 08807928->08000000, sema waited) +0us
51:42:571 idle0        D[DISP]: HLE\sceDisplay.cpp:531 Enter VBlank 10
51:42:571 idle0        D[DISP]: HLE\sceDisplay.cpp:565 Setting latched framebuffer 04044000 (prev: 04000000)
51:42:571 idle0        D[SCEGE]: GLES\Framebuffer.cpp:595 Finding no FBO matching address 04044000
51:42:571 idle0        D[SCEGE]: GLES\Framebuffer.cpp:595 Finding no FBO matching address 04044000
51:42:571 idle0        D[SCEGE]: GLES\Framebuffer.cpp:595 Finding no FBO matching address 04044000
51:42:574 Sched        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: idle0 -> Sched (272->281, pc: 08000000->0881f424, idle) +14817us
51:42:574 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: 26000001 @ 00000000
51:42:574 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: 28000000 @ 00000000
51:42:574 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: 5e000000 @ 00000000
51:42:574 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: cc000000 @ 00000000
51:42:574 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: e6000000 @ 00000000
51:42:574 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:271 sceKernelReferSemaStatus(297, 0bfbfa70)
51:42:574 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:304 sceKernelSignalSema(297, 1) (count: 0 -> 1)
51:42:574 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:271 sceKernelReferSemaStatus(291, 0bfbfa70)
51:42:574 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:304 sceKernelSignalSema(291, 1) (count: 0 -> 1)
51:42:574 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:271 sceKernelReferSemaStatus(289, 0bfbfa70)
51:42:574 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:304 sceKernelSignalSema(289, 1) (count: 0 -> 1)
51:42:574 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:271 sceKernelReferSemaStatus(285, 0bfbfa70)
51:42:574 dispThread   D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: Sched -> dispThread (281->296, pc: 0881f424->0881f5e0, vblank start waited) +0us
51:42:574 dispThread   D[KERNEL]: HLE\sceKernelSemaphore.cpp:453 SCE_KERNEL_ERROR_SEMA_ZERO=sceKernelPollSema(294, 1)
51:42:575 dispThread   D[KERNEL]: HLE\sceKernelSemaphore.cpp:414 0=sceKernelWaitSema(297, 1, 0)
51:42:575 Global Pad   D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: dispThread -> Global Pad (296->290, pc: 0881f5e0->0881f5e0, sema waited) +0us
51:42:575 Global Pad   D[CTRL]: HLE\sceCtrl.cpp:455 1=sceCtrlReadBufferPositive(08b2e310, 6)
51:42:575 Global Pad   D[KERNEL]: HLE\sceKernelSemaphore.cpp:414 0=sceKernelWaitSema(291, 1, 0)
51:42:575 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: Global Pad -> user_main (290->276, pc: 0881f5e0->0881f5e0, sema waited) +1us
51:42:575 user_main    D[KERNEL]: HLE\sceKernelSemaphore.cpp:304 sceKernelSignalSema(304, 1) (count: 0 -> 1)
51:42:575 fnThread     D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: user_main -> fnThread (276->305, pc: 0880734c->08807928, semaphore signaled) +0us
51:42:575 fnThread     D[KERNEL]: HLE\sceKernelSemaphore.cpp:414 0=sceKernelWaitSema(283, 1, 0)
51:42:575 fnThread     D[KERNEL]: HLE\sceKernelSemaphore.cpp:304 sceKernelSignalSema(282, 1) (count: 0 -> 1)
51:42:575 fioThread    D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: fnThread -> fioThread (305->284, pc: 08805864->088068ec, semaphore signaled) +0us
51:42:576 fioThread    D[IO]: HLE\sceUmd.cpp:316 0x32=sceUmdGetDriveStat()
51:42:576 fioThread    D[IO]: HLE\sceIo.cpp:1091 442560 = sceIoLseek(4, 6c0c0, 0)
51:42:576 fnThread     D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: fioThread -> fnThread (284->305, pc: 08805d00->08805864, io seek) +0us
51:42:576 fnThread     D[KERNEL]: HLE\sceKernelSemaphore.cpp:304 sceKernelSignalSema(283, 1) (count: 0 -> 1)
51:42:576 fnThread     D[KERNEL]: HLE\sceKernelSemaphore.cpp:414 0=sceKernelWaitSema(307, 1, 0)
51:42:576 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: fnThread -> user_main (305->276, pc: 088058f4->0880734c, sema waited) +0us
51:42:576 user_main    D[IO]: HLE\sceUmd.cpp:316 0x32=sceUmdGetDriveStat()
51:42:576 user_main    D[KERNEL]: HLE\sceKernelSemaphore.cpp:453 SCE_KERNEL_ERROR_SEMA_ZERO=sceKernelPollSema(289, 1)
51:42:576 user_main    D[KERNEL]: HLE\sceKernelSemaphore.cpp:414 0=sceKernelWaitSema(289, 1, 0)
51:42:576 idle0        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: user_main -> idle0 (276->272, pc: 0881f5e0->08000000, sema waited) +0us
51:42:576 fioThread    D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: idle0 -> fioThread (272->284, pc: 08000000->08805d00, idle) +99us
51:42:576 fioThread    D[KERNEL]: HLE\sceKernelSemaphore.cpp:304 sceKernelSignalSema(307, 1) (count: 0 -> 1)
51:42:576 fioThread    D[KERNEL]: HLE\sceKernelSemaphore.cpp:414 0=sceKernelWaitSema(282, 1, 0)
51:42:576 fnThread     D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: fioThread -> fnThread (284->305, pc: 088068ec->088058f4, sema waited) +0us
51:42:577 fnThread     D[KERNEL]: HLE\sceKernelSemaphore.cpp:414 0=sceKernelWaitSema(283, 1, 0)
51:42:577 fnThread     D[KERNEL]: HLE\sceKernelSemaphore.cpp:304 sceKernelSignalSema(282, 1) (count: 0 -> 1)
51:42:577 fioThread    D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: fnThread -> fioThread (305->284, pc: 08805864->088068ec, semaphore signaled) +0us
51:42:577 fioThread    D[IO]: HLE\sceUmd.cpp:316 0x32=sceUmdGetDriveStat()
51:42:577 fioThread    D[IO]: HLE\sceIo.cpp:813 sceIoRead(4, 08c4c7c0, 21): deferring result
51:42:577 fnThread     D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: fioThread -> fnThread (284->305, pc: 08805c88->08805864, io read) +0us
51:42:577 fnThread     D[KERNEL]: HLE\sceKernelSemaphore.cpp:304 sceKernelSignalSema(283, 1) (count: 0 -> 1)
51:42:577 fnThread     D[KERNEL]: HLE\sceKernelSemaphore.cpp:414 0=sceKernelWaitSema(307, 1, 0)
51:42:577 idle0        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: fnThread -> idle0 (305->272, pc: 088058f4->08000000, sema waited) +0us
51:42:577 fioThread    D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: idle0 -> fioThread (272->284, pc: 08000000->08805c88, idle) +99us
51:42:577 fioThread    D[KERNEL]: HLE\sceKernelSemaphore.cpp:304 sceKernelSignalSema(307, 1) (count: 0 -> 1)
51:42:577 fioThread    D[KERNEL]: HLE\sceKernelSemaphore.cpp:414 0=sceKernelWaitSema(282, 1, 0)
51:42:577 fnThread     D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: fioThread -> fnThread (284->305, pc: 088068ec->088058f4, sema waited) +0us
51:42:578 fnThread     D[KERNEL]: HLE\sceKernelSemaphore.cpp:414 0=sceKernelWaitSema(304, 1, 0)
51:42:578 idle0        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: fnThread -> idle0 (305->272, pc: 08807928->08000000, sema waited) +0us
51:42:578 idle0        D[DISP]: HLE\sceDisplay.cpp:627 Leave VBlank 10
51:42:578 idle0        D[DISP]: HLE\sceDisplay.cpp:531 Enter VBlank 11
51:42:578 idle0        D[SCEGE]: GLES\Framebuffer.cpp:595 Finding no FBO matching address 04044000
51:42:578 idle0        D[SCEGE]: GLES\Framebuffer.cpp:595 Finding no FBO matching address 04044000
51:42:578 idle0        D[SCEGE]: GLES\Framebuffer.cpp:595 Finding no FBO matching address 04044000
51:42:591 Sched        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: idle0 -> Sched (272->281, pc: 08000000->0881f424, idle) +16478us
51:42:591 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: 26000001 @ 00000000
51:42:591 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: 28000000 @ 00000000
51:42:591 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: 5e000000 @ 00000000
51:42:591 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: cc000000 @ 00000000
51:42:591 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: e6000000 @ 00000000
51:42:591 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:271 sceKernelReferSemaStatus(297, 0bfbfa70)
51:42:591 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:304 sceKernelSignalSema(297, 1) (count: 0 -> 1)
51:42:591 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:271 sceKernelReferSemaStatus(291, 0bfbfa70)
51:42:591 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:304 sceKernelSignalSema(291, 1) (count: 0 -> 1)
51:42:591 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:271 sceKernelReferSemaStatus(289, 0bfbfa70)
51:42:591 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:304 sceKernelSignalSema(289, 1) (count: 0 -> 1)
51:42:591 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:271 sceKernelReferSemaStatus(285, 0bfbfa70)
51:42:591 dispThread   D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: Sched -> dispThread (281->296, pc: 0881f424->0881f5e0, vblank start waited) +0us
51:42:591 dispThread   D[KERNEL]: HLE\sceKernelSemaphore.cpp:453 SCE_KERNEL_ERROR_SEMA_ZERO=sceKernelPollSema(294, 1)
51:42:591 dispThread   D[KERNEL]: HLE\sceKernelSemaphore.cpp:414 0=sceKernelWaitSema(297, 1, 0)
51:42:591 Global Pad   D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: dispThread -> Global Pad (296->290, pc: 0881f5e0->0881f5e0, sema waited) +0us
51:42:591 Global Pad   D[CTRL]: HLE\sceCtrl.cpp:455 1=sceCtrlReadBufferPositive(08b2e310, 6)
51:42:591 Global Pad   D[KERNEL]: HLE\sceKernelSemaphore.cpp:414 0=sceKernelWaitSema(291, 1, 0)
51:42:591 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: Global Pad -> user_main (290->276, pc: 0881f5e0->0881f5e0, sema waited) +1us
51:42:595 user_main    D[KERNEL]: HLE\sceKernelSemaphore.cpp:230 312=sceKernelCreateSema(volatile cs, 00000100, 1, 1, 00000000)
51:42:595 user_main    D[HLE]: HLE\scePower.cpp:319 sceKernelVolatileMemLock(0, 0bfff600, 0bfff604) - success
51:42:595 user_main    D[DISP]: HLE\sceDisplay.cpp:627 Leave VBlank 11
51:42:597 user_main    D[AUDIO]: HLE\sceAudio.cpp:223 sceAudioChReserve(00000007, 000001c0, 00000000)
51:42:597 user_main    D[AUDIO]: HLE\sceAudio.cpp:223 sceAudioChReserve(00000006, 00000100, 00000000)
51:42:597 user_main    D[AUDIO]: HLE\sceAudio.cpp:223 sceAudioChReserve(00000005, 00000100, 00000000)
51:42:597 user_main    D[AUDIO]: HLE\sceAudio.cpp:223 sceAudioChReserve(00000004, 00000100, 00000000)
51:42:598 user_main    D[AUDIO]: HLE\sceAudio.cpp:262 00000000 = sceAudioSetChannelDataLen(00000005, 00000100)
51:42:598 user_main    D[KERNEL]: HLE\sceKernelMutex.cpp:735 sceKernelCreateLwMutex(08b7244c, SceLibsndpSmfExcl, 00000000, 0, 00000000)
51:42:598 user_main    I[SCESAS]: HLE\sceSas.cpp:106 sceSasInit(08b74a80, 256, 32, 0, 44100)
51:42:599 user_main    D[KERNEL]: HLE\sceKernelMutex.cpp:735 sceKernelCreateLwMutex(08b735a8, SceLibsndpPrevExcl, 00000000, 0, 00000000)
51:42:599 user_main    I[KERNEL]: HLE\sceKernelThread.cpp:2136 315=sceKernelCreateThread(name=muscbThread, entry=08821c5c, prio=10, stacksize=8192)
51:42:599 user_main    I[KERNEL]: HLE\sceKernelThread.cpp:2187 sceKernelStartThread(thread=315, argSize=0, argPtr=00000000)
51:42:599 muscbThread  D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: user_main -> muscbThread (276->315, pc: 08821c48->08821c5c, thread started) +2671us
51:42:601 muscbThread  D[SCESAS]: HLE\sceSas.cpp:138 sceSasCore(08b74a80, 08b3ec80)
51:42:601 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: muscbThread -> user_main (315->276, pc: 08aa1fe0->08821c48, sas core) +10us
51:42:604 user_main    D[DISP]: HLE\sceDisplay.cpp:531 Enter VBlank 12
51:42:604 idle0        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: user_main -> idle0 (276->272, pc: 08a87e48->08000000, interrupt) +13999us
51:42:604 idle0        D[SCEGE]: GLES\Framebuffer.cpp:595 Finding no FBO matching address 04044000
51:42:604 idle0        D[SCEGE]: GLES\Framebuffer.cpp:595 Finding no FBO matching address 04044000
51:42:604 idle0        D[SCEGE]: GLES\Framebuffer.cpp:595 Finding no FBO matching address 04044000
51:42:607 muscbThread  D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: idle0 -> muscbThread (272->315, pc: 08000000->08aa1fe0, idle) +47us
51:42:607 muscbThread  D[G3D]: GPUCommon.cpp:935 DL Unknown: 26000001 @ 00000000
51:42:607 muscbThread  D[G3D]: GPUCommon.cpp:935 DL Unknown: 28000000 @ 00000000
51:42:607 muscbThread  D[G3D]: GPUCommon.cpp:935 DL Unknown: 5e000000 @ 00000000
51:42:607 muscbThread  D[G3D]: GPUCommon.cpp:935 DL Unknown: cc000000 @ 00000000
51:42:607 muscbThread  D[G3D]: GPUCommon.cpp:935 DL Unknown: e6000000 @ 00000000
51:42:607 muscbThread  D[SCESAS]: HLE\sceSas.cpp:528 sceSasGetAllEnvelopeHeights(08b74a80, 201026048)
51:42:607 muscbThread  D[AUDIO]: HLE\sceAudio.cpp:121 00000100 = sceAudioOutputPannedBlocking(00000005, 00008000, 00008000, 08b3ec80)
51:42:608 muscbThread  D[SCESAS]: HLE\sceSas.cpp:138 sceSasCore(08b74a80, 08b3f480)
51:42:608 Sched        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: muscbThread -> Sched (315->281, pc: 08aa1fe0->0881f424, sas core) +12us
51:42:608 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:271 sceKernelReferSemaStatus(297, 0bfbfa70)
51:42:608 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:304 sceKernelSignalSema(297, 1) (count: 0 -> 1)
51:42:608 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:271 sceKernelReferSemaStatus(291, 0bfbfa70)
51:42:608 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:304 sceKernelSignalSema(291, 1) (count: 0 -> 1)
51:42:608 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:271 sceKernelReferSemaStatus(289, 0bfbfa70)
51:42:608 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:304 sceKernelSignalSema(289, 1) (count: 0 -> 1)
51:42:608 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:271 sceKernelReferSemaStatus(285, 0bfbfa70)
51:42:608 dispThread   D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: Sched -> dispThread (281->296, pc: 0881f424->0881f5e0, vblank start waited) +0us
51:42:608 dispThread   D[KERNEL]: HLE\sceKernelSemaphore.cpp:453 SCE_KERNEL_ERROR_SEMA_ZERO=sceKernelPollSema(294, 1)
51:42:608 dispThread   D[KERNEL]: HLE\sceKernelSemaphore.cpp:414 0=sceKernelWaitSema(297, 1, 0)
51:42:608 Global Pad   D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: dispThread -> Global Pad (296->290, pc: 0881f5e0->0881f5e0, sema waited) +0us
51:42:608 Global Pad   D[CTRL]: HLE\sceCtrl.cpp:455 1=sceCtrlReadBufferPositive(08b2e310, 6)
51:42:608 Global Pad   D[KERNEL]: HLE\sceKernelSemaphore.cpp:414 0=sceKernelWaitSema(291, 1, 0)
51:42:608 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: Global Pad -> user_main (290->276, pc: 0881f5e0->08a87e48, sema waited) +1us
51:42:608 user_main    D[DISP]: HLE\sceDisplay.cpp:627 Leave VBlank 12
51:42:611 user_main    D[DISP]: HLE\sceDisplay.cpp:531 Enter VBlank 13
51:42:611 idle0        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: user_main -> idle0 (276->272, pc: 08a87e48->08000000, interrupt) +16620us
51:42:611 idle0        D[SCEGE]: GLES\Framebuffer.cpp:595 Finding no FBO matching address 04044000
51:42:611 idle0        D[SCEGE]: GLES\Framebuffer.cpp:595 Finding no FBO matching address 04044000
51:42:611 idle0        D[SCEGE]: GLES\Framebuffer.cpp:595 Finding no FBO matching address 04044000
51:42:624 idle0        D[DISP]: HLE\sceDisplay.cpp:627 Leave VBlank 13
51:42:624 muscbThread  D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: idle0 -> muscbThread (272->315, pc: 08000000->08aa1fe0, idle) +731us
51:42:624 muscbThread  D[G3D]: GPUCommon.cpp:935 DL Unknown: 26000001 @ 00000000
51:42:624 muscbThread  D[G3D]: GPUCommon.cpp:935 DL Unknown: 28000000 @ 00000000
51:42:624 muscbThread  D[G3D]: GPUCommon.cpp:935 DL Unknown: 5e000000 @ 00000000
51:42:624 muscbThread  D[G3D]: GPUCommon.cpp:935 DL Unknown: cc000000 @ 00000000
51:42:624 muscbThread  D[G3D]: GPUCommon.cpp:935 DL Unknown: e6000000 @ 00000000
51:42:624 muscbThread  D[SCESAS]: HLE\sceSas.cpp:528 sceSasGetAllEnvelopeHeights(08b74a80, 201026048)
51:42:624 muscbThread  D[AUDIO]: HLE\sceAudio.cpp:121 00000100 = sceAudioOutputPannedBlocking(00000005, 00008000, 00008000, 08b3f480)
51:42:624 muscbThread  D[SCESAS]: HLE\sceSas.cpp:138 sceSasCore(08b74a80, 08b3ec80)
51:42:624 Sched        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: muscbThread -> Sched (315->281, pc: 08aa1fe0->0881f424, sas core) +12us
51:42:624 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:271 sceKernelReferSemaStatus(297, 0bfbfa70)
51:42:624 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:304 sceKernelSignalSema(297, 1) (count: 0 -> 1)
51:42:624 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:271 sceKernelReferSemaStatus(291, 0bfbfa70)
51:42:624 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:304 sceKernelSignalSema(291, 1) (count: 0 -> 1)
51:42:624 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:271 sceKernelReferSemaStatus(289, 0bfbfa70)
51:42:624 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:304 sceKernelSignalSema(289, 1) (count: 1 -> 2)
51:42:624 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:271 sceKernelReferSemaStatus(285, 0bfbfa70)
51:42:624 dispThread   D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: Sched -> dispThread (281->296, pc: 0881f424->0881f5e0, vblank start waited) +0us
51:42:624 dispThread   D[KERNEL]: HLE\sceKernelSemaphore.cpp:453 SCE_KERNEL_ERROR_SEMA_ZERO=sceKernelPollSema(294, 1)
51:42:624 dispThread   D[KERNEL]: HLE\sceKernelSemaphore.cpp:414 0=sceKernelWaitSema(297, 1, 0)
51:42:624 Global Pad   D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: dispThread -> Global Pad (296->290, pc: 0881f5e0->0881f5e0, sema waited) +0us
51:42:624 Global Pad   D[CTRL]: HLE\sceCtrl.cpp:455 2=sceCtrlReadBufferPositive(08b2e310, 6)
51:42:624 Global Pad   D[KERNEL]: HLE\sceKernelSemaphore.cpp:414 0=sceKernelWaitSema(291, 1, 0)
51:42:624 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: Global Pad -> user_main (290->276, pc: 0881f5e0->08a87e48, sema waited) +1us
51:42:626 muscbThread  D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: user_main -> muscbThread (276->315, pc: 08a8c904->08aa1fe0, interrupts resumed) +5181us
51:42:626 muscbThread  D[SCESAS]: HLE\sceSas.cpp:528 sceSasGetAllEnvelopeHeights(08b74a80, 201026048)
51:42:626 muscbThread  D[AUDIO]: HLE\sceAudio.cpp:121 00000100 = sceAudioOutputPannedBlocking(00000005, 00008000, 00008000, 08b3ec80)
51:42:626 muscbThread  D[SCESAS]: HLE\sceSas.cpp:138 sceSasCore(08b74a80, 08b3f480)
51:42:626 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: muscbThread -> user_main (315->276, pc: 08aa1fe0->08a8c904, sas core) +12us
51:42:634 muscbThread  D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: user_main -> muscbThread (276->315, pc: 08816e04->08aa1fe0, vblank start waited) +1293us
51:42:634 muscbThread  D[SCESAS]: HLE\sceSas.cpp:528 sceSasGetAllEnvelopeHeights(08b74a80, 201026048)
51:42:634 muscbThread  D[AUDIO]: HLE\sceAudio.cpp:121 00000100 = sceAudioOutputPannedBlocking(00000005, 00008000, 00008000, 08b3f480)
51:42:634 idle0        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: muscbThread -> idle0 (315->272, pc: 08aa154c->08000000, blocking audio) +1us
51:42:634 muscbThread  D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: idle0 -> muscbThread (272->315, pc: 08000000->08aa154c, idle) +3697us
51:42:634 muscbThread  D[SCESAS]: HLE\sceSas.cpp:138 sceSasCore(08b74a80, 08b3ec80)
51:42:634 idle0        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: muscbThread -> idle0 (315->272, pc: 08aa1fe0->08000000, sas core) +11us
51:42:634 muscbThread  D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: idle0 -> muscbThread (272->315, pc: 08000000->08aa1fe0, idle) +240us
51:42:634 muscbThread  D[SCESAS]: HLE\sceSas.cpp:528 sceSasGetAllEnvelopeHeights(08b74a80, 201026048)
51:42:634 muscbThread  D[AUDIO]: HLE\sceAudio.cpp:121 00000100 = sceAudioOutputPannedBlocking(00000005, 00008000, 00008000, 08b3ec80)
51:42:634 idle0        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: muscbThread -> idle0 (315->272, pc: 08aa154c->08000000, blocking audio) +1us
51:42:634 idle0        D[DISP]: HLE\sceDisplay.cpp:531 Enter VBlank 14
51:42:634 idle0        D[SCEGE]: GLES\Framebuffer.cpp:595 Finding no FBO matching address 04044000
51:42:634 idle0        D[SCEGE]: GLES\Framebuffer.cpp:595 Finding no FBO matching address 04044000
51:42:634 idle0        D[SCEGE]: GLES\Framebuffer.cpp:595 Finding no FBO matching address 04044000
51:42:641 Sched        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: idle0 -> Sched (272->281, pc: 08000000->0881f424, idle) +5497us
51:42:641 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: 26000001 @ 00000000
51:42:641 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: 28000000 @ 00000000
51:42:641 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: 5e000000 @ 00000000
51:42:641 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: cc000000 @ 00000000
51:42:641 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: e6000000 @ 00000000
51:42:641 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:271 sceKernelReferSemaStatus(297, 0bfbfa70)
51:42:641 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:304 sceKernelSignalSema(297, 1) (count: 0 -> 1)
51:42:641 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:271 sceKernelReferSemaStatus(291, 0bfbfa70)
51:42:641 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:304 sceKernelSignalSema(291, 1) (count: 0 -> 1)
51:42:641 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:271 sceKernelReferSemaStatus(289, 0bfbfa70)
51:42:641 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:304 sceKernelSignalSema(289, 1) (count: 2 -> 3)
51:42:641 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:271 sceKernelReferSemaStatus(285, 0bfbfa70)
51:42:641 dispThread   D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: Sched -> dispThread (281->296, pc: 0881f424->0881f5e0, vblank start waited) +0us
51:42:641 dispThread   D[KERNEL]: HLE\sceKernelSemaphore.cpp:453 SCE_KERNEL_ERROR_SEMA_ZERO=sceKernelPollSema(294, 1)
51:42:641 dispThread   D[KERNEL]: HLE\sceKernelSemaphore.cpp:414 0=sceKernelWaitSema(297, 1, 0)
51:42:641 Global Pad   D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: dispThread -> Global Pad (296->290, pc: 0881f5e0->0881f5e0, sema waited) +0us
51:42:641 Global Pad   D[CTRL]: HLE\sceCtrl.cpp:461 sceCtrlReadBufferPositive(08b2e310, 6) - waiting
51:42:641 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: Global Pad -> user_main (290->276, pc: 0880895c->08816e04, ctrl buffer waited) +1us
51:42:641 user_main    D[KERNEL]: HLE\sceKernelSemaphore.cpp:447 0=sceKernelPollSema(289, 1)
51:42:641 user_main    D[KERNEL]: HLE\sceKernelSemaphore.cpp:447 0=sceKernelPollSema(289, 1)
51:42:641 user_main    D[KERNEL]: HLE\sceKernelSemaphore.cpp:447 0=sceKernelPollSema(289, 1)
51:42:641 user_main    D[KERNEL]: HLE\sceKernelSemaphore.cpp:453 SCE_KERNEL_ERROR_SEMA_ZERO=sceKernelPollSema(289, 1)
51:42:643 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:2499 50 = sceKernelGetThreadCurrentPriority()
51:42:643 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:2551 sceKernelChangeThreadPriority(276, 44)
51:42:643 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: user_main -> user_main (276->276, pc: 08808fc8->08808fc8, change thread priority) +5us
51:42:643 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:2551 sceKernelChangeThreadPriority(276, 50)
51:42:643 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: user_main -> user_main (276->276, pc: 08808fe4->08808fe4, change thread priority) +2us
51:42:645 user_main    D[KERNEL]: HLE\sceKernelSemaphore.cpp:304 sceKernelSignalSema(304, 1) (count: 0 -> 1)
51:42:645 fnThread     D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: user_main -> fnThread (276->305, pc: 0880734c->08807928, semaphore signaled) +4us
51:42:645 fnThread     D[KERNEL]: HLE\sceKernelSemaphore.cpp:414 0=sceKernelWaitSema(283, 1, 0)
51:42:645 fnThread     D[KERNEL]: HLE\sceKernelSemaphore.cpp:304 sceKernelSignalSema(282, 1) (count: 0 -> 1)
51:42:645 fioThread    D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: fnThread -> fioThread (305->284, pc: 08805864->088068ec, semaphore signaled) +4us
51:42:645 fioThread    D[IO]: HLE\sceIo.cpp:1222 5=sceIoOpen(umd0:/PSP_GAME/USRDIR/cfc.dig, 00000001, 000001ff)
51:42:645 fnThread     D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: fioThread -> fnThread (284->305, pc: 08805c18->08805864, file opened) +0us
51:42:645 fnThread     D[KERNEL]: HLE\sceKernelSemaphore.cpp:304 sceKernelSignalSema(283, 1) (count: 0 -> 1)
51:42:645 fnThread     D[KERNEL]: HLE\sceKernelSemaphore.cpp:414 0=sceKernelWaitSema(307, 1, 0)
51:42:645 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: fnThread -> user_main (305->276, pc: 088058f4->0880734c, sema waited) +0us
51:42:651 user_main    D[KERNEL]: HLE\sceKernelSemaphore.cpp:453 SCE_KERNEL_ERROR_SEMA_ZERO=sceKernelPollSema(302, 1)
51:42:651 muscbThread  D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: user_main -> muscbThread (276->315, pc: 08aa2c4c->08aa154c, interrupts resumed) +44us
51:42:651 muscbThread  D[SCESAS]: HLE\sceSas.cpp:138 sceSasCore(08b74a80, 08b3f480)
51:42:651 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: muscbThread -> user_main (315->276, pc: 08aa1fe0->08aa2c4c, sas core) +11us
51:42:659 fioThread    D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: user_main -> fioThread (276->284, pc: 08aa2f34->08805c18, interrupts resumed) +82us
51:42:659 fioThread    D[IO]: HLE\sceIo.cpp:1865 SCE_KERNEL_ERROR_NOASYNC = sceIoPollAsync(5, 0bfbea70)
51:42:659 fioThread    D[KERNEL]: HLE\sceKernelSemaphore.cpp:304 sceKernelSignalSema(307, 1) (count: 0 -> 1)
51:42:659 fioThread    D[KERNEL]: HLE\sceKernelSemaphore.cpp:414 0=sceKernelWaitSema(282, 1, 0)
51:42:659 fnThread     D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: fioThread -> fnThread (284->305, pc: 088068ec->088058f4, sema waited) +0us
51:42:659 fnThread     D[KERNEL]: HLE\sceKernelSemaphore.cpp:414 0=sceKernelWaitSema(304, 1, 0)
51:42:660 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: fnThread -> user_main (305->276, pc: 08807928->08aa2f34, sema waited) +0us
51:42:660 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:2499 50 = sceKernelGetThreadCurrentPriority()
51:42:660 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:2551 sceKernelChangeThreadPriority(276, 20)
51:42:660 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: user_main -> user_main (276->276, pc: 08818f68->08818f68, change thread priority) +19us
51:42:660 user_main    D[KERNEL]: HLE\sceKernelSemaphore.cpp:304 sceKernelSignalSema(298, 1) (count: 0 -> 1)
51:42:660 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:2551 sceKernelChangeThreadPriority(276, 50)
51:42:660 drawThread   D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: user_main -> drawThread (276->300, pc: 08819028->08819120, change thread priority) +2us
51:42:660 drawThread   D[KERNEL]: HLE\sceKernelThread.cpp:2499 36 = sceKernelGetThreadCurrentPriority()
51:42:660 drawThread   D[KERNEL]: HLE\sceKernelThread.cpp:2551 sceKernelChangeThreadPriority(300, 20)
51:42:660 drawThread   D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: drawThread -> drawThread (300->300, pc: 088190b0->088190b0, change thread priority) +2us
51:42:660 drawThread   D[KERNEL]: HLE\sceKernelThread.cpp:2551 sceKernelChangeThreadPriority(300, 36)
51:42:660 drawThread   D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: drawThread -> drawThread (300->300, pc: 08819154->08819154, change thread priority) +2us
51:42:661 drawThread   D[SCEGE]: HLE\sceGe.cpp:338 sceGeListEnQueue(addr=48b2e380, stall=48b2e380, cbid=00000000, param=08ad2cbc)
51:42:661 drawThread   D[G3D]: GPUCommon.cpp:662 Okay, starting DL execution at 08b2e380 - stall = 08b2e380
51:42:661 drawThread   D[SCEGE]: HLE\sceGe.cpp:345 List 889192450 enqueued.
51:42:662 drawThread   D[SCEGE]: HLE\sceGe.cpp:384 sceGeListUpdateStallAddr(dlid=889192450, stalladdr=48b2e480)
51:42:662 drawThread   D[G3D]: GPUCommon.cpp:662 Okay, starting DL execution at 08b2e380 - stall = 08b2e480
51:42:662 drawThread   D[SCEGE]: GLES\Framebuffer.cpp:611 viewport : 480x272, region : 480x272 , scissor: 480x272, stride: 512, 1
51:42:664 drawThread   I[SCEGE]: GLES\Framebuffer.cpp:811 Creating FBO for 00000000 : 480 x 272 x 1
51:42:664 drawThread   D[G3D]: GLES\VertexDecoder.cpp:662 VTYPE: THRU=1 TC=0 COL=7 POS=2 NRM=0 WT=0 NW=1 IDX=0 MC=1
51:42:664 drawThread   D[G3D]: GLES\VertexDecoder.cpp:828 SVT : size = 12, aligned to biggest 4
51:42:664 drawThread   D[G3D]: GLES\ShaderManager.cpp:73 Compiled shader:
#version 130
#define lowp
#define mediump
#define highp
attribute vec4 position;
attribute lowp vec4 color0;
uniform mat4 u_proj_through;
varying lowp vec4 v_color0;
void main() {
  v_color0 = color0;
  gl_Position = u_proj_through * vec4(position.xyz, 1.0);
}


51:42:664 drawThread   D[G3D]: GLES\ShaderManager.cpp:73 Compiled shader:
#version 130
#define lowp
#define mediump
#define highp
varying vec4 v_color0;
out vec4 fragColor0;
void main() {
  vec4 v = v_color0;
  fragColor0 = v;
}


51:42:664 drawThread   I[G3D]: GLES\ShaderManager.cpp:146 Linked shader: vs 13 fs 14
51:42:665 drawThread   D[SCEGE]: HLE\sceGe.cpp:384 sceGeListUpdateStallAddr(dlid=889192450, stalladdr=48b2e488)
51:42:665 drawThread   D[G3D]: GPUCommon.cpp:662 Okay, starting DL execution at 08b2e480 - stall = 08b2e488
51:42:665 idle0        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: drawThread -> idle0 (300->272, pc: 08aa2f34->08000000, interrupt) +8us
51:42:665 idle0        D[CPU]: HLE\sceGe.cpp:113 Entering interrupt handler 08aa5254
51:42:665 idle0        D[KERNEL]: HLE\sceKernelSemaphore.cpp:304 sceKernelSignalSema(301, 1) (count: 0 -> 1)
51:42:665 drawThread   D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: idle0 -> drawThread (272->300, pc: 08000000->08aa2f34, left interrupt) +0us
51:42:665 drawThread   D[KERNEL]: HLE\sceKernelSemaphore.cpp:414 0=sceKernelWaitSema(301, 1, 0)
51:42:665 drawThread   D[KERNEL]: HLE\sceKernelThread.cpp:2499 36 = sceKernelGetThreadCurrentPriority()
51:42:665 drawThread   D[KERNEL]: HLE\sceKernelThread.cpp:2551 sceKernelChangeThreadPriority(300, 20)
51:42:665 drawThread   D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: drawThread -> drawThread (300->300, pc: 08818f68->08818f68, change thread priority) +3us
51:42:665 drawThread   D[KERNEL]: HLE\sceKernelSemaphore.cpp:304 sceKernelSignalSema(302, 1) (count: 0 -> 1)
51:42:665 drawThread   D[KERNEL]: HLE\sceKernelThread.cpp:2551 sceKernelChangeThreadPriority(300, 36)
51:42:665 drawThread   D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: drawThread -> drawThread (300->300, pc: 08819028->08819028, change thread priority) +2us
51:42:665 drawThread   D[KERNEL]: HLE\sceKernelThread.cpp:2499 36 = sceKernelGetThreadCurrentPriority()
51:42:665 drawThread   D[KERNEL]: HLE\sceKernelThread.cpp:2551 sceKernelChangeThreadPriority(300, 20)
51:42:665 drawThread   D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: drawThread -> drawThread (300->300, pc: 08818f68->08818f68, change thread priority) +3us
51:42:665 drawThread   D[KERNEL]: HLE\sceKernelSemaphore.cpp:304 sceKernelSignalSema(294, 1) (count: 0 -> 1)
51:42:665 drawThread   D[KERNEL]: HLE\sceKernelThread.cpp:2551 sceKernelChangeThreadPriority(300, 36)
51:42:665 drawThread   D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: drawThread -> drawThread (300->300, pc: 08819028->08819028, change thread priority) +2us
51:42:665 drawThread   D[KERNEL]: HLE\sceKernelSemaphore.cpp:414 0=sceKernelWaitSema(293, 1, 0)
51:42:665 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: drawThread -> user_main (300->276, pc: 088093c8->08819028, sema waited) +0us
51:42:666 idle0        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: user_main -> idle0 (276->272, pc: 08816e04->08000000, vblank start waited) +1us
51:42:666 muscbThread  D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: idle0 -> muscbThread (272->315, pc: 08000000->08aa1fe0, idle) +109us
51:42:666 muscbThread  D[SCESAS]: HLE\sceSas.cpp:528 sceSasGetAllEnvelopeHeights(08b74a80, 201026048)
51:42:666 muscbThread  D[AUDIO]: HLE\sceAudio.cpp:121 00000100 = sceAudioOutputPannedBlocking(00000005, 00008000, 00008000, 08b3f480)
51:42:666 idle0        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: muscbThread -> idle0 (315->272, pc: 08aa154c->08000000, blocking audio) +1us
51:42:666 idle0        D[DISP]: HLE\sceDisplay.cpp:627 Leave VBlank 14
51:42:666 Global Pad   D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: idle0 -> Global Pad (272->290, pc: 08000000->0880895c, idle) +413us
51:42:666 Global Pad   D[KERNEL]: HLE\sceKernelSemaphore.cpp:414 0=sceKernelWaitSema(291, 1, 0)
51:42:666 idle0        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: Global Pad -> idle0 (290->272, pc: 0881f5e0->08000000, sema waited) +0us
51:42:666 muscbThread  D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: idle0 -> muscbThread (272->315, pc: 08000000->08aa154c, idle) +5125us
51:42:666 muscbThread  D[SCESAS]: HLE\sceSas.cpp:138 sceSasCore(08b74a80, 08b3ec80)
51:42:666 idle0        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: muscbThread -> idle0 (315->272, pc: 08aa1fe0->08000000, sas core) +11us
51:42:666 muscbThread  D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: idle0 -> muscbThread (272->315, pc: 08000000->08aa1fe0, idle) +240us
51:42:666 muscbThread  D[SCESAS]: HLE\sceSas.cpp:528 sceSasGetAllEnvelopeHeights(08b74a80, 201026048)
51:42:666 muscbThread  D[AUDIO]: HLE\sceAudio.cpp:121 00000100 = sceAudioOutputPannedBlocking(00000005, 00008000, 00008000, 08b3ec80)
51:42:666 idle0        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: muscbThread -> idle0 (315->272, pc: 08aa154c->08000000, blocking audio) +1us
51:42:666 muscbThread  D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: idle0 -> muscbThread (272->315, pc: 08000000->08aa154c, idle) +5551us
51:42:666 muscbThread  D[SCESAS]: HLE\sceSas.cpp:138 sceSasCore(08b74a80, 08b3f480)
51:42:666 idle0        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: muscbThread -> idle0 (315->272, pc: 08aa1fe0->08000000, sas core) +11us
51:42:666 muscbThread  D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: idle0 -> muscbThread (272->315, pc: 08000000->08aa1fe0, idle) +240us
51:42:666 muscbThread  D[SCESAS]: HLE\sceSas.cpp:528 sceSasGetAllEnvelopeHeights(08b74a80, 201026048)
51:42:666 muscbThread  D[AUDIO]: HLE\sceAudio.cpp:121 00000100 = sceAudioOutputPannedBlocking(00000005, 00008000, 00008000, 08b3f480)
51:42:666 idle0        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: muscbThread -> idle0 (315->272, pc: 08aa154c->08000000, blocking audio) +1us
51:42:666 idle0        D[DISP]: HLE\sceDisplay.cpp:531 Enter VBlank 15
51:42:666 idle0        D[SCEGE]: GLES\Framebuffer.cpp:595 Finding no FBO matching address 04044000
51:42:666 idle0        D[SCEGE]: GLES\Framebuffer.cpp:595 Finding no FBO matching address 04044000
51:42:666 idle0        D[SCEGE]: GLES\Framebuffer.cpp:595 Finding no FBO matching address 04044000
51:42:668 Sched        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: idle0 -> Sched (272->281, pc: 08000000->0881f424, idle) +4768us
51:42:668 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: 26000001 @ 00000000
51:42:668 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: 28000000 @ 00000000
51:42:668 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: 5e000000 @ 00000000
51:42:668 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: cc000000 @ 00000000
51:42:668 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: e6000000 @ 00000000
51:42:668 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:271 sceKernelReferSemaStatus(297, 0bfbfa70)
51:42:668 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:304 sceKernelSignalSema(297, 1) (count: 0 -> 1)
51:42:668 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:271 sceKernelReferSemaStatus(291, 0bfbfa70)
51:42:668 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:304 sceKernelSignalSema(291, 1) (count: 0 -> 1)
51:42:668 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:271 sceKernelReferSemaStatus(289, 0bfbfa70)
51:42:668 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:304 sceKernelSignalSema(289, 1) (count: 0 -> 1)
51:42:668 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:271 sceKernelReferSemaStatus(285, 0bfbfa70)
51:42:668 dispThread   D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: Sched -> dispThread (281->296, pc: 0881f424->0881f5e0, vblank start waited) +0us
51:42:668 dispThread   D[KERNEL]: HLE\sceKernelSemaphore.cpp:447 0=sceKernelPollSema(294, 1)
51:42:668 dispThread   D[KERNEL]: HLE\sceKernelThread.cpp:2499 35 = sceKernelGetThreadCurrentPriority()
51:42:668 dispThread   D[KERNEL]: HLE\sceKernelThread.cpp:2551 sceKernelChangeThreadPriority(296, 20)
51:42:668 dispThread   D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: dispThread -> dispThread (296->296, pc: 088190b0->088190b0, change thread priority) +3us
51:42:668 dispThread   D[KERNEL]: HLE\sceKernelThread.cpp:2551 sceKernelChangeThreadPriority(296, 35)
51:42:668 dispThread   D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: dispThread -> dispThread (296->296, pc: 08819154->08819154, change thread priority) +2us
51:42:668 dispThread   D[KERNEL]: HLE\sceKernelSemaphore.cpp:414 0=sceKernelWaitSema(297, 1, 0)
51:42:668 Global Pad   D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: dispThread -> Global Pad (296->290, pc: 0881f5e0->0881f5e0, sema waited) +0us
51:42:668 Global Pad   D[CTRL]: HLE\sceCtrl.cpp:461 sceCtrlReadBufferPositive(08b2e310, 6) - waiting
51:42:668 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: Global Pad -> user_main (290->276, pc: 0880895c->08816e04, ctrl buffer waited) +1us
51:42:668 user_main    D[KERNEL]: HLE\sceKernelSemaphore.cpp:447 0=sceKernelPollSema(289, 1)
51:42:668 user_main    D[KERNEL]: HLE\sceKernelSemaphore.cpp:453 SCE_KERNEL_ERROR_SEMA_ZERO=sceKernelPollSema(289, 1)
51:42:668 user_main    D[KERNEL]: HLE\sceKernelSemaphore.cpp:414 0=sceKernelWaitSema(289, 1, 0)
51:42:668 idle0        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: user_main -> idle0 (276->272, pc: 0881f5e0->08000000, sema waited) +0us
51:42:668 idle0        D[DISP]: HLE\sceDisplay.cpp:627 Leave VBlank 15
51:42:668 Global Pad   D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: idle0 -> Global Pad (272->290, pc: 08000000->0880895c, idle) +723us
51:42:668 Global Pad   D[KERNEL]: HLE\sceKernelSemaphore.cpp:414 0=sceKernelWaitSema(291, 1, 0)
51:42:669 idle0        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: Global Pad -> idle0 (290->272, pc: 0881f5e0->08000000, sema waited) +0us
51:42:669 muscbThread  D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: idle0 -> muscbThread (272->315, pc: 08000000->08aa154c, idle) +50us
51:42:669 muscbThread  D[SCESAS]: HLE\sceSas.cpp:138 sceSasCore(08b74a80, 08b3ec80)
51:42:669 idle0        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: muscbThread -> idle0 (315->272, pc: 08aa1fe0->08000000, sas core) +11us
51:42:669 muscbThread  D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: idle0 -> muscbThread (272->315, pc: 08000000->08aa1fe0, idle) +240us
51:42:669 muscbThread  D[SCESAS]: HLE\sceSas.cpp:528 sceSasGetAllEnvelopeHeights(08b74a80, 201026048)
51:42:669 muscbThread  D[AUDIO]: HLE\sceAudio.cpp:121 00000100 = sceAudioOutputPannedBlocking(00000005, 00008000, 00008000, 08b3ec80)
51:42:669 idle0        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: muscbThread -> idle0 (315->272, pc: 08aa154c->08000000, blocking audio) +1us
51:42:669 muscbThread  D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: idle0 -> muscbThread (272->315, pc: 08000000->08aa154c, idle) +5551us
51:42:669 muscbThread  D[SCESAS]: HLE\sceSas.cpp:138 sceSasCore(08b74a80, 08b3f480)
51:42:669 idle0        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: muscbThread -> idle0 (315->272, pc: 08aa1fe0->08000000, sas core) +11us
51:42:669 muscbThread  D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: idle0 -> muscbThread (272->315, pc: 08000000->08aa1fe0, idle) +240us
51:42:669 muscbThread  D[SCESAS]: HLE\sceSas.cpp:528 sceSasGetAllEnvelopeHeights(08b74a80, 201026048)
51:42:669 muscbThread  D[AUDIO]: HLE\sceAudio.cpp:121 00000100 = sceAudioOutputPannedBlocking(00000005, 00008000, 00008000, 08b3f480)
51:42:669 idle0        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: muscbThread -> idle0 (315->272, pc: 08aa154c->08000000, blocking audio) +1us
51:42:669 muscbThread  D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: idle0 -> muscbThread (272->315, pc: 08000000->08aa154c, idle) +5551us
51:42:669 muscbThread  D[SCESAS]: HLE\sceSas.cpp:138 sceSasCore(08b74a80, 08b3ec80)
51:42:669 idle0        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: muscbThread -> idle0 (315->272, pc: 08aa1fe0->08000000, sas core) +11us
51:42:669 muscbThread  D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: idle0 -> muscbThread (272->315, pc: 08000000->08aa1fe0, idle) +240us
51:42:669 muscbThread  D[SCESAS]: HLE\sceSas.cpp:528 sceSasGetAllEnvelopeHeights(08b74a80, 201026048)
51:42:669 muscbThread  D[AUDIO]: HLE\sceAudio.cpp:121 00000100 = sceAudioOutputPannedBlocking(00000005, 00008000, 00008000, 08b3ec80)
51:42:669 idle0        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: muscbThread -> idle0 (315->272, pc: 08aa154c->08000000, blocking audio) +1us
51:42:669 idle0        D[DISP]: HLE\sceDisplay.cpp:531 Enter VBlank 16
51:42:669 idle0        D[SCEGE]: GLES\Framebuffer.cpp:595 Finding no FBO matching address 04044000
51:42:669 idle0        D[SCEGE]: GLES\Framebuffer.cpp:595 Finding no FBO matching address 04044000
51:42:669 idle0        D[SCEGE]: GLES\Framebuffer.cpp:595 Finding no FBO matching address 04044000
51:42:674 Sched        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: idle0 -> Sched (272->281, pc: 08000000->0881f424, idle) +4040us
51:42:674 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: 26000001 @ 00000000
51:42:674 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: 28000000 @ 00000000
51:42:674 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: 5e000000 @ 00000000
51:42:674 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: cc000000 @ 00000000
51:42:674 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: e6000000 @ 00000000
51:42:674 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:271 sceKernelReferSemaStatus(297, 0bfbfa70)
51:42:674 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:304 sceKernelSignalSema(297, 1) (count: 0 -> 1)
51:42:674 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:271 sceKernelReferSemaStatus(291, 0bfbfa70)
51:42:674 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:304 sceKernelSignalSema(291, 1) (count: 0 -> 1)
51:42:674 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:271 sceKernelReferSemaStatus(289, 0bfbfa70)
51:42:674 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:304 sceKernelSignalSema(289, 1) (count: 0 -> 1)
51:42:674 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:271 sceKernelReferSemaStatus(285, 0bfbfa70)
51:42:674 dispThread   D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: Sched -> dispThread (281->296, pc: 0881f424->0881f5e0, vblank start waited) +0us
51:42:674 dispThread   D[KERNEL]: HLE\sceKernelSemaphore.cpp:414 0=sceKernelWaitSema(297, 1, 0)
51:42:674 Global Pad   D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: dispThread -> Global Pad (296->290, pc: 0881f5e0->0881f5e0, sema waited) +0us
51:42:674 Global Pad   D[CTRL]: HLE\sceCtrl.cpp:461 sceCtrlReadBufferPositive(08b2e310, 6) - waiting
51:42:674 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: Global Pad -> user_main (290->276, pc: 0880895c->0881f5e0, ctrl buffer waited) +1us
51:42:674 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:2499 50 = sceKernelGetThreadCurrentPriority()
51:42:674 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:2551 sceKernelChangeThreadPriority(276, 44)
51:42:674 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: user_main -> user_main (276->276, pc: 08808fc8->08808fc8, change thread priority) +5us
51:42:674 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:2551 sceKernelChangeThreadPriority(276, 50)
51:42:674 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: user_main -> user_main (276->276, pc: 08808fe4->08808fe4, change thread priority) +2us
51:42:675 user_main    D[KERNEL]: HLE\sceKernelSemaphore.cpp:304 sceKernelSignalSema(304, 1) (count: 0 -> 1)
51:42:675 fnThread     D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: user_main -> fnThread (276->305, pc: 0880734c->08807928, semaphore signaled) +0us
51:42:675 fnThread     D[KERNEL]: HLE\sceKernelSemaphore.cpp:414 0=sceKernelWaitSema(283, 1, 0)
51:42:675 fnThread     D[KERNEL]: HLE\sceKernelSemaphore.cpp:304 sceKernelSignalSema(282, 1) (count: 0 -> 1)
51:42:675 fioThread    D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: fnThread -> fioThread (305->284, pc: 08805864->088068ec, semaphore signaled) +0us
51:42:675 fioThread    D[IO]: HLE\sceUmd.cpp:316 0x32=sceUmdGetDriveStat()
51:42:675 fioThread    D[IO]: HLE\sceIo.cpp:1091 442560 = sceIoLseek(5, 6c0c0, 0)
51:42:675 fnThread     D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: fioThread -> fnThread (284->305, pc: 08805d00->08805864, io seek) +0us
51:42:675 fnThread     D[KERNEL]: HLE\sceKernelSemaphore.cpp:304 sceKernelSignalSema(283, 1) (count: 0 -> 1)
51:42:675 fnThread     D[KERNEL]: HLE\sceKernelSemaphore.cpp:414 0=sceKernelWaitSema(307, 1, 0)
51:42:675 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: fnThread -> user_main (305->276, pc: 088058f4->0880734c, sema waited) +0us
51:42:676 user_main    D[KERNEL]: HLE\sceKernelSemaphore.cpp:447 0=sceKernelPollSema(302, 1)
51:42:676 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:2499 50 = sceKernelGetThreadCurrentPriority()
51:42:676 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:2551 sceKernelChangeThreadPriority(276, 20)
51:42:676 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: user_main -> user_main (276->276, pc: 088190b0->088190b0, change thread priority) +6us
51:42:676 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:2551 sceKernelChangeThreadPriority(276, 50)
51:42:676 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: user_main -> user_main (276->276, pc: 08819154->08819154, change thread priority) +2us
51:42:676 user_main    D[KERNEL]: HLE\sceKernelSemaphore.cpp:453 SCE_KERNEL_ERROR_SEMA_ZERO=sceKernelPollSema(302, 1)
51:42:676 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:2499 50 = sceKernelGetThreadCurrentPriority()
51:42:676 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:2551 sceKernelChangeThreadPriority(276, 20)
51:42:676 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: user_main -> user_main (276->276, pc: 08818f68->08818f68, change thread priority) +102us
51:42:676 user_main    D[KERNEL]: HLE\sceKernelSemaphore.cpp:304 sceKernelSignalSema(298, 1) (count: 0 -> 1)
51:42:676 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:2551 sceKernelChangeThreadPriority(276, 50)
51:42:676 fioThread    D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: user_main -> fioThread (276->284, pc: 08819028->08805d00, change thread priority) +2us
51:42:676 fioThread    D[KERNEL]: HLE\sceKernelSemaphore.cpp:304 sceKernelSignalSema(307, 1) (count: 0 -> 1)
51:42:676 fioThread    D[KERNEL]: HLE\sceKernelSemaphore.cpp:414 0=sceKernelWaitSema(282, 1, 0)
51:42:676 fnThread     D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: fioThread -> fnThread (284->305, pc: 088068ec->088058f4, sema waited) +0us
51:42:677 fnThread     D[KERNEL]: HLE\sceKernelSemaphore.cpp:414 0=sceKernelWaitSema(283, 1, 0)
51:42:677 fnThread     D[KERNEL]: HLE\sceKernelSemaphore.cpp:304 sceKernelSignalSema(282, 1) (count: 0 -> 1)
51:42:677 fioThread    D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: fnThread -> fioThread (305->284, pc: 08805864->088068ec, semaphore signaled) +0us
51:42:677 fioThread    D[IO]: HLE\sceUmd.cpp:316 0x32=sceUmdGetDriveStat()
51:42:677 fioThread    D[IO]: HLE\sceIo.cpp:813 sceIoRead(5, 08c4c7c0, 21): deferring result
51:42:677 fnThread     D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: fioThread -> fnThread (284->305, pc: 08805c88->08805864, io read) +0us
51:42:677 fnThread     D[KERNEL]: HLE\sceKernelSemaphore.cpp:304 sceKernelSignalSema(283, 1) (count: 0 -> 1)
51:42:677 fnThread     D[KERNEL]: HLE\sceKernelSemaphore.cpp:414 0=sceKernelWaitSema(307, 1, 0)
51:42:677 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: fnThread -> user_main (305->276, pc: 088058f4->08819028, sema waited) +0us
51:42:677 idle0        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: user_main -> idle0 (276->272, pc: 08816e04->08000000, vblank start waited) +1us
51:42:677 fioThread    D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: idle0 -> fioThread (272->284, pc: 08000000->08805c88, idle) +98us
51:42:677 fioThread    D[KERNEL]: HLE\sceKernelSemaphore.cpp:304 sceKernelSignalSema(307, 1) (count: 0 -> 1)
51:42:677 fioThread    D[KERNEL]: HLE\sceKernelSemaphore.cpp:414 0=sceKernelWaitSema(282, 1, 0)
51:42:677 fnThread     D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: fioThread -> fnThread (284->305, pc: 088068ec->088058f4, sema waited) +0us
51:42:677 fnThread     D[KERNEL]: HLE\sceKernelSemaphore.cpp:414 0=sceKernelWaitSema(304, 1, 0)
51:42:677 idle0        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: fnThread -> idle0 (305->272, pc: 08807928->08000000, sema waited) +0us
51:42:677 idle0        D[DISP]: HLE\sceDisplay.cpp:627 Leave VBlank 16
51:42:677 Global Pad   D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: idle0 -> Global Pad (272->290, pc: 08000000->0880895c, idle) +504us
51:42:677 Global Pad   D[KERNEL]: HLE\sceKernelSemaphore.cpp:414 0=sceKernelWaitSema(291, 1, 0)
51:42:677 idle0        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: Global Pad -> idle0 (290->272, pc: 0881f5e0->08000000, sema waited) +0us
51:42:677 muscbThread  D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: idle0 -> muscbThread (272->315, pc: 08000000->08aa154c, idle) +779us
51:42:677 muscbThread  D[SCESAS]: HLE\sceSas.cpp:138 sceSasCore(08b74a80, 08b3f480)
51:42:677 idle0        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: muscbThread -> idle0 (315->272, pc: 08aa1fe0->08000000, sas core) +11us
51:42:677 muscbThread  D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: idle0 -> muscbThread (272->315, pc: 08000000->08aa1fe0, idle) +240us
51:42:677 muscbThread  D[SCESAS]: HLE\sceSas.cpp:528 sceSasGetAllEnvelopeHeights(08b74a80, 201026048)
51:42:677 muscbThread  D[AUDIO]: HLE\sceAudio.cpp:121 00000100 = sceAudioOutputPannedBlocking(00000005, 00008000, 00008000, 08b3f480)
51:42:677 idle0        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: muscbThread -> idle0 (315->272, pc: 08aa154c->08000000, blocking audio) +1us
51:42:677 muscbThread  D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: idle0 -> muscbThread (272->315, pc: 08000000->08aa154c, idle) +5551us
51:42:677 muscbThread  D[SCESAS]: HLE\sceSas.cpp:138 sceSasCore(08b74a80, 08b3ec80)
51:42:677 idle0        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: muscbThread -> idle0 (315->272, pc: 08aa1fe0->08000000, sas core) +11us
51:42:677 muscbThread  D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: idle0 -> muscbThread (272->315, pc: 08000000->08aa1fe0, idle) +240us
51:42:677 muscbThread  D[SCESAS]: HLE\sceSas.cpp:528 sceSasGetAllEnvelopeHeights(08b74a80, 201026048)
51:42:677 muscbThread  D[AUDIO]: HLE\sceAudio.cpp:121 00000100 = sceAudioOutputPannedBlocking(00000005, 00008000, 00008000, 08b3ec80)
51:42:677 idle0        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: muscbThread -> idle0 (315->272, pc: 08aa154c->08000000, blocking audio) +1us
51:42:677 muscbThread  D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: idle0 -> muscbThread (272->315, pc: 08000000->08aa154c, idle) +5551us
51:42:677 muscbThread  D[SCESAS]: HLE\sceSas.cpp:138 sceSasCore(08b74a80, 08b3f480)
51:42:677 idle0        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: muscbThread -> idle0 (315->272, pc: 08aa1fe0->08000000, sas core) +11us
51:42:677 muscbThread  D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: idle0 -> muscbThread (272->315, pc: 08000000->08aa1fe0, idle) +240us
51:42:677 muscbThread  D[SCESAS]: HLE\sceSas.cpp:528 sceSasGetAllEnvelopeHeights(08b74a80, 201026048)
51:42:677 muscbThread  D[AUDIO]: HLE\sceAudio.cpp:121 00000100 = sceAudioOutputPannedBlocking(00000005, 00008000, 00008000, 08b3f480)
51:42:677 idle0        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: muscbThread -> idle0 (315->272, pc: 08aa154c->08000000, blocking audio) +1us
51:42:677 idle0        D[DISP]: HLE\sceDisplay.cpp:531 Enter VBlank 17
51:42:677 idle0        D[SCEGE]: GLES\Framebuffer.cpp:595 Finding no FBO matching address 04044000
51:42:678 idle0        D[SCEGE]: GLES\Framebuffer.cpp:595 Finding no FBO matching address 04044000
51:42:678 idle0        D[SCEGE]: GLES\Framebuffer.cpp:595 Finding no FBO matching address 04044000
51:42:691 Sched        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: idle0 -> Sched (272->281, pc: 08000000->0881f424, idle) +3311us
51:42:691 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: 26000001 @ 00000000
51:42:691 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: 28000000 @ 00000000
51:42:691 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: 5e000000 @ 00000000
51:42:691 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: cc000000 @ 00000000
51:42:691 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: e6000000 @ 00000000
51:42:691 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:271 sceKernelReferSemaStatus(297, 0bfbfa70)
51:42:691 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:304 sceKernelSignalSema(297, 1) (count: 0 -> 1)
51:42:691 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:271 sceKernelReferSemaStatus(291, 0bfbfa70)
51:42:691 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:304 sceKernelSignalSema(291, 1) (count: 0 -> 1)
51:42:691 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:271 sceKernelReferSemaStatus(289, 0bfbfa70)
51:42:691 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:304 sceKernelSignalSema(289, 1) (count: 0 -> 1)
51:42:691 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:271 sceKernelReferSemaStatus(285, 0bfbfa70)
51:42:691 dispThread   D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: Sched -> dispThread (281->296, pc: 0881f424->0881f5e0, vblank start waited) +0us
51:42:691 dispThread   D[KERNEL]: HLE\sceKernelSemaphore.cpp:304 sceKernelSignalSema(293, 1) (count: 0 -> 1)
51:42:691 dispThread   D[KERNEL]: HLE\sceKernelSemaphore.cpp:414 0=sceKernelWaitSema(297, 1, 0)
51:42:691 drawThread   D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: dispThread -> drawThread (296->300, pc: 0881f5e0->088093c8, sema waited) +0us
51:42:691 drawThread   D[DISP]: HLE\sceDisplay.cpp:655 sceDisplaySetFramebuf(topaddr=04000000,linesize=512,pixelsize=1,sync=0)
51:42:692 drawThread   D[KERNEL]: HLE\sceKernelSemaphore.cpp:414 0=sceKernelWaitSema(298, 1, 0)
51:42:692 drawThread   D[KERNEL]: HLE\sceKernelThread.cpp:2499 36 = sceKernelGetThreadCurrentPriority()
51:42:692 drawThread   D[KERNEL]: HLE\sceKernelThread.cpp:2551 sceKernelChangeThreadPriority(300, 20)
51:42:692 drawThread   D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: drawThread -> drawThread (300->300, pc: 088190b0->088190b0, change thread priority) +4us
51:42:692 drawThread   D[KERNEL]: HLE\sceKernelThread.cpp:2551 sceKernelChangeThreadPriority(300, 36)
51:42:692 drawThread   D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: drawThread -> drawThread (300->300, pc: 08819154->08819154, change thread priority) +2us
51:42:692 drawThread   D[SCEGE]: HLE\sceGe.cpp:338 sceGeListEnQueue(addr=48b2e380, stall=48b2e380, cbid=00000000, param=08ad2cbc)
51:42:692 drawThread   D[G3D]: GPUCommon.cpp:662 Okay, starting DL execution at 08b2e380 - stall = 08b2e380
51:42:692 drawThread   D[SCEGE]: HLE\sceGe.cpp:345 List 889192451 enqueued.
51:42:692 drawThread   D[SCEGE]: HLE\sceGe.cpp:384 sceGeListUpdateStallAddr(dlid=889192451, stalladdr=48b2e480)
51:42:692 drawThread   D[G3D]: GPUCommon.cpp:662 Okay, starting DL execution at 08b2e380 - stall = 08b2e480
51:42:692 drawThread   D[SCEGE]: GLES\Framebuffer.cpp:611 viewport : 480x272, region : 480x272 , scissor: 480x272, stride: 512, 1
51:42:693 drawThread   I[SCEGE]: GLES\Framebuffer.cpp:811 Creating FBO for 00044000 : 480 x 272 x 1
51:42:693 drawThread   D[SCEGE]: HLE\sceGe.cpp:384 sceGeListUpdateStallAddr(dlid=889192451, stalladdr=48b2e488)
51:42:693 drawThread   D[G3D]: GPUCommon.cpp:662 Okay, starting DL execution at 08b2e480 - stall = 08b2e488
51:42:693 idle0        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: drawThread -> idle0 (300->272, pc: 08aa2f34->08000000, interrupt) +8us
51:42:693 idle0        D[CPU]: HLE\sceGe.cpp:113 Entering interrupt handler 08aa5254
51:42:693 idle0        D[KERNEL]: HLE\sceKernelSemaphore.cpp:304 sceKernelSignalSema(301, 1) (count: 0 -> 1)
51:42:693 drawThread   D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: idle0 -> drawThread (272->300, pc: 08000000->08aa2f34, left interrupt) +0us
51:42:693 drawThread   D[KERNEL]: HLE\sceKernelSemaphore.cpp:414 0=sceKernelWaitSema(301, 1, 0)
51:42:693 drawThread   D[KERNEL]: HLE\sceKernelThread.cpp:2499 36 = sceKernelGetThreadCurrentPriority()
51:42:693 drawThread   D[KERNEL]: HLE\sceKernelThread.cpp:2551 sceKernelChangeThreadPriority(300, 20)
51:42:693 drawThread   D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: drawThread -> drawThread (300->300, pc: 08818f68->08818f68, change thread priority) +3us
51:42:693 drawThread   D[KERNEL]: HLE\sceKernelSemaphore.cpp:304 sceKernelSignalSema(302, 1) (count: 0 -> 1)
51:42:693 drawThread   D[KERNEL]: HLE\sceKernelThread.cpp:2551 sceKernelChangeThreadPriority(300, 36)
51:42:693 drawThread   D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: drawThread -> drawThread (300->300, pc: 08819028->08819028, change thread priority) +2us
51:42:693 drawThread   D[KERNEL]: HLE\sceKernelThread.cpp:2499 36 = sceKernelGetThreadCurrentPriority()
51:42:693 drawThread   D[KERNEL]: HLE\sceKernelThread.cpp:2551 sceKernelChangeThreadPriority(300, 20)
51:42:693 drawThread   D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: drawThread -> drawThread (300->300, pc: 08818f68->08818f68, change thread priority) +3us
51:42:693 drawThread   D[KERNEL]: HLE\sceKernelSemaphore.cpp:304 sceKernelSignalSema(294, 1) (count: 0 -> 1)
51:42:693 drawThread   D[KERNEL]: HLE\sceKernelThread.cpp:2551 sceKernelChangeThreadPriority(300, 36)
51:42:693 drawThread   D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: drawThread -> drawThread (300->300, pc: 08819028->08819028, change thread priority) +2us
51:42:693 drawThread   D[KERNEL]: HLE\sceKernelSemaphore.cpp:414 0=sceKernelWaitSema(293, 1, 0)
51:42:693 Global Pad   D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: drawThread -> Global Pad (300->290, pc: 088093c8->0881f5e0, sema waited) +0us
51:42:693 Global Pad   D[CTRL]: HLE\sceCtrl.cpp:461 sceCtrlReadBufferPositive(08b2e310, 6) - waiting
51:42:693 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: Global Pad -> user_main (290->276, pc: 0880895c->08816e04, ctrl buffer waited) +1us
51:42:693 user_main    D[KERNEL]: HLE\sceKernelSemaphore.cpp:447 0=sceKernelPollSema(289, 1)
51:42:693 user_main    D[KERNEL]: HLE\sceKernelSemaphore.cpp:453 SCE_KERNEL_ERROR_SEMA_ZERO=sceKernelPollSema(289, 1)
51:42:693 user_main    D[KERNEL]: HLE\sceKernelSemaphore.cpp:414 0=sceKernelWaitSema(289, 1, 0)
51:42:693 idle0        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: user_main -> idle0 (276->272, pc: 0881f5e0->08000000, sema waited) +0us
51:42:693 idle0        D[DISP]: HLE\sceDisplay.cpp:627 Leave VBlank 17
51:42:693 Global Pad   D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: idle0 -> Global Pad (272->290, pc: 08000000->0880895c, idle) +702us
51:42:705 Global Pad   D[KERNEL]: HLE\sceKernelSemaphore.cpp:414 0=sceKernelWaitSema(291, 1, 0)
51:42:705 idle0        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: Global Pad -> idle0 (290->272, pc: 0881f5e0->08000000, sema waited) +0us
51:42:705 muscbThread  D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: idle0 -> muscbThread (272->315, pc: 08000000->08aa154c, idle) +1507us
51:42:705 muscbThread  D[SCESAS]: HLE\sceSas.cpp:138 sceSasCore(08b74a80, 08b3ec80)
51:42:705 idle0        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: muscbThread -> idle0 (315->272, pc: 08aa1fe0->08000000, sas core) +11us
51:42:705 muscbThread  D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: idle0 -> muscbThread (272->315, pc: 08000000->08aa1fe0, idle) +240us
51:42:705 muscbThread  D[SCESAS]: HLE\sceSas.cpp:528 sceSasGetAllEnvelopeHeights(08b74a80, 201026048)
51:42:705 muscbThread  D[AUDIO]: HLE\sceAudio.cpp:121 00000100 = sceAudioOutputPannedBlocking(00000005, 00008000, 00008000, 08b3ec80)
51:42:705 idle0        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: muscbThread -> idle0 (315->272, pc: 08aa154c->08000000, blocking audio) +1us
51:42:705 muscbThread  D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: idle0 -> muscbThread (272->315, pc: 08000000->08aa154c, idle) +5551us
51:42:705 muscbThread  D[SCESAS]: HLE\sceSas.cpp:138 sceSasCore(08b74a80, 08b3f480)
51:42:705 idle0        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: muscbThread -> idle0 (315->272, pc: 08aa1fe0->08000000, sas core) +11us
51:42:705 muscbThread  D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: idle0 -> muscbThread (272->315, pc: 08000000->08aa1fe0, idle) +240us
51:42:705 muscbThread  D[SCESAS]: HLE\sceSas.cpp:528 sceSasGetAllEnvelopeHeights(08b74a80, 201026048)
51:42:705 muscbThread  D[AUDIO]: HLE\sceAudio.cpp:121 00000100 = sceAudioOutputPannedBlocking(00000005, 00008000, 00008000, 08b3f480)
51:42:705 idle0        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: muscbThread -> idle0 (315->272, pc: 08aa154c->08000000, blocking audio) +1us
51:42:705 muscbThread  D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: idle0 -> muscbThread (272->315, pc: 08000000->08aa154c, idle) +5551us
51:42:705 muscbThread  D[SCESAS]: HLE\sceSas.cpp:138 sceSasCore(08b74a80, 08b3ec80)
51:42:705 idle0        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: muscbThread -> idle0 (315->272, pc: 08aa1fe0->08000000, sas core) +11us
51:42:705 muscbThread  D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: idle0 -> muscbThread (272->315, pc: 08000000->08aa1fe0, idle) +240us
51:42:705 muscbThread  D[SCESAS]: HLE\sceSas.cpp:528 sceSasGetAllEnvelopeHeights(08b74a80, 201026048)
51:42:705 muscbThread  D[AUDIO]: HLE\sceAudio.cpp:121 00000100 = sceAudioOutputPannedBlocking(00000005, 00008000, 00008000, 08b3ec80)
51:42:705 idle0        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: muscbThread -> idle0 (315->272, pc: 08aa154c->08000000, blocking audio) +1us
51:42:705 idle0        D[DISP]: HLE\sceDisplay.cpp:531 Enter VBlank 18
51:42:705 idle0        D[SCEGE]: GLES\Framebuffer.cpp:1053 Displaying FBO 00000000
51:42:707 Sched        D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: idle0 -> Sched (272->281, pc: 08000000->0881f424, idle) +2582us
51:42:707 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: 26000001 @ 00000000
51:42:707 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: 28000000 @ 00000000
51:42:707 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: 5e000000 @ 00000000
51:42:707 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: cc000000 @ 00000000
51:42:707 Sched        D[G3D]: GPUCommon.cpp:935 DL Unknown: e6000000 @ 00000000
51:42:707 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:271 sceKernelReferSemaStatus(297, 0bfbfa70)
51:42:707 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:304 sceKernelSignalSema(297, 1) (count: 0 -> 1)
51:42:707 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:271 sceKernelReferSemaStatus(291, 0bfbfa70)
51:42:707 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:304 sceKernelSignalSema(291, 1) (count: 0 -> 1)
51:42:707 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:271 sceKernelReferSemaStatus(289, 0bfbfa70)
51:42:707 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:304 sceKernelSignalSema(289, 1) (count: 0 -> 1)
51:42:707 Sched        D[KERNEL]: HLE\sceKernelSemaphore.cpp:271 sceKernelReferSemaStatus(285, 0bfbfa70)
51:42:707 dispThread   D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: Sched -> dispThread (281->296, pc: 0881f424->0881f5e0, vblank start waited) +0us
51:42:707 dispThread   D[KERNEL]: HLE\sceKernelSemaphore.cpp:447 0=sceKernelPollSema(294, 1)
51:42:707 dispThread   D[KERNEL]: HLE\sceKernelThread.cpp:2499 35 = sceKernelGetThreadCurrentPriority()
51:42:707 dispThread   D[KERNEL]: HLE\sceKernelThread.cpp:2551 sceKernelChangeThreadPriority(296, 20)
51:42:707 dispThread   D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: dispThread -> dispThread (296->296, pc: 088190b0->088190b0, change thread priority) +3us
51:42:707 dispThread   D[KERNEL]: HLE\sceKernelThread.cpp:2551 sceKernelChangeThreadPriority(296, 35)
51:42:707 dispThread   D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: dispThread -> dispThread (296->296, pc: 08819154->08819154, change thread priority) +2us
51:42:707 dispThread   D[KERNEL]: HLE\sceKernelSemaphore.cpp:414 0=sceKernelWaitSema(297, 1, 0)
51:42:707 Global Pad   D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: dispThread -> Global Pad (296->290, pc: 0881f5e0->0881f5e0, sema waited) +0us
51:42:707 Global Pad   D[CTRL]: HLE\sceCtrl.cpp:461 sceCtrlReadBufferPositive(08b2e310, 6) - waiting
51:42:707 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: Global Pad -> user_main (290->276, pc: 0880895c->0881f5e0, ctrl buffer waited) +1us
51:42:707 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:2499 50 = sceKernelGetThreadCurrentPriority()
51:42:707 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:2551 sceKernelChangeThreadPriority(276, 44)
51:42:707 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: user_main -> user_main (276->276, pc: 08808fc8->08808fc8, change thread priority) +5us
51:42:707 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:2551 sceKernelChangeThreadPriority(276, 50)
51:42:707 user_main    D[KERNEL]: HLE\sceKernelThread.cpp:3204 Context switch: user_main -> user_main (276->276, pc: 08808fe4->08808fe4, change thread priority) +2us
51:42:709 user_main    W[MM]: MemmapFunctions.cpp:131 WriteToHardware: Invalid address ffffffd5
52:20:241 user_main    I[SCEGE]: GLES\Framebuffer.cpp:1647 Destroying FBO for 00000000 : 480 x 272 x 1
52:20:241 user_main    I[SCEGE]: GLES\Framebuffer.cpp:1647 Destroying FBO for 00044000 : 480 x 272 x 1
52:20:265 user_main    I[KERNEL]: HLE\sceKernel.cpp:507 KO 272: Thread "idle0": pc= 08000000 sp= 083fff00  READY     (wt=0 wid=0 wv= 00000000 )
52:20:265 user_main    I[KERNEL]: HLE\sceKernel.cpp:507 KO 273: Thread "idle1": pc= 08000000 sp= 083fef00  READY     (wt=0 wid=0 wv= 00000000 )
52:20:265 user_main    I[KERNEL]: HLE\sceKernel.cpp:507 KO 274: Module "mainTest": name=mainTest gp=00000000 entry=0882a5dc
52:20:265 user_main    I[KERNEL]: HLE\sceKernel.cpp:507 KO 276: Thread "user_main": pc= 08808fe4 sp= 0bfff650 RUN      (wt=0 wid=0 wv= 00000001 )
52:20:265 user_main    I[KERNEL]: HLE\sceKernel.cpp:507 KO 277: MemoryPart "UserSbrk": MemPart: 08b7f000 - 09ef5c00	size: 01376c00
52:20:265 user_main    I[KERNEL]: HLE\sceKernel.cpp:507 KO 278: CallBack "exit": thread=276, argument= 00000000
52:20:265 user_main    I[KERNEL]: HLE\sceKernel.cpp:507 KO 279: CallBack "power": thread=276, argument= 00000000
52:20:265 user_main    I[KERNEL]: HLE\sceKernel.cpp:507 KO 280: CallBack "SysUmd": thread=276, argument= 00000000
52:20:265 user_main    I[KERNEL]: HLE\sceKernel.cpp:507 KO 281: Thread "Sched": pc= 0881f424 sp= 0bfbfa70   WAIT    (wt=12 wid=1 wv= 00000000 )
52:20:265 user_main    I[KERNEL]: HLE\sceKernel.cpp:507 KO 282: Semaphore "fio Sema": -
52:20:265 user_main    I[KERNEL]: HLE\sceKernel.cpp:507 KO 283: Semaphore "fio_ReEnt Sema": -
52:20:265 user_main    I[KERNEL]: HLE\sceKernel.cpp:507 KO 284: Thread "fioThread": pc= 088068ec sp= 0bfbea90   WAIT    (wt=3 wid=282 wv= 00000001 )
52:20:265 user_main    I[KERNEL]: HLE\sceKernel.cpp:507 KO 285: Semaphore "add client": -
52:20:265 user_main    I[KERNEL]: HLE\sceKernel.cpp:507 KO 286: Module "scePsmfP_library": faked name=scePsmfP_library gp=ffffffff entry=ffffffff
52:20:265 user_main    I[KERNEL]: HLE\sceKernel.cpp:507 KO 287: Module "scePsmf_library": faked name=scePsmf_library gp=ffffffff entry=ffffffff
52:20:265 user_main    I[KERNEL]: HLE\sceKernel.cpp:507 KO 288: Module "sceFont_Library": faked name=sceFont_Library gp=ffffffff entry=ffffffff
52:20:265 user_main    I[KERNEL]: HLE\sceKernel.cpp:507 KO 289: Semaphore "add client": -
52:20:265 user_main    I[KERNEL]: HLE\sceKernel.cpp:507 KO 290: Thread "Global Pad": pc= 0880895c sp= 0bfbcaa0   WAIT    (wt=15 wid=1 wv= 08b2e310 )
52:20:265 user_main    I[KERNEL]: HLE\sceKernel.cpp:507 KO 291: Semaphore "add client": -
52:20:265 user_main    I[KERNEL]: HLE\sceKernel.cpp:507 KO 292: EventFlag "SceGuSignal": init=00000001 cur=00000001 numwait=0
52:20:265 user_main    I[KERNEL]: HLE\sceKernel.cpp:507 KO 293: Semaphore "disp Done Sema": -
52:20:265 user_main    I[KERNEL]: HLE\sceKernel.cpp:507 KO 294: Semaphore "msg  Sema": -
52:20:265 user_main    I[KERNEL]: HLE\sceKernel.cpp:507 KO 295: Semaphore "wait Sema": -
52:20:265 user_main    I[KERNEL]: HLE\sceKernel.cpp:507 KO 296: Thread "dispThread": pc= 0881f5e0 sp= 0bfbaa80   WAIT    (wt=3 wid=297 wv= 00000001 )
52:20:265 user_main    I[KERNEL]: HLE\sceKernel.cpp:507 KO 297: Semaphore "add client": -
52:20:265 user_main    I[KERNEL]: HLE\sceKernel.cpp:507 KO 298: Semaphore "msg  Sema": -
52:20:265 user_main    I[KERNEL]: HLE\sceKernel.cpp:507 KO 299: Semaphore "wait Sema": -
52:20:265 user_main    I[KERNEL]: HLE\sceKernel.cpp:507 KO 300: Thread "drawThread": pc= 088093c8 sp= 0bfb9a70   WAIT    (wt=3 wid=293 wv= 00000001 )
52:20:265 user_main    I[KERNEL]: HLE\sceKernel.cpp:507 KO 301: Semaphore "draw Done Sema": -
52:20:265 user_main    I[KERNEL]: HLE\sceKernel.cpp:507 KO 302: Semaphore "msg  Sema": -
52:20:265 user_main    I[KERNEL]: HLE\sceKernel.cpp:507 KO 303: Semaphore "wait Sema": -
52:20:265 user_main    I[KERNEL]: HLE\sceKernel.cpp:507 KO 304: Semaphore "fn Sema": -
52:20:265 user_main    I[KERNEL]: HLE\sceKernel.cpp:507 KO 305: Thread "fnThread": pc= 08807928 sp= 0bfb8930   WAIT    (wt=3 wid=304 wv= 00000001 )
52:20:265 user_main    I[KERNEL]: HLE\sceKernel.cpp:507 KO 306: Semaphore "fio Sema tmp": -
52:20:265 user_main    I[KERNEL]: HLE\sceKernel.cpp:507 KO 307: Semaphore "fio Sema tmp": -
52:20:265 user_main    I[KERNEL]: HLE\sceKernel.cpp:507 KO 308: Semaphore "fn Decord Sema": -
52:20:265 user_main    I[KERNEL]: HLE\sceKernel.cpp:507 KO 309: Semaphore "fn Decord Sema End": -
52:20:265 user_main    I[KERNEL]: HLE\sceKernel.cpp:507 KO 310: Thread "fnDecordThread": pc= 08807648 sp= 0bfb7a90   WAIT    (wt=3 wid=308 wv= 00000001 )
52:20:266 user_main    I[KERNEL]: HLE\sceKernel.cpp:507 KO 311: OpenFile "umd0:umd0": Seekpos: 0006c0e1
52:20:266 user_main    I[KERNEL]: HLE\sceKernel.cpp:507 KO 312: Semaphore "volatile cs": -
52:20:266 user_main    I[KERNEL]: HLE\sceKernel.cpp:507 KO 313: LwMutex "SceLibsndpSmfExcl": -
52:20:266 user_main    I[KERNEL]: HLE\sceKernel.cpp:507 KO 314: LwMutex "SceLibsndpPrevExcl": -
52:20:266 user_main    I[KERNEL]: HLE\sceKernel.cpp:507 KO 315: Thread "muscbThread": pc= 08aa154c sp= 0bfb6a90   WAIT    (wt=10 wid=6 wv= 00000100 )
52:20:266 user_main    I[KERNEL]: HLE\sceKernel.cpp:507 KO 316: OpenFile "umd0:/PSP_GAME/USRDIR/cfc.dig": Seekpos: 0006c0e1
52:20:266 user_main    I[KERNEL]: HLE\sceKernel.cpp:158 Shutting down kernel - 44 kernel objects alive
52:20:266 Util\BlockAllocator.cpp:224 D[HLE]: Merging Blocks
52:20:266 Util\BlockAllocator.cpp:229 D[HLE]: Block Alloc found adjacent free blocks - merging
52:20:278 Util\BlockAllocator.cpp:224 D[HLE]: Merging Blocks
52:20:278 Util\BlockAllocator.cpp:229 D[HLE]: Block Alloc found adjacent free blocks - merging
52:20:278 Util\BlockAllocator.cpp:249 D[HLE]: Block Alloc found adjacent free blocks - merging
52:20:278 Util\BlockAllocator.cpp:224 D[HLE]: Merging Blocks
52:20:278 Util\BlockAllocator.cpp:224 D[HLE]: Merging Blocks
52:20:278 Util\BlockAllocator.cpp:224 D[HLE]: Merging Blocks
52:20:278 Util\BlockAllocator.cpp:249 D[HLE]: Block Alloc found adjacent free blocks - merging
52:20:278 Util\BlockAllocator.cpp:224 D[HLE]: Merging Blocks
52:20:278 Util\BlockAllocator.cpp:229 D[HLE]: Block Alloc found adjacent free blocks - merging
52:20:278 Util\BlockAllocator.cpp:224 D[HLE]: Merging Blocks
52:20:278 Util\BlockAllocator.cpp:229 D[HLE]: Block Alloc found adjacent free blocks - merging
52:20:278 Util\BlockAllocator.cpp:249 D[HLE]: Block Alloc found adjacent free blocks - merging
52:20:278 Util\BlockAllocator.cpp:224 D[HLE]: Merging Blocks
52:20:278 Util\BlockAllocator.cpp:229 D[HLE]: Block Alloc found adjacent free blocks - merging
52:20:278 Util\BlockAllocator.cpp:249 D[HLE]: Block Alloc found adjacent free blocks - merging
52:20:278 Util\BlockAllocator.cpp:224 D[HLE]: Merging Blocks
52:20:278 Util\BlockAllocator.cpp:249 D[HLE]: Block Alloc found adjacent free blocks - merging
52:20:278 HLE\sceKernelMemory.cpp:465 I[KERNEL]: Shutting down user memory pool: 
52:20:278 Util\BlockAllocator.cpp:381 I[HLE]: -----------
52:20:278 Util\BlockAllocator.cpp:385 I[HLE]: Block: 08800000 - 0bfb4c00 size 037b4c00 taken=0 tag=(untitled)
52:20:278 Util\BlockAllocator.cpp:385 I[HLE]: Block: 0bfb4c00 - 0bfb6c00 size 00002000 taken=1 tag=stack/muscbThread
52:20:278 Util\BlockAllocator.cpp:385 I[HLE]: Block: 0bfb6c00 - 0bfb7c00 size 00001000 taken=1 tag=stack/fnDecordThread
52:20:278 Util\BlockAllocator.cpp:385 I[HLE]: Block: 0bfb7c00 - 0bfb8c00 size 00001000 taken=1 tag=stack/fnThread
52:20:278 Util\BlockAllocator.cpp:385 I[HLE]: Block: 0bfb8c00 - 0bfb9c00 size 00001000 taken=1 tag=stack/drawThread
52:20:290 Util\BlockAllocator.cpp:385 I[HLE]: Block: 0bfb9c00 - 0bfbac00 size 00001000 taken=1 tag=stack/dispThread
52:20:290 Util\BlockAllocator.cpp:385 I[HLE]: Block: 0bfbac00 - 0bfbcc00 size 00002000 taken=1 tag=stack/Global Pad
52:20:290 Util\BlockAllocator.cpp:385 I[HLE]: Block: 0bfbcc00 - 0bfbec00 size 00002000 taken=1 tag=stack/fioThread
52:20:290 Util\BlockAllocator.cpp:385 I[HLE]: Block: 0bfbec00 - 0bfbfc00 size 00001000 taken=1 tag=stack/Sched
52:20:290 Util\BlockAllocator.cpp:385 I[HLE]: Block: 0bfbfc00 - 0bfffc00 size 00040000 taken=1 tag=stack/user_main
52:20:290 Util\BlockAllocator.cpp:385 I[HLE]: Block: 0bfffc00 - 0c000000 size 00000400 taken=0 tag=stack/root
52:20:290 Util\BlockAllocator.cpp:387 I[HLE]: -----------
52:20:290 HLE\sceKernelMemory.cpp:470 I[KERNEL]: Shutting down "kernel" memory pool: 
52:20:290 Util\BlockAllocator.cpp:381 I[HLE]: -----------
52:20:290 Util\BlockAllocator.cpp:385 I[HLE]: Block: 08000000 - 083fe000 size 003fe000 taken=0 tag=threadrethack
52:20:290 Util\BlockAllocator.cpp:385 I[HLE]: Block: 083fe000 - 083ff000 size 00001000 taken=1 tag=stack/idle1
52:20:290 Util\BlockAllocator.cpp:385 I[HLE]: Block: 083ff000 - 08400000 size 00001000 taken=1 tag=stack/idle0
52:20:290 Util\BlockAllocator.cpp:387 I[HLE]: -----------
52:20:335 MemMap.cpp:167 D[MM]: Memory system shut down.
52:20:354 Config.cpp:803 I[LOAD]: Config saved: E:\PPSSPP\ppsspp-v0.9.8-142-g36bdd99-windows-amd64\ppsspp\memstick/PSP/SYSTEM/ppsspp.ini
52:20:357 Config.cpp:815 I[LOAD]: Controller config saved: E:\PPSSPP\ppsspp-v0.9.8-142-g36bdd99-windows-amd64\ppsspp\memstick/PSP/SYSTEM/controls.ini
52:20:390 Config.cpp:803 I[LOAD]: Config saved: E:\PPSSPP\ppsspp-v0.9.8-142-g36bdd99-windows-amd64\ppsspp\memstick/PSP/SYSTEM/ppsspp.ini
52:20:392 Config.cpp:815 I[LOAD]: Controller config saved: E:\PPSSPP\ppsspp-v0.9.8-142-g36bdd99-windows-amd64\ppsspp\memstick/PSP/SYSTEM/controls.ini
