External hard drive frequently spinning up during sleep

Discussion in 'OS X El Capitan (10.11)' started by Mikel30, Oct 23, 2015.

  1. Mikel30 macrumors member

    Joined:
    Jan 11, 2004
    #1
    I have a Mac mini that I keep an external hard drive attached to. Recently I installed some online backup software that continuously uploads your changed files (including external drives). Around this time I noticed that the hard drive was spinning up and accessing data frequently. Usually just for a second or two at a time, roughly 1-2 minutes apart.

    I assumed the backup software was looking for changes. I contacted their support, but they told me their software doesn't work that way. That it would spin up the hard drive for indexing about once an hour. Skeptical, I uninstalled the software (using their uninstaller) to see if the problem continue. And it did. So perhaps the software isn't to blame.

    I tried disabling "Power Nap", but the hard drive still would spin up. Next I disabled "wake for network access", and this fixed the problem. But why? I would have thought that the backup software was waking the computer to upload files, but that software isn't even on my computer anymore. What else would be causing the computer to wake up that often, and spin up the hard drive with it?
     
  2. JonD25 macrumors 6502

    Joined:
    Feb 9, 2006
    #2
    I'm experiencing the exact same thing, but it's not even just my external since I can hear the internal spinning up even with the external drives ejected and unplugged. It even happens if I log out of my account first. Have you had any luck figuring it out?
     
  3. Mikel30 thread starter macrumors member

    Joined:
    Jan 11, 2004
    #3
    No, I haven't been able to figure it out. Do you have any backup software installed like I did? Or any other non-standard apps? Maybe together we can isolate it to a common application.
     
  4. chabig macrumors 68040

    Joined:
    Sep 6, 2002
    #4
    Look in your system log to find out what was going on at a particular time.
     
  5. JonD25 macrumors 6502

    Joined:
    Feb 9, 2006
    #5
    I'm using Crashplan for backup software, but wouldn't this be inactive if I'm currently logged out? I also set it to "pause" backups before going to sleep, which I guess doesn't mean it's not still accessing the hard drive, but who knows. Other than that, background apps I have running include Dropbox, Plex Media Server (although I quit that before sleeping and it didn't change anything), 1Password, Adobe Creative Cloud, Fantastical, and iStat Menus. But again, if I'm logged out and it's still occurring, it doesn't make sense that it would be any running apps does it?

    Ok, I don't really have much experience with this, but when I read your message I remembered the Console app. I pulled up the system log, inserted a marker, set the computer to sleep and let it sit while I heard the hard drives spin down briefly, then back up, then back down, then back up again. I woke it back up and inserted another marker. Here is the resulting log in between the two markers. If you can make any sense of it, please let me know!

    Code:
    11/1/15 1:40:36.189 PM    CommCenter[386]    Telling CSI to go low power.
    11/1/15 1:40:36.191 PM    AirPlayUIAgent[358]    2015-11-01 01:40:36.190680 PM [AirPlayUIAgent] BecomingInactive: NSWorkspaceWillSleepNotification
    11/1/15 1:40:36.191 PM    CrashPlan menu bar[396]    ** WE ARE __NOT__ CONNECTED **
    11/1/15 1:40:36.196 PM    sharingd[325]    13:40:36.196 : BTLE scanner Powered Off
    11/1/15 1:40:36.197 PM    sharingd[325]    13:40:36.196 : BTLE scanner Powered Off
    11/1/15 1:40:37.302 PM    identityservicesd[329]    <IMMacNotificationCenterManager: 0x7fb85ae6b6d0>: notification observer: com.apple.iChat   notification: __CFNotification 0x7fb85ac3f760 {name = _NSDoNotDisturbEnabledNotification}
    11/1/15 1:40:37.303 PM    imagent[359]    <IMMacNotificationCenterManager: 0x7fd78a52b1d0>: notification observer: com.apple.FaceTime   notification: __CFNotification 0x7fd78ca26ba0 {name = _NSDoNotDisturbEnabledNotification}
    11/1/15 1:40:37.310 PM    sharingd[325]    13:40:37.310 : Purged contact hashes
    11/1/15 1:40:37.311 PM    sharingd[325]    13:40:37.310 : Discoverable mode changed to Off
    11/1/15 1:40:37.311 PM    sharingd[325]    13:40:37.310 : BTLE scanning stopped
    11/1/15 1:40:37.312 PM    identityservicesd[329]    <IMMacNotificationCenterManager: 0x7fb85ae6b6d0>:    NC Disabled: NO
    11/1/15 1:40:37.317 PM    identityservicesd[329]    <IMMacNotificationCenterManager: 0x7fb85ae6b6d0>:   DND Enabled: YES
    11/1/15 1:40:37.317 PM    imagent[359]    <IMMacNotificationCenterManager: 0x7fd78a52b1d0>:    NC Disabled: NO
    11/1/15 1:40:37.317 PM    identityservicesd[329]    <IMMacNotificationCenterManager: 0x7fb85ae6b6d0>: Updating enabled: NO   (Topics: (
    ))
    11/1/15 1:40:37.320 PM    imagent[359]    <IMMacNotificationCenterManager: 0x7fd78a52b1d0>:   DND Enabled: YES
    11/1/15 1:40:37.320 PM    imagent[359]    <IMMacNotificationCenterManager: 0x7fd78a52b1d0>: Updating enabled: NO   (Topics: (
    ))
    11/1/15 1:40:37.489 PM    WindowServer[163]    device_generate_desktop_screenshot: authw 0x7fd412ad9000(2000), shield 0x7fd416883c00(2001)
    11/1/15 1:40:37.489 PM    WindowServer[163]    device_generate_lock_screen_screenshot: authw 0x7fd412ad9000(2000)[0, 0, 0, 0] shield 0x7fd416883c00(2001), dev [2560,1440]
    11/1/15 1:40:37.489 PM    WindowServer[163]    no sleep images for WillPowerOffWithImages
    11/1/15 1:40:54.000 PM    kernel[0]    PM response took 2872 ms (56, powerd)
    11/1/15 1:40:54.000 PM    kernel[0]    kern_open_file_for_direct_io(0)
    11/1/15 1:40:54.000 PM    kernel[0]    kern_open_file_for_direct_io took 14 ms
    11/1/15 1:40:54.000 PM    kernel[0]    Opened file /var/log/SleepWakeStacks.bin, size 172032, extents 2, maxio 2000000 ssd 1
    11/1/15 1:40:54.000 PM    kernel[0]    polled file major 1, minor 0, blocksize 4096, pollers 5
    11/1/15 1:40:54.000 PM    kernel[0]    ARPT: 5908.161341: AirPort_Brcm43xx::powerChange: System Sleep
    11/1/15 1:40:54.000 PM    kernel[0]    ARPT: 5908.663467: IOPMPowerSource Information: onSleep,  SleepType: Normal Sleep, 
    11/1/15 1:40:54.000 PM    kernel[0]    ARPT: 5908.663504: wl0: powerChange: *** BONJOUR/MDNS OFFLOADS ARE NOT RUNNING.
    11/1/15 1:40:54.000 PM    kernel[0]    AirPort: Link Down on awdl0. Reason 1 (Unspecified).
    11/1/15 1:40:54.000 PM    kernel[0]    en1: BSSID changed to 00:1d:d1:2d:e2:c0
    11/1/15 1:40:54.000 PM    kernel[0]    en1: channel changed to 11
    11/1/15 1:40:54.000 PM    kernel[0]    ARPT: 5908.715183: wl0: leaveModulePoweredForOffloads: Wi-Fi will turn off.
    11/1/15 1:40:54.000 PM    kernel[0]    in6_unlink_ifa: IPv6 address 0x8982a16aae841ce5 has no prefix
    11/1/15 1:40:54.000 PM    kernel[0]    AirPort: Link Down on en1. Reason 8 (Disassociated because station leaving).
    11/1/15 1:40:54.000 PM    kernel[0]    en1::IO80211Interface::postMessage bssid changed
    11/1/15 1:40:54.000 PM    kernel[0]    en1: 802.11d country code set to 'X0'.
    11/1/15 1:40:54.000 PM    kernel[0]    en1: 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 144 149 153 157 161 165
    11/1/15 1:40:54.000 PM    kernel[0]    ARPT: 5908.750105: AirPort_Brcm43xx::syncPowerState: WWEN[disabled]
    11/1/15 1:40:54.711 PM    symptomsd[224]    -[NetworkAnalyticsEngine _writeJournalRecord:fromCellFingerprint:key:atLOI:ofKind:lqm:isFaulty:] Hashing of the primary key failed. Dropping the journal record.
    11/1/15 1:40:54.718 PM    airportd[61]    _handleLinkEvent: WiFi is not powered. Resetting state variables.
    11/1/15 1:40:55.000 PM    kernel[0]    AppleThunderboltNHIType2::waitForOk2Go2Sx - intel_rp = 1 dlla_reporting_supported = 1
    11/1/15 1:40:55.000 PM    kernel[0]    AppleThunderboltNHIType2::waitForOk2Go2Sx - retries = 4025
    11/1/15 1:40:58.000 PM    kernel[0]    Wake reason: XHC1
    11/1/15 1:40:58.000 PM    kernel[0]    Previous sleep cause: 5
    11/1/15 1:40:58.000 PM    kernel[0]    AppleThunderboltNHIType2::prePCIWake - power up complete - took 3 us
    11/1/15 1:40:58.000 PM    kernel[0]    AppleThunderboltGenericHAL::earlyWake - complete - took 1 milliseconds
    11/1/15 1:40:58.000 PM    kernel[0]    IOThunderboltSwitch<0>(0x0)::listenerCallback - Thunderbolt HPD packet for route = 0x0 port = 11 unplug = 0
    11/1/15 1:40:58.000 PM    kernel[0]    IOThunderboltSwitch<0>(0x0)::listenerCallback - Thunderbolt HPD packet for route = 0x0 port = 12 unplug = 0
    11/1/15 1:40:58.000 PM    kernel[0]    TBT W (2): 0x0000 [x]
    11/1/15 1:40:58.000 PM    kernel[0]    en1: channel changed to 1
    11/1/15 1:40:58.000 PM    kernel[0]    AirPort: Link Up on awdl0
    11/1/15 1:40:58.000 PM    kernel[0]    Setting BTCoex Config: enable_2G:1, profile_2g:0, enable_5G:1, profile_5G:0
    11/1/15 1:40:58.000 PM    kernel[0]    IO80211AWDLPeerManager::setAwdlOperatingMode Setting the AWDL operation mode from AUTO to SUSPENDED
    11/1/15 1:40:58.000 PM    kernel[0]    IO80211AWDLPeerManager::setAwdlSuspendedMode() Suspending AWDL, enterQuietMode(true)
    11/1/15 1:40:58.000 PM    kernel[0]    en1: 802.11d country code set to 'US'.
    11/1/15 1:40:58.000 PM    kernel[0]    en1: Supported channels 1 2 3 4 5 6 7 8 9 10 11 36 40 44 48 52 56 60 64 100 104 108 112 116 120 124 128 132 136 140 144 149 153 157 161 165
    11/1/15 1:40:58.000 PM    kernel[0]    AirPort: Link Up on en1
    11/1/15 1:40:58.000 PM    kernel[0]    en1: BSSID changed to 00:1d:d1:2d:e2:c0
    11/1/15 1:40:58.000 PM    kernel[0]    en1: channel changed to 11
    11/1/15 1:40:58.000 PM    kernel[0]    en1::IO80211Interface::postMessage bssid changed
    11/1/15 1:40:58.000 PM    kernel[0]    in6_unlink_ifa: IPv6 address 0x8982a16acff48a05 has no prefix
    11/1/15 1:40:58.475 PM    configd[54]    LINKLOCAL en1: parent has no IP
    11/1/15 1:40:58.484 PM    UserEventAgent[44]    Captive: CNPluginHandler en1: Inactive
    11/1/15 1:40:58.484 PM    configd[54]    network changed: v4(en1-:10.0.0.13) v6(en1-:2601:1c2:500:c95e:ba09:8aff:fecc:a225) DNS- Proxy-
    11/1/15 1:40:58.509 PM    symptomsd[224]    -[NetworkAnalyticsEngine _writeJournalRecord:fromCellFingerprint:key:atLOI:ofKind:lqm:isFaulty:] Hashing of the primary key failed. Dropping the journal record.
    11/1/15 1:40:58.522 PM    networkd[196]    -[NETClientConnection effectiveBundleID] using process name uc as bundle ID (this is expected for daemons without bundle ID
    11/1/15 1:40:58.524 PM    networkd[196]    -[NETClientConnection effectiveBundleID] using process name uc as bundle ID (this is expected for daemons without bundle ID
    11/1/15 1:40:58.000 PM    kernel[0]    Unexpected payload found for message 9, dataLen 0
    11/1/15 1:40:58.644 PM    Dock[313]    -[UABestAppSuggestionManager notifyBestAppChanged:type:options:bundleIdentifier:activityType:dynamicIdentifier:when:confidence:deviceName:deviceIdentifier:deviceType:] (null) UASuggestedActionType=0 (null)/(null) opts=(null) when=2015-11-01 21:40:58 +0000 confidence=1 from=(null)/(null) (UABestAppSuggestionManager.m #319)
    11/1/15 1:40:58.000 PM    kernel[0]    AirPort: RSN handshake complete on en1
    11/1/15 1:40:58.724 PM    configd[54]    network changed: DNS* Proxy
    11/1/15 1:40:58.726 PM    UserEventAgent[44]    Captive: [CNInfoNetworkActive:1748] en1: SSID 'HOME-E2C2' making interface primary (protected network)
    11/1/15 1:40:58.726 PM    UserEventAgent[44]    Captive: CNPluginHandler en1: Evaluating
    11/1/15 1:40:58.727 PM    UserEventAgent[44]    Captive: en1: Probing 'HOME-E2C2'
    11/1/15 1:40:58.739 PM    configd[54]    network changed: v4(en1!:10.0.0.13) DNS+ Proxy+ SMB
    11/1/15 1:40:58.839 PM    UserEventAgent[44]    Captive: CNPluginHandler en1: Authenticated
    11/1/15 1:40:58.865 PM    hidd[101]    [HID] [MT] MTSimpleHIDManager::deviceDidBootload device bootloaded
    11/1/15 1:41:00.000 PM    kernel[0]    ARPT: 5912.134555: AirPort_Brcm43xx::powerChange: System Wake - Full Wake/ Dark Wake / Maintenance wake
    11/1/15 1:41:00.000 PM    kernel[0]    ARPT: 5912.636699: IOPMPowerSource Information: onWake,  SleepType: Normal Sleep, 
    11/1/15 1:41:00.000 PM    kernel[0]    ARPT: 5912.636801: AirPort_Brcm43xx::platformWoWEnable: WWEN[disable]
    11/1/15 1:41:02.167 PM    ntpd[212]    wake time set +0.767807 s
    11/1/15 1:41:06.288 PM    configd[54]    network changed: v4(en1:10.0.0.13) v6(en1+:2601:1c2:500:c95e:ba09:8aff:fecc:a225) DNS! Proxy SMB
    11/1/15 1:41:06.318 PM    configd[54]    network changed: v4(en1:10.0.0.13) v6(en1:2601:1c2:500:c95e:ba09:8aff:fecc:a225) DNS! Proxy SMB
    11/1/15 1:41:06.000 PM    kernel[0]    Setting BTCoex Config: enable_2G:1, profile_2g:1, enable_5G:1, profile_5G:0
    11/1/15 1:41:06.000 PM    kernel[0]    IO80211AWDLPeerManager::setAwdlOperatingMode Setting the AWDL operation mode from SUSPENDED to AUTO
    11/1/15 1:41:06.000 PM    kernel[0]    IO80211AWDLPeerManager::setAwdlAutoMode Resuming AWDL
    11/1/15 1:41:06.504 PM    mDNSResponder[94]    ERROR: socket closed prematurely tcpInfo->nread = 0
    11/1/15 1:41:06.505 PM    mDNSResponder[94]    ERROR: socket closed prematurely tcpInfo->nread = 0
    11/1/15 1:41:29.900 PM    loginwindow[98]    CoreAnimation: warning, deleted thread with uncommitted CATransaction; set CA_DEBUG_TRANSACTIONS=1 in environment to log backtraces.
    11/1/15 1:41:43.000 PM    kernel[0]    pci pause: SDXC
    11/1/15 1:41:46.816 PM    mDNSResponder[94]    mDNS_DeregisterInterface: Frequent transitions for interface awdl0 (FE80:0000:0000:0000:5C06:83FF:FE22:3425)
    11/1/15 1:41:46.816 PM    mDNSResponder[94]    mDNS_DeregisterInterface: Frequent transitions for interface en1 (2601:01C2:0500:C95E:BA09:8AFF:FECC:A225)
    11/1/15 1:41:48.000 PM    kernel[0]    PM response took 2075 ms (56, powerd)
    11/1/15 1:41:48.000 PM    kernel[0]    ARPT: 5959.721411: AirPort_Brcm43xx::powerChange: System Sleep
    11/1/15 1:41:49.000 PM    kernel[0]    ARPT: 5960.223526: IOPMPowerSource Information: onSleep,  SleepType: Normal Sleep, 
    11/1/15 1:41:49.000 PM    kernel[0]    ARPT: 5960.223562: wl0: powerChange: *** BONJOUR/MDNS OFFLOADS ARE NOT RUNNING.
    11/1/15 1:41:49.000 PM    kernel[0]    en1: BSSID changed to 00:1d:d1:2d:e2:c0
    11/1/15 1:41:49.000 PM    kernel[0]    en1: channel changed to 11
    11/1/15 1:41:49.000 PM    kernel[0]    AirPort: Link Down on awdl0. Reason 1 (Unspecified).
    11/1/15 1:41:49.000 PM    kernel[0]    ARPT: 5960.337061: wl0: leaveModulePoweredForOffloads: Wi-Fi will turn off.
    11/1/15 1:41:49.000 PM    kernel[0]    AirPort: Link Down on en1. Reason 8 (Disassociated because station leaving).
    11/1/15 1:41:49.000 PM    kernel[0]    en1::IO80211Interface::postMessage bssid changed
    11/1/15 1:41:49.000 PM    kernel[0]    en1: 802.11d country code set to 'X0'.
    11/1/15 1:41:49.000 PM    kernel[0]    en1: 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 144 149 153 157 161 165
    11/1/15 1:41:49.000 PM    kernel[0]    ARPT: 5960.374765: AirPort_Brcm43xx::syncPowerState: WWEN[disabled]
    11/1/15 1:41:49.000 PM    kernel[0]    in6_unlink_ifa: IPv6 address 0x8982a16acff48615 has no prefix
    11/1/15 1:41:49.392 PM    symptomsd[224]    -[NetworkAnalyticsEngine _writeJournalRecord:fromCellFingerprint:key:atLOI:ofKind:lqm:isFaulty:] Hashing of the primary key failed. Dropping the journal record.
    11/1/15 1:41:49.402 PM    airportd[61]    _handleLinkEvent: WiFi is not powered. Resetting state variables.
    11/1/15 1:41:50.000 PM    kernel[0]    AppleThunderboltNHIType2::waitForOk2Go2Sx - intel_rp = 1 dlla_reporting_supported = 1
    11/1/15 1:41:50.000 PM    kernel[0]    AppleThunderboltNHIType2::waitForOk2Go2Sx - retries = 4001
    11/1/15 1:41:53.000 PM    kernel[0]    Wake reason: XHC1
    11/1/15 1:41:53.000 PM    kernel[0]    Previous sleep cause: 5
    11/1/15 1:41:53.000 PM    kernel[0]    AppleThunderboltNHIType2::prePCIWake - power up complete - took 113 us
    11/1/15 1:41:53.000 PM    kernel[0]    AppleThunderboltGenericHAL::earlyWake - complete - took 1 milliseconds
    11/1/15 1:41:53.000 PM    kernel[0]    IOThunderboltSwitch<0>(0x0)::listenerCallback - Thunderbolt HPD packet for route = 0x0 port = 11 unplug = 0
    11/1/15 1:41:53.000 PM    kernel[0]    IOThunderboltSwitch<0>(0x0)::listenerCallback - Thunderbolt HPD packet for route = 0x0 port = 12 unplug = 0
    11/1/15 1:41:53.000 PM    kernel[0]    TBT W (2): 0x0001 [√]
    11/1/15 1:41:53.000 PM    kernel[0]    TBT: +-o 0@0x0 LCA (0x0000)
    11/1/15 1:41:53.000 PM    kernel[0]    TBT: +-o 0@0x0 LCB (0x0001) LSRx change
    11/1/15 1:41:53.000 PM    kernel[0]    en1: channel changed to 1
    11/1/15 1:41:53.000 PM    kernel[0]    AirPort: Link Up on awdl0
    11/1/15 1:41:53.000 PM    kernel[0]    Setting BTCoex Config: enable_2G:1, profile_2g:0, enable_5G:1, profile_5G:0
    11/1/15 1:41:53.000 PM    kernel[0]    IO80211AWDLPeerManager::setAwdlOperatingMode Setting the AWDL operation mode from AUTO to SUSPENDED
    11/1/15 1:41:53.000 PM    kernel[0]    IO80211AWDLPeerManager::setAwdlSuspendedMode() Suspending AWDL, enterQuietMode(true)
    11/1/15 1:41:53.376 PM    mDNSResponder[94]    mDNS_RegisterInterface: Frequent transitions for interface awdl0 (FE80:0000:0000:0000:5C06:83FF:FE22:3425)
    11/1/15 1:41:53.378 PM    mDNSResponder[94]    mDNS_RegisterInterface: Frequent transitions for interface en1 (FE80:0000:0000:0000:BA09:8AFF:FECC:A225)
    11/1/15 1:41:53.379 PM    mDNSResponder[94]    mDNS_RegisterInterface: Frequent transitions for interface en1 (10.0.0.13)
    11/1/15 1:41:53.000 PM    kernel[0]    AirPort: Link Up on en1
    11/1/15 1:41:53.000 PM    kernel[0]    en1: BSSID changed to 00:1d:d1:2d:e2:c0
    11/1/15 1:41:53.000 PM    kernel[0]    en1: channel changed to 11
    11/1/15 1:41:53.000 PM    kernel[0]    en1::IO80211Interface::postMessage bssid changed
    11/1/15 1:41:53.000 PM    kernel[0]    in6_unlink_ifa: IPv6 address 0x8982a16acff484c5 has no prefix
    11/1/15 1:41:53.467 PM    configd[54]    LINKLOCAL en1: parent has no IP
    11/1/15 1:41:53.475 PM    UserEventAgent[44]    Captive: CNPluginHandler en1: Inactive
    11/1/15 1:41:53.476 PM    configd[54]    network changed: v4(en1-:10.0.0.13) v6(en1-:2601:1c2:500:c95e:ba09:8aff:fecc:a225) DNS- Proxy-
    11/1/15 1:41:53.502 PM    symptomsd[224]    -[NetworkAnalyticsEngine _writeJournalRecord:fromCellFingerprint:key:atLOI:ofKind:lqm:isFaulty:] Hashing of the primary key failed. Dropping the journal record.
    11/1/15 1:41:53.542 PM    mDNSResponder[94]    mDNS_DeregisterInterface: Frequent transitions for interface en1 (10.0.0.13)
    11/1/15 1:41:53.542 PM    mDNSResponder[94]    mDNS_RegisterInterface: Frequent transitions for interface en1 (FE80:0000:0000:0000:BA09:8AFF:FECC:A225)
    11/1/15 1:41:53.547 PM    networkd[196]    -[NETClientConnection effectiveBundleID] using process name uc as bundle ID (this is expected for daemons without bundle ID
    11/1/15 1:41:53.000 PM    kernel[0]    en1: 802.11d country code set to 'US'.
    11/1/15 1:41:53.000 PM    kernel[0]    en1: Supported channels 1 2 3 4 5 6 7 8 9 10 11 36 40 44 48 52 56 60 64 100 104 108 112 116 120 124 128 132 136 140 144 149 153 157 161 165
    11/1/15 1:41:53.550 PM    networkd[196]    -[NETClientConnection effectiveBundleID] using process name uc as bundle ID (this is expected for daemons without bundle ID
    11/1/15 1:41:53.000 PM    kernel[0]    Unexpected payload found for message 9, dataLen 0
    11/1/15 1:41:53.603 PM    Dock[313]    -[UABestAppSuggestionManager notifyBestAppChanged:type:options:bundleIdentifier:activityType:dynamicIdentifier:when:confidence:deviceName:deviceIdentifier:deviceType:] (null) UASuggestedActionType=0 (null)/(null) opts=(null) when=2015-11-01 21:41:53 +0000 confidence=1 from=(null)/(null) (UABestAppSuggestionManager.m #319)
    11/1/15 1:41:53.000 PM    kernel[0]    AirPort: RSN handshake complete on en1
    11/1/15 1:41:53.713 PM    imagent[359]    [Warning] No incoming push handler for selector: handler:isConnectedChanged:    topic: (null)   command: (null)   context: (null)
    11/1/15 1:41:53.715 PM    networkd[196]    -[NETClientConnection effectiveBundleID] using process name apsd as bundle ID (this is expected for daemons without bundle ID
    11/1/15 1:41:53.716 PM    networkd[196]    -[NETClientConnection effectiveBundleID] using process name apsd as bundle ID (this is expected for daemons without bundle ID
    11/1/15 1:41:53.741 PM    cdpd[629]    Saw change in network reachability (isReachable=0)
    11/1/15 1:41:53.742 PM    Things[450]    network reachability has changed: not reachable
    11/1/15 1:41:53.745 PM    networkd[196]    -[NETClientConnection effectiveBundleID] using process name uc as bundle ID (this is expected for daemons without bundle ID
    11/1/15 1:41:53.745 PM    Things[450]    network reachability has changed: not reachable
    11/1/15 1:41:53.746 PM    symptomsd[224]    -[NetworkAnalyticsEngine _writeJournalRecord:fromCellFingerprint:key:atLOI:ofKind:lqm:isFaulty:] Hashing of the primary key failed. Dropping the journal record.
    11/1/15 1:41:53.746 PM    symptomsd[224]    __73-[NetworkAnalyticsEngine observeValueForKeyPath:ofObject:change:context:]_block_invoke unexpected switch value 2
    11/1/15 1:41:53.749 PM    netbiosd[963]    network_reachability_changed : network is not reachable, netbiosd is shutting down
    11/1/15 1:41:53.000 PM    kernel[0]    Setting BTCoex Config: enable_2G:1, profile_2g:1, enable_5G:1, profile_5G:0
    11/1/15 1:41:53.925 PM    hidd[101]    [HID] [MT] MTSimpleHIDManager::deviceDidBootload device bootloaded
    11/1/15 1:41:55.094 PM    configd[54]    network changed: DNS* Proxy
    11/1/15 1:41:55.096 PM    UserEventAgent[44]    Captive: [CNInfoNetworkActive:1748] en1: SSID 'HOME-E2C2' making interface primary (cache indicates network not captive)
    11/1/15 1:41:55.096 PM    UserEventAgent[44]    Captive: CNPluginHandler en1: Evaluating
    11/1/15 1:41:55.100 PM    UserEventAgent[44]    Captive: en1: Not probing 'HOME-E2C2' (cache indicates not captive)
    11/1/15 1:41:55.101 PM    UserEventAgent[44]    Captive: CNPluginHandler en1: Authenticated
    11/1/15 1:41:55.108 PM    configd[54]    network changed: v4(en1!:10.0.0.13) DNS+ Proxy+ SMB
    11/1/15 1:41:55.118 PM    mDNSResponder[94]    mDNS_RegisterInterface: Frequent transitions for interface en1 (10.0.0.13)
    11/1/15 1:41:55.000 PM    kernel[0]    IO80211AWDLPeerManager::setAwdlOperatingMode Setting the AWDL operation mode from SUSPENDED to AUTO
    11/1/15 1:41:55.000 PM    kernel[0]    IO80211AWDLPeerManager::setAwdlAutoMode Resuming AWDL
    11/1/15 1:41:55.000 PM    kernel[0]    ARPT: 5963.775661: AirPort_Brcm43xx::powerChange: System Wake - Full Wake/ Dark Wake / Maintenance wake
    11/1/15 1:41:55.519 PM    Things[450]    network reachability has changed: reachable
    11/1/15 1:41:55.519 PM    cdpd[629]    Saw change in network reachability (isReachable=2)
    11/1/15 1:41:55.520 PM    Things[450]    network reachability has changed: reachable
    11/1/15 1:41:55.000 PM    kernel[0]    ARPT: 5964.277780: IOPMPowerSource Information: onWake,  SleepType: Normal Sleep, 
    11/1/15 1:41:55.000 PM    kernel[0]    ARPT: 5964.277859: AirPort_Brcm43xx::platformWoWEnable: WWEN[disable]
    11/1/15 1:41:55.846 PM    symptomsd[224]    -[NetworkAnalyticsEngine _writeJournalRecord:fromCellFingerprint:key:atLOI:ofKind:lqm:isFaulty:] Hashing of the primary key failed. Dropping the journal record.
    11/1/15 1:41:55.846 PM    symptomsd[224]    __73-[NetworkAnalyticsEngine observeValueForKeyPath:ofObject:change:context:]_block_invoke unexpected switch value 2
    11/1/15 1:41:55.886 PM    configd[54]    network changed: v4(en1:10.0.0.13) v6(en1+:2601:1c2:500:c95e:ba09:8aff:fecc:a225) DNS! Proxy SMB
    11/1/15 1:41:56.141 PM    configd[54]    network changed: v4(en1:10.0.0.13) v6(en1:2601:1c2:500:c95e:ba09:8aff:fecc:a225) DNS! Proxy SMB
    11/1/15 1:41:57.114 PM    imagent[359]    [Warning] No incoming push handler for selector: handler:isConnectedChanged:    topic: (null)   command: (null)   context: (null)
    11/1/15 1:41:58.272 PM    ntpd[212]    wake time set +0.214921 s
    11/1/15 1:42:27.000 PM    syslogd[43]    ASL Sender Statistics
    11/1/15 1:42:38.000 PM    kernel[0]    pci pause: SDXC
    11/1/15 1:42:41.555 PM    mDNSResponder[94]    mDNS_DeregisterInterface: Frequent transitions for interface awdl0 (FE80:0000:0000:0000:5C06:83FF:FE22:3425)
    11/1/15 1:42:41.555 PM    mDNSResponder[94]    mDNS_DeregisterInterface: Frequent transitions for interface en1 (2601:01C2:0500:C95E:BA09:8AFF:FECC:A225)
    11/1/15 1:42:43.000 PM    kernel[0]    PM response took 2102 ms (56, powerd)
    11/1/15 1:42:43.000 PM    kernel[0]    ARPT: 6011.390660: AirPort_Brcm43xx::powerChange: System Sleep
    11/1/15 1:42:43.000 PM    kernel[0]    ARPT: 6011.892802: IOPMPowerSource Information: onSleep,  SleepType: Normal Sleep, 
    11/1/15 1:42:43.000 PM    kernel[0]    ARPT: 6011.892839: wl0: powerChange: *** BONJOUR/MDNS OFFLOADS ARE NOT RUNNING.
    11/1/15 1:42:43.000 PM    kernel[0]    AirPort: Link Down on awdl0. Reason 1 (Unspecified).
    11/1/15 1:42:43.000 PM    kernel[0]    en1: BSSID changed to 00:1d:d1:2d:e2:c0
    11/1/15 1:42:43.000 PM    kernel[0]    en1: channel changed to 11
    11/1/15 1:42:43.000 PM    kernel[0]    ARPT: 6012.009937: wl0: leaveModulePoweredForOffloads: Wi-Fi will turn off.
    11/1/15 1:42:43.000 PM    kernel[0]    in6_unlink_ifa: IPv6 address 0x8982a16acff488b5 has no prefix
    11/1/15 1:42:43.000 PM    kernel[0]    AirPort: Link Down on en1. Reason 8 (Disassociated because station leaving).
    11/1/15 1:42:43.000 PM    kernel[0]    en1::IO80211Interface::postMessage bssid changed
    11/1/15 1:42:43.000 PM    kernel[0]    en1: 802.11d country code set to 'X0'.
    11/1/15 1:42:43.000 PM    kernel[0]    en1: 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 144 149 153 157 161 165
    11/1/15 1:42:43.000 PM    kernel[0]    ARPT: 6012.047208: AirPort_Brcm43xx::syncPowerState: WWEN[disabled]
    11/1/15 1:42:43.828 PM    symptomsd[224]    -[NetworkAnalyticsEngine _writeJournalRecord:fromCellFingerprint:key:atLOI:ofKind:lqm:isFaulty:] Hashing of the primary key failed. Dropping the journal record.
    11/1/15 1:42:43.838 PM    airportd[61]    _handleLinkEvent: WiFi is not powered. Resetting state variables.
    11/1/15 1:42:45.000 PM    kernel[0]    AppleThunderboltNHIType2::waitForOk2Go2Sx - intel_rp = 1 dlla_reporting_supported = 1
    11/1/15 1:42:45.000 PM    kernel[0]    AppleThunderboltNHIType2::waitForOk2Go2Sx - retries = 4020
    11/1/15 1:42:48.000 PM    kernel[0]    Wake reason: XHC1
    11/1/15 1:42:48.000 PM    kernel[0]    Previous sleep cause: 5
    11/1/15 1:42:48.000 PM    kernel[0]    AppleThunderboltNHIType2::prePCIWake - power up complete - took 2 us
    11/1/15 1:42:48.000 PM    kernel[0]    AppleThunderboltGenericHAL::earlyWake - complete - took 1 milliseconds
    11/1/15 1:42:48.000 PM    kernel[0]    006013.825565 BRCM20702 Hub@14600000: IOUSBHostDevice::forcePowerGated: kPowerStateOn completed with 0x00000000 after 1636ms
    11/1/15 1:42:48.062 PM    hidd[101]    [HID] [MT] MTSimpleHIDManager::deviceDidBootload device bootloaded
    11/1/15 1:42:48.150 PM    airportd[61]    WARNING: uc (46) is not entitled for com.apple.wifi.set_power, temporarily allowing request with background priority —— all entitlement requirements will be strictly enforced in a future release
    11/1/15 1:42:48.000 PM    kernel[0]    IOThunderboltSwitch<0>(0x0)::listenerCallback - Thunderbolt HPD packet for route = 0x0 port = 11 unplug = 0
    11/1/15 1:42:48.000 PM    kernel[0]    IOThunderboltSwitch<0>(0x0)::listenerCallback - Thunderbolt HPD packet for route = 0x0 port = 12 unplug = 0
    11/1/15 1:42:48.000 PM    kernel[0]    TBT W (2): 0x0001 [√]
    11/1/15 1:42:48.000 PM    kernel[0]    TBT: +-o 0@0x0 LCA (0x0000)
    11/1/15 1:42:48.000 PM    kernel[0]    TBT: +-o 0@0x0 LCB (0x0001) LSRx change
    11/1/15 1:42:48.000 PM    kernel[0]    en1: channel changed to 1
    11/1/15 1:42:48.000 PM    kernel[0]    en1: channel changed to 1
    11/1/15 1:42:48.269 PM    Dock[313]    -[UABestAppSuggestionManager notifyBestAppChanged:type:options:bundleIdentifier:activityType:dynamicIdentifier:when:confidence:deviceName:deviceIdentifier:deviceType:] (null) UASuggestedActionType=0 (null)/(null) opts=(null) when=2015-11-01 21:42:48 +0000 confidence=1 from=(null)/(null) (UABestAppSuggestionManager.m #319)
    11/1/15 1:42:48.000 PM    kernel[0]    AirPort: Link Up on awdl0
    11/1/15 1:42:48.000 PM    kernel[0]    Setting BTCoex Config: enable_2G:1, profile_2g:0, enable_5G:1, profile_5G:0
    11/1/15 1:42:48.000 PM    kernel[0]    IO80211AWDLPeerManager::setAwdlOperatingMode Setting the AWDL operation mode from AUTO to SUSPENDED
    11/1/15 1:42:48.000 PM    kernel[0]    IO80211AWDLPeerManager::setAwdlSuspendedMode() Suspending AWDL, enterQuietMode(true)
    11/1/15 1:42:48.378 PM    mDNSResponder[94]    mDNS_RegisterInterface: Frequent transitions for interface awdl0 (FE80:0000:0000:0000:5C06:83FF:FE22:3425)
    11/1/15 1:42:48.380 PM    mDNSResponder[94]    mDNS_RegisterInterface: Frequent transitions for interface en1 (FE80:0000:0000:0000:BA09:8AFF:FECC:A225)
    11/1/15 1:42:48.382 PM    mDNSResponder[94]    mDNS_RegisterInterface: Frequent transitions for interface en1 (10.0.0.13)
    11/1/15 1:42:49.000 PM    kernel[0]    full wake promotion (reason 1) 1067 ms
    11/1/15 1:42:49.068 PM    CommCenter[386]    Telling CSI to exit low power.
    11/1/15 1:42:49.069 PM    loginwindow[98]    ERROR | -[LWBuiltInScreenLockAuthLion closeAuthAndReset:] | Attempted to remove an observer when not observing
    11/1/15 1:42:49.588 PM    WindowServer[163]    CGXDisplayDidWakeNotification [6015373963540]: posting kCGSDisplayDidWake
    11/1/15 1:42:49.589 PM    WindowServer[163]    handle_will_sleep_auth_and_shield_windows: NULL shield_window (lock state: 1)
    11/1/15 1:42:50.028 PM    identityservicesd[329]    <IMMacNotificationCenterManager: 0x7fb85ae6b6d0>: notification observer: com.apple.iChat   notification: __CFNotification 0x7fb85ac59120 {name = _NSDoNotDisturbDisabledNotification}
    11/1/15 1:42:50.029 PM    imagent[359]    <IMMacNotificationCenterManager: 0x7fd78a52b1d0>: notification observer: com.apple.FaceTime   notification: __CFNotification 0x7fd78a712400 {name = _NSDoNotDisturbDisabledNotification}
    11/1/15 1:42:50.041 PM    imagent[359]    <IMMacNotificationCenterManager: 0x7fd78a52b1d0>:    NC Disabled: NO
    11/1/15 1:42:50.041 PM    identityservicesd[329]    <IMMacNotificationCenterManager: 0x7fb85ae6b6d0>:    NC Disabled: NO
    11/1/15 1:42:50.048 PM    imagent[359]    <IMMacNotificationCenterManager: 0x7fd78a52b1d0>:   DND Enabled: NO
    11/1/15 1:42:50.048 PM    identityservicesd[329]    <IMMacNotificationCenterManager: 0x7fb85ae6b6d0>:   DND Enabled: NO
    11/1/15 1:42:50.048 PM    imagent[359]    <IMMacNotificationCenterManager: 0x7fd78a52b1d0>: Updating enabled: YES   (Topics: (
    ))
    11/1/15 1:42:50.048 PM    identityservicesd[329]    <IMMacNotificationCenterManager: 0x7fb85ae6b6d0>: Updating enabled: YES   (Topics: (
        "com.apple.private.alloy.icloudpairing",
        "com.apple.private.alloy.continuity.encryption",
        "com.apple.madrid",
        "com.apple.private.alloy.continuity.activity",
        "com.apple.private.ids",
        "com.apple.private.alloy.phonecontinuity",
        "com.apple.private.alloy.phone.auth",
        "com.apple.private.alloy.keychainsync",
        "com.apple.private.alloy.fmf",
        "com.apple.private.alloy.sms",
        "com.apple.private.alloy.thumper.keys",
        "com.apple.private.alloy.screensharing",
        "com.apple.private.alloy.maps",
        "com.apple.private.alloy.continuity.tethering"
    ))
    11/1/15 1:42:50.066 PM    sharingd[325]    13:42:50.065 : Discoverable mode changed to Contacts Only
    11/1/15 1:42:50.066 PM    sharingd[325]    13:42:50.066 : BTLE scanning started
    11/1/15 1:42:50.066 PM    sharingd[325]    13:42:50.066 : Scanning mode Contacts Only
    11/1/15 1:42:50.068 PM    sharingd[325]    13:42:50.067 : BTLE scanner Powered On
    11/1/15 1:42:55.000 PM    kernel[0]    IO80211AWDLPeerManager::setAwdlOperatingMode Setting the AWDL operation mode from SUSPENDED to AUTO
    11/1/15 1:42:55.000 PM    kernel[0]    IO80211AWDLPeerManager::setAwdlAutoMode Resuming AWDL
    11/1/15 1:42:55.929 PM    airportd[61]    -[CWXPCConnection performScanWithChannels:ssidList:legacyScanSSID:includeHiddenNetworks:mergeScanResults:maxAge:maxMissCount:maxWakeCount:maxAutoJoinCount:interfaceName:waitForWiFi:waitForBluetooth:token:priority:reply:]: !!! SCAN request received 0.5717 seconds after previous scan request from 46 (uc)
    11/1/15 1:42:56.000 PM    kernel[0]    IO80211AWDLPeerManager::setAwdlOperatingMode Setting the AWDL operation mode from AUTO to SUSPENDED
    11/1/15 1:42:56.000 PM    kernel[0]    IO80211AWDLPeerManager::setAwdlSuspendedMode() Suspending AWDL, enterQuietMode(true)
    11/1/15 1:42:56.000 PM    kernel[0]    en1: channel changed to 1
    11/1/15 1:42:59.000 PM    kernel[0]    IO80211AWDLPeerManager::setAwdlOperatingMode Setting the AWDL operation mode from SUSPENDED to AUTO
    11/1/15 1:42:59.000 PM    kernel[0]    IO80211AWDLPeerManager::setAwdlAutoMode Resuming AWDL
    
     
  6. JonD25 macrumors 6502

    Joined:
    Feb 9, 2006
    #6
    I think I just figured out my problem. I skimmed through that log and saw "Wake reason: XHC1". I did a little google searching and found this refers to either USB or Bluetooth. Some people online mention USB hubs being the culprit. I don't have a USB hub, and I already tried unplugging my USB external drives, but the internal still spun up. But then I realized this whole time I had been leaving my Apple FW800 to Thunderbolt adaptor still plugged in attached to my FW800 drive since that particular drive has a switch for powering it off. I assumed since it was off, it wouldn't be the culprit. But lo and behold, I unplugged that and set it to sleep, and the problem was gone. Guessing it's the actual adaptor that is causing it. Hopefully that helps you figure your problem out too Mikel30! If not, I also found this link. It's a little outdated, my issue XHC1 isn't listed, but there are some more recent comments that list it and might help as well.
     

Share This Page