osx 10.6 strange rsync errors

Robert DuToit rdutoit at comcast.net
Mon Apr 5 20:19:17 MDT 2010 

Hi Matt,

I set up a simple test with a nest of directories ( aa > bb > cc > dd &ee) with 1 file in each.
running rsync from OS 10.6 to another Mac with OS10.5 there seems to be no problem. When doing the reverse I am seeing the odd behavior.

Below is the log from running the options

-aHAXN --fileflags --force-change -stats -vvv  

note that the lines 

"rsync: mkstemp "/Volumes/xxx/testaaa/aa/..DS_Store.gnG29l" failed: No such file or directory (2)" 

are correct in that there are no such files but why does it think there are? They don't exist on source or dest. They do however get created on the destination. It seems in my test that there is one created for every directory. However, the original .DS_Store files are not copied over just the new ones with the odd extra dot prefix and the cryptic extension on the end. The new odd .DS_Store files take the place of the normal ones that should be created by the finder.

I don't know if this sheds any light at all on this. Others have reported that these files get created by the thousands on the destination. Not only .DS_Store files but other hidden files.

Rob




sending incremental file list
[sender] make_file(aa,*,2)
send_file_list done
[sender] make_file(aa/.DS_Store,*,2)
[sender] make_file(aa/bb,*,2)
[sender] make_file(aa/zwhite.icns,*,2)
send_files starting
[sender] make_file(aa/bb/.DS_Store,*,2)
[sender] make_file(aa/bb/cc,*,2)
[sender] make_file(aa/bb/excludes.txt,*,2)
[sender] make_file(aa/bb/cc/.DS_Store,*,2)
[sender] make_file(aa/bb/cc/dd,*,2)
[sender] make_file(aa/bb/cc/ee,*,2)
[sender] make_file(aa/bb/cc/size.txt,*,2)
[sender] make_file(aa/bb/cc/dd/.DS_Store,*,2)
[sender] make_file(aa/bb/cc/dd/splittersize.h,*,2)
server_recv(2) starting pid=939
recv_file_name(aa)
received 1 names
recv_file_list done
recv_file_name(aa/.DS_Store)
recv_file_name(aa/bb)
recv_file_name(aa/zwhite.icns)
received 3 names
recv_file_list done
get_local_name count=4 /Volumes/xxx/testaaa/
generator starting pid=939
delta-transmission disabled for local transfer or --whole-file
recv_files(1) starting
recv_file_name(aa/bb/.DS_Store)
recv_file_name(aa/bb/cc)
recv_file_name(aa/bb/excludes.txt)
received 3 names
recv_file_list done
recv_file_name(aa/bb/cc/.DS_Store)
recv_file_name(aa/bb/cc/dd)
recv_file_name(aa/bb/cc/ee)
recv_file_name(aa/bb/cc/size.txt)
received 4 names
recv_file_list done
recv_file_name(aa/bb/cc/dd/.DS_Store)
recv_file_name(aa/bb/cc/dd/splittersize.h)
received 2 names
recv_file_list done
received 0 names
recv_file_list done
recv_generator(aa,1)
recv_generator(aa,2)
send_files(2, /Users/astrid/Desktop/aa)
aa/
set modtime of aa to (1270518365) Mon Apr  5 21:46:05 2010
recv_generator(aa/.DS_Store,3)
recv_files(aa)
send_files(3, /Users/astrid/Desktop/aa/.DS_Store)
send_files mapped /Users/astrid/Desktop/aa/.DS_Store of size 6148
calling match_sums /Users/astrid/Desktop/aa/.DS_Store
aa/.DS_Store
        6148 100%    0.00kB/s    0:00:00
