Networker continuously Load same volume

Question

Hi, i have this issue with a stk L40, i paste the log file, as you can see the library load and unload the tape D00105 continuously.

Why is this happening? any ideas?

Thanks in advance.

12361 4/24/09 7:40:50 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd [Jukebox `STK@4.1.2', operation # 129]. Finished with status: succeeded
0 4/24/09 7:41:52 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd Operation 130 started : Load volume `D00105', volume id `2934435190'..
12361 4/24/09 7:41:57 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd [Jukebox `STK@4.1.2', operation # 130]. Finished with status: succeeded
0 4/24/09 7:42:57 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd Operation 131 started : Load volume `D00105', volume id `2934435190'..
12361 4/24/09 7:43:02 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd [Jukebox `STK@4.1.2', operation # 131]. Finished with status: succeeded
0 4/24/09 7:44:05 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd Operation 132 started : Load volume `D00105', volume id `2934435190'..
12361 4/24/09 7:44:10 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd [Jukebox `STK@4.1.2', operation # 132]. Finished with status: succeeded
0 4/24/09 7:45:21 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd Operation 133 started : Load volume `D00105', volume id `2934435190'..
12361 4/24/09 7:45:26 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd [Jukebox `STK@4.1.2', operation # 133]. Finished with status: succeeded
0 4/24/09 7:46:37 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd Operation 134 started : Load volume `D00105', volume id `2934435190'..
12361 4/24/09 7:46:40 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd [Jukebox `STK@4.1.2', operation # 134]. Finished with status: succeeded
0 4/24/09 7:47:55 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd Operation 135 started : Load volume `D00105', volume id `2934435190'..
42502 4/24/09 7:47:55 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd media alert event: Waiting for 1 writable volumes to backup pool 'RedPool' tape(s) on vtfuesapbk.fuesap.fuenlabrada.vt.valeo
12361 4/24/09 7:47:58 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd [Jukebox `STK@4.1.2', operation # 135]. Finished with status: succeeded
0 4/24/09 7:49:14 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd Operation 136 started : Load volume `D00105', volume id `2934435190'..
12361 4/24/09 7:49:18 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd [Jukebox `STK@4.1.2', operation # 136]. Finished with status: succeeded
0 4/24/09 7:50:33 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd Operation 137 started : Load volume `D00105', volume id `2934435190'..
12361 4/24/09 7:50:38 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd [Jukebox `STK@4.1.2', operation # 137]. Finished with status: succeeded
0 4/24/09 7:51:53 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd Operation 138 started : Load volume `D00105', volume id `2934435190'..
12361 4/24/09 7:51:58 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd [Jukebox `STK@4.1.2', operation # 138]. Finished with status: succeeded
0 4/24/09 7:53:18 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd Operation 139 started : Load volume `D00105', volume id `2934435190'..
12361 4/24/09 7:53:22 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd [Jukebox `STK@4.1.2', operation # 139]. Finished with status: succeeded
0 4/24/09 7:54:44 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd Operation 140 started : Load volume `D00105', volume id `2934435190'..
12361 4/24/09 7:54:49 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd [Jukebox `STK@4.1.2', operation # 140]. Finished with status: succeeded
0 4/24/09 7:56:18 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd Operation 141 started : Load volume `D00105', volume id `2934435190'..
12361 4/24/09 7:56:21 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd [Jukebox `STK@4.1.2', operation # 141]. Finished with status: succeeded
0 4/24/09 7:58:01 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd Operation 142 started : Load volume `D00105', volume id `2934435190'..
38758 4/24/09 7:58:01 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd media request critical: Waiting for 1 writable volumes to backup pool 'RedPool' tape on vtfuesapbk.fuesap.fuenlabrada.vt.valeo
42502 4/24/09 7:58:01 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd media critical event: Waiting for 1 writable volumes to backup pool 'RedPool' tape(s) on vtfuesapbk.fuesap.fuenlabrada.vt.valeo
12361 4/24/09 7:58:05 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd [Jukebox `STK@4.1.2', operation # 142]. Finished with status: succeeded
0 4/24/09 7:59:51 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd Operation 143 started : Load volume `D00105', volume id `2934435190'..
12361 4/24/09 7:59:55 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd [Jukebox `STK@4.1.2', operation # 143]. Finished with status: succeeded
0 4/24/09 8:01:45 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd Operation 144 started : Load volume `D00105', volume id `2934435190'..
12361 4/24/09 8:01:49 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd [Jukebox `STK@4.1.2', operation # 144]. Finished with status: succeeded
38758 4/24/09 8:03:43 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd media request critical: Waiting for 0 writable volumes to backup pool 'RedPool' tape on vtfuesapbk.fuesap.fuenlabrada.vt.valeo
42504 4/24/09 8:03:43 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd media event cleared: Waiting for 1 writable volumes to backup pool 'RedPool' tape(s) on vtfuesapbk.fuesap.fuenlabrada.vt.valeo
0 4/24/09 8:04:37 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd Operation 145 started : Load volume `D00105', volume id `2934435190'..
42502 4/24/09 8:04:37 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd media waiting event: Waiting for 1 writable volumes to backup pool 'RedPool' tape(s) on vtfuesapbk.fuesap.fuenlabrada.vt.valeo
12361 4/24/09 8:04:42 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd [Jukebox `STK@4.1.2', operation # 145]. Finished with status: succeeded
0 4/24/09 8:04:47 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd Operation 146 started : Load volume `D00105', volume id `2934435190'..
12361 4/24/09 8:04:52 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd [Jukebox `STK@4.1.2', operation # 146]. Finished with status: succeeded
0 4/24/09 8:05:00 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd Operation 147 started : Load volume `D00105', volume id `2934435190'..
12361 4/24/09 8:05:04 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd [Jukebox `STK@4.1.2', operation # 147]. Finished with status: succeeded
0 4/24/09 8:05:22 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd Operation 148 started : Load volume `D00105', volume id `2934435190'..
12361 4/24/09 8:05:26 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd [Jukebox `STK@4.1.2', operation # 148]. Finished with status: succeeded
0 4/24/09 8:05:52 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd Operation 149 started : Load volume `D00105', volume id `2934435190'..
12361 4/24/09 8:05:56 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd [Jukebox `STK@4.1.2', operation # 149]. Finished with status: succeeded
0 4/24/09 8:06:28 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd Operation 150 started : Load volume `D00105', volume id `2934435190'..
12361 4/24/09 8:06:32 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd [Jukebox `STK@4.1.2', operation # 150]. Finished with status: succeeded
0 4/24/09 8:07:06 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd Operation 151 started : Load volume `D00105', volume id `2934435190'..
12361 4/24/09 8:07:10 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd [Jukebox `STK@4.1.2', operation # 151]. Finished with status: succeeded
0 4/24/09 8:07:44 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd Operation 152 started : Load volume `D00105', volume id `2934435190'..
12361 4/24/09 8:07:48 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd [Jukebox `STK@4.1.2', operation # 152]. Finished with status: succeeded
0 4/24/09 8:08:25 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd Operation 153 started : Load volume `D00105', volume id `2934435190'..
12361 4/24/09 8:08:29 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd [Jukebox `STK@4.1.2', operation # 153]. Finished with status: succeeded
0 4/24/09 8:09:12 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd Operation 154 started : Load volume `D00105', volume id `2934435190'..
12361 4/24/09 8:09:17 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd [Jukebox `STK@4.1.2', operation # 154]. Finished with status: succeeded
0 4/24/09 8:10:05 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd Operation 155 started : Load volume `D00105', volume id `2934435190'..
12361 4/24/09 8:10:09 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd [Jukebox `STK@4.1.2', operation # 155]. Finished with status: succeeded
0 4/24/09 8:11:02 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd Operation 156 started : Load volume `D00105', volume id `2934435190'..
12361 4/24/09 8:11:07 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd [Jukebox `STK@4.1.2', operation # 156]. Finished with status: succeeded
0 4/24/09 8:12:05 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd Operation 157 started : Load volume `D00105', volume id `2934435190'..
12361 4/24/09 8:12:09 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd [Jukebox `STK@4.1.2', operation # 157]. Finished with status: succeeded
0 4/24/09 8:13:17 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd Operation 158 started : Load volume `D00105', volume id `2934435190'..
12361 4/24/09 8:13:21 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd [Jukebox `STK@4.1.2', operation # 158]. Finished with status: succeeded
0 4/24/09 8:14:38 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd Operation 159 started : Load volume `D00105', volume id `2934435190'..
12361 4/24/09 8:14:41 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd [Jukebox `STK@4.1.2', operation # 159]. Finished with status: succeeded
38714 4/24/09 8:15:32 PM 0 0 2 3884 3484 0 vtfuesapbk nsrd vt-fue-sfs1.fuenlabrada.vt.valeo:E:\ done saving to pool 'RedPool' (D00023) 34 GB
42506 4/24/09 8:15:32 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd savegroup warning: Inactive files in saveset E:\ on host vt-fue-sfs1.fuenlabrada.vt.valeo. occupy 70.00 percent of the used space, which exceeds threshold of 30 percent configured for this client
0 4/24/09 8:15:40 PM 2 0 0 2772 3312 0 vtfuesapbk nsrmmdbd pools supported: RedPool;
0 4/24/09 8:16:03 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd Operation 160 started : Load volume `D00105', volume id `2934435190'..
42506 4/24/09 8:16:03 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd write completion notice: Writing to volume D00023 complete
12361 4/24/09 8:16:07 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd [Jukebox `STK@4.1.2', operation # 160]. Finished with status: succeeded
0 4/24/09 8:17:29 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd Operation 161 started : Load volume `D00105', volume id `2934435190'..
12361 4/24/09 8:17:33 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd [Jukebox `STK@4.1.2', operation # 161]. Finished with status: succeeded
0 4/24/09 8:17:44 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd Operation 162 started : Unload jukebox device `rd=vt-fue-sfs1.fuenlabrada.vt.valeo:\\.\Tape0'..
38752 4/24/09 8:17:45 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd rd=vt-fue-sfs1.fuenlabrada.vt.valeo:\\.\Tape0 2:Eject operation in progress
0 4/24/09 8:19:01 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd Operation 163 started : Load volume `D00105', volume id `2934435190'..
12361 4/24/09 8:19:05 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd [Jukebox `STK@4.1.2', operation # 163]. Finished with status: succeeded
12361 4/24/09 8:19:45 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd [Jukebox `STK@4.1.2', operation # 162]. Finished with status: succeeded
0 4/24/09 8:20:41 PM 2 0 0 3884 3484 0 vtfuesapbk nsrd Operation 164 started : Load volume `D00105', volume id `2934435190'..

smora1 · Answer

Could you be some finer in your explication? Have you tried to restart NetWorker services? Please, also check that no nsrjb is hanging.

BGuevara · Answer

Yes i already try that with no results.

IKP1 · Answer

Hi,1) Shutting down ALL NetWorker services. 2) Delete ALL contents of the nsr/tmp directory3) Start ALL NetWorker services4) Perform a library element reset from the command line # nsrjb -HEvvvHTHIKP

BGuevara · Answer

Hi all thank 4 your replies, i notice that a slot that was configured as cleaning slot has a normal tape, i change it and all is working correctly now.Regardsssss.

BGuevara · Answer

i notice that a slot that was configured as cleaning slot has a normal tape, i change it and all is working properly now.

mahendra85 · Answer

Hi ,

I have same issue as below

Succeeded false Unload jukebox device `rd=xyz:/dev/tape/by-id/scsi-1IBM_ULTRIUM-TD3_74202100B8-nst'. 12 succeeded

Succeeded false Load volume `P00991', volume id `202248516'. 16 succeeded

Succeeded false Load volume `P01017', volume id `185471300'. 15 succeeded

As per above suggestion I have to restart networker services .. as I get even after reboot of networker as well...

As this backup are running on Storage Node i.e module are NDMA oracle backup's getting above on Data domain VTL's...

NetWorker

Networker continuously Load same volume

Was this post helpful?