Jump to content

Slow Shutdown


JDubU

Recommended Posts

  • Replies 54
  • Created
  • Last Reply

Top Posters In This Topic

Is there any new insight on the reason for extremely slow shutdown (several minutes)?

Are there any fixes to try?

 

D630, Nvidia, BIOS A18

EDP 4R7

OS 10.8.2

 

My D630 Nvidia does the exact same, I dont know why. Also if I tell it to restart, the bios takes ages when its starts back up again to load.

 

Seb

Link to comment
Share on other sites

Looking at the system log, I can see what is causing the delay but don't know enough about the internals to know why. It is attempting to rebuild the kextcache but is failing and then retrying. On the fifth failed try, it gives up and allows the reboot. It looks like AppleHDA and AppleACPIEC are involved in the problem.

 

Here are the system log entries for the last rebuild try:

 

 

9/23/12 11:45:11.256 AM com.apple.kextd[12]: kextcache error while updating / (error count: 4)

9/23/12 11:45:11.258 AM com.apple.kextd[12]: / is still busy, delaying reboot.

9/23/12 11:45:11.260 AM com.apple.kextd[12]: async child pid 916 exited with status 71

9/23/12 11:45:11.292 AM com.apple.kextcache[918]: rebuilding /System/Library/Caches/com.apple.kext.caches/Startup/kernelcache

9/23/12 11:45:11.775 AM com.apple.kextcache[919]: AppleTyMCEDriver.kext has no Info.plist file.

9/23/12 11:45:11.777 AM com.apple.kextcache[919]: AppleUpstreamUserClient.kext has no Info.plist file.

9/23/12 11:45:12.786 AM com.apple.kextcache[919]: AppleTyMCEDriver.kext has no Info.plist file.

9/23/12 11:45:12.787 AM com.apple.kextcache[919]: AppleUpstreamUserClient.kext has no Info.plist file.

9/23/12 11:45:51.152 AM com.apple.kextcache[919]: kxld[com.apple.driver.AppleHDA]: The following symbols are unresolved for this kext:

9/23/12 11:45:51.153 AM com.apple.kextcache[919]: kxld[com.apple.driver.AppleHDA]: IOAF_bcopy_WriteCombine(void const*, void*, unsigned int)

9/23/12 11:45:51.153 AM com.apple.kextcache[919]: kxld[com.apple.driver.AppleHDA]: DspAlgorithms::bcopyStride2(float const*, int, float*, int, int)

9/23/12 11:45:51.154 AM com.apple.kextcache[919]: kxld[com.apple.driver.AppleHDA]: DspAlgorithms::mBufferBytesPerChannel

9/23/12 11:45:51.154 AM com.apple.kextcache[919]: kxld[com.apple.driver.AppleHDA]: DspAlgorithms::downMixStereoToMonoStride(float const*, int, float*, int, unsigned int)

9/23/12 11:45:51.154 AM com.apple.kextcache[919]: kxld[com.apple.driver.AppleHDA]: DspFuncHelper::convertNanosToPercent(unsigned long long, unsigned long long, float*)

9/23/12 11:45:51.155 AM com.apple.kextcache[919]: kxld[com.apple.driver.AppleHDA]: DspFuncManager::setClientType(unsigned int)

9/23/12 11:45:51.155 AM com.apple.kextcache[919]: kxld[com.apple.driver.AppleHDA]: DspFuncManager::engineStarting()

9/23/12 11:45:51.156 AM com.apple.kextcache[919]: kxld[com.apple.driver.AppleHDA]: DspFuncManager::engineStopping()

9/23/12 11:45:51.156 AM com.apple.kextcache[919]: kxld[com.apple.driver.AppleHDA]: DspFuncManager::engineReStarting()

9/23/12 11:45:51.156 AM com.apple.kextcache[919]: kxld[com.apple.driver.AppleHDA]: DspFuncManager::getClientPGASetting()

9/23/12 11:45:51.157 AM com.apple.kextcache[919]: kxld[com.apple.driver.AppleHDA]: DspFuncManager::getClientPGABoostSetting()

