search

libimobiledevice / idevicerestore

Restore/upgrade firmware of iOS devices
https://libimobiledevice.org
GNU Lesser General Public License v3.0
1.33k stars 392 forks source link

Could not restore iphone XS #262

Closed decembersake closed 5 years ago

decembersake commented 5 years ago

Hello I am having trouble restoring my iphone which is now in recovery mode loop. Any advice to solve this problem? I know that there's not enough space on the device but I do not have any backup and desperate to recover all photos, videos, record and etc. Please help to solve this error. (If there's any way to mount recovery mode iphone as memory device in Mac OS, please let me know the command.)

ramrod_display_set_granular_progress_forced: 31.000000 ASR RESTORE PROGRESS: 92% ramrod_display_set_granular_progress_forced: 31.000000 ASR RESTORE PROGRESS: 94% ramrod_display_set_granular_progress_forced: 32.000000 ASR STATUS: fail ASR: Could not restore - No space left on device ASR STATUS: fail restore_apfs_image : failed to restore an APFS image, error = 14 [12:46:10.0690-GMT]{3>7} CHECKPOINT FAILURE:(FAILURE:14) RESTORED:[0x065B] asr_and_invert_image [0]D(failed to restore APFS image) restore-step-results = {0x1107065B:{0:14}} restore-step-codes = {0x1107065B:{0:14}} restore-step-domains = {0x1107065B:{0:"AMRestoreErrorDomain"}} restore-step-error = {0x1107065B:"[0]D(failed to restore APFS image)"} restore-step-uptime = 140 restore-step-user-progress = 32 [12:46:10.0695-GMT]{3>7} CHECKPOINT NOTICE: (NVRAM set) restore-step-user-progress=32 [sync=true] (first failure) [12:46:10.0695-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0647] cleanup_check_result restore-step-ids = {0x1103065B:47;0x11030647:48} restore-step-names = {0x1103065B:asr_and_invert_image;0x11030647:cleanup_check_result} restore-step-uptime = 140 restore-step-user-progress = 32 [12:46:10.0698-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0647] cleanup_check_result restore-step-ids = {0x1103065B:47} restore-step-names = {0x1103065B:asr_and_invert_image} restore-step-uptime = 140 restore-step-user-progress = 32 [12:46:10.0702-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0648] cleanup_send_final_status restore-step-ids = {0x1103065B:47;0x11030648:49} restore-step-names = {0x1103065B:asr_and_invert_image;0x11030648:cleanup_send_final_status} restore-step-uptime = 140 restore-step-user-progress = 32

ERROR: Unable to restore device

decembersake commented 5 years ago

