Numerous FPCarbonVol.cpp errors from AppleFileServer presage fseventsd: SLOWDOWN: client sleeping due to too many errors, pid 373 (Finder)

Question

Numerous FPCarbonVol.cpp errors from AppleFileServer presage fseventsd: SLOWDOWN: client sleeping due to too many errors, pid 373 (Finder)

I have a 2009 Mac Mini running OS X 10.8.5 Server. It was running for about 30 days straight, but a couple of days ago the system became totally unresponsive to Screen Sharing, Remote Desktop, VPN connections, SMB/AFP sessions, and even SSH logins. It would, however, respond to pings, and I could see a measurable amount of traffic from the machine at the router, which indicated that my CrashPlan backup was still running.

Looking back at the logs, I found an uncountable number of these FPCarbonVol.cpp errors before fseventsd started howling. But before that, I was seeing these errors occuring right after Time Machine started. These errors began on March 11th.

AppleFileServer _Assert error (FPCarbonVol.cpp)

fseventsd SLOWDOWN: client sleeping (pid 373, Finder)

3/17/14 1:19:42.174 AM AppleFileServer[6528]: _Assert: /SourceCache/afpserver/afpserver-607.8/afpserver/FPCarbonVol.cpp, 70 (-35)
3/17/14 1:19:47.145 AM digest-service[15442]: label: default
3/17/14 1:19:47.146 AM digest-service[15442]:     dbname: od:/Local/Default
3/17/14 1:19:47.146 AM digest-service[15442]:     mkey_file: /var/db/krb5kdc/m-key
3/17/14 1:19:47.147 AM digest-service[15442]:     acl_file: /var/db/krb5kdc/kadmind.acl
3/17/14 1:19:47.149 AM digest-service[15442]: digest-request: uid=0
3/17/14 1:19:47.167 AM rpcsvchost[15443]: sandbox_init: com.apple.msrpc.netlogon.sb succeeded
3/17/14 1:19:47.170 AM digest-service[15442]: digest-request: init request
3/17/14 1:19:47.173 AM digest-service[15442]: digest-request: init return domain: BUILTIN server: TARDIS
3/17/14 1:19:47.218 AM com.apple.launchd[1]: (com.apple.smbd[15441]) Check-in of Mach service failed. Already active: com.apple.smbd
3/17/14 1:19:47.418 AM sandboxd[15444]: ([15441]) smbd(15441) deny job-creation
3/17/14 1:19:47.000 AM kernel[0]: Sandbox: sandboxd(15444) deny mach-lookup com.apple.coresymbolicationd
3/17/14 1:19:52.174 AM AppleFileServer[6528]: _Assert: /SourceCache/afpserver/afpserver-607.8/afpserver/FPCarbonVol.cpp, 70 (-35)
3/17/14 1:20:02.173 AM AppleFileServer[6528]: _Assert: /SourceCache/afpserver/afpserver-607.8/afpserver/FPCarbonVol.cpp, 70 (-35)
3/17/14 1:20:12.172 AM AppleFileServer[6528]: _Assert: /SourceCache/afpserver/afpserver-607.8/afpserver/FPCarbonVol.cpp, 70 (-35)
3/17/14 1:20:15.244 AM collabd[133]: [CSContentService:47 64e0000 +22ms] Detected Magic Superuser Auth Token
3/17/14 1:20:22.171 AM AppleFileServer[6528]: _Assert: /SourceCache/afpserver/afpserver-607.8/afpserver/FPCarbonVol.cpp, 70 (-35)
3/17/14 1:20:32.172 AM AppleFileServer[6528]: _Assert: /SourceCache/afpserver/afpserver-607.8/afpserver/FPCarbonVol.cpp, 70 (-35)
3/17/14 1:20:42.171 AM AppleFileServer[6528]: _Assert: /SourceCache/afpserver/afpserver-607.8/afpserver/FPCarbonVol.cpp, 70 (-35)
3/17/14 1:20:44.414 AM bootpd[15458]: server name tardis.lan
3/17/14 1:20:44.415 AM bootpd[15458]: interface en0: ip 192.168.11.99 mask 255.255.255.0
3/17/14 1:20:44.416 AM bootpd[15458]: bsdpd: re-reading configuration
3/17/14 1:20:44.416 AM bootpd[15458]: bsdpd: shadow file size will be set to 48 megabytes
3/17/14 1:20:44.416 AM bootpd[15458]: bsdpd: age time 00:15:00
3/17/14 1:20:52.171 AM AppleFileServer[6528]: _Assert: /SourceCache/afpserver/afpserver-607.8/afpserver/FPCarbonVol.cpp, 70 (-35)
3/17/14 1:21:02.170 AM AppleFileServer[6528]: _Assert: /SourceCache/afpserver/afpserver-607.8/afpserver/FPCarbonVol.cpp, 70 (-35)
3/17/14 1:21:12.170 AM AppleFileServer[6528]: _Assert: /SourceCache/afpserver/afpserver-607.8/afpserver/FPCarbonVol.cpp, 70 (-35)
3/17/14 1:21:22.169 AM AppleFileServer[6528]: _Assert: /SourceCache/afpserver/afpserver-607.8/afpserver/FPCarbonVol.cpp, 70 (-35)
3/17/14 1:21:32.168 AM AppleFileServer[6528]: _Assert: /SourceCache/afpserver/afpserver-607.8/afpserver/FPCarbonVol.cpp, 70 (-35)
3/17/14 1:21:42.168 AM AppleFileServer[6528]: _Assert: /SourceCache/afpserver/afpserver-607.8/afpserver/FPCarbonVol.cpp, 70 (-35)
3/17/14 1:21:52.167 AM AppleFileServer[6528]: _Assert: /SourceCache/afpserver/afpserver-607.8/afpserver/FPCarbonVol.cpp, 70 (-35)
3/17/14 1:22:02.167 AM AppleFileServer[6528]: _Assert: /SourceCache/afpserver/afpserver-607.8/afpserver/FPCarbonVol.cpp, 70 (-35)
3/17/14 1:22:12.167 AM AppleFileServer[6528]: _Assert: /SourceCache/afpserver/afpserver-607.8/afpserver/FPCarbonVol.cpp, 70 (-35)
3/17/14 1:22:22.166 AM AppleFileServer[6528]: _Assert: /SourceCache/afpserver/afpserver-607.8/afpserver/FPCarbonVol.cpp, 70 (-35)
3/17/14 1:22:32.166 AM AppleFileServer[6528]: _Assert: /SourceCache/afpserver/afpserver-607.8/afpserver/FPCarbonVol.cpp, 70 (-35)
3/17/14 1:22:42.165 AM AppleFileServer[6528]: _Assert: /SourceCache/afpserver/afpserver-607.8/afpserver/FPCarbonVol.cpp, 70 (-35)
3/17/14 1:22:52.165 AM AppleFileServer[6528]: _Assert: /SourceCache/afpserver/afpserver-607.8/afpserver/FPCarbonVol.cpp, 70 (-35)
3/17/14 1:23:02.164 AM AppleFileServer[6528]: _Assert: /SourceCache/afpserver/afpserver-607.8/afpserver/FPCarbonVol.cpp, 70 (-35)
3/17/14 1:23:03.245 AM ruby[15482]: CFPreferences: user home directory for user kCFPreferencesCurrentUser at /var/teamsserver is unavailable. User domains will be volatile.
3/17/14 1:23:03.260 AM com.apple.launchd[1]: (com.apple.collabd.expire[15482]) Exited with code: 1
3/17/14 1:23:03.290 AM ruby[15483]: CFPreferences: user home directory for user kCFPreferencesCurrentUser at /var/teamsserver is unavailable. User domains will be volatile.
3/17/14 1:23:03.360 AM sandboxd[15486]: ([15483]) collabpp(15483) deny file-read-data /Applications/Server.app/Contents/ServerRoot/usr/lib/libpq.5.5.dylib
3/17/14 1:23:03.369 AM collabpp[15483]: CFPreferences: user home directory for user kCFPreferencesCurrentUser at /var/teamsserver is unavailable. User domains will be volatile.
3/17/14 1:23:03.547 AM sandboxd[15486]: ([15483]) collabpp(15483) deny file-read-data /Library/Preferences/.GlobalPreferences.plist
3/17/14 1:23:03.000 AM kernel[0]: Sandbox: sandboxd(15486) deny mach-lookup com.apple.coresymbolicationd
3/17/14 1:23:04.250 AM sandboxd[15486]: ([15483]) collabpp(15483) deny file-read-data /Library/Preferences/.GlobalPreferences.plist
3/17/14 1:23:12.163 AM AppleFileServer[6528]: _Assert: /SourceCache/afpserver/afpserver-607.8/afpserver/FPCarbonVol.cpp, 70 (-35)
3/17/14 1:23:22.163 AM AppleFileServer[6528]: _Assert: /SourceCache/afpserver/afpserver-607.8/afpserver/FPCarbonVol.cpp, 70 (-35)
3/17/14 1:23:32.162 AM AppleFileServer[6528]: _Assert: /SourceCache/afpserver/afpserver-607.8/afpserver/FPCarbonVol.cpp, 70 (-35)
3/17/14 1:23:42.162 AM AppleFileServer[6528]: _Assert: /SourceCache/afpserver/afpserver-607.8/afpserver/FPCarbonVol.cpp, 70 (-35)
3/17/14 1:23:52.161 AM AppleFileServer[6528]: _Assert: /SourceCache/afpserver/afpserver-607.8/afpserver/FPCarbonVol.cpp, 70 (-35)
3/17/14 1:24:02.161 AM AppleFileServer[6528]: _Assert: /SourceCache/afpserver/afpserver-607.8/afpserver/FPCarbonVol.cpp, 70 (-35)
3/17/14 1:24:12.161 AM AppleFileServer[6528]: _Assert: /SourceCache/afpserver/afpserver-607.8/afpserver/FPCarbonVol.cpp, 70 (-35)
3/17/14 1:24:22.159 AM AppleFileServer[6528]: _Assert: /SourceCache/afpserver/afpserver-607.8/afpserver/FPCarbonVol.cpp, 70 (-35)
3/17/14 1:24:32.160 AM AppleFileServer[6528]: _Assert: /SourceCache/afpserver/afpserver-607.8/afpserver/FPCarbonVol.cpp, 70 (-35)
3/17/14 1:24:42.159 AM AppleFileServer[6528]: _Assert: /SourceCache/afpserver/afpserver-607.8/afpserver/FPCarbonVol.cpp, 70 (-35)
3/17/14 1:24:52.159 AM AppleFileServer[6528]: _Assert: /SourceCache/afpserver/afpserver-607.8/afpserver/FPCarbonVol.cpp, 70 (-35)
3/17/14 1:25:02.158 AM AppleFileServer[6528]: _Assert: /SourceCache/afpserver/afpserver-607.8/afpserver/FPCarbonVol.cpp, 70 (-35)
3/17/14 1:25:12.158 AM AppleFileServer[6528]: _Assert: /SourceCache/afpserver/afpserver-607.8/afpserver/FPCarbonVol.cpp, 70 (-35)
3/17/14 1:25:22.157 AM AppleFileServer[6528]: _Assert: /SourceCache/afpserver/afpserver-607.8/afpserver/FPCarbonVol.cpp, 70 (-35)
3/17/14 1:25:32.156 AM AppleFileServer[6528]: _Assert: /SourceCache/afpserver/afpserver-607.8/afpserver/FPCarbonVol.cpp, 70 (-35)
3/17/14 1:25:42.155 AM AppleFileServer[6528]: _Assert: /SourceCache/afpserver/afpserver-607.8/afpserver/FPCarbonVol.cpp, 70 (-35)
3/17/14 1:25:47.506 AM digest-service[15516]: label: default
3/17/14 1:25:47.507 AM digest-service[15516]:     dbname: od:/Local/Default
3/17/14 1:25:47.507 AM digest-service[15516]:     mkey_file: /var/db/krb5kdc/m-key
3/17/14 1:25:47.508 AM digest-service[15516]:     acl_file: /var/db/krb5kdc/kadmind.acl
3/17/14 1:25:47.510 AM digest-service[15516]: digest-request: uid=0
3/17/14 1:25:47.515 AM digest-service[15516]: digest-request: init request
3/17/14 1:25:47.518 AM digest-service[15516]: digest-request: init return domain: BUILTIN server: TARDIS
3/17/14 1:25:47.542 AM com.apple.launchd[1]: (com.apple.smbd[15515]) Check-in of Mach service failed. Already active: com.apple.smbd
3/17/14 1:25:47.627 AM sandboxd[15517]: ([15515]) smbd(15515) deny job-creation
3/17/14 1:25:47.000 AM kernel[0]: Sandbox: sandboxd(15517) deny mach-lookup com.apple.coresymbolicationd
3/17/14 1:25:52.155 AM AppleFileServer[6528]: _Assert: /SourceCache/afpserver/afpserver-607.8/afpserver/FPCarbonVol.cpp, 70 (-35)
3/17/14 1:26:02.155 AM AppleFileServer[6528]: _Assert: /SourceCache/afpserver/afpserver-607.8/afpserver/FPCarbonVol.cpp, 70 (-35)
3/17/14 1:26:12.155 AM AppleFileServer[6528]: _Assert: /SourceCache/afpserver/afpserver-607.8/afpserver/FPCarbonVol.cpp, 70 (-35)
3/17/14 1:26:22.154 AM AppleFileServer[6528]: _Assert: /SourceCache/afpserver/afpserver-607.8/afpserver/FPCarbonVol.cpp, 70 (-35)
3/17/14 1:26:32.153 AM AppleFileServer[6528]: _Assert: /SourceCache/afpserver/afpserver-607.8/afpserver/FPCarbonVol.cpp, 70 (-35)
3/17/14 1:26:42.153 AM AppleFileServer[6528]: _Assert: /SourceCache/afpserver/afpserver-607.8/afpserver/FPCarbonVol.cpp, 70 (-35)
3/17/14 1:26:52.153 AM AppleFileServer[6528]: _Assert: /SourceCache/afpserver/afpserver-607.8/afpserver/FPCarbonVol.cpp, 70 (-35)
3/17/14 1:27:02.152 AM AppleFileServer[6528]: _Assert: /SourceCache/afpserver/afpserver-607.8/afpserver/FPCarbonVol.cpp, 70 (-35)
3/17/14 1:27:12.151 AM AppleFileServer[6528]: _Assert: /SourceCache/afpserver/afpserver-607.8/afpserver/FPCarbonVol.cpp, 70 (-35)
3/17/14 1:27:22.150 AM AppleFileServer[6528]: _Assert: /SourceCache/afpserver/afpserver-607.8/afpserver/FPCarbonVol.cpp, 70 (-35)
3/17/14 1:27:32.150 AM AppleFileServer[6528]: _Assert: /SourceCache/afpserver/afpserver-607.8/afpserver/FPCarbonVol.cpp, 70 (-35)
3/17/14 1:27:42.150 AM AppleFileServer[6528]: _Assert: /SourceCache/afpserver/afpserver-607.8/afpserver/FPCarbonVol.cpp, 70 (-35)
3/18/14 7:30:36.271 AM blued[63]: Device name: 'homeuser’s mouse' length:19
3/17/14 4:10:16.121 AM collabd[133]: [CSContentService:47 5218000 +22ms] Detected Magic Superuser Auth Token
3/17/14 4:10:23.174 AM fseventsd[44]: SLOWDOWN: client 0x7f821a830400 (pid 373) sleeping due to too many errors (num usleeps 883)
3/18/14 7:30:36.271 AM blued[63]: Finished reading the HID data
3/18/14 7:30:36.271 AM blued[63]: Found a device with PID:0x030d VID:0x05ac
3/17/14 4:10:55.515 AM bootpd[16748]: server name tardis.lan
3/17/14 4:10:55.516 AM bootpd[16748]: interface en0: ip 192.168.11.99 mask 255.255.255.0
3/17/14 4:14:19.511 AM fseventsd[44]: SLOWDOWN: client 0x7f821a830400 (pid 373) sleeping due to too many errors (num usleeps 906)
3/18/14 7:30:36.458 AM configd[23]: bootp_session_transmit: bpf_write(en1) failed: Network is down (50)
3/18/14 7:30:36.458 AM configd[23]: DHCP en1: INIT transmit failed
3/17/14 4:15:55.530 AM bootpd[16779]: server name tardis.lan
3/17/14 4:15:55.530 AM bootpd[16779]: interface en0: ip 192.168.11.99 mask 255.255.255.0
3/18/14 7:30:36.000 AM kernel[0]: 00000000  00000020  NVEthernet::setLinkStatus - not Active
3/18/14 7:30:36.481 AM configd[23]: network changed: DNS*
3/17/14 4:18:23.948 AM fseventsd[44]: SLOWDOWN: client 0x7f821a830400 (pid 373) sleeping due to too many errors (num usleeps 930)
3/17/14 4:20:16.173 AM collabd[133]: [CSContentService:47 5112000 +22ms] Detected Magic Superuser Auth Token
3/18/14 7:30:36.483 AM configd[23]: setting hostname to "tardis.lan"
3/18/14 7:30:38.623 AM hidd[93]: Posting 'com.apple.iokit.hid.displayStatus' notifyState=1
3/17/14 4:20:55.535 AM bootpd[16813]: server name tardis.lan
3/17/14 4:20:55.535 AM bootpd[16813]: interface en0: ip 192.168.11.99 mask 255.255.255.0
3/18/14 7:30:38.000 AM kernel[0]: CODE SIGNING: cs_invalid_page(0x1000): p=111[lacie_dm_service] clearing CS_VALID
3/18/14 7:30:38.000 AM kernel[0]: macx_swapon SUCCESS
3/17/14 4:21:11.576 AM fseventsd[44]: SLOWDOWN: client 0x7f821a830400 (pid 373) sleeping due to too many errors (num usleeps 946)
3/17/14 4:22:47.360 AM kdc[90]: Got a canonicalize request for a LKDC realm from local-ipc
3/18/14 7:30:38.627 AM hidd[93]: void __IOHIDLoadBundles(): Loaded 0 HID plugins
3/17/14 4:22:47.360 AM kdc[90]: LKDC referral to the real LKDC realm name
3/17/14 4:22:47.362 AM kdc[90]: AS-REQ chapman@LKDC:SHA1.4AC353BF3163FC9BDC25C964A69B0AAB2C460358 from local-ipc for krbtgt/LKDC:SHA1.4AC353BF3163FC9BDC25C964A69B0AAB2C460358@LKDC:SHA1.4AC353BF3163FC9BDC25C964A69B0AAB2C460358
3/17/14 4:24:25.506 AM fseventsd[44]: SLOWDOWN: client 0x7f821a830400 (pid 373) sleeping due to too many errors (num usleeps 965)
3/18/14 7:30:38.739 AM appleeventsd[102]: main: Starting up

