2025-01-24 22:07:18
Cafe OS SDK Version 2.13.01 Build 69088 Branch sdk_2_13
Espresso: 0x0000700100000201
Latte: 0x0000409f
System mode: 0x100000
Boot flags: 0x84810000
Security Level: 0x1e
Key Type: 0xfffffffc
Prod Version: 0x5
Serial: 701764003
Model: WUP-101(02)
Prod Area: 0x2
Game Area: 0x2
5GHz Code: 0x7
BOOT1: 0x20b9
DRH: 0x190c
BT: 0x205
----------- Starting System Log -----------
00:00:00:174: MMC(0): initializing Controller 0, Slot 0 base 0x0D070000
00:00:00:174: MMC(3): initializing Controller 2, Slot 0 base 0x0D100000
00:00:00:175: MMC(4): initializing Controller 3, Slot 0 base 0x0D110000
00:00:00:237: TEST Info: crossProcessHeap OK.
00:00:00:241: AUXIL Info: crossProcessHeap OK.
00:00:00:242: AUXIL Info: Net OK.
00:00:04:163: USB Trace: Activating root hubs @ uptime 4.161 s with options 0x40000.
00:00:04:174: UHS0 Trace: DevFsm(EHCI-0/L0/P0): Creating device, speed=HIGH.
00:00:04:178: UHS0 Trace: DevFsm(OHCI-0:0/L0/P0): Creating device, speed=FULL.
00:00:04:179: USB Info: UhsServerAddHc 0 OK.
00:00:04:189: UHS0 Trace: DevFsm(EHCI-1/L0/P0): Creating device, speed=HIGH.
00:00:04:193: UHS0 Trace: DevFsm(OHCI-1:0/L0/P0): Creating device, speed=FULL.
00:00:04:194: USB Info: UhsServerAddHc 1 OK.
00:00:04:209: UHS0 Trace: Powering on root hub group 0.
00:00:04:224: UHS0 Trace: Powering on root hub group 1.
00:00:04:225: AHCI_MGR Trace: Turning on drive power.
00:00:04:225: AHCI_MGR Trace: Turning on drive power.
00:00:04:229: AHCI_MGR Trace: Initializing phy.
00:00:04:229: AHCI_MGR Trace: Initializing phy.
00:00:04:230: AHCI_DRV Trace: Initiating cold open.
00:00:04:230: AHCI_DRV Trace: Initiating cold open.
00:00:04:230: AHCI_DRV Trace: Resetting HBA.
00:00:04:230: AHCI_DRV Trace: Resetting HBA.
00:00:04:280: AHCI_DRV Trace: HBA Reset OK.
00:00:04:280: AHCI_DRV Trace: HBA Reset OK.
00:00:04:281: AHCI_DRV Trace: link ready, speed is GEN 1.
00:00:04:281: AHCI_DRV Trace: link ready, speed is GEN 1.
00:00:04:329: ISFS: FAT INFO (ch WUP): slot 54 / seq 705450 (Each FAT slot has been updated 11022 times in avr)
00:00:04:329: ISFS: fs_fat.c(545)FAT INFO (ch WUP): slot 54 / seq 705450 (Each FAT slot has been updated 11022 times in avr)
00:00:04:329: FSA: [uptime 4.329 s]: Attached volume to slc01 (isfs): Capacity 511 MB, 262016 logical blocks of size 2048 B.
00:00:04:417: ISFS: FAT INFO (ch RVL Compat): slot 3 / seq 208085 (Each FAT slot has been updated 13005 times in avr)
00:00:04:417: ISFS: fs_fat.c(545)FAT INFO (ch RVL Compat): slot 3 / seq 208085 (Each FAT slot has been updated 13005 times in avr)
00:00:04:417: FSA: [uptime 4.417 s]: Attached volume to slccmpt01 (isfs): Capacity 511 MB, 261632 logical blocks of size 2048 B.
00:00:04:423: SCFM:Start init. BUILD_TIME:[16:02:03]
00:00:04:426: SCFM:FSAInit
00:00:04:426: SCFM:AddClient
00:00:04:427: SCFM:scfmMountSlc
00:00:04:427: SCFM:scfmLoad
00:00:04:427: SCFM

