Re: [Bacula-users] Bacula director crashes while labelling tapes with their barcodes.

Kern Sibbald Wed, 16 May 2018 00:31:18 -0700

The first and most obvious problem is that your Director and Storage daemons must both be *exactly* the same version.

Best regards,

Kern

On 05/15/2018 02:01 PM, Charles Nadeau wrote:

Hello!

I just got a used Dell TL2000 tape library to use with Bacula (9.0.4 for the director on Ubuntu 16.04, 9.0.6 for the storage director on Ubuntu 18.04).

I tested it with btape and mtx-changer and it passes all tests (strongly inspired by Dan Langille's https://dan.langille.org/2016/02/04/dell-tl4000-tape-library-running-btape-and-configuring-baculas-mtx-changer/).

Once defined/integrated in Bacula, I can't label the tapes, bacula-director crashes.

Here is what the session is at bconsole:

charles@bigzilla:/mnt/data/toburn/archive$ bconsole

Connecting to Director 192.168.0.53:9101

1000 OK: 103 bigzilla-dir Version: 9.0.4 (06 September 2017)

Enter a period to cancel a command.

*label barcodes

Automatically selected Catalog: MyCatalog

Using Catalog "MyCatalog"

The defined Storage resources are:

1: File3

2: TL2000

Select Storage resource (1-2): 2

Connecting to Storage daemon TL2000 at 192.168.0.17:9103 ...

Connecting to Storage daemon TL2000 at 192.168.0.17:9103 ...

3306 Issuing autochanger "slots" command.

Device "Autochanger" has 24 slots.

Connecting to Storage daemon TL2000 at 192.168.0.17:9103 ...

3301 Issuing autochanger "loaded? drive 0" command.

3302 Autochanger "loaded? drive 0", result: nothing loaded.

3306 Issuing autochanger "list" command.

The following Volumes will be labeled:

Slot Volume

==============

1 000151L3

2 000133L3

3 000128L3

4 000126L3

5 000122L3

6 000125L3

7 000124L3

8 000137L3

9 000129L3

10 000134L3

11 000131L3

12 000140L3

14 000153L3

15 000152L3

16 000132L3

17 000121L3

18 000127L3

19 000130L3

Do you want to label these Volumes? (yes|no): yes

Defined Pools:

1: Default

2: Default3

3: DefaultTape

4: Differential-File3

5: Differential-Tape

6: File

7: Full-File3

8: Full-Tape

9: Incremental-File3

10: Incremental-Tape

11: Photo-File

12: Scratch

Select the Pool (1-12): 12

Here are some details of my configuration:

charles@superbackup:/etc/bacula$ sudo lsscsi -g

[sudo] password for charles:

[3:0:0:0] disk ATA WDC WD20EARS-00M AB51 /dev/sda /dev/sg0

[7:0:0:0] cd/dvd HL-DT-ST DVDRAM GSA-H62L DL00 /dev/sr0 /dev/sg1

[8:0:0:0] disk ATA WDC WD20EARS-00M AB51 /dev/sdb /dev/sg2

[9:0:0:0] disk ATA WDC WD20EARX-00P AB51 /dev/sdc /dev/sg3

[10:0:0:0] disk ATA WDC WD20EARX-008 AB51 /dev/sdd /dev/sg4

[14:0:0:0] tape IBM ULT3580-TD3 73P5 /dev/st0 /dev/sg7

[14:0:0:1] mediumx IBM 3573-TL 8.40 /dev/sch0 /dev/sg8

[15:0:0:0] disk ATA WDC WD20EFRX-68E 0A82 /dev/sde /dev/sg5

[16:0:0:0] disk ATA WDC WD20EARS-00M AB51 /dev/sdf /dev/sg6

charles@superbackup:~$ sudo tapeinfo -f /dev/sg7

Product Type: Tape Drive

Vendor ID: 'IBM '

Product ID: 'ULT3580-TD3 '

Revision: '73P5'

Attached Changer API: No

SerialNumber: '1210306523'

MinBlock: 1

MaxBlock: 16777215

SCSI ID: 0

SCSI LUN: 0

Ready: no

Here is the relevant part of my bacula-sd.conf:

Autochanger {

Name = Autochanger

Device = Drive-1

Changer Command = "/etc/bacula/scripts/mtx-changer %c %o %S %a %d"

Changer Device = /dev/sg8

}

Device {

Name = Drive-1

Media Type = LTO-3

Device Type = Tape

Archive Device = /dev/nst0

AutomaticMount = yes # when device opened, read it

AlwaysOpen = yes

RemovableMedia = yes

RandomAccess = no

AutoChanger = yes

Drive Index = 0

# Enable the Alert command only if you have the mtx package loaded

Alert Command = "sh -c 'tapeinfo -f %c |grep TapeAlert|cat'"

# If you have smartctl, enable this, it has more info than tapeinfo

# Alert Command = "sh -c 'smartctl -H -l error %c'"

Maximum Spool Size = 1024GB

Maximum Job Spool Size = 800GB

Spool Directory = /baculatmp

Maximum Concurrent Jobs = 1

Maximum Block Size = 1024K

Maximum File Size = 8GB

Hardware End of Medium = no

Fast Forward Space File = yes

}

And the relevant part of my bacula-dir.conf

Storage {

Name = TL2000

Address = 192.168.0.17

SDPort = 9103

Password = "xxxxxxxxxxxxxxxxxxxxxxxxxxx"

Device = Autochanger

Media Type = LTO-3

Maximum Concurrent Jobs = 1

Autochanger = yes

AllowCompression = yes

}

To further investigate the issue, I started bacula-sd and bacula-dir manually in debug mode and captured below the messages it printed to the console:

Messages generated by "sudo /usr/sbin/bacula-dir -d 999 -v -c /etc/bacula/bacula-dir.conf -f -m"

bigzilla-dir: msgchan.c:120-0 Connect to Storage daemon 192.168.0.17:9103

bigzilla-dir: watchdog.c:197-0 Registered watchdog 7f0ec801cf08, interval 1800 one shot

bigzilla-dir: btimers.c:145-0 Start thread timer 7f0ec8021ab8 tid 7f0ed5d27700 for 1800 secs.

bigzilla-dir: bsock.c:237-0 Current 192.168.0.17:9103 All 192.168.0.17:9103

bigzilla-dir: bsock.c:166-0 who=Storage daemon host=192.168.0.17 port=9103

bigzilla-dir: bsock.c:349-0 OK connected to server Storage daemon 192.168.0.17:9103.

bigzilla-dir: btimers.c:203-0 Stop thread timer 7f0ec8021ab8 tid=7f0ed5d27700.

bigzilla-dir: watchdog.c:217-0 Unregistered watchdog 7f0ec801cf08

bigzilla-dir: watchdog.c:197-0 Registered watchdog 7f0ec801cf08, interval 600 one shot

bigzilla-dir: btimers.c:177-0 Start bsock timer 7f0ec8021ab8 tid=7f0ed5d27700 for 600 secs at 1526381821

bigzilla-dir: cram-md5.c:133-0 cram-get received: auth cram-md5 <651658768.1526381820@superbackup-sd> ssl=0

bigzilla-dir: cram-md5.c:157-0 sending resp to challenge: 5/+lrGpO76+YPR++Eh/AlC

bigzilla-dir: cram-md5.c:76-0 send: auth cram-md5 challenge <435475706.1526381821@bigzilla-dir> ssl=0

bigzilla-dir: cram-md5.c:95-0 Authenticate OK fz+CUyMWb4+Zh5wwHV/n6C

bigzilla-dir: authenticate.c:155-0 >stored: 1000 OK auth

bigzilla-dir: authenticate.c:162-0 <stored: 3000 OK Hello 306

bigzilla-dir: btimers.c:190-0 Stop bsock timer 7f0ec8021ab8 tid=7f0ed5d27700 at 1526381821.

bigzilla-dir: watchdog.c:217-0 Unregistered watchdog 7f0ec801cf08

bigzilla-dir: ua_label.c:868-0 Add slot=1 Vol=000151L3 to SD list.

bigzilla-dir: ua_label.c:868-0 Add slot=2 Vol=000133L3 to SD list.

bigzilla-dir: ua_label.c:868-0 Add slot=3 Vol=000128L3 to SD list.

bigzilla-dir: ua_label.c:868-0 Add slot=4 Vol=000126L3 to SD list.

bigzilla-dir: ua_label.c:868-0 Add slot=5 Vol=000122L3 to SD list.

bigzilla-dir: ua_label.c:868-0 Add slot=6 Vol=000125L3 to SD list.

bigzilla-dir: ua_label.c:868-0 Add slot=7 Vol=000124L3 to SD list.

bigzilla-dir: ua_label.c:868-0 Add slot=8 Vol=000137L3 to SD list.

bigzilla-dir: ua_label.c:868-0 Add slot=9 Vol=000129L3 to SD list.

bigzilla-dir: ua_label.c:868-0 Add slot=10 Vol=000134L3 to SD list.

bigzilla-dir: ua_label.c:868-0 Add slot=11 Vol=000131L3 to SD list.

bigzilla-dir: ua_label.c:868-0 Add slot=12 Vol=000140L3 to SD list.

bigzilla-dir: ua_label.c:868-0 Add slot=14 Vol=000153L3 to SD list.

bigzilla-dir: ua_label.c:868-0 Add slot=15 Vol=000152L3 to SD list.

bigzilla-dir: ua_label.c:868-0 Add slot=16 Vol=000132L3 to SD list.

bigzilla-dir: ua_label.c:868-0 Add slot=17 Vol=000121L3 to SD list.

bigzilla-dir: ua_label.c:868-0 Add slot=18 Vol=000127L3 to SD list.

bigzilla-dir: ua_label.c:868-0 Add slot=19 Vol=000130L3 to SD list.

bigzilla-dir: sql_get.c:666-0 Actual NumVols=0 Pool NumVols=0

bigzilla-dir: sql_get.c:666-0 Actual NumVols=0 Pool NumVols=0

bigzilla-dir: sql_get.c:666-0 Actual NumVols=0 Pool NumVols=0

bigzilla-dir: sql_get.c:666-0 Actual NumVols=46 Pool NumVols=46

bigzilla-dir: sql_get.c:666-0 Actual NumVols=0 Pool NumVols=0

bigzilla-dir: sql_get.c:666-0 Actual NumVols=0 Pool NumVols=0

bigzilla-dir: sql_get.c:666-0 Actual NumVols=282 Pool NumVols=282

bigzilla-dir: sql_get.c:666-0 Actual NumVols=0 Pool NumVols=0

bigzilla-dir: sql_get.c:666-0 Actual NumVols=118 Pool NumVols=118

bigzilla-dir: sql_get.c:666-0 Actual NumVols=0 Pool NumVols=0

bigzilla-dir: sql_get.c:666-0 Actual NumVols=62 Pool NumVols=62

bigzilla-dir: sql_get.c:666-0 Actual NumVols=23 Pool NumVols=23

bigzilla-dir: sql_get.c:666-0 Actual NumVols=23 Pool NumVols=23

bigzilla-dir: signal.c:125-0 sig=11 Segmentation violation

Bacula interrupted by signal 11: Segmentation violation

Kaboom! bacula-dir, bigzilla-dir got signal 11 - Segmentation violation at 15-May-2018 12:57:09. Attempting traceback.

Kaboom! exepath=/usr/sbin/

bigzilla-dir: signal.c:201-0 Working=/var/lib/bacula

bigzilla-dir: signal.c:202-0 btpath=/usr/sbin/btraceback

bigzilla-dir: signal.c:203-0 exepath=/usr/sbin/bacula-dir

bigzilla-dir: signal.c:232-0 Doing waitpid

Calling: /usr/sbin/btraceback /usr/sbin/bacula-dir 22819 /var/lib/bacula

bsmtp: bsmtp.c:488-0 Failed to connect to mailhost localhost

bigzilla-dir: signal.c:125-0 sig=17 Child status has changed

bigzilla-dir: signal.c:234-0 Done waitpid

The btraceback call returned 1

LockDump: /var/lib/bacula/bacula.22819.traceback

bigzilla-dir: lockmgr.c:1179-0 lockmgr disabled

==== Traceback output ====

[New LWP 22820]

[New LWP 22821]

[New LWP 22824]

[Thread debugging using libthread_db enabled]

Using host libthread_db library "/lib/x86_64-linux-gnu/libthread_db.so.1".

0x00007f0edd7eec1d in nanosleep () at ../sysdeps/unix/syscall-template.S:84

84 ../sysdeps/unix/syscall-template.S: No such file or directory.

$1 = 1294808369

$2 = 2053597538

$3 = 21733992

$4 = 21734056

$5 = 0

$6 = 1953722192

$7 = -576371987

$8 = -576372020

$9 = -576372027

$10 = -576371993

$11 = 2053597538

$12 = -576372000

Environment variable "TestName" not defined.

#0 0x00007f0edd7eec1d in nanosleep () at ../sysdeps/unix/syscall-template.S:84

#1 0x00007f0edda12817 in bmicrosleep(int, int) () from /usr/lib/bacula/libbac-9.0.4.so

#2 0x0000000000438814 in ?? ()

#3 0x000000000040de97 in ?? ()

#4 0x00007f0edd0b2830 in __libc_start_main (main=0x40d8b0, argc=8, argv=0x7fffa7fb79f8, init=<optimized out>, fini=<optimized out>, rtld_fini=<optimized out>, stack_end=0x7fffa7fb79e8) at ../csu/libc-start.c:291

#5 0x000000000040e729 in ?? ()

Thread 4 (Thread 0x7f0ed5d27700 (LWP 22824)):

#0 0x00007f0edd7eef7b in __waitpid (pid=22892, stat_loc=0x7f0ed5d253ec, options=0) at ../sysdeps/unix/sysv/linux/waitpid.c:29

#1 0x00007f0edda3dc28 in signal_handler () from /usr/lib/bacula/libbac-9.0.4.so

#2 <signal handler called>

#3 strlen () at ../sysdeps/x86_64/strlen.S:106

#4 0x0000000000445e83 in ?? ()

#5 0x000000000043ad55 in ?? ()

#6 0x000000000045c057 in ?? ()

#7 0x00007f0edda485fb in workq_server () from /usr/lib/bacula/libbac-9.0.4.so

#8 0x00007f0edd7e56ba in start_thread (arg=0x7f0ed5d27700) at pthread_create.c:333

#9 0x00007f0edd19941d in clone () at ../sysdeps/unix/sysv/linux/x86_64/clone.S:109

Thread 3 (Thread 0x7f0ed6528700 (LWP 22821)):

#0 pthread_cond_timedwait@@GLIBC_2.3.2 () at ../sysdeps/unix/sysv/linux/x86_64/pthread_cond_timedwait.S:225

#1 0x00007f0edda47cb4 in watchdog_thread () from /usr/lib/bacula/libbac-9.0.4.so

#2 0x00007f0edd7e56ba in start_thread (arg=0x7f0ed6528700) at pthread_create.c:333

#3 0x00007f0edd19941d in clone () at ../sysdeps/unix/sysv/linux/x86_64/clone.S:109

Thread 2 (Thread 0x7f0ed6d29700 (LWP 22820)):

#0 0x00007f0edd18f5d3 in select () at ../sysdeps/unix/syscall-template.S:84

#1 0x00007f0edda163b8 in bnet_thread_server(dlist*, int, workq_tag*, void* (*)(void*)) () from /usr/lib/bacula/libbac-9.0.4.so

#2 0x000000000045bc0c in ?? ()

#3 0x00007f0edd7e56ba in start_thread (arg=0x7f0ed6d29700) at pthread_create.c:333

#4 0x00007f0edd19941d in clone () at ../sysdeps/unix/sysv/linux/x86_64/clone.S:109

Thread 1 (Thread 0x7f0ede6b8740 (LWP 22819)):

#0 0x00007f0edd7eec1d in nanosleep () at ../sysdeps/unix/syscall-template.S:84

#1 0x00007f0edda12817 in bmicrosleep(int, int) () from /usr/lib/bacula/libbac-9.0.4.so

#2 0x0000000000438814 in ?? ()

#3 0x000000000040de97 in ?? ()

#4 0x00007f0edd0b2830 in __libc_start_main (main=0x40d8b0, argc=8, argv=0x7fffa7fb79f8, init=<optimized out>, fini=<optimized out>, rtld_fini=<optimized out>, stack_end=0x7fffa7fb79e8) at ../csu/libc-start.c:291

#5 0x000000000040e729 in ?? ()

#0 0x00007f0edd7eec1d in nanosleep () at ../sysdeps/unix/syscall-template.S:84

84 in ../sysdeps/unix/syscall-template.S

No locals.

#1 0x00007f0edda12817 in bmicrosleep(int, int) () from /usr/lib/bacula/libbac-9.0.4.so

No symbol table info available.

#2 0x0000000000438814 in ?? ()

No symbol table info available.

#3 0x000000000040de97 in ?? ()

No symbol table info available.

#4 0x00007f0edd0b2830 in __libc_start_main (main=0x40d8b0, argc=8, argv=0x7fffa7fb79f8, init=<optimized out>, fini=<optimized out>, rtld_fini=<optimized out>, stack_end=0x7fffa7fb79e8) at ../csu/libc-start.c:291

291 ../csu/libc-start.c: No such file or directory.

result = <optimized out>

unwind_buf = {cancel_jmp_buf = {{jmp_buf = {0, 8966355806345791312, 4253440, 140736011663856, 0, 0, -8966198045079206064, -9046782211473242288}, mask_was_saved = 0}}, priv = {pad = {0x0, 0x0, 0x8, 0x40d8b0}, data = "" = 0x0, cleanup = 0x0, canceltype = 8}}}

