hi,
habe von einem freund einen iphone 5 mit 16gb abgekauft. iOS 7 war drauf und ich wollte es wiederherstellen damit sein kram weg ist. ich habe bereits an 2 rechnern (neuste iTunes version) einmal mit 64bit, einmal mit einem 32bit netbook. software wird soweit extrahiert, der balken am display geht auf ca. 60% dann kommt die meldung mit einer (1) in klammern.
KEINE (-1) !!!
habe am netbook die antivir software, iTunes und alle dazugehörige apple software deinstalliert und die firewall deaktiviert. fehlschlag!
hier mal der log:
habe von einem freund einen iphone 5 mit 16gb abgekauft. iOS 7 war drauf und ich wollte es wiederherstellen damit sein kram weg ist. ich habe bereits an 2 rechnern (neuste iTunes version) einmal mit 64bit, einmal mit einem 32bit netbook. software wird soweit extrahiert, der balken am display geht auf ca. 60% dann kommt die meldung mit einer (1) in klammern.
KEINE (-1) !!!
habe am netbook die antivir software, iTunes und alle dazugehörige apple software deinstalliert und die firewall deaktiviert. fehlschlag!
hier mal der log:
Code:
2013-10-18 02:49:31.250 [4712:1288]: restore library built Aug 8 2013 at 02:24:58
2013-10-18 02:49:31.250 [4712:1288]: iTunes: iTunes 11.1.1.11
2013-10-18 02:49:31.250 [4712:1288]: iTunes: Software payload version: 11A501
2013-10-18 02:49:31.250 [4712:1288]: iTunes: Using MobileRestore state machine
[00:50:17.0489] Changing state from 'Idle' to 'Restoring'
[00:50:17.0489] requested restore behavior: Erase
[00:50:17.0489] requested variant: Erase
[00:50:17.0489] amai: AMAuthInstallBundleCopyBuildIdentityForVariant: No baseband chipid reported. Will match Build Identity based on ap chipid and boardid only.
[00:50:18.0004] amai: _AMAuthInstallBundleCreateServerRequestDictionary: withApTicket is True
[00:50:18.0004] amai: _AMAuthInstallBundleCreateServerRequestDictionary: personalizing "RestoreLogo" Digest = "<CFData 06043E10 [72DE8078]>{length = 20, capacity = 20, bytes = 0x<<<<<<<<<<<<<<<<<<UDID>>>>>>>>>>>>>>>>>>}"
[00:50:18.0004] amai: _AMAuthInstallBundleCreateServerRequestDictionary: personalizing "RestoreDeviceTree" Digest = "<CFData 06043F78 [72DE8078]>{length = 20, capacity = 20, bytes = 0x<<<<<<<<<<<<<<<<<<UDID>>>>>>>>>>>>>>>>>>}"
[00:50:18.0004] amai: _AMAuthInstallBundleCreateServerRequestDictionary: personalizing "RestoreKernelCache" Digest = "<CFData 060444D0 [72DE8078]>{length = 20, capacity = 20, bytes = 0x<<<<<<<<<<<<<<<<<<UDID>>>>>>>>>>>>>>>>>>}"
[00:50:18.0004] amai: _AMAuthInstallBundleCreateServerRequestDictionary: personalizing "RestoreRamDisk" Digest = "<CFData 06043558 [72DE8078]>{length = 20, capacity = 20, bytes = 0x<<<<<<<<<<<<<<<<<<UDID>>>>>>>>>>>>>>>>>>}"
[00:50:18.0004] amai: _AMAuthInstallBundleCreateServerRequestDictionary: personalizing "iBEC" Digest = "<CFData 06043DC8 [72DE8078]>{length = 20, capacity = 20, bytes = 0x<<<<<<<<<<<<<<<<<<UDID>>>>>>>>>>>>>>>>>>}"
[00:50:18.0004] amai: _AMAuthInstallBundleCreateServerRequestDictionary: personalizing "iBSS" Digest = "<CFData 06044488 [72DE8078]>{length = 20, capacity = 20, bytes = 0x<<<<<<<<<<<<<<<<<<UDID>>>>>>>>>>>>>>>>>>}"
[00:50:18.0004] amai: _AMAuthInstallBundleCreateServerRequestDictionary: personalizing "KernelCache" Digest = "<CFData 06043510 [72DE8078]>{length = 20, capacity = 20, bytes = 0x<<<<<<<<<<<<<<<<<<UDID>>>>>>>>>>>>>>>>>>}"
[00:50:18.0004] amai: _AMAuthInstallBundleCreateServerRequestDictionary: personalizing "BatteryLow1" Digest = "<CFData 06043438 [72DE8078]>{length = 20, capacity = 20, bytes = 0x<<<<<<<<<<<<<<<<<<UDID>>>>>>>>>>>>>>>>>>}"
[00:50:18.0004] amai: _AMAuthInstallBundleCreateServerRequestDictionary: personalizing "BatteryLow0" Digest = "<CFData 06043360 [72DE8078]>{length = 20, capacity = 20, bytes = 0x<<<<<<<<<<<<<<<<<<UDID>>>>>>>>>>>>>>>>>>}"
[00:50:18.0004] amai: _AMAuthInstallBundleCreateServerRequestDictionary: personalizing "LLB" Digest = "<CFData 06043288 [72DE8078]>{length = 20, capacity = 20, bytes = 0x<<<<<<<<<<<<<<<<<<UDID>>>>>>>>>>>>>>>>>>}"
[00:50:18.0004] amai: _AMAuthInstallBundleCreateServerRequestDictionary: personalizing "iBoot" Digest = "<CFData 060431B0 [72DE8078]>{length = 20, capacity = 20, bytes = 0x<<<<<<<<<<<<<<<<<<UDID>>>>>>>>>>>>>>>>>>}"
[00:50:18.0019] amai: _AMAuthInstallBundleCreateServerRequestDictionary: personalizing "DeviceTree" Digest = "<CFData 06043240 [72DE8078]>{length = 20, capacity = 20, bytes = 0x<<<<<<<<<<<<<<<<<<UDID>>>>>>>>>>>>>>>>>>}"
[00:50:18.0019] amai: _AMAuthInstallBundleCreateServerRequestDictionary: personalizing "BatteryCharging1" Digest = "<CFData 060431F8 [72DE8078]>{length = 20, capacity = 20, bytes = 0x<<<<<<<<<<<<<<<<<<UDID>>>>>>>>>>>>>>>>>>}"
[00:50:18.0019] amai: _AMAuthInstallBundleCreateServerRequestDictionary: personalizing "AppleLogo" Digest = "<CFData 060432D0 [72DE8078]>{length = 20, capacity = 20, bytes = 0x<<<<<<<<<<<<<<<<<<UDID>>>>>>>>>>>>>>>>>>}"
[00:50:18.0019] amai: _AMAuthInstallBundleCreateServerRequestDictionary: personalizing "BatteryPlugin" Digest = "<CFData 060439D8 [72DE8078]>{length = 20, capacity = 20, bytes = 0x<<<<<<<<<<<<<<<<<<UDID>>>>>>>>>>>>>>>>>>}"
[00:50:18.0019] amai: _AMAuthInstallBundleCreateServerRequestDictionary: personalizing "BatteryFull" Digest = "<CFData 06043D38 [72DE8078]>{length = 20, capacity = 20, bytes = 0x<<<<<<<<<<<<<<<<<<UDID>>>>>>>>>>>>>>>>>>}"
[00:50:18.0019] amai: _AMAuthInstallBundleCreateServerRequestDictionary: personalizing "BatteryCharging0" Digest = "<CFData 06043CF0 [72DE8078]>{length = 20, capacity = 20, bytes = 0x<<<<<<<<<<<<<<<<<<UDID>>>>>>>>>>>>>>>>>>}"
[00:50:18.0019] amai: _AMAuthInstallBundleCreateServerRequestDictionary: personalizing "RecoveryMode" Digest = "<CFData 06043C18 [72DE8078]>{length = 20, capacity = 20, bytes = 0x<<<<<<<<<<<<<<<<<<UDID>>>>>>>>>>>>>>>>>>}"
[00:50:18.0019] amai: _AMAuthInstallBundleCreateServerRequestDictionary: using UniqueBuildID <CFData 00AE8960 [72DE8078]>{length = 20, capacity = 20, bytes = 0x<<<<<<<<<<<<<<<<<<UDID>>>>>>>>>>>>>>>>>>}
[00:50:18.0019] amai: AMAuthInstallRequestSendSync: SSO function returned NULL, SSO disabled.
[00:50:18.0035] amai: AMAuthInstallDebugWriteObject: debug object written: C:\Users\Adnan\AppData\Local\Temp\Per112F.tmp\amai\debug\tss-request.plist
[00:50:18.0752] amai: tss_submit_job: HttpQueryInfo returned 200
[00:50:18.0955] amai: AMAuthInstallRequestSendSync: received tss response (server version: 2.1.0)
[00:50:18.0955] amai: AMAuthInstallDebugWriteObject: debug object written: C:\Users\Adnan\AppData\Local\Temp\Per112F.tmp\amai\debug\tss-response.plist
[00:50:19.0002] amai: _AMAuthInstallBundlePopulatePersonalizedBundle: no entry in manifest found for "Diags"
[00:50:19.0002] iBoot build-version = iBoot-1940.1.75
[00:50:19.0002] iBoot build-style = RELEASE
[00:50:19.0002] requested restore behavior: Erase
[00:50:19.0002] amai: AMAuthInstallBundleCopyBuildIdentityForVariant: No baseband chipid reported. Will match Build Identity based on ap chipid and boardid only.
[00:50:19.0002] requested restore behavior: Erase
[00:50:19.0002] amai: AMAuthInstallBundleCopyBuildIdentityForVariant: No baseband chipid reported. Will match Build Identity based on ap chipid and boardid only.
[00:50:19.0002] unable to open device_map.txt: No such file or directory
[00:50:19.0018] found device map entry for 0x00008950 0x00000002. boardConfig=n42ap platform=s5l8950x
[00:50:19.0018] _AMRestoreCopyDeviceMapPlistEntryForHardware: firmwareDirectory not in options
[00:50:19.0018] AMDeviceIoControl: GetOverlappedResult failed
[00:50:19.0018] AMDeviceIoControl: pipe stall
[00:50:19.0018] USBControlTransfer: error 31, usbd status c0000004
[00:50:19.0018] command device request for 'getenv radio-error' failed: 2008
[00:50:19.0018] radio-error not set
[00:50:19.0018] unable to open device_map.txt: No such file or directory
[00:50:19.0018] <Recovery Mode Device 00A4D290>: production fused device
[00:50:19.0018] requested restore behavior: Erase
[00:50:19.0018] amai: AMAuthInstallBundleCopyBuildIdentityForVariant: No baseband chipid reported. Will match Build Identity based on ap chipid and boardid only.
[00:50:19.0018] requested restore behavior: Erase
[00:50:19.0018] amai: AMAuthInstallBundleCopyBuildIdentityForVariant: No baseband chipid reported. Will match Build Identity based on ap chipid and boardid only.
[00:50:19.0018] interface has 1 endpoints, file pipe = 1
[00:50:19.0018]
[00:50:19.0018] <Recovery Mode Device 00A4D290>: operation 4 progress -1
[00:50:19.0064] bootstrapping restore with iBEC
[00:50:19.0064] requested restore behavior: Erase
[00:50:19.0064] amai: AMAuthInstallBundleCopyBuildIdentityForVariant: No baseband chipid reported. Will match Build Identity based on ap chipid and boardid only.
[00:50:19.0080] <Recovery Mode Device 00A4D290>: operation 31 progress -1
[00:50:20.0094] <Recovery Mode Device 00A4D290>: Recovery mode succeeded
[00:50:20.0094] Finished Recovery Restore Phase: Successful
[00:50:20.0297] Recovery mode device disconnected
[00:50:20.0297] Device removed when in state Restoring, moving device to transition state
[00:50:20.0297] Changing state from 'Restoring' to 'Transitioning'
[00:50:20.0297] Creating timer to monitor transition
[00:50:23.0502] Recovery mode device connected
[00:50:23.0502] Transitioning device returned, continuing restore.
[00:50:23.0502] Canceling timer
[00:50:23.0512] Changing state from 'Transitioning' to 'Restoring'
[00:50:23.0512] requested restore behavior: Erase
[00:50:23.0512] requested variant: Erase
[00:50:23.0512] amai: AMAuthInstallBundleCopyBuildIdentityForVariant: No baseband chipid reported. Will match Build Identity based on ap chipid and boardid only.
[00:50:24.0022] amai: _AMAuthInstallBundleCreateServerRequestDictionary: withApTicket is False
[00:50:24.0022] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "RestoreLogo"
[00:50:24.0022] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "RestoreDeviceTree"
[00:50:24.0022] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "RestoreKernelCache"
[00:50:24.0022] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "RestoreRamDisk"
[00:50:24.0022] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "iBEC"
[00:50:24.0032] amai: _AMAuthInstallBundleCreateServerRequestDictionary: entry "iBSS" has been previously personalized; skipping it
[00:50:24.0032] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "KernelCache"
[00:50:24.0032] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "BatteryLow1"
[00:50:24.0032] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "BatteryLow0"
[00:50:24.0032] amai: _AMAuthInstallBundleCreateServerRequestDictionary: entry "LLB" has been previously personalized; skipping it
[00:50:24.0032] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "iBoot"
[00:50:24.0032] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "DeviceTree"
[00:50:24.0032] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "BatteryCharging1"
[00:50:24.0032] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "AppleLogo"
[00:50:24.0032] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "BatteryPlugin"
[00:50:24.0032] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "BatteryFull"
[00:50:24.0032] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "BatteryCharging0"
[00:50:24.0032] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "RecoveryMode"
[00:50:24.0032] amai: _AMAuthInstallBundleCreateServerRequestDictionary: nothing to be done
[00:50:24.0032] iBoot build-version = iBoot-1940.1.75
[00:50:24.0032] iBoot build-style = RELEASE
[00:50:24.0032] requested restore behavior: Erase
[00:50:24.0032] amai: AMAuthInstallBundleCopyBuildIdentityForVariant: No baseband chipid reported. Will match Build Identity based on ap chipid and boardid only.
[00:50:24.0042] requested restore behavior: Erase
[00:50:24.0042] amai: AMAuthInstallBundleCopyBuildIdentityForVariant: No baseband chipid reported. Will match Build Identity based on ap chipid and boardid only.
[00:50:24.0042] unable to open device_map.txt: No such file or directory
[00:50:24.0042] found device map entry for 0x00008950 0x00000002. boardConfig=n42ap platform=s5l8950x
[00:50:24.0042] _AMRestoreCopyDeviceMapPlistEntryForHardware: firmwareDirectory not in options
[00:50:24.0042] AMDeviceIoControl: GetOverlappedResult failed
[00:50:24.0042] AMDeviceIoControl: pipe stall
[00:50:24.0042] USBControlTransfer: error 31, usbd status c0000004
[00:50:24.0042] command device request for 'getenv radio-error' failed: 2008
[00:50:24.0042] radio-error not set
[00:50:24.0042] unable to open device_map.txt: No such file or directory
[00:50:24.0042] <Recovery Mode Device 06BFEB38>: production fused device
[00:50:24.0042] requested restore behavior: Erase
[00:50:24.0042] amai: AMAuthInstallBundleCopyBuildIdentityForVariant: No baseband chipid reported. Will match Build Identity based on ap chipid and boardid only.
[00:50:24.0042] requested restore behavior: Erase
[00:50:24.0042] amai: AMAuthInstallBundleCopyBuildIdentityForVariant: No baseband chipid reported. Will match Build Identity based on ap chipid and boardid only.
[00:50:24.0052] interface has 1 endpoints, file pipe = 1
[00:50:24.0052]
[00:50:24.0052] <Recovery Mode Device 06BFEB38>: operation 4 progress -1
[00:50:24.0082] unable to open device_map.txt: No such file or directory
[00:50:24.0092] found device map entry for 0x00008950 0x00000002. boardConfig=n42ap platform=s5l8950x
[00:50:24.0092] _AMRestoreCopyDeviceMapPlistEntryForHardware: firmwareDirectory not in options
[00:50:24.0092] requested restore behavior: Erase
[00:50:24.0092] amai: AMAuthInstallBundleCopyBuildIdentityForVariant: No baseband chipid reported. Will match Build Identity based on ap chipid and boardid only.
[00:50:24.0092] requested restore behavior: Erase
[00:50:24.0092] amai: AMAuthInstallBundleCopyBuildIdentityForVariant: No baseband chipid reported. Will match Build Identity based on ap chipid and boardid only.
[00:50:24.0092] <Recovery Mode Device 06BFEB38>: operation 42 progress -1
[00:50:24.0092] requested restore behavior: Erase
[00:50:24.0092] amai: AMAuthInstallBundleCopyBuildIdentityForVariant: No baseband chipid reported. Will match Build Identity based on ap chipid and boardid only.
[00:50:25.0127] <Recovery Mode Device 06BFEB38>: operation 5 progress -1
[00:50:25.0454] unable to open device_map.txt: No such file or directory
[00:50:25.0454] found device map entry for 0x00008950 0x00000002. boardConfig=n42ap platform=s5l8950x
[00:50:25.0454] _AMRestoreCopyDeviceMapPlistEntryForHardware: firmwareDirectory not in options
[00:50:25.0454] AMDeviceIoControl: GetOverlappedResult failed
[00:50:25.0454] AMDeviceIoControl: pipe stall
[00:50:25.0454] USBControlTransfer: error 31, usbd status c0000004
[00:50:25.0454] command device request for 'getenv ramdisk-delay' failed: 2008
[00:50:27.0139] <Recovery Mode Device 06BFEB38>: operation 6 progress -1
[00:50:28.0153] <Recovery Mode Device 06BFEB38>: operation 7 progress -1
[00:50:28.0434] <Recovery Mode Device 06BFEB38>: operation 8 progress -1
[00:50:28.0434] unable to open device_map.txt: No such file or directory
[00:50:28.0434] found device map entry for 0x00008950 0x00000002. boardConfig=n42ap platform=s5l8950x
[00:50:28.0434] _AMRestoreCopyDeviceMapPlistEntryForHardware: firmwareDirectory not in options
[00:50:28.0434] <Recovery Mode Device 06BFEB38>: operation 9 progress -1
[00:50:28.0450] <Recovery Mode Device 06BFEB38>: Recovery mode succeeded
[00:50:28.0450] Finished Recovery Restore Phase: Successful
[00:50:29.0713] Recovery mode device disconnected
[00:50:29.0713] Device removed when in state Restoring, moving device to transition state
[00:50:29.0713] Changing state from 'Restoring' to 'Transitioning'
[00:50:29.0713] Creating timer to monitor transition
[00:50:32.0780] RestoreOS mode device connected
[00:50:32.0780] Transitioning device returned, continuing restore.
[00:50:32.0780] Canceling timer
[00:50:32.0780] Changing state from 'Transitioning' to 'Restoring'
[00:50:32.0780] <Restore Device 0E0A81B0>: operation 44 progress -1
[00:50:32.0780] requested restore behavior: Erase
[00:50:32.0780] requested variant: Erase
[00:50:32.0780] amai: AMAuthInstallBundleCopyBuildIdentityForVariant: No baseband chipid reported. Will match Build Identity based on ap chipid and boardid only.
[00:50:33.0298] amai: _AMAuthInstallBundleCreateServerRequestDictionary: withApTicket is False
[00:50:33.0298] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "RestoreLogo"
[00:50:33.0298] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "RestoreDeviceTree"
[00:50:33.0298] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "RestoreKernelCache"
[00:50:33.0298] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "RestoreRamDisk"
[00:50:33.0298] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "iBEC"
[00:50:33.0298] amai: _AMAuthInstallBundleCreateServerRequestDictionary: entry "iBSS" has been previously personalized; skipping it
[00:50:33.0298] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "KernelCache"
[00:50:33.0308] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "BatteryLow1"
[00:50:33.0308] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "BatteryLow0"
[00:50:33.0308] amai: _AMAuthInstallBundleCreateServerRequestDictionary: entry "LLB" has been previously personalized; skipping it
[00:50:33.0308] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "iBoot"
[00:50:33.0308] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "DeviceTree"
[00:50:33.0308] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "BatteryCharging1"
[00:50:33.0308] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "AppleLogo"
[00:50:33.0308] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "BatteryPlugin"
[00:50:33.0308] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "BatteryFull"
[00:50:33.0308] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "BatteryCharging0"
[00:50:33.0308] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "RecoveryMode"
[00:50:33.0308] amai: _AMAuthInstallBundleCreateServerRequestDictionary: nothing to be done
[00:50:33.0308] requested restore behavior: Erase
[00:50:33.0308] amai: AMAuthInstallBundleCopyBuildIdentityForVariant: No baseband chipid reported. Will match Build Identity based on ap chipid and boardid only.
[00:50:33.0308] device did not return saved USB log
[00:50:33.0318] device did not return saved panic log
[00:50:33.0318] previous restore failed with exit status 0x100
[00:50:33.0318] connected to service com.apple.mobile.restored
[00:50:33.0318] using protocol version 13
[00:50:33.0318] unable to open device_map.txt: No such file or directory
[00:50:33.0318] board config = n42ap
[00:50:33.0318] no value returned for BootArgs
[00:50:33.0318] _copyDeviceProperty() failed for restore bootargs
[00:50:33.0318] no value returned for MarketingPartNumber
[00:50:33.0318] _copyDeviceProperty() failed for mpn
[00:50:33.0318] requested restore behavior: Erase
[00:50:33.0318] amai: AMAuthInstallBundleCopyBuildIdentityForVariant: No baseband chipid reported. Will match Build Identity based on ap chipid and boardid only.
[00:50:33.0328] value query for 'HardwareModel' returned 'N42AP'
[00:50:33.0328] <Restore Device 0E0A81B0>: operation 28 progress -1
[00:50:49.0219] previous restore failed: Identified Serial Port on ARM Device=uart1 at 0x32600000(0x874a6000)
[00:50:49.0219] L2TP domain init
[00:50:49.0219] L2TP domain init complete
[00:50:49.0219] PPTP domain init
[00:50:49.0219] AppleSamsungSerial: Identified Serial Port on ARM Device=uart3 at 0x32800000(0x874be000)
[00:50:49.0219] virtual bool AppleDisplayPipe::start_hardware(IOService *), auto-detect chip
[00:50:49.0219] Scaler 0 enableDeviceClock(true,HALF_CLOCK_INDEX) = 0x0
[00:50:49.0219] Scaler 0 enableDeviceClock(true,FULL_CLOCK_INDEX) = 0x0
[00:50:49.0219] Scaler 0 enableDevicePower(true,0,HALF_CLOCK_INDEX) = 0x0
[00:50:49.0219] Scaler 0 enableDeviceClock(false,FULL_CLOCK_INDEX) = 0x0
[00:50:49.0219] Scaler 1 enableDeviceClock(true,HALF_CLOCK_INDEX) = 0x0
[00:50:49.0219] Scaler 1 enableDeviceClock(true,FULL_CLOCK_INDEX) = 0x0
[00:50:49.0219] Scaler 1 enableDevicePower(true,0,HALF_CLOCK_INDEX) = 0x0
[00:50:49.0219] Scaler 1 enableDeviceClock(false,FULL_CLOCK_INDEX) = 0x0
[00:50:49.0219] [nand_part_core:INF@2173] read valid partition table
[00:50:49.0219] [nand_part_core:INF@ 145] created partition 0 as 'Boot Block'
[00:50:49.0219] [nand_part_core:INF@ 145] created partition 1 as 'Effaceable'
[00:50:49.0219] [nand_part_core:INF@ 145] created partition 2 as 'NVRAM'
[00:50:49.0219] [nand_part_core:INF@ 145] created partition 3 as 'Firmware'
[00:50:49.0219] [nand_part_core:INF@ 145] created partition 4 as 'Filesystem'
[00:50:49.0219] [nand_part_core:INF@ 157] published partition 4
[00:50:49.0219] [nand_part_core:INF@ 145] created partition 5 as 'System Config'
[00:50:49.0219] [nand_part_core:INF@ 145] created partition 6 as 'Diagnostic Data'
[00:50:49.0219] [nand_part_core:INF@ 145] created partition 7 as 'Bad Block Table'
[00:50:49.0219] AppleSwissPPNFTL started with IOFlashStoragePartition provider
[00:50:49.0219] [NAND] _FindFlashMediaAndKeepout:601 physical nand block offset 1
[00:50:49.0219] AppleNANDFTL registered[nand_part_core:INF@ 157] published partition 7
[00:50:49.0219] [NAND] start:356 this 0x8bdd1c00 PROVIDER=0x8be1dd00 flashMedia=0x8be1dd00
[00:50:49.0219] [NAND] WMR_Start:149 Apple PPN NAND Driver, Read/Write
[00:50:49.0219] [NAND] WMR_Start:174 FIL_Init [OK]
[00:50:49.0219] AppleD1972PMUPowerSource: AppleUSBCableDetect 1
[00:50:49.0219] AppleD1972PMUPowerSource: AppleUSBCableType USBHost
[00:50:49.0219] [NAND] WMR_Open:371 VFL_Open [OK]
[00:50:49.0219] AppleAP3DSH::probe found device with ID: 0x3f
[00:50:49.0219] AppleAP3DSH::handleStart _calibrationMatrix [68115 -2041 1] [-1323 64854 131] [-25 499 64463]
[00:50:49.0219] AppleAP3DSH::handleStart _calibrationOffsets [881485 758633 67928]
[00:50:49.0219] AppleAP3DSH::handleStart - No calibration inverse matrix or the data is invalid, Compute locally
[00:50:49.0219] AppleAP3DSH::handleStart _calibrationInverseMatrix [63093 1985 -4] [1286 66265 -135] [13 -512 66626]
[00:50:49.0219] AppleAP3DSH::handleStart _odr400HzSampleInterval = 2414
[00:50:49.0219] AppleMultitouchN1SPI: successfully started
[00:50:49.0219] AppleH4CamIn::start - back camera expected
[00:50:49.0219] AppleH4CamIn::start - front camera expected
[00:50:49.0219] AppleH4CamIn::power_off_hardware
[00:50:49.0219] AppleH4CamIn::setPowerStateGated: 0
[00:50:49.0219] IOAccessoryDock9Pin::handleIDBusState: tristar: power handshake verification failed
[00:50:49.0219] AppleSynopsysOTGDevice::gated_handleUSBCableConnect cable connected, but don't have device configuration yet
[00:50:49.0219] AppleCS35L19Amp: could not allocate control 395
[00:50:49.0219] AppleSynopsysOTGDevice::gated_handleUSBCableConnect cable connected, but don't have device configuration yet
[00:50:49.0219] AppleMultitouchN1SPI: detected HBPP. driver will be kept alive
[00:50:49.0219] display-scale = 2
[00:50:49.0219] display-rotation = 0
[00:50:49.0219] found applelogo at /usr/share/progressui/applelogo@2x.tga
[00:50:49.0219] found display: primary
[00:50:49.0219] display: 640 x 1136
[00:50:49.0219] found PTP interface
[00:50:49.0219] AppleSynopsysOTGDevice - Configuration: PTP
[00:50:49.0219] AppleSynopsysOTGDevice Interface: PTP
[00:50:49.0219] AppleSynopsysOTGDevice - Configuration: iPod USB Interface
[00:50:49.0219] AppleSynopsysOTGDevice Interface: USBAudioControl
[00:50:49.0219] AppleSynopsysOTGDevice Interface: USBAudioStreaming
[00:50:49.0219] AppleSynopsysOTGDevice Interface: IapOverUsbHid
[00:50:49.0219] AppleSynopsysOTGDevice - Configuration: PTP + Apple Mobile Device
[00:50:49.0219] AppleSynopsysOTGDevice Interface: PTP
[00:50:49.0219] AppleSynopsysOTGDevice Interface: AppleUSBMux
[00:50:49.0219] AppleSynopsysOTGDevice - Configuration: PTP + Apple Mobile Device + Apple USB Ethernet
[00:50:49.0219] AppleSynopsysOTGDevice Interface: PTP
[00:50:49.0219] AppleSynopsysOTGDevice Interface: AppleUSBMux
[00:50:49.0219] AppleSynopsysOTGDevice Interface: AppleUSBEthernet
[00:50:49.0219] AppleSynopsysOTGDevice::gated_registerFunction Register function USBAudioControl
[00:50:49.0219] AppleSynopsysOTGDevice::gated_registerFunction Register function USBAudioStreaming
[00:50:49.0219] AppleSynopsysOTGDevice::gated_registerFunction Register function AppleUSBEthernet
[00:50:49.0219] IOAccessoryPortUSB::start
[00:50:49.0219] virtual bool AppleUSBDeviceMux::start(IOService *) build: Sep 9 2013 21:18:34
[00:50:49.0219] init_waste
[00:50:49.0219] AppleSynopsysOTGDevice::gated_registerFunction Register function AppleUSBMux
[00:50:49.0219] AppleSynopsysOTGDevice::gated_registerFunction Register function IapOverUsbHid
[00:50:49.0219] AppleSynopsysOTGDevice::gated_registerFunction Register function PTP
[00:50:49.0219] AppleSynopsysOTGDevice::startUSBStack Starting usb stack
[00:50:49.0219] IOReturn AppleUSBDeviceMux::setPropertiesGated(OSObject *) setting debug level to 7
[00:50:49.0219] 000084.257460 wlan.N[0] AppleBCMWLANBusInterfaceHSIC::attachBusGated(): AppleBCMWLANBusInterfaceHSIC (0x8c086800) -->>-- AppleBCMWLANBusInterfaceHSICShim (0x8c4e1180)
[00:50:49.0219] AppleBCMWLANCore::init(): IO80211-39 Sep 9 2013 20:46:03
[00:50:49.0219] AppleBCMWLANCore::init(): AppleBCMWLANV2-241 Sep 9 2013 21:20:29
[00:50:49.0219] 000084.362779 wlan.N[1] AppleBCMWLANCore::start(): Starting with MAC Address: <<<mac address>>>
[00:50:49.0219] 000084.363160 wlan.N[2] AppleBCMWLANCore::setPowerStateGated(): powerState 1, fStateFlags 0x20, dev 0xc9e91000 (this 1, provider 0)
[00:50:49.0219] 000084.363175 wlan.N[3] AppleBCMWLANCore::setPowerStateGated(): Received power state change before driver has initialized, ignoring
[00:50:49.0219] IO80211Peer::addPhyStatistics Phy stats started for addr <<<mac address>>>
[00:50:49.0219] IO80211Peer::addPhyStatistics Tx Completion stats started for addr <<<mac address>>>
[00:50:49.0219] IO80211PeerManager::initWithInterface cant add monitoring timer
[00:50:49.0219] Started logging for intf
[00:50:49.0219] IO80211PeerManager::initWithInterface: inited peer manager
[00:50:49.0219] IO80211Interface::init peerManager=0x8deea000
[00:50:49.0219] start:156
[00:50:49.0219] start:156
[00:50:49.0219] [NAND] WMR_Open:420 FTL_Open [OK]
[00:50:49.0219] [NAND] _publishServices:642 FTL capabilities: 0x00000001
[00:50:49.0219] [NAND] _ppnvflGetStruct:3469 Checking borrowed blocks - count: 23 max_count: 23
[00:50:49.0219] [NAND] _fetchBorrowedList:881 number of borrowed blocks 16
[00:50:49.0219] [nand_part_core:INF@ 157] published partition 0
[00:50:49.0219] [nand_part_core:INF@ 157] published partition 1
[00:50:49.0219] [nand_part_core:INF@ 157] published partition 2
[00:50:49.0219] [nand_part_core:INF@ 157] published partition 3
[00:50:49.0219] [nand_part_core:INF@ 157] published partition 5
[00:50:49.0219] [nand_part_core:INF@ 157] published partition 6
[00:50:49.0219] AppleUSBDeviceMux::handleConnectResult new session 0x8df5c318 established 62078<-lo0->49152 62078<-usb->62720
[00:50:49.0219] void AppleUSBDeviceMux::handleMuxTCPInput(mbuf_t) received reset, closing 0x8df5c318
[00:50:49.0219] recv(13, 4) failed: connection closed
[00:50:49.0219] unable to read message size: -1
[00:50:49.0219] could not receive message
[00:50:49.0219] AppleUSBDeviceMux::handleConnectResult new session 0x8df5c318 established 62078<-lo0->49153 62078<-usb->62976
[00:50:49.0219] AppleUSBDeviceMux::handleConnectResult new session 0x8df5c2c0 established 62078<-lo0->49154 62078<-usb->63232
[00:50:49.0219] AppleUSBDeviceMux::handleConnectResult new session 0x8df5c268 established 62078<-lo0->49155 62078<-usb->63488
[00:50:49.0219] void AppleUSBDeviceMux::handleMuxTCPInput(mbuf_t) received reset, closing 0x8df5c318
[00:50:49.0219] recv(13, 4) failed: connection closed
[00:50:49.0219] unable to read message size: -1
[00:50:49.0219] could not receive message
[00:50:49.0219] void AppleUSBDeviceMux::handleMuxTCPInput(mbuf_t) received reset, closing 0x8df5c268
[00:50:49.0219] recv(15, 4) failed: connection closed
[00:50:49.0219] unable to read message size: -1
[00:50:49.0219] could not receive message
[00:50:49.0219] AppleUSBDeviceMux::handleConnectResult new session 0x8df5c318 established 62078<-lo0->49156 62078<-usb->63744
[00:50:49.0219] void AppleUSBDeviceMux::handleMuxTCPInput(mbuf_t) received reset, closing 0x8df5c318
[00:50:49.0219] recv(13, 4) failed: connection closed
[00:50:49.0219] unable to read message size: -1
[00:50:49.0219] could not receive message
[00:50:49.0219] AppleUSBDeviceMux::handleConnectResult new session 0x8df5c318 established 62078<-lo0->49157 62078<-usb->64000
[00:50:49.0219] void AppleUSBDeviceMux::handleMuxTCPInput(mbuf_t) received reset, closing 0x8df5c318
[00:50:49.0219] void AppleUSBDeviceMux::handleMuxTCPInput(mbuf_t) received reset, closing 0x8df5c2c0
[00:50:49.0219] recv(9, 4) failed: connection closed
[00:50:49.0219] recv(14, 4) failed: connection closed
[00:50:49.0219] unable to read message size: -1
[00:50:49.0219] unable to read message size: -1
[00:50:49.0219] could not receive message
[00:50:49.0219] AppleUSBDeviceMux::handleConnectResult new session 0x8df5c2c0 established 62078<-lo0->49158 62078<-usb->64256
[00:50:49.0219] could not receive message
[00:50:49.0219] AppleUSBDeviceMux::handleConnectResult new session 0x8df5c318 established 62078<-lo0->49159 62078<-usb->64512
[00:50:49.0219] void AppleUSBDeviceMux::handleMuxTCPInput(mbuf_t) received reset, closing 0x8df5c318
[00:50:49.0219] recv(9, 4) failed: connection closed
[00:50:49.0219] unable to read message size: -1
[00:50:49.0219] could not receive message
[00:50:49.0219] AppleUSBDeviceMux::handleConnectResult new session 0x8df5c318 established 62078<-lo0->49160 62078<-usb->64768
[00:50:49.0219] void AppleUSBDeviceMux::handleMuxTCPInput(mbuf_t) received reset, closing 0x8df5c318
[00:50:49.0219] recv(9, 4) failed: connection closed
[00:50:49.0219] unable to read message size: -1
[00:50:49.0219] could not receive message
[00:50:49.0219] AppleUSBDeviceMux::handleConnectResult new session 0x8df5c268 established 62078<-lo0->49161 62078<-usb->65024
[00:50:49.0219] void AppleUSBDeviceMux::handleMuxTCPInput(mbuf_t) received reset, closing 0x8df5c268
[00:50:49.0219] recv(9, 4) failed: connection closed
[00:50:49.0219] unable to read message size: -1
[00:50:49.0219] could not receive message
[00:50:49.0219] AppleUSBDeviceMux::handleConnectResult new session 0x8df5c268 established 62078<-lo0->49162 62078<-usb->65280
[00:50:49.0219] void AppleUSBDeviceMux::handleMuxTCPInput(mbuf_t) received reset, closing 0x8df5c268
[00:50:49.0219] recv(9, 4) failed: connection closed
[00:50:49.0219] unable to read message size: -1
[00:50:49.0219] could not receive message
[00:50:49.0219] AppleUSBDeviceMux::handleConnectResult new session 0x8df5c268 established 62078<-lo0->49163 62078<-usb->1
[00:50:49.0219] unrecognized key 'BootArgs' in value query
[00:50:49.0219] failed to handle value query for key 'BootArgs', sending back empty response
[00:50:49.0219] void AppleUSBDeviceMux::handleMuxTCPInput(mbuf_t) received reset, closing 0x8df5c268
[00:50:49.0219] recv(9, 4) failed: connection closed
[00:50:49.0219] unable to read message size: -1
[00:50:49.0219] could not receive message
[00:50:49.0219] AppleUSBDeviceMux::handleConnectResult new session 0x8df5c268 established 62078<-lo0->49164 62078<-usb->257
[00:50:49.0219] unrecognized key 'MarketingPartNumber' in value query
[00:50:49.0219] failed to handle value query for key 'MarketingPartNumber', sending back empty response
[00:50:49.0219] void AppleUSBDeviceMux::handleMuxTCPInput(mbuf_t) received reset, closing 0x8df5c268
[00:50:49.0219] recv(9, 4) failed: connection closed
[00:50:49.0219] unable to read message size: -1
[00:50:49.0219] could not receive message
[00:50:49.0219] AppleUSBDeviceMux::handleConnectResult new session 0x8df5c268 established 62078<-lo0->49165 62078<-usb->513
[00:50:49.0219] void AppleUSBDeviceMux::handleMuxTCPInput(mbuf_t) received reset, closing 0x8df5c268
[00:50:49.0219] recv(9, 4) failed: connection closed
[00:50:49.0219] unable to read message size: -1
[00:50:49.0219] could not receive message
[00:50:49.0219] client protocol version 13
[00:50:49.0219] *** UUID 6FC3FD86-24C7-E94D-BC97-A7FB0FAF2128 ***
[00:50:49.0219] Restore options:
[00:50:49.0219] UUID => <CFString 0x14e61890 [0x303ad0]>{contents = "6FC3FD86-24C7-E94D-BC97-A7FB0FAF2128"}
[00:50:49.0219] MinimumSystemPartition => <CFNumber 0x14e617e0 [0x303ad0]>{value = +1590, type = kCFNumberSInt64Type}
[00:50:49.0219] SystemPartitionSize => <CFNumber 0x14e61210 [0x303ad0]>{value = +1590, type = kCFNumberSInt64Type}
[00:50:49.0219] SystemPartitionPadding => <CFBasicHash 0x14e60a20 [0x303ad0]>{type = mutable dict, count = 5,
[00:50:49.0219] entries =>
[00:50:49.0219] 2 : <CFString 0x14e61810 [0x303ad0]>{contents = "128"} = <CFNumber 0x14e61840 [0x303ad0]>{value = +1280, type = kCFNumberSInt64Type}
[00:50:49.0219] 3 : <CFString 0x14e60f90 [0x303ad0]>{contents = "16"} = <CFNumber 0x14e617b0 [0x303ad0]>{value = +160, type = kCFNumberSInt64Type}
[00:50:49.0219] 4 : <CFString 0x14e614f0 [0x303ad0]>{contents = "32"} = <CFNumber 0x14e61430 [0x303ad0]>{value = +320, type = kCFNumberSInt64Type}
[00:50:49.0219] 5 : <CFString 0x14e61240 [0x303ad0]>{contents = "8"} = <CFNumber 0x14e61200 [0x303ad0]>{value = +80, type = kCFNumberSInt64Type}
[00:50:49.0219] 8 : <CFString 0x14e61440 [0x303ad0]>{contents = "64"} = <CFNumber 0x14e609d0 [0x303ad0]>{value = +640, type = kCFNumberSInt64Type}
[00:50:49.0219] }
[00:50:49.0219]
[00:50:49.0219] entering load_sep_os
[00:50:49.0219] device has no sep
[00:50:49.0219] entering partition_nand_device
[00:50:49.0219] device supports boot-from-NAND
[00:50:49.0219] nand device is already partitioned
[00:50:49.0219] entering wait_for_storage_device
[00:50:49.0219] Searching for NAND service
[00:50:49.0219] Found NAND service: IOFlashStoragePartition
[00:50:49.0219] NAND initialized. Waiting for devnode.
[00:50:49.0219] entering clear_remap_variable
[00:50:49.0219] executing /usr/sbin/nvram
[00:50:49.0219] entering format_effaceable_storage
[00:50:49.0219] waiting for matching IOKit service: <CFBasicHash 0x14d684d0 [0x303ad0]>{type = mutable dict, count = 1,
[00:50:49.0219] entries =>
[00:50:49.0219] 2 : <CFString 0x45ee50 [0x303ad0]>{contents = "IOProviderClass"} = <CFString 0x14d66eb0 [0x303ad0]>{contents = "AppleEffaceableStorage"}
[00:50:49.0219] }
[00:50:49.0219]
[00:50:49.0219] effaceable storage is formatted, clearing it
[00:50:49.0219] [effaceable:INIT] found current generation, 59, in group 2
[00:50:49.0219] [effaceable:INIT] started
[00:50:49.0219] [effaceable:INIT] started
[00:50:49.0219] effaceable storaged cleared
[00:50:49.0219] entering ramrod_probe_media
[00:50:49.0219] device partitioning scheme is GPT
[00:50:49.0219] find_filesystem_partitions: storage=/dev/disk0s1 system=/dev/disk0s1s1 data=/dev/disk0s1s2
[00:50:49.0219] executing /sbin/fsck_hfs
[00:50:49.0219] ** /dev/rdisk0s1s1
[00:50:49.0219] Executing fsck_hfs (version hfs-227).
[00:50:49.0219] ** Checking Journaled HFS Plus volume.
[00:50:49.0219] ** Detected a case-sensitive volume.
[00:50:49.0219] The volume name is Innsbruck11A501.N42OS
[00:50:49.0219] ** Checking extents overflow file.
[00:50:49.0219] ** Checking catalog file.
[00:50:49.0219] ** Checking multi-linked files.
[00:50:49.0219] ** Checking catalog hierarchy.
[00:50:49.0219] ** Checking extended attributes file.
[00:50:49.0219] ** Checking volume bitmap.
[00:50:49.0219] ** Checking volume information.
[00:50:49.0219] ** Trimming unused blocks.
[00:50:49.0219] ** The volume Innsbruck11A501.N42OS appears to be OK.
[00:50:49.0219] executing /sbin/mount_hfs
[00:50:49.0219] /dev/disk0s1s1 mounted on /mnt1
[00:50:49.0219] entering check_for_restore_log
[00:50:49.0219] found restore log (size = 28715)
[00:50:49.0219] entering unmount_filesystems
[00:50:49.0219] error unmounting '/mnt2': Invalid argument
[00:50:49.0219] entering clean_NAND
[00:50:49.0219] NAND format complete
[00:50:49.0219] entering ramrod_probe_media
[00:50:49.0219] find_filesystem_partitions: storage=/dev/disk0 system= data=
[00:50:49.0219] entering format_storage_for_LwVM
[00:50:49.0219] entering ramrod_probe_media
[00:50:49.0219] device partitioning scheme is GPT
[00:50:49.0219] unexpected partition 'LwVM' - skipping
[00:50:49.0219] find_filesystem_partitions: storage=/dev/disk0s1 system= data=
[00:50:49.0219] entering create_filesystem_partitions
[00:50:49.0219] User specified system partition size, skipping firmware extras size.
[00:50:49.0219] system partition padding size is: 167772160 bytes
[00:50:49.0219] unable to open : No such file or directory
[00:50:49.0219] creating 2 partitions
[00:50:49.0219] creating encrypted data partition
[00:50:49.0219] entering ramrod_probe_media
[00:50:49.0219] device partitioning scheme is GPT
[00:50:49.0219] find_filesystem_partitions: storage=/dev/disk0s1 system=/dev/disk0s1s1 data=/dev/disk0s1s2
[00:50:49.0219] wipe entire partition: 1 (old = 0 new = 1750)
[00:50:49.0219] block size for /dev/disk0s1s1: 4096
[00:50:49.0219] /sbin/newfs_hfs -s -v System -J /dev/disk0s1s1
[00:50:49.0219] executing /sbin/newfs_hfs -s -v System -J /dev/disk0s1s1
[00:50:49.0219] Initialized /dev/rdisk0s1s1 as a 2 GB case-sensitive HFS Plus volume with a 8192k journal
[00:50:49.0219] block size for /dev/disk0s1s2: 4096
[00:50:49.0219] /sbin/newfs_hfs -s -v Data -J -P /dev/disk0s1s2
[00:50:49.0219] executing /sbin/newfs_hfs -s -v Data -J -P /dev/disk0s1s2
[00:50:49.0219] Initialized /dev/rdisk0s1s2 as a 13 GB case-sensitive HFS Plus volume with a 8192k journal
[00:50:49.0219] entering ramrod_probe_media
[00:50:49.0219] device partitioning scheme is GPT
[00:50:49.0219] find_filesystem_partitions: storage=/dev/disk0s1 system=/dev/disk0s1s1 data=/dev/disk0s1s2
[00:50:49.0219] entering mount_filesystems
[00:50:49.0219] executing /sbin/fsck_hfs
[00:50:49.0219] ** /dev/rdisk0s1s1
[00:50:49.0219] Executing fsck_hfs (version hfs-227).
[00:50:49.0219] ** Checking Journaled HFS Plus volume.
[00:50:49.0219] ** Detected a case-sensitive volume.
[00:50:49.0219] The volume name is System
[00:50:49.0219] ** Checking extents overflow file.
[00:50:49.0219] ** Checking catalog file.
[00:50:49.0219] ** Checking multi-linked files.
[00:50:49.0219] ** Checking catalog hierarchy.
[00:50:49.0219] ** Checking extended attributes file.
[00:50:49.0219] ** Checking volume bitmap.
[00:50:49.0219] ** Checking volume information.
[00:50:49.0219] ** Trimming unused blocks.
[00:50:49.0219] ** The volume System appears to be OK.
[00:50:49.0219] executing /sbin/mount_hfs
[00:50:49.0219] /dev/disk0s1s1 mounted on /mnt1
[00:50:49.0219] executing /sbin/fsck_hfs
[00:50:49.0219] ** /dev/rdisk0s1s2
[00:50:49.0219] Executing fsck_hfs (version hfs-227).
[00:50:49.0219] ** Checking Journaled HFS Plus volume.
[00:50:49.0219] ** Detected a case-sensitive volume.
[00:50:49.0219] The volume name is Data
[00:50:49.0219] ** Checking extents overflow file.
[00:50:49.0219] ** Checking catalog file.
[00:50:49.0219] ** Checking multi-linked files.
[00:50:49.0219] ** Checking catalog hierarchy.
[00:50:49.0219] ** Checking extended attributes file.
[00:50:49.0219] ** Checking volume bitmap.
[00:50:49.0219] ** Checking volume information.
[00:50:49.0219] ** Trimming unused blocks.
[00:50:49.0219] ** The volume Data appears to be OK.
[00:50:49.0219] executing /sbin/mount_hfs
[00:50:49.0219] /dev/disk0s1s2 mounted on /mnt2
[00:50:49.0219] entering resize_system_partition_to_options
[00:50:49.0219] User specified system partition size, skipping firmware extras size.
[00:50:49.0219] Found SystemPartitionPadding value of 167772160 bytes
[00:50:49.0219] Erasing system partition prior to resize operation.
[00:50:49.0219] block size for /dev/disk0s1s1: 4096
[00:50:49.0219] /sbin/newfs_hfs -s -v System -J /dev/disk0s1s1
[00:50:49.0219] executing /sbin/newfs_hfs -s -v System -J /dev/disk0s1s1
[00:50:49.0219] Initialized /dev/rdisk0s1s1 as a 2 GB case-sensitive HFS Plus volume with a 8192k journal
[00:50:49.0219] executing /sbin/fsck_hfs
[00:50:49.0219] ** /dev/rdisk0s1s1
[00:50:49.0219] Executing fsck_hfs (version hfs-227).
[00:50:49.0219] ** Checking Journaled HFS Plus volume.
[00:50:49.0219] ** Detected a case-sensitive volume.
[00:50:49.0219] The volume name is System
[00:50:49.0219] ** Checking extents overflow file.
[00:50:49.0219] ** Checking catalog file.
[00:50:49.0219] ** Checking multi-linked files.
[00:50:49.0219] ** Checking catalog hierarchy.
[00:50:49.0219] ** Checking extended attributes file.
[00:50:49.0219] ** Checking volume bitmap.
[00:50:49.0219] ** Checking volume information.
[00:50:49.0219] ** Trimming unused blocks.
[00:50:49.0219] ** The volume System appears to be OK.
[00:50:49.0219] executing /sbin/mount_hfs
[00:50:49.0219] /dev/disk0s1s1 mounted on /mnt1
[00:50:49.0219] Trying to resize system partition to 1835008000 bytes aka 1750 MB
[00:50:49.0219] entering adjust_partition
[00:50:49.0219] partition: requiredSize=448000
[00:50:49.0219] no change in size
[00:50:49.0219] Successfully resized the system partition
[00:50:49.0219] entering maximize_data_partition
[00:50:49.0219] entering adjust_partition
[00:50:49.0219] partition: requiredSize=<<<<<IMEI>>>>>>6
[00:50:49.0219] maximizing data partition to 14019461119 bytes
[00:50:49.0219] entering adjust_partition
[00:50:49.0219] partition: requiredSize=3422720
[00:50:49.0219] no change in size
[00:50:49.0219] Successfully resized data partition to consume free blocks
[00:50:49.0219] The system partition now has a total HFS+ capacity of 1750 MB
[00:50:49.0219] entering ramrod_probe_media
[00:50:49.0219] device partitioning scheme is GPT
[00:50:49.0219] find_filesystem_partitions: storage=/dev/disk0s1 system=/dev/disk0s1s1 data=/dev/disk0s1s2
[00:50:49.0219] entering unmount_filesystems
[00:50:49.0219] entering ramrod_ticket_update
[00:50:49.0219] looking up root ticket hash
[00:50:49.0219] device tree ticket-hash: <CFData 0x14d69750 [0x303ad0]>{length = 20, capacity = 20, bytes = 0x<<<<<<<<<<<<<<<<<<UDID>>>>>>>>>>>>>>>>>>}
[00:50:49.0219] ticket_hash: <<<<<<<<<<<<<<<<<<UDID>>>>>>>>>>>>>>>>>>
[00:50:49.0219] received valid ticket (2735 bytes)
[00:50:49.0219] entering restore_images
[00:50:49.0219] Successfully marked device node /dev/rdisk0s1s1 as static data
[00:50:49.0219] executing /usr/sbin/asr -source asr://localhost:12345 -target /dev/disk0s1s1 -erase -noprompt --chunkchecksum --puppetstrings
[00:50:49.0219] void AppleUSBDeviceMux::handleConnectResult(struct BulkUSBMuxSession *, errno_t) new session to port 12345 failed: 61
[00:50:49.0219] void AppleUSBDeviceMux::handleConnectResult(struct BulkUSBMuxSession *, errno_t) new session to port 12345 failed: 61
[00:50:49.0219] ASR: asr: Unable to disable idle sleep - -536870199
[00:50:49.0219] ASR STATUS: start 241.1 multicast-client
[00:50:49.0219] ASR: Waiting for connection attempt from server
[00:50:49.0219] AppleUSBDeviceMux::handleConnectResult new session 0x9260bec8 established 12345<-lo0->49168 12345<-usb->1281
[00:50:49.0219] ASR STATUS: setup
[00:50:49.0219] ASR: Validating target...
[00:50:49.0219] ASR: done
[00:50:49.0219] ASR STATUS: metadata
[00:50:49.0219] ASR: Validating source...
[00:50:49.0219] ASR: done
[00:50:49.0219] ASR: Retrieving scan information...
[00:50:49.0219] ASR: done
[00:50:49.0219] ASR: Validating sizes...
[00:50:49.0219] ASR: done
[00:50:49.0219] ASR STATUS: restore
[00:50:49.0219] ASR RESTORE PROGRESS: 2%
[00:50:49.0219] ASR RESTORE PROGRESS: 4%
[00:50:49.0219] ASR RESTORE PROGRESS: 6%
[00:50:49.0219] ASR RESTORE PROGRESS: 8%
[00:50:49.0219] ASR RESTORE PROGRESS: 10%
[00:50:49.0219] ASR RESTORE PROGRESS: 12%
[00:50:49.0219] ASR RESTORE PROGRESS: 14%
[00:50:49.0219] ASR RESTORE PROGRESS: 16%
[00:50:49.0219] ASR RESTORE PROGRESS: 18%
[00:50:49.0219] ASR RESTORE PROGRESS: 20%
[00:50:49.0219] ASR RESTORE PROGRESS: 22%
[00:50:49.0219] ASR RESTORE PROGRESS: 24%
[00:50:49.0219] ASR RESTORE PROGRESS: 26%
[00:50:49.0219] ASR RESTORE PROGRESS: 28%
[00:50:49.0219] ASR RESTORE PROGRESS: 30%
[00:50:49.0219] ASR RESTORE PROGRESS: 32%
[00:50:49.0219] ASR RESTORE PROGRESS: 34%
[00:50:49.0219] ASR RESTORE PROGRESS: 36%
[00:50:49.0219] ASR RESTORE PROGRESS: 38%
[00:50:49.0219] ASR RESTORE PROGRESS: 40%
[00:50:49.0219] ASR RESTORE PROGRESS: 42%
[00:50:49.0219] ASR RESTORE PROGRESS: 44%
[00:50:49.0219] ASR RESTORE PROGRESS: 46%
[00:50:49.0219] ASR RESTORE PROGRESS: 48%
[00:50:49.0219] ASR RESTORE PROGRESS: 50%
[00:50:49.0219] ASR RESTORE PROGRESS: 52%
[00:50:49.0219] ASR RESTORE PROGRESS: 54%
[00:50:49.0219] ASR RESTORE PROGRESS: 56%
[00:50:49.0219] ASR RESTORE PROGRESS: 58%
[00:50:49.0219] ASR RESTORE PROGRESS: 60%
[00:50:49.0219] ASR RESTORE PROGRESS: 62%
[00:50:49.0219] ASR RESTORE PROGRESS: 64%
[00:50:49.0219] ASR RESTORE PROGRESS: 66%
[00:50:49.0219] ASR RESTORE PROGRESS: 68%
[00:50:49.0219] ASR RESTORE PROGRESS: 70%
[00:50:49.0219] ASR RESTORE PROGRESS: 72%
[00:50:49.0219] ASR RESTORE PROGRESS: 74%
[00:50:49.0219] ASR RESTORE PROGRESS: 76%
[00:50:49.0219] ASR RESTORE PROGRESS: 78%
[00:50:49.0219] ASR RESTORE PROGRESS: 80%
[00:50:49.0219] ASR RESTORE PROGRESS: 82%
[00:50:49.0219] ASR RESTORE PROGRESS: 84%
[00:50:49.0219] ASR RESTORE PROGRESS: 86%
[00:50:49.0219] ASR RESTORE PROGRESS: 88%
[00:50:49.0219] ASR RESTORE PROGRESS: 90%
[00:50:49.0219] ASR RESTORE PROGRESS: 92%
[00:50:49.0219] ASR RESTORE PROGRESS: 94%
[00:50:49.0219] ASR RESTORE PROGRESS: 96%
[00:50:49.0219] ASR RESTORE PROGRESS: 98%
[00:50:49.0219] ASR: 2013-10-18 00:30:38.592 asr[21:1503] CFPreferences: user home directory at file:///var/root/ is unavailable. User domains will be volatile.
[00:50:49.0219] AppleUSBDeviceMux::sessionUpcall socket is closed, session 0x9260bec8 (12345<-lo0->49168 12345<-usb->1281)
[00:50:49.0219] ASR RESTORE PROGRESS: 100%
[00:50:49.0219] ASR: Copied 1667277312 bytes in 52.04 seconds, 31288.86 KiB/s
[00:50:49.0219] ASR STATUS: verify
[00:50:49.0219] ASR VERIFY PROGRESS: 2%
[00:50:49.0219] ASR VERIFY PROGRESS: 4%
[00:50:49.0219] ASR VERIFY PROGRESS: 6%
[00:50:49.0219] ASR VERIFY PROGRESS: 8%
[00:50:49.0219] ASR VERIFY PROGRESS: 10%
[00:50:49.0219] ASR VERIFY PROGRESS: 12%
[00:50:49.0219] ASR VERIFY PROGRESS: 14%
[00:50:49.0219] ASR VERIFY PROGRESS: 16%
[00:50:49.0219] ASR VERIFY PROGRESS: 18%
[00:50:49.0219] ASR VERIFY PROGRESS: 20%
[00:50:49.0219] ASR VERIFY PROGRESS: 22%
[00:50:49.0219] ASR VERIFY PROGRESS: 24%
[00:50:49.0219] ASR VERIFY PROGRESS: 26%
[00:50:49.0219] ASR VERIFY PROGRESS: 28%
[00:50:49.0219] ASR VERIFY PROGRESS: 30%
[00:50:49.0219] ASR VERIFY PROGRESS: 32%
[00:50:49.0219] ASR VERIFY PROGRESS: 34%
[00:50:49.0219] ASR VERIFY PROGRESS: 36%
[00:50:49.0219] ASR VERIFY PROGRESS: 38%
[00:50:49.0219] ASR VERIFY PROGRESS: 40%
[00:50:49.0219] ASR VERIFY PROGRESS: 42%
[00:50:49.0219] ASR VERIFY PROGRESS: 44%
[00:50:49.0219] ASR VERIFY PROGRESS: 46%
[00:50:49.0219] ASR VERIFY PROGRESS: 48%
[00:50:49.0219] ASR VERIFY PROGRESS: 50%
[00:50:49.0219] ASR VERIFY PROGRESS: 52%
[00:50:49.0219] ASR VERIFY PROGRESS: 54%
[00:50:49.0219] ASR VERIFY PROGRESS: 56%
[00:50:49.0219] ASR VERIFY PROGRESS: 58%
[00:50:49.0219] ASR VERIFY PROGRESS: 60%
[00:50:49.0219] ASR VERIFY PROGRESS: 62%
[00:50:49.0219] ASR VERIFY PROGRESS: 64%
[00:50:49.0219] ASR VERIFY PROGRESS: 66%
[00:50:49.0219] ASR VERIFY PROGRESS: 68%
[00:50:49.0219] ASR VERIFY PROGRESS: 70%
[00:50:49.0219] ASR VERIFY PROGRESS: 72%
[00:50:49.0219] ASR VERIFY PROGRESS: 74%
[00:50:49.0219] ASR VERIFY PROGRESS: 76%
[00:50:49.0219] ASR VERIFY PROGRESS: 78%
[00:50:49.0219] ASR VERIFY PROGRESS: 80%
[00:50:49.0219] ASR VERIFY PROGRESS: 82%
[00:50:49.0219] ASR VERIFY PROGRESS: 84%
[00:50:49.0219] ASR VERIFY PROGRESS: 86%
[00:50:49.0219] ASR VERIFY PROGRESS: 88%
[00:50:49.0219] ASR VERIFY PROGRESS: 90%
[00:50:49.0219] ASR VERIFY PROGRESS: 92%
[00:50:49.0219] ASR VERIFY PROGRESS: 94%
[00:50:49.0219] ASR VERIFY PROGRESS: 96%
[00:50:49.0219] ASR VERIFY PROGRESS: 98%
[00:50:49.0219] ASR VERIFY PROGRESS: 100%
[00:50:49.0219] ASR: Verified SHA-1 checksum 1667277312 bytes in 8.87 seconds, 183541.87 KiB/s
[00:50:49.0219] ASR STATUS: finish
[00:50:49.0219] entering ramrod_probe_media
[00:50:49.0219] device partitioning scheme is GPT
[00:50:49.0219] find_filesystem_partitions: storage=/dev/disk0s1 system=/dev/disk0s1s1 data=/dev/disk0s1s2
[00:50:49.0219] entering mount_filesystems
[00:50:49.0219] executing /sbin/fsck_hfs
[00:50:49.0219] ** /dev/rdisk0s1s1
[00:50:49.0219] Executing fsck_hfs (version hfs-227).
[00:50:49.0219] ** Checking Journaled HFS Plus volume.
[00:50:49.0219] ** Detected a case-sensitive volume.
[00:50:49.0219] The volume name is Innsbruck11A501.N42OS
[00:50:49.0219] ** Checking extents overflow file.
[00:50:49.0219] ** Checking catalog file.
[00:50:49.0219] ** Checking multi-linked files.
[00:50:49.0219] ** Checking catalog hierarchy.
[00:50:49.0219] ** Checking extended attributes file.
[00:50:49.0219] ** Checking volume bitmap.
[00:50:49.0219] ** Checking volume information.
[00:50:49.0219] ** Trimming unused blocks.
[00:50:49.0219] ** The volume Innsbruck11A501.N42OS appears to be OK.
[00:50:49.0219] executing /sbin/mount_hfs
[00:50:49.0219] /dev/disk0s1s1 mounted on /mnt1
[00:50:49.0219] executing /sbin/fsck_hfs
[00:50:49.0219] ** /dev/rdisk0s1s2
[00:50:49.0219] Executing fsck_hfs (version hfs-227).
[00:50:49.0219] ** Checking Journaled HFS Plus volume.
[00:50:49.0219] ** Detected a case-sensitive volume.
[00:50:49.0219] The volume name is Data
[00:50:49.0219] ** Checking extents overflow file.
[00:50:49.0219] ** Checking catalog file.
[00:50:49.0219] ** Checking multi-linked files.
[00:50:49.0219] ** Checking catalog hierarchy.
[00:50:49.0219] ** Checking extended attributes file.
[00:50:49.0219] ** Checking volume bitmap.
[00:50:49.0219] ** Checking volume information.
[00:50:49.0219] ** Trimming unused blocks.
[00:50:49.0219] ** The volume Data appears to be OK.
[00:50:49.0219] executing /sbin/mount_hfs
[00:50:49.0219] /dev/disk0s1s2 mounted on /mnt2
[00:50:49.0219] entering install_kernel_cache
[00:50:49.0219] writing kernelcache to /mnt1/System/Library/Caches/com.apple.kernelcaches/kernelcache
[00:50:49.0219] entering install_secure_vault_daemon
[00:50:49.0219] entering get_hardware_platform
[00:50:49.0219] platform-name = s5l8950x
[00:50:49.0219] linking /mnt1/usr/sbin/securekeyvaultd to /mnt1/usr/sbin/securekeyvaultd.s5l8950x
[00:50:49.0219] no securekeyvaultd for s5l8950x
[00:50:49.0219] entering ramrod_ticket_write
[00:50:49.0219] writing ticket to /mnt1/System/Library/Caches/apticket.der
[00:50:49.0219] entering update_device_firmware
[00:50:49.0219] create_baseband_update_options: Got imeisv: 5
[00:50:49.0219] baseband updater options = <CFBasicHash 0x14d6c470 [0x303ad0]>{type = mutable dict, count = 3,
[00:50:49.0219] entries =>
[00:50:49.0219] 0 : <CFString 0xfa238 [0x303ad0]>{contents = "IMEISwVersion"} = <CFNumber 0x14d6bd90 [0x303ad0]>{value = +5, type = kCFNumberSInt32Type}
[00:50:49.0219] 1 : <CFString 0xfa298 [0x303ad0]>{contents = "autoSetupEnv"} = <CFBoolean 0x303e88 [0x303ad0]>{value = false}
[00:50:49.0219] 2 : <CFString 0xfa2a8 [0x303ad0]>{contents = "disablePing"} = <CFBoolean 0x303e80 [0x303ad0]>{value = true}
[00:50:49.0219] }
[00:50:49.0219]
[00:50:49.0219] _baseband_update_requires_system_filesystem_once: querying baseband to determine if it requires system filesystem
[00:50:49.0219] _baseband_update_requires_system_filesystem_once: query returned <CFBasicHash 0x14d6c340 [0x303ad0]>{type = mutable dict, count = 3,
[00:50:49.0219] entries =>
[00:50:49.0219] 0 : <CFString 0xfa008 [0x303ad0]>{contents = "requireSystemPartitionMount"} = <CFBoolean 0x303e80 [0x303ad0]>{value = true}
[00:50:49.0219] 1 : <CFString 0xfa028 [0x303ad0]>{contents = "requireUserPartitionMount"} = <CFBoolean 0x303e88 [0x303ad0]>{value = false}
[00:50:49.0219] 2 : <CFString 0xfa038 [0x303ad0]>{contents = "requireBasebandFSPartitionMount"} = <CFBoolean 0x303e88 [0x303ad0]>{value = false}
[00:50:49.0219] }
[00:50:49.0219]
[00:50:49.0219] entering update_iBoot
[00:50:49.0219] found 'AppleImage3NORAccess' object in IORegistry
[00:50:49.0219] entering update_iBoot_image3_NOR_access
[00:50:49.0219] write_image3_data: flashing illb data (length = 0x24a1a)
[00:50:49.0219] write_image3_data: flashing SCAB data (length = 0xaf0)
[00:50:49.0219] ticket updated
[00:50:49.0219] write_image3_data: flashing ibot data (length = 0x4518c)
[00:50:49.0219] write_image3_data: flashing chg1 data (length = 0x88cc)
[00:50:49.0219] write_image3_data: flashing bat0 data (length = 0xaa4c)
[00:50:49.0219] write_image3_data: flashing batF data (length = 0x1484c)
[00:50:49.0219] write_image3_data: flashing logo data (length = 0x1a8c)
[00:50:49.0219] write_image3_data: flashing recm data (length = 0xdd8c)
[00:50:49.0219] write_image3_data: flashing dtre data (length = 0x1538c)
[00:50:49.0219] write_image3_data: flashing chg0 data (length = 0x260c)
[00:50:49.0219] write_image3_data: flashing bat1 data (length = 0x80c)
[00:50:49.0219] write_image3_data: flashing glyP data (length = 0xf8c)
[00:50:49.0219] AppleImage3NORAccess::_getSuperBlock imageVersion: 3
[00:50:49.0219] AppleImage3NORAccess::_getSuperBlock imageVersion: 3
[00:50:49.0219] [nand_part_core:INF@2289] first 2 pages of boot blocks written with copies of partition table
[00:50:49.0219] entering update_gas_gauge
[00:50:49.0219] entering update_ir_mcu
[00:50:49.0219] looking for mcu nub...no entry from path!
[00:50:49.0219] TiSerialFlasher not supported on this platform. Exiting.
[00:50:49.0219] entering update_baseband
[00:50:49.0219] update_baseband: registering for progress notifications
[00:50:49.0219] create_baseband_update_options: Got imeisv: 5
[00:50:49.0219] baseband updater options = <CFBasicHash 0x14e62500 [0x303ad0]>{type = mutable dict, count = 6,
[00:50:49.0219] entries =>
[00:50:49.0219] 0 : <CFString 0xfa1e8 [0x303ad0]>{contents = "SystemRoot"} = <CFString 0x14d6b680 [0x303ad0]>{contents = "/mnt1"}
[00:50:49.0219] 1 : <CFString 0xfa238 [0x303ad0]>{contents = "IMEISwVersion"} = <CFNumber 0x14d6bd90 [0x303ad0]>{value = +5, type = kCFNumberSInt32Type}
[00:50:49.0219] 2 : <CFString 0xfa298 [0x303ad0]>{contents = "autoSetupEnv"} = <CFBoolean 0x303e88 [0x303ad0]>{value = false}
[00:50:49.0219] 3 : <CFString 0xfa178 [0x303ad0]>{contents = "forceUpdate"} = <CFBoolean 0x303e80 [0x303ad0]>{value = true}
[00:50:49.0219] 5 : <CFString 0xfa2a8 [0x303ad0]>{contents = "disablePing"} = <CFBoolean 0x303e80 [0x303ad0]>{value = true}
[00:50:49.0219] 6 : <CFString 0xfa198 [0x303ad0]>{contents = "DisallowFusiing"} = <CFBoolean 0x303e80 [0x303ad0]>{value = true}
[00:50:49.0219] }
[00:50:49.0219]
[00:50:49.0219] update_baseband: querying baseband info
[00:50:49.0219] bbupdater: BEGIN: Querying info at stage first
[00:50:49.0219] bbupdater: BEGIN: Preparing first stage
[00:50:49.0219] bbupdater: Requested boot mode: kBBUBootModeNone
[00:50:49.0219] bbupdater: Creating transport, attempts remaining 5...bbupdater: FAILED(kBBUReturnIOError)
[00:50:49.0219] bbupdater: Creating transport, attempts remaining 4...bbupdater: FAILED(kBBUReturnIOError)
[00:50:49.0219] [nand_part_core:INF@3169] next 98 pages of boot blocks written with LLB image of size 150080 bytes
[00:50:49.0219] [nand_part_core:INF@3172] final 156 pages of boot blocks written with random data in full page format
[00:50:49.0219] bbupdater: Creating transport, attempts remaining 3...bbupdater: FAILED(kBBUReturnIOError)
[00:50:49.0219] bbupdater: Creating transport, attempts remaining 2...bbupdater: FAILED(kBBUReturnIOError)
[00:50:49.0219] bbupdater: Creating transport, attempts remaining 1...bbupdater: FAILED(kBBUReturnIOError)
[00:50:49.0219] bbupdater: Creating transport, attempts remaining 0...bbupdater: FAILED(kBBUReturnIOError)
[00:50:49.0219] bbupdater: END(kBBUReturnIOError): Preparing first stage
[00:50:49.0219] bbupdater: END(kBBUReturnIOError): Querying info at stage first
[00:50:49.0219] send_bbupdate_status: sending baseband update status to host
[00:50:49.0219] update_baseband: bbupdater error: The operation couldn\U2019t be completed. (BBUpdater error 3 - Failed creating a communication transport to baseband.)
[00:50:49.0219] 0: RamrodErrorDomain/3ec: update_baseband: failed querying baseband info
[00:50:49.0219] 1: BBUpdater/3: Failed creating a communication transport to baseband.
[00:50:49.0219] unable to convert ramrod error 1004
[00:50:49.0219] restore failed with CFError:
[00:50:49.0219] 0: AMRestoreErrorDomain/ffffffff: failed to update device firmware
[00:50:49.0219] 1: AMRestoreErrorDomain/ffffffff: ramrod firmware update failed
[00:50:49.0219] 2: RamrodErrorDomain/3ec: update_baseband: failed querying baseband info
[00:50:49.0219] 3: BBUpdater/3: Failed creating a communication transport to baseband.
[00:50:49.0219] waiting for host to acknowledge final status received...
[00:50:49.0219] void AppleUSBDeviceMux::handleMuxTCPInput(mbuf_t) received reset, closing 0x8df5c2c0
[00:50:49.0219] recv(13, 4) failed: connection closed
[00:50:49.0219] unable to read message size: -1
[00:50:49.0219] received NULL message from host, expected final status
[00:50:49.0219] attempting to dump restore log
[00:50:49.0219] writing log file: /mnt1/restore.log
[00:50:49.0219]
[00:50:49.0219] ==== end of previous restore log ====
[00:50:49.0282] <Restore Device 0E0A81B0>: operation 29 progress -1
[00:50:49.0282] <Restore Device 0E0A81B0>: operation 29 progress -1
[00:50:49.0578] <Restore Device 0E0A81B0>: operation 11 progress -1
[00:50:52.0698] <Restore Device 0E0A81B0>: operation 12 progress -1
[00:50:53.0494] <Restore Device 0E0A81B0>: operation 12 progress -1
[00:50:54.0789] <Restore Device 0E0A81B0>: operation 16 progress -1
[00:50:55.0195] <Restore Device 0E0A81B0>: operation 16 progress -1
[00:50:56.0069] <Restore Device 0E0A81B0>: operation 51 progress -1
[00:50:57.0301] <Restore Device 0E0A81B0>: operation 29 progress -1
[00:50:57.0301] <Restore Device 0E0A81B0>: operation 29 progress -1
[00:50:57.0332] <Restore Device 0E0A81B0>: operation 13 progress 0
[00:51:07.0363] <Restore Device 0E0A81B0>: operation 13 progress 1
[00:51:07.0363] ASR progress: Initialized communication with client
[00:51:08.0970] <Restore Device 0E0A81B0>: operation 13 progress 5
[00:51:08.0970] ASR progress: Starting to send payload
[00:51:09.0594] <Restore Device 0E0A81B0>: operation 13 progress 6
[00:51:09.0594] ASR progress: Sending payload
[00:51:10.0140] <Restore Device 0E0A81B0>: operation 13 progress 7
[00:51:10.0140] ASR progress: Sending payload
[00:51:10.0623] <Restore Device 0E0A81B0>: operation 13 progress 8
[00:51:10.0623] ASR progress: Sending payload
[00:51:11.0091] <Restore Device 0E0A81B0>: operation 13 progress 9
[00:51:11.0091] ASR progress: Sending payload
[00:51:11.0762] <Restore Device 0E0A81B0>: operation 13 progress 10
[00:51:11.0762] ASR progress: Sending payload
[00:51:12.0277] <Restore Device 0E0A81B0>: operation 13 progress 11
[00:51:12.0277] ASR progress: Sending payload
[00:51:12.0792] <Restore Device 0E0A81B0>: operation 13 progress 12
[00:51:12.0792] ASR progress: Sending payload
[00:51:13.0275] <Restore Device 0E0A81B0>: operation 13 progress 13
[00:51:13.0275] ASR progress: Sending payload
[00:51:13.0759] <Restore Device 0E0A81B0>: operation 13 progress 14
[00:51:13.0759] ASR progress: Sending payload
[00:51:14.0243] <Restore Device 0E0A81B0>: operation 13 progress 15
[00:51:14.0243] ASR progress: Sending payload
[00:51:14.0726] <Restore Device 0E0A81B0>: operation 13 progress 16
[00:51:14.0726] ASR progress: Sending payload
[00:51:15.0225] <Restore Device 0E0A81B0>: operation 13 progress 17
[00:51:15.0225] ASR progress: Sending payload
[00:51:15.0709] <Restore Device 0E0A81B0>: operation 13 progress 18
[00:51:15.0709] ASR progress: Sending payload
[00:51:16.0473] <Restore Device 0E0A81B0>: operation 13 progress 19
[00:51:16.0473] ASR progress: Sending payload
[00:51:16.0957] <Restore Device 0E0A81B0>: operation 13 progress 20
[00:51:16.0957] ASR progress: Sending payload
[00:51:17.0441] <Restore Device 0E0A81B0>: operation 13 progress 21
[00:51:17.0441] ASR progress: Sending payload
[00:51:17.0924] <Restore Device 0E0A81B0>: operation 13 progress 22
[00:51:17.0924] ASR progress: Sending payload
[00:51:18.0408] <Restore Device 0E0A81B0>: operation 13 progress 23
[00:51:18.0408] ASR progress: Sending payload
[00:51:18.0876] <Restore Device 0E0A81B0>: operation 13 progress 24
[00:51:18.0891] ASR progress: Sending payload
[00:51:19.0359] <Restore Device 0E0A81B0>: operation 13 progress 25
[00:51:19.0359] ASR progress: Sending payload
[00:51:19.0843] <Restore Device 0E0A81B0>: operation 13 progress 26
[00:51:19.0843] ASR progress: Sending payload
[00:51:20.0327] <Restore Device 0E0A81B0>: operation 13 progress 27
[00:51:20.0327] ASR progress: Sending payload
[00:51:20.0810] <Restore Device 0E0A81B0>: operation 13 progress 28
[00:51:20.0810] ASR progress: Sending payload
[00:51:21.0294] <Restore Device 0E0A81B0>: operation 13 progress 29
[00:51:21.0294] ASR progress: Sending payload
[00:51:21.0777] <Restore Device 0E0A81B0>: operation 13 progress 30
[00:51:21.0777] ASR progress: Sending payload
[00:51:22.0261] <Restore Device 0E0A81B0>: operation 13 progress 31
[00:51:22.0277] ASR progress: Sending payload
[00:51:22.0760] <Restore Device 0E0A81B0>: operation 13 progress 32
[00:51:22.0760] ASR progress: Sending payload
[00:51:23.0244] <Restore Device 0E0A81B0>: operation 13 progress 33
[00:51:23.0244] ASR progress: Sending payload
[00:51:23.0727] <Restore Device 0E0A81B0>: operation 13 progress 34
[00:51:23.0727] ASR progress: Sending payload
[00:51:24.0211] <Restore Device 0E0A81B0>: operation 13 progress 35
[00:51:24.0211] ASR progress: Sending payload
[00:51:24.0726] <Restore Device 0E0A81B0>: operation 13 progress 36
[00:51:24.0726] ASR progress: Sending payload
[00:51:25.0241] <Restore Device 0E0A81B0>: operation 13 progress 37
[00:51:25.0241] ASR progress: Sending payload
[00:51:25.0849] <Restore Device 0E0A81B0>: operation 13 progress 38
[00:51:25.0849] ASR progress: Sending payload
[00:51:26.0457] <Restore Device 0E0A81B0>: operation 13 progress 39
[00:51:26.0457] ASR progress: Sending payload
[00:51:27.0050] <Restore Device 0E0A81B0>: operation 13 progress 40
[00:51:27.0050] ASR progress: Sending payload
[00:51:27.0659] <Restore Device 0E0A81B0>: operation 13 progress 41
[00:51:27.0659] ASR progress: Sending payload
[00:51:28.0267] <Restore Device 0E0A81B0>: operation 13 progress 42
[00:51:28.0267] ASR progress: Sending payload
[00:51:28.0797] <Restore Device 0E0A81B0>: operation 13 progress 43
[00:51:28.0797] ASR progress: Sending payload
[00:51:29.0281] <Restore Device 0E0A81B0>: operation 13 progress 44
[00:51:29.0281] ASR progress: Sending payload
[00:51:29.0765] <Restore Device 0E0A81B0>: operation 13 progress 45
[00:51:29.0765] ASR progress: Sending payload
[00:51:30.0248] <Restore Device 0E0A81B0>: operation 13 progress 46
[00:51:30.0248] ASR progress: Sending payload
[00:51:30.0732] <Restore Device 0E0A81B0>: operation 13 progress 47
[00:51:30.0732] ASR progress: Sending payload
[00:51:31.0278] <Restore Device 0E0A81B0>: operation 13 progress 48
[00:51:31.0278] ASR progress: Sending payload
[00:51:31.0761] <Restore Device 0E0A81B0>: operation 13 progress 49
[00:51:31.0761] ASR progress: Sending payload
[00:51:32.0261] <Restore Device 0E0A81B0>: operation 13 progress 50
[00:51:32.0261] ASR progress: Sending payload
[00:51:32.0807] <Restore Device 0E0A81B0>: operation 13 progress 51
[00:51:32.0807] ASR progress: Sending payload
[00:51:33.0290] <Restore Device 0E0A81B0>: operation 13 progress 52
[00:51:33.0290] ASR progress: Sending payload
[00:51:33.0758] <Restore Device 0E0A81B0>: operation 13 progress 53
[00:51:33.0774] ASR progress: Sending payload
[00:51:34.0242] <Restore Device 0E0A81B0>: operation 13 progress 54
[00:51:34.0257] ASR progress: Sending payload
[00:51:34.0725] <Restore Device 0E0A81B0>: operation 13 progress 55
[00:51:34.0741] ASR progress: Sending payload
[00:51:35.0225] <Restore Device 0E0A81B0>: operation 13 progress 56
[00:51:35.0225] ASR progress: Sending payload
[00:51:35.0708] <Restore Device 0E0A81B0>: operation 13 progress