one init.
00:00:04:428: PCFS: Disabled because we are in PROD mode.
00:00:04:428: MCP: booting from NAND
00:00:04:429: MCP: Boot PM flags - PON_COLDBOOT PON_POWER_BTN PON_SMC POFF_4S
00:00:04:447: MCP: Cafe OS SDK Version 2.13.01 Build 69088 Branch sdk_2_13
00:00:04:447: MCP: Booting on Espresso (0x0000700100000201), Latte (0x25100028), RTC (0x01)
00:00:04:447: MCP: Platform - boardType(CF), boardRevision(11), devicePresence(0x00000000), sataDevice(3), consoleType(1)
00:00:04:449: ISFS: FAT block entries check start
00:00:04:449: ISFS: fs_ops.c(2215)FAT block entries check start
00:00:04:453: ISFS: FAT block entries check finished.
00:00:04:453: ISFS: fs_ops.c(2292)FAT block entries check finished.
00:00:04:467: FSA: [uptime 4.467 s]: Attached volume to mlc01 (wfs): Capacity 29760 MB, 60948480 logical blocks of size 512 B.
00:00:04:469: FSA: [uptime 4.469 s]: Attached volume to ramdisk01 (raw): Capacity 125 MB, 129022 logical blocks of size 1024 B.
00:00:04:470: MCP: Formatting Device ramdisk to wfs
00:00:04:613: FSA: [uptime 4.613 s]: Attached volume to ramdisk01 (wfs): Capacity 125 MB, 129022 logical blocks of size 1024 B.
00:00:04:614: MCP: Format Complete
00:00:04:638: FSA: [uptime 4.638 s]: Attached volume to sdcard01 (fat): Capacity 122112 MB, 250085376 logical blocks of size 512 B.
00:00:04:729: ISFS: FAT block entries check start
00:00:04:730: ISFS: fs_ops.c(2215)FAT block entries check start
00:00:04:734: ISFS: FAT block entries check finished.
00:00:04:734: ISFS: fs_ops.c(2292)FAT block entries check finished.
00:00:04:803: AHCI_DRV Trace: device ready.
00:00:04:803: AHCI_DRV Trace: device ready.
00:00:04:803: AHCI_DRV Trace: port operational.
00:00:04:803: AHCI_DRV Trace: port operational.
00:00:04:810: ODM: ODM: Successfully configured preload cache
00:00:04:810: ODM odm_fsm.c(856): ODM: Successfully configured preload cache
00:00:04:851: [ES] checkOwnedTitleUpdateFlags: no delete in progress
00:00:04:851: [ES] checkOwnedTitleUpdateFlags: no import in progress
00:00:04:862: MCP: File loading from ramdisk cache is enabled
00:00:04:871: MCP: Master title 0005001010040100 os 000500101000400a from mlc01 flags 0004
00:00:04:881: MCP: no valid title list found, rebuilding...
00:00:04:886: MCP: os version 10 NDEBUG (0x000500101000400a)
00:00:04:887: MCP: FSA volume on device /dev/mlc01 (wfs) attached @ uptime 4.887 s.
00:00:04:902: MCP: found master title 5001010040100 on mlc01 at 4.902 s
00:00:04:905: MCP: FSA volume on device /dev/ramdisk01 (wfs) attached @ uptime 4.905 s.
00:00:04:905: MCP: Titles scanned (dev_state 0006) on device /dev/ramdisk01 (wfs) @ uptime 4.905 s.
00:00:04:906: MCP: FSA volume on device /dev/sdcard01 (fat) attached @ uptime 4.905 s.
00:00:04:906: MCP: Titles scanned (dev_state 0006) on device /dev/sdcard01 (fat) @ uptime 4.906 s.
00:00:04:906: MCP: FSA volume on device /dev/slc01 (isfs) attached @ uptime 4.906 s.
00:00:04:906: MCP: FSA volume on device /dev/slccmpt01 (isfs) attached @ uptime 4.906 s.
00:00:04:907: MCP: Titles scanned (dev_state 0006) on device /dev/slccmpt01 (isfs) @ uptime 4.907 s.
00:00:05:104: ISFS: fs_ops.c(3733)Can not change the owner Id of a non-empty file
00:00:05:104: ISFS: fs_ops.c(3733) Can not change the owner Id of a non-empty file
00:00:05:104: ISFS: fs_ops.c(6719)Could not set attribute, rc=-524312
00:00:05:105: ISFS: fs_ops.c(6719) Could not set attribute, rc=-524312
00:00:05:123: MCP: Titles scanned (dev_state 000e) on device /dev/slc01 (isfs) @ uptime 5.123 s.
00:00:05:485: MCP: ECO mode is disabled
00:00:05:485: [+-* DK is ready for console input *-+]
00:00:05:485: MCP: syslog mask is set to 0xffffffff
00:00:05:491: W2C: Does not need W2C-reflection
00:00:05:751: UHS1 Trace: DevFsm(EHCI-2/L0/P0): Creating device, speed=HIGH.
00:00:05:754: UHS1 Trace: DevFsm(OHCI-2:0/L0/P0): Creating device, speed=FULL.
00:00:05:755: CCR_MAIN: activating root hub.
00:00:05:961: FS_MAIN: UMS Server Created.
00:00:05:964: AUXIL Info: resumed.
00:00:06:060: UHS1 Trace: DevFsm(EHCI-2/L1/P1): Creating device, speed=HIGH.
00:00:06:062: UHS1 Trace: DevFsm: There are now a total of 1 connected devices.
00:00:06:105: UHS1 Trace: CltIfFsm(V057e|P0341|IF0): Device EHCI-2/L1/P1/A01 entering probing state @ uptime 6.102 s.
00:00:06:108: UHS1 Trace: CltIfFsm(V057e|P0341|IF1): Device EHCI-2/L1/P1/A01 entering probing state @ uptime 6.105 s.
00:00:06:111: UHS1 Trace: CltIfFsm(V057e|P0341|IF2): Device EHCI-2/L1/P1/A01 entering probing state @ uptime 6.108 s.
00:00:06:114: UHS1 Trace: CltIfFsm(V057e|P0341|IF3): Device EHCI-2/L1/P1/A01 entering probing state @ uptime 6.111 s.
00:00:06:116: UHS1 Trace: CltIfFsm(V057e|P0341|IF4): Device EHCI-2/L1/P1/A01 entering probing state @ uptime 6.114 s.
00:00:06:119: UHS1 Trace: CltIfFsm(V057e|P0341|IF5): Device EHCI-2/L1/P1/A01 entering probing state @ uptime 6.117 s.
00:00:06:122: UHS1 Trace: CltIfFsm(V057e|P0341|IF6): Device EHCI-2/L1/P1/A01 entering probing state @ uptime 6.119 s.
00:00:06:125: UHS1 Trace: CltIfFsm(V057e|P0341|IF7): Device EHCI-2/L1/P1/A01 entering probing state @ uptime 6.122 s.
00:00:06:128: UHS1 Trace: CltIfFsm(V057e|P0341|IF8): Device EHCI-2/L1/P1/A01 entering probing state @ uptime 6.125 s.
00:00:06:131: UHS1 Trace: CltIfFsm(V057e|P0341|IF9): Device EHCI-2/L1/P1/A01 entering probing state @ uptime 6.128 s.
00:00:06:134: UHS1 Trace: CltIfFsm(V057e|P0341|IF10): Device EHCI-2/L1/P1/A01 entering probing state @ uptime 6.131 s.
00:00:06:137: UHS1 Trace: CltIfFsm(V057e|P0341|IF11): Device EHCI-2/L1/P1/A01 entering probing state @ uptime 6.134 s.
00:00:06:139: UHS1 Trace: CltIfFsm(V057e|P0341|IF0): Acquired by client in pid 6.
00:00:06:141: UHS1 Trace: CltIfFsm(V057e|P0341|IF0): Enable endpoints 0x00080000.
00:00:06:180: __ccr_hid_attach_add_interface: idx 0 ep 3
00:00:06:182: UHS1 Trace: CltIfFsm(V057e|P0341|IF1): Acquired by client in pid 6.
00:00:06:184: UHS1 Trace: CltIfFsm(V057e|P0341|IF1): Enable endpoints 0x00100000.
00:00:06:224: __ccr_hid_attach_add_interface: idx 1 ep 4
00:00:06:226: UHS1 Trace: CltIfFsm(V057e|P0341|IF2): Acquired by client in pid 6.
00:00:06:228: UHS1 Trace: CltIfFsm(V057e|P0341|IF3): Acquired by client in pid 6.
00:00:06:230: UHS1 Trace: CltIfFsm(V057e|P0341|IF3): Activating bAlternateSetting 0.
00:00:06:235: UHS1 Trace: CltIfFsm(V057e|P0341|IF4): Acquired by client in pid 6.
00:00:06:237: UHS1 Trace: CltIfFsm(V057e|P0341|IF5): Acquired by client in pid 6.
00:00:06:239: UHS1 Trace: CltIfFsm(V057e|P0341|IF5): Activating bAlternateSetting 0.
00:00:06:243: UHS1 Trace: CltIfFsm(V057e|P0341|IF7): Acquired by client in pid 6.
00:00:06:245: UHS1 Trace: CltIfFsm(V057e|P0341|IF7): Enable endpoints 0x08001000.
00:00:06:248: UHS1 Trace: CltIfFsm(V057e|P0341|IF8): Acquired by client in pid 6.
00:00:06:250: UHS1 Trace: CltIfFsm(V057e|P0341|IF9): Acquired by client in pid 6.
00:00:06:252: UHS1 Trace: CltIfFsm(V057e|P0341|IF9): Activating bAlternateSetting 0.
00:00:06:257: UHS1 Trace: CltIfFsm(V057e|P0341|IF10): Acquired by client in pid 6.
00:00:06:259: UHS1 Trace: CltIfFsm(V057e|P0341|IF11): Acquired by client in pid 6.
00:00:06:261: UHS1 Trace: CltIfFsm(V057e|P0341|IF11): Activating bAlternateSetting 0.
00:00:06:262: DRH chip revision 00000040
00:00:06:263: DRH firmware version 190c0117
00:00:06:263: DRH cdc version 00080000
00:00:06:263: DRH wifi module id a8e502d0
00:00:06:263: DRH SPL id 00001c58
00:00:06:314: BT: BTA/BTE/STACK now operational
00:00:06:335: UHS0 Trace: HubPort(EHCI-1/L0/P0/A00)-P1: Device is not high speed, releasing port @ uptime 6.332 s.
00:00:06:477: NET: Applied interface MTU (wl0:1400 eth0:1400).
00:00:06:493: USBETH Trace: Created interface 100.
00:00:06:551: MCP: boot1 version 2.11.09
00;00;05;905: COSREPORT: Set level:1 from syslog level
00;00;05;905:
----------------------------------------------- BPERF: (0/5905254) PPC Init.
00;00;05;905: Cafe OS SDK Version 2.13.01 Build 69088 Branch sdk_2_13
00;00;05;905: PPC NDEBUG Kernel Build date - Feb 4 2021 16:37:45
00;00;05;905: BUILT AS OS_VERSION_MAJOR 000500101000800A MINOR 0x3DE8
00;00;05;905: core=1 COLD BOOT
00;00;05;905: SOFT INTERRUPT MODE
00;00;05;905: -----------------------------------------------
00;00;05;905: KiCblRegisterBlocks() completed with status 0:-4.
00;00;05;905: PROD Mode - don't even try to load kdebug.elf
00;00;05;906: title id: 5001010040100, app type 90000001
00;00;05;906:
00;00;05;906: ---------------------------------------
00;00;05;906: OS VERSION ID 0x000500101000400A
00;00;05;906: MASTER TITLE ON FLASH
00;00;05;906: ---------------------------------------
00;00;05;906:
00:00:06:593: MCP: loaded and parsed 'preload.txt' at '/vol/system/title/00050010/1000400a/code'
00:00:06:602: UHS0 Trace: DevFsm(OHCI-1:0/L1/P1): Creating device, speed=FULL.
00:00:06:604: UHS0 Trace: DevFsm: There are now a total of 1 connected devices.
00:00:06:609: MCP: Wake 0 signal
00:00:06:614: DRH using runtime generated WLAN data
00:00:06:614: Setting DRH to Normal mode
00:00:06:617: setting DRH system time to 22:07:20
00:00:06:620: sending DRC WOWL wake
00:00:06:621: ccr_admin_wowl_wake_drc() returned -1893541
00;00;06;540: DIAG:+KiRPLLoaderSetup
00;00;06;540: DIAG:-KiRPLLoaderSetup: before no-return call to KiLoadContext (0xEFE09400) (0x01003FFC)
00:00:06:703: ACT: Current account is #2.
00:00:06:869: WUD_BCMFWCheck ==> chipname 20702A1 build 517 from SERIAL FLASH
00:00:06:871: BT: BTRM now Active (WUD Operational)
00:00:07:156: UHS0 Trace: DevFsm(OHCI-1:0/L1/P1/A01): Final teardown.
00:00:07:158: UHS0 Error: UhsFreeMem(pMem=0x102c0480) failed with error -4.
00:00:07:161: UHS0 Error: file uhs_device.c, function UhsDeviceHandleTeardown, line 432, status 0:-4, info 271320192(0x102c0480)
00:00:07:163: UHS0 Error: UhsFreeMem(pMem=0x102c0540) failed with error -4.
00:00:07:166: UHS0 Error: file uhs_device.c, function UhsDeviceHandleTeardown, line 432, status 0:-4, info 271320384(0x102c0540)
00:00:07:168: UHS0 Error: UhsFreeMem(pMem=0x102c0680) failed with error -4.
00:00:07:171: UHS0 Error: file uhs_device.c, function UhsDeviceHandleTeardown, line 432, status 0:-4, info 271320704(0x102c0680)
00;00;07;485: DIAG:+KiProcess_FinishInitAndPreload
00;00;07;485: KiCblRegisterBlocks() completed with status 0:-4.
00;00;07;501: Kernel is loading shared data...
00:00:07:825: UHS0 Trace: HubPort(EHCI-1/L0/P0/A00)-P1: Device is not high speed, releasing port @ uptime 7.823 s.
00:00:07:900: NET: Change admin state (2 -> 1)(iface:0 link:2)
00:00:07:900: [WD]>>>> Linkup msg from Net
00:00:07:910: wlc_mlme_join_cmd called with Command 0x3 Length 0x21
00:00:07:914: NET: Change admin state (0 -> 2)(iface:1 link:2)
00:00:07:914: IFNET_ETH: Configuring link adminState to DOWN.
00:00:07:915: NET: Change admin state (1 -> 1)(iface:0 link:3)
00:00:08:022: [WD]>>>> Linkup msg from Net
00:00:08:036: wlc_mlme_join_cmd called with Command 0x3 Length 0x21
00:00:08:080: UHS0 Trace: DevFsm(OHCI-1:0/L1/P1): Creating device, speed=FULL.
00:00:08:081: UHS0 Trace: DevFsm: There are now a total of 1 connected devices.
00;00;08;089: ***LoadShared - LoadAsync(0,0) failed with error -29 on file "CafeTw.ttf".
00:00:08:259: MCP: Heartbeat Enabled
00;00;08;140: DIAG:-KiProcess_FinishInitAndPreload: before no-return call to KiInitKernelFinish
00;00;08;140: DIAG:+KiInitKernelFinish
00;00;08;140: VVVVVVV----- PPC Kernel Waiting -----VVVVVVV
00;00;08;140: ^^^^^^^----- PPC Kernel Release -----^^^^^^^
00;00;08;140: DIAG:-KiInitKernelFinish: before no-return call to KiProcess_Launch
00;00;08;140:
--------------------
00;00;08;140: PROCESS 1 STARTING
00;00;08;140: SYSLOG_LEVEL 1: Warnings Enabled
00;00;08;140: UserMode Core & Thread Initialization (3 Cores)
00;00;08;140: Core 1 Complete, Default Thread 0x100457E0
00;00;08;142: Core 0 Complete, MSR 0x00005072, Default Thread 0x10045140
00;00;08;143: Core 2 Complete, MSR 0x00005072, Default Thread 0x10045E80
00;00;08;143: Clearing Process MEM2 Arena...
00;00;08;156: MEM2 Arena clear complete, size 23 MB, 13ms
00;00;08;182: UserMode OS library build date: Feb 4 2021 16:38:58
00;00;08;182: __AppFlags: 0x00000200
00;00;08;183: OSBlockThreadsOnExit default for sdk version 21301
00:00:08:429: UHS0 Trace: DevFsm(OHCI-1:0/L1/P1/A02): Final teardown.
00;00;08;317: OSSetting_SynchronousPrinting DISABLED
00;00;08;338: OSSetting_CrashDumpType 0, MINI dump after crash
00;00;08;341: TCL(1): init DONE
00:00:08:736: ccr_hid_input_start: idx 0 controller: 0, ep 3 int req --> 0
00;00;08;616: VPADInit() depricated, no need to call
00;00;08;616: port 0 attached
00;00;08;617: VPAD Init end, BPERF: (0/8736501) Title PID=1
00;00;08;845: ROOT: Read restart value 0
00;00;08;846: ROOT: Read audio relaunch value 0
00;00;08;846: ROOT: OSID 0x000500101000400A
00:00:09:100: UHS0 Trace: HubPort(EHCI-1/L0/P0/A00)-P1: Device is not high speed, releasing port @ uptime 9.097 s.
00;00;09;028: Info: Calculating cold boot font CRCs on core:0
00;00;09;028: WPAD: Master Init
00;00;09;028: VPADInit() depricated, no need to call
00;00;09;061: *** KeGetSharedArea() - area not loaded.
00;00;09;061: Error: Root could not get shared font data for font 3
COSREPORT: Using syslog level:1
COSREPORT: Set upid_mask:ffffffffffffffff module_mask:ffffffffffffffff level:1
00;00;09;202: TV mode before transition = 0
00;00;09;202: DRC mode before transition = 1
00;00;09;202: ROOT: Got audio buffer from foreground bucket @ e2c00000 len = 9437184
00:00:09:355: UHS0 Trace: DevFsm(OHCI-1:0/L1/P1): Creating device, speed=FULL.
00:00:09:357: UHS0 Trace: DevFsm: There are now a total of 1 connected devices.
00;00;09;260:
Querying BSP for Hardware Information...
00;00;09;260: It is not Holly/Bolly-Wood
00;00;09;260: It is Latte A2x or later
00;00;09;260: using DSP memory parameters:
00;00;09;260: DROM_BASE: 0x3000
00;00;09;260: IRAM_SIZE: 0x2000
00;00;09;260: DRAM_SIZE: 0x3000
00:00:09:664: MCP: Titles scanned (dev_state 0004) on device /dev/mlc01 (wfs) @ uptime 9.664 s.
00:00:09:804: MCP_ioctl100_patch 0x814400c
00:00:09:804: menuThread running
00:00:09:836: AHCI_DRV Warning: PHY Ready Change Detected.
00:00:09:836: AHCI_DRV Warning: PHY Ready Change Detected.
ahciDrvPrintStats(0):
tfeIntCount = 0
hbfIntCount = 0
hbdIntCount = 0
ifIntCount = 0
infIntCount = 0
ofIntCount = 0
prcIntCount = 1
pcIntCount = 0
dpIntCount = 7
ufIntCount = 0
dhrIntCount = 8
sdbIntCount = 0
fatalTxnAmbiguity = 0
stallAlarms = 0
txnCount = 0
dbgIntCount = 0
serrDiagX = 0
serrDiagF = 0
serrDiagT = 0
serrDiagS = 0
serrDiagH = 0
serrDiagC = 0
serrDiagD = 0
serrDiagB = 0
serrDiagW = 0
serrDiagI = 0
serrDiagN = 1
serrErrE = 0
serrErrP = 0
serrErrC = 1
serrErrT = 0
serrErrM = 0
serrErrI = 0
ahciDrvPrintRegisters(0):
SATA_HCCFG_INT_REG = 0x00000000
SATA_HCCFG_INTMSK_REG = 0x00000029
DI2SATA_SR_IDX = 0x00000000
DI2SATA_CVR = 0x00000000
DI2SATA_CR = 0x00000000
AHCI_HBA_GHC_GHC = 0x80000002
AHCI_HBA_GHC_IS = 0x00000000
AHCI_HBA_PORT_IS = 0x00000000
AHCI_HBA_PORT_IE = 0x7d400079
AHCI_HBA_PORT_CMD = 0x01046717
AHCI_HBA_PORT_TFD = 0x0000007f
AHCI_HBA_PORT_SSTS = 0x00000000
AHCI_HBA_PORT_SERR = 0x00000000
00:00:09:841: AHCI_DRV Trace: Initiating close.
00:00:09:841: AHCI_DRV Trace: Initiating close.
00:00:09:841: AHCI_DRV Trace: port disable OK.
00:00:09:841: AHCI_DRV Trace: port disable OK.
ahciDrvPrintTxnLog(0):
Transaction @ uptime 4.804230s, duration 0.000641s:
ATAPI_REQUEST_SENSE_CMD
size= 32
status=32
Transaction @ uptime 4.804957s, duration 0.000658s:
ATAPI_CF_INQUIRY_CMD
size= 32
status=32
Transaction @ uptime 4.805722s, duration 0.000785s:
ATAPI {0xf1,00,11,6b,bd,f0,10,83,41,70,00,00,00,01,00,00}
size= 32
status=32
Transaction @ uptime 4.806795s, duration 0.000652s:
ATAPI {0xf1,01,00,00,00,00,11,6b,be,30,00,00,00,00,00,00}
size= 32
status=32
Transaction @ uptime 4.807531s, duration 0.000741s:
ATAPI {0xf1,02,00,00,00,00,11,6b,be,30,11,6b,be,10,00,00}
size= 32
status=32
Transaction @ uptime 4.808498s, duration 0.000618s:
ATAPI {0xf1,03,00,00,00,00,11,6b,be,50,11,6b,be,10,00,00}
size= 32
status=32
Transaction @ uptime 4.809449s, duration 0.000672s:
ATAPI_REQUEST_SENSE_CMD
size= 32
status=32
Transaction @ uptime 4.810212s, duration 0.000344s:
ATAPI {0xfb,02,00,00,08,00,00,00,00,00,00,00,11,6c,06,f0}
size= 0
status=0
00:00:09:844: ODM odm_methods.c(779): failed with rval=-1049092, senseKey=0x88
00:00:09:844: ODM odm_methods.c(779): failed with rval=-1049092, senseKey=0x88
00:00:09:845: ODM odm_methods.c(497): Error handler result: rval=-1049092, nextState=ODM_STATE_FATAL(12)
00:00:09:845: ODM odm_methods.c(497): Error handler result: rval=-1049092, nextState=ODM_STATE_FATAL(12)
00:00:09:845: ODM odm_fsm.c(401): stop unit failed rval=-104909200:00:09:845: ODM odm_fsm.c(401): stop unit failed rval=-104909200:00:09:845: ODM odm_methods.c(779): failed with rval=-1049092, senseKey=0x01
00:00:09:845: ODM odm_methods.c(779): failed with rval=-1049092, senseKey=0x01
00:00:09:845: ODM odm_methods.c(497): Error handler result: rval=-1049092, nextState=ODM_STATE_FATAL(12)
00:00:09:846: ODM odm_methods.c(497): Error handler result: rval=-1049092, nextState=ODM_STATE_FATAL(12)
00:00:09:846: ODM odm_fsm.c(401): stop unit failed rval=-104909200:00:09:846: ODM odm_fsm.c(401): stop unit failed rval=-104909200:00:09:846: FSA: [uptime 9.846 s]: Attached volume to odd01 (raw)
00:00:09:846: MCP: FSA volume on device /dev/odd01 (raw) attached @ uptime 9.846 s.
00:00:09:848: FSA: [uptime 9.848 s]: Attached volume to odd01 (raw)
00:00:09:896: UHS0 Trace: DevFsm(OHCI-1:0/L1/P1/A03): Final teardown.
00:00:09:896: MCP: FSA volume on device /dev/odd01 (raw) detached @ uptime 9.896 s.
00:00:09:897: MCP: FSA volume on device /dev/odd01 (raw) attached @ uptime 9.897 s.
00:00:09:905: MCP: Titles scanned (dev_state 0006) on device /dev/odd01 (raw) @ uptime 9.905 s.
00:00:09:920: MCP: Titles scanned (dev_state 0006) on device /dev/odd01 (raw) @ uptime 9.920 s.
00:00:10:918: MCP: Titles scanned (dev_state 000c) on device /dev/mlc01 (wfs) @ uptime 10.918 s.
00:00:10:976: MCP: Titles scanned (dev_state 0006) on device /dev/mlc01 (wfs) @ uptime 10.976 s.
00:00:12:043: NET: Change admin state (1 -> 2)(iface:0 link:2)
00:00:12:915: IFNET_ETH: Link DOWN.
00:00:15:044: NET: Change admin state (2 -> 1)(iface:0 link:2)
00:00:15:044: [WD]>>>> Linkup msg from Net
00:00:15:055: wlc_mlme_join_cmd called with Command 0x3 Length 0x21