kernel: still waiting on znode … REG VTERM … gave up …

Moderators: jhartley, MSR734, nola

kernel: still waiting on znode … REG VTERM … gave up …

Post by grahamperrin » Sun Nov 17, 2013 3:09 am

For around four minutes this morning:

Code: Select all
2013-11-17 05:52:45.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:52:48.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM



2013-11-17 05:56:49.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:56:52.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM


As I never saw anything like that before, it may a side effect of me experimentally overriding one or more of the tunables.

Hopefully nothing to worry about, although I don't know the implication of giving up on a vnode ref for znode (see below).

Whilst my MacBookPro5,2 does perform much better with the current overrides, I remind myself that the tunables were for performance analysis only during a beta test.

All messages from an eight-minute period:

Code: Select all
2013-11-17 05:48:00.000 kernel[0]: still waiting on znode 1237165 (0xffffff841e483c88) REG ZIL
2013-11-17 05:48:00.000 kernel[0]: memorystatus_thread: idle exiting pid 3940 [cfprefsd]
2013-11-17 05:48:00.257 com.apple.launchd.peruser.19236[693]: (com.apple.cfprefsd.xpc.agent[3940]) Exited: Killed: 9
2013-11-17 05:48:00.516 com.apple.launchd[1]: (com.apple.cfprefsd.xpc.daemon[3920]) Exited: Killed: 9
2013-11-17 05:48:00.000 kernel[0]: memorystatus_thread: idle exiting pid 3920 [cfprefsd]
2013-11-17 05:48:00.000 kernel[0]: still waiting on znode 1237165 (0xffffff841e483c88) REG ZIL
2013-11-17 05:48:04.000 kernel[0]: still waiting on znode 1237165 (0xffffff841e483c88) REG ZIL
2013-11-17 05:48:04.000 kernel[0]: still waiting on znode 1237165 (0xffffff841e483c88) REG ZIL
2013-11-17 05:48:07.000 kernel[0]: still waiting on znode 1237165 (0xffffff841e483c88) REG ZIL
2013-11-17 05:48:07.000 kernel[0]: still waiting on znode 1237165 (0xffffff841e483c88) REG ZIL
2013-11-17 05:48:10.000 kernel[0]: still waiting on znode 1237165 (0xffffff841e483c88) REG ZIL
2013-11-17 05:48:10.000 kernel[0]: still waiting on znode 1237165 (0xffffff841e483c88) REG ZIL
2013-11-17 05:48:10.309 com.apple.launchd[1]: (com.apple.sleepservicesd[3957]) Exited: Killed: 9
2013-11-17 05:48:10.000 kernel[0]: memorystatus_thread: idle exiting pid 3957 [SleepServicesD]
2013-11-17 05:48:13.000 kernel[0]: still waiting on znode 1237165 (0xffffff841e483c88) REG ZIL
2013-11-17 05:48:13.000 kernel[0]: still waiting on znode 1237165 (0xffffff841e483c88) REG ZIL
2013-11-17 05:48:17.000 kernel[0]: still waiting on znode 1237165 (0xffffff841e483c88) REG ZIL
2013-11-17 05:48:17.000 kernel[0]: still waiting on znode 1237165 (0xffffff841e483c88) REG ZIL
2013-11-17 05:48:20.000 kernel[0]: still waiting on znode 1237165 (0xffffff841e483c88) REG ZIL
2013-11-17 05:48:20.000 kernel[0]: still waiting on znode 1237165 (0xffffff841e483c88) REG ZIL
2013-11-17 05:48:23.000 kernel[0]: still waiting on znode 1237165 (0xffffff841e483c88) REG ZIL
2013-11-17 05:48:23.000 kernel[0]: still waiting on znode 1237165 (0xffffff841e483c88) REG ZIL
2013-11-17 05:48:26.000 kernel[0]: still waiting on znode 1237165 (0xffffff841e483c88) REG ZIL
2013-11-17 05:48:27.000 kernel[0]: still waiting on znode 1237165 (0xffffff841e483c88) REG ZIL
2013-11-17 05:48:29.000 kernel[0]: still waiting on znode 1237165 (0xffffff841e483c88) REG ZIL
2013-11-17 05:48:46.185 WindowServer[671]: CGXDisableUpdate: UI updates were forcibly disabled by application "VirtualBox" for over 1.00 seconds. Server has re-enabled them.
2013-11-17 05:48:46.443 WindowServer[671]: reenable_update_for_connection: UI updates were finally reenabled by application "VirtualBox" after 1.26 seconds (server forcibly re-enabled them after 1.00 seconds)
2013-11-17 05:49:00.176 com.apple.launchd[1]: (com.apple.sleepservicesd[3965]) Exited: Killed: 9
2013-11-17 05:49:00.000 kernel[0]: memorystatus_thread: idle exiting pid 3965 [SleepServicesD]
2013-11-17 05:49:00.519 com.apple.launchd[1]: (com.apple.cfprefsd.xpc.daemon[3961]) Exited: Killed: 9
2013-11-17 05:49:00.000 kernel[0]: memorystatus_thread: idle exiting pid 3961 [cfprefsd]
2013-11-17 05:49:15.000 kernel[0]: (default pager): [KERNEL]: ps_select_segment - send HI_WAT_ALERT
2013-11-17 05:49:16.000 kernel[0]: macx_swapon SUCCESS
2013-11-17 05:49:20.158 com.apple.launchd[1]: (com.apple.sleepservicesd[3972]) Exited: Killed: 9
2013-11-17 05:49:20.000 kernel[0]: memorystatus_thread: idle exiting pid 3972 [SleepServicesD]
2013-11-17 05:49:41.212 com.apple.launchd[1]: (com.apple.sleepservicesd[3976]) Exited: Killed: 9
2013-11-17 05:49:41.000 kernel[0]: memorystatus_thread: idle exiting pid 3976 [SleepServicesD]
2013-11-17 05:49:49.000 kernel[0]: USBF:   14614.159   AppleUSBOHCI::SuspendUSBBus Processing WDH before suspending
2013-11-17 05:49:55.954 WindowServer[671]: CGXDisableUpdate: UI updates were forcibly disabled by application "Finder" for over 1.00 seconds. Server has re-enabled them.
2013-11-17 05:49:55.956 WindowServer[671]: reenable_update_for_connection: UI updates were finally reenabled by application "Finder" after 1.12 seconds (server forcibly re-enabled them after 1.12 seconds)
2013-11-17 05:50:27.000 kernel[0]: USBF:   14651.281   AppleUSBOHCI::SuspendUSBBus Processing WDH before suspending
2013-11-17 05:50:28.192 com.apple.backupd[1697]: Copied 34.1 GB of 41.86 GB, 639750 of 756016 items
2013-11-17 05:50:43.000 kernel[0]: nspace-handler-set-snapshot-time: 1384667445
2013-11-17 05:50:52.000 kernel[0]: memorystatus_thread: idle exiting pid 3987 [cfprefsd]
2013-11-17 05:50:52.517 com.apple.launchd[1]: (com.apple.sleepservicesd[3977]) Exited: Killed: 9
2013-11-17 05:50:52.000 kernel[0]: memorystatus_thread: idle exiting pid 3977 [SleepServicesD]
2013-11-17 05:51:03.277 com.apple.mtmd[52]: attempting to thin because of low free space on spare (/Volumes/spare) by removing 2013-11-17 04:49:32 +0000, estimate 0 bytes to recover, 1 snapshot can be thinned
2013-11-17 05:51:03.352 com.apple.mtmd[52]: attempting to thin because of low free space on disk0s3 (/Volumes/disk0s3) by removing 2013-11-17 04:49:32 +0000, estimate 0 bytes to recover, 1 snapshot can be thinned
2013-11-17 05:51:03.847 com.apple.launchd[1]: (com.apple.sleepservicesd[3991]) Exited: Killed: 9
2013-11-17 05:51:03.000 kernel[0]: memorystatus_thread: idle exiting pid 3991 [SleepServicesD]
2013-11-17 05:51:05.911 SIMBL Agent[779]: warning: failed to get scripting definition from /Applications/Utilities/Console.app; it may not be scriptable.
2013-11-17 05:51:15.000 kernel[0]: memorystatus_thread: idle exiting pid 3995 [SleepServicesD]
2013-11-17 05:51:15.526 com.apple.launchd[1]: (com.apple.sleepservicesd[3995]) Exited: Killed: 9
2013-11-17 05:51:20.000 kernel[0]: Sandbox: sandboxd(3998) deny mach-lookup com.apple.coresymbolicationd
2013-11-17 05:51:22.939 Console[3959]: Performance: Please update this scripting addition to supply a value for ThreadSafe for each event handler: "/Library/ScriptingAdditions/SIMBL.osax"
2013-11-17 05:51:25.830 com.apple.launchd[1]: (com.apple.xpcd.244B0000-0000-0000-0000-000000000000[3990]) Exited: Killed: 9
2013-11-17 05:51:26.000 kernel[0]: memorystatus_thread: idle exiting pid 3990 [xpcd]
2013-11-17 05:51:27.045 com.apple.launchd[1]: (com.apple.sleepservicesd[3999]) Exited: Killed: 9
2013-11-17 05:51:27.000 kernel[0]: memorystatus_thread: idle exiting pid 3999 [SleepServicesD]
2013-11-17 05:51:35.871 mdworker[4001]: code validation failed in the process of getting signing information; codeRef: 0x7fc93b4139b0
2013-11-17 05:51:35.976 mdworker[4001]: code validation failed in the process of getting signing information; codeRef: 0x7fc93b4139b0
2013-11-17 05:51:45.249 com.apple.launchd[1]: (com.apple.sleepservicesd[4000]) Exited: Killed: 9
2013-11-17 05:51:45.000 kernel[0]: memorystatus_thread: idle exiting pid 4000 [SleepServicesD]
2013-11-17 05:51:46.000 kernel[0]: zfsdev_ioctl: function error 16 on command 24
2013-11-17 05:51:46.000 kernel[0]: zfsdev_ioctl: function error 16 on command 24
2013-11-17 05:51:47.963 com.apple.launchd[1]: (com.apple.cfprefsd.xpc.daemon[3979]) Exited: Killed: 9
2013-11-17 05:51:47.000 kernel[0]: memorystatus_thread: idle exiting pid 3979 [cfprefsd]
2013-11-17 05:51:50.110 com.apple.launchd.peruser.19236[693]: (com.apple.cfprefsd.xpc.agent[3958]) Exited: Killed: 9
2013-11-17 05:51:50.000 kernel[0]: memorystatus_thread: idle exiting pid 3958 [cfprefsd]
2013-11-17 05:51:57.198 com.apple.launchd[1]: (com.apple.sleepservicesd[4003]) Exited: Killed: 9
2013-11-17 05:51:57.000 kernel[0]: memorystatus_thread: idle exiting pid 4003 [SleepServicesD]
2013-11-17 05:52:08.000 kernel[0]: memorystatus_thread: idle exiting pid 4009 [SleepServicesD]
2013-11-17 05:52:08.400 com.apple.launchd[1]: (com.apple.sleepservicesd[4009]) Exited: Killed: 9
2013-11-17 05:52:19.715 com.apple.launchd[1]: (com.apple.sleepservicesd[4031]) Exited: Killed: 9
2013-11-17 05:52:19.000 kernel[0]: memorystatus_thread: idle exiting pid 4031 [SleepServicesD]
2013-11-17 05:52:20.870 com.apple.launchd.peruser.19236[693]: (com.apple.tccd[4025]) Exited: Killed: 9
2013-11-17 05:52:20.000 kernel[0]: memorystatus_thread: idle exiting pid 4025 [tccd]
2013-11-17 05:52:32.524 com.apple.launchd[1]: (com.apple.sleepservicesd[4033]) Exited: Killed: 9
2013-11-17 05:52:32.000 kernel[0]: memorystatus_thread: idle exiting pid 4033 [SleepServicesD]
2013-11-17 05:52:37.000 kernel[0]: memorystatus_thread: idle exiting pid 1794 [distnoted]
2013-11-17 05:52:43.562 com.apple.launchd[1]: (com.apple.sleepservicesd[4035]) Exited: Killed: 9
2013-11-17 05:52:43.000 kernel[0]: memorystatus_thread: idle exiting pid 4035 [SleepServicesD]
2013-11-17 05:52:45.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:52:48.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:52:48.488 coreaudiod[371]: Disabled automatic stack shots because audio IO is active
2013-11-17 05:52:48.567 coreaudiod[371]: Enabled automatic stack shots because audio IO is inactive
2013-11-17 05:52:51.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:52:53.286 com.apple.launchd.peruser.19236[693]: (com.apple.accountsd[4037]) Exited: Killed: 9
2013-11-17 05:52:53.000 kernel[0]: memorystatus_thread: idle exiting pid 4037 [accountsd]
2013-11-17 05:52:53.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:52:55.023 com.apple.launchd[1]: (com.apple.sleepservicesd[4038]) Exited: Killed: 9
2013-11-17 05:52:55.000 kernel[0]: memorystatus_thread: idle exiting pid 4038 [SleepServicesD]
2013-11-17 05:52:55.000 kernel[0]: memorystatus_thread: idle exiting pid 4036 [com.apple.iCloud]
2013-11-17 05:52:55.700 com.apple.launchd[1]: (com.apple.iCloudHelper[4036]) Exited: Killed: 9
2013-11-17 05:52:57.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:52:57.856 LKDCHelper[4042]: Starting (uid=19236)
2013-11-17 05:53:00.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:53:03.156 com.apple.launchd[1]: (com.apple.xpcd.244B0000-0000-0000-0000-000000000000[4034]) Exited: Killed: 9
2013-11-17 05:53:03.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:53:03.000 kernel[0]: memorystatus_thread: idle exiting pid 4034 [xpcd]
2013-11-17 05:53:04.720 com.apple.launchd.peruser.19236[693]: (com.apple.pbs[4011]) Exited: Killed: 9
2013-11-17 05:53:04.000 kernel[0]: memorystatus_thread: idle exiting pid 4011 [pbs]
2013-11-17 05:53:06.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:53:06.482 com.apple.launchd[1]: (com.apple.sleepservicesd[4041]) Exited: Killed: 9
2013-11-17 05:53:06.000 kernel[0]: memorystatus_thread: idle exiting pid 4041 [SleepServicesD]
2013-11-17 05:53:09.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:53:12.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:53:12.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:53:15.389 com.apple.launchd.peruser.19236[693]: (com.apple.cfprefsd.xpc.agent[4007]) Exited: Killed: 9
2013-11-17 05:53:15.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:53:15.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:53:15.000 kernel[0]: memorystatus_thread: idle exiting pid 4007 [cfprefsd]
2013-11-17 05:53:15.797 com.apple.launchd[1]: (com.apple.cfprefsd.xpc.daemon[4006]) Exited: Killed: 9
2013-11-17 05:53:15.000 kernel[0]: memorystatus_thread: idle exiting pid 4006 [cfprefsd]
2013-11-17 05:53:17.759 com.apple.launchd[1]: (com.apple.sleepservicesd[4045]) Exited: Killed: 9
2013-11-17 05:53:17.000 kernel[0]: memorystatus_thread: idle exiting pid 4045 [SleepServicesD]
2013-11-17 05:53:18.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:53:18.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:53:21.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:53:21.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:53:24.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:53:24.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:53:27.047 com.apple.launchd.peruser.19236[693]: (com.apple.cfprefsd.xpc.agent[4050]) Exited: Killed: 9
2013-11-17 05:53:27.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:53:27.000 kernel[0]: memorystatus_thread: idle exiting pid 4050 [cfprefsd]
2013-11-17 05:53:28.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:53:28.910 com.apple.launchd[1]: (com.apple.sleepservicesd[4051]) Exited: Killed: 9
2013-11-17 05:53:28.000 kernel[0]: memorystatus_thread: idle exiting pid 4051 [SleepServicesD]
2013-11-17 05:53:30.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:53:31.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:53:33.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:53:34.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:53:36.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:53:37.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:53:39.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:53:40.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:53:42.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:53:43.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:53:45.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:53:47.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:53:48.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:53:50.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:53:51.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:53:53.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:53:54.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:53:56.324 com.apple.launchd[1]: (com.apple.sleepservicesd[4052]) Exited: Killed: 9
2013-11-17 05:53:56.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:53:56.000 kernel[0]: memorystatus_thread: idle exiting pid 4052 [SleepServicesD]
2013-11-17 05:53:57.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:53:59.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:54:00.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:54:02.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:54:03.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:54:05.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:54:06.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:54:07.947 com.apple.launchd[1]: (com.apple.sleepservicesd[4060]) Exited: Killed: 9
2013-11-17 05:54:07.000 kernel[0]: memorystatus_thread: idle exiting pid 4060 [SleepServicesD]
2013-11-17 05:54:08.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:54:09.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:54:11.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:54:12.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:54:12.000 kernel[0]: memorystatus_thread: idle exiting pid 4059 [cfprefsd]
2013-11-17 05:54:13.195 com.apple.launchd[1]: (com.apple.cfprefsd.xpc.daemon[4059]) Exited: Killed: 9
2013-11-17 05:54:14.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:54:14.000 kernel[0]: memorystatus_thread: idle exiting pid 4058 [cfprefsd]
2013-11-17 05:54:15.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:54:17.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:54:18.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:54:19.152 com.apple.launchd[1]: (com.apple.sleepservicesd[4063]) Exited: Killed: 9
2013-11-17 05:54:19.000 kernel[0]: memorystatus_thread: idle exiting pid 4063 [SleepServicesD]
2013-11-17 05:54:20.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:54:21.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:54:23.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:54:24.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:54:26.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:54:28.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:54:29.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:54:31.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:54:32.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:54:34.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:54:35.564 com.apple.launchd[1]: (com.apple.sleepservicesd[4066]) Exited: Killed: 9
2013-11-17 05:54:35.000 kernel[0]: memorystatus_thread: idle exiting pid 4066 [SleepServicesD]
2013-11-17 05:54:36.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:54:36.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:54:39.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:54:39.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:54:42.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:54:42.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:54:45.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:54:45.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:54:48.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:54:48.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:54:50.803 com.apple.launchd[1]: (com.apple.sleepservicesd[4067]) Exited: Killed: 9
2013-11-17 05:54:50.000 kernel[0]: memorystatus_thread: idle exiting pid 4067 [SleepServicesD]
2013-11-17 05:54:51.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:54:51.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:54:54.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:54:54.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:54:58.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:54:58.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:55:01.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:55:01.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:55:02.006 com.apple.launchd[1]: (com.apple.sleepservicesd[4068]) Exited: Killed: 9
2013-11-17 05:55:02.000 kernel[0]: memorystatus_thread: idle exiting pid 4068 [SleepServicesD]
2013-11-17 05:55:04.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:55:04.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:55:07.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:55:07.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:55:10.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:55:10.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:55:13.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:55:13.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:55:15.000 kernel[0]: memorystatus_thread: idle exiting pid 4075 [cfprefsd]
2013-11-17 05:55:16.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:55:16.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:55:17.883 com.apple.launchd[1]: (com.apple.sleepservicesd[4074]) Exited: Killed: 9
2013-11-17 05:55:17.000 kernel[0]: memorystatus_thread: idle exiting pid 4074 [SleepServicesD]
2013-11-17 05:55:19.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:55:19.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:55:22.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:55:22.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:55:25.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:55:25.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:55:28.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:55:28.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:55:31.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:55:31.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:55:34.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:55:34.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:55:37.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:55:37.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:55:40.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:55:40.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:55:43.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:55:43.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:55:46.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:55:46.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:55:49.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:55:49.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:55:52.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:55:52.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:55:55.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:55:55.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:55:58.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:55:58.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:56:01.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:56:01.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:56:04.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:56:04.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:56:07.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:56:07.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:56:09.907 sudo[4082]:    gjp22 : TTY=ttys004 ; PWD=/Volumes/gjp22 ; USER=root ; COMMAND=/bin/launchctl list
2013-11-17 05:56:10.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:56:11.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:56:13.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:56:14.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:56:16.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:56:17.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:56:19.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:56:20.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:56:22.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:56:22.540 sudo[4090]:    gjp22 : TTY=ttys004 ; PWD=/Volumes/gjp22 ; USER=root ; COMMAND=/bin/launchctl list com.getgreenbytes.zfs.autosnapshots
2013-11-17 05:56:24.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:56:25.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:56:27.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:56:28.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:56:30.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:56:32.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:56:33.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:56:35.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:56:35.770 com.apple.launchd[1]: (com.apple.sleepservicesd[4080]) Exited: Killed: 9
2013-11-17 05:56:35.000 kernel[0]: memorystatus_thread: idle exiting pid 4080 [SleepServicesD]
2013-11-17 05:56:36.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:56:36.000 kernel[0]: memorystatus_thread: idle exiting pid 4079 [cfprefsd]
2013-11-17 05:56:36.000 kernel[0]: memorystatus_thread: idle exiting pid 4057 [distnoted]
2013-11-17 05:56:38.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:56:39.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:56:39.769 com.apple.launchd[1]: (com.apple.cfprefsd.xpc.daemon[4072]) Exited: Killed: 9
2013-11-17 05:56:39.000 kernel[0]: memorystatus_thread: idle exiting pid 4072 [cfprefsd]
2013-11-17 05:56:41.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:56:42.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:56:44.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:56:45.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:56:47.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:56:49.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:56:49.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:56:52.000 kernel[0]: still waiting on znode 1237165 (0xffffff8446acd960) REG ZIL
2013-11-17 05:56:52.000 kernel[0]: still waiting on znode 16909459 (0xffffff841e4621a8) REG VTERM
2013-11-17 05:56:54.000 kernel[0]: gave up on vnode ref for znode 16909459 @ 0xffffff841e4621a8, vp 0xffffff803fbfcba0
grahamperrin Offline

