Skip site navigation (1)Skip section navigation (2)
Date:      Wed, 1 Nov 2023 15:45:35 +0000 (GMT)
From:      jenkins-admin@FreeBSD.org
To:        mjg@FreeBSD.org, noreply@github.com, behlendorf1@llnl.gov, tuexen@FreeBSD.org, dev-ci@FreeBSD.org
Cc:        jenkins-admin@FreeBSD.org
Subject:   FreeBSD-main-amd64-test - Build #24317 - Failure
Message-ID:  <953767011.7532.1698853535707@jenkins.ci.freebsd.org>
In-Reply-To: <1104820770.7502.1698837426106@jenkins.ci.freebsd.org>
References:  <1104820770.7502.1698837426106@jenkins.ci.freebsd.org>

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

FreeBSD-main-amd64-test - Build #24317 (aa64a8f5c35c13b1c325f1a4597c987a37b=
ec5da) - Failure

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

c3773de168668a5515e82d100ed6509e7d174fe9 by noreply:
ZIL: Cleanup sync and commit handling

05a7348a7e7e0be7ae5e729fdc98cb77416d30b8 by noreply:
RAIDZ: Use cache blocking during parity math

514d661ca1d5df1f5e4f852d169f6969fcff2994 by noreply:
Tune zio buffer caches and their alignments

799e09f75a31e80a1702a850838c79879af8b917 by noreply:
Unify arc_prune_async() code

dbe839a9ca1dbaa7bb68b7254e4954256123414e by behlendorf1:
zvol: Cleanup set property

60387facd267046db22221107a03181a2ae7d950 by behlendorf1:
zvol: Implement zvol threading as a Property

9ccdb8becdc6a50c389958877aa76ff12a8955d2 by behlendorf1:
zvol: fix delayed update to block device ro entry

cba99a046e346dc3f3170294de597495143546de by noreply:
Add all read-only compatible zpool features to grub2 compatibility

763ca47fa81808be62ab5e02357e896233f24abc by noreply:
Fix block cloning between unencrypted and encrypted datasets

41e55b476bcfc90f1ad81c02c5375367fdace9e9 by noreply:
Fix nfs_truncate_shares without /etc/exports.d

8b916c35c2885867df2351a94a4b22100ad8eade by mjg:
vfs: fix a typo introdued in previous

0c5cd045bfb847428a8a5e0e91e6fc3cf27a17c2 by mjg:
vfs: remove majority of stale commentary about free list

aa64a8f5c35c13b1c325f1a4597c987a37bec5da by tuexen:
udplite: fix checksum computation on the sender side



The end of the build log:

[...truncated 4.37 MB...]
passed  [0.008s]
sys/audit/inter-process:msgget_success  ->  2023-11-01T15:45:25.058652+00:0=
0 - auditd 39121 - - Got audit initialize trigger
passed  [0.009s]
sys/audit/inter-process:msgrcv_failure  ->  2023-11-01T15:45:25.082237+00:0=
0 - auditd 39121 - - Got audit initialize trigger
passed  [0.009s]
sys/audit/inter-process:msgrcv_success  ->  2023-11-01T15:45:25.106362+00:0=
0 - auditd 39121 - - Got audit initialize trigger
passed  [0.008s]
sys/audit/inter-process:msgsnd_failure  ->  2023-11-01T15:45:25.127665+00:0=
0 - auditd 39121 - - Got audit initialize trigger
passed  [0.008s]
sys/audit/inter-process:msgsnd_success  ->  2023-11-01T15:45:25.148876+00:0=
0 - auditd 39121 - - Got audit initialize trigger
passed  [0.008s]
sys/audit/inter-process:pipe_failure  ->  2023-11-01T15:45:25.172210+00:00 =
- auditd 39121 - - Got audit initialize trigger
passed  [0.010s]
sys/audit/inter-process:pipe_success  ->  2023-11-01T15:45:25.197093+00:00 =
- auditd 39121 - - Got audit initialize trigger
passed  [0.008s]
sys/audit/inter-process:posix_openpt_failure  ->  2023-11-01T15:45:25.21794=
2+00:00 - auditd 39121 - - Got audit initialize trigger
passed  [0.009s]
sys/audit/inter-process:posix_openpt_success  ->  2023-11-01T15:45:25.23908=
0+00:00 - auditd 39121 - - Got audit initialize trigger
passed  [0.010s]
sys/audit/inter-process:semctl_getall_failure  ->  2023-11-01T15:45:25.2612=
16+00:00 - auditd 39121 - - Got audit initialize trigger
passed  [0.008s]
sys/audit/inter-process:semctl_getall_success  ->  2023-11-01T15:45:25.2812=
73+00:00 - auditd 39121 - - Got audit initialize trigger
passed  [0.008s]
sys/audit/inter-process:semctl_getncnt_failure  ->  2023-11-01T15:45:25.304=
258+00:00 - auditd 39121 - - Got audit initialize trigger
passed  [0.008s]
sys/audit/inter-process:semctl_getncnt_success  ->  2023-11-01T15:45:25.328=
502+00:00 - auditd 39121 - - Got audit initialize trigger
passed  [0.008s]
sys/audit/inter-process:semctl_getpid_failure  ->  2023-11-01T15:45:25.3517=
56+00:00 - auditd 39121 - - Got audit initialize trigger
passed  [0.008s]
sys/audit/inter-process:semctl_getpid_success  ->  2023-11-01T15:45:25.3781=
15+00:00 - auditd 39121 - - Got audit initialize trigger
passed  [0.010s]
sys/audit/inter-process:semctl_getval_failure  ->  2023-11-01T15:45:25.4035=
64+00:00 - auditd 39121 - - Got audit initialize trigger
passed  [0.010s]
sys/audit/inter-process:semctl_getval_success  ->  2023-11-01T15:45:25.4286=
67+00:00 - auditd 39121 - - Got audit initialize trigger
passed  [0.010s]
sys/audit/inter-process:semctl_getzcnt_failure  ->  2023-11-01T15:45:25.452=
231+00:00 - auditd 39121 - - Got audit initialize trigger
passed  [0.008s]
sys/audit/inter-process:semctl_getzcnt_success  ->  2023-11-01T15:45:25.475=
443+00:00 - auditd 39121 - - Got audit initialize trigger
passed  [0.008s]
sys/audit/inter-process:semctl_illegal_command  ->  2023-11-01T15:45:25.497=
157+00:00 - auditd 39121 - - Got audit initialize trigger
passed  [0.009s]
sys/audit/inter-process:semctl_rmid_failure  ->  2023-11-01T15:45:25.519037=
+00:00 - auditd 39121 - - Got audit initialize trigger
passed  [0.009s]
sys/audit/inter-process:semctl_rmid_success  ->  2023-11-01T15:45:25.544936=
+00:00 - auditd 39121 - - Got audit initialize trigger
passed  [0.010s]
sys/audit/inter-process:semctl_set_failure  ->  2023-11-01T15:45:25.566437+=
00:00 - auditd 39121 - - Got audit initialize trigger
passed  [0.009s]
sys/audit/inter-process:semctl_set_success  ->  2023-11-01T15:45:25.591096+=
00:00 - auditd 39121 - - Got audit initialize trigger
passed  [0.009s]
sys/audit/inter-process:semctl_setall_failure  ->  2023-11-01T15:45:25.6154=
85+00:00 - auditd 39121 - - Got audit initialize trigger
passed  [0.009s]
sys/audit/inter-process:semctl_setall_success  ->  2023-11-01T15:45:25.6370=
88+00:00 - auditd 39121 - - Got audit initialize trigger
passed  [0.008s]
sys/audit/inter-process:semctl_setval_failure  ->  2023-11-01T15:45:25.6584=
92+00:00 - auditd 39121 - - Got audit initialize trigger
passed  [0.008s]
sys/audit/inter-process:semctl_setval_success  ->  2023-11-01T15:45:25.6796=
59+00:00 - auditd 39121 - - Got audit initialize trigger
passed  [0.009s]
sys/audit/inter-process:semctl_stat_failure  ->  2023-11-01T15:45:25.703542=
+00:00 - auditd 39121 - - Got audit initialize trigger
passed  [0.008s]
sys/audit/inter-process:semctl_stat_success  ->  2023-11-01T15:45:25.728462=
+00:00 - auditd 39121 - - Got audit initialize trigger
passed  [0.009s]
sys/audit/inter-process:semget_failure  ->  2023-11-01T15:45:25.753734+00:0=
0 - auditd 39121 - - Got audit initialize trigger
passed  [0.009s]
sys/audit/inter-process:semget_success  ->  2023-11-01T15:45:25.779043+00:0=
0 - auditd 39121 - - Got audit initialize trigger
passed  [0.010s]
sys/audit/inter-process:semop_failure  ->  2023-11-01T15:45:25.804311+00:00=
 - auditd 39121 - - Got audit initialize trigger
passed  [0.010s]
sys/audit/inter-process:semop_success  ->  2023-11-01T15:45:25.826841+00:00=
 - auditd 39121 - - Got audit initialize trigger
passed  [0.008s]
sys/audit/inter-process:shm_open_failure  ->  2023-11-01T15:45:25.848600+00=
:00 - auditd 39121 - - Got audit initialize trigger
passed  [0.009s]
sys/audit/inter-process:shm_open_success  ->  2023-11-01T15:45:25.869895+00=
:00 - auditd 39121 - - Got audit initialize trigger
passed  [0.008s]
sys/audit/inter-process:shm_unlink_failure  ->  2023-11-01T15:45:25.891839+=
00:00 - auditd 39121 - - Got audit initialize trigger
passed  [0.009s]
sys/audit/inter-process:shm_unlink_success  ->  2023-11-01T15:45:25.914063+=
00:00 - auditd 39121 - - Got audit initialize trigger
passed  [0.009s]
sys/audit/inter-process:shmat_failure  ->  2023-11-01T15:45:25.935023+00:00=
 - auditd 39121 - - Got audit initialize trigger
passed  [0.008s]
sys/audit/inter-process:shmat_success  ->  2023-11-01T15:45:25.958517+00:00=
 - auditd 39121 - - Got audit initialize trigger
passed  [0.008s]
sys/audit/inter-process:shmctl_illegal_command  ->  2023-11-01T15:45:25.979=
396+00:00 - auditd 39121 - - Got audit initialize trigger
passed  [0.008s]
sys/audit/inter-process:shmctl_rmid_failure  ->  2023-11-01T15:45:26.002267=
+00:00 - auditd 39121 - - Got audit initialize trigger
passed  [0.010s]
sys/audit/inter-process:shmctl_rmid_success  ->  2023-11-01T15:45:26.027546=
+00:00 - auditd 39121 - - Got audit initialize trigger
passed  [0.010s]
sys/audit/inter-process:shmctl_set_failure  ->  2023-11-01T15:45:26.050701+=
00:00 - auditd 39121 - - Got audit initialize trigger
passed  [0.009s]
sys/audit/inter-process:shmctl_set_success  ->  2023-11-01T15:45:26.075509+=
00:00 - auditd 39121 - - Got audit initialize trigger
passed  [0.009s]
sys/audit/inter-process:shmctl_stat_failure  ->  2023-11-01T15:45:26.096418=
+00:00 - auditd 39121 - - Got audit initialize trigger
passed  [0.008s]
sys/audit/inter-process:shmctl_stat_success  ->  2023-11-01T15:45:26.121275=
+00:00 - auditd 39121 - - Got audit initialize trigger
passed  [0.009s]
sys/audit/inter-process:shmdt_failure  ->  2023-11-01T15:45:26.143978+00:00=
 - auditd 39121 - - Got audit initialize trigger
passed  [0.009s]
sys/audit/inter-process:shmdt_success  ->  2023-11-01T15:45:26.169290+00:00=
 - auditd 39121 - - Got audit initialize trigger
passed  [0.010s]
sys/audit/inter-process:shmget_failure  ->  2023-11-01T15:45:26.194952+00:0=
0 - auditd 39121 - - Got audit initialize trigger
passed  [0.010s]
sys/audit/inter-process:shmget_success  ->  2023-11-01T15:45:26.220330+00:0=
0 - auditd 39121 - - Got audit initialize trigger
passed  [0.010s]
sys/audit/ioctl:ioctl_failure  ->  2023-11-01T15:45:26.244953+00:00 - audit=
d 39121 - - Got audit initialize trigger
passed  [0.009s]
sys/audit/ioctl:ioctl_success  ->  2023-11-01T15:45:26.265510+00:00 - audit=
d 39121 - - Got audit initialize trigger
passed  [0.008s]
sys/audit/miscellaneous:audit_failure  ->  2023-11-01T15:45:26.288323+00:00=
 - auditd 39121 - - Got audit initialize trigger
