FreeBSD-main-amd64-test - Build #22950 - Failure

From: <jenkins-admin_at_FreeBSD.org>
Date: Thu, 09 Feb 2023 17:17:20 UTC
FreeBSD-main-amd64-test - Build #22950 (5a5436eb5d960b9e243f8196147c6a51ca4f9dee) - Failure

Build information: https://ci.FreeBSD.org/job/FreeBSD-main-amd64-test/22950/
Full change log: https://ci.FreeBSD.org/job/FreeBSD-main-amd64-test/22950/changes
Full build log: https://ci.FreeBSD.org/job/FreeBSD-main-amd64-test/22950/console

Status explanation:
"Failure" - the build is suspected being broken by the following changes
"Still Failing" - the build has not been fixed by the following changes and
                  this is a notification to note that these changes have
                  not been fully tested by the CI system

Change summaries:
(Those commits are likely but not certainly responsible)

5a5436eb5d960b9e243f8196147c6a51ca4f9dee by melifaro:
netlink: do not require elevated privileges when reading arp/ndp state.



The end of the build log:

[...truncated 4.25 MB...]
lib/libc/stdio/printf_test:snprintf_posarg_error  ->  passed  [0.004s]
lib/libc/stdio/printf_test:snprintf_posarg_width  ->  passed  [0.004s]
lib/libc/stdio/printf_test:sprintf_zeropad  ->  passed  [0.004s]
lib/libc/stdio/printfloat_test:alternate_form  ->  passed  [0.004s]
lib/libc/stdio/printfloat_test:decimal_rounding  ->  passed  [0.004s]
lib/libc/stdio/printfloat_test:float_within_limits  ->  passed  [0.004s]
lib/libc/stdio/printfloat_test:hexadecimal_floating_point  ->  passed  [0.004s]
lib/libc/stdio/printfloat_test:hexadecimal_rounding  ->  passed  [0.004s]
lib/libc/stdio/printfloat_test:infinities_and_nans  ->  passed  [0.004s]
lib/libc/stdio/printfloat_test:padding  ->  passed  [0.005s]
lib/libc/stdio/printfloat_test:padding_and_decimal_point_placement  ->  passed  [0.004s]
lib/libc/stdio/printfloat_test:precision_specifiers  ->  passed  [0.004s]
lib/libc/stdio/printfloat_test:signed_conversions  ->  passed  [0.004s]
lib/libc/stdio/printfloat_test:subnormal_double  ->  passed  [0.004s]
lib/libc/stdio/printfloat_test:subnormal_float  ->  passed  [0.004s]
lib/libc/stdio/printfloat_test:thousands_separator_and_other_locale_tests  ->  passed  [0.005s]
lib/libc/stdio/scanf_test:sscanf_neghex  ->  passed  [0.004s]
lib/libc/stdio/scanf_test:sscanf_whitespace  ->  expected_failure: fails on FreeBSD and some variants of Linux: /usr/src/contrib/netbsd-tests/lib/libc/stdio/t_scanf.c:74: c == 'z' not met  [0.004s]
lib/libc/stdio/scanfloat_test:infinities_and_nans  ->  passed  [0.004s]
lib/libc/stdio/scanfloat_test:normalized_numbers  ->  passed  [0.004s]
lib/libc/stdio/scanfloat_test:rounding_tests  ->  passed  [0.004s]
lib/libc/stdio/scanfloat_test:strtod  ->  passed  [0.005s]
lib/libc/stdlib/abs_test:abs_basic  ->  passed  [0.004s]
lib/libc/stdlib/abs_test:imaxabs_basic  ->  passed  [0.005s]
lib/libc/stdlib/abs_test:labs_basic  ->  passed  [0.005s]
lib/libc/stdlib/abs_test:llabs_basic  ->  passed  [0.004s]
lib/libc/stdlib/atoi_test:atof_strtod  ->  passed  [0.004s]
lib/libc/stdlib/atoi_test:atoi_strtol  ->  passed  [0.004s]
lib/libc/stdlib/atoi_test:atol_strtol  ->  passed  [0.004s]
lib/libc/stdlib/atoi_test:atoll_strtoll  ->  passed  [0.004s]
lib/libc/stdlib/clearenv_test:clearenv__double_clear_vars  ->  passed  [0.004s]
lib/libc/stdlib/clearenv_test:clearenv__environ_null  ->  passed  [0.006s]
lib/libc/stdlib/clearenv_test:clearenv__multiple_vars_test  ->  passed  [0.005s]
lib/libc/stdlib/clearenv_test:clearenv__putenv_vars  ->  passed  [0.005s]
lib/libc/stdlib/clearenv_test:clearenv__recreated_system_var_test  ->  passed  [0.004s]
lib/libc/stdlib/clearenv_test:clearenv__recreated_vars_test  ->  passed  [0.004s]
lib/libc/stdlib/clearenv_test:clearenv__single_var_test  ->  passed  [0.004s]
lib/libc/stdlib/clearenv_test:clearenv__system_var_test  ->  passed  [0.004s]
lib/libc/stdlib/cxa_thread_atexit_nothr_test:cxx__nothr  ->  passed  [0.006s]
lib/libc/stdlib/cxa_thread_atexit_nothr_test:cxx__thread_inf_dtors  ->  passed  [0.005s]
lib/libc/stdlib/cxa_thread_atexit_nothr_test:cxx__thread_local_main  ->  passed  [0.005s]
lib/libc/stdlib/cxa_thread_atexit_test:cxx__thr  ->  passed  [0.005s]
lib/libc/stdlib/cxa_thread_atexit_test:cxx__thread_inf_dtors  ->  passed  [0.006s]
lib/libc/stdlib/cxa_thread_atexit_test:cxx__thread_local_add_while_calling_dtors  ->  passed  [1.011s]
lib/libc/stdlib/cxa_thread_atexit_test:cxx__thread_local_after  ->  passed  [1.029s]
lib/libc/stdlib/cxa_thread_atexit_test:cxx__thread_local_before  ->  passed  [0.007s]
lib/libc/stdlib/div_test:div_basic  ->  passed  [0.004s]
lib/libc/stdlib/div_test:ldiv_basic  ->  passed  [0.004s]
lib/libc/stdlib/div_test:lldiv_basic  ->  passed  [0.004s]
lib/libc/stdlib/dynthr_test:maintc  ->  passed  [0.005s]
lib/libc/stdlib/exit_test:exit_atexit  ->  passed  [0.005s]
lib/libc/stdlib/exit_test:exit_basic  ->  passed  [0.006s]
lib/libc/stdlib/exit_test:exit_status  ->  passed  [0.009s]
lib/libc/stdlib/exit_test:exit_tmpfile  ->  passed  [0.005s]
lib/libc/stdlib/getenv_test:clearenv_basic  ->  passed  [0.009s]
lib/libc/stdlib/getenv_test:getenv_basic  ->  passed  [0.004s]
lib/libc/stdlib/getenv_test:putenv_basic  ->  passed  [0.004s]
lib/libc/stdlib/getenv_test:setenv_basic  ->  pid 1972 (getenv_test), jid 0, uid 0: exited on signal 11 (core dumped)
expected_failure: FreeBSD does not validate the second argument to setenv(3); see bin/189805  [0.910s]
lib/libc/stdlib/getenv_test:setenv_mixed  ->  passed  [0.006s]
lib/libc/stdlib/getopt_test:getopt  ->  passed  [0.089s]
lib/libc/stdlib/getopt_test:getopt_long  ->  passed  [0.074s]
lib/libc/stdlib/heapsort_test:heapsort_test  ->  passed  [0.366s]
lib/libc/stdlib/hsearch_test:hsearch_basic  ->  passed  [0.005s]
lib/libc/stdlib/hsearch_test:hsearch_duplicate  ->  passed  [0.004s]
lib/libc/stdlib/hsearch_test:hsearch_nonexistent  ->  passed  [0.004s]
lib/libc/stdlib/hsearch_test:hsearch_r_basic  ->  passed  [0.004s]
lib/libc/stdlib/hsearch_test:hsearch_r_duplicate  ->  passed  [0.004s]
lib/libc/stdlib/hsearch_test:hsearch_r_nonexistent  ->  expected_failure: behavior doesn't match docs; see bug # 216872: /usr/src/contrib/netbsd-tests/lib/libc/stdlib/t_hsearch.c:345: hsearch_r(e, FIND, &ep, &t) == 1 not met  [0.004s]
lib/libc/stdlib/hsearch_test:hsearch_r_two  ->  passed  [0.004s]
lib/libc/stdlib/hsearch_test:hsearch_two  ->  passed  [0.004s]
lib/libc/stdlib/mergesort_test:mergesort_test  ->  passed  [0.369s]
lib/libc/stdlib/posix_memalign_test:aligned_alloc_basic  ->  passed  [0.005s]
lib/libc/stdlib/posix_memalign_test:posix_memalign_basic  ->  passed  [0.005s]
lib/libc/stdlib/qsort_b_test:qsort_b_test  ->  passed  [0.397s]
lib/libc/stdlib/qsort_r_compat_test:qsort_r_compat_test  ->  passed  [0.370s]
lib/libc/stdlib/qsort_r_test:qsort_r_test  ->  passed  [0.405s]
lib/libc/stdlib/qsort_s_test:qsort_s_h  ->  passed  [0.006s]
lib/libc/stdlib/qsort_s_test:qsort_s_nmemb_gt_rmax  ->  passed  [0.006s]
lib/libc/stdlib/qsort_s_test:qsort_s_nmemb_gt_rmax_h  ->  passed  [0.005s]
lib/libc/stdlib/qsort_s_test:qsort_s_nmemb_lt_zero  ->  passed  [0.006s]
lib/libc/stdlib/qsort_s_test:qsort_s_nmemb_lt_zero_h  ->  passed  [0.005s]
lib/libc/stdlib/qsort_s_test:qsort_s_null_compar  ->  passed  [0.005s]
lib/libc/stdlib/qsort_s_test:qsort_s_null_compar_h  ->  passed  [0.004s]
lib/libc/stdlib/qsort_s_test:qsort_s_size_gt_rmax  ->  passed  [0.004s]
lib/libc/stdlib/qsort_s_test:qsort_s_size_gt_rmax_h  ->  passed  [0.004s]
lib/libc/stdlib/qsort_s_test:qsort_s_size_lt_zero  ->  passed  [0.005s]
lib/libc/stdlib/qsort_s_test:qsort_s_size_lt_zero_h  ->  passed  [0.004s]
lib/libc/stdlib/qsort_s_test:qsort_s_test  ->  passed  [0.383s]
lib/libc/stdlib/qsort_test:qsort_test  ->  passed  [0.283s]
lib/libc/stdlib/random_test:random_same  ->  passed  [0.004s]
lib/libc/stdlib/set_constraint_handler_s_test:abort_handler  ->  passed  [0.004s]
lib/libc/stdlib/set_constraint_handler_s_test:ignore_handler  ->  passed  [0.004s]
lib/libc/stdlib/set_constraint_handler_s_test:null_handler  ->  passed  [0.004s]
lib/libc/stdlib/strfmon_test:strfmon_cs_precedes_0  ->  passed  [0.004s]
lib/libc/stdlib/strfmon_test:strfmon_cs_precedes_1  ->  passed  [0.004s]
lib/libc/stdlib/strfmon_test:strfmon_examples  ->  passed  [0.004s]
lib/libc/stdlib/strfmon_test:strfmon_international_currency_code  ->  passed  [0.005s]
lib/libc/stdlib/strfmon_test:strfmon_l  ->  passed  [0.005s]
lib/libc/stdlib/strfmon_test:strfmon_locale_thousands  ->  passed  [0.005s]
lib/libc/stdlib/strtod_test:strtod_basic  ->  passed  [0.005s]
lib/libc/stdlib/strtod_test:strtod_gherman_bug  ->  passed  [0.006s]
lib/libc/stdlib/strtod_test:strtod_hex  ->  passed  [0.005s]
lib/libc/stdlib/strtod_test:strtod_inf  ->  *** /usr/src/contrib/kyua/utils/process/executor.cpp:779: Invariant check failed: PID 2140 already in all_exec_handles; not properly cleaned up or reused too fast
*** Fatal signal 6 received
*** Log file is /.kyua/logs/kyua.20230209-161432.log
*** Please report this problem to kyua-discuss@googlegroups.com detailing what you were doing before the crash happened; if possible, include the log file mentioned above
pid 781 (kyua), jid 0, uid 0: exited on signal 6 (core dumped)
Abort trap (core dumped)
+ rc=134
+ set -e
+ [ 134 -ne 0 ]
+ [ 134 -ne 1 ]
+ exit 134
+ tar cvf /dev/vtbd1 -C /meta .
a .
a ./disable-zfs-tests.sh
a ./disable-dtrace-tests.sh
a ./run.sh
a ./run-kyua.sh
a ./disable-notyet-tests.sh
a ./auto-shutdown
+ [ -f /meta/auto-shutdown ]
+ uname -p
+ shutdown -p now
Shutdown NOW!
shutdown: [pid 2144]
+ startmsg .
+ check_startmsgs
+ [ -n yes ]
+ checkyesno rc_startmsgs
+ eval '_value=$rc_startmsgs'
+ _value=YES
+ debug 'checkyesno: rc_startmsgs is set to YES.'
+ return 0
+ echo .
.
+ _return=0
+ umask 0022
+ [ 0 -ne 0 ]
+ return 0
+ _run_rc_postcmd
+ [ -n '' ]
+ return 0
+ return 0
2023-02-09T17:17:12.621102+00:00 - shutdown 2144 - - power-down by root: 

