travis_fold:start:worker_info [0K[33;1mWorker information[0m hostname: 41a5e40d-284f-4930-a1b6-3c46f1b76628@1.worker-n2-com-779d777f7b-hxsb6.gce-production-1 version: 6.2.22 https://github.com/travis-ci/worker/tree/858cb91994a513269f2fe9782c15fc113e966231 instance: travis-job-ef622a91-5bd2-4ff2-b6b3-cf582bd67c32 travis-ci-ubuntu-2004-1707238145-6d1d1b02 (via amqp) startup: 6.529485318s travis_fold:end:worker_info [0Ktravis_time:start:0653f798 [0Ktravis_time:end:0653f798:start=1709108402734044633,finish=1709108403094556569,duration=360511936,event=no_world_writable_dirs [0Ktravis_time:start:090e02f0 [0Ktravis_time:end:090e02f0:start=1709108403097754626,finish=1709108403106561664,duration=8807038,event=agent [0Ktravis_time:start:045e8cc9 [0Ktravis_time:end:045e8cc9:start=1709108403109503395,finish=1709108403111636857,duration=2133462,event=check_unsupported [0Ktravis_time:start:11bc35f2 [0Ktravis_fold:start:system_info [0K[33;1mBuild system information[0m Build language: ruby Build dist: focal Build id: 269162204 Job id: 618435581 Runtime kernel version: 5.15.0-1049-gcp travis-build version: f3de9fb7 [34m[1mBuild image provisioning date and time[0m Tue 06 Feb 2024 05:15:48 PM 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 4a0cff6 https://github.com/travis-ci/travis-cookbooks/tree/4a0cff6 [34m[1mgit version[0m git version 2.43.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.5 API version: 1.43 Go version: go1.20.3 Git commit: 24.0.5-0ubuntu1~20.04.1 Built: Mon Aug 21 19:50:14 2023 OS/Arch: linux/amd64 Context: default Server: Engine: Version: 24.0.5 API version: 1.43 (minimum version 1.12) Go version: go1.20.3 Git commit: 24.0.5-0ubuntu1~20.04.1 Built: Mon Aug 21 19:50:14 2023 OS/Arch: linux/amd64 Experimental: false containerd: Version: 1.7.2 GitCommit: runc: Version: 1.1.7-0ubuntu1~20.04.2 GitCommit: docker-init: Version: 0.19.0 GitCommit: [34m[1mclang version[0m clang version 16.0.0 [34m[1mjq version[0m jq-1.7 [34m[1mbats version[0m Bats 0.4.0 [34m[1mshellcheck version[0m 0.9.0 [34m[1mshfmt version[0m v3.7.0 [34m[1mccache version[0m 3.7.7 [34m[1mcmake version[0m cmake version 3.26.3 [34m[1mheroku version[0m heroku/8.7.1 linux-x64 node-v16.19.0 [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.36-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 1.9.4 [34m[1mpostgresql client version[0m psql (PostgreSQL) 13.13 (Ubuntu 13.13-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 Dec 07 2023 15:42:49) [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.39.7 [34m[1mperlbrew version[0m /home/travis/perl5/perlbrew/bin/perlbrew - App::perlbrew/0.95 [34m[1mphpenv version[0m rbenv 1.2.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 2.7.6p219 (2022-04-12 revision c9c2245c0a) [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.28 [34m[1mPhantomJS version[0m 2.1.1 [34m[1mRedis version[0m redis-server 7.2.4 [34m[1mPre-installed Go versions[0m 1.11.1 [34m[1mmvn version[0m Apache Maven 3.9.4 (dfbb324ad4a7c8fb0bf182e6d91b0ae20e3d2dd9) [34m[1mgradle version[0m Gradle 8.3! [34m[1mlein version[0m Leiningen 2.11.1 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.19.0 v18.4.0 v20.11.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.5.9 ruby-2.7.6 ruby-3.1.2 travis_fold:end:system_info [0K travis_time:end:11bc35f2:start=1709108403114978969,finish=1709108403125527879,duration=10548910,event=show_system_info [0Ktravis_time:start:029a90a8 [0Ktravis_time:end:029a90a8:start=1709108403128673202,finish=1709108403152111002,duration=23437800,event=rm_riak_source [0Ktravis_time:start:01a639da [0Ktravis_time:end:01a639da:start=1709108403156014678,finish=1709108403161945769,duration=5931091,event=fix_rwky_redis [0Ktravis_time:start:04940940 [0Ktravis_time:end:04940940:start=1709108403165553796,finish=1709108403976619724,duration=811065928,event=wait_for_network [0Ktravis_time:start:117bf280 [0Ktravis_time:end:117bf280:start=1709108403979704537,finish=1709108404310060796,duration=330356259,event=update_apt_keys [0Ktravis_time:start:0961d7a2 [0Ktravis_time:end:0961d7a2:start=1709108404312877935,finish=1709108404368436349,duration=55558414,event=fix_hhvm_source [0Ktravis_time:start:147f9e37 [0Ktravis_time:end:147f9e37:start=1709108404371403931,finish=1709108404384190126,duration=12786195,event=update_mongo_arch [0Ktravis_time:start:00264c52 [0Ktravis_time:end:00264c52:start=1709108404386889164,finish=1709108404421093755,duration=34204591,event=fix_sudo_enabled_trusty [0Ktravis_time:start:24b4834e [0Ktravis_time:end:24b4834e:start=1709108404423942160,finish=1709108404425952298,duration=2010138,event=update_glibc [0Ktravis_time:start:1b0c1cb0 [0Ktravis_time:end:1b0c1cb0:start=1709108404428466879,finish=1709108404436342496,duration=7875617,event=clean_up_path [0Ktravis_time:start:19b4b0d6 [0Ktravis_time:end:19b4b0d6:start=1709108404439014530,finish=1709108404449841589,duration=10827059,event=fix_resolv_conf [0Ktravis_time:start:0e2e080a [0Ktravis_time:end:0e2e080a:start=1709108404452768256,finish=1709108404480704944,duration=27936688,event=fix_etc_hosts [0Ktravis_time:start:0bd030ff [0Ktravis_time:end:0bd030ff:start=1709108404483515222,finish=1709108404490555332,duration=7040110,event=fix_mvn_settings_xml [0Ktravis_time:start:1d256f90 [0Ktravis_time:end:1d256f90:start=1709108404493204980,finish=1709108404502793533,duration=9588553,event=no_ipv6_localhost [0Ktravis_time:start:0ee1fe66 [0Ktravis_time:end:0ee1fe66:start=1709108404505417475,finish=1709108404507279002,duration=1861527,event=fix_etc_mavenrc [0Ktravis_time:start:2232c82e [0KOK travis_time:end:2232c82e:start=1709108404509805026,finish=1709108404846915436,duration=337110410,event=fix_perforce_key [0Ktravis_time:start:018a9ea5 [0Ktravis_time:end:018a9ea5:start=1709108404849720660,finish=1709108404852301962,duration=2581302,event=fix_wwdr_certificate [0Ktravis_time:start:237e0d60 [0Ktravis_time:end:237e0d60:start=1709108404854935449,finish=1709108404908716971,duration=53781522,event=put_localhost_first [0Ktravis_time:start:2abf03e5 [0Ktravis_time:end:2abf03e5:start=1709108404911570089,finish=1709108404914250856,duration=2680767,event=home_paths [0Ktravis_time:start:056e8d44 [0Ktravis_time:end:056e8d44:start=1709108404916965544,finish=1709108404930263773,duration=13298229,event=disable_initramfs [0Ktravis_time:start:0c8df2a6 [0Ktravis_time:end:0c8df2a6:start=1709108404933022588,finish=1709108405081581007,duration=148558419,event=disable_ssh_roaming [0Ktravis_time:start:1bfb12ca [0Ktravis_time:end:1bfb12ca:start=1709108405084309250,finish=1709108405086235487,duration=1926237,event=debug_tools [0Ktravis_time:start:0127c8ca [0Ktravis_time:end:0127c8ca:start=1709108405088793079,finish=1709108405091415601,duration=2622522,event=uninstall_oclint [0Ktravis_time:start:03485f28 [0Ktravis_time:end:03485f28:start=1709108405094261732,finish=1709108405096755146,duration=2493414,event=rvm_use [0Ktravis_time:start:11d4fb2d [0Ktravis_time:end:11d4fb2d:start=1709108405099281368,finish=1709108405106689696,duration=7408328,event=rm_etc_boto_cfg [0Ktravis_time:start:0fb8d246 [0Ktravis_time:end:0fb8d246:start=1709108405112643598,finish=1709108405115465225,duration=2821627,event=rm_oraclejdk8_symlink [0Ktravis_time:start:2d29906d [0Ktravis_time:end:2d29906d:start=1709108405119240095,finish=1709108405228142020,duration=108901925,event=enable_i386 [0Ktravis_time:start:204b440c [0Ktravis_time:end:204b440c:start=1709108405230883533,finish=1709108405234618000,duration=3734467,event=update_rubygems [0Ktravis_time:start:0912ed69 [0Ktravis_time:end:0912ed69:start=1709108405237409493,finish=1709108406121452796,duration=884043303,event=ensure_path_components [0Ktravis_time:start:08bc3c4f [0Ktravis_time:end:08bc3c4f:start=1709108406124192615,finish=1709108406126023534,duration=1830919,event=redefine_curl [0Ktravis_time:start:0a255958 [0Ktravis_time:end:0a255958:start=1709108406128527829,finish=1709108406130410019,duration=1882190,event=nonblock_pipe [0Ktravis_time:start:26562308 [0Ktravis_time:end:26562308:start=1709108406132900522,finish=1709108412169159061,duration=6036258539,event=apt_get_update [0Ktravis_time:start:07ccaec6 [0Ktravis_time:end:07ccaec6:start=1709108412172666903,finish=1709108412174918356,duration=2251453,event=deprecate_xcode_64 [0Ktravis_time:start:022071c6 [0Ktravis_time:end:022071c6:start=1709108412177794865,finish=1709108416086422073,duration=3908627208,event=update_heroku [0Ktravis_time:start:10398480 [0Ktravis_time:end:10398480:start=1709108416089482155,finish=1709108416091528609,duration=2046454,event=shell_session_update [0Ktravis_time:start:14a823a0 [0Ktravis_fold:start:docker_mtu_and_registry_mirrors [0Ktravis_fold:end:docker_mtu_and_registry_mirrors [0Ktravis_time:end:14a823a0:start=1709108416094282019,finish=1709108418284566035,duration=2190284016,event=set_docker_mtu_and_registry_mirrors [0Ktravis_time:start:006af138 [0Ktravis_fold:start:resolvconf [0Ktravis_fold:end:resolvconf [0Ktravis_time:end:006af138:start=1709108418287637676,finish=1709108418345923415,duration=58285739,event=resolvconf [0Ktravis_time:start:00b4dc50 [0Ktravis_time:end:00b4dc50:start=1709108418348875866,finish=1709108418460651447,duration=111775581,event=maven_central_mirror [0Ktravis_time:start:0868ef90 [0Ktravis_time:end:0868ef90:start=1709108418463584640,finish=1709108418553528028,duration=89943388,event=maven_https [0Ktravis_fold:start:apt [0Ktravis_time:start:006ab8a0 [0K$ travis_apt_get_update travis_time:end:006ab8a0:start=1709108418556953343,finish=1709108430966126386,duration=12409173043,event=prepare [0K[33;1mInstalling APT Packages[0m [33;1mPostgreSQL package is detected. Stopping postgresql service. See https://github.com/travis-ci/travis-ci/issues/5737 for more information.[0m $ sudo systemctl stop postgresql travis_time:start:0281281e [0K$ sudo -E apt-get -yq --no-install-suggests --no-install-recommends $(travis_apt_get_options) install postgresql-11 postgresql-client-11 Reading package lists... Building dependency tree... Reading state information... The following packages were automatically installed and are no longer required: libjs-jquery-metadata libjs-jquery-tablesorter postgresql-client-12 Use 'sudo apt autoremove' to remove them. Suggested packages: postgresql-doc-11 Recommended packages: sysstat The following NEW packages will be installed: postgresql-11 postgresql-client-11 0 upgraded, 2 newly installed, 0 to remove and 44 not upgraded. Need to get 15.8 MB of archives. After this operation, 54.1 MB of additional disk space will be used. Get:1 http://apt.postgresql.org/pub/repos/apt focal-pgdg/main amd64 postgresql-client-11 amd64 11.22-2.pgdg20.04+1 [1,494 kB] Get:2 http://apt.postgresql.org/pub/repos/apt focal-pgdg/main amd64 postgresql-11 amd64 11.22-2.pgdg20.04+1 [14.3 MB] Fetched 15.8 MB in 2s (7,348 kB/s) Preconfiguring packages ... Selecting previously unselected package postgresql-client-11. (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 ... 198539 files and directories currently installed.) Preparing to unpack .../postgresql-client-11_11.22-2.pgdg20.04+1_amd64.deb ... Unpacking postgresql-client-11 (11.22-2.pgdg20.04+1) ... Selecting previously unselected package postgresql-11. Preparing to unpack .../postgresql-11_11.22-2.pgdg20.04+1_amd64.deb ... Unpacking postgresql-11 (11.22-2.pgdg20.04+1) ... Setting up postgresql-client-11 (11.22-2.pgdg20.04+1) ... Setting up postgresql-11 (11.22-2.pgdg20.04+1) ... Creating new PostgreSQL cluster 11/main ... /usr/lib/postgresql/11/bin/initdb -D /var/lib/postgresql/11/main --auth-local peer --auth-host md5 The files belonging to this database system will be owned by user "postgres". This user must also own the server process. The database cluster will be initialized with locale "en_US.UTF-8". The default database encoding has accordingly been set to "UTF8". The default text search configuration will be set to "english". Data page checksums are disabled. fixing permissions on existing directory /var/lib/postgresql/11/main ... ok creating subdirectories ... ok selecting default max_connections ... 100 selecting default shared_buffers ... 128MB selecting default timezone ... UTC selecting dynamic shared memory implementation ... posix creating configuration files ... ok running bootstrap script ... ok performing post-bootstrap initialization ... ok syncing data to disk ... ok Success. You can now start the database server using: pg_ctlcluster 11 main start Processing triggers for postgresql-common (256.pgdg20.04+1) ... Building PostgreSQL dictionaries from installed myspell/hunspell packages... en_us Removing obsolete dictionary files: travis_time:end:0281281e:start=1709108430986745466,finish=1709108444096371994,duration=13109626528,event=prepare [0Ktravis_fold:end:apt [0Ktravis_time:start:0ba7ae56 [0Ktravis_fold:start:services [0Ktravis_fold:end:services [0Ktravis_time:end:0ba7ae56:start=1709108444100120591,finish=1709108447105785970,duration=3005665379,event=services [0Ktravis_time:start:0787d3c6 [0Ktravis_time:end:0787d3c6:start=1709108447108883266,finish=1709108447111022596,duration=2139330,event=fix_ps4 [0Ktravis_fold:start:postgresql [0Ktravis_time:start:13c5b8f0 [0K$ travis_setup_postgresql 11 [33;1mStarting PostgreSQL v11[0K sudo systemctl start postgresql@11-main travis_time:end:13c5b8f0:start=1709108447113983809,finish=1709108449892904385,duration=2778920576,event=prepare [0Ktravis_fold:end:postgresql [0Ktravis_time:start:07e63b6d [0K travis_fold:start:git.checkout [0Ktravis_time:start:19d5d574 [0Ktravis_time:end:19d5d574:start=1709108449899590619,finish=1709108449905195191,duration=5604572,event=checkout [0Ktravis_time:start:02ab4b14 [0K$ git clone --depth=50 --branch=prd-ruby-upgrade-dev https://github.com/travis-ci/marginalia.git travis-ci/marginalia Cloning into 'travis-ci/marginalia'... remote: Enumerating objects: 606, done.[K remote: Counting objects: 0% (1/606)[K remote: Counting objects: 1% (7/606)[K remote: Counting objects: 2% (13/606)[K remote: Counting objects: 3% (19/606)[K remote: Counting objects: 4% (25/606)[K remote: Counting objects: 5% (31/606)[K remote: Counting objects: 6% (37/606)[K remote: Counting objects: 7% (43/606)[K remote: Counting objects: 8% (49/606)[K remote: Counting objects: 9% (55/606)[K remote: Counting objects: 10% (61/606)[K remote: Counting objects: 11% (67/606)[K remote: Counting objects: 12% (73/606)[K remote: Counting objects: 13% (79/606)[K remote: Counting objects: 14% (85/606)[K remote: Counting objects: 15% (91/606)[K remote: Counting objects: 16% (97/606)[K remote: Counting objects: 17% (104/606)[K remote: Counting objects: 18% (110/606)[K remote: Counting objects: 19% (116/606)[K remote: Counting objects: 20% (122/606)[K remote: Counting objects: 21% (128/606)[K remote: Counting objects: 22% (134/606)[K remote: Counting objects: 23% (140/606)[K remote: Counting objects: 24% (146/606)[K remote: Counting objects: 25% (152/606)[K remote: Counting objects: 26% (158/606)[K remote: Counting objects: 27% (164/606)[K remote: Counting objects: 28% (170/606)[K remote: Counting objects: 29% (176/606)[K remote: Counting objects: 30% (182/606)[K remote: Counting objects: 31% (188/606)[K remote: Counting objects: 32% (194/606)[K remote: Counting objects: 33% (200/606)[K remote: Counting objects: 34% (207/606)[K remote: Counting objects: 35% (213/606)[K remote: Counting objects: 36% (219/606)[K remote: Counting objects: 37% (225/606)[K remote: Counting objects: 38% (231/606)[K remote: Counting objects: 39% (237/606)[K remote: Counting objects: 40% (243/606)[K remote: Counting objects: 41% (249/606)[K remote: Counting objects: 42% (255/606)[K remote: Counting objects: 43% (261/606)[K remote: Counting objects: 44% (267/606)[K remote: Counting objects: 45% (273/606)[K remote: Counting objects: 46% (279/606)[K remote: Counting objects: 47% (285/606)[K remote: Counting objects: 48% (291/606)[K remote: Counting objects: 49% (297/606)[K remote: Counting objects: 50% (303/606)[K remote: Counting objects: 51% (310/606)[K remote: Counting objects: 52% (316/606)[K remote: Counting objects: 53% (322/606)[K remote: Counting objects: 54% (328/606)[K remote: Counting objects: 55% (334/606)[K remote: Counting objects: 56% (340/606)[K remote: Counting objects: 57% (346/606)[K remote: Counting objects: 58% (352/606)[K remote: Counting objects: 59% (358/606)[K remote: Counting objects: 60% (364/606)[K remote: Counting objects: 61% (370/606)[K remote: Counting objects: 62% (376/606)[K remote: Counting objects: 63% (382/606)[K remote: Counting objects: 64% (388/606)[K remote: Counting objects: 65% (394/606)[K remote: Counting objects: 66% (400/606)[K remote: Counting objects: 67% (407/606)[K remote: Counting objects: 68% (413/606)[K remote: Counting objects: 69% (419/606)[K remote: Counting objects: 70% (425/606)[K remote: Counting objects: 71% (431/606)[K remote: Counting objects: 72% (437/606)[K remote: Counting objects: 73% (443/606)[K remote: Counting objects: 74% (449/606)[K remote: Counting objects: 75% (455/606)[K remote: Counting objects: 76% (461/606)[K remote: Counting objects: 77% (467/606)[K remote: Counting objects: 78% (473/606)[K remote: Counting objects: 79% (479/606)[K remote: Counting objects: 80% (485/606)[K remote: Counting objects: 81% (491/606)[K remote: Counting objects: 82% (497/606)[K remote: Counting objects: 83% (503/606)[K remote: Counting objects: 84% (510/606)[K remote: Counting objects: 85% (516/606)[K remote: Counting objects: 86% (522/606)[K remote: Counting objects: 87% (528/606)[K remote: Counting objects: 88% (534/606)[K remote: Counting objects: 89% (540/606)[K remote: Counting objects: 90% (546/606)[K remote: Counting objects: 91% (552/606)[K remote: Counting objects: 92% (558/606)[K remote: Counting objects: 93% (564/606)[K remote: Counting objects: 94% (570/606)[K remote: Counting objects: 95% (576/606)[K remote: Counting objects: 96% (582/606)[K remote: Counting objects: 97% (588/606)[K remote: Counting objects: 98% (594/606)[K remote: Counting objects: 99% (600/606)[K remote: Counting objects: 100% (606/606)[K remote: Counting objects: 100% (606/606), done.[K remote: Compressing objects: 0% (1/322)[K remote: Compressing objects: 1% (4/322)[K remote: Compressing objects: 2% (7/322)[K remote: Compressing objects: 3% (10/322)[K remote: Compressing objects: 4% (13/322)[K remote: Compressing objects: 5% (17/322)[K remote: Compressing objects: 6% (20/322)[K remote: Compressing objects: 7% (23/322)[K remote: Compressing objects: 8% (26/322)[K remote: Compressing objects: 9% (29/322)[K remote: Compressing objects: 10% (33/322)[K remote: Compressing objects: 11% (36/322)[K remote: Compressing objects: 12% (39/322)[K remote: Compressing objects: 13% (42/322)[K remote: Compressing objects: 14% (46/322)[K remote: Compressing objects: 15% (49/322)[K remote: Compressing objects: 16% (52/322)[K remote: Compressing objects: 17% (55/322)[K remote: Compressing objects: 18% (58/322)[K remote: Compressing objects: 19% (62/322)[K remote: Compressing objects: 20% (65/322)[K remote: Compressing objects: 21% (68/322)[K remote: Compressing objects: 22% (71/322)[K remote: Compressing objects: 23% (75/322)[K remote: Compressing objects: 24% (78/322)[K remote: Compressing objects: 25% (81/322)[K remote: Compressing objects: 26% (84/322)[K remote: Compressing objects: 27% (87/322)[K remote: Compressing objects: 28% (91/322)[K remote: Compressing objects: 29% (94/322)[K remote: Compressing objects: 30% (97/322)[K remote: Compressing objects: 31% (100/322)[K remote: Compressing objects: 32% (104/322)[K remote: Compressing objects: 33% (107/322)[K remote: Compressing objects: 34% (110/322)[K remote: Compressing objects: 35% (113/322)[K remote: Compressing objects: 36% (116/322)[K remote: Compressing objects: 37% (120/322)[K remote: Compressing objects: 38% (123/322)[K remote: Compressing objects: 39% (126/322)[K remote: Compressing objects: 40% (129/322)[K remote: Compressing objects: 41% (133/322)[K remote: Compressing objects: 42% (136/322)[K remote: Compressing objects: 43% (139/322)[K remote: Compressing objects: 44% (142/322)[K remote: Compressing objects: 45% (145/322)[K remote: Compressing objects: 46% (149/322)[K remote: Compressing objects: 47% (152/322)[K remote: Compressing objects: 48% (155/322)[K remote: Compressing objects: 49% (158/322)[K remote: Compressing objects: 50% (161/322)[K remote: Compressing objects: 51% (165/322)[K remote: Compressing objects: 52% (168/322)[K remote: Compressing objects: 53% (171/322)[K remote: Compressing objects: 54% (174/322)[K remote: Compressing objects: 55% (178/322)[K remote: Compressing objects: 56% (181/322)[K remote: Compressing objects: 57% (184/322)[K remote: Compressing objects: 58% (187/322)[K remote: Compressing objects: 59% (190/322)[K remote: Compressing objects: 60% (194/322)[K remote: Compressing objects: 61% (197/322)[K remote: Compressing objects: 62% (200/322)[K remote: Compressing objects: 63% (203/322)[K remote: Compressing objects: 64% (207/322)[K remote: Compressing objects: 65% (210/322)[K remote: Compressing objects: 66% (213/322)[K remote: Compressing objects: 67% (216/322)[K remote: Compressing objects: 68% (219/322)[K remote: Compressing objects: 69% (223/322)[K remote: Compressing objects: 70% (226/322)[K remote: Compressing objects: 71% (229/322)[K remote: Compressing objects: 72% (232/322)[K remote: Compressing objects: 73% (236/322)[K remote: Compressing objects: 74% (239/322)[K remote: Compressing objects: 75% (242/322)[K remote: Compressing objects: 76% (245/322)[K remote: Compressing objects: 77% (248/322)[K remote: Compressing objects: 78% (252/322)[K remote: Compressing objects: 79% (255/322)[K remote: Compressing objects: 80% (258/322)[K remote: Compressing objects: 81% (261/322)[K remote: Compressing objects: 82% (265/322)[K remote: Compressing objects: 83% (268/322)[K remote: Compressing objects: 84% (271/322)[K remote: Compressing objects: 85% (274/322)[K remote: Compressing objects: 86% (277/322)[K remote: Compressing objects: 87% (281/322)[K remote: Compressing objects: 88% (284/322)[K remote: Compressing objects: 89% (287/322)[K remote: Compressing objects: 90% (290/322)[K remote: Compressing objects: 91% (294/322)[K remote: Compressing objects: 92% (297/322)[K remote: Compressing objects: 93% (300/322)[K remote: Compressing objects: 94% (303/322)[K remote: Compressing objects: 95% (306/322)[K remote: Compressing objects: 96% (310/322)[K remote: Compressing objects: 97% (313/322)[K remote: Compressing objects: 98% (316/322)[K remote: Compressing objects: 99% (319/322)[K remote: Compressing objects: 100% (322/322)[K remote: Compressing objects: 100% (322/322), done.[K Receiving objects: 0% (1/606) Receiving objects: 1% (7/606) Receiving objects: 2% (13/606) Receiving objects: 3% (19/606) Receiving objects: 4% (25/606) Receiving objects: 5% (31/606) Receiving objects: 6% (37/606) Receiving objects: 7% (43/606) Receiving objects: 8% (49/606) Receiving objects: 9% (55/606) Receiving objects: 10% (61/606) Receiving objects: 11% (67/606) Receiving objects: 12% (73/606) Receiving objects: 13% (79/606) Receiving objects: 14% (85/606) Receiving objects: 15% (91/606) Receiving objects: 16% (97/606) Receiving objects: 17% (104/606) Receiving objects: 18% (110/606) Receiving objects: 19% (116/606) Receiving objects: 20% (122/606) Receiving objects: 21% (128/606) Receiving objects: 22% (134/606) Receiving objects: 23% (140/606) Receiving objects: 24% (146/606) Receiving objects: 25% (152/606) Receiving objects: 26% (158/606) Receiving objects: 27% (164/606) Receiving objects: 28% (170/606) Receiving objects: 29% (176/606) Receiving objects: 30% (182/606) Receiving objects: 31% (188/606) Receiving objects: 32% (194/606) Receiving objects: 33% (200/606) Receiving objects: 34% (207/606) Receiving objects: 35% (213/606) Receiving objects: 36% (219/606) Receiving objects: 37% (225/606) Receiving objects: 38% (231/606) Receiving objects: 39% (237/606) Receiving objects: 40% (243/606) Receiving objects: 41% (249/606) Receiving objects: 42% (255/606) Receiving objects: 43% (261/606) Receiving objects: 44% (267/606) Receiving objects: 45% (273/606) Receiving objects: 46% (279/606) Receiving objects: 47% (285/606) Receiving objects: 48% (291/606) Receiving objects: 49% (297/606) Receiving objects: 50% (303/606) Receiving objects: 51% (310/606) Receiving objects: 52% (316/606) Receiving objects: 53% (322/606) Receiving objects: 54% (328/606) Receiving objects: 55% (334/606) Receiving objects: 56% (340/606) Receiving objects: 57% (346/606) Receiving objects: 58% (352/606) Receiving objects: 59% (358/606) Receiving objects: 60% (364/606) Receiving objects: 61% (370/606) Receiving objects: 62% (376/606) Receiving objects: 63% (382/606) Receiving objects: 64% (388/606) Receiving objects: 65% (394/606) Receiving objects: 66% (400/606) Receiving objects: 67% (407/606) Receiving objects: 68% (413/606) Receiving objects: 69% (419/606) Receiving objects: 70% (425/606) Receiving objects: 71% (431/606) Receiving objects: 72% (437/606) Receiving objects: 73% (443/606) Receiving objects: 74% (449/606) Receiving objects: 75% (455/606) Receiving objects: 76% (461/606) Receiving objects: 77% (467/606) Receiving objects: 78% (473/606) Receiving objects: 79% (479/606) Receiving objects: 80% (485/606) Receiving objects: 81% (491/606) remote: Total 606 (delta 300), reused 559 (delta 258), pack-reused 0[K Receiving objects: 82% (497/606) Receiving objects: 83% (503/606) Receiving objects: 84% (510/606) Receiving objects: 85% (516/606) Receiving objects: 86% (522/606) Receiving objects: 87% (528/606) Receiving objects: 88% (534/606) Receiving objects: 89% (540/606) Receiving objects: 90% (546/606) Receiving objects: 91% (552/606) Receiving objects: 92% (558/606) Receiving objects: 93% (564/606) Receiving objects: 94% (570/606) Receiving objects: 95% (576/606) Receiving objects: 96% (582/606) Receiving objects: 97% (588/606) Receiving objects: 98% (594/606) Receiving objects: 99% (600/606) Receiving objects: 100% (606/606) Receiving objects: 100% (606/606), 87.52 KiB | 2.50 MiB/s, done. Resolving deltas: 0% (0/300) Resolving deltas: 1% (3/300) Resolving deltas: 2% (6/300) Resolving deltas: 3% (9/300) Resolving deltas: 4% (12/300) Resolving deltas: 5% (15/300) Resolving deltas: 6% (18/300) Resolving deltas: 7% (21/300) Resolving deltas: 8% (24/300) Resolving deltas: 9% (27/300) Resolving deltas: 10% (30/300) Resolving deltas: 11% (33/300) Resolving deltas: 12% (36/300) Resolving deltas: 13% (39/300) Resolving deltas: 14% (42/300) Resolving deltas: 15% (45/300) Resolving deltas: 16% (48/300) Resolving deltas: 17% (51/300) Resolving deltas: 18% (54/300) Resolving deltas: 19% (57/300) Resolving deltas: 20% (60/300) Resolving deltas: 21% (63/300) Resolving deltas: 22% (66/300) Resolving deltas: 23% (69/300) Resolving deltas: 24% (72/300) Resolving deltas: 25% (75/300) Resolving deltas: 26% (78/300) Resolving deltas: 27% (81/300) Resolving deltas: 28% (84/300) Resolving deltas: 29% (87/300) Resolving deltas: 30% (90/300) Resolving deltas: 31% (93/300) Resolving deltas: 32% (96/300) Resolving deltas: 33% (99/300) Resolving deltas: 34% (102/300) Resolving deltas: 35% (105/300) Resolving deltas: 36% (108/300) Resolving deltas: 37% (111/300) Resolving deltas: 38% (114/300) Resolving deltas: 39% (117/300) Resolving deltas: 40% (120/300) Resolving deltas: 41% (123/300) Resolving deltas: 42% (126/300) Resolving deltas: 43% (129/300) Resolving deltas: 44% (132/300) Resolving deltas: 45% (135/300) Resolving deltas: 46% (138/300) Resolving deltas: 47% (141/300) Resolving deltas: 48% (144/300) Resolving deltas: 49% (147/300) Resolving deltas: 50% (150/300) Resolving deltas: 51% (153/300) Resolving deltas: 52% (156/300) Resolving deltas: 53% (159/300) Resolving deltas: 54% (162/300) Resolving deltas: 55% (165/300) Resolving deltas: 56% (168/300) Resolving deltas: 57% (171/300) Resolving deltas: 58% (174/300) Resolving deltas: 59% (177/300) Resolving deltas: 60% (180/300) Resolving deltas: 61% (183/300) Resolving deltas: 62% (186/300) Resolving deltas: 63% (189/300) Resolving deltas: 64% (192/300) Resolving deltas: 65% (195/300) Resolving deltas: 66% (198/300) Resolving deltas: 67% (201/300) Resolving deltas: 68% (204/300) Resolving deltas: 69% (207/300) Resolving deltas: 70% (210/300) Resolving deltas: 71% (213/300) Resolving deltas: 72% (216/300) Resolving deltas: 73% (219/300) Resolving deltas: 74% (222/300) Resolving deltas: 75% (225/300) Resolving deltas: 76% (228/300) Resolving deltas: 77% (231/300) Resolving deltas: 78% (234/300) Resolving deltas: 79% (237/300) Resolving deltas: 80% (240/300) Resolving deltas: 81% (243/300) Resolving deltas: 82% (246/300) Resolving deltas: 83% (249/300) Resolving deltas: 84% (252/300) Resolving deltas: 85% (255/300) Resolving deltas: 86% (258/300) Resolving deltas: 87% (261/300) Resolving deltas: 88% (264/300) Resolving deltas: 89% (267/300) Resolving deltas: 90% (270/300) Resolving deltas: 91% (273/300) Resolving deltas: 92% (276/300) Resolving deltas: 93% (279/300) Resolving deltas: 94% (282/300) Resolving deltas: 95% (285/300) Resolving deltas: 96% (288/300) Resolving deltas: 97% (291/300) Resolving deltas: 98% (294/300) Resolving deltas: 99% (297/300) Resolving deltas: 100% (300/300) Resolving deltas: 100% (300/300), done. travis_time:end:02ab4b14:start=1709108449908471455,finish=1709108450372565268,duration=464093813,event=checkout [0K$ cd travis-ci/marginalia $ git checkout -qf af24f2a6d2c5da19626bfc469194aecf058e7b3f travis_fold:end:git.checkout [0K travis_time:end:02ab4b14:start=1709108449908471455,finish=1709108450378796762,duration=470325307,event=checkout [0Ktravis_time:start:076152b4 [0K [33;1mSetting environment variables from .travis.yml[0m $ export PGPORT=5432 $ export PGHOST=localhost $ export MARGINALIA_DB_PORT=5432 $ export MARGINALIA_LOG_FILE=/var/log/postgresql/postgresql-11-main.log travis_time:end:076152b4:start=1709108450382080828,finish=1709108450389816888,duration=7736060,event=env [0Ktravis_fold:start:rvm [0Ktravis_time:start:1cad8670 [0K$ rvm get head Downloading https://get.rvm.io [32mDownloading https://raw.githubusercontent.com/rvm/rvm/master/binscripts/rvm-installer.asc[0m [0m[32mVerifying /home/travis/.rvm/archives/rvm-installer.asc[0m [0mgpg: Signature made Tue 21 Feb 2023 11:35:16 PM UTC gpg: using RSA key 7D2BAF1CF37B13E2069D6956105BD0E739499BDB gpg: Good signature from "Piotr Kuczynski <piotr.kuczynski@gmail.com>" [unknown] gpg: WARNING: This key is not certified with a trusted signature! gpg: There is no indication that the signature belongs to the owner. Primary key fingerprint: 7D2B AF1C F37B 13E2 069D 6956 105B D0E7 3949 9BDB [32mGPG verified '/home/travis/.rvm/archives/rvm-installer'[0m [0mDownloading https://github.com/rvm/rvm/archive/master.tar.gz [32mUpgrading the RVM installation in /home/travis/.rvm/[0m [0m RVM PATH line found in /home/travis/.mkshrc /home/travis/.profile /home/travis/.zshrc. [33m RVM PATH line not found for Bash, rerun this command with '--auto-dotfiles' flag to fix it.[0m [0m RVM sourcing line found in /home/travis/.profile /home/travis/.bashrc /home/travis/.zlogin. [32mUpgrade of RVM in /home/travis/.rvm/ is complete.[0m [0m [32m[33mThanks for installing RVM ðŸ™[0m Please consider donating to our open collective to help us maintain RVM. 👉 Donate: [34mhttps://opencollective.com/rvm/donate[0m [0m [0m[32mRVM reloaded![0m [0mtravis_time:end:1cad8670:start=1709108450397838463,finish=1709108453593128898,duration=3195290435,event= [0Ktravis_time:start:0080839e [0K$ rvm use 3.2.2 --install --binary --fuzzy curl: (22) The requested URL returned error: 404 [33mRequired ruby-3.2.2 is not installed - installing.[0m [0mcurl: (22) The requested URL returned error: 404 Searching for binary rubies, this might take some time. Found remote file https://rubies.travis-ci.org/ubuntu/20.04/x86_64/ruby-3.2.2.tar.bz2 Checking requirements for ubuntu. Requirements installation successful. ruby-3.2.2 - #configure ruby-3.2.2 - #download % Total % Received % Xferd Average Speed Time Time Time Current Dload Upload Total Spent Left Speed 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0 0 32.4M 0 134k 0 0 317k 0 0:01:44 --:--:-- 0:01:44 317k 100 32.4M 100 32.4M 0 0 34.3M 0 --:--:-- --:--:-- --:--:-- 62.1M [33mNo checksum for downloaded archive, recording checksum in user configuration.[0m [0mruby-3.2.2 - #validate archive ruby-3.2.2 - #extract ruby-3.2.2 - #validate binary ruby-3.2.2 - #setup ruby-3.2.2 - #gemset created /home/travis/.rvm/gems/ruby-3.2.2@global [32mruby-3.2.2 - #importing gemset /home/travis/.rvm/gemsets/global.gems[0m|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.. [32mruby-3.2.2 - #generating global wrappers[0m|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/. [32mruby-3.2.2 - #uninstalling gem rubygems-bundler-1.4.5[0m|/. ruby-3.2.2 - #gemset created /home/travis/.rvm/gems/ruby-3.2.2 [32mruby-3.2.2 - #importing gemset /home/travis/.rvm/gemsets/default.gems[0m|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\. [32mruby-3.2.2 - #generating default wrappers[0m|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-. Using /home/travis/.rvm/gems/ruby-3.2.2 travis_time:end:0080839e:start=1709108453597410876,finish=1709108472837719548,duration=19240308672,event= [0Ktravis_fold:end:rvm [0K $ export BUNDLE_GEMFILE=$PWD/Gemfile travis_fold:start:ruby.versions [0K$ ruby --version ruby 3.2.2 (2023-03-30 revision e51014f9c0) [x86_64-linux] $ rvm --version rvm 1.29.12-next (master) by Michal Papis, Piotr Kuczynski, Wayne E. Seguin [https://rvm.io] $ bundle --version Bundler version 2.4.10 $ gem --version 3.4.10 travis_fold:end:ruby.versions [0K travis_fold:start:before_install [0Ktravis_time:start:0583f9ca [0K$ bash -c "yes | gem uninstall -i /home/travis/.rvm/gems/ruby-3.2.0@global rake" Gem 'rake' is not installed travis_time:end:0583f9ca:start=1709108473278926245,finish=1709108473456809480,duration=177883235,event=before_install [0Ktravis_fold:end:before_install [0Ktravis_fold:start:install.bundler [0Ktravis_time:start:125c8341 [0K$ bundle install --jobs=3 --retry=3 Fetching gem metadata from https://rubygems.org/....... Resolving dependencies... [32mFetching rake 13.1.0[0m [32mInstalling rake 13.1.0[0m [32mFetching base64 0.2.0[0m [32mFetching bigdecimal 3.1.6[0m [32mFetching concurrent-ruby 1.2.3[0m [32mInstalling bigdecimal 3.1.6 with native extensions[0m [32mInstalling base64 0.2.0[0m [32mFetching connection_pool 2.4.1[0m [32mInstalling concurrent-ruby 1.2.3[0m Using ruby2_keywords 0.0.5 [32mFetching minitest 5.22.2[0m [32mInstalling connection_pool 2.4.1[0m [32mFetching mutex_m 0.2.0[0m [32mInstalling minitest 5.22.2[0m [32mFetching timeout 0.4.1[0m [32mInstalling mutex_m 0.2.0[0m Using bundler 2.4.10 [32mFetching pg 1.5.5[0m [32mInstalling timeout 0.4.1[0m Using power_assert 2.0.3 [32mFetching i18n 1.14.1[0m [32mInstalling pg 1.5.5 with native extensions[0m [32mInstalling i18n 1.14.1[0m [32mFetching tzinfo 2.0.6[0m [32mInstalling tzinfo 2.0.6[0m [32mFetching drb 2.2.0[0m [32mInstalling drb 2.2.0[0m [32mFetching mocha 2.1.0[0m [32mInstalling mocha 2.1.0[0m [32mFetching test-unit 3.6.2[0m [32mInstalling test-unit 3.6.2[0m [32mFetching activesupport 7.1.3.2[0m [32mFetching sequel 5.77.0[0m [32mInstalling activesupport 7.1.3.2[0m [32mInstalling sequel 5.77.0[0m [32mFetching activemodel 7.1.3.2[0m [32mInstalling activemodel 7.1.3.2[0m [32mFetching activerecord 7.1.3.2[0m [32mInstalling activerecord 7.1.3.2[0m Using marginalia 1.5.0 from source at `.` [32mBundle complete! 7 Gemfile dependencies, 22 gems now installed.[0m [32mUse `bundle info [gemname]` to see where a bundled gem is installed.[0m travis_time:end:125c8341:start=1709108473461931910,finish=1709108492078716893,duration=18616784983,event=install [0Ktravis_fold:end:install.bundler [0K travis_fold:start:before_script [0Ktravis_time:start:0dd7f448 [0K$ sudo chmod 0644 $MARGINALIA_LOG_FILE travis_time:end:0dd7f448:start=1709108492083915155,finish=1709108492093097071,duration=9181916,event=before_script [0Ktravis_fold:end:before_script [0Ktravis_time:start:0edc7511 [0K$ bundle exec rake db:reset test:postgresql createdb: could not connect to database template1: connection to server at "localhost" (127.0.0.1), port 5432 failed: Connection refused Is the server running on that host and accepting TCP/IP connections? connection to server at "localhost" (127.0.1.1), port 5432 failed: Connection refused Is the server running on that host and accepting TCP/IP connections? set -e; for file in $(find test -type f -name '*_test.rb'); do MARGINALIA_LOG_FILE=/var/log/postgresql/postgresql-11-main.log MARGINALIA_DB_PORT=5432 ruby -Ilib -Itest $file; done /home/travis/.rvm/gems/ruby-3.2.2/gems/mocha-2.1.0/lib/mocha/test_unit.rb:5:in `<top (required)>': [1mTest::Unit must be loaded *before* `require 'mocha/test_unit'`. ([1;4mRuntimeError[m[1m)[m from <internal:/home/travis/.rvm/rubies/ruby-3.2.2/lib/ruby/3.2.0/rubygems/core_ext/kernel_require.rb>:37:in `require' from <internal:/home/travis/.rvm/rubies/ruby-3.2.2/lib/ruby/3.2.0/rubygems/core_ext/kernel_require.rb>:37:in `require' from test/sequel/query_comments_test.rb:2:in `<main>' rake aborted! Command failed with status (1): [set -e; for file in $(find test -type f -name '*_test.rb'); do MARGINALIA_LOG_FILE=/var/log/postgresql/postgresql-11-main.log MARGINALIA_DB_PORT=5432 ruby -Ilib -Itest $file; done] /home/travis/build/travis-ci/marginalia/Rakefile:15:in `block (2 levels) in <top (required)>' /home/travis/.rvm/gems/ruby-3.2.2/gems/rake-13.1.0/exe/rake:27:in `<top (required)>' /home/travis/.rvm/gems/ruby-3.2.2/bin/ruby_executable_hooks:22:in `eval' /home/travis/.rvm/gems/ruby-3.2.2/bin/ruby_executable_hooks:22:in `<main>' Tasks: TOP => test:postgresql (See full trace by running task with --trace) travis_time:end:0edc7511:start=1709108492097527803,finish=1709108492733129710,duration=635601907,event=script [0K[31;1mThe command "bundle exec rake db:reset test:postgresql" exited with 1.[0m Done. Your build exited with 1.