You can make a difference in the Apple Support Community!

When you sign up with your Apple Account, you can provide valuable feedback to other community members by upvoting helpful replies and User Tips.

Looks like no one’s replied in a while. To start the conversation again, simply ask a new question.

Time Machine always requires deep traversal?

Hi all-


For the tl;dr crowd: every time my Mac Pro starts a backup, it does a deep traversal (this has gone on for about two months since I got the drive). I'm backing up to a 2TB USB external drive that is always connected. I've added the backup drive to Spotlight's exclude/privacy list. Yesterday I rebooted the machine using the OSX installation disk and performed disk repairs on both the system drive and the backup drive (neither was found to have any errors). I don't have clamXav or any other AV installed. What else can I try to avoid the deep traversal? Here are the console logs for two back-to-back backups (note that these are just before I got into the office, so I don't think user interaction is forcing the deep traversal):


5/31/12 6:53:32 AM
com.apple.backupd[5425]
Starting standard backup
5/31/12 6:53:33 AM
com.apple.backupd[5425]
Backing up to: /Volumes/Time Machine Backups/Backups.backupdb
5/31/12 6:55:00 AM
com.apple.backupd[5425]
Node requires deep traversal:/ reason:contains changes|must scan subdirs|fsevent|
5/31/12 6:57:11 AM
_spotlight[5455]
vol.notice /usr/fl/etc/volume.cfg not found
5/31/12 6:57:11 AM
_spotlight[5460]
vol.notice /usr/fl/etc/volume.cfg not found
5/31/12 6:57:21 AM
com.apple.backupd[5425]
No pre-backup thinning needed: 1.87 GB requested (including padding), 1.36 TB available
5/31/12 6:57:23 AM
_spotlight[5466]
vol.notice /usr/fl/etc/volume.cfg not found
5/31/12 6:57:23 AM
_spotlight[5471]
vol.notice /usr/fl/etc/volume.cfg not found
5/31/12 6:57:23 AM
_spotlight[5476]
vol.notice /usr/fl/etc/volume.cfg not found
5/31/12 6:57:23 AM
_spotlight[5481]
vol.notice /usr/fl/etc/volume.cfg not found
5/31/12 6:57:34 AM
com.apple.backupd[5425]
Copied 2085 files (17.3 MB) from volume Snow Leopard.
5/31/12 6:59:02 AM
com.apple.backupd[5425]
Node requires deep traversal:/ reason:contains changes|must scan subdirs|fsevent|
5/31/12 7:01:05 AM
_spotlight[5498]
vol.notice /usr/fl/etc/volume.cfg not found
5/31/12 7:01:05 AM
_spotlight[5503]
vol.notice /usr/fl/etc/volume.cfg not found
5/31/12 7:01:13 AM
com.apple.backupd[5425]
No pre-backup thinning needed: 1.87 GB requested (including padding), 1.36 TB available
5/31/12 7:01:15 AM
_spotlight[5508]
vol.notice /usr/fl/etc/volume.cfg not found
5/31/12 7:01:15 AM
_spotlight[5513]
vol.notice /usr/fl/etc/volume.cfg not found
5/31/12 7:01:15 AM
_spotlight[5518]
vol.notice /usr/fl/etc/volume.cfg not found
5/31/12 7:01:15 AM
_spotlight[5523]
vol.notice /usr/fl/etc/volume.cfg not found
5/31/12 7:01:26 AM
com.apple.backupd[5425]
Copied 2085 files (16.9 MB) from volume Snow Leopard.
5/31/12 7:02:57 AM
com.apple.backupd[5425]
Starting post-backup thinning
5/31/12 7:32:41 AM
com.apple.backupd[5425]
Deleted backup /Volumes/Time Machine Backups/Backups.backupdb/warp/2012-05-29-143904: 1.36 TB now available
5/31/12 7:32:41 AM
com.apple.backupd[5425]
Post-back up thinning complete: 1 expired backups removed
5/31/12 7:32:42 AM
com.apple.backupd[5425]
Backup completed successfully.
5/31/12 7:53:33 AM
com.apple.backupd[5706]
Starting standard backup
5/31/12 7:53:33 AM
com.apple.backupd[5706]
Backing up to: /Volumes/Time Machine Backups/Backups.backupdb
5/31/12 7:55:13 AM
com.apple.backupd[5706]
Node requires deep traversal:/ reason:contains changes|must scan subdirs|fsevent|
5/31/12 7:57:26 AM
_spotlight[5735]
vol.notice /usr/fl/etc/volume.cfg not found
5/31/12 7:57:26 AM
_spotlight[5740]
vol.notice /usr/fl/etc/volume.cfg not found
5/31/12 7:57:35 AM
com.apple.backupd[5706]
No pre-backup thinning needed: 1.87 GB requested (including padding), 1.36 TB available
5/31/12 7:57:37 AM
_spotlight[5745]
vol.notice /usr/fl/etc/volume.cfg not found
5/31/12 7:57:37 AM
_spotlight[5750]
vol.notice /usr/fl/etc/volume.cfg not found
5/31/12 7:57:37 AM
_spotlight[5755]
vol.notice /usr/fl/etc/volume.cfg not found
5/31/12 7:57:37 AM
_spotlight[5760]
vol.notice /usr/fl/etc/volume.cfg not found
5/31/12 7:57:48 AM
com.apple.backupd[5706]
Copied 2085 files (18.9 MB) from volume Snow Leopard.
5/31/12 7:59:15 AM
com.apple.backupd[5706]
Node requires deep traversal:/ reason:contains changes|must scan subdirs|fsevent|
5/31/12 8:01:24 AM
_spotlight[5778]
vol.notice /usr/fl/etc/volume.cfg not found
5/31/12 8:01:24 AM
_spotlight[5783]
vol.notice /usr/fl/etc/volume.cfg not found
5/31/12 8:01:32 AM
com.apple.backupd[5706]
No pre-backup thinning needed: 1.87 GB requested (including padding), 1.36 TB available
5/31/12 8:01:34 AM
_spotlight[5788]
vol.notice /usr/fl/etc/volume.cfg not found
5/31/12 8:01:34 AM
_spotlight[5793]
vol.notice /usr/fl/etc/volume.cfg not found
5/31/12 8:01:34 AM
_spotlight[5798]
vol.notice /usr/fl/etc/volume.cfg not found
5/31/12 8:01:34 AM
_spotlight[5803]
vol.notice /usr/fl/etc/volume.cfg not found
5/31/12 8:01:43 AM
com.apple.backupd[5706]
Copied 2085 files (18.9 MB) from volume Snow Leopard.
5/31/12 8:03:15 AM
com.apple.backupd[5706]
Starting post-backup thinning
5/31/12 8:31:33 AM
com.apple.backupd[5706]
Deleted backup /Volumes/Time Machine Backups/Backups.backupdb/warp/2012-05-29-123915: 1.36 TB now available
5/31/12 8:31:33 AM
com.apple.backupd[5706]
Post-back up thinning complete: 1 expired backups removed
5/31/12 8:31:35 AM
com.apple.backupd[5706]
Backup completed successfully.


The long version: in March I got a 2TB USB external drive to back up the Mac Pro at my work. I've had good success with Time Machine at home, backing up two MacBooks and a Mac Mini with no problems what-so-ever (it really "just works"), so I was surprised when Time Machine struggled with the Mac Pro. I did a lot of research on the web, and followed as much advice as I could (excluding the backup drive from Spotlight, making sure backups completed uninterrupted, repairing drives, etc.), but I continue to have backups that take almost a full hour (and thus Time Machine is almost constantly running). The actual quantity of data backed up is pretty small (similar to the log above, it's usually 20-50 MB).


