BackupPC-users

[BackupPC-users] All incr fail(SIGPIPE) all full complete - cygwin/W7

2015-05-13 16:32:35
Subject: [BackupPC-users] All incr fail(SIGPIPE) all full complete - cygwin/W7
From: fred AT damen DOT org
To: backuppc-users AT lists.sourceforge DOT net
Date: Wed, 13 May 2015 15:15:00 -0500
Greetings,

I have BackupPC (server) setup on a linux computer with many Windows 7
computers (clients) setup with cygwin/rsyncd.  All the full backups seem to
complete, yet all the inrc backups fail with signal=PIPE.  This leads me to
two questions, why would rsync fail in the incr mode and how to find out why
rsync failed?

Let me explain the second question first.  I have rsync setup on the W7
computers as a windows service and the 'log file' entry pointing to a file in
a directory in the cygwin path. With the log file non-existing and then
starting the rsync as a service an empty log file is created.  After that
nothing.  Even if I create the log file manually, still nothing logged. 
Nothing is logged when BackupPc performs an rsyncd connection.  I have tried
adding setting that should be creating something in the log, but nothing. 
What is required to get rsync to write debugging information into the log
file.  missing libraries???

If a debugging guide for this configuration exists I would love to read it, 
short of that here is what I have for the last incr failure.  Note that I
started a full backup in an attempt to debug, BackupPC appears to have run
another incr backup subsequent to this. Shouldn't this be an extremely small
transaction, as not much should have changed.

