Bug#741239: happened again on another machine
Yesterday I triggered the same issue on another machine. Same steps to
reproduce: loopback mounting, rsync'ing. This time I had 3 images mounted
and while unmounting the 2nd image the system froze completely. I could no
longer type any command, login, or do anything, so even worse than the first
report.
This system had the /data partition (where the .img files resided on that
were used for loopback mounting) mounted through NFS. So no DRBD or RAID
involved here.
Mar 25 16:13:41 h2 kernel: [262688.108616] BUG: soft lockup - CPU#1 stuck
for 22s! [umount:28026]
Mar 25 16:13:41 h2 kernel: [262688.108673] Modules linked in: tun ext3 jbd
ip6table_filter ip6_tables iptable_filter ip_tables ebtable_nat ebtables
x_tables nfsd nfs nfs_acl auth_rpcgss fscac
he lockd sunrpc bridge 8021q garp stp loop kvm_intel kvm coretemp psmouse
crc32c_intel eeepc_wmi asus_wmi sparse_keymap rfkill ghash_clmulni_intel
mxm_wmi aesni_intel aes_x86_64 aes_generic c
ryptd snd_pcm snd_page_alloc snd_timer snd soundcore pcspkr i2c_i801
serio_raw i915 video drm_kms_helper drm i2c_algo_bit iTCO_wdt i2c_core
iTCO_vendor_support joydev evdev acpi_cpufreq mperf
button wmi processor ext4 crc16 jbd2 mbcache dm_mod raid1 md_mod usbhid hid
sg sd_mod crc_t10dif ahci libahci thermal fan thermal_sys xhci_hcd ehci_hcd
ixgbe usbcore dca mdio usb_common e100
0e libata scsi_mod [last unloaded: scsi_wait_scan]
Mar 25 16:13:41 h2 kernel: [262688.108740] CPU 1
Mar 25 16:13:41 h2 kernel: [262688.108741] Modules linked in: tun ext3 jbd
ip6table_filter ip6_tables iptable_filter ip_tables ebtable_nat ebtables
x_tables nfsd nfs nfs_acl auth_rpcgss fscac
he lockd sunrpc bridge 8021q garp stp loop kvm_intel kvm coretemp psmouse
crc32c_intel eeepc_wmi asus_wmi sparse_keymap rfkill ghash_clmulni_intel
mxm_wmi aesni_intel aes_x86_64 aes_generic c
ryptd snd_pcm snd_page_alloc snd_timer snd soundcore pcspkr i2c_i801
serio_raw i915 video drm_kms_helper drm i2c_algo_bit iTCO_wdt i2c_core
iTCO_vendor_support joydev evdev acpi_cpufreq mperf
button wmi processor ext4 crc16 jbd2 mbcache dm_mod raid1 md_mod usbhid hid
sg sd_mod crc_t10dif ahci libahci thermal fan thermal_sys xhci_hcd ehci_hcd
ixgbe usbcore dca mdio usb_common e100
0e libata scsi_mod [last unloaded: scsi_wait_scan]
Mar 25 16:13:41 h2 kernel: [262688.108796]
Mar 25 16:13:41 h2 kernel: [262688.108799] Pid: 28026, comm: umount Not
tainted 3.2.0-4-amd64 #1 Debian 3.2.54-2 System manufacturer System Product
Name/P8Z77-V
Mar 25 16:13:41 h2 kernel: [262688.108805] RIP: 0010:[<ffffffff81071046>]
[<ffffffff81071046>] do_raw_spin_lock+0x15/0x1b
Mar 25 16:13:41 h2 kernel: [262688.108813] RSP: 0018:ffff880196559df0
EFLAGS: 00000a02
Mar 25 16:13:41 h2 kernel: [262688.108816] RAX: 000000005ab186c7 RBX:
0000000000000246 RCX: 00000000c0000100
Mar 25 16:13:41 h2 kernel: [262688.108819] RDX: 0000000000005ab1 RSI:
ffff880196559e40 RDI: ffff8805d48c31e0
Mar 25 16:13:41 h2 kernel: [262688.108821] RBP: ffff8805d48c3160 R08:
ffff880196558000 R09: 0000000000000001
Mar 25 16:13:41 h2 kernel: [262688.108824] R10: 0000000000000001 R11:
ffff88081bf78000 R12: 0000000000000000
Mar 25 16:13:41 h2 kernel: [262688.108827] R13: ffff8807fc6f3c30 R14:
ffff8807fc6f3710 R15: ffff8807fc6f3c30
Mar 25 16:13:41 h2 kernel: [262688.108830] FS: 00007f933443c7e0(0000)
GS:ffff88081fa80000(0000) knlGS:0000000000000000
Mar 25 16:13:41 h2 kernel: [262688.108833] CS: 0010 DS: 0000 ES: 0000 CR0:
000000008005003b
Mar 25 16:13:41 h2 kernel: [262688.108836] CR2: 0000000001f02580 CR3:
00000005172d3000 CR4: 00000000001406e0
Mar 25 16:13:41 h2 kernel: [262688.108838] DR0: 0000000000000000 DR1:
0000000000000000 DR2: 0000000000000000
Mar 25 16:13:41 h2 kernel: [262688.108841] DR3: 0000000000000000 DR6:
00000000ffff0ff0 DR7: 0000000000000400
Mar 25 16:13:41 h2 kernel: [262688.108844] Process umount (pid: 28026,
threadinfo ffff880196558000, task ffff8807fd72eab0)
Mar 25 16:13:41 h2 kernel: [262688.108847] Stack:
Mar 25 16:13:41 h2 kernel: [262688.108866] ffffffff811173c0
7fffffffffffffff ffff8807fe47ac00 ffff880284489dc8
Mar 25 16:13:41 h2 kernel: [262688.108871] 0000000000000001
0000000000000002 ffff880196559e20 ffff880196559e20
Mar 25 16:13:41 h2 kernel: [262688.108875] ffff880196559e38
0000000000000000 0000000000030003 ffff880196559e48
Mar 25 16:13:41 h2 kernel: [262688.108880] Call Trace:
Mar 25 16:13:41 h2 kernel: [262688.108907] [<ffffffff811173c0>] ?
sync_inodes_sb+0xe5/0x16a
Mar 25 16:13:41 h2 kernel: [262688.108911] [<ffffffff8111be40>] ?
__sync_filesystem+0x3b/0x76
Mar 25 16:13:41 h2 kernel: [262688.108917] [<ffffffff810fc153>] ?
generic_shutdown_super+0x26/0xb4
Mar 25 16:13:41 h2 kernel: [262688.108922] [<ffffffff810fc1ff>] ?
kill_block_super+0x1e/0x5f
Mar 25 16:13:41 h2 kernel: [262688.108926] [<ffffffff810fc4a2>] ?
deactivate_locked_super+0x1b/0x4b
Mar 25 16:13:41 h2 kernel: [262688.108930] [<ffffffff8111143e>] ?
sys_umount+0x2d5/0x303
Mar 25 16:13:41 h2 kernel: [262688.108935] [<ffffffff81056278>] ?
set_current_blocked+0x2d/0x43
Mar 25 16:13:41 h2 kernel: [262688.108940] [<ffffffff81354d92>] ?
system_call_fastpath+0x16/0x1b
Mar 25 16:13:41 h2 kernel: [262688.108942] Code: 05 e8 6f 32 14 00 c3 f0 81
2f 00 00 10 00 74 05 e8 40 32 14 00 c3 b8 00 00 01 00 f0 0f c1 07 89 c2 c1
ea 10 66 39 d0 74 07 f3 90 <66> 8b 07 eb
f4 c3 8b 17 31 c0 89 d1 c1 e9 10 66 39 ca 75 14 8d
Mar 25 16:13:41 h2 kernel: [262688.109236] Call Trace:
Mar 25 16:13:41 h2 kernel: [262688.109240] [<ffffffff811173c0>] ?
sync_inodes_sb+0xe5/0x16a
Mar 25 16:13:41 h2 kernel: [262688.109244] [<ffffffff8111be40>] ?
__sync_filesystem+0x3b/0x76
Mar 25 16:13:41 h2 kernel: [262688.109249] [<ffffffff810fc153>] ?
generic_shutdown_super+0x26/0xb4
Mar 25 16:13:41 h2 kernel: [262688.109253] [<ffffffff810fc1ff>] ?
kill_block_super+0x1e/0x5f
Mar 25 16:13:41 h2 kernel: [262688.109257] [<ffffffff810fc4a2>] ?
deactivate_locked_super+0x1b/0x4b
Mar 25 16:13:41 h2 kernel: [262688.109261] [<ffffffff8111143e>] ?
sys_umount+0x2d5/0x303
Mar 25 16:13:41 h2 kernel: [262688.109265] [<ffffffff81056278>] ?
set_current_blocked+0x2d/0x43
Mar 25 16:13:41 h2 kernel: [262688.109268] [<ffffffff81354d92>] ?
system_call_fastpath+0x16/0x1b
After this, more CPU hang messages appeared (for all cores) on the console
but they were no longer logged to disk.
Reply to: