git.sur5r.net Git - bacula/bacula/blob - bacula/src/dird/job.c

   1 /*
   2  *
   3  *   Bacula Director Job processing routines
   4  *
   5  *     Kern Sibbald, October MM
   6  *
   7  *    Version $Id$
   8  */
   9 /*
  10    Copyright (C) 2000-2003 Kern Sibbald and John Walker
  11
  12    This program is free software; you can redistribute it and/or
  13    modify it under the terms of the GNU General Public License as
  14    published by the Free Software Foundation; either version 2 of
  15    the License, or (at your option) any later version.
  16
  17    This program is distributed in the hope that it will be useful,
  18    but WITHOUT ANY WARRANTY; without even the implied warranty of
  19    MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE. See the GNU
  20    General Public License for more details.
  21
  22    You should have received a copy of the GNU General Public
  23    License along with this program; if not, write to the Free
  24    Software Foundation, Inc., 59 Temple Place - Suite 330, Boston,
  25    MA 02111-1307, USA.
  26
  27  */
  28
  29 #include "bacula.h"
  30 #include "dird.h"
  31
  32 /* Forward referenced subroutines */
  33 static void *job_thread(void *arg);
  34 static char *edit_run_codes(JCR *jcr, char *omsg, char *imsg);
  35 static void release_resource_locks(JCR *jcr);
  36 static int acquire_resource_locks(JCR *jcr);
  37 #ifdef USE_SEMAPHORE
  38 static void backoff_resource_locks(JCR *jcr, int count);
  39 #endif
  40
  41 /* Exported subroutines */
  42 void run_job(JCR *jcr);
  43
  44
  45 /* Imported subroutines */
  46 extern void term_scheduler();
  47 extern void term_ua_server();
  48 extern int do_backup(JCR *jcr);
  49 extern int do_restore(JCR *jcr);
  50 extern int do_verify(JCR *jcr);
  51 extern void backup_cleanup(void);
  52
  53 #ifdef USE_SEMAPHORE
  54 static semlock_t job_lock;
  55 static pthread_mutex_t mutex;
  56 static pthread_cond_t  resource_wait;
  57 static int waiting = 0;               /* count of waiting threads */
  58 #else
  59 /* Queue of jobs to be run */
  60 workq_t job_wq;                   /* our job work queue */
  61 #endif
  62
  63 void init_job_server(int max_workers)
  64 {
  65    int stat;
  66 #ifdef USE_SEMAPHORE
  67    if ((stat = sem_init(&job_lock, max_workers)) != 0) {
  68       Emsg1(M_ABORT, 0, _("Could not init job lock: ERR=%s\n"), strerror(stat));
  69    }
  70    if ((stat = pthread_mutex_init(&mutex, NULL)) != 0) {
  71       Emsg1(M_ABORT, 0, _("Could not init resource mutex: ERR=%s\n"), strerror(stat));
  72    }
  73    if ((stat = pthread_cond_init(&resource_wait, NULL)) != 0) {
  74       Emsg1(M_ABORT, 0, _("Could not init resource wait: ERR=%s\n"), strerror(stat));
  75    }
  76
  77 #else
  78    if ((stat = workq_init(&job_wq, max_workers, job_thread)) != 0) {
  79       Emsg1(M_ABORT, 0, _("Could not init job work queue: ERR=%s\n"), strerror(stat));
  80    }
  81 #endif
  82    return;
  83 }
  84
  85 /*
  86  * Run a job -- typically called by the scheduler, but may also
  87  *              be called by the UA (Console program).
  88  *
  89  */
  90 void run_job(JCR *jcr)
  91 {
  92    int stat, errstat;
  93 #ifdef USE_SEMAPHORE
  94    pthread_t tid;
  95 #else
  96    workq_ele_t *work_item;
  97 #endif
  98
  99    sm_check(__FILE__, __LINE__, True);
 100    init_msg(jcr, jcr->messages);
 101    create_unique_job_name(jcr, jcr->job->hdr.name);
 102    set_jcr_job_status(jcr, JS_Created);
 103    jcr->jr.SchedTime = jcr->sched_time;
 104    jcr->jr.StartTime = jcr->start_time;
 105    jcr->jr.Type = jcr->JobType;
 106    jcr->jr.Level = jcr->JobLevel;
 107    jcr->jr.JobStatus = jcr->JobStatus;
 108    bstrncpy(jcr->jr.Name, jcr->job->hdr.name, sizeof(jcr->jr.Name));
 109    bstrncpy(jcr->jr.Job, jcr->Job, sizeof(jcr->jr.Job));
 110
 111    /* Initialize termination condition variable */
 112    if ((errstat = pthread_cond_init(&jcr->term_wait, NULL)) != 0) {
 113       Jmsg1(jcr, M_FATAL, 0, _("Unable to init job cond variable: ERR=%s\n"), strerror(errstat));
 114       set_jcr_job_status(jcr, JS_ErrorTerminated);
 115       free_jcr(jcr);
 116       return;
 117    }
 118
 119    /*
 120     * Open database
 121     */
 122    Dmsg0(50, "Open database\n");
 123    jcr->db=db_init_database(jcr, jcr->catalog->db_name, jcr->catalog->db_user,
 124                             jcr->catalog->db_password, jcr->catalog->db_address,
 125                             jcr->catalog->db_port, jcr->catalog->db_socket);
 126    if (!db_open_database(jcr, jcr->db)) {
 127       Jmsg(jcr, M_FATAL, 0, "%s", db_strerror(jcr->db));
 128       set_jcr_job_status(jcr, JS_ErrorTerminated);
 129       free_jcr(jcr);
 130       return;
 131    }
 132    Dmsg0(50, "DB opened\n");
 133
 134    /*
 135     * Create Job record
 136     */
 137    jcr->jr.JobStatus = jcr->JobStatus;
 138    if (!db_create_job_record(jcr, jcr->db, &jcr->jr)) {
 139       Jmsg(jcr, M_FATAL, 0, "%s", db_strerror(jcr->db));
 140       set_jcr_job_status(jcr, JS_ErrorTerminated);
 141       free_jcr(jcr);
 142       return;
 143    }
 144    jcr->JobId = jcr->jr.JobId;
 145    ASSERT(jcr->jr.JobId > 0);
 146
 147    Dmsg4(30, "Created job record JobId=%d Name=%s Type=%c Level=%c\n",
 148        jcr->JobId, jcr->Job, jcr->jr.Type, jcr->jr.Level);
 149    Dmsg0(200, "Add jrc to work queue\n");
 150
 151 #ifdef USE_SEMAPHORE
 152   if ((stat = pthread_create(&tid, NULL, job_thread, (void *)jcr)) != 0) {
 153       Emsg1(M_ABORT, 0, _("Unable to create job thread: ERR=%s\n"), strerror(stat));
 154    }
 155 #else
 156    /* Queue the job to be run */
 157    if ((stat = workq_add(&job_wq, (void *)jcr, &work_item, 0)) != 0) {
 158       Emsg1(M_ABORT, 0, _("Could not add job to work queue: ERR=%s\n"), strerror(stat));
 159    }
 160    jcr->work_item = work_item;
 161 #endif
 162    Dmsg0(200, "Done run_job()\n");
 163 }
 164
 165 /*
 166  * This is the engine called by workq_add() when we were pulled
 167  *  from the work queue.
 168  *  At this point, we are running in our own thread
 169  */
 170 static void *job_thread(void *arg)
 171 {
 172    JCR *jcr = (JCR *)arg;
 173
 174    pthread_detach(pthread_self());
 175    sm_check(__FILE__, __LINE__, True);
 176
 177    if (!acquire_resource_locks(jcr)) {
 178       set_jcr_job_status(jcr, JS_Canceled);
 179    }
 180
 181    Dmsg0(200, "=====Start Job=========\n");
 182    jcr->start_time = time(NULL);      /* set the real start time */
 183    set_jcr_job_status(jcr, JS_Running);
 184
 185    if (job_canceled(jcr)) {
 186       update_job_end_record(jcr);
 187    } else if (jcr->job->MaxStartDelay != 0 && jcr->job->MaxStartDelay <
 188        (utime_t)(jcr->start_time - jcr->sched_time)) {
 189       Jmsg(jcr, M_FATAL, 0, _("Job canceled because max start delay time exceeded.\n"));
 190       set_jcr_job_status(jcr, JS_Canceled);
 191       update_job_end_record(jcr);
 192    } else {
 193
 194       /* Run Job */
 195       if (jcr->job->RunBeforeJob) {
 196          POOLMEM *before = get_pool_memory(PM_FNAME);
 197          int status;
 198
 199          before = edit_run_codes(jcr, before, jcr->job->RunBeforeJob);
 200          status = run_program(before, 0, NULL);
 201          if (status != 0) {
 202             Jmsg(jcr, M_FATAL, 0, _("RunBeforeJob returned non-zero status=%d\n"),
 203                status);
 204             set_jcr_job_status(jcr, JS_FatalError);
 205             update_job_end_record(jcr);
 206             free_pool_memory(before);
 207             goto bail_out;
 208          }
 209          free_pool_memory(before);
 210       }
 211       switch (jcr->JobType) {
 212          case JT_BACKUP:
 213             do_backup(jcr);
 214             if (jcr->JobStatus == JS_Terminated) {
 215                do_autoprune(jcr);
 216             }
 217             break;
 218          case JT_VERIFY:
 219             do_verify(jcr);
 220             if (jcr->JobStatus == JS_Terminated) {
 221                do_autoprune(jcr);
 222             }
 223             break;
 224          case JT_RESTORE:
 225             do_restore(jcr);
 226             if (jcr->JobStatus == JS_Terminated) {
 227                do_autoprune(jcr);
 228             }
 229             break;
 230          case JT_ADMIN:
 231             /* No actual job */
 232             do_autoprune(jcr);
 233             set_jcr_job_status(jcr, JS_Terminated);
 234             break;
 235          default:
 236             Pmsg1(0, "Unimplemented job type: %d\n", jcr->JobType);
 237             break;
 238          }
 239       if (jcr->job->RunAfterJob) {
 240          POOLMEM *after = get_pool_memory(PM_FNAME);
 241          int status;
 242
 243          after = edit_run_codes(jcr, after, jcr->job->RunAfterJob);
 244          status = run_program(after, 0, NULL);
 245          if (status != 0) {
 246             Jmsg(jcr, M_FATAL, 0, _("RunAfterJob returned non-zero status=%d\n"),
 247                status);
 248             set_jcr_job_status(jcr, JS_FatalError);
 249             update_job_end_record(jcr);
 250          }
 251          free_pool_memory(after);
 252       }
 253    }
 254 bail_out:
 255    release_resource_locks(jcr);
 256    Dmsg0(50, "Before free jcr\n");
 257    free_jcr(jcr);
 258    Dmsg0(50, "======== End Job ==========\n");
 259    sm_check(__FILE__, __LINE__, True);
 260    return NULL;
 261 }
 262
 263 /*
 264  * Acquire the resources needed. These locks limit the
 265  *  number of jobs by each resource. We have limits on
 266  *  Jobs, Clients, Storage, and total jobs.
 267  */
 268 static int acquire_resource_locks(JCR *jcr)
 269 {
 270    time_t now = time(NULL);
 271
 272    /* Wait until scheduled time arrives */
 273    if (jcr->sched_time > now && verbose) {
 274       Jmsg(jcr, M_INFO, 0, _("Waiting %d seconds for sched time.\n"),
 275            jcr->sched_time - now);
 276    }
 277    while (jcr->sched_time > now) {
 278       Dmsg2(100, "Waiting on sched time, jobid=%d secs=%d\n", jcr->JobId,
 279             jcr->sched_time - now);
 280       bmicrosleep(jcr->sched_time - now, 0);
 281       now = time(NULL);
 282    }
 283
 284
 285 #ifdef USE_SEMAPHORE
 286    int stat;
 287
 288    /* Initialize semaphores */
 289    if (jcr->store->sem.valid != SEMLOCK_VALID) {
 290       if ((stat = sem_init(&jcr->store->sem, jcr->store->MaxConcurrentJobs)) != 0) {
 291          Emsg1(M_ABORT, 0, _("Could not init Storage semaphore: ERR=%s\n"), strerror(stat));
 292       }
 293    }
 294    if (jcr->client->sem.valid != SEMLOCK_VALID) {
 295       if ((stat = sem_init(&jcr->client->sem, jcr->client->MaxConcurrentJobs)) != 0) {
 296          Emsg1(M_ABORT, 0, _("Could not init Client semaphore: ERR=%s\n"), strerror(stat));
 297       }
 298    }
 299    if (jcr->job->sem.valid != SEMLOCK_VALID) {
 300       if ((stat = sem_init(&jcr->job->sem, jcr->job->MaxConcurrentJobs)) != 0) {
 301          Emsg1(M_ABORT, 0, _("Could not init Job semaphore: ERR=%s\n"), strerror(stat));
 302       }
 303    }
 304
 305    for ( ;; ) {
 306       /* Acquire semaphore */
 307       set_jcr_job_status(jcr, JS_WaitJobRes);
 308       if ((stat = sem_lock(&jcr->job->sem)) != 0) {
 309          Emsg1(M_ABORT, 0, _("Could not acquire Job max jobs lock: ERR=%s\n"), strerror(stat));
 310       }
 311       set_jcr_job_status(jcr, JS_WaitClientRes);
 312       if ((stat = sem_trylock(&jcr->client->sem)) != 0) {
 313          if (stat == EBUSY) {
 314             backoff_resource_locks(jcr, 1);
 315             goto wait;
 316          } else {
 317             Emsg1(M_ABORT, 0, _("Could not acquire Client max jobs lock: ERR=%s\n"), strerror(stat));
 318          }
 319       }
 320       set_jcr_job_status(jcr, JS_WaitStoreRes);
 321       if ((stat = sem_trylock(&jcr->store->sem)) != 0) {
 322          if (stat == EBUSY) {
 323             backoff_resource_locks(jcr, 2);
 324             goto wait;
 325          } else {
 326             Emsg1(M_ABORT, 0, _("Could not acquire Storage max jobs lock: ERR=%s\n"), strerror(stat));
 327          }
 328       }
 329       set_jcr_job_status(jcr, JS_WaitMaxJobs);
 330       if ((stat = sem_trylock(&job_lock)) != 0) {
 331          if (stat == EBUSY) {
 332             backoff_resource_locks(jcr, 3);
 333             goto wait;
 334          } else {
 335             Emsg1(M_ABORT, 0, _("Could not acquire max jobs lock: ERR=%s\n"), strerror(stat));
 336          }
 337       }
 338       break;
 339
 340 wait:
 341       P(mutex);
 342       /*
 343        * Wait for a resource to be released either by backoff or
 344        *  by a job terminating.
 345        */
 346       waiting++;
 347       pthread_cond_wait(&resource_wait, &mutex);
 348       waiting--;
 349       V(mutex);
 350       /* Try again */
 351    }
 352 #endif
 353    return 1;
 354 }
 355
 356 #ifdef USE_SEMAPHORE
 357 /*
 358  * We could not get all the resource locks because
 359  *  too many jobs are running, so release any locks
 360  *  we did acquire, giving others a chance to use them
 361  *  while we wait.
 362  */
 363 static void backoff_resource_locks(JCR *jcr, int count)
 364 {
 365    P(mutex);
 366    switch (count) {
 367    case 3:
 368       sem_unlock(&jcr->store->sem);
 369       /* Fall through wanted */
 370    case 2:
 371       sem_unlock(&jcr->client->sem);
 372       /* Fall through wanted */
 373    case 1:
 374       sem_unlock(&jcr->job->sem);
 375       break;
 376    }
 377    /*
 378     * Since we released a lock, if there are any threads
 379     *  waiting, wake them up so that they can try again.
 380     */
 381    if (waiting > 0) {
 382       pthread_cond_broadcast(&resource_wait);
 383    }
 384    V(mutex);
 385 }
 386 #endif
 387
 388 /*
 389  * This is called at the end of the job to release
 390  *   any resource limits on the number of jobs. If
 391  *   there are any other jobs waiting, we wake them
 392  *   up so that they can try again.
 393  */
 394 static void release_resource_locks(JCR *jcr)
 395 {
 396 #ifdef USE_SEMAPHORE
 397    P(mutex);
 398    sem_unlock(&jcr->store->sem);
 399    sem_unlock(&jcr->client->sem);
 400    sem_unlock(&jcr->job->sem);
 401    sem_unlock(&job_lock);
 402    if (waiting > 0) {
 403       pthread_cond_broadcast(&resource_wait);
 404    }
 405    V(mutex);
 406 #endif
 407 }
 408
 409 /*
 410  * Get or create a Client record for this Job
 411  */
 412 int get_or_create_client_record(JCR *jcr)
 413 {
 414    CLIENT_DBR cr;
 415
 416    memset(&cr, 0, sizeof(cr));
 417    bstrncpy(cr.Name, jcr->client->hdr.name, sizeof(cr.Name));
 418    cr.AutoPrune = jcr->client->AutoPrune;
 419    cr.FileRetention = jcr->client->FileRetention;
 420    cr.JobRetention = jcr->client->JobRetention;
 421    if (jcr->client_name) {
 422       free_pool_memory(jcr->client_name);
 423    }
 424    jcr->client_name = get_memory(strlen(jcr->client->hdr.name) + 1);
 425    strcpy(jcr->client_name, jcr->client->hdr.name);
 426    if (!db_create_client_record(jcr, jcr->db, &cr)) {
 427       Jmsg(jcr, M_FATAL, 0, _("Could not create Client record. ERR=%s\n"),
 428          db_strerror(jcr->db));
 429       return 0;
 430    }
 431    jcr->jr.ClientId = cr.ClientId;
 432    if (cr.Uname[0]) {
 433       if (jcr->client_uname) {
 434          free_pool_memory(jcr->client_uname);
 435       }
 436       jcr->client_uname = get_memory(strlen(cr.Uname) + 1);
 437       strcpy(jcr->client_uname, cr.Uname);
 438    }
 439    Dmsg2(100, "Created Client %s record %d\n", jcr->client->hdr.name,
 440       jcr->jr.ClientId);
 441    return 1;
 442 }
 443
 444
 445 /*
 446  * Write status and such in DB
 447  */
 448 void update_job_end_record(JCR *jcr)
 449 {
 450    if (jcr->jr.EndTime == 0) {
 451       jcr->jr.EndTime = time(NULL);
 452    }
 453    jcr->end_time = jcr->jr.EndTime;
 454    jcr->jr.JobId = jcr->JobId;
 455    jcr->jr.JobStatus = jcr->JobStatus;
 456    jcr->jr.JobFiles = jcr->JobFiles;
 457    jcr->jr.JobBytes = jcr->JobBytes;
 458    jcr->jr.VolSessionId = jcr->VolSessionId;
 459    jcr->jr.VolSessionTime = jcr->VolSessionTime;
 460    if (!db_update_job_end_record(jcr, jcr->db, &jcr->jr)) {
 461       Jmsg(jcr, M_WARNING, 0, _("Error updating job record. %s"),
 462          db_strerror(jcr->db));
 463    }
 464 }
 465
 466 /*
 467  * Takes base_name and appends (unique) current
 468  *   date and time to form unique job name.
 469  *
 470  *  Returns: unique job name in jcr->Job
 471  *    date/time in jcr->start_time
 472  */
 473 void create_unique_job_name(JCR *jcr, char *base_name)
 474 {
 475    /* Job start mutex */
 476    static pthread_mutex_t mutex = PTHREAD_MUTEX_INITIALIZER;
 477    static time_t last_start_time = 0;
 478    time_t now;
 479    struct tm tm;
 480    char dt[MAX_TIME_LENGTH];
 481    char name[MAX_NAME_LENGTH];
 482    char *p;
 483
 484    /* Guarantee unique start time -- maximum one per second, and
 485     * thus unique Job Name
 486     */
 487    P(mutex);                          /* lock creation of jobs */
 488    now = time(NULL);
 489    while (now == last_start_time) {
 490       bmicrosleep(0, 500000);
 491       now = time(NULL);
 492    }
 493    last_start_time = now;
 494    V(mutex);                          /* allow creation of jobs */
 495    jcr->start_time = now;
 496    /* Form Unique JobName */
 497    localtime_r(&now, &tm);
 498    /* Use only characters that are permitted in Windows filenames */
 499    strftime(dt, sizeof(dt), "%Y-%m-%d_%H.%M.%S", &tm);
 500    bstrncpy(name, base_name, sizeof(name));
 501    name[sizeof(name)-22] = 0;          /* truncate if too long */
 502    sprintf(jcr->Job, "%s.%s", name, dt); /* add date & time */
 503    /* Convert spaces into underscores */
 504    for (p=jcr->Job; *p; p++) {
 505       if (*p == ' ') {
 506          *p = '_';
 507       }
 508    }
 509 }
 510
 511 /*
 512  * Free the Job Control Record if no one is still using it.
 513  *  Called from main free_jcr() routine in src/lib/jcr.c so
 514  *  that we can do our Director specific cleanup of the jcr.
 515  */
 516 void dird_free_jcr(JCR *jcr)
 517 {
 518    Dmsg0(200, "Start dird free_jcr\n");
 519
 520    if (jcr->file_bsock) {
 521       Dmsg0(200, "Close File bsock\n");
 522       bnet_close(jcr->file_bsock);
 523    }
 524    if (jcr->store_bsock) {
 525       Dmsg0(200, "Close Store bsock\n");
 526       bnet_close(jcr->store_bsock);
 527    }
 528    if (jcr->fname) {
 529       Dmsg0(200, "Free JCR fname\n");
 530       free_pool_memory(jcr->fname);
 531    }
 532    if (jcr->stime) {
 533       Dmsg0(200, "Free JCR stime\n");
 534       free_pool_memory(jcr->stime);
 535    }
 536    if (jcr->db) {
 537       Dmsg0(200, "Close DB\n");
 538       db_close_database(jcr, jcr->db);
 539    }
 540    if (jcr->RestoreWhere) {
 541       free(jcr->RestoreWhere);
 542    }
 543    if (jcr->RestoreBootstrap) {
 544       free(jcr->RestoreBootstrap);
 545    }
 546    if (jcr->client_uname) {
 547       free_pool_memory(jcr->client_uname);
 548    }
 549    Dmsg0(200, "End dird free_jcr\n");
 550 }
 551
 552 /*
 553  * Set some defaults in the JCR necessary to
 554  * run. These items are pulled from the job
 555  * definition as defaults, but can be overridden
 556  * later either by the Run record in the Schedule resource,
 557  * or by the Console program.
 558  */
 559 void set_jcr_defaults(JCR *jcr, JOB *job)
 560 {
 561    jcr->job = job;
 562    jcr->JobType = job->JobType;
 563    jcr->JobLevel = job->level;
 564    jcr->store = job->storage;
 565    jcr->client = job->client;
 566    if (jcr->client_name) {
 567       free_pool_memory(jcr->client_name);
 568    }
 569    jcr->client_name = get_memory(strlen(jcr->client->hdr.name) + 1);
 570    strcpy(jcr->client_name, jcr->client->hdr.name);
 571    jcr->pool = job->pool;
 572    jcr->catalog = job->client->catalog;
 573    jcr->fileset = job->fileset;
 574    jcr->messages = job->messages;
 575    if (jcr->RestoreBootstrap) {
 576       free(jcr->RestoreBootstrap);
 577    }
 578    /* This can be overridden by Console program */
 579    if (job->RestoreBootstrap) {
 580       jcr->RestoreBootstrap = bstrdup(job->RestoreBootstrap);
 581    }
 582    /* If no default level given, set one */
 583    if (jcr->JobLevel == 0) {
 584       switch (jcr->JobType) {
 585       case JT_VERIFY:
 586          jcr->JobLevel = L_VERIFY_CATALOG;
 587          break;
 588       case JT_BACKUP:
 589          jcr->JobLevel = L_INCREMENTAL;
 590          break;
 591       case JT_RESTORE:
 592       case JT_ADMIN:
 593          jcr->JobLevel = L_FULL;
 594          break;
 595       default:
 596          break;
 597       }
 598    }
 599 }
 600
 601 /*
 602  * Edit codes into Run command
 603  *  %% = %
 604  *  %c = Client's name
 605  *  %d = Director's name
 606  *  %i = JobId
 607  *  %e = Job Exit
 608  *  %j = Job
 609  *  %l = Job Level
 610  *  %n = Job name
 611  *  %t = Job type
 612  *
 613  *  omsg = edited output message
 614  *  imsg = input string containing edit codes (%x)
 615  *
 616  */
 617 static char *edit_run_codes(JCR *jcr, char *omsg, char *imsg)
 618 {
 619    char *p;
 620    const char *str;
 621    char add[20];
 622
 623    *omsg = 0;
 624    Dmsg1(200, "edit_run_codes: %s\n", imsg);
 625    for (p=imsg; *p; p++) {
 626       if (*p == '%') {
 627          switch (*++p) {
 628          case '%':
 629             str = "%";
 630             break;
 631          case 'c':
 632             str = jcr->client_name;
 633             if (!str) {
 634                str = "";
 635             }
 636             break;
 637          case 'd':
 638             str = my_name;
 639             break;
 640          case 'e':
 641             str = job_status_to_str(jcr->JobStatus);
 642             break;
 643          case 'i':
 644             sprintf(add, "%d", jcr->JobId);
 645             str = add;
 646             break;
 647          case 'j':                    /* Job */
 648             str = jcr->Job;
 649             break;
 650          case 'l':
 651             str = job_level_to_str(jcr->JobLevel);
 652             break;
 653          case 'n':
 654             str = jcr->job->hdr.name;
 655             break;
 656          case 't':
 657             str = job_type_to_str(jcr->JobType);
 658             break;
 659          default:
 660             add[0] = '%';
 661             add[1] = *p;
 662             add[2] = 0;
 663             str = add;
 664             break;
 665          }
 666       } else {
 667          add[0] = *p;
 668          add[1] = 0;
 669          str = add;
 670       }
 671       Dmsg1(200, "add_str %s\n", str);
 672       pm_strcat(&omsg, (char *)str);
 673       Dmsg1(200, "omsg=%s\n", omsg);
 674    }
 675    return omsg;
 676 }