IBM Support

IT02287: "LANFREE DATA BYTES" INCORRECTLY COUNTED IN THE STATISTICS REPORT AFTER A SUCCESSFUL "RESTORE VM"

Subscribe

You can track all active APARs for this component.

 

APAR status

  • Closed as program error.

Error description

  • At the end of a successful RESTORE VM using Tivoli Storage
    Manager Client and/or Tivoli Data Protection for Virtual
    Environments in combination with Tivoli Storage Manager Storage
    Agent, the statistics report shows a wrong bytes count for the
    "LanFree data bytes".
    
    This is an example of a wrong bytes calculation in the final
    statistics report:
    
    ************************
    Total number of objects restored:             1
    Total number of objects failed:               0
    Total number of bytes transferred:         8.49 GB
    LanFree data bytes:                        5.23 MB        <<<<<<
    Data transfer time:                      290.42 sec
    Network data transfer rate:           30,672.92 KB/sec
    Aggregate data transfer rate:         27,278.90 KB/sec
    Elapsed processing time:               00:05:26
    
    ************************
    
    In this example, even if the whole virtual machine restore has
    been performed through the Storage Area Network using Storage
    Agent, only 5.23 MB has been reported as "LanFree data bytes".
    
    Customer/L2 Diagnostics:
    
    A trace collected with the traceflags "service api api_detail
    session vm enter exit" shows that the client calculates only
    bytes from VB_Data and VB_ExtData verbs, while during vm data
    restore the client uses VB_PartialObjDataEnh and
    VB_PartialObjData to transfer the data.
    
    In this specific case the verb 1B00 is PartialObjDataEnh and it
    is used to transport data restoring the vm.
    
    ***************************************************
    ..\..\common\vs\DccVsLanFreeProtocol.cpp(3519):
    ListenOnStorageAgentInbound(000000B8E713C870): Received Server
    verb 1B00.
    ..\..\common\vs\DccVsLanFreeProtocol.cpp(3668):
    ListenOnStorageAgentInbound(000000B8E713C870): Proxying verb
    1B00 to client
    ..\..\common\com\commtsm.cpp( 758): TsmWrite(e7111af8): Placing
    buffer e9495050 on write queue.
    ..\..\common\ut\dsfifo.cpp( 265): fifoQinsert(000000B8E35A6DD0):
    Producer is waiting on consumer
    ..\..\common\ut\dsfifo.cpp( 269): fifoQinsert() Thread 6152
    waiting on queue 000000B8E35A6DD0 .
    vmvddksdk.cpp       (2917): <========= Exiting vddksdkWrite()
    ..\..\common\vm\vmcommonrestvddk.cpp(1403): vmRestoreExtent():
    Writing disk: startSector=786432 numberOfSectors=512
    startByteOffset=402653184, rc=0
    ..\..\common\vm\vmcommonrestvddk.cpp(1239): vmRestoreExtent():
    Sectors left to restore=261632; Restoring 512 sectors
    ..\..\common\vm\vmAPISendData.cpp(2542): =========> Entering
    vmAPISendData::getData()
    ***************************************************
    
    This trace explains why the RESTORE operation ONLY is affected.
    
    Again, the trace shows that if the data comes via data verb, the
    client correctly calculates it adding the size to the
    VsAgntDataBytesRecv:
    
    ***************************************************
     ..\..\common\com\session.cpp(4822):   Length:    81 Code:
    00010005 Type:    <- GetStatsResp
     ..\..\common\cu\cucommon.cpp(4917):
    Contents of verb (0x10005) GetStatsResp, length: 81:
    version             : 0x1
    VsAgntBytesSentHi   : 0
    VsAgntBytesSentLo   : 23
    VsAgntBytesRecvHi   : 0
    VsAgntBytesRecvLo   : 74298 <<<<<<
    VsAgntDataBytesSentHi: 0
    VsAgntDataBytesSentLo: 0
    VsAgntDataBytesRecvHi: 0
    VsAgntDataBytesRecvLo: 74251 <<<<<<
    ***************************************************
    
    If the data comes via PartialObjData the client does not update
    VsAgntDataBytesRecv and statistics are not updated:
    
    ***************************************************
    ..\..\common\com\session.cpp(4822):   Length:    81 Code:
    00010005 Type:    <- GetStatsResp
    ..\..\common\cu\cucommon.cpp(4917):
    Contents of verb (0x10005) GetStatsResp, length: 81:
    version             : 0x1
    VsAgntBytesSentHi   : 0
    VsAgntBytesSentLo   : 97
    VsAgntBytesRecvHi   : 0
    VsAgntBytesRecvLo   : 88084545 <<<<<<
    VsAgntDataBytesSentHi: 0
    VsAgntDataBytesSentLo: 0
    VsAgntDataBytesRecvHi: 0
    VsAgntDataBytesRecvLo: 0 <<<<<<
    ***************************************************
    
    Tivoli Storage Manager Versions Affected:
    Tivoli Storage Manager client 7.1.x on all supported platforms
    
    Initial Impact:
    Low
    
    Additional Keywords:
    restore vm lanfree count bytes wrong lan san backup
    

Local fix

Problem summary

  • ****************************************************************
    * USERS AFFECTED: Backup-archive client versions 6.4 and 7.1   *
    *                 running on Microsoft Windows and             *
    *                 Linux x86_64 platforms.                      *
    ****************************************************************
    * PROBLEM DESCRIPTION: See ERROR DESCRIPTION                   *
    ****************************************************************
    * RECOMMENDATION: Apply fixing level when available. ThisPR    *
    *                 problem is currently projected to be fixed   *
    *                 in levels 6.4.3 and 7.1.1. Note that this    *
    *                 is subject to change at the discretion of    *
    *                 IBM.                                         *
    ****************************************************************
    *
    

Problem conclusion

  • Lan-Free statistic is now correctly calculated.
    

Temporary fix

Comments

APAR Information

  • APAR number

    IT02287

  • Reported component name

    TSM CLIENT

  • Reported component ID

    5698ISMCL

  • Reported release

    71W

  • Status

    CLOSED PER

  • PE

    NoPE

  • HIPER

    NoHIPER

  • Special Attention

    NoSpecatt

  • Submitted date

    2014-06-09

  • Closed date

    2014-06-26

  • Last modified date

    2014-06-26

  • APAR is sysrouted FROM one or more of the following:

  • APAR is sysrouted TO one or more of the following:

Modules/Macros

  • DSMAGENT
    

Fix information

  • Fixed component name

    TSM CLIENT

  • Fixed component ID

    5698ISMCL

Applicable component levels

  • R64L PSY

       UP

  • R64W PSY

       UP

  • R71L PSY

       UP

  • R71W PSY

       UP

[{"Business Unit":{"code":"BU058","label":"IBM Infrastructure w\/TPS"},"Product":{"code":"SSGSG7","label":"Tivoli Storage Manager"},"Platform":[{"code":"PF025","label":"Platform Independent"}],"Version":"71W","Line of Business":{"code":"LOB26","label":"Storage"}}]

Document Information

Modified date:
08 January 2022