I've noticed over the last few days that my rMBP will wake for no reason. I have had it sitting on my bed and just all of sudden I look over and the Apple will be on. I'd reach for it, and as soon as I did it fell back asleep. Today though, I caught it. The Apple flashed once and it grabbed my attention. Then it came on solid. So I grabbed my laptop and opened it.
Sure enough, there it was sitting on the log-in screen. I logged in, and there was nothing going on. So I checked the Console and gathered some logs. There a quite a few, so I can't list them, but this one keeps repeating. Its odd too, because it can happen all by itself or the error occurs multiple times (150x or more):
kernel[0]: SMC::smcReadKeyAction ERROR TC0D kSMCBadArgumentError(0x89) fKeyHashTable=0x0xffffff81ac664000
Any reason for that? I haven't tried reinstalling the OS yet as its still forked and to reinstall it I would need to download the OS over the internet. It take 40+ minutes on my 30Mbps network. Then 40 to install it.
Specs: 15" Retina MacBook Pro Late 2013. 2.3GHz i7, 16GB of RAM, 512GB Flash.
----------
Some of the logs (abridged to fit):
2/14/14 8:07:41.000 PM kernel[0]: IOThunderboltSwitch<0xffffff802cda9200>(0x0)::listenerCallback - Thunderbolt HPD packet for route = 0x0 port = 11 unplug = 0
2/14/14 8:07:41.000 PM kernel[0]: IOThunderboltSwitch<0xffffff802cda9200>(0x0)::listenerCallback - Thunderbolt HPD packet for route = 0x0 port = 12 unplug = 0
2/14/14 8:07:41.000 PM kernel[0]: vm_compressor_flush - starting
2/14/14 8:07:41.000 PM kernel[0]: vm_compressor_flush completed - took 3055 msecs
2/14/14 8:07:41.000 PM kernel[0]: hibernate_flush_memory: buffer_cache_gc freed up 3331 wired pages
2/14/14 8:07:41.000 PM kernel[0]: hibernate_alloc_pages act 63239, inact 39670, anon 396, throt 0, spec 7382, wire 424526, wireinit 158704
2/14/14 8:07:41.000 PM kernel[0]: hibernate_setup(0) took 3693 ms
2/14/14 8:07:41.000 PM kernel[0]: en0: BSSID changed to 88:1f:a1:33:4c:b7
2/14/14 8:07:41.000 PM kernel[0]: ARPT: 375014.304038: scanparams:
2/14/14 8:07:41.000 PM kernel[0]: ARPT: 375014.304041: flags 0
2/14/14 8:07:41.000 PM kernel[0]: ARPT: 375014.304043: active_time 0, passive_time 0
2/14/14 8:07:41.000 PM kernel[0]: ARPT: 375014.304044: scan_start_delay 0
2/14/14 8:07:41.000 PM kernel[0]: ARPT: 375014.304046: scan_cycle_idle_rest_time 0, scan_cycle_idle_rest_time_multiplier 0
2/14/14 8:07:41.000 PM kernel[0]: ARPT: 375014.304049: max_scan_cycles 0, max_rest_time 0
2/14/14 8:07:41.000 PM kernel[0]: ARPT: 375014.304051: Scan Channels (0): None
2/14/14 8:07:41.000 PM kernel[0]: ARPT: 375014.304052: SSID (0): None
2/14/14 8:07:41.000 PM kernel[0]: ARPT: 375014.304055: SSID count = 0
2/14/14 8:07:41.000 PM kernel[0]: ARPT: 375014.304058: wl0: leaveModulePoweredForOffloads: Wi-Fi will turn off.
2/14/14 8:07:41.000 PM kernel[0]: Bluetooth -- LE is supported - Disable LE meta event
2/14/14 8:07:41.000 PM kernel[0]: wlEvent: en0 en0 Link DOWN virtIf = 0
2/14/14 8:07:41.000 PM kernel[0]: AirPort: Link Down on en0. Reason 8 (Disassociated because station leaving).
2/14/14 8:07:41.000 PM kernel[0]: **** [IOBluetoothHostControllerUSBTransport][SuspendDevice] -- Suspend -- suspendDeviceCallResult = 0x0000 (kIOReturnSuccess) -- 0x5400 ****
2/14/14 8:07:41.000 PM kernel[0]: AppleCamIn::systemWakeCall - messageType = 0xE0000340
2/14/14 7:17:29.000 PM kernel[0]: AppleThunderboltNHIType2::waitForOk2Go2Sx - retries = 13
2/14/14 8:07:41.000 PM kernel[0]: hibernate_page_list_setall(preflight 0) start 0xffffff826ad57000, 0xffffff826add7000
2/14/14 8:07:41.000 PM kernel[0]: hibernate_teardown started
2/14/14 8:07:41.000 PM kernel[0]: hibernate_teardown: wired_pages 432286, free_pages 3637857, active_pages 54467, inactive_pages 36704, speculative_pages 0, cleaned_pages 0, compressor_pages 89
2/14/14 8:07:41.000 PM kernel[0]: hibernate_teardown_pmap_structs done: last_valid_compact_indx 329694
2/14/14 8:07:41.000 PM kernel[0]: hibernate_teardown: mark_as_unneeded_pages 8192, 63340, 34267
2/14/14 8:07:41.000 PM kernel[0]: hibernate_teardown completed - discarded 105799
2/14/14 8:07:41.000 PM kernel[0]: hibernate_page_list_setall time: 715 ms
2/14/14 8:07:41.000 PM kernel[0]: pages 413586, wire 303206, act 54467, inact 36704, cleaned 0 spec 0, zf 0, throt 0, compr 89, xpmapped 91171
2/14/14 8:07:41.000 PM kernel[0]: did discard act 5486 inact 2966 purgeable 3286 spec 7382 cleaned 0
2/14/14 8:07:41.000 PM kernel[0]: hibernate_page_list_setall found pageCount 394466
2/14/14 8:07:41.000 PM kernel[0]: IOHibernatePollerOpen, ml_get_interrupts_enabled 0
2/14/14 8:07:41.000 PM kernel[0]: IOHibernatePollerOpen(0)
2/14/14 8:07:41.000 PM kernel[0]: encryptStart 14000
2/14/14 8:07:41.000 PM kernel[0]: bitmap_size 0x7f504, previewSize 0x0, writing 394129 pages @ 0x93504
2/14/14 8:07:41.000 PM kernel[0]: hibernate_rebuild started
2/14/14 8:07:41.000 PM kernel[0]: hibernate_rebuild_pmap_structs done: last_valid_compact_indx 329694
2/14/14 8:07:41.000 PM kernel[0]: hibernate_rebuild completed - took 93 msecs
2/14/14 8:07:41.000 PM kernel[0]: booter start at 991 ms smc 0 ms, [11, 0, 0] total 1591 ms, dsply 976, 0 ms, tramp 716 ms
2/14/14 8:07:41.000 PM kernel[0]: hibernate_machine_init: state 2, image pages 303003, sum was 33349fa3, imageSize 0x2af4a000, image1Size 0x15d45000, conflictCount 4697, nextFree 1083
2/14/14 8:07:41.000 PM kernel[0]: hibernate_newruntime_map time: 0 ms, IOHibernatePollerOpen(), ml_get_interrupts_enabled 0
2/14/14 8:07:41.000 PM kernel[0]: IOHibernatePollerOpen(0) 5 ms
2/14/14 8:07:41.000 PM kernel[0]: hibernate_machine_init reading
2/14/14 8:07:41.000 PM kernel[0]: PMStats: Hibernate read took 501 ms
2/14/14 8:07:41.000 PM kernel[0]: hibernate_machine_init pagesDone 394263 sum2 5eed1f98, time: 501 ms, disk(0x20000) 680 Mb/s, comp bytes: 118476800 time: 83 ms 1349 Mb/s, crypt bytes: 354439168 time: 80 ms 4212 Mb/s
2/14/14 8:07:41.000 PM kernel[0]: Wake reason: RTC (Alarm)
2/14/14 8:07:41.000 PM kernel[0]: RTC: SleepService 2014/2/15 04:07:37, sleep 2014/2/15 03:17:29
2/14/14 8:07:41.000 PM kernel[0]: AppleCamIn::systemWakeCall - messageType = 0xE0000320
2/14/14 8:07:41.000 PM kernel[0]: AppleCamIn::systemWakeCall - messageType = 0xE0000340
2/14/14 8:07:41.000 PM kernel[0]: AppleCamIn::wakeEventHandlerThread
2/14/14 8:07:41.000 PM kernel[0]: Previous Sleep Cause: 5
2/14/14 8:07:41.000 PM kernel[0]: Previous Shutdown Cause: 5
2/14/14 8:07:41.000 PM kernel[0]: IOPPF: Sent cpu-plimit-notification last value 0 (rounded time weighted average 0)
2/14/14 8:07:41.000 PM kernel[0]: IOPPF: Sent gpu-external-plimit-notification last value 0 (rounded time weighted average 0)
2/14/14 8:07:41.000 PM kernel[0]: IOPPF: Sent gpu-internal-plimit-notification last value 0 (rounded time weighted average 0)
2/14/14 8:07:41.000 PM kernel[0]: AppleThunderboltNHI:
rePCIWake - power up complete - took 0 us
2/14/14 8:07:41.000 PM kernel[0]: AppleThunderboltHAL::earlyWake - complete - took 1 milliseconds
2/14/14 8:07:41.000 PM kernel[0]: IOThunderboltSwitch<0xffffff802cda9200>(0x0)::listenerCallback - Thunderbolt HPD packet for route = 0x0 port = 11 unplug = 0
2/14/14 8:07:41.000 PM kernel[0]: TBT W (2): 0x0040 [x]
2/14/14 8:07:41.000 PM kernel[0]: IOThunderboltSwitch<0xffffff802cda9200>(0x0)::listenerCallback - Thunderbolt HPD packet for route = 0x0 port = 12 unplug = 0
2/14/14 8:07:41.000 PM kernel[0]: SMC::smcReadKeyAction ERROR TC0D kSMCBadArgumentError(0x89) fKeyHashTable=0x0xffffff81ac664000
2/14/14 8:07:41.000 PM kernel[0]: SMC::smcReadKeyAction ERROR TC0H kSMCBadArgumentError(0x89) fKeyHashTable=0x0xffffff81ac664000
2/14/14 8:07:41.000 PM kernel[0]: SMC::smcReadKeyAction ERROR TCAH kSMCBadArgumentError(0x89) fKeyHashTable=0x0xffffff81ac664000
2/14/14 8:07:41.000 PM kernel[0]: SMC::smcReadKeyAction ERROR TC0H kSMCBadArgumentError(0x89) fKeyHashTable=0x0xffffff81ac664000
2/14/14 8:07:41.000 PM kernel[0]: ARPT: 375015.800614: si_survive_perst_war: bar0win before 18003000, bar0win after 18001000
2/14/14 8:07:41.333 PM WindowServer[92]: CGXDisplayDidWakeNotification [375015905768113]: posting kCGSDisplayDidWake
2/14/14 8:07:41.334 PM WindowServer[92]: handle_will_sleep_auth_and_shield_windows: Deferring.
2/14/14 8:07:41.000 PM kernel[0]: ARPT: 375016.011300: AirPort_Brcm43xx:
owerChange: System Wake - Full Wake/ Dark Wake / Maintenance wake
2/14/14 8:07:41.000 PM kernel[0]: AppleCamIn::systemWakeCall - messageType = 0xE0000340
2/14/14 8:07:41.000 PM kernel[0]: AppleCamIn::wakeEventHandlerThread
2/14/14 8:07:41.000 PM kernel[0]: USBMSC Identifier (non-unique): 000000000820 0x5ac 0x8406 0x820, 3
2/14/14 8:07:41.735 PM blued[40]: Incoming Core Bluetooth message 29: <dictionary: 0x7fd3ee974a60> { count = 2, contents =
"kCBMsgArgUUIDs" => <array: 0x7fd3ee96f4f0> { count = 0, capacity = 0, contents =
}
"kCBMsgArgOptions" => <dictionary: 0x7fd3ee974b30> { count = 1, contents =
"kCBScanOptionAllowDuplicates" => <int64: 0x7fd3ee96f7a0>: 1
}
}
2/14/14 8:07:41.000 PM kernel[0]: [SendRawHCICommand] ### ERROR: EnqueueRequestForController failed (err=e00002bc)
2/14/14 8:07:41.000 PM kernel[0]: [SendRawHCICommand] ### ERROR: EnqueueRequestForController failed (err=e00002bc)
2/14/14 8:07:41.747 PM loginwindow[62]: ERROR | -[LWBuiltInScreenLockAuthLion askForPasswordBuiltIn:] | Attempted to add an observer when already observing
2/14/14 8:07:41.000 PM kernel[0]: flow_divert_kctl_disconnect (0): disconnecting group 1
2/14/14 8:07:41.000 PM kernel[0]: SMC::smcReadKeyAction ERROR TC0D kSMCBadArgumentError(0x89) fKeyHashTable=0x0xffffff81ac664000
2/14/14 8:07:41.000 PM kernel[0]: SMC::smcReadKeyAction ERROR TC0H kSMCBadArgumentError(0x89) fKeyHashTable=0x0xffffff81ac664000
2/14/14 8:07:41.000 PM kernel[0]: SMC::smcReadKeyAction ERROR TCAH kSMCBadArgumentError(0x89) fKeyHashTable=0x0xffffff81ac664000
2/14/14 8:07:41.000 PM kernel[0]: SMC::smcReadKeyAction ERROR TC0H kSMCBadArgumentError(0x89) fKeyHashTable=0x0xffffff81ac664000
2/14/14 8:07:42.000 PM kernel[0]: AppleUSBMultitouchDriver::checkStatus - received Status Packet, Payload 2: device was reinitialized
2/14/14 8:07:42.000 PM kernel[0]: IOBluetoothUSBDFU:
robe
2/14/14 8:07:42.000 PM kernel[0]: IOBluetoothUSBDFU:
robe ProductID - 0x8289 FirmwareVersion - 0x0078
2/14/14 8:07:42.000 PM kernel[0]: **** [IOBluetoothHostControllerUSBTransport][start] -- completed -- result = TRUE -- 0x0000 ****
2/14/14 8:07:42.000 PM kernel[0]: **** [BroadcomBluetoothHostControllerUSBTransport][start] -- Completed -- 0x0000 ****
2/14/14 8:07:42.000 PM kernel[0]: [IOBluetoothHCIController][staticBluetoothHCIControllerTransportShowsUp] -- Received Bluetooth Controller register service notification -- 0x0000
2/14/14 8:07:42.378 PM blued[40]: Incoming Core Bluetooth message 29: <dictionary: 0x7fd3eec2eaf0> { count = 2, contents =
"kCBMsgArgUUIDs" => <array: 0x7fd3eec2c810> { count = 0, capacity = 0, contents =
}
"kCBMsgArgOptions" => <dictionary: 0x7fd3eec2ebc0> { count = 1, contents =
"kCBScanOptionAllowDuplicates" => <int64: 0x7fd3eec2c960>: 1
}
}
2/14/14 8:07:42.000 PM kernel[0]: [IOBluetoothHCIController::setConfigState] calling registerService
2/14/14 8:07:42.000 PM kernel[0]: **** [IOBluetoothHCIController][protectedBluetoothHCIControllerTransportShowsUp] -- Connected to the transport successfully -- 0xc900 -- 0x6000 -- 0x0000 ****
2/14/14 8:07:42.389 PM blued[40]: Incoming Core Bluetooth message 29: <dictionary: 0x7fd3eeb40970> { count = 2, contents =
"kCBMsgArgUUIDs" => <array: 0x7fd3eeb45010> { count = 0, capacity = 0, contents =
}
"kCBMsgArgOptions" => <dictionary: 0x7fd3eeb40a40> { count = 1, contents =
"kCBScanOptionAllowDuplicates" => <int64: 0x7fd3eeb45090>: 1
}
}
2/14/14 8:07:44.000 PM kernel[0]: SMC::smcReadKeyAction ERROR TC0D kSMCBadArgumentError(0x89) fKeyHashTable=0x0xffffff81ac664000
2/14/14 8:07:46.000 PM kernel[0]: AppleCamIn::handleWakeEvent_gated
2/14/14 8:07:46.000 PM kernel[0]: AppleCamIn::handleWakeEvent_gated
2/14/14 8:07:46.450 PM UserEventAgent[11]: Captive: CNPluginHandler en0: Inactive
2/14/14 8:07:46.451 PM configd[18]: network changed: v4(en0-:10.0.1.178) DNS- Proxy-
2/14/14 8:07:46.000 PM kernel[0]: AppleCamIn::systemWakeCall - messageType = 0xE0000300
2/14/14 8:07:46.963 PM netbiosd[25406]: Unable to start NetBIOS name service:
2/14/14 8:07:47.000 PM kernel[0]: ARPT: 375021.872742: si_survive_perst_war: bar0win before 18003000, bar0win after 18001000
2/14/14 8:07:47.000 PM kernel[0]: flow_divert_kctl_disconnect (0): disconnecting group 1
2/14/14 8:07:47.000 PM kernel[0]: SMC::smcReadKeyAction ERROR TC0D kSMCBadArgumentError(0x89) fKeyHashTable=0x0xffffff81ac664000
2/14/14 8:07:48.573 PM SystemUIServer[192]: Menu Extra: <DisplaysExtra: 0x7f9d9a54c510> is over retained.
2/14/14 8:07:48.000 PM kernel[0]: ARPT: 375023.253542: MacAuthEvent en0 Auth result for: 88:1f:a1:33:4c:b7 MAC AUTH succeeded
2/14/14 8:07:48.000 PM kernel[0]: wlEvent: en0 en0 Link UP virtIf = 0
2/14/14 8:07:48.000 PM kernel[0]: AirPort: Link Up on en0
2/14/14 8:07:48.000 PM kernel[0]: en0: BSSID changed to 88:1f:a1:33:4c:b7
2/14/14 8:07:48.000 PM kernel[0]: AirPort: RSN handshake complete on en0
2/14/14 8:07:49.000 PM kernel[0]: flow_divert_kctl_disconnect (0): disconnecting group 1
2/14/14 8:07:50.000 PM kernel[0]: SMC::smcReadKeyAction ERROR TC0D kSMCBadArgumentError(0x89) fKeyHashTable=0x0xffffff81ac664000
2/14/14 8:07:51.045 PM UserEventAgent[11]: Captive: [CNInfoNetworkActive:1655] en0: SSID 'The Command Center' making interface primary (cache indicates network not captive)
2/14/14 8:07:51.046 PM configd[18]: network changed: DNS* Proxy
2/14/14 8:07:51.046 PM UserEventAgent[11]: Captive: CNPluginHandler en0: Evaluating
2/14/14 8:07:51.047 PM UserEventAgent[11]: Captive: en0: Not probing 'The Command Center' (cache indicates not captive)
2/14/14 8:07:51.047 PM UserEventAgent[11]: Captive: CNPluginHandler en0: Authenticated
2/14/14 8:07:51.050 PM configd[18]: network changed: v4(en0!:10.0.1.178) DNS+ Proxy+ SMB
2/14/14 8:07:53.207 PM apsd[79]: Unrecognized leaf certificate
2/14/14 8:07:53.000 PM kernel[0]: SMC::smcReadKeyAction ERROR TC0D kSMCBadArgumentError(0x89) fKeyHashTable=0x0xffffff81ac664000
2/14/14 8:07:56.000 PM kernel[0]: SMC::smcReadKeyAction ERROR TC0D kSMCBadArgumentError(0x89) fKeyHashTable=0x0xffffff81ac664000
2/14/14 8:07:59.000 PM kernel[0]: SMC::smcReadKeyAction ERROR TC0D kSMCBadArgumentError(0x89) fKeyHashTable=0x0xffffff81ac664000
2/14/14 8:08:02.000 PM kernel[0]: SMC::smcReadKeyAction ERROR TC0D kSMCBadArgumentError(0x89) fKeyHashTable=0x0xffffff81ac664000
2/14/14 8:08:05.000 PM kernel[0]: SMC::smcReadKeyAction ERROR TC0D kSMCBadArgumentError(0x89) fKeyHashTable=0x0xffffff81ac664000
2/14/14 8:08:07.235 PM com.apple.IconServicesAgent[233]: main Failed to composit image for binding VariantBinding [0x57f] flags: 0x8 binding: FileInfoBinding [0x773] - extension: jpg, UTI: public.jpeg, fileType: ????.
2/14/14 8:08:07.236 PM quicklookd[25415]: Warning: Cache image returned by the server has size range covering all valid image sizes. Binding: VariantBinding [0x203] flags: 0x8 binding: FileInfoBinding [0x103] - extension: jpg, UTI: public.jpeg, fileType: ???? request size:128 scale: 1
Sure enough, there it was sitting on the log-in screen. I logged in, and there was nothing going on. So I checked the Console and gathered some logs. There a quite a few, so I can't list them, but this one keeps repeating. Its odd too, because it can happen all by itself or the error occurs multiple times (150x or more):
kernel[0]: SMC::smcReadKeyAction ERROR TC0D kSMCBadArgumentError(0x89) fKeyHashTable=0x0xffffff81ac664000
Any reason for that? I haven't tried reinstalling the OS yet as its still forked and to reinstall it I would need to download the OS over the internet. It take 40+ minutes on my 30Mbps network. Then 40 to install it.
Specs: 15" Retina MacBook Pro Late 2013. 2.3GHz i7, 16GB of RAM, 512GB Flash.
----------
Some of the logs (abridged to fit):
2/14/14 8:07:41.000 PM kernel[0]: IOThunderboltSwitch<0xffffff802cda9200>(0x0)::listenerCallback - Thunderbolt HPD packet for route = 0x0 port = 11 unplug = 0
2/14/14 8:07:41.000 PM kernel[0]: IOThunderboltSwitch<0xffffff802cda9200>(0x0)::listenerCallback - Thunderbolt HPD packet for route = 0x0 port = 12 unplug = 0
2/14/14 8:07:41.000 PM kernel[0]: vm_compressor_flush - starting
2/14/14 8:07:41.000 PM kernel[0]: vm_compressor_flush completed - took 3055 msecs
2/14/14 8:07:41.000 PM kernel[0]: hibernate_flush_memory: buffer_cache_gc freed up 3331 wired pages
2/14/14 8:07:41.000 PM kernel[0]: hibernate_alloc_pages act 63239, inact 39670, anon 396, throt 0, spec 7382, wire 424526, wireinit 158704
2/14/14 8:07:41.000 PM kernel[0]: hibernate_setup(0) took 3693 ms
2/14/14 8:07:41.000 PM kernel[0]: en0: BSSID changed to 88:1f:a1:33:4c:b7
2/14/14 8:07:41.000 PM kernel[0]: ARPT: 375014.304038: scanparams:
2/14/14 8:07:41.000 PM kernel[0]: ARPT: 375014.304041: flags 0
2/14/14 8:07:41.000 PM kernel[0]: ARPT: 375014.304043: active_time 0, passive_time 0
2/14/14 8:07:41.000 PM kernel[0]: ARPT: 375014.304044: scan_start_delay 0
2/14/14 8:07:41.000 PM kernel[0]: ARPT: 375014.304046: scan_cycle_idle_rest_time 0, scan_cycle_idle_rest_time_multiplier 0
2/14/14 8:07:41.000 PM kernel[0]: ARPT: 375014.304049: max_scan_cycles 0, max_rest_time 0
2/14/14 8:07:41.000 PM kernel[0]: ARPT: 375014.304051: Scan Channels (0): None
2/14/14 8:07:41.000 PM kernel[0]: ARPT: 375014.304052: SSID (0): None
2/14/14 8:07:41.000 PM kernel[0]: ARPT: 375014.304055: SSID count = 0
2/14/14 8:07:41.000 PM kernel[0]: ARPT: 375014.304058: wl0: leaveModulePoweredForOffloads: Wi-Fi will turn off.
2/14/14 8:07:41.000 PM kernel[0]: Bluetooth -- LE is supported - Disable LE meta event
2/14/14 8:07:41.000 PM kernel[0]: wlEvent: en0 en0 Link DOWN virtIf = 0
2/14/14 8:07:41.000 PM kernel[0]: AirPort: Link Down on en0. Reason 8 (Disassociated because station leaving).
2/14/14 8:07:41.000 PM kernel[0]: **** [IOBluetoothHostControllerUSBTransport][SuspendDevice] -- Suspend -- suspendDeviceCallResult = 0x0000 (kIOReturnSuccess) -- 0x5400 ****
2/14/14 8:07:41.000 PM kernel[0]: AppleCamIn::systemWakeCall - messageType = 0xE0000340
2/14/14 7:17:29.000 PM kernel[0]: AppleThunderboltNHIType2::waitForOk2Go2Sx - retries = 13
2/14/14 8:07:41.000 PM kernel[0]: hibernate_page_list_setall(preflight 0) start 0xffffff826ad57000, 0xffffff826add7000
2/14/14 8:07:41.000 PM kernel[0]: hibernate_teardown started
2/14/14 8:07:41.000 PM kernel[0]: hibernate_teardown: wired_pages 432286, free_pages 3637857, active_pages 54467, inactive_pages 36704, speculative_pages 0, cleaned_pages 0, compressor_pages 89
2/14/14 8:07:41.000 PM kernel[0]: hibernate_teardown_pmap_structs done: last_valid_compact_indx 329694
2/14/14 8:07:41.000 PM kernel[0]: hibernate_teardown: mark_as_unneeded_pages 8192, 63340, 34267
2/14/14 8:07:41.000 PM kernel[0]: hibernate_teardown completed - discarded 105799
2/14/14 8:07:41.000 PM kernel[0]: hibernate_page_list_setall time: 715 ms
2/14/14 8:07:41.000 PM kernel[0]: pages 413586, wire 303206, act 54467, inact 36704, cleaned 0 spec 0, zf 0, throt 0, compr 89, xpmapped 91171
2/14/14 8:07:41.000 PM kernel[0]: did discard act 5486 inact 2966 purgeable 3286 spec 7382 cleaned 0
2/14/14 8:07:41.000 PM kernel[0]: hibernate_page_list_setall found pageCount 394466
2/14/14 8:07:41.000 PM kernel[0]: IOHibernatePollerOpen, ml_get_interrupts_enabled 0
2/14/14 8:07:41.000 PM kernel[0]: IOHibernatePollerOpen(0)
2/14/14 8:07:41.000 PM kernel[0]: encryptStart 14000
2/14/14 8:07:41.000 PM kernel[0]: bitmap_size 0x7f504, previewSize 0x0, writing 394129 pages @ 0x93504
2/14/14 8:07:41.000 PM kernel[0]: hibernate_rebuild started
2/14/14 8:07:41.000 PM kernel[0]: hibernate_rebuild_pmap_structs done: last_valid_compact_indx 329694
2/14/14 8:07:41.000 PM kernel[0]: hibernate_rebuild completed - took 93 msecs
2/14/14 8:07:41.000 PM kernel[0]: booter start at 991 ms smc 0 ms, [11, 0, 0] total 1591 ms, dsply 976, 0 ms, tramp 716 ms
2/14/14 8:07:41.000 PM kernel[0]: hibernate_machine_init: state 2, image pages 303003, sum was 33349fa3, imageSize 0x2af4a000, image1Size 0x15d45000, conflictCount 4697, nextFree 1083
2/14/14 8:07:41.000 PM kernel[0]: hibernate_newruntime_map time: 0 ms, IOHibernatePollerOpen(), ml_get_interrupts_enabled 0
2/14/14 8:07:41.000 PM kernel[0]: IOHibernatePollerOpen(0) 5 ms
2/14/14 8:07:41.000 PM kernel[0]: hibernate_machine_init reading
2/14/14 8:07:41.000 PM kernel[0]: PMStats: Hibernate read took 501 ms
2/14/14 8:07:41.000 PM kernel[0]: hibernate_machine_init pagesDone 394263 sum2 5eed1f98, time: 501 ms, disk(0x20000) 680 Mb/s, comp bytes: 118476800 time: 83 ms 1349 Mb/s, crypt bytes: 354439168 time: 80 ms 4212 Mb/s
2/14/14 8:07:41.000 PM kernel[0]: Wake reason: RTC (Alarm)
2/14/14 8:07:41.000 PM kernel[0]: RTC: SleepService 2014/2/15 04:07:37, sleep 2014/2/15 03:17:29
2/14/14 8:07:41.000 PM kernel[0]: AppleCamIn::systemWakeCall - messageType = 0xE0000320
2/14/14 8:07:41.000 PM kernel[0]: AppleCamIn::systemWakeCall - messageType = 0xE0000340
2/14/14 8:07:41.000 PM kernel[0]: AppleCamIn::wakeEventHandlerThread
2/14/14 8:07:41.000 PM kernel[0]: Previous Sleep Cause: 5
2/14/14 8:07:41.000 PM kernel[0]: Previous Shutdown Cause: 5
2/14/14 8:07:41.000 PM kernel[0]: IOPPF: Sent cpu-plimit-notification last value 0 (rounded time weighted average 0)
2/14/14 8:07:41.000 PM kernel[0]: IOPPF: Sent gpu-external-plimit-notification last value 0 (rounded time weighted average 0)
2/14/14 8:07:41.000 PM kernel[0]: IOPPF: Sent gpu-internal-plimit-notification last value 0 (rounded time weighted average 0)
2/14/14 8:07:41.000 PM kernel[0]: AppleThunderboltNHI:
2/14/14 8:07:41.000 PM kernel[0]: AppleThunderboltHAL::earlyWake - complete - took 1 milliseconds
2/14/14 8:07:41.000 PM kernel[0]: IOThunderboltSwitch<0xffffff802cda9200>(0x0)::listenerCallback - Thunderbolt HPD packet for route = 0x0 port = 11 unplug = 0
2/14/14 8:07:41.000 PM kernel[0]: TBT W (2): 0x0040 [x]
2/14/14 8:07:41.000 PM kernel[0]: IOThunderboltSwitch<0xffffff802cda9200>(0x0)::listenerCallback - Thunderbolt HPD packet for route = 0x0 port = 12 unplug = 0
2/14/14 8:07:41.000 PM kernel[0]: SMC::smcReadKeyAction ERROR TC0D kSMCBadArgumentError(0x89) fKeyHashTable=0x0xffffff81ac664000
2/14/14 8:07:41.000 PM kernel[0]: SMC::smcReadKeyAction ERROR TC0H kSMCBadArgumentError(0x89) fKeyHashTable=0x0xffffff81ac664000
2/14/14 8:07:41.000 PM kernel[0]: SMC::smcReadKeyAction ERROR TCAH kSMCBadArgumentError(0x89) fKeyHashTable=0x0xffffff81ac664000
2/14/14 8:07:41.000 PM kernel[0]: SMC::smcReadKeyAction ERROR TC0H kSMCBadArgumentError(0x89) fKeyHashTable=0x0xffffff81ac664000
2/14/14 8:07:41.000 PM kernel[0]: ARPT: 375015.800614: si_survive_perst_war: bar0win before 18003000, bar0win after 18001000
2/14/14 8:07:41.333 PM WindowServer[92]: CGXDisplayDidWakeNotification [375015905768113]: posting kCGSDisplayDidWake
2/14/14 8:07:41.334 PM WindowServer[92]: handle_will_sleep_auth_and_shield_windows: Deferring.
2/14/14 8:07:41.000 PM kernel[0]: ARPT: 375016.011300: AirPort_Brcm43xx:
2/14/14 8:07:41.000 PM kernel[0]: AppleCamIn::systemWakeCall - messageType = 0xE0000340
2/14/14 8:07:41.000 PM kernel[0]: AppleCamIn::wakeEventHandlerThread
2/14/14 8:07:41.000 PM kernel[0]: USBMSC Identifier (non-unique): 000000000820 0x5ac 0x8406 0x820, 3
2/14/14 8:07:41.735 PM blued[40]: Incoming Core Bluetooth message 29: <dictionary: 0x7fd3ee974a60> { count = 2, contents =
"kCBMsgArgUUIDs" => <array: 0x7fd3ee96f4f0> { count = 0, capacity = 0, contents =
}
"kCBMsgArgOptions" => <dictionary: 0x7fd3ee974b30> { count = 1, contents =
"kCBScanOptionAllowDuplicates" => <int64: 0x7fd3ee96f7a0>: 1
}
}
2/14/14 8:07:41.000 PM kernel[0]: [SendRawHCICommand] ### ERROR: EnqueueRequestForController failed (err=e00002bc)
2/14/14 8:07:41.000 PM kernel[0]: [SendRawHCICommand] ### ERROR: EnqueueRequestForController failed (err=e00002bc)
2/14/14 8:07:41.747 PM loginwindow[62]: ERROR | -[LWBuiltInScreenLockAuthLion askForPasswordBuiltIn:] | Attempted to add an observer when already observing
2/14/14 8:07:41.000 PM kernel[0]: flow_divert_kctl_disconnect (0): disconnecting group 1
2/14/14 8:07:41.000 PM kernel[0]: SMC::smcReadKeyAction ERROR TC0D kSMCBadArgumentError(0x89) fKeyHashTable=0x0xffffff81ac664000
2/14/14 8:07:41.000 PM kernel[0]: SMC::smcReadKeyAction ERROR TC0H kSMCBadArgumentError(0x89) fKeyHashTable=0x0xffffff81ac664000
2/14/14 8:07:41.000 PM kernel[0]: SMC::smcReadKeyAction ERROR TCAH kSMCBadArgumentError(0x89) fKeyHashTable=0x0xffffff81ac664000
2/14/14 8:07:41.000 PM kernel[0]: SMC::smcReadKeyAction ERROR TC0H kSMCBadArgumentError(0x89) fKeyHashTable=0x0xffffff81ac664000
2/14/14 8:07:42.000 PM kernel[0]: AppleUSBMultitouchDriver::checkStatus - received Status Packet, Payload 2: device was reinitialized
2/14/14 8:07:42.000 PM kernel[0]: IOBluetoothUSBDFU:
2/14/14 8:07:42.000 PM kernel[0]: IOBluetoothUSBDFU:
2/14/14 8:07:42.000 PM kernel[0]: **** [IOBluetoothHostControllerUSBTransport][start] -- completed -- result = TRUE -- 0x0000 ****
2/14/14 8:07:42.000 PM kernel[0]: **** [BroadcomBluetoothHostControllerUSBTransport][start] -- Completed -- 0x0000 ****
2/14/14 8:07:42.000 PM kernel[0]: [IOBluetoothHCIController][staticBluetoothHCIControllerTransportShowsUp] -- Received Bluetooth Controller register service notification -- 0x0000
2/14/14 8:07:42.378 PM blued[40]: Incoming Core Bluetooth message 29: <dictionary: 0x7fd3eec2eaf0> { count = 2, contents =
"kCBMsgArgUUIDs" => <array: 0x7fd3eec2c810> { count = 0, capacity = 0, contents =
}
"kCBMsgArgOptions" => <dictionary: 0x7fd3eec2ebc0> { count = 1, contents =
"kCBScanOptionAllowDuplicates" => <int64: 0x7fd3eec2c960>: 1
}
}
2/14/14 8:07:42.000 PM kernel[0]: [IOBluetoothHCIController::setConfigState] calling registerService
2/14/14 8:07:42.000 PM kernel[0]: **** [IOBluetoothHCIController][protectedBluetoothHCIControllerTransportShowsUp] -- Connected to the transport successfully -- 0xc900 -- 0x6000 -- 0x0000 ****
2/14/14 8:07:42.389 PM blued[40]: Incoming Core Bluetooth message 29: <dictionary: 0x7fd3eeb40970> { count = 2, contents =
"kCBMsgArgUUIDs" => <array: 0x7fd3eeb45010> { count = 0, capacity = 0, contents =
}
"kCBMsgArgOptions" => <dictionary: 0x7fd3eeb40a40> { count = 1, contents =
"kCBScanOptionAllowDuplicates" => <int64: 0x7fd3eeb45090>: 1
}
}
2/14/14 8:07:44.000 PM kernel[0]: SMC::smcReadKeyAction ERROR TC0D kSMCBadArgumentError(0x89) fKeyHashTable=0x0xffffff81ac664000
2/14/14 8:07:46.000 PM kernel[0]: AppleCamIn::handleWakeEvent_gated
2/14/14 8:07:46.000 PM kernel[0]: AppleCamIn::handleWakeEvent_gated
2/14/14 8:07:46.450 PM UserEventAgent[11]: Captive: CNPluginHandler en0: Inactive
2/14/14 8:07:46.451 PM configd[18]: network changed: v4(en0-:10.0.1.178) DNS- Proxy-
2/14/14 8:07:46.000 PM kernel[0]: AppleCamIn::systemWakeCall - messageType = 0xE0000300
2/14/14 8:07:46.963 PM netbiosd[25406]: Unable to start NetBIOS name service:
2/14/14 8:07:47.000 PM kernel[0]: ARPT: 375021.872742: si_survive_perst_war: bar0win before 18003000, bar0win after 18001000
2/14/14 8:07:47.000 PM kernel[0]: flow_divert_kctl_disconnect (0): disconnecting group 1
2/14/14 8:07:47.000 PM kernel[0]: SMC::smcReadKeyAction ERROR TC0D kSMCBadArgumentError(0x89) fKeyHashTable=0x0xffffff81ac664000
2/14/14 8:07:48.573 PM SystemUIServer[192]: Menu Extra: <DisplaysExtra: 0x7f9d9a54c510> is over retained.
2/14/14 8:07:48.000 PM kernel[0]: ARPT: 375023.253542: MacAuthEvent en0 Auth result for: 88:1f:a1:33:4c:b7 MAC AUTH succeeded
2/14/14 8:07:48.000 PM kernel[0]: wlEvent: en0 en0 Link UP virtIf = 0
2/14/14 8:07:48.000 PM kernel[0]: AirPort: Link Up on en0
2/14/14 8:07:48.000 PM kernel[0]: en0: BSSID changed to 88:1f:a1:33:4c:b7
2/14/14 8:07:48.000 PM kernel[0]: AirPort: RSN handshake complete on en0
2/14/14 8:07:49.000 PM kernel[0]: flow_divert_kctl_disconnect (0): disconnecting group 1
2/14/14 8:07:50.000 PM kernel[0]: SMC::smcReadKeyAction ERROR TC0D kSMCBadArgumentError(0x89) fKeyHashTable=0x0xffffff81ac664000
2/14/14 8:07:51.045 PM UserEventAgent[11]: Captive: [CNInfoNetworkActive:1655] en0: SSID 'The Command Center' making interface primary (cache indicates network not captive)
2/14/14 8:07:51.046 PM configd[18]: network changed: DNS* Proxy
2/14/14 8:07:51.046 PM UserEventAgent[11]: Captive: CNPluginHandler en0: Evaluating
2/14/14 8:07:51.047 PM UserEventAgent[11]: Captive: en0: Not probing 'The Command Center' (cache indicates not captive)
2/14/14 8:07:51.047 PM UserEventAgent[11]: Captive: CNPluginHandler en0: Authenticated
2/14/14 8:07:51.050 PM configd[18]: network changed: v4(en0!:10.0.1.178) DNS+ Proxy+ SMB
2/14/14 8:07:53.207 PM apsd[79]: Unrecognized leaf certificate
2/14/14 8:07:53.000 PM kernel[0]: SMC::smcReadKeyAction ERROR TC0D kSMCBadArgumentError(0x89) fKeyHashTable=0x0xffffff81ac664000
2/14/14 8:07:56.000 PM kernel[0]: SMC::smcReadKeyAction ERROR TC0D kSMCBadArgumentError(0x89) fKeyHashTable=0x0xffffff81ac664000
2/14/14 8:07:59.000 PM kernel[0]: SMC::smcReadKeyAction ERROR TC0D kSMCBadArgumentError(0x89) fKeyHashTable=0x0xffffff81ac664000
2/14/14 8:08:02.000 PM kernel[0]: SMC::smcReadKeyAction ERROR TC0D kSMCBadArgumentError(0x89) fKeyHashTable=0x0xffffff81ac664000
2/14/14 8:08:05.000 PM kernel[0]: SMC::smcReadKeyAction ERROR TC0D kSMCBadArgumentError(0x89) fKeyHashTable=0x0xffffff81ac664000
2/14/14 8:08:07.235 PM com.apple.IconServicesAgent[233]: main Failed to composit image for binding VariantBinding [0x57f] flags: 0x8 binding: FileInfoBinding [0x773] - extension: jpg, UTI: public.jpeg, fileType: ????.
2/14/14 8:08:07.236 PM quicklookd[25415]: Warning: Cache image returned by the server has size range covering all valid image sizes. Binding: VariantBinding [0x203] flags: 0x8 binding: FileInfoBinding [0x103] - extension: jpg, UTI: public.jpeg, fileType: ???? request size:128 scale: 1