da dav16 » ven mag 04, 2007 4:31 pm
questa è la diagnosi fatto con itunes (aiuto-diagniosi-ipod)
Microsoft Windows XP Home Edition Service Pack 2 (Build 2600)
Packard Bell BV EasyNote_MX45
iTunes 7.0.2.16
iPodService 7.0.2.16 attualmente funzionante.
iTunesHelper 7.0.2.16 attualmente funzionante.
L'utente attuale è amministratore.
Dispositivi di archiviazione collegato:
IDE\DiskST9120822A______________________________3.ALA___, Bus Type ATA, Bus Address [0,0]
USBSTOR\DiskApple___iPod____________1.62
Controller USB (Universal serial bus):
Intel(R) 82801G (ICH7 Family) USB Universal Host Controller - 27C8, Bus PCI 0, periferica 29, funzione 0. Il dispositivo funziona correttamente
Intel(R) 82801G (ICH7 Family) USB Universal Host Controller - 27C9, Bus PCI 0, periferica 29, funzione 1. Il dispositivo funziona correttamente
Intel(R) 82801G (ICH7 Family) USB Universal Host Controller - 27CA, Bus PCI 0, periferica 29, funzione 2. Il dispositivo funziona correttamente
Intel(R) 82801G (ICH7 Family) USB Universal Host Controller - 27CB, Bus PCI 0, periferica 29, funzione 3. Il dispositivo funziona correttamente
Intel(R) 82801G (ICH7 Family) USB2 Enhanced Host Controller - 27CC, Bus PCI 0, periferica 29, funzione 7. Il dispositivo funziona correttamente
Non è stato trovato alcun controller host IEEE 1394.
Informazione sul dispositivo collegato
IPOD, eseguo versione firmware 1.1.2
Numero di serie: 5U651Z1NVQ5
Velocità bus: 61440
Numero di serie dell'ultimo iPod collegato: 5U651Z1NVQ5.
Informazioni sui log del servizio iPod:
[SERVICE: 0x944,15:18:54 INFO] Started C:\Programmi\iPod\bin\iPodService.exe (Fri May 04 15:18:54 2007)
[SERVICE: 0x944,15:18:54 INFO] ##### iPodService starting as a service, version: 7.0.2.16
[SERVICE: 0x95C,15:18:54 INFO] Got signaled to go ahead... Starting device manager!
[SERVICE: 0x9B4,15:18:54 INFO] Listener Window created
[SERVICE: 0x9B4,15:18:56 INFO] [DevNodesChanged]
[SERVICE: 0x9B4,15:18:56 INFO] [DevNodesChanged]
[SERVICE: 0x9B4,15:18:57 INFO] [DevNodesChanged]
[SERVICE: 0x9B4,15:18:57 INFO] [DevNodesChanged]
[SERVICE: 0x9B4,15:19:17 INFO] [DevNodesChanged]
[SERVICE: 0x9B4,15:19:17 INFO] [DevNodesChanged]
[SERVICE: 0x9B4,15:19:17 INFO] [DevNodesChanged]
[SERVICE: 0x9B4,15:19:17 INFO] [DevNodesChanged]
[SERVICE: 0x9B4,15:19:18 INFO] [DevNodesChanged]
[SERVICE: 0x9B4,15:19:23 INFO] [DevNodesChanged]
[SERVICE: 0x9B4,15:19:26 INFO] [DevNodesChanged]
[SERVICE: 0x9B4,15:21:38 INFO] [DevNodesChanged]
[SERVICE: 0x9B4,15:21:38 INFO] [DevNodesChanged]
[SERVICE: 0x9B4,15:21:38 INFO] [DevNodesChanged]
[SERVICE: 0x9B4,15:21:40 INFO] [InterfaceArrival] \\?\usbstor#disk&ven_apple&prod_ipod&rev_1.62#000a2700195e186d&0#{53f56307-b6bf-11d0-94f2-00a0c91efb8b}
[SERVICE: 0x9B4,15:21:40 INFO] device \\?\usbstor#disk&ven_apple&prod_ipod&rev_1.62#000a2700195e186d&0#{53f56307-b6bf-11d0-94f2-00a0c91efb8b}
[SERVICE: 0x9B4,15:21:40 INFO] device is an iPod
[SERVICE: 0x9B4,15:21:40 INFO] type 0x7 drive 0x1 partition 0x0
[SERVICE: 0x9B4,15:21:40 INFO] [-1] set waiting to mount = 1
[SERVICE: 0x9B4,15:21:40 INFO] [1] Assigning session 0
[SERVICE: 0x9B4,15:21:40 INFO] [1] added device interface "\\?\usbstor#disk&ven_apple&prod_ipod&rev_1.62#000a2700195e186d&0#{53f56307-b6bf-11d0-94f2-00a0c91efb8b}" to m_objDeviceNameMap
[SERVICE: 0x9B4,15:21:40 INFO] [1] added state machine 1 to m_objDeviceIdMap
[SERVICE: 0x9B4,15:21:40 INFO] [1] added device number 1 to m_objDeviceNumberMap
[SERVICE: 0x9B4,15:21:40 INFO] [1] added device interface "\\?\usbstor#disk&ven_apple&prod_ipod&rev_1.62#000a2700195e186d&0#{53f56307-b6bf-11d0-94f2-00a0c91efb8b}" to m_vctDeviceInterfaces
[SERVICE: 0x9B4,15:21:40 INFO] [DevNodesChanged]
[SERVICE: 0x9B4,15:21:40 INFO] [1] input #0 from src #0
[SERVICE: 0x9A4,15:21:40 INFO] [1] input #0
[SERVICE: 0x9B4,15:21:40 INFO] [DevNodesChanged]
[SERVICE: 0x9B4,15:21:40 INFO] [1] input #1 from src #0
[SERVICE: 0x9AC,15:21:40 INFO] [1] input #1
[SERVICE: 0x9B4,15:21:40 INFO] [VolumeArrive] mask = 0x20
[SERVICE: 0x9B4,15:21:40 INFO] looking up device # for \\.\F:
[SERVICE: 0x9B4,15:21:40 INFO] type 0x7 drive 0x1 partition 0x1
[SERVICE: 0x9B4,15:21:40 INFO] iTunes device #1 found with drive letter F, mask 0x20
[SERVICE: 0x9B4,15:21:40 INFO] [1] set waiting to mount = 0
[SERVICE: 0x9B4,15:21:40 INFO] [DevNodesChanged]
[SERVICE: 0x9B4,15:21:40 INFO] [1] input #2 from src #0
[SERVICE: 0x9A8,15:21:40 INFO] [1] input #2
[SERVICE: 0x9B4,15:21:40 INFO] [DevNodesChanged]
[SERVICE: 0x9B4,15:21:40 INFO] [1] input #3 from src #0
[SERVICE: 0x9B4,15:21:40 INFO] [DevNodesChanged]
[SERVICE: 0x9B4,15:21:40 INFO] [1] input #4 from src #0
[SERVICE: 0x9A4,15:21:41 INFO] [MACHINE 1 INPUT #0] - (HDW) CheckDevNode
[SERVICE: 0x9A4,15:21:41 INFO] Connection Detection Status - 0x180600A, device '\\?\usbstor#disk&ven_apple&prod_ipod&rev_1.62#000a2700195e186d&0#{53f56307-b6bf-11d0-94f2-00a0c91efb8b}'
[SERVICE: 0x9AC,15:21:41 INFO] [MACHINE 1 INPUT #1] - (HDW) CheckDevNode
[SERVICE: 0x9AC,15:21:41 INFO] Connection Detection Status - 0x180600A, device '\\?\usbstor#disk&ven_apple&prod_ipod&rev_1.62#000a2700195e186d&0#{53f56307-b6bf-11d0-94f2-00a0c91efb8b}'
[SERVICE: 0x9A8,15:21:41 INFO] [MACHINE 1 INPUT #2] - (HDW) CheckDevNode
[SERVICE: 0x9A8,15:21:41 INFO] Connection Detection Status - 0x180600A, device '\\?\usbstor#disk&ven_apple&prod_ipod&rev_1.62#000a2700195e186d&0#{53f56307-b6bf-11d0-94f2-00a0c91efb8b}'
[SERVICE: 0x9A8,15:21:41 INFO] [1] input #3
[SERVICE: 0x9A4,15:21:41 INFO] [1] input #4
[SERVICE: 0x9A8,15:21:41 INFO] [MACHINE 1 INPUT #3] - (HDW) CheckDevNode
[SERVICE: 0x9A8,15:21:41 INFO] Connection Detection Status - 0x180600A, device '\\?\usbstor#disk&ven_apple&prod_ipod&rev_1.62#000a2700195e186d&0#{53f56307-b6bf-11d0-94f2-00a0c91efb8b}'
[SERVICE: 0x9A4,15:21:41 INFO] [MACHINE 1 INPUT #4] - (HDW) CheckDevNode
[SERVICE: 0x9A4,15:21:41 INFO] Connection Detection Status - 0x180600A, device '\\?\usbstor#disk&ven_apple&prod_ipod&rev_1.62#000a2700195e186d&0#{53f56307-b6bf-11d0-94f2-00a0c91efb8b}'
[SERVICE: 0x9B0,15:21:44 INFO] Connection Detection Status - 0x180600A, device '\\?\usbstor#disk&ven_apple&prod_ipod&rev_1.62#000a2700195e186d&0#{53f56307-b6bf-11d0-94f2-00a0c91efb8b}'
[SERVICE: 0x9B0,15:21:44 INFO] [First Connect] Creating connect event for device 1
[SERVICE: 0x9B0,15:21:44 INFO] [1] set waiting to mount = 1
[SERVICE: 0x9B0,15:21:44 INFO] [1] input #5 from src #0
[SERVICE: 0x9AC,15:21:44 INFO] [1] input #5
[SERVICE: 0x9AC,15:21:44 INFO] [MACHINE 1 INPUT #5] - (HDW) Interface Arrival
[SERVICE: 0x9AC,15:21:44 INFO] [1] progress state is 2, Waiting to mount = 1
[SERVICE: 0x9AC,15:21:44 INFO] [1] progress is now 2
[SERVICE: 0x9AC,15:21:44 INFO] [1] progress is now 2
[SERVICE: 0x9AC,15:21:44 INFO] [MACHINE 1 TRANSITION] - {Unknown} ==> {Connected}
[SERVICE: 0x9AC,15:21:44 INFO] [MACHINE 1 ACTIONS] - {Connected}
[SERVICE: 0x9AC,15:21:44 INFO] [1] SCSI Inquiry attempt #0
[SERVICE: 0x9AC,15:21:44 INFO] VendorId: Apple
[SERVICE: 0x9AC,15:21:44 INFO] ProductId: iPod
[SERVICE: 0x9AC,15:21:44 INFO] revision: 1.62
[SERVICE: 0x9AC,15:21:44 INFO] vendor bytes:
[SERVICE: 0x9AC,15:21:44 INFO] 02 01 00 00 00 00 00 00 00 10 00 07 92 00 00 00 00 00 00 00
[SERVICE: 0x9AC,15:21:44 INFO] [1] firmware version: 1.62 (0x13E)
[SERVICE: 0x9AC,15:21:44 INFO] [1] Power State: Powered
[SERVICE: 0x9AC,15:21:44 INFO] [1] Checkpoint attempt #0
[SERVICE: 0x9AC,15:21:44 ERROR] Did not find first letter of stage
[SERVICE: 0x9AC,15:21:44 INFO] got HotPlugState 0
[SERVICE: 0x9AC,15:21:44 INFO] [1] serial number 000A2700195E186D
[SERVICE: 0x9AC,15:21:44 INFO] [1] ***** CONNECTED - Sending event out, device session 0.
[SERVICE: 0x9B0,15:21:45 INFO] [First Connect] Creating mount event for device 1
[SERVICE: 0x9B0,15:21:45 INFO] [VolumeArrive] mask = 0x2C
[SERVICE: 0x9B0,15:21:45 INFO] looking up device # for \\.\F:
[SERVICE: 0x9B0,15:21:45 INFO] type 0x7 drive 0x1 partition 0x1
[SERVICE: 0x9B0,15:21:45 INFO] iTunes device #1 found with drive letter F, mask 0x20
[SERVICE: 0x9B0,15:21:45 INFO] [1] set waiting to mount = 0
[SERVICE: 0x9B0,15:21:45 INFO] [1] input #6 from src #0
[SERVICE: 0x9B0,15:21:45 INFO] looking up device # for \\.\D:
[SERVICE: 0x9B0,15:21:45 INFO] type 0x2 drive 0x0 partition 0xffffffff
[SERVICE: 0x9A8,15:21:45 INFO] [1] input #6
[SERVICE: 0x9B0,15:21:45 INFO] [SIMULATED INTERFACE ARRIVAL] generating connect event for device 0
[SERVICE: 0x9B0,15:21:45 INFO] looking up device # for \\?\usbstor#disk&ven_apple&prod_ipod&rev_1.62#000a2700195e186d&0#{53f56307-b6bf-11d0-94f2-00a0c91efb8b}
[SERVICE: 0x9B0,15:21:45 INFO] type 0x7 drive 0x1 partition 0x0
[SERVICE: 0x9A8,15:21:45 INFO] [MACHINE 1 INPUT #6] - (HDW) Volume Mount
[SERVICE: 0x9A8,15:21:45 INFO] [MACHINE 1 TRANSITION] - {Connected} ==> {Mounted}
[SERVICE: 0x9A8,15:21:45 INFO] Connection Detection Status - 0x180600A, device '\\?\usbstor#disk&ven_apple&prod_ipod&rev_1.62#000a2700195e186d&0#{53f56307-b6bf-11d0-94f2-00a0c91efb8b}'
[SERVICE: 0x9A8,15:21:45 INFO] [MACHINE 1 ACTIONS] - {Mounted}
[SERVICE: 0x9A8,15:21:45 INFO] [1] progress state is 2, Waiting to mount = 0
[SERVICE: 0x9A8,15:21:45 INFO] [1] progress state is 2, Waiting to mount = 0
[SERVICE: 0x9A8,15:21:45 ERROR] Did not find first letter of stage
[SERVICE: 0x9A8,15:21:45 INFO] got HotPlugState 0
[SERVICE: 0x9A8,15:21:45 INFO] [1] OS says filesystem is FAT32
[SERVICE: 0x9A8,15:21:45 INFO] [1] ===== iPod Nano =====
[SERVICE: 0x9A8,15:21:45 INFO] [1] progress state is 2, Waiting to mount = 0
[SERVICE: 0x9A8,15:21:45 INFO] 15:21:45, year 2007, day of yr. 123, GMT offset 8 isDST 1
[SERVICE: 0x9A8,15:21:54 INFO] FAILED! Last Error = 0x79
[SERVICE: 0x9A8,15:21:54 INFO] m_hDisk = 0x0000022c, ScsiStatus = 0x00000000, sense pStrBuffer:
[SERVICE: 0x9A8,15:21:54 INFO] 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
[SERVICE: 0x9A8,15:21:54 ASSERT] Assertion failure: 'result' [File: .\DeviceManagement\iPodDevice.cpp, Line: 611]
[SERVICE: 0x9A8,15:21:54 ASSERT] Assertion failure: 'SetCurrentTime()' [File: .\DeviceManagement\iTunesDevice.cpp, Line: 2349]
[SERVICE: 0x9A8,15:21:54 INFO] [1] progress is now 0
[SERVICE: 0x9A8,15:21:56 INFO] [1] ***** MOUNTED - Sending event out, device session 0.
[SERVICE: 0x9A8,15:21:56 INFO] [1] Auto-launch iTunes DISABLED
[SERVICE: 0x994,15:23:06 INFO] <0x4> Got Serial #
[SERVICE: 0x994,15:23:06 INFO] <0x4> GetFormatType() returned unknown format 0
[SERVICE: 0x99C,15:23:06 INFO] [1] Progress state is 0, Waiting to disconnect = 0
[SERVICE: 0x99C,15:23:06 INFO] Mounted
[SERVICE: 0x99C,15:23:06 INFO] Device 1 is FAT32 and appears mounted, checking intermediate state...
[SERVICE: 0x99C,15:23:06 INFO] Device 1 not in intermediate state. It appears to be truly mounted.
[SERVICE: 0x994,15:23:06 INFO] Mounted
[SERVICE: 0x994,15:23:06 INFO] [1] already mounted!
[SERVICE: 0x994,15:23:06 INFO] [1] progress state is 0, Waiting to mount = 0
[SERVICE: 0x994,15:23:08 INFO] <0x4> GetFormatType() returned unknown format 0
[SERVICE: 0x99C,15:23:08 INFO] [1] Progress state is 0, Waiting to disconnect = 0
[SERVICE: 0x99C,15:23:08 INFO] Mounted
[SERVICE: 0x99C,15:23:08 INFO] Device 1 is FAT32 and appears mounted, checking intermediate state...
[SERVICE: 0x99C,15:23:08 INFO] Device 1 not in intermediate state. It appears to be truly mounted.
[SERVICE: 0x994,15:23:08 INFO] <0x4> COM request for device 1 drive letter - F
[SERVICE: 0x994,15:23:08 INFO] [1] Progress state is 0, Waiting to disconnect = 0
[SERVICE: 0x994,15:23:08 INFO] Mounted
[SERVICE: 0x994,15:23:08 INFO] Device 1 is FAT32 and appears mounted, checking intermediate state...
[SERVICE: 0x994,15:23:08 INFO] Device 1 not in intermediate state. It appears to be truly mounted.
[SERVICE: 0x99C,15:23:08 INFO] Mounted
[SERVICE: 0x99C,15:23:08 INFO] [1] already mounted!
[SERVICE: 0x99C,15:23:08 INFO] [1] progress state is 0, Waiting to mount = 0
[SERVICE: 0x994,15:23:20 INFO] Mounted
[SERVICE: 0x994,15:23:20 INFO] Device 0 is FAT32 and appears mounted, checking intermediate state...
[SERVICE: 0x994,15:23:20 INFO] Device 0 not in intermediate state. It appears to be truly mounted.
[SERVICE: 0x994,15:23:20 INFO] [1] input #7 from src #286156
[SERVICE: 0x9A4,15:23:20 INFO] [1] input #7
[SERVICE: 0x9A4,15:23:20 INFO] [MACHINE 1 INPUT #7] - (APP) Mountlock Unmount
[SERVICE: 0x9A4,15:23:20 INFO] [1] Begin Unmounting...
[SERVICE: 0x9A4,15:23:20 INFO] [1] progress is now 3
[SERVICE: 0x9A4,15:23:20 INFO] total locks = 1, caller = 2468, caller locks = 1
[SERVICE: 0x9A4,15:23:20 INFO] Ejecting media
[SERVICE: 0x9A4,15:23:20 INFO] SUCCESS
[SERVICE: 0x9A4,15:23:20 INFO] Volume lock success!
[SERVICE: 0x9A4,15:23:23 INFO] total locks = 2, caller = 2468, caller locks = 2
[SERVICE: 0x9A4,15:23:24 INFO] CM_Query_And_Remove_SubTreeW stop
[SERVICE: 0x9B4,15:23:24 INFO] [DevNodesChanged]
[SERVICE: 0x9B4,15:23:24 INFO] [1] input #8 from src #0
[SERVICE: 0x9AC,15:23:24 INFO] [1] input #8
[SERVICE: 0x9B4,15:23:24 INFO] [DevNodesChanged]
[SERVICE: 0x9B4,15:23:24 INFO] [1] input #9 from src #0
[SERVICE: 0x9A8,15:23:24 INFO] [1] input #9
[SERVICE: 0x9A4,15:23:24 INFO] CM_Query_And_Remove_SubTreeW took 204 ms
[SERVICE: 0x9A4,15:23:24 INFO] total locks = 1, caller = 2468, caller locks = 1
[SERVICE: 0x9A4,15:23:24 INFO] total locks = 0, caller = 2468, caller locks = 0
[SERVICE: 0x9A4,15:23:24 INFO] [1] Finished Unmounting with status 1
[SERVICE: 0x9A4,15:23:24 INFO] NOT Mounted
[SERVICE: 0x9A4,15:23:24 INFO] [1] **** NOT in intermediate state, device is Mounted
[SERVICE: 0x9A4,15:23:24 INFO] [MACHINE 1 TRANSITION] - {Mounted} ==> {iTunesPseudoUnmounting}
[SERVICE: 0x9A4,15:23:24 INFO] [MACHINE 1 ACTIONS] - {iTunesPseudoUnmounting}
[SERVICE: 0x99C,15:23:24 INFO] [1] Progress state is 3, Waiting to disconnect = 0
[SERVICE: 0x9B4,15:23:24 INFO] [VolumeRemoved] existing mask 0x20, arrive mask 0x20
[SERVICE: 0x9B4,15:23:24 INFO] [1] value = 1
[SERVICE: 0x9B4,15:23:24 INFO] [1] input #10 from src #0
[SERVICE: 0x9B4,15:23:24 INFO] [InterfaceRemoved]
[SERVICE: 0x9B4,15:23:24 INFO] [1] value = 0
[SERVICE: 0x9A4,15:23:24 INFO] [1] input #10
[SERVICE: 0x9B4,15:23:24 INFO] removed device number 1 from m_objDeviceNumberMap
[SERVICE: 0x9B4,15:23:24 INFO] [1] input #11 from src #0
[SERVICE: 0xCC4,15:23:25 INFO] [1] Progress state is 3, Waiting to disconnect = 0
[SERVICE: 0x994,15:23:25 INFO] NOT Mounted
[SERVICE: 0x994,15:23:25 INFO] [1] Unmount in progress, wait till finish...
[SERVICE: 0x9AC,15:23:25 INFO] [MACHINE 1 INPUT #8] - (HDW) CheckDevNode
[SERVICE: 0x9AC,15:23:25 INFO] Connection Detection Status - 0x180600A, device '\\?\usbstor#disk&ven_apple&prod_ipod&rev_1.62#000a2700195e186d&0#{53f56307-b6bf-11d0-94f2-00a0c91efb8b}'
[SERVICE: 0x9A8,15:23:25 INFO] [MACHINE 1 INPUT #9] - (HDW) CheckDevNode
[SERVICE: 0x9A8,15:23:25 INFO] Connection Detection Status - 0x180600A, device '\\?\usbstor#disk&ven_apple&prod_ipod&rev_1.62#000a2700195e186d&0#{53f56307-b6bf-11d0-94f2-00a0c91efb8b}'
[SERVICE: 0x9A4,15:23:25 INFO] [MACHINE 1 INPUT #10] - (HDW) Volume Unmount
[SERVICE: 0x9A4,15:23:25 INFO] [1] progress is now 3
[SERVICE: 0x9A4,15:23:25 INFO] [1] Setting progress to 3
[SERVICE: 0x9A4,15:23:25 INFO] *** CItunesDevice::HandleHardwareInput()
[SERVICE: 0x9A4,15:23:25 INFO] [1] input #11
[SERVICE: 0x9A4,15:23:25 INFO] [MACHINE 1 INPUT #11] - (HDW) Interface Removal
[SERVICE: 0x9A4,15:23:25 INFO] [MACHINE 1 TRANSITION] - {iTunesPseudoUnmounting} ==> {iTunesPseudoUnmounted}
[SERVICE: 0x9A4,15:23:25 INFO] [MACHINE 1 ACTIONS] - {iTunesPseudoUnmounted}
[SERVICE: 0x9A4,15:23:25 INFO] [1] ***** iTunesPseudoUnmounted - Sending event out, device session 0
[SERVICE: 0x9A4,15:23:25 INFO] [1] progress is now 0
[SERVICE: 0x994,15:23:25 INFO] NOT Mounted
[SERVICE: 0x994,15:23:25 INFO] [1] progress state is 0, Waiting to mount = 0
[SERVICE: 0x994,15:23:25 INFO] [1] progress state is 0, Waiting to mount = 0
[SERVICE: 0x994,15:23:25 INFO] Connection Detection Status - 0x180600A, device '\\?\usbstor#disk&ven_apple&prod_ipod&rev_1.62#000a2700195e186d&0#{53f56307-b6bf-11d0-94f2-00a0c91efb8b}'
[SERVICE: 0x994,15:23:25 INFO] [1] input #12 from src #286156
[SERVICE: 0x9AC,15:23:25 INFO] [1] input #12
[SERVICE: 0x9AC,15:23:25 INFO] [MACHINE 1 INPUT #12] - (APP) Mountlock Mount
[SERVICE: 0x9AC,15:23:25 INFO] [1] Begin Mounting...
[SERVICE: 0x9AC,15:23:25 INFO] [1] progress is now 2
[SERVICE: 0x9AC,15:23:25 INFO] NOT USB
[SERVICE: 0x9B4,15:23:27 INFO] [DevNodesChanged]
[SERVICE: 0x9B4,15:23:27 INFO] [1] input #13 from src #0
[SERVICE: 0x9A8,15:23:27 INFO] [1] input #13
[SERVICE: 0x9B4,15:23:27 INFO] [InterfaceArrival] \\?\usbstor#disk&ven_apple&prod_ipod&rev_1.62#000a2700195e186d&0#{53f56307-b6bf-11d0-94f2-00a0c91efb8b}
[SERVICE: 0x9B4,15:23:27 INFO] type 0x7 drive 0x1 partition 0x0
[SERVICE: 0x9B4,15:23:27 INFO] [1] set waiting to mount = 1
[SERVICE: 0x9B4,15:23:27 INFO] [1] added device interface "\\?\usbstor#disk&ven_apple&prod_ipod&rev_1.62#000a2700195e186d&0#{53f56307-b6bf-11d0-94f2-00a0c91efb8b}" to m_objDeviceNameMap
[SERVICE: 0x9B4,15:23:27 INFO] [1] added state machine 1 to m_objDeviceIdMap
[SERVICE: 0x9B4,15:23:27 INFO] [1] added device number 1 to m_objDeviceNumberMap
[SERVICE: 0x9B4,15:23:27 INFO] [1] input #14 from src #0
[SERVICE: 0x9A4,15:23:27 INFO] [1] input #14
[SERVICE: 0x9B4,15:23:27 INFO] [DevNodesChanged]
[SERVICE: 0x9B4,15:23:27 INFO] [1] input #15 from src #0
[SERVICE: 0x9B4,15:23:27 INFO] [DevNodesChanged]
[SERVICE: 0x9B4,15:23:27 INFO] [1] input #16 from src #0
[SERVICE: 0x9B4,15:23:27 INFO] [VolumeArrive] mask = 0x20
[SERVICE: 0x9B4,15:23:27 INFO] looking up device # for \\.\F:
[SERVICE: 0x9B4,15:23:27 INFO] type 0x7 drive 0x1 partition 0x1
[SERVICE: 0x9B4,15:23:27 INFO] iTunes device #1 found with drive letter F, mask 0x20
[SERVICE: 0x9B4,15:23:27 INFO] [1] set waiting to mount = 0
[SERVICE: 0x9B4,15:23:27 INFO] [1] input #17 from src #0
[SERVICE: 0x9B4,15:23:27 INFO] [DevNodesChanged]
[SERVICE: 0x9B4,15:23:27 INFO] [1] input #18 from src #0
[SERVICE: 0x9AC,15:23:27 INFO] SUCCESS
[SERVICE: 0x9A8,15:23:27 INFO] [MACHINE 1 INPUT #13] - (HDW) CheckDevNode
[SERVICE: 0x9A8,15:23:27 INFO] Connection Detection Status - 0x180600A, device '\\?\usbstor#disk&ven_apple&prod_ipod&rev_1.62#000a2700195e186d&0#{53f56307-b6bf-11d0-94f2-00a0c91efb8b}'
[SERVICE: 0x9A4,15:23:27 INFO] [MACHINE 1 INPUT #14] - (HDW) Interface Arrival
[SERVICE: 0x9A4,15:23:27 INFO] [1] progress state is 2, Waiting to mount = 0
[SERVICE: 0x9A4,15:23:27 INFO] [1] progress is now 2
[SERVICE: 0x9A4,15:23:27 INFO] [1] progress is now 2
[SERVICE: 0x9AC,15:23:27 INFO] [1] progress is now 2
[SERVICE: 0x9AC,15:23:27 INFO] [MACHINE 1 TRANSITION] - {FalsePseudoMounting} ==> {iTunesPseudoMounting}
[SERVICE: 0x9AC,15:23:27 INFO] [MACHINE 1 ACTIONS] - {iTunesPseudoMounting}
[SERVICE: 0x9AC,15:23:27 INFO] [1] input #15
[SERVICE: 0x994,15:23:27 INFO] [1] progress state is 2, Waiting to mount = 0
[SERVICE: 0x994,15:23:27 INFO] [1] Mount in progress, wait till finish...
[SERVICE: 0x9A4,15:23:27 INFO] [MACHINE 1 TRANSITION] - {FalsePseudoMounting} ==> {iTunesPseudoMounting}
[SERVICE: 0x9A4,15:23:27 INFO] [MACHINE 1 ACTIONS] - {iTunesPseudoMounting}
[SERVICE: 0x9A4,15:23:27 INFO] [1] input #16
[SERVICE: 0x9A8,15:23:28 INFO] [1] input #17
[SERVICE: 0x9AC,15:23:28 INFO] [MACHINE 1 INPUT #15] - (HDW) CheckDevNode
[SERVICE: 0x9AC,15:23:28 INFO] Connection Detection Status - 0x180600A, device '\\?\usbstor#disk&ven_apple&prod_ipod&rev_1.62#000a2700195e186d&0#{53f56307-b6bf-11d0-94f2-00a0c91efb8b}'
[SERVICE: 0x9A4,15:23:28 INFO] [MACHINE 1 INPUT #16] - (HDW) CheckDevNode
[SERVICE: 0x9A4,15:23:28 INFO] Connection Detection Status - 0x180600A, device '\\?\usbstor#disk&ven_apple&prod_ipod&rev_1.62#000a2700195e186d&0#{53f56307-b6bf-11d0-94f2-00a0c91efb8b}'
[SERVICE: 0x9A4,15:23:28 INFO] [1] input #18
[SERVICE: 0x9A8,15:23:28 INFO] [MACHINE 1 INPUT #17] - (HDW) Volume Mount
[SERVICE: 0x9A8,15:23:28 INFO] [MACHINE 1 TRANSITION] - {iTunesPseudoMounting} ==> {Mounted}
[SERVICE: 0x9A8,15:23:28 INFO] Connection Detection Status - 0x180600A, device '\\?\usbstor#disk&ven_apple&prod_ipod&rev_1.62#000a2700195e186d&0#{53f56307-b6bf-11d0-94f2-00a0c91efb8b}'
[SERVICE: 0x9A8,15:23:28 INFO] [1] ***** iTunesPseudoMounting state finalizing internal mount
[SERVICE: 0x9A8,15:23:28 INFO] total locks = 1, caller = 2472, caller locks = 1
[SERVICE: 0x9A8,15:23:28 INFO] SUCCESS
[SERVICE: 0x9A8,15:23:28 INFO] Volume lock success!
[SERVICE: 0x9A4,15:23:28 INFO] [MACHINE 1 INPUT #18] - (HDW) CheckDevNode
[SERVICE: 0x9A4,15:23:28 INFO] Connection Detection Status - 0x180600A, device '\\?\usbstor#disk&ven_apple&prod_ipod&rev_1.62#000a2700195e186d&0#{53f56307-b6bf-11d0-94f2-00a0c91efb8b}'
[SERVICE: 0x9A8,15:23:29 INFO] total locks = 0, caller = 2472, caller locks = 0
[SERVICE: 0x9A8,15:23:29 INFO] [1] Finished Mounting with status 1
[SERVICE: 0x9A8,15:23:29 INFO] [MACHINE 1 ACTIONS] - {Mounted}
[SERVICE: 0x9A8,15:23:29 INFO] [1] progress state is 2, Waiting to mount = 0
[SERVICE: 0x9A8,15:23:29 INFO] [1] progress state is 2, Waiting to mount = 0
[SERVICE: 0x9A8,15:23:29 ERROR] Did not find first letter of stage
[SERVICE: 0x9A8,15:23:29 INFO] got HotPlugState 0
[SERVICE: 0x9A8,15:23:29 INFO] [1] OS says filesystem is FAT32
[SERVICE: 0x9A8,15:23:29 INFO] [1] ===== iPod Nano =====
[SERVICE: 0x9A8,15:23:29 INFO] [1] progress state is 2, Waiting to mount = 0
[SERVICE: 0x9A8,15:23:29 INFO] 15:23:29, year 2007, day of yr. 123, GMT offset 8 isDST 1
[SERVICE: 0x9A8,15:23:31 INFO] [1] progress is now 0
[SERVICE: 0x994,15:23:31 INFO] [1] progress state is 0, Waiting to mount = 0
[SERVICE: 0x99C,15:23:31 INFO] <0x4> GetFormatType() returned unknown format 0
[SERVICE: 0xCC4,15:23:31 INFO] [1] Progress state is 0, Waiting to disconnect = 0
[SERVICE: 0xCC4,15:23:31 INFO] Mounted
[SERVICE: 0xCC4,15:23:31 INFO] Device 1 is FAT32 and appears mounted, checking intermediate state...
[SERVICE: 0xCC4,15:23:31 INFO] Device 1 not in intermediate state. It appears to be truly mounted.
[SERVICE: 0x994,15:23:31 INFO] <0x4> COM request for device 1 drive letter - F
[SERVICE: 0x99C,15:23:32 INFO] [1] input #19 from src #4
[SERVICE: 0x9A8,15:23:33 INFO] [1] ***** MOUNTED - Sending event out, device session 0.
[SERVICE: 0x9A8,15:23:33 INFO] [1] input #19
[SERVICE: 0x9A8,15:23:33 INFO] [MACHINE 1 INPUT #19] - (APP) Unmount - lock count not 0, ignoring
[SERVICE: 0x99C,15:23:33 ERROR] <0x4> Request failed!
[SERVICE: 0x994,15:23:38 INFO] <0x4> GetFormatType() returned unknown format 0
[SERVICE: 0xCC4,15:23:42 INFO] Mounted
[SERVICE: 0xCC4,15:23:42 INFO] Device 0 is FAT32 and appears mounted, checking intermediate state...
[SERVICE: 0xCC4,15:23:42 INFO] Device 0 not in intermediate state. It appears to be truly mounted.
[SERVICE: 0xCC4,15:23:42 INFO] [1] input #20 from src #286156
[SERVICE: 0x9A4,15:23:42 INFO] [1] input #20
[SERVICE: 0x9A4,15:23:42 INFO] [MACHINE 1 INPUT #20] - (APP) Mountlock Unmount
[SERVICE: 0x9A4,15:23:42 INFO] [1] Begin Unmounting...
[SERVICE: 0x9A4,15:23:42 INFO] [1] progress is now 3
[SERVICE: 0x9A4,15:23:42 INFO] total locks = 1, caller = 2468, caller locks = 1
[SERVICE: 0x9A4,15:23:42 INFO] Ejecting media
[SERVICE: 0x9A4,15:23:42 INFO] SUCCESS
[SERVICE: 0x9A4,15:23:43 INFO] Volume lock success!
[SERVICE: 0x9A4,15:23:46 INFO] total locks = 2, caller = 2468, caller locks = 2
[SERVICE: 0x9A4,15:23:47 INFO] CM_Query_And_Remove_SubTreeW stop
[SERVICE: 0x9B4,15:23:47 INFO] [DevNodesChanged]
[SERVICE: 0x9B4,15:23:47 INFO] [1] input #21 from src #0
[SERVICE: 0x9AC,15:23:47 INFO] [1] input #21
[SERVICE: 0x9B4,15:23:47 INFO] [DevNodesChanged]
[SERVICE: 0x9B4,15:23:47 INFO] [1] input #22 from src #0
[SERVICE: 0x9A8,15:23:47 INFO] [1] input #22
[SERVICE: 0x9A4,15:23:47 INFO] CM_Query_And_Remove_SubTreeW took 94 ms
[SERVICE: 0x9A4,15:23:47 INFO] total locks = 1, caller = 2468, caller locks = 1
[SERVICE: 0x9A4,15:23:47 INFO] total locks = 0, caller = 2468, caller locks = 0
[SERVICE: 0x9A4,15:23:47 INFO] [1] Finished Unmounting with status 1
[SERVICE: 0x9A4,15:23:47 INFO] NOT Mounted
[SERVICE: 0x9A4,15:23:47 INFO] [1] **** NOT in intermediate state, device is Mounted
[SERVICE: 0x9A4,15:23:47 INFO] [MACHINE 1 TRANSITION] - {Mounted} ==> {iTunesPseudoUnmounting}
[SERVICE: 0x9A4,15:23:47 INFO] [MACHINE 1 ACTIONS] - {iTunesPseudoUnmounting}
[SERVICE: 0x99C,15:23:47 INFO] [1] Progress state is 3, Waiting to disconnect = 0
[SERVICE: 0x9B4,15:23:47 INFO] [VolumeRemoved] existing mask 0x20, arrive mask 0x20
[SERVICE: 0x9B4,15:23:47 INFO] [1] value = 1
[SERVICE: 0x9B4,15:23:47 INFO] [1] input #23 from src #0
[SERVICE: 0x9A4,15:23:47 INFO] [1] input #23
[SERVICE: 0x9B4,15:23:47 INFO] [InterfaceRemoved]
[SERVICE: 0x9B4,15:23:47 INFO] [1] value = 0
[SERVICE: 0x9B4,15:23:47 INFO] removed device number 1 from m_objDeviceNumberMap
[SERVICE: 0x9B4,15:23:47 INFO] [1] input #24 from src #0
[SERVICE: 0x994,15:23:47 INFO] [1] Progress state is 3, Waiting to disconnect = 0
[SERVICE: 0xCC4,15:23:47 INFO] NOT Mounted
[SERVICE: 0xCC4,15:23:47 INFO] [1] Unmount in progress, wait till finish...
[SERVICE: 0x9AC,15:23:47 INFO] [MACHINE 1 INPUT #21] - (HDW) CheckDevNode
[SERVICE: 0x9AC,15:23:47 INFO] Connection Detection Status - 0x180600A, device '\\?\usbstor#disk&ven_apple&prod_ipod&rev_1.62#000a2700195e186d&0#{53f56307-b6bf-11d0-94f2-00a0c91efb8b}'
[SERVICE: 0x9A8,15:23:47 INFO] [MACHINE 1 INPUT #22] - (HDW) CheckDevNode
[SERVICE: 0x9A8,15:23:47 INFO] Connection Detection Status - 0x180600A, device '\\?\usbstor#disk&ven_apple&prod_ipod&rev_1.62#000a2700195e186d&0#{53f56307-b6bf-11d0-94f2-00a0c91efb8b}'
[SERVICE: 0x9A4,15:23:47 INFO] [MACHINE 1 INPUT #23] - (HDW) Volume Unmount
[SERVICE: 0x9A4,15:23:47 INFO] [1] progress is now 3
[SERVICE: 0x9A4,15:23:47 INFO] [1] Setting progress to 3
[SERVICE: 0x9A4,15:23:47 INFO] *** CItunesDevice::HandleHardwareInput()
[SERVICE: 0x9A4,15:23:47 INFO] [1] input #24
[SERVICE: 0x9A4,15:23:47 INFO] [MACHINE 1 INPUT #24] - (HDW) Interface Removal
[SERVICE: 0x9A4,15:23:47 INFO] [MACHINE 1 TRANSITION] - {iTunesPseudoUnmounting} ==> {iTunesPseudoUnmounted}
[SERVICE: 0x9A4,15:23:47 INFO] [MACHINE 1 ACTIONS] - {iTunesPseudoUnmounted}
[SERVICE: 0x9A4,15:23:47 INFO] [1] ***** iTunesPseudoUnmounted - Sending event out, device session 0
[SERVICE: 0x9A4,15:23:47 INFO] [1] progress is now 0
[SERVICE: 0xCC4,15:23:47 INFO] NOT Mounted
[SERVICE: 0xCC4,15:23:47 INFO] [1] progress state is 0, Waiting to mount = 0
[SERVICE: 0xCC4,15:23:47 INFO] [1] progress state is 0, Waiting to mount = 0
[SERVICE: 0xCC4,15:23:48 INFO] Connection Detection Status - 0x180600A, device '\\?\usbstor#disk&ven_apple&prod_ipod&rev_1.62#000a2700195e186d&0#{53f56307-b6bf-11d0-94f2-00a0c91efb8b}'
[SERVICE: 0xCC4,15:23:48 INFO] [1] input #25 from src #286156
[SERVICE: 0x9AC,15:23:48 INFO] [1] input #25
[SERVICE: 0x9AC,15:23:48 INFO] [MACHINE 1 INPUT #25] - (APP) Mountlock Mount
[SERVICE: 0x9AC,15:23:48 INFO] [1] Begin Mounting...
[SERVICE: 0x9AC,15:23:48 INFO] [1] progress is now 2
[SERVICE: 0x9AC,15:23:48 INFO] NOT USB
[SERVICE: 0x9B4,15:23:48 INFO] [DevNodesChanged]
[SERVICE: 0x9B4,15:23:48 INFO] [1] input #26 from src #0
[SERVICE: 0x9A8,15:23:48 INFO] [1] input #26
[SERVICE: 0x9B4,15:23:48 INFO] [InterfaceArrival] \\?\usbstor#disk&ven_apple&prod_ipod&rev_1.62#000a2700195e186d&0#{53f56307-b6bf-11d0-94f2-00a0c91efb8b}
[SERVICE: 0x9B4,15:23:48 INFO] type 0x7 drive 0x1 partition 0x0
[SERVICE: 0x9B4,15:23:48 INFO] [1] set waiting to mount = 1
[SERVICE: 0x9B4,15:23:48 INFO] [1] added device interface "\\?\usbstor#disk&ven_apple&prod_ipod&rev_1.62#000a2700195e186d&0#{53f56307-b6bf-11d0-94f2-00a0c91efb8b}" to m_objDeviceNameMap
[SERVICE: 0x9B4,15:23:48 INFO] [1] added state machine 1 to m_objDeviceIdMap
[SERVICE: 0x9B4,15:23:48 INFO] [1] added device number 1 to m_objDeviceNumberMap
[SERVICE: 0x9B4,15:23:48 INFO] [1] input #27 from src #0
[SERVICE: 0x9A4,15:23:48 INFO] [1] input #27
[SERVICE: 0x9B4,15:23:48 INFO] [DevNodesChanged]
[SERVICE: 0x9B4,15:23:48 INFO] [1] input #28 from src #0
[SERVICE: 0x9B4,15:23:48 INFO] [DevNodesChanged]
[SERVICE: 0x9B4,15:23:48 INFO] [1] input #29 from src #0
[SERVICE: 0x9B4,15:23:48 INFO] [VolumeArrive] mask = 0x20
[SERVICE: 0x9B4,15:23:48 INFO] looking up device # for \\.\F:
[SERVICE: 0x9B4,15:23:48 INFO] type 0x7 drive 0x1 partition 0x1
[SERVICE: 0x9B4,15:23:48 INFO] iTunes device #1 found with drive letter F, mask 0x20
[SERVICE: 0x9B4,15:23:48 INFO] [1] set waiting to mount = 0
[SERVICE: 0x9B4,15:23:48 INFO] [1] input #30 from src #0
[SERVICE: 0x9B4,15:23:48 INFO] [DevNodesChanged]
[SERVICE: 0x9B4,15:23:48 INFO] [1] input #31 from src #0
[SERVICE: 0x9AC,15:23:48 INFO] SUCCESS
[SERVICE: 0x9AC,15:23:48 INFO] [1] progress is now 2
[SERVICE: 0x9AC,15:23:48 INFO] [MACHINE 1 TRANSITION] - {iTunesPseudoUnmounted} ==> {iTunesPseudoMounting}
[SERVICE: 0xCC4,15:23:48 INFO] [1] progress state is 2, Waiting to mount = 0
[SERVICE: 0xCC4,15:23:48 INFO] [1] Mount in progress, wait till finish...
[SERVICE: 0x9AC,15:23:48 INFO] [MACHINE 1 ACTIONS] - {iTunesPseudoMounting}
[SERVICE: 0x9AC,15:23:48 INFO] [1] input #28
[SERVICE: 0x9A8,15:23:48 INFO] [MACHINE 1 INPUT #26] - (HDW) CheckDevNode
[SERVICE: 0x9A8,15:23:48 INFO] Connection Detection Status - 0x180600A, device '\\?\usbstor#disk&ven_apple&prod_ipod&rev_1.62#000a2700195e186d&0#{53f56307-b6bf-11d0-94f2-00a0c91efb8b}'
[SERVICE: 0x9A4,15:23:48 INFO] [MACHINE 1 INPUT #27] - (HDW) Interface Arrival
[SERVICE: 0x9A4,15:23:48 INFO] [1] progress state is 2, Waiting to mount = 0
[SERVICE: 0x9A4,15:23:48 INFO] [1] progress is now 2
[SERVICE: 0x9A4,15:23:48 INFO] *** CItunesDevice::HandleHardwareInput()
[SERVICE: 0x9A4,15:23:48 INFO] [1] progress is now 2
[SERVICE: 0x9A4,15:23:48 INFO] [1] input #29
[SERVICE: 0x9AC,15:23:48 INFO] [MACHINE 1 INPUT #28] - (HDW) CheckDevNode
[SERVICE: 0x9AC,15:23:48 INFO] Connection Detection Status - 0x180600A, device '\\?\usbstor#disk&ven_apple&prod_ipod&rev_1.62#000a2700195e186d&0#{53f56307-b6bf-11d0-94f2-00a0c91efb8b}'
[SERVICE: 0x9AC,15:23:48 INFO] [1] input #30
[SERVICE: 0x9A8,15:23:48 INFO] [1] input #31
[SERVICE: 0x9A4,15:23:48 INFO] [MACHINE 1 INPUT #29] - (HDW) CheckDevNode
[SERVICE: 0x9A4,15:23:49 INFO] Connection Detection Status - 0x180600A, device '\\?\usbstor#disk&ven_apple&prod_ipod&rev_1.62#000a2700195e186d&0#{53f56307-b6bf-11d0-94f2-00a0c91efb8b}'
[SERVICE: 0x9AC,15:23:49 INFO] [MACHINE 1 INPUT #30] - (HDW) Volume Mount
[SERVICE: 0x9AC,15:23:49 INFO] [MACHINE 1 TRANSITION] - {iTunesPseudoMounting} ==> {Mounted}
[SERVICE: 0x9AC,15:23:49 INFO] Connection Detection Status - 0x180600A, device '\\?\usbstor#disk&ven_apple&prod_ipod&rev_1.62#000a2700195e186d&0#{53f56307-b6bf-11d0-94f2-00a0c91efb8b}'
[SERVICE: 0x9AC,15:23:49 INFO] [1] ***** iTunesPseudoMounting state finalizing internal mount
[SERVICE: 0x9AC,15:23:49 INFO] total locks = 1, caller = 2476, caller locks = 1
[SERVICE: 0x9AC,15:23:49 INFO] SUCCESS
[SERVICE: 0x9AC,15:23:49 INFO] Volume lock success!
[SERVICE: 0x9A8,15:23:49 INFO] [MACHINE 1 INPUT #31] - (HDW) CheckDevNode
[SERVICE: 0x9A8,15:23:49 INFO] Connection Detection Status - 0x180600A, device '\\?\usbstor#disk&ven_apple&prod_ipod&rev_1.62#000a2700195e186d&0#{53f56307-b6bf-11d0-94f2-00a0c91efb8b}'
[SERVICE: 0x9AC,15:23:50 INFO] total locks = 0, caller = 2476, caller locks = 0
[SERVICE: 0x9AC,15:23:50 INFO] [1] Finished Mounting with status 1
[SERVICE: 0x9AC,15:23:50 INFO] [MACHINE 1 ACTIONS] - {Mounted}
[SERVICE: 0x9AC,15:23:50 INFO] [1] progress state is 2, Waiting to mount = 0
[SERVICE: 0x9AC,15:23:50 INFO] [1] progress state is 2, Waiting to mount = 0
[SERVICE: 0x9AC,15:23:50 ERROR] Did not find first letter of stage
[SERVICE: 0x9AC,15:23:50 INFO] got HotPlugState 0
[SERVICE: 0x9AC,15:23:50 INFO] [1] OS says filesystem is FAT32
[SERVICE: 0x9AC,15:23:50 INFO] [1] ===== iPod Nano =====
[SERVICE: 0x9AC,15:23:50 INFO] [1] progress state is 2, Waiting to mount = 0
[SERVICE: 0x9AC,15:23:50 INFO] 15:23:50, year 2007, day of yr. 123, GMT offset 8 isDST 1
[SERVICE: 0x9AC,15:23:50 INFO] [1] progress is now 0
[SERVICE: 0xCC4,15:23:50 INFO] [1] progress state is 0, Waiting to mount = 0
[SERVICE: 0x99C,15:23:51 INFO] <0x4> GetFormatType() returned unknown format 0
[SERVICE: 0x994,15:23:51 INFO] [1] Progress state is 0, Waiting to disconnect = 0
[SERVICE: 0x994,15:23:51 INFO] Mounted
[SERVICE: 0x994,15:23:51 INFO] Device 1 is FAT32 and appears mounted, checking intermediate state...
[SERVICE: 0x994,15:23:51 INFO] Device 1 not in intermediate state. It appears to be truly mounted.
[SERVICE: 0xCC4,15:23:51 INFO] <0x4> COM request for device 1 drive letter - F
[SERVICE: 0x994,15:23:51 INFO] [1] input #32 from src #4
[SERVICE: 0x9AC,15:23:52 INFO] [1] ***** MOUNTED - Sending event out, device session 0.
[SERVICE: 0x9AC,15:23:52 INFO] [1] input #32
[SERVICE: 0x9AC,15:23:52 INFO] [MACHINE 1 INPUT #32] - (APP) Unmount - lock count not 0, ignoring
[SERVICE: 0x994,15:23:52 ERROR] <0x4> Request failed!
[SERVICE: 0xCC4,15:23:55 INFO] <0x4> GetFormatType() returned unknown format 0
[SERVICE: 0x99C,15:23:58 INFO] Mounted
[SERVICE: 0x99C,15:23:58 INFO] Device 0 is FAT32 and appears mounted, checking intermediate state...
[SERVICE: 0x99C,15:23:58 INFO] Device 0 not in intermediate state. It appears to be truly mounted.
[SERVICE: 0x99C,15:23:58 INFO] [1] input #33 from src #286156
[SERVICE: 0x9A8,15:23:58 INFO] [1] input #33
[SERVICE: 0x9A8,15:23:59 INFO] [MACHINE 1 INPUT #33] - (APP) Mountlock Unmount
[SERVICE: 0x9A8,15:23:59 INFO] [1] Begin Unmounting...
[SERVICE: 0x9A8,15:23:59 INFO] [1] progress is now 3
[SERVICE: 0x9A8,15:23:59 INFO] total locks = 1, caller = 2472, caller locks = 1
[SERVICE: 0x9A8,15:23:59 INFO] Ejecting media
[SERVICE: 0x9A8,15:23:59 INFO] SUCCESS
[SERVICE: 0x9A8,15:23:59 INFO] Volume lock success!
[SERVICE: 0x9A8,15:24:02 INFO] total locks = 2, caller = 2472, caller locks = 2
[SERVICE: 0x9A8,15:24:03 INFO] CM_Query_And_Remove_SubTreeW stop
[SERVICE: 0x9B4,15:24:03 INFO] [DevNodesChanged]
[SERVICE: 0x9B4,15:24:03 INFO] [1] input #34 from src #0
[SERVICE: 0x9A4,15:24:03 INFO] [1] input #34
[SERVICE: 0x9B4,15:24:03 INFO] [DevNodesChanged]
[SERVICE: 0x9B4,15:24:03 INFO] [1] input #35 from src #0
[SERVICE: 0x9AC,15:24:03 INFO] [1] input #35
[SERVICE: 0x9A8,15:24:03 INFO] CM_Query_And_Remove_SubTreeW took 203 ms
[SERVICE: 0x9A8,15:24:03 INFO] total locks = 1, caller = 2472, caller locks = 1
[SERVICE: 0x9A8,15:24:03 INFO] total locks = 0, caller = 2472, caller locks = 0
[SERVICE: 0x9A8,15:24:03 INFO] [1] Finished Unmounting with status 1
[SERVICE: 0x9A8,15:24:03 INFO] NOT Mounted
[SERVICE: 0x9A8,15:24:03 INFO] [1] **** NOT in intermediate state, device is Mounted
[SERVICE: 0x9A8,15:24:03 INFO] [MACHINE 1 TRANSITION] - {Mounted} ==> {iTunesPseudoUnmounting}
[SERVICE: 0x9A8,15:24:03 INFO] [MACHINE 1 ACTIONS] - {iTunesPseudoUnmounting}
[SERVICE: 0x994,15:24:03 INFO] [1] Progress state is 3, Waiting to disconnect = 0
[SERVICE: 0x9B4,15:24:03 INFO] [VolumeRemoved] existing mask 0x20, arrive mask 0x20
[SERVICE: 0x9B4,15:24:03 INFO] [1] value = 1
[SERVICE: 0x9B4,15:24:03 INFO] [1] input #36 from src #0
[SERVICE: 0x9A8,15:24:03 INFO] [1] input #36
[SERVICE: 0x9B4,15:24:03 INFO] [InterfaceRemoved]
[SERVICE: 0x9B4,15:24:03 INFO] [1] value = 0
[SERVICE: 0x9B4,15:24:03 INFO] removed device number 1 from m_objDeviceNumberMap
[SERVICE: 0x9B4,15:24:03 INFO] [1] input #37 from src #0
[SERVICE: 0x9A4,15:24:03 INFO] [MACHINE 1 INPUT #34] - (HDW) CheckDevNode
[SERVICE: 0x9A4,15:24:03 INFO] Connection Detection Status - 0x180600A, device '\\?\usbstor#disk&ven_apple&prod_ipod&rev_1.62#000a2700195e186d&0#{53f56307-b6bf-11d0-94f2-00a0c91efb8b}'
[SERVICE: 0x9AC,15:24:03 INFO] [MACHINE 1 INPUT #35] - (HDW) CheckDevNode
[SERVICE: 0x9AC,15:24:03 INFO] Connection Detection Status - 0x180600A, device '\\?\usbstor#disk&ven_apple&prod_ipod&rev_1.62#000a2700195e186d&0#{53f56307-b6bf-11d0-94f2-00a0c91efb8b}'
[SERVICE: 0x9A8,15:24:03 INFO] [MACHINE 1 INPUT #36] - (HDW) Volume Unmount
[SERVICE: 0x9A8,15:24:03 INFO] [1] progress is now 3
[SERVICE: 0x9A8,15:24:03 INFO] [1] Setting progress to 3
[SERVICE: 0x9A8,15:24:03 INFO] *** CItunesDevice::HandleHardwareInput()
[SERVICE: 0x9A8,15:24:03 INFO] [1] input #37
[SERVICE: 0x9A8,15:24:03 INFO] [MACHINE 1 INPUT #37] - (HDW) Interface Removal
[SERVICE: 0x9A8,15:24:03 INFO] [MACHINE 1 TRANSITION] - {iTunesPseudoUnmounting} ==> {iTunesPseudoUnmounted}
[SERVICE: 0x9A8,15:24:03 INFO] [MACHINE 1 ACTIONS] - {iTunesPseudoUnmounted}
[SERVICE: 0x9A8,15:24:03 INFO] [1] ***** iTunesPseudoUnmounted - Sending event out, device session 0
[SERVICE: 0x9A8,15:24:03 INFO] [1] progress is now 0
[SERVICE: 0x99C,15:26:38 INFO] <0x4> Got Serial #
[SERVICE: 0xCC4,15:26:38 INFO] <0x4> GetFormatType() returned unknown format 0
[SERVICE: 0xCC4,15:26:38 INFO] [1] Progress state is 0, Waiting to disconnect = 0
[SERVICE: 0xCC4,15:26:38 INFO] NOT Mounted
[SERVICE: 0xF00,15:26:38 INFO] NOT Mounted
[SERVICE: 0xF00,15:26:38 INFO] NOT Mounted
[SERVICE: 0xF00,15:26:38 INFO] [1] progress state is 0, Waiting to mount = 0
[SERVICE: 0xF00,15:26:38 INFO] [1] progress state is 0, Waiting to mount = 0
[SERVICE: 0xF00,15:26:38 INFO] Connection Detection Status - 0x180600A, device '\\?\usbstor#disk&ven_apple&prod_ipod&rev_1.62#000a2700195e186d&0#{53f56307-b6bf-11d0-94f2-00a0c91efb8b}'
[SERVICE: 0xF00,15:26:38 INFO] [1] input #38 from src #301860
[SERVICE: 0x9A4,15:26:38 INFO] [1] input #38
[SERVICE: 0x9A4,15:26:39 INFO] [MACHINE 1 INPUT #38] - (APP) Mountlock Mount
[SERVICE: 0x9A4,15:26:39 INFO] [1] Begin Mounting...
[SERVICE: 0x9A4,15:26:39 INFO] [1] progress is now 2
[SERVICE: 0x9A4,15:26:39 INFO] NOT USB
[SERVICE: 0x9B4,15:26:39 INFO] [DevNodesChanged]
[SERVICE: 0x9B4,15:26:39 INFO] [1] input #39 from src #0
[SERVICE: 0x9A8,15:26:39 INFO] [1] input #39
[SERVICE: 0x9B4,15:26:39 INFO] [InterfaceArrival] \\?\usbstor#disk&ven_apple&prod_ipod&rev_1.62#000a2700195e186d&0#{53f56307-b6bf-11d0-94f2-00a0c91efb8b}
[SERVICE: 0x9B4,15:26:39 INFO] type 0x7 drive 0x1 partition 0x0
[SERVICE: 0x9B4,15:26:39 INFO] [1] set waiting to mount = 1
[SERVICE: 0x9B4,15:26:39 INFO] [1] added device interface "\\?\usbstor#disk&ven_apple&prod_ipod&rev_1.62#000a2700195e186d&0#{53f56307-b6bf-11d0-94f2-00a0c91efb8b}" to m_objDeviceNameMap
[SERVICE: 0x9B4,15:26:39 INFO] [1] added state machine 1 to m_objDeviceIdMap
[SERVICE: 0x9B4,15:26:39 INFO] [1] added device number 1 to m_objDeviceNumberMap
[SERVICE: 0x9B4,15:26:39 INFO] [1] input #40 from src #0
[SERVICE: 0x9AC,15:26:39 INFO] [1] input #40
[SERVICE: 0x9B4,15:26:39 INFO] [DevNodesChanged]
[SERVICE: 0x9B4,15:26:39 INFO] [1] input #41 from src #0
[SERVICE: 0x9B4,15:26:39 INFO] [DevNodesChanged]
[SERVICE: 0x9B4,15:26:39 INFO] [1] input #42 from src #0
[SERVICE: 0x9A4,15:26:39 INFO] SUCCESS
[SERVICE: 0x9A4,15:26:39 INFO] [1] progress is now 2
[SERVICE: 0x9A4,15:26:39 INFO] [MACHINE 1 TRANSITION] - {iTunesPseudoUnmounted} ==> {iTunesPseudoMounting}
[SERVICE: 0x9A4,15:26:39 INFO] [MACHINE 1 ACTIONS] - {iTunesPseudoMounting}
[SERVICE: 0x9A4,15:26:39 INFO] [1] input #41
[SERVICE: 0xF00,15:26:39 INFO] [1] progress state is 2, Waiting to mount = 1
[SERVICE: 0xF00,15:26:39 INFO] [1] Mount in progress, wait till finish...
[SERVICE: 0x9A8,15:26:39 INFO] [MACHINE 1 INPUT #39] - (HDW) CheckDevNode
[SERVICE: 0x9A8,15:26:39 INFO] Connection Detection Status - 0x180600A, device '\\?\usbstor#disk&ven_apple&prod_ipod&rev_1.62#000a2700195e186d&0#{53f56307-b6bf-11d0-94f2-00a0c91efb8b}'
[SERVICE: 0x9AC,15:26:39 INFO] [MACHINE 1 INPUT #40] - (HDW) Interface Arrival
[SERVICE: 0x9AC,15:26:39 INFO] [1] progress state is 2, Waiting to mount = 1
[SERVICE: 0x9AC,15:26:39 INFO] [1] progress is now 2
[SERVICE: 0x9AC,15:26:39 INFO] *** CItunesDevice::HandleHardwareInput()
[SERVICE: 0x9AC,15:26:39 INFO] [1] progress is now 2
[SERVICE: 0x9AC,15:26:39 INFO] [1] input #42
[SERVICE: 0x9A4,15:26:39 INFO] [MACHINE 1 INPUT #41] - (HDW) CheckDevNode
[SERVICE: 0x9B4,15:26:39 INFO] [VolumeArrive] mask = 0x20
[SERVICE: 0x9B4,15:26:39 INFO] looking up device # for \\.\F:
[SERVICE: 0x9B4,15:26:39 INFO] type 0x7 drive 0x1 partition 0x1
[SERVICE: 0x9B4,15:26:39 INFO] iTunes device #1 found with drive letter F, mask 0x20
[SERVICE: 0x9B4,15:26:39 INFO] [1] set waiting to mount = 0
[SERVICE: 0x9B4,15:26:39 INFO] [1] input #43 from src #0
[SERVICE: 0x9B4,15:26:39 INFO] [DevNodesChanged]
[SERVICE: 0x9B4,15:26:39 INFO] [1] input #44 from src #0
[SERVICE: 0x9A4,15:26:39 INFO] Connection Detection Status - 0x180600A, device '\\?\usbstor#disk&ven_apple&prod_ipod&rev_1.62#000a2700195e186d&0#{53f56307-b6bf-11d0-94f2-00a0c91efb8b}'
[SERVICE: 0x9A4,15:26:39 INFO] [1] input #43
[SERVICE: 0x9AC,15:26:39 INFO] [MACHINE 1 INPUT #42] - (HDW) CheckDevNode
[SERVICE: 0x9AC,15:26:39 INFO] Connection Detection Status - 0x180600A, device '\\?\usbstor#disk&ven_apple&prod_ipod&rev_1.62#000a2700195e186d&0#{53f56307-b6bf-11d0-94f2-00a0c91efb8b}'
[SERVICE: 0x9AC,15:26:39 INFO] [1] input #44
[SERVICE: 0x9A4,15:26:39 INFO] [MACHINE 1 INPUT #43] - (HDW) Volume Mount
[SERVICE: 0x9A4,15:26:39 INFO] [MACHINE 1 TRANSITION] - {iTunesPseudoMounting} ==> {Mounted}
[SERVICE: 0x9A4,15:26:40 INFO] Connection Detection Status - 0x180600A, device '\\?\usbstor#disk&ven_apple&prod_ipod&rev_1.62#000a2700195e186d&0#{53f56307-b6bf-11d0-94f2-00a0c91efb8b}'
[SERVICE: 0x9A4,15:26:40 INFO] [1] ***** iTunesPseudoMounting state finalizing internal mount
[SERVICE: 0x9A4,15:26:40 INFO] total locks = 1, caller = 2468, caller locks = 1
[SERVICE: 0x9A4,15:26:40 INFO] SUCCESS
[SERVICE: 0x9A4,15:26:40 INFO] Volume lock success!
[SERVICE: 0x9AC,15:26:40 INFO] [MACHINE 1 INPUT #44] - (HDW) CheckDevNode
[SERVICE: 0x9AC,15:26:40 INFO] Connection Detection Status - 0x180600A, device '\\?\usbstor#disk&ven_apple&prod_ipod&rev_1.62#000a2700195e186d&0#{53f56307-b6bf-11d0-94f2-00a0c91efb8b}'
[SERVICE: 0x9A4,15:26:41 INFO] total locks = 0, caller = 2468, caller locks = 0
[SERVICE: 0x9A4,15:26:41 INFO] [1] Finished Mounting with status 1
[SERVICE: 0x9A4,15:26:41 INFO] [MACHINE 1 ACTIONS] - {Mounted}
[SERVICE: 0x9A4,15:26:41 INFO] [1] progress state is 2, Waiting to mount = 0
[SERVICE: 0x9A4,15:26:41 INFO] [1] progress state is 2, Waiting to mount = 0
[SERVICE: 0x9A4,15:26:41 ERROR] Did not find first letter of stage
[SERVICE: 0x9A4,15:26:41 INFO] got HotPlugState 0
[SERVICE: 0x9A4,15:26:41 INFO] [1] OS says filesystem is FAT32
[SERVICE: 0x9A4,15:26:41 INFO] [1] ===== iPod Nano =====
[SERVICE: 0x9A4,15:26:41 INFO] [1] progress state is 2, Waiting to mount = 0
[SERVICE: 0x9A4,15:26:41 INFO] 15:26:41, year 2007, day of yr. 123, GMT offset 8 isDST 1
[SERVICE: 0x9A4,15:26:41 INFO] [1] progress is now 0
[SERVICE: 0xF00,15:26:41 INFO] [1] progress state is 0, Waiting to mount = 0
[SERVICE: 0x9A4,15:26:43 INFO] [1] ***** MOUNTED - Sending event out, device session 0.
[SERVICE: 0x99C,15:26:43 INFO] <0x4> GetFormatType() returned unknown format 0
[SERVICE: 0x994,15:26:43 INFO] [1] Progress state is 0, Waiting to disconnect = 0
[SERVICE: 0x994,15:26:43 INFO] Mounted
[SERVICE: 0x994,15:26:43 INFO] Device 1 is FAT32 and appears mounted, checking intermediate state...
[SERVICE: 0x994,15:26:43 INFO] Device 1 not in intermediate state. It appears to be truly mounted.
[SERVICE: 0xCC4,15:26:43 INFO] <0x4> COM request for device 1 drive letter - F
[SERVICE: 0x994,15:26:43 INFO] [1] Progress state is 0, Waiting to disconnect = 0
[SERVICE: 0x994,15:26:43 INFO] Mounted
[SERVICE: 0x994,15:26:43 INFO] Device 1 is FAT32 and appears mounted, checking intermediate state...
[SERVICE: 0x994,15:26:43 INFO] Device 1 not in intermediate state. It appears to be truly mounted.
[SERVICE: 0xCC4,15:26:43 INFO] Mounted
[SERVICE: 0xCC4,15:26:43 INFO] [1] already mounted!
[SERVICE: 0xCC4,15:26:43 INFO] [1] progress state is 0, Waiting to mount = 0
[SERVICE: 0x99C,15:26:45 INFO] Mounted
[SERVICE: 0x99C,15:26:45 INFO] Device 0 is FAT32 and appears mounted, checking intermediate state...
[SERVICE: 0x99C,15:26:45 INFO] Device 0 not in intermediate state. It appears to be truly mounted.
[SERVICE: 0x99C,15:26:45 INFO] [1] input #45 from src #301860
[SERVICE: 0x9A8,15:26:45 INFO] [1] input #45
[SERVICE: 0x9A8,15:26:45 INFO] [MACHINE 1 INPUT #45] - (APP) Mountlock Unmount
[SERVICE: 0x9A8,15:26:45 INFO] [1] Begin Unmounting...
[SERVICE: 0x9A8,15:26:45 INFO] [1] progress is now 3
[SERVICE: 0x9A8,15:26:45 INFO] total locks = 1, caller = 2472, caller locks = 1
[SERVICE: 0x9A8,15:26:45 INFO] Ejecting media
[SERVICE: 0x9A8,15:26:45 INFO] SUCCESS
[SERVICE: 0x9A8,15:26:45 INFO] Volume lock success!
[SERVICE: 0x9A8,15:26:47 INFO] total locks = 2, caller = 2472, caller locks = 2
[SERVICE: 0x9A8,15:26:49 INFO] CM_Query_And_Remove_SubTreeW stop
[SERVICE: 0x9B4,15:26:49 INFO] [DevNodesChanged]
[SERVICE: 0x9B4,15:26:49 INFO] [1] input #46 from src #0
[SERVICE: 0x9AC,15:26:49 INFO] [1] input #46
[SERVICE: 0x9B4,15:26:49 INFO] [DevNodesChanged]
[SERVICE: 0x9B4,15:26:49 INFO] [1] input #47 from src #0
[SERVICE: 0x9A4,15:26:49 INFO] [1] input #47
[SERVICE: 0x9A8,15:26:49 INFO] CM_Query_And_Remove_SubTreeW took 656 ms
[SERVICE: 0x9A8,15:26:49 INFO] total locks = 1, caller = 2472, caller locks = 1
[SERVICE: 0x9A8,15:26:49 INFO] total locks = 0, caller = 2472, caller locks = 0
[SERVICE: 0x9A8,15:26:49 INFO] [1] Finished Unmounting with status 1
[SERVICE: 0x9A8,15:26:49 INFO] NOT Mounted
[SERVICE: 0x9A8,15:26:49 INFO] [1] **** NOT in intermediate state, device is Mounted
[SERVICE: 0x9A8,15:26:49 INFO] [MACHINE 1 TRANSITION] - {Mounted} ==> {iTunesPseudoUnmounting}
[SERVICE: 0x9A8,15:26:49 INFO] [MACHINE 1 ACTIONS] - {iTunesPseudoUnmounting}
[SERVICE: 0x994,15:26:49 INFO] [1] Progress state is 3, Waiting to disconnect = 0
[SERVICE: 0x9B4,15:26:49 INFO] [VolumeRemoved] existing mask 0x20, arrive mask 0x20
[SERVICE: 0x9B4,15:26:49 INFO] [1] value = 1
[SERVICE: 0x9B4,15:26:49 INFO] [1] input #48 from src #0
[SERVICE: 0x9A8,15:26:49 INFO] [1] input #48
[SERVICE: 0x9B4,15:26:49 INFO] [InterfaceRemoved]
[SERVICE: 0x9B4,15:26:49 INFO] [1] value = 0
[SERVICE: 0x9B4,15:26:49 INFO] removed device number 1 from m_objDeviceNumberMap
[SERVICE: 0x9B4,15:26:49 INFO] [1] input #49 from src #0
[SERVICE: 0x9AC,15:26:49 INFO] [MACHINE 1 INPUT #46] - (HDW) CheckDevNode
[SERVICE: 0x9AC,15:26:49 INFO] Connection Detection Status - 0x180600A, device '\\?\usbstor#disk&ven_apple&prod_ipod&rev_1.62#000a2700195e186d&0#{53f56307-b6bf-11d0-94f2-00a0c91efb8b}'
[SERVICE: 0x9A4,15:26:49 INFO] [MACHINE 1 INPUT #47] - (HDW) CheckDevNode
[SERVICE: 0x9A4,15:26:50 INFO] Connection Detection Status - 0x180600A, device '\\?\usbstor#disk&ven_apple&prod_ipod&rev_1.62#000a2700195e186d&0#{53f56307-b6bf-11d0-94f2-00a0c91efb8b}'
[SERVICE: 0x9A4,15:26:50 INFO] [1] input #49
[SERVICE: 0x9A8,15:26:50 INFO] [MACHINE 1 INPUT #48] - (HDW) Volume Unmount
[SERVICE: 0x9A8,15:26:50 INFO] [1] progress is now 3
[SERVICE: 0x9A8,15:26:50 INFO] [1] Setting progress to 3
[SERVICE: 0x9A8,15:26:50 INFO] *** CItunesDevice::HandleHardwareInput()
[SERVICE: 0x9A4,15:26:50 INFO] [MACHINE 1 INPUT #49] - (HDW) Interface Removal
[SERVICE: 0x9A4,15:26:50 INFO] [MACHINE 1 TRANSITION] - {iTunesPseudoUnmounting} ==> {iTunesPseudoUnmounted}
[SERVICE: 0x9A4,15:26:50 INFO] [MACHINE 1 ACTIONS] - {iTunesPseudoUnmounted}
[SERVICE: 0x9A4,15:26:50 INFO] [1] ***** iTunesPseudoUnmounted - Sending event out, device session 0
[SERVICE: 0x9A4,15:26:50 INFO] [1] progress is now 0
[SERVICE: 0xCC4,15:26:54 INFO] [1] Progress state is 0, Waiting to disconnect = 0
[SERVICE: 0xCC4,15:26:54 INFO] NOT Mounted
[SERVICE: 0x99C,15:26:54 INFO] NOT Mounted
[SERVICE: 0x99C,15:26:54 INFO] NOT Mounted
[SERVICE: 0x99C,15:26:54 INFO] [1] progress state is 0, Waiting to mount = 0
[SERVICE: 0x99C,15:26:54 INFO] [1] progress state is 0, Waiting to mount = 0
[SERVICE: 0x99C,15:26:54 INFO] Connection Detection Status - 0x180600A, device '\\?\usbstor#disk&ven_apple&prod_ipod&rev_1.62#000a2700195e186d&0#{53f56307-b6bf-11d0-94f2-00a0c91efb8b}'
[SERVICE: 0x99C,15:26:54 INFO] [1] input #50 from src #301860
[SERVICE: 0x9A8,15:26:54 INFO] [1] input #50
[SERVICE: 0x9A8,15:26:54 INFO] [MACHINE 1 INPUT #50] - (APP) Mountlock Mount
[SERVICE: 0x9A8,15:26:54 INFO] [1] Begin Mounting...
[SERVICE: 0x9A8,15:26:54 INFO] [1] progress is now 2
[SERVICE: 0x9A8,15:26:54 INFO] NOT USB
[SERVICE: 0x9B4,15:26:55 INFO] [DevNodesChanged]
[SERVICE: 0x9B4,15:26:55 INFO] [1] input #51 from src #0
[SERVICE: 0x9AC,15:26:55 INFO] [1] input #51
[SERVICE: 0x9B4,15:26:55 INFO] [InterfaceArrival] \\?\usbstor#disk&ven_apple&prod_ipod&rev_1.62#000a2700195e186d&0#{53f56307-b6bf-11d0-94f2-00a0c91efb8b}
[SERVICE: 0x9B4,15:26:55 INFO] type 0x7 drive 0x1 partition 0x0
[SERVICE: 0x9B4,15:26:55 INFO] [1] set waiting to mount = 1
[SERVICE: 0x9B4,15:26:55 INFO] [1] added device interface "\\?\usbstor#disk&ven_apple&prod_ipod&rev_1.62#000a2700195e186d&0#{53f56307-b6bf-11d0-94f2-00a0c91efb8b}" to m_objDeviceNameMap
[SERVICE: 0x9B4,15:26:55 INFO] [1] added state machine 1 to m_objDeviceIdMap
[SERVICE: 0x9B4,15:26:55 INFO] [1] added device number 1 to m_objDeviceNumberMap
[SERVICE: 0x9B4,15:26:55 INFO] [1] input #52 from src #0
[SERVICE: 0x9A4,15:26:55 INFO] [1] input #52
[SERVICE: 0x9B4,15:26:55 INFO] [DevNodesChanged]
[SERVICE: 0x9B4,15:26:55 INFO] [1] input #53 from src #0
[SERVICE: 0x9B4,15:26:55 INFO] [DevNodesChanged]
[SERVICE: 0x9B4,15:26:55 INFO] [1] input #54 from src #0
[SERVICE: 0x9B4,15:26:55 INFO] [VolumeArrive] mask = 0x20
[SERVICE: 0x9B4,15:26:55 INFO] looking up device # for \\.\F:
[SERVICE: 0x9B4,15:26:55 INFO] type 0x7 drive 0x1 partition 0x1
[SERVICE: 0x9B4,15:26:55 INFO] iTunes device #1 found with drive letter F, mask 0x20
[SERVICE: 0x9B4,15:26:55 INFO] [1] set waiting to mount = 0
[SERVICE: 0x9B4,15:26:55 INFO] [1] input #55 from src #0
[SERVICE: 0x9B4,15:26:55 INFO] [DevNodesChanged]
[SERVICE: 0x9B4,15:26:55 INFO] [1] input #56 from src #0
[SERVICE: 0x9A8,15:26:55 INFO] SUCCESS
[SERVICE: 0x9A8,15:26:55 INFO] [1] progress is now 2
[SERVICE: 0x9A8,15:26:55 INFO] [MACHINE 1 TRANSITION] - {iTunesPseudoUnmounted} ==> {iTunesPseudoMounting}
[SERVICE: 0x9A8,15:26:55 INFO] [MACHINE 1 ACTIONS] - {iTunesPseudoMounting}
[SERVICE: 0x9A8,15:26:55 INFO] [1] input #53
[SERVICE: 0x99C,15:26:55 INFO] [1] progress state is 2, Waiting to mount = 0
[SERVICE: 0x99C,15:26:55 INFO] [1] Mount in progress, wait till finish...
[SERVICE: 0x9AC,15:26:55 INFO] [MACHINE 1 INPUT #51] - (HDW) CheckDevNode
[SERVICE: 0x9AC,15:26:55 INFO] Connection Detection Status - 0x180600A, device '\\?\usbstor#disk&ven_apple&prod_ipod&rev_1.62#000a2700195e186d&0#{53f56307-b6bf-11d0-94f2-00a0c91efb8b}'
[SERVICE: 0x9A4,15:26:55 INFO] [MACHINE 1 INPUT #52] - (HDW) Interface Arrival
[SERVICE: 0x9A4,15:26:55 INFO] [1] progress state is 2, Waiting to mount = 0
[SERVICE: 0x9A4,15:26:55 INFO] [1] progress is now 2
[SERVICE: 0x9A4,15:26:55 INFO] *** CItunesDevice::HandleHardwareInput()
[SERVICE: 0x9A4,15:26:55 INFO] [1] progress is now 2
[SERVICE: 0x9A4,15:26:55 INFO] [1] input #54
[SERVICE: 0x9A8,15:26:55 INFO] [MACHINE 1 INPUT #53] - (HDW) CheckDevNode
[SERVICE: 0x9A8,15:26:55 INFO] Connection Detection Status - 0x180600A, device '\\?\usbstor#disk&ven_apple&prod_ipod&rev_1.62#000a2700195e186d&0#{53f56307-b6bf-11d0-94f2-00a0c91efb8b}'
[SERVICE: 0x9A8,15:26:55 INFO] [1] input #55
[SERVICE: 0x9A4,15:26:55 INFO] [MACHINE 1 INPUT #54] - (HDW) CheckDevNode
[SERVICE: 0x9A4,15:26:55 INFO] Connection Detection Status - 0x180600A, device '\\?\usbstor#disk&ven_apple&prod_ipod&rev_1.62#000a2700195e186d&0#{53f56307-b6bf-11d0-94f2-00a0c91efb8b}'
[SERVICE: 0x9A4,15:26:55 INFO] [1] input #56
[SERVICE: 0x9A8,15:26:55 INFO] [MACHINE 1 INPUT #55] - (HDW) Volume Mount
[SERVICE: 0x9A8,15:26:55 INFO] [MACHINE 1 TRANSITION] - {iTunesPseudoMounting} ==> {Mounted}
[SERVICE: 0x9A8,15:26:55 INFO] Connection Detection Status - 0x180600A, device '\\?\usbstor#disk&ven_apple&prod_ipod&rev_1.62#000a2700195e186d&0#{53f56307-b6bf-11d0-94f2-00a0c91efb8b}'
[SERVICE: 0x9A8,15:26:55 INFO] [1] ***** iTunesPseudoMounting state finalizing internal mount
[SERVICE: 0x9A8,15:26:55 INFO] total locks = 1, caller = 2472, caller locks = 1
[SERVICE: 0x9A8,15:26:55 INFO] SUCCESS
[SERVICE: 0x9A8,15:26:55 INFO] Volume lock success!
[SERVICE: 0x9A4,15:26:55 INFO] [MACHINE 1 INPUT #56] - (HDW) CheckDevNode
[SERVICE: 0x9A4,15:26:55 INFO] Connection Detection Status - 0x180600A, device '\\?\usbstor#disk&ven_apple&prod_ipod&rev_1.62#000a2700195e186d&0#{53f56307-b6bf-11d0-94f2-00a0c91efb8b}'
[SERVICE: 0x9A8,15:26:56 INFO] total locks = 0, caller = 2472, caller locks = 0
[SERVICE: 0x9A8,15:26:56 INFO] [1] Finished Mounting with status 1
[SERVICE: 0x9A8,15:26:56 INFO] [MACHINE 1 ACTIONS] - {Mounted}
[SERVICE: 0x9A8,15:26:56 INFO] [1] progress state is 2, Waiting to mount = 0
[SERVICE: 0x9A8,15:26:56 INFO] [1] progress state is 2, Waiting to mount = 0
[SERVICE: 0x9A8,15:26:56 ERROR] Did not find first letter of stage
[SERVICE: 0x9A8,15:26:56 INFO] got HotPlugState 0
[SERVICE: 0x9A8,15:26:57 INFO] [1] OS says filesystem is FAT32
[SERVICE: 0x9A8,15:26:57 INFO] [1] ===== iPod Nano =====
[SERVICE: 0x9A8,15:26:57 INFO] [1] progress state is 2, Waiting to mount = 0
[SERVICE: 0x9A8,15:26:57 INFO] 15:26:57, year 2007, day of yr. 123, GMT offset 8 isDST 1
[SERVICE: 0x9A8,15:26:58 INFO] [1] progress is now 0
[SERVICE: 0x99C,15:26:58 INFO] [1] progress state is 0, Waiting to mount = 0
[SERVICE: 0x994,15:26:59 INFO] <0x4> GetFormatType() returned unknown format 0
[SERVICE: 0xCC4,15:26:59 INFO] [1] Progress state is 0, Waiting to disconnect = 0
[SERVICE: 0xCC4,15:26:59 INFO] Mounted
[SERVICE: 0xCC4,15:26:59 INFO] Device 1 is FAT32 and appears mounted, checking intermediate state...
[SERVICE: 0xCC4,15:26:59 INFO] Device 1 not in intermediate state. It appears to be truly mounted.
[SERVICE: 0x994,15:26:59 INFO] <0x4> COM request for device 1 drive letter - F
[SERVICE: 0x9A8,15:27:00 INFO] [1] ***** MOUNTED - Sending event out, device session 0.
[SERVICE: 0x99C,15:27:00 INFO] Mounted
[SERVICE: 0x99C,15:27:00 INFO] Device 0 is FAT32 and appears mounted, checking intermediate state...
[SERVICE: 0x99C,15:27:00 INFO] Device 0 not in intermediate state. It appears to be truly mounted.
[SERVICE: 0x99C,15:27:00 INFO] [1] input #57 from src #301860
[SERVICE: 0x9AC,15:27:00 INFO] [1] input #57
[SERVICE: 0x9AC,15:27:00 INFO] [MACHINE 1 INPUT #57] - (APP) Mountlock Unmount
[SERVICE: 0x9AC,15:27:00 INFO] [1] Begin Unmounting...
[SERVICE: 0x9AC,15:27:00 INFO] [1] progress is now 3
[SERVICE: 0x9AC,15:27:00 INFO] total locks = 1, caller = 2476, caller locks = 1
[SERVICE: 0x9AC,15:27:00 INFO] Ejecting media
[SERVICE: 0x9AC,15:27:00 INFO] SUCCESS
[SERVICE: 0x9AC,15:27:00 INFO] Volume lock success!
[SERVICE: 0x9AC,15:27:02 INFO] total locks = 2, caller = 2476, caller locks = 2
[SERVICE: 0x9AC,15:27:03 INFO] CM_Query_And_Remove_SubTreeW stop
[SERVICE: 0x9B4,15:27:03 INFO] [DevNodesChanged]
[SERVICE: 0x9B4,15:27:03 INFO] [1] input #58 from src #0
[SERVICE: 0x9B4,15:27:03 INFO] [DevNodesChanged]
[SERVICE: 0x9B4,15:27:03 INFO] [1] input #59 from src #0
[SERVICE: 0x9A8,15:27:03 INFO] [1] input #58
[SERVICE: 0x9A4,15:27:03 INFO] [1] input #59
[SERVICE: 0x9AC,15:27:03 INFO] CM_Query_And_Remove_SubTreeW took 406 ms
[SERVICE: 0x9AC,15:27:03 INFO] total locks = 1, caller = 2476, caller locks = 1
[SERVICE: 0x9AC,15:27:03 INFO] total locks = 0, caller = 2476, caller locks = 0
[SERVICE: 0x9AC,15:27:03 INFO] [1] Finished Unmounting with status 1
[SERVICE: 0x9AC,15:27:03 INFO] NOT Mounted
[SERVICE: 0x9AC,15:27:03 INFO] [1] **** NOT in intermediate state, device is Mounted
[SERVICE: 0x9AC,15:27:03 INFO] [MACHINE 1 TRANSITION] - {Mounted} ==> {iTunesPseudoUnmounting}
[SERVICE: 0x9AC,15:27:03 INFO] [MACHINE 1 ACTIONS] - {iTunesPseudoUnmounting}
[SERVICE: 0xCC4,15:27:03 INFO] [1] Progress state is 3, Waiting to disconnect = 0
[SERVICE: 0x9B4,15:27:03 INFO] [VolumeRemoved] existing mask 0x20, arrive mask 0x20
[SERVICE: 0x9B4,15:27:03 INFO] [1] value = 1
[SERVICE: 0x9B4,15:27:03 INFO] [1] input #60 from src #0
[SERVICE: 0x9AC,15:27:03 INFO] [1] input #60
[SERVICE: 0x9B4,15:27:03 INFO] [InterfaceRemoved]
[SERVICE: 0x9B4,15:27:03 INFO] [1] value = 0
[SERVICE: 0x9B4,15:27:03 INFO] removed device number 1 from m_objDeviceNumberMap
[SERVICE: 0x9B4,15:27:03 INFO] [1] input #61 from src #0