not_first_call = <optimized out>

#5 0x000000000040e729 in ?? ()

No symbol table info available.

#0 0x0000000000000000 in ?? ()

No symbol table info available.

#0 0x0000000000000000 in ?? ()

No symbol table info available.

Attempt to dump current JCRs. njcrs=2

threadid=0x7f0ede6b8740 JobId=0 JobStatus=R jcr=0x150ba08 name=*JobMonitor*.2018-05-15_12.56.49_01

use_count=1 killable=0

JobType=I JobLevel=

sched_time=15-May-2018 12:56 start_time=15-May-2018 12:56

end_time=01-Jan-1970 01:00 wait_time=01-Jan-1970 01:00

db=(nil) db_batch=(nil) batch_started=0

wstore=0x14d0d68 rstore=(nil) wjcr=(nil) client=0x14c9ff8 reschedule_count=0 SD_msg_chan_started=0

threadid=0x7f0ed5d27700 JobId=0 JobStatus=R jcr=0x7f0ec80008e8 name=-Console-.2018-05-15_12.56.53_02

use_count=1 killable=0

JobType=U JobLevel=

sched_time=15-May-2018 12:56 start_time=15-May-2018 12:56

end_time=01-Jan-1970 01:00 wait_time=01-Jan-1970 01:00

