#23 Hang SCST with numerous remounting of block devices.

[valera]

Good day Bart, thanks again for fix the fall speed of reading, but faced with a new problem for about 16000 cycles recreate targets, block devices and cease to give to the network a new goal old is active, then also freezing when connected iniziatore suspends the execution of commands and hangs. All this happens for about 16000+ re-creations. Tried on Debian also 8.9 to 9.8, a symptom of the same at 16000, possibly kakoeto internal limit on the total number of the count of Loon, although if you disconnect from a target command execution is going on but the new targets are not working, please help me to understand why two weeks of testing, the problem manifests itself roughly in the same place and also hang, and after a time kernel:[ 2991.945912] BUG: soft lockup - CPU#1 stuck for 22s! [scst_uid132268:21137] the Cycle of deleting and then adding a block device. Right now I will add a new log from the moment of the failure.

[ ... ]

[Bart Van Assche]

With which SCST version did this occur? Please provide the output of cat /sys/kernel/scst_tgt/trace_cmds while the hang occurs and the output of cat /sys/kernel/scst_tgt/trace_mcmds. Please provide the call trace from /var/log/messages, /var/log/syslog or from the journalctl output.

[valera]

The time before the failure, everything is still fine.

Apr 12 23:38:36 COMP11 kernel: [ 3027.166248] [712]: iscsi_target_create:69:Creating target tid 16408, name scst299
Apr 12 23:38:36 COMP11 kernel: [ 3027.166365] [712]: scst: scst_register_target:529:Target scst299 for template iscsi registered successfully
Apr 12 23:38:36 COMP11 kernel: [ 3027.166745] [14940]: dev_vdisk: vdisk_report_registering:6795:Registering virtual vdisk_fileio device scst299 (ROTATIONAL)
Apr 12 23:38:36 COMP11 kernel: [ 3027.166857] [14940]: dev_vdisk: vdisk_attach:1268:Attached SCSI target virtual disk scst299 (file="/dev/mapper/scst299", fs=1024MB, bs=512, nblocks=2097152, cyln=1024)
Apr 12 23:38:36 COMP11 kernel: [ 3027.166973] [14940]: scst_alloc_add_tgt_dev:5398:Device scst299 on SCST lun=16483
Apr 12 23:38:36 COMP11 kernel: [ 3027.166979] [14940]: scst: scst_alloc_set_UA:13047:Queuing new UA ffff8800b84a6ab0 (6:29:0, d_sense 0) to tgt_dev ffff8800b731dc00 (dev scst299, initiator copy_manager_sess)
Apr 12 23:38:36 COMP11 kernel: [ 3027.167013] [14942]: scst: scst_cmd_thread:5643:Processing thread scst2990_0 started
Apr 12 23:38:36 COMP11 kernel: [ 3027.167029] [14943]: scst: scst_cmd_thread:5643:Processing thread scst2990_1 started
Apr 12 23:38:36 COMP11 kernel: [ 3027.167043] [14944]: scst: scst_cmd_thread:5643:Processing thread scst2990_2 started
Apr 12 23:38:36 COMP11 kernel: [ 3027.167057] [14945]: scst: scst_cmd_thread:5643:Processing thread scst2990_3 started
Apr 12 23:38:36 COMP11 kernel: [ 3027.167071] [14946]: scst: scst_cmd_thread:5643:Processing thread scst2990_4 started
Apr 12 23:38:36 COMP11 kernel: [ 3027.167085] [14947]: scst: scst_cmd_thread:5643:Processing thread scst2990_5 started
Apr 12 23:38:36 COMP11 kernel: [ 3027.167099] [14948]: scst: scst_cmd_thread:5643:Processing thread scst2990_6 started
Apr 12 23:38:36 COMP11 kernel: [ 3027.167113] [14949]: scst: scst_cmd_thread:5643:Processing thread scst2990_7 started
Apr 12 23:38:36 COMP11 kernel: [ 3027.167143] [14940]: scst: scst_acg_add_lun:4529:Added device scst299 to group copy_manager_tgt (LUN 16483, flags 0x4) to target copy_manager_tgt
Apr 12 23:38:36 COMP11 kernel: [ 3027.167155] [14940]: scst: scst_translate_lun:5025:tgt_dev for LUN 99 not found, command to unexisting LU (initiator copy_manager_sess, target copy_manager_tgt)?
Apr 12 23:38:36 COMP11 kernel: [ 3027.167169] [14940]: scst: scst_register_virtual_device_node:1403:Attached to virtual device scst299 (id 16483)
Apr 12 23:38:36 COMP11 kernel: [ 3027.167309] [695]: scst: scst_acg_add_lun:4529:Added device scst299 to group scst299 (LUN 0, flags 0x2) to target scst299
Apr 12 23:38:36 COMP11 kernel: [ 3027.167453] [695]: scst: scst_process_tgt_enable_store:2320:Using autogenerated relative target id 16408 for target scst299

Has gone crashing and if the connected initiator, the commands themselves already are not executed.

Apr 12 23:39:04 COMP11 kernel: [ 3055.108966] [15178]: scst: scst_cmd_thread:5643:Processing thread scst40_5 started
Apr 12 23:39:04 COMP11 kernel: [ 3055.109256] [15179]: scst: scst_cmd_thread:5643:Processing thread scst40_6 started
Apr 12 23:39:04 COMP11 kernel: [ 3055.109271] [15180]: scst: scst_cmd_thread:5643:Processing thread scst40_7 started
Apr 12 23:39:04 COMP11 kernel: [ 3055.109294] [695]: scst: scst_acg_add_lun:4529:Added device scst4 to group copy_manager_tgt (LUN 16487, flags 0x4) to target copy_manager_tgt
Apr 12 23:39:04 COMP11 kernel: [ 3055.109305] [695]: scst: scst_translate_lun:5025:tgt_dev for LUN 103 not found, command to unexisting LU (initiator copy_manager_sess, target copy_manager_tgt)?
Apr 12 23:39:04 COMP11 kernel: [ 3055.109317] [695]: scst: scst_register_virtual_device_node:1403:Attached to virtual device scst4 (id 16487)
Apr 12 23:39:04 COMP11 kernel: [ 3055.109447] [695]: scst: scst_acg_add_lun:4529:Added device scst4 to group scst4 (LUN 0, flags 0x2) to target scst4
Apr 12 23:39:04 COMP11 kernel: [ 3055.109585] [695]: scst: scst_process_tgt_enable_store:2320:Using autogenerated relative target id 16411 for target scst4
Apr 12 23:39:04 COMP11 kernel: [ 3055.122680] [695]: scst: __scst_process_luns_mgmt_store:1484:Removed all devices from group scst5
Apr 12 23:39:04 COMP11 kernel: [ 3055.122693] [695]: scst: __scst_acg_del_lun:4594:Removed LUN 0 from group scst5 (target scst5)
Apr 12 23:39:04 COMP11 kernel: [ 3055.122748] [712]: target_destroy:227:Destroying target tid 16114
Apr 12 23:39:04 COMP11 kernel: [ 3055.122782] [712]: scst_suspend_activity:916:suspend_count 0
Apr 12 23:39:04 COMP11 kernel: [ 3055.122792] [712]: scst: scst_suspend_activity:941:Waiting for 1 active commands to complete...
Apr 12 23:39:09 COMP11 kernel: [ 3060.127180] [712]: scst: scst_susp_wait:858:1 active commands to still not completed. See README for possible reasons.
Apr 12 23:39:09 COMP11 kernel: [ 3060.127199] [712]: scst: scst_to_syslog:814:Pending commands:
Apr 12 23:39:09 COMP11 kernel: [ 3060.127203]     cmd ffff88008c635940: state EXEC_CHECK_BLOCKING; op REPORT LUNS; proc time 5 sec; tgtt iscsi; tgt scst1; session iqn.2000-01.org.etherboot:COMP01; grp scst1; LUN 0; ini iqn.2000-01.org.et

[valera]

these parameters are empty

cat /sys/kernel/scsi_tgt/trace_cmds

cat /sys/kernel/scst_tgt/trace_mcmds

root@COMP11:~# modinfo scst
filename: /lib/modules/3.16.0-4-amd64/extra/scst.ko
version: 3.4.0-pre1
description: SCSI target core
license: GPL
author: Vladislav Bolkhovitin
srcversion: 107CB1D6111F08729766E9D
depends: dlm,scsi_mod,crc-t10dif
vermagic: 3.16.0-4-amd64 SMP mod_unload modversions
parm: alua_invariant_check:Enables a run-time ALUA state invariant check. (bool)
parm: scst_threads:SCSI target threads count (int)
parm: scst_max_cmd_mem:Maximum memory allowed to be consumed by all SCSI commands of all devices at any given time in MB (int)
parm: scst_max_dev_cmd_mem:Maximum memory allowed to be consumed by all SCSI commands of a device at any given time in MB (int)
parm: forcibly_close_sessions:If enabled, close the sessions associated with an access control group (ACG) when an ACG is deleted via sysfs instead of returning -EBUSY (int)
parm: auto_cm_assignment:Enables the copy managers auto registration (int)
root@COMP11:~# modinfo iscsi_scst
filename: /lib/modules/3.16.0-4-amd64/extra/iscsi-scst.ko
description: SCST iSCSI Target
license: GPL
version: 3.4.0-pre1
srcversion: 0A30D7D27B21CE845A4541D
depends: scst,libcrc32c
vermagic: 3.16.0-4-amd64 SMP mod_unload modversions
root@COMP11:~#

[valera]

Message from syslogd@COMP11 at Apr 13 00:08:17 ...
 kernel:[ 4810.237799] BUG: soft lockup - CPU#1 stuck for 22s! [scst_uid:695]

