Abrupt and sudden mac sleep while in use (narcolepsy)

[alitan]

Hi,
I've recently been experiencing serious issues with my mac (mid 2009 13 inch mac book pro, OSX 10.8.2).

While I'm browsing the web or simply listening to music on Itunes, my computer goes to sleep randomly. This sleep issue is activated even when my hand is still on the trackpad. I have reset the SMC before, but it keeps happening. I've only had this issue since upgrading to Mountain Lion (from Lion). I have a mid 2009 13 inch mac book pro with upgraded Ram (8gb from Corsair).
I recently also had issue with the HDD cable which I got it replaced at the apple store. With the old cable, my computer would abruptly eject the disk and freeze. I no longer have that issue, but now it goes to sleep randomly.

My settings are set to never for computer sleep and after 1 hour for display sleep. 'Hard Disk sleeping whenever possible' is disabled. I have also kept the same for both on battery and for on AC power.
Upon inspecting the console system.log I get the following:

Dec  1 00:45:21 AliComp.local WindowServer[139]: CGXSetWindowBackgroundBlurRadius: Invalid window 0xffffffff
Dec  1 00:45:21 AliComp.local loginwindow[43]: find_shared_window: WID -1
Dec  1 00:45:21 AliComp.local loginwindow[43]: CGSGetWindowTags: Invalid window 0xffffffff
Dec  1 00:45:21 AliComp.local loginwindow[43]: find_shared_window: WID -1
Dec  1 00:45:21 AliComp.local loginwindow[43]: CGSSetWindowTags: Invalid window 0xffffffff
Dec  1 00:45:31 AliComp.local WindowServer[139]: Created shield window 0x605 for display 0x04272800
Dec  1 00:45:31 AliComp.local WindowServer[139]: device_generate_desktop_screenshot: authw 0x7f815aeb0e60(2000), shield 0x7f815acc1bb0(2001)
Dec  1 00:45:31 AliComp.local WindowServer[139]: device_generate_lock_screen_screenshot: authw 0x7f815aeb0e60(2000), shield 0x7f815acc1bb0(2001)
Dec  1 00:45:31 AliComp.local com.apple.time[11]: Next maintenance wake [Backup Interval]: <date: 0x7fb3c142a8b0> Sat Dec 01 01:39:41 2012 EST (approx)
Dec  1 00:45:31 AliComp.local com.apple.time[11]: Requesting maintenance wake [Backup Interval]: <date: 0x7fb3c142a8b0> Sat Dec 01 01:39:41 2012 EST (approx)
Dec  1 00:45:31 AliComp.local mDNSResponder[40]: ActivateLocalProxy: No service for interface vnic0
Dec  1 00:45:31 AliComp.local mDNSResponder[40]: ActivateLocalProxy: No service for interface vnic1
Dec  1 00:45:31 AliComp kernel[0]: hibernate image path: /var/vm/sleepimage
Dec  1 00:45:31 AliComp kernel[0]: sizeof(IOHibernateImageHeader) == 512
Dec  1 00:45:31 AliComp kernel[0]: AirPort_Brcm43xx::powerChange: System Sleep 
Dec  1 00:45:31 AliComp kernel[0]: kern_open_file_for_direct_io(0) took 80 ms
Dec  1 00:45:31 AliComp kernel[0]: Opened file /var/vm/sleepimage, size 8589934592, partition base 0x0, maxio 400000 ssd 0
Dec  1 00:45:31 AliComp kernel[0]: hibernate image major 1, minor 0, blocksize 512, pollers 5
Dec  1 00:45:31 AliComp kernel[0]: hibernate_alloc_pages flags 00000000, gobbling 0 pages
Dec  1 00:45:31 AliComp kernel[0]: hibernate_setup(0) took 0 ms
Dec  1 00:45:32 AliComp kernel[0]: /drv/ MacModule.cpp:304   powerStateWillChangeTo: flags=4 stateNumber=2
Dec  1 00:45:32 AliComp kernel[0]: /drv/ MacModule.cpp:309   powerStateWillChangeTo: found flag=kIOPMSleepCapability (4)
Dec  1 00:45:32 AliComp kernel[0]: 00000000  00000020  NVEthernet::setLinkStatus - not Active
Dec  1 00:45:33 AliComp kernel[0]: /drv/ MacModule.cpp:304   powerStateDidChangeTo: flags=4 stateNumber=2
Dec  1 00:45:33 AliComp kernel[0]: /drv/ MacModule.cpp:309   powerStateDidChangeTo: found flag=kIOPMSleepCapability (4)
Dec  1 00:45:33 AliComp kernel[0]: hibernate_page_list_setall start 0xffffff80e7642000, 0xffffff80e7681000
Dec  1 00:45:34 AliComp kernel[0]: hibernate_page_list_setall time: 625 ms
Dec  1 00:45:34 AliComp kernel[0]: pages 1254630, wire 241994, act 542391, inact 23455, cleaned 0 spec 459, zf 13948, throt 0, could discard act 150590 inact 71375 purgeable 9266 spec 201152 cleaned 0
Dec  1 00:45:34 AliComp kernel[0]: hibernate_page_list_setall found pageCount 822247
Dec  1 00:45:34 AliComp kernel[0]: IOHibernatePollerOpen, ml_get_interrupts_enabled 0
Dec  1 00:45:34 AliComp kernel[0]: IOHibernatePollerOpen(0)
Dec  1 00:45:34 AliComp kernel[0]: encryptStart 13270
Dec  1 00:45:34 AliComp kernel[0]: IOPolledInterface::checkForWork[5] 0xe00002eb
Dec  1 00:45:34 AliComp kernel[0]: PMStats: Hibernate write took 2 ms
Dec  1 00:45:34 AliComp kernel[0]: all time: 2 ms, comp bytes: 0 time: 0 ms 0 Mb/s, crypt bytes: 184208 time: 1 ms 139 Mb/s, 
Dec  1 00:45:34 AliComp kernel[0]: image 0, uncompressed 0 (0), compressed 0 (0%), sum1 da68877d, sum2 0
Dec  1 00:45:34 AliComp kernel[0]: wired_pages_encrypted 0, wired_pages_clear 0, dirty_pages_encrypted 0
Dec  1 00:45:34 AliComp kernel[0]: hibernate_write_image done(e00002eb)
Dec  1 00:45:34 AliComp kernel[0]: sleep
Dec  1 00:45:36 AliComp.local loginwindow[43]: ERROR | -[LWScreenLock(Private) screenIsLockedTimeExpired:] | No lock state found, use built in check
Dec  1 00:45:36 AliComp kernel[0]: Wake reason: EC LID0
Dec  1 00:45:36 AliComp kernel[0]: AirPort_Brcm43xx::powerChange: System Wake - Full Wake/ Dark Wake / Maintenance wake
Dec  1 00:45:36 AliComp kernel[0]: /drv/ MacModule.cpp:304   powerStateWillChangeTo: flags=2 stateNumber=3
Dec  1 00:45:36 AliComp kernel[0]: /drv/ MacModule.cpp:305   powerStateWillChangeTo: found flag=kIOPMPowerOn (2)
Dec  1 00:45:36 AliComp kernel[0]: HID tickle 26 ms
Dec  1 00:45:36 AliComp kernel[0]: /drv/ MacModule.cpp:304   powerStateDidChangeTo: flags=2 stateNumber=3
Dec  1 00:45:36 AliComp kernel[0]: /drv/ MacModule.cpp:305   powerStateDidChangeTo: found flag=kIOPMPowerOn (2)
Dec  1 00:45:36 AliComp kernel[0]: Previous Sleep Cause: 5
Dec  1 00:45:36 AliComp kernel[0]: wlEvent: en1 en1 Link DOWN virtIf = 0
Dec  1 00:45:36 AliComp kernel[0]: AirPort: Link Down on en1. Reason 8 (Disassociated because station leaving).
Dec  1 00:45:36 AliComp kernel[0]: en1::IO80211Interface::postMessage bssid changed
Dec  1 00:45:36 AliComp kernel[0]: en1: 802.11d country code set to 'X0'.
Dec  1 00:45:36 AliComp 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 149 153 157 161 165
Dec  1 00:45:36 AliComp.local WindowServer[139]: handle_will_sleep_auth_and_shield_windows: no lock state data
Dec  1 00:45:36 AliComp kernel[0]: 00000000  00000020  NVEthernet::setLinkStatus - not Active
Dec  1 00:45:39 AliComp kernel[0]: en1: 802.11d country code set to 'US'.
Dec  1 00:45:39 AliComp 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 149 153 157 161 165
Dec  1 00:45:39 AliComp.local configd[18]: network changed: v4(en1-:192.168.1.101) DNS- Proxy- SMB-
Dec  1 00:45:39 AliComp.local mDNSResponder[40]: 106: Could not write data to clientPID[-1]()  because of error - aborting connection
Dec  1 00:45:39 AliComp.local mDNSResponder[40]: 106: DNSServiceGetAddrInfo      v4v6 8-courier.sandbox.push.apple.com. PID[-1]()
Dec  1 00:45:39 AliComp.local mDNSResponder[40]: 107: Could not write data to clientPID[-1]()  because of error - aborting connection
Dec  1 00:45:39 AliComp.local mDNSResponder[40]: 107: DNSServiceGetAddrInfo      v4v6 34-courier.push.apple.com. PID[-1]()
Dec  1 00:45:39 AliComp.local mDNSResponder[40]:  38: Could not write data to clientPID[-1]()  because of error - aborting connection
Dec  1 00:45:39 AliComp.local mDNSResponder[40]:  38: DNSServiceGetAddrInfo      v4v6 8-courier.sandbox.push.apple.com. PID[-1]()
Dec  1 00:45:40 AliComp kernel[0]: MacAuthEvent en1   Auth result for: 68:7f:74:02:9d:18  MAC AUTH succeeded
Dec  1 00:45:40 AliComp kernel[0]: wlEvent: en1 en1 Link UP virtIf = 0
Dec  1 00:45:40 AliComp kernel[0]: AirPort: Link Up on en1
Dec  1 00:45:40 AliComp kernel[0]: en1: BSSID changed to 68:7f:74:02:9d:18
Dec  1 00:45:40 AliComp kernel[0]: en1::IO80211Interface::postMessage bssid changed
Dec  1 00:45:40 AliComp kernel[0]: AirPort: RSN handshake complete on en1
Dec  1 00:45:40 AliComp.local airportd[3093]: _doAutoJoin: Already associated to “Supernet”. Bailing on auto-join.
Dec  1 00:45:41 AliComp.local loginwindow[43]: in pam_sm_authenticate(): Got user: alitanara
Dec  1 00:45:41 AliComp.local loginwindow[43]: in pam_sm_authenticate(): Got ruser: alitanara
Dec  1 00:45:41 AliComp.local loginwindow[43]: in pam_sm_authenticate(): Got service: screensaver
Dec  1 00:45:41 AliComp.local loginwindow[43]: in od_principal_for_user(): No authentication authority returned
Dec  1 00:45:41 AliComp.local loginwindow[43]: in od_principal_for_user(): failed: 7
Dec  1 00:45:41 AliComp.local loginwindow[43]: in pam_sm_authenticate(): Failed to determine Kerberos principal name.
Dec  1 00:45:41 AliComp.local loginwindow[43]: in pam_sm_authenticate(): Done cleanup3
Dec  1 00:45:41 AliComp.local loginwindow[43]: in pam_sm_authenticate(): Kerberos 5 refuses you
Dec  1 00:45:41 AliComp.local airportd[3093]: _doAutoJoin: Already associated to “Supernet”. Bailing on auto-join.
Dec  1 00:45:41 --- last message repeated 1 time ---
Dec  1 00:45:41 AliComp.local configd[18]: network changed: v4(en1+:192.168.1.101) DNS+ Proxy+ SMB+
Dec  1 00:45:41 AliComp.local loginwindow[43]: in pam_sm_acct_mgmt(): OpenDirectory - Membership cache TTL set to 1800.
Dec  1 00:45:41 AliComp.local UserEventAgent[11]: Captive: en1: Not probing 'Supernet' (protected network)
Dec  1 00:45:41 AliComp.local loginwindow[43]: in od_record_check_pwpolicy(): retval: 0
Dec  1 00:45:41 AliComp.local loginwindow[43]: in od_record_attribute_create_cfstring(): returned 2 attributes for dsAttrTypeStandard:AuthenticationAuthority
Dec  1 00:45:41 AliComp.local loginwindow[43]: in pam_sm_setcred(): Establishing credentials
Dec  1 00:45:41 AliComp.local loginwindow[43]: in pam_sm_setcred(): Got user: alitanara
Dec  1 00:45:41 AliComp.local loginwindow[43]: in pam_sm_setcred(): Context initialised
Dec  1 00:45:41 AliComp.local loginwindow[43]: in pam_sm_setcred(): Got euid, egid: 502 20
Dec  1 00:45:41 AliComp.local loginwindow[43]: in pam_sm_setcred(): Done getpwnam()
Dec  1 00:45:41 AliComp.local loginwindow[43]: in pam_sm_setcred(): Done setegid() & seteuid()
Dec  1 00:45:41 AliComp.local loginwindow[43]: in pam_sm_setcred(): pam_sm_setcred: krb5 user alitanara doesn't have a principal
Dec  1 00:45:41 AliComp.local loginwindow[43]: in pam_sm_setcred(): Done cleanup3
Dec  1 00:45:41 AliComp.local loginwindow[43]: in pam_sm_setcred(): Done seteuid() & setegid()
Dec  1 00:45:41 AliComp.local loginwindow[43]: in pam_sm_setcred(): Done cleanup4

I would really appreciate it if someone could kindly shed some light on this matter. I have found other threads where people were able to resolve the issue by resetting the SMC and the checking and unchecking the settings, but this has not fixed it for me. I have also reset the NVRAM before and the issue keeps happening, though it did not happen for a while.

Also, if there is a way for me to avoid reinstalling OSX that would be great. I'm in middle of exams and unfortunately don't have the resources to do that.

Again, I really appreciate any help.

Thank you.

Sincerely,
alitan

 

[alitan]

Anyone has any idea on this issue?

 

[switon]

RE: pmset...

Hi alitan,

The terminal command "pmset" will provide you with the assertions that should cause/prevent your machine to/from going into sleep/hibernate modes. For instance,

pmset -g assertions

will list these assertions that prevent sleep mode from activating. The command:

pmset -g

will list the current parameter values, the command

pmset -g log

will print the log file listing all sleep/hibernate modes and what caused them. This way you can figure out why your machine goes into sleep mode.

The manpage "man pmset" provides documentation for the "pmset" command. You will need administrator privileges in order to modify any parameters, meaning that you will either have to login as root or use "sudo" in front of the pmset commands.

Good luck,
Switon