FreeBSD-stable-14-amd64-test - Build #25 - Failure

From: <jenkins-admin_at_FreeBSD.org>
Date: Tue, 12 Sep 2023 16:15:38 UTC
FreeBSD-stable-14-amd64-test - Build #25 (deaa6984ada80e36aea2f16e5f7211dd0d14800c) - Failure

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

29a28b9940d568519aac4574ccc293f205a732ae by 0mp:
getdirentries.2: Reference directory(3)

f4960baf80758aa34e17210adf1741dd6238ed69 by 0mp:
getdirentries.2: Improve readability of dirent members

d2557f02d126c1300b491235b1264bcd39d8de50 by 0mp:
getdirentries.2: Reference dir(5)

deaa6984ada80e36aea2f16e5f7211dd0d14800c by karels:
mountd: do not warn about using class mask with -mask



The end of the build log:

[...truncated 4.32 MB...]
sys/audit/file-attribute-modify:chown_success  ->  2023-09-12T16:15:28.510317+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.005s]
sys/audit/file-attribute-modify:extattr_delete_fd_failure  ->  2023-09-12T16:15:28.524600+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.006s]
sys/audit/file-attribute-modify:extattr_delete_fd_success  ->  2023-09-12T16:15:28.539143+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.007s]
sys/audit/file-attribute-modify:extattr_delete_file_failure  ->  2023-09-12T16:15:28.551216+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.005s]
sys/audit/file-attribute-modify:extattr_delete_file_success  ->  2023-09-12T16:15:28.563021+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.005s]
sys/audit/file-attribute-modify:extattr_delete_link_failure  ->  2023-09-12T16:15:28.574541+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.005s]
sys/audit/file-attribute-modify:extattr_delete_link_success  ->  2023-09-12T16:15:28.586038+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.006s]
sys/audit/file-attribute-modify:extattr_set_fd_failure  ->  2023-09-12T16:15:28.598186+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.005s]
sys/audit/file-attribute-modify:extattr_set_fd_success  ->  2023-09-12T16:15:28.609270+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.005s]
sys/audit/file-attribute-modify:extattr_set_file_failure  ->  2023-09-12T16:15:28.620941+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.005s]
sys/audit/file-attribute-modify:extattr_set_file_success  ->  2023-09-12T16:15:28.632599+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.005s]
sys/audit/file-attribute-modify:extattr_set_link_failure  ->  2023-09-12T16:15:28.644291+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.005s]
sys/audit/file-attribute-modify:extattr_set_link_success  ->  2023-09-12T16:15:28.656252+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.005s]
sys/audit/file-attribute-modify:fchflags_failure  ->  2023-09-12T16:15:28.668192+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.005s]
sys/audit/file-attribute-modify:fchflags_success  ->  2023-09-12T16:15:28.679224+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.005s]
sys/audit/file-attribute-modify:fchmod_failure  ->  2023-09-12T16:15:28.690025+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.004s]
sys/audit/file-attribute-modify:fchmod_success  ->  2023-09-12T16:15:28.703758+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.005s]
sys/audit/file-attribute-modify:fchmodat_failure  ->  2023-09-12T16:15:28.717339+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.006s]
sys/audit/file-attribute-modify:fchmodat_success  ->  2023-09-12T16:15:28.731041+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.006s]
sys/audit/file-attribute-modify:fchown_failure  ->  2023-09-12T16:15:28.745454+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.004s]
sys/audit/file-attribute-modify:fchown_success  ->  2023-09-12T16:15:28.758764+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.005s]
sys/audit/file-attribute-modify:fchownat_failure  ->  2023-09-12T16:15:28.769999+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.005s]
sys/audit/file-attribute-modify:fchownat_success  ->  2023-09-12T16:15:28.783739+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.006s]
sys/audit/file-attribute-modify:fcntl_failure  ->  2023-09-12T16:15:28.794829+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.004s]
sys/audit/file-attribute-modify:fcntl_success  ->  2023-09-12T16:15:28.805464+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.004s]
sys/audit/file-attribute-modify:flock_failure  ->  2023-09-12T16:15:28.815528+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.004s]
sys/audit/file-attribute-modify:flock_success  ->  2023-09-12T16:15:28.826183+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.004s]
sys/audit/file-attribute-modify:fsync_failure  ->  2023-09-12T16:15:28.836938+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.005s]
sys/audit/file-attribute-modify:fsync_success  ->  2023-09-12T16:15:28.848599+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.005s]
sys/audit/file-attribute-modify:futimes_failure  ->  2023-09-12T16:15:28.860190+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.005s]
sys/audit/file-attribute-modify:futimes_success  ->  2023-09-12T16:15:28.871195+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.005s]
sys/audit/file-attribute-modify:futimesat_failure  ->  2023-09-12T16:15:28.881813+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.004s]
sys/audit/file-attribute-modify:futimesat_success  ->  2023-09-12T16:15:28.892783+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.004s]
sys/audit/file-attribute-modify:lchflags_failure  ->  2023-09-12T16:15:28.905172+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.005s]
sys/audit/file-attribute-modify:lchflags_success  ->  2023-09-12T16:15:28.916514+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.005s]
sys/audit/file-attribute-modify:lchmod_failure  ->  2023-09-12T16:15:28.927500+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.005s]
sys/audit/file-attribute-modify:lchmod_success  ->  2023-09-12T16:15:28.938863+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.005s]
sys/audit/file-attribute-modify:lchown_failure  ->  2023-09-12T16:15:28.950178+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.004s]
sys/audit/file-attribute-modify:lchown_success  ->  2023-09-12T16:15:28.960918+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.005s]
sys/audit/file-attribute-modify:lutimes_failure  ->  2023-09-12T16:15:28.975291+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.006s]
sys/audit/file-attribute-modify:lutimes_success  ->  2023-09-12T16:15:28.988653+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.005s]
sys/audit/file-attribute-modify:mprotect_failure  ->  2023-09-12T16:15:29.000306+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.005s]
sys/audit/file-attribute-modify:mprotect_success  ->  2023-09-12T16:15:29.014712+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.006s]
sys/audit/file-attribute-modify:undelete_failure  ->  2023-09-12T16:15:29.029245+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.006s]
sys/audit/file-attribute-modify:utimes_failure  ->  2023-09-12T16:15:29.042921+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.004s]
sys/audit/file-attribute-modify:utimes_success  ->  2023-09-12T16:15:29.055604+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.005s]
sys/audit/file-close:close_failure  ->  2023-09-12T16:15:29.069591+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.005s]
sys/audit/file-close:close_success  ->  2023-09-12T16:15:29.082399+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.004s]
sys/audit/file-close:closefrom_success  ->  2023-09-12T16:15:29.092844+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.005s]
sys/audit/file-close:munmap_failure  ->  2023-09-12T16:15:29.104492+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.004s]
sys/audit/file-close:munmap_success  ->  2023-09-12T16:15:29.117357+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.004s]
sys/audit/file-close:revoke_failure  ->  2023-09-12T16:15:29.128034+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.004s]
sys/audit/file-close:revoke_success  ->  2023-09-12T16:15:29.138171+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.004s]
sys/audit/file-create:link_failure  ->  2023-09-12T16:15:29.149067+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.004s]
sys/audit/file-create:link_success  ->  2023-09-12T16:15:29.159261+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.004s]
sys/audit/file-create:linkat_failure  ->  2023-09-12T16:15:29.169636+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.005s]
sys/audit/file-create:linkat_success  ->  2023-09-12T16:15:29.184137+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.006s]
sys/audit/file-create:mkdir_failure  ->  2023-09-12T16:15:29.200322+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.005s]
sys/audit/file-create:mkdir_success  ->  2023-09-12T16:15:29.210869+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.005s]
sys/audit/file-create:mkdirat_failure  ->  2023-09-12T16:15:29.222028+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.005s]
sys/audit/file-create:mkdirat_success  ->  2023-09-12T16:15:29.233652+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.005s]
sys/audit/file-create:mkfifo_failure  ->  2023-09-12T16:15:29.246942+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.005s]
sys/audit/file-create:mkfifo_success  ->  2023-09-12T16:15:29.258143+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.005s]
sys/audit/file-create:mkfifoat_failure  ->  2023-09-12T16:15:29.269204+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.005s]
sys/audit/file-create:mkfifoat_success  ->  2023-09-12T16:15:29.280003+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.005s]
sys/audit/file-create:mknod_failure  ->  2023-09-12T16:15:29.293986+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.006s]
sys/audit/file-create:mknod_success  ->  2023-09-12T16:15:29.307930+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.005s]
sys/audit/file-create:mknodat_failure  ->  2023-09-12T16:15:29.319377+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.005s]
sys/audit/file-create:mknodat_success  ->  2023-09-12T16:15:29.330481+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.005s]
sys/audit/file-create:rename_failure  ->  2023-09-12T16:15:29.341883+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.004s]
sys/audit/file-create:rename_success  ->  2023-09-12T16:15:29.353770+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.005s]
sys/audit/file-create:renameat_failure  ->  2023-09-12T16:15:29.367749+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.005s]
sys/audit/file-create:renameat_success  ->  2023-09-12T16:15:29.382016+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.006s]
sys/audit/file-create:symlink_failure  ->  2023-09-12T16:15:29.395618+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.005s]
sys/audit/file-create:symlink_success  ->  2023-09-12T16:15:29.408568+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.005s]
sys/audit/file-create:symlinkat_failure  ->  2023-09-12T16:15:29.422184+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.006s]
sys/audit/file-create:symlinkat_success  ->  2023-09-12T16:15:29.435024+00:00 - auditd 26417 - - Got audit initialize trigger
passed  [0.006s]
sys/audit/file-delete:rename_failure  ->  2023-09-12T16:15:29.449525+00:00 - auditd 26417 - - Got audit initialize trigger
*** /usr/src/contrib/kyua/utils/process/executor.cpp:822: Invariant check failed: PID 26787 already in all_exec_handles; not properly cleaned up or reused too fast
*** Fatal signal 6 received
*** Log file is /.kyua/logs/kyua.20230912-154147.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 778 (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 ./run-kyua.sh
a ./auto-shutdown
a ./disable-notyet-tests.sh
a ./disable-dtrace-tests.sh
a ./run.sh
a ./disable-zfs-tests.sh
+ [ -f /meta/auto-shutdown ]
+ uname -p
+ shutdown -p now
Shutdown NOW!
shutdown: [pid 26791]
+ 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-09-12T16:15:29.545363+00:00 - shutdown 26792023-09-12T16:15:29.545964+00:00 - auditd 26417 - - auditd_wait_for_events: SIGTERM
2023-09-12T16:15:29.547122+00:00 - auditd 26417 - - Auditing disabled
2023-09-12T16:15:29.548529+00:00 - auditd 26417 - - renamed /var/audit/20230912161527.not_terminated to /var/audit/20230912161527.20230912161529
2023-09-12T16:15:29.550598+00:00 - auditd 26417 - - 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.
Uptime: 33m46s
acpi0: Powering system off
+ rc=0
+ echo 'bhyve return code = 0'
bhyve return code = 0
+ sudo /usr/sbin/bhyvectl '--vm=testvm-14-amd64-25' --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 ./run-kyua.sh
x ./auto-shutdown
x ./disable-notyet-tests.sh
x ./disable-dtrace-tests.sh
x ./run.sh
x ./disable-zfs-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-stable-14-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-stable-14-amd64-test] $ /bin/sh -xe /tmp/jenkins725992302496768985.sh
+ ./freebsd-ci/artifact/post-link.py
Post link: {'job_name': 'FreeBSD-stable-14-amd64-test', 'commit': 'deaa6984ada80e36aea2f16e5f7211dd0d14800c', 'branch': 'stable-14', 'target': 'amd64', 'target_arch': 'amd64', 'link_type': 'latest_tested'}
"Link created: stable-14/latest_tested/amd64/amd64 -> ../../deaa6984ada80e36aea2f16e5f7211dd0d14800c/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