`Found device in Recovery mode Identified device as d321ap, iPhone11,2 The following firmwares are currently being signed for iPhone11,2: [1] 12.3.1 (build 16F203) [2] 12.3 (build 16F156) Select the firmware you want to restore: 2 Selected firmware 12.3 (build 16F156) Downloading firmware (http://updates-http.cdn-apple.com/2019SpringFCS/fullrestores/041-61681/B8D99728-71E2-11E9-B014-F483412A1E9F/iPhone11,2_12.3_16F156_Restore.ipsw) downloading: 1% downloading: 2% downloading: 3% downloading: 4% downloading: 5% downloading: 6% downloading: 7% downloading: 8% downloading: 9% downloading: 10% downloading: 11% downloading: 12% downloading: 13% downloading: 14% downloading: 15% downloading: 16% downloading: 17% downloading: 18% downloading: 19% downloading: 20% downloading: 21% downloading: 22% downloading: 23% downloading: 24% downloading: 25% downloading: 26% downloading: 27% downloading: 28% downloading: 29% downloading: 30% downloading: 31% downloading: 32% downloading: 33% downloading: 34% downloading: 35% downloading: 36% downloading: 37% downloading: 38% downloading: 39% downloading: 40% downloading: 41% downloading: 42% downloading: 43% downloading: 44% downloading: 45% downloading: 46% downloading: 47% downloading: 48% downloading: 49% downloading: 50% downloading: 51% downloading: 52% downloading: 53% downloading: 54% downloading: 55% downloading: 56% downloading: 57% downloading: 58% downloading: 59% downloading: 60% downloading: 61% downloading: 62% downloading: 63% downloading: 64% downloading: 65% downloading: 66% downloading: 67% downloading: 68% downloading: 69% downloading: 70% downloading: 71% downloading: 72% downloading: 73% downloading: 74% downloading: 75% downloading: 76% downloading: 77% downloading: 78% downloading: 79% downloading: 80% downloading: 81% downloading: 82% downloading: 83% downloading: 84% downloading: 85% downloading: 86% downloading: 87% downloading: 88% downloading: 89% downloading: 90% downloading: 91% downloading: 92% downloading: 93% downloading: 94% downloading: 95% downloading: 96% downloading: 97% downloading: 98% downloading: 99%

Verifying 'iPhone11,2_12.3_16F156_Restore.ipsw'... Checksum matches. Extracting BuildManifest from IPSW Product Version: 12.3 Product Build: 16F156 Major: 16 INFO: device serial number is DNPX9193KPG4 Device supports Image4: true Variant: Customer Upgrade Install (IPSW) This restore will update your device without losing data. Checking IPSW for required components... All required components found in IPSW Extracting filesystem from IPSW: 048-43159-178.dmg [==================================================] 100.0% Found ECID 4909083227848750 Getting ApNonce in recovery mode... d8 45 b5 75 49 de 57 19 ae 8d 68 29 cc a7 0e ff 31 78 e8 53 24 88 98 11 db 40 e2 d3 30 3e f3 7f Trying to fetch new SHSH blob Getting SepNonce in recovery mode... 6f 92 3b 84 cb 15 76 78 03 4b e0 cb de f1 ca 62 9f a6 3d a8 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 Extracting iBEC.d321.RELEASE.im4p... Personalizing IMG4 component iBEC... Sending iBEC (1063306 bytes)... Recovery Mode Environment: iBoot build-version=iBoot-4513.260.81 iBoot build-style=RELEASE Sending RestoreLogo... Extracting applelogo@3x~iphone.im4p... Personalizing IMG4 component RestoreLogo... Sending RestoreLogo (20910 bytes)... Extracting h11_ane_fw_quin.im4p... Personalizing IMG4 component ANE... Sending ANE (9394706 bytes)... Extracting aopfw-iphone11aop.im4p... Personalizing IMG4 component AOP... Sending AOP (1396234 bytes)... Extracting AppleAVE2FW.im4p... Personalizing IMG4 component AVE... Sending AVE (1111370 bytes)... Extracting armfw_g11p.im4p... Personalizing IMG4 component GFX... Sending GFX (1555834 bytes)... Extracting adc-petra-d3x.im4p... Personalizing IMG4 component ISP... Sending ISP (14639242 bytes)... Extracting 048-43107-180.dmg.trustcache... Personalizing IMG4 component RestoreTrustCache... Sending RestoreTrustCache (11671 bytes)... Extracting SmartIOFirmwareT8020.im4p... Personalizing IMG4 component SIO... Sending SIO (1356094 bytes)... Extracting WirelessPower.iphone11.im4p... Personalizing IMG4 component WCHFirmwareUpdater... Sending WCHFirmwareUpdater (28773 bytes)... ramdisk-size=0x20000000 Extracting 048-43107-180.dmg... Personalizing IMG4 component RestoreRamDisk... Sending RestoreRamDisk (93872653 bytes)... Extracting DeviceTree.d321ap.im4p... Personalizing IMG4 component RestoreDeviceTree... Sending RestoreDeviceTree (193792 bytes)... Extracting kernelcache.release.iphone11... Personalizing IMG4 component RestoreKernelCache... Sending RestoreKernelCache (17958779 bytes)... About to restore device... Waiting for device... Device 00008020-001170C901F8002E is now connected in restore mode... Connecting now... Connected to com.apple.mobile.restored, version 15 Device 00008020-001170C901F8002E has successfully entered restore mode Hardware Information: BoardID: 14 ChipID: 32800 UniqueChipID: 4909083227848750 ProductionMode: true Previous restore exit status: 0x100 Starting FDR listener thread About to send NORData... Found firmware path Firmware/all_flash Getting firmware manifest from build identity Extracting LLB.d321.RELEASE.im4p... Personalizing IMG4 component LLB... Extracting applelogo@3x~iphone.im4p... Personalizing IMG4 component AppleLogo... Extracting batterycharging0@3x~iphone.im4p... Personalizing IMG4 component BatteryCharging0... Extracting batterycharging1@3x~iphone.im4p... Personalizing IMG4 component BatteryCharging1... Extracting batteryfull@3x~iphone.im4p... Personalizing IMG4 component BatteryFull... Extracting batterylow0@3x~iphone.im4p... Personalizing IMG4 component BatteryLow0... Extracting batterylow1@3x~iphone.im4p... Personalizing IMG4 component BatteryLow1... Extracting glyphplugin@2436~iphone-lightning.im4p... Personalizing IMG4 component BatteryPlugin... Extracting DeviceTree.d321ap.im4p... Personalizing IMG4 component DeviceTree... Extracting liquiddetect@2436~iphone-lightning.im4p... Personalizing IMG4 component Liquid... Extracting lowpowermode@2436~iphone-lightning.im4p... Personalizing IMG4 component LowPowerWallet0... Extracting recoverymode@2436~iphone-lightning.im4p... Personalizing IMG4 component RecoveryMode... Extracting iBoot.d321.RELEASE.im4p... Personalizing IMG4 component iBoot... Extracting sep-firmware.d321.RELEASE.im4p... Personalizing IMG4 component RestoreSEP... Extracting sep-firmware.d321.RELEASE.im4p... Personalizing IMG4 component SEP... Sending NORData now... Done sending NORData About to send RootTicket... Sending RootTicket now... Done sending RootTicket Waiting for NAND (28) Updating S3E Firmware (58) Checking filesystems (15) Checking filesystems (15) About to send FDR Trust data... Sending FDR Trust data now... Done sending FDR Trust Data Unmounting filesystems (29) Unmounting filesystems (29) Unmounting filesystems (29) Unmounting filesystems (29) Unmounting filesystems (29) Creating filesystem (12) About to send filesystem... Connected to ASR Validating the filesystem Filesystem validated Sending filesystem now... [================================================ ] 94.0%ERROR: Unable to send data to ASR. Sent 0 of 1450 bytes. ERROR: Unable to send filesystem payload ERROR: Unable to send payload to ASR ERROR: Unable to send filesystem ERROR: Unable to successfully restore device Got status message Status: Fail Log is available: SYSLOG: May 31 12:43:50 localhost bootlog[0] : BOOT_TIME 1559306630 552520 [12:43:51.0341-GMT]{3>7} CHECKPOINT NOTICE: Image4 device: AP nonce clearable entering ramrod_clear_ap_nonce [12:43:51.0354-GMT]{3>7} CHECKPOINT NOTICE: AP nonce consumed [12:43:51.0355-GMT]{3>7} CHECKPOINT NOTICE: Pre-existing NVRAM variable: auto-boot=false [12:43:51.0356-GMT]{3>7} CHECKPOINT NOTICE: Pre-existing NVRAM variable: restore-outcome=initial_monitor_no_return [12:43:51.0357-GMT]{3>7} CHECKPOINT PROGRESS: START (unknown) -> (initial_engine_no_return) [12:43:51.0357-GMT]{3>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 [12:43:51.0369-GMT]{3>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 [12:43:51.0372-GMT]{3>7} CHECKPOINT END: MAIN:[0x0400] umask restore-step-ids = {} restore-step-names = {} restore-step-uptime = 1 restore-step-user-progress = -1 [12:43:51.0375-GMT]{3>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 [12:43:51.0377-GMT]{3>7} CHECKPOINT END: MAIN:[0x0402] setvbuf restore-step-ids = {} restore-step-names = {} restore-step-uptime = 1 restore-step-user-progress = -1 [12:43:51.0380-GMT]{3>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 [12:43:51.0382-GMT]{3>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 [12:43:51.0386-GMT]{3>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: primary display-scale = 3 display-rotation = 0 found applelogo at /usr/share/progressui/applelogo@3x.tga display: 1125 x 2436 powering on display ramrod_display_set_granular_progress_forced: 0.000000 [12:43:51.0409-GMT]{3>7} CHECKPOINT END: MAIN:[0x0406] set_progress_0 restore-step-ids = {} restore-step-names = {} restore-step-uptime = 1 restore-step-user-progress = 0 [12:43:51.0412-GMT]{3>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 [12:43:51.0415-GMT]{3>7} CHECKPOINT WARNING: MAIN:[0x0407] gasgauge_start_update_thread failed: -1 [12:43:51.0416-GMT]{3>7} CHECKPOINT END: MAIN:[0x0407] start_gasgauge_thread restore-step-ids = {} restore-step-names = {} restore-step-warnings = {0x11060407:{0:"gasgauge_start_update_thread failed: -1"}} restore-step-uptime = 1 restore-step-user-progress = 0 [12:43:51.0419-GMT]{3>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 [12:43:51.0422-GMT]{3>7} CHECKPOINT END: MAIN:[0x0408] listen_for_log_client restore-step-ids = {} restore-step-names = {} restore-step-uptime = 1 restore-step-user-progress = 0 [12:43:51.0425-GMT]{3>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 [12:43:51.0427-GMT]{3>7} CHECKPOINT END: MAIN:[0x040D] create_listen_socket restore-step-ids = {} restore-step-names = {} restore-step-uptime = 1 restore-step-user-progress = 0 [12:43:51.0430-GMT]{3>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 [12:43:51.0433-GMT]{3>7} CHECKPOINT END: MAIN:[0x0404] update_root_mount restore-step-ids = {} restore-step-names = {} restore-step-uptime = 1 restore-step-user-progress = 0 [12:43:51.0435-GMT]{3>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 [12:43:51.0440-GMT]{3>7} CHECKPOINT END: MAIN:[0x0405] disable_watchdog restore-step-ids = {} restore-step-names = {} restore-step-uptime = 1 restore-step-user-progress = 0 [12:43:51.0443-GMT]{3>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 0x1051064f0 [0x10135f940]>{type = mutable dict, count = 1, entries => 0 : <CFString 0x1015f82a0 [0x10135f940]>{contents = "IOProviderClass"} = <CFString 0x1051066f0 [0x10135f940]>{contents = "AppleUSBDeviceMux"} }

[12:43:54.0453-GMT]{3>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(10, 4) failed: connection closed recv(8, 4) failed: connection closed unable to read message size: -1 could not receive message recv(11, 4) failed: connection closed unable to read message size: -1 could not receive message unable to read message size: -1 could not receive message recv(13, 4) failed: connection closed unable to read message size: -1 could not receive message recv(11, 4) failed: connection closed unable to read message size: -1 recv(8, 4) failed: connection closed unable to read message size: -1 could not receive message recv(10, 4) failed: connection closed could not receive message recv(15, 4) failed: connection closed unable to read message size: -1 could not receive message recv(12, 4) failed: connection closed unable to read message size: -1 could not receive message unable to read message size: -1 recv(11, 4) failed: connection closed unable to read message size: -1 could not receive message recv(13, 4) failed: connection closed recv(15, 4) failed: connection closed unable to read message size: -1 could not receive message recv(16, 4) failed: connection closed unable to read message size: -1 could not receive message recv(18, 4) failed: connection closed unable to read message size: -1 could not receive message recv(17, 4) failed: connection closed unable to read message size: -1 could not receive message recv(8, 4) failed: connection closed unable to read message size: -1 could not receive message could not receive message recv(15, 4) failed: connection closed unable to read message size: -1 could not receive message recv(12, 4) failed: connection closed unable to read message size: -1 could not receive message recv(11, 4) failed: connection closed unable to read message size: -1 could not receive message recv(13, 4) failed: connection closed unable to read message size: -1 could not receive message recv(16, 4) failed: connection closed unable to read message size: -1 could not receive message unable to read message size: -1 could not receive message recv(19, 4) failed: connection closed recv(11, 4) failed: connection closed unable to read message size: -1 recv(8, 4) failed: connection closed unable to read message size: -1 could not receive message recv(10, 4) failed: connection closed unable to read message size: -1 could not receive message recv(12, 4) failed: connection closed unable to read message size: -1 could not receive message recv(13, 4) failed: connection closed unable to read message size: -1 could not receive message unable to read message size: -1 could not receive message could not receive message recv(8, 4) failed: connection closed unable to read message size: -1 could not receive message recv(10, 4) failed: connection closed unable to read message size: -1 could not receive message [12:43:57.0139-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0600] client_protocol_version restore-step-ids = {0x11030600:11} restore-step-names = {0x11030600:client_protocol_version} restore-step-uptime = 7 restore-step-user-progress = 0 client protocol version 15 [12:43:57.0148-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0600] client_protocol_version restore-step-ids = {} restore-step-names = {} restore-step-uptime = 7 restore-step-user-progress = 0 [12:43:57.0152-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0601] copy_restore_options restore-step-ids = {0x11030601:12} restore-step-names = {0x11030601:copy_restore_options} restore-step-uptime = 7 restore-step-user-progress = 0 unable to open /usr/local/share/restore//options.d321.plist: No such file or directory unable to open /usr/local/share/restore//options.plist: No such file or directory UUID 62E0618A-D36E-C19A-F98E-BD50DDE2D241 Restore options: UUID => <CFString 0x108101120 [0x10135f940]>{contents = "62E0618A-D36E-C19A-F98E-BD50DDE2D241"} TZ0RequiredCapacity => 0xBE00000 PersonalizedDuringPreflight => <CFBoolean 0x1013654f0 [0x10135f940]>{value = true} CreateFilesystemPartitions => <CFBoolean 0x101365508 [0x10135f940]>{value = false} [12:43:57.0164-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0601] copy_restore_options restore-step-ids = {} restore-step-names = {} restore-step-uptime = 7 restore-step-user-progress = 0 [12:43:57.0167-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0655] is_host_compatible restore-step-ids = {0x11030655:13} restore-step-names = {0x11030655:is_host_compatible} restore-step-uptime = 7 restore-step-user-progress = 0 [12:43:57.0169-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0655] is_host_compatible restore-step-ids = {} restore-step-names = {} restore-step-uptime = 7 restore-step-user-progress = 0 [12:43:57.0172-GMT]{3>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 = 7 restore-step-user-progress = 0 [12:43:57.0175-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0604] set_weight_from_options restore-step-ids = {} restore-step-names = {} restore-step-uptime = 7 restore-step-user-progress = 0 [12:43:57.0178-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0608] device_has_hoover restore-step-ids = {0x11030608:15} restore-step-names = {0x11030608:device_has_hoover} restore-step-uptime = 7 restore-step-user-progress = 0 [12:43:57.0182-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0608] device_has_hoover restore-step-ids = {} restore-step-names = {} restore-step-uptime = 7 restore-step-user-progress = 0 [12:43:57.0185-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0609] load_sep_os restore-step-ids = {0x11030609:16} restore-step-names = {0x11030609:load_sep_os} restore-step-uptime = 7 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 (0x10c5b0000 - 7429760) executing /usr/libexec/seputil --restore+art - waiting for child to exit child exited exit status: 0 entering ramrod_wait_for_sep_load executing /usr/libexec/seputil --ping seputil: ping failed executing /usr/libexec/seputil --ping SEP OS is booted [12:44:00.0004-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0609] load_sep_os restore-step-ids = {} restore-step-names = {} restore-step-uptime = 10 restore-step-user-progress = 0 [12:44:00.0007-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x060B] update_ticket restore-step-ids = {0x1103060B:17} restore-step-names = {0x1103060B:update_ticket} restore-step-uptime = 10 restore-step-user-progress = 0 entering ramrod_ticket_update_verify looking up boot manifest hash device tree ticket_hash: B723788F6D1CEB3BD359A638EC0BA91B2169F29C04985B37156AE719AE7DF2F20BFF007112AFD84CA10C4964143739D0 crypto-hash-method found. Using SHA2-384 computed ticket_hash : B723788F6D1CEB3BD359A638EC0BA91B2169F29C04985B37156AE719AE7DF2F20BFF007112AFD84CA10C4964143739D0 received valid ticket (7650 bytes) [12:44:00.0018-GMT]{3>7} CHECKPOINT END: RESTORED:[0x060B] update_ticket restore-step-ids = {} restore-step-names = {} restore-step-uptime = 10 restore-step-user-progress = 0 [12:44:00.0021-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x060D] wait_for_storage restore-step-ids = {0x1103060D:18} restore-step-names = {0x1103060D:wait_for_storage} restore-step-uptime = 10 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: AppleANS2CGNVMeController NAND initialized. Waiting for devnode. [12:44:00.0029-GMT]{3>7} CHECKPOINT END: RESTORED:[0x060D] wait_for_storage restore-step-ids = {} restore-step-names = {} restore-step-uptime = 10 restore-step-user-progress = 0 [12:44:00.0033-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x060E] update_NAND_firmware restore-step-ids = {0x1103060E:19} restore-step-names = {0x1103060E:update_NAND_firmware} restore-step-uptime = 10 restore-step-user-progress = 0 ramrod_display_set_granular_progress_forced: 0.000000 entering update_NAND executing /usr/bin/nvmefwupdater --query S4E/0000001202019313.pak NAND update file: "/usr/standalone/firmware/S4E/0000001202019313.pak" executing /usr/bin/nvmefwupdater --validate /usr/standalone/firmware/S4E/0000001202019313.pak s4e-bfh-params: 50555746 00200001 00204044 004080D9 004080DB 004080DD 004280E6 004680EB 030080FF 805080EC 00060002 100108A8 Performing BFH OFW stage... set_pci_port_state: result=0 set_pci_port_state: result=0 returning Regular update executing /usr/bin/nvmefwupdater --update /usr/standalone/firmware/S4E/0000001202019313.pak Downloading FW... Activating FW... Successfully updated FW... [12:44:05.0769-GMT]{3>7} CHECKPOINT END: RESTORED:[0x060E] update_NAND_firmware restore-step-ids = {} restore-step-names = {} restore-step-uptime = 15 restore-step-user-progress = 0 [12:44:05.0782-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x060F] clear_remap_variable restore-step-ids = {0x1103060F:20} restore-step-names = {0x1103060F:clear_remap_variable} restore-step-uptime = 15 restore-step-user-progress = 0 entering clear_remap_variable executing /usr/sbin/nvram -d enable-remap-mode enable-remap-mode [12:44:05.0824-GMT]{3>7} CHECKPOINT END: RESTORED:[0x060F] clear_remap_variable restore-step-ids = {} restore-step-names = {} restore-step-uptime = 15 restore-step-user-progress = 0 [12:44:05.0828-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x065C] print_nvram_variables restore-step-ids = {0x1103065C:21} restore-step-names = {0x1103065C:print_nvram_variables} restore-step-uptime = 15 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">

auto-boot ZmFsc2U= backlight-level NzQw boot-args boot-breadcrumbs NDcyNjUpIDxCT09UPiAwMDBmMDAwNSg2MTZmNzA2NikgMDAwZjAwMDYgNDAwZjAxMDEg MDAwZjAwMDUoNzM2OTZmNjYpIDAwMGYwMDA2IDQwMGYwMTAxIDAwMGYwMDA1KDYxNmU2 NTY2KSAwMDBmMDAwNiA0MDBmMDEwMSAwMDBmMDAwNSg2MTc2NjU2NikgMDAwZjAwMDYg NDAwZjAxMDEgMDAwZjAwMDUoNjc2Njc4NjYpIDAwMGYwMDA2IDQwMGYwMTAxIDAwMGYw MDA1KDY5NzM3MDY2KSAwMDBmMDAwNiA0MDBmMDEwMSAwMDAzMDAwZig2NDc0NzI2NSkg com.apple.System.tz0-size MHhCRTAwMDAw restore-outcome aW5pdGlhbF9lbmdpbmVfbm9fcmV0dXJu restored-exit-status MHgxMDA= usbcfwflasherResult Tm8gZXJyb3Jz

[12:44:05.0852-GMT]{3>7} CHECKPOINT END: RESTORED:[0x065C] print_nvram_variables restore-step-ids = {} restore-step-names = {} restore-step-uptime = 15 restore-step-user-progress = 0 [12:44:05.0855-GMT]{3>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 = 15 restore-step-user-progress = 0 [12:44:05.0858-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0610] asp_nand_set_writable restore-step-ids = {} restore-step-names = {} restore-step-uptime = 15 restore-step-user-progress = 0 [12:44:05.0861-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0613] find_filesystem_partitions restore-step-ids = {0x11030613:23} restore-step-names = {0x11030613:find_filesystem_partitions} restore-step-uptime = 15 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=/dev/disk0s1s3 log= update= xart= hardware=/dev/disk0s1s4 scratch= [12:44:05.0868-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0613] find_filesystem_partitions restore-step-ids = {} restore-step-names = {} restore-step-uptime = 15 restore-step-user-progress = 0 [12:44:05.0871-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0665] fsck_filesystems restore-step-ids = {0x11030665:24} restore-step-names = {0x11030665:fsck_filesystems} restore-step-uptime = 15 restore-step-user-progress = 0 entering fsck_apfs_container ramrod_display_set_granular_progress_forced: 0.000000 Starting an xpc transaction. executing /System/Library/Filesystems/apfs.fs/fsck_apfs -dyo /dev/disk0s1 Checking the container superblock. Checking the space manager. Checking the space manager free queue trees. Checking the object map. Checking volume. Checking the APFS volume superblock. The volume System was formatted by newfs_apfs (945.260.7) and last modified by apfs_kext (945.260.7). Checking the object map. Checking the snapshot metadata tree. Checking the snapshot metadata. Checking the extent ref tree. Checking the fsroot tree. Checking volume. Checking the APFS volume superblock. The volume Data was formatted by newfs_apfs (748.200.60) and last modified by apfs_kext (945.260.7). Checking the object map. /sbin/mount_apfs -c /dev/disk0s1s2 /private/var dev_init:607: Using /private/var/apfs and /private/var/nx for device-io. Checking the snapshot metadata tree. Checking the snapshot metadata. Checking the extent ref tree. Checking the fsroot tree. Checking volume. Checking the APFS volume superblock. The volume Baseband Data was formatted by newfs_apfs (748.200.60) and last modified by apfs_kext (945.250.134). Checking the object map. Checking the snapshot metadata tree. Checking the snapshot metadata. Checking the extent ref tree. Checking the fsroot tree. Checking volume. Checking the APFS volume superblock. The volume Hardware was formatted by newfs_apfs (748.200.60) and last modified by apfs_kext (945.260.7). Checking the object map. Checking the snapshot metadata tree. Checking the snapshot metadata. Checking the extent ref tree. Checking the fsroot tree. Verifying allocated space. The volume /dev/disk0s1 appears to be OK. fsck succeeded on /dev/disk0s1 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=/dev/disk0s1s3 log= update= xart= hardware=/dev/disk0s1s4 scratch= [12:44:37.0040-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0665] fsck_filesystems restore-step-ids = {} restore-step-names = {} restore-step-uptime = 47 restore-step-user-progress = 0 [12:44:37.0043-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0614] mount_system_partition restore-step-ids = {0x11030614:25} restore-step-names = {0x11030614:mount_system_partition} restore-step-uptime = 47 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 [12:44:37.0067-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0614] mount_system_partition restore-step-ids = {} restore-step-names = {} restore-step-uptime = 47 restore-step-user-progress = 0 [12:44:37.0070-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0654] read_previous_os_build_version restore-step-ids = {0x11030654:26} restore-step-names = {0x11030654:read_previous_os_build_version} restore-step-uptime = 47 restore-step-user-progress = 0 unable to open /mnt1/System/Library/CoreServices/SystemVersion.plist: No such file or directory ramrod_read_previous_os_build_version: Unable to read system version plist [12:44:37.0074-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0654] read_previous_os_build_version restore-step-ids = {} restore-step-names = {} restore-step-uptime = 47 restore-step-user-progress = 0 [12:44:37.0077-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0615] copy_hardware_info restore-step-ids = {0x11030615:27} restore-step-names = {0x11030615:copy_hardware_info} restore-step-uptime = 47 restore-step-user-progress = 0 [12:44:37.0080-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0615] copy_hardware_info restore-step-ids = {} restore-step-names = {} restore-step-uptime = 47 restore-step-user-progress = 0 [12:44:37.0083-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0616] fdr_create restore-step-ids = {0x11030616:28} restore-step-names = {0x11030616:fdr_create} restore-step-uptime = 47 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] : da 30 67 3a 75 24 63 69 94 6f 40 4d 80 6d 7d 7c : 02 ee 52 e3 : ----------------------------------------------- CryptoGenerateRSAKeys: SecKeyCreateRSAPrivateKey -> 0x1004b88f8 CryptoGenerateRSAKeys: SecKeyCreateRSAPublicKey -> 0x1004b88f0 _copyDataInstanceForSealingMapEntry: Using value 0000005E-0A01D1F15DAFE63200000000 for key BasebandUniqueId from query cache _copyDataInstanceForSealingMapEntry: Using value 0000005E-0A01D1F15DAFE63200000000 for key BasebandUniqueId from query cache _copyDataInstanceForSealingMapEntry: Using value 32800 for key ChipID from query cache _copyDataInstanceForSealingMapEntry: Using value 4909083227848750 for key UniqueChipID from query cache _copyDataInstanceForSealingMapEntry: Using value FXR826237XJJNK595+11013104696167073811771913 for key CoverglassSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value 3E-82808872 for key AmbientLightSensorSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x10470cd00 [0x10135f940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x10470cd00 [0x10135f940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x10470cd00 [0x10135f940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x10470cd00 [0x10135f940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x10470cd00 [0x10135f940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x10470cd00 [0x10135f940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x10470cd00 [0x10135f940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x10470cd00 [0x10135f940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x10470cd00 [0x10135f940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x10470cd00 [0x10135f940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x10470cd00 [0x10135f940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x10470cd00 [0x10135f940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x10470cd00 [0x10135f940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x10470cd00 [0x10135f940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value 32800 for key ChipID from query cache _copyDataInstanceForSealingMapEntry: Using value 4909083227848750 for key UniqueChipID from query cache _copyDataInstanceForSealingMapEntry: Using value A4.01-000000000DD0941E6738BCCC50EC0455 for key NFCUniqueChipID from query cache _copyDataInstanceForSealingMapEntry: Using value 32800 for key ChipID from query cache _copyDataInstanceForSealingMapEntry: Using value 4909083227848750 for key UniqueChipID from query cache _copyDataInstanceForSealingMapEntry: Using value 32800 for key ChipID from query cache _copyDataInstanceForSealingMapEntry: Using value 4909083227848750 for key UniqueChipID from query cache _copyDataInstanceForSealingMapEntry: Using value 32800 for key ChipID from query cache _copyDataInstanceForSealingMapEntry: Using value 4909083227848750 for key UniqueChipID from query cache _copyDataInstanceForSealingMapEntry: Using value 32800 for key ChipID from query cache _copyDataInstanceForSealingMapEntry: Using value 4909083227848750 for key UniqueChipID from query cache created HTTP FDR client 0x10512ae80 _copyDataInstanceForSealingMapEntry: Using value 0000005E-0A01D1F15DAFE63200000000 for key BasebandUniqueId from query cache _copyDataInstanceForSealingMapEntry: Using value 0000005E-0A01D1F15DAFE63200000000 for key BasebandUniqueId from query cache _copyDataInstanceForSealingMapEntry: Using value 32800 for key ChipID from query cache _copyDataInstanceForSealingMapEntry: Using value 4909083227848750 for key UniqueChipID from query cache _copyDataInstanceForSealingMapEntry: Using value FXR826237XJJNK595+11013104696167073811771913 for key CoverglassSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value 3E-82808872 for key AmbientLightSensorSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x108102340 [0x10135f940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x108102340 [0x10135f940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x108102340 [0x10135f940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x108102340 [0x10135f940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x108102340 [0x10135f940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x108102340 [0x10135f940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x108102340 [0x10135f940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x108102340 [0x10135f940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x108102340 [0x10135f940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x108102340 [0x10135f940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x108102340 [0x10135f940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x108102340 [0x10135f940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x108102340 [0x10135f940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x108102340 [0x10135f940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value 32800 for key ChipID from query cache _copyDataInstanceForSealingMapEntry: Using value 4909083227848750 for key UniqueChipID from query cache _copyDataInstanceForSealingMapEntry: Using value A4.01-000000000DD0941E6738BCCC50EC0455 for key NFCUniqueChipID from query cache _copyDataInstanceForSealingMapEntry: Using value 32800 for key ChipID from query cache _copyDataInstanceForSealingMapEntry: Using value 4909083227848750 for key UniqueChipID from query cache _copyDataInstanceForSealingMapEntry: Using value 32800 for key ChipID from query cache _copyDataInstanceForSealingMapEntry: Using value 4909083227848750 for key UniqueChipID from query cache _copyDataInstanceForSealingMapEntry: Using value 32800 for key ChipID from query cache _copyDataInstanceForSealingMapEntry: Using value 4909083227848750 for key UniqueChipID from query cache _copyDataInstanceForSealingMapEntry: Using value 32800 for key ChipID from query cache _copyDataInstanceForSealingMapEntry: Using value 4909083227848750 for key UniqueChipID from query cache created local FDR client 0x1081023e0 Received response without expected RESTORED_FDR_TRUST_DATA AMSupportPlatformMakeDirectoryForURL: Could not mkdir (Read-only file system) AMSupportPlatformMakeDirectoryForURL: /mnt1/System AMFDRCreateError: AMFDRDataLocalCopyDataStoragePath: AMSupportMakeDirectory failed: code=4 AMFDRCreateError: AMFDRDataLocalCopy: missing data storage path: code=4 failed to copy trust object from fdrLocal 0: AMFDRError/4: missing data storage path 1: AMFDRError/4: AMSupportMakeDirectory failed Found ramdisk trust object, computing digest.. Ramdisk trust object digest DOES match AP ticket. Not enabling SSO for FDR RestoredFDRCreate() returned 0 FDR is supported on this device [12:44:38.0425-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0616] fdr_create restore-step-ids = {} restore-step-names = {} restore-step-uptime = 48 restore-step-user-progress = 0 [12:44:38.0428-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0617] fdr_save_data restore-step-ids = {0x11030617:29} restore-step-names = {0x11030617:fdr_save_data} restore-step-uptime = 48 restore-step-user-progress = 0 _AMFDRAPTicketHasBooleanEntitlement: no ticket in options AMFDRSealingMapCreateAndPopulateSealedData: populate sealedData with sealing manifest, sealingManifestOverride : (null), forceSealing : (null), allowForbidden : (null), allowUnSeal : 0 AMSupportPlatformMakeDirectoryForURL: Could not mkdir (Read-only file system) AMSupportPlatformMakeDirectoryForURL: /mnt1/System AMFDRCreateError: AMFDRDataLocalCopyDataStoragePath: AMSupportMakeDirectory failed: code=4 AMFDRCreateError: AMFDRDataLocalCopy: missing data storage path: code=4 AMFDRCreateError: AMFDRDataCopy: seal:00008020-001170C901F8002E get data failed - foundData is NULL: code=10 AMFDRCreateError: AMFDRSealingMapPopulateSealingManifest: sealingManifest is NULL: code=10 AMFDRCreateError: AMFDRSealingMapCreateAndPopulateSealedData: AMFDRSealingMapPopulateSealingManifest failed on amfdr: code=10 AMFDRSealedDataRestoreOptions: sealedData is NULL failed to save FDR persistent state RestoredFDRSaveData success [12:44:38.0437-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0617] fdr_save_data restore-step-ids = {} restore-step-names = {} restore-step-uptime = 48 restore-step-user-progress = 0 [12:44:38.0439-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0618] store_baseband_migration restore-step-ids = {0x11030618:30} restore-step-names = {0x11030618:store_baseband_migration} restore-step-uptime = 48 restore-step-user-progress = 0 [12:44:38.0442-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0618] store_baseband_migration restore-step-ids = {} restore-step-names = {} restore-step-uptime = 48 restore-step-user-progress = 0 [12:44:38.0445-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0619] check_for_restore_log restore-step-ids = {0x11030619:31} restore-step-names = {0x11030619:check_for_restore_log} restore-step-uptime = 48 restore-step-user-progress = 0 entering check_for_restore_log restore log does not exist [12:44:38.0449-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0619] check_for_restore_log restore-step-ids = {} restore-step-names = {} restore-step-uptime = 48 restore-step-user-progress = 0 [12:44:38.0452-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x061A] check_for_ota_logs restore-step-ids = {0x1103061A:32} restore-step-names = {0x1103061A:check_for_ota_logs} restore-step-uptime = 48 restore-step-user-progress = 0 entering mount_partition executing /System/Library/Filesystems/apfs.fs/mount_apfs /dev/disk0s1s2 /mnt2 /dev/disk0s1s2 mounted on /mnt2 Data mounted read-write entering dump_and_return_panic_logs entering dump_panic_logs executing /System/Library/CoreServices/DumpPanic -r/mnt2/mobile/Library/Logs/CrashReporter Looking for logs between 1559306678 and 1559306678 entering check_for_ota_logs_with_mount_point Diagnostic log submission disabled Searching /mnt2/mobile/Library/Logs/CrashReporter/ check_for_ota_logs_with_mount_point complete Found log directory(/mnt2/MobileSoftwareUpdate/lastOTA)..Deleting contentsSuccessfully checked for OTA logs [12:44:38.0925-GMT]{3>7} CHECKPOINT END: RESTORED:[0x061A] check_for_ota_logs restore-step-ids = {} restore-step-names = {} restore-step-uptime = 48 restore-step-user-progress = 0 [12:44:38.0928-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x061B] submit_update_stats restore-step-ids = {0x1103061B:33} restore-step-names = {0x1103061B:submit_update_stats} restore-step-uptime = 48 restore-step-user-progress = 0 entering mount_partition executing /sbin/mount -u -w /dev/disk0s1s1 /mnt1 Changed permissions on /dev/disk0s1s1 mounted at /mnt1 to readwrite entering mount_partition Data already mounted read-write (mount ignored) Attempting to update nvram shadow file /mnt2/MobileSoftwareUpdate/nvram.plist ramrod-nvram-shadow-path = /mnt2/MobileSoftwareUpdate/nvram.plist executing /usr/sbin/nvram ramrod-nvram-shadow-path=/mnt2/MobileSoftwareUpdate/nvram.plist ramrod-nvram-session = 1559306630 executing /usr/sbin/nvram ramrod-nvram-session=1559306630 Loaded persistent file: { "OTA-fsck-metrics" = "dev= vers=945.250.134 result=0 fp=0 fl=-1 repairs=0 time=1 iter=1"; "auto-boot" = true; "backlight-level" = <373430>; "boot-args" = ""; "com.apple.System.tz0-size" = 0xBE00000; "ota-breadcrumbs" = "2:pBjDoACEHLKNnlacedTUWXZ"; "ota-outcome" = success; "ota-result" = success; "ota-step-ids" = "{}"; "ota-step-monitor" = "{0x11010207:\"wifexited\"}"; "ota-step-names" = "{}"; "ota-step-uptime" = 216; "ota-step-user-progress" = 100; "ramrod-file-only-vars" = { "OTA-fsck-metrics" = "dev= vers=945.250.134 result=0 fp=0 fl=-1 repairs=0 time=1 iter=1"; "auto-boot" = true; "com.apple.System.tz0-size" = 0xBE00000; "ota-breadcrumbs" = "2:pBjDoACEHLKNnlacedTUWXZ"; "ota-outcome" = success; "ota-result" = success; "ota-step-ids" = "{}"; "ota-step-monitor" = "{0x11010207:\"wifexited\"}"; "ota-step-names" = "{}"; "ota-step-uptime" = 216; "ota-step-user-progress" = 100; "ramrod-nvram-session" = 1559020603; "ramrod-nvram-shadow-path" = "/mnt2/MobileSoftwareUpdate/nvram.plist"; "restore-outcome" = "initial_engine_no_return"; "restore-step-ids" = "{0x1103061B:33}"; "restore-step-names" = "{0x1103061B:submit_update_stats}"; "restore-step-uptime" = 48; "restore-step-user-progress" = 0; "restore-step-warnings" = "{0x11060407:{0:\"gasgauge_start_update_thread failed: -1\"}}"; }; "ramrod-nvram-sequence" = <31>; "ramrod-nvram-session" = 1559020603; "ramrod-nvram-shadow-path" = "/mnt2/MobileSoftwareUpdate/nvram.plist"; "ramrod-nvram-shadow-vars" = { "auto-boot" = <66616c73 65>; "backlight-level" = <373430>; "boot-args" = ""; "com.apple.System.tz0-size" = <30784245 30303030 30>; "ramrod-nvram-sequence" = <31>; "ramrod-nvram-session" = <31353539 30323036 3033>; "ramrod-nvram-shadow-path" = <2f6d6e74 322f4d6f 62696c65 536f6674 77617265 55706461 74652f6e 7672616d 2e706c69 7374>; "restore-outcome" = <696e6974 69616c5f 656e6769 6e655f6e 6f5f7265 7475726e>; "restored-exit-status" = <30783130 30>; usbcfwflasherResult = <4e6f2065 72726f72 73>; }; "restore-outcome" = "initial_engine_no_return"; "restore-step-ids" = "{0x1103061B:33}"; "restore-step-names" = "{0x1103061B:submit_update_stats}"; "restore-step-uptime" = 48; "restore-step-user-progress" = 0; "restore-step-warnings" = "{0x11060407:{0:\"gasgauge_start_update_thread failed: -1\"}}"; "restored-exit-status" = <30783130 30>; usbcfwflasherResult = <4e6f2065 72726f72 73>; } Pending file-vars: { "ramrod-nvram-session" = 1559306630; "ramrod-nvram-shadow-path" = "/mnt2/MobileSoftwareUpdate/nvram.plist"; "restore-outcome" = "initial_engine_no_return"; "restore-step-ids" = "{0x1103061B:33}"; "restore-step-names" = "{0x1103061B:submit_update_stats}"; "restore-step-uptime" = 48; "restore-step-user-progress" = 0; "restore-step-warnings" = "{0x11060407:{0:\"gasgauge_start_update_thread failed: -1\"}}"; } Pending var deletes: ( "enable-remap-mode" ) Final vars: { "OTA-fsck-metrics" = "dev= vers=945.250.134 result=0 fp=0 fl=-1 repairs=0 time=1 iter=1"; "auto-boot" = true; "com.apple.System.tz0-size" = 0xBE00000; "ota-breadcrumbs" = "2:pBjDoACEHLKNnlacedTUWXZ"; "ota-outcome" = success; "ota-result" = success; "ota-step-ids" = "{}"; "ota-step-monitor" = "{0x11010207:\"wifexited\"}"; "ota-step-names" = "{}"; "ota-step-uptime" = 216; "ota-step-user-progress" = 100; "ramrod-nvram-session" = 1559306630; "ramrod-nvram-shadow-path" = "/mnt2/MobileSoftwareUpdate/nvram.plist"; "restore-outcome" = "initial_engine_no_return"; "restore-step-ids" = "{0x1103061B:33}"; "restore-step-names" = "{0x1103061B:submit_update_stats}"; "restore-step-uptime" = 48; "restore-step-user-progress" = 0; "restore-step-warnings" = "{0x11060407:{0:\"gasgauge_start_update_thread failed: -1\"}}"; } executing /usr/sbin/nvram ramrod-nvram-sequence=1 Failed to persist contents of nvram to the filesystem. File system may not be available nvram will be shadowed at the path /mnt2/MobileSoftwareUpdate/nvram.plist AMSupportHttpCopyProxySettings_block_invoke: Proxy available AMSupportHttpCopyProxySettings_block_invoke: AMSupportHttpCopyProxySettings: RPNotificationProxyAvailable AMSupportHttpCopyProxySettings: proxyInfo = <CFBasicHash 0x10512cae0 [0x10135f940]>{type = mutable dict, count = 2, entries => 0 : <CFString 0x101396748 [0x10135f940]>{contents = "SOCKSProxy"} = <CFString 0x100ef8dd8 [0x10135f940]>{contents = "127.0.0.1"} 1 : <CFString 0x101396768 [0x10135f940]>{contents = "SOCKSPort"} = <CFNumber 0xdb47665aa6fcd9cd [0x10135f940]>{value = +1081, type = kCFNumberSInt32Type} }

calling UMEventShimSubmitEvents : start

: ignoring call to recordPostUpdateEvent when no install is in progress or we haven't performed the apply operation

UMEventShimSubmitEvents done : submitEventsInBackground running

[12:44:39.0037-GMT]{3>7} CHECKPOINT END: RESTORED:[0x061B] submit_update_stats restore-step-ids = {} restore-step-names = {} restore-step-uptime = 49 restore-step-user-progress = 0 [12:44:39.0040-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0661] read_persistent_files restore-step-ids = {0x11030661:34} restore-step-names = {0x11030661:read_persistent_files} restore-step-uptime = 49 restore-step-user-progress = 0 executing /System/Library/Filesystems/apfs.fs/mount_apfs /dev/disk0s1s4 /mnt6 /dev/disk0s1s4 mounted on /mnt6 File /mnt2/iomfb_bics_daemon/bic: not found. File /mnt2/iomfb_bics_daemon/history: not found. : unable to set attributes on directory for update events: Error Domain=NSCocoaErrorDomain Code=640 "(null)" UserInfo={NSFilePath=/mnt2/db/UpdateMetrics/Events, NSUnderlyingError=0x108303ab0 {Error Domain=NSPOSIXErrorDomain Code=28 "No space left on device"}}

File /mnt6/bic: 666772 bytes read into memory. File /mnt6/history: 21933776 bytes read into memory. 2 files found in total. [12:44:39.0092-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0661] read_persistent_files restore-step-ids = {} restore-step-names = {} restore-step-uptime = 49 restore-step-user-progress = 0 [12:44:39.0095-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x061D] unmount_unconditionally restore-step-ids = {0x1103061D:35} restore-step-names = {0x1103061D:unmount_unconditionally} restore-step-uptime = 49 restore-step-user-progress = 0 entering unmount_filesystems ramrod_display_set_granular_progress_forced: 1.000000 entering unmount_partition System unmounted ramrod_display_set_granular_progress_forced: 1.000000 entering unmount_partition Data unmounted create_baseband_update_options: Got imeisv: 8 baseband updater options = <CFBasicHash 0x105136c30 [0x10135f940]>{type = mutable dict, count = 4, entries => 0 : <CFString 0x10072a780 [0x10135f940]>{contents = "IMEISwVersion"} = <CFNumber 0xdb47665aa6fc9add [0x10135f940]>{value = +8, type = kCFNumberSInt32Type} 1 : <CFString 0x10072a740 [0x10135f940]>{contents = "restoredInternal"} = <CFBoolean 0x101365508 [0x10135f940]>{value = false} 2 : <CFString 0x10072a8a0 [0x10135f940]>{contents = "autoSetupEnv"} = <CFBoolean 0x101365508 [0x10135f940]>{value = false} 6 : <CFString 0x10072a8c0 [0x10135f940]>{contents = "disablePing"} = <CFBoolean 0x1013654f0 [0x10135f940]>{value = true} }

_baseband_update_requires_filesystems_once: querying baseband to determine if it requires system filesystem bbupdater: BEGIN: Command: requirePartitionMount bbupdater: cmdCopyRequirePartitionMount: supports flashless 1 bbupdater: cmdCopyRequirePartitionMount: supports REFS 1 bbupdater: END: Command: requirePartitionMount _baseband_update_requires_filesystems_once: query returned <CFBasicHash 0x1051374d0 [0x10135f940]>{type = mutable dict, count = 3, entries => 0 : <CFString 0x10072a100 [0x10135f940]>{contents = "requireUserPartitionMount"} = <CFBoolean 0x1013654f0 [0x10135f940]>{value = true} 1 : <CFString 0x10072a120 [0x10135f940]>{contents = "requestedBasebandFSPartitionMountSize"} = <CFNumber 0xdb47665aa6fc9afc [0x10135f940]>{value = +10, type = kCFNumberSInt64Type} 2 : <CFString 0x10072a0c0 [0x10135f940]>{contents = "requireSystemPartitionMount"} = <CFBoolean 0x1013654f0 [0x10135f940]>{value = true} }

ramrod_display_set_granular_progress_forced: 1.000000 entering unmount_partition Baseband Data not mounted (unmount ignored) ramrod_display_set_granular_progress_forced: 1.000000 entering unmount_partition xART not mounted (unmount ignored) ramrod_display_set_granular_progress_forced: 1.000000 entering unmount_partition Hardware not mounted (unmount ignored) [12:44:39.0148-GMT]{3>7} CHECKPOINT END: RESTORED:[0x061D] unmount_unconditionally restore-step-ids = {} restore-step-names = {} restore-step-uptime = 49 restore-step-user-progress = 1 [12:44:39.0151-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x064E] clean_nand restore-step-ids = {0x1103064E:36} restore-step-names = {0x1103064E:clean_nand} restore-step-uptime = 49 restore-step-user-progress = 1 entering clean_NAND [12:44:39.0154-GMT]{3>7} CHECKPOINT END: RESTORED:[0x064E] clean_nand restore-step-ids = {} restore-step-names = {} restore-step-uptime = 49 restore-step-user-progress = 1 [12:44:39.0157-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0653] create_readwrite_ramdisk restore-step-ids = {0x11030653:37} restore-step-names = {0x11030653:create_readwrite_ramdisk} restore-step-uptime = 49 restore-step-user-progress = 1 executing /usr/sbin/hdik -nomount ram://5120 /dev/disk4
executing /sbin/newfs_hfs -J -v readwrite_ramdisk /dev/disk4 Initialized /dev/rdisk4 as a 3 MB case-insensitive HFS Plus volume with a 512k journal executing /sbin/fsck_hfs -fdy /dev/disk4 journal_replay(/dev/disk4) returned 0 /dev/rdisk4 Using cacheBlockSize=32K cacheTotalBlock=14864 cacheSize=475648K. Executing fsck_hfs (version hfs-407.200.4). Checking Journaled HFS Plus volume. The volume name is readwrite_ramdisk Checking extents overflow file. Checking catalog file. Checking multi-linked files. Checking catalog hierarchy. Checking extended attributes file. Checking volume bitmap. Checking volume information. The volume readwrite_ramdisk appears to be OK. CheckHFS returned 0, fsmodified = 0 executing /sbin/mount_hfs /dev/disk4 /mnt5 mount_hfs: Could not create property for re-key environment check: No such file or directory entering show_service_nodes disk0

IOBlockStorageDriver RegistryID : 0x10000038f Busy State : 0x0 Service State : 0x1e NS_01 RegistryID : 0x10000037a Busy State : 0x0 Service State : 0x1e AppleANS2CGNVMeController RegistryID : 0x10000032a Busy State : 0x0 Service State : 0x1e RTBuddyV2 RegistryID : 0x1000002f6 Busy State : 0x0 Service State : 0x1e iop-ans-nub RegistryID : 0x100000149 Busy State : 0x0 Service State : 0x1e AppleASCWrapV2 RegistryID : 0x10000022d Busy State : 0x0 Service State : 0x0 ans RegistryID : 0x100000148 Busy State : 0x0 Service State : 0x1e AppleT802xIO RegistryID : 0x100000207 Busy State : 0x6 Service State : 0x1e arm-io RegistryID : 0x100000112 Busy State : 0x1 Service State : 0x1e AppleARMPE RegistryID : 0x1000001e6 Busy State : 0x1 Service State : 0x1e D321AP RegistryID : 0x1000001e5 Busy State : 0x1 Service State : 0x1e Root RegistryID : 0x100000100 Busy State : 0x0 Service State : 0x0

disk1

IOBlockStorageDriver RegistryID : 0x10000043a Busy State : 0x0 Service State : 0x1e NS_02 RegistryID : 0x100000439 Busy State : 0x0 Service State : 0x1e AppleANS2CGNVMeController RegistryID : 0x10000032a Busy State : 0x0 Service State : 0x1e RTBuddyV2 RegistryID : 0x1000002f6 Busy State : 0x0 Service State : 0x1e iop-ans-nub RegistryID : 0x100000149 Busy State : 0x0 Service State : 0x1e AppleASCWrapV2 RegistryID : 0x10000022d Busy State : 0x0 Service State : 0x0 ans RegistryID : 0x100000148 Busy State : 0x0 Service State : 0x1e AppleT802xIO RegistryID : 0x100000207 Busy State : 0x6 Service State : 0x1e arm-io RegistryID : 0x100000112 Busy State : 0x1 Service State : 0x1e AppleARMPE RegistryID : 0x1000001e6 Busy State : 0x1 Service State : 0x1e D321AP RegistryID : 0x1000001e5 Busy State : 0x1 Service State : 0x1e Root RegistryID : 0x100000100 Busy State : 0x0 Service State : 0x0

disk2

IOBlockStorageDriver RegistryID : 0x100000446 Busy State : 0x0 Service State : 0x1e NS_07 RegistryID : 0x100000445 Busy State : 0x0 Service State : 0x1e AppleANS2CGNVMeController RegistryID : 0x10000032a Busy State : 0x0 Service State : 0x1e RTBuddyV2 RegistryID : 0x1000002f6 Busy State : 0x0 Service State : 0x1e iop-ans-nub RegistryID : 0x100000149 Busy State : 0x0 Service State : 0x1e AppleASCWrapV2 RegistryID : 0x10000022d Busy State : 0x0 Service State : 0x0 ans RegistryID : 0x100000148 Busy State : 0x0 Service State : 0x1e AppleT802xIO RegistryID : 0x100000207 Busy State : 0x6 Service State : 0x1e arm-io RegistryID : 0x100000112 Busy State : 0x1 Service State : 0x1e AppleARMPE RegistryID : 0x1000001e6 Busy State : 0x1 Service State : 0x1e D321AP RegistryID : 0x1000001e5 Busy State : 0x1 Service State : 0x1e Root RegistryID : 0x100000100 Busy State : 0x0 Service State : 0x0

disk3

IOBlockStorageDriver RegistryID : 0x10000044d Busy State : 0x0 Service State : 0x1e NS_08 RegistryID : 0x10000044c Busy State : 0x0 Service State : 0x1e AppleANS2CGNVMeController RegistryID : 0x10000032a Busy State : 0x0 Service State : 0x1e RTBuddyV2 RegistryID : 0x1000002f6 Busy State : 0x0 Service State : 0x1e iop-ans-nub RegistryID : 0x100000149 Busy State : 0x0 Service State : 0x1e AppleASCWrapV2 RegistryID : 0x10000022d Busy State : 0x0 Service State : 0x0 ans RegistryID : 0x100000148 Busy State : 0x0 Service State : 0x1e AppleT802xIO RegistryID : 0x100000207 Busy State : 0x6 Service State : 0x1e arm-io RegistryID : 0x100000112 Busy State : 0x1 Service State : 0x1e AppleARMPE RegistryID : 0x1000001e6 Busy State : 0x1 Service State : 0x1e D321AP RegistryID : 0x1000001e5 Busy State : 0x1 Service State : 0x1e Root RegistryID : 0x100000100 Busy State : 0x0 Service State : 0x0

disk4

IOBlockStorageDriver RegistryID : 0x10000047d Busy State : 0x0 Service State : 0x1e IODiskImageBlockStorageDeviceInKernel RegistryID : 0x10000047c Busy State : 0x0 Service State : 0x1e IOHDIXHDDriveInKernel RegistryID : 0x10000047b Busy State : 0x0 Service State : 0x1e KDIDiskImageNub RegistryID : 0x10000047a Busy State : 0x0 Service State : 0x1e KDIReadWriteDiskImage RegistryID : 0x100000479 Busy State : 0x0 Service State : 0x1e KDIRAMBackingStore RegistryID : 0x100000476 Busy State : 0x0 Service State : 0x1e ram://5120 RegistryID : 0x100000475 Busy State : 0x0 Service State : 0x1e IOHDIXController RegistryID : 0x1000001f3 Busy State : 0x0 Service State : 0x1e IOResources RegistryID : 0x1000001e8 Busy State : 0x0 Service State : 0x1e D321AP RegistryID : 0x1000001e5 Busy State : 0x1 Service State : 0x1e Root RegistryID : 0x100000100 Busy State : 0x0 Service State : 0x0

[12:44:39.0337-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0653] create_readwrite_ramdisk restore-step-ids = {} restore-step-names = {} restore-step-uptime = 49 restore-step-user-progress = 1 [12:44:39.0338-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x061F] format_effaceable_storage restore-step-ids = {0x1103061F:38} restore-step-names = {0x1103061F:format_effaceable_storage} restore-step-uptime = 49 restore-step-user-progress = 1 entering format_effaceable_storage effaceable storage is formatted, nothing to do [12:44:39.0339-GMT]{3>7} CHECKPOINT END: RESTORED:[0x061F] format_effaceable_storage restore-step-ids = {} restore-step-names = {} restore-step-uptime = 49 restore-step-user-progress = 1 [12:44:39.0340-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0660] update_partitions_for_apfs restore-step-ids = {0x11030660:39} restore-step-names = {0x11030660:update_partitions_for_apfs} restore-step-uptime = 49 restore-step-user-progress = 1 APFS Update Install entering check_for_compatibility check_for_compatibility - Status Online Deleting System partition during Update Install delete_apfs_partition returned 0 during Update Install We should not have an xART partition. Attempting to delete Update partition during Update install 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= data=/dev/disk0s1s2 baseband data=/dev/disk0s1s3 log= update= xart= hardware=/dev/disk0s1s4 scratch= delete_apfs_update_partition_if_exists : no update partition found, returning 0 [12:44:40.0070-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0660] update_partitions_for_apfs restore-step-ids = {} restore-step-names = {} restore-step-uptime = 50 restore-step-user-progress = 1 [12:44:40.0073-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0622] reload_filesystem_partitions restore-step-ids = {0x11030622:40} restore-step-names = {0x11030622:reload_filesystem_partitions} restore-step-uptime = 50 restore-step-user-progress = 1 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= data=/dev/disk0s1s2 baseband data=/dev/disk0s1s3 log= update= xart= hardware=/dev/disk0s1s4 scratch= [12:44:40.0080-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0622] reload_filesystem_partitions restore-step-ids = {} restore-step-names = {} restore-step-uptime = 50 restore-step-user-progress = 1 [12:44:40.0083-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x065D] delete_mobilebackups restore-step-ids = {0x1103065D:41} restore-step-names = {0x1103065D:delete_mobilebackups} restore-step-uptime = 50 restore-step-user-progress = 1 executing /System/Library/Filesystems/apfs.fs/mount_apfs /dev/disk0s1s2 /mnt2 /dev/disk0s1s2 mounted on /mnt2 ramrod_delete_all_mobilebackup_snapshots : No snapshots to delete on /mnt2 [12:44:40.0550-GMT]{3>7} CHECKPOINT END: RESTORED:[0x065D] delete_mobilebackups restore-step-ids = {} restore-step-names = {} restore-step-uptime = 50 restore-step-user-progress = 1 [12:44:40.0555-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0658] format_media restore-step-ids = {0x11030658:42} restore-step-names = {0x11030658:format_media} restore-step-uptime = 50 restore-step-user-progress = 1 Update install using APFS diskimage on APFS formatted device, no converter use necessary entering create_apfs_filesystems 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= data=/dev/disk0s1s2 baseband data=/dev/disk0s1s3 log= update= xart= hardware=/dev/disk0s1s4 scratch= ramrod_display_set_granular_progress_forced: 1.000000 block size for /dev/disk0s1: 4096 /System/Library/Filesystems/apfs.fs/newfs_apfs -A -o fsindex=0 -v System /dev/disk0s1 executing /System/Library/Filesystems/apfs.fs/newfs_apfs -A -o fsindex=0 -v System /dev/disk0s1 We should not have an xART partition. Not creating an xART partition because we're on a system that doesn't support it. IORegistry requires a 50 MiB Hardware Partition executing /System/Library/Filesystems/apfs.fs/mount_apfs /dev/disk0s1s4 /mnt6 /dev/disk0s1s4 mounted on /mnt6 totalBlocks:12800 blockSize:4096 blocksAvailable:7227 Filesystem /mnt6 is 50 MB get_total_file_system_size is 52428800 Hardware volume looks OK, doing nothing. Should we generate a scratch partition? Not generating a sctach partition because the system doesn't support it. [12:44:42.0062-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0658] format_media restore-step-ids = {} restore-step-names = {} restore-step-uptime = 52 restore-step-user-progress = 1 [12:44:42.0066-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0659] find_volumes_after_format restore-step-ids = {0x11030659:43} restore-step-names = {0x11030659:find_volumes_after_format} restore-step-uptime = 52 restore-step-user-progress = 1 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=/dev/disk0s1s3 log= update= xart= hardware=/dev/disk0s1s4 scratch= [12:44:42.0076-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0659] find_volumes_after_format restore-step-ids = {} restore-step-names = {} restore-step-uptime = 52 restore-step-user-progress = 1 [12:44:42.0078-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x065F] reserve_overprov_space restore-step-ids = {0x1103065F:44} restore-step-names = {0x1103065F:reserve_overprov_space} restore-step-uptime = 52 restore-step-user-progress = 1 executing /System/Library/Filesystems/apfs.fs/mount_apfs /dev/disk0s1s2 /mnt2 /dev/disk0s1s2 mounted on /mnt2 space already reserved for overprovisioning [12:44:42.0734-GMT]{3>7} CHECKPOINT END: RESTORED:[0x065F] reserve_overprov_space restore-step-ids = {} restore-step-names = {} restore-step-uptime = 52 restore-step-user-progress = 1 [12:44:42.0741-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0662] write_persistent_files restore-step-ids = {0x11030662:45} restore-step-names = {0x11030662:write_persistent_files} restore-step-uptime = 52 restore-step-user-progress = 1 executing /System/Library/Filesystems/apfs.fs/mount_apfs /dev/disk0s1s2 /mnt2 /dev/disk0s1s2 mounted on /mnt2 executing /System/Library/Filesystems/apfs.fs/mount_apfs /dev/disk0s1s4 /mnt6 /dev/disk0s1s4 mounted on /mnt6 Not overwriting file in stage1. Not overwriting file in stage1. Committed 2 persistent files to NAND [12:44:43.0424-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0662] write_persistent_files restore-step-ids = {} restore-step-names = {} restore-step-uptime = 53 restore-step-user-progress = 1 [12:44:43.0430-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x065A] baseband_migration_data restore-step-ids = {0x1103065A:46} restore-step-names = {0x1103065A:baseband_migration_data} restore-step-uptime = 53 restore-step-user-progress = 1 [12:44:43.0434-GMT]{3>7} CHECKPOINT END: RESTORED:[0x065A] baseband_migration_data restore-step-ids = {} restore-step-names = {} restore-step-uptime = 53 restore-step-user-progress = 1 [12:44:43.0438-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x065B] asr_and_invert_image restore-step-ids = {0x1103065B:47} restore-step-names = {0x1103065B:asr_and_invert_image} restore-step-uptime = 53 restore-step-user-progress = 1 restore_apfs_image : started restoring an APFS image entering mount_partition executing /System/Library/Filesystems/apfs.fs/mount_apfs /dev/disk0s1s1 /mnt1 /dev/disk0s1s1 mounted on /mnt1 System mounted read-write Successfully marked device node /dev/rdisk0s1s1 as static data OS digest = d7e900edf07339b715e5f0d3097e81dc030f17230555d8b86135c5afd5bad308c365eeb0079337057126e5608691044e Restoring to APFS Inverter Image = /mnt1/apfs_invert_asr_img executing /usr/sbin/asr -source asr://localhost:12345 -target /mnt1/apfs_invert_asr_img --embed -erase -noprompt --chunkchecksum --puppetstrings --expectedhash d7e900edf07339b715e5f0d3097e81dc030f17230555d8b86135c5afd5bad308c365eeb0079337057126e5608691044e ASR STATUS: start 412 multicast-client ASR: Waiting for connection attempt from server ASR STATUS: setup ASR: Validating target...done ASR STATUS: metadata ASR: Validating source... ASR: nx_kernel_mount:1473: : checkpoint search: largest xid 11, best xid 11 @ 21 ASR: done ASR: Retrieving scan information... ASR: done ASR: Validating sizes...done ASR STATUS: restore ASR RESTORE PROGRESS: 2% ramrod_display_set_granular_progress_forced: 6.000000 ASR RESTORE PROGRESS: 4% ramrod_display_set_granular_progress_forced: 7.000000 ASR RESTORE PROGRESS: 6% ramrod_display_set_granular_progress_forced: 7.000000 ASR RESTORE PROGRESS: 8% ramrod_display_set_granular_progress_forced: 8.000000 ASR RESTORE PROGRESS: 10% ramrod_display_set_granular_progress_forced: 8.000000 ASR RESTORE PROGRESS: 12% ramrod_display_set_granular_progress_forced: 9.000000 ASR RESTORE PROGRESS: 14% ramrod_display_set_granular_progress_forced: 10.000000 ASR RESTORE PROGRESS: 16% ramrod_display_set_granular_progress_forced: 10.000000 ASR RESTORE PROGRESS: 18% ramrod_display_set_granular_progress_forced: 11.000000 ASR RESTORE PROGRESS: 20% ramrod_display_set_granular_progress_forced: 11.000000 ASR RESTORE PROGRESS: 22% ramrod_display_set_granular_progress_forced: 12.000000 ASR RESTORE PROGRESS: 24% ramrod_display_set_granular_progress_forced: 12.000000 ASR RESTORE PROGRESS: 26% ramrod_display_set_granular_progress_forced: 13.000000 ASR RESTORE PROGRESS: 28% ramrod_display_set_granular_progress_forced: 13.000000 ASR RESTORE PROGRESS: 30% ramrod_display_set_granular_progress_forced: 14.000000 ASR RESTORE PROGRESS: 32% ramrod_display_set_granular_progress_forced: 15.000000 ASR RESTORE PROGRESS: 34% ramrod_display_set_granular_progress_forced: 15.000000 ASR RESTORE PROGRESS: 36% ramrod_display_set_granular_progress_forced: 16.000000 ASR RESTORE PROGRESS: 38% ramrod_display_set_granular_progress_forced: 16.000000 ASR RESTORE PROGRESS: 40% ramrod_display_set_granular_progress_forced: 17.000000 ASR RESTORE PROGRESS: 42% ramrod_display_set_granular_progress_forced: 17.000000 ASR RESTORE PROGRESS: 44% ramrod_display_set_granular_progress_forced: 18.000000 ASR RESTORE PROGRESS: 46% ramrod_display_set_granular_progress_forced: 18.000000 ASR RESTORE PROGRESS: 48% ramrod_display_set_granular_progress_forced: 19.000000 ASR RESTORE PROGRESS: 50% ramrod_display_set_granular_progress_forced: 20.000000 ASR RESTORE PROGRESS: 52% ramrod_display_set_granular_progress_forced: 20.000000 ASR RESTORE PROGRESS: 54% ramrod_display_set_granular_progress_forced: 21.000000 ASR RESTORE PROGRESS: 56% ramrod_display_set_granular_progress_forced: 21.000000 ASR RESTORE PROGRESS: 58% ramrod_display_set_granular_progress_forced: 22.000000 ASR RESTORE PROGRESS: 60% ramrod_display_set_granular_progress_forced: 22.000000 ASR RESTORE PROGRESS: 62% ramrod_display_set_granular_progress_forced: 23.000000 ASR RESTORE PROGRESS: 64% ramrod_display_set_granular_progress_forced: 23.000000 ASR RESTORE PROGRESS: 66% ramrod_display_set_granular_progress_forced: 24.000000 ASR RESTORE PROGRESS: 68% ramrod_display_set_granular_progress_forced: 24.000000 ASR RESTORE PROGRESS: 70% ramrod_display_set_granular_progress_forced: 25.000000 ASR RESTORE PROGRESS: 72% ramrod_display_set_granular_progress_forced: 26.000000 ASR RESTORE PROGRESS: 74% ramrod_display_set_granular_progress_forced: 26.000000 ASR RESTORE PROGRESS: 76% ramrod_display_set_granular_progress_forced: 27.000000 ASR RESTORE PROGRESS: 78% ramrod_display_set_granular_progress_forced: 27.000000 ASR RESTORE PROGRESS: 80% ramrod_display_set_granular_progress_forced: 28.000000 ASR RESTORE PROGRESS: 82% ramrod_display_set_granular_progress_forced: 28.000000 ASR RESTORE PROGRESS: 84% ramrod_display_set_granular_progress_forced: 29.000000 ASR RESTORE PROGRESS: 86% ramrod_display_set_granular_progress_forced: 29.000000 ASR RESTORE PROGRESS: 88% ramrod_display_set_granular_progress_forced: 30.000000 ASR RESTORE PROGRESS: 90% ramrod_display_set_granular_progress_forced: 31.000000 ASR RESTORE PROGRESS: 92% ramrod_display_set_granular_progress_forced: 31.000000 ASR RESTORE PROGRESS: 94% ramrod_display_set_granular_progress_forced: 32.000000 ASR STATUS: fail ASR: Could not restore - No space left on device ASR STATUS: fail restore_apfs_image : failed to restore an APFS image, error = 14 [12:46:10.0690-GMT]{3>7} CHECKPOINT FAILURE:(FAILURE:14) RESTORED:[0x065B] asr_and_invert_image [0]D(failed to restore APFS image) restore-step-results = {0x1107065B:{0:14}} restore-step-codes = {0x1107065B:{0:14}} restore-step-domains = {0x1107065B:{0:"AMRestoreErrorDomain"}} restore-step-error = {0x1107065B:"[0]D(failed to restore APFS image)"} restore-step-uptime = 140 restore-step-user-progress = 32 [12:46:10.0695-GMT]{3>7} CHECKPOINT NOTICE: (NVRAM set) restore-step-user-progress=32 [sync=true] (first failure) [12:46:10.0695-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0647] cleanup_check_result restore-step-ids = {0x1103065B:47;0x11030647:48} restore-step-names = {0x1103065B:asr_and_invert_image;0x11030647:cleanup_check_result} restore-step-uptime = 140 restore-step-user-progress = 32 [12:46:10.0698-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0647] cleanup_check_result restore-step-ids = {0x1103065B:47} restore-step-names = {0x1103065B:asr_and_invert_image} restore-step-uptime = 140 restore-step-user-progress = 32 [12:46:10.0702-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0648] cleanup_send_final_status restore-step-ids = {0x1103065B:47;0x11030648:49} restore-step-names = {0x1103065B:asr_and_invert_image;0x11030648:cleanup_send_final_status} restore-step-uptime = 140 restore-step-user-progress = 32

ERROR: Unable to restore device `