Message from syslogd@COMP11 at Apr 13 00:08:53 ...
 kernel:[ 4846.283248] BUG: soft lockup - CPU#1 stuck for 22s! [scst_uid:695]

Message from syslogd@COMP11 at Apr 13 00:09:21 ...
 kernel:[ 4874.318597] BUG: soft lockup - CPU#1 stuck for 22s! [scst_uid:695]

[valera]

New Test Checked out revision 8180.
Linux Debian 4.9.0-8-amd64 #1 SMP Debian 4.9.144-3.1 (2019-02-19) x86_64 GNU/Linux
A couple of minutes before the failure.

The point of failure journalctl

апр 13 00:29:03 Debian kernel: [703]: iscsi_target_create:69:Creating target tid 16397, name scst2
апр 13 00:29:03 Debian kernel: [703]: scst: scst_register_target:529:Target scst2 for template iscsi registered successfully
апр 13 00:29:03 Debian kernel: [19825]: dev_vdisk: vdisk_report_registering:6795:Registering virtual vdisk_fileio device scst2 (ROTATIONAL)
апр 13 00:29:03 Debian kernel: [19825]: dev_vdisk: vdisk_attach:1268:Attached SCSI target virtual disk scst2 (file="/dev/mapper/scst2", fs=1024MB, bs=512, nblocks=2097152, cyln=1024)
апр 13 00:29:03 Debian kernel: [19825]: scst_alloc_add_tgt_dev:5398:Device scst2 on SCST lun=16449
апр 13 00:29:03 Debian kernel: [19825]: scst: scst_alloc_set_UA:13047:Queuing new UA ffff9407c2640990 (6:29:0, d_sense 0) to tgt_dev ffff94075bc1a080 (dev scst2, initiator copy_manager_sess)
апр 13 00:29:03 Debian kernel: [19826]: scst: scst_cmd_thread:5643:Processing thread scst20_0 started
апр 13 00:29:03 Debian kernel: [19827]: scst: scst_cmd_thread:5643:Processing thread scst20_1 started
апр 13 00:29:03 Debian kernel: [19828]: scst: scst_cmd_thread:5643:Processing thread scst20_2 started
апр 13 00:29:03 Debian kernel: [19829]: scst: scst_cmd_thread:5643:Processing thread scst20_3 started
апр 13 00:29:03 Debian kernel: [19830]: scst: scst_cmd_thread:5643:Processing thread scst20_4 started
апр 13 00:29:03 Debian kernel: [19831]: scst: scst_cmd_thread:5643:Processing thread scst20_5 started
апр 13 00:29:03 Debian kernel: [19832]: scst: scst_cmd_thread:5643:Processing thread scst20_6 started
апр 13 00:29:03 Debian kernel: [19833]: scst: scst_cmd_thread:5643:Processing thread scst20_7 started
апр 13 00:29:03 Debian kernel: [19825]: scst: scst_acg_add_lun:4529:Added device scst2 to group copy_manager_tgt (LUN 16449, flags 0x4) to target copy_manager_tgt
апр 13 00:29:03 Debian kernel: [19825]: scst: scst_translate_lun:5025:tgt_dev for LUN 65 not found, command to unexisting LU (initiator copy_manager_sess, target copy_manager_tgt)?
апр 13 00:29:03 Debian kernel: [19825]: scst: scst_register_virtual_device_node:1403:Attached to virtual device scst2 (id 16449)
апр 13 00:29:03 Debian kernel: [664]: scst: scst_acg_add_lun:4529:Added device scst2 to group scst2 (LUN 0, flags 0x2) to target scst2
апр 13 00:29:03 Debian kernel: [664]: scst: scst_process_tgt_enable_store:2320:Using autogenerated relative target id 16397 for target scst2
апр 13 00:29:03 Debian kernel: [664]: scst: __scst_process_luns_mgmt_store:1484:Removed all devices from group scst3
апр 13 00:29:03 Debian kernel: [664]: scst: __scst_acg_del_lun:4594:Removed LUN 0 from group scst3 (target scst3)
апр 13 00:29:03 Debian kernel: [703]: target_destroy:227:Destroying target tid 16100
апр 13 00:29:03 Debian kernel: [703]: scst_suspend_activity:916:suspend_count 0
апр 13 00:29:03 Debian kernel: [703]: scst: scst_suspend_activity:941:Waiting for 1 active commands to complete...
апр 13 00:29:08 Debian kernel: [703]: scst: scst_susp_wait:858:1 active commands to still not completed. See README for possible reasons.
апр 13 00:29:08 Debian kernel: [703]: scst: scst_to_syslog:814:Pending commands:
апр 13 00:29:08 Debian kernel:
апр 13 00:29:08 Debian kernel: cmd ffff9407d023b9c0: state EXEC_CHECK_BLOCKING; op REPORT LUNS; proc time 5 sec; tgtt iscsi; tgt scst1; session iqn.2000-01.org.etherboot:COMP01; grp scst1; LUN 0; ini iqn.2000-01.org.etherboot:COMP01; cdb
апр 13 00:31:13 Debian kernel: [0]: iscsi-scst: __iscsi_state_change:436:***ERROR***: Connection ffff9407e122e700 with initiator iqn.2000-01.org.etherboot:COMP01 unexpectedly closed!
апр 13 00:31:13 Debian kernel: [0]: __iscsi_state_change:438:conn ffff9407e122e700, sk state 7
апр 13 00:31:13 Debian kernel: [19846]: close_conn:252:Closing connection ffff9407e122e700 (conn_ref_cnt=2)
апр 13 00:31:13 Debian kernel: [19846]: scst: scst_rx_mgmt_fn:7819:TM fn NEXUS_LOSS_SESS/6 (mcmd ffff9407f1e5be00, initiator iqn.2000-01.org.etherboot:COMP01, target scst1)
апр 13 00:31:13 Debian kernel: [19846]: scst_rx_mgmt_fn:7833:sess=ffff9407eeeb2000, tag_set 0, tag 0, lun_set 1, lun=0, cmd_sn_set 0, cmd_sn 0, priv ffff9407e122e700
апр 13 00:31:13 Debian kernel: [19846]: scst_post_rx_mgmt_cmd:7746:Adding mgmt cmd ffff9407f1e5be00 to active mgmt cmd list
апр 13 00:31:13 Debian kernel: [19846]: req_cmnd_release_force:585:req ffff9407f1e81800
апр 13 00:31:13 Debian kernel: [19846]: conn_abort:2572:Aborting conn ffff9407e122e700
апр 13 00:31:13 Debian kernel: [669]: scst_tm_thread:7631:Deleting mgmt cmd ffff9407f1e5be00 from active cmd list
апр 13 00:31:13 Debian kernel: [19846]: __cmnd_abort:2337:Aborting cmd ffff9407f1e81080, scst_cmd ffff9407d023b9c0 (scst state 4, ref_cnt 1, on_write_timeout_list 0, write_start 0, ITT b1140000, sn 5297, op 1, r2t_len_to_receive 0, r2t_le
апр 13 00:31:13 Debian kernel: [19846]: __cmnd_abort:2354:Setting conn_tm_active for conn ffff9407e122e700
апр 13 00:31:13 Debian kernel: [669]: scst_abort_all_nexus_loss_sess:6982:Nexus loss or UNREG SESS for sess ffff9407eeeb2000 (mcmd ffff9407f1e5be00)
апр 13 00:31:13 Debian kernel: [19846]: __cmnd_abort:2371:Timer for conn ffff9407e122e700 is going to fire on 4295651398 (timeout time 4295654307)
апр 13 00:31:13 Debian kernel: [669]: scst: scst_abort_cmd:6162:Aborting cmd ffff9407d023b9c0 (tag 2970877952, op REPORT LUNS)
апр 13 00:31:13 Debian kernel: [19846]: iscsi_check_tm_data_wait_timeouts:633:conn ffff9407e122e700, read_cmnd           (null), read_state 0, j 4295651557 (TIMEOUT 2750, force 1)
апр 13 00:31:13 Debian kernel: [669]: scst: scst_abort_cmd:6283:cmd ffff9407d023b9c0 (tag 2970877952, sn 4294967276) being executed/xmitted (state EXEC_CHECK_BLOCKING, op REPORT LUNS, proc time 130 sec., timeout 10 sec.), deferring ABORT
апр 13 00:31:13 Debian kernel: [19846]: iscsi_check_tm_data_wait_timeouts:694:Clearing conn_tm_active for conn ffff9407e122e700
апр 13 00:31:13 Debian kernel: [669]: iscsi_on_abort_cmd:2558:Scheduling abort check for scst_cmd ffff9407d023b9c0
апр 13 00:31:13 Debian kernel: [669]: __scst_unblock_aborted_cmds:6421:Unblock aborted blocked cmd ffff9407d023b9c0
апр 13 00:31:13 Debian kernel: [669]: scst: scst_alloc_set_UA:13047:Queuing new UA ffff9407d8400aa0 (6:29:7, d_sense 0) to tgt_dev ffff9407d790c7c0 (dev scst1, initiator iqn.2000-01.org.etherboot:COMP01)
апр 13 00:31:13 Debian kernel: [19769]: __scst_check_local_events:3238:ABORTED set, aborting cmd ffff9407d023b9c0
апр 13 00:31:13 Debian kernel: [669]: scst_call_dev_task_mgmt_fn_done:6114:Calling dev handler vdisk_fileio task_mgmt_fn_done(fn=6)
апр 13 00:31:13 Debian kernel: [669]: scst_call_dev_task_mgmt_fn_done:6117:Dev handler vdisk_fileio task_mgmt_fn_done() returned
апр 13 00:31:13 Debian kernel: [19769]: scst_xmit_process_aborted_cmd:13961:Aborted cmd ffff9407d023b9c0 done (cmd_ref 3)
апр 13 00:31:13 Debian kernel: [669]: iscsi_task_mgmt_affected_cmds_done:172:scst_mcmd ffff9407f1e5be00, fn 6, priv ffff9407e122e700
апр 13 00:31:13 Debian kernel: [19769]: scst_done_cmd_mgmt:5902:cmd ffff9407d023b9c0 done (tag 2970877952)
апр 13 00:31:13 Debian kernel: [669]: scst_call_task_mgmt_affected_cmds_done:7345:Target's iscsi task_mgmt_affected_cmds_done() returned
апр 13 00:31:13 Debian kernel: [19769]: iscsi_xmit_response:3496:req ffff9407f1e81080 (scst_cmd ffff9407d023b9c0) aborted
апр 13 00:31:13 Debian kernel: [669]: scst: scst_set_mcmd_next_state:6338:cmd_finish_wait_count(1) not 0, preparing to wait
апр 13 00:31:13 Debian kernel: [19769]: req_cmnd_release_force:585:req ffff9407f1e81080
апр 13 00:31:13 Debian kernel: [19769]: req_cmnd_pre_release:667:Release aborted req cmd ffff9407f1e81080 (scst cmd ffff9407d023b9c0, state 5)
апр 13 00:31:13 Debian kernel: [19769]: cmnd_done:419:Done aborted cmd ffff9407f1e81080 (scst cmd ffff9407d023b9c0, state 5, parent_req           (null))
апр 13 00:31:13 Debian kernel: [19769]: scst: scst_finish_cmd_mgmt:6058:Aborted cmd ffff9407d023b9c0 finished (tag 2970877952, ref 3)
апр 13 00:31:13 Debian kernel: [19769]: scst_finish_cmd_mgmt:6067:mcmd ffff9407f1e5be00, mcmd->cmd_finish_wait_count 1
апр 13 00:31:13 Debian kernel: [19769]: __scst_dec_finish_wait_count:5977:Adding mgmt cmd ffff9407f1e5be00 to active mgmt cmd list
апр 13 00:31:13 Debian kernel: [19769]: cmnd_free:354:Free aborted cmd ffff9407f1e81080 (scst cmd ffff9407d023b9c0, state 5, parent_req           (null))
апр 13 00:31:13 Debian kernel: [669]: scst_tm_thread:7631:Deleting mgmt cmd ffff9407f1e5be00 from active cmd list
апр 13 00:31:13 Debian kernel: [669]: scst: scst_mgmt_cmd_send_done:7482:TM fn 6 (mcmd ffff9407f1e5be00) finished, status 0
апр 13 00:31:13 Debian kernel: [669]: iscsi_task_mgmt_fn_done:3765:req ffff9407e122e700, scst_mcmd ffff9407f1e5be00, fn 6, scst status 0, status 0
апр 13 00:31:13 Debian kernel: [669]: scst_mgmt_cmd_send_done:7497:Target's iscsi task_mgmt_fn_done() returned
апр 13 00:31:13 Debian kernel: [16052]: iscsi_cmnd_abort_fn:2499:Checking aborted scst_cmd ffff9407d023b9c0 (cmnd           (null))
апр 13 00:31:13 Debian kernel: [16052]: scst_free_cmd:7479:Freeing aborted cmd ffff9407d023b9c0
апр 13 00:31:13 Debian kernel: [16052]: scst_put:710:Waking up scst_dev_cmd_waitQ
апр 13 00:31:13 Debian kernel: [703]: scst_susp_wait:876:wait_event() returned 0
апр 13 00:31:13 Debian kernel: [703]: scst_susp_wait:876:wait_event() returned 0
апр 13 00:31:13 Debian kernel: [703]: scst: scst_suspend_activity:977:All active commands completed
апр 13 00:31:13 Debian kernel: [703]: __scst_resume_activity:1019:suspend_count 0 left
апр 13 00:31:13 Debian iscsi-scstd[703]: Connect from 192.168.0.1:60914 to 192.168.0.11:3260
апр 13 00:31:13 Debian kernel: [703]: scst: scst_unregister_target:639:Target scst3 for template iscsi unregistered successfully
апр 13 00:31:13 Debian kernel: [664]: scst: __scst_acg_del_lun:4594:Removed LUN 16150 from group copy_manager_tgt (target copy_manager_tgt)
апр 13 00:31:13 Debian kernel: [703]: __add_session:149:Adding session SID 3000037010040
апр 13 00:31:13 Debian kernel: [664]: scst_free_all_UA:13205:Clearing UA for tgt_dev LUN 16150
апр 13 00:31:13 Debian kernel: [1789]: scst: scst_cmd_thread:5807:Processing thread scst30_0 finished
апр 13 00:31:13 Debian kernel: [1790]: scst: scst_cmd_thread:5807:Processing thread scst30_1 finished
апр 13 00:31:13 Debian kernel: [1791]: scst: scst_cmd_thread:5807:Processing thread scst30_2 finished
апр 13 00:31:13 Debian kernel: [1792]: scst: scst_cmd_thread:5807:Processing thread scst30_3 finished
апр 13 00:31:13 Debian kernel: [1793]: scst: scst_cmd_thread:5807:Processing thread scst30_4 finished
апр 13 00:31:13 Debian kernel: [1794]: scst: scst_cmd_thread:5807:Processing thread scst30_5 finished
апр 13 00:31:13 Debian kernel: [1795]: scst: scst_cmd_thread:5807:Processing thread scst30_6 finished
апр 13 00:31:13 Debian kernel: [1796]: scst: scst_cmd_thread:5807:Processing thread scst30_7 finished
апр 13 00:31:13 Debian kernel: [664]: dev_vdisk: vdisk_detach:1335:Detached virtual device scst3 ("/dev/mapper/scst3")
апр 13 00:31:13 Debian kernel: [664]: scst: scst_unregister_virtual_device:1481:Detached from virtual device scst3 (id 16151)
апр 13 00:31:13 Debian kernel: [703]: scst: scst_init_session:8065:Using security group "scst1" for initiator "iqn.2000-01.org.etherboot:COMP01" (target scst1)
апр 13 00:31:13 Debian kernel: [703]: scst_alloc_add_tgt_dev:5398:Device scst1 on SCST lun=0
апр 13 00:31:13 Debian kernel: [703]: scst: scst_alloc_set_UA:13047:Queuing new UA ffff9407c71cbbb0 (6:29:0, d_sense 0) to tgt_dev ffff9407d750b800 (dev scst1, initiator iqn.2000-01.org.etherboot:COMP01)
апр 13 00:31:13 Debian kernel: [19848]: scst: scst_cmd_thread:5643:Processing thread scst12_0 started
апр 13 00:31:13 Debian kernel: [19849]: scst: scst_cmd_thread:5643:Processing thread scst12_1 started
апр 13 00:31:13 Debian kernel: [19850]: scst: scst_cmd_thread:5643:Processing thread scst12_2 started
апр 13 00:31:13 Debian kernel: [19851]: scst: scst_cmd_thread:5643:Processing thread scst12_3 started
апр 13 00:31:13 Debian kernel: [19852]: scst: scst_cmd_thread:5643:Processing thread scst12_4 started
апр 13 00:31:13 Debian kernel: [19853]: scst: scst_cmd_thread:5643:Processing thread scst12_5 started
апр 13 00:31:13 Debian kernel: [19854]: scst: scst_cmd_thread:5643:Processing thread scst12_6 started
апр 13 00:31:13 Debian kernel: [19855]: scst: scst_cmd_thread:5643:Processing thread scst12_7 started
апр 13 00:31:13 Debian kernel: [703]: iscsi-scst: iscsi_session_alloc:101:Session ffff9407dd67a080 created: target ffff94074fc62400, tid 900, sid 0x3000037010040, initiator iqn.2000-01.org.etherboot:COMP01
апр 13 00:31:13 Debian kernel: [703]: iscsi-scst: log_params:89:Negotiated parameters: InitialR2T No, ImmediateData Yes, MaxConnections 1, MaxRecvDataSegmentLength 1048576, MaxXmitDataSegmentLength 65536,
апр 13 00:31:13 Debian kernel: [703]: iscsi-scst: log_params:92:    MaxBurstLength 262144, FirstBurstLength 65536, DefaultTime2Wait 0, DefaultTime2Retain 0,
апр 13 00:31:13 Debian kernel: [703]: iscsi-scst: log_params:97:    MaxOutstandingR2T 16, DataPDUInOrder Yes, DataSequenceInOrder Yes, ErrorRecoveryLevel 0,
апр 13 00:31:13 Debian kernel: [703]: iscsi-scst: log_params:104:    HeaderDigest None, DataDigest None, OFMarker No, IFMarker No, OFMarkInt 2048, IFMarkInt 2048, RDMAExtensions No
апр 13 00:31:13 Debian kernel: [703]: iscsi-scst: iscsi_tgt_params_set:269:Target parameters set for session 3000037010040: QueuedCommands 32, Response timeout 90, Nop-In interval 30, Nop-In timeout 30
апр 13 00:31:13 Debian kernel: [703]: iscsi-scst: iscsi_conn_alloc:936:Creating connection ffff9407e122e080 for sid 0x3000037010040, cid 1 (initiator iqn.2000-01.org.etherboot:COMP01)
апр 13 00:31:13 Debian kernel: [703]: conn_activate:733:Enabling conn ffff9407e122e080
апр 13 00:31:13 Debian kernel: [664]: dev_vdisk: vdev_del_device:7599:Virtual device scst3 unregistered
апр 13 00:31:13 Debian kernel: Buffer I/O error on dev dm-3, logical block 262128, async page read
апр 13 00:31:13 Debian kernel: Buffer I/O error on dev dm-3, logical block 0, async page read
апр 13 00:31:13 Debian kernel: [703]: iscsi_target_create:69:Creating target tid 16398, name scst3
апр 13 00:31:13 Debian kernel: [703]: scst: scst_register_target:529:Target scst3 for template iscsi registered successfully
апр 13 00:31:13 Debian kernel: [664]: dev_vdisk: vdisk_report_registering:6795:Registering virtual vdisk_fileio device scst3 (ROTATIONAL)
апр 13 00:31:13 Debian kernel: [664]: dev_vdisk: vdisk_attach:1268:Attached SCSI target virtual disk scst3 (file="/dev/mapper/scst3", fs=1024MB, bs=512, nblocks=2097152, cyln=1024)
апр 13 00:31:13 Debian kernel: [664]: scst_alloc_add_tgt_dev:5398:Device scst3 on SCST lun=16450
апр 13 00:31:13 Debian kernel: [664]: scst: scst_alloc_set_UA:13047:Queuing new UA ffff94075e40c330 (6:29:0, d_sense 0) to tgt_dev ffff9407f27037c0 (dev scst3, initiator copy_manager_sess)
апр 13 00:31:13 Debian kernel: [19901]: scst: scst_cmd_thread:5643:Processing thread scst30_0 started
апр 13 00:31:13 Debian kernel: [19902]: scst: scst_cmd_thread:5643:Processing thread scst30_1 started
апр 13 00:31:13 Debian kernel: [19903]: scst: scst_cmd_thread:5643:Processing thread scst30_2 started
апр 13 00:31:13 Debian kernel: [19904]: scst: scst_cmd_thread:5643:Processing thread scst30_3 started
апр 13 00:31:13 Debian kernel: [19905]: scst: scst_cmd_thread:5643:Processing thread scst30_4 started
апр 13 00:31:13 Debian kernel: [19906]: scst: scst_cmd_thread:5643:Processing thread scst30_5 started
апр 13 00:31:13 Debian kernel: [19907]: scst: scst_cmd_thread:5643:Processing thread scst30_6 started
апр 13 00:31:13 Debian kernel: [19908]: scst: scst_cmd_thread:5643:Processing thread scst30_7 started
апр 13 00:31:13 Debian kernel: [664]: scst: scst_acg_add_lun:4529:Added device scst3 to group copy_manager_tgt (LUN 16450, flags 0x4) to target copy_manager_tgt
апр 13 00:31:13 Debian kernel: [664]: scst: scst_translate_lun:5025:tgt_dev for LUN 66 not found, command to unexisting LU (initiator copy_manager_sess, target copy_manager_tgt)?
апр 13 00:31:13 Debian kernel: [664]: scst: scst_register_virtual_device_node:1403:Attached to virtual device scst3 (id 16450)
апр 13 00:31:13 Debian kernel: [664]: scst: scst_acg_add_lun:4529:Added device scst3 to group scst3 (LUN 0, flags 0x2) to target scst3
апр 13 00:31:13 Debian kernel: [664]: scst: scst_process_tgt_enable_store:2320:Using autogenerated relative target id 16398 for target scst3
апр 13 00:31:14 Debian kernel: [19846]: iscsi-scst: conn_free:819:Freeing conn ffff9407e122e700 (sess=ffff9407c973e040, 0x2000037010040 1, initiator iqn.2000-01.org.etherboot:COMP01)
апр 13 00:31:14 Debian kernel: [19846]: iscsi-scst: session_free:302:Freeing session ffff9407c973e040 (SID 2000037010040)
апр 13 00:31:14 Debian kernel: [19846]: scst_unregister_session:8358:Unregistering session ffff9407eeeb2000 (wait 0)
апр 13 00:31:14 Debian kernel: [19846]: scst_rx_mgmt_fn:7823:TM fn UNREG_SESS_TM/10 (mcmd ffff9407f1e5b7e0)
апр 13 00:31:14 Debian kernel: [19846]: scst_rx_mgmt_fn:7833:sess=ffff9407eeeb2000, tag_set 0, tag 0, lun_set 0, lun=0, cmd_sn_set 0, cmd_sn 0, priv           (null)
апр 13 00:31:14 Debian kernel: [19846]: scst_post_rx_mgmt_cmd:7746:Adding mgmt cmd ffff9407f1e5b7e0 to active mgmt cmd list
апр 13 00:31:14 Debian kernel: [19846]: close_conn:415:Notifying user space about closing connection ffff9407e122e700
апр 13 00:31:14 Debian kernel: [669]: scst_tm_thread:7631:Deleting mgmt cmd ffff9407f1e5b7e0 from active cmd list
апр 13 00:31:14 Debian kernel: [669]: scst_abort_all_nexus_loss_sess:6982:Nexus loss or UNREG SESS for sess ffff9407eeeb2000 (mcmd ffff9407f1e5b7e0)
апр 13 00:31:14 Debian kernel: [669]: scst_call_dev_task_mgmt_fn_done:6114:Calling dev handler vdisk_fileio task_mgmt_fn_done(fn=10)
апр 13 00:31:14 Debian kernel: [669]: scst_call_dev_task_mgmt_fn_done:6117:Dev handler vdisk_fileio task_mgmt_fn_done() returned
апр 13 00:31:14 Debian kernel: [669]: scst_mgmt_cmd_send_done:7485:TM fn 10 (mcmd ffff9407f1e5b7e0) finished, status 0
апр 13 00:31:14 Debian kernel: [670]: scst_free_all_UA:13205:Clearing UA for tgt_dev LUN 0
апр 13 00:31:14 Debian kernel: [670]: scst_free_all_UA:13205:Clearing UA for tgt_dev LUN 0
апр 13 00:31:14 Debian kernel: [19768]: scst: scst_cmd_thread:5807:Processing thread scst11_0 finished
апр 13 00:31:14 Debian kernel: [19769]: scst: scst_cmd_thread:5807:Processing thread scst11_1 finished
апр 13 00:31:14 Debian kernel: [19770]: scst: scst_cmd_thread:5807:Processing thread scst11_2 finished
апр 13 00:31:14 Debian kernel: [19771]: scst: scst_cmd_thread:5807:Processing thread scst11_3 finished
апр 13 00:31:14 Debian kernel: [19772]: scst: scst_cmd_thread:5807:Processing thread scst11_4 finished
апр 13 00:31:14 Debian kernel: [19773]: scst: scst_cmd_thread:5807:Processing thread scst11_5 finished
апр 13 00:31:14 Debian kernel: [19774]: scst: scst_cmd_thread:5807:Processing thread scst11_6 finished
апр 13 00:31:14 Debian kernel: [19775]: scst: scst_cmd_thread:5807:Processing thread scst11_7 finished

messages

Apr 13 00:29:02 Debian kernel: [ 2898.781149] [664]: scst: scst_register_virtual_device_node:1403:Attached to virtual device scst299 (id 16447)
Apr 13 00:29:02 Debian kernel: [ 2898.781278] [664]: scst: scst_acg_add_lun:4529:Added device scst299 to group scst299 (LUN 0, flags 0x2) to target scst299
Apr 13 00:29:02 Debian kernel: [ 2898.781280] [19704]: scst: scst_cmd_thread:5643:Processing thread scst2990_7 started
Apr 13 00:29:02 Debian kernel: [ 2898.781352] [664]: scst: scst_process_tgt_enable_store:2320:Using autogenerated relative target id 16396 for target scst299
Apr 13 00:29:03 Debian kernel: [ 2899.786429] [664]: scst: __scst_process_luns_mgmt_store:1484:Removed all devices from group scst1
Apr 13 00:29:03 Debian kernel: [ 2899.786462] [664]: scst: __scst_acg_del_lun:4594:Removed LUN 0 from group scst1 (target scst1)
Apr 13 00:29:03 Debian kernel: [ 2899.786473] [664]: iscsi_scsi_aen:3801:SCSI AEN to sess ffff9407c973e040 (initiator iqn.2000-01.org.etherboot:COMP01)
Apr 13 00:29:03 Debian kernel: [ 2899.786570] [677]: scst_aen_done:2809:AEN ffff9407ef8d7268 (fn 0) done (initiator iqn.2000-01.org.etherboot:COMP01)
Apr 13 00:29:03 Debian kernel: [ 2899.801954] [1669]: scst: scst_cmd_thread:5807:Processing thread scst11_0 finished
Apr 13 00:29:03 Debian kernel: [ 2899.802026] [1670]: scst: scst_cmd_thread:5807:Processing thread scst11_1 finished
Apr 13 00:29:03 Debian kernel: [ 2899.802058] [1671]: scst: scst_cmd_thread:5807:Processing thread scst11_2 finished
Apr 13 00:29:03 Debian kernel: [ 2899.802104] [1672]: scst: scst_cmd_thread:5807:Processing thread scst11_3 finished
Apr 13 00:29:03 Debian kernel: [ 2899.802128] [1673]: scst: scst_cmd_thread:5807:Processing thread scst11_4 finished
Apr 13 00:29:03 Debian kernel: [ 2899.802165] [1674]: scst: scst_cmd_thread:5807:Processing thread scst11_5 finished
Apr 13 00:29:03 Debian kernel: [ 2899.802189] [1675]: scst: scst_cmd_thread:5807:Processing thread scst11_6 finished
Apr 13 00:29:03 Debian kernel: [ 2899.802224] [1676]: scst: scst_cmd_thread:5807:Processing thread scst11_7 finished
Apr 13 00:29:03 Debian kernel: [ 2899.804563] [664]: scst: __scst_acg_del_lun:4594:Removed LUN 16148 from group copy_manager_tgt (target copy_manager_tgt)
Apr 13 00:29:03 Debian kernel: [ 2899.806242] [675]: scst: scst_translate_lun:5025:tgt_dev for LUN 0 not found, command to unexisting LU (initiator iqn.2000-01.org.etherboot:COMP01, target scst1)?
Apr 13 00:29:03 Debian kernel: [ 2899.806265] [675]: iscsi_preliminary_complete:1539:Prelim completed req ffff9407f1e81080, orig_req ffff9407f1e81080 (FINAL 80, outstanding_r2t 0)
Apr 13 00:29:03 Debian kernel: [ 2899.806274] [675]: cmnd_prepare_get_rejected_immed_data:1476:Skipping (cmnd ffff9407f1e81080, ITT a7140000, op 1, cmd op a0, datasize 0, scst_cmd ffff9407d023bc80, scst state 2, status 2)
Apr 13 00:29:03 Debian kernel: [ 2899.806430] [675]: scst: scst_translate_lun:5025:tgt_dev for LUN 0 not found, command to unexisting LU (initiator iqn.2000-01.org.etherboot:COMP01, target scst1)?
Apr 13 00:29:03 Debian kernel: [ 2899.806447] [675]: iscsi_preliminary_complete:1539:Prelim completed req ffff9407f1df57c0, orig_req ffff9407f1df57c0 (FINAL 80, outstanding_r2t 0)
Apr 13 00:29:03 Debian kernel: [ 2899.806454] [675]: cmnd_prepare_get_rejected_immed_data:1476:Skipping (cmnd ffff9407f1df57c0, ITT a8140000, op 1, cmd op 12, datasize 0, scst_cmd ffff9407d023bc80, scst state 2, status 0)
Apr 13 00:29:03 Debian kernel: [ 2899.806689] [675]: scst: scst_translate_lun:5025:tgt_dev for LUN 0 not found, command to unexisting LU (initiator iqn.2000-01.org.etherboot:COMP01, target scst1)?
Apr 13 00:29:03 Debian kernel: [ 2899.806702] [675]: iscsi_preliminary_complete:1539:Prelim completed req ffff9407f1e81080, orig_req ffff9407f1e81080 (FINAL 80, outstanding_r2t 0)
Apr 13 00:29:03 Debian kernel: [ 2899.806709] [675]: cmnd_prepare_get_rejected_immed_data:1476:Skipping (cmnd ffff9407f1e81080, ITT a9140000, op 1, cmd op 12, datasize 0, scst_cmd ffff9407d023bc80, scst state 2, status 0)
Apr 13 00:29:03 Debian kernel: [ 2899.806914] [675]: scst: scst_translate_lun:5025:tgt_dev for LUN 1 not found, command to unexisting LU (initiator iqn.2000-01.org.etherboot:COMP01, target scst1)?
Apr 13 00:29:03 Debian kernel: [ 2899.806929] [675]: iscsi_preliminary_complete:1539:Prelim completed req ffff9407f1df57c0, orig_req ffff9407f1df57c0 (FINAL 80, outstanding_r2t 0)
Apr 13 00:29:03 Debian kernel: [ 2899.806937] [675]: cmnd_prepare_get_rejected_immed_data:1476:Skipping (cmnd ffff9407f1df57c0, ITT aa140000, op 1, cmd op 12, datasize 0, scst_cmd ffff9407d023bc80, scst state 2, status 0)
Apr 13 00:29:03 Debian kernel: [ 2899.807046] [675]: scst: scst_translate_lun:5025:tgt_dev for LUN 2 not found, command to unexisting LU (initiator iqn.2000-01.org.etherboot:COMP01, target scst1)?
Apr 13 00:29:03 Debian kernel: [ 2899.807059] [675]: iscsi_preliminary_complete:1539:Prelim completed req ffff9407f1e81080, orig_req ffff9407f1e81080 (FINAL 80, outstanding_r2t 0)
Apr 13 00:29:03 Debian kernel: [ 2899.807067] [675]: cmnd_prepare_get_rejected_immed_data:1476:Skipping (cmnd ffff9407f1e81080, ITT ab140000, op 1, cmd op 12, datasize 0, scst_cmd ffff9407d023bc80, scst state 2, status 0)
Apr 13 00:29:03 Debian kernel: [ 2899.807265] [675]: scst: scst_translate_lun:5025:tgt_dev for LUN 3 not found, command to unexisting LU (initiator iqn.2000-01.org.etherboot:COMP01, target scst1)?
Apr 13 00:29:03 Debian kernel: [ 2899.807278] [675]: iscsi_preliminary_complete:1539:Prelim completed req ffff9407f1df57c0, orig_req ffff9407f1df57c0 (FINAL 80, outstanding_r2t 0)
Apr 13 00:29:03 Debian kernel: [ 2899.807285] [675]: cmnd_prepare_get_rejected_immed_data:1476:Skipping (cmnd ffff9407f1df57c0, ITT ac140000, op 1, cmd op 12, datasize 0, scst_cmd ffff9407d023bc80, scst state 2, status 0)
Apr 13 00:29:03 Debian kernel: [ 2899.807468] [675]: scst: scst_translate_lun:5025:tgt_dev for LUN 4 not found, command to unexisting LU (initiator iqn.2000-01.org.etherboot:COMP01, target scst1)?
Apr 13 00:29:03 Debian kernel: [ 2899.807481] [675]: iscsi_preliminary_complete:1539:Prelim completed req ffff9407f1e81080, orig_req ffff9407f1e81080 (FINAL 80, outstanding_r2t 0)
Apr 13 00:29:03 Debian kernel: [ 2899.807488] [675]: cmnd_prepare_get_rejected_immed_data:1476:Skipping (cmnd ffff9407f1e81080, ITT ad140000, op 1, cmd op 12, datasize 0, scst_cmd ffff9407d023bc80, scst state 2, status 0)
Apr 13 00:29:03 Debian kernel: [ 2899.807672] [675]: scst: scst_translate_lun:5025:tgt_dev for LUN 5 not found, command to unexisting LU (initiator iqn.2000-01.org.etherboot:COMP01, target scst1)?
Apr 13 00:29:03 Debian kernel: [ 2899.807687] [675]: iscsi_preliminary_complete:1539:Prelim completed req ffff9407f1df57c0, orig_req ffff9407f1df57c0 (FINAL 80, outstanding_r2t 0)
Apr 13 00:29:03 Debian kernel: [ 2899.807694] [675]: cmnd_prepare_get_rejected_immed_data:1476:Skipping (cmnd ffff9407f1df57c0, ITT ae140000, op 1, cmd op 12, datasize 0, scst_cmd ffff9407d023bc80, scst state 2, status 0)
Apr 13 00:29:03 Debian kernel: [ 2899.807877] [675]: scst: scst_translate_lun:5025:tgt_dev for LUN 6 not found, command to unexisting LU (initiator iqn.2000-01.org.etherboot:COMP01, target scst1)?
Apr 13 00:29:03 Debian kernel: [ 2899.807890] [675]: iscsi_preliminary_complete:1539:Prelim completed req ffff9407f1e81080, orig_req ffff9407f1e81080 (FINAL 80, outstanding_r2t 0)
Apr 13 00:29:03 Debian kernel: [ 2899.807897] [675]: cmnd_prepare_get_rejected_immed_data:1476:Skipping (cmnd ffff9407f1e81080, ITT af140000, op 1, cmd op 12, datasize 0, scst_cmd ffff9407d023bc80, scst state 2, status 0)
Apr 13 00:29:03 Debian kernel: [ 2899.808080] [675]: scst: scst_translate_lun:5025:tgt_dev for LUN 7 not found, command to unexisting LU (initiator iqn.2000-01.org.etherboot:COMP01, target scst1)?
Apr 13 00:29:03 Debian kernel: [ 2899.808100] [675]: iscsi_preliminary_complete:1539:Prelim completed req ffff9407f1df57c0, orig_req ffff9407f1df57c0 (FINAL 80, outstanding_r2t 0)
Apr 13 00:29:03 Debian kernel: [ 2899.808107] [675]: cmnd_prepare_get_rejected_immed_data:1476:Skipping (cmnd ffff9407f1df57c0, ITT b0140000, op 1, cmd op 12, datasize 0, scst_cmd ffff9407d023bc80, scst state 2, status 0)
Apr 13 00:29:03 Debian kernel: [ 2899.817807] [664]: scst_free_all_UA:13205:Clearing UA for tgt_dev LUN 16148
Apr 13 00:29:03 Debian kernel: [ 2899.817829] [1660]: scst: scst_cmd_thread:5807:Processing thread scst10_0 finished
Apr 13 00:29:03 Debian kernel: [ 2899.817854] [1661]: scst: scst_cmd_thread:5807:Processing thread scst10_1 finished
Apr 13 00:29:03 Debian kernel: [ 2899.817877] [1662]: scst: scst_cmd_thread:5807:Processing thread scst10_2 finished
Apr 13 00:29:03 Debian kernel: [ 2899.817925] [1663]: scst: scst_cmd_thread:5807:Processing thread scst10_3 finished
Apr 13 00:29:03 Debian kernel: [ 2899.817940] [1664]: scst: scst_cmd_thread:5807:Processing thread scst10_4 finished
Apr 13 00:29:03 Debian kernel: [ 2899.817965] [1665]: scst: scst_cmd_thread:5807:Processing thread scst10_5 finished
Apr 13 00:29:03 Debian kernel: [ 2899.817979] [1666]: scst: scst_cmd_thread:5807:Processing thread scst10_6 finished
Apr 13 00:29:03 Debian kernel: [ 2899.818002] [1667]: scst: scst_cmd_thread:5807:Processing thread scst10_7 finished
Apr 13 00:29:03 Debian kernel: [ 2899.818050] [664]: dev_vdisk: vdisk_detach:1335:Detached virtual device scst1 ("/dev/mapper/scst1")
Apr 13 00:29:03 Debian kernel: [ 2899.818061] [664]: scst: scst_unregister_virtual_device:1481:Detached from virtual device scst1 (id 16149)

syslog

Apr 13 00:29:02 Debian kernel: [ 2898.781352] [664]: scst: scst_process_tgt_enable_store:2320:Using autogenerated relative target id 16396 for target scst299
Apr 13 00:29:03 Debian kernel: [ 2899.786429] [664]: scst: __scst_process_luns_mgmt_store:1484:Removed all devices from group scst1
Apr 13 00:29:03 Debian kernel: [ 2899.786462] [664]: scst: __scst_acg_del_lun:4594:Removed LUN 0 from group scst1 (target scst1)
Apr 13 00:29:03 Debian kernel: [ 2899.786473] [664]: iscsi_scsi_aen:3801:SCSI AEN to sess ffff9407c973e040 (initiator iqn.2000-01.org.etherboot:COMP01)
Apr 13 00:29:03 Debian kernel: [ 2899.786570] [677]: scst_aen_done:2809:AEN ffff9407ef8d7268 (fn 0) done (initiator iqn.2000-01.org.etherboot:COMP01)
Apr 13 00:29:03 Debian iscsi-scstd: Can't destroy target Device or resource busy 900
Apr 13 00:29:03 Debian kernel: [ 2899.801954] [1669]: scst: scst_cmd_thread:5807:Processing thread scst11_0 finished
Apr 13 00:29:03 Debian kernel: [ 2899.802026] [1670]: scst: scst_cmd_thread:5807:Processing thread scst11_1 finished
Apr 13 00:29:03 Debian kernel: [ 2899.802058] [1671]: scst: scst_cmd_thread:5807:Processing thread scst11_2 finished
Apr 13 00:29:03 Debian kernel: [ 2899.802104] [1672]: scst: scst_cmd_thread:5807:Processing thread scst11_3 finished
Apr 13 00:29:03 Debian kernel: [ 2899.802128] [1673]: scst: scst_cmd_thread:5807:Processing thread scst11_4 finished
Apr 13 00:29:03 Debian kernel: [ 2899.802165] [1674]: scst: scst_cmd_thread:5807:Processing thread scst11_5 finished
Apr 13 00:29:03 Debian kernel: [ 2899.802189] [1675]: scst: scst_cmd_thread:5807:Processing thread scst11_6 finished
Apr 13 00:29:03 Debian kernel: [ 2899.802224] [1676]: scst: scst_cmd_thread:5807:Processing thread scst11_7 finished
Apr 13 00:29:03 Debian kernel: [ 2899.804563] [664]: scst: __scst_acg_del_lun:4594:Removed LUN 16148 from group copy_manager_tgt (target copy_manager_tgt)
Apr 13 00:29:03 Debian kernel: [ 2899.806242] [675]: scst: scst_translate_lun:5025:tgt_dev for LUN 0 not found, command to unexisting LU (initiator iqn.2000-01.org.etherboot:COMP01, target scst1)?
Apr 13 00:29:03 Debian kernel: [ 2899.806265] [675]: iscsi_preliminary_complete:1539:Prelim completed req ffff9407f1e81080, orig_req ffff9407f1e81080 (FINAL 80, outstanding_r2t 0)
Apr 13 00:29:03 Debian kernel: [ 2899.806274] [675]: cmnd_prepare_get_rejected_immed_data:1476:Skipping (cmnd ffff9407f1e81080, ITT a7140000, op 1, cmd op a0, datasize 0, scst_cmd ffff9407d023bc80, scst state 2, status 2)
Apr 13 00:29:03 Debian kernel: [ 2899.806430] [675]: scst: scst_translate_lun:5025:tgt_dev for LUN 0 not found, command to unexisting LU (initiator iqn.2000-01.org.etherboot:COMP01, target scst1)?
Apr 13 00:29:03 Debian kernel: [ 2899.806447] [675]: iscsi_preliminary_complete:1539:Prelim completed req ffff9407f1df57c0, orig_req ffff9407f1df57c0 (FINAL 80, outstanding_r2t 0)
Apr 13 00:29:03 Debian kernel: [ 2899.806454] [675]: cmnd_prepare_get_rejected_immed_data:1476:Skipping (cmnd ffff9407f1df57c0, ITT a8140000, op 1, cmd op 12, datasize 0, scst_cmd ffff9407d023bc80, scst state 2, status 0)
Apr 13 00:29:03 Debian kernel: [ 2899.806689] [675]: scst: scst_translate_lun:5025:tgt_dev for LUN 0 not found, command to unexisting LU (initiator iqn.2000-01.org.etherboot:COMP01, target scst1)?
Apr 13 00:29:03 Debian kernel: [ 2899.806702] [675]: iscsi_preliminary_complete:1539:Prelim completed req ffff9407f1e81080, orig_req ffff9407f1e81080 (FINAL 80, outstanding_r2t 0)
Apr 13 00:29:03 Debian kernel: [ 2899.806709] [675]: cmnd_prepare_get_rejected_immed_data:1476:Skipping (cmnd ffff9407f1e81080, ITT a9140000, op 1, cmd op 12, datasize 0, scst_cmd ffff9407d023bc80, scst state 2, status 0)
Apr 13 00:29:03 Debian kernel: [ 2899.806914] [675]: scst: scst_translate_lun:5025:tgt_dev for LUN 1 not found, command to unexisting LU (initiator iqn.2000-01.org.etherboot:COMP01, target scst1)?
Apr 13 00:29:03 Debian kernel: [ 2899.806929] [675]: iscsi_preliminary_complete:1539:Prelim completed req ffff9407f1df57c0, orig_req ffff9407f1df57c0 (FINAL 80, outstanding_r2t 0)
Apr 13 00:29:03 Debian kernel: [ 2899.806937] [675]: cmnd_prepare_get_rejected_immed_data:1476:Skipping (cmnd ffff9407f1df57c0, ITT aa140000, op 1, cmd op 12, datasize 0, scst_cmd ffff9407d023bc80, scst state 2, status 0)
Apr 13 00:29:03 Debian kernel: [ 2899.807046] [675]: scst: scst_translate_lun:5025:tgt_dev for LUN 2 not found, command to unexisting LU (initiator iqn.2000-01.org.etherboot:COMP01, target scst1)?
Apr 13 00:29:03 Debian kernel: [ 2899.807059] [675]: iscsi_preliminary_complete:1539:Prelim completed req ffff9407f1e81080, orig_req ffff9407f1e81080 (FINAL 80, outstanding_r2t 0)
Apr 13 00:29:03 Debian kernel: [ 2899.807067] [675]: cmnd_prepare_get_rejected_immed_data:1476:Skipping (cmnd ffff9407f1e81080, ITT ab140000, op 1, cmd op 12, datasize 0, scst_cmd ffff9407d023bc80, scst state 2, status 0)
Apr 13 00:29:03 Debian kernel: [ 2899.807265] [675]: scst: scst_translate_lun:5025:tgt_dev for LUN 3 not found, command to unexisting LU (initiator iqn.2000-01.org.etherboot:COMP01, target scst1)?
Apr 13 00:29:03 Debian kernel: [ 2899.807278] [675]: iscsi_preliminary_complete:1539:Prelim completed req ffff9407f1df57c0, orig_req ffff9407f1df57c0 (FINAL 80, outstanding_r2t 0)
Apr 13 00:29:03 Debian kernel: [ 2899.807285] [675]: cmnd_prepare_get_rejected_immed_data:1476:Skipping (cmnd ffff9407f1df57c0, ITT ac140000, op 1, cmd op 12, datasize 0, scst_cmd ffff9407d023bc80, scst state 2, status 0)
Apr 13 00:29:03 Debian kernel: [ 2899.807468] [675]: scst: scst_translate_lun:5025:tgt_dev for LUN 4 not found, command to unexisting LU (initiator iqn.2000-01.org.etherboot:COMP01, target scst1)?
Apr 13 00:29:03 Debian kernel: [ 2899.807481] [675]: iscsi_preliminary_complete:1539:Prelim completed req ffff9407f1e81080, orig_req ffff9407f1e81080 (FINAL 80, outstanding_r2t 0)
Apr 13 00:29:03 Debian kernel: [ 2899.807488] [675]: cmnd_prepare_get_rejected_immed_data:1476:Skipping (cmnd ffff9407f1e81080, ITT ad140000, op 1, cmd op 12, datasize 0, scst_cmd ffff9407d023bc80, scst state 2, status 0)
Apr 13 00:29:03 Debian kernel: [ 2899.807672] [675]: scst: scst_translate_lun:5025:tgt_dev for LUN 5 not found, command to unexisting LU (initiator iqn.2000-01.org.etherboot:COMP01, target scst1)?
Apr 13 00:29:03 Debian kernel: [ 2899.807687] [675]: iscsi_preliminary_complete:1539:Prelim completed req ffff9407f1df57c0, orig_req ffff9407f1df57c0 (FINAL 80, outstanding_r2t 0)
Apr 13 00:29:03 Debian kernel: [ 2899.807694] [675]: cmnd_prepare_get_rejected_immed_data:1476:Skipping (cmnd ffff9407f1df57c0, ITT ae140000, op 1, cmd op 12, datasize 0, scst_cmd ffff9407d023bc80, scst state 2, status 0)
Apr 13 00:29:03 Debian kernel: [ 2899.807877] [675]: scst: scst_translate_lun:5025:tgt_dev for LUN 6 not found, command to unexisting LU (initiator iqn.2000-01.org.etherboot:COMP01, target scst1)?
Apr 13 00:29:03 Debian kernel: [ 2899.807890] [675]: iscsi_preliminary_complete:1539:Prelim completed req ffff9407f1e81080, orig_req ffff9407f1e81080 (FINAL 80, outstanding_r2t 0)

[valera]

апр 13 00:46:01 Debian kernel: [664]: scst: scst_translate_lun:5025:tgt_dev for LUN 74 not found, command to unexisting LU (initiator copy_manager_sess, target copy_manager_tgt)?
A feeling that he is over the moon if this is how you can make them infinite? if you can help record video of the simulation when and what causes the failure.

[Bart Van Assche]

Thank you for having provided the call traces. These show that waiting for commands happens on the context of a worker thread (inside sysfs_work_thread_fn()). I will see whether I can rework that code such that the waiting no longer happens on the context of a worker thread.

[valera]

If you can fix the fall, please write I will test, thank you.

[bilanich]

Please correct this error, thanks in advance.

[Evhen]

Good day. I also have a crash after a long use. Rebooting the server solves the problem, but this is not the best solution. Can I count on fix this bug?

[Bart Van Assche]

Please create a new ticket and report all relevant details instead of replying to an existing bug report.

[valera]

There are chances that fixed the destruction, all the experiments stopped, or this bug is not a priority for developers?.

[Bart Van Assche]

The first step in fixing a reported issue is to reproduce it. I have not yet been able to reproduce the reported behavior.

[Bart Van Assche]

Although I still have not been able to reproduce the reported behavior, a candidate fix has been checked in on the trunk. Further feedback is welcome.

[valera]

manifestation of panic kernel need half an hour of time, please check and whether you can correct, thank you.

[valera]

New test id 16386 remount

Linux DEBIAN10 4.19.0-5-amd64 #1 SMP Debian 4.19.37-5+deb10u1 (2019-07-19) x86_64 GNU/Linux

cat /sys/kernel/scst_tgt/trace_cmds
cmd 000000000ddac654: state EXEC_CHECK_BLOCKING; op REPORT LUNS; proc time 608 sec; tgtt iscsi; tgt scst1; session iqn.2000-01.org.etherboot:COMP01; grp scst1; LUN 0; ini iqn.2000-01.org.etherboot:COMP01; cdb a0 00 00 00 00 00 00 00 00 10 00 00

июл 23 09:38:47 DEBIAN10 kernel: INFO: task scst_uid:339 blocked for more than 120 seconds.
июл 23 09:38:47 DEBIAN10 kernel: Tainted: G OE 4.19.0-5-amd64 #1 Debian 4.19.37-5+deb10u1
июл 23 09:38:47 DEBIAN10 kernel: "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
июл 23 09:38:47 DEBIAN10 kernel: scst_uid D 0 339 2 0x80000000
июл 23 09:38:47 DEBIAN10 kernel: Call Trace:
июл 23 09:38:47 DEBIAN10 kernel: ? __schedule+0x2a2/0x870
июл 23 09:38:47 DEBIAN10 kernel: schedule+0x28/0x80
июл 23 09:38:47 DEBIAN10 kernel: schedule_timeout+0x26d/0x390
июл 23 09:38:47 DEBIAN10 kernel: ? vdev_find+0x60/0x60 [scst_vdisk]
июл 23 09:38:47 DEBIAN10 kernel: ? wake_up_klogd+0x30/0x40
июл 23 09:38:47 DEBIAN10 kernel: wait_for_completion+0x11f/0x190
июл 23 09:38:47 DEBIAN10 kernel: ? wake_up_q+0x70/0x70
июл 23 09:38:47 DEBIAN10 kernel: scst_free_device+0x6d/0x90 [scst]
июл 23 09:38:47 DEBIAN10 kernel: vdev_del_device+0x1e/0x40 [scst_vdisk]
июл 23 09:38:47 DEBIAN10 kernel: vdisk_del_device+0x3c/0x50 [scst_vdisk]
июл 23 09:38:47 DEBIAN10 kernel: scst_devt_mgmt_store_work_fn+0x18b/0x1a0 [scst]
июл 23 09:38:47 DEBIAN10 kernel: sysfs_work_thread_fn+0xff/0x330 [scst]
июл 23 09:38:47 DEBIAN10 kernel: ? finish_wait+0x80/0x80
июл 23 09:38:47 DEBIAN10 kernel: ? scst_devt_mgmt_store+0x20/0x20 [scst]
июл 23 09:38:47 DEBIAN10 kernel: kthread+0x112/0x130
июл 23 09:38:47 DEBIAN10 kernel: ? kthread_bind+0x30/0x30
июл 23 09:38:47 DEBIAN10 kernel: ret_from_fork+0x22/0x40

[valera]

июл 23 14:35:57 DEBIAN10 kernel: scst: Removed all devices from group scst3
июл 23 14:35:57 DEBIAN10 kernel: scst: Removed LUN 0 from group scst3 (target scst3)
июл 23 14:35:57 DEBIAN10 kernel: ------------[ cut here ]------------
июл 23 14:35:57 DEBIAN10 kernel: kernel BUG at mm/slub.c:294!
июл 23 14:35:57 DEBIAN10 kernel: invalid opcode: 0000 [#1] SMP NOPTI
июл 23 14:35:57 DEBIAN10 kernel: CPU: 0 PID: 11583 Comm: kworker/0:1 Tainted: G OE 4.19.0-5-amd64 #1 Debian 4.19.37-5+deb10u1
июл 23 14:35:57 DEBIAN10 kernel: Hardware name: System manufacturer System Product Name/M3A76-CM, BIOS 1001 07/09/2009
июл 23 14:35:57 DEBIAN10 kernel: Workqueue: events scst_tgt_dev_free_workfn [scst]
июл 23 14:35:57 DEBIAN10 kernel: RIP: 0010:kmem_cache_free+0x1ac/0x1d0
июл 23 14:35:57 DEBIAN10 kernel: Code: e4 5b 5d 41 5c c3 48 89 c5 e9 8e fe ff ff 48 89 fe 41 b8 01 00 00 00 48 89 d9 48 89 da 48 89 ef e8 e9 fa ff ff e9 10 ff ff ff <0f> 0b
июл 23 14:35:57 DEBIAN10 kernel: RSP: 0018:ffffb0690617fdf0 EFLAGS: 00010246
июл 23 14:35:57 DEBIAN10 kernel: RAX: ffff9fedac8b2000 RBX: ffff9fedac8b2000 RCX: ffff9fedac8b2000
июл 23 14:35:57 DEBIAN10 kernel: RDX: 000000000000286c RSI: ffff9fedb3a276d0 RDI: ffffd41844b22c00
июл 23 14:35:57 DEBIAN10 kernel: RBP: ffff9fedb2812c00 R08: 0000000000000001 R09: ffffffffc097d371
июл 23 14:35:57 DEBIAN10 kernel: R10: 0000000000000000 R11: 0000000000000000 R12: ffff9fedafa7b480
июл 23 14:35:57 DEBIAN10 kernel: R13: ffff9fedac833d20 R14: ffff9fedb07586c0 R15: ffff9fedac8b2028
июл 23 14:35:57 DEBIAN10 kernel: FS: 0000000000000000(0000) GS:ffff9fedb3a00000(0000) knlGS:0000000000000000
июл 23 14:35:57 DEBIAN10 kernel: CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
июл 23 14:35:57 DEBIAN10 kernel: CR2: 00007f7ecf00e690 CR3: 000000012d47a000 CR4: 00000000000006f0
июл 23 14:35:57 DEBIAN10 kernel: Call Trace:
июл 23 14:35:57 DEBIAN10 kernel: scst_free_tgt_dev+0xe1/0x170 [scst]
июл 23 14:35:57 DEBIAN10 kernel: scst_tgt_dev_free_workfn+0x32/0xd0 [scst]
июл 23 14:35:57 DEBIAN10 kernel: process_one_work+0x1a7/0x3a0
июл 23 14:35:57 DEBIAN10 kernel: worker_thread+0x30/0x390
июл 23 14:35:57 DEBIAN10 kernel: ? create_worker+0x1a0/0x1a0
июл 23 14:35:57 DEBIAN10 kernel: kthread+0x112/0x130
июл 23 14:35:57 DEBIAN10 kernel: ? kthread_bind+0x30/0x30
июл 23 14:35:57 DEBIAN10 kernel: ret_from_fork+0x22/0x40
июл 23 14:35:57 DEBIAN10 kernel: Modules linked in: dm_mod loop scst_vdisk(OE) isert_scst(OE) iscsi_scst(OE) scst(OE) rdma_cm iw_cm ib_cm ib_core dlm configfs libcrc32c snd_
июл 23 14:35:57 DEBIAN10 kernel: libphy floppy
июл 23 14:35:57 DEBIAN10 kernel: ---[ end trace 46def2565fa40a20 ]---
июл 23 14:35:57 DEBIAN10 kernel: RIP: 0010:kmem_cache_free+0x1ac/0x1d0
июл 23 14:35:57 DEBIAN10 kernel: Code: e4 5b 5d 41 5c c3 48 89 c5 e9 8e fe ff ff 48 89 fe 41 b8 01 00 00 00 48 89 d9 48 89 da 48 89 ef e8 e9 fa ff ff e9 10 ff ff ff <0f> 0b
июл 23 14:35:57 DEBIAN10 kernel: RSP: 0018:ffffb0690617fdf0 EFLAGS: 00010246
июл 23 14:35:57 DEBIAN10 kernel: RAX: ffff9fedac8b2000 RBX: ffff9fedac8b2000 RCX: ffff9fedac8b2000
июл 23 14:35:57 DEBIAN10 kernel: RDX: 000000000000286c RSI: ffff9fedb3a276d0 RDI: ffffd41844b22c00
июл 23 14:35:57 DEBIAN10 kernel: RBP: ffff9fedb2812c00 R08: 0000000000000001 R09: ffffffffc097d371
июл 23 14:35:57 DEBIAN10 kernel: R10: 0000000000000000 R11: 0000000000000000 R12: ffff9fedafa7b480
июл 23 14:35:57 DEBIAN10 kernel: R13: ffff9fedac833d20 R14: ffff9fedb07586c0 R15: ffff9fedac8b2028
июл 23 14:35:57 DEBIAN10 kernel: FS: 0000000000000000(0000) GS:ffff9fedb3a00000(0000) knlGS:0000000000000000
июл 23 14:35:57 DEBIAN10 kernel: CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
июл 23 14:35:57 DEBIAN10 kernel: CR2: 00007f7ecf00e690 CR3: 000000012d47a000 CR4: 00000000000006f0
июл 23 14:36:01 DEBIAN10 iscsi-scstd[374]: Connect from 192.168.0.1:51346 to 192.168.0.11:3260

root@DEBIAN10:~# cat /sys/kernel/scst_tgt/trace_cmds
cat: /sys/kernel/scst_tgt/trace_cmds: Ресурс временно недоступен

[Bart Van Assche]

Does trunk r8478 work better?

[valera]

8477 panic
8478 test write the result

[Bart Van Assche]

It would help a lot if you could mention all the steps involved in the
procedure that fails. What does e.g. replace sda1 on sda2 mean? Do you
change the SCST sysfs filename attribute or do you use LUN replacement?

[valera]

8478 test

Jul 25 12:26:08 Debian kernel: [ 1251.188745] scst: Added device scst1 to group scst1 (LUN 0, flags 0x2) to target scst1
Jul 25 12:26:08 Debian kernel: [ 1251.203667] scst: Removed all devices from group scst1
Jul 25 12:26:08 Debian kernel: [ 1251.203679] scst: Removed LUN 0 from group scst1 (target scst1)
Jul 25 12:26:08 Debian iscsi-scstd: Can't destroy target Device or resource busy 3
Jul 25 12:26:08 Debian iscsi-scstd: Can't send mgmt reply (cookie 65569, result -16, res -22): Invalid argument
Jul 25 12:26:08 Debian kernel: [ 1251.215931] scst: Removed LUN 16390 from group copy_manager_tgt (target copy_manager_tgt)
Jul 25 12:26:08 Debian kernel: [ 1251.231592] dev_vdisk: Detached virtual device scst1 ("/dev/sda2")
Jul 25 12:26:08 Debian kernel: [ 1251.231610] scst: Detached from virtual device scst1 (id 16390)
Jul 25 12:29:25 Debian kernel: [ 1447.404283] INFO: task scst_uid:412 blocked for more than 120 seconds.
Jul 25 12:29:25 Debian kernel: [ 1447.404303] Tainted: G O 4.9.0-8-amd64 #1 Debian 4.9.144-3.1
Jul 25 12:29:25 Debian kernel: [ 1447.404315] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
Jul 25 12:29:25 Debian kernel: [ 1447.404328] scst_uid D 0 412 2 0x00000000
Jul 25 12:29:25 Debian kernel: [ 1447.404337] ffff99b9b10b7ac0 0000000000000000 ffff99b9ae0b23c0 ffff99b9b7c18980
Jul 25 12:29:25 Debian kernel: [ 1447.404344] ffffffff8a611500 ffffa4fd80b8bca0 ffffffff8a0144b9 ffffffffc08f00ae
Jul 25 12:29:25 Debian kernel: [ 1447.404350] 0000000000000096 ffff99b9b7c18980 ffffffff89ac4cf2 ffff99b9ae0b23c0
Jul 25 12:29:25 Debian kernel: [ 1447.404356] Call Trace:
Jul 25 12:29:25 Debian kernel: [ 1447.404371] [<ffffffff8a0144b9>]</ffffffff8a0144b9> ? __schedule+0x239/0x6f0
Jul 25 12:29:25 Debian kernel: [ 1447.404381] [<ffffffff89ac4cf2>]</ffffffff89ac4cf2> ? up+0x12/0x60
Jul 25 12:29:25 Debian kernel: [ 1447.404387] [<ffffffff8a0149a2>]</ffffffff8a0149a2> ? schedule+0x32/0x80
Jul 25 12:29:25 Debian kernel: [ 1447.404392] [<ffffffff8a017d4d>]</ffffffff8a017d4d> ? schedule_timeout+0x1dd/0x380
Jul 25 12:29:25 Debian kernel: [ 1447.404399] [<ffffffff89ad2676>]</ffffffff89ad2676> ? vprintk_emit+0x316/0x4d0
Jul 25 12:29:25 Debian kernel: [ 1447.404406] [<ffffffff8a0153e1>]</ffffffff8a0153e1> ? wait_for_completion+0xf1/0x130
Jul 25 12:29:25 Debian kernel: [ 1447.404410] [<ffffffff89aa5a70>]</ffffffff89aa5a70> ? wake_up_q+0x70/0x70
Jul 25 12:29:25 Debian kernel: [ 1447.404457] [<ffffffffc08c69ed>]</ffffffffc08c69ed> ? scst_free_device+0x6d/0x90 [scst]
Jul 25 12:29:25 Debian kernel: [ 1447.404469] [<ffffffffc088ef9b>]</ffffffffc088ef9b> ? vdev_del_device+0x1b/0x50 [scst_vdisk]
Jul 25 12:29:25 Debian kernel: [ 1447.404479] [<ffffffffc088f00a>]</ffffffffc088f00a> ? vcdrom_del_device+0x3a/0x80 [scst_vdisk]
Jul 25 12:29:25 Debian kernel: [ 1447.404483] [<ffffffff8a01673e>]</ffffffff8a01673e> ? mutex_lock+0xe/0x30
Jul 25 12:29:25 Debian kernel: [ 1447.404520] [<ffffffffc08d49df>]</ffffffffc08d49df> ? scst_devt_mgmt_store_work_fn+0x16f/0x210 [scst]
Jul 25 12:29:25 Debian kernel: [ 1447.404558] [<ffffffffc08d4d49>]</ffffffffc08d4d49> ? sysfs_work_thread_fn+0xe9/0x300 [scst]
Jul 25 12:29:25 Debian kernel: [ 1447.404564] [<ffffffff89abd350>]</ffffffff89abd350> ? prepare_to_wait_event+0xf0/0xf0
Jul 25 12:29:25 Debian kernel: [ 1447.404600] [<ffffffffc08d4c60>]</ffffffffc08d4c60> ? scst_alloc_sysfs_work+0xc0/0xc0 [scst]
Jul 25 12:29:25 Debian kernel: [ 1447.404606] [<ffffffff89a9a5d9>]</ffffffff89a9a5d9> ? kthread+0xd9/0xf0
Jul 25 12:29:25 Debian kernel: [ 1447.404612] [<ffffffff89a9a500>]</ffffffff89a9a500> ? kthread_park+0x60/0x60
Jul 25 12:29:25 Debian kernel: [ 1447.404617] [<ffffffff8a0193e4>]</ffffffff8a0193e4> ? ret_from_fork+0x44/0x70

[valera]

an example of a failure

[valera]

Replacing sda1 with sda2 is just an example of replacing the target point for work, the work itself will be with a snapshot of the block device, after each reconstruction the machine receives a reference copy of the data, that is, when you restart windows and its data is always clean. All debris and viruses are destroyed. The problem is that when the target reaches 16000 cycles, it freezes and the point to reanimate the meringue server restart is no longer possible.. In the screenshots painted stage failure. Can You record a video of the experience so it will be clear?

new trunk test 8484 crashing at approximately the same point id16386

Even if I increase the re-creation interval, the scst freezes when it reaches 16000+ re-creatе

https://www.youtube.com/watch?v=easPv9cis5o

[Bart Van Assche]

Thank you for having provided a call trace. That is very helpful. Does the following patch help?

diff --git a/scst/src/scst_lib.c b/scst/src/scst_lib.c
index a461c291c787..2195c87f6fc7 100644
--- a/scst/src/scst_lib.c
+++ b/scst/src/scst_lib.c
@@ -4584,7 +4584,11 @@ void scst_free_tgt_dev_rcu(struct rcu_head *rcu)

    tgt_dev->a = scst_get();
    percpu_ref_get(&tgt_dev->dev->refcnt);
+#if LINUX_VERSION_CODE < KERNEL_VERSION(2, 6, 36)
    WARN_ON_ONCE(!schedule_work(&tgt_dev->free_work));
+#else

+   WARN_ON_ONCE(!queue_work(system_long_wq, &tgt_dev->free_work));
+#endif
 }

 /* Delete a LUN without generating a unit attention. */

[valera]

Trunk 8487 video failure
https://youtu.be/NlvdGOykQkU
Is this patch in trunk 8487? and I don't know how to use it if introduced, not helped again crashing.