Freak Out - Extreme Freeride uneven fps

[benderscruffy]

just keeps on printing out this error

42:14:346 HLE\sceKernelMemory.cpp:503 E[HLE]: UNIMPL sceKernelPrintf(08cf08c8, 08cf0898, 00000112, 00000048)
42:14:346 HLE\sceKernelMemory.cpp:504 E[HLE]: libc:%s: no reent structure found

http://pastebin.com/b89ZdZvE

[unknownbrackets]

It seems to be expecting 0x446B00 more bytes to be free, which is quite a few. It would work if the ELF were much smaller, e.g. 0xC0C00. Clearly the module start info helped this, or it would've been even worse.

Maybe it's because of something wrong in sceKernelQueryModuleInfo(). I wonder if that is under-advertising the memory used by the module.

-[Unknown]

[dbz400]

Dragon Ball Z Tenkaichi Tag Team , similar issue i think

31:54:201 HLE\sceKernelMemory.cpp:508 E[HLE]: UNIMPL sceKernelPrintf(08a76c4c, 08a76c18, 00000000, 00000000)
31:54:201 HLE\sceKernelMemory.cpp:509 E[HLE]: libc:%s: something wrong 0x%08X

[unknownbrackets]

Sounds like it's still not booting but the errors have changed:
http://forums.ppsspp.org/showthread.php?tid=2522

A more up to date log would help.

-[Unknown]

[scraggles80]

