FreeBSD-main-amd64-test - Build #24058 - Failure
Date: Sun, 20 Aug 2023 12:26:42 UTC
FreeBSD-main-amd64-test - Build #24058 (64fbda90da1b91d2412a5b970a3996f3cf1c8522) - Failure
Build information: https://ci.FreeBSD.org/job/FreeBSD-main-amd64-test/24058/
Full change log: https://ci.FreeBSD.org/job/FreeBSD-main-amd64-test/24058/changes
Full build log: https://ci.FreeBSD.org/job/FreeBSD-main-amd64-test/24058/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)
83d941e0af3720f45ab9f2c3d035519a11752bea by delphij:
Bump __FreeBSD_version for zlib 1.3.
58983e4b0253ad38a3e1ef2166fedd3133fdb552 by dsl:
dpaa2: Clean up channels in separate tasks
62aa7ab939ea0f9187336ea5f91b954da0cbd4c7 by wulf:
Add plug and play information macro for SPI bus.
1c4edee342bba99aff29da38b164a862492f1d78 by wulf:
bcm5974(4): add support for devices attached over SPI bus
64fbda90da1b91d2412a5b970a3996f3cf1c8522 by wulf:
Add atopcase, the Apple HID over SPI input driver
The end of the build log:
[...truncated 4.32 MB...]
passed [0.008s]
sys/audit/administrative:auditon_getkmask_failure -> 2023-08-20T12:26:33.018043+00:00 - auditd 24628 - - Got audit initialize trigger
passed [0.008s]
sys/audit/administrative:auditon_getkmask_success -> 2023-08-20T12:26:33.039059+00:00 - auditd 24628 - - Got audit initialize trigger
passed [0.007s]
sys/audit/administrative:auditon_getpolicy_failure -> 2023-08-20T12:26:33.063755+00:00 - auditd 24628 - - Got audit initialize trigger
passed [0.008s]
sys/audit/administrative:auditon_getpolicy_success -> 2023-08-20T12:26:33.085400+00:00 - auditd 24628 - - Got audit initialize trigger
passed [0.007s]
sys/audit/administrative:auditon_getqctrl_failure -> 2023-08-20T12:26:33.103912+00:00 - auditd 24628 - - Got audit initialize trigger
passed [0.007s]
sys/audit/administrative:auditon_getqctrl_success -> 2023-08-20T12:26:33.121739+00:00 - auditd 24628 - - Got audit initialize trigger
passed [0.006s]
sys/audit/administrative:auditon_getstat_failure -> 2023-08-20T12:26:33.139515+00:00 - auditd 24628 - - Got audit initialize trigger
passed [0.007s]
sys/audit/administrative:auditon_setclass_failure -> 2023-08-20T12:26:33.162133+00:00 - auditd 24628 - - Got audit initialize trigger
passed [0.008s]
sys/audit/administrative:auditon_setclass_success -> 2023-08-20T12:26:33.184526+00:00 - auditd 24628 - - Got audit initialize trigger
passed [0.008s]
sys/audit/administrative:auditon_setcond_failure -> 2023-08-20T12:26:33.205169+00:00 - auditd 24628 - - Got audit initialize trigger
passed [0.007s]
sys/audit/administrative:auditon_setcond_success -> 2023-08-20T12:26:33.222881+00:00 - auditd 24628 - - Got audit initialize trigger
passed [0.007s]
sys/audit/administrative:auditon_setkmask_failure -> 2023-08-20T12:26:33.241670+00:00 - auditd 24628 - - Got audit initialize trigger
passed [0.007s]
sys/audit/administrative:auditon_setkmask_success -> 2023-08-20T12:26:33.264508+00:00 - auditd 24628 - - Got audit initialize trigger
passed [0.008s]
sys/audit/administrative:auditon_setpolicy_failure -> 2023-08-20T12:26:33.286654+00:00 - auditd 24628 - - Got audit initialize trigger
passed [0.008s]
sys/audit/administrative:auditon_setpolicy_success -> 2023-08-20T12:26:33.306929+00:00 - auditd 24628 - - Got audit initialize trigger
passed [0.007s]
sys/audit/administrative:auditon_setqctrl_failure -> 2023-08-20T12:26:33.326699+00:00 - auditd 24628 - - Got audit initialize trigger
passed [0.007s]
sys/audit/administrative:auditon_setqctrl_success -> 2023-08-20T12:26:33.348834+00:00 - auditd 24628 - - Got audit initialize trigger
passed [0.008s]
sys/audit/administrative:auditon_setsmask_failure -> 2023-08-20T12:26:33.369918+00:00 - auditd 24628 - - Got audit initialize trigger
passed [0.007s]
sys/audit/administrative:auditon_setstat_failure -> 2023-08-20T12:26:33.391675+00:00 - auditd 24628 - - Got audit initialize trigger
passed [0.008s]
sys/audit/administrative:auditon_setumask_failure -> 2023-08-20T12:26:33.411268+00:00 - auditd 24628 - - Got audit initialize trigger
passed [0.007s]
sys/audit/administrative:clock_settime_failure -> 2023-08-20T12:26:33.432532+00:00 - auditd 24628 - - Got audit initialize trigger
passed [0.007s]
sys/audit/administrative:clock_settime_success -> 2023-08-20T12:26:33.450763+00:00 - auditd 24628 - - Got audit initialize trigger
passed [0.007s]
sys/audit/administrative:getaudit_addr_failure -> 2023-08-20T12:26:33.468583+00:00 - auditd 24628 - - Got audit initialize trigger
passed [0.007s]
sys/audit/administrative:getaudit_addr_success -> 2023-08-20T12:26:33.488074+00:00 - auditd 24628 - - Got audit initialize trigger
passed [0.007s]
sys/audit/administrative:getaudit_failure -> 2023-08-20T12:26:33.506896+00:00 - auditd 24628 - - Got audit initialize trigger
passed [0.007s]
sys/audit/administrative:getaudit_success -> 2023-08-20T12:26:33.525006+00:00 - auditd 24628 - - Got audit initialize trigger
passed [0.007s]
sys/audit/administrative:getauid_failure -> 2023-08-20T12:26:33.542803+00:00 - auditd 24628 - - Got audit initialize trigger
passed [0.006s]
sys/audit/administrative:getauid_success -> 2023-08-20T12:26:33.560213+00:00 - auditd 24628 - - Got audit initialize trigger
passed [0.006s]
sys/audit/administrative:mount_failure -> 2023-08-20T12:26:33.577840+00:00 - auditd 24628 - - Got audit initialize trigger
passed [0.006s]
sys/audit/administrative:nfs_getfh_failure -> 2023-08-20T12:26:33.594978+00:00 - auditd 24628 - - Got audit initialize trigger
passed [0.006s]
sys/audit/administrative:nfs_getfh_success -> 2023-08-20T12:26:33.613021+00:00 - auditd 24628 - - Got audit initialize trigger
passed [0.007s]
sys/audit/administrative:nmount_failure -> 2023-08-20T12:26:33.630711+00:00 - auditd 24628 - - Got audit initialize trigger
passed [0.007s]
sys/audit/administrative:ntp_adjtime_failure -> 2023-08-20T12:26:33.648955+00:00 - auditd 24628 - - Got audit initialize trigger
passed [0.007s]
sys/audit/administrative:ntp_adjtime_success -> 2023-08-20T12:26:33.667382+00:00 - auditd 24628 - - Got audit initialize trigger
passed [0.007s]
sys/audit/administrative:quotactl_failure -> 2023-08-20T12:26:33.685663+00:00 - auditd 24628 - - Got audit initialize trigger
passed [0.006s]
sys/audit/administrative:reboot_failure -> 2023-08-20T12:26:33.703545+00:00 - auditd 24628 - - Got audit initialize trigger
passed [0.007s]
sys/audit/administrative:setaudit_addr_failure -> 2023-08-20T12:26:33.721483+00:00 - auditd 24628 - - Got audit initialize trigger
passed [0.007s]
sys/audit/administrative:setaudit_addr_success -> 2023-08-20T12:26:33.739526+00:00 - auditd 24628 - - Got audit initialize trigger
passed [0.007s]
sys/audit/administrative:setaudit_failure -> 2023-08-20T12:26:33.758061+00:00 - auditd 24628 - - Got audit initialize trigger
passed [0.007s]
sys/audit/administrative:setaudit_success -> 2023-08-20T12:26:33.776209+00:00 - auditd 24628 - - Got audit initialize trigger
passed [0.007s]
sys/audit/administrative:setauid_failure -> 2023-08-20T12:26:33.794270+00:00 - auditd 24628 - - Got audit initialize trigger
passed [0.007s]
sys/audit/administrative:setauid_success -> 2023-08-20T12:26:33.812406+00:00 - auditd 24628 - - Got audit initialize trigger
passed [0.007s]
sys/audit/administrative:settimeofday_failure -> 2023-08-20T12:26:33.830789+00:00 - auditd 24628 - - Got audit initialize trigger
passed [0.007s]
sys/audit/administrative:settimeofday_success -> 2023-08-20T12:26:33.850533+00:00 - auditd 24628 - - Got audit initialize trigger
passed [0.007s]
sys/audit/administrative:swapoff_failure -> 2023-08-20T12:26:33.869361+00:00 - auditd 24628 - - Got audit initialize trigger
passed [0.008s]
sys/audit/administrative:swapon_failure -> 2023-08-20T12:26:33.888143+00:00 - auditd 24628 - - Got audit initialize trigger
passed [0.007s]
sys/audit/file-attribute-access:access_failure -> 2023-08-20T12:26:33.906180+00:00 - auditd 24628 - - Got audit initialize trigger
passed [0.007s]
sys/audit/file-attribute-access:access_success -> 2023-08-20T12:26:33.928999+00:00 - auditd 24628 - - Got audit initialize trigger
passed [0.008s]
sys/audit/file-attribute-access:eaccess_failure -> 2023-08-20T12:26:33.947639+00:00 - auditd 24628 - - Got audit initialize trigger
passed [0.007s]
sys/audit/file-attribute-access:eaccess_success -> 2023-08-20T12:26:33.966537+00:00 - auditd 24628 - - Got audit initialize trigger
passed [0.008s]
sys/audit/file-attribute-access:extattr_get_fd_failure -> 2023-08-20T12:26:33.986150+00:00 - auditd 24628 - - Got audit initialize trigger
passed [0.008s]
sys/audit/file-attribute-access:extattr_get_fd_success -> 2023-08-20T12:26:34.005227+00:00 - auditd 24628 - - Got audit initialize trigger
passed [0.008s]
sys/audit/file-attribute-access:extattr_get_file_failure -> 2023-08-20T12:26:34.024896+00:00 - auditd 24628 - - Got audit initialize trigger
passed [0.008s]
sys/audit/file-attribute-access:extattr_get_file_success -> 2023-08-20T12:26:34.043358+00:00 - auditd 24628 - - Got audit initialize trigger
passed [0.007s]
sys/audit/file-attribute-access:extattr_get_link_failure -> 2023-08-20T12:26:34.061271+00:00 - auditd 24628 - - Got audit initialize trigger
passed [0.007s]
sys/audit/file-attribute-access:extattr_get_link_success -> 2023-08-20T12:26:34.079399+00:00 - auditd 24628 - - Got audit initialize trigger
passed [0.007s]
sys/audit/file-attribute-access:extattr_list_fd_failure -> 2023-08-20T12:26:34.102442+00:00 - auditd 24628 - - Got audit initialize trigger
passed [0.009s]
sys/audit/file-attribute-access:extattr_list_fd_success -> 2023-08-20T12:26:34.125136+00:00 - auditd 24628 - - Got audit initialize trigger
passed [0.009s]
sys/audit/file-attribute-access:extattr_list_file_failure -> 2023-08-20T12:26:34.146274+00:00 - auditd 24628 - - Got audit initialize trigger
passed [0.008s]
sys/audit/file-attribute-access:extattr_list_file_success -> 2023-08-20T12:26:34.166652+00:00 - auditd 24628 - - Got audit initialize trigger
passed [0.007s]
sys/audit/file-attribute-access:extattr_list_link_failure -> 2023-08-20T12:26:34.188486+00:00 - auditd 24628 - - Got audit initialize trigger
passed [0.009s]
sys/audit/file-attribute-access:extattr_list_link_success -> 2023-08-20T12:26:34.207970+00:00 - auditd 24628 - - Got audit initialize trigger
passed [0.008s]
sys/audit/file-attribute-access:faccessat_failure -> 2023-08-20T12:26:34.226821+00:00 - auditd 24628 - - Got audit initialize trigger
passed [0.007s]
sys/audit/file-attribute-access:faccessat_success -> 2023-08-20T12:26:34.244861+00:00 - auditd 24628 - - Got audit initialize trigger
passed [0.007s]
sys/audit/file-attribute-access:fhopen_failure -> 2023-08-20T12:26:34.263168+00:00 - auditd 24628 - - Got audit initialize trigger
passed [0.007s]
sys/audit/file-attribute-access:fhopen_success -> 2023-08-20T12:26:34.281453+00:00 - auditd 24628 - - Got audit initialize trigger
passed [0.007s]
sys/audit/file-attribute-access:fhstat_failure -> 2023-08-20T12:26:34.300439+00:00 - auditd 24628 - - Got audit initialize trigger
*** /usr/src/contrib/kyua/utils/process/executor.cpp:822: Invariant check failed: PID 24778 already in all_exec_handles; not properly cleaned up or reused too fast
*** Fatal signal 6 received
*** Log file is /.kyua/logs/kyua.20230820-114857.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 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 ./run-kyua.sh
a ./disable-dtrace-tests.sh
a ./run.sh
a ./auto-shutdown
a ./disable-notyet-tests.sh
a ./disable-zfs-tests.sh
+ [ -f /meta/auto-shutdown ]
+ uname -p
+ shutdown -p now
Shutdown NOW!
shutdown: [pid 24782]
+ 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-08-20T12:26:34.425545+00:00 - shutdown 24782 - - power-down by root:
System shutdown time has arrived
2023-08-20T12:26:34.427096+00:00 - auditd 24628 - - auditd_wait_for_events: SIGTERM
2023-08-20T12:26:34.428361+00:00 - auditd 24628 - - Auditing disabled
2023-08-20T12:26:34.429793+00:00 - auditd 24628 - - renamed /var/audit/20230820122632.not_terminated to /var/audit/20230820122632.20230820122634
2023-08-20T12:26:34.432193+00:00 - auditd 24628 - - 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 0xfffff8000ba0ccb0 devfs (devfs, lockmgr) @ /usr/src/sys/kern/vfs_mount.c:2240
2nd 0xfffff8000ba0c5b0 fdescfs (fdescfs, lockmgr) @ /usr/src/sys/kern/vfs_subr.c:3060
lock order devfs -> fdescfs attempted at:
#0 0xffffffff80bc04ce at witness_checkorder+0xbbe
#1 0xffffffff80b1a7b1 at lockmgr_lock_flags+0x181
#2 0xffffffff80c5a8d3 at _vn_lock+0x53
#3 0xffffffff80c4213d at vget_finish+0x4d
#4 0xffffffff82610262 at fdesc_root+0x22
#5 0xffffffff80c431db at vflush+0x4b
#6 0xffffffff82610211 at fdesc_unmount+0x71
#7 0xffffffff80c380f5 at dounmount+0x7b5
#8 0xffffffff80c4491a at vfs_unmountall+0x6a
#9 0xffffffff80c1511c at bufshutdown+0x30c
#10 0xffffffff80b4d203 at kern_reboot+0x703
#11 0xffffffff80b4caa9 at sys_reboot+0x3a9
#12 0xffffffff8104a398 at amd64_syscall+0x138
#13 0xffffffff8101c68b at fast_syscall_common+0xf8
Uptime: 37m40s
acpi0: Powering system off
+ rc=0
+ echo 'bhyve return code = 0'
bhyve return code = 0
+ sudo /usr/sbin/bhyvectl '--vm=testvm-main-amd64-24058' --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 ./disable-dtrace-tests.sh
x ./run.sh
x ./auto-shutdown
x ./disable-notyet-tests.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-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/jenkins13483789984907730124.sh
+ ./freebsd-ci/artifact/post-link.py
Post link: {'job_name': 'FreeBSD-main-amd64-test', 'commit': '64fbda90da1b91d2412a5b970a3996f3cf1c8522', 'branch': 'main', 'target': 'amd64', 'target_arch': 'amd64', 'link_type': 'latest_tested'}
"Link created: main/latest_tested/amd64/amd64 -> ../../64fbda90da1b91d2412a5b970a3996f3cf1c8522/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