2021-06-23 05:21:47

by kernel test robot

[permalink] [raw]
Subject: [ethtool] 4d1fb7cde0: WARNING:at_net/ethtool/netlink.c:#ethnl_default_doit



Greeting,

FYI, we noticed the following commit (built with gcc-9):

commit: 4d1fb7cde0ccc6000cafb72d9079de1504e3cb2a ("ethtool: add a stricter length check")
https://git.kernel.org/cgit/linux/kernel/git/next/linux-next.git master


in testcase: packetdrill
version: packetdrill-x86_64-75fe342-1_20210508
with following parameters:

ucode: 0xde



on test machine: 4 threads 1 sockets Intel(R) Core(TM) i7-7567U CPU @ 3.50GHz with 32G memory

caused below changes (please refer to attached dmesg/kmsg for entire log/backtrace):



If you fix the issue, kindly add following tag
Reported-by: kernel test robot <[email protected]>


kern :warn : [ 27.338203] WARNING: CPU: 1 PID: 3472 at net/ethtool/netlink.c:360 ethnl_default_doit (kbuild/src/consumer/net/ethtool/netlink.c:360 (discriminator 3))
kern :warn : [ 27.338878] Modules linked in: tun netconsole btrfs blake2b_generic xor zstd_compress raid6_pq libcrc32c sd_mod t10_pi sg intel_rapl_msr intel_rapl_common x86_pkg_temp_thermal intel_powerclamp i915 coretemp intel_gtt kvm_intel drm_kms_helper syscopyarea sysfillrect sysimgblt fb_sys_fops kvm intel_wmi_thunderbolt irqbypass crct10dif_pclmul wmi_bmof crc32_pclmul crc32c_intel ahci drm libahci mei_me ghash_clmulni_intel rapl intel_cstate libata mei intel_uncore rtsx_pci ipmi_devintf ipmi_msghandler wmi intel_pch_thermal video intel_pmc_core acpi_pad ip_tables
kern :warn : [ 27.342493] CPU: 1 PID: 3472 Comm: ethtool Not tainted 5.13.0-rc3-01678-g4d1fb7cde0cc #1
kern :warn : [ 27.343095] Hardware name: Intel Corporation NUC7i7BNH/NUC7i7BNB, BIOS BNKBL357.86A.0067.2018.0814.1500 08/14/2018
kern :warn : [ 27.343860] RIP: 0010:ethnl_default_doit (kbuild/src/consumer/net/ethtool/netlink.c:360 (discriminator 3))
kern :warn : [ 27.344240] Code: 80 3d e0 da 29 01 00 0f 85 c1 fe ff ff 44 89 e2 44 89 f6 4c 89 04 24 48 c7 c7 70 7d 62 82 c6 05 c2 da 29 01 01 e8 d8 8a 18 00 <0f> 0b 4c 8b 04 24 e9 99 fe ff ff 41 bc f4 ff ff ff e9 67 ff ff ff
All code
========
0: 80 3d e0 da 29 01 00 cmpb $0x0,0x129dae0(%rip) # 0x129dae7
7: 0f 85 c1 fe ff ff jne 0xfffffffffffffece
d: 44 89 e2 mov %r12d,%edx
10: 44 89 f6 mov %r14d,%esi
13: 4c 89 04 24 mov %r8,(%rsp)
17: 48 c7 c7 70 7d 62 82 mov $0xffffffff82627d70,%rdi
1e: c6 05 c2 da 29 01 01 movb $0x1,0x129dac2(%rip) # 0x129dae7
25: e8 d8 8a 18 00 callq 0x188b02
2a:* 0f 0b ud2 <-- trapping instruction
2c: 4c 8b 04 24 mov (%rsp),%r8
30: e9 99 fe ff ff jmpq 0xfffffffffffffece
35: 41 bc f4 ff ff ff mov $0xfffffff4,%r12d
3b: e9 67 ff ff ff jmpq 0xffffffffffffffa7

