Editing Bootprocess

{{Wikify}}

== Initial Power on ==

As soon as power is applied to the console, a bootloader inside [[MediaCon]] loads the blob [[Flash-Main#0x4000|"C0000001"]] (MediaCon firmware) from the [[Flash-Main|main serial flash]]. The main serial flash is then re-initialized and MediaCon parses a number of configuration settings from the flash before finally loading the blob [[Flash-Main#0x144000|"C0020001"]] (wifi/bluetooth chipset firmware) from the flash .

Ethernet, WiFi and Bluetooth are initialized and the ps4 is now in it's standby state. [[MediaCon]] waits for a signal to boot the rest of the console.

== Booting the APU ==

The OrbisOS hash checks are made (known as LV2 CORE OS Hash) on the PlayStation 3. The PlayStation 4 runs a hash check on the FLASH file system to ensure all firmware files are not modified. Some have found that unlike PlayStation 3, the PlayStation 4 encrypts and decrypts the FLASH files with the public and private key pair.

== Console Bootlog ==
This is a log from a cold boot from a [[DUH-T1000xA series]] PS4 Testkit. This log has been taken from the logconsole [[Neighborhood for PlayStation 4]]. The reference to CUSA00016 is the game WatchDogs in the Bluray Drive. I've let it log until the login screen for your PS4 Profile. 

<syntaxhighlight lang="text" line enclose="div">
SCE CONFIDENTIAL
Copyright (C) 2014 Sony Computer Entertainment Inc.
All Rights Reserved.
Copyright (c) 1992-2012 The FreeBSD Project.
Copyright (c) 1979, 1980, 1983, 1986, 1988, 1989, 1991, 1992, 1993, 1994
	The Regents of the University of California. All rights reserved.
FreeBSD is a registered trademark of The FreeBSD Foundation.
r43234/release_branches/release_01.760 Aug 20 2014 07:45:23 amd64
mDBG: Kernel Build ID = 3e1463e658d6a84a
CPU: DG1000FGF84HT                                   (1594.00-MHz K8-class CPU)
  Origin = "AuthenticAMD"  Id = 0x710f13  Family = 16  Model = 11  Stepping = 3
  Features=0x178bfbff<FPU,VME,DE,PSE,TSC,MSR,PAE,MCE,CX8,APIC,SEP,MTRR,PGE,MCA,CMOV,PAT,PSE36,CLFLUSH,MMX,FXSR,SSE,SSE2,HTT>
  Features2=0x36d8220b<SSE3,PCLMULQDQ,MON,SSSE3,CX16,SSE4.1,SSE4.2,MOVBE,POPCNT,AESNI,XSAVE,AVX,F16C>
  AMD Features=0x2e500800<SYSCALL,NX,MMX+,FFXSR,Page1GB,RDTSCP,LM>
  AMD Features2=0x154837fb<LAHF,CMP,ExtAPIC,CR8,ABM,SSE4A,MAS,Prefetch,OSVW,IBS,SKINIT,WDT,NodeId,Topology,PerfCtrExtNB,<b26>,<b28>>
  TSC: P-state invariant, performance statistics
Event timer "LAPIC" quality 400
ACPI APIC Table: <SCEI   ORBIS   >
FreeBSD/SMP: Multiprocessor System Detected: 8 CPUs
FreeBSD/SMP: 1 package(s) x 8 core(s)
 cpu0 (BSP): APIC ID:  0
 cpu1 (AP): APIC ID:  1
 cpu2 (AP): APIC ID:  2
 cpu3 (AP): APIC ID:  3
 cpu4 (AP): APIC ID:  4
 cpu5 (AP): APIC ID:  5
 cpu6 (AP): APIC ID:  6
 cpu7 (AP): APIC ID:  7
MADT: Could not find APIC for SCI IRQ 9
Aux direct memory bitmap: 0x0000000000000ce0 bytes @ [0xffffff8049018000 - 0xffffff8049018ce0)
[REGMGR] LOAD REGMGR...
GEOM_SCHED: Modevent 0.
GEOM_SCHED: Initializing global data.
GEOM_SCHED: Loaded module 'bds' error 0.
GEOM_SCHED: Modevent 0.
GEOM_SCHED: Loaded module 'is' error 0.
acpi0: <SCEI ORBIS> on motherboard
cpu0: <ACPI CPU> on acpi0
cpu1: <ACPI CPU> on acpi0
cpu2: <ACPI CPU> on acpi0
cpu3: <ACPI CPU> on acpi0
cpu4: <ACPI CPU> on acpi0
cpu5: <ACPI CPU> on acpi0
cpu6: <ACPI CPU> on acpi0
cpu7: <ACPI CPU> on acpi0
pcib0: <ACPI Host-PCI bridge> port 0xcf8-0xcff on acpi0
pci0: <ACPI PCI bus> on pcib0
pci0: found aeolia_pcie
iommu0: <AMD IOMMU> at device 0.2 on pci0
gc0: <Starsha> port 0x6000-0x60ff mem 0xe0000000-0xe3ffffff,0xe4000000-0xe47fffff,0xe4800000-0xe483ffff at device 1.0 on pci0
LVP BX
GC SE0 Redundant CU: 0x200
GC SE1 Redundant CU: 0x200
** HALT MEC 0x50000000 ***
** UNHALT MEC 0x0 ***
SClkVid:0x3c SClkDpmVid:3 Dpm:3
hdac0: <GPU/DEHT Audio Controller> mem 0xe4840000-0xe4843fff at device 1.1 on pci0
apcie0: <Aeolia PCI Express glue> mem 0xd0200000-0xd03fffff at device 20.4 on pci0
apcie0: Misc Peripherals base:0xfffffe00d0200000, start:0xd0200000 end:0xd03fffff size:0x200000
apcie0: Chip revision: 00000300
apcie0: Chip ID0: 41b30130
apcie0: Chip ID1: 52024d44
icc0: <Aeolia ICC> at device 20.4 on pci0
hpet_pci0: <Aeolia High Precision Event Timer> at device 20.4 on pci0
Timecounter "HPET" frequency 10000000 Hz quality 950
Event timer "HPET" frequency 10000000 Hz quality 450
Event timer "HPET1" frequency 10000000 Hz quality 450
Event timer "HPET2" frequency 10000000 Hz quality 450
Event timer "HPET3" frequency 10000000 Hz quality 450
sflash0: <Aeolia Serial Flash I/F> at device 20.4 on pci0
Sflash:Macronix(1920c2)
iommu_add_device_table_entry: device_id:00a4 dev:20 func:4  sflash
rtc0: <Aeolia RTC> at device 20.4 on pci0
uart0: <Non-standard ns8250 class UART with FIFOs> at device 20.4 on pci0
uart0: uart_bus_attach
uart0: console (115200,n,8,1)
twsi0: <Aeolia TWSI> at device 20.4 on pci0
xhci0: <XHCI (ORBIS) USB 3.0 controller> mem 0xdc000000-0xdc1fffff at device 20.7 on pci0
xhci1: <XHCI (ORBIS) USB 3.0 controller> mem 0xdc200000-0xdc3fffff at device 20.7 on pci0
iommu_add_device_table_entry: device_id:00a7 dev:20 func:7  xhci
usbus1 on xhci1
xhci2: <XHCI (ORBIS) USB 3.0 controller> mem 0xdc400000-0xdc5fffff at device 20.7 on pci0
aeolia_acpi0: <Aeolia acpi> port 0x1000-0x10ff at device 20.0 on pci0
mskc0: <Aeolia GBE controller> mem 0xc4000000-0xc4003fff at device 20.1 on pci0
iommu_add_device_table_entry: device_id:00a1 dev:20 func:1  mskc
msk0: <Aeolia GBE Id:0xbd Rev:0x01> on mskc0
eth0: Ethernet address: 00:0e:00:00:00:00
miibus0: <MII bus> on msk0
e1000phy0: <Marvell 88E1510 Gigabit PHY> PHY 1 on miibus0
e1000phy0:  none, 10baseT, 10baseT-FDX, 100baseTX, 100baseTX-FDX, 1000baseT, 1000baseT-master, 1000baseT-FDX, 1000baseT-FDX-master, auto, auto-flowe1000phy0: 
ahci0: <Orbis Aeolia AHCI SATA controller> mem 0xc8000000-0xc8000fff,0xc8001000-0xc8001fff at device 20.2 on pci0
ahci0: r_mem start:0xc8001000 r_mem end:0xc8001fff r_mem size:0x1000
 ahci0: Aeolia SATA PHY init
[SATA] Apply ATE SRAM RTC Setting Version: 0x1
ahci0: PHY calibration result[align90]: 0x5e
ahci0: Aeolia SATA PHY ID : 0x2100
ahci0: AHCI v1.30 with 1 3Gbps ports, Port Multiplier supported with FBS
ahcich0: <AHCI channel> at channel 0 on ahci0
iommu_add_device_table_entry: device_id:00a2 dev:0 func:0  ahcich
sdhci0: <Aeolia SDHCI> mem 0xcc000000-0xcc000fff at device 20.3 on pci0
iommu_add_device_table_entry: device_id:00a3 dev:20 func:3  sdhci
sdhci0: 1 slot(s) allocated
dmac0: <Aeolia DMA controller> mem 0xd4000000-0xd4000fff at device 20.5 on pci0
dmac0: base:0xfffffe00d4000000, start:0xd4000000 end:0xd4000fff size:0x1000
dmac0: sbram_size: 0x10000000
iommu_add_device_table_entry: device_id:00a5 dev:20 func:5  dmac
dmac1: <Aeolia DMA controller> mem 0xd4001000-0xd4001fff at device 20.5 on pci0
dmac1: base:0xfffffe00d4001000, start:0xd4001000 end:0xd4001fff size:0x1000
dmac1: sbram_size: 0x10000000
spm0: <Aeolia Scratch Pad Memory> mem 0xd9000000-0xd903ffff at device 20.6 on pci0
spm0: scratch pad memory window start:0xd9000000 end:0xd903ffff size:0x40000
MAC address [0]: 00:00:00:00:00:00
MAC address [1]: ff:ff:ff:ff:ff:ff
sbram0: <Aeolia DDR3 memory> mem 0x80000000-0xbfffffff at device 20.6 on pci0
hwpstate0: <Cool`n'Quiet 2.0> on cpu0
gbase_register_interrupt_handler(52)
gbase_register_interrupt_handler(53)
dce: 15
diag load
_kapi_kctx_init: context 0xffffffff835d86d0 attached to ops 0
_sdma_hw_init(0): microcode loaded
_kapi_kctx_init: context 0xffffffff835d88c8 attached to ops 1
_sdma_hw_init(1): microcode loaded
acpDecAc3: <Codec DecAc3 built on Aug 20 2014 07:41:30>
acpEncAc3: <Codec EncAc3 built on Aug 20 2014 07:41:34>
acpDecTrhd: <Codec DecTrhd built on Aug 20 2014 07:41:33>
acpDecM2bc: <Codec DecM2bc built on Aug 20 2014 07:41:31>
acpEncDts: <Codec EncDts built on Aug 20 2014 07:41:35>
acpDecM4aacfng: <Codec DecM4aacfng built on Aug 20 2014 07:41:32>
acpDecCelp: <Codec DecCelp built on Aug 20 2014 07:41:31>
acpEncCelp: <Codec EncCelp built on Aug 20 2014 07:41:35>
ajm: <Audio CoProcessor Job Manager built on Aug 20 2014 07:44:08>
acpDecMp3: <Codec DecMp3 built on Aug 20 2014 07:41:33>
acpDecAt9: <Codec DecAt9 built on Aug 20 2014 07:41:30>
acpDecM4aac: <Codec DecM4aac built on Aug 20 2014 07:41:32>
acpEncM4Aac: <Codec EncM4Aac built on Aug 20 2014 07:41:36>
acpDecCelp8: <Codec DecCelp8 built on Aug 20 2014 07:41:30>
acpEncCelp8: <Codec EncCelp8 built on Aug 20 2014 07:41:34>
**[scanin event_handler:1515]MOD_LOAD
scanin_initialize:1544
scanin_make_dev:1591
can't re-use a leaf (v_free_reserved)!
can't re-use a leaf (v_free_target)!
can't re-use a leaf (v_free_min)!
can't re-use a leaf (v_inactive_target)!
can't re-use a leaf (v_cache_min)!
can't re-use a leaf (v_cache_max)!
can't re-use a leaf (v_pageout_free_min)!
can't re-use a leaf (v_free_reserved)!
can't re-use a leaf (v_free_target)!
can't re-use a leaf (v_free_min)!
can't re-use a leaf (v_inactive_target)!
can't re-use a leaf (v_cache_min)!
can't re-use a leaf (v_cache_max)!
can't re-use a leaf (v_pageout_free_min)!
UVFAT_Initialize: exit
fuse-freebsd: version 0.4.4, FUSE ABI 7.8
Timecounters tick every 1.000 msec
Session ID: fe632ac3fc967332a63f52a29606725c
secure kernel build: Aug 20 201hdac0: #0: GPU
4 07:26:47 (r4464:release_branches/release_01.760)
xtsQ 4, inflateQ 4, hmacshaQ 4, commonQ 4
pcm0: <GPU PCM #0 HDMI> at cad 0 nid 1 on hdac0
pcm1: <GPU PCM #1 Analog> at cad 0 nid 1 on hdac0
pcm2: <GPU PCM #2 Digital> at cad 0 nid 1 on hdac0
usbus1: 5.0Gbps Super Speed USB v3.0
ahcich0: r_mem start:0xc8001000 r_mem end:0xc8001fff r_mem size:0x1000
 ahcich0: Aeolia SATA PHY init
ugen1.1: <0x104d> at usbus1
uhub1: <0x104d XHCI root HUB, class 9/0, rev 3.00/1.00, addr 1> on usbus1
[SATA] Apply ATE SRAM RTC Setting Version: 0x1
ahcich0: PHY calibration result[align90]: 0x5b
ahcich0: Aeolia SATA PHY ID : 0x2100
GEOM_SCHED: Loading: mp = 0xffffffff832aa4b0, g_sched_class = 0xffffffff832aa4b0.
g_lvd_init 248 : Layered vnode device is initialized.
g_lvd_init 250 : lvd is built at 07:41:54 Aug 20 2014
icc_power_set_boot_request_notify_mode: set boot request notify=1
icc_button_init: enabled power button notification
icc_button_init: enabled eject button notification
icc_button_init: enabled reset button notification
pass0 at ahcich0 bus 0 scbus1 target 0 lun 0
icc_thermal_set_notify: enabled thermal notification
icc nvs device registered
icc thermal info device registered
icc fan info device registered
icc configuration info device registered
icc indicator device registered
icc device_power info device registered
pass0: <SONY PS-SYSTEM   402R 0063> Removable CD-ROM SCSI-0 device 
pass0: 150.000MB/s transfers (SATA 1.x, UDMA4, ATAPI 12bytes, PIO 8192bytes)
[REGMGR] READY NVS EVENT...
[REGMGR] NVS information [00175020(2)] ent: 22 (364) <0/0>.
[REGMGR] Product code [UC2 (0002)] [ASS (TestKit)] (0182).
[REGMGR] Registry initialize count  = 342 (1024)
[REGMGR] Registry initialize binary = 85 (1280)
[REGMGR] Registry cache binary      = 54420 (204800)
[REGMGR] Registry number of updated = 2
[REGMGR] Registry number of written = 4
[REGMGR] Registry EAP output count  = 225 / bin = 6700
[REGMGR] Registry version (NVS) = 00175020 : 00175020
[REGMGR](0.044257 sec) Registry NVS Initialize...
[REGMGR](0.323018 sec) Registry NVS Initialize...
uhub1: 2 ports with 2 removable, self powered
DVI Mode
*** CEC FT [Normal:0x0] ***
Set CEC FeatureTable [Normal]
HDCP mode changed [HDCP Enable] 
HDMI kernel module has been available
mmc0: <MMC/SD bus> on sdhci0
sbram0: base:0xfffffe0080000000, start:0x80000000 end:0xbfffffff size:0x40000000
sbram0: addr:0xfffffe0080000000
sbram0: size:0x10000000
trsw0 on sdio0
bt0 on sdio0
trs0 on sdio0
sdio0: <SDIO Device> at mmc0
g_crypt_deferred_init
g_crypt_deferred_init: calling CCP
g_crypt_deferred_init done
SMP: AP CPU #6 Launched!
SMP: AP CPU #2 Launched!
SMP: AP CPU #5 Launched!
SMP: AP CPU #3 Launched!
SMP: AP CPU #7 Launched!
SMP: AP CPU #1 Launched!
SMP: AP CPU #4 Launched!
init_safe_mode: 0
trsw0: FW version : 14.130.16.p37
wlan0: Ethernet address: 00:00:00:00:00:00
wlan1: Ethernet address: 00:00:00:00:00:00
ugen1.2: <SCEI> at usbus1
umass0: <SCEI USB-SATA Bridge, class 0/0, rev 3.00/0.01, addr 1> on usbus1
umass0:  SCSI over Bulk-Only; quirks = 0x0000
umass0:0:0:-1: Attached to scbus0
Trying to mount root from msdosfs:md0 []...
init program: /mini-syscore.elf
<118>[SceSysCore mini] launched
<118>*** start manu_cert ***
<118>Special Wake is invalid
usbus0 on xhci0
usbus0: 5.0Gbps Super Speed USB v3.0
da0 at umass-sim0 bus 0 scbus0 target 0 lun 0
da0: <SCEI USB-SATA Bridge 0001> Fixed Direct Access SCSI-6 device 
da0: 400.000MB/s transfers
da0: 476940MB (976773168 512 byte sectors: 255H 63S/T 60801C)
ugen0.1: <0x104d> at usbus0
<118>[SceSysAvControl] launched
uhub0: <0x104d XHCI root HUB, class 9/0, rev 3.00/1.00, addr 1> on usbus0
sysctl_kern_init_safe_mode: current_mode: 0
TSC freq = 1593844360
Timecounter "TSC-low" frequency 12451909 Hz quality 1000
sysctl_kern_init_safe_mode: current_mode: 0
<118>set CEC OFF
usbus2 on xhci2
usbus2: 5.0Gbps Super Speed USB v3.0
<118>* [AvSetting core:1525] hdmiConnected = 0
<118>* [AvSetting core:397] hdmi event: disconnected(0)
<118>** set_mode **
<118> video: port:0 1080P_5994 RGB444 full CERGB 24bpp 16:9 nodata
<118> audio: port:HDMI src:I2S 48k 2.0 24bit fmt:LPCM LPCM null
ugen2.1: <0x104d> at usbus2
uhub2: <0x104d XHCI root HUB, class 9/0, rev 3.00/1.00, addr 1> on usbus2
<118>*** Hdmi Init(kern)  : 0 ***
uhub0: 2 ports with 2 removable, self powered
uhub2: 2 ports with 2 removable, self powered
<118>[SceSysCore mini] fstype=msdosfs
ugen0.2: <GenesysLogic> at usbus0
uhub3: <GenesysLogic USB2.0 Hub, class 9/0, rev 2.10/46.12, addr 1> on usbus0
<118>*** Hdmi Setup(kern) : 0 ***
<118>[SceSysCore mini] nmount /dev/da0x4.crypt to /system OK
<118>[SceSysCore mini] nmount /dev/da0x5.crypt to /system_ex OK
cd0 at ahcich0 bus 0 scbus1 target 0 lun 0
cd0: <SONY PS-SYSTEM   402R 0063> Removable CD-ROM SCSI-0 device 
cd0: 150.000MB/s transfers (SATA 1.x, UDMA4, ATAPI 12bytes, uhub3: 4 ports with 4 removable, self powered
PIO 8192bytes)
cd0: cd present [12218912 x 2048 byte records]
GL3520-21: 4612
<118>[SceSysCore mini] nmount_ufs /dev/da0x9.crypt to /system_data OK
<118>[SceSysCore mini] nmount_ufs /dev/da0x13.crypt to /user OK
<118>[SceSysCore mini] nmount_ufs /dev/da0x14.crypt to /eap_user OK
<118>[SceSysCore mini] nmount /dev/da0x12.crypt to /update OK
ugen0.3: <GenesysLogic> at usbus0
uhub4: <GenesysLogic> on usbus0
[REGMGR] READY HDD EVENT...
[REGMGR] Registry version (HDD) = 00175020 : 00175020
[REGMGR] Registry number of updated = 2
[REGMGR] HDD information [00175020(2)] ent: 1750 (+ 9).
[REGMGR](0.029156 sec) Registry HDD Initialize...
[REGMGR](3.977080 sec) Registry HDD Initialize...
<118>[SceSysCore mini] nmount /dev/da0x0.crypt to /preinst OK
<118>[SceSysCore mini] nmount /dev/da0x1.crypt to /preinst2 OK
<118>[SceSysCore mini] Entering normal mode...
<118>[SceSysCore mini] HDD slow-mode is disabled
<118>verify_header: Header size 523776 wp 550
<118>[SceSysCore] launched
5.491534,[1] gsched_is(1897):                    g_is_init,!	init,	 target=,'da0', preset=0
GEOM_SCHED: Device da0.sched. created.
<118>[SceSysCore] enabled GEOM I/O scheduler 'is' for da0
uhub4: 4 ports with 4 removable, self powered
HID : Safe Mode 0
HID : Controller USB Connection 0
ugen0.4: <Sony Computer Entertainment> at usbus0
usb_hid0: <Sony Computer Entertainment Wireless Controller, class 0/0, rev 2.00/1.00, addr 3> on usbus0
pfs_sbram_init(81)	***WRN*** pfs_sbram_init():Rel Mode.
<118>[SceSysCore] nmount /data to /user/data OK
<118>mDBG: Lastlog cleared.
<118>[MbusBaseEnv]alloc_count = 297
<118>[MbusBaseEnv]free_count  = 0
<118>[MbusBaseEnv]alloc_size  = 731672 bytes (715 KiB)
<118>[Syscore App]  ExpandCpuSetMode : enable
<118>[Syscore App] srand seed: 0x5430d8af
<118>[SceSysCore] spawn /system/sys/orbis_audiod.elf OK
<118>[SceSysCore] spawn /system/sys/GnmCompositor.elf OK
 +++ num clients 1
<118>[SceShellCore] Start
<118>[SceShellCore] Version Info
<118>[SceShellCore]  release: 0x01760001
<118>[SceShellCore]  build: testkit
<118>[SceShellCore]  security-repository-path: release_branches/release_01.760
<118>[SceShellCore]  security-revision: 4464
<118>[SceShellCore]  sys-repository-path: release_branches/release_01.760
<118>[SceShellCore]  sys-revision: 43234
<118>[SceShellCore]  sdk-internal-build-number: 68351
<118>[SceShellCore]  middleware-repository-path: release_branches/release_01.760
<118>[SceShellCore]  middleware-revision: 8267
<118>[SceShellCore]  middleware-build-number: 40682
<118>[SceShellCore]  vsh-repository-path: release_branches/release_01.760
<118>[SceShellCore]  vsh-revision: 67936
<118>[SceShellCore]  vsh-build-number: 3849### AEC initializing
Shared System size : 0x400000
Shared System Addr : 0xff8000000
Shared Video size  : 0x1200000
Shared Video Addr  : 0xff0000000
25
<118>[SceShellCore] ModuleLoader 0 msec
<118>** set_mode_a **
<118> video: port:0 1080P_5994 RGB444 full CERGB 24bpp 16:9 nodata
<118> audio: port:HDMI src:I2S 48k 2.0 24bit fmt:LPCM LPCM null
<118>verify_header: Header size 523776 wp 586
<118>*** Hdmi Audio Setup(kern) : 0 ***
<118>[SceShellCore] ShellCoreMain 425 msec
<118>[SceShellCore] PafJob 0 msec
<118>[SceShellCore] ModuleLoaderSync 0 msec
<118>open: /system_data/priv/home/new_user_group.dat: 0x80af5022
<118>[SceShellCore] UserService 4 msec
<118>[SceShellCore] ContentManager 122 msec
<118>[SceShellCore] AppDB 7 msec
<118>[SceShellCore] ModuleLoaderSync 0 msec
<118>[Syscore App] Add event : pid=0x24
<118>[SceShellCore] AppMgr 3 msec
<118>[SceShellCore] LnC 2 msec
<118>[SceSystemStateMgr] Power-Up Cause Report from EMC
<118>[SceSystemStateMgr]   powerup_cause POWER_BUTTON (00000100)
<118>[SceSystemStateMgr]   first_boot 02
<118>[SceSystemStateMgr]   last_shutdown_cause 00
<118>[SceSystemStateMgr]   depth 02
<118>[SceSystemStateMgr]   special_wake 00
<118>[SceSystemStateMgr]   magic_code 00
<118>[SceSystemStateMgr] State Change: WORKING
icc_power_set_boot_request_notify_mode: set boot request notify=0
<118>[SceShellCore] SystemStateMgr 48 msec
<118>WARNING AutoMounter(int32_t AutoMount::EventManager::registerCallback(uint32_t, sceAutoMounter::CallbackFunc, ScePthreadAttr *, const char *, void *, size_t, bool) 193):
<118>	threadName(SceProcessStarterDiscInsertionStart) is too long and will be truncated.
<118>WARNING AutoMounter(int32_t AutoMount::EventManager::registerCallback(uint32_t, sceAutoMounter::CallbackFunc, ScePthreadAttr *, const char *, void *, size_t, bool) 193):
<118>	threadName(SceProcessStarterDiscInsertionEnd) is too long and will be truncated.
<118>[SceShellCore] ProcessStarter 17 msec
<118>[SceShellCore] AppInstaller 0 msec
<118>[SceShellCore] ModuleLoaderSync 0 msec
<118>[SceShellCore] AppMessaging 0 msec
<118>[SceShellCore] ShellCoreUtil 0 msec
<118>[SceShellCore] SystemService 2 msec
<118>[SceShellCore] ModuleLoaderSync 0 msec
<118>[SceShellCore] Net 3 msec
<118>[ScePsnCore] _scePsnCoreInit() sceNpArchInit() finished
<118>[ScePsnCore] _scePsnCoreInit() sceNpManagerVshInit() finished
<118>[ScePsnCore] _scePsnCoreInit() sceNetHttpXmlInit() finished
<118>[ScePsnCore] _scePsnCoreInit() sceNpPushCoreInit() finished
<118>[ScePsnCore] _scePsnCoreInit() sceNpPushServiceInit() finished
<118>[ScePsnCore] _scePsnCoreInit() sceNpIpcServerInit() finished
<118>[ScePsnCore] _scePsnCoreInit() sceNpServiceServerInit() finished
<118>[ScePsnCore] _scePsnCoreInit() sceNpTrophyServiceInit() finished
<118>[ScePsnCore] _scePsnCoreInit() sceNpServiceServerStart() finished
<118>[ScePsnCore] _scePsnCoreInit() sceNpManagerVshInitSyncUsers() finished
<118>[ScePsnCore] _scePsnCoreInit() sceNpMutexInit(SCE_NP_MANAGER_PRX_MUTEX_NAME)
<118>[ScePsnCore] _scePsnCoreInit() sceNpPresenceServiceInitialize() finished
<118>[ScePsnCore] _scePsnCoreInit() sceNpInGameMessageIntInitialize() finished
<118>[SystemLogger][01:35:44:635][Thread 0x00018799][TRACE][ERROR][ALWAYS]setting_value_manager.cpp(33) IsDebugOutput(): sceRegMgrGetInt failed[0x800d0203][-2146631165]
<118>[ScePsnCore] _scePsnCoreInit() sceNpSignalingIpcServerInit() finished
<118>[ScePsnCore] _scePsnCoreInit() sceNpManagerStartVsh() finished
<118>[ScePsnCore] _scePsnCoreInit() _setNpTitleId() finished
<118>[ScePsnCore] _scePsnCoreInit() sceNpTrophyVshInit() finished
<118>[ScePsnCore] _scePsnCoreInit() sceNpManagerVshPlusInit() finished
<118>[ScePsnCore] _scePsnCoreInit() sceNpPresenceInitialize() finished
<118>[ScePsnCore] _scePsnCoreInit() NpServiceBaseUrlVsh::Initialize() finished
<118>[ScePsnCore] _scePsnCoreInit() sceNpPushCoreStart() finished
<118>[ScePsnCore] _scePsnCoreInit() sceNpRifManagerServiceInit() finished
<118>[ScePsnCore] _scePsnCoreInit() sceNpSnsVshInit() finished
<118>[ScePsnCore] _scePsnCoreInit() sceNpSnsVshInitIpcServer() finished
<118>[ScePsnCore] _scePsnCoreInit() sceNpUtilityInit() finished
<118>[SceShellCore] PsnCore 107 msec
<118>[SceShellCore] NetService 0 msec
<118>[SceShellCore] Json 0 msec
<118>BD Copy : 0x0
<118>[BGFT] last checked (2014-10-05T01:35:44)
<118>[BGFT] interval (2014-10-05T04:57:47)
<118>[SceBgftServer] ServiceServer Start
<118>[SceShellCore] BGFT 77 msec
<118>[SceShellCore] Change run-level 0 -> 70
<118>[SceShellCore] Daemons 0 msec
<118>[SceShellCore] CompanionAppProxyUtil 0 msec
<118>[SceShellCore] UpdateService 0 msec
<118>[SceShellCore] SaveDataServer 29 msec
<118>[SceShellCore] Change run-level 70 -> 80
<118>[SceShellCore] START Shell UI
<118>[SceLncService] launchApp() titleId = {NPXS20001}
<118>[SceLncService] Launch NPXS20001, appType = {SCE_LNC_APP_TYPE_SHELL_UI}  []
<118>[SceLncService] Num. of logged-in users is 0
<118>[SceSystemStateMgr] Power Mode Change: NAVIGATION
<118>[SceSystemStateMgr] HLT #CU ACLK DCLK ECLK LCLK SCLK SAMCLK VCLK DispCLK DPM VID
<118>[SceSystemStateMgr]   1   8  800  609  609  800  711    711  711     673   3 003c0040
<118>[SceSysCore] ip_conflict_cb: 2
<118>[SceSysCore] ip_conflict_cb: 0 0
[SceShellUI] Loading PSM
[SceShellUI] Loading libSceWeb
<118>[SceLncService] isBigAppOrMiniApp = {0}, app_param.{enableSuspendOnSpecialVideOutSettingInBgState, prohibitUsingSpecialVideOutSetting, enableS3d} = {0, 0, 0} (00)
<118>[Syscore App] createApp NPXS20001
<118>[Syscore App] processSpawn(pid, 0xb0c0101, 0x10101020, appParam, processParam, 1, 1, 1, param, debug, 0)
<118>[Syscore App] appParam: appType = 0x5, rootPath = /mnt/sandbox/NPXS20001_0000, titleId = NPXS20001
<118>[Syscore App] processParam: elfPath = /app0/eboot.bin, fullPath = /system_ex/app/NPXS20001/eboot.bin
<118>[Syscore App] attributeExe= 0
<118>[Syscore App] Add event : pid=0x2a
<118>[AppMgr Trace]: New Process, pid=0x2a, created.
<118>[AppMgr Trace]: New App, appId=0xb0c0101, created
<118>[SceShellCore] ShellUI 201 msec
<118>[SceShellCore] UserServiceServer 0 msec
<118>waiting for SceUserService..[SceShellCore] UserServiceClient 63 msec
<118>[SceShellCore] DeviceDiscovery 0 msec
<118>[SceShellCore] ScreenShotServer 0 msec
<118>MSG AutoMounter(int AutoMount::Init() 148):
<118>	trc_notify=0.
<118>[SceShellCore] AutoMount 1 msec
<118>[SceShellCore] MediaEventListener 0 msec
<118>[SceShellCore] AppInstaller 0 msec
<118>[SceShellCore] AppContent 0 msec
<118>pass0: <SONY PS-SYSTEM   402R 0063> Removable CD-ROM SCSI-0 device 
<118>[SceShellCore] GroupMessaging 10 msec
<118>[SystemLogger][01:35:45:072][Thread 0x0001872d][INFO][TRACE][ALWAYS][SYSTEM LOGGER INITIALIZE ASYNC BEGIN]
<118>[SystemLogger][01:35:45:073][Thread 0x000187d4][INFO][TRACE][ALWAYS][SystemLogger][01:35:45:073][Thread 0x0001872d][INFO][TRACE][ALWAYS][SYSTEM LOGGER INITIALIZE ASYNC END  ]
<118>[SceShellCore] SystemLogger 1 msec
<118>[SYSTEM LOGGER INITIALIZE BEGIN][Heap]sanity OK, free 2546464 (61%), in-use 1647840 (39%), peak 1648192 (39%), when 9 [sec]
<118>[SystemLogger][01:35:45:073][Thread 0x000187d4][INFO][TRACE][ALWAYS]BUILD TYPE TestKit
<118>[SceShellCore] DbRecovery 0 msec
<118>[DecidServer] DECID_SERVER_ASSIST_MODE
<118>[DecidServer] DecidServerReleaseCheckMode=[2]
<118>[SceShellCore] DecidServer 0 msec
<118>[SceShellCore] AutoMounterIpcServer 0 msec
<118>[DecidServer] waiting for connecting client...
<118>media type:PS4 BD-ROM
<118>[SceAutoMount] libcam: MaximizeSpeed
<118>[SceAutoMount] libcam: set speed [speed:65535 kbyte/sec][rotation:0]
<118>[SceShellCore] ShareServerPost::Init 15 msec
<118>[SceShellCore] RTC 0 msec
<118>[SceShellCore] SystemStateMgr::PostInit 0 msec
<118>[SceShellCore] ShareServerPost::Start 0 msec
<118>[SceShellCore] CheckOsEventLog 0 msec
<118>[SceShellCore] Completed initialization
<118>[SceLncUtil] blockAppSuspend: name={SceVshLog}, appId={0x0b0c0000}, refCount={1}
<118>
<118>*** network ready. myaddr: 192.168.1.1 ***
<118>[SceShellCore] NpManager acquires /eap_user (refCount 1)
SERIAL_PRINT_TIME_TICK : 12063 msec -- main : start
<118>[SceShellUI] Start
<118>[SceShellUI] Run
<118>[SceShellUI] initializeSystem
SERIAL_PRINT_TIME_TICK : 12067 msec -- initializeSystem : start
SERIAL_PRINT_TIME_TICK : 12080 msec -- loadModules : start
SERIAL_PRINT_TIME_TICK : 12174 msec (total 94 msec) -- loadModules : end
<118>[SceLncUtil] unblockAppSuspend: name={SceVshLog}, appId={0x0b0c0000}, refCount={0}
<118>[SceShellCore] NpManager releases /eap_user (refCount 0)
<118>[SystemLogger][01:35:45:351][Thread 0x000187c7][TRACE][ERROR][ALWAYS]setting_value_manager.cpp(33) IsDebugOutput(): sceRegMgrGetInt failed[0x800d0203][-2146631165]
<118>[SystemLogger][01:35:45:425][Thread 0x000187d4][INFO][TRACE][ALWAYS][SYSTEM LOGGER INITIALIZE END  ][Heap]sanity OK, free 2311904 (55%), in-use 1882400 (45%), peak 2035776 (49%), when 10 [sec]
<118>[REGIO] (202): HDD SAVE (5)...[0]
<118>[SceShellCore] NpManager acquires /eap_user (refCount 1)
<118>MSG: Setup AbstractStorage.
<118>[GetInstance]WARNING:Undefined Memory Allocator
<118>[SceShellCore] NpManager releases /eap_user (refCount 0)
<118>MSG NotificationDb(int sceNotificationDbInit::notificationDbInitialize() 1554):
<118>	userId(0x10000000) is already registered. we will create tables for them.
SERIAL_PRINT_TIME_TICK : 12503 msec (total 436 msec) -- initializeSystem : end
<118>[SceShellUI] initializeFramework
SERIAL_PRINT_TIME_TICK : 12510 msec -- initializeFramework : start
<118>Loading PSM AOT PRX:/4VrE1TCMrg/common/lib/libScePsm_aot.sprx
<118>Loading UI2 AOT PRX:/4VrE1TCMrg/common/lib/libSceVshCommon_aot.sprx
<118>Loading VSH AOT PRX:/app0/libSceVsh_aot.sprx
<118>VM: sockets[VM_SOCKET] = 73
<118>VM: sockets[COMP_SOCKET] = 72
<118>VM: before starting compiler
<118>SystemService prx detected, using sceSystemServiceAddLocalProcess to spawn compiler
<118>[Syscore App] calling add process
<118>[Syscore App] processSpawn(pid, 0xb0c0101, 0x10101031, appParam, processParam, 0, 0, 0, param, debug, 0)
<118>[Syscore App] appParam: appType = 0x5, rootPath = /mnt/sandbox/NPXS20001_0000, titleId = NPXS20001
<118>[Syscore App] processParam: elfPath = /4VrE1TCMrg/common/lib/MonoCompiler.elf, fullPath = /system/common/lib/MonoCompiler.elf
<118>[Syscore App] attributeExe= 0
<118>[Syscore App] Add event : pid=0x2b
<118>[AppMgr Trace]: New Process, pid=0x2b, created.
<118>  + compiler_local_pid = 10101031
<118>[PSM] PsmFramework::Initialize
<118>PSM:24487
<118>MonoVM:f19b9d6104343a6ee9f3ae718ccda33692e511a1
<118>PSS Platform:a730c133a7d00bca756c3b48aaff86556c41b006
<118>Piglet:3555fd9238638fe168f3ddca765bfe5aa5e119f7
<118>BootParam :1   
<118>[PSM] Loading Json
<118>[PSM] LoadModulesInBG 0 msec
<118>[PSM] Loading SysCore
Accept InitRequest from PID 42
Type   : 0
Size   : 0x1600000
Addr   : 0x1000000000
Type   : 3
Size   : 0x8400000
Addr   : 0x1080000000
<118>[PSM] Loading libSceDipsw
<118>[PSM] Loading Piglet
<118>[PSM] Loading AudioOut
<118>[PSM] Loading Audiodec
<118>[Sce GnmCompositor] Last modified: Thu Apr 10 22:43:02 2014
<118>[PSM] Loading WebKit
<118>Size   : 0x1600000
<118>Addr   : 0x1000000000
<118>Size   : 0x8400000
<118>Addr   : 0x1080000000
<118>PigletAllocatorInitialize system(addr=1000000000, size=23068672) video=(addr=1080000000, size=138412032)
<118>PigletAllocatorTerminate
<118>[PSM] scePssGraphicsInitialize() 132 msec. elapsed
<118>mount ---
<118>MONO_LOG_LEVEL=error
<118>vm: jit_area 900000000, fd 83
<118>vm: outgoing_area 909000000, fd 84
<118>vm: incoming_area 908000000, fd 85
<118>compiler was started with SystemService.prx, closing socket 72
<118>Failed to create filesystem from /hostapp/dll
<118>Load DLL /4VrE1TCMrg/common/lib/mscorlib.dll
<118>[SceShellCore] Libc Heap Status: free 2295808 (55%), in-use 1898496, trend +10112.7 KB/min, peak 2035776, when 11 [sec]
<118>[PSM] Allocated 268435456 bytes for Resource Heap
<118>[SceLncService] No heart beat of Shell UI has been observed for 1012 msec.
<118>Load DLL /4VrE1TCMrg/common/lib/Sce.PlayStation.Core.dll
<118>Load DLL /4VrE1TCMrg/common/lib/System.dll
<118>[PSM] PsmFramework::Initailize() 452 msec. elapsed
<118>W:\Build\J00739822\vsh\cdlg\np_commerce_dialog\server\np_commerce_server_wrapper.cpp(309) initializeCSharp:
<118>MSG AbstractStorageWrapper(int sce::vsh::orbis::abstract_storage::InitializeCSharp() 223):
<118>	Register Table for ContentManager's PInvokes
<118>MSG ContentManagerWrapper(int sce::vsh::orbis::content_manager::InitializeCSharp() 427):
<118>	Register Table for ContentManager's PInvokes
SERIAL_PRINT_TIME_TICK : 13418 msec (total 908 msec) -- initializeFramework : end
<118>[SceShellUI] initializeSystemAfterPsm
SERIAL_PRINT_TIME_TICK : 13459 msec -- initializeSystemAfterPsm : start
<118>#LOGIN MGR# sceMbusEventCreate() success (handle = 2).
<118>@ deviceMonitor2StartPolling:L2652
<118>@ connectDeviceByFunction:L1258
* [mbus:378] owner-changed from unknown device
<118>@ connectDeviceByFunction:L1258
* [mbus:378] owner-changed from unknown device
<118>@ connectDeviceByFunction:L1258
* [mbus:378] owner-changed from unknown device
<118>[AppDb][Server] Rcv Event 6
<118>[SceShellUI] initializeFrameworkDependentModules
SERIAL_PRINT_TIME_TICK : 13494 msec -- initializeFrameworkDependentModules : start
<118>@ connectDeviceByFunction:L1258
* [mbus:378] owner-changed from unknown device
SERIAL_PRINT_TIME_TICK : 13520 msec (total 26 msec) -- initializeFrameworkDependentModules : end
<118>ScePsP: Open Pad [0x000000000001030f, 16, 12]: ret=0x03010300
<118>ScePsP: ConnectedDeviceStatus: count=1
<118>  [c][DeviceId          ][UserId    ][Model     ]
<118>  [ ][0xffffffffffffffff][0xffffffff][none      ]
<118>  [ ][0xffffffffffffffff][0xffffffff][none      ]
<118>  [ ][0xffffffffffffffff][0xffffffff][none      ]
<118>  [ ][0xffffffffffffffff][0xffffffff][none      ]
<118>[SceShellUI] runFramework
<118>Load DLL /app0/psm/Application/app.exe
<118>Load DLL /4VrE1TCMrg/common/lib/System.Json.dll
<118>Load DLL /4VrE1TCMrg/common/lib/System.Runtime.Serialization.dll
<118>Load DLL /4VrE1TCMrg/common/lib/System.Xml.dll
<118>Load DLL /4VrE1TCMrg/common/lib/System.Core.dll
<118>Load DLL /4VrE1TCMrg/common/lib/System.ServiceModel.Web.dll
<118>Load DLL /4VrE1TCMrg/common/lib/System.ServiceModel.dll
<118>Load DLL /app0/psm/Application/Sce.Vsh.Lx.dll
<118>Load DLL /4VrE1TCMrg/common/lib/Sce.PlayStation.HighLevel.UI2.dll
<118>Load DLL /4VrE1TCMrg/common/lib/Sce.PlayStation.Orbis.dll
<118>Load DLL /app0/psm/Application/Sce.Vsh.Accessor.Db.dll
<118>Load DLL /4VrE1TCMrg/common/lib/Sce.Vsh.SQLite.dll
<118>Load DLL /app0/psm/Application/Sce.Vsh.DbRecoveryUtilityWrapper.dll
<118>Load DLL /app0/psm/Application/Sce.Vsh.Accessor.Db.Notify.dll
<118>Load DLL /4VrE1TCMrg/common/lib/Sce.Vsh.AppDbWrapper.dll
<118>Load DLL /4VrE1TCMrg/common/lib/Sce.Vsh.Orbis.AbstractStorage.dll
<118>Load DLL /4VrE1TCMrg/common/lib/Sce.Vsh.UserServiceWrapper.dll
<118>Load DLL /app0/psm/Application/Sce.Vsh.MimeType.dll
<118>Load DLL /app0/psm/Application/Sce.Vsh.Accessor.dll
<118>Load DLL /4VrE1TCMrg/common/lib/Sce.Vsh.KernelSysWrapper.dll
<118>Load DLL /app0/psm/Application/Sce.Vsh.SystemLoggerWrapper.dll
<118>Load DLL /4VrE1TCMrg/common/lib/Sce.Vsh.Registry.dll
<118>Load DLL /4VrE1TCMrg/common/lib/Sce.Vsh.Gls.NativeCall.dll
<118>Load DLL /4VrE1TCMrg/common/lib/Sce.Vsh.dll
<118>Load DLL /4VrE1TCMrg/common/lib/Sce.Vsh.UpdateServiceWrapper.dll
<118>Load DLL /4VrE1TCMrg/common/lib/Sce.Vsh.Orbis.Bgft.dll
<118>Load DLL /app0/psm/Application/Sce.Vsh.JsExtension.dll
<118>Load DLL /app0/psm/Application/Sce.Vsh.VideoServiceWrapper.dll
<118>Load DLL /app0/psm/Application/Sce.Vsh.MusicCoreServerJsExWrapper.dll
<118>Load DLL /4VrE1TCMrg/common/lib/Sce.Vsh.Np.Manager.dll
<118>Load DLL /4VrE1TCMrg/common/lib/Sce.Vsh.AppInstUtilWrapper.dll
<118>Load DLL /app0/psm/Application/Sce.Vsh.Np.RifManager.dll
<118>Load DLL /app0/psm/Application/Sce.Vsh.SysUtilWrapper.dll
<118>Load DLL /app0/psm/Application/Sce.Vsh.ShellCoreUtilWrapper.dll
<118>Load DLL /4VrE1TCMrg/common/lib/Sce.Vsh.MarlinDownloaderWrapper.dll
<118>Load DLL /app0/psm/Application/Sce.Vsh.FileSelector.dll
<118>Load DLL /app0/psm/Application/Sce.Vsh.Orbis.ContentManager.dll
<118>Load DLL /4VrE1TCMrg/common/lib/Sce.Vsh.ProfileCache.dll
<118>Load DLL /4VrE1TCMrg/common/lib/System.Xml.Linq.dll
<118>Load DLL /app0/psm/Application/Sce.Vsh.Friend.dll
<118>Load DLL /app0/psm/Application/Sce.Vsh.Np.Webapi.dll
<118>Load DLL /4VrE1TCMrg/common/lib/Sce.Vsh.Np.Trophy.dll
<118>Load DLL /4VrE1TCMrg/common/lib/Sce.Vsh.PartyCommon.dll
<118>Load DLL /4VrE1TCMrg/common/lib/Sce.Vsh.Np.Common.dll
<118>Load DLL /4VrE1TCMrg/common/lib/Sce.Vsh.WebViewDialog.dll
<118>Load DLL /app0/psm/Application/Sce.Vsh.VideoRecordingWrapper.dll
<118>Load DLL /4VrE1TCMrg/common/lib/Sce.Vsh.Np.Sns.dll
<118>Load DLL /app0/psm/Application/Sce.Vsh.Orbis.BgftAccessor.dll
<118>Load DLL /4VrE1TCMrg/common/lib/Sce.Vsh.Webbrowser.XdbWrapper.dll
<118>Load DLL /4VrE1TCMrg/common/lib/Sce.Vsh.Messages.StorageAccessLib.dll
<118>Load DLL /app0/psm/Application/Sce.Vsh.Messages.dll
<118>Load DLL /4VrE1TCMrg/common/lib/Sce.Vsh.Messages.BgAccessLib.dll
<118>Load DLL /4VrE1TCMrg/common/lib/Sce.Vsh.VoiceMsg.VoiceMsgWrapper.dll
<118>Load DLL /4VrE1TCMrg/common/lib/Sce.Vsh.GriefReportStorage.dll
<118>Load DLL /app0/psm/Application/Sce.Vsh.Orbis.CdlgServerNpCommerce.dll
<118>Load DLL /4VrE1TCMrg/common/lib/Sce.Vsh.PsnUtil.dll
<118>Load DLL /4VrE1TCMrg/common/lib/Sce.Vsh.Np.Asm.dll
<118>Load DLL /app0/psm/Application/Sce.Vsh.SessionInvitation.dll
<118>Load DLL /app0/psm/Application/Sce.Vsh.GameCustomData.dll
<118>Load DLL /app0/psm/Application/Sce.Vsh.GriefReport.dll
<118>Load DLL /app0/psm/Application/Sce.Vsh.Np.Tmdb.dll
<118>Load DLL /app0/psm/Application/Sce.Vsh.ErrorDialogUtilWrapper.dll
<118>Load DLL /app0/psm/Application/Sce.Vsh.SysfileUtilWrapper.dll
<118>Load DLL /app0/psm/Application/Sce.Vsh.SyscallWrapper.dll
<118>Load DLL /app0/psm/Application/Sce.Vsh.ShareServerPostWrapper.dll
<118>Load DLL /app0/psm/Application/Sce.Vsh.Np.AppLaunchLink.dll
<118>Load DLL /app0/psm/Application/Sce.Vsh.Passcode.dll
<118>Load DLL /4VrE1TCMrg/common/lib/Sce.Vsh.Webbrowser.XutilWrapper.dll
<118>Load DLL /4VrE1TCMrg/common/lib/Sce.Vsh.Np.ServiceChecker.dll
<118>Load DLL /app0/psm/Application/Sce.Vsh.DbRecoveryWrapper.dll
<118>[REGIO] (202): HDD SAVE (5)...[0]
SERIAL_PRINT_TIME_TICK#: 14217 msec -- AppMain.Main : start
<118>[SceLncService] No heart beat of Shell UI has been observed for 2023 msec.
SERIAL_PRINT_TIME_TICK#: 14665 msec -- ProcessBackgroundInit : start
<118>Ime started
SERIAL_PRINT_TIME_TICK#: 14779 msec -- AppMain.Main : before app.Run
<118>sceProfileCacheServerInitialize() 
<118>#PROFILE CACHE#: \profile_cache_core.cpp(98) : init_dependent_lib : s_libnetMemId: 3009
<118>#PROFILE CACHE#: \profile_cache_core.cpp(106) : init_dependent_lib : s_libsslCtxId: 6
<118>#PROFILE CACHE#: \profile_cache_core.cpp(114) : init_dependent_lib : s_libhttpCtxId: 9
<118>#PROFILE CACHE#: \profile_cache_core.cpp(127) : init_dependent_lib : s_webapiLibCtxId: 3
<118>#PROFILE CACHE#: \profile_cache_ipc_server.cpp(72) : sceProfileCacheIpcServerInit : 
<118>#PROFILE CACHE#: \profile_cache_ipc_server.cpp(141) : Run : ---- doServer ---- START 
<118>#PROFILE CACHE#: \profile_cache_ipc_server.cpp(205) : Run : --- cond waiting. --- 
<118>#PROFILE CACHE#: \profile_cache_ipc_server.cpp(54) : dispatchRequest : runDispatcher. 
<118>#LOGIN MGR# Event Received : SCE_LOGIN_MGR_EVENT_START_INITIALIZE
SERIAL_PRINT_TIME_TICK#: 14941 msec -- ProcessBackgroundInit : step 1
<118>W/PSM UI : **** WARNING: Shown called without Alive status : TransitionScene
<118>W/PSM UI : *** NOTICE *** : LoadSync Start !! : TransitionScene : TransitionScene
<118>W/PSM UI : *** NOTICE *** : LoadSync End !! : TransitionScene : TransitionScene
<118>W/PSM UI : *** NOTICE *** : LoadSync Start !! : BlankScene : Scene
<118>W/PSM UI : *** NOTICE *** : LoadSync End !! : BlankScene : Scene
<118>PigletAllocatorInitialize system(addr=1000000000, size=23068672) video=(addr=1080000000, size=138412032)
<118>Sony Computer Entertainment Inc.
<118>Piglet
<118>OpenGL ES 2.0 Piglet
<118>OpenGL ES GLSL ES 2.0
<118>I/PSM UI : UI system timer started!! 00:00:00.0001528
<118>#0: (wrapper managed-to-native) System.Threading.Thread:Join_internal (System.Threading.InternalThread,int,intptr)
<118>#1: System.Threading.Thread:Join ()
<118>#2: Sce.PlayStation.HighLevel.UI2.Application:Initialize ()
<118>#3: Sce.PlayStation.HighLevel.UI2.Application:Run ()
<118>#4: Sce.Vsh.ShellUI.AppMain.AppMain:Main (string[])
<118>#5: (wrapper runtime-invoke) <Module>:runtime_invoke_void_object (object,intptr,intptr,intptr)
<118>I/PSM UI : OrbisSystemSound::Initialize()  soundEffectType:Default
SERIAL_PRINT_TIME_TICK#: 15222 msec -- AppMain.Main : app.Launched : start
<118>W/PSM UI : *** NOTICE *** : LoadSync Start !! : Game : LayerScene
<118>W/PSM UI : *** NOTICE *** : LoadSync End !! : Game : LayerScene
<118>W/PSM UI : *** NOTICE *** : LoadSync Start !! : SystemBG : LayerScene
<118>W/PSM UI : *** NOTICE *** : LoadSync End !! : SystemBG : LayerScene
<118>W/PSM UI : *** NOTICE *** : LoadSync Start !! : TopMenu : LayerScene
<118>W/PSM UI : *** NOTICE *** : LoadSync End !! : TopMenu : LayerScene
<118>W/PSM UI : *** NOTICE *** : LoadSync Start !! : ShellApp : LayerScene
<118>W/PSM UI : *** NOTICE *** : LoadSync End !! : ShellApp : LayerScene
<118>W/PSM UI : *** NOTICE *** : LoadSync Start !! : LaunchError : LayerScene
<118>W/PSM UI : *** NOTICE *** : LoadSync End !! : LaunchError : LayerScene
<118>W/PSM UI : *** NOTICE *** : LoadSync Start !! : Error : LayerScene
<118>W/PSM UI : *** NOTICE *** : LoadSync End !! : Error : LayerScene
<118>W/PSM UI : *** NOTICE *** : LoadSync Start !! : CrashReport : LayerScene
<118>W/PSM UI : *** NOTICE *** : LoadSync End !! : CrashReport : LayerScene
<118>W/PSM UI : *** NOTICE *** : LoadSync Start !! : Impose : LayerScene
<118>W/PSM UI : *** NOTICE *** : LoadSync End !! : Impose : LayerScene
<118>W/PSM UI : *** NOTICE *** : LoadSync Start !! : Ime : LayerScene
<118>W/PSM UI : *** NOTICE *** : LoadSync End !! : Ime : LayerScene
<118>W/PSM UI : *** NOTICE *** : LoadSync Start !! : PSMenu : LayerScene
<118>W/PSM UI : *** NOTICE *** : LoadSync End !! : PSMenu : LayerScene
<118>W/PSM UI : *** NOTICE *** : LoadSync Start !! : SystemFG : LayerScene
<118>W/PSM UI : *** NOTICE *** : LoadSync End !! : SystemFG : LayerScene
<118>W/PSM UI : *** NOTICE *** : LoadSync Start !! : Notification : LayerScene
<118>W/PSM UI : *** NOTICE *** : LoadSync End !! : Notification : LayerScene
<118>W/PSM UI : *** NOTICE *** : LoadSync Start !! : VoiceRecognition : LayerScene
<118>W/PSM UI : *** NOTICE *** : LoadSync End !! : VoiceRecognition : LayerScene
<118>W/PSM UI : *** NOTICE *** : LoadSync Start !! : SystemOverlay : LayerScene
<118>W/PSM UI : *** NOTICE *** : LoadSync End !! : SystemOverlay : LayerScene
<118>W/PSM UI : *** NOTICE *** : LoadSync Start !! : Navigation : ContainerScene
<118>W/PSM UI : *** NOTICE *** : LoadSync End !! : Navigation : ContainerScene
<118>W/PSM UI : *** NOTICE *** : LoadSync Start !! : ShellAppScreen : ContainerScene
<118>W/PSM UI : *** NOTICE *** : LoadSync End !! : ShellAppScreen : ContainerScene
<118>W/PSM UI : *** NOTICE *** : LoadSync Start !! : BGLayerPlugin : BGLayerPlugin
<118>W/PSM UI : !!!! WARNING !!!! /Application/resource/Sce.Vsh.ShellUI.BGLayer.rco is loaded in main thread.
<118>W/PSM UI : !!!! WARNING !!!! cxml://BGLayerPlugin/layout_bg_layer is loaded in main thread.
<118>W/PSM UI : *** NOTICE *** : LoadSync Start !! : BGScene : BGScene
<118>Initialize XfGraphics
<118>W/PSM UI : *** NOTICE *** : LoadSync End !! : BGScene : BGScene
<118>W/PSM UI : *** NOTICE *** : LoadSync End !! : BGLayerPlugin : BGLayerPlugin
<118>[SceLncService] W:\Build\J00739822\vsh\shell\shell_core\lnc_service\lnc_manager.cpp(1770) setControllerFocus: LNC_ISOK::0x80940004
<118>[SceLncUtil] W:\Build\J00739822\vsh\common_lib\lnc_util\src\lnc_util_ipc_client.cpp(523) setControllerFocus: LNC_ISOK::0x80940004
SERIAL_PRINT_TIME_TICK#: 15498 msec -- AppMain.Main : app.Launched : end
<118>I/PSM UI : SceneQueue: Load : loop count 0 : TopMenuBG : Scene, Alive
<118>I/PSM UI : SceneQueue: Load : loop count 0 : ShellAppBG : Scene, Alive
<118>I/PSM UI : SceneQueue : Load : loop count 0 : Sce.Vsh.ShellUI.AppSystem.LayerManager.RootScene : RootScene, Alive
<118>I/PSM UI : OnFocusActiveSceneChanged [] -> [TopMenuBG : Scene]
<118>I/PSM UI :      Scene [TopMenuBG : Scene] : Alive
<118>[SystemLogger][ClickThrough][EVT21]: s:[NULL]s:[NULL]s:[Scene]s:[Sce.Vsh.ShellUI.AppSystem.LayerManager.RootScene:TopMenu:TopMenuBG]s:[NULL]s:[NULL]s:[NULL]
<118>EVT22 is empty
<118>EVT_invalid_ is empty
<118>SetDeviceIndexBehavior: mode=MergeAllConnectedDevice, param=null
<118>pglPlatformShaderCompilerSupported:134 - Failed to load shader compiler!
SERIAL_PRINT_TIME_TICK#: 15915 msec -- ProcessBackgroundInit : step 2
<118>[SceShellCore] Change run-level 80 -> 100
<118>[SceShellCore] START AV Capture Manager
<118>[SceLncService] launchApp() titleId = {NPXS21003}
<118>[SceLncService] Launch NPXS21003, appType = {SCE_LNC_APP_TYPE_DAEMON}  []
<118>[SceLncService] Num. of logged-in users is 0
<118>[SceLncService] isBigAppOrMiniApp = {0}, app_param.{enableSuspendOnSpecialVideOutSettingInBgState, prohibitUsingSpecialVideOutSetting, enableS3d} = {0, 0, 0} (00)
<118>[Syscore App] createApp NPXS21003
<118>[Syscore App] processSpawn(pid, 0xb0c0202, 0x10202040, appParam, processParam, 0, 0, 1, param, debug, 0)
<118>[Syscore App] appParam: appType = 0x2, rootPath = /mnt/sandbox/NPXS21003_0000, titleId = NPXS21003
<118>[Syscore App] processParam: elfPath = /app0/eboot.bin, fullPath = /system/vsh/app/NPXS21003/eboot.bin
<118>[Syscore App] attributeExe= 0
<118>[Syscore App] Add event : pid=0x2c
<118>[AppMgr Trace]: New Process, pid=0x2c, created.
<118>[AppMgr Trace]: New App, appId=0xb0c0202, created
<118>[SceShellCore] START Game Live Streaming
<118>[SceLncService] launchApp() titleId = {NPXS21000}
<118>[SceLncService] Launch NPXS21000, appType = {SCE_LNC_APP_TYPE_DAEMON}  []
<118>[SceLncService] Num. of logged-in users is 0
<118>[SceLncService] isBigAppOrMiniApp = {0}, app_param.{enableSuspendOnSpecialVideOutSettingInBgState, prohibitUsingSpecialVideOutSetting, enableS3d} = {0, 0, 0} (00)
<118>[Syscore App] createApp NPXS21000
<118>[Syscore App] processSpawn(pid, 0xb0c0303, 0x10303050, appParam, processParam, 0, 0, 1, param, debug, 0)
<118>[Syscore App] appParam: appType = 0x2, rootPath = /mnt/sandbox/NPXS21000_0000, titleId = NPXS21000
<118>[Syscore App] processParam: elfPath = /app0/eboot.bin, fullPath = /system/vsh/app/NPXS21000/eboot.bin
<118>[Syscore App] attributeExe= 0
<118>[Syscore App] Add event : pid=0x2d
<118>[AppMgr Trace]: New Process, pid=0x2d, created.
<118>[AppMgr Trace]: New App, appId=0xb0c0303, created
<118>[SceShellCore] START Party Daemon
<118>[SceLncService] launchApp() titleId = {NPXS21002}
<118>[SceLncService] Launch NPXS21002, appType = {SCE_LNC_APP_TYPE_DAEMON}  []
<118>[SceLncService] Num. of logged-in users is 0
<118>[SceLncService] isBigAppOrMiniApp = {0}, app_param.{enableSuspendOnSpecialVideOutSettingInBgState, prohibitUsingSpecialVideOutSetting, enableS3d} = {0, 0, 0} (00)
<118>[Syscore App] createApp NPXS21002
<118>[Syscore App] processSpawn(pid, 0xb0c0404, 0x10404060, appParam, processParam, 0, 0, 1, param, debug, 0)
<118>[Syscore App] appParam: appType = 0x2, rootPath = /mnt/sandbox/NPXS21002_0000, titleId = NPXS21002
<118>[Syscore App] processParam: elfPath = /app0/eboot.bin, fullPath = /system/vsh/app/NPXS21002/eboot.bin
<118>[Syscore App] attributeExe= 0
<118>[Syscore App] Add event : pid=0x2e
<118>[AppMgr Trace]: New Process, pid=0x2e, created.
<118>[AppMgr Trace]: New App, appId=0xb0c0404, created
<118>[SceShellCore] START Video Core Server
<118>[SceLncService] launchApp() titleId = {NPXS21004}
<118>[SceLncService] Launch NPXS21004, appType = {SCE_LNC_APP_TYPE_DAEMON}  []
<118>[SceLncService] Num. of logged-in users is 0
<118>[SceLncService] isBigAppOrMiniApp = {0}, app_param.{enableSuspendOnSpecialVideOutSettingInBgState, prohibitUsingSpecialVideOutSetting, enableS3d} = {0, 0, 0} (00)
<118>[Syscore App] createApp NPXS21004
<118>[Syscore App] processSpawn(pid, 0xb0c0505, 0x10505070, appParam, processParam, 0, 0, 1, param, debug, 0)
<118>[Syscore App] appParam: appType = 0x2, rootPath = /mnt/sandbox/NPXS21004_0000, titleId = NPXS21004
<118>[Syscore App] processParam: elfPath = /app0/eboot.bin, fullPath = /system/vsh/app/NPXS21004/eboot.bin
<118>[Syscore App] attributeExe= 0
Deci Daemon has been set up. Please connect to 8550 port

<118>[Syscore App] Add event : pid=0x2f
<118>[AppMgr Trace]: New Process, pid=0x2f, created.
<118>[AppMgr Trace]: New App, appId=0xb0c0505, created
<118>[SceShellCore] START Remote Play Daemon
<118>[SceLncService] launchApp() titleId = {NPXS21006}
<118>[SceLncService] Launch NPXS21006, appType = {SCE_LNC_APP_TYPE_DAEMON}  []
<118>[SceLncService] Num. of logged-in users is 0
[VCS]checkFocusStatus() [LNC->VCS] Focus Change. appType = 1(1:SHELL_UI, 4:MINI_APP, 5:BIG_APP). appId = 0xb0c0101.
<118>[SceLncService] isBigAppOrMiniApp = {0}, app_param.{enableSuspendOnSpecialVideOutSettingInBgState, prohibitUsingSpecialVideOutSetting, enableS3d} = {0, 0, 0} (00)
<118>[Syscore App] createApp NPXS21006
<118>[Syscore App] processSpawn(pid, 0xb0c0606, 0x10606080, appParam, processParam, 0, 0, 1, param, debug, 0)
<118>[Syscore App] appParam: appType = 0x2, rootPath = /mnt/sandbox/NPXS21006_0000, titleId = NPXS21006
<118>[Syscore App] processParam: elfPath = /app0/eboot.bin, fullPath = /system/vsh/app/NPXS21006/eboot.bin
<118>[Syscore App] attributeExe= 0
<118>sceCameraSetConfigInternal failed: -2144468976
<118>[         VisionMgrCtrlCamera.cpp][    1134][                               _ProcessSetConfig]::Error sceCameraSetConfig( handleOfCamera_=257,...) is failed...(ret=0x802e0010)
<118>[               VisionMgrCore.cpp][    3367][                    WaitResponseCtrlCameraThread]::Error CtrlCamera Thread failed...(ret=0x802e0010)
<118>sceCameraSetConfig failed: -2144468976
<118>[##### RECOGNITION WARNING #####]:W:\Build\J00739822\vsh\shell\shell_ui\src\recognition\vision\rcg_vision_engine\src\common\system_logger\rcg_vision_camera_data.cpp UpdateData():46 : [result == 0]:sceCameraSetConfig() returns 0x802e0010
<118>[Syscore App] Add event : pid=0x30
<118>[AppMgr Trace]: New Process, pid=0x30, created.
<118>[AppMgr Trace]: New App, appId=0xb0c0606, created
<118>[SceShellCore] START IDU Daemon
<118>[SceShellCore]  Not IDU Mode
<118>[SceShellCore] START PS Cloud Daemon
<118>[SceLncService] launchApp() titleId = {NPXS21010}
<118>[SceLncService] Launch NPXS21010, appType = {SCE_LNC_APP_TYPE_DAEMON}  []
<118>[SceLncService] Num. of logged-in users is 0
<118>[SceLncService] isBigAppOrMiniApp = {0}, app_param.{enableSuspendOnSpecialVideOutSettingInBgState, prohibitUsingSpecialVideOutSetting, enableS3d} = {0, 0, 0} (00)
<118>[Syscore App] createApp NPXS21010
<118>[Syscore App] processSpawn(pid, 0xb0c0707, 0x10707090, appParam, processParam, 0, 0, 1, param, debug, 0)
<118>[Syscore App] appParam: appType = 0x2, rootPath = /mnt/sandbox/NPXS21010_0000, titleId = NPXS21010
<118>[Syscore App] processParam: elfPath = /app0/eboot.bin, fullPath = /system/vsh/app/NPXS21010/eboot.bin
<118>[Syscore App] attributeExe= 0
[KE]sceCameraDevStop::2251 ERROR: sceCameraProcConfigStop 0x802e0006
<118>sceCameraStopByHandle failed: -2144468986
<118>[##### RECOGNITION WARNING #####]:W:\Build\J00739822\vsh\shell\shell_ui\src\recognition\vision\rcg_vision_engine\src\common\system_logger\rcg_vision_camera_data.cpp UpdateData():139 : [resultTemp == 0]:sceCameraStopByHandle() returns 0x802e0006
<118>[Syscore App] Add event : pid=0x31
<118>[AppMgr Trace]: New Process, pid=0x31, created.
<118>[AppMgr Trace]: New App, appId=0xb0c0707, created
<118>[SceSysCore] spawn /system/sys/SceVdecProxy.elf OK
<118>[SceSysCore] spawn /system/sys/SceVencProxy.elf OK
<118>[SceSysCore] spawn /system/sys/fs_cleaner.elf OK
<118>fs_cleaner: fs_clean(173)  * cleaned mountpoints=0/295, files=0
<118>I/PSM UI : SceneQueue: Load : loop count 0 : BasePlugin : BasePlugin, Alive
<118>W/PSM UI : *** NOTICE *** : LoadSync Start !! : BigApp : BigAppContainerScene
<118>W/PSM UI : *** NOTICE *** : LoadSync End !! : BigApp : BigAppContainerScene
<118>W/PSM UI : *** NOTICE *** : LoadSync Start !! : AppScreen : ApplicationScreenScene
<118>W/PSM UI : *** NOTICE *** : LoadSync End !! : AppScreen : ApplicationScreenScene
<118>W/PSM UI : *** NOTICE *** : LoadSync Start !! : AppErrorDialog : ErrorDialogScene
<118>W/PSM UI : *** NOTICE *** : LoadSync End !! : AppErrorDialog : ErrorDialogScene
<118>W/PSM UI : *** NOTICE *** : LoadSync Start !! : CdlgScreen : CommonDialogScreenScene
<118>W/PSM UI : *** NOTICE *** : LoadSync End !! : CdlgScreen : CommonDialogScreenScene
<118>W/PSM UI : *** NOTICE *** : LoadSync Start !! : CdlgErrorDialog : ErrorDialogScene
<118>W/PSM UI : *** NOTICE *** : LoadSync End !! : CdlgErrorDialog : ErrorDialogScene
<118>W/PSM UI : *** NOTICE *** : LoadSync Start !! : SplashScreen : SplashScreenScene
<118>W/PSM UI : *** NOTICE *** : LoadSync End !! : SplashScreen : SplashScreenScene
[SystemLogger][01:35:50:590][Thread 0x00018863][TRACE][ERROR][ALWAYS]setting_value_manager.cpp(33) IsDebugOutput(): sceRegMgrGetInt failed[0x800d0203][-2146631165]
<118>W/PSM UI : *** NOTICE *** : LoadSync Start !! : Spectating : ContainerScene
<118>W/PSM UI : *** NOTICE *** : LoadSync End !! : Spectating : ContainerScene
<118>W/PSM UI : *** NOTICE *** : LoadSync Start !! : MiniApp : MiniAppContainerScene
<118>W/PSM UI : *** NOTICE *** : LoadSync End !! : MiniApp : MiniAppContainerScene
<118>W/PSM UI : *** NOTICE *** : LoadSync Start !! : AppScreen : ApplicationScreenScene
<118>W/PSM UI : *** NOTICE *** : LoadSync End !! : AppScreen : ApplicationScreenScene
<118>W/PSM UI : *** NOTICE *** : LoadSync Start !! : AppErrorDialog : ErrorDialogScene
<118>W/PSM UI : *** NOTICE *** : LoadSync End !! : AppErrorDialog : ErrorDialogScene
<118>W/PSM UI : *** NOTICE *** : LoadSync Start !! : CdlgScreen : CommonDialogScreenScene
<118>W/PSM UI : *** NOTICE *** : LoadSync End !! : CdlgScreen : CommonDialogScreenScene
<118>W/PSM UI : *** NOTICE *** : LoadSync Start !! : CdlgErrorDialog : ErrorDialogScene
<118>W/PSM UI : *** NOTICE *** : LoadSync End !! : CdlgErrorDialog : ErrorDialogScene
<118>W/PSM UI : *** NOTICE *** : LoadSync Start !! : SplashScreen : SplashScreenScene
<118>W/PSM UI : *** NOTICE *** : LoadSync End !! : SplashScreen : SplashScreenScene
<118>I/PSM UI : SceneQueue: Load : loop count 0 : Noname : GameLayerPlugin, Alive
<118>I/PSM UI : SceneQueue: Load : loop count 0 : Noname : DebugPlugin, Alive
<118>I/PSM UI : SceneQueue: Load : loop count 0 : Noname : ProfileCachePlugin, Alive
<118>I/PSM UI : SceneQueue: Load : loop count 0 : GlsShellUICollectorPlugin : GlsShellUICollectorPlugin, Alive
<118>[CloudClientIpmiClient] ERROR W:\Build\J00739822\vsh\common_lib\cloud_client\cloud_client.cpp(115): IPMI::Client::connect() failed. (0x80020003)
SERIAL_PRINT_TIME_TICK#: 17563 msec -- StartFarsightUI : start
SERIAL_PRINT_TIME_TICK#: 17567 msec -- ProcessBackgroundInit : end
[SystemLogger][01:35:50:799][Thread 0x0001887a][TRACE][ERROR][ALWAYS]setting_value_manager.cpp(33) IsDebugOutput(): sceRegMgrGetInt failed[0x800d0203][-2146631165]
[CloudClientDaemon] TRACE W:\Build\J00739822\vsh\daemon\cloud_client\src\state_machine.cpp(56): onInitializeToIdle
[CloudClientDaemon] DEBUG W:\Build\J00739822\vsh\daemon\cloud_client\src\daemon_manager.cpp(260): DaemonManager::onInitializeToIdle() m_hasResetRequest = 1
INFO [timestamp: 15404628, name: initializeLib, message: Gaikai Player v.3.0.1.4.3 ----- (OBSBLD-W06.build.rd.scei.sony.co.jp @ 8/20/2014 8:44:48 AM, VSH build)]
[CloudClientDaemon] DEBUG W:\Build\J00739822\vsh\daemon\cloud_client\src\daemon_manager.cpp(241): local user detected. userId:0x10000000
[SystemLogger][01:35:50:849][Thread 0x0001887c][TRACE][ERROR][ALWAYS]setting_value_manager.cpp(33) IsDebugOutput(): sceRegMgrGetInt failed[0x800d0203][-2146631165]
<118>Task 00000003 : 0000000007039020 [type=3,subtype=6] : started
<118>Task 00000005 : 0000000007040691 [type=3,subtype=6] : started
<118>[_mainLoop:1412487350]receve[
<118>{"Record":{"actionUri":"","functionId":"CLOUD_CLIENT","messageId":"TurnExpiredForUpdate","originator":"CLOUD_CLIENT","popupDeterrence":false,"readFlag":false,"receivedDate":1412487350,"sentDate":1412487350,"settingTarget":"CLOUD_CLIENT","subject":"","subjectId":505,"subjectIdParams":"","titleIcon":"","titleId":"","titleName":"","userId":268435456},"action":"2","dataType":"Notification"}
<118>][_mainLoop:1412487350]receve[
<118>{"Record":{"actionUri":"","functionId":"CLOUD_CLIENT","messageId":"GameStartedForUpdate","originator":"CLOUD_CLIENT","popupDeterrence":true,"readFlag":true,"receivedDate":1412487350,"sentDate":1412487350,"settingTarget":"CLOUD_CLIENT","subject":"","subjectId":504,"subjectIdParams":"","titleIcon":"","titleId":"","titleName":"","userId":268435456},"action":"2","dataType":"Notification"}"}
<118>]#LOGIN MGR# Event Received : SCE_LOGIN_MGR_EVENT_START_EVENT_WATCH
<118>#LOGIN MGR# OnStartInitialize() deviceId : 0xffffffffffffffff
<118>#LOGIN MGR# [LoginMgr] startEventWatch() mode:1
<118>#LOGIN MGR# : \watch_thread.cpp(1941) : GetUnassignedDeviceInfo : GetUnassignedDeviceInfo()
<118>GetUnassignedDeviceInfo() : deviceLoop=1
<118>#LOGIN MGR#  [GetUnassignedDeviceInfo] DeviceID:0x0002000000000000, UserId:0x000000ff, type:2, subtype:1
<118>#LOGIN MGR#  [GetUnassignedDeviceInfo] DeviceID:0x0002000000000001, UserId:0x000000ff, type:2, subtype:1
<118>#LOGIN MGR#  [GetUnassignedDeviceInfo] DeviceID:0x0002000000000002, UserId:0x000000ff, type:2, subtype:1
<118>#LOGIN MGR#  [GetUnassignedDeviceInfo] DeviceID:0x000000000001030f, UserId:0x000000ff, type:2, subtype:13
<118>#LOGIN MGR# : \watch_thread.cpp(2055) : GetUnassignedDeviceInfo : GetUnassignedDeviceInfo() end
<118>entryGetNumberKeyboardHandler() OK
<118>Processing mode :1
<118>#LOGIN MGR# Receive Event : SCE_MBUS_EVENT_DEVICE_ADDED [DeviceId:0x2000000000000][type:2][subType:1]
<118>#LOGIN MGR# [GetDeviceFunction] DeviceId:0x2000000000000, Function:0x0000000000000002
<118>#LOGIN MGR# The device is already assigned.
<118>#LOGIN MGR#  Set event flag [SCE_BOOT_STAT_LOGIN_MGR]
<118>#LOGIN MGR# : \event_thread.cpp(175) : Run : Event Received : SCE_LOGIN_MGR_EVENT_WATCH_THREAD_READY
<118>#LOGIN MGR# : \event_thread.cpp(229) : OnDeviceAdded : IsLoginRunning : 0
<118>W/PSM UI : *** NOTICE *** : LoadSync Start !! : UserChange : Scene
<118>W/PSM UI : *** NOTICE *** : LoadSync End !! : UserChange : Scene
<118>Processing mode :1
[SystemLogger][01:35:51:072][Thread 0x0001886c][TRACE][ERROR][ALWAYS]setting_value_manager.cpp(33) IsDebugOutput(): sceRegMgrGetInt failed[0x800d0203][-2146631165]
SERIAL_PRINT_TIME_TICK#: 17770 msec -- StartFarsightUI : end
<118>Processing mode :1
<118>#LOGIN MGR# Receive Event : SCE_MBUS_EVENT_DEVICE_ADDED [DeviceId:0x2000000000001][type:2][subType:1]
<118>#LOGIN MGR# [GetDeviceFunction] DeviceId:0x2000000000001, Function:0x0000000000000002
<118>#LOGIN MGR# The device is already assigned.
<118>Processing mode :1
<118>Processing mode :1
<118>#LOGIN MGR# Receive Event : SCE_MBUS_EVENT_DEVICE_ADDED [DeviceId:0x2000000000002][type:2][subType:1]
<118>#LOGIN MGR# [GetDeviceFunction] DeviceId:0x2000000000002, Function:0x0000000000000002
<118>#LOGIN MGR# The device is already assigned.
<118>Processing mode :1
<118>#LOGIN MGR# Receive Event : SCE_MBUS_EVENT_DEVICE_ADDED [DeviceId:0x1030f][type:2][subType:13]
<118>#LOGIN MGR# [GetDeviceFunction] DeviceId:0x1030f, Function:0x0000000000008000
<118>#LOGIN MGR# The device is already assigned.
<118>Processing mode :1
<118>#LOGIN MGR# Receive Event : SCE_MBUS_EVENT_DEVICE_OWNER_CHANGED [DeviceId:0x2000000000000][UserId:0x000000ff]
<118>#LOGIN MGR# [GetDeviceFunction] DeviceId:0x2000000000000, Function:0x0000000000000002
<118>PsmEvent::Post()
<118>Processing mode :1
<118>#LOGIN MGR# Receive Event : SCE_MBUS_EVENT_DEVICE_OWNER_CHANGED [DeviceId:0x2000000000001][UserId:0x000000ff]
<118>#LOGIN MGR# [GetDeviceFunction] DeviceId:0x2000000000001, Function:0x0000000000000002
<118>PsmEvent::Post()
<118>Task 00000003 : 0000000007318336(279 msec) [type=3,subtype=6] : ended (state=0,runstate=2,error=0x0)
<118>Processing mode :1
<118>#LOGIN MGR# Receive Event : SCE_MBUS_EVENT_DEVICE_OWNER_CHANGED [DeviceId:0x2000000000002][UserId:0x000000ff]
<118>#LOGIN MGR# [GetDeviceFunction] DeviceId:0x2000000000002, Function:0x0000000000000002
<118>PsmEvent::Post()
<118>Processing mode :1
<118>#LOGIN MGR# Receive Event : SCE_MBUS_EVENT_DEVICE_OWNER_CHANGED [DeviceId:0x1030f][UserId:0x000000ff]
<118>#LOGIN MGR# [GetDeviceFunction] DeviceId:0x1030f, Function:0x0000000000008000
<118>PsmEvent::Post()
<118>Processing mode :1
<118>Processing mode :1
[CloudClientDaemon] TRACE W:\Build\J00739822\vsh\daemon\cloud_client\src\state_machine.cpp(95): onGetStatusInIdle
<118>[AppDb][Server] Rcv Event 2
<118>MSG AutomounterMelUtil(int32_t sceAutomounterMelUtil::unregisterDiscInsertionCallback() 686):
<118>	callback for disc insertion event has not been registered yet.
<118>MSG AutomounterMelUtil(int32_t sceAutomounterMelUtil::unregisterDiscEjectionCallback() 727):
<118>	callback for disc insertion event has not been registered yet.
<118>MSG AutomounterMelUtil(int32_t sceAutomounterMelUtil::unregisterDiscMountCallback() 578):
<118>	callback for mount event has been not registered yet.
<118>MSG AutomounterMelUtil(int32_t sceAutomounterMelUtil::unregisterDiscUnmountCallback() 638):
<118>	callback for umount event has not been registered yet.
<118>MSG AutomounterMelUtil(int sceAutomounterMelUtil::_transMediaType2DiscType(int, uint64_t) 164):
<118>	game disc_type(0xff80/PS4Disc)
<118>-- boot sequence finished --
<118>I/PSM UI : SceneQueue: Load : loop count 0 : PsImpose : PSImposePlugin, Alive
<118>SetDeviceIndexBehavior: mode=MergeAllConnectedDevice, param=null
<118>[NOTI_RECV]PsmEventHandle(148):Receive Event OnDbUpdated[/4VrE1TCMrg/priv/mms/app.db:tbl_appbrowse_0268435456]:time(1412487351)
<118>[NOTI_RECV]PsmEventHandle(148):Receive Event OnDbUpdated[/4VrE1TCMrg/priv/mms/app.db:tbl_appbrowse_0268435456]:time(1412487351)
<118>I/PSM UI : SceneQueue: Load : loop count 0 : Notification : NotificationScene, Alive
<118>I/PSM UI : SceneQueue: Load : loop count 0 : VoiceRecognitionUI : VoiceRecognitionScene, Alive
<118>I/PSM UI : SceneQueue: Load : loop count 0 : CdlgShellContainer : ContainerScene, Alive
<118>I/PSM UI : SceneQueue: Load : loop count 0 : CdlgShellContainer : ContainerScene, Alive
<118>I/PSM UI : SceneQueue: Load : loop count 0 : ScreenShotScene : ScreenShotScene, Alive
<118>I/PSM UI : SceneQueue: Load : loop count 0 : ShareNavigationScene : ShareNavigationScene, Alive
<118>I/PSM UI : SceneQueue: Load : loop count 0 : Noname : LoginMgrImposePlugin, Alive
<118>I/PSM UI : SceneQueue: Load : loop count 0 : UserChange : Scene, Alive
<118>I/PSM UI : SceneQueue: Load : loop count 0 : Noname : Scene, Alive
<118>I/PSM UI : OnFocusActiveSceneChanged [TopMenuBG : Scene] -> [UserSelectScene : UserSelectScene]
<118>I/PSM UI :      Scene [UserSelectScene : UserSelectScene] : Alive
<118>[SystemLogger][ClickThrough][EVT21]: s:[Scene]s:[Sce.Vsh.ShellUI.AppSystem.LayerManager.RootScene:TopMenu:TopMenuBG]s:[UserSelectScene]s:[Sce.Vsh.ShellUI.AppSystem.LayerManager.RootScene:Impose:LoginMgrFrame:LoginMgrRootScene:UserSelectScene]s:[NULL]s:[NULL]s:[NULL]
<118>EVT22 is empty
<118>EVT_invalid_ is empty
<118>SetDeviceIndexBehavior: mode=MergeAllConnectedDevice, param=null
<118>sceBdSchedConfigure 74 : The specified package file is on /dev/cd0.
g_bd_sched_init 2889 : BD scheduler is initialized. 
g_bd_sched_init 2891 : bd_sched is built at 07:41:55 Aug 20 2014
g_bd_sched_init 2900 : geom name is cd0.sched..
g_bd_sched_init 2922 : /dev/cd0
GEOM_SCHED: Device cd0.sched. created.
bd_sched_ioctl_configure 3382 : /user/app/CUSA00016/app.pkg
bd_sched_ioctl_configure 3399 : /system_data/playgo/CUSA00016/bdcopy.pbm
bd_sched_ioctl_configure 3441 : /mnt/disc/app/CUSA00016/app.pkg
bd_sched_ioctl_configure 3469 : emap size=21857697792, physical=3166568448, logical=0
<118>Task 00000001 : 0000000007936745 [type=3,subtype=6] : started
<118>I/PSM UI : SceneQueue: Load : loop count 3 : UserSelectScene : UserSelectScene, Alive
bd_sched_bd_reader 1859 : [Ripping] All data have read. 0 0
bd_sched_bd_reader 1864 : [Ripping] All data have written or existed on the HDD.
<118>ERROR AutomounterMelUtil(int32_t sceAutomounterMelUtil::unregisterUsbStorageMountCallback() 768):
<118>	callback for mount event has been not registered yet.
<118>ERROR AutomounterMelUtil(int32_t sceAutomounterMelUtil::unregisterUsbStorageUnmountCallback() 809):
<118>	callback for umount event has not been registered yet.
<118>SetDeviceIndexBehavior: mode=MergeAllConnectedDevice, param=null
<118>I/PSM UI : SceneQueue: Load : loop count 0 : LoginMgrRootScene : LoginMgrRootScene, Alive
<118>I/PSM UI : SceneQueue : Load : loop count 0 : LoginMgrFrame : FrameScene, Alive
<118>Task 00000001 : BD Copy Sync
<118>Task 00000001 : BD Copy No Sync
<118>Task 00000001 : 0000000009073193(1136 msec) [type=3,subtype=6] : ended (state=0,runstate=2,error=0x0)
<118>[NpPush] Established.
<118>[SceShellCore] Libc Heap Status: free 2171200 (52%), in-use 2023104, trend +5388.2 KB/min, peak 2052672, when 22 [sec]
[GnmCompositor] VideoOutModeChange YCbCr 0 
Monitor Type [HDMI]
<118>* [AvSetting core:397] hdmi event: connected(1)
<118>@ connectDeviceByFunction:L1258
* [mbus:378] owner-changed from unknown device
<118>** set_mode **
<118> video: port:0 1080P_5994 RGB444 limited CERGB 24bpp 16:9 nodata
<118> audio: port:HDMI src:I2S 48k 2.0 24bit fmt:LPCM LPCM once
<118>*** Hdmi Init(kern)  : 0 ***
<118>Processing mode :1
<118>#LOGIN MGR# Receive Event : SCE_MBUS_EVENT_DEVICE_ADDED [DeviceId:0x9000000000001][type:2][subType:10]
<118>#LOGIN MGR# [GetDeviceFunction] DeviceId:0x9000000000001, Function:0x0000000000000000
<118>Processing mode :1
<118>#LOGIN MGR# Receive Event : SCE_MBUS_EVENT_DEVICE_OWNER_CHANGED [DeviceId:0x9000000000001][UserId:0x000000ff]
<118>#LOGIN MGR# [GetDeviceFunction] DeviceId:0x9000000000001, Function:0x0000000000000000
<118>PsmEvent::Post()
<118>Processing mode :1
<118>#LOGIN MGR# Receive Event : SCE_MBUS_EVENT_VIDEO_OUT_EVENT
* [AvSetting :211] ignore SIGNAL_ON_READY_SCANIN
<118>*** Hdmi Setup(kern) : 0 ***
<118>* [AvSetting core:397] hdmi event: hdcp done(2)
<118>Processing mode :1
<118>#LOGIN MGR# Receive Event : SCE_MBUS_EVENT_VIDEO_OUT_EVENT
<118>* [AvSetting core:397] hdmi event: hdcp done(2)
<118>@ jackConnected:L1758
<118>**jackConnected:L1928 mbusOnJackConnected failed. [0x809b00ff]
<118>* attachDevice:L1459 not found sub device id.
<118>Processing mode :1
<118>#LOGIN MGR# Receive Event : SCE_MBUS_EVENT_DEVICE_ADDED [DeviceId:0x40301][type:1][subType:2]
<118>#LOGIN MGR# [GetDeviceFunction] DeviceId:0x40301, Function:0x0000000000000009
<118>#LOGIN MGR# SetDisableVibration( 0x40301, 1 )
<118>#LOGIN MGR# GetBtDeviceNum : 1
<118>#LOGIN MGR#     Controller Num : 1
<118>    Move Num : 0
<118>     Special Controller Num : 0
<118>* addInfo:L790 [MBUS] Create pad bus.(busId=0x10000000)
<118>ScePsP: Open Pad [0x0000000000040301, 0, 0]: ret=0x03020301
<118>     Standard Controller Num : 0
<118>GetControllerNum : 1
<118>IsBusTrastion() : 0
<118>ScePsP: ConnectedDeviceStatus: count=2
<118>Event OnControllerActivated   [c][DeviceId          ][UserId    ][Model     ]
<118>PsmEvent::Post()
<118>  [o][0x0000000000040301][0xffffffff][DUALSHOCK4]
<118>  [ ][0xffffffffffffffff][0xffffffff][none      ]
<118>  [ ][0xffffffffffffffff][0xffffffff][none      ]
<118>  [ ][0xffffffffffffffff][0xffffffff][none      ]
<118>m_systemState:1000, isSendEvent:1
<118>SetEventFlag( SCE_LOGIN_MGR_EVENT_DEVICE_ADDED )
<118>#LOGIN MGR# : \event_thread.cpp(165) : Run : Event Received : SCE_LOGIN_MGR_EVENT_DEVICE_ADDED
<118>#LOGIN MGR# : \event_thread.cpp(229) : OnDeviceAdded : IsLoginRunning : 0
<118>Post Event : type=SelectUser, deviceId=0x40301
<118>[OnDeviceAdded] deviceId : 0x40301
<118>GetActiveAudioDeviceNum() : 0
<118>[OnDeviceAdded] Post OnLoginMgrVisibilityChanged PSM Event
<118>Processing mode :1
<118>#LOGIN MGR# Receive Event : SCE_MBUS_EVENT_DEVICE_STATUS_UPDATED [DeviceId:0x40301]
<118>#LOGIN MGR# Battery status changed.
<118>Start GetUserInfo()
<118>SetDeviceIndexBehavior: mode=SpecificDevice, param=0x0000000000040301
<118>#LOGIN MGR# : \event_thread.cpp(149) : Run : Event Received : SCE_LOGIN_MGR_EVENT_LOGIN_STARTED
<118>Start GetUserInfoJob::Run()
<118>[GetRegisteredUser] Start
<118>[GetRegisteredUser] RegisteredUserNum : 1
<118>[GetRegisteredUser] LoginUserNum : 0
<118>[GetRegisteredUser] End
<118>Finish GetUserInfoJob::Run()
<118>Start GetUserInfoJob::Finish() / Cancelled False / Result True
<118>Call GetUserInfoAction
<118>[UserListPanel.UserListPanelWithDevice] OnGetUserInfoAction() : CurrentSceneState=UserSelectWithDevice, MySceneState=UserSelectWithDevice
<118>[UserListPanel] OnGetUserInfoAction() : Name=UserListPanelWithDevice, Length=1
<118>Finish GetUserInfo()
<118>Finish GetUserInfoJob::Finish()
<118>[SceShellCore] Libc Heap Status: free 2170656 (52%), in-use 2023648, trend +3040.3 KB/min, peak 2052672, when 39 [sec]
<118>[LoginMgr] Focusing UserId=0x10000000
<118>[ProfileCacheManager] JobUpdate.Run(0x10000000, FirstTime)
<118>[ProfileCacheManager] IN  HttpReceiver.ConnectHttp() TID:52.
<118>[ProfileCacheManager] IN  HttpReceiver.RequestCallBack() TID:5.
<118>
<118>
<118>~~~~~~~~~~ 	int CreateWithSystemPermission() type=FILE, path='/4VrE1TCMrg/priv/cache/profile/0x10000000/avatar.png', permission=00700
<118>
<118>
<118>[ProfileCacheManager] OUT HttpReceiver.RequestCallBack()
<118>[ProfileCacheManager] OUT HttpReceiver.ConnectHttp()
<118>[ProfileCacheManager] IN  HttpReceiver.ConnectHttp() TID:52.
<118>[SceShellCore] VM Stats: page fault 6.1 / sec
<118>[SceShellCore] PID 0x1f FMEM   0.7/  11.8 SceSysAvControl.elf
<118>[SceShellCore] PID 0x21 FMEM   9.8/  74.5 SceSysCore.elf
<118>[SceShellCore] PID 0x22 FMEM   6.5/  51.0 orbis_audiod.elf
<118>[SceShellCore] PID 0x23 FMEM   2.0/  16.8 GnmCompositor.elf
<118>[SceShellCore] PID 0x24 FMEM  17.1/ 144.3 SceShellCore
<118>[SceShellCore] PID 0x25 FMEM  12.5/  95.3 decid.elf
<118>[SceShellCore] PID 0x2a FMEM 130.8/1128.4 NPXS20001 SceShellUI
<118>[SceShellCore] PID 0x2b FMEM  24.2/ 376.9 NPXS20001 MonoCompiler.elf
<118>[SceShellCore] PID 0x2c FMEM   2.1/   6.8 NPXS21003 SceAvCapture
<118>[SceShellCore] PID 0x2d FMEM   6.1/  17.6 NPXS21000 SceGameLiveStreamin
<118>[SceShellCore] PID 0x2e FMEM   5.3/  18.5 NPXS21002 ScePartyDaemon
<118>[SceShellCore] PID 0x2f FMEM   3.1/  22.4 NPXS21004 SceVideoCoreServer
<118>[SceShellCore] PID 0x30 FMEM   6.8/  62.7 NPXS21006 SceRemotePlay
<118>[SceShellCore] PID 0x31 FMEM   4.6/  15.5 NPXS21010 SceCloudClientDaemo
<118>[SceShellCore] PID 0x32 FMEM   1.5/  11.3 SceVdecProxy.elf
<118>[SceShellCore] PID 0x33 FMEM   1.5/  11.2 SceVencProxy.elf
<118>[SceShellCore] PID 0x34 FMEM   1.4/   4.4 fs_cleaner.elf
<118>[ProfileCacheManager] IN  HttpReceiver.RequestCallBack() TID:5.
<118>
<118>
<118>~~~~~~~~~~ 	int CreateWithSystemPermission() type=FILE, path='/4VrE1TCMrg/priv/cache/profile/0x10000000/picture.png', permission=00700
<118>
<118>
<118>[ProfileCacheManager] OUT HttpReceiver.RequestCallBack()
<118>[ProfileCacheManager] OUT HttpReceiver.ConnectHttp()
<118>[ProfileCacheManager] JobUpdate.Finish(0x10000000)
<118>* removeDevice:L1047 [MBUS] Receive device disconnect event.(deviceId=0x9000000000001)
<118>* [AvSetting core:397] hdmi event: disconnected(0)
<118>* removeInfo:L784 [MBUS] Remove device info.(deviceId=0x9000000000001)
<118>* mbusEventSendMsg:L3203 [MBUS] Send device removed event.(deviceId=0x9000000000001)
<118>Processing mode :1
<118>#LOGIN MGR# Receive Event : SCE_MBUS_EVENT_DEVICE_REMOVED [DeviceId:0x9000000000001][SubType:10][REASON:0]
<118>#LOGIN MGR# : \event_thread.cpp(170) : Run : Event Received : SCE_LOGIN_MGR_EVENT_DEVICE_REMOVED
<118>PsmEvent::Post()
<118>Processing mode :1
<118>#LOGIN MGR# Receive Event : SCE_MBUS_EVENT_VIDEO_OUT_EVENT
**[mbus:290] no entry. system=9:hdmi status=0:disconnected
<118>[SceShellCore] VM Stats: page fault 5.5 / sec
<118>[SceShellCore] PID 0x1f FMEM   0.7/  11.8 SceSysAvControl.elf
<118>[SceShellCore] PID 0x21 FMEM   9.8/  74.5 SceSysCore.elf
<118>[SceShellCore] PID 0x22 FMEM   6.5/  51.0 orbis_audiod.elf
<118>[SceShellCore] PID 0x23 FMEM   2.0/  16.8 GnmCompositor.elf
<118>[SceShellCore] PID 0x24 FMEM  17.1/ 144.3 SceShellCore
<118>[SceShellCore] PID 0x25 FMEM  12.5/  95.3 decid.elf
<118>[SceShellCore] PID 0x2a FMEM 140.0/1135.6 NPXS20001 SceShellUI
<118>[SceShellCore] PID 0x2b FMEM  25.0/ 376.9 NPXS20001 MonoCompiler.elf
<118>[SceShellCore] PID 0x2c FMEM   2.1/   6.8 NPXS21003 SceAvCapture
<118>[SceShellCore] PID 0x2d FMEM   6.1/  17.6 NPXS21000 SceGameLiveStreamin
<118>[SceShellCore] PID 0x2e FMEM   5.3/  18.5 NPXS21002 ScePartyDaemon
<118>[SceShellCore] PID 0x2f FMEM   3.1/  22.4 NPXS21004 SceVideoCoreServer
<118>[SceShellCore] PID 0x30 FMEM   6.8/  62.7 NPXS21006 SceRemotePlay
<118>[SceShellCore] PID 0x31 FMEM   4.6/  15.5 NPXS21010 SceCloudClientDaemo
<118>[SceShellCore] PID 0x32 FMEM   1.5/  11.3 SceVdecProxy.elf
<118>[SceShellCore] PID 0x33 FMEM   1.5/  11.2 SceVencProxy.elf
<118>[SceShellCore] PID 0x34 FMEM   1.4/   4.4 fs_cleaner.elf
<118>I/PSM UI : UI system timer elapsed 00:06:00
<118>[VSMALLOC] Video: Free=69478604, FreeChunk=56; System: Free=10024944, FreeChunk=6; Heap: Free=5485056
<118>Shader=6;VertexBuffer=38;PixelBuffer=252;FrameBuffer=9;Image=0
<118>[SceSystemStateMgr] No user input for 60 seconds
<118>[VSMALLOC] Video: Free=69478604, FreeChunk=56; System: Free=10024944, FreeChunk=6; Heap: Free=5485056
<118>Shader=6;VertexBuffer=38;PixelBuffer=252;FrameBuffer=9;Image=0
</syntaxhighlight>


{{Reverse Engineering}}
<noinclude>[[Category:Main]]</noinclude>