FreeBSD-main-amd64-test - Build #24607 - Failure
Date: Sun, 31 Dec 2023 20:46:24 UTC
FreeBSD-main-amd64-test - Build #24607 (ad3174ecea3374442b3504149fe2b5a9d9ec6f1e) - Failure
Build information: https://ci.FreeBSD.org/job/FreeBSD-main-amd64-test/24607/
Full change log: https://ci.FreeBSD.org/job/FreeBSD-main-amd64-test/24607/changes
Full build log: https://ci.FreeBSD.org/job/FreeBSD-main-amd64-test/24607/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)
f12a9a4c041a4dbce7dccc85aa5fad155e137d7e by markj:
frag6: Drop unneeded casts from malloc calls
0736a38072b52204289c669770a34d0b801a8a7e by markj:
frag6: Reduce code duplication
8b57b2a98b641794538980aed2cd16c94aedaf4d by markj:
frag6 tests: Serialize
e1f336704d308679d4178fd5063dba854b22a07b by markj:
gtaskqueue: Fix a typo
ad3174ecea3374442b3504149fe2b5a9d9ec6f1e by markj:
libdtrace: Fix line number reporting in error messages
The end of the build log:
[...truncated 4.35 MB...]
passed [0.008s]
sys/audit/open:openat_read_write_creat_success -> 2023-12-31T20:46:14.790997+00:00 - auditd 54009 - - Got audit initialize trigger
passed [0.008s]
sys/audit/open:openat_read_write_creat_trunc_failure -> 2023-12-31T20:46:14.809725+00:00 - auditd 54009 - - Got audit initialize trigger
passed [0.007s]
sys/audit/open:openat_read_write_creat_trunc_success -> 2023-12-31T20:46:14.828098+00:00 - auditd 54009 - - Got audit initialize trigger
passed [0.007s]
sys/audit/open:openat_read_write_failure -> 2023-12-31T20:46:14.849145+00:00 - auditd 54009 - - Got audit initialize trigger
passed [0.010s]
sys/audit/open:openat_read_write_success -> 2023-12-31T20:46:14.869859+00:00 - auditd 54009 - - Got audit initialize trigger
passed [0.008s]
sys/audit/open:openat_read_write_trunc_failure -> 2023-12-31T20:46:14.889555+00:00 - auditd 54009 - - Got audit initialize trigger
passed [0.008s]
sys/audit/open:openat_read_write_trunc_success -> 2023-12-31T20:46:14.912771+00:00 - auditd 54009 - - Got audit initialize trigger
passed [0.009s]
sys/audit/open:openat_write_creat_failure -> 2023-12-31T20:46:14.935541+00:00 - auditd 54009 - - Got audit initialize trigger
passed [0.009s]
sys/audit/open:openat_write_creat_success -> 2023-12-31T20:46:14.958145+00:00 - auditd 54009 - - Got audit initialize trigger
passed [0.009s]
sys/audit/open:openat_write_creat_trunc_failure -> 2023-12-31T20:46:14.979829+00:00 - auditd 54009 - - Got audit initialize trigger
passed [0.008s]
sys/audit/open:openat_write_creat_trunc_success -> 2023-12-31T20:46:15.001341+00:00 - auditd 54009 - - Got audit initialize trigger
passed [0.008s]
sys/audit/open:openat_write_failure -> 2023-12-31T20:46:15.022236+00:00 - auditd 54009 - - Got audit initialize trigger
passed [0.007s]
sys/audit/open:openat_write_success -> 2023-12-31T20:46:15.044152+00:00 - auditd 54009 - - Got audit initialize trigger
passed [0.009s]
sys/audit/open:openat_write_trunc_failure -> 2023-12-31T20:46:15.065587+00:00 - auditd 54009 - - Got audit initialize trigger
passed [0.008s]
sys/audit/open:openat_write_trunc_success -> 2023-12-31T20:46:15.084109+00:00 - auditd 54009 - - Got audit initialize trigger
passed [0.007s]
sys/audit/process-control:_exit_success -> 2023-12-31T20:46:15.105676+00:00 - auditd 54009 - - Got audit initialize trigger
passed [0.009s]
sys/audit/process-control:cap_enter_success -> 2023-12-31T20:46:15.128856+00:00 - auditd 54009 - - Got audit initialize trigger
passed [0.010s]
sys/audit/process-control:cap_getmode_failure -> 2023-12-31T20:46:15.152234+00:00 - auditd 54009 - - Got audit initialize trigger
passed [0.009s]
sys/audit/process-control:cap_getmode_success -> 2023-12-31T20:46:15.175476+00:00 - auditd 54009 - - Got audit initialize trigger
passed [0.010s]
sys/audit/process-control:chdir_failure -> 2023-12-31T20:46:15.196663+00:00 - auditd 54009 - - Got audit initialize trigger
passed [0.008s]
sys/audit/process-control:chdir_success -> 2023-12-31T20:46:15.217799+00:00 - auditd 54009 - - Got audit initialize trigger
passed [0.009s]
sys/audit/process-control:chroot_failure -> 2023-12-31T20:46:15.240056+00:00 - auditd 54009 - - Got audit initialize trigger
passed [0.009s]
sys/audit/process-control:chroot_success -> 2023-12-31T20:46:15.262745+00:00 - auditd 54009 - - Got audit initialize trigger
passed [0.008s]
sys/audit/process-control:fchdir_failure -> 2023-12-31T20:46:15.281014+00:00 - auditd 54009 - - Got audit initialize trigger
passed [0.007s]
sys/audit/process-control:fchdir_success -> 2023-12-31T20:46:15.298932+00:00 - auditd 54009 - - Got audit initialize trigger
passed [0.007s]
sys/audit/process-control:fork_success -> 2023-12-31T20:46:15.317185+00:00 - auditd 54009 - - Got audit initialize trigger
passed [0.007s]
sys/audit/process-control:getresgid_failure -> 2023-12-31T20:46:15.335482+00:00 - auditd 54009 - - Got audit initialize trigger
passed [0.007s]
sys/audit/process-control:getresgid_success -> 2023-12-31T20:46:15.353900+00:00 - auditd 54009 - - Got audit initialize trigger
passed [0.007s]
sys/audit/process-control:getresuid_failure -> 2023-12-31T20:46:15.372709+00:00 - auditd 54009 - - Got audit initialize trigger
passed [0.008s]
sys/audit/process-control:getresuid_success -> 2023-12-31T20:46:15.396330+00:00 - auditd 54009 - - Got audit initialize trigger
passed [0.010s]
sys/audit/process-control:kill_failure -> 2023-12-31T20:46:15.420132+00:00 - auditd 54009 - - Got audit initialize trigger
passed [0.009s]
sys/audit/process-control:kill_success -> 2023-12-31T20:46:15.443419+00:00 - auditd 54009 - - Got audit initialize trigger
passed [0.009s]
sys/audit/process-control:ktrace_failure -> 2023-12-31T20:46:15.465699+00:00 - auditd 54009 - - Got audit initialize trigger
passed [0.010s]
sys/audit/process-control:ktrace_success -> 2023-12-31T20:46:15.489549+00:00 - auditd 54009 - - Got audit initialize trigger
passed [0.010s]
sys/audit/process-control:minherit_failure -> 2023-12-31T20:46:15.510046+00:00 - auditd 54009 - - Got audit initialize trigger
passed [0.008s]
sys/audit/process-control:minherit_success -> 2023-12-31T20:46:15.529476+00:00 - auditd 54009 - - Got audit initialize trigger
passed [0.008s]
sys/audit/process-control:mlock_failure -> 2023-12-31T20:46:15.549228+00:00 - auditd 54009 - - Got audit initialize trigger
passed [0.008s]
sys/audit/process-control:mlock_success -> 2023-12-31T20:46:15.571684+00:00 - auditd 54009 - - Got audit initialize trigger
passed [0.008s]
sys/audit/process-control:munlock_failure -> 2023-12-31T20:46:15.590924+00:00 - auditd 54009 - - Got audit initialize trigger
passed [0.008s]
sys/audit/process-control:munlock_success -> 2023-12-31T20:46:15.610303+00:00 - auditd 54009 - - Got audit initialize trigger
passed [0.008s]
sys/audit/process-control:procctl_failure -> 2023-12-31T20:46:15.632408+00:00 - auditd 54009 - - Got audit initialize trigger
passed [0.008s]
sys/audit/process-control:procctl_success -> 2023-12-31T20:46:15.651843+00:00 - auditd 54009 - - Got audit initialize trigger
passed [0.008s]
sys/audit/process-control:profil_failure -> 2023-12-31T20:46:15.676787+00:00 - auditd 54009 - - Got audit initialize trigger
passed [0.009s]
sys/audit/process-control:profil_success -> 2023-12-31T20:46:15.699893+00:00 - auditd 54009 - - Got audit initialize trigger
passed [0.008s]
sys/audit/process-control:ptrace_failure -> 2023-12-31T20:46:15.721403+00:00 - auditd 54009 - - Got audit initialize trigger
passed [0.008s]
sys/audit/process-control:ptrace_success -> 2023-12-31T20:46:15.746169+00:00 - auditd 54009 - - Got audit initialize trigger
passed [0.009s]
sys/audit/process-control:rfork_failure -> 2023-12-31T20:46:15.769780+00:00 - auditd 54009 - - Got audit initialize trigger
passed [0.010s]
sys/audit/process-control:rfork_success -> 2023-12-31T20:46:15.791756+00:00 - auditd 54009 - - Got audit initialize trigger
passed [0.008s]
sys/audit/process-control:rtprio_failure -> 2023-12-31T20:46:15.814538+00:00 - auditd 54009 - - Got audit initialize trigger
passed [0.009s]
sys/audit/process-control:rtprio_success -> 2023-12-31T20:46:15.833829+00:00 - auditd 54009 - - Got audit initialize trigger
passed [0.007s]
sys/audit/process-control:setegid_success -> 2023-12-31T20:46:15.853062+00:00 - auditd 54009 - - Got audit initialize trigger
passed [0.007s]
sys/audit/process-control:seteuid_success -> 2023-12-31T20:46:15.871593+00:00 - auditd 54009 - - Got audit initialize trigger
passed [0.007s]
sys/audit/process-control:setgid_success -> 2023-12-31T20:46:15.890097+00:00 - auditd 54009 - - Got audit initialize trigger
passed [0.007s]
sys/audit/process-control:setgroups_failure -> 2023-12-31T20:46:15.908736+00:00 - auditd 54009 - - Got audit initialize trigger
passed [0.007s]
sys/audit/process-control:setgroups_success -> 2023-12-31T20:46:15.927405+00:00 - auditd 54009 - - Got audit initialize trigger
passed [0.007s]
sys/audit/process-control:setlogin_failure -> 2023-12-31T20:46:15.947959+00:00 - auditd 54009 - - Got audit initialize trigger
passed [0.009s]
sys/audit/process-control:setlogin_success -> 2023-12-31T20:46:15.970992+00:00 - auditd 54009 - - Got audit initialize trigger
passed [0.009s]
sys/audit/process-control:setpgrp_failure -> 2023-12-31T20:46:15.991796+00:00 - auditd 54009 - - Got audit initialize trigger
passed [0.007s]
sys/audit/process-control:setpgrp_success -> 2023-12-31T20:46:16.013345+00:00 - auditd 54009 - - Got audit initialize trigger
passed [0.008s]
sys/audit/process-control:setpriority_failure -> 2023-12-31T20:46:16.037600+00:00 - auditd 54009 - - Got audit initialize trigger
passed [0.009s]
sys/audit/process-control:setpriority_success -> 2023-12-31T20:46:16.060112+00:00 - auditd 54009 - - Got audit initialize trigger
passed [0.009s]
sys/audit/process-control:setregid_success -> 2023-12-31T20:46:16.080745+00:00 - auditd 54009 - - Got audit initialize trigger
passed [0.007s]
sys/audit/process-control:setresgid_success -> 2023-12-31T20:46:16.101863+00:00 - auditd 54009 - - Got audit initialize trigger
passed [0.009s]
sys/audit/process-control:setresuid_success -> 2023-12-31T20:46:16.123927+00:00 - auditd 54009 - - Got audit initialize trigger
passed [0.008s]
sys/audit/process-control:setreuid_success -> 2023-12-31T20:46:16.143213+00:00 - auditd 54009 - - Got audit initialize trigger
passed [0.007s]
sys/audit/process-control:setrlimit_failure -> 2023-12-31T20:46:16.161612+00:00 - auditd 54009 - - Got audit initialize trigger
passed [0.007s]
sys/audit/process-control:setrlimit_success -> *** /usr/src/contrib/kyua/utils/process/executor.cpp:779: Invariant check failed: PID 54821 already in all_exec_handles; not properly cleaned up or reused too fast
*** Fatal signal 6 received
*** Log file is /.kyua/logs/kyua.20231231-200029.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
2023-12-31T20:46:16.185026+00:00 - auditd 54009 - - Got audit initialize trigger
pid 806 (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-notyet-tests.sh
a ./run-kyua.sh
a ./auto-shutdown
a ./run.sh
a ./disable-dtrace-tests.sh
+ [ -f /meta/auto-shutdown ]
+ uname -p
+ shutdown -p now
Shutdown NOW!
shutdown: [pid 54828]
+ 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-12-31T20:46:16.319281+00:00 - shutdown 54828 - - power-down by root:
System shutdown time has arrived
2023-12-31T20:46:16.320956+00:00 - auditd 54009 - - auditd_wait_for_events: SIGTERM
2023-12-31T20:46:16.322677+00:00 - auditd 54009 - - Auditing disabled
2023-12-31T20:46:16.323809+00:00 - auditd 54009 - - renamed /var/audit/20231231204607.not_terminated to /var/audit/20231231204607.20231231204616
2023-12-31T20:46:16.326250+00:00 - auditd 54009 - - 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 0xfffff80009a38070 devfs (devfs, lockmgr) @ /usr/src/sys/kern/vfs_mount.c:2253
2nd 0xfffff80009a39930 fdescfs (fdescfs, lockmgr) @ /usr/src/sys/kern/vfs_subr.c:3294
lock order devfs -> fdescfs attempted at:
#0 0xffffffff80bc6803 at witness_checkorder+0xb63
#1 0xffffffff80b1f671 at lockmgr_lock_flags+0x181
#2 0xffffffff80c628c3 at _vn_lock+0x53
#3 0xffffffff80c49e6d at vget_finish+0x4d
#4 0xffffffff82610262 at fdesc_root+0x22
#5 0xffffffff80c4aefb at vflush+0x4b
#6 0xffffffff82610211 at fdesc_unmount+0x71
#7 0xffffffff80c3fa75 at dounmount+0x7b5
#8 0xffffffff80c4c63a at vfs_unmountall+0x6a
#9 0xffffffff80c1c9ff at bufshutdown+0x31f
#10 0xffffffff80b52573 at kern_reboot+0x703
#11 0xffffffff80b51e19 at sys_reboot+0x3a9
#12 0xffffffff81059453 at amd64_syscall+0x153
#13 0xffffffff8102ae8b at fast_syscall_common+0xf8
Uptime: 45m54s
acpi0: Powering system off
+ rc=0
+ echo 'bhyve return code = 0'
bhyve return code = 0
+ sudo /usr/sbin/bhyvectl '--vm=testvm-main-amd64-24607' --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-notyet-tests.sh
x ./run-kyua.sh
x ./auto-shutdown
x ./run.sh
x ./disable-dtrace-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/jenkins12479607766992650235.sh
+ ./freebsd-ci/artifact/post-link.py
Post link: {'job_name': 'FreeBSD-main-amd64-test', 'commit': 'ad3174ecea3374442b3504149fe2b5a9d9ec6f1e', 'branch': 'main', 'target': 'amd64', 'target_arch': 'amd64', 'link_type': 'latest_tested'}
"Link created: main/latest_tested/amd64/amd64 -> ../../ad3174ecea3374442b3504149fe2b5a9d9ec6f1e/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