FreeBSD-main-amd64-test - Build #23038 - Still Failing

From: <jenkins-admin_at_FreeBSD.org>
Date: Thu, 23 Feb 2023 23:52:55 UTC
FreeBSD-main-amd64-test - Build #23038 (4e696aff69090da046817a6339d01f4675728b95) - Still Failing

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

17a5a290032ef75ed4aa8a2aa68b3a7e08935c1c by emaste:
efibootmgr: add missing break for 'u' case

c9ba91435a01a80632a5b68144d75b38241fc8be by bz:
net80211: ieee80211_swscan_bg_scan() track return variable under lock

0455b90beeddb636b0644c5d47ef80ffb3e4b4c7 by emaste:
tools/git: fix typos in documentation

4e696aff69090da046817a6339d01f4675728b95 by kevans:
iconvlist(3): fix count argument type



The end of the build log:

[...truncated 3.82 MB...]
sys/kern/pipe/big_pipe_test:main  ->  passed  [0.416s]
sys/kern/pipe/pipe_fstat_bug_test:main  ->  passed  [0.005s]
sys/kern/pipe/pipe_ino_test:main  ->  passed  [0.004s]
sys/kern/pipe/pipe_kqueue_test:pipe_kqueue__closed_read_end  ->  passed  [0.004s]
sys/kern/pipe/pipe_kqueue_test:pipe_kqueue__closed_read_end_register_before_close  ->  passed  [0.004s]
sys/kern/pipe/pipe_kqueue_test:pipe_kqueue__closed_write_end  ->  passed  [0.044s]
sys/kern/pipe/pipe_kqueue_test:pipe_kqueue__closed_write_end_register_before_close  ->  passed  [0.051s]
sys/kern/pipe/pipe_kqueue_test:pipe_kqueue__write_end  ->  passed  [0.050s]
sys/kern/pipe/pipe_overcommit1_test:main  ->  passed  [0.054s]
sys/kern/pipe/pipe_overcommit2_test:main  ->  passed  [0.031s]
sys/kern/pipe/pipe_reverse2_test:main  ->  passed  [0.003s]
sys/kern/pipe/pipe_reverse_test:main  ->  passed  [0.004s]
sys/kern/pipe/pipe_wraparound_test:main  ->  passed  [0.004s]
sys/kqueue/kqueue_peek_signal:main  ->  passed  [0.009s]
sys/kqueue/proc1_test:proc1  ->  passed  [2.013s]
sys/kqueue/proc3_test:proc3  ->  passed  [0.005s]
sys/kqueue/sig_test:sig  ->  passed  [12.123s]
sys/kqueue/vnode_test:dir_no_note_link_create_file_in  ->  passed  [0.004s]
sys/kqueue/vnode_test:dir_no_note_link_delete_file_in  ->  passed  [0.004s]
sys/kqueue/vnode_test:dir_no_note_link_mv_dir_within  ->  passed  [0.004s]
sys/kqueue/vnode_test:dir_no_note_link_mv_file_within  ->  passed  [0.004s]
sys/kqueue/vnode_test:dir_note_link_create_dir_in  ->  passed  [0.004s]
sys/kqueue/vnode_test:dir_note_link_delete_dir_in  ->  passed  [0.005s]
sys/kqueue/vnode_test:dir_note_link_mv_dir_in  ->  passed  [0.005s]
sys/kqueue/vnode_test:dir_note_link_mv_dir_out  ->  passed  [0.005s]
sys/kqueue/vnode_test:dir_note_write_create_dir_in  ->  passed  [0.005s]
sys/kqueue/vnode_test:dir_note_write_create_file_in  ->  passed  [0.004s]
sys/kqueue/vnode_test:dir_note_write_delete_dir_in  ->  passed  [0.005s]
sys/kqueue/vnode_test:dir_note_write_delete_file_in  ->  passed  [0.005s]
sys/kqueue/vnode_test:dir_note_write_mv_dir_in  ->  passed  [0.006s]
sys/kqueue/vnode_test:dir_note_write_mv_dir_out  ->  passed  [0.005s]
sys/kqueue/vnode_test:dir_note_write_mv_dir_within  ->  passed  [0.005s]
sys/kqueue/vnode_test:dir_note_write_mv_file_in  ->  passed  [0.004s]
sys/kqueue/vnode_test:dir_note_write_mv_file_out  ->  passed  [0.004s]
sys/kqueue/vnode_test:dir_note_write_mv_file_within  ->  passed  [0.004s]
sys/kqueue/libkqueue/kqueue_test:main  ->  passed  [48.153s]
sys/mac/bsdextended/ugidfw_test:main  ->  passed  [0.007s]
sys/mac/portacl/nobody_test:main  ->  passed  [53.301s]
sys/mac/portacl/root_test:main  ->  passed  [52.391s]
sys/mqueue/mqueue_test:mqtest1  ->  passed  [0.021s]
sys/mqueue/mqueue_test:mqtest2  ->  passed  [0.024s]
sys/mqueue/mqueue_test:mqtest5  ->  passed  [0.031s]
sys/net/if_ovpn/if_ovpn:4in4  ->  skipped: Required program 'openvpn' not found in PATH  [0.003s]
sys/net/if_ovpn/if_ovpn:4in6  ->  skipped: Required program 'openvpn' not found in PATH  [0.003s]
sys/net/if_ovpn/if_ovpn:4mapped  ->  skipped: Required program 'openvpn' not found in PATH  [0.003s]
sys/net/if_ovpn/if_ovpn:6in4  ->  skipped: Required program 'openvpn' not found in PATH  [0.003s]
sys/net/if_ovpn/if_ovpn:6in6  ->  skipped: Required program 'openvpn' not found in PATH  [0.003s]
sys/net/if_ovpn/if_ovpn:chacha  ->  skipped: Required program 'openvpn' not found in PATH  [0.003s]
sys/net/if_ovpn/if_ovpn:explicit_exit  ->  skipped: Required program 'openvpn' not found in PATH  [0.003s]
sys/net/if_ovpn/if_ovpn:gcm_128  ->  skipped: Required program 'openvpn' not found in PATH  [0.003s]
sys/net/if_ovpn/if_ovpn:multi_client  ->  skipped: Required program 'openvpn' not found in PATH  [0.003s]
sys/net/if_ovpn/if_ovpn:ra  ->  skipped: Required program 'openvpn' not found in PATH  [0.003s]
sys/net/if_ovpn/if_ovpn:route_to  ->  skipped: Required program 'openvpn' not found in PATH  [0.003s]
sys/net/if_ovpn/if_ovpn:timeout_client  ->  skipped: Required program 'openvpn' not found in PATH  [0.003s]
sys/net/if_ovpn/if_ovpn_c:tcp  ->  passed  [0.007s]
sys/netgraph/basic:message  ->  passed  [0.018s]
sys/netgraph/basic:node  ->  passed  [0.113s]
sys/netgraph/basic:queuelimit  ->  expected_failure: Queue full (320): 1 checks failed as expected; see output for more details  [0.074s]
sys/netgraph/basic:same_name  ->  failed in ng_con_part2()
passed  [0.007s]
sys/netgraph/basic:send_recv  ->  passed  [0.059s]
sys/netgraph/bridge:basic  ->  passed  [0.451s]
sys/netgraph/bridge:loop  ->  passed  [0.117s]
sys/netgraph/bridge:many_broadcasts  ->  expected_failure: netgraph queue full (191): 1 checks failed as expected; see output for more details  [12.015s]
sys/netgraph/bridge:many_unicasts  ->  expected_failure: response too large: 1 checks failed as expected; see output for more details  [54.793s]
sys/netgraph/bridge:persistence  ->  passed  [0.006s]
sys/netgraph/bridge:uplink_classic  ->  passed  [0.602s]
sys/netgraph/bridge:uplink_private  ->  passed  [0.605s]
sys/netgraph/hub:basic  ->  passed  [0.275s]
sys/netgraph/hub:loop  ->  passed  [0.065s]
sys/netgraph/hub:many_hooks  ->  expected_failure: Implementation limitation (320): 1 checks failed as expected; see output for more details  [18.660s]
sys/netgraph/hub:persistence  ->  passed  [0.006s]
sys/netgraph/ng_macfilter_test:main  ->  skipped: could not find a valid interface  [0.059s]
sys/netgraph/vlan_rotate:basic  ->  passed  [4.453s]
sys/netgraph/vlan_rotate:ethertype  ->  passed  [1.098s]
sys/netgraph/vlan_rotate:minmax  ->  passed  [1.944s]
sys/netgraph/vlan_rotate:reverse  ->  passed  [4.453s]
sys/netgraph/vlan_rotate:typeether  ->  passed  [1.098s]
sys/netinet/arp:arp_add_success  ->  epair0a: Ethernet address: 02:f1:3f:42:dd:0a
epair0b: Ethernet address: 02:f1:3f:42:dd:0b
epair0a: link state changed to UP
epair0b: link state changed to UP
epair0a: link state changed to DOWN
epair0b: link state changed to DOWN
passed  [0.111s]
sys/netinet/arp:arp_del_success  ->  epair0a: Ethernet address: 02:cd:50:dc:19:0a
epair0b: Ethernet address: 02:cd:50:dc:19:0b
epair0a: link state changed to UP
epair0b: link state changed to UP
epair0a: link state changed to DOWN
epair0b: link state changed to DOWN
passed  [1.096s]
sys/netinet/arp:pending_delete_if  ->  epair0a: Ethernet address: 02:72:88:a7:8f:0a
epair0b: Ethernet address: 02:72:88:a7:8f:0b
epair0a: link state changed to UP
epair0b: link state changed to UP
epair0b: link state changed to DOWN
epair0a: link state changed to DOWN
passed  [1.878s]
sys/netinet/carp:basic_v4  ->  bridge0: Ethernet address: 58:9c:fc:10:ff:cb
epair0a: Ethernet address: 02:28:d8:42:63:0a
epair0b: Ethernet address: 02:28:d8:42:63:0b
epair0a: link state changed to UP
epair0b: link state changed to UP
epair1a: Ethernet address: 02:be:c7:66:4f:0a
epair1b: Ethernet address: 02:be:c7:66:4f:0b
epair1a: link state changed to UP
epair1b: link state changed to UP
bridge0: link state changed to UP
epair0a: promiscuous mode enabled
epair1a: promiscuous mode enabled
epair0b: promiscuous mode enabled
carp: 1@epair0b: INIT -> BACKUP (initialization complete)
epair1b: promiscuous mode enabled
carp: 1@epair1b: INIT -> BACKUP (initialization complete)
carp: 1@epair0b: BACKUP -> MASTER (master timed out)
epair1a: promiscuous mode disabled
epair0a: promiscuous mode disabled
bridge0: link state changed to DOWN
epair0a: link state changed to DOWN
carp: 1@epair0b: MASTER -> INIT (hardware interface down)
carp: demoted by 240 to 240 (interface down)
epair0b: link state changed to DOWN
lock order reversal: (sleepable after non-sleepable)
 1st 0xfffff8000697cd08 carp_softc (carp_softc, sleep mutex) @ /usr/src/sys/netinet/ip_carp.c:1993
 2nd 0xffffffff81f95d00 in_multi_sx (in_multi_sx, sx) @ /usr/src/sys/netinet/in_mcast.c:1285
