]> git.sur5r.net Git - bacula/bacula/blob - bacula/src/stored/askdir.c
Enhance FD status to have level
[bacula/bacula] / bacula / src / stored / askdir.c
1 /*
2    Bacula® - The Network Backup Solution
3
4    Copyright (C) 2000-2009 Free Software Foundation Europe e.V.
5
6    The main author of Bacula is Kern Sibbald, with contributions from
7    many others, a complete list can be found in the file AUTHORS.
8    This program is Free Software; you can redistribute it and/or
9    modify it under the terms of version two of the GNU General Public
10    License as published by the Free Software Foundation and included
11    in the file LICENSE.
12
13    This program is distributed in the hope that it will be useful, but
14    WITHOUT ANY WARRANTY; without even the implied warranty of
15    MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE. See the GNU
16    General Public License for more details.
17
18    You should have received a copy of the GNU General Public License
19    along with this program; if not, write to the Free Software
20    Foundation, Inc., 51 Franklin Street, Fifth Floor, Boston, MA
21    02110-1301, USA.
22
23    Bacula® is a registered trademark of Kern Sibbald.
24    The licensor of Bacula is the Free Software Foundation Europe
25    (FSFE), Fiduciary Program, Sumatrastrasse 25, 8006 Zürich,
26    Switzerland, email:ftf@fsfeurope.org.
27 */
28 /*
29  *  Subroutines to handle Catalog reqests sent to the Director
30  *   Reqests/commands from the Director are handled in dircmd.c
31  *
32  *   Kern Sibbald, December 2000
33  *
34  *   Version $Id$
35  */
36
37 #include "bacula.h"                   /* pull in global headers */
38 #include "stored.h"                   /* pull in Storage Deamon headers */
39
40 /* Requests sent to the Director */
41 static char Find_media[]   = "CatReq Job=%s FindMedia=%d pool_name=%s media_type=%s\n";
42 static char Get_Vol_Info[] = "CatReq Job=%s GetVolInfo VolName=%s write=%d\n";
43 static char Update_media[] = "CatReq Job=%s UpdateMedia VolName=%s"
44    " VolJobs=%u VolFiles=%u VolBlocks=%u VolBytes=%s VolMounts=%u"
45    " VolErrors=%u VolWrites=%u MaxVolBytes=%s EndTime=%s VolStatus=%s"
46    " Slot=%d relabel=%d InChanger=%d VolReadTime=%s VolWriteTime=%s"
47    " VolFirstWritten=%s VolParts=%u\n";
48 static char Create_job_media[] = "CatReq Job=%s CreateJobMedia"
49    " FirstIndex=%u LastIndex=%u StartFile=%u EndFile=%u"
50    " StartBlock=%u EndBlock=%u Copy=%d Strip=%d MediaId=%s\n";
51 static char FileAttributes[] = "UpdCat Job=%s FileAttributes ";
52 static char Job_status[]     = "Status Job=%s JobStatus=%d\n";
53
54 /* Responses received from the Director */
55 static char OK_media[] = "1000 OK VolName=%127s VolJobs=%u VolFiles=%lu"
56    " VolBlocks=%lu VolBytes=%lld VolMounts=%lu VolErrors=%lu VolWrites=%lu"
57    " MaxVolBytes=%lld VolCapacityBytes=%lld VolStatus=%20s"
58    " Slot=%ld MaxVolJobs=%lu MaxVolFiles=%lu InChanger=%ld"
59    " VolReadTime=%lld VolWriteTime=%lld EndFile=%lu EndBlock=%lu"
60    " VolParts=%lu LabelType=%ld MediaId=%lld\n";
61
62
63 static char OK_create[] = "1000 OK CreateJobMedia\n";
64
65 static pthread_mutex_t vol_info_mutex = PTHREAD_MUTEX_INITIALIZER;
66
67 #ifdef needed
68
69 static char Device_update[] = "DevUpd Job=%s device=%s "
70    "append=%d read=%d num_writers=%d "
71    "open=%d labeled=%d offline=%d "
72    "reserved=%d max_writers=%d "
73    "autoselect=%d autochanger=%d "
74    "changer_name=%s media_type=%s volume_name=%s\n";
75
76
77 /* Send update information about a device to Director */
78 bool dir_update_device(JCR *jcr, DEVICE *dev)
79 {
80    BSOCK *dir = jcr->dir_bsock;
81    POOL_MEM dev_name, VolumeName, MediaType, ChangerName;
82    DEVRES *device = dev->device;
83    bool ok;
84    
85    pm_strcpy(dev_name, device->hdr.name);
86    bash_spaces(dev_name);
87    if (dev->is_labeled()) {
88       pm_strcpy(VolumeName, dev->VolHdr.VolumeName);
89    } else {
90       pm_strcpy(VolumeName, "*");
91    }
92    bash_spaces(VolumeName);
93    pm_strcpy(MediaType, device->media_type);
94    bash_spaces(MediaType);
95    if (device->changer_res) {
96       pm_strcpy(ChangerName, device->changer_res->hdr.name);
97       bash_spaces(ChangerName);
98    } else {
99       pm_strcpy(ChangerName, "*");
100    }
101    ok = dir->fsend(Device_update, 
102       jcr->Job,
103       dev_name.c_str(),
104       dev->can_append()!=0,
105       dev->can_read()!=0, dev->num_writers, 
106       dev->is_open()!=0, dev->is_labeled()!=0,
107       dev->is_offline()!=0, dev->reserved_device, 
108       dev->is_tape()?100000:1,
109       dev->autoselect, 0, 
110       ChangerName.c_str(), MediaType.c_str(), VolumeName.c_str());
111    Dmsg1(100, ">dird: %s\n", dir->msg);
112    return ok;
113 }
114
115 bool dir_update_changer(JCR *jcr, AUTOCHANGER *changer)
116 {
117    BSOCK *dir = jcr->dir_bsock;
118    POOL_MEM dev_name, MediaType;
119    DEVRES *device;
120    bool ok;
121
122    pm_strcpy(dev_name, changer->hdr.name);
123    bash_spaces(dev_name);
124    device = (DEVRES *)changer->device->first();
125    pm_strcpy(MediaType, device->media_type);
126    bash_spaces(MediaType);
127    /* This is mostly to indicate that we are here */
128    ok = dir->fsend(Device_update,
129       jcr->Job,
130       dev_name.c_str(),         /* Changer name */
131       0, 0, 0,                  /* append, read, num_writers */
132       0, 0, 0,                  /* is_open, is_labeled, offline */
133       0, 0,                     /* reserved, max_writers */
134       0,                        /* Autoselect */
135       changer->device->size(),  /* Number of devices */
136       "0",                      /* PoolId */
137       "*",                      /* ChangerName */
138       MediaType.c_str(),        /* MediaType */
139       "*");                     /* VolName */
140    Dmsg1(100, ">dird: %s\n", dir->msg);
141    return ok;
142 }
143 #endif
144
145
146 /*
147  * Send current JobStatus to Director
148  */
149 bool dir_send_job_status(JCR *jcr)
150 {
151    return jcr->dir_bsock->fsend(Job_status, jcr->Job, jcr->JobStatus);
152 }
153
154 /*
155  * Common routine for:
156  *   dir_get_volume_info()
157  * and
158  *   dir_find_next_appendable_volume()
159  *
160  *  NOTE!!! All calls to this routine must be protected by
161  *          locking vol_info_mutex before calling it so that
162  *          we don't have one thread modifying the parameters
163  *          and another reading them.
164  *
165  *  Returns: true  on success and vol info in dcr->VolCatInfo
166  *           false on failure
167  */
168 static bool do_get_volume_info(DCR *dcr)
169 {
170     JCR *jcr = dcr->jcr;
171     BSOCK *dir = jcr->dir_bsock;
172     VOLUME_CAT_INFO vol;
173     int n;
174     int32_t InChanger;
175
176     if (dir->recv() <= 0) {
177        Dmsg0(200, "getvolname error bnet_recv\n");
178        Mmsg(jcr->errmsg, _("Network error on bnet_recv in req_vol_info.\n"));
179        return false;
180     }
181     memset(&vol, 0, sizeof(vol));
182     Dmsg1(100, "<dird %s", dir->msg);
183     n = sscanf(dir->msg, OK_media, vol.VolCatName,
184                &vol.VolCatJobs, &vol.VolCatFiles,
185                &vol.VolCatBlocks, &vol.VolCatBytes,
186                &vol.VolCatMounts, &vol.VolCatErrors,
187                &vol.VolCatWrites, &vol.VolCatMaxBytes,
188                &vol.VolCatCapacityBytes, vol.VolCatStatus,
189                &vol.Slot, &vol.VolCatMaxJobs, &vol.VolCatMaxFiles,
190                &InChanger, &vol.VolReadTime, &vol.VolWriteTime,
191                &vol.EndFile, &vol.EndBlock, &vol.VolCatParts,
192                &vol.LabelType, &vol.VolMediaId);
193     if (n != 22) {
194        Dmsg3(100, "Bad response from Dir fields=%d, len=%d: %s", 
195              n, dir->msglen, dir->msg);
196        Mmsg(jcr->errmsg, _("Error getting Volume info: %s"), dir->msg);
197        return false;
198     }
199     vol.InChanger = InChanger;        /* bool in structure */
200     unbash_spaces(vol.VolCatName);
201     bstrncpy(dcr->VolumeName, vol.VolCatName, sizeof(dcr->VolumeName));
202     dcr->VolCatInfo = vol;            /* structure assignment */
203
204     Dmsg2(100, "do_reqest_vol_info return true slot=%d Volume=%s\n",
205           vol.Slot, vol.VolCatName);
206     return true;
207 }
208
209
210 /*
211  * Get Volume info for a specific volume from the Director's Database
212  *
213  * Returns: true  on success   (Director guarantees that Pool and MediaType
214  *                              are correct and VolStatus==Append or
215  *                              VolStatus==Recycle)
216  *          false on failure
217  *
218  *          Volume information returned in dcr->VolCatInfo
219  */
220 bool dir_get_volume_info(DCR *dcr, enum get_vol_info_rw writing)
221 {
222     JCR *jcr = dcr->jcr;
223     BSOCK *dir = jcr->dir_bsock;
224
225     P(vol_info_mutex);
226     bstrncpy(dcr->VolCatInfo.VolCatName, dcr->VolumeName, sizeof(dcr->VolCatInfo.VolCatName));
227     bash_spaces(dcr->VolCatInfo.VolCatName);
228     dir->fsend(Get_Vol_Info, jcr->Job, dcr->VolCatInfo.VolCatName,
229        writing==GET_VOL_INFO_FOR_WRITE?1:0);
230     Dmsg1(100, ">dird %s", dir->msg);
231     unbash_spaces(dcr->VolCatInfo.VolCatName);
232     bool ok = do_get_volume_info(dcr);
233     V(vol_info_mutex);
234     return ok;
235 }
236
237
238
239 /*
240  * Get info on the next appendable volume in the Director's database
241  *
242  * Returns: true  on success dcr->VolumeName is volume
243  *                reserve_volume() called on Volume name
244  *          false on failure dcr->VolumeName[0] == 0
245  *                also sets dcr->found_in_use if at least one 
246  *                in use volume was found.
247  *
248  *          Volume information returned in dcr
249  *
250  */
251 bool dir_find_next_appendable_volume(DCR *dcr)
252 {
253     JCR *jcr = dcr->jcr;
254     BSOCK *dir = jcr->dir_bsock;
255     bool rtn;
256     char lastVolume[MAX_NAME_LENGTH];
257
258     Dmsg2(200, "dir_find_next_appendable_volume: reserved=%d Vol=%s\n", 
259        dcr->is_reserved(), dcr->VolumeName);
260
261     /*
262      * Try the twenty oldest or most available volumes.  Note,
263      *   the most available could already be mounted on another
264      *   drive, so we continue looking for a not in use Volume.
265      */
266     lock_volumes();
267     P(vol_info_mutex);
268     dcr->clear_found_in_use();
269     lastVolume[0] = 0;
270     for (int vol_index=1;  vol_index < 20; vol_index++) {
271        bash_spaces(dcr->media_type);
272        bash_spaces(dcr->pool_name);
273        dir->fsend(Find_media, jcr->Job, vol_index, dcr->pool_name, dcr->media_type);
274        unbash_spaces(dcr->media_type);
275        unbash_spaces(dcr->pool_name);
276        Dmsg1(100, ">dird %s", dir->msg);
277        if (do_get_volume_info(dcr)) {
278           /* Give up if we get the same volume name twice */
279           if (lastVolume[0] && strcmp(lastVolume, dcr->VolumeName) == 0) {
280              Dmsg1(100, "Got same vol = %s\n", lastVolume);
281              break;
282           }
283           bstrncpy(lastVolume, dcr->VolumeName, sizeof(lastVolume));
284           if (dcr->can_i_write_volume()) {
285              Dmsg1(100, "Call reserve_volume. Vol=%s\n", dcr->VolumeName);
286              if (reserve_volume(dcr, dcr->VolumeName) == NULL) {
287                 Dmsg2(100, "Could not reserve volume %s on %s\n", dcr->VolumeName,
288                     dcr->dev->print_name());
289                 continue;
290              }
291              Dmsg1(100, "dir_find_next_appendable_volume return true. vol=%s\n",
292                 dcr->VolumeName);
293              rtn = true;
294              goto get_out;
295           } else {
296              Dmsg1(100, "Volume %s is in use.\n", dcr->VolumeName);
297              /* If volume is not usable, it is in use by someone else */
298              dcr->set_found_in_use();
299              continue;
300           }
301        }
302        Dmsg2(100, "No vol. index %d return false. dev=%s\n", vol_index,
303           dcr->dev->print_name());
304        break;
305     }
306     rtn = false;
307     dcr->VolumeName[0] = 0;
308
309 get_out:
310     V(vol_info_mutex);
311     unlock_volumes();
312     return rtn;
313 }
314
315
316 /*
317  * After writing a Volume, send the updated statistics
318  * back to the director. The information comes from the
319  * dev record.
320  */
321 bool dir_update_volume_info(DCR *dcr, bool label, bool update_LastWritten)
322 {
323    JCR *jcr = dcr->jcr;
324    BSOCK *dir = jcr->dir_bsock;
325    DEVICE *dev = dcr->dev;
326    VOLUME_CAT_INFO *vol = &dev->VolCatInfo;
327    char ed1[50], ed2[50], ed3[50], ed4[50], ed5[50], ed6[50];
328    int InChanger;
329    bool ok = false;
330    POOL_MEM VolumeName;
331
332    /* If system job, do not update catalog */
333    if (jcr->getJobType() == JT_SYSTEM) {
334       return true;
335    }
336
337    if (vol->VolCatName[0] == 0) {
338       Jmsg0(jcr, M_FATAL, 0, _("NULL Volume name. This shouldn't happen!!!\n"));
339       Pmsg0(000, _("NULL Volume name. This shouldn't happen!!!\n"));
340       return false;
341    }
342
343    /* Lock during Volume update */
344    P(vol_info_mutex);
345    Dmsg1(100, "Update cat VolFiles=%d\n", dev->file);
346    /* Just labeled or relabeled the tape */
347    if (label) {
348       bstrncpy(vol->VolCatStatus, "Append", sizeof(vol->VolCatStatus));
349    }
350 // if (update_LastWritten) {
351       vol->VolLastWritten = time(NULL);
352 // }
353    pm_strcpy(VolumeName, vol->VolCatName);
354    bash_spaces(VolumeName);
355    InChanger = vol->InChanger;
356    dir->fsend(Update_media, jcr->Job,
357       VolumeName.c_str(), vol->VolCatJobs, vol->VolCatFiles,
358       vol->VolCatBlocks, edit_uint64(vol->VolCatBytes, ed1),
359       vol->VolCatMounts, vol->VolCatErrors,
360       vol->VolCatWrites, edit_uint64(vol->VolCatMaxBytes, ed2),
361       edit_uint64(vol->VolLastWritten, ed6), 
362       vol->VolCatStatus, vol->Slot, label,
363       InChanger,                      /* bool in structure */
364       edit_int64(vol->VolReadTime, ed3),
365       edit_int64(vol->VolWriteTime, ed4),
366       edit_uint64(vol->VolFirstWritten, ed5),
367       vol->VolCatParts);
368     Dmsg1(100, ">dird %s", dir->msg);
369
370    /* Do not lock device here because it may be locked from label */
371    if (!do_get_volume_info(dcr)) {
372       Jmsg(jcr, M_FATAL, 0, "%s", jcr->errmsg);
373       Dmsg2(100, _("Didn't get vol info vol=%s: ERR=%s"), 
374          vol->VolCatName, jcr->errmsg);
375       goto bail_out;
376    }
377    Dmsg1(420, "get_volume_info() %s", dir->msg);
378    /* Update dev Volume info in case something changed (e.g. expired) */
379    dev->VolCatInfo = dcr->VolCatInfo;
380    ok = true;
381
382 bail_out:
383    /* ***FIXME*** remove for production */
384    sm_check(__FILE__, __LINE__, true);
385    V(vol_info_mutex);
386    return ok;
387 }
388
389 /*
390  * After writing a Volume, create the JobMedia record.
391  */
392 bool dir_create_jobmedia_record(DCR *dcr, bool zero)
393 {
394    JCR *jcr = dcr->jcr;
395    BSOCK *dir = jcr->dir_bsock;
396    char ed1[50];
397
398    /* If system job, do not update catalog */
399    if (jcr->getJobType() == JT_SYSTEM) {
400       return true;
401    }
402
403    /* Throw out records where FI is zero -- i.e. nothing done */
404    if (!zero && dcr->VolFirstIndex == 0 && 
405         (dcr->StartBlock != 0 || dcr->EndBlock != 0)) {
406       Dmsg0(100, "JobMedia FI=0 StartBlock!=0 record suppressed\n");
407       return true;
408    }
409
410    if (!dcr->WroteVol) {
411       return true;                    /* nothing written to tape */
412    }
413
414    dcr->WroteVol = false;
415    if (zero) {
416       /* Send dummy place holder to avoid purging */
417       dir->fsend(Create_job_media, jcr->Job,
418          0 , 0, 0, 0, 0, 0, 0, 0, edit_uint64(dcr->VolMediaId, ed1));
419    } else {
420       dir->fsend(Create_job_media, jcr->Job,
421          dcr->VolFirstIndex, dcr->VolLastIndex,
422          dcr->StartFile, dcr->EndFile,
423          dcr->StartBlock, dcr->EndBlock, 
424          dcr->Copy, dcr->Stripe, 
425          edit_uint64(dcr->VolMediaId, ed1));
426    }
427    Dmsg1(100, ">dird %s", dir->msg);
428    if (dir->recv() <= 0) {
429       Dmsg0(190, "create_jobmedia error bnet_recv\n");
430       Jmsg(jcr, M_FATAL, 0, _("Error creating JobMedia record: ERR=%s\n"),
431            dir->bstrerror());
432       return false;
433    }
434    Dmsg1(100, "<dird %s", dir->msg);
435    if (strcmp(dir->msg, OK_create) != 0) {
436       Dmsg1(130, "Bad response from Dir: %s\n", dir->msg);
437       Jmsg(jcr, M_FATAL, 0, _("Error creating JobMedia record: %s\n"), dir->msg);
438       return false;
439    }
440    return true;
441 }
442
443
444 /*
445  * Update File Attribute data
446  */
447 bool dir_update_file_attributes(DCR *dcr, DEV_RECORD *rec)
448 {
449    JCR *jcr = dcr->jcr;
450    BSOCK *dir = jcr->dir_bsock;
451    ser_declare;
452
453 #ifdef NO_ATTRIBUTES_TEST
454    return true;
455 #endif
456
457    dir->msg = check_pool_memory_size(dir->msg, sizeof(FileAttributes) +
458                 MAX_NAME_LENGTH + sizeof(DEV_RECORD) + rec->data_len + 1);
459    dir->msglen = bsnprintf(dir->msg, sizeof(FileAttributes) +
460                 MAX_NAME_LENGTH + 1, FileAttributes, jcr->Job);
461    ser_begin(dir->msg + dir->msglen, 0);
462    ser_uint32(rec->VolSessionId);
463    ser_uint32(rec->VolSessionTime);
464    ser_int32(rec->FileIndex);
465    ser_int32(rec->Stream);
466    ser_uint32(rec->data_len);
467    ser_bytes(rec->data, rec->data_len);
468    dir->msglen = ser_length(dir->msg);
469    Dmsg1(1800, ">dird %s\n", dir->msg);    /* Attributes */
470    if (rec->Stream == STREAM_UNIX_ATTRIBUTES || 
471        rec->Stream == STREAM_UNIX_ATTRIBUTES_EX) {
472       dir->set_data_end();                 /* set offset of last valid data */
473    }
474    return dir->send();
475 }
476
477
478 /*
479  *   Request the sysop to create an appendable volume
480  *
481  *   Entered with device blocked.
482  *   Leaves with device blocked.
483  *
484  *   Returns: true  on success (operator issues a mount command)
485  *            false on failure
486  *              Note, must create dev->errmsg on error return.
487  *
488  *    On success, dcr->VolumeName and dcr->VolCatInfo contain
489  *      information on suggested volume, but this may not be the
490  *      same as what is actually mounted.
491  *
492  *    When we return with success, the correct tape may or may not
493  *      actually be mounted. The calling routine must read it and
494  *      verify the label.
495  */
496 bool dir_ask_sysop_to_create_appendable_volume(DCR *dcr)
497 {
498    int stat = W_TIMEOUT;
499    DEVICE *dev = dcr->dev;
500    JCR *jcr = dcr->jcr;
501    bool got_vol = false;
502
503    if (job_canceled(jcr)) {
504       return false;
505    }
506    Dmsg0(400, "enter dir_ask_sysop_to_create_appendable_volume\n");
507    ASSERT(dev->blocked());
508    for ( ;; ) {
509       if (job_canceled(jcr)) {
510          Mmsg(dev->errmsg,
511               _("Job %s canceled while waiting for mount on Storage Device \"%s\".\n"),
512               jcr->Job, dev->print_name());
513          Jmsg(jcr, M_INFO, 0, "%s", dev->errmsg);
514          return false;
515       }
516       got_vol = dir_find_next_appendable_volume(dcr);   /* get suggested volume */
517       if (got_vol) {
518          goto get_out;
519       } else {
520          if (stat == W_TIMEOUT || stat == W_MOUNT) {
521             Mmsg(dev->errmsg, _(
522 "Job %s is waiting. Cannot find any appendable volumes.\n"
523 "Please use the \"label\" command to create a new Volume for:\n"
524 "    Storage:      %s\n"
525 "    Pool:         %s\n"
526 "    Media type:   %s\n"),
527                jcr->Job,
528                dev->print_name(),
529                dcr->pool_name,
530                dcr->media_type);
531             Jmsg(jcr, M_MOUNT, 0, "%s", dev->errmsg);
532             Dmsg1(100, "%s", dev->errmsg);
533          }
534       }
535
536       set_jcr_job_status(jcr, JS_WaitMedia);
537       dir_send_job_status(jcr);
538
539       stat = wait_for_sysop(dcr);
540       Dmsg1(100, "Back from wait_for_sysop stat=%d\n", stat);
541       if (dev->poll) {
542          Dmsg1(100, "Poll timeout in create append vol on device %s\n", dev->print_name());
543          continue;
544       }
545
546       if (stat == W_TIMEOUT) {
547          if (!double_dev_wait_time(dev)) {
548             Mmsg(dev->errmsg, _("Max time exceeded waiting to mount Storage Device %s for Job %s\n"),
549                dev->print_name(), jcr->Job);
550             Jmsg(jcr, M_FATAL, 0, "%s", dev->errmsg);
551             Dmsg1(100, "Gave up waiting on device %s\n", dev->print_name());
552             return false;             /* exceeded maximum waits */
553          }
554          continue;
555       }
556       if (stat == W_ERROR) {
557          berrno be;
558          Mmsg0(dev->errmsg, _("pthread error in mount_next_volume.\n"));
559          Jmsg(jcr, M_FATAL, 0, "%s", dev->errmsg);
560          return false;
561       }
562       Dmsg1(100, "Someone woke me for device %s\n", dev->print_name());
563    }
564
565 get_out:
566    set_jcr_job_status(jcr, JS_Running);
567    dir_send_job_status(jcr);
568    Dmsg0(100, "leave dir_ask_sysop_to_mount_create_appendable_volume\n");
569    return true;
570 }
571
572 /*
573  *   Request to mount specific Volume
574  *
575  *   Entered with device blocked and dcr->VolumeName is desired
576  *      volume.
577  *   Leaves with device blocked.
578  *
579  *   Returns: true  on success (operator issues a mount command)
580  *            false on failure
581  *                  Note, must create dev->errmsg on error return.
582  *
583  */
584 bool dir_ask_sysop_to_mount_volume(DCR *dcr, int mode)
585 {
586    int stat = W_TIMEOUT;
587    DEVICE *dev = dcr->dev;
588    JCR *jcr = dcr->jcr;
589
590    Dmsg0(400, "enter dir_ask_sysop_to_mount_volume\n");
591    if (!dcr->VolumeName[0]) {
592       Mmsg0(dev->errmsg, _("Cannot request another volume: no volume name given.\n"));
593       return false;
594    }
595    ASSERT(dev->blocked());
596    for ( ;; ) {
597       if (job_canceled(jcr)) {
598          Mmsg(dev->errmsg, _("Job %s canceled while waiting for mount on Storage Device %s.\n"),
599               jcr->Job, dev->print_name());
600          return false;
601       }
602
603       if (dev->is_dvd()) {   
604          dev->unmount(0);
605       }
606       
607       /*
608        * If we are not polling, and the wait timeout or the
609        *   user explicitly did a mount, send him the message.
610        *   Otherwise skip it.
611        */
612       if (!dev->poll && (stat == W_TIMEOUT || stat == W_MOUNT)) {
613          char *msg;
614          if (mode == ST_APPEND) {
615             msg = _("Please mount Volume \"%s\" or label a new one for:\n"
616               "    Job:          %s\n"
617               "    Storage:      %s\n"
618               "    Pool:         %s\n"
619               "    Media type:   %s\n");
620          } else {
621             msg = _("Please mount Volume \"%s\" for:\n"
622               "    Job:          %s\n"
623               "    Storage:      %s\n"
624               "    Pool:         %s\n"
625               "    Media type:   %s\n");
626          }
627          Jmsg(jcr, M_MOUNT, 0, msg, 
628               dcr->VolumeName,
629               jcr->Job,
630               dev->print_name(),
631               dcr->pool_name,
632               dcr->media_type);
633          Dmsg3(400, "Mount \"%s\" on device \"%s\" for Job %s\n",
634                dcr->VolumeName, dev->print_name(), jcr->Job);
635       }
636
637       set_jcr_job_status(jcr, JS_WaitMount);
638       dir_send_job_status(jcr);
639
640       stat = wait_for_sysop(dcr);          /* wait on device */
641       Dmsg1(100, "Back from wait_for_sysop stat=%d\n", stat);
642       if (dev->poll) {
643          Dmsg1(400, "Poll timeout in mount vol on device %s\n", dev->print_name());
644          Dmsg1(400, "Blocked=%s\n", dev->print_blocked());
645          goto get_out;
646       }
647
648       if (stat == W_TIMEOUT) {
649          if (!double_dev_wait_time(dev)) {
650             Mmsg(dev->errmsg, _("Max time exceeded waiting to mount Storage Device %s for Job %s\n"),
651                dev->print_name(), jcr->Job);
652             Jmsg(jcr, M_FATAL, 0, "%s", dev->errmsg);
653             Dmsg1(400, "Gave up waiting on device %s\n", dev->print_name());
654             return false;             /* exceeded maximum waits */
655          }
656          continue;
657       }
658       if (stat == W_ERROR) {
659          berrno be;
660          Mmsg(dev->errmsg, _("pthread error in mount_volume\n"));
661          Jmsg(jcr, M_FATAL, 0, "%s", dev->errmsg);
662          return false;
663       }
664       Dmsg1(400, "Someone woke me for device %s\n", dev->print_name());
665       break;
666    }
667
668 get_out:
669    set_jcr_job_status(jcr, JS_Running);
670    dir_send_job_status(jcr);
671    Dmsg0(400, "leave dir_ask_sysop_to_mount_volume\n");
672    return true;
673 }