Skip site navigation (1)Skip section navigation (2)
Date:      Wed, 27 Dec 2023 08:40:50 +0000 (GMT)
From:      jenkins-admin@FreeBSD.org
To:        rscheff@FreeBSD.org, mav@FreeBSD.org, dev-ci@FreeBSD.org
Cc:        jenkins-admin@FreeBSD.org
Subject:   FreeBSD-main-amd64-test - Build #24583 - Failure
Message-ID:  <1171348304.11430.1703666450609@jenkins.ci.freebsd.org>
In-Reply-To: <1490952954.11426.1703664065974@jenkins.ci.freebsd.org>
References:  <1490952954.11426.1703664065974@jenkins.ci.freebsd.org>

next in thread | previous in thread | raw e-mail | index | archive | help
------=_Part_11429_1212256254.1703666450262
Content-Type: text/plain; charset=UTF-8
Content-Transfer-Encoding: quoted-printable

FreeBSD-main-amd64-test - Build #24583 (7bbac6419d174c98cc6ea969b68fcfe0f9a=
9bab8) - Failure

Build information: https://ci.FreeBSD.org/job/FreeBSD-main-amd64-test/24583=
/
Full change log: https://ci.FreeBSD.org/job/FreeBSD-main-amd64-test/24583/c=
hanges
Full build log: https://ci.FreeBSD.org/job/FreeBSD-main-amd64-test/24583/co=
nsole

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)

a8f80c0c16c7fb38c46ddccd7e1b06dc46c407b1 by mav:
iichid(4): Unify two taskqueue tasks

358453ce9bdd99eb69641b02f2d7e29cedecbe27 by mav:
iichid(4): Switch taskqueue to "fast"

a8b70cf26030d68631200619bd1b0ad35b34b6b8 by rscheff:
netpfil: Use accessor functions and named constants for all tcphdr flags

7bbac6419d174c98cc6ea969b68fcfe0f9a9bab8 by mav:
Schedule fast taskqueue callouts on right CPU.



The end of the build log:

