linux-kernel - [lkp] [net/netpolicy] ed519e0259: BUG: scheduling while atomic: migration/0/15/0x00000002

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>] [day] [month] [year] [list]
Message-ID: <20160807140647.GB21617@yexl-desktop>
Date:	Sun, 7 Aug 2016 22:06:47 +0800
From:	kernel test robot <xiaolong.ye@...el.com>
To:	Kan Liang <kan.liang@...el.com>
Cc:	0day robot <fengguang.wu@...el.com>,
	LKML <linux-kernel@...r.kernel.org>, lkp@...org
Subject: [lkp] [net/netpolicy]  ed519e0259: BUG: scheduling while atomic:
 migration/0/15/0x00000002


FYI, we noticed the following commit:

https://github.com/0day-ci/linux kan-liang-intel-com/net-introduce-NET-policy/20160805-034810
commit ed519e02592874e3cb2d643173e9f34bee2d74e7 ("net/netpolicy: fast path for finding the queues")

in testcase: boot

on test machine: 2 threads qemu-system-i386 -enable-kvm with 320M memory

caused below changes:


+------------------------------------------------+------------+------------+
|                                                | cf30f0dd66 | ed519e0259 |
+------------------------------------------------+------------+------------+
| boot_successes                                 | 0          | 0          |
| boot_failures                                  | 14         | 12         |
| INFO:trying_to_register_non-static_key         | 14         | 12         |
| backtrace:lock_acquire                         | 14         | 12         |
| backtrace:_raw_spin_lock                       | 14         | 12         |
| backtrace:init_netpolicy                       | 14         | 12         |
| backtrace:netpolicy_dev_init                   | 14         | 12         |
| backtrace:netpolicy_net_init                   | 14         | 12         |
| backtrace:ops_init                             | 14         | 12         |
| backtrace:register_pernet_operations           | 14         | 12         |
| backtrace:register_pernet_subsys               | 14         | 12         |
| backtrace:netpolicy_init                       | 14         | 12         |
| backtrace:kernel_init_freeable                 | 14         | 12         |
| IP-Config:Auto-configuration_of_network_failed | 2          | 2          |
| invoked_oom-killer:gfp_mask=0x                 | 0          | 1          |
| Mem-Info                                       | 0          | 1          |
| BUG:scheduling_while_atomic                    | 0          | 8          |
| INFO:lockdep_is_turned_off                     | 0          | 8          |
| kernel_BUG_at_kernel/cpu.c                     | 0          | 8          |
| invalid_opcode:#[##]PREEMPT_SMP                | 0          | 8          |
| EIP_is_at_cpuhp_report_idle_dead               | 0          | 8          |
| Kernel_panic-not_syncing:Fatal_exception       | 0          | 8          |
| backtrace:cpu_startup_entry                    | 0          | 8          |
+------------------------------------------------+------------+------------+

