debian 9 - not working

classic Classic list List threaded Threaded
14 messages Options
Reply | Threaded
Open this post in threaded view
|

debian 9 - not working

inktvis75
Dependencies installed: build-essentials sg3-utils lsscsi mtx unzip liblzo2-dev zlib1g-dev mt-st linux-headers-$(uname -r)
  policykit-1

Kernel version: Linux 4.9.0-8-amd64

Installed via git, modified mhvtl-load-modules.service, changed path from /usr/sbin/modprobe into /sbin/modprobe. Seems to load module:

Jan 30 09:41:46 debian kernel: mhvtl: loading out-of-tree module taints kernel.
Jan 30 09:41:46 debian kernel: scsi host3: mhvtl: version 0.18.18 [20180429-0], opts=0x0

lsmod | grep mhvtl
mhvtl                  36864  0
scsi_mod              225280  8 mhvtl,sd_mod,mptscsih,libata,scsi_transport_spi,sr_mod,sg,mptspi

status of the target:
systemctl status mhvtl.target | more
* mhvtl.target - mhvtl service allowing to start/stop all vtltape@.service and vtllibrary@.service instances at once
   Loaded: loaded (/usr/lib/systemd/system/mhvtl.target; enabled; vendor preset: enabled)
   Active: active since Wed 2019-01-30 09:41:46 CET; 8min ago
     Docs: man:man:vtltape(1)
           man:man:vtllibrary(1)

Jan 30 09:41:46 debian systemd[1]: Reached target mhvtl service allowing to start/stop all vtltape@.service and vtllibrary@.service instance
s at once.

systemctl status mhvtl-load-modules.service
* mhvtl-load-modules.service - Load mhvtl modules
   Loaded: loaded (/etc/systemd/system/mhvtl-load-modules.service; enabled; vendor preset: enabled)
   Active: active (exited) since Wed 2019-01-30 09:41:46 CET; 8min ago
     Docs: man:man:vtltape(1)
           man:man:vtllibrary(1)
  Process: 523 ExecStart=/sbin/modprobe sg (code=exited, status=0/SUCCESS)
  Process: 505 ExecStart=/sbin/modprobe mhvtl opts=${VTL_DEBUG} (code=exited, status=0/SUCCESS)
 Main PID: 523 (code=exited, status=0/SUCCESS)
    Tasks: 0 (limit: 19660)
   CGroup: /system.slice/mhvtl-load-modules.service

Jan 30 09:41:46 debian systemd[1]: Starting Load mhvtl modules...
Jan 30 09:41:46 debian systemd[1]: Started Load mhvtl modules.

so far so good, except: lsscsi -g doesn't show the tape devices ... where to start debugging is the first question :)
Reply | Threaded
Open this post in threaded view
|

Re: debian 9 - not working

inktvis75
just trying something (Note: i am completely new to mhVTL):

root@debian:~# systemctl start vtltape@34
root@debian:~# systemctl status vtltape@34
* vtltape@34.service - Tape Daemon for Virtual Tape & Robot Library
   Loaded: loaded (/usr/lib/systemd/system/vtltape@.service; disabled; vendor preset: enabled)
   Active: failed (Result: signal) since Wed 2019-01-30 10:48:56 CET; 4s ago
     Docs: man:vtltape(1)
           man:vtlcmd(1)
  Process: 619 ExecStop=/usr/bin/vtlcmd 34 exit (code=exited, status=1/FAILURE)
  Process: 618 ExecStart=/usr/bin/vtltape -F -q34 -v${VERBOSE} ${DAEMON_DEBUG} (code=killed, signal=ABRT)
 Main PID: 618 (code=killed, signal=ABRT)

Jan 30 10:48:56 debian vtltape[618]: vtltape: readline():  Backoff: 400
Jan 30 10:48:56 debian vtltape[618]: vtltape: init_lu(): Backoff value: 400
Jan 30 10:48:56 debian vtltape[618]: vtltape: readline(): # fifo: /var/tmp/mhvtl
Jan 30 10:48:56 debian vtltape[618]: vtltape: readline():
Jan 30 10:48:56 debian vtltape[618]: vtltape: init_lu(): Looking for 34, Found drive 34
Jan 30 10:48:56 debian vtltape[618]: vtltape: checkstrlen(): Line #: 129, String
Jan 30 10:48:56 debian systemd[1]: vtltape@34.service: Unit entered failed state.
Jan 30 10:48:56 debian vtltape[618]: String
Jan 30 10:48:56 debian vtltape[618]: Please fix config file
Jan 30 10:48:56 debian systemd[1]: vtltape@34.service: Failed with result 'signal'.


journalctl -u vtltape@34.service
-- Logs begin at Wed 2019-01-30 10:32:40 CET, end at Wed 2019-01-30 10:51:57 CET. --
Jan 30 10:48:56 debian systemd[1]: Started Tape Daemon for Virtual Tape & Robot Library.
Jan 30 10:48:56 debian vtltape[618]: vtltape: readline():
Jan 30 10:48:56 debian vtltape[618]: vtltape: init_lu(): Looking for 34, Found drive 1077772712
Jan 30 10:48:56 debian vtltape[618]: vtltape: readline(): VERSION: 5
Jan 30 10:48:56 debian vtltape[618]: vtltape: readline():
Jan 30 10:48:56 debian vtltape[618]: vtltape: init_lu(): Looking for 34, Found drive 1077772712
Jan 30 10:48:56 debian vtltape[618]: vtltape: readline(): # VPD page format:
Jan 30 10:48:56 debian vtltape[618]: vtltape: readline(): # <page #> <Length> <x> <x+1>... <x+n>
Jan 30 10:48:56 debian vtltape[618]: vtltape: readline(): # NAA format is an 8 hex byte value seperated by ':'
Jan 30 10:48:56 debian vtltape[618]: vtltape: readline(): # Note: NAA is part of inquiry VPD 0x83
Jan 30 10:48:56 debian vtltape[618]: vtltape: readline(): #
Jan 30 10:48:56 debian vtltape[618]: vtltape: readline(): # Each 'record' is separated by one (or more) blank lines.
Jan 30 10:48:56 debian vtltape[618]: vtltape: readline(): # Each 'record' starts at column 1
Jan 30 10:48:56 debian vtltape[618]: vtltape: readline(): # Serial num max len is 10.
Jan 30 10:48:56 debian vtltape[618]: vtltape: readline(): # Compression: factor X enabled 0|1
Jan 30 10:48:56 debian vtltape[618]: vtltape: readline(): #     Where X is zlib compression factor        1 = Fastest compression
Jan 30 10:48:56 debian vtltape[618]: vtltape: readline(): #                                                9 = Best compression
Jan 30 10:48:56 debian vtltape[618]: vtltape: readline(): #     enabled 0 == off, 1 == on
Jan 30 10:48:56 debian vtltape[618]: vtltape: readline(): #
Jan 30 10:48:56 debian vtltape[618]: vtltape: readline(): # fifo: /var/tmp/mhvtl
Jan 30 10:48:56 debian vtltape[618]: vtltape: readline(): # If enabled, data must be read from fifo, otherwise daemon will block
Jan 30 10:48:56 debian vtltape[618]: vtltape: readline(): # trying to write.
Jan 30 10:48:56 debian vtltape[618]: vtltape: readline(): # e.g. cat /var/tmp/mhvtl (in another terminal)
...skipping...
Jan 30 10:48:56 debian vtltape[618]: vtltape: readline():
Jan 30 10:48:56 debian vtltape[618]: vtltape: init_lu(): Looking for 34, Found drive 33
Jan 30 10:48:56 debian vtltape[618]: vtltape: readline(): Drive: 34 CHANNEL: 00 TARGET: 12 LUN: 00
Jan 30 10:48:56 debian vtltape[618]: vtltape: init_lu(): Looking for 34, Found drive 34
Jan 30 10:48:56 debian vtltape[618]: vtltape: readline():  Library ID: 30 Slot: 04
Jan 30 10:48:56 debian vtltape[618]: vtltape: init_lu(): Library ID: 30
Jan 30 10:48:56 debian vtltape[618]: vtltape: readline():  Vendor identification: STK
Jan 30 10:48:56 debian vtltape[618]: vtltape: readline():  Product identification: T10000B
Jan 30 10:48:56 debian vtltape[618]: vtltape: readline():  Unit serial number: XYZZY_B4
Jan 30 10:48:56 debian vtltape[618]: vtltape: readline():  NAA: 30:22:33:44:ab:00:12:00
Jan 30 10:48:56 debian vtltape[618]: vtltape: init_lu(): Setting NAA: to 30:22:33:44:ab:00:12:00
Jan 30 10:48:56 debian vtltape[618]: vtltape: readline():  Compression: factor 1 enabled 1
Jan 30 10:48:56 debian vtltape[618]: vtltape: readline():  Compression type: lzo
Jan 30 10:48:56 debian vtltape[618]: vtltape: init_lu(): Compression set to LZO
Jan 30 10:48:56 debian vtltape[618]: vtltape: readline():  Backoff: 400
Jan 30 10:48:56 debian vtltape[618]: vtltape: init_lu(): Backoff value: 400
Jan 30 10:48:56 debian vtltape[618]: vtltape: readline(): # fifo: /var/tmp/mhvtl
Jan 30 10:48:56 debian vtltape[618]: vtltape: readline():
Jan 30 10:48:56 debian vtltape[618]: vtltape: init_lu(): Looking for 34, Found drive 34
Jan 30 10:48:56 debian vtltape[618]: vtltape: checkstrlen(): Line #: 129, String
Jan 30 10:48:56 debian systemd[1]: vtltape@34.service: Unit entered failed state.
Jan 30 10:48:56 debian vtltape[618]: String
Jan 30 10:48:56 debian vtltape[618]: Please fix config file
Jan 30 10:48:56 debian systemd[1]: vtltape@34.service: Failed with result 'signal'.
Reply | Threaded
Open this post in threaded view
|

Re: debian 9 - not working

Mark Harvey
Administrator
Can you please provide the /etc/mhvtl/device.conf from your system

Cheers 

Sent from my iPad

On Jan 30, 2019, at 20:54, inktvis75 [via mhVTL - A Linux Virtual Tape Library] <[hidden email]> wrote:

just trying something (Note: i am completely new to mhVTL):