System shutdown time has arrived
Waiting (max 60 seconds) for system process `vnlru' to stop... done
Waiting (max 60 seconds) for system process `syncer' to stop... 
Syncing disks, vnodes remaining... 1 0 0 done
All buffers synced.
lock order reversal:
 1st 0xfffff8001b16c930 ufs (ufs, lockmgr) @ /usr/src/sys/kern/vfs_mount.c:2158
 2nd 0xfffff8001bbb03f0 tarfsz (tarfsz, lockmgr) @ /usr/src/sys/fs/tarfs/tarfs_io.c:700
lock order tarfsz -> ufs established at:
#0 0xffffffff80c5a25b at witness_checkorder+0x2fb
#1 0xffffffff80bb665c at lockmgr_lock_flags+0x7c
#2 0xffffffff80f4b74c at ffs_lock+0x6c
#3 0xffffffff80cf4224 at _vn_lock+0x54
#4 0xffffffff828859be at tarfs_zread+0x1fe
#5 0xffffffff811aa184 at VOP_READ_APV+0x34
#6 0xffffffff82885092 at tarfs_io_read+0x92
#7 0xffffffff828851d2 at tarfs_io_read_buf+0x52
#8 0xffffffff82888756 at tarfs_alloc_mount+0x2e6
#9 0xffffffff82887fd2 at tarfs_mount+0x3d2
#10 0xffffffff80cd454b at vfs_domount_first+0x24b
#11 0xffffffff80cd0b11 at vfs_domount+0x2f1
#12 0xffffffff80ccf42f at vfs_donmount+0x7ef
#13 0xffffffff80ccec09 at sys_nmount+0x69
#14 0xffffffff810daa92 at amd64_syscall+0x6e2
#15 0xffffffff810ad0fb at fast_syscall_common+0xf8
lock order ufs -> tarfsz attempted at:
#0 0xffffffff80c5ab13 at witness_checkorder+0xbb3
#1 0xffffffff80bb6760 at lockmgr_lock_flags+0x180
#2 0xffffffff80cf4224 at _vn_lock+0x54
#3 0xffffffff828854cb at tarfs_io_fini+0x3b
#4 0xffffffff82889fc7 at tarfs_free_mount+0x87
#5 0xffffffff828880b5 at tarfs_unmount+0x65
#6 0xffffffff80cd1aef at dounmount+0x7bf
#7 0xffffffff80cde3ea at vfs_unmountall+0x6a
#8 0xffffffff80caf29c at bufshutdown+0x33c
#9 0xffffffff80be8ec4 at kern_reboot+0x764
#10 0xffffffff80be8708 at sys_reboot+0x3a8
#11 0xffffffff810daa92 at amd64_syscall+0x6e2
#12 0xffffffff810ad0fb at fast_syscall_common+0xf8
lock order reversal:
 1st 0xfffff80006a145b0 devfs (devfs, lockmgr) @ /usr/src/sys/kern/vfs_mount.c:2158
 2nd 0xfffff80006b7ce70 fdescfs (fdescfs, lockmgr) @ /usr/src/sys/kern/vfs_subr.c:3043