User avatar
 
Posts: 1596
Joined: Fri Sep 14, 2012 10:21 pm
Location: Brighton and Hove, United Kingdom

Re: kernel: still waiting on znode … REG VTERM … gave up …

Post by leeb » Sun Nov 17, 2013 2:45 pm

grahamperrin wrote:As I never saw anything like that before, it may a side effect of me experimentally overriding one or more of the tunables.

It's not. Was a significant issue during the beta, though it was improved greatly back when ZEVO was being developed and should now usually be a nuisance rather then very serious. I can still get it to trigger pretty reliably with certain virtual machine access patterns, just saw it a few minutes ago actually, and on a system that I haven't done any tunable configuration at all on. It hopefully won't render your system useless any longer and will eventually recover itself within 5 minutes or so, but it can make whatever application trying to call die in some cases. Just a quirk to ignore though since not really anything to be done about it in the context of ZEVO. Hopefully as OpenZFS development picks up and gets more mature we'll see ZFS-OSX surpass ZEVO entirely at some point, or perhaps that latter will get open sourced, get picked up and resync'd, or whatever.
leeb Offline


 
Posts: 3
Joined: Fri Sep 14, 2012 11:09 pm

Re: kernel: still waiting on znode … REG VTERM … gave up …

Post by grahamperrin » Sun Nov 17, 2013 4:45 pm

Thanks for the insight. Much appreciated.

… ZFS-OSX …


https://groups.google.com/forum/#!forum/maczfs-devel – I can respond to things there.

… make whatever application trying to call die in some cases.


I do have occasional trouble with one VirtualBoxVM (Mavericks guest) aborting, but I can't correlate those incidents with REG VTERM messages at the Mountain Lion host.

Out of interest, I used Spotlight to search my seed test archives for VTERM. Just one match, from earlier this year:

Code: Select all
Feb  9 11:35:19 macbookpro08-centrim kernel[0]: still waiting on znode 11750398 (0xffffff813887d320) REG VTERM


So for me, the quirk is very rare.

Just a quirk to ignore …


+1
grahamperrin Offline

User avatar
 
Posts: 1596
Joined: Fri Sep 14, 2012 10:21 pm
Location: Brighton and Hove, United Kingdom


Return to General Discussion

Who is online

Users browsing this forum: ilovezfs and 0 guests

cron