During my initial backup I ran into a problem with Git which may be pertitent, but I'm not sure. I was in charge of my company's conversion from Subversion to Git, and in the process I locally cloned a bunch of Git repositories (on the order of 300-400 repos). Since Git uses hard links between local clones, this all fit on my 500GB drive no problem. But Time Machine attempted to back up each directory independently, and the backup ballooned to over 2.5TB and didn't fit on the 2TB external drive. After I excluded the Git repos from the backup, the intial backup completed without any visible problems.


Otherwise the machine is used for pretty standard software development (python, gcc, gdb, git), plus standard office email/web browsing.


I've been digging into this on and off since I first noticed the problem shortly after getting the drive and I'm running out of ideas. Anyone have additional suggestions on how to avoid the deep traversal? Let me know if there's additional useful information I've left out.


Thanks!

Stephen

Mac Pro (Mid 2010), Mac OS X (10.6.8)

Posted on May 31, 2012 6:23 AM

Reply
Question marked as Top-ranking reply

Posted on May 31, 2012 6:03 PM

Stephen Bash wrote:

. . .

5/31/12 6:55:00 AM com.apple.backupd[5425] Node requires deep traversal:/ reason:contains changes|must scan subdirs|fsevent|
...
5/31/12 6:59:02 AM com.apple.backupd[5425] Node requires deep traversal:/ reason:contains changes|must scan subdirs|fsevent|

That's curious. I've rarely seen those reason codes; it looks like there was a very large volume of file system changes, but that usually sends a different message.


Even stranger, it's doing a deep traversal on both passes of the same backup. I don't recall seeing that before, either, so I suspect a problem with the File System Event Store, the hidden log of file changes that OSX keps on each volume. TM normally uses it to see what needs to be backed-up, instead of the deep traversal.


Are you running any apps that routinely make many, many changes to the file system (files or folders added, changed, moved, renamed, etc.)?


5/31/12 7:01:05 AM _spotlight[5503] vol.notice /usr/fl/etc/volume.cfg not found

Spotlight is also very unhappy about whatever that is. I don't have an fl folder in my /usr folder, so have no idea what it is, or whether that's connected to the Time Machine problem, but it sure looks suspicious.


Any idea what it is?

174 replies

Feb 28, 2013 1:07 AM in response to Pondini

Seems I could fix the problem for now.

I excluded "ibdata1" from backup (the file will be recreated automatically when importing the backed-up databases, so I see no problem here) and deactivated "XtraFinder" (I remember I had to reinstall this after upgrading to Mountain Lion).

Now the backups are very small:

User uploaded file

Thanks for your help and the hints.

Jan 21, 2014 9:16 AM in response to Pondini

Pondini wrote:


PierrickL wrote:

. . .

Node requires deep traversal:/ reason:contains changes|must scan subdirs|fsevent|

That's the same message Stephen is getting, and is quite odd to get it twice in the same backup. It sounds like a very high volume of file changes, which could happen for the first "pass," but makes no sense for the second.


Well, I'm going to add my own experience to this old thread. It was quite a brand new issue for me after years of 10.6.8 and am grateful for having found a (temporary?) solution here. I had "only" 1712 files in .fseventsd but the command rm -rf /.fsevenstd/* in single user mode did the trick (I had already tried unsuccessfully booting in safe mode).


I'd like to add that since a few weeks I had noticed that the number of files copied in the first and the second pass was identical and that sounded weird. Even weirder the many MB copied in the second pass when compared to the size of the first (I keep my main volume pretty slender, exclude from backups a few critical folders subject to lots of changes and the second pass used to amount to less than 1 MB). Unfortunately I haven't the logs anymore, but I remember no other odd messages. Just 2 or 3 days ago the Node requires deep traversal thing began.


Of course I can't tell what happened. It might be useful for future reference reporting that over last months backups were getting slower and slower (I'm using a 3rd generationTime Capsule). I resolved to give a try with DiskWarrior 4.4 connecting with cable. While reading the backup volume's directory DW signaled speed inhibited by disk malfunction and its log reported a bad block. While checking for differences in files and folders (step 9), the process got stuck and I had no other choice than forcing shutdown. Then I erased and zeroed out Time Capsule's disk and for maybe two weeks everything ran smooth. Until the above new issue. I really don't know whether an impending disk failure can be related to Time Machine always requiring deep traversals.