[...truncated 3.94 MB...]
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.444s]
sys/netlink/test_rtnl_ifaddr.py:TestRtNlIfaddrOpsBroadcast::test_del[ifa_lo=
cal-ipv4_prefix]  ->  epair0a: Ethernet address: 02:38:b4:cb:1b:0a
epair0b: Ethernet address: 02:38:b4:cb:1b: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.407s]
sys/netlink/test_rtnl_ifaddr.py:TestRtNlIfaddrOpsBroadcast::test_del[ifa_lo=
cal-ipv6_gu_host]  ->  epair0a: Ethernet address: 02:7c:99:a1:13:0a
epair0b: Ethernet address: 02:7c:99:a1:13: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.426s]
sys/netlink/test_rtnl_ifaddr.py:TestRtNlIfaddrOpsBroadcast::test_del[ifa_lo=
cal-ipv6_gu_prefix]  ->  epair0a: Ethernet address: 02:c4:68:48:06:0a
epair0b: Ethernet address: 02:c4:68:48:06: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.431s]
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.428s]
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.411s]
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.432s]
sys/netlink/test_rtnl_ifaddr.py:TestRtNlIfaddrOpsP2p::test_add_4[dst_outsid=
e_30]  ->  gif0: link state changed to DOWN
lo0: link state changed to UP
passed  [0.444s]
sys/netlink/test_rtnl_ifaddr.py:TestRtNlIfaddrOpsP2p::test_add_4[dst_outsid=
e_32]  ->  gif0: link state changed to DOWN
lo0: link state changed to UP
passed  [0.429s]
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=
.483s]
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=
.482s]
sys/netlink/test_rtnl_ifaddr.py:TestRtNlIfaddrOpsP2p::test_add_6[dst_outsid=
e_128]  ->  gif0: link state changed to DOWN
lo0: link state changed to UP
passed  [0.413s]
sys/netlink/test_rtnl_ifaddr.py:TestRtNlIfaddrOpsP2p::test_add_6[dst_outsid=
e_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=
.462s]
sys/netlink/test_rtnl_ifaddr.py:TestRtNlIfaddrOpsP2p::test_del[ifa_addr=3Da=
ddr,ifa_local=3Daddr-ip6_dst_outside_128]  ->  gif0: link state changed to =
DOWN
lo0: link state changed to UP
passed  [0.432s]
sys/netlink/test_rtnl_ifaddr.py:TestRtNlIfaddrOpsP2p::test_del[ifa_addr=3Da=
ddr,ifa_local=3Daddr-ipv4_dst_inside_30]  ->  gif0: link state changed to D=
OWN
lo0: link state changed to UP
passed  [0.425s]
sys/netlink/test_rtnl_ifaddr.py:TestRtNlIfaddrOpsP2p::test_del[ifa_addr=3Da=
ddr,ifa_local=3Daddr-ipv4_dst_outside_32]  ->  gif0: link state changed to =
DOWN
lo0: link state changed to UP
passed  [0.418s]
sys/netlink/test_rtnl_ifaddr.py:TestRtNlIfaddrOpsP2p::test_del[ifa_addr=3Da=
ddr-ip6_dst_outside_128]  ->  gif0: link state changed to DOWN
lo0: link state changed to UP
passed  [0.401s]
sys/netlink/test_rtnl_ifaddr.py:TestRtNlIfaddrOpsP2p::test_del[ifa_addr=3Da=
ddr-ipv4_dst_inside_30]  ->  gif0: link state changed to DOWN
lo0: link state changed to UP
passed  [0.412s]
sys/netlink/test_rtnl_ifaddr.py:TestRtNlIfaddrOpsP2p::test_del[ifa_addr=3Da=
ddr-ipv4_dst_outside_32]  ->  gif0: link state changed to DOWN
lo0: link state changed to UP
passed  [0.433s]
sys/netlink/test_rtnl_ifaddr.py:TestRtNlIfaddrOpsP2p::test_del[ifa_local=3D=
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_local=3D=
addr-ipv4_dst_inside_30]  ->  gif0: link state changed to DOWN
lo0: link state changed to UP
passed  [0.427s]
sys/netlink/test_rtnl_ifaddr.py:TestRtNlIfaddrOpsP2p::test_del[ifa_local=3D=
addr-ipv4_dst_outside_32]  ->  gif0: link state changed to DOWN
lo0: link state changed to UP
passed  [0.410s]
sys/netlink/test_rtnl_neigh.py:TestRtNlNeigh::test_4_filter_iface  ->  epai=
r0a: Ethernet address: 02:13:ff:4a:2a:0a
epair0b: Ethernet address: 02:13:ff:4a:2a: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.453s]
sys/netlink/test_rtnl_neigh.py:TestRtNlNeigh::test_6_filter_iface  ->  epai=
r0a: Ethernet address: 02:7a:17:df:3b:0a
epair0b: Ethernet address: 02:7a:17:df:3b: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.461s]
sys/netlink/test_rtnl_route.py:TestRtNlRoute::test_add_route4_ll_if_gw  -> =
 epair0a: Ethernet address: 02:4f:3c:ec:a7:0a
epair0b: Ethernet address: 02:4f:3c:ec:a7: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.454s]
sys/netlink/test_rtnl_route.py:TestRtNlRoute::test_add_route6_ll_gw  ->  ep=
air0a: Ethernet address: 02:ac:6e:a4:9c:0a
epair0b: Ethernet address: 02:ac:6e:a4:9c: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.477s]
sys/netlink/test_rtnl_route.py:TestRtNlRoute::test_add_route6_ll_if_gw  -> =
 epair0a: Ethernet address: 02:1c:4d:dd:fe:0a
epair0b: Ethernet address: 02:1c:4d:dd:fe: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.493s]
sys/netlink/test_rtnl_route.py:TestRtNlRoute::test_buffer_override  ->  epa=
ir0a: Ethernet address: 02:f6:f2:54:af:0a
epair0b: Ethernet address: 02:f6:f2:54:af: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.570s]
sys/netlink/test_snl:snl_list_ifaces  ->  passed  [0.004s]
sys/netlink/test_snl:snl_parse_errmsg_capped  ->  skipped: does not work  [=
0.004s]
sys/netlink/test_snl:snl_parse_errmsg_capped_extack  ->  *** /usr/src/contr=
ib/kyua/utils/process/executor.cpp:779: Invariant check failed: PID 24168 a=
lready in all_exec_handles; not properly cleaned up or reused too fast
*** Fatal signal 6 received
*** Log file is /.kyua/logs/kyua.20231227-082023.log
*** Please report this problem to kyua-discuss@googlegroups.com detailing w=
hat 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=3D134
+ 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 ./disable-notyet-tests.sh
a ./auto-shutdown
a ./disable-zfs-tests.sh
a ./run-kyua.sh
+ [ -f /meta/auto-shutdown ]
+ uname -p
+ shutdown -p now
Shutdown NOW!
shutdown: [pid 24175]
+ startmsg .
+ check_startmsgs
+ [ -n yes ]
+ checkyesno rc_startmsgs
+ eval '_value=3D$rc_startmsgs'
+ _value=3DYES
+ debug 'checkyesno: rc_startmsgs is set to YES.'
+ return 0
+ echo .
.
+ _return=3D0
+ umask 0022
+ [ 0 -ne 0 ]
+ return 0
+ _run_rc_postcmd
+ [ -n '' ]
+ return 0
+ return 0
2023-12-27T08:40:42.374223+00:00 - shutdown 24175 - - power-down by root:=
=20