Code starting with the faulting instruction
===========================================
0: 0f 0b ud2
2: 4c 8b 04 24 mov (%rsp),%r8
6: e9 99 fe ff ff jmpq 0xfffffffffffffea4
b: 41 bc f4 ff ff ff mov $0xfffffff4,%r12d
11: e9 67 ff ff ff jmpq 0xffffffffffffff7d
kern :warn : [ 27.345616] RSP: 0000:ffffc90002b3fb48 EFLAGS: 00010286
kern :warn : [ 27.346011] RAX: 0000000000000000 RBX: ffffffff822faf60 RCX: 0000000000000027
kern :warn : [ 27.346548] RDX: 0000000000000027 RSI: 00000000ffff7fff RDI: ffff88887ec97bf8
kern :warn : [ 27.347080] RBP: ffff888879b35e60 R08: ffff88887ec97bf0 R09: ffffc90002b3f968
kern :warn : [ 27.347618] R10: 0000000000000001 R11: 0000000000000001 R12: 00000000000008bc
kern :warn : [ 27.348153] R13: ffffc90002b3fbb0 R14: 0000000000000001 R15: ffff888879f47e00
kern :warn : [ 27.348689] FS: 00007fad89e55740(0000) GS:ffff88887ec80000(0000) knlGS:0000000000000000
kern :warn : [ 27.349300] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
kern :warn : [ 27.349733] CR2: 0000000000517868 CR3: 000000087a29e005 CR4: 00000000003706e0
kern :warn : [ 27.350272] Call Trace:
kern :warn : [ 27.350475] genl_family_rcv_msg_doit+0xef/0x180
kern :warn : [ 27.350876] genl_rcv_msg (kbuild/src/consumer/net/netlink/genetlink.c:783 kbuild/src/consumer/net/netlink/genetlink.c:800)
kern :warn : [ 27.351154] ? ethnl_reply_init (kbuild/src/consumer/net/ethtool/netlink.c:313)
kern :warn : [ 27.351481] ? ethnl_default_parse (kbuild/src/consumer/net/ethtool/netlink.c:486)
kern :warn : [ 27.351810] ? ethnl_fill_reply_header (kbuild/src/consumer/net/ethtool/netlink.c:313)
kern :warn : [ 27.352226] ? __ethtool_get_ts_info (kbuild/src/consumer/net/ethtool/netlink.c:541)
kern :warn : [ 27.352564] ? genl_family_rcv_msg_doit+0x180/0x180
kern :warn : [ 27.352978] netlink_rcv_skb (kbuild/src/consumer/net/netlink/af_netlink.c:2504)
kern :warn : [ 27.353279] genl_rcv (kbuild/src/consumer/net/netlink/genetlink.c:812)
kern :warn : [ 27.353527] netlink_unicast (kbuild/src/consumer/net/netlink/af_netlink.c:1315 kbuild/src/consumer/net/netlink/af_netlink.c:1340)
kern :warn : [ 27.353831] netlink_sendmsg (kbuild/src/consumer/net/netlink/af_netlink.c:1929)
kern :warn : [ 27.354135] sock_sendmsg (kbuild/src/consumer/net/socket.c:654 kbuild/src/consumer/net/socket.c:674)
kern :warn : [ 27.354411] __sys_sendto (kbuild/src/consumer/net/socket.c:1977)
kern :warn : [ 27.354690] ? __sys_recvmsg (kbuild/src/consumer/include/linux/file.h:32 kbuild/src/consumer/net/socket.c:2643)
kern :warn : [ 27.354979] ? exit_to_user_mode_prepare (kbuild/src/consumer/kernel/entry/common.c:207)
kern :warn : [ 27.355352] __x64_sys_sendto (kbuild/src/consumer/net/socket.c:1989 kbuild/src/consumer/net/socket.c:1985 kbuild/src/consumer/net/socket.c:1985)
kern :warn : [ 27.355646] do_syscall_64 (kbuild/src/consumer/arch/x86/entry/common.c:47)
kern :warn : [ 27.355926] entry_SYSCALL_64_after_hwframe (kbuild/src/consumer/arch/x86/entry/entry_64.S:112)
kern :warn : [ 27.356321] RIP: 0033:0x7fad89f529b7
kern :warn : [ 27.356601] Code: 64 89 02 48 c7 c0 ff ff ff ff eb b6 0f 1f 80 00 00 00 00 48 8d 05 49 5d 0c 00 41 89 ca 8b 00 85 c0 75 10 b8 2c 00 00 00 0f 05 <48> 3d 00 f0 ff ff 77 71 c3 41 57 4d 89 c7 41 56 41 89 ce 41 55 49
All code
========
0: 64 89 02 mov %eax,%fs:(%rdx)
3: 48 c7 c0 ff ff ff ff mov $0xffffffffffffffff,%rax
a: eb b6 jmp 0xffffffffffffffc2
c: 0f 1f 80 00 00 00 00 nopl 0x0(%rax)
13: 48 8d 05 49 5d 0c 00 lea 0xc5d49(%rip),%rax # 0xc5d63
1a: 41 89 ca mov %ecx,%r10d
1d: 8b 00 mov (%rax),%eax
1f: 85 c0 test %eax,%eax
21: 75 10 jne 0x33
23: b8 2c 00 00 00 mov $0x2c,%eax
28: 0f 05 syscall
2a:* 48 3d 00 f0 ff ff cmp $0xfffffffffffff000,%rax <-- trapping instruction
30: 77 71 ja 0xa3
32: c3 retq
33: 41 57 push %r15
35: 4d 89 c7 mov %r8,%r15
38: 41 56 push %r14
3a: 41 89 ce mov %ecx,%r14d
3d: 41 55 push %r13
3f: 49 rex.WB

