Skip to content

Instantly share code, notes, and snippets.

@octomike
Created April 12, 2016 15:02
Show Gist options
  • Star 0 You must be signed in to star a gist
  • Fork 0 You must be signed in to fork a gist
  • Save octomike/be9b76d0dc164c41c84bd7fffa97e916 to your computer and use it in GitHub Desktop.
Save octomike/be9b76d0dc164c41c84bd7fffa97e916 to your computer and use it in GitHub Desktop.
OSX RTC wakeup and puppet fail
Apr 12 05:55:12 <hostname> kernel[0]: IOThunderboltSwitch<0xffffff8013e5c200>(0x0)::listenerCallback - Thunderbolt HPD packet for route = 0x0 port = 11 unplug = 0
Apr 12 05:55:12 <hostname> kernel[0]: vm_compressor_flush - starting
Apr 12 05:55:12 <hostname> kernel[0]: vm_compressor_flush completed - took 523 msecs
Apr 12 05:55:12 <hostname> kernel[0]: hibernate_flush_memory: buffer_cache_gc freed up 1694 wired pages
Apr 12 05:55:12 <hostname> kernel[0]: hibernate_alloc_pages act 42879, inact 2096, anon 53, throt 0, spec 6393, wire 180796, wireinit 86809
Apr 12 05:55:12 <hostname> kernel[0]: hibernate_setup(0) took 708 ms
Apr 12 05:55:12 <hostname> kernel[0]: ARPT: 6209.439451: wl0: leaveModulePoweredForOffloads: Wi-Fi will stay on.
Apr 12 05:55:12 <hostname> kernel[0]: AppleBCM5701Ethernet [en0]: Link down (womp enabled, proxy 445)
Apr 12 05:55:12 <hostname> kernel[0]: AppleBCM5701Ethernet [en0]: 0 0 memWrInd fBJP_Wakeup_Timer
Apr 12 05:55:12 <hostname> kernel[0]: hibernate_page_list_setall(preflight 0) start 0xffffff80d3c5d000, 0xffffff80d3c9d000
Apr 12 05:55:12 <hostname> kernel[0]: hibernate_teardown started
Apr 12 05:55:12 <hostname> kernel[0]: hibernate_teardown: wired_pages 180769, free_pages 1860376, active_pages 40000, inactive_pages 0, speculative_pages 0, cleaned_pages 0, compressor_pages 54
Apr 12 05:55:12 <hostname> kernel[0]: hibernate_teardown_pmap_structs done: last_valid_compact_indx 118117
Apr 12 05:55:12 <hostname> kernel[0]: hibernate_teardown: mark_as_unneeded_pages 2048, 28977, 19024
Apr 12 05:55:12 <hostname> kernel[0]: hibernate_teardown completed - discarded 50049
Apr 12 05:55:12 <hostname> kernel[0]: hibernate_page_list_setall time: 244 ms
Apr 12 05:55:12 <hostname> kernel[0]: pages 150534, wire 99112, act 40000, inact 0, cleaned 0 spec 0, zf 0, throt 0, compr 54, xpmapped 40000
Apr 12 05:55:12 <hostname> kernel[0]: did discard act 2871 inact 2096 purgeable 8 spec 6393 cleaned 0
Apr 12 05:55:12 <hostname> kernel[0]: WARNING: hibernate_page_list_setall skipped 184 xpmapped pages
Apr 12 05:55:12 <hostname> kernel[0]: hibernate_page_list_setall found pageCount 139166
Apr 12 05:55:12 <hostname> kernel[0]: IOHibernatePollerOpen, ml_get_interrupts_enabled 0
Apr 12 05:55:12 <hostname> kernel[0]: IOHibernatePollerOpen(0)
Apr 12 05:55:12 <hostname> kernel[0]: encryptStart 14010
Apr 12 05:55:12 <hostname> kernel[0]: bitmap_size 0x3f104, previewSize 0xb7e628, writing 135871 pages @ 0xbd173c
Apr 12 05:55:12 <hostname> kernel[0]: hibernate_rebuild started
Apr 12 05:55:12 <hostname> kernel[0]: hibernate_rebuild_pmap_structs done: last_valid_compact_indx 118117
Apr 12 05:55:12 <hostname> kernel[0]: hibernate_rebuild completed - took 34 msecs
Apr 12 05:55:12 <hostname> kernel[0]: booter start at 704 ms smc 0 ms, [16, 0, 0] total 320 ms, dsply 0, 0 ms, tramp 265 ms
Apr 12 05:55:12 <hostname> kernel[0]: hibernate_machine_init: state 2, image pages 98899, sum was f7988012, imageSize 0x122cf000, image1Size 0x8f3e000, conflictCount 206, nextFree 18d
Apr 12 05:55:12 <hostname> kernel[0]: hibernate_newruntime_map time: 0 ms, IOHibernatePollerOpen(), ml_get_interrupts_enabled 0
Apr 12 05:55:12 <hostname> kernel[0]: IOHibernatePollerOpen(0) 10 ms
Apr 12 05:55:12 <hostname> kernel[0]: hibernate_machine_init reading
Apr 12 05:55:12 <hostname> kernel[0]: PMStats: Hibernate read took 307 ms
Apr 12 05:55:12 <hostname> kernel[0]: hibernate_machine_init pagesDone 138953 sum2 9c094bfb, time: 307 ms, disk(0x20000) 496 Mb/s, comp bytes: 53813248 time: 40 ms 1274 Mb/s, crypt bytes: 154734592 time: 35 ms 4136 Mb/s
Apr 12 05:55:12 <hostname> kernel[0]: Wake reason: RTC (Alarm)
Apr 12 05:55:12 <hostname> kernel[0]: RTC: Maintenance 2016/4/12 12:55:11, sleep 2016/4/12 10:55:15
Apr 12 05:55:12 <hostname> kernel[0]: Previous sleep cause: 5
Apr 12 05:55:12 <hostname> kernel[0]: Previous shutdown cause: 5
Apr 12 05:55:12 <hostname> kernel[0]: AppleThunderboltNHIType2::prePCIWake - power up complete - took 136 us
Apr 12 05:55:12 <hostname> kernel[0]: ARPT: 6210.660091: wl0: leaveModulePoweredForOffloads: Wi-Fi will stay on.
Apr 12 05:55:12 <hostname> kernel[0]: IOThunderboltSwitch<0xffffff8013e5c200>(0x0)::listenerCallback - Thunderbolt HPD packet for route = 0x0 port = 11 unplug = 0
Apr 12 05:55:12 <hostname> kernel[0]: TBT W (2): 0x0040 [x]
Apr 12 05:55:12 <hostname> kernel[0]: AppleThunderboltGenericHAL::earlyWake - complete - took 133 milliseconds
Apr 12 05:55:12 <hostname> kernel[0]: ARPT: 6210.976306: AirPort_Brcm43xx::powerChange: System Wake - Full Wake/ Dark Wake / Maintenance wake
Apr 12 05:55:12 <hostname> kernel[0]: ARPT: 6210.976311: AirPort_Brcm43xx::checkInterfacePowerState: Check _pwrOffThreadCall!
Apr 12 05:55:12 <hostname> configd[50]: network changed: v4(en0-:141.14.157.209) DNS- Proxy-
Apr 12 05:55:12 <hostname> networkd[159]: +[NETLedBelly stopFastFail] Clearing ledbelly failure cache
Apr 12 05:55:13 <hostname> puppet-agent[32754]: Unable to fetch my node definition, but the agent run will continue:
Apr 12 05:55:13 <hostname> puppet-agent[32754]: getaddrinfo: nodename nor servname provided, or not known
Apr 12 05:55:13 <hostname> puppet-agent[32754]: (/File[/private/var/lib/puppet/facts.d]) Failed to generate additional resources using 'eval_generate': getaddrinfo: nodename nor servname provided, or not known
Apr 12 05:55:13 <hostname> puppet-agent[32754]: (/File[/private/var/lib/puppet/facts.d]) Could not evaluate: Could not retrieve file metadata for puppet://<puppetserver>/pluginfacts: getaddrinfo: nodename nor servname provided, or not known
Apr 12 05:55:13 <hostname> kernel[0]: Ethernet [AppleBCM5701Ethernet]: Link up on en0, 1-Gigabit, Full-duplex, Symmetric flow-control, Debug [796d,2301,0de1,0300,c5e1,2800]
Apr 12 05:55:13 <hostname> puppet-agent[32754]: (/File[/private/var/lib/puppet/lib]) Failed to generate additional resources using 'eval_generate': getaddrinfo: nodename nor servname provided, or not known
Apr 12 05:55:13 <hostname> puppet-agent[32754]: (/File[/private/var/lib/puppet/lib]) Could not evaluate: Could not retrieve file metadata for puppet://<puppetserver>/plugins: getaddrinfo: nodename nor servname provided, or not known
Apr 12 05:55:14 <hostname> netbiosd[32742]: network_reachability_changed : network is not reachable, netbiosd is shutting down
Apr 12 05:55:15 <hostname> networkd[159]: +[NETLedBelly stopFastFail] Clearing ledbelly failure cache
Apr 12 05:55:15 <hostname> configd[50]: network changed: v4(en0+:<IPv4_Addr>) DNS+ Proxy+ SMB
Apr 12 05:55:18 <hostname> kernel[0]: en1: channel changed to 1
Apr 12 05:55:18 <hostname> kernel[0]: AirPort: Link Up on awdl0
Apr 12 05:55:18 <hostname> ntpd[188]: wake time set -0.183449 s
Apr 12 05:55:20 <hostname> mDNSResponder[86]: AwdlD2d AwdlD2dStartAdvertisingPair: '<hostname>' Advertising service started
Apr 12 05:55:20 <hostname> mDNSResponder[86]: AwdlD2d AwdlD2dStartAdvertisingPair: '<foo>ip6arpa' Advertising service started
Apr 12 05:55:21 <hostname> kernel[0]: IO80211AWDLPeerManager::doDisable source [handleSIOCSIFFLAGS]
Apr 12 05:55:21 <hostname> kernel[0]: AirPort: Link Down on awdl0. Reason 1 (Unspecified).
Apr 12 05:55:21 <hostname> kernel[0]: IO80211AWDLPeerManager::doDisable source [setLinkState]
Apr 12 05:55:25 <hostname> puppet-agent[32754]: Could not prefetch service provider 'launchd': No child processes
Apr 12 05:55:25 <hostname> puppet-agent[32754]: Could not set 'running' on ensure: No child processes at 12:/etc/puppetlabs/code/environments/production/modules/sshd/manifests/darwin.pp
Apr 12 05:55:25 <hostname>ge repeated 1 time ---
Apr 12 05:55:25 <hostname> puppet-agent[32754]: Wrapped exception:
Apr 12 05:55:25 <hostname> puppet-agent[32754]: No child processes
Apr 12 05:55:25 <hostname> puppet-agent[32754]: (/Stage[main]/Sshd::Darwin/Service[com.openssh.sshd]/ensure) change from absent to running failed: Could not set 'running' on ensure: No child processes at 12:/etc/puppetlabs/code/environments/production/modules/sshd/manifests/darwin.pp
Apr 12 05:55:25 <hostname> puppet-agent[32754]: (/Stage[main]/Lip_munki/Lip_osxdefaults::Lip_osxdefaults[munki client identifier]/Exec[write munki client identifier]) Could not evaluate: No child processes
Apr 12 05:55:25 <hostname> puppet-agent[32754]: (/Stage[main]/Lip_munki/Lip_osxdefaults::Lip_osxdefaults[munki repo url]/Exec[write munki repo url]) Dependency Exec[write munki client identifier] has failures: true
Apr 12 05:55:25 <hostname> puppet-agent[32754]: (/Stage[main]/Lip_munki/Lip_osxdefaults::Lip_osxdefaults[munki repo url]/Exec[write munki repo url]) Skipping because of failed dependencies
Apr 12 05:55:25 <hostname> puppet-agent[32754]: Could not prefetch user provider 'directoryservice': No child processes
Apr 12 05:55:25 <hostname> puppet-agent[32754]: (/User[admin]) Could not evaluate: No child processes
Apr 12 05:55:25 <hostname> puppet-agent[32754]: (/Stage[main]/Lip_printers::Cups/Lip_printers::Cups::Printer[LIP_AUTO_C353]/Printer[LIP_AUTO_C353]/ensure) created
Apr 12 05:55:25 <hostname> puppet-agent[32754]: (/Stage[main]/Lip_printers::Cups/Lip_printers::Cups::Printer[LIP_AUTO_C353]/Printer[LIP_AUTO_C353]) Could not evaluate: No child processes
Apr 12 05:55:25 <hostname> puppet-agent[32754]: (/Stage[main]/Puppetclient::Darwin/Service[com.puppetlabs.puppet]/ensure) defined 'ensure' as 'running'
Apr 12 05:55:25 <hostname> puppet-agent[32754]: (/Stage[main]/Lip_printers::Cups/Lip_printers::Cups::Printer[LIP_AUTO_C220]/Printer[LIP_AUTO_C220]/ensure) created
Apr 12 05:55:26 <hostname> puppet-agent[32754]: (/Stage[main]/Lip_printers::Cups/Lip_printers::Cups::Printer[LIP_AUTO_C220]/Printer[LIP_AUTO_C220]) Could not evaluate: No child processes
Apr 12 05:55:26 <hostname> puppet-agent[32754]: (/Stage[main]/Lip_printers::Cups/Lip_printers::Cups::Printer[LIP_AUTO_C360]/Printer[LIP_AUTO_C360]/ensure) created
Apr 12 05:55:26 <hostname> puppet-agent[32754]: (/Stage[main]/Lip_printers::Cups/Lip_printers::Cups::Printer[LIP_AUTO_C360]/Printer[LIP_AUTO_C360]) Could not evaluate: No child processes
Apr 12 05:55:26 <hostname> puppet-agent[32754]: (/Stage[main]/Lip_autoupgrades::Darwin/Lip_osxdefaults::Lip_osxdefaults[auto_update_check]/Exec[write auto_update_check]) Could not evaluate: No child processes
Apr 12 05:55:26 <hostname> puppet-agent[32754]: (/Stage[main]/Lip_autoupgrades::Darwin/Lip_osxdefaults::Lip_osxdefaults[auto_updates]/Exec[write auto_updates]) Could not evaluate: No child processes
Apr 12 05:55:26 <hostname> puppet-agent[32754]: Finished catalog run in 1.68 seconds
Apr 12 05:55:56 <hostname> kernel[0]: pci pause: SDXC
Apr 12 05:56:02 <hostname> mDNSResponder[86]: mDNSPlatformClearSPSMACAddr: Unable to remove key
Apr 12 05:56:02 <hostname> airportd[54]: _configureScanOffloadParameters: Unable to configure scan offloading on en1 (Device power is off)
Apr 12 05:56:04 <hostname> kernel[0]: PM response took 1821 ms (51, powerd)
Apr 12 05:56:04 <hostname> kernel[0]: ARPT: 6262.875456: AirPort_Brcm43xx::powerChange: System Sleep
Apr 12 05:56:04 <hostname> kernel[0]: ARPT: 6262.875460: wl0: powerChange: *** BONJOUR/MDNS OFFLOADS ARE NOT RUNNING.
Apr 12 05:56:04 <hostname> SystemUIServer[222]: Menu Extra: <DisplaysExtra: 0x7f9f22510ff0> is over retained.
Apr 12 05:56:04 <hostname> kernel[0]: hibernate image path: /var/vm/sleepimage
Apr 12 05:56:04 <hostname> kernel[0]: efi pagecount 67
Apr 12 05:56:04 <hostname> kernel[0]: hibernate_page_list_setall(preflight 1) start 0xffffff80d3c5d000, 0xffffff80d3c9d000
Apr 12 05:56:04 <hostname> kernel[0]: hibernate_page_list_setall time: 146 ms
Apr 12 05:56:04 <hostname> kernel[0]: pages 270760, wire 151356, act 46688, inact 1, cleaned 0 spec 6, zf 68, throt 0, compr 21558, xpmapped 40000
Apr 12 05:56:04 <hostname> kernel[0]: could discard act 42752 inact 2039 purgeable 8 spec 6284 cleaned 0
Apr 12 05:56:04 <hostname> kernel[0]: WARNING: hibernate_page_list_setall skipped 184 xpmapped pages
Apr 12 05:56:04 <hostname> kernel[0]: hibernate_page_list_setall preflight pageCount 151356 est comp 51 setfile 360710144 min 2147483648
Apr 12 05:56:04 <hostname> kernel[0]: [0x2ec80c000, 0x40000000]
Apr 12 05:56:04 <hostname> kernel[0]: [0x32c80c000, 0x40000000]
Apr 12 05:56:04 <hostname> kernel[0]: [0x0, 0x0]
Apr 12 05:56:04 <hostname> kernel[0]: kern_open_file_for_direct_io(0) took 0 ms
Apr 12 05:56:04 <hostname> kernel[0]: Opened file /var/vm/sleepimage, size 2147483648, partition base 0x0, maxio 2000000 ssd 1
Apr 12 05:56:04 <hostname> kernel[0]: hibernate image major 1, minor 0, blocksize 4096, pollers 5
Apr 12 05:56:04 <hostname> kernel[0]: AppleThunderboltNHIType2::prePCIWake - power up complete - took 177 us
Apr 12 05:56:04 <hostname> kernel[0]: AppleThunderboltGenericHAL::earlyWake - complete - took 0 milliseconds
Apr 12 05:56:05 <hostname> kernel[0]: AppleThunderboltNHIType2::waitForOk2Go2Sx - retries = 16
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment