I use a 1tb external ssd for Time Machine (Formatted Mac OS Extended).
Ever since updating to High Sierra when I enter Time Machine there are two Backups with the same time at every point where a Backup has been made.
I have tried re-formatting the ssd and deleting Time Machine's preferences to start from scratch, but it still does the same thing every time.
Anyone with any ideas? Thanks.
IMAC (RETINA 5K, 27-INCH, LATE 2015), macOS High Sierra (10.13)
Extracting Time Machine log activity may or may not yield useful data, but if you are interested the instructions follow below.
To extract potentially relevant Time Machine activity consider using the following shell script:
clear; printf '\e[3J' && log show --predicate 'subsystem == "com.apple.TimeMachine"' --info --last 6h | grep -F 'eMac' | grep -Fv 'etat' | awk -F']' '{print substr($0,1,19), $NF}' Copy (triple-click to select the entire line) and Paste that line in a Terminal window. The Terminal app is in your Mac's Utilities folder.
It extracts Time Machine activity logged during the previous 6 hours. To change that time period change that value. If Time Machine is running there is no need to interrupt TM to use it. Be advised that log is fairly resource-intensive, and if you are using a portable Mac it will consume a lot of battery power as it runs.
log will need a few moments to extract the Time Machine log data. Wait for it to finish. It is normal for its results to include various "errors" and "failures" and none of them are necessarily an indication of anything wrong.
Copy (Edit > Select All and then Copy) and Paste that Terminal window's contents in a reply to this Discussion. Please omit or obscure any information that you may consider personal.
For fundamental troubleshooting references please read If you can't back up or restore your Mac using Time Machine - Apple Support and macOS Sierra: Time Machine troubleshooting.
Thanks. They are not duplicates, but real backups.
What you are seeing are Time Machine's local snapshots, which in the past were created only on portable Macs. When you "Enter Time Machine" you are viewing both those local snapshots, as well as those backed up on your TMBACKUP disk, and are in fact not duplicates. If you need to restore individual files or folders, you can choose from either one. Local snapshots take nearly no time at all to create or "thin" due to APFS's inherent efficiencies. Read about local snapshots here: About Time Machine local snapshots - Apple Support.
If you needed to restore an entire system, only those backups stored on the backup devices (TMBACKUP or TMBAKUP) would be available.
Although it has no bearing on the question, at one time you designated another backup disk with the name TMBAKUP. For at least the time of that log excerpt, Time Machine could not find it, meaning it was probably just not connected during those six hours. If you do not intend to use TMBAKUP, you can safely remove it from Time Machine's Preferences. You may find an icon adjacent to it indicating is has not backed up to that device in a while.
I have tried what you suggested, but Terminal doesn't seem to like the script.
I get the following message:
> 01. clear; printf '\e[3J' && log show --predicate 'subsystem == "com.apple.TimeMachine"' --info --last 6h | grep -F 'eMac' | grep -Fv 'etat' | awk -F']' '{print substr($0,1,19), $NF}'
-bash: syntax error near unexpected token `('
Please re-read my instructions. If you place your cursor anywhere within it and triple-click, that will select the entire script. Dragging won't work, neither will selecting the script in the emailed Discussion notification you received. What you paste in the Terminal window must begin with the word clear.
I should probably add that it might not render properly in browsers other than Safari or Firefox.
OK thanks John. I did that the first couple of times but just got a blank screen on Terminal, but I wasn't waiting long enough for the results to appear.
here is the log:
Please note that any thing after 2017-09-30 13:23:50 may be different as I have just reformatted the disc again so it may be normal now.
2017-09-30 09:23:46 Starting automatic backup
2017-09-30 09:23:46 Backing up to /dev/disk3s2: /Volumes/TMBACKUP/Backups.backupdb
2017-09-30 09:23:47 Starting age based thinning of Time Machine local snapshots on disk '/'
2017-09-30 09:23:47 Failed to unmount disk mounted at '/Volumes/com.apple.TimeMachine.localsnapshots/Backups.backupdb/CLIVE’s iMac/2017-09-29-073228/Macintosh HD', error: {
Target = "file: Target = "file:///Volumes/com.apple.TimeMachine.localsnapshots/Backups.backupdb/CLIVE%E2 %80%99s%20iMac/2017-09-29-073228/Macintosh%20HD";
2017-09-30 09:23:47 Age based thinning deleted Time Machine snapshot 'com.apple.TimeMachine.2017-09-29-073228' on disk '/
2017-09-30 09:23:47 Failed to unmount disk mounted at '/Volumes/com.apple.TimeMachine.localsnapshots/Backups.backupdb/CLIVE’s iMac/2017-09-29-083245/Macintosh HD', error: {
Target = "file: Target = "file:///Volumes/com.apple.TimeMachine.localsnapshots/Backups.backupdb/CLIVE%E2 %80%99s%20iMac/2017-09-29-083245/Macintosh%20HD";
2017-09-30 09:23:47 Age based thinning deleted Time Machine snapshot 'com.apple.TimeMachine.2017-09-29-083245' on disk '/
2017-09-30 09:23:57 Completed thinning of Time Machine local snapshots on disk '/' in 10.3 seconds - current free space: 699.88 GB (699,882,967,040 bytes), target free space: 26.84 GB (26,843,545,600 bytes), initial free space: 699.66 GB (699,662,188,544 bytes), urgency: 2, remaining snapshots: {(
"com.apple.Time "com.apple.TimeMachine.2017-09-29-103245",
"com.apple.Time "com.apple.TimeMachine.2017-09-30-082511",
"com.apple.Time "com.apple.TimeMachine.2017-09-29-163355",
"com.apple.Time "com.apple.TimeMachine.2017-09-29-143230",
"com.apple.Time "com.apple.TimeMachine.2017-09-29-173352",
"com.apple.Time "com.apple.TimeMachine.2017-09-29-153759",
"com.apple.Time "com.apple.TimeMachine.2017-09-29-183345",
"com.apple.Time "com.apple.TimeMachine.2017-09-29-123245",
"com.apple.Time "com.apple.TimeMachine.2017-09-29-113636",
"com.apple.Time "com.apple.TimeMachine.2017-09-29-203245"
2017-09-30 09:23:57 Failed to write unlock record UUIDs as extended attribute for disk '/', error: Error Domain=NSPOSIXErrorDomain Code=1 "Operation not permitted"
2017-09-30 09:23:57 Created Time Machine local snapshot with name 'com.apple.TimeMachine.2017-09-30-092357' on disk '/'
2017-09-30 09:23:57 Declared stable snapshot: com.apple.TimeMachine.2017-09-30-092357
2017-09-30 09:23:57 Mounted stable snapshot: com.apple.TimeMachine.2017-09-30-092357 at path: /Volumes/com.apple.TimeMachine.localsnapshots/Backups.backupdb/CLIVE’s iMac/2017-09-30-092357/Macintosh HD source: Macintosh HD
2017-09-30 09:23:57 Mounted reference snapshot: com.apple.TimeMachine.2017-09-30-082511 at path: /Volumes/com.apple.TimeMachine.localsnapshots/Backups.backupdb/CLIVE’s iMac/2017-09-30-082511/Macintosh HD source: Macintosh HD
2017-09-30 09:23:58 Will copy (40.7 MB) from Macintosh HD
2017-09-30 09:23:58 Found 370 files (40.7 MB) needing backup
2017-09-30 09:23:58 899.2 MB required (including padding), 731.35 GB available
2017-09-30 09:23:59 Copied 399 items (40.5 MB) from volume Macintosh HD. Linked 2429.
2017-09-30 09:23:59 Saved clone family cache for 'Macintosh HD' at /Volumes/TMBACKUP/Backups.backupdb/CLIVE’s iMac/2017-09-30-092357.inProgress/A454C856-BB94-4B34-9825-AA398B87CC69/.3339E39 8-3CBC-3B22-B307-4C0F158D0BAD.clonedb
2017-09-30 09:23:59 Unmounted local snapshot: com.apple.TimeMachine.2017-09-30-092357 at path: /Volumes/com.apple.TimeMachine.localsnapshots/Backups.backupdb/CLIVE’s iMac/2017-09-30-092357/Macintosh HD source: Macintosh HD
2017-09-30 09:24:00 Unmounted local snapshot: com.apple.TimeMachine.2017-09-30-082511 at path: /Volumes/com.apple.TimeMachine.localsnapshots/Backups.backupdb/CLIVE’s iMac/2017-09-30-082511/Macintosh HD source: Macintosh HD
2017-09-30 09:24:00 Marked as reference snapshot: com.apple.TimeMachine.2017-09-30-092357
2017-09-30 09:24:00 Completed snapshot: 2017-09-30-092400
2017-09-30 09:24:01 Starting post-backup thinning
2017-09-30 09:24:01 Deleted /Volumes/TMBACKUP/Backups.backupdb/CLIVE’s iMac/2017-09-29-083248 (10.5 MB)
2017-09-30 09:24:01 Post-backup thinning complete: 1 expired backups removed
2017-09-30 09:24:01 Backup completed successfully.
2017-09-30 10:29:37 Starting automatic backup
2017-09-30 10:29:37 Backing up to /dev/disk3s2: /Volumes/TMBACKUP/Backups.backupdb
2017-09-30 10:29:37 Starting age based thinning of Time Machine local snapshots on disk '/'
2017-09-30 10:29:37 Completed thinning of Time Machine local snapshots on disk '/' in 0.0 seconds - current free space: 699.7 GB (699,698,388,992 bytes), target free space: 26.84 GB (26,843,545,600 bytes), initial free space: 699.7 GB (699,698,388,992 bytes), urgency: 2, remaining snapshots: {(
"com.apple.Time "com.apple.TimeMachine.2017-09-29-103245",
"com.apple.Time "com.apple.TimeMachine.2017-09-30-082511",
"com.apple.Time "com.apple.TimeMachine.2017-09-29-163355",
"com.apple.Time "com.apple.TimeMachine.2017-09-29-143230",
"com.apple.Time "com.apple.TimeMachine.2017-09-29-173352",
"com.apple.Time "com.apple.TimeMachine.2017-09-29-153759",
"com.apple.Time "com.apple.TimeMachine.2017-09-29-183345",
"com.apple.Time "com.apple.TimeMachine.2017-09-29-123245",
"com.apple.Time "com.apple.TimeMachine.2017-09-30-092357",
"com.apple.Time "com.apple.TimeMachine.2017-09-29-113636",
"com.apple.Time "com.apple.TimeMachine.2017-09-29-203245"
2017-09-30 10:29:37 Failed to write unlock record UUIDs as extended attribute for disk '/', error: Error Domain=NSPOSIXErrorDomain Code=1 "Operation not permitted"
2017-09-30 10:29:37 Created Time Machine local snapshot with name 'com.apple.TimeMachine.2017-09-30-102937' on disk '/'
2017-09-30 10:29:37 Declared stable snapshot: com.apple.TimeMachine.2017-09-30-102937
2017-09-30 10:29:37 Mounted stable snapshot: com.apple.TimeMachine.2017-09-30-102937 at path: /Volumes/com.apple.TimeMachine.localsnapshots/Backups.backupdb/CLIVE’s iMac/2017-09-30-102937/Macintosh HD source: Macintosh HD
2017-09-30 10:29:37 Mounted reference snapshot: com.apple.TimeMachine.2017-09-30-092357 at path: /Volumes/com.apple.TimeMachine.localsnapshots/Backups.backupdb/CLIVE’s iMac/2017-09-30-092357/Macintosh HD source: Macintosh HD
2017-09-30 10:29:39 Will copy (17.5 MB) from Macintosh HD
2017-09-30 10:29:39 Found 292 files (17.5 MB) needing backup
2017-09-30 10:29:39 871.4 MB required (including padding), 731.31 GB available
2017-09-30 10:29:41 Copied 350 items (17.5 MB) from volume Macintosh HD. Linked 2041.
2017-09-30 10:29:41 Saved clone family cache for 'Macintosh HD' at /Volumes/TMBACKUP/Backups.backupdb/CLIVE’s iMac/2017-09-30-102937.inProgress/3BCB7E32-8965-4A3D-BC7A-357B151A83FD/.3339E39 8-3CBC-3B22-B307-4C0F158D0BAD.clonedb
2017-09-30 10:29:41 Unmounted local snapshot: com.apple.TimeMachine.2017-09-30-102937 at path: /Volumes/com.apple.TimeMachine.localsnapshots/Backups.backupdb/CLIVE’s iMac/2017-09-30-102937/Macintosh HD source: Macintosh HD
2017-09-30 10:29:41 Unmounted local snapshot: com.apple.TimeMachine.2017-09-30-092357 at path: /Volumes/com.apple.TimeMachine.localsnapshots/Backups.backupdb/CLIVE’s iMac/2017-09-30-092357/Macintosh HD source: Macintosh HD
2017-09-30 10:29:41 Marked as reference snapshot: com.apple.TimeMachine.2017-09-30-102937
2017-09-30 10:29:41 Completed snapshot: 2017-09-30-102941
2017-09-30 10:29:43 Starting post-backup thinning
2017-09-30 10:29:43 No post-backup thinning needed: no expired backups exist
2017-09-30 10:29:43 Backup completed successfully.
2017-09-30 11:28:33 Starting automatic backup
2017-09-30 11:28:33 Backing up to /dev/disk3s2: /Volumes/TMBACKUP/Backups.backupdb
2017-09-30 11:28:33 Starting age based thinning of Time Machine local snapshots on disk '/'
2017-09-30 11:28:33 Failed to unmount disk mounted at '/Volumes/com.apple.TimeMachine.localsnapshots/Backups.backupdb/CLIVE’s iMac/2017-09-29-103245/Macintosh HD', error: {
Target = "file: Target = "file:///Volumes/com.apple.TimeMachine.localsnapshots/Backups.backupdb/CLIVE%E2 %80%99s%20iMac/2017-09-29-103245/Macintosh%20HD";
2017-09-30 11:28:33 Age based thinning deleted Time Machine snapshot 'com.apple.TimeMachine.2017-09-29-103245' on disk '/
2017-09-30 11:28:38 Completed thinning of Time Machine local snapshots on disk '/' in 5.0 seconds - current free space: 699.56 GB (699,564,462,080 bytes), target free space: 26.84 GB (26,843,545,600 bytes), initial free space: 699.53 GB (699,532,713,984 bytes), urgency: 2, remaining snapshots: {(
"com.apple.Time "com.apple.TimeMachine.2017-09-30-082511",
"com.apple.Time "com.apple.TimeMachine.2017-09-29-163355",
"com.apple.Time "com.apple.TimeMachine.2017-09-29-173352",
"com.apple.Time "com.apple.TimeMachine.2017-09-29-153759",
"com.apple.Time "com.apple.TimeMachine.2017-09-29-143230",
"com.apple.Time "com.apple.TimeMachine.2017-09-29-183345",
"com.apple.Time "com.apple.TimeMachine.2017-09-29-123245",
"com.apple.Time "com.apple.TimeMachine.2017-09-30-092357",
"com.apple.Time "com.apple.TimeMachine.2017-09-29-113636",
"com.apple.Time "com.apple.TimeMachine.2017-09-29-203245",
"com.apple.Time "com.apple.TimeMachine.2017-09-30-102937"
2017-09-30 11:28:39 Failed to write unlock record UUIDs as extended attribute for disk '/', error: Error Domain=NSPOSIXErrorDomain Code=1 "Operation not permitted"
2017-09-30 11:28:39 Created Time Machine local snapshot with name 'com.apple.TimeMachine.2017-09-30-112839' on disk '/'
2017-09-30 11:28:39 Declared stable snapshot: com.apple.TimeMachine.2017-09-30-112839
2017-09-30 11:28:39 Mounted stable snapshot: com.apple.TimeMachine.2017-09-30-112839 at path: /Volumes/com.apple.TimeMachine.localsnapshots/Backups.backupdb/CLIVE’s iMac/2017-09-30-112839/Macintosh HD source: Macintosh HD
2017-09-30 11:28:39 Mounted reference snapshot: com.apple.TimeMachine.2017-09-30-102937 at path: /Volumes/com.apple.TimeMachine.localsnapshots/Backups.backupdb/CLIVE’s iMac/2017-09-30-102937/Macintosh HD source: Macintosh HD
2017-09-30 11:28:39 Will copy (30.5 MB) from Macintosh HD
2017-09-30 11:28:39 Found 217 files (30.5 MB) needing backup
2017-09-30 11:28:39 887 MB required (including padding), 731.29 GB available
2017-09-30 11:28:40 Copied 246 items (30.4 MB) from volume Macintosh HD. Linked 1870.
2017-09-30 11:28:40 Saved clone family cache for 'Macintosh HD' at /Volumes/TMBACKUP/Backups.backupdb/CLIVE’s iMac/2017-09-30-112839.inProgress/F8F979FE-280A-4DF9-939C-786E26E58AA6/.3339E39 8-3CBC-3B22-B307-4C0F158D0BAD.clonedb
2017-09-30 11:28:40 Unmounted local snapshot: com.apple.TimeMachine.2017-09-30-112839 at path: /Volumes/com.apple.TimeMachine.localsnapshots/Backups.backupdb/CLIVE’s iMac/2017-09-30-112839/Macintosh HD source: Macintosh HD
2017-09-30 11:28:40 Unmounted local snapshot: com.apple.TimeMachine.2017-09-30-102937 at path: /Volumes/com.apple.TimeMachine.localsnapshots/Backups.backupdb/CLIVE’s iMac/2017-09-30-102937/Macintosh HD source: Macintosh HD
2017-09-30 11:28:41 Marked as reference snapshot: com.apple.TimeMachine.2017-09-30-112839
2017-09-30 11:28:41 Completed snapshot: 2017-09-30-112840
2017-09-30 11:28:42 Starting post-backup thinning
2017-09-30 11:28:42 Deleted /Volumes/TMBACKUP/Backups.backupdb/CLIVE’s iMac/2017-09-29-103250 (7.6 MB)
2017-09-30 11:28:42 Post-backup thinning complete: 1 expired backups removed
2017-09-30 11:28:42 Backup completed successfully.
2017-09-30 12:25:41 Starting automatic backup
2017-09-30 12:25:41 Backing up to /dev/disk3s2: /Volumes/TMBACKUP/Backups.backupdb
2017-09-30 12:25:41 Starting age based thinning of Time Machine local snapshots on disk '/'
2017-09-30 12:25:41 Failed to unmount disk mounted at '/Volumes/com.apple.TimeMachine.localsnapshots/Backups.backupdb/CLIVE’s iMac/2017-09-29-113636/Macintosh HD', error: {
Target = "file: Target = "file:///Volumes/com.apple.TimeMachine.localsnapshots/Backups.backupdb/CLIVE%E2 %80%99s%20iMac/2017-09-29-113636/Macintosh%20HD";
2017-09-30 12:25:41 Age based thinning deleted Time Machine snapshot 'com.apple.TimeMachine.2017-09-29-113636' on disk '/
2017-09-30 12:25:46 Completed thinning of Time Machine local snapshots on disk '/' in 4.9 seconds - current free space: 699.43 GB (699,434,254,336 bytes), target free space: 26.84 GB (26,843,545,600 bytes), initial free space: 699.4 GB (699,404,955,648 bytes), urgency: 2, remaining snapshots: {(
"com.apple.Time "com.apple.TimeMachine.2017-09-30-082511",
"com.apple.Time "com.apple.TimeMachine.2017-09-30-112839",
"com.apple.Time "com.apple.TimeMachine.2017-09-29-173352",
"com.apple.Time "com.apple.TimeMachine.2017-09-29-163355",
"com.apple.Time "com.apple.TimeMachine.2017-09-29-153759",
"com.apple.Time "com.apple.TimeMachine.2017-09-29-143230",
"com.apple.Time "com.apple.TimeMachine.2017-09-29-183345",
"com.apple.Time "com.apple.TimeMachine.2017-09-29-123245",
"com.apple.Time "com.apple.TimeMachine.2017-09-30-092357",
"com.apple.Time "com.apple.TimeMachine.2017-09-29-203245",
"com.apple.Time "com.apple.TimeMachine.2017-09-30-102937"
2017-09-30 12:25:46 Failed to write unlock record UUIDs as extended attribute for disk '/', error: Error Domain=NSPOSIXErrorDomain Code=1 "Operation not permitted"
2017-09-30 12:25:46 Created Time Machine local snapshot with name 'com.apple.TimeMachine.2017-09-30-122546' on disk '/'
2017-09-30 12:25:46 Declared stable snapshot: com.apple.TimeMachine.2017-09-30-122546
2017-09-30 12:25:46 Mounted stable snapshot: com.apple.TimeMachine.2017-09-30-122546 at path: /Volumes/com.apple.TimeMachine.localsnapshots/Backups.backupdb/CLIVE’s iMac/2017-09-30-122546/Macintosh HD source: Macintosh HD
2017-09-30 12:25:46 Mounted reference snapshot: com.apple.TimeMachine.2017-09-30-112839 at path: /Volumes/com.apple.TimeMachine.localsnapshots/Backups.backupdb/CLIVE’s iMac/2017-09-30-112839/Macintosh HD source: Macintosh HD
2017-09-30 12:25:47 Will copy (25.8 MB) from Macintosh HD
2017-09-30 12:25:47 Found 238 files (25.8 MB) needing backup
2017-09-30 12:25:47 881.4 MB required (including padding), 731.27 GB available
2017-09-30 12:25:48 Copied 240 items (25.7 MB) from volume Macintosh HD. Linked 1808.
2017-09-30 12:25:48 Saved clone family cache for 'Macintosh HD' at /Volumes/TMBACKUP/Backups.backupdb/CLIVE’s iMac/2017-09-30-122546.inProgress/35336931-FDFA-4223-875E-72D0329C95D4/.3339E39 8-3CBC-3B22-B307-4C0F158D0BAD.clonedb
2017-09-30 12:25:48 Unmounted local snapshot: com.apple.TimeMachine.2017-09-30-122546 at path: /Volumes/com.apple.TimeMachine.localsnapshots/Backups.backupdb/CLIVE’s iMac/2017-09-30-122546/Macintosh HD source: Macintosh HD
2017-09-30 12:25:48 Unmounted local snapshot: com.apple.TimeMachine.2017-09-30-112839 at path: /Volumes/com.apple.TimeMachine.localsnapshots/Backups.backupdb/CLIVE’s iMac/2017-09-30-112839/Macintosh HD source: Macintosh HD
2017-09-30 12:25:49 Marked as reference snapshot: com.apple.TimeMachine.2017-09-30-122546
2017-09-30 12:25:49 Completed snapshot: 2017-09-30-122549
2017-09-30 12:25:50 Starting post-backup thinning
2017-09-30 12:25:50 Deleted /Volumes/TMBACKUP/Backups.backupdb/CLIVE’s iMac/2017-09-29-113638 (13.2 MB)
2017-09-30 12:25:50 Post-backup thinning complete: 1 expired backups removed
2017-09-30 12:25:50 Backup completed successfully.
2017-09-30 13:23:50 Starting automatic backup
2017-09-30 13:23:50 Backing up to /dev/disk3s2: /Volumes/TMBACKUP/Backups.backupdb
2017-09-30 13:23:50 Starting age based thinning of Time Machine local snapshots on disk '/'
2017-09-30 13:23:50 Failed to unmount disk mounted at '/Volumes/com.apple.TimeMachine.localsnapshots/Backups.backupdb/CLIVE’s iMac/2017-09-29-123245/Macintosh HD', error: {
Target = "file: Target = "file:///Volumes/com.apple.TimeMachine.localsnapshots/Backups.backupdb/CLIVE%E2 %80%99s%20iMac/2017-09-29-123245/Macintosh%20HD";
2017-09-30 13:23:50 Age based thinning deleted Time Machine snapshot 'com.apple.TimeMachine.2017-09-29-123245' on disk '/
2017-09-30 13:23:55 Completed thinning of Time Machine local snapshots on disk '/' in 5.1 seconds - current free space: 699.31 GB (699,311,771,648 bytes), target free space: 26.84 GB (26,843,545,600 bytes), initial free space: 699.29 GB (699,289,014,272 bytes), urgency: 2, remaining snapshots: {(
"com.apple.Time "com.apple.TimeMachine.2017-09-30-082511",
"com.apple.Time "com.apple.TimeMachine.2017-09-30-112839",
"com.apple.Time "com.apple.TimeMachine.2017-09-29-173352",
"com.apple.Time "com.apple.TimeMachine.2017-09-29-163355",
"com.apple.Time "com.apple.TimeMachine.2017-09-29-153759",
"com.apple.Time "com.apple.TimeMachine.2017-09-29-143230",
"com.apple.Time "com.apple.TimeMachine.2017-09-29-183345",
"com.apple.Time "com.apple.TimeMachine.2017-09-30-122546",
"com.apple.Time "com.apple.TimeMachine.2017-09-30-092357",
"com.apple.Time "com.apple.TimeMachine.2017-09-29-203245",
"com.apple.Time "com.apple.TimeMachine.2017-09-30-102937"
2017-09-30 13:23:55 Failed to write unlock record UUIDs as extended attribute for disk '/', error: Error Domain=NSPOSIXErrorDomain Code=1 "Operation not permitted"
2017-09-30 13:23:56 Created Time Machine local snapshot with name 'com.apple.TimeMachine.2017-09-30-132355' on disk '/'
2017-09-30 13:23:56 Declared stable snapshot: com.apple.TimeMachine.2017-09-30-132355
2017-09-30 13:23:56 Mounted stable snapshot: com.apple.TimeMachine.2017-09-30-132355 at path: /Volumes/com.apple.TimeMachine.localsnapshots/Backups.backupdb/CLIVE’s iMac/2017-09-30-132355/Macintosh HD source: Macintosh HD
2017-09-30 13:23:56 Mounted reference snapshot: com.apple.TimeMachine.2017-09-30-122546 at path: /Volumes/com.apple.TimeMachine.localsnapshots/Backups.backupdb/CLIVE’s iMac/2017-09-30-122546/Macintosh HD source: Macintosh HD
2017-09-30 13:23:56 Will copy (24.1 MB) from Macintosh HD
2017-09-30 13:23:56 Found 298 files (24.1 MB) needing backup
2017-09-30 13:23:56 879.4 MB required (including padding), 731.26 GB available
2017-09-30 13:23:57 Copied 301 items (24.1 MB) from volume Macintosh HD. Linked 1509.
2017-09-30 13:23:57 Saved clone family cache for 'Macintosh HD' at /Volumes/TMBACKUP/Backups.backupdb/CLIVE’s iMac/2017-09-30-132356.inProgress/AA767A7E-9A5A-4D01-98C8-12125B97476D/.3339E39 8-3CBC-3B22-B307-4C0F158D0BAD.clonedb
2017-09-30 13:23:57 Unmounted local snapshot: com.apple.TimeMachine.2017-09-30-132355 at path: /Volumes/com.apple.TimeMachine.localsnapshots/Backups.backupdb/CLIVE’s iMac/2017-09-30-132355/Macintosh HD source: Macintosh HD
2017-09-30 13:23:57 Unmounted local snapshot: com.apple.TimeMachine.2017-09-30-122546 at path: /Volumes/com.apple.TimeMachine.localsnapshots/Backups.backupdb/CLIVE’s iMac/2017-09-30-122546/Macintosh HD source: Macintosh HD
2017-09-30 13:23:57 Marked as reference snapshot: com.apple.TimeMachine.2017-09-30-132355
2017-09-30 13:23:57 Completed snapshot: 2017-09-30-132357
2017-09-30 13:23:59 Starting post-backup thinning
2017-09-30 13:23:59 Deleted /Volumes/TMBACKUP/Backups.backupdb/CLIVE’s iMac/2017-09-29-123247 (20.5 MB)
2017-09-30 13:23:59 Post-backup thinning complete: 1 expired backups removed
2017-09-30 13:23:59 Backup completed successfully.
2017-09-30 13:35:31 com.apple.TMHelperAgent.SetupOffer enabled
2017-09-30 13:35:31 com.apple.TMHelperAgent.SetupOffer enabled
2017-09-30 13:35:32 com.apple.TMHelperAgent.SetupOffer enabled
2017-09-30 13:35:33 com.apple.TMHelperAgent.SetupOffer enabled
2017-09-30 13:35:37 com.apple.TMHelperAgent.SetupOffer enabled
2017-09-30 13:43:40 Failed to open '/Volumes/TMBAKUP', error: No such file or directory
2017-09-30 13:43:40 Failed to retrieve Time Machine local snapshots for disk 'TMBACKUP', error: Error Domain=NSPOSIXErrorDomain Code=2 "No such file or directory" UserInfo={NSFilePath=/Volumes/TMBAKUP, NSLocalizedDescription=/Volumes/TMBAKUP: No such file or directory (error 2)}
2017-09-30 13:45:48 Starting age based thinning of Time Machine local snapshots on disk '/'
2017-09-30 13:45:48 Completed thinning of Time Machine local snapshots on disk '/' in 0.0 seconds - current free space: 699.04 GB (699,044,773,888 bytes), target free space: 26.84 GB (26,843,545,600 bytes), initial free space: 699.04 GB (699,044,773,888 bytes), urgency: 2, remaining snapshots: {(
"com.apple.Time "com.apple.TimeMachine.2017-09-30-082511",
"com.apple.Time "com.apple.TimeMachine.2017-09-30-112839",
"com.apple.Time "com.apple.TimeMachine.2017-09-29-173352",
"com.apple.Time "com.apple.TimeMachine.2017-09-29-163355",
"com.apple.Time "com.apple.TimeMachine.2017-09-29-153759",
"com.apple.Time "com.apple.TimeMachine.2017-09-29-143230",
"com.apple.Time "com.apple.TimeMachine.2017-09-29-183345",
"com.apple.Time "com.apple.TimeMachine.2017-09-30-122546",
"com.apple.Time "com.apple.TimeMachine.2017-09-30-092357",
"com.apple.Time "com.apple.TimeMachine.2017-09-29-203245",
"com.apple.Time "com.apple.TimeMachine.2017-09-30-102937",
"com.apple.Time "com.apple.TimeMachine.2017-09-30-132355"
2017-09-30 13:45:48 Failed to write unlock record UUIDs as extended attribute for disk '/', error: Error Domain=NSPOSIXErrorDomain Code=1 "Operation not permitted"
2017-09-30 13:45:48 Created Time Machine local snapshot with name 'com.apple.TimeMachine.2017-09-30-134548' on disk '/'
2017-09-30 13:52:48 Failed to open '/Volumes/TMBAKUP', error: No such file or directory
2017-09-30 13:52:48 Failed to retrieve Time Machine local snapshots for disk 'TMBACKUP', error: Error Domain=NSPOSIXErrorDomain Code=2 "No such file or directory" UserInfo={NSFilePath=/Volumes/TMBAKUP, NSLocalizedDescription=/Volumes/TMBAKUP: No such file or directory (error 2)}
2017-09-30 14:02:51 Failed to open '/Volumes/TMBAKUP', error: No such file or directory
2017-09-30 14:02:51 Failed to retrieve Time Machine local snapshots for disk 'TMBACKUP', error: Error Domain=NSPOSIXErrorDomain Code=2 "No such file or directory" UserInfo={NSFilePath=/Volumes/TMBAKUP, NSLocalizedDescription=/Volumes/TMBAKUP: No such file or directory (error 2)}
2017-09-30 14:11:43 Failed to unmount disk mounted at '/Volumes/com.apple.TimeMachine.localsnapshots/Backups.backupdb/CLIVE’s iMac/2017-09-30-134548/Macintosh HD', error: {
Target = "file: Target = "file:///Volumes/com.apple.TimeMachine.localsnapshots/Backups.backupdb/CLIVE%E2 %80%99s%20iMac/2017-09-30-134548/Macintosh%20HD";
2017-09-30 14:11:43 Failed to unmount disk mounted at '/Volumes/com.apple.TimeMachine.localsnapshots/Backups.backupdb/CLIVE’s iMac/2017-09-30-134548/VM', error: {
Target = "file: Target = "file:///Volumes/com.apple.TimeMachine.localsnapshots/Backups.backupdb/CLIVE%E2 %80%99s%20iMac/2017-09-30-134548/VM";
2017-09-30 14:11:43 Failed to unmount disk mounted at '/Volumes/com.apple.TimeMachine.localsnapshots/Backups.backupdb/CLIVE’s iMac/2017-09-30-134548/HDBACKUP', error: {
Target = "file: Target = "file:///Volumes/com.apple.TimeMachine.localsnapshots/Backups.backupdb/CLIVE%E2 %80%99s%20iMac/2017-09-30-134548/HDBACKUP";
2017-09-30 14:11:43 Failed to unmount disk mounted at '/Volumes/com.apple.TimeMachine.localsnapshots/Backups.backupdb/CLIVE’s iMac/2017-09-30-134548/TMBACKUP', error: {
Target = "file: Target = "file:///Volumes/com.apple.TimeMachine.localsnapshots/Backups.backupdb/CLIVE%E2 %80%99s%20iMac/2017-09-30-134548/TMBACKUP";
2017-09-30 14:11:43 Failed to enumerate 'file:///Volumes/com.apple.TimeMachine.localsnapshots', error: Error Domain=NSCocoaErrorDomain Code=260 "The file “com.apple.TimeMachine.localsnapshots” couldn’t be opened because there is no such file." UserInfo={NSURL=file:///Volumes/com.apple.TimeMachine.localsnapshots, NSFilePath=/Volumes/com.apple.TimeMachine.localsnapshots, NSUnderlyingError=0x7fc59e504bd0 {Error Domain=NSPOSIXErrorDomain Code=2 "No such file or directory"}}
2017-09-30 14:11:43 Deleted Time Machine local snapshot with name 'com.apple.TimeMachine.2017-09-30-134548' on disk '/'
2017-09-30 14:11:43 Failed to delete APFS snapshot with name 'com.apple.TimeMachine.2017-09-30-134548' on volume '/private/var/vm', error: Error Domain=NSPOSIXErrorDomain Code=2 "No such file or directory"
2017-09-30 14:11:43 Failed to delete Time Machine local snapshot with name 'com.apple.TimeMachine.2017-09-30-134548' on disk '/private/var/vm'
2017-09-30 14:11:43 Failed to delete APFS snapshot with name 'com.apple.TimeMachine.2017-09-30-134548' on volume '/Volumes/HDBACKUP', error: Error Domain=NSPOSIXErrorDomain Code=2 "No such file or directory"
2017-09-30 14:11:43 Failed to delete Time Machine local snapshot with name 'com.apple.TimeMachine.2017-09-30-134548' on disk '/Volumes/HDBACKUP'
2017-09-30 14:11:43 Failed to delete APFS snapshot with name 'com.apple.TimeMachine.2017-09-30-134548' on volume '/Volumes/TMBACKUP 1', error: Error Domain=NSPOSIXErrorDomain Code=2 "No such file or directory"
2017-09-30 14:11:43 Failed to delete Time Machine local snapshot with name 'com.apple.TimeMachine.2017-09-30-134548' on disk '/Volumes/TMBACKUP 1'
2017-09-30 14:12:54 Failed to open '/Volumes/TMBAKUP', error: No such file or directory
2017-09-30 14:12:54 Failed to retrieve Time Machine local snapshots for disk 'TMBACKUP', error: Error Domain=NSPOSIXErrorDomain Code=2 "No such file or directory" UserInfo={NSFilePath=/Volumes/TMBAKUP, NSLocalizedDescription=/Volumes/TMBAKUP: No such file or directory (error 2)}
2017-09-30 14:13:23 com.apple.TMHelperAgent.SetupOffer enabled
2017-09-30 14:13:29 com.apple.TMHelperAgent.SetupOffer enabled
2017-09-30 14:13:30 com.apple.TMHelperAgent.SetupOffer enabled
2017-09-30 14:13:34 Displaying erase confirmation alert for volume named: TMBACKUP mounted at: /Volumes/TMBACKUP 1
2017-09-30 14:14:31 com.apple.TMHelperAgent.SetupOffer enabled
2017-09-30 14:14:35 com.apple.TMHelperAgent.SetupOffer enabled
2017-09-30 14:14:56 Starting automatic backup
2017-09-30 14:14:57 Backing up to /dev/disk3s3: /Volumes/TMBACKUP/Backups.backupdb
2017-09-30 14:14:58 Starting age based thinning of Time Machine local snapshots on disk '/'
2017-09-30 14:14:58 Completed thinning of Time Machine local snapshots on disk '/' in 0.0 seconds - current free space: 698.92 GB (698,921,472,000 bytes), target free space: 26.84 GB (26,843,545,600 bytes), initial free space: 698.92 GB (698,921,472,000 bytes), urgency: 2, remaining snapshots: {(
"com.apple.Time "com.apple.TimeMachine.2017-09-30-082511",
"com.apple.Time "com.apple.TimeMachine.2017-09-30-112839",
"com.apple.Time "com.apple.TimeMachine.2017-09-29-173352",
"com.apple.Time "com.apple.TimeMachine.2017-09-29-163355",
"com.apple.Time "com.apple.TimeMachine.2017-09-29-153759",
"com.apple.Time "com.apple.TimeMachine.2017-09-29-143230",
"com.apple.Time "com.apple.TimeMachine.2017-09-29-183345",
"com.apple.Time "com.apple.TimeMachine.2017-09-30-122546",
"com.apple.Time "com.apple.TimeMachine.2017-09-30-092357",
"com.apple.Time "com.apple.TimeMachine.2017-09-29-203245",
"com.apple.Time "com.apple.TimeMachine.2017-09-30-102937",
"com.apple.Time "com.apple.TimeMachine.2017-09-30-132355"
2017-09-30 14:14:58 Failed to write unlock record UUIDs as extended attribute for disk '/', error: Error Domain=NSPOSIXErrorDomain Code=1 "Operation not permitted"
2017-09-30 14:14:58 Created Time Machine local snapshot with name 'com.apple.TimeMachine.2017-09-30-141458' on disk '/'
2017-09-30 14:14:58 Declared stable snapshot: com.apple.TimeMachine.2017-09-30-141458
2017-09-30 14:14:58 Mounted stable snapshot: com.apple.TimeMachine.2017-09-30-141458 at path: /Volumes/com.apple.TimeMachine.localsnapshots/Backups.backupdb/CLIVE’s iMac/2017-09-30-141458/Macintosh HD source: Macintosh HD
2017-09-30 14:14:58 Initial backup of source: "Macintosh HD" (device: /dev/disk1s1 mount: '/' fsUUID: 3339E398-3CBC-3B22-B307-4C0F158D0BAD eventDBUUID: 26FC1C25-EEE7-48DF-B8B6-8AC140EEE16A)
2017-09-30 14:15:00 Total content size: 298.53 GB excluded items size: 3.88 GB for volume Macintosh HD
2017-09-30 14:15:00 Found 928023 files (294.65 GB) needing backup
2017-09-30 14:15:00 316.12 GB required (including padding), 511.42 GB available
2017-09-30 14:15:00 Waiting for index to be ready (100)
2017-09-30 14:29:43 Not starting scheduled Time Machine backup: Backup already running
2017-09-30 15:08:54 Copied 904602 items (284.38 GB) from volume Macintosh HD. Linked 0.
2017-09-30 15:08:54 Saved clone family cache for 'Macintosh HD' at /Volumes/TMBACKUP/Backups.backupdb/CLIVE’s iMac/2017-09-30-141458.inProgress/E16F637F-4430-4CF4-903C-BE27E92BFE67/.3339E39 8-3CBC-3B22-B307-4C0F158D0BAD.clonedb
2017-09-30 15:08:54 Unmounted local snapshot: com.apple.TimeMachine.2017-09-30-141458 at path: /Volumes/com.apple.TimeMachine.localsnapshots/Backups.backupdb/CLIVE’s iMac/2017-09-30-141458/Macintosh HD source: Macintosh HD
2017-09-30 15:08:54 Marked as reference snapshot: com.apple.TimeMachine.2017-09-30-141458
2017-09-30 15:08:54 Completed snapshot: 2017-09-30-150854
2017-09-30 15:08:55 Copying recovery system
2017-09-30 15:08:58 Finished copying recovery system
2017-09-30 15:08:59 Starting post-backup thinning
2017-09-30 15:08:59 No post-backup thinning needed: no expired backups exist
2017-09-30 15:08:59 Backup completed successfully.
CLIVEs-iMac:~ ozbusa$
Thanks for the explanation and link John. All clear to me now.
The TMBAKUP is long gone now, I deleted it and removed from Time Machine shortly after that log was created, but thanks anyway.
FWIW still making duplicates after 2017-09-30 13:23:50.
Time Machine showing duplicate backups