lock order devfs -> fdescfs attempted at:
#0 0xffffffff80c5ab13 at witness_checkorder+0xbb3
#1 0xffffffff80bb6760 at lockmgr_lock_flags+0x180
#2 0xffffffff80cf4224 at _vn_lock+0x54
#3 0xffffffff80cdbb9f at vget_finish+0x4f
#4 0xffffffff82710242 at fdesc_root+0x22
#5 0xffffffff80cdcbfc at vflush+0x4c
#6 0xffffffff827101f2 at fdesc_unmount+0x72
#7 0xffffffff80cd1aef at dounmount+0x7bf
#8 0xffffffff80cde3ea at vfs_unmountall+0x6a
#9 0xffffffff80caf29c at bufshutdown+0x33c
#10 0xffffffff80be8ec4 at kern_reboot+0x764
#11 0xffffffff80be8708 at sys_reboot+0x3a8
#12 0xffffffff810daa92 at amd64_syscall+0x6e2
#13 0xffffffff810ad0fb at fast_syscall_common+0xf8
pid 495 (devd), jid 0, uid 0: exited on signal 11
Uptime: 1h2m46s
acpi0: Powering system off
+ rc=0
+ echo 'bhyve return code = 0'
bhyve return code = 0
+ sudo /usr/sbin/bhyvectl '--vm=testvm-main-amd64-22950' --destroy
+ sh -ex freebsd-ci/scripts/test/extract-meta.sh
+ METAOUTDIR=meta-out
+ rm -fr meta-out
+ mkdir meta-out
+ tar xvf meta.tar -C meta-out
x ./
x ./disable-zfs-tests.sh
x ./disable-dtrace-tests.sh
x ./run.sh
x ./run-kyua.sh
x ./disable-notyet-tests.sh
x ./auto-shutdown
+ rm -f test-report.txt test-report.xml
+ mv 'meta-out/test-report.*' .
mv: rename meta-out/test-report.* to ./test-report.*: No such file or directory
+ report=test-report.xml
+ [ -e freebsd-ci/jobs/FreeBSD-main-amd64-test/xfail-list -a -e test-report.xml ]
+ rm -f disk-cam
+ jot 5
+ rm -f disk1
+ rm -f disk2
+ rm -f disk3
+ rm -f disk4
+ rm -f disk5
+ rm -f disk-test.img
[PostBuildScript] - [INFO] Executing post build scripts.
[FreeBSD-main-amd64-test] $ /bin/sh -xe /tmp/jenkins8834158183940759786.sh
+ ./freebsd-ci/artifact/post-link.py
Post link: {'job_name': 'FreeBSD-main-amd64-test', 'commit': '5a5436eb5d960b9e243f8196147c6a51ca4f9dee', 'branch': 'main', 'target': 'amd64', 'target_arch': 'amd64', 'link_type': 'latest_tested'}
"Link created: main/latest_tested/amd64/amd64 -> ../../5a5436eb5d960b9e243f8196147c6a51ca4f9dee/amd64/amd64\n"
Recording test results
ERROR: Step ‘Publish JUnit test result report’ failed: No test report files were found. Configuration error?
Checking for post-build
Performing post-build step
Checking if email needs to be generated
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
Sending mail from default account using System Admin e-mail address