Skip to content
This repository has been archived by the owner on Apr 14, 2023. It is now read-only.

iPhone12,1 iOS 15.6 beta1 97% completed restore then fail #86

Closed
0nenZer0 opened this issue Nov 8, 2022 · 3 comments
Closed

iPhone12,1 iOS 15.6 beta1 97% completed restore then fail #86

0nenZer0 opened this issue Nov 8, 2022 · 3 comments

Comments

@0nenZer0
Copy link

0nenZer0 commented Nov 8, 2022

Hi @TrungNguyen1909, I tried to restore iPhone 11 using Beta 1 version of iOS 15.6 but i'm stuck at 97% then fail. Any suggestion? Using MBPro (M1)

Thanks,
1n0

0nenzer0@MBProKoTo ~ % /Users/Shared/qemu-t8030/build/qemu-system-aarch64 -s -M t8030,trustcache-filename=/Users/Shared/iphone11.15.6/Firmware/078-34019-076.dmg.trustcache,ticket-filename=/Users/0nenzer0/root_ticket.der
-kernel /Users/Shared/iphone11.15.6/kernelcache.research.iphone12b
-dtb /Users/Shared/iphone11.15.6/Firmware/all_flash/DeviceTree.n104ap.im4p
-append "debug=0x14e kextlog=0xffff serial=3 -v wdt=-1"
-initrd /Users/Shared/iphone11.15.6/078-34019-076.dmg
-cpu max -smp 4
-m 4G -serial mon:stdio
-drive file=/Users/Shared/nvme.1,format=raw,if=none,id=drive.1
-device nvme-ns,drive=drive.1,bus=nvme-bus.0,nsid=1,nstype=1,logical_block_size=4096,physical_block_size=4096
-drive file=/Users/Shared/nvme.2,format=raw,if=none,id=drive.2
-device nvme-ns,drive=drive.2,bus=nvme-bus.0,nsid=2,nstype=2,logical_block_size=4096,physical_block_size=4096
-drive file=/Users/Shared/nvme.3,format=raw,if=none,id=drive.3
-device nvme-ns,drive=drive.3,bus=nvme-bus.0,nsid=3,nstype=3,logical_block_size=4096,physical_block_size=4096
-drive file=/Users/Shared/nvme.4,format=raw,if=none,id=drive.4
-device nvme-ns,drive=drive.4,bus=nvme-bus.0,nsid=4,nstype=4,logical_block_size=4096,physical_block_size=4096
-drive file=/Users/Shared/nvram,if=none,format=raw,id=nvram
-device apple-nvram,drive=nvram,bus=nvme-bus.0,nsid=5,nstype=5,id=nvram,logical_block_size=4096,physical_block_size=4096
-drive file=/Users/Shared/nvme.6,format=raw,if=none,id=drive.6
-device nvme-ns,drive=drive.6,bus=nvme-bus.0,nsid=6,nstype=6,logical_block_size=4096,physical_block_size=4096
-drive file=/Users/Shared/nvme.7,format=raw,if=none,id=drive.7
-device nvme-ns,drive=drive.7,bus=nvme-bus.0,nsid=7,nstype=8,logical_block_size=4096,physical_block_size=4096
-monitor telnet:127.0.0.1:1235,server,nowait
Loading iOS 15.6...
kernel_low: 0xfffffff004000000
kernel_high: 0xfffffff00a030cb8
KPF: found apfs_vfsop_mount
KPF: found handle_eval_rootauth
KPF: Found AMFI hashtype check
kpf_amfi_callback: Found AMFI (Leaf)
kpf_amfi_callback: Found lookup_in_trust_cache_module @ 0xfffffff007cb6e30
KPF: Found mac_mount
KPF: Found mac_mount
kpf_amfi_callback: Found AMFI (Leaf)
kpf_amfi_callback: Found lookup_in_static_trust_cache @ 0xfffffff009c1c370
qemu-system-aarch64: Missing patch: trustcache16
KPF: Found AppleKeyStoreUserClient::handleUserClientCommandGated
Qemu FB realize
qemu-system-aarch64: -device apple-nvram,drive=nvram,bus=nvme-bus.0,nsid=5,nstype=5,id=nvram,logical_block_size=4096,physical_block_size=4096: nvram bank fails adler32: expected: 0x0, got 0x1fec0001
qemu-system-aarch64: nvram bank fails adler32: expected: 0x0, got 0x1fec0001
boot_mode: 0
auto-boot=false
g_virt_base: 0xfffffff004000000
g_phys_base: 0x0000000802000000
slide_virt: 0x00000000019b8000
slide_phys: 0x00000000019b8000
entry: 0x0000000807c704f0
cmdline: [-restore rd=md0 nand-enable-reformat=1 -progress debug=0x14e kextlog=0xffff serial=3 -v wdt=-1]
iBoot version: qemu-t8030
Darwin Image4 Validator Version 4.2.0: Sat Jun 18 18:53:08 PDT 2022; root:AppleImage4-158.100.11~2910/AppleImage4/RELEASE_ARM64E
AppleImage4: failed to read nvram property: oblit-inprogress: 2
AppleImage4: failed to read nvram property: 40A0DDD2-77F8-4392-B4A3-1E7304206516:nonce-seeds: 2
AppleImage4: nonce manager: error reading seeds: 2
AppleImage4: nonce manager: unsupported nonce blob: version = 0, length = 0, v0 length = 304
AMFI is running in RESEARCH mode!
AMFI: UDID enforcement enabled
AppleCredentialManager: init: called, instance = .
ACMFirstResponderKernelService: init: called, .
ACMRM-S: init: called, starting PersistentStore service.
ACMRM-C: init: called, starting AccessoryCache service.
ACMKernelService: initValueFromBootArgAliasesUInt32: acc-cache size = 16 (default).
ACMKernelService: initValueFromBootArgAliasesUInt32: acc-cache expiration = 2592000 (default).
ACMRM: init: called, starting TRM service.
ACMRM-A: init: called, starting TRM Analytics service.
ACMKernelService: initValueFromBootArgAliasesUInt32: analytics collection period = 86400 (default).
ACMKernelService: initValueFromBootArgAliasesUInt32: policy mode timeout = 259200 (default).
ACMRM-A: notifyStandardModeTimeoutChanged: called, value = 259200 (modified = YES).
ACMKernelService: initValueFromBootArgAliasesUInt32: (bounded) grace period timeout = 3600 (default).
ACMRM-A: notifyGracePeriodTimeoutChanged: called, value = 3600 (modified = YES).
ACMKernelService: initValueFromBootArgAliasesUInt32: enabled = 1 (default).
ACMRM: _disableBy: [TRM ENABLED=YES] (mask=0, DISABLED BY: Def=NO* BtArg=NO LegHW=NO OSEnv=NO | MngCo=NO DwnOS=NO ChkBd=NO coGSw=NO).
ACMRM: _disableBy: [TRM ENABLED=YES] (mask=0, DISABLED BY: Def=NO BtArg=NO* LegHW=NO OSEnv=NO | MngCo=NO DwnOS=NO ChkBd=NO coGSw=NO).
ACMRM: _loadDisabledByOSEnvironment: disabled by OSEnvironment: NO.
ACMRM: _disableBy: [TRM ENABLED=YES] (mask=0, DISABLED BY: Def=NO BtArg=NO LegHW=NO OSEnv=NO* | MngCo=NO DwnOS=NO ChkBd=NO coGSw=NO).
ACMRM: _mapAndPublishTRM: set TRM_PolicyTimeout = 259200.
ACMRM: _mapAndPublishTRM: sending kIOMessageServicePropertyChange(n=1) while DISABLED, TRM: 259200 -/ff 4294967295 -/ff miss=ff (CUR: 259200 -/ff 4294967295 -/ff).
AppleCredentialManager: init: returning, result = true, instance = .
AppleARMBootPerf: Error: profile handoff region not found (2)
AppleARMBootPerf: Error: failed to publish profile data (2)
virtual bool CoreAnalyticsHub::start(IOService *)::114:CoreAnalyticsHub start
AppleS5L8940XI2CController::start: i2c1 this: _i2cBaseAddress:
AppleGen0SPMIController[spmi1]:78: Start
000001.804445 AppleT8030TypeCPhy@0: AppleT8027TypeCPhy::start: usb3-phy-parent not specified
AppleS5L8940XI2CController::start: i2c0 this: _i2cBaseAddress:
AppleS8000AES::start: registers at phys:0x0x235008000/0x0x23d2d0000 virt:0x/0x0x4000 / 0x/0x0x4000
AppleGPIOICController::start: this: , _gpioicBaseAddress:
AppleGPIOICController::start: this: , _gpioicBaseAddress:
AppleInterruptController::start: Num Shared Timestamps == 0
AppleGPIOICController::start: this: , _gpioicBaseAddress:
AppleGen0SPMIController[spmi2]:78: Start
virtual bool AppleARMLightEmUp::start(IOService *): starting...
AppleOLYHAL::probe: score = 1000
AppleOLYHAL::start: entry with provider 0x43aecd523b
AppleS5L8940XI2CController::start: smc-i2c1 this: _i2cBaseAddress:
AppleS5L8940XI2CController::start: i2c2 this: _i2cBaseAddress:
ApplePMGR: Starting AppleT8030PMGR
AppleGen0SPMIController[spmi0]:78: Start
AppleS5L8940XI2CController::start: i2c3 this: _i2cBaseAddress:
000002.141518 wlan0.A[1] start@1843:Default options property found with value 4
AppleSSE::start called
AppleSSE::start returning, result = 1
Creating an object of AppleOLYHALPlatformFunctionEmbeddedAMFM class
000002.187155 wlan0.A[2] start@2238: Raised adjustBusy(+1), getBusyState() -> 1
000002.187355 wlan0.A[3] setupNotifier@2303:Setting up notifier for CoreAnalyticsHub
Warning: arc4random not implemented
Warning: arc4random not implemented
Warning: arc4random not implemented
AppleSEPKeyStore:319:0: starting (BUILT: Jun 18 2022 19:13:29)
AppleSEPKeyStore:524:0: _sep_enabled = 1
AppleCredentialManager: start: called, instance = .
ACMRM: _publishIOResource: AppleUSBRestrictedModeTimeout = 259200.
AppleCredentialManager: start: initializing power management.
AppleCredentialManager: start: will join SEPManager's PM tree in getSEPEndpoint().
AppleCredentialManager: start: registering notifications.
AppleCredentialManager: start: started, instance = .
AppleCredentialManager: start: returning, result = true, instance = .
AMFIInitializeLocalSigningPublicKey: disabling local signing since we're in the restore environment
AppleA7IOPNub: withRegistryEntry, 47: allocated nub

