Problem working with WBSAirback (Bacula) and TS3500

Tape drive and auto-loader redirector over iSCSI

Moderators: anton (staff), art (staff), Max (staff), Anatoly (staff)

rodrigo_fsantos
Posts: 10
Joined: Mon Nov 05, 2018 5:30 pm

Sat Nov 17, 2018 2:22 am

I'm trying to work with WBSAirback (Bacula Enterprise) and TS3500 LTO5 drive through Starwind Tape redirector.

I'm able to mount, label and write some backup jobs, but sometimes I get an I/O error (results attached)

These are the errors logs on Starwind console..
11/17 0:50:34.545 1348 Sw: *** Swn_SocketRecv: WSARecv() failed with error 10054 (0x2746)!
11/17 0:50:34.545 1348 Srv: *** SwSocket::Recv: Swn_SocketRecv() failed with error 10054 (0x2746)!
11/17 0:50:34.545 1348 C[2], LIN: iScsiConnection::receive: recvData returned 10054 (0x2746)!
11/17 0:50:34.545 1348 C[2], LIN: iScsiConnection::recvWorker: *** 'recv' thread: recv failed 10058.

I read some notes talking about transfer size, I did some test changing these parameters, but I didnt have success.
Could you help me?

Tks.
Attachments
error_bacula.jpg
error_bacula.jpg (122.54 KiB) Viewed 15943 times
Oleg(staff)
Staff
Posts: 568
Joined: Fri Nov 24, 2017 7:52 am

Tue Nov 20, 2018 9:14 am

These messages are related to network interruptions.
Is it possible to send us full logs in order to investigate the issue more deeply?
rodrigo_fsantos
Posts: 10
Joined: Mon Nov 05, 2018 5:30 pm

Wed Nov 21, 2018 12:44 pm

Of course! Attached the Starwind full log.
Please let me know, if another logs are necessary!

Thanks.
Attachments
127.0.0.1-3261-service-starwind-20181117-072852.log.zip
Starwind full log.
(8.69 KiB) Downloaded 649 times
Last edited by rodrigo_fsantos on Wed Nov 21, 2018 6:01 pm, edited 1 time in total.
Oleg(staff)
Staff
Posts: 568
Joined: Fri Nov 24, 2017 7:52 am

Wed Nov 21, 2018 4:19 pm

Thank you! I will keep you posted.
rodrigo_fsantos
Posts: 10
Joined: Mon Nov 05, 2018 5:30 pm

Thu Nov 22, 2018 8:34 pm

Hi Oleg,

These are the configs in the iscsid.conf on the initiator side... Do you think that I need to change something?

#WBSAirback iSCSI autoconfiguration
node.startup = automatic
node.session.timeo.replacement_timeout = 120
node.conn[0].timeo.login_timeout = 15
node.conn[0].timeo.logout_timeout = 15
node.conn[0].timeo.noop_out_interval = 5
node.conn[0].timeo.noop_out_timeout = 5
node.session.initial_login_retry_max = 8
node.session.cmds_max = 128
node.session.queue_depth = 32
node.session.iscsi.InitialR2T = No
node.session.iscsi.ImmediateData = Yes
node.session.iscsi.FirstBurstLength = 262144
node.session.iscsi.MaxBurstLength = 16776192
node.conn[0].iscsi.MaxRecvDataSegmentLength = 131072
discovery.sendtargets.iscsi.MaxRecvDataSegmentLength = 32768
node.session.iscsi.FastAbort = Yes
Oleg(staff)
Staff
Posts: 568
Joined: Fri Nov 24, 2017 7:52 am

Thu Nov 22, 2018 9:18 pm

Thank you Rodrigo,
Could you please also give more details about WBSAirback, does it have ISCSI initiator?
Is it possible to get the log from this client?
rodrigo_fsantos
Posts: 10
Joined: Mon Nov 05, 2018 5:30 pm

Fri Nov 23, 2018 1:12 am

Hello Oleg,

WBSAirback is a software backup tool that runs in Linux Debian 7, but we are working in a appliance format, just the WBS has root access.
It has an Linux iSCSI initiator to access the tape drive from Starwind.
What logs would you like?

Thanks,

Rodrigo.
Oleg(staff)
Staff
Posts: 568
Joined: Fri Nov 24, 2017 7:52 am

Fri Nov 23, 2018 12:36 pm

Hello Rodrigo,
Could you please try to change these parameters to 65536:
node.session.iscsi.FirstBurstLength = 262144
node.session.iscsi.MaxBurstLength = 16776192
node.conn[0].iscsi.MaxRecvDataSegmentLength = 131072

Please share the results of this change.
rodrigo_fsantos
Posts: 10
Joined: Mon Nov 05, 2018 5:30 pm

Fri Nov 23, 2018 2:36 pm

Thanks, Oleg, I will try with these new parameters.
Oleg(staff)
Staff
Posts: 568
Joined: Fri Nov 24, 2017 7:52 am

Fri Nov 23, 2018 2:48 pm

Please keep us updated with the results.
Oleg(staff)
Staff
Posts: 568
Joined: Fri Nov 24, 2017 7:52 am

Wed Nov 28, 2018 5:07 pm

Hello Rodrigo,
Did you try to change the parameters?
Please share the results of this change with the community if yes.
rodrigo_fsantos
Posts: 10
Joined: Mon Nov 05, 2018 5:30 pm

Wed Nov 28, 2018 5:40 pm

Hello Oleg,

Yes, I'm trying with the new parameters on iSCSI initator, but.....
- I was able to complete a backup job and a restore job once... and after I tried to write a new backup job I had the same I/O error.

I've noticed that errors always occur when a tape operation is required, such as position to the end, rewind the tape....
It is an intermittent error! Attached the new logs!

Do you know that is better to use Windows 2012?

Thanks for your help!
Attachments
127.0.0.1-3261-service-starwind-20181128-224410.log.zip
Starwind log
(8.44 KiB) Downloaded 641 times
rodrigo_fsantos
Posts: 10
Joined: Mon Nov 05, 2018 5:30 pm

Wed Nov 28, 2018 7:38 pm

I have just finished a successfull backup and when I try to restore I have these errors (image attached).
Attachments
WBS-error-restore
WBS-error-restore
wbs-error.JPG (90.32 KiB) Viewed 15850 times
Oleg(staff)
Staff
Posts: 568
Joined: Fri Nov 24, 2017 7:52 am

Thu Nov 29, 2018 12:26 pm

Thank you, Rodrigo,
I have passed this information to our R&D team. I will keep the community updated.
rodrigo_fsantos
Posts: 10
Joined: Mon Nov 05, 2018 5:30 pm

Thu Dec 06, 2018 3:03 pm

Hi Olleg, how are you doing?

Would you have some news about this case?

Thanks.

Rodrigo
Post Reply