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

From: <jenkins-admin_at_FreeBSD.org>
Date: Mon, 06 Feb 2023 19:16:37 UTC
FreeBSD-main-amd64-test - Build #22932 (9c067b844f85a224f0416e6eb46ba3ef82aec5c4) - Failure

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

07db1f36848c008efb7ab6b37e199212560833ae by dchagin:
linux(4): Attach netlink on i386.

cc6e8949daf0c6167d0050d7d85fc8c1426dd6dc by des:
tarfs: Fix typo in man page.

c9ff56ce2d4126eac79342eff2facafbbbd3f39c by des:
tarfs: Terminate dirents before copying them out.

a8fc2fe3af3d456dd2bc19429a8c55648ad875af by des:
tarfs: Remove unnecessary code.

fe1371e8f3d7336748d291a7360b2aacce943fb1 by emaste:
ssh: fix double-free caused by compat_kex_proposal()

94e21add45344f0669f910ea77db499e8c892c90 by emaste:
ssh: fix bug in PermitRemoteOpen which caused it to ignore...

9c067b844f85a224f0416e6eb46ba3ef82aec5c4 by ambrisko:
enic: Cisco VIC driver



The end of the build log:

[...truncated 4.13 MB...]
usr.sbin/rpcbind/addrmerge_test:addrmerge_singlehomed  ->  passed  [0.005s]
usr.sbin/rpcbind/addrmerge_test:addrmerge_singlehomed6  ->  passed  [0.005s]
usr.sbin/fstyp/fstyp_test:befs  ->  passed  [0.040s]
usr.sbin/fstyp/fstyp_test:cd9660  ->  passed  [0.044s]
usr.sbin/fstyp/fstyp_test:cd9660_label  ->  passed  [0.044s]
usr.sbin/fstyp/fstyp_test:dir  ->  passed  [0.029s]
usr.sbin/fstyp/fstyp_test:empty  ->  passed  [0.032s]
usr.sbin/fstyp/fstyp_test:exfat  ->  passed  [0.283s]
usr.sbin/fstyp/fstyp_test:exfat_label  ->  passed  [0.288s]
usr.sbin/fstyp/fstyp_test:ext2  ->  passed  [0.041s]
usr.sbin/fstyp/fstyp_test:ext3  ->  passed  [0.040s]
usr.sbin/fstyp/fstyp_test:ext4  ->  passed  [0.041s]
usr.sbin/fstyp/fstyp_test:ext4_label  ->  passed  [0.034s]
usr.sbin/fstyp/fstyp_test:fat12  ->  passed  [0.046s]
usr.sbin/fstyp/fstyp_test:fat16  ->  passed  [0.042s]
usr.sbin/fstyp/fstyp_test:fat32  ->  passed  [0.046s]
usr.sbin/fstyp/fstyp_test:fat32_label  ->  passed  [0.045s]
usr.sbin/fstyp/fstyp_test:ntfs  ->  passed  [0.052s]
usr.sbin/fstyp/fstyp_test:ntfs_with_label  ->  passed  [0.051s]
usr.sbin/fstyp/fstyp_test:ufs1  ->  passed  [0.045s]
usr.sbin/fstyp/fstyp_test:ufs2  ->  passed  [0.045s]
usr.sbin/fstyp/fstyp_test:ufs2_label  ->  passed  [0.037s]
usr.sbin/fstyp/fstyp_test:ufs_on_device  ->  passed  [0.053s]
usr.sbin/fstyp/fstyp_test:zeros  ->  passed  [0.030s]
usr.sbin/daemon/daemon_test:both_pidfile  ->  passed  [0.050s]
usr.sbin/daemon/daemon_test:chdir  ->  passed  [0.034s]
usr.sbin/daemon/daemon_test:child_pidfile  ->  passed  [0.036s]
usr.sbin/daemon/daemon_test:child_pidfile_lock  ->  passed  [0.030s]
usr.sbin/daemon/daemon_test:newsyslog  ->  passed  [0.461s]
usr.sbin/daemon/daemon_test:output_file  ->  passed  [0.026s]
usr.sbin/daemon/daemon_test:restart_child  ->  passed  [1.110s]
usr.sbin/daemon/daemon_test:supervisor_pidfile  ->  passed  [0.030s]
usr.sbin/daemon/daemon_test:supervisor_pidfile_lock  ->  passed  [0.025s]
usr.sbin/daemon/daemon_test:title  ->  passed  [0.030s]
usr.sbin/daemon/daemon_test:user  ->  passed  [0.032s]
usr.sbin/nmtree/nmtree_test:mtree_check  ->  passed  [0.025s]
usr.sbin/nmtree/nmtree_test:mtree_convert_C  ->  passed  [0.017s]
usr.sbin/nmtree/nmtree_test:mtree_convert_C_S  ->  passed  [0.017s]
usr.sbin/nmtree/nmtree_test:mtree_convert_D  ->  passed  [0.017s]
usr.sbin/nmtree/nmtree_test:mtree_convert_D_S  ->  passed  [0.017s]
usr.sbin/nmtree/nmtree_test:mtree_create  ->  passed  [0.031s]
usr.sbin/nmtree/nmtree_test:mtree_ignore  ->  passed  [0.037s]
usr.sbin/nmtree/nmtree_test:mtree_merge  ->  passed  [0.021s]
usr.sbin/nmtree/nmtree_test:mtree_nonemptydir  ->  passed  [0.025s]
usr.sbin/nmtree/nmtree_test:mtree_specspec_type  ->  passed  [0.030s]
usr.sbin/nmtree/nmtree_test:netbsd6_check  ->  passed  [0.025s]
usr.sbin/nmtree/nmtree_test:netbsd6_convert_C  ->  passed  [0.022s]
usr.sbin/nmtree/nmtree_test:netbsd6_convert_C_S  ->  passed  [0.017s]
usr.sbin/nmtree/nmtree_test:netbsd6_convert_D  ->  passed  [0.017s]
usr.sbin/nmtree/nmtree_test:netbsd6_convert_D_S  ->  passed  [0.017s]
usr.sbin/nmtree/nmtree_test:netbsd6_create  ->  passed  [0.026s]
usr.sbin/nmtree/nmtree_test:netbsd6_ignore  ->  passed  [0.031s]
usr.sbin/nmtree/nmtree_test:netbsd6_merge  ->  passed  [0.020s]
usr.sbin/nmtree/nmtree_test:netbsd6_nonemptydir  ->  passed  [0.025s]
usr.sbin/sa/legacy_test:main  ->  passed  [0.079s]
usr.sbin/pw/pw_config_test:generate_config  ->  passed  [0.026s]
usr.sbin/pw/pw_config_test:modify_config_uid_gid_boundaries  ->  passed  [0.025s]
usr.sbin/pw/pw_etcdir_test:etcdir_must_exist  ->  passed  [0.019s]
usr.sbin/pw/pw_groupadd_test:group_add_already_exists  ->  passed  [0.029s]
usr.sbin/pw/pw_groupadd_test:group_add_gid_too_large  ->  passed  [0.022s]
usr.sbin/pw/pw_groupdel_test:group_do_not_delete_wheel_if_group_unknown  ->  passed  [0.037s]
usr.sbin/pw/pw_groupmod_test:do_not_duplicate_group_on_gid_change  ->  passed  [0.037s]
usr.sbin/pw/pw_groupmod_test:groupmod_bug_193704  ->  passed  [0.037s]
usr.sbin/pw/pw_groupmod_test:groupmod_invalid_user  ->  passed  [0.033s]
usr.sbin/pw/pw_groupmod_test:groupmod_members  ->  passed  [0.113s]
usr.sbin/pw/pw_groupmod_test:groupmod_rename  ->  passed  [0.034s]
usr.sbin/pw/pw_groupmod_test:groupmod_user  ->  passed  [0.044s]
usr.sbin/pw/pw_groupmod_test:usermod_bug_185666  ->  passed  [0.093s]
usr.sbin/pw/pw_groupshow_test:group_show_all  ->  passed  [0.027s]
usr.sbin/pw/pw_groupshow_test:group_show_gid  ->  passed  [0.023s]
usr.sbin/pw/pw_groupshow_test:group_show_name  ->  passed  [0.023s]
usr.sbin/pw/pw_groupshow_test:group_show_nonexistent_gid  ->  passed  [0.029s]
usr.sbin/pw/pw_groupshow_test:group_show_nonexistent_name  ->  passed  [0.028s]
usr.sbin/pw/pw_lock_test:numeric_locking  ->  passed  [0.098s]
usr.sbin/pw/pw_lock_test:user_locking  ->  passed  [0.050s]
usr.sbin/pw/pw_useradd_test:user_add  ->  passed  [0.041s]
usr.sbin/pw/pw_useradd_test:user_add_R  ->  passed  [0.089s]
usr.sbin/pw/pw_useradd_test:user_add_R_symlink  ->  passed  [0.045s]
usr.sbin/pw/pw_useradd_test:user_add_account_expiration_date_month  ->  passed  [0.045s]
usr.sbin/pw/pw_useradd_test:user_add_account_expiration_date_numeric  ->  passed  [0.044s]
usr.sbin/pw/pw_useradd_test:user_add_account_expiration_date_relative  ->  passed  [0.041s]
usr.sbin/pw/pw_useradd_test:user_add_account_expiration_epoch  ->  passed  [0.043s]
usr.sbin/pw/pw_useradd_test:user_add_already_exists  ->  passed  [0.045s]
usr.sbin/pw/pw_useradd_test:user_add_bad_shell  ->  passed  [0.045s]
usr.sbin/pw/pw_useradd_test:user_add_comments  ->  passed  [0.043s]
usr.sbin/pw/pw_useradd_test:user_add_comments_invalid  ->  passed  [0.035s]
usr.sbin/pw/pw_useradd_test:user_add_comments_invalid_noupdate  ->  passed  [0.034s]
usr.sbin/pw/pw_useradd_test:user_add_comments_noupdate  ->  passed  [0.037s]
usr.sbin/pw/pw_useradd_test:user_add_conf_defaultpasswd  ->  passed  [0.068s]
usr.sbin/pw/pw_useradd_test:user_add_defaultgroup  ->  passed  [0.049s]
usr.sbin/pw/pw_useradd_test:user_add_expiration  ->  passed  [0.184s]
usr.sbin/pw/pw_useradd_test:user_add_homedir  ->  passed  [0.044s]
usr.sbin/pw/pw_useradd_test:user_add_invalid_group_entry  ->  passed  [0.040s]
usr.sbin/pw/pw_useradd_test:user_add_invalid_user_entry  ->  passed  [0.040s]
usr.sbin/pw/pw_useradd_test:user_add_name_too_long  ->  passed  [0.029s]
usr.sbin/pw/pw_useradd_test:user_add_name_with_spaces  ->  passed  [0.043s]
usr.sbin/pw/pw_useradd_test:user_add_name_with_spaces_and_gid_specified  ->  passed  [0.070s]
usr.sbin/pw/pw_useradd_test:user_add_noupdate  ->  passed  [0.036s]
usr.sbin/pw/pw_useradd_test:user_add_password_expiration_date_month  ->  passed  [0.044s]
usr.sbin/pw/pw_useradd_test:user_add_password_expiration_date_numeric  ->  passed  [0.044s]
usr.sbin/pw/pw_useradd_test:user_add_password_expiration_date_relative  ->  passed  [0.036s]
usr.sbin/pw/pw_useradd_test:user_add_password_expiration_epoch  ->  passed  [0.042s]
usr.sbin/pw/pw_useradd_test:user_add_password_from_h  ->  passed  [0.053s]
usr.sbin/pw/pw_useradd_test:user_add_skel  ->  *** /usr/src/contrib/kyua/utils/process/executor.cpp:779: Invariant check failed: PID 2140 already in all_exec_handles; not properly cleaned up or reused too fast
*** Fatal signal 6 received
*** Log file is /.kyua/logs/kyua.20230206-182449.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 781 (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-notyet-tests.sh
a ./auto-shutdown
a ./run.sh
a ./disable-zfs-tests.sh
a ./disable-dtrace-tests.sh
+ [ -f /meta/auto-shutdown ]
+ uname -p
+ shutdown -p now
Shutdown NOW!
shutdown: [pid 2178]
+ 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-02-06T19:16:29.116119+00:00 - shutdown 2178 - - 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... 
Syncing disks, vnodes remaining... 1 2 0 done
All buffers synced.
lock order reversal:
 1st 0xfffff8001f059770 ufs (ufs, lockmgr) @ /usr/src/sys/kern/vfs_mount.c:2158
 2nd 0xfffff8001f2f1070 tarfsz (tarfsz, lockmgr) @ /usr/src/sys/fs/tarfs/tarfs_io.c:689
lock order tarfsz -> ufs established at:
#0 0xffffffff80c5ff9d at witness_checkorder+0x32d
#1 0xffffffff80bbb7ac at lockmgr_lock_flags+0x7c
#2 0xffffffff80f5360c at ffs_lock+0x6c
#3 0xffffffff80cfa6a4 at _vn_lock+0x54
#4 0xffffffff828859bd at tarfs_zread+0x1fd
#5 0xffffffff811b3e34 at VOP_READ_APV+0x34
#6 0xffffffff82885092 at tarfs_io_read+0x92
#7 0xffffffff828851d2 at tarfs_io_read_buf+0x52
#8 0xffffffff828886f3 at tarfs_alloc_mount+0x2d3
#9 0xffffffff82887f71 at tarfs_mount+0x3b1
#10 0xffffffff80cda990 at vfs_domount_first+0x250
#11 0xffffffff80cd6ef1 at vfs_domount+0x2f1
#12 0xffffffff80cd5885 at vfs_donmount+0x895
#13 0xffffffff80cd4fb9 at sys_nmount+0x69
#14 0xffffffff810e3bc4 at amd64_syscall+0x6b4
#15 0xffffffff810b6b9b at fast_syscall_common+0xf8
lock order ufs -> tarfsz attempted at:
#0 0xffffffff80c6086d at witness_checkorder+0xbfd
#1 0xffffffff80bbb8b2 at lockmgr_lock_flags+0x182
#2 0xffffffff80cfa6a4 at _vn_lock+0x54
#3 0xffffffff828854cb at tarfs_io_fini+0x3b
#4 0xffffffff82889457 at tarfs_free_mount+0x87
#5 0xffffffff82888055 at tarfs_unmount+0x65
#6 0xffffffff80cd7ed3 at dounmount+0x7c3
#7 0xffffffff80ce487a at vfs_unmountall+0x6a
#8 0xffffffff80cb540e at bufshutdown+0x34e
#9 0xffffffff80bee0e4 at kern_reboot+0x764
#10 0xffffffff80bed928 at sys_reboot+0x3a8
#11 0xffffffff810e3bc4 at amd64_syscall+0x6b4
#12 0xffffffff810b6b9b at fast_syscall_common+0xf8
lock order reversal:
 1st 0xfffff80006b1e3f0 devfs (devfs, lockmgr) @ /usr/src/sys/kern/vfs_mount.c:2158
 2nd 0xfffff80006cbccb0 fdescfs (fdescfs, lockmgr) @ /usr/src/sys/kern/vfs_subr.c:3043
lock order devfs -> fdescfs attempted at:
#0 0xffffffff80c6086d at witness_checkorder+0xbfd
#1 0xffffffff80bbb8b2 at lockmgr_lock_flags+0x182
#2 0xffffffff80cfa6a4 at _vn_lock+0x54
#3 0xffffffff80ce202f at vget_finish+0x4f
#4 0xffffffff82710242 at fdesc_root+0x22
#5 0xffffffff80ce308c at vflush+0x4c
#6 0xffffffff827101f2 at fdesc_unmount+0x72
#7 0xffffffff80cd7ed3 at dounmount+0x7c3
#8 0xffffffff80ce487a at vfs_unmountall+0x6a
#9 0xffffffff80cb540e at bufshutdown+0x34e
#10 0xffffffff80bee0e4 at kern_reboot+0x764
#11 0xffffffff80bed928 at sys_reboot+0x3a8
#12 0xffffffff810e3bc4 at amd64_syscall+0x6b4
#13 0xffffffff810b6b9b at fast_syscall_common+0xf8
pid 495 (devd), jid 0, uid 0: exited on signal 11
Uptime: 51m46s
acpi0: Powering system off
+ rc=0
+ echo 'bhyve return code = 0'
bhyve return code = 0
+ sudo /usr/sbin/bhyvectl '--vm=testvm-main-amd64-22932' --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-notyet-tests.sh
x ./auto-shutdown
x ./run.sh
x ./disable-zfs-tests.sh
x ./disable-dtrace-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/jenkins3519882592813285404.sh
+ ./freebsd-ci/artifact/post-link.py
Post link: {'job_name': 'FreeBSD-main-amd64-test', 'commit': '9c067b844f85a224f0416e6eb46ba3ef82aec5c4', 'branch': 'main', 'target': 'amd64', 'target_arch': 'amd64', 'link_type': 'latest_tested'}
"Link created: main/latest_tested/amd64/amd64 -> ../../9c067b844f85a224f0416e6eb46ba3ef82aec5c4/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