search

tihmstar / futurerestore

A hacked up idevicerestore wrapper, which allows specifying SEP and Baseband for restoring
GNU Lesser General Public License v3.0
864 stars 272 forks source link

Status: Disk Failure (iPhone 6) #55

Open adrianmkofficial opened 7 years ago

adrianmkofficial commented 7 years ago

Device: iPhone 6 Method: Upgrading from iOS 9.3.3. (jbme.qwertyoruiop.com, Nonce-Enabled) to iOS 10.2

Needless to mention the iPhone is uselessly stuck in a bootloop now and needs a full restore to iOS 10.2.1 to function, since the Restore failed quite deep into the process. (Couldn't get it back with iRecovery)

SHSH2 was definitely valid and previously checked with https://tsssaver.1conan.com

Runned FutureRestore as follows:

./futurerestore_macos -t -iOS 10.2 4883352865870522_iPhone7,2_10.2-14C92.shsh2 -b Mav10-5.32.00.Release.bbfw -p BuildManifest.plist -s sep-firmware.n61.RELEASE.im4p -m BuildManifest.plist iPhone_4.7_10.2_14C92_Restore.ipsw

Status: Disk Failure
Log is available:
SYSLOG: Feb 12 23:23:01 localhost bootlog[0] <Notice>: BOOT_TIME 1486941781 559417
[23:23:02.0280-GMT]{5>7} CHECKPOINT NOTICE: Image4 device: AP nonce clearable
entering ramrod_clear_ap_nonce
[23:23:02.0294-GMT]{5>7} CHECKPOINT NOTICE: AP nonce consumed
No IOFlashController instance found
[23:23:02.0295-GMT]{5>7} CHECKPOINT NOTICE: Pre-existing NVRAM variable: auto-boot=false
[23:23:02.0296-GMT]{5>7} CHECKPOINT NOTICE: Pre-existing NVRAM variable: restore-outcome=initial_monitor_no_return
[23:23:02.0297-GMT]{5>7} CHECKPOINT ANOMALY: [check_collection]restore-step-monitor(does_not_exist)
[23:23:02.0297-GMT]{5>7} CHECKPOINT PROGRESS: START (unknown) -> (initial_engine_no_return)
[23:23:02.0297-GMT]{5>7} CHECKPOINT NOTICE: NVRAM access available on initial check
restore-anomalies = {0x00000000:[check_collection]restore-step-monitor(does_not_exist)}
restore-outcome = initial_engine_no_return
executing /usr/sbin/nvram restore-outcome=initial_engine_no_return
[23:23:02.0338-GMT]{5>7} CHECKPOINT BEGIN: MAIN:[0x0400] umask
restore-step-ids = {0x11030400:1}
restore-step-names = {0x11030400:umask}
restore-step-uptime = 1
restore-step-user-progress = -1
[23:23:02.0340-GMT]{5>7} CHECKPOINT END: MAIN:[0x0400] umask
restore-step-ids = {}
restore-step-names = {}
restore-step-uptime = 1
restore-step-user-progress = -1
[23:23:02.0341-GMT]{5>7} CHECKPOINT BEGIN: MAIN:[0x0402] setvbuf
restore-step-ids = {0x11030402:2}
restore-step-names = {0x11030402:setvbuf}
restore-step-uptime = 1
restore-step-user-progress = -1
[23:23:02.0343-GMT]{5>7} CHECKPOINT END: MAIN:[0x0402] setvbuf
restore-step-ids = {}
restore-step-names = {}
restore-step-uptime = 1
restore-step-user-progress = -1
[23:23:02.0344-GMT]{5>7} CHECKPOINT BEGIN: MAIN:[0x0403] kernel_logger_thread
restore-step-ids = {0x11030403:3}
restore-step-names = {0x11030403:kernel_logger_thread}
restore-step-uptime = 1
restore-step-user-progress = -1
[23:23:02.0346-GMT]{5>7} CHECKPOINT END: MAIN:[0x0403] kernel_logger_thread
unable to open /dev/klog: No such file or directory
restore-step-ids = {}
restore-step-names = {}
restore-step-uptime = 1
restore-step-user-progress = -1
[23:23:02.0348-GMT]{5>7} CHECKPOINT BEGIN: MAIN:[0x0406] set_progress_0
restore-step-ids = {0x11030406:4}
restore-step-names = {0x11030406:set_progress_0}
restore-step-uptime = 1
restore-step-user-progress = -1
inverting UI colordisplay-scale = 2
display-rotation = 0
found applelogo at /usr/share/progressui/applelogo@2x.tga
found display: primary
display: 750 x 1334
powering on display
ramrod_display_set_granular_progress: 0.000000
[23:23:02.0385-GMT]{5>7} CHECKPOINT END: MAIN:[0x0406] set_progress_0
restore-step-ids = {}
restore-step-names = {}
restore-step-uptime = 1
restore-step-user-progress = 0
[23:23:02.0387-GMT]{5>7} CHECKPOINT BEGIN: MAIN:[0x0407] start_gasgauge_thread
restore-step-ids = {0x11030407:5}
restore-step-names = {0x11030407:start_gasgauge_thread}
restore-step-uptime = 1
restore-step-user-progress = 0
[23:23:02.0390-GMT]{5>7} CHECKPOINT END: MAIN:[0x0407] start_gasgauge_thread
restore-step-ids = {}
restore-step-names = {}
restore-step-uptime = 1
restore-step-user-progress = 0
[23:23:02.0392-GMT]{5>7} CHECKPOINT BEGIN: MAIN:[0x0408] listen_for_log_client
restore-step-ids = {0x11030408:6}
restore-step-names = {0x11030408:listen_for_log_client}
restore-step-uptime = 1
restore-step-user-progress = 0
[23:23:02.0394-GMT]{5>7} CHECKPOINT END: MAIN:[0x0408] listen_for_log_client
restore-step-ids = {}
restore-step-names = {}
restore-step-uptime = 1
restore-step-user-progress = 0
[23:23:02.0396-GMT]{5>7} CHECKPOINT BEGIN: MAIN:[0x040D] create_listen_socket
restore-step-ids = {0x1103040D:7}
restore-step-names = {0x1103040D:create_listen_socket}
restore-step-uptime = 1
restore-step-user-progress = 0
[23:23:02.0398-GMT]{5>7} CHECKPOINT END: MAIN:[0x040D] create_listen_socket
restore-step-ids = {}
restore-step-names = {}
restore-step-uptime = 1
restore-step-user-progress = 0
[23:23:02.0400-GMT]{5>7} CHECKPOINT BEGIN: MAIN:[0x0404] update_root_mount
restore-step-ids = {0x11030404:8}
restore-step-names = {0x11030404:update_root_mount}
restore-step-uptime = 1
restore-step-user-progress = 0
[23:23:02.0403-GMT]{5>7} CHECKPOINT END: MAIN:[0x0404] update_root_mount
restore-step-ids = {}
restore-step-names = {}
restore-step-uptime = 1
restore-step-user-progress = 0
[23:23:02.0405-GMT]{5>7} CHECKPOINT BEGIN: MAIN:[0x0405] disable_watchdog
restore-step-ids = {0x11030405:9}
restore-step-names = {0x11030405:disable_watchdog}
restore-step-uptime = 1
restore-step-user-progress = 0
[23:23:02.0409-GMT]{5>7} CHECKPOINT END: MAIN:[0x0405] disable_watchdog
restore-step-ids = {}
restore-step-names = {}
restore-step-uptime = 1
restore-step-user-progress = 0
[23:23:02.0411-GMT]{5>7} CHECKPOINT BEGIN: MAIN:[0x040E] enable_usb
restore-step-ids = {0x1103040E:10}
restore-step-names = {0x1103040E:enable_usb}
restore-step-uptime = 1
restore-step-user-progress = 0
waiting for matching IOKit service: <CFBasicHash 0x125e0e360 [0x100e9acd8]>{type = mutable dict, count = 1,
entries =>
    0 : <CFString 0x10113f640 [0x100e9acd8]>{contents = "IOProviderClass"} = <CFString 0x125e056c0 [0x100e9acd8]>{contents = "AppleUSBDeviceMux"}
}

[23:23:05.0426-GMT]{5>7} CHECKPOINT END: MAIN:[0x040E] enable_usb
restore-step-ids = {}
restore-step-names = {}
restore-step-uptime = 4
restore-step-user-progress = 0
waiting for host to trigger start of restore [timeout of 120 seconds]
recv(8, 4) failed: connection closed
unable to read message size: -1
could not receive message
recv(9, 4) failed: connection closed
recv(10, 4) failed: connection closed
unable to read message size: -1
unable to read message size: -1
could not receive message
could not receive message
[23:23:05.0729-GMT]{5>7} CHECKPOINT BEGIN: RESTORED:[0x0600] client_protocol_version
restore-step-ids = {0x11030600:11}
restore-step-names = {0x11030600:client_protocol_version}
restore-step-uptime = 4
restore-step-user-progress = 0
client protocol version 14
[23:23:05.0737-GMT]{5>7} CHECKPOINT END: RESTORED:[0x0600] client_protocol_version
restore-step-ids = {}
restore-step-names = {}
restore-step-uptime = 4
restore-step-user-progress = 0
[23:23:05.0744-GMT]{5>7} CHECKPOINT BEGIN: RESTORED:[0x0601] copy_restore_options
restore-step-ids = {0x11030601:12}
restore-step-names = {0x11030601:copy_restore_options}
restore-step-uptime = 4
restore-step-user-progress = 0
*** UUID EC116DF1-721A-D78F-8521-D5BDC835C3BD ***
Restore options:
    CreateFilesystemPartitions     => <CFBoolean 0x100e9b230 [0x100e9acd8]>{value = true}
    MinimumSystemPartition         => <CFNumber 0xb00000000000d2d3 [0x100e9acd8]>{value = +3373, type = kCFNumberSInt64Type}
    UUID                           => <CFString 0x125d0deb0 [0x100e9acd8]>{contents = "EC116DF1-721A-D78F-8521-D5BDC835C3BD"}
    SystemPartitionSize            => <CFNumber 0xb00000000000d2d3 [0x100e9acd8]>{value = +3373, type = kCFNumberSInt64Type}
    SystemPartitionPadding         => <CFBasicHash 0x125e07b30 [0x100e9acd8]>{type = mutable dict, count = 9,
entries =>
    0 : 512 = <CFNumber 0xb000000000005003 [0x100e9acd8]>{value = +1280, type = kCFNumberSInt64Type}
    2 : 128 = <CFNumber 0xb000000000005003 [0x100e9acd8]>{value = +1280, type = kCFNumberSInt64Type}
    3 : 16 = <CFNumber 0xb000000000000a03 [0x100e9acd8]>{value = +160, type = kCFNumberSInt64Type}
    4 : 1024 = <CFNumber 0xb000000000005003 [0x100e9acd8]>{value = +1280, type = kCFNumberSInt64Type}
    5 : 32 = <CFNumber 0xb000000000001403 [0x100e9acd8]>{value = +320, type = kCFNumberSInt64Type}
    6 : 768 = <CFNumber 0xb000000000005003 [0x100e9acd8]>{value = +1280, type = kCFNumberSInt64Type}
    7 : 8 = <CFNumber 0xb000000000000503 [0x100e9acd8]>{value = +80, type = kCFNumberSInt64Type}
    8 : 64 = <CFNumber 0xb000000000002803 [0x100e9acd8]>{value = +640, type = kCFNumberSInt64Type}
    10 : 256 = <CFNumber 0xb000000000005003 [0x100e9acd8]>{value = +1280, type = kCFNumberSInt64Type}
}

    PersonalizedDuringPreflight    => <CFBoolean 0x100e9b230 [0x100e9acd8]>{value = true}
[23:23:05.0757-GMT]{5>7} CHECKPOINT END: RESTORED:[0x0601] copy_restore_options
restore-step-ids = {}
restore-step-names = {}
restore-step-uptime = 4
restore-step-user-progress = 0
[23:23:05.0762-GMT]{5>7} CHECKPOINT BEGIN: RESTORED:[0x0655] is_host_compatible
restore-step-ids = {0x11030655:13}
restore-step-names = {0x11030655:is_host_compatible}
restore-step-uptime = 4
restore-step-user-progress = 0
[23:23:05.0767-GMT]{5>7} CHECKPOINT END: RESTORED:[0x0655] is_host_compatible
restore-step-ids = {}
restore-step-names = {}
restore-step-uptime = 4
restore-step-user-progress = 0
[23:23:05.0772-GMT]{5>7} CHECKPOINT BEGIN: RESTORED:[0x0604] set_weight_from_options
restore-step-ids = {0x11030604:14}
restore-step-names = {0x11030604:set_weight_from_options}
restore-step-uptime = 4
restore-step-user-progress = 0
[23:23:05.0777-GMT]{5>7} CHECKPOINT END: RESTORED:[0x0604] set_weight_from_options
restore-step-ids = {}
restore-step-names = {}
restore-step-uptime = 4
restore-step-user-progress = 0
[23:23:05.0782-GMT]{5>7} CHECKPOINT BEGIN: RESTORED:[0x0608] device_has_hoover
restore-step-ids = {0x11030608:15}
restore-step-names = {0x11030608:device_has_hoover}
restore-step-uptime = 4
restore-step-user-progress = 0
[23:23:05.0788-GMT]{5>7} CHECKPOINT END: RESTORED:[0x0608] device_has_hoover
restore-step-ids = {}
restore-step-names = {}
restore-step-uptime = 4
restore-step-user-progress = 0
[23:23:05.0793-GMT]{5>7} CHECKPOINT BEGIN: RESTORED:[0x0609] load_sep_os
restore-step-ids = {0x11030609:16}
restore-step-names = {0x11030609:load_sep_os}
restore-step-uptime = 4
restore-step-user-progress = 0
entering load_sep_os
device has sep - getting firmware
entering copy_restore_sep
got sep firmware - making call to load it
entering ramrod_load_sep_os
entering ramrod_execute_command_with_input_data: /usr/libexec/seputil (0x1055b0000 - 4986470)
executing /usr/libexec/seputil --restore+art -
waiting for child to exit
child exited
exit status: 0
[23:23:08.0355-GMT]{5>7} CHECKPOINT END: RESTORED:[0x0609] load_sep_os
restore-step-ids = {}
restore-step-names = {}
restore-step-uptime = 7
restore-step-user-progress = 0
[23:23:08.0357-GMT]{5>7} CHECKPOINT BEGIN: RESTORED:[0x060B] update_ticket
restore-step-ids = {0x1103060B:17}
restore-step-names = {0x1103060B:update_ticket}
restore-step-uptime = 7
restore-step-user-progress = 0
entering ramrod_ticket_update
looking up boot manifest hash
crypto-hash-method found. Using SHA1
device tree ticket_hash: 39D24DE58AA507535B0E81A43355C2E01D2D4568
computed ticket_hash   : 39D24DE58AA507535B0E81A43355C2E01D2D4568
received valid ticket (5096 bytes)
[23:23:08.0363-GMT]{5>7} CHECKPOINT END: RESTORED:[0x060B] update_ticket
restore-step-ids = {}
restore-step-names = {}
restore-step-uptime = 7
restore-step-user-progress = 0
[23:23:08.0365-GMT]{5>7} CHECKPOINT BEGIN: RESTORED:[0x060C] partition_nand
restore-step-ids = {0x1103060C:18}
restore-step-names = {0x1103060C:partition_nand}
restore-step-uptime = 7
restore-step-user-progress = 0
entering partition_nand_device
[23:23:08.0367-GMT]{5>7} CHECKPOINT END: RESTORED:[0x060C] partition_nand
restore-step-ids = {}
restore-step-names = {}
restore-step-uptime = 7
restore-step-user-progress = 0
[23:23:08.0368-GMT]{5>7} CHECKPOINT BEGIN: RESTORED:[0x060D] wait_for_storage
restore-step-ids = {0x1103060D:19}
restore-step-names = {0x1103060D:wait_for_storage}
restore-step-uptime = 7
restore-step-user-progress = 0
entering wait_for_storage_device
ramrod_display_set_granular_progress: 0.000000
Searching for NAND service
Found NAND service: ASPStorage
NAND initialized. Waiting for devnode.
[23:23:08.0373-GMT]{5>7} CHECKPOINT END: RESTORED:[0x060D] wait_for_storage
restore-step-ids = {}
restore-step-names = {}
restore-step-uptime = 7
restore-step-user-progress = 0
[23:23:08.0375-GMT]{5>7} CHECKPOINT BEGIN: RESTORED:[0x060E] update_s3e_firmware
restore-step-ids = {0x1103060E:20}
restore-step-names = {0x1103060E:update_s3e_firmware}
restore-step-uptime = 7
restore-step-user-progress = 0
[23:23:08.0377-GMT]{5>7} CHECKPOINT END: RESTORED:[0x060E] update_s3e_firmware
restore-step-ids = {}
restore-step-names = {}
restore-step-uptime = 7
restore-step-user-progress = 0
[23:23:08.0379-GMT]{5>7} CHECKPOINT BEGIN: RESTORED:[0x060F] clear_remap_variable
restore-step-ids = {0x1103060F:21}
restore-step-names = {0x1103060F:clear_remap_variable}
restore-step-uptime = 7
restore-step-user-progress = 0
entering clear_remap_variable
executing /usr/sbin/nvram -d enable-remap-mode
enable-remap-mode
[23:23:08.0399-GMT]{5>7} CHECKPOINT END: RESTORED:[0x060F] clear_remap_variable
restore-step-ids = {}
restore-step-names = {}
restore-step-uptime = 7
restore-step-user-progress = 0
[23:23:08.0401-GMT]{5>7} CHECKPOINT BEGIN: RESTORED:[0x0610] asp_nand_set_writable
restore-step-ids = {0x11030610:22}
restore-step-names = {0x11030610:asp_nand_set_writable}
restore-step-uptime = 7
restore-step-user-progress = 0
Service name : ASPStorage
Set ASP writable successfully
[23:23:08.0407-GMT]{5>7} CHECKPOINT END: RESTORED:[0x0610] asp_nand_set_writable
restore-step-ids = {}
restore-step-names = {}
restore-step-uptime = 7
restore-step-user-progress = 0
[23:23:08.0409-GMT]{5>7} CHECKPOINT BEGIN: RESTORED:[0x0611] reprobe_storage
restore-step-ids = {0x11030611:23}
restore-step-names = {0x11030611:reprobe_storage}
restore-step-uptime = 7
restore-step-user-progress = 0
entering ramrod_reprobe_device_path
entering ramrod_probe_media
device partitioning scheme is GPT
find_filesystem_partitions: storage=/dev/disk0s1 container= system=/dev/disk0s1s1 data=/dev/disk0s1s2 baseband data=/dev/disk0s1s3 log=
[23:23:08.0422-GMT]{5>7} CHECKPOINT END: RESTORED:[0x0611] reprobe_storage
restore-step-ids = {}
restore-step-names = {}
restore-step-uptime = 7
restore-step-user-progress = 0
[23:23:08.0424-GMT]{5>7} CHECKPOINT BEGIN: RESTORED:[0x0612] reprobe_firmware
restore-step-ids = {0x11030612:24}
restore-step-names = {0x11030612:reprobe_firmware}
restore-step-uptime = 7
restore-step-user-progress = 0
entering ramrod_reprobe_device_path
entering ramrod_probe_media
device partitioning scheme is GPT
find_filesystem_partitions: storage=/dev/disk0s1 container= system=/dev/disk0s1s1 data=/dev/disk0s1s2 baseband data=/dev/disk0s1s3 log=
[23:23:08.0432-GMT]{5>7} CHECKPOINT END: RESTORED:[0x0612] reprobe_firmware
restore-step-ids = {}
restore-step-names = {}
restore-step-uptime = 7
restore-step-user-progress = 0
[23:23:08.0434-GMT]{5>7} CHECKPOINT BEGIN: RESTORED:[0x0613] find_filesystem_partitions
restore-step-ids = {0x11030613:25}
restore-step-names = {0x11030613:find_filesystem_partitions}
restore-step-uptime = 7
restore-step-user-progress = 0
entering ramrod_probe_media
device partitioning scheme is GPT
find_filesystem_partitions: storage=/dev/disk0s1 container= system=/dev/disk0s1s1 data=/dev/disk0s1s2 baseband data=/dev/disk0s1s3 log=
[23:23:08.0438-GMT]{5>7} CHECKPOINT END: RESTORED:[0x0613] find_filesystem_partitions
restore-step-ids = {}
restore-step-names = {}
restore-step-uptime = 7
restore-step-user-progress = 0
[23:23:08.0440-GMT]{5>7} CHECKPOINT BEGIN: RESTORED:[0x0614] mount_system_partition
restore-step-ids = {0x11030614:26}
restore-step-names = {0x11030614:mount_system_partition}
restore-step-uptime = 7
restore-step-user-progress = 0
ramrod_display_set_granular_progress: 0.000000
entering mount_partition
executing /sbin/fsck_hfs -fdy /dev/disk0s1s1
journal_replay(/dev/disk0s1s1) returned 0
** /dev/rdisk0s1s1
    Using cacheBlockSize=32K cacheTotalBlock=3956 cacheSize=126592K.
   Executing fsck_hfs (version hfs-366.30.3).
** Checking Journaled HFS Plus volume.
** Detected a case-sensitive volume.
   The volume name is Frisco13F69.N61OS
** Checking extents overflow file.
** Checking catalog file.
** Checking multi-linked files.
** Checking catalog hierarchy.
** Checking extended attributes file.
** Checking volume bitmap.
** Checking volume information.
** Trimming unused blocks.
** The volume Frisco13F69.N61OS appears to be OK.
    CheckHFS returned 0, fsmodified = 0
executing /sbin/mount_hfs -o rdonly /dev/disk0s1s1 /mnt1
mount_hfs: Could not create property for re-key environment check: No such file or directory
/dev/disk0s1s1 mounted on /mnt1
System mounted read-only
[23:23:15.0888-GMT]{5>7} CHECKPOINT END: RESTORED:[0x0614] mount_system_partition
restore-step-ids = {}
restore-step-names = {}
restore-step-uptime = 14
restore-step-user-progress = 0
[23:23:15.0890-GMT]{5>7} CHECKPOINT BEGIN: RESTORED:[0x0654] read_previous_os_build_version
restore-step-ids = {0x11030654:27}
restore-step-names = {0x11030654:read_previous_os_build_version}
restore-step-uptime = 14
restore-step-user-progress = 0
ramrod_read_previous_os_build_version: previous OS version: (null)
[23:23:15.0893-GMT]{5>7} CHECKPOINT END: RESTORED:[0x0654] read_previous_os_build_version
restore-step-ids = {}
restore-step-names = {}
restore-step-uptime = 14
restore-step-user-progress = 0
[23:23:15.0895-GMT]{5>7} CHECKPOINT BEGIN: RESTORED:[0x0615] copy_hardware_info
restore-step-ids = {0x11030615:28}
restore-step-names = {0x11030615:copy_hardware_info}
restore-step-uptime = 14
restore-step-user-progress = 0
[23:23:15.0896-GMT]{5>7} CHECKPOINT END: RESTORED:[0x0615] copy_hardware_info
restore-step-ids = {}
restore-step-names = {}
restore-step-uptime = 14
restore-step-user-progress = 0
[23:23:15.0898-GMT]{5>7} CHECKPOINT BEGIN: RESTORED:[0x0616] fdr_create
restore-step-ids = {0x11030616:29}
restore-step-names = {0x11030616:fdr_create}
restore-step-uptime = 14
restore-step-user-progress = 0
restored_fdr_initialize: FDR is supported
CryptoAcceleratorEncrypt: perform aes => 0 (kIOReturnSuccess)
pseudo_ccrng_allocate: ccdrbg_init() -> 0
CryptoGenerateRSAKeys: ccrsa_generate_key() -> 0
CryptoGenerateRSAKeys: [RSA Public Key SHA1: 20 bytes]
: a4 e1 51 85 93 f3 3f 63 17 c9 f3 9a bf 2e 76 51 
: 56 df 80 4f 
: -----------------------------------------------
CryptoGenerateRSAKeys: SecKeyCreateRSAPrivateKey -> 0x1000932a0
CryptoGenerateRSAKeys: SecKeyCreateRSAPublicKey -> 0x100093298
created HTTP FDR client 0x125e0bab0
created local FDR client 0x125e0bff0
Received response without expected RESTORED_FDR_TRUST_DATA
ramrod_ticket_copy_data_object_property: failed to get data property from Img4 manifest
failed to set trust object digest
RestoredFDRCreate() returned 6
FDR is not supported on this device
[23:23:18.0212-GMT]{5>7} CHECKPOINT FAILURE:(FAILURE:6) RESTORED:[0x0616] fdr_create [0]D(fatal FDR Error returned from RestoredFDRCreate())
restore-step-results = {0x11070616:{0:6}}
restore-step-codes = {0x11070616:{0:6}}
restore-step-domains = {0x11070616:{0:"AMRestoreErrorDomain"}}
restore-step-error = {0x11070616:"[0]D(fatal FDR Error returned from RestoredFDRCreate())"}
restore-step-uptime = 17
restore-step-user-progress = 0
[23:23:18.0219-GMT]{5>7} CHECKPOINT NOTICE: (NVRAM set) restore-step-user-progress=0 [sync=true] (first failure)
[23:23:18.0220-GMT]{5>7} CHECKPOINT BEGIN: RESTORED:[0x0647] cleanup_check_result
restore-step-ids = {0x11030616:29;0x11030647:30}
restore-step-names = {0x11030616:fdr_create;0x11030647:cleanup_check_result}
restore-step-uptime = 17
restore-step-user-progress = 0
[23:23:18.0226-GMT]{5>7} CHECKPOINT END: RESTORED:[0x0647] cleanup_check_result
restore-step-ids = {0x11030616:29}
restore-step-names = {0x11030616:fdr_create}
restore-step-uptime = 17
restore-step-user-progress = 0
[23:23:18.0233-GMT]{5>7} CHECKPOINT BEGIN: RESTORED:[0x0648] cleanup_send_final_status
restore-step-ids = {0x11030616:29;0x11030648:31}
restore-step-names = {0x11030616:fdr_create;0x11030648:cleanup_send_final_status}
restore-step-uptime = 17
restore-step-user-progress = 0

ERROR: Unable to successfully restore device
[Error] ERROR: Unable to restore device
Done: restoring failed.
Failed with errorcode=-11
tihmstar commented 7 years ago

I'm not really sure what happened here, but i don't think this is related to prometheus. Maybe your device has some broken hardware or sth. You can try re-restoring with prometheus in case the device still has the nonce you need. Otherwise you have to restore to latest signed version and hope that will fix this. If even latest normal version doesn't restore successfully you can try restoring to beta, which saved me once.

adrianmkofficial commented 7 years ago

Immediately after facing this error I've successfully (yet unfortunately) restored to iOS 10.3 (beta at that time).

The iPhone was also working perfectly before this failed restore. The file system had not been tampered with previously, I did however have an iOS 9.3.3 jailbroken via jbme.qwertyoruiop.com with the Stashing Tweak by Coolstar installed. Perhaps that was the culprit...

The error must be related to the idevicerestore-library, but I can't seem to figure out what exactly caused this issue... The logs read restored_fdr_initialize: FDR is supported and then FDR is not supported on this device which is pretty confusing... Possibly closable though.

NotAlexNoyle commented 7 years ago

Hi, I'm having this same problem. Stuck in a boot loop now, it kernel panics over and over again. Is there anything I can do or am I going to be forced to restore to 10.3? iPhone 6.

`Sierra-MBP:FUTURERESTORE95 NotAlexNoyle$ ./futurerestore_macos -t iPhone7,2_5684294864504870_14C92.shsh2 -b Mav10-5.32.00.Release.bbfw -p BuildManifest.plist -s sep-firmware.n61.RELEASE.im4p -m BuildManifest.plist iPhone_4.7_10.2_14C92_Restore.ipsw Version: 9fcf613f8fe68b15be7fd19c267e7351523eb387 - 95 futurerestore init done reading ticket iPhone7,2_5684294864504870_14C92.shsh2 done [TSSC] opening BuildManifest.plist WARNING: Unable to find BbSkeyId node [TSSR] User specified not to request a Baseband ticket. Request URL set to https://gs.apple.com/TSS/controller?action=2 Sending TSS request attempt 1... response successfully received Did set sep+baseband path and firmware [TSSC] opening BuildManifest.plist WARNING: Unable to find BbSkeyId node [TSSR] User specified to request only a Baseband ticket. ERROR: Unable to get BasebandFirmware node ERROR: Unable to find required BbGoldCertId in parameters Request URL set to https://gs.apple.com/TSS/controller?action=2 Sending TSS request attempt 1... response successfully received Found device in Normal mode Entering recovery mode... INFO: device serial number is C7CNJPLJG5MF Found device in Recovery mode Identified device as n61ap, iPhone7,2 Extracting BuildManifest from IPSW Product Version: 10.2 Product Build: 14C92 Major: 14 Device supports Image4: true checking APTicket to be valid for this restore... Verified ECID in APTicket matches device ECID Verified APTicket to be valid for this restore Variant: Customer Erase Install (IPSW) This restore will erase your device data. Extracting filesystem from IPSW [==================================================] 100.0% Extracting iBEC.n61.RELEASE.im4p... Personalizing IMG4 component iBEC... Sending iBEC (631956 bytes)... waiting for device to reconnect... Getting SepNonce in recovery mode... c0 80 97 e8 d9 ed 2b 99 54 fa 96 28 f5 3b 25 f3 b2 b2 53 5b Getting ApNonce in recovery mode... d9 3f 1f 76 f4 e1 73 70 15 a6 20 84 b9 a4 e3 00 e3 0c 4d df [WARNING] Setting bgcolor to green! If you don't see a green screen, then your device didn't boot iBEC correctly Recovery Mode Environment: iBoot build-version=iBoot-3406.30.8 iBoot build-style=RELEASE Sending RestoreLogo... Extracting applelogo@2x~iphone.t7000.im4p... Personalizing IMG4 component RestoreLogo... Sending RestoreLogo (11636 bytes)... ramdisk-size=0x10000000 Extracting 058-54560-094.dmg... Personalizing IMG4 component RestoreRamDisk... Sending RestoreRamDisk (40330259 bytes)... Extracting DeviceTree.n61ap.im4p... Personalizing IMG4 component RestoreDeviceTree... Sending RestoreDeviceTree (123449 bytes)... Extracting kernelcache.release.n61... Personalizing IMG4 component RestoreKernelCache... Sending RestoreKernelCache (12368336 bytes)... Trying to fetch new SHSH blob WARNING: Unable to find BbSkeyId node Request URL set to https://gs.apple.com/TSS/controller?action=2 Sending TSS request attempt 1... response successfully received Received SHSH blobs About to restore device... Waiting for device... Device 777f0b7683b47e2007249efff1c1a16c4d7f5538 is now connected in restore mode... Connecting now... Connected to com.apple.mobile.restored, version 14 Device 777f0b7683b47e2007249efff1c1a16c4d7f5538 has successfully entered restore mode Hardware Information: BoardID: 6 ChipID: 28672 UniqueChipID: 5684294864504870 ProductionMode: true Starting FDR listener thread About to send NORData... Found firmware path Firmware/all_flash/all_flash.n61ap.production Getting firmware manifest from Firmware/all_flash/all_flash.n61ap.production/manifest Extracting LLB.n61.RELEASE.im4p... Personalizing IMG4 component LLB... Extracting iBoot.n61.RELEASE.im4p... Personalizing IMG4 component iBoot... Extracting DeviceTree.n61ap.im4p... Personalizing IMG4 component DeviceTree... Extracting applelogo@2x~iphone.t7000.im4p... Personalizing IMG4 component AppleLogo... Extracting recoverymode@1334~iphone-lightning.t7000.im4p... Personalizing IMG4 component RecoveryMode... Extracting batterylow0@2x~iphone.t7000.im4p... Personalizing IMG4 component BatteryLow0... Extracting batterylow1@2x~iphone.t7000.im4p... Personalizing IMG4 component BatteryLow1... Extracting batterycharging0@2x~iphone.t7000.im4p... Personalizing IMG4 component BatteryCharging0... Extracting batterycharging1@2x~iphone.t7000.im4p... Personalizing IMG4 component BatteryCharging1... Extracting glyphplugin@1334~iphone-lightning.t7000.im4p... Personalizing IMG4 component BatteryPlugin... Extracting batteryfull@2x~iphone.t7000.im4p... Personalizing IMG4 component BatteryFull... Personalizing IMG4 component RestoreSEP... Personalizing IMG4 component SEP... Sending NORData now... Done sending NORData About to send RootTicket... Sending RootTicket now... Done sending RootTicket Waiting for NAND (28) Checking filesystems (15) About to send FDR Trust data... Sending FDR Trust data now... Done sending FDR Trust Data Got status message Status: Disk Failure Log is available: SYSLOG: Mar 31 16:23:05 localhost bootlog[0] : BOOT_TIME 1490977385 45654 [16:23:05.0776-GMT]{5>7} CHECKPOINT NOTICE: Image4 device: AP nonce clearable entering ramrod_clear_ap_nonce [16:23:05.0790-GMT]{5>7} CHECKPOINT NOTICE: AP nonce consumed No IOFlashController instance found [16:23:05.0791-GMT]{5>7} CHECKPOINT NOTICE: Pre-existing NVRAM variable: auto-boot=false [16:23:05.0791-GMT]{5>7} CHECKPOINT NOTICE: Pre-existing NVRAM variable: restore-outcome=initial_monitor_no_return [16:23:05.0793-GMT]{5>7} CHECKPOINT ANOMALY: [check_collection]restore-step-monitor(does_not_exist) [16:23:05.0793-GMT]{5>7} CHECKPOINT PROGRESS: START (unknown) -> (initial_engine_no_return) [16:23:05.0793-GMT]{5>7} CHECKPOINT NOTICE: NVRAM access available on initial check restore-anomalies = {0x00000000:[check_collection]restore-step-monitor(does_not_exist)} restore-outcome = initial_engine_no_return executing /usr/sbin/nvram restore-outcome=initial_engine_no_return [16:23:05.0811-GMT]{5>7} CHECKPOINT BEGIN: MAIN:[0x0400] umask restore-step-ids = {0x11030400:1} restore-step-names = {0x11030400:umask} restore-step-uptime = 0 restore-step-user-progress = -1 [16:23:05.0813-GMT]{5>7} CHECKPOINT END: MAIN:[0x0400] umask restore-step-ids = {} restore-step-names = {} restore-step-uptime = 0 restore-step-user-progress = -1 [16:23:05.0815-GMT]{5>7} CHECKPOINT BEGIN: MAIN:[0x0402] setvbuf restore-step-ids = {0x11030402:2} restore-step-names = {0x11030402:setvbuf} restore-step-uptime = 0 restore-step-user-progress = -1 [16:23:05.0817-GMT]{5>7} CHECKPOINT END: MAIN:[0x0402] setvbuf restore-step-ids = {} restore-step-names = {} restore-step-uptime = 0 restore-step-user-progress = -1 [16:23:05.0819-GMT]{5>7} CHECKPOINT BEGIN: MAIN:[0x0403] kernel_logger_thread restore-step-ids = {0x11030403:3} restore-step-names = {0x11030403:kernel_logger_thread} restore-step-uptime = 0 restore-step-user-progress = -1 [16:23:05.0820-GMT]{5>7} CHECKPOINT END: MAIN:[0x0403] kernel_logger_thread unable to open /dev/klog: No such file or directory restore-step-ids = {} restore-step-names = {} restore-step-uptime = 0 restore-step-user-progress = -1 [16:23:05.0822-GMT]{5>7} CHECKPOINT BEGIN: MAIN:[0x0406] set_progress_0 restore-step-ids = {0x11030406:4} restore-step-names = {0x11030406:set_progress_0} restore-step-uptime = 0 restore-step-user-progress = -1 inverting UI colordisplay-scale = 2 display-rotation = 0 found applelogo at /usr/share/progressui/applelogo@2x.tga found display: primary display: 750 x 1334 powering on display ramrod_display_set_granular_progress: 0.000000 [16:23:05.0859-GMT]{5>7} CHECKPOINT END: MAIN:[0x0406] set_progress_0 restore-step-ids = {} restore-step-names = {} restore-step-uptime = 0 restore-step-user-progress = 0 [16:23:05.0861-GMT]{5>7} CHECKPOINT BEGIN: MAIN:[0x0407] start_gasgauge_thread restore-step-ids = {0x11030407:5} restore-step-names = {0x11030407:start_gasgauge_thread} restore-step-uptime = 0 restore-step-user-progress = 0 [16:23:05.0864-GMT]{5>7} CHECKPOINT END: MAIN:[0x0407] start_gasgauge_thread restore-step-ids = {} restore-step-names = {} restore-step-uptime = 0 restore-step-user-progress = 0 [16:23:05.0866-GMT]{5>7} CHECKPOINT BEGIN: MAIN:[0x0408] listen_for_log_client restore-step-ids = {0x11030408:6} restore-step-names = {0x11030408:listen_for_log_client} restore-step-uptime = 0 restore-step-user-progress = 0 [16:23:05.0868-GMT]{5>7} CHECKPOINT END: MAIN:[0x0408] listen_for_log_client restore-step-ids = {} restore-step-names = {} restore-step-uptime = 0 restore-step-user-progress = 0 [16:23:05.0871-GMT]{5>7} CHECKPOINT BEGIN: MAIN:[0x040D] create_listen_socket restore-step-ids = {0x1103040D:7} restore-step-names = {0x1103040D:create_listen_socket} restore-step-uptime = 0 restore-step-user-progress = 0 [16:23:05.0872-GMT]{5>7} CHECKPOINT END: MAIN:[0x040D] create_listen_socket restore-step-ids = {} restore-step-names = {} restore-step-uptime = 0 restore-step-user-progress = 0 [16:23:05.0874-GMT]{5>7} CHECKPOINT BEGIN: MAIN:[0x0404] update_root_mount restore-step-ids = {0x11030404:8} restore-step-names = {0x11030404:update_root_mount} restore-step-uptime = 0 restore-step-user-progress = 0 [16:23:05.0877-GMT]{5>7} CHECKPOINT END: MAIN:[0x0404] update_root_mount restore-step-ids = {} restore-step-names = {} restore-step-uptime = 0 restore-step-user-progress = 0 [16:23:05.0879-GMT]{5>7} CHECKPOINT BEGIN: MAIN:[0x0405] disable_watchdog restore-step-ids = {0x11030405:9} restore-step-names = {0x11030405:disable_watchdog} restore-step-uptime = 0 restore-step-user-progress = 0 [16:23:05.0882-GMT]{5>7} CHECKPOINT END: MAIN:[0x0405] disable_watchdog restore-step-ids = {} restore-step-names = {} restore-step-uptime = 0 restore-step-user-progress = 0 [16:23:05.0884-GMT]{5>7} CHECKPOINT BEGIN: MAIN:[0x040E] enable_usb restore-step-ids = {0x1103040E:10} restore-step-names = {0x1103040E:enable_usb} restore-step-uptime = 0 restore-step-user-progress = 0 waiting for matching IOKit service: <CFBasicHash 0x104007910 [0x100f4acd8]>{type = mutable dict, count = 1, entries => 0 : <CFString 0x1011ef640 [0x100f4acd8]>{contents = "IOProviderClass"} = <CFString 0x104007850 [0x100f4acd8]>{contents = "AppleUSBDeviceMux"} }

[16:23:08.0899-GMT]{5>7} CHECKPOINT END: MAIN:[0x040E] enable_usb restore-step-ids = {} restore-step-names = {} restore-step-uptime = 3 restore-step-user-progress = 0 waiting for host to trigger start of restore [timeout of 120 seconds] recv(8, 4) failed: connection closed unable to read message size: -1 recv(9, 4) failed: connection closed could not receive message recv(13, 4) failed: connection closed recv(14, 4) failed: connection closed recv(15, 4) failed: connection closed recv(10, 4) failed: connection closed recv(16, 4) failed: connection closed recv(11, 4) failed: connection closed recv(18, 4) failed: connection closed unable to read message size: -1 recv(19, 4) failed: connection closed recv(20, 4) failed: connection closed recv(21, 4) failed: connection closed unable to read message size: -1 recv(8, 4) failed: connection closed unable to read message size: -1 recv(22, 4) failed: connection closed unable to read message size: -1 recv(23, 4) failed: connection closed recv(24, 4) failed: connection closed unable to read message size: -1 recv(25, 4) failed: connection closed recv(26, 4) failed: connection closed unable to read message size: -1 unable to read message size: -1 unable to read message size: -1 could not receive message unable to read message size: -1 unable to read message size: -1 unable to read message size: -1 could not receive message unable to read message size: -1 could not receive message unable to read message size: -1 could not receive message unable to read message size: -1 unable to read message size: -1 could not receive message unable to read message size: -1 unable to read message size: -1 could not receive message could not receive message could not receive message could not receive message could not receive message could not receive message could not receive message could not receive message could not receive message could not receive message could not receive message could not receive message [16:23:09.0727-GMT]{5>7} CHECKPOINT BEGIN: RESTORED:[0x0600] client_protocol_version restore-step-ids = {0x11030600:11} restore-step-names = {0x11030600:client_protocol_version} restore-step-uptime = 4 restore-step-user-progress = 0 client protocol version 14 [16:23:09.0736-GMT]{5>7} CHECKPOINT END: RESTORED:[0x0600] client_protocol_version restore-step-ids = {} restore-step-names = {} restore-step-uptime = 4 restore-step-user-progress = 0 [16:23:09.0743-GMT]{5>7} CHECKPOINT BEGIN: RESTORED:[0x0601] copy_restore_options restore-step-ids = {0x11030601:12} restore-step-names = {0x11030601:copy_restore_options} restore-step-uptime = 4 restore-step-user-progress = 0 UUID 75419ED4-5408-D307-064E-F37683385E14 Restore options: CreateFilesystemPartitions => <CFBoolean 0x100f4b230 [0x100f4acd8]>{value = true} BBUpdaterState => <CFBasicHash 0x10360c940 [0x100f4acd8]>{type = mutable dict, count = 6, entries => 0 : CertID = <CFNumber 0xb000000e4e408183 [0x100f4acd8]>{value = +3840149528, type = kCFNumberSInt64Type} 1 : ChipID = <CFNumber 0xb000000007f50e13 [0x100f4acd8]>{value = +8343777, type = kCFNumberSInt64Type} 2 : VendorID = <CFNumber 0xb000000000000033 [0x100f4acd8]>{value = +3, type = kCFNumberSInt64Type} 3 : Nonce = <CFData 0x10360d050 [0x100f4acd8]>{length = 20, capacity = 20, bytes = 0xef7f445adb3a5fc7e39085c030eb13485b99c953} 11 : <CFString 0x10360ca80 [0x100f4acd8]>{contents = "ChipSerialNo"} = <CFData 0x10360c6e0 [0x100f4acd8]>{length = 4, capacity = 4, bytes = 0x0544374e} 12 : <CFString 0x10360cbc0 [0x100f4acd8]>{contents = "ManifestInfo"} = <CFBasicHash 0x10360cdd0 [0x100f4acd8]>{type = mutable dict, count = 2, entries => 2 : <CFString 0x10360cef0 [0x100f4acd8]>{contents = "SKeyStatus"} = <CFNumber 0xb000000000000002 [0x100f4acd8]>{value = +0, type = kCFNumberSInt32Type} 10 : SKeyHash = <CFData 0x10360cda0 ... MinimumSystemPartition => <CFNumber 0xb00000000000d2d3 [0x100f4acd8]>{value = +3373, type = kCFNumberSInt64Type} UUID => <CFString 0x10360d5c0 [0x100f4acd8]>{contents = "75419ED4-5408-D307-064E-F37683385E14"} SystemPartitionSize => <CFNumber 0xb00000000000d2d3 [0x100f4acd8]>{value = +3373, type = kCFNumberSInt64Type} SystemPartitionPadding => <CFBasicHash 0x10360d230 [0x100f4acd8]>{type = mutable dict, count = 9, entries => 0 : 512 = <CFNumber 0xb000000000005003 [0x100f4acd8]>{value = +1280, type = kCFNumberSInt64Type} 2 : 128 = <CFNumber 0xb000000000005003 [0x100f4acd8]>{value = +1280, type = kCFNumberSInt64Type} 3 : 16 = <CFNumber 0xb000000000000a03 [0x100f4acd8]>{value = +160, type = kCFNumberSInt64Type} 4 : 1024 = <CFNumber 0xb000000000005003 [0x100f4acd8]>{value = +1280, type = kCFNumberSInt64Type} 5 : 32 = <CFNumber 0xb000000000001403 [0x100f4acd8]>{value = +320, type = kCFNumberSInt64Type} 6 : 768 = <CFNumber 0xb000000000005003 [0x100f4acd8]>{value = +1280, type = kCFNumberSInt64Type} 7 : 8 = <CFNumber 0xb000000000000503 [0x100f4acd8]>{value = +80, type = kCFNumberSInt64Type} 8 : 64 = <CFNumber 0xb000000000002803 [0x100f4acd8]>{value = +640, type = kCFNumberSInt64Type} 10 : 256 = <CFNumber 0xb000000000005003 [0x100f4acd8]>{value = +1280, type = kCFNumberSInt64Type} }

PersonalizedDuringPreflight    => <CFBoolean 0x100f4b230 [0x100f4acd8]>{value = true}

[16:23:09.0759-GMT]{5>7} CHECKPOINT END: RESTORED:[0x0601] copy_restore_options restore-step-ids = {} restore-step-names = {} restore-step-uptime = 4 restore-step-user-progress = 0 [16:23:09.0764-GMT]{5>7} CHECKPOINT BEGIN: RESTORED:[0x0655] is_host_compatible restore-step-ids = {0x11030655:13} restore-step-names = {0x11030655:is_host_compatible} restore-step-uptime = 4 restore-step-user-progress = 0 [16:23:09.0769-GMT]{5>7} CHECKPOINT END: RESTORED:[0x0655] is_host_compatible restore-step-ids = {} restore-step-names = {} restore-step-uptime = 4 restore-step-user-progress = 0 [16:23:09.0774-GMT]{5>7} CHECKPOINT BEGIN: RESTORED:[0x0604] set_weight_from_options restore-step-ids = {0x11030604:14} restore-step-names = {0x11030604:set_weight_from_options} restore-step-uptime = 4 restore-step-user-progress = 0 [16:23:09.0779-GMT]{5>7} CHECKPOINT END: RESTORED:[0x0604] set_weight_from_options restore-step-ids = {} restore-step-names = {} restore-step-uptime = 4 restore-step-user-progress = 0 [16:23:09.0784-GMT]{5>7} CHECKPOINT BEGIN: RESTORED:[0x0608] device_has_hoover restore-step-ids = {0x11030608:15} restore-step-names = {0x11030608:device_has_hoover} restore-step-uptime = 4 restore-step-user-progress = 0 [16:23:09.0790-GMT]{5>7} CHECKPOINT END: RESTORED:[0x0608] device_has_hoover restore-step-ids = {} restore-step-names = {} restore-step-uptime = 4 restore-step-user-progress = 0 [16:23:09.0795-GMT]{5>7} CHECKPOINT BEGIN: RESTORED:[0x0609] load_sep_os restore-step-ids = {0x11030609:16} restore-step-names = {0x11030609:load_sep_os} restore-step-uptime = 4 restore-step-user-progress = 0 entering load_sep_os device has sep - getting firmware entering copy_restore_sep got sep firmware - making call to load it entering ramrod_load_sep_os entering ramrod_execute_command_with_input_data: /usr/libexec/seputil (0x10689c000 - 4986470) executing /usr/libexec/seputil --restore+art - waiting for child to exit child exited exit status: 0 [16:23:12.0351-GMT]{5>7} CHECKPOINT END: RESTORED:[0x0609] load_sep_os restore-step-ids = {} restore-step-names = {} restore-step-uptime = 7 restore-step-user-progress = 0 [16:23:12.0357-GMT]{5>7} CHECKPOINT BEGIN: RESTORED:[0x060B] update_ticket restore-step-ids = {0x1103060B:17} restore-step-names = {0x1103060B:update_ticket} restore-step-uptime = 7 restore-step-user-progress = 0 entering ramrod_ticket_update looking up boot manifest hash crypto-hash-method found. Using SHA1 device tree ticket_hash: 2723E8C52C3DF6D1AD71C835FF5496D3B24D17A9 computed ticket_hash : 2723E8C52C3DF6D1AD71C835FF5496D3B24D17A9 received valid ticket (5096 bytes) [16:23:12.0372-GMT]{5>7} CHECKPOINT END: RESTORED:[0x060B] update_ticket restore-step-ids = {} restore-step-names = {} restore-step-uptime = 7 restore-step-user-progress = 0 [16:23:12.0377-GMT]{5>7} CHECKPOINT BEGIN: RESTORED:[0x060C] partition_nand restore-step-ids = {0x1103060C:18} restore-step-names = {0x1103060C:partition_nand} restore-step-uptime = 7 restore-step-user-progress = 0 entering partition_nand_device [16:23:12.0383-GMT]{5>7} CHECKPOINT END: RESTORED:[0x060C] partition_nand restore-step-ids = {} restore-step-names = {} restore-step-uptime = 7 restore-step-user-progress = 0 [16:23:12.0390-GMT]{5>7} CHECKPOINT BEGIN: RESTORED:[0x060D] wait_for_storage restore-step-ids = {0x1103060D:19} restore-step-names = {0x1103060D:wait_for_storage} restore-step-uptime = 7 restore-step-user-progress = 0 entering wait_for_storage_device ramrod_display_set_granular_progress: 0.000000 Searching for NAND service Found NAND service: ASPStorage NAND initialized. Waiting for devnode. [16:23:12.0408-GMT]{5>7} CHECKPOINT END: RESTORED:[0x060D] wait_for_storage restore-step-ids = {} restore-step-names = {} restore-step-uptime = 7 restore-step-user-progress = 0 [16:23:12.0415-GMT]{5>7} CHECKPOINT BEGIN: RESTORED:[0x060E] update_s3e_firmware restore-step-ids = {0x1103060E:20} restore-step-names = {0x1103060E:update_s3e_firmware} restore-step-uptime = 7 restore-step-user-progress = 0 [16:23:12.0423-GMT]{5>7} CHECKPOINT END: RESTORED:[0x060E] update_s3e_firmware restore-step-ids = {} restore-step-names = {} restore-step-uptime = 7 restore-step-user-progress = 0 [16:23:12.0430-GMT]{5>7} CHECKPOINT BEGIN: RESTORED:[0x060F] clear_remap_variable restore-step-ids = {0x1103060F:21} restore-step-names = {0x1103060F:clear_remap_variable} restore-step-uptime = 7 restore-step-user-progress = 0 entering clear_remap_variable executing /usr/sbin/nvram -d enable-remap-mode enable-remap-mode [16:23:12.0481-GMT]{5>7} CHECKPOINT END: RESTORED:[0x060F] clear_remap_variable restore-step-ids = {} restore-step-names = {} restore-step-uptime = 7 restore-step-user-progress = 0 [16:23:12.0486-GMT]{5>7} CHECKPOINT BEGIN: RESTORED:[0x0610] asp_nand_set_writable restore-step-ids = {0x11030610:22} restore-step-names = {0x11030610:asp_nand_set_writable} restore-step-uptime = 7 restore-step-user-progress = 0 Service name : ASPStorage Set ASP writable successfully [16:23:12.0497-GMT]{5>7} CHECKPOINT END: RESTORED:[0x0610] asp_nand_set_writable restore-step-ids = {} restore-step-names = {} restore-step-uptime = 7 restore-step-user-progress = 0 [16:23:12.0502-GMT]{5>7} CHECKPOINT BEGIN: RESTORED:[0x0611] reprobe_storage restore-step-ids = {0x11030611:23} restore-step-names = {0x11030611:reprobe_storage} restore-step-uptime = 7 restore-step-user-progress = 0 entering ramrod_reprobe_device_path entering ramrod_probe_media device partitioning scheme is GPT find_filesystem_partitions: storage=/dev/disk0s1 container= system=/dev/disk0s1s1 data=/dev/disk0s1s2 baseband data=/dev/disk0s1s3 log= [16:23:12.0528-GMT]{5>7} CHECKPOINT END: RESTORED:[0x0611] reprobe_storage restore-step-ids = {} restore-step-names = {} restore-step-uptime = 7 restore-step-user-progress = 0 [16:23:12.0533-GMT]{5>7} CHECKPOINT BEGIN: RESTORED:[0x0612] reprobe_firmware restore-step-ids = {0x11030612:24} restore-step-names = {0x11030612:reprobe_firmware} restore-step-uptime = 7 restore-step-user-progress = 0 entering ramrod_reprobe_device_path entering ramrod_probe_media device partitioning scheme is GPT find_filesystem_partitions: storage=/dev/disk0s1 container= system=/dev/disk0s1s1 data=/dev/disk0s1s2 baseband data=/dev/disk0s1s3 log= [16:23:12.0548-GMT]{5>7} CHECKPOINT END: RESTORED:[0x0612] reprobe_firmware restore-step-ids = {} restore-step-names = {} restore-step-uptime = 7 restore-step-user-progress = 0 [16:23:12.0553-GMT]{5>7} CHECKPOINT BEGIN: RESTORED:[0x0613] find_filesystem_partitions restore-step-ids = {0x11030613:25} restore-step-names = {0x11030613:find_filesystem_partitions} restore-step-uptime = 7 restore-step-user-progress = 0 entering ramrod_probe_media device partitioning scheme is GPT find_filesystem_partitions: storage=/dev/disk0s1 container= system=/dev/disk0s1s1 data=/dev/disk0s1s2 baseband data=/dev/disk0s1s3 log= [16:23:12.0562-GMT]{5>7} CHECKPOINT END: RESTORED:[0x0613] find_filesystem_partitions restore-step-ids = {} restore-step-names = {} restore-step-uptime = 7 restore-step-user-progress = 0 [16:23:12.0567-GMT]{5>7} CHECKPOINT BEGIN: RESTORED:[0x0614] mount_system_partition restore-step-ids = {0x11030614:26} restore-step-names = {0x11030614:mount_system_partition} restore-step-uptime = 7 restore-step-user-progress = 0 ramrod_display_set_granular_progress: 0.000000 entering mount_partition executing /sbin/fsck_hfs -fdy /dev/disk0s1s1 journal_replay(/dev/disk0s1s1) returned 0 /dev/rdisk0s1s1 Using cacheBlockSize=32K cacheTotalBlock=3956 cacheSize=126592K. Executing fsck_hfs (version hfs-366.30.3). Checking Journaled HFS Plus volume. Detected a case-sensitive volume. The volume name is OkemoZurs12D508.N61OS Checking extents overflow file. Checking catalog file. Checking multi-linked files. Checking catalog hierarchy. Checking extended attributes file. Checking volume bitmap. Checking volume information. Trimming unused blocks. The volume OkemoZurs12D508.N61OS appears to be OK. CheckHFS returned 0, fsmodified = 0 executing /sbin/mount_hfs -o rdonly /dev/disk0s1s1 /mnt1 mount_hfs: Could not create property for re-key environment check: No such file or directory /dev/disk0s1s1 mounted on /mnt1 System mounted read-only [16:23:18.0024-GMT]{5>7} CHECKPOINT END: RESTORED:[0x0614] mount_system_partition restore-step-ids = {} restore-step-names = {} restore-step-uptime = 13 restore-step-user-progress = 0 [16:23:18.0027-GMT]{5>7} CHECKPOINT BEGIN: RESTORED:[0x0654] read_previous_os_build_version restore-step-ids = {0x11030654:27} restore-step-names = {0x11030654:read_previous_os_build_version} restore-step-uptime = 13 restore-step-user-progress = 0 ramrod_read_previous_os_build_version: previous OS version: (null) [16:23:18.0032-GMT]{5>7} CHECKPOINT END: RESTORED:[0x0654] read_previous_os_build_version restore-step-ids = {} restore-step-names = {} restore-step-uptime = 13 restore-step-user-progress = 0 [16:23:18.0034-GMT]{5>7} CHECKPOINT BEGIN: RESTORED:[0x0615] copy_hardware_info restore-step-ids = {0x11030615:28} restore-step-names = {0x11030615:copy_hardware_info} restore-step-uptime = 13 restore-step-user-progress = 0 [16:23:18.0036-GMT]{5>7} CHECKPOINT END: RESTORED:[0x0615] copy_hardware_info restore-step-ids = {} restore-step-names = {} restore-step-uptime = 13 restore-step-user-progress = 0 [16:23:18.0039-GMT]{5>7} CHECKPOINT BEGIN: RESTORED:[0x0616] fdr_create restore-step-ids = {0x11030616:29} restore-step-names = {0x11030616:fdr_create} restore-step-uptime = 13 restore-step-user-progress = 0 restored_fdr_initialize: FDR is supported CryptoAcceleratorEncrypt: perform aes => 0 (kIOReturnSuccess) pseudo_ccrng_allocate: ccdrbg_init() -> 0 CryptoGenerateRSAKeys: ccrsa_generate_key() -> 0 CryptoGenerateRSAKeys: [RSA Public Key SHA1: 20 bytes] : b6 05 a1 0b 1b 22 77 8f 92 27 d5 34 a1 62 e3 18 : 34 97 08 64 : ----------------------------------------------- CryptoGenerateRSAKeys: SecKeyCreateRSAPrivateKey -> 0x1001632a0 CryptoGenerateRSAKeys: SecKeyCreateRSAPublicKey -> 0x100163298 created HTTP FDR client 0x104010570 created local FDR client 0x10400aed0 Received response without expected RESTORED_FDR_TRUST_DATA ramrod_ticket_copy_data_object_property: failed to get data property from Img4 manifest failed to set trust object digest RestoredFDRCreate() returned 6 FDR is not supported on this device [16:23:20.0395-GMT]{5>7} CHECKPOINT FAILURE:(FAILURE:6) RESTORED:[0x0616] fdr_create [0]D(fatal FDR Error returned from RestoredFDRCreate()) restore-step-results = {0x11070616:{0:6}} restore-step-codes = {0x11070616:{0:6}} restore-step-domains = {0x11070616:{0:"AMRestoreErrorDomain"}} restore-step-error = {0x11070616:"[0]D(fatal FDR Error returned from RestoredFDRCreate())"} restore-step-uptime = 15 restore-step-user-progress = 0 [16:23:20.0406-GMT]{5>7} CHECKPOINT NOTICE: (NVRAM set) restore-step-user-progress=0 [sync=true] (first failure) [16:23:20.0407-GMT]{5>7} CHECKPOINT BEGIN: RESTORED:[0x0647] cleanup_check_result restore-step-ids = {0x11030616:29;0x11030647:30} restore-step-names = {0x11030616:fdr_create;0x11030647:cleanup_check_result} restore-step-uptime = 15 restore-step-user-progress = 0 [16:23:20.0414-GMT]{5>7} CHECKPOINT END: RESTORED:[0x0647] cleanup_check_result restore-step-ids = {0x11030616:29} restore-step-names = {0x11030616:fdr_create} restore-step-uptime = 15 restore-step-user-progress = 0 [16:23:20.0422-GMT]{5>7} CHECKPOINT BEGIN: RESTORED:[0x0648] cleanup_send_final_status restore-step-ids = {0x11030616:29;0x11030648:31} restore-step-names = {0x11030616:fdr_create;0x11030648:cleanup_send_final_status} restore-step-uptime = 15 restore-step-user-progress = 0

ERROR: Unable to successfully restore device [Error] ERROR: Unable to restore device Done: restoring failed. Failed with errorcode=-11 `

NotAlexNoyle commented 7 years ago

I ended up restoring to 10.2.1 -- I hope that the log is helpful in identifying the cause of this problem. It seems several people with iPhone 6 have had this issue.

adrianmkofficial commented 7 years ago

Unfortunately I haven't stumbled upon a better solution for this problem other than restoring to the currently signed iOS. 😢

CzXe7 commented 7 years ago

Same problem from ios 9.3.3 via luca todescos JB. trying to go to 10.2.1 and im endlessly stuck

NotAlexNoyle commented 6 years ago

I just reproduced this issue on the Apple TV 4:

Zephyr-HighSierra:futurerestore-latest NotAlexNoyle$ ./futurerestore_macos -t ../AppleTV5,3_4601817761114150_15J582.shsh2 --latest-sep -m BuildManifest.plist ../AppleTV5,3_11.1_15J582_Restore.ipsw --no-baseband -w
Version: a0113a4e46bfd00962cd25e3af548fc8b0bd21fd - 173
Odysseus Support: no
[INFO] 64bit device detected
futurerestore init done
reading ticket ../AppleTV5,3_4601817761114150_15J582.shsh2 done
Found device AppleTV5,3 j42dap
user specified to use latest signed sep
[TSSC] opening firmware.json
[DOWN] downloading file https://api.ipsw.me/v2.1/firmwares.json/condensed
[TSSC] selecting latest iOS: 11.2.5
[TSSC] got firmwareurl for iOS 11.2.5 build 15K552
100 [================================================================================================100 [===================================================================================================>]
downloading SEP [================================================================================================100
opening /tmp/futurerestore/sepManifest.plist
WARNING: Unable to find BbChipID node
[TSSR] User specified not to request a Baseband ticket.
Request URL set to https://gs.apple.com/TSS/controller?action=2
Sending TSS request attempt 1... response successfully received

WARNING: user specified not to flash a baseband. This can make the restore fail if the device needs a baseband!
if you added this flag by mistake you can press CTRL-C now to cancel
continuing restore in 5 4 3 2 1 
Found device in Normal mode
Entering recovery mode...
INFO: device serial number is DY4QG48SGXH8
waiting for nonce: 6e ca bf 8c 9d ec fb 00 ff bd b4 17 ff 2c bc f4 92 f0 b1 0f 
Got ApNonce from device: 6e ca bf 8c 9d ec fb 00 ff bd b4 17 ff 2c bc f4 92 f0 b1 0f 
Device has requested ApNonce now
Found device in Recovery mode
Identified device as j42dap, AppleTV5,3
Extracting BuildManifest from IPSW
Product Version: 11.1
Product Build: 15J582 Major: 15
Device supports Image4: true
Got APNonce from device: 6e ca bf 8c 9d ec fb 00 ff bd b4 17 ff 2c bc f4 92 f0 b1 0f 
checking APTicket to be valid for this restore...
Verified ECID in APTicket matches device ECID
checking APTicket to be valid for this restore...
Verified ECID in APTicket matches device ECID
Verified APTicket to be valid for this restore
Variant: Customer Erase Install (IPSW)
This restore will erase your device data.
Extracting filesystem from IPSW
[==================================================] 100.0%
Extracting iBEC.j42d.RELEASE.im4p...
Personalizing IMG4 component iBEC...
Sending iBEC (705613 bytes)...
waiting for device to reconnect... 
Getting SepNonce in recovery mode... 82 b1 3d 58 20 fb 6e fd 16 39 cf d5 d0 a4 5c a4 72 d9 bc 49 
Getting ApNonce in recovery mode... 6e ca bf 8c 9d ec fb 00 ff bd b4 17 ff 2c bc f4 92 f0 b1 0f 
[WARNING] Setting bgcolor to green! If you don't see a green screen, then your device didn't boot iBEC correctly
Recovery Mode Environment:
iBoot build-version=iBoot-4076.20.48
iBoot build-style=RELEASE
Sending RestoreLogo...
Extracting applelogo~appletv.im4p...
Personalizing IMG4 component RestoreLogo...
Sending RestoreLogo (9228 bytes)...
ramdisk-size=0x20000000
Extracting 058-86523-084.dmg...
Personalizing IMG4 component RestoreRamDisk...
Sending RestoreRamDisk (42942859 bytes)...
Extracting DeviceTree.j42dap.im4p...
Personalizing IMG4 component RestoreDeviceTree...
Sending RestoreDeviceTree (88437 bytes)...
Extracting kernelcache.release.j42d...
Personalizing IMG4 component RestoreKernelCache...
Sending RestoreKernelCache (12548470 bytes)...
Trying to fetch new SHSH blob
WARNING: Unable to find BbChipID node
Request URL set to https://gs.apple.com/TSS/controller?action=2
Sending TSS request attempt 1... response successfully received
Received SHSH blobs
About to restore device... 
Waiting for device...
Device c873375cfa5e6aa9ba04414a3d109c06e5a66de9 is now connected in restore mode...
Connecting now...
Connected to com.apple.mobile.restored, version 15
Device c873375cfa5e6aa9ba04414a3d109c06e5a66de9 has successfully entered restore mode
Hardware Information:
BoardID: 52
ChipID: 28672
UniqueChipID: 4601817761114150
ProductionMode: true
Starting FDR listener thread
About to send NORData...
Found firmware path Firmware/all_flash
Getting firmware manifest from build identity
Extracting LLB.j42d.RELEASE.im4p...
Personalizing IMG4 component LLB...
Extracting applelogo~appletv.im4p...
Personalizing IMG4 component AppleLogo...
Extracting DeviceTree.j42dap.im4p...
Personalizing IMG4 component DeviceTree...
Extracting recoverymode@1080~appletv5.im4p...
Personalizing IMG4 component RecoveryMode...
Extracting iBoot.j42d.RELEASE.im4p...
Personalizing IMG4 component iBoot...
Personalizing IMG4 component RestoreSEP...
Personalizing IMG4 component SEP...
Sending NORData now...
Done sending NORData
About to send RootTicket...
Sending RootTicket now...
Done sending RootTicket
Waiting for NAND (28)
Checking filesystems (15)
Checking filesystems (15)
About to send FDR Trust data...
Sending FDR Trust data now...
Done sending FDR Trust Data
Got status message
Status: Disk Failure
Log is available:
SYSLOG: Feb 11 05:35:02 localhost bootlog[0] <Notice>: BOOT_TIME 1518327302 534606
[05:35:03.0069-GMT]{5>7} CHECKPOINT NOTICE: Image4 device: AP nonce clearable
entering ramrod_clear_ap_nonce
[05:35:03.0083-GMT]{5>7} CHECKPOINT NOTICE: AP nonce consumed
[05:35:03.0084-GMT]{5>7} CHECKPOINT NOTICE: Pre-existing NVRAM variable: auto-boot=false
[05:35:03.0085-GMT]{5>7} CHECKPOINT NOTICE: Pre-existing NVRAM variable: restore-outcome=initial_monitor_no_return
[05:35:03.0087-GMT]{5>7} CHECKPOINT PROGRESS: START (unknown) -> (initial_engine_no_return)
[05:35:03.0087-GMT]{5>7} CHECKPOINT NOTICE: NVRAM access available on initial check
restore-outcome = initial_engine_no_return
executing /usr/sbin/nvram restore-outcome=initial_engine_no_return
[05:35:03.0105-GMT]{5>7} CHECKPOINT BEGIN: MAIN:[0x0400] umask
restore-step-ids = {0x11030400:1}
restore-step-names = {0x11030400:umask}
restore-step-uptime = 1
restore-step-user-progress = -1
[05:35:03.0108-GMT]{5>7} CHECKPOINT END: MAIN:[0x0400] umask
restore-step-ids = {}
restore-step-names = {}
restore-step-uptime = 1
restore-step-user-progress = -1
[05:35:03.0110-GMT]{5>7} CHECKPOINT BEGIN: MAIN:[0x0402] setvbuf
restore-step-ids = {0x11030402:2}
restore-step-names = {0x11030402:setvbuf}
restore-step-uptime = 1
restore-step-user-progress = -1
[05:35:03.0112-GMT]{5>7} CHECKPOINT END: MAIN:[0x0402] setvbuf
restore-step-ids = {}
restore-step-names = {}
restore-step-uptime = 1
restore-step-user-progress = -1
[05:35:03.0114-GMT]{5>7} CHECKPOINT BEGIN: MAIN:[0x0403] kernel_logger_thread
restore-step-ids = {0x11030403:3}
restore-step-names = {0x11030403:kernel_logger_thread}
restore-step-uptime = 1
restore-step-user-progress = -1
[05:35:03.0116-GMT]{5>7} CHECKPOINT END: MAIN:[0x0403] kernel_logger_thread
unable to open /dev/klog: Resource busy
restore-step-ids = {}
restore-step-names = {}
restore-step-uptime = 1
restore-step-user-progress = -1
[05:35:03.0119-GMT]{5>7} CHECKPOINT BEGIN: MAIN:[0x0406] set_progress_0
restore-step-ids = {0x11030406:4}
restore-step-names = {0x11030406:set_progress_0}
restore-step-uptime = 1
restore-step-user-progress = -1
found display: external
attempting to power on display port
starting display hot plug thread
ramrod_display_set_granular_progress_forced: 0.000000
[05:35:03.0137-GMT]{5>7} CHECKPOINT END: MAIN:[0x0406] set_progress_0
restore-step-ids = {}
restore-step-names = {}
restore-step-uptime = 1
restore-step-user-progress = 0
[05:35:03.0139-GMT]{5>7} CHECKPOINT BEGIN: MAIN:[0x0408] listen_for_log_client
restore-step-ids = {0x11030408:5}
restore-step-names = {0x11030408:listen_for_log_client}
restore-step-uptime = 1
restore-step-user-progress = 0
[05:35:03.0142-GMT]{5>7} CHECKPOINT END: MAIN:[0x0408] listen_for_log_client
restore-step-ids = {}
restore-step-names = {}
restore-step-uptime = 1
restore-step-user-progress = 0
[05:35:03.0144-GMT]{5>7} CHECKPOINT BEGIN: MAIN:[0x040D] create_listen_socket
restore-step-ids = {0x1103040D:6}
restore-step-names = {0x1103040D:create_listen_socket}
restore-step-uptime = 1
restore-step-user-progress = 0
[05:35:03.0146-GMT]{5>7} CHECKPOINT END: MAIN:[0x040D] create_listen_socket
restore-step-ids = {}
restore-step-names = {}
restore-step-uptime = 1
restore-step-user-progress = 0
[05:35:03.0148-GMT]{5>7} CHECKPOINT BEGIN: MAIN:[0x0404] update_root_mount
restore-step-ids = {0x11030404:7}
restore-step-names = {0x11030404:update_root_mount}
restore-step-uptime = 1
restore-step-user-progress = 0
[05:35:03.0152-GMT]{5>7} CHECKPOINT END: MAIN:[0x0404] update_root_mount
restore-step-ids = {}
restore-step-names = {}
restore-step-uptime = 1
restore-step-user-progress = 0
[05:35:03.0155-GMT]{5>7} CHECKPOINT BEGIN: MAIN:[0x0405] disable_watchdog
restore-step-ids = {0x11030405:8}
restore-step-names = {0x11030405:disable_watchdog}
restore-step-uptime = 1
restore-step-user-progress = 0
[05:35:03.0159-GMT]{5>7} CHECKPOINT END: MAIN:[0x0405] disable_watchdog
restore-step-ids = {}
restore-step-names = {}
restore-step-uptime = 1
restore-step-user-progress = 0
[05:35:03.0161-GMT]{5>7} CHECKPOINT BEGIN: MAIN:[0x040E] enable_usb
restore-step-ids = {0x1103040E:9}
restore-step-names = {0x1103040E:enable_usb}
restore-step-uptime = 1
restore-step-user-progress = 0
waiting for matching IOKit service: <CFBasicHash 0x104605790 [0x101bc2d70]>{type = mutable dict, count = 1,
entries =>
    0 : <CFString 0x101e73e00 [0x101bc2d70]>{contents = "IOProviderClass"} = <CFString 0x104603b00 [0x101bc2d70]>{contents = "AppleUSBDeviceMux"}
}

[05:35:06.0175-GMT]{5>7} CHECKPOINT END: MAIN:[0x040E] enable_usb
restore-step-ids = {}
restore-step-names = {}
restore-step-uptime = 4
restore-step-user-progress = 0
waiting for host to trigger start of restore [timeout of 120 seconds]
recv(8, 4) failed: connection closed
unable to read message size: -1
recv(9, 4) failed: connection closed
could not receive message
recv(11, 4) failed: connection closed
unable to read message size: -1
unable to read message size: -1
could not receive message
could not receive message
[05:35:06.0446-GMT]{5>7} CHECKPOINT BEGIN: RESTORED:[0x0600] client_protocol_version
restore-step-ids = {0x11030600:10}
restore-step-names = {0x11030600:client_protocol_version}
restore-step-uptime = 4
restore-step-user-progress = 0
client protocol version 15
[05:35:06.0457-GMT]{5>7} CHECKPOINT END: RESTORED:[0x0600] client_protocol_version
restore-step-ids = {}
restore-step-names = {}
restore-step-uptime = 4
restore-step-user-progress = 0
[05:35:06.0463-GMT]{5>7} CHECKPOINT BEGIN: RESTORED:[0x0601] copy_restore_options
restore-step-ids = {0x11030601:11}
restore-step-names = {0x11030601:copy_restore_options}
restore-step-uptime = 4
restore-step-user-progress = 0
*** UUID AB5929FA-1E68-11CB-42EC-263C1BCE8A2E ***
Restore options:
    CreateFilesystemPartitions     => <CFBoolean 0x101bc32c8 [0x101bc2d70]>{value = true}
    MinimumSystemPartition         => <CFNumber 0xb0000000000094a3 [0x101bc2d70]>{value = +2378, type = kCFNumberSInt64Type}
    UUID                           => <CFString 0x104606b00 [0x101bc2d70]>{contents = "AB5929FA-1E68-11CB-42EC-263C1BCE8A2E"}
    SystemPartitionSize            => <CFNumber 0xb0000000000094a3 [0x101bc2d70]>{value = +2378, type = kCFNumberSInt64Type}
    SystemPartitionPadding         => <CFBasicHash 0x104606db0 [0x101bc2d70]>{type = mutable dict, count = 9,
entries =>
    0 : 512 = <CFNumber 0xb000000000005003 [0x101bc2d70]>{value = +1280, type = kCFNumberSInt64Type}
    2 : 128 = <CFNumber 0xb000000000005003 [0x101bc2d70]>{value = +1280, type = kCFNumberSInt64Type}
    3 : 16 = <CFNumber 0xb000000000000a03 [0x101bc2d70]>{value = +160, type = kCFNumberSInt64Type}
    4 : 1024 = <CFNumber 0xb000000000005003 [0x101bc2d70]>{value = +1280, type = kCFNumberSInt64Type}
    5 : 32 = <CFNumber 0xb000000000001403 [0x101bc2d70]>{value = +320, type = kCFNumberSInt64Type}
    6 : 768 = <CFNumber 0xb000000000005003 [0x101bc2d70]>{value = +1280, type = kCFNumberSInt64Type}
    7 : 8 = <CFNumber 0xb000000000000503 [0x101bc2d70]>{value = +80, type = kCFNumberSInt64Type}
    8 : 64 = <CFNumber 0xb000000000002803 [0x101bc2d70]>{value = +640, type = kCFNumberSInt64Type}
    10 : 256 = <CFNumber 0xb000000000005003 [0x101bc2d70]>{value = +1280, type = kCFNumberSInt64Type}
}

    PersonalizedDuringPreflight    => <CFBoolean 0x101bc32c8 [0x101bc2d70]>{value = true}
[05:35:06.0480-GMT]{5>7} CHECKPOINT END: RESTORED:[0x0601] copy_restore_options
restore-step-ids = {}
restore-step-names = {}
restore-step-uptime = 4
restore-step-user-progress = 0
[05:35:06.0486-GMT]{5>7} CHECKPOINT BEGIN: RESTORED:[0x0655] is_host_compatible
restore-step-ids = {0x11030655:12}
restore-step-names = {0x11030655:is_host_compatible}
restore-step-uptime = 4
restore-step-user-progress = 0
[05:35:06.0492-GMT]{5>7} CHECKPOINT END: RESTORED:[0x0655] is_host_compatible
restore-step-ids = {}
restore-step-names = {}
restore-step-uptime = 4
restore-step-user-progress = 0
[05:35:06.0498-GMT]{5>7} CHECKPOINT BEGIN: RESTORED:[0x0604] set_weight_from_options
restore-step-ids = {0x11030604:13}
restore-step-names = {0x11030604:set_weight_from_options}
restore-step-uptime = 4
restore-step-user-progress = 0
[05:35:06.0506-GMT]{5>7} CHECKPOINT END: RESTORED:[0x0604] set_weight_from_options
restore-step-ids = {}
restore-step-names = {}
restore-step-uptime = 4
restore-step-user-progress = 0
[05:35:06.0512-GMT]{5>7} CHECKPOINT BEGIN: RESTORED:[0x0608] device_has_hoover
restore-step-ids = {0x11030608:14}
restore-step-names = {0x11030608:device_has_hoover}
restore-step-uptime = 4
restore-step-user-progress = 0
entering bootstrap_hoover
bootstrap_hoover: using customer firmware
bootstrap_hoover: hoover successfully bootstrapped
[05:35:07.0746-GMT]{5>7} CHECKPOINT END: RESTORED:[0x0608] device_has_hoover
restore-step-ids = {}
restore-step-names = {}
restore-step-uptime = 5
restore-step-user-progress = 0
[05:35:07.0755-GMT]{5>7} CHECKPOINT BEGIN: RESTORED:[0x0609] load_sep_os
restore-step-ids = {0x11030609:15}
restore-step-names = {0x11030609:load_sep_os}
restore-step-uptime = 5
restore-step-user-progress = 0
entering load_sep_os
device has sep - getting firmware
entering copy_restore_sep
display attached
0: 720 x 480 @ 60 (score = 0)
1: 1280 x 720 @ 60 (score = 0)
2: 720 x 576 @ 50 (score = 0)
3: 1280 x 720 @ 50 (score = 0)
4: 1920 x 1080 @ 60 (score = 0)
5: 1920 x 1080 @ 50 (score = 0)
6: 800 x 600 @ 60 (score = 1029)
7: 640 x 480 @ 75 (score = 98)
8: 640 x 480 @ 72 (score = 94)
9: 640 x 480 @ 60 (score = 1018)
10: 1280 x 1024 @ 75 (score = 173)
11: 1024 x 768 @ 75 (score = 134)
12: 1024 x 768 @ 70 (score = 125)
13: 1024 x 768 @ 60 (score = 1047)
14: 800 x 600 @ 75 (score = 111)
15: 800 x 600 @ 72 (score = 107)
16: 1152 x 864 @ 75 (score = 150)
17: 1280 x 800 @ 60 (score = 6061)
18: 1280 x 960 @ 60 (score = 1074)
19: 1280 x 1024 @ 60 (score = 1079)
20: 1440 x 900 @ 60 (score = 6078)
21: 1440 x 900 @ 75 (score = 5172)
22: 1680 x 1050 @ 60 (score = 6106)
23: 1600 x 1200 @ 60 (score = 1115)
24: 1920 x 1080 @ 60 (score = 16224)
25: 1360 x 768 @ 60 (score = 6063)
26: 1280 x 720 @ 60 (score = 16155)
27: 720 x 480 @ 60 (score = 16121)
28: 1920 x 1080 @ 24 (score = 15174)
29: 1920 x 1080 @ 30 (score = 15192)
using 1920 x 1080 @ 60 (score = 16224)
timing_data_struct
 activeVerticalAxis: 1080
 activeHorizontalAxis: 1920
 interlaced: 0
 pixelClock: 148351648
 ratioType: 3
 scanInformation: 0
cea_id = 16
Setting Digital out mode - ColorID: 66 timingID: 49got sep firmware - making call to load it
entering ramrod_load_sep_os
entering ramrod_execute_command_with_input_data: /usr/libexec/seputil (0x105380000 - 1835998)
executing /usr/libexec/seputil --restore+art -
waiting for child to exit
display: 1920 x 1080
powering on display
child exited
exit status: 0
[05:35:08.0935-GMT]{5>7} CHECKPOINT END: RESTORED:[0x0609] load_sep_os
restore-step-ids = {}
restore-step-names = {}
restore-step-uptime = 6
restore-step-user-progress = 0
[05:35:08.0945-GMT]{5>7} CHECKPOINT BEGIN: RESTORED:[0x060B] update_ticket
restore-step-ids = {0x1103060B:16}
restore-step-names = {0x1103060B:update_ticket}
restore-step-uptime = 6
restore-step-user-progress = 0
entering ramrod_ticket_update_verify
looking up boot manifest hash
device tree ticket_hash: DA812641CCF40125B53D9468BD963755EF2C4012
crypto-hash-method found. Using SHA1
computed ticket_hash   : DA812641CCF40125B53D9468BD963755EF2C4012
received valid ticket (4448 bytes)
[05:35:08.0968-GMT]{5>7} CHECKPOINT END: RESTORED:[0x060B] update_ticket
restore-step-ids = {}
restore-step-names = {}
restore-step-uptime = 6
restore-step-user-progress = 0
[05:35:08.0977-GMT]{5>7} CHECKPOINT BEGIN: RESTORED:[0x060D] wait_for_storage
restore-step-ids = {0x1103060D:17}
restore-step-names = {0x1103060D:wait_for_storage}
restore-step-uptime = 6
restore-step-user-progress = 0
entering wait_for_storage_device
ramrod_display_set_granular_progress_forced: 0.000000
Searching for NAND service
Found NAND service: ASPStorage
NAND initialized. Waiting for devnode.
[05:35:08.0999-GMT]{5>7} CHECKPOINT END: RESTORED:[0x060D] wait_for_storage
restore-step-ids = {}
restore-step-names = {}
restore-step-uptime = 6
restore-step-user-progress = 0
[05:35:09.0008-GMT]{5>7} CHECKPOINT BEGIN: RESTORED:[0x060E] update_NAND_firmware
restore-step-ids = {0x1103060E:18}
restore-step-names = {0x1103060E:update_NAND_firmware}
restore-step-uptime = 7
restore-step-user-progress = 0
[05:35:09.0018-GMT]{5>7} CHECKPOINT END: RESTORED:[0x060E] update_NAND_firmware
restore-step-ids = {}
restore-step-names = {}
restore-step-uptime = 7
restore-step-user-progress = 0
[05:35:09.0027-GMT]{5>7} CHECKPOINT BEGIN: RESTORED:[0x060F] clear_remap_variable
restore-step-ids = {0x1103060F:19}
restore-step-names = {0x1103060F:clear_remap_variable}
restore-step-uptime = 7
restore-step-user-progress = 0
entering clear_remap_variable
executing /usr/sbin/nvram -d enable-remap-mode
enable-remap-mode
[05:35:09.0079-GMT]{5>7} CHECKPOINT END: RESTORED:[0x060F] clear_remap_variable
restore-step-ids = {}
restore-step-names = {}
restore-step-uptime = 7
restore-step-user-progress = 0
[05:35:09.0085-GMT]{5>7} CHECKPOINT BEGIN: RESTORED:[0x065C] print_nvram_variables
restore-step-ids = {0x1103065C:20}
restore-step-names = {0x1103065C:print_nvram_variables}
restore-step-uptime = 7
restore-step-user-progress = 0
ramrod_print_NVRAM_variables
executing /usr/sbin/nvram -xp
<?xml version="1.0" encoding="UTF-8"?>
<!DOCTYPE plist PUBLIC "-//Apple//DTD PLIST 1.0//EN" "http://www.apple.com/DTDs/PropertyList-1.0.dtd">
<plist version="1.0">
<dict>
    <key>auto-boot</key>
    <data>
    ZmFsc2U=
    </data>
    <key>boot-args</key>
    <string></string>
    <key>com.apple.System.tz0-size</key>
    <data>
    MHg4MDAwMDA=
    </data>
    <key>restore-outcome</key>
    <data>
    aW5pdGlhbF9lbmdpbmVfbm9fcmV0dXJu
    </data>
</dict>
</plist>
[05:35:09.0125-GMT]{5>7} CHECKPOINT END: RESTORED:[0x065C] print_nvram_variables
restore-step-ids = {}
restore-step-names = {}
restore-step-uptime = 7
restore-step-user-progress = 0
[05:35:09.0131-GMT]{5>7} CHECKPOINT BEGIN: RESTORED:[0x0610] asp_nand_set_writable
restore-step-ids = {0x11030610:21}
restore-step-names = {0x11030610:asp_nand_set_writable}
restore-step-uptime = 7
restore-step-user-progress = 0
Service name : ASPStorage
Set ASP writable successfully
[05:35:09.0143-GMT]{5>7} CHECKPOINT END: RESTORED:[0x0610] asp_nand_set_writable
restore-step-ids = {}
restore-step-names = {}
restore-step-uptime = 7
restore-step-user-progress = 0
[05:35:09.0149-GMT]{5>7} CHECKPOINT BEGIN: RESTORED:[0x0611] reprobe_storage
restore-step-ids = {0x11030611:22}
restore-step-names = {0x11030611:reprobe_storage}
restore-step-uptime = 7
restore-step-user-progress = 0
entering ramrod_reprobe_device_path
entering ramrod_probe_media
device partitioning scheme is GPT
APFS Container /dev/disk0s1
device is APFS formatted
find_filesystem_partitions: storage=/dev/disk0 container=/dev/disk0s1 system=/dev/disk0s1s1 data=/dev/disk0s1s2 baseband data= log= update= xart= hardware= scratch=
[05:35:09.0185-GMT]{5>7} CHECKPOINT END: RESTORED:[0x0611] reprobe_storage
restore-step-ids = {}
restore-step-names = {}
restore-step-uptime = 7
restore-step-user-progress = 0
[05:35:09.0191-GMT]{5>7} CHECKPOINT BEGIN: RESTORED:[0x0612] reprobe_firmware
restore-step-ids = {0x11030612:23}
restore-step-names = {0x11030612:reprobe_firmware}
restore-step-uptime = 7
restore-step-user-progress = 0
entering ramrod_reprobe_device_path
entering ramrod_probe_media
device partitioning scheme is GPT
APFS Container /dev/disk0s1
device is APFS formatted
find_filesystem_partitions: storage=/dev/disk0 container=/dev/disk0s1 system=/dev/disk0s1s1 data=/dev/disk0s1s2 baseband data= log= update= xart= hardware= scratch=
[05:35:09.0207-GMT]{5>7} CHECKPOINT END: RESTORED:[0x0612] reprobe_firmware
restore-step-ids = {}
restore-step-names = {}
restore-step-uptime = 7
restore-step-user-progress = 0
[05:35:09.0211-GMT]{5>7} CHECKPOINT BEGIN: RESTORED:[0x0613] find_filesystem_partitions
restore-step-ids = {0x11030613:24}
restore-step-names = {0x11030613:find_filesystem_partitions}
restore-step-uptime = 7
restore-step-user-progress = 0
entering ramrod_probe_media
device partitioning scheme is GPT
APFS Container /dev/disk0s1
device is APFS formatted
find_filesystem_partitions: storage=/dev/disk0 container=/dev/disk0s1 system=/dev/disk0s1s1 data=/dev/disk0s1s2 baseband data= log= update= xart= hardware= scratch=
[05:35:09.0219-GMT]{5>7} CHECKPOINT END: RESTORED:[0x0613] find_filesystem_partitions
restore-step-ids = {}
restore-step-names = {}
restore-step-uptime = 7
restore-step-user-progress = 0
[05:35:09.0222-GMT]{5>7} CHECKPOINT BEGIN: RESTORED:[0x0665] fsck_filesystems
restore-step-ids = {0x11030665:25}
restore-step-names = {0x11030665:fsck_filesystems}
restore-step-uptime = 7
restore-step-user-progress = 0
entering fsck_apfs_container
ramrod_display_set_granular_progress_forced: 0.000000
executing /System/Library/Filesystems/apfs.fs/fsck_apfs -dy /dev/disk0s1
** Checking volume.
** Checking the container superblock.
** Checking the space manager.
** Checking the object map.
** Checking the APFS volume superblock.
** Checking the object map.
** Checking the fsroot tree.
** Checking the snapshot metadata tree.
** Checking the extent ref tree.
** Checking the snapshots.
** Checking the APFS volume superblock.
** Checking the object map.
dev_init:453: Using /private/var/apfs and /private/var/nx for device-io.
** Checking the fsroot tree.
** Checking the snapshot metadata tree.
** Checking the extent ref tree.
** Checking the snapshots.
** Verifying allocated space.
error: Overallocation Detected on Main device: (15362904+1) bitmap address (28287)
   Space Verification failed.
** The volume /dev/disk0s1 could not be verified completely.
fsck succeeded on /dev/disk0s1
[05:35:10.0970-GMT]{5>7} CHECKPOINT END: RESTORED:[0x0665] fsck_filesystems
restore-step-ids = {}
restore-step-names = {}
restore-step-uptime = 8
restore-step-user-progress = 0
[05:35:10.0974-GMT]{5>7} CHECKPOINT BEGIN: RESTORED:[0x0614] mount_system_partition
restore-step-ids = {0x11030614:26}
restore-step-names = {0x11030614:mount_system_partition}
restore-step-uptime = 8
restore-step-user-progress = 0
ramrod_display_set_granular_progress_forced: 0.000000
entering mount_partition
executing /System/Library/Filesystems/apfs.fs/mount_apfs -o rdonly /dev/disk0s1s1 /mnt1
/dev/disk0s1s1 mounted on /mnt1
System mounted read-only
[05:35:11.0015-GMT]{5>7} CHECKPOINT END: RESTORED:[0x0614] mount_system_partition
restore-step-ids = {}
restore-step-names = {}
restore-step-uptime = 9
restore-step-user-progress = 0
[05:35:11.0020-GMT]{5>7} CHECKPOINT BEGIN: RESTORED:[0x0654] read_previous_os_build_version
restore-step-ids = {0x11030654:27}
restore-step-names = {0x11030654:read_previous_os_build_version}
restore-step-uptime = 9
restore-step-user-progress = 0
ramrod_read_previous_os_build_version: previous OS version: (null)
[05:35:11.0027-GMT]{5>7} CHECKPOINT END: RESTORED:[0x0654] read_previous_os_build_version
restore-step-ids = {}
restore-step-names = {}
restore-step-uptime = 9
restore-step-user-progress = 0
[05:35:11.0031-GMT]{5>7} CHECKPOINT BEGIN: RESTORED:[0x0615] copy_hardware_info
restore-step-ids = {0x11030615:28}
restore-step-names = {0x11030615:copy_hardware_info}
restore-step-uptime = 9
restore-step-user-progress = 0
[05:35:11.0034-GMT]{5>7} CHECKPOINT END: RESTORED:[0x0615] copy_hardware_info
restore-step-ids = {}
restore-step-names = {}
restore-step-uptime = 9
restore-step-user-progress = 0
[05:35:11.0038-GMT]{5>7} CHECKPOINT BEGIN: RESTORED:[0x0616] fdr_create
restore-step-ids = {0x11030616:29}
restore-step-names = {0x11030616:fdr_create}
restore-step-uptime = 9
restore-step-user-progress = 0
restored_fdr_initialize: FDR is supported
CryptoAcceleratorEncrypt: perform aes => 0 (kIOReturnSuccess)
pseudo_ccrng_allocate: ccdrbg_init() -> 0
CryptoGenerateRSAKeys: ccrsa_generate_key() -> 0
CryptoGenerateRSAKeys: [RSA Public Key SHA1: 20 bytes]
: 09 e7 94 4d 41 44 d5 b3 ec 11 f6 33 87 4e 24 1a 
: be 89 8c 50 
: -----------------------------------------------
CryptoGenerateRSAKeys: SecKeyCreateRSAPrivateKey -> 0x100e96500
CryptoGenerateRSAKeys: SecKeyCreateRSAPublicKey -> 0x100e964f8
_copyDataInstanceForSealingMapEntry: Using value 28672 for key ChipID from query cache
_copyDataInstanceForSealingMapEntry: Using value 4601817761114150 for key UniqueChipID from query cache
created HTTP FDR client 0x10440ce00
_copyDataInstanceForSealingMapEntry: Using value 28672 for key ChipID from query cache
_copyDataInstanceForSealingMapEntry: Using value 4601817761114150 for key UniqueChipID from query cache
created local FDR client 0x10440d760
Received response without expected RESTORED_FDR_TRUST_DATA
ramrod_ticket_copy_data_object_property: failed to get data property from Img4 manifest
failed to set trust object digest
RestoredFDRCreate() returned 6
FDR is not supported on this device
[05:35:13.0226-GMT]{5>7} CHECKPOINT FAILURE:(FAILURE:6) RESTORED:[0x0616] fdr_create [0]D(fatal FDR Error returned from RestoredFDRCreate())
restore-step-results = {0x11070616:{0:6}}
restore-step-codes = {0x11070616:{0:6}}
restore-step-domains = {0x11070616:{0:"AMRestoreErrorDomain"}}
restore-step-error = {0x11070616:"[0]D(fatal FDR Error returned from RestoredFDRCreate())"}
restore-step-uptime = 11
restore-step-user-progress = 0
[05:35:13.0230-GMT]{5>7} CHECKPOINT NOTICE: (NVRAM set) restore-step-user-progress=0 [sync=true] (first failure)
[05:35:13.0230-GMT]{5>7} CHECKPOINT BEGIN: RESTORED:[0x0647] cleanup_check_result
restore-step-ids = {0x11030616:29;0x11030647:30}
restore-step-names = {0x11030616:fdr_create;0x11030647:cleanup_check_result}
restore-step-uptime = 11
restore-step-user-progress = 0
[05:35:13.0232-GMT]{5>7} CHECKPOINT END: RESTORED:[0x0647] cleanup_check_result
restore-step-ids = {0x11030616:29}
restore-step-names = {0x11030616:fdr_create}
restore-step-uptime = 11
restore-step-user-progress = 0
[05:35:13.0234-GMT]{5>7} CHECKPOINT BEGIN: RESTORED:[0x0648] cleanup_send_final_status
restore-step-ids = {0x11030616:29;0x11030648:31}
restore-step-names = {0x11030616:fdr_create;0x11030648:cleanup_send_final_status}
restore-step-uptime = 11
restore-step-user-progress = 0

ERROR: Unable to successfully restore device
[Error] ERROR: Unable to restore device
Done: restoring failed.
Failed with errorcode=-11`