My log looks like this:
./run_canon_fw.sh EOSM,firmware=boot=0 -s -S &
arm-none-eabi-gdb -x EOSM/patches.gdb
DebugMsg=0x40D4 (from GDB script)
Lockdown read 0
Lockdown read 0
Lockdown read 1
Lockdown read 1
Lockdown read 2
Lockdown read 2
Lockdown read 3
Lockdown read 3
Lockdown read 4
Lockdown read 4
00000000 - 00000FFF: eos.tcm_code
40000000 - 40000FFF: eos.tcm_data
00001000 - 1FFFFFFF: eos.ram
40001000 - 5FFFFFFF: eos.ram_uncached
F0000000 - F0FFFFFF: eos.rom0
F1000000 - F1FFFFFF: eos.rom0_mirror
F2000000 - F2FFFFFF: eos.rom0_mirror
F3000000 - F3FFFFFF: eos.rom0_mirror
F4000000 - F4FFFFFF: eos.rom0_mirror
F5000000 - F5FFFFFF: eos.rom0_mirror
F6000000 - F6FFFFFF: eos.rom0_mirror
F7000000 - F7FFFFFF: eos.rom0_mirror
F8000000 - F8FFFFFF: eos.rom1
F9000000 - F9FFFFFF: eos.rom1_mirror
FA000000 - FAFFFFFF: eos.rom1_mirror
FB000000 - FBFFFFFF: eos.rom1_mirror
FC000000 - FCFFFFFF: eos.rom1_mirror
FD000000 - FDFFFFFF: eos.rom1_mirror
FE000000 - FEFFFFFF: eos.rom1_mirror
FF000000 - FFFFFFFF: eos.rom1_mirror
C0000000 - DFFFFFFF: eos.iomem
[EOS] loading './EOSM/ROM0.BIN' to 0xF0000000-0xF0FFFFFF
[EOS] loading './EOSM/ROM1.BIN' to 0xF8000000-0xF8FFFFFF
[EOS] loading './EOSM/SFDATA.BIN' as serial flash, size=0x800000
[MPU] warning: non-empty spell #30 (PROP 80030019) has duplicate(s): #34
[MPU] warning: non-empty spell #40 (PROP_VIDEO_MODE) has duplicate(s): #41
[MPU] Available keys:
- Arrow keys : Navigation
- [ and ] : Main dial (top scrollwheel)
- SPACE : SET
- DELETE : guess (press only)
- M : MENU (press only)
- P : PLAY (press only)
- I : INFO/DISP (press only)
- Q : guess
- L : LiveView (press only)
- Shift : Half-shutter
- 0/9 : Mode dial (press only)
- V : Movie mode (press only)
- B : Open battery door
- C : Open card door
- F10 : Power down switch
- F1 : show this help
Setting BOOTDISK flag to 0
0xffff0000 in ?? ()
++macro define CURRENT_TASK ((int)0xFFFFFFFF)
++macro define CURRENT_ISR ((int)0xFFFFFFFF)
++macro define RTC_VALID_FLAG ((int)0xFFFFFFFF)
++macro define NUM_CORES 1
++macro define PRINT_CALLSTACK 0
++macro define MEM(x) (*(unsigned int*)(x))
++set pagination off
++set output-radix 16
++define hook-quit
++define KRED
++define KCYN
++define KBLU
++define KGRN
++define KYLW
++define KRESET
++macro define CURRENT_TASK_NAME (((int*)CURRENT_TASK)[0] ? ((char***)CURRENT_TASK)[0][9] : CURRENT_TASK)
++define print_callstack
++define print_current_location
++define print_current_location_with_callstack
++define print_formatted_string
++define DebugMsg_log
++define DebugMsg1_log
++define printf_log
++define task_create_log
++define task_switch_log
++define msleep_log
++define assert_log
++define assert0_log
++define create_semaphore_log
++define delete_semaphore_log
++define print_sem_name
++define take_semaphore_log
++define give_semaphore_log
++define create_msg_queue_log
++define print_mq_name
++define post_msg_queue_log
++define try_receive_msg_queue_log
++define receive_msg_queue_log
++define register_interrupt_log
++define register_func_log
++define mpu_decode
++define mpu_send_log
++define mpu_recv_log
++define mpu_analyze_recv_data_log
++define prop_lookup_maybe_log
++define mpu_prop_lookup_log
++define prop_print_data
++define prop_request_change_log
++define prop_deliver_log
++define try_expand_ram_struct
++define try_post_event_log
++define delayed_call_print_name
++define delayed_call_log
++define SetTimerAfter_log
++define SetHPTimerAfterNow_log
++define SetHPTimerNextTick_log
++define CancelTimer_log
++define engine_resource_description
++define engine_resources_list
++define CreateResLockEntry_log
++define LockEngineResources_log
++define AsyncLockEngineResources_log
++define UnLockEngineResources_log
++define StartEDmac_log
++define SetEDmac_log
++define print_date_time
++define set_date_time
++define load_default_date_time_log
++define rtc_read_log
++define rtc_write_log
++define CreateStateObject_log
++define state_transition_log
++define log_result
++define generic_log
++define generic_log_with_result
FFFF0800: MCR p15,0,Rd,cr9,cr1,0: XSCALE_LOCK_ICACHE_LINE <- 0x40000006 (40000000 - 40000FFF, 0x1000)
FFFF094C: MRC p15,0,Rd,cr1,cr0,0: SCTLR -> 0x2078
FFFF094C: MCR p15,0,Rd,cr1,cr0,0: SCTLR <- 0x12078
FFFF4604: MCR p15,0,Rd,cr6,cr0,0: 946_PRBS0 <- 0x3F (00000000 - FFFFFFFF, 0x100000000)
FFFF460C: MCR p15,0,Rd,cr6,cr1,0: 946_PRBS1 <- 0x3D (00000000 - 7FFFFFFF, 0x80000000)
FFFF4614: MCR p15,0,Rd,cr6,cr2,0: 946_PRBS2 <- 0xE0000039 (E0000000 - FFFFFFFF, 0x20000000)
FFFF461C: MCR p15,0,Rd,cr6,cr3,0: 946_PRBS3 <- 0xC0000039 (C0000000 - DFFFFFFF, 0x20000000)
FFFF4624: MCR p15,0,Rd,cr6,cr4,0: 946_PRBS4 <- 0xFF00002F (FF000000 - FFFFFFFF, 0x1000000)
FFFF462C: MCR p15,0,Rd,cr6,cr5,0: 946_PRBS5 <- 0x37 (00000000 - 0FFFFFFF, 0x10000000)
FFFF4634: MCR p15,0,Rd,cr6,cr6,0: 946_PRBS6 <- 0xF700002F (F7000000 - F7FFFFFF, 0x1000000)
FFFF463C: MCR p15,0,Rd,cr2,cr0,0: DCACHE_CFG <- 0x70
FFFF4644: MCR p15,0,Rd,cr3,cr0,0: DACR <- 0x70
FFFF4648: MCR p15,0,Rd,cr2,cr0,1: ICACHE_CFG <- 0x70
FFFF464C: MCR p15,0,Rd,cr5,cr0,0: DATA_AP <- 0x3FFF
FFFF4654: MCR p15,0,Rd,cr5,cr0,1: INSN_AP <- 0x3FFF
FFFF4658: MRC p15,0,Rd,cr1,cr0,0: SCTLR -> 0x12078
FFFF4658: MCR p15,0,Rd,cr1,cr0,0: SCTLR <- 0xC001307D
FFFF095C: MCR p15,0,Rd,cr9,cr1,1: XSCALE_UNLOCK_ICACHE <- 0x6 (00000000 - 00000FFF, 0x1000)
FFFF095C: MRC p15,0,Rd,cr1,cr0,0: SCTLR -> 0xC001307D
FFFF095C: MCR p15,0,Rd,cr1,cr0,0: SCTLR <- 0xC005307D
FFFF098C: MRC p15,0,Rd,cr1,cr0,0: SCTLR -> 0xC005307D
FFFF098C: MCR p15,0,Rd,cr1,cr0,0: SCTLR <- 0xC005107D
MID=0xEC(fact_area=0xEC)
K331 READY
64K Sector FROM From BL 0xec
[SF] InstallSerialFlash 4 0xc022c0d4 0x0 0x800000 1
[SF] Bufcon Base 0xc022c0d4
SerialFlash Initialize
[DMA1] Copy [0xF8099000] -> [0x40540200], length [0x00000F84], flags [0x00030001]
[DMA1] OK
[DMA1] Copy [0xF8F00000] -> [0x40541400], length [0x0001132C], flags [0x00030001]
[DMA1] OK
[EEPROM-DMA]! [0x340000] -> [0x40480000] (0xBD820 bytes)
0: 22.528 [STARTUP]
K331 ICU Firmware Version 2.0.2 ( 9.9.8 )
6: 26.112 [PROPAD] SerialFlash Packages!! 0x340000
[DMA1] Copy [0xF8F60000] -> [0x40561600], length [0x0001AEDC], flags [0x00030001]
[DMA1] OK
[EEPROM-DMA]! [0x340000] -> [0x40480000] (0x0 bytes)
[DMA1] Copy [0xF8060000] -> [0x40581700], length [0x00003B24], flags [0x00030001]
[DMA1] OK
10: 34.304 [PROPAD] SerialFlash Packages!! 0x7
12: 34.560 [PROPAD] PROPAD_CreateFROMPropertyHandle DRAMAddr 0x4fe00000
13: 35.072 [PROPAD] SerialFlash Packages!! 0x10000
[EEPROM-DMA]! [0x10000] -> [0x4FE00000] (0x191570 bytes)
[EEPROM-DMA]! [0x10000] -> [0x4FE00000] (0x0 bytes)
[MPU] Received: 06 04 02 00 00 00 (Init - spell #1)
[MPU] Sending : 50 4e 02 0e 02 02 01 01 00 00 00 60 00 00 00 19 64 00 00 00 00 21 00 00 06 04 00 00 06 04 00 00 06 04 00 00 00 00 00 00 65 28 00 00 00 00 00 00 00 00 00 00 00 00 80 48 78 48 00 03 03 01 00 00 00 00 02 01 00 00 00 01 00 00 00 00 03 00 01 00 (Mode group)
15: 40.960 [STARTUP] InitializeIntercom
16: 41.216 [STARTUP] InitializeIntercom End(0x0)
17: 41.984 [PROPAD] SerialFlash Packages!! 0x7
30: 48.640 [DL] dlMain : Start
33: 48.896 [DL] PROP_ACTIVE_SWEEP_MODE (1)
[MPU] Received: 0a 08 03 57 10 33 00 01 00 00 (PROP 8003005E - spell #4)
[MPU] Sending : 24 23 02 0d 00 00 00 00 01 00 00 00 00 01 00 00 00 01 02 00 00 00 00 00 00 00 00 01 00 00 00 00 00 00 00 00 (Card group)
[MPU] Received: 08 06 01 1d 21 84 00 00 (unknown - PROP_PICTURE_STYLE)
[MPU] Received: 08 06 00 00 02 0e 00 00 (Complete WaitID = 0x80000001 Mode group - spell #2)
[MPU] Sending : 28 27 02 0f 01 00 00 10 01 01 00 00 00 00 00 00 00 00 00 00 00 18 00 00 00 0c 00 00 00 00 00 00 00 02 00 00 00 01 01 00 (Movie group)
[MPU] Sending : 3c 3a 02 10 00 00 00 00 00 00 01 00 00 00 00 ff 00 00 ff 00 ff ff ff ff ff ff ff ff 00 00 00 00 00 01 ff 00 00 02 01 01 00 03 00 01 00 04 00 00 01 05 00 01 01 00 01 00 00 3f 00 00 (AF group)
[MPU] Sending : 3e 3c 02 11 01 ff 01 00 01 00 01 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 28 00 ff 00 00 ff 00 ff ff ff ff ff ff ff ff 00 00 00 (AF2 group)
[MPU] Sending : 0a 08 01 6e 80 48 00 00 00 00 (PROP_ISO_RANGE)
[MPU] Sending : 08 06 01 0b 00 00 00 00 (PROP_AEB)
[MPU] Sending : 06 05 01 76 00 00 (PROP_SILENT_CONTROL_SETTING)
[MPU] Sending : 06 05 01 71 00 00 (PROP_AF_METHOD_SELECT_FOCUS_AREA)
[MPU] Sending : 06 05 01 7e 00 00 (PROP_GPS_COMPAS_SELECT)
[MPU] Sending : 06 05 01 7c 00 00 (PROP_GPS_AUTO_TIME_SETTING)
[MPU] Sending : 0a 08 01 85 00 00 00 01 00 00 (PROP_GIS_SETTING)
[MPU] Sending : 08 06 01 47 0a 02 00 00 (PROP_SELFTIMER_CONTINUOUS_NUM)
[MPU] Sending : 06 05 01 7b 01 00 (PROP_CONTINUOUS_AF)
[MPU] Sending : 08 06 01 57 00 00 00 00 (PROP_BUILTIN_STROBO_MODE)
[MPU] Sending : 06 05 01 86 00 00 (PROP 8004004A)
[MPU] Sending : 06 05 01 87 00 00 (PROP 8004004B)
[MPU] Sending : 06 05 01 8d 00 00 (PROP 80040050)
[MPU] Sending : 06 05 01 8e 00 00 (PROP_GPSLOG_SETTING)
[MPU] Sending : 10 0e 01 8f 00 00 00 00 00 00 00 00 00 00 00 00 (PROP_LV_CFILTER)
[MPU] Sending : 06 05 01 90 00 00 (PROP_WIFI_SETTING)
[MPU] Sending : 06 05 01 8b 00 00 (PROP 8004004E)
[MPU] Sending : 08 06 01 91 00 00 00 00 (PROP_BUILTINGPS_PINPOINTING_INTERVAL_SETTING)
[MPU] Sending : 06 05 01 98 00 00 (PROP 80040056)
[MPU] Sending : 08 06 01 88 07 08 00 00 (PROP 8000004F)
[MPU] Sending : 06 05 03 37 00 00 (PROP_MIRROR_DOWN_IN_MOVIE_MODE)
[MPU] Sending : 06 05 01 92 07 00 (PROP_IMAGE_ASPECT_RATIO)
[MPU] Sending : 0e 0c 02 04 08 00 00 00 00 00 00 01 00 00 (PROP_CFN)
[MPU] Sending : 0a 08 03 58 00 00 00 00 00 00 (PROP 8003005F)
[MPU] Sending : 06 05 03 5a 02 00 (PROP 80030060)
[MPU] Sending : 16 14 01 61 00 09 d1 3e 00 00 00 00 ff e7 ff ff 00 0a 26 fe 00 00 (PROP 80040027)
[MPU] Sending : 0a 08 03 2f 00 00 00 00 00 00 (PROP_SPECIAL_OPTION)
[MPU] Received: 0a 08 03 06 00 00 00 00 00 00 (PROP_AVAIL_SHOT - spell #5)
[MPU] Sending : 0a 08 03 2f 00 00 00 00 00 00 (PROP_SPECIAL_OPTION)
[MPU] Received: 06 04 03 10 00 00 (PROP 80030008 - spell #6)
[MPU] Sending : 06 05 03 20 01 00 (PROP_STARTUP_CONDITION)
[MPU] Received: 06 05 03 07 ff 00 (PROP_BURST_COUNT - spell #7)
[MPU] Sending : 0c 0b 03 42 00 00 00 00 00 00 00 00 (PROP_LED_LIGHT)
[MPU] Sending : 62 61 02 12 01 20 50 00 f0 00 11 00 37 91 77 1a 00 00 ff 00 00 00 00 00 00 00 01 f8 96 00 00 00 00 00 00 01 f8 96 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 23 43 23 00 00 00 00 00 00 00 10 31 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 (Lens group)
[MPU] Received: 06 05 01 2e 01 00 (PROP_SAVE_MODE - spell #8)
[MPU] Received: 0a 08 03 0b 00 00 00 00 00 00 (PROP 80030007 - spell #9)
[DMA5] Copy [0xFF892D90] -> [0x01E00000], length [0x00065BD4], flags [0x00000001]
[DMA5] OK
[MPU] Sending : 06 05 03 05 02 00 (PROP_POWER_LEVEL)
[MPU] Sending : 06 05 04 06 05 00 (PROP_DEFAULT_LV_MANIP)
[MPU] Sending : 06 05 01 97 00 01 (PROP 8003006F)
[MPU] Sending : 06 05 04 06 05 00 (PROP_DEFAULT_LV_MANIP)
[MPU] Sending : 06 05 01 2e 01 00 (PROP_SAVE_MODE)
[MPU] Sending : 06 05 04 06 05 00 (PROP_DEFAULT_LV_MANIP)
[MPU] Received: 08 06 00 00 01 97 00 00 (Complete WaitID = 0x8003006F PROP 8003006F - spell #3)
[MPU] Sending : 06 05 04 06 05 00 (PROP_DEFAULT_LV_MANIP)
[MPU] Received: 22 20 03 3b 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 (unnamed - spell #10)
[MPU] Received: 06 05 04 0e 01 00 (PROP 8002000D - spell #11)
101: 43.520 [RSC] hMemoryQueue (0xA20012) hStorageQueue (0xA40014)
102: 44.544 [RSC] ### LIST 5 0 5 ###
167: 56.832 [SND] Seq LPC fin
193: 58.368 [ENG] [ENGIO](Addr:0x41400000, Data:0x 44000)
209: 72.704 [FM] FM_RegisterSpaceNotifyCallback
213: 72.704 [AUDIO] [GPS] GPS_RegisterSpaceNotifyCallback
217: 72.960 [FM] FM_RegisterSpaceNotifyCallback
219: 72.960 [TERMINATE] SHUTDOWN init comp
221: 72.960 [TERMINATE] Abort init comp
253: 75.008 [MC] [MC] PROP_HEADPHONE_VOLUME_VALUE : 0
254: 75.008 [MC] [MC] PROP_MOVIE_PLAY_VOLUME : 10
259: 75.264 [MC] regist master CardCover
[MPU] Received: 08 07 01 2a 1b e6 00 00 (PROP_CARD2_FILE_NUMBER - spell #12)
[MPU] Received: 06 05 03 07 05 00 (PROP_BURST_COUNT - spell #13)
[MPU] Received: 0a 08 03 06 00 00 04 56 00 00 (unknown - PROP_AVAIL_SHOT)
[MPU] Received: 06 05 03 11 01 00 (PROP_ICU_AUTO_POWEROFF - spell #15)
[MPU] Received: 06 05 02 0a 00 00 (PROP_PERMIT_ICU_EVENT - spell #16)
[MPU] Sending : 06 05 01 2c 02 00 (PROP_CURRENT_MEDIA)
[MPU] Received: 06 05 03 0d 00 00 (PROP_CARD2_RECORD - spell #17)
[MPU] Sending : 12 10 03 00 b8 00 00 3a 07 00 00 00 00 00 00 00 00 00 (PROP 80030000)
[MPU] Received: 06 05 03 0c 00 00 (PROP_CARD1_RECORD - spell #18)
[MPU] Sending : 06 05 03 23 19 00 (unnamed)
[MPU] Sending : 06 05 03 04 00 00 (PROP_POWER_KIND)
[MPU] Sending : 1e 1d 03 24 45 46 2d 53 31 37 2d 35 35 6d 6d 20 66 2f 32 2e 38 20 49 53 20 55 53 4d 00 00 (PROP_LENS_NAME)
303: 89.856 [PRP] M:B8 F:0 L:0 P:3A T:7
304: 90.112 [STARTUP] update coded version.
[MPU] Received: 06 05 03 19 01 00 (PROP_TFT_STATUS - spell #19)
[MPU] Sending : 06 04 03 25 00 00 (unnamed)
[MPU] Sending : 24 23 03 15 01 20 50 00 f0 00 11 00 37 91 77 1a 00 00 ff 00 00 00 00 00 00 00 01 f8 96 00 00 00 00 21 00 00 (PROP_LENS)
[MPU] Sending : 24 22 03 3c 00 00 01 f8 96 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 (PROP 8003003C)
[MPU] Sending : 06 05 03 5d 8e 00 (PROP 80030062)
[MPU] Sending : 24 23 03 15 01 20 50 00 f0 00 11 00 37 91 77 1a 00 00 ff 00 00 00 00 00 00 00 01 f8 96 00 00 00 00 21 00 00 (PROP_LENS)
[MPU] Sending : 06 05 01 3d 00 00 (PROP_TEMP_STATUS)
[MPU] Sending : 06 05 03 37 00 00 (PROP_MIRROR_DOWN_IN_MOVIE_MODE)
[MPU] Sending : 06 05 04 06 05 00 (PROP_DEFAULT_LV_MANIP)
[MPU] Sending : 06 05 03 0d 00 00 (PROP_CARD2_RECORD)
[MPU] Sending : 06 05 03 0c 00 00 (PROP_CARD1_RECORD)
[MPU] Received: 06 05 09 11 01 00 (PROP_LV_DISPSIZE - spell #20)
[MPU] Received: 12 11 09 15 00 00 00 00 00 00 00 00 00 00 00 00 00 00 (PROP 80050020 - spell #21)
[MPU] Received: 14 13 09 25 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 (unnamed - spell #22)
[MPU] Received: 06 05 01 5a 00 00 (PROP_CONTINUOUS_AF_VALID - spell #23)
[MPU] Received: 06 05 09 2f 01 00 (unnamed - spell #24)
[MPU] Sending : 06 05 01 59 01 00 (PROP_MOVIE_SERVO_AF)
[MPU] Received: 14 13 09 25 02 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 (unnamed - spell #25)
[MPU] Received: 06 05 01 5a 01 00 (PROP_CONTINUOUS_AF_VALID - spell #26)
[MPU] Sending : 06 05 01 59 01 00 (PROP_MOVIE_SERVO_AF)
[MPU] Received: 0a 08 09 1a 00 00 00 00 00 00 (PROP 8005002A - spell #27)
[MPU] Received: 0a 08 09 24 00 00 00 00 00 00 (unnamed - spell #28)
[MPU] Received: 08 06 03 18 00 00 00 00 (PROP 8003000F - spell #29)
[MPU] Received: 08 06 03 1f 00 00 00 00 (PROP 80030019 - spell #30)
[MPU] Sending : 06 05 01 58 00 00 (PROP_VIDEOSNAP_MODE)
[MPU] Received: 06 05 03 13 00 00 (PROP_LOGICAL_CONNECT - spell #31)
[MPU] Received: 06 05 03 1e 00 00 (PROP 8003001A - spell #32)
[MPU] Received: 06 05 01 8a 00 00 (PROP_SW2_MOVIE_START - spell #33)
[MPU] Received: 08 06 03 1f 00 00 00 00 (PROP 80030019 - spell #34)
[MPU] Sending : 06 05 01 8a 00 00 (PROP_SW2_MOVIE_START)
[MPU] Received: 0a 08 01 3b ff ff 00 00 00 00 (PROP_USBDEVICE_CONNECT - spell #35)
[MPU] Received: 0a 08 01 3b ff 00 00 00 00 00 (PROP_USBDEVICE_CONNECT - spell #36)
[MPU] Sending : 06 05 03 38 8f 00 (PROP 80030035)
348: 131.328 [MR] mvrChangeAckCBR : Video - Mode=0, Type=0, Rate=24, GOP=12
391: 139.264 [LVDTS] WARN First Get DTS_GetAllRandomData
392: 139.520 [LVDTS] WARN First Get DTS_GetAllRandomData
400: 140.800 SPECIAL_OPTION AF MOVIE GERO OFF
406: 141.312 [LVDTS] WARN First Get DTS_GetAllRandomData
407: 141.312 [LVDTS] WARN First Get DTS_GetAllRandomData
408: 141.312 [LVDTS] WARN First Get DTS_GetAllRandomData
411: 141.312 [LVDTS] WARN First Get DTS_GetAllRandomData
412: 141.312 [LVDTS] WARN First Get DTS_GetAllRandomData
414: 141.312 [LVDTS] WARN First Get DTS_GetAllRandomData
415: 141.312 [LVDTS] WARN First Get DTS_GetAllRandomData
420: 141.568 [LVDTS] WARN First Get DTS_GetAllRandomData
421: 141.568 [LVDTS] WARN First Get DTS_GetAllRandomData
422: 141.568 [LVDTS] WARN First Get DTS_GetAllRandomData
423: 141.824 [LVGMT] PROP_LV_PROHIBIT_OUTPUT 0 0
424: 141.824 [LVDTS] WARN First Get DTS_GetAllRandomData
426: 141.824 [LVGMT] PROP_LV_CFILTER[0][0]
427: 141.824 [LVGMT] PROP_LV_CENTER_OF_DIORAM_CFILTER[2684][1793]
431: 142.336 [LVDTS] WARN First Get DTS_GetAllRandomData
432: 142.592 [LVDTS] WARN First Get DTS_GetAllRandomData
441: 144.384 [LVCOM] InitializeLiveViewDefectDetection
442: 144.896 [LVCOM] ExecuteDefectMarge Start
443: 144.896 [LVCOM] ExecuteDefectMarge End
448: 80.128 [LVDTS] WARN First Get DTS_GetAllRandomData
449: 80.128 [LVDTS] WARN First Get DTS_GetAllRandomData
462: 150.272 [AF] Ratio:30 Reboot:2 !!!
464: 150.528 [LV] PROP_LV_BLOCK PROP_LV_UNBLOCKING 0
475: 153.344 [AUDIO] RegisterCBRSDIOCableConnect
503: 156.928 [WFT] PROP_ADAPTER_DEVICE_ACTIVE: Can Not Change(0) Connect(0)
541: 161.280 [PTP] PSI UnlockTransImg : Trans List is NULL
542: 161.280 [PTP] PSI TarminateTransImgList : SessionTarget [1]
543: 161.280 [PTP] PSI TarminateTransImgList : Trans List is NULL
546: 161.536 [PTP] PSI UnlockTransImg : Trans List is NULL
547: 161.536 [PTP] PSI TarminateTransImgList : SessionTarget [10]
548: 161.536 [PTP] PSI TarminateTransImgList : Trans List is NULL
550: 161.536 [PTP] PSI DisconnectViewFinder
557: 162.048 [PTP] PROP_SCREEN_SAVER 0
560: 162.304 [PTPCOM] SetPtpTransportResources:0,323d
562: 162.560 [PTP] PSI UnlockTransImg : Trans List is NULL
563: 162.816 [PTP] PSI TarminateTransImgList : SessionTarget [10]
564: 162.816 [PTP] PSI TarminateTransImgList : Trans List is NULL
594: 100.352 [WFT] Regist PropCBR PROP_WFT_BLUETOOTH
SD: Unknown CMD1
[SDIO] Error
SD: Unknown CMD1
[SDIO] Error
SD: Unknown CMD1
[SDIO] Error
627: 131.072 [SD] ERROR SDINTREP=0x00000000
628: 131.328 [SD] ERROR UNEXPECTED ERROR
[MPU] Received: 0a 08 03 06 00 00 00 0b 00 00 (unknown - PROP_AVAIL_SHOT)
655: 240.640 [FM] FileNo (DriveNo = 2, 0 <-> 7142)
656: 240.640 [FM] FreeCluster (DriveNo = 2, 11628 <-> 932093)
[MPU] Received: 08 07 01 2a 1b e6 00 00 (PROP_CARD2_FILE_NUMBER - spell #37)
[MPU] Received: 08 07 01 2a 1b e6 00 00 (PROP_CARD2_FILE_NUMBER - spell #37)
[MPU] Received: 06 05 03 19 01 00 (PROP_TFT_STATUS - spell #39)
[MPU] Received: 1e 1c 01 4e 00 00 00 00 00 00 00 00 00 00 00 18 00 00 00 0c 00 00 00 00 00 00 00 02 00 00 (PROP_VIDEO_MODE - spell #40)
[MPU] Sending : 1e 1c 01 4e 00 00 00 00 00 00 00 00 00 00 00 18 00 00 00 0c 00 00 00 00 00 00 00 02 00 00 (PROP_VIDEO_MODE)
[MPU] Received: 1e 1c 01 4e 00 00 00 00 00 00 00 00 00 00 00 18 00 00 00 0c 00 00 00 00 00 00 00 02 00 00 (PROP_VIDEO_MODE - spell #40)
[MPU] Sending : 06 05 01 53 01 00 (PROP_AF_DURING_RECORD)
[MPU] Received: 06 05 03 19 01 00 (PROP_TFT_STATUS - spell #42)
[MPU] Sending : 06 05 01 58 00 00 (PROP_VIDEOSNAP_MODE)
[MPU] Received: 06 05 03 19 01 00 (PROP_TFT_STATUS - spell #42)
[MPU] Sending : 06 05 01 59 01 00 (PROP_MOVIE_SERVO_AF)
[MPU] Received: 06 05 02 0a 01 00 (PROP_PERMIT_ICU_EVENT - spell #44)
[MPU] Sending : 06 05 01 49 01 00 (PROP_LIVE_VIEW_AF_SYSTEM)
[MPU] Received: 06 05 03 19 01 00 (PROP_TFT_STATUS - spell #45)
[MPU] Sending : 1e 1c 01 4e 00 00 00 00 00 00 00 00 00 00 00 18 00 00 00 0c 00 00 00 00 00 00 00 02 00 00 (PROP_VIDEO_MODE)
[MPU] Received: 06 05 04 00 00 00 (NotifyGUIEvent - spell #46)
696: 250.112 [FM] [GPS] GPS_Initialize (36, 25)
772: 190.976 [DP] LOGICAL_CONNECT [0x00000000]
774: 190.976 [PROPAD] ERROR GetPropertyData ID (0) = 0x02050038
775: 190.976 [PRP] ERROR NOT FOUND PROPERTY ID = 0x02050038 L:2411
776: 190.976 [DP] PROP_WIFI_SETTING [0]
796: 259.840 WARN localI2C_Read : 377
797: 260.352 WARN localI2C_Read : 377
798: 260.608 WARN localI2C_Read : 377
799: 260.864 WARN localI2C_Read : 377
800: 261.120 WARN localI2C_Read : 377
801: 261.120 WARN localI2C_Read : 377
802: 261.376 [HDMI] cec_initialize_reg_set : END
803: 261.376 WARN localI2C_Read : 377
804: 261.632 WARN localI2C_Read : 377
805: 261.888 WARN localI2C_Read : 377
806: 261.888 [HDMI] Logical Address Set : End
807: 261.888 [HDMI] CEC DEVICE SETUP
808: 261.888 [HDMI] InitializeHDMI
815: 268.032 [IMPP] H264E InitializeH264EncodeFor1080pDZoom
816: 268.032 [IMPP] H264E InitializeH264EncodeFor1080p25fpsDZoom
1051: 288.768 [MR_MOV] (Empty Func) MVW_RegisterXmpDataCallback
1065: 289.280 [HDMI] CEC OFF
1083: 290.560 [STARTUP] startupInitializeComplete
1086: 290.560 [MC] guimode comp. 0
1101: 291.072 [MC] guimode comp. 0
1148: 295.168 [MR] mvrChangeAckCBR : Video - Mode=0, Type=0, Rate=24, GOP=12
1157: 231.936 [LVDTS] WARN First Get DTS_GetAllRandomData
1158: 231.936 [LVDTS] WARN First Get DTS_GetAllRandomData
[MPU] Received: 08 06 04 0c 03 00 00 00 (PROP_SHOOTING_TYPE - spell #53)
[MPU] Received: 06 05 03 1d 1f 00 (unknown - PROP_BATTERY_REPORT)
1176:[MPU] Sending : 06 05 01 53 01 00 (PROP_AF_DURING_RECORD)
[MPU] Received: 06 05 08 06 ff 00 (unknown - COM_FA_CHECK_FROM)
244.480 [MR] mvrChangeAckCBR : Video - Mode=0, Type=0, Rate=24, GOP=12
[MPU] Sending : 06 05 01 58 00 00 (PROP_VIDEOSNAP_MODE)
[MPU] Sending : 06 05 01 59 01 00 (PROP_MOVIE_SERVO_AF)
1183: 247.2[MPU] Sending : 06 05 01 49 01 00 (PROP_LIVE_VIEW_AF_SYSTEM)
96 [LVDTS] WARN First Get DTS_GetAllRandomData
1184: 247.296 [LVDTS] WARN First Get DTS_GetAllRandomData
[MPU] Sending : 06 05 06 11 01 00 (GUI_SWITCH)
[MPU] Sending : 06 05 06 12 00 00 (GUI_SWITCH)
[MPU] Sending : 46 45 0a 08 ff 1f 01 00 00 00 00 00 00 00 01 03 50 20 28 01 01 00 60 04 01 04 87 00 00 00 00 00 00 01 01 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 (PD_NotifyOlcInfoChanged)
[MPU] Sending : 08 06 01 04 00 00 00 00 (PROP_AF_MODE)
[MPU] Sending : 06 05 03 37 00 00 (PROP_MIRROR_DOWN_IN_MOVIE_MODE)
[MPU] Sending : 06 05 04 00 00 01 (NotifyGUIEvent)
[MPU] Sending : 08 06 04 0c 03 00 01 00 (PROP_SHOOTING_TYPE)
1230: 261.888 [MC] guimode comp. 0
[MPU] Received: 08 06 00 00 04 00 00 00 (Complete WaitID = 0x80020000 - spell #47)
[MPU] Received: 06 05 03 19 01 00 (PROP_TFT_STATUS - spell #56)
[MPU] Received: 06 04 04 13 00 00 (unknown - PROP 80020012)
[DMA5] Copy [0xFFA14DDC] -> [0xD0288000], length [0x00006E74], flags [0x00000001]
[DMA5] OK
[DMA5] Copy [0xFFA1BC50] -> [0xD0280000], length [0x000001C0], flags [0x00000001]
[DMA5] OK
[DMA5] Copy [0xFFA1BE10] -> [0x01E80000], length [0x00001A28], flags [0x00000001]
[DMA5] OK
[MPU] Received: 08 06 00 00 04 0c 00 00 (unknown - Complete WaitID)
[MPU] Received: 14 13 09 25 02 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 (unnamed - spell #25)
[MPU] Received: 06 05 03 19 01 00 (PROP_TFT_STATUS - spell #39)
[MPU] Received: 06 04 09 00 00 00 (unknown - PROP_LV_LENS)
[MPU] Received: 06 05 09 0b 02 00 (unknown - PROP_LV_AF_RESULT)
[MPU] Received: 0a 08 09 24 ff ff 00 00 00 00 (unknown - unnamed)
[MPU] Received: 06 05 0e 00 01 00 (unknown - unnamed)
1271: 265.984 [RSC] ###!! Lv or MovieRec (X 48000064)18:0
1272: 265.984 [RSC] ###!! Lv or MovieRec (46000064)
1279: 267.264 [LVDTS] WARN First Get DTS_GetAllRandomData
1280: 267.264 [LVDTS] WARN First Get DTS_GetAllRandomData
1281: 267.520 [LVDTS] WARN First Get DTS_GetAllRandomData
1286: 267.776 [LVDTS] WARN First Get DTS_GetAllRandomData
1287: 267.776 [LVDTS] WARN First Get DTS_GetAllRandomData
1288: 267.776 [LVDTS] WARN First Get DTS_GetAllRandomData
1292: 267.776 [LVDTS] WARN First Get DTS_GetAllRandomData
1293: 267.776 [LVDTS] WARN First Get DTS_GetAllRandomData
1294: 267.776 [LVDTS] WARN First Get DTS_GetAllRandomData
1306: 269.312 [LVDTS] WARN First Get DTS_GetAllRandomData
1307: 269.312 [LVDTS] WARN First Get DTS_GetAllRandomData
1308: 269.312 [LVDTS] WARN First Get DTS_GetAllRandomData
1312: 269.824 [LVDTS] WARN First Get DTS_GetAllRandomData
1325: 270.592 [LVDTS] WARN First Get DTS_GetAllRandomData
1326: 270.848 [LVDTS] WARN First Get DTS_GetAllRandomData
1328: 271.104 [LVDTS] WARN First Get DTS_GetAllRandomData
1329: 271.360 [LVDTS] WARN First Get DTS_GetAllRandomData
1331: 271.616 [LVDTS] WARN First Get DTS_GetAllRandomData
1333: 271.872 [LVICV] LVICV_SetResource Rsc:0 Img:0
1428: 350.720 [TCH]ERROR TouchPanelIC Ack Error
Key event: 32 -> 0001
[MPU] Sending : 06 05 06 00 01 00 (GUI_SWITCH)
[MPU] Received: 06 05 04 00 01 00 (NotifyGUIEvent - spell #46)
[MPU] Sending : 06 05 04 00 01 01 (NotifyGUIEvent)
[MPU] Received: 08 06 00 00 04 00 00 00 (Complete WaitID = 0x80020000 - spell #47)
1468: 1335.552 [MC] guimode comp. 1
1477: 1336.832 [LVDTS] WARN First Get DTS_GetAllRandomData
1482: 1337.856 [LVDTS] WARN First Get DTS_GetAllRandomData
1483: 1338.112 [LVEVF] ERROR [VRAM]VRAM_SDV_SetSenserDriveParameter FrameData==NULL)
1489: 1340.928 [LVICV] LVICV_ReleaseResource
1490: 1340.928 [LVCOM] ERROR [ADST] ADST_ReleaseMemAddrArray(16):Failed
1495: 1341.440 [LVDTS] WARN First Get DTS_GetAllRandomData
1575: 1368.320 [DISP] MuteONImage (1470)
1580: 1368.576 [PTP] PSI DisconnectViewFinder
1583: 1471.744 [LVDTS] WARN First Get DTS_GetAllRandomData
[MPU] Received: 06 05 03 19 00 00 (unknown - PROP_TFT_STATUS)
or, with lua_fix and CONFIG_QEMU=y (keys pressed: L L L, followed by down arrow pressed for 1 second):
./run_canon_fw.sh EOSM,firmware=boot=1 -s -S &
arm-none-eabi-gdb -x EOSM/patches.gdb -ex quit
DebugMsg=0x40D4 (from GDB script)
Lockdown read 0
Lockdown read 0
Lockdown read 1
Lockdown read 1
Lockdown read 2
Lockdown read 2
Lockdown read 3
Lockdown read 3
Lockdown read 4
Lockdown read 4
00000000 - 00000FFF: eos.tcm_code
40000000 - 40000FFF: eos.tcm_data
00001000 - 1FFFFFFF: eos.ram
40001000 - 5FFFFFFF: eos.ram_uncached
F0000000 - F0FFFFFF: eos.rom0
F1000000 - F1FFFFFF: eos.rom0_mirror
F2000000 - F2FFFFFF: eos.rom0_mirror
F3000000 - F3FFFFFF: eos.rom0_mirror
F4000000 - F4FFFFFF: eos.rom0_mirror
F5000000 - F5FFFFFF: eos.rom0_mirror
F6000000 - F6FFFFFF: eos.rom0_mirror
F7000000 - F7FFFFFF: eos.rom0_mirror
F8000000 - F8FFFFFF: eos.rom1
F9000000 - F9FFFFFF: eos.rom1_mirror
FA000000 - FAFFFFFF: eos.rom1_mirror
FB000000 - FBFFFFFF: eos.rom1_mirror
FC000000 - FCFFFFFF: eos.rom1_mirror
FD000000 - FDFFFFFF: eos.rom1_mirror
FE000000 - FEFFFFFF: eos.rom1_mirror
FF000000 - FFFFFFFF: eos.rom1_mirror
C0000000 - DFFFFFFF: eos.iomem
[EOS] loading './EOSM/ROM0.BIN' to 0xF0000000-0xF0FFFFFF
[EOS] loading './EOSM/ROM1.BIN' to 0xF8000000-0xF8FFFFFF
[EOS] loading './EOSM/SFDATA.BIN' as serial flash, size=0x800000
[MPU] warning: non-empty spell #30 (PROP 80030019) has duplicate(s): #34
[MPU] warning: non-empty spell #40 (PROP_VIDEO_MODE) has duplicate(s): #41
[MPU] Available keys:
- Arrow keys : Navigation
- [ and ] : Main dial (top scrollwheel)
- SPACE : SET
- DELETE : guess (press only)
- M : MENU (press only)
- P : PLAY (press only)
- I : INFO/DISP (press only)
- Q : guess
- L : LiveView (press only)
- Shift : Half-shutter
- 0/9 : Mode dial (press only)
- V : Movie mode (press only)
- B : Open battery door
- C : Open card door
- F10 : Power down switch
- F1 : show this help
Setting BOOTDISK flag to FFFFFFFF
0xffff0000 in ?? ()
++macro define CURRENT_TASK ((int)0xFFFFFFFF)
++macro define CURRENT_ISR ((int)0xFFFFFFFF)
++macro define RTC_VALID_FLAG ((int)0xFFFFFFFF)
++macro define NUM_CORES 1
++macro define PRINT_CALLSTACK 0
++macro define MEM(x) (*(unsigned int*)(x))
++set pagination off
++set output-radix 16
++define hook-quit
++define KRED
++define KCYN
++define KBLU
++define KGRN
++define KYLW
++define KRESET
++macro define CURRENT_TASK_NAME (((int*)CURRENT_TASK)[0] ? ((char***)CURRENT_TASK)[0][9] : CURRENT_TASK)
++define print_callstack
++define print_current_location
++define print_current_location_with_callstack
++define print_formatted_string
++define DebugMsg_log
++define DebugMsg1_log
++define printf_log
++define task_create_log
++define task_switch_log
++define msleep_log
++define assert_log
++define assert0_log
++define create_semaphore_log
++define delete_semaphore_log
++define print_sem_name
++define take_semaphore_log
++define give_semaphore_log
++define create_msg_queue_log
++define print_mq_name
++define post_msg_queue_log
++define try_receive_msg_queue_log
++define receive_msg_queue_log
++define register_interrupt_log
++define register_func_log
++define mpu_decode
++define mpu_send_log
++define mpu_recv_log
++define mpu_analyze_recv_data_log
++define prop_lookup_maybe_log
++define mpu_prop_lookup_log
++define prop_print_data
++define prop_request_change_log
++define prop_deliver_log
++define try_expand_ram_struct
++define try_post_event_log
++define delayed_call_print_name
++define delayed_call_log
++define SetTimerAfter_log
++define SetHPTimerAfterNow_log
++define SetHPTimerNextTick_log
++define CancelTimer_log
++define engine_resource_description
++define engine_resources_list
++define CreateResLockEntry_log
++define LockEngineResources_log
++define AsyncLockEngineResources_log
++define UnLockEngineResources_log
++define StartEDmac_log
++define SetEDmac_log
++define print_date_time
++define set_date_time
++define load_default_date_time_log
++define rtc_read_log
++define rtc_write_log
++define CreateStateObject_log
++define state_transition_log
++define log_result
++define generic_log
++define generic_log_with_result
FFFF0800: MCR p15,0,Rd,cr9,cr1,0: XSCALE_LOCK_ICACHE_LINE <- 0x40000006 (40000000 - 40000FFF, 0x1000)
FFFF094C: MRC p15,0,Rd,cr1,cr0,0: SCTLR -> 0x2078
FFFF094C: MCR p15,0,Rd,cr1,cr0,0: SCTLR <- 0x12078
FFFF4604: MCR p15,0,Rd,cr6,cr0,0: 946_PRBS0 <- 0x3F (00000000 - FFFFFFFF, 0x100000000)
FFFF460C: MCR p15,0,Rd,cr6,cr1,0: 946_PRBS1 <- 0x3D (00000000 - 7FFFFFFF, 0x80000000)
FFFF4614: MCR p15,0,Rd,cr6,cr2,0: 946_PRBS2 <- 0xE0000039 (E0000000 - FFFFFFFF, 0x20000000)
FFFF461C: MCR p15,0,Rd,cr6,cr3,0: 946_PRBS3 <- 0xC0000039 (C0000000 - DFFFFFFF, 0x20000000)
FFFF4624: MCR p15,0,Rd,cr6,cr4,0: 946_PRBS4 <- 0xFF00002F (FF000000 - FFFFFFFF, 0x1000000)
FFFF462C: MCR p15,0,Rd,cr6,cr5,0: 946_PRBS5 <- 0x37 (00000000 - 0FFFFFFF, 0x10000000)
FFFF4634: MCR p15,0,Rd,cr6,cr6,0: 946_PRBS6 <- 0xF700002F (F7000000 - F7FFFFFF, 0x1000000)
FFFF463C: MCR p15,0,Rd,cr2,cr0,0: DCACHE_CFG <- 0x70
FFFF4644: MCR p15,0,Rd,cr3,cr0,0: DACR <- 0x70
FFFF4648: MCR p15,0,Rd,cr2,cr0,1: ICACHE_CFG <- 0x70
FFFF464C: MCR p15,0,Rd,cr5,cr0,0: DATA_AP <- 0x3FFF
FFFF4654: MCR p15,0,Rd,cr5,cr0,1: INSN_AP <- 0x3FFF
FFFF4658: MRC p15,0,Rd,cr1,cr0,0: SCTLR -> 0x12078
FFFF4658: MCR p15,0,Rd,cr1,cr0,0: SCTLR <- 0xC001307D
FFFF095C: MCR p15,0,Rd,cr9,cr1,1: XSCALE_UNLOCK_ICACHE <- 0x6 (00000000 - 00000FFF, 0x1000)
FFFF095C: MRC p15,0,Rd,cr1,cr0,0: SCTLR -> 0xC001307D
FFFF095C: MCR p15,0,Rd,cr1,cr0,0: SCTLR <- 0xC005307D
FFFF098C: MRC p15,0,Rd,cr1,cr0,0: SCTLR -> 0xC005307D
FFFF098C: MCR p15,0,Rd,cr1,cr0,0: SCTLR <- 0xC005107D
MID=0xEC(fact_area=0xEC)
SD: CMD12 in a wrong state
[SDIO] Error
SD: CMD12 in a wrong state
[SDIO] Error
SD LOAD OK.
Open file for read : AUTOEXEC.BIN
SD: CMD12 in a wrong state
[SDIO] Error
SD: CMD12 in a wrong state
[SDIO] Error
File size : 0x6BE60
Now jump to AUTOEXEC.BIN!!
0010E408: MRC p15,0,Rd,cr1,cr0,0: SCTLR -> 0xC005107D
0010E408: MCR p15,0,Rd,cr1,cr0,0: SCTLR <- 0xC005107D
[boot] copy_and_restart 0x9e1e0 (647648)
[BOOT] changing user_mem_start from 0x9e1c8 (647624) to 0x11d240 (1167936)
[BOOT] changing init_task from 0xff0c5484 (-15969148) to 0x9e67c (648828)
[BOOT] installing task dispatch hook at 0x3dd60 (253280)
[****] Starting task 9e67c(0) init
[BOOT] expecting armlib to overwrite E5CC8: FBE3A (task id 20002)
[BOOT] autoexec.bin loaded at 9E1E0 - 11D240.
[BOOT] reserved 520288 bytes for ML (used 520288)
K331 READY
64K Sector FROM From BL 0xec
[SF] InstallSerialFlash 4 0xc022c0d4 0x0 0x800000 1
[SF] Bufcon Base 0xc022c0d4
SerialFlash Initialize
[BOOT] E5CC8 now contains 0, restoring FBE3A.
[****] Starting task ff0f34a4(47e82c) Startup
[****] Starting task ff0c357c(0) Startup2
[DMA1] Copy [0xF8099000] -> [0x40540200], length [0x00000F84], flags [0x00030001]
[DMA1] OK
[DMA1] Copy [0xF8F00000] -> [0x40541400], length [0x0001132C], flags [0x00030001]
[DMA1] OK
[****] Starting task ff0c28c8(0) TaskMain
[****] Starting task 22138(47e530) DbgMgr
[EEPROM-DMA]! [0x340000] -> [0x40480000] (0xBD820 bytes)
0: 41.728 [STARTUP]
K331 ICU Firmware Version 2.0.2 ( 9.9.8 )
8: 45.312 [PROPAD] SerialFlash Packages!! 0x340000
[****] Starting task ff341390(0) PowerMgr
[DMA1] Copy [0xF8F60000] -> [0x40561600], length [0x0001AEDC], flags [0x00030001]
[DMA1] OK
[EEPROM-DMA]! [0x340000] -> [0x40480000] (0x0 bytes)
[DMA1] Copy [0xF8060000] -> [0x40581700], length [0x00003B24], flags [0x00030001]
[DMA1] OK
13: 53.760 [PROPAD] SerialFlash Packages!! 0x7
15: 53.760 [PROPAD] PROPAD_CreateFROMPropertyHandle DRAMAddr 0x4fe00000
16: 54.528 [PROPAD] SerialFlash Packages!! 0x10000
[EEPROM-DMA]! [0x10000] -> [0x4FE00000] (0x191570 bytes)
[EEPROM-DMA]! [0x10000] -> [0x4FE00000] (0x0 bytes)
18: 60.928 [PROPAD] SerialFlash Packages!! 0x7
[****] Starting task 22138(5a4750) PropMgr
[MPU] Received: 06 04 02 00 00 00 (Init - spell #1)
[MPU] Sending : 50 4e 02 0e 02 02 01 01 00 00 00 60 00 00 00 19 64 00 00 00 00 21 00 00 06 04 00 00 06 04 00 00 06 04 00 00 00 00 00 00 65 28 00 00 00 00 00 00 00 00 00 00 00 00 80 48 78 48 00 03 03 01 00 00 00 00 02 01 00 00 00 01 00 00 00 00 03 00 01 00 (Mode group)
[****] Starting task ff0d0d68(0) DL
[****] Starting task 22138(5aed88) EventMgr
[****] Starting task ff0cb890(0) HotPlug
22: 62.720 [STARTUP] InitializeIntercom
23: 62.976 [STARTUP] InitializeIntercom End(0x0)
33: 69.632 [DL] dlMain : Start
36: 70.144 [DL] PROP_ACTIVE_SWEEP_MODE (1)
[MPU] Received: 0a 08 03 57 10 33 00 01 00 00 (PROP 8003005E - spell #4)
[MPU] Sending : 24 23 02 0d 00 00 00 00 01 00 00 00 00 01 00 00 00 01 02 00 00 00 00 00 00 00 00 01 00 00 00 00 00 00 00 00 (Card group)
[MPU] Received: 08 06 01 1d 21 84 00 00 (unknown - PROP_PICTURE_STYLE)
[MPU] Received: 08 06 00 00 02 0e 00 00 (Complete WaitID = 0x80000001 Mode group - spell #2)
[MPU] Sending : 28 27 02 0f 01 00 00 10 01 01 00 00 00 00 00 00 00 00 00 00 00 18 00 00 00 0c 00 00 00 00 00 00 00 02 00 00 00 01 01 00 (Movie group)
[MPU] Sending : 3c 3a 02 10 00 00 00 00 00 00 01 00 00 00 00 ff 00 00 ff 00 ff ff ff ff ff ff ff ff 00 00 00 00 00 01 ff 00 00 02 01 01 00 03 00 01 00 04 00 00 01 05 00 01 01 00 01 00 00 3f 00 00 (AF group)
[MPU] Sending : 3e 3c 02 11 01 ff 01 00 01 00 01 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 28 00 ff 00 00 ff 00 ff ff ff ff ff ff ff ff 00 00 00 (AF2 group)
[MPU] Sending : 0a 08 01 6e 80 48 00 00 00 00 (PROP_ISO_RANGE)
[MPU] Sending : 08 06 01 0b 00 00 00 00 (PROP_AEB)
[MPU] Sending : 06 05 01 76 00 00 (PROP_SILENT_CONTROL_SETTING)
[MPU] Sending : 06 05 01 71 00 00 (PROP_AF_METHOD_SELECT_FOCUS_AREA)
[MPU] Sending : 06 05 01 7e 00 00 (PROP_GPS_COMPAS_SELECT)
[MPU] Sending : 06 05 01 7c 00 00 (PROP_GPS_AUTO_TIME_SETTING)
[MPU] Sending : 0a 08 01 85 00 00 00 01 00 00 (PROP_GIS_SETTING)
[MPU] Sending : 08 06 01 47 0a 02 00 00 (PROP_SELFTIMER_CONTINUOUS_NUM)
[MPU] Sending : 06 05 01 7b 01 00 (PROP_CONTINUOUS_AF)
[MPU] Sending : 08 06 01 57 00 00 00 00 (PROP_BUILTIN_STROBO_MODE)
[MPU] Sending : 06 05 01 86 00 00 (PROP 8004004A)
[MPU] Sending : 06 05 01 87 00 00 (PROP 8004004B)
[MPU] Sending : 06 05 01 8d 00 00 (PROP 80040050)
[MPU] Sending : 06 05 01 8e 00 00 (PROP_GPSLOG_SETTING)
[MPU] Sending : 10 0e 01 8f 00 00 00 00 00 00 00 00 00 00 00 00 (PROP_LV_CFILTER)
[MPU] Sending : 06 05 01 90 00 00 (PROP_WIFI_SETTING)
[MPU] Sending : 06 05 01 8b 00 00 (PROP 8004004E)
[MPU] Sending : 08 06 01 91 00 00 00 00 (PROP_BUILTINGPS_PINPOINTING_INTERVAL_SETTING)
[MPU] Sending : 06 05 01 98 00 00 (PROP 80040056)
[MPU] Sending : 08 06 01 88 07 08 00 00 (PROP 8000004F)
[MPU] Sending : 06 05 03 37 00 00 (PROP_MIRROR_DOWN_IN_MOVIE_MODE)
[MPU] Sending : 06 05 01 92 07 00 (PROP_IMAGE_ASPECT_RATIO)
[MPU] Sending : 0e 0c 02 04 08 00 00 00 00 00 00 01 00 00 (PROP_CFN)
[MPU] Sending : 0a 08 03 58 00 00 00 00 00 00 (PROP 8003005F)
[MPU] Sending : 06 05 03 5a 02 00 (PROP 80030060)
[MPU] Sending : 16 14 01 61 00 09 d1 3e 00 00 00 00 ff e7 ff ff 00 0a 26 fe 00 00 (PROP 80040027)
[****] Starting task 22138(5af3b0) FileMgr
[****] Starting task 22138(6cfcc0) FileCache
[****] Starting task 22138(6d00c0) RscMgr
[MPU] Sending : 0a 08 03 2f 00 00 00 00 00 00 (PROP_SPECIAL_OPTION)
[MPU] Received: 0a 08 03 06 00 00 00 00 00 00 (PROP_AVAIL_SHOT - spell #5)
[MPU] Sending : 0a 08 03 2f 00 00 00 00 00 00 (PROP_SPECIAL_OPTION)
[MPU] Received: 06 04 03 10 00 00 (PROP 80030008 - spell #6)
[MPU] Sending : 06 05 03 20 01 00 (PROP_STARTUP_CONDITION)
[MPU] Received: 06 05 03 07 ff 00 (PROP_BURST_COUNT - spell #7)
[MPU] Sending : 0c 0b 03 42 00 00 00 00 00 00 00 00 (PROP_LED_LIGHT)
[MPU] Sending : 62 61 02 12 01 20 50 00 f0 00 11 00 37 91 77 1a 00 00 ff 00 00 00 00 00 00 00 01 f8 96 00 00 00 00 00 00 01 f8 96 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 23 43 23 00 00 00 00 00 00 00 10 31 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 (Lens group)
[MPU] Received: 06 05 01 2e 01 00 (PROP_SAVE_MODE - spell #8)
[****] Starting task 21a30(6d4554) ShootCapture
[MPU] Received: 0a 08 03 0b 00 00 00 00 00 00 (PROP 80030007 - spell #9)
[DMA5] Copy [0xFF892D90] -> [0x01E00000], length [0x00065BD4], flags [0x00000001]
[DMA5] OK
[MPU] Sending : 06 05 03 05 02 00 (PROP_POWER_LEVEL)
[MPU] Sending : 06 05 04 06 05 00 (PROP_DEFAULT_LV_MANIP)
[MPU] Sending : 06 05 01 97 00 01 (PROP 8003006F)
[MPU] Sending : 06 05 04 06 05 00 (PROP_DEFAULT_LV_MANIP)
[MPU] Sending : 06 05 01 2e 01 00 (PROP_SAVE_MODE)
[MPU] Sending : 06 05 04 06 05 00 (PROP_DEFAULT_LV_MANIP)
[****] Starting task ff4166fc(0) systemtask
[****] Starting task 21a30(6e9ab0) ShootBlack
[****] Starting task 21a30(6ee410) ShootPreDevelop
[****] Starting task 22138(6ee664) SAF
[MPU] Received: 08 06 00 00 01 97 00 00 (Complete WaitID = 0x8003006F PROP 8003006F - spell #3)
[MPU] Sending : 06 05 04 06 05 00 (PROP_DEFAULT_LV_MANIP)
[****] Starting task 22138(6ee6b4) SAF_CROSSTALK
[****] Starting task ff0cee8c(0) MainCtrl
[MPU] Received: 22 20 03 3b 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 (unnamed - spell #10)
[MPU] Received: 06 05 04 0e 01 00 (PROP 8002000D - spell #11)
[****] Starting task 21a30(6ef0e4) TOMgr
[****] Starting task 21a30(6f0298) Fstorage
[****] Starting task 22138(6f1510) HDRMgr
[****] Starting task 21a30(6f1698) HDRStage
[****] Starting task 22138(6f3b14) GISMgr
[****] Starting task 21a30(6f3ca8) GISStage
[****] Starting task ff144e74(0) AEmodeJudge
[****] Starting task ff4f550c(0) CSMgrTask
104: 64.512 [RSC] hMemoryQueue (0xA20012) hStorageQueue (0xA40014)
105: 65.792 [RSC] ### LIST 5 0 5 ###
170: 79.616 [SND] Seq LPC fin
196: 81.152 [ENG] [ENGIO](Addr:0x41400000, Data:0x 44000)
212: 93.696 [FM] FM_RegisterSpaceNotifyCallback
216: 93.952 [AUDIO] [GPS] GPS_RegisterSpaceNotifyCallback
220: 93.952 [FM] FM_RegisterSpaceNotifyCallback
222: 94.208 [TERMINATE] SHUTDOWN init comp
224: 94.208 [TERMINATE] Abort init comp
256: 97.536 [MC] [MC] PROP_HEADPHONE_VOLUME_VALUE : 0
257: 97.536 [MC] [MC] PROP_MOVIE_PLAY_VOLUME : 10
262: 98.048 [MC] regist master CardCover
[MPU] Received: 08 07 01 2a 1b e6 00 00 (PROP_CARD2_FILE_NUMBER - spell #12)
[****] Starting task 21a30(6f653c) FrontShtDevelop
[****] Starting task 21a30(6f68b0) DianaFrontShtDevelop
[MPU] Received: 06 05 03 07 05 00 (PROP_BURST_COUNT - spell #13)
[****] Starting task 21a30(6f6d08) RearShtDevelop
[****] Starting task 21a30(6f6eec) DianaRearShtDevelop
[****] Starting task 21a30(6f7138) ShootSsDevelop
[****] Starting task 21a30(6f74b0) ShootVfx
[MPU] Received: 0a 08 03 06 00 00 04 56 00 00 (unknown - PROP_AVAIL_SHOT)
[MPU] Received: 06 05 03 11 01 00 (PROP_ICU_AUTO_POWEROFF - spell #15)
[MPU] Received: 06 05 02 0a 00 00 (PROP_PERMIT_ICU_EVENT - spell #16)
[MPU] Sending : 06 05 01 2c 02 00 (PROP_CURRENT_MEDIA)
[MPU] Received: 06 05 03 0d 00 00 (PROP_CARD2_RECORD - spell #17)
[MPU] Sending : 12 10 03 00 b8 00 00 3a 07 00 00 00 00 00 00 00 00 00 (PROP 80030000)
[MPU] Received: 06 05 03 0c 00 00 (PROP_CARD1_RECORD - spell #18)
[MPU] Sending : 06 05 03 23 19 00 (unnamed)
[MPU] Sending : 06 05 03 04 00 00 (PROP_POWER_KIND)
[MPU] Sending : 1e 1d 03 24 45 46 2d 53 31 37 2d 35 35 6d 6d 20 66 2f 32 2e 38 20 49 53 20 55 53 4d 00 00 (PROP_LENS_NAME)
[****] Starting task ff0d8260(0) GuiLockTask
306: 112.640 [PRP] M:B8 F:0 L:0 P:3A T:7
307: 112.896 [STARTUP] update coded version.
[MPU] Received: 06 05 03 19 01 00 (PROP_TFT_STATUS - spell #19)
[MPU] Sending : 06 04 03 25 00 00 (unnamed)
[MPU] Sending : 24 23 03 15 01 20 50 00 f0 00 11 00 37 91 77 1a 00 00 ff 00 00 00 00 00 00 00 01 f8 96 00 00 00 00 21 00 00 (PROP_LENS)
[MPU] Sending : 24 22 03 3c 00 00 01 f8 96 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 (PROP 8003003C)
[MPU] Sending : 06 05 03 5d 8e 00 (PROP 80030062)
[MPU] Sending : 24 23 03 15 01 20 50 00 f0 00 11 00 37 91 77 1a 00 00 ff 00 00 00 00 00 00 00 01 f8 96 00 00 00 00 21 00 00 (PROP_LENS)
[MPU] Sending : 06 05 01 3d 00 00 (PROP_TEMP_STATUS)
[MPU] Sending : 06 05 03 37 00 00 (PROP_MIRROR_DOWN_IN_MOVIE_MODE)
[MPU] Sending : 06 05 04 06 05 00 (PROP_DEFAULT_LV_MANIP)
[MPU] Sending : 06 05 03 0d 00 00 (PROP_CARD2_RECORD)
[MPU] Sending : 06 05 03 0c 00 00 (PROP_CARD1_RECORD)
[****] Starting task 22138(726c5c) ASIF
[****] Starting task 22138(726dac) AudioCtrl
[****] Starting task 22138(72b5f0) SoundEffect
[****] Starting task 22138(72c400) MovWriter
[****] Starting task 22138(72caf8) MovieRecorder
[****] Starting task 22138(744124) MoviePlay
[****] Starting task ff1e6754(0) AviRead
[****] Starting task 22138(74441c) MovReader
[****] Starting task 22138(7446b4) LVC_DEV
[****] Starting task ff0f99a8(0) LVC_FACE
[****] Starting task 22138(7456dc) Gmt
[MPU] Received: 06 05 09 11 01 00 (PROP_LV_DISPSIZE - spell #20)
[MPU] Received: 12 11 09 15 00 00 00 00 00 00 00 00 00 00 00 00 00 00 (PROP 80050020 - spell #21)
[MPU] Received: 14 13 09 25 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 (unnamed - spell #22)
[MPU] Received: 06 05 01 5a 00 00 (PROP_CONTINUOUS_AF_VALID - spell #23)
[MPU] Received: 06 05 09 2f 01 00 (unnamed - spell #24)
[MPU] Sending : 06 05 01 59 01 00 (PROP_MOVIE_SERVO_AF)
[****] Starting task 22138(75c320) Evf
[MPU] Received: 14 13 09 25 02 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 (unnamed - spell #25)
[MPU] Received: 06 05 01 5a 01 00 (PROP_CONTINUOUS_AF_VALID - spell #26)
[MPU] Sending : 06 05 01 59 01 00 (PROP_MOVIE_SERVO_AF)
[****] Starting task 22138(767838) Epp
[****] Starting task 22138(76add8) LVFACE
[****] Starting task 22138(76b04c) LVICV
[****] Starting task 22138(76b2e8) CLR_CALC
[****] Starting task 22138(76cbd4) AeWb
[MPU] Received: 0a 08 09 1a 00 00 00 00 00 00 (PROP 8005002A - spell #27)
[MPU] Received: 0a 08 09 24 00 00 00 00 00 00 (unnamed - spell #28)
[MPU] Received: 08 06 03 18 00 00 00 00 (PROP 8003000F - spell #29)
[MPU] Received: 08 06 03 1f 00 00 00 00 (PROP 80030019 - spell #30)
[MPU] Sending : 06 05 01 58 00 00 (PROP_VIDEOSNAP_MODE)
[MPU] Received: 06 05 03 13 00 00 (PROP_LOGICAL_CONNECT - spell #31)
[MPU] Received: 06 05 03 1e 00 00 (PROP 8003001A - spell #32)
[MPU] Received: 06 05 01 8a 00 00 (PROP_SW2_MOVIE_START - spell #33)
[MPU] Received: 08 06 03 1f 00 00 00 00 (PROP 80030019 - spell #34)
[MPU] Sending : 06 05 01 8a 00 00 (PROP_SW2_MOVIE_START)
[MPU] Received: 0a 08 01 3b ff ff 00 00 00 00 (PROP_USBDEVICE_CONNECT - spell #35)
[MPU] Received: 0a 08 01 3b ff 00 00 00 00 00 (PROP_USBDEVICE_CONNECT - spell #36)
[MPU] Sending : 06 05 03 38 8f 00 (PROP 80030035)
[****] Starting task ff10cd40(0) SoundDevice
[****] Starting task 22138(72b4f4) AudioLevel
[****] Starting task ff203358(0) TestGero
[****] Starting task 21a30(787d8c) GaUSB20Drv
[****] Starting task ff285ae8(0) USBTrns
[****] Starting task ff28757c(0) SDIOTrns
[****] Starting task ff283c10(78a908) PTPSessionTASK
[****] Starting task 21a30(7ab800) PtpDps
[****] Starting task 22138(806bf8) Ceres
[****] Starting task 21a30(80b554) Remote
[****] Starting task 21a30(82a498) Fcreate
351: 88.576 [MR] mvrChangeAckCBR : Video - Mode=0, Type=0, Rate=24, GOP=12
394: 96.768 [LVDTS] WARN First Get DTS_GetAllRandomData
395: 96.768 [LVDTS] WARN First Get DTS_GetAllRandomData
403: 98.304 SPECIAL_OPTION AF MOVIE GERO OFF
409: 98.816 [LVDTS] WARN First Get DTS_GetAllRandomData
410: 98.816 [LVDTS] WARN First Get DTS_GetAllRandomData
411: 98.816 [LVDTS] WARN First Get DTS_GetAllRandomData
414: 98.816 [LVDTS] WARN First Get DTS_GetAllRandomData
415: 98.816 [LVDTS] WARN First Get DTS_GetAllRandomData
417: 98.816 [LVDTS] WARN First Get DTS_GetAllRandomData
418: 98.816 [LVDTS] WARN First Get DTS_GetAllRandomData
423: 99.072 [LVDTS] WARN First Get DTS_GetAllRandomData
424: 99.072 [LVDTS] WARN First Get DTS_GetAllRandomData
425: 99.328 [LVDTS] WARN First Get DTS_GetAllRandomData
426: 99.328 [LVGMT] PROP_LV_PROHIBIT_OUTPUT 0 0
427: 99.328 [LVDTS] WARN First Get DTS_GetAllRandomData
429: 99.328 [LVGMT] PROP_LV_CFILTER[0][0]
430: 99.328 [LVGMT] PROP_LV_CENTER_OF_DIORAM_CFILTER[2684][1793]
434: 100.096 [LVDTS] WARN First Get DTS_GetAllRandomData
435: 100.096 [LVDTS] WARN First Get DTS_GetAllRandomData
444: 102.144 [LVCOM] InitializeLiveViewDefectDetection
445: 102.656 [LVCOM] ExecuteDefectMarge Start
446: 102.912 [LVCOM] ExecuteDefectMarge End
450: 103.168 [LVDTS] WARN First Get DTS_GetAllRandomData
451: 103.168 [LVDTS] WARN First Get DTS_GetAllRandomData
465: 108.544 [AF] Ratio:30 Reboot:2 !!!
467: 108.544 [LV] PROP_LV_BLOCK PROP_LV_UNBLOCKING 0
478: 112.384 [AUDIO] RegisterCBRSDIOCableConnect
506: 116.480 [WFT] PROP_ADAPTER_DEVICE_ACTIVE: Can Not Change(0) Connect(0)
544: 121.600 [PTP] PSI UnlockTransImg : Trans List is NULL
545: 121.856 [PTP] PSI TarminateTransImgList : SessionTarget [1]
546: 121.856 [PTP] PSI TarminateTransImgList : Trans List is NULL
549: 121.856 [PTP] PSI UnlockTransImg : Trans List is NULL
550: 121.856 [PTP] PSI TarminateTransImgList : SessionTarget [10]
551: 121.856 [PTP] PSI TarminateTransImgList : Trans List is NULL
553: 122.112 [PTP] PSI DisconnectViewFinder
560: 122.624 [PTP] PROP_SCREEN_SAVER 0
563: 122.624 [PTPCOM] SetPtpTransportResources:0,323d
565: 122.880 [PTP] PSI UnlockTransImg : Trans List is NULL
566: 122.880 [PTP] PSI TarminateTransImgList : SessionTarget [10]
567: 122.880 [PTP] PSI TarminateTransImgList : Trans List is NULL
597: 125.440 [WFT] Regist PropCBR PROP_WFT_BLUETOOTH
SD: Unknown CMD1
[SDIO] Error
SD: Unknown CMD1
[SDIO] Error
SD: Unknown CMD1
[SDIO] Error
630: 155.648 [SD] ERROR SDINTREP=0x00000000
631: 155.648 [SD] ERROR UNEXPECTED ERROR
658: 187.392 [FM] FileNo (DriveNo = 2, 0 <-> 7142)
659: 187.392 [FM] FreeCluster (DriveNo = 2, 11628 <-> 932093)
[MPU] Received: 0a 08 03 06 00 00 00 0b 00 00 (unknown - PROP_AVAIL_SHOT)
[****] Starting task 21a30(8b4da4) Fwrite
[****] Starting task 22138(8b550c) Sound
[MPU] Received: 08 07 01 2a 1b e6 00 00 (PROP_CARD2_FILE_NUMBER - spell #37)
[MPU] Received: 08 07 01 2a 1b e6 00 00 (PROP_CARD2_FILE_NUMBER - spell #37)
[****] Starting task 21a30(8b4b58) Fread
[****] Starting task 22138(8b52c8) Voice
[****] Starting task 22138(8b5624) WavReader
[****] Starting task 22138(8b5b08) Gps
[****] Starting task 21a30(8cfb9c) ShootArtFilter
[****] Starting task 22138(944a6c) TouchMgr
[****] Starting task 22138(944c48) DisplayMgr
[****] Starting task ff0d72a0(0) GuiMainTask
[****] Replacing task ff0d72a0 with ac6b0
[****] Starting task ff239654(0) ImgPlayDrv
[****] Starting task ff327478(0) CtrlSrv
[MPU] Received: 06 05 03 19 01 00 (PROP_TFT_STATUS - spell #39)
[****] Starting task 22138(8cc94c) ReDevelop
[****] Starting task 22138(8cc9f0) DpMgr
[****] Starting task ff24ede0(0) DpsReceiveTask
[****] Starting task 22138(8cecc8) DpImgEditMgr
[****] Starting task 22138(8ceeec) InnerDevelopMgr
[****] Starting task 22138(945cd4) CEC
[****] Starting task ff31ba90(0) EyeFi
[MPU] Received: 1e 1c 01 4e 00 00 00 00 00 00 00 00 00 00 00 18 00 00 00 0c 00 00 00 00 00 00 00 02 00 00 (PROP_VIDEO_MODE - spell #40)
[MPU] Sending : 1e 1c 01 4e 00 00 00 00 00 00 00 00 00 00 00 18 00 00 00 0c 00 00 00 00 00 00 00 02 00 00 (PROP_VIDEO_MODE)
[MPU] Received: 1e 1c 01 4e 00 00 00 00 00 00 00 00 00 00 00 18 00 00 00 0c 00 00 00 00 00 00 00 02 00 00 (PROP_VIDEO_MODE - spell #40)
[MPU] Sending : 06 05 01 53 01 00 (PROP_AF_DURING_RECORD)
[MPU] Received: 06 05 03 19 01 00 (PROP_TFT_STATUS - spell #42)
[MPU] Sending : 06 05 01 58 00 00 (PROP_VIDEOSNAP_MODE)
[MPU] Received: 06 05 03 19 01 00 (PROP_TFT_STATUS - spell #42)
[MPU] Sending : 06 05 01 59 01 00 (PROP_MOVIE_SERVO_AF)
[MPU] Received: 06 05 02 0a 01 00 (PROP_PERMIT_ICU_EVENT - spell #44)
[MPU] Sending : 06 05 01 49 01 00 (PROP_LIVE_VIEW_AF_SYSTEM)
[MPU] Received: 06 05 03 19 01 00 (PROP_TFT_STATUS - spell #45)
[MPU] Sending : 1e 1c 01 4e 00 00 00 00 00 00 00 00 00 00 00 18 00 00 00 0c 00 00 00 00 00 00 00 02 00 00 (PROP_VIDEO_MODE)
[****] Starting task ff492674(0) PTPtoFAPI_EventProcTask
[****] Starting task 22138(8cc42c) Mrk
[MPU] Received: 06 05 04 00 00 00 (NotifyGUIEvent - spell #46)
[****] Starting task 22138(847454) MetaCtg
[****] Starting task ff1df3b8(0) LpfMode
699: 194.816 [FM] [GPS] GPS_Initialize (36, 25)
775: 201.472 [DP] LOGICAL_CONNECT [0x00000000]
777: 201.728 [PROPAD] ERROR GetPropertyData ID (0) = 0x02050038
778: 201.728 [PRP] ERROR NOT FOUND PROPERTY ID = 0x02050038 L:2411
779: 201.728 [DP] PROP_WIFI_SETTING [0]
799: 207.104 WARN localI2C_Read : 377
800: 207.360 WARN localI2C_Read : 377
801: 207.616 WARN localI2C_Read : 377
802: 208.128 WARN localI2C_Read : 377
803: 208.384 WARN localI2C_Read : 377
804: 208.896 WARN localI2C_Read : 377
805: 208.896 [HDMI] cec_initialize_reg_set : END
806: 209.408 WARN localI2C_Read : 377
807: 209.664 WARN localI2C_Read : 377
808: 210.176 WARN localI2C_Read : 377
809: 210.176 [HDMI] Logical Address Set : End
810: 210.176 [HDMI] CEC DEVICE SETUP
811: 210.688 [HDMI] InitializeHDMI
818: 221.440 [IMPP] H264E InitializeH264EncodeFor1080pDZoom
819: 221.696 [IMPP] H264E InitializeH264EncodeFor1080p25fpsDZoom
1054: 242.688 [MR_MOV] (Empty Func) MVW_RegisterXmpDataCallback
1068: 243.200 [HDMI] CEC OFF
1086: 244.224 [STARTUP] startupInitializeComplete
1089: 244.480 [MC] guimode comp. 0
1104: 244.992 [MC] guimode comp. 0
1152: 249.344 [MR] mvrChangeAckCBR : Video - Mode=0, Type=0, Rate=24, GOP=12
1160: 251.648 [LVDTS] WARN First Get DTS_GetAllRandomData
1161: 251.648 [LVDTS] WARN First Get DTS_GetAllRandomData
[MPU] Received: 08 06 04 0c 03 00 00 00 (PROP_SHOOTING_TYPE - spell #53)
[MPU] Received: 06 05 03 1d 1f 00 (unknown - PROP_BATTERY_REPORT)
[MPU] Sending : 06 05 01 53 01 00 (PROP_AF_DURING_RECORD)
[MPU] Received: 06 05 08 06 ff 00 (unknown - COM_FA_CHECK_FROM)
1179: 264.192 [MR] mvrChangeAckCBR : Video - Mode=0, Type=0, Rate=24, GOP=12
[MPU] Sending : 06 05 01 58 00 00 (PROP_VIDEOSNAP_MODE)
[MPU] Sending : 06 05 01 59 01 00 (PROP_MOVIE_SERVO_AF)
1186:[MPU] Sending : 06 05 01 49 01 00 (PROP_LIVE_VIEW_AF_SYSTEM)
267.264 [LVDTS] WARN First Get DTS_GetAllRandomData
1187: 267.264 [LVDTS] WARN First Get DTS_GetAllRandomData
[MPU] Sending : 06 05 06 11 01 00 (GUI_SWITCH)
[MPU] Sending : 06 05 06 12 00 00 (GUI_SWITCH)
[MPU] Sending : 46 45 0a 08 ff 1f 01 00 00 00 00 00 00 00 01 03 50 20 28 01 01 00 60 04 01 04 87 00 00 00 00 00 00 01 01 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 (PD_NotifyOlcInfoChanged)
[MPU] Sending : 08 06 01 04 00 00 00 00 (PROP_AF_MODE)
[MPU] Sending : 06 05 03 37 00 00 (PROP_MIRROR_DOWN_IN_MOVIE_MODE)
[MPU] Sending : 06 05 04 00 00 01 (NotifyGUIEvent)
[MPU] Sending : 08 06 04 0c 03 00 01 00 (PROP_SHOOTING_TYPE)
1233: 282.368 [MC] guimode comp. 0
[MPU] Received: 08 06 00 00 04 00 00 00 (Complete WaitID = 0x80020000 - spell #47)
[MPU] Received: 06 05 03 19 01 00 (PROP_TFT_STATUS - spell #56)
[MPU] Received: 06 04 04 13 00 00 (unknown - PROP 80020012)
[DMA5] Copy [0xFFA14DDC] -> [0xD0288000], length [0x00006E74], flags [0x00000001]
[DMA5] OK
[DMA5] Copy [0xFFA1BC50] -> [0xD0280000], length [0x000001C0], flags [0x00000001]
[DMA5] OK
[DMA5] Copy [0xFFA1BE10] -> [0x01E80000], length [0x00001A28], flags [0x00000001]
[DMA5] OK
[MPU] Received: 08 06 00 00 04 0c 00 00 (unknown - Complete WaitID)
[MPU] Received: 14 13 09 25 02 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 (unnamed - spell #25)
[MPU] Received: 06 05 03 19 01 00 (PROP_TFT_STATUS - spell #39)
[MPU] Received: 06 04 09 00 00 00 (unknown - PROP_LV_LENS)
[MPU] Received: 06 05 09 0b 02 00 (unknown - PROP_LV_AF_RESULT)
[MPU] Received: 0a 08 09 24 ff ff 00 00 00 00 (unknown - unnamed)
[MPU] Received: 06 05 0e 00 01 00 (unknown - unnamed)
1274: 285.696 [RSC] ###!! Lv or MovieRec (X 48000064)18:0
1275: 285.952 [RSC] ###!! Lv or MovieRec (46000064)
1282: 286.720 [LVDTS] WARN First Get DTS_GetAllRandomData
1283: 286.720 [LVDTS] WARN First Get DTS_GetAllRandomData
1284: 286.720 [LVDTS] WARN First Get DTS_GetAllRandomData
1289: 286.976 [LVDTS] WARN First Get DTS_GetAllRandomData
1290: 286.976 [LVDTS] WARN First Get DTS_GetAllRandomData
1291: 286.976 [LVDTS] WARN First Get DTS_GetAllRandomData
1295: 287.232 [LVDTS] WARN First Get DTS_GetAllRandomData
1296: 287.232 [LVDTS] WARN First Get DTS_GetAllRandomData
1297: 287.232 [LVDTS] WARN First Get DTS_GetAllRandomData
1307: 288.512 [LVDTS] WARN First Get DTS_GetAllRandomData
1308: 288.512 [LVDTS] WARN First Get DTS_GetAllRandomData
1309: 288.512 [LVDTS] WARN First Get DTS_GetAllRandomData
1313: 289.024 [LVDTS] WARN First Get DTS_GetAllRandomData
1326: 289.792 [LVDTS] WARN First Get DTS_GetAllRandomData
1327: 290.048 [LVDTS] WARN First Get DTS_GetAllRandomData
1329: 290.304 [LVDTS] WARN First Get DTS_GetAllRandomData
1330: 290.560 [LVDTS] WARN First Get DTS_GetAllRandomData
1332: 291.072 [LVDTS] WARN First Get DTS_GetAllRandomData
1334: 291.328 [LVICV] LVICV_SetResource Rsc:0 Img:0
[****] Starting task 9ecb4(0) ml_init
1430: 369.920 [TCH]ERROR TouchPanelIC Ack Error
Lens moving (0, 0)
[****] Starting task 9ea30(0) ml_backup
[****] Starting task a6578(0) menu_task
[****] Starting task a911c(0) menu_redraw_task
[****] Starting task b2110(0) bitrate_task
[****] Starting task bd604(0) focus_task
[****] Starting task bdfe0(0) notifybox_task
[****] Starting task c10e4(0) fps_task
[****] Starting task c82f8(0) shoot_task
[****] Starting task c4c38(0) clock_task
[****] Starting task cedbc(0) audio_common_task
[****] Starting task d59d4(0) livev_hiprio_task
[****] Starting task d4744(0) cls_task
[****] Starting task e0588(0) console_task
[****] Starting task ab7b4(0) debug_task
[****] Starting task b337c(0) tweak_task
[****] Starting task bde24(0) focus_misc_task
[****] Starting task ca43c(0) vignetting_init
[****] Starting task e5d14(0) module_task
[****] Starting task d5570(0) livev_loprio_task
Scanning modules...
Load modules...
Linking..
Register modules...
Load configs...
Init modules...
Updating symbols...
[i] 404: edmac_format_size 9fb90
[i] 404: edmac_format_size a1ea0
[i] 404: edmac_format_size aab70
[i] 404: edmac_format_size ac630
[i] 404: dual_iso_get_recovery_iso b4e80
[i] 404: dual_iso_is_active b4e80
[i] 404: auto_ettr_intervalometer_wait c1bf0
[i] 404: auto_ettr_intervalometer_warning c1bf0
[i] 404: auto_ettr_export_correction cc820
[i] 404: dual_iso_get_dr_improvement db2e0
[i] 404: dual_iso_get_recovery_iso db2e0
[i] 404: edmac_format_size df9c0
Modules loaded
updating Movie Tweaks -> Movie Logging
updating Movie Tweaks -> Time Indicator
Key event: 26 -> 2701
[MPU] Sending : 06 05 06 27 01 00 (GUI_SWITCH)
Key event: 26 -> 2701
[MPU] Sending : 06 05 06 27 01 00 (GUI_SWITCH)
[MPU] Received: 08 06 04 0c 00 00 00 00 (PROP_SHOOTING_TYPE - spell #53)
[MPU] Sending : 08 06 04 0c 00 00 01 00 (PROP_SHOOTING_TYPE)
[MPU] Received: 06 05 04 00 00 00 (NotifyGUIEvent - spell #46)
[MPU] Sending : 06 05 04 00 00 01 (NotifyGUIEvent)
[MPU] Received: 08 06 00 00 04 0c 00 00 (unknown - Complete WaitID)
[MPU] Received: 06 05 03 19 01 00 (PROP_TFT_STATUS - spell #56)
[MPU] Received: 06 05 03 19 01 00 (PROP_TFT_STATUS - spell #56)
[MPU] Received: 06 05 04 00 00 00 (NotifyGUIEvent - spell #46)
[MPU] Sending : 06 05 04 00 00 01 (NotifyGUIEvent)
[MPU] Received: 08 06 04 0c 03 00 00 00 (PROP_SHOOTING_TYPE - spell #53)
[MPU] Sending : 08 06 04 0c 03 00 01 00 (PROP_SHOOTING_TYPE)
[MPU] Received: 06 04 04 13 00 00 (unknown - PROP 80020012)
[MPU] Received: 06 05 03 19 01 00 (PROP_TFT_STATUS - spell #56)
[MPU] Received: 06 05 03 19 01 00 (PROP_TFT_STATUS - spell #56)
[MPU] Received: 06 05 03 19 00 00 (unknown - PROP_TFT_STATUS)
Key event: 26 -> 2701
[MPU] Sending : 06 05 06 27 01 00 (GUI_SWITCH)
[MPU] Received: 08 06 04 0c 00 00 00 00 (PROP_SHOOTING_TYPE - spell #53)
[MPU] Sending : 08 06 04 0c 00 00 01 00 (PROP_SHOOTING_TYPE)
[MPU] Received: 06 05 04 00 00 00 (NotifyGUIEvent - spell #46)
[MPU] Sending : 06 05 04 00 00 01 (NotifyGUIEvent)
[MPU] Received: 06 05 03 19 01 00 (PROP_TFT_STATUS - spell #56)
[MPU] Received: 06 05 03 19 01 00 (PROP_TFT_STATUS - spell #56)
[MPU] Received: 06 05 03 19 01 00 (PROP_TFT_STATUS - spell #56)
[MPU] Received: 06 05 03 19 01 00 (PROP_TFT_STATUS - spell #56)
[MPU] Received: 06 05 04 00 00 00 (NotifyGUIEvent - spell #46)
[MPU] Sending : 06 05 04 00 00 01 (NotifyGUIEvent)
[MPU] Received: 08 06 04 0c 03 00 00 00 (PROP_SHOOTING_TYPE - spell #53)
[MPU] Sending : 08 06 04 0c 03 00 01 00 (PROP_SHOOTING_TYPE)
[MPU] Received: 06 04 04 13 00 00 (unknown - PROP 80020012)
[MPU] Received: 06 05 03 19 01 00 (PROP_TFT_STATUS - spell #56)
[MPU] Received: 06 05 03 19 01 00 (PROP_TFT_STATUS - spell #56)
[MPU] Received: 06 05 03 19 00 00 (unknown - PROP_TFT_STATUS)
Default raw buffer OK for 0x727 (0).
raw update from livev_hiprio_task
LV RAW size too small
Key event: 50 -> 1901
[MPU] Sending : 06 05 06 19 01 00 (GUI_SWITCH)
[MPU] Received: 06 05 04 00 06 00 (NotifyGUIEvent - spell #46)
[MPU] Sending : 06 05 04 00 06 01 (NotifyGUIEvent)
Key event: d0 -> 1900
[MPU] Sending : 06 05 06 19 00 00 (GUI_SWITCH)
Log diff.
The ROM is from you:
700154260069474f478dc4904862e4de EOSM/ROM1.BIN
a3eefdfb3f9ed2ab4516423866e56b64 EOSM/SFDATA.BIN
Some messages are in different order; this may indicate a race condition. One way to diagnose these is to run in deterministic emulation mode, with -icount (try -icount 1, -icount 2 ... -icount 10). That way, if we both run with -icount 5, we should get the same execution trace (repeatable). By default, the execution is not deterministic; it just tries to mimic the real-time clock to some extent, and depends a lot on the host CPU speed.
Here, all -icount settings from 1 to 15 are working well; the last ones are too slow to be practical. Try one of them. Unfortunately, we can't set intermediate values, so the issue is hard to debug.
A similar issue happens on 6D: different CPU speeds between my local machine and the build server cause the menu navigation test to pass nearly all the time on mine, and fail (with only one screenshot slightly different, but repeatable) on the server.
Got another suggestion: spell #4 is not recognized in your log. What if you change it in mpu_spells/EOSM.h?
- { { 0x0a, 0x08, 0x03, 0x57, 0x10, 0x33, 0x00, 0x01, 0x00 }, .description = "PROP 8003005E", .out_spells = { /* spell #4 */
+ { { 0x0a, 0x08, 0x03, 0x57, ARG0, ARG1, 0x00, 0x01, 0x00 }, .description = "PROP 8003005E", .out_spells = { /* spell #4 */
That change would match any argument for that property. Our emulated MPU waits for this property in order to send properties 8003005F and 80030060 (whatever these do, I have no idea); yours property 8003005E is set to 0x31. That must be a setting from Canon menu.
edit: maybe not?
FF0F5280:
DebugMsg(129, 3, "PROP_RequestChange PROP_LEO_LENSID 0x%lx Tender 0x%x Ver 0x%x", v6);
prop_request_change(0x8003005E, &v6, 4);
known_spells.py:
"03 57" : (0x8003005E, "PROP_LEO_LENSID", (4, "ARG0"), (5, "ARG1")),
"03 58" : (0x8003005F, "PROP_LEO_LENS_START"),
"03 5a" : (0x80030060, "PROP_LEO_LENS_END"),
Fix committed, let's hope it works