db=0x7f0ec80031d8 db_batch=(nil) batch_started=0

wstore=0x14d12c8 rstore=(nil) wjcr=(nil) client=0x14c9ff8 reschedule_count=0 SD_msg_chan_started=0

BDB=0x7f0ec80031d8 db_name=bacula db_user=bacula connected=true

cmd="SELECT MediaId,VolumeName,VolJobs,VolFiles,VolBlocks,VolBytes,VolABytes,VolHoleBytes,VolHoles,VolMounts,VolErrors,VolWrites,MaxVolBytes,VolCapacityBytes,MediaType,VolStatus,PoolId,VolRetention,VolUseDuration,MaxVolJobs,MaxVolFiles,Recycle,Slot,FirstWritten,LastWritten,InChanger,EndFile,EndBlock,VolType,VolParts,VolCloudParts,LastPartBytes,LabelType,LabelDate,StorageId,Enabled,LocationId,RecycleCount,InitialWrite,ScratchPoolId,RecyclePoolId,VolReadTime,VolWriteTime,ActionOnPurge,CacheRetention FROM Media WHERE VolumeName='000151L3'" changes=0

RWLOCK=0x7f0ec80031f0 w_active=0 w_wait=0

List plugins. Hook count=0

bigzilla-dir: signal.c:125-0 sig=17 Child status has changed