here is an up to date log
36:09:827 EmuThread.cpp:75 I[BOOT]: Done.
36:14:170 EmuScreen.cpp:54 I[BOOT]: Starting up hardware.
36:14:170 System.cpp:70 I[HLE]: PPSSPP v0.7.6-1251-gea5996b
36:14:170 MemArena.cpp:369 I[MM]: Found valid memory base at 09800000 after 35 tries.
36:14:170 MemMap.cpp:82 I[MM]: Memory system initialized. RAM at 0B1D0000 (mirror at 0 @ 11800000, uncached @ 11800000)
36:14:190 Loaders.cpp:130 I[LOAD]: Identifying file...
36:14:190 PSPLoaders.cpp:67 I[LOAD]: ULES00783 : FREAK OUT EXTREME FREERIDE
36:14:190 PSPLoaders.cpp:132 I[LOAD]: Loading disc0:/PSP_GAME/SYSDIR/EBOOT.BIN...
36:14:190 HLE\sceKernelMemory.cpp:162 I[HLE]: Kernel and user memory pools initialized
36:14:190 HLE\sceIo.cpp:261 I[HLE]: Starting up I/O...
36:14:190 FileUtil.cpp:204 I[COMMON]: CreateFullPath: path d:\4\EmuCR-ppsspp-20130109-x64\memstick
36:14:190 FileUtil.cpp:208 I[COMMON]: CreateFullPath: path exists d:\4\EmuCR-ppsspp-20130109-x64\memstick
36:14:191 FileUtil.cpp:204 I[COMMON]: CreateFullPath: path d:\4\EmuCR-ppsspp-20130109-x64\flash0
36:14:191 FileUtil.cpp:208 I[COMMON]: CreateFullPath: path exists d:\4\EmuCR-ppsspp-20130109-x64\flash0
36:14:195 FileUtil.cpp:204 I[COMMON]: CreateFullPath: path Cheats
36:14:195 FileUtil.cpp:208 I[COMMON]: CreateFullPath: path exists Cheats
36:14:195 FileUtil.cpp:204 I[COMMON]: CreateFullPath: path d:\4\EmuCR-ppsspp-20130109-x64\memstick\PSP\PPSSPP_STATE
36:14:195 FileUtil.cpp:208 I[COMMON]: CreateFullPath: path exists d:\4\EmuCR-ppsspp-20130109-x64\memstick\PSP\PPSSPP_STATE
36:14:226 HLE\sceKernel.cpp:131 I[HLE]: Kernel initialized.
36:14:246 HLE\sceKernelModule.cpp:426 I[HLE]: Decrypting ~PSP file
36:14:359 C:\BuildAgent\work\acf56f986e98e7c9\Core/ELF/ElfReader.h:58 I[LOAD]: ElfReader: 10610020
36:14:363 Util\BlockAllocator.cpp:359 I[HLE]: -----------
36:14:363 Util\BlockAllocator.cpp:363 I[HLE]: Block: 08800000 - 08804000 size 00004000 taken=0 tag=(untitled)
36:14:363 Util\BlockAllocator.cpp:363 I[HLE]: Block: 08804000 - 08d0b700 size 00507700 taken=1 tag=ELF
36:14:363 Util\BlockAllocator.cpp:363 I[HLE]: Block: 08d0b700 - 0a000000 size 012f4900 taken=0 tag=(untitled)
36:14:367 ELF\ElfReader.cpp:516 N[LOAD]: ELF loading completed successfully.
36:14:446 HLE\sceKernelModule.cpp:546 I[LOAD]: Module Freeride: 08cfff50 08c3f2c4 08c3f2dc
36:14:446 HLE\sceKernelModule.cpp:715 I[HLE]: Exporting ent 0 named Freeride, 2 funcs, 4 vars, resident 08c3f65c
36:14:447 HLE\sceKernelModule.cpp:938 I[LOAD]: Module entry: 08804124
36:14:708 root N[BOOT]: EmuScreen.cpp:98 Loading D:\4\EmuCR-ppsspp-20130109-x64\roms\Freak Out - Extreme Freeride (Europe) (En,Fr,De,Es,It) (v1.02).iso...
36:14:708 root I[HLE]: HLE\sceKernelThread.cpp:1886 276=sceKernelCreateThread(name=user_main, entry=08804224, prio=20, stacksize=262144)
36:14:708 root I[HLE]: HLE\sceKernelThread.cpp:1929 sceKernelStartThread(thread=276, argSize=33, argPtr=09fffe00)
36:14:708 root I[HLE]: HLE\sceKernelThread.cpp:2015 __KernelReturnFromThread: 0
36:14:709 user_main I[HLE]: HLE\sceKernelModule.cpp:1332 sceKernelGetModuleId()
36:14:709 user_main I[HLE]: HLE\sceKernelModule.cpp:1399 sceKernelQueryModuleInfo(274, 09fff600)
36:14:723 user_main I[HLE]: Util\BlockAllocator.cpp:359 -----------
36:14:723 user_main I[HLE]: Util\BlockAllocator.cpp:363 Block: 08800000 - 08804000 size 00004000 taken=0 tag=(untitled)
36:14:723 user_main I[HLE]: Util\BlockAllocator.cpp:363 Block: 08804000 - 08d0b700 size 00507700 taken=1 tag=ELF
36:14:723 user_main I[HLE]: Util\BlockAllocator.cpp:363 Block: 08d0b700 - 09fbfc00 size 012b4500 taken=0 tag=(untitled)
36:14:723 user_main I[HLE]: Util\BlockAllocator.cpp:363 Block: 09fbfc00 - 09fffc00 size 00040000 taken=1 tag=stack/user_main
36:14:723 user_main I[HLE]: Util\BlockAllocator.cpp:363 Block: 09fffc00 - 0a000000 size 00000400 taken=0 tag=stack/root
36:14:723 user_main E[HLE]: Util\BlockAllocator.cpp:131 Block Allocator failed to allocate 24113152 (016ff000) bytes of contiguous memory
36:14:723 user_main I[HLE]: Util\BlockAllocator.cpp:359 -----------
36:14:723 user_main I[HLE]: Util\BlockAllocator.cpp:363 Block: 08800000 - 08804000 size 00004000 taken=0 tag=(untitled)
36:14:723 user_main I[HLE]: Util\BlockAllocator.cpp:363 Block: 08804000 - 08d0b700 size 00507700 taken=1 tag=ELF
36:14:723 user_main I[HLE]: Util\BlockAllocator.cpp:363 Block: 08d0b700 - 09fbfc00 size 012b4500 taken=0 tag=(untitled)
36:14:723 user_main I[HLE]: Util\BlockAllocator.cpp:363 Block: 09fbfc00 - 09fffc00 size 00040000 taken=1 tag=stack/user_main
36:14:723 user_main I[HLE]: Util\BlockAllocator.cpp:363 Block: 09fffc00 - 0a000000 size 00000400 taken=0 tag=stack/root
36:14:723 user_main E[HLE]: HLE\sceKernelMemory.cpp:524 ARGH! sceKernelAllocPartitionMemory failed
36:14:724 user_main I[HLE]: Util\BlockAllocator.cpp:359 -----------
36:14:724 user_main I[HLE]: Util\BlockAllocator.cpp:363 Block: 08800000 - 08804000 size 00004000 taken=0 tag=(untitled)
36:14:724 user_main I[HLE]: Util\BlockAllocator.cpp:363 Block: 08804000 - 08d0b700 size 00507700 taken=1 tag=ELF
36:14:724 user_main I[HLE]: Util\BlockAllocator.cpp:363 Block: 08d0b700 - 09fbfc00 size 012b4500 taken=0 tag=(untitled)
36:14:724 user_main I[HLE]: Util\BlockAllocator.cpp:363 Block: 09fbfc00 - 09fffc00 size 00040000 taken=1 tag=stack/user_main
36:14:724 user_main I[HLE]: Util\BlockAllocator.cpp:363 Block: 09fffc00 - 0a000000 size 00000400 taken=0 tag=stack/root
36:14:724 user_main E[HLE]: Util\BlockAllocator.cpp:131 Block Allocator failed to allocate 24113152 (016ff000) bytes of contiguous memory

