@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@ Machine : isydmgcvcel01.infoplex.int File : CVD.log @@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@ 2720 13b8 12/17 14:56:40 5260 [DSBACKUP ] Head port to connect to machine isydmgcvcel01.infoplex.int on 4591 2720 13b8 12/17 14:56:40 5260 [DSBACKUP ] tail trying to connect to M/C 192.168.16.48 at port 4591 2720 13b8 12/17 14:56:40 5260 [DSBACKUP ] Connect succeeded to head module on machine isydmgcvcel01.infoplex.int on port 4591 2720 13b8 12/17 14:56:40 5260 [DSBACKUP ] Keeping Head/Tail Socket Alive 2720 13b8 12/17 14:56:40 5260 [DSBACKUP ] Keeping Head/Tail Socket Alive Type: 16 SubType: 261 Status: 0 EventErrorCode: 0 2720 13b8 12/17 14:56:40 5260 [DSBACKUP ] DsBackup received a Init Message 2720 13b8 12/17 14:56:40 5260 [DSBACKUP ] Initialzie job client with token [5260:6:1] 2720 13b8 12/17 14:56:40 5260 JM Client CVBkpJobClient::init(): Initializing job object with token [5260:6:1]. 2720 13b8 12/17 14:56:40 5260 [DSBACKUP ] initializing datamover with Storage Policy Number: 9 MediaGroup ID: 25 2720 13b8 12/17 14:56:40 5260 [DM_RECEIVER] Did not find a DataWriter for the media group [25] 2720 13b8 12/17 14:56:40 5260 [DM_RECEIVER] Instantiating the NAS DataMover for MediaGroup Id [25] 2720 13b8 12/17 14:56:40 5260 [DM_RECEIVER] Added a new DataWriter for the media group [25].. will proceed to mount 2720 13b8 12/17 14:56:40 5260 [DM_RECEIVER] USE COUNT for media group [25] is [1] 2720 13b8 12/17 14:56:40 5260 [DM_BASE ] Initialising DataMoverBase for MediaGroupId = 25 ... 2720 13b8 12/17 14:56:40 5260 [DM_BASE ] Maximum Number of Archive Files allowed per Chunk during write mode is :20 ... 2720 13b8 12/17 14:56:40 5260 [DM_BASE ] DataMoverMaxMountRetryValue [0] DataMoverMaxMountRetrySleepTime [0] DataMoverMaxReadRetryValue [0] DataMoverWaitTimeBeforeChunkCloseInSec [0] DataMoverCloseChunkImmediately [0] 2720 13b8 12/17 14:56:40 5260 [DM_BASE ] DataMoverMonitorThreadRetryValue [5], DataMoverMonitorThreadSleepValueMins[10] 2720 13b8 12/17 14:56:40 5260 [DM_BASE ] Going to mount MediaGroupId = 25 for writing 2720 13b8 12/17 14:56:42 5260 [DM_BASE ] Succesfully mounted Active volume 834 MediaGroupId = 25 for writing. Reservation id [4260] 2720 13b8 12/17 14:56:42 5260 [DM_BASE ] Looks like it is SDM, NAS, Centera or Single Instance backup 2720 13b8 12/17 14:56:42 5260 [MEDIAFS ] The volume will be recorded with the block size [64] KB 2720 13b8 12/17 14:56:42 5260 [MEDIAFS ] Connecting and Authenticating MOVER... 2720 13b8 12/17 14:56:42 #### ndmp.cpp 649 CONNECT: opening socket connection to host [192.168.16.112] port [10000] 2720 13b8 12/17 14:56:42 #### ndmp.cpp 687 CONNECT successful: Now waiting for NOTIFY_CONNECTED message. 2720 13b8 12/17 14:56:42 #### ndmp.cpp 687 NDMP_NOTIFY_CONNECTED: recived ndmp_notify_connected. Version is [4] 2720 13b8 12/17 14:56:42 #### ndmp.cpp 1995 NDMP_CONNECT_OPEN: protocol_version[4] 2720 13b8 12/17 14:56:42 #### ndmp.cpp 2009 NDMP_CONNECT_OPEN: successful 2720 13b8 12/17 14:56:42 #### ndmp.cpp 2009 NDMP_NOTIFY_CONNECTED: successful. Version is [4] 2720 13b8 12/17 14:56:42 #### ndmp_v4.cpp 858 NDMP_CONFIG_GET_SERVER_INFO: 2720 13b8 12/17 14:56:42 #### ndmp_v4.cpp 858 NDMP DEBUG 0: The process id for NDMP service is 0xb1242d6c 2720 13b8 12/17 14:56:42 #### ndmp.cpp 1406 Message not replied to yet. 2720 13b8 12/17 14:56:42 #### ndmp.cpp 972 Reply to msg 0x108 not yet received, continuing. 2720 13b8 12/17 14:56:43 #### ndmp_v4.cpp 884 NDMP_CONFIG_GET_SERVER_INFO: successful. Vendor[EMC2] Product[CELERRA] Revision[T.5.5.22.207] AuthType[1] 2720 13b8 12/17 14:56:43 #### ndmp_v4.cpp 749 NDMP_CONNECT_CLIENT_AUTH: login[ndmp] mode[1=NDMP_AUTH_TEXT] 2720 13b8 12/17 14:56:43 #### ndmp_v4.cpp 768 NDMP_CONNECT_CLIENT_AUTH: successful 2720 13b8 12/17 14:56:43 #### ndmp_v4.cpp 808 NDMP_CONFIG_GET_HOST_INFO: 2720 13b8 12/17 14:56:43 #### ndmp_v4.cpp 829 NDMP_CONFIG_GET_HOST_INFO: successful. Host[server_2] OsType[DartOS] Version[EMC Celerra File Server.T.5.5.22.207] HostId[abc1997] 2720 13b8 12/17 14:56:43 #### ndmp_v4.cpp 858 NDMP_CONFIG_GET_SERVER_INFO: 2720 13b8 12/17 14:56:43 #### ndmp_v4.cpp 884 NDMP_CONFIG_GET_SERVER_INFO: successful. Vendor[EMC2] Product[CELERRA] Revision[T.5.5.22.207] AuthType[1] 2720 13b8 12/17 14:56:43 #### [DM_MONITOR ] ConnetionRetryValue [5], SleepIntervalInMins [10] 2720 13b8 12/17 14:56:43 5260 JM Client CVBkpJobClient::init(): Initializing job object with token [5260:6:1]. 2720 13b8 12/17 14:56:43 5260 [DM_RECEIVER] DataReciever Init Successfull for the Primary Data Writer 2720 13b8 12/17 14:56:43 5260 [DSBACKUP ] dsBackup initialization success Type: 16 SubType: 136 Status: 0 EventErrorCode: 0 2720 13b8 12/17 14:56:44 5260 [DM_BASE ] Trying to create archive file : afileId = 13616, ArchiveFileSeqNo = 0,FirstChunkSeqNo= 0, logical_offset = 0, physical_offset = 0 2720 13b8 12/17 14:56:45 5260 [DM_BASE ] The size of the chunk will be 2048 MB 2720 13b8 12/17 14:56:45 5260 [DM_BASE ] Creating new chunk chunk id 41705 VolId= 834 after setting the volume id for the chunk in the database 2720 13b8 12/17 14:56:45 #### ndmp_v4.cpp 1560 NDMP_TAPE_OPEN: Device[c128t0l0] Mode[1] 2720 13b8 12/17 14:56:45 #### ndmp_v4.cpp 1579 NDMP_TAPE_OPEN: successful 2720 13b8 12/17 14:56:45 #### ndmp_v4.cpp 1855 NDMP_TAPE_EXECUTE_CDB: direction[1]buflen[255] 1a 08 0f 00 ff 00 2720 13b8 12/17 14:56:45 #### ndmp_v4.cpp 1889 NDMP_TAPE_EXECUTE_CDB: successful 2720 13b8 12/17 14:56:45 #### ndmp_v4.cpp 1893 NDMP_TAPE_EXECUTE_CDB: status code: 0 2720 13b8 12/17 14:56:45 5260 [MEDIAFS ] Hardware compression set ON. 2720 13b8 12/17 14:56:45 5260 [MEDIAFS ] NasMfs is forwarding to fileMarker=4 on the Tape volId=834 2720 13b8 12/17 14:56:45 5260 [MEDIAFS ] Tape is currently positioned at file marker 4. We need to go to mark 4. 2720 13b8 12/17 14:56:45 5260 [MEDIAFS ] tape will be positioned to 4 (curFileNumber=-1, atFilemark false) 2720 13b8 12/17 14:56:45 #### ndmp_v4.cpp 1633 NDMP_TAPE_GET_STATE: 2720 13b8 12/17 14:56:45 #### ndmp_v4.cpp 1672 NDMP_TAPE_GET_STATE: successful. Flags[0x8] TotalSpace[18446744073709551615] SpaceRemain[0] BlockSize[0] BlockNo[-1] FileNum[-1] SoftErrors[-1] 2720 13b8 12/17 14:56:45 #### ndmp_tape.cpp 220 MTIO: Current file num unknown. 2720 13b8 12/17 14:56:45 #### ndmp_tape.cpp 256 MTIO: Rewinding - current file num unknown. 2720 13b8 12/17 14:56:45 #### ndmp_v4.cpp 1706 NDMP_TAPE_MTIO: Operation[4] Count[1] 2720 13b8 12/17 14:56:52 #### ndmp_v4.cpp 1725 NDMP_TAPE_MTIO: successful. Count[0] 2720 13b8 12/17 14:56:52 #### ndmp_v4.cpp 1706 NDMP_TAPE_MTIO: Operation[0] Count[4] 2720 13b8 12/17 14:56:56 #### ndmp_v4.cpp 1725 NDMP_TAPE_MTIO: successful. Count[0] 2720 13b8 12/17 14:56:56 #### ndmp_v4.cpp 1633 NDMP_TAPE_GET_STATE: 2720 13b8 12/17 14:56:56 #### ndmp_v4.cpp 1672 NDMP_TAPE_GET_STATE: successful. Flags[0x8] TotalSpace[18446744073709551615] SpaceRemain[0] BlockSize[0] BlockNo[0] FileNum[4] SoftErrors[-1] 2720 13b8 12/17 14:56:56 #### ndmp_tape.cpp 420 MTIO: Ending state. File Num[4]. Target file num[4]. 2720 13b8 12/17 14:56:56 5260 [MEDIAFS ] Updating volume to indicate position is 4. 2720 13b8 12/17 14:56:56 #### ndmp_v4.cpp 2527 NDMP_MOVER_SET_RECORD_SIZE: RecSize[65536] 2720 13b8 12/17 14:56:56 #### ndmp_v4.cpp 2542 NDMP_MOVER_SET_RECORD_SIZE: successful 2720 13b8 12/17 14:56:56 #### ndmp_v4.cpp 2568 NDMP_MOVER_SET_WINDOW: Offset[0] Length[2147483648] 2720 13b8 12/17 14:56:56 #### ndmp_v4.cpp 2583 NDMP_MOVER_SET_WINDOW: successful 2720 13b8 12/17 14:56:56 #### ndmp_v4.cpp 2479 NDMP_MOVER_LISTEN: mode[0] addr_type[1] 2720 13b8 12/17 14:56:56 #### ndmp_v4.cpp 2501 NDMP_MOVER_LISTEN: successful 2720 13b8 12/17 14:56:56 5260 [MEDIAFS ] Attempting connect...NDMP server is listening on 1 IP/ports. 2720 13b8 12/17 14:56:56 5260 [MEDIAFS ] trying to connect to MOVER at addr 0xC0A81070 port 51150 2720 13b8 12/17 14:57:17 #### () - Connect to 192.168.16.112:51150 failed: Connection timed out 2720 13b8 12/17 14:57:17 5260 [MEDIAFS ] connect() failed: Connect to 192.168.16.112:51150 failed: Connection timed out 2720 13b8 12/17 14:57:17 5260 [MEDIAFS ] connect to listening MOVER failed. 2720 13b8 12/17 14:57:17 5260 [MEDIAFS ] NasMfs failed to position tape volId=834 to file 4