On Tuesday 07 August 2018 09:29:59 Christoph Hellwig wrote: > Looks like the dma allocation is too late. Updated version below: > > ... Crashes a bit later now: [ 89.270529] scsi host2: Adaptec AHA-1542 (SCSI-ID 7) at IO 0x330, IRQ 11, DMA 7 [ 89.346535] scsi host2: Adaptec 1542 [ 89.358411] bounce: isa pool size: 16 pages [ 89.627133] WARNING: CPU: 0 PID: 0 at ./include/linux/dma-mapping.h:541 dma_free_attrs.constprop.8+0x29/0x76 [aha1542] [ 89.630753] Modules linked in: aha1542 i2c_dev nouveau psmouse serio_raw sg 8139cp wmi hwmon ttm parport_pc parport intel_agp [ 89.630753] CPU: 0 PID: 0 Comm: swapper/0 Not tainted 4.17.0+ #263 [ 89.630753] Hardware name: /i440ZX-W977TF, BIOS 4.51 PG 07/12/00 [ 89.630753] EIP: dma_free_attrs.constprop.8+0x29/0x76 [aha1542] [ 89.630753] EFLAGS: 00010086 CPU: 0 [ 89.630753] EAX: cfbda200 EBX: 00000086 ECX: c008d000 EDX: 00000006 [ 89.630753] ESI: 00000000 EDI: cf514aa0 EBP: cf80df64 ESP: cf80df54 [ 89.630753] DS: 007b ES: 007b FS: 00d8 GS: 0000 SS: 0068 [ 89.630753] CR0: 80050033 CR2: d0d3b000 CR3: 0fbad000 CR4: 00000290 [ 89.630753] Call Trace: [ 89.630753] <IRQ> [ 89.630753] aha1542_free_cmd+0x29/0x40 [aha1542] [ 89.630753] aha1542_interrupt+0x1be/0x267 [aha1542] [ 89.630753] ? scsi_dev_queue_ready+0x7f/0x7f [ 89.630753] __handle_irq_event_percpu+0x2f/0xb4 [ 89.630753] ? irq_set_chained_handler_and_data+0x4a/0x4a [ 89.630753] handle_irq_event_percpu+0x17/0x3d [ 89.630753] handle_irq_event+0x22/0x3b [ 89.630753] handle_level_irq+0x55/0x7a [ 89.630753] handle_irq+0x6c/0x81 [ 89.630753] </IRQ> [ 89.630753] do_IRQ+0x35/0x95 [ 89.630753] ? acpi_idle_enter_s2idle+0x41/0x41 [ 89.630753] common_interrupt+0x34/0x3c [ 89.630753] EIP: cpuidle_enter_state+0xca/0x125 [ 89.630753] EFLAGS: 00000246 CPU: 0 [ 89.630753] EAX: de2b83d5 EBX: 00000000 ECX: 00000014 EDX: cfde46e0 [ 89.630753] ESI: 00000002 EDI: cf213c80 EBP: cf661f48 ESP: cf661f28 [ 89.630753] DS: 007b ES: 007b FS: 00d8 GS: 0000 SS: 0068 [ 89.630753] ? acpi_idle_enter_s2idle+0x41/0x41 [ 89.630753] cpuidle_enter+0xf/0x12 [ 89.630753] do_idle+0x162/0x1b1 [ 89.630753] cpu_startup_entry+0x19/0x1b [ 89.630753] rest_init+0x8c/0x8e [ 89.630753] start_kernel+0x306/0x30b [ 89.630753] i386_start_kernel+0x95/0x99 [ 89.630753] startup_32_smp+0x15f/0x164 [ 89.630753] Code: 5d c3 55 85 c0 89 e5 57 56 53 53 74 0a 8b b8 20 01 00 00 85 ff 75 0c 8b 3d 08 aa 66 cf 85 ff 75 02 0f 0b 9c 5b 0f ba e3 09 72 02 <0f> 0b 89 45 f0 8d 42 ff 89 cb c1 e8 0c 83 c9 ff 89 d6 0f bd d0 [ 89.630753] ---[ end trace 3524d2ff63a5e038 ]--- [ 90.240799] scsi host2: Unexpected interrupt [ 90.244724] scsi host2: tarstat=0, hastat=11 idlun=0 ccb#=0 [ 100.293508] systemd-logind[1782]: Failed to start user service, ignoring: Unknown unit: user@0.service [ 100.416746] systemd-logind[1782]: New session c2 of user root. [ 111.096323] scsi 2:0:1:0: tag#0 Trying device reset for target [ 111.105632] scsi 2:0:1:0: tag#0 Trying device reset for target [ 111.114020] scsi host2: Sent BUS RESET to scsi host 2 [ 111.114020] WARNING: CPU: 0 PID: 1821 at ./include/linux/dma-mapping.h:541 dma_free_attrs.constprop.8+0x29/0x76 [aha1542] [ 111.114020] Modules linked in: aha1542 i2c_dev nouveau psmouse serio_raw sg 8139cp wmi hwmon ttm parport_pc parport intel_agp [ 111.114020] CPU: 0 PID: 1821 Comm: scsi_eh_2 Tainted: G W 4.17.0+ #263 [ 111.114020] Hardware name: /i440ZX-W977TF, BIOS 4.51 PG 07/12/00 [ 111.114020] EIP: dma_free_attrs.constprop.8+0x29/0x76 [aha1542] [ 111.114020] EFLAGS: 00010086 CPU: 0 [ 111.114020] EAX: cfbda200 EBX: 00000086 ECX: 00000000 EDX: 00000006 [ 111.114020] ESI: c0090000 EDI: cf514aa0 EBP: cbe89ebc ESP: cbe89eac [ 111.114020] DS: 007b ES: 007b FS: 00d8 GS: 0000 SS: 0068 [ 111.114020] CR0: 80050033 CR2: 0817ae44 CR3: 0bc2c000 CR4: 00000290 [ 111.114020] Call Trace: [ 111.114020] aha1542_free_cmd+0x29/0x40 [aha1542] [ 111.114020] aha1542_reset+0xb0/0xe5 [aha1542] [ 111.114020] aha1542_bus_reset+0xd/0xf [aha1542] [ 111.114020] scsi_try_bus_reset+0x4b/0x94 [ 111.114020] scsi_eh_ready_devs+0x5a4/0x781 [ 111.114020] scsi_error_handler+0x268/0x4b0 [ 111.114020] ? __schedule+0x38f/0x3dd [ 111.114020] kthread+0xcc/0xce [ 111.114020] ? scsi_eh_get_sense+0x16e/0x16e [ 111.114020] ? kthread_cancel_delayed_work_sync+0xf/0xf [ 111.114020] ret_from_fork+0x2e/0x38 [ 111.114020] Code: 5d c3 55 85 c0 89 e5 57 56 53 53 74 0a 8b b8 20 01 00 00 85 ff 75 0c 8b 3d 08 aa 66 cf 85 ff 75 02 0f 0b 9c 5b 0f ba e3 09 72 02 <0f> 0b 89 45 f0 8d 42 ff 89 cb c1 e8 0c 83 c9 ff 89 d6 0f bd d0 [ 111.114020] ---[ end trace 3524d2ff63a5e039 ]--- [ 111.114020] WARNING: CPU: 0 PID: 1821 at ./include/linux/dma-mapping.h:541 dma_free_attrs.constprop.8+0x29/0x76 [aha1542] [ 111.114020] Modules linked in: aha1542 i2c_dev nouveau psmouse serio_raw sg 8139cp wmi hwmon ttm parport_pc parport intel_agp [ 111.114020] CPU: 0 PID: 1821 Comm: scsi_eh_2 Tainted: G W 4.17.0+ #263 [ 111.114020] Hardware name: /i440ZX-W977TF, BIOS 4.51 PG 07/12/00 [ 111.114020] EIP: dma_free_attrs.constprop.8+0x29/0x76 [aha1542] [ 111.114020] EFLAGS: 00010086 CPU: 0 [ 111.114020] EAX: cfbda200 EBX: 00000086 ECX: 00000000 EDX: 00000006 [ 111.114020] ESI: c0090000 EDI: cf514aa0 EBP: cbe89ebc ESP: cbe89eac [ 111.114020] DS: 007b ES: 007b FS: 00d8 GS: 0000 SS: 0068 [ 111.114020] CR0: 80050033 CR2: 0817ae44 CR3: 0bc2c000 CR4: 00000290 [ 111.114020] Call Trace: [ 111.114020] aha1542_free_cmd+0x29/0x40 [aha1542] [ 111.114020] aha1542_reset+0xb0/0xe5 [aha1542] [ 111.114020] aha1542_bus_reset+0xd/0xf [aha1542] [ 111.114020] scsi_try_bus_reset+0x4b/0x94 [ 111.114020] scsi_eh_ready_devs+0x5a4/0x781 [ 111.114020] scsi_error_handler+0x268/0x4b0 [ 111.114020] ? __schedule+0x38f/0x3dd [ 111.114020] kthread+0xcc/0xce [ 111.114020] ? scsi_eh_get_sense+0x16e/0x16e [ 111.114020] ? kthread_cancel_delayed_work_sync+0xf/0xf [ 111.114020] ret_from_fork+0x2e/0x38 [ 111.114020] Code: 5d c3 55 85 c0 89 e5 57 56 53 53 74 0a 8b b8 20 01 00 00 85 ff 75 0c 8b 3d 08 aa 66 cf 85 ff 75 02 0f 0b 9c 5b 0f ba e3 09 72 02 <0f> 0b 89 45 f0 8d 42 ff 89 cb c1 e8 0c 83 c9 ff 89 d6 0f bd d0 [ 111.114020] ---[ end trace 3524d2ff63a5e03a ]--- [ 111.114020] WARNING: CPU: 0 PID: 1821 at ./include/linux/dma-mapping.h:541 dma_free_attrs.constprop.8+0x29/0x76 [aha1542] [ 111.114020] Modules linked in: aha1542 i2c_dev nouveau psmouse serio_raw sg 8139cp wmi hwmon ttm parport_pc parport intel_agp [ 111.114020] CPU: 0 PID: 1821 Comm: scsi_eh_2 Tainted: G W 4.17.0+ #263 [ 111.114020] Hardware name: /i440ZX-W977TF, BIOS 4.51 PG 07/12/00 [ 111.114020] EIP: dma_free_attrs.constprop.8+0x29/0x76 [aha1542] [ 111.114020] EFLAGS: 00010086 CPU: 0 [ 111.114020] EAX: cfbda200 EBX: 00000086 ECX: 00000000 EDX: 00000006 [ 111.114020] ESI: c0090000 EDI: cf514aa0 EBP: cbe89ebc ESP: cbe89eac [ 111.114020] DS: 007b ES: 007b FS: 00d8 GS: 0000 SS: 0068 [ 111.114020] CR0: 80050033 CR2: 0817ae44 CR3: 0bc2c000 CR4: 00000290 [ 111.114020] Call Trace: [ 111.114020] aha1542_free_cmd+0x29/0x40 [aha1542] [ 111.114020] aha1542_reset+0xb0/0xe5 [aha1542] [ 111.114020] aha1542_bus_reset+0xd/0xf [aha1542] [ 111.114020] scsi_try_bus_reset+0x4b/0x94 [ 111.114020] scsi_eh_ready_devs+0x5a4/0x781 [ 111.114020] scsi_error_handler+0x268/0x4b0 [ 111.114020] ? __schedule+0x38f/0x3dd [ 111.114020] kthread+0xcc/0xce [ 111.114020] ? scsi_eh_get_sense+0x16e/0x16e [ 111.114020] ? kthread_cancel_delayed_work_sync+0xf/0xf [ 111.114020] ret_from_fork+0x2e/0x38 [ 111.114020] Code: 5d c3 55 85 c0 89 e5 57 56 53 53 74 0a 8b b8 20 01 00 00 85 ff 75 0c 8b 3d 08 aa 66 cf 85 ff 75 02 0f 0b 9c 5b 0f ba e3 09 72 02 <0f> 0b 89 45 f0 8d 42 ff 89 cb c1 e8 0c 83 c9 ff 89 d6 0f bd d0 [ 111.114020] ---[ end trace 3524d2ff63a5e03b ]--- [ 111.114020] WARNING: CPU: 0 PID: 1821 at ./include/linux/dma-mapping.h:541 dma_free_attrs.constprop.8+0x29/0x76 [aha1542] [ 111.114020] Modules linked in: aha1542 i2c_dev nouveau psmouse serio_raw sg 8139cp wmi hwmon ttm parport_pc parport intel_agp [ 111.114020] CPU: 0 PID: 1821 Comm: scsi_eh_2 Tainted: G W 4.17.0+ #263 [ 111.114020] Hardware name: /i440ZX-W977TF, BIOS 4.51 PG 07/12/00 [ 111.114020] EIP: dma_free_attrs.constprop.8+0x29/0x76 [aha1542] [ 111.114020] EFLAGS: 00010086 CPU: 0 [ 111.114020] EAX: cfbda200 EBX: 00000086 ECX: 00000000 EDX: 00000006 [ 111.114020] ESI: c0090000 EDI: cf514aa0 EBP: cbe89ebc ESP: cbe89eac [ 111.114020] DS: 007b ES: 007b FS: 00d8 GS: 0000 SS: 0068 [ 111.114020] CR0: 80050033 CR2: 0817ae44 CR3: 0bc2c000 CR4: 00000290 [ 111.114020] Call Trace: [ 111.114020] aha1542_free_cmd+0x29/0x40 [aha1542] [ 111.114020] aha1542_reset+0xb0/0xe5 [aha1542] [ 111.114020] aha1542_bus_reset+0xd/0xf [aha1542] [ 111.114020] scsi_try_bus_reset+0x4b/0x94 [ 111.114020] scsi_eh_ready_devs+0x5a4/0x781 [ 111.114020] scsi_error_handler+0x268/0x4b0 [ 111.114020] ? __schedule+0x38f/0x3dd [ 111.114020] kthread+0xcc/0xce [ 111.114020] ? scsi_eh_get_sense+0x16e/0x16e [ 111.114020] ? kthread_cancel_delayed_work_sync+0xf/0xf [ 111.114020] ret_from_fork+0x2e/0x38 [ 111.114020] Code: 5d c3 55 85 c0 89 e5 57 56 53 53 74 0a 8b b8 20 01 00 00 85 ff 75 0c 8b 3d 08 aa 66 cf 85 ff 75 02 0f 0b 9c 5b 0f ba e3 09 72 02 <0f> 0b 89 45 f0 8d 42 ff 89 cb c1 e8 0c 83 c9 ff 89 d6 0f bd d0 [ 111.114020] ---[ end trace 3524d2ff63a5e03c ]--- [ 111.833619] scsi host2: Unexpected interrupt [ 111.837501] scsi host2: tarstat=0, hastat=11 idlun=0 ccb#=0 [ 122.084277] scsi 2:0:1:0: tag#0 Trying device reset for target [ 122.093295] scsi host2: Sent BUS RESET to scsi host 2 [ 122.093295] WARNING: CPU: 0 PID: 1821 at ./include/linux/dma-mapping.h:541 dma_free_attrs.constprop.8+0x29/0x76 [aha1542] [ 122.093295] Modules linked in: aha1542 i2c_dev nouveau psmouse serio_raw sg 8139cp wmi hwmon ttm parport_pc parport intel_agp [ 122.093295] CPU: 0 PID: 1821 Comm: scsi_eh_2 Tainted: G W 4.17.0+ #263 [ 122.093295] Hardware name: /i440ZX-W977TF, BIOS 4.51 PG 07/12/00 [ 122.093295] EIP: dma_free_attrs.constprop.8+0x29/0x76 [aha1542] [ 122.093295] EFLAGS: 00010086 CPU: 0 [ 122.093295] EAX: cfbda200 EBX: 00000086 ECX: 00000000 EDX: 00000006 [ 122.093295] ESI: c0090000 EDI: cf514aa0 EBP: cbe89ebc ESP: cbe89eac [ 122.093295] DS: 007b ES: 007b FS: 00d8 GS: 0000 SS: 0068 [ 122.093295] CR0: 80050033 CR2: 08321408 CR3: 0bcee000 CR4: 00000290 [ 122.093295] Call Trace: [ 122.093295] aha1542_free_cmd+0x29/0x40 [aha1542] [ 122.093295] aha1542_reset+0xb0/0xe5 [aha1542] [ 122.093295] aha1542_host_reset+0xd/0xf [aha1542] [ 122.093295] scsi_try_host_reset+0x4c/0x95 [ 122.093295] scsi_eh_ready_devs+0x689/0x781 [ 122.093295] scsi_error_handler+0x268/0x4b0 [ 122.093295] ? __schedule+0x38f/0x3dd [ 122.093295] kthread+0xcc/0xce [ 122.093295] ? scsi_eh_get_sense+0x16e/0x16e [ 122.093295] ? kthread_cancel_delayed_work_sync+0xf/0xf [ 122.093295] ret_from_fork+0x2e/0x38 [ 122.093295] Code: 5d c3 55 85 c0 89 e5 57 56 53 53 74 0a 8b b8 20 01 00 00 85 ff 75 0c 8b 3d 08 aa 66 cf 85 ff 75 02 0f 0b 9c 5b 0f ba e3 09 72 02 <0f> 0b 89 45 f0 8d 42 ff 89 cb c1 e8 0c 83 c9 ff 89 d6 0f bd d0 [ 122.093295] ---[ end trace 3524d2ff63a5e03d ]--- [ 122.093295] WARNING: CPU: 0 PID: 1821 at ./include/linux/dma-mapping.h:541 dma_free_attrs.constprop.8+0x29/0x76 [aha1542] [ 122.093295] Modules linked in: aha1542 i2c_dev nouveau psmouse serio_raw sg 8139cp wmi hwmon ttm parport_pc parport intel_agp [ 122.093295] CPU: 0 PID: 1821 Comm: scsi_eh_2 Tainted: G W 4.17.0+ #263 [ 122.093295] Hardware name: /i440ZX-W977TF, BIOS 4.51 PG 07/12/00 [ 122.093295] EIP: dma_free_attrs.constprop.8+0x29/0x76 [aha1542] [ 122.093295] EFLAGS: 00010086 CPU: 0 [ 122.093295] EAX: cfbda200 EBX: 00000086 ECX: 00000000 EDX: 00000006 [ 122.093295] ESI: c0090000 EDI: cf514aa0 EBP: cbe89ebc ESP: cbe89eac [ 122.093295] DS: 007b ES: 007b FS: 00d8 GS: 0000 SS: 0068 [ 122.093295] CR0: 80050033 CR2: 08321408 CR3: 0bcee000 CR4: 00000290 [ 122.093295] Call Trace: [ 122.093295] aha1542_free_cmd+0x29/0x40 [aha1542] [ 122.093295] aha1542_reset+0xb0/0xe5 [aha1542] [ 122.093295] aha1542_host_reset+0xd/0xf [aha1542] [ 122.093295] scsi_try_host_reset+0x4c/0x95 [ 122.093295] scsi_eh_ready_devs+0x689/0x781 [ 122.093295] scsi_error_handler+0x268/0x4b0 [ 122.093295] ? __schedule+0x38f/0x3dd [ 122.093295] kthread+0xcc/0xce [ 122.093295] ? scsi_eh_get_sense+0x16e/0x16e [ 122.093295] ? kthread_cancel_delayed_work_sync+0xf/0xf [ 122.093295] ret_from_fork+0x2e/0x38 [ 122.093295] Code: 5d c3 55 85 c0 89 e5 57 56 53 53 74 0a 8b b8 20 01 00 00 85 ff 75 0c 8b 3d 08 aa 66 cf 85 ff 75 02 0f 0b 9c 5b 0f ba e3 09 72 02 <0f> 0b 89 45 f0 8d 42 ff 89 cb c1 e8 0c 83 c9 ff 89 d6 0f bd d0 [ 122.093295] ---[ end trace 3524d2ff63a5e03e ]--- [ 132.580275] scsi 2:0:1:0: tag#0 Trying device reset for target [ 132.585659] scsi 2:0:1:0: Device offlined - not ready after error recovery [ 132.830010] scsi host2: Unexpected interrupt [ 132.833680] scsi host2: tarstat=0, hastat=0 idlun=20 ccb#=0 [ 133.083186] scsi host2: Unexpected interrupt [ 133.087100] scsi host2: tarstat=0, hastat=0 idlun=20 ccb#=0 -- Ondrej Zary