passed  [0.007s]
sys/audit/miscellaneous:sysarch_failure  ->  2023-11-01T15:45:26.309568+00:=
00 - auditd 39121 - - Got audit initialize trigger
passed  [0.008s]
sys/audit/miscellaneous:sysarch_success  ->  2023-11-01T15:45:26.329384+00:=
00 - auditd 39121 - - Got audit initialize trigger
passed  [0.008s]
sys/audit/miscellaneous:sysctl_failure  ->  2023-11-01T15:45:26.349066+00:0=
0 - auditd 39121 - - Got audit initialize trigger
passed  [0.007s]
sys/audit/miscellaneous:sysctl_success  ->  2023-11-01T15:45:26.368263+00:0=
0 - auditd 39121 - - Got audit initialize trigger
passed  [0.008s]
sys/audit/network:accept_failure  ->  2023-11-01T15:45:26.393374+00:00 - au=
ditd 39121 - - Got audit initialize trigger
passed  [0.010s]
sys/audit/network:accept_success  ->  2023-11-01T15:45:26.418929+00:00 - au=
ditd 39121 - - Got audit initialize trigger
passed  [0.009s]
sys/audit/network:bind_failure  ->  2023-11-01T15:45:26.445885+00:00 - audi=
td 39121 - - Got audit initialize trigger
passed  [0.011s]
sys/audit/network:bind_success  ->  2023-11-01T15:45:26.470355+00:00 - audi=
td 39121 - - Got audit initialize trigger
passed  [0.011s]
sys/audit/network:bindat_failure  ->  2023-11-01T15:45:26.497971+00:00 - au=
ditd 39121 - - Got audit initialize trigger
passed  [0.010s]
sys/audit/network:bindat_success  ->  2023-11-01T15:45:26.524361+00:00 - au=
ditd 39121 - - Got audit initialize trigger
passed  [0.013s]
sys/audit/network:connect_failure  ->  2023-11-01T15:45:26.550506+00:00 - a=
uditd 39121 - - Got audit initialize trigger
passed  [0.008s]
sys/audit/network:connect_success  ->  2023-11-01T15:45:26.573482+00:00 - a=
uditd 39121 - - Got audit initialize trigger
passed  [0.010s]
sys/audit/network:connectat_failure  ->  *** /usr/src/contrib/kyua/utils/pr=
ocess/executor.cpp:779: Invariant check failed: PID 39674 already in all_ex=
ec_handles; not properly cleaned up or reused too fast
*** Fatal signal 6 received
*** Log file is /.kyua/logs/kyua.20231101-150025.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
2023-11-01T15:45:26.596092+00:00 - auditd 39121 - - Got audit initialize tr=
igger
pid 758 (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-notyet-tests.sh
a ./auto-shutdown
a ./run.sh
a ./disable-zfs-tests.sh
a ./disable-dtrace-tests.sh
a ./run-kyua.sh
+ [ -f /meta/auto-shutdown ]
+ uname -p
+ shutdown -p now
Shutdown NOW!
shutdown: [pid 39678]
+ 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-11-01T15:45:26.738043+00:00 - shutdown 39678 - - power-down by root:=
=20

System shutdown time has arrived=07=07
2023-11-01T15:45:26.739868+00:00 - auditd 39121 - - auditd_wait_for_events:=
 SIGTERM
2023-11-01T15:45:26.741673+00:00 - auditd 39121 - - Auditing disabled
2023-11-01T15:45:26.743279+00:00 - auditd 39121 - - renamed /var/audit/2023=
1101154519.not_terminated to /var/audit/20231101154519.20231101154526
2023-11-01T15:45:26.745922+00:00 - auditd 39121 - - 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 done
All buffers synced.
lock order reversal:
 1st 0xfffff80009a25070 devfs (devfs, lockmgr) @ /usr/src/sys/kern/vfs_moun=
t.c:2255
 2nd 0xfffff80009a26930 fdescfs (fdescfs, lockmgr) @ /usr/src/sys/kern/vfs_=
subr.c:3296
lock order devfs -> fdescfs attempted at:
#0 0xffffffff80bc33ce at witness_checkorder+0xbbe
#1 0xffffffff80b1cd01 at lockmgr_lock_flags+0x181
#2 0xffffffff80c5f1a3 at _vn_lock+0x53
#3 0xffffffff80c4678d at vget_finish+0x4d
#4 0xffffffff82610262 at fdesc_root+0x22
#5 0xffffffff80c4782b at vflush+0x4b
#6 0xffffffff82610211 at fdesc_unmount+0x71
#7 0xffffffff80c3c475 at dounmount+0x7b5
#8 0xffffffff80c48f6a at vfs_unmountall+0x6a
#9 0xffffffff80c194ac at bufshutdown+0x30c
#10 0xffffffff80b4fbe3 at kern_reboot+0x703
#11 0xffffffff80b4f489 at sys_reboot+0x3a9
#12 0xffffffff810516b3 at amd64_syscall+0x153
#13 0xffffffff810232eb at fast_syscall_common+0xf8
Uptime: 45m5s
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-24317' --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-notyet-tests.sh
x ./auto-shutdown
x ./run.sh
x ./disable-zfs-tests.sh
x ./disable-dtrace-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/jenkins2964813013151917685.sh
+ ./freebsd-ci/artifact/post-link.py
Post link: {'job_name': 'FreeBSD-main-amd64-test', 'commit': 'aa64a8f5c35c1=
3b1c325f1a4597c987a37bec5da', 'branch': 'main', 'target': 'amd64', 'target_=
arch': 'amd64', 'link_type': 'latest_tested'}
"Link created: main/latest_tested/amd64/amd64 -> ../../aa64a8f5c35c13b1c325=
f1a4597c987a37bec5da/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_7531_860660323.1698853535091--



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