APAR status
Closed as program error.
Error description
Backup vm via VCB may fail with ANS1017E session rejection for connection failure though backup summary shows whole target objects has been backed up. It can occur when there is unexpected TCP/IP connection error during "backup vm" and will not persist for the next backup. When the problem occur, rerunning the backup is needed though summary indicates successful backups. Here are the example of standard output when the problem occur: ------------------------------ Backup VM command started. Total number of virtual machines to process: 1 Backup of Virtual Machine 'VM_SAMPLE' started Mount virtual machine disk on backup proxy for VM 'VM_SAMPLE' Executing Operating System command or script: vcbMounter -h <HOSTNAME> -u administrator -p **** -a ipaddr:<IP ADDRESS> -r "<PATH>\fullvm\VM_SAMPLE\BACKUP_CURRENT" -t fullvm Finished command. Return code is: 0 ... Starting Full VM backup of Virtual Machine 'VM_SAMPLE' ... Backup processing of 'VMFULL' finished without failure. ... Total number of objects inspected: 10 Total number of objects backed up: 10 Total number of objects updated: 0 Total number of objects rebound: 0 Total number of objects deleted: 0 Total number of objects expired: 0 Total number of objects failed: 0 Total number of subfile objects: 0 Total number of bytes inspected: 1.0 TB Total number of bytes transferred: 1.0 TB Data transfer time: 10,000.00 sec Network data transfer rate: 100,000.00 KB/sec Aggregate data transfer rate: 0,000.00 KB/sec Objects compressed by: 0% Total data reduction ratio: 0.00% Subfile objects reduced by: 0% Elapsed processing time: 07:00:00 ANS1017E Session rejected: TCP/IP connection failure ANS4148E Full VM backup of Virtual Machine 'VM_SAMPLE' failed with RC -50 ------------------------------ Tivoli Storage Manager Versions Affected: Tivoli Storage Manager Client 5.5, 6.1, 6.2.0 and 6.2.1 on Windows platform. Customer/L2 Diagnostics (If Applicable) By analyzing client trace with SERVICE class, the following log records will be seen. >>> ------------------------------ yyyy-mm-dd HH:MM:SS.sss [***] [***] : DccTaskStatus.cpp (1681): ccFinalStats: Restoring to SESS_NODE_SCHED yyyy-mm-dd HH:MM:SS.sss [***] [***] : dscback.cpp (6661): DscBackupVMFull(): Backup for virtual machine 'VM_SAMPLE'. Number of Full VM backup objects backed up=10 failed=0 yyyy-mm-dd HH:MM:SS.sss [***] [***] : dscback.cpp (6681): DscBackupVMFull(): Backup for virtual machine 'VM_SAMPLE'. Object Enum total size=***** yyyy-mm-dd HH:MM:SS.sss [***] [***] : groups.cpp ( 764): baCloseGroupLeader(): Entering, groupMcNum='*', groupObjID='*****' yyyy-mm-dd HH:MM:SS.sss [***] [***] : session.cpp (2225): Address of buffer is 48b0068 yyyy-mm-dd HH:MM:SS.sss [***] [***] : cutxn.cpp ( 282): cuBeginTxn: Sending a BeginTxn verb. yyyy-mm-dd HH:MM:SS.sss [***] [***] : session.cpp (1615): Send Verb: Length: 4 Code: 00000012 Type: BeginTxn yyyy-mm-dd HH:MM:SS.sss [***] [***] : commtcp.cpp (2131): TcpWrite(): Warning - protocol violation, session not open yyyy-mm-dd HH:MM:SS.sss [***] [***] : commtcp.cpp (2309): TcpFlush: writebuff(0000000000000000), bufflen(0), lock(0000000000000000) yyyy-mm-dd HH:MM:SS.sss [***] [***] : commtcp.cpp (2319): TcpFlush(): Warning - protocol violation, session not open yyyy-mm-dd HH:MM:SS.sss [***] [***] : commtcp.cpp (2426): TcpFlush: error 10038 during send. yyyy-mm-dd HH:MM:SS.sss [***] [***] : commtcp.cpp (2540): ANS1006I TCP/IP write error on socket = 4294967295, errno = 10038, reason : An operation was attempted on something that is not a socket. yyyy-mm-dd HH:MM:SS.sss [***] [***] : session.cpp (1668): Send Verb: yyyy-mm-dd HH:MM:SS.sss [***] [***] : session.cpp (1669): ...error yyyy-mm-dd HH:MM:SS.sss [***] [***] : session.cpp (1672): sessSendVerb: Error sending Verb, rc: -50 yyyy-mm-dd HH:MM:SS.sss [***] [***] : session.cpp (4423): sessClose: Transitioning: sInit state ===> sInit state yyyy-mm-dd HH:MM:SS.sss [***] [***] : session.cpp (1847): sessClose: Session closed. ------------------------------ Initial Impact: Low Additional Keywords: vcb vm 1017 10038 zz55 zz61 zz62
Local fix
Use vStor alternative for VCB which is available with the 6.2.2 or higher client
Problem summary
**************************************************************** * USERS AFFECTED: Backup-archive client versions 5.5, 6.1, * * 6.2.0 and 6.2.1 running on all Microsoft * * Windows platforms. * * Versions 6.3 and 6.4 are not affected. * **************************************************************** * PROBLEM DESCRIPTION: See ERROR DESCRIPTION * **************************************************************** * RECOMMENDATION: Apply fixing level when available. This * * problem is currently projected to be fixed * * in level 6.2.2.Note that until the fixing * * level is available, this information is * * subject to change at the discretion of IBM. * **************************************************************** *
Problem conclusion
The problem has been fixed so that it no longer occurs
Temporary fix
Comments
APAR Information
APAR number
IC92937
Reported component name
TSM SERVER
Reported component ID
5698ISMSV
Reported release
62W
Status
CLOSED PER
PE
NoPE
HIPER
NoHIPER
Special Attention
NoSpecatt
Submitted date
2013-06-10
Closed date
2013-07-28
Last modified date
2013-07-28
APAR is sysrouted FROM one or more of the following:
APAR is sysrouted TO one or more of the following:
Modules/Macros
DSMC
Fix information
Fixed component name
TSM CLIENT
Fixed component ID
5698ISMCL
Applicable component levels
R62W PSY
UP
R63W PSY
UP
R64W PSY
UP
[{"Business Unit":{"code":"BU058","label":"IBM Infrastructure w\/TPS"},"Product":{"code":"SSGSG7","label":"Tivoli Storage Manager"},"Component":"","ARM Category":[],"Platform":[{"code":"PF025","label":"Platform Independent"}],"Version":"62W","Edition":"","Line of Business":{"code":"LOB26","label":"Storage"}}]
Document Information
Modified date:
28 July 2013