Something very similar has happened to my girlfriend's phone. It's an iPhone 5S and after an update to iOS 9.0.1, it is stuck in DFU mode. Went to the Genius Bar and they told me that it is a hardware issue (which miraculously appeared during the update) and the only option is to buy a "new" iPhone 5S. Seems that there are some backwards compatibility issues with the iOS 9.0.1.
The log:
2015-09-22 15:43:12.332 [7428:2abc]: restore library built Sep 2 2015 at 16:46:14
2015-09-22 15:43:12.332 [7428:2abc]: iTunes: iTunes 12.3.0.44
2015-09-22 15:43:12.332 [7428:2abc]: iTunes: Software payload version: 13A344
2015-09-22 15:43:12.332 [7428:2abc]: iTunes: Using MobileRestore state machine
[13:44:20.0062] Changing state from '(null)' to 'Restoring'
[13:44:20.0067] requested restore behavior: Erase
[13:44:20.0068] amai: AMAuthInstallBundleCopyBuildIdentityForVariant: No baseband chipid reported. Will match Build Identity based on ap chipid and boardid only.
[13:44:20.0100] requested restore behavior: Erase
[13:44:20.0100] requested variant: Erase
[13:44:20.0101] requested restore behavior: Erase
[13:44:20.0602] amai: _AMAuthInstallBundleCreateServerRequestDictionary: withApTicket is True
[13:44:20.0602] amai: _AMAuthInstallBundleCreateServerRequestDictionary: personalizing "RestoreLogo" Digest = "<CFData 000000001143C440 [000007FEEC9F8100]>{length = 20, capacity = 20, bytes = 0x50b993ea4a8828d6e3c28b992a68603e9ce6e674}"
[13:44:20.0602] amai: _AMAuthInstallBundleCreateServerRequestDictionary: personalizing "RestoreDeviceTree" Digest = "<CFData 000000001143D4E0 [000007FEEC9F8100]>{length = 20, capacity = 20, bytes = 0x3dd7c424d063ee533094c9b892cda5961509b7ea}"
[13:44:20.0602] amai: _AMAuthInstallBundleCreateServerRequestDictionary: personalizing "RestoreKernelCache" Digest = "<CFData 000000001143D780 [000007FEEC9F8100]>{length = 20, capacity = 20, bytes = 0x7d628520f08365d70af05bed9ad0d348e883d4a0}"
[13:44:20.0602] amai: _AMAuthInstallBundleCreateServerRequestDictionary: personalizing "RestoreRamDisk" Digest = "<CFData 000000001143E350 [000007FEEC9F8100]>{length = 20, capacity = 20, bytes = 0xce141daa5a17e4c62db8ebeb87cbe2b8a7bc50e3}"
[13:44:20.0602] amai: _AMAuthInstallBundleCreateServerRequestDictionary: personalizing "iBEC" Digest = "<CFData 000000001143E2E0 [000007FEEC9F8100]>{length = 20, capacity = 20, bytes = 0xfca8d09f21eb803f921750a535ce334768b5b002}"
[13:44:20.0602] amai: _AMAuthInstallBundleCreateServerRequestDictionary: personalizing "iBSS" Digest = "<CFData 000000001143E0B0 [000007FEEC9F8100]>{length = 20, capacity = 20, bytes = 0x8bd7cd49e9781253c46825d6f6a623be8a098a6e}"
[13:44:20.0602] amai: _AMAuthInstallBundleCreateServerRequestDictionary: personalizing "KernelCache" Digest = "<CFData 000000001143E040 [000007FEEC9F8100]>{length = 20, capacity = 20, bytes = 0xb7d237081cac3d95f929040a16f5fb8f8e688bf5}"
[13:44:20.0602] amai: _AMAuthInstallBundleCreateServerRequestDictionary: entry "ftap" not part of manifest, skipping
[13:44:20.0602] amai: _AMAuthInstallBundleCreateServerRequestDictionary: entry "rfta" not part of manifest, skipping
[13:44:20.0602] amai: _AMAuthInstallBundleCreateServerRequestDictionary: entry "ftsp" not part of manifest, skipping
[13:44:20.0602] amai: _AMAuthInstallBundleCreateServerRequestDictionary: entry "rfts" not part of manifest, skipping
[13:44:20.0602] amai: _AMAuthInstallBundleCreateServerRequestDictionary: entry "Diags" not part of manifest, skipping
[13:44:20.0602] amai: _AMAuthInstallBundleCreateServerRequestDictionary: entry "CFELoader" not part of manifest, skipping
[13:44:20.0602] amai: _AMAuthInstallBundleCreateServerRequestDictionary: entry "RBM" not part of manifest, skipping
[13:44:20.0602] amai: _AMAuthInstallBundleCreateServerRequestDictionary: entry "PHLEET" not part of manifest, skipping
[13:44:20.0603] amai: _AMAuthInstallBundleCreateServerRequestDictionary: entry "PERTOS" not part of manifest, skipping
[13:44:20.0603] amai: _AMAuthInstallBundleCreateServerRequestDictionary: entry "PEHammer" not part of manifest, skipping
[13:44:20.0603] amai: _AMAuthInstallBundleCreateServerRequestDictionary: personalizing "LLB" Digest = "<CFData 000000001143DE10 [000007FEEC9F8100]>{length = 20, capacity = 20, bytes = 0xbb635b90c30b94dffe87073938b7b8e2645a999f}"
[13:44:20.0603] amai: _AMAuthInstallBundleCreateServerRequestDictionary: personalizing "AppleLogo" Digest = "<CFData 000000001143DDA0 [000007FEEC9F8100]>{length = 20, capacity = 20, bytes = 0x8079df20e2df686f3970a4d32e1cac9de5caeca1}"
[13:44:20.0603] amai: _AMAuthInstallBundleCreateServerRequestDictionary: personalizing "BatteryCharging1" Digest = "<CFData 000000001143DB70 [000007FEEC9F8100]>{length = 20, capacity = 20, bytes = 0x332a1108366fe677244425b93f79747035643e02}"
[13:44:20.0603] amai: _AMAuthInstallBundleCreateServerRequestDictionary: personalizing "SEP" Digest = "<CFData 000000001143DB00 [000007FEEC9F8100]>{length = 20, capacity = 20, bytes = 0xe977e8367a86c0349c23ee8e0ecf4fac31c5f57d}"
[13:44:20.0603] amai: _AMAuthInstallBundleCreateServerRequestDictionary: personalizing "BatteryFull" Digest = "<CFData 000000001143D8D0 [000007FEEC9F8100]>{length = 20, capacity = 20, bytes = 0xf6f741051033bcaa14d4dd92f7ace6fb81f27a43}"
[13:44:20.0603] amai: _AMAuthInstallBundleCreateServerRequestDictionary: personalizing "BatteryPlugin" Digest = "<CFData 000000001143D860 [000007FEEC9F8100]>{length = 20, capacity = 20, bytes = 0xefbc6503e5f9ab6fa394b0a3d4faa54d50665153}"
[13:44:20.0603] amai: _AMAuthInstallBundleCreateServerRequestDictionary: personalizing "BatteryCharging0" Digest = "<CFData 000000001143D630 [000007FEEC9F8100]>{length = 20, capacity = 20, bytes = 0x31e666d945b119258fc109f95d491237ce6d19b2}"
[13:44:20.0603] amai: _AMAuthInstallBundleCreateServerRequestDictionary: personalizing "BatteryLow1" Digest = "<CFData 000000001143F540 [000007FEEC9F8100]>{length = 20, capacity = 20, bytes = 0x65fa7a8775e800f100df2693113aee6f71a1d011}"
[13:44:20.0603] amai: _AMAuthInstallBundleCreateServerRequestDictionary: personalizing "RestoreSEP" Digest = "<CFData 000000001143FBD0 [000007FEEC9F8100]>{length = 20, capacity = 20, bytes = 0x61e721dd7cc9376df28a0850844358ae71b2d7b0}"
[13:44:20.0603] amai: _AMAuthInstallBundleCreateServerRequestDictionary: personalizing "BatteryLow0" Digest = "<CFData 000000001143F9A0 [000007FEEC9F8100]>{length = 20, capacity = 20, bytes = 0x12990b58a4596f56648587d6770d52379c13a97a}"
[13:44:20.0603] amai: _AMAuthInstallBundleCreateServerRequestDictionary: personalizing "RecoveryMode" Digest = "<CFData 000000001143FA10 [000007FEEC9F8100]>{length = 20, capacity = 20, bytes = 0xadd5c371b09819ef5b462071e12a21adea43afe2}"
[13:44:20.0603] amai: _AMAuthInstallBundleCreateServerRequestDictionary: personalizing "DeviceTree" Digest = "<CFData 000000001143F700 [000007FEEC9F8100]>{length = 20, capacity = 20, bytes = 0x3131cb57ebf1b978d9090861cff0fbc43df6fdb3}"
[13:44:20.0603] amai: _AMAuthInstallBundleCreateServerRequestDictionary: personalizing "iBoot" Digest = "<CFData 000000001143F770 [000007FEEC9F8100]>{length = 20, capacity = 20, bytes = 0xfdbdc80eba555e2b7d9d329c1c3f5ba439055e2b}"
[13:44:20.0604] amai: _AMAuthInstallBundleCreateServerRequestDictionary: using UniqueBuildID <CFData 000000006A9C0AD0 [000007FEEC9F8100]>{length = 20, capacity = 20, bytes = 0xf2780e471a89c8dc253e0f60c62b19c779c2a63e}
[13:44:20.0607] amai: AMAuthInstallRequestSendSync: SSO function returned NULL and no SSO token was provided, SSO disabled.
[13:44:20.0609] amai: tss_submit_job_with_retry: TSS Connection attempt 1 of 3. (Will retry if TSS_ERR_SERVER_NOT_REACHABLE.)
[13:44:20.0998] amai: tss_submit_job: HttpQueryInfo returned 200
[13:44:21.0135] amai: AMAuthInstallRequestSendSync: received tss response (server version: 2.1.0)
[13:44:21.0293] amai: _AMAuthInstallBundlePopulatePersonalizedBundle: no entry in manifest found for "ftap"
[13:44:21.0293] amai: _AMAuthInstallBundlePopulatePersonalizedBundle: no entry in manifest found for "rfta"
[13:44:21.0293] amai: _AMAuthInstallBundlePopulatePersonalizedBundle: no entry in manifest found for "ftsp"
[13:44:21.0293] amai: _AMAuthInstallBundlePopulatePersonalizedBundle: no entry in manifest found for "rfts"
[13:44:21.0293] amai: _AMAuthInstallBundlePopulatePersonalizedBundle: no entry in manifest found for "Diags"
[13:44:21.0293] amai: _AMAuthInstallBundlePopulatePersonalizedBundle: no entry in manifest found for "CFELoader"
[13:44:21.0293] amai: _AMAuthInstallBundlePopulatePersonalizedBundle: no entry in manifest found for "RBM"
[13:44:21.0293] amai: _AMAuthInstallBundlePopulatePersonalizedBundle: no entry in manifest found for "PHLEET"
[13:44:21.0293] amai: _AMAuthInstallBundlePopulatePersonalizedBundle: no entry in manifest found for "PERTOS"
[13:44:21.0293] amai: _AMAuthInstallBundlePopulatePersonalizedBundle: no entry in manifest found for "PEHammer"
[13:44:21.0443] iBoot build-version = iBoot-2261.30.37
[13:44:21.0445] iBoot build-style = RELEASE
[13:44:21.0445] requested restore behavior: Erase
[13:44:21.0448] requested restore behavior: Erase
[13:44:21.0451] unable to open device_map.txt: No such file or directory
[13:44:21.0452] found device map entry for 0x00008960 0x00000002. boardConfig=n53ap platform=s5l8960x
[13:44:21.0452] _AMRestoreCopyDeviceMapPlistEntryForHardware: firmwareDirectory not in options
[13:44:21.0453] AMDeviceIoControl: GetOverlappedResult failed
[13:44:21.0453] AMDeviceIoControl: pipe stall
[13:44:21.0453] USBControlTransfer: error 31, usbd status c0000004
[13:44:21.0454] command device request for 'getenv radio-error' failed: 2008
[13:44:21.0454] radio-error not set
[13:44:21.0454] unable to open device_map.txt: No such file or directory
[13:44:21.0454] <Recovery Mode Device 0000000008008380>: production fused device
[13:44:21.0455] requested restore behavior: Erase
[13:44:21.0457] requested restore behavior: Erase
[13:44:21.0463] interface has 1 endpoints, file pipe = 1
[13:44:21.0463]
[13:44:21.0463] <Recovery Mode Device 0000000008008380>: operation 4 progress -1
[13:44:21.0466] bootstrapping restore with iBEC
[13:44:21.0466] requested restore behavior: Erase
[13:44:21.0490] <Recovery Mode Device 0000000008008380>: operation 31 progress -1
[13:44:22.0490] <Recovery Mode Device 0000000008008380>: Recovery mode succeeded
[13:44:22.0490] Finished Recovery Restore Phase: Successful
[13:44:22.0669] Recovery mode device disconnected
[13:44:22.0669] Device removed when in state Restoring, moving device to transition state
[13:44:22.0669] Changing state from 'Restoring' to 'Transitioning'
[13:44:22.0669] Creating timer to monitor transition
[13:44:24.0289] Recovery mode device connected
[13:44:24.0289] Transitioning device returned, continuing restore.
[13:44:24.0289] Canceling timer
[13:44:24.0289] Changing state from 'Transitioning' to 'Restoring'
[13:44:24.0289] requested restore behavior: Erase
[13:44:24.0296] amai: AMAuthInstallBundleCopyBuildIdentityForVariant: No baseband chipid reported. Will match Build Identity based on ap chipid and boardid only.
[13:44:24.0296] requested restore behavior: Erase
[13:44:24.0296] requested variant: Erase
[13:44:24.0296] requested restore behavior: Erase
[13:44:24.0676] amai: _AMAuthInstallBundleCreateServerRequestDictionary: withApTicket is False
[13:44:24.0676] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "RestoreLogo"
[13:44:24.0676] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "RestoreDeviceTree"
[13:44:24.0676] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "RestoreKernelCache"
[13:44:24.0676] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "RestoreRamDisk"
[13:44:24.0676] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "iBEC"
[13:44:24.0676] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "iBSS"
[13:44:24.0676] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "KernelCache"
[13:44:24.0676] amai: _AMAuthInstallBundleCreateServerRequestDictionary: entry "ftap" not part of manifest, skipping
[13:44:24.0676] amai: _AMAuthInstallBundleCreateServerRequestDictionary: entry "rfta" not part of manifest, skipping
[13:44:24.0676] amai: _AMAuthInstallBundleCreateServerRequestDictionary: entry "ftsp" not part of manifest, skipping
[13:44:24.0676] amai: _AMAuthInstallBundleCreateServerRequestDictionary: entry "rfts" not part of manifest, skipping
[13:44:24.0676] amai: _AMAuthInstallBundleCreateServerRequestDictionary: entry "Diags" not part of manifest, skipping
[13:44:24.0676] amai: _AMAuthInstallBundleCreateServerRequestDictionary: entry "CFELoader" not part of manifest, skipping
[13:44:24.0676] amai: _AMAuthInstallBundleCreateServerRequestDictionary: entry "RBM" not part of manifest, skipping
[13:44:24.0676] amai: _AMAuthInstallBundleCreateServerRequestDictionary: entry "PHLEET" not part of manifest, skipping
[13:44:24.0676] amai: _AMAuthInstallBundleCreateServerRequestDictionary: entry "PERTOS" not part of manifest, skipping
[13:44:24.0676] amai: _AMAuthInstallBundleCreateServerRequestDictionary: entry "PEHammer" not part of manifest, skipping
[13:44:24.0676] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "LLB"
[13:44:24.0676] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "AppleLogo"
[13:44:24.0676] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "BatteryCharging1"
[13:44:24.0676] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "SEP"
[13:44:24.0676] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "BatteryFull"
[13:44:24.0676] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "BatteryPlugin"
[13:44:24.0676] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "BatteryCharging0"
[13:44:24.0676] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "BatteryLow1"
[13:44:24.0676] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "RestoreSEP"
[13:44:24.0676] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "BatteryLow0"
[13:44:24.0676] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "RecoveryMode"
[13:44:24.0677] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "DeviceTree"
[13:44:24.0677] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "iBoot"
[13:44:24.0677] amai: _AMAuthInstallBundleCreateServerRequestDictionary: nothing to be done
[13:44:24.0679] iBoot build-version = iBoot-2817.1.93
[13:44:24.0681] iBoot build-style = RELEASE
[13:44:24.0681] requested restore behavior: Erase
[13:44:24.0684] requested restore behavior: Erase
[13:44:24.0687] unable to open device_map.txt: No such file or directory
[13:44:24.0687] found device map entry for 0x00008960 0x00000002. boardConfig=n53ap platform=s5l8960x
[13:44:24.0687] _AMRestoreCopyDeviceMapPlistEntryForHardware: firmwareDirectory not in options
[13:44:24.0688] AMDeviceIoControl: GetOverlappedResult failed
[13:44:24.0688] AMDeviceIoControl: pipe stall
[13:44:24.0688] USBControlTransfer: error 31, usbd status c0000004
[13:44:24.0689] command device request for 'getenv radio-error' failed: 2008
[13:44:24.0689] radio-error not set
[13:44:24.0689] unable to open device_map.txt: No such file or directory
[13:44:24.0689] <Recovery Mode Device 0000000008008140>: production fused device
[13:44:24.0689] requested restore behavior: Erase
[13:44:24.0693] requested restore behavior: Erase
[13:44:24.0697] interface has 1 endpoints, file pipe = 1
[13:44:24.0697]
[13:44:24.0697] <Recovery Mode Device 0000000008008140>: operation 4 progress -1
[13:44:24.0701] unable to open device_map.txt: No such file or directory
[13:44:24.0701] found device map entry for 0x00008960 0x00000002. boardConfig=n53ap platform=s5l8960x
[13:44:24.0701] _AMRestoreCopyDeviceMapPlistEntryForHardware: firmwareDirectory not in options
[13:44:24.0702] requested restore behavior: Erase
[13:44:24.0704] requested restore behavior: Erase
[13:44:24.0709] <Recovery Mode Device 0000000008008140>: operation 42 progress -1
[13:44:24.0709] requested restore behavior: Erase
[13:44:25.0724] <Recovery Mode Device 0000000008008140>: operation 5 progress -1
[13:44:26.0338] unable to open device_map.txt: No such file or directory
[13:44:26.0339] found device map entry for 0x00008960 0x00000002. boardConfig=n53ap platform=s5l8960x
[13:44:26.0339] _AMRestoreCopyDeviceMapPlistEntryForHardware: firmwareDirectory not in options
[13:44:26.0340] AMDeviceIoControl: GetOverlappedResult failed
[13:44:26.0340] AMDeviceIoControl: pipe stall
[13:44:26.0340] USBControlTransfer: error 31, usbd status c0000004
[13:44:26.0340] command device request for 'getenv ramdisk-delay' failed: 2008
[13:44:27.0608] <Recovery Mode Device 0000000008008140>: operation 6 progress -1
[13:44:28.0624] <Recovery Mode Device 0000000008008140>: operation 7 progress -1
[13:44:28.0910] <Recovery Mode Device 0000000008008140>: operation 8 progress -1
[13:44:28.0910] unable to open device_map.txt: No such file or directory
[13:44:28.0911] found device map entry for 0x00008960 0x00000002. boardConfig=n53ap platform=s5l8960x
[13:44:28.0911] _AMRestoreCopyDeviceMapPlistEntryForHardware: firmwareDirectory not in options
[13:44:28.0912] <Recovery Mode Device 0000000008008140>: operation 9 progress -1
[13:44:28.0913] <Recovery Mode Device 0000000008008140>: Recovery mode succeeded
[13:44:28.0913] Finished Recovery Restore Phase: Successful
[13:44:29.0904] Recovery mode device disconnected
[13:44:29.0904] Device removed when in state Restoring, moving device to transition state
[13:44:29.0904] Changing state from 'Restoring' to 'Transitioning'
[13:44:29.0904] Creating timer to monitor transition
[13:44:35.0913] RestoreOS mode device connected
[13:44:35.0913] Transitioning device returned, continuing restore.
[13:44:35.0913] Canceling timer
[13:44:35.0913] Changing state from 'Transitioning' to 'Restoring'
[13:44:35.0919] requested restore behavior: Erase
[13:44:35.0922] amai: AMAuthInstallBundleCopyBuildIdentityForVariant: No baseband chipid reported. Will match Build Identity based on ap chipid and boardid only.
[13:44:35.0923] <Restore Device 000000000836D2C0>: operation 44 progress -1
[13:44:35.0923] requested restore behavior: Erase
[13:44:35.0923] requested variant: Erase
[13:44:35.0923] requested restore behavior: Erase
[13:44:36.0307] amai: _AMAuthInstallBundleCreateServerRequestDictionary: withApTicket is False
[13:44:36.0307] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "RestoreLogo"
[13:44:36.0307] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "RestoreDeviceTree"
[13:44:36.0307] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "RestoreKernelCache"
[13:44:36.0307] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "RestoreRamDisk"
[13:44:36.0307] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "iBEC"
[13:44:36.0307] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "iBSS"
[13:44:36.0307] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "KernelCache"
[13:44:36.0308] amai: _AMAuthInstallBundleCreateServerRequestDictionary: entry "ftap" not part of manifest, skipping
[13:44:36.0308] amai: _AMAuthInstallBundleCreateServerRequestDictionary: entry "rfta" not part of manifest, skipping
[13:44:36.0308] amai: _AMAuthInstallBundleCreateServerRequestDictionary: entry "ftsp" not part of manifest, skipping
[13:44:36.0308] amai: _AMAuthInstallBundleCreateServerRequestDictionary: entry "rfts" not part of manifest, skipping
[13:44:36.0308] amai: _AMAuthInstallBundleCreateServerRequestDictionary: entry "Diags" not part of manifest, skipping
[13:44:36.0308] amai: _AMAuthInstallBundleCreateServerRequestDictionary: entry "CFELoader" not part of manifest, skipping
[13:44:36.0308] amai: _AMAuthInstallBundleCreateServerRequestDictionary: entry "RBM" not part of manifest, skipping
[13:44:36.0308] amai: _AMAuthInstallBundleCreateServerRequestDictionary: entry "PHLEET" not part of manifest, skipping
[13:44:36.0308] amai: _AMAuthInstallBundleCreateServerRequestDictionary: entry "PERTOS" not part of manifest, skipping
[13:44:36.0308] amai: _AMAuthInstallBundleCreateServerRequestDictionary: entry "PEHammer" not part of manifest, skipping
[13:44:36.0308] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "LLB"
[13:44:36.0308] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "AppleLogo"
[13:44:36.0308] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "BatteryCharging1"
[13:44:36.0308] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "SEP"
[13:44:36.0308] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "BatteryFull"
[13:44:36.0308] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "BatteryPlugin"
[13:44:36.0308] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "BatteryCharging0"
[13:44:36.0308] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "BatteryLow1"
[13:44:36.0308] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "RestoreSEP"
[13:44:36.0308] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "BatteryLow0"
[13:44:36.0308] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "RecoveryMode"
[13:44:36.0308] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "DeviceTree"
[13:44:36.0308] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "iBoot"
[13:44:36.0308] amai: _AMAuthInstallBundleCreateServerRequestDictionary: nothing to be done
[13:44:36.0308] requested restore behavior: Erase
[13:44:36.0310] overwrite InstallDiags to false
[13:44:36.0316] device did not return saved USB log
[13:44:36.0316] device did not return saved panic log
[13:44:36.0316] previous restore failed with exit status 0x100
[13:44:36.0318] connected to service com.apple.mobile.restored
[13:44:36.0318] using protocol version 13
[13:44:36.0323] unable to open device_map.txt: No such file or directory
[13:44:36.0324] board config = n53ap
[13:44:36.0332] no value returned for BootArgs
[13:44:36.0332] _copyDeviceProperty() failed for restore bootargs
[13:44:36.0342] no value returned for MarketingPartNumber
[13:44:36.0342] _copyDeviceProperty() failed for mpn
[13:44:36.0342] requested restore behavior: Erase
[13:44:36.0355] value query for 'HardwareModel' returned 'N53AP'
[13:44:36.0355] Established proxy for device ID 3
[13:44:36.0468] <Restore Device 000000000836D2C0>: operation 35 progress -1
[13:44:36.0468] requested restore behavior: Erase
[13:44:38.0940] <Restore Device 000000000836D2C0>: operation 28 progress -1
[13:44:46.0307] previous restore failed: SYSLOG: Sep 22 13:38:28 localhost bootlog[0] <Notice>: BOOT_TIME 1442929108 0
[13:44:46.0307] SYSLOG: Sep 22 13:38:28 localhost kernel[0] <Notice>: s = 0x<<<<<MEID>>>>>00 provider = 0x<<<<<MEID>>>>>00
[13:44:46.0307] SYSLOG: Sep 22 13:38:28 localhost kernel[0] <Notice>: ASPSEPNotifier::start - Exit Success
[13:44:46.0307] SYSLOG: Sep 22 13:38:28 localhost kernel[0] <Notice>: ASPSEPNotifier:XXXXXXXXXSP - Waiting for ASPStorage
[13:44:46.0307] SYSLOG: Sep 22 13:38:28 localhost kernel[0] <Notice>: ASPStorage::start - ASP command timeout is 30 seconds
[13:44:46.0307] SYSLOG: Sep 22 13:38:28 localhost kernel[0] <Notice>: ASPStorage:XXXXXXXXXResources - ASP # cmds 64KB 20 1MB 11 8MB 1
[13:44:46.0307] SYSLOG: Sep 22 13:38:28 localhost kernel[0] <Notice>: ASPStorage:XXXXXXXXXPEvent - Host protocol version 10 aspcore protocol version 10
[13:44:46.0307] SYSLOG: Sep 22 13:38:28 localhost kernel[0] <Notice>: ASPStorage:XXXXXXXXXeometry - NAND Geometry info:
[13:44:46.0307] SYSLOG: Sep 22 13:38:28 localhost kernel[0] <Notice>: ASPStorage:XXXXXXXXXeometry - Num LBAs : 3906250
[13:44:46.0307] SYSLOG: Sep 22 13:38:28 localhost kernel[0] <Notice>: ASPStorage:XXXXXXXXXeometry - Bytes per LBA : 4096
[13:44:46.0307] SYSLOG: Sep 22 13:38:28 localhost kernel[0] <Notice>: ASPStorage:XXXXXXXXXeometry - Preferred buffer size: 65536
[13:44:46.0307] SYSLOG: Sep 22 13:38:28 localhost kernel[0] <Notice>: ASPStorage:XXXXXXXXXeometry - lbaFormatted : YES
[13:44:46.0307] SYSLOG: Sep 22 13:38:28 localhost kernel[0] <Notice>: ASPStorage:XXXXXXXXXeometry - utilFormatted : YES
[13:44:46.0307] SYSLOG: Sep 22 13:38:28 localhost kernel[0] <Notice>: AppleSamsungSerial: Identified Serial Port on ARM Device=uart1 at 0x20a0a4000(0x<<<<<MEID>>>>>00)
[13:44:46.0307] SYSLOG: Sep 22 13:38:28 localhost kernel[0] <Notice>: BSD root: md0, major 2, minor 0
[13:44:46.0307] SYSLOG: Sep 22 13:38:28 localhost kernel[0] <Notice>: com.apple.AppleFSCompressionTypeZlib kmod start
[13:44:46.0307] SYSLOG: Sep 22 13:38:28 localhost kernel[0] <Notice>: AppleSamsungSerial: Identified Serial Port on ARM Device=uart4 at 0x20a0b0000(0x<<<<<MEID>>>>>00)
[13:44:46.0307] SYSLOG: Sep 22 13:38:28 localhost kernel[0] <Notice>: AppleSamsungSerial: Identified Serial Port on ARM Device=uart2 at 0x20a0a8000(0x<<<<<MEID>>>>>00)
[13:44:46.0307] SYSLOG: Sep 22 13:38:28 localhost kernel[0] <Notice>: com.apple.AppleFSCompressionTypeZlib load succeeded
[13:44:46.0307] SYSLOG: Sep 22 13:38:28 localhost kernel[0] <Notice>: L2TP domain init
[13:44:46.0307] SYSLOG: Sep 22 13:38:28 localhost kernel[0] <Notice>: L2TP domain init complete
[13:44:46.0307] SYSLOG: Sep 22 13:38:28 localhost kernel[0] <Notice>: PPTP domain init
[13:44:46.0307] SYSLOG: Sep 22 13:38:28 localhost kernel[0] <Notice>: AppleBaseband: Backpowering function: functionXXXXXXXXXring_pin0
[13:44:46.0307] SYSLOG: Sep 22 13:38:28 localhost kernel[0] <Notice>: AppleBaseband: Found 1 backpowering pins
[13:44:46.0307] SYSLOG: Sep 22 13:38:28 localhost kernel[0] <Notice>: Found DPB Driver
[13:44:46.0307] SYSLOG: Sep 22 13:38:28 localhost kernel[0] <Notice>: Found DPB Driver
[13:44:46.0307] SYSLOG: Sep 22 13:38:28 localhost kernel[0] <Notice>: Dither pDeviceMemory->getLength()) = 0x8000
[13:44:46.0307] SYSLOG: Sep 22 13:38:28 localhost kernel[0] <Notice>: Found Dither Driver
[13:44:46.0307] SYSLOG: Sep 22 13:38:28 localhost kernel[0] <Notice>: virtual bool AppleH4DisplayPipe::start_hardware(IOService *), auto-detect chip
[13:44:46.0307] SYSLOG: Sep 22 13:38:28 localhost kernel[0] <Notice>: void AppleDisplayPipe:XXXXXXXXXequencies(): minimumXXXXXXXXXy property not found, using getClockFrequency(0) instead.
[13:44:46.0307] SYSLOG: Sep 22 13:38:28 localhost kernel[0] <Notice>: AppleOscarProcessorXXXXXXXXXXXXXXXXXXXXX setting oscar-state=0
[13:44:46.0307] SYSLOG: Sep 22 13:38:28 localhost kernel[0] <Notice>: ASPStorage:XXXXXXXXXalizeTime - kern.monotonicclock at boot = 60913322
[13:44:46.0307] SYSLOG: Sep 22 13:38:28 localhost kernel[0] <Notice>: ASPStorageXXXXXXXXXXXXXXXXXXXXdisk - Root device is md0
[13:44:46.0307] SYSLOG: Sep 22 13:38:28 localhost kernel[0] <Notice>: [ANS syslog: nand] Push_PowerGovernorInit:Nand Die:2 MLC: 2 No SLC: 2 No Erase:2
[13:44:46.0307] SYSLOG: Sep 22 13:38:28 localhost kernel[0] <Notice>: AGXk: AGXAcceleratorG3_B0: GPU firmware booted successfully (AGXFirmwareKextG3)
[13:44:46.0307] SYSLOG: Sep 22 13:38:28 localhost kernel[0] <Notice>: AppleH6CamIn::start - back camera expected
[13:44:46.0307] SYSLOG: Sep 22 13:38:28 localhost kernel[0] <Notice>: AppleH6CamIn::start - front camera expected
[13:44:46.0307] SYSLOG: Sep 22 13:38:28 localhost kernel[0] <Notice>: AppleMultitouchN1SPI: successfully started
[13:44:46.0307] SYSLOG: Sep 22 13:38:28 localhost kernel[0] <Notice>: AppleH6CamIn::power_off_hardware
[13:44:46.0307] SYSLOG: Sep 22 13:38:28 localhost kernel[0] <Notice>: AppleH6CamIn::start - About to register service
[13:44:46.0307] SYSLOG: Sep 22 13:38:28 localhost kernel[0] <Notice>: AppleH6CamInXXXXXXXXXXXXXXXXXXXXX 0
[13:44:46.0307] SYSLOG: Sep 22 13:38:28 localhost kernel[0] <Notice>: ASPBlockStorage:XXXXXXXXXvice - Creating block device of 3906250 sectors of 4096 bytes
[13:44:46.0307] SYSLOG: Sep 22 13:38:28 localhost kernel[0] <Notice>: AppleARMPMUCharger: AppleUSBCableDetect 1
[13:44:46.0307] SYSLOG: Sep 22 13:38:28 localhost kernel[0] <Notice>: AppleARMPMUCharger: AppleUSBCableType USBHost
[13:44:46.0307] SYSLOG: Sep 22 13:38:28 localhost kernel[0] <Notice>: AppleS5L8960XPerformanceController::start: Dynamic Framebuffer Caching is enabled
[13:44:46.0307] SYSLOG: Sep 22 13:38:28 localhost kernel[0] <Notice>: AppleOscarProcessorXXXXXXXXXXXXXXXXXXXXX setting oscar-state=10001
[13:44:46.0307] SYSLOG: Sep 22 13:38:28 localhost kernel[0] <Notice>: AppleOscarProcessor:XXXXXXXXXtGated: Starting Oscar1, baudRate=1500000
[13:44:46.0307] SYSLOG: Sep 22 13:38:28 localhost kernel[0] <Notice>: ready - 00000000: 3f | ?
[13:44:46.0307] SYSLOG: Sep 22 13:38:28 localhost kernel[0] <Notice>: AppleARMPMUCharger: AppleUSBCableDetect 0
[13:44:46.0307] SYSLOG: Sep 22 13:38:28 localhost kernel[0] <Notice>: AppleARMPMUCharger: AppleUSBCableType Detached
[13:44:46.0307] SYSLOG: Sep 22 13:38:28 localhost kernel[0] <Notice>: AppleSynopsysOTGDevice::gated_handleUSBCableConnect cable connected, but don't have device configuration yet
[13:44:46.0307] SYSLOG: Sep 22 13:38:28 localhost kernel[0] <Notice>: AppleSynopsysOTGDevice::gated_handleUSBCableConnect cable connected, but don't have device configuration yet
[13:44:46.0307] SYSLOG: Sep 22 13:38:28 localhost kernel[0] <Notice>: LwVM::probe - failed to read header from media
[13:44:46.0307] SYSLOG: Sep 22 13:38:28 localhost kernel[0] <Notice>: [effaceable:INIT] found current generation, 177, in group 0
[13:44:46.0307] SYSLOG: Sep 22 13:38:28 localhost kernel[0] <Notice>: [effaceable:INIT] started
[13:44:46.0307] SYSLOG: Sep 22 13:38:28 localhost kernel[0] <Notice>: [ANS syslog: nand] Util_HostXXXXXXXXXng to read element=PANICLOG not yet written, returning ERR_ABORT
[13:44:46.0307] SYSLOG: Sep 22 13:38:28 localhost kernel[0] <Notice>: LwVM::probe - failed to read header from media
[13:44:46.0307] SYSLOG: Sep 22 13:38:28 localhost kernel[0] <Notice>: [ANS syslog: nand] Util_HostXXXXXXXXXng to read element=PANICLOG not yet written, returning ERR_ABORT
[13:44:46.0307] SYSLOG: Sep 22 13:38:28 localhost kernel[0] <Notice>: [ANS syslog: nand] Util_HostXXXXXXXXXng to read element=PANICLOG not yet written, returning ERR_ABORT
[13:44:46.0307] SYSLOG: Sep 22 13:38:28 localhost kernel[0] <Notice>: [ANS syslog: nand] Util_HostXXXXXXXXXng to read element=PANICLOG not yet written, returning ERR_ABORT
[13:44:46.0307] SYSLOG: Sep 22 13:38:28 localhost kernel[0] <Notice>: AppleARMPMUCharger: AppleUSBCableDetect 1
[13:44:46.0307] SYSLOG: Sep 22 13:38:28 localhost kernel[0] <Notice>: AppleARMPMUCharger: AppleUSBCableType USBHost
[13:44:46.0307] SYSLOG: Sep 22 13:38:28 localhost kernel[0] <Notice>: AppleSynopsysOTGDevice::gated_handleUSBCableConnect cable connected, but don't have device configuration yet
[13:44:46.0307] SYSLOG: Sep 22 13:38:28 localhost kernel[0] <Notice>: AppleMultitouchN1SPI: detected HBPP. driver will be kept alive
[13:44:46.0307] unable to open /dev/klog: Resource busy
[13:44:46.0307] display-scale = 2
[13:44:46.0307] displayXXXXXXXXX = 0
[13:44:46.0307] found applelogo at /usr/share/progressui/applelogo@2x.tga
[13:44:46.0307] SYSLOG: Sep 22 13:38:29 localhost restored_external[6] <Error>: IOMFB: /System/Library/Frameworks/MediaToolbox.framework/MediaToolbox not found
[13:44:46.0307] SYSLOG: Sep 22 13:38:29 localhost restored_external[6] <Error>: IOMFB: /System/Library/PrivateFrameworks/MediaToolbox.framework/MediaToolbox not found
[13:44:46.0307] SYSLOG: Sep 22 13:38:29 localhost restored_external[6] <Error>: IOMFB: /System/Library/PrivateFrameworks/Celestial.framework/Celestial not found
[13:44:46.0307] SYSLOG: Sep 22 13:38:29 localhost restored_external[6] <Error>: IOMFB: FigInstallVirtualDisplay not found
[13:44:46.0307] SYSLOG: Sep 22 13:38:29 localhost restored_external[6] <Error>: CFPreferences could not connect to its daemon.
[13:44:46.0307] Preferences using the connection 0x0 will be volatile and will not be persisted to disk.
[13:44:46.0307] found display: primary
[13:44:46.0307] display: 640 x 1136
[13:44:46.0307] SYSLOG: Sep 22 13:38:29 localhost kernel[0] <Notice>: Loading syscfg.
[13:44:46.0307] SYSLOG: Sep 22 13:38:29 localhost kernel[0] <Notice>: AppleSynopsysOTGDevice - Configuration: Apple Mobile Device
[13:44:46.0307] SYSLOG: Sep 22 13:38:29 localhost kernel[0] <Notice>: AppleSynopsysOTGDevice Interface: AppleUSBMux
[13:44:46.0307] waiting for matching IOKit service: <CFBasicHash 0x135d0a5f0 [0x1005e3fa0]>{type = mutable dict, count = 1,
[13:44:46.0307] entries =>
[13:44:46.0307] 0 : <CFString 0x1007e6e10 [0x1005e3fa0]>{contents = "IOProviderClass"} = <CFString 0x135d077d0 [0x1005e3fa0]>{contents = "AppleUSBDeviceMux"}
[13:44:46.0307] }
[13:44:46.0307] SYSLOG: Sep 22 13:38:29 localhost kernel[0] <Notice>: virtual bool AppleUSBDeviceMux::start(IOService *) build: Aug 5 2015 19:18:25
[13:44:46.0307] SYSLOG: Sep 22 13:38:29 localhost kernel[0] <Notice>: AppleSynopsysOTGDevice::gated_registerFunction Register function AppleUSBMux
[13:44:46.0307] SYSLOG: Sep 22 13:38:29 localhost kernel[0] <Notice>: AppleSynopsysOTGDevice:XXXXXXXXXStack Starting usb stack
[13:44:46.0307] SYSLOG: Sep 22 13:38:29 localhost kernel[0] <Notice>: AppleBCMWLANCore::init IO80211-154.5 Aug 5 2015 19:23:49
[13:44:46.0307] SYSLOG: Sep 22 13:38:29 localhost kernel[0] <Notice>: 000135.927672 wlan0.A[0] AppleBCMWLANProvisioningManagerXXXXXXXXXXXXXXXXXXXXta(): WARNING, Wifi 'serial baud rate' does not exist in the device tree
[13:44:46.0307] SYSLOG: Sep 22 13:38:29 localhost kernel[0] <Notice>: 000135.933355 wlan0.N[1] AppleBCMWLANCore::start(): Starting with MAC Address: <<<mac address>>>
[13:44:46.0307] SYSLOG: Sep 22 13:38:29 localhost kernel[0] <Notice>: 000135.933878 wlan0.N[2] AppleBCMWLANCoreXXXXXXXXXXXXXXXXXXXX(): powerState 1, fStateFlags 0x20, dev 0x<<<<<MEID>>>>>00 (this 1, provider 0)
[13:44:46.0307] SYSLOG: Sep 22 13:38:29 localhost kernel[0] <Notice>: 000135.933897 wlan0.N[3] AppleBCMWLANCoreXXXXXXXXXXXXXXXXXXXX(): Received power state change before driver has initialized, ignoring
[13:44:46.0307] SYSLOG: Sep 22 13:38:29 localhost kernel[0] <Notice>: IO80211PeerManager:XXXXXXXXXInterface can't add monitoring timer
[13:44:46.0307] SYSLOG: Sep 22 13:38:29 localhost kernel[0] <Notice>: IO80211Interface::init peerManager=0x<<<<<MEID>>>>>00
[13:44:46.0307] SYSLOG: Sep 22 13:38:32 localhost kernel[0] <Notice>: IOReturn AppleUSBDeviceMuxXXXXXXXXXXXXXXXXXXXX(OSObject *) setting debug level to 7
[13:44:46.0307] SYSLOG: Sep 22 13:38:32 localhost kernel[0] <Notice>: void AppleUSBDeviceMux:XXXXXXXXXxTCPInput(mbuf_t) received reset, closing 0x<<<<<MEID>>>>>00
[13:44:46.0307] SYSLOG: Sep 22 13:38:32 localhost kernel[0] <Notice>: AppleUSBDeviceMuxXXXXXXXXXXXXXXXXXXXXt new session 0x<<<<<MEID>>>>>00 established 62078<-lo0->49153 62078<-usb->5120
[13:44:46.0307] SYSLOG: Sep 22 13:38:32 localhost kernel[0] <Notice>: AppleUSBDeviceMuxXXXXXXXXXXXXXXXXXXXXt new session 0x<<<<<MEID>>>>>80 established 62078<-lo0->49154 62078<-usb->5376
[13:44:46.0307] SYSLOG: Sep 22 13:38:32 localhost kernel[0] <Notice>: AppleUSBDeviceMuxXXXXXXXXXXXXXXXXXXXXt new session 0x<<<<<MEID>>>>>80 established 62078<-lo0->49155 62078<-usb->5632
[13:44:46.0307] SYSLOG: Sep 22 13:38:32 localhost kernel[0] <Notice>: void AppleUSBDeviceMux:XXXXXXXXXxTCPInput(mbuf_t) received reset, closing 0x<<<<<MEID>>>>>80
[13:44:46.0307] SYSLOG: Sep 22 13:38:32 localhost kernel[0] <Notice>: AppleUSBDeviceMuxXXXXXXXXXXXXXXXXXXXXt new session 0x<<<<<MEID>>>>>80 established 62078<-lo0->49156 62078<-usb->5888
[13:44:46.0307] SYSLOG: Sep 22 13:38:32 localhost kernel[0] <Notice>: void AppleUSBDeviceMux:XXXXXXXXXxTCPInput(mbuf_t) received reset, closing 0x<<<<<MEID>>>>>80
[13:44:46.0307] SYSLOG: Sep 22 13:38:32 localhost kernel[0] <Notice>: void AppleUSBDeviceMux:XXXXXXXXXxTCPInput(mbuf_t) received reset, closing 0x<<<<<MEID>>>>>00
[13:44:46.0307] SYSLOG: Sep 22 13:38:32 localhost kernel[0] <Notice>: AppleUSBDeviceMuxXXXXXXXXXXXXXXXXXXXXt new session 0x<<<<<MEID>>>>>00 established 62078<-lo0->49157 62078<-usb->6144
[13:44:46.0307] SYSLOG: Sep 22 13:38:32 localhost kernel[0] <Notice>: void AppleUSBDeviceMux:XXXXXXXXXxTCPInput(mbuf_t) received reset, closing 0x<<<<<MEID>>>>>80
[13:44:46.0307] SYSLOG: Sep 22 13:38:32 localhost kernel[0] <Notice>: AppleUSBDeviceMuxXXXXXXXXXXXXXXXXXXXXt new session 0x<<<<<MEID>>>>>80 established 62078<-lo0->49158 62078<-usb->6400
[13:44:46.0307] recv(11, 4) failed: connection closed
[13:44:46.0307] recv(13, 4) failed: connection closed
[13:44:46.0307] recv(14, 4) failed: connection closed
[13:44:46.0307] recv(12, 4) failed: connection closed
[13:44:46.0307] recv(15, 4) failed: connection closed
[13:44:46.0307] SYSLOG: Sep 22 13:38:32 localhost kernel[0] <Notice>: void AppleUSBDeviceMux:XXXXXXXXXxTCPInput(mbuf_t) received reset, closing 0x<<<<<MEID>>>>>80
[13:44:46.0307] SYSLOG: Sep 22 13:38:32 localhost kernel[0] <Notice>: AppleUSBDeviceMuxXXXXXXXXXXXXXXXXXXXXt new session 0x<<<<<MEID>>>>>00 established 62078<-lo0->49159 62078<-usb->6656
[13:44:46.0307] SYSLOG: Sep 22 13:38:32 localhost kernel[0] <Notice>: void AppleUSBDeviceMux:XXXXXXXXXxTCPInput(mbuf_t) received reset, closing 0x<<<<<MEID>>>>>00
[13:44:46.0307] unable to read message size: -1
[13:44:46.0307] unable to read message size: -1
[13:44:46.0307] unable to read message size: -1
[13:44:46.0307] unable to read message size: -1
[13:44:46.0307] unable to read message size: -1
[13:44:46.0307] recv(17, 4) failed: connection closed
[13:44:46.0307] recv(18, 4) failed: connection closed
[13:44:46.0307] could not receive message
[13:44:46.0307] could not receive message
[13:44:46.0307] could not receive message
[13:44:46.0307] could not receive message
[13:44:46.0307] could not receive message
[13:44:46.0307] unable to read message size: -1
[13:44:46.0307] unable to read message size: -1
[13:44:46.0307] could not receive message
[13:44:46.0307] could not receive message
[13:44:46.0307] SYSLOG: Sep 22 13:38:32 localhost kernel[0] <Notice>: AppleUSBDeviceMuxXXXXXXXXXXXXXXXXXXXXt new session 0x<<<<<MEID>>>>>00 established 62078<-lo0->49160 62078<-usb->6912
[13:44:46.0307] SYSLOG: Sep 22 13:38:32 localhost kernel[0] <Notice>: void AppleUSBDeviceMux:XXXXXXXXXxTCPInput(mbuf_t) received reset, closing 0x<<<<<MEID>>>>>00
[13:44:46.0307] recv(11, 4) failed: connection closed
[13:44:46.0307] SYSLOG: Sep 22 13:38:32 localhost kernel[0] <Notice>: AppleUSBDeviceMuxXXXXXXXXXXXXXXXXXXXXt new session 0x<<<<<MEID>>>>>00 established 62078<-lo0->49161 62078<-usb->7168
[13:44:46.0307] SYSLOG: Sep 22 13:38:32 localhost kernel[0] <Notice>: void AppleUSBDeviceMux:XXXXXXXXXxTCPInput(mbuf_t) received reset, closing 0x<<<<<MEID>>>>>00
[13:44:46.0307] unable to read message size: -1
[13:44:46.0307] SYSLOG: Sep 22 13:38:32 localhost kernel[0] <Notice>: AppleUSBDeviceMuxXXXXXXXXXXXXXXXXXXXXt new session 0x<<<<<MEID>>>>>00 established 62078<-lo0->49162 62078<-usb->7424
[13:44:46.0307] recv(12, 4) failed: connection closed
[13:44:46.0307] could not receive message
[13:44:46.0307] unrecognized key 'BootArgs' in value query
[13:44:46.0307] unable to read message size: -1
[13:44:46.0307] failed to handle value query for key 'BootArgs', sending back empty response
[13:44:46.0307] SYSLOG: Sep 22 13:38:32 localhost kernel[0] <Notice>: void AppleUSBDeviceMux:XXXXXXXXXxTCPInput(mbuf_t) received reset, closing 0x<<<<<MEID>>>>>00
[13:44:46.0307] SYSLOG: Sep 22 13:38:32 localhost kernel[0] <Notice>: AppleUSBDeviceMuxXXXXXXXXXXXXXXXXXXXXt new session 0x<<<<<MEID>>>>>80 established 62078<-lo0->49163 62078<-usb->7680
[13:44:46.0307] could not receive message
[13:44:46.0307] recv(13, 4) failed: connection closed
[13:44:46.0307] unrecognized key 'MarketingPartNumber' in value query
[13:44:46.0307] unable to read message size: -1
[13:44:46.0307] failed to handle value query for key 'MarketingPartNumber', sending back empty response
[13:44:46.0307] SYSLOG: Sep 22 13:38:32 localhost kernel[0] <Notice>: void AppleUSBDeviceMux:XXXXXXXXXxTCPInput(mbuf_t) received reset, closing 0x<<<<<MEID>>>>>80
[13:44:46.0307] could not receive message
[13:44:46.0307] recv(11, 4) failed: connection closed
[13:44:46.0307] unable to read message size: -1
[13:44:46.0307] could not receive message
[13:44:46.0307] SYSLOG: Sep 22 13:38:32 localhost kernel[0] <Notice>: AppleUSBDeviceMuxXXXXXXXXXXXXXXXXXXXXt new session 0x<<<<<MEID>>>>>00 established 62078<-lo0->49164 62078<-usb->7936
[13:44:46.0307] SYSLOG: Sep 22 13:38:32 localhost kernel[0] <Notice>: void AppleUSBDeviceMux:XXXXXXXXXxTCPInput(mbuf_t) received reset, closing 0x<<<<<MEID>>>>>00
[13:44:46.0307] SYSLOG: Sep 22 13:38:32 localhost kernel[0] <Notice>: AppleUSBDeviceMuxXXXXXXXXXXXXXXXXXXXXt new session 0x<<<<<MEID>>>>>00 established 1082<-lo0->49165 1082<-usb->8192
[13:44:46.0307] recv(11, 4) failed: connection closed
[13:44:46.0307] unable to read message size: -1
[13:44:46.0307] could not receive message
[13:44:46.0307] client protocol version 13
[13:44:46.0307] *** UUID AF9D6BDF-62B0-A247-B44C-679E6E6E6075 ***
[13:44:46.0307] Restore options:
[13:44:46.0307] MinimumSystemPartition => <CFNumber 0x<<<<<MEID>>>>>53 [0x1005e3fa0]>{value = +2645, type = kCFNumberSInt64Type}
[13:44:46.0307] UUID => <CFString 0x135d0ad80 [0x1005e3fa0]>{contents = "AF9D6BDF-62B0-A247-B44C-679E6E6E6075"}
[13:44:46.0307] SystemPartitionSize => <CFNumber 0x<<<<<MEID>>>>>53 [0x1005e3fa0]>{value = +2645, type = kCFNumberSInt64Type}
[13:44:46.0307] SystemPartitionPadding => <CFBasicHash 0x135d0a7b0 [0x1005e3fa0]>{type = mutable dict, count = 9,
[13:44:46.0307] entries =>
[13:44:46.0307] 0 : <CFString 0x135d0abc0 [0x1005e3fa0]>{contents = "512"} = <CFNumber 0xb<<<<<IMEI>>>>>> [0x1005e3fa0]>{value = +1280, type = kCFNumberSInt64Type}
[13:44:46.0307] 2 : <CFString 0x135d0b6f0 [0x1005e3fa0]>{contents = "128"} = <CFNumber 0xb<<<<<IMEI>>>>>> [0x1005e3fa0]>{value = +1280, type = kCFNumberSInt64Type}
[13:44:46.0307] 3 : <CFString 0x135d0a900 [0x1005e3fa0]>{contents = "16"} = <CFNumber 0xb<<<<<IMEI>>>>>> [0x1005e3fa0]>{value = +260, type = kCFNumberSInt64Type}
[13:44:46.0307] 4 : <CFString 0x135d0b730 [0x1005e3fa0]>{contents = "1024"} = <CFNumber 0xb<<<<<IMEI>>>>>> [0x1005e3fa0]>{value = +1280, type = kCFNumberSInt64Type}
[13:44:46.0307] 5 : <CFString 0x135d04c50 [0x1005e3fa0]>{contents = "32"} = <CFNumber 0xb<<<<<IMEI>>>>>> [0x1005e3fa0]>{value = +320, type = kCFNumberSInt64Type}
[13:44:46.0307] 6 : <CFString 0x135d0ad20 [0x1005e3fa0]>{contents = "768"} = <CFNumber 0xb<<<<<IMEI>>>>>> [0x1005e3fa0]>{value = +1280, type = kCFNumberSInt64Type}
[13:44:46.0307] 7 : <CFString 0x135d0b420 [0x1005e3fa0]>{cont...
[13:44:46.0307] entering bootstrap_hoover
[13:44:46.0307] bootstrap_hoover: using factory firmware
[13:44:46.0307] bootstrap_hoover: hoover failed to bootstrap XXXXXXXXX5
[13:44:46.0307] entering load_sep_os
[13:44:46.0307] device has sep - getting firmware
[13:44:46.0307] entering copy_restore_sep
[13:44:46.0307] got sep firmware - making call to load it
[13:44:46.0307] entering ramrod_load_sep_os
[13:44:46.0307] entering ramrod_execute_command_with_input_data: /usr/libexec/seputil (0x104468000 - 4383773)
[13:44:46.0307] executing /usr/libexec/seputil
[13:44:46.0307] waiting for child to exit
[13:44:46.0307] child exited
[13:44:46.0307] exit status: 0
[13:44:46.0307] entering ramrod_ticket_update
[13:44:46.0307] looking up boot manifest hash
[13:44:46.0307] device tree ticket-hash: <CFData 0x135e15130 [0x1005e3fa0]>{length = 20, capacity = 20, bytes = 0x<<<<<<<<<<<<<<<<<<UDID>>>>>>>>>>>>>>>>>>}
[13:44:46.0307] ticket_hash: <<<<<<<<<<<<<<<<<<UDID>>>>>>>>>>>>>>>>>>
[13:44:46.0307] received valid ticket (4991 bytes)
[13:44:46.0307] entering partition_nand_device
[13:44:46.0307] No IOFlashController instance found
[13:44:46.0307] entering wait_for_storage_device
[13:44:46.0307] Searching for NAND service
[13:44:46.0307] Found NAND service: ASPStorage
[13:44:46.0307] NAND initialized. Waiting for devnode.
[13:44:46.0307] entering clear_remap_variable
[13:44:46.0307] executing /usr/sbin/nvram
[13:44:46.0307] entering ramrod_probe_media
[13:44:46.0307] device partitioning scheme is GPT
[13:44:46.0307] find_filesystem_partitions: storage=/dev/disk0s1 system=/dev/disk0s1s1 data=/dev/disk0s1s2 baseband data= log=
[13:44:46.0307] executing /sbin/fsck_hfs
[13:44:46.0307] SYSLOG: Sep 22 13:38:35 localhost kernel[0] <Notice>: ASPStorageXXXXXXXXXXXXXXXXXXXXdisk - Root device is md0
[13:44:46.0307] SYSLOG: Sep 22 13:38:35 localhost kernel[0] <Notice>: ART: 30 48 02 01 00 30 21 02 03 02 85 b5 04 14 e5 4c 69 28 c9 bf 82 94 f4 9f 78 49 e0 c9 c9 b6 09 4f 65 b8 04 00 04 00 31 00 04 20 de 20 98 34 67 f7 c3 57 c6 18 0d 80 42 80 f3 f5 61 92 35 0e a2 b4 6b 3c 30 9d 2f c8 ab 29 4f fa
[13:44:46.0307] ** /dev/rdisk0s1s1
[13:44:46.0307] Executing fsck_hfs (version hfs-286.30.1).
[13:44:46.0307] ** Checking Journaled HFS Plus volume.
[13:44:46.0307] ** Detected a caseXXXXXXXXXe volume.
[13:44:46.0307] The volume name is Monarch13A344.N53OS
[13:44:46.0307] ** Checking extents overflow file.
[13:44:46.0307] ** Checking catalog file.
[13:44:46.0307] ** Checking multi-linked files.
[13:44:46.0307] ** Checking catalog hierarchy.
[13:44:46.0307] ** Checking extended attributes file.
[13:44:46.0307] ** Checking volume bitmap.
[13:44:46.0307] ** Checking volume information.
[13:44:46.0307] ** Trimming unused blocks.
[13:44:46.0307] ** The volume Monarch13A344.N53OS appears to be OK.
[13:44:46.0307] executing /sbin/mount_hfs
[13:44:46.0307] /dev/disk0s1s1 mounted on /mnt1
[13:44:46.0307] restored_fdr_initialize returned false
[13:44:46.0307] RestoredFDRCreate() returned 0
[13:44:46.0307] FDR is not supported on this device
[13:44:46.0307] RestoredFDRSaveData: restoredFDR is NULL, not able to preserve FDR data.
[13:44:46.0307] RestoredFDRSaveData success
[13:44:46.0307] entering check_for_restore_log
[13:44:46.0307] found restore log (size = 44017)
[13:44:46.0307] executing /sbin/fsck_hfs
[13:44:46.0307] ** /dev/rdisk0s1s2
[13:44:46.0307] Executing fsck_hfs (version hfs-286.30.1).
[13:44:46.0307] ** Checking Journaled HFS Plus volume.
[13:44:46.0307] ** Detected a caseXXXXXXXXXe volume.
[13:44:46.0307] The volume name is Data
[13:44:46.0307] ** Checking extents overflow file.
[13:44:46.0307] ** Checking catalog file.
[13:44:46.0307] ** Checking multi-linked files.
[13:44:46.0307] ** Checking catalog hierarchy.
[13:44:46.0307] ** Checking extended attributes file.
[13:44:46.0307] ** Checking volume bitmap.
[13:44:46.0307] ** Checking volume information.
[13:44:46.0307] ** Trimming unused blocks.
[13:44:46.0307] ** The volume Data appears to be OK.
[13:44:46.0307] executing /sbin/mount_hfs
[13:44:46.0307] mount_hfs: Could not exec re-keying daemon /usr/libexec/rolld: No such file or directory
[13:44:46.0307] /dev/disk0s1s2 mounted on /mnt2
[13:44:46.0307] entering dump_panic_logs
[13:44:46.0307] executing /System/Library/CoreServices/DumpPanic
[13:44:46.0307] SYSLOG: Sep 22 13:38:43 localhost kernel[0] <Notice>: [ANS syslog: nand] Util_HostXXXXXXXXXng to read element=PANICLOG not yet written, returning ERR_ABORT
[13:44:46.0307] SYSLOG: Sep 22 13:38:43 localhost kernel[0] <Notice>: disk3: invalid argument.
[13:44:46.0307] SYSLOG: Sep 22 13:38:43 localhost DumpPanic[16] <Error>: Unexpected read result (<<<<<<<<ICCID>>>>>>> of 524288 bytes) of panic data (/dev/rdisk3): errno 22
[13:44:46.0307] entering check_for_ota_logs_with_mount_point
[13:44:46.0307] restore log does not exist
[13:44:46.0307] skipping log submission, failed to read user settings from: /mnt2/mobile/Library/ConfigurationProfiles/EffectiveUserSettings.plist
[13:44:46.0307] Diagnostic log submission disabled
[13:44:46.0307] Searching /mnt2/mobile/Library/Logs/CrashReporter/
[13:44:46.0307] check_for_ota_logs_with_mount_point complete
[13:44:46.0307] Successfully checked for OTA logs
[13:44:46.0307] entering unmount_filesystems
[13:44:46.0307] create_baseband_update_options: Got imeisv: 11
[13:44:46.0307] baseband updater options = <CFBasicHash 0x135d0d5d0 [0x1005e3fa0]>{type = mutable dict, count = 3,
[13:44:46.0307] entries =>
[13:44:46.0307] 0 : <CFString 0x100f55420 [0x1005e3fa0]>{contents = "autoSetupEnv"} = <CFBoolean 0x1005e4350 [0x1005e3fa0]>{value = false}
[13:44:46.0307] 1 : <CFString 0x100f55440 [0x1005e3fa0]>{contents = "disablePing"} = <CFBoolean 0x1005e4340 [0x1005e3fa0]>{value = true}
[13:44:46.0307] 2 : <CFString 0x100f55300 [0x1005e3fa0]>{contents = "IMEISwVersion"} = <CFNumber 0x<<<<<MEID>>>>>b2 [0x1005e3fa0]>{value = +11, type = kCFNumberSInt32Type}
[13:44:46.0307] }
[13:44:46.0307] _baseband_update_requires_filesystems_once: querying baseband to determine if it requires system filesystem
[13:44:46.0307] bbupdater: cmdCopyRequirePartitionMount: supports flashless 1
[13:44:46.0307] bbupdater: cmdCopyRequirePartitionMount: supports REFS 0
[13:44:46.0307] bbupdater: cmdCopyRequirePartitionMount: need data partition for coredumps
[13:44:46.0307] _baseband_update_requires_filesystems_once: query returned <CFBasicHash 0x135d0d6f0 [0x1005e3fa0]>{type = mutable dict, count = 3,
[13:44:46.0307] entries =>
[13:44:46.0307] 0 : <CFString 0x100f54da0 [0x1005e3fa0]>{contents = "requireUserPartitionMount"} = <CFBoolean 0x1005e4340 [0x1005e3fa0]>{value = true}
[13:44:46.0307] 1 : <CFString 0x100f54dc0 [0x1005e3fa0]>{contents = "requestedBasebandFSPartitionMountSize"} = <CFNumber 0xb<<<<<IMEI>>>>>> [0x1005e3fa0]>{value = +0, type = kCFNumberSInt64Type}
[13:44:46.0307] 2 : <CFString 0x100f54d60 [0x1005e3fa0]>{contents = "requireSystemPartitionMount"} = <CFBoolean 0x1005e4340 [0x1005e3fa0]>{value = true}
[13:44:46.0307] }
[13:44:46.0307] entering clean_NAND
[13:44:46.0307] SYSLOG: Sep 22 13:38:43 localhost kernel[0] <Notice>: [ANS syslog: nand] Format_Send_Unmap_AllXXXXXXXXXg All LBAs
[13:44:46.0307] SYSLOG: Sep 22 13:38:44 localhost kernel[0] <Notice>: [ANS syslog: nand] Push_PowerGovernorInit:Nand Die:2 MLC: 2 No SLC: 2 No Erase:2
[13:44:46.0307] SYSLOG: Sep 22 13:38:44 localhost kernel[0] <Notice>: [ANS syslog: nand] Format_UserArea:*** FORMATTING ***
[13:44:46.0307] SYSLOG: Sep 22 13:38:44 localhost kernel[0] <Notice>: [ANS syslog: nand] Format_UserArea: indMemoryInHeap: 4096 KB
[13:44:46.0307] SYSLOG: Sep 22 13:38:44 localhost kernel[0] <Notice>: ASPStorage:XXXXXXXXXeometry - NAND Geometry info:
[13:44:46.0307] SYSLOG: Sep 22 13:38:44 localhost kernel[0] <Notice>: ASPStorage:XXXXXXXXXeometry - Num LBAs : 3906250
[13:44:46.0307] SYSLOG: Sep 22 13:38:44 localhost kernel[0] <Notice>: ASPStorage:XXXXXXXXXeometry - Bytes per LBA : 4096
[13:44:46.0307] SYSLOG: Sep 22 13:38:44 localhost kernel[0] <Notice>: ASPStorage:XXXXXXXXXeometry - Preferred buffer size: 65536
[13:44:46.0307] SYSLOG: Sep 22 13:38:44 localhost kernel[0] <Notice>: ASPStorage:XXXXXXXXXeometry - lbaFormatted : YES
[13:44:46.0307] SYSLOG: Sep 22 13:38:44 localhost kernel[0] <Notice>: ASPStorage:XXXXXXXXXeometry - utilFormatted : YES
[13:44:46.0307] NAND format complete
[13:44:46.0307] entering ramrod_probe_media
[13:44:46.0307] find_filesystem_partitions: storage=/dev/disk0 system= data= baseband data= log=
[13:44:46.0307] entering format_effaceable_storage
[13:44:46.0307] effaceable storage is formatted, clearing it
[13:44:46.0307] effaceable storaged cleared
[13:44:46.0307] entering format_storage_for_LwVM
[13:44:46.0307] no-lwvm-offset-mgmt property not found
[13:44:46.0307] entering ramrod_probe_media
[13:44:46.0307] device partitioning scheme is GPT
[13:44:46.0307] unexpected partition 'LwVM' - skipping
[13:44:46.0307] find_filesystem_partitions: storage=/dev/disk0s1 system= data= baseband data= log=
[13:44:46.0307] entering create_filesystem_partitions
[13:44:46.0307] User specified system partition size, skipping firmware extras size.
[13:44:46.0307] system partition padding size is: 272629760 bytes
[13:44:46.0307] unable to open : No such file or directory
[13:44:46.0307] creating 2 partitions
[13:44:46.0307] creating encrypted data partition
[13:44:46.0307] entering ramrod_probe_media
[13:44:46.0307] device partitioning scheme is GPT
[13:44:46.0307] find_filesystem_partitions: storage=/dev/disk0s1 system=/dev/disk0s1s1 data=/dev/disk0s1s2 baseband data= log=
[13:44:46.0307] wipe entire partition: 1 (old = 0 new = 2905)
[13:44:46.0307] block size for /dev/disk0s1s1: 4096
[13:44:46.0307] /sbin/newfs_hfs -s -v System -J /dev/disk0s1s1
[13:44:46.0307] executing /sbin/newfs_hfs -s -v System -J /dev/disk0s1s1
[13:44:46.0307] Initialized /dev/rdisk0s1s1 as a 3 GB caseXXXXXXXXXe HFS Plus volume with a 8192k journal
[13:44:46.0307] block size for /dev/disk0s1s2: 4096
[13:44:46.0307] /sbin/newfs_hfs -s -v Data -J -P /dev/disk0s1s2
[13:44:46.0307] executing /sbin/newfs_hfs -s -v Data -J -P /dev/disk0s1s2
[13:44:46.0307] Initialized /dev/rdisk0s1s2 as a 12 GB caseXXXXXXXXXe HFS Plus volume with a 8192k journal
[13:44:46.0307] entering ramrod_probe_media
[13:44:46.0307] device partitioning scheme is GPT
[13:44:46.0307] find_filesystem_partitions: storage=/dev/disk0s1 system=/dev/disk0s1s1 data=/dev/disk0s1s2 baseband data= log=
[13:44:46.0307] entering mount_filesystems
[13:44:46.0307] executing /sbin/fsck_hfs
[13:44:46.0307] ** /dev/rdisk0s1s1
[13:44:46.0307] Executing fsck_hfs (version hfs-286.30.1).
[13:44:46.0307] ** Checking Journaled HFS Plus volume.
[13:44:46.0307] ** Detected a caseXXXXXXXXXe volume.
[13:44:46.0307] The volume name is System
[13:44:46.0307] ** Checking extents overflow file.
[13:44:46.0307] ** Checking catalog file.
[13:44:46.0307] ** Checking multi-linked files.
[13:44:46.0307] ** Checking catalog hierarchy.
[13:44:46.0307] ** Checking extended attributes file.
[13:44:46.0307] ** Checking volume bitmap.
[13:44:46.0307] ** Checking volume information.
[13:44:46.0307] ** Trimming unused blocks.
[13:44:46.0307] ** The volume System appears to be OK.
[13:44:46.0307] executing /sbin/mount_hfs
[13:44:46.0307] /dev/disk0s1s1 mounted on /mnt1
[13:44:46.0307] executing /sbin/fsck_hfs
[13:44:46.0307] ** /dev/rdisk0s1s2
[13:44:46.0307] Executing fsck_hfs (version hfs-286.30.1).
[13:44:46.0307] ** Checking Journaled HFS Plus volume.
[13:44:46.0307] ** Detected a caseXXXXXXXXXe volume.
[13:44:46.0307] The volume name is Data
[13:44:46.0307] ** Checking extents overflow file.
[13:44:46.0307] ** Checking catalog file.
[13:44:46.0307] ** Checking multi-linked files.
[13:44:46.0307] ** Checking catalog hierarchy.
[13:44:46.0307] ** Checking extended attributes file.
[13:44:46.0307] ** Checking volume bitmap.
[13:44:46.0307] ** Checking volume information.
[13:44:46.0307] ** Trimming unused blocks.
[13:44:46.0307] ** The volume Data appears to be OK.
[13:44:46.0307] executing /sbin/mount_hfs
[13:44:46.0307] mount_hfs: Could not exec re-keying daemon /usr/libexec/rolld: No such file or directory
[13:44:46.0307] /dev/disk0s1s2 mounted on /mnt2
[13:44:46.0307] entering resize_system_partition_to_options
[13:44:46.0307] User specified system partition size, skipping firmware extras size.
[13:44:46.0307] Found SystemPartitionPadding value of 272629760 bytes
[13:44:46.0307] Erasing system partition prior to resize operation.
[13:44:46.0307] block size for /dev/disk0s1s1: 4096
[13:44:46.0307] /sbin/newfs_hfs -s -v System -J /dev/disk0s1s1
[13:44:46.0307] executing /sbin/newfs_hfs -s -v System -J /dev/disk0s1s1
[13:44:46.0307] Initialized /dev/rdisk0s1s1 as a 3 GB caseXXXXXXXXXe HFS Plus volume with a 8192k journal
[13:44:46.0307] executing /sbin/fsck_hfs
[13:44:46.0307] ** /dev/rdisk0s1s1
[13:44:46.0307] Executing fsck_hfs (version hfs-286.30.1).
[13:44:46.0307] ** Checking Journaled HFS Plus volume.
[13:44:46.0307] ** Detected a caseXXXXXXXXXe volume.
[13:44:46.0307] The volume name is System
[13:44:46.0307] ** Checking extents overflow file.
[13:44:46.0307] ** Checking catalog file.
[13:44:46.0307] ** Checking multi-linked files.
[13:44:46.0307] ** Checking catalog hierarchy.
[13:44:46.0307] ** Checking extended attributes file.
[13:44:46.0307] ** Checking volume bitmap.
[13:44:46.0307] ** Checking volume information.
[13:44:46.0307] ** Trimming unused blocks.
[13:44:46.0307] ** The volume System appears to be OK.
[13:44:46.0307] executing /sbin/mount_hfs
[13:44:46.0307] /dev/disk0s1s1 mounted on /mnt1
[13:44:46.0307] Trying to resize system partition to 3046113280 bytes aka 2905 MB
[13:44:46.0307] entering adjust_partition_preflight
[13:44:46.0307] partition:0 requiredSize=743680
[13:44:46.0307] no change in size
[13:44:46.0307] Successfully resized the system partition
[13:44:46.0307] entering maximize_data_partition
[13:44:46.0307] entering adjust_partition_preflight
[13:44:46.0307] partition:1 requiredSize=<<<<<IMEI>>>>>>6
[13:44:46.0307] maximizing data partition to 12808355839 bytes
[13:44:46.0307] entering adjust_partition_preflight
[13:44:46.0307] partition:1 requiredSize=3127040
[13:44:46.0307] no change in size
[13:44:46.0307] Successfully resized data partition to consume free blocks
[13:44:46.0307] The system partition now has a total HFS+ capacity of 2905 MB
[13:44:46.0307] entering ramrod_probe_media
[13:44:46.0307] device partitioning scheme is GPT
[13:44:46.0307] find_filesystem_partitions: storage=/dev/disk0s1 system=/dev/disk0s1s1 data=/dev/disk0s1s2 baseband data= log=
[13:44:46.0307] entering unmount_filesystems
[13:44:46.0307] entering restore_images
[13:44:46.0307] Successfully marked device node /dev/rdisk0s1s1 as static data
[13:44:46.0307] executing /usr/sbin/asr -source asr://localhost:12345 -target /dev/disk0s1s1 XXXXXXXXXLOG: Sep 22 13:38:50 localhost kernel[0] <Notice>: void AppleUSBDeviceMuxXXXXXXXXXXXXXXXXXXXXt(struct BulkUSBMuxSession *, errno_t) new session to port 12345 failed: 61
[13:44:46.0307] XXXXXXXXX -XXXXXXXXXcksum -XXXXXXXXXrings
[13:44:46.0307] SYSLOG: Sep 22 13:38:50 localhost asr[29] <Error>: bootstrap_look_up2 failed with 0x44e
[13:44:46.0307] ASR: asr: Unable to disable idle sleep - XXXXXXXXX9
[13:44:46.0307] ASR STATUS: start 242.6 multicast-client
[13:44:46.0307] ASR: Waiting for connection attempt from server
[13:44:46.0307] SYSLOG: Sep 22 13:38:50 localhost asr[29] <Error>: __net_helper_get_connection_block_invoke_3 could not connect to networkd
[13:44:46.0307] SYSLOG: Sep 22 13:39:00 localhost kernel[0] <Notice>: AppleUSBDeviceMuxXXXXXXXXXXXXXXXXXXXXt new session 0x<<<<<MEID>>>>>00 established 12345<-lo0->49168 12345<-usb->8704
[13:44:46.0307] ASR STATUS: setup
[13:44:46.0307] ASR: Validating target...done
[13:44:46.0307] ASR STATUS: metadata
[13:44:46.0307] ASR: Validating source...
[13:44:46.0307] ASR: done
[13:44:46.0307] ASR: Retrieving scan information...
[13:44:46.0307] ASR: done
[13:44:46.0307] ASR: Validating sizes...
[13:44:46.0307] ASR: done
[13:44:46.0307] ASR STATUS: restore
[13:44:46.0307] ASR RESTORE PROGRESS: 2%
[13:44:46.0307] ASR RESTORE PROGRESS: 4%
[13:44:46.0307] ASR RESTORE PROGRESS: 6%
[13:44:46.0307] ASR RESTORE PROGRESS: 8%
[13:44:46.0307] ASR RESTORE PROGRESS: 10%
[13:44:46.0307] ASR RESTORE PROGRESS: 12%
[13:44:46.0307] ASR RESTORE PROGRESS: 14%
[13:44:46.0307] ASR RESTORE PROGRESS: 16%
[13:44:46.0307] ASR RESTORE PROGRESS: 18%
[13:44:46.0307] ASR RESTORE PROGRESS: 20%
[13:44:46.0307] ASR RESTORE PROGRESS: 22%
[13:44:46.0307] ASR RESTORE PROGRESS: 24%
[13:44:46.0307] ASR RESTORE PROGRESS: 26%
[13:44:46.0307] ASR RESTORE PROGRESS: 28%
[13:44:46.0307] ASR RESTORE PROGRESS: 30%
[13:44:46.0307] ASR RESTORE PROGRESS: 32%
[13:44:46.0307] ASR RESTORE PROGRESS: 34%
[13:44:46.0307] ASR RESTORE PROGRESS: 36%
[13:44:46.0307] ASR RESTORE PROGRESS: 38%
[13:44:46.0307] ASR RESTORE PROGRESS: 40%
[13:44:46.0307] ASR RESTORE PROGRESS: 42%
[13:44:46.0307] ASR RESTORE PROGRESS: 44%
[13:44:46.0307] ASR RESTORE PROGRESS: 46%
[13:44:46.0307] ASR RESTORE PROGRESS: 48%
[13:44:46.0307] ASR RESTORE PROGRESS: 50%
[13:44:46.0307] ASR RESTORE PROGRESS: 52%
[13:44:46.0307] ASR RESTORE PROGRESS: 54%
[13:44:46.0307] ASR RESTORE PROGRESS: 56%
[13:44:46.0307] ASR RESTORE PROGRESS: 58%
[13:44:46.0307] ASR RESTORE PROGRESS: 60%
[13:44:46.0307] ASR RESTORE PROGRESS: 62%
[13:44:46.0307] ASR RESTORE PROGRESS: 64%
[13:44:46.0307] ASR RESTORE PROGRESS: 66%
[13:44:46.0307] ASR RESTORE PROGRESS: 68%
[13:44:46.0307] ASR RESTORE PROGRESS: 70%
[13:44:46.0307] ASR RESTORE PROGRESS: 72%
[13:44:46.0307] ASR RESTORE PROGRESS: 74%
[13:44:46.0307] ASR RESTORE PROGRESS: 76%
[13:44:46.0307] ASR RESTORE PROGRESS: 78%
[13:44:46.0307] ASR RESTORE PROGRESS: 80%
[13:44:46.0307] ASR RESTORE PROGRESS: 82%
[13:44:46.0307] ASR RESTORE PROGRESS: 84%
[13:44:46.0307] ASR RESTORE PROGRESS: 86%
[13:44:46.0307] ASR RESTORE PROGRESS: 88%
[13:44:46.0307] ASR RESTORE PROGRESS: 90%
[13:44:46.0307] ASR RESTORE PROGRESS: 92%
[13:44:46.0307] ASR RESTORE PROGRESS: 94%
[13:44:46.0307] ASR RESTORE PROGRESS: 96%
[13:44:46.0307] ASR RESTORE PROGRESS: 98%
[13:44:46.0307] SYSLOG: Sep 22 13:40:07 localhost asr[29] <Error>: CFPreferences could not connect to its daemon.
[13:44:46.0307] Preferences using the connection 0x0 will be volatile and will not be persisted to disk.
[13:44:46.0307] SYSLOG: Sep 22 13:40:07 localhost kernel[0] <Notice>: AppleUSBDeviceMux:XXXXXXXXXpcall socket is closed, session 0x<<<<<MEID>>>>>00 (12345<-lo0->49168 12345<-usb->8704)
[13:44:46.0307] SYSLOG: Sep 22 13:40:07 localhost asr[29] <Critical>: securityd_message_with_reply_sync Failed to talk to secd after 4 attempts.
[13:44:46.0307] SYSLOG: Sep 22 13:40:07 localhost asr[29] <Critical>: securityd_message_with_reply_sync Failed to talk to secd after 4 attempts.
[13:44:46.0307] SYSLOG: Sep 22 13:40:07 localhost asr[29] <Error>: SecTrustEvaluate
[13:44:46.0307] SYSLOG: Sep 22 13:40:07 localhost asr[29] <Critical>: securityd_message_with_reply_sync Failed to talk to secd after 4 attempts.
[13:44:46.0307] SYSLOG: Sep 22 13:40:07 localhost asr[29] <Critical>: securityd_message_with_reply_sync Failed to talk to secd after 4 attempts.
[13:44:46.0307] SYSLOG: Sep 22 13:40:07 localhost asr[29] <Error>: SecTrustEvaluate
[13:44:46.0307] ASR RESTORE PROGRESS: 100%
[13:44:46.0307] ASR: Copied 2770522624 bytes in 65.31 seconds, 41426.48 KiB/s
[13:44:46.0307] ASR STATUS: verify
[13:44:46.0307] ASR VERIFY PROGRESS: 2%
[13:44:46.0307] ASR VERIFY PROGRESS: 4%
[13:44:46.0307] ASR VERIFY PROGRESS: 6%
[13:44:46.0307] ASR VERIFY PROGRESS: 8%
[13:44:46.0307] ASR VERIFY PROGRESS: 10%
[13:44:46.0307] ASR VERIFY PROGRESS: 12%
[13:44:46.0307] ASR VERIFY PROGRESS: 14%
[13:44:46.0307] ASR VERIFY PROGRESS: 16%
[13:44:46.0307] ASR VERIFY PROGRESS: 18%
[13:44:46.0307] ASR VERIFY PROGRESS: 20%
[13:44:46.0307] ASR VERIFY PROGRESS: 22%
[13:44:46.0307] ASR VERIFY PROGRESS: 24%
[13:44:46.0307] ASR VERIFY PROGRESS: 26%
[13:44:46.0307] ASR VERIFY PROGRESS: 28%
[13:44:46.0307] ASR VERIFY PROGRESS: 30%
[13:44:46.0307] ASR VERIFY PROGRESS: 32%
[13:44:46.0307] ASR VERIFY PROGRESS: 34%
[13:44:46.0307] ASR VERIFY PROGRESS: 36%
[13:44:46.0307] ASR VERIFY PROGRESS: 38%
[13:44:46.0307] ASR VERIFY PROGRESS: 40%
[13:44:46.0307] ASR VERIFY PROGRESS: 42%
[13:44:46.0307] ASR VERIFY PROGRESS: 44%
[13:44:46.0307] ASR VERIFY PROGRESS: 46%
[13:44:46.0307] ASR VERIFY PROGRESS: 48%
[13:44:46.0307] ASR VERIFY PROGRESS: 50%
[13:44:46.0307] ASR VERIFY PROGRESS: 52%
[13:44:46.0307] ASR VERIFY PROGRESS: 54%
[13:44:46.0307] ASR VERIFY PROGRESS: 56%
[13:44:46.0307] ASR VERIFY PROGRESS: 58%
[13:44:46.0307] ASR VERIFY PROGRESS: 60%
[13:44:46.0307] ASR VERIFY PROGRESS: 62%
[13:44:46.0307] ASR VERIFY PROGRESS: 64%
[13:44:46.0307] ASR VERIFY PROGRESS: 66%
[13:44:46.0307] ASR VERIFY PROGRESS: 68%
[13:44:46.0307] ASR VERIFY PROGRESS: 70%
[13:44:46.0307] ASR VERIFY PROGRESS: 72%
[13:44:46.0307] ASR VERIFY PROGRESS: 74%
[13:44:46.0307] ASR VERIFY PROGRESS: 76%
[13:44:46.0307] ASR VERIFY PROGRESS: 78%
[13:44:46.0307] ASR VERIFY PROGRESS: 80%
[13:44:46.0307] ASR VERIFY PROGRESS: 82%
[13:44:46.0307] ASR VERIFY PROGRESS: 84%
[13:44:46.0307] ASR VERIFY PROGRESS: 86%
[13:44:46.0307] ASR VERIFY PROGRESS: 88%
[13:44:46.0307] ASR VERIFY PROGRESS: 90%
[13:44:46.0307] ASR VERIFY PROGRESS: 92%
[13:44:46.0307] ASR VERIFY PROGRESS: 94%
[13:44:46.0307] ASR VERIFY PROGRESS: 96%
[13:44:46.0307] ASR VERIFY PROGRESS: 98%
[13:44:46.0307] ASR VERIFY PROGRESS: 100%
[13:44:46.0307] ASR: Verified SHA-1 checksum 2770522624 bytes in 7.96 seconds, 339783.87 KiB/s
[13:44:46.0307] ASR STATUS: finish
[13:44:46.0307] entering ramrod_probe_media
[13:44:46.0307] device partitioning scheme is GPT
[13:44:46.0307] find_filesystem_partitions: storage=/dev/disk0s1 system=/dev/disk0s1s1 data=/dev/disk0s1s2 baseband data= log=
[13:44:46.0307] entering mount_filesystems
[13:44:46.0307] executing /sbin/fsck_hfs
[13:44:46.0307] ** /dev/rdisk0s1s1
[13:44:46.0307] Executing fsck_hfs (version hfs-286.30.1).
[13:44:46.0307] ** Checking Journaled HFS Plus volume.
[13:44:46.0307] ** Detected a caseXXXXXXXXXe volume.
[13:44:46.0307] The volume name is Donner12H321.N53OS
[13:44:46.0307] ** Checking extents overflow file.
[13:44:46.0307] ** Checking catalog file.
[13:44:46.0307] ** Checking multi-linked files.
[13:44:46.0307] ** Checking catalog hierarchy.
[13:44:46.0307] ** Checking extended attributes file.
[13:44:46.0307] ** Checking volume bitmap.
[13:44:46.0307] ** Checking volume information.
[13:44:46.0307] ** Trimming unused blocks.
[13:44:46.0307] ** The volume Donner12H321.N53OS appears to be OK.
[13:44:46.0307] executing /sbin/mount_hfs
[13:44:46.0307] /dev/disk0s1s1 mounted on /mnt1
[13:44:46.0307] executing /sbin/fsck_hfs
[13:44:46.0307] ** /dev/rdisk0s1s2
[13:44:46.0307] Executing fsck_hfs (version hfs-286.30.1).
[13:44:46.0307] ** Checking Journaled HFS Plus volume.
[13:44:46.0307] ** Detected a caseXXXXXXXXXe volume.
[13:44:46.0307] The volume name is Data
[13:44:46.0307] ** Checking extents overflow file.
[13:44:46.0307] ** Checking catalog file.
[13:44:46.0307] ** Checking multi-linked files.
[13:44:46.0307] ** Checking catalog hierarchy.
[13:44:46.0307] ** Checking extended attributes file.
[13:44:46.0307] ** Checking volume bitmap.
[13:44:46.0307] ** Checking volume information.
[13:44:46.0307] ** Trimming unused blocks.
[13:44:46.0307] ** The volume Data appears to be OK.
[13:44:46.0307] executing /sbin/mount_hfs
[13:44:46.0307] mount_hfs: Could not exec re-keying daemon /usr/libexec/rolld: No such file or directory
[13:44:46.0307] /dev/disk0s1s2 mounted on /mnt2
[13:44:46.0307] RestoredFDRRestoreSavedData success
[13:44:46.0307] entering install_kernel_cache
[13:44:46.0307] writing kernelcache to /mnt1/System/Library/Caches/com.apple.kernelcaches/kernelcache
[13:44:46.0307] entering install_secure_vault_daemon
[13:44:46.0307] entering get_hardware_platform
[13:44:46.0307] platform-name = s5l8960x
[13:44:46.0307] linking /mnt1/usr/sbin/securekeyvaultd to /mnt1/usr/sbin/securekeyvaultd.s5l8960x
[13:44:46.0307] no securekeyvaultd for s5l8960x
[13:44:46.0307] entering ramrod_ticket_write
[13:44:46.0307] writing ticket to /mnt1/System/Library/Caches/apticket.der
[13:44:46.0307] entering RestoredFDRRecover
[13:44:46.0307] entering update_device_firmware
[13:44:46.0307] entering add_baseband_partition_options
[13:44:46.0307] entering ramrod_update_device_firmware
[13:44:46.0307] entering update_iBoot
[13:44:46.0307] entering copy_sep
[13:44:46.0307] found 'ASPStorage' object in IORegistry
[13:44:46.0307] entering update_iBoot_ASP_storage
[13:44:46.0307] entering wait_for_device: '/dev/disk1'
[13:44:46.0307] entering wait_for_device: '/dev/disk2'
[13:44:46.0307] writing 10 images to Firmware node '/dev/disk1' (preferred_block_size = 4096)
[13:44:46.0307] original data length: 644140; img4_restore_data length: 644177
[13:44:46.0307] write_data_to_fd: length=644177, preferred_block_size=4096
[13:44:46.0307] SYSLOG: Sep 22 13:40:23 localhost kernel[0] <Notice>: [ANS syslog: nand] Util_Host:element=FW written size=1101824, host request trimmed to end of written content
[13:44:46.0307] original data length: 6894; img4_restore_data length: 6931
[13:44:46.0307] write_data_to_fd: length=6931, preferred_block_size=4096
[13:44:46.0307] original data length: 152826; img4_restore_data length: 152863
[13:44:46.0307] write_data_to_fd: length=152863, preferred_block_size=4096
[13:44:46.0307] original data length: 8798; img4_restore_data length: 8835
[13:44:46.0307] write_data_to_fd: length=8835, preferred_block_size=4096
[13:44:46.0307] original data length: 14574; img4_restore_data length: 14611
[13:44:46.0307] write_data_to_fd: length=14611, preferred_block_size=4096
[13:44:46.0307] original data length: 48462; img4_restore_data length: 48499
[13:44:46.0307] write_data_to_fd: length=48499, preferred_block_size=4096
[13:44:46.0307] original data length: 88913; img4_restore_data length: 88950
[13:44:46.0307] write_data_to_fd: length=88950, preferred_block_size=4096
[13:44:46.0307] original data length: 39854; img4_restore_data length: 39891
[13:44:46.0307] write_data_to_fd: length=39891, preferred_block_size=4096
[13:44:46.0307] original data length: 11662; img4_restore_data length: 11699
[13:44:46.0307] write_data_to_fd: length=11699, preferred_block_size=4096
[13:44:46.0307] original data length: 78897; img4_restore_data length: 78934
[13:44:46.0307] write_data_to_fd: length=78934, preferred_block_size=4096
[13:44:46.0307] done with flash images - writing end of contents
[13:44:46.0307] write_data_to_fd: length=2, preferred_block_size=4096
[13:44:46.0307] SYSLOG: Sep 22 13:40:24 localhost kernel[0] <Notice>: [ANS syslog: nand] Util_FW_Host_Resize:---fwSize size 269 bytes
[13:44:46.0307] SYSLOG: Sep 22 13:40:24 localhost kernel[0] <Notice>: [ANS syslog: nand] Util_FW:[ 2, 3, 0] Wrote Firmware B with err=NO_ERROR
[13:44:46.0307] SYSLOG: Sep 22 13:40:24 localhost kernel[0] <Notice>: [ANS syslog: nand] Util_FW:[ 1, 1, 0] Wrote Firmware A with err=NO_ERROR
[13:44:46.0307] writing 1 boot images to boot block node '/dev/disk2' (preferred_block_size = 0x4096)
[13:44:46.0307] original data length: 160812; img4_restore_data length: 160849
[13:44:46.0307] write_data_to_fd: length=160849, preferred_block_size=4096
[13:44:46.0307] SYSLOG: Sep 22 13:40:24 localhost kernel[0] <Notice>: [ANS syslog: nand] Util_Host:element=LLB written size=167936, host request trimmed to end of written content
[13:44:46.0307] write_data_to_fd: length=2, preferred_block_size=4096
[13:44:46.0307] write_data_to_fd: length=3026, preferred_block_size=4096
[13:44:46.0307] done with boot images - writing end of contents
[13:44:46.0307] SYSLOG: Sep 22 13:40:24 localhost kernel[0] <Notice>: LwVM::probe - failed to read header from media
[13:44:46.0307] entering update_sep
[13:44:46.0307] writing sep firmware to /mnt1/usr/standalone/firmware/sepXXXXXXXXX.img4
[13:44:46.0307] write_data_to_fd: length=4383773, preferred_block_size=4096
[13:44:46.0307] update_sep returned: success
[13:44:46.0307] entering update_gas_gauge
[13:44:46.0307] entering update_ir_mcu
[13:44:46.0307] looking for mcu nub...no entry from path!
[13:44:46.0307] TiSerialFlasher not supported on this platform. Exiting.
[13:44:46.0307] entering update_baseband
[13:44:46.0307] update_baseband: registering for progress notifications
[13:44:46.0307] create_baseband_update_options: Got imeisv: 11
[13:44:46.0307] baseband updater options = <CFBasicHash 0x135d0bbe0 [0x1005e3fa0]>{type = mutable dict, count = 7,
[13:44:46.0307] entries =>
[13:44:46.0307] 2 : <CFString 0x100f55200 [0x1005e3fa0]>{contents = "SystemRoot"} = <CFString 0x135d11070 [0x1005e3fa0]>{contents = "/mnt1"}
[13:44:46.0307] 4 : <CFString 0x100f55120 [0x1005e3fa0]>{contents = "DisallowFusiing"} = <CFBoolean 0x1005e4340 [0x1005e3fa0]>{value = true}
[13:44:46.0307] 6 : <CFString 0x100f55420 [0x1005e3fa0]>{contents = "autoSetupEnv"} = <CFBoolean 0x1005e4350 [0x1005e3fa0]>{value = false}
[13:44:46.0307] 7 : <CFString 0x100f550c0 [0x1005e3fa0]>{contents = "forceUpdate"} = <CFBoolean 0x1005e4340 [0x1005e3fa0]>{value = true}
[13:44:46.0307] 8 : <CFString 0x100f55440 [0x1005e3fa0]>{contents = "disablePing"} = <CFBoolean 0x1005e4340 [0x1005e3fa0]>{value = true}
[13:44:46.0307] 11 : <CFString 0x100f55220 [0x1005e3fa0]>{contents = "DataRoot"} = <CFString 0x135d11110 [0x1005e3fa0]>{contents = "/mnt2"}
[13:44:46.0307] 12 : <CFString 0x100f55300 [0x1005e3fa0]>{contents = "IMEISwVersion"} = <CFNumber 0x<<<<<MEID>>>>>b2 [0x1005e3fa0]>{value = +11, type = kCFNumberSInt32Type}
[13:44:46.0307] }
[13:44:46.0307] update_baseband: querying baseband info
[13:44:46.0307] bbupdater: BEGIN: Querying info at stage first
[13:44:46.0307] bbupdater: BEGIN: Preparing first stage
[13:44:46.0307] bbupdater: Requested boot mode: kBBUBootModeNone
[13:44:46.0307] bbupdater: Creating transport, attempts remaining 5...bbupdater: OK
[13:44:46.0307] bbupdater: END: Preparing first stage
[13:44:46.0307] bbupdater: Connecting to Loader...bbupdater: OK
[13:44:46.0307] bbupdater: Getting Version...bbupdater: OK
[13:44:46.0307] bbupdater: Loader version: PBLXXXXXXXXX2.0
[13:44:46.0307] bbupdater: Fusing disallowed, will treat as fused
[13:44:46.0307] bbupdater: END: Querying info at stage first
[13:44:46.0307] update_baseband: query returned <CFBasicHash 0x135d12220 [0x1005e3fa0]>{type = mutable dict, count = 6,
[13:44:46.0307] entries =>
[13:44:46.0307] 0 : <CFString 0x100f554e0 [0x1005e3fa0]>{contents = "ChipID"} = <CFNumber 0x<<<<<MEID>>>>>13 [0x1005e3fa0]>{value = +7282913, type = kCFNumberSInt64Type}
[13:44:46.0307] 1 : <CFString 0x100f554c0 [0x1005e3fa0]>{contents = "ChipSerialNo" XXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXX XXXX
[13:44:46.0307] 2 : <CFString 0x100f55820 [0x1005e3fa0]>{contents = "CertID"} = <CFNumber 0x<<<<<MEID>>>>>23 [0x1005e3fa0]>{value = +3554301762, type = kCFNumberSInt64Type}
[13:44:46.0307] 3 : <CFString 0x100f55840 [0x1005e3fa0]>{contents = "VendorID"} = <CFNumber 0xb<<<<<IMEI>>>>>> [0x1005e3fa0]>{value = +3, type = kCFNumberSInt32Type}
[13:44:46.0307] 4 : <CFString 0x100f558e0 [0x1005e3fa0]>{contents = "FusingStatus"} = <CFNumber 0xb<<<<<IMEI>>>>>> [0x1005e3fa0]>{value = +3, type = kCFNumberSInt32Type}
[13:44:46.0307] 6 : <CFString 0x100f55540 [0x1005e3fa0]>{contents = "CertHash"} = <CFData 0x135d121c0 [0x1005e3fa0]>{length = 32, capacity = 32, bytes = 0x<<<<<<<<ICCID>>>>>>>924d38ecceff ... <<<<<MEID>>>>>18}
[13:44:46.0307] }
[13:44:46.0307] update_baseband: requesting baseband firmware data
[13:44:46.0307] update_baseband: received data from host (107673 bytes)
[13:44:46.0307] update_baseband: performing next update stage
[13:44:46.0307] bbupdater: BEGIN: Perform stage at first
[13:44:46.0307] bbupdater: Loading...
[13:44:46.0307] bbupdater: 0x2a008400 of 0x2a01d6f0 (28 percent)
[13:44:46.0307] bbupdater: 0x2a010800 of 0x2a01d6f0 (56 percent)
[13:44:46.0307] bbupdater: 0x2a018c00 of 0x2a01d6f0 (84 percent)
[13:44:46.0307] bbupdater: 0x2a01d6f0 of 0x2a01d6f0 (100 percent)
[13:44:46.0307] bbupdater:
[13:44:46.0307] bbupdater: Launching...bbupdater: OK
[13:44:46.0307] bbupdater: END: Perform stage at first
[13:44:46.0307] send_bbupdate_status: sending baseband update status to host
[13:44:46.0307] update_baseband: querying baseband info
[13:44:46.0307] bbupdater: BEGIN: Querying info at stage second
[13:44:46.0307] bbupdater: BEGIN: Preparing Second stage
[13:44:46.0307] bbupdater: ReXXXXXXXXXe transport for second stage.
[13:44:46.0307] bbupdater: END: Preparing Second stage
[13:44:46.0307] bbupdater: BEGIN: Gathering Personalization parameters...
[13:44:46.0307] bbupdater: Waiting for Hello...bbupdater: FAILED(kBBUReturnIOError)
[13:44:46.0307] bbupdater: END(kBBUReturnNAKHello): Gathering Personalization parameters...
[13:44:46.0307] bbupdater: END(kBBUReturnNAKHello): Querying info at stage second
[13:44:46.0307] bbupdater: core dump collection disabled
[13:44:46.0307] send_bbupdate_status: sending baseband update status to host
[13:44:46.0307] update_baseband: calling CFNotificationCenterRemoveEveryObserver
[13:44:46.0307] update_baseband: bbupdater error: The operation couldn\U2019t be completed. (BBUpdater error 47 - Failed gatherPersonalizationParameters in second stage)
[13:44:46.0307] Update[Baseband] error - The operation couldn\U2019t be completed. (RamrodErrorDomain error 1004 - update_baseband: failed querying baseband info)
[13:44:46.0307] Update[Baseband] failed - 0 retries remaining...
[13:44:46.0307] 0: RamrodErrorDomain/3ec: update_baseband: failed querying baseband info
[13:44:46.0307] 1: BBUpdater/2f: Failed gatherPersonalizationParameters in second stage
[13:44:46.0307] unable to convert ramrod error 1004
[13:44:46.0307] restore failed with CFError:
[13:44:46.0307] 0: AMRestoreErrorDomain/<<<<<MEID>>>>>ff: failed to update device firmware
[13:44:46.0307] 1: AMRestoreErrorDomain/<<<<<MEID>>>>>ff: ramrod firmware update failed
[13:44:46.0307] 2: RamrodErrorDomain/3ec: update_baseband: failed querying baseband info
[13:44:46.0307] 3: BBUpdater/2f: Failed gatherPersonalizationParameters in second stage
[13:44:46.0307] waiting for host to acknowledge final status received...
[13:44:46.0307] host received final status
[13:44:46.0307] attempting to dump restore log
[13:44:46.0307] writing log file: /mnt1/restore.log
[13:44:46.0307]
[13:44:46.0307] ==== end of previous restore log ====
[13:44:46.0309] <Restore Device 000000000836D2C0>: operation 29 progress -1
[13:44:46.0309] <Restore Device 000000000836D2C0>: operation 29 progress -1
[13:44:47.0151] <Restore Device 000000000836D2C0>: operation 11 progress -1
[13:44:47.0324] <Restore Device 000000000836D2C0>: operation 12 progress -1
[13:44:48.0302] <Restore Device 000000000836D2C0>: operation 12 progress -1
[13:44:49.0646] <Restore Device 000000000836D2C0>: operation 16 progress -1
[13:44:49.0994] <Restore Device 000000000836D2C0>: operation 16 progress -1
[13:44:50.0696] <Restore Device 000000000836D2C0>: operation 51 progress -1
[13:44:52.0115] <Restore Device 000000000836D2C0>: operation 29 progress -1
[13:44:52.0141] <Restore Device 000000000836D2C0>: operation 29 progress -1
[13:44:52.0175] <Restore Device 000000000836D2C0>: operation 13 progress 0
[13:45:02.0189] <Restore Device 000000000836D2C0>: operation 13 progress 1
[13:45:02.0189] ASR progress: Initialized communication with client
[13:45:03.0563] <Restore Device 000000000836D2C0>: operation 13 progress 5
[13:45:03.0563] ASR progress: Starting to send payload
[13:45:04.0327] <Restore Device 000000000836D2C0>: operation 13 progress 6
[13:45:04.0327] ASR progress: Sending payload
[13:45:04.0995] <Restore Device 000000000836D2C0>: operation 13 progress 7
[13:45:04.0995] ASR progress: Sending payload
[13:45:05.0654] <Restore Device 000000000836D2C0>: operation 13 progress 8
[13:45:05.0654] ASR progress: Sending payload
[13:45:06.0258] <Restore Device 000000000836D2C0>: operation 13 progress 9
[13:45:06.0258] ASR progress: Sending payload
[13:45:07.0185] <Restore Device 000000000836D2C0>: operation 13 progress 10
[13:45:07.0185] ASR progress: Sending payload
[13:45:07.0776] <Restore Device 000000000836D2C0>: operation 13 progress 11
[13:45:07.0776] ASR progress: Sending payload
[13:45:08.0415] <Restore Device 000000000836D2C0>: operation 13 progress 12
[13:45:08.0415] ASR progress: Sending payload
[13:45:09.0008] <Restore Device 000000000836D2C0>: operation 13 progress 13
[13:45:09.0008] ASR progress: Sending payload
[13:45:09.0656] <Restore Device 000000000836D2C0>: operation 13 progress 14
[13:45:09.0656] ASR progress: Sending payload
[13:45:10.0256] <Restore Device 000000000836D2C0>: operation 13 progress 15
[13:45:10.0256] ASR progress: Sending payload
[13:45:10.0851] <Restore Device 000000000836D2C0>: operation 13 progress 16
[13:45:10.0851] ASR progress: Sending payload
[13:45:11.0463] <Restore Device 000000000836D2C0>: operation 13 progress 17
[13:45:11.0463] ASR progress: Sending payload
[13:45:12.0082] <Restore Device 000000000836D2C0>: operation 13 progress 18
[13:45:12.0082] ASR progress: Sending payload
[13:45:12.0704] <Restore Device 000000000836D2C0>: operation 13 progress 19
[13:45:12.0704] ASR progress: Sending payload
[13:45:13.0311] <Restore Device 000000000836D2C0>: operation 13 progress 20
[13:45:13.0311] ASR progress: Sending payload
[13:45:13.0936] <Restore Device 000000000836D2C0>: operation 13 progress 21
[13:45:13.0936] ASR progress: Sending payload
[13:45:14.0525] <Restore Device 000000000836D2C0>: operation 13 progress 22
[13:45:14.0525] ASR progress: Sending payload
[13:45:15.0109] <Restore Device 000000000836D2C0>: operation 13 progress 23
[13:45:15.0109] ASR progress: Sending payload
[13:45:15.0824] <Restore Device 000000000836D2C0>: operation 13 progress 24
[13:45:15.0824] ASR progress: Sending payload
[13:45:16.0396] <Restore Device 000000000836D2C0>: operation 13 progress 25
[13:45:16.0396] ASR progress: Sending payload
[13:45:16.0976] <Restore Device 000000000836D2C0>: operation 13 progress 26
[13:45:16.0976] ASR progress: Sending payload
[13:45:17.0550] <Restore Device 000000000836D2C0>: operation 13 progress 27
[13:45:17.0550] ASR progress: Sending payload
[13:45:18.0143] <Restore Device 000000000836D2C0>: operation 13 progress 28
[13:45:18.0143] ASR progress: Sending payload
[13:45:18.0720] <Restore Device 000000000836D2C0>: operation 13 progress 29
[13:45:18.0720] ASR progress: Sending payload
[13:45:19.0307] <Restore Device 000000000836D2C0>: operation 13 progress 30
[13:45:19.0307] ASR progress: Sending payload
[13:45:19.0916] <Restore Device 000000000836D2C0>: operation 13 progress 31
[13:45:19.0916] ASR progress: Sending payload
[13:45:20.0584] <Restore Device 000000000836D2C0>: operation 13 progress 32
[13:45:20.0584] ASR progress: Sending payload
[13:45:21.0244] <Restore Device 000000000836D2C0>: operation 13 progress 33
[13:45:21.0244] ASR progress: Sending payload
[13:45:21.0846] <Restore Device 000000000836D2C0>: operation 13 progress 34
[13:45:21.0846] ASR progress: Sending payload
[13:45:22.0481] <Restore Device 000000000836D2C0>: operation 13 progress 35
[13:45:22.0481] ASR progress: Sending payload
[13:45:23.0077] <Restore Device 000000000836D2C0>: operation 13 progress 36
[13:45:23.0077] ASR progress: Sending payload
[13:45:23.0678] <Restore Device 000000000836D2C0>: operation 13 progress 37
[13:45:23.0678] ASR progress: Sending payload
[13:45:24.0305] <Restore Device 000000000836D2C0>: operation 13 progress 38
[13:45:24.0305] ASR progress: Sending payload
[13:45:24.0922] <Restore Device 000000000836D2C0>: operation 13 progress 39
[13:45:24.0922] ASR progress: Sending payload
[13:45:25.0524] <Restore Device 000000000836D2C0>: operation 13 progress 40
[13:45:25.0524] ASR progress: Sending payload
[13:45:26.0114] <Restore Device 000000000836D2C0>: operation 13 progress 41
[13:45:26.0117] ASR progress: Sending payload
[13:45:26.0705] <Restore Device 000000000836D2C0>: operation 13 progress 42
[13:45:26.0705] ASR progress: Sending payload
[13:45:27.0331] <Restore Device 000000000836D2C0>: operation 13 progress 43
[13:45:27.0331] ASR progress: Sending payload
[13:45:27.0908] <Restore Device 000000000836D2C0>: operation 13 progress 44
[13:45:27.0908] ASR progress: Sending payload
[13:45:28.0490] <Restore Device 000000000836D2C0>: operation 13 progress 45
[13:45:28.0490] ASR progress: Sending payload
[13:45:29.0139] <Restore Device 000000000836D2C0>: operation 13 progress 46
[13:45:29.0139] ASR progress: Sending payload
[13:45:29.0741] <Restore Device 000000000836D2C0>: operation 13 progress 47
[13:45:29.0741] ASR progress: Sending payload
[13:45:30.0374] <Restore Device 000000000836D2C0>: operation 13 progress 48
[13:45:30.0374] ASR progress: Sending payload
[13:45:30.0991] <Restore Device 000000000836D2C0>: operation 13 progress 49
[13:45:30.0991] ASR progress: Sending payload
[13:45:31.0641] <Restore Device 000000000836D2C0>: operation 13 progress 50
[13:45:31.0641] ASR progress: Sending payload
[13:45:32.0208] <Restore Device 000000000836D2C0>: operation 13 progress 51
[13:45:32.0208] ASR progress: Sending payload
[13:45:32.0811] <Restore Device 000000000836D2C0>: operation 13 progress 52
[13:45:32.0811] ASR progress: Sending payload
[13:45:33.0431] <Restore Device 000000000836D2C0>: operation 13 progress 53
[13:45:33.0431] ASR progress: Sending payload
[13:45:34.0048] <Restore Device 000000000836D2C0>: operation 13 progress 54
[13:45:34.0048] ASR progress: Sending payload
[13:45:34.0813] <Restore Device 000000000836D2C0>: operation 13 progress 55
[13:45:34.0813] ASR progress: Sending payload
[13:45:35.0385] <Restore Device 000000000836D2C0>: operation 13 progress 56
[13:45:35.0386] ASR progress: Sending payload
[13:45:35.0958] <Restore Device 000000000836D2C0>: operation 13 progress 57
[13:45:35.0958] ASR progress: Sending payload
[13:45:36.0563] <Restore Device 000000000836D2C0>: operation 13 progress 58
[13:45:36.0563] ASR progress: Sending payload
[13:45:37.0155] <Restore Device 000000000836D2C0>: operation 13 progress 59
[13:45:37.0156] ASR progress: Sending payload
[13:45:37.0873] <Restore Device 000000000836D2C0>: operation 13 progress 60
[13:45:37.0873] ASR progress: Sending payload
[13:45:38.0874] <Restore Device 000000000836D2C0>: operation 13 progress 61
[13:45:38.0874] ASR progress: Sending payload
[13:45:39.0476] <Restore Device 000000000836D2C0>: operation 13 progress 62
[13:45:39.0476] ASR progress: Sending payload
[13:45:40.0114] <Restore Device 000000000836D2C0>: operation 13 progress 63
[13:45:40.0114] ASR progress: Sending payload
[13:45:40.0759] <Restore Device 000000000836D2C0>: operation 13 progress 64
[13:45:40.0759] ASR progress: Sending payload
[13:45:41.0330] <Restore Device 000000000836D2C0>: operation 13 progress 65
[13:45:41.0330] ASR progress: Sending payload
[13:45:41.0932] <Restore Device 000000000836D2C0>: operation 13 progress 66
[13:45:41.0932] ASR progress: Sending payload
[13:45:42.0495] <Restore Device 000000000836D2C0>: operation 13 progress 67
[13:45:42.0495] ASR progress: Sending payload
[13:45:43.0060] <Restore Device 000000000836D2C0>: operation 13 progress 68
[13:45:43.0060] ASR progress: Sending payload
[13:45:43.0624] <Restore Device 000000000836D2C0>: operation 13 progress 69
[13:45:43.0624] ASR progress: Sending payload
[13:45:44.0278] <Restore Device 000000000836D2C0>: operation 13 progress 70
[13:45:44.0278] ASR progress: Sending payload
[13:45:44.0995] <Restore Device 000000000836D2C0>: operation 13 progress 71
[13:45:44.0995] ASR progress: Sending payload
[13:45:45.0690] <Restore Device 000000000836D2C0>: operation 13 progress 72
[13:45:45.0690] ASR progress: Sending payload
[13:45:46.0293] <Restore Device 000000000836D2C0>: operation 13 progress 73
[13:45:46.0293] ASR progress: Sending payload
[13:45:46.0867] <Restore Device 000000000836D2C0>: operation 13 progress 74
[13:45:46.0867] ASR progress: Sending payload
[13:45:47.0449] <Restore Device 000000000836D2C0>: operation 13 progress 75
[13:45:47.0449] ASR progress: Sending payload
[13:45:48.0041] <Restore Device 000000000836D2C0>: operation 13 progress 76
[13:45:48.0041] ASR progress: Sending payload
[13:45:48.0641] <Restore Device 000000000836D2C0>: operation 13 progress 77
[13:45:48.0641] ASR progress: Sending payload
[13:45:49.0464] <Restore Device 000000000836D2C0>: operation 13 progress 78
[13:45:49.0465] ASR progress: Sending payload
[13:45:50.0427] <Restore Device 000000000836D2C0>: operation 13 progress 79
[13:45:50.0427] ASR progress: Sending payload
[13:45:51.0393] <Restore Device 000000000836D2C0>: operation 13 progress 80
[13:45:51.0393] ASR progress: Sending payload
[13:45:52.0298] <Restore Device 000000000836D2C0>: operation 13 progress 81
[13:45:52.0298] ASR progress: Sending payload
[13:45:53.0312] <Restore Device 000000000836D2C0>: operation 13 progress 82
[13:45:53.0312] ASR progress: Sending payload
[13:45:54.0419] <Restore Device 000000000836D2C0>: operation 13 progress 83
[13:45:54.0419] ASR progress: Sending payload
[13:45:55.0475] <Restore Device 000000000836D2C0>: operation 13 progress 84
[13:45:55.0475] ASR progress: Sending payload
[13:45:56.0831] <Restore Device 000000000836D2C0>: operation 13 progress 85
[13:45:56.0831] ASR progress: Sending payload
[13:45:58.0576] <Restore Device 000000000836D2C0>: operation 13 progress 86
[13:45:58.0576] ASR progress: Sending payload
[13:46:00.0338] <Restore Device 000000000836D2C0>: operation 13 progress 87
[13:46:00.0338] ASR progress: Sending payload
[13:46:01.0449] <Restore Device 000000000836D2C0>: operation 13 progress 88
[13:46:01.0449] ASR progress: Sending payload
[13:46:02.0219] <Restore Device 000000000836D2C0>: operation 13 progress 89
[13:46:02.0219] ASR progress: Sending payload
[13:46:03.0010] <Restore Device 000000000836D2C0>: operation 13 progress 90
[13:46:03.0010] ASR progress: Sending payload
[13:46:03.0783] <Restore Device 000000000836D2C0>: operation 13 progress 91
[13:46:03.0783] ASR progress: Sending payload
[13:46:04.0552] <Restore Device 000000000836D2C0>: operation 13 progress 92
[13:46:04.0552] ASR progress: Sending payload
[13:46:05.0337] <Restore Device 000000000836D2C0>: operation 13 progress 93
[13:46:05.0338] ASR progress: Sending payload
[13:46:06.0166] <Restore Device 000000000836D2C0>: operation 13 progress 94
[13:46:06.0166] ASR progress: Sending payload
[13:46:07.0012] <Restore Device 000000000836D2C0>: operation 13 progress 95
[13:46:07.0012] ASR progress: Sending payload
[13:46:07.0880] <Restore Device 000000000836D2C0>: operation 13 progress 96
[13:46:07.0880] ASR progress: Sending payload
[13:46:08.0880] <Restore Device 000000000836D2C0>: operation 13 progress 97
[13:46:08.0880] ASR progress: Sending payload
[13:46:10.0241] <Restore Device 000000000836D2C0>: operation 13 progress 98
[13:46:10.0241] ASR progress: Sending payload
[13:46:12.0141] <Restore Device 000000000836D2C0>: operation 13 progress 100
[13:46:12.0141] ASR progress: Finished
[13:46:12.0464] <Restore Device 000000000836D2C0>: operation 14 progress 2
[13:46:12.0633] <Restore Device 000000000836D2C0>: operation 14 progress 4
[13:46:12.0801] <Restore Device 000000000836D2C0>: operation 14 progress 6
[13:46:12.0969] <Restore Device 000000000836D2C0>: operation 14 progress 8
[13:46:13.0137] <Restore Device 000000000836D2C0>: operation 14 progress 10
[13:46:13.0305] <Restore Device 000000000836D2C0>: operation 14 progress 12
[13:46:13.0473] <Restore Device 000000000836D2C0>: operation 14 progress 14
[13:46:13.0641] <Restore Device 000000000836D2C0>: operation 14 progress 16
[13:46:13.0803] <Restore Device 000000000836D2C0>: operation 14 progress 18
[13:46:13.0970] <Restore Device 000000000836D2C0>: operation 14 progress 20
[13:46:14.0138] <Restore Device 000000000836D2C0>: operation 14 progress 22
[13:46:14.0306] <Restore Device 000000000836D2C0>: operation 14 progress 24
[13:46:14.0474] <Restore Device 000000000836D2C0>: operation 14 progress 26
[13:46:14.0644] <Restore Device 000000000836D2C0>: operation 14 progress 28
[13:46:14.0811] <Restore Device 000000000836D2C0>: operation 14 progress 30
[13:46:14.0979] <Restore Device 000000000836D2C0>: operation 14 progress 32
[13:46:15.0147] <Restore Device 000000000836D2C0>: operation 14 progress 34
[13:46:15.0308] <Restore Device 000000000836D2C0>: operation 14 progress 36
[13:46:15.0476] <Restore Device 000000000836D2C0>: operation 14 progress 38
[13:46:15.0645] <Restore Device 000000000836D2C0>: operation 14 progress 40
[13:46:15.0812] <Restore Device 000000000836D2C0>: operation 14 progress 42
[13:46:15.0980] <Restore Device 000000000836D2C0>: operation 14 progress 44
[13:46:16.0148] <Restore Device 000000000836D2C0>: operation 14 progress 46
[13:46:16.0317] <Restore Device 000000000836D2C0>: operation 14 progress 48
[13:46:16.0485] <Restore Device 000000000836D2C0>: operation 14 progress 50
[13:46:16.0647] <Restore Device 000000000836D2C0>: operation 14 progress 52
[13:46:16.0814] <Restore Device 000000000836D2C0>: operation 14 progress 54
[13:46:16.0982] <Restore Device 000000000836D2C0>: operation 14 progress 56
[13:46:17.0150] <Restore Device 000000000836D2C0>: operation 14 progress 58
[13:46:17.0318] <Restore Device 000000000836D2C0>: operation 14 progress 60
[13:46:17.0486] <Restore Device 000000000836D2C0>: operation 14 progress 62
[13:46:17.0654] <Restore Device 000000000836D2C0>: operation 14 progress 64
[13:46:17.0823] <Restore Device 000000000836D2C0>: operation 14 progress 66
[13:46:17.0990] <Restore Device 000000000836D2C0>: operation 14 progress 68
[13:46:18.0152] <Restore Device 000000000836D2C0>: operation 14 progress 70
[13:46:18.0320] <Restore Device 000000000836D2C0>: operation 14 progress 72
[13:46:18.0489] <Restore Device 000000000836D2C0>: operation 14 progress 74
[13:46:18.0657] <Restore Device 000000000836D2C0>: operation 14 progress 76
[13:46:18.0826] <Restore Device 000000000836D2C0>: operation 14 progress 78
[13:46:18.0993] <Restore Device 000000000836D2C0>: operation 14 progress 80
[13:46:19.0161] <Restore Device 000000000836D2C0>: operation 14 progress 82
[13:46:19.0329] <Restore Device 000000000836D2C0>: operation 14 progress 84
[13:46:19.0490] <Restore Device 000000000836D2C0>: operation 14 progress 86
[13:46:19.0658] <Restore Device 000000000836D2C0>: operation 14 progress 88
[13:46:19.0827] <Restore Device 000000000836D2C0>: operation 14 progress 90
[13:46:19.0995] <Restore Device 000000000836D2C0>: operation 14 progress 92
[13:46:20.0163] <Restore Device 000000000836D2C0>: operation 14 progress 94
[13:46:20.0331] <Restore Device 000000000836D2C0>: operation 14 progress 96
[13:46:20.0499] <Restore Device 000000000836D2C0>: operation 14 progress 98
[13:46:20.0661] <Restore Device 000000000836D2C0>: operation 14 progress 100
[13:46:20.0726] <Restore Device 000000000836D2C0>: operation 16 progress -1
[13:46:27.0612] <Restore Device 000000000836D2C0>: operation 16 progress -1
[13:46:28.0273] requested restore behavior: Erase
[13:46:28.0276] <Restore Device 000000000836D2C0>: operation 27 progress -1
[13:46:29.0008] <Restore Device 000000000836D2C0>: operation 27 progress -1
[13:46:29.0150] <Restore Device 000000000836D2C0>: operation 18 progress 0
[13:46:29.0664] <Restore Device 000000000836D2C0>: operation 18 progress 100
[13:46:29.0665] <Restore Device 000000000836D2C0>: operation 46 progress -1
[13:46:29.0678] <Restore Device 000000000836D2C0>: operation 46 progress -1
[13:46:29.0695] <Restore Device 000000000836D2C0>: operation 19 progress -1
[13:46:30.0372] requested restore behavior: Erase
[13:46:30.0385] amai: AMAuthInstallBasebandSetParametersWithUpdaterOutput: manifest dict not found
[13:46:30.0385] amai: _AMAuthInstallBasebandCheckForParameterChange: bbParameters is now non-NULL
[13:46:30.0385] requested restore behavior: Erase
[13:46:30.0385] requested variant: Erase
[13:46:30.0386] requested restore behavior: Erase
[13:46:30.0678] amai: AMAuthInstallBasebandCreateMeasurements: Using set ChipID 0x006F20E1 to measure
[13:46:30.0681] amai: _FindSbl1HeaderInFileData: found SBL header
[13:46:30.0681] amai: _FindSbl1HeaderInFileData: foundMagic=1
[13:46:30.0681] amai: AMAuthInstallMonetSetVersionAndPartialDigestForSBL: fileSize=0x185b8, srcOffset=0x50, codeSize=0x16c68
[13:46:30.0681] amai: AMAuthInstallMonetSetVersionAndPartialDigestForSBL: version=0xa400ea60, personalizationOffset=0x16bf0
[13:46:30.0681] amai: AMAuthInstallMonetSetVersionAndPartialDigestForSBL: reservationLength=0x78, codeBytesHashed=0x16c40 (ok)
[13:46:31.0415] amai: _FindSbl1HeaderInFileData: found SBL header
[13:46:31.0415] amai: _FindSbl1HeaderInFileData: foundMagic=1
[13:46:31.0415] amai: AMAuthInstallMonetSetVersionAndPartialDigestForSBL: fileSize=0x1d6f0, srcOffset=0x50, codeSize=0x1bda0
[13:46:31.0415] amai: AMAuthInstallMonetSetVersionAndPartialDigestForSBL: version=0xa410ea60, personalizationOffset=0x1bd30
[13:46:31.0415] amai: AMAuthInstallMonetSetVersionAndPartialDigestForSBL: reservationLength=0x70, codeBytesHashed=0x1bd80 (ok)
[13:46:31.0492] amai: _AMAuthInstallBundleSetBasebandKeyHashes: setting (from build manifest): BbProvisioningManifestKeyHash = <CFData 000000006A6884E0 [000007FEEC9F8100]>{length = 20, capacity = 20, bytes = 0xecc404532bf31b88238d973b2ac34d0154d2f20e}
[13:46:31.0492] amai: _AMAuthInstallBundleSetBasebandKeyHashes: setting (from build manifest): BbActivationManifestKeyHash = <CFData 000000006A6853E0 [000007FEEC9F8100]>{length = 20, capacity = 20, bytes = 0xaea5cce143668d0efb4ce1f2c94c966a6496c6aa}
[13:46:31.0492] amai: _AMAuthInstallBundleCreateServerRequestDictionary: withApTicket is False
[13:46:31.0493] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "RestoreLogo"
[13:46:31.0493] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "RestoreDeviceTree"
[13:46:31.0493] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "RestoreKernelCache"
[13:46:31.0493] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "RestoreRamDisk"
[13:46:31.0493] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "iBEC"
[13:46:31.0493] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "iBSS"
[13:46:31.0493] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "KernelCache"
[13:46:31.0493] amai: _AMAuthInstallBundleCreateServerRequestDictionary: entry "ftap" not part of manifest, skipping
[13:46:31.0493] amai: _AMAuthInstallBundleCreateServerRequestDictionary: entry "rfta" not part of manifest, skipping
[13:46:31.0493] amai: _AMAuthInstallBundleCreateServerRequestDictionary: entry "ftsp" not part of manifest, skipping
[13:46:31.0493] amai: _AMAuthInstallBundleCreateServerRequestDictionary: entry "rfts" not part of manifest, skipping
[13:46:31.0493] amai: _AMAuthInstallBundleCreateServerRequestDictionary: entry "Diags" not part of manifest, skipping
[13:46:31.0493] amai: _AMAuthInstallBundleCreateServerRequestDictionary: entry "CFELoader" not part of manifest, skipping
[13:46:31.0493] amai: _AMAuthInstallBundleCreateServerRequestDictionary: entry "RBM" not part of manifest, skipping
[13:46:31.0493] amai: _AMAuthInstallBundleCreateServerRequestDictionary: entry "PHLEET" not part of manifest, skipping
[13:46:31.0493] amai: _AMAuthInstallBundleCreateServerRequestDictionary: entry "PERTOS" not part of manifest, skipping
[13:46:31.0493] amai: _AMAuthInstallBundleCreateServerRequestDictionary: entry "PEHammer" not part of manifest, skipping
[13:46:31.0493] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "LLB"
[13:46:31.0493] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "AppleLogo"
[13:46:31.0493] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "BatteryCharging1"
[13:46:31.0493] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "SEP"
[13:46:31.0493] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "BatteryFull"
[13:46:31.0493] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "BatteryPlugin"
[13:46:31.0493] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "BatteryCharging0"
[13:46:31.0493] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "BatteryLow1"
[13:46:31.0493] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "RestoreSEP"
[13:46:31.0493] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "BatteryLow0"
[13:46:31.0493] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "RecoveryMode"
[13:46:31.0493] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "DeviceTree"
[13:46:31.0493] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "iBoot"
[13:46:31.0494] amai: AMAuthInstallBasebandApplyTssOverrides: failed to create CFDictionary from Options.plist
[13:46:31.0494] amai: _AMAuthInstallBundleCreateServerRequestDictionary: using UniqueBuildID <CFData 00000000604454B0 [000007FEEC9F8100]>{length = 20, capacity = 20, bytes = 0xf2780e471a89c8dc253e0f60c62b19c779c2a63e}
[13:46:31.0494] amai: AMAuthInstallRequestSendSync: SSO function returned NULL and no SSO token was provided, SSO disabled.
[13:46:31.0497] amai: tss_submit_job_with_retry: TSS Connection attempt 1 of 3. (Will retry if TSS_ERR_SERVER_NOT_REACHABLE.)
[13:46:31.0754] amai: tss_submit_job: HttpQueryInfo returned 200
[13:46:32.0000] amai: AMAuthInstallRequestSendSync: received tss response (server version: 2.1.0)
[13:46:32.0005] amai: _AMAuthInstallBundleInstallPersonalizedEntry: entry "RestoreLogo" has been previously personalized; skipping it
[13:46:32.0005] amai: _AMAuthInstallBundleInstallPersonalizedEntry: entry "RestoreDeviceTree" has been previously personalized; skipping it
[13:46:32.0005] amai: _AMAuthInstallBundleInstallPersonalizedEntry: entry "RestoreKernelCache" has been previously personalized; skipping it
[13:46:32.0006] amai: _AMAuthInstallBundleInstallPersonalizedEntry: entry "RestoreRamDisk" has been previously personalized; skipping it
[13:46:32.0006] amai: _AMAuthInstallBundleInstallPersonalizedEntry: entry "iBEC" has been previously personalized; skipping it
[13:46:32.0006] amai: _AMAuthInstallBundleInstallPersonalizedEntry: entry "iBSS" has been previously personalized; skipping it
[13:46:32.0006] amai: _AMAuthInstallBundleInstallPersonalizedEntry: entry "KernelCache" has been previously personalized; skipping it
[13:46:32.0006] amai: _AMAuthInstallBundlePopulatePersonalizedBundle: no entry in manifest found for "ftap"
[13:46:32.0006] amai: _AMAuthInstallBundlePopulatePersonalizedBundle: no entry in manifest found for "rfta"
[13:46:32.0006] amai: _AMAuthInstallBundlePopulatePersonalizedBundle: no entry in manifest found for "ftsp"
[13:46:32.0006] amai: _AMAuthInstallBundlePopulatePersonalizedBundle: no entry in manifest found for "rfts"
[13:46:32.0006] amai: _AMAuthInstallBundlePopulatePersonalizedBundle: no entry in manifest found for "Diags"
[13:46:32.0006] amai: _AMAuthInstallBundlePopulatePersonalizedBundle: no entry in manifest found for "CFELoader"
[13:46:32.0006] amai: _AMAuthInstallBundlePopulatePersonalizedBundle: no entry in manifest found for "RBM"
[13:46:32.0006] amai: _AMAuthInstallBundlePopulatePersonalizedBundle: no entry in manifest found for "PHLEET"
[13:46:32.0006] amai: _AMAuthInstallBundlePopulatePersonalizedBundle: no entry in manifest found for "PERTOS"
[13:46:32.0006] amai: _AMAuthInstallBundlePopulatePersonalizedBundle: no entry in manifest found for "PEHammer"
[13:46:32.0011] amai: AMAuthInstallBasebandStitchFirmwareFromBbfw: stitch function returned NULL for "sbl2.mbn"; continuing anyway
[13:46:32.0012] amai: AMAuthInstallBasebandStitchFirmwareFromBbfw: stitch function returned NULL for "rpm.mbn"; continuing anyway
[13:46:32.0032] amai: AMAuthInstallBasebandStitchFirmwareFromBbfw: stitch function returned NULL for "apps.mbn"; continuing anyway
[13:46:32.0071] amai: AMAuthInstallBasebandStitchFirmwareFromBbfw: stitch function returned NULL for "dsp1.mbn"; continuing anyway
[13:46:32.0476] amai: AMAuthInstallBasebandStitchFirmwareFromBbfw: stitch function returned NULL for "dsp2.mbn"; continuing anyway
[13:46:32.0535] amai: AMAuthInstallBasebandStitchFirmwareFromBbfw: stitch function returned NULL for "dsp3.mbn"; continuing anyway
[13:46:32.0541] amai: BbfwWriterAddFile: added bbfw file: Options.plist
[13:46:32.0554] amai: BbfwWriterAddFile: added bbfw file: sbl1.mbn
[13:46:32.0572] amai: BbfwWriterAddFile: added bbfw file: restoresbl1.mbn
[13:46:32.0572] amai: _AMAuthInstallBundleInstallPersonalizedEntry: entry "LLB" has been previously personalized; skipping it
[13:46:32.0573] amai: _AMAuthInstallBundleInstallPersonalizedEntry: entry "AppleLogo" has been previously personalized; skipping it
[13:46:32.0573] amai: _AMAuthInstallBundleInstallPersonalizedEntry: entry "BatteryCharging1" has been previously personalized; skipping it
[13:46:32.0573] amai: _AMAuthInstallBundleInstallPersonalizedEntry: entry "SEP" has been previously personalized; skipping it
[13:46:32.0574] amai: _AMAuthInstallBundleInstallPersonalizedEntry: entry "BatteryFull" has been previously personalized; skipping it
[13:46:32.0574] amai: _AMAuthInstallBundleInstallPersonalizedEntry: entry "BatteryPlugin" has been previously personalized; skipping it
[13:46:32.0574] amai: _AMAuthInstallBundleInstallPersonalizedEntry: entry "BatteryCharging0" has been previously personalized; skipping it
[13:46:32.0574] amai: _AMAuthInstallBundleInstallPersonalizedEntry: entry "BatteryLow1" has been previously personalized; skipping it
[13:46:32.0575] amai: _AMAuthInstallBundleInstallPersonalizedEntry: entry "RestoreSEP" has been previously personalized; skipping it
[13:46:32.0575] amai: _AMAuthInstallBundleInstallPersonalizedEntry: entry "BatteryLow0" has been previously personalized; skipping it
[13:46:32.0575] amai: _AMAuthInstallBundleInstallPersonalizedEntry: entry "RecoveryMode" has been previously personalized; skipping it
[13:46:32.0575] amai: _AMAuthInstallBundleInstallPersonalizedEntry: entry "DeviceTree" has been previously personalized; skipping it
[13:46:32.0576] amai: _AMAuthInstallBundleInstallPersonalizedEntry: entry "iBoot" has been previously personalized; skipping it
[13:46:32.0811] <Restore Device 000000000836D2C0>: operation 19 progress 0
[13:46:33.0015] <Restore Device 000000000836D2C0>: operation 19 progress 0
[13:46:33.0218] <Restore Device 000000000836D2C0>: operation 19 progress 0
[13:46:39.0344] <Restore Device 000000000836D2C0>: operation 19 progress 0
[13:46:39.0348] amai: AMAuthInstallBasebandHandleUpdaterStatus: commandAccepted: YES
[13:48:01.0375] requested restore behavior: Erase
[13:48:01.0375] amai: AMAuthInstallBasebandSetParametersWithUpdaterOutput: manifest dict not found
[13:48:01.0375] requested restore behavior: Erase
[13:48:01.0375] requested variant: Erase
[13:48:01.0375] requested restore behavior: Erase
[13:48:01.0702] amai: AMAuthInstallBasebandCreateMeasurements: Using set ChipID 0x006F20E1 to measure
[13:48:01.0705] amai: _FindSbl1HeaderInFileData: found SBL header
[13:48:01.0705] amai: _FindSbl1HeaderInFileData: foundMagic=1
[13:48:01.0705] amai: AMAuthInstallMonetSetVersionAndPartialDigestForSBL: fileSize=0x185b8, srcOffset=0x50, codeSize=0x16c68
[13:48:01.0705] amai: AMAuthInstallMonetSetVersionAndPartialDigestForSBL: version=0xa400ea60, personalizationOffset=0x16bf0
[13:48:01.0705] amai: AMAuthInstallMonetSetVersionAndPartialDigestForSBL: reservationLength=0x78, codeBytesHashed=0x16c40 (ok)
[13:48:02.0511] amai: _FindSbl1HeaderInFileData: found SBL header
[13:48:02.0511] amai: _FindSbl1HeaderInFileData: foundMagic=1
[13:48:02.0511] amai: AMAuthInstallMonetSetVersionAndPartialDigestForSBL: fileSize=0x1d6f0, srcOffset=0x50, codeSize=0x1bda0
[13:48:02.0511] amai: AMAuthInstallMonetSetVersionAndPartialDigestForSBL: version=0xa410ea60, personalizationOffset=0x1bd30
[13:48:02.0511] amai: AMAuthInstallMonetSetVersionAndPartialDigestForSBL: reservationLength=0x70, codeBytesHashed=0x1bd80 (ok)
[13:48:02.0591] amai: _AMAuthInstallBundleSetBasebandKeyHashes: setting (from build manifest): BbProvisioningManifestKeyHash = <CFData 000000006A6884E0 [000007FEEC9F8100]>{length = 20, capacity = 20, bytes = 0xecc404532bf31b88238d973b2ac34d0154d2f20e}
[13:48:02.0591] amai: _AMAuthInstallBundleSetBasebandKeyHashes: setting (from build manifest): BbActivationManifestKeyHash = <CFData 000000006A6853E0 [000007FEEC9F8100]>{length = 20, capacity = 20, bytes = 0xaea5cce143668d0efb4ce1f2c94c966a6496c6aa}
[13:48:02.0591] amai: _AMAuthInstallBundleCreateServerRequestDictionary: withApTicket is False
[13:48:02.0593] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "RestoreLogo"
[13:48:02.0593] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "RestoreDeviceTree"
[13:48:02.0593] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "RestoreKernelCache"
[13:48:02.0593] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "RestoreRamDisk"
[13:48:02.0593] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "iBEC"
[13:48:02.0593] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "iBSS"
[13:48:02.0593] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "KernelCache"
[13:48:02.0593] amai: _AMAuthInstallBundleCreateServerRequestDictionary: entry "ftap" not part of manifest, skipping
[13:48:02.0593] amai: _AMAuthInstallBundleCreateServerRequestDictionary: entry "rfta" not part of manifest, skipping
[13:48:02.0593] amai: _AMAuthInstallBundleCreateServerRequestDictionary: entry "ftsp" not part of manifest, skipping
[13:48:02.0593] amai: _AMAuthInstallBundleCreateServerRequestDictionary: entry "rfts" not part of manifest, skipping
[13:48:02.0593] amai: _AMAuthInstallBundleCreateServerRequestDictionary: entry "Diags" not part of manifest, skipping
[13:48:02.0593] amai: _AMAuthInstallBundleCreateServerRequestDictionary: entry "CFELoader" not part of manifest, skipping
[13:48:02.0593] amai: _AMAuthInstallBundleCreateServerRequestDictionary: entry "RBM" not part of manifest, skipping
[13:48:02.0593] amai: _AMAuthInstallBundleCreateServerRequestDictionary: entry "PHLEET" not part of manifest, skipping
[13:48:02.0593] amai: _AMAuthInstallBundleCreateServerRequestDictionary: entry "PERTOS" not part of manifest, skipping
[13:48:02.0593] amai: _AMAuthInstallBundleCreateServerRequestDictionary: entry "PEHammer" not part of manifest, skipping
[13:48:02.0593] amai: _AMAuthInstallBundleCreateServerRequestDictionary: entry "BasebandFirmware" has been previously personalized; skipping it
[13:48:02.0593] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "LLB"
[13:48:02.0593] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "AppleLogo"
[13:48:02.0593] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "BatteryCharging1"
[13:48:02.0593] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "SEP"
[13:48:02.0593] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "BatteryFull"
[13:48:02.0593] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "BatteryPlugin"
[13:48:02.0593] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "BatteryCharging0"
[13:48:02.0593] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "BatteryLow1"
[13:48:02.0593] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "RestoreSEP"
[13:48:02.0593] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "BatteryLow0"
[13:48:02.0593] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "RecoveryMode"
[13:48:02.0593] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "DeviceTree"
[13:48:02.0593] amai: _AMAuthInstallBundleCreateServerRequestDictionary: not personalizing "iBoot"
[13:48:02.0593] amai: _AMAuthInstallBundleCreateServerRequestDictionary: nothing to be done
[13:48:02.0821] <Restore Device 000000000836D2C0>: operation 19 progress 0
[13:48:03.0023] <Restore Device 000000000836D2C0>: operation 19 progress 0
[13:48:03.0228] <Restore Device 000000000836D2C0>: operation 19 progress 0
[13:48:09.0354] <Restore Device 000000000836D2C0>: operation 19 progress 0
[13:48:09.0359] amai: AMAuthInstallBasebandHandleUpdaterStatus: commandAccepted: YES
[13:49:29.0427] amai: AMAuthInstallBasebandHandleUpdaterStatus: commandAccepted: NO
[13:49:29.0474] device returned CFError with code -1
[13:49:29.0474] dumping CFError returned by restored:
[13:49:29.0474] CFError domain:AMRestoreErrorDomain code:-1 description:failed to update device firmware
[13:49:29.0474] CFError domain:AMRestoreErrorDomain code:-1 description:ramrod firmware update failed
[13:49:29.0474] CFError domain:RamrodErrorDomain code:1004 description:update_baseband: failed querying baseband info
[13:49:29.0474] CFError domain:BBUpdater code:47 description:Failed gatherPersonalizationParameters in second stage
[13:49:29.0474] Sending acknowledgement that final status was received
[13:49:30.0685]
[13:49:30.0685] ==== device restore output ====
[13:49:30.0685] SYSLOG: Sep 22 13:44:34 localhost bootlog[0] <Notice>: BOOT_TIME 1442929474 0
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: DGeometry - NAND Geometry info:
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: ASPStorage:XXXXXXXXXeometry - Num LBAs : 3906250
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: ASPStorage:XXXXXXXXXeometry - Bytes per LBA : 4096
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: ASPStorage:XXXXXXXXXeometry - Preferred buffer size: 65536
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: ASPStorage:XXXXXXXXXeometry - lbaFormatted : YES
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: ASPStorage:XXXXXXXXXeometry - utilFormatted : YES
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: AppleSamsungSerial: Identified Serial Port on ARM Device=uart2 at 0x20a0a8000(<ptr>)
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: AppleSamsungSerial: Identified Serial Port on ARM Device=uart4 at 0x20a0b0000(<ptr>)
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: AppleSamsungSerial: Identified Serial Port on ARM Device=uart1 at 0x20a0a4000(<ptr>)
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: BSD root: md0, major 2, minor 0
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: com.apple.AppleFSCompressionTypeZlib kmod start
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: com.apple.AppleFSCompressionTypeZlib load succeeded
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: AppleMultitouchN1SPI: successfully started
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: AppleBaseband: Backpowering function: functionXXXXXXXXXring_pin0
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: AppleBaseband: Found 1 backpowering pins
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: L2TP domain init
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: L2TP domain init complete
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: AppleH6CamIn::start - fISPVersion=3
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: PPTP domain init
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: IOMFBSoCH6Profile.getProfile()
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: virtual bool Block::init(IOService *, IOMFBSoCProfile *, IOMFB:XXXXXXXXXe): failed to find the register index for BlockTypeXXXXXXXXXXXXXXXXXXXXer
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: virtual bool AppleH4DisplayPipe::start_hardware(IOService *), auto-detect chip
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: AppleMobileADBE0 DisplayPipe fRegisters virtual = <ptr>, physical = 0x206200000
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: AppleOscarProcessorXXXXXXXXXXXXXXXXXXXXX setting oscar-state=0
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: ASPStorage:XXXXXXXXXalizeTime - kern.monotonicclock at boot = 60913689
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: ASPStorageXXXXXXXXXXXXXXXXXXXXdisk - Root device is md0
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: ASPStorageXXXXXXXXXXXXXXXXXXXXdisk - Root device is a ramdisk
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: ASPStorage:XXXXXXXXXzeASP - NAND is not writable!
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: void AppleDisplayPipe:XXXXXXXXXequencies(): minimumXXXXXXXXXy property not found, using getClockFrequency(0) instead.
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: AGXk: AGXAcceleratorG3_B0: GPU firmware booted successfully (AGXFirmwareKextG3)
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: ADBE0::start_hardware -> 1
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: ASPBlockStorage:XXXXXXXXXvice - Creating block device of 3906250 sectors of 4096 bytes
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: AppleH6CamIn::power_off_hardware
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: AppleARMPMUCharger: AppleUSBCableDetect 1
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: AppleARMPMUCharger: AppleUSBCableType USBHost
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: ASPStorage:XXXXXXXXXdOnly - Ramdisk rooted. Returning readonly true
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: AppleH6CamInXXXXXXXXXXXXXXXXXXXXX 0
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: AppleH6CamIn::start - About to register service
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: AppleOscarProcessor:XXXXXXXXXrtGated: baudRate=0
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: AppleOscarProcessorXXXXXXXXXXXXXXXXXXXXX setting oscar-state=10001
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: AppleOscarFirmware::start: No firmware image
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: AppleOscarProcessor:XXXXXXXXXirmware: firmware published successfully
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: AppleOscarProcessor:XXXXXXXXXtGated: Starting Oscar1, baudRate=1500000
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: AppleARMBacklight::start: Pre-strobe iDAC=1973 default
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: ready - 00000000: 3f | ?
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: AppleOscarProcessorXXXXXXXXXXXXXXXXXXXXy: _BootROMReady=1
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: AppleOscarFirmwareXXXXXXXXXXXXXXXXXXXXge: waiting for firmware
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: AppleSynopsysOTGDevice::gated_handleUSBCableConnect cable connected, but don't have device configuration yet
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: AppleSynopsysOTGDevice::gated_handleUSBCableConnect cable connected, but don't have device configuration yet
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: AppleSynopsysOTGDevice::gated_handleUSBCableConnect cable connected, but don't have device configuration yet
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: ASPStorage:XXXXXXXXXdOnly - Ramdisk rooted. Returning readonly true
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: ASPStorage:XXXXXXXXXdOnly - Ramdisk rooted. Returning readonly true
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: LwVM::probe - failed to read header from media
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: 000139.361079 AppleUSBHostResources@: AppleUSBHostResourcesXXXXXXXXXXXXXXXXXXXXBusCurrentGated: assuming successful wakeUnits 100 sleepUnits 0
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: [effaceable:INIT] found current generation, 179, in group 0
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: [effaceable:INIT] started
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: ASPStorage:XXXXXXXXXdOnly - Ramdisk rooted. Returning readonly true
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: [ANS syslog: nand] Util_HostXXXXXXXXXng to read element=PANICLOG not yet written, returning ERR_ABORT
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: LwVM::probe - failed to read header from media
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: [ANS syslog: nand] Util_HostXXXXXXXXXng to read element=PANICLOG not yet written, returning ERR_ABORT
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: [ANS syslog: nand] Util_HostXXXXXXXXXng to read element=PANICLOG not yet written, returning ERR_ABORT
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: [ANS syslog: nand] Util_HostXXXXXXXXXng to read element=PANICLOG not yet written, returning ERR_ABORT
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: AppleMultitouchN1SPI: detected HBPP. driver will be kept alive
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost syslogd[4] <Notice>: ASL Sender Statistics
[13:49:30.0685] unable to open /dev/klog: Resource busy
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost restored_external[6] <Error>: libMobileGestalt MobileGestalt.c:145: couldn't load support library
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost restored_external[6] <Error>: libMobileGestalt MobileGestalt.c:511: _MGSCopyAnswerFromServer can't be loaded
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost restored_external[6] <Error>: libMobileGestalt MobileGestalt.c:115: called dummy function!
[13:49:30.0685] display-scale = 2
[13:49:30.0685] displayXXXXXXXXX = 0
[13:49:30.0685] found applelogo at /usr/share/progressui/applelogo@2x.tga
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost restored_external[6] <Error>: IOMFB: /System/Library/Frameworks/MediaToolbox.framework/MediaToolbox not found
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost restored_external[6] <Error>: IOMFB: /System/Library/PrivateFrameworks/MediaToolbox.framework/MediaToolbox not found
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost restored_external[6] <Error>: IOMFB: /System/Library/PrivateFrameworks/Celestial.framework/Celestial not found
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost restored_external[6] <Error>: IOMFB: FigInstallVirtualDisplay not found
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost restored_external[6] <Error>: CFPreferences could not connect to its daemon.
[13:49:30.0685] Preferences using the connection 0x0 will be volatile and will not be persisted to disk.
[13:49:30.0685] found display: primary
[13:49:30.0685] display: 640 x 1136
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: Loading diags data region 1
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: AppleSynopsysOTGDevice - Configuration: Apple Mobile Device
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: AppleSynopsysOTGDevice Interface: AppleUSBMux
[13:49:30.0685] waiting for matching IOKit service: <CFBasicHash 0x126603a60 [0x100b627d8]>{type = mutable dict, count = 1,
[13:49:30.0685] entries =>
[13:49:30.0685] 0 : <CFString 0x100df2f10 [0x100b627d8]>{contents = "IOProviderClass"} = <CFString 0x126603970 [0x100b627d8]>{contents = "AppleUSBDeviceMux"}
[13:49:30.0685] }
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: virtual bool AppleUSBDeviceMux::start(IOService *) build: Aug 20 2015 13:24:01
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: AppleSynopsysOTGDevice::gated_registerFunction Register function AppleUSBMux
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: AppleSynopsysOTGDevice:XXXXXXXXXStack Starting usb stack
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: AppleBCMWLANCore::init IO80211-176 "IO80211-176" Aug 20 2015 13:23:05
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: IO80211Controller:XXXXXXXXXReporters 0x<<<<<MEID>>>>>3d
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: CCFlags: 0x0, CCLevel: 5 ConsoleFlags: 0x0, ConsoleLevel: -1
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: No Service found 100000364
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: configureInterests - nElements <= 0!Failed to addSubscription for group Chip subgroup Bytes Transferred driver 0x<<<<<MEID>>>>>3d - data underrun
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: IO80211ControllerMonitorXXXXXXXXXXXXXXXXXXXXions() failed to add subscriptionIO80211Controller::start _controller is 0x<<<<<MEID>>>>>3d, provider is 0x<<<<<MEID>>>>>3d
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: 000140.308696 wlan0.A[0] gatherDeviceTreeData@767: WARNING, Wifi 'serial baud rate' does not exist in the device tree
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: 000140.314563 wlan0.N[1] start@1178XXXXXXXXX with MAC Address: <<<mac address>>>
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: AppleBCMWLANCoreXXXXXXXXXXXXXXXXXXXXoctl type 0xc cmd GET
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: AppleBCMWLANCoreXXXXXXXXXXXXXXXXXXXXoctl type 0x50 cmd GET
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: 000140.314923 wlan0.N[2] setPowerStateGated@15237: powerState 1, fStateFlags 0x20, dev 0x<<<<<MEID>>>>>3d (this 1, provider 0)
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: 000140.314943 wlan0.N[3] setPowerStateGated@15240: Received power state change before driver has initialized, ignoring
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: IO80211PeerManager:XXXXXXXXXInterface can't add monitoring timer
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: IO80211Interface::init peerManager=0x<<<<<MEID>>>>>3d
[13:49:30.0685] SYSLOG: Sep 22 13:44:35 localhost kernel[0] <Notice>: IO80211ControllerXXXXXXXXXXXXXXXXXXXXX Setting mac address on interface
[13:49:30.0685] SYSLOG: Sep 22 13:44:38 localhost kernel[0] <Notice>: IOReturn AppleUSBDeviceMuxXXXXXXXXXXXXXXXXXXXX(OSObject *) setting debug level to 7
[13:49:30.0685] recv(9, 4) failed: connection closed
[13:49:30.0685] recv(10, 4) failed: connection closed
[13:49:30.0685] unable to read message size: -1
[13:49:30.0685] recv(12, 4) failed: connection closed
[13:49:30.0685] recv(11, 4) failed: connection closed
[13:49:30.0685] unable to read message size: -1
[13:49:30.0685] could not receive message
[13:49:30.0685] unable to read message size: -1
[13:49:30.0685] unable to read message size: -1
[13:49:30.0685] could not receive message
[13:49:30.0685] could not receive message
[13:49:30.0685] could not receive message
[13:49:30.0685] recv(15, 4) failed: connection closed
[13:49:30.0685] unable to read message size: -1
[13:49:30.0685] could not receive message
[13:49:30.0685] recv(9, 4) failed: connection closed
[13:49:30.0685] unable to read message size: -1
[13:49:30.0685] could not receive message
[13:49:30.0685] recv(13, 4) failed: connection closed
[13:49:30.0685] unable to read message size: -1
[13:49:30.0685] could not receive message
[13:49:30.0685] recv(9, 4) failed: connection closed
[13:49:30.0685] unable to read message size: -1
[13:49:30.0685] could not receive message
[13:49:30.0685] recv(10, 4) failed: connection closed
[13:49:30.0685] unable to read message size: -1
[13:49:30.0685] could not receive message
[13:49:30.0685] unrecognized key 'BootArgs' in value query
[13:49:30.0685] failed to handle value query for key 'BootArgs', sending back empty response
[13:49:30.0685] recv(9, 4) failed: connection closed
[13:49:30.0685] unable to read message size: -1
[13:49:30.0685] unrecognized key 'MarketingPartNumber' in value query
[13:49:30.0685] could not receive message
[13:49:30.0685] failed to handle value query for key 'MarketingPartNumber', sending back empty response
[13:49:30.0685] recv(10, 4) failed: connection closed
[13:49:30.0685] unable to read message size: -1
[13:49:30.0685] could not receive message
[13:49:30.0685] recv(9, 4) failed: connection closed
[13:49:30.0685] unable to read message size: -1
[13:49:30.0685] could not receive message
[13:49:30.0685] client protocol version 13
[13:49:30.0685] *** UUID 3EDC4BF9-3D08-104F-BC46-1370E730E339 ***
[13:49:30.0685] Restore options:
[13:49:30.0685] MinimumSystemPartition => <CFNumber 0x<<<<<MEID>>>>>03 [0x100b627d8]>{value = +2688, type = kCFNumberSInt64Type}
[13:49:30.0685] UUID => <CFString 0x12650da70 [0x100b627d8]>{contents = "3EDC4BF9-3D08-104F-BC46-1370E730E339"}
[13:49:30.0685] SystemPartitionSize => <CFNumber 0x<<<<<MEID>>>>>03 [0x100b627d8]>{value = +2688, type = kCFNumberSInt64Type}
[13:49:30.0685] SystemPartitionPadding => <CFBasicHash 0x126604cf0 [0x100b627d8]>{type = mutable dict, count = 9,
[13:49:30.0685] entries =>
[13:49:30.0685] 0 : <CFString 0x126604f80 [0x100b627d8]>{contents = "512"} = <CFNumber 0xb<<<<<IMEI>>>>>> [0x100b627d8]>{value = +1280, type = kCFNumberSInt64Type}
[13:49:30.0685] 2 : <CFString 0x126604e10 [0x100b627d8]>{contents = "128"} = <CFNumber 0xb<<<<<IMEI>>>>>> [0x100b627d8]>{value = +1280, type = kCFNumberSInt64Type}
[13:49:30.0685] 3 : <CFString 0x126604e50 [0x100b627d8]>{contents = "16"} = <CFNumber 0x<<<<<MEID>>>>>03 [0x100b627d8]>{value = +160, type = kCFNumberSInt64Type}
[13:49:30.0685] 4 : <CFString 0x1266039e0 [0x100b627d8]>{contents = "1024"} = <CFNumber 0xb<<<<<IMEI>>>>>> [0x100b627d8]>{value = +1280, type = kCFNumberSInt64Type}
[13:49:30.0685] 5 : <CFString 0x126603b70 [0x100b627d8]>{contents = "32"} = <CFNumber 0xb<<<<<IMEI>>>>>> [0x100b627d8]>{value = +320, type = kCFNumberSInt64Type}
[13:49:30.0685] 6 : <CFString 0x126605000 [0x100b627d8]>{contents = "768"} = <CFNumber 0xb<<<<<IMEI>>>>>> [0x100b627d8]>{value = +1280, type = kCFNumberSInt64Type}
[13:49:30.0685] 7 : <CFString 0x100b0a820 [0x100b627d8]>{cont...
[13:49:30.0685] entering load_sep_os
[13:49:30.0685] device has sep - getting firmware
[13:49:30.0685] entering copy_restore_sep
[13:49:30.0685] got sep firmware - making call to load it
[13:49:30.0685] entering ramrod_load_sep_os
[13:49:30.0685] entering ramrod_execute_command_with_input_data: /usr/libexec/seputil (0x104ebc000 - 4473885)
[13:49:30.0685] executing /usr/libexec/seputil
[13:49:30.0685] waiting for child to exit
[13:49:30.0685] SYSLOG: Sep 22 13:44:39 localhost kernel[0] <Notice>: bool AppleSEPFirmware::_initFromMemory(IOMemoryDescriptor *): loaded 4473885 bytes of firmware from client
[13:49:30.0685] SYSLOG: Sep 22 13:44:39 localhost kernel[0] <Notice>: AppleSEP:WARNING: Could not register SEP root shmcon (err=-1)
[13:49:30.0685] SYSLOG: Sep 22 13:44:39 localhost kernel[0] <Notice>: AppleSEP:WARNING: Could not register SEP debugger shmcon (err=-1)
[13:49:30.0685] SYSLOG: Sep 22 13:44:39 localhost kernel[0] <Notice>: IOReturn AppleSEPManager:XXXXXXXXXareBytes(IOMemoryDescriptor *, bool, bool): SEP Shared Memory Buffer at <ptr>
[13:49:30.0685] SYSLOG: Sep 22 13:44:39 localhost kernel[0] <Notice>: void AppleSEPBooter::_bootAction(void *, void *): SEP status: 1
[13:49:30.0685] SYSLOG: Sep 22 13:44:39 localhost kernel[0] <Notice>: void AppleSEPBooter::_bootAction(void *, void *): SEP accepted Tz0
[13:49:30.0685] SYSLOG: Sep 22 13:44:39 localhost kernel[0] <Notice>: void AppleSEPBooter::_bootAction(void *, void *): SEP status: 2
[13:49:30.0685] SYSLOG: Sep 22 13:44:39 localhost kernel[0] <Notice>: void AppleSEPBooter::_bootAction(void *, void *): SEP status: 2
[13:49:30.0685] SYSLOG: Sep 22 13:44:39 localhost kernel[0] <Notice>: IOReturn AppleSEPBooter::bootSEP(AppleSEPFirmware *, AppleSEPSharedMemoryBuffer *, bool): SEP booting
[13:49:30.0685] SYSLOG: Sep 22 13:44:39 localhost kernel[0] <Notice>: IOReturn AppleSEPBooter::bootSEP(AppleSEPFirmware *, AppleSEPSharedMemoryBuffer *, bool): Shmbuf for SEP: { paddr = 0x805530000, size = 0x10000 }
[13:49:30.0685] SYSLOG: Sep 22 13:44:41 localhost kernel[0] <Notice>: void AppleSEPBooter::_bootAction(void *, void *): SEP accepted IMG4
[13:49:30.0685] child exited
[13:49:30.0685] exit status: 0
[13:49:30.0685] entering ramrod_ticket_update
[13:49:30.0685] looking up boot manifest hash
[13:49:30.0685] crypto-hash-method found. Using SHA1
[13:49:30.0685] device tree ticket_hash: <<<<<<<<<<<<<<<<<<UDID>>>>>>>>>>>>>>>>>>
[13:49:30.0685] computed ticket_hash : <<<<<<<<<<<<<<<<<<UDID>>>>>>>>>>>>>>>>>>
[13:49:30.0685] received valid ticket (4991 bytes)
[13:49:30.0685] entering partition_nand_device
[13:49:30.0685] No IOFlashController instance found
[13:49:30.0685] entering wait_for_storage_device
[13:49:30.0685] Searching for NAND service
[13:49:30.0685] Found NAND service: ASPStorage
[13:49:30.0685] NAND initialized. Waiting for devnode.
[13:49:30.0685] entering clear_remap_variable
[13:49:30.0685] executing /usr/sbin/nvram
[13:49:30.0685] Service name : ASPStorage
[13:49:30.0685] SYSLOG: Sep 22 13:44:41 localhost kernel[0] <Notice>: ASPStorage:XXXXXXXXXdOnly - Ramdisk rooted. Returning readonly false
[13:49:30.0685] SYSLOG: Sep 22 13:44:41 localhost kernel[0] <Notice>: [ANS syslog: nand] Push_PowerGovernorInit:Nand Die:2 MLC: 2 No SLC: 2 No Erase:2
[13:49:30.0685] SYSLOG: Sep 22 13:44:41 localhost kernel[0] <Notice>: ASPStorageXXXXXXXXXXXXXXXXXXXXdisk - Root device is md0
[13:49:30.0685] SYSLOG: Sep 22 13:44:41 localhost kernel[0] <Notice>: ASPStorageXXXXXXXXXXXXXXXXXXXXdisk - Root device is a ramdisk
[13:49:30.0685] SYSLOG: Sep 22 13:44:41 localhost kernel[0] <Notice>: IOFirmwareDevice:XXXXXXXXXdiaParams - prev num blks 1024 new num blks 1024
[13:49:30.0685] SYSLOG: Sep 22 13:44:41 localhost kernel[0] <Notice>: ASPStorage:XXXXXXXXXdOnly - Ramdisk rooted. Returning readonly false
[13:49:30.0685] SYSLOG: Sep 22 13:44:41 localhost kernel[0] <Notice>: ASPStorage:XXXXXXXXXdOnly - Ramdisk rooted. Returning readonly false
[13:49:30.0685] Set ASP writable successfully
[13:49:30.0685] entering ramrod_reprobe_device_path
[13:49:30.0685] entering ramrod_probe_media
[13:49:30.0685] device partitioning scheme is GPT
[13:49:30.0685] find_filesystem_partitions: storage=/dev/disk0s1 system=/dev/disk0s1s1 data=/dev/disk0s1s2 baseband data= log=
[13:49:30.0685] entering ramrod_reprobe_device_path
[13:49:30.0685] entering ramrod_probe_media
[13:49:30.0685] device partitioning scheme is GPT
[13:49:30.0685] find_filesystem_partitions: storage=/dev/disk0s1 system=/dev/disk0s1s1 data=/dev/disk0s1s2 baseband data= log=
[13:49:30.0685] entering ramrod_probe_media
[13:49:30.0685] device partitioning scheme is GPT
[13:49:30.0685] find_filesystem_partitions: storage=/dev/disk0s1 system=/dev/disk0s1s1 data=/dev/disk0s1s2 baseband data= log=
[13:49:30.0685] executing /sbin/fsck_hfs
[13:49:30.0685] SYSLOG: Sep 22 13:44:41 localhost kernel[0] <Notice>: void AppleSEPManager:XXXXXXXXXActive(): SEP/OS is alive
[13:49:30.0685] SYSLOG: Sep 22 13:44:41 localhost kernel[0] <Notice>: void AppleSEPManager::_updateDeviceTree(): updateDeviceTreeThread started
[13:49:30.0685] SYSLOG: Sep 22 13:44:41 localhost kernel[0] <Notice>: IOReturn AppleSEPARTRequests::handle_first_connected(): Configuring in buffer
[13:49:30.0685] SYSLOG: Sep 22 13:44:41 localhost kernel[0] <Notice>: static void AppleSEPManager::_updateDeviceTreeThread(void *): updateDeviceTree Success
[13:49:30.0685] SYSLOG: Sep 22 13:44:41 localhost kernel[0] <Notice>: IOReturn AppleSEPARTRequests::handle_first_connected(): Configuring out buffer
[13:49:30.0685] SYSLOG: Sep 22 13:44:41 localhost kernel[0] <Notice>: IOReturn AppleSEPARTStorage::handle_first_connected(): Sending MANIFEST with timeout
[13:49:30.0685] SYSLOG: Sep 22 13:44:41 localhost kernel[0] <Notice>: ASPSEPNotifier::message - msg = 1
[13:49:30.0685] SYSLOG: Sep 22 13:44:41 localhost kernel[0] <Notice>: ASPSEPNotifier::message - kSEPNotifyOK2Wrap
[13:49:30.0685] SYSLOG: Sep 22 13:44:41 localhost kernel[0] <Notice>: IOReturn AppleSEPARTStorage::handle_first_connected(): Sending ART_LOAD with timeout
[13:49:30.0685] SYSLOG: Sep 22 13:44:41 localhost kernel[0] <Notice>: ASPStorageXXXXXXXXXXXXXXXXXXXXdisk - Root device is md0
[13:49:30.0685] SYSLOG: Sep 22 13:44:41 localhost kernel[0] <Notice>: ASPStorageXXXXXXXXXXXXXXXXXXXXdisk - Root device is a ramdisk
[13:49:30.0685] SYSLOG: Sep 22 13:44:41 localhost kernel[0] <Notice>: bool AppleSEPARTStorage::save_incoming_art(const uint8_t *, const uint8_t *): Incoming art set and synched
[13:49:30.0685] journal_replay(/dev/disk0s1s1) returned 0
[13:49:30.0685] ** /dev/rdisk0s1s1
[13:49:30.0685] Using cacheBlockSize=32K cacheTotalBlock=4000 cacheSize=128000K.
[13:49:30.0685] Executing fsck_hfs (version hfs-305.1.1).
[13:49:30.0685] ** Checking Journaled HFS Plus volume.
[13:49:30.0685] ** Detected a caseXXXXXXXXXe volume.
[13:49:30.0685] The volume name is Donner12H321.N53OS
[13:49:30.0685] ** Checking extents overflow file.
[13:49:30.0685] ** Checking catalog file.
[13:49:30.0685] ** Checking multi-linked files.
[13:49:30.0685] ** Checking catalog hierarchy.
[13:49:30.0685] ** Checking extended attributes file.
[13:49:30.0685] ** Checking volume bitmap.
[13:49:30.0685] ** Checking volume information.
[13:49:30.0685] ** Trimming unused blocks.
[13:49:30.0685] ** The volume Donner12H321.N53OS appears to be OK.
[13:49:30.0685] CheckHFS returned 0, fsmodified = 0
[13:49:30.0685] executing /sbin/mount_hfs
[13:49:30.0685] /dev/disk0s1s1 mounted on /mnt1
[13:49:30.0685] restored_fdr_initialize returned false
[13:49:30.0685] RestoredFDRCreate() returned 0
[13:49:30.0685] FDR is not supported on this device
[13:49:30.0685] RestoredFDRSaveData: restoredFDR is NULL, not able to preserve FDR data.
[13:49:30.0685] RestoredFDRSaveData success
[13:49:30.0685] entering check_for_restore_log
[13:49:30.0685] found restore log (size = 43253)
[13:49:30.0685] executing /sbin/fsck_hfs
[13:49:30.0685] journal_replay(/dev/disk0s1s2) returned 0
[13:49:30.0685] ** /dev/rdisk0s1s2
[13:49:30.0685] Using cacheBlockSize=32K cacheTotalBlock=4000 cacheSize=128000K.
[13:49:30.0685] Executing fsck_hfs (version hfs-305.1.1).
[13:49:30.0685] ** Checking Journaled HFS Plus volume.
[13:49:30.0685] ** Detected a caseXXXXXXXXXe volume.
[13:49:30.0685] The volume name is Data
[13:49:30.0685] ** Checking extents overflow file.
[13:49:30.0685] ** Checking catalog file.
[13:49:30.0685] ** Checking multi-linked files.
[13:49:30.0685] ** Checking catalog hierarchy.
[13:49:30.0685] ** Checking extended attributes file.
[13:49:30.0685] ** Checking volume bitmap.
[13:49:30.0685] ** Checking volume information.
[13:49:30.0685] ** Trimming unused blocks.
[13:49:30.0685] ** The volume Data appears to be OK.
[13:49:30.0685] CheckHFS returned 0, fsmodified = 0
[13:49:30.0685] executing /sbin/mount_hfs
[13:49:30.0685] mount_hfs: Could not exec re-keying daemon /usr/libexec/rolld: No such file or directory
[13:49:30.0685] /dev/disk0s1s2 mounted on /mnt2
[13:49:30.0685] entering dump_panic_logs
[13:49:30.0685] executing /System/Library/CoreServices/DumpPanic
[13:49:30.0685] SYSLOG: Sep 22 13:44:48 localhost kernel[0] <Notice>: [ANS syslog: nand] Util_HostXXXXXXXXXng to read element=PANICLOG not yet written, returning ERR_ABORT
[13:49:30.0685] SYSLOG: Sep 22 13:44:48 localhost kernel[0] <Notice>: disk3: invalid argument.
[13:49:30.0685] SYSLOG: Sep 22 13:44:48 localhost DumpPanic[16] <Error>: no panic data detected from /dev/rdisk3
[13:49:30.0685] entering check_for_ota_logs_with_mount_point
[13:49:30.0685] restore log does not exist
[13:49:30.0685] skipping log submission, failed to read user settings from: /mnt2/mobile/Library/ConfigurationProfiles/EffectiveUserSettings.plist
[13:49:30.0685] Diagnostic log submission disabled
[13:49:30.0685] Searching /mnt2/mobile/Library/Logs/CrashReporter/
[13:49:30.0685] check_for_ota_logs_with_mount_point complete
[13:49:30.0685] Successfully checked for OTA logs
[13:49:30.0685] __AMSupportHttpCopyProxySettings_block_invoke: Proxy available
[13:49:30.0685] __AMSupportHttpCopyProxySettings_block_invoke: AMSupportHttpCopyProxySettings: RPNotificationProxyAvailable
[13:49:30.0685] AMSupportHttpCopyProxySettings: proxyInfo = <CFBasicHash 0x1266075a0 [0x100b627d8]>{type = mutable dict, count = 2,
[13:49:30.0685] entries =>
[13:49:30.0685] 0 : <CFString 0x100b3e860 [0x100b627d8]>{contents = "SOCKSProxy"} = <CFString 0x100600c40 [0x100b627d8]>{contents = "127.0.0.1"}
[13:49:30.0685] 1 : <CFString 0x100b3e880 [0x100b627d8]>{contents = "SOCKSPort"} = <CFNumber 0xb<<<<<IMEI>>>>>> [0x100b627d8]>{value = +1081, type = kCFNumberSInt32Type}
[13:49:30.0685] }
[13:49:30.0685] calling UMEventShimSubmitEvents
[13:49:30.0685] SYSLOG: Sep 22 13:44:48 localhost restored_external[6] <Warning>: unable to create support directory: Error Domain=NSCocoaErrorDomain Code=642 "(null)" UserInfo={NSFilePath=/var/db/UpdateMetrics, NSUnderlyingError=0x12651a2d0 {Error Domain=NSPOSIXErrorDomain Code=30 "Read-only file system"}}
[13:49:30.0685] UMEventShimSubmitEvents done
[13:49:30.0685] entering unmount_filesystems
[13:49:30.0685] create_baseband_update_options: Got imeisv: 12
[13:49:30.0685] baseband updater options = <CFBasicHash 0x1266081f0 [0x100b627d8]>{type = mutable dict, count = 4,
[13:49:30.0685] entries =>
[13:49:30.0685] 0 : <CFString 0x101790ec0 [0x100b627d8]>{contents = "IMEISwVersion"} = <CFNumber 0x<<<<<MEID>>>>>c2 [0x100b627d8]>{value = +12, type = kCFNumberSInt32Type}
[13:49:30.0685] 1 : <CFString 0x101790e80 [0x100b627d8]>{contents = "restoredInternal"} = <CFBoolean 0x100b62d20 [0x100b627d8]>{value = false}
[13:49:30.0685] 2 : <CFString 0x101790fe0 [0x100b627d8]>{contents = "autoSetupEnv"} = <CFBoolean 0x100b62d20 [0x100b627d8]>{value = false}
[13:49:30.0685] 6 : <CFString 0x101791000 [0x100b627d8]>{contents = "disablePing"} = <CFBoolean 0x100b62d10 [0x100b627d8]>{value = true}
[13:49:30.0685] }
[13:49:30.0685] _baseband_update_requires_filesystems_once: querying baseband to determine if it requires system filesystem
[13:49:30.0685] bbupdater: cmdCopyRequirePartitionMount: supports flashless 1
[13:49:30.0685] bbupdater: cmdCopyRequirePartitionMount: supports REFS 0
[13:49:30.0685] bbupdater: cmdCopyRequirePartitionMount: need data partition for coredumps
[13:49:30.0685] _baseband_update_requires_filesystems_once: query returned <CFBasicHash 0x1266082d0 [0x100b627d8]>{type = mutable dict, count = 3,
[13:49:30.0685] entries =>
[13:49:30.0685] 0 : <CFString 0x101790880 [0x100b627d8]>{contents = "requireUserPartitionMount"} = <CFBoolean 0x100b62d10 [0x100b627d8]>{value = true}
[13:49:30.0685] 1 : <CFString 0x1017908a0 [0x100b627d8]>{contents = "requestedBasebandFSPartitionMountSize"} = <CFNumber 0xb<<<<<IMEI>>>>>> [0x100b627d8]>{value = +0, type = kCFNumberSInt64Type}
[13:49:30.0685] 2 : <CFString 0x101790840 [0x100b627d8]>{contents = "requireSystemPartitionMount"} = <CFBoolean 0x100b62d10 [0x100b627d8]>{value = true}
[13:49:30.0685] }
[13:49:30.0685] entering clean_NAND
[13:49:30.0685] SYSLOG: Sep 22 13:44:48 localhost kernel[0] <Notice>: ASPStorage:XXXXXXXXXdOnly - Ramdisk rooted. Returning readonly false
[13:49:30.0685] SYSLOG: Sep 22 13:44:48 localhost kernel[0] <Notice>: [ANS syslog: nand] Format_LBA:Format_LBA. Request size 0 lba, param 0
[13:49:30.0685] SYSLOG: Sep 22 13:44:48 localhost kernel[0] <Notice>: [ANS syslog: nand] Util_ClogClear:Format_LBA. Clear Clog. Major 15, Minor 1. Resetting to Major 255, Minor 255
[13:49:30.0685] SYSLOG: Sep 22 13:44:48 localhost kernel[0] <Notice>: [ANS syslog: nand] Format_Send_Unmap_AllXXXXXXXXXg All LBAs
[13:49:30.0685] SYSLOG: Sep 22 13:44:49 localhost kernel[0] <Notice>: [ANS syslog: nand] Push_PowerGovernorInit:Nand Die:2 MLC: 2 No SLC: 2 No Erase:2
[13:49:30.0685] SYSLOG: Sep 22 13:44:49 localhost kernel[0] <Notice>: [ANS syslog: nand] Format_UserArea:Format_UserArea. updateCapaticy: 1
[13:49:30.0685] SYSLOG: Sep 22 13:44:49 localhost kernel[0] <Notice>: [ANS syslog: nand] Format_UserArea:Format_UserArea. indMemoryInHeap: 4096 KB
[13:49:30.0685] SYSLOG: Sep 22 13:44:49 localhost kernel[0] <Notice>: [ANS syslog: nand] Format_LBA:Format_LBA. Format CLog
[13:49:30.0685] SYSLOG: Sep 22 13:44:49 localhost kernel[0] <Notice>: [ANS syslog: nand] Clog_Format:Format_LBA. Reset Clog. Major 255, Minor 255
[13:49:30.0685] SYSLOG: Sep 22 13:44:49 localhost kernel[0] <Notice>: ASPStorage:XXXXXXXXXeometry - NAND Geometry info:
[13:49:30.0685] SYSLOG: Sep 22 13:44:49 localhost kernel[0] <Notice>: ASPStorage:XXXXXXXXXeometry - Num LBAs : 3906250
[13:49:30.0685] SYSLOG: Sep 22 13:44:49 localhost kernel[0] <Notice>: ASPStorage:XXXXXXXXXeometry - Bytes per LBA : 4096
[13:49:30.0685] SYSLOG: Sep 22 13:44:49 localhost kernel[0] <Notice>: ASPStorage:XXXXXXXXXeometry - Preferred buffer size: 65536
[13:49:30.0685] SYSLOG: Sep 22 13:44:49 localhost kernel[0] <Notice>: ASPStorage:XXXXXXXXXeometry - lbaFormatted : YES
[13:49:30.0685] SYSLOG: Sep 22 13:44:49 localhost kernel[0] <Notice>: ASPStorage:XXXXXXXXXeometry - utilFormatted : YES
[13:49:30.0685] SYSLOG: Sep 22 13:44:49 localhost kernel[0] <Notice>: ASPStorage:XXXXXXXXXBAFormat - Ramdisk rooted. Sending kASPUpdateMediaParams
[13:49:30.0685] SYSLOG: Sep 22 13:44:49 localhost kernel[0] <Notice>: ASPStorage:XXXXXXXXXdOnly - Ramdisk rooted. Returning readonly false
[13:49:30.0685] SYSLOG: Sep 22 13:44:49 localhost kernel[0] <Notice>: ASPStorageXXXXXXXXXXXXXXXXXXXXdisk - Root device is md0
[13:49:30.0685] SYSLOG: Sep 22 13:44:49 localhost kernel[0] <Notice>: ASPStorageXXXXXXXXXXXXXXXXXXXXdisk - Root device is a ramdisk
[13:49:30.0685] SYSLOG: Sep 22 13:44:49 localhost kernel[0] <Notice>: IOFirmwareDevice:XXXXXXXXXdiaParams - prev num blks 1024 new num blks 1024
[13:49:30.0685] SYSLOG: Sep 22 13:44:49 localhost kernel[0] <Notice>: ASPStorage:XXXXXXXXXdOnly - Ramdisk rooted. Returning readonly false
[13:49:30.0685] SYSLOG: Sep 22 13:44:49 localhost kernel[0] <Notice>: ASPStorage:XXXXXXXXXdOnly - Ramdisk rooted. Returning readonly false
[13:49:30.0685] SYSLOG: Sep 22 13:44:49 localhost kernel[0] <Notice>: ASPStorage:XXXXXXXXXdOnly - Ramdisk rooted. Returning readonly false
[13:49:30.0685] SYSLOG: Sep 22 13:44:49 localhost kernel[0] <Notice>: ASPStorage:XXXXXXXXXdOnly - Ramdisk rooted. Returning readonly false
[13:49:30.0685] NAND format complete
[13:49:30.0685] entering ramrod_probe_media
[13:49:30.0685] find_filesystem_partitions: storage=/dev/disk0 system= data= baseband data= log=
[13:49:30.0685] entering format_effaceable_storage
[13:49:30.0685] effaceable storage is formatted, clearing it
[13:49:30.0685] effaceable storaged cleared
[13:49:30.0685] entering format_storage_for_LwVM
[13:49:30.0685] no-lwvm-offset-mgmt property not found
[13:49:30.0685] entering ramrod_probe_media
[13:49:30.0685] device partitioning scheme is GPT
[13:49:30.0685] unexpected partition 'LwVM' - skipping
[13:49:30.0685] find_filesystem_partitions: storage=/dev/disk0s1 system= data= baseband data= log=
[13:49:30.0685] entering create_filesystem_partitions
[13:49:30.0685] User specified system partition size, skipping firmware extras size.
[13:49:30.0685] system partition padding size is: 167772160 bytes
[13:49:30.0685] unable to open : No such file or directory
[13:49:30.0685] creating 2 partitions
[13:49:30.0685] creating encrypted data partition
[13:49:30.0685] entering ramrod_probe_media
[13:49:30.0685] device partitioning scheme is GPT
[13:49:30.0685] find_filesystem_partitions: storage=/dev/disk0s1 system=/dev/disk0s1s1 data=/dev/disk0s1s2 baseband data= log=
[13:49:30.0685] wipe entire partition: 1 (old = 0 new = 2848)
[13:49:30.0685] block size for /dev/disk0s1s1: 4096
[13:49:30.0685] /sbin/newfs_hfs -s -v System -J /dev/disk0s1s1
[13:49:30.0685] executing /sbin/newfs_hfs -s -v System -J /dev/disk0s1s1
[13:49:30.0685] Initialized /dev/rdisk0s1s1 as a 3 GB caseXXXXXXXXXe HFS Plus volume with a 8192k journal
[13:49:30.0685] block size for /dev/disk0s1s2: 4096
[13:49:30.0685] /sbin/newfs_hfs -s -v Data -J -P /dev/disk0s1s2
[13:49:30.0685] executing /sbin/newfs_hfs -s -v Data -J -P /dev/disk0s1s2
[13:49:30.0685] Initialized /dev/rdisk0s1s2 as a 12 GB caseXXXXXXXXXe HFS Plus volume with a 8192k journal
[13:49:30.0685] entering ramrod_probe_media
[13:49:30.0685] device partitioning scheme is GPT
[13:49:30.0685] find_filesystem_partitions: storage=/dev/disk0s1 system=/dev/disk0s1s1 data=/dev/disk0s1s2 baseband data= log=
[13:49:30.0685] entering mount_filesystems
[13:49:30.0685] executing /sbin/fsck_hfs
[13:49:30.0685] journal_replay(/dev/disk0s1s1) returned 0
[13:49:30.0685] ** /dev/rdisk0s1s1
[13:49:30.0685] Using cacheBlockSize=32K cacheTotalBlock=4000 cacheSize=128000K.
[13:49:30.0685] Executing fsck_hfs (version hfs-305.1.1).
[13:49:30.0685] ** Checking Journaled HFS Plus volume.
[13:49:30.0685] ** Detected a caseXXXXXXXXXe volume.
[13:49:30.0685] The volume name is System
[13:49:30.0685] ** Checking extents overflow file.
[13:49:30.0685] ** Checking catalog file.
[13:49:30.0685] ** Checking multi-linked files.
[13:49:30.0685] ** Checking catalog hierarchy.
[13:49:30.0685] ** Checking extended attributes file.
[13:49:30.0685] ** Checking volume bitmap.
[13:49:30.0685] ** Checking volume information.
[13:49:30.0685] ** Trimming unused blocks.
[13:49:30.0685] ** The volume System appears to be OK.
[13:49:30.0685] CheckHFS returned 0, fsmodified = 0
[13:49:30.0685] executing /sbin/mount_hfs
[13:49:30.0685] /dev/disk0s1s1 mounted on /mnt1
[13:49:30.0685] executing /sbin/fsck_hfs
[13:49:30.0685] journal_replay(/dev/disk0s1s2) returned 0
[13:49:30.0685] ** /dev/rdisk0s1s2
[13:49:30.0685] Using cacheBlockSize=32K cacheTotalBlock=4000 cacheSize=128000K.
[13:49:30.0685] Executing fsck_hfs (version hfs-305.1.1).
[13:49:30.0685] ** Checking Journaled HFS Plus volume.
[13:49:30.0685] ** Detected a caseXXXXXXXXXe volume.
[13:49:30.0685] The volume name is Data
[13:49:30.0685] ** Checking extents overflow file.
[13:49:30.0685] ** Checking catalog file.
[13:49:30.0685] ** Checking multi-linked files.
[13:49:30.0685] ** Checking catalog hierarchy.
[13:49:30.0685] ** Checking extended attributes file.
[13:49:30.0685] ** Checking volume bitmap.
[13:49:30.0685] ** Checking volume information.
[13:49:30.0685] ** Trimming unused blocks.
[13:49:30.0685] ** The volume Data appears to be OK.
[13:49:30.0685] CheckHFS returned 0, fsmodified = 0
[13:49:30.0685] executing /sbin/mount_hfs
[13:49:30.0685] mount_hfs: Could not exec re-keying daemon /usr/libexec/rolld: No such file or directory
[13:49:30.0685] /dev/disk0s1s2 mounted on /mnt2
[13:49:30.0685] entering resize_system_partition_to_options
[13:49:30.0685] User specified system partition size, skipping firmware extras size.
[13:49:30.0685] Found SystemPartitionPadding value of 167772160 bytes
[13:49:30.0685] Erasing system partition prior to resize operation.
[13:49:30.0685] block size for /dev/disk0s1s1: 4096
[13:49:30.0685] /sbin/newfs_hfs -s -v System -J /dev/disk0s1s1
[13:49:30.0685] executing /sbin/newfs_hfs -s -v System -J /dev/disk0s1s1
[13:49:30.0685] Initialized /dev/rdisk0s1s1 as a 3 GB caseXXXXXXXXXe HFS Plus volume with a 8192k journal
[13:49:30.0685] executing /sbin/fsck_hfs
[13:49:30.0685] journal_replay(/dev/disk0s1s1) returned 0
[13:49:30.0685] ** /dev/rdisk0s1s1
[13:49:30.0685] Using cacheBlockSize=32K cacheTotalBlock=4000 cacheSize=128000K.
[13:49:30.0685] Executing fsck_hfs (version hfs-305.1.1).
[13:49:30.0685] ** Checking Journaled HFS Plus volume.
[13:49:30.0685] ** Detected a caseXXXXXXXXXe volume.
[13:49:30.0685] The volume name is System
[13:49:30.0685] ** Checking extents overflow file.
[13:49:30.0685] ** Checking catalog file.
[13:49:30.0685] ** Checking multi-linked files.
[13:49:30.0685] ** Checking catalog hierarchy.
[13:49:30.0685] ** Checking extended attributes file.
[13:49:30.0685] ** Checking volume bitmap.
[13:49:30.0685] ** Checking volume information.
[13:49:30.0685] ** Trimming unused blocks.
[13:49:30.0685] ** The volume System appears to be OK.
[13:49:30.0685] CheckHFS returned 0, fsmodified = 0
[13:49:30.0685] executing /sbin/mount_hfs
[13:49:30.0685] /dev/disk0s1s1 mounted on /mnt1
[13:49:30.0685] Trying to resize system partition to 2986344448 bytes aka 2848 MB
[13:49:30.0685] entering adjust_partition_preflight
[13:49:30.0685] partition:0 requiredSize=729088
[13:49:30.0685] no change in size
[13:49:30.0685] Successfully resized the system partition
[13:49:30.0685] entering maximize_data_partition
[13:49:30.0685] entering adjust_partition_preflight
[13:49:30.0685] partition:1 requiredSize=<<<<<IMEI>>>>>>6
[13:49:30.0685] maximizing data partition to 12868124671 bytes
[13:49:30.0685] entering adjust_partition_preflight
[13:49:30.0685] partition:1 requiredSize=3141632
[13:49:30.0685] no change in size
[13:49:30.0685] Successfully resized data partition to consume free blocks
[13:49:30.0685] The system partition now has a total HFS+ capacity of 2848 MB
[13:49:30.0685] entering ramrod_probe_media
[13:49:30.0685] device partitioning scheme is GPT
[13:49:30.0685] find_filesystem_partitions: storage=/dev/disk0s1 system=/dev/disk0s1s1 data=/dev/disk0s1s2 baseband data= log=
[13:49:30.0685] entering unmount_filesystems
[13:49:30.0685] entering restore_images
[13:49:30.0685] Successfully marked device node /dev/rdisk0s1s1 as static data
[13:49:30.0685] executing /usr/sbin/asrSYSLOG: Sep 22 13:44:54 localhost kernel[0] <Notice>: void AppleUSBDeviceMuxXXXXXXXXXXXXXXXXXXXXt(struct BulkUSBMuxSession *, errno_t) new session to port 12345 failed: 61
[13:49:30.0685] -source asr://localhost:12345 -target /dev/disk0s1s1 -erase XXXXXXXXX -XXXXXXXXXcksum -XXXXXXXXXrings
[13:49:30.0685] SYSLOG: Sep 22 13:44:54 localhost asr[29] <Error>: bootstrap_look_up2 failed with 0x44e
[13:49:30.0685] ASR: asr: Unable to disable idle sleep - XXXXXXXXX9
[13:49:30.0685] ASR STATUS: start 242.6 multicast-client
[13:49:30.0685] ASR: Waiting for connection attempt from server
[13:49:30.0685] SYSLOG: Sep 22 13:44:54 localhost asr[29] <Error>: __net_helper_get_connection_block_invoke_3 could not connect to networkd
[13:49:30.0685] ASR STATUS: setup
[13:49:30.0685] ASR: Validating target...
[13:49:30.0685] ASR: done
[13:49:30.0685] ASR STATUS: metadata
[13:49:30.0685] ASR: Validating source...
[13:49:30.0685] ASR: done
[13:49:30.0685] ASR: Retrieving scan information...
[13:49:30.0685] ASR: done
[13:49:30.0685] ASR: Validating sizes...
[13:49:30.0685] ASR: done
[13:49:30.0685] ASR STATUS: restore
[13:49:30.0685] ASR RESTORE PROGRESS: 2%
[13:49:30.0685] ASR RESTORE PROGRESS: 4%
[13:49:30.0685] ASR RESTORE PROGRESS: 6%
[13:49:30.0685] ASR RESTORE PROGRESS: 8%
[13:49:30.0685] ASR RESTORE PROGRESS: 10%
[13:49:30.0685] ASR RESTORE PROGRESS: 12%
[13:49:30.0685] ASR RESTORE PROGRESS: 14%
[13:49:30.0685] ASR RESTORE PROGRESS: 16%
[13:49:30.0685] ASR RESTORE PROGRESS: 18%
[13:49:30.0685] ASR RESTORE PROGRESS: 20%
[13:49:30.0685] ASR RESTORE PROGRESS: 22%
[13:49:30.0685] ASR RESTORE PROGRESS: 24%
[13:49:30.0685] ASR RESTORE PROGRESS: 26%
[13:49:30.0685] ASR RESTORE PROGRESS: 28%
[13:49:30.0685] ASR RESTORE PROGRESS: 30%
[13:49:30.0685] ASR RESTORE PROGRESS: 32%
[13:49:30.0685] ASR RESTORE PROGRESS: 34%
[13:49:30.0685] ASR RESTORE PROGRESS: 36%
[13:49:30.0685] ASR RESTORE PROGRESS: 38%
[13:49:30.0685] ASR RESTORE PROGRESS: 40%
[13:49:30.0685] ASR RESTORE PROGRESS: 42%
[13:49:30.0685] ASR RESTORE PROGRESS: 44%
[13:49:30.0685] ASR RESTORE PROGRESS: 46%
[13:49:30.0685] ASR RESTORE PROGRESS: 48%
[13:49:30.0685] ASR RESTORE PROGRESS: 50%
[13:49:30.0685] ASR RESTORE PROGRESS: 52%
[13:49:30.0685] ASR RESTORE PROGRESS: 54%
[13:49:30.0685] ASR RESTORE PROGRESS: 56%
[13:49:30.0685] ASR RESTORE PROGRESS: 58%
[13:49:30.0685] ASR RESTORE PROGRESS: 60%
[13:49:30.0685] ASR RESTORE PROGRESS: 62%
[13:49:30.0685] ASR RESTORE PROGRESS: 64%
[13:49:30.0685] ASR RESTORE PROGRESS: 66%
[13:49:30.0685] ASR RESTORE PROGRESS: 68%
[13:49:30.0685] ASR RESTORE PROGRESS: 70%
[13:49:30.0685] ASR RESTORE PROGRESS: 72%
[13:49:30.0685] ASR RESTORE PROGRESS: 74%
[13:49:30.0685] ASR RESTORE PROGRESS: 76%
[13:49:30.0685] ASR RESTORE PROGRESS: 78%
[13:49:30.0685] ASR RESTORE PROGRESS: 80%
[13:49:30.0685] ASR RESTORE PROGRESS: 82%
[13:49:30.0685] ASR RESTORE PROGRESS: 84%
[13:49:30.0685] ASR RESTORE PROGRESS: 86%
[13:49:30.0685] ASR RESTORE PROGRESS: 88%
[13:49:30.0685] ASR RESTORE PROGRESS: 90%
[13:49:30.0685] ASR RESTORE PROGRESS: 92%
[13:49:30.0685] ASR RESTORE PROGRESS: 94%
[13:49:30.0685] ASR RESTORE PROGRESS: 96%
[13:49:30.0685] ASR RESTORE PROGRESS: 98%
[13:49:30.0685] SYSLOG: Sep 22 13:46:14 localhost asr[29] <Error>: CFPreferences could not connect to its daemon.
[13:49:30.0685] Preferences using the connection 0x0 will be volatile and will not be persisted to disk.
[13:49:30.0685] SYSLOG: Sep 22 13:46:14 localhost asr[29] <Critical>: securityd_message_with_reply_sync Failed to talk to secd after 4 attempts.
[13:49:30.0685] SYSLOG: Sep 22 13:46:14 localhost asr[29] <Critical>: securityd_message_with_reply_sync Failed to talk to secd after 4 attempts.
[13:49:30.0685] SYSLOG: Sep 22 13:46:14 localhost asr[29] <Error>: SecTrustEvaluate
[13:49:30.0685] SYSLOG: Sep 22 13:46:14 localhost asr[29] <Critical>: securityd_message_with_reply_sync Failed to talk to secd after 4 attempts.
[13:49:30.0685] SYSLOG: Sep 22 13:46:14 localhost asr[29] <Critical>: securityd_message_with_reply_sync Failed to talk to secd after 4 attempts.
[13:49:30.0685] SYSLOG: Sep 22 13:46:14 localhost asr[29] <Error>: SecTrustEvaluate
[13:49:30.0685] ASR RESTORE PROGRESS: 100%
[13:49:30.0685] ASR: Copied 2818908672 bytes in 68.73 seconds, 40050.42 KiB/s
[13:49:30.0685] ASR STATUS: verify
[13:49:30.0685] ASR VERIFY PROGRESS: 2%
[13:49:30.0685] ASR VERIFY PROGRESS: 4%
[13:49:30.0685] ASR VERIFY PROGRESS: 6%
[13:49:30.0685] ASR VERIFY PROGRESS: 8%
[13:49:30.0685] ASR VERIFY PROGRESS: 10%
[13:49:30.0685] ASR VERIFY PROGRESS: 12%
[13:49:30.0685] ASR VERIFY PROGRESS: 14%
[13:49:30.0685] ASR VERIFY PROGRESS: 16%
[13:49:30.0685] ASR VERIFY PROGRESS: 18%
[13:49:30.0685] ASR VERIFY PROGRESS: 20%
[13:49:30.0685] ASR VERIFY PROGRESS: 22%
[13:49:30.0685] ASR VERIFY PROGRESS: 24%
[13:49:30.0685] ASR VERIFY PROGRESS: 26%
[13:49:30.0685] ASR VERIFY PROGRESS: 28%
[13:49:30.0685] ASR VERIFY PROGRESS: 30%
[13:49:30.0685] ASR VERIFY PROGRESS: 32%
[13:49:30.0685] ASR VERIFY PROGRESS: 34%
[13:49:30.0685] ASR VERIFY PROGRESS: 36%
[13:49:30.0685] ASR VERIFY PROGRESS: 38%
[13:49:30.0685] ASR VERIFY PROGRESS: 40%
[13:49:30.0685] ASR VERIFY PROGRESS: 42%
[13:49:30.0685] ASR VERIFY PROGRESS: 44%
[13:49:30.0685] ASR VERIFY PROGRESS: 46%
[13:49:30.0685] ASR VERIFY PROGRESS: 48%
[13:49:30.0685] ASR VERIFY PROGRESS: 50%
[13:49:30.0685] ASR VERIFY PROGRESS: 52%
[13:49:30.0685] ASR VERIFY PROGRESS: 54%
[13:49:30.0685] ASR VERIFY PROGRESS: 56%
[13:49:30.0685] ASR VERIFY PROGRESS: 58%
[13:49:30.0685] ASR VERIFY PROGRESS: 60%
[13:49:30.0685] ASR VERIFY PROGRESS: 62%
[13:49:30.0685] ASR VERIFY PROGRESS: 64%
[13:49:30.0685] ASR VERIFY PROGRESS: 66%
[13:49:30.0685] ASR VERIFY PROGRESS: 68%
[13:49:30.0685] ASR VERIFY PROGRESS: 70%
[13:49:30.0685] ASR VERIFY PROGRESS: 72%
[13:49:30.0685] ASR VERIFY PROGRESS: 74%
[13:49:30.0685] ASR VERIFY PROGRESS: 76%
[13:49:30.0685] ASR VERIFY PROGRESS: 78%
[13:49:30.0685] ASR VERIFY PROGRESS: 80%
[13:49:30.0685] ASR VERIFY PROGRESS: 82%
[13:49:30.0685] ASR VERIFY PROGRESS: 84%
[13:49:30.0685] ASR VERIFY PROGRESS: 86%
[13:49:30.0685] ASR VERIFY PROGRESS: 88%
[13:49:30.0685] ASR VERIFY PROGRESS: 90%
[13:49:30.0685] ASR VERIFY PROGRESS: 92%
[13:49:30.0685] ASR VERIFY PROGRESS: 94%
[13:49:30.0685] ASR VERIFY PROGRESS: 96%
[13:49:30.0685] ASR VERIFY PROGRESS: 98%
[13:49:30.0685] ASR VERIFY PROGRESS: 100%
[13:49:30.0685] ASR: Verified SHA-1 checksum 2818908672 bytes in 8.37 seconds, 328731.88 KiB/s
[13:49:30.0685] ASR STATUS: finish
[13:49:30.0685] entering ramrod_probe_media
[13:49:30.0685] device partitioning scheme is GPT
[13:49:30.0685] find_filesystem_partitions: storage=/dev/disk0s1 system=/dev/disk0s1s1 data=/dev/disk0s1s2 baseband data= log=
[13:49:30.0685] entering mount_filesystems
[13:49:30.0685] executing /sbin/fsck_hfs
[13:49:30.0685] journal_replay(/dev/disk0s1s1) returned 0
[13:49:30.0685] ** /dev/rdisk0s1s1
[13:49:30.0685] Using cacheBlockSize=32K cacheTotalBlock=4000 cacheSize=128000K.
[13:49:30.0685] Executing fsck_hfs (version hfs-305.1.1).
[13:49:30.0685] ** Checking Journaled HFS Plus volume.
[13:49:30.0685] ** Detected a caseXXXXXXXXXe volume.
[13:49:30.0685] The volume name is Monarch13A344.N53OS
[13:49:30.0685] ** Checking extents overflow file.
[13:49:30.0685] ** Checking catalog file.
[13:49:30.0685] ** Checking multi-linked files.
[13:49:30.0685] ** Checking catalog hierarchy.
[13:49:30.0685] ** Checking extended attributes file.
[13:49:30.0685] ** Checking volume bitmap.
[13:49:30.0685] ** Checking volume information.
[13:49:30.0685] ** Trimming unused blocks.
[13:49:30.0685] ** The volume Monarch13A344.N53OS appears to be OK.
[13:49:30.0685] CheckHFS returned 0, fsmodified = 0
[13:49:30.0685] executing /sbin/mount_hfs
[13:49:30.0685] /dev/disk0s1s1 mounted on /mnt1
[13:49:30.0685] executing /sbin/fsck_hfs
[13:49:30.0685] journal_replay(/dev/disk0s1s2) returned 0
[13:49:30.0685] ** /dev/rdisk0s1s2
[13:49:30.0685] Using cacheBlockSize=32K cacheTotalBlock=4000 cacheSize=128000K.
[13:49:30.0685] Executing fsck_hfs (version hfs-305.1.1).
[13:49:30.0685] ** Checking Journaled HFS Plus volume.
[13:49:30.0685] ** Detected a caseXXXXXXXXXe volume.
[13:49:30.0685] The volume name is Data
[13:49:30.0685] ** Checking extents overflow file.
[13:49:30.0685] ** Checking catalog file.
[13:49:30.0685] ** Checking multi-linked files.
[13:49:30.0685] ** Checking catalog hierarchy.
[13:49:30.0685] ** Checking extended attributes file.
[13:49:30.0685] ** Checking volume bitmap.
[13:49:30.0685] ** Checking volume information.
[13:49:30.0685] ** Trimming unused blocks.
[13:49:30.0685] ** The volume Data appears to be OK.
[13:49:30.0685] CheckHFS returned 0, fsmodified = 0
[13:49:30.0685] executing /sbin/mount_hfs
[13:49:30.0685] mount_hfs: Could not exec re-keying daemon /usr/libexec/rolld: No such file or directory
[13:49:30.0685] /dev/disk0s1s2 mounted on /mnt2
[13:49:30.0685] RestoredFDRRestoreSavedData success
[13:49:30.0685] entering install_kernel_cache
[13:49:30.0685] writing kernelcache to /mnt1/System/Library/Caches/com.apple.kernelcaches/kernelcache
[13:49:30.0685] entering install_secure_vault_daemon
[13:49:30.0685] entering get_hardware_platform
[13:49:30.0685] platform-name = s5l8960x
[13:49:30.0685] linking /mnt1/usr/sbin/securekeyvaultd to /mnt1/usr/sbin/securekeyvaultd.s5l8960x
[13:49:30.0685] no securekeyvaultd for s5l8960x
[13:49:30.0685] entering ramrod_ticket_write
[13:49:30.0685] writing ticket to /mnt1/System/Library/Caches/apticket.der
[13:49:30.0685] entering RestoredFDRRecover
[13:49:30.0685] entering update_device_firmware
[13:49:30.0685] entering add_baseband_partition_options
[13:49:30.0685] entering ramrod_update_device_firmware
[13:49:30.0685] entering update_iBoot
[13:49:30.0685] entering copy_sep
[13:49:30.0685] found 'ASPStorage' object in IORegistry
[13:49:30.0685] entering update_iBoot_ASP_storage
[13:49:30.0685] entering wait_for_device: '/dev/disk1'
[13:49:30.0685] entering wait_for_device: '/dev/disk2'
[13:49:30.0685] writing 10 images to Firmware node '/dev/disk1' (preferred_block_size = 4096)
[13:49:30.0685] original data length: 644139; img4_restore_data length: 644176
[13:49:30.0685] write_data_to_fd: length=644176, preferred_block_size=4096
[13:49:30.0685] SYSLOG: Sep 22 13:46:31 localhost kernel[0] <Notice>: [ANS syslog: nand] Util_Host:element=FW written size=1101824, host request trimmed to end of written content
[13:49:30.0685] original data length: 6890; img4_restore_data length: 6927
[13:49:30.0685] write_data_to_fd: length=6927, preferred_block_size=4096
[13:49:30.0685] original data length: 156057; img4_restore_data length: 156094
[13:49:30.0685] write_data_to_fd: length=156094, preferred_block_size=4096
[13:49:30.0685] original data length: 8794; img4_restore_data length: 8831
[13:49:30.0685] write_data_to_fd: length=8831, preferred_block_size=4096
[13:49:30.0685] original data length: 14570; img4_restore_data length: 14607
[13:49:30.0685] write_data_to_fd: length=14607, preferred_block_size=4096
[13:49:30.0685] original data length: 48458; img4_restore_data length: 48495
[13:49:30.0685] write_data_to_fd: length=48495, preferred_block_size=4096
[13:49:30.0685] original data length: 88909; img4_restore_data length: 88946
[13:49:30.0685] write_data_to_fd: length=88946, preferred_block_size=4096
[13:49:30.0685] original data length: 39850; img4_restore_data length: 39887
[13:49:30.0685] write_data_to_fd: length=39887, preferred_block_size=4096
[13:49:30.0685] original data length: 11658; img4_restore_data length: 11695
[13:49:30.0685] write_data_to_fd: length=11695, preferred_block_size=4096
[13:49:30.0685] original data length: 78381; img4_restore_data length: 78418
[13:49:30.0685] write_data_to_fd: length=78418, preferred_block_size=4096
[13:49:30.0685] done with flash images - writing end of contents
[13:49:30.0685] write_data_to_fd: length=2, preferred_block_size=4096
[13:49:30.0685] SYSLOG: Sep 22 13:46:31 localhost kernel[0] <Notice>: [ANS syslog: nand] Util_FW_Host_Resize:---fwSize size 269 bytes
[13:49:30.0685] SYSLOG: Sep 22 13:46:31 localhost kernel[0] <Notice>: [ANS syslog: nand] Util_FW_Ans:[ 2, 3, 0] Wrote Firmware B with err=NO_ERROR
[13:49:30.0685] SYSLOG: Sep 22 13:46:31 localhost kernel[0] <Notice>: [ANS syslog: nand] Util_FW_Ans:[ 1, 1, 0] Wrote Firmware A with err=NO_ERROR
[13:49:30.0685] writing 1 boot images to boot block node '/dev/disk2' (preferred_block_size = 0x4096)
[13:49:30.0685] original data length: 152619; img4_restore_data length: 152656
[13:49:30.0685] write_data_to_fd: length=152656, preferred_block_size=4096
[13:49:30.0685] SYSLOG: Sep 22 13:46:32 localhost kernel[0] <Notice>: [ANS syslog: nand] Util_Host:element=LLB written size=167936, host request trimmed to end of written content
[13:49:30.0685] write_data_to_fd: length=2, preferred_block_size=4096
[13:49:30.0685] write_data_to_fd: length=3027, preferred_block_size=4096
[13:49:30.0685] done with boot images - writing end of contents
[13:49:30.0685] SYSLOG: Sep 22 13:46:32 localhost kernel[0] <Notice>: LwVM::probe - failed to read header from media
[13:49:30.0685] entering update_sep
[13:49:30.0685] writing sep firmware to /mnt1/usr/standalone/firmware/sepXXXXXXXXX.img4
[13:49:30.0685] write_data_to_fd: length=4473885, preferred_block_size=4096
[13:49:30.0685] update_sep returned: success
[13:49:30.0685] entering update_gas_gauge
[13:49:30.0685] entering update_ir_mcu
[13:49:30.0685] looking for mcu nub...no entry from path!
[13:49:30.0685] TiSerialFlasher not supported on this platform. Exiting.
[13:49:30.0685] entering update_baseband
[13:49:30.0685] update_baseband: registering for progress notifications
[13:49:30.0685] create_baseband_update_options: Got imeisv: 12
[13:49:30.0685] baseband updater options = <CFBasicHash 0x126526c10 [0x100b627d8]>{type = mutable dict, count = 8,
[13:49:30.0685] entries =>
[13:49:30.0685] 2 : <CFString 0x101790ce0 [0x100b627d8]>{contents = "SystemRoot"} = /mnt1
[13:49:30.0685] 4 : <CFString 0x101790c00 [0x100b627d8]>{contents = "DisallowFusiing"} = <CFBoolean 0x100b62d10 [0x100b627d8]>{value = true}
[13:49:30.0685] 6 : <CFString 0x101790fe0 [0x100b627d8]>{contents = "autoSetupEnv"} = <CFBoolean 0x100b62d20 [0x100b627d8]>{value = false}
[13:49:30.0685] 7 : <CFString 0x101790ba0 [0x100b627d8]>{contents = "forceUpdate"} = <CFBoolean 0x100b62d10 [0x100b627d8]>{value = true}
[13:49:30.0685] 8 : <CFString 0x101791000 [0x100b627d8]>{contents = "disablePing"} = <CFBoolean 0x100b62d10 [0x100b627d8]>{value = true}
[13:49:30.0685] 9 : <CFString 0x101790e80 [0x100b627d8]>{contents = "restoredInternal"} = <CFBoolean 0x100b62d20 [0x100b627d8]>{value = false}
[13:49:30.0685] 11 : <CFString 0x101790d00 [0x100b627d8]>{contents = "DataRoot"} = /mnt2
[13:49:30.0685] 12 : <CFString 0x101790ec0 [0x100b627d8]>{contents = "IMEISwVersion"} = <CFNumber 0x<<<<<MEID>>>>>c2 [0x100b627d8]>{value = +12, type = kCFNumberSInt32Type}
[13:49:30.0685] }
[13:49:30.0685] update_baseband: querying baseband info
[13:49:30.0685] bbupdater: BEGIN: Querying info at stage first
[13:49:30.0685] bbupdater: BEGIN: Preparing first stage
[13:49:30.0685] bbupdater: Requested boot mode: kBBUBootModeNone
[13:49:30.0685] bbupdater: Creating transport, attempts remaining 5...bbupdater: OK
[13:49:30.0685] bbupdater: END: Preparing first stage
[13:49:30.0685] bbupdater: Connecting to Loader...bbupdater: OK
[13:49:30.0685] bbupdater: Getting Version...bbupdater: OK
[13:49:30.0685] bbupdater: Loader version: PBLXXXXXXXXX2.0
[13:49:30.0685] bbupdater: Fusing disallowed, will treat as fused
[13:49:30.0685] bbupdater: END: Querying info at stage first
[13:49:30.0685] update_baseband: query returned <CFBasicHash 0x1265293f0 [0x100b627d8]>{type = mutable dict, count = 6,
[13:49:30.0685] entries =>
[13:49:30.0685] 0 : <CFString 0x1017910a0 [0x100b627d8]>{contents = "ChipID"} = <CFNumber 0x<<<<<MEID>>>>>13 [0x100b627d8]>{value = +7282913, type = kCFNumberSInt64Type}
[13:49:30.0685] 1 : <CFString 0x101791080 [0x100b627d8]>{contents = "ChipSerialNo" XXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXX XXXX
[13:49:30.0685] 2 : <CFString 0x1017913e0 [0x100b627d8]>{contents = "CertID"} = <CFNumber 0x<<<<<MEID>>>>>23 [0x100b627d8]>{value = +3554301762, type = kCFNumberSInt64Type}
[13:49:30.0685] 3 : <CFString 0x101791400 [0x100b627d8]>{contents = "VendorID"} = <CFNumber 0xb<<<<<IMEI>>>>>> [0x100b627d8]>{value = +3, type = kCFNumberSInt32Type}
[13:49:30.0685] 4 : <CFString 0x1017914a0 [0x100b627d8]>{contents = "FusingStatus"} = <CFNumber 0xb<<<<<IMEI>>>>>> [0x100b627d8]>{value = +3, type = kCFNumberSInt32Type}
[13:49:30.0685] 6 : <CFString 0x101791100 [0x100b627d8]>{contents = "CertHash"} = <CFData 0x126527900 [0x100b627d8]>{length = 32, capacity = 32, bytes = 0x<<<<<<<<ICCID>>>>>>>924d38ecceff ... <<<<<MEID>>>>>18}
[13:49:30.0685] }
[13:49:30.0685] update_baseband: requesting baseband firmware data
[13:49:30.0685] update_baseband: received data from host (107670 bytes)
[13:49:30.0685] update_baseband: performing next update stage
[13:49:30.0685] bbupdater: BEGIN: Perform stage at first
[13:49:30.0685] bbupdater: isInRegularBootMode: false
[13:49:30.0685] bbupdater: Loading...
[13:49:30.0685] bbupdater: 0x2a008400 of 0x2a01d6f0 (28 percent)
[13:49:30.0685] bbupdater: 0x2a010800 of 0x2a01d6f0 (56 percent)
[13:49:30.0685] bbupdater: 0x2a018c00 of 0x2a01d6f0 (84 percent)
[13:49:30.0685] bbupdater: 0x2a01d6f0 of 0x2a01d6f0 (100 percent)
[13:49:30.0685] bbupdater:
[13:49:30.0685] bbupdater: Launching...bbupdater: OK
[13:49:30.0685] bbupdater: END: Perform stage at first
[13:49:30.0685] send_bbupdate_status: sending baseband update status to host
[13:49:30.0685] update_baseband: querying baseband info
[13:49:30.0685] bbupdater: BEGIN: Querying info at stage second
[13:49:30.0685] bbupdater: BEGIN: Preparing Second stage
[13:49:30.0685] bbupdater: ReXXXXXXXXXe transport for second stage.
[13:49:30.0685] bbupdater: END: Preparing Second stage
[13:49:30.0685] bbupdater: isInRegularBootMode: false
[13:49:30.0685] bbupdater: BEGIN: Gathering Personalization parameters...
[13:49:30.0685] bbupdater: Waiting for Hello...bbupdater: FAILED(kBBUReturnIOError)
[13:49:30.0685] bbupdater: END(kBBUReturnNAKHello): Gathering Personalization parameters...
[13:49:30.0685] bbupdater: END(kBBUReturnNAKHello): Querying info at stage second
[13:49:30.0685] bbupdater: core dump collection disabled
[13:49:30.0685] bbupdater: BEGIN: Querying info at stage first
[13:49:30.0685] bbupdater: BEGIN: Preparing first stage
[13:49:30.0685] bbupdater: Requested boot mode: kBBUBootModeNone
[13:49:30.0685] bbupdater: Creating transport, attempts remaining 5...bbupdater: OK
[13:49:30.0685] bbupdater: END: Preparing first stage
[13:49:30.0685] bbupdater: Connecting to Loader...bbupdater: OK
[13:49:30.0685] bbupdater: Getting Version...bbupdater: OK
[13:49:30.0685] bbupdater: Loader version: PBLXXXXXXXXX2.0
[13:49:30.0685] bbupdater: END: Querying info at stage first
[13:49:30.0685] update_baseband: query returned <CFBasicHash 0x1265293f0 [0x100b627d8]>{type = mutable dict, count = 6,
[13:49:30.0685] entries =>
[13:49:30.0685] 0 : <CFString 0x1017910a0 [0x100b627d8]>{contents = "ChipID"} = <CFNumber 0x<<<<<MEID>>>>>13 [0x100b627d8]>{value = +7282913, type = kCFNumberSInt64Type}
[13:49:30.0685] 1 : <CFString 0x101791080 [0x100b627d8]>{contents = "ChipSerialNo" XXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXX XXXX
[13:49:30.0685] 2 : <CFString 0x1017913e0 [0x100b627d8]>{contents = "CertID"} = <CFNumber 0x<<<<<MEID>>>>>23 [0x100b627d8]>{value = +3554301762, type = kCFNumberSInt64Type}
[13:49:30.0685] 3 : <CFString 0x101791400 [0x100b627d8]>{contents = "VendorID"} = <CFNumber 0xb<<<<<IMEI>>>>>> [0x100b627d8]>{value = +3, type = kCFNumberSInt32Type}
[13:49:30.0685] 4 : <CFString 0x1017914a0 [0x100b627d8]>{contents = "FusingStatus"} = <CFNumber 0xb<<<<<IMEI>>>>>> [0x100b627d8]>{value = +3, type = kCFNumberSInt32Type}
[13:49:30.0685] 6 : <CFString 0x101791100 [0x100b627d8]>{contents = "CertHash"} = <CFData 0x1265276e0 [0x100b627d8]>{length = 32, capacity = 32, bytes = 0x<<<<<<<<ICCID>>>>>>>924d38ecceff ... <<<<<MEID>>>>>18}
[13:49:30.0685] }
[13:49:30.0685] update_baseband: requesting baseband firmware data
[13:49:30.0685] update_baseband: received data from host (107670 bytes)
[13:49:30.0685] update_baseband: performing next update stage
[13:49:30.0685] bbupdater: BEGIN: Perform stage at first
[13:49:30.0685] bbupdater: isInRegularBootMode: false
[13:49:30.0685] bbupdater: Loading...
[13:49:30.0685] bbupdater: 0x2a008400 of 0x2a01d6f0 (28 percent)
[13:49:30.0685] bbupdater: 0x2a010800 of 0x2a01d6f0 (56 percent)
[13:49:30.0685] bbupdater: 0x2a018c00 of 0x2a01d6f0 (84 percent)
[13:49:30.0685] bbupdater: 0x2a01d6f0 of 0x2a01d6f0 (100 percent)
[13:49:30.0685] bbupdater:
[13:49:30.0685] bbupdater: Launching...bbupdater: OK
[13:49:30.0685] bbupdater: END: Perform stage at first
[13:49:30.0685] send_bbupdate_status: sending baseband update status to host
[13:49:30.0685] update_baseband: querying baseband info
[13:49:30.0685] bbupdater: BEGIN: Querying info at stage second
[13:49:30.0685] bbupdater: BEGIN: Preparing Second stage
[13:49:30.0685] bbupdater: ReXXXXXXXXXe transport for second stage.
[13:49:30.0685] bbupdater: END: Preparing Second stage
[13:49:30.0685] bbupdater: isInRegularBootMode: false
[13:49:30.0685] bbupdater: BEGIN: Gathering Personalization parameters...
[13:49:30.0685] bbupdater: Waiting for Hello...bbupdater: FAILED(kBBUReturnIOError)
[13:49:30.0685] bbupdater: END(kBBUReturnNAKHello): Gathering Personalization parameters...
[13:49:30.0685] bbupdater: END(kBBUReturnNAKHello): Querying info at stage second
[13:49:30.0685] bbupdater: core dump collection disabled
[13:49:30.0685] send_bbupdate_status: sending baseband update status to host
[13:49:30.0685] update_baseband: calling CFNotificationCenterRemoveEveryObserver
[13:49:30.0685] update_baseband: bbupdater error: The operation couldn\U2019t be completed. (BBUpdater error 47 - Failed gatherPersonalizationParameters in second stage)
[13:49:30.0685] Update[Baseband] error - The operation couldn\U2019t be completed. (RamrodErrorDomain error 1004 - update_baseband: failed querying baseband info)
[13:49:30.0685] Update[Baseband] failed - 0 retries remaining...
[13:49:30.0685] 0: RamrodErrorDomain/3ec: update_baseband: failed querying baseband info
[13:49:30.0685] 1: BBUpdater/2f: Failed gatherPersonalizationParameters in second stage
[13:49:30.0685] unable to convert ramrod error 1004
[13:49:30.0685]
[13:49:30.0685] ==== end of device restore output ====
[13:49:30.0685] AMRAuthInstallDeletePersonalizedBundle
[13:49:30.0748] <Restore Device 000000000836D2C0>: Restore failed (result = -1)
[13:49:30.0748] Restore completed, status:-1
[13:49:30.0748] Failure Description:
[13:49:30.0748] Depth:0 Error:AMRestorePerformRestoreModeRestoreWithError failed with error: -1
[13:49:30.0748] Depth:1 Error:The operation couldn’t be completed. (AMRestoreErrorDomain error -1 - Failed to handle message type StatusMsg)
[13:49:30.0748] Depth:2 Error:The operation couldn’t be completed. (AMRestoreErrorDomain error -1 - failed to update device firmware)
[13:49:30.0748] Depth:3 Error:The operation couldn’t be completed. (AMRestoreErrorDomain error -1 - ramrod firmware update failed)
[13:49:30.0748] Depth:4 Error:The operation couldn’t be completed. (RamrodErrorDomain error 1004 - update_baseband: failed querying baseband info)
[13:49:30.0748] Depth:5 Error:The operation couldn’t be completed. (BBUpdater error 47 - Failed gatherPersonalizationParameters in second stage)