3 * Bacula Tape manipulation program
5 * Has various tape manipulation commands -- mostly for
6 * use in determining how tapes really work.
8 * Kern Sibbald, April MM
10 * Note, this program reads stored.conf, and will only
11 * talk to devices that are configured.
17 Copyright (C) 2000-2004 Kern Sibbald and John Walker
19 This program is free software; you can redistribute it and/or
20 modify it under the terms of the GNU General Public License as
21 published by the Free Software Foundation; either version 2 of
22 the License, or (at your option) any later version.
24 This program is distributed in the hope that it will be useful,
25 but WITHOUT ANY WARRANTY; without even the implied warranty of
26 MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE. See the GNU
27 General Public License for more details.
29 You should have received a copy of the GNU General Public
30 License along with this program; if not, write to the Free
31 Software Foundation, Inc., 59 Temple Place - Suite 330, Boston,
40 /* External subroutines */
41 extern void free_config_resources();
42 extern char *edit_device_codes(JCR *jcr, char *omsg, char *imsg, char *cmd);
44 /* Exported variables */
47 int bsize = TAPE_BSIZE;
48 char VolName[MAX_NAME_LENGTH];
49 bool forge_on = false;
52 * If you change the format of the state file,
53 * increment this value
55 static uint32_t btape_state_level = 2;
58 DEVRES *device = NULL;
61 /* Forward referenced subroutines */
62 static void do_tape_cmds();
63 static void helpcmd();
64 static void scancmd();
65 static void rewindcmd();
66 static void clearcmd();
70 static void fillcmd();
71 static void qfillcmd();
72 static void statcmd();
73 static void unfillcmd();
74 static int flush_block(DEV_BLOCK *block, int dump);
76 static int record_cb(JCR *jcr, DEVICE *dev, DEV_BLOCK *block, DEV_RECORD *rec);
78 static int quickie_cb(JCR *jcr, DEVICE *dev, DEV_BLOCK *block, DEV_RECORD *rec);
79 static bool compare_blocks(DEV_BLOCK *last_block, DEV_BLOCK *block);
80 static int my_mount_next_read_volume(JCR *jcr, DEVICE *dev, DEV_BLOCK *block);
81 static void scan_blocks();
82 static void set_volume_name(char *VolName, int volnum);
83 static void rawfill_cmd();
84 static void bfill_cmd();
85 static bool open_the_device();
86 static void autochangercmd();
87 static void do_unfill();
90 /* Static variables */
91 #define CONFIG_FILE "bacula-sd.conf"
94 #define MAX_CMD_ARGS 30
97 static char *argk[MAX_CMD_ARGS];
98 static char *argv[MAX_CMD_ARGS];
101 static int quickie_count = 0;
102 static BSR *bsr = NULL;
103 static int signals = TRUE;
106 static uint64_t vol_size;
107 static uint64_t VolBytes;
110 static int32_t file_index;
111 static int end_of_tape = 0;
112 static uint32_t LastBlock = 0;
113 static uint32_t eot_block;
114 static uint32_t eot_block_len;
115 static uint32_t eot_FileIndex;
116 static int dumped = 0;
117 static DEV_BLOCK *last_block1 = NULL;
118 static DEV_BLOCK *last_block2 = NULL;
119 static DEV_BLOCK *last_block = NULL;
120 static DEV_BLOCK *this_block = NULL;
121 static DEV_BLOCK *first_block = NULL;
122 static uint32_t last_file1 = 0;
123 static uint32_t last_file2 = 0;
124 static uint32_t last_file = 0;
125 static uint32_t last_block_num1 = 0;
126 static uint32_t last_block_num2 = 0;
127 static uint32_t last_block_num = 0;
128 static uint32_t BlockNumber = 0;
129 static bool simple = true;
131 static char *VolumeName = NULL;
132 static int vol_num = 0;
134 static JCR *jcr = NULL;
138 static void terminate_btape(int sig);
139 int get_cmd(char *prompt);
142 /*********************************************************************
144 * Main Bacula Pool Creation Program
147 int main(int margc, char *margv[])
152 if (TAPE_BSIZE % DEV_BSIZE != 0 || TAPE_BSIZE / DEV_BSIZE == 0) {
153 Emsg2(M_ABORT, 0, "Tape block size (%d) not multiple of system size (%d)\n",
154 TAPE_BSIZE, DEV_BSIZE);
156 if (TAPE_BSIZE != (1 << (ffs(TAPE_BSIZE)-1))) {
157 Emsg1(M_ABORT, 0, "Tape block size (%d) is not a power of 2\n", TAPE_BSIZE);
160 printf("Tape block granularity is %d bytes.\n", TAPE_BSIZE);
162 working_directory = "/tmp";
163 my_name_is(margc, margv, "btape");
164 init_msg(NULL, NULL);
166 while ((ch = getopt(margc, margv, "b:c:d:psv?")) != -1) {
168 case 'b': /* bootstrap file */
169 bsr = parse_bsr(NULL, optarg);
170 // dump_bsr(bsr, true);
173 case 'c': /* specify config file */
174 if (configfile != NULL) {
177 configfile = bstrdup(optarg);
180 case 'd': /* set debug level */
181 debug_level = atoi(optarg);
182 if (debug_level <= 0) {
209 cmd = get_pool_memory(PM_FNAME);
210 args = get_pool_memory(PM_FNAME);
213 init_signals(terminate_btape);
216 if (configfile == NULL) {
217 configfile = bstrdup(CONFIG_FILE);
220 daemon_start_time = time(NULL);
222 parse_config(configfile);
225 /* See if we can open a device */
227 Pmsg0(000, "No archive name specified.\n");
230 } else if (margc != 1) {
231 Pmsg0(000, "Improper number of arguments specified.\n");
236 jcr = setup_jcr("btape", margv[0], bsr, NULL);
237 dev = setup_to_access_device(jcr, 0); /* acquire for write */
241 if (!open_the_device()) {
245 Dmsg0(200, "Do tape commands\n");
253 static void terminate_btape(int stat)
256 sm_check(__FILE__, __LINE__, false);
260 free_config_resources();
262 free_pool_memory(args);
266 free_pool_memory(cmd);
274 if (debug_level > 10)
275 print_memory_pool_stats();
285 free_block(this_block);
289 close_memory_pool(); /* free memory in pool */
295 static bool open_the_device()
299 block = new_block(dev);
301 if (!(dev->state & ST_OPENED)) {
302 Dmsg1(200, "Opening device %s\n", jcr->VolumeName);
303 if (open_dev(dev, jcr->VolumeName, OPEN_READ_WRITE) < 0) {
304 Emsg1(M_FATAL, 0, _("dev open failed: %s\n"), dev->errmsg);
310 Pmsg1(000, "open_dev %s OK\n", dev_name(dev));
323 * Write a label to the tape
325 static void labelcmd()
328 pm_strcpy(&cmd, VolumeName);
330 if (!get_cmd("Enter Volume Name: ")) {
335 if (!(dev->state & ST_OPENED)) {
336 if (!first_open_device(dev)) {
337 Pmsg1(0, "Device open failed. ERR=%s\n", strerror_dev(dev));
341 write_volume_label_to_dev(jcr, jcr->device, cmd, "Default");
342 Pmsg1(-1, "Wrote Volume label for volume \"%s\".\n", cmd);
346 * Read the tape label
348 static void readlabelcmd()
350 int save_debug_level = debug_level;
354 block = new_block(dev);
355 stat = read_dev_volume_label(jcr, dev, block);
358 Pmsg0(0, "Volume has no label.\n");
361 Pmsg0(0, "Volume label read correctly.\n");
364 Pmsg1(0, "I/O error on device: ERR=%s", strerror_dev(dev));
367 Pmsg0(0, "Volume name error\n");
369 case VOL_CREATE_ERROR:
370 Pmsg1(0, "Error creating label. ERR=%s", strerror_dev(dev));
372 case VOL_VERSION_ERROR:
373 Pmsg0(0, "Volume version error.\n");
375 case VOL_LABEL_ERROR:
376 Pmsg0(0, "Bad Volume label type.\n");
379 Pmsg0(0, "Unknown error.\n");
384 dump_volume_label(dev);
385 debug_level = save_debug_level;
391 * Load the tape should have prevously been taken
392 * off line, otherwise this command is not necessary.
394 static void loadcmd()
397 if (!load_dev(dev)) {
398 Pmsg1(0, "Bad status from load. ERR=%s\n", strerror_dev(dev));
400 Pmsg1(0, "Loaded %s\n", dev_name(dev));
406 static void rewindcmd()
408 if (!rewind_dev(dev)) {
409 Pmsg1(0, "Bad status from rewind. ERR=%s\n", strerror_dev(dev));
410 clrerror_dev(dev, -1);
412 Pmsg1(0, "Rewound %s\n", dev_name(dev));
417 * Clear any tape error
419 static void clearcmd()
421 clrerror_dev(dev, -1);
425 * Write and end of file on the tape
427 static void weofcmd()
438 if ((stat = weof_dev(dev, num)) < 0) {
439 Pmsg2(0, "Bad status from weof %d. ERR=%s\n", stat, strerror_dev(dev));
442 Pmsg3(0, "Wrote %d EOF%s to %s\n", num, num==1?"":"s", dev_name(dev));
447 /* Go to the end of the medium -- raw command
448 * The idea was orginally that the end of the Bacula
449 * medium would be flagged differently. This is not
450 * currently the case. So, this is identical to the
456 Pmsg1(0, "%s", strerror_dev(dev));
459 Pmsg0(0, _("Moved to end of medium.\n"));
464 * Go to the end of the medium (either hardware determined
465 * or defined by two eofs.
485 if (!bsf_dev(dev, num)) {
486 Pmsg1(0, _("Bad status from bsf. ERR=%s\n"), strerror_dev(dev));
488 Pmsg2(0, _("Backspaced %d file%s.\n"), num, num==1?"":"s");
504 if (!bsr_dev(dev, num)) {
505 Pmsg1(0, _("Bad status from bsr. ERR=%s\n"), strerror_dev(dev));
507 Pmsg2(0, _("Backspaced %d record%s.\n"), num, num==1?"":"s");
512 * List device capabilities as defined in the
517 printf(_("Configured device capabilities:\n"));
518 printf("%sEOF ", dev->capabilities & CAP_EOF ? "" : "!");
519 printf("%sBSR ", dev->capabilities & CAP_BSR ? "" : "!");
520 printf("%sBSF ", dev->capabilities & CAP_BSF ? "" : "!");
521 printf("%sFSR ", dev->capabilities & CAP_FSR ? "" : "!");
522 printf("%sFSF ", dev->capabilities & CAP_FSF ? "" : "!");
523 printf("%sFASTFSF ", dev->capabilities & CAP_FASTFSF ? "" : "!");
524 printf("%sEOM ", dev->capabilities & CAP_EOM ? "" : "!");
525 printf("%sREM ", dev->capabilities & CAP_REM ? "" : "!");
526 printf("%sRACCESS ", dev->capabilities & CAP_RACCESS ? "" : "!");
527 printf("%sAUTOMOUNT ", dev->capabilities & CAP_AUTOMOUNT ? "" : "!");
528 printf("%sLABEL ", dev->capabilities & CAP_LABEL ? "" : "!");
529 printf("%sANONVOLS ", dev->capabilities & CAP_ANONVOLS ? "" : "!");
530 printf("%sALWAYSOPEN ", dev->capabilities & CAP_ALWAYSOPEN ? "" : "!");
533 printf(_("Device status:\n"));
534 printf("%sOPENED ", dev->state & ST_OPENED ? "" : "!");
535 printf("%sTAPE ", dev->state & ST_TAPE ? "" : "!");
536 printf("%sLABEL ", dev->state & ST_LABEL ? "" : "!");
537 printf("%sMALLOC ", dev->state & ST_MALLOC ? "" : "!");
538 printf("%sAPPEND ", dev->state & ST_APPEND ? "" : "!");
539 printf("%sREAD ", dev->state & ST_READ ? "" : "!");
540 printf("%sEOT ", dev->state & ST_EOT ? "" : "!");
541 printf("%sWEOT ", dev->state & ST_WEOT ? "" : "!");
542 printf("%sEOF ", dev->state & ST_EOF ? "" : "!");
543 printf("%sNEXTVOL ", dev->state & ST_NEXTVOL ? "" : "!");
544 printf("%sSHORT ", dev->state & ST_SHORT ? "" : "!");
547 printf(_("Device parameters:\n"));
548 printf("Device name: %s\n", dev->dev_name);
549 printf("File=%u block=%u\n", dev->file, dev->block_num);
550 printf("Min block=%u Max block=%u\n", dev->min_block_size, dev->max_block_size);
558 * Test writting larger and larger records.
559 * This is a torture test for records.
561 static void rectestcmd()
567 Pmsg0(0, "Test writting larger and larger records.\n"
568 "This is a torture test for records.\nI am going to write\n"
569 "larger and larger records. It will stop when the record size\n"
570 "plus the header exceeds the block size (by default about 64K)\n");
573 get_cmd("Do you want to continue? (y/n): ");
575 Pmsg0(000, "Command aborted.\n");
579 sm_check(__FILE__, __LINE__, false);
580 block = new_block(dev);
583 for (i=1; i<500000; i++) {
584 rec->data = check_pool_memory_size(rec->data, i);
585 memset(rec->data, i & 0xFF, i);
587 sm_check(__FILE__, __LINE__, false);
588 if (write_record_to_block(block, rec)) {
591 Pmsg2(0, "Block %d i=%d\n", blkno, i);
595 sm_check(__FILE__, __LINE__, false);
599 sm_check(__FILE__, __LINE__, false);
603 * This test attempts to re-read a block written by Bacula
604 * normally at the end of the tape. Bacula will then back up
605 * over the two eof marks, backup over the record and reread
606 * it to make sure it is valid. Bacula can skip this validation
607 * if you set "Backward space record = no"
609 static int re_read_block_test()
616 if (!(dev->capabilities & CAP_BSR)) {
617 Pmsg0(-1, _("Skipping read backwards test because BSR turned off.\n"));
621 Pmsg0(-1, _("\n=== Write, backup, and re-read test ===\n\n"
622 "I'm going to write three records and an EOF\n"
623 "then backup over the EOF and re-read the last record.\n"
624 "Bacula does this after writing the last block on the\n"
625 "tape to verify that the block was written correctly.\n\n"
626 "This is not an *essential* feature ...\n\n"));
628 block = new_block(dev);
630 rec->data = check_pool_memory_size(rec->data, block->buf_len);
631 len = rec->data_len = block->buf_len-100;
632 memset(rec->data, 1, rec->data_len);
633 if (!write_record_to_block(block, rec)) {
634 Pmsg0(0, _("Error writing record to block.\n"));
637 if (!write_block_to_dev(jcr->dcr, block)) {
638 Pmsg0(0, _("Error writing block to device.\n"));
641 Pmsg1(0, _("Wrote first record of %d bytes.\n"), rec->data_len);
643 memset(rec->data, 2, rec->data_len);
644 if (!write_record_to_block(block, rec)) {
645 Pmsg0(0, _("Error writing record to block.\n"));
648 if (!write_block_to_dev(jcr->dcr, block)) {
649 Pmsg0(0, _("Error writing block to device.\n"));
652 Pmsg1(0, _("Wrote second record of %d bytes.\n"), rec->data_len);
654 memset(rec->data, 3, rec->data_len);
655 if (!write_record_to_block(block, rec)) {
656 Pmsg0(0, _("Error writing record to block.\n"));
659 if (!write_block_to_dev(jcr->dcr, block)) {
660 Pmsg0(0, _("Error writing block to device.\n"));
663 Pmsg1(0, _("Wrote third record of %d bytes.\n"), rec->data_len);
666 if (dev_cap(dev, CAP_TWOEOF)) {
669 if (!bsf_dev(dev, 1)) {
670 Pmsg1(0, _("Backspace file failed! ERR=%s\n"), strerror_dev(dev));
673 if (dev_cap(dev, CAP_TWOEOF)) {
674 if (!bsf_dev(dev, 1)) {
675 Pmsg1(0, _("Backspace file failed! ERR=%s\n"), strerror_dev(dev));
679 Pmsg0(0, "Backspaced over EOF OK.\n");
680 if (!bsr_dev(dev, 1)) {
681 Pmsg1(0, _("Backspace record failed! ERR=%s\n"), strerror_dev(dev));
684 Pmsg0(0, "Backspace record OK.\n");
685 if (!read_block_from_dev(jcr, dev, block, NO_BLOCK_NUMBER_CHECK)) {
686 Pmsg1(0, _("Read block failed! ERR=%s\n"), strerror(dev->dev_errno));
689 memset(rec->data, 0, rec->data_len);
690 if (!read_record_from_block(block, rec)) {
691 Pmsg1(0, _("Read block failed! ERR=%s\n"), strerror(dev->dev_errno));
694 for (int i=0; i<len; i++) {
695 if (rec->data[i] != 3) {
696 Pmsg0(0, _("Bad data in record. Test failed!\n"));
700 Pmsg0(0, _("\nBlock re-read correct. Test succeeded!\n"));
701 Pmsg0(-1, _("=== End Write, backup, and re-read test ===\n\n"));
709 Pmsg0(0, _("This is not terribly serious since Bacula only uses\n"
710 "this function to verify the last block written to the\n"
711 "tape. Bacula will skip the last block verification\n"
713 "Backward Space Record = No\n\n"
714 "to your Storage daemon's Device resource definition.\n"));
721 * This test writes Bacula blocks to the tape in
722 * several files. It then rewinds the tape and attepts
723 * to read these blocks back checking the data.
725 static int write_read_test()
733 Pmsg0(-1, _("\n=== Write, rewind, and re-read test ===\n\n"
734 "I'm going to write 1000 records and an EOF\n"
735 "then write 1000 records and an EOF, then rewind,\n"
736 "and re-read the data to verify that it is correct.\n\n"
737 "This is an *essential* feature ...\n\n"));
738 block = new_block(dev);
740 if (!rewind_dev(dev)) {
741 Pmsg1(0, "Bad status from rewind. ERR=%s\n", strerror_dev(dev));
744 rec->data = check_pool_memory_size(rec->data, block->buf_len);
745 rec->data_len = block->buf_len-100;
746 len = rec->data_len/sizeof(i);
747 for (i=1; i<=1000; i++) {
748 p = (int *)rec->data;
749 for (j=0; j<len; j++) {
752 if (!write_record_to_block(block, rec)) {
753 Pmsg0(0, _("Error writing record to block.\n"));
756 if (!write_block_to_dev(jcr->dcr, block)) {
757 Pmsg0(0, _("Error writing block to device.\n"));
761 Pmsg1(0, _("Wrote 1000 blocks of %d bytes.\n"), rec->data_len);
763 for (i=1001; i<=2000; i++) {
764 p = (int *)rec->data;
765 for (j=0; j<len; j++) {
768 if (!write_record_to_block(block, rec)) {
769 Pmsg0(0, _("Error writing record to block.\n"));
772 if (!write_block_to_dev(jcr->dcr, block)) {
773 Pmsg0(0, _("Error writing block to device.\n"));
777 Pmsg1(0, _("Wrote 1000 blocks of %d bytes.\n"), rec->data_len);
779 if (dev_cap(dev, CAP_TWOEOF)) {
782 if (!rewind_dev(dev)) {
783 Pmsg1(0, "Bad status from rewind. ERR=%s\n", strerror_dev(dev));
786 Pmsg0(0, "Rewind OK.\n");
788 for (i=1; i<=2000; i++) {
790 if (!read_block_from_dev(jcr, dev, block, NO_BLOCK_NUMBER_CHECK)) {
791 if (dev_state(dev, ST_EOF)) {
792 Pmsg0(-1, _("Got EOF on tape.\n"));
795 Pmsg1(0, _("Read block failed! ERR=%s\n"), strerror(dev->dev_errno));
798 memset(rec->data, 0, rec->data_len);
799 if (!read_record_from_block(block, rec)) {
800 Pmsg1(0, _("Read record failed! ERR=%s\n"), strerror(dev->dev_errno));
803 p = (int *)rec->data;
804 for (j=0; j<len; j++) {
806 Pmsg3(0, _("Bad data in record. Expected %d, got %d at byte %d. Test failed!\n"),
812 if (i == 1000 || i == 2000) {
813 Pmsg0(-1, _("1000 blocks re-read correctly.\n"));
816 Pmsg0(-1, _("=== Test Succeeded. End Write, rewind, and re-read test ===\n\n"));
826 * This test writes Bacula blocks to the tape in
827 * several files. It then rewinds the tape and attepts
828 * to read these blocks back checking the data.
830 static int position_test()
838 int file = 0, blk = 0;
841 Pmsg0(-1, _("\n=== Write, rewind, and position test ===\n\n"
842 "I'm going to write 1000 records and an EOF\n"
843 "then write 1000 records and an EOF, then rewind,\n"
844 "and position to a few blocks and verify that it is correct.\n\n"
845 "This is an *essential* feature ...\n\n"));
846 block = new_block(dev);
848 if (!rewind_dev(dev)) {
849 Pmsg1(0, "Bad status from rewind. ERR=%s\n", strerror_dev(dev));
852 rec->data = check_pool_memory_size(rec->data, block->buf_len);
853 rec->data_len = block->buf_len-100;
854 len = rec->data_len/sizeof(i);
855 for (i=1; i<=1000; i++) {
856 p = (int *)rec->data;
857 for (j=0; j<len; j++) {
860 if (!write_record_to_block(block, rec)) {
861 Pmsg0(0, _("Error writing record to block.\n"));
864 if (!write_block_to_dev(jcr->dcr, block)) {
865 Pmsg0(0, _("Error writing block to device.\n"));
869 Pmsg1(0, _("Wrote 1000 blocks of %d bytes.\n"), rec->data_len);
871 for (i=1001; i<=2000; i++) {
872 p = (int *)rec->data;
873 for (j=0; j<len; j++) {
876 if (!write_record_to_block(block, rec)) {
877 Pmsg0(0, _("Error writing record to block.\n"));
880 if (!write_block_to_dev(jcr->dcr, block)) {
881 Pmsg0(0, _("Error writing block to device.\n"));
885 Pmsg1(0, _("Wrote 1000 blocks of %d bytes.\n"), rec->data_len);
887 if (dev_cap(dev, CAP_TWOEOF)) {
890 if (!rewind_dev(dev)) {
891 Pmsg1(0, "Bad status from rewind. ERR=%s\n", strerror_dev(dev));
894 Pmsg0(0, "Rewind OK.\n");
898 /* Set up next item to read based on where we are */
934 Pmsg2(-1, "Reposition to file:block %d:%d\n", file, blk);
935 if (!reposition_dev(dev, file, blk)) {
936 Pmsg0(0, "Reposition error.\n");
940 if (!read_block_from_dev(jcr, dev, block, NO_BLOCK_NUMBER_CHECK)) {
941 if (dev_state(dev, ST_EOF)) {
942 Pmsg0(-1, _("Got EOF on tape.\n"));
945 Pmsg1(0, _("Read block failed! ERR=%s\n"), strerror(dev->dev_errno));
948 memset(rec->data, 0, rec->data_len);
949 if (!read_record_from_block(block, rec)) {
950 Pmsg1(0, _("Read record failed! ERR=%s\n"), strerror(dev->dev_errno));
953 p = (int *)rec->data;
954 for (j=0; j<len; j++) {
956 Pmsg3(0, _("Bad data in record. Expected %d, got %d at byte %d. Test failed!\n"),
961 Pmsg0(-1, _("Block re-read correctly.\n"));
963 Pmsg0(-1, _("=== Test Succeeded. End Write, rewind, and re-read test ===\n\n"));
976 * This test writes some records, then writes an end of file,
977 * rewinds the tape, moves to the end of the data and attepts
978 * to append to the tape. This function is essential for
979 * Bacula to be able to write multiple jobs to the tape.
981 static int append_test()
983 Pmsg0(-1, _("\n\n=== Append files test ===\n\n"
984 "This test is essential to Bacula.\n\n"
985 "I'm going to write one record in file 0,\n"
986 " two records in file 1,\n"
987 " and three records in file 2\n\n"));
991 weofcmd(); /* end file 0 */
994 weofcmd(); /* end file 1 */
998 weofcmd(); /* end file 2 */
999 if (dev_cap(dev, CAP_TWOEOF)) {
1003 Pmsg0(0, _("Now moving to end of medium.\n"));
1005 Pmsg2(-1, _("We should be in file 3. I am at file %d. This is %s\n"),
1006 dev->file, dev->file == 3 ? "correct!" : "NOT correct!!!!");
1008 if (dev->file != 3) {
1012 Pmsg0(-1, _("\nNow the important part, I am going to attempt to append to the tape.\n\n"));
1015 if (dev_cap(dev, CAP_TWOEOF)) {
1019 Pmsg0(-1, _("Done appending, there should be no I/O errors\n\n"));
1020 Pmsg0(-1, "Doing Bacula scan of blocks:\n");
1022 Pmsg0(-1, _("End scanning the tape.\n"));
1023 Pmsg2(-1, _("We should be in file 4. I am at file %d. This is %s\n"),
1024 dev->file, dev->file == 4 ? "correct!" : "NOT correct!!!!");
1026 if (dev->file != 4) {
1034 * This test exercises the autochanger
1036 static int autochanger_test()
1038 POOLMEM *results, *changer;
1039 int slot, status, loaded;
1040 int timeout = jcr->device->max_changer_wait;
1043 Dmsg1(100, "Max changer wait = %d sec\n", timeout);
1044 if (!dev_cap(dev, CAP_AUTOCHANGER)) {
1047 if (!(jcr->device && jcr->device->changer_name && jcr->device->changer_command)) {
1048 Pmsg0(-1, "\nAutochanger enabled, but no name or no command device specified.\n");
1052 Pmsg0(-1, "\nAh, I see you have an autochanger configured.\n"
1053 "To test the autochanger you must have a blank tape\n"
1054 " that I can write on in Slot 1.\n");
1055 if (!get_cmd("\nDo you wish to continue with the Autochanger test? (y/n): ")) {
1058 if (cmd[0] != 'y' && cmd[0] != 'Y') {
1062 Pmsg0(-1, _("\n\n=== Autochanger test ===\n\n"));
1064 results = get_pool_memory(PM_MESSAGE);
1065 changer = get_pool_memory(PM_FNAME);
1069 jcr->VolCatInfo.Slot = slot;
1070 /* Find out what is loaded, zero means device is unloaded */
1071 Pmsg0(-1, _("3301 Issuing autochanger \"loaded\" command.\n"));
1072 changer = edit_device_codes(jcr, changer, jcr->device->changer_command,
1074 status = run_program(changer, timeout, results);
1075 Dmsg3(100, "run_prog: %s stat=%d result=%s\n", changer, status, results);
1077 loaded = atoi(results);
1079 Pmsg1(-1, _("3991 Bad autochanger command: %s\n"), changer);
1080 Pmsg2(-1, _("3991 status=%d result=%s\n"), status, results);
1084 Pmsg1(-1, "Slot %d loaded. I am going to unload it.\n", loaded);
1086 Pmsg0(-1, "Nothing loaded in the drive. OK.\n");
1088 Dmsg1(100, "Results from loaded query=%s\n", results);
1090 jcr->VolCatInfo.Slot = loaded;
1091 offline_or_rewind_dev(dev);
1092 /* We are going to load a new tape, so close the device */
1093 force_close_dev(dev);
1094 Pmsg2(-1, _("3302 Issuing autochanger \"unload %d %d\" command.\n"),
1095 loaded, dev->drive_index);
1096 changer = edit_device_codes(jcr, changer,
1097 jcr->device->changer_command, "unload");
1098 status = run_program(changer, timeout, results);
1099 Pmsg2(-1, "unload status=%s %d\n", status==0?"OK":"Bad", status);
1101 Pmsg1(-1, _("3992 Bad autochanger command: %s\n"), changer);
1102 Pmsg2(-1, _("3992 status=%d result=%s\n"), status, results);
1111 jcr->VolCatInfo.Slot = slot;
1112 Pmsg2(-1, _("3303 Issuing autochanger \"load slot %d %d\" command.\n"),
1113 slot, dev->drive_index);
1114 changer = edit_device_codes(jcr, changer, jcr->device->changer_command, "load");
1115 Dmsg1(100, "Changer=%s\n", changer);
1116 force_close_dev(dev);
1117 status = run_program(changer, timeout, results);
1119 Pmsg2(-1, _("3303 Autochanger \"load slot %d %d\" status is OK.\n"),
1120 slot, dev->drive_index);
1122 Pmsg1(-1, _("3993 Bad autochanger command: %s\n"), changer);
1123 Pmsg2(-1, _("3993 status=%d result=%s\n"), status, results);
1127 if (!open_the_device()) {
1130 bmicrosleep(sleep_time, 0);
1131 if (!rewind_dev(dev)) {
1132 Pmsg1(0, "Bad status from rewind. ERR=%s\n", strerror_dev(dev));
1133 clrerror_dev(dev, -1);
1134 Pmsg0(-1, "\nThe test failed, probably because you need to put\n"
1135 "a longer sleep time in the mtx-script in the load) case.\n"
1136 "Adding a 30 second sleep and trying again ...\n");
1140 Pmsg1(0, "Rewound %s\n", dev_name(dev));
1143 if ((status = weof_dev(dev, 1)) < 0) {
1144 Pmsg2(0, "Bad status from weof %d. ERR=%s\n", status, strerror_dev(dev));
1147 Pmsg1(0, "Wrote EOF to %s\n", dev_name(dev));
1151 Pmsg1(-1, "\nThe test worked this time. Please add:\n\n"
1153 "to your mtx-changer script in the load) case.\n\n",
1156 Pmsg0(-1, "\nThe test autochanger worked!!\n\n");
1159 free_pool_memory(changer);
1160 free_pool_memory(results);
1165 free_pool_memory(changer);
1166 free_pool_memory(results);
1167 Pmsg0(-1, "You must correct this error or the Autochanger will not work.\n");
1171 static void autochangercmd()
1178 * This test assumes that the append test has been done,
1179 * then it tests the fsf function.
1181 static int fsf_test()
1183 bool set_off = false;
1185 Pmsg0(-1, _("\n\n=== Forward space files test ===\n\n"
1186 "This test is essential to Bacula.\n\n"
1187 "I'm going to write five files then test forward spacing\n\n"));
1191 weofcmd(); /* end file 0 */
1194 weofcmd(); /* end file 1 */
1198 weofcmd(); /* end file 2 */
1201 weofcmd(); /* end file 3 */
1203 weofcmd(); /* end file 4 */
1204 if (dev_cap(dev, CAP_TWOEOF)) {
1210 Pmsg0(0, _("Now forward spacing 1 file.\n"));
1211 if (!fsf_dev(dev, 1)) {
1212 Pmsg1(0, "Bad status from fsr. ERR=%s\n", strerror_dev(dev));
1215 Pmsg2(-1, _("We should be in file 1. I am at file %d. This is %s\n"),
1216 dev->file, dev->file == 1 ? "correct!" : "NOT correct!!!!");
1218 if (dev->file != 1) {
1222 Pmsg0(0, _("Now forward spacing 2 files.\n"));
1223 if (!fsf_dev(dev, 2)) {
1224 Pmsg1(0, "Bad status from fsr. ERR=%s\n", strerror_dev(dev));
1227 Pmsg2(-1, _("We should be in file 3. I am at file %d. This is %s\n"),
1228 dev->file, dev->file == 3 ? "correct!" : "NOT correct!!!!");
1230 if (dev->file != 3) {
1235 Pmsg0(0, _("Now forward spacing 4 files.\n"));
1236 if (!fsf_dev(dev, 4)) {
1237 Pmsg1(0, "Bad status from fsr. ERR=%s\n", strerror_dev(dev));
1240 Pmsg2(-1, _("We should be in file 4. I am at file %d. This is %s\n"),
1241 dev->file, dev->file == 4 ? "correct!" : "NOT correct!!!!");
1243 if (dev->file != 4) {
1247 Pmsg0(-1, "The test worked this time. Please add:\n\n"
1248 " Fast Forward Space File = no\n\n"
1249 "to your Device resource for this drive.\n");
1253 Pmsg0(0, _("Now forward spacing 1 more file.\n"));
1254 if (!fsf_dev(dev, 1)) {
1255 Pmsg1(0, "Bad status from fsr. ERR=%s\n", strerror_dev(dev));
1257 Pmsg2(-1, _("We should be in file 5. I am at file %d. This is %s\n"),
1258 dev->file, dev->file == 5 ? "correct!" : "NOT correct!!!!");
1259 if (dev->file != 5) {
1262 Pmsg0(-1, _("\n=== End Forward space files test ===\n\n"));
1266 Pmsg0(-1, _("\nThe forward space file test failed.\n"));
1267 if (dev_cap(dev, CAP_FASTFSF)) {
1268 Pmsg0(-1, "You have Fast Forward Space File enabled.\n"
1269 "I am turning it off then retrying the test.\n");
1270 dev->capabilities &= ~CAP_FASTFSF;
1274 Pmsg0(-1, "You must correct this error or Bacula will not work.\n");
1283 * This is a general test of Bacula's functions
1284 * needed to read and write the tape.
1286 static void testcmd()
1290 if (!write_read_test()) {
1293 if (!position_test()) {
1297 stat = append_test();
1298 if (stat == 1) { /* OK get out */
1301 if (stat == -1) { /* first test failed */
1302 if (dev_cap(dev, CAP_EOM) || dev_cap(dev, CAP_FASTFSF)) {
1303 Pmsg0(-1, "\nAppend test failed. Attempting again.\n"
1304 "Setting \"Hardware End of Medium = no\n"
1305 " and \"Fast Forward Space File = no\n"
1306 "and retrying append test.\n\n");
1307 dev->capabilities &= ~CAP_EOM; /* turn off eom */
1308 dev->capabilities &= ~CAP_FASTFSF; /* turn off fast fsf */
1309 stat = append_test();
1311 Pmsg0(-1, "\n\nIt looks like the test worked this time, please add:\n\n"
1312 " Hardware End of Medium = No\n\n"
1313 " Fast Forward Space File = No\n"
1314 "to your Device resource in the Storage conf file.\n");
1318 Pmsg0(-1, "\n\nThat appears *NOT* to have corrected the problem.\n");
1321 /* Wrong count after append */
1323 Pmsg0(-1, "\n\nIt looks like the append failed. Attempting again.\n"
1324 "Setting \"BSF at EOM = yes\" and retrying append test.\n");
1325 dev->capabilities |= CAP_BSFATEOM; /* backspace on eom */
1326 stat = append_test();
1328 Pmsg0(-1, "\n\nIt looks like the test worked this time, please add:\n\n"
1329 " Hardware End of Medium = No\n"
1330 " Fast Forward Space File = No\n"
1331 " BSF at EOM = yes\n\n"
1332 "to your Device resource in the Storage conf file.\n");
1339 Pmsg0(-1, "\nAppend test failed.\n\n");
1340 Pmsg0(-1, "\n!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!\n"
1341 "Unable to correct the problem. You MUST fix this\n"
1342 "problem before Bacula can use your tape drive correctly\n");
1343 Pmsg0(-1, "\nPerhaps running Bacula in fixed block mode will work.\n"
1344 "Do so by setting:\n\n"
1345 "Minimum Block Size = nnn\n"
1346 "Maximum Block Size = nnn\n\n"
1347 "in your Storage daemon's Device definition.\n"
1348 "nnn must match your tape driver's block size, which\n"
1349 "can be determined by reading your tape manufacturers\n"
1350 "information, and the information on your kernel dirver.\n"
1351 "Fixed block sizes, however, are not normally an ideal solution.\n");
1356 Pmsg0(-1, _("\nThe above Bacula scan should have output identical to what follows.\n"
1357 "Please double check it ...\n"
1358 "=== Sample correct output ===\n"
1359 "1 block of 64448 bytes in file 1\n"
1360 "End of File mark.\n"
1361 "2 blocks of 64448 bytes in file 2\n"
1362 "End of File mark.\n"
1363 "3 blocks of 64448 bytes in file 3\n"
1364 "End of File mark.\n"
1365 "1 block of 64448 bytes in file 4\n"
1366 "End of File mark.\n"
1367 "Total files=4, blocks=7, bytes = 451,136\n"
1368 "=== End sample correct output ===\n\n"));
1370 Pmsg0(-1, _("If the above scan output is not identical to the\n"
1371 "sample output, you MUST correct the problem\n"
1372 "or Bacula will not be able to write multiple Jobs to \n"
1376 re_read_block_test();
1379 fsf_test(); /* do fast forward space file test */
1381 autochanger_test(); /* do autochanger test */
1385 /* Forward space a file */
1386 static void fsfcmd()
1390 num = atoi(argk[1]);
1395 if (!fsf_dev(dev, num)) {
1396 Pmsg1(0, "Bad status from fsf. ERR=%s\n", strerror_dev(dev));
1399 Pmsg2(0, "Forward spaced %d file%s.\n", num, num==1?"":"s");
1402 /* Forward space a record */
1403 static void fsrcmd()
1407 num = atoi(argk[1]);
1412 if (!fsr_dev(dev, num)) {
1413 Pmsg1(0, "Bad status from fsr. ERR=%s\n", strerror_dev(dev));
1416 Pmsg2(0, "Forward spaced %d record%s.\n", num, num==1?"":"s");
1421 * Write a Bacula block to the tape
1429 sm_check(__FILE__, __LINE__, false);
1430 block = new_block(dev);
1432 dump_block(block, "test");
1434 i = block->buf_len - 100;
1436 rec->data = check_pool_memory_size(rec->data, i);
1437 memset(rec->data, i & 0xFF, i);
1439 sm_check(__FILE__, __LINE__, false);
1440 if (!write_record_to_block(block, rec)) {
1441 Pmsg0(0, _("Error writing record to block.\n"));
1444 if (!write_block_to_dev(jcr->dcr, block)) {
1445 Pmsg0(0, _("Error writing block to device.\n"));
1448 Pmsg1(0, _("Wrote one record of %d bytes.\n"), i);
1450 Pmsg0(0, _("Wrote block to device.\n"));
1453 sm_check(__FILE__, __LINE__, false);
1456 sm_check(__FILE__, __LINE__, false);
1460 * Read a record from the tape
1467 if (!get_cmd("Enter length to read: ")) {
1471 if (len < 0 || len > 1000000) {
1472 Pmsg0(0, _("Bad length entered, using default of 1024 bytes.\n"));
1475 buf = (char *)malloc(len);
1476 stat = read(dev->fd, buf, len);
1477 if (stat > 0 && stat <= len) {
1480 Pmsg3(0, _("Read of %d bytes gives stat=%d. ERR=%s\n"),
1481 len, stat, strerror(errno));
1487 * Scan tape by reading block by block. Report what is
1488 * on the tape. Note, this command does raw reads, and as such
1489 * will not work with fixed block size devices.
1491 static void scancmd()
1494 int blocks, tot_blocks, tot_files;
1500 blocks = block_size = tot_blocks = 0;
1502 if (dev->state & ST_EOT) {
1503 Pmsg0(0, "End of tape\n");
1506 update_pos_dev(dev);
1507 tot_files = dev->file;
1508 Pmsg1(0, _("Starting scan at file %u\n"), dev->file);
1510 if ((stat = read(dev->fd, buf, sizeof(buf))) < 0) {
1511 clrerror_dev(dev, -1);
1512 Mmsg2(&dev->errmsg, "read error on %s. ERR=%s.\n",
1513 dev->dev_name, strerror(dev->dev_errno));
1514 Pmsg2(0, "Bad status from read %d. ERR=%s\n", stat, strerror_dev(dev));
1516 printf("%d block%s of %d bytes in file %d\n",
1517 blocks, blocks>1?"s":"", block_size, dev->file);
1520 Dmsg1(200, "read status = %d\n", stat);
1522 if (stat != block_size) {
1523 update_pos_dev(dev);
1525 printf("%d block%s of %d bytes in file %d\n",
1526 blocks, blocks>1?"s":"", block_size, dev->file);
1531 if (stat == 0) { /* EOF */
1532 update_pos_dev(dev);
1533 printf("End of File mark.\n");
1534 /* Two reads of zero means end of tape */
1535 if (dev->state & ST_EOF)
1536 dev->state |= ST_EOT;
1538 dev->state |= ST_EOF;
1541 if (dev->state & ST_EOT) {
1542 printf("End of tape\n");
1545 } else { /* Got data */
1546 dev->state &= ~ST_EOF;
1552 update_pos_dev(dev);
1553 tot_files = dev->file - tot_files;
1554 printf("Total files=%d, blocks=%d, bytes = %s\n", tot_files, tot_blocks,
1555 edit_uint64_with_commas(bytes, ec1));
1560 * Scan tape by reading Bacula block by block. Report what is
1561 * on the tape. This function reads Bacula blocks, so if your
1562 * Device resource is correctly defined, it should work with
1563 * either variable or fixed block sizes.
1565 static void scan_blocks()
1567 int blocks, tot_blocks, tot_files;
1568 uint32_t block_size;
1573 block = new_block(dev);
1574 blocks = block_size = tot_blocks = 0;
1577 update_pos_dev(dev);
1578 tot_files = dev->file;
1580 if (!read_block_from_device(jcr, dev, block, NO_BLOCK_NUMBER_CHECK)) {
1581 Dmsg1(100, "!read_block(): ERR=%s\n", strerror_dev(dev));
1582 if (dev->state & ST_EOT) {
1584 printf("%d block%s of %d bytes in file %d\n",
1585 blocks, blocks>1?"s":"", block_size, dev->file);
1590 if (dev->state & ST_EOF) {
1592 printf("%d block%s of %d bytes in file %d\n",
1593 blocks, blocks>1?"s":"", block_size, dev->file);
1596 printf(_("End of File mark.\n"));
1599 if (dev->state & ST_SHORT) {
1601 printf("%d block%s of %d bytes in file %d\n",
1602 blocks, blocks>1?"s":"", block_size, dev->file);
1605 printf(_("Short block read.\n"));
1608 printf(_("Error reading block. ERR=%s\n"), strerror_dev(dev));
1611 if (block->block_len != block_size) {
1613 printf("%d block%s of %d bytes in file %d\n",
1614 blocks, blocks>1?"s":"", block_size, dev->file);
1617 block_size = block->block_len;
1621 bytes += block->block_len;
1622 Dmsg6(100, "Blk_blk=%u dev_blk=%u blen=%u bVer=%d SessId=%u SessTim=%u\n",
1623 block->BlockNumber, dev->block_num, block->block_len, block->BlockVer,
1624 block->VolSessionId, block->VolSessionTime);
1626 DEV_RECORD *rec = new_record();
1627 read_record_from_block(block, rec);
1628 Pmsg8(-1, "Blk_block: %u dev_blk=%u blen=%u First rec FI=%s SessId=%u SessTim=%u Strm=%s rlen=%d\n",
1629 block->BlockNumber, dev->block_num, block->block_len,
1630 FI_to_ascii(rec->FileIndex), rec->VolSessionId, rec->VolSessionTime,
1631 stream_to_ascii(rec->Stream, rec->FileIndex), rec->data_len);
1634 } else if (verbose > 1) {
1635 dump_block(block, "");
1641 tot_files = dev->file - tot_files;
1642 printf("Total files=%d, blocks=%d, bytes = %s\n", tot_files, tot_blocks,
1643 edit_uint64_with_commas(bytes, ec1));
1647 static void statcmd()
1649 int debug = debug_level;
1651 Pmsg2(0, "Device status: %u. ERR=%s\n", status_dev(dev), strerror_dev(dev));
1653 dump_volume_label(dev);
1655 debug_level = debug;
1660 * First we label the tape, then we fill
1661 * it with data get a new tape and write a few blocks.
1663 static void fillcmd()
1670 uint32_t min_block_size;
1680 This command simulates Bacula writing to a tape.\n\
1681 It requires either one or two blank tapes, which it\n\
1682 will label and write.\n\n\
1683 If you have an autochanger configured, it will use\n\
1684 the tapes that are in slots 1 and 2, otherwise, you will\n\
1685 be prompted to insert the tapes when necessary.\n\n\
1686 It will print a status approximately\n\
1687 every 322 MB, and write an EOF every 3.2 GB. If you have\n\
1688 selected the simple test option, after writing the first tape\n\
1689 it will rewind it and re-read the last block written.\n\n\
1690 If you have selected the multiple tape test, when the first tape\n\
1691 fills, it will ask for a second, and after writing a few more \n\
1692 blocks, it will stop. Then it will begin re-reading the\n\
1694 This may take a long time -- hours! ...\n\n");
1696 get_cmd("Do you want to run the simplified test (s) with one tape\n"
1697 "or the complete multiple tape (m) test: (s/m) ");
1698 if (cmd[0] == 's') {
1699 Pmsg0(-1, "Simple test (single tape) selected.\n");
1701 } else if (cmd[0] == 'm') {
1702 Pmsg0(-1, "Multiple tape test selected.\n");
1705 Pmsg0(000, "Command aborted.\n");
1709 Dmsg1(20, "Begin append device=%s\n", dev_name(dev));
1710 Dmsg1(20, "MaxVolSize=%s\n", edit_uint64(dev->max_volume_size, ec1));
1712 /* Use fixed block size to simplify read back */
1713 min_block_size = dev->min_block_size;
1714 dev->min_block_size = dev->max_block_size;
1717 * Acquire output device for writing. Note, after acquiring a
1718 * device, we MUST release it, which is done at the end of this
1721 Dmsg0(100, "just before acquire_device\n");
1722 if (!acquire_device_for_append(jcr)) {
1723 set_jcr_job_status(jcr, JS_ErrorTerminated);
1726 block = jcr->dcr->block;
1728 Dmsg0(100, "Just after acquire_device_for_append\n");
1730 * Write Begin Session Record
1732 if (!write_session_label(jcr, block, SOS_LABEL)) {
1733 set_jcr_job_status(jcr, JS_ErrorTerminated);
1734 Jmsg1(jcr, M_FATAL, 0, _("Write session label failed. ERR=%s\n"),
1738 Pmsg0(-1, "Wrote Start Of Session label.\n");
1740 memset(&rec, 0, sizeof(rec));
1741 rec.data = get_memory(100000); /* max record size */
1743 #define REC_SIZE 32768
1744 rec.data_len = REC_SIZE;
1747 * Put some random data in the record
1749 fd = open("/dev/urandom", O_RDONLY);
1751 read(fd, rec.data, rec.data_len);
1754 uint32_t *p = (uint32_t *)rec.data;
1755 srandom(time(NULL));
1756 for (i=0; i<rec.data_len/sizeof(uint32_t); i++) {
1762 * Generate data as if from File daemon, write to device
1764 jcr->dcr->VolFirstIndex = 0;
1765 time(&jcr->run_time); /* start counting time for rates */
1767 Pmsg0(-1, "Begin writing Bacula records to tape ...\n");
1769 Pmsg0(-1, "Begin writing Bacula records to first tape ...\n");
1771 for (file_index = 0; ok && !job_canceled(jcr); ) {
1772 rec.VolSessionId = jcr->VolSessionId;
1773 rec.VolSessionTime = jcr->VolSessionTime;
1774 rec.FileIndex = ++file_index;
1775 rec.Stream = STREAM_FILE_DATA;
1777 /* Mix up the data just a bit */
1778 uint32_t *lp = (uint32_t *)rec.data;
1780 for (i=1; i < (rec.data_len-sizeof(uint32_t))/sizeof(uint32_t)-1; i++) {
1784 Dmsg4(250, "before write_rec FI=%d SessId=%d Strm=%s len=%d\n",
1785 rec.FileIndex, rec.VolSessionId, stream_to_ascii(rec.Stream, rec.FileIndex),
1788 while (!write_record_to_block(block, &rec)) {
1790 * When we get here we have just filled a block
1792 Dmsg2(150, "!write_record_to_block data_len=%d rem=%d\n", rec.data_len,
1795 /* Write block to tape */
1796 if (!flush_block(block, 1)) {
1800 /* Every 5000 blocks (approx 322MB) report where we are.
1802 if ((block->BlockNumber % 5000) == 0) {
1804 now -= jcr->run_time;
1806 now = 1; /* prevent divide error */
1808 kbs = (double)dev->VolCatInfo.VolCatBytes / (1000.0 * (double)now);
1809 Pmsg4(-1, "Wrote blk_block=%u, dev_blk_num=%u VolBytes=%s rate=%.1f KB/s\n",
1810 block->BlockNumber, dev->block_num,
1811 edit_uint64_with_commas(dev->VolCatInfo.VolCatBytes, ec1), (float)kbs);
1813 /* Every 15000 blocks (approx 1GB) write an EOF.
1815 if ((block->BlockNumber % 15000) == 0) {
1816 Pmsg0(-1, "Flush block, write EOF\n");
1817 flush_block(block, 0);
1821 /* Get out after writing 10 blocks to the second tape */
1822 if (++BlockNumber > 10 && stop != 0) { /* get out */
1827 Pmsg0(000, _("Not OK\n"));
1830 jcr->JobBytes += rec.data_len; /* increment bytes this job */
1831 Dmsg4(190, "write_record FI=%s SessId=%d Strm=%s len=%d\n",
1832 FI_to_ascii(rec.FileIndex), rec.VolSessionId,
1833 stream_to_ascii(rec.Stream, rec.FileIndex), rec.data_len);
1835 /* Get out after writing 10 blocks to the second tape */
1836 if (BlockNumber > 10 && stop != 0) { /* get out */
1837 Pmsg0(-1, "Done writing ...\n");
1842 Dmsg0(100, "Write_end_session_label()\n");
1843 /* Create Job status for end of session label */
1844 if (!job_canceled(jcr) && ok) {
1845 set_jcr_job_status(jcr, JS_Terminated);
1847 set_jcr_job_status(jcr, JS_ErrorTerminated);
1849 if (!write_session_label(jcr, block, EOS_LABEL)) {
1850 Pmsg1(000, _("Error writting end session label. ERR=%s\n"), strerror_dev(dev));
1853 /* Write out final block of this session */
1854 if (!write_block_to_device(jcr->dcr, block)) {
1855 Pmsg0(-1, _("Set ok=false after write_block_to_device.\n"));
1858 Pmsg0(-1, _("Wrote End Of Session label.\n"));
1860 /* Save last block info for second tape */
1861 last_block_num2 = last_block_num;
1862 last_file2 = last_file;
1864 free_block(last_block2);
1866 last_block2 = dup_block(last_block);
1869 sprintf(buf, "%s/btape.state", working_directory);
1870 fd = open(buf, O_CREAT|O_TRUNC|O_WRONLY, 0640);
1872 write(fd, &btape_state_level, sizeof(btape_state_level));
1873 write(fd, &simple, sizeof(simple));
1874 write(fd, &last_block_num1, sizeof(last_block_num1));
1875 write(fd, &last_block_num2, sizeof(last_block_num2));
1876 write(fd, &last_file1, sizeof(last_file1));
1877 write(fd, &last_file2, sizeof(last_file2));
1878 write(fd, last_block1->buf, last_block1->buf_len);
1879 write(fd, last_block2->buf, last_block2->buf_len);
1880 write(fd, first_block->buf, first_block->buf_len);
1882 Pmsg2(-1, "Wrote state file last_block_num1=%d last_block_num2=%d\n",
1883 last_block_num1, last_block_num2);
1885 Pmsg2(-1, _("Could not create state file: %s ERR=%s\n"), buf,
1889 /* Release the device */
1890 if (!release_device(jcr)) {
1891 Pmsg0(-1, _("Error in release_device\n"));
1896 Pmsg2(-1, _("\n\nDone filling tape%s. Now beginning re-read of %stape ...\n"),
1897 simple?"":"s", simple?"":"first ");
1901 dev->min_block_size = min_block_size;
1902 free_memory(rec.data);
1906 * Read two tapes written by the "fill" command and ensure
1907 * that the data is valid. If stop==1 we simulate full read back
1908 * of two tapes. If stop==-1 we simply read the last block and
1909 * verify that it is correct.
1911 static void unfillcmd()
1915 last_block1 = new_block(dev);
1916 last_block2 = new_block(dev);
1917 first_block = new_block(dev);
1918 sprintf(buf, "%s/btape.state", working_directory);
1919 fd = open(buf, O_RDONLY);
1921 uint32_t state_level;
1922 read(fd, &state_level, sizeof(btape_state_level));
1923 read(fd, &simple, sizeof(simple));
1924 read(fd, &last_block_num1, sizeof(last_block_num1));
1925 read(fd, &last_block_num2, sizeof(last_block_num2));
1926 read(fd, &last_file1, sizeof(last_file1));
1927 read(fd, &last_file2, sizeof(last_file2));
1928 read(fd, last_block1->buf, last_block1->buf_len);
1929 read(fd, last_block2->buf, last_block2->buf_len);
1930 read(fd, first_block->buf, first_block->buf_len);
1932 if (state_level != btape_state_level) {
1933 Pmsg0(-1, "\nThe state file level has changed. You must redo\n"
1934 "the fill command.\n");
1938 Pmsg2(-1, "\nCould not find the state file: %s ERR=%s\n"
1939 "You must redo the fill command.\n", buf, strerror(errno));
1946 static void do_unfill()
1954 block = new_block(dev);
1956 Dmsg0(20, "Enter do_unfill\n");
1957 dev->capabilities |= CAP_ANONVOLS; /* allow reading any volume */
1958 dev->capabilities &= ~CAP_LABEL; /* don't label anything here */
1962 time(&jcr->run_time); /* start counting time for rates */
1966 free_block(last_block);
1968 last_block_num = last_block_num1;
1969 last_file = last_file1;
1970 last_block = last_block1;
1973 /* Multiple Volume tape */
1974 /* Close device so user can use autochanger if desired */
1975 if (dev_cap(dev, CAP_OFFLINEUNMOUNT)) {
1978 autochanger = autoload_device(jcr, dev, 1, NULL);
1980 force_close_dev(dev);
1981 get_cmd(_("Mount first tape. Press enter when ready: "));
1985 set_volume_name("TestVolume1", 1);
1987 create_vol_list(jcr);
1989 dev->state &= ~ST_READ;
1990 if (!acquire_device_for_read(jcr)) {
1991 Pmsg1(-1, "%s", dev->errmsg);
1996 * We now have the first tape mounted.
1997 * Note, re-reading last block may have caused us to
1998 * loose track of where we are (block number unknown).
2000 rewind_dev(dev); /* get to a known place on tape */
2001 /* Read the first 1000 records */
2002 Pmsg0(-1, _("Reading the first 1000 records.\n"));
2003 read_records(jcr, dev, quickie_cb, my_mount_next_read_volume);
2004 Pmsg4(-1, _("Reposition from %u:%u to %u:%u\n"), dev->file, dev->block_num,
2005 last_file, last_block_num);
2006 if (!reposition_dev(dev, last_file, last_block_num)) {
2007 Pmsg1(-1, "Reposition error. ERR=%s\n", strerror_dev(dev));
2009 Pmsg1(-1, _("Reading block %u.\n"), last_block_num);
2010 if (!read_block_from_device(jcr, dev, block, NO_BLOCK_NUMBER_CHECK)) {
2011 Pmsg1(-1, _("Error reading block: ERR=%s\n"), strerror_dev(dev));
2014 if (compare_blocks(last_block, block)) {
2016 Pmsg0(-1, _("\nThe last block on the tape matches. Test succeeded.\n\n"));
2018 Pmsg0(-1, _("\nThe last block of the first tape matches.\n\n"));
2025 /* restore info for last block on second Volume */
2026 last_block_num = last_block_num2;
2027 last_file = last_file2;
2028 last_block = last_block2;
2030 /* Multiple Volume tape */
2031 /* Close device so user can use autochanger if desired */
2032 if (dev_cap(dev, CAP_OFFLINEUNMOUNT)) {
2037 set_volume_name("TestVolume2", 2);
2039 create_vol_list(jcr);
2040 autochanger = autoload_device(jcr, dev, 1, NULL);
2042 force_close_dev(dev);
2043 get_cmd(_("Mount second tape. Press enter when ready: "));
2046 dev->state &= ~ST_READ;
2047 if (!acquire_device_for_read(jcr)) {
2048 Pmsg1(-1, "%s", dev->errmsg);
2052 /* Space to "first" block which is last block not written
2053 * on the previous tape.
2055 Pmsg2(-1, _("Reposition from %u:%u to 0:1\n"), dev->file, dev->block_num);
2056 if (!reposition_dev(dev, 0, 1)) {
2057 Pmsg1(-1, "Reposition error. ERR=%s\n", strerror_dev(dev));
2060 Pmsg1(-1, _("Reading block %d.\n"), dev->block_num);
2061 if (!read_block_from_device(jcr, dev, block, NO_BLOCK_NUMBER_CHECK)) {
2062 Pmsg1(-1, _("Error reading block: ERR=%s\n"), strerror_dev(dev));
2065 if (compare_blocks(first_block, block)) {
2066 Pmsg0(-1, _("\nThe first block on the second tape matches.\n\n"));
2069 /* Now find and compare the last block */
2070 Pmsg4(-1, _("Reposition from %u:%u to %u:%u\n"), dev->file, dev->block_num,
2071 last_file, last_block_num);
2072 if (!reposition_dev(dev, last_file, last_block_num)) {
2073 Pmsg1(-1, "Reposition error. ERR=%s\n", strerror_dev(dev));
2076 Pmsg1(-1, _("Reading block %d.\n"), dev->block_num);
2077 if (!read_block_from_device(jcr, dev, block, NO_BLOCK_NUMBER_CHECK)) {
2078 Pmsg1(-1, _("Error reading block: ERR=%s\n"), strerror_dev(dev));
2081 if (compare_blocks(last_block, block)) {
2082 Pmsg0(-1, _("\nThe last block on the second tape matches. Test succeeded.\n\n"));
2087 free_block(last_block1);
2088 free_block(last_block2);
2089 free_block(first_block);
2092 /* Read 1000 records then stop */
2093 static int quickie_cb(JCR *jcr, DEVICE *dev, DEV_BLOCK *block, DEV_RECORD *rec)
2096 return quickie_count <= 1000;
2099 static bool compare_blocks(DEV_BLOCK *last_block, DEV_BLOCK *block)
2102 uint32_t CheckSum, block_len;
2105 p = last_block->buf;
2107 unser_begin(q, BLKHDR2_LENGTH);
2108 unser_uint32(CheckSum);
2109 unser_uint32(block_len);
2110 while (q < (block->buf+block_len)) {
2117 dump_block(last_block, _("Last block written"));
2119 dump_block(block, _("Block read back"));
2120 Pmsg1(-1, "\n\nThe blocks differ at byte %u\n", p - last_block->buf);
2121 Pmsg0(-1, "\n\n!!!! The last block written and the block\n"
2122 "that was read back differ. The test FAILED !!!!\n"
2123 "This must be corrected before you use Bacula\n"
2124 "to write multi-tape Volumes.!!!!\n");
2128 dump_block(last_block, _("Last block written"));
2129 dump_block(block, _("Block read back"));
2139 * Write current block to tape regardless of whether or
2140 * not it is full. If the tape fills, attempt to
2141 * acquire another tape.
2143 static int flush_block(DEV_BLOCK *block, int dump)
2148 uint32_t this_file, this_block_num;
2151 this_block = new_block(dev);
2154 last_block = new_block(dev);
2157 this_file = dev->file;
2158 this_block_num = dev->block_num;
2159 if (!write_block_to_dev(jcr->dcr, block)) {
2160 Pmsg3(000, "Last block at: %u:%u this_dev_block_num=%d\n",
2161 last_file, last_block_num, this_block_num);
2164 * This is 1st tape, so save first tape info separate
2165 * from second tape info
2167 last_block_num1 = last_block_num;
2168 last_file1 = last_file;
2169 last_block1 = dup_block(last_block);
2170 last_block2 = dup_block(last_block);
2171 first_block = dup_block(block); /* first block second tape */
2174 Pmsg3(000, "Block not written: FileIndex=%u blk_block=%u Size=%u\n",
2175 (unsigned)file_index, block->BlockNumber, block->block_len);
2176 dump_block(last_block, "Last block written");
2178 dump_block(block, "Block not written");
2181 eot_block = block->BlockNumber;
2182 eot_block_len = block->block_len;
2183 eot_FileIndex = file_index;
2187 now -= jcr->run_time;
2189 now = 1; /* don't divide by zero */
2191 kbs = (double)dev->VolCatInfo.VolCatBytes / (1000 * now);
2192 vol_size = dev->VolCatInfo.VolCatBytes;
2193 Pmsg2(000, "End of tape. VolumeCapacity=%s. Write rate = %.1f KB/s\n",
2194 edit_uint64_with_commas(dev->VolCatInfo.VolCatBytes, ec1), kbs);
2197 stop = -1; /* stop, but do simplified test */
2199 /* Full test in progress */
2200 if (!fixup_device_block_write_error(jcr, dev, block)) {
2201 Pmsg1(000, _("Cannot fixup device error. %s\n"), strerror_dev(dev));
2206 BlockNumber = 0; /* start counting for second tape */
2209 return 1; /* end of tape reached */
2212 /* Save contents after write so that the header is serialized */
2213 memcpy(this_block->buf, block->buf, this_block->buf_len);
2216 * Toggle between two allocated blocks for efficiency.
2217 * Switch blocks so that the block just successfully written is
2218 * always in last_block.
2220 tblock = last_block;
2221 last_block = this_block;
2222 this_block = tblock;
2223 last_file = this_file;
2224 last_block_num = this_block_num;
2232 * First we label the tape, then we fill
2233 * it with data get a new tape and write a few blocks.
2235 static void qfillcmd()
2241 Pmsg0(0, "Test writing blocks of 64512 bytes to tape.\n");
2243 get_cmd("How many blocks do you want to write? (1000): ");
2250 sm_check(__FILE__, __LINE__, false);
2251 block = new_block(dev);
2254 i = block->buf_len - 100;
2256 rec->data = check_pool_memory_size(rec->data, i);
2257 memset(rec->data, i & 0xFF, i);
2260 Pmsg1(0, "Begin writing %d Bacula blocks to tape ...\n", count);
2261 for (i=0; i < count; i++) {
2266 if (!write_record_to_block(block, rec)) {
2267 Pmsg0(0, _("Error writing record to block.\n"));
2270 if (!write_block_to_dev(jcr->dcr, block)) {
2271 Pmsg0(0, _("Error writing block to device.\n"));
2277 if (dev_cap(dev, CAP_TWOEOF)) {
2284 sm_check(__FILE__, __LINE__, false);
2287 sm_check(__FILE__, __LINE__, false);
2292 * Fill a tape using raw write() command
2294 static void rawfill_cmd()
2299 uint32_t block_num = 0;
2304 block = new_block(dev);
2305 fd = open("/dev/urandom", O_RDONLY);
2307 read(fd, block->buf, block->buf_len);
2310 uint32_t *p = (uint32_t *)block->buf;
2311 srandom(time(NULL));
2312 for (i=0; i<block->buf_len/sizeof(uint32_t); i++) {
2316 p = (uint32_t *)block->buf;
2317 Pmsg1(0, "Begin writing raw blocks of %u bytes.\n", block->buf_len);
2320 stat = write(dev->fd, block->buf, block->buf_len);
2321 if (stat == (int)block->buf_len) {
2322 if ((block_num++ % 100) == 0) {
2327 for (i=1; i<(block->buf_len-sizeof(uint32_t))/sizeof(uint32_t)-1; i++) {
2336 printf("Write failed at block %u. stat=%d ERR=%s\n", block_num, stat,
2337 strerror(my_errno));
2344 * Fill a tape using raw write() command
2346 static void bfill_cmd()
2349 uint32_t block_num = 0;
2355 block = new_block(dev);
2356 fd = open("/dev/urandom", O_RDONLY);
2358 read(fd, block->buf, block->buf_len);
2361 uint32_t *p = (uint32_t *)block->buf;
2362 srandom(time(NULL));
2363 for (i=0; i<block->buf_len/sizeof(uint32_t); i++) {
2367 p = (uint32_t *)block->buf;
2368 Pmsg1(0, "Begin writing Bacula blocks of %u bytes.\n", block->buf_len);
2371 block->binbuf = block->buf_len;
2372 block->bufp = block->buf + block->binbuf;
2373 if (!write_block_to_dev(jcr->dcr, block)) {
2376 if ((block_num++ % 100) == 0) {
2381 for (i=1; i<(block->buf_len/sizeof(uint32_t)-1); i++) {
2387 printf("Write failed at block %u.\n", block_num);
2393 struct cmdstruct { char *key; void (*func)(); char *help; };
2394 static struct cmdstruct commands[] = {
2395 {"autochanger", autochangercmd, "test autochanger"},
2396 {"bsf", bsfcmd, "backspace file"},
2397 {"bsr", bsrcmd, "backspace record"},
2398 {"bfill", bfill_cmd, "fill tape using Bacula writes"},
2399 {"cap", capcmd, "list device capabilities"},
2400 {"clear", clearcmd, "clear tape errors"},
2401 {"eod", eodcmd, "go to end of Bacula data for append"},
2402 {"eom", eomcmd, "go to the physical end of medium"},
2403 {"fill", fillcmd, "fill tape, write onto second volume"},
2404 {"unfill", unfillcmd, "read filled tape"},
2405 {"fsf", fsfcmd, "forward space a file"},
2406 {"fsr", fsrcmd, "forward space a record"},
2407 {"help", helpcmd, "print this command"},
2408 {"label", labelcmd, "write a Bacula label to the tape"},
2409 {"load", loadcmd, "load a tape"},
2410 {"quit", quitcmd, "quit btape"},
2411 {"rawfill", rawfill_cmd, "use write() to fill tape"},
2412 {"readlabel", readlabelcmd, "read and print the Bacula tape label"},
2413 {"rectest", rectestcmd, "test record handling functions"},
2414 {"rewind", rewindcmd, "rewind the tape"},
2415 {"scan", scancmd, "read() tape block by block to EOT and report"},
2416 {"scanblocks", scan_blocks, "Bacula read block by block to EOT and report"},
2417 {"status", statcmd, "print tape status"},
2418 {"test", testcmd, "General test Bacula tape functions"},
2419 {"weof", weofcmd, "write an EOF on the tape"},
2420 {"wr", wrcmd, "write a single Bacula block"},
2421 {"rr", rrcmd, "read a single record"},
2422 {"qfill", qfillcmd, "quick fill command"},
2424 #define comsize (sizeof(commands)/sizeof(struct cmdstruct))
2432 while (get_cmd("*")) {
2433 sm_check(__FILE__, __LINE__, false);
2435 parse_args(cmd, &args, &argc, argk, argv, MAX_CMD_ARGS);
2436 for (i=0; i<comsize; i++) /* search for command */
2437 if (argc > 0 && fstrsch(argk[0], commands[i].key)) {
2438 (*commands[i].func)(); /* go execute command */
2443 Pmsg1(0, _("%s is an illegal command\n"), cmd);
2449 static void helpcmd()
2453 printf(_("Interactive commands:\n"));
2454 printf(_(" Command Description\n ======= ===========\n"));
2455 for (i=0; i<comsize; i++)
2456 printf(" %-10s %s\n", commands[i].key, commands[i].help);
2463 "\nVersion: " VERSION " (" BDATE ")\n\n"
2464 "Usage: btape <options> <device_name>\n"
2465 " -b <file> specify bootstrap file\n"
2466 " -c <file> set configuration file to file\n"
2467 " -d <nn> set debug level to nn\n"
2468 " -p proceed inspite of I/O errors\n"
2469 " -s turn off signals\n"
2471 " -? print this message.\n"
2477 * Get next input command from terminal. This
2478 * routine is REALLY primitive, and should be enhanced
2479 * to have correct backspacing, etc.
2482 get_cmd(char *prompt)
2486 fprintf(stdout, prompt);
2488 /* We really should turn off echoing and pretty this
2492 while ((ch = fgetc(stdin)) != EOF) {
2494 strip_trailing_junk(cmd);
2496 } else if (ch == 4 || ch == 0xd3 || ch == 0x8) {
2509 /* Dummies to replace askdir.c */
2510 int dir_update_file_attributes(JCR *jcr, DEV_RECORD *rec) { return 1;}
2511 int dir_send_job_status(JCR *jcr) {return 1;}
2513 int dir_update_volume_info(JCR *jcr, DEVICE *dev, int relabel)
2519 int dir_get_volume_info(JCR *jcr, enum get_vol_info_rw writing)
2521 Dmsg0(20, "Enter dir_get_volume_info\n");
2522 bstrncpy(jcr->VolCatInfo.VolCatName, jcr->VolumeName, sizeof(jcr->VolCatInfo.VolCatName));
2526 int dir_create_jobmedia_record(JCR *jcr)
2528 jcr->dcr->WroteVol = false;
2533 int dir_find_next_appendable_volume(JCR *jcr)
2535 Dmsg1(20, "Enter dir_find_next_appendable_volume. stop=%d\n", stop);
2536 return jcr->VolumeName[0] != 0;
2539 int dir_ask_sysop_to_mount_volume(JCR *jcr, DEVICE *dev)
2541 Dmsg0(20, "Enter dir_ask_sysop_to_mount_volume\n");
2542 if (jcr->VolumeName[0] == 0) {
2543 return dir_ask_sysop_to_create_appendable_volume(jcr, dev);
2545 /* Close device so user can use autochanger if desired */
2546 if (dev_cap(dev, CAP_OFFLINEUNMOUNT)) {
2549 force_close_dev(dev);
2550 Pmsg1(-1, "%s", dev->errmsg); /* print reason */
2551 if (jcr->VolumeName[0] == 0 || strcmp(jcr->VolumeName, "TestVolume2") == 0) {
2552 fprintf(stderr, "Mount second Volume on device %s and press return when ready: ",
2555 fprintf(stderr, "Mount Volume \"%s\" on device %s and press return when ready: ",
2556 jcr->VolumeName, dev_name(dev));
2562 int dir_ask_sysop_to_create_appendable_volume(JCR *jcr, DEVICE *dev)
2565 Dmsg0(20, "Enter dir_ask_sysop_to_create_appendable_volume\n");
2567 set_volume_name("TestVolume1", 1);
2569 set_volume_name("TestVolume2", 2);
2571 /* Close device so user can use autochanger if desired */
2572 if (dev_cap(dev, CAP_OFFLINEUNMOUNT)) {
2575 autochanger = autoload_device(jcr, dev, 1, NULL);
2577 force_close_dev(dev);
2578 fprintf(stderr, "Mount blank Volume on device %s and press return when ready: ",
2582 open_device(jcr, dev);
2589 static int my_mount_next_read_volume(JCR *jcr, DEVICE *dev, DEV_BLOCK *block)
2593 Dmsg0(20, "Enter my_mount_next_read_volume\n");
2594 Pmsg1(000, "End of Volume \"%s\"\n", jcr->VolumeName);
2596 if (LastBlock != block->BlockNumber) {
2597 VolBytes += block->block_len;
2599 LastBlock = block->BlockNumber;
2601 now -= jcr->run_time;
2605 kbs = (double)VolBytes / (1000.0 * (double)now);
2606 Pmsg3(-1, "Read block=%u, VolBytes=%s rate=%.1f KB/s\n", block->BlockNumber,
2607 edit_uint64_with_commas(VolBytes, ec1), (float)kbs);
2609 if (strcmp(jcr->VolumeName, "TestVolume2") == 0) {
2615 set_volume_name("TestVolume2", 2);
2617 create_vol_list(jcr);
2619 dev->state &= ~ST_READ;
2620 if (!acquire_device_for_read(jcr)) {
2621 Pmsg2(0, "Cannot open Dev=%s, Vol=%s\n", dev_name(dev), jcr->VolumeName);
2624 return 1; /* next volume mounted */
2627 static void set_volume_name(char *VolName, int volnum)
2629 DCR *dcr = jcr->dcr;
2630 VolumeName = VolName;
2632 pm_strcpy(&jcr->VolumeName, VolName);
2633 bstrncpy(dev->VolCatInfo.VolCatName, VolName, sizeof(dev->VolCatInfo.VolCatName));
2634 bstrncpy(jcr->VolCatInfo.VolCatName, VolName, sizeof(jcr->VolCatInfo.VolCatName));
2635 bstrncpy(dcr->VolCatInfo.VolCatName, VolName, sizeof(dcr->VolCatInfo.VolCatName));
2636 bstrncpy(dcr->VolumeName, VolName, sizeof(dcr->VolumeName));
2637 jcr->VolCatInfo.Slot = volnum;
2638 dcr->VolCatInfo.Slot = volnum;
2643 * Edit codes into ChangerCommand
2645 * %a = archive device name
2646 * %c = changer device name
2647 * %f = Client's name
2655 * omsg = edited output message
2656 * imsg = input string containing edit codes (%x)
2657 * cmd = command string (load, unload, ...)
2660 static char *edit_device_codes(JCR *jcr, char *omsg, char *imsg, char *cmd)
2667 Dmsg1(400, "edit_device_codes: %s\n", imsg);
2668 for (p=imsg; *p; p++) {
2675 str = dev_name(jcr->device->dev);
2678 str = NPRT(jcr->device->changer_name);
2684 sprintf(add, "%d", jcr->VolCatInfo.Slot - 1);
2688 sprintf(add, "%d", jcr->VolCatInfo.Slot);
2691 case 'j': /* Job name */
2695 str = NPRT(jcr->VolumeName);
2698 str = NPRT(jcr->client_name);
2713 Dmsg1(400, "add_str %s\n", str);
2714 pm_strcat(&omsg, (char *)str);
2715 Dmsg1(400, "omsg=%s\n", omsg);
2723 * We are called here from "unfill" for each record on the tape.
2725 static int record_cb(JCR *jcr, DEVICE *dev, DEV_BLOCK *block, DEV_RECORD *rec)
2727 SESSION_LABEL label;
2729 if (stop > 1 && !dumped) { /* on second tape */
2732 dump_block(block, "First block on second tape");
2734 Pmsg4(-1, "Blk: FileIndex=%d: block=%u size=%d vol=%s\n",
2735 rec->FileIndex, block->BlockNumber, block->block_len, dev->VolHdr.VolName);
2736 Pmsg6(-1, " Rec: VId=%d VT=%d FI=%s Strm=%s len=%d state=%x\n",
2737 rec->VolSessionId, rec->VolSessionTime,
2738 FI_to_ascii(rec->FileIndex), stream_to_ascii(rec->Stream, rec->FileIndex),
2739 rec->data_len, rec->state);
2741 if (rec->FileIndex < 0) {
2743 dump_label_record(dev, rec, 1);
2745 switch (rec->FileIndex) {
2747 Pmsg0(-1, "Volume is prelabeled. This tape cannot be scanned.\n");
2750 unser_volume_label(dev, rec);
2751 Pmsg3(-1, "VOL_LABEL: block=%u size=%d vol=%s\n", block->BlockNumber,
2752 block->block_len, dev->VolHdr.VolName);
2756 unser_session_label(&label, rec);
2757 Pmsg1(-1, "SOS_LABEL: JobId=%u\n", label.JobId);
2760 unser_session_label(&label, rec);
2761 Pmsg2(-1, "EOS_LABEL: block=%u JobId=%u\n", block->BlockNumber,
2765 Pmsg0(-1, "EOM_LABEL:\n");
2767 case EOT_LABEL: /* end of all tapes */
2770 if (LastBlock != block->BlockNumber) {
2771 VolBytes += block->block_len;
2773 LastBlock = block->BlockNumber;
2775 now -= jcr->run_time;
2779 kbs = (double)VolBytes / (1000 * now);
2780 Pmsg3(000, "Read block=%u, VolBytes=%s rate=%.1f KB/s\n", block->BlockNumber,
2781 edit_uint64_with_commas(VolBytes, ec1), (float)kbs);
2783 Pmsg0(000, "End of all tapes.\n");
2791 if (++file_index != rec->FileIndex) {
2792 Pmsg3(000, "Incorrect FileIndex in Block %u. Got %d, expected %d.\n",
2793 block->BlockNumber, rec->FileIndex, file_index);
2795 if (LastBlock != block->BlockNumber) {
2796 VolBytes += block->block_len;
2798 if ((block->BlockNumber != LastBlock) && (block->BlockNumber % 50000) == 0) {
2801 now -= jcr->run_time;
2805 kbs = (double)VolBytes / (1000 * now);
2806 Pmsg3(000, "Read block=%u, VolBytes=%s rate=%.1f KB/s\n", block->BlockNumber,
2807 edit_uint64_with_commas(VolBytes, ec1), (float)kbs);
2809 LastBlock = block->BlockNumber;
2811 Pmsg1(000, "End of all blocks. Block=%u\n", block->BlockNumber);