root@debian:~# systemctl start vtltape@34
root@debian:~# systemctl status vtltape@34
* [hidden email] - Tape Daemon for Virtual Tape & Robot Library
   Loaded: loaded (/usr/lib/systemd/system/vtltape@.service; disabled; vendor preset: enabled)
   Active: failed (Result: signal) since Wed 2019-01-30 10:48:56 CET; 4s ago
     Docs: man:vtltape(1)
           man:vtlcmd(1)
  Process: 619 ExecStop=/usr/bin/vtlcmd 34 exit (code=exited, status=1/FAILURE)
  Process: 618 ExecStart=/usr/bin/vtltape -F -q34 -v${VERBOSE} ${DAEMON_DEBUG} (code=killed, signal=ABRT)
 Main PID: 618 (code=killed, signal=ABRT)

Jan 30 10:48:56 debian vtltape[618]: vtltape: readline():  Backoff: 400
Jan 30 10:48:56 debian vtltape[618]: vtltape: init_lu(): Backoff value: 400
Jan 30 10:48:56 debian vtltape[618]: vtltape: readline(): # fifo: /var/tmp/mhvtl
Jan 30 10:48:56 debian vtltape[618]: vtltape: readline():
Jan 30 10:48:56 debian vtltape[618]: vtltape: init_lu(): Looking for 34, Found drive 34
Jan 30 10:48:56 debian vtltape[618]: vtltape: checkstrlen(): Line #: 129, String
Jan 30 10:48:56 debian systemd[1]: [hidden email]: Unit entered failed state.
Jan 30 10:48:56 debian vtltape[618]: String
Jan 30 10:48:56 debian vtltape[618]: Please fix config file
Jan 30 10:48:56 debian systemd[1]: [hidden email]: Failed with result 'signal'.


journalctl -u [hidden email]
-- Logs begin at Wed 2019-01-30 10:32:40 CET, end at Wed 2019-01-30 10:51:57 CET. --
Jan 30 10:48:56 debian systemd[1]: Started Tape Daemon for Virtual Tape & Robot Library.
Jan 30 10:48:56 debian vtltape[618]: vtltape: readline():
Jan 30 10:48:56 debian vtltape[618]: vtltape: init_lu(): Looking for 34, Found drive 1077772712
Jan 30 10:48:56 debian vtltape[618]: vtltape: readline(): VERSION: 5
Jan 30 10:48:56 debian vtltape[618]: vtltape: readline():
Jan 30 10:48:56 debian vtltape[618]: vtltape: init_lu(): Looking for 34, Found drive 1077772712
Jan 30 10:48:56 debian vtltape[618]: vtltape: readline(): # VPD page format:
Jan 30 10:48:56 debian vtltape[618]: vtltape: readline(): # <page #> <Length> <x> <x+1>... <x+n>
Jan 30 10:48:56 debian vtltape[618]: vtltape: readline(): # NAA format is an 8 hex byte value seperated by ':'
Jan 30 10:48:56 debian vtltape[618]: vtltape: readline(): # Note: NAA is part of inquiry VPD 0x83
Jan 30 10:48:56 debian vtltape[618]: vtltape: readline(): #
Jan 30 10:48:56 debian vtltape[618]: vtltape: readline(): # Each 'record' is separated by one (or more) blank lines.
Jan 30 10:48:56 debian vtltape[618]: vtltape: readline(): # Each 'record' starts at column 1
Jan 30 10:48:56 debian vtltape[618]: vtltape: readline(): # Serial num max len is 10.
Jan 30 10:48:56 debian vtltape[618]: vtltape: readline(): # Compression: factor X enabled 0|1
Jan 30 10:48:56 debian vtltape[618]: vtltape: readline(): #     Where X is zlib compression factor        1 = Fastest compression
Jan 30 10:48:56 debian vtltape[618]: vtltape: readline(): #                                                9 = Best compression
Jan 30 10:48:56 debian vtltape[618]: vtltape: readline(): #     enabled 0 == off, 1 == on
Jan 30 10:48:56 debian vtltape[618]: vtltape: readline(): #
Jan 30 10:48:56 debian vtltape[618]: vtltape: readline(): # fifo: /var/tmp/mhvtl
Jan 30 10:48:56 debian vtltape[618]: vtltape: readline(): # If enabled, data must be read from fifo, otherwise daemon will block
Jan 30 10:48:56 debian vtltape[618]: vtltape: readline(): # trying to write.
Jan 30 10:48:56 debian vtltape[618]: vtltape: readline(): # e.g. cat /var/tmp/mhvtl (in another terminal)
...skipping...
Jan 30 10:48:56 debian vtltape[618]: vtltape: readline():
Jan 30 10:48:56 debian vtltape[618]: vtltape: init_lu(): Looking for 34, Found drive 33
Jan 30 10:48:56 debian vtltape[618]: vtltape: readline(): Drive: 34 CHANNEL: 00 TARGET: 12 LUN: 00
Jan 30 10:48:56 debian vtltape[618]: vtltape: init_lu(): Looking for 34, Found drive 34
Jan 30 10:48:56 debian vtltape[618]: vtltape: readline():  Library ID: 30 Slot: 04
Jan 30 10:48:56 debian vtltape[618]: vtltape: init_lu(): Library ID: 30
Jan 30 10:48:56 debian vtltape[618]: vtltape: readline():  Vendor identification: STK
Jan 30 10:48:56 debian vtltape[618]: vtltape: readline():  Product identification: T10000B
Jan 30 10:48:56 debian vtltape[618]: vtltape: readline():  Unit serial number: XYZZY_B4
Jan 30 10:48:56 debian vtltape[618]: vtltape: readline():  NAA: 30:22:33:44:ab:00:12:00
Jan 30 10:48:56 debian vtltape[618]: vtltape: init_lu(): Setting NAA: to 30:22:33:44:ab:00:12:00
Jan 30 10:48:56 debian vtltape[618]: vtltape: readline():  Compression: factor 1 enabled 1
Jan 30 10:48:56 debian vtltape[618]: vtltape: readline():  Compression type: lzo
Jan 30 10:48:56 debian vtltape[618]: vtltape: init_lu(): Compression set to LZO
Jan 30 10:48:56 debian vtltape[618]: vtltape: readline():  Backoff: 400
Jan 30 10:48:56 debian vtltape[618]: vtltape: init_lu(): Backoff value: 400
Jan 30 10:48:56 debian vtltape[618]: vtltape: readline(): # fifo: /var/tmp/mhvtl
Jan 30 10:48:56 debian vtltape[618]: vtltape: readline():
Jan 30 10:48:56 debian vtltape[618]: vtltape: init_lu(): Looking for 34, Found drive 34
Jan 30 10:48:56 debian vtltape[618]: vtltape: checkstrlen(): Line #: 129, String
Jan 30 10:48:56 debian systemd[1]: [hidden email]: Unit entered failed state.
Jan 30 10:48:56 debian vtltape[618]: String
Jan 30 10:48:56 debian vtltape[618]: Please fix config file
Jan 30 10:48:56 debian systemd[1]: [hidden email]: Failed with result 'signal'.


If you reply to this email, your message will be added to the discussion below:
http://mhvtl-a-linux-virtual-tape-library.966029.n3.nabble.com/debian-9-not-working-tp4026184p4026185.html
To start a new topic under mhVTL - A Linux Virtual Tape Library, email [hidden email]
To unsubscribe from mhVTL - A Linux Virtual Tape Library, click here.
NAML
Regards from Australia
Mark Harvey
Reply | Threaded
Open this post in threaded view
|

Re: debian 9 - not working

inktvis75
thanks for your fast reply !  I didn't modify this file. This is the content:


VERSION: 5

# VPD page format:
# <page #> <Length> <x> <x+1>... <x+n>
# NAA format is an 8 hex byte value seperated by ':'
# Note: NAA is part of inquiry VPD 0x83
#
# Each 'record' is separated by one (or more) blank lines.
# Each 'record' starts at column 1
# Serial num max len is 10.
# Compression: factor X enabled 0|1
#     Where X is zlib compression factor 1 = Fastest compression
# 9 = Best compression
#     enabled 0 == off, 1 == on
#
# fifo: /var/tmp/mhvtl
# If enabled, data must be read from fifo, otherwise daemon will block
# trying to write.
# e.g. cat /var/tmp/mhvtl (in another terminal)

Library: 10 CHANNEL: 00 TARGET: 00 LUN: 00
 Vendor identification: STK
 Product identification: L700
 Unit serial number: XYZZY_A
 NAA: 10:22:33:44:ab:00:00:00
 Home directory: /opt/mhvtl
 PERSIST: False
 Backoff: 400
# fifo: /var/tmp/mhvtl

Drive: 11 CHANNEL: 00 TARGET: 01 LUN: 00
 Library ID: 10 Slot: 01
 Vendor identification: IBM
 Product identification: ULT3580-TD5
 Unit serial number: XYZZY_A1
 NAA: 10:22:33:44:ab:00:01:00
 Compression: factor 1 enabled 1
 Compression type: lzo
 Backoff: 400
# fifo: /var/tmp/mhvtl

Drive: 12 CHANNEL: 00 TARGET: 02 LUN: 00
 Library ID: 10 Slot: 02
 Vendor identification: IBM
 Product identification: ULT3580-TD5
 Unit serial number: XYZZY_A2
 NAA: 10:22:33:44:ab:00:02:00
 Compression: factor 1 enabled 1
 Compression type: lzo
 Backoff: 400
# fifo: /var/tmp/mhvtl

Drive: 13 CHANNEL: 00 TARGET: 03 LUN: 00
 Library ID: 10 Slot: 03
 Vendor identification: IBM
 Product identification: ULT3580-TD4
 Unit serial number: XYZZY_A3
 NAA: 10:22:33:44:ab:00:03:00
 Compression: factor 1 enabled 1
 Compression type: lzo
 Backoff: 400
# fifo: /var/tmp/mhvtl

Drive: 14 CHANNEL: 00 TARGET: 04 LUN: 00
 Library ID: 10 Slot: 04
 Vendor identification: IBM
 Product identification: ULT3580-TD4
 Unit serial number: XYZZY_A4
 NAA: 10:22:33:44:ab:00:04:00
 Compression: factor 1 enabled 1
 Compression type: lzo
 Backoff: 400
# fifo: /var/tmp/mhvtl

Library: 30 CHANNEL: 00 TARGET: 08 LUN: 00
 Vendor identification: STK
 Product identification: L80
 Unit serial number: XYZZY_B
 NAA: 30:22:33:44:ab:00:08:00
 Home directory: /opt/mhvtl
 PERSIST: False
 Backoff: 400
# fifo: /var/tmp/mhvtl

Drive: 31 CHANNEL: 00 TARGET: 09 LUN: 00
 Library ID: 30 Slot: 01
 Vendor identification: STK
 Product identification: T10000B
 Unit serial number: XYZZY_B1
 NAA: 30:22:33:44:ab:00:09:00
 Compression: factor 1 enabled 1
 Compression type: lzo
 Backoff: 400