9/23/12 11:45:51.157 AM com.apple.kextcache[919]: kxld[com.apple.driver.AppleHDA]: DspFuncManager::setGainAdjustDSPProperties()

9/23/12 11:45:51.158 AM com.apple.kextcache[919]: kxld[com.apple.driver.AppleHDA]: DspFuncManager::process(void const*, unsigned int, void const*, unsigned int, unsigned int, unsigned int, unsigned int, unsigned int)

9/23/12 11:45:51.159 AM com.apple.kextcache[919]: kxld[com.apple.driver.AppleHDA]: AppleHDAController::claimSinkDevice(unsigned int, IOService*)

9/23/12 11:45:51.159 AM com.apple.kextcache[919]: kxld[com.apple.driver.AppleHDA]: AppleHDAController::updateVideoMode(unsigned int, IOService*, HDAGFXModeStruct*)

9/23/12 11:45:51.160 AM com.apple.kextcache[919]: kxld[com.apple.driver.AppleHDA]: AppleHDAController::requestBandwidth(unsigned int, IOService*, unsigned int)

9/23/12 11:45:51.160 AM com.apple.kextcache[919]: kxld[com.apple.driver.AppleHDA]: AppleHDAController::releaseSinkDevice(unsigned int, IOService*)

9/23/12 11:45:51.161 AM com.apple.kextcache[919]: kxld[com.apple.driver.AppleHDA]: AppleHDAController::alwaysDisplayRouting()

9/23/12 11:45:51.161 AM com.apple.kextcache[919]: kxld[com.apple.driver.AppleHDA]: AppleHDAController::verifySinkDeviceAttached(unsigned int, IOService*)

9/23/12 11:45:51.183 AM com.apple.kextcache[919]: Link failed (error code 5).

9/23/12 11:45:51.185 AM com.apple.kextcache[919]: Prelink failed for com.apple.driver.AppleHDA; omitting from prelinked kernel.

9/23/12 11:45:52.897 AM com.apple.kextcache[919]: kxld[com.apple.driver.AppleACPIEC]: The following symbols are unresolved for this kext:

9/23/12 11:45:52.897 AM com.apple.kextcache[919]: kxld[com.apple.driver.AppleACPIEC]: _AcpiHwRead

9/23/12 11:45:52.898 AM com.apple.kextcache[919]: kxld[com.apple.driver.AppleACPIEC]: _AcpiHwWrite

9/23/12 11:45:52.916 AM com.apple.kextcache[919]: Link failed (error code 5).

9/23/12 11:45:52.917 AM com.apple.kextcache[919]: Prelink failed for com.apple.driver.AppleACPIEC; aborting prelink.

9/23/12 11:45:52.941 AM com.apple.kextcache[919]: Failed to generate prelinked kernel.

9/23/12 11:45:52.976 AM com.apple.kextcache[918]: Child process /usr/sbin/kextcache[919] exited with status 71.

9/23/12 11:45:52.977 AM com.apple.kextcache[918]: Error 107 rebuilding /System/Library/Caches/com.apple.kext.caches/Startup/kernelcache.

9/23/12 11:45:52.978 AM com.apple.kextd[12]: kextcache error while updating / (error count: 5)

9/23/12 11:45:52.979 AM com.apple.kextd[12]: /: giving up; kextcache hit max failures

9/23/12 11:45:52.979 AM com.apple.kextd[12]: up to date; unblocking reboot.

Link to comment
Share on other sites

Looking at the system log, I can see what is causing the delay but don't know enough about the internals to know why. It is attempting to rebuild the kextcache but is failing and then retrying. On the fifth failed try, it gives up and allows the reboot. It looks like AppleHDA and AppleACPIEC are involved in the problem.

 

Here are the system log entries for the last rebuild try:

 

 

9/23/12 11:45:11.256 AM com.apple.kextd[12]: kextcache error while updating / (error count: 4)

9/23/12 11:45:11.258 AM com.apple.kextd[12]: / is still busy, delaying reboot.

