FreeBSD-main-amd64-test - Build #24492 - Failure

From: <jenkins-admin_at_FreeBSD.org>
Date: Thu, 07 Dec 2023 18:04:14 UTC
FreeBSD-main-amd64-test - Build #24492 (9276ad23b872eddc42e05304acb10bf5421b043c) - Failure

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

a95cd6e4870b79178860e03366c4327e533ecf1e by rscheff:
siftr: refactor batch log processing

25f37779bdeba6856f92d0bc94f74582566fcb0f by osa:
bsd-family-tree: add FreeBSD 14

9276ad23b872eddc42e05304acb10bf5421b043c by rscheff:
tcp: shift PRR sending cadence slightly left



The end of the build log:

[...truncated 4.31 MB...]
lo0: link state changed to UP
epair0a: link state changed to DOWN
epair0b: link state changed to DOWN
passed  [0.444s]
sys/netlink/test_rtnl_ifaddr.py:TestRtNlIfaddrOpsBroadcast::test_del[ifa_local-ipv4_host]  ->  epair0a: Ethernet address: 02:ad:86:70:37:0a
epair0b: Ethernet address: 02:ad:86:70:37:0b
epair0a: link state changed to UP
epair0b: link state changed to UP
lo0: link state changed to UP
epair0a: link state changed to DOWN
epair0b: link state changed to DOWN
passed  [0.424s]
sys/netlink/test_rtnl_ifaddr.py:TestRtNlIfaddrOpsBroadcast::test_del[ifa_local-ipv4_prefix]  ->  epair0a: Ethernet address: 02:8f:a5:3e:5d:0a
epair0b: Ethernet address: 02:8f:a5:3e:5d:0b
epair0a: link state changed to UP
epair0b: link state changed to UP
lo0: link state changed to UP
epair0a: link state changed to DOWN
epair0b: link state changed to DOWN
passed  [0.408s]
sys/netlink/test_rtnl_ifaddr.py:TestRtNlIfaddrOpsBroadcast::test_del[ifa_local-ipv6_gu_host]  ->  epair0a: Ethernet address: 02:6f:ce:8c:5b:0a
epair0b: Ethernet address: 02:6f:ce:8c:5b:0b
epair0a: link state changed to UP
epair0b: link state changed to UP
lo0: link state changed to UP
epair0a: link state changed to DOWN
epair0b: link state changed to DOWN
passed  [0.441s]
sys/netlink/test_rtnl_ifaddr.py:TestRtNlIfaddrOpsBroadcast::test_del[ifa_local-ipv6_gu_prefix]  ->  epair0a: Ethernet address: 02:39:c1:e2:94:0a
epair0b: Ethernet address: 02:39:c1:e2:94:0b
epair0a: link state changed to UP
epair0b: link state changed to UP
lo0: link state changed to UP
epair0a: link state changed to DOWN
epair0b: link state changed to DOWN
passed  [0.421s]
sys/netlink/test_rtnl_ifaddr.py:TestRtNlIfaddrOpsP2p::test_add_4[dst_inside_24]  ->  gif0: link state changed to DOWN
lo0: link state changed to UP
passed  [0.415s]
sys/netlink/test_rtnl_ifaddr.py:TestRtNlIfaddrOpsP2p::test_add_4[dst_inside_30]  ->  gif0: link state changed to DOWN
lo0: link state changed to UP
passed  [0.397s]
sys/netlink/test_rtnl_ifaddr.py:TestRtNlIfaddrOpsP2p::test_add_4[dst_inside_31]  ->  gif0: link state changed to DOWN
lo0: link state changed to UP
passed  [0.386s]
sys/netlink/test_rtnl_ifaddr.py:TestRtNlIfaddrOpsP2p::test_add_4[dst_outside_30]  ->  gif0: link state changed to DOWN
lo0: link state changed to UP
passed  [0.383s]
sys/netlink/test_rtnl_ifaddr.py:TestRtNlIfaddrOpsP2p::test_add_4[dst_outside_32]  ->  gif0: link state changed to DOWN
lo0: link state changed to UP
passed  [0.423s]
sys/netlink/test_rtnl_ifaddr.py:TestRtNlIfaddrOpsP2p::test_add_6[dst_inside_127]  ->  gif0: link state changed to DOWN
lo0: link state changed to UP
skipped: /usr/tests/sys/netlink/test_rtnl_ifaddr.py:592: AssertionError  [0.459s]
sys/netlink/test_rtnl_ifaddr.py:TestRtNlIfaddrOpsP2p::test_add_6[dst_inside_64]  ->  gif0: link state changed to DOWN
lo0: link state changed to UP
skipped: /usr/tests/sys/netlink/test_rtnl_ifaddr.py:592: AssertionError  [0.468s]
sys/netlink/test_rtnl_ifaddr.py:TestRtNlIfaddrOpsP2p::test_add_6[dst_outside_128]  ->  gif0: link state changed to DOWN
lo0: link state changed to UP
passed  [0.403s]
sys/netlink/test_rtnl_ifaddr.py:TestRtNlIfaddrOpsP2p::test_add_6[dst_outside_64]  ->  gif0: link state changed to DOWN
lo0: link state changed to UP
skipped: /usr/tests/sys/netlink/test_rtnl_ifaddr.py:592: AssertionError  [0.446s]
sys/netlink/test_rtnl_ifaddr.py:TestRtNlIfaddrOpsP2p::test_del[ifa_addr=addr,ifa_local=addr-ip6_dst_outside_128]  ->  gif0: link state changed to DOWN
lo0: link state changed to UP
passed  [0.415s]
sys/netlink/test_rtnl_ifaddr.py:TestRtNlIfaddrOpsP2p::test_del[ifa_addr=addr,ifa_local=addr-ipv4_dst_inside_30]  ->  gif0: link state changed to DOWN
lo0: link state changed to UP
passed  [0.405s]
sys/netlink/test_rtnl_ifaddr.py:TestRtNlIfaddrOpsP2p::test_del[ifa_addr=addr,ifa_local=addr-ipv4_dst_outside_32]  ->  gif0: link state changed to DOWN
lo0: link state changed to UP
passed  [0.408s]
sys/netlink/test_rtnl_ifaddr.py:TestRtNlIfaddrOpsP2p::test_del[ifa_addr=addr-ip6_dst_outside_128]  ->  gif0: link state changed to DOWN
lo0: link state changed to UP
passed  [0.423s]
sys/netlink/test_rtnl_ifaddr.py:TestRtNlIfaddrOpsP2p::test_del[ifa_addr=addr-ipv4_dst_inside_30]  ->  gif0: link state changed to DOWN
lo0: link state changed to UP
passed  [0.390s]
sys/netlink/test_rtnl_ifaddr.py:TestRtNlIfaddrOpsP2p::test_del[ifa_addr=addr-ipv4_dst_outside_32]  ->  gif0: link state changed to DOWN
lo0: link state changed to UP
passed  [0.393s]
sys/netlink/test_rtnl_ifaddr.py:TestRtNlIfaddrOpsP2p::test_del[ifa_local=addr-ip6_dst_outside_128]  ->  gif0: link state changed to DOWN
lo0: link state changed to UP
passed  [0.386s]
sys/netlink/test_rtnl_ifaddr.py:TestRtNlIfaddrOpsP2p::test_del[ifa_local=addr-ipv4_dst_inside_30]  ->  gif0: link state changed to DOWN
lo0: link state changed to UP
passed  [0.411s]
sys/netlink/test_rtnl_ifaddr.py:TestRtNlIfaddrOpsP2p::test_del[ifa_local=addr-ipv4_dst_outside_32]  ->  gif0: link state changed to DOWN
lo0: link state changed to UP
passed  [0.399s]
sys/netlink/test_rtnl_neigh.py:TestRtNlNeigh::test_4_filter_iface  ->  epair0a: Ethernet address: 02:c4:2a:73:f7:0a
epair0b: Ethernet address: 02:c4:2a:73:f7:0b
epair0a: link state changed to UP
epair0b: link state changed to UP
lo0: link state changed to UP
epair0a: link state changed to DOWN
epair0b: link state changed to DOWN
passed  [0.409s]
sys/netlink/test_rtnl_neigh.py:TestRtNlNeigh::test_6_filter_iface  ->  epair0a: Ethernet address: 02:ad:7f:3e:11:0a
epair0b: Ethernet address: 02:ad:7f:3e:11:0b
epair0a: link state changed to UP
epair0b: link state changed to UP
lo0: link state changed to UP
epair0a: link state changed to DOWN
epair0b: link state changed to DOWN
passed  [0.419s]
sys/netlink/test_rtnl_route.py:TestRtNlRoute::test_add_route4_ll_if_gw  ->  epair0a: Ethernet address: 02:93:c3:21:10:0a
epair0b: Ethernet address: 02:93:c3:21:10:0b
epair0a: link state changed to UP
epair0b: link state changed to UP
lo0: link state changed to UP
epair0a: link state changed to DOWN
epair0b: link state changed to DOWN
passed  [0.476s]
sys/netlink/test_rtnl_route.py:TestRtNlRoute::test_add_route6_ll_gw  ->  epair0a: Ethernet address: 02:d7:1b:c1:59:0a
epair0b: Ethernet address: 02:d7:1b:c1:59:0b
epair0a: link state changed to UP
epair0b: link state changed to UP
lo0: link state changed to UP
epair0a: link state changed to DOWN
epair0b: link state changed to DOWN
passed  [0.482s]
sys/netlink/test_rtnl_route.py:TestRtNlRoute::test_add_route6_ll_if_gw  ->  epair0a: Ethernet address: 02:ef:15:4e:c7:0a
epair0b: Ethernet address: 02:ef:15:4e:c7:0b
epair0a: link state changed to UP
epair0b: link state changed to UP
lo0: link state changed to UP
epair0a: link state changed to DOWN
epair0b: link state changed to DOWN
passed  [0.455s]
sys/netlink/test_rtnl_route.py:TestRtNlRoute::test_buffer_override  ->  epair0a: Ethernet address: 02:fa:0c:8f:39:0a
epair0b: Ethernet address: 02:fa:0c:8f:39:0b
epair0a: link state changed to UP
epair0b: link state changed to UP
lo0: link state changed to UP
*** /usr/src/contrib/kyua/utils/process/executor.cpp:822: Invariant check failed: PID 40187 already in all_exec_handles; not properly cleaned up or reused too fast
*** Fatal signal 6 received
*** Log file is /.kyua/logs/kyua.20231207-172048.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 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-dtrace-tests.sh
a ./run.sh
a ./run-kyua.sh
a ./auto-shutdown
a ./disable-zfs-tests.sh
a ./disable-notyet-tests.sh
+ [ -f /meta/auto-shutdown ]
+ uname -p
+ shutdown -p now
Shutdown NOW!
shutdown: [pid 40193]
+ 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-07T18:04:05.938117+00:00 - shutdown 40193 - - power-down by root: 