==== End traceback output ====

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 1048 bytes at 14c09a8 from postgresql.c:83

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 280 bytes at 14ef858 from jcr.c:388

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 1048 bytes at 14f0908 from postgresql.c:81

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 280 bytes at 14f0d58 from jcr.c:384

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 432 bytes at 7f0ed00008e8 from bnet.c:570

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 4120 bytes at 7f0ed0000ad8 from bnet.c:579

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 4120 bytes at 7f0ed0001b28 from bnet.c:580

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 536 bytes at 7f0ed0002b78 from bnet.c:581

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 7 bytes at 7f0ed0002dc8 from bnet.c:582

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 13 bytes at 7f0ed0002e08 from bnet.c:583

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 16 bytes at 7f0ed0002e48 from workq.c:198

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 24 bytes at 7f0ec8001488 from jcr.c:372

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 536 bytes at 7f0ec80014d8 from jcr.c:386

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 280 bytes at 7f0ec8001728 from jcr.c:390

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 280 bytes at 7f0ec8001878 from job.c:1568

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 280 bytes at 7f0ec80019c8 from job.c:1571

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 536 bytes at 7f0ec8001b18 from job.c:1574

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 536 bytes at 7f0ec8001d68 from job.c:1577

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 536 bytes at 7f0ec8001fb8 from job.c:1580

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 536 bytes at 7f0ec8002338 from job.c:1764

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 154 bytes at 7f0ec8002588 from job.c:1593

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 6 bytes at 7f0ec8002208 from ua_server.c:93

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 776 bytes at 7f0ec8002658 from ua_server.c:185

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 280 bytes at 7f0ec8002998 from ua_server.c:189

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 280 bytes at 7f0ec8002ae8 from ua_server.c:190

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 280 bytes at 7f0ec8002c38 from ua_server.c:191

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 536 bytes at 7f0ec8002dc8 from dird_conf.h:381

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 584 bytes at 7f0ec80031d8 from postgresql.c:137

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 536 bytes at 7f0ec8003458 from sql.c:173

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 536 bytes at 7f0ec80036a8 from sql.c:174

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 24 bytes at 7f0ec80038f8 from postgresql.c:75

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 11 bytes at 7f0ec8002d88 from postgresql.c:79

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 280 bytes at 7f0ec8003948 from postgresql.c:84

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 280 bytes at 7f0ec8003a98 from postgresql.c:87

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 280 bytes at 7f0ec8003be8 from postgresql.c:88

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 280 bytes at 7f0ec8003d38 from postgresql.c:89

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 280 bytes at 7f0ec8003e88 from postgresql.c:90

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 280 bytes at 7f0ec8003fd8 from postgresql.c:91

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 280 bytes at 7f0ec8004128 from postgresql.c:97

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 7 bytes at 7f0ec8003198 from postgresql.c:141

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 7 bytes at 7f0ec8004278 from postgresql.c:142

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 9 bytes at 7f0ec80042b8 from postgresql.c:144

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 10 bytes at 7f0ec80042f8 from postgresql.c:147

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 7 bytes at 7f0ec8004338 from postgresql.c:155

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 32 bytes at 7f0ec8002248 from job.c:1787

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 80 bytes at 7f0ec8020fe8 from alist.c:55

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 25 bytes at 7f0ec800cb98 from ua_label.c:523

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 24 bytes at 7f0ec80211f8 from ua_label.c:858

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 9 bytes at 7f0ec8020638 from ua_label.c:864

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 24 bytes at 7f0ec8021848 from ua_label.c:858

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 9 bytes at 7f0ec8021568 from ua_label.c:864

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 24 bytes at 7f0ec801f828 from ua_label.c:858

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 9 bytes at 7f0ec8003138 from ua_label.c:864

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 24 bytes at 7f0ec80209e8 from ua_label.c:858

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 9 bytes at 7f0ec8021b88 from ua_label.c:864

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 24 bytes at 7f0ec8021bc8 from ua_label.c:858

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 9 bytes at 7f0ec80022a8 from ua_label.c:864

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 24 bytes at 7f0ec80022e8 from ua_label.c:858

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 9 bytes at 7f0ec8020db8 from ua_label.c:864

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 24 bytes at 7f0ec8020df8 from ua_label.c:858

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 9 bytes at 7f0ec80210b8 from ua_label.c:864

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 24 bytes at 7f0ec80210f8 from ua_label.c:858

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 9 bytes at 7f0ec801f8c8 from ua_label.c:864

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 24 bytes at 7f0ec801f908 from ua_label.c:858

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 9 bytes at 7f0ec801f478 from ua_label.c:864

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 24 bytes at 7f0ec801f4b8 from ua_label.c:858

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 9 bytes at 7f0ec801f508 from ua_label.c:864

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 24 bytes at 7f0ec801f548 from ua_label.c:858

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 9 bytes at 7f0ec801f598 from ua_label.c:864

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 24 bytes at 7f0ec801ea08 from ua_label.c:858

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 9 bytes at 7f0ec801ea58 from ua_label.c:864

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 24 bytes at 7f0ec801ea98 from ua_label.c:858

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 9 bytes at 7f0ec801eae8 from ua_label.c:864

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 24 bytes at 7f0ec801eb28 from ua_label.c:858

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 9 bytes at 7f0ec801eb78 from ua_label.c:864

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 24 bytes at 7f0ec801ebb8 from ua_label.c:858

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 9 bytes at 7f0ec801ec08 from ua_label.c:864

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 24 bytes at 7f0ec801ec48 from ua_label.c:858

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 9 bytes at 7f0ec801ec98 from ua_label.c:864

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 24 bytes at 7f0ec801ecd8 from ua_label.c:858

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 9 bytes at 7f0ec801ed28 from ua_label.c:864

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 24 bytes at 7f0ec801ed68 from ua_label.c:858

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 9 bytes at 7f0ec801edb8 from ua_label.c:864

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 160 bytes at 7f0ec801d4f8 from bsys.c:388

