]> git.sur5r.net Git - bacula/bacula/blob - bacula/src/dird/backup.c
Tweak restart base
[bacula/bacula] / bacula / src / dird / backup.c
1 /*
2    Bacula® - The Network Backup Solution
3
4    Copyright (C) 2000-2011 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 three of the GNU Affero General Public
10    License as published by the Free Software Foundation and included
11    in the file LICENSE.
12
13    This program is distributed in the hope that it will be useful, but
14    WITHOUT ANY WARRANTY; without even the implied warranty of
15    MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE. See the GNU
16    General Public License for more details.
17
18    You should have received a copy of the GNU Affero General Public License
19    along with this program; if not, write to the Free Software
20    Foundation, Inc., 51 Franklin Street, Fifth Floor, Boston, MA
21    02110-1301, USA.
22
23    Bacula® is a registered trademark of Kern Sibbald.
24    The licensor of Bacula is the Free Software Foundation Europe
25    (FSFE), Fiduciary Program, Sumatrastrasse 25, 8006 Zürich,
26    Switzerland, email:ftf@fsfeurope.org.
27 */
28 /*
29  *
30  *   Bacula Director -- backup.c -- responsible for doing backup jobs
31  *
32  *     Kern Sibbald, March MM
33  *
34  *  Basic tasks done here:
35  *     Open DB and create records for this job.
36  *     Open Message Channel with Storage daemon to tell him a job will be starting.
37  *     Open connection with File daemon and pass him commands
38  *       to do the backup.
39  *     When the File daemon finishes the job, update the DB.
40  *
41  */
42
43 #include "bacula.h"
44 #include "dird.h"
45 #include "ua.h"
46
47 /* Commands sent to File daemon */
48 static char backupcmd[] = "backup FileIndex=%ld\n";
49 static char storaddr[]  = "storage address=%s port=%d ssl=%d\n";
50
51 /* Responses received from File daemon */
52 static char OKbackup[]   = "2000 OK backup\n";
53 static char OKstore[]    = "2000 OK storage\n";
54 static char EndJob[]     = "2800 End Job TermCode=%d JobFiles=%u "
55                            "ReadBytes=%llu JobBytes=%llu Errors=%u "  
56                            "VSS=%d Encrypt=%d\n";
57 /* Pre 1.39.29 (04Dec06) EndJob */
58 static char OldEndJob[]  = "2800 End Job TermCode=%d JobFiles=%u "
59                            "ReadBytes=%llu JobBytes=%llu Errors=%u\n";
60 /* 
61  * Called here before the job is run to do the job
62  *   specific setup.
63  */
64 bool do_backup_init(JCR *jcr)
65 {
66
67    if (jcr->is_JobLevel(L_VIRTUAL_FULL)) {
68       return do_vbackup_init(jcr);
69    }
70    free_rstorage(jcr);                   /* we don't read so release */
71
72    if (!get_or_create_fileset_record(jcr)) {
73       return false;
74    }
75
76    /* 
77     * Get definitive Job level and since time
78     */
79    get_level_since_time(jcr, jcr->since, sizeof(jcr->since));
80
81    apply_pool_overrides(jcr);
82
83    if (!allow_duplicate_job(jcr)) {
84       return false;
85    }
86
87    jcr->jr.PoolId = get_or_create_pool_record(jcr, jcr->pool->name());
88    if (jcr->jr.PoolId == 0) {
89       return false;
90    }
91
92    /* If pool storage specified, use it instead of job storage */
93    copy_wstorage(jcr, jcr->pool->storage, _("Pool resource"));
94
95    if (!jcr->wstorage) {
96       Jmsg(jcr, M_FATAL, 0, _("No Storage specification found in Job or Pool.\n"));
97       return false;
98    }
99
100    create_clones(jcr);                /* run any clone jobs */
101
102    return true;
103 }
104
105 /* Take all base jobs from job resource and find the
106  * last L_BASE jobid.
107  */
108 static bool get_base_jobids(JCR *jcr, db_list_ctx *jobids)
109 {
110    JOB_DBR jr;
111    JOB *job;
112    JobId_t id;
113    char str_jobid[50];
114
115    if (!jcr->job->base) {
116       return false;             /* no base job, stop accurate */
117    }
118
119    memset(&jr, 0, sizeof(JOB_DBR));
120    jr.StartTime = jcr->jr.StartTime;
121
122    foreach_alist(job, jcr->job->base) {
123       bstrncpy(jr.Name, job->name(), sizeof(jr.Name));
124       db_get_base_jobid(jcr, jcr->db, &jr, &id);
125
126       if (id) {
127          if (jobids->count) {
128             pm_strcat(jobids->list, ",");
129          }
130          pm_strcat(jobids->list, edit_uint64(id, str_jobid));
131          jobids->count++;
132       }
133    }
134
135    return jobids->count > 0;
136 }
137
138 /*
139  * Foreach files in currrent list, send "/path/fname\0LStat\0MD5\0Delta" to FD
140  *      row[0]=Path, row[1]=Filename, row[2]=FileIndex
141  *      row[3]=JobId row[4]=LStat row[5]=MarkId row[6]=MD5
142  */
143 static int accurate_list_handler(void *ctx, int num_fields, char **row)
144 {
145    JCR *jcr = (JCR *)ctx;
146
147    if (job_canceled(jcr)) {
148       return 1;
149    }
150    
151    if (row[2][0] == '0') {           /* discard when file_index == 0 */
152       return 0;
153    }
154
155    /* sending with checksum */
156    if (jcr->use_accurate_chksum 
157        && num_fields == 7 
158        && row[6][0] /* skip checksum = '0' */
159        && row[6][1])
160    { 
161       jcr->file_bsock->fsend("%s%s%c%s%c%s%c%s", 
162                              row[0], row[1], 0, row[4], 0, row[6], 0, row[5]); 
163    } else {
164       jcr->file_bsock->fsend("%s%s%c%s%c%c%s", 
165                              row[0], row[1], 0, row[4], 0, 0, row[5]); 
166    }
167    return 0;
168 }
169
170 /* In this procedure, we check if the current fileset is using checksum
171  * FileSet-> Include-> Options-> Accurate/Verify/BaseJob=checksum
172  * This procedure uses jcr->HasBase, so it must be call after the initialization
173  */
174 static bool is_checksum_needed_by_fileset(JCR *jcr)
175 {
176    FILESET *f;
177    INCEXE *inc;
178    FOPTS *fopts;
179    bool in_block=false;
180    bool have_basejob_option=false;
181    if (!jcr->job || !jcr->job->fileset) {
182       return false;
183    }
184
185    f = jcr->job->fileset;
186    
187    for (int i=0; i < f->num_includes; i++) { /* Parse all Include {} */
188       inc = f->include_items[i];
189       
190       for (int j=0; j < inc->num_opts; j++) { /* Parse all Options {} */
191          fopts = inc->opts_list[j];
192          
193          for (char *k=fopts->opts; *k ; k++) { /* Try to find one request */
194             switch (*k) {
195             case 'V':           /* verify */
196                in_block = (jcr->getJobType() == JT_VERIFY); /* not used now */
197                break;
198             case 'J':           /* Basejob keyword */
199                have_basejob_option = in_block = jcr->HasBase;
200                break;
201             case 'C':           /* Accurate keyword */
202                in_block = !jcr->is_JobLevel(L_FULL);
203                break;
204             case ':':           /* End of keyword */
205                in_block = false;
206                break;
207             case '5':           /* MD5  */
208             case '1':           /* SHA1 */
209                if (in_block) {
210                   Dmsg0(50, "Checksum will be sent to FD\n");
211                   return true;
212                }
213                break;
214             default:
215                break;
216             }
217          }
218       }
219    }
220
221    /* By default for BaseJobs, we send the checksum */
222    if (!have_basejob_option && jcr->HasBase) {
223       return true;
224    }
225    
226    Dmsg0(50, "Checksum will be sent to FD\n");
227    return false;
228 }
229
230 /*
231  * Send current file list to FD
232  *    DIR -> FD : accurate files=xxxx
233  *    DIR -> FD : /path/to/file\0Lstat\0MD5\0Delta
234  *    DIR -> FD : /path/to/dir/\0Lstat\0MD5\0Delta
235  *    ...
236  *    DIR -> FD : EOD
237  */
238 bool send_accurate_current_files(JCR *jcr)
239 {
240    POOL_MEM buf;
241    db_list_ctx jobids;
242    db_list_ctx nb;
243    char ed1[50];
244
245    /* In base level, no previous job is used and no restart incomplete jobs */
246    if (jcr->is_canceled() || jcr->is_JobLevel(L_BASE)) {
247       return true;
248    }
249    if (!jcr->accurate && !jcr->incomplete) {
250       return true;
251    }
252
253    /* For incomplete Jobs, we add our own id */
254    if (jcr->incomplete) {
255       edit_int64(jcr->JobId, ed1);   
256       jobids.add(ed1);
257    }
258    
259    if (jcr->is_JobLevel(L_FULL)) {
260       /* On Full mode, if no previous base job, no accurate things */
261       if (!get_base_jobids(jcr, &jobids) && !jcr->incomplete) {
262          return true;
263       }
264       jcr->HasBase = true;
265       Jmsg(jcr, M_INFO, 0, _("Using BaseJobId(s): %s\n"), jobids.list);
266
267    } else {
268       /* For Incr/Diff level, we search for older jobs */
269       db_accurate_get_jobids(jcr, jcr->db, &jcr->jr, &jobids);
270
271       /* We are in Incr/Diff, but no Full to build the accurate list... */
272       if (jobids.count == 0) {
273          Jmsg(jcr, M_FATAL, 0, _("Cannot find previous jobids.\n"));
274          return false;  /* fail */
275       }
276    }
277
278    /* Don't send and store the checksum if fileset doesn't require it */
279    jcr->use_accurate_chksum = is_checksum_needed_by_fileset(jcr);
280
281    if (jcr->JobId) {            /* display the message only for real jobs */
282       Jmsg(jcr, M_INFO, 0, _("Sending Accurate information.\n"));
283    }
284
285    /* to be able to allocate the right size for htable */
286    Mmsg(buf, "SELECT sum(JobFiles) FROM Job WHERE JobId IN (%s)", jobids.list);
287    db_sql_query(jcr->db, buf.c_str(), db_list_handler, &nb);
288    Dmsg2(200, "jobids=%s nb=%s\n", jobids.list, nb.list);
289    jcr->file_bsock->fsend("accurate files=%s\n", nb.list); 
290
291    if (!db_open_batch_connexion(jcr, jcr->db)) {
292       Jmsg0(jcr, M_FATAL, 0, "Can't get batch sql connexion");
293       return false;  /* Fail */
294    }
295    
296    if (jcr->HasBase) {
297       jcr->nb_base_files = str_to_int64(nb.list);
298       db_create_base_file_list(jcr, jcr->db, jobids.list);
299       db_get_base_file_list(jcr, jcr->db, jcr->use_accurate_chksum,
300                             accurate_list_handler, (void *)jcr);
301
302    } else {
303       db_get_file_list(jcr, jcr->db_batch,
304                        jobids.list, jcr->use_accurate_chksum, false /* no delta */,
305                        accurate_list_handler, (void *)jcr);
306    } 
307
308    /* TODO: close the batch connection ? (can be used very soon) */
309
310    jcr->file_bsock->signal(BNET_EOD);
311    return true;
312 }
313
314 /*
315  * Do a backup of the specified FileSet
316  *
317  *  Returns:  false on failure
318  *            true  on success
319  */
320 bool do_backup(JCR *jcr)
321 {
322    int stat;
323    int tls_need = BNET_TLS_NONE;
324    BSOCK   *fd;
325    STORE *store;
326    char ed1[100];
327    db_int64_ctx job;
328    POOL_MEM buf;
329
330    if (jcr->is_JobLevel(L_VIRTUAL_FULL)) {
331       return do_vbackup(jcr);
332    }
333
334    /* Print Job Start message */
335    if (jcr->incomplete) {
336       Jmsg(jcr, M_INFO, 0, _("Restart Incomplete Backup JobId %s, Job=%s\n"),
337            edit_uint64(jcr->JobId, ed1), jcr->Job);
338    } else {
339       Jmsg(jcr, M_INFO, 0, _("Start Backup JobId %s, Job=%s\n"),
340            edit_uint64(jcr->JobId, ed1), jcr->Job);
341    }
342
343    jcr->setJobStatus(JS_Running);
344    Dmsg2(100, "JobId=%d JobLevel=%c\n", jcr->jr.JobId, jcr->jr.JobLevel);
345    if (!db_update_job_start_record(jcr, jcr->db, &jcr->jr)) {
346       Jmsg(jcr, M_FATAL, 0, "%s", db_strerror(jcr->db));
347       return false;
348    }
349
350    /* For incomplete Jobs, we add our own id */
351    if (jcr->incomplete) {
352       edit_int64(jcr->JobId, ed1);   
353       Mmsg(buf, "SELECT max(FileIndex) FROM File WHERE JobId=%s", ed1);
354       if (!db_sql_query(jcr->db, buf.c_str(), db_int64_handler, &job)) {
355          Jmsg(jcr, M_FATAL, 0, "%s", db_strerror(jcr->db));
356          return false;
357       }
358       jcr->JobFiles = job.value;
359       Dmsg1(100, "==== FI=%ld\n", jcr->JobFiles);
360       Mmsg(buf, "SELECT VolSessionId FROM Job WHERE JobId=%s", ed1);
361       if (!db_sql_query(jcr->db, buf.c_str(), db_int64_handler, &job)) {
362          Jmsg(jcr, M_FATAL, 0, "%s", db_strerror(jcr->db));
363          return false;
364       }
365       jcr->VolSessionId = job.value;
366       Mmsg(buf, "SELECT VolSessionTime FROM Job WHERE JobId=%s", ed1);
367       if (!db_sql_query(jcr->db, buf.c_str(), db_int64_handler, &job)) {
368          Jmsg(jcr, M_FATAL, 0, "%s", db_strerror(jcr->db));
369          return false;
370       }
371       jcr->VolSessionTime = job.value;
372       Dmsg4(100, "JobId=%s JobFiles=%ld VolSessionId=%ld VolSessionTime=%ld\n", ed1, 
373             jcr->JobFiles, jcr->VolSessionId, jcr->VolSessionTime);
374    }
375
376    /*
377     * Open a message channel connection with the Storage
378     * daemon. This is to let him know that our client
379     * will be contacting him for a backup  session.
380     *
381     */
382    Dmsg0(110, "Open connection with storage daemon\n");
383    jcr->setJobStatus(JS_WaitSD);
384    /*
385     * Start conversation with Storage daemon
386     */
387    if (!connect_to_storage_daemon(jcr, 10, SDConnectTimeout, 1)) {
388       return false;
389    }
390    /*
391     * Now start a job with the Storage daemon
392     */
393    if (!start_storage_daemon_job(jcr, NULL, jcr->wstorage)) {
394       return false;
395    }
396
397    /*
398     * Start the job prior to starting the message thread below
399     * to avoid two threads from using the BSOCK structure at
400     * the same time.
401     */
402    if (!jcr->store_bsock->fsend("run")) {
403       return false;
404    }
405
406    /*
407     * Now start a Storage daemon message thread.  Note,
408     *   this thread is used to provide the catalog services
409     *   for the backup job, including inserting the attributes
410     *   into the catalog.  See catalog_update() in catreq.c
411     */
412    if (!start_storage_daemon_message_thread(jcr)) {
413       return false;
414    }
415    Dmsg0(150, "Storage daemon connection OK\n");
416
417    jcr->setJobStatus(JS_WaitFD);
418    if (!connect_to_file_daemon(jcr, 10, FDConnectTimeout, 1)) {
419       goto bail_out;
420    }
421
422    jcr->setJobStatus(JS_Running);
423    fd = jcr->file_bsock;
424
425    if (!send_include_list(jcr)) {
426       goto bail_out;
427    }
428
429    if (!send_exclude_list(jcr)) {
430       goto bail_out;
431    }
432
433    if (!send_level_command(jcr)) {
434       goto bail_out;
435    }
436
437    /*
438     * send Storage daemon address to the File daemon
439     */
440    store = jcr->wstore;
441    if (store->SDDport == 0) {
442       store->SDDport = store->SDport;
443    }
444
445    /* TLS Requirement */
446    if (store->tls_enable) {
447       if (store->tls_require) {
448          tls_need = BNET_TLS_REQUIRED;
449       } else {
450          tls_need = BNET_TLS_OK;
451       }
452    }
453
454    fd->fsend(storaddr, store->address, store->SDDport, tls_need);
455    if (!response(jcr, fd, OKstore, "Storage", DISPLAY_ERROR)) {
456       goto bail_out;
457    }
458
459    if (!send_runscripts_commands(jcr)) {
460       goto bail_out;
461    }
462
463    /*    
464     * We re-update the job start record so that the start
465     *  time is set after the run before job.  This avoids 
466     *  that any files created by the run before job will
467     *  be saved twice.  They will be backed up in the current
468     *  job, but not in the next one unless they are changed.
469     *  Without this, they will be backed up in this job and
470     *  in the next job run because in that case, their date 
471     *   is after the start of this run.
472     */
473    jcr->start_time = time(NULL);
474    jcr->jr.StartTime = jcr->start_time;
475    if (!db_update_job_start_record(jcr, jcr->db, &jcr->jr)) {
476       Jmsg(jcr, M_FATAL, 0, "%s", db_strerror(jcr->db));
477    }
478
479    /*
480     * If backup is in accurate mode, we send the list of
481     * all files to FD.
482     */
483    if (!send_accurate_current_files(jcr)) {
484       goto bail_out;     /* error */
485    }
486
487    /* Send backup command */
488    fd->fsend(backupcmd, jcr->JobFiles);
489    Dmsg1(100, ">filed: %s", fd->msg);
490    if (!response(jcr, fd, OKbackup, "backup", DISPLAY_ERROR)) {
491       goto bail_out;
492    }
493
494    /* Pickup Job termination data */
495    stat = wait_for_job_termination(jcr);
496    db_write_batch_file_records(jcr);    /* used by bulk batch file insert */
497
498    if (jcr->HasBase && !db_commit_base_file_attributes_record(jcr, jcr->db))  {
499       Jmsg(jcr, M_FATAL, 0, "%s", db_strerror(jcr->db));
500    }
501
502    if (stat == JS_Terminated) {
503       backup_cleanup(jcr, stat);
504       return true;
505    }     
506    return false;
507
508 /* Come here only after starting SD thread */
509 bail_out:
510    jcr->setJobStatus(JS_ErrorTerminated);
511    Dmsg1(400, "wait for sd. use=%d\n", jcr->use_count());
512    /* Cancel SD */
513    wait_for_job_termination(jcr, FDConnectTimeout);
514    Dmsg1(400, "after wait for sd. use=%d\n", jcr->use_count());
515    return false;
516 }
517
518
519 /*
520  * Here we wait for the File daemon to signal termination,
521  *   then we wait for the Storage daemon.  When both
522  *   are done, we return the job status.
523  * Also used by restore.c
524  */
525 int wait_for_job_termination(JCR *jcr, int timeout)
526 {
527    int32_t n = 0;
528    BSOCK *fd = jcr->file_bsock;
529    bool fd_ok = false;
530    uint32_t JobFiles, JobErrors;
531    uint32_t JobWarnings = 0;
532    uint64_t ReadBytes = 0;
533    uint64_t JobBytes = 0;
534    int VSS = 0;
535    int Encrypt = 0;
536    btimer_t *tid=NULL;
537
538    jcr->setJobStatus(JS_Running);
539
540    if (fd) {
541       if (timeout) {
542          tid = start_bsock_timer(fd, timeout); /* TODO: New timeout directive??? */
543       }
544       /* Wait for Client to terminate */
545       while ((n = bget_dirmsg(fd)) >= 0) {
546          if (!fd_ok && 
547              (sscanf(fd->msg, EndJob, &jcr->FDJobStatus, &JobFiles,
548                      &ReadBytes, &JobBytes, &JobErrors, &VSS, &Encrypt) == 7 ||
549               sscanf(fd->msg, OldEndJob, &jcr->FDJobStatus, &JobFiles,
550                      &ReadBytes, &JobBytes, &JobErrors) == 5)) {
551             fd_ok = true;
552             jcr->setJobStatus(jcr->FDJobStatus);
553             Dmsg1(100, "FDStatus=%c\n", (char)jcr->JobStatus);
554          } else {
555             Jmsg(jcr, M_WARNING, 0, _("Unexpected Client Job message: %s\n"),
556                  fd->msg);
557          }
558          if (job_canceled(jcr)) {
559             break;
560          }
561       }
562       if (tid) {
563          stop_bsock_timer(tid);
564       }
565
566       if (is_bnet_error(fd)) {
567          int i = 0;
568          Jmsg(jcr, M_FATAL, 0, _("Network error with FD during %s: ERR=%s\n"),
569               job_type_to_str(jcr->getJobType()), fd->bstrerror());
570          while (i++ < 10 && jcr->job->RescheduleIncompleteJobs && jcr->is_canceled()) {
571             bmicrosleep(3, 0);
572          }
573             
574       }
575       fd->signal(BNET_TERMINATE);   /* tell Client we are terminating */
576    }
577
578    /*
579     * Force cancel in SD if failing, but not for Incomplete jobs
580     *  so that we let the SD despool.
581     */
582    Dmsg5(100, "cancel=%d fd_ok=%d FDJS=%d JS=%d SDJS=%d\n", jcr->is_canceled(), fd_ok, jcr->FDJobStatus,
583         jcr->JobStatus, jcr->SDJobStatus);
584    if (jcr->is_canceled() || (!jcr->job->RescheduleIncompleteJobs && !fd_ok)) {
585       Dmsg4(100, "fd_ok=%d FDJS=%d JS=%d SDJS=%d\n", fd_ok, jcr->FDJobStatus,
586            jcr->JobStatus, jcr->SDJobStatus);
587       cancel_storage_daemon_job(jcr);
588    }
589
590    /* Note, the SD stores in jcr->JobFiles/ReadBytes/JobBytes/JobErrors */
591    wait_for_storage_daemon_termination(jcr);
592
593    /* Return values from FD */
594    if (fd_ok) {
595       jcr->JobFiles = JobFiles;
596       jcr->JobErrors += JobErrors;       /* Keep total errors */
597       jcr->ReadBytes = ReadBytes;
598       jcr->JobBytes = JobBytes;
599       jcr->JobWarnings = JobWarnings;
600       jcr->VSS = VSS;
601       jcr->Encrypt = Encrypt;
602    } else {
603       Jmsg(jcr, M_FATAL, 0, _("No Job status returned from FD.\n"));
604    }
605
606 // Dmsg4(100, "fd_ok=%d FDJS=%d JS=%d SDJS=%d\n", fd_ok, jcr->FDJobStatus,
607 //   jcr->JobStatus, jcr->SDJobStatus);
608
609    /* Return the first error status we find Dir, FD, or SD */
610    if (!fd_ok || is_bnet_error(fd)) { /* if fd not set, that use !fd_ok */
611       jcr->FDJobStatus = JS_ErrorTerminated;
612    }
613    if (jcr->JobStatus != JS_Terminated) {
614       return jcr->JobStatus;
615    }
616    if (jcr->FDJobStatus != JS_Terminated) {
617       return jcr->FDJobStatus;
618    }
619    return jcr->SDJobStatus;
620 }
621
622 /*
623  * Release resources allocated during backup.
624  */
625 void backup_cleanup(JCR *jcr, int TermCode)
626 {
627    char sdt[50], edt[50], schedt[50];
628    char ec1[30], ec2[30], ec3[30], ec4[30], ec5[30], compress[50];
629    char ec6[30], ec7[30], ec8[30], elapsed[50];
630    char term_code[100], fd_term_msg[100], sd_term_msg[100];
631    const char *term_msg;
632    int msg_type = M_INFO;
633    MEDIA_DBR mr;
634    CLIENT_DBR cr;
635    double kbps, compression;
636    utime_t RunTime;
637    POOL_MEM base_info;
638
639    if (jcr->is_JobLevel(L_VIRTUAL_FULL)) {
640       vbackup_cleanup(jcr, TermCode);
641       return;
642    }
643
644    Dmsg2(100, "Enter backup_cleanup %d %c\n", TermCode, TermCode);
645    memset(&mr, 0, sizeof(mr));
646    memset(&cr, 0, sizeof(cr));
647
648 #ifdef xxxx
649    if (jcr->getJobStatus() == JS_Terminated && 
650         (jcr->JobErrors || jcr->SDErrors || jcr->JobWarnings)) {
651       TermCode = JS_Warnings;
652    }
653 #endif
654          
655    update_job_end(jcr, TermCode);
656
657    if (!db_get_job_record(jcr, jcr->db, &jcr->jr)) {
658       Jmsg(jcr, M_WARNING, 0, _("Error getting Job record for Job report: ERR=%s"),
659          db_strerror(jcr->db));
660       jcr->setJobStatus(JS_ErrorTerminated);
661    }
662
663    bstrncpy(cr.Name, jcr->client->name(), sizeof(cr.Name));
664    if (!db_get_client_record(jcr, jcr->db, &cr)) {
665       Jmsg(jcr, M_WARNING, 0, _("Error getting Client record for Job report: ERR=%s"),
666          db_strerror(jcr->db));
667    }
668
669    bstrncpy(mr.VolumeName, jcr->VolumeName, sizeof(mr.VolumeName));
670    if (!db_get_media_record(jcr, jcr->db, &mr)) {
671       Jmsg(jcr, M_WARNING, 0, _("Error getting Media record for Volume \"%s\": ERR=%s"),
672          mr.VolumeName, db_strerror(jcr->db));
673       jcr->setJobStatus(JS_ErrorTerminated);
674    }
675
676    update_bootstrap_file(jcr);
677
678    switch (jcr->JobStatus) {
679       case JS_Terminated:
680          if (jcr->JobErrors || jcr->SDErrors) {
681             term_msg = _("Backup OK -- with warnings");
682          } else {
683             term_msg = _("Backup OK");
684          }
685          break;
686       case JS_Incomplete:
687          term_msg = _("Backup failed -- incomplete");
688          break;
689       case JS_Warnings:
690          term_msg = _("Backup OK -- with warnings");
691          break;
692       case JS_FatalError:
693       case JS_ErrorTerminated:
694          term_msg = _("*** Backup Error ***");
695          msg_type = M_ERROR;          /* Generate error message */
696          if (jcr->store_bsock) {
697             jcr->store_bsock->signal(BNET_TERMINATE);
698             if (jcr->SD_msg_chan) {
699                pthread_cancel(jcr->SD_msg_chan);
700             }
701          }
702          break;
703       case JS_Canceled:
704          term_msg = _("Backup Canceled");
705          if (jcr->store_bsock) {
706             jcr->store_bsock->signal(BNET_TERMINATE);
707             if (jcr->SD_msg_chan) {
708                pthread_cancel(jcr->SD_msg_chan);
709             }
710          }
711          break;
712       default:
713          term_msg = term_code;
714          sprintf(term_code, _("Inappropriate term code: %c\n"), jcr->JobStatus);
715          break;
716    }
717    bstrftimes(schedt, sizeof(schedt), jcr->jr.SchedTime);
718    bstrftimes(sdt, sizeof(sdt), jcr->jr.StartTime);
719    bstrftimes(edt, sizeof(edt), jcr->jr.EndTime);
720    RunTime = jcr->jr.EndTime - jcr->jr.StartTime;
721    if (RunTime <= 0) {
722       kbps = 0;
723    } else {
724       kbps = ((double)jcr->jr.JobBytes) / (1000.0 * (double)RunTime);
725    }
726    if (!db_get_job_volume_names(jcr, jcr->db, jcr->jr.JobId, &jcr->VolumeName)) {
727       /*
728        * Note, if the job has erred, most likely it did not write any
729        *  tape, so suppress this "error" message since in that case
730        *  it is normal.  Or look at it the other way, only for a
731        *  normal exit should we complain about this error.
732        */
733       if (jcr->JobStatus == JS_Terminated && jcr->jr.JobBytes) {
734          Jmsg(jcr, M_ERROR, 0, "%s", db_strerror(jcr->db));
735       }
736       jcr->VolumeName[0] = 0;         /* none */
737    }
738
739    if (jcr->ReadBytes == 0) {
740       bstrncpy(compress, "None", sizeof(compress));
741    } else {
742       compression = (double)100 - 100.0 * ((double)jcr->JobBytes / (double)jcr->ReadBytes);
743       if (compression < 0.5) {
744          bstrncpy(compress, "None", sizeof(compress));
745       } else {
746          bsnprintf(compress, sizeof(compress), "%.1f %%", compression);
747       }
748    }
749    jobstatus_to_ascii(jcr->FDJobStatus, fd_term_msg, sizeof(fd_term_msg));
750    jobstatus_to_ascii(jcr->SDJobStatus, sd_term_msg, sizeof(sd_term_msg));
751
752    if (jcr->HasBase) {
753       Mmsg(base_info, "  Base files/Used files:  %lld/%lld (%.2f%%)\n",
754            jcr->nb_base_files, 
755            jcr->nb_base_files_used, 
756            jcr->nb_base_files_used*100.0/jcr->nb_base_files);
757    }
758 // bmicrosleep(15, 0);                /* for debugging SIGHUP */
759
760    Jmsg(jcr, msg_type, 0, _("%s %s %s (%s):\n"
761 "  Build OS:               %s %s %s\n"
762 "  JobId:                  %d\n"
763 "  Job:                    %s\n"
764 "  Backup Level:           %s%s\n"
765 "  Client:                 \"%s\" %s\n"
766 "  FileSet:                \"%s\" %s\n"
767 "  Pool:                   \"%s\" (From %s)\n"
768 "  Catalog:                \"%s\" (From %s)\n"
769 "  Storage:                \"%s\" (From %s)\n"
770 "  Scheduled time:         %s\n"
771 "  Start time:             %s\n"
772 "  End time:               %s\n"
773 "  Elapsed time:           %s\n"
774 "  Priority:               %d\n"
775 "  FD Files Written:       %s\n"
776 "  SD Files Written:       %s\n"
777 "  FD Bytes Written:       %s (%sB)\n"
778 "  SD Bytes Written:       %s (%sB)\n"
779 "  Rate:                   %.1f KB/s\n"
780 "  Software Compression:   %s\n"
781 "%s"                                         /* Basefile info */
782 "  VSS:                    %s\n"
783 "  Encryption:             %s\n"
784 "  Accurate:               %s\n"
785 "  Volume name(s):         %s\n"
786 "  Volume Session Id:      %d\n"
787 "  Volume Session Time:    %d\n"
788 "  Last Volume Bytes:      %s (%sB)\n"
789 "  Non-fatal FD errors:    %d\n"
790 "  SD Errors:              %d\n"
791 "  FD termination status:  %s\n"
792 "  SD termination status:  %s\n"
793 "  Termination:            %s\n\n"),
794         BACULA, my_name, VERSION, LSMDATE,
795         HOST_OS, DISTNAME, DISTVER,
796         jcr->jr.JobId,
797         jcr->jr.Job,
798         level_to_str(jcr->getJobLevel()), jcr->since,
799         jcr->client->name(), cr.Uname,
800         jcr->fileset->name(), jcr->FSCreateTime,
801         jcr->pool->name(), jcr->pool_source,
802         jcr->catalog->name(), jcr->catalog_source,
803         jcr->wstore->name(), jcr->wstore_source,
804         schedt,
805         sdt,
806         edt,
807         edit_utime(RunTime, elapsed, sizeof(elapsed)),
808         jcr->JobPriority,
809         edit_uint64_with_commas(jcr->jr.JobFiles, ec1),
810         edit_uint64_with_commas(jcr->SDJobFiles, ec2),
811         edit_uint64_with_commas(jcr->jr.JobBytes, ec3),
812         edit_uint64_with_suffix(jcr->jr.JobBytes, ec4),
813         edit_uint64_with_commas(jcr->SDJobBytes, ec5),
814         edit_uint64_with_suffix(jcr->SDJobBytes, ec6),
815         kbps,
816         compress,
817         base_info.c_str(),
818         jcr->VSS?_("yes"):_("no"),
819         jcr->Encrypt?_("yes"):_("no"),
820         jcr->accurate?_("yes"):_("no"),
821         jcr->VolumeName,
822         jcr->VolSessionId,
823         jcr->VolSessionTime,
824         edit_uint64_with_commas(mr.VolBytes, ec7),
825         edit_uint64_with_suffix(mr.VolBytes, ec8),
826         jcr->JobErrors,
827         jcr->SDErrors,
828         fd_term_msg,
829         sd_term_msg,
830         term_msg);
831
832    Dmsg0(100, "Leave backup_cleanup()\n");
833 }
834
835 void update_bootstrap_file(JCR *jcr)
836 {
837    /* Now update the bootstrap file if any */
838    if (jcr->JobStatus == JS_Terminated && jcr->jr.JobBytes &&
839        jcr->job->WriteBootstrap) {
840       FILE *fd;
841       BPIPE *bpipe = NULL;
842       int got_pipe = 0;
843       POOLMEM *fname = get_pool_memory(PM_FNAME);
844       fname = edit_job_codes(jcr, fname, jcr->job->WriteBootstrap, "");
845
846       VOL_PARAMS *VolParams = NULL;
847       int VolCount;
848       char edt[50], ed1[50], ed2[50];
849
850       if (*fname == '|') {
851          got_pipe = 1;
852          bpipe = open_bpipe(fname+1, 0, "w"); /* skip first char "|" */
853          fd = bpipe ? bpipe->wfd : NULL;
854       } else {
855          /* ***FIXME*** handle BASE */
856          fd = fopen(fname, jcr->is_JobLevel(L_FULL)?"w+b":"a+b");
857       }
858       if (fd) {
859          VolCount = db_get_job_volume_parameters(jcr, jcr->db, jcr->JobId,
860                     &VolParams);
861          if (VolCount == 0) {
862             Jmsg(jcr, M_ERROR, 0, _("Could not get Job Volume Parameters to "
863                  "update Bootstrap file. ERR=%s\n"), db_strerror(jcr->db));
864              if (jcr->SDJobFiles != 0) {
865                 jcr->setJobStatus(JS_ErrorTerminated);
866              }
867
868          }
869          /* Start output with when and who wrote it */
870          bstrftimes(edt, sizeof(edt), time(NULL));
871          fprintf(fd, "# %s - %s - %s%s\n", edt, jcr->jr.Job,
872                  level_to_str(jcr->getJobLevel()), jcr->since);
873          for (int i=0; i < VolCount; i++) {
874             /* Write the record */
875             fprintf(fd, "Volume=\"%s\"\n", VolParams[i].VolumeName);
876             fprintf(fd, "MediaType=\"%s\"\n", VolParams[i].MediaType);
877             if (VolParams[i].Slot > 0) {
878                fprintf(fd, "Slot=%d\n", VolParams[i].Slot);
879             }
880             fprintf(fd, "VolSessionId=%u\n", jcr->VolSessionId);
881             fprintf(fd, "VolSessionTime=%u\n", jcr->VolSessionTime);
882             fprintf(fd, "VolAddr=%s-%s\n", 
883                     edit_uint64(VolParams[i].StartAddr, ed1),
884                     edit_uint64(VolParams[i].EndAddr, ed2));
885             fprintf(fd, "FileIndex=%d-%d\n", VolParams[i].FirstIndex,
886                          VolParams[i].LastIndex);
887          }
888          if (VolParams) {
889             free(VolParams);
890          }
891          if (got_pipe) {
892             close_bpipe(bpipe);
893          } else {
894             fclose(fd);
895          }
896       } else {
897          berrno be;
898          Jmsg(jcr, M_ERROR, 0, _("Could not open WriteBootstrap file:\n"
899               "%s: ERR=%s\n"), fname, be.bstrerror());
900          jcr->setJobStatus(JS_ErrorTerminated);
901       }
902       free_pool_memory(fname);
903    }
904 }