Identified Serial Port uart7 at 0x23521c000()
RTBuddy(SMC): start() - (Jun 18 2022@19:12:14)
RTBuddy(SMC): Boot args override: wdt = -1
RTBuddy(SMC): Resuming...

AppleA7IOPNub: withRegistryEntry, 47: allocated nub
........
.......
Skipping Rose update since it does not appear to be supported. If it should be, file a radar!
[16:26:17.0030-GMT]{3>6} CHECKPOINT END: FIRMWARE_SEALING:[0x1503] update_rose_postseal
restore-step-ids = {0x1103067B:64;0x11030668:93}
restore-step-names = {0x1103067B:perform_restore_installing;0x11030668:update_firmware_post_sealing}
restore-step-uptime = 3129
restore-step-user-progress = 97
[16:26:17.0079-GMT]{3>6} CHECKPOINT BEGIN: FIRMWARE_SEALING:[0x1319] stage_fdr_ean
restore-step-ids = {0x1103067B:64;0x11030668:93;0x11031319:97}
restore-step-names = {0x1103067B:perform_restore_installing;0x11030668:update_firmware_post_sealing;0x11031319:stage_fdr_ean}
restore-step-uptime = 3129
restore-step-user-progress = 97
Skipping stage_fdr_ean on device with no EAN
[16:26:17.0142-GMT]{3>6} CHECKPOINT END: FIRMWARE_SEALING:[0x1319] stage_fdr_ean
restore-step-ids = {0x1103067B:64;0x11030668:93}
restore-step-names = {0x1103067B:perform_restore_installing;0x11030668:update_firmware_post_sealing}
restore-step-uptime = 3129
restore-step-user-progress = 97
[16:26:17.0193-GMT]{3>6} CHECKPOINT BEGIN: FIRMWARE_SEALING:[0x131A] ensure_fdr_ean
restore-step-ids = {0x1103067B:64;0x11030668:93;0x1103131A:98}
restore-step-names = {0x1103067B:perform_restore_installing;0x11030668:update_firmware_post_sealing;0x1103131A:ensure_fdr_ean}
restore-step-uptime = 3129
restore-step-user-progress = 97
Skipping ensure_fdr_ean on device with no EAN
[16:26:17.0273-GMT]{3>6} CHECKPOINT END: FIRMWARE_SEALING:[0x131A] ensure_fdr_ean
restore-step-ids = {0x1103067B:64;0x11030668:93}
restore-step-names = {0x1103067B:perform_restore_installing;0x11030668:update_firmware_post_sealing}
restore-step-uptime = 3129
restore-step-user-progress = 97
[16:26:17.0340-GMT]{3>6} CHECKPOINT BEGIN: FIRMWARE_SEALING:[0x1504] update_fdr_ean
restore-step-ids = {0x1103067B:64;0x11030668:93;0x11031504:99}
restore-step-names = {0x1103067B:perform_restore_installing;0x11030668:update_firmware_post_sealing;0x11031504:update_fdr_ean}
restore-step-uptime = 3129
restore-step-user-progress = 97
ramrod_display_set_granular_progress_forced: 97.000000
Skipping update_fdr_ean on device with no EAN
ramrod_display_set_granular_progress_forced: 97.000000
Skipping ensure_fdr_ean on device with no EAN
[16:26:17.0437-GMT]{3>6} CHECKPOINT END: FIRMWARE_SEALING:[0x1504] update_fdr_ean
restore-step-ids = {0x1103067B:64;0x11030668:93}
restore-step-names = {0x1103067B:perform_restore_installing;0x11030668:update_firmware_post_sealing}
restore-step-uptime = 3129
restore-step-user-progress = 97
[16:26:17.0508-GMT]{3>6} CHECKPOINT BEGIN: FIRMWARE_SEALING:[0x1314] update_fillmore
restore-step-ids = {0x1103067B:64;0x11030668:93;0x11031314:100}
restore-step-names = {0x1103067B:perform_restore_installing;0x11030668:update_firmware_post_sealing;0x11031314:update_fillmore}
restore-step-uptime = 3129
restore-step-user-progress = 97
entering update_fillmore
Not a Fillmore-capable device, nothing to update..
[16:26:17.0582-GMT]{3>6} CHECKPOINT END: FIRMWARE_SEALING:[0x1314] update_fillmore
restore-step-ids = {0x1103067B:64;0x11030668:93}
restore-step-names = {0x1103067B:perform_restore_installing;0x11030668:update_firmware_post_sealing}
restore-step-uptime = 3129
restore-step-user-progress = 97
[16:26:17.0690-GMT]{3>6} CHECKPOINT END: (null):[0x0668] update_firmware_post_sealing
restore-step-ids = {0x1103067B:64}
restore-step-names = {0x1103067B:perform_restore_installing}
restore-step-uptime = 3129
restore-step-user-progress = 97
[16:26:17.0763-GMT]{3>6} CHECKPOINT BEGIN: (null):[0x063D] fdr_verify_sealed_manifest
restore-step-ids = {0x1103067B:64;0x1103063D:101}
restore-step-names = {0x1103067B:perform_restore_installing;0x1103063D:fdr_verify_sealed_manifest}
restore-step-uptime = 3129
restore-step-user-progress = 97
[16:26:17.0832-GMT]{3>6} CHECKPOINT END: (null):[0x063D] fdr_verify_sealed_manifest
restore-step-ids = {0x1103067B:64}
restore-step-names = {0x1103067B:perform_restore_installing}
restore-step-uptime = 3129
restore-step-user-progress = 97
Tolerated step 0x63d has actually succeeded. Marking it as such
[16:26:17.0938-GMT]{3>6} CHECKPOINT BEGIN: (null):[0x066F] commit_sep_os
restore-step-ids = {0x1103067B:64;0x1103066F:102}
restore-step-names = {0x1103067B:perform_restore_installing;0x1103066F:commit_sep_os}
restore-step-uptime = 3129
restore-step-user-progress = 97
entering commit_sep_os
device has no sep
entering ramrod_kill_sep_nonce
device has no sep
[16:26:17.0994-GMT]{3>6} CHECKPOINT END: (null):[0x066F] commit_sep_os
restore-step-ids = {0x1103067B:64}
restore-step-names = {0x1103067B:perform_restore_installing}
restore-step-uptime = 3129
restore-step-user-progress = 97
[16:26:18.0055-GMT]{3>6} CHECKPOINT BEGIN: (null):[0x0674] create_protected_filesystems
restore-step-ids = {0x1103067B:64;0x11030674:103}
restore-step-names = {0x1103067B:perform_restore_installing;0x11030674:create_protected_filesystems}
restore-step-uptime = 3130
restore-step-user-progress = 97
entering create_protected_filesystems
ramrod_display_set_granular_progress_forced: 97.000000
content-protect property not found
encryptable property not found
creating class d key for /mnt2
creating unencrypted data partition
unable to open /dev/disk0s1 to get block size: Resource busy
block size for /dev/disk0s1: 0
/System/Library/Filesystems/apfs.fs/newfs_apfs -A -D -o role=d -v Data /dev/disk0s1
executing /System/Library/Filesystems/apfs.fs/newfs_apfs -A -D -o role=d -v Data /dev/disk0s1
apfs_newfs:28581: disk0s1s2 FS will NOT be encrypted.
entering ramrod_probe_media_internal
entering wait_for_device: 'EmbeddedDeviceTypeRoot'
Using device path /dev/disk0 for EmbeddedDeviceTypeRoot
device partitioning scheme is GPT
APFS Container 'Container' /dev/disk0s1
device is APFS formatted
Captured preboot partition on main OS container 2
find_filesystem_partitions: storage=/dev/disk0 container=/dev/disk0s1 system=/dev/disk0s1s1 data=/dev/disk0s1s2 baseband data= log= update=/dev/disk0s1s5 xart= hardware=/dev/disk0s1s3 scratch= preboot=/dev/disk0s1s4
find_filesystem_partitions: recovery os container= volume=
entering ramrod_probe_media_internal
entering wait_for_device: 'EmbeddedDeviceTypeRoot'
Using device path /dev/disk0 for EmbeddedDeviceTypeRoot
device partitioning scheme is GPT
APFS Container 'Container' /dev/disk0s1
device is APFS formatted
Captured preboot partition on main OS container 2
find_filesystem_partitions: storage=/dev/disk0 container=/dev/disk0s1 system=/dev/disk0s1s1 data=/dev/disk0s1s2 baseband data= log= update=/dev/disk0s1s5 xart= hardware=/dev/disk0s1s3 scratch= preboot=/dev/disk0s1s4
find_filesystem_partitions: recovery os container= volume=
entering mount_partition
executing /sbin/mount_apfs -R /dev/disk0s1s2 /mnt2
apfs_mount:27083: disk0s1s2 mount for ramdisk
set_cloneinfo_id_epoch:26435: disk0s1s2 set cloneinfo_id_epoch to 16
apfs_log_mount_unmount:1889: disk0s1s2 mounting volume Data, requested by: mount_apfs (pid 35); parent: restored_externa (pid 6)
handle_mount:655: disk0s1s2 vol-uuid: 61706673-7575-6964-0040-766F6C756D01 block size: 4096 block count: 8388597 (unencrypted; flags: 0x1; features: 8.0.2)
handle_mount:668: disk0s1s2 setting dev block size to 4096 from 512
nx_volume_group_update:7762: disk0s1s2 Volume Data is not in a volume group
fastsim_is_enabled:9717: ================ fastsim is enabled ================
/dev/disk0s1s2 mounted on /mnt2
Data mounted read-write
[16:26:23.0954-GMT]{3>6} CHECKPOINT END: (null):[0x0674] create_protected_filesystems
restore-step-ids = {0x1103067B:64}
restore-step-names = {0x1103067B:perform_restore_installing}
restore-step-uptime = 3135
restore-step-user-progress = 97
[16:26:23.0985-GMT]{3>6} CHECKPOINT BEGIN: (null):[0x065F] reserve_overprov_space
restore-step-ids = {0x1103067B:64;0x1103065F:104}
restore-step-names = {0x1103067B:perform_restore_installing;0x1103065F:reserve_overprov_space}
restore-step-uptime = 3135
restore-step-user-progress = 97
Reserving space for overprov since this is a erase install
device_size = 34359738368 (32 GB)
file_size = 343597383 (0 GB)
[16:26:25.0974-GMT]{3>6} CHECKPOINT END: (null):[0x065F] reserve_overprov_space
restore-step-ids = {0x1103067B:64}
restore-step-names = {0x1103067B:perform_restore_installing}
restore-step-uptime = 3137
restore-step-user-progress = 97
[16:26:26.0020-GMT]{3>6} CHECKPOINT BEGIN: (null):[0x0628] install_kernel_cache
restore-step-ids = {0x1103067B:64;0x11030628:105}
restore-step-names = {0x1103067B:perform_restore_installing;0x11030628:install_kernel_cache}
restore-step-uptime = 3138
restore-step-user-progress = 97
[16:26:26.0077-GMT]{3>6} CHECKPOINT BEGIN: SYSTEM:[0x0E00] install_kernel_cache
restore-step-ids = {0x1103067B:64;0x11030628:105;0x11030E00:106}
restore-step-names = {0x1103067B:perform_restore_installing;0x11030628:install_kernel_cache;0x11030E00:install_kernel_cache}
...
.
.
.
......
com.apple.xpc.launchd|2022-11-07 16:42:55.071187 : hello
com.apple.xpc.launchd|2022-11-07 16:42:55.092536 : Darwin Bootstrapper Version 7.0.0: Fri Jun 17 23:50:10 PDT 2022; root:libxpc_executables-2236.140.2~15/launchd/RELEASE_ARM64E
com.apple.xpc.launchd|2022-11-07 16:42:55.093871 : boot-args = debug=0x14e kextlog=0xffff serial=3 -v wdt=-1
com.apple.xpc.launchd|2022-11-07 16:42:55.113840 (system) : entering ondemand mode
com.apple.xpc.launchd|2022-11-07 16:42:55.117355 (system) : created
com.apple.xpc.launchd|2022-11-07 16:42:55.128933 : Doing boot task: fsck
** Checking the container superblock.
Checking the checkpoint with transaction ID 235.
** Checking the object map.
** Checking volume /dev/rdisk0s1s1.
** Checking the APFS volume superblock.
The volume System was formatted by newfs_apfs (1677.41.3.100.4) and last modified by apfs_kext (1934.142.1).
warning: apfs superblock at index 0: apfs_unmount_time (1667839430974954666) is greater than current time (1667839377956999000)
warning: apfs superblock at index 0: apfs_last_mod_time (1667839382659444541) is greater than current time (1667839377956999000)
warning: apfs superblock at index 0: apfs_modified_by[0].timestamp (1667839430974853041) is greater than current time (1667839377956999000)
** Checking volume /dev/rdisk0s1s2.
** Checking the APFS volume superblock.
The volume Data was formatted by newfs_apfs (1934.142.1) and last modified by apfs_kext (1934.142.1).
warning: apfs superblock at index 1: apfs_unmount_time (1667839430819765666) is greater than current time (1667839377958672000)
warning: apfs superblock at index 1: apfs_modified_by[0].timestamp (1667839430819550208) is greater than current time (1667839377958672000)
** Checking volume /dev/rdisk0s1s3.
** Checking the APFS volume superblock.
The volume Hardware was formatted by newfs_apfs (1934.142.1) and last modified by apfs_kext (1934.142.1).
warning: apfs superblock at index 2: apfs_unmount_time (1667839430918759583) is greater than current time (1667839377959462000)
warning: apfs superblock at index 2: apfs_modified_by[0].timestamp (1667839430918578666) is greater than current time (1667839377959462000)
** Checking volume /dev/rdisk0s1s4.
** Checking the APFS volume superblock.
The volume Preboot was formatted by newfs_apfs (1934.142.1) and last modified by apfs_kext (1934.142.1).
** Checking volume /dev/rdisk0s1s5.
** Checking the APFS volume superblock.
The volume Update was formatted by newfs_apfs (1934.142.1) and last modified by apfs_kext (1934.142.1).
warning: apfs superblock at index 4: apfs_unmount_time (1667839430873470958) is greater than current time (1667839377961012000)
warning: apfs superblock at index 4: apfs_last_mod_time (1667839393517862208) is greater than current time (1667839377961012000)
warning: apfs superblock at index 4: apfs_modified_by[0].timestamp (1667839430873320541) is greater than current time (1667839377961012000)
** QUICKCHECK ONLY; FILESYSTEM CLEAN
com.apple.xpc.launchd|2022-11-07 16:42:58.010219 : Doing boot task: mount-phase-1
mount: found boot container: /dev/disk0s1, data volume: /dev/disk0s1s2 env: 1
apfs_log_mount_unmount:1889: disk0s1s4 mounting volume Preboot, requested by: mount_apfs (pid 5); parent: mount (pid 4)
handle_mount:655: disk0s1s4 vol-uuid: 61706673-7575-6964-0010-766F6C756D03 block size: 4096 block count: 8388597 (unencrypted; flags: 0x1; features: 8.0.2)
handle_mount:668: disk0s1s4 setting dev block size to 4096 from 512
nx_volume_group_update:7756: disk0s1s4 Volume Preboot role 10 Not a System or data volume
fastsim_is_enabled:9717: ================ fastsim is enabled ================
/dev/disk0s1s4 on /private/preboot (apfs, local, nodev, nosuid, read-only, journaled, noatime, nobrowse)
com.apple.xpc.launchd|2022-11-07 16:42:58.231961 : Doing boot task: data-protection
004199.479666 AppleT8027USBXDCI@: AppleUSBXDCIARM::start: _ioPort is NULL, defaulting to device mode
004199.480656 AppleT8027USBXDCI@: IOUSBDeviceController::prepareDefaults: model iPhone version 12.1
init_data_protection: No SEP present on this device
com.apple.xpc.launchd|2022-11-07 16:42:58.496335 : Doing boot task: finish-obliteration
Obliterator: In INIT check
Mon Nov 7 16:42:58 2022: checkOblitNVRAMkey: IORegistryEntryGetProperty failed, may be does not exist [gF: 0x0000000000000000]
Obliterator: No obliteration needed, continue booting, returning 0
com.apple.xpc.launchd|2022-11-07 16:42:58.714092 : Doing boot task: commit-boot-mode
com.apple.xpc.launchd|2022-11-07 16:42:58.715133 : boot-mode committed: (null)
com.apple.xpc.launchd|2022-11-07 16:42:58.715891 : Doing boot task: restore-datapartition
com.apple.xpc.launchd|2022-11-07 16:42:58.718806 : restore-datapartition: optional boot task not present
com.apple.xpc.launchd|2022-11-07 16:42:58.719744 : Doing boot task: mount-phase-2
mount: found boot container: /dev/disk0s1, data volume: /dev/disk0s1s2 env: 1
spaceman_metazone_init:191: disk0s1 metazone for device 0 of size 262143 blocks (encrypted: 8126454-8257525 unencrypted: 8257525-8388597)
spaceman_datazone_init:625: disk0s1 allocation zone on dev 0 for allocations of 1 blocks starting at paddr 4096000
spaceman_datazone_init:625: disk0s1 allocation zone on dev 0 for allocations of 2 blocks starting at paddr 32768
spaceman_datazone_init:625: disk0s1 allocation zone on dev 0 for allocations of 3 blocks starting at paddr 65536
spaceman_datazone_init:625: disk0s1 allocation zone on dev 0 for allocations of 4 blocks starting at paddr 98304
dev_dump:256: Aggregate constructed: dev= di=0 dv_num_slice=15 dv_num_slice_blk=589824 dv_num_lslice_blk=131061
migrate_media_keys_if_needed:1255: disk0s1 no media keys to migrate
spaceman_scan_free_blocks:3172: disk0s1 scan took 0.026907 s (no trims)
mount: failed to migrate Media Keys, error = c002
spaceman_scan_free_blocks:3154: disk0s1 scan took 0.083568 s, trims took 0.054730 s
spaceman_scan_free_blocks:3156: disk0s1 6193755 blocks free in 3142 extents
spaceman_scan_free_blocks:3164: disk0s1 6193755 blocks trimmed in 3142 extents (17 us/trim, 57409 trims/s)
spaceman_scan_free_blocks:3167: disk0s1 trim distribution 1:1086 2+:631 4+:1036 16+:297 64+:43 256+:49
apfs_log_mount_unmount:1889: disk0s1s2 mounting volume Data, requested by: mount_apfs (pid 10); parent: mount (pid 9)
handle_mount:655: disk0s1s2 vol-uuid: 61706673-7575-6964-0040-766F6C756D01 block size: 4096 block count: 8388597 (unencrypted; flags: 0x1; features: 8.0.2)
handle_mount:668: disk0s1s2 setting dev block size to 4096 from 512
nx_volume_group_update:7762: disk0s1s2 Volume Data is not in a volume group
fastsim_is_enabled:9717: ================ fastsim is enabled ================
/dev/disk0s1s2 on /private/var (apfs, local, nodev, nosuid, journaled, noatime)
apfs_log_mount_unmount:1889: disk0s1s5 mounting volume Update, requested by: mount_apfs (pid 11); parent: mount (pid 9)
handle_mount:655: disk0s1s5 vol-uuid: AEF563AB-7E6C-4E08-BF64-754460DCA1E8 block size: 4096 block count: 8388597 (unencrypted; flags: 0x1; features: 8.0.2)
handle_mount:668: disk0s1s5 setting dev block size to 4096 from 512
nx_volume_group_update:7756: disk0s1s5 Volume Update role c0 Not a System or data volume
fastsim_is_enabled:9717: ================ fastsim is enabled ================
/dev/disk0s1s5 on /private/var/MobileSoftwareUpdate (apfs, local, nodev, nosuid, journaled, noatime, nobrowse)
apfs_log_mount_unmount:1889: disk0s1s3 mounting volume Hardware, requested by: mount_apfs (pid 12); parent: mount (pid 9)
handle_mount:655: disk0s1s3 vol-uuid: 61706673-7575-6964-0140-766F6C756D02 block size: 4096 block count: 8388597 (unencrypted; flags: 0x1; features: 8.0.2)
handle_mount:668: disk0s1s3 setting dev block size to 4096 from 512
nx_volume_group_update:7756: disk0s1s3 Volume Hardware role 140 Not a System or data volume
fastsim_is_enabled:9717: ================ fastsim is enabled ================
/dev/disk0s1s3 on /private/var/hardware (apfs, local, nodev, nosuid, journaled, noatime, nobrowse)
com.apple.xpc.launchd|2022-11-07 16:42:59.160131 : Doing boot task: init-with-data-volume
com.apple.xpc.launchd|2022-11-07 16:42:59.318433 : Doing boot task: MSUEarlyBootTask
MSUEarlyBootTask: MSUEarlyBootTask running
main: Content from the ramdisk will be present at /private/var/MobileSoftwareUpdate//158e4be1ac4c894fdf8a8821e5b8a9d37dc8caabee9d3aee29b1bda284278581cb0eff4702f1862d0352d1b488f74675-MSUData if it exists
MSUEarlyBootTask: I have nothing to do. Goodbye!!
com.apple.xpc.launchd|2022-11-07 16:42:59.776932 : Doing boot task: fips
Tracing: disabled
FIPSPOST_USER [100824457634] fipspost_post:156: [FIPSPOST][Module-ID] Apple corecrypto Module v12.0 [Apple ARM, User, Software, SL1]
FIPSPOST_USER [100824650780] fipspost_post:160: PASSED: (8 ms) - fipspost_post_hmac
FIPSPOST_USER [100824894487] fipspost_post:169: PASSED: (18 ms) - fipspost_post_integrity
FIPSPOST_USER [100824935634] fipspost_post:175: PASSED: (19 ms) - fipspost_post_indicator
FIPSPOST_USER [100824947487] fipspost_post:176: PASSED: (20 ms) - fipspost_post_aes_ecb
FIPSPOST_USER [100824958682] fipspost_post:177: PASSED: (20 ms) - fipspost_post_aes_cbc
FIPSPOST_USER [100825359292] fipspost_post:178: PASSED: (37 ms) - fipspost_post_rsa_sig
FIPSPOST_USER [100826777195] fipspost_post:179: PASSED: (96 ms) - fipspost_post_ecdsa
FIPSPOST_USER [100826852780] fipspost_post:180: PASSED: (99 ms) - fipspost_post_ecdh
FIPSPOST_USER [100826880634] fipspost_post:181: PASSED: (100 ms) - fipspost_post_aes_ccm
FIPSPOST_USER [100826898317] fipspost_post:182: PASSED: (101 ms) - fipspost_post_aes_cmac
FIPSPOST_USER [100826909853] fipspost_post:183: PASSED: (102 ms) - fipspost_post_hkdf
FIPSPOST_USER [100827857829] fipspost_post:184: PASSED: (141 ms) - fipspost_post_pbkdf
FIPSPOST_USER [100827870000] fipspost_post:186: PASSED: (142 ms) - fipspost_post_kdf_ctr
FIPSPOST_USER [100827890317] fipspost_post:187: PASSED: (143 ms) - fipspost_post_aes_gcm
FIPSPOST_USER [100827904000] fipspost_post:188: PASSED: (143 ms) - fipspost_post_aes_xts
FIPSPOST_USER [100827924536] fipspost_post:189: PASSED: (144 ms) - fipspost_post_tdes_ecb
FIPSPOST_USER [100827936292] fipspost_post:190: PASSED: (144 ms) - fipspost_post_drbg_ctr
FIPSPOST_USER [100827955170] fipspost_post:191: PASSED: (145 ms) - fipspost_post_drbg_hmac
FIPSPOST_USER [100828878634] fipspost_post:193: PASSED: (184 ms) - fipspost_post_ffdh
FIPSPOST_USER [100829503609] fipspost_post:194: PASSED: (210 ms) - fipspost_post_rsa_enc_dec
FIPSPOST_USER [100829507878] fipspost_post:213: all tests PASSED (210 ms)
com.apple.xpc.launchd|2022-11-07 16:43:00.043536 : Doing boot task: keybag
****** DIAGNOSTICS MODE ENABLED, SKIP INIT ****
com.apple.xpc.launchd|2022-11-07 16:43:00.287765 : Doing boot task: usermanagerd
com.apple.xpc.launchd|2022-11-07 16:43:00.290833 : usermanagerd: optional boot task not present
com.apple.xpc.launchd|2022-11-07 16:43:00.291798 : Doing boot task: dirs_cleaner
com.apple.xpc.launchd|2022-11-07 16:43:00.358583 : launchd logging initialized. name: com.apple.xpc.launchd pid: 1
com.apple.xpc.launchd|2022-11-07 16:43:00.358650 : Doing boot task: xpcroleaccountd
com.apple.xpc.launchd|2022-11-07 16:43:00.433287 : Doing boot task: init_featureflags
com.apple.xpc.launchd|2022-11-07 16:43:01.238400 : Doing boot task: auearlyboot
auearlyboot: -FudEarlyBoot doFUDEarlyBoot:: Starting Early Boot
auearlyboot: -[AppleFirmwareUpdateController getEarlyBootListInternal:]: Pending critical earlyBoot entries (
)
auearlyboot: No Early Boot Accessories
auearlyboot: -[FudEarlyBoot calculateTimeTakenForEarlyBootEntries] Time Taken to wait for critical earlyBoot entries: 0.000000 sec
auearlyboot: -FudEarlyBoot doFUDEarlyBoot:: End Early Boot
auearlyboot: Exitng Early Boot
com.apple.xpc.launchd|2022-11-07 16:43:01.444135 : Doing boot task: tzinit
tzinit: Bad zoneinfo link : No such file or directory
tzinit: Invalid current symlinks; resetting to system partition: No such file or directory
com.apple.xpc.launchd|2022-11-07 08:43:01.524173 : Doing boot task: finish-restore
com.apple.xpc.launchd|2022-11-07 08:43:01.570622 : Doing boot task: finish-demo-restore
com.apple.xpc.launchd|2022-11-07 08:43:01.642349 : Doing boot task: sysstatuscheck
com.apple.xpc.launchd|2022-11-07 08:43:01.695850 : Doing boot task: prng_seedctl
kern.prng.user_reseed_count: (-1) (2) No such file or directory
failed to load kernel prng seed: (-76) (2) No such file or directory
failed to load virtual random: (-147) (-536870212)
com.apple.xpc.launchd|2022-11-07 08:43:01.757679 : Doing boot task: launchd_cache_loader
0 Found valid port: 4867 Valid: 1
1 Found valid port: 0 Valid: 0
2 Found valid port: 0 Valid: 0
Using default cache paths
Code: /System/Library/xpc/launchd.plist Sig: /System/Library/xpc/launchd.plist.sig
static IOReturn AppleMobileFileIntegrityUserClient::isCdhashInTrustCache(OSObject *, void *, IOExternalMethodArguments *): Process 26 is checking if a cdhash is in the trust cache
static IOReturn AppleMobileFileIntegrityUserClient::isCdhashInTrustCache(OSObject *, void *, IOExternalMethodArguments *): Returning IOReturn 0x0 to process 26
cdhash: {length = 20, bytes = 0x505a58928f6f4b560b5f7eb86b0fe5cd5681ff39} is trusted
Attached signature to file, checking ...
Trying to send bytes to launchd: 4867 16384
Sending validated cache to launchd
Cache sent to launchd successfully
com.apple.xpc.launchd|2022-11-07 08:43:02.459016 : launchd UUID: DC5BEC0B-5E1A-30A2-83B3-6D2FCF01641A
com.apple.xpc.launchd|2022-11-07 08:43:02.459164 : Early boot complete. Continuing system boot.
004209.160316 AppleOLYHAL_log.A[1] AppleOLYHALPortInterfacePCIeAMFM::initWithProvider: amfm not matched
004209.164456 wlan0.A[4] deferredStart@2755: Lowered adjustBusy(-1), getBusyState() -> 4
deferred rematching count

