travis_fold:start:worker_info [0K[33;1mWorker information[0m hostname: 7157ea50-2e0e-454d-9ae2-99dc25871ac0@1.worker-n2-com-696d86f5d9-lxm9v.gce-production-1 version: v6.2.24-6-g098ca78 https://github.com/travis-ci/worker/tree/098ca78612c4c91c488169d6a2c94fbeee1fb89d instance: travis-job-346f797c-e407-440e-a4ef-1661bc3afb9d travis-ci-ubuntu-2004-1722508972-dca9c545 (via amqp) startup: 6.041432629s travis_fold:end:worker_info [0Ktravis_time:start:014781a2 [0Ktravis_time:end:014781a2:start=1724142553486146309,finish=1724142553783794570,duration=297648261,event=no_world_writable_dirs [0Ktravis_time:start:09753e98 [0Ktravis_time:end:09753e98:start=1724142553786413766,finish=1724142553789454312,duration=3040546,event=setup_filter [0Ktravis_time:start:0cf0de68 [0Ktravis_time:end:0cf0de68:start=1724142553793326725,finish=1724142553801652486,duration=8325761,event=agent [0Ktravis_time:start:21918e00 [0Ktravis_time:end:21918e00:start=1724142553804102009,finish=1724142553805871835,duration=1769826,event=check_unsupported [0Ktravis_time:start:2627ba88 [0Ktravis_fold:start:system_info [0K[33;1mBuild system information[0m Build language: go Build dist: focal Build id: 271956719 Job id: 625289876 Runtime kernel version: 5.15.0-1065-gcp travis-build version: 5243a51a [34m[1mBuild image provisioning date and time[0m Thu 01 Aug 2024 11:09:08 AM UTC [34m[1mOperating System Details[0m Distributor ID: Ubuntu Description: Ubuntu 20.04.6 LTS Release: 20.04 Codename: focal [34m[1mSystemd Version[0m systemd 245 (245.4-4ubuntu3.23) [34m[1mCookbooks Version[0m 50feb93 https://github.com/travis-ci/travis-cookbooks/tree/50feb93 [34m[1mgit version[0m git version 2.46.0 [34m[1mbash version[0m GNU bash, version 5.0.17(1)-release (x86_64-pc-linux-gnu) [34m[1mgcc version[0m gcc (Ubuntu 9.4.0-1ubuntu1~20.04.2) 9.4.0 [34m[1mdocker version[0m Client: Version: 24.0.7 API version: 1.43 Go version: go1.21.1 Git commit: 24.0.7-0ubuntu2~20.04.1 Built: Wed Mar 13 20:29:24 2024 OS/Arch: linux/amd64 Context: default Server: Engine: Version: 24.0.7 API version: 1.43 (minimum version 1.12) Go version: go1.21.1 Git commit: 24.0.7-0ubuntu2~20.04.1 Built: Wed Mar 13 20:29:24 2024 OS/Arch: linux/amd64 Experimental: false containerd: Version: 1.7.12 GitCommit: runc: Version: 1.1.12-0ubuntu2~20.04.1 GitCommit: docker-init: Version: 0.19.0 GitCommit: [34m[1mclang version[0m clang version 18.1.8 [34m[1mjq version[0m jq-1.7.1 [34m[1mbats version[0m Bats 1.11.0 [34m[1mshellcheck version[0m 0.10.0 [34m[1mshfmt version[0m v3.8.0 [34m[1mccache version[0m 3.7.7 [34m[1mcmake version[0m cmake version 3.29.0 [34m[1mheroku version[0m heroku/9.1.0 linux-x64 node-v16.20.2 [34m[1mimagemagick version[0m Version: ImageMagick 6.9.10-23 Q16 x86_64 20190101 https://imagemagick.org [34m[1mmd5deep version[0m 4.4 [34m[1mmercurial version[0m version 6.5.2 [34m[1mmysql version[0m mysql Ver 8.0.39-0ubuntu0.20.04.1 for Linux on x86_64 ((Ubuntu)) [34m[1mopenssl version[0m OpenSSL 1.1.1f 31 Mar 2020 [34m[1mpacker version[0m Packer v1.11.2 [34m[1mpostgresql client version[0m psql (PostgreSQL) 13.15 (Ubuntu 13.15-1.pgdg20.04+1) [34m[1mragel version[0m Ragel State Machine Compiler version 6.10 March 2017 [34m[1msudo version[0m 1.8.31 [34m[1mgzip version[0m gzip 1.10 [34m[1mzip version[0m Zip 3.0 [34m[1mvim version[0m VIM - Vi IMproved 8.1 (2018 May 18, compiled May 03 2024 02:36:35) [34m[1miptables version[0m iptables v1.8.4 (legacy) [34m[1mcurl version[0m curl 7.68.0 (x86_64-pc-linux-gnu) libcurl/7.68.0 OpenSSL/1.1.1f zlib/1.2.11 brotli/1.0.7 libidn2/2.2.0 libpsl/0.21.0 (+libidn2/2.2.0) libssh/0.9.3/openssl/zlib nghttp2/1.40.0 librtmp/2.3 [34m[1mwget version[0m GNU Wget 1.20.3 built on linux-gnu. [34m[1mrsync version[0m rsync version 3.1.3 protocol version 31 [34m[1mgimme version[0m v1.5.4 [34m[1mnvm version[0m 0.40.0 [34m[1mperlbrew version[0m /home/travis/perl5/perlbrew/bin/perlbrew - App::perlbrew/0.95 [34m[1mphpenv version[0m rbenv 1.3.0 [34m[1mrvm version[0m rvm 1.29.12 (latest) by Michal Papis, Piotr Kuczynski, Wayne E. Seguin [https://rvm.io] [34m[1mdefault ruby version[0m ruby 3.3.1 (2024-04-23 revision c56cd86388) [x86_64-linux] [34m[1mdefault python version[0m Python 3.7.17 [34m[1mElasticSearch version[0m 7.16.3 [34m[1mInstalled Firefox version[0m firefox 99.0 [34m[1mMongoDB version[0m MongoDB 4.4.29 [34m[1mPhantomJS version[0m 2.1.1 [34m[1mRedis version[0m redis-server 7.4.0 [34m[1mPre-installed Go versions[0m 1.22.5 [34m[1mmvn version[0m Apache Maven 3.9.4 (dfbb324ad4a7c8fb0bf182e6d91b0ae20e3d2dd9) [34m[1mgradle version[0m Gradle 8.3! [34m[1mlein version[0m Leiningen 2.11.2 on Java 11.0.21 OpenJDK 64-Bit Server VM [34m[1mPre-installed Node.js versions[0m v10.24.1 v12.22.12 v14.21.3 v16.15 v16.20.2 v18.20.3 v18.20.4 v20.16.0 v4.9.1 v6.17.1 v8.17.0 [34m[1mphpenv versions[0m system 7.4 * 7.4.6 (set by /home/travis/.phpenv/version) hhvm-stable hhvm [34m[1mcomposer --version[0m Composer version 1.10.6 2020-05-06 10:28:10 [34m[1mPre-installed Ruby versions[0m ruby-2.7.6 ruby-3.3.1 travis_fold:end:system_info [0K travis_time:end:2627ba88:start=1724142553808250980,finish=1724142553814925373,duration=6674393,event=show_system_info [0Ktravis_time:start:0b30178b [0Ktravis_time:end:0b30178b:start=1724142553817416276,finish=1724142553841200722,duration=23784446,event=rm_riak_source [0Ktravis_time:start:16d76cee [0Ktravis_time:end:16d76cee:start=1724142553851240160,finish=1724142553856261140,duration=5020980,event=fix_rwky_redis [0Ktravis_time:start:09e95682 [0Ktravis_time:end:09e95682:start=1724142553858948660,finish=1724142554630148585,duration=771199925,event=wait_for_network [0Ktravis_time:start:02d47be0 [0Ktravis_time:end:02d47be0:start=1724142554634627112,finish=1724142554950717430,duration=316090318,event=update_apt_keys [0Ktravis_time:start:03648213 [0Ktravis_time:end:03648213:start=1724142554954267083,finish=1724142555008659827,duration=54392744,event=fix_hhvm_source [0Ktravis_time:start:3314a096 [0Ktravis_time:end:3314a096:start=1724142555013607879,finish=1724142555026943522,duration=13335643,event=update_mongo_arch [0Ktravis_time:start:16f6d700 [0Ktravis_time:end:16f6d700:start=1724142555031752576,finish=1724142555067978865,duration=36226289,event=fix_sudo_enabled_trusty [0Ktravis_time:start:06fb2415 [0Ktravis_time:end:06fb2415:start=1724142555072594506,finish=1724142555075064239,duration=2469733,event=update_glibc [0Ktravis_time:start:1730546d [0Ktravis_time:end:1730546d:start=1724142555079712515,finish=1724142555107599996,duration=27887481,event=clean_up_path [0Ktravis_time:start:063ac362 [0Ktravis_time:end:063ac362:start=1724142555111680417,finish=1724142555122465190,duration=10784773,event=fix_resolv_conf [0Ktravis_time:start:03a9d528 [0Ktravis_time:end:03a9d528:start=1724142555127239696,finish=1724142555142768135,duration=15528439,event=fix_etc_hosts [0Ktravis_time:start:0bba77ce [0Ktravis_time:end:0bba77ce:start=1724142555146762402,finish=1724142555155759359,duration=8996957,event=fix_mvn_settings_xml [0Ktravis_time:start:01ddc704 [0Ktravis_time:end:01ddc704:start=1724142555159751230,finish=1724142555170197792,duration=10446562,event=no_ipv6_localhost [0Ktravis_time:start:0f37ed42 [0Ktravis_time:end:0f37ed42:start=1724142555174260899,finish=1724142555176678543,duration=2417644,event=fix_etc_mavenrc [0Ktravis_time:start:0766aa84 [0KOK travis_time:end:0766aa84:start=1724142555180611459,finish=1724142555563746033,duration=383134574,event=fix_perforce_key [0Ktravis_time:start:1eb893a2 [0Ktravis_time:end:1eb893a2:start=1724142555568867491,finish=1724142555571921034,duration=3053543,event=fix_wwdr_certificate [0Ktravis_time:start:03ed4870 [0Ktravis_time:end:03ed4870:start=1724142555576606888,finish=1724142555616370908,duration=39764020,event=put_localhost_first [0Ktravis_time:start:05cb89a8 [0Ktravis_time:end:05cb89a8:start=1724142555619863024,finish=1724142555622742974,duration=2879950,event=home_paths [0Ktravis_time:start:122c1600 [0Ktravis_time:end:122c1600:start=1724142555626118776,finish=1724142555639935071,duration=13816295,event=disable_initramfs [0Ktravis_time:start:05f5a350 [0Ktravis_time:end:05f5a350:start=1724142555644478074,finish=1724142555775024538,duration=130546464,event=disable_ssh_roaming [0Ktravis_time:start:056e1f50 [0Ktravis_time:end:056e1f50:start=1724142555779735954,finish=1724142555782129788,duration=2393834,event=debug_tools [0Ktravis_time:start:038e419c [0Ktravis_time:end:038e419c:start=1724142555785472646,finish=1724142555789034986,duration=3562340,event=uninstall_oclint [0Ktravis_time:start:1131bde6 [0Ktravis_time:end:1131bde6:start=1724142555792481108,finish=1724142555795931428,duration=3450320,event=rvm_use [0Ktravis_time:start:1b0ccda2 [0Ktravis_time:end:1b0ccda2:start=1724142555799347213,finish=1724142555808101651,duration=8754438,event=rm_etc_boto_cfg [0Ktravis_time:start:02b3d13c [0Ktravis_time:end:02b3d13c:start=1724142555811555585,finish=1724142555814151126,duration=2595541,event=rm_oraclejdk8_symlink [0Ktravis_time:start:090f987c [0Ktravis_time:end:090f987c:start=1724142555817671085,finish=1724142555937982928,duration=120311843,event=enable_i386 [0Ktravis_time:start:0bf6e038 [0Ktravis_time:end:0bf6e038:start=1724142555942716439,finish=1724142555946390050,duration=3673611,event=update_rubygems [0Ktravis_time:start:0296948c [0Ktravis_time:end:0296948c:start=1724142555951060997,finish=1724142556930055449,duration=978994452,event=ensure_path_components [0Ktravis_time:start:05e06ced [0Ktravis_time:end:05e06ced:start=1724142556935060124,finish=1724142556937542306,duration=2482182,event=redefine_curl [0Ktravis_time:start:13f4a809 [0Ktravis_time:end:13f4a809:start=1724142556942287159,finish=1724142557074367646,duration=132080487,event=nonblock_pipe [0Ktravis_time:start:186b91d3 [0Ktravis_time:end:186b91d3:start=1724142557079340456,finish=1724142563115475334,duration=6036134878,event=apt_get_update [0Ktravis_time:start:06f7d4f6 [0Ktravis_time:end:06f7d4f6:start=1724142563119281162,finish=1724142563121441420,duration=2160258,event=deprecate_xcode_64 [0Ktravis_time:start:20bf8d2a [0Ktravis_time:end:20bf8d2a:start=1724142563124743419,finish=1724142567066555445,duration=3941812026,event=update_heroku [0Ktravis_time:start:0c812dec [0Ktravis_time:end:0c812dec:start=1724142567070893496,finish=1724142567073606005,duration=2712509,event=shell_session_update [0Ktravis_time:start:152e4b2f [0Ktravis_fold:start:docker_mtu_and_registry_mirrors [0Ktravis_fold:end:docker_mtu_and_registry_mirrors [0Ktravis_time:end:152e4b2f:start=1724142567077138286,finish=1724142569323218682,duration=2246080396,event=set_docker_mtu_and_registry_mirrors [0Ktravis_time:start:1d2e8000 [0Ktravis_fold:start:resolvconf [0Ktravis_fold:end:resolvconf [0Ktravis_time:end:1d2e8000:start=1724142569329585269,finish=1724142569390215808,duration=60630539,event=resolvconf [0Ktravis_time:start:2260fee4 [0Ktravis_time:end:2260fee4:start=1724142569395138653,finish=1724142569614392852,duration=219254199,event=maven_central_mirror [0Ktravis_time:start:2c6c2ae2 [0Ktravis_time:end:2c6c2ae2:start=1724142569619193454,finish=1724142569731927749,duration=112734295,event=maven_https [0Ktravis_time:start:01574b34 [0Ktravis_fold:start:services [0Ktravis_time:start:1e6cd980 [0K$ sudo systemctl start rabbitmq-server travis_time:end:1e6cd980:start=1724142569740507659,finish=1724142569754374925,duration=13867266,event=prepare [0Ktravis_time:start:188e2680 [0K$ sudo systemctl start docker travis_time:end:188e2680:start=1724142569758407126,finish=1724142569771943592,duration=13536466,event=prepare [0Ktravis_time:start:0a86512f [0K$ sudo systemctl start redis-server travis_time:end:0a86512f:start=1724142569775735573,finish=1724142569855955072,duration=80219499,event=prepare [0Ktravis_fold:end:services [0Ktravis_time:end:0a86512f:start=1724142569775735573,finish=1724142572863680207,duration=3087944634,event=services [0Ktravis_time:start:00328c19 [0Ktravis_time:end:00328c19:start=1724142572868814777,finish=1724142572871313870,duration=2499093,event=fix_ps4 [0KUpdating gimme travis_time:start:252bf733 [0K travis_fold:start:git.checkout [0Ktravis_time:start:03c3302a [0Ktravis_time:end:03c3302a:start=1724142577857958711,finish=1724142577865888474,duration=7929763,event=checkout [0Ktravis_time:start:0009eec2 [0K$ git clone --depth=10 https://github.com/travis-ci/worker.git travis-ci/worker Cloning into 'travis-ci/worker'... travis_time:end:0009eec2:start=1724142577870038200,finish=1724142578366071174,duration=496032974,event=checkout [0K$ cd travis-ci/worker travis_time:start:051280e0 [0K$ git fetch origin +refs/pull/675/merge: --depth=10 From https://github.com/travis-ci/worker * branch refs/pull/675/merge -> FETCH_HEAD travis_time:end:051280e0:start=1724142578371532726,finish=1724142578688949135,duration=317416409,event=checkout [0K$ git checkout -qf FETCH_HEAD travis_fold:end:git.checkout [0K travis_time:end:051280e0:start=1724142578371532726,finish=1724142578704126560,duration=332593834,event=checkout [0K$ travis_export_go 1.22.x github.com/travis-ci/worker travis_time:start:066a25d3 [0K [33;1mSetting environment variables from repository settings[0m $ export ARTIFACTS_PATHS=./build $ export ARTIFACTS_BUCKET=travis-worker-artifacts $ export ARTIFACTS_PERMISSIONS=public-read $ export ARTIFACTS_KEY=[secure] $ export ARTIFACTS_SECRET=[secure] $ export PACKAGECLOUD_TOKEN=[secure] $ export DOCKER_HUB_TRIGGER_URL=[secure] $ export DOCKER_LOGIN_USERNAME=[secure] $ export DOCKER_LOGIN_PASSWORD=[secure] $ export VAULT_PASS=[secure] $ export GCE_PROJECT=[secure] $ export VAULT_USERNAME=[secure] $ export VAULT_ADDR=[secure] $ export CLOUDSDK_CORE_DISABLE_PROMPTS=[secure] [33;1mSetting environment variables from .travis.yml[0m $ export AMQP_URI="amqp://" $ export GOPATH="$HOME/gopath" $ export PATH="bin:$HOME/gopath/bin:$HOME/bin:$PATH" $ export CHECKOUT_ROOT="$HOME/gopath/src/github.com/travis-ci/worker" $ export GO15VENDOREXPERIMENT='1' $ export REDIS_URL="redis://" travis_time:end:066a25d3:start=1724142578711576639,finish=1724142578718679282,duration=7102643,event=env [0Ktravis_time:start:00e580c0 [0K$ travis_setup_go go version go1.22.6 linux/amd64 $ export GOPATH="/home/travis/gopath" $ export PATH="/home/travis/gopath/bin:/home/travis/.gimme/versions/go1.22.6.linux.amd64/bin:bin:/home/travis/gopath/bin:/home/travis/bin:/home/travis/bin:/home/travis/bin:/home/travis/.local/bin:/usr/local/lib/jvm/openjdk11/bin:/opt/pyenv/shims:/home/travis/.phpenv/shims:/home/travis/perl5/perlbrew/bin:/home/travis/.nvm/versions/node/v18.20.3/bin:/home/travis/.kiex/elixirs/elixir-1.7.4/bin:/home/travis/.kiex/bin:/home/travis/.rvm/gems/ruby-3.3.1/bin:/home/travis/.rvm/gems/ruby-3.3.1@global/bin:/home/travis/.rvm/rubies/ruby-3.3.1/bin:/home/travis/gopath/bin:/home/travis/.gimme/versions/go1.22.5.linux.amd64/bin:/usr/local/maven-3.9.4/bin:/usr/local/cmake-3.29.0/bin:/usr/local/clang-18.1.8/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/snap/bin:/usr/local/ant/bin:/home/travis/.rvm/bin:/home/travis/.phpenv/bin:/opt/pyenv/bin:/home/travis/.yarn/bin" $ export GO111MODULE="auto" travis_time:end:00e580c0:start=1724142578722864029,finish=1724142581417516992,duration=2694652963,event= [0Ktravis_fold:start:cache.1 [0KSetting up build cache $ export CASHER_DIR=${TRAVIS_HOME}/.casher travis_time:start:2a9081b2 [0K$ Installing caching utilities travis_time:end:2a9081b2:start=1724142582211726660,finish=1724142582364887436,duration=153160776,event=setup_casher [0Ktravis_time:start:02a06b8c [0Ktravis_time:end:02a06b8c:start=1724142582372044402,finish=1724142582375439846,duration=3395444,event=setup_casher [0Ktravis_time:start:050017e8 [0Kattempting to download cache archive[0m [32;1mfetching PR.675/cache--linux-focal-8e66efc74188d5464db6c5a9d3decd4835ed340208a6ac39f04af14f2f93a35a--go-1.22.x.tgz[0m [32;1mfetching PR.675/cache-linux-focal-8e66efc74188d5464db6c5a9d3decd4835ed340208a6ac39f04af14f2f93a35a--go-1.22.x.tgz[0m [32;1mfetching PR.675/cache--go-1.22.x.tgz[0m [32;1mfetching master/cache--linux-focal-8e66efc74188d5464db6c5a9d3decd4835ed340208a6ac39f04af14f2f93a35a--go-1.22.x.tgz[0m [32;1mfetching master/cache-linux-focal-8e66efc74188d5464db6c5a9d3decd4835ed340208a6ac39f04af14f2f93a35a--go-1.22.x.tgz[0m [32;1mfetching master/cache--go-1.22.x.tgz[0m [31;1mcould not download cache[0m travis_time:end:050017e8:start=1724142582381173151,finish=1724142583796473861,duration=1415300710,event=setup_casher [0Ktravis_time:start:12c551d6 [0Ktravis_time:end:12c551d6:start=1724142583802501681,finish=1724142583806437161,duration=3935480,event=setup_casher [0Ktravis_time:start:1701f0bb [0Kadding /home/travis/gopath/src/github.com/travis-ci/worker/vendor to cache[0m creating directory /home/travis/gopath/src/github.com/travis-ci/worker/vendor[0m adding /home/travis/.cache/go-build to cache[0m adding /home/travis/gopath/bin to cache[0m adding /home/travis/gopath/pkg/mod to cache[0m creating directory /home/travis/gopath/pkg/mod[0m travis_time:end:1701f0bb:start=1724142583812752198,finish=1724142585121188489,duration=1308436291,event=setup_casher [0Ktravis_fold:end:cache.1 [0K $ gimme version v1.5.4 $ go version go version go1.22.6 linux/amd64 travis_fold:start:go.env [0K$ go env GO111MODULE='auto' GOARCH='amd64' GOBIN='' GOCACHE='/home/travis/.cache/go-build' GOENV='/home/travis/.config/go/env' GOEXE='' GOEXPERIMENT='' GOFLAGS='' GOHOSTARCH='amd64' GOHOSTOS='linux' GOINSECURE='' GOMODCACHE='/home/travis/gopath/pkg/mod' GONOPROXY='' GONOSUMDB='' GOOS='linux' GOPATH='/home/travis/gopath' GOPRIVATE='' GOPROXY='https://proxy.golang.org,direct' GOROOT='/home/travis/.gimme/versions/go1.22.6.linux.amd64' GOSUMDB='sum.golang.org' GOTMPDIR='' GOTOOLCHAIN='auto' GOTOOLDIR='/home/travis/.gimme/versions/go1.22.6.linux.amd64/pkg/tool/linux_amd64' GOVCS='' GOVERSION='go1.22.6' GCCGO='gccgo' GOAMD64='v1' AR='ar' CC='gcc' CXX='g++' CGO_ENABLED='1' GOMOD='/home/travis/gopath/src/github.com/travis-ci/worker/go.mod' GOWORK='' CGO_CFLAGS='-O2 -g' CGO_CPPFLAGS='' CGO_CXXFLAGS='-O2 -g' CGO_FFLAGS='-O2 -g' CGO_LDFLAGS='-O2 -g' PKG_CONFIG='pkg-config' GOGCCFLAGS='-fPIC -m64 -pthread -Wl,--no-gc-sections -fmessage-length=0 -ffile-prefix-map=/tmp/go-build1231596292=/tmp/go-build -gno-record-gcc-switches' travis_fold:end:go.env [0Ktravis_fold:start:install [0Ktravis_time:start:0cdc4640 [0K$ travis_install_go_dependencies 1.22.x -v Makefile detected travis_time:end:0cdc4640:start=1724142585439244918,finish=1724142585445093830,duration=5848912,event=install [0Ktravis_fold:end:install [0Ktravis_time:start:16b4b110 [0K$ GO111MODULE=on make build GO111MODULE=on go mod download GO111MODULE=on go mod vendor touch .deps-fetched go install -tags netgo -ldflags "-X 'github.com/travis-ci/worker.VersionString=v6.2.24-9-geb517f6' -X 'github.com/travis-ci/worker.RevisionString=eb517f652c9e618e0efb8ad39bcae481194947f7' -X 'github.com/travis-ci/worker.RevisionURLString=https://github.com/travis-ci/worker/tree/eb517f652c9e618e0efb8ad39bcae481194947f7' -X 'github.com/travis-ci/worker.GeneratedString=2024-08-20T08:29:57+0000' -X 'github.com/travis-ci/worker.CopyrightString=© 2018 Travis CI GmbH'" github.com/travis-ci/worker github.com/travis-ci/worker/image github.com/travis-ci/worker/backend github.com/travis-ci/worker/metrics github.com/travis-ci/worker/winrm github.com/travis-ci/worker/ssh github.com/travis-ci/worker/context github.com/travis-ci/worker/ratelimit github.com/travis-ci/worker/config github.com/travis-ci/worker/errors github.com/travis-ci/worker/remote github.com/travis-ci/worker/cmd/... travis_time:end:16b4b110:start=1724142585452426196,finish=1724142695102011843,duration=109649585647,event=script [0K[32;1mThe command "GO111MODULE=on make build" exited with 0.[0m travis_time:start:0a9ef0d0 [0K$ mkdir -p build/linux/amd64 travis_time:end:0a9ef0d0:start=1724142695108795669,finish=1724142695114732030,duration=5936361,event=script [0K[32;1mThe command "mkdir -p build/linux/amd64" exited with 0.[0m travis_time:start:0595bb61 [0K$ cp ${GOPATH%%:*}/bin/travis-worker build/linux/amd64 travis_time:end:0595bb61:start=1724142695120648140,finish=1724142695164700239,duration=44052099,event=script [0K[32;1mThe command "cp ${GOPATH%%:*}/bin/travis-worker build/linux/amd64" exited with 0.[0m travis_time:start:022353d2 [0K$ make http-job-test ./script/http-job-test Cloning into '/tmp/job-board-clone.TqkxmFX'... Unable to find image 'redis:latest' locally latest: Pulling from library/redis e4fff0779e6d: Pulling fs layer d1dde3db2ec5: Pulling fs layer 1d321a003dde: Pulling fs layer d65aedb2f012: Pulling fs layer 4018f93716a2: Pulling fs layer b0967b02e8cf: Pulling fs layer 4f4fb700ef54: Pulling fs layer d288b86f5d06: Pulling fs layer d65aedb2f012: Waiting 4018f93716a2: Waiting b0967b02e8cf: Waiting 4f4fb700ef54: Waiting d288b86f5d06: Waiting d1dde3db2ec5: Verifying Checksum d1dde3db2ec5: Download complete d65aedb2f012: Verifying Checksum d65aedb2f012: Download complete e4fff0779e6d: Verifying Checksum e4fff0779e6d: Download complete 4018f93716a2: Verifying Checksum 4018f93716a2: Download complete b0967b02e8cf: Verifying Checksum b0967b02e8cf: Download complete 4f4fb700ef54: Verifying Checksum 4f4fb700ef54: Download complete d288b86f5d06: Verifying Checksum d288b86f5d06: Download complete e4fff0779e6d: Pull complete d1dde3db2ec5: Pull complete 1d321a003dde: Verifying Checksum 1d321a003dde: Download complete 1d321a003dde: Pull complete d65aedb2f012: Pull complete 4018f93716a2: Pull complete b0967b02e8cf: Pull complete 4f4fb700ef54: Pull complete d288b86f5d06: Pull complete Digest: sha256:878983f8f5045b28384fc300268cec62bca3b14d5e1a448bec21f28cfcc7bf78 Status: Downloaded newer image for redis:latest d3a694646f2a0db1caec9112906b87b3a2cae1695545d66912ee6b5abdb6f88c Unable to find image 'postgres:latest' locally latest: Pulling from library/postgres e4fff0779e6d: Already exists 3dd23fa89c28: Pulling fs layer 9110f5284332: Pulling fs layer b2a5b191a941: Pulling fs layer f0baaf1c42c6: Pulling fs layer 3c42bd6bf488: Pulling fs layer cb55f9f5ebf8: Pulling fs layer 6eeec50ef8e1: Pulling fs layer ba3d1f8aa002: Pulling fs layer 199cdf05dfec: Pulling fs layer 438d147df750: Pulling fs layer a2e706f2e593: Pulling fs layer 2505d0b60422: Pulling fs layer 133de8acf4aa: Pulling fs layer f0baaf1c42c6: Waiting 3c42bd6bf488: Waiting cb55f9f5ebf8: Waiting 6eeec50ef8e1: Waiting ba3d1f8aa002: Waiting 199cdf05dfec: Waiting 438d147df750: Waiting a2e706f2e593: Waiting 2505d0b60422: Waiting 133de8acf4aa: Waiting 3dd23fa89c28: Verifying Checksum 3dd23fa89c28: Download complete 9110f5284332: Verifying Checksum 9110f5284332: Download complete 3dd23fa89c28: Pull complete f0baaf1c42c6: Verifying Checksum f0baaf1c42c6: Download complete 9110f5284332: Pull complete cb55f9f5ebf8: Verifying Checksum cb55f9f5ebf8: Download complete 6eeec50ef8e1: Verifying Checksum 6eeec50ef8e1: Download complete ba3d1f8aa002: Verifying Checksum ba3d1f8aa002: Download complete 199cdf05dfec: Verifying Checksum 199cdf05dfec: Download complete 438d147df750: Verifying Checksum 438d147df750: Download complete a2e706f2e593: Verifying Checksum a2e706f2e593: Download complete 2505d0b60422: Download complete 133de8acf4aa: Verifying Checksum 133de8acf4aa: Download complete b2a5b191a941: Verifying Checksum b2a5b191a941: Download complete b2a5b191a941: Pull complete f0baaf1c42c6: Pull complete 3c42bd6bf488: Verifying Checksum 3c42bd6bf488: Download complete 3c42bd6bf488: Pull complete cb55f9f5ebf8: Pull complete 6eeec50ef8e1: Pull complete ba3d1f8aa002: Pull complete 199cdf05dfec: Pull complete 438d147df750: Pull complete a2e706f2e593: Pull complete 2505d0b60422: Pull complete 133de8acf4aa: Pull complete Digest: sha256:c62fdb7fd6f519ef425c54760894c74e8d0cb04fbf4f7d3d79aafd86bae24edd Status: Downloaded newer image for postgres:latest b79ece40b0a088bd6c72046664f732c77d1b15825f83889ddad5b229ff0269d8 /var/run/postgresql:5432 - no response /var/run/postgresql:5432 - accepting connections List of databases Name | Owner | Encoding | Locale Provider | Collate | Ctype | ICU Locale | ICU Rules | Access privileges ----------------+----------+----------+-----------------+------------+------------+------------+-----------+----------------------- job_board_test | postgres | UTF8 | libc | en_US.utf8 | en_US.utf8 | | | postgres | postgres | UTF8 | libc | en_US.utf8 | en_US.utf8 | | | template0 | postgres | UTF8 | libc | en_US.utf8 | en_US.utf8 | | | =c/postgres + | | | | | | | | postgres=CTc/postgres template1 | postgres | UTF8 | libc | en_US.utf8 | en_US.utf8 | | | =c/postgres + | | | | | | | | postgres=CTc/postgres (4 rows) Unable to find image 'ruby:2.5' locally 2.5: Pulling from library/ruby 0bc3020d05f1: Pulling fs layer a110e5871660: Pulling fs layer 83d3c0fa203a: Pulling fs layer a8fd09c11b02: Pulling fs layer 14feb89c4a52: Pulling fs layer 958d2475f181: Pulling fs layer ba6c4f28fec1: Pulling fs layer 757d13b54b5e: Pulling fs layer a8fd09c11b02: Waiting 14feb89c4a52: Waiting 958d2475f181: Waiting ba6c4f28fec1: Waiting 757d13b54b5e: Waiting a110e5871660: Verifying Checksum a110e5871660: Download complete 83d3c0fa203a: Verifying Checksum 83d3c0fa203a: Download complete 0bc3020d05f1: Verifying Checksum 0bc3020d05f1: Download complete 958d2475f181: Verifying Checksum 958d2475f181: Download complete a8fd09c11b02: Download complete ba6c4f28fec1: Verifying Checksum ba6c4f28fec1: Download complete 757d13b54b5e: Verifying Checksum 757d13b54b5e: Download complete 14feb89c4a52: Verifying Checksum 14feb89c4a52: Download complete 0bc3020d05f1: Pull complete a110e5871660: Pull complete 83d3c0fa203a: Pull complete a8fd09c11b02: Pull complete 14feb89c4a52: Pull complete 958d2475f181: Pull complete ba6c4f28fec1: Pull complete 757d13b54b5e: Pull complete Digest: sha256:ecc3e4f5da13d881a415c9692bb52d2b85b090f38f4ad99ae94f932b3598444b Status: Downloaded newer image for ruby:2.5 Get:1 http://security.debian.org/debian-security buster/updates InRelease [34.8 kB] Get:2 http://deb.debian.org/debian buster InRelease [122 kB] Get:3 http://security.debian.org/debian-security buster/updates/main amd64 Packages [610 kB] Get:4 http://deb.debian.org/debian buster-updates InRelease [56.6 kB] Get:5 http://deb.debian.org/debian buster/main amd64 Packages [7909 kB] Get:6 http://deb.debian.org/debian buster-updates/main amd64 Packages [8788 B] Fetched 8741 kB in 2s (5233 kB/s) Reading package lists... Reading package lists... Building dependency tree... Reading state information... perl is already the newest version (5.28.1-6+deb10u1). perl set to manually installed. The following additional packages will be installed: distro-info-data libpq-dev libpq5 lsb-release postgresql-client-11 postgresql-client-common Suggested packages: postgresql-doc-11 lsb postgresql-11 The following NEW packages will be installed: distro-info-data lsb-release postgresql-client postgresql-client-11 postgresql-client-common The following packages will be upgraded: libpq-dev libpq5 2 upgraded, 5 newly installed, 0 to remove and 165 not upgraded. Need to get 1942 kB of archives. After this operation, 6625 kB of additional disk space will be used. Get:1 http://security.debian.org/debian-security buster/updates/main amd64 distro-info-data all 0.41+deb10u9 [7832 B] Get:2 http://security.debian.org/debian-security buster/updates/main amd64 libpq-dev amd64 11.22-0+deb10u2 [171 kB] Get:3 http://deb.debian.org/debian buster/main amd64 lsb-release all 10.2019051400 [27.5 kB] Get:4 http://deb.debian.org/debian buster/main amd64 postgresql-client-common all 200+deb10u5 [85.0 kB] Get:5 http://deb.debian.org/debian buster/main amd64 postgresql-client all 11+200+deb10u5 [61.1 kB] Get:6 http://security.debian.org/debian-security buster/updates/main amd64 libpq5 amd64 11.22-0+deb10u2 [175 kB] Get:7 http://security.debian.org/debian-security buster/updates/main amd64 postgresql-client-11 amd64 11.22-0+deb10u2 [1415 kB] debconf: delaying package configuration, since apt-utils is not installed Fetched 1942 kB in 1s (1549 kB/s) Selecting previously unselected package distro-info-data. (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 23987 files and directories currently installed.) Preparing to unpack .../0-distro-info-data_0.41+deb10u9_all.deb ... Unpacking distro-info-data (0.41+deb10u9) ... Preparing to unpack .../1-libpq-dev_11.22-0+deb10u2_amd64.deb ... Unpacking libpq-dev (11.22-0+deb10u2) over (11.12-0+deb10u1) ... Preparing to unpack .../2-libpq5_11.22-0+deb10u2_amd64.deb ... Unpacking libpq5:amd64 (11.22-0+deb10u2) over (11.12-0+deb10u1) ... Selecting previously unselected package lsb-release. Preparing to unpack .../3-lsb-release_10.2019051400_all.deb ... Unpacking lsb-release (10.2019051400) ... Selecting previously unselected package postgresql-client-common. Preparing to unpack .../4-postgresql-client-common_200+deb10u5_all.deb ... Unpacking postgresql-client-common (200+deb10u5) ... Selecting previously unselected package postgresql-client-11. Preparing to unpack .../5-postgresql-client-11_11.22-0+deb10u2_amd64.deb ... Unpacking postgresql-client-11 (11.22-0+deb10u2) ... Selecting previously unselected package postgresql-client. Preparing to unpack .../6-postgresql-client_11+200+deb10u5_all.deb ... Unpacking postgresql-client (11+200+deb10u5) ... Setting up postgresql-client-common (200+deb10u5) ... Setting up distro-info-data (0.41+deb10u9) ... Setting up libpq5:amd64 (11.22-0+deb10u2) ... Setting up libpq-dev (11.22-0+deb10u2) ... Setting up postgresql-client-11 (11.22-0+deb10u2) ... update-alternatives: using /usr/share/postgresql/11/man/man1/psql.1.gz to provide /usr/share/man/man1/psql.1.gz (psql.1.gz) in auto mode Setting up lsb-release (10.2019051400) ... Setting up postgresql-client (11+200+deb10u5) ... Processing triggers for libc-bin (2.28-10) ... '/root/.cache/cpanm' -> '/root/bin/cpanm' --> Working on local::lib Fetching http://www.cpan.org/authors/id/H/HA/HAARG/local-lib-2.000029.tar.gz ... OK Configuring local-lib-2.000029 ... OK Building and testing local-lib-2.000029 ... OK Successfully installed local-lib-2.000029 1 distribution installed Attempting to create directory /root/perl5 Successfully installed Module-Build-0.4234 Successfully installed URI-5.28 Successfully installed URI-Nested-0.10 Successfully installed URI-db-0.22 Successfully installed Sub-Install-0.929 Successfully installed Params-Util-1.102 Successfully installed Data-OptList-0.114 Successfully installed Sub-Exporter-0.991 Successfully installed Encode-Locale-1.05 Successfully installed String-Formatter-1.235 Successfully installed DBI-1.643 Successfully installed Clone-0.47 Successfully installed Clone-Choose-0.010 Successfully installed Hash-Merge-0.302 Successfully installed Module-Runtime-0.016 Successfully installed MooX-Types-MooseLike-0.29 Successfully installed Sub-Uplevel-0.2800 Successfully installed Test-Exception-0.43 Successfully installed Sub-Quote-2.006008 Successfully installed Role-Tiny-2.002004 Successfully installed Class-Method-Modifiers-2.15 Successfully installed Moo-2.005005 Successfully installed Config-GitLike-1.18 Successfully installed Try-Tiny-0.32 Successfully installed libintl-perl-1.33 Successfully installed Template-Tiny-1.14 Successfully installed Devel-StackTrace-2.05 Successfully installed IPC-System-Simple-1.30 Successfully installed Throwable-1.001 Successfully installed Exporter-Tiny-1.006002 Successfully installed Type-Tiny-2.004000 Successfully installed Dist-CheckConflicts-0.11 Successfully installed Eval-Closure-0.14 Successfully installed MRO-Compat-0.15 Successfully installed Test-Fatal-0.017 Successfully installed XString-0.005 Successfully installed Specio-0.48 Successfully installed Sub-Identify-0.14 Successfully installed Module-Implementation-0.09 Successfully installed Sub-Exporter-Progressive-0.001013 Successfully installed Variable-Magic-0.64 Successfully installed B-Hooks-EndOfScope-0.28 Successfully installed Package-Stash-XS-0.30 Successfully installed Package-Stash-0.40 Successfully installed namespace-clean-0.27 Successfully installed namespace-autoclean-0.29 Successfully installed Class-Data-Inheritable-0.09 Successfully installed Exception-Class-1.45 Successfully installed Params-ValidationCompiler-0.31 Successfully installed File-ShareDir-Install-0.14 Successfully installed Class-Inspector-1.36 Successfully installed File-ShareDir-1.118 Successfully installed DateTime-Locale-1.43 Successfully installed Class-Singleton-1.6 Successfully installed DateTime-TimeZone-2.62 Successfully installed DateTime-1.65 Successfully installed Path-Class-0.37 Successfully installed PerlIO-utf8_strict-0.010 Successfully installed String-ShellQuote-1.04 Successfully installed Algorithm-Backoff-0.010 Successfully installed TermReadKey-2.38 Successfully installed File-Which-1.27 Successfully installed IO-Pager-2.10 Successfully installed List-MoreUtils-XS-0.430 Successfully installed List-MoreUtils-0.430 Successfully installed IPC-Run3-0.049 Successfully installed App-Sqitch-v1.4.1 67 distributions installed Successfully installed DBD-Pg-3.18.0 1 distribution installed sqitch (App::Sqitch) v1.4.1 Adding registry tables to job_board_test Deploying changes to job_board_test + appschema ........................ ok + images ........................... ok + images_indices ................... ok + jobs ............................. ok + jobs_indices ..................... ok + jobs_images_updated_at_defaults .. ok Verifying job_board_test * appschema ........................ ok * images ........................... ok * images_indices ................... ok * jobs ............................. ok * jobs_indices ..................... ok * jobs_images_updated_at_defaults .. ok Verify successful Successfully installed bundler-2.0.1 1 gem installed Fetching gem metadata from https://rubygems.org/......... Fetching https://github.com/travis-ci/travis-logger.git Fetching rake 12.3.1 Installing rake 12.3.1 Fetching concurrent-ruby 1.0.5 Installing concurrent-ruby 1.0.5 Fetching i18n 1.1.1 Installing i18n 1.1.1 Fetching minitest 5.11.3 Installing minitest 5.11.3 Fetching thread_safe 0.3.6 Installing thread_safe 0.3.6 Fetching tzinfo 1.2.5 Installing tzinfo 1.2.5 Fetching activesupport 5.2.1 Installing activesupport 5.2.1 Fetching public_suffix 3.0.3 Installing public_suffix 3.0.3 Fetching addressable 2.5.2 Installing addressable 2.5.2 Fetching ast 2.4.0 Installing ast 2.4.0 Fetching backports 3.11.4 Installing backports 3.11.4 Using bundler 2.0.1 Fetching coderay 1.1.2 Installing coderay 1.1.2 Fetching connection_pool 2.2.2 Installing connection_pool 2.2.2 Fetching diff-lcs 1.3 Installing diff-lcs 1.3 Fetching docile 1.1.5 Installing docile 1.1.5 Fetching factory_girl 4.9.0 Installing factory_girl 4.9.0 Fetching redis 4.0.2 Installing redis 4.0.2 Fetching fakeredis 0.7.0 Installing fakeredis 0.7.0 Fetching multipart-post 2.0.0 Installing multipart-post 2.0.0 Fetching faraday 0.15.3 Installing faraday 0.15.3 Fetching hashr 2.0.1 Installing hashr 2.0.1 Fetching jaro_winkler 1.5.1 Installing jaro_winkler 1.5.1 with native extensions Fetching jemalloc 1.0.1 Installing jemalloc 1.0.1 with native extensions Using json 2.1.0 Fetching jwt 2.1.0 Installing jwt 2.1.0 Fetching method_source 0.9.0 Installing method_source 0.9.0 Fetching multi_json 1.13.1 Installing multi_json 1.13.1 Fetching mustermann 1.0.3 Installing mustermann 1.0.3 Fetching parallel 1.12.1 Installing parallel 1.12.1 Fetching parser 2.5.1.2 Installing parser 2.5.1.2 Fetching pg 1.1.3 Installing pg 1.1.3 with native extensions Fetching powerpack 0.1.2 Installing powerpack 0.1.2 Fetching pry 0.11.3 Installing pry 0.11.3 Fetching puma 3.12.0 Installing puma 3.12.0 with native extensions Fetching rack 2.0.6 Installing rack 2.0.6 Fetching rack-protection 2.0.4 Installing rack-protection 2.0.4 Fetching rack-ssl 1.4.1 Installing rack-ssl 1.4.1 Fetching rack-test 1.1.0 Installing rack-test 1.1.0 Fetching rainbow 3.0.0 Installing rainbow 3.0.0 Fetching redis-namespace 1.6.0 Installing redis-namespace 1.6.0 Fetching rspec-support 3.8.0 Installing rspec-support 3.8.0 Fetching rspec-core 3.8.0 Installing rspec-core 3.8.0 Fetching rspec-expectations 3.8.2 Installing rspec-expectations 3.8.2 Fetching rspec-mocks 3.8.0 Installing rspec-mocks 3.8.0 Fetching rspec 3.8.0 Installing rspec 3.8.0 Fetching ruby-progressbar 1.10.0 Installing ruby-progressbar 1.10.0 Fetching unicode-display_width 1.4.0 Installing unicode-display_width 1.4.0 Fetching rubocop 0.59.2 Installing rubocop 0.59.2 Fetching sentry-raven 2.7.4 Installing sentry-raven 2.7.4 Fetching sequel 5.13.0 Installing sequel 5.13.0 Fetching simplecov-html 0.10.2 Installing simplecov-html 0.10.2 Fetching simplecov 0.13.0 Installing simplecov 0.13.0 Fetching tilt 2.0.8 Installing tilt 2.0.8 Fetching sinatra 2.0.4 Installing sinatra 2.0.4 Fetching sinatra-contrib 2.0.4 Installing sinatra-contrib 2.0.4 Fetching sinatra-param 1.5.0 Installing sinatra-param 1.5.0 Fetching travis-config 1.1.3 Installing travis-config 1.1.3 Using travis-logger 0.0.1 from https://github.com/travis-ci/travis-logger.git (at master@b589e0c) Bundle complete! 26 Gemfile dependencies, 59 gems now installed. Use `bundle info [gemname]` to see where a bundled gem is installed. DEPRECATION WARNING: The factory_girl gem is deprecated. Please upgrade to factory_bot. See https://github.com/thoughtbot/factory_bot/blob/v4.9.0/UPGRADE_FROM_FACTORY_GIRL.md for further instructions. (called from require at /usr/src/app/spec/support.rb:20) Randomized with seed 17147 Worker Interaction Connection refused - connect(2) for "127.0.0.1" port 11164 Connection refused - connect(2) for "127.0.0.1" port 11264 schedules the correct job count schedules jobs schedules each job only once marks jobs completed only when completed (FAILED - 1) completes all jobs even when worker(s) disappear removes all records of completed jobs (FAILED - 2) Failures: 1) Worker Interaction marks jobs completed only when completed Failure/Error: expect(finished.length).to eq job_count expected: 80 got: 0 (compared using ==) # ./spec/integration/worker_interaction_spec.rb:153:in `block (2 levels) in <top (required)>' 2) Worker Interaction removes all records of completed jobs Failure/Error: expect( JobBoard::Models::Job.where(site: 'test').select(:job_id).map(:job_id) ).to be_empty expected `["100001", "100002", "100003", "100004", "100005", "100006", "100007", "100008", "100009", "100010", ... "100071", "100072", "100073", "100074", "100075", "100076", "100077", "100078", "100079", "100080"].empty?` to return true, got false # ./spec/integration/worker_interaction_spec.rb:140:in `block (2 levels) in <top (required)>' Finished in 3 minutes 6.2 seconds (files took 0.50216 seconds to load) 6 examples, 2 failures Failed examples: rspec ./spec/integration/worker_interaction_spec.rb:149 # Worker Interaction marks jobs completed only when completed rspec ./spec/integration/worker_interaction_spec.rb:139 # Worker Interaction removes all records of completed jobs Randomized with seed 17147 job-board-postgres job-board-redis make: *** [Makefile:52: http-job-test] Error 1 travis_time:end:022353d2:start=1724142695170972000,finish=1724143090656864776,duration=395485892776,event=script [0K[31;1mThe command "make http-job-test" exited with 2.[0m travis_fold:start:before_cache [0Ktravis_time:start:08d926a0 [0K$ make clean ./script/clean removed '/home/travis/gopath/bin/travis-worker' travis_time:end:08d926a0:start=1724143090664612315,finish=1724143090823974605,duration=159362290,event=before_cache [0Ktravis_fold:end:before_cache [0Ktravis_fold:start:cache.2 [0Kstore build cache travis_time:start:35f17564 [0Ktravis_time:end:35f17564:start=1724143090831188582,finish=1724143090834893368,duration=3704786,event=cache [0Ktravis_time:start:239445cc [0K[32;1mchanges detected, packing new archive[0m gzip: warning: GZIP environment variable is deprecated; use an alias or script [32;1muploading PR.675/cache--linux-focal-8e66efc74188d5464db6c5a9d3decd4835ed340208a6ac39f04af14f2f93a35a--go-1.22.x.tgz[0m [32;1mcache uploaded[0m travis_time:end:239445cc:start=1724143090841040524,finish=1724143115894325385,duration=25053284861,event=cache [0Ktravis_fold:end:cache.2 [0K Done. Your build exited with 1.