Constructing of filelist of "myserver" failed - TIMEOUT(1)

ramirezv · January 27, 2014, 4:18pm

I am having the following error in a Windows 2003 Domain Controller that is using Dynamic drives. It was able to create the image backup, but not the file backups.

Errors  
27.01.14 11:04  
Constructing of filelist of "pandora" failed - TIMEOUT(1)  
Errors  
27.01.14 11:04  
Backup had errors. Deleting partial backup.

I have another Windows 2003 (that is currently running the urBackup server) and it is making both image and file backups without errors. I also have another Windows 2008 R2 64bits that is making backups correctly. The only one with errors is the Win 2003 Domain Controller that happens to be our main file sharing server :-(

I created a dummy folder as “C:\Deleteme” with only one text file in it and used that folder as the only backup path in the Win 2003 that is failing. urBackup still gives me the error, so I guess it is not related to the size of the folder.

I also, changed the account name that is running the urBackup services to the domain Administrator account to see if the error is related to the security but the error still happens.

The backup destination is a shared Synology server that I think runs as an SMB share. But I don’t think the problem is related to the destination because the other two backup clients are making their backups to that same Synology server.

uroni · January 28, 2014, 10:12pm

Can you have a look at the client side log file (Default location C:\Program Files\UrBackup\debug.log)? Can you change „warn“ to „debug“ in C:\Program Files\UrBackup\args.txt and then restart the „UrBackupBackend“ Service (or Windows). It should then log a lot more (debug messages). A log file can give me more details about your case. If you can post the appropriate log message here or give me the complete log file by sending it zipped to martin@urbackup.org . Posting in this forum is the perferred form of communication since others may have the same problem.
When crashing UrBackup will also save a crash dump (Minimized memory dump of the application during the crash). It will write in the log file where it saves the crash dump. If you can send me (to martin@urbackup.org ) that crash dump, that would be helpful as well.

ramirezv · January 30, 2014, 1:45pm

Here is a ZIP file with the log and the dmps.

The end of the log is like this:

STATUS#pw=mpGydMS9SR7Mxfc4A91bmgPJs5lNU0
2014-01-30 09:24:28: rc=0 hasError=true state=0
2014-01-30 09:24:28: ClientService cmd: GET INCRINTERVALL#pw=mpGydMS9SR7Mxfc4A91bmgPJs5lNU0
2014-01-30 09:24:28: rc=0 hasError=true state=0
2014-01-30 09:24:29: ClientService cmd: STATUS#pw=mpGydMS9SR7Mxfc4A91bmgPJs5lNU0
2014-01-30 09:24:29: rc=0 hasError=true state=0
2014-01-30 09:24:29: ClientService cmd: GET INCRINTERVALL#pw=mpGydMS9SR7Mxfc4A91bmgPJs5lNU0
2014-01-30 09:24:29: rc=0 hasError=true state=0
2014-01-30 09:24:30: ClientService cmd: STATUS#pw=mpGydMS9SR7Mxfc4A91bmgPJs5lNU0
2014-01-30 09:24:30: rc=0 hasError=true state=0
2014-01-30 09:24:30: ClientService cmd: GET INCRINTERVALL#pw=mpGydMS9SR7Mxfc4A91bmgPJs5lNU0
2014-01-30 09:24:30: rc=0 hasError=true state=0
2014-01-30 09:24:31: ClientService cmd: STATUS#pw=mpGydMS9SR7Mxfc4A91bmgPJs5lNU0
2014-01-30 09:24:31: rc=0 hasError=true state=0
2014-01-30 09:24:31: ClientService cmd: GET INCRINTERVALL#pw=mpGydMS9SR7Mxfc4A91bmgPJs5lNU0
2014-01-30 09:24:31: rc=0 hasError=true state=0
2014-01-30 09:24:32: ClientService cmd: STATUS#pw=mpGydMS9SR7Mxfc4A91bmgPJs5lNU0
2014-01-30 09:24:32: rc=0 hasError=true state=0
2014-01-30 09:24:32: ClientService cmd: GET INCRINTERVALL#pw=mpGydMS9SR7Mxfc4A91bmgPJs5lNU0
2014-01-30 09:24:32: rc=0 hasError=true state=0
2014-01-30 09:24:33: ClientService cmd: STATUS#pw=mpGydMS9SR7Mxfc4A91bmgPJs5lNU0
2014-01-30 09:24:33: rc=0 hasError=true state=0
2014-01-30 09:24:33: ClientService cmd: GET INCRINTERVALL#pw=mpGydMS9SR7Mxfc4A91bmgPJs5lNU0
2014-01-30 09:24:33: rc=0 hasError=true state=0
2014-01-30 09:24:34: ClientService cmd: STATUS#pw=mpGydMS9SR7Mxfc4A91bmgPJs5lNU0
2014-01-30 09:24:34: rc=0 hasError=true state=0
2014-01-30 09:24:34: ClientService cmd: GET INCRINTERVALL#pw=mpGydMS9SR7Mxfc4A91bmgPJs5lNU0
2014-01-30 09:24:34: rc=0 hasError=true state=0
2014-01-30 09:24:35: ClientService cmd: STATUS#pw=mpGydMS9SR7Mxfc4A91bmgPJs5lNU0
2014-01-30 09:24:35: rc=0 hasError=true state=0
2014-01-30 09:24:35: ClientService cmd: GET INCRINTERVALL#pw=mpGydMS9SR7Mxfc4A91bmgPJs5lNU0
2014-01-30 09:24:35: rc=0 hasError=true state=0
2014-01-30 09:24:36: ClientService cmd: STATUS#pw=mpGydMS9SR7Mxfc4A91bmgPJs5lNU0
2014-01-30 09:24:36: rc=0 hasError=true state=0
2014-01-30 09:24:36: ClientService cmd: GET INCRINTERVALL#pw=mpGydMS9SR7Mxfc4A91bmgPJs5lNU0
2014-01-30 09:24:36: rc=0 hasError=true state=0
2014-01-30 09:24:37: ClientService cmd: STATUS#pw=mpGydMS9SR7Mxfc4A91bmgPJs5lNU0
2014-01-30 09:24:37: rc=0 hasError=true state=0
2014-01-30 09:24:37: ClientService cmd: GET INCRINTERVALL#pw=mpGydMS9SR7Mxfc4A91bmgPJs5lNU0
2014-01-30 09:24:37: rc=0 hasError=true state=0
2014-01-30 09:24:38: ClientService cmd: STATUS#pw=mpGydMS9SR7Mxfc4A91bmgPJs5lNU0
2014-01-30 09:24:38: rc=0 hasError=true state=0
2014-01-30 09:24:38: ClientService cmd: GET INCRINTERVALL#pw=mpGydMS9SR7Mxfc4A91bmgPJs5lNU0
2014-01-30 09:24:38: rc=0 hasError=true state=0
2014-01-30 09:24:38: ClientService cmd: #IKo4qavJpWfQSaXbCdSIu#PING RUNNING -0-#token=gjBP8ERRWgh4L3iBdWTp
2014-01-30 09:24:38: ClientService cmd: #IKo4qavJpWfQSaXbCdSIu#2START FULL BACKUP#token=gjBP8ERRWgh4L3iBdWTp
2014-01-30 09:24:38: Removing VSS log data…
2014-01-30 09:24:38: Final path: E:\AutoPak\Procedimientos
2014-01-30 09:24:38: rc=0 hasError=true state=0
2014-01-30 09:24:38: Deleting files… doing full index…
2014-01-30 09:24:39: ClientService cmd: STATUS#pw=mpGydMS9SR7Mxfc4A91bmgPJs5lNU0
2014-01-30 09:24:39: rc=0 hasError=true state=0
2014-01-30 09:24:39: ClientService cmd: GET INCRINTERVALL#pw=mpGydMS9SR7Mxfc4A91bmgPJs5lNU0
2014-01-30 09:24:39: rc=0 hasError=true state=0
2014-01-30 09:24:39: Final path: E:\AutoPak\Procedimientos
2014-01-30 09:24:45: ClientService cmd: PONG
2014-01-30 09:24:48: ClientService cmd: #IKo4qavJpWfQSaXbCdSIu#PING RUNNING -0-#token=gjBP8ERRWgh4L3iBdWTp
2014-01-30 09:24:48: rc=0 hasError=true state=0
2014-01-30 09:24:49: ClientService cmd: STATUS#pw=mpGydMS9SR7Mxfc4A91bmgPJs5lNU0
2014-01-30 09:24:49: rc=0 hasError=true state=0
2014-01-30 09:24:49: ClientService cmd: GET INCRINTERVALL#pw=mpGydMS9SR7Mxfc4A91bmgPJs5lNU0
2014-01-30 09:24:49: rc=0 hasError=true state=0
2014-01-30 09:24:49: Creating shadowcopy of “Procedimientos” in indexDirs()
2014-01-30 09:24:51: Number of Writers: 14
2014-01-30 09:24:51: Writer System Writer has failure state VSS_WS_STABLE with error S_OK.
2014-01-30 09:24:51: Writer SqlServerWriter has failure state VSS_WS_FAILED_AT_PREPARE_SNAPSHOT with error VSS_E_WRITERERROR_RETRYABLE
2014-01-30 09:24:51: Writer NTDS has failure state VSS_WS_STABLE with error S_OK.
2014-01-30 09:24:51: Writer TermServLicensing has failure state VSS_WS_STABLE with error S_OK.
2014-01-30 09:24:51: Writer MSDEWriter has failure state VSS_WS_STABLE with error S_OK.
2014-01-30 09:24:51: Writer WINS Jet Writer has failure state VSS_WS_STABLE with error S_OK.
2014-01-30 09:24:51: Writer COM+ REGDB Writer has failure state VSS_WS_STABLE with error S_OK.
2014-01-30 09:24:51: Writer WMI Writer has failure state VSS_WS_STABLE with error S_OK.
2014-01-30 09:24:51: Writer Registry Writer has failure state VSS_WS_STABLE with error S_OK.
2014-01-30 09:24:51: Writer Event Log Writer has failure state VSS_WS_STABLE with error S_OK.
2014-01-30 09:24:51: Writer IIS Metabase Writer has failure state VSS_WS_STABLE with error S_OK.
2014-01-30 09:24:51: Writer FRS Writer has failure state VSS_WS_STABLE with error S_OK.
2014-01-30 09:24:51: Writer BITS Writer has failure state VSS_WS_STABLE with error S_OK.
2014-01-30 09:24:51: Writer Dhcp Jet Writer has failure state VSS_WS_STABLE with error S_OK.
2014-01-30 09:24:51: Number of Writers: 14
2014-01-30 09:24:51: Writer System Writer has failure state VSS_WS_STABLE with error S_OK.
2014-01-30 09:24:51: Writer SqlServerWriter has failure state VSS_WS_STABLE with error S_OK.
2014-01-30 09:24:51: Writer NTDS has failure state VSS_WS_STABLE with error S_OK.
2014-01-30 09:24:51: Writer TermServLicensing has failure state VSS_WS_STABLE with error S_OK.
2014-01-30 09:24:51: Writer MSDEWriter has failure state VSS_WS_STABLE with error S_OK.
2014-01-30 09:24:51: Writer WINS Jet Writer has failure state VSS_WS_STABLE with error S_OK.
2014-01-30 09:24:51: Writer COM+ REGDB Writer has failure state VSS_WS_STABLE with error S_OK.
2014-01-30 09:24:51: Writer WMI Writer has failure state VSS_WS_STABLE with error S_OK.
2014-01-30 09:24:51: Writer Registry Writer has failure state VSS_WS_STABLE with error S_OK.
2014-01-30 09:24:51: Writer Event Log Writer has failure state VSS_WS_STABLE with error S_OK.
2014-01-30 09:24:51: Writer IIS Metabase Writer has failure state VSS_WS_STABLE with error S_OK.
2014-01-30 09:24:51: Writer FRS Writer has failure state VSS_WS_STABLE with error S_OK.
2014-01-30 09:24:51: Writer BITS Writer has failure state VSS_WS_STABLE with error S_OK.
2014-01-30 09:24:51: Writer Dhcp Jet Writer has failure state VSS_WS_STABLE with error S_OK.
2014-01-30 09:24:55: FileSrv: UDP: PING received… sending PONG. Delay=430ms
2014-01-30 09:24:55: FileSrv: UDP: PING received… sending PONG. Delay=230ms
2014-01-30 09:24:56: FileSrv: UDP: PING received… sending PONG. Delay=99ms
2014-01-30 09:24:56: FileSrv: UDP: PING received… sending PONG. Delay=251ms
2014-01-30 09:24:56: FileSrv: UDP: PING received… sending PONG. Delay=428ms
2014-01-30 09:24:56: FileSrv: UDP: PING received… sending PONG. Delay=131ms
2014-01-30 09:24:57: Number of Writers: 14
2014-01-30 09:24:57: Writer System Writer has failure state VSS_WS_WAITING_FOR_BACKUP_COMPLETE with error S_OK.
2014-01-30 09:24:57: ERROR: Writer SqlServerWriter has failure state VSS_WS_FAILED_AT_PREPARE_SNAPSHOT with error VSS_E_WRITERERROR_NONRETRYABLE UrBackup will continue with the backup but the associated data may not be consistent.
2014-01-30 09:24:57: Writer NTDS has failure state VSS_WS_WAITING_FOR_BACKUP_COMPLETE with error S_OK.
2014-01-30 09:24:57: Writer TermServLicensing has failure state VSS_WS_WAITING_FOR_BACKUP_COMPLETE with error S_OK.
2014-01-30 09:24:57: Writer MSDEWriter has failure state VSS_WS_WAITING_FOR_BACKUP_COMPLETE with error S_OK.
2014-01-30 09:24:57: Writer WINS Jet Writer has failure state VSS_WS_WAITING_FOR_BACKUP_COMPLETE with error S_OK.
2014-01-30 09:24:57: Writer COM+ REGDB Writer has failure state VSS_WS_WAITING_FOR_BACKUP_COMPLETE with error S_OK.
2014-01-30 09:24:57: Writer WMI Writer has failure state VSS_WS_WAITING_FOR_BACKUP_COMPLETE with error S_OK.
2014-01-30 09:24:57: Writer Registry Writer has failure state VSS_WS_WAITING_FOR_BACKUP_COMPLETE with error S_OK.
2014-01-30 09:24:57: Writer Event Log Writer has failure state VSS_WS_WAITING_FOR_BACKUP_COMPLETE with error S_OK.
2014-01-30 09:24:57: Writer IIS Metabase Writer has failure state VSS_WS_WAITING_FOR_BACKUP_COMPLETE with error S_OK.
2014-01-30 09:24:57: Writer FRS Writer has failure state VSS_WS_WAITING_FOR_BACKUP_COMPLETE with error S_OK.
2014-01-30 09:24:57: Writer BITS Writer has failure state VSS_WS_WAITING_FOR_BACKUP_COMPLETE with error S_OK.
2014-01-30 09:24:57: Writer Dhcp Jet Writer has failure state VSS_WS_WAITING_FOR_BACKUP_COMPLETE with error S_OK.
2014-01-30 09:24:57: WARNING: Snapshotting failed because of Writer. Retrying in 30s…
2014-01-30 09:24:58: ClientService cmd: #IKo4qavJpWfQSaXbCdSIu#PING RUNNING -0-#token=gjBP8ERRWgh4L3iBdWTp
2014-01-30 09:24:58: rc=0 hasError=true state=0
2014-01-30 09:24:59: ClientService cmd: STATUS#pw=mpGydMS9SR7Mxfc4A91bmgPJs5lNU0
2014-01-30 09:24:59: rc=0 hasError=true state=0
2014-01-30 09:24:59: ClientService cmd: GET INCRINTERVALL#pw=mpGydMS9SR7Mxfc4A91bmgPJs5lNU0
2014-01-30 09:24:59: rc=0 hasError=true state=0
2014-01-30 09:25:08: ClientService cmd: #IKo4qavJpWfQSaXbCdSIu#PING RUNNING -0-#token=gjBP8ERRWgh4L3iBdWTp
2014-01-30 09:25:08: rc=0 hasError=true state=0
2014-01-30 09:25:09: ClientService cmd: STATUS#pw=mpGydMS9SR7Mxfc4A91bmgPJs5lNU0
2014-01-30 09:25:09: rc=0 hasError=true state=0
2014-01-30 09:25:09: ClientService cmd: GET INCRINTERVALL#pw=mpGydMS9SR7Mxfc4A91bmgPJs5lNU0
2014-01-30 09:25:09: rc=0 hasError=true state=0
2014-01-30 09:25:18: ClientService cmd: #IKo4qavJpWfQSaXbCdSIu#PING RUNNING -0-#token=gjBP8ERRWgh4L3iBdWTp
2014-01-30 09:25:18: rc=0 hasError=true state=0
2014-01-30 09:25:19: ClientService cmd: STATUS#pw=mpGydMS9SR7Mxfc4A91bmgPJs5lNU0
2014-01-30 09:25:19: rc=0 hasError=true state=0
2014-01-30 09:25:19: ClientService cmd: GET INCRINTERVALL#pw=mpGydMS9SR7Mxfc4A91bmgPJs5lNU0
2014-01-30 09:25:19: rc=0 hasError=true state=0
2014-01-30 09:25:27: ERROR: Fatal exception (APPLICATION CRASHED). Crash dump written to “C:\DOCUME~1\ADMINI~1.PAN\LOCALS~1\Temp\UrBackup\v0.25.1-20140130-092527-6184-7168.dmp”

ramirezv · January 30, 2014, 1:47pm

Here is the complete log in a zip file.

ramirezv · January 30, 2014, 1:48pm

… and one of the dmp files.

uroni · February 1, 2014, 11:13pm

I think this bug was fixed with 1.3.1. I have released that version. Can you try if this fixes your crash?

Thank you for you help!

jollyjokester · February 10, 2015, 7:22am

I know that this topic is quite dated, but some of my clients also have similar problem. I didn’t find a more recent topic which covered this isssue.

Timeout occures on random hosts. We have ~40-50 files on each host, which are something like 100MB (more or less) so it’s not the problem with the number of files I guess. We are using UrBackup 1.4.6.