Task 62086609373

refactor: separate log generation from log handling

2026-01-31 14:06:58 completed pr/mlog 9569400e51aa04dbbb99f4ee9162bdacafa0a818


Commands that took longer than 1 second (total 15m21s)
linedurationpercentagecommand
8210s0%dirname ./ci/test/00_setup_env.sh
8220s0%cd ./ci/test/../../
8230s0%pwd
8240s0%BASE_READ_ONLY_DIR=/home/admin/actions-runner/_work/bitcoin/bitcoin
8250s0%export BASE_READ_ONLY_DIR
8260s0%export BASE_ROOT_DIR=/home/admin/actions-runner/_work/_temp
8270s0%BASE_ROOT_DIR=/home/admin/actions-runner/_work/_temp
8280s0%export DEPENDS_DIR=/home/admin/actions-runner/_work/_temp/depends
8290s0%DEPENDS_DIR=/home/admin/actions-runner/_work/_temp/depends
8300s0%export BASE_SCRATCH_DIR=/home/admin/actions-runner/_work/_temp/ci/scratch
8310s0%BASE_SCRATCH_DIR=/home/admin/actions-runner/_work/_temp/ci/scratch
8320s0%echo 'Setting specific values in env'
8330s0%'[' -n ./ci/test/00_setup_env_i686_no_ipc.sh ']'
8340s0%set -o errexit
8350s0%source ./ci/test/00_setup_env_i686_no_ipc.sh
8360s0%export LC_ALL=C.UTF-8
8370s0%LC_ALL=C.UTF-8
8380s0%export HOST=i686-pc-linux-gnu
8390s0%HOST=i686-pc-linux-gnu
8400s0%export CONTAINER_NAME=ci_i686_no_multiprocess
8410s0%CONTAINER_NAME=ci_i686_no_multiprocess
8420s0%export CI_IMAGE_NAME_TAG=mirror.gcr.io/debian:trixie
8430s0%CI_IMAGE_NAME_TAG=mirror.gcr.io/debian:trixie
8440s0%export CI_IMAGE_PLATFORM=linux/amd64
8450s0%CI_IMAGE_PLATFORM=linux/amd64
8460s0%export 'PACKAGES=llvm clang g++-multilib'
8470s0%PACKAGES='llvm clang g++-multilib'
8480s0%export 'DEP_OPTS=DEBUG=1 NO_IPC=1'
8490s0%DEP_OPTS='DEBUG=1 NO_IPC=1'
8500s0%export GOAL=install
8510s0%GOAL=install
8520s0%export CI_LIMIT_STACK_SIZE=1
8530s0%CI_LIMIT_STACK_SIZE=1
8540s0%export 'TEST_RUNNER_EXTRA=--v2transport --usecli'
8550s0%TEST_RUNNER_EXTRA='--v2transport --usecli'
8560s0%export 'BITCOIN_CONFIG= --preset=dev-mode -DENABLE_IPC=OFF -DCMAKE_BUILD_TYPE=Debug -DCMAKE_C_COMPILER='\''clang;-m32'\'' -DCMAKE_CXX_COMPILER='\''clang++;-m32'\'' -DAPPEND_CPPFLAGS='\''-DBOOST_MULTI_INDEX_ENABLE_SAFE_MODE'\'' '
8570s0%BITCOIN_CONFIG=' --preset=dev-mode -DENABLE_IPC=OFF -DCMAKE_BUILD_TYPE=Debug -DCMAKE_C_COMPILER='\''clang;-m32'\'' -DCMAKE_CXX_COMPILER='\''clang++;-m32'\'' -DAPPEND_CPPFLAGS='\''-DBOOST_MULTI_INDEX_ENABLE_SAFE_MODE'\'' '
8580s0%echo 'Fallback to default values in env (if not yet set)'
8610s0%command -v nproc
8620s0%nproc
8630s0%export MAKEJOBS=-j8
8640s0%MAKEJOBS=-j8
8650s0%export RUN_UNIT_TESTS=true
8660s0%RUN_UNIT_TESTS=true
8670s0%export RUN_FUNCTIONAL_TESTS=true
8680s0%RUN_FUNCTIONAL_TESTS=true
8690s0%export RUN_TIDY=false
8700s0%RUN_TIDY=false
8710s0%export TEST_RUNNER_TIMEOUT_FACTOR=40
8720s0%TEST_RUNNER_TIMEOUT_FACTOR=40
8730s0%export RUN_FUZZ_TESTS=false
8740s0%RUN_FUZZ_TESTS=false
8750s0%export BOOST_TEST_RANDOM=1
8760s0%BOOST_TEST_RANDOM=1
8770s0%export DEBIAN_FRONTEND=noninteractive
8780s0%DEBIAN_FRONTEND=noninteractive
8790s0%export CCACHE_MAXSIZE=500M
8800s0%CCACHE_MAXSIZE=500M
8810s0%export CCACHE_TEMPDIR=/tmp/.ccache-temp
8820s0%CCACHE_TEMPDIR=/tmp/.ccache-temp
8830s0%export CCACHE_COMPRESS=1
8840s0%CCACHE_COMPRESS=1
8850s0%export CCACHE_DIR=/home/admin/actions-runner/_work/_temp/ccache_dir
8860s0%CCACHE_DIR=/home/admin/actions-runner/_work/_temp/ccache_dir
8870s0%export BASE_OUTDIR=/home/admin/actions-runner/_work/_temp/ci/scratch/out
8880s0%BASE_OUTDIR=/home/admin/actions-runner/_work/_temp/ci/scratch/out
8890s0%export PREVIOUS_RELEASES_DIR=/home/admin/actions-runner/_work/_temp/previous_releases
8900s0%PREVIOUS_RELEASES_DIR=/home/admin/actions-runner/_work/_temp/previous_releases
8910s0%export 'CI_BASE_PACKAGES=build-essential pkgconf curl ca-certificates ccache python3-dev rsync git procps bison e2fsprogs cmake ninja-build'
8920s0%CI_BASE_PACKAGES='build-essential pkgconf curl ca-certificates ccache python3-dev rsync git procps bison e2fsprogs cmake ninja-build'
8930s0%export GOAL=install
8940s0%GOAL=install
8950s0%export DIR_QA_ASSETS=/home/admin/actions-runner/_work/_temp/ci/scratch/qa-assets
8960s0%DIR_QA_ASSETS=/home/admin/actions-runner/_work/_temp/ci/scratch/qa-assets
8970s0%export CI_RETRY_EXE=retry
8980s0%CI_RETRY_EXE=retry
8990s0%export CI_IMAGE_PLATFORM=linux/amd64
9000s0%CI_IMAGE_PLATFORM=linux/amd64
9010s0%set -o errexit
9020s0%./ci/test/02_run_container.py
9040s0%bash -c 'grep export ./ci/test/00_setup_env*.sh'
9050s0%cat /tmp/env-admin-ci_i686_no_multiprocess
94120s2%docker buildx build --file=/home/admin/actions-runner/_work/bitcoin/bitcoin/ci/test_imagefile --build-arg=CI_IMAGE_NAME_TAG=mirror.gcr.io/debian:trixie --build-arg=FILE_ENV=./ci/test/00_setup_env_i686_no_ipc.sh --build-arg=BASE_ROOT_DIR=/home/admin/actions-runner/_work/_temp --platform=linux/amd64 --label=bitcoin-ci-test --tag=ci_i686_no_multiprocess --cache-from type=gha,url=http://127.0.0.1:12321/,url_v2=http://127.0.0.1:12321/,scope=ci_i686_no_multiprocess --load /home/admin/actions-runner/_work/bitcoin/bitcoin
10150s0%docker volume create ci_i686_no_multiprocess_ccache
10170s0%docker volume create ci_i686_no_multiprocess_depends
10190s0%docker volume create ci_i686_no_multiprocess_depends_sources
10210s0%docker volume create ci_i686_no_multiprocess_previous_releases
10230s0%docker network create --ipv6 --subnet 1111:1111::/112 ci-ip6net
10260s0%docker image prune --force --filter label=bitcoin-ci-test
10280s0%docker run --rm --interactive --detach --tty --cap-add=LINUX_IMMUTABLE --mount=type=bind,src=/home/admin/actions-runner/_work/bitcoin/bitcoin,dst=/home/admin/actions-runner/_work/bitcoin/bitcoin,readonly --mount=type=bind,src=/home/admin/actions-runner/_work/_temp/ccache_dir,dst=/home/admin/actions-runner/_work/_temp/ccache_dir --mount=type=bind,src=/home/admin/actions-runner/_work/_temp/depends/built,dst=/home/admin/actions-runner/_work/_temp/depends/built --mount=type=bind,src=/home/admin/actions-runner/_work/_temp/depends/sources,dst=/home/admin/actions-runner/_work/_temp/depends/sources --mount=type=bind,src=/home/admin/actions-runner/_work/_temp/previous_releases,dst=/home/admin/actions-runner/_work/_temp/previous_releases --mount=type=bind,src=/home/admin/actions-runner/_work/_temp/build,dst=/home/admin/actions-runner/_work/_temp/build --env-file=/tmp/env-admin-ci_i686_no_multiprocess --name=ci_i686_no_multiprocess --network=ci-ip6net --platform=linux/amd64 ci_i686_no_multiprocess
10290s0%docker exec fba5aa520187423257575df33545636454d75ff30f88bc7b7564d4af578fef83 rsync --recursive --perms --stats --human-readable /home/admin/actions-runner/_work/bitcoin/bitcoin/ /home/admin/actions-runner/_work/_temp
10470s0%docker exec fba5aa520187423257575df33545636454d75ff30f88bc7b7564d4af578fef83 /home/admin/actions-runner/_work/_temp/ci/test/01_base_install.sh
10480s0%CFG_DONE=/home/admin/actions-runner/_work/_temp/ci.base-install-done
10490s0%cat /home/admin/actions-runner/_work/_temp/ci.base-install-done
10500s0%'[' done == done ']'
10510s0%echo 'Skip base install'
10520s0%exit 0
10540s0%docker exec fba5aa520187423257575df33545636454d75ff30f88bc7b7564d4af578fef83 /home/admin/actions-runner/_work/_temp/ci/test/03_test_script.sh
10550s0%cd /home/admin/actions-runner/_work/_temp
10560s0%export 'PATH=/path_with space:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin'
10570s0%PATH='/path_with space:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin'
10580s0%export ASAN_OPTIONS=detect_leaks=1:detect_stack_use_after_return=1:check_initialization_order=1:strict_init_order=1
10590s0%ASAN_OPTIONS=detect_leaks=1:detect_stack_use_after_return=1:check_initialization_order=1:strict_init_order=1
10600s0%export LSAN_OPTIONS=suppressions=/home/admin/actions-runner/_work/_temp/test/sanitizer_suppressions/lsan
10610s0%LSAN_OPTIONS=suppressions=/home/admin/actions-runner/_work/_temp/test/sanitizer_suppressions/lsan
10620s0%export TSAN_OPTIONS=suppressions=/home/admin/actions-runner/_work/_temp/test/sanitizer_suppressions/tsan:halt_on_error=1:second_deadlock_stack=1
10630s0%TSAN_OPTIONS=suppressions=/home/admin/actions-runner/_work/_temp/test/sanitizer_suppressions/tsan:halt_on_error=1:second_deadlock_stack=1
10640s0%export UBSAN_OPTIONS=suppressions=/home/admin/actions-runner/_work/_temp/test/sanitizer_suppressions/ubsan:print_stacktrace=1:halt_on_error=1:report_error_type=1
10650s0%UBSAN_OPTIONS=suppressions=/home/admin/actions-runner/_work/_temp/test/sanitizer_suppressions/ubsan:print_stacktrace=1:halt_on_error=1:report_error_type=1
10660s0%nproc
10670s0%echo 'Number of available processing units: 8'
10680s0%'[' '' == macos ']'
10690s0%free -m -h
10740s0%uname --kernel-name --kernel-release
10750s0%echo 'System info: Linux 6.14.0-37-generic'
10770s0%lscpu
10800s0%echo 'Free disk space:'
10810s0%df -h
11240s0%[[ ci_i686_no_multiprocess == \c\i\_\n\a\t\i\v\e\_\a\s\a\n ]]
11250s0%export HOST=i686-pc-linux-gnu
11260s0%HOST=i686-pc-linux-gnu
11270s0%echo '=== BEGIN env ==='
11280s0%env
11840s0%echo '=== END env ==='
11850s0%[[ '' != true ]]
11860s0%tee /dev/fd/63
11870s0%patch -p1
11900s0%b/src/leveldb/db/db_impl.cc
12000s0%1].Add(stats);
12010s0%'[' false = true ']'
12020s0%'[' true = true ']'
12030s0%export DIR_UNIT_TEST_DATA=/home/admin/actions-runner/_work/_temp/ci/scratch/qa-assets/unit_test_data/
12040s0%DIR_UNIT_TEST_DATA=/home/admin/actions-runner/_work/_temp/ci/scratch/qa-assets/unit_test_data/
12050s0%'[' '!' -d /home/admin/actions-runner/_work/_temp/ci/scratch/qa-assets/unit_test_data/ ']'
12060s0%mkdir -p /home/admin/actions-runner/_work/_temp/ci/scratch/qa-assets/unit_test_data/
12080s0%retry curl --location --fail https://github.com/bitcoin-core/qa-assets/raw/main/unit_test_data/script_assets_test.json -o /home/admin/actions-runner/_work/_temp/ci/scratch/qa-assets/unit_test_data//script_assets_test.json
12170s0%'[' '' == macos ']'
12180s0%echo
12190s0%'[' -z '' ']'
12200s0%[[ mirror.gcr.io/debian:trixie == *alpine* ]]
12210s0%SHELL_OPTS=CONFIG_SHELL=
12227s0%bash -c 'CONFIG_SHELL= make -j8 -C depends HOST=i686-pc-linux-gnu DEBUG=1 NO_IPC=1 LOG=1'
15360s0%'[' '' = true ']'
15370s0%BITCOIN_CONFIG_ALL='-DBUILD_BENCH=ON -DBUILD_FUZZ_BINARY=ON'
15380s0%'[' -z '' ']'
15390s0%BITCOIN_CONFIG_ALL='-DBUILD_BENCH=ON -DBUILD_FUZZ_BINARY=ON -DCMAKE_TOOLCHAIN_FILE=/home/admin/actions-runner/_work/_temp/depends/i686-pc-linux-gnu/toolchain.cmake'
15400s0%'[' -z '' ']'
15410s0%BITCOIN_CONFIG_ALL='-DBUILD_BENCH=ON -DBUILD_FUZZ_BINARY=ON -DCMAKE_TOOLCHAIN_FILE=/home/admin/actions-runner/_work/_temp/depends/i686-pc-linux-gnu/toolchain.cmake -DWERROR=ON'
15420s0%ccache --zero-stats
15440s0%PRINT_CCACHE_STATISTICS='ccache --version | head -n 1 && ccache --show-stats'
15450s0%BASE_BUILD_DIR=/home/admin/actions-runner/_work/_temp/build
15460s0%BITCOIN_CONFIG_ALL='-DBUILD_BENCH=ON -DBUILD_FUZZ_BINARY=ON -DCMAKE_TOOLCHAIN_FILE=/home/admin/actions-runner/_work/_temp/depends/i686-pc-linux-gnu/toolchain.cmake -DWERROR=ON -DCMAKE_INSTALL_PREFIX=/home/admin/actions-runner/_work/_temp/ci/scratch/out -Werror=dev'
15470s0%[[ '' == true ]]
15480s0%[[ false == true ]]
15490s0%eval 'CMAKE_ARGS=(-DBUILD_BENCH=ON -DBUILD_FUZZ_BINARY=ON -DCMAKE_TOOLCHAIN_FILE=/home/admin/actions-runner/_work/_temp/depends/i686-pc-linux-gnu/toolchain.cmake -DWERROR=ON -DCMAKE_INSTALL_PREFIX=/home/admin/actions-runner/_work/_temp/ci/scratch/out -Werror=dev --preset=dev-mode -DENABLE_IPC=OFF -DCMAKE_BUILD_TYPE=Debug -DCMAKE_C_COMPILER='\''clang;-m32'\'' -DCMAKE_CXX_COMPILER='\''clang++;-m32'\'' -DAPPEND_CPPFLAGS='\''-DBOOST_MULTI_INDEX_ENABLE_SAFE_MODE'\'' )'
15500s0%CMAKE_ARGS=(-DBUILD_BENCH=ON -DBUILD_FUZZ_BINARY=ON -DCMAKE_TOOLCHAIN_FILE=/home/admin/actions-runner/_work/_temp/depends/i686-pc-linux-gnu/toolchain.cmake -DWERROR=ON -DCMAKE_INSTALL_PREFIX=/home/admin/actions-runner/_work/_temp/ci/scratch/out -Werror=dev --preset=dev-mode -DENABLE_IPC=OFF -DCMAKE_BUILD_TYPE=Debug -DCMAKE_C_COMPILER='clang;-m32' -DCMAKE_CXX_COMPILER='clang++;-m32' -DAPPEND_CPPFLAGS='-DBOOST_MULTI_INDEX_ENABLE_SAFE_MODE')
15510s0%cmake -S /home/admin/actions-runner/_work/_temp -B /home/admin/actions-runner/_work/_temp/build -DBUILD_BENCH=ON -DBUILD_FUZZ_BINARY=ON -DCMAKE_TOOLCHAIN_FILE=/home/admin/actions-runner/_work/_temp/depends/i686-pc-linux-gnu/toolchain.cmake -DWERROR=ON -DCMAKE_INSTALL_PREFIX=/home/admin/actions-runner/_work/_temp/ci/scratch/out -Werror=dev --preset=dev-mode -DENABLE_IPC=OFF -DCMAKE_BUILD_TYPE=Debug '-DCMAKE_C_COMPILER=clang;-m32' '-DCMAKE_CXX_COMPILER=clang++;-m32' -DAPPEND_CPPFLAGS=-DBOOST_MULTI_INDEX_ENABLE_SAFE_MODE
157414s1%- skipped
19690s0%compiler .......................... Clang 19.1.7, /bin/clang++
19720s0%compiler flags .................... -m32 -O0 -ftrapv -O1 -g3 -g3 -std=c++20 -fPIC -fmacro-prefix-map=/home/admin/actions-runner/_work/_temp/src=. -U_FORTIFY_SOURCE -D_FORTIFY_SOURCE=3 -Wstack-protector -fstack-protector-all -fcf-protection=full -fstack-clash-protection -Werror -Wall -Wextra -Wgnu -Wformat -Wformat-security -Wvla -Wshadow-field -Wthread-safety -Wloop-analysis -Wredundant-decls -Wunused-member-function -Wdate-time -Wconditional-uninitialized -Woverloaded-virtual -Wsuggest-override -Wimplicit-fallthrough -Wunreachable-code -Wdocumentation -Wself-assign -Wundef -Wno-unused-parameter -DBOOST_MULTI_INDEX_ENABLE_SAFE_MODE
19860s0%[[ install != all ]]
19870s0%[[ install != codegen ]]
19880s0%GOAL='all install'
19895m7s33%cmake --build /home/admin/actions-runner/_work/_temp/build -j8 --target all install
31090s0%bash -c 'ccache --version | head -n 1 && ccache --show-stats'
31210s0%ccache --show-stats
31220s0%grep Hits:
31230s0%head -1
31240s0%sed 's/.*(\(.*\)%).*/\1/'
31250s0%hit_rate=24.34
31270s0%'[' 24 -lt 75 ']'
31280s0%echo '::notice title=low ccache hitrate::Ccache hit-rate in ci_i686_no_multiprocess was 24.34%'
31290s0%du -sh /home/admin/actions-runner/_work/_temp/depends/SDKs/ /home/admin/actions-runner/_work/_temp/depends/builders/ /home/admin/actions-runner/_work/_temp/depends/built/ /home/admin/actions-runner/_work/_temp/depends/hosts/ /home/admin/actions-runner/_work/_temp/depends/i686-pc-linux-gnu/ /home/admin/actions-runner/_work/_temp/depends/packages/ /home/admin/actions-runner/_work/_temp/depends/patches/ /home/admin/actions-runner/_work/_temp/depends/sdk-sources/ /home/admin/actions-runner/_work/_temp/depends/sources/
31390s0%du -sh /home/admin/actions-runner/_work/_temp/previous_releases
31410s0%'[' -n 1 ']'
31420s0%ulimit -s 512
31430s0%'[' -n '' ']'
31440s0%'[' '' = true ']'
31450s0%'[' true = true ']'
31460s0%DIR_UNIT_TEST_DATA=/home/admin/actions-runner/_work/_temp/ci/scratch/qa-assets/unit_test_data/
31470s0%LD_LIBRARY_PATH=/home/admin/actions-runner/_work/_temp/depends/i686-pc-linux-gnu/lib
31480s0%CTEST_OUTPUT_ON_FAILURE=ON
31491m27s9%ctest --test-dir /home/admin/actions-runner/_work/_temp/build --stop-on-failure -j8 --timeout 2400
34600s0%'[' true = true ']'
34610s0%eval 'TEST_RUNNER_EXTRA=(--v2transport --usecli)'
34620s0%TEST_RUNNER_EXTRA=(--v2transport --usecli)
34630s0%LD_LIBRARY_PATH=/home/admin/actions-runner/_work/_temp/depends/i686-pc-linux-gnu/lib
34647m4s46%/home/admin/actions-runner/_work/_temp/build/test/functional/test_runner.py -j8 --tmpdirprefix /home/admin/actions-runner/_work/_temp/ci/scratch/test_runner/ --ansi --combinedlogslen=99999999 --timeout-factor=40 --v2transport --usecli --quiet --failfast
48410s0%'[' false = true ']'
48420s0%[[ '' == true ]]
48430s0%'[' false = true ']'
48457s0%docker container kill fba5aa520187423257575df33545636454d75ff30f88bc7b7564d4af578fef83
Tags
  • i686, no IPC
  • pr/mlog
  • COMPLETED