Return-Path: Received: (majordomo@vger.kernel.org) by vger.kernel.org via listexpand id S1758533Ab1D2KXQ (ORCPT ); Fri, 29 Apr 2011 06:23:16 -0400 Received: from mail-qy0-f174.google.com ([209.85.216.174]:36093 "EHLO mail-qy0-f174.google.com" rhost-flags-OK-OK-OK-OK) by vger.kernel.org with ESMTP id S1754488Ab1D2KXM convert rfc822-to-8bit (ORCPT ); Fri, 29 Apr 2011 06:23:12 -0400 DomainKey-Signature: a=rsa-sha1; c=nofws; d=googlemail.com; s=gamma; h=mime-version:reply-to:in-reply-to:references:date:message-id :subject:from:to:cc:content-type:content-transfer-encoding; b=H0lFll3nCpeacp+qhJTPuhn24AGJCPpNMw9g4GEBjiAgBEc7Dt67bH+nCgiF0oSDdD zZ07x54P894JezCTKqiFqMTYvssP0tepiBlZZu4C6/gOOzzwBDY8pMsnnrTADvtxtm9G PAn3eVJ9msSI104awWdiuSiNhoRrCBEPMq6cA= MIME-Version: 1.0 Reply-To: sedat.dilek@gmail.com In-Reply-To: <1303924902.2583.13.camel@mulgrave.site> References: <1303920553.2583.7.camel@mulgrave.site> <1303921583-sup-4021@think> <1303923000.2583.8.camel@mulgrave.site> <1303923177-sup-2603@think> <1303924902.2583.13.camel@mulgrave.site> Date: Fri, 29 Apr 2011 12:23:09 +0200 Message-ID: Subject: Re: [BUG] fatal hang untarring 90GB file, possibly writeback related. From: Sedat Dilek To: James Bottomley Cc: Chris Mason , linux-fsdevel , linux-mm , linux-kernel Content-Type: text/plain; charset=UTF-8 Content-Transfer-Encoding: 8BIT Sender: linux-kernel-owner@vger.kernel.org List-ID: X-Mailing-List: linux-kernel@vger.kernel.org Content-Length: 40934 Lines: 587 Sorry for the top-posting! But as I see these RCU (CPU) stalls, the patch from [1] might be worth a try. First, I have seen negative effects on my UP-system was when playing with linux-next [2]. It was not clear what the origin was and the the side-effects were somehow "bizarre". The issue could be easily reproduced by tar-ing the kernel build-dir to an external USB-hdd. The issue kept RCU and TIP folks really busy. Before stepping 4 weeks in the dark, give it a try and let me know in case of success. For the systemd/cgroups part of the discussion (yes, I followed this thread in parallel): The patch from [4] might be interesting (untested here). Hope this helps you. Have fun! - Sedat - [1] http://git.us.kernel.org/?p=linux/kernel/git/tip/linux-2.6-tip.git;a=commit;h=ce31332d3c77532d6ea97ddcb475a2b02dd358b4 [2] http://lkml.org/lkml/2011/3/25/97 [3] http://lkml.org/lkml/2011/4/28/444 [4] https://patchwork.kernel.org/patch/738921/ On Wed, Apr 27, 2011 at 7:21 PM, James Bottomley wrote: > On Wed, 2011-04-27 at 12:54 -0400, Chris Mason wrote: >> Ok, I'd try turning it on so we catch the sleeping with a spinlock held >> case better. > > Will do, that's CONFIG_PREEMPT (rather than CONFIG_PREEMPT_VOLUNTARY)? > > This is the trace with sysrq-l and sysrq-w > > The repro this time doesn't have a soft lockup, just the tar is hung and > one of my CPUs is in 99% system. > > James > > --- > > > [  453.351255] SysRq : Show backtrace of all active CPUs > [  453.352601] sending NMI to all CPUs: > [  453.353849] NMI backtrace for cpu 3 > [  453.355545] CPU 3 > [  453.355560] Modules linked in: netconsole configfs cpufreq_ondemand acpi_cpufreq freq_table mperf snd_hda_codec_hdmi snd_hda_codec_conexant arc4 snd_hda_intel snd_hda_codec iwlagn snd_hwdep snd_seq mac80211 snd_seq_device uvcvideo btusb cfg80211 bluetooth wmi e1000e snd_pcm videodev rfkill i2c_i801 microcode iTCO_wdt iTCO_vendor_support xhci_hcd snd_timer v4l2_compat_ioctl32 joydev pcspkr snd soundcore snd_page_alloc uinput ipv6 sdhci_pci sdhci mmc_core i915 drm_kms_helper drm i2c_algo_bit i2c_core video [last unloaded: scsi_wait_scan] > [  453.363188] > [  453.365162] Pid: 46, comm: kswapd0 Not tainted 2.6.39-rc4+ #1 LENOVO 4170CTO/4170CTO > [  453.367133] RIP: 0010:[]  [] mutex_trylock+0x16/0x38 > [  453.369122] RSP: 0018:ffff88006dfc1d40  EFLAGS: 00000246 > [  453.371098] RAX: 0000000000000001 RBX: ffff880037de15f0 RCX: 0000000000000001 > [  453.373099] RDX: 0000000000000000 RSI: 0000000000000000 RDI: ffff880037875820 > [  453.375097] RBP: ffff88006dfc1d40 R08: 0000000000000000 R09: 00000000000074ad > [  453.377079] R10: 0000000000000002 R11: ffffffff81a44e50 R12: 0000000000000000 > [  453.379052] R13: 0000000000000000 R14: ffff880037875800 R15: ffff880037875820 > [  453.381015] FS:  0000000000000000(0000) GS:ffff8801002c0000(0000) knlGS:0000000000000000 > [  453.382985] CS:  0010 DS: 0000 ES: 0000 CR0: 000000008005003b > [  453.384944] CR2: 00007fbf8ea8d090 CR3: 0000000001a03000 CR4: 00000000000406e0 > [  453.386920] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 > [  453.388887] DR3: 0000000000000000 DR6: 00000000ffff0ff0 DR7: 0000000000000400 > [  453.390789] Process kswapd0 (pid: 46, threadinfo ffff88006dfc0000, task ffff88006dfb8000) > [  453.392649] Stack: > [  453.394473]  ffff88006dfc1d90 ffffffffa007ff52 ffff88006dfc1d90 ffffffff811613b5 > [  453.396337]  ffff88006dfc1d60 ffff880037de15f0 0000000000000000 0000000000000000 > [  453.398174]  00000000000000d0 000000000006366c ffff88006dfc1de0 ffffffff810e1f89 > [  453.400015] Call Trace: > [  453.401845]  [] i915_gem_inactive_shrink+0x2f/0x194 [i915] > [  453.403702]  [] ? mb_cache_shrink_fn+0x32/0xd0 > [  453.405499]  [] shrink_slab+0x6d/0x166 > [  453.407234]  [] kswapd+0x533/0x798 > [  453.408952]  [] ? mem_cgroup_shrink_node_zone+0xe3/0xe3 > [  453.410690]  [] kthread+0x84/0x8c > [  453.412432]  [] kernel_thread_helper+0x4/0x10 > [  453.414187]  [] ? kthread_worker_fn+0x148/0x148 > [  453.415945]  [] ? gs_change+0x13/0x13 > [  453.417671] Code: 00 48 c7 47 18 00 00 00 00 f0 ff 07 7f 05 e8 ed 02 00 00 5d c3 55 48 89 e5 0f 1f 44 00 00 b9 01 00 00 00 31 d2 89 c8 f0 0f b1 17 > [  453.417905]  c1 31 c0 ff c9 75 18 65 48 8b 04 25 c8 cc 00 00 48 2d d8 1f > [  453.421534] Call Trace: > [  453.423337]  [] i915_gem_inactive_shrink+0x2f/0x194 [i915] > [  453.425172]  [] ? mb_cache_shrink_fn+0x32/0xd0 > [  453.426997]  [] shrink_slab+0x6d/0x166 > [  453.428818]  [] kswapd+0x533/0x798 > [  453.430639]  [] ? mem_cgroup_shrink_node_zone+0xe3/0xe3 > [  453.432485]  [] kthread+0x84/0x8c > [  453.434298]  [] kernel_thread_helper+0x4/0x10 > [  453.436112]  [] ? kthread_worker_fn+0x148/0x148 > [  453.437894]  [] ? gs_change+0x13/0x13 > [  453.439654] NMI backtrace for cpu 2 > [  453.441508] CPU 2 > [  453.441525] Modules linked in: netconsole configfs cpufreq_ondemand acpi_cpufreq freq_table mperf snd_hda_codec_hdmi snd_hda_codec_conexant arc4 snd_hda_intel snd_hda_codec iwlagn snd_hwdep snd_seq mac80211 snd_seq_device uvcvideo btusb cfg80211 bluetooth wmi e1000e snd_pcm videodev rfkill i2c_i801 microcode iTCO_wdt iTCO_vendor_support xhci_hcd snd_timer v4l2_compat_ioctl32 joydev pcspkr snd soundcore snd_page_alloc uinput ipv6 sdhci_pci sdhci mmc_core i915 drm_kms_helper drm i2c_algo_bit i2c_core video [last unloaded: scsi_wait_scan] > [  453.449517] > [  453.451516] Pid: 0, comm: kworker/0:1 Not tainted 2.6.39-rc4+ #1 LENOVO 4170CTO/4170CTO > [  453.453704] RIP: 0010:[]  [] intel_idle+0xaa/0x100 > [  453.455772] RSP: 0018:ffff8800715c9e68  EFLAGS: 00000046 > [  453.457827] RAX: 0000000000000030 RBX: 0000000000000010 RCX: 0000000000000001 > [  453.459903] RDX: 0000000000000000 RSI: ffff8800715c9fd8 RDI: ffffffff81a0e640 > [  453.461999] RBP: ffff8800715c9eb8 R08: 000000000000006d R09: 00000000000003e5 > [  453.464039] R10: ffffffff00000002 R11: ffff880100293b40 R12: 0000000000000030 > [  453.466013] R13: 12187898d4512537 R14: 0000000000000004 R15: 0000000000000002 > [  453.467918] FS:  0000000000000000(0000) GS:ffff880100280000(0000) knlGS:0000000000000000 > [  453.469797] CS:  0010 DS: 0000 ES: 0000 CR0: 000000008005003b > [  453.471644] CR2: 0000000000452630 CR3: 0000000001a03000 CR4: 00000000000406e0 > [  453.473512] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 > [  453.475356] DR3: 0000000000000000 DR6: 00000000ffff0ff0 DR7: 0000000000000400 > [  453.477185] Process kworker/0:1 (pid: 0, threadinfo ffff8800715c8000, task ffff8800715a1700) > [  453.479024] Stack: > [  453.480855]  ffff8800715c9e88 ffffffff810731c0 ffff880100291290 0000000000011290 > [  453.482739]  ffff8800715c9eb8 000000028139c97a ffffe8ffffc80170 ffffe8ffffc80170 > [  453.484631]  ffffe8ffffc80300 0000000000000000 ffff8800715c9ef8 ffffffff8139b868 > [  453.486518] Call Trace: > [  453.488365]  [] ? pm_qos_request+0x3e/0x45 > [  453.490226]  [] cpuidle_idle_call+0xe7/0x166 > [  453.492096]  [] cpu_idle+0xa5/0xdf > [  453.493947]  [] start_secondary+0x223/0x225 > [  453.495791] Code: 28 e0 ff ff 80 e2 08 75 22 31 d2 48 83 c0 10 48 89 d1 0f 01 c8 0f ae f0 48 8b 86 38 e0 ff ff a8 08 75 08 b1 01 4c 89 e0 0f 01 c9 23 09 e0 ff 4c 29 e8 48 89 c7 e8 ab 29 de ff 4c 69 e0 40 42 > [  453.499958] Call Trace: > [  453.501895]  [] ? pm_qos_request+0x3e/0x45 > [  453.503837]  [] cpuidle_idle_call+0xe7/0x166 > [  453.505775]  [] cpu_idle+0xa5/0xdf > [  453.507687]  [] start_secondary+0x223/0x225 > [  453.509598] NMI backtrace for cpu 1 > [  453.511390] CPU 1 > [  453.511405] Modules linked in: netconsole configfs cpufreq_ondemand acpi_cpufreq freq_table mperf snd_hda_codec_hdmi snd_hda_codec_conexant arc4 snd_hda_intel snd_hda_codec iwlagn snd_hwdep snd_seq mac80211 snd_seq_device uvcvideo btusb cfg80211 bluetooth wmi e1000e snd_pcm videodev rfkill i2c_i801 microcode iTCO_wdt iTCO_vendor_support xhci_hcd snd_timer v4l2_compat_ioctl32 joydev pcspkr snd soundcore snd_page_alloc uinput ipv6 sdhci_pci sdhci mmc_core i915 drm_kms_helper drm i2c_algo_bit i2c_core video [last unloaded: scsi_wait_scan] > [  453.519288] > [  453.521289] Pid: 0, comm: kworker/0:0 Not tainted 2.6.39-rc4+ #1 LENOVO 4170CTO/4170CTO > [  453.523353] RIP: 0010:[]  [] intel_idle+0xaa/0x100 > [  453.525377] RSP: 0018:ffff880071587e68  EFLAGS: 00000046 > [  453.527353] RAX: 0000000000000010 RBX: 0000000000000004 RCX: 0000000000000001 > [  453.529332] RDX: 0000000000000000 RSI: ffff880071587fd8 RDI: ffffffff81a0e640 > [  453.531303] RBP: ffff880071587eb8 R08: 00000000000004af R09: 00000000000003e5 > [  453.533276] R10: ffffffff00000001 R11: ffff880100253b40 R12: 0000000000000010 > [  453.535249] R13: 12187898d4512ee3 R14: 0000000000000002 R15: 0000000000000001 > [  453.537229] FS:  0000000000000000(0000) GS:ffff880100240000(0000) knlGS:0000000000000000 > [  453.539224] CS:  0010 DS: 0000 ES: 0000 CR0: 000000008005003b > [  453.541210] CR2: 00000037d9071fa0 CR3: 0000000001a03000 CR4: 00000000000406e0 > [  453.543220] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 > [  453.545233] DR3: 0000000000000000 DR6: 00000000ffff0ff0 DR7: 0000000000000400 > [  453.547239] Process kworker/0:0 (pid: 0, threadinfo ffff880071586000, task ffff880071589700) > [  453.549274] Stack: > [  453.551289]  ffff880071587e88 ffffffff810731c0 ffff880100251290 0000000000011290 > [  453.553301]  ffff880071587eb8 000000018139c97a ffffe8ffffc40170 ffffe8ffffc40170 > [  453.555257]  ffffe8ffffc40240 0000000000000000 ffff880071587ef8 ffffffff8139b868 > [  453.557156] Call Trace: > [  453.558980]  [] ? pm_qos_request+0x3e/0x45 > [  453.560817]  [] cpuidle_idle_call+0xe7/0x166 > [  453.562635]  [] cpu_idle+0xa5/0xdf > [  453.564438]  [] start_secondary+0x223/0x225 > [  453.566227] Code: 28 e0 ff ff 80 e2 08 75 22 31 d2 48 83 c0 10 48 89 d1 0f 01 c8 0f ae f0 48 8b 86 38 e0 ff ff a8 08 75 08 b1 01 4c 89 e0 0f 01 c9 23 09 e0 ff 4c 29 e8 48 89 c7 e8 ab 29 de ff 4c 69 e0 40 42 > [  453.570292] Call Trace: > [  453.572196]  [] ? pm_qos_request+0x3e/0x45 > [  453.574117]  [] cpuidle_idle_call+0xe7/0x166 > [  453.576031]  [] cpu_idle+0xa5/0xdf > [  453.577924]  [] start_secondary+0x223/0x225 > [  453.579811] NMI backtrace for cpu 0 > [  453.581279] CPU 0 > [  453.581289] Modules linked in: netconsole configfs cpufreq_ondemand acpi_cpufreq freq_table mperf snd_hda_codec_hdmi snd_hda_codec_conexant arc4 snd_hda_intel snd_hda_codec iwlagn snd_hwdep snd_seq mac80211 snd_seq_device uvcvideo btusb cfg80211 bluetooth wmi e1000e snd_pcm videodev rfkill i2c_i801 microcode iTCO_wdt iTCO_vendor_support xhci_hcd snd_timer v4l2_compat_ioctl32 joydev pcspkr snd soundcore snd_page_alloc uinput ipv6 sdhci_pci sdhci mmc_core i915 drm_kms_helper drm i2c_algo_bit i2c_core video [last unloaded: scsi_wait_scan] > [  453.587576] > [  453.589160] Pid: 0, comm: swapper Not tainted 2.6.39-rc4+ #1 LENOVO 4170CTO/4170CTO > [  453.590777] RIP: 0010:[]  [] native_read_tsc+0x1/0x14 > [  453.592390] RSP: 0018:ffff880100203b98  EFLAGS: 00000883 > [  453.594001] RAX: 00000000f9ab6980 RBX: 0000000000002710 RCX: 0000000000000040 > [  453.595624] RDX: 000000000026066c RSI: 0000000000000100 RDI: 000000000026066d > [  453.597250] RBP: ffff880100203ba8 R08: 000000008b000052 R09: 0000000000000000 > [  453.598872] R10: 0000000000000000 R11: 0000000000000003 R12: 000000000026066d > [  453.600437] R13: 0000000000000000 R14: 0000000000000002 R15: 0000000000000001 > [  453.601924] FS:  0000000000000000(0000) GS:ffff880100200000(0000) knlGS:0000000000000000 > [  453.603434] CS:  0010 DS: 0000 ES: 0000 CR0: 000000008005003b > [  453.604942] CR2: 0000000000440360 CR3: 0000000001a03000 CR4: 00000000000406f0 > [  453.606460] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 > [  453.607981] DR3: 0000000000000000 DR6: 00000000ffff0ff0 DR7: 0000000000000400 > [  453.609597] Process swapper (pid: 0, threadinfo ffffffff81a00000, task ffffffff81a0b020) > [  453.611134] Stack: > [  453.612655]  ffff880100203ba8 ffffffff81232dfe ffff880100203bd8 ffffffff81232ecb > [  453.614176]  0000000000002710 0000000000000008 000000000000006c 0000000000000002 > [  453.615656]  ffff880100203be8 ffffffff81232e49 ffff880100203bf8 ffffffff81232e77 > [  453.617101] Call Trace: > [  453.618492]   > [  453.619874]  [] ? paravirt_read_tsc+0xe/0x12 > [  453.621251]  [] delay_tsc+0x27/0x74 > [  453.622613]  [] __delay+0xf/0x11 > [  453.623973]  [] __const_udelay+0x2c/0x2e > [  453.625322]  [] arch_trigger_all_cpu_backtrace+0x76/0x88 > [  453.626673]  [] sysrq_handle_showallcpus+0xe/0x10 > [  453.628027]  [] __handle_sysrq+0xa2/0x13c > [  453.629372]  [] sysrq_filter+0x112/0x16e > [  453.630706]  [] input_pass_event+0x94/0xcc > [  453.632028]  [] input_handle_event+0x480/0x48f > [  453.633342]  [] ? walk_tg_tree.constprop.71+0x28/0x94 > [  453.634655]  [] input_event+0x69/0x87 > [  453.635978]  [] atkbd_interrupt+0x4c1/0x58e > [  453.637283]  [] serio_interrupt+0x45/0x7f > [  453.638563]  [] i8042_interrupt+0x299/0x2ab > [  453.639830]  [] ? native_sched_clock+0x34/0x36 > [  453.641092]  [] handle_irq_event_percpu+0x5f/0x198 > [  453.642354]  [] handle_irq_event+0x38/0x56 > [  453.643598]  [] ? ack_apic_edge+0x25/0x29 > [  453.644832]  [] handle_edge_irq+0x9d/0xc0 > [  453.646069]  [] handle_irq+0x88/0x8e > [  453.647299]  [] do_IRQ+0x4d/0xa5 > [  453.648527]  [] common_interrupt+0x13/0x13 > [  453.649695]   > [  453.650794]  [] ? paravirt_read_tsc+0x9/0xd > [  453.651911]  [] ? intel_idle+0xdb/0x100 > [  453.653025]  [] ? intel_idle+0xba/0x100 > [  453.654129]  [] cpuidle_idle_call+0xe7/0x166 > [  453.655231]  [] cpu_idle+0xa5/0xdf > [  453.656329]  [] rest_init+0x72/0x74 > [  453.657417]  [] start_kernel+0x3de/0x3e9 > [  453.658514]  [] x86_64_start_reservations+0xaf/0xb3 > [  453.659576]  [] ? early_idt_handlers+0x140/0x140 > [  453.660589]  [] x86_64_start_kernel+0x102/0x111 > [  453.661559] Code: 21 00 00 e8 74 3d 22 00 5d c3 90 90 90 55 40 88 f8 48 89 e5 e6 70 e4 71 5d c3 55 40 88 f0 48 89 e5 e6 70 40 88 f8 e6 71 5d c3 55 > [  453.661721]  89 e5 0f 31 89 c1 48 89 d0 48 c1 e0 20 48 09 c8 5d c3 55 b2 > [  453.663728] Call Trace: > [  453.664713]    [] ? paravirt_read_tsc+0xe/0x12 > [  453.665710]  [] delay_tsc+0x27/0x74 > [  453.666698]  [] __delay+0xf/0x11 > [  453.667686]  [] __const_udelay+0x2c/0x2e > [  453.668675]  [] arch_trigger_all_cpu_backtrace+0x76/0x88 > [  453.669676]  [] sysrq_handle_showallcpus+0xe/0x10 > [  453.670681]  [] __handle_sysrq+0xa2/0x13c > [  453.671676]  [] sysrq_filter+0x112/0x16e > [  453.672662]  [] input_pass_event+0x94/0xcc > [  453.673646]  [] input_handle_event+0x480/0x48f > [  453.674627]  [] ? walk_tg_tree.constprop.71+0x28/0x94 > [  453.675614]  [] input_event+0x69/0x87 > [  453.676587]  [] atkbd_interrupt+0x4c1/0x58e > [  453.677550]  [] serio_interrupt+0x45/0x7f > [  453.678498]  [] i8042_interrupt+0x299/0x2ab > [  453.679431]  [] ? native_sched_clock+0x34/0x36 > [  453.680351]  [] handle_irq_event_percpu+0x5f/0x198 > [  453.681270]  [] handle_irq_event+0x38/0x56 > [  453.682186]  [] ? ack_apic_edge+0x25/0x29 > [  453.683100]  [] handle_edge_irq+0x9d/0xc0 > [  453.684014]  [] handle_irq+0x88/0x8e > [  453.684924]  [] do_IRQ+0x4d/0xa5 > [  453.685831]  [] common_interrupt+0x13/0x13 > [  453.686740]    [] ? paravirt_read_tsc+0x9/0xd > [  453.687655]  [] ? intel_idle+0xdb/0x100 > [  453.688573]  [] ? intel_idle+0xba/0x100 > [  453.689480]  [] cpuidle_idle_call+0xe7/0x166 > [  453.690387]  [] cpu_idle+0xa5/0xdf > [  453.691293]  [] rest_init+0x72/0x74 > [  453.692195]  [] start_kernel+0x3de/0x3e9 > [  453.693095]  [] x86_64_start_reservations+0xaf/0xb3 > [  453.693996]  [] ? early_idt_handlers+0x140/0x140 > [  453.694905]  [] x86_64_start_kernel+0x102/0x111 > [  454.680802] SysRq : Show Blocked State > [  454.683427]   task                        PC stack   pid father > [  454.686058] systemd         D 0000000000000000     0     1      0 0x00000000 > [  454.688752]  ffff8801003bdcd8 0000000000000082 ffff8801003bdc88 ffffffff00000000 > [  454.691491]  ffff880100370000 ffff8801003bdfd8 ffff8801003bdfd8 0000000000013b40 > [  454.694228]  ffff8800715e1700 ffff880100370000 ffff8801003bdcb8 00000001811329db > [  454.696969] Call Trace: > [  454.699683]  [] schedule_timeout+0x34/0xde > [  454.702447]  [] ? __call_rcu+0x123/0x12c > [  454.705184]  [] ? call_rcu_sched+0x15/0x17 > [  454.707906]  [] wait_for_common+0xac/0x101 > [  454.710656]  [] ? try_to_wake_up+0x226/0x226 > [  454.713445]  [] wait_for_completion+0x1d/0x1f > [  454.716199]  [] synchronize_sched+0x5a/0x5c > [  454.718972]  [] ? find_ge_pid+0x43/0x43 > [  454.721766]  [] cgroup_diput+0x37/0xe3 > [  454.724562]  [] ? parse_cgroupfs_options+0x353/0x353 > [  454.727328]  [] dentry_kill+0xfa/0x121 > [  454.730103]  [] dput+0xdd/0xea > [  454.732866]  [] do_rmdir+0xc6/0xfe > [  454.735481]  [] ? filp_close+0x6e/0x7a > [  454.737990]  [] sys_rmdir+0x16/0x18 > [  454.740469]  [] system_call_fastpath+0x16/0x1b > [  454.742935] flush-253:2     D 0000000000000000     0   793      2 0x00000000 > [  454.745425]  ffff88006355b710 0000000000000046 ffff88006355b6b0 ffffffff00000000 > [  454.747955]  ffff880037ee9700 ffff88006355bfd8 ffff88006355bfd8 0000000000013b40 > [  454.750506]  ffffffff81a0b020 ffff880037ee9700 ffff88006355b710 000000018106e7c3 > [  454.753048] Call Trace: > [  454.755537]  [] do_get_write_access+0x1c6/0x38d > [  454.758071]  [] ? autoremove_wake_function+0x3d/0x3d > [  454.760644]  [] jbd2_journal_get_write_access+0x2b/0x42 > [  454.763206]  [] ? ext4_read_block_bitmap+0x54/0x2d0 > [  454.765770]  [] __ext4_journal_get_write_access+0x58/0x66 > [  454.768353]  [] ext4_mb_mark_diskspace_used+0x70/0x2ae > [  454.770942]  [] ext4_mb_new_blocks+0x1c8/0x3c2 > [  454.773501]  [] ext4_ext_map_blocks+0x1961/0x1c04 > [  454.776082]  [] ? radix_tree_gang_lookup_tag_slot+0x81/0xa2 > [  454.778711]  [] ? find_get_pages_tag+0x3b/0xd6 > [  454.781323]  [] ext4_map_blocks+0x112/0x1e7 > [  454.783894]  [] mpage_da_map_and_submit+0x93/0x2cd > [  454.786491]  [] ext4_da_writepages+0x2c1/0x44d > [  454.789090]  [] do_writepages+0x21/0x2a > [  454.791703]  [] writeback_single_inode+0xb2/0x1bc > [  454.794334]  [] writeback_sb_inodes+0xcd/0x161 > [  454.796962]  [] writeback_inodes_wb+0x119/0x12b > [  454.799582]  [] wb_writeback+0x1ee/0x335 > [  454.802204]  [] ? arch_local_irq_save+0x15/0x1b > [  454.804803]  [] ? _raw_spin_lock_irqsave+0x12/0x2f > [  454.807427]  [] wb_do_writeback+0x143/0x19d > [  454.810077]  [] ? schedule_timeout+0xb0/0xde > [  454.812776]  [] bdi_writeback_thread+0x88/0x1e5 > [  454.815464]  [] ? wb_do_writeback+0x19d/0x19d > [  454.818129]  [] kthread+0x84/0x8c > [  454.820808]  [] kernel_thread_helper+0x4/0x10 > [  454.823452]  [] ? kthread_worker_fn+0x148/0x148 > [  454.826103]  [] ? gs_change+0x13/0x13 > [  454.828711] jbd2/dm-2-8     D 0000000000000000     0   799      2 0x00000000 > [  454.831390]  ffff88006d59db10 0000000000000046 ffff88006d59daa0 ffffffff00000000 > [  454.834094]  ffff88006deb4500 ffff88006d59dfd8 ffff88006d59dfd8 0000000000013b40 > [  454.836788]  ffffffff81a0b020 ffff88006deb4500 ffff88006d59dad0 000000016d59dad0 > [  454.839453] Call Trace: > [  454.842098]  [] ? lock_page+0x3e/0x3e > [  454.844738]  [] ? lock_page+0x3e/0x3e > [  454.847303]  [] io_schedule+0x63/0x7e > [  454.849877]  [] sleep_on_page+0xe/0x12 > [  454.852469]  [] __wait_on_bit+0x48/0x7b > [  454.855021]  [] wait_on_page_bit+0x72/0x74 > [  454.857583]  [] ? autoremove_wake_function+0x3d/0x3d > [  454.860171]  [] filemap_fdatawait_range+0x84/0x163 > [  454.862744]  [] filemap_fdatawait+0x24/0x26 > [  454.865299]  [] jbd2_journal_commit_transaction+0x922/0x1194 > [  454.867892]  [] ? __switch_to+0xc6/0x220 > [  454.870496]  [] kjournald2+0xc9/0x20a > [  454.873103]  [] ? remove_wait_queue+0x3a/0x3a > [  454.875690]  [] ? commit_timeout+0x10/0x10 > [  454.878327]  [] kthread+0x84/0x8c > [  454.880961]  [] kernel_thread_helper+0x4/0x10 > [  454.883604]  [] ? kthread_worker_fn+0x148/0x148 > [  454.886262]  [] ? gs_change+0x13/0x13 > [  454.888875] tar             D ffff88006e573af8     0   991    838 0x00000000 > [  454.891546]  ffff880037f5b8a8 0000000000000086 ffff8801002a1d40 0000000000000282 > [  454.894213]  ffff88006d644500 ffff880037f5bfd8 ffff880037f5bfd8 0000000000013b40 > [  454.896889]  ffff8801002b4500 ffff88006d644500 ffff880037f5b8a8 ffffffff8106e7c3 > [  454.899530] Call Trace: > [  454.902118]  [] ? prepare_to_wait+0x6c/0x78 > [  454.904724]  [] do_get_write_access+0x1c6/0x38d > [  454.907344]  [] ? autoremove_wake_function+0x3d/0x3d > [  454.909967]  [] ? ext4_dirty_inode+0x33/0x4c > [  454.912574]  [] jbd2_journal_get_write_access+0x2b/0x42 > [  454.915192]  [] __ext4_journal_get_write_access+0x58/0x66 > [  454.917819]  [] ext4_reserve_inode_write+0x41/0x83 > [  454.920459]  [] ext4_mark_inode_dirty+0x7c/0x1f0 > [  454.923070]  [] ext4_dirty_inode+0x33/0x4c > [  454.925660]  [] __mark_inode_dirty+0x2f/0x175 > [  454.928247]  [] generic_write_end+0x6c/0x7e > [  454.930865]  [] ext4_da_write_end+0x1a5/0x204 > [  454.933454]  [] generic_file_buffered_write+0x17e/0x23a > [  454.936062]  [] __generic_file_aio_write+0x242/0x272 > [  454.938648]  [] generic_file_aio_write+0x61/0xba > [  454.941288]  [] ext4_file_write+0x1dc/0x234 > [  454.943909]  [] do_sync_write+0xbf/0xff > [  454.946501]  [] ? fsnotify+0x1eb/0x217 > [  454.949114]  [] ? selinux_file_permission+0x58/0xb4 > [  454.951736]  [] ? security_file_permission+0x2e/0x33 > [  454.954349]  [] ? rw_verify_area+0xb0/0xcd > [  454.956943]  [] vfs_write+0xac/0xf3 > [  454.959530]  [] sys_write+0x4a/0x6e > [  454.962129]  [] system_call_fastpath+0x16/0x1b > [  454.964732] dhclient-script D 0000000000000000     0  2856   2855 0x00000000 > [  454.967360]  ffff88006e1f5b18 0000000000000082 ffff8800378da880 0000000000000000 > [  454.970056]  ffff88006deb1700 ffff88006e1f5fd8 ffff88006e1f5fd8 0000000000013b40 > [  454.972706]  ffff880071589700 ffff88006deb1700 ffff88006e1f5ad8 000000016e1f5ad8 > [  454.975323] Call Trace: > [  454.977882]  [] ? sleep_on_page+0x12/0x12 > [  454.980477]  [] io_schedule+0x63/0x7e > [  454.983063]  [] sleep_on_page_killable+0xe/0x3b > [  454.985622]  [] __wait_on_bit_lock+0x46/0x8f > [  454.988182]  [] __lock_page_killable+0x66/0x68 > [  454.990785]  [] ? autoremove_wake_function+0x3d/0x3d > [  454.993436]  [] lock_page_killable+0x3e/0x43 > [  454.996099]  [] generic_file_aio_read+0x463/0x640 > [  454.998730]  [] do_sync_read+0xbf/0xff > [  455.001383]  [] ? avc_has_perm+0x51/0x63 > [  455.004012]  [] ? security_file_permission+0x2e/0x33 > [  455.006644]  [] ? rw_verify_area+0xb0/0xcd > [  455.009289]  [] vfs_read+0xa9/0xf0 > [  455.011917]  [] kernel_read+0x41/0x4f > [  455.014511]  [] prepare_binprm+0xe4/0xe8 > [  455.017094]  [] do_execve+0x114/0x277 > [  455.019678]  [] sys_execve+0x43/0x5a > [  455.022281]  [] stub_execve+0x6c/0xc0 > [  455.024888] Sched Debug Version: v0.10, 2.6.39-rc4+ #1 > [  455.027487] ktime                                   : 455879.226285 > [  455.030142] sched_clk                               : 455024.886257 > [  455.032786] cpu_clk                                 : 455024.886397 > [  455.035352] jiffies                                 : 4295123185 > [  455.037904] sched_clock_stable                      : 1 > [  455.040413] > [  455.042892] sysctl_sched > [  455.045306]   .sysctl_sched_latency                    : 18.000000 > [  455.047775]   .sysctl_sched_min_granularity            : 2.250000 > [  455.050206]   .sysctl_sched_wakeup_granularity         : 3.000000 > [  455.052643]   .sysctl_sched_child_runs_first           : 0 > [  455.055034]   .sysctl_sched_features                   : 7279 > [  455.057423]   .sysctl_sched_tunable_scaling            : 1 (logaritmic) > [  455.059829] > [  455.059830] cpu#0, 2491.994 MHz > [  455.064443]   .nr_running                    : 0 > [  455.066757]   .load                          : 0 > [  455.069054]   .nr_switches                   : 146510 > [  455.071353]   .nr_load_updates               : 233084 > [  455.073642]   .nr_uninterruptible            : 2 > [  455.075894]   .next_balance                  : 4295.122831 > [  455.078152]   .curr->pid                     : 0 > [  455.080396]   .clock                         : 454680.481348 > [  455.082634]   .cpu_load[0]                   : 0 > [  455.084867]   .cpu_load[1]                   : 0 > [  455.087065]   .cpu_load[2]                   : 0 > [  455.089233]   .cpu_load[3]                   : 0 > [  455.091390]   .cpu_load[4]                   : 0 > [  455.093499]   .yld_count                     : 0 > [  455.095605]   .sched_switch                  : 0 > [  455.097667]   .sched_count                   : 149062 > [  455.099765]   .sched_goidle                  : 62756 > [  455.101781]   .avg_idle                      : 1000000 > [  455.103807]   .ttwu_count                    : 77219 > [  455.105958]   .ttwu_local                    : 74144 > [  455.107957]   .bkl_count                     : 0 > [  455.109914] > [  455.109915] cfs_rq[0]:/ > [  455.113642]   .exec_clock                    : 20017.048374 > [  455.115515]   .MIN_vruntime                  : 0.000001 > [  455.117353]   .min_vruntime                  : 28900.800090 > [  455.119185]   .max_vruntime                  : 0.000001 > [  455.121028]   .spread                        : 0.000000 > [  455.122820]   .spread0                       : 0.000000 > [  455.124581]   .nr_spread_over                : 54 > [  455.126318]   .nr_running                    : 0 > [  455.128045]   .load                          : 0 > [  455.129743]   .load_avg                      : 0.000000 > [  455.131414]   .load_period                   : 0.000000 > [  455.133052]   .load_contrib                  : 0 > [  455.134692]   .load_tg                       : 0 > [  455.136305] > [  455.136306] runnable tasks: > [  455.136307]             task   PID         tree-key  switches  prio     exec-runtime         sum-exec        sum-sleep > [  455.136310] ---------------------------------------------------------------------------------------------------------- > [  455.142856] > [  455.142857] cpu#1, 2491.994 MHz > [  455.146215]   .nr_running                    : 0 > [  455.147931]   .load                          : 0 > [  455.149648]   .nr_switches                   : 62175 > [  455.151348]   .nr_load_updates               : 217324 > [  455.153045]   .nr_uninterruptible            : 2 > [  455.154747]   .next_balance                  : 4295.123306 > [  455.156457]   .curr->pid                     : 0 > [  455.158149]   .clock                         : 455157.364642 > [  455.159867]   .cpu_load[0]                   : 0 > [  455.161594]   .cpu_load[1]                   : 0 > [  455.163283]   .cpu_load[2]                   : 0 > [  455.164954]   .cpu_load[3]                   : 0 > [  455.166575]   .cpu_load[4]                   : 0 > [  455.168185]   .yld_count                     : 60 > [  455.169791]   .sched_switch                  : 0 > [  455.171401]   .sched_count                   : 62899 > [  455.172984]   .sched_goidle                  : 27394 > [  455.174580]   .avg_idle                      : 1000000 > [  455.176171]   .ttwu_count                    : 30510 > [  455.177739]   .ttwu_local                    : 25277 > [  455.179292]   .bkl_count                     : 0 > [  455.180882] > [  455.180883] cfs_rq[1]:/ > [  455.183954]   .exec_clock                    : 10655.021809 > [  455.185550]   .MIN_vruntime                  : 0.000001 > [  455.187141]   .min_vruntime                  : 19718.135550 > [  455.188771]   .max_vruntime                  : 0.000001 > [  455.190407]   .spread                        : 0.000000 > [  455.192016]   .spread0                       : -9182.664540 > [  455.193634]   .nr_spread_over                : 80 > [  455.195242]   .nr_running                    : 0 > [  455.196848]   .load                          : 0 > [  455.198441]   .load_avg                      : 0.000000 > [  455.200059]   .load_period                   : 0.000000 > [  455.201654]   .load_contrib                  : 0 > [  455.203240]   .load_tg                       : 0 > [  455.204836] > [  455.204837] runnable tasks: > [  455.204838]             task   PID         tree-key  switches  prio     exec-runtime         sum-exec        sum-sleep > [  455.204841] ---------------------------------------------------------------------------------------------------------- > [  455.211403] > [  455.211404] cpu#2, 2491.994 MHz > [  455.214958]   .nr_running                    : 0 > [  455.216771]   .load                          : 0 > [  455.218564]   .nr_switches                   : 37444 > [  455.220394]   .nr_load_updates               : 219042 > [  455.222202]   .nr_uninterruptible            : 0 > [  455.224039]   .next_balance                  : 4295.123375 > [  455.225897]   .curr->pid                     : 0 > [  455.227769]   .clock                         : 455227.204963 > [  455.229681]   .cpu_load[0]                   : 0 > [  455.231548]   .cpu_load[1]                   : 0 > [  455.233353]   .cpu_load[2]                   : 0 > [  455.235059]   .cpu_load[3]                   : 0 > [  455.236676]   .cpu_load[4]                   : 0 > [  455.238280]   .yld_count                     : 0 > [  455.239879]   .sched_switch                  : 0 > [  455.241471]   .sched_count                   : 37815 > [  455.243075]   .sched_goidle                  : 16831 > [  455.244674]   .avg_idle                      : 1000000 > [  455.246270]   .ttwu_count                    : 18348 > [  455.247849]   .ttwu_local                    : 16899 > [  455.249430]   .bkl_count                     : 0 > [  455.250992] > [  455.250993] cfs_rq[2]:/ > [  455.254040]   .exec_clock                    : 6758.351942 > [  455.255630]   .MIN_vruntime                  : 0.000001 > [  455.257236]   .min_vruntime                  : 13719.942866 > [  455.258861]   .max_vruntime                  : 0.000001 > [  455.260497]   .spread                        : 0.000000 > [  455.262122]   .spread0                       : -15180.857224 > [  455.263753]   .nr_spread_over                : 21 > [  455.265389]   .nr_running                    : 0 > [  455.267018]   .load                          : 0 > [  455.268637]   .load_avg                      : 0.000000 > [  455.270292]   .load_period                   : 0.000000 > [  455.271911]   .load_contrib                  : 0 > [  455.273530]   .load_tg                       : 0 > [  455.275163] > [  455.275165] runnable tasks: > [  455.275166]             task   PID         tree-key  switches  prio     exec-runtime         sum-exec        sum-sleep > [  455.275169] ---------------------------------------------------------------------------------------------------------- > [  455.281810] > [  455.281811] cpu#3, 2491.994 MHz > [  455.285349]   .nr_running                    : 4 > [  455.287149]   .load                          : 2048 > [  455.288952]   .nr_switches                   : 30358 > [  455.290787]   .nr_load_updates               : 223302 > [  455.292599]   .nr_uninterruptible            : 1 > [  455.294419]   .next_balance                  : 4295.123506 > [  455.296250]   .curr->pid                     : 46 > [  455.298090]   .clock                         : 431792.394314 > [  455.299953]   .cpu_load[0]                   : 2048 > [  455.301810]   .cpu_load[1]                   : 2048 > [  455.303610]   .cpu_load[2]                   : 2048 > [  455.305311]   .cpu_load[3]                   : 2048 > [  455.306926]   .cpu_load[4]                   : 2048 > [  455.308531]   .yld_count                     : 63 > [  455.310130]   .sched_switch                  : 0 > [  455.311723]   .sched_count                   : 30824 > [  455.313315]   .sched_goidle                  : 13491 > [  455.314904]   .avg_idle                      : 1000000 > [  455.316481]   .ttwu_count                    : 13858 > [  455.318057]   .ttwu_local                    : 12507 > [  455.319629]   .bkl_count                     : 0 > [  455.321187] > [  455.321188] cfs_rq[3]:/ > [  455.324213]   .exec_clock                    : 5334.144946 > [  455.325795]   .MIN_vruntime                  : 13295.262803 > [  455.327401]   .min_vruntime                  : 13302.523317 > [  455.329046]   .max_vruntime                  : 13295.262803 > [  455.330656]   .spread                        : 0.000000 > [  455.332297]   .spread0                       : -15598.276773 > [  455.333925]   .nr_spread_over                : 117 > [  455.335577]   .nr_running                    : 2 > [  455.337204]   .load                          : 2048 > [  455.338823]   .load_avg                      : 0.000000 > [  455.340476]   .load_period                   : 0.000000 > [  455.342094]   .load_contrib                  : 0 > [  455.343702]   .load_tg                       : 0 > [  455.345302] > [  455.345303] rt_rq[3]:/ > [  455.348416]   .rt_nr_running                 : 1 > [  455.350006]   .rt_throttled                  : 0 > [  455.351587]   .rt_time                       : 0.000000 > [  455.353173]   .rt_runtime                    : 950.000000 > [  455.354759] > [  455.354760] runnable tasks: > [  455.354761]             task   PID         tree-key  switches  prio     exec-runtime         sum-exec        sum-sleep > [  455.354764] ---------------------------------------------------------------------------------------------------------- > [  455.361357]      migration/3    17         0.000000      1084     0         0.000000         0.000933         0.000000 / > [  455.363278]       watchdog/3    20         0.000000        31     0         0.000000         0.780405         0.002351 / > [  455.365212] R        kswapd0    46     13302.523317       714   120     13302.523317      1148.767369    245855.504389 / > [  455.367220]      kworker/3:1    74     13295.262803     10488   120     13295.262803       324.924994    315669.659686 / > [  455.369317] > > > -- > To unsubscribe from this list: send the line "unsubscribe linux-fsdevel" in > the body of a message to majordomo@vger.kernel.org > More majordomo info at  http://vger.kernel.org/majordomo-info.html > -- To unsubscribe from this list: send the line "unsubscribe linux-kernel" in the body of a message to majordomo@vger.kernel.org More majordomo info at http://vger.kernel.org/majordomo-info.html Please read the FAQ at http://www.tux.org/lkml/