Minimize log file: get rid of ".d...p..... send"

Hans Troost hans.troost at gmail.com
Fri Sep 3 10:18:38 MDT 2010


Matt,

Took a while to get out that I didn't have strace, installed and learned it 
a bit.

!!! Even with strace I do not get a "chmod" call shown. !!!

I do not worry, since my problem is solved (thanks), but still am curious. 
Please don't spend time if this is not interesting for you and others as 
well. This is just to inform you!

Created a new folder "new-rsync-with-strace" ran my script again:

#!/bin/bash
RawDate=`date +%Y%m%d`
NiceDate=`date +%Y-%m-%d`
Now=`date +%H%M`
strace -o /home/hans/strace.log -s 80 rsync -axhhX --no-p --stats --delete 
--delete-excluded --backup --backup-dir-dels=$NiceDate/deleted --suffix-
dels=.$Now --backup-dir=$NiceDate/updated --suffix=.$Now --log-
file=/home/hans/rsync-files/rsync-log.$RawDate-$Now --exclude-
from=/home/hans/rsync-files/exclude.txt /home/hans/rsync-files/rsync-test 
/mnt/backup

folder listing (source):
drwxrwxr-x 2 hans hans 4096 2010-09-03 18:06 new-rsync-with-strace
(destination)
drwxrwxr-x 2 hans hans 4096 2010-09-03 18:06 new-rsync-with-strace

and got this output (search for : "new-rsync-with-strace"):