bigzilla-dir: smartall.c:400-0 Orphaned buffer: bigzilla-dir 160 bytes at 7f0ec801edf8 from bsys.c:388

Messages generated by "sudo /usr/sbin/bacula-sd -d 999 -v -c /etc/bacula/bacula-sd.conf -f"

superbackup-sd: bnet.c:569-0 socket=4 who=client host=192.168.0.53 port=9103

superbackup-sd: dircmd.c:188-0 Got a DIR connection at 15-mai-2018 12:56:59

superbackup-sd: jcr.c:931-0 set_jcr_job_status(0, C)

superbackup-sd: jcr.c:940-0 OnEntry JobStatus=0 newJobstatus=C

superbackup-sd: jcr.c:951-0 Set new stat. old: 0,0 new: C,0

superbackup-sd: jcr.c:956-0 leave setJobStatus old=0 new=C

superbackup-sd: watchdog.c:197-0 Registered watchdog 7f10bc0012e8, interval 600 one shot

superbackup-sd: btimers.c:177-0 Start bsock timer 7f10bc001278 tid=7f10c3fff700 for 600 secs at 1526381819

superbackup-sd: cram-md5.c:69-0 send: auth cram-md5 challenge <1260624335.1526381819@superbackup-sd> ssl=0

superbackup-sd: cram-md5.c:133-0 cram-get received: auth cram-md5 <636874980.1526381820@bigzilla-dir> ssl=0