# fifo: /var/tmp/mhvtl

Drive: 32 CHANNEL: 00 TARGET: 10 LUN: 00
 Library ID: 30 Slot: 02
 Vendor identification: STK
 Product identification: T10000B
 Unit serial number: XYZZY_B2
 NAA: 30:22:33:44:ab:00:10:00
 Compression: factor 1 enabled 1
 Compression type: lzo
 Backoff: 400
# fifo: /var/tmp/mhvtl

Drive: 33 CHANNEL: 00 TARGET: 11 LUN: 00
 Library ID: 30 Slot: 03
 Vendor identification: STK
 Product identification: T10000B
 Unit serial number: XYZZY_B3
 NAA: 30:22:33:44:ab:00:11:00
 Compression: factor 1 enabled 1
 Compression type: lzo
 Backoff: 400
# fifo: /var/tmp/mhvtl

Drive: 34 CHANNEL: 00 TARGET: 12 LUN: 00
 Library ID: 30 Slot: 04
 Vendor identification: STK
 Product identification: T10000B
 Unit serial number: XYZZY_B4
 NAA: 30:22:33:44:ab:00:12:00
 Compression: factor 1 enabled 1
 Compression type: lzo
 Backoff: 400
# fifo: /var/tmp/mhvtl

Reply | Threaded
Open this post in threaded view
|

Re: debian 9 - not working

inktvis75
In reply to this post by inktvis75
I found one other messages:

Jan 30 10:51:57 debian vtltape[632]: vtltape: init_lu(): Looking for 33, Found drive 32
Jan 30 10:51:57 debian vtltape[632]: vtltape: readline():  Library ID: 30 Slot: 02
Jan 30 10:51:57 debian vtltape[632]: vtltape: readline():  Vendor identification: STK
Jan 30 10:51:57 debian vtltape[632]: vtltape: readline():  Product identification: T10000B
Jan 30 10:51:57 debian vtltape[632]: vtltape: readline():  Unit serial number: XYZZY_B2
Jan 30 10:51:57 debian vtltape[632]: vtltape: readline():  NAA: 30:22:33:44:ab:00:10:00
Jan 30 10:51:57 debian vtltape[632]: vtltape: readline():  Compression: factor 1 enabled 1
Jan 30 10:51:57 debian vtltape[632]: vtltape: readline():  Compression type: lzo
Jan 30 10:51:57 debian vtltape[632]: vtltape: readline():  Backoff: 400
Jan 30 10:51:57 debian vtltape[632]: vtltape: readline(): # fifo: /var/tmp/mhvtl
Jan 30 10:51:57 debian vtltape[632]: vtltape: readline():
Jan 30 10:51:57 debian vtltape[632]: vtltape: init_lu(): Looking for 33, Found drive 32
Jan 30 10:51:57 debian vtltape[632]: vtltape: readline(): Drive: 33 CHANNEL: 00 TARGET: 11 LUN: 00
Jan 30 10:51:57 debian vtltape[632]: vtltape: init_lu(): Looking for 33, Found drive 33
Jan 30 10:51:57 debian vtlcmd[634]: OpenExistingQueue: No such file or directory
Jan 30 10:51:57 debian vtlcmd[634]: MessageQueue not available


Reply | Threaded
Open this post in threaded view
|

Re: debian 9 - not working

Mark Harvey
Administrator
Can I obtain the output of:

ps -ef | grep vtl
ipcs -a

Cheers

On 30 Jan 2019, at 9:13 pm, inktvis75 [via mhVTL - A Linux Virtual Tape Library] <[hidden email]> wrote:

I found one other messages:

Jan 30 10:51:57 debian vtltape[632]: vtltape: init_lu(): Looking for 33, Found drive 32
Jan 30 10:51:57 debian vtltape[632]: vtltape: readline():  Library ID: 30 Slot: 02
Jan 30 10:51:57 debian vtltape[632]: vtltape: readline():  Vendor identification: STK
Jan 30 10:51:57 debian vtltape[632]: vtltape: readline():  Product identification: T10000B
Jan 30 10:51:57 debian vtltape[632]: vtltape: readline():  Unit serial number: XYZZY_B2
Jan 30 10:51:57 debian vtltape[632]: vtltape: readline():  NAA: 30:22:33:44:ab:00:10:00
Jan 30 10:51:57 debian vtltape[632]: vtltape: readline():  Compression: factor 1 enabled 1
Jan 30 10:51:57 debian vtltape[632]: vtltape: readline():  Compression type: lzo
Jan 30 10:51:57 debian vtltape[632]: vtltape: readline():  Backoff: 400
Jan 30 10:51:57 debian vtltape[632]: vtltape: readline(): # fifo: /var/tmp/mhvtl
Jan 30 10:51:57 debian vtltape[632]: vtltape: readline():
Jan 30 10:51:57 debian vtltape[632]: vtltape: init_lu(): Looking for 33, Found drive 32
Jan 30 10:51:57 debian vtltape[632]: vtltape: readline(): Drive: 33 CHANNEL: 00 TARGET: 11 LUN: 00
Jan 30 10:51:57 debian vtltape[632]: vtltape: init_lu(): Looking for 33, Found drive 33
Jan 30 10:51:57 debian vtlcmd[634]: OpenExistingQueue: No such file or directory
Jan 30 10:51:57 debian vtlcmd[634]: MessageQueue not available





