From: Ondrej Zary <linux@rainbow-software.org>
To: Finn Thain <fthain@telegraphics.com.au>
Cc: Sam Creasey <sammy@sammy.net>,
Michael Schmitz <schmitzmic@gmail.com>,
"James E.J. Bottomley" <JBottomley@odin.com>,
linux-m68k@vger.kernel.org, linux-scsi@vger.kernel.org,
linux-kernel@vger.kernel.org
Subject: Re: [PATCH 00/71] More fixes, cleanup and modernization for NCR5380 drivers
Date: Fri, 20 Nov 2015 19:29:15 +0100 [thread overview]
Message-ID: <201511201929.17000.linux@rainbow-software.org> (raw)
In-Reply-To: <alpine.LNX.2.00.1511201238430.31133@nippy.intranet>
On Friday 20 November 2015 02:41:19 Finn Thain wrote:
>
> On Thu, 19 Nov 2015, Ondrej Zary wrote:
>
> > On Thursday 19 November 2015 03:24:56 Finn Thain wrote:
> >
> > > On Wed, 18 Nov 2015, Ondrej Zary wrote:
> > >
> > > >
> > > > I have some NCR5380 ISA cards and can test them.
> > >
> > > Thanks Ondrej. I've no idea which ISA drivers are presently working in
> > > mainline. Finding regressions may be more difficult than usual ;-)
> >
> > You're right... looks very broken:
> >
> > [ 62.577194] scsi host2: Generic NCR5380/NCR53C400 SCSI, io_port 0x240, n_io_port 16, base 0x0, irq 0, can_queue 16, cmd_per_lun 2,
> > sg_tablesize 128, this_id 7, flags { DTC3181E NO_PSEUDO_DMA }, USLEEP_POLL 3, USLEEP_WAITLONG 1250, options { AUTOPROBE_IRQ PSEUDO_DMA
> > NCR53C400 }
> > [ 62.796635] scsi 2:0:0:0: Direct-Access IBM 0663 e PQ: 0 ANSI: 2
> > [ 63.878494] sd 2:0:0:0: Attached scsi generic sg1 type 0
> > [ 95.848260] sd 2:0:0:0: aborting command
> >
> > And the system hangs completely.
> >
>
> Yes. That was the usual failure mode. The old EH abort routine is fatal.
> Up until I disabled PDMA by default for mac_scsi (in v3.19), that driver
> would do the same thing.
>
> > It's much better with your patches, but still not great :)
> >
>
> Pleased to hear it :)
>
> > [ 93.963264] pnp 01:01.00: [io 0x0240-0x025f]
> > [ 93.963493] pnp 01:01.00: [irq 5]
> > [ 93.965768] pnp 01:01.00: activated
> > [ 93.977147] scsi host2: Generic NCR5380/NCR53C400 SCSI, io_port 0x240, n_io_port 16, base 0x0, irq 0, can_queue 16, cmd_per_lun 2,
> > sg_tablesize 128, this_id 7, flags { DTC3181E NO_PSEUDO_DMA }, options { AUTOPROBE_IRQ PSEUDO_DMA }
> > [ 93.987527] scsi host2: rejecting message
> > [ 93.987647] Synchronous Data Transfer Request period = 100 ns offset = 12
> > [ 94.001219] scsi 2:0:0:0: Direct-Access IBM 0663 e PQ: 0 ANSI: 2
> > [ 113.000794] sd 2:0:0:0: Attached scsi generic sg1 type 0
>
> I'd be interested to know what commands were in play in that 19 second
> interval. Might need to use scsi_logging_level to figure that out.
>
> My tests involved 3 different scsi targets (two disks and a CD-ROM) but
> none of these send a SDTR. Your log says the driver correctly rejected the
> SDTR message but that doesn't mean the target actually went to MSG IN
> phase and got the message. Do you have any older targets you can test?
Another disk, without patches:
[ 84.481582] pnp 01:01.00: activated
[ 84.489650] scsi host2: Generic NCR5380/NCR53C400 SCSI, io_port 0x240, n_io_port 16, base 0x0, irq 0, can_queue 16, cmd_per_lun 2, sg_tablesize 128, this_id 7, flags { DTC3181E NO_PSEUDO_DMA }, USLEEP_POLL 3, USLEEP_WAITLONG 1250, options { AUTOPROBE_IRQ PSEUDO_DMA NCR53C400 }
[ 84.953332] scsi 2:0:1:0: Direct-Access QUANTUM LP240S GM240S01X 4.6 PQ: 0 ANSI: 2 CCS
[ 86.786475] sd 2:0:1:0: Attached scsi generic sg1 type 0
[ 86.793753] sd 2:0:1:0: [sdb] 479350 512-byte logical blocks: (245 MB/234 MiB)
[ 86.998555] sd 2:0:1:0: [sdb] Write Protect is off
[ 87.406068] sd 2:0:1:0: [sdb] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[ 118.888271] sd 2:0:1:0: [sdb] aborting command
[ 118.888738] sd 2:0:1:0: [sdb] aborting command
With patches:
[ 258.473748] pnp 01:01.00: activated
[ 258.483592] scsi host2: Generic NCR5380/NCR53C400 SCSI, io_port 0x240, n_io_port 16, base 0x0, irq 0, can_queue 16, cmd_per_lun 2, sg_tablesize 128, this_id 7, flags { DTC3181E NO_PSEUDO_DMA }, options { AUTOPROBE_IRQ PSEUDO_DMA }
[ 261.347632] scsi 2:0:1:0: Direct-Access QUANTUM LP240S GM240S01X 4.6 PQ: 0 ANSI: 2 CCS
[ 275.560451] sd 2:0:1:0: Attached scsi generic sg1 type 0
[ 275.632519] sd 2:0:1:0: [sdb] 479350 512-byte logical blocks: (245 MB/234 MiB)
[ 275.635533] sd 2:0:1:0: [sdb] Write Protect is off
[ 275.642315] sd 2:0:1:0: [sdb] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[ 469.076347] sd 2:0:1:0: [sdb] FAILED Result: hostbyte=DID_TIME_OUT driverbyte=DRIVER_SENSE
[ 469.076613] sd 2:0:1:0: [sdb] Sense Key : Aborted Command [current]
[ 469.076851] sd 2:0:1:0: [sdb] Add. Sense: No additional sense information
[ 469.077086] sd 2:0:1:0: [sdb] CDB: Read(10) 28 00 00 00 00 02 00 00 02 00
[ 469.077306] blk_update_request: I/O error, dev sdb, sector 2
[ 469.077522] Buffer I/O error on dev sdb, logical block 1, async page read
[ 480.108255] INFO: task kworker/u2:2:60 blocked for more than 120 seconds.
[ 480.109773] Not tainted 4.3.0-rc1+ #74
[ 480.109973] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 480.110179] kworker/u2:2 D 00000040 0 60 2 0x00000000
[ 480.110671] Workqueue: events_unbound async_run_entry_fn
[ 480.110999] cf9e8780 00000046 2eff25f7 00000040 c117f111 2ee82733 00000040 0016fec4
[ 480.112390] 00000000 cfaa6000 00000000 7fffffff c139c7d2 c139c504 7fffffff c139d9d3
[ 480.113661] 00000040 cfaa5cfc c106f460 00161108 00000000 0000c648 2106dcce 00000040
[ 480.114893] Call Trace:
[ 480.115124] [<c117f111>] ? blk_queue_bio+0x1e8/0x1fb
[ 480.115344] [<c139c7d2>] ? bit_wait_io_timeout+0x3d/0x3d
[ 480.115564] [<c139c504>] ? schedule+0x5b/0x67
[ 480.115794] [<c139d9d3>] ? schedule_timeout+0x13/0xc5
[ 480.116007] [<c106f460>] ? timekeeping_get_ns+0x10/0x69
[ 480.116406] [<c139c7d2>] ? bit_wait_io_timeout+0x3d/0x3d
[ 480.116636] [<c106fae7>] ? ktime_get+0x38/0x48
[ 480.116843] [<c139bf83>] ? io_schedule_timeout+0x83/0xd7
[ 480.117062] [<c139c7f3>] ? bit_wait_io+0x21/0x26
[ 480.117256] [<c139c697>] ? __wait_on_bit+0x2f/0x5a
[ 480.117486] [<c10ff1eb>] ? blkdev_readpages+0x15/0x15
[ 480.117704] [<c10ad361>] ? wait_on_page_bit+0x57/0x5e
[ 480.117942] [<c1054a98>] ? wake_atomic_t_function+0x2a/0x2a
[ 480.118151] [<c10ad386>] ? wait_on_page_read+0xf/0x2a
[ 480.118373] [<c10ae0e1>] ? do_read_cache_page+0x8e/0x116
[ 480.118587] [<c10ff1eb>] ? blkdev_readpages+0x15/0x15
[ 480.118809] [<c10ae192>] ? read_cache_page+0x14/0x18
[ 480.119008] [<c1189b0e>] ? read_dev_sector+0x25/0x57
[ 480.119222] [<c118a8a8>] ? adfspart_check_ICS+0x30/0x1ac
[ 480.119438] [<c119a3f1>] ? vsnprintf+0x78/0x25d
[ 480.119671] [<c119a614>] ? snprintf+0x16/0x18
[ 480.119874] [<c118a7ea>] ? check_partition+0xd7/0x165
[ 480.120253] [<c118a067>] ? rescan_partitions+0x95/0x283
[ 480.120443] [<c1254b50>] ? scsi_block_when_processing_errors+0x13/0xae
[ 480.120693] [<c139cbc6>] ? mutex_lock+0x9/0x21
[ 480.120915] [<c1100046>] ? __blkdev_get+0x155/0x2f6
[ 480.121133] [<c110032f>] ? blkdev_get+0x148/0x258
[ 480.121350] [<c10ec747>] ? unlock_new_inode+0x36/0x3c
[ 480.121570] [<c10ff106>] ? bdget+0xdc/0xe6
[ 480.121761] [<c118854f>] ? add_disk+0x221/0x368
[ 480.121996] [<c126321a>] ? sd_probe_async+0xed/0x157
[ 480.122214] [<c10443a0>] ? async_run_entry_fn+0x2c/0xad
[ 480.122437] [<c103f060>] ? process_one_work+0x130/0x21f
[ 480.122639] [<c103f2f6>] ? worker_thread+0x18a/0x247
[ 480.122854] [<c103f16c>] ? process_scheduled_works+0x1d/0x1d
[ 480.123069] [<c1042c46>] ? kthread+0x7c/0x81
[ 480.123288] [<c139e201>] ? ret_from_kernel_thread+0x21/0x30
[ 480.123493] [<c1042bca>] ? kthread_parkme+0x11/0x11
[ 480.123733] INFO: task modprobe:1977 blocked for more than 120 seconds.
[ 480.123919] Not tainted 4.3.0-rc1+ #74
[ 480.124239] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 480.124410] modprobe D 00000040 0 1977 1969 0x00000000
[ 480.124864] cfb20000 00000086 29042653 00000040 c1525f88 28a83a17 00000040 005bec3c
[ 480.126123] 00000000 ccdd0000 ffffffff ffffffff d2057280 c139c504 00000000 c104416d
[ 480.127354] 00000000 cfb20000 c1054a45 c151fd8c c151fd8c d2057280 00000000 ccd621f0
[ 480.128746] Call Trace:
[ 480.128961] [<c139c504>] ? schedule+0x5b/0x67
[ 480.129202] [<c104416d>] ? async_synchronize_cookie_domain+0x73/0x9f
[ 480.129449] [<c1054a45>] ? abort_exclusive_wait+0x6e/0x6e
[ 480.129667] [<c10ac9bc>] ? do_init_module+0xa4/0x1a3
[ 480.129899] [<c107ddb5>] ? load_module+0x14de/0x18ca
[ 480.130119] [<c107e2a0>] ? SyS_finit_module+0x47/0x56
[ 480.130346] [<c139e2c0>] ? sysenter_do_call+0x12/0x12
[ 502.100317] sd 2:0:1:0: [sdb] FAILED Result: hostbyte=DID_TIME_OUT driverbyte=DRIVER_SENSE
[ 502.100578] sd 2:0:1:0: [sdb] Sense Key : Aborted Command [current]
[ 502.100818] sd 2:0:1:0: [sdb] Add. Sense: No additional sense information
[ 502.101057] sd 2:0:1:0: [sdb] CDB: Read(10) 28 00 00 00 00 04 00 00 02 00
[ 502.101279] blk_update_request: I/O error, dev sdb, sector 4
[ 502.101495] Buffer I/O error on dev sdb, logical block 2, async page read
[ 600.128255] INFO: task kworker/u2:2:60 blocked for more than 120 seconds.
[ 600.128486] Not tainted 4.3.0-rc1+ #74
[ 600.128687] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 600.128891] kworker/u2:2 D 00000040 0 60 2 0x00000000
[ 600.129381] Workqueue: events_unbound async_run_entry_fn
[ 600.129709] cf9e8780 00000046 2eff25f7 00000040 c117f111 2ee82733 00000040 0016fec4
[ 600.130941] 00000000 cfaa6000 00000000 7fffffff c139c7d2 c139c504 7fffffff c139d9d3
[ 600.132342] 00000040 cfaa5cfc c106f460 00161108 00000000 0000c648 2106dcce 00000040
[ 600.133613] Call Trace:
[ 600.133821] [<c117f111>] ? blk_queue_bio+0x1e8/0x1fb
[ 600.134065] [<c139c7d2>] ? bit_wait_io_timeout+0x3d/0x3d
[ 600.134283] [<c139c504>] ? schedule+0x5b/0x67
[ 600.134509] [<c139d9d3>] ? schedule_timeout+0x13/0xc5
[ 600.134723] [<c106f460>] ? timekeeping_get_ns+0x10/0x69
[ 600.134948] [<c139c7d2>] ? bit_wait_io_timeout+0x3d/0x3d
[ 600.135154] [<c106fae7>] ? ktime_get+0x38/0x48
[ 600.135377] [<c139bf83>] ? io_schedule_timeout+0x83/0xd7
[ 600.135576] [<c139c7f3>] ? bit_wait_io+0x21/0x26
[ 600.135788] [<c139c697>] ? __wait_on_bit+0x2f/0x5a
[ 600.136000] [<c10ff1eb>] ? blkdev_readpages+0x15/0x15
[ 600.136399] [<c10ad361>] ? wait_on_page_bit+0x57/0x5e
[ 600.136607] [<c1054a98>] ? wake_atomic_t_function+0x2a/0x2a
[ 600.136838] [<c10ad386>] ? wait_on_page_read+0xf/0x2a
[ 600.137044] [<c10ae0e1>] ? do_read_cache_page+0x8e/0x116
[ 600.137276] [<c10ff1eb>] ? blkdev_readpages+0x15/0x15
[ 600.137481] [<c10ae192>] ? read_cache_page+0x14/0x18
[ 600.137699] [<c1189b0e>] ? read_dev_sector+0x25/0x57
[ 600.137901] [<c118a8a8>] ? adfspart_check_ICS+0x30/0x1ac
[ 600.138131] [<c119a3f1>] ? vsnprintf+0x78/0x25d
[ 600.138329] [<c119a614>] ? snprintf+0x16/0x18
[ 600.138544] [<c118a7ea>] ? check_partition+0xd7/0x165
[ 600.138738] [<c118a067>] ? rescan_partitions+0x95/0x283
[ 600.138962] [<c1254b50>] ? scsi_block_when_processing_errors+0x13/0xae
[ 600.139189] [<c139cbc6>] ? mutex_lock+0x9/0x21
[ 600.139427] [<c1100046>] ? __blkdev_get+0x155/0x2f6
[ 600.139632] [<c110032f>] ? blkdev_get+0x148/0x258
[ 600.139865] [<c10ec747>] ? unlock_new_inode+0x36/0x3c
[ 600.140263] [<c10ff106>] ? bdget+0xdc/0xe6
[ 600.140448] [<c118854f>] ? add_disk+0x221/0x368
[ 600.140689] [<c126321a>] ? sd_probe_async+0xed/0x157
[ 600.140908] [<c10443a0>] ? async_run_entry_fn+0x2c/0xad
[ 600.141133] [<c103f060>] ? process_one_work+0x130/0x21f
[ 600.141336] [<c103f2f6>] ? worker_thread+0x18a/0x247
[ 600.141552] [<c103f16c>] ? process_scheduled_works+0x1d/0x1d
[ 600.141764] [<c1042c46>] ? kthread+0x7c/0x81
[ 600.141982] [<c139e201>] ? ret_from_kernel_thread+0x21/0x30
[ 600.142186] [<c1042bca>] ? kthread_parkme+0x11/0x11
[ 600.142426] INFO: task modprobe:1977 blocked for more than 120 seconds.
[ 600.142612] Not tainted 4.3.0-rc1+ #74
[ 600.142787] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 600.142991] modprobe D 00000040 0 1977 1969 0x00000000
[ 600.143444] cfb20000 00000086 29042653 00000040 c1525f88 28a83a17 00000040 005bec3c
[ 600.144819] 00000000 ccdd0000 ffffffff ffffffff d2057280 c139c504 00000000 c104416d
[ 600.146052] 00000000 cfb20000 c1054a45 c151fd8c c151fd8c d2057280 00000000 ccd621f0
[ 600.147279] Call Trace:
[ 600.147489] [<c139c504>] ? schedule+0x5b/0x67
[ 600.147729] [<c104416d>] ? async_synchronize_cookie_domain+0x73/0x9f
[ 600.147992] [<c1054a45>] ? abort_exclusive_wait+0x6e/0x6e
[ 600.148390] [<c10ac9bc>] ? do_init_module+0xa4/0x1a3
[ 600.148627] [<c107ddb5>] ? load_module+0x14de/0x18ca
[ 600.148846] [<c107e2a0>] ? SyS_finit_module+0x47/0x56
[ 600.149073] [<c139e2c0>] ? sysenter_do_call+0x12/0x12
[ 662.100333] sd 2:0:1:0: [sdb] FAILED Result: hostbyte=DID_TIME_OUT driverbyte=DRIVER_SENSE
[ 662.100598] sd 2:0:1:0: [sdb] Sense Key : Aborted Command [current]
[ 662.100838] sd 2:0:1:0: [sdb] Add. Sense: No additional sense information
[ 662.101076] sd 2:0:1:0: [sdb] CDB: Read(10) 28 00 00 00 00 06 00 00 02 00
[ 662.101297] blk_update_request: I/O error, dev sdb, sector 6
[ 662.101512] Buffer I/O error on dev sdb, logical block 3, async page read
[ 720.148270] INFO: task modprobe:1977 blocked for more than 120 seconds.
[ 720.148499] Not tainted 4.3.0-rc1+ #74
[ 720.148699] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 720.148903] modprobe D 00000040 0 1977 1969 0x00000000
[ 720.149360] cfb20000 00000086 29042653 00000040 c1525f88 28a83a17 00000040 005bec3c
[ 720.150615] 00000000 ccdd0000 ffffffff ffffffff d2057280 c139c504 00000000 c104416d
[ 720.151836] 00000000 cfb20000 c1054a45 c151fd8c c151fd8c d2057280 00000000 ccd621f0
[ 720.153221] Call Trace:
[ 720.153465] [<c139c504>] ? schedule+0x5b/0x67
[ 720.153689] [<c104416d>] ? async_synchronize_cookie_domain+0x73/0x9f
[ 720.153931] [<c1054a45>] ? abort_exclusive_wait+0x6e/0x6e
[ 720.154149] [<c10ac9bc>] ? do_init_module+0xa4/0x1a3
[ 720.154379] [<c107ddb5>] ? load_module+0x14de/0x18ca
[ 720.154593] [<c107e2a0>] ? SyS_finit_module+0x47/0x56
[ 720.154820] [<c139e2c0>] ? sysenter_do_call+0x12/0x12
[ 781.025039] systemd-logind[1942]: New session c2 of user rainbow.
[ 840.152254] INFO: task kworker/u2:2:60 blocked for more than 120 seconds.
[ 840.152486] Not tainted 4.3.0-rc1+ #74
[ 840.152693] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 840.152903] kworker/u2:2 D 0000009a 0 60 2 0x00000000
[ 840.153399] Workqueue: events_unbound async_run_entry_fn
[ 840.153730] cf9e8780 00000046 2860b1ff 0000009a c117f111 284404dd 0000009a 001cad22
[ 840.156408] 00000000 cfaa6000 00000000 7fffffff c139c7d2 c139c504 7fffffff c139d9d3
[ 840.157689] 0000009a cfaa5c64 c106f460 00161e18 00000000 00013d94 006b70ce 0000009a
[ 840.158925] Call Trace:
[ 840.159158] [<c117f111>] ? blk_queue_bio+0x1e8/0x1fb
[ 840.159379] [<c139c7d2>] ? bit_wait_io_timeout+0x3d/0x3d
[ 840.159600] [<c139c504>] ? schedule+0x5b/0x67
[ 840.159834] [<c139d9d3>] ? schedule_timeout+0x13/0xc5
[ 840.160052] [<c106f460>] ? timekeeping_get_ns+0x10/0x69
[ 840.160446] [<c139c7d2>] ? bit_wait_io_timeout+0x3d/0x3d
[ 840.160677] [<c106fae7>] ? ktime_get+0x38/0x48
[ 840.160884] [<c139bf83>] ? io_schedule_timeout+0x83/0xd7
[ 840.161105] [<c139c7f3>] ? bit_wait_io+0x21/0x26
[ 840.161306] [<c139c697>] ? __wait_on_bit+0x2f/0x5a
[ 840.161541] [<c10ad361>] ? wait_on_page_bit+0x57/0x5e
[ 840.161767] [<c1054a98>] ? wake_atomic_t_function+0x2a/0x2a
[ 840.161997] [<c10ad386>] ? wait_on_page_read+0xf/0x2a
[ 840.162206] [<c10ae14f>] ? do_read_cache_page+0xfc/0x116
[ 840.162445] [<c10ff1eb>] ? blkdev_readpages+0x15/0x15
[ 840.162651] [<c10ae192>] ? read_cache_page+0x14/0x18
[ 840.162872] [<c1189b0e>] ? read_dev_sector+0x25/0x57
[ 840.163073] [<c118e22f>] ? read_lba+0x94/0x10b
[ 840.163289] [<c118e7eb>] ? efi_partition+0xbc/0x451
[ 840.163506] [<c10b5c33>] ? put_page+0x16/0x24
[ 840.163732] [<c10ad39d>] ? wait_on_page_read+0x26/0x2a
[ 840.163968] [<c10ff1eb>] ? blkdev_readpages+0x15/0x15
[ 840.164348] [<c10ae192>] ? read_cache_page+0x14/0x18
[ 840.164541] [<c118a8a8>] ? adfspart_check_ICS+0x30/0x1ac
[ 840.164777] [<c119a3f1>] ? vsnprintf+0x78/0x25d
[ 840.164977] [<c119a614>] ? snprintf+0x16/0x18
[ 840.165187] [<c118a7ea>] ? check_partition+0xd7/0x165
[ 840.165382] [<c118a067>] ? rescan_partitions+0x95/0x283
[ 840.165603] [<c1254b50>] ? scsi_block_when_processing_errors+0x13/0xae
[ 840.165829] [<c139cbc6>] ? mutex_lock+0x9/0x21
[ 840.166066] [<c1100046>] ? __blkdev_get+0x155/0x2f6
[ 840.166270] [<c110032f>] ? blkdev_get+0x148/0x258
[ 840.166501] [<c10ec747>] ? unlock_new_inode+0x36/0x3c
[ 840.166707] [<c10ff106>] ? bdget+0xdc/0xe6
[ 840.166914] [<c118854f>] ? add_disk+0x221/0x368
[ 840.167134] [<c126321a>] ? sd_probe_async+0xed/0x157
[ 840.167372] [<c10443a0>] ? async_run_entry_fn+0x2c/0xad
[ 840.167582] [<c103f060>] ? process_one_work+0x130/0x21f
[ 840.167802] [<c103f2f6>] ? worker_thread+0x18a/0x247
[ 840.168006] [<c103f16c>] ? process_scheduled_works+0x1d/0x1d
[ 840.168416] [<c1042c46>] ? kthread+0x7c/0x81
[ 840.168642] [<c139e201>] ? ret_from_kernel_thread+0x21/0x30
[ 840.168847] [<c1042bca>] ? kthread_parkme+0x11/0x11
[ 840.169094] INFO: task modprobe:1977 blocked for more than 120 seconds.
[ 840.169281] Not tainted 4.3.0-rc1+ #74
[ 840.169454] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 840.169659] modprobe D 00000040 0 1977 1969 0x00000000
[ 840.170114] cfb20000 00000086 29042653 00000040 c1525f88 28a83a17 00000040 005bec3c
[ 840.171368] 00000000 ccdd0000 ffffffff ffffffff d2057280 c139c504 00000000 c104416d
[ 840.172741] 00000000 cfb20000 c1054a45 c151fd8c c151fd8c d2057280 00000000 ccd621f0
[ 840.173986] Call Trace:
[ 840.174200] [<c139c504>] ? schedule+0x5b/0x67
[ 840.174443] [<c104416d>] ? async_synchronize_cookie_domain+0x73/0x9f
[ 840.174689] [<c1054a45>] ? abort_exclusive_wait+0x6e/0x6e
[ 840.174910] [<c10ac9bc>] ? do_init_module+0xa4/0x1a3
[ 840.175141] [<c107ddb5>] ? load_module+0x14de/0x18ca
[ 840.175359] [<c107e2a0>] ? SyS_finit_module+0x47/0x56
[ 840.175607] [<c139e2c0>] ? sysenter_do_call+0x12/0x12
[ 856.020359] sd 2:0:1:0: [sdb] FAILED Result: hostbyte=DID_TIME_OUT driverbyte=DRIVER_SENSE
[ 856.020623] sd 2:0:1:0: [sdb] Sense Key : Aborted Command [current]
[ 856.020862] sd 2:0:1:0: [sdb] Add. Sense: No additional sense information
[ 856.021101] sd 2:0:1:0: [sdb] CDB: Read(10) 28 00 00 00 00 02 00 00 02 00
[ 856.021324] blk_update_request: I/O error, dev sdb, sector 2
[ 856.021539] Buffer I/O error on dev sdb, logical block 1, async page read
[ 857.025325] sd 2:0:1:0: [sdb] FAILED Result: hostbyte=DID_ABORT driverbyte=DRIVER_OK
[ 857.025596] sd 2:0:1:0: [sdb] CDB: Read(10) 28 00 00 00 00 04 00 00 02 00
[ 857.025830] blk_update_request: I/O error, dev sdb, sector 4
[ 857.026043] Buffer I/O error on dev sdb, logical block 2, async page read
And a CD-ROM, first without patches:
[ 655.929795] pnp 01:01.00: activated
[ 655.939503] scsi host2: Generic NCR5380/NCR53C400 SCSI, io_port 0x240, n_io_port 16, base 0x0, irq 0, can_queue 16, cmd_per_lun 2, sg_tablesize 128, this_id 7, flags { DTC3181E NO_PSEUDO_DMA }, USLEEP_POLL 3, USLEEP_WAITLONG 1250, options { AUTOPROBE_IRQ PSEUDO_DMA NCR53C400 }
[ 656.441943] scsi 2:0:2:0: CD-ROM SONY CD-ROM CDU-55S 1.0t PQ: 0 ANSI: 2
[ 657.829087] scsi 2:0:2:0: Attached scsi generic sg1 type 5
[ 658.325517] sr 2:0:2:0: [sr0] scsi-1 drive
[ 658.325731] cdrom: Uniform CD-ROM driver Revision: 3.20
Modprobe succeeded but mount resulted in this & hang:
[ 694.056266] sr 2:0:2:0: [sr0] aborting command
Then with patches:
[ 109.753273] pnp 01:01.00: activated
[ 109.763039] scsi host2: Generic NCR5380/NCR53C400 SCSI, io_port 0x240, n_io_port 16, base 0x0, irq 0, can_queue 16, cmd_per_lun 2, sg_tablesize 128, this_id 7, flags { DTC3181E NO_PSEUDO_DMA }, options { AUTOPROBE_IRQ PSEUDO_DMA }
[ 115.456294] scsi 2:0:2:0: CD-ROM SONY CD-ROM CDU-55S 1.0t PQ: 0 ANSI: 2
[ 126.823400] scsi 2:0:2:0: Attached scsi generic sg1 type 5
[ 126.909680] sr 2:0:2:0: [sr0] scsi-1 drive
[ 126.909888] cdrom: Uniform CD-ROM driver Revision: 3.20
Modprobe succeeded but mount failed after some time with this:
[ 1005.149546] sr 2:0:2:0: [sr0] FAILED Result: hostbyte=DID_OK driverbyte=DRIVER_SENSE
[ 1005.149764] sr 2:0:2:0: [sr0] Sense Key : Illegal Request [current]
[ 1005.149992] sr 2:0:2:0: [sr0] Add. Sense: Logical block address out of range
[ 1005.150222] sr 2:0:2:0: [sr0] CDB: Read(10) 28 00 00 05 7a 94 00 00 02 00
[ 1005.150433] blk_update_request: critical target error, dev sr0, sector 1436240
[ 1005.154101] sr 2:0:2:0: [sr0] FAILED Result: hostbyte=DID_OK driverbyte=DRIVER_SENSE
[ 1005.154309] sr 2:0:2:0: [sr0] Sense Key : Illegal Request [current]
[ 1005.154533] sr 2:0:2:0: [sr0] Add. Sense: Logical block address out of range
[ 1005.156209] sr 2:0:2:0: [sr0] CDB: Read(10) 28 00 00 05 7a 94 00 00 02 00
[ 1005.156404] blk_update_request: critical target error, dev sr0, sector 1436240
[ 1005.156607] Buffer I/O error on dev sr0, logical block 179530, async page read
mount: unknown filesystem type 'iso9660'
--
Ondrej Zary
next prev parent reply other threads:[~2015-11-20 18:29 UTC|newest]
Thread overview: 182+ messages / expand[flat|nested] mbox.gz Atom feed top
2015-11-18 8:34 [PATCH 00/71] More fixes, cleanup and modernization for NCR5380 drivers Finn Thain
2015-11-18 8:34 ` [PATCH 01/71] atari_scsi: Fix SCSI host ID setting Finn Thain
2015-11-19 7:37 ` Hannes Reinecke
2015-11-18 8:34 ` [PATCH 02/71] ncr5380: Remove redundant static variable initializers Finn Thain
2015-11-19 7:37 ` Hannes Reinecke
2015-11-18 8:34 ` [PATCH 03/71] ncr5380: Eliminate PDEBUG*, TDEBUG* and DTCDEBUG* macros Finn Thain
2015-11-19 7:38 ` Hannes Reinecke
2015-11-18 8:34 ` [PATCH 04/71] ncr5380: Remove more pointless macros Finn Thain
2015-11-19 7:38 ` Hannes Reinecke
2015-11-18 8:35 ` [PATCH 05/71] ncr5380: Remove NCR5380_local_declare and NCR5380_setup macros Finn Thain
2015-11-19 7:41 ` Hannes Reinecke
2015-11-18 8:35 ` [PATCH 06/71] ncr5380: Remove NCR5380_instance_name macro Finn Thain
2015-11-19 7:41 ` Hannes Reinecke
2015-11-18 8:35 ` [PATCH 07/71] ncr5380: Split NCR5380_init() into two functions Finn Thain
2015-11-19 13:30 ` Hannes Reinecke
2015-11-18 8:35 ` [PATCH 08/71] ncr5380: Move NCR53C400-specific code Finn Thain
2015-11-19 13:31 ` Hannes Reinecke
2015-11-18 8:35 ` [PATCH 09/71] atari_NCR5380: Reset bus on driver initialization if required Finn Thain
2015-11-19 13:38 ` Hannes Reinecke
2015-11-18 8:35 ` [PATCH 10/71] atari_NCR5380: Remove RESET_BOOT, CONFIG_ATARI_SCSI_TOSHIBA_DELAY and CONFIG_ATARI_SCSI_RESET_BOOT Finn Thain
2015-11-19 3:05 ` Michael Schmitz
2015-11-19 4:05 ` Finn Thain
2015-11-19 4:43 ` Michael Schmitz
2015-11-19 13:41 ` Hannes Reinecke
2015-11-18 8:35 ` [PATCH 11/71] ncr5380: Simplify bus reset handlers Finn Thain
2015-11-19 13:56 ` Hannes Reinecke
2015-11-18 8:35 ` [PATCH 12/71] ncr5380: Remove unused hostdata->aborted flag Finn Thain
2015-11-19 14:13 ` Hannes Reinecke
2015-11-18 8:35 ` [PATCH 13/71] ncr5380: Remove redundant register writes Finn Thain
2015-11-19 14:14 ` Hannes Reinecke
2015-11-18 8:35 ` [PATCH 14/71] ncr5380: Use return instead of goto in NCR5380_select() Finn Thain
2015-11-19 14:14 ` Hannes Reinecke
2015-11-18 8:35 ` [PATCH 15/71] ncr5380: Always escalate bad target time-out " Finn Thain
2015-11-19 14:15 ` Hannes Reinecke
2015-11-18 8:35 ` [PATCH 16/71] ncr5380: Proceed with next command after NCR5380_select() calls scsi_done Finn Thain
2015-11-19 14:16 ` Hannes Reinecke
2015-11-18 8:35 ` [PATCH 17/71] ncr5380: Keep BSY asserted when entering SELECTION phase Finn Thain
2015-11-18 8:35 ` [PATCH 18/71] ncr5380: Eliminate USLEEP_WAITLONG delay Finn Thain
2015-11-18 8:35 ` [PATCH 19/71] ncr5380: Cleanup bogus {request,release}_region() calls Finn Thain
2015-11-18 8:35 ` [PATCH 20/71] ncr5380: Introduce unbound workqueue Finn Thain
2015-11-18 8:35 ` [PATCH 21/71] ncr5380: Sleep when polling, if possible Finn Thain
2015-11-18 8:35 ` [PATCH 22/71] ncr5380: Eliminate selecting state Finn Thain
2015-11-24 19:08 ` Ondrej Zary
2015-11-25 3:17 ` Finn Thain
2015-11-25 21:59 ` Ondrej Zary
2015-11-26 10:23 ` Finn Thain
2015-11-26 19:35 ` Ondrej Zary
2015-11-26 22:32 ` Finn Thain
2015-11-28 23:13 ` Ondrej Zary
2015-11-29 0:46 ` Finn Thain
2015-11-29 9:09 ` Ondrej Zary
2015-11-29 9:27 ` Geert Uytterhoeven
2015-11-29 10:25 ` Finn Thain
2015-11-29 13:50 ` Geert Uytterhoeven
2015-11-30 2:12 ` Finn Thain
2015-11-18 8:35 ` [PATCH 23/71] ncr5380: Always retry arbitration and selection Finn Thain
2015-11-18 8:35 ` [PATCH 24/71] ncr5380: Implement NCR5380_dma_xfer_len and remove LIMIT_TRANSFERSIZE macro Finn Thain
2015-11-18 8:35 ` [PATCH 25/71] ncr5380: Rework disconnect versus poll logic Finn Thain
2015-11-18 8:35 ` [PATCH 26/71] ncr5380: Fix NCR5380_transfer_pio() result Finn Thain
2015-11-18 8:35 ` [PATCH 27/71] ncr5380: Add missing lock in eh_abort_handler Finn Thain
2015-11-18 8:35 ` [PATCH 28/71] ncr5380: Drop DEF_SCSI_QCMD macro Finn Thain
2015-11-18 8:35 ` [PATCH 29/71] ncr5380: Remove references to linked commands Finn Thain
2015-11-18 8:35 ` [PATCH 30/71] ncr5380: Add missing break after case MESSAGE_REJECT Finn Thain
2015-11-18 8:35 ` [PATCH 31/71] ncr5380: Fix !REQ timeout in do_abort() Finn Thain
2015-11-18 8:35 ` [PATCH 32/71] ncr5380: Fix bus phase " Finn Thain
2015-11-18 8:35 ` [PATCH 33/71] atari_NCR5380: Set do_abort() timeouts Finn Thain
2015-11-18 8:35 ` [PATCH 34/71] atari_NCR5380: Use arbitration timeout Finn Thain
2015-11-18 8:35 ` [PATCH 35/71] ncr5380: Dont wait for BUS FREE after disconnect Finn Thain
2015-11-18 8:35 ` [PATCH 36/71] ncr5380: Use work_struct instead of delayed_work Finn Thain
2015-11-18 8:35 ` [PATCH 37/71] ncr5380: Standardize work queueing algorithm Finn Thain
2015-11-18 8:35 ` [PATCH 38/71] ncr5380: Remove UNSAFE macro Finn Thain
2015-11-18 8:35 ` [PATCH 39/71] ncr5380: Standardize interrupt handling Finn Thain
2015-11-18 8:35 ` [PATCH 40/71] ncr5380: Introduce NCR5380_poll_politely2 Finn Thain
2015-11-18 8:35 ` [PATCH 41/71] ncr5380: Replace redundant flags with FLAG_NO_DMA_FIXUP Finn Thain
2015-11-18 8:35 ` [PATCH 42/71] ncr5380: Replace READ_OVERRUNS macro with FLAG_NO_DMA_FIXUPS Finn Thain
2015-11-18 8:35 ` [PATCH 43/71] ncr5380: Standardize reselection handling Finn Thain
2015-11-18 8:35 ` [PATCH 44/71] ncr5380: Fix off-by-one bug in extended_msg[] bounds check Finn Thain
2015-11-18 8:35 ` [PATCH 45/71] ncr5380: Cleanup #include directives Finn Thain
2015-11-18 8:35 ` [PATCH 46/71] ncr5380: Fix NDEBUG_NO_DATAOUT flag Finn Thain
2015-11-18 8:35 ` [PATCH 47/71] ncr5380: Fix and cleanup scsi_host_template initializers Finn Thain
2015-11-18 8:35 ` [PATCH 48/71] atari_NCR5380: Fix queue_size limit Finn Thain
2015-11-18 8:35 ` [PATCH 49/71] atari_NCR5380: Introduce FLAG_DTC3181E Finn Thain
2015-11-18 8:35 ` [PATCH 50/71] ncr5380: Change instance->host_lock to hostdata->lock Finn Thain
2015-11-18 8:35 ` [PATCH 51/71] ncr5380: Remove command list debug code Finn Thain
2015-11-18 8:35 ` [PATCH 52/71] ncr5380: Remove H_NO macro and introduce dsprintk Finn Thain
2015-11-18 8:35 ` [PATCH 53/71] ncr5380: Use shost_priv helper Finn Thain
2015-11-18 8:35 ` [PATCH 54/71] ncr5380: Use dsprintk() for queue debugging Finn Thain
2015-11-18 8:35 ` [PATCH 55/71] ncr5380: Remove LIST and REMOVE macros Finn Thain
2015-11-18 8:35 ` [PATCH 56/71] ncr5380: Remove redundant volatile qualifiers Finn Thain
2015-11-18 8:35 ` [PATCH 57/71] ncr5380: Use standard list data structure Finn Thain
2015-11-18 8:35 ` [PATCH 58/71] ncr5380: Refactor command completion Finn Thain
2015-11-18 8:35 ` [PATCH 59/71] ncr5380: Fix autosense bugs Finn Thain
2015-11-18 8:35 ` [PATCH 60/71] ncr5380: Implement new eh_abort_handler Finn Thain
2015-11-18 8:35 ` [PATCH 61/71] ncr5380: Fix EH during arbitration and selection Finn Thain
2015-11-18 8:35 ` [PATCH 62/71] ncr5380: Implement new eh_bus_reset_handler Finn Thain
2015-11-18 8:35 ` [PATCH 63/71] atari_NCR5380: Remove HOSTNO macro from printk() and seq_printf() calls Finn Thain
2015-11-18 8:35 ` [PATCH 64/71] atari_NCR5380: Eliminate HOSTNO macro Finn Thain
2015-11-18 8:36 ` [PATCH 65/71] atari_scsi, sun3_scsi: Remove global Scsi_Host pointer Finn Thain
2015-11-18 8:36 ` [PATCH 66/71] ncr5380: Fix soft lockups Finn Thain
2015-11-18 8:36 ` [PATCH 67/71] ncr5380: Cleanup comments Finn Thain
2015-11-18 8:36 ` [PATCH 68/71] ncr5380: Fix whitespace issues using regexp Finn Thain
2015-11-18 8:36 ` [PATCH 69/71] ncr5380: Merge changes from atari_NCR5380.c Finn Thain
2015-11-18 8:36 ` [PATCH 70/71] atari_NCR5380: Merge changes from NCR5380.c Finn Thain
2015-11-18 8:36 ` [PATCH 71/71] ncr5380: Cleanup whitespace and parentheses Finn Thain
2015-11-18 11:35 ` [PATCH 00/71] More fixes, cleanup and modernization for NCR5380 drivers Ondrej Zary
2015-11-19 2:24 ` Finn Thain
2015-11-19 2:52 ` Michael Schmitz
2015-11-19 7:48 ` Ondrej Zary
2015-11-19 22:50 ` Ondrej Zary
2015-11-20 1:41 ` Finn Thain
2015-11-20 7:21 ` Finn Thain
2015-11-20 7:33 ` Christoph Hellwig
2015-11-20 8:19 ` Finn Thain
2015-11-20 9:16 ` Ondrej Zary
2015-11-20 10:00 ` Christoph Hellwig
2015-11-20 10:53 ` Finn Thain
2015-11-20 11:40 ` Ondrej Zary
2015-11-20 11:45 ` Christoph Hellwig
2015-11-20 12:23 ` Geert Uytterhoeven
2015-11-20 12:46 ` Ondrej Zary
2015-11-20 7:35 ` Ondrej Zary
2015-11-20 18:29 ` Ondrej Zary [this message]
2015-11-21 1:58 ` Finn Thain
2015-11-21 13:01 ` Ondrej Zary
2015-11-21 23:07 ` Ondrej Zary
2015-11-21 23:32 ` Finn Thain
2015-11-23 22:55 ` Ondrej Zary
2015-11-24 1:21 ` Finn Thain
2015-11-24 8:04 ` Ondrej Zary
2015-11-24 9:13 ` Finn Thain
2015-11-24 12:03 ` Ondrej Zary
2015-11-24 18:04 ` Ondrej Zary
2015-11-24 21:40 ` Ondrej Zary
2015-11-25 2:10 ` Finn Thain
2015-11-25 9:04 ` Ondrej Zary
2015-11-25 11:50 ` Finn Thain
2015-11-25 23:01 ` Ondrej Zary
2015-11-25 21:34 ` [PATCH 72/71] ncr5380: Fix pseudo-DMA Ondrej Zary
2015-11-29 9:39 ` [RFC PATCH 73/71] ncr5380: Use runtime register mapping Ondrej Zary
2015-11-30 11:50 ` Finn Thain
2015-11-29 9:39 ` [RFC PATCH 74/71] ncr5380: Enable PDMA for NCR53C400A Ondrej Zary
2015-11-30 11:52 ` Finn Thain
2015-11-30 12:04 ` Finn Thain
2015-11-30 13:40 ` Ondrej Zary
2015-12-06 3:20 ` Finn Thain
2015-11-29 10:01 ` [RFC PATCH 75/71] ncr5380: Remove FLAG_DTC3181E Ondrej Zary
2015-11-30 4:56 ` Finn Thain
2015-12-03 23:03 ` [RFC PATCH 76/71] ncr5380: Enable PDMA for DTC chips Ondrej Zary
2015-12-04 0:12 ` Julian Calaby
2015-12-04 8:38 ` Finn Thain
2015-12-05 1:32 ` Julian Calaby
2015-12-05 2:12 ` Finn Thain
2015-12-05 2:38 ` Julian Calaby
2015-12-04 9:08 ` Finn Thain
2015-12-04 9:32 ` Ondrej Zary
2015-12-04 9:20 ` Finn Thain
2015-12-03 23:03 ` [RFC PATCH 77/71] ncr5380: Fix wait for 53C80 registers registers after PDMA Ondrej Zary
2015-12-04 21:00 ` [PATCH 73/71] ncr5380: Use runtime register mapping Ondrej Zary
2015-12-06 3:39 ` Finn Thain
2015-12-06 8:42 ` Geert Uytterhoeven
2015-12-04 21:02 ` [PATCH 74/71] ncr5380: Enable PDMA for NCR53C400A Ondrej Zary
2015-12-06 3:41 ` Finn Thain
2015-12-04 21:17 ` [PATCH 76/71] ncr5380: Enable PDMA for DTC chips Ondrej Zary
2015-12-06 3:40 ` Finn Thain
2015-12-06 22:47 ` Ondrej Zary
2015-12-05 21:18 ` [RFC PATCH 78/71] ncr5380: Add support for HP 53C400A-based cards (C2502) Ondrej Zary
2015-12-06 3:39 ` Finn Thain
2015-12-06 22:20 ` [PATCH v2 73/71] ncr5380: Use runtime register mapping Ondrej Zary
2015-12-06 22:21 ` [PATCH v2 74/71] ncr5380: Enable PDMA for NCR53C400A Ondrej Zary
2015-12-08 2:05 ` Finn Thain
2015-12-09 13:39 ` Ondrej Zary
2015-12-10 23:39 ` Finn Thain
2015-12-06 22:55 ` [PATCH v2 76/71] ncr5380: Enable PDMA for DTC chips Ondrej Zary
2015-12-06 23:17 ` [PATCH v2 77/71] ncr5380: Fix wait for 53C80 registers registers after PDMA Ondrej Zary
2015-12-07 3:16 ` Finn Thain
2015-12-07 8:08 ` Ondrej Zary
2015-12-06 23:20 ` [PATCH v3 76/71] ncr5380: Enable PDMA for DTC chips Ondrej Zary
2015-12-08 7:51 ` [PATCH v2 78/71] ncr5380: Add support for HP 53C400A-based cards (C2502) Ondrej Zary
2015-12-08 11:40 ` Finn Thain
2015-12-09 11:33 ` Ondrej Zary
2015-12-10 23:38 ` Finn Thain
2015-12-09 12:11 ` [PATCH v3 " Ondrej Zary
Reply instructions:
You may reply publicly to this message via plain-text email
using any one of the following methods:
* Save the following mbox file, import it into your mail client,
and reply-to-all from there: mbox
Avoid top-posting and favor interleaved quoting:
https://en.wikipedia.org/wiki/Posting_style#Interleaved_style
* Reply using the --to, --cc, and --in-reply-to
switches of git-send-email(1):
git send-email \
--in-reply-to=201511201929.17000.linux@rainbow-software.org \
--to=linux@rainbow-software.org \
--cc=JBottomley@odin.com \
--cc=fthain@telegraphics.com.au \
--cc=linux-kernel@vger.kernel.org \
--cc=linux-m68k@vger.kernel.org \
--cc=linux-scsi@vger.kernel.org \
--cc=sammy@sammy.net \
--cc=schmitzmic@gmail.com \
/path/to/YOUR_REPLY
https://kernel.org/pub/software/scm/git/docs/git-send-email.html
* If your mail client supports setting the In-Reply-To header
via mailto: links, try the mailto: link
Be sure your reply has a Subject: header at the top and a blank line
before the message body.
This is a public inbox, see mirroring instructions
for how to clone and mirror all data and code used for this inbox;
as well as URLs for NNTP newsgroup(s).