lists.openwall.net   lists  /  announce  owl-users  owl-dev  john-users  john-dev  passwdqc-users  yescrypt  popa3d-users  /  oss-security  kernel-hardening  musl  sabotage  tlsify  passwords  /  crypt-dev  xvendor  /  Bugtraq  Full-Disclosure  linux-kernel  linux-netdev  linux-ext4  linux-hardening  linux-cve-announce  PHC 
Open Source and information security mailing list archives
 
Hash Suite: Windows password security audit tool. GUI, reports in PDF.
[<prev] [next>] [thread-next>] [day] [month] [year] [list]
Message-ID: <87fuwk1c0o.fsf@yhuang-dev.intel.com>
Date:	Tue, 23 Feb 2016 08:55:03 +0800
From:	kernel test robot <ying.huang@...ux.intel.com>
TO:	Sergey Senozhatsky <sergey.senozhatsky@...il.com>
CC:	Stephen Rothwell <sfr@...b.auug.org.au>
Subject: [lkp] [printk] 34578dc67f: EIP is at vprintk_emit+0x1ea/0x600

FYI, we noticed the below changes on

https://git.kernel.org/pub/scm/linux/kernel/git/next/linux-next.git master
commit 34578dc67f38c02ccbe696e4099967884caa8e15 ("printk: set may_schedule for some of console_trylock() callers")


+------------------------------------------------+------------+------------+
|                                                | 08e0722e8e | 34578dc67f |
+------------------------------------------------+------------+------------+
| boot_successes                                 | 0          | 0          |
| boot_failures                                  | 98         | 100        |
| BUG:kernel_torture_test_oversize               | 98         | 50         |
| EIP_is_at_raw_spin_unlock_irqrestore           | 0          | 3          |
| Kernel_panic-not_syncing:softlockup:hung_tasks | 0          | 50         |
| backtrace:of_unittest                          | 0          | 50         |
| backtrace:kernel_init_freeable                 | 0          | 50         |
| EIP_is_at_vprintk_emit                         | 0          | 28         |
| EIP_is_at_lock_acquire                         | 0          | 5          |
| EIP_is_at_of_unittest_overlay                  | 0          | 8          |
| EIP_is_at_mutex_lock_nested                    | 0          | 1          |
| EIP_is_at__mutex_unlock_slowpath               | 0          | 2          |
| EIP_is_at_of_overlay_destroy                   | 0          | 1          |
| EIP_is_at_idr_find_slowpath                    | 0          | 1          |
| EIP_is_at___might_sleep                        | 0          | 1          |
+------------------------------------------------+------------+------------+



