2.0.3 status update
Trammell Hudson
firmware dump and haven't even started on the new AK4646 audio code.
There must be a better way to find the functions that Magic Lantern
depends on in Canon's firmware images. Where is msleep()? How did
I find it last time? And so on.
Even if Canon understandably doesn't want to distribute the source
for their firmware, a dump of arm-elf-nm or a symbol table would be
very useful.
--
Trammell
Antony Newman
When Assembler code fragment hunting, I used to ignore Branches, and search the whole memory for specific mathematical operations.
To track down the periodic software interrupts, I would a new interrupt to the interrupt stack, then used my interrupt to dump all the others currently being called.
... I might be able to help you when I can get a dissasembled dump of the OS.
Antony
--
http://magiclantern.wikia.com/
To post to this group, send email to ml-d...@googlegroups.com
To unsubscribe from this group, send email to ml-devel+u...@googlegroups.com
For more options, visit this group at http://groups.google.com/group/ml-devel?hl=en
Trammell Hudson
> [...] There must be a better way to find the functions that Magic
> Lantern depends on in Canon's firmware images.
Especially now that they have acknowledged the audio bug in 2.0.3
and will be releasing a new firmware version. Hopefully it will be
very similar in compilation to the current one so that only a few
symbols need to be relocated.
At the very bottom of this page:
> We have learned that some users of the Canon EOS 5D Mark II digital
> SLR camera are experiencing issues with Firmware Update Version
> 2.0.3. We are working on a new firmware update to address these
> phenomena, which will be available soon
--
Trammell
B. Cole
On Mar 17, 7:22 pm, Trammell Hudson <hud...@osresearch.net> wrote:
> On Mon, Mar 15, 2010 at 06:39:54PM -0400, Trammell Hudson wrote:
> > [...] There must be a better way to find the functions that Magic
> > Lantern depends on in Canon's firmware images.
>
> Especially now that they have acknowledged the audio bug in 2.0.3
> and will be releasing a new firmware version. Hopefully it will be
> very similar in compilation to the current one so that only a few
> symbols need to be relocated.
I thought with IDA you just create a .sig file and it'll map the
function signatures
to their new addresses. That is one of the ways the chdk folks do it.
Unless the problem you're having is that the code is changing too
much.
You can't really expect them to publish symbol tables for their
proprietary OS.
Trammell Hudson
> I thought with IDA you just create a .sig file and it'll map the
> function signatures to their new addresses.
How do you create the .sig file? I searched the Hex Rays website
and found some fascinating discussion of how the FLIRT tree is
constructed and it is used to quickly locate functions, but nothing
about how to actually output one for a project.
> Unless the problem you're having is that the code is changing too
> much.
Some (low address) functions I've found just by going to where they
were in 1.1.0 and looking around. The boot functions are all at
nearly the same addresses, so that was easy. The difficult ones
like msleep() are still eluding me.
> You can't really expect them to publish symbol tables for their
> proprietary OS.
I can wish...
Based on the hubub at cinema5d and dvinfo, it sounds like Canon is
no longer distributing 2.0.3 due to the audio bug and will be coming
out the a new version shortly to address the missing audio. More work
for us, I guess.
I wish they had a posted estimate for when it would be available.
If it is week or two, I plan to hold off on any further 2.0.3 tests,
but if it is another nine months I'll go ahead and finish the
upgrade.
--
Trammell
B. Cole
> On Wed, Mar 17, 2010 at 09:13:20PM -0700, B. Cole wrote:
> > I thought with IDA you just create a .sig file and it'll map the
> > function signatures to their new addresses.
>
> How do you create the .sig file? I searched the Hex Rays website
> and found some fascinating discussion of how the FLIRT tree is
> constructed and it is used to quickly locate functions, but nothing
> about how to actually output one for a project.
>
http://www.hex-rays.com/idapro/ida/flair54.zip which I don't think you
can get a copy of without buying IDA 5.x. You probably don't have
FLAIR if you're just using the demo or freeware versions, like me.
The canon .sig files posted on the CHDK sites do seem to correctly map
some dryos functions for my 7d images, so the strategy seems to work.
This is why I asked for .sig files of your work in my first post. It
sure beats everyone having to separately treasure hunt for dryos
routines, and you can have IDA help find the new routine locations
after new canon releases.
A freeware solution that I've seen is:
http://www.woodmann.net/collaborative/tools/index.php/Fast_IDB2Sig_and_LoadMap_IDA_plugins
There is a .map file for 1.07 5D firmware that loads with the LoadMap
function found above.
I haven't actually looked into how this solution compares to FLAIR
really.
>
> I can wish...
>
> Based on the hubub at cinema5d and dvinfo, it sounds like Canon is
> no longer distributing 2.0.3 due to the audio bug and will be coming
> out the a new version shortly to address the missing audio. More work
> for us, I guess.
When you say *the* audio bug you mean the problem with custom modes
(c1,c2,c3)?
Or the problem with the pre-amp still not working as well as a field
recorder
like the zoom h4n?
>
> I wish they had a posted estimate for when it would be available.
> If it is week or two, I plan to hold off on any further 2.0.3 tests,
> but if it is another nine months I'll go ahead and finish the
> upgrade.
And I wish the 7D would have dryos feature updates at the same time as
the 5d.
Both the 5d and 7d are premium DSLRs and the 7d shouldn't be treated
as second class just because it's cheaper (not full frame 35mm). If
the hardware on the 7d can handle manual gain control us lowly 7d
users should have it as well. Save the reduced functionality for the
consumer-grade rebel line...
Maybe canon is just letting the 5d users beta test 2.0.x and the 7d
will be updated as soon as the audio issues with 2.0.x are sorted
out. :)
phroid
http://web.canon.jp/imaging/eosd/firm-e/eos5dmk2/firmware.html
Marvin
tracking changes to firmware.
FLIRT is based on byte matching in the first 32bytes of a function.
With a CPU like x86 where opcodes are typically bytes this works
well. 32 bytes can contain a lot of CISC instructions. The system is
at it's best identifying libraries which contain a higher proportion
of predictable bytes (for example calls internal to that library will
all have the same offsets).
With MIPS and ARM things don't work so well. In 32bit mode those 32
bytes represent just 8 instructions with the opcode bits, immediate
constants and offsets all mashed together. The algorithm chosen for
byte selection can only demand whole bytes that match or whole bytes
to ignore to be encoded in the final sig file.
If the system worked with individual bits this would go a long way to
resolving the problem but ultimately the richest source of function
identification information - the xref data - needs to be included to
get high retention between updates. In my head this would work by
tracking static data like messages and scraps of debug information
which are very reliable methods of identifying functions and then
iterating the confidence levels in the remaining functions using the
xref data in something like a Bayesian net. It's one thing to rewrite
sections of plugins for FLIRT and a totally different thing to write a
program from scratch to try this and I'm not round to starting this
phase.
With luck the the problem will be solved by patchdiff for people with
a recent enough IDA version.
Trammell Hudson
> [...] With luck the the problem will be solved by patchdiff for
> people with a recent enough IDA version.
I've had great luck with patchdiff2 this afternoon. It found 90% of
the symbols that we need to link Magic Lantern and the remaining
ones have not been too difficult to match up. Hopefully tomorrow
I'll have it linking (and maybe running).
The one feature that I wish it had the ability to do is apply the
found symbols to the new firmware image. It matches them up, but it
seems that it requires a manual procedure to input the old name in
the new firmware. If there were a way to dump the symbols to a
text file I could transform it into an IDC script that would create
them.
The only interesting set of changes that I've seen so far are in the
audio section; I haven't looked at the diffs in the intermediate
pass code to see how the 24p and other frame rate are implemented.
--
Trammell
Trammell Hudson
> [...] Hopefully tomorrow I'll have it linking (and maybe running).
Well it links, but immediately reports "Err 70" when it boots with
2.0.4. Next step: turn off all the features and see if we get some
of the simple things to work (I suspect the audio changes are
incompatible and parts of audio.c will need to be substantially
re-written).
I've pushed the latest changes to bitbucket. You can pull them and
give it a go if you like.
--
Trammell
Trammell Hudson
> Well it links, but immediately reports "Err 70" when it boots with
> 2.0.4. Next step: turn off all the features and see if we get some
> of the simple things to work
Even with most of the modules unlinked I'm still getting the err70
failure (apparently inside of bmp_printf()). my_init_task() is able
to do a dumpf() after writing the version string and loading the
config, which produces a normal looking set of output (the last
lines of which are the notices from ML as it reads the
magiclantern.cfg file, so the FIO_* routines are working):
Sun Mar 21 10:50:10 2010
0: 8.759 [STARTUP] ICU Firmware Version 2.0.4 ( 6.8.1 )
1: 8.817 [STARTUP] ICU Release DateTime 2010.03.18 13:51:43
2: 8.997 [SEQ] CreateSequencer (Startup, Num = 6)
3: 9.214 [SEQ] NotifyComplete (Cur = 0, 0x10000, Flag = 0x10000)
4: 10.078 [MAGIC] Magic Lantern 0.1.8 (affc59ae71cf+ tip)
5: 10.097 [MAGIC] Built on 2010-03-21 14:50:37 by hudson@kremvax
6: 10.196 [SEQ] seqEventDispatch (Startup, 0)
7: 10.216 [STARTUP] startupEntry
8: 43.235 [PROPST] dwNewAeModeDial = 0
9: 43.402 [PROPST] PROP_MOVIE_SOUND_RECORD_FOR_CREATIVE 0 0 3 ######
10: 43.487 [PROPST] PROP_MOVIE_SOUND_RECORD 0 3 0 3 ######
11: 43.755 [PROPST] PROP_MOVIE_SOUND_RECORD 0 3 3 3 ######
12: 43.964 [PROPST] PROP_MOVIE_SOUND_RECORD_FOR_CREATIVE 0 3 3 ######
13: 46.815 [HPD] TOEDetectISR 0
14: 47.082 [HPD] CreateTask Master End
15: 48.228 [FIO] [EM] emSlaveChangeCBR : AUTO_POWEROFF (1)
16: 48.378 [FIO] [EM] emSlaveChangeCBR : UILOCK (0x0)
17: 86.681 [STARTUP] startupPropAdminMain : End
18: 86.756 [SEQ] NotifyComplete (Cur = 1, 0x20000002, Flag = 0x20000000)
19: 93.692 [PROPST] dwNewAeModeDial = 3
20: 93.730 [PROPST] dwNewAeModeDial = 3
21: 95.430 [SEQ] NotifyComplete (Cur = 1, 0x2, Flag = 0x2)
22: 95.785 [PROPST] dwNewAeModeDial = 3
23: 95.868 [PROPST] dwNewAeModeDial = 3
24: 96.656 [PRP] Complete WaitID = 0x80000001, 0x00000000(0)
25: 96.719 [PRP] SpecialComplete ID = 0x80000001, 0x80000001 1164
26: 97.105 [PRP] MovieParamData
27: 97.243 [PRP] #mode 0 size 0x0 , framerate 0x1e , type 0xf
28: 97.556 [SEQ] seqEventDispatch (Startup, 1)
29: 97.591 [STARTUP] startupPrepareProperty
30: 97.827 [STARTUP] startupChangeAckCBR (Ceres = 0, USB = -1)
31: 97.842 [STARTUP] Ceres Disappeared
32: 99.085 [FM] FM_Initialize (1, 0, 1)
33: 99.431 [FM] fmResultCBR (0x51c324)
34: 100.037 [FM] PROP_HDD_DCIM_PATH (/)
35: 100.324 [FC] FC_Initialize [drive:3][ClassID:39]
36: 100.524 [FM] PROP_CARD1_STATUS = 0x0
37: 100.628 [FM] PROP_CARD1_FOLDER_NUMBER = 103
38: 100.779 [FM] PROP_CARD2_STATUS = 0x0
39: 100.862 [FM] PROP_CARD2_FOLDER_NUMBER = 100
40: 100.982 [FM] PROP_CARD3_EXIST = 0
41: 101.033 [FM] PROP_CARD3_STATUS = 0x0
42: 101.085 [FM] PROP_CARD3_RECORD = 0 => 1
43: 101.139 [FM] PROP_CARD3_FOLDER_NUMBER = 100
44: 101.238 [FM] PROP_FILE_NUMBERING_MODE = 1, 0
45: 101.287 [FM] PROP_CARD_EXTENSION = 0
46: 101.334 [FM] PROP_CURRENT_MEDIA = 1
47: 101.386 [FM] PROP_USBDEVICE_CONNECT = -1
48: 101.435 [FM] PROP_NUMBER_OF_CONTINUOUS_MODE = 306
49: 101.467 [SEQ] NotifyComplete (Cur = 2, 0x10, Flag = 0x10)
50: 101.555 [SEQ] seqEventDispatch (Startup, 2)
51: 101.577 [STARTUP] startupPrepareCapture
52: 102.467 [RSC] MemMgr 0 2
53: 102.493 [RSC] MemMgr 0 0
54: 102.507 [RSC] MemMgr 0 4
55: 102.520 [RSC] MemMgr 0 0
56: 102.787 [RSC] RearrangeMemMgr 0 5
57: 102.971 [RSC] Enter AllocateMEM3 0x4000 JOB
58: 104.299 [RSC] this->dwCardStatus[0] = 0x0(502)
59: 104.457 [RSC] this->dwCardStatus[1] = 0x0(502)
60: 104.593 [RSC] this->dwCardStatus[2] = 0x0(502)
61: 104.720 [RSC] PROP_PC_HDD_STATUS = 0x1
62: 105.182 [RSC] Enter AllocateMEM3 0x4000 JOB
63: 105.985 [RSC] Enter AllocateMEM3 0x4000 JOB
64: 106.498 [RSC] Enter AllocateMEM3 0x4000 JOB
65: 107.033 [RSC] Enter AllocateMEM3 0x4000 JOB
66: 108.076 [RSC] PROP_SAVE_MODE = 0x1
67: 109.029 [RSC] Enter AllocateMEM3 0x4000 JOB
68: 109.507 [RSC] RearrangeMemMgr 0 4
69: 109.700 [RSC] Enter AllocateMEM3 0x4000 JOB
70: 110.349 [RSC] Enter AllocateMEM3 0x4000 JOB
71: 111.153 [RSC] PC_CLUSTER_SIZE = 0x1000
72: 111.706 [RSC] Enter AllocateMEM3 0x4000 JOB
73: 111.910 [RSC] PROP_CFN_TAB2 ST_MEM_MAP_NORMAL->ST_MEM_MAP_NORMAL
74: 112.356 [RSC] #### PROP_AE_MODE_DIAL 3 1 0 0
75: 112.547 [RSC] #### PROP_LIVE_VIEW_MOVIE_SELECT 2 1 1 0
76: 112.710 [RSC] #### PROP_LIVE_VIEW_MOVIE_SELECT 0 1 1 0
77: 113.077 [FIO] [EM] emRegisterMulticastCallback : EventID = 14, ClassID = 128
78: 113.191 [FIO] [EM] emRegisterMulticastCallback : EventID = 15, ClassID = 128
79: 113.277 [FIO] [EM] emRegisterMulticastCallback : EventID = 4, ClassID = 128
80: 113.661 [RSC] SetBusy 0x50(0x50)(0x10)
81: 113.890 [JOB] InitializeJobClass (ID = 8396, Num = 12)
82: 114.050 [BIND] dcsResultCBR (0x63f078)
83: 114.950 [CERES] RegisterGPSInfoCallback
84: 115.385 [FIO] [EM] emLockControl (TYPE_JOBSTATE = 0x0)
85: 115.522 [RSC] this->fDevDone = TRUE
86: 115.648 [Burst3] 6540436 4 59 0 14545983
87: 117.195 [SEQ] NotifyComplete (Cur = 3, 0xe0110, Flag = 0x40000)
88: 117.324 [FIO] [EM] emRegisterMulticastCallback : EventID = 14, ClassID = 147
89: 117.445 [FIO] [EM] emRegisterMulticastCallback : EventID = 2, ClassID = 147
90: 117.524 [FIO] [EM] emRegisterMulticastCallback : EventID = 3, ClassID = 147
91: 117.601 [FIO] [EM] emRegisterMulticastCallback : EventID = 15, ClassID = 147
92: 117.671 [FIO] [EM] emRegisterMulticastCallback : EventID = 5, ClassID = 147
93: 117.742 [FIO] [EM] emRegisterMulticastCallback : EventID = 6, ClassID = 147
94: 117.809 [FIO] [EM] emRegisterMulticastCallback : EventID = 8, ClassID = 147
95: 117.880 [FIO] [EM] emRegisterMulticastCallback : EventID = 9, ClassID = 147
96: 117.946 [FIO] [EM] emRegisterMulticastCallback : EventID = 10, ClassID = 147
97: 118.150 [SHTC] scsProperty ID=0x0(0x0)
98: 118.293 [SHTC] scsInit
99: 118.771 [PROPAD] ERROR GetPropertyData ID = 0x010100A5
100: 118.862 [PROPAD] ERROR GetPropertyData ID = 0x010100A6
101: 119.028 [ENG] [ENGIO](Addr:0x5c640000, Data:0x 30000)
102: 124.730 [SHTC] BathtubAddress:0x5c714000, Size:65536
103: 124.876 [RSC] ClearBusy 0x10(0x10)(0x40)
104: 125.317 [SEQ] NotifyComplete (Cur = 3, 0xa0110, Flag = 0x80000)
105: 125.584 [SHTB] sbsInit
106: 125.737 [SHTB] VShadingAddress:0x5c694000, Size:524288
107: 126.308 [SHTP] spsInit
108: 126.405 [MRK] RegisterSpaceNotifyCallback : DriveNo = 1
109: 126.431 [FM] RegisterSpaceNotifyCallback : DriveNo = 1
110: 126.462 [FM] FM_RegisterSpaceNotifyCallback
111: 126.543 [MRK] RegisterSpaceNotifyCallback : DriveNo = 3
112: 126.565 [FM] RegisterSpaceNotifyCallback : DriveNo = 3
113: 126.601 [FM] FM_RegisterNumberNotifyCallback
114: 126.770 [TERM] terminateChangeCBR : SHUTDOWN (255)
115: 126.801 [TERM] terminateChangeCBR : AUTO_POWEROFF (1)
116: 126.925 [SEQ] NotifyComplete (Cur = 3, 0x20110, Flag = 0x100)
117: 126.996 TOM_Initialize
118: 127.389 PROP_WFT_IMAGE_TRANS (1)
119: 127.785 [FIO] [EM] emRegisterMulticastCallback : EventID = 0, ClassID = 158
120: 127.916 [FIO] [EM] emRegisterMulticastCallback : EventID = 1, ClassID = 158
121: 128.002 [FIO] [EM] emRegisterMulticastCallback : EventID = 4, ClassID = 158
122: 128.863 [FIO] [EM] emRegisterMulticastCallback : EventID = 0, ClassID = 160
123: 128.991 [FIO] [EM] emRegisterMulticastCallback : EventID = 11, ClassID = 160
124: 129.020 [FIO] [EM] Already SW1OFF
125: 129.039 [MC] cam event metering timer start
126: 129.129 [FIO] [EM] emRegisterMulticastCallback : EventID = 7, ClassID = 160
127: 129.205 [FIO] [EM] emRegisterMulticastCallback : EventID = 1, ClassID = 160
128: 129.280 [FIO] [EM] emRegisterMulticastCallback : EventID = 4, ClassID = 160
129: 129.350 [FIO] [EM] emRegisterMulticastCallback : EventID = 3, ClassID = 160
130: 129.411 [FIO] [EM] emRegisterMulticastCallback : EventID = 2, ClassID = 160
131: 129.461 [PTP] PD_RegistTFTTurnSwCBR:0
132: 129.755 [MC] PROP_DISPLAY_OFF_SENSOR : 1
133: 129.859 [MC] DisplaySensor : 1(0)
134: 130.130 [MC] PROP_GUI_STATE 0
135: 130.228 [MC] PROP_LV_ACTION : LV_STOP
136: 130.275 [MC] PROP_LV_DISPBUSY : not Busy
137: 130.319 [MC] PROP_LV_LOCK : LVLOCK_PERMIT
138: 130.364 [MC] PROP_DISABLE_PLAY_IMAGE : Enable Play
139: 130.417 [MC] JobState 0
140: 130.614 [MC] HDMIConnect ---> (0)
141: 130.860 [MC] QRTime : 8
142: 131.046 [MC] GuiGroundState : 0
143: 131.218 [MC] PROP_LV_ACTION : LV_STOP
144: 131.715 [MC] regist master CardCover
145: 131.867 [FIO] [EM] emRegisterMulticastCallback : EventID = 13, ClassID = 160
146: 131.960 [FM] fmInitialized
147: 132.010 [FC] _FC_SetDirSuffix (EOS5D)
148: 132.054 [FC] _FC_SetConsecutiveMode (mode = 1, DCF = 306)
149: 132.122 [FM] fmPrepare
150: 132.552 [FM] ALV_Initialize (36, 25)
151: 132.951 [FM] fmSetInitialCardInfo (Drive = 3, 0)
152: 133.283 tomSetRawJpgMode (Type = 0x4)
153: 133.421 [CF] ---- CFEventHandler(ID=0:Event=8) ----
154: 173.803 [FM] PROP_CARD3_RECORD = 0 => 0
155: 175.237 [RSC] this->dwCardStatus[2] = 0x0(502)
156: 175.887 [RSC] Enter AllocateMEM3 0x4000 JOB
157: 176.595 [PRP] Deliv WaitID = 0x8000002F, 0xFF82C88C(1)
158: 176.696 [PRP] Deliv WaitID = 0x8000002F, 0xFF829F3C(2)
159: 177.176 [RSC] Enter AllocateMEM3 0x4000 JOB
160: 177.446 [PRP] Deliv WaitID = 0x8000002F, 0xFF82C88C(1)
161: 177.536 [PRP] Deliv WaitID = 0x8000002F, 0xFF829F3C(2)
162: 177.916 [PRP] Deliv WaitID = 0x8000002F, 0xFF82C88C(1)
163: 178.012 [PRP] Deliv WaitID = 0x8000002F, 0xFF829F3C(2)
164: 178.233 [RSC] PROP_SAVE_MODE = 0x1
165: 178.504 [PRP] Complete WaitID = 0x8000002F, 0x00000000(0)
166: 178.719 [RSC] this->dwCardStatus[2] = 0x0(502)
167: 178.975 [PRP] Complete WaitID = 0x8000002F, 0xFF82C88C(1)
168: 179.059 [PRP] Complete WaitID = 0x8000002F, 0xFF829F3C(0)
169: 179.132 [PRP] Complete WaitID = 0x8000002F, 0xFF82C88C(1)
170: 179.189 [PRP] Complete WaitID = 0x8000002F, 0xFF829F3C(0)
171: 179.252 [PRP] Complete WaitID = 0x8000002F, 0xFF82C88C(1)
172: 179.311 [PRP] Complete WaitID = 0x8000002F, 0xFF829F3C(0)
173: 179.353 [PRP] SpecialComplete ID = 0x8000002F, 0x8000001A 1164
174: 179.592 [FM] PROP_CARD3_EXIST = 0
175: 179.701 [FM] PROP_CARD3_STATUS = 0x0
176: 179.786 [FM] PROP_CARD_EXTENSION = 0
177: 179.883 [FM] PROP_CARD3_STATUS = 0x0
178: 180.309 [PRP] Deliv WaitID = 0x80000030, 0xFF82C88C(1)
179: 180.405 [PRP] Deliv WaitID = 0x80000030, 0xFF829F3C(2)
180: 180.874 [RSC] Enter AllocateMEM3 0x4000 JOB
181: 181.138 [PRP] Deliv WaitID = 0x80000030, 0xFF82C88C(1)
182: 181.229 [PRP] Deliv WaitID = 0x80000030, 0xFF829F3C(2)
183: 181.608 [PRP] Deliv WaitID = 0x80000030, 0xFF82C88C(1)
184: 181.699 [PRP] Deliv WaitID = 0x80000030, 0xFF829F3C(2)
185: 181.804 [PRP] Complete WaitID = 0x80000030, 0x00000000(0)
186: 181.882 [PRP] Complete WaitID = 0x80000030, 0xFF82C88C(1)
187: 181.943 [PRP] Complete WaitID = 0x80000030, 0xFF829F3C(0)
188: 182.003 [PRP] Complete WaitID = 0x80000030, 0xFF82C88C(1)
189: 182.055 [PRP] Complete WaitID = 0x80000030, 0xFF829F3C(0)
190: 182.110 [PRP] Complete WaitID = 0x80000030, 0xFF82C88C(1)
191: 182.163 [PRP] Complete WaitID = 0x80000030, 0xFF829F3C(0)
192: 182.208 [PRP] SpecialComplete ID = 0x80000030, 0x8000001B 1164
193: 183.214 [PRP] Deliv WaitID = 0x80000031, 0xFF82C88C(1)
194: 183.313 [PRP] Deliv WaitID = 0x80000031, 0xFF829F3C(2)
195: 183.863 [RSC] Enter AllocateMEM3 0x4000 JOB
196: 184.131 [PRP] Deliv WaitID = 0x80000031, 0xFF82C88C(1)
197: 184.235 [PRP] Deliv WaitID = 0x80000031, 0xFF829F3C(2)
198: 184.622 [PRP] Deliv WaitID = 0x80000031, 0xFF82C88C(1)
199: 184.718 [PRP] Deliv WaitID = 0x80000031, 0xFF829F3C(2)
200: 184.821 [PRP] Complete WaitID = 0x80000031, 0x00000000(0)
201: 184.903 [PRP] Complete WaitID = 0x80000031, 0xFF82C88C(1)
202: 184.960 [PRP] Complete WaitID = 0x80000031, 0xFF829F3C(0)
203: 185.019 [PRP] Complete WaitID = 0x80000031, 0xFF82C88C(1)
204: 185.077 [PRP] Complete WaitID = 0x80000031, 0xFF829F3C(0)
205: 185.134 [PRP] Complete WaitID = 0x80000031, 0xFF82C88C(1)
206: 185.186 [PRP] Complete WaitID = 0x80000031, 0xFF829F3C(0)
207: 185.229 [PRP] SpecialComplete ID = 0x80000031, 0x8000001C 1164
208: 253.389 [CF] [CIS] MakerInfo : SanDisk
209: 253.405 [CF] [CIS] VersionInfo: SDP
210: 316.699 [CF] Word164 = 0x891b
211: 316.729 [CF] [ID:Firmware Revision] = HDX 4.42
212: 316.744 [CF] [ID:Model Number] = SanDisk SDCFX3-032G
213: 316.776 [CF] IDE = 4, PCMCIA = 80, UDMA = 4
214: 316.816 [CF] Cyl=63520, Hds=16, Trk=63, nSec=64028160, Ms=4
215: 316.840 [CF] CF_GetAccessTiming : DatTim = 3, DatMod = 4
216: 316.869 [CF] cfIdentifyDrive: Cache Support
217: 317.065 [CF] cfIdentifyDrive: Idle Command(500mSec)
218: 317.249 [CF] cfIdentifyDrive: Set UDMA( Mode=4 )
219: 317.349 [CF] nBlocks=64028160, bytesPerBlk=512
220: 317.367 [CF] blksPerTrack=63, nHeads=16
221: 318.515 [CSMGR] Analyze BOOT...SUCCESS
222: 631.010 [CSMGR] GetNumOfFreeClusters1 = 349533
223: 631.589 [FM] EV_INSERTION_COMPLETE : ID = 1, stat = 0
224: 631.724 [FM] fmNormalMountCard (ID = 1, Ret = 0)
225: 631.744 [FM] fmPrepareShooting (Drive = 1)
226: 631.822 [FC] _FC_PrepareCatalog (1, A:)
227: 632.316 [CF] ---- CFEventHandler(ID=0:< A: >) Mounted ----
228: 643.644 [FM] DirNo = 103, FileNo = 306
229: 643.704 [CSMGR] GetNumOfFreeClusters2 = 349533
230: 643.749 [FM] Cluster = 32768, Total = 1000178, Free = 349533
231: 643.800 [FC] _FC_GetNewDirDcfNo (1, 0, 0, 0)
232: 643.841 [FM] fmSetInitialCardInfo (Drive = 1, 0)
233: 644.749 [RSC] this->dwCardStatus[0] = 0x1(502)
234: 645.806 [RSC] Storage Space 349533
235: 646.169 [RSC] DCF No 306
236: 646.433 [RSC] BURST 58 Enable 1524 Reserve 7503872
237: 646.500 [RSC] Burst 58 ENABLE 1524 Reserve 7503872
238: 646.575 [SEQ] NotifyComplete (Cur = 3, 0x20010, Flag = 0x20000)
239: 647.353 [SEQ] NotifyComplete (Cur = 3, 0x10, Flag = 0x10)
240: 647.511 [FM] PROP_CARD1_STATUS = 0x1
241: 647.574 [FM] PROP_CARD1_FOLDER_NUMBER = 103
242: 647.701 [SEQ] seqEventDispatch (Startup, 3)
243: 647.722 [SND] Seq LPC 5-0
244: 647.745 [SND] HARB_ARBMODE Before:0x00000000 Current:0x00000000
245: 647.779 [SND] HARB_HARBCTRL Before:0x002AAAA8 Current:0x002AAAA8
246: 647.790 [SND] Seq LPC 5-1
247: 647.799 [SND] Seq LPC 5-2
248: 647.828 [SND] Seq LPC 5-3
249: 647.849 [SND] Seq LPC 5-4
250: 647.858 [SND] Seq LPC 5-5
251: 647.869 [SND] Seq LPC 5-6
252: 648.161 [SND] Seq LPC 5-7
253: 648.171 [SND] Seq LPC fin
254: 648.319 [RSC] ClearBusy 0x0(0x0)(0x10)
255: 648.803 [STARTUP] startupPrepareDevelop
256: 649.983 [PRP] M:9A F:0 L:0 P:0
257: 650.324 [STARTUP] internal version 06:08:01:00:9a:00:00:00
258: 651.438 [SHTFD] sdsInit
259: 651.730 sdsInit
260: 651.827 [SHTP] spsActivate
261: 664.169 [SHTFD] sdsActivate
262: 666.555 [SHTRD] sdsActivate
263: 667.068 < GUI Lock > InitializeGUILock (PUB)
264: 667.437 [GUI] MasterResultCBR
265: 667.674 [AUDIO] InitializeAudioIC(0xc02200d0, 71)
266: 667.701 [Device]_AudioSTBY(1) = 0
267: 667.818 [AUDIO] EnableAudioIC
268: 667.848 [AUDIO] Reg(0x05) Data(0x0023)
269: 667.985 [AUDIO] Reg(0x00) Data(0x0040)
270: 668.060 [AUDIO] Reg(0x01) Data(0x0003)
271: 668.126 [AUDIO] Reg(0x02) Data(0x0000)
272: 668.182 [AUDIO] Reg(0x04) Data(0x006a)
273: 668.279 [AUDIO] Reg(0x06) Data(0x0064)
274: 668.355 [AUDIO] Reg(0x0E) Data(0x0091)
275: 668.411 [AUDIO] Reg(0x0F) Data(0x0008)
276: 668.466 [AUDIO] Reg(0x08) Data(0x00d2)
277: 668.522 [AUDIO] Reg(0x09) Data(0x00d2)
278: 668.574 [AUDIO] Reg(0x0C) Data(0x00d2)
279: 668.628 [AUDIO] Reg(0x0A) Data(0x0049)
280: 668.679 [AUDIO] Reg(0x25) Data(0x0049)
281: 668.731 [AUDIO] Reg(0x0B) Data(0x0040)
282: 668.783 [AUDIO] Reg(0x07) Data(0x0024)
283: 668.839 [AUDIO] Reg(0x11) Data(0x0000)
284: 668.992 [AUDIO] InitializeASIF�FPriority(23)
285: 669.021 [AUDIO] EnableASIF
286: 669.044 [AUDIO] WaitPllLockComplete�FVectNo(71)
287: 669.144 [FM] PROP_CURRENT_MEDIA = 1
288: 708.289 [AUDIO] _PllLockTimeout
289: 708.336 [AUDIO] MIC Disconnect
290: 708.739 [AUDIO] InitializeSoundDevice
291: 709.032 [SND] NRbuffer:0x00724CF0
292: 709.057 [MR_MOV] MOVW_Initialize
293: 709.325 [MR] MVR_Initialize
294: 709.636 [MR] mvrResultCBR : 0x729d64
295: 709.722 [MR] mvrChangeAckCBR : PROP_USBDEVICE_CONNECT(-1)
296: 709.778 [MR] mvrChangeAckCBR : Video - Mode=0, Type=0, Rate=30, GOP=15
297: 709.832 [MR] mvrChangeAckCBR : Sound Manual(C=2,R=48000,B=16)
298: 709.876 [MR] mvrChangeAckCBR : ISO(85)
299: 709.940 [MR] mvrChangeAckCBR : MOVIE_REC_VOLUME(L:47 R:47)
300: 711.859 [LVFD] FD_LensEventForFaceSerch2(1) 0
301: 713.208 [LVMD] Init RCh1=0, RCh2=0
302: 713.299 [LVFD] LVCPF_Initialize
303: 713.572 [LVCFG] LV_Initialize Feb 9 2010
304: 715.285 [LV] FD_SetAfState(7) Mode:-1
305: 715.303 [LV] AF Mode FACE
306: 715.321 [LV] FD_FACEAF_ON
307: 715.423 [LV] GetImageTrimming X(2976)=0(2414, 2416), Y(1928)=0(1552, 1548)
308: 716.306 [LVMD] Set RCh1=a, RCh2=19
309: 718.635 [LV] FD_SetAfState(7) Mode:-1
310: 718.657 [LV] AF Mode FACE
311: 718.674 [LV] FD_FACEAF_ON
312: 719.251 [LVCFG] PROP_TEMP_STATUS Temp:0, FrameRate:1
313: 719.474 [LVCFG] PROP_LV_ACTION STOP
314: 719.534 [LV] JudgeStartLV 0x1 0x0 0xFFFF
315: 719.558 < GUI Lock > GUILock_PermitPowerLockOnlyImagePlay (PUB)
316: 719.605 < GUI Lock > GUILock_PermitPowerLock (PUB)
317: 719.778 [LVCFG] PROP_LV_LOCK PERIMIT
318: 719.833 [LV] JudgeStartLV 0x1 0x1 0xFFFF
319: 719.851 < GUI Lock > GUILock_PermitPowerLockOnlyImagePlay (PUB)
320: 719.883 < GUI Lock > GUILock_PermitPowerLock (PUB)
321: 720.041 [LVCFG] PROP_SHOOTING_TYPE 0
322: 720.566 [LV] JudgeStartLV 0x1 0x1 0x0
323: 720.592 < GUI Lock > GUILock_PermitPowerLockOnlyImagePlay (PUB)
324: 720.631 < GUI Lock > GUILock_PermitPowerLock (PUB)
325: 720.938 [LV] lvSetBadFrame Old:0 New:a -> a L:5870
326: 721.336 [LVCFG] PROP_CFN_TAB1 IsoExpansion 1
327: 721.824 [LV] PROP_LIVE_VIEW_FACE_AF
328: 721.966 [LVCFG] PROP_EFIC_TEMP 26��
329: 722.162 [LVCFG] PROP_LV_LENS
330: 722.371 [LV] FD_SetAfState(7) Mode:0
331: 722.387 [LV] AF Mode FACE
332: 722.405 [LV] FD_FACEAF_ON
333: 722.702 [LVCFG] PROP_MOVIE_PARAM 0 1
334: 722.843 [LVCFG] PROP_LIVE_VIEW_VIEWTYPE_SELECT 0->2
335: 722.881 [LVCFG] ViewType:2
336: 723.045 [LVCFG] PROP_LIGHT_FALLOFF_COMP 0
337: 723.178 [LVCFG] PROP_LENS ID:9b
338: 723.335 [LV] PROP_LV_TVAF_MODE(0)
339: 724.528 [FIO] [EM] emRegisterMulticastCallback : EventID = 19, ClassID = 152
340: 724.647 [FIO] [EM] emRegisterMulticastCallback : EventID = 20, ClassID = 152
341: 724.721 [FIO] [EM] emRegisterMulticastCallback : EventID = 17, ClassID = 152
342: 724.798 [FIO] [EM] emRegisterMulticastCallback : EventID = 18, ClassID = 152
343: 724.868 [FIO] [EM] emRegisterMulticastCallback : EventID = 21, ClassID = 152
344: 724.937 [FIO] [EM] emRegisterMulticastCallback : EventID = 1, ClassID = 152
345: 725.007 [FIO] [EM] emRegisterMulticastCallback : EventID = 4, ClassID = 152
346: 725.648 [STARTUP] startupPrepareRemote
347: 725.696 [DEVICE]USB PHY Type Reg:3263e7
348: 725.717 [DEVICE]USB PHY Type Reg:3263e7
349: 725.728 [DEVICE]USB PHY FUJITU
350: 725.791 [DEVICE]USB PHY Type Reg:3263e7
351: 725.812 [DEVICE]USB PHY Type Reg:3263e7
352: 726.892 [RMT] rmtPropSetAv [16][15]
353: 726.931 [RMT] PROP_LENS [16][50][15]
354: 728.217 [PTP] PD_RegistRemoteFunc:0
355: 728.368 [RMT] QuickTransmissionEnable (0, 1, 2, 2)
356: 728.417 [RMT] PROP_WFT_SYSTEM : 0
357: 728.441 [RMT] PROP_SDIO_PHYSICAL_CONNECT:0
358: 728.462 [RMT] rmtDisconnect (0, 0)
359: 728.924 [SDCOM] SDCOM_Initialize
360: 731.007 [RTOM]ResetTransferStatus
361: 732.050 [RMT] PROP_CONNECT_TARGET (0x0 <= 0x0)
362: 732.415 [RMT] PROP_CONNECT_TARGET_WFT (0x0 <= 0x0)
363: 734.212 [PTP] Allocate:75a97c,0,5fad0000,100000
364: 734.529 [RMT] PTP_PROPERTY_RELEASE_PARAM_ID_LIST END:75
365: 736.870 [RMT] RELEASE PARAM ID LIST Free
366: 736.921 [RMT] PTP_PROPERTY_FLAVOR_PARAM_ID_LIST END:19
367: 738.564 [RMT] SUPPORT ID LIST Free
368: 739.447 [PTP] PROP_ICU_UILOCK Rec[0]
369: 739.490 [PTP] PROP_REMOTE_RELEASE[0]
370: 739.533 [PTP] PROP_REMOTE_BULB_RELEASE_START[0]
371: 739.556 [PTP] PROP_REMOTE_BULB_RELEASE_END[0]
372: 739.657 [PTP] PROP_REMOTE_SW1[0]
373: 739.696 [PTP] PROP_REMOTE_SW2[0]
374: 739.734 [PTP] PROP_REMOTE_AFSTART_BUTTON[0]
375: 739.955 [PTP] PhotoStudioMode:0
376: 740.181 [PTP] PROP_CONNECT_TARGET [0]
377: 740.224 [PTP] PROP_LOGICAL_CONNECT[0]
378: 740.274 [PTP] PROP_TUNING_FLAG[ffffffff]
379: 740.466 [PTP] PROP_CONNECT_TARGET_WFT [0]
380: 740.508 [PTP] PROP_LOGICAL_CONNECT_WFT[0]
381: 740.531 [PTP] PROP_SDIO_PHYSICAL_CONNECT[0]
382: 740.705 [PTP] PD_DeRegistReadFileCBR
383: 740.747 [PTP] PD_DeRegistGetObjectCBR[0xff847f44]
384: 741.273 PROP_PHYSICAL_CONNECT : 0
385: 741.335 PROP_SDIO_PHYSICAL_CONNECT : 0, 0, 1, COM = 5354048
386: 741.363 PROP_CONNECT_TARGET_WFT = 0x0 <= 0x0
387: 741.411 PROP_WFT_SYSTEM : 0, 0, USB = 1, COM = 0
388: 741.450 PROP_USBDEVICE_CONNECT : USBDevice = -1
389: 741.557 PROP_BTDEVICE_CONNECT : BtDevice = -1
390: 741.595 PROP_WFT_BLUETOOTH : BtType = -1
391: 742.923 ceresPropertyChangeCBR ID[0x5010000] Size[0x18]
392: 743.037 ceresReceiveCallback (0x27, 0xd1e1, 0x0)
393: 743.134 ceresPropertyChangeCBR ID[0x5010001] Size[0x220]
394: 743.196 ceresReceiveCallback (0x27, 0xd1e2, 0x0)
395: 743.259 ceresPropertyChangeCBR ID[0x5010002] Size[0x89c]
396: 743.380 ceresReceiveCallback (0x27, 0xd1e3, 0x0)
397: 743.443 ceresPropertyChangeCBR ID[0x5010003] Size[0x4f0]
398: 743.526 ceresReceiveCallback (0x27, 0xd1e4, 0x0)
399: 743.588 ceresPropertyChangeCBR ID[0x5010004] Size[0x40]
400: 743.621 ceresReceiveCallback (0x27, 0xd1e5, 0x0)
401: 743.684 ceresPropertyChangeCBR ID[0x5010005] Size[0x2c]
402: 743.716 ceresReceiveCallback (0x27, 0xd1e6, 0x0)
403: 743.770 ceresPropertyChangeCBR ID[0x5010007] Size[0x1c]
404: 743.806 ceresReceiveCallback (0x27, 0xd1e8, 0x0)
405: 743.865 ceresPropertyChangeCBR ID[0x501000a] Size[0x1f8]
406: 743.901 ceresReceiveCallback (0x27, 0xd1ea, 0x0)
407: 743.965 ceresPropertyChangeCBR ID[0x501000b] Size[0xe0]
408: 743.992 ceresReceiveCallback (0x27, 0xd1e9, 0x0)
409: 744.055 ceresPropertyChangeCBR ID[0x5010008] Size[0x18]
410: 744.103 ceresPropertyChangeCBR ID[0x5010009] Size[0x54]
411: 744.144 ceresPropertyChangeCBR ID[0x80030019] Size[0x4]
412: 744.218 ceresPropertyChangeCBR ID[0x501000c] Size[0x4]
413: 744.241 ceresReceiveCallback (0x27, 0xc1e3, 0x1)
414: 744.295 ceresPropertyChangeCBR ID[0x80020000] Size[0x4]
415: 744.333 ceresPropertyChangeCBR ID[0x8003001d] Size[0x60]
416: 744.354 [CERES] PROP_BATTERY_REPORT:1
417: 744.371 [CERES] 1,0,5a,3
418: 744.414 ceresPropertyChangeCBR ID[0x501000d] Size[0x120]
419: 744.444 ceresReceiveCallback (0x27, 0xc1ea, 0x404f5a2c)
420: 744.521 ceresPropertyChangeCBR ID[0x501000e] Size[0x1c0]
421: 744.551 ceresReceiveCallback (0x27, 0xd1ec, 0x0)
422: 745.258 [MAC] MAC_Initialize
423: 745.616 [MAC] K_BOARDID4
424: 745.654 [MAC] K_BOARDID3
425: 745.686 [MAC] K_BOARDID2
426: 745.710 [MAC] K_BOARDID1
427: 745.981 [MAC] Key=0x1 Board=0xcc7f9294 Body=0x131478fb
428: 746.131 [FIO] [EM] emRegisterMulticastCallback : EventID = 16, ClassID = 157
429: 746.241 [SEQ] NotifyComplete (Cur = 4, 0x110, Flag = 0x100)
430: 746.581 [PTP] Dispatch : Cur = 0, Event = 5, Param = 0x2
431: 746.616 [PTP] PROP_SDIO_PHYSICAL_CONNECT:0
432: 746.638 [RMT] rmtFreeStoredJob (0, 0)
433: 746.729 [PTP] Dispatch : Cur = 0, Event = 5, Param = 0x2
434: 746.756 [PTP] LV End Clear LVData
435: 746.769 [PTP] PSI DisconnectViewFinder
436: 746.870 [PTP] Dispatch : Cur = 0, Event = 5, Param = 0x2
437: 746.921 [PTP] Dispatch : Cur = 0, Event = 5, Param = 0x2
438: 746.940 [PTP] PROP_CONNECT_TARGET (0x0 <= 0x0)
439: 746.985 [PTP] Dispatch : Cur = 0, Event = 5, Param = 0x2
440: 747.004 [PTP] PROP_CONNECT_TARGET_WFT (0x0 <= 0x0)
441: 747.133 [PTP] ptpPropertyChangeEvent[80000001][4][3][0][0]
442: 747.162 [PTP] AeMode = 3
443: 747.321 [PTP] ptpPropertyChangeEvent[80000004][2][48000000][0][0]
444: 747.464 [PTP] ptpPropertyChangeEvent[80000003][4][0][0][0]
445: 747.592 [PTP] ptpPropertyChangeEvent[80000002][4][1][0][0]
446: 747.717 [PTP] ptpPropertyChangeEvent[8000000d][4][0][0][0]
447: 747.844 [PTP] ptpPropertyChangeEvent[8000000e][4][c80][0][0]
448: 747.979 [PTP] ptpPropertyChangeEvent[80000011][4][0][0][0]
449: 748.102 [PTP] ptpPropertyChangeEvent[80000010][4][0][0][0]
450: 748.229 [PTP] ptpPropertyChangeEvent[80000013][4][0][0][0]
451: 748.350 [PTP] ptpPropertyChangeEvent[80000012][4][0][0][0]
452: 748.477 [PTP] ptpPropertyChangeEvent[2060000][4][2][0][0]
453: 748.599 [PTP] ptpPropertyChangeEvent[80030005][4][5f4][0][0]
454: 748.735 [PTP] ptpPropertyChangeEvent[80040019][4][0][0][0]
455: 748.860 [PTP] ptpPropertyChangeEvent[80000024][4][3c][0][0]
456: 748.985 [PTP] ptpPropertyChangeEvent[80030024][4][1][0][0]
457: 749.113 [PTP] ptpPropertyChangeEvent[2][1a4][6f6e6143][0][0]
458: 749.241 [PTP] ptpPropertyChangeEvent[2000004][20][6d617254][0][0]
459: 749.380 [PTP] ptpPropertyChangeEvent[8000002d][4][0][0][0]
460: 749.512 [PTP] ptpPropertyChangeEvent[8000002c][4][0][0][0]
461: 749.640 [PTP] ptpPropertyChangeEvent[8000002e][4][0][0][0]
462: 749.763 [PTP] ptpPropertyChangeEvent[80000008][4][0][0][0]
463: 749.886 [PTP] ptpPropertyChangeEvent[8000000b][4][0][0][0]
464: 750.028 [PTP] ptpPropertyChangeEvent[80030004][4][2][0][0]
465: 750.268 [PTP] ptpPropertyChangeEvent[80030003][4][0][0][0]
466: 750.407 [PTP] ptpPropertyChangeEvent[8000002f][4][3010000][0][0]
467: 750.554 [PTP] ptpPropertyChangeEvent[80000031][4][3010000][0][0]
468: 750.681 [PTP] ptpPropertyChangeEvent[e020002][1e4][0][0][0]
469: 750.829 [PTP] ptpPropertyChangeEvent[8000002a][4][1][0][0]
470: 750.978 [PTP] ptpPropertyChangeEvent[80010004][8][1000008][0][0]
471: 751.133 [PTP] ptpPropertyChangeEvent[80010005][6][206][0][0]
472: 751.275 [PTP] ptpPropertyChangeEvent[80010006][f][9][0][0]
473: 751.426 [PTP] ptpPropertyChangeEvent[80010007][8][5000008][0][0]
474: 751.572 [PTP] ptpPropertyChangeEvent[e020001][38][30][0][0]
475: 751.721 [PTP] ptpPropertyChangeEvent[80030011][e][501601][0][0]
476: 751.761 [PTP] PROP_LENS [d1a8][80030011]
477: 751.896 [PTP] ptpPropertyChangeEvent[80030011][e][501601][0][0]
478: 751.932 [PTP] PROP_LENS [d1a8][80030011]
479: 752.059 [PTP] ptpPropertyChangeEvent[8004000f][4][0][0][0]
480: 752.197 [PTP] ptpPropertyChangeEvent[8004001c][4][2][0][0]
481: 752.326 [PTP] ptpPropertyChangeEvent[8005000b][2][0][0][0]
482: 752.450 [PTP] ptpPropertyChangeEvent[80050016][4][0][0][0]
483: 752.559 [PTP] ptpPropertyChangeEvent[80050018][4][0][0][0]
484: 752.658 [PTP] ptpPropertyChangeEvent[8005001a][28][0][0][0]
485: 752.761 [PTP] ptpPropertyChangeEvent[80050019][4][c80][0][0]
486: 752.853 [PTP] ptpPropertyChangeEvent[2020006][4][8][0][0]
487: 752.953 [PTP] ptpPropertyChangeEvent[2020000][34][0][0][0]
488: 752.990 [PTP] PROP_MWB[34]
489: 753.105 [PTP] ptpPropertyChangeEvent[80030029][8][340a][0][0]
490: 753.224 [PTP] ptpPropertyChangeEvent[80030028][4][0][0][0]
491: 753.336 [PTP] ptpPropertyChangeEvent[80040016][4][0][0][0]
492: 753.437 [PTP] ptpPropertyChangeEvent[80040001][4][0][0][0]
493: 753.546 [PTP] ptpPropertyChangeEvent[80040002][4][1][0][0]
494: 753.655 [PTP] ptpPropertyChangeEvent[2010000][4][67][0][0]
495: 753.760 [PTP] ptpPropertyChangeEvent[1000006][4][131478fb][0][0]
496: 753.793 [PTP] BodyID:320108795
497: 753.987 [PTP] ptpPropertyChangeEvent[e070000][40][0][0][0]
498: 754.140 [PTP] ptpPropertyChangeEvent[e070001][40][6d617254][0][0]
499: 754.248 [PTP] ptpPropertyChangeEvent[8000000b][4][0][0][0]
500: 754.357 [PTP] ptpPropertyChangeEvent[8004001d][4][0][0][0]
501: 754.465 [PTP] ptpPropertyChangeEvent[80000039][10][0][0][0]
502: 754.568 [PTP] ptpPropertyChangeEvent[4020000][8db0][1c0dad][0][0]
503: 755.106 [PTP] ptpPropertyChangeEvent[80000034][4][2][0][0]
504: 755.215 [PTP] ptpPropertyChangeEvent[80000033][4][0][0][0]
505: 755.304 [PTP] ptpPropertyChangeEvent[80040004][2][0][0][0]
506: 755.402 [PTP] ptpPropertyChangeEvent[8000000a][4][1ff][0][0]
507: 755.513 [PTP] ptpPropertyChangeEvent[80030021][46][35384645][0][0]
508: 755.615 [PTP] ptpPropertyChangeEvent[30001][1e5c][20000003][0][0]
509: 755.820 [PTP] ptpPropertyChangeEvent[8003001b][10][0][0][0]
510: 755.924 [PTP] ptpPropertyChangeEvent[80030026][e][0][0][0]
511: 756.033 [PTP] ptpPropertyChangeEvent[80000023][4][1][0][0]
512: 756.115 [PTP] ptpPropertyChangeEvent[80030025][4][0][0][0]
513: 756.208 [PTP] ptpPropertyChangeEvent[1000000][4][ffffffff][0][0]
514: 756.287 [PTP] ptpPropertyChangeEvent[80030013][4][0][0][0]
515: 756.377 [PTP] ptpPropertyChangeEvent[80030012][4][0][0][0]
516: 756.452 [PTP] ptpPropertyChangeEvent[2040003][4][0][0][0]
517: 756.645 [PTP] ptpPropertyChangeEvent[80000028][4][84][0][0]
518: 756.786 [PTP] ptpPropertyChangeEvent[2060001][18][0][0][0]
519: 756.924 [PTP] ptpPropertyChangeEvent[2060002][18][fffffffc][0][0]
520: 757.028 [PTP] ptpPropertyChangeEvent[2060003][18][0][0][0]
521: 757.130 [PTP] ptpPropertyChangeEvent[2060004][18][0][0][0]
522: 757.224 [PTP] ptpPropertyChangeEvent[2060005][18][0][0][0]
523: 757.326 [PTP] ptpPropertyChangeEvent[2060006][18][0][0][0]
524: 757.420 [PTP] ptpPropertyChangeEvent[2060007][18][0][0][0]
525: 757.510 [PTP] ptpPropertyChangeEvent[2060008][18][0][0][0]
526: 757.593 [PTP] ptpPropertyChangeEvent[2060009][18][0][0][0]
527: 757.675 [PTP] ptpPropertyChangeEvent[206000a][4][41][0][0]
528: 757.763 [PTP] ptpPropertyChangeEvent[206000b][4][81][0][0]
529: 757.851 [PTP] ptpPropertyChangeEvent[206000c][4][81][0][0]
530: 757.935 [PTP] ptpPropertyChangeEvent[4010000][4][1][0][0]
531: 758.009 [PTP] ptpPropertyChangeEvent[4010002][4][0][0][0]
532: 758.078 [PTP] ptpPropertyChangeEvent[4010004][4][0][0][0]
533: 758.153 [PTP] ptpPropertyChangeEvent[4010001][4128][844128][0][0]
534: 758.472 [PTP] ptpPropertyChangeEvent[4010003][4128][0][0][0]
535: 758.800 [PTP] ptpPropertyChangeEvent[4010005][4128][0][0][0]
536: 759.133 [PTP] ptpPropertyChangeEvent[80040012][24][0][0][0]
537: 759.232 [PTP] Dispatch : Cur = 0, Event = 6, Param = 0x2
538: 759.273 [PTP] PtpPropSetStorageID:1,1,0
539: 759.334 [PTP] PtpPropSetStorageID:1,0,0x0 -> 0x10000
540: 759.400 [PTP] Dispatch : Cur = 0, Event = 6, Param = 0x2
541: 759.431 [PTP] PtpPropSetStorageID:1,1,1
542: 759.473 [PTP] PtpPropSetStorageID:1,1,0x10000 -> 0x10001
543: 759.536 [PTP] Dispatch : Cur = 0, Event = 6, Param = 0x2
544: 759.587 [PTP] Dispatch : Cur = 0, Event = 6, Param = 0x2
545: 759.653 [PTP] Dispatch : Cur = 0, Event = 6, Param = 0x2
546: 759.677 [PTP] PtpPropSetStorageID:3,0,0
547: 759.717 [PTP] PtpPropSetStorageID:0,0,0x0 -> 0x30000
548: 759.773 [PTP] Dispatch : Cur = 0, Event = 6, Param = 0x2
549: 759.797 [PTP] PtpPropSetStorageID:3,0,0
550: 759.823 [PTP] PtpPropSetStorageID:0,0,0x30000 -> 0x30000
551: 759.876 [PTP] Dispatch : Cur = 0, Event = 6, Param = 0x2
552: 759.892 [PTP] PROP_CARD3_CLUSTER_SIZE = 0
553: 759.938 [PTP] Dispatch : Cur = 0, Event = 6, Param = 0x2
554: 759.986 [PTP] Dispatch : Cur = 0, Event = 8, Param = 0x2
555: 760.044 [PTP] Dispatch : Cur = 0, Event = 8, Param = 0x2
556: 760.062 [PTP] PROP_LAST_JOB_STATE = 0
557: 760.103 [PTP] Dispatch : Cur = 0, Event = 8, Param = 0x2
558: 760.124 [PTP] PROP_ICU_AUTO_POWEROFF 1
559: 760.172 [PTP] Dispatch : Cur = 0, Event = 10, Param = 0x0
560: 760.220 [PTP] ptpConnectModeChanged:ffffffff -> ffffffff
561: 760.242 [MAGIC] SetPtpTransportResources:0,3199
562: 760.513 [PTP] Dispatch : Cur = 0, Event = 2, Param = 0x1
563: 760.847 [RMT] PROP_CONNECT_TARGET_WFT (0x0 <= 0x0)
564: 760.989 [PTP] PROP_CONNECT_TARGET_WFT [0]
565: 761.032 PROP_CONNECT_TARGET_WFT = 0x0 <= 0x0
566: 761.074 ceresPropertyChangeCBR ID[0x80030019] Size[0x4]
567: 761.519 [PTP] PROP_LOGICAL_CONNECT_WFT[0]
568: 761.609 [PTP] PtpWftConnectInfo [0]
569: 761.778 [PTP] Dispatch : Cur = 0, Event = 2, Param = 0x0
570: 761.816 [PTP] ptpNoAction 0 7572356
571: 761.878 [PTP] Dispatch : Cur = 0, Event = 5, Param = 0x2
572: 761.908 [PTP] PROP_CONNECT_TARGET_WFT (0x0 <= 0x0)
573: 762.020 ceresPropertyChanged (0x501000d, 1078942252)
574: 762.049 WriteFROM Normal:0,0
575: 762.168 ceresPropertyChanged (0x80040004, 0)
576: 762.220 ceresPropertyChanged (0x80030012, 0)
577: 762.262 ceresSendEvent (0xd1e1, 0)
578: 762.316 [PTP] PD_WftRequestEvent ID(0xc189)
579: 762.363 [PTP] ptpEvtGetTargetEventList Not Regist ID :0x2
580: 762.400 [CERES] PD_WftRequestEvent d1e1
581: 762.451 ceresSendEvent (0xd1e2, 0)
582: 762.483 [PTP] PD_WftRequestEvent ID(0xc189)
583: 762.522 [PTP] ptpEvtGetTargetEventList Not Regist ID :0x2
584: 762.555 [CERES] PD_WftRequestEvent d1e2
585: 762.607 ceresSendEvent (0xd1e3, 0)
586: 762.646 [PTP] PD_WftRequestEvent ID(0xc189)
587: 762.684 [PTP] ptpEvtGetTargetEventList Not Regist ID :0x2
588: 762.716 [CERES] PD_WftRequestEvent d1e3
589: 762.761 ceresSendEvent (0xd1e4, 0)
590: 762.797 [PTP] PD_WftRequestEvent ID(0xc189)
591: 762.826 [PTP] ptpEvtGetTargetEventList Not Regist ID :0x2
592: 762.857 [CERES] PD_WftRequestEvent d1e4
593: 762.899 ceresSendEvent (0xd1e5, 0)
594: 762.930 [PTP] PD_WftRequestEvent ID(0xc189)
595: 762.960 [PTP] ptpEvtGetTargetEventList Not Regist ID :0x2
596: 762.988 [CERES] PD_WftRequestEvent d1e5
597: 763.033 ceresSendEvent (0xd1e6, 0)
598: 763.062 [PTP] PD_WftRequestEvent ID(0xc189)
599: 763.090 [PTP] ptpEvtGetTargetEventList Not Regist ID :0x2
600: 763.123 [CERES] PD_WftRequestEvent d1e6
601: 763.174 ceresSendEvent (0xd1e8, 0)
602: 763.202 [PTP] PD_WftRequestEvent ID(0xc189)
603: 763.230 [PTP] ptpEvtGetTargetEventList Not Regist ID :0x2
604: 763.259 [CERES] PD_WftRequestEvent d1e8
605: 763.304 ceresSendEvent (0xd1ea, 0)
606: 763.334 [PTP] PD_WftRequestEvent ID(0xc189)
607: 763.360 [PTP] ptpEvtGetTargetEventList Not Regist ID :0x2
608: 763.387 [CERES] PD_WftRequestEvent d1ea
609: 763.430 ceresSendEvent (0xd1e9, 0)
610: 763.464 [PTP] PD_WftRequestEvent ID(0xc189)
611: 763.492 [PTP] ptpEvtGetTargetEventList Not Regist ID :0x2
612: 763.523 [CERES] PD_WftRequestEvent d1e9
613: 763.571 ceresSendEvent (0xc1e3, 1)
614: 763.591 [PTP] PD_WftRequestEvent ID(0xc1e3)
615: 763.624 [PTP] ptpEvtGetTargetEventList Not Regist ID :0x2
616: 763.686 ceresSendEvent (0xc1ea, 1078942252)
617: 763.720 ceresSendEvent (0xd1ec, 0)
618: 763.751 [PTP] PD_WftRequestEvent ID(0xc189)
619: 763.788 [PTP] ptpEvtGetTargetEventList Not Regist ID :0x2
620: 763.816 [CERES] PD_WftRequestEvent d1ec
621: 763.907 [FM] fmActivate
622: 763.935 [FM] fmPreparePlayback (Drive = 1)
623: 763.962 [FC] _FC_OpenCatalog (A:)
624: 764.474 [SDIOTSK] sdioTskTerminate : ExternalDisconnect(0)
625: 765.840 ceresPropertyChangeCBR ID[0x8003001d] Size[0x60]
626: 765.871 [CERES] PROP_BATTERY_REPORT:1
627: 765.888 [CERES] 1,0,5a,3
628: 791.047 [FC] Root(1):(Dirs:4,Files:378,Arch:378)
629: 793.862 [FC] Root(2):(Dirs:0,Files:0,Arch:0)
630: 793.891 [FC] Drive:(Dirs:6,Files:378,Arch:378)
631: 794.084 [FR] FR_Initialize (ID = 1, A:)
632: 794.109 [FR] frCreate (A:)
633: 794.343 [FW] FW_Initialize (ID = 36, A:)
634: 794.361 [FW] fwCreate (A:)
635: 794.974 [MRK] PropertyCallback : CurrentMedia = 1
636: 795.109 [MRK] PropertyCallback : Card1 Exist = 0x00000001
637: 795.138 [MRK] PropertyCallback : Card2 Exist = 0x00000000
638: 795.164 [MRK] PropertyCallback : Card3 Exist = 0x00000000
639: 795.184 [MRK] PropertyCallback : Card1 Status = 0x00000001
640: 795.204 [MRK] PropertyCallback : Card2 Status = 0x00000000
641: 795.226 [MRK] PropertyCallback : Card3 Status = 0x00000000
642: 795.448 [FC] _FC_GetMrkHandle (1, 0, 0, 0, 0)(1)
643: 795.558 [FC] _FC_GetMrkType (1, 2, 2, 512, 6)
644: 795.645 [FC] _FC_GetMrkHandle (1, 0, 0, 0, 0)(2)
645: 795.714 [FC] _FC_GetMrkType (1, 2, 2, 4096, 6)
646: 795.791 [FM] fmSetAllDcfNo(0xe)(0,0,0)
647: 796.015 [FM] fmResultCBR (0x7ad96c)
648: 796.309 [SEQ] NotifyComplete (Cur = 4, 0x10, Flag = 0x10)
649: 796.455 [FM] PROP_CARD1_STATUS = 0x1
650: 796.551 [FM] PROP_CARD1_FOLDER_NUMBER = 103
651: 796.637 [FM] PROP_CARD2_STATUS = 0x0
652: 796.694 [FM] PROP_CARD2_FOLDER_NUMBER = 100
653: 796.748 [FM] PROP_CARD3_EXIST = 0
654: 796.797 [FM] PROP_CARD3_STATUS = 0x0
655: 796.849 [FM] PROP_CARD3_FOLDER_NUMBER = 100
656: 796.912 [FM] PROP_FILE_NUMBERING_MODE = 1, 306
657: 796.969 [FM] PROP_CARD_EXTENSION = 0
658: 797.021 [FM] PROP_CURRENT_MEDIA = 1
659: 797.096 [FM] PROP_USBDEVICE_CONNECT = -1
660: 797.203 [PTP] Dispatch : Cur = 0, Event = 7, Param = 0x2
661: 797.333 [PTP] Dispatch : Cur = 0, Event = 11, Param = 0x2
662: 797.374 [PTP] ptpPropertySendPropValuet[d1a5][3][0][0]
663: 797.467 [SEQ] seqEventDispatch (Startup, 4)
664: 797.485 [STARTUP] startupPreparePlayback
665: 797.759 [DP] DP_Initialize()
666: 797.779 [DP] DP_Create()
667: 797.801 [DP] CreateTaskClass()
668: 798.020 [DP] CreateEventFlag()
669: 798.509 [DP] DP_DataInitialize()
670: 798.533 [DP] Dp_InitializeDpPrinterMgrT()
671: 798.552 [DP] Dp_InitializeDpPrinterCurrentStateT()
672: 798.566 [DP] Dp_InitializeDpJobMgrT()
673: 798.644 [DP] Std T_PrintPage[0] T_PrintNo[0] R_PrintNo[0]
674: 798.681 [DP] Std C_PrintNo[0] C_PrintPage[0], C_Copies[0]
675: 798.773 [DP] Dp_SetPD_RegistApi Prev:0 New:0
676: 798.793 [DP] Dp_InitializeMemoryResourceForDirectPrint()
677: 799.072 [DP] Dp_ReadCancel Drv:0 RdExec:0
678: 799.131 [DP] Dp_ReadCancel Drv:0 RdExec:0
679: 799.175 [DP] Dp_ReadCancel Drv:0 RdExec:0
680: 799.253 [DP] PROP_CONNECT_TARGET [0x00000000]
681: 799.381 [DP] PROP_PHYSICAL_CONNECT [0x00000000]
682: 799.405 [DP] RD_Cancel No Issue
683: 799.751 [DP] [GYO]DpFunctionList[0x10117fff]
684: 799.864 [DP] X FreeMem Address[0x00000000]
685: 799.915 [PTP] PD_RegistSendObjectCBR (ff8ca858)
686: 799.935 [DP] DP_ImgEdit_main()
687: 799.952 [DP] DP_ImgEdit_Create()
688: 799.982 [DP] CreateTaskClass()
689: 800.143 [DP] DP_ImgEdit_CreateStateObject()
690: 800.550 [PTP] PROP_WFT_SYSTEM[0x0]
691: 800.599 [PTP] PROP_PHYSICAL_CONNECT[0][0][0]
692: 800.709 [MP] MVP_Initialize (44, 22)
693: 801.089 [MP_MOV] MOVR_InitializeMovReader (45, 23)
694: 801.533 [STARTUP] AllocateVramCBR pAddress=43f00000
695: 801.579 [DISP] InitializeDisplayDeviceController (PUB)
696: 802.867 [DISP] Port Setting Fin
697: 802.967 [BmpDDev] InitializeBitmapDisplayDevice (PUB)
698: 803.699 [HDMI] [EDID] PROP_CFN_TAB2 HDMI THRUE 0
699: 803.758 [HDMI] [EDID] VIDEO_SYSTEM 0
700: 803.991 [HDMI] hdmiChangeAckCBR (0)
701: 804.074 [HDMI] HPD OFF
702: 804.109 [HDMI] DisconnectHDMI : Not Connected
703: 804.138 [SVG] CreateBufferMemory()
704: 804.188 [GUI] GUI_Initialize ClassID[131]GUI[23]Ctrl[24]
705: 804.470 [GUI] -> handleGuiInit
706: 810.589 [IMPP] [H264Dec] InitializeH264DecRotatePath 553
707: 810.786 [IMPP] [H264ForHD] InitializeH264DecForHdPath
708: 810.963 [IMPD] (PUB) InitializeImagePlayDriver 1964
709: 811.239 [IMP] (PUB) InitializeImagePlayer 1132
710: 811.287 [GUI] PlayMovieMain.c InitializePlayBack
711: 811.344 [GUI_E] AllocateVramCBR pAddress=43f80000
712: 811.423 [BmpDDev] CreatePhysicalVram (PUB)
713: 813.832 [BmpDDev] DisplayPhysicalScreen (PUB) 0x43F00008
714: 816.595 [CERES] RegisterAdapterStatusCallback
715: 829.487 [GUI] GuiStartGraphics (PUB)
716: 829.720 [RSC] SRM_AllocateMemoryResourceForImgVram 131 3
717: 829.874 [RSC] srmAllocateImgVram 131 3
718: 829.893 [RSC] ImgVram Before -1 -1 -1
719: 829.935 [RSC] ImgVram After 131 131 131
720: 830.040 [IMP] (PUB) StartImagePlayer(mode=0) 1203
721: 830.075 [IMP] (PUB) SetVisibleImageVramOffset 4064
722: 830.098 [IMP] (PUB) SetCopyVramMode(mode=0) 1411
723: 830.111 [GUI] GuiGraphicsNormalMode (PUB)
724: 830.161 [IMP] (PUB) SetImageWorkMemory 1:0x40d00000, 2:0x41700000
725: 830.190 [IMP] (PUB) SetImageWorkMaxPixel W:2200,H:1872,0x5e4340
726: 830.222 [IMP] (PUB) SetEffectiveSizeOfJpeg(w:7488 h:4992) 2995
727: 830.244 [IMP] (PUB) SetYuvColorParameter 1447
728: 830.339 [GUI] IDLEHandler INITIALIZE_CONTROLLER
729: 830.367 [GUI] IDLEHandler GOT_TOP_OF_CONTROL
730: 830.383 [GUI] GuiClearImage
731: 830.415 [IMP] (PUB) SetVramInformation(w:1920 h:1080)
732: 830.458 [IMP] 1920x1080 BaseVram:1920, VramYuv:1
733: 830.481 [IMP] 1920x1080 BaseVram:1920, VramYuv:1
734: 830.521 [IMP] SetImageVramParameter x:0 y:0 w:1920 h:1080/* Aspect:0*/
735: 830.547 [IMP] (PUB) SyncroAllClearImagePlayWorkVramWithoutEngine 2953
736: 830.561 [IMP] GetVramNumber 619
737: 830.576 [IMP] GetVramNumber 619
738: 849.180 [IMP] (PUB) SetVramInformation(w:720 h:480)
739: 849.208 [IMP] 720x480 BaseVram:720, VramYuv:1
740: 849.228 [IMP] 720x480 BaseVram:720, VramYuv:1
741: 849.257 [IMP] SetImageVramParameter x:0 y:0 w:720 h:480/* Aspect:0*/
742: 849.275 [IMP] GetVramNumber 619
743: 849.322 [DISP] EnableImagePhysicalScreenParameter
744: 849.602 [IMP] GetVramNumber 619
745: 849.624 [IMP] GetVramNumber 619
746: 849.645 [GUI] StopDateTimer
747: 849.665 [GUI] ClearColorPalette (0)
748: 849.726 [GUI] GUI_RegisterPropertySlave
749: 854.212 [SHTC] scsProperty ID=0x80020002(0x0)
750: 854.929 [LVCFG] PROP_LV_OUTPUT_DEVICE 0 0
751: 855.491 [LVCFG] PROP_OUTPUT_TYPE 0(0) / 0
752: 855.792 [LV] PROP_LV_MIRROR_DOWN_STATUS 0 0
753: 855.832 [LV] lvSetBadFrame Old:a New:2 -> a L:6109
754: 856.198 [GUI] MasterResultCBR_AvailableMyMenuList(0x876f44)
755: 856.350 [GUI] MasterResultCBR_ErrBattery(0x876fe4)
756: 856.744 [DP] DP_RegisterCBR() Id=1 Count:12
757: 856.784 [DP] DP_RegisterCBR() Id=2 Count:12
758: 856.810 [DP] DP_RegisterCBR() Id=4 Count:12
759: 857.051 [HDMI] [EDID] VIDEO_SYSTEM 0
760: 857.190 [GUI] GUI_SetLanguage (0)
761: 857.485 [GUI] ManualBrightness[5]
762: 857.686 [SEQ] NotifyComplete (Cur = 5, 0x200200, Flag = 0x200000)
763: 857.703 [GUI] <- handleGuiInit
764: 861.768 [GUI] guiDispSensorStop
765: 861.787 [MC] DisplaySensorStop
766: 862.355 [GUI] PROP_CARD1_EXIST[1]
767: 862.423 [GUI] PROP_CARD2_EXIST[0]
768: 862.481 [GUI] PROP_CARD3_EXIST[0]
769: 862.548 [GUI] PROP_CARD1_STATUS[1]
770: 862.609 [GUI] PROP_CARD2_STATUS[0]
771: 862.668 [GUI] MainEventHandler PROP_CARD3_STATUS(0x0)
772: 862.685 [GUI] PROP_CARD3_STATUS[0]
773: 863.025 [GUI] PROP_PROGRAM_SHIFT[0]
774: 863.537 [GUI] MainEventHandler PROP_ICU_UILOCK(0x0)
775: 863.635 [GUI] MainEventHandler PROP_GUIGROUND_STATE(0)
776: 863.742 [MC] Current DisplaySensor : 0
777: 863.762 [GUI] MainEventHandler PROP_DISPSENSOR_CTRL(0)
778: 863.953 [GUI] GuiMainEventHandler.c PROP_BATTERY_REPORT size<96>
779: 863.982 [GUI] GUI_GetNumOfBatteriesHistory: num<0>
780: 864.018 [GUI] PROP_BATTERY_REPORT copysize (96)<-(96)
781: 864.177 [GUI] MainEventHndler PROP_CONNECT_TARGET(0x0)
782: 864.582 [GUI] MainEventHandler handleLastJobState(0x0)
783: 864.773 [GUI] MainEventHandler VIDEO_DISCONNECT
784: 864.853 [GUI] MainEventHandler HDMI_DISCONNECT
785: 864.961 [GUI] MainEventHndler PROP_CONNECT_TARGET_WFT(0x0)
786: 865.033 [GUI] PROP_STROBO_SETTING
787: 865.047 [GUI] StroboSettingData.status[0x0]
788: 865.060 [GUI] StroboSettingData.setting0[0x0]
789: 865.073 [GUI] StroboSettingData.setting1[0x0]
790: 865.086 [GUI] StroboSettingData.setting2[0x0]
791: 865.099 [GUI] StroboSettingData.setting3[0x3]
792: 865.113 [GUI] StroboSettingData.setting4[0x0]
793: 865.127 [GUI] StroboSettingData.setting5[0x0]
794: 865.141 [GUI] StroboSettingData.setting6[0x0]
795: 865.154 [GUI] StroboSettingData.setting7[0x21]
796: 865.168 [GUI] StroboSettingData.setting8[0x0]
797: 865.182 [GUI] StroboSettingData.setting9[0x0]
798: 865.194 [GUI] StroboSettingData.setting10[0x0]
799: 865.208 [GUI] StroboSettingData.setting11[0x1f]
800: 865.222 [GUI] StroboSettingData.setting12[0x0]
801: 865.234 [GUI] StroboSettingData.setting13[0x3]
802: 865.249 [GUI] StroboSettingData.setting14[0x80]
803: 865.657 [GUI] HDMI_VIDEO_CODE 0
804: 865.928 [GUI] MainEventHandler PROP_CURRENT_MEDIA(1)
805: 865.995 [GUI] GUI_GetTotalFileInDrive hDriveHandle(0x50000000)
806: 866.065 [FC] _FC_GetDriveObject (1,1)
807: 866.122 [GUI] GUI_GetTotalFileInDrive FM_GetDriveObject Num(378)
808: 866.539 [GUI] GuiPropertyData PROP_WIZARD_WFT size(3b0)<-(3b0)
809: 866.823 [GUI] MainEventHandler PROP_TEMP_STATUS(0)
810: 866.917 [GUI] CurrentLensName[EF85mm f/1.8 USM]
811: 867.174 [GUI] MainEventHandler PROP_ERROR_FOR_DISPLAY(0)
812: 867.264 [GUI] PROP_PHOTO_STUDIO_MODE (0)
813: 867.571 [GUI] PROP_SHUTTER_COUNTER [8812932][8]
814: 867.797 [GUI] MainEventHandler PROP_SCREEN_SAVER
815: 868.250 [GUI] MainEventHandler PROP_LV_ACTION(1)
816: 868.269 [GUI] MainEventHandler PROP_LV_STOP
817: 868.286 [GUI] GuiClearBackImageWithoutRefresh
818: 868.321 [IMP] (PUB) SetVramInformation(w:1920 h:1080)
819: 868.371 [IMP] 1920x1080 BaseVram:1920, VramYuv:1
820: 868.396 [IMP] 1920x1080 BaseVram:1920, VramYuv:1
821: 868.434 [IMP] (PUB) SyncroAllClearImagePlayIdleVramWithoutEngine 2926
822: 868.449 [IMP] GetVramNumber 619
823: 887.060 [IMP] (PUB) SetVramInformation(w:720 h:480)
824: 887.090 [IMP] 720x480 BaseVram:720, VramYuv:1
825: 887.110 [IMP] 720x480 BaseVram:720, VramYuv:1
826: 887.148 [GUI] StopLiveViewApp hThisDialog Nothing!
827: 887.170 [GUI] StopLiveViewPictureStyleApp
828: 887.213 [BmpDDev] ChangePhysicalScreen (PUB) 0x43F80008
829: 897.564 [GUI] PROP_LV_ACTION[1]
830: 897.789 [GUI] MainEventHandler PROP_LV_DISPBUSY(0)
831: 897.866 [BmpDDev] ChangePhysicalScreen (PUB) 0x43F00008
832: 908.183 [GUI] PROP_LV_DISPBUSY[0]
833: 909.398 [GUI] PROP_SLIDESHOW [8814272]
834: 909.880 [GUI] PROP_BATTERY_HISTORY copysize (76)<-(76)
835: 910.220 [GUI] PROP_MOVIE_SOUND_RECORD [3]
836: 910.347 [GUI] PROP_MOVIE_PARAM [8815076]
837: 910.476 [GUI] PROP_MOVIE_REC_VOLUME L/R[47/47]
838: 911.773 [GUI] PropertyData PROP_USBDEVICE_CONNECT[0xffffffff]->[0xffffffff]
839: 912.136 [GUI] PropertyData mymenuList.dwSize[30]
840: 912.158 [GUI] PropertyData mymenuList.dwNoOfMyMenu[5]
841: 912.179 [GUI] PropertyData MyMenuItem0.dwOrderMyMenu[1]
842: 912.205 [GUI] PropertyData MyMenuItem0.dwMenuID[20010]
843: 912.223 [GUI] PropertyData MyMenuItem1.dwOrderMyMenu[2]
844: 912.241 [GUI] PropertyData MyMenuItem1.dwMenuID[70001]
845: 912.255 [GUI] PropertyData MyMenuItem2.dwOrderMyMenu[3]
846: 912.273 [GUI] PropertyData MyMenuItem2.dwMenuID[6000e]
847: 912.288 [GUI] PropertyData MyMenuItem3.dwOrderMyMenu[4]
848: 912.306 [GUI] PropertyData MyMenuItem3.dwMenuID[2001e]
849: 912.320 [GUI] PropertyData MyMenuItem4.dwOrderMyMenu[5]
850: 912.338 [GUI] PropertyData MyMenuItem4.dwMenuID[50002]
851: 912.356 [GUI] PropertyData MyMenuItem5.dwOrderMyMenu[20547]
852: 912.370 [GUI] PropertyData MyMenuItem5.dwMenuID[6]
853: 912.494 [GUI] GuiPropertyData PROP_DATA_INPUT_TRANSMISSION (1e4)<-(1e4)
854: 912.914 [GUI] MainEventHndler PROP_WFT_SYSTEM Err Clear
855: 912.957 [GUI] GuiPropertyData PROP_WFT_SYSTEM size(18)<-(18)
856: 913.070 [GUI] GuiPropertyData PROP_WFT_ADAPTERINFO (24)<-(24)
857: 913.193 [GUI] GuiPropertyData PROP_WFT_TCPIP ConfigNo(0) (220)<-(220)
858: 913.309 [GUI] GuiPropertyData PROP_WFT_FTP ConfigNo(0) (89c)<-(89c)
859: 913.467 [GUI] GuiPropertyData PROP_WFT_WIRELESS ConfigNo(0) (4f0)<-(4f0)
860: 913.600 [GUI] GuiPropertyData PROP_WFT_WIRED ConfigNo(0) (40)<-(40)
861: 913.709 [GUI] GuiPropertyData PROP_WFT_TRANSMISSION ConfigNo(0) (2c)<-(2c)
862: 913.822 [GUI] GuiPropertyData PROP_WFT_DONGLE ConfigNo(0) (310)<-(310)
863: 913.932 [GUI] GuiPropertyData PROP_WFT_IMAGE_TRANS (1c)<-(1c)
864: 914.043 [GUI] GuiPropertyData PROP_WFT_LOCK ConfigNo(0) (18)<-(18)
865: 914.158 [GUI] GuiPropertyData PROP_WFT_CAPTION ConfigNo(0) (54)<-(54)
866: 914.264 [GUI] GuiPropertyData PROP_WFT_HTTP (e0)<-(e0)
867: 914.364 [GUI] GuiPropertyData PROP_WFT_HOSTINFO (1f8)<-(1f8)
868: 914.512 [GUI] GuiPropertyData PROP_WFT_C2C (1c0)<-(1c0)
869: 914.625 [GUI] GuiPropertyData PROP_WFT_BLUETOOTH (120)<-(120)
870: 914.717 [GUI] MainEventHandler PROP_VIDEO_SYSTEM(0)
871: 915.656 [GUI] GUI_GetTotalFileInDrive hDriveHandle(0x50000000)
872: 915.744 [FC] _FC_GetDriveObject (1,1)
873: 915.809 [GUI] GUI_GetTotalFileInDrive FM_GetDriveObject Num(378)
874: 916.059 [PRP] MovieParamData
875: 916.126 [PRP] #mode 0 size 0x0 , framerate 0x1e , type 0xf
876: 916.617 [MR] mvrChangeAckCBR : Video - Mode=0, Type=0, Rate=30, GOP=15
877: 916.737 [LVCFG] PROP_MOVIE_PARAM 0 1
878: 917.215 [GUI] MainEventHandler PROP_LV_OUTPUT_DEVICE(0)
879: 917.241 [GUI] MainEventHndler PROP_LV_OUTPUT_DEVICE(0x0)
880: 917.497 [GUI] MainEventHandler PROP_VIDEO_SYSTEM(0)
881: 918.119 [GUI] PROP_MOVIE_PARAM [8876912]
882: 918.286 [IMPD] ImagePlayDriverTask 1833
883: 918.418 [FCS] fcsActivate
884: 918.479 [FCS] BodyID = 0x131478fb, 4
885: 918.768 [FCS] fcsChangeAckCBR : PROP_GPS_STATUS (0)
886: 918.812 [FCS] fcsChangeAckCBR : PROP_SPECIAL_OPTION (0)
887: 918.847 [FCS] fcsChangeAckCBR : PROP_ARTIST ()
888: 918.943 [FCS] fcsChangeAckCBR : PROP_COPYRIGHT (Trammell Hudson)
889: 919.034 [PRP] MovieParamData
890: 919.095 [PRP] #mode 0 size 0x0 , framerate 0x1e , type 0xf
891: 919.523 [MR] mvrChangeAckCBR : Video - Mode=0, Type=0, Rate=30, GOP=15
892: 919.659 [LVCFG] PROP_MOVIE_PARAM 0 1
893: 920.130 [GUI] PROP_MOVIE_PARAM [8877212]
894: 920.393 [DP] Dp_InitializeRequest()
895: 920.416 [DP] DpCurrentState = DEFAULT or PTP
896: 920.510 [DP] RegisterDPSNotifyCBR(NOTIFY_PRINTER_CONNECT)
897: 920.528 [DP] RegisterDPSNotifyCBR(NOTIFY_PRINTER_CONNECT)
898: 920.541 [DP] RegisterDPSNotifyCBR(NOTIFY_JOB_STATE)
899: 920.554 [DP] RegisterDPSNotifyCBR(NOTIFY_DEVICE_STATUS)
900: 920.600 [SEQ] NotifyComplete (Cur = 5, 0x200, Flag = 0x200)
901: 920.732 tomActivate
902: 920.762 [TOM] tomCheckOrder (ID = 1)
903: 920.798 [TOM_F] tomGetTOFInfo (ID = 1)
904: 921.114 [TOM_F] tomGetTOFInfo : Not exist
905: 921.149 [TOM_F] tomIsFileReadOnly (ID = 1)
906: 921.374 [TOM_F] tomIsFileReadOnly : Not exist
907: 921.412 [TOM_C] tomGetTOFEntryList (ID = 1)
908: 921.450 [TOM_C] tomGetTOFEntryList : Cache Not Hit (ID = 2792088)
909: 921.467 [TOM_C] tomRefillCache (ID = 1)
910: 921.483 [TOM_F] tomGetTOFInfo (ID = 1)
911: 921.702 [TOM_F] tomGetTOFInfo : Not exist
912: 921.723 [TOM_C] tomRefillCache : Not Exist ?
913: 921.749 [TOM_F] tomGetTOFInfo (ID = 1)
914: 921.948 [TOM_F] tomGetTOFInfo : Not exist
915: 922.111 tomRegister
916: 922.244 [PTP] ptpPropertyChangeEvent[80050011][4][0][0][0]
917: 922.396 [PTP] ptpPropertyChangeEvent[80050019][4][c80][0][0]
918: 922.497 [PTP] ptpPropertyChangeEvent[80050018][4][0][0][0]
919: 922.591 [PTP] ptpPropertyChangeEvent[80050016][4][1][0][0]
920: 922.674 [PTP] ptpPropertyChangeEvent[80050023][4][0][0][0]
921: 922.765 [PTP] ptpPropertyChangeEvent[80040009][4][3ad0][0][0]
922: 922.861 [PTP] ptpPropertyChangeEvent[2040003][4][0][0][0]
923: 922.948 [PTP] ptpPropertyChangeEvent[80000039][10][0][0][0]
924: 923.055 [PTP] ptpPropertyChangeEvent[80000039][10][0][0][0]
925: 923.155 [SEQ] seqEventDispatch (Startup, 5)
926: 923.176 [STARTUP] startupInitializeComplete
927: 923.423 [DL] InitializeDL (0x0)
928: 923.595 [DL] PROP_ACTIVE_SWEEP_STATUS (0)
929: 923.634 [DL] PROP_EFIC_TEMP (154)
930: 923.705 [DL] PROP_DL_SYMPATHETIC_VIBRATION (1528)
931: 923.727 [DL] PROP_DL_ACTION (1)
932: 923.847 [BIND] bindChangeModeCompleteCBR (0, 0, 0)
933: 923.912 [MC] cam event guimode comp. 0
934: 923.984 [BIND] bindChangeLcdStateCompleteCBR (0)
935: 924.014 [BIND] bindChangeShootTypeCompleteCBR (0 => 0)
936: 924.126 [BIND] PROP_STARTUP_CONDITION (1)
937: 924.175 [BIND] GUI_STATE : IDLE (SW = 1, JOB = 0)
938: 924.192 [GUI_E] GUI_ChangeMode:0
939: 924.243 [GUI_E] GUI_Control:21 0x0
940: 924.280 [BIND] PROP_LCD_STATE : OFF
941: 924.299 [GUI_E] GUI_ChangeLcdState:0
942: 924.336 [BIND] PROP_LAST_JOB_STATE (SW = 1, GUI = 0)
943: 924.358 [BIND] PROP_SHOOTING_TYPE : NORMAL
944: 924.379 [GUI_E] GUI_ChangeShootType:0
945: 924.412 [BIND] ACTIVE_SWEEP_STATUS : 0 (0)
946: 924.680 [GUI_M] GUI_ChangeMode_Post:0, 0, 0
947: 924.813 [GUI_M] GUI_ChangeLcdState_Post:0
948: 924.878 [GUI_M] GUI_ChangeShootType_Post:0
949: 925.143 [GUI] IDLEHandler START_IDLE_MODE
950: 925.187 [BIND] bindChangeModeCompleteCBR (0, 0, 0)
951: 925.244 [MC] cam event guimode comp. 0
952: 925.325 < GUI Lock > GUILock_TurnOffDisplay (PUB)
953: 925.410 < GUI Lock > GUILockTask 2
954: 925.453 [DISP] TurnOffDisplay (PUB) Type=0 fDisplayTurnOn=0
955: 926.078 [GUI] IDLEHandler START_SHOOT_NORMAL
956: 926.124 [BIND] bindChangeShootTypeCompleteCBR (0 => 0)
957: 926.144 [GUI] GUI_SetLvAction (1)
958: 926.297 [MC] Request LV_ACTION : (1)
959: 926.384 < GUI Lock > GUILock_TurnOffDisplay (PUB)
960: 926.475 < GUI Lock > GUILockTask 2
961: 926.539 [DISP] TurnOffDisplay (PUB) Type=0 fDisplayTurnOn=0
962: 927.265 < GUI Lock > GUILock_PermitLock (PUB)
963: 927.329 [IMPD] (PUB) UnlockImagePlayDiriver
964: 927.360 [IMPD] SetLockState 321
965: 927.634 [GUI_E] GUI_Control:42 0x0
966: 927.756 [BIND] PROP_PERMIT_ICU_EVENT (SW = 1, 1)
967: 927.780 [GUI_E] GUI_Control:43 0x1
968: 928.034 [BIND] bindReceiveSwitch (17, 1)
969: 928.085 [BIND] LOCK (1)
970: 928.114 [BIND] bindReceiveSwitch (39)
971: 928.134 [GUI_E] GUI_Control:39 0x0
972: 928.260 [BIND] bindReceiveSwitch (18, 0)
973: 928.282 [BIND] bindReceiveSwitch (41)
974: 928.297 [GUI_E] GUI_Control:41 0x0
975: 928.358 [BIND] bindReceiveSwitch (19, 0)
976: 928.608 [GUI_M] GUICMD_UI_OK
977: 928.722 [GUI_M] GUICMD_START_AS_CHECK
978: 928.799 [GUI_M] GUICMD_LOCK_ON
979: 928.874 [GUI_M] GUICMD_CLOSE_SLOT_COVER
980: 929.034 [GUI] IDLEHandler UI_OK
981: 929.133 [GUI] GUI_RefreshBatteriesHistory()
982: 929.559 [BIND] bindReceiveNewTFTOLC
983: 929.614 [GUI_E] GUI_Control:59 0x87777c
984: 929.790 [BIND] PROP_LCD_STATE : ON
985: 929.822 [GUI_E] GUI_ChangeLcdState:1
986: 930.363 [GUI] GUI_SetLvMirrorDownStatus status=0 prestatus=0
987: 930.568 [GUI_M] GUI_ChangeLcdState_Post:1
988: 931.103 [GUI] GUI_GetBatteriesHistory: copysize (76)<-(76)
989: 931.148 [GUI] GUI_SetBatteriesHistory(0x172be0)
990: 931.644 [GUI] IDLEHandler START_AS_CHECK[1]
991: 931.718 [GUI] IDLEHandler GUI_LOCK_ON
992: 931.792 [GUI] IDLEHandler CLOSE_SLOT_COVER
993: 931.945 [GUI] PROP_BATTERY_HISTORY copysize (76)<-(76)
994: 932.273 [FA] ChangeCBR(ID=0x8003000a)
995: 933.587 [SHTC] scsProperty ID=0x80040000(0x0)
996: 935.628 [FAC] [PTPtoFAPI]StartupPTPtoFAPI
997: 939.554 [SEQ] seqEventDispatch (Startup) : End
998: 939.756 [FSS] fssRegister (0x0, 0x0)
999: 939.861 [PTP] Dispatch : Cur = 0, Event = 10, Param = 0x2
1000: 939.897 [PTP] ptpPropertyOlcInfoChangeEvent[1][4][1][0][0]
1001: 939.913 [PTP] ptpNotifyOlcInfoChanged:1,4
1002: 939.990 [PTP] Dispatch : Cur = 0, Event = 10, Param = 0x2
1003: 940.016 [PTP] ptpPropertyOlcInfoChangeEvent[2][4][0][0][0]
1004: 940.030 [PTP] ptpNotifyOlcInfoChanged:0,4
1005: 940.114 [PTP] Dispatch : Cur = 0, Event = 10, Param = 0x2
1006: 940.141 [PTP] ptpPropertyOlcInfoChangeEvent[0][4][0][0][0]
1007: 940.155 [PTP] ptpNotifyOlcInfoChanged:0,4
1008: 940.218 [PTP] Dispatch : Cur = 0, Event = 10, Param = 0x2
1009: 940.242 [PTP] ptpPropertyOlcInfoChangeEvent[3][4][0][0][0]
1010: 940.256 [PTP] ptpNotifyOlcInfoChanged:0,4
1011: 940.312 [PTP] Dispatch : Cur = 0, Event = 10, Param = 0x2
1012: 940.339 [PTP] ptpPropertyOlcInfoChangeEvent[0][4][0][0][0]
1013: 940.352 [PTP] ptpNotifyOlcInfoChanged:0,4
1014: 940.432 [PTP] ptpPropertyChangeEvent[8000002c][4][63][0][0]
1015: 940.542 [PTP] ptpPropertyChangeEvent[8000002d][4][15][0][0]
1016: 940.636 [PTP] ptpPropertyChangeEvent[8000002e][4][55][0][0]
1017: 940.776 [MRK] CreateObject : Handle = 0x60082006
1018: 940.854 [MRK] CreateObject : File not exist
1019: 940.895 [MRK] PrepareCallback : Success(Handle = 0x60082006)
1020: 941.018 [MRK] CreateObject : Handle = 0x60090006
1021: 941.071 [MRK] CreateObject : File not exist
1022: 941.101 [MRK] PrepareCallback : Success(Handle = 0x60090006)
1023: 1201.038 [LVCFG] PROP_EFIC_TEMP 24��
1024: 1201.162 [DL] PROP_EFIC_TEMP (152)
1025: 1262.127 [MAGIC] config_parse_line: malloc(128) = 87e36c
1026: 1262.158 [MAGIC] config_parse_line: 'zebra.level' => '61440'
1027: 1262.172 [MAGIC] config_auto_parse: 'zebra.level' unused?
1028: 1263.921 [MAGIC] config_parse_line: malloc(128) = 87e3f8
1029: 1263.950 [MAGIC] config_parse_line: 'zebra.draw' => '0'
1030: 1263.966 [MAGIC] config_auto_parse: 'zebra.draw' unused?
1031: 1270.114 [MAGIC] config_parse_line: malloc(128) = 87e484
1032: 1270.137 [MAGIC] config_parse_line: 'edge.draw' => '0'
1033: 1270.153 [MAGIC] config_auto_parse: 'edge.draw' unused?
1034: 1274.391 [MAGIC] config_parse_line: malloc(128) = 87e510
1035: 1274.417 [MAGIC] config_parse_line: 'crop.draw' => '0'
1036: 1274.433 [MAGIC] config_auto_parse: 'crop.draw' unused?
1037: 1276.057 [MAGIC] config_parse_line: malloc(128) = 87e59c
1038: 1276.079 [MAGIC] config_parse_line: 'hist.draw' => '0'
1039: 1276.093 [MAGIC] config_auto_parse: 'hist.draw' unused?
1040: 1298.857 [MAGIC] config_parse_line: malloc(128) = 87e628
1041: 1298.882 [MAGIC] config_parse_line: 'audio.mgain' => '4'
1042: 1298.895 [MAGIC] config_auto_parse: 'audio.mgain' unused?
1043: 1314.183 [MAGIC] config_parse_line: malloc(128) = 87e6b4
1044: 1314.214 [MAGIC] config_parse_line: 'audio.dgain' => '18 # dB'
1045: 1314.229 [MAGIC] config_auto_parse: 'audio.dgain' unused?
1046: 1323.833 [MAGIC] config_parse_line: malloc(128) = 87e740
1047: 1323.860 [MAGIC] config_parse_line: 'audio.mic-power' => '1'
1048: 1323.876 [MAGIC] config_auto_parse: 'audio.mic-power' unused?
1049: 1343.828 [MAGIC] config_parse_line: malloc(128) = 87e7cc
1050: 1343.854 [MAGIC] config_parse_line: 'enable-liveview' => '1'
1051: 1343.871 [MAGIC] config_auto_parse: 'enable-liveview' unused?
1052: 1363.229 [MAGIC] config_parse_line: malloc(128) = 87e858
1053: 1363.254 [MAGIC] config_parse_line: 'disable-powersave' => '1'
1054: 1363.269 [MAGIC] config_auto_parse: 'disable-powersave' unused?
1055: 1365.511 [MAGIC] config_parse_line: malloc(128) = 87e8e4
1056: 1365.537 [MAGIC] config_parse_line: 'reloc.enabled' => '1'
1057: 1365.550 [MAGIC] config_auto_parse: 'reloc.enabled' unused?
1058: 1365.691 [MAGIC] config_parse: Read 11 config values