[   27.102864] BUG: scheduling while atomic: migration/0/15/0x00000002
[   27.103622] INFO: lockdep is turned off.
[   27.104080] Modules linked in:
[   27.104458] CPU: 0 PID: 15 Comm: migration/0 Not tainted 4.7.0-11573-ged519e0 #1
[   27.105316] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS Debian-1.8.2-1 04/01/2014
[   27.106337]  00000000 00200246 d2af1cbc c1273665 d2ae93c0 00000000 d2af1cc8 c105bd4e
[   27.107356]  d2af2000 d2af1d00 c15757b4 d2800ec0 00af1ce0 c1578d83 d2802180 d2af1d60
[   27.108376]  d31ce800 d35a6a94 d2800efc d2ae93c0 d2af2000 d2af1dd4 d2ae93c0 d2af1d0c
[   27.109394] Call Trace:
[   27.118595]  [<c1273665>] dump_stack+0x55/0x6e
[   27.119122]  [<c105bd4e>] __schedule_bug+0x63/0x74
[   27.119692]  [<c15757b4>] __schedule+0x53/0x587
[   27.120222]  [<c1578d83>] ? _raw_spin_unlock+0x22/0x35
[   27.120831]  [<c1575d5c>] schedule+0x74/0x88
[   27.121329]  [<c1578770>] schedule_timeout+0x1a/0x9b
[   27.138958]  [<c1070c56>] ? lock_release+0x161/0x369
[   27.139538]  [<c106fd94>] ? lock_acquired+0xe0/0x23d
[   27.140125]  [<c157647b>] ? __wait_for_common+0xbe/0xef
[   27.140835]  [<c1073425>] ? do_raw_spin_trylock+0x8/0x3a
[   27.141514]  [<c1073460>] ? do_raw_spin_unlock+0x9/0x72
[   27.142185]  [<c1578def>] ? _raw_spin_unlock_irq+0x27/0x3a
[   27.142885]  [<c1576482>] __wait_for_common+0xc5/0xef
[   27.147292]  [<c1578756>] ? usleep_range+0x52/0x52
[   27.147957]  [<c105e0d8>] ? wake_up_q+0x3b/0x3b
[   27.148572]  [<c15764c5>] wait_for_completion+0x19/0x1c
[   27.149275]  [<c1085088>] __wait_rcu_gp+0x9e/0xab
[   27.149930]  [<c108bd9a>] synchronize_rcu+0x3e/0x41
[   27.150607]  [<c108b0d0>] ? rcu_barrier+0x14/0x14
[   27.151286]  [<c10849f2>] ? __rcu_read_unlock+0x4c/0x4c
[   27.152073]  [<c148c6fd>] update_netpolicy_sys_map+0x17d/0x192
[   27.152867]  [<c1578d83>] ? _raw_spin_unlock+0x22/0x35
[   27.164665]  [<c148c72c>] netpolicy_cpu_callback+0x1a/0x21
[   27.165499]  [<c105730a>] notifier_call_chain+0x56/0x78
[   27.166314]  [<c1040c9d>] ? notify_online+0x18/0x18
[   27.167310]  [<c10575a0>] __raw_notifier_call_chain+0x13/0x15
[   27.168232]  [<c1040bf6>] __cpu_notify+0x2b/0x45
[   27.174501]  [<c1040c83>] cpu_notify+0x12/0x14
[   27.175082]  [<c1040cb1>] notify_dying+0x14/0x18
[   27.175677]  [<c10409ea>] cpuhp_invoke_callback+0x35/0x50
[   27.176359]  [<c1040c9d>] ? notify_online+0x18/0x18
[   27.177181]  [<c1041136>] take_cpu_down+0x4d/0x64
[   27.177789]  [<c10ab930>] multi_cpu_stop+0x74/0xa3
[   27.178396]  [<c10ab8bc>] ? cpu_stopper_thread+0xcc/0xcc
[   27.179072]  [<c10ab85b>] cpu_stopper_thread+0x6b/0xcc
[   27.179731]  [<c10593bf>] smpboot_thread_fn+0x186/0x1c6
[   27.180389]  [<c1059239>] ? sort_range+0x1d/0x1d
[   27.180983]  [<c1056826>] kthread+0x97/0x9c
[   27.181516]  [<c157648c>] ? __wait_for_common+0xcf/0xef
[   27.189205]  [<c15795e2>] ret_from_kernel_thread+0xe/0x24
[   27.190075]  [<c105678f>] ? kthread_stop+0x129/0x129



FYI, raw QEMU command line is:

	qemu-system-i386 -enable-kvm -kernel /pkg/linux/i386-randconfig-sb0-08051838/gcc-5/ed519e02592874e3cb2d643173e9f34bee2d74e7/vmlinuz-4.7.0-11573-ged519e0 -append 'ip=::::vm-kbuild-yocto-i386-21::dhcp root=/dev/ram0 user=lkp job=/lkp/scheduled/vm-kbuild-yocto-i386-21/boot-1-yocto-minimal-i386.cgz-ed519e02592874e3cb2d643173e9f34bee2d74e7-20160806-122326-o7mamq-0.yaml ARCH=i386 kconfig=i386-randconfig-sb0-08051838 branch=linux-devel/devel-spot-201608051704 commit=ed519e02592874e3cb2d643173e9f34bee2d74e7 BOOT_IMAGE=/pkg/linux/i386-randconfig-sb0-08051838/gcc-5/ed519e02592874e3cb2d643173e9f34bee2d74e7/vmlinuz-4.7.0-11573-ged519e0 max_uptime=600 RESULT_ROOT=/result/boot/1/vm-kbuild-yocto-i386/yocto-minimal-i386.cgz/i386-randconfig-sb0-08051838/gcc-5/ed519e02592874e3cb2d643173e9f34bee2d74e7/0 LKP_SERVER=inn debug apic=debug sysrq_always_enabled rcupdate.rcu_cpu_stall_timeout=100 panic=-1 softlockup_panic=1 nmi_watchdog=panic oops=panic load_ramdisk=2 prompt_ramdisk=0 systemd.log_level=err ignore_loglevel earlyprintk=ttyS0,115200 console=ttyS0,115200 console=tty0 vga=normal rw drbd.minor_count=8'  -initrd /fs/sdf1/initrd-vm-kbuild-yocto-i386-21 -m 320 -smp 2 -device e1000,netdev=net0 -netdev user,id=net0 -boot order=nc -no-reboot -watchdog i6300esb -watchdog-action debug -rtc base=localtime -drive file=/fs/sdf1/disk0-vm-kbuild-yocto-i386-21,media=disk,if=virtio -pidfile /dev/shm/kboot/pid-vm-kbuild-yocto-i386-21 -serial file:/dev/shm/kboot/serial-vm-kbuild-yocto-i386-21 -daemonize -display none -monitor null 





Thanks,
Xiaolong

View attachment "config-4.7.0-11573-ged519e0" of type "text/plain" (97484 bytes)

Download attachment "dmesg.xz" of type "application/octet-stream" (12452 bytes)