System shutdown time has arrived
Waiting (max 60 seconds) for system process `vnlru' to stop... done
Waiting (max 60 seconds) for system process `syncer' to stop... epair0a: link state changed to DOWN
epair0b: link state changed to DOWN

Syncing disks, vnodes remaining... 0 0 done
All buffers synced.
lock order reversal:
 1st 0xfffff80009a23230 devfs (devfs, lockmgr) @ /usr/src/sys/kern/vfs_mount.c:2253
 2nd 0xfffff80009a2aaf0 fdescfs (fdescfs, lockmgr) @ /usr/src/sys/kern/vfs_subr.c:3294
lock order devfs -> fdescfs attempted at:
#0 0xffffffff80bc4bde at witness_checkorder+0xbbe
#1 0xffffffff80b1e001 at lockmgr_lock_flags+0x181
#2 0xffffffff80c60c33 at _vn_lock+0x53
#3 0xffffffff80c481fd at vget_finish+0x4d
#4 0xffffffff82610262 at fdesc_root+0x22
#5 0xffffffff80c4929b at vflush+0x4b
#6 0xffffffff82610211 at fdesc_unmount+0x71
#7 0xffffffff80c3dda5 at dounmount+0x7b5
#8 0xffffffff80c4a9da at vfs_unmountall+0x6a
#9 0xffffffff80c1adbc at bufshutdown+0x30c
#10 0xffffffff80b50ed3 at kern_reboot+0x703
#11 0xffffffff80b50779 at sys_reboot+0x3a9
#12 0xffffffff81055d9b at amd64_syscall+0x84b
#13 0xffffffff810277db at fast_syscall_common+0xf8
pid 520 (devd), jid 0, uid 0: exited on signal 11 (no core dump - other error)
Uptime: 43m22s
acpi0: Powering system off
+ rc=0
+ echo 'bhyve return code = 0'
bhyve return code = 0
+ sudo /usr/sbin/bhyvectl '--vm=testvm-main-amd64-24492' --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-dtrace-tests.sh
x ./run.sh
x ./run-kyua.sh
x ./auto-shutdown
x ./disable-zfs-tests.sh
x ./disable-notyet-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/jenkins14120128359909091164.sh
+ ./freebsd-ci/artifact/post-link.py
Post link: {'job_name': 'FreeBSD-main-amd64-test', 'commit': '9276ad23b872eddc42e05304acb10bf5421b043c', 'branch': 'main', 'target': 'amd64', 'target_arch': 'amd64', 'link_type': 'latest_tested'}
"Link created: main/latest_tested/amd64/amd64 -> ../../9276ad23b872eddc42e05304acb10bf5421b043c/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