VM Explorer Practitioner Forum
cancel
Showing results for 
Search instead for 
Did you mean: 

Copy backup task fails with target of CentOS 7.2

Highlighted
rnmixon
Acclaimed Contributor

Copy backup task fails with target of CentOS 7.2

We are evaluating VM Explorer - the backup features seem great. But were are running into a bit of a problem trying to copy an 8GB backup to a folder on a Linux server target. We are able to setup the server fine and the "test connection" works.

However once it begins to copy we end up with this error "The copy backup task failed. Not connected".  It may be a Linux issue, not a VM Explorer issue, but we are not seeing anything on the Linux side other than the user was disconnected. I'm including messages first form the VM Explorer log and then corresponding time-frame messages from the linux log.

Is there a way to get more detail in the VM Explorer log?

Thank you for any ideas/suggestions - Richard.

 

Messages from VMExplorer-6_1_5.log:

---------------------------------------------------------------------------------------
[12132] 7/18/2016 4:10:45 PM		[1795945313] Copy Backup Task (03d08122-5386-487c-a710-bd424fd13f0d) started for VM backup: 'web1', type: Normal (VMX: 6.1.005.0)
[12132] 7/18/2016 4:10:45 PM		[1795945313] Scheduled task execution: 838860b0-ab4f-4ef9-89c9-f8c6a650f412 - 7/18/2016 4:10:45 PM
[12132] 7/18/2016 4:10:45 PM		[1795945313] Processing backup 7046e3b5-e75d-47f3-8a36-5c6b8cee2ec8 (multi: ) : Backup of 'web1' from 'Whaleshark' to 'Local Computer' in 'K:\Trilead\{VM}\{DATETIME}'
[12132] 7/18/2016 4:10:45 PM		[1795945313] Looking for most recent backup...
[12132] 7/18/2016 4:10:45 PM		[2774108] Search existing  backup GUID = "85c6be22-0bdc-4e33-82f0-306ef563b6ca", search incremental backup = False
[12132] 7/18/2016 4:10:45 PM		[2774108] Backup folder "K:\Trilead\web1\2016-07-18-154250" (K:\Trilead\web1\2016-07-18-154250)
[12132] 7/18/2016 4:10:45 PM		[2774108] Search old backups in folder: K:\Trilead\web1\2016-07-18-154250
[12132] 7/18/2016 4:10:45 PM		[2774108] Found 1 backups
[12132] 7/18/2016 4:10:45 PM		Folder "K:\Trilead\web1\2016-07-18-154250" contains VM Explorer backup file
[12132] 7/18/2016 4:10:45 PM		[1795945313] Most recent backup found: 7/18/2016 3:42:50 PM - 85c6be22-0bdc-4e33-82f0-306ef563b6ca
[12132] 7/18/2016 4:10:45 PM		[1795945313] Looking for most recent backup copies...
[12132] 7/18/2016 4:10:45 PM		[1795945313] No recent backup copy found
[12132] 7/18/2016 4:10:48 PM		[1795945313] Copy Backup from RE started for VM: web1 (VMX: 6.1.005.0)
[12132] 7/18/2016 4:10:48 PM		[1795945313] Source scheduled task: 5ec49fbf-bcd3-4cc6-959f-d574b392a31c, backup: 85c6be22-0bdc-4e33-82f0-306ef563b6ca, multi: 
[12132] 7/18/2016 4:10:48 PM		[1795945313] Source server: Local Machine
[12132] 7/18/2016 4:10:48 PM		[1795945313] Target server: CCC barge2
[12132] 7/18/2016 4:10:48 PM		[1795945313] Target path: /home/custco/vmexplorer/web1/2016-07-18-161045
[12132] 7/18/2016 4:10:48 PM		[1795945313] Required space: 7,610,512,158 bytes
[12132] 7/18/2016 4:10:48 PM		[1795945313] It was not possible to determine the target datastore free space, skipping backup size check
[12132] 7/18/2016 4:10:50 PM		[1795945313] Start copying files: 4
[12132] 7/18/2016 4:10:50 PM		[1795945313] Copying file 1 of 4: K:\Trilead\web1\2016-07-18-154250\2590CC64-A065-45EC-9084-1EC2BA5A82D3.xml (40,362 bytes)
[12132] 7/18/2016 4:10:50 PM		[1795945313] Copying file 2 of 4: K:\Trilead\web1\2016-07-18-154250\ide0_0\CCCWebServer.vhd (7,576,780,800 bytes)
[12132] 7/18/2016 4:11:33 PM		[1795945313] Removing temp file '/home/custco/vmexplorer/web1/2016-07-18-161045/2590CC64-A065-45EC-9084-1EC2BA5A82D3.xml.071816105012.tmp'
[12132] 7/18/2016 4:11:39 PM		[1795945313] Removing temp file '/home/custco/vmexplorer/web1/2016-07-18-161045/ide0_0/CCCWebServer.vhd.071816105012.tmp'
[12132] 7/18/2016 4:11:39 PM		[1795945313] Removing temp file '/home/custco/vmexplorer/web1/2016-07-18-161045/ide0_0/CCCWebServer.vhd.sbi.071816105012.tmp'
[12132] 7/18/2016 4:11:39 PM		[1795945313] Removing target folders if empty...
[12132] 7/18/2016 4:11:39 PM		[1795945313] target folder deleted: /home/custco/vmexplorer/web1/2016-07-18-161045/ide0_0
[12132] 7/18/2016 4:11:40 PM		[1795945313] target folder deleted: /home/custco/vmexplorer/web1/2016-07-18-161045
[12132] 7/18/2016 4:11:40 PM [ERROR]	[1795945313] Error during copy backup from restore entry: Not connected
[12132] 7/18/2016 4:11:40 PM [ERROR]	[1795945313] Error during copy backup: Not connected
[12132] 7/18/2016 4:11:40 PM [ERROR]	The task failed (The copy backup task failed. Not connected)
[12132] 7/18/2016 4:11:40 PM		[6299368] Saving Result for task "Offsite Copy of web1"
[12132] 7/18/2016 4:11:40 PM [ERROR]	Exception in asynchronous job Scheduled Task 'Offsite Copy of web1': The copy backup task failed. Not connected
[12132] 7/18/2016 4:11:40 PM [ERROR]	[6299368] Error on perform scheduled task 'Offsite Copy of web1' ("ea6af01f-d7a0-46e8-8f2c-e5c70a67d4e7"). The copy backup task failed. Not connected
[12132] 7/18/2016 4:11:40 PM		[6299368] Task 'Offsite Copy of web1' ("ea6af01f-d7a0-46e8-8f2c-e5c70a67d4e7") terminated sending FinishJob
[12132] 7/18/2016 4:11:40 PM		[6299368] Start closing host
[12132] 7/18/2016 4:11:50 PM		[6299368] Host closed
---------------------------------------------------------------------------------------


