[rdiff-backup-users] Strange crash

[Kevin Horton]

I have a repeatable crash with rdiff-backup-1.1.5, installed via fink  
on OS X 10.4.5.  Last week I successfully made a full backup of an  
iBook to my main computer.  This week a backup attempt repeatably  
fails with:

Incrementing mirror file /Volumes/Maxtor_300/bu/iBook/Music/iTunes/ 
iTunes Music/Molly Johnson/Another day
Exception 'Path: /Volumes/Maxtor_300/bu/iBook/rdiff-backup-data/ 
increments/Music/iTunes/iTunes Music/Molly Johnson/Another day. 
2006-03-26T08:00:43-05:00.dir
Index: ('Music', 'iTunes', 'iTunes Music', 'Molly Johnson', 'Another  
day.2006-03-26T08:00:43-05:00.dir')
Data: {'carbonfile': {'flags': 0, 'type': '\x00\x00\x00\x00',  
'location': (0, 0), 'creator': '\x00\x00\x00\x00'}, 'uid': 0,  
'perms': 493, 'type': 'reg', 'gname': 'unknown', 'ctime': 1143935080,  
'devloc': 234881041L, 'uname': 'root', 'nlink': 1, 'gid': 99,  
'mtime': 1080778719, 'resourcefork': '', 'atime': 1143935080,  
'inode': 1031905L, 'size': 0L}' raised of class  
'exceptions.AssertionError':
  File "/sw/lib/python2.4/site-packages/rdiff_backup/Main.py", line  
295, in error_check_Main
    try: Main(arglist)
  File "/sw/lib/python2.4/site-packages/rdiff_backup/Main.py", line  
315, in Main
    take_action(rps)
  File "/sw/lib/python2.4/site-packages/rdiff_backup/Main.py", line  
271, in take_action
    elif action == "backup": Backup(rps[0], rps[1])
  File "/sw/lib/python2.4/site-packages/rdiff_backup/Main.py", line  
334, in Backup
    backup.Mirror_and_increment(rpin, rpout, incdir)
  File "/sw/lib/python2.4/site-packages/rdiff_backup/backup.py",  
line 51, in Mirror_and_increment
    DestS.patch_and_increment(dest_rpath, source_diffiter, inc_rpath)
  File "/sw/lib/python2.4/site-packages/rdiff_backup/backup.py",  
line 229, in patch_and_increment
    ITR(diff.index, diff)
  File "/sw/lib/python2.4/site-packages/rdiff_backup/rorpiter.py",  
line 284, in __call__
    branch.start_process(*args)
  File "/sw/lib/python2.4/site-packages/rdiff_backup/backup.py",  
line 691, in start_process
    inc_prefix)
  File "/sw/lib/python2.4/site-packages/rdiff_backup/increment.py",  
line 41, in Increment
    elif mirror.isdir(): incrp = makedir(mirror, incpref)
  File "/sw/lib/python2.4/site-packages/rdiff_backup/increment.py",  
line 94, in makedir
    dirsign = get_inc(incpref, "dir")
  File "/sw/lib/python2.4/site-packages/rdiff_backup/increment.py",  
line 114, in get_inc
    assert not incrp.lstat(), incrp

Traceback (most recent call last):
  File "/sw/bin/rdiff-backup", line 23, in ?
    rdiff_backup.Main.error_check_Main(sys.argv[1:])
  File "/sw/lib/python2.4/site-packages/rdiff_backup/Main.py", line  
295, in error_check_Main
    try: Main(arglist)
  File "/sw/lib/python2.4/site-packages/rdiff_backup/Main.py", line  
315, in Main
    take_action(rps)
  File "/sw/lib/python2.4/site-packages/rdiff_backup/Main.py", line  
271, in take_action
    elif action == "backup": Backup(rps[0], rps[1])
  File "/sw/lib/python2.4/site-packages/rdiff_backup/Main.py", line  
334, in Backup
    backup.Mirror_and_increment(rpin, rpout, incdir)
  File "/sw/lib/python2.4/site-packages/rdiff_backup/backup.py",  
line 51, in Mirror_and_increment
    DestS.patch_and_increment(dest_rpath, source_diffiter, inc_rpath)
  File "/sw/lib/python2.4/site-packages/rdiff_backup/backup.py",  
line 229, in patch_and_increment
    ITR(diff.index, diff)
  File "/sw/lib/python2.4/site-packages/rdiff_backup/rorpiter.py",  
line 284, in __call__
    branch.start_process(*args)
  File "/sw/lib/python2.4/site-packages/rdiff_backup/backup.py",  
line 691, in start_process
    inc_prefix)
  File "/sw/lib/python2.4/site-packages/rdiff_backup/increment.py",  
line 41, in Increment
    elif mirror.isdir(): incrp = makedir(mirror, incpref)
  File "/sw/lib/python2.4/site-packages/rdiff_backup/increment.py",  
line 94, in makedir
    dirsign = get_inc(incpref, "dir")
  File "/sw/lib/python2.4/site-packages/rdiff_backup/increment.py",  
line 114, in get_inc
    assert not incrp.lstat(), incrp
AssertionError: Path: /Volumes/Maxtor_300/bu/iBook/rdiff-backup-data/ 
increments/Music/iTunes/iTunes Music/Molly Johnson/Another day. 
2006-03-26T08:00:43-05:00.dir
Index: ('Music', 'iTunes', 'iTunes Music', 'Molly Johnson', 'Another  
day.2006-03-26T08:00:43-05:00.dir')
Data: {'carbonfile': {'flags': 0, 'type': '\x00\x00\x00\x00',  
'location': (0, 0), 'creator': '\x00\x00\x00\x00'}, 'uid': 0,  
'perms': 493, 'type': 'reg', 'gname': 'unknown', 'ctime': 1143935080,  
'devloc': 234881041L, 'uname': 'root', 'nlink': 1, 'gid': 99,  
'mtime': 1080778719, 'resourcefork': '', 'atime': 1143935080,  
'inode': 1031905L, 'size': 0L}

Notes: 1. The file in question was added since the last backup.  I  
looked at the file in Terminal.app, and can't see anything obviously  
wrong, but I don't know what to look for either, as I don't  
understand the cryptic traceback.  The file plays fine in iTunes.

2. I used the following command line to run rdiff-backup:
sudo rdiff-backup -v5 --carbonfile --print-statistics --exclude- 
globbing-filelist /rdiff-backup_exclude_list /Volumes/tmh /Volumes/ 
Maxtor_300/bu/iBook

3. I bypassed the problem file by adding it to the --exclude-globbing- 
filelist, and the third attempt at a backup succeeded.


Kevin Horton
Ottawa, Canada