Feb 16, 2014 4:02 PM in response to Stephen Bash

I found the solution to my Time Machine problem, though mine may be pretty unique. The cause appears to be the Partition function of Apple’s Disk Utility.


When I first installed Snow Leopard on my MBP, I used Disk Utility to delete the existing partition, then I created a new partition using the + sign in the Partition tab. I have always done this with fresh installs or new disks. For some reason, boot disks (and perhaps non boot disks) that are freshly partitioned with Disk Utility from the 10.6.3 retail DVD will confuse Time Machine and cause it to run slower and slower. Slower as in 20 minutes to complete a backup with no files changed, and nothing running.


I reinstalled Snow Leopard, but this time simply used the Erase function to erase the entire HD, not just the partition. After erasing the HD and reinstalling Snow Leopard, TM runs MUCH faster. Backups complete on the first loop in under a minute. I am no longer seeing:


Needs new backup due to change in /

Some filesystem changes made during the course of the backup may not be accounted for. Still busy after 2 retries.


in Backup.log


It seems like this is a bug with Apple’s Disk Utility, perhaps not accounting for the hard drive’s Last Block correctly. Or maybe you are just not supposed to use the Partition tab to create new partitions, only resize?


Anyway I verified the problem on 3 different machines each with different hard drives, none of them liked a partition created by Disk Utility’s Partition function.




B

Feb 17, 2014 12:45 AM in response to bernuli

Hi Bernuli. That is interesting. The disk I have trouble with is also partitioned using Disk Utility. I've pretty much abandoned Time Machine since it takes over an hour to complete each run (with the fans spinning).


I have a Mac mini with 2 disks inside. Both are partitioned, but I only would like to use Time Mchine on the main partition (the otheres are manual backups and separate installs of Lione etc). Do you think it would be OK if I kept multiple partitions on disk 2 (and exlcuded them all from Time Machine), and reformatted Disk 1 (SSD) with just my main Snow Leopard Install?


Plan: I can temporarily clone Disk 1 (SL partition) to a new partition on Disk 2 and then erase all of Disk 1. But then I would like to simply clone the Snow Leopard partition back from Disk 2 onto Disk 1. Do you think this would work to resolve the situation? I want to avoid reinstalling the OS and all my files. Do you know if there is a way to clone it back without first having to use Disk Utility to make a partition on Disk 1?

Feb 17, 2014 7:59 AM in response to ZX48

ZX48,


I am not sure we have the same problem. The fans on my Macbook Pro never sped up, and the backups never quite hit an hour. When my backups slowed down, I would delete /.fseventsd. This was a temporary solution as over time the backups would slow down.


I don't remember seeing the Deep Traversal note in .Backup.log, though I was not specifically looking for it.


You can tell if you have the same problem as me by creating a new folder and putting a text file in it. Then run TM. Then edit the text file. Then run TM 3-4 times, but do NOT make any more changes to the text file. After you have a little history, run:


stat -f %i%t%N /Volumes/YOURTMDRIVE/Backups.backupdb/NAMEOFCOMPY/*/MacHD/Users/USERNAME/TMTEST DIR


That will display the inode and full path to the folder you are checking. You should see mostly the same inode number. If it is different for each TM run, and you have not made any changes, then your problem is the same as mine.


Also I think the following log entry will coincide with the problem.


Needs new backup due to change in /

Some filesystem changes made during the course of the backup may not be accounted for. Still busy after 2 retries.


I think cloning your drive will work. What utility do you plan to use? I will try it out and see if TM works okay after format and clone restore.


I only have one HD in my Mac Pro which I have been using as a test machine, so I can't speak to that now.


My Macbook Pro has the one internal, I am just finishing up a fresh install so I will let you know how that works. The problem affecting me is easily repeatable though so I am sure I will be good after fresh install complete.


B

Time Machine always requires deep traversal?

Welcome to Apple Support Community
A forum where Apple customers help each other with their products. Get started with your Apple Account.