Messages from Centos server "/var/log/secure" log:

Jul 18 16:10:40 barge2 sshd[20661]: Accepted password for custco from 192.168.1.151 port 53171 ssh2
Jul 18 16:10:40 barge2 sshd[20661]: pam_unix(sshd:session): session opened for user custco by (uid=0)
Jul 18 16:10:41 barge2 su: pam_unix(su-l:session): session opened for user root by custco(uid=1001)
Jul 18 16:10:41 barge2 su: pam_unix(su-l:session): session opened for user root by custco(uid=1001)
Jul 18 16:10:42 barge2 su: pam_unix(su-l:session): session closed for user root
Jul 18 16:10:43 barge2 su: pam_unix(su-l:session): session closed for user root
Jul 18 16:10:43 barge2 sshd[20665]: Received disconnect from 192.168.1.151: 11: Closed due to user request.
Jul 18 16:10:43 barge2 sshd[20661]: pam_unix(sshd:session): session closed for user custco
Jul 18 16:10:43 barge2 sshd[20753]: Accepted password for custco from 192.168.1.151 port 53173 ssh2
Jul 18 16:10:43 barge2 sshd[20753]: pam_unix(sshd:session): session opened for user custco by (uid=0)
Jul 18 16:10:44 barge2 su: pam_unix(su-l:session): session opened for user root by custco(uid=1001)
Jul 18 16:11:27 barge2 su: pam_unix(su-l:session): session closed for user root
Jul 18 16:11:27 barge2 sshd[20758]: Received disconnect from 192.168.1.151: 11: Closed due to user request.
Jul 18 16:11:27 barge2 sshd[20753]: pam_unix(sshd:session): session closed for user custco
Jul 18 16:11:28 barge2 sshd[20817]: Accepted password for custco from 192.168.1.151 port 53177 ssh2
Jul 18 16:11:28 barge2 sshd[20817]: pam_unix(sshd:session): session opened for user custco by (uid=0)
Jul 18 16:11:33 barge2 su: pam_unix(su-l:session): session opened for user root by custco(uid=1001)
Jul 18 16:11:45 barge2 sshd[20817]: pam_unix(sshd:session): session closed for user custco
Jul 18 16:11:45 barge2 su: pam_unix(su-l:session): session closed for user root

 

 

 

4 REPLIES
Sandeep Kumar S
HPE Expert

Re: Copy backup task fails with target of CentOS 7.2

Hello,

Please attach the logs and task report for further analysis. Log collection procedure:

In the Web Interface, go to "admin" -> "Settings" -> "Support" and click to "Generate New Debug Report". Download the zip file and provide it to us.

Regards,

Sandeep

rnmixon
Acclaimed Contributor

Re: Copy backup task fails with target of CentOS 7.2

Sandeep,

Thank you for the response and instructions.

I just reran the "copy backup" scheduled task and the debug report is attached. It would not allow me to attach the ".zip" file so I had to rename it to end in ".jpg" - but just change it back to ".zip" I guess.

 - Richard

Sandeep Kumar S
HPE Expert

Re: Copy backup task fails with target of CentOS 7.2

Hello,

Yes...Due to recent change us policy, zip files are not allowed to be uploaded. You can log a case through HPE SSO Portal https://softwaresupport.hpe.com/ and we can look into it by providing FTP link. 

Let me check if I can get a FTP link so that the logs can be uploaded.

Regards,

Sandeep

rnmixon
Acclaimed Contributor

Re: Copy backup task fails with target of CentOS 7.2

Sandeep,

Sorry - my post was not clear. The log files did upload as an attachment to yesterday's post. 

You just have to rename the file "VMXDebugReport-20160719-103208.jpg" to end in "zip".

 - Richard

//Add this to "OnDomLoad" event