IOUserClient.cpp errors from kernel[0]:

3/16/14 10:53:14.856 AM com.apple.backupd[1256]: Starting automatic backup
3/16/14 10:53:14.922 AM com.apple.backupd[1256]: Backing up to: /Volumes/timemachine/Backups.backupdb
3/16/14 10:53:16.444 AM sudo[1284]:     root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/Applications/Server.app/Contents/ServerRoot/usr/bin/psql -h /Library/Server/PostgreSQL For Server Services/Socket -U webauth -d webauth -c SELECT max(version) FROM schema_migrations
3/16/14 10:53:16.792 AM AppleFileServer[6528]: _Assert: /SourceCache/afpserver/afpserver-607.8/afpserver/FPCarbonVol.cpp, 70 (-35)
3/16/14 10:53:20.954 AM sudo[1306]:     root : TTY=unknown ; PWD=/Applications/Server.app/Contents/ServerRoot/usr/share/devicemgr/backend ; USER=root ; COMMAND=/Applications/Server.app/Contents/ServerRoot/usr/bin/psql -h /Library/Server/PostgreSQL For Server Services/Socket -U webauth -d webauth -c SELECT max(version) FROM schema_migrations
3/16/14 10:53:22.223 AM serveradmin[1328]: servermgr_swupdate[WRN]: Missing or invalid language for product items request.  Using default "en".
3/16/14 10:53:23.760 AM sudo[1350]:     root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/Applications/Server.app/Contents/ServerRoot/usr/bin/psql -h /Library/Server/PostgreSQL For Server Services/Socket -U webauth -d webauth -c SELECT max(version) FROM schema_migrations
3/16/14 10:53:25.504 AM sudo[1373]:     root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/Applications/Server.app/Contents/ServerRoot/usr/bin/psql -h /Library/Server/PostgreSQL For Server Services/Socket -U webauth -d webauth -c SELECT max(version) FROM schema_migrations
3/16/14 10:53:26.794 AM AppleFileServer[6528]: _Assert: /SourceCache/afpserver/afpserver-607.8/afpserver/FPCarbonVol.cpp, 70 (-35)
3/16/14 10:53:27.790 AM sudo[1450]:     root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/Applications/Server.app/Contents/ServerRoot/usr/bin/psql -h /Library/Server/PostgreSQL For Server Services/Socket -U webauth -d webauth -c SELECT max(version) FROM schema_migrations
3/16/14 10:53:32.147 AM sudo[1472]:     root : TTY=unknown ; PWD=/Applications/Server.app/Contents/ServerRoot/usr/share/devicemgr/backend ; USER=root ; COMMAND=/Applications/Server.app/Contents/ServerRoot/usr/bin/psql -h /Library/Server/PostgreSQL For Server Services/Socket -U webauth -d webauth -c SELECT max(version) FROM schema_migrations
3/16/14 10:53:35.187 AM serveradmin[1508]: servermgr_swupdate[WRN]: Missing or invalid language for product items request.  Using default "en".
3/16/14 10:53:36.790 AM AppleFileServer[6528]: _Assert: /SourceCache/afpserver/afpserver-607.8/afpserver/FPCarbonVol.cpp, 70 (-35)
3/16/14 10:53:36.829 AM sudo[1534]:     root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/Applications/Server.app/Contents/ServerRoot/usr/bin/psql -h /Library/Server/PostgreSQL For Server Services/Socket -U webauth -d webauth -c SELECT max(version) FROM schema_migrations
3/16/14 10:53:38.687 AM sudo[1557]:     root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/Applications/Server.app/Contents/ServerRoot/usr/bin/psql -h /Library/Server/PostgreSQL For Server Services/Socket -U webauth -d webauth -c SELECT max(version) FROM schema_migrations
3/16/14 10:53:40.000 AM kernel[0]: /SourceCache/xnu/xnu-2050.48.12/iokit/Kernel/IOUserClient.cpp: mach_msg_send_from_kernel_proper {1000000d}
3/16/14 10:53:40.000 AM kernel[0]: /SourceCache/xnu/xnu-2050.48.12/iokit/Kernel/IOUserClient.cpp: mach_msg_send_from_kernel_proper {1000000d}
3/16/14 10:53:40.000 AM kernel[0]: /SourceCache/xnu/xnu-2050.48.12/iokit/Kernel/IOUserClient.cpp: mach_msg_send_from_kernel_proper {1000000d}
3/16/14 10:53:40.000 AM kernel[0]: /SourceCache/xnu/xnu-2050.48.12/iokit/Kernel/IOUserClient.cpp: mach_msg_send_from_kernel_proper {1000000d}
3/16/14 10:53:40.000 AM kernel[0]: /SourceCache/xnu/xnu-2050.48.12/iokit/Kernel/IOUserClient.cpp: mach_msg_send_from_kernel_proper {1000000d}
3/16/14 10:53:40.000 AM kernel[0]: /SourceCache/xnu/xnu-2050.48.12/iokit/Kernel/IOUserClient.cpp: mach_msg_send_from_kernel_proper {1000000d}
3/16/14 10:53:40.000 AM kernel[0]: /SourceCache/xnu/xnu-2050.48.12/iokit/Kernel/IOUserClient.cpp: mach_msg_send_from_kernel_proper {1000000d}
3/16/14 10:53:40.000 AM kernel[0]: /SourceCache/xnu/xnu-2050.48.12/iokit/Kernel/IOUserClient.cpp: mach_msg_send_from_kernel_proper {1000000d}
3/16/14 10:53:40.000 AM kernel[0]: /SourceCache/xnu/xnu-2050.48.12/iokit/Kernel/IOUserClient.cpp: mach_msg_send_from_kernel_proper {1000000d}
3/16/14 10:53:40.000 AM kernel[0]: /SourceCache/xnu/xnu-2050.48.12/iokit/Kernel/IOUserClient.cpp: mach_msg_send_from_kernel_proper {1000000d}
3/16/14 10:53:40.000 AM kernel[0]: /SourceCache/xnu/xnu-2050.48.12/iokit/Kernel/IOUserClient.cpp: mach_msg_send_from_kernel_proper {1000000d}
3/16/14 10:53:40.000 AM kernel[0]: /SourceCache/xnu/xnu-2050.48.12/iokit/Kernel/IOUserClient.cpp: mach_msg_send_from_kernel_proper {1000000d}
3/16/14 10:53:40.000 AM kernel[0]: /SourceCache/xnu/xnu-2050.48.12/iokit/Kernel/IOUserClient.cpp: mach_msg_send_from_kernel_proper {1000000d}
3/16/14 10:53:40.000 AM kernel[0]: /SourceCache/xnu/xnu-2050.48.12/iokit/Kernel/IOUserClient.cpp: mach_msg_send_from_kernel_proper {1000000d}
3/16/14 10:53:40.000 AM kernel[0]: /SourceCache/xnu/xnu-2050.48.12/iokit/Kernel/IOUserClient.cpp: mach_msg_send_from_kernel_proper {1000000d}
3/16/14 10:53:40.000 AM kernel[0]: /SourceCache/xnu/xnu-2050.48.12/iokit/Kernel/IOUserClient.cpp: mach_msg_send_from_kernel_proper {1000000d}
3/16/14 10:53:40.000 AM kernel[0]: /SourceCache/xnu/xnu-2050.48.12/iokit/Kernel/IOUserClient.cpp: mach_msg_send_from_kernel_proper {1000000d}
3/16/14 10:53:40.000 AM kernel[0]: /SourceCache/xnu/xnu-2050.48.12/iokit/Kernel/IOUserClient.cpp: mach_msg_send_from_kernel_proper {1000000d}
3/16/14 10:53:40.000 AM kernel[0]: /SourceCache/xnu/xnu-2050.48.12/iokit/Kernel/IOUserClient.cpp: mach_msg_send_from_kernel_proper {1000000d}
3/16/14 10:53:40.000 AM kernel[0]: /SourceCache/xnu/xnu-2050.48.12/iokit/Kernel/IOUserClient.cpp: mach_msg_send_from_kernel_proper {1000000d}
3/16/14 10:53:40.000 AM kernel[0]: /SourceCache/xnu/xnu-2050.48.12/iokit/Kernel/IOUserClient.cpp: mach_msg_send_from_kernel_proper {1000000d}
3/16/14 10:53:40.000 AM kernel[0]: /SourceCache/xnu/xnu-2050.48.12/iokit/Kernel/IOUserClient.cpp: mach_msg_send_from_kernel_proper {1000000d}
3/16/14 10:53:40.000 AM kernel[0]: /SourceCache/xnu/xnu-2050.48.12/iokit/Kernel/IOUserClient.cpp: mach_msg_send_from_kernel_proper {1000000d}
3/16/14 10:53:40.000 AM kernel[0]: /SourceCache/xnu/xnu-2050.48.12/iokit/Kernel/IOUserClient.cpp: mach_msg_send_from_kernel_proper {1000000d}
3/16/14 10:53:40.000 AM kernel[0]: /SourceCache/xnu/xnu-2050.48.12/iokit/Kernel/IOUserClient.cpp: mach_msg_send_from_kernel_proper {1000000d}
3/16/14 10:53:40.000 AM kernel[0]: /SourceCache/xnu/xnu-2050.48.12/iokit/Kernel/IOUserClient.cpp: mach_msg_send_from_kernel_proper {1000000d}
3/16/14 10:53:40.000 AM kernel[0]: /SourceCache/xnu/xnu-2050.48.12/iokit/Kernel/IOUserClient.cpp: mach_msg_send_from_kernel_proper {1000000d}
3/16/14 10:53:40.000 AM kernel[0]: /SourceCache/xnu/xnu-2050.48.12/iokit/Kernel/IOUserClient.cpp: mach_msg_send_from_kernel_proper {1000000d}
3/16/14 10:53:40.000 AM kernel[0]: /SourceCache/xnu/xnu-2050.48.12/iokit/Kernel/IOUserClient.cpp: mach_msg_send_from_kernel_proper {1000000d}
3/16/14 10:53:40.000 AM kernel[0]: /SourceCache/xnu/xnu-2050.48.12/iokit/Kernel/IOUserClient.cpp: mach_msg_send_from_kernel_proper {1000000d}
3/16/14 10:53:40.000 AM kernel[0]: /SourceCache/xnu/xnu-2050.48.12/iokit/Kernel/IOUserClient.cpp: mach_msg_send_from_kernel_proper {1000000d}
3/16/14 10:53:40.000 AM kernel[0]: /SourceCache/xnu/xnu-2050.48.12/iokit/Kernel/IOUserClient.cpp: mach_msg_send_from_kernel_proper {1000000d}
3/16/14 10:53:40.000 AM kernel[0]: /SourceCache/xnu/xnu-2050.48.12/iokit/Kernel/IOUserClient.cpp: mach_msg_send_from_kernel_proper {1000000d}
3/16/14 10:53:40.000 AM kernel[0]: /SourceCache/xnu/xnu-2050.48.12/iokit/Kernel/IOUserClient.cpp: mach_msg_send_from_kernel_proper {1000000d}
3/16/14 10:53:40.000 AM kernel[0]: /SourceCache/xnu/xnu-2050.48.12/iokit/Kernel/IOUserClient.cpp: mach_msg_send_from_kernel_proper {1000000d}
3/16/14 10:53:40.000 AM kernel[0]: /SourceCache/xnu/xnu-2050.48.12/iokit/Kernel/IOUserClient.cpp: mach_msg_send_from_kernel_proper {1000000d}
3/16/14 10:53:40.000 AM kernel[0]: /SourceCache/xnu/xnu-2050.48.12/iokit/Kernel/IOUserClient.cpp: mach_msg_send_from_kernel_proper {1000000d}
3/16/14 10:53:40.000 AM kernel[0]: /SourceCache/xnu/xnu-2050.48.12/iokit/Kernel/IOUserClient.cpp: mach_msg_send_from_kernel_proper {1000000d}
3/16/14 10:53:40.000 AM kernel[0]: /SourceCache/xnu/xnu-2050.48.12/iokit/Kernel/IOUserClient.cpp: mach_msg_send_from_kernel_proper {1000000d}
3/16/14 10:53:40.000 AM kernel[0]: /SourceCache/xnu/xnu-2050.48.12/iokit/Kernel/IOUserClient.cpp: mach_msg_send_from_kernel_proper {1000000d}
3/16/14 10:53:40.000 AM kernel[0]: /SourceCache/xnu/xnu-2050.48.12/iokit/Kernel/IOUserClient.cpp: mach_msg_send_from_kernel_proper {1000000d}
3/16/14 10:53:40.000 AM kernel[0]: /SourceCache/xnu/xnu-2050.48.12/iokit/Kernel/IOUserClient.cpp: mach_msg_send_from_kernel_proper {1000000d}
3/16/14 10:53:40.000 AM kernel[0]: /SourceCache/xnu/xnu-2050.48.12/iokit/Kernel/IOUserClient.cpp: mach_msg_send_from_kernel_proper {1000000d}
3/16/14 10:53:40.000 AM kernel[0]: /SourceCache/xnu/xnu-2050.48.12/iokit/Kernel/IOUserClient.cpp: mach_msg_send_from_kernel_proper {1000000d}
3/16/14 10:53:40.000 AM kernel[0]: /SourceCache/xnu/xnu-2050.48.12/iokit/Kernel/IOUserClient.cpp: mach_msg_send_from_kernel_proper {1000000d}
3/16/14 10:53:40.000 AM kernel[0]: /SourceCache/xnu/xnu-2050.48.12/iokit/Kernel/IOUserClient.cpp: mach_msg_send_from_kernel_proper {1000000d}
3/16/14 10:53:40.000 AM kernel[0]: /SourceCache/xnu/xnu-2050.48.12/iokit/Kernel/IOUserClient.cpp: mach_msg_send_from_kernel_proper {1000000d}
3/16/14 10:53:40.000 AM kernel[0]: /SourceCache/xnu/xnu-2050.48.12/iokit/Kernel/IOUserClient.cpp: mach_msg_send_from_kernel_proper {1000000d}
3/16/14 10:53:40.000 AM kernel[0]: /SourceCache/xnu/xnu-2050.48.12/iokit/Kernel/IOUserClient.cpp: mach_msg_send_from_kernel_proper {1000000d}
3/16/14 10:53:40.000 AM kernel[0]: /SourceCache/xnu/xnu-2050.48.12/iokit/Kernel/IOUserClient.cpp: mach_msg_send_from_kernel_proper {1000000d}
3/16/14 10:53:40.000 AM kernel[0]: /SourceCache/xnu/xnu-2050.48.12/iokit/Kernel/IOUserClient.cpp: mach_msg_send_from_kernel_proper {1000000d}
3/16/14 10:53:40.000 AM kernel[0]: /SourceCache/xnu/xnu-2050.48.12/iokit/Kernel/IOUserClient.cpp: mach_msg_send_from_kernel_proper {1000000d}
3/16/14 10:53:40.000 AM kernel[0]: /SourceCache/xnu/xnu-2050.48.12/iokit/Kernel/IOUserClient.cpp: mach_msg_send_from_kernel_proper {1000000d}
3/16/14 10:53:40.000 AM kernel[0]: /SourceCache/xnu/xnu-2050.48.12/iokit/Kernel/IOUserClient.cpp: mach_msg_send_from_kernel_proper {1000000d}
3/16/14 10:53:40.000 AM kernel[0]: /SourceCache/xnu/xnu-2050.48.12/iokit/Kernel/IOUserClient.cpp: mach_msg_send_from_kernel_proper {1000000d}
3/16/14 10:53:40.000 AM kernel[0]: /SourceCache/xnu/xnu-2050.48.12/iokit/Kernel/IOUserClient.cpp: mach_msg_send_from_kernel_proper {1000000d}
3/16/14 10:53:40.000 AM kernel[0]: /SourceCache/xnu/xnu-2050.48.12/iokit/Kernel/IOUserClient.cpp: mach_msg_send_from_kernel_proper {1000000d}
3/16/14 10:53:40.000 AM kernel[0]: /SourceCache/xnu/xnu-2050.48.12/iokit/Kernel/IOUserClient.cpp: mach_msg_send_from_kernel_proper {1000000d}
3/16/14 10:53:40.459 AM com.apple.backupd[1256]: Using file event preflight for Tardis SSD
3/16/14 10:53:40.573 AM com.apple.backupd[1256]: Will copy (141.3 MB) from Tardis SSD
3/16/14 10:53:40.581 AM com.apple.backupd[1256]: Found 225 files (141.3 MB) needing backup
3/16/14 10:53:40.603 AM com.apple.backupd[1256]: 1.27 GB required (including padding), 272.1 GB available
3/16/14 10:53:46.789 AM AppleFileServer[6528]: _Assert: /SourceCache/afpserver/afpserver-607.8/afpserver/FPCarbonVol.cpp, 70 (-35)
3/16/14 10:53:49.419 AM com.apple.backupd[1256]: Copied 2238 files (141.9 MB) from volume Tardis SSD.
3/16/14 10:53:49.477 AM com.apple.backupd[1256]: Using file event preflight for Tardis SSD
3/16/14 10:53:49.480 AM com.apple.backupd[1256]: Will copy (112 KB) from Tardis SSD
3/16/14 10:53:49.481 AM com.apple.backupd[1256]: Found 11 files (112 KB) needing backup
3/16/14 10:53:49.482 AM com.apple.backupd[1256]: 1.1 GB required (including padding), 271.96 GB available
3/16/14 10:53:52.000 AM com.apple.backupd[1256]: Copied 283 files (112 KB) from volume Tardis SSD.
3/16/14 10:53:52.228 AM com.apple.backupd[1256]: Created new backup: 2014-03-16-105352
3/16/14 10:53:52.827 AM com.apple.backupd[1256]: Starting post-backup thinning
3/16/14 10:53:56.789 AM AppleFileServer[6528]: _Assert: /SourceCache/afpserver/afpserver-607.8/afpserver/FPCarbonVol.cpp, 70 (-35)
3/16/14 10:53:58.646 AM com.apple.backupd[1256]: Deleted /Volumes/timemachine/Backups.backupdb/tardis/2014-03-15-095353 (141.1 MB)
3/16/14 10:53:58.646 AM com.apple.backupd[1256]: Post-back up thinning complete: 1 expired backups removed
3/16/14 10:53:58.853 AM com.apple.backupd[1256]: Backup completed successfully.
3/16/14 10:54:06.790 AM AppleFileServer[6528]: _Assert: /SourceCache/afpserver/afpserver-607.8/afpserver/FPCarbonVol.cpp, 70 (-35)
3/16/14 10:54:16.789 AM AppleFileServer[6528]: _Assert: /SourceCache/afpserver/afpserver-607.8/afpserver/FPCarbonVol.cpp, 70 (-35)
3/16/14 10:54:26.788 AM AppleFileServer[6528]: _Assert: /SourceCache/afpserver/afpserver-607.8/afpserver/FPCarbonVol.cpp, 70 (-35)
3/16/14 10:54:36.787 AM AppleFileServer[6528]: _Assert: /SourceCache/afpserver/afpserver-607.8/afpserver/FPCarbonVol.cpp, 70 (-35)
3/16/14 10:54:46.787 AM AppleFileServer[6528]: _Assert: /SourceCache/afpserver/afpserver-607.8/afpserver/FPCarbonVol.cpp, 70 (-35)
3/16/14 10:54:56.787 AM AppleFileServer[6528]: _Assert: /SourceCache/afpserver/afpserver-607.8/afpserver/FPCarbonVol.cpp, 70 (-35)
3/16/14 10:55:06.786 AM AppleFileServer[6528]: _Assert: /SourceCache/afpserver/afpserver-607.8/afpserver/FPCarbonVol.cpp, 70 (-35)
3/16/14 10:55:16.786 AM AppleFileServer[6528]: _Assert: /SourceCache/afpserver/afpserver-607.8/afpserver/FPCarbonVol.cpp, 70 (-35)
3/16/14 10:55:26.785 AM AppleFileServer[6528]: _Assert: /SourceCache/afpserver/afpserver-607.8/afpserver/FPCarbonVol.cpp, 70 (-35)
3/16/14 10:55:36.785 AM AppleFileServer[6528]: _Assert: /SourceCache/afpserver/afpserver-607.8/afpserver/FPCarbonVol.cpp, 70 (-35)
3/16/14 10:55:46.784 AM AppleFileServer[6528]: _Assert: /SourceCache/afpserver/afpserver-607.8/afpserver/FPCarbonVol.cpp, 70 (-35)
3/16/14 10:55:49.695 AM digest-service[1635]: label: default
3/16/14 10:55:49.695 AM digest-service[1635]:     dbname: od:/Local/Default
3/16/14 10:55:49.695 AM digest-service[1635]:     mkey_file: /var/db/krb5kdc/m-key
3/16/14 10:55:49.695 AM digest-service[1635]:     acl_file: /var/db/krb5kdc/kadmind.acl
3/16/14 10:55:49.697 AM digest-service[1635]: digest-request: uid=0
3/16/14 10:55:49.700 AM digest-service[1635]: digest-request: init request