[   33.497678] ### dt-test ### of_unittest_destroy_tracked_overlays: overlay destroy failed for #6
[   33.497693] NMI watchdog: BUG: soft lockup - CPU#0 stuck for 23s! [swapper:1]
[   33.497693] NMI watchdog: BUG: soft lockup - CPU#0 stuck for 23s! [swapper:1]
[   33.497695] Modules linked in:
[   33.497695] Modules linked in:
[   33.497696] irq event stamp: 69018756
[   33.497696] irq event stamp: 69018756
[   33.497700] hardirqs last  enabled at (69018755): [<c068e185>] vprintk_emit+0x1e5/0x600
[   33.497700] hardirqs last  enabled at (69018755): [<c068e185>] vprintk_emit+0x1e5/0x600
[   33.497704] hardirqs last disabled at (69018756): [<c0a091b8>] apic_timer_interrupt+0x28/0x40
[   33.497704] hardirqs last disabled at (69018756): [<c0a091b8>] apic_timer_interrupt+0x28/0x40
[   33.497707] softirqs last  enabled at (68988726): [<c064cf32>] __do_softirq+0x312/0x3f0
[   33.497707] softirqs last  enabled at (68988726): [<c064cf32>] __do_softirq+0x312/0x3f0
[   33.497710] softirqs last disabled at (68988719): [<c0604c7e>] do_softirq_own_stack+0x1e/0x30
[   33.497710] softirqs last disabled at (68988719): [<c0604c7e>] do_softirq_own_stack+0x1e/0x30
[   33.497713] CPU: 0 PID: 1 Comm: swapper Not tainted 4.5.0-rc4-00295-g34578dc #1
[   33.497713] CPU: 0 PID: 1 Comm: swapper Not tainted 4.5.0-rc4-00295-g34578dc #1
[   33.497714] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS Debian-1.8.2-1 04/01/2014
[   33.497714] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS Debian-1.8.2-1 04/01/2014
[   33.497715] task: b0058000 ti: b0060000 task.ti: b0060000
[   33.497715] task: b0058000 ti: b0060000 task.ti: b0060000
[   33.497716] EIP: 0060:[<c068e18a>] EFLAGS: 00000246 CPU: 0
[   33.497716] EIP: 0060:[<c068e18a>] EFLAGS: 00000246 CPU: 0
[   33.497718] EIP is at vprintk_emit+0x1ea/0x600
[   33.497718] EIP is at vprintk_emit+0x1ea/0x600
[   33.497719] EAX: 00000246 EBX: 00000053 ECX: 00000000 EDX: 00000001
[   33.497719] EAX: 00000246 EBX: 00000053 ECX: 00000000 EDX: 00000001
[   33.497720] ESI: 00000006 EDI: 00000000 EBP: b0061e4c ESP: b0061e1c
[   33.497720] ESI: 00000006 EDI: 00000000 EBP: b0061e4c ESP: b0061e1c
[   33.497721]  DS: 007b ES: 007b FS: 0000 GS: 0000 SS: 0068
[   33.497721]  DS: 007b ES: 007b FS: 0000 GS: 0000 SS: 0068
[   33.497722] CR0: 8005003b CR2: 00000000 CR3: 10e3d000 CR4: 00000690
[   33.497722] CR0: 8005003b CR2: 00000000 CR3: 10e3d000 CR4: 00000690
[   33.497726] Stack:
[   33.497726] Stack:
[   33.497730]  00000000 00000000 00000000 00000000 c15d9462 00000053 c15d9462 00000000
[   33.497730]  00000000 00000000 00000000 00000000 c15d9462 00000053 c15d9462 00000000
[   33.497734]  00000246 00000006 00000001 00000000 b0061e6c c068e712 00000000 00000004
[   33.497734]  00000246 00000006 00000001 00000000 b0061e6c c068e712 00000000 00000004
[   33.497737]  00000000 00000000 c0bcf58c b0061e80 b0061e74 c06fdf6e b0061ea4 c0df5eec
[   33.497737]  00000000 00000000 c0bcf58c b0061e80 b0061e74 c06fdf6e b0061ea4 c0df5eec
[   33.497738] Call Trace:
[   33.497738] Call Trace:
[   33.497741]  [<c068e712>] vprintk_default+0x32/0x40
[   33.497741]  [<c068e712>] vprintk_default+0x32/0x40
[   33.497744]  [<c06fdf6e>] printk+0x11/0x13
[   33.497744]  [<c06fdf6e>] printk+0x11/0x13
[   33.497748]  [<c0df5eec>] of_unittest_overlay+0x8d1/0x900
[   33.497748]  [<c0df5eec>] of_unittest_overlay+0x8d1/0x900
[   33.497750]  [<c0df6b1f>] of_unittest+0xc04/0xc2d
[   33.497750]  [<c0df6b1f>] of_unittest+0xc04/0xc2d
[   33.497753]  [<c067f29b>] ? trace_hardirqs_on+0xb/0x10
[   33.497753]  [<c067f29b>] ? trace_hardirqs_on+0xb/0x10
[   33.497756]  [<c099fda9>] ? add_sysfs_fw_map_entry+0x3c/0x7d
[   33.497756]  [<c099fda9>] ? add_sysfs_fw_map_entry+0x3c/0x7d
[   33.497758]  [<c0600433>] ? do_one_initcall+0x73/0x1d0
[   33.497758]  [<c0600433>] ? do_one_initcall+0x73/0x1d0
[   33.497760]  [<c0df5f1b>] ? of_unittest_overlay+0x900/0x900
[   33.497760]  [<c0df5f1b>] ? of_unittest_overlay+0x900/0x900
[   33.497761]  [<c060043e>] do_one_initcall+0x7e/0x1d0
[   33.497761]  [<c060043e>] do_one_initcall+0x7e/0x1d0
[   33.497763]  [<c0df5f1b>] ? of_unittest_overlay+0x900/0x900
[   33.497763]  [<c0df5f1b>] ? of_unittest_overlay+0x900/0x900
[   33.497765]  [<c0664def>] ? parse_args+0x24f/0x440
[   33.497765]  [<c0664def>] ? parse_args+0x24f/0x440
[   33.497767]  [<c067f29b>] ? trace_hardirqs_on+0xb/0x10
[   33.497767]  [<c067f29b>] ? trace_hardirqs_on+0xb/0x10
[   33.497770]  [<c0dc4b30>] ? kernel_init_freeable+0xc3/0x15b
[   33.497770]  [<c0dc4b30>] ? kernel_init_freeable+0xc3/0x15b
[   33.497771]  [<c0dc4b4d>] kernel_init_freeable+0xe0/0x15b
[   33.497771]  [<c0dc4b4d>] kernel_init_freeable+0xe0/0x15b
[   33.497773]  [<c0a014bb>] kernel_init+0xb/0xe0
[   33.497773]  [<c0a014bb>] kernel_init+0xb/0xe0
[   33.497776]  [<c066e17c>] ? schedule_tail+0xc/0x50
[   33.497776]  [<c066e17c>] ? schedule_tail+0xc/0x50
[   33.497778]  [<c0a088a0>] ret_from_kernel_thread+0x20/0x40
[   33.497778]  [<c0a088a0>] ret_from_kernel_thread+0x20/0x40
[   33.497779]  [<c0a014b0>] ? rest_init+0x110/0x110
[   33.497779]  [<c0a014b0>] ? rest_init+0x110/0x110
[   33.497804] Code: 00 8d 40 ff 80 b8 60 94 5d c1 0a 0f 85 d0 fe ff ff 89 c3 be 02 00 00 00 e9 c6 fe ff ff 8d 74 26 00 e8 0b 11 ff ff 8b 45 f0 50 9d <8d> 74 26 00 80 7d ef 00 0f 85 7e ff ff ff e8 73 ce fe ff e8 fe
[   33.497804] Code: 00 8d 40 ff 80 b8 60 94 5d c1 0a 0f 85 d0 fe ff ff 89 c3 be 02 00 00 00 e9 c6 fe ff ff 8d 74 26 00 e8 0b 11 ff ff 8b 45 f0 50 9d <8d> 74 26 00 80 7d ef 00 0f 85 7e ff ff ff e8 73 ce fe ff e8 fe
[   33.497805] Kernel panic - not syncing: softlockup: hung tasks
[   33.497805] Kernel panic - not syncing: softlockup: hung tasks
[   33.497807] CPU: 0 PID: 1 Comm: swapper Tainted: G             L  4.5.0-rc4-00295-g34578dc #1
[   33.497807] CPU: 0 PID: 1 Comm: swapper Tainted: G             L  4.5.0-rc4-00295-g34578dc #1
[   33.497808] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS Debian-1.8.2-1 04/01/2014
[   33.497808] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS Debian-1.8.2-1 04/01/2014
[   33.497812]  b0058000 b0061cf8 c07c681d b0061d10 c06fdaf6 b0058000 00000017 b0058000
[   33.497812]  b0058000 b0061cf8 c07c681d b0061d10 c06fdaf6 b0058000 00000017 b0058000
[   33.497815]  00000000 b0061d40 c06c11cd c0b7dd9b 00000000 00000017 b0058298 00000001
[   33.497815]  00000000 b0061d40 c06c11cd c0b7dd9b 00000000 00000017 b0058298 00000001
[   33.497819]  b0061de0 00000008 c0d799a0 c0d760c0 7fffffff b0061d7c c069b960 00000000
[   33.497819]  b0061de0 00000008 c0d799a0 c0d760c0 7fffffff b0061d7c c069b960 00000000
[   33.497819] Call Trace:
[   33.497819] Call Trace:
[   33.497821]  [<c07c681d>] dump_stack+0x16/0x19
[   33.497821]  [<c07c681d>] dump_stack+0x16/0x19
[   33.497823]  [<c06fdaf6>] panic+0x85/0x190
[   33.497823]  [<c06fdaf6>] panic+0x85/0x190
[   33.497825]  [<c06c11cd>] watchdog_timer_fn+0x1ad/0x1b0
[   33.497825]  [<c06c11cd>] watchdog_timer_fn+0x1ad/0x1b0
[   33.497828]  [<c069b960>] hrtimer_run_queues+0x140/0x4a0
[   33.497828]  [<c069b960>] hrtimer_run_queues+0x140/0x4a0
[   33.497829]  [<c06c1020>] ? watchdog+0x40/0x40
[   33.497829]  [<c06c1020>] ? watchdog+0x40/0x40
[   33.497831]  [<c069aa9b>] update_process_times+0x1b/0x50
[   33.497831]  [<c069aa9b>] update_process_times+0x1b/0x50
[   33.497834]  [<c06ab364>] tick_periodic+0x34/0xd0
[   33.497834]  [<c06ab364>] tick_periodic+0x34/0xd0
[   33.497836]  [<c06ab454>] ? tick_handle_periodic+0x14/0x60
[   33.497836]  [<c06ab454>] ? tick_handle_periodic+0x14/0x60
[   33.497837]  [<c06ab454>] tick_handle_periodic+0x14/0x60
[   33.497837]  [<c06ab454>] tick_handle_periodic+0x14/0x60
[   33.497841]  [<c0630b20>] local_apic_timer_interrupt+0x20/0x50
[   33.497841]  [<c0630b20>] local_apic_timer_interrupt+0x20/0x50
[   33.497843]  [<c06312cc>] smp_apic_timer_interrupt+0x2c/0x40
[   33.497843]  [<c06312cc>] smp_apic_timer_interrupt+0x2c/0x40
[   33.497844]  [<c0a091bf>] apic_timer_interrupt+0x2f/0x40
[   33.497844]  [<c0a091bf>] apic_timer_interrupt+0x2f/0x40
[   33.497846]  [<c068e18a>] ? vprintk_emit+0x1ea/0x600
[   33.497846]  [<c068e18a>] ? vprintk_emit+0x1ea/0x600
[   33.497848]  [<c068e712>] vprintk_default+0x32/0x40
[   33.497848]  [<c068e712>] vprintk_default+0x32/0x40
[   33.497850]  [<c06fdf6e>] printk+0x11/0x13
[   33.497850]  [<c06fdf6e>] printk+0x11/0x13
[   33.497852]  [<c0df5eec>] of_unittest_overlay+0x8d1/0x900
[   33.497852]  [<c0df5eec>] of_unittest_overlay+0x8d1/0x900
[   33.497854]  [<c0df6b1f>] of_unittest+0xc04/0xc2d
[   33.497854]  [<c0df6b1f>] of_unittest+0xc04/0xc2d
[   33.497855]  [<c067f29b>] ? trace_hardirqs_on+0xb/0x10
[   33.497855]  [<c067f29b>] ? trace_hardirqs_on+0xb/0x10
[   33.497857]  [<c099fda9>] ? add_sysfs_fw_map_entry+0x3c/0x7d
[   33.497857]  [<c099fda9>] ? add_sysfs_fw_map_entry+0x3c/0x7d
[   33.497859]  [<c0600433>] ? do_one_initcall+0x73/0x1d0
[   33.497859]  [<c0600433>] ? do_one_initcall+0x73/0x1d0
[   33.497861]  [<c0df5f1b>] ? of_unittest_overlay+0x900/0x900
[   33.497861]  [<c0df5f1b>] ? of_unittest_overlay+0x900/0x900
[   33.497862]  [<c060043e>] do_one_initcall+0x7e/0x1d0
[   33.497862]  [<c060043e>] do_one_initcall+0x7e/0x1d0
[   33.497864]  [<c0df5f1b>] ? of_unittest_overlay+0x900/0x900
[   33.497864]  [<c0df5f1b>] ? of_unittest_overlay+0x900/0x900
[   33.497866]  [<c0664def>] ? parse_args+0x24f/0x440
[   33.497866]  [<c0664def>] ? parse_args+0x24f/0x440
[   33.497867]  [<c067f29b>] ? trace_hardirqs_on+0xb/0x10
[   33.497867]  [<c067f29b>] ? trace_hardirqs_on+0xb/0x10
[   33.497869]  [<c0dc4b30>] ? kernel_init_freeable+0xc3/0x15b
[   33.497869]  [<c0dc4b30>] ? kernel_init_freeable+0xc3/0x15b
[   33.497871]  [<c0dc4b4d>] kernel_init_freeable+0xe0/0x15b
[   33.497871]  [<c0dc4b4d>] kernel_init_freeable+0xe0/0x15b
[   33.497872]  [<c0a014bb>] kernel_init+0xb/0xe0
[   33.497872]  [<c0a014bb>] kernel_init+0xb/0xe0
[   33.497874]  [<c066e17c>] ? schedule_tail+0xc/0x50
[   33.497874]  [<c066e17c>] ? schedule_tail+0xc/0x50
[   33.497876]  [<c0a088a0>] ret_from_kernel_thread+0x20/0x40
[   33.497876]  [<c0a088a0>] ret_from_kernel_thread+0x20/0x40
[   33.497877]  [<c0a014b0>] ? rest_init+0x110/0x110
[   33.497877]  [<c0a014b0>] ? rest_init+0x110/0x110
[   33.497881] Kernel Offset: 0xf600000 from 0xb1000000 (relocation range: 0xb0000000-0xc47dffff)
[   33.497881] Kernel Offset: 0xf600000 from 0xb1000000 (relocation range: 0xb0000000-0xc47dffff)






Thanks,
Ying Huang

View attachment "config-4.5.0-rc4-00295-g34578dc" of type "text/plain" (71693 bytes)

Download attachment "dmesg.xz" of type "application/x-xz" (12836 bytes)

Powered by blists - more mailing lists

Powered by Openwall GNU/*/Linux Powered by OpenVZ