If you reply to this email, your message will be added to the discussion below:
http://mhvtl-a-linux-virtual-tape-library.966029.n3.nabble.com/debian-9-not-working-tp4026184p4026188.html
To start a new topic under mhVTL - A Linux Virtual Tape Library, [hidden email]
To unsubscribe from mhVTL - A Linux Virtual Tape Library, click here.
NAML

Regards from Australia
Mark Harvey
Reply | Threaded
Open this post in threaded view
|

Re: debian 9 - not working

inktvis75
root@debian:/var/log# ps -ef | grep vtl
root        908    606  0 11:29 pts/0    00:00:00 grep vtl

---> so daemon is not running at all

root@debian:/var/log# ipcs -a

------ Message Queues --------
key        msqid      owner      perms      used-bytes   messages

------ Shared Memory Segments --------
key        shmid      owner      perms      bytes      nattch     status

------ Semaphore Arrays --------
key        semid      owner      perms      nsems
Reply | Threaded
Open this post in threaded view
|

Re: debian 9 - not working

Mark Harvey
Administrator
I’m about to call it quits for the night..

Can I please ask for the output of the following:

vtltape -q 11 -d

Note: the process will run in the foreground - so if it stays running, in another terminal, run “vtlcmd 11 exit” which will send an ‘exit’ message to the process (via the message queue) and it should terminate cleanly. 
Note2: Pressing ‘ctrl-C’ may not clean up the kernel module side of the logical unit and sometimes a reboot is the only way to clean up the kernel module (sorry about that).


I’ve just reproduced the issue.

I’ll have a look at this tomorrow.


On 30 Jan 2019, at 9:30 pm, inktvis75 [via mhVTL - A Linux Virtual Tape Library] <[hidden email]> wrote:

root@debian:/var/log# ps -ef | grep vtl
root        908    606  0 11:29 pts/0    00:00:00 grep vtl

---> so daemon is not running at all

root@debian:/var/log# ipcs -a

------ Message Queues --------
key        msqid      owner      perms      used-bytes   messages

------ Shared Memory Segments --------
key        shmid      owner      perms      bytes      nattch     status

------ Semaphore Arrays --------
key        semid      owner      perms      nsems


If you reply to this email, your message will be added to the discussion below:
http://mhvtl-a-linux-virtual-tape-library.966029.n3.nabble.com/debian-9-not-working-tp4026184p4026190.html
To start a new topic under mhVTL - A Linux Virtual Tape Library, [hidden email]
To unsubscribe from mhVTL - A Linux Virtual Tape Library, click here.
NAML

Regards from Australia
Mark Harvey
Reply | Threaded
Open this post in threaded view
|

Re: debian 9 - not working

inktvis75
thank you !!!
Reply | Threaded
Open this post in threaded view
|

Re: debian 9 - not working

Mark Harvey
Administrator
Can you please re-try the latest git repository - Two issues:
- Revert a change where it now fails to skip blank lines in the device.conf file.
- ‘-q x’ (where x is an index into device.conf) is mandatory option to vtltape & vtllibrary

Cheers

On 30 Jan 2019, at 9:55 pm, inktvis75 [via mhVTL - A Linux Virtual Tape Library] <[hidden email]> wrote:

thank you !!!


If you reply to this email, your message will be added to the discussion below:
http://mhvtl-a-linux-virtual-tape-library.966029.n3.nabble.com/debian-9-not-working-tp4026184p4026192.html
To start a new topic under mhVTL - A Linux Virtual Tape Library, [hidden email]
To unsubscribe from mhVTL - A Linux Virtual Tape Library, click here.
NAML

Regards from Australia
Mark Harvey
Reply | Threaded
Open this post in threaded view
|

Re: debian 9 - not working

inktvis75
great !