36:14:768 user_main I[HLE]: HLE\sceKernelMemory.cpp:642 sceKernelPrintf: libc:_getmodreent: no reent structure found

36:16:269 user_main I[HLE]: HLE\sceKernel.cpp:461 KO 272: Thread "idle0": pc= 08000000 sp= 083fff00 READY (wt=0 wid=0 wv= 00000000 )
36:16:269 user_main I[HLE]: HLE\sceKernel.cpp:461 KO 273: Thread "idle1": pc= 08000000 sp= 083fef00 READY (wt=0 wid=0 wv= 00000000 )
36:16:269 user_main I[HLE]: HLE\sceKernel.cpp:461 KO 274: Module "Freeride": name=Freeride gp=08cfff50 entry=08804124
36:16:269 user_main I[HLE]: HLE\sceKernel.cpp:461 KO 276: Thread "user_main": pc= 08c3ab84 sp= 09fff5d0 RUN (wt=0 wid=0 wv= 00000001 )
36:16:269 user_main I[HLE]: HLE\sceKernel.cpp:142 Shutting down kernel - 4 kernel objects alive
36:16:309 HLE\sceKernelMemory.cpp:188 I[HLE]: Shutting down user memory pool:
36:16:309 Util\BlockAllocator.cpp:359 I[HLE]: -----------
36:16:309 Util\BlockAllocator.cpp:363 I[HLE]: Block: 08800000 - 0a000000 size 01800000 taken=0 tag=(untitled)
36:16:309 HLE\sceKernelMemory.cpp:191 I[HLE]: Shutting down "kernel" memory pool:
36:16:309 Util\BlockAllocator.cpp:359 I[HLE]: -----------
36:16:309 Util\BlockAllocator.cpp:363 I[HLE]: Block: 08000000 - 08400000 size 00400000 taken=0 tag=threadrethack
36:16:311 MemMap.cpp:101 I[MM]: Memory system shut down.
36:16:313 Config.cpp:252 I[LOAD]: Config saved: ppsspp.ini

[scraggles80]

v0.8.1-1173-ge03acc4
still a black screen

