From mboxrd@z Thu Jan 1 00:00:00 1970 From: Heiko =?ISO-8859-1?Q?St=FCbner?= Subject: poweroff-issue with dwc2 on Felipe's testing/next branch Date: Wed, 16 Dec 2015 00:49:37 +0100 Message-ID: <2855104.z6YbyzHk7K@diego> Mime-Version: 1.0 Content-Type: text/plain; charset="us-ascii" Content-Transfer-Encoding: 7Bit Return-path: Sender: linux-usb-owner-u79uwXL29TY76Z2rM5mHXA@public.gmane.org To: balbi-l0cyMroinI0@public.gmane.org Cc: john.youn-HKixBCOQz3hWk0Htik3J/w@public.gmane.org, linux-usb-u79uwXL29TY76Z2rM5mHXA@public.gmane.org, linux-rockchip-IAPFreCvJWM7uuMidbF8XUB+6BGkLq7r@public.gmane.org, Doug Anderson List-Id: linux-rockchip.vger.kernel.org Hi, it seems the recent dwc2 additions to the testing/next branch [0] caused some interesting issue for me. Setting is a regular 4.4-rc3/4 (only with some display-stuff added), and the testing/next branch merged in. If I attach a single usb device everything still works fine, but once it is connected through a hub, like the following: root@localhost:~# lsusb -t /: Bus 02.Port 1: Dev 1, Class=root_hub, Driver=ehci-platform/1p, 480M |__ Port 1: Dev 2, If 0, Class=Video, Driver=, 480M |__ Port 1: Dev 2, If 1, Class=Video, Driver=, 480M /: Bus 01.Port 1: Dev 1, Class=root_hub, Driver=dwc2/1p, 480M |__ Port 1: Dev 2, If 0, Class=Hub, Driver=hub/5p, 480M |__ Port 1: Dev 3, If 0, Class=Vendor Specific Class, Driver=smsc95xx, 480M |__ Port 2: Dev 4, If 0, Class=Mass Storage, Driver=usb-storage, 480M I get strange results when powering off the device with the usb device still attached. On regular 4.4-rc3 root@localhost:~# poweroff ... reboot: Power down ~20sec delay before actual poweroff [that delay is only present with a usb hub in between, probably due to the big number of interrupts it creates] With testing/next the device cannot poweroff anymore and instead I get [ 40.117160] reboot: Power down [ 68.031372] NMI watchdog: BUG: soft lockup - CPU#0 stuck for 22s! [systemd-shutdow:1] [ 68.046575] Modules linked in: [ 68.053084] irq event stamp: 1654975 [ 68.060091] hardirqs last enabled at (1654974): [] __irq_svc+0x5c/0x78 [ 68.074935] hardirqs last disabled at (1654975): [] __irq_svc+0x48/0x78 [ 68.089666] softirqs last enabled at (1654846): [] __do_softirq+0x358/0x49c [ 68.105261] softirqs last disabled at (1654847): [] irq_exit+0x94/0xd4 [ 68.120027] CPU: 0 PID: 1 Comm: systemd-shutdow Not tainted 4.4.0-rc4+ #2761 [ 68.133507] Hardware name: Rockchip (Device Tree) [ 68.142690] task: ee900d40 ti: ee902000 task.ti: ee902000 [ 68.153237] PC is at rcu_lockdep_current_cpu_online+0x6c/0x90 [ 68.164438] LR is at rcu_read_lock_held+0x38/0x58 [ 68.173683] pc : [] lr : [] psr: 00010113 [ 68.173683] sp : ee903be8 ip : ee903bf8 fp : ee903bf4 [ 68.195300] r10: c0b884f8 r9 : 00000000 r8 : c0b884f8 [ 68.205429] r7 : ffffbccc r6 : eed7f680 r5 : 00000001 r4 : ee955800 [ 68.217938] r3 : ee902028 r2 : 0000000f r1 : c0b1891c r0 : 00000001 [ 68.230482] Flags: nzcv IRQs on FIQs on Mode SVC_32 ISA ARM Segment none [ 68.244141] Control: 10c5387d Table: 2dae806a DAC: 00000051 [ 68.255283] CPU: 0 PID: 1 Comm: systemd-shutdow Not tainted 4.4.0-rc4+ #2761 [ 68.268720] Hardware name: Rockchip (Device Tree) [ 68.278165] [] (unwind_backtrace) from [] (show_stack+0x20/0x24) [ 68.293198] [] (show_stack) from [] (dump_stack+0x84/0xb8) [ 68.307285] [] (dump_stack) from [] (show_regs+0x1c/0x20) [ 68.321205] [] (show_regs) from [] (watchdog_timer_fn+0x1c8/0x250) [ 68.336579] [] (watchdog_timer_fn) from [] (__hrtimer_run_queues+0x2cc/0x55c) [ 68.353819] [] (__hrtimer_run_queues) from [] (hrtimer_interrupt+0xac/0x1f8) [ 68.370795] [] (hrtimer_interrupt) from [] (arch_timer_handler_phys+0x38/0x48) [ 68.388044] [] (arch_timer_handler_phys) from [] (handle_percpu_devid_irq+0x15c/0x314) [ 68.406687] [] (handle_percpu_devid_irq) from [] (generic_handle_irq+0x28/0x38) [ 68.424177] [] (generic_handle_irq) from [] (__handle_domain_irq+0x9c/0xc4) [ 68.440945] [] (__handle_domain_irq) from [] (gic_handle_irq+0x58/0x80) [ 68.457054] [] (gic_handle_irq) from [] (__irq_svc+0x58/0x78) [ 68.471405] Exception stack(0xee903b98 to 0xee903be0) [ 68.481288] 3b80: 00000001 c0b1891c [ 68.497074] 3ba0: 0000000f ee902028 ee955800 00000001 eed7f680 ffffbccc c0b884f8 00000000 [ 68.512875] 3bc0: c0b884f8 ee903bf4 ee903bf8 ee903be8 c0094d00 c0095e98 00010113 ffffffff [ 68.528713] [] (__irq_svc) from [] (rcu_lockdep_current_cpu_online+0x6c/0x90) [ 68.545915] [] (rcu_lockdep_current_cpu_online) from [] (rcu_read_lock_held+0x38/0x58) [ 68.564535] [] (rcu_read_lock_held) from [] (run_rebalance_domains+0x114/0x3e4) [ 68.582013] [] (run_rebalance_domains) from [] (__do_softirq+0x1d8/0x49c) [ 68.598529] [] (__do_softirq) from [] (irq_exit+0x94/0xd4) [ 68.612591] [] (irq_exit) from [] (__handle_domain_irq+0xa0/0xc4) [ 68.808119] [] (__handle_domain_irq) from [] (gic_handle_irq+0x58/0x80) [ 69.004792] [] (gic_handle_irq) from [] (__irq_svc+0x58/0x78) [ 69.203767] Exception stack(0xee903d20 to 0xee903d68) [ 69.402232] 3d20: 00000001 00000010 c134e8f8 ee900d40 00000000 60010013 ee26a834 00000000 [ 69.608139] 3d40: 00000000 00000000 00000000 ee903db4 00000002 ee903d70 ee9012a8 c007f4bc [ 69.811985] 3d60: 80010013 ffffffff [ 70.007318] [] (__irq_svc) from [] (lock_acquire+0x190/0x218) [ 70.212947] [] (lock_acquire) from [] (mutex_lock_nested+0x78/0x41c) [ 70.419796] [] (mutex_lock_nested) from [] (regmap_lock_mutex+0x1c/0x20) [ 70.630771] [] (regmap_lock_mutex) from [] (regmap_update_bits+0x34/0x70) [ 70.842523] [] (regmap_update_bits) from [] (rk808_device_shutdown+0x4c/0x74) [ 71.056896] [] (rk808_device_shutdown) from [] (machine_power_off+0x34/0x3c) [ 71.271604] [] (machine_power_off) from [] (kernel_power_off+0x6c/0x80) [ 71.486193] [] (kernel_power_off) from [] (SyS_reboot+0x148/0x1d8) [ 71.701543] [] (SyS_reboot) from [] (ret_fast_syscall+0x0/0x1c) [ 71.920475] Kernel panic - not syncing: softlockup: hung tasks [ 72.134543] CPU: 0 PID: 1 Comm: systemd-shutdow Tainted: G L 4.4.0-rc4+ #2761 [ 72.353754] Hardware name: Rockchip (Device Tree) [ 72.567683] [] (unwind_backtrace) from [] (show_stack+0x20/0x24) [ 72.789719] [] (show_stack) from [] (dump_stack+0x84/0xb8) [ 73.012087] [] (dump_stack) from [] (panic+0x9c/0x210) [ 73.233823] [] (panic) from [] (watchdog_timer_fn+0x210/0x250) [ 73.456871] [] (watchdog_timer_fn) from [] (__hrtimer_run_queues+0x2cc/0x55c) [ 73.683212] [] (__hrtimer_run_queues) from [] (hrtimer_interrupt+0xac/0x1f8) [ 73.909999] [] (hrtimer_interrupt) from [] (arch_timer_handler_phys+0x38/0x48) [ 74.137596] [] (arch_timer_handler_phys) from [] (handle_percpu_devid_irq+0x15c/0x314) [ 74.367459] [] (handle_percpu_devid_irq) from [] (generic_handle_irq+0x28/0x38) [ 74.596433] [] (generic_handle_irq) from [] (__handle_domain_irq+0x9c/0xc4) [ 74.826935] [] (__handle_domain_irq) from [] (gic_handle_irq+0x58/0x80) [ 75.057263] [] (gic_handle_irq) from [] (__irq_svc+0x58/0x78) [ 75.285610] Exception stack(0xee903b98 to 0xee903be0) [ 75.509201] 3b80: 00000001 c0b1891c [ 75.737970] 3ba0: 0000000f ee902028 ee955800 00000001 eed7f680 ffffbccc c0b884f8 00000000 [ 75.965750] 3bc0: c0b884f8 ee903bf4 ee903bf8 ee903be8 c0094d00 c0095e98 00010113 ffffffff [ 76.193210] [] (__irq_svc) from [] (rcu_lockdep_current_cpu_online+0x6c/0x90) [ 76.422735] [] (rcu_lockdep_current_cpu_online) from [] (rcu_read_lock_held+0x38/0x58) [ 76.654439] [] (rcu_read_lock_held) from [] (run_rebalance_domains+0x114/0x3e4) [ 76.885606] [] (run_rebalance_domains) from [] (__do_softirq+0x1d8/0x49c) [ 77.116138] [] (__do_softirq) from [] (irq_exit+0x94/0xd4) [ 77.342544] [] (irq_exit) from [] (__handle_domain_irq+0xa0/0xc4) [ 77.569812] [] (__handle_domain_irq) from [] (gic_handle_irq+0x58/0x80) [ 77.801452] [] (gic_handle_irq) from [] (__irq_svc+0x58/0x78) [ 78.030528] Exception stack(0xee903d20 to 0xee903d68) [ 78.254326] 3d20: 00000001 00000010 c134e8f8 ee900d40 00000000 60010013 ee26a834 00000000 [ 78.483633] 3d40: 00000000 00000000 00000000 ee903db4 00000002 ee903d70 ee9012a8 c007f4bc [ 78.710987] 3d60: 80010013 ffffffff [ 78.929606] [] (__irq_svc) from [] (lock_acquire+0x190/0x218) [ 79.156074] [] (lock_acquire) from [] (mutex_lock_nested+0x78/0x41c) [ 79.383616] [] (mutex_lock_nested) from [] (regmap_lock_mutex+0x1c/0x20) [ 79.611793] [] (regmap_lock_mutex) from [] (regmap_update_bits+0x34/0x70) [ 79.839125] [] (regmap_update_bits) from [] (rk808_device_shutdown+0x4c/0x74) [ 80.066755] [] (rk808_device_shutdown) from [] (machine_power_off+0x34/0x3c) [ 80.296308] [] (machine_power_off) from [] (kernel_power_off+0x6c/0x80) [ 80.525430] [] (kernel_power_off) from [] (SyS_reboot+0x148/0x1d8) [ 80.753737] [] (SyS_reboot) from [] (ret_fast_syscall+0x0/0x1c) [ 80.986626] ---[ end Kernel panic - not syncing: softlockup: hung tasks There are more pending patches I haven't looked at - so maybe one of them improves that, but maybe one of you also has some idea :-) . Heiko [0] https://git.kernel.org/cgit/linux/kernel/git/balbi/usb.git/log/?h=testing/next -- To unsubscribe from this list: send the line "unsubscribe linux-usb" in the body of a message to majordomo-u79uwXL29TY76Z2rM5mHXA@public.gmane.org More majordomo info at http://vger.kernel.org/majordomo-info.html