superbackup-sd: cram-md5.c:157-0 sending resp to challenge: bWw7W/hBp+M6m9+KeU+iUA

superbackup-sd: btimers.c:190-0 Stop bsock timer 7f10bc001278 tid=7f10c3fff700 at 1526381819.

superbackup-sd: watchdog.c:217-0 Unregistered watchdog 7f10bc0012e8

superbackup-sd: dircmd.c:214-0 Message channel init completed.

superbackup-sd: dircmd.c:225-0 <dird: autochanger slots Autochanger

superbackup-sd: dircmd.c:239-0 Do command: autochanger

superbackup-sd: dircmd.c:1107-0 Try changer device Drive-1

superbackup-sd: dircmd.c:1127-0 Found changer device Drive-1

superbackup-sd: dircmd.c:1140-0 Found device Drive-1

superbackup-sd: block_util.c:167-0 Rechdr len=1048576 max_items=52428

superbackup-sd: block_util.c:286-0 empty_block: adata=0 len=1048576 set binbuf=24

superbackup-sd: block_util.c:170-0 New block adata=0 len=1048576 block=7f10bc001980

superbackup-sd: acquire.c:658-0 Attach 0xbc001368 to dev "Drive-1" (/dev/nst0)

superbackup-sd: acquire.c:704-0 JobId=0 enter attach_dcr_to_dev

superbackup-sd: lock.c:159-0 Lock Drive-1 from dircmd.c:1755 precnt=0

superbackup-sd: autochanger.c:328-0 Locking changer Autochanger

superbackup-sd: autochanger.c:804-0 omsg=/etc/bacula/scripts/mtx-changer /dev/sg8 slots 0 /dev/nst0 0

superbackup-sd: watchdog.c:197-0 Registered watchdog 7f10bc0012e8, interval 300

superbackup-sd: btimers.c:67-0 Start child timer 7f10bc201e48, pid 30185 for 300 secs.

superbackup-sd: autochanger.c:695-0 <stored: slots=24

superbackup-sd: bpipe.c:273-0 Wait for 30185 opt=1

superbackup-sd: bpipe.c:285-0 Got wpid=0 status=0 ERR=none

superbackup-sd: bpipe.c:285-0 Got wpid=0 status=0 ERR=none

superbackup-sd: signal.c:125-0 sig=17 Child status has changed

superbackup-sd: bnet.c:569-0 socket=6 who=client host=192.168.0.53 port=9103

superbackup-sd: dircmd.c:188-0 Got a DIR connection at 15-mai-2018 12:57:00

superbackup-sd: jcr.c:931-0 set_jcr_job_status(0, C)

superbackup-sd: jcr.c:940-0 OnEntry JobStatus=0 newJobstatus=C

superbackup-sd: jcr.c:951-0 Set new stat. old: 0,0 new: C,0

superbackup-sd: jcr.c:956-0 leave setJobStatus old=0 new=C

superbackup-sd: watchdog.c:197-0 Registered watchdog 7f10b4001a28, interval 600 one shot

superbackup-sd: btimers.c:177-0 Start bsock timer 7f10b40019b8 tid=7f10c37fe700 for 600 secs at 1526381820

superbackup-sd: cram-md5.c:69-0 send: auth cram-md5 challenge <651658768.1526381820@superbackup-sd> ssl=0

