INFO:workitem.py:647(13530): Agent 1707750846-665 one_id: 886866 running 10.215.101.145:38627 (buildKey: qt/qtquicktimeline/8b6ee66dccf488f837cd31500243f563eb796f6c/LinuxRHEL_9_2x86_64LinuxRHEL_9_2x86_64GCCqtci-linux-RHEL-9.2-x86_64-51-efd8d5InstallQt5Dependencies_Sccache_UseConfigure/a47471411482031b9e12b31953b2a7594f1019ff/Test) agent:2024/02/12 14:53:42 agent.go:232: Welcome. The agent (id: 1707750846-665) is listening on 10.215.101.145:38627 agent:2024/02/12 14:53:42 agent.go:233: The local time is: 2024-02-12 14:53:42.323011142 +0000 UTC m=+0.122472091 agent:2024/02/12 14:53:42 agent.go:235: The agent has 2 cores and 8672 MB of memory agent:2024/02/12 14:53:42 agent.go:95: Request: Test 'qt/qtquicktimeline' agent:2024/02/12 14:53:42 agent.go:96: Path: qt/qtquicktimeline/8b6ee66dccf488f837cd31500243f563eb796f6c/LinuxRHEL_9_2x86_64LinuxRHEL_9_2x86_64GCCqtci-linux-RHEL-9.2-x86_64-51-efd8d5InstallQt5Dependencies_Sccache_UseConfigure/a47471411482031b9e12b31953b2a7594f1019ff/test_1707752099 agent:2024/02/12 14:53:42 agent.go:97: Branch: dev agent:2024/02/12 14:53:42 agent.go:98: ID: rhel-9.2 agent:2024/02/12 14:53:42 agent.go:99: Configuration: BuildAndTest agent:2024/02/12 14:53:42 agent.go:100: Host: os: Linux, osVersion: RHEL_9_2, compiler: GCC, arch: X86_64 agent:2024/02/12 14:53:42 agent.go:101: Target: os: Linux, osVersion: RHEL_9_2, compiler: GCC, arch: X86_64 agent:2024/02/12 14:53:42 agent.go:102: Features: &[Sccache UseConfigure InstallQt5Dependencies] agent:2024/02/12 14:53:42 agent.go:103: Extra Configure Args: &[-nomake examples -release -force-debug-info -headersclean -separate-debug-info -qt-libjpeg -qt-libpng -qt-pcre -qt-harfbuzz -qt-doubleconversion -no-libudev -bundled-xcb-xinput] agent:2024/02/12 14:53:42 agent.go:104: Toolsets: agent:2024/02/12 14:53:42 agent.go:113: VM Template: 'qtci-linux-RHEL-9.2-x86_64-51-efd8d5' agent:2024/02/12 14:53:42 agent.go:114: Environment: running on 'annoying-dog.on1.qt.io' agent:2024/02/12 14:53:42 agent.go:115: AbortTestingOnFirstFailure: 'false' agent:2024/02/12 14:53:42 agent.go:324: Environment variables: agent:2024/02/12 14:53:42 agent.go:327: SHELL=/bin/bash agent:2024/02/12 14:53:42 agent.go:327: SESSION_MANAGER=local/unix:@/tmp/.ICE-unix/1944,unix/unix:/tmp/.ICE-unix/1944 agent:2024/02/12 14:53:42 agent.go:327: FFMPEG_DIR=/usr/local/FFmpeg-n6.1 agent:2024/02/12 14:53:42 agent.go:327: HISTCONTROL=ignoredups agent:2024/02/12 14:53:42 agent.go:327: XDG_MENU_PREFIX=gnome- agent:2024/02/12 14:53:42 agent.go:327: HOSTNAME=localhost agent:2024/02/12 14:53:42 agent.go:327: HISTSIZE=1000 agent:2024/02/12 14:53:42 agent.go:327: MQTT_TEST_BROKER_LOCATION=/opt/paho_broker/interoperability/startbroker.py agent:2024/02/12 14:53:42 agent.go:327: GNOME_SHELL_SESSION_MODE=classic agent:2024/02/12 14:53:42 agent.go:327: SSH_AUTH_SOCK=/run/user/1000/keyring/ssh agent:2024/02/12 14:53:42 agent.go:327: SCCACHE_IDLE_TIMEOUT=0 agent:2024/02/12 14:53:42 agent.go:327: SSH_PUBLIC_KEY= agent:2024/02/12 14:53:42 agent.go:327: XMODIFIERS=@im=ibus agent:2024/02/12 14:53:42 agent.go:327: DESKTOP_SESSION=gnome-classic agent:2024/02/12 14:53:42 agent.go:327: SSH_AGENT_PID=1623 agent:2024/02/12 14:53:42 agent.go:327: DISK_ID=1 agent:2024/02/12 14:53:42 agent.go:327: ANDROID_API_VERSION=android-34 agent:2024/02/12 14:53:42 agent.go:327: CONAN_REVISIONS_ENABLED=1 agent:2024/02/12 14:53:42 agent.go:327: PWD=/home/qt agent:2024/02/12 14:53:42 agent.go:327: VCPKG_ROOT=/home/qt/vcpkg-2023.10.19 agent:2024/02/12 14:53:42 agent.go:327: XDG_SESSION_DESKTOP=gnome-classic agent:2024/02/12 14:53:42 agent.go:327: LOGNAME=qt agent:2024/02/12 14:53:42 agent.go:327: XDG_SESSION_TYPE=x11 agent:2024/02/12 14:53:42 agent.go:327: LLVM_INSTALL_DIR=/usr/local/libclang-15.0.0 agent:2024/02/12 14:53:42 agent.go:327: BREAKPAD_SOURCE_DIR=/home/qt/breakpad agent:2024/02/12 14:53:42 agent.go:327: SYSTEMD_EXEC_PID=1944 agent:2024/02/12 14:53:42 agent.go:327: XAUTHORITY=/run/user/1000/gdm/Xauthority agent:2024/02/12 14:53:42 agent.go:327: COIN_LAUNCH_PARAMETERS=--scheduler-service=10.215.100.35:43189 --webserver-service=10.215.100.35:8080 --sourcestorage-service=10.215.100.35:33129 --storage-service=10.215.100.35:38329 qt/qtquicktimeline/8b6ee66dccf488f837cd31500243f563eb796f6c/LinuxRHEL_9_2x86_64LinuxRHEL_9_2x86_64GCCqtci-linux-RHEL-9.2-x86_64-51-efd8d5InstallQt5Dependencies_Sccache_UseConfigure/a47471411482031b9e12b31953b2a7594f1019ff/Test 1707750846-665 0 agent:2024/02/12 14:53:42 agent.go:327: COIN_DOWNLOAD_URL=http://10.215.100.35:8080/coin/binary/linux_amd64/agent agent:2024/02/12 14:53:42 agent.go:327: absl_ROOT=/home/qt/install-grpc-1.50.1 agent:2024/02/12 14:53:42 agent.go:327: LLVM_DYNAMIC_LIBS_100=/usr/local/libclang-dynlibs-10.0 agent:2024/02/12 14:53:42 agent.go:327: WINDOWPATH=2 agent:2024/02/12 14:53:42 agent.go:327: GDM_LANG=en_US.UTF-8 agent:2024/02/12 14:53:42 agent.go:327: HOME=/home/qt agent:2024/02/12 14:53:42 agent.go:327: USERNAME=qt agent:2024/02/12 14:53:42 agent.go:327: LANG=en_US.UTF-8 agent:2024/02/12 14:53:42 agent.go:327: XDG_CURRENT_DESKTOP=GNOME-Classic:GNOME agent:2024/02/12 14:53:42 agent.go:327: ANDROID_NDK_ROOT_DEFAULT=/opt/android/android-ndk-r26b agent:2024/02/12 14:53:42 agent.go:327: ANDROID_NDK_HOST=linux-x86_64 agent:2024/02/12 14:53:42 agent.go:327: INVOCATION_ID=b87a5c45f819486e930b830c12173de0 agent:2024/02/12 14:53:42 agent.go:327: MANAGERPID=1089 agent:2024/02/12 14:53:42 agent.go:327: ANDROID_NDK_HOME=/opt/android/android-ndk-r26b agent:2024/02/12 14:53:42 agent.go:327: OPENSSL_ANDROID_HOME_LATEST=/home/qt/prebuilt-openssl-3.0.7-for-android-ndk-r26b agent:2024/02/12 14:53:42 agent.go:327: OPENSSL_ANDROID_HOME_DEFAULT=/home/qt/prebuilt-openssl-3.0.7-for-android-ndk-r26b agent:2024/02/12 14:53:42 agent.go:327: XDG_SESSION_CLASS=user agent:2024/02/12 14:53:42 agent.go:327: LESSOPEN=||/usr/bin/lesspipe.sh %s agent:2024/02/12 14:53:42 agent.go:327: USER=qt agent:2024/02/12 14:53:42 agent.go:327: DISPLAY=:0 agent:2024/02/12 14:53:42 agent.go:327: SHLVL=1 agent:2024/02/12 14:53:42 agent.go:327: ANDROID_SDK_ROOT=/opt/android/sdk agent:2024/02/12 14:53:42 agent.go:327: QT_IM_MODULE=ibus agent:2024/02/12 14:53:42 agent.go:327: DESKTOP_AUTOSTART_ID=1090655dc62bd049e170774953723277900000019440018 agent:2024/02/12 14:53:42 agent.go:327: XDG_RUNTIME_DIR=/run/user/1000 agent:2024/02/12 14:53:42 agent.go:327: which_declare=declare -f agent:2024/02/12 14:53:42 agent.go:327: JOURNAL_STREAM=8:23834 agent:2024/02/12 14:53:42 agent.go:327: ANDROID_NDK_ROOT_LATEST=/opt/android/android-ndk-r26b agent:2024/02/12 14:53:42 agent.go:327: CONAN_V2_MODE=1 agent:2024/02/12 14:53:42 agent.go:327: XDG_DATA_DIRS=/home/qt/.local/share/flatpak/exports/share:/var/lib/flatpak/exports/share:/usr/local/share/:/usr/share/ agent:2024/02/12 14:53:42 agent.go:327: GDK_BACKEND=x11 agent:2024/02/12 14:53:42 agent.go:327: PATH=/opt/dwz-0.13/bin:/opt/cmake-3.27.7/bin:/home/qt/git/bin:/home/qt/sccache_wrapper:/usr/local/sccache:/opt/dwz-0.13/bin:/opt/cmake-3.27.7/bin:/home/qt/git/bin:/home/qt/sccache_wrapper:/usr/local/sccache:/home/qt/.local/bin:/home/qt/bin:/usr/local/bin:/usr/local/sbin:/usr/bin:/usr/sbin agent:2024/02/12 14:53:42 agent.go:327: gRPC_ROOT=/home/qt/install-grpc-1.50.1 agent:2024/02/12 14:53:42 agent.go:327: GDMSESSION=gnome-classic agent:2024/02/12 14:53:42 agent.go:327: DBUS_SESSION_BUS_ADDRESS=unix:path=/run/user/1000/bus agent:2024/02/12 14:53:42 agent.go:327: MAIL=/var/spool/mail/qt agent:2024/02/12 14:53:42 agent.go:327: GIO_LAUNCHED_DESKTOP_FILE_PID=3455 agent:2024/02/12 14:53:42 agent.go:327: GIO_LAUNCHED_DESKTOP_FILE=/home/qt/.config/autostart/coin-bootstrap-agent.desktop agent:2024/02/12 14:53:42 agent.go:327: FBXSDK=/opt/fbx agent:2024/02/12 14:53:42 agent.go:327: ANDROID_EMULATOR_RUNNER=/home/qt/android_emulator_launcher.sh agent:2024/02/12 14:53:42 agent.go:327: TARGET=hdb agent:2024/02/12 14:53:42 agent.go:327: BASH_FUNC_which%%=() { ( alias; eval ${which_declare} ) | /usr/bin/which --tty-only --read-alias --read-functions --show-tilde --show-dot $@ } agent:2024/02/12 14:53:42 agent.go:327: _=/home/qt/agent agent:2024/02/12 14:53:42 agent.go:327: QT_COIN_GIT_DAEMON=10.215.100.35:9418 agent:2024/02/12 14:53:42 agent.go:327: INTEGRATION_ID=1707746690 agent:2024/02/12 14:53:42 agent.go:327: OWNER_HOSTNAME=annoying-dog.on1.qt.io agent:2024/02/12 14:53:42 agent.go:327: COIN_UNIQUE_JOB_ID=1707750846-665-RHEL_9_2 agent:2024/02/12 14:53:42 agent.go:327: TESTED_MODULE_BRANCH_COIN=dev agent:2024/02/12 14:53:42 agent.go:327: TESTED_MODULE_REVISION_COIN=cc7f63db9fe2e2454ec8e980ce1e8f4cddb7534a agent:2024/02/12 14:53:42 agent.go:327: TESTED_MODULE_COIN=qtquicktimeline agent:2024/02/12 14:53:42 agent.go:327: TESTED_MODULE_PLAIN_COIN=quicktimeline agent:2024/02/12 14:53:42 agent.go:327: HOST_OS_COIN=linux agent:2024/02/12 14:53:42 agent.go:327: HOST_OSVERSION_COIN=rhel_9_2 agent:2024/02/12 14:53:42 agent.go:327: HOST_COMPILER_COIN=gcc agent:2024/02/12 14:53:42 agent.go:327: HOST_ARCH_COIN=x86_64 agent:2024/02/12 14:53:42 agent.go:327: TARGET_OS_COIN=linux agent:2024/02/12 14:53:42 agent.go:327: TARGET_OSVERSION_COIN=rhel_9_2 agent:2024/02/12 14:53:42 agent.go:327: TARGET_COMPILER_COIN=gcc agent:2024/02/12 14:53:42 agent.go:327: TARGET_ARCH_COIN=x86_64 agent:2024/02/12 14:53:42 agent.go:327: IPADDRESS=10.215.101.145 agent:2024/02/12 14:53:45 build.go:795: Executing instruction 1 of 58 - ExecuteCommand agent:2024/02/12 14:53:45 build.go:375: Started on background: [/usr/bin/sudo -E telegraf --config /etc/telegraf-coin.conf] 3m0s 3m0s true true agent:2024/02/12 14:53:45 build.go:1190: agent:2024/02/12 14:53:45 build.go:795: Executing instruction 2 of 58 - EnvironmentVariable agent:2024/02/12 14:53:45 build.go:513: set MODULE_ARTIFACTS_RELATIVE_STORAGE_PATH=qt/qtquicktimeline/8b6ee66dccf488f837cd31500243f563eb796f6c/LinuxRHEL_9_2x86_64LinuxRHEL_9_2x86_64GCCqtci-linux-RHEL-9.2-x86_64-51-efd8d5InstallQt5Dependencies_Sccache_UseConfigure/a47471411482031b9e12b31953b2a7594f1019ff/build_1707751894 agent:2024/02/12 14:53:45 build.go:1190: agent:2024/02/12 14:53:45 build.go:795: Executing instruction 3 of 58 - EnvironmentVariable agent:2024/02/12 14:53:45 build.go:513: set MODULE_SOURCES_RELATIVE_STORAGE_PATH=qt/qtquicktimeline/cc7f63db9fe2e2454ec8e980ce1e8f4cddb7534a/sources_unix.tar.gz agent:2024/02/12 14:53:45 build.go:1190: agent:2024/02/12 14:53:45 build.go:795: Executing instruction 4 of 58 - EnvironmentVariable agent:2024/02/12 14:53:45 build.go:513: set MAKEFLAGS=--jobs=2 agent:2024/02/12 14:53:45 build.go:1190: agent:2024/02/12 14:53:45 build.go:795: Executing instruction 5 of 58 - EnvironmentVariable agent:2024/02/12 14:53:45 build.go:513: set NINJAFLAGS=-j2 agent:2024/02/12 14:53:45 build.go:1190: agent:2024/02/12 14:53:45 build.go:795: Executing instruction 6 of 58 - EnvironmentVariable agent:2024/02/12 14:53:45 build.go:513: set CONFIGURE_ARGS=-nomake examples -release -force-debug-info -headersclean -separate-debug-info -qt-libjpeg -qt-libpng -qt-pcre -qt-harfbuzz -qt-doubleconversion -no-libudev -bundled-xcb-xinput agent:2024/02/12 14:53:45 build.go:1190: agent:2024/02/12 14:53:45 build.go:795: Executing instruction 7 of 58 - InstallSourceArchive agent:2024/02/12 14:53:45 storageclient.go:325: Streaming-Unpacking 105823 bytes from "http://10.215.100.35:8080/coin/api/results/qt/qtquicktimeline/cc7f63db9fe2e2454ec8e980ce1e8f4cddb7534a/sources_unix.tar.gz" in "/home/qt/work/qt/qtquicktimeline" agent:2024/02/12 14:53:45 build.go:1190: agent:2024/02/12 14:53:45 build.go:795: Executing instruction 8 of 58 - ChangeDirectory agent:2024/02/12 14:53:45 build.go:820: cd /home/qt/work/qt/qtquicktimeline agent:2024/02/12 14:53:45 build.go:1190: agent:2024/02/12 14:53:45 build.go:795: Executing instruction 9 of 58 - ChangeDirectory agent:2024/02/12 14:53:45 build.go:820: cd /home/qt/work agent:2024/02/12 14:53:45 build.go:1190: agent:2024/02/12 14:53:45 build.go:795: Executing instruction 10 of 58 - WriteFile agent:2024/02/12 14:53:45 build.go:900: Write file: /home/qt/work/../.aws/credentials using FileMode 420 agent:2024/02/12 14:53:45 build.go:1190: agent:2024/02/12 14:53:45 build.go:795: Executing instruction 11 of 58 - EnvironmentVariable agent:2024/02/12 14:53:45 build.go:513: set SCCACHE_ENDPOINT=ci-sccache:9000 agent:2024/02/12 14:53:45 build.go:1190: agent:2024/02/12 14:53:45 build.go:795: Executing instruction 12 of 58 - EnvironmentVariable agent:2024/02/12 14:53:45 build.go:513: set SCCACHE_BUCKET=cache agent:2024/02/12 14:53:45 build.go:1190: agent:2024/02/12 14:53:45 build.go:795: Executing instruction 13 of 58 - ExecuteCommand agent:2024/02/12 14:53:45 build.go:427: [sccache --start-server] 3m0s 3m0s false true agent:2024/02/12 14:53:45 build.go:404: sccache: Starting the server... agent:2024/02/12 14:53:45 build.go:1190: agent:2024/02/12 14:53:45 build.go:795: Executing instruction 14 of 58 - ChangeDirectory agent:2024/02/12 14:53:45 build.go:820: cd /home/qt/work/qt/qtquicktimeline agent:2024/02/12 14:53:45 build.go:1190: agent:2024/02/12 14:53:45 build.go:795: Executing instruction 15 of 58 - EnvironmentVariable agent:2024/02/12 14:53:45 build.go:513: set CMAKE_ARGS=-DOpenGL_GL_PREFERENCE=LEGACY agent:2024/02/12 14:53:45 build.go:1190: agent:2024/02/12 14:53:45 build.go:795: Executing instruction 16 of 58 - EnvironmentVariable agent:2024/02/12 14:53:45 build.go:513: set NON_QTBASE_CMAKE_ARGS=-DFFMPEG_DIR=/usr/local/FFmpeg-n6.1 agent:2024/02/12 14:53:45 build.go:1190: agent:2024/02/12 14:53:45 build.go:795: Executing instruction 17 of 58 - InstallBinaryArchive agent:2024/02/12 14:53:45 storageclient.go:325: Streaming-Unpacking 29076175 bytes from "http://10.215.100.35:8080/coin/api/results/qt/qtshadertools/cac345f747cac212a10b94f681e616b3cf7c6192/LinuxRHEL_9_2x86_64LinuxRHEL_9_2x86_64GCCqtci-linux-RHEL-9.2-x86_64-51-efd8d5InstallQt5Dependencies_Sccache_UseConfigure/a73ba226ef5bbea5cecc62437bd7d065c329528a/build_1707737131/artifacts.tar.gz" in "/home/qt/work" agent:2024/02/12 14:53:45 build.go:1190: agent:2024/02/12 14:53:45 build.go:795: Executing instruction 18 of 58 - InstallBinaryArchive agent:2024/02/12 14:53:45 storageclient.go:325: Streaming-Unpacking 6688303 bytes from "http://10.215.100.35:8080/coin/api/results/qt/qtsvg/9024aa02ccf20cbf8aff4853526d2d2e0dfea85a/LinuxRHEL_9_2x86_64LinuxRHEL_9_2x86_64GCCqtci-linux-RHEL-9.2-x86_64-51-efd8d5InstallQt5Dependencies_Sccache_UseConfigure/a73ba226ef5bbea5cecc62437bd7d065c329528a/build_1707737130/artifacts.tar.gz" in "/home/qt/work" agent:2024/02/12 14:53:45 build.go:1190: agent:2024/02/12 14:53:45 build.go:795: Executing instruction 19 of 58 - InstallBinaryArchive agent:2024/02/12 14:53:46 storageclient.go:325: Streaming-Unpacking 3606372 bytes from "http://10.215.100.35:8080/coin/api/results/qt/qtimageformats/61c4d0a0e250de50aae81452e5a8f01b5b4ffaf9/LinuxRHEL_9_2x86_64LinuxRHEL_9_2x86_64GCCqtci-linux-RHEL-9.2-x86_64-51-efd8d5InstallQt5Dependencies_Sccache_UseConfigure/a73ba226ef5bbea5cecc62437bd7d065c329528a/build_1707737132/artifacts.tar.gz" in "/home/qt/work" agent:2024/02/12 14:53:46 build.go:1190: agent:2024/02/12 14:53:46 build.go:795: Executing instruction 20 of 58 - InstallBinaryArchive agent:2024/02/12 14:53:46 storageclient.go:325: Streaming-Unpacking 866414203 bytes from "http://10.215.100.35:8080/coin/api/results/qt/qtdeclarative/90eb43d56c2ddceb76d70dfd51a200be4daa9b13/LinuxRHEL_9_2x86_64LinuxRHEL_9_2x86_64GCCqtci-linux-RHEL-9.2-x86_64-51-efd8d5InstallQt5Dependencies_Sccache_UseConfigure/1ede166fa417acc27e7ffcc5356ac356bfc1f6e9/build_1707751886/artifacts.tar.gz" in "/home/qt/work" agent:2024/02/12 14:54:01 build.go:1190: agent:2024/02/12 14:54:01 build.go:795: Executing instruction 21 of 58 - InstallBinaryArchive agent:2024/02/12 14:54:01 storageclient.go:325: Streaming-Unpacking 11626468 bytes from "http://10.215.100.35:8080/coin/api/results/qt/qtlanguageserver/3bdce38490ddac67a509832e00ce2381ecf5cf84/LinuxRHEL_9_2x86_64LinuxRHEL_9_2x86_64GCCqtci-linux-RHEL-9.2-x86_64-51-efd8d5InstallQt5Dependencies_Sccache_UseConfigure/a73ba226ef5bbea5cecc62437bd7d065c329528a/build_1707737133/artifacts.tar.gz" in "/home/qt/work" agent:2024/02/12 14:54:01 build.go:1190: agent:2024/02/12 14:54:01 build.go:795: Executing instruction 22 of 58 - InstallBinaryArchive agent:2024/02/12 14:54:01 storageclient.go:325: Streaming-Unpacking 438498575 bytes from "http://10.215.100.35:8080/coin/api/results/qt/qtbase/1fc1a473a3243524ff430899e1cadd49f9aa8058/LinuxRHEL_9_2x86_64LinuxRHEL_9_2x86_64GCCqtci-linux-RHEL-9.2-x86_64-51-efd8d5InstallQt5Dependencies_Sccache_UseConfigure/9d3196b5420d6faa8c61da85c983872e3dbf0172/build_1707737129/artifacts.tar.gz" in "/home/qt/work" agent:2024/02/12 14:54:09 build.go:1190: agent:2024/02/12 14:54:09 build.go:795: Executing instruction 23 of 58 - InstallBinaryArchive agent:2024/02/12 14:54:09 storageclient.go:325: Streaming-Unpacking 5875997 bytes from "http://10.215.100.35:8080/coin/api/results/qt/qtquicktimeline/8b6ee66dccf488f837cd31500243f563eb796f6c/LinuxRHEL_9_2x86_64LinuxRHEL_9_2x86_64GCCqtci-linux-RHEL-9.2-x86_64-51-efd8d5InstallQt5Dependencies_Sccache_UseConfigure/a47471411482031b9e12b31953b2a7594f1019ff/build_1707751894/artifacts.tar.gz" in "/home/qt/work" agent:2024/02/12 14:54:09 build.go:1190: agent:2024/02/12 14:54:09 build.go:795: Executing instruction 24 of 58 - EnvironmentVariable agent:2024/02/12 14:54:09 build.go:513: set CMAKE_GENERATOR=Ninja agent:2024/02/12 14:54:09 build.go:1190: agent:2024/02/12 14:54:09 build.go:795: Executing instruction 25 of 58 - EnvironmentVariable agent:2024/02/12 14:54:09 build.go:513: set CI_PATH_SEP=/ agent:2024/02/12 14:54:09 build.go:1190: agent:2024/02/12 14:54:09 build.go:795: Executing instruction 26 of 58 - PrependToEnvironmentVariable agent:2024/02/12 14:54:09 build.go:513: set COMMON_CMAKE_ARGS=-DCMAKE_C_COMPILER=gcc -DCMAKE_CXX_COMPILER=g++ agent:2024/02/12 14:54:09 build.go:1190: agent:2024/02/12 14:54:09 build.go:795: Executing instruction 27 of 58 - EnvironmentVariable agent:2024/02/12 14:54:09 build.go:515: unset ENV_PREFIX agent:2024/02/12 14:54:09 build.go:1190: agent:2024/02/12 14:54:09 build.go:795: Executing instruction 28 of 58 - EnvironmentVariable agent:2024/02/12 14:54:09 build.go:515: unset TARGET_ENV_PREFIX agent:2024/02/12 14:54:09 build.go:1190: agent:2024/02/12 14:54:09 build.go:795: Executing instruction 29 of 58 - AppendToEnvironmentVariable agent:2024/02/12 14:54:09 build.go:513: set COMMON_CMAKE_ARGS=-DCMAKE_C_COMPILER=gcc -DCMAKE_CXX_COMPILER=g++ -DQT_BUILD_TESTS=OFF -DCMAKE_AUTOGEN_VERBOSE=ON -DCMAKE_MESSAGE_LOG_LEVEL=STATUS agent:2024/02/12 14:54:09 build.go:1190: agent:2024/02/12 14:54:09 build.go:795: Executing instruction 30 of 58 - AppendToEnvironmentVariable agent:2024/02/12 14:54:09 build.go:513: set COMMON_NON_QTBASE_CMAKE_ARGS= -DQT_BUILD_TESTS=OFF -DCMAKE_AUTOGEN_VERBOSE=ON -DCMAKE_MESSAGE_LOG_LEVEL=STATUS agent:2024/02/12 14:54:09 build.go:1190: agent:2024/02/12 14:54:09 build.go:795: Executing instruction 31 of 58 - AppendToEnvironmentVariable agent:2024/02/12 14:54:09 build.go:513: set COMMON_TEST_CMAKE_ARGS= -DCMAKE_AUTOGEN_VERBOSE=ON -DCMAKE_MESSAGE_LOG_LEVEL=STATUS agent:2024/02/12 14:54:09 build.go:1190: agent:2024/02/12 14:54:09 build.go:795: Executing instruction 32 of 58 - AppendToEnvironmentVariable agent:2024/02/12 14:54:09 build.go:513: set COMMON_TARGET_CMAKE_ARGS= -DQT_BUILD_TESTS=OFF -DCMAKE_AUTOGEN_VERBOSE=ON -DCMAKE_MESSAGE_LOG_LEVEL=STATUS agent:2024/02/12 14:54:09 build.go:1190: agent:2024/02/12 14:54:09 build.go:795: Executing instruction 33 of 58 - AppendToEnvironmentVariable agent:2024/02/12 14:54:09 build.go:513: set COMMON_NON_QTBASE_TARGET_CMAKE_ARGS= -DQT_BUILD_TESTS=OFF -DCMAKE_AUTOGEN_VERBOSE=ON -DCMAKE_MESSAGE_LOG_LEVEL=STATUS agent:2024/02/12 14:54:09 build.go:1190: agent:2024/02/12 14:54:09 build.go:795: Executing instruction 34 of 58 - AppendToEnvironmentVariable agent:2024/02/12 14:54:09 build.go:513: set COMMON_TARGET_TEST_CMAKE_ARGS= -DCMAKE_AUTOGEN_VERBOSE=ON -DCMAKE_MESSAGE_LOG_LEVEL=STATUS agent:2024/02/12 14:54:09 build.go:1190: agent:2024/02/12 14:54:09 build.go:795: Executing instruction 35 of 58 - AppendToEnvironmentVariable agent:2024/02/12 14:54:09 build.go:513: set COMMON_CMAKE_ARGS=-DCMAKE_C_COMPILER=gcc -DCMAKE_CXX_COMPILER=g++ -DQT_BUILD_TESTS=OFF -DCMAKE_AUTOGEN_VERBOSE=ON -DCMAKE_MESSAGE_LOG_LEVEL=STATUS -DCMAKE_C_COMPILER_LAUNCHER=sccache -DCMAKE_CXX_COMPILER_LAUNCHER=sccache agent:2024/02/12 14:54:09 build.go:1190: agent:2024/02/12 14:54:09 build.go:795: Executing instruction 36 of 58 - AppendToEnvironmentVariable agent:2024/02/12 14:54:09 build.go:513: set COMMON_NON_QTBASE_CMAKE_ARGS= -DQT_BUILD_TESTS=OFF -DCMAKE_AUTOGEN_VERBOSE=ON -DCMAKE_MESSAGE_LOG_LEVEL=STATUS -DCMAKE_C_COMPILER_LAUNCHER=sccache -DCMAKE_CXX_COMPILER_LAUNCHER=sccache agent:2024/02/12 14:54:09 build.go:1190: agent:2024/02/12 14:54:09 build.go:795: Executing instruction 37 of 58 - AppendToEnvironmentVariable agent:2024/02/12 14:54:09 build.go:513: set COMMON_TEST_CMAKE_ARGS= -DCMAKE_AUTOGEN_VERBOSE=ON -DCMAKE_MESSAGE_LOG_LEVEL=STATUS -DCMAKE_C_COMPILER_LAUNCHER=sccache -DCMAKE_CXX_COMPILER_LAUNCHER=sccache agent:2024/02/12 14:54:09 build.go:1190: agent:2024/02/12 14:54:09 build.go:795: Executing instruction 38 of 58 - AppendToEnvironmentVariable agent:2024/02/12 14:54:09 build.go:513: set COMMON_TARGET_CMAKE_ARGS= -DQT_BUILD_TESTS=OFF -DCMAKE_AUTOGEN_VERBOSE=ON -DCMAKE_MESSAGE_LOG_LEVEL=STATUS -DCMAKE_C_COMPILER_LAUNCHER=sccache -DCMAKE_CXX_COMPILER_LAUNCHER=sccache agent:2024/02/12 14:54:09 build.go:1190: agent:2024/02/12 14:54:09 build.go:795: Executing instruction 39 of 58 - AppendToEnvironmentVariable agent:2024/02/12 14:54:09 build.go:513: set COMMON_NON_QTBASE_TARGET_CMAKE_ARGS= -DQT_BUILD_TESTS=OFF -DCMAKE_AUTOGEN_VERBOSE=ON -DCMAKE_MESSAGE_LOG_LEVEL=STATUS -DCMAKE_C_COMPILER_LAUNCHER=sccache -DCMAKE_CXX_COMPILER_LAUNCHER=sccache agent:2024/02/12 14:54:09 build.go:1190: agent:2024/02/12 14:54:09 build.go:795: Executing instruction 40 of 58 - AppendToEnvironmentVariable agent:2024/02/12 14:54:09 build.go:513: set COMMON_TARGET_TEST_CMAKE_ARGS= -DCMAKE_AUTOGEN_VERBOSE=ON -DCMAKE_MESSAGE_LOG_LEVEL=STATUS -DCMAKE_C_COMPILER_LAUNCHER=sccache -DCMAKE_CXX_COMPILER_LAUNCHER=sccache agent:2024/02/12 14:54:09 build.go:1190: agent:2024/02/12 14:54:09 build.go:795: Executing instruction 43 of 58 - EnvironmentVariable agent:2024/02/12 14:54:09 build.go:513: set HOST_INSTALL_DIR=/home/qt/work/install agent:2024/02/12 14:54:09 build.go:1190: agent:2024/02/12 14:54:09 build.go:795: Executing instruction 44 of 58 - EnvironmentVariable agent:2024/02/12 14:54:09 build.go:513: set LIBEXEC_INSTALL_DIR=/home/qt/work/install/libexec/ agent:2024/02/12 14:54:09 build.go:1190: agent:2024/02/12 14:54:09 build.go:795: Executing instruction 45 of 58 - EnvironmentVariable agent:2024/02/12 14:54:09 build.go:513: set COIN_COMMAND_OUTPUT_TIMEOUT=900 agent:2024/02/12 14:54:09 build.go:1190: agent:2024/02/12 14:54:09 build.go:795: Executing instruction 46 of 58 - EnvironmentVariable agent:2024/02/12 14:54:09 build.go:513: set QTEST_ENVIRONMENT=ci agent:2024/02/12 14:54:09 build.go:1190: agent:2024/02/12 14:54:09 build.go:795: Executing instruction 47 of 58 - EnvironmentVariable agent:2024/02/12 14:54:09 build.go:515: unset TESTS_ENV_PREFIX agent:2024/02/12 14:54:09 build.go:1190: agent:2024/02/12 14:54:09 build.go:795: Executing instruction 48 of 58 - MakeDirectory agent:2024/02/12 14:54:09 build.go:826: mkdir /home/qt/work/qt/qtquicktimeline_standalone_tests agent:2024/02/12 14:54:09 build.go:1190: agent:2024/02/12 14:54:09 build.go:795: Executing instruction 49 of 58 - InstallTestBinaryArchive agent:2024/02/12 14:54:09 storageclient.go:325: Streaming-Unpacking 2033339 bytes from "http://10.215.100.35:8080/coin/api/results/qt/qtquicktimeline/8b6ee66dccf488f837cd31500243f563eb796f6c/LinuxRHEL_9_2x86_64LinuxRHEL_9_2x86_64GCCqtci-linux-RHEL-9.2-x86_64-51-efd8d5InstallQt5Dependencies_Sccache_UseConfigure/a47471411482031b9e12b31953b2a7594f1019ff/build_1707751894/tests.tar.gz" in "/home/qt/work/qt/qtquicktimeline_standalone_tests" agent:2024/02/12 14:54:09 build.go:1190: agent:2024/02/12 14:54:09 build.go:795: Executing instruction 50 of 58 - ChangeDirectory agent:2024/02/12 14:54:09 build.go:820: cd /home/qt/work/qt/qtquicktimeline_standalone_tests agent:2024/02/12 14:54:09 build.go:1190: agent:2024/02/12 14:54:09 build.go:795: Executing instruction 51 of 58 - ScheduleUploadTestResults agent:2024/02/12 14:54:09 build.go:1190: agent:2024/02/12 14:54:09 build.go:795: Executing instruction 52 of 58 - PrependToEnvironmentVariable agent:2024/02/12 14:54:09 build.go:513: set PATH=:/opt/dwz-0.13/bin:/opt/cmake-3.27.7/bin:/home/qt/git/bin:/home/qt/sccache_wrapper:/usr/local/sccache:/opt/dwz-0.13/bin:/opt/cmake-3.27.7/bin:/home/qt/git/bin:/home/qt/sccache_wrapper:/usr/local/sccache:/home/qt/.local/bin:/home/qt/bin:/usr/local/bin:/usr/local/sbin:/usr/bin:/usr/sbin agent:2024/02/12 14:54:09 build.go:1190: agent:2024/02/12 14:54:09 build.go:795: Executing instruction 53 of 58 - EnvironmentVariable agent:2024/02/12 14:54:09 build.go:513: set TESTRUNNER=/home/qt/work/install/libexec/qt-testrunner.py -- agent:2024/02/12 14:54:09 build.go:1190: agent:2024/02/12 14:54:09 build.go:795: Executing instruction 54 of 58 - EnvironmentVariable agent:2024/02/12 14:54:09 build.go:513: set COIN_CTEST_RESULTSDIR=/home/qt/work/testresults agent:2024/02/12 14:54:09 build.go:1190: agent:2024/02/12 14:54:09 build.go:795: Executing instruction 55 of 58 - EnvironmentVariable agent:2024/02/12 14:54:09 build.go:513: set CTEST_ARGS=-V agent:2024/02/12 14:54:09 build.go:1190: agent:2024/02/12 14:54:09 build.go:795: Executing instruction 56 of 58 - EnvironmentVariable agent:2024/02/12 14:54:09 build.go:513: set CTEST_OUTPUT_ON_FAILURE=1 agent:2024/02/12 14:54:09 build.go:1190: agent:2024/02/12 14:54:09 build.go:795: Executing instruction 57 of 58 - AppendToEnvironmentVariable agent:2024/02/12 14:54:09 build.go:513: set CTEST_ARGS=-V --output-junit /home/qt/work/testresults/test_summary.ctest_junit_xml agent:2024/02/12 14:54:09 build.go:1190: agent:2024/02/12 14:54:09 build.go:795: Executing instruction 58 of 58 - ExecuteCommand agent:2024/02/12 14:54:09 build.go:427: [ctest -V --output-junit /home/qt/work/testresults/test_summary.ctest_junit_xml] 3h0m0s 15m0s false false agent:2024/02/12 14:54:10 build.go:404: UpdateCTestConfiguration from :/home/qt/work/qt/qtquicktimeline_standalone_tests/DartConfiguration.tcl agent:2024/02/12 14:54:10 build.go:404: Parse Config file:/home/qt/work/qt/qtquicktimeline_standalone_tests/DartConfiguration.tcl agent:2024/02/12 14:54:10 build.go:404: UpdateCTestConfiguration from :/home/qt/work/qt/qtquicktimeline_standalone_tests/DartConfiguration.tcl agent:2024/02/12 14:54:10 build.go:404: Parse Config file:/home/qt/work/qt/qtquicktimeline_standalone_tests/DartConfiguration.tcl agent:2024/02/12 14:54:10 build.go:404: Test project /home/qt/work/qt/qtquicktimeline_standalone_tests agent:2024/02/12 14:54:10 build.go:404: Constructing a list of tests agent:2024/02/12 14:54:10 build.go:404: Done constructing a list of tests agent:2024/02/12 14:54:10 build.go:404: Updating test list for fixtures agent:2024/02/12 14:54:10 build.go:404: Added 0 tests to meet fixture requirements agent:2024/02/12 14:54:10 build.go:404: Checking test dependency graph... agent:2024/02/12 14:54:10 build.go:404: Checking test dependency graph end agent:2024/02/12 14:54:10 build.go:404: test 1 agent:2024/02/12 14:54:10 build.go:404: Start 1: tst_qtquicktimeline agent:2024/02/12 14:54:10 build.go:404: 1: Test command: /opt/cmake-3.27.7/bin/cmake "-P" "/home/qt/work/qt/qtquicktimeline_standalone_tests/tests/auto/qtquicktimeline/tst_qtquicktimelineWrapperRelWithDebInfo.cmake" agent:2024/02/12 14:54:10 build.go:404: 1: Working Directory: /home/qt/work/qt/qtquicktimeline_standalone_tests/tests/auto/qtquicktimeline agent:2024/02/12 14:54:10 build.go:404: 1: Test timeout computed to be: 1500 agent:2024/02/12 14:54:11 build.go:404: 1: qt-testrunner.py INFO: Will write XML test logs to directory COIN_CTEST_RESULTSDIR=/home/qt/work/testresults agent:2024/02/12 14:54:11 build.go:404: 1: qt-testrunner.py DEBUG: Running test command line: ['/home/qt/work/qt/qtquicktimeline_standalone_tests/tests/auto/qtquicktimeline/tst_qtquicktimeline', '-o', '/home/qt/work/testresults/tst_qtquicktimeline-1707749651057.xml,xml', '-o', '/home/qt/work/testresults/tst_qtquicktimeline-1707749651057.junit.xml,junitxml', '-o', '/home/qt/work/testresults/tst_qtquicktimeline-1707749651057.txt,txt', '-o', '-,txt'] agent:2024/02/12 14:54:11 build.go:404: 1: ********* Start testing of Tst_QtQuickTimeline ********* agent:2024/02/12 14:54:11 build.go:404: 1: Config: Using QtTest library 6.8.0, Qt 6.8.0 (x86_64-little_endian-lp64 shared (dynamic) release build; by GCC 11.3.1 20221121 (Red Hat 11.3.1-4)), rhel 9.2 agent:2024/02/12 14:54:11 build.go:404: 1: PASS : Tst_QtQuickTimeline::initTestCase() agent:2024/02/12 14:54:11 build.go:404: 1: PASS : Tst_QtQuickTimeline::checkImport() agent:2024/02/12 14:54:12 build.go:404: 1: PASS : Tst_QtQuickTimeline::simpleTest() agent:2024/02/12 14:54:12 build.go:404: 1: PASS : Tst_QtQuickTimeline::parameterization() agent:2024/02/12 14:54:12 build.go:404: 1: PASS : Tst_QtQuickTimeline::vectors() agent:2024/02/12 14:54:12 build.go:404: 1: PASS : Tst_QtQuickTimeline::deltaFunction() agent:2024/02/12 14:54:12 build.go:404: 1: PASS : Tst_QtQuickTimeline::keyframeUpdate() agent:2024/02/12 14:54:12 build.go:404: 1: PASS : Tst_QtQuickTimeline::easingcurveInterpolation() agent:2024/02/12 14:54:12 build.go:404: 1: PASS : Tst_QtQuickTimeline::cleanupTestCase() agent:2024/02/12 14:54:12 build.go:404: 1: Totals: 9 passed, 0 failed, 0 skipped, 0 blacklisted, 935ms agent:2024/02/12 14:54:12 build.go:404: 1: ********* Finished testing of Tst_QtQuickTimeline ********* agent:2024/02/12 14:54:12 build.go:404: 1: qt-testrunner.py INFO: Test process exited with code: 0 agent:2024/02/12 14:54:12 build.go:404: 1: qt-testrunner.py INFO: Parsed XML file /home/qt/work/testresults/tst_qtquicktimeline-1707749651057.xml in 0.000 seconds agent:2024/02/12 14:54:12 build.go:404: 1: qt-testrunner.py INFO: Found 9 passes and 0 failures agent:2024/02/12 14:54:12 build.go:404: 1/2 Test #1: tst_qtquicktimeline .............. Passed 1.89 sec agent:2024/02/12 14:54:12 build.go:404: test 2 agent:2024/02/12 14:54:12 build.go:404: Start 2: tst_blendtrees agent:2024/02/12 14:54:12 build.go:404: 2: Test command: /opt/cmake-3.27.7/bin/cmake "-P" "/home/qt/work/qt/qtquicktimeline_standalone_tests/tests/auto/qtquicktimeline_blendtrees/tst_blendtreesWrapperRelWithDebInfo.cmake" agent:2024/02/12 14:54:12 build.go:404: 2: Working Directory: /home/qt/work/qt/qtquicktimeline_standalone_tests/tests/auto/qtquicktimeline_blendtrees agent:2024/02/12 14:54:12 build.go:404: 2: Test timeout computed to be: 1500 agent:2024/02/12 14:54:12 build.go:404: 2: qt-testrunner.py INFO: Will write XML test logs to directory COIN_CTEST_RESULTSDIR=/home/qt/work/testresults agent:2024/02/12 14:54:12 build.go:404: 2: qt-testrunner.py DEBUG: Running test command line: ['/home/qt/work/qt/qtquicktimeline_standalone_tests/tests/auto/qtquicktimeline_blendtrees/tst_blendtrees', '-o', '/home/qt/work/testresults/tst_blendtrees-1707749652262.xml,xml', '-o', '/home/qt/work/testresults/tst_blendtrees-1707749652262.junit.xml,junitxml', '-o', '/home/qt/work/testresults/tst_blendtrees-1707749652262.txt,txt', '-o', '-,txt'] agent:2024/02/12 14:54:12 build.go:404: 2: ********* Start testing of Tst_BlendTrees ********* agent:2024/02/12 14:54:12 build.go:404: 2: Config: Using QtTest library 6.8.0, Qt 6.8.0 (x86_64-little_endian-lp64 shared (dynamic) release build; by GCC 11.3.1 20221121 (Red Hat 11.3.1-4)), rhel 9.2 agent:2024/02/12 14:54:12 build.go:404: 2: PASS : Tst_BlendTrees::initTestCase() agent:2024/02/12 14:54:12 build.go:404: 2: PASS : Tst_BlendTrees::checkImport() agent:2024/02/12 14:54:12 build.go:404: 2: PASS : Tst_BlendTrees::testBlendAnimationNode() agent:2024/02/12 14:54:12 build.go:404: 2: PASS : Tst_BlendTrees::cleanupTestCase() agent:2024/02/12 14:54:12 build.go:404: 2: Totals: 4 passed, 0 failed, 0 skipped, 0 blacklisted, 26ms agent:2024/02/12 14:54:12 build.go:404: 2: ********* Finished testing of Tst_BlendTrees ********* agent:2024/02/12 14:54:12 build.go:404: 2: qt-testrunner.py INFO: Test process exited with code: 0 agent:2024/02/12 14:54:12 build.go:404: 2: qt-testrunner.py INFO: Parsed XML file /home/qt/work/testresults/tst_blendtrees-1707749652262.xml in 0.000 seconds agent:2024/02/12 14:54:12 build.go:404: 2: qt-testrunner.py INFO: Found 4 passes and 0 failures agent:2024/02/12 14:54:12 build.go:404: 2/2 Test #2: tst_blendtrees ................... Passed 0.19 sec agent:2024/02/12 14:54:12 build.go:404: 100% tests passed, 0 tests failed out of 2 agent:2024/02/12 14:54:12 build.go:404: Label Time Summary: agent:2024/02/12 14:54:12 build.go:404: tests/auto/qtquicktimeline/tst_qtquicktimeline = 1.89 sec*proc (1 test) agent:2024/02/12 14:54:12 build.go:404: tests/auto/qtquicktimeline_blendtrees/tst_blendtrees = 0.19 sec*proc (1 test) agent:2024/02/12 14:54:12 build.go:404: Total Test time (real) = 2.10 sec agent:2024/02/12 14:54:12 build.go:1190: agent:2024/02/12 14:54:12 build.go:755: Executing scheduled instruction 1 of 3 - Upload all core dumps if there are some agent:2024/02/12 14:54:12 build.go:652: Skip uploading core files because CORE_FILES_PATH is not set in the environment agent:2024/02/12 14:54:12 build.go:763: agent:2024/02/12 14:54:12 build.go:755: Executing scheduled instruction 2 of 3 - Print sccache statistics agent:2024/02/12 14:54:12 build.go:427: [sccache -s] 30s 30s false true agent:2024/02/12 14:54:12 build.go:404: Compile requests 0 agent:2024/02/12 14:54:12 build.go:404: Compile requests executed 0 agent:2024/02/12 14:54:12 build.go:404: Cache hits 0 agent:2024/02/12 14:54:12 build.go:404: Cache misses 0 agent:2024/02/12 14:54:12 build.go:404: Cache timeouts 0 agent:2024/02/12 14:54:12 build.go:404: Cache read errors 0 agent:2024/02/12 14:54:12 build.go:404: Forced recaches 0 agent:2024/02/12 14:54:12 build.go:404: Cache write errors 0 agent:2024/02/12 14:54:12 build.go:404: Compilation failures 0 agent:2024/02/12 14:54:12 build.go:404: Cache errors 0 agent:2024/02/12 14:54:12 build.go:404: Non-cacheable compilations 0 agent:2024/02/12 14:54:12 build.go:404: Non-cacheable calls 0 agent:2024/02/12 14:54:12 build.go:404: Non-compilation calls 0 agent:2024/02/12 14:54:12 build.go:404: Unsupported compiler calls 0 agent:2024/02/12 14:54:12 build.go:404: Average cache write 0.000 s agent:2024/02/12 14:54:12 build.go:404: Average cache read miss 0.000 s agent:2024/02/12 14:54:12 build.go:404: Average cache read hit 0.000 s agent:2024/02/12 14:54:12 build.go:404: Failed distributed compilations 0 agent:2024/02/12 14:54:12 build.go:404: Cache location S3, bucket: Bucket(name=cache, base_url=http://ci-sccache:9000/cache/) agent:2024/02/12 14:54:12 build.go:763: agent:2024/02/12 14:54:12 build.go:755: Executing scheduled instruction 3 of 3 - Upload test results agent:2024/02/12 14:54:12 storageclient.go:532: Collecting test results, archiving and uploading them agent:2024/02/12 14:54:12 result.go:216: Collecting 7 test results ... agent:2024/02/12 14:54:12 build.go:763: agent:2024/02/12 14:54:12 agent.go:385: Test succeeded INFO:workitem.py:688(13530): Agent FINISHED PASS: qt/qtquicktimeline/8b6ee66dccf488f837cd31500243f563eb796f6c/LinuxRHEL_9_2x86_64LinuxRHEL_9_2x86_64GCCqtci-linux-RHEL-9.2-x86_64-51-efd8d5InstallQt5Dependencies_Sccache_UseConfigure/a47471411482031b9e12b31953b2a7594f1019ff/Test INFO:workitem.py:770(13530): VM metrics INFO:workitem.py:773(13530): Host metrics