Failed: error - Async indexing process not found

Server
1

Hello,

A Server was backing up fine, but now i am getting the following when trying to backup

failed: error - Async indexing process not found

Any ideas on this - i have tried to reinstall UrBackup but the same happens.

I am using Windows Server 2016 and Version 2.1.16 of UrBackup

I have this in the logs

2017-09-19 16:09:23: ERROR: Recvfrom error in CUDPThread::UdpStep

2017-09-19 16:09:23: ERROR: Last error: 0
2017-09-19 16:09:23: WARNING: Info not found at ‘c:’ - reindexing
2017-09-19 16:10:14: ERROR: Recvfrom error in CUDPThread::UdpStep
2017-09-19 16:10:14: ERROR: Last error: 10058
2017-09-19 16:11:05: ERROR: Recvfrom error in CUDPThread::UdpStep
2017-09-19 16:11:05: ERROR: Last error: 10058
2017-09-19 16:11:55: ERROR: Recvfrom error in CUDPThread::UdpStep
2017-09-19 16:11:55: ERROR: Last error: 10058
2017-09-19 16:11:57: WARNING: Limiting number of DC users to 102
2017-09-19 16:11:59: ERROR: Error while enumerating DC user groups: 234
2017-09-19 16:12:02: ERROR: Error while enumerating DC user groups: 234
2017-09-19 16:12:04: ERROR: Error while enumerating DC user groups: 234
2017-09-19 16:12:05: ERROR: Error while enumerating DC user groups: 234
2017-09-19 16:12:05: ERROR: Error while enumerating DC user groups: 234
2017-09-19 16:12:06: ERROR: Error while enumerating DC user groups: 234
2017-09-19 16:12:07: ERROR: Error while enumerating DC user groups: 234
2017-09-19 16:15:51: Loaded -fileserv- plugin
2017-09-19 16:15:51: Loaded -fsimageplugin- plugin
2017-09-19 16:15:51: Loaded -cryptoplugin- plugin
2017-09-19 16:15:51: SQLite: recovered 1227 frames from WAL file C:\Program Files\UrBackup\urbackup\backup_client.db-wal code: 283
2017-09-19 16:15:51: urbackupserver: Server started up successfully!
2017-09-19 16:15:51: FileSrv: Backup privileges set successfully
2017-09-19 16:15:51: FileSrv: Backup privileges set successfully (SE_SECURITY_NAME)
2017-09-19 16:15:51: FileSrv: Backup privileges set successfully (SE_RESTORE_NAME)
2017-09-19 16:15:51: FileSrv: Binding UDP socket at port 35622…
2017-09-19 16:15:51: FileSrv: done.
2017-09-19 16:15:51: FileSrv: Disabling new behavior…
2017-09-19 16:15:51: FileSrv: Servername: -INETC1168-
2017-09-19 16:15:51: FileSrv: Server started up successfully
2017-09-19 16:15:51: FileSrv: UDP Thread startet
2017-09-19 16:15:51: Started UrBackupClient Backend…
2017-09-19 16:15:51: Filesystem. Vol="\?\Volume{12ed6c5d-0000-0000-0000-100000000000}" Name=“system reserved” Type=“ntfs” VPaths=0 Size=524283904
2017-09-19 16:15:51: Bootable flag set for volume
2017-09-19 16:15:51: Found potential candidate: \?\Volume{12ed6c5d-0000-0000-0000-100000000000}\ Score: 103
2017-09-19 16:15:51: Filesystem. Vol="\?\Volume{12ed6c5d-0000-0000-0000-501f00000000}" Name="" Type=“ntfs” VPaths=1 Size=53687087104
2017-09-19 16:15:51: Filesystem is System partition. Skipping…
2017-09-19 16:15:51: Filesystem. Vol="\?\Volume{12ed6c5d-0000-0000-0000-509f0c000000}" Name=“data” Type=“ntfs” VPaths=0 Size=945428623360
2017-09-19 16:15:51: Bootable flag not set for volume
2017-09-19 16:15:51: Found potential candidate: \?\Volume{12ed6c5d-0000-0000-0000-509f0c000000}\ Score: 1
2017-09-19 16:15:51: Filesystem. Vol="\?\Volume{7772b6f1-35c0-4671-8c9c-1c8dd2d7dc10}" Name=“new volume” Type=“csvfs” VPaths=1 Size=9770914279424
2017-09-19 16:15:51: GPT formated hard disk encountered. No bootable flag. Attributes = -9223372036854775808
2017-09-19 16:15:51: Do not automount is set
2017-09-19 16:15:51: Bootable flag not set for volume
2017-09-19 16:15:51: Filesystem. Vol="\?\Volume{1564f475-25d1-11e7-90e3-806e6f6e6963}" Name="" Type="" VPaths=1 Size=-1
2017-09-19 16:15:51: GetVolumeInformation failed with error code 21. Skipping…
2017-09-19 16:15:51: Selected volume \?\Volume{12ed6c5d-0000-0000-0000-100000000000}
2017-09-19 16:15:51: System dir: C:\Windows
2017-09-19 16:15:51: Volpath: \.\C:
2017-09-19 16:15:51: Device is not GPT formatted (0)
2017-09-19 16:15:51: Found no EFI System Partition
2017-09-19 16:15:51: urbackupserver: No available slots… starting new Worker
2017-09-19 16:15:51: ClientService cmd: STATUS DETAIL#pw=dx9wsmLHmZZXJjEHipDbDSJb4CB9e0
2017-09-19 16:15:51: ClientService cmd: STATUS#pw=dx9wsmLHmZZXJjEHipDbDSJb4CB9e0
2017-09-19 16:15:51: ClientService cmd: STATUS DETAIL#pw=dx9wsmLHmZZXJjEHipDbDSJb4CB9e0
2017-09-19 16:15:52: Looking for old Sessions… 0 sessions
2017-09-19 16:15:52: Internet mode not enabled
2017-09-19 16:15:52: Final path: C:\backup
2017-09-19 16:15:52: ClientService cmd: STATUS#pw=dx9wsmLHmZZXJjEHipDbDSJb4CB9e0
2017-09-19 16:15:52: ClientService cmd: STATUS DETAIL#pw=dx9wsmLHmZZXJjEHipDbDSJb4CB9e0
2017-09-19 16:15:52: ClientService cmd: #I1GpxWDMCqsF52sKgAo2e#WAIT FOR INDEX async_id=568ac2e270b0680a16399fabb0eea7e0#token=64N5uXEZNfovaOk4h2L1
2017-09-19 16:15:52: Async index 568ac2e270b0680a16399fabb0eea7e0 not found
2017-09-19 16:15:52: ClientService cmd: #I1GpxWDMCqsF52sKgAo2e#GET VSSLOG
2017-09-19 16:15:52: VSS logdata - 14 bytes
2017-09-19 16:15:52: rc=0 hasError=true state=0
2017-09-19 16:15:52: rc=0 hasError=true state=0
2017-09-19 16:15:53: ClientService cmd: STATUS DETAIL#pw=dx9wsmLHmZZXJjEHipDbDSJb4CB9e0
2017-09-19 16:15:53: ClientService cmd: #I1GpxWDMCqsF52sKgAo2e#1CHANNEL capa=4096&token=64N5uXEZNfovaOk4h2L1&restore_version=1&virtual_client=
2017-09-19 16:15:53: New channel: Number of Channels: 1
2017-09-19 16:15:54: ClientService cmd: STATUS DETAIL#pw=dx9wsmLHmZZXJjEHipDbDSJb4CB9e0
2017-09-19 16:15:55: ClientService cmd: STATUS DETAIL#pw=dx9wsmLHmZZXJjEHipDbDSJb4CB9e0
2017-09-19 16:15:56: ClientService cmd: STATUS DETAIL#pw=dx9wsmLHmZZXJjEHipDbDSJb4CB9e0
2017-09-19 16:15:57: ClientService cmd: STATUS DETAIL#pw=dx9wsmLHmZZXJjEHipDbDSJb4CB9e0
2017-09-19 16:15:57: ClientService cmd: #I1GpxWDMCqsF52sKgAo2e#2LOGDATA 1505833718 0-1505833565-Starting unscheduled full file backup…
2-1505833711-Constructing of filelist of “INETC1168” failed: ERR
2-1505833718-Backup had an early error. Deleting partial backup.

