https://bugzilla.novell.com/show_bug.cgi?id=888259
https://bugzilla.novell.com/show_bug.cgi?id=888259#c0
Summary: "Preparing disk" crashes kernel Classification: openSUSE Product: openSUSE Factory Version: 201407* Platform: i586 OS/Version: Other Status: NEW Severity: Critical Priority: P5 - None Component: Kernel AssignedTo: kernel-maintainers@forge.provo.novell.com ReportedBy: coolo@suse.com QAContact: qa-bugs@suse.de CC: aschnell@suse.com Found By: --- Blocker: ---
https://openqa.opensuse.org/tests/13025 shows the kernel crashing while formatting the disks.
[ 201.263361] BUG: unable to handle kernel paging request at 00d6840c [ 201.264020] IP: [<c048983a>] __blk_bios_map_sg+0x18a/0x2f0 [ 201.264020] *pde = 00000000 [ 201.264020] Oops: 0000 [#1] SMP [ 201.264020] Modules linked in: dm_multipath dm_mod scsi_dh multipath raid10 raid456 async_raid6_recov async_memcpy async_pq async_xor xor async_tx raid6_pq raid1 raid0 md_mod parport_pc parport nls_utf8 isofs usb_storage iscsi_ibft iscsi_boot_sysfs 8021q garp stp mrp llc arc4 ecb fan thermal nfs lockd fscache nls_iso8859_1 nls_cp437 sg st af_packet hid_generic usbhid sunrpc sr_mod cdrom ata_generic cirrus syscopyarea sysfillrect sysimgblt virtio_net ttm virtio_blk uhci_hcd ehci_hcd drm_kms_helper ata_piix ahci usbcore libahci drm pvpanic processor thermal_sys libata button hwmon i2c_core floppy usb_common virtio_pci virtio_ring virtio edd squashfs loop [last unloaded: ppa] [ 201.264020] CPU: 0 PID: 4999 Comm: mkfs.btrfs Not tainted 3.16.0-rc5-1-default #1 [ 201.264020] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS Bochs 01/01/2011 [ 201.264020] task: ec1540d0 ti: d338c000 task.ti: d338c000 [ 201.264020] EIP: 0060:[<c048983a>] EFLAGS: 00010206 CPU: 0 [ 201.264020] EIP is at __blk_bios_map_sg+0x18a/0x2f0 [ 201.264020] EAX: 00d6840c EBX: d338de08 ECX: eeb3d5a4 EDX: 00d6840f [ 201.264020] ESI: 00000000 EDI: 00000000 EBP: d338ddf4 ESP: d338ddac [ 201.264020] DS: 007b ES: 007b FS: 00d8 GS: 00e0 SS: 0068 [ 201.264020] CR0: 8005003b CR2: 00d6840c CR3: 16e97000 CR4: 000006d0 [ 201.264020] Stack: [ 201.264020] f2d3ae00 00000010 d338dde4 eeb3cb90 00002000 ee921248 01000004 00000081 [ 201.264020] d336b350 00000000 f3956bc0 2c1dc000 00001000 00001000 00001000 eeb3ca80 [ 201.264020] ee921248 00000000 d338de18 c04899cf d338de08 f368d0e0 00000000 00d6840c [ 201.264020] Call Trace: [ 201.264020] [<c04899cf>] blk_rq_map_sg+0x2f/0x130 [ 201.264020] [<f84ae478>] virtio_queue_rq+0x98/0x220 [virtio_blk] [ 201.264020] [<c048ce59>] __blk_mq_run_hw_queue+0x199/0x2c0 [ 201.264020] [<c048df0b>] blk_mq_insert_requests+0xab/0x100 [ 201.264020] [<c048e8bf>] blk_mq_flush_plug_list+0x10f/0x120 [ 201.264020] [<c0485ece>] blk_flush_plug_list+0x9e/0x1b0 [ 201.264020] [<c04862d2>] blk_finish_plug+0x12/0x40 [ 201.264020] [<c0327f8d>] generic_writepages+0x3d/0x60 [ 201.264020] [<c0328d4a>] do_writepages+0x1a/0x40 [ 201.264020] [<c0320124>] __filemap_fdatawrite_range+0x54/0x60 [ 201.264020] [<c0322b2b>] SyS_fadvise64_64+0x24b/0x250 [ 201.264020] [<c071db15>] syscall_call+0x7/0xb [ 201.264020] [<b7645eb3>] 0xb7645eb2 [ 201.264020] Code: 5d e4 c1 fa 05 c1 e2 0c 03 55 dc 01 d9 39 d1 0f 84 fc 00 00 00 8d 74 26 00 83 20 fd 8b 45 08 8b 00 e8 bb fe 02 00 8b 5d 08 89 03 <8b> 10 8b 5d e0 83 e2 03 f6 c3 03 0f 85 0c 01 00 00 8b 4d dc 09 [ 201.264020] EIP: [<c048983a>] __blk_bios_map_sg+0x18a/0x2f0 SS:ESP 0068:d338ddac [ 201.264020] CR2: 0000000000d6840c [ 201.310761] ---[ end trace a22ed0866cd5a71b ]---
https://bugzilla.novell.com/show_bug.cgi?id=888259
https://bugzilla.novell.com/show_bug.cgi?id=888259#c1
Stephan Kulow coolo@suse.com changed:
What |Removed |Added ---------------------------------------------------------------------------- Platform|i586 |All
--- Comment #1 from Stephan Kulow coolo@suse.com 2014-07-22 06:48:49 CEST --- the same crash happens on x86_64 too:
https://openqa.opensuse.org/tests/13026
[ 193.015267] BUG: unable to handle kernel paging request at 0000000010000000 [ 193.016022] IP: [<ffffffff812e5a9b>] __blk_bios_map_sg+0x1bb/0x320 [ 193.016022] PGD 13518067 PUD 13519067 PMD 0 [ 193.016022] Oops: 0000 [#1] SMP [ 193.016022] Modules linked in: dm_multipath dm_mod scsi_dh multipath raid10 raid456 async_raid6_recov async_memcpy async_pq async_xor xor async_tx raid6_pq raid1 raid0 md_mod parport_pc parport nls_utf8 isofs usb_storage iscsi_ibft iscsi_boot_sysfs 8021q garp stp mrp llc arc4 ecb fan thermal nfs lockd fscache nls_iso8859_1 nls_cp437 sg st hid_generic usbhid af_packet sunrpc sr_mod cdrom ata_generic cirrus syscopyarea sysfillrect uhci_hcd sysimgblt virtio_net virtio_blk ttm ehci_hcd drm_kms_helper usbcore drm ata_piix floppy pvpanic processor button usb_common virtio_pci virtio_ring virtio edd squashfs loop [last unloaded: ppa] [ 193.016022] CPU: 0 PID: 4965 Comm: mkfs.btrfs Not tainted 3.16.0-rc5-1-default #1 [ 193.016022] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS Bochs 01/01/2011 [ 193.016022] task: ffff8800179b2390 ti: ffff8800134a8000 task.ti: ffff8800134a8000 [ 193.016022] RIP: 0010:[<ffffffff812e5a9b>] [<ffffffff812e5a9b>] __blk_bios_map_sg+0x1bb/0x320 [ 193.016022] RSP: 0018:ffff8800134abc90 EFLAGS: 00010206 [ 193.016022] RAX: 0000000010000000 RBX: 0000000000001000 RCX: ffff8800134abd00 [ 193.016022] RDX: 0000000010000001 RSI: 0000000000002000 RDI: ffff880032a63560 [ 193.016022] RBP: 0000000000000000 R08: 0000000000000000 R09: ffff880013670b20 [ 193.016022] R10: 0000000017ac3000 R11: 0000000000000000 R12: 0000000000000000 [ 193.016022] R13: 0000000000000000 R14: 0000000000001000 R15: ffffea0000ae6980 [ 193.016022] FS: 00007f64218677c0(0000) GS:ffff88003be00000(0000) knlGS:0000000000000000 [ 193.016022] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 [ 193.016022] CR2: 0000000010000000 CR3: 0000000017bf5000 CR4: 00000000000006f0 [ 193.016022] Stack: [ 193.016022] ffff8800134abd00 0000000000000000 ffff880013670b20 01ffffff00000083 [ 193.016022] ffff880032a3c7c8 ffff880032a62520 ffff880013771d00 ffff880032a62380 [ 193.016022] ffff880032a3c7c8 0000000000000000 0000000010020001 0000000000000001 [ 193.016022] Call Trace: [ 193.016022] [<ffffffff812e5c2f>] blk_rq_map_sg+0x2f/0x170 [ 193.016022] [<ffffffffa00574db>] virtio_queue_rq+0x9b/0x240 [virtio_blk] [ 193.016022] [<ffffffff812e9622>] __blk_mq_run_hw_queue+0x1c2/0x320 [ 193.016022] [<ffffffff812ea99d>] blk_mq_insert_requests+0xbd/0x120 [ 193.016022] [<ffffffff812eb4d9>] blk_mq_flush_plug_list+0x129/0x140 [ 193.016022] [<ffffffff812e1e43>] blk_flush_plug_list+0xe3/0x230 [ 193.016022] [<ffffffff812e2300>] blk_finish_plug+0x10/0x40 [ 193.016022] [<ffffffff8115037d>] generic_writepages+0x4d/0x60 [ 193.016022] [<ffffffff81146d4e>] __filemap_fdatawrite_range+0x4e/0x60 [ 193.016022] [<ffffffff81149b1c>] SyS_fadvise64+0x21c/0x230 [ 193.016022] [<ffffffff815cf12d>] system_call_fastpath+0x1a/0x1f [ 193.016022] [<00007f6420f4686d>] 0x7f6420f4686c [ 193.016022] Code: 48 83 20 fd 4c 89 4c 24 10 48 8b 39 44 89 44 24 08 48 89 0c 24 e8 76 46 03 00 48 8b 0c 24 4c 8b 4c 24 10 44 8b 44 24 08 48 89 01 <48> 8b 10 83 e2 03 41 f6 c7 03 0f 85 ea 00 00 00 83 44 24 18 01 [ 193.016022] RIP [<ffffffff812e5a9b>] __blk_bios_map_sg+0x1bb/0x320 [ 193.016022] RSP <ffff8800134abc90> [ 193.016022] CR2: 0000000010000000 [ 193.085308] ---[ end trace 9bc1c3e5a908ae98 ]---
https://bugzilla.novell.com/show_bug.cgi?id=888259
https://bugzilla.novell.com/show_bug.cgi?id=888259#c2
--- Comment #2 from Stephan Kulow coolo@suse.com 2014-07-22 06:57:27 CEST --- what makes this reproducible is configuring lvm:
https://openqa.opensuse.org/tests/12920/modules/start_install/steps/3
Interestingly enough encrypted lvm doesn't show the crash.
https://bugzilla.novell.com/show_bug.cgi?id=888259
https://bugzilla.novell.com/show_bug.cgi?id=888259#c3
Stephan Kulow coolo@suse.com changed:
What |Removed |Added ---------------------------------------------------------------------------- CC| |mge@suse.com AssignedTo|kernel-maintainers@forge.pr |dsterba@suse.com |ovo.novell.com |
--- Comment #3 from Stephan Kulow coolo@suse.com 2014-07-22 10:18:16 CEST --- Taking that it happens during mkfs.btrfs let's assume David can help
https://bugzilla.novell.com/show_bug.cgi?id=888259
https://bugzilla.novell.com/show_bug.cgi?id=888259#c4
Takashi Iwai tiwai@suse.com changed:
What |Removed |Added ---------------------------------------------------------------------------- CC| |mlin@suse.com
--- Comment #4 from Takashi Iwai tiwai@suse.com 2014-08-11 11:23:08 UTC --- *** Bug 891278 has been marked as a duplicate of this bug. *** http://bugzilla.novell.com/show_bug.cgi?id=891278
https://bugzilla.novell.com/show_bug.cgi?id=888259
https://bugzilla.novell.com/show_bug.cgi?id=888259#c5
Stephan Kulow coolo@suse.com changed:
What |Removed |Added ---------------------------------------------------------------------------- Priority|P5 - None |P1 - Urgent Version|201407* |201409*
--- Comment #5 from Stephan Kulow coolo@suse.com 2014-09-17 09:51:57 CEST --- looks like I need to raise the prio to get attention
https://bugzilla.novell.com/show_bug.cgi?id=888259
https://bugzilla.novell.com/show_bug.cgi?id=888259#c6
--- Comment #6 from Stephan Kulow coolo@suse.com 2014-09-17 09:53:38 CEST ---
From a more recent https://openqa.opensuse.org/tests/22578/file/serial0.txt
[ 211.245518] general protection fault: 0000 [#1] SMP [ 211.246405] Modules linked in: dm_multipath dm_mod scsi_dh multipath raid10 raid456 async_raid6_recov async_memcpy async_pq async_xor xor async_tx raid6_pq raid1 raid0 md_mod parport_pc parport nls_utf8 isofs usb_storage iscsi_ibft iscsi_boot_sysfs 8021q garp stp mrp llc arc4 ecb fan thermal nfs lockd fscache nls_iso8859_1 nls_cp437 sg st hid_generic usbhid af_packet sunrpc sr_mod cdrom ata_generic cirrus uhci_hcd syscopyarea sysfillrect sysimgblt ehci_hcd ttm virtio_net virtio_blk usbcore drm_kms_helper drm floppy ata_piix processor button usb_common pvpanic virtio_pci virtio_ring virtio edd squashfs loop [last unloaded: ppa] [ 211.248012] CPU: 0 PID: 4249 Comm: mkfs.btrfs Not tainted 3.16.2-1.gdcee397-default #1 [ 211.248012] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.7.5-0-ge51488c-20140909_173029-build30 04/01/2014 [ 211.248012] task: ffff88001785e290 ti: ffff880018320000 task.ti: ffff880018320000 [ 211.248012] RIP: 0010:[<ffffffff812e667b>] [<ffffffff812e667b>] __blk_bios_map_sg+0x1bb/0x320 [ 211.248012] RSP: 0018:ffff880018323c90 EFLAGS: 00010206 [ 211.248012] RAX: 66fffffcc9e9fffc RBX: 0000000000001000 RCX: ffff880018323d00 [ 211.248012] RDX: 66fffffcc9e9ffff RSI: 0000000000002000 RDI: ffff880038a49fc0 [ 211.248012] RBP: 0000000000000000 R08: 0000000000000000 R09: ffff880012fa5d20 [ 211.248012] R10: 0000000012e56000 R11: 0000000000000000 R12: 0000000000000000 [ 211.248012] R13: 0000000000000000 R14: 0000000000001000 R15: ffffea0000420548 [ 211.248012] FS: 00007f7d9f2657c0(0000) GS:ffff88003c800000(0000) knlGS:0000000000000000 [ 211.248012] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 [ 211.248012] CR2: 00007ffffe9fd185 CR3: 0000000017bf0000 CR4: 00000000000006f0 [ 211.248012] Stack: [ 211.248012] ffff880018323d00 0000000000000000 ffff880012fa5d20 01ffffff00000082 [ 211.248012] ffff8800389d57c8 ffff880038a48fa0 ffff88000f019d00 ffff880038a48e00 [ 211.248012] ffff8800389d57c8 0000000000000000 0000000010020001 0000000000000001 [ 211.248012] Call Trace: [ 211.248012] [<ffffffff812e680f>] blk_rq_map_sg+0x2f/0x170 [ 211.248012] [<ffffffffa00504db>] virtio_queue_rq+0x9b/0x240 [virtio_blk] [ 211.248012] [<ffffffff812ea202>] __blk_mq_run_hw_queue+0x1c2/0x320 [ 211.248012] [<ffffffff812eb57d>] blk_mq_insert_requests+0xbd/0x120 [ 211.248012] [<ffffffff812ec0b9>] blk_mq_flush_plug_list+0x129/0x140 [ 211.248012] [<ffffffff812e2a43>] blk_flush_plug_list+0xe3/0x230 [ 211.248012] [<ffffffff812e2f00>] blk_finish_plug+0x10/0x40 [ 211.248012] [<ffffffff8115060d>] generic_writepages+0x4d/0x60 [ 211.248012] [<ffffffff81146fde>] __filemap_fdatawrite_range+0x4e/0x60 [ 211.248012] [<ffffffff81149dac>] SyS_fadvise64+0x21c/0x230 [ 211.248012] [<ffffffff815d002d>] system_call_fastpath+0x1a/0x1f [ 211.248012] [<00007f7d9e9434dd>] 0x7f7d9e9434dc [ 211.248012] Code: 48 83 20 fd 4c 89 4c 24 10 48 8b 39 44 89 44 24 08 48 89 0c 24 e8 86 46 03 00 48 8b 0c 24 4c 8b 4c 24 10 44 8b 44 24 08 48 89 01 <48> 8b 10 83 e2 03 41 f6 c7 03 0f 85 ea 00 00 00 83 44 24 18 01 [ 211.248012] RIP [<ffffffff812e667b>] __blk_bios_map_sg+0x1bb/0x320 [ 211.248012] RSP <ffff880018323c90> [ 211.293031] ---[ end trace 195feb99ba703b03 ]--- [ 544.010780] SysRq : Show Blocked State [ 544.011503] task PC stack pid father [ 544.012007] udevd D ffff88003c813580 0 4157 102 0x00000004 [ 544.012007] ffff880017b47b80 0000000000000082 ffff880017bc20d0 0000000000013580 [ 544.012007] ffff880017b47fd8 0000000000013580 ffff8800242f01d0 ffff88003852f4d8 [ 544.012007] ffff88003852f4dc ffff880017bc20d0 00000000ffffffff ffff88003852f4e0 [ 544.012007] Call Trace: [ 544.012007] [<ffffffff815cc899>] schedule_preempt_disabled+0x29/0x70 [ 544.012007] [<ffffffff815ce363>] __mutex_lock_slowpath+0xd3/0x1c0 [ 544.012007] [<ffffffff815ce463>] mutex_lock+0x13/0x22 [ 544.012007] [<ffffffff811e5cf3>] __blkdev_get+0x63/0x480 [ 544.012007] [<ffffffff811e62c6>] blkdev_get+0x1b6/0x310 [ 544.012007] [<ffffffff811aee52>] do_dentry_open+0x1f2/0x330 [ 544.012007] [<ffffffff811bf510>] do_last+0x550/0x1200 [ 544.012007] [<ffffffff811c027b>] path_openat+0xbb/0x670 [ 544.012007] [<ffffffff811c17ca>] do_filp_open+0x3a/0x90 [ 544.012007] [<ffffffff811b0919>] do_sys_open+0x129/0x220 [ 544.012007] [<ffffffff815d002d>] system_call_fastpath+0x1a/0x1f [ 544.012007] [<00007f338e793190>] 0x7f338e79318f [ 544.012007] mkfs.btrfs D ffff88003c813580 0 4249 2861 0x00000002 [ 544.012007] ffff880018323918 0000000000000046 ffff88001785e290 0000000000013580 [ 544.012007] ffff880018323fd8 0000000000013580 ffff880012ca2450 ffff88003c813e90 [ 544.012007] 0000000000000002 ffffffff811456b0 ffff880018323980 ffff880018323a68 [ 544.012007] Call Trace: [ 544.012007] [<ffffffff815cc74d>] io_schedule+0x9d/0x120 [ 544.012007] [<ffffffff811456ba>] sleep_on_page+0xa/0x10 [ 544.012007] [<ffffffff815ccadc>] __wait_on_bit+0x5c/0x90 [ 544.012007] [<ffffffff811454af>] wait_on_page_bit+0x7f/0x90 [ 544.012007] [<ffffffff81145590>] filemap_fdatawait_range+0xd0/0x160 [ 544.012007] [<ffffffff81147046>] filemap_write_and_wait+0x36/0x50 [ 544.012007] [<ffffffff811e5b4d>] __blkdev_put+0x5d/0x1a0 [ 544.012007] [<ffffffff811e66a1>] blkdev_close+0x21/0x30 [ 544.012007] [<ffffffff811b3035>] __fput+0xb5/0x1c0 [ 544.012007] [<ffffffff810796e4>] task_work_run+0xb4/0xd0 [ 544.012007] [<ffffffff8105e05c>] do_exit+0x2bc/0xa50 [ 544.012007] [<ffffffff81006377>] oops_end+0x97/0xe0 [ 544.012007] [<ffffffff815d1f48>] general_protection+0x28/0x30 [ 544.012007] [<ffffffff812e667b>] __blk_bios_map_sg+0x1bb/0x320 [ 544.012007] [<ffffffff812e680f>] blk_rq_map_sg+0x2f/0x170 [ 544.012007] [<ffffffffa00504db>] virtio_queue_rq+0x9b/0x240 [virtio_blk] [ 544.012007] [<ffffffff812ea202>] __blk_mq_run_hw_queue+0x1c2/0x320 [ 544.012007] [<ffffffff812eb57d>] blk_mq_insert_requests+0xbd/0x120 [ 544.012007] [<ffffffff812ec0b9>] blk_mq_flush_plug_list+0x129/0x140 [ 544.012007] [<ffffffff812e2a43>] blk_flush_plug_list+0xe3/0x230 [ 544.012007] [<ffffffff812e2f00>] blk_finish_plug+0x10/0x40 [ 544.012007] [<ffffffff8115060d>] generic_writepages+0x4d/0x60 [ 544.012007] [<ffffffff81146fde>] __filemap_fdatawrite_range+0x4e/0x60 [ 544.012007] [<ffffffff81149dac>] SyS_fadvise64+0x21c/0x230 [ 544.012007] [<ffffffff815d002d>] system_call_fastpath+0x1a/0x1f [ 544.012007] [<00007f7d9e9434dd>] 0x7f7d9e9434dc [ 544.012007] Sched Debug Version: v0.11, 3.16.2-1.gdcee397-default #1 [ 544.012007] ktime : 544059.629845 [ 544.012007] sched_clk : 605307.351983 [ 544.012007] cpu_clk : 544012.007584 [ 544.012007] jiffies : 4295028298 [ 544.012007] sched_clock_stable() : 0 [ 544.012007] [ 544.012007] sysctl_sched [ 544.012007] .sysctl_sched_latency : 6.000000 [ 544.012007] .sysctl_sched_min_granularity : 0.750000 [ 544.012007] .sysctl_sched_wakeup_granularity : 1.000000 [ 544.012007] .sysctl_sched_child_runs_first : 0 [ 544.012007] .sysctl_sched_features : 77435 [ 544.012007] .sysctl_sched_tunable_scaling : 1 (logaritmic) [ 544.012007] [ 544.012007] cpu#0, 2600.000 MHz [ 544.012007] .nr_running : 7 [ 544.012007] .load : 5150 [ 544.012007] .nr_switches : 590555 [ 544.012007] .nr_load_updates : 108842 [ 544.012007] .nr_uninterruptible : 2 [ 544.012007] .next_balance : 4294.892296 [ 544.012007] .curr->pid : 4274 [ 544.012007] .clock : 544010.693078 [ 544.012007] .cpu_load[0] : 2074 [ 544.012007] .cpu_load[1] : 2074 [ 544.012007] .cpu_load[2] : 2074 [ 544.012007] .cpu_load[3] : 2074 [ 544.012007] .cpu_load[4] : 2074 [ 544.012007] .yld_count : 6135 [ 544.012007] .sched_count : 596893 [ 544.012007] .sched_goidle : 2620 [ 544.012007] .avg_idle : 75713 [ 544.012007] .max_idle_balance_cost : 500000 [ 544.012007] .ttwu_count : 393773 [ 544.012007] .ttwu_local : 393773 [ 544.012007] [ 544.012007] cfs_rq[0]:/ [ 544.012007] .exec_clock : 430017.418815 [ 544.012007] .MIN_vruntime : 257366.325734 [ 544.012007] .min_vruntime : 257369.325734 [ 544.012007] .max_vruntime : 257493.689865 [ 544.012007] .spread : 127.364131 [ 544.012007] .spread0 : 0.000000 [ 544.012007] .nr_spread_over : 5517 [ 544.012007] .nr_running : 7 [ 544.012007] .load : 5150 [ 544.012007] .runnable_load_avg : 2082 [ 544.012007] .blocked_load_avg : 21 [ 544.012007] .tg_load_contrib : 2100 [ 544.012007] .tg_runnable_contrib : 1008 [ 544.012007] .tg_load_avg : 2100 [ 544.012007] .tg->runnable_avg : 1008 [ 544.012007] .tg->cfs_bandwidth.timer_active: 0 [ 544.012007] .throttled : 0 [ 544.012007] .throttle_count : 0 [ 544.012007] .avg->runnable_avg_sum : 46276 [ 544.012007] .avg->runnable_avg_period : 46276 [ 544.012007] [ 544.012007] rt_rq[0]:/ [ 544.012007] .rt_nr_running : 0 [ 544.012007] .rt_throttled : 0 [ 544.012007] .rt_time : 0.000000 [ 544.012007] .rt_runtime : 950.000000 [ 544.012007] [ 544.012007] runnable tasks: [ 544.012007] task PID tree-key switches prio exec-runtime sum-exec sum-sleep [ 544.012007] ---------------------------------------------------------------------------------------------------------- [ 544.012007] init 1 254696.516517 22880 120 254696.516517 8991.014187 528413.838218 0 / [ 544.012007] kthreadd 2 82443.242803 69 120 82443.242803 1.856298 210738.162760 0 / [ 544.012007] ksoftirqd/0 3 257282.744014 165 120 257282.744014 150.411695 543493.189219 0 / [ 544.012007] kworker/0:0H 5 3069.551194 6 100 3069.551194 0.304086 4027.981388 0 / [ 544.012007] kworker/u2:0 6 111467.560713 102 120 111467.560713 3.327681 244891.096072 0 / [ 544.012007] rcu_sched 7 257364.970307 183074 120 257364.970307 3964.530558 534768.665824 0 / [ 544.012007] rcuos/0 8 257364.965954 129067 120 257364.965954 1065.802685 542416.895481 0 / [ 544.012007] rcu_bh 9 12.911435 2 120 12.911435 0.000000 0.000000 0 / [ 544.012007] rcuob/0 10 12.918680 2 120 12.918680 0.000000 0.000000 0 / [ 544.012007] migration/0 11 0.060318 37 0 0.060318 2.459261 0.000000 0 / [ 544.012007] watchdog/0 12 0.000000 138 0 0.000000 14.255035 0.002252 0 / [ 544.012007] khelper 13 16.140186 2 100 16.140186 0.003144 0.002022 0 / [ 544.012007] kdevtmpfs 14 82441.738280 236 120 82441.738280 1.653558 210624.191496 0 / [ 544.012007] netns 15 20.200777 2 100 20.200777 0.003598 0.002234 0 / [ 544.012007] khungtaskd 16 226146.628656 3 120 226146.628656 0.007344 479998.765527 0 / [ 544.012007] writeback 17 24.203457 2 100 24.203457 0.003141 0.001778 0 / [ 544.012007] ksmd 18 26.208685 2 125 26.208685 0.003631 0.001714 0 / [ 544.012007] khugepaged 19 253227.923088 63 139 253227.923088 27.438372 534296.593663 0 / [ 544.012007] crypto 20 29.706675 2 100 29.706675 0.002853 0.001918 0 / [ 544.012007] kintegrityd 21 31.707666 2 100 31.707666 0.002701 0.001802 0 / [ 544.012007] bioset 22 33.708741 2 100 33.708741 0.002555 0.001669 0 / [ 544.012007] kblockd 23 3069.549386 4 100 3069.549386 0.013159 3793.058610 0 / [ 544.012007] ata_sff 24 260.141736 2 100 260.141736 0.004144 0.003552 0 / [ 544.012007] kworker/0:1 25 257366.325734 4370 120 257366.325734 677.468950 541609.033354 0 / [ 544.012007] kswapd0 26 161167.700069 19 120 161167.700069 13.569143 344768.953069 0 / [ 544.012007] fsnotify_mark 27 82731.310110 75 120 82731.310110 0.470119 209167.740330 0 / [ 544.012007] kthrotld 34 1904.964349 2 100 1904.964349 0.004087 0.001979 0 / [ 544.012007] kpsmoused 35 1954.691457 2 100 1954.691457 0.005001 0.003739 0 / [ 544.012007] ipv6_addrconf 36 1964.738155 2 100 1964.738155 0.003439 0.002221 0 / [ 544.012007] kworker/0:2 37 81498.916962 261 120 81498.916962 84.607633 207163.049016 0 / [ 544.012007] deferwq 38 1965.939749 2 100 1965.939749 0.003372 0.002088 0 / [ 544.012007] kworker/u2:1 39 3037.768164 18 120 3037.768164 0.644567 1428.564883 0 / [ 544.012007] loop0 96 82433.295204 876 100 82433.295204 55.915930 207756.471854 0 / [ 544.012007] loop1 97 82433.603741 180 100 82433.603741 15.617796 207718.653300 0 / [ 544.012007] udevd 102 256155.022139 943 120 256155.022139 388.879746 537011.596007 0 / [ 544.012007] scsi_eh_0 119 2947.010746 4 120 2947.010746 0.610839 196.198421 0 / [ 544.012007] scsi_tmf_0 120 2931.146213 2 100 2931.146213 0.005168 0.001771 0 / [ 544.012007] scsi_eh_1 121 78095.315203 110 120 78095.315203 17.971906 190232.428600 0 / [ 544.012007] scsi_tmf_1 122 2932.649392 2 100 2932.649392 0.003898 0.002566 0 / [ 544.012007] khubd 127 75818.533812 41 120 75818.533812 18.171095 162127.333588 0 / [ 544.012007] ttm_swap 130 2980.163483 2 100 2980.163483 0.005556 0.003576 0 / [ 544.012007] haveged 131 257366.325734 3481 120 257366.325734 834.293370 538296.374790 0 / [ 544.012007] kworker/0:1H 143 82671.612554 528 100 82671.612554 5.500042 207054.044120 0 / [ 544.012007] rpciod 144 3072.875808 2 100 3072.875808 0.004544 0.002068 0 / [ 544.012007] rpc.idmapd 147 3077.856220 2 120 3077.856220 0.240588 0.000000 0 / [ 544.012007] dbus-daemon 154 65157.466713 245 120 65157.466713 15.906711 80023.072094 0 / [ 544.012007] wickedd 158 65157.506911 114 120 65157.506911 26.160290 79957.361671 0 / [ 544.012007] wickedd-auto4 162 50528.493681 6 120 50528.493681 1.453126 64933.684328 0 / [ 544.012007] wickedd-dhcp4 165 51833.090796 24 120 51833.090796 4.423296 66384.169434 0 / [ 544.012007] wickedd-dhcp6 167 65157.069225 15 120 65157.069225 3.096583 79878.678072 0 / [ 544.012007] wickedd-nanny 169 3158.005054 1 120 3158.005054 0.204898 0.000000 0 / [ 544.012007] nfsiod 399 5117.237747 2 100 5117.237747 0.005686 0.004101 0 / [ 544.012007] acpi_thermal_pm 446 5493.299203 2 100 5493.299203 0.005534 0.003994 0 / [ 544.012007] sh 909 9263.966595 20 120 9263.966595 8.172201 25.280040 0 / [ 544.012007] loop2 1436 95869.124019 609 100 95869.124019 51.288184 201566.064126 0 / [ 544.012007] loop3 1437 82433.940253 1158 100 82433.940253 186.449665 186085.714644 0 / [ 544.012007] loop5 1452 69813.084169 96 100 69813.084169 2.567002 73998.283691 0 / [ 544.012007] loop6 1465 69813.170854 37 100 69813.170854 0.272918 73964.272577 0 / [ 544.012007] bash 1472 75752.856129 215 120 75752.856129 42.586920 133878.586637 0 / [ 544.012007] bash 1473 18161.277272 59 120 18161.277272 23.530539 175.922470 0 / [ 544.012007] bash 1474 18159.298171 55 120 18159.298171 21.783039 181.093949 0 / [ 544.012007] init 1475 18101.474455 2 120 18101.474455 0.271377 0.000000 0 / [ 544.012007] inst_setup 1476 22624.348296 54 120 22624.348296 22.023106 7087.471088 0 / [ 544.012007] syslogd 1577 255501.737688 414 120 255501.737688 19.998238 509963.065941 0 / [ 544.012007] klogd 1580 82777.375138 392 120 82777.375138 133.192913 180642.945037 0 / [ 544.012007] nscd 1583 253672.645870 1426 120 253672.645870 19.318339 506192.385346 0 / [ 544.012007] nscd 1584 211722.915172 18 120 211722.915172 21.799742 420274.331713 0 / [ 544.012007] nscd 1585 30514.365572 2 120 30514.365572 0.037702 18000.054243 0 / [ 544.012007] nscd 1586 31505.938086 2 120 31505.938086 0.032545 19000.053313 0 / [ 544.012007] nscd 1587 235979.158842 149 120 235979.158842 1.787329 470001.227909 0 / [ 544.012007] nscd 1588 218182.042296 154 120 218182.042296 11.688515 433533.303989 0 / [ 544.012007] nscd 1589 253672.617712 150 120 253672.617712 1.773612 506210.069491 0 / [ 544.012007] nscd 1590 235979.169423 151 120 235979.169423 2.445923 470004.430759 0 / [ 544.012007] nscd 1591 253672.608053 150 120 253672.608053 1.801354 506213.835836 0 / [ 544.012007] yast 1610 24630.402274 599 120 24630.402274 63.014976 2901.053209 0 / [ 544.012007] YaST2.call 2410 25886.439910 302 120 25886.439910 34.474305 1491.336711 0 / [ 544.012007] Xorg 2799 257366.325734 16628 120 257366.325734 4870.597501 499238.789803 0 / [ 544.012007] icewm 2806 257283.306728 814 120 257283.306728 668.152897 503333.691428 0 / [ 544.012007] y2base 2861 257369.374346 98903 120 257369.374346 186706.513451 153294.110056 0 / [ 544.012007] ruby-timer-thr 2862 253673.021808 16 120 253673.021808 0.586872 496973.673579 0 / [ 544.012007] y2base 2863 257369.325734 49728 120 257369.325734 194707.535312 140897.884209 0 / [ 544.012007] QXcbEventReader 2864 257283.220828 2266 120 257283.220828 23.851702 502604.662075 0 / [ 544.012007] dbus-launch 2868 27048.836263 8 120 27048.836263 0.233413 8.203458 0 / [ 544.012007] dbus-daemon 2869 27052.071327 7 120 27052.071327 0.512651 0.313104 0 / [ 544.012007] ag_udev_persist 2920 30309.320250 177 120 30309.320250 358.625006 8.172217 0 / [ 544.012007] ruby-timer-thr 2921 30204.738376 1 120 30204.738376 0.012403 0.000000 0 / [ 544.012007] kauditd 3433 66427.193862 2 120 66427.193862 0.005913 0.005114 0 / [ 544.012007] md 3503 68821.906820 2 100 68821.906820 0.006438 0.004485 0 / [ 544.012007] raid5wq 3510 68858.266108 2 100 68858.266108 0.010287 0.003469 0 / [ 544.012007] kmpathd 3567 69467.358621 2 100 69467.358621 0.004488 0.004216 0 / [ 544.012007] kmpath_handlerd 3568 69469.361736 2 100 69469.361736 0.005910 0.002024 0 / [ 544.012007] udevd 4157 82736.103550 1779 120 82736.103550 98.453099 1051.814098 0 / [ 544.012007] kdmflush 4191 82379.255578 2 100 82379.255578 0.005387 0.005048 0 / [ 544.012007] bioset 4192 82381.257914 2 100 82381.257914 0.005450 0.002774 0 / [ 544.012007] kdmflush 4205 82446.231164 2 100 82446.231164 0.005090 0.004804 0 / [ 544.012007] bioset 4206 82448.233398 2 100 82448.233398 0.005041 0.002637 0 / [ 544.012007] mkfs.btrfs 4249 82734.310548 102 120 82734.310548 32.991000 5.631142 0 / [ 544.012007] gzip 4272 257493.689865 93 139 257493.689865 316.583848 0.000000 0 / [ 544.012007] R gzip 4274 257550.408904 18 139 257550.408904 57.952227 0.000000 0 / [ 544.012007] [ 544.305585] SysRq : Show backtrace of all active CPUs [ 544.306402] sending NMI to all CPUs: [ 544.306974] NMI backtrace for cpu 0 [ 544.307574] CPU: 0 PID: 4274 Comm: gzip Tainted: G D 3.16.2-1.gdcee397-default #1 [ 544.309055] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.7.5-0-ge51488c-20140909_173029-build30 04/01/2014 [ 544.309376] task: ffff880017be2350 ti: ffff8800243b0000 task.ti: ffff8800243b0000 [ 544.309376] RIP: 0010:[<ffffffff81043926>] [<ffffffff81043926>] native_write_msr_safe+0x6/0x10 [ 544.309376] RSP: 0000:ffff88003c803b90 EFLAGS: 00000046 [ 544.309376] RAX: 0000000000000400 RBX: 0000000000000000 RCX: 0000000000000830 [ 544.309376] RDX: 0000000000000000 RSI: 0000000000000400 RDI: 0000000000000830 [ 544.309376] RBP: ffffffff81ce55c0 R08: ffffffff81ce55c0 R09: ffff88003a16ef00 [ 544.309376] R10: 0000000000000303 R11: 0720072007200720 R12: 0000000000000000 [ 544.309376] R13: 000000000000b0ea R14: 0000000000000002 R15: 0000000000080000 [ 544.309376] FS: 00007f7469d07700(0000) GS:ffff88003c800000(0000) knlGS:0000000000000000 [ 544.309376] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 [ 544.309376] CR2: 00007fb38c002000 CR3: 000000001789a000 CR4: 00000000000006f0 [ 544.309376] Stack: [ 544.309376] ffffffff8103b16d 0000000000000002 0000000000000082 ffffffff81c9da00 [ 544.309376] 000000000000006c 0000000000000001 000000000000000f ffff8800396055d8 [ 544.309376] ffff880039524e00 ffffffff810371c3 ffffffff81c9da00 ffffffff813db52c [ 544.309376] Call Trace: [ 544.309376] [<ffffffff8103b16d>] __x2apic_send_IPI_mask+0xad/0xe0 [ 544.309376] [<ffffffff810371c3>] arch_trigger_all_cpu_backtrace+0xc3/0x140 [ 544.309376] [<ffffffff813db52c>] __handle_sysrq+0xfc/0x160 [ 544.309376] [<ffffffff813db957>] sysrq_filter+0x397/0x3e0 [ 544.309376] [<ffffffff81468ec8>] input_to_handler+0x48/0xf0 [ 544.309376] [<ffffffff8146a0ce>] input_pass_values.part.4+0x14e/0x160 [ 544.309376] [<ffffffff8146c13f>] input_handle_event+0x11f/0x540 [ 544.309376] [<ffffffff8146c5ba>] input_event+0x5a/0x80 [ 544.309376] [<ffffffff814722e4>] atkbd_interrupt+0x5e4/0x6f0 [ 544.309376] [<ffffffff814664f1>] serio_interrupt+0x41/0x80 [ 544.309376] [<ffffffff8146758a>] i8042_interrupt+0x18a/0x360 [ 544.309376] [<ffffffff810b45e5>] handle_irq_event_percpu+0x35/0x190 [ 544.309376] [<ffffffff810b4778>] handle_irq_event+0x38/0x60 [ 544.309376] [<ffffffff810b7205>] handle_edge_irq+0x85/0x150 [ 544.309376] [<ffffffff81004ffd>] handle_irq+0x1d/0x30 [ 544.309376] [<ffffffff815d2d19>] do_IRQ+0x49/0xe0 [ 544.309376] [<ffffffff815d0cad>] common_interrupt+0x6d/0x6d [ 544.309376] [<ffffffff81060ac8>] __do_softirq+0x88/0x290 [ 544.309376] [<ffffffff81060f05>] irq_exit+0x95/0xa0 [ 544.309376] [<ffffffff815d2d22>] do_IRQ+0x52/0xe0 [ 544.309376] [<ffffffff815d0cad>] common_interrupt+0x6d/0x6d [ 544.309376] [<000000000040a89f>] 0x40a89e [ 544.309376] Code: c2 48 89 d0 c3 89 f9 0f 32 31 c9 48 c1 e2 20 89 c0 89 0e 48 09 c2 48 89 d0 c3 66 66 2e 0f 1f 84 00 00 00 00 00 89 f0 89 f9 0f 30 <31> c0 c3 0f 1f 80 00 00 00 00 89 f9 0f 33 48 c1 e2 20 89 c0 48 [ 544.309376] INFO: NMI handler (arch_trigger_all_cpu_backtrace_handler) took too long to run: 47.746 msecs [ 544.563491] SysRq : HELP : loglevel(0-9) reboot(b) crash(c) terminate-all-tasks(e) memory-full-oom-kill(f) kill-all-tasks(i) thaw-filesystems(j) sak(k) show-backtrace-all-active-cpus(l) show-memory-usage(m) nice-all-RT-tasks(n) poweroff(o) show-registers(p) show-all-timers(q) unraw(r) sync(s) show-task-states(t) unmount(u) force-fb(V) show-blocked-tasks(w) dump-ftrace-buffer(z) [ 544.569707] SysRq : HELP : loglevel(0-9) reboot(b) crash(c) terminate-all-tasks(e) memory-full-oom-kill(f) kill-all-tasks(i) thaw-filesystems(j) sak(k) show-backtrace-all-active-cpus(l) show-memory-usage(m) nice-all-RT-tasks(n) poweroff(o) show-registers(p) show-all-timers(q) unraw(r) sync(s) show-task-states(t) unmount(u) force-fb(V) show-blocked-tasks(w) dump-ftrace-buffer(z)
https://bugzilla.novell.com/show_bug.cgi?id=888259
https://bugzilla.novell.com/show_bug.cgi?id=888259#c7
Jeff Mahoney jeffm@suse.com changed:
What |Removed |Added ---------------------------------------------------------------------------- Status|NEW |NEEDINFO InfoProvider| |coolo@suse.com AssignedTo|dsterba@suse.com |jeffm@suse.com
--- Comment #7 from Jeff Mahoney jeffm@suse.com 2014-09-17 08:06:46 EDT --- This isn't a btrfs issue. mkfs.btrfs is an ordinary userspace program that writes to a block device. I'd imagine you'd encounter the same issue with any program that writes to the block device.
I expect this is related to: commit 0738854939e6ec9b9111a8cfc0ca1dfa3cff6b2e Author: Ming Lei ming.lei@canonical.com Date: Tue Sep 2 23:02:59 2014 +0800
blk-merge: fix blk_recount_segments
... which is included in 3.17-rc5. I've added the patch to the stable tree. Please test a KOTD with the following commit: commit 5fca623fef82770d0a6895d3fb6382ac069cb1a6 Author: Jeff Mahoney jeffm@suse.com Date: Wed Sep 17 08:06:06 2014 -0400
blk-merge: fix blk_recount_segments (bnc#888259).
https://bugzilla.novell.com/show_bug.cgi?id=888259
https://bugzilla.novell.com/show_bug.cgi?id=888259#c8
--- Comment #8 from Stephan Kulow coolo@suse.com 2014-09-17 14:25:13 CEST --- I can't really test KOTD with installation. I can report back if the bug is gone in Factory though
https://bugzilla.novell.com/show_bug.cgi?id=888259
https://bugzilla.novell.com/show_bug.cgi?id=888259#c9
--- Comment #9 from Bernhard Wiedemann bwiedemann@suse.com 2014-09-18 13:00:47 CEST --- This is an autogenerated message for OBS integration: This bug (888259) was mentioned in https://build.opensuse.org/request/show/250084 Factory / kernel-source
http://bugzilla.novell.com/show_bug.cgi?id=888259
--- Comment #11 from Stephan Kulow coolo@suse.com --- any other theories?
-
bugzilla_noreply＠novell.com