execve("/usr/bin/rsync", ["rsync", "-axhhX", "--no-p", "--stats", "--
delete", "--delete-excluded", "--backup", "--backup-dir-
dels=2010-09-03/deleted", "--suffix-dels=.1806", "--backup-
dir=2010-09-03/updated", "--suffix=.1806", "--log-file=/home/hans/rsync-
files/rsync-log.20100903-1806", "--exclude-from=/home/hans/rsync-
files/exclude.txt", "/home/hans/rsync-files/rsync-test", "/mnt/backup"], [/* 
76 vars */]) = 0
brk(0)                                  = 0x9a62000
mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 
0xb77fb000
access("/etc/ld.so.preload", R_OK)      = -1 ENOENT (No such file or 
directory)
open("/etc/ld.so.cache", O_RDONLY)      = 3
fstat64(3, {st_mode=S_IFREG|0644, st_size=122494, ...}) = 0
mmap2(NULL, 122494, PROT_READ, MAP_PRIVATE, 3, 0) = 0xb77dd000
close(3)                                = 0
open("/lib/libacl.so.1", O_RDONLY)      = 3
read(3, 
"\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\0\340\24\0\0004\0\0\0\0l\0\0\0\0\0\0004\0 
\0\5\0(\0\32\0\31\0\1\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\310h\0\0\310"..., 512) 
= 512
fstat64(3, {st_mode=S_IFREG|0644, st_size=28688, ...}) = 0
mmap2(NULL, 31556, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 
0xb77d5000
mmap2(0xb77dc000, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|
MAP_DENYWRITE, 3, 0x6) = 0xb77dc000
close(3)                                = 0
open("/usr/lib/libpopt.so.0", O_RDONLY) = 3
read(3, 
"\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\0`\22\0\0004\0\0\0\224l\0\0\0\0\0\0004\0 
\0\5\0(\0\31\0\30\0\1\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\314h\0\0\314"..., 512) 
= 512
fstat64(3, {st_mode=S_IFREG|0755, st_size=28796, ...}) = 0
mmap2(NULL, 31724, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 
0xb77cd000
mmap2(0xb77d4000, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|
MAP_DENYWRITE, 3, 0x6) = 0xb77d4000
close(3)                                = 0
open("/lib/i686/libc.so.6", O_RDONLY)   = 3
read(3, 
"\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\0\220k\1\0004\0\0\0\324\326\25\0\0\0\0\0004\0 
\0\n\0(\0D\0C\0\6\0\0\0004\0\0\0004\0\0\0004\0\0\0@\1\0\0@"..., 512) = 512
fstat64(3, {st_mode=S_IFREG|0644, st_size=1433972, ...}) = 0
mmap2(NULL, 1444104, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) 
= 0xb766c000
mprotect(0xb77c6000, 4096, PROT_NONE)   = 0
mmap2(0xb77c7000, 12288, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|
MAP_DENYWRITE, 3, 0x15a) = 0xb77c7000
mmap2(0xb77ca000, 10504, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|
MAP_ANONYMOUS, -1, 0) = 0xb77ca000
close(3)                                = 0
open("/lib/libattr.so.1", O_RDONLY)     = 3
read(3, 
"\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\0\20\16\0\0004\0\0\0\250=\0\0\0\0\0\0004\0 
\0\5\0(\0\32\0\31\0\1\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\20;\0\0\20"..., 512) = 
512
fstat64(3, {st_mode=S_IFREG|0644, st_size=16824, ...}) = 0
mmap2(NULL, 19676, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 
0xb7667000
mmap2(0xb766b000, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|
MAP_DENYWRITE, 3, 0x3) = 0xb766b000
close(3)                                = 0
mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 
0xb7666000
mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 
0xb7665000
set_thread_area({entry_number:-1 -> 6, base_addr:0xb76656c0, limit:1048575, 
seg_32bit:1, contents:0, read_exec_only:0, limit_in_pages:1, 
seg_not_present:0, useable:1}) = 0
mprotect(0xb77c7000, 8192, PROT_READ)   = 0
mprotect(0xb7818000, 4096, PROT_READ)   = 0
munmap(0xb77dd000, 122494)              = 0
rt_sigaction(SIGUSR1, {0x8063790, [], SA_NOCLDSTOP}, NULL, 8) = 0
rt_sigaction(SIGUSR2, {0x8064100, [], SA_NOCLDSTOP}, NULL, 8) = 0
rt_sigaction(SIGCHLD, {0x8064150, [], SA_NOCLDSTOP}, NULL, 8) = 0
time(NULL)                              = 1283530015
geteuid32()                             = 500
umask(0)                                = 02
brk(0)                                  = 0x9a62000
brk(0x9a83000)                          = 0x9a83000
open("/usr/share/locale/locale-archive", O_RDONLY|O_LARGEFILE) = -1 ENOENT 
(No such file or directory)
open("/usr/share/locale/locale.alias", O_RDONLY) = 3
fstat64(3, {st_mode=S_IFREG|0644, st_size=2570, ...}) = 0
mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 
0xb77fa000
read(3, "# Locale name alias data base.\n# Copyright (C) 
1996-2001,2003,2007 Free Software"..., 4096) = 2570
read(3, "", 4096)                       = 0
close(3)                                = 0
munmap(0xb77fa000, 4096)                = 0
open("/usr/share/locale/en_US.UTF-8/LC_CTYPE", O_RDONLY) = 3
fstat64(3, {st_mode=S_IFREG|0644, st_size=256316, ...}) = 0
mmap2(NULL, 256316, PROT_READ, MAP_PRIVATE, 3, 0) = 0xb7626000
close(3)                                = 0
open("/usr/lib/gconv/gconv-modules.cache", O_RDONLY) = 3
fstat64(3, {st_mode=S_IFREG|0644, st_size=26048, ...}) = 0
mmap2(NULL, 26048, PROT_READ, MAP_SHARED, 3, 0) = 0xb77f4000
close(3)                                = 0
open("/etc/popt", O_RDONLY|O_LARGEFILE) = -1 ENOENT (No such file or 
directory)
open("/home/hans/.popt", O_RDONLY|O_LARGEFILE) = -1 ENOENT (No such file or 
directory)
open("/home/hans/rsync-files/exclude.txt", O_RDONLY|O_LARGEFILE) = 3
fstat64(3, {st_mode=S_IFREG|0664, st_size=69, ...}) = 0
mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 
0xb77f3000
read(3, ".*\nDownloads\nMovies\nMusic\nPictures\nrsync-files/rsync-
log.*\ntmp\nVideos", 4096) = 69
read(3, "", 4096)                       = 0
close(3)                                = 0
munmap(0xb77f3000, 4096)                = 0
time(NULL)                              = 1283530015
open("/etc/localtime", O_RDONLY)        = 3
fstat64(3, {st_mode=S_IFREG|0644, st_size=2917, ...}) = 0
fstat64(3, {st_mode=S_IFREG|0644, st_size=2917, ...}) = 0
mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 
0xb77f3000
read(3, 
"TZif2\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\r\0\0\0\r\0\0\0\0\0\0\0\264\0\0\0\r\0\0\0\32\233\f.
\354\233\325\326\\\234\331\270\f\235\244\277\f\236\247%\f"..., 4096) = 2917
_llseek(3, -28, [2889], SEEK_CUR)       = 0
read(3, "\nCET-1CEST,M3.5.0,M10.5.0/3\n", 4096) = 28
close(3)                                = 0
munmap(0xb77f3000, 4096)                = 0
umask(022)                              = 0
open("/home/hans/rsync-files/rsync-log.20100903-1806", O_WRONLY|O_APPEND|
O_CREAT|O_LARGEFILE, 0666) = 3
fstat64(3, {st_mode=S_IFREG|0644, st_size=0, ...}) = 0
mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 
0xb77f3000
fstat64(3, {st_mode=S_IFREG|0644, st_size=0, ...}) = 0
_llseek(3, 0, [0], SEEK_SET)            = 0
umask(0)                                = 022
rt_sigaction(SIGINT, {0x80526e0, [], SA_NOCLDSTOP}, NULL, 8) = 0
rt_sigaction(SIGHUP, {0x80526e0, [], SA_NOCLDSTOP}, NULL, 8) = 0
rt_sigaction(SIGTERM, {0x80526e0, [], SA_NOCLDSTOP}, NULL, 8) = 0
rt_sigprocmask(SIG_UNBLOCK, [HUP INT USR1 USR2 TERM CHLD], NULL, 8) = 0
rt_sigaction(SIGPIPE, {SIG_IGN}, NULL, 8) = 0
rt_sigaction(SIGXFSZ, {SIG_IGN}, NULL, 8) = 0
getcwd("/home/hans/Documents", 4095)    = 21
socketpair(PF_FILE, SOCK_STREAM, 0, [4, 5]) = 0
fcntl64(4, F_GETFL)                     = 0x2 (flags O_RDWR)
fcntl64(4, F_SETFL, O_RDWR|O_NONBLOCK)  = 0
fcntl64(5, F_GETFL)                     = 0x2 (flags O_RDWR)
fcntl64(5, F_SETFL, O_RDWR|O_NONBLOCK)  = 0
socketpair(PF_FILE, SOCK_STREAM, 0, [6, 7]) = 0
fcntl64(6, F_GETFL)                     = 0x2 (flags O_RDWR)
fcntl64(6, F_SETFL, O_RDWR|O_NONBLOCK)  = 0
fcntl64(7, F_GETFL)                     = 0x2 (flags O_RDWR)
fcntl64(7, F_SETFL, O_RDWR|O_NONBLOCK)  = 0
clone(child_stack=0, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD, 
child_tidptr=0xb7665728) = 3902
close(7)                                = 0
close(4)                                = 0
fcntl64(6, F_GETFL)                     = 0x802 (flags O_RDWR|O_NONBLOCK)
fcntl64(5, F_GETFL)                     = 0x802 (flags O_RDWR|O_NONBLOCK)
select(6, NULL, [5], [5], {60, 0})      = 1 (out [5], left {59, 999995})
write(5, "\36\0\0\0", 4)                = 4
select(7, [6], [], NULL, {60, 0})       = 1 (in [6], left {59, 999995})
read(6, "\36\0\0\0", 4)                 = 4
select(7, [6], [], NULL, {60, 0})       = 1 (in [6], left {59, 999996})
read(6, "\r", 1)                        = 1
select(7, [6], [], NULL, {60, 0})       = 1 (in [6], left {59, 999996})
read(6, "\37\35\201L", 4)               = 4
fcntl64(2, F_GETFL)                     = 0x8001 (flags O_WRONLY|
O_LARGEFILE)
getpid()                                = 3901
time(NULL)                              = 1283530015
stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2917, ...}) = 0
write(3, "2010/09/03 18:06:55 [3901] building file list\n", 46) = 46
gettimeofday({1283530015, 591644}, NULL) = 0
chdir("/home/hans/rsync-files")         = 0
lstat64("rsync-test", {st_mode=S_IFDIR|0775, st_size=4096, ...}) = 0
mmap2(NULL, 135168, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) 
= 0xb7605000
llistxattr("rsync-test", 0x9a6cea0, 1024) = 0
socket(PF_FILE, 0x80801 /* SOCK_??? */, 0) = 4
connect(4, {sa_family=AF_FILE, path="/var/run/nscd/socket"}, 110) = -1 
ENOENT (No such file or directory)
close(4)                                = 0
socket(PF_FILE, 0x80801 /* SOCK_??? */, 0) = 4
connect(4, {sa_family=AF_FILE, path="/var/run/nscd/socket"}, 110) = -1 
ENOENT (No such file or directory)
close(4)                                = 0
open("/etc/nsswitch.conf", O_RDONLY)    = 4
fstat64(4, {st_mode=S_IFREG|0644, st_size=1290, ...}) = 0
mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 
0xb7604000
read(4, "#\n# /etc/nsswitch.conf\n#\n# An example Name Service Switch config 
file. This file"..., 4096) = 1290
read(4, "", 4096)                       = 0
close(4)                                = 0
munmap(0xb7604000, 4096)                = 0
open("/etc/ld.so.cache", O_RDONLY)      = 4
fstat64(4, {st_mode=S_IFREG|0644, st_size=122494, ...}) = 0
mmap2(NULL, 122494, PROT_READ, MAP_PRIVATE, 4, 0) = 0xb75e7000
close(4)                                = 0
open("/lib/libnss_files.so.2", O_RDONLY) = 4
read(4, 
"\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\0\340\31\0\0004\0\0\0\304\261\0\0\0\0\0\0004\0 
\0\t\0(\0\35\0\34\0\6\0\0\0004\0\0\0004\0\0\0004\0\0\0 \1"..., 512) = 512
fstat64(4, {st_mode=S_IFREG|0755, st_size=46668, ...}) = 0
mmap2(NULL, 49864, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 4, 0) = 
0xb75da000
mmap2(0xb75e5000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|
MAP_DENYWRITE, 4, 0xa) = 0xb75e5000
close(4)                                = 0
mprotect(0xb75e5000, 4096, PROT_READ)   = 0
munmap(0xb75e7000, 122494)              = 0
open("/etc/passwd", O_RDONLY|0x80000)   = 4
fcntl64(4, F_GETFD)                     = 0x1 (flags FD_CLOEXEC)
fstat64(4, {st_mode=S_IFREG|0644, st_size=1957, ...}) = 0
mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 
0xb7604000
read(4, 
"root:x:0:0:root:/root:/bin/bash\nbin:x:1:1:bin:/bin:/bin/sh\ndaemon:x:2:2:daemon:/"..., 
4096) = 1957
close(4)                                = 0
munmap(0xb7604000, 4096)                = 0
socket(PF_FILE, 0x80801 /* SOCK_??? */, 0) = 4
connect(4, {sa_family=AF_FILE, path="/var/run/nscd/socket"}, 110) = -1 
ENOENT (No such file or directory)
close(4)                                = 0
socket(PF_FILE, 0x80801 /* SOCK_??? */, 0) = 4
connect(4, {sa_family=AF_FILE, path="/var/run/nscd/socket"}, 110) = -1 
ENOENT (No such file or directory)
close(4)                                = 0
open("/etc/group", O_RDONLY|0x80000)    = 4
fstat64(4, {st_mode=S_IFREG|0644, st_size=917, ...}) = 0
mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 
0xb7604000
read(4, "root:x:0:\nbin:x:1:\ndaemon:x:2:\nsys:x:3:\nadm:x:4:\ntty:x:5:
\ndisk:x:6:\nlp:x:7:mysql"..., 4096) = 917
close(4)                                = 0
munmap(0xb7604000, 4096)                = 0
mmap2(NULL, 135168, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) 
= 0xb75b9000
gettimeofday({1283530015, 601913}, NULL) = 0
gettimeofday({1283530015, 602060}, NULL) = 0
mmap2(NULL, 135168, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) 
= 0xb7598000
lstat64("rsync-test", {st_mode=S_IFDIR|0775, st_size=4096, ...}) = 0
open("rsync-test", O_RDONLY|O_NONBLOCK|O_LARGEFILE|O_DIRECTORY|0x80000) = 4
fcntl64(4, F_GETFD)                     = 0x1 (flags FD_CLOEXEC)
getdents64(4, /* 7 entries */, 32768)   = 224
lstat64("rsync-test/2bchanged", {st_mode=S_IFDIR|0775, st_size=4096, ...}) 
= 0
llistxattr("rsync-test/2bchanged", 0x9a6cea0, 1024) = 0
mmap2(NULL, 135168, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) 
= 0xb7577000
lstat64("rsync-test/unchanged", {st_mode=S_IFDIR|0775, st_size=4096, ...}) 
= 0
llistxattr("rsync-test/unchanged", 0x9a6cea0, 1024) = 0
lstat64("rsync-test/test.sh", {st_mode=S_IFREG|0775, st_size=507, ...}) = 0
mmap2(NULL, 266240, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) 
= 0xb7536000
llistxattr("rsync-test/test.sh", 0x9a6cea0, 1024) = 0
lstat64("rsync-test/new-rsync-with-strace", {st_mode=S_IFDIR|0775, 
st_size=4096, ...}) = 0
llistxattr("rsync-test/new-rsync-with-strace", 0x9a6cea0, 1024) = 0
lstat64("rsync-test/test.sh~", {st_mode=S_IFREG|0775, st_size=510, ...}) = 
0
llistxattr("rsync-test/test.sh~", 0x9a6cea0, 1024) = 0
getdents64(4, /* 0 entries */, 32768)   = 0
close(4)                                = 0
select(6, NULL, [5], [5], {60, 0})      = 1 (out [5], left {59, 999994})
write(5, "\246\0\0\7\5\f\nrsync-
test\0\0\20L\32\35\201\375A\0\0\201\364\4hans\201\364\4hans\0\0\0\377d:
\n\n/2bchanged\0\0\20L\313\317\177\1:\v\tunchanged"..., 170) = 170
lstat64("rsync-test/2bchanged", {st_mode=S_IFDIR|0775, st_size=4096, ...}) 
= 0
open("rsync-test/2bchanged", O_RDONLY|O_NONBLOCK|O_LARGEFILE|O_DIRECTORY|
0x80000) = 4
getdents64(4, /* 6 entries */, 32768)   = 200
lstat64("rsync-test/2bchanged/2bedited.txt", {st_mode=S_IFREG|0664, 
st_size=23, ...}) = 0
llistxattr("rsync-test/2bchanged/2bedited.txt", 0x9a6cea0, 1024) = 0
mmap2(NULL, 135168, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) 
= 0xb7515000
lstat64("rsync-test/2bchanged/2bdeleted.txt", {st_mode=S_IFREG|0664, 
st_size=38, ...}) = 0
llistxattr("rsync-test/2bchanged/2bdeleted.txt", 0x9a6cea0, 1024) = 0
lstat64("rsync-test/2bchanged/2bedited.txt~", {st_mode=S_IFREG|0664, 
st_size=2, ...}) = 0
llistxattr("rsync-test/2bchanged/2bedited.txt~", 0x9a6cea0, 1024) = 0
lstat64("rsync-test/2bchanged/2bdeleted.txt~", {st_mode=S_IFREG|0664, 
st_size=2, ...}) = 0
llistxattr("rsync-test/2bchanged/2bdeleted.txt~", 0x9a6cea0, 1024) = 0
getdents64(4, /* 0 entries */, 32768)   = 0
close(4)                                = 0
lstat64("rsync-test/new-rsync-with-strace", {st_mode=S_IFDIR|0775, 
st_size=4096, ...}) = 0
open("rsync-test/new-rsync-with-strace", O_RDONLY|O_NONBLOCK|O_LARGEFILE|
O_DIRECTORY|0x80000) = 4
getdents64(4, /* 2 entries */, 32768)   = 48
getdents64(4, /* 0 entries */, 32768)   = 0
close(4)                                = 0
lstat64("rsync-test/unchanged", {st_mode=S_IFDIR|0775, st_size=4096, ...}) 
= 0
open("rsync-test/unchanged", O_RDONLY|O_NONBLOCK|O_LARGEFILE|O_DIRECTORY|
0x80000) = 4
getdents64(4, /* 4 entries */, 32768)   = 128
lstat64("rsync-test/unchanged/Permanent2.txt", {st_mode=S_IFREG|0664, 
st_size=45, ...}) = 0
llistxattr("rsync-test/unchanged/Permanent2.txt", 0x9a6cea0, 1024) = 0
mmap2(NULL, 135168, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) 
= 0xb74f4000
lstat64("rsync-test/unchanged/Permanent1.txt", {st_mode=S_IFREG|0664, 
st_size=45, ...}) = 0
llistxattr("rsync-test/unchanged/Permanent1.txt", 0x9a6cea0, 1024) = 0
getdents64(4, /* 0 entries */, 32768)   = 0
close(4)                                = 0
select(6, NULL, [5], [5], {60, 0})      = 1 (out [5], left {59, 999995})
write(5, 
"\246\0\0\7\377\0018\v\0262bchanged/2bedited.txt\0\27\0L\237\317\177\264\201\0\0\1:
\27\vdeleted.txt\0&\0L\313\317\177\1:\27\vedited.txt~\0"..., 170) = 170
select(7, [6], [], NULL, {60, 0})       = 1 (in [6], left {59, 969097})
read(6, "\4\0\0\7", 4)                  = 4
select(7, [6], [], NULL, {60, 0})       = 1 (in [6], left {59, 999995})
read(6, "\3\10\0\0", 4)                 = 4
time(NULL)                              = 1283530015
stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2917, ...}) = 0
write(3, "2010/09/03 18:06:55 [3901] .d..t...... rsync-test/\n", 51) = 51
select(6, NULL, [5], [5], {60, 0})      = 1 (out [5], left {59, 999994})
write(5, "\3\0\0\7\3\10\0", 7)          = 7
munmap(0xb75b9000, 135168)              = 0
select(6, NULL, [5], [5], {60, 0})      = 1 (out [5], left {59, 999995})
write(5, "\1\0\0\7\0", 5)               = 5
select(7, [6], [], NULL, {60, 0})       = 1 (in [6], left {59, 958683})
read(6, "\1\0\0\7", 4)                  = 4
select(7, [6], [], NULL, {60, 0})       = 1 (in [6], left {59, 999996})
read(6, "\0", 1)                        = 1
munmap(0xb7577000, 135168)              = 0
select(6, NULL, [5], [5], {60, 0})      = 1 (out [5], left {59, 999996})
write(5, "\1\0\0\7\0", 5)               = 5
select(7, [6], [], NULL, {60, 0})       = 1 (in [6], left {59, 987574})
read(6, "\4\0\0\7", 4)                  = 4
select(7, [6], [], NULL, {60, 0})       = 1 (in [6], left {59, 999996})
read(6, "\v\0`\0", 4)                   = 4
time(NULL)                              = 1283530015
stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2917, ...}) = 0
write(3, "2010/09/03 18:06:55 [3901] cd+++++++++ rsync-test/new-rsync-with-
strace/\n", 73) = 73
select(6, NULL, [5], [5], {60, 0})      = 1 (out [5], left {59, 999995})
write(5, "\3\0\0\7\v\0`", 7)            = 7
munmap(0xb7515000, 135168)              = 0
select(6, NULL, [5], [5], {60, 0})      = 1 (out [5], left {59, 999995})
write(5, "\1\0\0\7\0", 5)               = 5
select(7, [6], [], NULL, {60, 0})       = 1 (in [6], left {59, 991051})
read(6, "\1\0\0\7", 4)                  = 4
select(7, [6], [], NULL, {60, 0})       = 1 (in [6], left {59, 999995})
read(6, "\0", 1)                        = 1
select(6, NULL, [5], [5], {60, 0})      = 1 (out [5], left {59, 999996})
write(5, "\1\0\0\7\0", 5)               = 5
select(7, [6], [], NULL, {60, 0})       = 1 (in [6], left {59, 998826})
read(6, "\1\0\0\7", 4)                  = 4
select(7, [6], [], NULL, {60, 0})       = 1 (in [6], left {59, 999996})
read(6, "\0", 1)                        = 1
munmap(0xb7536000, 266240)              = 0
munmap(0xb74f4000, 135168)              = 0
select(6, NULL, [5], [5], {60, 0})      = 1 (out [5], left {59, 999995})
write(5, "\1\0\0\7\0", 5)               = 5
select(7, [6], [], NULL, {60, 0})       = 1 (in [6], left {59, 999996})
read(6, "\2\0\0\7", 4)                  = 4
select(7, [6], [], NULL, {60, 0})       = 1 (in [6], left {59, 999996})
read(6, "\0\0", 2)                      = 2
select(6, NULL, [5], [5], {60, 0})      = 1 (out [5], left {59, 999996})
write(5, "\1\0\0\7\0", 5)               = 5
select(6, NULL, [5], [5], {60, 0})      = 1 (out [5], left {59, 999996})
write(5, "\1\0\0\7\0", 5)               = 5
time(NULL)                              = 1283530015
select(7, [6], [], NULL, {60, 0})       = 1 (in [6], left {59, 999996})
read(6, "\1\0\0\7", 4)                  = 4
select(7, [6], [], NULL, {60, 0})       = 1 (in [6], left {59, 999996})
read(6, "\0", 1)                        = 1
waitpid(3902, 0xbfaa6e2c, WNOHANG)      = 0
gettimeofday({1283530015, 718700}, NULL) = 0
select(0, NULL, NULL, NULL, {0, 20000}) = ? ERESTARTNOHAND (To be 
restarted)
--- SIGCHLD (Child exited) @ 0 (0) ---
waitpid(-1, [{WIFEXITED(s) && WEXITSTATUS(s) == 0}], WNOHANG) = 3902
waitpid(-1, 0xbfaa6a8c, WNOHANG)        = -1 ECHILD (No child processes)
sigreturn()                             = ? (mask now [])
gettimeofday({1283530015, 739244}, NULL) = 0
waitpid(3902, 0xbfaa6e2c, WNOHANG)      = -1 ECHILD (No child processes)
fstat64(1, {st_mode=S_IFREG|0600, st_size=18226, ...}) = 0
mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 
0xb75d9000
write(1, "\n", 1)                       = 1
time(NULL)                              = 1283530015
stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2917, ...}) = 0
write(3, "2010/09/03 18:06:55 [3901] Number of files: 12\n", 47) = 47
write(1, "Number of files: 12\n", 20)   = 20
time(NULL)                              = 1283530015
stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2917, ...}) = 0
write(3, "2010/09/03 18:06:55 [3901] Number of files transferred: 0\n", 58) 
= 58
write(1, "Number of files transferred: 0\n", 31) = 31
time(NULL)                              = 1283530015
stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2917, ...}) = 0
write(3, "2010/09/03 18:06:55 [3901] Total file size: 1.14K bytes\n", 56) = 
56
write(1, "Total file size: 1.14K bytes\n", 29) = 29
time(NULL)                              = 1283530015
stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2917, ...}) = 0
write(3, "2010/09/03 18:06:55 [3901] Total transferred file size: 0 
bytes\n", 64) = 64
write(1, "Total transferred file size: 0 bytes\n", 37) = 37
time(NULL)                              = 1283530015
stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2917, ...}) = 0
write(3, "2010/09/03 18:06:55 [3901] Literal data: 0 bytes\n", 49) = 49
write(1, "Literal data: 0 bytes\n", 22) = 22
time(NULL)                              = 1283530015
stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2917, ...}) = 0
write(3, "2010/09/03 18:06:55 [3901] Matched data: 0 bytes\n", 49) = 49
write(1, "Matched data: 0 bytes\n", 22) = 22
time(NULL)                              = 1283530015
stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2917, ...}) = 0
write(3, "2010/09/03 18:06:55 [3901] File list size: 326\n", 47) = 47
write(1, "File list size: 326\n", 20)   = 20
time(NULL)                              = 1283530015
stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2917, ...}) = 0
write(3, "2010/09/03 18:06:55 [3901] File list generation time: 0.010 
seconds\n", 68) = 68
write(1, "File list generation time: 0.010 seconds\n", 41) = 41
time(NULL)                              = 1283530015
stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2917, ...}) = 0
write(3, "2010/09/03 18:06:55 [3901] File list transfer time: 0.000 
seconds\n", 66) = 66
write(1, "File list transfer time: 0.000 seconds\n", 39) = 39
time(NULL)                              = 1283530015
stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2917, ...}) = 0
write(3, "2010/09/03 18:06:55 [3901] Total bytes sent: 349\n", 49) = 49
write(1, "Total bytes sent: 349\n", 22) = 22
time(NULL)                              = 1283530015
stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2917, ...}) = 0
write(3, "2010/09/03 18:06:55 [3901] Total bytes received: 22\n", 52) = 52
write(1, "Total bytes received: 22\n", 25) = 25
write(1, "\n", 1)                       = 1
time(NULL)                              = 1283530015
stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2917, ...}) = 0
write(3, "2010/09/03 18:06:55 [3901] sent 349 bytes  received 22 bytes  
742.00 bytes/sec\n", 79) = 79
write(1, "sent 349 bytes  received 22 bytes  742.00 bytes/sec\n", 52) = 52
time(NULL)                              = 1283530015
stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2917, ...}) = 0
write(3, "2010/09/03 18:06:55 [3901] total size is 1.14K  speedup is 
3.16\n", 64) = 64
write(1, "total size is 1.14K  speedup is 3.16\n", 37) = 37
rt_sigaction(SIGUSR1, {SIG_IGN}, NULL, 8) = 0
rt_sigaction(SIGUSR2, {SIG_IGN}, NULL, 8) = 0
waitpid(3902, 0xbfaa6e2c, WNOHANG)      = -1 ECHILD (No child processes)
time(NULL)                              = 1283530015
stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2917, ...}) = 0
write(3, "2010/09/03 18:06:55 [3901] sent 349 bytes  received 23 bytes  
total size 1172\n", 78) = 78
exit_group(0)                           = ?

Regards

Hans Troost


More information about the rsync mailing list