FreeBSD-stable-14-amd64-test - Build #228 - Still Failing

From: <jenkins-admin_at_FreeBSD.org>
Date: Tue, 05 Dec 2023 18:23:34 UTC
FreeBSD-stable-14-amd64-test - Build #228 (9b8515f71bd413520ba7d8e2b92a60deb2c7a528) - Still Failing

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

9b8515f71bd413520ba7d8e2b92a60deb2c7a528 by karels:
ifconfig: add -D option to print driver name for interface



The end of the build log:

[...truncated 4.32 MB...]
bin/pkill/pgrep-f_test:main  ->  passed  [0.221s]
bin/pkill/pgrep-g_test:main  ->  passed  [0.634s]
bin/pkill/pgrep-i_test:main  ->  passed  [0.313s]
bin/pkill/pgrep-j_test:main  ->  passed  [5.633s]
bin/pkill/pgrep-l_test:main  ->  passed  [0.312s]
bin/pkill/pgrep-n_test:main  ->  passed  [0.330s]
bin/pkill/pgrep-o_test:main  ->  passed  [0.334s]
bin/pkill/pgrep-q_test:main  ->  passed  [0.323s]
bin/pkill/pgrep-s_test:main  ->  passed  [0.639s]
bin/pkill/pgrep-t_test:main  ->  passed  [0.321s]
bin/pkill/pgrep-v_test:main  ->  passed  [0.320s]
bin/pkill/pgrep-x_test:main  ->  passed  [0.315s]
bin/pkill/pkill-_f_test:main  ->  passed  [0.318s]
bin/pkill/pkill-_g_test:main  ->  passed  [0.621s]
bin/pkill/pkill-_lf_test:main  ->  passed  [0.665s]
bin/pkill/pkill-_p_test:main  ->  passed  [0.318s]
bin/pkill/pkill-_u_test:main  ->  passed  [0.631s]
bin/pkill/pkill-g_test:main  ->  passed  [0.632s]
bin/pkill/pkill-i_test:main  ->  passed  [0.319s]
bin/pkill/pkill-j_test:main  ->  passed  [36.171s]
bin/pkill/pkill-s_test:main  ->  passed  [0.631s]
bin/pkill/pkill-t_test:main  ->  passed  [0.651s]
bin/pkill/pkill-x_test:main  ->  passed  [0.641s]
bin/date/format_string_test:A_test  ->  passed  [0.023s]
bin/date/format_string_test:B_test  ->  passed  [0.022s]
bin/date/format_string_test:C_test  ->  passed  [0.020s]
bin/date/format_string_test:D_test  ->  passed  [0.022s]
bin/date/format_string_test:F_test  ->  passed  [0.022s]
bin/date/format_string_test:G_test  ->  passed  [0.022s]
bin/date/format_string_test:H_test  ->  passed  [0.023s]
bin/date/format_string_test:I_test  ->  passed  [0.022s]
bin/date/format_string_test:M_test  ->  passed  [0.023s]
bin/date/format_string_test:R_test  ->  passed  [0.023s]
bin/date/format_string_test:S_test  ->  passed  [0.021s]
bin/date/format_string_test:U_test  ->  passed  [0.022s]
bin/date/format_string_test:V_test  ->  passed  [0.021s]
bin/date/format_string_test:W_test  ->  passed  [0.023s]
bin/date/format_string_test:X_test  ->  passed  [0.022s]
bin/date/format_string_test:Y_test  ->  passed  [0.020s]
bin/date/format_string_test:Z_test  ->  passed  [0.021s]
bin/date/format_string_test:a_test  ->  passed  [0.021s]
bin/date/format_string_test:b_test  ->  passed  [0.022s]
bin/date/format_string_test:c_test  ->  passed  [0.022s]
bin/date/format_string_test:d_test  ->  passed  [0.021s]
bin/date/format_string_test:e_test  ->  passed  [0.023s]
bin/date/format_string_test:g_test  ->  passed  [0.022s]
bin/date/format_string_test:h_test  ->  passed  [0.021s]
bin/date/format_string_test:iso8601_date_parity  ->  passed  [0.028s]
bin/date/format_string_test:iso8601_date_test  ->  passed  [0.024s]
bin/date/format_string_test:iso8601_default_parity  ->  passed  [0.025s]
bin/date/format_string_test:iso8601_default_test  ->  passed  [0.023s]
bin/date/format_string_test:iso8601_hours_parity  ->  passed  [0.022s]
bin/date/format_string_test:iso8601_hours_test  ->  passed  [0.023s]
bin/date/format_string_test:iso8601_minutes_parity  ->  passed  [0.025s]
bin/date/format_string_test:iso8601_minutes_test  ->  passed  [0.022s]
bin/date/format_string_test:iso8601_seconds_parity  ->  passed  [0.025s]
bin/date/format_string_test:iso8601_seconds_test  ->  passed  [0.024s]
bin/date/format_string_test:j_test  ->  passed  [0.024s]
bin/date/format_string_test:k_test  ->  passed  [0.022s]
bin/date/format_string_test:l_test  ->  passed  [0.022s]
bin/date/format_string_test:m_test  ->  passed  [0.021s]
bin/date/format_string_test:p_test  ->  passed  [0.022s]
bin/date/format_string_test:percent_test  ->  passed  [0.022s]
bin/date/format_string_test:plus_test  ->  passed  [0.023s]
bin/date/format_string_test:r_test  ->  passed  [0.023s]
bin/date/format_string_test:s_test  ->  passed  [0.022s]
bin/date/format_string_test:u_test  ->  passed  [0.023s]
bin/date/format_string_test:v_test  ->  passed  [0.021s]
bin/date/format_string_test:w_test  ->  passed  [0.020s]
bin/date/format_string_test:x_test  ->  passed  [0.021s]
bin/date/format_string_test:y_test  ->  passed  [0.021s]
bin/date/format_string_test:z_test  ->  passed  [0.020s]
bin/dd/dd2_test:max_seek  ->  skipped: UFS's maximum file size is too small  [0.012s]
bin/dd/dd2_test:seek_overflow  ->  passed  [0.021s]
bin/dd/dd2_test:sigint_open  ->  passed  [3.054s]
bin/dd/dd2_test:sigint_read  ->  passed  [3.094s]
bin/dd/dd_test:io  ->  passed  [0.038s]
bin/dd/dd_test:length  ->  passed  [0.018s]
bin/dd/dd_test:seek  ->  passed  [0.031s]
usr.bin/renice/renice_test:renice_abs_pgid  ->  passed  [0.026s]
usr.bin/renice/renice_test:renice_abs_pid  ->  passed  [0.022s]
usr.bin/renice/renice_test:renice_abs_user  ->  passed  [0.025s]
usr.bin/renice/renice_test:renice_delim  ->  passed  [0.069s]
usr.bin/renice/renice_test:renice_incr_noarg  ->  passed  [0.015s]
usr.bin/renice/renice_test:renice_rel_pgid  ->  passed  [0.027s]
usr.bin/renice/renice_test:renice_rel_pid  ->  passed  [0.029s]
usr.bin/renice/renice_test:renice_rel_user  ->  passed  [0.032s]
usr.bin/tftp/tftp_test:tftp_get_big  ->  passed  [2.914s]
usr.bin/tftp/tftp_test:tftp_get_host  ->  passed  [0.037s]
usr.bin/tftp/tftp_test:tftp_get_ipv4  ->  passed  [0.037s]
usr.bin/tftp/tftp_test:tftp_get_ipv6  ->  passed  [0.037s]
usr.bin/tftp/tftp_test:tftp_get_more  ->  passed  [0.227s]
usr.bin/tftp/tftp_test:tftp_get_multi_host  ->  passed  [0.055s]
usr.bin/tftp/tftp_test:tftp_get_one  ->  passed  [0.031s]
usr.bin/tftp/tftp_test:tftp_get_two  ->  passed  [0.037s]
usr.bin/tftp/tftp_test:tftp_put_big  ->  passed  [2.307s]
usr.bin/tftp/tftp_test:tftp_put_host  ->  passed  [0.033s]
usr.bin/tftp/tftp_test:tftp_put_ipv4  ->  passed  [0.033s]
usr.bin/tftp/tftp_test:tftp_put_ipv6  ->  passed  [0.034s]
usr.bin/tftp/tftp_test:tftp_put_more  ->  passed  [0.228s]
usr.bin/tftp/tftp_test:tftp_put_multi_host  ->  passed  [0.060s]
usr.bin/tftp/tftp_test:tftp_put_one  ->  passed  [0.041s]
usr.bin/tftp/tftp_test:tftp_put_two  ->  passed  [0.040s]
usr.bin/tftp/tftp_test:tftp_url_host  ->  passed  [0.042s]
usr.bin/tftp/tftp_test:tftp_url_ipv4  ->  passed  [0.041s]
usr.bin/tftp/tftp_test:tftp_url_ipv6  ->  expected_failure: tftp does not support bracketed IPv6 literals in URLs: atf-check failed; see the output of the test for details  [0.035s]
sys/acl/00:main  ->  passed  [0.289s]
sys/acl/01:main  ->  passed  [0.632s]
sys/acl/02:main  ->  passed  [0.609s]
sys/acl/03:main  ->  passed  [0.540s]
sys/acl/04:main  ->  passed  [0.165s]
sys/aio/lio_test:lio_listio_eagain_kevent  ->  passed  [1.008s]
sys/aio/lio_test:lio_listio_empty_nowait  ->  passed  [0.005s]
sys/aio/lio_test:lio_listio_empty_nowait_kevent  ->  expected_failure: Bug 251515 - lio_listio(2) never sends kevent if nent==0  [10.009s]
sys/aio/lio_test:lio_listio_empty_nowait_signal  ->  passed  [0.005s]
sys/aio/lio_test:lio_listio_empty_nowait_thread  ->  passed  [0.004s]
sys/aio/lio_test:lio_listio_empty_wait  ->  passed  [0.004s]
sys/aio/lio_test:lio_listio_invalid_opcode  ->  passed  [0.003s]
sys/aio/lio_test:lio_listio_opcodes  ->  passed  [0.004s]
sys/audit/administrative:acct_failure  ->  2023-12-05T18:23:25.997048+00:00 - auditd 711 - - Got audit initialize trigger
passed  [0.006s]
sys/audit/administrative:acct_success  ->  Accounting enabled
2023-12-05T18:23:26.011570+00:00 - auditd 711 - - Got audit initialize trigger
Accounting disabled
passed  [0.006s]
sys/audit/administrative:adjtime_failure  ->  2023-12-05T18:23:26.040911+00:00 - auditd 711 - - Got audit initialize trigger
passed  [0.005s]
sys/audit/administrative:adjtime_success  ->  2023-12-05T18:23:26.055236+00:00 - auditd 711 - - Got audit initialize trigger
passed  [0.006s]
sys/audit/administrative:auditctl_failure  ->  2023-12-05T18:23:26.070359+00:00 - auditd 711 - - Got audit initialize trigger
passed  [0.006s]
sys/audit/administrative:auditctl_success  ->  2023-12-05T18:23:26.085710+00:00 - auditd 711 - - Got audit initialize trigger
2023-12-05T18:23:26.107746+00:00 - auditd 711 - - Got close and die trigger
2023-12-05T18:23:26.108558+00:00 - auditd 711 - - Auditing disabled
2023-12-05T18:23:26.109548+00:00 - auditd 711 - - renamed /var/audit/20231205174255.not_terminated to /var/audit/20231205174255.20231205182326
2023-12-05T18:23:26.109991+00:00 - auditd 711 - - Finished
2023-12-05T18:23:26.110180+00:00 - auditd 711 - - auditd exiting.
2023-12-05T18:23:26.126129+00:00 - auditd 41072 - - starting...
2023-12-05T18:23:26.126949+00:00 - auditd 41073 - - Auditing disabled
2023-12-05T18:23:26.127396+00:00 - auditd 41073 - - Configured trail files distribution.
2023-12-05T18:23:26.128064+00:00 - auditd 41073 - - Auditing enabled
2023-12-05T18:23:26.128877+00:00 - auditd 41073 - - New audit file is /var/audit/20231205182326.not_terminated
passed  [0.006s]
sys/audit/administrative:auditon_default_failure  ->  2023-12-05T18:23:26.131612+00:00 - auditd 41073 - - Registered 677 event to class mappings.
2023-12-05T18:23:26.131744+00:00 - auditd 41073 - - Registered non-attributable event mask.
2023-12-05T18:23:26.131887+00:00 - auditd 41073 - - Set audit policy in kernel.
2023-12-05T18:23:26.132022+00:00 - auditd 41073 - - Set audit trail size in kernel.
2023-12-05T18:23:26.132164+00:00 - auditd 41073 - - Set audit trail queue in kernel.
2023-12-05T18:23:26.132297+00:00 - auditd 41073 - - Set audit trail min free percent in kernel.
2023-12-05T18:23:26.132425+00:00 - auditd 41073 - - audit_control(5) may be missing 'host:' field
2023-12-05T18:23:26.132549+00:00 - auditd 41073 - - Audit controls init successful
*** /usr/src/contrib/kyua/utils/process/executor.cpp:779: Invariant check failed: PID 41074 already in all_exec_handles; not properly cleaned up or reused too fast
*** Fatal signal 6 received
*** Log file is /.kyua/logs/kyua.20231205-174255.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-05T18:23:26.145127+00:00 - auditd 41073 - - Got audit initialize trigger
pid 786 (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-notyet-tests.sh
a ./disable-zfs-tests.sh
a ./run-kyua.sh
a ./run.sh
a ./disable-dtrace-tests.sh
+ [ -f /meta/auto-shutdown ]
+ uname -p
+ shutdown -p now
Shutdown NOW!
shutdown: [pid 41078]
+ 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-05T18:23:26.233768+00:00 - shutdown 41078 - - power-down by root: 

System shutdown time has arrived
2023-12-05T18:23:26.235053+00:00 - auditd 41073 - - auditd_wait_for_events: SIGTERM
2023-12-05T18:23:26.236426+00:00 - auditd 41073 - - Auditing disabled
2023-12-05T18:23:26.237686+00:00 - auditd 41073 - - renamed /var/audit/20231205182326.not_terminated to /var/audit/20231205182326.20231205182326
2023-12-05T18:23:26.239672+00:00 - auditd 41073 - - 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: 40m34s
acpi0: Powering system off
+ rc=0
+ echo 'bhyve return code = 0'
bhyve return code = 0
+ sudo /usr/sbin/bhyvectl '--vm=testvm-14-amd64-228' --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-notyet-tests.sh
x ./disable-zfs-tests.sh
x ./run-kyua.sh
x ./run.sh
x ./disable-dtrace-tests.sh
+ rm -f 'test-report.*'
+ 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/jenkins17694633378651756580.sh
+ ./freebsd-ci/artifact/post-link.py
Post link: {'job_name': 'FreeBSD-stable-14-amd64-test', 'commit': '9b8515f71bd413520ba7d8e2b92a60deb2c7a528', 'branch': 'stable-14', 'target': 'amd64', 'target_arch': 'amd64', 'link_type': 'latest_tested'}
"Link created: stable-14/latest_tested/amd64/amd64 -> ../../9b8515f71bd413520ba7d8e2b92a60deb2c7a528/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