Import phase 2 just sits on begin reading

[Giroevolver]

Hi Guys,

I am import some backup exec media in to Netbackup but it seems to be hanging?!? I'm not sure if this is normal or not as I havent needed to do this before!

Detailed status is shown below

24/06/2009 16:45:23 - requesting resource A00002
24/06/2009 16:45:23 - granted resource A00002
24/06/2009 16:45:23 - granted resource HP.ULTRIUM3-SCSI.001
24/06/2009 16:45:25 - started process bptm (5952)
24/06/2009 16:45:25 - mounting A00002
24/06/2009 16:46:00 - mounted; mount time: 00:00:35
24/06/2009 16:46:00 - positioning A00002 to file 1
24/06/2009 16:46:00 - positioned A00002; position time: 00:00:00
24/06/2009 16:46:00 - begin reading

It seems to be just sitting there with no speed and no kilobytes written. Does anyone know if this is normal?

Thanks

[Abesama]

It should say something more, about reading files from the tape.

But  the import phase 2 does take time, about the same amount of time as you do restore which will be time(and half) of backup.

So leave it for a while, at least for an hour or two?

Abe

[Giroevolver · Accepted solution]

I have answered this myself.
 
It seems this is normal! My import has complete and it doesnt show any bytes written or speed or files read! How horrible is that. you think they would give you a clue that its doing something :)

However on a job that is spanned accross tapes it does make a change when tapes are changed see below:

24/06/2009 16:45:17 - begin Import
24/06/2009 16:45:23 - started process bptm (5952)
24/06/2009 16:45:23 - started process bptm (5000)
24/06/2009 16:45:23 - requesting resource A00002
24/06/2009 16:45:23 - granted resource A00002
24/06/2009 16:45:23 - granted resource HP.ULTRIUM3-SCSI.001
24/06/2009 16:45:25 - started process bptm (5952)
24/06/2009 16:45:25 - mounting A00002
24/06/2009 16:46:00 - mounted; mount time: 00:00:35
24/06/2009 16:46:00 - positioning A00002 to file 1
24/06/2009 16:46:00 - positioned A00002; position time: 00:00:00
24/06/2009 16:46:00 - begin reading
24/06/2009 19:41:46 - end reading; read time: 02:55:46
24/06/2009 19:41:46 - current media A00002 complete, requesting next resource HP.ULTRIUM3-SCSI.001:A00004
24/06/2009 19:41:46 - granted resource A00004
24/06/2009 19:41:46 - granted resource HP.ULTRIUM3-SCSI.000
24/06/2009 19:41:48 - started process bptm (5952)
24/06/2009 19:41:48 - mounting A00004
24/06/2009 19:42:24 - mounted; mount time: 00:00:36
24/06/2009 19:42:24 - positioning A00004 to file 1
24/06/2009 19:42:24 - positioned A00004; position time: 00:00:00
24/06/2009 19:42:24 - begin reading
24/06/2009 22:07:56 - end reading; read time: 02:25:32
24/06/2009 22:07:56 - current media A00004 complete, requesting next resource HP.ULTRIUM3-SCSI.000:A00007
24/06/2009 22:07:56 - granted resource A00007
24/06/2009 22:07:56 - granted resource HP.ULTRIUM3-SCSI.001
24/06/2009 22:07:58 - started process bptm (5952)
24/06/2009 22:07:58 - mounting A00007
24/06/2009 22:08:35 - mounted; mount time: 00:00:37
24/06/2009 22:08:35 - positioning A00007 to file 1
24/06/2009 22:08:35 - positioned A00007; position time: 00:00:00
24/06/2009 22:08:35 - begin reading
25/06/2009 00:22:32 - end reading; read time: 02:13:57
25/06/2009 00:22:32 - current media A00007 complete, requesting next resource HP.ULTRIUM3-SCSI.001:A00005
25/06/2009 00:22:32 - granted resource A00005
25/06/2009 00:22:32 - granted resource HP.ULTRIUM3-SCSI.000
25/06/2009 00:22:34 - started process bptm (5952)
25/06/2009 00:22:34 - mounting A00005
25/06/2009 00:23:10 - mounted; mount time: 00:00:36
25/06/2009 00:23:10 - positioning A00005 to file 1
25/06/2009 00:23:10 - positioned A00005; position time: 00:00:00
25/06/2009 00:23:10 - begin reading
25/06/2009 03:21:17 - end reading; read time: 02:58:07
25/06/2009 03:21:17 - current media A00005 complete, requesting next resource HP.ULTRIUM3-SCSI.000:A00001
25/06/2009 03:21:18 - granted resource A00001
25/06/2009 03:21:18 - granted resource HP.ULTRIUM3-SCSI.001
25/06/2009 03:21:19 - started process bptm (5952)
25/06/2009 03:21:19 - mounting A00001
25/06/2009 03:21:56 - mounted; mount time: 00:00:37
25/06/2009 03:21:56 - positioning A00001 to file 1
25/06/2009 03:21:56 - positioned A00001; position time: 00:00:00
25/06/2009 03:21:56 - begin reading
25/06/2009 06:05:15 - end reading; read time: 02:43:19
25/06/2009 06:05:15 - current media A00001 complete, requesting next resource HP.ULTRIUM3-SCSI.001:A00000
25/06/2009 06:05:15 - awaiting resource HP.ULTRIUM3-SCSI.001:A00000 Reason: Drives are in use, Media Server: crw-nbu01,
Robot Number: 0, Robot Type: TLD, Media ID: N/A, Drive Name: N/A,
Volume Pool: N/A, Storage Unit: N/A, Drive Scan Host: N/A

25/06/2009 06:05:59 - granted resource A00000
25/06/2009 06:05:59 - granted resource HP.ULTRIUM3-SCSI.001
25/06/2009 06:06:01 - started process bptm (5952)
25/06/2009 06:06:01 - mounting A00000
25/06/2009 06:06:36 - mounted; mount time: 00:00:35
25/06/2009 06:06:37 - positioning A00000 to file 1
25/06/2009 06:06:37 - positioned A00000; position time: 00:00:00
25/06/2009 06:06:37 - begin reading
25/06/2009 08:22:56 - end reading; read time: 02:16:19
25/06/2009 08:22:56 - current media A00000 complete, requesting next resource HP.ULTRIUM3-SCSI.001:A00008
25/06/2009 08:22:56 - awaiting resource HP.ULTRIUM3-SCSI.001:A00008 Reason: Drives are in use, Media Server: crw-nbu01,
Robot Number: 0, Robot Type: TLD, Media ID: N/A, Drive Name: N/A,
Volume Pool: N/A, Storage Unit: N/A, Drive Scan Host: N/A

25/06/2009 08:23:40 - started process bptm (5952)
25/06/2009 08:23:40 - mounting A00008
25/06/2009 08:23:40 - granted resource A00008
25/06/2009 08:23:40 - granted resource HP.ULTRIUM3-SCSI.001
25/06/2009 08:24:15 - mounted; mount time: 00:00:35
25/06/2009 08:24:15 - positioning A00008 to file 1
25/06/2009 08:24:15 - positioned A00008; position time: 00:00:00
25/06/2009 08:24:15 - begin reading

Thanks for your help anyway!