Jump to content

USB host controllers reset by S3 sleep-resume cycle


libotter
 Share

4 posts in this topic

Recommended Posts

I installed 10.13 on my X99 rig.

It works great but has a critical problem.

All of USB devices are disconnected and then they are re-connected when resume from S3 sleep. 

This process causes "Disk not ejected properly" error when any storage device attached to the USB port.

 

Some related messages are found:

2018-09-30 18:29:57.008858+0900 0x1647a    Default     0x0                  0      0    kernel: (IOUSBHostFamily) 005840.434471 XHC@14000000: AppleUSBHostController::hardwareExceptionThreadCallGated: 0x00000100
2018-09-30 18:29:57.011494+0900 0x1646f    Activity    0x8af8               52     0    configd: processing network kernel events
2018-09-30 18:29:57.012124+0900 0x16484    Default     0x0                  0      0    kernel: (IOBluetoothHostControllerUSBTransport) **** [IOBluetoothHostControllerUSBTransport][terminateWL] -- entering -- mCurrentInternalPowerState = SLEEP -- this = 0x4800 ****
2018-09-30 18:29:57.017348+0900 0x1646a    Default     0x0                  0      0    kernel: (AppleKeyStore) AppleKeyStore::ipc_device_state_transition: Device UnLock call(-501): lockstate=1, transientCnt=0, 87
2018-09-30 18:29:57.020232+0900 0x6f       Default     0x0                  0      0    kernel: (IOUSBMassStorageDriver) USB device 04BB100414600000 - I-O DATA, USB Flash Disk - not found during wake up
2018-09-30 18:29:57.023679+0900 0x164b6    Default     0x0                  0      0    kernel: (IOUSBHostFamily) 005840.449299 D072@00000000: AppleUSBHostController::hardwareExceptionThreadCallGated: 0x00000100
2018-09-30 18:29:57.025847+0900 0x164b9    Default     0x0                  0      0    kernel: (AirPortBrcmNIC) ARPT: 5840.451469: ChangeVCO => vco:960, xtalF:40, frac: 98, ndivMode: 3, ndivint: 24
2018-09-30 18:29:57.025858+0900 0x164b9    Default     0x0                  0      0    kernel: (AirPortBrcmNIC) ARPT: 5840.451483: Data written into the PLL_CNTRL_ADDR2: 00000c31
2018-09-30 18:29:57.025877+0900 0x164b9    Default     0x0                  0      0    kernel: (AirPortBrcmNIC) ARPT: 5840.451501: Data written into the PLL_CNTRL_ADDR3 (Fractional): 0000100e
2018-09-30 18:29:57.026431+0900 0x164b6    Default     0x0                  0      0    kernel: (IOUSBHostFamily) 005840.452043 D072@00000000: AppleUSBHostController::hardwareExceptionThreadCallGated: attempting recovery
2018-09-30 18:29:57.037995+0900 0x164e3    Default     0x0                  0      0    kernel: (IOStorageFamily) disk4s2: media is not present.
2018-09-30 18:29:57.038033+0900 0x164e3    Default     0x0                  0      0    kernel: (IOStorageFamily) disk4s2: media is not present.
2018-09-30 18:29:57.038060+0900 0x164e3    Default     0x0                  0      0    kernel: (IOStorageFamily) disk4s2: media is not present.
2018-09-30 18:29:57.038083+0900 0x164e3    Default     0x0                  0      0    kernel: (IOStorageFamily) disk4s2: media is not present.
2018-09-30 18:29:57.038110+0900 0x164e3    Default     0x0                  0      0    kernel: (msdosfs) msdosfs_fat_uninit_vol: error 6 from msdosfs_fat_cache_flush
2018-09-30 18:29:57.038385+0900 0x1646a    Default     0x0                  0      0    kernel: (AppleKeyStore) AppleKeyStore: operation failed (pid: 87 sel: 9 ret: e00002ce '-536870194', 501, 100007)
2018-09-30 18:29:57.053588+0900 0x16532    Default     0x0                  0      0    kernel: (AppleCredentialManager) ACM: findCredentialSet: returning, err = -2.
2018-09-30 18:29:57.053603+0900 0x16532    Default     0x0                  0      0    kernel: (AppleCredentialManager) ACM: createCredentialSet: Credential set created, CS[109].
2018-09-30 18:29:57.054687+0900 0x16532    Default     0x0                  0      0    kernel: (AppleCredentialManager) ACM: verifyPolicy: Verifying policy DeviceOwnerAuthenticationWithBiometrics, checkKeybagUUID = No, CS[109].
2018-09-30 18:29:57.054702+0900 0x16532    Default     0x0                  0      0    kernel: (AppleCredentialManager) ACM: verifyPolicy: Policy satisfied = No, CS[109].
2018-09-30 18:29:57.056258+0900 0x16532    Default     0x0                  0      0    kernel: (AppleCredentialManager) ACM: deleteCredentialSet: Deleting credential set, CS[109].
2018-09-30 18:29:57.066021+0900 0x1646f    Activity    0x8afd               52     0    configd: processing network kernel events
2018-09-30 18:29:57.066077+0900 0x1646f    Activity    0x8afe               52     0    configd: processing network kernel events
2018-09-30 18:29:57.066263+0900 0x1646f    Activity    0x8aff               52     0    configd: processing network kernel events
2018-09-30 18:29:57.066299+0900 0x1646f    Activity    0x8b10               52     0    configd: processing network kernel events
2018-09-30 18:29:57.066475+0900 0x1646f    Activity    0x8b11               52     0    configd: processing network kernel events
2018-09-30 18:29:57.066726+0900 0x1646f    Activity    0x8b12               52     0    configd: processing network kernel events
2018-09-30 18:29:57.088028+0900 0x5e0      Default     0x0                  0      0    kernel: IOConsoleUsers: time(1) 1538299749->1538299749, lin 1, llk 1,
2018-09-30 18:29:57.088043+0900 0x5e0      Default     0x0                  0      0    kernel: IOConsoleUsers: gIOScreenLockState 3, hs 0, bs 0, now 1538299797, sm 0x0
2018-09-30 18:29:57.185420+0900 0x1e47     Activity    0x8b1c               52     0    configd: processing network kernel events
2018-09-30 18:29:57.186432+0900 0x16482    Default     0x0                  0      0    kernel: (kernel) AppleIGB::startTxQueue()
2018-09-30 18:29:57.186533+0900 0x1e47     Activity    0x8b1d               52     0    configd: processing network kernel events
2018-09-30 18:29:57.223999+0900 0x16484    Default     0x0                  0      0    kernel: (IOBluetoothHostControllerUSBTransport) **** [IOBluetoothHostControllerUSBTransport][terminateWL] -- exiting -- (matched on Device) -- this = 0x4800 ****
2018-09-30 18:29:57.225207+0900 0x1647a    Default     0x0                  0      0    kernel: (IOUSBHostFamily) 005840.650822 XHC@14000000: AppleUSBHostController::hardwareExceptionThreadCallGated: attempting recovery
2018-09-30 18:29:57.315168+0900 0x163f0    Default     0x0                  0      0    kernel: (IO80211Family) AirPort: Link Up on awdl0
2018-09-30 18:29:57.315244+0900 0x1646f    Activity    0x8b1e               52     0    configd: processing network kernel events
2018-09-30 18:29:57.316383+0900 0x163f0    Default     0x0                  0      0    kernel: (IO80211Family) en0: channel changed to 1
2018-09-30 18:29:57.318670+0900 0x449      Default     0x0                  0      0    kernel: (IO80211Family) Setting BTCoex Config: enable_2G:1, profile_2g:0, enable_5G:1, profile_5G:0
2018-09-30 18:29:57.320706+0900 0x1646f    Activity    0x8b1f               52     0    configd: processing network kernel events
2018-09-30 18:29:57.323191+0900 0x1646f    Activity    0x8b50               52     0    configd: processing network kernel events
2018-09-30 18:29:57.336696+0900 0x163f5    Activity    0x8b53               52     0    configd: processing network kernel events
2018-09-30 18:29:57.354935+0900 0x547      Default     0x0                  0      0    kernel: (IO80211Family) com.apple.p2p: updateLocalRequests[10360] : AWDL will be turned ON by x99tclocal AAAA advertise, Called from mDNSResponder (pid 168)
2018-09-30 18:29:57.356417+0900 0x547      Default     0x0                  0      0    kernel: (IO80211Family) com.apple.p2p: updateLocalRequests[10360] : AWDL will be turned ON by a49c47efff23934100000000000008efip6arpa PTR advertise, Called from mDNSResponder (pid 168)
2018-09-30 18:29:57.358441+0900 0x163f5    Activity    0x8b58               52     0    configd: processing network kernel events
2018-09-30 18:29:57.358485+0900 0x163f5    Activity    0x8b59               52     0    configd: processing network kernel events
2018-09-30 18:29:57.358548+0900 0x16465    Activity    0x8b5a               52     0    configd: processing network kernel events
2018-09-30 18:29:57.358589+0900 0x16465    Activity    0x8b5b               52     0    configd: processing network kernel events
2018-09-30 18:29:57.507207+0900 0x1e65     Default     0x0                  0      0    kernel: (IO80211Family) en0: 802.11d country code set to 'JP'.
2018-09-30 18:29:57.507281+0900 0x1e65     Default     0x0                  0      0    kernel: (IO80211Family) en0: Supported channels 1 2 3 4 5 6 7 8 9 10 11 12 13 36 40 44 48 52 56 60 64 100 104 108 112 116 120 124 128 132 136 140
2018-09-30 18:29:57.523278+0900 0x16580    Default     0x0                  0      0    kernel: (IO80211Family) com.apple.p2p: IO80211AWDLPeerManager::setAwdlOperatingMode Setting the AWDL operation mode from AUTO to SUSPENDED
2018-09-30 18:29:57.523285+0900 0x16580    Default     0x0                  0      0    kernel: (IO80211Family) com.apple.p2p: AWDL is suspended
2018-09-30 18:29:57.562664+0900 0x16580    Default     0x0                  0      0    kernel: (AirPortBrcmNIC) ARPT: 5840.988284: wl0: setCIPHER_KEY: key == NULL, clear keys
2018-09-30 18:29:57.563088+0900 0x16580    Default     0x0                  0      0    kernel: (IO80211Family) en0: Terminating supplicant.
2018-09-30 18:29:57.563107+0900 0x16580    Default     0x0                  0      0    kernel: (IO80211Family) RSNSupplicant: Releasing authenticator for 74:03:bd:6c:70:a7
2018-09-30 18:29:57.563125+0900 0x16580    Default     0x0                  0      0    kernel: (IO80211Family) parseRSNIE: groupCipherType = 5 pairwiseCipherType = 5 authSel = 2
2018-09-30 18:29:57.563138+0900 0x16580    Default     0x0                  0      0    kernel: (IO80211Family) initWithInterfaceAndIE: _myMacAddress ac:bc:32:a4:e7:29
2018-09-30 18:29:57.563148+0900 0x16580    Default     0x0                  0      0    kernel: (IO80211Family) setPMK: PMK SET!
2018-09-30 18:29:57.695919+0900 0x25c      Default     0x0                  0      0    kernel: (AirPortBrcmNIC) ARPT: 5841.121538: txpwr advertised by STA: min 6dbm max 32dbm
2018-09-30 18:29:57.709868+0900 0x1645b    Default     0x0                  0      0    kernel: (IO80211Family) AirPort: Link Up on en0
2018-09-30 18:29:57.709891+0900 0x163f5    Activity    0x8b5f               52     0    configd: processing network kernel events
2018-09-30 18:29:57.710164+0900 0x1645b    Default     0x0                  0      0    kernel: (IO80211Family) en0: BSSID changed to 74:03:bd:6c:70:a7
2018-09-30 18:29:57.710195+0900 0x1645b    Default     0x0                  0      0    kernel: (IO80211Family) en0: channel changed to 116,80
2018-09-30 18:29:57.710208+0900 0x1645b    Default     0x0                  0      0    kernel: (IO80211Family) en0::IO80211Interface::postMessage bssid changed
2018-09-30 18:29:57.710685+0900 0x163f5    Activity    0x8bb0               52     0    configd: processing network kernel events
2018-09-30 18:29:57.711809+0900 0x25c      Default     0x0                  0      0    kernel: (IO80211Family) en0: Received EAPOL packet (length = 135)
2018-09-30 18:29:57.711819+0900 0x25c      Default     0x0                  0      0    kernel: (IO80211Family) inputEAPOLFrame: 0 extra bytes present in EAPOL frame.
2018-09-30 18:29:57.711823+0900 0x25c      Default     0x0                  0      0    kernel: (IO80211Family) inputEAPOLFrame: Received message 1 of 4

 

What does the return value 0x00000100 mean?

Why does macOS attempt to mount the USB storage device before initializing of the host controller???

 

I tried to fix this problem but I have absolutely no idea at all. Please help me. 

Edited by libotter
Link to comment
Share on other sites

Thank you for your reply.

 

Enabling/Disabling XMP doesn't work on my rig...

I'm not using any kext to inject USB properties because I want to keep the OS clean and vanilla.

So, I add some SSDT tables to inject them (I forgot to upload, sorry!)

Link to comment
Share on other sites

 Share

×
×
  • Create New...