git checkout 6d0abeca3242a88cab8232e4acd7e2bf088f3bc2 ls -a /kernel-tests/run-queue/kvm/i386-randconfig-an1-02182100/linux-devel:devel-hourly-2014021821:6d0abeca3242a88cab8232e4acd7e2bf088f3bc2:bisect-linux 2014-02-19 00:58:36: cmd_fail: '/bin/grep' '-r' '--include=dmesg-*' '-s' '-l' 'BUG: MAX_LOCK_DEPTH too' '/kernel/i386-randconfig-an1-02182100/6d0abeca3242a88cab8232e4acd7e2bf088f3bc2' , ret=2, ref: /kernel-tests/failed-cmd/bee-grep-kbuild.log 2014-02-19-00:58:36 6d0abeca3242a88cab8232e4acd7e2bf088f3bc2 compiling 77 real 1241 user 110 sys 1738.94% cpu i386-randconfig-an1-02182100 2014-02-19-01:00:04 detecting boot state 3.14.0-rc3.... 6 10 23 SUCCESS bisect: good commit 6d0abeca3242a88cab8232e4acd7e2bf088f3bc2 git bisect start d5471974ffc0bd5cbf7213231e4d6276007cab37 6d0abeca3242a88cab8232e4acd7e2bf088f3bc2 -- /c/kernel-tests/linear-bisect: ["-b", "d5471974ffc0bd5cbf7213231e4d6276007cab37", "-g", "6d0abeca3242a88cab8232e4acd7e2bf088f3bc2", "/c/kernel-tests/bisect-test-boot-failure.sh", "/kernel-tests/linux/obj-bisect"] Bisecting: 1897 revisions left to test after this (roughly 11 steps) [52732e61f8895e45c10f3b1977b1252a58a2b64e] Merge 'drdb/for-3.15-p2' into devel-hourly-2014021821 running /c/kernel-tests/bisect-test-boot-failure.sh /kernel-tests/linux/obj-bisect ls -a /kernel-tests/run-queue/kvm/i386-randconfig-an1-02182100/linux-devel:devel-hourly-2014021821:52732e61f8895e45c10f3b1977b1252a58a2b64e:bisect-linux 2014-02-19 01:03:36: cmd_fail: '/bin/grep' '-r' '--include=dmesg-*' '-s' '-l' 'BUG: MAX_LOCK_DEPTH too' '/kernel/i386-randconfig-an1-02182100/52732e61f8895e45c10f3b1977b1252a58a2b64e' , ret=2, ref: /kernel-tests/failed-cmd/bee-grep-kbuild.log 2014-02-19-01:03:36 52732e61f8895e45c10f3b1977b1252a58a2b64e compiling 74 real 1240 user 112 sys 1818.00% cpu i386-randconfig-an1-02182100 2014-02-19-01:05:04 detecting boot state 3.14.0-rc3-wl-ath-01203-g52732e6.. 5 12 17 19 23 SUCCESS Bisecting: 694 revisions left to test after this (roughly 10 steps) [9737c3be3ccc4aac6ab919b897dcf68c4a2b4f33] Merge 'arm-perf/misc-patches' into devel-hourly-2014021821 running /c/kernel-tests/bisect-test-boot-failure.sh /kernel-tests/linux/obj-bisect ls -a /kernel-tests/run-queue/kvm/i386-randconfig-an1-02182100/linux-devel:devel-hourly-2014021821:9737c3be3ccc4aac6ab919b897dcf68c4a2b4f33:bisect-linux 2014-02-19 01:08:35: cmd_fail: '/bin/grep' '-r' '--include=dmesg-*' '-s' '-l' 'BUG: MAX_LOCK_DEPTH too' '/kernel/i386-randconfig-an1-02182100/9737c3be3ccc4aac6ab919b897dcf68c4a2b4f33' , ret=2, ref: /kernel-tests/failed-cmd/bee-grep-kbuild.log 2014-02-19-01:08:35 9737c3be3ccc4aac6ab919b897dcf68c4a2b4f33 compiling 73 real 1240 user 111 sys 1829.54% cpu i386-randconfig-an1-02182100 2014-02-19-01:10:03 detecting boot state 3.14.0-rc3-wl-ath-01486-g9737c3be.. 2 10 18 22 23 SUCCESS Bisecting: 411 revisions left to test after this (roughly 9 steps) [0e1ba5d0198d3d1cd947287661fc9ac30164e666] Merge 'regulator/topic/tps6507x' into devel-hourly-2014021821 running /c/kernel-tests/bisect-test-boot-failure.sh /kernel-tests/linux/obj-bisect ls -a /kernel-tests/run-queue/kvm/i386-randconfig-an1-02182100/linux-devel:devel-hourly-2014021821:0e1ba5d0198d3d1cd947287661fc9ac30164e666:bisect-linux 2014-02-19 01:13:33: cmd_fail: '/bin/grep' '-r' '--include=dmesg-*' '-s' '-l' 'BUG: MAX_LOCK_DEPTH too' '/kernel/i386-randconfig-an1-02182100/0e1ba5d0198d3d1cd947287661fc9ac30164e666' , ret=2, ref: /kernel-tests/failed-cmd/bee-grep-kbuild.log 2014-02-19-01:13:33 0e1ba5d0198d3d1cd947287661fc9ac30164e666 compiling 17 real 97 user 10 sys 624.51% cpu i386-randconfig-an1-02182100 2014-02-19-01:13:59 detecting boot state 3.14.0-rc3-wl-ath-01749-g0e1ba5d.. 3 19 23 SUCCESS Bisecting: 148 revisions left to test after this (roughly 8 steps) [b8e87ddb72da627fd03aeb02b77c07065e13427c] Merge 'iio/fixes-togreg' into devel-hourly-2014021821 running /c/kernel-tests/bisect-test-boot-failure.sh /kernel-tests/linux/obj-bisect ls -a /kernel-tests/run-queue/kvm/i386-randconfig-an1-02182100/linux-devel:devel-hourly-2014021821:b8e87ddb72da627fd03aeb02b77c07065e13427c:bisect-linux 2014-02-19 01:16:34: cmd_fail: '/bin/grep' '-r' '--include=dmesg-*' '-s' '-l' 'BUG: MAX_LOCK_DEPTH too' '/kernel/i386-randconfig-an1-02182100/b8e87ddb72da627fd03aeb02b77c07065e13427c' , ret=2, ref: /kernel-tests/failed-cmd/bee-grep-kbuild.log 2014-02-19-01:16:34 b8e87ddb72da627fd03aeb02b77c07065e13427c compiling 14 real 29 user 4 sys 248.56% cpu i386-randconfig-an1-02182100 2014-02-19-01:17:41 detecting boot state 3.14.0-rc3-wl-ath-01821-gb8e87dd.. 2 12 18 23 SUCCESS Bisecting: 76 revisions left to test after this (roughly 7 steps) [6648c2574f90963cb0bc2421f00f173e9fdc8cc0] Merge 'arm-perf/pci/bios32' into devel-hourly-2014021821 running /c/kernel-tests/bisect-test-boot-failure.sh /kernel-tests/linux/obj-bisect ls -a /kernel-tests/run-queue/kvm/i386-randconfig-an1-02182100/linux-devel:devel-hourly-2014021821:6648c2574f90963cb0bc2421f00f173e9fdc8cc0:bisect-linux 2014-02-19 01:20:42: cmd_fail: '/bin/grep' '-r' '--include=dmesg-*' '-s' '-l' 'BUG: MAX_LOCK_DEPTH too' '/kernel/i386-randconfig-an1-02182100/6648c2574f90963cb0bc2421f00f173e9fdc8cc0' , ret=2, ref: /kernel-tests/failed-cmd/bee-grep-kbuild.log 2014-02-19-01:20:42 6648c2574f90963cb0bc2421f00f173e9fdc8cc0 compiling 60 real 1083 user 94 sys 1939.47% cpu i386-randconfig-an1-02182100 2014-02-19-01:21:55 detecting boot state 3.14.0-rc3-wl-ath-01875-g6648c25.. 10 20 23 SUCCESS Bisecting: 22 revisions left to test after this (roughly 5 steps) [037d40fe91c5721054a8d1a61cd926dbdb75f968] Merge 'alexshi/single-balance' into devel-hourly-2014021821 running /c/kernel-tests/bisect-test-boot-failure.sh /kernel-tests/linux/obj-bisect ls -a /kernel-tests/run-queue/kvm/i386-randconfig-an1-02182100/linux-devel:devel-hourly-2014021821:037d40fe91c5721054a8d1a61cd926dbdb75f968:bisect-linux 2014-02-19 01:24:30: cmd_fail: '/bin/grep' '-r' '--include=dmesg-*' '-s' '-l' 'BUG: MAX_LOCK_DEPTH too' '/kernel/i386-randconfig-an1-02182100/037d40fe91c5721054a8d1a61cd926dbdb75f968' , ret=2, ref: /kernel-tests/failed-cmd/bee-grep-kbuild.log 2014-02-19-01:24:31 037d40fe91c5721054a8d1a61cd926dbdb75f968 compiling 83 real 1242 user 107 sys 1619.29% cpu i386-randconfig-an1-02182100 2014-02-19-01:27:12 detecting boot state 3.14.0-rc3-wl-ath-01896-g037d40f.. TEST FAILURE [ 1.193361] softirq: huh, entered softirq 7 SCHED 4107f8c4 with preempt_count 00000100, exited with 00000101? [ 1.196697] softirq: huh, entered softirq 7 SCHED 4107f8c4 with preempt_count 00000100, exited with 00000101? [ 1.200028] softirq: huh, entered softirq 7 SCHED 4107f8c4 with preempt_count 00000100, exited with 00000101? [ 1.200750] BUG: MAX_LOCK_DEPTH too low! [ 1.201061] turning off the locking correctness validator. [ 1.201449] Please attach the output of /proc/lock_stat to the bug report [ 1.201932] depth: 48 max: 48! [ 1.202160] 48 locks held by swapper/0/1: [ 1.202447] #0: (rcu_read_lock){.+.+.+}, at: [<4107d24d>] rcu_read_lock+0x0/0x28 [ 1.203060] #1: (rcu_read_lock){.+.+.+}, at: [<4107d24d>] rcu_read_lock+0x0/0x28 [ 1.203347] #2: (rcu_read_lock){.+.+.+}, at: [<4107d24d>] rcu_read_lock+0x0/0x28 [ 1.203347] #3: (rcu_read_lock){.+.+.+}, at: [<4107d24d>] rcu_read_lock+0x0/0x28 [ 1.203347] #4: (rcu_read_lock){.+.+.+}, at: [<4107d24d>] rcu_read_lock+0x0/0x28 [ 1.203347] #5: (rcu_read_lock){.+.+.+}, at: [<4107d24d>] rcu_read_lock+0x0/0x28 [ 1.203347] #6: (rcu_read_lock){.+.+.+}, at: [<4107d24d>] rcu_read_lock+0x0/0x28 [ 1.203347] #7: (rcu_read_lock){.+.+.+}, at: [<4107d24d>] rcu_read_lock+0x0/0x28 [ 1.203347] #8: (rcu_read_lock){.+.+.+}, at: [<4107d24d>] rcu_read_lock+0x0/0x28 [ 1.203347] #9: (rcu_read_lock){.+.+.+}, at: [<4107d24d>] rcu_read_lock+0x0/0x28 [ 1.203347] #10: (rcu_read_lock){.+.+.+}, at: [<4107d24d>] rcu_read_lock+0x0/0x28 [ 1.203347] #11: (rcu_read_lock){.+.+.+}, at: [<4107d24d>] rcu_read_lock+0x0/0x28 [ 1.203347] #12: (rcu_read_lock){.+.+.+}, at: [<4107d24d>] rcu_read_lock+0x0/0x28 [ 1.203347] #13: (rcu_read_lock){.+.+.+}, at: [<4107d24d>] rcu_read_lock+0x0/0x28 [ 1.203347] #14: (rcu_read_lock){.+.+.+}, at: [<4107d24d>] rcu_read_lock+0x0/0x28 [ 1.203347] #15: (rcu_read_lock){.+.+.+}, at: [<4107d24d>] rcu_read_lock+0x0/0x28 [ 1.203347] #16: (rcu_read_lock){.+.+.+}, at: [<4107d24d>] rcu_read_lock+0x0/0x28 [ 1.203347] #17: (rcu_read_lock){.+.+.+}, at: [<4107d24d>] rcu_read_lock+0x0/0x28 [ 1.203347] #18: (rcu_read_lock){.+.+.+}, at: [<4107d24d>] rcu_read_lock+0x0/0x28 [ 1.203347] #19: (rcu_read_lock){.+.+.+}, at: [<4107d24d>] rcu_read_lock+0x0/0x28 [ 1.203347] #20: (rcu_read_lock){.+.+.+}, at: [<4107d24d>] rcu_read_lock+0x0/0x28 [ 1.203347] #21: (rcu_read_lock){.+.+.+}, at: [<4107d24d>] rcu_read_lock+0x0/0x28 [ 1.203347] #22: (rcu_read_lock){.+.+.+}, at: [<4107d24d>] rcu_read_lock+0x0/0x28 [ 1.203347] #23: (rcu_read_lock){.+.+.+}, at: [<4107d24d>] rcu_read_lock+0x0/0x28 [ 1.203347] #24: (rcu_read_lock){.+.+.+}, at: [<4107d24d>] rcu_read_lock+0x0/0x28 [ 1.203347] #25: (rcu_read_lock){.+.+.+}, at: [<4107d24d>] rcu_read_lock+0x0/0x28 [ 1.203347] #26: (rcu_read_lock){.+.+.+}, at: [<4107d24d>] rcu_read_lock+0x0/0x28 [ 1.203347] #27: (rcu_read_lock){.+.+.+}, at: [<4107d24d>] rcu_read_lock+0x0/0x28 [ 1.203347] #28: (rcu_read_lock){.+.+.+}, at: [<4107d24d>] rcu_read_lock+0x0/0x28 [ 1.203347] #29: (rcu_read_lock){.+.+.+}, at: [<4107d24d>] rcu_read_lock+0x0/0x28 [ 1.203347] #30: (rcu_read_lock){.+.+.+}, at: [<4107d24d>] rcu_read_lock+0x0/0x28 [ 1.203347] #31: (rcu_read_lock){.+.+.+}, at: [<4107d24d>] rcu_read_lock+0x0/0x28 [ 1.203347] #32: (rcu_read_lock){.+.+.+}, at: [<4107d24d>] rcu_read_lock+0x0/0x28 [ 1.203347] #33: (rcu_read_lock){.+.+.+}, at: [<4107d24d>] rcu_read_lock+0x0/0x28 [ 1.203347] #34: (rcu_read_lock){.+.+.+}, at: [<4107d24d>] rcu_read_lock+0x0/0x28 [ 1.203347] #35: (rcu_read_lock){.+.+.+}, at: [<4107d24d>] rcu_read_lock+0x0/0x28 [ 1.203347] #36: (rcu_read_lock){.+.+.+}, at: [<4107d24d>] rcu_read_lock+0x0/0x28 [ 1.203347] #37: (rcu_read_lock){.+.+.+}, at: [<4107d24d>] rcu_read_lock+0x0/0x28 [ 1.203347] #38: (rcu_read_lock){.+.+.+}, at: [<4107d24d>] rcu_read_lock+0x0/0x28 [ 1.203347] #39: (rcu_read_lock){.+.+.+}, at: [<4107d24d>] rcu_read_lock+0x0/0x28 [ 1.203347] #40: (rcu_read_lock){.+.+.+}, at: [<4107d24d>] rcu_read_lock+0x0/0x28 [ 1.203347] #41: (rcu_read_lock){.+.+.+}, at: [<4107d24d>] rcu_read_lock+0x0/0x28 [ 1.203347] #42: (rcu_read_lock){.+.+.+}, at: [<4107d24d>] rcu_read_lock+0x0/0x28 [ 1.203347] #43: (rcu_read_lock){.+.+.+}, at: [<4107d24d>] rcu_read_lock+0x0/0x28 [ 1.203347] #44: (rcu_read_lock){.+.+.+}, at: [<4107d24d>] rcu_read_lock+0x0/0x28 [ 1.203347] #45: (rcu_read_lock){.+.+.+}, at: [<4107d24d>] rcu_read_lock+0x0/0x28 [ 1.203347] #46: (&rq->lock){-.-.-.}, at: [<4158f328>] __schedule+0x7e/0x5ce [ 1.203347] #47: ((null)){.-.-..}, at: [<4158f3e3>] __schedule+0x139/0x5ce /kernel/i386-randconfig-an1-02182100/037d40fe91c5721054a8d1a61cd926dbdb75f968/dmesg-quantal-xian-4:20140219012805:i386-randconfig-an1-02182100:3.14.0-rc3-wl-ath-01896-g037d40f:137 /kernel/i386-randconfig-an1-02182100/037d40fe91c5721054a8d1a61cd926dbdb75f968/dmesg-quantal-xian-6:20140219012809:i386-randconfig-an1-02182100:3.14.0-rc3-wl-ath-01896-g037d40f:137 /kernel/i386-randconfig-an1-02182100/037d40fe91c5721054a8d1a61cd926dbdb75f968/dmesg-yocto-xgwo-7:20140219012814:i386-randconfig-an1-02182100:3.14.0-rc3-wl-ath-01896-g037d40f:137 /kernel/i386-randconfig-an1-02182100/037d40fe91c5721054a8d1a61cd926dbdb75f968/dmesg-yocto-xian-15:20140219012818:i386-randconfig-an1-02182100:3.14.0-rc3-wl-ath-01896-g037d40f:137 /kernel/i386-randconfig-an1-02182100/037d40fe91c5721054a8d1a61cd926dbdb75f968/dmesg-yocto-xian-58:20140219012813:i386-randconfig-an1-02182100:3.14.0-rc3-wl-ath-01896-g037d40f:137 0:5:1 all_good:bad:all_bad boots linear-bisect: bad branch may be alexshi/single-balance linear-bisect: handle over to git bisect linear-bisect: git bisect start 037d40fe91c5721054a8d1a61cd926dbdb75f968 6648c2574f90963cb0bc2421f00f173e9fdc8cc0 -- Previous HEAD position was 037d40f... Merge 'alexshi/single-balance' into devel-hourly-2014021821 HEAD is now at adc429b... Merge 'cgroup/review-kernfs-conversion' into devel-hourly-2014021518 Bisecting: 10 revisions left to test after this (roughly 3 steps) [4a5d7c9f371d437e80369739bc7c38743f0d87c3] sched: rename update_*_cpu_load linear-bisect: git bisect run /c/kernel-tests/bisect-test-boot-failure.sh /kernel-tests/linux/obj-bisect running /c/kernel-tests/bisect-test-boot-failure.sh /kernel-tests/linux/obj-bisect ls -a /kernel-tests/run-queue/kvm/i386-randconfig-an1-02182100/linux-devel:devel-hourly-2014021821:4a5d7c9f371d437e80369739bc7c38743f0d87c3:bisect-linux 2014-02-19 01:28:44: cmd_fail: '/bin/grep' '-r' '--include=dmesg-*' '-s' '-l' 'BUG: MAX_LOCK_DEPTH too' '/kernel/i386-randconfig-an1-02182100/4a5d7c9f371d437e80369739bc7c38743f0d87c3' , ret=2, ref: /kernel-tests/failed-cmd/bee-grep-kbuild.log 2014-02-19-01:28:44 4a5d7c9f371d437e80369739bc7c38743f0d87c3 compiling 75 real 1247 user 111 sys 1792.44% cpu i386-randconfig-an1-02182100 2014-02-19-01:30:30 detecting boot state 3.14.0-rc2-00010-g4a5d7c9. 1 8 23 SUCCESS Bisecting: 5 revisions left to test after this (roughly 3 steps) [480c3ba7685296b8da892020d408223e7abdc70b] sched: remove un-used functions running /c/kernel-tests/bisect-test-boot-failure.sh /kernel-tests/linux/obj-bisect ls -a /kernel-tests/run-queue/kvm/i386-randconfig-an1-02182100/linux-devel:devel-hourly-2014021821:480c3ba7685296b8da892020d408223e7abdc70b:bisect-linux 2014-02-19 01:32:30: cmd_fail: '/bin/grep' '-r' '--include=dmesg-*' '-s' '-l' 'BUG: MAX_LOCK_DEPTH too' '/kernel/i386-randconfig-an1-02182100/480c3ba7685296b8da892020d408223e7abdc70b' , ret=2, ref: /kernel-tests/failed-cmd/bee-grep-kbuild.log 2014-02-19-01:32:30 480c3ba7685296b8da892020d408223e7abdc70b compiling 16 real 35 user 5 sys 252.76% cpu i386-randconfig-an1-02182100 2014-02-19-01:32:57 detecting boot state 3.14.0-rc2-00015-g480c3ba. 4 12 20 23 SUCCESS Bisecting: 2 revisions left to test after this (roughly 2 steps) [0e32dab5df39cfb1be9a937d67c877404b964324] sched/balance: rebuild ovutil tree after task moving running /c/kernel-tests/bisect-test-boot-failure.sh /kernel-tests/linux/obj-bisect ls -a /kernel-tests/run-queue/kvm/i386-randconfig-an1-02182100/linux-devel:devel-hourly-2014021821:0e32dab5df39cfb1be9a937d67c877404b964324:bisect-linux 2014-02-19 01:35:28: cmd_fail: '/bin/grep' '-r' '--include=dmesg-*' '-s' '-l' 'BUG: MAX_LOCK_DEPTH too' '/kernel/i386-randconfig-an1-02182100/0e32dab5df39cfb1be9a937d67c877404b964324' , ret=2, ref: /kernel-tests/failed-cmd/bee-grep-kbuild.log 2014-02-19-01:35:28 0e32dab5df39cfb1be9a937d67c877404b964324 compiling 15 real 31 user 4 sys 229.28% cpu i386-randconfig-an1-02182100 2014-02-19-01:35:57 detecting boot state 3.14.0-rc2-00018-g0e32dab. 4 18 23 SUCCESS Bisecting: 0 revisions left to test after this (roughly 1 step) [98564060e5c360908d93f61a78ccbef4a082d3c2] sched/balance: add balance_interval to tuning top level balance frequency running /c/kernel-tests/bisect-test-boot-failure.sh /kernel-tests/linux/obj-bisect ls -a /kernel-tests/run-queue/kvm/i386-randconfig-an1-02182100/linux-devel:devel-hourly-2014021821:98564060e5c360908d93f61a78ccbef4a082d3c2:bisect-linux 2014-02-19 01:37:58: cmd_fail: '/bin/grep' '-r' '--include=dmesg-*' '-s' '-l' 'BUG: MAX_LOCK_DEPTH too' '/kernel/i386-randconfig-an1-02182100/98564060e5c360908d93f61a78ccbef4a082d3c2' , ret=2, ref: /kernel-tests/failed-cmd/bee-grep-kbuild.log 2014-02-19-01:37:58 98564060e5c360908d93f61a78ccbef4a082d3c2 compiling 14 real 38 user 5 sys 303.21% cpu i386-randconfig-an1-02182100 2014-02-19-01:38:24 detecting boot state 3.14.0-rc2-00020-g9856406. TEST FAILURE [ 1.193365] softirq: huh, entered softirq 7 SCHED 4107f914 with preempt_count 00000100, exited with 00000101? [ 1.196698] softirq: huh, entered softirq 7 SCHED 4107f914 with preempt_count 00000100, exited with 00000101? [ 1.200031] softirq: huh, entered softirq 7 SCHED 4107f914 with preempt_count 00000100, exited with 00000101? [ 1.200768] BUG: MAX_LOCK_DEPTH too low! [ 1.201066] turning off the locking correctness validator. [ 1.201475] Please attach the output of /proc/lock_stat to the bug report [ 1.201957] depth: 48 max: 48! [ 1.202189] 48 locks held by swapper/0/1: [ 1.202484] #0: (rcu_read_lock){.+.+.+}, at: [<4107d29d>] rcu_read_lock+0x0/0x28 [ 1.203091] #1: (rcu_read_lock){.+.+.+}, at: [<4107d29d>] rcu_read_lock+0x0/0x28 [ 1.203349] #2: (rcu_read_lock){.+.+.+}, at: [<4107d29d>] rcu_read_lock+0x0/0x28 [ 1.203349] #3: (rcu_read_lock){.+.+.+}, at: [<4107d29d>] rcu_read_lock+0x0/0x28 [ 1.203349] #4: (rcu_read_lock){.+.+.+}, at: [<4107d29d>] rcu_read_lock+0x0/0x28 [ 1.203349] #5: (rcu_read_lock){.+.+.+}, at: [<4107d29d>] rcu_read_lock+0x0/0x28 [ 1.203349] #6: (rcu_read_lock){.+.+.+}, at: [<4107d29d>] rcu_read_lock+0x0/0x28 [ 1.203349] #7: (rcu_read_lock){.+.+.+}, at: [<4107d29d>] rcu_read_lock+0x0/0x28 [ 1.203349] #8: (rcu_read_lock){.+.+.+}, at: [<4107d29d>] rcu_read_lock+0x0/0x28 [ 1.203349] #9: (rcu_read_lock){.+.+.+}, at: [<4107d29d>] rcu_read_lock+0x0/0x28 [ 1.203349] #10: (rcu_read_lock){.+.+.+}, at: [<4107d29d>] rcu_read_lock+0x0/0x28 [ 1.203349] #11: (rcu_read_lock){.+.+.+}, at: [<4107d29d>] rcu_read_lock+0x0/0x28 [ 1.203349] #12: (rcu_read_lock){.+.+.+}, at: [<4107d29d>] rcu_read_lock+0x0/0x28 [ 1.203349] #13: (rcu_read_lock){.+.+.+}, at: [<4107d29d>] rcu_read_lock+0x0/0x28 [ 1.203349] #14: (rcu_read_lock){.+.+.+}, at: [<4107d29d>] rcu_read_lock+0x0/0x28 [ 1.203349] #15: (rcu_read_lock){.+.+.+}, at: [<4107d29d>] rcu_read_lock+0x0/0x28 [ 1.203349] #16: (rcu_read_lock){.+.+.+}, at: [<4107d29d>] rcu_read_lock+0x0/0x28 [ 1.203349] #17: (rcu_read_lock){.+.+.+}, at: [<4107d29d>] rcu_read_lock+0x0/0x28 [ 1.203349] #18: (rcu_read_lock){.+.+.+}, at: [<4107d29d>] rcu_read_lock+0x0/0x28 [ 1.203349] #19: (rcu_read_lock){.+.+.+}, at: [<4107d29d>] rcu_read_lock+0x0/0x28 [ 1.203349] #20: (rcu_read_lock){.+.+.+}, at: [<4107d29d>] rcu_read_lock+0x0/0x28 [ 1.203349] #21: (rcu_read_lock){.+.+.+}, at: [<4107d29d>] rcu_read_lock+0x0/0x28 [ 1.203349] #22: (rcu_read_lock){.+.+.+}, at: [<4107d29d>] rcu_read_lock+0x0/0x28 [ 1.203349] #23: (rcu_read_lock){.+.+.+}, at: [<4107d29d>] rcu_read_lock+0x0/0x28 [ 1.203349] #24: (rcu_read_lock){.+.+.+}, at: [<4107d29d>] rcu_read_lock+0x0/0x28 [ 1.203349] #25: (rcu_read_lock){.+.+.+}, at: [<4107d29d>] rcu_read_lock+0x0/0x28 [ 1.203349] #26: (rcu_read_lock){.+.+.+}, at: [<4107d29d>] rcu_read_lock+0x0/0x28 [ 1.203349] #27: (rcu_read_lock){.+.+.+}, at: [<4107d29d>] rcu_read_lock+0x0/0x28 [ 1.203349] #28: (rcu_read_lock){.+.+.+}, at: [<4107d29d>] rcu_read_lock+0x0/0x28 [ 1.203349] #29: (rcu_read_lock){.+.+.+}, at: [<4107d29d>] rcu_read_lock+0x0/0x28 [ 1.203349] #30: (rcu_read_lock){.+.+.+}, at: [<4107d29d>] rcu_read_lock+0x0/0x28 [ 1.203349] #31: (rcu_read_lock){.+.+.+}, at: [<4107d29d>] rcu_read_lock+0x0/0x28 [ 1.203349] #32: (rcu_read_lock){.+.+.+}, at: [<4107d29d>] rcu_read_lock+0x0/0x28 [ 1.203349] #33: (rcu_read_lock){.+.+.+}, at: [<4107d29d>] rcu_read_lock+0x0/0x28 [ 1.203349] #34: (rcu_read_lock){.+.+.+}, at: [<4107d29d>] rcu_read_lock+0x0/0x28 [ 1.203349] #35: (rcu_read_lock){.+.+.+}, at: [<4107d29d>] rcu_read_lock+0x0/0x28 [ 1.203349] #36: (rcu_read_lock){.+.+.+}, at: [<4107d29d>] rcu_read_lock+0x0/0x28 [ 1.203349] #37: (rcu_read_lock){.+.+.+}, at: [<4107d29d>] rcu_read_lock+0x0/0x28 [ 1.203349] #38: (rcu_read_lock){.+.+.+}, at: [<4107d29d>] rcu_read_lock+0x0/0x28 [ 1.203349] #39: (rcu_read_lock){.+.+.+}, at: [<4107d29d>] rcu_read_lock+0x0/0x28 [ 1.203349] #40: (rcu_read_lock){.+.+.+}, at: [<4107d29d>] rcu_read_lock+0x0/0x28 [ 1.203349] #41: (rcu_read_lock){.+.+.+}, at: [<4107d29d>] rcu_read_lock+0x0/0x28 [ 1.203349] #42: (rcu_read_lock){.+.+.+}, at: [<4107d29d>] rcu_read_lock+0x0/0x28 [ 1.203349] #43: (rcu_read_lock){.+.+.+}, at: [<4107d29d>] rcu_read_lock+0x0/0x28 [ 1.203349] #44: (rcu_read_lock){.+.+.+}, at: [<4107d29d>] rcu_read_lock+0x0/0x28 [ 1.203349] #45: (rcu_read_lock){.+.+.+}, at: [<4107d29d>] rcu_read_lock+0x0/0x28 [ 1.203349] #46: (&rq->lock){-.-.-.}, at: [<4158b4b8>] __schedule+0x7e/0x5ce [ 1.203349] #47: ((null)){.-.-..}, at: [<4158b573>] __schedule+0x139/0x5ce /kernel/i386-randconfig-an1-02182100/98564060e5c360908d93f61a78ccbef4a082d3c2/dmesg-quantal-xian-1:20140219013837:i386-randconfig-an1-02182100:3.14.0-rc2-00020-g9856406:141 /kernel/i386-randconfig-an1-02182100/98564060e5c360908d93f61a78ccbef4a082d3c2/dmesg-yocto-athens-27:20140219013841:i386-randconfig-an1-02182100:3.14.0-rc2-00020-g9856406:141 /kernel/i386-randconfig-an1-02182100/98564060e5c360908d93f61a78ccbef4a082d3c2/dmesg-yocto-athens-2:20140219013842:i386-randconfig-an1-02182100:3.14.0-rc2-00020-g9856406:141 /kernel/i386-randconfig-an1-02182100/98564060e5c360908d93f61a78ccbef4a082d3c2/dmesg-yocto-athens-6:20140219013838:i386-randconfig-an1-02182100:3.14.0-rc2-00020-g9856406:141 /kernel/i386-randconfig-an1-02182100/98564060e5c360908d93f61a78ccbef4a082d3c2/dmesg-yocto-xian-33:20140219013837:i386-randconfig-an1-02182100:3.14.0-rc2-00020-g9856406:141 /kernel/i386-randconfig-an1-02182100/98564060e5c360908d93f61a78ccbef4a082d3c2/dmesg-yocto-xian-4:20140219013836:i386-randconfig-an1-02182100:3.14.0-rc2-00020-g9856406:141 0:6:6 all_good:bad:all_bad boots Bisecting: 0 revisions left to test after this (roughly 0 steps) [34c6c7844fd7ac6b7636614534d83c1099ab6fc7] sched/balance: add llc balance interval running /c/kernel-tests/bisect-test-boot-failure.sh /kernel-tests/linux/obj-bisect ls -a /kernel-tests/run-queue/kvm/i386-randconfig-an1-02182100/linux-devel:devel-hourly-2014021821:34c6c7844fd7ac6b7636614534d83c1099ab6fc7:bisect-linux 2014-02-19 01:38:55: cmd_fail: '/bin/grep' '-r' '--include=dmesg-*' '-s' '-l' 'BUG: MAX_LOCK_DEPTH too' '/kernel/i386-randconfig-an1-02182100/34c6c7844fd7ac6b7636614534d83c1099ab6fc7' , ret=2, ref: /kernel-tests/failed-cmd/bee-grep-kbuild.log 2014-02-19-01:38:55 34c6c7844fd7ac6b7636614534d83c1099ab6fc7 compiling 14 real 40 user 5 sys 306.77% cpu i386-randconfig-an1-02182100 2014-02-19-01:39:20 detecting boot state 3.14.0-rc2-00019-g34c6c78.. 2 3 13 23 SUCCESS 98564060e5c360908d93f61a78ccbef4a082d3c2 is the first bad commit commit 98564060e5c360908d93f61a78ccbef4a082d3c2 Author: Alex Shi Date: Tue Feb 18 21:01:54 2014 +0800 sched/balance: add balance_interval to tuning top level balance frequency Since central balance stains less cpu cache as current balance, we can set the balance interval more short. Signed-off-by: Alex Shi :040000 040000 1a5b5e08d930f1a88907b52e5c8403df0ea0bb21 1ac930e3f91d670e37d82a6b7e9d54e1f355f8d8 M include :040000 040000 bc7ea74ada5d7540e205c3feea69bdfd0c6155b6 9c27e6af630830a1a6973373abfb30a8929c5c8e M kernel bisect run success ls -a /kernel-tests/run-queue/kvm/i386-randconfig-an1-02182100/linux-devel:devel-hourly-2014021821:34c6c7844fd7ac6b7636614534d83c1099ab6fc7:bisect-linux 2014-02-19-01:42:21 34c6c7844fd7ac6b7636614534d83c1099ab6fc7 reuse /kernel/i386-randconfig-an1-02182100/34c6c7844fd7ac6b7636614534d83c1099ab6fc7/vmlinuz-3.14.0-rc2-00019-g34c6c78 2014-02-19-01:42:21 detecting boot state .. 11 46 57 69 SUCCESS ls -a /kernel-tests/run-queue/kvm/i386-randconfig-an1-02182100/linux-devel:devel-hourly-2014021821:d5471974ffc0bd5cbf7213231e4d6276007cab37:bisect-linux TEST FAILURE [ 1.078906] audit: initializing netlink subsys (disabled) [ 1.078952] audit: type=2000 audit(1392733659.374:1): initialized [ 1.080493] softirq: huh, entered softirq 7 SCHED 4107f776 with preempt_count 00000100, exited with 00000101? [ 1.081238] [ BUG: cryptomgr_test/29 still has locks held! ] [ 1.081672] VFS: Disk quotas dquot_6.5.2 [ 1.081674] 3.14.0-rc3-wl-ath-01897-gd547197 #4 Not tainted [ 1.081675] ------------------------------------- [ 1.081676] 1 lock held by cryptomgr_test/29: [ 1.081702] #0: (rcu_read_lock){.+.+.+}, at: [<4107d10c>] rcu_read_lock+0x0/0x28 [ 1.081702] [ 1.081702] stack backtrace: [ 1.081706] CPU: 1 PID: 29 Comm: cryptomgr_test Not tainted 3.14.0-rc3-wl-ath-01897-gd547197 #4 [ 1.081707] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 1.081709] 00000000 00000000 4c02dea8 415896ba 4c028090 4c02ded0 4108719a 4179a99e [ 1.081712] 417a9168 4179b52b 4c02832c 0000001d 4179abe1 417e872f 4c028090 4c02df14 [ 1.081714] 41060dfe 00000006 4c028458 4c02825c 4c028088 4c02825c 00000001 4003eca0 [ 1.081714] Call Trace: [ 1.081731] [<415896ba>] dump_stack+0x48/0x60 [ 1.081739] [<4108719a>] debug_check_no_locks_held+0x76/0x7e [ 1.081745] [<41060dfe>] do_exit+0x69d/0x6fd [ 1.081757] [<4112522b>] ? crypto_unregister_pcomp+0xd/0xd [ 1.081759] [<41125246>] cryptomgr_test+0x1b/0x1b [ 1.081763] [<410717fe>] kthread+0x8e/0x93 [ 1.081765] [<41085f19>] ? trace_hardirqs_on+0xb/0xd [ 1.081767] [<4108344a>] ? complete+0x12/0x35 [ 1.081771] [<415921f7>] ret_from_kernel_thread+0x1b/0x28 [ 1.081772] [<41071770>] ? __kthread_parkme+0x50/0x50 [ 1.083355] softirq: huh, entered softirq 7 SCHED 4107f776 with preempt_count 00000101, exited with 00000102? [ 1.090018] softirq: huh, entered softirq 7 SCHED 4107f776 with preempt_count 00000101, exited with 00000102? [ 1.092746] softirq: huh, entered softirq 7 SCHED 4107f776 with preempt_count 00000100, exited with 00000101? /kernel/i386-randconfig-an1-02182100/d5471974ffc0bd5cbf7213231e4d6276007cab37/dmesg-yocto-nhm4-4:20140219005714:i386-randconfig-an1-02182100:3.14.0-rc3-wl-ath-01897-gd547197:4 /kernel/i386-randconfig-an1-02182100/d5471974ffc0bd5cbf7213231e4d6276007cab37/dmesg-quantal-athens-39:20140218222753:i386-randconfig-an1-02182100:3.14.0-rc3-wl-ath-01897-gd547197:4 /kernel/i386-randconfig-an1-02182100/d5471974ffc0bd5cbf7213231e4d6276007cab37/dmesg-yocto-xps-4:20140219005710:i386-randconfig-an1-02182100:3.14.0-rc3-wl-ath-01897-gd547197:4 /kernel/i386-randconfig-an1-02182100/d5471974ffc0bd5cbf7213231e4d6276007cab37/dmesg-yocto-nhm4-1:20140219005710:i386-randconfig-an1-02182100:3.14.0-rc3-wl-ath-01897-gd547197:4 /kernel/i386-randconfig-an1-02182100/d5471974ffc0bd5cbf7213231e4d6276007cab37/dmesg-yocto-cairo-33:20140218222757:i386-randconfig-an1-02182100:3.14.0-rc3-wl-ath-01897-gd547197:4 /kernel/i386-randconfig-an1-02182100/d5471974ffc0bd5cbf7213231e4d6276007cab37/dmesg-yocto-athens-35:20140219005710:i386-randconfig-an1-02182100:3.14.0-rc3-wl-ath-01897-gd547197:4 /kernel/i386-randconfig-an1-02182100/d5471974ffc0bd5cbf7213231e4d6276007cab37/dmesg-yocto-xian-44:20140219005714:i386-randconfig-an1-02182100:3.14.0-rc3-wl-ath-01897-gd547197:4 /kernel/i386-randconfig-an1-02182100/d5471974ffc0bd5cbf7213231e4d6276007cab37/dmesg-yocto-xps-2:20140219005712:i386-randconfig-an1-02182100:3.14.0-rc3-wl-ath-01897-gd547197:4 /kernel/i386-randconfig-an1-02182100/d5471974ffc0bd5cbf7213231e4d6276007cab37/dmesg-yocto-athens-7:20140218222754:i386-randconfig-an1-02182100:3.14.0-rc3-wl-ath-01897-gd547197:4 /kernel/i386-randconfig-an1-02182100/d5471974ffc0bd5cbf7213231e4d6276007cab37/dmesg-yocto-xian-26:20140218222754:i386-randconfig-an1-02182100:3.14.0-rc3-wl-ath-01897-gd547197:4 /kernel/i386-randconfig-an1-02182100/d5471974ffc0bd5cbf7213231e4d6276007cab37/dmesg-yocto-xian-26:20140218222744:i386-randconfig-an1-02182100:3.14.0-rc3-wl-ath-01897-gd547197:4 0:11:19 all_good:bad:all_bad boots [detached HEAD 7a455ad] Revert "sched/balance: add balance_interval to tuning top level balance frequency" Committer: Wu Fengguang Your name and email address were configured automatically based on your username and hostname. Please check that they are accurate. You can suppress this message by setting them explicitly: git config --global user.name "Your Name" git config --global user.email you@example.com After doing this, you may fix the identity used for this commit with: git commit --amend --reset-author 3 files changed, 19 deletions(-) ls -a /kernel-tests/run-queue/kvm/i386-randconfig-an1-02182100/linux-devel:devel-hourly-2014021821:7a455ad6947d320cdf0234d07c4e4575b018cc11:bisect-linux 2014-02-19-01:45:24 7a455ad6947d320cdf0234d07c4e4575b018cc11 compiling 2014-02-19-01:46:51 detecting boot state 3.14.0-rc3-wl-ath-01898-g7a455ad.. 9 27 31 55 65 69 SUCCESS ========= upstream ========= Warning: you are leaving 1 commit behind, not connected to any of your branches: 7a455ad Revert "sched/balance: add balance_interval to tuning top level balance frequency" If you want to keep them by creating a new branch, this may be a good time to do so with: git branch new_branch_name 7a455ad HEAD is now at 60f76ea... Merge tag 'dma-buf-for-3.14' of git://git.kernel.org/pub/scm/linux/kernel/git/sumits/dma-buf ls -a /kernel-tests/run-queue/kvm/i386-randconfig-an1-02182100/linux-devel:devel-hourly-2014021821:60f76eab19e3903e810bdc3ec846c158efcd2e21:bisect-linux 2014-02-19-01:50:52 60f76eab19e3903e810bdc3ec846c158efcd2e21 compiling 2014-02-19-01:52:23 detecting boot state 3.14.0-rc3-00020-g60f76ea.. 7 17 35 61 69 SUCCESS ========= linux-next ========= Previous HEAD position was 60f76ea... Merge tag 'dma-buf-for-3.14' of git://git.kernel.org/pub/scm/linux/kernel/git/sumits/dma-buf HEAD is now at 02d56d4... Add linux-next specific files for 20140218 ls -a /kernel-tests/run-queue/kvm/i386-randconfig-an1-02182100/linux-devel:devel-hourly-2014021821:02d56d4d19b8aa889c856287729d89c805ee42ec:bisect-linux 2014-02-19-01:55:56 02d56d4d19b8aa889c856287729d89c805ee42ec reuse /kernel/i386-randconfig-an1-02182100/02d56d4d19b8aa889c856287729d89c805ee42ec/vmlinuz-3.14.0-rc3-next-20140218-03475-g02d56d4 2014-02-19-01:55:56 detecting boot state .. 12 20 48 65 69 SUCCESS