@TrungNguyen1909
Copy link
Owner

How come you cut off the most important part of your output...

My best guess is that it tries to seal the system volume, but we cant do that right now without SEP.

One possible workaround is to use https://github.com/iSuns9/restored_external64patcher to patch out the steps, but I cant provide you support with that for now.

@0nenZer0
Copy link
Author

0nenZer0 commented Nov 8, 2022

Hi @TrungNguyen1909,

Sorry for that lacking info, you are correct it fails to seal the system volume.

===QEMU arch linux idevicerestore debug log===
estore-step-error = {0x1107068B:"[0]D(failed to seal system volume.)[1]D(img4_firmware_execute failed)"}
restore-step-uptime = 2134
restore-step-user-progress = 97

I will take a look on how to implement restored_external64patcher. Will share if can move forward :)

Thanks..

@0nenZer0
Copy link
Author

0nenZer0 commented Nov 8, 2022

Hi @TrungNguyen1909, restore successful after implementing restored_external64patcher. Thanks for your input.

================
emu-linux-arch log:

Modifying persistent boot-args (25)
Checkpoint 1593 complete with code 0
Checkpoint 10964841237974091358 complete with code 0
Checkpoint 1672 complete with code 0
Checkpoint 1659 complete with code 0
Checkpoint 5632 complete with code 0
Checkpoint 1599 complete with code 0
Checkpoint 1600 complete with code 0
Checkpoint 1675 complete with code 0
Checkpoint 1641 complete with code 0
Unmounting filesystems (29)
Unmounting filesystems (29)
Unmounting filesystems (29)
Unmounting filesystems (29)
Unmounting filesystems (29)
Checkpoint 1602 complete with code 0
FDR 0x5558af664ca0 timeout waiting for command
FDR 0x5558af664ca0 waiting for message...
Checkpoint 1660 complete with code 0
Checkpoint 5651 complete with code 0
Checkpoint 1607 complete with code 0
Got status message
Status: Restore Finished
FDR 0x5558af664ca0 terminating...
Cleaning up...
DONE
progress: 6 1.000000
[arch@archlinux ~]$

==================
qemu-ios log:

auearlyboot: -FudEarlyBoot doFUDEarlyBoot:: Starting Early Boot
auearlyboot: -[AppleFirmwareUpdateController getEarlyBootListInternal:]: Pending critical earlyBoot entries (
)
auearlyboot: No Early Boot Accessories
auearlyboot: -[FudEarlyBoot calculateTimeTakenForEarlyBootEntries] Time Taken to wait for critical earlyBoot entries: 0.000000 sec
auearlyboot: -FudEarlyBoot doFUDEarlyBoot:: End Early Boot
auearlyboot: Exitng Early Boot
com.apple.xpc.launchd|2022-11-08 15:35:34.075218 : Doing boot task: tzinit
tzinit: Bad zoneinfo link : No such file or directory
tzinit: Invalid current symlinks; resetting to system partition: No such file or directory
com.apple.xpc.launchd|2022-11-08 07:35:34.158461 : Doing boot task: finish-restore
com.apple.xpc.launchd|2022-11-08 07:35:34.207205 : Doing boot task: finish-demo-restore
com.apple.xpc.launchd|2022-11-08 07:35:34.280739 : Doing boot task: sysstatuscheck
com.apple.xpc.launchd|2022-11-08 07:35:34.337059 : Doing boot task: prng_seedctl
kern.prng.user_reseed_count: (-1) (2) No such file or directory
failed to load kernel prng seed: (-76) (2) No such file or directory
failed to load virtual random: (-147) (-536870212)
com.apple.xpc.launchd|2022-11-08 07:35:34.399308 : Doing boot task: launchd_cache_loader
0 Found valid port: 2307 Valid: 1
1 Found valid port: 0 Valid: 0
2 Found valid port: 0 Valid: 0
Using default cache paths
Code: /System/Library/xpc/launchd.plist Sig: /System/Library/xpc/launchd.plist.sig
static IOReturn AppleMobileFileIntegrityUserClient::isCdhashInTrustCache(OSObject *, void *, IOExternalMethodArguments *): Process 27 is checking if a cdhash is in the trust cache
static IOReturn AppleMobileFileIntegrityUserClient::isCdhashInTrustCache(OSObject *, void *, IOExternalMethodArguments *): Returning IOReturn 0x0 to process 27
cdhash: {length = 20, bytes = 0x505a58928f6f4b560b5f7eb86b0fe5cd5681ff39} is trusted
Attached signature to file, checking ...
Trying to send bytes to launchd: 2307 16384
Sending validated cache to launchd
Cache sent to launchd successfully
com.apple.xpc.launchd|2022-11-08 07:35:35.006348 : launchd UUID: DC5BEC0B-5E1A-30A2-83B3-6D2FCF01641A
com.apple.xpc.launchd|2022-11-08 07:35:35.006510 : Early boot complete. Continuing system boot.
002878.676254 AppleOLYHAL_log.A[1] AppleOLYHALPortInterfacePCIeAMFM::initWithProvider: amfm not matched
002878.680703 wlan0.A[4] deferredStart@2755: Lowered adjustBusy(-1), getBusyState() -> 4
deferred rematching count 0

Any more good stuff after this? ,

Sign up for free to subscribe to this conversation on GitHub. Already have an account? Sign in.
Labels
None yet
Projects
None yet
Development

No branches or pull requests

2 participants