sending file_sum
false_alarms=0 hash_hits=0 matches=0
        6148 100%    0.00kB/s    0:00:00 (xfer#1, to-check=11/13)
sender finished /Users/astrid/Desktop/aa/.DS_Store
recv_generator(aa/zwhite.icns,4)
send_files(4, /Users/astrid/Desktop/aa/zwhite.icns)
send_files mapped /Users/astrid/Desktop/aa/zwhite.icns of size 54611
calling match_sums /Users/astrid/Desktop/aa/zwhite.icns
aa/zwhite.icns
       32768  60%  820.51kB/s    0:00:00
sending file_sum
false_alarms=0 hash_hits=0 matches=0
       54611 100%    1.21MB/s    0:00:00 (xfer#2, to-check=10/13)
sender finished /Users/astrid/Desktop/aa/zwhite.icns
recv_generator(aa/bb,5)
recv_generator(aa/bb,6)
recv_files(aa/.DS_Store)
send_files(6, /Users/astrid/Desktop/aa/bb)
aa/bb/
set modtime of aa/bb to (1270518373) Mon Apr  5 21:46:13 2010
recv_generator(aa/bb/.DS_Store,7)
rsync: mkstemp "/Volumes/xxx/testaaa/aa/..DS_Store.gnG29l" failed: No such file or directory (2)     
send_files(7, /Users/astrid/Desktop/aa/bb/.DS_Store)
send_files mapped /Users/astrid/Desktop/aa/bb/.DS_Store of size 6148
calling match_sums /Users/astrid/Desktop/aa/bb/.DS_Store
aa/bb/.DS_Store
        6148 100%  103.52kB/s    0:00:00
sending file_sum
false_alarms=0 hash_hits=0 matches=0
        6148 100%  101.76kB/s    0:00:00 (xfer#3, to-check=8/13)
sender finished /Users/astrid/Desktop/aa/bb/.DS_Store
recv_generator(aa/bb/excludes.txt,8)
send_files(8, /Users/astrid/Desktop/aa/bb/excludes.txt)
send_files mapped /Users/astrid/Desktop/aa/bb/excludes.txt of size 285
calling match_sums /Users/astrid/Desktop/aa/bb/excludes.txt
aa/bb/excludes.txt
         285 100%    4.42kB/s    0:00:00
sending file_sum
false_alarms=0 hash_hits=0 matches=0
         285 100%    4.35kB/s    0:00:00 (xfer#4, to-check=7/13)
sender finished /Users/astrid/Desktop/aa/bb/excludes.txt
got file_sum
recv_generator(aa/bb/cc,9)
recv_generator(aa/bb/cc,10)
send_files(10, /Users/astrid/Desktop/aa/bb/cc)
aa/bb/cc/
recv_files(aa/zwhite.icns)
set modtime of aa/bb/cc to (1270518390) Mon Apr  5 21:46:30 2010
recv_generator(aa/bb/cc/.DS_Store,11)
send_files(11, /Users/astrid/Desktop/aa/bb/cc/.DS_Store)
send_files mapped /Users/astrid/Desktop/aa/bb/cc/.DS_Store of size 6148
calling match_sums /Users/astrid/Desktop/aa/bb/cc/.DS_Store
aa/bb/cc/.DS_Store
        6148 100%   87.01kB/s    0:00:00
sending file_sum
false_alarms=0 hash_hits=0 matches=0
        6148 100%   85.77kB/s    0:00:00 (xfer#5, to-check=5/13)
sender finished /Users/astrid/Desktop/aa/bb/cc/.DS_Store
recv_generator(aa/bb/cc/size.txt,12)
send_files(12, /Users/astrid/Desktop/aa/bb/cc/size.txt)
send_files mapped /Users/astrid/Desktop/aa/bb/cc/size.txt of size 0
calling match_sums /Users/astrid/Desktop/aa/bb/cc/size.txt
aa/bb/cc/size.txt
sending file_sum
false_alarms=0 hash_hits=0 matches=0
           0 100%    0.00kB/s    0:00:00 (xfer#6, to-check=4/13)
sender finished /Users/astrid/Desktop/aa/bb/cc/size.txt
recv_generator(aa/bb/cc/dd,13)
recv_generator(aa/bb/cc/ee,14)
recv_generator(aa/bb/cc/dd,15)
send_files(15, /Users/astrid/Desktop/aa/bb/cc/dd)
aa/bb/cc/dd/
set modtime of aa/bb/cc/dd to (1270518407) Mon Apr  5 21:46:47 2010
recv_generator(aa/bb/cc/dd/.DS_Store,16)
send_files(16, /Users/astrid/Desktop/aa/bb/cc/dd/.DS_Store)
send_files mapped /Users/astrid/Desktop/aa/bb/cc/dd/.DS_Store of size 6148
calling match_sums /Users/astrid/Desktop/aa/bb/cc/dd/.DS_Store
aa/bb/cc/dd/.DS_Store
        6148 100%   30.32kB/s    0:00:00
sending file_sum
false_alarms=0 hash_hits=0 matches=0
        6148 100%   30.32kB/s    0:00:00 (xfer#7, to-check=1/13)
sender finished /Users/astrid/Desktop/aa/bb/cc/dd/.DS_Store
recv_generator(aa/bb/cc/dd/splittersize.h,17)
send_files(17, /Users/astrid/Desktop/aa/bb/cc/dd/splittersize.h)
send_files mapped /Users/astrid/Desktop/aa/bb/cc/dd/splittersize.h of size 216
calling match_sums /Users/astrid/Desktop/aa/bb/cc/dd/splittersize.h
aa/bb/cc/dd/splittersize.h
         216 100%    1.06kB/s    0:00:00
sending file_sum
false_alarms=0 hash_hits=0 matches=0
         216 100%    1.06kB/s    0:00:00 (xfer#8, to-check=0/13)
sender finished /Users/astrid/Desktop/aa/bb/cc/dd/splittersize.h
recv_generator(aa/bb/cc/ee,18)
send_files(18, /Users/astrid/Desktop/aa/bb/cc/ee)
aa/bb/cc/ee/
set modtime of aa/bb/cc/ee to (1270518387) Mon Apr  5 21:46:27 2010
generate_files phase=1
got file_sum
set modtime of aa/.zwhite.icns.YHRl4r to (1237675238) Sat Mar 21 18:40:38 2009
renaming aa/.zwhite.icns.YHRl4r to aa/zwhite.icns
set modtime of aa to (1270518365) Mon Apr  5 21:46:05 2010
recv_files(aa/bb)
recv_files(aa/bb/.DS_Store)
rsync: mkstemp "/Volumes/xxx/testaaa/aa/bb/..DS_Store.YrLgmu" failed: No such file or directory (2)
got file_sum
recv_files(aa/bb/excludes.txt)
got file_sum
set modtime of aa/bb/.excludes.txt.4OMBT1 to (1234705660) Sun Feb 15 08:47:40 2009
renaming aa/bb/.excludes.txt.4OMBT1 to aa/bb/excludes.txt
set modtime of aa/bb to (1270518373) Mon Apr  5 21:46:13 2010
recv_files(aa/bb/cc)
recv_files(aa/bb/cc/.DS_Store)
rsync: mkstemp "/Volumes/xxx/testaaa/aa/bb/cc/..DS_Store.s36jF0" failed: No such file or directory (2)
got file_sum
recv_files(aa/bb/cc/size.txt)
got file_sum
set modtime of aa/bb/cc/.size.txt.QvNbNt to (1147355897) Thu May 11 09:58:17 2006
renaming aa/bb/cc/.size.txt.QvNbNt to aa/bb/cc/size.txt
set modtime of aa/bb/cc to (1270518390) Mon Apr  5 21:46:30 2010
recv_files(aa/bb/cc/dd)
recv_files(aa/bb/cc/dd/.DS_Store)
rsync: mkstemp "/Volumes/xxx/testaaa/aa/bb/cc/dd/..DS_Store.jHTMCW" failed: No such file or directory (2)
got file_sum
recv_files(aa/bb/cc/dd/splittersize.h)
got file_sum
set modtime of aa/bb/cc/dd/.splittersize.h.hVRihb to (1236212797) Wed Mar  4 19:26:37 2009
renaming aa/bb/cc/dd/.splittersize.h.hVRihb to aa/bb/cc/dd/splittersize.h
set modtime of aa/bb/cc/dd to (1270518407) Mon Apr  5 21:46:47 2010
send_files phase=1
recv_files(aa/bb/cc/ee)
recv_files phase=1
generate_files phase=2
send_files phase=2
send files finished
total: matches=0  hash_hits=0  false_alarms=0 data=79704
recv_files phase=2
generate_files phase=3
recv_files finished
generate_files finished

More information about the rsync mailing list