Date: Sun, 10 Sep 2023 21:42:26 +0000 (GMT) From: jenkins-admin@FreeBSD.org To: delphij@FreeBSD.org, dev-ci@FreeBSD.org Cc: jenkins-admin@FreeBSD.org Subject: FreeBSD-main-amd64-test - Build #24144 - Failure Message-ID: <1731161327.3896.1694382146779@jenkins.ci.freebsd.org> In-Reply-To: <382377631.3894.1694379846889@jenkins.ci.freebsd.org> References: <382377631.3894.1694379846889@jenkins.ci.freebsd.org>
next in thread | previous in thread | raw e-mail | index | archive | help
------=_Part_3895_973362629.1694382146526 Content-Type: text/plain; charset=UTF-8 Content-Transfer-Encoding: quoted-printable FreeBSD-main-amd64-test - Build #24144 (898496ee09ed2b7d25f6807edc451562819= 6ec0a) - Failure Build information: https://ci.FreeBSD.org/job/FreeBSD-main-amd64-test/24144= / Full change log: https://ci.FreeBSD.org/job/FreeBSD-main-amd64-test/24144/c= hanges Full build log: https://ci.FreeBSD.org/job/FreeBSD-main-amd64-test/24144/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) 72d4668c77f014e21af1db10648768e4843ce5d2 by delphij: Vendor import of file 5.45. The end of the build log: [...truncated 4.33 MB...] passed [0.007s] sys/audit/file-attribute-access:fhstat_failure -> 2023-09-10T21:42:17.396= 260+00:00 - auditd 25122 - - Got audit initialize trigger passed [0.007s] sys/audit/file-attribute-access:fhstat_success -> 2023-09-10T21:42:17.416= 218+00:00 - auditd 25122 - - Got audit initialize trigger passed [0.007s] sys/audit/file-attribute-access:fhstatfs_failure -> 2023-09-10T21:42:17.4= 35752+00:00 - auditd 25122 - - Got audit initialize trigger passed [0.007s] sys/audit/file-attribute-access:fhstatfs_success -> 2023-09-10T21:42:17.4= 55424+00:00 - auditd 25122 - - Got audit initialize trigger passed [0.007s] sys/audit/file-attribute-access:fpathconf_failure -> 2023-09-10T21:42:17.= 475232+00:00 - auditd 25122 - - Got audit initialize trigger passed [0.007s] sys/audit/file-attribute-access:fpathconf_success -> 2023-09-10T21:42:17.= 492968+00:00 - auditd 25122 - - Got audit initialize trigger passed [0.007s] sys/audit/file-attribute-access:fstat_failure -> 2023-09-10T21:42:17.5125= 23+00:00 - auditd 25122 - - Got audit initialize trigger passed [0.008s] sys/audit/file-attribute-access:fstat_success -> 2023-09-10T21:42:17.5340= 14+00:00 - auditd 25122 - - Got audit initialize trigger passed [0.008s] sys/audit/file-attribute-access:fstatat_failure -> 2023-09-10T21:42:17.55= 1997+00:00 - auditd 25122 - - Got audit initialize trigger passed [0.007s] sys/audit/file-attribute-access:fstatat_success -> 2023-09-10T21:42:17.57= 0228+00:00 - auditd 25122 - - Got audit initialize trigger passed [0.007s] sys/audit/file-attribute-access:fstatfs_failure -> 2023-09-10T21:42:17.58= 7930+00:00 - auditd 25122 - - Got audit initialize trigger passed [0.006s] sys/audit/file-attribute-access:fstatfs_success -> 2023-09-10T21:42:17.60= 4872+00:00 - auditd 25122 - - Got audit initialize trigger passed [0.006s] sys/audit/file-attribute-access:getfsstat_failure -> 2023-09-10T21:42:17.= 621757+00:00 - auditd 25122 - - Got audit initialize trigger passed [0.007s] sys/audit/file-attribute-access:getfsstat_success -> 2023-09-10T21:42:17.= 638972+00:00 - auditd 25122 - - Got audit initialize trigger passed [0.007s] sys/audit/file-attribute-access:lgetfh_failure -> 2023-09-10T21:42:17.656= 195+00:00 - auditd 25122 - - Got audit initialize trigger passed [0.007s] sys/audit/file-attribute-access:lgetfh_success -> 2023-09-10T21:42:17.676= 275+00:00 - auditd 25122 - - Got audit initialize trigger passed [0.007s] sys/audit/file-attribute-access:lpathconf_failure -> 2023-09-10T21:42:17.= 693639+00:00 - auditd 25122 - - Got audit initialize trigger passed [0.007s] sys/audit/file-attribute-access:lpathconf_success -> 2023-09-10T21:42:17.= 711113+00:00 - auditd 25122 - - Got audit initialize trigger passed [0.007s] sys/audit/file-attribute-access:lstat_failure -> 2023-09-10T21:42:17.7315= 57+00:00 - auditd 25122 - - Got audit initialize trigger passed [0.009s] sys/audit/file-attribute-access:lstat_success -> 2023-09-10T21:42:17.7492= 54+00:00 - auditd 25122 - - Got audit initialize trigger passed [0.007s] sys/audit/file-attribute-access:pathconf_failure -> 2023-09-10T21:42:17.7= 66308+00:00 - auditd 25122 - - Got audit initialize trigger passed [0.006s] sys/audit/file-attribute-access:pathconf_success -> 2023-09-10T21:42:17.7= 82851+00:00 - auditd 25122 - - Got audit initialize trigger passed [0.006s] sys/audit/file-attribute-access:stat_failure -> 2023-09-10T21:42:17.79924= 8+00:00 - auditd 25122 - - Got audit initialize trigger passed [0.007s] sys/audit/file-attribute-access:stat_success -> 2023-09-10T21:42:17.81618= 7+00:00 - auditd 25122 - - Got audit initialize trigger passed [0.007s] sys/audit/file-attribute-access:statfs_failure -> 2023-09-10T21:42:17.833= 549+00:00 - auditd 25122 - - Got audit initialize trigger passed [0.006s] sys/audit/file-attribute-access:statfs_success -> 2023-09-10T21:42:17.853= 951+00:00 - auditd 25122 - - Got audit initialize trigger passed [0.008s] sys/audit/file-attribute-modify:chflags_failure -> 2023-09-10T21:42:17.87= 5478+00:00 - auditd 25122 - - Got audit initialize trigger passed [0.008s] sys/audit/file-attribute-modify:chflags_success -> 2023-09-10T21:42:17.89= 7347+00:00 - auditd 25122 - - Got audit initialize trigger passed [0.008s] sys/audit/file-attribute-modify:chflagsat_failure -> 2023-09-10T21:42:17.= 917927+00:00 - auditd 25122 - - Got audit initialize trigger passed [0.007s] sys/audit/file-attribute-modify:chflagsat_success -> 2023-09-10T21:42:17.= 939320+00:00 - auditd 25122 - - Got audit initialize trigger passed [0.009s] sys/audit/file-attribute-modify:chmod_failure -> 2023-09-10T21:42:17.9613= 68+00:00 - auditd 25122 - - Got audit initialize trigger passed [0.007s] sys/audit/file-attribute-modify:chmod_success -> 2023-09-10T21:42:17.9823= 11+00:00 - auditd 25122 - - Got audit initialize trigger passed [0.008s] sys/audit/file-attribute-modify:chown_failure -> 2023-09-10T21:42:18.0035= 46+00:00 - auditd 25122 - - Got audit initialize trigger passed [0.007s] sys/audit/file-attribute-modify:chown_success -> 2023-09-10T21:42:18.0243= 10+00:00 - auditd 25122 - - Got audit initialize trigger passed [0.008s] sys/audit/file-attribute-modify:extattr_delete_fd_failure -> 2023-09-10T2= 1:42:18.044412+00:00 - auditd 25122 - - Got audit initialize trigger passed [0.007s] sys/audit/file-attribute-modify:extattr_delete_fd_success -> 2023-09-10T2= 1:42:18.065607+00:00 - auditd 25122 - - Got audit initialize trigger passed [0.008s] sys/audit/file-attribute-modify:extattr_delete_file_failure -> 2023-09-10= T21:42:18.083852+00:00 - auditd 25122 - - Got audit initialize trigger passed [0.007s] sys/audit/file-attribute-modify:extattr_delete_file_success -> 2023-09-10= T21:42:18.102428+00:00 - auditd 25122 - - Got audit initialize trigger passed [0.008s] sys/audit/file-attribute-modify:extattr_delete_link_failure -> 2023-09-10= T21:42:18.124347+00:00 - auditd 25122 - - Got audit initialize trigger passed [0.008s] sys/audit/file-attribute-modify:extattr_delete_link_success -> 2023-09-10= T21:42:18.145998+00:00 - auditd 25122 - - Got audit initialize trigger passed [0.009s] sys/audit/file-attribute-modify:extattr_set_fd_failure -> 2023-09-10T21:4= 2:18.168821+00:00 - auditd 25122 - - Got audit initialize trigger passed [0.008s] sys/audit/file-attribute-modify:extattr_set_fd_success -> 2023-09-10T21:4= 2:18.190715+00:00 - auditd 25122 - - Got audit initialize trigger passed [0.009s] sys/audit/file-attribute-modify:extattr_set_file_failure -> 2023-09-10T21= :42:18.213654+00:00 - auditd 25122 - - Got audit initialize trigger passed [0.008s] sys/audit/file-attribute-modify:extattr_set_file_success -> 2023-09-10T21= :42:18.235253+00:00 - auditd 25122 - - Got audit initialize trigger passed [0.009s] sys/audit/file-attribute-modify:extattr_set_link_failure -> 2023-09-10T21= :42:18.257816+00:00 - auditd 25122 - - Got audit initialize trigger passed [0.008s] sys/audit/file-attribute-modify:extattr_set_link_success -> 2023-09-10T21= :42:18.279307+00:00 - auditd 25122 - - Got audit initialize trigger passed [0.009s] sys/audit/file-attribute-modify:fchflags_failure -> 2023-09-10T21:42:18.3= 01417+00:00 - auditd 25122 - - Got audit initialize trigger passed [0.008s] sys/audit/file-attribute-modify:fchflags_success -> 2023-09-10T21:42:18.3= 21639+00:00 - auditd 25122 - - Got audit initialize trigger passed [0.008s] sys/audit/file-attribute-modify:fchmod_failure -> 2023-09-10T21:42:18.342= 324+00:00 - auditd 25122 - - Got audit initialize trigger passed [0.007s] sys/audit/file-attribute-modify:fchmod_success -> 2023-09-10T21:42:18.362= 295+00:00 - auditd 25122 - - Got audit initialize trigger passed [0.007s] sys/audit/file-attribute-modify:fchmodat_failure -> 2023-09-10T21:42:18.3= 80357+00:00 - auditd 25122 - - Got audit initialize trigger passed [0.007s] sys/audit/file-attribute-modify:fchmodat_success -> 2023-09-10T21:42:18.3= 98590+00:00 - auditd 25122 - - Got audit initialize trigger passed [0.007s] sys/audit/file-attribute-modify:fchown_failure -> 2023-09-10T21:42:18.421= 238+00:00 - auditd 25122 - - Got audit initialize trigger passed [0.008s] sys/audit/file-attribute-modify:fchown_success -> 2023-09-10T21:42:18.440= 645+00:00 - auditd 25122 - - Got audit initialize trigger passed [0.007s] sys/audit/file-attribute-modify:fchownat_failure -> 2023-09-10T21:42:18.4= 57493+00:00 - auditd 25122 - - Got audit initialize trigger passed [0.006s] sys/audit/file-attribute-modify:fchownat_success -> 2023-09-10T21:42:18.4= 75070+00:00 - auditd 25122 - - Got audit initialize trigger passed [0.007s] sys/audit/file-attribute-modify:fcntl_failure -> 2023-09-10T21:42:18.4925= 07+00:00 - auditd 25122 - - Got audit initialize trigger passed [0.006s] sys/audit/file-attribute-modify:fcntl_success -> 2023-09-10T21:42:18.5088= 43+00:00 - auditd 25122 - - Got audit initialize trigger passed [0.006s] sys/audit/file-attribute-modify:flock_failure -> 2023-09-10T21:42:18.5256= 78+00:00 - auditd 25122 - - Got audit initialize trigger passed [0.006s] sys/audit/file-attribute-modify:flock_success -> 2023-09-10T21:42:18.5448= 07+00:00 - auditd 25122 - - Got audit initialize trigger passed [0.009s] sys/audit/file-attribute-modify:fsync_failure -> 2023-09-10T21:42:18.5657= 35+00:00 - auditd 25122 - - Got audit initialize trigger passed [0.008s] sys/audit/file-attribute-modify:fsync_success -> 2023-09-10T21:42:18.5838= 82+00:00 - auditd 25122 - - Got audit initialize trigger passed [0.007s] sys/audit/file-attribute-modify:futimes_failure -> 2023-09-10T21:42:18.60= 1400+00:00 - auditd 25122 - - Got audit initialize trigger passed [0.007s] sys/audit/file-attribute-modify:futimes_success -> 2023-09-10T21:42:18.61= 9278+00:00 - auditd 25122 - - Got audit initialize trigger passed [0.007s] sys/audit/file-attribute-modify:futimesat_failure -> 2023-09-10T21:42:18.= 636477+00:00 - auditd 25122 - - Got audit initialize trigger passed [0.007s] sys/audit/file-attribute-modify:futimesat_success -> 2023-09-10T21:42:18.= 656911+00:00 - auditd 25122 - - Got audit initialize trigger passed [0.008s] sys/audit/file-attribute-modify:lchflags_failure -> *** /usr/src/contrib/= kyua/utils/process/executor.cpp:779: Invariant check failed: PID 25403 alre= ady in all_exec_handles; not properly cleaned up or reused too fast *** Fatal signal 6 received *** Log file is /.kyua/logs/kyua.20230910-210459.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-09-10T21:42:18.680404+00:00 - auditd 25122 - - Got audit initialize tr= igger pid 790 (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-zfs-tests.sh a ./run-kyua.sh a ./disable-notyet-tests.sh a ./run.sh a ./auto-shutdown a ./disable-dtrace-tests.sh + [ -f /meta/auto-shutdown ] + uname -p + shutdown -p now Shutdown NOW! shutdown: [pid 25407] + 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-09-10T21:42:18.779897+00:00 - shutdown 25407 - - power-down by root:= =20 System shutdown time has arrived=07=07 2023-09-10T21:42:18.781291+00:00 - auditd 25122 - - auditd_wait_for_events:= SIGTERM 2023-09-10T21:42:18.782652+00:00 - auditd 25122 - - Auditing disabled 2023-09-10T21:42:18.784119+00:00 - auditd 25122 - - renamed /var/audit/2023= 0910214215.not_terminated to /var/audit/20230910214215.20230910214218 2023-09-10T21:42:18.786884+00:00 - auditd 25122 - - 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 0xfffff80009a56cb0 devfs (devfs, lockmgr) @ /usr/src/sys/kern/vfs_moun= t.c:2240 2nd 0xfffff80009a565b0 fdescfs (fdescfs, lockmgr) @ /usr/src/sys/kern/vfs_= subr.c:3085 lock order devfs -> fdescfs attempted at: #0 0xffffffff80bc25fe at witness_checkorder+0xbbe #1 0xffffffff80b1c281 at lockmgr_lock_flags+0x181 #2 0xffffffff80c5dea3 at _vn_lock+0x53 #3 0xffffffff80c4567d at vget_finish+0x4d #4 0xffffffff82610262 at fdesc_root+0x22 #5 0xffffffff80c4671b at vflush+0x4b #6 0xffffffff82610211 at fdesc_unmount+0x71 #7 0xffffffff80c3b4e5 at dounmount+0x7b5 #8 0xffffffff80c47e5a at vfs_unmountall+0x6a #9 0xffffffff80c184ec at bufshutdown+0x30c #10 0xffffffff80b4f383 at kern_reboot+0x703 #11 0xffffffff80b4ec29 at sys_reboot+0x3a9 #12 0xffffffff8104e3d8 at amd64_syscall+0x138 #13 0xffffffff8101ffbb at fast_syscall_common+0xf8 Uptime: 37m23s 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-24144' --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-zfs-tests.sh x ./run-kyua.sh x ./disable-notyet-tests.sh x ./run.sh x ./auto-shutdown 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 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/jenkins5008964315660216900.sh + ./freebsd-ci/artifact/post-link.py Post link: {'job_name': 'FreeBSD-main-amd64-test', 'commit': '898496ee09ed2= b7d25f6807edc4515628196ec0a', 'branch': 'main', 'target': 'amd64', 'target_= arch': 'amd64', 'link_type': 'latest_tested'} "Link created: main/latest_tested/amd64/amd64 -> ../../898496ee09ed2b7d25f6= 807edc4515628196ec0a/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_3895_973362629.1694382146526--
Want to link to this message? Use this URL: <https://mail-archive.FreeBSD.org/cgi/mid.cgi?1731161327.3896.1694382146779>