From nobody Wed Nov 1 15:45:35 2023 X-Original-To: dev-ci@mlmmj.nyi.freebsd.org Received: from mx1.freebsd.org (mx1.freebsd.org [IPv6:2610:1c1:1:606c::19:1]) by mlmmj.nyi.freebsd.org (Postfix) with ESMTP id 4SLBDJ2d6yz4yWTR for ; Wed, 1 Nov 2023 15:45:36 +0000 (UTC) (envelope-from jenkins-admin@FreeBSD.org) Received: from mxrelay.nyi.freebsd.org (mxrelay.nyi.freebsd.org [IPv6:2610:1c1:1:606c::19:3]) (using TLSv1.3 with cipher TLS_AES_256_GCM_SHA384 (256/256 bits) key-exchange X25519 server-signature RSA-PSS (4096 bits) server-digest SHA256 client-signature RSA-PSS (4096 bits) client-digest SHA256) (Client CN "mxrelay.nyi.freebsd.org", Issuer "R3" (verified OK)) by mx1.freebsd.org (Postfix) with ESMTPS id 4SLBDH65vZz4gDZ; Wed, 1 Nov 2023 15:45:35 +0000 (UTC) (envelope-from jenkins-admin@FreeBSD.org) ARC-Message-Signature: i=1; a=rsa-sha256; c=relaxed/relaxed; d=freebsd.org; s=dkim; t=1698853535; h=from:from:reply-to:subject:subject:date:date:message-id:message-id: to:to:cc:cc:mime-version:mime-version:content-type:content-type: in-reply-to:in-reply-to:references:references:list-id; bh=ngS6hGqp44vOHShglPOrnWWTYdrZoYc5TsfPFTOI0EE=; b=ZyWDHHpEk7pCL4X2P2rRqh4ofW+1yaHOZ7vsjAhC0SGzfY7loVu+MKQz3e4T2bCjTlYdNm 7f5b0H+xo4lLmDOhTBZAWxEeZJylEsscalDtXnuqwOzyxMGlfhNEWZJZVFTkIA8awG8X9Z l9lNe/8NTKvPwJPoqZtMl1lDQhok47fA7ofos/wB/S1iKrNaqrElOgWtBtC5LrbpS7c5k/ Emf1M7BvFq0UJA83MisTiYQziZNPyEgs/g+rax9MVCvTSd5EfTAzX9emUBq9isvXqoVZyu vn+TONv4Fsg239rnalebO/6aYk7JsP689ND+BdDXxJhhlomBGvvDx5JePihf3w== ARC-Authentication-Results: i=1; mx1.freebsd.org; none ARC-Seal: i=1; s=dkim; d=freebsd.org; t=1698853535; a=rsa-sha256; cv=none; b=KkNfx/kot+L61L1+leK1ajTbrbBUYwdU7T6QfS/nWfw8+eQpxq+DUDaM7D3/cvPx8T71EP Ru/eqzXFxakgjRMCl6Xm3IkyHBAxcbHt7/1IshHSVrAuXSGx0Y6K1qyLEOmGMn3hkG2m+F bNfMj5FkJ1BAXS+q1ngmvhkroqBGf/AH9PrgBWAJG5TUgpiZYrbOdH7lDPYN+CssfIzziT xy1zAuOKiiZ7YPhM6LGa/pkf9ZH0IcR2V3j/52QXXE51nF6997OMTXZ66e70ykTbIngBnO mRQZxkba3L7z1uQo9IeEAnzPERfkDG/ABVmHTITY4jQiMRDfZUJX8K8QT9m3Rw== Received: from jenkins.ci.freebsd.org (jenkins.ci.freebsd.org [IPv6:2610:1c1:1:607c::16:16]) by mxrelay.nyi.freebsd.org (Postfix) with ESMTP id 4SLBDH4m8pzsQJ; Wed, 1 Nov 2023 15:45:35 +0000 (UTC) (envelope-from jenkins-admin@FreeBSD.org) 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 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> Subject: FreeBSD-main-amd64-test - Build #24317 - Failure List-Id: Continuous Integration Build and Test Results List-Archive: https://lists.freebsd.org/archives/dev-ci List-Help: List-Post: List-Subscribe: List-Unsubscribe: Sender: owner-dev-ci@freebsd.org X-BeenThere: dev-ci@freebsd.org MIME-Version: 1.0 Content-Type: multipart/mixed; boundary="----=_Part_7531_860660323.1698853535091" X-Jenkins-Job: FreeBSD-main-amd64-test X-Jenkins-Result: FAILURE List-ID: FreeBSD CI Build Notifications Precedence: bulk ------=_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--