9/23/12 11:45:11.260 AM com.apple.kextd[12]: async child pid 916 exited with status 71

9/23/12 11:45:11.292 AM com.apple.kextcache[918]: rebuilding /System/Library/Caches/com.apple.kext.caches/Startup/kernelcache

9/23/12 11:45:11.775 AM com.apple.kextcache[919]: AppleTyMCEDriver.kext has no Info.plist file.

9/23/12 11:45:11.777 AM com.apple.kextcache[919]: AppleUpstreamUserClient.kext has no Info.plist file.

9/23/12 11:45:12.786 AM com.apple.kextcache[919]: AppleTyMCEDriver.kext has no Info.plist file.

9/23/12 11:45:12.787 AM com.apple.kextcache[919]: AppleUpstreamUserClient.kext has no Info.plist file.

9/23/12 11:45:51.152 AM com.apple.kextcache[919]: kxld[com.apple.driver.AppleHDA]: The following symbols are unresolved for this kext:

9/23/12 11:45:51.153 AM com.apple.kextcache[919]: kxld[com.apple.driver.AppleHDA]: IOAF_bcopy_WriteCombine(void const*, void*, unsigned int)

9/23/12 11:45:51.153 AM com.apple.kextcache[919]: kxld[com.apple.driver.AppleHDA]: DspAlgorithms::bcopyStride2(float const*, int, float*, int, int)

9/23/12 11:45:51.154 AM com.apple.kextcache[919]: kxld[com.apple.driver.AppleHDA]: DspAlgorithms::mBufferBytesPerChannel

9/23/12 11:45:51.154 AM com.apple.kextcache[919]: kxld[com.apple.driver.AppleHDA]: DspAlgorithms::downMixStereoToMonoStride(float const*, int, float*, int, unsigned int)

9/23/12 11:45:51.154 AM com.apple.kextcache[919]: kxld[com.apple.driver.AppleHDA]: DspFuncHelper::convertNanosToPercent(unsigned long long, unsigned long long, float*)

9/23/12 11:45:51.155 AM com.apple.kextcache[919]: kxld[com.apple.driver.AppleHDA]: DspFuncManager::setClientType(unsigned int)

9/23/12 11:45:51.155 AM com.apple.kextcache[919]: kxld[com.apple.driver.AppleHDA]: DspFuncManager::engineStarting()

9/23/12 11:45:51.156 AM com.apple.kextcache[919]: kxld[com.apple.driver.AppleHDA]: DspFuncManager::engineStopping()

9/23/12 11:45:51.156 AM com.apple.kextcache[919]: kxld[com.apple.driver.AppleHDA]: DspFuncManager::engineReStarting()

9/23/12 11:45:51.156 AM com.apple.kextcache[919]: kxld[com.apple.driver.AppleHDA]: DspFuncManager::getClientPGASetting()

9/23/12 11:45:51.157 AM com.apple.kextcache[919]: kxld[com.apple.driver.AppleHDA]: DspFuncManager::getClientPGABoostSetting()

9/23/12 11:45:51.157 AM com.apple.kextcache[919]: kxld[com.apple.driver.AppleHDA]: DspFuncManager::setGainAdjustDSPProperties()

9/23/12 11:45:51.158 AM com.apple.kextcache[919]: kxld[com.apple.driver.AppleHDA]: DspFuncManager::process(void const*, unsigned int, void const*, unsigned int, unsigned int, unsigned int, unsigned int, unsigned int)

9/23/12 11:45:51.159 AM com.apple.kextcache[919]: kxld[com.apple.driver.AppleHDA]: AppleHDAController::claimSinkDevice(unsigned int, IOService*)

9/23/12 11:45:51.159 AM com.apple.kextcache[919]: kxld[com.apple.driver.AppleHDA]: AppleHDAController::updateVideoMode(unsigned int, IOService*, HDAGFXModeStruct*)

9/23/12 11:45:51.160 AM com.apple.kextcache[919]: kxld[com.apple.driver.AppleHDA]: AppleHDAController::requestBandwidth(unsigned int, IOService*, unsigned int)

