]> git.sur5r.net Git - bacula/bacula/blob - bacula/src/dird/migrate.c
b820b8bce7e926957bf31548e4de366b27709da5
[bacula/bacula] / bacula / src / dird / migrate.c
1 /*
2    Bacula® - The Network Backup Solution
3
4    Copyright (C) 2004-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  *
30  *   Bacula Director -- migrate.c -- responsible for doing
31  *     migration jobs.
32  *
33  *     Kern Sibbald, September MMIV
34  *
35  *  Basic tasks done here:
36  *     Open DB and create records for this job.
37  *     Open Message Channel with Storage daemon to tell him a job will be starting.
38  *     Open connection with Storage daemon and pass him commands
39  *       to do the backup.
40  *     When the Storage daemon finishes the job, update the DB.
41  *
42  *   Version $Id$
43  */
44
45 #include "bacula.h"
46 #include "dird.h"
47 #include "ua.h"
48 #ifndef HAVE_REGEX_H
49 #include "lib/bregex.h"
50 #else
51 #include <regex.h>
52 #endif
53
54 static const int dbglevel = 10;
55
56 static char OKbootstrap[] = "3000 OK bootstrap\n";
57 static int get_job_to_migrate(JCR *jcr);
58 struct idpkt;
59 static bool regex_find_jobids(JCR *jcr, idpkt *ids, const char *query1,
60                  const char *query2, const char *type);
61 static bool find_mediaid_then_jobids(JCR *jcr, idpkt *ids, const char *query1,
62                  const char *type);
63 static bool find_jobids_from_mediaid_list(JCR *jcr, idpkt *ids, const char *type);
64 static void start_migration_job(JCR *jcr);
65 static int get_next_dbid_from_list(char **p, DBId_t *DBId);
66
67 /* 
68  * Called here before the job is run to do the job
69  *   specific setup.  Note, one of the important things to
70  *   complete in this init code is to make the definitive
71  *   choice of input and output storage devices.  This is
72  *   because immediately after the init, the job is queued
73  *   in the jobq.c code, and it checks that all the resources
74  *   (storage resources in particular) are available, so these
75  *   must all be properly defined.
76  *
77  *  previous_jr refers to the job DB record of the Job that is
78  *    going to be migrated.
79  *  prev_job refers to the job resource of the Job that is
80  *    going to be migrated.
81  *  jcr is the jcr for the current "migration" job.  It is a
82  *    control job that is put in the DB as a migration job, which
83  *    means that this job migrated a previous job to a new job.
84  *    No Volume or File data is associated with this control
85  *    job.
86  *  mig_jcr refers to the newly migrated job that is run by
87  *    the current jcr.  It is a backup job that moves (migrates) the
88  *    data written for the previous_jr into the new pool.  This
89  *    job (mig_jcr) becomes the new backup job that replaces
90  *    the original backup job. Note, this jcr is not really run. It
91  *    is simply attached to the current jcr.  It will show up in
92  *    the Director's status output, but not in the SD or FD, both of
93  *    which deal only with the current migration job (i.e. jcr).
94  */
95 bool do_migration_init(JCR *jcr)
96 {
97    POOL_DBR pr;
98    POOL *pool;
99    char ed1[100];
100    JOB *job, *prev_job;
101    JCR *mig_jcr;                   /* newly migrated job */
102    int count;
103
104
105    apply_pool_overrides(jcr);
106
107    jcr->jr.PoolId = get_or_create_pool_record(jcr, jcr->pool->name());
108    if (jcr->jr.PoolId == 0) {
109       Dmsg1(dbglevel, "JobId=%d no PoolId\n", (int)jcr->JobId);
110       Jmsg(jcr, M_FATAL, 0, _("Could not get or create a Pool record.\n"));
111       return false;
112    }
113    /*
114     * Note, at this point, pool is the pool for this job.  We
115     *  transfer it to rpool (read pool), and a bit later,
116     *  pool will be changed to point to the write pool, 
117     *  which comes from pool->NextPool.
118     */
119    jcr->rpool = jcr->pool;            /* save read pool */
120    pm_strcpy(jcr->rpool_source, jcr->pool_source);
121
122
123    Dmsg2(dbglevel, "Read pool=%s (From %s)\n", jcr->rpool->name(), jcr->rpool_source);
124
125    /* If we find a job or jobs to migrate it is previous_jr.JobId */
126    count = get_job_to_migrate(jcr);
127    if (count < 0) {
128       return false;
129    }
130    if (count == 0) {
131       return true;
132    }
133
134    Dmsg1(dbglevel, "Back from get_job_to_migrate JobId=%d\n", (int)jcr->JobId);
135
136    if (jcr->previous_jr.JobId == 0) {
137       Dmsg1(dbglevel, "JobId=%d no previous JobId\n", (int)jcr->JobId);
138       Jmsg(jcr, M_INFO, 0, _("No previous Job found to migrate.\n"));
139       return true;                    /* no work */
140    }
141
142    if (!get_or_create_fileset_record(jcr)) {
143       Dmsg1(dbglevel, "JobId=%d no FileSet\n", (int)jcr->JobId);
144       Jmsg(jcr, M_FATAL, 0, _("Could not get or create the FileSet record.\n"));
145       return false;
146    }
147
148    create_restore_bootstrap_file(jcr);
149
150    if (jcr->previous_jr.JobId == 0 || jcr->ExpectedFiles == 0) {
151       set_jcr_job_status(jcr, JS_Terminated);
152       Dmsg1(dbglevel, "JobId=%d expected files == 0\n", (int)jcr->JobId);
153       if (jcr->previous_jr.JobId == 0) {
154          Jmsg(jcr, M_INFO, 0, _("No previous Job found to migrate.\n"));
155       } else {
156          Jmsg(jcr, M_INFO, 0, _("Previous Job has no data to migrate.\n"));
157       }
158       return true;                    /* no work */
159    }
160
161    Dmsg5(dbglevel, "JobId=%d: Previous: Name=%s JobId=%d Type=%c Level=%c\n",
162       (int)jcr->JobId,
163       jcr->previous_jr.Name, (int)jcr->previous_jr.JobId, 
164       jcr->previous_jr.JobType, jcr->previous_jr.JobLevel);
165
166    Dmsg5(dbglevel, "JobId=%d: Current: Name=%s JobId=%d Type=%c Level=%c\n",
167       (int)jcr->JobId,
168       jcr->jr.Name, (int)jcr->jr.JobId, 
169       jcr->jr.JobType, jcr->jr.JobLevel);
170
171    LockRes();
172    job = (JOB *)GetResWithName(R_JOB, jcr->jr.Name);
173    prev_job = (JOB *)GetResWithName(R_JOB, jcr->previous_jr.Name);
174    UnlockRes();
175    if (!job) {
176       Jmsg(jcr, M_FATAL, 0, _("Job resource not found for \"%s\".\n"), jcr->jr.Name);
177       return false;
178    }
179    if (!prev_job) {
180       Jmsg(jcr, M_FATAL, 0, _("Previous Job resource not found for \"%s\".\n"), 
181            jcr->previous_jr.Name);
182       return false;
183    }
184
185    jcr->spool_data = job->spool_data;     /* turn on spooling if requested in job */ 
186
187    /* Create a migation jcr */
188    mig_jcr = jcr->mig_jcr = new_jcr(sizeof(JCR), dird_free_jcr);
189    memcpy(&mig_jcr->previous_jr, &jcr->previous_jr, sizeof(mig_jcr->previous_jr));
190
191    /*
192     * Turn the mig_jcr into a "real" job that takes on the aspects of
193     *   the previous backup job "prev_job".
194     */
195    set_jcr_defaults(mig_jcr, prev_job);
196    if (!setup_job(mig_jcr)) {
197       Jmsg(jcr, M_FATAL, 0, _("setup job failed.\n"));
198       return false;
199    }
200
201    /* Now reset the job record from the previous job */
202    memcpy(&mig_jcr->jr, &jcr->previous_jr, sizeof(mig_jcr->jr));
203    /* Update the jr to reflect the new values of PoolId and JobId. */
204    mig_jcr->jr.PoolId = jcr->jr.PoolId;
205    mig_jcr->jr.JobId = mig_jcr->JobId;
206
207    Dmsg4(dbglevel, "mig_jcr: Name=%s JobId=%d Type=%c Level=%c\n",
208       mig_jcr->jr.Name, (int)mig_jcr->jr.JobId, 
209       mig_jcr->jr.JobType, mig_jcr->jr.JobLevel);
210
211    /*
212     * Get the PoolId used with the original job. Then
213     *  find the pool name from the database record.
214     */
215    memset(&pr, 0, sizeof(pr));
216    pr.PoolId = mig_jcr->previous_jr.PoolId;
217    if (!db_get_pool_record(jcr, jcr->db, &pr)) {
218       Jmsg(jcr, M_FATAL, 0, _("Pool for JobId %s not in database. ERR=%s\n"),
219             edit_int64(pr.PoolId, ed1), db_strerror(jcr->db));
220          return false;
221    }
222    /* Get the pool resource corresponding to the original job */
223    pool = (POOL *)GetResWithName(R_POOL, pr.Name);
224    if (!pool) {
225       Jmsg(jcr, M_FATAL, 0, _("Pool resource \"%s\" not found.\n"), pr.Name);
226       return false;
227    }
228
229    /* If pool storage specified, use it for restore */
230    copy_rstorage(mig_jcr, pool->storage, _("Pool resource"));
231    copy_rstorage(jcr, pool->storage, _("Pool resource"));
232
233    /*
234     * If the original backup pool has a NextPool, make sure a 
235     *  record exists in the database. Note, in this case, we
236     *  will be migrating from pool to pool->NextPool.
237     */
238    if (pool->NextPool) {
239       jcr->jr.PoolId = get_or_create_pool_record(jcr, pool->NextPool->name());
240       if (jcr->jr.PoolId == 0) {
241          return false;
242       }
243    }
244    if (!set_migration_wstorage(jcr, pool)) {
245       return false;
246    }
247    mig_jcr->pool = jcr->pool = pool->NextPool;
248    pm_strcpy(jcr->pool_source, _("Job Pool's NextPool resource"));
249    mig_jcr->jr.PoolId = jcr->jr.PoolId;
250
251    Dmsg2(dbglevel, "Write pool=%s read rpool=%s\n", jcr->pool->name(), jcr->rpool->name());
252    return true;
253 }
254
255 /*
256  * Do a Migration of a previous job
257  *
258  *  Returns:  false on failure
259  *            true  on success
260  */
261 bool do_migration(JCR *jcr)
262 {
263    char ed1[100];
264    BSOCK *sd;
265    JCR *mig_jcr = jcr->mig_jcr;    /* newly migrated job */
266
267    /*
268     * If mig_jcr is NULL, there is nothing to do for this job,
269     *  so set a normal status, cleanup and return OK.
270     */
271    if (!mig_jcr) {
272       set_jcr_job_status(jcr, JS_Terminated);
273       migration_cleanup(jcr, jcr->JobStatus);
274       return true;
275    }
276
277    /* Print Job Start message */
278    Jmsg(jcr, M_INFO, 0, _("Start Migration JobId %s, Job=%s\n"),
279         edit_uint64(jcr->JobId, ed1), jcr->Job);
280
281
282
283    /*
284     * Open a message channel connection with the Storage
285     * daemon. This is to let him know that our client
286     * will be contacting him for a backup  session.
287     *
288     */
289    Dmsg0(110, "Open connection with storage daemon\n");
290    set_jcr_job_status(jcr, JS_WaitSD);
291    set_jcr_job_status(mig_jcr, JS_WaitSD);
292    /*
293     * Start conversation with Storage daemon
294     */
295    if (!connect_to_storage_daemon(jcr, 10, SDConnectTimeout, 1)) {
296       return false;
297    }
298    sd = jcr->store_bsock;
299    /*
300     * Now start a job with the Storage daemon
301     */
302    Dmsg2(dbglevel, "Read store=%s, write store=%s\n", 
303       ((STORE *)jcr->rstorage->first())->name(),
304       ((STORE *)jcr->wstorage->first())->name());
305    if (((STORE *)jcr->rstorage->first())->name() == ((STORE *)jcr->wstorage->first())->name()) {
306       Jmsg(jcr, M_FATAL, 0, _("Read storage \"%s\" same as write storage.\n"),
307            ((STORE *)jcr->rstorage->first())->name());
308       return false;
309    }
310    if (!start_storage_daemon_job(jcr, jcr->rstorage, jcr->wstorage)) {
311       return false;
312    }
313    Dmsg0(150, "Storage daemon connection OK\n");
314
315    if (!send_bootstrap_file(jcr, sd) ||
316        !response(jcr, sd, OKbootstrap, "Bootstrap", DISPLAY_ERROR)) {
317       return false;
318    }
319
320    /*    
321     * We re-update the job start record so that the start
322     *  time is set after the run before job.  This avoids 
323     *  that any files created by the run before job will
324     *  be saved twice.  They will be backed up in the current
325     *  job, but not in the next one unless they are changed.
326     *  Without this, they will be backed up in this job and
327     *  in the next job run because in that case, their date 
328     *   is after the start of this run.
329     */
330    jcr->start_time = time(NULL);
331    jcr->jr.StartTime = jcr->start_time;
332    jcr->jr.JobTDate = jcr->start_time;
333    set_jcr_job_status(jcr, JS_Running);
334
335    /* Update job start record for this migration control job */
336    if (!db_update_job_start_record(jcr, jcr->db, &jcr->jr)) {
337       Jmsg(jcr, M_FATAL, 0, "%s", db_strerror(jcr->db));
338       return false;
339    }
340
341
342    mig_jcr->start_time = time(NULL);
343    mig_jcr->jr.StartTime = mig_jcr->start_time;
344    mig_jcr->jr.JobTDate = mig_jcr->start_time;
345    set_jcr_job_status(mig_jcr, JS_Running);
346
347    /* Update job start record for the real migration backup job */
348    if (!db_update_job_start_record(mig_jcr, mig_jcr->db, &mig_jcr->jr)) {
349       Jmsg(jcr, M_FATAL, 0, "%s", db_strerror(mig_jcr->db));
350       return false;
351    }
352
353    Dmsg4(dbglevel, "mig_jcr: Name=%s JobId=%d Type=%c Level=%c\n",
354       mig_jcr->jr.Name, (int)mig_jcr->jr.JobId, 
355       mig_jcr->jr.JobType, mig_jcr->jr.JobLevel);
356
357
358    /*
359     * Start the job prior to starting the message thread below
360     * to avoid two threads from using the BSOCK structure at
361     * the same time.
362     */
363    if (!bnet_fsend(sd, "run")) {
364       return false;
365    }
366
367    /*
368     * Now start a Storage daemon message thread
369     */
370    if (!start_storage_daemon_message_thread(jcr)) {
371       return false;
372    }
373
374
375    set_jcr_job_status(jcr, JS_Running);
376    set_jcr_job_status(mig_jcr, JS_Running);
377
378    /* Pickup Job termination data */
379    /* Note, the SD stores in jcr->JobFiles/ReadBytes/JobBytes/Errors */
380    wait_for_storage_daemon_termination(jcr);
381    set_jcr_job_status(jcr, jcr->SDJobStatus);
382    db_write_batch_file_records(jcr);    /* used by bulk batch file insert */
383    if (jcr->JobStatus != JS_Terminated) {
384       return false;
385    }
386
387    migration_cleanup(jcr, jcr->JobStatus);
388    if (mig_jcr) {
389       char jobid[50];
390       UAContext *ua = new_ua_context(jcr);
391       edit_uint64(jcr->previous_jr.JobId, jobid);
392       /* Purge all old file records, but leave Job record */
393       purge_files_from_jobs(ua, jobid);
394       free_ua_context(ua);
395    }
396    return true;
397 }
398
399 struct idpkt {
400    POOLMEM *list;
401    uint32_t count;
402 };
403
404 /* Add an item to the list if it is unique */
405 static void add_unique_id(idpkt *ids, char *item) 
406 {
407    char id[30];
408    char *q = ids->list;
409
410    /* Walk through current list to see if each item is the same as item */
411    for ( ; *q; ) {
412        id[0] = 0;
413        for (int i=0; i<(int)sizeof(id); i++) {
414           if (*q == 0) {
415              break;
416           } else if (*q == ',') {
417              q++;
418              break;
419           }
420           id[i] = *q++;
421           id[i+1] = 0;
422        }
423        if (strcmp(item, id) == 0) {
424           return;
425        }
426    }
427    /* Did not find item, so add it to list */
428    if (ids->count == 0) {
429       ids->list[0] = 0;
430    } else {
431       pm_strcat(ids->list, ",");
432    }
433    pm_strcat(ids->list, item);
434    ids->count++;
435 // Dmsg3(0, "add_uniq count=%d Ids=%p %s\n", ids->count, ids->list, ids->list);
436    return;
437 }
438
439 /*
440  * Callback handler make list of DB Ids
441  */
442 static int unique_dbid_handler(void *ctx, int num_fields, char **row)
443 {
444    idpkt *ids = (idpkt *)ctx;
445
446    add_unique_id(ids, row[0]);
447    Dmsg3(dbglevel, "dbid_hdlr count=%d Ids=%p %s\n", ids->count, ids->list, ids->list);
448    return 0;
449 }
450
451
452 struct uitem {
453    dlink link;   
454    char *item;
455 };
456
457 static int item_compare(void *item1, void *item2)
458 {
459    uitem *i1 = (uitem *)item1;
460    uitem *i2 = (uitem *)item2;
461    return strcmp(i1->item, i2->item);
462 }
463
464 static int unique_name_handler(void *ctx, int num_fields, char **row)
465 {
466    dlist *list = (dlist *)ctx;
467
468    uitem *new_item = (uitem *)malloc(sizeof(uitem));
469    uitem *item;
470    
471    memset(new_item, 0, sizeof(uitem));
472    new_item->item = bstrdup(row[0]);
473    Dmsg1(dbglevel, "Unique_name_hdlr Item=%s\n", row[0]);
474    item = (uitem *)list->binary_insert((void *)new_item, item_compare);
475    if (item != new_item) {            /* already in list */
476       free(new_item->item);
477       free((char *)new_item);
478       return 0;
479    }
480    return 0;
481 }
482
483 /* Get Job names in Pool */
484 const char *sql_job =
485    "SELECT DISTINCT Job.Name from Job,Pool"
486    " WHERE Pool.Name='%s' AND Job.PoolId=Pool.PoolId";
487
488 /* Get JobIds from regex'ed Job names */
489 const char *sql_jobids_from_job =
490    "SELECT DISTINCT Job.JobId,Job.StartTime FROM Job,Pool"
491    " WHERE Job.Name='%s' AND Pool.Name='%s' AND Job.PoolId=Pool.PoolId"
492    " ORDER by Job.StartTime";
493
494 /* Get Client names in Pool */
495 const char *sql_client =
496    "SELECT DISTINCT Client.Name from Client,Pool,Job"
497    " WHERE Pool.Name='%s' AND Job.ClientId=Client.ClientId AND"
498    " Job.PoolId=Pool.PoolId";
499
500 /* Get JobIds from regex'ed Client names */
501 const char *sql_jobids_from_client =
502    "SELECT DISTINCT Job.JobId,Job.StartTime FROM Job,Pool,Client"
503    " WHERE Client.Name='%s' AND Pool.Name='%s' AND Job.PoolId=Pool.PoolId"
504    " AND Job.ClientId=Client.ClientId AND Job.Type='B'"
505    " ORDER by Job.StartTime";
506
507 /* Get Volume names in Pool */
508 const char *sql_vol = 
509    "SELECT DISTINCT VolumeName FROM Media,Pool WHERE"
510    " VolStatus in ('Full','Used','Error') AND Media.Enabled=1 AND"
511    " Media.PoolId=Pool.PoolId AND Pool.Name='%s'";
512
513 /* Get JobIds from regex'ed Volume names */
514 const char *sql_jobids_from_vol =
515    "SELECT DISTINCT Job.JobId,Job.StartTime FROM Media,JobMedia,Job"
516    " WHERE Media.VolumeName='%s' AND Media.MediaId=JobMedia.MediaId"
517    " AND JobMedia.JobId=Job.JobId AND Job.Type='B'"
518    " ORDER by Job.StartTime";
519
520
521 const char *sql_smallest_vol = 
522    "SELECT MediaId FROM Media,Pool WHERE"
523    " VolStatus in ('Full','Used','Error') AND Media.Enabled=1 AND"
524    " Media.PoolId=Pool.PoolId AND Pool.Name='%s'"
525    " ORDER BY VolBytes ASC LIMIT 1";
526
527 const char *sql_oldest_vol = 
528    "SELECT MediaId FROM Media,Pool WHERE"
529    " VolStatus in ('Full','Used','Error') AND Media.Enabled=1 AND"
530    " Media.PoolId=Pool.PoolId AND Pool.Name='%s'"
531    " ORDER BY LastWritten ASC LIMIT 1";
532
533 /* Get JobIds when we have selected MediaId */
534 const char *sql_jobids_from_mediaid =
535    "SELECT DISTINCT Job.JobId,Job.StartTime FROM JobMedia,Job"
536    " WHERE JobMedia.JobId=Job.JobId AND JobMedia.MediaId=%s"
537    " AND Job.Type='B'"
538    " ORDER by Job.StartTime";
539
540 /* Get tne number of bytes in the pool */
541 const char *sql_pool_bytes =
542    "SELECT SUM(VolBytes) FROM Media,Pool WHERE"
543    " VolStatus in ('Full','Used','Error','Append') AND Media.Enabled=1 AND"
544    " Media.PoolId=Pool.PoolId AND Pool.Name='%s'";
545
546 /* Get tne number of bytes in the Jobs */
547 const char *sql_job_bytes =
548    "SELECT SUM(JobBytes) FROM Job WHERE JobId IN (%s)";
549
550
551 /* Get Media Ids in Pool */
552 const char *sql_mediaids =
553    "SELECT MediaId FROM Media,Pool WHERE"
554    " VolStatus in ('Full','Used','Error') AND Media.Enabled=1 AND"
555    " Media.PoolId=Pool.PoolId AND Pool.Name='%s' ORDER BY LastWritten ASC";
556
557 /* Get JobIds in Pool longer than specified time */
558 const char *sql_pool_time = 
559    "SELECT DISTINCT Job.JobId from Pool,Job,Media,JobMedia WHERE"
560    " Pool.Name='%s' AND Media.PoolId=Pool.PoolId AND"
561    " VolStatus in ('Full','Used','Error') AND Media.Enabled=1 AND"
562    " Job.Type='B' AND"
563    " JobMedia.JobId=Job.JobId AND Job.PoolId=Media.PoolId"
564    " AND Job.RealEndTime<='%s'";
565
566 /*
567 * const char *sql_ujobid =
568 *   "SELECT DISTINCT Job.Job from Client,Pool,Media,Job,JobMedia "
569 *   " WHERE Media.PoolId=Pool.PoolId AND Pool.Name='%s' AND"
570 *   " JobMedia.JobId=Job.JobId AND Job.PoolId=Media.PoolId";
571 */
572
573
574
575 /*
576  *
577  * This is the central piece of code that finds a job or jobs 
578  *   actually JobIds to migrate.  It first looks to see if one
579  *   has been "manually" specified in jcr->MigrateJobId, and if
580  *   so, it returns that JobId to be run.  Otherwise, it
581  *   examines the Selection Type to see what kind of migration
582  *   we are doing (Volume, Job, Client, ...) and applies any
583  *   Selection Pattern if appropriate to obtain a list of JobIds.
584  *   Finally, it will loop over all the JobIds found, except the last
585  *   one starting a new job with MigrationJobId set to that JobId, and
586  *   finally, it returns the last JobId to the caller.
587  *
588  * Returns: -1  on error
589  *           0  if no jobs to migrate
590  *           1  if OK and jcr->previous_jr filled in
591  */
592 static int get_job_to_migrate(JCR *jcr)
593 {
594    char ed1[30], ed2[30];
595    POOL_MEM query(PM_MESSAGE);
596    JobId_t JobId;
597    DBId_t  MediaId = 0;
598    int stat;
599    char *p;
600    idpkt ids, mid, jids;
601    db_int64_ctx ctx;
602    int64_t pool_bytes;
603    time_t ttime;
604    struct tm tm;
605    char dt[MAX_TIME_LENGTH];
606    int count = 0;
607
608    ids.list = get_pool_memory(PM_MESSAGE);
609    ids.list[0] = 0;
610    ids.count = 0;
611    mid.list = get_pool_memory(PM_MESSAGE);
612    mid.list[0] = 0;
613    mid.count = 0;
614    jids.list = get_pool_memory(PM_MESSAGE);
615    jids.list[0] = 0;
616    jids.count = 0;
617
618
619    /*
620     * If MigrateJobId is set, then we migrate only that Job,
621     *  otherwise, we go through the full selection of jobs to
622     *  migrate.
623     */
624    if (jcr->MigrateJobId != 0) {
625       Dmsg1(dbglevel, "At Job start previous jobid=%u\n", jcr->MigrateJobId);
626       edit_uint64(jcr->MigrateJobId, ids.list);
627       ids.count = 1;
628    } else {
629       switch (jcr->job->selection_type) {
630       case MT_JOB:
631          if (!regex_find_jobids(jcr, &ids, sql_job, sql_jobids_from_job, "Job")) {
632             goto bail_out;
633          } 
634          break;
635       case MT_CLIENT:
636          if (!regex_find_jobids(jcr, &ids, sql_client, sql_jobids_from_client, "Client")) {
637             goto bail_out;
638          } 
639          break;
640       case MT_VOLUME:
641          if (!regex_find_jobids(jcr, &ids, sql_vol, sql_jobids_from_vol, "Volume")) {
642             goto bail_out;
643          } 
644          break;
645       case MT_SQLQUERY:
646          if (!jcr->job->selection_pattern) {
647             Jmsg(jcr, M_FATAL, 0, _("No Migration SQL selection pattern specified.\n"));
648             goto bail_out;
649          }
650          Dmsg1(dbglevel, "SQL=%s\n", jcr->job->selection_pattern);
651          if (!db_sql_query(jcr->db, jcr->job->selection_pattern,
652               unique_dbid_handler, (void *)&ids)) {
653             Jmsg(jcr, M_FATAL, 0,
654                  _("SQL failed. ERR=%s\n"), db_strerror(jcr->db));
655             goto bail_out;
656          }
657          break;
658       case MT_SMALLEST_VOL:
659          if (!find_mediaid_then_jobids(jcr, &ids, sql_smallest_vol, "Smallest Volume")) {
660             goto bail_out;
661          }
662          break;
663       case MT_OLDEST_VOL:
664          if (!find_mediaid_then_jobids(jcr, &ids, sql_oldest_vol, "Oldest Volume")) {
665             goto bail_out;
666          }
667          break;
668
669       case MT_POOL_OCCUPANCY:
670          ctx.count = 0;
671          /* Find count of bytes in pool */
672          Mmsg(query, sql_pool_bytes, jcr->rpool->name());
673          if (!db_sql_query(jcr->db, query.c_str(), db_int64_handler, (void *)&ctx)) {
674             Jmsg(jcr, M_FATAL, 0, _("SQL failed. ERR=%s\n"), db_strerror(jcr->db));
675             goto bail_out;
676          }
677          if (ctx.count == 0) {
678             Jmsg(jcr, M_INFO, 0, _("No Volumes found to migrate.\n"));
679             goto ok_out;
680          }
681          pool_bytes = ctx.value;
682          Dmsg2(dbglevel, "highbytes=%d pool=%d\n", (int)jcr->rpool->MigrationHighBytes,
683                (int)pool_bytes);
684          if (pool_bytes < (int64_t)jcr->rpool->MigrationHighBytes) {
685             Jmsg(jcr, M_INFO, 0, _("No Volumes found to migrate.\n"));
686             goto ok_out;
687          }
688          Dmsg0(dbglevel, "We should do Occupation migration.\n");
689
690          ids.count = 0;
691          /* Find a list of MediaIds that could be migrated */
692          Mmsg(query, sql_mediaids, jcr->rpool->name());
693          Dmsg1(dbglevel, "query=%s\n", query.c_str());
694          if (!db_sql_query(jcr->db, query.c_str(), unique_dbid_handler, (void *)&ids)) {
695             Jmsg(jcr, M_FATAL, 0, _("SQL failed. ERR=%s\n"), db_strerror(jcr->db));
696             goto bail_out;
697          }
698          if (ids.count == 0) {
699             Jmsg(jcr, M_INFO, 0, _("No Volumes found to migrate.\n"));
700             goto ok_out;
701          }
702          Dmsg2(dbglevel, "Pool Occupancy ids=%d MediaIds=%s\n", ids.count, ids.list);
703
704          /*
705           * Now loop over MediaIds getting more JobIds to migrate until
706           *  we reduce the pool occupancy below the low water mark.
707           */
708          p = ids.list;
709          for (int i=0; i < (int)ids.count; i++) {
710             stat = get_next_dbid_from_list(&p, &MediaId);
711             Dmsg2(dbglevel, "get_next_dbid stat=%d MediaId=%u\n", stat, MediaId);
712             if (stat < 0) {
713                Jmsg(jcr, M_FATAL, 0, _("Invalid MediaId found.\n"));
714                goto bail_out;
715             } else if (stat == 0) {
716                break;
717             }
718             mid.count = 1;
719             Mmsg(mid.list, "%s", edit_int64(MediaId, ed1));
720             if (!find_jobids_from_mediaid_list(jcr, &mid, "Volumes")) {
721                continue;
722             }
723             if (i != 0) {
724                pm_strcat(jids.list, ",");
725             }
726             pm_strcat(jids.list, mid.list);
727             jids.count += mid.count;
728
729             /* Now get the count of bytes added */
730             ctx.count = 0;
731             /* Find count of bytes from Jobs */
732             Mmsg(query, sql_job_bytes, mid.list);
733             Dmsg1(dbglevel, "Jobbytes query: %s\n", query.c_str());
734             if (!db_sql_query(jcr->db, query.c_str(), db_int64_handler, (void *)&ctx)) {
735                Jmsg(jcr, M_FATAL, 0, _("SQL failed. ERR=%s\n"), db_strerror(jcr->db));
736                goto bail_out;
737             }
738             pool_bytes -= ctx.value;
739             Dmsg1(dbglevel, "Total migrate Job bytes=%s\n", edit_int64(ctx.value, ed1));
740             Dmsg2(dbglevel, "lowbytes=%s poolafter=%s\n", 
741                   edit_int64(jcr->rpool->MigrationLowBytes, ed1),
742                   edit_int64(pool_bytes, ed2));
743             if (pool_bytes <= (int64_t)jcr->rpool->MigrationLowBytes) {
744                Dmsg0(dbglevel, "We should be done.\n");
745                break;
746             }
747
748          }
749          /* Transfer jids to ids, where the jobs list is expected */
750          ids.count = jids.count;
751          pm_strcpy(ids.list, jids.list);
752          Dmsg2(dbglevel, "Pool Occupancy ids=%d JobIds=%s\n", ids.count, ids.list);
753          break;
754
755       case MT_POOL_TIME:
756          ttime = time(NULL) - (time_t)jcr->rpool->MigrationTime;
757          (void)localtime_r(&ttime, &tm);
758          strftime(dt, sizeof(dt), "%Y-%m-%d %H:%M:%S", &tm);
759
760          ids.count = 0;
761          Mmsg(query, sql_pool_time, jcr->rpool->name(), dt);
762          Dmsg1(dbglevel, "query=%s\n", query.c_str());
763          if (!db_sql_query(jcr->db, query.c_str(), unique_dbid_handler, (void *)&ids)) {
764             Jmsg(jcr, M_FATAL, 0, _("SQL failed. ERR=%s\n"), db_strerror(jcr->db));
765             goto bail_out;
766          }
767          if (ids.count == 0) {
768             Jmsg(jcr, M_INFO, 0, _("No Volumes found to migrate.\n"));
769             goto ok_out;
770          }
771          Dmsg2(dbglevel, "PoolTime ids=%d JobIds=%s\n", ids.count, ids.list);
772          break;
773
774       default:
775          Jmsg(jcr, M_FATAL, 0, _("Unknown Migration Selection Type.\n"));
776          goto bail_out;
777       }
778    }
779
780    /*
781     * Loop over all jobids except the last one, sending
782     *  them to start_migration_job(), which will start a job
783     *  for each of them.  For the last JobId, we handle it below.
784     */
785    p = ids.list;
786    if (ids.count == 0) {
787       Jmsg(jcr, M_INFO, 0, _("No JobIds found to migrate.\n"));
788       goto ok_out;
789    }
790
791    Jmsg(jcr, M_INFO, 0, _("The following %u JobId%s were chosen to be migrated: %s\n"),
792       ids.count, ids.count==0?"":"s", ids.list);
793
794    Dmsg2(dbglevel, "Before loop count=%d ids=%s\n", ids.count, ids.list);
795    for (int i=1; i < (int)ids.count; i++) {
796       JobId = 0;
797       stat = get_next_jobid_from_list(&p, &JobId);
798       Dmsg3(dbglevel, "get_jobid_no=%d stat=%d JobId=%u\n", i, stat, JobId);
799       jcr->MigrateJobId = JobId;
800       start_migration_job(jcr);
801       Dmsg0(dbglevel, "Back from start_migration_job\n");
802       if (stat < 0) {
803          Jmsg(jcr, M_FATAL, 0, _("Invalid JobId found.\n"));
804          goto bail_out;
805       } else if (stat == 0) {
806          Jmsg(jcr, M_INFO, 0, _("No JobIds found to migrate.\n"));
807          goto ok_out;
808       }
809    }
810    
811    /* Now get the last JobId and handle it in the current job */
812    JobId = 0;
813    stat = get_next_jobid_from_list(&p, &JobId);
814    Dmsg2(dbglevel, "Last get_next_jobid stat=%d JobId=%u\n", stat, (int)JobId);
815    if (stat < 0) {
816       Jmsg(jcr, M_FATAL, 0, _("Invalid JobId found.\n"));
817       goto bail_out;
818    } else if (stat == 0) {
819       Jmsg(jcr, M_INFO, 0, _("No JobIds found to migrate.\n"));
820       goto ok_out;
821    }
822
823    jcr->previous_jr.JobId = JobId;
824    Dmsg1(dbglevel, "Previous jobid=%d\n", (int)jcr->previous_jr.JobId);
825
826    if (!db_get_job_record(jcr, jcr->db, &jcr->previous_jr)) {
827       Jmsg(jcr, M_FATAL, 0, _("Could not get job record for JobId %s to migrate. ERR=%s"),
828            edit_int64(jcr->previous_jr.JobId, ed1),
829            db_strerror(jcr->db));
830       goto bail_out;
831    }
832    Jmsg(jcr, M_INFO, 0, _("Migration using JobId=%s Job=%s\n"),
833       edit_int64(jcr->previous_jr.JobId, ed1), jcr->previous_jr.Job);
834    Dmsg3(dbglevel, "Migration JobId=%d  using JobId=%s Job=%s\n",
835       jcr->JobId,
836       edit_int64(jcr->previous_jr.JobId, ed1), jcr->previous_jr.Job);
837    count = 1;
838
839 ok_out:
840    goto out;
841
842 bail_out:
843    count = -1;
844            
845 out:
846    free_pool_memory(ids.list);
847    free_pool_memory(mid.list);
848    free_pool_memory(jids.list);
849    return count;
850 }
851
852 static void start_migration_job(JCR *jcr)
853 {
854    UAContext *ua = new_ua_context(jcr);
855    char ed1[50];
856    ua->batch = true;
857    Mmsg(ua->cmd, "run %s jobid=%s", jcr->job->hdr.name, 
858         edit_uint64(jcr->MigrateJobId, ed1));
859    Dmsg1(dbglevel, "=============== Migration cmd=%s\n", ua->cmd);
860    parse_ua_args(ua);                 /* parse command */
861    int stat = run_cmd(ua, ua->cmd);
862    if (stat == 0) {
863       Jmsg(jcr, M_ERROR, 0, _("Could not start migration job.\n"));
864    } else {
865       Jmsg(jcr, M_INFO, 0, _("Migration JobId %d started.\n"), stat);
866    }
867    free_ua_context(ua);
868 }
869
870 static bool find_mediaid_then_jobids(JCR *jcr, idpkt *ids, const char *query1,
871                  const char *type) 
872 {
873    bool ok = false;
874    POOL_MEM query(PM_MESSAGE);
875
876    ids->count = 0;
877    /* Basic query for MediaId */
878    Mmsg(query, query1, jcr->rpool->name());
879    if (!db_sql_query(jcr->db, query.c_str(), unique_dbid_handler, (void *)ids)) {
880       Jmsg(jcr, M_FATAL, 0, _("SQL failed. ERR=%s\n"), db_strerror(jcr->db));
881       goto bail_out;
882    }
883    if (ids->count == 0) {
884       Jmsg(jcr, M_INFO, 0, _("No %ss found to migrate.\n"), type);
885       ok = true;         /* Not an error */
886       goto bail_out;
887    } else if (ids->count != 1) {
888       Jmsg(jcr, M_FATAL, 0, _("SQL error. Expected 1 MediaId got %d\n"), 
889          ids->count);
890       goto bail_out;
891    }
892    Dmsg1(dbglevel, "Smallest Vol Jobids=%s\n", ids->list);
893
894    ok = find_jobids_from_mediaid_list(jcr, ids, type);
895
896 bail_out:
897    return ok;
898 }
899
900 static bool find_jobids_from_mediaid_list(JCR *jcr, idpkt *ids, const char *type) 
901 {
902    bool ok = false;
903    POOL_MEM query(PM_MESSAGE);
904
905    Mmsg(query, sql_jobids_from_mediaid, ids->list);
906    ids->count = 0;
907    if (!db_sql_query(jcr->db, query.c_str(), unique_dbid_handler, (void *)ids)) {
908       Jmsg(jcr, M_FATAL, 0, _("SQL failed. ERR=%s\n"), db_strerror(jcr->db));
909       goto bail_out;
910    }
911    if (ids->count == 0) {
912       Jmsg(jcr, M_INFO, 0, _("No %ss found to migrate.\n"), type);
913    }
914    ok = true;
915 bail_out:
916    return ok;
917 }
918
919 static bool regex_find_jobids(JCR *jcr, idpkt *ids, const char *query1,
920                  const char *query2, const char *type) 
921 {
922    dlist *item_chain;
923    uitem *item = NULL;
924    uitem *last_item = NULL;
925    regex_t preg;
926    char prbuf[500];
927    int rc;
928    bool ok = false;
929    POOL_MEM query(PM_MESSAGE);
930
931    item_chain = New(dlist(item, &item->link));
932    if (!jcr->job->selection_pattern) {
933       Jmsg(jcr, M_FATAL, 0, _("No Migration %s selection pattern specified.\n"),
934          type);
935       goto bail_out;
936    }
937    Dmsg1(dbglevel, "regex-sel-pattern=%s\n", jcr->job->selection_pattern);
938    /* Basic query for names */
939    Mmsg(query, query1, jcr->rpool->name());
940    Dmsg1(dbglevel, "get name query1=%s\n", query.c_str());
941    if (!db_sql_query(jcr->db, query.c_str(), unique_name_handler, 
942         (void *)item_chain)) {
943       Jmsg(jcr, M_FATAL, 0,
944            _("SQL to get %s failed. ERR=%s\n"), type, db_strerror(jcr->db));
945       goto bail_out;
946    }
947    Dmsg1(dbglevel, "query1 returned %d names\n", item_chain->size());
948    if (item_chain->size() == 0) {
949       Jmsg(jcr, M_INFO, 0, _("Query of Pool \"%s\" returned no Jobs to migrate.\n"),
950            jcr->rpool->name());
951       ok = true;
952       goto bail_out;               /* skip regex match */
953    } else {
954       /* Compile regex expression */
955       rc = regcomp(&preg, jcr->job->selection_pattern, REG_EXTENDED);
956       if (rc != 0) {
957          regerror(rc, &preg, prbuf, sizeof(prbuf));
958          Jmsg(jcr, M_FATAL, 0, _("Could not compile regex pattern \"%s\" ERR=%s\n"),
959               jcr->job->selection_pattern, prbuf);
960          goto bail_out;
961       }
962       /* Now apply the regex to the names and remove any item not matched */
963       foreach_dlist(item, item_chain) {
964          const int nmatch = 30;
965          regmatch_t pmatch[nmatch];
966          if (last_item) {
967             Dmsg1(dbglevel, "Remove item %s\n", last_item->item);
968             free(last_item->item);
969             item_chain->remove(last_item);
970          }
971          Dmsg1(dbglevel, "get name Item=%s\n", item->item);
972          rc = regexec(&preg, item->item, nmatch, pmatch,  0);
973          if (rc == 0) {
974             last_item = NULL;   /* keep this one */
975          } else {   
976             last_item = item;
977          }
978       }
979       if (last_item) {
980          free(last_item->item);
981          Dmsg1(dbglevel, "Remove item %s\n", last_item->item);
982          item_chain->remove(last_item);
983       }
984       regfree(&preg);
985    }
986    if (item_chain->size() == 0) {
987       Jmsg(jcr, M_INFO, 0, _("Regex pattern matched no Jobs to migrate.\n"));
988       ok = true;
989       goto bail_out;               /* skip regex match */
990    }
991
992    /* 
993     * At this point, we have a list of items in item_chain
994     *  that have been matched by the regex, so now we need
995     *  to look up their jobids.
996     */
997    ids->count = 0;
998    foreach_dlist(item, item_chain) {
999       Dmsg2(dbglevel, "Got %s: %s\n", type, item->item);
1000       Mmsg(query, query2, item->item, jcr->rpool->name());
1001       Dmsg1(dbglevel, "get id from name query2=%s\n", query.c_str());
1002       if (!db_sql_query(jcr->db, query.c_str(), unique_dbid_handler, (void *)ids)) {
1003          Jmsg(jcr, M_FATAL, 0,
1004               _("SQL failed. ERR=%s\n"), db_strerror(jcr->db));
1005          goto bail_out;
1006       }
1007    }
1008    if (ids->count == 0) {
1009       Jmsg(jcr, M_INFO, 0, _("No %ss found to migrate.\n"), type);
1010    }
1011    ok = true;
1012
1013 bail_out:
1014    Dmsg2(dbglevel, "Count=%d Jobids=%s\n", ids->count, ids->list);
1015    foreach_dlist(item, item_chain) {
1016       free(item->item);
1017    }
1018    delete item_chain;
1019    return ok;
1020 }
1021
1022
1023 /*
1024  * Release resources allocated during backup.
1025  */
1026 void migration_cleanup(JCR *jcr, int TermCode)
1027 {
1028    char sdt[MAX_TIME_LENGTH], edt[MAX_TIME_LENGTH];
1029    char ec1[30], ec2[30], ec3[30], ec4[30], ec5[30], elapsed[50];
1030    char ec6[50], ec7[50], ec8[50];
1031    char term_code[100], sd_term_msg[100];
1032    const char *term_msg;
1033    int msg_type = M_INFO;
1034    MEDIA_DBR mr;
1035    double kbps;
1036    utime_t RunTime;
1037    JCR *mig_jcr = jcr->mig_jcr;
1038    POOL_MEM query(PM_MESSAGE);
1039
1040    Dmsg2(100, "Enter migrate_cleanup %d %c\n", TermCode, TermCode);
1041    update_job_end(jcr, TermCode);
1042    memset(&mr, 0, sizeof(mr));
1043
1044    /* 
1045     * Check if we actually did something.  
1046     *  mig_jcr is jcr of the newly migrated job.
1047     */
1048    if (mig_jcr) {
1049       mig_jcr->JobFiles = jcr->JobFiles = jcr->SDJobFiles;
1050       mig_jcr->JobBytes = jcr->JobBytes = jcr->SDJobBytes;
1051       mig_jcr->VolSessionId = jcr->VolSessionId;
1052       mig_jcr->VolSessionTime = jcr->VolSessionTime;
1053       mig_jcr->jr.RealEndTime = 0; 
1054       mig_jcr->jr.PriorJobId = jcr->previous_jr.JobId;
1055
1056       update_job_end(mig_jcr, TermCode);
1057      
1058       /* Update final items to set them to the previous job's values */
1059       Mmsg(query, "UPDATE Job SET StartTime='%s',EndTime='%s',"
1060                   "JobTDate=%s WHERE JobId=%s", 
1061          jcr->previous_jr.cStartTime, jcr->previous_jr.cEndTime, 
1062          edit_uint64(jcr->previous_jr.JobTDate, ec1),
1063          edit_uint64(mig_jcr->jr.JobId, ec2));
1064       db_sql_query(mig_jcr->db, query.c_str(), NULL, NULL);
1065
1066       /* Now mark the previous job as migrated if it terminated normally */
1067       if (jcr->JobStatus == JS_Terminated) {
1068          Mmsg(query, "UPDATE Job SET Type='%c' WHERE JobId=%s",
1069               (char)JT_MIGRATED_JOB, edit_uint64(jcr->previous_jr.JobId, ec1));
1070          db_sql_query(mig_jcr->db, query.c_str(), NULL, NULL);
1071       } 
1072
1073       if (!db_get_job_record(jcr, jcr->db, &jcr->jr)) {
1074          Jmsg(jcr, M_WARNING, 0, _("Error getting Job record for Job report: ERR=%s"),
1075             db_strerror(jcr->db));
1076          set_jcr_job_status(jcr, JS_ErrorTerminated);
1077       }
1078
1079       bstrncpy(mr.VolumeName, jcr->VolumeName, sizeof(mr.VolumeName));
1080       if (!db_get_media_record(jcr, jcr->db, &mr)) {
1081          Jmsg(jcr, M_WARNING, 0, _("Error getting Media record for Volume \"%s\": ERR=%s"),
1082             mr.VolumeName, db_strerror(jcr->db));
1083          set_jcr_job_status(jcr, JS_ErrorTerminated);
1084       }
1085
1086       update_bootstrap_file(mig_jcr);
1087
1088       if (!db_get_job_volume_names(mig_jcr, mig_jcr->db, mig_jcr->jr.JobId, &mig_jcr->VolumeName)) {
1089          /*
1090           * Note, if the job has failed, most likely it did not write any
1091           *  tape, so suppress this "error" message since in that case
1092           *  it is normal.  Or look at it the other way, only for a
1093           *  normal exit should we complain about this error.
1094           */
1095          if (jcr->JobStatus == JS_Terminated && jcr->jr.JobBytes) {
1096             Jmsg(jcr, M_ERROR, 0, "%s", db_strerror(mig_jcr->db));
1097          }
1098          mig_jcr->VolumeName[0] = 0;         /* none */
1099       }
1100       switch (jcr->JobStatus) {
1101       case JS_Terminated:
1102          if (jcr->Errors || jcr->SDErrors) {
1103             term_msg = _("%s OK -- with warnings");
1104          } else {
1105             term_msg = _("%s OK");
1106          }
1107          break;
1108       case JS_FatalError:
1109       case JS_ErrorTerminated:
1110          term_msg = _("*** %s Error ***");
1111          msg_type = M_ERROR;          /* Generate error message */
1112          if (jcr->store_bsock) {
1113             bnet_sig(jcr->store_bsock, BNET_TERMINATE);
1114             if (jcr->SD_msg_chan) {
1115                pthread_cancel(jcr->SD_msg_chan);
1116             }
1117          }
1118          break;
1119       case JS_Canceled:
1120          term_msg = _("%s Canceled");
1121          if (jcr->store_bsock) {
1122             bnet_sig(jcr->store_bsock, BNET_TERMINATE);
1123             if (jcr->SD_msg_chan) {
1124                pthread_cancel(jcr->SD_msg_chan);
1125             }
1126          }
1127          break;
1128       default:
1129          term_msg = _("Inappropriate %s term code");
1130          break;
1131       }
1132   } else {
1133      if (jcr->previous_jr.JobId != 0) {
1134         /* Mark previous job as migrated */
1135         Mmsg(query, "UPDATE Job SET Type='%c' WHERE JobId=%s",
1136              (char)JT_MIGRATED_JOB, edit_uint64(jcr->previous_jr.JobId, ec1));
1137         Dmsg1(000, "Mark: %s\n", query.c_str());
1138         db_sql_query(jcr->db, query.c_str(), NULL, NULL);
1139      }
1140      term_msg = _("%s -- no files to migrate");
1141   }
1142
1143    bsnprintf(term_code, sizeof(term_code), term_msg, "Migration");
1144    bstrftimes(sdt, sizeof(sdt), jcr->jr.StartTime);
1145    bstrftimes(edt, sizeof(edt), jcr->jr.EndTime);
1146    RunTime = jcr->jr.EndTime - jcr->jr.StartTime;
1147    if (RunTime <= 0) {
1148       kbps = 0;
1149    } else {
1150       kbps = (double)jcr->SDJobBytes / (1000 * RunTime);
1151    }
1152
1153
1154    jobstatus_to_ascii(jcr->SDJobStatus, sd_term_msg, sizeof(sd_term_msg));
1155
1156    Jmsg(jcr, msg_type, 0, _("Bacula %s %s (%s): %s\n"
1157 "  Build OS:               %s %s %s\n"
1158 "  Prev Backup JobId:      %s\n"
1159 "  New Backup JobId:       %s\n"
1160 "  Migration JobId:        %s\n"
1161 "  Migration Job:          %s\n"
1162 "  Backup Level:           %s%s\n"
1163 "  Client:                 %s\n"
1164 "  FileSet:                \"%s\" %s\n"
1165 "  Read Pool:              \"%s\" (From %s)\n"
1166 "  Read Storage:           \"%s\" (From %s)\n"
1167 "  Write Pool:             \"%s\" (From %s)\n"
1168 "  Write Storage:          \"%s\" (From %s)\n"
1169 "  Start time:             %s\n"
1170 "  End time:               %s\n"
1171 "  Elapsed time:           %s\n"
1172 "  Priority:               %d\n"
1173 "  SD Files Written:       %s\n"
1174 "  SD Bytes Written:       %s (%sB)\n"
1175 "  Rate:                   %.1f KB/s\n"
1176 "  Volume name(s):         %s\n"
1177 "  Volume Session Id:      %d\n"
1178 "  Volume Session Time:    %d\n"
1179 "  Last Volume Bytes:      %s (%sB)\n"
1180 "  SD Errors:              %d\n"
1181 "  SD termination status:  %s\n"
1182 "  Termination:            %s\n\n"),
1183         my_name, VERSION, LSMDATE, edt,
1184         HOST_OS, DISTNAME, DISTVER,
1185         edit_uint64(jcr->previous_jr.JobId, ec6),
1186         mig_jcr ? edit_uint64(mig_jcr->jr.JobId, ec7) : "0",
1187         edit_uint64(jcr->jr.JobId, ec8),
1188         jcr->jr.Job,
1189         level_to_str(jcr->JobLevel), jcr->since,
1190         jcr->client->name(),
1191         jcr->fileset->name(), jcr->FSCreateTime,
1192         jcr->rpool->name(), jcr->rpool_source,
1193         jcr->rstore?jcr->rstore->name():"*None*", 
1194         NPRT(jcr->rstore_source), 
1195         jcr->pool->name(), jcr->pool_source,
1196         jcr->wstore?jcr->wstore->name():"*None*", 
1197         NPRT(jcr->wstore_source),
1198         sdt,
1199         edt,
1200         edit_utime(RunTime, elapsed, sizeof(elapsed)),
1201         jcr->JobPriority,
1202         edit_uint64_with_commas(jcr->SDJobFiles, ec1),
1203         edit_uint64_with_commas(jcr->SDJobBytes, ec2),
1204         edit_uint64_with_suffix(jcr->SDJobBytes, ec3),
1205         (float)kbps,
1206         mig_jcr ? mig_jcr->VolumeName : "",
1207         jcr->VolSessionId,
1208         jcr->VolSessionTime,
1209         edit_uint64_with_commas(mr.VolBytes, ec4),
1210         edit_uint64_with_suffix(mr.VolBytes, ec5),
1211         jcr->SDErrors,
1212         sd_term_msg,
1213         term_code);
1214
1215    Dmsg1(100, "migrate_cleanup() mig_jcr=0x%x\n", jcr->mig_jcr);
1216    if (jcr->mig_jcr) {
1217       free_jcr(jcr->mig_jcr);
1218       jcr->mig_jcr = NULL;
1219    }
1220    Dmsg0(100, "Leave migrate_cleanup()\n");
1221 }
1222
1223 /* 
1224  * Return next DBId from comma separated list   
1225  *
1226  * Returns:
1227  *   1 if next DBId returned
1228  *   0 if no more DBIds are in list
1229  *  -1 there is an error
1230  */
1231 static int get_next_dbid_from_list(char **p, DBId_t *DBId)
1232 {
1233    char id[30];
1234    char *q = *p;
1235
1236    id[0] = 0;
1237    for (int i=0; i<(int)sizeof(id); i++) {
1238       if (*q == 0) {
1239          break;
1240       } else if (*q == ',') {
1241          q++;
1242          break;
1243       }
1244       id[i] = *q++;
1245       id[i+1] = 0;
1246    }
1247    if (id[0] == 0) {
1248       return 0;
1249    } else if (!is_a_number(id)) {
1250       return -1;                      /* error */
1251    }
1252    *p = q;
1253    *DBId = str_to_int64(id);
1254    return 1;
1255 }
1256
1257 bool set_migration_wstorage(JCR *jcr, POOL *pool)
1258 {
1259    POOL *wpool = pool->NextPool;
1260
1261    if (!wpool) {
1262       Jmsg(jcr, M_FATAL, 0, _("No Next Pool specification found in Pool \"%s\".\n"),
1263          pool->hdr.name);
1264       return false;
1265    }
1266
1267    if (!wpool->storage || wpool->storage->size() == 0) {
1268       Jmsg(jcr, M_FATAL, 0, _("No Storage specification found in Next Pool \"%s\".\n"),
1269          wpool->name());
1270       return false;
1271    }
1272
1273    /* If pool storage specified, use it instead of job storage for backup */
1274    copy_wstorage(jcr, wpool->storage, _("Storage from Pool's NextPool resource"));
1275    return true;
1276 }