lock order carp_softc -> in_multi_sx attempted at:
#0 0xffffffff80c5ef03 at witness_checkorder+0xbb3
#1 0xffffffff80bf84c3 at _sx_xlock+0x63
#2 0xffffffff80db6b97 at in_leavegroup+0x27
#3 0xffffffff8287b153 at carp_detach+0x233
#4 0xffffffff80db0da8 at in_difaddr_ioctl+0x308
#5 0xffffffff80dafe3a at in_control+0xba
#6 0xffffffff80d17a5d at if_purgeaddrs+0x12d
#7 0xffffffff80d17fe2 at if_detach_internal+0x1c2
#8 0xffffffff80d17c51 at if_detach+0x71
#9 0xffffffff82916586 at epair_clone_destroy+0x66
#10 0xffffffff80d207f9 at if_clone_destroyif_flags+0x69
#11 0xffffffff80d206ff at if_clone_destroy+0xff
#12 0xffffffff80d1c773 at ifioctl+0x8d3
#13 0xffffffff80c64b7e at kern_ioctl+0x1fe
#14 0xffffffff80c64914 at sys_ioctl+0x154
#15 0xffffffff810e0a92 at amd64_syscall+0x6e2
#16 0xffffffff810b36cb at fast_syscall_common+0xf8
carp: demoted by -240 to 0 (vhid removed)
epair0b: promiscuous mode disabled
epair1a: link state changed to DOWN
carp: 1@epair1b: BACKUP -> INIT (hardware interface down)
carp: demoted by 240 to 240 (interface down)
epair1b: link state changed to DOWN
carp: demoted by -240 to 0 (vhid removed)
epair1b: promiscuous mode disabled
passed  [5.555s]
sys/netinet/carp:basic_v6  ->  bridge0: Ethernet address: 58:9c:fc:10:ff:cb
epair0a: Ethernet address: 02:d2:99:53:00:0a
epair0b: Ethernet address: 02:d2:99:53:00:0b
epair0a: link state changed to UP
epair0b: link state changed to UP
epair1a: Ethernet address: 02:01:ff:6f:32:0a
epair1b: Ethernet address: 02:01:ff:6f:32:0b
epair1a: link state changed to UP
epair1b: link state changed to UP
Memory modified after free 0xfffffe00cc0a8000(8184) val=0 @ 0xfffffe00cc0a8698
panic: Most recently used by temp