05:22:793 EmuThread.cpp:122 I[BOOT]: Done.
05:35:760 EmuScreen.cpp:63 I[BOOT]: Starting up hardware.
05:35:760 System.cpp:64 I[HLE]: PPSSPP v0.8.1-1167-gf01279f
05:35:760 MemMap.cpp:93 I[MM]: Memory system initialized. RAM at 000000000CAC0000 (mirror at 0 @ 0000000088000000, uncached @ 00000000C8000000)
05:35:776 Loaders.cpp:136 I[LOAD]: Identifying file...
05:35:777 PSPLoaders.cpp:121 I[LOAD]: ULES00783 : FREAK OUT EXTREME FREERIDE
05:35:777 PSPLoaders.cpp:192 I[LOAD]: Loading disc0:/PSP_GAME/SYSDIR/EBOOT.BIN...
05:35:777 HLE\sceKernelMemory.cpp:164 I[HLE]: Kernel and user memory pools initialized
05:35:777 HLE\sceIo.cpp:298 I[HLE]: Starting up I/O...
05:35:777 FileUtil.cpp:214 I[COMMON]: CreateFullPath: path D:\4\EmuCR-ppsspp-20130109-x64\memstick
05:35:777 FileUtil.cpp:218 I[COMMON]: CreateFullPath: path exists D:\4\EmuCR-ppsspp-20130109-x64\memstick
05:35:777 FileUtil.cpp:214 I[COMMON]: CreateFullPath: path D:\4\EmuCR-ppsspp-20130109-x64\flash0
05:35:777 FileUtil.cpp:218 I[COMMON]: CreateFullPath: path exists D:\4\EmuCR-ppsspp-20130109-x64\flash0
05:35:782 GLES\Framebuffer.cpp:205 N[HLE]: GPU Vendor : ATI Technologies Inc.
05:35:782 FileUtil.cpp:214 I[COMMON]: CreateFullPath: path cheats
05:35:782 FileUtil.cpp:218 I[COMMON]: CreateFullPath: path exists cheats
05:35:782 FileUtil.cpp:214 I[COMMON]: CreateFullPath: path D:\4\EmuCR-ppsspp-20130109-x64\memstick\PSP\PPSSPP_STATE
05:35:782 FileUtil.cpp:218 I[COMMON]: CreateFullPath: path exists D:\4\EmuCR-ppsspp-20130109-x64\memstick\PSP\PPSSPP_STATE
05:35:810 HLE\sceKernel.cpp:135 I[HLE]: Kernel initialized.
05:35:827 HLE\sceKernelModule.cpp:454 I[HLE]: Decrypting ~PSP file
05:35:918 C:\BuildAgent\work\acf56f986e98e7c9\Core/ELF/ElfReader.h:58 I[LOAD]: ElfReader: 00000000135B0040
05:35:922 Util\BlockAllocator.cpp:359 I[HLE]: -----------
05:35:922 Util\BlockAllocator.cpp:363 I[HLE]: Block: 08800000 - 08804000 size 00004000 taken=0 tag=(untitled)
05:35:922 Util\BlockAllocator.cpp:363 I[HLE]: Block: 08804000 - 08d0b700 size 00507700 taken=1 tag=ELF
05:35:922 Util\BlockAllocator.cpp:363 I[HLE]: Block: 08d0b700 - 0a000000 size 012f4900 taken=0 tag=(untitled)
05:35:924 ELF\ElfReader.cpp:516 N[LOAD]: ELF loading completed successfully.
05:35:989 HLE\sceKernelModule.cpp:557 I[LOAD]: Module Freeride: 08cfff50 08c3f2c4 08c3f2dc
05:35:989 HLE\sceKernelModule.cpp:730 I[HLE]: Exporting ent 0 named Freeride, 2 funcs, 4 vars, resident 08c3f65c
05:35:990 HLE\sceKernelModule.cpp:985 I[LOAD]: Module entry: 08804124
05:36:211 root N[BOOT]: EmuScreen.cpp:105 Loading D:\4\EmuCR-ppsspp-20130109-x64\roms\Freak Out - Extreme Freeride (Europe) (En,Fr,De,Es,It) (v1.02).iso...
05:36:211 root I[HLE]: HLE\sceKernelThread.cpp:1943 276=sceKernelCreateThread(name=user_main, entry=08804224, prio=20, stacksize=262144)
05:36:211 root I[HLE]: HLE\sceKernelThread.cpp:1986 sceKernelStartThread(thread=276, argSize=33, argPtr=09fffe00)
05:36:211 root I[HLE]: HLE\sceKernelThread.cpp:2072 __KernelReturnFromThread: 0
05:36:212 user_main I[HLE]: HLE\sceKernelModule.cpp:1402 sceKernelGetModuleId()
05:36:212 user_main I[HLE]: HLE\sceKernelModule.cpp:1469 sceKernelQueryModuleInfo(274, 09fff600)
05:36:223 user_main I[HLE]: Util\BlockAllocator.cpp:359 -----------
05:36:223 user_main I[HLE]: Util\BlockAllocator.cpp:363 Block: 08800000 - 08804000 size 00004000 taken=0 tag=(untitled)
05:36:223 user_main I[HLE]: Util\BlockAllocator.cpp:363 Block: 08804000 - 08d0b700 size 00507700 taken=1 tag=ELF
05:36:223 user_main I[HLE]: Util\BlockAllocator.cpp:363 Block: 08d0b700 - 09fbfc00 size 012b4500 taken=0 tag=(untitled)
05:36:223 user_main I[HLE]: Util\BlockAllocator.cpp:363 Block: 09fbfc00 - 09fffc00 size 00040000 taken=1 tag=stack/user_main
05:36:223 user_main I[HLE]: Util\BlockAllocator.cpp:363 Block: 09fffc00 - 0a000000 size 00000400 taken=0 tag=stack/root
05:36:223 user_main E[HLE]: Util\BlockAllocator.cpp:131 Block Allocator failed to allocate 24113152 (016ff000) bytes of contiguous memory
05:36:223 user_main I[HLE]: Util\BlockAllocator.cpp:359 -----------
05:36:223 user_main I[HLE]: Util\BlockAllocator.cpp:363 Block: 08800000 - 08804000 size 00004000 taken=0 tag=(untitled)
05:36:223 user_main I[HLE]: Util\BlockAllocator.cpp:363 Block: 08804000 - 08d0b700 size 00507700 taken=1 tag=ELF
05:36:223 user_main I[HLE]: Util\BlockAllocator.cpp:363 Block: 08d0b700 - 09fbfc00 size 012b4500 taken=0 tag=(untitled)
05:36:223 user_main I[HLE]: Util\BlockAllocator.cpp:363 Block: 09fbfc00 - 09fffc00 size 00040000 taken=1 tag=stack/user_main
05:36:223 user_main I[HLE]: Util\BlockAllocator.cpp:363 Block: 09fffc00 - 0a000000 size 00000400 taken=0 tag=stack/root
05:36:223 user_main E[HLE]: HLE\sceKernelMemory.cpp:527 ARGH! sceKernelAllocPartitionMemory failed
05:36:223 user_main I[HLE]: Util\BlockAllocator.cpp:359 -----------
05:36:223 user_main I[HLE]: Util\BlockAllocator.cpp:363 Block: 08800000 - 08804000 size 00004000 taken=0 tag=(untitled)
05:36:223 user_main I[HLE]: Util\BlockAllocator.cpp:363 Block: 08804000 - 08d0b700 size 00507700 taken=1 tag=ELF
05:36:223 user_main I[HLE]: Util\BlockAllocator.cpp:363 Block: 08d0b700 - 09fbfc00 size 012b4500 taken=0 tag=(untitled)
05:36:223 user_main I[HLE]: Util\BlockAllocator.cpp:363 Block: 09fbfc00 - 09fffc00 size 00040000 taken=1 tag=stack/user_main
05:36:223 user_main I[HLE]: Util\BlockAllocator.cpp:363 Block: 09fffc00 - 0a000000 size 00000400 taken=0 tag=stack/root
05:36:223 user_main E[HLE]: Util\BlockAllocator.cpp:131 Block Allocator failed to allocate 24113152 (016ff000) bytes of contiguous memory
05:36:224 user_main I[HLE]: Util\BlockAllocator.cpp:359 -----------
05:36:224 user_main I[HLE]: Util\BlockAllocator.cpp:363 Block: 08800000 - 08804000 size 00004000 taken=0 tag=(untitled)
05:36:224 user_main I[HLE]: Util\BlockAllocator.cpp:363 Block: 08804000 - 08d0b700 size 00507700 taken=1 tag=ELF
05:36:224 user_main I[HLE]: Util\BlockAllocator.cpp:363 Block: 08d0b700 - 09fbfc00 size 012b4500 taken=0 tag=(untitled)
05:36:224 user_main I[HLE]: Util\BlockAllocator.cpp:363 Block: 09fbfc00 - 09fffc00 size 00040000 taken=1 tag=stack/user_main
05:36:224 user_main I[HLE]: Util\BlockAllocator.cpp:363 Block: 09fffc00 - 0a000000 size 00000400 taken=0 tag=stack/root
05:36:224 user_main E[HLE]: HLE\sceKernelMemory.cpp:527 ARGH! sceKernelAllocPartitionMemory failed
05:36:225 user_main I[HLE]: Util\BlockAllocator.cpp:359 -----------
05:36:225 user_main I[HLE]: Util\BlockAllocator.cpp:363 Block: 08800000 - 08804000 size 00004000 taken=0 tag=(untitled)
05:36:225 user_main I[HLE]: Util\BlockAllocator.cpp:363 Block: 08804000 - 08d0b700 size 00507700 taken=1 tag=ELF
05:36:225 user_main I[HLE]: Util\BlockAllocator.cpp:363 Block: 08d0b700 - 09fbfc00 size 012b4500 taken=0 tag=(untitled)
05:36:225 user_main I[HLE]: Util\BlockAllocator.cpp:363 Block: 09fbfc00 - 09fffc00 size 00040000 taken=1 tag=stack/user_main
05:36:225 user_main I[HLE]: Util\BlockAllocator.cpp:363 Block: 09fffc00 - 0a000000 size 00000400 taken=0 tag=stack/root
05:36:225 user_main E[HLE]: Util\BlockAllocator.cpp:131 Block Allocator failed to allocate 24113152 (016ff000) bytes of contiguous memory
05:36:226 user_main I[HLE]: Util\BlockAllocator.cpp:359 -----------
05:36:226 user_main I[HLE]: Util\BlockAllocator.cpp:363 Block: 08800000 - 08804000 size 00004000 taken=0 tag=(untitled)
05:36:226 user_main I[HLE]: Util\BlockAllocator.cpp:363 Block: 08804000 - 08d0b700 size 00507700 taken=1 tag=ELF
05:36:226 user_main I[HLE]: Util\BlockAllocator.cpp:363 Block: 08d0b700 - 09fbfc00 size 012b4500 taken=0 tag=(untitled)
05:36:226 user_main I[HLE]: Util\BlockAllocator.cpp:363 Block: 09fbfc00 - 09fffc00 size 00040000 taken=1 tag=stack/user_main
05:36:226 user_main I[HLE]: Util\BlockAllocator.cpp:363 Block: 09fffc00 - 0a000000 size 00000400 taken=0 tag=stack/root
05:36:226 user_main E[HLE]: HLE\sceKernelMemory.cpp:527 ARGH! sceKernelAllocPartitionMemory failed
05:36:227 user_main I[HLE]: Util\BlockAllocator.cpp:359 -----------
05:36:227 user_main I[HLE]: Util\BlockAllocator.cpp:363 Block: 08800000 - 08804000 size 00004000 taken=0 tag=(untitled)
05:36:227 user_main I[HLE]: Util\BlockAllocator.cpp:363 Block: 08804000 - 08d0b700 size 00507700 taken=1 tag=ELF
05:36:227 user_main I[HLE]: Util\BlockAllocator.cpp:363 Block: 08d0b700 - 09fbfc00 size 012b4500 taken=0 tag=(untitled)
05:36:227 user_main I[HLE]: Util\BlockAllocator.cpp:363 Block: 09fbfc00 - 09fffc00 size 00040000 taken=1 tag=stack/user_main
05:36:227 user_main I[HLE]: Util\BlockAllocator.cpp:363 Block: 09fffc00 - 0a000000 size 00000400 taken=0 tag=stack/root
05:36:227 user_main E[HLE]: Util\BlockAllocator.cpp:131 Block Allocator failed to allocate 24113152 (016ff000) bytes of contiguous memory
05:36:227 user_main I[HLE]: Util\BlockAllocator.cpp:359 -----------
05:36:227 user_main I[HLE]: Util\BlockAllocator.cpp:363 Block: 08800000 - 08804000 size 00004000 taken=0 tag=(untitled)
05:36:227 user_main I[HLE]: Util\BlockAllocator.cpp:363 Block: 08804000 - 08d0b700 size 00507700 taken=1 tag=ELF
05:36:227 user_main I[HLE]: Util\BlockAllocator.cpp:363 Block: 08d0b700 - 09fbfc00 size 012b4500 taken=0 tag=(untitled)
05:36:227 user_main I[HLE]: Util\BlockAllocator.cpp:363 Block: 09fbfc00 - 09fffc00 size 00040000 taken=1 tag=stack/user_main
05:36:227 user_main I[HLE]: Util\BlockAllocator.cpp:363 Block: 09fffc00 - 0a000000 size 00000400 taken=0 tag=stack/root
05:36:227 user_main E[HLE]: HLE\sceKernelMemory.cpp:527 ARGH!