System shutdown time has arrived=07=07
2023-12-27T08:40:42.375532+00:00 - auditd 723 - - auditd_wait_for_events: S=
IGTERM
2023-12-27T08:40:42.376756+00:00 - auditd 723 - - Auditing disabled
2023-12-27T08:40:42.378244+00:00 - auditd 723 - - renamed /var/audit/202312=
27082023.not_terminated to /var/audit/20231227082023.20231227084042
2023-12-27T08:40:42.380375+00:00 - auditd 723 - - Finished
Waiting (max 60 seconds) for system process `vnlru' to stop... done
Waiting (max 60 seconds) for system process `syncer' to stop...=20
Syncing disks, vnodes remaining... 0 0 done
All buffers synced.
lock order reversal:
 1st 0xfffff80009a043f0 devfs (devfs, lockmgr) @ /usr/src/sys/kern/vfs_moun=
t.c:2253
 2nd 0xfffff80009a2acb0 fdescfs (fdescfs, lockmgr) @ /usr/src/sys/kern/vfs_=
subr.c:3294
lock order devfs -> fdescfs attempted at:
#0 0xffffffff80bc4ab3 at witness_checkorder+0xb63
#1 0xffffffff80b1d931 at lockmgr_lock_flags+0x181
#2 0xffffffff80c60be3 at _vn_lock+0x53
#3 0xffffffff80c4817d at vget_finish+0x4d
#4 0xffffffff82610262 at fdesc_root+0x22
#5 0xffffffff80c4920b at vflush+0x4b
#6 0xffffffff82610211 at fdesc_unmount+0x71
#7 0xffffffff80c3dd25 at dounmount+0x7b5
#8 0xffffffff80c4a94a at vfs_unmountall+0x6a
#9 0xffffffff80c1acaf at bufshutdown+0x31f
#10 0xffffffff80b50833 at kern_reboot+0x703
#11 0xffffffff80b500d9 at sys_reboot+0x3a9
#12 0xffffffff81057453 at amd64_syscall+0x153
#13 0xffffffff810293db at fast_syscall_common+0xf8
Uptime: 20m22s
acpi0: Powering system off
+ rc=3D0
+ echo 'bhyve return code =3D 0'
bhyve return code =3D 0
+ sudo /usr/sbin/bhyvectl '--vm=3Dtestvm-main-amd64-24583' --destroy
+ sh -ex freebsd-ci/scripts/test/extract-meta.sh
+ METAOUTDIR=3Dmeta-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 ./disable-notyet-tests.sh
x ./auto-shutdown
x ./disable-zfs-tests.sh
x ./run-kyua.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 direc=
tory
+ report=3Dtest-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/jenkins6777246456850375744.sh
+ ./freebsd-ci/artifact/post-link.py
Post link: {'job_name': 'FreeBSD-main-amd64-test', 'commit': '7bbac6419d174=
c98cc6ea969b68fcfe0f9a9bab8', 'branch': 'main', 'target': 'amd64', 'target_=
arch': 'amd64', 'link_type': 'latest_tested'}
"Link created: main/latest_tested/amd64/amd64 -> ../../7bbac6419d174c98cc6e=
a969b68fcfe0f9a9bab8/amd64/amd64\n"
Recording test results
ERROR: Step =E2=80=98Publish JUnit test result report=E2=80=99 failed: No t=
est 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
------=_Part_11429_1212256254.1703666450262--



Want to link to this message? Use this URL: <https://mail-archive.FreeBSD.org/cgi/mid.cgi?1171348304.11430.1703666450609>