root@debian:/home/student# systemctl start vtltape@34.service
root@debian:/home/student# journalctl -u vtltape@34.service
-- Logs begin at Thu 2019-01-31 09:23:37 CET, end at Thu 2019-01-31 09:24:51 CET. --
Jan 31 09:24:51 debian systemd[1]: Started Tape Daemon for Virtual Tape & Robot Library.
Jan 31 09:24:51 debian /usr/bin/vtltape[713]: init_lu(): Backoff value: 400
Jan 31 09:24:51 debian /usr/bin/vtltape[713]: init_lu(): Adding default vers info: 0105
Jan 31 09:24:51 debian /usr/bin/vtltape[713]: add_lu(): Child PID 714 starting logical unit [0:12:0]
Jan 31 09:24:51 debian /usr/bin/vtltape[713]: main(): Started /usr/bin/vtltape: version 1.5.5-git-12cb908, verbose log lvl: 1, lu [0:12:0]
Jan 31 09:24:51 debian /usr/bin/vtltape[713]: main(): Size of buffer is 2097152
Jan 31 09:24:51 debian /usr/bin/vtltape[713]: CDB (1) (delay 50400): 12 00 00 00 24 00
Jan 31 09:24:51 debian /usr/bin/vtltape[713]: spc_inquiry(): INQUIRY ** (1)
Jan 31 09:24:51 debian /usr/bin/vtltape[713]: CDB (2) (delay 805): 12 00 00 00 4a 00
Jan 31 09:24:51 debian /usr/bin/vtltape[713]: spc_inquiry(): INQUIRY ** (2)
Jan 31 09:24:51 debian /usr/bin/vtltape[713]: CDB (3) (delay 805): 12 01 00 00 ff 00
Jan 31 09:24:51 debian /usr/bin/vtltape[713]: spc_inquiry(): INQUIRY ** (3)
Jan 31 09:24:51 debian /usr/bin/vtltape[713]: CDB (4) (delay 405): 12 01 80 00 ff 00
Jan 31 09:24:51 debian /usr/bin/vtltape[713]: spc_inquiry(): INQUIRY ** (4)
Jan 31 09:24:51 debian /usr/bin/vtltape[713]: CDB (5) (delay 405): 12 01 83 00 ff 00
Jan 31 09:24:51 debian /usr/bin/vtltape[713]: spc_inquiry(): INQUIRY ** (5)
Jan 31 09:24:51 debian /usr/bin/vtltape[713]: main(): Cleaning up after add_lu child pid: 714
Jan 31 09:24:51 debian /usr/bin/vtltape[713]: CDB (6) (delay 4405): 12 00 00 00 fe 00
Jan 31 09:24:51 debian /usr/bin/vtltape[713]: spc_inquiry(): INQUIRY ** (6)
Jan 31 09:24:51 debian /usr/bin/vtltape[713]: CDB (7) (delay 5): 12 00 00 00 fe 00
Jan 31 09:24:51 debian /usr/bin/vtltape[713]: spc_inquiry(): INQUIRY ** (7)
Jan 31 09:24:51 debian /usr/bin/vtltape[713]: CDB (8) (delay 805): 12 01 00 00 fe 00
Jan 31 09:24:51 debian /usr/bin/vtltape[713]: spc_inquiry(): INQUIRY ** (8)
...skipping...
Jan 31 09:24:51 debian /usr/bin/vtltape[713]: spc_inquiry(): INQUIRY ** (5)
Jan 31 09:24:51 debian /usr/bin/vtltape[713]: main(): Cleaning up after add_lu child pid: 714
Jan 31 09:24:51 debian /usr/bin/vtltape[713]: CDB (6) (delay 4405): 12 00 00 00 fe 00
Jan 31 09:24:51 debian /usr/bin/vtltape[713]: spc_inquiry(): INQUIRY ** (6)
Jan 31 09:24:51 debian /usr/bin/vtltape[713]: CDB (7) (delay 5): 12 00 00 00 fe 00
Jan 31 09:24:51 debian /usr/bin/vtltape[713]: spc_inquiry(): INQUIRY ** (7)
Jan 31 09:24:51 debian /usr/bin/vtltape[713]: CDB (8) (delay 805): 12 01 00 00 fe 00
Jan 31 09:24:51 debian /usr/bin/vtltape[713]: spc_inquiry(): INQUIRY ** (8)
Jan 31 09:24:51 debian /usr/bin/vtltape[713]: CDB (9) (delay 5): 12 01 00 00 fe 00
Jan 31 09:24:51 debian /usr/bin/vtltape[713]: spc_inquiry(): INQUIRY ** (9)
Jan 31 09:24:51 debian /usr/bin/vtltape[713]: CDB (10) (delay 1605): 12 01 80 00 fe 00
Jan 31 09:24:51 debian /usr/bin/vtltape[713]: spc_inquiry(): INQUIRY ** (10)
Jan 31 09:24:51 debian /usr/bin/vtltape[713]: CDB (11) (delay 5): 12 01 80 00 fe 00
Jan 31 09:24:51 debian /usr/bin/vtltape[713]: spc_inquiry(): INQUIRY ** (11)
Jan 31 09:24:51 debian /usr/bin/vtltape[713]: CDB (12) (delay 1205): 12 01 83 00 fe 00
Jan 31 09:24:51 debian /usr/bin/vtltape[713]: spc_inquiry(): INQUIRY ** (12)
Jan 31 09:24:51 debian /usr/bin/vtltape[713]: CDB (13) (delay 5): 12 01 83 00 fe 00
Jan 31 09:24:51 debian /usr/bin/vtltape[713]: spc_inquiry(): INQUIRY ** (13)
Jan 31 09:24:51 debian /usr/bin/vtltape[713]: CDB (14) (delay 3205): 00 00 00 00 00 00
Jan 31 09:24:51 debian /usr/bin/vtltape[713]: return_sense(): [Key/ASC/ASCQ] [06 29 00]
Jan 31 09:24:51 debian /usr/bin/vtltape[713]: CDB (15) (delay 1205): 00 00 00 00 00 00
Jan 31 09:24:51 debian /usr/bin/vtltape[713]: return_sense(): [Key/ASC/ASCQ] [02 3a 00]
Jan 31 09:24:51 debian /usr/bin/vtltape[713]: ssc_tur(): Test Unit Ready (15) ** : No, No tape loaded
Jan 31 09:24:51 debian /usr/bin/vtltape[713]: CDB (16) (delay 805): 12 00 00 00 c8 00
Jan 31 09:24:51 debian /usr/bin/vtltape[713]: spc_inquiry(): INQUIRY ** (16)

root@debian:/home/student# lsscsi -g
[0:0:0:0]    disk    VMware,  VMware Virtual S 1.0   /dev/sda   /dev/sg0
[0:0:1:0]    disk    VMware,  VMware Virtual S 1.0   /dev/sdb   /dev/sg1
[0:0:2:0]    disk    VMware,  VMware Virtual S 1.0   /dev/sdc   /dev/sg2
[2:0:0:0]    cd/dvd  NECVMWar VMware IDE CDR10 1.00  /dev/sr0   /dev/sg3