[unknownbrackets]

Any change? Is it still failing to allocate memory?

-[Unknown]

[scraggles80]

no change
still failing to allocate memory

[unknownbrackets]

Does it work any better now with module stop handled better? Or with PSP Model set to 2000/3000?

An updated log would be useful.

-[Unknown]

[ppmeis]

Tested with latest build. Game boots fine, but on player select screen game goes slow 35/35 FPS and music background plays very rare. In game FPS is normal but I get a force close after first race. I have to test it a bit more but it seems to be caused by block transfer option.

P.S.: @unknownbrackets confirmed. With block transfer disable I manage to continue next level.

Screenshot when music and game overall is slow:

[unknownbrackets]

Has this improved at all with the latest git build, and with block transfers still enabled?

-[Unknown]

[ppmeis]

@unknownbrackets tested with latest build. Game does not crash anymore, but sound bug is still present.

[unknownbrackets]

It's still showing the unusual fps also, right?

-[Unknown]

[ppmeis]

@unknownbrackets yes. But even during game music is choppy.

[ppmeis]

Tested with latest build. Same status.

[ppmeis]

Tested with latest build. Sounds seems to get an improvement, but unusual fps are still there.

[unknownbrackets]

Hm. Now that the memory allocations aren't failing (it sounds like), I wonder if the FPS is because of sync operations or something.

