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

From: <jenkins-admin_at_FreeBSD.org>
Date: Wed, 22 Nov 2023 16:14:32 UTC
FreeBSD-main-amd64-test - Build #24426 (b01cad6d3a8523101e7915809144f47e3045067f) - Failure

Build information: https://ci.FreeBSD.org/job/FreeBSD-main-amd64-test/24426/
Full change log: https://ci.FreeBSD.org/job/FreeBSD-main-amd64-test/24426/changes
Full build log: https://ci.FreeBSD.org/job/FreeBSD-main-amd64-test/24426/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)

8ec79e8ae07d34a371eeb09329ad32993aecd906 by 0mp:
loader.efi.8: Fix a typo

b01cad6d3a8523101e7915809144f47e3045067f by kp:
ip_mroute: handle V_mfchashtbl allocation failure



The end of the build log:

[...truncated 3.95 MB...]
lib/atf/libatf-c/detail/dynstr_test:init_ap  ->  passed  [0.004s]
lib/atf/libatf-c/detail/dynstr_test:init_fmt  ->  passed  [0.004s]
lib/atf/libatf-c/detail/dynstr_test:init_raw  ->  passed  [0.004s]
lib/atf/libatf-c/detail/dynstr_test:init_rep  ->  passed  [0.012s]
lib/atf/libatf-c/detail/dynstr_test:init_substr  ->  passed  [0.004s]
lib/atf/libatf-c/detail/dynstr_test:length  ->  passed  [0.008s]
lib/atf/libatf-c/detail/dynstr_test:prepend_ap  ->  passed  [0.033s]
lib/atf/libatf-c/detail/dynstr_test:prepend_fmt  ->  passed  [0.032s]
lib/atf/libatf-c/detail/dynstr_test:rfind_ch  ->  passed  [0.005s]
lib/atf/libatf-c/detail/env_test:get  ->  passed  [0.004s]
lib/atf/libatf-c/detail/env_test:get_with_default  ->  passed  [0.003s]
lib/atf/libatf-c/detail/env_test:has  ->  passed  [0.004s]
lib/atf/libatf-c/detail/env_test:set  ->  passed  [0.004s]
lib/atf/libatf-c/detail/env_test:unset  ->  passed  [0.003s]
lib/atf/libatf-c/detail/fs_test:eaccess  ->  passed  [0.006s]
lib/atf/libatf-c/detail/fs_test:exists  ->  passed  [0.004s]
lib/atf/libatf-c/detail/fs_test:getcwd  ->  passed  [0.004s]
lib/atf/libatf-c/detail/fs_test:mkdtemp_err  ->  passed  [0.005s]
lib/atf/libatf-c/detail/fs_test:mkdtemp_ok  ->  passed  [0.005s]
lib/atf/libatf-c/detail/fs_test:mkdtemp_umask  ->  passed  [0.004s]
lib/atf/libatf-c/detail/fs_test:mkstemp_err  ->  passed  [0.005s]
lib/atf/libatf-c/detail/fs_test:mkstemp_ok  ->  passed  [0.005s]
lib/atf/libatf-c/detail/fs_test:mkstemp_umask  ->  passed  [0.004s]
lib/atf/libatf-c/detail/fs_test:path_append  ->  passed  [0.005s]
lib/atf/libatf-c/detail/fs_test:path_branch_path  ->  passed  [0.004s]
lib/atf/libatf-c/detail/fs_test:path_copy  ->  passed  [0.004s]
lib/atf/libatf-c/detail/fs_test:path_equal  ->  passed  [0.005s]
lib/atf/libatf-c/detail/fs_test:path_is_absolute  ->  passed  [0.004s]
lib/atf/libatf-c/detail/fs_test:path_is_root  ->  passed  [0.004s]
lib/atf/libatf-c/detail/fs_test:path_leaf_name  ->  passed  [0.004s]
lib/atf/libatf-c/detail/fs_test:path_normalize  ->  passed  [0.004s]
lib/atf/libatf-c/detail/fs_test:path_to_absolute  ->  passed  [0.004s]
lib/atf/libatf-c/detail/fs_test:rmdir_empty  ->  passed  [0.005s]
lib/atf/libatf-c/detail/fs_test:rmdir_enotempty  ->  passed  [0.005s]
lib/atf/libatf-c/detail/fs_test:rmdir_eperm  ->  passed  [0.005s]
lib/atf/libatf-c/detail/fs_test:stat_mode  ->  passed  [0.004s]
lib/atf/libatf-c/detail/fs_test:stat_perms  ->  passed  [0.004s]
lib/atf/libatf-c/detail/fs_test:stat_type  ->  passed  [0.005s]
lib/atf/libatf-c/detail/list_test:list_append  ->  passed  [0.005s]
lib/atf/libatf-c/detail/list_test:list_append_list  ->  passed  [0.004s]
lib/atf/libatf-c/detail/list_test:list_for_each  ->  passed  [0.004s]
lib/atf/libatf-c/detail/list_test:list_for_each_c  ->  passed  [0.004s]
lib/atf/libatf-c/detail/list_test:list_index  ->  passed  [0.004s]
lib/atf/libatf-c/detail/list_test:list_index_c  ->  passed  [0.004s]
lib/atf/libatf-c/detail/list_test:list_init  ->  passed  [0.004s]
lib/atf/libatf-c/detail/list_test:list_to_charpp_empty  ->  passed  [0.004s]
lib/atf/libatf-c/detail/list_test:list_to_charpp_some  ->  passed  [0.004s]
lib/atf/libatf-c/detail/map_test:find  ->  passed  [0.004s]
lib/atf/libatf-c/detail/map_test:find_c  ->  passed  [0.003s]
lib/atf/libatf-c/detail/map_test:map_for_each  ->  passed  [0.004s]
lib/atf/libatf-c/detail/map_test:map_for_each_c  ->  passed  [0.004s]
lib/atf/libatf-c/detail/map_test:map_init  ->  passed  [0.004s]
lib/atf/libatf-c/detail/map_test:map_init_charpp_empty  ->  passed  [0.003s]
lib/atf/libatf-c/detail/map_test:map_init_charpp_null  ->  passed  [0.003s]
lib/atf/libatf-c/detail/map_test:map_init_charpp_short  ->  passed  [0.003s]
lib/atf/libatf-c/detail/map_test:map_init_charpp_some  ->  passed  [0.004s]
lib/atf/libatf-c/detail/map_test:map_insert  ->  passed  [0.004s]
lib/atf/libatf-c/detail/map_test:stable_keys  ->  passed  [0.004s]
lib/atf/libatf-c/detail/map_test:to_charpp_empty  ->  passed  [0.004s]
lib/atf/libatf-c/detail/map_test:to_charpp_some  ->  passed  [0.004s]
lib/atf/libatf-c/detail/process_test:child_pid  ->  passed  [0.006s]
lib/atf/libatf-c/detail/process_test:child_wait_eintr  ->  passed  [1.021s]
lib/atf/libatf-c/detail/process_test:exec_failure  ->  passed  [0.006s]
lib/atf/libatf-c/detail/process_test:exec_list  ->  passed  [0.006s]
lib/atf/libatf-c/detail/process_test:exec_prehook  ->  passed  [0.006s]
lib/atf/libatf-c/detail/process_test:exec_success  ->  passed  [0.006s]
lib/atf/libatf-c/detail/process_test:fork_cookie  ->  passed  [0.006s]
lib/atf/libatf-c/detail/process_test:fork_out_capture_err_capture  ->  passed  [0.006s]
lib/atf/libatf-c/detail/process_test:fork_out_capture_err_connect  ->  passed  [0.006s]
lib/atf/libatf-c/detail/process_test:fork_out_capture_err_default  ->  passed  [0.006s]
lib/atf/libatf-c/detail/process_test:fork_out_capture_err_inherit  ->  passed  [0.006s]
lib/atf/libatf-c/detail/process_test:fork_out_capture_err_redirect_fd  ->  passed  [0.006s]
lib/atf/libatf-c/detail/process_test:fork_out_capture_err_redirect_path  ->  passed  [0.006s]
lib/atf/libatf-c/detail/process_test:fork_out_connect_err_capture  ->  passed  [0.006s]
lib/atf/libatf-c/detail/process_test:fork_out_connect_err_connect  ->  passed  [0.006s]
lib/atf/libatf-c/detail/process_test:fork_out_connect_err_default  ->  passed  [0.006s]
lib/atf/libatf-c/detail/process_test:fork_out_connect_err_inherit  ->  passed  [0.006s]
lib/atf/libatf-c/detail/process_test:fork_out_connect_err_redirect_fd  ->  passed  [0.006s]
lib/atf/libatf-c/detail/process_test:fork_out_connect_err_redirect_path  ->  passed  [0.007s]
lib/atf/libatf-c/detail/process_test:fork_out_default_err_capture  ->  passed  [0.006s]
lib/atf/libatf-c/detail/process_test:fork_out_default_err_connect  ->  passed  [0.006s]
lib/atf/libatf-c/detail/process_test:fork_out_default_err_default  ->  passed  [0.006s]
lib/atf/libatf-c/detail/process_test:fork_out_default_err_inherit  ->  passed  [0.006s]
lib/atf/libatf-c/detail/process_test:fork_out_default_err_redirect_fd  ->  passed  [0.006s]
lib/atf/libatf-c/detail/process_test:fork_out_default_err_redirect_path  ->  passed  [0.006s]
lib/atf/libatf-c/detail/process_test:fork_out_inherit_err_capture  ->  passed  [0.005s]
lib/atf/libatf-c/detail/process_test:fork_out_inherit_err_connect  ->  passed  [0.006s]
lib/atf/libatf-c/detail/process_test:fork_out_inherit_err_default  ->  passed  [0.006s]
lib/atf/libatf-c/detail/process_test:fork_out_inherit_err_inherit  ->  passed  [0.005s]
lib/atf/libatf-c/detail/process_test:fork_out_inherit_err_redirect_fd  ->  passed  [0.005s]
lib/atf/libatf-c/detail/process_test:fork_out_inherit_err_redirect_path  ->  passed  [0.005s]
lib/atf/libatf-c/detail/process_test:fork_out_redirect_fd_err_capture  ->  passed  [0.005s]
lib/atf/libatf-c/detail/process_test:fork_out_redirect_fd_err_connect  ->  passed  [0.005s]
lib/atf/libatf-c/detail/process_test:fork_out_redirect_fd_err_default  ->  passed  [0.005s]
lib/atf/libatf-c/detail/process_test:fork_out_redirect_fd_err_inherit  ->  passed  [0.005s]
lib/atf/libatf-c/detail/process_test:fork_out_redirect_fd_err_redirect_fd  ->  passed  [0.005s]
lib/atf/libatf-c/detail/process_test:fork_out_redirect_fd_err_redirect_path  ->  passed  [0.005s]
lib/atf/libatf-c/detail/process_test:fork_out_redirect_path_err_capture  ->  passed  [0.005s]
lib/atf/libatf-c/detail/process_test:fork_out_redirect_path_err_connect  ->  passed  [0.006s]
lib/atf/libatf-c/detail/process_test:fork_out_redirect_path_err_default  ->  passed  [0.007s]
lib/atf/libatf-c/detail/process_test:fork_out_redirect_path_err_inherit  ->  passed  [0.006s]
lib/atf/libatf-c/detail/process_test:fork_out_redirect_path_err_redirect_fd  ->  passed  [0.006s]
lib/atf/libatf-c/detail/process_test:fork_out_redirect_path_err_redirect_path  ->  passed  [0.006s]
lib/atf/libatf-c/detail/process_test:status_coredump  ->  pid 7599 (process_test), jid 0, uid 0: exited on signal 3 (core dumped)
passed  [0.016s]
lib/atf/libatf-c/detail/process_test:status_exited  ->  passed  [0.005s]
lib/atf/libatf-c/detail/process_test:status_signaled  ->  passed  [0.005s]
lib/atf/libatf-c/detail/process_test:stream_init_capture  ->  passed  [0.004s]
lib/atf/libatf-c/detail/process_test:stream_init_connect  ->  passed  [0.004s]
lib/atf/libatf-c/detail/process_test:stream_init_inherit  ->  passed  [0.005s]
lib/atf/libatf-c/detail/process_test:stream_init_redirect_fd  ->  passed  [0.004s]
lib/atf/libatf-c/detail/process_test:stream_init_redirect_path  ->  passed  [0.004s]
lib/atf/libatf-c/detail/sanity_test:inv  ->  pid 7613 (sanity_test), jid 0, uid 0: exited on signal 6 (core dumped)
passed  [0.013s]
lib/atf/libatf-c/detail/sanity_test:post  ->  pid 7616 (sanity_test), jid 0, uid 0: exited on signal 6 (core dumped)
passed  [0.013s]
lib/atf/libatf-c/detail/sanity_test:pre  ->  pid 7619 (sanity_test), jid 0, uid 0: exited on signal 6 (core dumped)
passed  [0.013s]
lib/atf/libatf-c/detail/sanity_test:unreachable  ->  pid 7622 (sanity_test), jid 0, uid 0: exited on signal 6 (core dumped)
passed  [0.013s]
lib/atf/libatf-c/detail/text_test:for_each_word  ->  passed  [0.003s]
lib/atf/libatf-c/detail/text_test:format  ->  passed  [0.003s]
lib/atf/libatf-c/detail/text_test:format_ap  ->  passed  [0.003s]
lib/atf/libatf-c/detail/text_test:split  ->  passed  [0.003s]
lib/atf/libatf-c/detail/text_test:split_delims  ->  passed  [0.003s]
lib/atf/libatf-c/detail/text_test:to_bool  ->  passed  [0.003s]
lib/atf/libatf-c/detail/text_test:to_long  ->  passed  [0.003s]
lib/atf/libatf-c/detail/user_test:euid  ->  passed  [0.003s]
lib/atf/libatf-c/detail/user_test:is_member_of_group  ->  passed  [0.003s]
lib/atf/libatf-c/detail/user_test:is_root  ->  passed  [0.003s]
lib/atf/libatf-c/detail/user_test:is_unprivileged  ->  passed  [0.003s]
lib/libkvm/kvm_close_test:kvm_close_negative_test_NULL  ->  passed  [0.004s]
lib/libkvm/kvm_geterr_test:kvm_geterr_negative_test_NULL  ->  passed  [0.004s]
lib/libkvm/kvm_geterr_test:kvm_geterr_positive_test_error  ->  passed  [0.004s]
lib/libkvm/kvm_geterr_test:kvm_geterr_positive_test_no_error  ->  *** /usr/src/contrib/kyua/utils/process/executor.cpp:779: Invariant check failed: PID 7642 already in all_exec_handles; not properly cleaned up or reused too fast
*** Fatal signal 6 received
*** Log file is /.kyua/logs/kyua.20231122-155444.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 766 (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 ./auto-shutdown
a ./disable-zfs-tests.sh
a ./disable-dtrace-tests.sh
a ./run.sh
a ./run-kyua.sh
a ./disable-notyet-tests.sh
+ [ -f /meta/auto-shutdown ]
+ uname -p
+ shutdown -p now
Shutdown NOW!
shutdown: [pid 7646]
+ 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-11-22T16:14:24.390656+00:00 - shutdown 7646 - - power-down by root: 

System shutdown time has arrived
2023-11-22T16:14:24.392734+00:00 - auditd 683 - - auditd_wait_for_events: SIGTERM
2023-11-22T16:14:24.393843+00:00 - auditd 683 - - Auditing disabled
2023-11-22T16:14:24.395228+00:00 - auditd 683 - - renamed /var/audit/20231122155443.not_terminated to /var/audit/20231122155443.20231122161424
2023-11-22T16:14:24.397545+00:00 - auditd 683 - - Finished
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... 0 0 done
All buffers synced.
lock order reversal:
 1st 0xfffff800097ffe70 devfs (devfs, lockmgr) @ /usr/src/sys/kern/vfs_mount.c:2254
 2nd 0xfffff800099e2070 fdescfs (fdescfs, lockmgr) @ /usr/src/sys/kern/vfs_subr.c:3296
lock order devfs -> fdescfs attempted at:
#0 0xffffffff80bc35ae at witness_checkorder+0xbbe
#1 0xffffffff80b1ced1 at lockmgr_lock_flags+0x181
#2 0xffffffff80c5f393 at _vn_lock+0x53
#3 0xffffffff80c4695d at vget_finish+0x4d
#4 0xffffffff82610262 at fdesc_root+0x22
#5 0xffffffff80c479fb at vflush+0x4b
#6 0xffffffff82610211 at fdesc_unmount+0x71
#7 0xffffffff80c3c645 at dounmount+0x7b5
#8 0xffffffff80c4913a at vfs_unmountall+0x6a
#9 0xffffffff80c1968c at bufshutdown+0x30c
#10 0xffffffff80b4fdb3 at kern_reboot+0x713
#11 0xffffffff80b4f649 at sys_reboot+0x3a9
#12 0xffffffff810546b3 at amd64_syscall+0x153
#13 0xffffffff810265db at fast_syscall_common+0xf8
Uptime: 19m48s
acpi0: Powering system off
+ rc=0
+ echo 'bhyve return code = 0'
bhyve return code = 0
+ sudo /usr/sbin/bhyvectl '--vm=testvm-main-amd64-24426' --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 ./auto-shutdown
x ./disable-zfs-tests.sh
x ./disable-dtrace-tests.sh
x ./run.sh
x ./run-kyua.sh
x ./disable-notyet-tests.sh
+ 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/jenkins16268337519627716885.sh
+ ./freebsd-ci/artifact/post-link.py
Post link: {'job_name': 'FreeBSD-main-amd64-test', 'commit': 'b01cad6d3a8523101e7915809144f47e3045067f', 'branch': 'main', 'target': 'amd64', 'target_arch': 'amd64', 'link_type': 'latest_tested'}
"Link created: main/latest_tested/amd64/amd64 -> ../../b01cad6d3a8523101e7915809144f47e3045067f/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