Code starting with the faulting instruction
===========================================
0: 48 3d 00 f0 ff ff cmp $0xfffffffffffff000,%rax
6: 77 71 ja 0x79
8: c3 retq
9: 41 57 push %r15
b: 4d 89 c7 mov %r8,%r15
e: 41 56 push %r14
10: 41 89 ce mov %ecx,%r14d
13: 41 55 push %r13
15: 49 rex.WB
kern :warn : [ 27.358004] RSP: 002b:00007ffecb6e28e8 EFLAGS: 00000246 ORIG_RAX: 000000000000002c
kern :warn : [ 27.358584] RAX: ffffffffffffffda RBX: 000055db102fd2f0 RCX: 00007fad89f529b7
kern :warn : [ 27.359127] RDX: 0000000000000028 RSI: 000055db102fd360 RDI: 0000000000000008
kern :warn : [ 27.359669] RBP: 000055db102fd360 R08: 00007fad8a01cbe0 R09: 000000000000000c
kern :warn : [ 27.360211] R10: 0000000000000000 R11: 0000000000000246 R12: 000055db0ef89d70
kern :warn : [ 27.360752] R13: 000055db102fd300 R14: 00007ffecb6e29b0 R15: 000055db0ef96073
kern :warn : [ 27.361301] ---[ end trace 5751ea12d76fbf29 ]---
user :err : [ 28.549439] 18 Jun 21:13:00 ntpdate[401]: no server suitable for synchronization found

user :err : [ 33.170516] cwnd-moderation-ecn-enter-cwr-no-moderation-700.pkt:24: error in Python code

user :err : [ 33.171942] Traceback (most recent call last):

user :err : [ 33.173384] File "/tmp/code_x2li9Z", line 195, in <module>

user :err : [ 33.174817] assert tcpi_snd_cwnd == 4, tcpi_snd_cwnd

user :err : [ 33.175709] AssertionError: 5

user :notice: [ 36.022826] result_service: raw_upload, RESULT_MNT: /internal-lkp-server/result, RESULT_ROOT: /internal-lkp-server/result/packetdrill/ucode=0xde/lkp-kbl-nuc1/debian-10.4-x86_64-20200603.cgz/x86_64-rhel-8.3/gcc-9/4d1fb7cde0ccc6000cafb72d9079de1504e3cb2a/3, TMP_RESULT_ROOT: /tmp/lkp/result

user :notice: [ 36.027813] run-job /lkp/jobs/scheduled/lkp-kbl-nuc1/packetdrill-ucode=0xde-debian-10.4-x86_64-20200603.cgz-4d1fb7cde0ccc6000cafb72d9079de1504e3cb2a-20210619-26615-19d8agt-3.yaml