9/23/12 11:45:51.160 AM com.apple.kextcache[919]: kxld[com.apple.driver.AppleHDA]: AppleHDAController::releaseSinkDevice(unsigned int, IOService*)

9/23/12 11:45:51.161 AM com.apple.kextcache[919]: kxld[com.apple.driver.AppleHDA]: AppleHDAController::alwaysDisplayRouting()

9/23/12 11:45:51.161 AM com.apple.kextcache[919]: kxld[com.apple.driver.AppleHDA]: AppleHDAController::verifySinkDeviceAttached(unsigned int, IOService*)

9/23/12 11:45:51.183 AM com.apple.kextcache[919]: Link failed (error code 5).

9/23/12 11:45:51.185 AM com.apple.kextcache[919]: Prelink failed for com.apple.driver.AppleHDA; omitting from prelinked kernel.

9/23/12 11:45:52.897 AM com.apple.kextcache[919]: kxld[com.apple.driver.AppleACPIEC]: The following symbols are unresolved for this kext:

9/23/12 11:45:52.897 AM com.apple.kextcache[919]: kxld[com.apple.driver.AppleACPIEC]: _AcpiHwRead

9/23/12 11:45:52.898 AM com.apple.kextcache[919]: kxld[com.apple.driver.AppleACPIEC]: _AcpiHwWrite

9/23/12 11:45:52.916 AM com.apple.kextcache[919]: Link failed (error code 5).

9/23/12 11:45:52.917 AM com.apple.kextcache[919]: Prelink failed for com.apple.driver.AppleACPIEC; aborting prelink.

9/23/12 11:45:52.941 AM com.apple.kextcache[919]: Failed to generate prelinked kernel.

9/23/12 11:45:52.976 AM com.apple.kextcache[918]: Child process /usr/sbin/kextcache[919] exited with status 71.

9/23/12 11:45:52.977 AM com.apple.kextcache[918]: Error 107 rebuilding /System/Library/Caches/com.apple.kext.caches/Startup/kernelcache.

9/23/12 11:45:52.978 AM com.apple.kextd[12]: kextcache error while updating / (error count: 5)

9/23/12 11:45:52.979 AM com.apple.kextd[12]: /: giving up; kextcache hit max failures

9/23/12 11:45:52.979 AM com.apple.kextd[12]: up to date; unblocking reboot.

 

And I also noticed every time I boot up my D630, kextcache process takes about 99% cpu regenerating kext caches. Even if I havent changed the kext cache - it gets quite annoying!

 

Seb

Link to comment
Share on other sites

I am a total novice at this but just comparing the info.plist files for the AppleHDA.kext packages in S/L/E vs. E/E, it looks like they are very, very different. I wonder if the E/E AppleHDA.kext is based on a very old Apple version that is just not compatible with the Mountain Lion version and cannot be resolved during kextcaching?

 

I don't know what the AppleACPIEC error is about. I don't see that file in either of the Extension folders.

 

Does anyone know how this stuff is supposed to fit together?

Link to comment
Share on other sites

I had not tried to play any movies before running MyHack to remove the kexts so I don't know if they were causing a problem. Video playback seems to be working fine now.

 

I've run MyFix many times. It does not solve the slow shutdown problem.

 

My guess is that the two kexts (in Extra folder from EDP) still listed in the log (AppleHDA and AppleACPI) are not fully compatible with OS 10.8.x so the kernel caching operation is not able to merge/link them into the cache. Every time the system is shut down, it tries to rebuild the kernel cache but fails on these two kexts -- trying five times before bailing out. The slowdown is the time it takes to make these failed attempts.

Link to comment
Share on other sites

sometimes osx rebuilds the caches on shut down so it takes a little longer to shut down.

 

My D630 rebuilds the kext cache every time it boots, and it refuses to shut down if it is doing it. It takes about 5/10 minutes to do, and puts the CPU at 90-100% load...

 

Any solutions? Use Kernel Cache is set to YES.

 

Seb

Link to comment
Share on other sites


×
×
  • Create New...