travis_fold:start:worker_info [0K[33;1mWorker information[0m hostname: e03eb598-b1eb-4b80-a021-0ef0a154b990@1.worker-n2-com-779d777f7b-rxlft.gce-production-1 version: 6.2.22 https://github.com/travis-ci/worker/tree/858cb91994a513269f2fe9782c15fc113e966231 instance: travis-job-70d197f2-e462-42b3-b096-9d98644602ab travis-ci-ubuntu-1804-1706776257-3d36ff62 (via amqp) startup: 6.149423611s travis_fold:end:worker_info [0Ktravis_time:start:00c2c298 [0Ktravis_time:end:00c2c298:start=1709115543623407738,finish=1709115543828172309,duration=204764571,event=no_world_writable_dirs [0Ktravis_time:start:0a52bd90 [0Ktravis_time:end:0a52bd90:start=1709115543831087530,finish=1709115543838372929,duration=7285399,event=agent [0Ktravis_time:start:04d931b4 [0Ktravis_time:end:04d931b4:start=1709115543842405455,finish=1709115543844830377,duration=2424922,event=check_unsupported [0Ktravis_time:start:342a8ab6 [0Ktravis_fold:start:system_info [0K[33;1mBuild system information[0m Build language: ruby Build dist: bionic Build id: 269165054 Job id: 618442433 Runtime kernel version: 5.4.0-1106-gcp travis-build version: f3de9fb7 [34m[1mBuild image provisioning date and time[0m Thu Feb 1 09:04:40 UTC 2024 [34m[1mOperating System Details[0m Distributor ID: Ubuntu Description: Ubuntu 18.04.6 LTS Release: 18.04 Codename: bionic [34m[1mSystemd Version[0m systemd 237 [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 4.4.20(1)-release (x86_64-pc-linux-gnu) [34m[1mgcc version[0m gcc (Ubuntu 7.5.0-3ubuntu1~18.04) 7.5.0 [34m[1mdocker version[0m Client: Version: 20.10.21 API version: 1.41 Go version: go1.18.1 Git commit: 20.10.21-0ubuntu1~18.04.3 Built: Thu Apr 27 05:50:21 2023 OS/Arch: linux/amd64 Context: default Experimental: true Server: Engine: Version: 20.10.21 API version: 1.41 (minimum version 1.12) Go version: go1.18.1 Git commit: 20.10.21-0ubuntu1~18.04.3 Built: Thu Apr 27 05:36:22 2023 OS/Arch: linux/amd64 Experimental: false containerd: Version: 1.6.12-0ubuntu1~18.04.1 GitCommit: runc: Version: 1.1.4-0ubuntu1~18.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.4.1 [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.7-4 Q16 x86_64 20170114 http://www.imagemagick.org [34m[1mmd5deep version[0m 4.4 [34m[1mmercurial version[0m version 5.3 [34m[1mmysql version[0m mysql Ver 14.14 Distrib 5.7.42, for Linux (x86_64) using EditLine wrapper [34m[1mopenssl version[0m OpenSSL 1.1.1 11 Sep 2018 [34m[1mpacker version[0m 1.9.4 [34m[1mpostgresql client version[0m psql (PostgreSQL) 11.20 (Ubuntu 11.20-1.pgdg18.04+1) [34m[1mragel version[0m Ragel State Machine Compiler version 6.10 March 2017 [34m[1msudo version[0m 1.8.21p2 [34m[1mgzip version[0m gzip 1.6 [34m[1mzip version[0m Zip 3.0 [34m[1mvim version[0m VIM - Vi IMproved 8.0 (2016 Sep 12, compiled Apr 18 2023 09:20:34) [34m[1miptables version[0m iptables v1.6.1 [34m[1mcurl version[0m curl 7.58.0 (x86_64-pc-linux-gnu) libcurl/7.58.0 OpenSSL/1.1.1 zlib/1.2.11 libidn2/2.0.4 libpsl/0.19.1 (+libidn2/2.0.4) nghttp2/1.30.0 librtmp/2.3 [34m[1mwget version[0m GNU Wget 1.19.4 built on linux-gnu. [34m[1mrsync version[0m rsync version 3.1.2 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 63.0.1 [34m[1mMongoDB version[0m MongoDB 4.4.28 [34m[1mPhantomJS version[0m 2.1.1 [34m[1mPre-installed PostgreSQL versions[0m 9.3.25 9.4.26 9.5.25 9.6.24 [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.15.1 v16.20.2 v18.19.0 v20.11.0 v4.9.1 v6.17.1 v8.17.0 [34m[1mphpenv versions[0m system 7.1 7.1.33 7.2 * 7.2.27 (set by /home/travis/.phpenv/version) 7.3 7.3.14 7.4 7.4.2 hhvm-stable hhvm [34m[1mcomposer --version[0m Composer version 1.9.2 2020-01-14 16:30:31 [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:342a8ab6:start=1709115543847710479,finish=1709115543857476193,duration=9765714,event=show_system_info [0Ktravis_time:start:0bdb8688 [0Ktravis_time:end:0bdb8688:start=1709115543860544576,finish=1709115543875655555,duration=15110979,event=rm_riak_source [0Ktravis_time:start:0c811e42 [0Ktravis_time:end:0c811e42:start=1709115543878812444,finish=1709115543884273765,duration=5461321,event=fix_rwky_redis [0Ktravis_time:start:1a420244 [0Ktravis_time:end:1a420244:start=1709115543890350545,finish=1709115544599605191,duration=709254646,event=wait_for_network [0Ktravis_time:start:004072d4 [0Ktravis_time:end:004072d4:start=1709115544602731101,finish=1709115544941920114,duration=339189013,event=update_apt_keys [0Ktravis_time:start:17c67474 [0Ktravis_time:end:17c67474:start=1709115544944795110,finish=1709115544997885988,duration=53090878,event=fix_hhvm_source [0Ktravis_time:start:28028b2e [0Ktravis_time:end:28028b2e:start=1709115545000903528,finish=1709115545003346725,duration=2443197,event=update_mongo_arch [0Ktravis_time:start:02195225 [0Ktravis_time:end:02195225:start=1709115545005957040,finish=1709115545046687167,duration=40730127,event=fix_sudo_enabled_trusty [0Ktravis_time:start:0b77f542 [0Ktravis_time:end:0b77f542:start=1709115545049661254,finish=1709115545051734482,duration=2073228,event=update_glibc [0Ktravis_time:start:212cb5c0 [0Ktravis_time:end:212cb5c0:start=1709115545054390205,finish=1709115545061996998,duration=7606793,event=clean_up_path [0Ktravis_time:start:12a87650 [0Ktravis_time:end:12a87650:start=1709115545064706881,finish=1709115545072984871,duration=8277990,event=fix_resolv_conf [0Ktravis_time:start:2119519a [0Ktravis_time:end:2119519a:start=1709115545075691580,finish=1709115545129652285,duration=53960705,event=fix_etc_hosts [0Ktravis_time:start:2bee58ec [0Ktravis_time:end:2bee58ec:start=1709115545132457800,finish=1709115545140117684,duration=7659884,event=fix_mvn_settings_xml [0Ktravis_time:start:0791344f [0Ktravis_time:end:0791344f:start=1709115545142929627,finish=1709115545152878875,duration=9949248,event=no_ipv6_localhost [0Ktravis_time:start:008fbfef [0Ktravis_time:end:008fbfef:start=1709115545155719991,finish=1709115545157713703,duration=1993712,event=fix_etc_mavenrc [0Ktravis_time:start:072f1174 [0KOK travis_time:end:072f1174:start=1709115545160397326,finish=1709115545545359323,duration=384961997,event=fix_perforce_key [0Ktravis_time:start:269421ea [0Ktravis_time:end:269421ea:start=1709115545548232349,finish=1709115545550926039,duration=2693690,event=fix_wwdr_certificate [0Ktravis_time:start:0cdc79f1 [0Ktravis_time:end:0cdc79f1:start=1709115545553627372,finish=1709115545656781338,duration=103153966,event=put_localhost_first [0Ktravis_time:start:033b0ca6 [0Ktravis_time:end:033b0ca6:start=1709115545659850956,finish=1709115545662680320,duration=2829364,event=home_paths [0Ktravis_time:start:0073a706 [0Ktravis_time:end:0073a706:start=1709115545665583201,finish=1709115545677795557,duration=12212356,event=disable_initramfs [0Ktravis_time:start:069a6b68 [0Ktravis_time:end:069a6b68:start=1709115545680782692,finish=1709115545842599499,duration=161816807,event=disable_ssh_roaming [0Ktravis_time:start:0f2e313c [0Ktravis_time:end:0f2e313c:start=1709115545845616529,finish=1709115545847821904,duration=2205375,event=debug_tools [0Ktravis_time:start:28568502 [0Ktravis_time:end:28568502:start=1709115545850563157,finish=1709115545853446907,duration=2883750,event=uninstall_oclint [0Ktravis_time:start:216850d0 [0Ktravis_time:end:216850d0:start=1709115545856264072,finish=1709115545859152162,duration=2888090,event=rvm_use [0Ktravis_time:start:3e6dcf2e [0Ktravis_time:end:3e6dcf2e:start=1709115545862037822,finish=1709115545870320784,duration=8282962,event=rm_etc_boto_cfg [0Ktravis_time:start:113a8bc4 [0Ktravis_time:end:113a8bc4:start=1709115545873348682,finish=1709115545876122655,duration=2773973,event=rm_oraclejdk8_symlink [0Ktravis_time:start:2156073d [0Ktravis_time:end:2156073d:start=1709115545879145329,finish=1709115545979857747,duration=100712418,event=enable_i386 [0Ktravis_time:start:06ab49e3 [0Ktravis_time:end:06ab49e3:start=1709115545983038813,finish=1709115545986906353,duration=3867540,event=update_rubygems [0Ktravis_time:start:03b5cd88 [0Ktravis_time:end:03b5cd88:start=1709115545989959263,finish=1709115546928155077,duration=938195814,event=ensure_path_components [0Ktravis_time:start:00feb9fb [0Ktravis_time:end:00feb9fb:start=1709115546931266176,finish=1709115546933429952,duration=2163776,event=redefine_curl [0Ktravis_time:start:01ad0885 [0Ktravis_time:end:01ad0885:start=1709115546936287945,finish=1709115546938405472,duration=2117527,event=nonblock_pipe [0Ktravis_time:start:01abf823 [0Ktravis_time:end:01abf823:start=1709115546941288257,finish=1709115552979289348,duration=6038001091,event=apt_get_update [0Ktravis_time:start:069546a0 [0Ktravis_time:end:069546a0:start=1709115552982754051,finish=1709115552985040888,duration=2286837,event=deprecate_xcode_64 [0Ktravis_time:start:0849d3d0 [0Ktravis_time:end:0849d3d0:start=1709115552987849415,finish=1709115556884983726,duration=3897134311,event=update_heroku [0Ktravis_time:start:0cf0de60 [0Ktravis_time:end:0cf0de60:start=1709115556887995379,finish=1709115556890098591,duration=2103212,event=shell_session_update [0Ktravis_time:start:06c7d148 [0Ktravis_fold:start:docker_mtu_and_registry_mirrors [0Ktravis_fold:end:docker_mtu_and_registry_mirrors [0Ktravis_time:end:06c7d148:start=1709115556892891307,finish=1709115559172115906,duration=2279224599,event=set_docker_mtu_and_registry_mirrors [0Ktravis_time:start:03b2d4e4 [0Ktravis_fold:start:resolvconf [0Ktravis_fold:end:resolvconf [0Ktravis_time:end:03b2d4e4:start=1709115559175723337,finish=1709115559244322444,duration=68599107,event=resolvconf [0Ktravis_time:start:2ca937fe [0Ktravis_time:end:2ca937fe:start=1709115559249366080,finish=1709115559389948827,duration=140582747,event=maven_central_mirror [0Ktravis_time:start:066a0cd8 [0Ktravis_time:end:066a0cd8:start=1709115559392827239,finish=1709115559482809965,duration=89982726,event=maven_https [0Ktravis_fold:start:apt [0Ktravis_time:start:1a72e132 [0K$ travis_apt_get_update travis_time:end:1a72e132:start=1709115559486688549,finish=1709115571991733466,duration=12505044917,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:193e5cf2 [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... postgresql-11 is already the newest version (11.20-1.pgdg18.04+1). postgresql-client-11 is already the newest version (11.20-1.pgdg18.04+1). postgresql-client-11 set to manually installed. The following package was automatically installed and is no longer required: libgeos-3.6.2 Use 'sudo apt autoremove' to remove it. 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. travis_time:end:193e5cf2:start=1709115572047948899,finish=1709115572881210415,duration=833261516,event=prepare [0Ktravis_fold:end:apt [0Ktravis_time:start:00eb4a28 [0Ktravis_fold:start:services [0Ktravis_fold:end:services [0Ktravis_time:end:00eb4a28:start=1709115572884426713,finish=1709115575890109811,duration=3005683098,event=services [0Ktravis_time:start:06e6bab7 [0Ktravis_time:end:06e6bab7:start=1709115575893263268,finish=1709115575895423375,duration=2160107,event=fix_ps4 [0Ktravis_fold:start:postgresql [0Ktravis_time:start:016ba83a [0K$ travis_setup_postgresql 11 [33;1mStarting PostgreSQL v11[0K sudo systemctl start postgresql@11-main travis_time:end:016ba83a:start=1709115575898527788,finish=1709115579081319739,duration=3182791951,event=prepare [0Ktravis_fold:end:postgresql [0Ktravis_time:start:0f6fc1e1 [0K travis_fold:start:git.checkout [0Ktravis_time:start:24be4966 [0Ktravis_time:end:24be4966:start=1709115579087950371,finish=1709115579093104771,duration=5154400,event=checkout [0Ktravis_time:start:004abb42 [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: 597, done.[K remote: Counting objects: 0% (1/597)[K remote: Counting objects: 1% (6/597)[K remote: Counting objects: 2% (12/597)[K remote: Counting objects: 3% (18/597)[K remote: Counting objects: 4% (24/597)[K remote: Counting objects: 5% (30/597)[K remote: Counting objects: 6% (36/597)[K remote: Counting objects: 7% (42/597)[K remote: Counting objects: 8% (48/597)[K remote: Counting objects: 9% (54/597)[K remote: Counting objects: 10% (60/597)[K remote: Counting objects: 11% (66/597)[K remote: Counting objects: 12% (72/597)[K remote: Counting objects: 13% (78/597)[K remote: Counting objects: 14% (84/597)[K remote: Counting objects: 15% (90/597)[K remote: Counting objects: 16% (96/597)[K remote: Counting objects: 17% (102/597)[K remote: Counting objects: 18% (108/597)[K remote: Counting objects: 19% (114/597)[K remote: Counting objects: 20% (120/597)[K remote: Counting objects: 21% (126/597)[K remote: Counting objects: 22% (132/597)[K remote: Counting objects: 23% (138/597)[K remote: Counting objects: 24% (144/597)[K remote: Counting objects: 25% (150/597)[K remote: Counting objects: 26% (156/597)[K remote: Counting objects: 27% (162/597)[K remote: Counting objects: 28% (168/597)[K remote: Counting objects: 29% (174/597)[K remote: Counting objects: 30% (180/597)[K remote: Counting objects: 31% (186/597)[K remote: Counting objects: 32% (192/597)[K remote: Counting objects: 33% (198/597)[K remote: Counting objects: 34% (203/597)[K remote: Counting objects: 35% (209/597)[K remote: Counting objects: 36% (215/597)[K remote: Counting objects: 37% (221/597)[K remote: Counting objects: 38% (227/597)[K remote: Counting objects: 39% (233/597)[K remote: Counting objects: 40% (239/597)[K remote: Counting objects: 41% (245/597)[K remote: Counting objects: 42% (251/597)[K remote: Counting objects: 43% (257/597)[K remote: Counting objects: 44% (263/597)[K remote: Counting objects: 45% (269/597)[K remote: Counting objects: 46% (275/597)[K remote: Counting objects: 47% (281/597)[K remote: Counting objects: 48% (287/597)[K remote: Counting objects: 49% (293/597)[K remote: Counting objects: 50% (299/597)[K remote: Counting objects: 51% (305/597)[K remote: Counting objects: 52% (311/597)[K remote: Counting objects: 53% (317/597)[K remote: Counting objects: 54% (323/597)[K remote: Counting objects: 55% (329/597)[K remote: Counting objects: 56% (335/597)[K remote: Counting objects: 57% (341/597)[K remote: Counting objects: 58% (347/597)[K remote: Counting objects: 59% (353/597)[K remote: Counting objects: 60% (359/597)[K remote: Counting objects: 61% (365/597)[K remote: Counting objects: 62% (371/597)[K remote: Counting objects: 63% (377/597)[K remote: Counting objects: 64% (383/597)[K remote: Counting objects: 65% (389/597)[K remote: Counting objects: 66% (395/597)[K remote: Counting objects: 67% (400/597)[K remote: Counting objects: 68% (406/597)[K remote: Counting objects: 69% (412/597)[K remote: Counting objects: 70% (418/597)[K remote: Counting objects: 71% (424/597)[K remote: Counting objects: 72% (430/597)[K remote: Counting objects: 73% (436/597)[K remote: Counting objects: 74% (442/597)[K remote: Counting objects: 75% (448/597)[K remote: Counting objects: 76% (454/597)[K remote: Counting objects: 77% (460/597)[K remote: Counting objects: 78% (466/597)[K remote: Counting objects: 79% (472/597)[K remote: Counting objects: 80% (478/597)[K remote: Counting objects: 81% (484/597)[K remote: Counting objects: 82% (490/597)[K remote: Counting objects: 83% (496/597)[K remote: Counting objects: 84% (502/597)[K remote: Counting objects: 85% (508/597)[K remote: Counting objects: 86% (514/597)[K remote: Counting objects: 87% (520/597)[K remote: Counting objects: 88% (526/597)[K remote: Counting objects: 89% (532/597)[K remote: Counting objects: 90% (538/597)[K remote: Counting objects: 91% (544/597)[K remote: Counting objects: 92% (550/597)[K remote: Counting objects: 93% (556/597)[K remote: Counting objects: 94% (562/597)[K remote: Counting objects: 95% (568/597)[K remote: Counting objects: 96% (574/597)[K remote: Counting objects: 97% (580/597)[K remote: Counting objects: 98% (586/597)[K remote: Counting objects: 99% (592/597)[K remote: Counting objects: 100% (597/597)[K remote: Counting objects: 100% (597/597), done.[K remote: Compressing objects: 0% (1/317)[K remote: Compressing objects: 1% (4/317)[K remote: Compressing objects: 2% (7/317)[K remote: Compressing objects: 3% (10/317)[K remote: Compressing objects: 4% (13/317)[K remote: Compressing objects: 5% (16/317)[K remote: Compressing objects: 6% (20/317)[K remote: Compressing objects: 7% (23/317)[K remote: Compressing objects: 8% (26/317)[K remote: Compressing objects: 9% (29/317)[K remote: Compressing objects: 10% (32/317)[K remote: Compressing objects: 11% (35/317)[K remote: Compressing objects: 12% (39/317)[K remote: Compressing objects: 13% (42/317)[K remote: Compressing objects: 14% (45/317)[K remote: Compressing objects: 15% (48/317)[K remote: Compressing objects: 16% (51/317)[K remote: Compressing objects: 17% (54/317)[K remote: Compressing objects: 18% (58/317)[K remote: Compressing objects: 19% (61/317)[K remote: Compressing objects: 20% (64/317)[K remote: Compressing objects: 21% (67/317)[K remote: Compressing objects: 22% (70/317)[K remote: Compressing objects: 23% (73/317)[K remote: Compressing objects: 24% (77/317)[K remote: Compressing objects: 25% (80/317)[K remote: Compressing objects: 26% (83/317)[K remote: Compressing objects: 27% (86/317)[K remote: Compressing objects: 28% (89/317)[K remote: Compressing objects: 29% (92/317)[K remote: Compressing objects: 30% (96/317)[K remote: Compressing objects: 31% (99/317)[K remote: Compressing objects: 32% (102/317)[K remote: Compressing objects: 33% (105/317)[K remote: Compressing objects: 34% (108/317)[K remote: Compressing objects: 35% (111/317)[K remote: Compressing objects: 36% (115/317)[K remote: Compressing objects: 37% (118/317)[K remote: Compressing objects: 38% (121/317)[K remote: Compressing objects: 39% (124/317)[K remote: Compressing objects: 40% (127/317)[K remote: Compressing objects: 41% (130/317)[K remote: Compressing objects: 42% (134/317)[K remote: Compressing objects: 43% (137/317)[K remote: Compressing objects: 44% (140/317)[K remote: Compressing objects: 45% (143/317)[K remote: Compressing objects: 46% (146/317)[K remote: Compressing objects: 47% (149/317)[K remote: Compressing objects: 48% (153/317)[K remote: Compressing objects: 49% (156/317)[K remote: Compressing objects: 50% (159/317)[K remote: Compressing objects: 51% (162/317)[K remote: Compressing objects: 52% (165/317)[K remote: Compressing objects: 53% (169/317)[K remote: Compressing objects: 54% (172/317)[K remote: Compressing objects: 55% (175/317)[K remote: Compressing objects: 56% (178/317)[K remote: Compressing objects: 57% (181/317)[K remote: Compressing objects: 58% (184/317)[K remote: Compressing objects: 59% (188/317)[K remote: Compressing objects: 60% (191/317)[K remote: Compressing objects: 61% (194/317)[K remote: Compressing objects: 62% (197/317)[K remote: Compressing objects: 63% (200/317)[K remote: Compressing objects: 64% (203/317)[K remote: Compressing objects: 65% (207/317)[K remote: Compressing objects: 66% (210/317)[K remote: Compressing objects: 67% (213/317)[K remote: Compressing objects: 68% (216/317)[K remote: Compressing objects: 69% (219/317)[K remote: Compressing objects: 70% (222/317)[K remote: Compressing objects: 71% (226/317)[K remote: Compressing objects: 72% (229/317)[K remote: Compressing objects: 73% (232/317)[K remote: Compressing objects: 74% (235/317)[K remote: Compressing objects: 75% (238/317)[K remote: Compressing objects: 76% (241/317)[K remote: Compressing objects: 77% (245/317)[K remote: Compressing objects: 78% (248/317)[K remote: Compressing objects: 79% (251/317)[K remote: Compressing objects: 80% (254/317)[K remote: Compressing objects: 81% (257/317)[K remote: Compressing objects: 82% (260/317)[K remote: Compressing objects: 83% (264/317)[K remote: Compressing objects: 84% (267/317)[K remote: Compressing objects: 85% (270/317)[K remote: Compressing objects: 86% (273/317)[K remote: Compressing objects: 87% (276/317)[K remote: Compressing objects: 88% (279/317)[K remote: Compressing objects: 89% (283/317)[K remote: Compressing objects: 90% (286/317)[K remote: Compressing objects: 91% (289/317)[K remote: Compressing objects: 92% (292/317)[K remote: Compressing objects: 93% (295/317)[K remote: Compressing objects: 94% (298/317)[K remote: Compressing objects: 95% (302/317)[K remote: Compressing objects: 96% (305/317)[K remote: Compressing objects: 97% (308/317)[K remote: Compressing objects: 98% (311/317)[K remote: Compressing objects: 99% (314/317)[K remote: Compressing objects: 100% (317/317)[K remote: Compressing objects: 100% (317/317), done.[K Receiving objects: 0% (1/597) Receiving objects: 1% (6/597) Receiving objects: 2% (12/597) Receiving objects: 3% (18/597) Receiving objects: 4% (24/597) Receiving objects: 5% (30/597) Receiving objects: 6% (36/597) Receiving objects: 7% (42/597) Receiving objects: 8% (48/597) Receiving objects: 9% (54/597) Receiving objects: 10% (60/597) Receiving objects: 11% (66/597) Receiving objects: 12% (72/597) Receiving objects: 13% (78/597) Receiving objects: 14% (84/597) Receiving objects: 15% (90/597) Receiving objects: 16% (96/597) Receiving objects: 17% (102/597) Receiving objects: 18% (108/597) Receiving objects: 19% (114/597) Receiving objects: 20% (120/597) Receiving objects: 21% (126/597) Receiving objects: 22% (132/597) Receiving objects: 23% (138/597) Receiving objects: 24% (144/597) Receiving objects: 25% (150/597) Receiving objects: 26% (156/597) Receiving objects: 27% (162/597) Receiving objects: 28% (168/597) Receiving objects: 29% (174/597) Receiving objects: 30% (180/597) Receiving objects: 31% (186/597) Receiving objects: 32% (192/597) Receiving objects: 33% (198/597) Receiving objects: 34% (203/597) Receiving objects: 35% (209/597) Receiving objects: 36% (215/597) Receiving objects: 37% (221/597) Receiving objects: 38% (227/597) Receiving objects: 39% (233/597) Receiving objects: 40% (239/597) Receiving objects: 41% (245/597) Receiving objects: 42% (251/597) Receiving objects: 43% (257/597) Receiving objects: 44% (263/597) Receiving objects: 45% (269/597) Receiving objects: 46% (275/597) Receiving objects: 47% (281/597) Receiving objects: 48% (287/597) Receiving objects: 49% (293/597) Receiving objects: 50% (299/597) Receiving objects: 51% (305/597) Receiving objects: 52% (311/597) Receiving objects: 53% (317/597) Receiving objects: 54% (323/597) Receiving objects: 55% (329/597) Receiving objects: 56% (335/597) Receiving objects: 57% (341/597) Receiving objects: 58% (347/597) Receiving objects: 59% (353/597) Receiving objects: 60% (359/597) Receiving objects: 61% (365/597) Receiving objects: 62% (371/597) Receiving objects: 63% (377/597) Receiving objects: 64% (383/597) Receiving objects: 65% (389/597) Receiving objects: 66% (395/597) Receiving objects: 67% (400/597) Receiving objects: 68% (406/597) Receiving objects: 69% (412/597) Receiving objects: 70% (418/597) Receiving objects: 71% (424/597) Receiving objects: 72% (430/597) Receiving objects: 73% (436/597) Receiving objects: 74% (442/597) Receiving objects: 75% (448/597) Receiving objects: 76% (454/597) Receiving objects: 77% (460/597) Receiving objects: 78% (466/597) Receiving objects: 79% (472/597) Receiving objects: 80% (478/597) Receiving objects: 81% (484/597) Receiving objects: 82% (490/597) Receiving objects: 83% (496/597) Receiving objects: 84% (502/597) Receiving objects: 85% (508/597) Receiving objects: 86% (514/597) Receiving objects: 87% (520/597) Receiving objects: 88% (526/597) Receiving objects: 89% (532/597) Receiving objects: 90% (538/597) remote: Total 597 (delta 293), reused 546 (delta 253), pack-reused 0[K Receiving objects: 91% (544/597) Receiving objects: 92% (550/597) Receiving objects: 93% (556/597) Receiving objects: 94% (562/597) Receiving objects: 95% (568/597) Receiving objects: 96% (574/597) Receiving objects: 97% (580/597) Receiving objects: 98% (586/597) Receiving objects: 99% (592/597) Receiving objects: 100% (597/597) Receiving objects: 100% (597/597), 88.51 KiB | 1.81 MiB/s, done. Resolving deltas: 0% (0/293) Resolving deltas: 1% (3/293) Resolving deltas: 2% (6/293) Resolving deltas: 3% (9/293) Resolving deltas: 4% (12/293) Resolving deltas: 5% (15/293) Resolving deltas: 6% (18/293) Resolving deltas: 7% (21/293) Resolving deltas: 8% (24/293) Resolving deltas: 9% (27/293) Resolving deltas: 10% (30/293) Resolving deltas: 11% (33/293) Resolving deltas: 12% (36/293) Resolving deltas: 13% (39/293) Resolving deltas: 14% (42/293) Resolving deltas: 15% (44/293) Resolving deltas: 16% (47/293) Resolving deltas: 17% (50/293) Resolving deltas: 18% (53/293) Resolving deltas: 19% (56/293) Resolving deltas: 20% (59/293) Resolving deltas: 21% (62/293) Resolving deltas: 22% (65/293) Resolving deltas: 23% (68/293) Resolving deltas: 24% (71/293) Resolving deltas: 25% (74/293) Resolving deltas: 26% (77/293) Resolving deltas: 27% (80/293) Resolving deltas: 28% (83/293) Resolving deltas: 29% (85/293) Resolving deltas: 30% (88/293) Resolving deltas: 31% (91/293) Resolving deltas: 32% (94/293) Resolving deltas: 33% (97/293) Resolving deltas: 34% (100/293) Resolving deltas: 35% (103/293) Resolving deltas: 36% (106/293) Resolving deltas: 37% (109/293) Resolving deltas: 38% (112/293) Resolving deltas: 39% (115/293) Resolving deltas: 40% (118/293) Resolving deltas: 41% (121/293) Resolving deltas: 42% (124/293) Resolving deltas: 43% (126/293) Resolving deltas: 44% (129/293) Resolving deltas: 45% (132/293) Resolving deltas: 46% (135/293) Resolving deltas: 47% (138/293) Resolving deltas: 48% (141/293) Resolving deltas: 49% (144/293) Resolving deltas: 50% (147/293) Resolving deltas: 51% (150/293) Resolving deltas: 52% (153/293) Resolving deltas: 53% (156/293) Resolving deltas: 54% (159/293) Resolving deltas: 55% (162/293) Resolving deltas: 56% (165/293) Resolving deltas: 57% (168/293) Resolving deltas: 58% (170/293) Resolving deltas: 59% (173/293) Resolving deltas: 60% (176/293) Resolving deltas: 61% (179/293) Resolving deltas: 62% (182/293) Resolving deltas: 63% (185/293) Resolving deltas: 64% (188/293) Resolving deltas: 65% (191/293) Resolving deltas: 66% (194/293) Resolving deltas: 67% (197/293) Resolving deltas: 68% (200/293) Resolving deltas: 69% (203/293) Resolving deltas: 70% (206/293) Resolving deltas: 71% (209/293) Resolving deltas: 72% (211/293) Resolving deltas: 73% (214/293) Resolving deltas: 74% (217/293) Resolving deltas: 75% (220/293) Resolving deltas: 76% (223/293) Resolving deltas: 77% (226/293) Resolving deltas: 78% (229/293) Resolving deltas: 79% (232/293) Resolving deltas: 80% (235/293) Resolving deltas: 81% (238/293) Resolving deltas: 82% (241/293) Resolving deltas: 83% (244/293) Resolving deltas: 84% (247/293) Resolving deltas: 85% (250/293) Resolving deltas: 86% (252/293) Resolving deltas: 87% (255/293) Resolving deltas: 88% (258/293) Resolving deltas: 89% (261/293) Resolving deltas: 90% (264/293) Resolving deltas: 91% (267/293) Resolving deltas: 92% (270/293) Resolving deltas: 93% (273/293) Resolving deltas: 94% (276/293) Resolving deltas: 95% (279/293) Resolving deltas: 96% (282/293) Resolving deltas: 97% (285/293) Resolving deltas: 98% (288/293) Resolving deltas: 99% (291/293) Resolving deltas: 100% (293/293) Resolving deltas: 100% (293/293), done. travis_time:end:004abb42:start=1709115579096377425,finish=1709115579544183038,duration=447805613,event=checkout [0K$ cd travis-ci/marginalia $ git checkout -qf 729872776ab3620bbe1cd2fc37e5d16efd25fd1b travis_fold:end:git.checkout [0K travis_time:end:004abb42:start=1709115579096377425,finish=1709115579549824875,duration=453447450,event=checkout [0Ktravis_time:start:0b79f02b [0K [33;1mSetting environment variables from .travis.yml[0m $ export MARGINALIA_DB_PORT=5432 $ export MARGINALIA_LOG_FILE=/var/log/postgresql/postgresql-11-main.log travis_time:end:0b79f02b:start=1709115579552847043,finish=1709115579558652839,duration=5805796,event=env [0Ktravis_fold:start:rvm [0Ktravis_time:start:0f0566da [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:0f0566da:start=1709115579567086779,finish=1709115582369650306,duration=2802563527,event= [0Ktravis_time:start:0ddc389c [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/18.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 0 0 0 0 0 0 0 --:--:-- 0:00:01 --:--:-- 0 0 0 0 0 0 0 0 0 --:--:-- 0:00:01 --:--:-- 0 100 29.2M 100 29.2M 0 0 16.2M 0 0:00:01 0:00:01 --:--:-- 43.7M [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:0ddc389c:start=1709115582373902182,finish=1709115605431137956,duration=23057235774,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:0108bb7f [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:0108bb7f:start=1709115605877580530,finish=1709115606048520659,duration=170940129,event=before_install [0Ktravis_fold:end:before_install [0Ktravis_fold:start:install.bundler [0Ktravis_time:start:016476ee [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 concurrent-ruby 1.2.3[0m [32mFetching base64 0.2.0[0m [32mFetching bigdecimal 3.1.6[0m [32mInstalling base64 0.2.0[0m [32mFetching connection_pool 2.4.1[0m [32mInstalling bigdecimal 3.1.6 with native extensions[0m [32mInstalling connection_pool 2.4.1[0m Using ruby2_keywords 0.0.5 [32mFetching minitest 5.18.1[0m [32mInstalling concurrent-ruby 1.2.3[0m [32mInstalling minitest 5.18.1[0m [32mFetching mutex_m 0.2.0[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 drb 2.2.0[0m [32mInstalling drb 2.2.0[0m [32mFetching mocha 2.1.0[0m [32mInstalling pg 1.5.5 with native extensions[0m [32mInstalling mocha 2.1.0[0m [32mFetching i18n 1.14.1[0m [32mInstalling i18n 1.14.1[0m [32mFetching tzinfo 2.0.6[0m [32mInstalling tzinfo 2.0.6[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.6.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:016476ee:start=1709115606053943802,finish=1709115622498133148,duration=16444189346,event=install [0Ktravis_fold:end:install.bundler [0K travis_fold:start:before_script [0Ktravis_time:start:0cf251b5 [0K$ sudo chmod 0644 $MARGINALIA_LOG_FILE travis_time:end:0cf251b5:start=1709115622503567504,finish=1709115622512710308,duration=9142804,event=before_script [0Ktravis_fold:end:before_script [0Ktravis_time:start:043a4afe [0K$ bundle exec rake db:reset test:postgresql 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 Run options: --seed 36731 # Running: ...... Finished in 0.004645s, 1291.7263 runs/s, 1722.3017 assertions/s. 6 runs, 8 assertions, 0 failures, 0 errors, 0 skips Run options: --seed 8558 # Running: .. Finished in 0.001026s, 1949.0575 runs/s, 2923.5862 assertions/s. 2 runs, 3 assertions, 0 failures, 0 errors, 0 skips -- create_table("posts", {:force=>true}) -> 0.0071s Run options: --seed 23674 # Running: . Finished in 0.021135s, 47.3159 runs/s, 141.9476 assertions/s. 1 runs, 3 assertions, 0 failures, 0 errors, 0 skips Run options: --seed 39767 # Running: .. Finished in 0.005928s, 337.3725 runs/s, 674.7449 assertions/s. 2 runs, 4 assertions, 0 failures, 0 errors, 0 skips travis_time:end:043a4afe:start=1709115622517783657,finish=1709115624974094603,duration=2456310946,event=script [0K[32;1mThe command "bundle exec rake db:reset test:postgresql" exited with 0.[0m Done. Your build exited with 0.