user :err : [ 36.210266] cwnd-moderation-ecn-enter-cwr-no-moderation-700.pkt: error executing code: '/usr/bin/python' returned non-zero status 1

user :notice: [ 37.041161] /usr/bin/wget -q --timeout=1800 --tries=1 --local-encoding=UTF-8 http://internal-lkp-server:80/~lkp/cgi-bin/lkp-jobfile-append-var?job_file=/lkp/jobs/scheduled/lkp-kbl-nuc1/packetdrill-ucode=0xde-debian-10.4-x86_64-20200603.cgz-4d1fb7cde0ccc6000cafb72d9079de1504e3cb2a-20210619-26615-19d8agt-3.yaml&job_state=running -O /dev/null

user :notice: [ 37.043739] target ucode: 0xde

user :notice: [ 37.044812] current_version: de, target_version: de

user :notice: [ 37.046550] Running packetdrill/tests/bsd/fast_retransmit/fr-4pkt-sack-bsd.pkt ...

user :notice: [ 37.049460] 2021-06-18 21:13:02 packetdrill/packetdrill --tolerance_usecs=40000 packetdrill/tests/bsd/fast_retransmit/fr-4pkt-sack-bsd.pkt

user :notice: [ 37.053086] packetdrill/tests/bsd/fast_retransmit/fr-4pkt-sack-bsd.pkt:25: error handling packet: live packet payload: expected 1000 bytes vs actual 2000 bytes

user :notice: [ 37.055352] packetdrill/tests/bsd/fast_retransmit/fr-4pkt-sack-bsd.pkt failed

user :notice: [ 37.057296] Running packetdrill/tests/linux/fast_retransmit/fr-4pkt-sack-linux.pkt ...

user :notice: [ 37.060307] 2021-06-18 21:13:02 packetdrill/packetdrill --tolerance_usecs=40000 packetdrill/tests/linux/fast_retransmit/fr-4pkt-sack-linux.pkt

user :notice: [ 37.062516] packetdrill/tests/linux/fast_retransmit/fr-4pkt-sack-linux.pkt pass

user :notice: [ 37.064264] Running packetdrill/tests/linux/packetdrill/socket_err.pkt ...

user :notice: [ 37.066963] 2021-06-18 21:13:02 packetdrill/packetdrill --tolerance_usecs=40000 packetdrill/tests/linux/packetdrill/socket_err.pkt

user :notice: [ 37.070773] packetdrill/tests/linux/packetdrill/socket_err.pkt:6: runtime error in socket call: Expected non-negative result but got -1 with errno 93 (Protocol not supported)

user :notice: [ 37.072986] packetdrill/tests/linux/packetdrill/socket_err.pkt failed

user :notice: [ 37.074760] Running packetdrill/tests/linux/packetdrill/socket_wrong_err.pkt ...

user :notice: [ 37.077598] 2021-06-18 21:13:03 packetdrill/packetdrill --tolerance_usecs=40000 packetdrill/tests/linux/packetdrill/socket_wrong_err.pkt

user :notice: [ 37.081422] packetdrill/tests/linux/packetdrill/socket_wrong_err.pkt:4: runtime error in socket call: Expected result -99 but got -1 with errno 93 (Protocol not supported)



To reproduce:

git clone https://github.com/intel/lkp-tests.git
cd lkp-tests
bin/lkp install job.yaml # job file is attached in this email
bin/lkp split-job --compatible job.yaml # generate the yaml file for lkp run
bin/lkp run generated-yaml-file



---
0DAY/LKP+ Test Infrastructure Open Source Technology Center
https://lists.01.org/hyperkitty/list/[email protected] Intel Corporation

Thanks,
Oliver Sang


Attachments:
(No filename) (12.11 kB)
config-5.13.0-rc3-01678-g4d1fb7cde0cc (177.06 kB)
job-script (5.23 kB)
kmsg.xz (24.85 kB)
packetdrill (26.72 kB)
job.yaml (4.39 kB)
reproduce (426.00 B)
Download all attachments