One thing: the target unit doesn't start/stop all vtltape@.service and vtllibrary@.service instances at once
[3:0:12:0]   tape    STK      T10000B          0105  /dev/st0   /dev/sg4
Reply | Threaded
Open this post in threaded view
|

Re: debian 9 - not working

inktvis75
vtltape -q 11 -d &> /tmp/vtltape.log

[3:0:1:0]    tape    IBM      ULT3580-TD5      0105  /dev/st0   /dev/sg4

/lib/udev/scsi_id --whitelist --page 0x80 /dev/sg4
SIBM     ULT3580-TD5     XYZZY_A1

which is drive 11 from the configuration file as expected ...

root@debian:~# systemctl enable --now vtllibrary@34.service
Created symlink /etc/systemd/system/mhvtl.target.wants/vtllibrary@34.service -> /usr/lib/systemd/system/vtllibrary@.service.
root@debian:~# systemctl enable --now vtltape@34.service
Created symlink /etc/systemd/system/mhvtl.target.wants/vtltape@34.service -> /usr/lib/systemd/system/vtltape@.service.

is working fine for this specific device
Reply | Threaded
Open this post in threaded view
|

Re: debian 9 - not working

inktvis75
until you reboot, during the boot process:

Feb 01 11:03:31 debian kernel: CPU: 0 PID: 555 Comm: vtltape Tainted: G           O    4.9.0-8-amd64 #1 Debian 4.9.130-2
Feb 01 11:03:31 debian kernel: Hardware name: VMware, Inc. VMware Virtual Platform/440BX Desktop Reference Platform, BIOS 6.00 04/13/2018
Feb 01 11:03:31 debian kernel: task: ffff884cb7aa9040 task.stack: ffffaa50c1f54000
Feb 01 11:03:31 debian kernel: RIP: 0010:[<ffffffffc00b724a>]  [<ffffffffc00b724a>] scsi_remove_device+0xa/0x30 [scsi_mod]
Feb 01 11:03:31 debian kernel: RSP: 0018:ffffaa50c1f57e08  EFLAGS: 00010246
Feb 01 11:03:31 debian kernel: RAX: dead000000000200 RBX: ffff884cb7933410 RCX: dead000000000200
Feb 01 11:03:31 debian kernel: RDX: ffff884cb7933410 RSI: 00007ffe153a5f80 RDI: 0000000000000000
Feb 01 11:03:31 debian kernel: RBP: 0000000000000000 R08: ffff884cb7af0e40 R09: 000000000000000f
Feb 01 11:03:31 debian kernel: R10: 0000000000000000 R11: 0000000000000000 R12: 0000000000000000
Feb 01 11:03:31 debian kernel: R13: ffff884cb7af0e40 R14: ffff884cb7933410 R15: 0000000000000000
Feb 01 11:03:31 debian kernel: FS:  00007fc79a1752c0(0000) GS:ffff884cbc600000(0000) knlGS:0000000000000000
Feb 01 11:03:31 debian kernel: CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
Feb 01 11:03:31 debian kernel: CR2: 0000000000000000 CR3: 00000000378fe000 CR4: 0000000000360670
Feb 01 11:03:31 debian kernel: Stack:
Feb 01 11:03:31 debian kernel:  ffff884cb7933410 0000000000000022 ffffffffc06a73b2 000055cddc3f2740
Feb 01 11:03:31 debian kernel:  0000000c00000000 0000000000000000 ffff884c00000000 ffffaa5000000001
Feb 01 11:03:31 debian kernel:  0000000000000000 c799ff557b2c60b5 ffff884cb694b600 ffff884cb694b600
Feb 01 11:03:31 debian kernel: Call Trace:
Feb 01 11:03:31 debian kernel:  [<ffffffffc06a73b2>] ? vtl_c_ioctl+0x152/0x7b0 [mhvtl]
Feb 01 11:03:31 debian kernel:  [<ffffffff8b21f442>] ? do_vfs_ioctl+0xa2/0x620
Feb 01 11:03:31 debian kernel:  [<ffffffff8b21fa34>] ? SyS_ioctl+0x74/0x80
Feb 01 11:03:31 debian kernel:  [<ffffffff8b003b7d>] ? do_syscall_64+0x8d/0xf0
Feb 01 11:03:31 debian kernel:  [<ffffffff8b618f8e>] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6
Feb 01 11:03:31 debian kernel: Code: bb 50 04 00 00 e8 b7 7a 3c cb 48 89 ef e8 3f 10 3d cb 48 89 ef e8 47 78 3c cb e9 65 ff ff ff 66 90 0f 1f 44 00 00 55 53 48 89 fd <48> 8b 07 48 8d 58 60 48 89 df e8 27 f2 55 cb 48 89 ef e8 0f ff
Feb 01 11:03:31 debian kernel: RIP  [<ffffffffc00b724a>] scsi_remove_device+0xa/0x30 [scsi_mod]
Feb 01 11:03:31 debian kernel:  RSP <ffffaa50c1f57e08>
Feb 01 11:03:31 debian kernel: CR2: 0000000000000000
Feb 01 11:03:31 debian kernel: ---[ end trace 74eff359279a13d4 ]---
Reply | Threaded
Open this post in threaded view
|

Re: debian 9 - not working

inktvis75
In reply to this post by inktvis75
note, this is debian specific, it works fine in RH7.6