nikias commented 5 years ago

This is a strange problem... it ( = Apple's restore code that runs on the device) should not resize the root filesystem to something else. What is the storage size of this iPhone? Also, there is no way to "mount" an iPhone in recovery mode.

decembersake commented 5 years ago

This is a strange problem... it ( = Apple's restore code that runs on the device) should not resize the root filesystem to something else. What is the storage size of this iPhone? Also, there is no way to "mount" an iPhone in recovery mode.

It's a 256GB .. Is there's no way to recover my phone from recovery mode please save me I work in the design part and really do need all the data I'm going to die please help me.. any advice to try out

nikias commented 5 years ago

Are you sure you are using the latest code? It should copy the system partition padding from the BuildManifest. That specifies how large the root filesystem should be. Maybe you can try this patch too:

diff --git a/src/restore.c b/src/restore.c
index 4e6b91d..1cd9e46 100644
--- a/src/restore.c
+++ b/src/restore.c
@@ -2417,11 +2417,16 @@ int restore_device(struct idevicerestore_client_t* client, plist_t build_identit
                spp = plist_copy(spp);
        } else {
                spp = plist_new_dict();
+               plist_dict_set_item(spp, "1024", plist_new_uint(1280));
                plist_dict_set_item(spp, "128", plist_new_uint(1280));
                plist_dict_set_item(spp, "16", plist_new_uint(160));
+               plist_dict_set_item(spp, "256", plist_new_uint(1280));
                plist_dict_set_item(spp, "32", plist_new_uint(320));
+               plist_dict_set_item(spp, "512", plist_new_uint(1280));
                plist_dict_set_item(spp, "64", plist_new_uint(640));
+               plist_dict_set_item(spp, "768", plist_new_uint(1280));
                plist_dict_set_item(spp, "8", plist_new_uint(80));
+
        }
        plist_dict_set_item(opts, "SystemPartitionPadding", spp);
        char* guid = generate_guid();
nikias commented 5 years ago

Also have you tried with 12.3.1 ?

decembersake commented 5 years ago

Yes I am using the latest code. I have tried with 12.3.1 and 12.3 both are not working.. I have tried your new patch after committing but still not working.. still same issue and stop exactly at the same point.

`ASR RESTORE PROGRESS: 94% ramrod_display_set_granular_progress_forced: 32.000000 ASR STATUS: fail ASR: Could not restore - No space left on device ASR STATUS: fail restore_apfs_image : failed to restore an APFS image, error = 14 [10:04:47.0307-GMT]{3>7} CHECKPOINT FAILURE:(FAILURE:14) RESTORED:[0x065B] asr_and_invert_image [0]D(failed to restore APFS image) restore-step-results = {0x1107065B:{0:14}} restore-step-codes = {0x1107065B:{0:14}} restore-step-domains = {0x1107065B:{0:"AMRestoreErrorDomain"}} restore-step-error = {0x1107065B:"[0]D(failed to restore APFS image)"} restore-step-uptime = 141 restore-step-user-progress = 32 [10:04:47.0311-GMT]{3>7} CHECKPOINT NOTICE: (NVRAM set) restore-step-user-progress=32 [sync=true] (first failure) [10:04:47.0311-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0647] cleanup_check_result restore-step-ids = {0x1103065B:47;0x11030647:48} restore-step-names = {0x1103065B:asr_and_invert_image;0x11030647:cleanup_check_result} restore-step-uptime = 141 restore-step-user-progress = 32 [10:04:47.0315-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0647] cleanup_check_result restore-step-ids = {0x1103065B:47} restore-step-names = {0x1103065B:asr_and_invert_image} restore-step-uptime = 141 restore-step-user-progress = 32 [10:04:47.0318-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0648] cleanup_send_final_status restore-step-ids = {0x1103065B:47;0x11030648:49} restore-step-names = {0x1103065B:asr_and_invert_image;0x11030648:cleanup_send_final_status} restore-step-uptime = 141 restore-step-user-progress = 32

ERROR: Unable to restore device `

decembersake commented 5 years ago

I really do appreciate your help Thank you SO SO much but Is there's literally NO way to recover my photos? This is so bad and can't believe.. I really need all data it's just insane that phone dies because of no space in 2019... could you please suggest any other things to try, please...

decembersake commented 5 years ago

i dont know if it helps but here's full log

Password: Found device in Recovery mode Identified device as d321ap, iPhone11,2 The following firmwares are currently being signed for iPhone11,2: [1] 12.3.1 (build 16F203) [2] 12.3 (build 16F156) Select the firmware you want to restore: 1 Selected firmware 12.3.1 (build 16F203)

Verifying 'iPhone11,2_12.3.1_16F203_Restore.ipsw'... Checksum matches. Extracting BuildManifest from IPSW Product Version: 12.3.1 Product Build: 16F203 Major: 16 INFO: device serial number is DNPX9193KPG4 Device supports Image4: true Variant: Customer Upgrade Install (IPSW) This restore will update your device without losing data. Checking IPSW for required components... All required components found in IPSW Extracting filesystem from IPSW: 048-43159-182.dmg [==================================================] 100.0% Found ECID 4909083227848750 Getting ApNonce in recovery mode... c1 f3 30 06 41 85 31 a0 22 7d 1a 26 91 09 65 02 3b 61 c0 c6 72 cc 49 c2 19 af 5c 58 b8 21 a3 70 Trying to fetch new SHSH blob Getting SepNonce in recovery mode... 8a 5a 37 d2 29 77 4f c4 7a 4d c2 70 e7 e0 95 6f 3e 67 7a fd 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 Extracting iBEC.d321.RELEASE.im4p... Personalizing IMG4 component iBEC... Sending iBEC (1063306 bytes)... Recovery Mode Environment: iBoot build-version=iBoot-4513.260.81 iBoot build-style=RELEASE Sending RestoreLogo... Extracting applelogo@3x~iphone.im4p... Personalizing IMG4 component RestoreLogo... Sending RestoreLogo (20910 bytes)... Extracting h11_ane_fw_quin.im4p... Personalizing IMG4 component ANE... Sending ANE (9394706 bytes)... Extracting aopfw-iphone11aop.im4p... Personalizing IMG4 component AOP... Sending AOP (1396234 bytes)... Extracting AppleAVE2FW.im4p... Personalizing IMG4 component AVE... Sending AVE (1111370 bytes)... Extracting armfw_g11p.im4p... Personalizing IMG4 component GFX... Sending GFX (1555834 bytes)... Extracting adc-petra-d3x.im4p... Personalizing IMG4 component ISP... Sending ISP (14639242 bytes)... Extracting 048-43107-184.dmg.trustcache... Personalizing IMG4 component RestoreTrustCache... Sending RestoreTrustCache (11671 bytes)... Extracting SmartIOFirmwareT8020.im4p... Personalizing IMG4 component SIO... Sending SIO (1356094 bytes)... Extracting WirelessPower.iphone11.im4p... Personalizing IMG4 component WCHFirmwareUpdater... Sending WCHFirmwareUpdater (28773 bytes)... ramdisk-size=0x20000000 Extracting 048-43107-184.dmg... Personalizing IMG4 component RestoreRamDisk... Sending RestoreRamDisk (93872653 bytes)... Extracting DeviceTree.d321ap.im4p... Personalizing IMG4 component RestoreDeviceTree... Sending RestoreDeviceTree (193792 bytes)... Extracting kernelcache.release.iphone11... Personalizing IMG4 component RestoreKernelCache... Sending RestoreKernelCache (17958779 bytes)... About to restore device... Waiting for device... Device 00008020-001170C901F8002E is now connected in restore mode... Connecting now... Connected to com.apple.mobile.restored, version 15 Device 00008020-001170C901F8002E has successfully entered restore mode Hardware Information: BoardID: 14 ChipID: 32800 UniqueChipID: 4909083227848750 ProductionMode: true Previous restore exit status: 0x100 Starting FDR listener thread About to send NORData... Found firmware path Firmware/all_flash Getting firmware manifest from build identity Extracting LLB.d321.RELEASE.im4p... Personalizing IMG4 component LLB... Extracting applelogo@3x~iphone.im4p... Personalizing IMG4 component AppleLogo... Extracting batterycharging0@3x~iphone.im4p... Personalizing IMG4 component BatteryCharging0... Extracting batterycharging1@3x~iphone.im4p... Personalizing IMG4 component BatteryCharging1... Extracting batteryfull@3x~iphone.im4p... Personalizing IMG4 component BatteryFull... Extracting batterylow0@3x~iphone.im4p... Personalizing IMG4 component BatteryLow0... Extracting batterylow1@3x~iphone.im4p... Personalizing IMG4 component BatteryLow1... Extracting glyphplugin@2436~iphone-lightning.im4p... Personalizing IMG4 component BatteryPlugin... Extracting DeviceTree.d321ap.im4p... Personalizing IMG4 component DeviceTree... Extracting liquiddetect@2436~iphone-lightning.im4p... Personalizing IMG4 component Liquid... Extracting lowpowermode@2436~iphone-lightning.im4p... Personalizing IMG4 component LowPowerWallet0... Extracting recoverymode@2436~iphone-lightning.im4p... Personalizing IMG4 component RecoveryMode... Extracting iBoot.d321.RELEASE.im4p... Personalizing IMG4 component iBoot... Extracting sep-firmware.d321.RELEASE.im4p... Personalizing IMG4 component RestoreSEP... Extracting sep-firmware.d321.RELEASE.im4p... Personalizing IMG4 component SEP... Sending NORData now... Done sending NORData About to send RootTicket... Sending RootTicket now... Done sending RootTicket Waiting for NAND (28) Updating S3E Firmware (58) Checking filesystems (15) Checking filesystems (15) About to send FDR Trust data... Sending FDR Trust data now... Done sending FDR Trust Data Unmounting filesystems (29) Unmounting filesystems (29) Unmounting filesystems (29) Unmounting filesystems (29) Unmounting filesystems (29) Creating filesystem (12) About to send filesystem... Connected to ASR Validating the filesystem Filesystem validated Sending filesystem now... [================================================ ] 94.0%ERROR: Unable to send data to ASR. Sent 0 of 1450 bytes. ERROR: Unable to send filesystem payload ERROR: Unable to send payload to ASR ERROR: Unable to send filesystem ERROR: Unable to successfully restore device Got status message Status: Fail Log is available: SYSLOG: Jun 2 10:02:26 localhost bootlog[0] : BOOT_TIME 1559469746 175628 [10:02:26.0961-GMT]{3>7} CHECKPOINT NOTICE: Image4 device: AP nonce clearable entering ramrod_clear_ap_nonce [10:02:26.0974-GMT]{3>7} CHECKPOINT NOTICE: AP nonce consumed [10:02:26.0975-GMT]{3>7} CHECKPOINT NOTICE: Pre-existing NVRAM variable: auto-boot=false [10:02:26.0976-GMT]{3>7} CHECKPOINT NOTICE: Pre-existing NVRAM variable: restore-outcome=initial_monitor_no_return [10:02:26.0976-GMT]{3>7} CHECKPOINT PROGRESS: START (unknown) -> (initial_engine_no_return) [10:02:26.0977-GMT]{3>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 [10:02:26.0989-GMT]{3>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 [10:02:26.0992-GMT]{3>7} CHECKPOINT END: MAIN:[0x0400] umask restore-step-ids = {} restore-step-names = {} restore-step-uptime = 0 restore-step-user-progress = -1 [10:02:26.0994-GMT]{3>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 [10:02:26.0997-GMT]{3>7} CHECKPOINT END: MAIN:[0x0402] setvbuf restore-step-ids = {} restore-step-names = {} restore-step-uptime = 0 restore-step-user-progress = -1 [10:02:27.0000-GMT]{3>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 [10:02:27.0003-GMT]{3>7} CHECKPOINT END: MAIN:[0x0403] kernel_logger_thread restore-step-ids = {} unable to open /dev/klog: Resource busy restore-step-names = {} restore-step-uptime = 1 restore-step-user-progress = -1 [10:02:27.0006-GMT]{3>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: primary display-scale = 3 display-rotation = 0 found applelogo at /usr/share/progressui/applelogo@3x.tga display: 1125 x 2436 powering on display ramrod_display_set_granular_progress_forced: 0.000000 [10:02:27.0030-GMT]{3>7} CHECKPOINT END: MAIN:[0x0406] set_progress_0 restore-step-ids = {} restore-step-names = {} restore-step-uptime = 1 restore-step-user-progress = 0 [10:02:27.0032-GMT]{3>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 [10:02:27.0036-GMT]{3>7} CHECKPOINT WARNING: MAIN:[0x0407] gasgauge_start_update_thread failed: -1 [10:02:27.0036-GMT]{3>7} CHECKPOINT END: MAIN:[0x0407] start_gasgauge_thread restore-step-ids = {} restore-step-names = {} restore-step-warnings = {0x11060407:{0:"gasgauge_start_update_thread failed: -1"}} restore-step-uptime = 1 restore-step-user-progress = 0 [10:02:27.0039-GMT]{3>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 [10:02:27.0042-GMT]{3>7} CHECKPOINT END: MAIN:[0x0408] listen_for_log_client restore-step-ids = {} restore-step-names = {} restore-step-uptime = 1 restore-step-user-progress = 0 [10:02:27.0045-GMT]{3>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 [10:02:27.0048-GMT]{3>7} CHECKPOINT END: MAIN:[0x040D] create_listen_socket restore-step-ids = {} restore-step-names = {} restore-step-uptime = 1 restore-step-user-progress = 0 [10:02:27.0051-GMT]{3>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 [10:02:27.0054-GMT]{3>7} CHECKPOINT END: MAIN:[0x0404] update_root_mount restore-step-ids = {} restore-step-names = {} restore-step-uptime = 1 restore-step-user-progress = 0 [10:02:27.0057-GMT]{3>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 [10:02:27.0061-GMT]{3>7} CHECKPOINT END: MAIN:[0x0405] disable_watchdog restore-step-ids = {} restore-step-names = {} restore-step-uptime = 1 restore-step-user-progress = 0 [10:02:27.0064-GMT]{3>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 0x14bd0dd30 [0x103c1f940]>{type = mutable dict, count = 1, entries => 0 : <CFString 0x103eb82a0 [0x103c1f940]>{contents = "IOProviderClass"} = <CFString 0x14bd0d7a0 [0x103c1f940]>{contents = "AppleUSBDeviceMux"} }

[10:02:30.0074-GMT]{3>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(8, 4) failed: connection closed recv(9, 4) failed: connection closed unable to read message size: -1 could not receive message unable to read message size: -1 could not receive message recv(11, 4) failed: connection closed unable to read message size: -1 recv(9, 4) failed: connection closed recv(8, 4) failed: connection closed could not receive message unable to read message size: -1 unable to read message size: -1 recv(12, 4) failed: connection closed unable to read message size: -1 could not receive message could not receive message recv(14, 4) failed: connection closed unable to read message size: -1 could not receive message recv(11, 4) failed: connection closed unable to read message size: -1 could not receive message could not receive message recv(8, 4) failed: connection closed unable to read message size: -1 could not receive message recv(13, 4) failed: connection closed recv(14, 4) failed: connection closed unable to read message size: -1 could not receive message recv(15, 4) failed: connection closed unable to read message size: -1 could not receive message unable to read message size: -1 could not receive message recv(17, 4) failed: connection closed unable to read message size: -1 could not receive message recv(8, 4) failed: connection closed unable to read message size: -1 could not receive message recv(14, 4) failed: connection closed unable to read message size: -1 could not receive message recv(12, 4) failed: connection closed recv(15, 4) failed: connection closed unable to read message size: -1 recv(11, 4) failed: connection closed unable to read message size: -1 could not receive message recv(19, 4) failed: connection closed unable to read message size: -1 could not receive message recv(9, 4) failed: connection closed unable to read message size: -1 could not receive message recv(14, 4) failed: connection closed unable to read message size: -1 recv(8, 4) failed: connection closed unable to read message size: -1 recv(9, 4) failed: connection closed unable to read message size: -1 could not receive message recv(18, 4) failed: connection closed unable to read message size: -1 could not receive message unable to read message size: -1 could not receive message recv(17, 4) failed: connection closed could not receive message recv(13, 4) failed: connection closed recv(11, 4) failed: connection closed 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 recv(8, 4) failed: connection closed unable to read message size: -1 could not receive message recv(9, 4) failed: connection closed unable to read message size: -1 could not receive message [10:02:32.0759-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0600] client_protocol_version restore-step-ids = {0x11030600:11} restore-step-names = {0x11030600:client_protocol_version} restore-step-uptime = 6 restore-step-user-progress = 0 client protocol version 15 [10:02:32.0767-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0600] client_protocol_version restore-step-ids = {} restore-step-names = {} restore-step-uptime = 6 restore-step-user-progress = 0 [10:02:32.0772-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0601] copy_restore_options restore-step-ids = {0x11030601:12} restore-step-names = {0x11030601:copy_restore_options} restore-step-uptime = 6 restore-step-user-progress = 0 unable to open /usr/local/share/restore//options.d321.plist: No such file or directory unable to open /usr/local/share/restore//options.plist: No such file or directory UUID 6A05DC94-A58E-DA4A-0AC9-3B04A7AE46A7 Restore options: UUID => <CFString 0x14d001440 [0x103c1f940]>{contents = "6A05DC94-A58E-DA4A-0AC9-3B04A7AE46A7"} TZ0RequiredCapacity => 0xBE00000 PersonalizedDuringPreflight => <CFBoolean 0x103c254f0 [0x103c1f940]>{value = true} CreateFilesystemPartitions => <CFBoolean 0x103c25508 [0x103c1f940]>{value = false} [10:02:32.0783-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0601] copy_restore_options restore-step-ids = {} restore-step-names = {} restore-step-uptime = 6 restore-step-user-progress = 0 [10:02:32.0786-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0655] is_host_compatible restore-step-ids = {0x11030655:13} restore-step-names = {0x11030655:is_host_compatible} restore-step-uptime = 6 restore-step-user-progress = 0 [10:02:32.0789-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0655] is_host_compatible restore-step-ids = {} restore-step-names = {} restore-step-uptime = 6 restore-step-user-progress = 0 [10:02:32.0791-GMT]{3>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 = 6 restore-step-user-progress = 0 [10:02:32.0794-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0604] set_weight_from_options restore-step-ids = {} restore-step-names = {} restore-step-uptime = 6 restore-step-user-progress = 0 [10:02:32.0798-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0608] device_has_hoover restore-step-ids = {0x11030608:15} restore-step-names = {0x11030608:device_has_hoover} restore-step-uptime = 6 restore-step-user-progress = 0 [10:02:32.0801-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0608] device_has_hoover restore-step-ids = {} restore-step-names = {} restore-step-uptime = 6 restore-step-user-progress = 0 [10:02:32.0804-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0609] load_sep_os restore-step-ids = {0x11030609:16} restore-step-names = {0x11030609:load_sep_os} restore-step-uptime = 6 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 (0x10b838000 - 7429760) executing /usr/libexec/seputil --restore+art - waiting for child to exit child exited exit status: 0 entering ramrod_wait_for_sep_load executing /usr/libexec/seputil --ping seputil: ping failed executing /usr/libexec/seputil --ping SEP OS is booted [10:02:35.0641-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0609] load_sep_os restore-step-ids = {} restore-step-names = {} restore-step-uptime = 9 restore-step-user-progress = 0 [10:02:35.0645-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x060B] update_ticket restore-step-ids = {0x1103060B:17} restore-step-names = {0x1103060B:update_ticket} restore-step-uptime = 9 restore-step-user-progress = 0 entering ramrod_ticket_update_verify looking up boot manifest hash device tree ticket_hash: 5DAC48E9D02FDD30329008AC030F5DA01A73350B2DACEC2F07212C46A4D609C01BF7CA9CAB3060E384F75693A8EF8A2B crypto-hash-method found. Using SHA2-384 computed ticket_hash : 5DAC48E9D02FDD30329008AC030F5DA01A73350B2DACEC2F07212C46A4D609C01BF7CA9CAB3060E384F75693A8EF8A2B received valid ticket (7650 bytes) [10:02:35.0655-GMT]{3>7} CHECKPOINT END: RESTORED:[0x060B] update_ticket restore-step-ids = {} restore-step-names = {} restore-step-uptime = 9 restore-step-user-progress = 0 [10:02:35.0658-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x060D] wait_for_storage restore-step-ids = {0x1103060D:18} restore-step-names = {0x1103060D:wait_for_storage} restore-step-uptime = 9 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: AppleANS2CGNVMeController NAND initialized. Waiting for devnode. [10:02:35.0666-GMT]{3>7} CHECKPOINT END: RESTORED:[0x060D] wait_for_storage restore-step-ids = {} restore-step-names = {} restore-step-uptime = 9 restore-step-user-progress = 0 [10:02:35.0669-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x060E] update_NAND_firmware restore-step-ids = {0x1103060E:19} restore-step-names = {0x1103060E:update_NAND_firmware} restore-step-uptime = 9 restore-step-user-progress = 0 ramrod_display_set_granular_progress_forced: 0.000000 entering update_NAND executing /usr/bin/nvmefwupdater --query S4E/0000001202019313.pak NAND update file: "/usr/standalone/firmware/S4E/0000001202019313.pak" executing /usr/bin/nvmefwupdater --validate /usr/standalone/firmware/S4E/0000001202019313.pak s4e-bfh-params: 50555746 00200001 00204044 004080D9 004080DB 004080DD 004280E6 004680EB 030080FF 805080EC 00060002 100108A8 Performing BFH OFW stage... set_pci_port_state: result=0 set_pci_port_state: result=0 returning Regular update executing /usr/bin/nvmefwupdater --update /usr/standalone/firmware/S4E/0000001202019313.pak Downloading FW... Activating FW... Successfully updated FW... [10:02:41.0400-GMT]{3>7} CHECKPOINT END: RESTORED:[0x060E] update_NAND_firmware restore-step-ids = {} restore-step-names = {} restore-step-uptime = 15 restore-step-user-progress = 0 [10:02:41.0414-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x060F] clear_remap_variable restore-step-ids = {0x1103060F:20} restore-step-names = {0x1103060F:clear_remap_variable} restore-step-uptime = 15 restore-step-user-progress = 0 entering clear_remap_variable executing /usr/sbin/nvram -d enable-remap-mode enable-remap-mode [10:02:41.0459-GMT]{3>7} CHECKPOINT END: RESTORED:[0x060F] clear_remap_variable restore-step-ids = {} restore-step-names = {} restore-step-uptime = 15 restore-step-user-progress = 0 [10:02:41.0462-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x065C] print_nvram_variables restore-step-ids = {0x1103065C:21} restore-step-names = {0x1103065C:print_nvram_variables} restore-step-uptime = 15 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">

auto-boot ZmFsc2U= backlight-level NzQw boot-args boot-breadcrumbs NDcyNjUpIDxCT09UPiAwMDBmMDAwNSg2MTZmNzA2NikgMDAwZjAwMDYgNDAwZjAxMDEg MDAwZjAwMDUoNzM2OTZmNjYpIDAwMGYwMDA2IDQwMGYwMTAxIDAwMGYwMDA1KDYxNmU2 NTY2KSAwMDBmMDAwNiA0MDBmMDEwMSAwMDBmMDAwNSg2MTc2NjU2NikgMDAwZjAwMDYg NDAwZjAxMDEgMDAwZjAwMDUoNjc2Njc4NjYpIDAwMGYwMDA2IDQwMGYwMTAxIDAwMGYw MDA1KDY5NzM3MDY2KSAwMDBmMDAwNiA0MDBmMDEwMSAwMDAzMDAwZig2NDc0NzI2NSkg com.apple.System.tz0-size MHhCRTAwMDAw restore-outcome aW5pdGlhbF9lbmdpbmVfbm9fcmV0dXJu restored-exit-status MHgxMDA= usbcfwflasherResult Tm8gZXJyb3Jz

[10:02:41.0486-GMT]{3>7} CHECKPOINT END: RESTORED:[0x065C] print_nvram_variables restore-step-ids = {} restore-step-names = {} restore-step-uptime = 15 restore-step-user-progress = 0 [10:02:41.0489-GMT]{3>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 = 15 restore-step-user-progress = 0 [10:02:41.0492-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0610] asp_nand_set_writable restore-step-ids = {} restore-step-names = {} restore-step-uptime = 15 restore-step-user-progress = 0 [10:02:41.0495-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0613] find_filesystem_partitions restore-step-ids = {0x11030613:23} restore-step-names = {0x11030613:find_filesystem_partitions} restore-step-uptime = 15 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=/dev/disk0s1s3 log= update= xart= hardware=/dev/disk0s1s4 scratch= [10:02:41.0501-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0613] find_filesystem_partitions restore-step-ids = {} restore-step-names = {} restore-step-uptime = 15 restore-step-user-progress = 0 [10:02:41.0504-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0665] fsck_filesystems restore-step-ids = {0x11030665:24} restore-step-names = {0x11030665:fsck_filesystems} restore-step-uptime = 15 restore-step-user-progress = 0 entering fsck_apfs_container ramrod_display_set_granular_progress_forced: 0.000000 Starting an xpc transaction. executing /System/Library/Filesystems/apfs.fs/fsck_apfs -dyo /dev/disk0s1 Checking the container superblock. Checking the space manager. Checking the space manager free queue trees. Checking the object map. Checking volume. Checking the APFS volume superblock. The volume System was formatted by newfs_apfs (945.260.7) and last modified by apfs_kext (945.260.7). Checking the object map. Checking the snapshot metadata tree. Checking the snapshot metadata. Checking the extent ref tree. Checking the fsroot tree. Checking volume. Checking the APFS volume superblock. The volume Data was formatted by newfs_apfs (748.200.60) and last modified by apfs_kext (945.260.7). Checking the object map. /sbin/mount_apfs -c /dev/disk0s1s2 /private/var dev_init:607: Using /private/var/apfs and /private/var/nx for device-io. Checking the snapshot metadata tree. Checking the snapshot metadata. Checking the extent ref tree. Checking the fsroot tree. Checking volume. Checking the APFS volume superblock. The volume Baseband Data was formatted by newfs_apfs (748.200.60) and last modified by apfs_kext (945.250.134). Checking the object map. Checking the snapshot metadata tree. Checking the snapshot metadata. Checking the extent ref tree. Checking the fsroot tree. Checking volume. Checking the APFS volume superblock. The volume Hardware was formatted by newfs_apfs (748.200.60) and last modified by apfs_kext (945.260.7). Checking the object map. Checking the snapshot metadata tree. Checking the snapshot metadata. Checking the extent ref tree. Checking the fsroot tree. Verifying allocated space. The volume /dev/disk0s1 appears to be OK. fsck succeeded on /dev/disk0s1 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=/dev/disk0s1s3 log= update= xart= hardware=/dev/disk0s1s4 scratch= [10:03:12.0826-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0665] fsck_filesystems restore-step-ids = {} restore-step-names = {} restore-step-uptime = 46 restore-step-user-progress = 0 [10:03:12.0829-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0614] mount_system_partition restore-step-ids = {0x11030614:25} restore-step-names = {0x11030614:mount_system_partition} restore-step-uptime = 46 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 [10:03:12.0853-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0614] mount_system_partition restore-step-ids = {} restore-step-names = {} restore-step-uptime = 46 restore-step-user-progress = 0 [10:03:12.0856-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0654] read_previous_os_build_version restore-step-ids = {0x11030654:26} restore-step-names = {0x11030654:read_previous_os_build_version} restore-step-uptime = 46 restore-step-user-progress = 0 unable to open /mnt1/System/Library/CoreServices/SystemVersion.plist: No such file or directory ramrod_read_previous_os_build_version: Unable to read system version plist [10:03:12.0860-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0654] read_previous_os_build_version restore-step-ids = {} restore-step-names = {} restore-step-uptime = 46 restore-step-user-progress = 0 [10:03:12.0863-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0615] copy_hardware_info restore-step-ids = {0x11030615:27} restore-step-names = {0x11030615:copy_hardware_info} restore-step-uptime = 46 restore-step-user-progress = 0 [10:03:12.0866-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0615] copy_hardware_info restore-step-ids = {} restore-step-names = {} restore-step-uptime = 46 restore-step-user-progress = 0 [10:03:12.0870-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0616] fdr_create restore-step-ids = {0x11030616:28} restore-step-names = {0x11030616:fdr_create} restore-step-uptime = 46 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] : da 30 67 3a 75 24 63 69 94 6f 40 4d 80 6d 7d 7c : 02 ee 52 e3 : ----------------------------------------------- CryptoGenerateRSAKeys: SecKeyCreateRSAPrivateKey -> 0x102d7c8f8 CryptoGenerateRSAKeys: SecKeyCreateRSAPublicKey -> 0x102d7c8f0 _copyDataInstanceForSealingMapEntry: Using value 0000005E-0A01D1F15DAFE63200000000 for key BasebandUniqueId from query cache _copyDataInstanceForSealingMapEntry: Using value 0000005E-0A01D1F15DAFE63200000000 for key BasebandUniqueId from query cache _copyDataInstanceForSealingMapEntry: Using value 32800 for key ChipID from query cache _copyDataInstanceForSealingMapEntry: Using value 4909083227848750 for key UniqueChipID from query cache _copyDataInstanceForSealingMapEntry: Using value FXR826237XJJNK595+11013104696167073811771913 for key CoverglassSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value 3E-82808872 for key AmbientLightSensorSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x14bd333a0 [0x103c1f940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x14bd333a0 [0x103c1f940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x14bd333a0 [0x103c1f940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x14bd333a0 [0x103c1f940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x14bd333a0 [0x103c1f940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x14bd333a0 [0x103c1f940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x14bd333a0 [0x103c1f940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x14bd333a0 [0x103c1f940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x14bd333a0 [0x103c1f940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x14bd333a0 [0x103c1f940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x14bd333a0 [0x103c1f940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x14bd333a0 [0x103c1f940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x14bd333a0 [0x103c1f940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x14bd333a0 [0x103c1f940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value 32800 for key ChipID from query cache _copyDataInstanceForSealingMapEntry: Using value 4909083227848750 for key UniqueChipID from query cache _copyDataInstanceForSealingMapEntry: Using value A4.01-000000000DD0941E6738BCCC50EC0455 for key NFCUniqueChipID from query cache _copyDataInstanceForSealingMapEntry: Using value 32800 for key ChipID from query cache _copyDataInstanceForSealingMapEntry: Using value 4909083227848750 for key UniqueChipID from query cache _copyDataInstanceForSealingMapEntry: Using value 32800 for key ChipID from query cache _copyDataInstanceForSealingMapEntry: Using value 4909083227848750 for key UniqueChipID from query cache _copyDataInstanceForSealingMapEntry: Using value 32800 for key ChipID from query cache _copyDataInstanceForSealingMapEntry: Using value 4909083227848750 for key UniqueChipID from query cache _copyDataInstanceForSealingMapEntry: Using value 32800 for key ChipID from query cache _copyDataInstanceForSealingMapEntry: Using value 4909083227848750 for key UniqueChipID from query cache created HTTP FDR client 0x14bd32d80 _copyDataInstanceForSealingMapEntry: Using value 0000005E-0A01D1F15DAFE63200000000 for key BasebandUniqueId from query cache _copyDataInstanceForSealingMapEntry: Using value 0000005E-0A01D1F15DAFE63200000000 for key BasebandUniqueId from query cache _copyDataInstanceForSealingMapEntry: Using value 32800 for key ChipID from query cache _copyDataInstanceForSealingMapEntry: Using value 4909083227848750 for key UniqueChipID from query cache _copyDataInstanceForSealingMapEntry: Using value FXR826237XJJNK595+11013104696167073811771913 for key CoverglassSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value 3E-82808872 for key AmbientLightSensorSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x14d100ba0 [0x103c1f940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x14d100ba0 [0x103c1f940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x14d100ba0 [0x103c1f940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x14d100ba0 [0x103c1f940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x14d100ba0 [0x103c1f940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x14d100ba0 [0x103c1f940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x14d100ba0 [0x103c1f940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x14d100ba0 [0x103c1f940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x14d100ba0 [0x103c1f940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x14d100ba0 [0x103c1f940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x14d100ba0 [0x103c1f940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x14d100ba0 [0x103c1f940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x14d100ba0 [0x103c1f940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x14d100ba0 [0x103c1f940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value 32800 for key ChipID from query cache _copyDataInstanceForSealingMapEntry: Using value 4909083227848750 for key UniqueChipID from query cache _copyDataInstanceForSealingMapEntry: Using value A4.01-000000000DD0941E6738BCCC50EC0455 for key NFCUniqueChipID from query cache _copyDataInstanceForSealingMapEntry: Using value 32800 for key ChipID from query cache _copyDataInstanceForSealingMapEntry: Using value 4909083227848750 for key UniqueChipID from query cache _copyDataInstanceForSealingMapEntry: Using value 32800 for key ChipID from query cache _copyDataInstanceForSealingMapEntry: Using value 4909083227848750 for key UniqueChipID from query cache _copyDataInstanceForSealingMapEntry: Using value 32800 for key ChipID from query cache _copyDataInstanceForSealingMapEntry: Using value 4909083227848750 for key UniqueChipID from query cache _copyDataInstanceForSealingMapEntry: Using value 32800 for key ChipID from query cache _copyDataInstanceForSealingMapEntry: Using value 4909083227848750 for key UniqueChipID from query cache created local FDR client 0x14d1008f0 Received response without expected RESTORED_FDR_TRUST_DATA AMSupportPlatformMakeDirectoryForURL: Could not mkdir (Read-only file system) AMSupportPlatformMakeDirectoryForURL: /mnt1/System AMFDRCreateError: AMFDRDataLocalCopyDataStoragePath: AMSupportMakeDirectory failed: code=4 AMFDRCreateError: AMFDRDataLocalCopy: missing data storage path: code=4 failed to copy trust object from fdrLocal 0: AMFDRError/4: missing data storage path 1: AMFDRError/4: AMSupportMakeDirectory failed Found ramdisk trust object, computing digest.. Ramdisk trust object digest DOES match AP ticket. Not enabling SSO for FDR RestoredFDRCreate() returned 0 FDR is supported on this device [10:03:14.0178-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0616] fdr_create restore-step-ids = {} restore-step-names = {} restore-step-uptime = 48 restore-step-user-progress = 0 [10:03:14.0182-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0617] fdr_save_data restore-step-ids = {0x11030617:29} restore-step-names = {0x11030617:fdr_save_data} restore-step-uptime = 48 restore-step-user-progress = 0 _AMFDRAPTicketHasBooleanEntitlement: no ticket in options AMFDRSealingMapCreateAndPopulateSealedData: populate sealedData with sealing manifest, sealingManifestOverride : (null), forceSealing : (null), allowForbidden : (null), allowUnSeal : 0 AMSupportPlatformMakeDirectoryForURL: Could not mkdir (Read-only file system) AMSupportPlatformMakeDirectoryForURL: /mnt1/System AMFDRCreateError: AMFDRDataLocalCopyDataStoragePath: AMSupportMakeDirectory failed: code=4 AMFDRCreateError: AMFDRDataLocalCopy: missing data storage path: code=4 AMFDRCreateError: AMFDRDataCopy: seal:00008020-001170C901F8002E get data failed - foundData is NULL: code=10 AMFDRCreateError: AMFDRSealingMapPopulateSealingManifest: sealingManifest is NULL: code=10 AMFDRCreateError: AMFDRSealingMapCreateAndPopulateSealedData: AMFDRSealingMapPopulateSealingManifest failed on amfdr: code=10 AMFDRSealedDataRestoreOptions: sealedData is NULL failed to save FDR persistent state RestoredFDRSaveData success [10:03:14.0191-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0617] fdr_save_data restore-step-ids = {} restore-step-names = {} restore-step-uptime = 48 restore-step-user-progress = 0 [10:03:14.0194-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0618] store_baseband_migration restore-step-ids = {0x11030618:30} restore-step-names = {0x11030618:store_baseband_migration} restore-step-uptime = 48 restore-step-user-progress = 0 [10:03:14.0197-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0618] store_baseband_migration restore-step-ids = {} restore-step-names = {} restore-step-uptime = 48 restore-step-user-progress = 0 [10:03:14.0200-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0619] check_for_restore_log restore-step-ids = {0x11030619:31} restore-step-names = {0x11030619:check_for_restore_log} restore-step-uptime = 48 restore-step-user-progress = 0 entering check_for_restore_log restore log does not exist [10:03:14.0204-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0619] check_for_restore_log restore-step-ids = {} restore-step-names = {} restore-step-uptime = 48 restore-step-user-progress = 0 [10:03:14.0207-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x061A] check_for_ota_logs restore-step-ids = {0x1103061A:32} restore-step-names = {0x1103061A:check_for_ota_logs} restore-step-uptime = 48 restore-step-user-progress = 0 entering mount_partition executing /System/Library/Filesystems/apfs.fs/mount_apfs /dev/disk0s1s2 /mnt2 /dev/disk0s1s2 mounted on /mnt2 Data mounted read-write entering dump_and_return_panic_logs entering dump_panic_logs executing /System/Library/CoreServices/DumpPanic -r/mnt2/mobile/Library/Logs/CrashReporter Looking for logs between 1559469794 and 1559469794 entering check_for_ota_logs_with_mount_point Diagnostic log submission disabled Searching /mnt2/mobile/Library/Logs/CrashReporter/ check_for_ota_logs_with_mount_point complete Found log directory(/mnt2/MobileSoftwareUpdate/lastOTA)..Deleting contentsSuccessfully checked for OTA logs [10:03:14.0677-GMT]{3>7} CHECKPOINT END: RESTORED:[0x061A] check_for_ota_logs restore-step-ids = {} restore-step-names = {} restore-step-uptime = 48 restore-step-user-progress = 0 [10:03:14.0680-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x061B] submit_update_stats restore-step-ids = {0x1103061B:33} restore-step-names = {0x1103061B:submit_update_stats} restore-step-uptime = 48 restore-step-user-progress = 0 entering mount_partition executing /sbin/mount -u -w /dev/disk0s1s1 /mnt1 Changed permissions on /dev/disk0s1s1 mounted at /mnt1 to readwrite entering mount_partition Data already mounted read-write (mount ignored) Attempting to update nvram shadow file /mnt2/MobileSoftwareUpdate/nvram.plist ramrod-nvram-shadow-path = /mnt2/MobileSoftwareUpdate/nvram.plist executing /usr/sbin/nvram ramrod-nvram-shadow-path=/mnt2/MobileSoftwareUpdate/nvram.plist ramrod-nvram-session = 1559469746 executing /usr/sbin/nvram ramrod-nvram-session=1559469746 Loaded persistent file: { "OTA-fsck-metrics" = "dev= vers=945.250.134 result=0 fp=0 fl=-1 repairs=0 time=1 iter=1"; "auto-boot" = true; "backlight-level" = <373430>; "boot-args" = ""; "com.apple.System.tz0-size" = 0xBE00000; "ota-breadcrumbs" = "2:pBjDoACEHLKNnlacedTUWXZ"; "ota-outcome" = success; "ota-result" = success; "ota-step-ids" = "{}"; "ota-step-monitor" = "{0x11010207:\"wifexited\"}"; "ota-step-names" = "{}"; "ota-step-uptime" = 216; "ota-step-user-progress" = 100; "ramrod-file-only-vars" = { "OTA-fsck-metrics" = "dev= vers=945.250.134 result=0 fp=0 fl=-1 repairs=0 time=1 iter=1"; "auto-boot" = true; "com.apple.System.tz0-size" = 0xBE00000; "ota-breadcrumbs" = "2:pBjDoACEHLKNnlacedTUWXZ"; "ota-outcome" = success; "ota-result" = success; "ota-step-ids" = "{}"; "ota-step-monitor" = "{0x11010207:\"wifexited\"}"; "ota-step-names" = "{}"; "ota-step-uptime" = 216; "ota-step-user-progress" = 100; "ramrod-nvram-session" = 1559020603; "ramrod-nvram-shadow-path" = "/mnt2/MobileSoftwareUpdate/nvram.plist"; "restore-outcome" = "initial_engine_no_return"; "restore-step-ids" = "{0x1103061B:33}"; "restore-step-names" = "{0x1103061B:submit_update_stats}"; "restore-step-uptime" = 48; "restore-step-user-progress" = 0; "restore-step-warnings" = "{0x11060407:{0:\"gasgauge_start_update_thread failed: -1\"}}"; }; "ramrod-nvram-sequence" = <31>; "ramrod-nvram-session" = 1559020603; "ramrod-nvram-shadow-path" = "/mnt2/MobileSoftwareUpdate/nvram.plist"; "ramrod-nvram-shadow-vars" = { "auto-boot" = <66616c73 65>; "backlight-level" = <373430>; "boot-args" = ""; "com.apple.System.tz0-size" = <30784245 30303030 30>; "ramrod-nvram-sequence" = <31>; "ramrod-nvram-session" = <31353539 30323036 3033>; "ramrod-nvram-shadow-path" = <2f6d6e74 322f4d6f 62696c65 536f6674 77617265 55706461 74652f6e 7672616d 2e706c69 7374>; "restore-outcome" = <696e6974 69616c5f 656e6769 6e655f6e 6f5f7265 7475726e>; "restored-exit-status" = <30783130 30>; usbcfwflasherResult = <4e6f2065 72726f72 73>; }; "restore-outcome" = "initial_engine_no_return"; "restore-step-ids" = "{0x1103061B:33}"; "restore-step-names" = "{0x1103061B:submit_update_stats}"; "restore-step-uptime" = 48; "restore-step-user-progress" = 0; "restore-step-warnings" = "{0x11060407:{0:\"gasgauge_start_update_thread failed: -1\"}}"; "restored-exit-status" = <30783130 30>; usbcfwflasherResult = <4e6f2065 72726f72 73>; } Pending file-vars: { "ramrod-nvram-session" = 1559469746; "ramrod-nvram-shadow-path" = "/mnt2/MobileSoftwareUpdate/nvram.plist"; "restore-outcome" = "initial_engine_no_return"; "restore-step-ids" = "{0x1103061B:33}"; "restore-step-names" = "{0x1103061B:submit_update_stats}"; "restore-step-uptime" = 48; "restore-step-user-progress" = 0; "restore-step-warnings" = "{0x11060407:{0:\"gasgauge_start_update_thread failed: -1\"}}"; } Pending var deletes: ( "enable-remap-mode" ) Final vars: { "OTA-fsck-metrics" = "dev= vers=945.250.134 result=0 fp=0 fl=-1 repairs=0 time=1 iter=1"; "auto-boot" = true; "com.apple.System.tz0-size" = 0xBE00000; "ota-breadcrumbs" = "2:pBjDoACEHLKNnlacedTUWXZ"; "ota-outcome" = success; "ota-result" = success; "ota-step-ids" = "{}"; "ota-step-monitor" = "{0x11010207:\"wifexited\"}"; "ota-step-names" = "{}"; "ota-step-uptime" = 216; "ota-step-user-progress" = 100; "ramrod-nvram-session" = 1559469746; "ramrod-nvram-shadow-path" = "/mnt2/MobileSoftwareUpdate/nvram.plist"; "restore-outcome" = "initial_engine_no_return"; "restore-step-ids" = "{0x1103061B:33}"; "restore-step-names" = "{0x1103061B:submit_update_stats}"; "restore-step-uptime" = 48; "restore-step-user-progress" = 0; "restore-step-warnings" = "{0x11060407:{0:\"gasgauge_start_update_thread failed: -1\"}}"; } executing /usr/sbin/nvram ramrod-nvram-sequence=1 Failed to persist contents of nvram to the filesystem. File system may not be available nvram will be shadowed at the path /mnt2/MobileSoftwareUpdate/nvram.plist AMSupportHttpCopyProxySettings_block_invoke: Proxy available AMSupportHttpCopyProxySettings_block_invoke: AMSupportHttpCopyProxySettings: RPNotificationProxyAvailable AMSupportHttpCopyProxySettings: proxyInfo = <CFBasicHash 0x14be06270 [0x103c1f940]>{type = mutable dict, count = 2, entries => 0 : <CFString 0x103c56748 [0x103c1f940]>{contents = "SOCKSProxy"} = <CFString 0x102f1cdd8 [0x103c1f940]>{contents = "127.0.0.1"} 1 : <CFString 0x103c56768 [0x103c1f940]>{contents = "SOCKSPort"} = <CFNumber 0xbfe54b7eae76932e [0x103c1f940]>{value = +1081, type = kCFNumberSInt32Type} }

calling UMEventShimSubmitEvents : start

: ignoring call to recordPostUpdateEvent when no install is in progress or we haven't performed the apply operation

UMEventShimSubmitEvents done : submitEventsInBackground running

[10:03:14.0785-GMT]{3>7} CHECKPOINT END: RESTORED:[0x061B] submit_update_stats restore-step-ids = {} restore-step-names = {} restore-step-uptime = 48 restore-step-user-progress = 0 [10:03:14.0788-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0661] read_persistent_files restore-step-ids = {0x11030661:34} restore-step-names = {0x11030661:read_persistent_files} restore-step-uptime = 48 restore-step-user-progress = 0 executing /System/Library/Filesystems/apfs.fs/mount_apfs /dev/disk0s1s4 /mnt6 : unable to set attributes on directory for update events: Error Domain=NSCocoaErrorDomain Code=640 "(null)" UserInfo={NSFilePath=/mnt2/db/UpdateMetrics/Events, NSUnderlyingError=0x14d101420 {Error Domain=NSPOSIXErrorDomain Code=28 "No space left on device"}}

/dev/disk0s1s4 mounted on /mnt6 File /mnt2/iomfb_bics_daemon/bic: not found. File /mnt2/iomfb_bics_daemon/history: not found. File /mnt6/bic: 666772 bytes read into memory. File /mnt6/history: 21933776 bytes read into memory. 2 files found in total. [10:03:14.0851-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0661] read_persistent_files restore-step-ids = {} restore-step-names = {} restore-step-uptime = 48 restore-step-user-progress = 0 [10:03:14.0854-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x061D] unmount_unconditionally restore-step-ids = {0x1103061D:35} restore-step-names = {0x1103061D:unmount_unconditionally} restore-step-uptime = 48 restore-step-user-progress = 0 entering unmount_filesystems ramrod_display_set_granular_progress_forced: 1.000000 entering unmount_partition System unmounted ramrod_display_set_granular_progress_forced: 1.000000 entering unmount_partition Data unmounted create_baseband_update_options: Got imeisv: 9 baseband updater options = <CFBasicHash 0x14bd364b0 [0x103c1f940]>{type = mutable dict, count = 4, entries => 0 : <CFString 0x103122780 [0x103c1f940]>{contents = "IMEISwVersion"} = <CFNumber 0xbfe54b7eae76d02e [0x103c1f940]>{value = +9, type = kCFNumberSInt32Type} 1 : <CFString 0x103122740 [0x103c1f940]>{contents = "restoredInternal"} = <CFBoolean 0x103c25508 [0x103c1f940]>{value = false} 2 : <CFString 0x1031228a0 [0x103c1f940]>{contents = "autoSetupEnv"} = <CFBoolean 0x103c25508 [0x103c1f940]>{value = false} 6 : <CFString 0x1031228c0 [0x103c1f940]>{contents = "disablePing"} = <CFBoolean 0x103c254f0 [0x103c1f940]>{value = true} }

_baseband_update_requires_filesystems_once: querying baseband to determine if it requires system filesystem bbupdater: BEGIN: Command: requirePartitionMount bbupdater: cmdCopyRequirePartitionMount: supports flashless 1 bbupdater: cmdCopyRequirePartitionMount: supports REFS 1 bbupdater: END: Command: requirePartitionMount _baseband_update_requires_filesystems_once: query returned <CFBasicHash 0x14bd35660 [0x103c1f940]>{type = mutable dict, count = 3, entries => 0 : <CFString 0x103122100 [0x103c1f940]>{contents = "requireUserPartitionMount"} = <CFBoolean 0x103c254f0 [0x103c1f940]>{value = true} 1 : <CFString 0x103122120 [0x103c1f940]>{contents = "requestedBasebandFSPartitionMountSize"} = <CFNumber 0xbfe54b7eae76d01f [0x103c1f940]>{value = +10, type = kCFNumberSInt64Type} 2 : <CFString 0x1031220c0 [0x103c1f940]>{contents = "requireSystemPartitionMount"} = <CFBoolean 0x103c254f0 [0x103c1f940]>{value = true} }

ramrod_display_set_granular_progress_forced: 1.000000 entering unmount_partition Baseband Data not mounted (unmount ignored) ramrod_display_set_granular_progress_forced: 1.000000 entering unmount_partition xART not mounted (unmount ignored) ramrod_display_set_granular_progress_forced: 1.000000 entering unmount_partition Hardware not mounted (unmount ignored) [10:03:14.0905-GMT]{3>7} CHECKPOINT END: RESTORED:[0x061D] unmount_unconditionally restore-step-ids = {} restore-step-names = {} restore-step-uptime = 48 restore-step-user-progress = 1 [10:03:14.0908-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x064E] clean_nand restore-step-ids = {0x1103064E:36} restore-step-names = {0x1103064E:clean_nand} restore-step-uptime = 48 restore-step-user-progress = 1 entering clean_NAND [10:03:14.0912-GMT]{3>7} CHECKPOINT END: RESTORED:[0x064E] clean_nand restore-step-ids = {} restore-step-names = {} restore-step-uptime = 48 restore-step-user-progress = 1 [10:03:14.0915-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0653] create_readwrite_ramdisk restore-step-ids = {0x11030653:37} restore-step-names = {0x11030653:create_readwrite_ramdisk} restore-step-uptime = 48 restore-step-user-progress = 1 executing /usr/sbin/hdik -nomount ram://5120 /dev/disk4
executing /sbin/newfs_hfs -J -v readwrite_ramdisk /dev/disk4 Initialized /dev/rdisk4 as a 3 MB case-insensitive HFS Plus volume with a 512k journal executing /sbin/fsck_hfs -fdy /dev/disk4 journal_replay(/dev/disk4) returned 0 /dev/rdisk4 Using cacheBlockSize=32K cacheTotalBlock=14864 cacheSize=475648K. Executing fsck_hfs (version hfs-407.200.4). Checking Journaled HFS Plus volume. The volume name is readwrite_ramdisk Checking extents overflow file. Checking catalog file. Checking multi-linked files. Checking catalog hierarchy. Checking extended attributes file. Checking volume bitmap. Checking volume information. The volume readwrite_ramdisk appears to be OK. CheckHFS returned 0, fsmodified = 0 executing /sbin/mount_hfs /dev/disk4 /mnt5 mount_hfs: Could not create property for re-key environment check: No such file or directory entering show_service_nodes disk0

IOBlockStorageDriver RegistryID : 0x100000375 Busy State : 0x0 Service State : 0x1e NS_01 RegistryID : 0x10000036e Busy State : 0x0 Service State : 0x1e AppleANS2CGNVMeController RegistryID : 0x10000030e Busy State : 0x0 Service State : 0x1e RTBuddyV2 RegistryID : 0x1000002db Busy State : 0x0 Service State : 0x1e iop-ans-nub RegistryID : 0x100000149 Busy State : 0x0 Service State : 0x1e AppleASCWrapV2 RegistryID : 0x100000224 Busy State : 0x0 Service State : 0x0 ans RegistryID : 0x100000148 Busy State : 0x0 Service State : 0x1e AppleT802xIO RegistryID : 0x10000020d Busy State : 0x6 Service State : 0x1e arm-io RegistryID : 0x100000112 Busy State : 0x1 Service State : 0x1e AppleARMPE RegistryID : 0x1000001e6 Busy State : 0x1 Service State : 0x1e D321AP RegistryID : 0x1000001e5 Busy State : 0x1 Service State : 0x1e Root RegistryID : 0x100000100 Busy State : 0x0 Service State : 0x0

disk1

IOBlockStorageDriver RegistryID : 0x10000043a Busy State : 0x0 Service State : 0x1e NS_02 RegistryID : 0x100000439 Busy State : 0x0 Service State : 0x1e AppleANS2CGNVMeController RegistryID : 0x10000030e Busy State : 0x0 Service State : 0x1e RTBuddyV2 RegistryID : 0x1000002db Busy State : 0x0 Service State : 0x1e iop-ans-nub RegistryID : 0x100000149 Busy State : 0x0 Service State : 0x1e AppleASCWrapV2 RegistryID : 0x100000224 Busy State : 0x0 Service State : 0x0 ans RegistryID : 0x100000148 Busy State : 0x0 Service State : 0x1e AppleT802xIO RegistryID : 0x10000020d Busy State : 0x6 Service State : 0x1e arm-io RegistryID : 0x100000112 Busy State : 0x1 Service State : 0x1e AppleARMPE RegistryID : 0x1000001e6 Busy State : 0x1 Service State : 0x1e D321AP RegistryID : 0x1000001e5 Busy State : 0x1 Service State : 0x1e Root RegistryID : 0x100000100 Busy State : 0x0 Service State : 0x0

disk2

IOBlockStorageDriver RegistryID : 0x100000446 Busy State : 0x0 Service State : 0x1e NS_07 RegistryID : 0x100000445 Busy State : 0x0 Service State : 0x1e AppleANS2CGNVMeController RegistryID : 0x10000030e Busy State : 0x0 Service State : 0x1e RTBuddyV2 RegistryID : 0x1000002db Busy State : 0x0 Service State : 0x1e iop-ans-nub RegistryID : 0x100000149 Busy State : 0x0 Service State : 0x1e AppleASCWrapV2 RegistryID : 0x100000224 Busy State : 0x0 Service State : 0x0 ans RegistryID : 0x100000148 Busy State : 0x0 Service State : 0x1e AppleT802xIO RegistryID : 0x10000020d Busy State : 0x6 Service State : 0x1e arm-io RegistryID : 0x100000112 Busy State : 0x1 Service State : 0x1e AppleARMPE RegistryID : 0x1000001e6 Busy State : 0x1 Service State : 0x1e D321AP RegistryID : 0x1000001e5 Busy State : 0x1 Service State : 0x1e Root RegistryID : 0x100000100 Busy State : 0x0 Service State : 0x0

disk3

IOBlockStorageDriver RegistryID : 0x10000044d Busy State : 0x0 Service State : 0x1e NS_08 RegistryID : 0x10000044c Busy State : 0x0 Service State : 0x1e AppleANS2CGNVMeController RegistryID : 0x10000030e Busy State : 0x0 Service State : 0x1e RTBuddyV2 RegistryID : 0x1000002db Busy State : 0x0 Service State : 0x1e iop-ans-nub RegistryID : 0x100000149 Busy State : 0x0 Service State : 0x1e AppleASCWrapV2 RegistryID : 0x100000224 Busy State : 0x0 Service State : 0x0 ans RegistryID : 0x100000148 Busy State : 0x0 Service State : 0x1e AppleT802xIO RegistryID : 0x10000020d Busy State : 0x6 Service State : 0x1e arm-io RegistryID : 0x100000112 Busy State : 0x1 Service State : 0x1e AppleARMPE RegistryID : 0x1000001e6 Busy State : 0x1 Service State : 0x1e D321AP RegistryID : 0x1000001e5 Busy State : 0x1 Service State : 0x1e Root RegistryID : 0x100000100 Busy State : 0x0 Service State : 0x0

disk4

IOBlockStorageDriver RegistryID : 0x10000047d Busy State : 0x0 Service State : 0x1e IODiskImageBlockStorageDeviceInKernel RegistryID : 0x10000047c Busy State : 0x0 Service State : 0x1e IOHDIXHDDriveInKernel RegistryID : 0x10000047b Busy State : 0x0 Service State : 0x1e KDIDiskImageNub RegistryID : 0x10000047a Busy State : 0x0 Service State : 0x1e KDIReadWriteDiskImage RegistryID : 0x100000479 Busy State : 0x0 Service State : 0x1e KDIRAMBackingStore RegistryID : 0x100000476 Busy State : 0x0 Service State : 0x1e ram://5120 RegistryID : 0x100000475 Busy State : 0x0 Service State : 0x1e IOHDIXController RegistryID : 0x1000001f3 Busy State : 0x0 Service State : 0x1e IOResources RegistryID : 0x1000001e8 Busy State : 0x0 Service State : 0x1e D321AP RegistryID : 0x1000001e5 Busy State : 0x1 Service State : 0x1e Root RegistryID : 0x100000100 Busy State : 0x0 Service State : 0x0

[10:03:15.0092-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0653] create_readwrite_ramdisk restore-step-ids = {} restore-step-names = {} restore-step-uptime = 49 restore-step-user-progress = 1 [10:03:15.0092-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x061F] format_effaceable_storage restore-step-ids = {0x1103061F:38} restore-step-names = {0x1103061F:format_effaceable_storage} restore-step-uptime = 49 restore-step-user-progress = 1 entering format_effaceable_storage effaceable storage is formatted, nothing to do [10:03:15.0094-GMT]{3>7} CHECKPOINT END: RESTORED:[0x061F] format_effaceable_storage restore-step-ids = {} restore-step-names = {} restore-step-uptime = 49 restore-step-user-progress = 1 [10:03:15.0094-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0660] update_partitions_for_apfs restore-step-ids = {0x11030660:39} restore-step-names = {0x11030660:update_partitions_for_apfs} restore-step-uptime = 49 restore-step-user-progress = 1 APFS Update Install entering check_for_compatibility check_for_compatibility - Status Online Deleting System partition during Update Install delete_apfs_partition returned 0 during Update Install We should not have an xART partition. Attempting to delete Update partition during Update install 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= data=/dev/disk0s1s2 baseband data=/dev/disk0s1s3 log= update= xart= hardware=/dev/disk0s1s4 scratch= delete_apfs_update_partition_if_exists : no update partition found, returning 0 [10:03:15.0831-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0660] update_partitions_for_apfs restore-step-ids = {} restore-step-names = {} restore-step-uptime = 49 restore-step-user-progress = 1 [10:03:15.0834-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0622] reload_filesystem_partitions restore-step-ids = {0x11030622:40} restore-step-names = {0x11030622:reload_filesystem_partitions} restore-step-uptime = 49 restore-step-user-progress = 1 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= data=/dev/disk0s1s2 baseband data=/dev/disk0s1s3 log= update= xart= hardware=/dev/disk0s1s4 scratch= [10:03:15.0841-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0622] reload_filesystem_partitions restore-step-ids = {} restore-step-names = {} restore-step-uptime = 49 restore-step-user-progress = 1 [10:03:15.0844-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x065D] delete_mobilebackups restore-step-ids = {0x1103065D:41} restore-step-names = {0x1103065D:delete_mobilebackups} restore-step-uptime = 49 restore-step-user-progress = 1 executing /System/Library/Filesystems/apfs.fs/mount_apfs /dev/disk0s1s2 /mnt2 /dev/disk0s1s2 mounted on /mnt2 ramrod_delete_all_mobilebackup_snapshots : No snapshots to delete on /mnt2 [10:03:16.0305-GMT]{3>7} CHECKPOINT END: RESTORED:[0x065D] delete_mobilebackups restore-step-ids = {} restore-step-names = {} restore-step-uptime = 50 restore-step-user-progress = 1 [10:03:16.0310-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0658] format_media restore-step-ids = {0x11030658:42} restore-step-names = {0x11030658:format_media} restore-step-uptime = 50 restore-step-user-progress = 1 Update install using APFS diskimage on APFS formatted device, no converter use necessary entering create_apfs_filesystems 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= data=/dev/disk0s1s2 baseband data=/dev/disk0s1s3 log= update= xart= hardware=/dev/disk0s1s4 scratch= ramrod_display_set_granular_progress_forced: 1.000000 block size for /dev/disk0s1: 4096 /System/Library/Filesystems/apfs.fs/newfs_apfs -A -o fsindex=0 -v System /dev/disk0s1 executing /System/Library/Filesystems/apfs.fs/newfs_apfs -A -o fsindex=0 -v System /dev/disk0s1 We should not have an xART partition. Not creating an xART partition because we're on a system that doesn't support it. IORegistry requires a 50 MiB Hardware Partition executing /System/Library/Filesystems/apfs.fs/mount_apfs /dev/disk0s1s4 /mnt6 /dev/disk0s1s4 mounted on /mnt6 totalBlocks:12800 blockSize:4096 blocksAvailable:7227 Filesystem /mnt6 is 50 MB get_total_file_system_size is 52428800 Hardware volume looks OK, doing nothing. Should we generate a scratch partition? Not generating a sctach partition because the system doesn't support it. [10:03:17.0797-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0658] format_media restore-step-ids = {} restore-step-names = {} restore-step-uptime = 51 restore-step-user-progress = 1 [10:03:17.0801-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0659] find_volumes_after_format restore-step-ids = {0x11030659:43} restore-step-names = {0x11030659:find_volumes_after_format} restore-step-uptime = 51 restore-step-user-progress = 1 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=/dev/disk0s1s3 log= update= xart= hardware=/dev/disk0s1s4 scratch= [10:03:17.0810-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0659] find_volumes_after_format restore-step-ids = {} restore-step-names = {} restore-step-uptime = 51 restore-step-user-progress = 1 [10:03:17.0813-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x065F] reserve_overprov_space restore-step-ids = {0x1103065F:44} restore-step-names = {0x1103065F:reserve_overprov_space} restore-step-uptime = 51 restore-step-user-progress = 1 executing /System/Library/Filesystems/apfs.fs/mount_apfs /dev/disk0s1s2 /mnt2 /dev/disk0s1s2 mounted on /mnt2 space already reserved for overprovisioning [10:03:18.0468-GMT]{3>7} CHECKPOINT END: RESTORED:[0x065F] reserve_overprov_space restore-step-ids = {} restore-step-names = {} restore-step-uptime = 52 restore-step-user-progress = 1 [10:03:18.0475-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0662] write_persistent_files restore-step-ids = {0x11030662:45} restore-step-names = {0x11030662:write_persistent_files} restore-step-uptime = 52 restore-step-user-progress = 1 executing /System/Library/Filesystems/apfs.fs/mount_apfs /dev/disk0s1s2 /mnt2 /dev/disk0s1s2 mounted on /mnt2 executing /System/Library/Filesystems/apfs.fs/mount_apfs /dev/disk0s1s4 /mnt6 /dev/disk0s1s4 mounted on /mnt6 Not overwriting file in stage1. Not overwriting file in stage1. Committed 2 persistent files to NAND [10:03:19.0165-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0662] write_persistent_files restore-step-ids = {} restore-step-names = {} restore-step-uptime = 53 restore-step-user-progress = 1 [10:03:19.0171-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x065A] baseband_migration_data restore-step-ids = {0x1103065A:46} restore-step-names = {0x1103065A:baseband_migration_data} restore-step-uptime = 53 restore-step-user-progress = 1 [10:03:19.0176-GMT]{3>7} CHECKPOINT END: RESTORED:[0x065A] baseband_migration_data restore-step-ids = {} restore-step-names = {} restore-step-uptime = 53 restore-step-user-progress = 1 [10:03:19.0180-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x065B] asr_and_invert_image restore-step-ids = {0x1103065B:47} restore-step-names = {0x1103065B:asr_and_invert_image} restore-step-uptime = 53 restore-step-user-progress = 1 restore_apfs_image : started restoring an APFS image entering mount_partition executing /System/Library/Filesystems/apfs.fs/mount_apfs /dev/disk0s1s1 /mnt1 /dev/disk0s1s1 mounted on /mnt1 System mounted read-write Successfully marked device node /dev/rdisk0s1s1 as static data OS digest = 41a524fe51d993b206dbcb920e76d768306fa86cd2c59e60714db7079ebb6a0e0eb6841d3b7a16f062b59860f6df1806 Restoring to APFS Inverter Image = /mnt1/apfs_invert_asr_img executing /usr/sbin/asr -source asr://localhost:12345 -target /mnt1/apfs_invert_asr_img --embed -erase -noprompt --chunkchecksum --puppetstrings --expectedhash 41a524fe51d993b206dbcb920e76d768306fa86cd2c59e60714db7079ebb6a0e0eb6841d3b7a16f062b59860f6df1806 ASR STATUS: start 412 multicast-client ASR: Waiting for connection attempt from server ASR STATUS: setup ASR: Validating target...done ASR STATUS: metadata ASR: Validating source... ASR: nx_kernel_mount:1473: : checkpoint search: largest xid 11, best xid 11 @ 21 ASR: done ASR: Retrieving scan information... ASR: done ASR: Validating sizes...done ASR STATUS: restore ASR RESTORE PROGRESS: 2% ramrod_display_set_granular_progress_forced: 6.000000 ASR RESTORE PROGRESS: 4% ramrod_display_set_granular_progress_forced: 7.000000 ASR RESTORE PROGRESS: 6% ramrod_display_set_granular_progress_forced: 7.000000 ASR RESTORE PROGRESS: 8% ramrod_display_set_granular_progress_forced: 8.000000 ASR RESTORE PROGRESS: 10% ramrod_display_set_granular_progress_forced: 8.000000 ASR RESTORE PROGRESS: 12% ramrod_display_set_granular_progress_forced: 9.000000 ASR RESTORE PROGRESS: 14% ramrod_display_set_granular_progress_forced: 10.000000 ASR RESTORE PROGRESS: 16% ramrod_display_set_granular_progress_forced: 10.000000 ASR RESTORE PROGRESS: 18% ramrod_display_set_granular_progress_forced: 11.000000 ASR RESTORE PROGRESS: 20% ramrod_display_set_granular_progress_forced: 11.000000 ASR RESTORE PROGRESS: 22% ramrod_display_set_granular_progress_forced: 12.000000 ASR RESTORE PROGRESS: 24% ramrod_display_set_granular_progress_forced: 12.000000 ASR RESTORE PROGRESS: 26% ramrod_display_set_granular_progress_forced: 13.000000 ASR RESTORE PROGRESS: 28% ramrod_display_set_granular_progress_forced: 13.000000 ASR RESTORE PROGRESS: 30% ramrod_display_set_granular_progress_forced: 14.000000 ASR RESTORE PROGRESS: 32% ramrod_display_set_granular_progress_forced: 15.000000 ASR RESTORE PROGRESS: 34% ramrod_display_set_granular_progress_forced: 15.000000 ASR RESTORE PROGRESS: 36% ramrod_display_set_granular_progress_forced: 16.000000 ASR RESTORE PROGRESS: 38% ramrod_display_set_granular_progress_forced: 16.000000 ASR RESTORE PROGRESS: 40% ramrod_display_set_granular_progress_forced: 17.000000 ASR RESTORE PROGRESS: 42% ramrod_display_set_granular_progress_forced: 17.000000 ASR RESTORE PROGRESS: 44% ramrod_display_set_granular_progress_forced: 18.000000 ASR RESTORE PROGRESS: 46% ramrod_display_set_granular_progress_forced: 18.000000 ASR RESTORE PROGRESS: 48% ramrod_display_set_granular_progress_forced: 19.000000 ASR RESTORE PROGRESS: 50% ramrod_display_set_granular_progress_forced: 20.000000 ASR RESTORE PROGRESS: 52% ramrod_display_set_granular_progress_forced: 20.000000 ASR RESTORE PROGRESS: 54% ramrod_display_set_granular_progress_forced: 21.000000 ASR RESTORE PROGRESS: 56% ramrod_display_set_granular_progress_forced: 21.000000 ASR RESTORE PROGRESS: 58% ramrod_display_set_granular_progress_forced: 22.000000 ASR RESTORE PROGRESS: 60% ramrod_display_set_granular_progress_forced: 22.000000 ASR RESTORE PROGRESS: 62% ramrod_display_set_granular_progress_forced: 23.000000 ASR RESTORE PROGRESS: 64% ramrod_display_set_granular_progress_forced: 23.000000 ASR RESTORE PROGRESS: 66% ramrod_display_set_granular_progress_forced: 24.000000 ASR RESTORE PROGRESS: 68% ramrod_display_set_granular_progress_forced: 24.000000 ASR RESTORE PROGRESS: 70% ramrod_display_set_granular_progress_forced: 25.000000 ASR RESTORE PROGRESS: 72% ramrod_display_set_granular_progress_forced: 26.000000 ASR RESTORE PROGRESS: 74% ramrod_display_set_granular_progress_forced: 26.000000 ASR RESTORE PROGRESS: 76% ramrod_display_set_granular_progress_forced: 27.000000 ASR RESTORE PROGRESS: 78% ramrod_display_set_granular_progress_forced: 27.000000 ASR RESTORE PROGRESS: 80% ramrod_display_set_granular_progress_forced: 28.000000 ASR RESTORE PROGRESS: 82% ramrod_display_set_granular_progress_forced: 28.000000 ASR RESTORE PROGRESS: 84% ramrod_display_set_granular_progress_forced: 29.000000 ASR RESTORE PROGRESS: 86% ramrod_display_set_granular_progress_forced: 29.000000 ASR RESTORE PROGRESS: 88% ramrod_display_set_granular_progress_forced: 30.000000 ASR RESTORE PROGRESS: 90% ramrod_display_set_granular_progress_forced: 31.000000 ASR RESTORE PROGRESS: 92% ramrod_display_set_granular_progress_forced: 31.000000 ASR RESTORE PROGRESS: 94% ramrod_display_set_granular_progress_forced: 32.000000 ASR STATUS: fail ASR: Could not restore - No space left on device ASR STATUS: fail restore_apfs_image : failed to restore an APFS image, error = 14 [10:04:47.0307-GMT]{3>7} CHECKPOINT FAILURE:(FAILURE:14) RESTORED:[0x065B] asr_and_invert_image [0]D(failed to restore APFS image) restore-step-results = {0x1107065B:{0:14}} restore-step-codes = {0x1107065B:{0:14}} restore-step-domains = {0x1107065B:{0:"AMRestoreErrorDomain"}} restore-step-error = {0x1107065B:"[0]D(failed to restore APFS image)"} restore-step-uptime = 141 restore-step-user-progress = 32 [10:04:47.0311-GMT]{3>7} CHECKPOINT NOTICE: (NVRAM set) restore-step-user-progress=32 [sync=true] (first failure) [10:04:47.0311-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0647] cleanup_check_result restore-step-ids = {0x1103065B:47;0x11030647:48} restore-step-names = {0x1103065B:asr_and_invert_image;0x11030647:cleanup_check_result} restore-step-uptime = 141 restore-step-user-progress = 32 [10:04:47.0315-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0647] cleanup_check_result restore-step-ids = {0x1103065B:47} restore-step-names = {0x1103065B:asr_and_invert_image} restore-step-uptime = 141 restore-step-user-progress = 32 [10:04:47.0318-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0648] cleanup_send_final_status restore-step-ids = {0x1103065B:47;0x11030648:49} restore-step-names = {0x1103065B:asr_and_invert_image;0x11030648:cleanup_send_final_status} restore-step-uptime = 141 restore-step-user-progress = 32

ERROR: Unable to restore device

nikias commented 5 years ago

Hi, sorry but there is no obvious issue from the computer side. The device has multiple partitions (System, user data, baseband data, ...) and for some reason the first one which is where the root filesystems is to be restored is not large enough. Not sure from what version you initially had before trying to update, but apparently the root filesystem size changed, for example:

iOS 12.1.2 image 048-40501-063.dmg is 3431679581 bytes

vs.

iOS 12.3.1 image 048-43159-182.dmg is 3498654431 bytes

So the root filesystem size increased by about 2%, for you it fails at about 94%. This could be related, even though from what I understood is that the rootfs will have a sufficient size overhead (hence the "SystemPartitionPadding").

Unfortunately I don't see anything you can do here. You can't supply a different image (e.g. from a previous version) because it will cryptographically verify it. Technically Apple would be able to help you: they could boot the device with some special ramdisk to recover data; however knowing them they will pretend there's nothing they can do. Especially not for a private person. You could ask but I doubt they will really help you. Sorry :-(

decembersake commented 5 years ago

Oh my god.. I see. That's crazy it's just 2% and can't update. Yeah, I can see how Apple will reply but I appreciate your help and explanation so so much. Again, thank you so much. Have a lovely day!

nikias commented 5 years ago

You can still try. If you go to a genius bar and they want to try something, they need to do a firmware update restore (not an erase restore, which would wipe all your data).

nikias commented 5 years ago

Hey I might have found something. There's an entry MinimumSystemPartition, maybe it needs to be added.

nikias commented 5 years ago

Can you try this:

diff --git a/src/restore.c b/src/restore.c
index 4e6b91d..fc274ee 100644
--- a/src/restore.c
+++ b/src/restore.c
@@ -2412,16 +2412,26 @@ int restore_device(struct idevicerestore_client_t* client, plist_t build_identit
        plist_dict_set_item(opts, "SystemImage", plist_new_bool(1));
        // FIXME: new on iOS 5 ?
        plist_dict_set_item(opts, "SystemImageType", plist_new_string("User"));
+       plist_t msp = plist_access_path(build_identity, 2, "Info", "MinimumSystemPartition");
+       if (msp) {
+               plist_dict_set_item(opts, "MinimumSystemPartition", plist_copy(msp));
+               plist_dict_set_item(opts, "SystemPartitionSize", plist_copy(msp));
+       }
        plist_t spp = plist_access_path(build_identity, 2, "Info", "SystemPartitionPadding");
        if (spp) {
                spp = plist_copy(spp);
        } else {
                spp = plist_new_dict();
+               plist_dict_set_item(spp, "1024", plist_new_uint(1280));
                plist_dict_set_item(spp, "128", plist_new_uint(1280));
                plist_dict_set_item(spp, "16", plist_new_uint(160));
+               plist_dict_set_item(spp, "256", plist_new_uint(1280));
                plist_dict_set_item(spp, "32", plist_new_uint(320));
+               plist_dict_set_item(spp, "512", plist_new_uint(1280));
                plist_dict_set_item(spp, "64", plist_new_uint(640));
+               plist_dict_set_item(spp, "768", plist_new_uint(1280));
                plist_dict_set_item(spp, "8", plist_new_uint(80));
+
        }
        plist_dict_set_item(opts, "SystemPartitionPadding", spp);
        char* guid = generate_guid();
decembersake commented 5 years ago

Hey sorry for the late reply, I almost gave up. I obviously visited the genius bar apple store and they tried the firmware update which occurred error 14 at the very beginning of this disaster. I have tried your new patch and it also didn't work, but I can't thank you enough. I'm really grateful for your help.

decembersake commented 5 years ago

This is what happened, which seems to be exactly the same as before.

Changes to be committed: (use "git reset HEAD ..." to unstage)

modified:   src/restore.c

usrname:idevicerestore Usrname$ git commit -a [master d681e99] commit restore.c Committer: Usr Usrname@whatsoever.local

1 files changed, 10 insertions(+)

create mode 160000 libimobiledevice

Verifying 'iPhone11,2_12.3.1_16F203_Restore.ipsw'... Checksum matches. Extracting BuildManifest from IPSW Product Version: 12.3.1 Product Build: 16F203 Major: 16 INFO: device serial number is DNPX9193KPG4 Device supports Image4: true Variant: Customer Upgrade Install (IPSW) This restore will update your device without losing data. Checking IPSW for required components... All required components found in IPSW Extracting filesystem from IPSW: 048-43159-182.dmg [==================================================] 100.0% Found ECID 4909083227848750 Getting ApNonce in recovery mode... c7 63 e9 00 67 57 84 b9 af de a7 6a 31 b7 9e ad ef 89 4c 72 e7 75 91 ab 35 92 a2 86 5b 1d 53 30 Trying to fetch new SHSH blob Getting SepNonce in recovery mode... a4 76 1c c5 bb 15 a0 e1 1c 73 9a 79 2f 24 e6 98 6a 97 bb 76 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 Extracting iBEC.d321.RELEASE.im4p... Personalizing IMG4 component iBEC... Sending iBEC (1063306 bytes)... Recovery Mode Environment: iBoot build-version=iBoot-4513.260.81 iBoot build-style=RELEASE Sending RestoreLogo... Extracting applelogo@3x~iphone.im4p... Personalizing IMG4 component RestoreLogo... Sending RestoreLogo (20910 bytes)... Extracting h11_ane_fw_quin.im4p... Personalizing IMG4 component ANE... Sending ANE (9394706 bytes)... Extracting aopfw-iphone11aop.im4p... Personalizing IMG4 component AOP... Sending AOP (1396234 bytes)... Extracting AppleAVE2FW.im4p... Personalizing IMG4 component AVE... Sending AVE (1111370 bytes)... Extracting armfw_g11p.im4p... Personalizing IMG4 component GFX... Sending GFX (1555834 bytes)... Extracting adc-petra-d3x.im4p... Personalizing IMG4 component ISP... Sending ISP (14639242 bytes)... Extracting 048-43107-184.dmg.trustcache... Personalizing IMG4 component RestoreTrustCache... Sending RestoreTrustCache (11671 bytes)... Extracting SmartIOFirmwareT8020.im4p... Personalizing IMG4 component SIO... Sending SIO (1356094 bytes)... Extracting WirelessPower.iphone11.im4p... Personalizing IMG4 component WCHFirmwareUpdater... Sending WCHFirmwareUpdater (28773 bytes)... ramdisk-size=0x20000000 Extracting 048-43107-184.dmg... Personalizing IMG4 component RestoreRamDisk... Sending RestoreRamDisk (93872653 bytes)... Extracting DeviceTree.d321ap.im4p... Personalizing IMG4 component RestoreDeviceTree... Sending RestoreDeviceTree (193792 bytes)... Extracting kernelcache.release.iphone11... Personalizing IMG4 component RestoreKernelCache... Sending RestoreKernelCache (17958779 bytes)... About to restore device... Waiting for device... Device 00008020-001170C901F8002E is now connected in restore mode... Connecting now... Connected to com.apple.mobile.restored, version 15 Device 00008020-001170C901F8002E has successfully entered restore mode Hardware Information: BoardID: 14 ChipID: 32800 UniqueChipID: 4909083227848750 ProductionMode: true Previous restore exit status: 0x100 Starting FDR listener thread About to send NORData... Found firmware path Firmware/all_flash Getting firmware manifest from build identity Extracting LLB.d321.RELEASE.im4p... Personalizing IMG4 component LLB... Extracting applelogo@3x~iphone.im4p... Personalizing IMG4 component AppleLogo... Extracting batterycharging0@3x~iphone.im4p... Personalizing IMG4 component BatteryCharging0... Extracting batterycharging1@3x~iphone.im4p... Personalizing IMG4 component BatteryCharging1... Extracting batteryfull@3x~iphone.im4p... Personalizing IMG4 component BatteryFull... Extracting batterylow0@3x~iphone.im4p... Personalizing IMG4 component BatteryLow0... Extracting batterylow1@3x~iphone.im4p... Personalizing IMG4 component BatteryLow1... Extracting glyphplugin@2436~iphone-lightning.im4p... Personalizing IMG4 component BatteryPlugin... Extracting DeviceTree.d321ap.im4p... Personalizing IMG4 component DeviceTree... Extracting liquiddetect@2436~iphone-lightning.im4p... Personalizing IMG4 component Liquid... Extracting lowpowermode@2436~iphone-lightning.im4p... Personalizing IMG4 component LowPowerWallet0... Extracting recoverymode@2436~iphone-lightning.im4p... Personalizing IMG4 component RecoveryMode... Extracting iBoot.d321.RELEASE.im4p... Personalizing IMG4 component iBoot... Extracting sep-firmware.d321.RELEASE.im4p... Personalizing IMG4 component RestoreSEP... Extracting sep-firmware.d321.RELEASE.im4p... Personalizing IMG4 component SEP... Sending NORData now... Done sending NORData About to send RootTicket... Sending RootTicket now... Done sending RootTicket Waiting for NAND (28) Updating S3E Firmware (58) Checking filesystems (15) Checking filesystems (15) About to send FDR Trust data... Sending FDR Trust data now... Done sending FDR Trust Data Unmounting filesystems (29) Unmounting filesystems (29) Unmounting filesystems (29) Unmounting filesystems (29) Unmounting filesystems (29) Creating filesystem (12) About to send filesystem... Connected to ASR Validating the filesystem Filesystem validated Sending filesystem now... [================================================ ] 94.0%ERROR: Unable to send data to ASR. Sent 0 of 1450 bytes. ERROR: Unable to send filesystem payload ERROR: Unable to send payload to ASR ERROR: Unable to send filesystem ERROR: Unable to successfully restore device Got status message Status: Fail Log is available: SYSLOG: Jun 5 20:01:20 localhost bootlog[0] : BOOT_TIME 1559764880 631591 [20:01:21.0423-GMT]{3>7} CHECKPOINT NOTICE: Image4 device: AP nonce clearable entering ramrod_clear_ap_nonce [20:01:21.0436-GMT]{3>7} CHECKPOINT NOTICE: AP nonce consumed [20:01:21.0437-GMT]{3>7} CHECKPOINT NOTICE: Pre-existing NVRAM variable: auto-boot=false [20:01:21.0438-GMT]{3>7} CHECKPOINT NOTICE: Pre-existing NVRAM variable: restore-outcome=initial_monitor_no_return [20:01:21.0439-GMT]{3>7} CHECKPOINT PROGRESS: START (unknown) -> (initial_engine_no_return) [20:01:21.0439-GMT]{3>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 [20:01:21.0451-GMT]{3>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 [20:01:21.0453-GMT]{3>7} CHECKPOINT END: MAIN:[0x0400] umask restore-step-ids = {} restore-step-names = {} restore-step-uptime = 1 restore-step-user-progress = -1 [20:01:21.0456-GMT]{3>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 [20:01:21.0459-GMT]{3>7} CHECKPOINT END: MAIN:[0x0402] setvbuf restore-step-ids = {} restore-step-names = {} restore-step-uptime = 1 restore-step-user-progress = -1 [20:01:21.0462-GMT]{3>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 [20:01:21.0465-GMT]{3>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 [20:01:21.0468-GMT]{3>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: primary display-scale = 3 display-rotation = 0 found applelogo at /usr/share/progressui/applelogo@3x.tga display: 1125 x 2436 powering on display ramrod_display_set_granular_progress_forced: 0.000000 [20:01:21.0493-GMT]{3>7} CHECKPOINT END: MAIN:[0x0406] set_progress_0 restore-step-ids = {} restore-step-names = {} restore-step-uptime = 1 restore-step-user-progress = 0 [20:01:21.0496-GMT]{3>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 [20:01:21.0500-GMT]{3>7} CHECKPOINT WARNING: MAIN:[0x0407] gasgauge_start_update_thread failed: -1 [20:01:21.0500-GMT]{3>7} CHECKPOINT END: MAIN:[0x0407] start_gasgauge_thread restore-step-ids = {} restore-step-names = {} restore-step-warnings = {0x11060407:{0:"gasgauge_start_update_thread failed: -1"}} restore-step-uptime = 1 restore-step-user-progress = 0 [20:01:21.0504-GMT]{3>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 [20:01:21.0507-GMT]{3>7} CHECKPOINT END: MAIN:[0x0408] listen_for_log_client restore-step-ids = {} restore-step-names = {} restore-step-uptime = 1 restore-step-user-progress = 0 [20:01:21.0509-GMT]{3>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 [20:01:21.0512-GMT]{3>7} CHECKPOINT END: MAIN:[0x040D] create_listen_socket restore-step-ids = {} restore-step-names = {} restore-step-uptime = 1 restore-step-user-progress = 0 [20:01:21.0515-GMT]{3>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 [20:01:21.0518-GMT]{3>7} CHECKPOINT END: MAIN:[0x0404] update_root_mount restore-step-ids = {} restore-step-names = {} restore-step-uptime = 1 restore-step-user-progress = 0 [20:01:21.0521-GMT]{3>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 [20:01:21.0525-GMT]{3>7} CHECKPOINT END: MAIN:[0x0405] disable_watchdog restore-step-ids = {} restore-step-names = {} restore-step-uptime = 1 restore-step-user-progress = 0 [20:01:21.0528-GMT]{3>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 0x155e02ca0 [0x101b83940]>{type = mutable dict, count = 1, entries => 0 : <CFString 0x101e1c2a0 [0x101b83940]>{contents = "IOProviderClass"} = <CFString 0x155e02210 [0x101b83940]>{contents = "AppleUSBDeviceMux"} }

[20:01:24.0538-GMT]{3>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(12, 4) failed: connection closed unable to read message size: -1 recv(8, 4) failed: connection closed recv(11, 4) failed: connection closed could not receive message unable to read message size: -1 unable to read message size: -1 could not receive message recv(13, 4) failed: connection closed unable to read message size: -1 could not receive message recv(12, 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 recv(15, 4) failed: connection closed could not receive message could not receive message recv(11, 4) failed: connection closed recv(17, 4) failed: connection closed recv(16, 4) failed: connection closed unable to read message size: -1 recv(12, 4) failed: connection closed 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 recv(10, 4) failed: connection closed recv(8, 4) failed: connection closed recv(12, 4) failed: connection closed unable to read message size: -1 could not receive message could not receive message recv(19, 4) failed: connection closed unable to read message size: -1 could not receive message unable to read message size: -1 could not receive message recv(20, 4) failed: connection closed unable to read message size: -1 could not receive message could not receive message recv(21, 4) failed: connection closed unable to read message size: -1 could not receive message recv(13, 4) failed: connection closed unable to read message size: -1 could not receive message recv(12, 4) failed: connection closed unable to read message size: -1 could not receive message recv(8, 4) failed: connection closed unable to read message size: -1 could not receive message recv(15, 4) failed: connection closed unable to read message size: -1 could not receive message unable to read message size: -1 could not receive message recv(16, 4) failed: connection closed unable to read message size: -1 could not receive message recv(18, 4) failed: connection closed unable to read message size: -1 could not receive message recv(8, 4) failed: connection closed unable to read message size: -1 could not receive message recv(12, 4) failed: connection closed unable to read message size: -1 could not receive message recv(17, 4) failed: connection closed unable to read message size: -1 could not receive message recv(19, 4) failed: connection closed unable to read message size: -1 unable to read message size: -1 could not receive message could not receive message recv(8, 4) failed: connection closed unable to read message size: -1 could not receive message recv(10, 4) failed: connection closed unable to read message size: -1 could not receive message [20:01:29.0223-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0600] client_protocol_version restore-step-ids = {0x11030600:11} restore-step-names = {0x11030600:client_protocol_version} restore-step-uptime = 9 restore-step-user-progress = 0 client protocol version 15 [20:01:29.0231-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0600] client_protocol_version restore-step-ids = {} restore-step-names = {} restore-step-uptime = 9 restore-step-user-progress = 0 [20:01:29.0236-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0601] copy_restore_options restore-step-ids = {0x11030601:12} restore-step-names = {0x11030601:copy_restore_options} restore-step-uptime = 9 restore-step-user-progress = 0 unable to open /usr/local/share/restore//options.d321.plist: No such file or directory unable to open /usr/local/share/restore//options.plist: No such file or directory UUID 6AD571D0-C5F5-DB72-A5A4-560347902252 Restore options: UUID => <CFString 0x157000ee0 [0x101b83940]>{contents = "6AD571D0-C5F5-DB72-A5A4-560347902252"} TZ0RequiredCapacity => 0xBE00000 PersonalizedDuringPreflight => <CFBoolean 0x101b894f0 [0x101b83940]>{value = true} CreateFilesystemPartitions => <CFBoolean 0x101b89508 [0x101b83940]>{value = false} [20:01:29.0247-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0601] copy_restore_options restore-step-ids = {} restore-step-names = {} restore-step-uptime = 9 restore-step-user-progress = 0 [20:01:29.0250-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0655] is_host_compatible restore-step-ids = {0x11030655:13} restore-step-names = {0x11030655:is_host_compatible} restore-step-uptime = 9 restore-step-user-progress = 0 [20:01:29.0253-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0655] is_host_compatible restore-step-ids = {} restore-step-names = {} restore-step-uptime = 9 restore-step-user-progress = 0 [20:01:29.0256-GMT]{3>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 = 9 restore-step-user-progress = 0 [20:01:29.0259-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0604] set_weight_from_options restore-step-ids = {} restore-step-names = {} restore-step-uptime = 9 restore-step-user-progress = 0 [20:01:29.0262-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0608] device_has_hoover restore-step-ids = {0x11030608:15} restore-step-names = {0x11030608:device_has_hoover} restore-step-uptime = 9 restore-step-user-progress = 0 [20:01:29.0266-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0608] device_has_hoover restore-step-ids = {} restore-step-names = {} restore-step-uptime = 9 restore-step-user-progress = 0 [20:01:29.0269-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0609] load_sep_os restore-step-ids = {0x11030609:16} restore-step-names = {0x11030609:load_sep_os} restore-step-uptime = 9 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 (0x1097a0000 - 7429760) executing /usr/libexec/seputil --restore+art - waiting for child to exit child exited exit status: 0 entering ramrod_wait_for_sep_load executing /usr/libexec/seputil --ping seputil: ping failed executing /usr/libexec/seputil --ping SEP OS is booted [20:01:32.0432-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0609] load_sep_os restore-step-ids = {} restore-step-names = {} restore-step-uptime = 12 restore-step-user-progress = 0 [20:01:32.0435-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x060B] update_ticket restore-step-ids = {0x1103060B:17} restore-step-names = {0x1103060B:update_ticket} restore-step-uptime = 12 restore-step-user-progress = 0 entering ramrod_ticket_update_verify looking up boot manifest hash device tree ticket_hash: 5AF11933E72DEE5EE2524CA93FF1BF5BA7A8E7CB023442D3B6E4E3A0A96C6C8952AC5FEA454BE4B2F1641E55AB7B2392 crypto-hash-method found. Using SHA2-384 computed ticket_hash : 5AF11933E72DEE5EE2524CA93FF1BF5BA7A8E7CB023442D3B6E4E3A0A96C6C8952AC5FEA454BE4B2F1641E55AB7B2392 received valid ticket (7650 bytes) [20:01:32.0445-GMT]{3>7} CHECKPOINT END: RESTORED:[0x060B] update_ticket restore-step-ids = {} restore-step-names = {} restore-step-uptime = 12 restore-step-user-progress = 0 [20:01:32.0448-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x060D] wait_for_storage restore-step-ids = {0x1103060D:18} restore-step-names = {0x1103060D:wait_for_storage} restore-step-uptime = 12 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: AppleANS2CGNVMeController NAND initialized. Waiting for devnode. [20:01:32.0456-GMT]{3>7} CHECKPOINT END: RESTORED:[0x060D] wait_for_storage restore-step-ids = {} restore-step-names = {} restore-step-uptime = 12 restore-step-user-progress = 0 [20:01:32.0459-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x060E] update_NAND_firmware restore-step-ids = {0x1103060E:19} restore-step-names = {0x1103060E:update_NAND_firmware} restore-step-uptime = 12 restore-step-user-progress = 0 ramrod_display_set_granular_progress_forced: 0.000000 entering update_NAND executing /usr/bin/nvmefwupdater --query S4E/0000001202019313.pak NAND update file: "/usr/standalone/firmware/S4E/0000001202019313.pak" executing /usr/bin/nvmefwupdater --validate /usr/standalone/firmware/S4E/0000001202019313.pak s4e-bfh-params: 50555746 00200001 00204044 004080D9 004080DB 004080DD 004280E6 004680EB 030080FF 805080EC 00060002 100108A8 Performing BFH OFW stage... set_pci_port_state: result=0 set_pci_port_state: result=0 returning Regular update executing /usr/bin/nvmefwupdater --update /usr/standalone/firmware/S4E/0000001202019313.pak Downloading FW... Activating FW... Successfully updated FW... [20:01:38.0191-GMT]{3>7} CHECKPOINT END: RESTORED:[0x060E] update_NAND_firmware restore-step-ids = {} restore-step-names = {} restore-step-uptime = 18 restore-step-user-progress = 0 [20:01:38.0204-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x060F] clear_remap_variable restore-step-ids = {0x1103060F:20} restore-step-names = {0x1103060F:clear_remap_variable} restore-step-uptime = 18 restore-step-user-progress = 0 entering clear_remap_variable executing /usr/sbin/nvram -d enable-remap-mode enable-remap-mode [20:01:38.0251-GMT]{3>7} CHECKPOINT END: RESTORED:[0x060F] clear_remap_variable restore-step-ids = {} restore-step-names = {} restore-step-uptime = 18 restore-step-user-progress = 0 [20:01:38.0254-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x065C] print_nvram_variables restore-step-ids = {0x1103065C:21} restore-step-names = {0x1103065C:print_nvram_variables} restore-step-uptime = 18 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">

auto-boot ZmFsc2U= backlight-level NzQw boot-args boot-breadcrumbs NDcyNjUpIDxCT09UPiAwMDBmMDAwNSg2MTZmNzA2NikgMDAwZjAwMDYgNDAwZjAxMDEg MDAwZjAwMDUoNzM2OTZmNjYpIDAwMGYwMDA2IDQwMGYwMTAxIDAwMGYwMDA1KDYxNmU2 NTY2KSAwMDBmMDAwNiA0MDBmMDEwMSAwMDBmMDAwNSg2MTc2NjU2NikgMDAwZjAwMDYg NDAwZjAxMDEgMDAwZjAwMDUoNjc2Njc4NjYpIDAwMGYwMDA2IDQwMGYwMTAxIDAwMGYw MDA1KDY5NzM3MDY2KSAwMDBmMDAwNiA0MDBmMDEwMSAwMDAzMDAwZig2NDc0NzI2NSkg com.apple.System.tz0-size MHhCRTAwMDAw restore-outcome aW5pdGlhbF9lbmdpbmVfbm9fcmV0dXJu restored-exit-status MHgxMDA= usbcfwflasherResult Tm8gZXJyb3Jz

[20:01:38.0276-GMT]{3>7} CHECKPOINT END: RESTORED:[0x065C] print_nvram_variables restore-step-ids = {} restore-step-names = {} restore-step-uptime = 18 restore-step-user-progress = 0 [20:01:38.0279-GMT]{3>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 = 18 restore-step-user-progress = 0 [20:01:38.0281-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0610] asp_nand_set_writable restore-step-ids = {} restore-step-names = {} restore-step-uptime = 18 restore-step-user-progress = 0 [20:01:38.0284-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0613] find_filesystem_partitions restore-step-ids = {0x11030613:23} restore-step-names = {0x11030613:find_filesystem_partitions} restore-step-uptime = 18 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=/dev/disk0s1s3 log= update= xart= hardware=/dev/disk0s1s4 scratch= [20:01:38.0291-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0613] find_filesystem_partitions restore-step-ids = {} restore-step-names = {} restore-step-uptime = 18 restore-step-user-progress = 0 [20:01:38.0294-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0665] fsck_filesystems restore-step-ids = {0x11030665:24} restore-step-names = {0x11030665:fsck_filesystems} restore-step-uptime = 18 restore-step-user-progress = 0 entering fsck_apfs_container ramrod_display_set_granular_progress_forced: 0.000000 Starting an xpc transaction. executing /System/Library/Filesystems/apfs.fs/fsck_apfs -dyo /dev/disk0s1 Checking the container superblock. Checking the space manager. Checking the space manager free queue trees. Checking the object map. Checking volume. Checking the APFS volume superblock. The volume System was formatted by newfs_apfs (945.260.7) and last modified by apfs_kext (945.260.7). Checking the object map. Checking the snapshot metadata tree. Checking the snapshot metadata. Checking the extent ref tree. Checking the fsroot tree. Checking volume. Checking the APFS volume superblock. The volume Data was formatted by newfs_apfs (748.200.60) and last modified by apfs_kext (945.260.7). Checking the object map. /sbin/mount_apfs -c /dev/disk0s1s2 /private/var dev_init:607: Using /private/var/apfs and /private/var/nx for device-io. Checking the snapshot metadata tree. Checking the snapshot metadata. Checking the extent ref tree. Checking the fsroot tree. Checking volume. Checking the APFS volume superblock. The volume Baseband Data was formatted by newfs_apfs (748.200.60) and last modified by apfs_kext (945.250.134). Checking the object map. Checking the snapshot metadata tree. Checking the snapshot metadata. Checking the extent ref tree. Checking the fsroot tree. Checking volume. Checking the APFS volume superblock. The volume Hardware was formatted by newfs_apfs (748.200.60) and last modified by apfs_kext (945.260.7). Checking the object map. Checking the snapshot metadata tree. Checking the snapshot metadata. Checking the extent ref tree. Checking the fsroot tree. Verifying allocated space. The volume /dev/disk0s1 appears to be OK. fsck succeeded on /dev/disk0s1 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=/dev/disk0s1s3 log= update= xart= hardware=/dev/disk0s1s4 scratch= [20:02:09.0362-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0665] fsck_filesystems restore-step-ids = {} restore-step-names = {} restore-step-uptime = 49 restore-step-user-progress = 0 [20:02:09.0366-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0614] mount_system_partition restore-step-ids = {0x11030614:25} restore-step-names = {0x11030614:mount_system_partition} restore-step-uptime = 49 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 [20:02:09.0390-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0614] mount_system_partition restore-step-ids = {} restore-step-names = {} restore-step-uptime = 49 restore-step-user-progress = 0 [20:02:09.0393-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0654] read_previous_os_build_version restore-step-ids = {0x11030654:26} restore-step-names = {0x11030654:read_previous_os_build_version} restore-step-uptime = 49 restore-step-user-progress = 0 unable to open /mnt1/System/Library/CoreServices/SystemVersion.plist: No such file or directory ramrod_read_previous_os_build_version: Unable to read system version plist [20:02:09.0397-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0654] read_previous_os_build_version restore-step-ids = {} restore-step-names = {} restore-step-uptime = 49 restore-step-user-progress = 0 [20:02:09.0400-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0615] copy_hardware_info restore-step-ids = {0x11030615:27} restore-step-names = {0x11030615:copy_hardware_info} restore-step-uptime = 49 restore-step-user-progress = 0 [20:02:09.0403-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0615] copy_hardware_info restore-step-ids = {} restore-step-names = {} restore-step-uptime = 49 restore-step-user-progress = 0 [20:02:09.0405-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0616] fdr_create restore-step-ids = {0x11030616:28} restore-step-names = {0x11030616:fdr_create} restore-step-uptime = 49 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] : da 30 67 3a 75 24 63 69 94 6f 40 4d 80 6d 7d 7c : 02 ee 52 e3 : ----------------------------------------------- CryptoGenerateRSAKeys: SecKeyCreateRSAPrivateKey -> 0x100cdc8f8 CryptoGenerateRSAKeys: SecKeyCreateRSAPublicKey -> 0x100cdc8f0 _copyDataInstanceForSealingMapEntry: Using value 0000005E-0A01D1F15DAFE63200000000 for key BasebandUniqueId from query cache _copyDataInstanceForSealingMapEntry: Using value 0000005E-0A01D1F15DAFE63200000000 for key BasebandUniqueId from query cache _copyDataInstanceForSealingMapEntry: Using value 32800 for key ChipID from query cache _copyDataInstanceForSealingMapEntry: Using value 4909083227848750 for key UniqueChipID from query cache _copyDataInstanceForSealingMapEntry: Using value FXR826237XJJNK595+11013104696167073811771913 for key CoverglassSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value 3E-82808872 for key AmbientLightSensorSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x155d328f0 [0x101b83940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x155d328f0 [0x101b83940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x155d328f0 [0x101b83940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x155d328f0 [0x101b83940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x155d328f0 [0x101b83940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x155d328f0 [0x101b83940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x155d328f0 [0x101b83940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x155d328f0 [0x101b83940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x155d328f0 [0x101b83940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x155d328f0 [0x101b83940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x155d328f0 [0x101b83940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x155d328f0 [0x101b83940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x155d328f0 [0x101b83940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x155d328f0 [0x101b83940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value 32800 for key ChipID from query cache _copyDataInstanceForSealingMapEntry: Using value 4909083227848750 for key UniqueChipID from query cache _copyDataInstanceForSealingMapEntry: Using value A4.01-000000000DD0941E6738BCCC50EC0455 for key NFCUniqueChipID from query cache _copyDataInstanceForSealingMapEntry: Using value 32800 for key ChipID from query cache _copyDataInstanceForSealingMapEntry: Using value 4909083227848750 for key UniqueChipID from query cache _copyDataInstanceForSealingMapEntry: Using value 32800 for key ChipID from query cache _copyDataInstanceForSealingMapEntry: Using value 4909083227848750 for key UniqueChipID from query cache _copyDataInstanceForSealingMapEntry: Using value 32800 for key ChipID from query cache _copyDataInstanceForSealingMapEntry: Using value 4909083227848750 for key UniqueChipID from query cache _copyDataInstanceForSealingMapEntry: Using value 32800 for key ChipID from query cache _copyDataInstanceForSealingMapEntry: Using value 4909083227848750 for key UniqueChipID from query cache created HTTP FDR client 0x155d32b70 _copyDataInstanceForSealingMapEntry: Using value 0000005E-0A01D1F15DAFE63200000000 for key BasebandUniqueId from query cache _copyDataInstanceForSealingMapEntry: Using value 0000005E-0A01D1F15DAFE63200000000 for key BasebandUniqueId from query cache _copyDataInstanceForSealingMapEntry: Using value 32800 for key ChipID from query cache _copyDataInstanceForSealingMapEntry: Using value 4909083227848750 for key UniqueChipID from query cache _copyDataInstanceForSealingMapEntry: Using value FXR826237XJJNK595+11013104696167073811771913 for key CoverglassSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value 3E-82808872 for key AmbientLightSensorSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x155d328f0 [0x101b83940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x155d328f0 [0x101b83940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x155d328f0 [0x101b83940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x155d328f0 [0x101b83940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x155d328f0 [0x101b83940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x155d328f0 [0x101b83940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x155d328f0 [0x101b83940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x155d328f0 [0x101b83940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x155d328f0 [0x101b83940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x155d328f0 [0x101b83940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x155d328f0 [0x101b83940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x155d328f0 [0x101b83940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x155d328f0 [0x101b83940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value <CFData 0x155d328f0 [0x101b83940]>{length = 20, capacity = 20, bytes = 0x50600b3cc574d35554d51af402037029152d0e0c} for key SavageSerialNumber from query cache _copyDataInstanceForSealingMapEntry: Using value 32800 for key ChipID from query cache _copyDataInstanceForSealingMapEntry: Using value 4909083227848750 for key UniqueChipID from query cache _copyDataInstanceForSealingMapEntry: Using value A4.01-000000000DD0941E6738BCCC50EC0455 for key NFCUniqueChipID from query cache _copyDataInstanceForSealingMapEntry: Using value 32800 for key ChipID from query cache _copyDataInstanceForSealingMapEntry: Using value 4909083227848750 for key UniqueChipID from query cache _copyDataInstanceForSealingMapEntry: Using value 32800 for key ChipID from query cache _copyDataInstanceForSealingMapEntry: Using value 4909083227848750 for key UniqueChipID from query cache _copyDataInstanceForSealingMapEntry: Using value 32800 for key ChipID from query cache _copyDataInstanceForSealingMapEntry: Using value 4909083227848750 for key UniqueChipID from query cache _copyDataInstanceForSealingMapEntry: Using value 32800 for key ChipID from query cache _copyDataInstanceForSealingMapEntry: Using value 4909083227848750 for key UniqueChipID from query cache created local FDR client 0x157101300 Received response without expected RESTORED_FDR_TRUST_DATA AMSupportPlatformMakeDirectoryForURL: Could not mkdir (Read-only file system) AMSupportPlatformMakeDirectoryForURL: /mnt1/System AMFDRCreateError: AMFDRDataLocalCopyDataStoragePath: AMSupportMakeDirectory failed: code=4 AMFDRCreateError: AMFDRDataLocalCopy: missing data storage path: code=4 failed to copy trust object from fdrLocal 0: AMFDRError/4: missing data storage path 1: AMFDRError/4: AMSupportMakeDirectory failed Found ramdisk trust object, computing digest.. Ramdisk trust object digest DOES match AP ticket. Not enabling SSO for FDR RestoredFDRCreate() returned 0 FDR is supported on this device [20:02:10.0707-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0616] fdr_create restore-step-ids = {} restore-step-names = {} restore-step-uptime = 50 restore-step-user-progress = 0 [20:02:10.0710-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0617] fdr_save_data restore-step-ids = {0x11030617:29} restore-step-names = {0x11030617:fdr_save_data} restore-step-uptime = 50 restore-step-user-progress = 0 _AMFDRAPTicketHasBooleanEntitlement: no ticket in options AMFDRSealingMapCreateAndPopulateSealedData: populate sealedData with sealing manifest, sealingManifestOverride : (null), forceSealing : (null), allowForbidden : (null), allowUnSeal : 0 AMSupportPlatformMakeDirectoryForURL: Could not mkdir (Read-only file system) AMSupportPlatformMakeDirectoryForURL: /mnt1/System AMFDRCreateError: AMFDRDataLocalCopyDataStoragePath: AMSupportMakeDirectory failed: code=4 AMFDRCreateError: AMFDRDataLocalCopy: missing data storage path: code=4 AMFDRCreateError: AMFDRDataCopy: seal:00008020-001170C901F8002E get data failed - foundData is NULL: code=10 AMFDRCreateError: AMFDRSealingMapPopulateSealingManifest: sealingManifest is NULL: code=10 AMFDRCreateError: AMFDRSealingMapCreateAndPopulateSealedData: AMFDRSealingMapPopulateSealingManifest failed on amfdr: code=10 AMFDRSealedDataRestoreOptions: sealedData is NULL failed to save FDR persistent state RestoredFDRSaveData success [20:02:10.0719-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0617] fdr_save_data restore-step-ids = {} restore-step-names = {} restore-step-uptime = 50 restore-step-user-progress = 0 [20:02:10.0721-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0618] store_baseband_migration restore-step-ids = {0x11030618:30} restore-step-names = {0x11030618:store_baseband_migration} restore-step-uptime = 50 restore-step-user-progress = 0 [20:02:10.0723-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0618] store_baseband_migration restore-step-ids = {} restore-step-names = {} restore-step-uptime = 50 restore-step-user-progress = 0 [20:02:10.0726-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0619] check_for_restore_log restore-step-ids = {0x11030619:31} restore-step-names = {0x11030619:check_for_restore_log} restore-step-uptime = 50 restore-step-user-progress = 0 entering check_for_restore_log restore log does not exist [20:02:10.0730-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0619] check_for_restore_log restore-step-ids = {} restore-step-names = {} restore-step-uptime = 50 restore-step-user-progress = 0 [20:02:10.0733-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x061A] check_for_ota_logs restore-step-ids = {0x1103061A:32} restore-step-names = {0x1103061A:check_for_ota_logs} restore-step-uptime = 50 restore-step-user-progress = 0 entering mount_partition executing /System/Library/Filesystems/apfs.fs/mount_apfs /dev/disk0s1s2 /mnt2 /dev/disk0s1s2 mounted on /mnt2 Data mounted read-write entering dump_and_return_panic_logs entering dump_panic_logs executing /System/Library/CoreServices/DumpPanic -r/mnt2/mobile/Library/Logs/CrashReporter Looking for logs between 1559764930 and 1559764930 entering check_for_ota_logs_with_mount_point Diagnostic log submission disabled Searching /mnt2/mobile/Library/Logs/CrashReporter/ check_for_ota_logs_with_mount_point complete Found log directory(/mnt2/MobileSoftwareUpdate/lastOTA)..Deleting contentsSuccessfully checked for OTA logs [20:02:11.0218-GMT]{3>7} CHECKPOINT END: RESTORED:[0x061A] check_for_ota_logs restore-step-ids = {} restore-step-names = {} restore-step-uptime = 51 restore-step-user-progress = 0 [20:02:11.0222-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x061B] submit_update_stats restore-step-ids = {0x1103061B:33} restore-step-names = {0x1103061B:submit_update_stats} restore-step-uptime = 51 restore-step-user-progress = 0 entering mount_partition executing /sbin/mount -u -w /dev/disk0s1s1 /mnt1 Changed permissions on /dev/disk0s1s1 mounted at /mnt1 to readwrite entering mount_partition Data already mounted read-write (mount ignored) Attempting to update nvram shadow file /mnt2/MobileSoftwareUpdate/nvram.plist ramrod-nvram-shadow-path = /mnt2/MobileSoftwareUpdate/nvram.plist executing /usr/sbin/nvram ramrod-nvram-shadow-path=/mnt2/MobileSoftwareUpdate/nvram.plist ramrod-nvram-session = 1559764880 executing /usr/sbin/nvram ramrod-nvram-session=1559764880 Loaded persistent file: { "OTA-fsck-metrics" = "dev= vers=945.250.134 result=0 fp=0 fl=-1 repairs=0 time=1 iter=1"; "auto-boot" = true; "backlight-level" = <373430>; "boot-args" = ""; "com.apple.System.tz0-size" = 0xBE00000; "ota-breadcrumbs" = "2:pBjDoACEHLKNnlacedTUWXZ"; "ota-outcome" = success; "ota-result" = success; "ota-step-ids" = "{}"; "ota-step-monitor" = "{0x11010207:\"wifexited\"}"; "ota-step-names" = "{}"; "ota-step-uptime" = 216; "ota-step-user-progress" = 100; "ramrod-file-only-vars" = { "OTA-fsck-metrics" = "dev= vers=945.250.134 result=0 fp=0 fl=-1 repairs=0 time=1 iter=1"; "auto-boot" = true; "com.apple.System.tz0-size" = 0xBE00000; "ota-breadcrumbs" = "2:pBjDoACEHLKNnlacedTUWXZ"; "ota-outcome" = success; "ota-result" = success; "ota-step-ids" = "{}"; "ota-step-monitor" = "{0x11010207:\"wifexited\"}"; "ota-step-names" = "{}"; "ota-step-uptime" = 216; "ota-step-user-progress" = 100; "ramrod-nvram-session" = 1559020603; "ramrod-nvram-shadow-path" = "/mnt2/MobileSoftwareUpdate/nvram.plist"; "restore-outcome" = "initial_engine_no_return"; "restore-step-ids" = "{0x1103061B:33}"; "restore-step-names" = "{0x1103061B:submit_update_stats}"; "restore-step-uptime" = 48; "restore-step-user-progress" = 0; "restore-step-warnings" = "{0x11060407:{0:\"gasgauge_start_update_thread failed: -1\"}}"; }; "ramrod-nvram-sequence" = <31>; "ramrod-nvram-session" = 1559020603; "ramrod-nvram-shadow-path" = "/mnt2/MobileSoftwareUpdate/nvram.plist"; "ramrod-nvram-shadow-vars" = { "auto-boot" = <66616c73 65>; "backlight-level" = <373430>; "boot-args" = ""; "com.apple.System.tz0-size" = <30784245 30303030 30>; "ramrod-nvram-sequence" = <31>; "ramrod-nvram-session" = <31353539 30323036 3033>; "ramrod-nvram-shadow-path" = <2f6d6e74 322f4d6f 62696c65 536f6674 77617265 55706461 74652f6e 7672616d 2e706c69 7374>; "restore-outcome" = <696e6974 69616c5f 656e6769 6e655f6e 6f5f7265 7475726e>; "restored-exit-status" = <30783130 30>; usbcfwflasherResult = <4e6f2065 72726f72 73>; }; "restore-outcome" = "initial_engine_no_return"; "restore-step-ids" = "{0x1103061B:33}"; "restore-step-names" = "{0x1103061B:submit_update_stats}"; "restore-step-uptime" = 48; "restore-step-user-progress" = 0; "restore-step-warnings" = "{0x11060407:{0:\"gasgauge_start_update_thread failed: -1\"}}"; "restored-exit-status" = <30783130 30>; usbcfwflasherResult = <4e6f2065 72726f72 73>; } Pending file-vars: { "ramrod-nvram-session" = 1559764880; "ramrod-nvram-shadow-path" = "/mnt2/MobileSoftwareUpdate/nvram.plist"; "restore-outcome" = "initial_engine_no_return"; "restore-step-ids" = "{0x1103061B:33}"; "restore-step-names" = "{0x1103061B:submit_update_stats}"; "restore-step-uptime" = 51; "restore-step-user-progress" = 0; "restore-step-warnings" = "{0x11060407:{0:\"gasgauge_start_update_thread failed: -1\"}}"; } Pending var deletes: ( "enable-remap-mode" ) Final vars: { "OTA-fsck-metrics" = "dev= vers=945.250.134 result=0 fp=0 fl=-1 repairs=0 time=1 iter=1"; "auto-boot" = true; "com.apple.System.tz0-size" = 0xBE00000; "ota-breadcrumbs" = "2:pBjDoACEHLKNnlacedTUWXZ"; "ota-outcome" = success; "ota-result" = success; "ota-step-ids" = "{}"; "ota-step-monitor" = "{0x11010207:\"wifexited\"}"; "ota-step-names" = "{}"; "ota-step-uptime" = 216; "ota-step-user-progress" = 100; "ramrod-nvram-session" = 1559764880; "ramrod-nvram-shadow-path" = "/mnt2/MobileSoftwareUpdate/nvram.plist"; "restore-outcome" = "initial_engine_no_return"; "restore-step-ids" = "{0x1103061B:33}"; "restore-step-names" = "{0x1103061B:submit_update_stats}"; "restore-step-uptime" = 51; "restore-step-user-progress" = 0; "restore-step-warnings" = "{0x11060407:{0:\"gasgauge_start_update_thread failed: -1\"}}"; } executing /usr/sbin/nvram ramrod-nvram-sequence=1 Failed to persist contents of nvram to the filesystem. File system may not be available nvram will be shadowed at the path /mnt2/MobileSoftwareUpdate/nvram.plist AMSupportHttpCopyProxySettings_block_invoke: Proxy available AMSupportHttpCopyProxySettings_block_invoke: AMSupportHttpCopyProxySettings: RPNotificationProxyAvailable AMSupportHttpCopyProxySettings: proxyInfo = <CFBasicHash 0x155d32150 [0x101b83940]>{type = mutable dict, count = 2, entries => 0 : <CFString 0x101bba748 [0x101b83940]>{contents = "SOCKSProxy"} = <CFString 0x100d20dd8 [0x101b83940]>{contents = "127.0.0.1"} 1 : <CFString 0x101bba768 [0x101b83940]>{contents = "SOCKSPort"} = <CFNumber 0xcb402d4a78019b55 [0x101b83940]>{value = +1081, type = kCFNumberSInt32Type} }

calling UMEventShimSubmitEvents : start

: ignoring call to recordPostUpdateEvent when no install is in progress or we haven't performed the apply operation

UMEventShimSubmitEvents done : submitEventsInBackground running

[20:02:11.0328-GMT]{3>7} CHECKPOINT END: RESTORED:[0x061B] submit_update_stats restore-step-ids = {} restore-step-names = {} restore-step-uptime = 51 restore-step-user-progress = 0 [20:02:11.0332-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0661] read_persistent_files restore-step-ids = {0x11030661:34} restore-step-names = {0x11030661:read_persistent_files} restore-step-uptime = 51 restore-step-user-progress = 0 executing /System/Library/Filesystems/apfs.fs/mount_apfs /dev/disk0s1s4 /mnt6 : unable to set attributes on directory for update events: Error Domain=NSCocoaErrorDomain Code=640 "(null)" UserInfo={NSFilePath=/mnt2/db/UpdateMetrics/Events, NSUnderlyingError=0x157101e40 {Error Domain=NSPOSIXErrorDomain Code=28 "No space left on device"}}

/dev/disk0s1s4 mounted on /mnt6 File /mnt2/iomfb_bics_daemon/bic: not found. File /mnt2/iomfb_bics_daemon/history: not found. File /mnt6/bic: 666772 bytes read into memory. File /mnt6/history: 21933776 bytes read into memory. 2 files found in total. [20:02:11.0395-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0661] read_persistent_files restore-step-ids = {} restore-step-names = {} restore-step-uptime = 51 restore-step-user-progress = 0 [20:02:11.0398-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x061D] unmount_unconditionally restore-step-ids = {0x1103061D:35} restore-step-names = {0x1103061D:unmount_unconditionally} restore-step-uptime = 51 restore-step-user-progress = 0 entering unmount_filesystems ramrod_display_set_granular_progress_forced: 1.000000 entering unmount_partition System unmounted ramrod_display_set_granular_progress_forced: 1.000000 entering unmount_partition Data unmounted create_baseband_update_options: Got imeisv: 9 baseband updater options = <CFBasicHash 0x155d3b5b0 [0x101b83940]>{type = mutable dict, count = 4, entries => 0 : <CFString 0x100e32780 [0x101b83940]>{contents = "IMEISwVersion"} = <CFNumber 0xcb402d4a7801d855 [0x101b83940]>{value = +9, type = kCFNumberSInt32Type} 1 : <CFString 0x100e32740 [0x101b83940]>{contents = "restoredInternal"} = <CFBoolean 0x101b89508 [0x101b83940]>{value = false} 2 : <CFString 0x100e328a0 [0x101b83940]>{contents = "autoSetupEnv"} = <CFBoolean 0x101b89508 [0x101b83940]>{value = false} 6 : <CFString 0x100e328c0 [0x101b83940]>{contents = "disablePing"} = <CFBoolean 0x101b894f0 [0x101b83940]>{value = true} }

_baseband_update_requires_filesystems_once: querying baseband to determine if it requires system filesystem bbupdater: BEGIN: Command: requirePartitionMount bbupdater: cmdCopyRequirePartitionMount: supports flashless 1 bbupdater: cmdCopyRequirePartitionMount: supports REFS 1 bbupdater: END: Command: requirePartitionMount _baseband_update_requires_filesystems_once: query returned <CFBasicHash 0x155e0a910 [0x101b83940]>{type = mutable dict, count = 3, entries => 0 : <CFString 0x100e32100 [0x101b83940]>{contents = "requireUserPartitionMount"} = <CFBoolean 0x101b894f0 [0x101b83940]>{value = true} 1 : <CFString 0x100e32120 [0x101b83940]>{contents = "requestedBasebandFSPartitionMountSize"} = <CFNumber 0xcb402d4a7801d864 [0x101b83940]>{value = +10, type = kCFNumberSInt64Type} 2 : <CFString 0x100e320c0 [0x101b83940]>{contents = "requireSystemPartitionMount"} = <CFBoolean 0x101b894f0 [0x101b83940]>{value = true} }

ramrod_display_set_granular_progress_forced: 1.000000 entering unmount_partition Baseband Data not mounted (unmount ignored) ramrod_display_set_granular_progress_forced: 1.000000 entering unmount_partition xART not mounted (unmount ignored) ramrod_display_set_granular_progress_forced: 1.000000 entering unmount_partition Hardware not mounted (unmount ignored) [20:02:11.0440-GMT]{3>7} CHECKPOINT END: RESTORED:[0x061D] unmount_unconditionally restore-step-ids = {} restore-step-names = {} restore-step-uptime = 51 restore-step-user-progress = 1 [20:02:11.0443-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x064E] clean_nand restore-step-ids = {0x1103064E:36} restore-step-names = {0x1103064E:clean_nand} restore-step-uptime = 51 restore-step-user-progress = 1 entering clean_NAND [20:02:11.0447-GMT]{3>7} CHECKPOINT END: RESTORED:[0x064E] clean_nand restore-step-ids = {} restore-step-names = {} restore-step-uptime = 51 restore-step-user-progress = 1 [20:02:11.0450-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0653] create_readwrite_ramdisk restore-step-ids = {0x11030653:37} restore-step-names = {0x11030653:create_readwrite_ramdisk} restore-step-uptime = 51 restore-step-user-progress = 1 executing /usr/sbin/hdik -nomount ram://5120 /dev/disk4
executing /sbin/newfs_hfs -J -v readwrite_ramdisk /dev/disk4 Initialized /dev/rdisk4 as a 3 MB case-insensitive HFS Plus volume with a 512k journal executing /sbin/fsck_hfs -fdy /dev/disk4 journal_replay(/dev/disk4) returned 0 /dev/rdisk4 Using cacheBlockSize=32K cacheTotalBlock=14864 cacheSize=475648K. Executing fsck_hfs (version hfs-407.200.4). Checking Journaled HFS Plus volume. The volume name is readwrite_ramdisk Checking extents overflow file. Checking catalog file. Checking multi-linked files. Checking catalog hierarchy. Checking extended attributes file. Checking volume bitmap. Checking volume information. The volume readwrite_ramdisk appears to be OK. CheckHFS returned 0, fsmodified = 0 executing /sbin/mount_hfs /dev/disk4 /mnt5 mount_hfs: Could not create property for re-key environment check: No such file or directory entering show_service_nodes disk0

IOBlockStorageDriver RegistryID : 0x10000039f Busy State : 0x0 Service State : 0x1e NS_01 RegistryID : 0x100000381 Busy State : 0x0 Service State : 0x1e AppleANS2CGNVMeController RegistryID : 0x100000308 Busy State : 0x0 Service State : 0x1e RTBuddyV2 RegistryID : 0x1000002e9 Busy State : 0x0 Service State : 0x1e iop-ans-nub RegistryID : 0x100000149 Busy State : 0x0 Service State : 0x1e AppleASCWrapV2 RegistryID : 0x100000224 Busy State : 0x0 Service State : 0x0 ans RegistryID : 0x100000148 Busy State : 0x0 Service State : 0x1e AppleT802xIO RegistryID : 0x10000020d Busy State : 0x6 Service State : 0x1e arm-io RegistryID : 0x100000112 Busy State : 0x1 Service State : 0x1e AppleARMPE RegistryID : 0x1000001e6 Busy State : 0x1 Service State : 0x1e D321AP RegistryID : 0x1000001e5 Busy State : 0x1 Service State : 0x1e Root RegistryID : 0x100000100 Busy State : 0x0 Service State : 0x0

disk1

IOBlockStorageDriver RegistryID : 0x10000043a Busy State : 0x0 Service State : 0x1e NS_02 RegistryID : 0x100000439 Busy State : 0x0 Service State : 0x1e AppleANS2CGNVMeController RegistryID : 0x100000308 Busy State : 0x0 Service State : 0x1e RTBuddyV2 RegistryID : 0x1000002e9 Busy State : 0x0 Service State : 0x1e iop-ans-nub RegistryID : 0x100000149 Busy State : 0x0 Service State : 0x1e AppleASCWrapV2 RegistryID : 0x100000224 Busy State : 0x0 Service State : 0x0 ans RegistryID : 0x100000148 Busy State : 0x0 Service State : 0x1e AppleT802xIO RegistryID : 0x10000020d Busy State : 0x6 Service State : 0x1e arm-io RegistryID : 0x100000112 Busy State : 0x1 Service State : 0x1e AppleARMPE RegistryID : 0x1000001e6 Busy State : 0x1 Service State : 0x1e D321AP RegistryID : 0x1000001e5 Busy State : 0x1 Service State : 0x1e Root RegistryID : 0x100000100 Busy State : 0x0 Service State : 0x0

disk2

IOBlockStorageDriver RegistryID : 0x100000446 Busy State : 0x0 Service State : 0x1e NS_07 RegistryID : 0x100000445 Busy State : 0x0 Service State : 0x1e AppleANS2CGNVMeController RegistryID : 0x100000308 Busy State : 0x0 Service State : 0x1e RTBuddyV2 RegistryID : 0x1000002e9 Busy State : 0x0 Service State : 0x1e iop-ans-nub RegistryID : 0x100000149 Busy State : 0x0 Service State : 0x1e AppleASCWrapV2 RegistryID : 0x100000224 Busy State : 0x0 Service State : 0x0 ans RegistryID : 0x100000148 Busy State : 0x0 Service State : 0x1e AppleT802xIO RegistryID : 0x10000020d Busy State : 0x6 Service State : 0x1e arm-io RegistryID : 0x100000112 Busy State : 0x1 Service State : 0x1e AppleARMPE RegistryID : 0x1000001e6 Busy State : 0x1 Service State : 0x1e D321AP RegistryID : 0x1000001e5 Busy State : 0x1 Service State : 0x1e Root RegistryID : 0x100000100 Busy State : 0x0 Service State : 0x0

disk3

IOBlockStorageDriver RegistryID : 0x10000044d Busy State : 0x0 Service State : 0x1e NS_08 RegistryID : 0x10000044c Busy State : 0x0 Service State : 0x1e AppleANS2CGNVMeController RegistryID : 0x100000308 Busy State : 0x0 Service State : 0x1e RTBuddyV2 RegistryID : 0x1000002e9 Busy State : 0x0 Service State : 0x1e iop-ans-nub RegistryID : 0x100000149 Busy State : 0x0 Service State : 0x1e AppleASCWrapV2 RegistryID : 0x100000224 Busy State : 0x0 Service State : 0x0 ans RegistryID : 0x100000148 Busy State : 0x0 Service State : 0x1e AppleT802xIO RegistryID : 0x10000020d Busy State : 0x6 Service State : 0x1e arm-io RegistryID : 0x100000112 Busy State : 0x1 Service State : 0x1e AppleARMPE RegistryID : 0x1000001e6 Busy State : 0x1 Service State : 0x1e D321AP RegistryID : 0x1000001e5 Busy State : 0x1 Service State : 0x1e Root RegistryID : 0x100000100 Busy State : 0x0 Service State : 0x0

disk4

IOBlockStorageDriver RegistryID : 0x10000047d Busy State : 0x0 Service State : 0x1e IODiskImageBlockStorageDeviceInKernel RegistryID : 0x10000047c Busy State : 0x0 Service State : 0x1e IOHDIXHDDriveInKernel RegistryID : 0x10000047b Busy State : 0x0 Service State : 0x1e KDIDiskImageNub RegistryID : 0x10000047a Busy State : 0x0 Service State : 0x1e KDIReadWriteDiskImage RegistryID : 0x100000479 Busy State : 0x0 Service State : 0x1e KDIRAMBackingStore RegistryID : 0x100000476 Busy State : 0x0 Service State : 0x1e ram://5120 RegistryID : 0x100000475 Busy State : 0x0 Service State : 0x1e IOHDIXController RegistryID : 0x1000001f3 Busy State : 0x0 Service State : 0x1e IOResources RegistryID : 0x1000001e8 Busy State : 0x0 Service State : 0x1e D321AP RegistryID : 0x1000001e5 Busy State : 0x1 Service State : 0x1e Root RegistryID : 0x100000100 Busy State : 0x0 Service State : 0x0

[20:02:11.0626-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0653] create_readwrite_ramdisk restore-step-ids = {} restore-step-names = {} restore-step-uptime = 51 restore-step-user-progress = 1 [20:02:11.0627-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x061F] format_effaceable_storage restore-step-ids = {0x1103061F:38} restore-step-names = {0x1103061F:format_effaceable_storage} restore-step-uptime = 51 restore-step-user-progress = 1 entering format_effaceable_storage effaceable storage is formatted, nothing to do [20:02:11.0629-GMT]{3>7} CHECKPOINT END: RESTORED:[0x061F] format_effaceable_storage restore-step-ids = {} restore-step-names = {} restore-step-uptime = 51 restore-step-user-progress = 1 [20:02:11.0629-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0660] update_partitions_for_apfs restore-step-ids = {0x11030660:39} restore-step-names = {0x11030660:update_partitions_for_apfs} restore-step-uptime = 51 restore-step-user-progress = 1 APFS Update Install entering check_for_compatibility check_for_compatibility - Status Online Deleting System partition during Update Install delete_apfs_partition returned 0 during Update Install We should not have an xART partition. Attempting to delete Update partition during Update install 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= data=/dev/disk0s1s2 baseband data=/dev/disk0s1s3 log= update= xart= hardware=/dev/disk0s1s4 scratch= delete_apfs_update_partition_if_exists : no update partition found, returning 0 [20:02:12.0368-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0660] update_partitions_for_apfs restore-step-ids = {} restore-step-names = {} restore-step-uptime = 52 restore-step-user-progress = 1 [20:02:12.0371-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0622] reload_filesystem_partitions restore-step-ids = {0x11030622:40} restore-step-names = {0x11030622:reload_filesystem_partitions} restore-step-uptime = 52 restore-step-user-progress = 1 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= data=/dev/disk0s1s2 baseband data=/dev/disk0s1s3 log= update= xart= hardware=/dev/disk0s1s4 scratch= [20:02:12.0378-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0622] reload_filesystem_partitions restore-step-ids = {} restore-step-names = {} restore-step-uptime = 52 restore-step-user-progress = 1 [20:02:12.0381-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x065D] delete_mobilebackups restore-step-ids = {0x1103065D:41} restore-step-names = {0x1103065D:delete_mobilebackups} restore-step-uptime = 52 restore-step-user-progress = 1 executing /System/Library/Filesystems/apfs.fs/mount_apfs /dev/disk0s1s2 /mnt2 /dev/disk0s1s2 mounted on /mnt2 ramrod_delete_all_mobilebackup_snapshots : No snapshots to delete on /mnt2 [20:02:12.0844-GMT]{3>7} CHECKPOINT END: RESTORED:[0x065D] delete_mobilebackups restore-step-ids = {} restore-step-names = {} restore-step-uptime = 52 restore-step-user-progress = 1 [20:02:12.0849-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0658] format_media restore-step-ids = {0x11030658:42} restore-step-names = {0x11030658:format_media} restore-step-uptime = 52 restore-step-user-progress = 1 Update install using APFS diskimage on APFS formatted device, no converter use necessary entering create_apfs_filesystems 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= data=/dev/disk0s1s2 baseband data=/dev/disk0s1s3 log= update= xart= hardware=/dev/disk0s1s4 scratch= ramrod_display_set_granular_progress_forced: 1.000000 block size for /dev/disk0s1: 4096 /System/Library/Filesystems/apfs.fs/newfs_apfs -A -o fsindex=0 -v System /dev/disk0s1 executing /System/Library/Filesystems/apfs.fs/newfs_apfs -A -o fsindex=0 -v System /dev/disk0s1 We should not have an xART partition. Not creating an xART partition because we're on a system that doesn't support it. IORegistry requires a 50 MiB Hardware Partition executing /System/Library/Filesystems/apfs.fs/mount_apfs /dev/disk0s1s4 /mnt6 /dev/disk0s1s4 mounted on /mnt6 totalBlocks:12800 blockSize:4096 blocksAvailable:7227 Filesystem /mnt6 is 50 MB get_total_file_system_size is 52428800 Hardware volume looks OK, doing nothing. Should we generate a scratch partition? Not generating a sctach partition because the system doesn't support it. [20:02:14.0353-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0658] format_media restore-step-ids = {} restore-step-names = {} restore-step-uptime = 54 restore-step-user-progress = 1 [20:02:14.0357-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0659] find_volumes_after_format restore-step-ids = {0x11030659:43} restore-step-names = {0x11030659:find_volumes_after_format} restore-step-uptime = 54 restore-step-user-progress = 1 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=/dev/disk0s1s3 log= update= xart= hardware=/dev/disk0s1s4 scratch= [20:02:14.0367-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0659] find_volumes_after_format restore-step-ids = {} restore-step-names = {} restore-step-uptime = 54 restore-step-user-progress = 1 [20:02:14.0369-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x065F] reserve_overprov_space restore-step-ids = {0x1103065F:44} restore-step-names = {0x1103065F:reserve_overprov_space} restore-step-uptime = 54 restore-step-user-progress = 1 executing /System/Library/Filesystems/apfs.fs/mount_apfs /dev/disk0s1s2 /mnt2 /dev/disk0s1s2 mounted on /mnt2 space already reserved for overprovisioning [20:02:15.0032-GMT]{3>7} CHECKPOINT END: RESTORED:[0x065F] reserve_overprov_space restore-step-ids = {} restore-step-names = {} restore-step-uptime = 55 restore-step-user-progress = 1 [20:02:15.0039-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0662] write_persistent_files restore-step-ids = {0x11030662:45} restore-step-names = {0x11030662:write_persistent_files} restore-step-uptime = 55 restore-step-user-progress = 1 executing /System/Library/Filesystems/apfs.fs/mount_apfs /dev/disk0s1s2 /mnt2 /dev/disk0s1s2 mounted on /mnt2 executing /System/Library/Filesystems/apfs.fs/mount_apfs /dev/disk0s1s4 /mnt6 /dev/disk0s1s4 mounted on /mnt6 Not overwriting file in stage1. Not overwriting file in stage1. Committed 2 persistent files to NAND [20:02:15.0733-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0662] write_persistent_files restore-step-ids = {} restore-step-names = {} restore-step-uptime = 55 restore-step-user-progress = 1 [20:02:15.0739-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x065A] baseband_migration_data restore-step-ids = {0x1103065A:46} restore-step-names = {0x1103065A:baseband_migration_data} restore-step-uptime = 55 restore-step-user-progress = 1 [20:02:15.0743-GMT]{3>7} CHECKPOINT END: RESTORED:[0x065A] baseband_migration_data restore-step-ids = {} restore-step-names = {} restore-step-uptime = 55 restore-step-user-progress = 1 [20:02:15.0747-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x065B] asr_and_invert_image restore-step-ids = {0x1103065B:47} restore-step-names = {0x1103065B:asr_and_invert_image} restore-step-uptime = 55 restore-step-user-progress = 1 restore_apfs_image : started restoring an APFS image entering mount_partition executing /System/Library/Filesystems/apfs.fs/mount_apfs /dev/disk0s1s1 /mnt1 /dev/disk0s1s1 mounted on /mnt1 System mounted read-write Successfully marked device node /dev/rdisk0s1s1 as static data OS digest = 41a524fe51d993b206dbcb920e76d768306fa86cd2c59e60714db7079ebb6a0e0eb6841d3b7a16f062b59860f6df1806 Restoring to APFS Inverter Image = /mnt1/apfs_invert_asr_img executing /usr/sbin/asr -source asr://localhost:12345 -target /mnt1/apfs_invert_asr_img --embed -erase -noprompt --chunkchecksum --puppetstrings --expectedhash 41a524fe51d993b206dbcb920e76d768306fa86cd2c59e60714db7079ebb6a0e0eb6841d3b7a16f062b59860f6df1806 ASR STATUS: start 412 multicast-client ASR: Waiting for connection attempt from server ASR STATUS: setup ASR: Validating target...done ASR STATUS: metadata ASR: Validating source... ASR: nx_kernel_mount:1473: : checkpoint search: largest xid 11, best xid 11 @ 21 ASR: done ASR: Retrieving scan information... ASR: done ASR: Validating sizes...done ASR STATUS: restore ASR RESTORE PROGRESS: 2% ramrod_display_set_granular_progress_forced: 6.000000 ASR RESTORE PROGRESS: 4% ramrod_display_set_granular_progress_forced: 7.000000 ASR RESTORE PROGRESS: 6% ramrod_display_set_granular_progress_forced: 7.000000 ASR RESTORE PROGRESS: 8% ramrod_display_set_granular_progress_forced: 8.000000 ASR RESTORE PROGRESS: 10% ramrod_display_set_granular_progress_forced: 8.000000 ASR RESTORE PROGRESS: 12% ramrod_display_set_granular_progress_forced: 9.000000 ASR RESTORE PROGRESS: 14% ramrod_display_set_granular_progress_forced: 10.000000 ASR RESTORE PROGRESS: 16% ramrod_display_set_granular_progress_forced: 10.000000 ASR RESTORE PROGRESS: 18% ramrod_display_set_granular_progress_forced: 11.000000 ASR RESTORE PROGRESS: 20% ramrod_display_set_granular_progress_forced: 11.000000 ASR RESTORE PROGRESS: 22% ramrod_display_set_granular_progress_forced: 12.000000 ASR RESTORE PROGRESS: 24% ramrod_display_set_granular_progress_forced: 12.000000 ASR RESTORE PROGRESS: 26% ramrod_display_set_granular_progress_forced: 13.000000 ASR RESTORE PROGRESS: 28% ramrod_display_set_granular_progress_forced: 13.000000 ASR RESTORE PROGRESS: 30% ramrod_display_set_granular_progress_forced: 14.000000 ASR RESTORE PROGRESS: 32% ramrod_display_set_granular_progress_forced: 15.000000 ASR RESTORE PROGRESS: 34% ramrod_display_set_granular_progress_forced: 15.000000 ASR RESTORE PROGRESS: 36% ramrod_display_set_granular_progress_forced: 16.000000 ASR RESTORE PROGRESS: 38% ramrod_display_set_granular_progress_forced: 16.000000 ASR RESTORE PROGRESS: 40% ramrod_display_set_granular_progress_forced: 17.000000 ASR RESTORE PROGRESS: 42% ramrod_display_set_granular_progress_forced: 17.000000 ASR RESTORE PROGRESS: 44% ramrod_display_set_granular_progress_forced: 18.000000 ASR RESTORE PROGRESS: 46% ramrod_display_set_granular_progress_forced: 18.000000 ASR RESTORE PROGRESS: 48% ramrod_display_set_granular_progress_forced: 19.000000 ASR RESTORE PROGRESS: 50% ramrod_display_set_granular_progress_forced: 20.000000 ASR RESTORE PROGRESS: 52% ramrod_display_set_granular_progress_forced: 20.000000 ASR RESTORE PROGRESS: 54% ramrod_display_set_granular_progress_forced: 21.000000 ASR RESTORE PROGRESS: 56% ramrod_display_set_granular_progress_forced: 21.000000 ASR RESTORE PROGRESS: 58% ramrod_display_set_granular_progress_forced: 22.000000 ASR RESTORE PROGRESS: 60% ramrod_display_set_granular_progress_forced: 22.000000 ASR RESTORE PROGRESS: 62% ramrod_display_set_granular_progress_forced: 23.000000 ASR RESTORE PROGRESS: 64% ramrod_display_set_granular_progress_forced: 23.000000 ASR RESTORE PROGRESS: 66% ramrod_display_set_granular_progress_forced: 24.000000 ASR RESTORE PROGRESS: 68% ramrod_display_set_granular_progress_forced: 24.000000 ASR RESTORE PROGRESS: 70% ramrod_display_set_granular_progress_forced: 25.000000 ASR RESTORE PROGRESS: 72% ramrod_display_set_granular_progress_forced: 26.000000 ASR RESTORE PROGRESS: 74% ramrod_display_set_granular_progress_forced: 26.000000 ASR RESTORE PROGRESS: 76% ramrod_display_set_granular_progress_forced: 27.000000 ASR RESTORE PROGRESS: 78% ramrod_display_set_granular_progress_forced: 27.000000 ASR RESTORE PROGRESS: 80% ramrod_display_set_granular_progress_forced: 28.000000 ASR RESTORE PROGRESS: 82% ramrod_display_set_granular_progress_forced: 28.000000 ASR RESTORE PROGRESS: 84% ramrod_display_set_granular_progress_forced: 29.000000 ASR RESTORE PROGRESS: 86% ramrod_display_set_granular_progress_forced: 29.000000 ASR RESTORE PROGRESS: 88% ramrod_display_set_granular_progress_forced: 30.000000 ASR RESTORE PROGRESS: 90% ramrod_display_set_granular_progress_forced: 31.000000 ASR RESTORE PROGRESS: 92% ramrod_display_set_granular_progress_forced: 31.000000 ASR RESTORE PROGRESS: 94% ramrod_display_set_granular_progress_forced: 32.000000 ASR STATUS: fail ASR: Could not restore - No space left on device ASR STATUS: fail restore_apfs_image : failed to restore an APFS image, error = 14 [20:03:41.0036-GMT]{3>7} CHECKPOINT FAILURE:(FAILURE:14) RESTORED:[0x065B] asr_and_invert_image [0]D(failed to restore APFS image) restore-step-results = {0x1107065B:{0:14}} restore-step-codes = {0x1107065B:{0:14}} restore-step-domains = {0x1107065B:{0:"AMRestoreErrorDomain"}} restore-step-error = {0x1107065B:"[0]D(failed to restore APFS image)"} restore-step-uptime = 141 restore-step-user-progress = 32 [20:03:41.0041-GMT]{3>7} CHECKPOINT NOTICE: (NVRAM set) restore-step-user-progress=32 [sync=true] (first failure) [20:03:41.0042-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0647] cleanup_check_result restore-step-ids = {0x1103065B:47;0x11030647:48} restore-step-names = {0x1103065B:asr_and_invert_image;0x11030647:cleanup_check_result} restore-step-uptime = 141 restore-step-user-progress = 32 [20:03:41.0044-GMT]{3>7} CHECKPOINT END: RESTORED:[0x0647] cleanup_check_result restore-step-ids = {0x1103065B:47} restore-step-names = {0x1103065B:asr_and_invert_image} restore-step-uptime = 141 restore-step-user-progress = 32 [20:03:41.0048-GMT]{3>7} CHECKPOINT BEGIN: RESTORED:[0x0648] cleanup_send_final_status restore-step-ids = {0x1103065B:47;0x11030648:49} restore-step-names = {0x1103065B:asr_and_invert_image;0x11030648:cleanup_send_final_status} restore-step-uptime = 141 restore-step-user-progress = 32

ERROR: Unable to restore device

james-carrots commented 5 years ago

Hi @decembersake @nikias, I'm facing the exact same issue here - my ASR RESTORE PROGRESS is at 96%.

At this point it seems like there's no good solution, until when Apple releases a compatible firmware that "does not resize the root filesystem to something else." Or a firmware that is very lean (though unlikely given the current trends). Is this understanding correct?

Trying to decide if I should leave the phone as is as a brick for until that day comes, or take the it and restore. Thank you!

james-carrots commented 5 years ago

Current signed firmware is 12.4 only.

sungzh commented 5 years ago

@cliewdevelop @decembersake Have you recovered your mobile phone? I don't know the mechanism of the system, but I have seen some people constantly try. After dozens of times, there is enough space. I don't know if there is any theoretical basis. @nikias Do you know the theory inside?

lzl124631x commented 4 years ago

Having the same issue. My OS version was 13.5.1 and the current version I'm trying to update it to 13.6.1. Stuck at 96% with error 14.

[23:01:41.0129] ASR RESTORE PROGRESS: 96%
[23:01:41.0129] ramrod_display_set_granular_progress_forced: 32.000000
[23:01:41.0129] ASR STATUS: fail
[23:01:41.0129] ASR: Could not restore - No space left on device
[23:01:41.0129] ASR STATUS: fail
[23:01:41.0129] restore_apfs_image : failed to restore an APFS image, error = 14
[23:01:41.0129] [06:01:37.0450-GMT]{3>6} CHECKPOINT FAILURE:(FAILURE:14) (null):[0x065B] asr_and_invert_image [0]D(failed to restore APFS image)

I think this is a insanely stupid error in the ios system. How can it have such a critical issue that updating the system causes the entire system be down? Can't it pre-check if there is enough space for the new system? Apple great job!

james-carrots commented 4 years ago

@sungzh - on my end, I just restored and lost my pictures and all data. I know its not the best news, but just updating for closure.

xslidian commented 3 years ago

The FDR & ASR process changed in the iOS 14.4 beta (18D5030e). A few users reported successful restoration without wiping data. You may want to try it. cc @lzl124631x

FYI, here's an example of unsuccessful update (no enough space):

## 14.3_18C66 ##
ASR RESTORE PROGRESS: 66%
ramrod_display_set_granular_progress_forced: 24.000000
ASR RESTORE PROGRESS: 68%
ramrod_display_set_granular_progress_forced: 24.000000
ASR RESTORE PROGRESS: 70%
ramrod_display_set_granular_progress_forced: 25.000000
ASR RESTORE PROGRESS: 72%
ramrod_display_set_granular_progress_forced: 26.000000
ASR STATUS: fail
ASR: Could not restore - No space left on device
ASR STATUS: fail
restore_apfs_image : failed to restore an APFS image, error = 14
[16:16:12.0102-GMT]{4>8} CHECKPOINT FAILURE:(FAILURE:14) (null):[0x065B] asr_and_invert_image [0]D(failed to restore APFS image)
## 14.4_18D5030e ##
Sending NORData now...
Done sending NORData
Unmounting filesystems (29)
Unmounting filesystems (29)
Unmounting filesystems (29)
Unmounting filesystems (29)
Unmounting filesystems (29)
Unmounting filesystems (29)
Checking filesystems (15)
About to send FDR Trust data...
Sending FDR Trust data now...
Done sending FDR Trust Data
Checking for uncollected logs (44)
Checking for uncollected logs (44)
ERROR: Unable to receive message from FDR 0x7ffa07f0a640 (-2). 0/2 bytes
ERROR: Unable to receive message from FDR 0x7ffa07d05420 (-2). 0/2 bytes
ERROR: Unable to receive message from FDR 0x7ffa07d05430 (-2). 0/2 bytes
ERROR: Unable to receive message from FDR 0x7ffa07c9aa00 (-2). 0/2 bytes
Unmounting filesystems (29)
Unmounting filesystems (29)
Unmounting filesystems (29)
Unmounting filesystems (29)
Unmounting filesystems (29)
Unmounting filesystems (29)
Creating filesystem (12)
About to send filesystem...
Connected to ASR
Validating the filesystem
Filesystem validated
Sending filesystem now...
[==================================                ]  66.0%ERROR: Unable to send data to ASR. Sent 0 of 131072 bytes.
ERROR: Unable to send filesystem payload
ERROR: Unable to send payload to ASR
ERROR: Unable to send filesystem
ERROR: Unable to successfully restore device
About to send filesystem...
Connected to ASR
Validating the filesystem
Filesystem validated
Sending filesystem now...
[==================================                ]  66.0%ERROR: Unable to send data to ASR. Sent 0 of 131072 bytes.
ERROR: Unable to send filesystem payload
ERROR: Unable to send payload to ASR
ERROR: Unable to send filesystem
ERROR: Unable to restore device
lzl124631x commented 3 years ago

@xslidian Thanks! 50+ friends in our group who faced the same issue successfully recovered their data with the 14.4 beta. It indeed works.

Unfortunately, my phone was reset by my mistake and a insanely stupid bug of iTunes.

I was using iTunes for the restoring. Every time after the failure I need to unplug and replug the wire to do another trial. But iTunes has a bug that if you unplug and replug the wire during restoration, it changes it behavior to RESET! I mistakenly unplug/repluged my phone during the restore process and my phone was reset... I was a fan of Apple but now I hate it...

iTunes sucks. I should have used other 3rd party softwares that are less error prone. I put my phone in the drawer and maybe one day we can find ways to decrypt the date from it.

BTW, if anyone knows how to resolve this special RESET issue, please let me know. Really appreciate it!

xslidian commented 3 years ago

50+ friends in our group who faced the same issue successfully recovered their data with the 14.4 beta. It indeed works.

Glad to hear that. Amazing number.

But iTunes has a bug that if you unplug and replug the wire during restoration, it changes it behavior to RESET!

Thanks for telling us of such a bug. Hope you find a solution soon.

idevicerestore chooses the variant perfectly as far as I know. If your friends aren't comfortable with the command line, the free-to-use part of iMazing should help.