Mac mini, OS X Server, Server 10.8.5, Core2Duo, 8GB RAM

Posted on Mar 18, 2014 5:33 PM

Reply

Answer 1

AJ 2010

Level 1

15 points

Aug 19, 2015 12:42 PM in response to Bradley Chapman

This is becoming more of an issue with a 10.8.5 server I administer. I'm also seeing tons of AppleFileServer[275]: _Assert: /SourceCache/afpserver/afpserver-607.9/afpserver/FPCarbonVol.cpp, 70 (-35) errors along with the symptoms you described above. Were you ever able to find a solution to this or identify what causes this to happen? Rebooting fixes it for a while but it always seems to come back eventually.

Reply

Answer 2

zepfhyr

Level 1

4 points

Aug 26, 2015 11:34 AM in response to AJ 2010

I too am experiencing this issue on a 10.9.5 server I administer. The strange thing is that this server was completely set up from scratch in April 2015 and had ZERO errors in the logs until this one started cropping up. My users reported very slow transfer and directory listing speeds when the errors started to appear. The only things this server is doing besides serving file shares is as a VPN server, FileMaker server, and Universal Type Server. Everything else appears to be functioning properly.

Have cleared caches (creating a whole host of XPC warnings in the log, which is a whole separate headache when trying to troubleshoot the real issue) and also ensured that permissions for the file shares are properly propagated.

The only other regular error popping up in the log is this: sandboxd[108]: ([24665]) mdworker(24665) deny file-read-xattr <filepath> ()

I have tried turning off Spotlight indexing for the drive to see if it helps resolve any slowness, but it has not affected the appearance of the FPCarbonVol.cpp errors.

Reply