superbackup-sd: cram-md5.c:133-0 cram-get received: auth cram-md5 <435475706.1526381821@bigzilla-dir> ssl=0

superbackup-sd: cram-md5.c:157-0 sending resp to challenge: fz+CUyMWb4+Zh5wwHV/n6C

superbackup-sd: btimers.c:190-0 Stop bsock timer 7f10b40019b8 tid=7f10c37fe700 at 1526381820.

superbackup-sd: watchdog.c:217-0 Unregistered watchdog 7f10b4001a28

superbackup-sd: dircmd.c:214-0 Message channel init completed.

superbackup-sd: dircmd.c:225-0 <dird: autochanger list Autochanger

superbackup-sd: dircmd.c:239-0 Do command: autochanger

superbackup-sd: dircmd.c:1107-0 Try changer device Drive-1

superbackup-sd: dircmd.c:1127-0 Found changer device Drive-1

superbackup-sd: dircmd.c:1140-0 Found device Drive-1

superbackup-sd: block_util.c:167-0 Rechdr len=1048576 max_items=52428

superbackup-sd: block_util.c:286-0 empty_block: adata=0 len=1048576 set binbuf=24

superbackup-sd: block_util.c:170-0 New block adata=0 len=1048576 block=7f10b4002190

superbackup-sd: acquire.c:658-0 Attach 0xb4001b78 to dev "Drive-1" (/dev/nst0)

superbackup-sd: acquire.c:704-0 JobId=0 enter attach_dcr_to_dev

superbackup-sd: lock.c:159-0 Lock Drive-1 from dircmd.c:1755 precnt=1

superbackup-sd: bpipe.c:273-0 Wait for 30185 opt=1

superbackup-sd: bpipe.c:281-0 Got break wpid=30185 status=0 ERR=none

superbackup-sd: bpipe.c:302-0 child status=0

superbackup-sd: btimers.c:79-0 Stop child timer 7f10bc201e48 pid 30185

superbackup-sd: watchdog.c:217-0 Unregistered watchdog 7f10bc0012e8

superbackup-sd: bpipe.c:317-0 returning stat=0,0

superbackup-sd: autochanger.c:342-0 Unlocking changer Autochanger

superbackup-sd: lock.c:169-0 Unlock Drive-1 from dircmd.c:1767 postcnt=0

superbackup-sd: acquire.c:722-0 Enter detach_dcr_from_dev

superbackup-sd: lock.c:159-0 Lock Drive-1 from acquire.c:724 precnt=0

superbackup-sd: lock.c:169-0 Unlock Drive-1 from acquire.c:745 postcnt=0

superbackup-sd: block_util.c:254-0 free_block buffer=7f10bc001a60

superbackup-sd: block_util.c:261-0 === free_block block 7f10bc001980

superbackup-sd: record_util.c:277-0 Enter free_record.

superbackup-sd: record_util.c:281-0 Data buf is freed.

superbackup-sd: record_util.c:283-0 Leave free_record.

superbackup-sd: sd_plugins.c:102-0 No b_plugin_list: generate_plugin_event ignored.

superbackup-sd: message.c:561-0 Close_msg jcr=7f10bc000b48

superbackup-sd: job.c:323-0 End Job JobId=0 7f10bc000b48

superbackup-sd: job.c:331-0 Send terminate jid=0 7f10bc000b48

superbackup-sd: message.c:561-0 Close_msg jcr=0

superbackup-sd: message.c:586-0 ===Begin close msg resource at 55acdc932228

superbackup-sd: message.c:675-0 Done walking message chain.

superbackup-sd: message.c:682-0 ===End close msg resource

superbackup-sd: autochanger.c:328-0 Locking changer Autochanger

superbackup-sd: message.c:1417-0 Enter Jmsg type=6

superbackup-sd: autochanger.c:804-0 omsg=/etc/bacula/scripts/mtx-changer /dev/sg8 loaded 0 /dev/nst0 0

superbackup-sd: autochanger.c:284-0 Run program=/etc/bacula/scripts/mtx-changer /dev/sg8 loaded 0 /dev/nst0 0

superbackup-sd: watchdog.c:197-0 Registered watchdog 7f10b4001a28, interval 300

superbackup-sd: btimers.c:67-0 Start child timer 7f10b420a5e8, pid 30193 for 300 secs.

superbackup-sd: signal.c:125-0 sig=17 Child status has changed

superbackup-sd: bpipe.c:472-0 Run program fgets stat=0

superbackup-sd: bpipe.c:501-0 resadr=0xb4202400 reslen=2 res=0

superbackup-sd: bpipe.c:273-0 Wait for 30193 opt=1

superbackup-sd: bpipe.c:281-0 Got break wpid=30193 status=0 ERR=none

superbackup-sd: bpipe.c:302-0 child status=0

superbackup-sd: btimers.c:79-0 Stop child timer 7f10b420a5e8 pid 30193

superbackup-sd: watchdog.c:217-0 Unregistered watchdog 7f10b4001a28

superbackup-sd: bpipe.c:317-0 returning stat=0,0

superbackup-sd: bpipe.c:505-0 Run program returning 0

superbackup-sd: autochanger.c:286-0 run_prog: /etc/bacula/scripts/mtx-changer /dev/sg8 loaded 0 /dev/nst0 0 stat=0 result=0

