3 * Bacula Director Job processing routines
5 * Kern Sibbald, October MM
10 Copyright (C) 2000-2003 Kern Sibbald and John Walker
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.
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.
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,
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);
38 static void backoff_resource_locks(JCR *jcr, int count);
41 /* Exported subroutines */
42 void run_job(JCR *jcr);
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_admin(JCR *jcr);
50 extern int do_restore(JCR *jcr);
51 extern int do_verify(JCR *jcr);
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 */
59 /* Queue of jobs to be run */
60 workq_t job_wq; /* our job work queue */
63 void init_job_server(int max_workers)
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));
70 if ((stat = pthread_mutex_init(&mutex, NULL)) != 0) {
71 Emsg1(M_ABORT, 0, _("Could not init resource mutex: ERR=%s\n"), strerror(stat));
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));
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));
86 * Run a job -- typically called by the scheduler, but may also
87 * be called by the UA (Console program).
90 void run_job(JCR *jcr)
96 workq_ele_t *work_item;
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));
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);
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);
132 Dmsg0(50, "DB opened\n");
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);
144 jcr->JobId = jcr->jr.JobId;
145 ASSERT(jcr->jr.JobId > 0);
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");
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));
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));
160 jcr->work_item = work_item;
162 Dmsg0(200, "Done run_job()\n");
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
170 static void *job_thread(void *arg)
172 JCR *jcr = (JCR *)arg;
174 pthread_detach(pthread_self());
175 sm_check(__FILE__, __LINE__, True);
178 if (!acquire_resource_locks(jcr)) {
179 set_jcr_job_status(jcr, JS_Canceled);
182 Dmsg0(200, "=====Start Job=========\n");
183 jcr->start_time = time(NULL); /* set the real start time */
184 set_jcr_job_status(jcr, JS_Running);
186 if (job_canceled(jcr)) {
187 update_job_end_record(jcr);
188 } else if (jcr->job->MaxStartDelay != 0 && jcr->job->MaxStartDelay <
189 (utime_t)(jcr->start_time - jcr->sched_time)) {
190 Jmsg(jcr, M_FATAL, 0, _("Job canceled because max start delay time exceeded.\n"));
191 set_jcr_job_status(jcr, JS_Canceled);
192 update_job_end_record(jcr);
196 if (jcr->job->RunBeforeJob) {
197 POOLMEM *before = get_pool_memory(PM_FNAME);
200 char line[MAXSTRING];
202 before = edit_run_codes(jcr, before, jcr->job->RunBeforeJob);
203 bpipe = open_bpipe(before, 0, "r");
204 while (fgets(line, sizeof(line), bpipe->rfd)) {
205 Jmsg(jcr, M_INFO, 0, _("RunBefore: %s"), line);
207 status = close_bpipe(bpipe);
209 Jmsg(jcr, M_FATAL, 0, _("RunBeforeJob returned non-zero status=%d\n"),
211 set_jcr_job_status(jcr, JS_FatalError);
212 update_job_end_record(jcr);
213 free_pool_memory(before);
216 free_pool_memory(before);
218 switch (jcr->JobType) {
221 if (jcr->JobStatus == JS_Terminated) {
227 if (jcr->JobStatus == JS_Terminated) {
233 if (jcr->JobStatus == JS_Terminated) {
239 if (jcr->JobStatus == JS_Terminated) {
244 Pmsg1(0, "Unimplemented job type: %d\n", jcr->JobType);
247 if (jcr->job->RunAfterJob) {
248 POOLMEM *after = get_pool_memory(PM_FNAME);
251 char line[MAXSTRING];
253 after = edit_run_codes(jcr, after, jcr->job->RunAfterJob);
254 bpipe = open_bpipe(after, 0, "r");
255 while (fgets(line, sizeof(line), bpipe->rfd)) {
256 Jmsg(jcr, M_INFO, 0, _("RunAfter: %s"), line);
258 status = close_bpipe(bpipe);
260 Jmsg(jcr, M_FATAL, 0, _("RunAfterJob returned non-zero status=%d\n"),
262 set_jcr_job_status(jcr, JS_FatalError);
263 update_job_end_record(jcr);
265 free_pool_memory(after);
269 release_resource_locks(jcr);
270 if (jcr->job->RescheduleOnError &&
271 jcr->JobStatus != JS_Terminated &&
272 jcr->JobStatus != JS_Canceled &&
273 jcr->job->RescheduleTimes > 0 &&
274 jcr->reschedule_count < jcr->job->RescheduleTimes) {
277 * Reschedule this job by cleaning it up, but
278 * reuse the same JobId if possible.
280 jcr->reschedule_count++;
281 jcr->sched_time = time(NULL) + jcr->job->RescheduleInterval;
282 Dmsg2(000, "Reschedule Job %s in %d seconds.\n", jcr->Job,
283 (int)jcr->job->RescheduleInterval);
284 jcr->JobStatus = JS_Created; /* force new status */
285 dird_free_jcr(jcr); /* partial cleanup old stuff */
286 if (jcr->JobBytes == 0) {
287 continue; /* reschedule the job */
290 * Something was actually backed up, so we cannot reuse
291 * the old JobId or there will be database record
292 * conflicts. We now create a new job, copying the
293 * appropriate fields.
295 JCR *njcr = new_jcr(sizeof(JCR), dird_free_jcr);
296 set_jcr_defaults(njcr, jcr->job);
297 njcr->reschedule_count = jcr->reschedule_count;
298 njcr->JobLevel = jcr->JobLevel;
299 njcr->JobStatus = jcr->JobStatus;
300 njcr->pool = jcr->pool;
301 njcr->store = jcr->store;
302 njcr->messages = jcr->messages;
309 Dmsg0(200, "Close DB\n");
310 db_close_database(jcr, jcr->db);
314 Dmsg0(50, "======== End Job ==========\n");
315 sm_check(__FILE__, __LINE__, True);
320 * Acquire the resources needed. These locks limit the
321 * number of jobs by each resource. We have limits on
322 * Jobs, Clients, Storage, and total jobs.
324 static int acquire_resource_locks(JCR *jcr)
326 time_t now = time(NULL);
327 time_t wtime = jcr->sched_time - now;
329 /* Wait until scheduled time arrives */
330 if (wtime > 0 && verbose) {
331 Jmsg(jcr, M_INFO, 0, _("Job %s waiting %d seconds for scheduled start time.\n"),
333 set_jcr_job_status(jcr, JS_WaitStartTime);
335 /* Check every 30 seconds if canceled */
337 Dmsg2(100, "Waiting on sched time, jobid=%d secs=%d\n", jcr->JobId, wtime);
341 bmicrosleep(wtime, 0);
342 if (job_canceled(jcr)) {
345 wtime = jcr->sched_time - time(NULL);
352 /* Initialize semaphores */
353 if (jcr->store->sem.valid != SEMLOCK_VALID) {
354 if ((stat = sem_init(&jcr->store->sem, jcr->store->MaxConcurrentJobs)) != 0) {
355 Emsg1(M_ABORT, 0, _("Could not init Storage semaphore: ERR=%s\n"), strerror(stat));
358 if (jcr->client->sem.valid != SEMLOCK_VALID) {
359 if ((stat = sem_init(&jcr->client->sem, jcr->client->MaxConcurrentJobs)) != 0) {
360 Emsg1(M_ABORT, 0, _("Could not init Client semaphore: ERR=%s\n"), strerror(stat));
363 if (jcr->job->sem.valid != SEMLOCK_VALID) {
364 if ((stat = sem_init(&jcr->job->sem, jcr->job->MaxConcurrentJobs)) != 0) {
365 Emsg1(M_ABORT, 0, _("Could not init Job semaphore: ERR=%s\n"), strerror(stat));
370 /* Acquire semaphore */
371 set_jcr_job_status(jcr, JS_WaitJobRes);
372 if ((stat = sem_lock(&jcr->job->sem)) != 0) {
373 Emsg1(M_ABORT, 0, _("Could not acquire Job max jobs lock: ERR=%s\n"), strerror(stat));
375 set_jcr_job_status(jcr, JS_WaitClientRes);
376 if ((stat = sem_trylock(&jcr->client->sem)) != 0) {
378 backoff_resource_locks(jcr, 1);
381 Emsg1(M_ABORT, 0, _("Could not acquire Client max jobs lock: ERR=%s\n"), strerror(stat));
384 set_jcr_job_status(jcr, JS_WaitStoreRes);
385 if ((stat = sem_trylock(&jcr->store->sem)) != 0) {
387 backoff_resource_locks(jcr, 2);
390 Emsg1(M_ABORT, 0, _("Could not acquire Storage max jobs lock: ERR=%s\n"), strerror(stat));
393 set_jcr_job_status(jcr, JS_WaitMaxJobs);
394 if ((stat = sem_trylock(&job_lock)) != 0) {
396 backoff_resource_locks(jcr, 3);
399 Emsg1(M_ABORT, 0, _("Could not acquire max jobs lock: ERR=%s\n"), strerror(stat));
405 if (job_canceled(jcr)) {
410 * Wait for a resource to be released either by backoff or
411 * by a job terminating.
414 pthread_cond_wait(&resource_wait, &mutex);
419 jcr->acquired_resource_locks = 1;
426 * We could not get all the resource locks because
427 * too many jobs are running, so release any locks
428 * we did acquire, giving others a chance to use them
431 static void backoff_resource_locks(JCR *jcr, int count)
436 sem_unlock(&jcr->store->sem);
437 /* Fall through wanted */
439 sem_unlock(&jcr->client->sem);
440 /* Fall through wanted */
442 sem_unlock(&jcr->job->sem);
446 * Since we released a lock, if there are any threads
447 * waiting, wake them up so that they can try again.
450 pthread_cond_broadcast(&resource_wait);
457 * This is called at the end of the job to release
458 * any resource limits on the number of jobs. If
459 * there are any other jobs waiting, we wake them
460 * up so that they can try again.
462 static void release_resource_locks(JCR *jcr)
464 if (!jcr->acquired_resource_locks) {
465 return; /* Job canceled, no locks acquired */
469 sem_unlock(&jcr->store->sem);
470 sem_unlock(&jcr->client->sem);
471 sem_unlock(&jcr->job->sem);
472 sem_unlock(&job_lock);
474 pthread_cond_broadcast(&resource_wait);
476 jcr->acquired_resource_locks = 0;
482 * Get or create a Client record for this Job
484 int get_or_create_client_record(JCR *jcr)
488 memset(&cr, 0, sizeof(cr));
489 bstrncpy(cr.Name, jcr->client->hdr.name, sizeof(cr.Name));
490 cr.AutoPrune = jcr->client->AutoPrune;
491 cr.FileRetention = jcr->client->FileRetention;
492 cr.JobRetention = jcr->client->JobRetention;
493 if (!jcr->client_name) {
494 jcr->client_name = get_pool_memory(PM_NAME);
496 pm_strcpy(&jcr->client_name, jcr->client->hdr.name);
497 if (!db_create_client_record(jcr, jcr->db, &cr)) {
498 Jmsg(jcr, M_FATAL, 0, _("Could not create Client record. ERR=%s\n"),
499 db_strerror(jcr->db));
502 jcr->jr.ClientId = cr.ClientId;
504 if (!jcr->client_uname) {
505 jcr->client_uname = get_pool_memory(PM_NAME);
507 pm_strcpy(&jcr->client_uname, cr.Uname);
509 Dmsg2(100, "Created Client %s record %d\n", jcr->client->hdr.name,
516 * Write status and such in DB
518 void update_job_end_record(JCR *jcr)
520 if (jcr->jr.EndTime == 0) {
521 jcr->jr.EndTime = time(NULL);
523 jcr->end_time = jcr->jr.EndTime;
524 jcr->jr.JobId = jcr->JobId;
525 jcr->jr.JobStatus = jcr->JobStatus;
526 jcr->jr.JobFiles = jcr->JobFiles;
527 jcr->jr.JobBytes = jcr->JobBytes;
528 jcr->jr.VolSessionId = jcr->VolSessionId;
529 jcr->jr.VolSessionTime = jcr->VolSessionTime;
530 if (!db_update_job_end_record(jcr, jcr->db, &jcr->jr)) {
531 Jmsg(jcr, M_WARNING, 0, _("Error updating job record. %s"),
532 db_strerror(jcr->db));
537 * Takes base_name and appends (unique) current
538 * date and time to form unique job name.
540 * Returns: unique job name in jcr->Job
541 * date/time in jcr->start_time
543 void create_unique_job_name(JCR *jcr, char *base_name)
545 /* Job start mutex */
546 static pthread_mutex_t mutex = PTHREAD_MUTEX_INITIALIZER;
547 static time_t last_start_time = 0;
550 char dt[MAX_TIME_LENGTH];
551 char name[MAX_NAME_LENGTH];
554 /* Guarantee unique start time -- maximum one per second, and
555 * thus unique Job Name
557 P(mutex); /* lock creation of jobs */
559 while (now == last_start_time) {
560 bmicrosleep(0, 500000);
563 last_start_time = now;
564 V(mutex); /* allow creation of jobs */
565 jcr->start_time = now;
566 /* Form Unique JobName */
567 localtime_r(&now, &tm);
568 /* Use only characters that are permitted in Windows filenames */
569 strftime(dt, sizeof(dt), "%Y-%m-%d_%H.%M.%S", &tm);
570 bstrncpy(name, base_name, sizeof(name));
571 name[sizeof(name)-22] = 0; /* truncate if too long */
572 bsnprintf(jcr->Job, sizeof(jcr->Job), "%s.%s", name, dt); /* add date & time */
573 /* Convert spaces into underscores */
574 for (p=jcr->Job; *p; p++) {
582 * Free the Job Control Record if no one is still using it.
583 * Called from main free_jcr() routine in src/lib/jcr.c so
584 * that we can do our Director specific cleanup of the jcr.
586 void dird_free_jcr(JCR *jcr)
588 Dmsg0(200, "Start dird free_jcr\n");
590 if (jcr->sd_auth_key) {
591 free(jcr->sd_auth_key);
592 jcr->sd_auth_key = NULL;
598 if (jcr->file_bsock) {
599 Dmsg0(200, "Close File bsock\n");
600 bnet_close(jcr->file_bsock);
601 jcr->file_bsock = NULL;
603 if (jcr->store_bsock) {
604 Dmsg0(200, "Close Store bsock\n");
605 bnet_close(jcr->store_bsock);
606 jcr->store_bsock = NULL;
609 Dmsg0(200, "Free JCR fname\n");
610 free_pool_memory(jcr->fname);
614 Dmsg0(200, "Free JCR stime\n");
615 free_pool_memory(jcr->stime);
618 if (jcr->RestoreBootstrap) {
619 free(jcr->RestoreBootstrap);
620 jcr->RestoreBootstrap = NULL;
622 if (jcr->client_uname) {
623 free_pool_memory(jcr->client_uname);
624 jcr->client_uname = NULL;
626 Dmsg0(200, "End dird free_jcr\n");
630 * Set some defaults in the JCR necessary to
631 * run. These items are pulled from the job
632 * definition as defaults, but can be overridden
633 * later either by the Run record in the Schedule resource,
634 * or by the Console program.
636 void set_jcr_defaults(JCR *jcr, JOB *job)
639 jcr->JobType = job->JobType;
640 jcr->JobLevel = job->level;
641 jcr->store = job->storage;
642 jcr->client = job->client;
643 if (!jcr->client_name) {
644 jcr->client_name = get_pool_memory(PM_NAME);
646 pm_strcpy(&jcr->client_name, jcr->client->hdr.name);
647 jcr->pool = job->pool;
648 jcr->catalog = job->client->catalog;
649 jcr->fileset = job->fileset;
650 jcr->messages = job->messages;
651 if (jcr->RestoreBootstrap) {
652 free(jcr->RestoreBootstrap);
654 /* This can be overridden by Console program */
655 if (job->RestoreBootstrap) {
656 jcr->RestoreBootstrap = bstrdup(job->RestoreBootstrap);
658 /* If no default level given, set one */
659 if (jcr->JobLevel == 0) {
660 switch (jcr->JobType) {
662 jcr->JobLevel = L_VERIFY_CATALOG;
665 jcr->JobLevel = L_INCREMENTAL;
669 jcr->JobLevel = L_FULL;
678 * Edit codes into Run command
681 * %d = Director's name
689 * omsg = edited output message
690 * imsg = input string containing edit codes (%x)
693 static char *edit_run_codes(JCR *jcr, char *omsg, char *imsg)
700 Dmsg1(200, "edit_run_codes: %s\n", imsg);
701 for (p=imsg; *p; p++) {
708 str = jcr->client_name;
717 str = job_status_to_str(jcr->JobStatus);
720 sprintf(add, "%d", jcr->JobId);
727 str = job_level_to_str(jcr->JobLevel);
730 str = jcr->job->hdr.name;
733 str = job_type_to_str(jcr->JobType);
747 Dmsg1(200, "add_str %s\n", str);
748 pm_strcat(&omsg, (char *)str);
749 Dmsg1(200, "omsg=%s\n", omsg);