Could you take a screenshot with the debug stats enabled when FPS is uneven?

Anyone have this and a PSP with CFW to compare the FPS it should be? Wondering if it ought to be 30 or ought to be 60.

-[Unknown]

[Panderner]

Even the game Hits 60 fps the audio still crackling.

[unknownbrackets]

The audio in this game sounds bad, but it's not an FPS problem.

It seems to convert the mono song to S32 at 08C1C884. Then, it mixes that with a zero S16 buffer at 08C11DA8 and writes to another S16 buffer. At 08C13FC8, it sends it to Output2. At a high level, that all seems right.

What goes awry (and causes the static) is that it processes the buffers in a strange order:

Convert to S32 08d8df88[096ef1d0] -> 08d8cf50 - 00000100 stereo
Mix S32 into S16 08d8cf50 + 08d06240 -> 08d07680 - 00000100 stereo
Convert to S32 08d8df88[096ef1d0] -> 08d8b750 - 00000100 stereo
Mix S32 into S16 08d8b750 + 08d06240 -> 08d06a80 - 00000100 stereo
00000200=sceAudioOutput2OutputBlocking(00008000, 08d06a80)
Convert to S32 08d8df88[096ef1d0] -> 08d8bf50 - 00000100 stereo
Mix S32 into S16 08d8bf50 + 08d06240 -> 08d06e80 - 00000100 stereo

