This is the complete results of the btape fill test. Please see http://www.freebsddiary.org/digital-tl891.php for full details *rewind btape: btape.c:438 Rewound "DLT" (/dev/nsa0) *fill This command simulates Bacula writing to a tape. It requires either one or two blank tapes, which it will label and write. If you have an autochanger configured, it will use the tapes that are in slots 1 and 2, otherwise, you will be prompted to insert the tapes when necessary. It will print a status approximately every 322 MB, and write an EOF every 3.2 GB. If you have selected the simple test option, after writing the first tape it will rewind it and re-read the last block written. If you have selected the multiple tape test, when the first tape fills, it will ask for a second, and after writing a few more blocks, it will stop. Then it will begin re-reading the two tapes. This may take a long time -- hours! ... Do you want to run the simplified test (s) with one tape or the complete multiple tape (m) test: (s/m) m Multiple tape test selected. Wrote Volume label for volume "TestVolume1". Wrote Start of Session label. 15:01:52 Begin writing Bacula records to first tape ... Wrote blk_block=5000, dev_blk_num=986 VolBytes=63,608,832 rate=4240.6 KB/s Wrote blk_block=10000, dev_blk_num=5986 VolBytes=386,168,808 rate=4438.7 KB/s Wrote blk_block=15000, dev_blk_num=10986 VolBytes=708,728,752 rate=4374.9 KB/s Wrote blk_block=20000, dev_blk_num=486 VolBytes=1,031,288,704 rate=4407.2 KB/s Wrote blk_block=25000, dev_blk_num=5486 VolBytes=1,353,848,648 rate=4409.9 KB/s Wrote blk_block=30000, dev_blk_num=10486 VolBytes=1,676,408,592 rate=4446.7 KB/s 15:08:41 Flush block, write EOF Wrote blk_block=35000, dev_blk_num=3000 VolBytes=1,998,968,544 rate=4412.7 KB/s Wrote blk_block=40000, dev_blk_num=8000 VolBytes=2,321,528,488 rate=4438.9 KB/s Wrote blk_block=45000, dev_blk_num=13000 VolBytes=2,644,088,440 rate=4421.6 KB/s Wrote blk_block=50000, dev_blk_num=2500 VolBytes=2,966,648,384 rate=4427.8 KB/s Wrote blk_block=55000, dev_blk_num=7500 VolBytes=3,289,208,328 rate=4421.0 KB/s Wrote blk_block=60000, dev_blk_num=12500 VolBytes=3,611,768,280 rate=4415.4 KB/s 15:16:28 Flush block, write EOF Wrote blk_block=65000, dev_blk_num=1000 VolBytes=3,934,328,224 rate=4410.7 KB/s Wrote blk_block=70000, dev_blk_num=6000 VolBytes=4,256,888,176 rate=4406.7 KB/s Wrote blk_block=75000, dev_blk_num=11000 VolBytes=4,579,448,120 rate=4420.3 KB/s Wrote blk_block=80000, dev_blk_num=500 VolBytes=4,902,008,064 rate=4408.3 KB/s Wrote blk_block=85000, dev_blk_num=5500 VolBytes=5,224,568,016 rate=4420.1 KB/s Wrote blk_block=90000, dev_blk_num=10500 VolBytes=5,547,127,960 rate=4416.5 KB/s Wrote blk_block=95000, dev_blk_num=15500 VolBytes=5,869,687,912 rate=4430.0 KB/s 15:24:13 Flush block, write EOF Wrote blk_block=100000, dev_blk_num=4000 VolBytes=6,192,247,856 rate=4410.4 KB/s Wrote blk_block=105000, dev_blk_num=9000 VolBytes=6,514,807,800 rate=4407.9 KB/s Wrote blk_block=110000, dev_blk_num=14000 VolBytes=6,837,367,752 rate=4405.5 KB/s Wrote blk_block=115000, dev_blk_num=3500 VolBytes=7,159,927,696 rate=4408.8 KB/s Wrote blk_block=120000, dev_blk_num=8500 VolBytes=7,482,487,640 rate=4409.2 KB/s Wrote blk_block=125000, dev_blk_num=13500 VolBytes=7,805,047,592 rate=4407.1 KB/s 15:32:07 Flush block, write EOF Wrote blk_block=130000, dev_blk_num=2000 VolBytes=8,127,607,536 rate=4402.8 KB/s Wrote blk_block=135000, dev_blk_num=7000 VolBytes=8,450,167,488 rate=4401.1 KB/s Wrote blk_block=140000, dev_blk_num=12000 VolBytes=8,772,727,432 rate=4410.6 KB/s Wrote blk_block=145000, dev_blk_num=1500 VolBytes=9,095,287,376 rate=4404.5 KB/s Wrote blk_block=150000, dev_blk_num=6500 VolBytes=9,417,847,328 rate=4411.2 KB/s Wrote blk_block=155000, dev_blk_num=11500 VolBytes=9,740,407,272 rate=4409.4 KB/s Wrote blk_block=160000, dev_blk_num=1000 VolBytes=10,062,967,224 rate=4411.6 KB/s 15:39:53 Flush block, write EOF Wrote blk_block=165000, dev_blk_num=5000 VolBytes=10,385,527,168 rate=4406.2 KB/s Wrote blk_block=170000, dev_blk_num=10000 VolBytes=10,708,087,112 rate=4412.1 KB/s Wrote blk_block=175000, dev_blk_num=15000 VolBytes=11,030,647,064 rate=4410.5 KB/s Wrote blk_block=180000, dev_blk_num=4500 VolBytes=11,353,207,008 rate=4412.4 KB/s Wrote blk_block=185000, dev_blk_num=9500 VolBytes=11,675,766,952 rate=4410.9 KB/s Wrote blk_block=190000, dev_blk_num=14500 VolBytes=11,998,326,904 rate=4411.1 KB/s 15:47:43 Flush block, write EOF Wrote blk_block=195000, dev_blk_num=3000 VolBytes=12,320,886,848 rate=4408.2 KB/s Wrote blk_block=200000, dev_blk_num=8000 VolBytes=12,643,446,800 rate=4406.9 KB/s Wrote blk_block=205000, dev_blk_num=13000 VolBytes=12,966,006,744 rate=4413.2 KB/s Wrote blk_block=210000, dev_blk_num=2500 VolBytes=13,288,566,688 rate=4407.5 KB/s Wrote blk_block=215000, dev_blk_num=7500 VolBytes=13,611,126,640 rate=4413.5 KB/s Wrote blk_block=220000, dev_blk_num=12500 VolBytes=13,933,686,584 rate=4412.2 KB/s 15:55:28 Flush block, write EOF Wrote blk_block=225000, dev_blk_num=1000 VolBytes=14,256,246,536 rate=4411.0 KB/s Wrote blk_block=230000, dev_blk_num=6000 VolBytes=14,578,806,480 rate=4409.8 KB/s Wrote blk_block=235000, dev_blk_num=11000 VolBytes=14,901,366,424 rate=4413.9 KB/s Wrote blk_block=240000, dev_blk_num=500 VolBytes=15,223,926,376 rate=4410.2 KB/s Wrote blk_block=245000, dev_blk_num=5500 VolBytes=15,546,486,320 rate=4415.4 KB/s Wrote blk_block=250000, dev_blk_num=10500 VolBytes=15,869,046,264 rate=4413.0 KB/s Wrote blk_block=255000, dev_blk_num=15500 VolBytes=16,191,606,216 rate=4417.9 KB/s 16:03:18 Flush block, write EOF Wrote blk_block=260000, dev_blk_num=4000 VolBytes=16,514,166,160 rate=4410.8 KB/s Wrote blk_block=265000, dev_blk_num=9000 VolBytes=16,836,726,112 rate=4409.8 KB/s Wrote blk_block=270000, dev_blk_num=14000 VolBytes=17,159,286,056 rate=4414.5 KB/s Wrote blk_block=275000, dev_blk_num=3500 VolBytes=17,481,846,000 rate=4411.3 KB/s Wrote blk_block=280000, dev_blk_num=8500 VolBytes=17,804,405,952 rate=4414.7 KB/s Wrote blk_block=285000, dev_blk_num=13500 VolBytes=18,126,965,896 rate=4414.8 KB/s 16:11:02 Flush block, write EOF Wrote blk_block=290000, dev_blk_num=2000 VolBytes=18,449,525,848 rate=4412.7 KB/s Wrote blk_block=295000, dev_blk_num=7000 VolBytes=18,772,085,792 rate=4412.8 KB/s Wrote blk_block=300000, dev_blk_num=12000 VolBytes=19,094,645,736 rate=4417.0 KB/s Wrote blk_block=305000, dev_blk_num=1500 VolBytes=19,417,205,688 rate=4414.0 KB/s Wrote blk_block=310000, dev_blk_num=6500 VolBytes=19,739,765,632 rate=4417.0 KB/s Wrote blk_block=315000, dev_blk_num=11500 VolBytes=20,062,325,584 rate=4417.1 KB/s Wrote blk_block=320000, dev_blk_num=1000 VolBytes=20,384,885,528 rate=4418.1 KB/s 16:18:46 Flush block, write EOF Wrote blk_block=325000, dev_blk_num=5000 VolBytes=20,707,445,472 rate=4415.2 KB/s Wrote blk_block=330000, dev_blk_num=10000 VolBytes=21,030,005,424 rate=4419.0 KB/s Wrote blk_block=335000, dev_blk_num=15000 VolBytes=21,352,565,368 rate=4418.1 KB/s Wrote blk_block=340000, dev_blk_num=4500 VolBytes=21,675,125,312 rate=4415.4 KB/s Wrote blk_block=345000, dev_blk_num=9500 VolBytes=21,997,685,264 rate=4419.0 KB/s Wrote blk_block=350000, dev_blk_num=14500 VolBytes=22,320,245,208 rate=4418.1 KB/s 16:26:34 Flush block, write EOF Wrote blk_block=355000, dev_blk_num=3000 VolBytes=22,642,805,160 rate=4417.2 KB/s Wrote blk_block=360000, dev_blk_num=8000 VolBytes=22,965,365,104 rate=4417.3 KB/s Wrote blk_block=365000, dev_blk_num=13000 VolBytes=23,287,925,048 rate=4419.8 KB/s Wrote blk_block=370000, dev_blk_num=2500 VolBytes=23,610,485,000 rate=4417.3 KB/s Wrote blk_block=375000, dev_blk_num=7500 VolBytes=23,933,044,944 rate=4420.6 KB/s Wrote blk_block=380000, dev_blk_num=12500 VolBytes=24,255,604,896 rate=4419.8 KB/s 16:34:17 Flush block, write EOF Wrote blk_block=385000, dev_blk_num=1000 VolBytes=24,578,164,840 rate=4418.9 KB/s Wrote blk_block=390000, dev_blk_num=6000 VolBytes=24,900,724,784 rate=4418.9 KB/s Wrote blk_block=395000, dev_blk_num=11000 VolBytes=25,223,284,736 rate=4421.3 KB/s Wrote blk_block=400000, dev_blk_num=500 VolBytes=25,545,844,680 rate=4418.9 KB/s Wrote blk_block=405000, dev_blk_num=5500 VolBytes=25,868,404,624 rate=4418.9 KB/s Wrote blk_block=410000, dev_blk_num=10500 VolBytes=26,190,964,576 rate=4421.9 KB/s Wrote blk_block=415000, dev_blk_num=15500 VolBytes=26,513,524,520 rate=4421.1 KB/s 16:42:05 Flush block, write EOF Wrote blk_block=420000, dev_blk_num=4000 VolBytes=26,836,084,472 rate=4420.4 KB/s Wrote blk_block=425000, dev_blk_num=9000 VolBytes=27,158,644,416 rate=4419.6 KB/s Wrote blk_block=430000, dev_blk_num=14000 VolBytes=27,481,204,360 rate=4422.5 KB/s Wrote blk_block=435000, dev_blk_num=3500 VolBytes=27,803,764,312 rate=4420.3 KB/s Wrote blk_block=440000, dev_blk_num=8500 VolBytes=28,126,324,256 rate=4422.4 KB/s Wrote blk_block=445000, dev_blk_num=13500 VolBytes=28,448,884,208 rate=4422.3 KB/s 16:49:49 Flush block, write EOF Wrote blk_block=450000, dev_blk_num=2000 VolBytes=28,771,444,152 rate=4421.6 KB/s Wrote blk_block=455000, dev_blk_num=7000 VolBytes=29,094,004,096 rate=4420.9 KB/s Wrote blk_block=460000, dev_blk_num=12000 VolBytes=29,416,564,048 rate=4423.5 KB/s Wrote blk_block=465000, dev_blk_num=1500 VolBytes=29,739,123,992 rate=4421.5 KB/s Wrote blk_block=470000, dev_blk_num=6500 VolBytes=30,061,683,936 rate=4423.4 KB/s Wrote blk_block=475000, dev_blk_num=11500 VolBytes=30,384,243,888 rate=4423.4 KB/s Wrote blk_block=480000, dev_blk_num=1000 VolBytes=30,706,803,832 rate=4421.4 KB/s 16:57:37 Flush block, write EOF Wrote blk_block=485000, dev_blk_num=5000 VolBytes=31,029,363,784 rate=4422.0 KB/s 15-Feb 16:59 btape: End of Volume "TestVolume1" at 45:8218 on device "DLT" (/dev/nsa0). Write of 64512 bytes got 0. btape: btape.c:2301 Last block at: 45:8217 this_dev_block_num=8218 btape: btape.c:2335 End of tape 47:0. VolumeCapacity=31,236,963,360. Write rate = 4418.2 KB/s 15-Feb 16:59 btape: End of medium on Volume "TestVolume1" Bytes=31,236,963,360 Blocks=484,204 at 15-Feb-2006 16:59. 15-Feb 16:59 btape: ERROR in dev.c:1631 dev.c:1630 I/O function "MTREW" not supported on this device. Mount blank Volume on device "DLT" (/dev/nsa0) and press return when ready: Wrote Volume label for volume "TestVolume2". dev.c:1630 I/O function "MTREW" not supported on this device. Mount second Volume on device "DLT" (/dev/nsa0) and press return when ready: 15-Feb 19:14 btape: Wrote label to prelabeled Volume "TestVolume2" on device "DLT" (/dev/nsa0) 15-Feb 19:14 btape: New volume "TestVolume2" mounted on device "DLT" (/dev/nsa0) at 15-Feb-2006 19:14. Done writing ... Wrote End of Session label. Wrote state file last_block_num1=8217 last_block_num2=11 19:14:15 Done filling tapes at 0:13. Now beginning re-read of first tape ... Mount first tape. Press enter when ready: 15-Feb 19:16 btape: Ready to read from volume "TestVolume1" on device "DLT" (/dev/nsa0). Rewinding. Reading the first 10000 records from 0:0. 10000 records read now at 1:5084 Reposition from 1:5084 to 45:8217 Reading block 8217. The last block of the first tape matches. Mount second tape. Press enter when ready: 15-Feb 19:58 btape: Ready to read from volume "TestVolume2" on device "DLT" (/dev/nsa0). Reposition from 0:0 to 0:1 Reading block 1. The first block on the second tape matches. Reposition from 0:2 to 0:11 Reading block 11. The last block on the second tape matches. Test succeeded. *