FreeBSD-main-amd64-test - Build #24144 - Failure
Date: Sun, 10 Sep 2023 21:42:26 UTC
FreeBSD-main-amd64-test - Build #24144 (898496ee09ed2b7d25f6807edc4515628196ec0a) - Failure
Build information: https://ci.FreeBSD.org/job/FreeBSD-main-amd64-test/24144/
Full change log: https://ci.FreeBSD.org/job/FreeBSD-main-amd64-test/24144/changes
Full build log: https://ci.FreeBSD.org/job/FreeBSD-main-amd64-test/24144/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)
72d4668c77f014e21af1db10648768e4843ce5d2 by delphij:
Vendor import of file 5.45.
The end of the build log:
[...truncated 4.33 MB...]
passed [0.007s]
sys/audit/file-attribute-access:fhstat_failure -> 2023-09-10T21:42:17.396260+00:00 - auditd 25122 - - Got audit initialize trigger
passed [0.007s]
sys/audit/file-attribute-access:fhstat_success -> 2023-09-10T21:42:17.416218+00:00 - auditd 25122 - - Got audit initialize trigger
passed [0.007s]
sys/audit/file-attribute-access:fhstatfs_failure -> 2023-09-10T21:42:17.435752+00:00 - auditd 25122 - - Got audit initialize trigger
passed [0.007s]
sys/audit/file-attribute-access:fhstatfs_success -> 2023-09-10T21:42:17.455424+00:00 - auditd 25122 - - Got audit initialize trigger
passed [0.007s]
sys/audit/file-attribute-access:fpathconf_failure -> 2023-09-10T21:42:17.475232+00:00 - auditd 25122 - - Got audit initialize trigger
passed [0.007s]
sys/audit/file-attribute-access:fpathconf_success -> 2023-09-10T21:42:17.492968+00:00 - auditd 25122 - - Got audit initialize trigger
passed [0.007s]
sys/audit/file-attribute-access:fstat_failure -> 2023-09-10T21:42:17.512523+00:00 - auditd 25122 - - Got audit initialize trigger
passed [0.008s]
sys/audit/file-attribute-access:fstat_success -> 2023-09-10T21:42:17.534014+00:00 - auditd 25122 - - Got audit initialize trigger
passed [0.008s]
sys/audit/file-attribute-access:fstatat_failure -> 2023-09-10T21:42:17.551997+00:00 - auditd 25122 - - Got audit initialize trigger
passed [0.007s]
sys/audit/file-attribute-access:fstatat_success -> 2023-09-10T21:42:17.570228+00:00 - auditd 25122 - - Got audit initialize trigger
passed [0.007s]
sys/audit/file-attribute-access:fstatfs_failure -> 2023-09-10T21:42:17.587930+00:00 - auditd 25122 - - Got audit initialize trigger
passed [0.006s]
sys/audit/file-attribute-access:fstatfs_success -> 2023-09-10T21:42:17.604872+00:00 - auditd 25122 - - Got audit initialize trigger
passed [0.006s]
sys/audit/file-attribute-access:getfsstat_failure -> 2023-09-10T21:42:17.621757+00:00 - auditd 25122 - - Got audit initialize trigger
passed [0.007s]
sys/audit/file-attribute-access:getfsstat_success -> 2023-09-10T21:42:17.638972+00:00 - auditd 25122 - - Got audit initialize trigger
passed [0.007s]
sys/audit/file-attribute-access:lgetfh_failure -> 2023-09-10T21:42:17.656195+00:00 - auditd 25122 - - Got audit initialize trigger
passed [0.007s]
sys/audit/file-attribute-access:lgetfh_success -> 2023-09-10T21:42:17.676275+00:00 - auditd 25122 - - Got audit initialize trigger
passed [0.007s]
sys/audit/file-attribute-access:lpathconf_failure -> 2023-09-10T21:42:17.693639+00:00 - auditd 25122 - - Got audit initialize trigger
passed [0.007s]
sys/audit/file-attribute-access:lpathconf_success -> 2023-09-10T21:42:17.711113+00:00 - auditd 25122 - - Got audit initialize trigger
passed [0.007s]
sys/audit/file-attribute-access:lstat_failure -> 2023-09-10T21:42:17.731557+00:00 - auditd 25122 - - Got audit initialize trigger
passed [0.009s]
sys/audit/file-attribute-access:lstat_success -> 2023-09-10T21:42:17.749254+00:00 - auditd 25122 - - Got audit initialize trigger
passed [0.007s]
sys/audit/file-attribute-access:pathconf_failure -> 2023-09-10T21:42:17.766308+00:00 - auditd 25122 - - Got audit initialize trigger
passed [0.006s]
sys/audit/file-attribute-access:pathconf_success -> 2023-09-10T21:42:17.782851+00:00 - auditd 25122 - - Got audit initialize trigger
passed [0.006s]
sys/audit/file-attribute-access:stat_failure -> 2023-09-10T21:42:17.799248+00:00 - auditd 25122 - - Got audit initialize trigger
passed [0.007s]
sys/audit/file-attribute-access:stat_success -> 2023-09-10T21:42:17.816187+00:00 - auditd 25122 - - Got audit initialize trigger
passed [0.007s]
sys/audit/file-attribute-access:statfs_failure -> 2023-09-10T21:42:17.833549+00:00 - auditd 25122 - - Got audit initialize trigger
passed [0.006s]
sys/audit/file-attribute-access:statfs_success -> 2023-09-10T21:42:17.853951+00:00 - auditd 25122 - - Got audit initialize trigger
passed [0.008s]
sys/audit/file-attribute-modify:chflags_failure -> 2023-09-10T21:42:17.875478+00:00 - auditd 25122 - - Got audit initialize trigger
passed [0.008s]
sys/audit/file-attribute-modify:chflags_success -> 2023-09-10T21:42:17.897347+00:00 - auditd 25122 - - Got audit initialize trigger
passed [0.008s]
sys/audit/file-attribute-modify:chflagsat_failure -> 2023-09-10T21:42:17.917927+00:00 - auditd 25122 - - Got audit initialize trigger
passed [0.007s]
sys/audit/file-attribute-modify:chflagsat_success -> 2023-09-10T21:42:17.939320+00:00 - auditd 25122 - - Got audit initialize trigger
passed [0.009s]
sys/audit/file-attribute-modify:chmod_failure -> 2023-09-10T21:42:17.961368+00:00 - auditd 25122 - - Got audit initialize trigger
passed [0.007s]
sys/audit/file-attribute-modify:chmod_success -> 2023-09-10T21:42:17.982311+00:00 - auditd 25122 - - Got audit initialize trigger
passed [0.008s]
sys/audit/file-attribute-modify:chown_failure -> 2023-09-10T21:42:18.003546+00:00 - auditd 25122 - - Got audit initialize trigger
passed [0.007s]
sys/audit/file-attribute-modify:chown_success -> 2023-09-10T21:42:18.024310+00:00 - auditd 25122 - - Got audit initialize trigger
passed [0.008s]
sys/audit/file-attribute-modify:extattr_delete_fd_failure -> 2023-09-10T21:42:18.044412+00:00 - auditd 25122 - - Got audit initialize trigger
passed [0.007s]
sys/audit/file-attribute-modify:extattr_delete_fd_success -> 2023-09-10T21:42:18.065607+00:00 - auditd 25122 - - Got audit initialize trigger
passed [0.008s]
sys/audit/file-attribute-modify:extattr_delete_file_failure -> 2023-09-10T21:42:18.083852+00:00 - auditd 25122 - - Got audit initialize trigger
passed [0.007s]
sys/audit/file-attribute-modify:extattr_delete_file_success -> 2023-09-10T21:42:18.102428+00:00 - auditd 25122 - - Got audit initialize trigger
passed [0.008s]
sys/audit/file-attribute-modify:extattr_delete_link_failure -> 2023-09-10T21:42:18.124347+00:00 - auditd 25122 - - Got audit initialize trigger
passed [0.008s]
sys/audit/file-attribute-modify:extattr_delete_link_success -> 2023-09-10T21:42:18.145998+00:00 - auditd 25122 - - Got audit initialize trigger
passed [0.009s]
sys/audit/file-attribute-modify:extattr_set_fd_failure -> 2023-09-10T21:42:18.168821+00:00 - auditd 25122 - - Got audit initialize trigger
passed [0.008s]
sys/audit/file-attribute-modify:extattr_set_fd_success -> 2023-09-10T21:42:18.190715+00:00 - auditd 25122 - - Got audit initialize trigger
passed [0.009s]
sys/audit/file-attribute-modify:extattr_set_file_failure -> 2023-09-10T21:42:18.213654+00:00 - auditd 25122 - - Got audit initialize trigger
passed [0.008s]
sys/audit/file-attribute-modify:extattr_set_file_success -> 2023-09-10T21:42:18.235253+00:00 - auditd 25122 - - Got audit initialize trigger
passed [0.009s]
sys/audit/file-attribute-modify:extattr_set_link_failure -> 2023-09-10T21:42:18.257816+00:00 - auditd 25122 - - Got audit initialize trigger
passed [0.008s]
sys/audit/file-attribute-modify:extattr_set_link_success -> 2023-09-10T21:42:18.279307+00:00 - auditd 25122 - - Got audit initialize trigger
passed [0.009s]
sys/audit/file-attribute-modify:fchflags_failure -> 2023-09-10T21:42:18.301417+00:00 - auditd 25122 - - Got audit initialize trigger
passed [0.008s]
sys/audit/file-attribute-modify:fchflags_success -> 2023-09-10T21:42:18.321639+00:00 - auditd 25122 - - Got audit initialize trigger
passed [0.008s]
sys/audit/file-attribute-modify:fchmod_failure -> 2023-09-10T21:42:18.342324+00:00 - auditd 25122 - - Got audit initialize trigger
passed [0.007s]
sys/audit/file-attribute-modify:fchmod_success -> 2023-09-10T21:42:18.362295+00:00 - auditd 25122 - - Got audit initialize trigger
passed [0.007s]
sys/audit/file-attribute-modify:fchmodat_failure -> 2023-09-10T21:42:18.380357+00:00 - auditd 25122 - - Got audit initialize trigger
passed [0.007s]
sys/audit/file-attribute-modify:fchmodat_success -> 2023-09-10T21:42:18.398590+00:00 - auditd 25122 - - Got audit initialize trigger
passed [0.007s]
sys/audit/file-attribute-modify:fchown_failure -> 2023-09-10T21:42:18.421238+00:00 - auditd 25122 - - Got audit initialize trigger
passed [0.008s]
sys/audit/file-attribute-modify:fchown_success -> 2023-09-10T21:42:18.440645+00:00 - auditd 25122 - - Got audit initialize trigger
passed [0.007s]
sys/audit/file-attribute-modify:fchownat_failure -> 2023-09-10T21:42:18.457493+00:00 - auditd 25122 - - Got audit initialize trigger
passed [0.006s]
sys/audit/file-attribute-modify:fchownat_success -> 2023-09-10T21:42:18.475070+00:00 - auditd 25122 - - Got audit initialize trigger
passed [0.007s]
sys/audit/file-attribute-modify:fcntl_failure -> 2023-09-10T21:42:18.492507+00:00 - auditd 25122 - - Got audit initialize trigger
passed [0.006s]
sys/audit/file-attribute-modify:fcntl_success -> 2023-09-10T21:42:18.508843+00:00 - auditd 25122 - - Got audit initialize trigger
passed [0.006s]
sys/audit/file-attribute-modify:flock_failure -> 2023-09-10T21:42:18.525678+00:00 - auditd 25122 - - Got audit initialize trigger
passed [0.006s]
sys/audit/file-attribute-modify:flock_success -> 2023-09-10T21:42:18.544807+00:00 - auditd 25122 - - Got audit initialize trigger
passed [0.009s]
sys/audit/file-attribute-modify:fsync_failure -> 2023-09-10T21:42:18.565735+00:00 - auditd 25122 - - Got audit initialize trigger
passed [0.008s]
sys/audit/file-attribute-modify:fsync_success -> 2023-09-10T21:42:18.583882+00:00 - auditd 25122 - - Got audit initialize trigger
passed [0.007s]
sys/audit/file-attribute-modify:futimes_failure -> 2023-09-10T21:42:18.601400+00:00 - auditd 25122 - - Got audit initialize trigger
passed [0.007s]
sys/audit/file-attribute-modify:futimes_success -> 2023-09-10T21:42:18.619278+00:00 - auditd 25122 - - Got audit initialize trigger
passed [0.007s]
sys/audit/file-attribute-modify:futimesat_failure -> 2023-09-10T21:42:18.636477+00:00 - auditd 25122 - - Got audit initialize trigger
passed [0.007s]
sys/audit/file-attribute-modify:futimesat_success -> 2023-09-10T21:42:18.656911+00:00 - auditd 25122 - - Got audit initialize trigger
passed [0.008s]
sys/audit/file-attribute-modify:lchflags_failure -> *** /usr/src/contrib/kyua/utils/process/executor.cpp:779: Invariant check failed: PID 25403 already in all_exec_handles; not properly cleaned up or reused too fast
*** Fatal signal 6 received
*** Log file is /.kyua/logs/kyua.20230910-210459.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-09-10T21:42:18.680404+00:00 - auditd 25122 - - Got audit initialize trigger
pid 790 (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 ./run-kyua.sh
a ./disable-notyet-tests.sh
a ./run.sh
a ./auto-shutdown
a ./disable-dtrace-tests.sh
+ [ -f /meta/auto-shutdown ]
+ uname -p
+ shutdown -p now
Shutdown NOW!
shutdown: [pid 25407]
+ 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-10T21:42:18.779897+00:00 - shutdown 25407 - - power-down by root:
System shutdown time has arrived
2023-09-10T21:42:18.781291+00:00 - auditd 25122 - - auditd_wait_for_events: SIGTERM
2023-09-10T21:42:18.782652+00:00 - auditd 25122 - - Auditing disabled
2023-09-10T21:42:18.784119+00:00 - auditd 25122 - - renamed /var/audit/20230910214215.not_terminated to /var/audit/20230910214215.20230910214218
2023-09-10T21:42:18.786884+00:00 - auditd 25122 - - 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 0xfffff80009a56cb0 devfs (devfs, lockmgr) @ /usr/src/sys/kern/vfs_mount.c:2240
2nd 0xfffff80009a565b0 fdescfs (fdescfs, lockmgr) @ /usr/src/sys/kern/vfs_subr.c:3085
lock order devfs -> fdescfs attempted at:
#0 0xffffffff80bc25fe at witness_checkorder+0xbbe
#1 0xffffffff80b1c281 at lockmgr_lock_flags+0x181
#2 0xffffffff80c5dea3 at _vn_lock+0x53
#3 0xffffffff80c4567d at vget_finish+0x4d
#4 0xffffffff82610262 at fdesc_root+0x22
#5 0xffffffff80c4671b at vflush+0x4b
#6 0xffffffff82610211 at fdesc_unmount+0x71
#7 0xffffffff80c3b4e5 at dounmount+0x7b5
#8 0xffffffff80c47e5a at vfs_unmountall+0x6a
#9 0xffffffff80c184ec at bufshutdown+0x30c
#10 0xffffffff80b4f383 at kern_reboot+0x703
#11 0xffffffff80b4ec29 at sys_reboot+0x3a9
#12 0xffffffff8104e3d8 at amd64_syscall+0x138
#13 0xffffffff8101ffbb at fast_syscall_common+0xf8
Uptime: 37m23s
acpi0: Powering system off
+ rc=0
+ echo 'bhyve return code = 0'
bhyve return code = 0
+ sudo /usr/sbin/bhyvectl '--vm=testvm-main-amd64-24144' --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 ./run-kyua.sh
x ./disable-notyet-tests.sh
x ./run.sh
x ./auto-shutdown
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/jenkins5008964315660216900.sh
+ ./freebsd-ci/artifact/post-link.py
Post link: {'job_name': 'FreeBSD-main-amd64-test', 'commit': '898496ee09ed2b7d25f6807edc4515628196ec0a', 'branch': 'main', 'target': 'amd64', 'target_arch': 'amd64', 'link_type': 'latest_tested'}
"Link created: main/latest_tested/amd64/amd64 -> ../../898496ee09ed2b7d25f6807edc4515628196ec0a/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