cpuid = 0
time = 1677196374
KDB: stack backtrace:
db_trace_self_wrapper() at db_trace_self_wrapper+0x2b/frame 0xfffffe00ccd37950
vpanic() at vpanic+0x152/frame 0xfffffe00ccd379a0
panic() at panic+0x43/frame 0xfffffe00ccd37a00
mtrash_dtor() at mtrash_dtor/frame 0xfffffe00ccd37a20
item_ctor() at item_ctor+0x11f/frame 0xfffffe00ccd37a70
malloc() at malloc+0x7f/frame 0xfffffe00ccd37ab0
ipf_state_soft_create() at ipf_state_soft_create+0x20/frame 0xfffffe00ccd37ad0
ipf_create_all() at ipf_create_all+0x5f/frame 0xfffffe00ccd37af0
vnet_ipf_init() at vnet_ipf_init+0x2a/frame 0xfffffe00ccd37b10
vnet_alloc() at vnet_alloc+0x144/frame 0xfffffe00ccd37b40
kern_jail_set() at kern_jail_set+0x1645/frame 0xfffffe00ccd37dd0
sys_jail_set() at sys_jail_set+0x40/frame 0xfffffe00ccd37e00
amd64_syscall() at amd64_syscall+0x6e2/frame 0xfffffe00ccd37f30
fast_syscall_common() at fast_syscall_common+0xf8/frame 0xfffffe00ccd37f30
--- syscall (507, FreeBSD ELF64, jail_set), rip = 0x2d6aa82c69da, rsp = 0x2d6aa4159388, rbp = 0x2d6aa4159470 ---
KDB: enter: panic
[ thread pid 71364 tid 101009 ]
Stopped at      kdb_enter+0x32: movq    $0,0x1293d53(%rip)
db:0:kdb.enter.panic> show pcpu
cpuid        = 0
dynamic pcpu = 0x9c0640
curthread    = 0xfffffe00d167d1e0: pid 71364 tid 101009 critnest 1 "jail"
curpcb       = 0xfffffe00d167d700
fpcurthread  = 0xfffffe00d167d1e0: pid 71364 "jail"
idlethread   = 0xfffffe00112243a0: tid 100003 "idle: cpu0"
self         = 0xffffffff82610000
curpmap      = 0xfffffe00d1699530
tssp         = 0xffffffff82610384
rsp0         = 0xfffffe00ccd38000
kcr3         = 0x800000008d79637c
ucr3         = 0x800000008d791b7c
scr3         = 0x8d791b7c
gs32p        = 0xffffffff82610404
ldt          = 0xffffffff82610444
tss          = 0xffffffff82610434
curvnet      = 0xfffff80003625200
spin locks held:
db:0:kdb.enter.panic>  reset
Uptime: 13m40s
+ rc=0
+ echo 'bhyve return code = 0'
bhyve return code = 0
+ sudo /usr/sbin/bhyvectl '--vm=testvm-main-amd64-23038' --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 ./auto-shutdown
x ./disable-zfs-tests.sh
x ./disable-notyet-tests.sh
x ./run.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-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/jenkins281248788434936622.sh
+ ./freebsd-ci/artifact/post-link.py
Post link: {'job_name': 'FreeBSD-main-amd64-test', 'commit': '4e696aff69090da046817a6339d01f4675728b95', 'branch': 'main', 'target': 'amd64', 'target_arch': 'amd64', 'link_type': 'latest_tested'}
"Link created: main/latest_tested/amd64/amd64 -> ../../4e696aff69090da046817a6339d01f4675728b95/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