Log File ---------------------------------
2015-05-11 22:00:01 full backup started for directory cDrive (baseline backup
#10)
2015-05-11 23:27:00 full backup 11 complete, 465979 files, 76932620859 bytes,
214 xferErrs (0 bad files, 0 bad shares, 214 other)
2015-05-12 22:00:01 incr backup started back to 2015-05-11 22:00:01 (backup
#11) for directory cDrive
2015-05-12 22:33:58 Aborting backup up after signal PIPE
2015-05-12 22:34:00 Got fatal error during xfer (aborted by signal=PIPE)
2015-05-12 23:00:01 incr backup started back to 2015-05-11 22:00:01 (backup
#11) for directory cDrive
2015-05-12 23:33:05 Aborting backup up after signal PIPE
2015-05-12 23:33:06 Got fatal error during xfer (aborted by signal=PIPE)
2015-05-13 01:00:02 incr backup started back to 2015-05-11 22:00:01 (backup
#11) for directory cDrive
2015-05-13 01:42:33 Aborting backup up after signal PIPE
2015-05-13 01:42:34 Got fatal error during xfer (aborted by signal=PIPE)
2015-05-13 02:00:00 incr backup started back to 2015-05-11 22:00:01 (backup
#11) for directory cDrive
2015-05-13 02:32:26 Aborting backup up after signal PIPE
2015-05-13 02:32:27 Got fatal error during xfer (aborted by signal=PIPE)
2015-05-13 03:00:01 incr backup started back to 2015-05-11 22:00:01 (backup
#11) for directory cDrive
2015-05-13 03:25:37 Aborting backup up after signal PIPE
2015-05-13 03:25:38 Got fatal error during xfer (aborted by signal=PIPE)
2015-05-13 04:00:01 incr backup started back to 2015-05-11 22:00:01 (backup
#11) for directory cDrive
2015-05-13 04:21:27 Aborting backup up after signal PIPE
2015-05-13 04:21:28 Got fatal error during xfer (aborted by signal=PIPE)
2015-05-13 05:23:05 incr backup started back to 2015-05-11 22:00:01 (backup
#11) for directory cDrive
2015-05-13 05:49:52 Aborting backup up after signal PIPE
2015-05-13 05:49:54 Got fatal error during xfer (aborted by signal=PIPE)
2015-05-13 06:00:01 incr backup started back to 2015-05-11 22:00:01 (backup
#11) for directory cDrive
2015-05-13 06:31:34 Aborting backup up after signal PIPE
2015-05-13 06:31:35 Got fatal error during xfer (aborted by signal=PIPE)
Log File -----------------------

XferLOG (top) ------------------------------

Contents of file /var/lib/BackupPC//pc/pwi._.edu/XferLOG.bad.z, modified
2015-05-13 06:31:35

incr backup started back to 2015-05-11 22:00:01 (backup #11) for directory 
cDrive
Connected to pwi._.edu:873, remote version 31
Negotiated protocol version 28
Got response: 4cd1c9c2c2d160088ceaf4f37985e212
Auth: got challenge: w9e/A6Mx1L8SPNU/7scpiQ, reply: backuppc
TNHJwsLRYAiM6vTzeYXiEg
Connected to module cDrive
Sending args: --server --sender --numeric-ids --perms --owner --group -D
--links --hard-links --times --block-size=2048 --recursive --one-file-system .
.
Checksum seed is 1431514810
Got checksumSeed 0x55532eba
Got file (0 of 3415): .
XferLOG (top) --------------------------

XferLOG (bottom) ----------------

Remote[1]: rsync: send_files failed to open
"ProgramData/Microsoft/Search/Data/Applications/Windows/MSS.log" (in cDrive):
Device or resource busy (16)
Remote[1]: rsync: send_files failed to open
"ProgramData/Microsoft/Search/Data/Applications/Windows/MSStmp.log" (in
cDrive): Device or resource busy (16)
Can't write 33188 bytes to socket
Sending csums, cnt = 117351, phase = 1
Read EOF:
Tried again: got 0 bytes
Got done from child
Got stats: 0 0 0 2 ('errorCnt' => 0,'ExistFileSize' => 0,'ExistFileCnt' =>
0,'TotalFileCnt' => 5,'ExistFileCompSize' => 0,'TotalFileSize' => 10009745)
finish: removing in-process file
ProgramData/Microsoft/RAC/StateData/RacDatabase.sdf
  delete d 775   544/544           0 ProgramData/Microsoft/RAC/Temp
attribWrite(dir=fcDrive/ProgramData/Microsoft/RAC) ->
/var/lib/BackupPC//pc/pwi.uimcc.uic.edu/new/fcDrive/fProgramData/fMicrosoft/fRAC/attrib
  delete d 775 544/197121           0 ProgramData/Microsoft/WLSetup
  delete d 770     18/18           0 ProgramData/Microsoft/Windows Defender
  delete d 770 544/4294967295           0 ProgramData/Microsoft/eHome
  delete d 775     18/18           0 ProgramData/Microsoft/Windows Live
  delete d 775     18/18           0 ProgramData/Microsoft/Search
  delete d 770   544/544           0 ProgramData/Microsoft/Vault
  delete d 775     18/18           0 ProgramData/Microsoft/WwanSvc
  delete d 775   544/544           0 ProgramData/Microsoft/Windows
  delete d 775     18/18           0 ProgramData/Microsoft/WPD
  delete d 775   544/544           0 ProgramData/Microsoft/User Account Pictures
  delete d 775     18/18           0 ProgramData/Microsoft/Windows NT
attribWrite(dir=fcDrive/ProgramData/Microsoft) ->
/var/lib/BackupPC//pc/pwi._.edu/new/fcDrive/fProgramData/fMicrosoft/attrib
Done: 5 files, 10009745 bytes
Got fatal error during xfer (aborted by signal=PIPE)
Backup aborted by user signal
XferLOG(bottom) -------------------


Thanks,

Fred


------------------------------------------------------------------------------
One dashboard for servers and applications across Physical-Virtual-Cloud 
Widest out-of-the-box monitoring support with 50+ applications
Performance metrics, stats and reports that give you Actionable Insights
Deep dive visibility with transaction tracing using APM Insight.
http://ad.doubleclick.net/ddm/clk/290420510;117567292;y
_______________________________________________
BackupPC-users mailing list
BackupPC-users AT lists.sourceforge DOT net
List:    https://lists.sourceforge.net/lists/listinfo/backuppc-users
Wiki:    http://backuppc.wiki.sourceforge.net
Project: http://backuppc.sourceforge.net/