Convert to S32 08d8df88[096ef1d0] -> 08d8c750 - 00000100 stereo
Mix S32 into S16 08d8c750 + 08d06240 -> 08d07280 - 00000100 stereo
00000200=sceAudioOutput2OutputBlocking(00008000, 08d07280)
Convert to S32 08d8df88[096ef1d0] -> 08d8cf50 - 00000100 stereo
Mix S32 into S16 08d8cf50 + 08d06240 -> 08d07680 - 00000100 stereo
...

It's really just playing a simple PCM S16 mono song, though it's doing left/right audio adjustments (I think to make it sound like the audio source is moving.) In the last part, it goes from 096ef1d0 -> 08d07280 ultimately, for 0x100 samples (0x400 total bytes, since it's stereo.)

Then it sends samples (from the same place, 08d07280) to sceAudioOutput2OutputBlocking, which immediately enqueues 0x200 samples (0x800 bytes.) That's more than it actually mixed.

Next up (after returning from the blocking function), it converts another 0x100 samples (0x400 bytes)... and puts them at 08d07680. 08d07680 is actually 08d07280 + 0x400. Clearly, it's trying to fill in the last 0x100 samples of the last send.

A quick hack to delay the last 0x100 samples and actually enqueue them from RAM on the next call of sceAudioOutput2OutputBlocking (which isn't correct but was quick) fixes it, so that confirms the problem. I'm not quite sure if this is a bug in the game, but it does seem likely the PSP firmware just reads directly off RAM... I think the blocking func only blocks if there's content already in the queue.

-[Unknown]

[ghost]

Can you still reproduce this issue?

[ppmeis]

Tested in latest Windows build. Same issues.

[hrydgard]

Why close? Did you get confirmation that it's fixed? @benderscruffy

[unknownbrackets]

The behavior I described above is definitely not changed:

A quick hack to delay the last 0x100 samples and actually enqueue them from RAM on the next call of sceAudioOutput2OutputBlocking (which isn't correct but was quick) fixes it, so that confirms the problem. I'm not quite sure if this is a bug in the game, but it does seem likely the PSP firmware just reads directly off RAM... I think the blocking func only blocks if there's content already in the queue.

We could maybe read off RAM more directly here, copying blocks using a timing event into the queue at a smaller rate. There'd probably be a perf impact, but it could be a compat option (I generally don't like those, but most games are well-behaved here, so it'd be a reasonable option in this case, I think.)

-[Unknown]

[ppmeis]

Tested in latest build. Same issues.