git.sur5r.net Git - bacula/bacula/blob - bacula/src/stored/askdir.c

   1 /*
   2    Bacula® - The Network Backup Solution
   3
   4    Copyright (C) 2000-2007 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 plus additions
  11    that are listed 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 John Walker.
  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=%d 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 =bnet_fsend(dir, 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 = bnet_fsend(dir, 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 bnet_fsend(jcr->dir_bsock, 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 (bnet_recv(dir) <= 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        Dmsg2(100, "Bad response from Dir fields=%d: %s", n, dir->msg);
 195        Mmsg(jcr->errmsg, _("Error getting Volume info: %s"), dir->msg);
 196        return false;
 197     }
 198     vol.InChanger = InChanger;        /* bool in structure */
 199     unbash_spaces(vol.VolCatName);
 200     bstrncpy(dcr->VolumeName, vol.VolCatName, sizeof(dcr->VolumeName));
 201     dcr->VolCatInfo = vol;            /* structure assignment */
 202
 203     Dmsg2(100, "do_reqest_vol_info return true slot=%d Volume=%s\n",
 204           vol.Slot, vol.VolCatName);
 205     return true;
 206 }
 207
 208
 209 /*
 210  * Get Volume info for a specific volume from the Director's Database
 211  *
 212  * Returns: true  on success   (Director guarantees that Pool and MediaType
 213  *                              are correct and VolStatus==Append or
 214  *                              VolStatus==Recycle)
 215  *          false on failure
 216  *
 217  *          Volume information returned in dcr->VolCatInfo
 218  */
 219 bool dir_get_volume_info(DCR *dcr, enum get_vol_info_rw writing)
 220 {
 221     JCR *jcr = dcr->jcr;
 222     BSOCK *dir = jcr->dir_bsock;
 223
 224     P(vol_info_mutex);
 225     bstrncpy(dcr->VolCatInfo.VolCatName, dcr->VolumeName, sizeof(dcr->VolCatInfo.VolCatName));
 226     bash_spaces(dcr->VolCatInfo.VolCatName);
 227     bnet_fsend(dir, Get_Vol_Info, jcr->Job, dcr->VolCatInfo.VolCatName,
 228        writing==GET_VOL_INFO_FOR_WRITE?1:0);
 229     Dmsg1(100, ">dird: %s", dir->msg);
 230     unbash_spaces(dcr->VolCatInfo.VolCatName);
 231     bool ok = do_get_volume_info(dcr);
 232     V(vol_info_mutex);
 233     return ok;
 234 }
 235
 236
 237
 238 /*
 239  * Get info on the next appendable volume in the Director's database
 240  *
 241  * Returns: true  on success dcr->VolumeName is volume
 242  *                reserve_volume() called on Volume name
 243  *          false on failure dcr->VolumeName[0] == 0
 244  *
 245  *          Volume information returned in dcr
 246  *
 247  */
 248 bool dir_find_next_appendable_volume(DCR *dcr)
 249 {
 250     JCR *jcr = dcr->jcr;
 251     BSOCK *dir = jcr->dir_bsock;
 252     bool found = false;
 253
 254     Dmsg0(200, "dir_find_next_appendable_volume\n");
 255     /*
 256      * Try the twenty oldest or most available volumes.  Note,
 257      *   the most available could already be mounted on another
 258      *   drive, so we continue looking for a not in use Volume.
 259      */
 260     lock_reservations();
 261     P(vol_info_mutex);
 262     for (int vol_index=1;  vol_index < 20; vol_index++) {
 263        bash_spaces(dcr->media_type);
 264        bash_spaces(dcr->pool_name);
 265        bnet_fsend(dir, Find_media, jcr->Job, vol_index, dcr->pool_name, dcr->media_type);
 266        unbash_spaces(dcr->media_type);
 267        unbash_spaces(dcr->pool_name);
 268        Dmsg1(100, ">dird: %s", dir->msg);
 269        bool ok = do_get_volume_info(dcr);
 270        if (ok) {
 271           if (dcr->any_volume || !is_volume_in_use(dcr)) {
 272              found = true;
 273              break;
 274           } else {
 275              Dmsg1(100, "Volume %s is in use.\n", dcr->VolumeName);
 276              continue;
 277           }
 278        } else {
 279           Dmsg2(100, "No vol. index %d return false. dev=%s\n", vol_index,
 280              dcr->dev->print_name());
 281           found = false;
 282           break;
 283        }
 284     }
 285     if (found) {
 286        Dmsg0(400, "dir_find_next_appendable_volume return true\n");
 287        reserve_volume(dcr, dcr->VolumeName);   /* reserve volume */
 288        V(vol_info_mutex);
 289        unlock_reservations();
 290        return true;
 291     }
 292     dcr->VolumeName[0] = 0;
 293     V(vol_info_mutex);
 294     unlock_reservations();
 295     return false;
 296 }
 297
 298
 299 /*
 300  * After writing a Volume, send the updated statistics
 301  * back to the director. The information comes from the
 302  * dev record.
 303  */
 304 bool dir_update_volume_info(DCR *dcr, bool label)
 305 {
 306    JCR *jcr = dcr->jcr;
 307    BSOCK *dir = jcr->dir_bsock;
 308    DEVICE *dev = dcr->dev;
 309    time_t LastWritten = time(NULL);
 310    VOLUME_CAT_INFO *vol = &dev->VolCatInfo;
 311    char ed1[50], ed2[50], ed3[50], ed4[50], ed5[50];
 312    int InChanger;
 313    bool ok = false;
 314    POOL_MEM VolumeName;
 315
 316    /* If system job, do not update catalog */
 317    if (jcr->JobType == JT_SYSTEM) {
 318       return true;
 319    }
 320
 321    if (vol->VolCatName[0] == 0) {
 322       Jmsg0(jcr, M_FATAL, 0, _("NULL Volume name. This shouldn't happen!!!\n"));
 323       Pmsg0(000, _("NULL Volume name. This shouldn't happen!!!\n"));
 324       return false;
 325    }
 326
 327    /* Lock during Volume update */
 328    P(vol_info_mutex);
 329    Dmsg1(100, "Update cat VolFiles=%d\n", dev->file);
 330    /* Just labeled or relabeled the tape */
 331    if (label) {
 332       bstrncpy(vol->VolCatStatus, "Append", sizeof(vol->VolCatStatus));
 333    }
 334    pm_strcpy(VolumeName, vol->VolCatName);
 335    bash_spaces(VolumeName);
 336    InChanger = vol->InChanger;
 337    bnet_fsend(dir, Update_media, jcr->Job,
 338       VolumeName.c_str(), vol->VolCatJobs, vol->VolCatFiles,
 339       vol->VolCatBlocks, edit_uint64(vol->VolCatBytes, ed1),
 340       vol->VolCatMounts, vol->VolCatErrors,
 341       vol->VolCatWrites, edit_uint64(vol->VolCatMaxBytes, ed2),
 342       LastWritten, vol->VolCatStatus, vol->Slot, label,
 343       InChanger,                      /* bool in structure */
 344       edit_int64(vol->VolReadTime, ed3),
 345       edit_int64(vol->VolWriteTime, ed4),
 346       edit_uint64(vol->VolFirstWritten, ed5),
 347       vol->VolCatParts);
 348     Dmsg1(100, ">dird: %s", dir->msg);
 349
 350    /* Do not lock device here because it may be locked from label */
 351    if (!do_get_volume_info(dcr)) {
 352       Jmsg(jcr, M_FATAL, 0, "%s", jcr->errmsg);
 353       Dmsg2(100, _("Didn't get vol info vol=%s: ERR=%s"),
 354          vol->VolCatName, jcr->errmsg);
 355       goto bail_out;
 356    }
 357    Dmsg1(420, "get_volume_info(): %s", dir->msg);
 358    /* Update dev Volume info in case something changed (e.g. expired) */
 359    dev->VolCatInfo = dcr->VolCatInfo;
 360    ok = true;
 361
 362 bail_out:
 363    V(vol_info_mutex);
 364    return ok;
 365 }
 366
 367 /*
 368  * After writing a Volume, create the JobMedia record.
 369  */
 370 bool dir_create_jobmedia_record(DCR *dcr)
 371 {
 372    JCR *jcr = dcr->jcr;
 373    BSOCK *dir = jcr->dir_bsock;
 374    char ed1[50];
 375
 376    /* If system job, do not update catalog */
 377    if (jcr->JobType == JT_SYSTEM) {
 378       return true;
 379    }
 380
 381    if (!dcr->WroteVol) {
 382       return true;                    /* nothing written to tape */
 383    }
 384
 385    dcr->WroteVol = false;
 386    bnet_fsend(dir, Create_job_media, jcr->Job,
 387       dcr->VolFirstIndex, dcr->VolLastIndex,
 388       dcr->StartFile, dcr->EndFile,
 389       dcr->StartBlock, dcr->EndBlock,
 390       dcr->Copy, dcr->Stripe,
 391       edit_uint64(dcr->dev->VolCatInfo.VolMediaId, ed1));
 392     Dmsg1(100, ">dird: %s", dir->msg);
 393    if (bnet_recv(dir) <= 0) {
 394       Dmsg0(190, "create_jobmedia error bnet_recv\n");
 395       Jmsg(jcr, M_FATAL, 0, _("Error creating JobMedia record: ERR=%s\n"),
 396            bnet_strerror(dir));
 397       return false;
 398    }
 399    Dmsg1(100, "<dir: %s", dir->msg);
 400    if (strcmp(dir->msg, OK_create) != 0) {
 401       Dmsg1(130, "Bad response from Dir: %s\n", dir->msg);
 402       Jmsg(jcr, M_FATAL, 0, _("Error creating JobMedia record: %s\n"), dir->msg);
 403       return false;
 404    }
 405    return true;
 406 }
 407
 408
 409 /*
 410  * Update File Attribute data
 411  */
 412 bool dir_update_file_attributes(DCR *dcr, DEV_RECORD *rec)
 413 {
 414    JCR *jcr = dcr->jcr;
 415    BSOCK *dir = jcr->dir_bsock;
 416    ser_declare;
 417
 418 #ifdef NO_ATTRIBUTES_TEST
 419    return true;
 420 #endif
 421
 422    dir->msglen = sprintf(dir->msg, FileAttributes, jcr->Job);
 423    dir->msg = check_pool_memory_size(dir->msg, dir->msglen +
 424                 sizeof(DEV_RECORD) + rec->data_len);
 425    ser_begin(dir->msg + dir->msglen, 0);
 426    ser_uint32(rec->VolSessionId);
 427    ser_uint32(rec->VolSessionTime);
 428    ser_int32(rec->FileIndex);
 429    ser_int32(rec->Stream);
 430    ser_uint32(rec->data_len);
 431    ser_bytes(rec->data, rec->data_len);
 432    dir->msglen = ser_length(dir->msg);
 433    Dmsg1(1800, ">dird: %s\n", dir->msg);    /* Attributes */
 434    return bnet_send(dir);
 435 }
 436
 437
 438 /*
 439  *   Request the sysop to create an appendable volume
 440  *
 441  *   Entered with device blocked.
 442  *   Leaves with device blocked.
 443  *
 444  *   Returns: true  on success (operator issues a mount command)
 445  *            false on failure
 446  *              Note, must create dev->errmsg on error return.
 447  *
 448  *    On success, dcr->VolumeName and dcr->VolCatInfo contain
 449  *      information on suggested volume, but this may not be the
 450  *      same as what is actually mounted.
 451  *
 452  *    When we return with success, the correct tape may or may not
 453  *      actually be mounted. The calling routine must read it and
 454  *      verify the label.
 455  */
 456 bool dir_ask_sysop_to_create_appendable_volume(DCR *dcr)
 457 {
 458    int stat = W_TIMEOUT;
 459    DEVICE *dev = dcr->dev;
 460    JCR *jcr = dcr->jcr;
 461    bool got_vol = false;
 462
 463    Dmsg0(400, "enter dir_ask_sysop_to_create_appendable_volume\n");
 464    ASSERT(dev->blocked());
 465    for ( ;; ) {
 466       if (job_canceled(jcr)) {
 467          Mmsg(dev->errmsg,
 468               _("Job %s canceled while waiting for mount on Storage Device \"%s\".\n"),
 469               jcr->Job, dev->print_name());
 470          Jmsg(jcr, M_INFO, 0, "%s", dev->errmsg);
 471          return false;
 472       }
 473       dev->dlock();
 474       got_vol = dir_find_next_appendable_volume(dcr);   /* get suggested volume */
 475       dev->dunlock();
 476       if (got_vol) {
 477          return true;
 478       } else {
 479          if (stat == W_TIMEOUT || stat == W_MOUNT) {
 480             Jmsg(jcr, M_MOUNT, 0, _(
 481 "Job %s waiting. Cannot find any appendable volumes.\n"
 482 "Please use the \"label\"  command to create a new Volume for:\n"
 483 "    Storage:      %s\n"
 484 "    Media type:   %s\n"
 485 "    Pool:         %s\n"),
 486                jcr->Job,
 487                dev->print_name(),
 488                dcr->media_type,
 489                dcr->pool_name);
 490          }
 491       }
 492
 493       set_jcr_job_status(jcr, JS_WaitMedia);
 494       dir_send_job_status(jcr);
 495
 496       stat = wait_for_sysop(dcr);
 497       Dmsg1(100, "Back from wait_for_sysop stat=%d\n", stat);
 498       if (dev->poll) {
 499          Dmsg1(100, "Poll timeout in create append vol on device %s\n", dev->print_name());
 500          continue;
 501       }
 502
 503       if (stat == W_TIMEOUT) {
 504          if (!double_dev_wait_time(dev)) {
 505             Mmsg(dev->errmsg, _("Max time exceeded waiting to mount Storage Device %s for Job %s\n"),
 506                dev->print_name(), jcr->Job);
 507             Jmsg(jcr, M_FATAL, 0, "%s", dev->errmsg);
 508             Dmsg1(100, "Gave up waiting on device %s\n", dev->print_name());
 509             return false;             /* exceeded maximum waits */
 510          }
 511          continue;
 512       }
 513       if (stat == W_ERROR) {
 514          berrno be;
 515          Mmsg0(dev->errmsg, _("pthread error in mount_next_volume.\n"));
 516          Jmsg(jcr, M_FATAL, 0, "%s", dev->errmsg);
 517          return false;
 518       }
 519       Dmsg1(100, "Someone woke me for device %s\n", dev->print_name());
 520    }
 521    set_jcr_job_status(jcr, JS_Running);
 522    dir_send_job_status(jcr);
 523    Dmsg0(100, "leave dir_ask_sysop_to_mount_create_appendable_volume\n");
 524    return true;
 525 }
 526
 527 /*
 528  *   Request to mount specific Volume
 529  *
 530  *   Entered with device blocked and dcr->VolumeName is desired
 531  *      volume.
 532  *   Leaves with device blocked.
 533  *
 534  *   Returns: true  on success (operator issues a mount command)
 535  *            false on failure
 536  *                  Note, must create dev->errmsg on error return.
 537  *
 538  */
 539 bool dir_ask_sysop_to_mount_volume(DCR *dcr)
 540 {
 541    int stat = W_TIMEOUT;
 542    DEVICE *dev = dcr->dev;
 543    JCR *jcr = dcr->jcr;
 544
 545    Dmsg0(400, "enter dir_ask_sysop_to_mount_volume\n");
 546    if (!dcr->VolumeName[0]) {
 547       Mmsg0(dev->errmsg, _("Cannot request another volume: no volume name given.\n"));
 548       return false;
 549    }
 550    ASSERT(dev->blocked());
 551    for ( ;; ) {
 552       if (job_canceled(jcr)) {
 553          Mmsg(dev->errmsg, _("Job %s canceled while waiting for mount on Storage Device %s.\n"),
 554               jcr->Job, dev->print_name());
 555          return false;
 556       }
 557
 558       if (dev->is_dvd()) {
 559          dev->unmount(0);
 560       }
 561
 562       /*
 563        * If we are not polling, and the wait timeout or the
 564        *   user explicitly did a mount, send him the message.
 565        *   Otherwise skip it.
 566        */
 567       if (!dev->poll && (stat == W_TIMEOUT || stat == W_MOUNT)) {
 568          Jmsg(jcr, M_MOUNT, 0, _("Please mount Volume \"%s\" on Storage Device %s for Job %s\n"),
 569               dcr->VolumeName, dev->print_name(), jcr->Job);
 570          Dmsg3(400, "Mount \"%s\" on device \"%s\" for Job %s\n",
 571                dcr->VolumeName, dev->print_name(), jcr->Job);
 572       }
 573
 574       set_jcr_job_status(jcr, JS_WaitMount);
 575       dir_send_job_status(jcr);
 576
 577       stat = wait_for_sysop(dcr);          /* wait on device */
 578       Dmsg1(100, "Back from wait_for_sysop stat=%d\n", stat);
 579       if (dev->poll) {
 580          Dmsg1(400, "Poll timeout in mount vol on device %s\n", dev->print_name());
 581          Dmsg1(400, "Blocked=%s\n", dev->print_blocked());
 582          return true;
 583       }
 584
 585       if (stat == W_TIMEOUT) {
 586          if (!double_dev_wait_time(dev)) {
 587             Mmsg(dev->errmsg, _("Max time exceeded waiting to mount Storage Device %s for Job %s\n"),
 588                dev->print_name(), jcr->Job);
 589             Jmsg(jcr, M_FATAL, 0, "%s", dev->errmsg);
 590             Dmsg1(400, "Gave up waiting on device %s\n", dev->print_name());
 591             return false;             /* exceeded maximum waits */
 592          }
 593          continue;
 594       }
 595       if (stat == W_ERROR) {
 596          berrno be;
 597          Mmsg(dev->errmsg, _("pthread error in mount_volume\n"));
 598          Jmsg(jcr, M_FATAL, 0, "%s", dev->errmsg);
 599          return false;
 600       }
 601       Dmsg1(400, "Someone woke me for device %s\n", dev->print_name());
 602       break;
 603    }
 604    set_jcr_job_status(jcr, JS_Running);
 605    dir_send_job_status(jcr);
 606    Dmsg0(400, "leave dir_ask_sysop_to_mount_volume\n");
 607    return true;
 608 }