2017-09-19 16:15:57: rc=0 hasError=true state=0
2017-09-19 16:15:57: ClientService cmd: #I1GpxWDMCqsF52sKgAo2e#2LOGDATA 1505834156 0-1505833866-Starting unscheduled full file backup…
2-1505834152-Constructing of filelist of “INETC1168” failed: error - Async indexing process not found
2-1505834156-Backup had an early error. Deleting partial backup.

2

@uroni

I am having the exact same issue with several Win7 clients. Image backups work fine, but File backups all fail, with the urbackup service crashing. This was not a problem about a week ago, and started suddenly with multiple machines.

2017-11-01 00:27:54: rc=0 hasError=true state=0
2017-11-01 00:27:54: SERVICE_COMMANDS finished
2017-11-01 00:27:54: Started connection to SERVICE_COMMANDS
2017-11-01 00:27:55: ClientService cmd: #IAO6M7ej6wjDZMn2eM3rx#2LOGDATA 1509521273 0-1509521178-Starting unscheduled incremental file backup...
2-1509521263-Constructing of filelist of "FIELDHAVEN06" failed: error - Async indexing process not found
2-1509521273-Backup had an early error. Deleting partial backup.

Clients are running version 2.1.6
Server is running version 2.1.19

Client OS: Windows 7 Home Premium x32
Server OS: Debian 9.1 x64

I have tried uninstalling client 2.1.6, rebooting, and installing the beta 2.2.2 client, (from this post: Async indexing process not found). Same issue - the service crashes every time when it runs file indexing. I have removed the beta 2.2.2 client, and went back to the 2.1.6 client and I can reproduce the issue by running File Backup.

I will try to send the crashdumps and the debug log file to bugreports@urbackup.org, but I worry about their size not going through email - crashdumps are 85MB. Please let me know an alternate method to upload the crashdump. I’m happy to upload them to Dropbox and share the link.

I would really like to help get this issue fixed. I’m a CrashPlan refuge, so I plan on replacing about 20 CrashPlan instances with UrBackup. So I have plenty of machines to test any fixes, and provide any logs or dumps needed, or test beta versions.

Thanks in advance.

3

Thanks for the log+crash dump. It’s the " in the exclude pattern that causes this.

1 Like
4

That was it! A single double-quote character was causing all the file backup errors and service crashes. I hope this helps someone - review your exclusions carefully.

Any way that some kind of check can be done on the text field to check for “illegal” characters?

5

It’s a bug. I’ll fix that it crashes with a single " :wink:

2 Likes
6

Flatlinebb,
where do you insert (and remove) that single double-quote character?
Thanks
Stefano

7

@stefano,

It was in the Settings > File Backups > Excluded Files (With Wildcards)

8

@Flatlinebb
Thank You