superbackup-sd: message.c:1417-0 Enter Jmsg type=6

superbackup-sd: autochanger.c:342-0 Unlocking changer Autochanger

superbackup-sd: autochanger.c:328-0 Locking changer Autochanger

superbackup-sd: autochanger.c:804-0 omsg=/etc/bacula/scripts/mtx-changer /dev/sg8 list 0 /dev/nst0 0

superbackup-sd: watchdog.c:197-0 Registered watchdog 7f10b4001a28, interval 300

superbackup-sd: btimers.c:67-0 Start child timer 7f10b420a5e8, pid 30206 for 300 secs.

superbackup-sd: autochanger.c:682-0 <stored: 1:000151L3

superbackup-sd: autochanger.c:682-0 <stored: 2:000133L3

superbackup-sd: autochanger.c:682-0 <stored: 3:000128L3

superbackup-sd: autochanger.c:682-0 <stored: 4:000126L3

superbackup-sd: autochanger.c:682-0 <stored: 5:000122L3

superbackup-sd: autochanger.c:682-0 <stored: 6:000125L3

superbackup-sd: autochanger.c:682-0 <stored: 7:000124L3

superbackup-sd: autochanger.c:682-0 <stored: 8:000137L3

superbackup-sd: autochanger.c:682-0 <stored: 9:000129L3

superbackup-sd: autochanger.c:682-0 <stored: 10:000134L3

superbackup-sd: autochanger.c:682-0 <stored: 11:000131L3

superbackup-sd: autochanger.c:682-0 <stored: 12:000140L3

superbackup-sd: autochanger.c:682-0 <stored: 14:000153L3

superbackup-sd: autochanger.c:682-0 <stored: 15:000152L3

superbackup-sd: autochanger.c:682-0 <stored: 16:000132L3

superbackup-sd: autochanger.c:682-0 <stored: 17:000121L3

superbackup-sd: autochanger.c:682-0 <stored: 18:000127L3

superbackup-sd: autochanger.c:682-0 <stored: 19:000130L3

superbackup-sd: signal.c:125-0 sig=17 Child status has changed

superbackup-sd: bpipe.c:273-0 Wait for 30206 opt=1

superbackup-sd: bpipe.c:281-0 Got break wpid=30206 status=0 ERR=none

superbackup-sd: bpipe.c:302-0 child status=0

superbackup-sd: btimers.c:79-0 Stop child timer 7f10b420a5e8 pid 30206

superbackup-sd: watchdog.c:217-0 Unregistered watchdog 7f10b4001a28

superbackup-sd: bpipe.c:317-0 returning stat=0,0

superbackup-sd: autochanger.c:342-0 Unlocking changer Autochanger

superbackup-sd: lock.c:169-0 Unlock Drive-1 from dircmd.c:1767 postcnt=0

superbackup-sd: acquire.c:722-0 Enter detach_dcr_from_dev

superbackup-sd: lock.c:159-0 Lock Drive-1 from acquire.c:724 precnt=0

superbackup-sd: lock.c:169-0 Unlock Drive-1 from acquire.c:745 postcnt=0

superbackup-sd: block_util.c:254-0 free_block buffer=7f10b4002270

superbackup-sd: block_util.c:261-0 === free_block block 7f10b4002190

superbackup-sd: record_util.c:277-0 Enter free_record.

superbackup-sd: record_util.c:281-0 Data buf is freed.

superbackup-sd: record_util.c:283-0 Leave free_record.

superbackup-sd: sd_plugins.c:102-0 No b_plugin_list: generate_plugin_event ignored.

superbackup-sd: message.c:561-0 Close_msg jcr=7f10b4000b48

superbackup-sd: job.c:323-0 End Job JobId=0 7f10b4000b48

superbackup-sd: job.c:331-0 Send terminate jid=0 7f10b4000b48

superbackup-sd: message.c:561-0 Close_msg jcr=0

superbackup-sd: message.c:586-0 ===Begin close msg resource at 55acdc932228

superbackup-sd: message.c:675-0 Done walking message chain.

superbackup-sd: message.c:682-0 ===End close msg resource

Could anybody tell me where the problem could be? Could it be about the versions mismatch? I saw on the list that Dan Langille wrote (https://sourceforge.net/p/bacula/mailman/message/36187800/): "bacula-dir = bacula-sd >= bacula-fd" How close should the versions of -dir and -sd be? In my case they are 0.0.2 apart.

Thanks!

Charles

--

Charles Nadeau Ph.D.
http://charlesnadeau.blogspot.com/
------------------------------------------------------------------------------
Check out the vibrant tech community on one of the world's most
engaging tech sites, Slashdot.org! http://sdm.link/slashdot
_______________________________________________
Bacula-users mailing list
Bacula-users@lists.sourceforge.net
https://lists.sourceforge.net/lists/listinfo/bacula-users

------------------------------------------------------------------------------
Check out the vibrant tech community on one of the world's most
engaging tech sites, Slashdot.org! http://sdm.link/slashdot

_______________________________________________
Bacula-users mailing list
Bacula-users@lists.sourceforge.net
https://lists.sourceforge.net/lists/listinfo/bacula-users

Re: [Bacula-users] Bacula director crashes while labelling tapes with their barcodes.

Reply via email to