travis_fold:start:worker_info [0K[33;1mWorker information[0m hostname: 67d88709-78e7-4bdc-b343-afec4d59fa63@1.worker-n2-com-779d777f7b-hxsb6.gce-production-1 version: 6.2.22 https://github.com/travis-ci/worker/tree/858cb91994a513269f2fe9782c15fc113e966231 instance: travis-job-96dcfb07-05c2-4d17-ac50-ee545b25c702 travis-ci-sardonyx-xenial-1684402799-0876f6f0 (via amqp) startup: 6.086965542s travis_fold:end:worker_info [0Ktravis_time:start:177109aa [0Ktravis_time:end:177109aa:start=1709104370492724783,finish=1709104370639572480,duration=146847697,event=no_world_writable_dirs [0Ktravis_time:start:1c8be37a [0Ktravis_time:end:1c8be37a:start=1709104370642692391,finish=1709104370649794549,duration=7102158,event=agent [0Ktravis_time:start:0ca68340 [0Ktravis_time:end:0ca68340:start=1709104370652564027,finish=1709104370654643747,duration=2079720,event=check_unsupported [0Ktravis_time:start:1b8686b0 [0Ktravis_fold:start:system_info [0K[33;1mBuild system information[0m Build language: ruby Build dist: xenial Build id: 246801657 Job id: 560569080 Runtime kernel version: 4.15.0-1098-gcp travis-build version: f3de9fb7 [34m[1mBuild image provisioning date and time[0m Thu May 18 10:07:51 UTC 2023 [34m[1mOperating System Details[0m Distributor ID: Ubuntu Description: Ubuntu 16.04.7 LTS Release: 16.04 Codename: xenial [34m[1mSystemd Version[0m systemd 229 [34m[1mCookbooks Version[0m d19e5ff https://github.com/travis-ci/travis-cookbooks/tree/d19e5ff [34m[1mgit version[0m git version 2.40.1 [34m[1mbash version[0m GNU bash, version 4.3.48(1)-release (x86_64-pc-linux-gnu) [34m[1mgcc version[0m gcc (Ubuntu 5.4.0-6ubuntu1~16.04.12) 5.4.0 20160609 [34m[1mdocker version[0m Client: Docker Engine - Community Version: 20.10.7 API version: 1.41 Go version: go1.13.15 Git commit: f0df350 Built: Wed Jun 2 11:56:47 2021 OS/Arch: linux/amd64 Context: default Experimental: true Server: Docker Engine - Community Engine: Version: 20.10.7 API version: 1.41 (minimum version 1.12) Go version: go1.13.15 Git commit: b0f5bc3 Built: Wed Jun 2 11:54:58 2021 OS/Arch: linux/amd64 Experimental: false containerd: Version: 1.4.6 GitCommit: d71fcd7d8303cbf684402823e425e9dd2e99285d runc: Version: 1.0.0-rc95 GitCommit: b9ee9c6314599f1b4a7f497e1f1f856fe433d3b7 docker-init: Version: 0.19.0 GitCommit: de40ad0 [34m[1mclang version[0m clang version 7.0.0 (tags/RELEASE_700/final) [34m[1mjq version[0m jq-1.6 [34m[1mbats version[0m Bats 0.4.0 [34m[1mshellcheck version[0m 0.7.2 [34m[1mshfmt version[0m v3.2.1 [34m[1mccache version[0m 3.2.4 [34m[1mcmake version[0m cmake version 3.26.3 [34m[1mheroku version[0m heroku/8.1.3 linux-x64 node-v16.19.0 [34m[1mimagemagick version[0m Version: ImageMagick 6.8.9-9 Q16 x86_64 2020-12-04 http://www.imagemagick.org [34m[1mmd5deep version[0m 4.4 [34m[1mmercurial version[0m version 5.9.3 [34m[1mmysql version[0m mysql Ver 14.14 Distrib 5.7.33, for Linux (x86_64) using EditLine wrapper [34m[1mopenssl version[0m OpenSSL 1.0.2g 1 Mar 2016 [34m[1mpacker version[0m 1.7.5 [34m[1mpostgresql client version[0m psql (PostgreSQL) 10.17 (Ubuntu 10.17-1.pgdg16.04+1) [34m[1mragel version[0m Ragel State Machine Compiler version 6.8 Feb 2013 [34m[1msudo version[0m 1.8.16 [34m[1mgzip version[0m gzip 1.6 [34m[1mzip version[0m Zip 3.0 [34m[1mvim version[0m VIM - Vi IMproved 7.4 (2013 Aug 10, compiled Oct 13 2020 16:04:38) [34m[1miptables version[0m iptables v1.6.0 [34m[1mcurl version[0m curl 7.47.0 (x86_64-pc-linux-gnu) libcurl/7.47.0 GnuTLS/3.4.10 zlib/1.2.8 libidn/1.32 librtmp/2.3 [34m[1mwget version[0m GNU Wget 1.17.1 built on linux-gnu. [34m[1mrsync version[0m rsync version 3.1.1 protocol version 31 [34m[1mgimme version[0m v1.5.4 [34m[1mnvm version[0m 0.39.3 [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.13 [34m[1mCouchDB version[0m couchdb 1.6.1 [34m[1mElasticSearch version[0m 7.16.3 [34m[1mInstalled Firefox version[0m firefox 63.0.1 [34m[1mMongoDB version[0m MongoDB 4.4.21 [34m[1mPhantomJS version[0m 2.1.1 [34m[1mPre-installed PostgreSQL versions[0m 9.4.26 9.5.25 9.6.22 [34m[1mRedis version[0m redis-server 6.0.6 [34m[1mPre-installed Go versions[0m 1.18.4 [34m[1mant version[0m Apache Ant(TM) version 1.9.6 compiled on July 20 2018 [34m[1mmvn version[0m Apache Maven 3.8.8 (4c87b05d9aedce574290d1acc98575ed5eb6cd39) [34m[1mgradle version[0m Gradle 7.5.1! [34m[1mlein version[0m Leiningen 2.10.0 on Java 11.0.15.1 OpenJDK 64-Bit Server VM [34m[1mPre-installed Node.js versions[0m v10.24.1 v12.22.12 v14.21.3 v16.15 v16.16.0 v16.20.0 v18.16.0 v4.9.1 v6.17.1 v8.17.0 [34m[1mphpenv versions[0m system 7.4 * 7.4.30 (set by /home/travis/.phpenv/version) hhvm-stable hhvm [34m[1mcomposer --version[0m Composer version 2.3.7 2022-06-06 16:43:28 [34m[1mPre-installed Ruby versions[0m ruby-2.7.6 ruby-3.0.4 ruby-3.1.2 travis_fold:end:system_info [0K travis_time:end:1b8686b0:start=1709104370657453419,finish=1709104370666356416,duration=8902997,event=show_system_info [0Ktravis_time:start:1005e718 [0Ktravis_time:end:1005e718:start=1709104370670199582,finish=1709104370682833262,duration=12633680,event=rm_riak_source [0Ktravis_time:start:14369b68 [0Ktravis_time:end:14369b68:start=1709104370685706247,finish=1709104370693170361,duration=7464114,event=fix_rwky_redis [0Ktravis_time:start:0523e9cc [0Ktravis_time:end:0523e9cc:start=1709104370697629331,finish=1709104372018795728,duration=1321166397,event=wait_for_network [0Ktravis_time:start:01512ab9 [0Ktravis_time:end:01512ab9:start=1709104372021907351,finish=1709104384497738063,duration=12475830712,event=update_apt_keys [0Ktravis_time:start:18178f25 [0Ktravis_time:end:18178f25:start=1709104384501063311,finish=1709104384552858664,duration=51795353,event=fix_hhvm_source [0Ktravis_time:start:0f0d1388 [0Ktravis_time:end:0f0d1388:start=1709104384556236986,finish=1709104384558938571,duration=2701585,event=update_mongo_arch [0Ktravis_time:start:2c6f5753 [0Ktravis_time:end:2c6f5753:start=1709104384561888587,finish=1709104384601727046,duration=39838459,event=fix_sudo_enabled_trusty [0Ktravis_time:start:073ab608 [0Ktravis_time:end:073ab608:start=1709104384605079719,finish=1709104384607378518,duration=2298799,event=update_glibc [0Ktravis_time:start:008f3974 [0Ktravis_time:end:008f3974:start=1709104384610460545,finish=1709104384644540589,duration=34080044,event=clean_up_path [0Ktravis_time:start:162a2330 [0Ktravis_time:end:162a2330:start=1709104384647944204,finish=1709104384656175592,duration=8231388,event=fix_resolv_conf [0Ktravis_time:start:106b25a0 [0Ktravis_time:end:106b25a0:start=1709104384659332055,finish=1709104384668420980,duration=9088925,event=fix_etc_hosts [0Ktravis_time:start:0174419c [0Ktravis_time:end:0174419c:start=1709104384671446614,finish=1709104384678969999,duration=7523385,event=fix_mvn_settings_xml [0Ktravis_time:start:18a225c0 [0Ktravis_time:end:18a225c0:start=1709104384681960136,finish=1709104384690922955,duration=8962819,event=no_ipv6_localhost [0Ktravis_time:start:06b1fdd1 [0Ktravis_time:end:06b1fdd1:start=1709104384693651290,finish=1709104384695843495,duration=2192205,event=fix_etc_mavenrc [0Ktravis_time:start:2dd18c5c [0KOK travis_time:end:2dd18c5c:start=1709104384698581853,finish=1709104385021873495,duration=323291642,event=fix_perforce_key [0Ktravis_time:start:0c605fe2 [0Ktravis_time:end:0c605fe2:start=1709104385025136374,finish=1709104385028435116,duration=3298742,event=fix_wwdr_certificate [0Ktravis_time:start:10cf2a8e [0Ktravis_time:end:10cf2a8e:start=1709104385031494318,finish=1709104385054491709,duration=22997391,event=put_localhost_first [0Ktravis_time:start:02462e50 [0Ktravis_time:end:02462e50:start=1709104385057501533,finish=1709104385060497591,duration=2996058,event=home_paths [0Ktravis_time:start:1053bbc2 [0Ktravis_time:end:1053bbc2:start=1709104385063507619,finish=1709104385074753171,duration=11245552,event=disable_initramfs [0Ktravis_time:start:2e603850 [0Ktravis_time:end:2e603850:start=1709104385077782036,finish=1709104385350307528,duration=272525492,event=disable_ssh_roaming [0Ktravis_time:start:255f3b35 [0Ktravis_time:end:255f3b35:start=1709104385353727042,finish=1709104385356051742,duration=2324700,event=debug_tools [0Ktravis_time:start:01af9b58 [0Ktravis_time:end:01af9b58:start=1709104385359156173,finish=1709104385362320161,duration=3163988,event=uninstall_oclint [0Ktravis_time:start:0aac0060 [0Ktravis_time:end:0aac0060:start=1709104385365460710,finish=1709104385368489406,duration=3028696,event=rvm_use [0Ktravis_time:start:0b6594b8 [0Ktravis_time:end:0b6594b8:start=1709104385371613586,finish=1709104385379403924,duration=7790338,event=rm_etc_boto_cfg [0Ktravis_time:start:08a09a59 [0Ktravis_time:end:08a09a59:start=1709104385382443540,finish=1709104385385119632,duration=2676092,event=rm_oraclejdk8_symlink [0Ktravis_time:start:1dbb17e2 [0Ktravis_time:end:1dbb17e2:start=1709104385388208112,finish=1709104385478155600,duration=89947488,event=enable_i386 [0Ktravis_time:start:10391f50 [0Ktravis_time:end:10391f50:start=1709104385481699281,finish=1709104385485662361,duration=3963080,event=update_rubygems [0Ktravis_time:start:23381c5b [0Ktravis_time:end:23381c5b:start=1709104385488909696,finish=1709104386361510754,duration=872601058,event=ensure_path_components [0Ktravis_time:start:14a446cc [0Ktravis_time:end:14a446cc:start=1709104386364900775,finish=1709104386367261413,duration=2360638,event=redefine_curl [0Ktravis_time:start:176f19a8 [0Ktravis_time:end:176f19a8:start=1709104386370139001,finish=1709104386372213505,duration=2074504,event=nonblock_pipe [0Ktravis_time:start:030acc44 [0Ktravis_time:end:030acc44:start=1709104386375046567,finish=1709104392407581836,duration=6032535269,event=apt_get_update [0Ktravis_time:start:0d97e310 [0Ktravis_time:end:0d97e310:start=1709104392410777591,finish=1709104392413011663,duration=2234072,event=deprecate_xcode_64 [0Ktravis_time:start:1de16f43 [0Ktravis_time:end:1de16f43:start=1709104392415977576,finish=1709104396031841367,duration=3615863791,event=update_heroku [0Ktravis_time:start:2591b58a [0Ktravis_time:end:2591b58a:start=1709104396035070300,finish=1709104396037257471,duration=2187171,event=shell_session_update [0Ktravis_time:start:09e69c22 [0Ktravis_fold:start:docker_mtu_and_registry_mirrors [0Ktravis_fold:end:docker_mtu_and_registry_mirrors [0Ktravis_time:end:09e69c22:start=1709104396040163088,finish=1709104398478187045,duration=2438023957,event=set_docker_mtu_and_registry_mirrors [0Ktravis_time:start:2faf4ec9 [0Ktravis_fold:start:resolvconf [0Ktravis_fold:end:resolvconf [0Ktravis_time:end:2faf4ec9:start=1709104398482170916,finish=1709104398540817548,duration=58646632,event=resolvconf [0Ktravis_time:start:108e9124 [0Ktravis_time:end:108e9124:start=1709104398545638727,finish=1709104398676086284,duration=130447557,event=maven_central_mirror [0Ktravis_time:start:0ffb7948 [0Ktravis_time:end:0ffb7948:start=1709104398679280870,finish=1709104398767038742,duration=87757872,event=maven_https [0Ktravis_time:start:119d5ffe [0Ktravis_fold:start:services [0Ktravis_fold:end:services [0Ktravis_time:end:119d5ffe:start=1709104398770531028,finish=1709104401774928137,duration=3004397109,event=services [0Ktravis_time:start:06ef957a [0Ktravis_time:end:06ef957a:start=1709104401778054441,finish=1709104401780183554,duration=2129113,event=fix_ps4 [0Ktravis_fold:start:postgresql [0Ktravis_time:start:081fa7ae [0K$ travis_setup_postgresql 9.6 [33;1mStarting PostgreSQL v9.6[0K sudo systemctl start postgresql@9.6-main travis_time:end:081fa7ae:start=1709104401783571933,finish=1709104404708155069,duration=2924583136,event=prepare [0Ktravis_fold:end:postgresql [0Ktravis_time:start:0b6b6d2e [0K travis_fold:start:git.checkout [0Ktravis_time:start:26a70ba5 [0Ktravis_time:end:26a70ba5:start=1709104404714580998,finish=1709104404719419483,duration=4838485,event=checkout [0Ktravis_time:start:1c9620d5 [0K$ git clone --depth=50 --branch=5.x https://github.com/travis-ci/marginalia.git travis-ci/marginalia Cloning into 'travis-ci/marginalia'... remote: Enumerating objects: 587, done.[K remote: Counting objects: 0% (1/587)[K remote: Counting objects: 1% (6/587)[K remote: Counting objects: 2% (12/587)[K remote: Counting objects: 3% (18/587)[K remote: Counting objects: 4% (24/587)[K remote: Counting objects: 5% (30/587)[K remote: Counting objects: 6% (36/587)[K remote: Counting objects: 7% (42/587)[K remote: Counting objects: 8% (47/587)[K remote: Counting objects: 9% (53/587)[K remote: Counting objects: 10% (59/587)[K remote: Counting objects: 11% (65/587)[K remote: Counting objects: 12% (71/587)[K remote: Counting objects: 13% (77/587)[K remote: Counting objects: 14% (83/587)[K remote: Counting objects: 15% (89/587)[K remote: Counting objects: 16% (94/587)[K remote: Counting objects: 17% (100/587)[K remote: Counting objects: 18% (106/587)[K remote: Counting objects: 19% (112/587)[K remote: Counting objects: 20% (118/587)[K remote: Counting objects: 21% (124/587)[K remote: Counting objects: 22% (130/587)[K remote: Counting objects: 23% (136/587)[K remote: Counting objects: 24% (141/587)[K remote: Counting objects: 25% (147/587)[K remote: Counting objects: 26% (153/587)[K remote: Counting objects: 27% (159/587)[K remote: Counting objects: 28% (165/587)[K remote: Counting objects: 29% (171/587)[K remote: Counting objects: 30% (177/587)[K remote: Counting objects: 31% (182/587)[K remote: Counting objects: 32% (188/587)[K remote: Counting objects: 33% (194/587)[K remote: Counting objects: 34% (200/587)[K remote: Counting objects: 35% (206/587)[K remote: Counting objects: 36% (212/587)[K remote: Counting objects: 37% (218/587)[K remote: Counting objects: 38% (224/587)[K remote: Counting objects: 39% (229/587)[K remote: Counting objects: 40% (235/587)[K remote: Counting objects: 41% (241/587)[K remote: Counting objects: 42% (247/587)[K remote: Counting objects: 43% (253/587)[K remote: Counting objects: 44% (259/587)[K remote: Counting objects: 45% (265/587)[K remote: Counting objects: 46% (271/587)[K remote: Counting objects: 47% (276/587)[K remote: Counting objects: 48% (282/587)[K remote: Counting objects: 49% (288/587)[K remote: Counting objects: 50% (294/587)[K remote: Counting objects: 51% (300/587)[K remote: Counting objects: 52% (306/587)[K remote: Counting objects: 53% (312/587)[K remote: Counting objects: 54% (317/587)[K remote: Counting objects: 55% (323/587)[K remote: Counting objects: 56% (329/587)[K remote: Counting objects: 57% (335/587)[K remote: Counting objects: 58% (341/587)[K remote: Counting objects: 59% (347/587)[K remote: Counting objects: 60% (353/587)[K remote: Counting objects: 61% (359/587)[K remote: Counting objects: 62% (364/587)[K remote: Counting objects: 63% (370/587)[K remote: Counting objects: 64% (376/587)[K remote: Counting objects: 65% (382/587)[K remote: Counting objects: 66% (388/587)[K remote: Counting objects: 67% (394/587)[K remote: Counting objects: 68% (400/587)[K remote: Counting objects: 69% (406/587)[K remote: Counting objects: 70% (411/587)[K remote: Counting objects: 71% (417/587)[K remote: Counting objects: 72% (423/587)[K remote: Counting objects: 73% (429/587)[K remote: Counting objects: 74% (435/587)[K remote: Counting objects: 75% (441/587)[K remote: Counting objects: 76% (447/587)[K remote: Counting objects: 77% (452/587)[K remote: Counting objects: 78% (458/587)[K remote: Counting objects: 79% (464/587)[K remote: Counting objects: 80% (470/587)[K remote: Counting objects: 81% (476/587)[K remote: Counting objects: 82% (482/587)[K remote: Counting objects: 83% (488/587)[K remote: Counting objects: 84% (494/587)[K remote: Counting objects: 85% (499/587)[K remote: Counting objects: 86% (505/587)[K remote: Counting objects: 87% (511/587)[K remote: Counting objects: 88% (517/587)[K remote: Counting objects: 89% (523/587)[K remote: Counting objects: 90% (529/587)[K remote: Counting objects: 91% (535/587)[K remote: Counting objects: 92% (541/587)[K remote: Counting objects: 93% (546/587)[K remote: Counting objects: 94% (552/587)[K remote: Counting objects: 95% (558/587)[K remote: Counting objects: 96% (564/587)[K remote: Counting objects: 97% (570/587)[K remote: Counting objects: 98% (576/587)[K remote: Counting objects: 99% (582/587)[K remote: Counting objects: 100% (587/587)[K remote: Counting objects: 100% (587/587), done.[K remote: Compressing objects: 0% (1/311)[K remote: Compressing objects: 1% (4/311)[K remote: Compressing objects: 2% (7/311)[K remote: Compressing objects: 3% (10/311)[K remote: Compressing objects: 4% (13/311)[K remote: Compressing objects: 5% (16/311)[K remote: Compressing objects: 6% (19/311)[K remote: Compressing objects: 7% (22/311)[K remote: Compressing objects: 8% (25/311)[K remote: Compressing objects: 9% (28/311)[K remote: Compressing objects: 10% (32/311)[K remote: Compressing objects: 11% (35/311)[K remote: Compressing objects: 12% (38/311)[K remote: Compressing objects: 13% (41/311)[K remote: Compressing objects: 14% (44/311)[K remote: Compressing objects: 15% (47/311)[K remote: Compressing objects: 16% (50/311)[K remote: Compressing objects: 17% (53/311)[K remote: Compressing objects: 18% (56/311)[K remote: Compressing objects: 19% (60/311)[K remote: Compressing objects: 20% (63/311)[K remote: Compressing objects: 21% (66/311)[K remote: Compressing objects: 22% (69/311)[K remote: Compressing objects: 23% (72/311)[K remote: Compressing objects: 24% (75/311)[K remote: Compressing objects: 25% (78/311)[K remote: Compressing objects: 26% (81/311)[K remote: Compressing objects: 27% (84/311)[K remote: Compressing objects: 28% (88/311)[K remote: Compressing objects: 29% (91/311)[K remote: Compressing objects: 30% (94/311)[K remote: Compressing objects: 31% (97/311)[K remote: Compressing objects: 32% (100/311)[K remote: Compressing objects: 33% (103/311)[K remote: Compressing objects: 34% (106/311)[K remote: Compressing objects: 35% (109/311)[K remote: Compressing objects: 36% (112/311)[K remote: Compressing objects: 37% (116/311)[K remote: Compressing objects: 38% (119/311)[K remote: Compressing objects: 39% (122/311)[K remote: Compressing objects: 40% (125/311)[K remote: Compressing objects: 41% (128/311)[K remote: Compressing objects: 42% (131/311)[K remote: Compressing objects: 43% (134/311)[K remote: Compressing objects: 44% (137/311)[K remote: Compressing objects: 45% (140/311)[K remote: Compressing objects: 46% (144/311)[K remote: Compressing objects: 47% (147/311)[K remote: Compressing objects: 48% (150/311)[K remote: Compressing objects: 49% (153/311)[K remote: Compressing objects: 50% (156/311)[K remote: Compressing objects: 51% (159/311)[K remote: Compressing objects: 52% (162/311)[K remote: Compressing objects: 53% (165/311)[K remote: Compressing objects: 54% (168/311)[K remote: Compressing objects: 55% (172/311)[K remote: Compressing objects: 56% (175/311)[K remote: Compressing objects: 57% (178/311)[K remote: Compressing objects: 58% (181/311)[K remote: Compressing objects: 59% (184/311)[K remote: Compressing objects: 60% (187/311)[K remote: Compressing objects: 61% (190/311)[K remote: Compressing objects: 62% (193/311)[K remote: Compressing objects: 63% (196/311)[K remote: Compressing objects: 64% (200/311)[K remote: Compressing objects: 65% (203/311)[K remote: Compressing objects: 66% (206/311)[K remote: Compressing objects: 67% (209/311)[K remote: Compressing objects: 68% (212/311)[K remote: Compressing objects: 69% (215/311)[K remote: Compressing objects: 70% (218/311)[K remote: Compressing objects: 71% (221/311)[K remote: Compressing objects: 72% (224/311)[K remote: Compressing objects: 73% (228/311)[K remote: Compressing objects: 74% (231/311)[K remote: Compressing objects: 75% (234/311)[K remote: Compressing objects: 76% (237/311)[K remote: Compressing objects: 77% (240/311)[K remote: Compressing objects: 78% (243/311)[K remote: Compressing objects: 79% (246/311)[K remote: Compressing objects: 80% (249/311)[K remote: Compressing objects: 81% (252/311)[K remote: Compressing objects: 82% (256/311)[K remote: Compressing objects: 83% (259/311)[K remote: Compressing objects: 84% (262/311)[K remote: Compressing objects: 85% (265/311)[K remote: Compressing objects: 86% (268/311)[K remote: Compressing objects: 87% (271/311)[K remote: Compressing objects: 88% (274/311)[K remote: Compressing objects: 89% (277/311)[K remote: Compressing objects: 90% (280/311)[K remote: Compressing objects: 91% (284/311)[K remote: Compressing objects: 92% (287/311)[K remote: Compressing objects: 93% (290/311)[K remote: Compressing objects: 94% (293/311)[K remote: Compressing objects: 95% (296/311)[K remote: Compressing objects: 96% (299/311)[K remote: Compressing objects: 97% (302/311)[K remote: Compressing objects: 98% (305/311)[K remote: Compressing objects: 99% (308/311)[K remote: Compressing objects: 100% (311/311)[K remote: Compressing objects: 100% (311/311), done.[K Receiving objects: 0% (1/587) Receiving objects: 1% (6/587) Receiving objects: 2% (12/587) Receiving objects: 3% (18/587) Receiving objects: 4% (24/587) Receiving objects: 5% (30/587) Receiving objects: 6% (36/587) Receiving objects: 7% (42/587) Receiving objects: 8% (47/587) Receiving objects: 9% (53/587) Receiving objects: 10% (59/587) Receiving objects: 11% (65/587) Receiving objects: 12% (71/587) Receiving objects: 13% (77/587) Receiving objects: 14% (83/587) Receiving objects: 15% (89/587) Receiving objects: 16% (94/587) Receiving objects: 17% (100/587) Receiving objects: 18% (106/587) Receiving objects: 19% (112/587) Receiving objects: 20% (118/587) Receiving objects: 21% (124/587) Receiving objects: 22% (130/587) Receiving objects: 23% (136/587) Receiving objects: 24% (141/587) Receiving objects: 25% (147/587) Receiving objects: 26% (153/587) Receiving objects: 27% (159/587) Receiving objects: 28% (165/587) Receiving objects: 29% (171/587) Receiving objects: 30% (177/587) Receiving objects: 31% (182/587) Receiving objects: 32% (188/587) Receiving objects: 33% (194/587) Receiving objects: 34% (200/587) Receiving objects: 35% (206/587) Receiving objects: 36% (212/587) Receiving objects: 37% (218/587) Receiving objects: 38% (224/587) Receiving objects: 39% (229/587) Receiving objects: 40% (235/587) Receiving objects: 41% (241/587) Receiving objects: 42% (247/587) Receiving objects: 43% (253/587) Receiving objects: 44% (259/587) Receiving objects: 45% (265/587) Receiving objects: 46% (271/587) Receiving objects: 47% (276/587) Receiving objects: 48% (282/587) Receiving objects: 49% (288/587) Receiving objects: 50% (294/587) Receiving objects: 51% (300/587) Receiving objects: 52% (306/587) Receiving objects: 53% (312/587) Receiving objects: 54% (317/587) Receiving objects: 55% (323/587) Receiving objects: 56% (329/587) Receiving objects: 57% (335/587) Receiving objects: 58% (341/587) Receiving objects: 59% (347/587) Receiving objects: 60% (353/587) Receiving objects: 61% (359/587) Receiving objects: 62% (364/587) Receiving objects: 63% (370/587) Receiving objects: 64% (376/587) Receiving objects: 65% (382/587) Receiving objects: 66% (388/587) Receiving objects: 67% (394/587) Receiving objects: 68% (400/587) Receiving objects: 69% (406/587) Receiving objects: 70% (411/587) Receiving objects: 71% (417/587) Receiving objects: 72% (423/587) Receiving objects: 73% (429/587) Receiving objects: 74% (435/587) Receiving objects: 75% (441/587) Receiving objects: 76% (447/587) Receiving objects: 77% (452/587) Receiving objects: 78% (458/587) Receiving objects: 79% (464/587) Receiving objects: 80% (470/587) Receiving objects: 81% (476/587) Receiving objects: 82% (482/587) Receiving objects: 83% (488/587) Receiving objects: 84% (494/587) Receiving objects: 85% (499/587) Receiving objects: 86% (505/587) Receiving objects: 87% (511/587) Receiving objects: 88% (517/587) Receiving objects: 89% (523/587) Receiving objects: 90% (529/587) Receiving objects: 91% (535/587) Receiving objects: 92% (541/587) remote: Total 587 (delta 288), reused 544 (delta 251), pack-reused 0[K Receiving objects: 93% (546/587) Receiving objects: 94% (552/587) Receiving objects: 95% (558/587) Receiving objects: 96% (564/587) Receiving objects: 97% (570/587) Receiving objects: 98% (576/587) Receiving objects: 99% (582/587) Receiving objects: 100% (587/587) Receiving objects: 100% (587/587), 85.66 KiB | 1.71 MiB/s, done. Resolving deltas: 0% (0/288) Resolving deltas: 1% (3/288) Resolving deltas: 2% (6/288) Resolving deltas: 3% (9/288) Resolving deltas: 4% (12/288) Resolving deltas: 5% (15/288) Resolving deltas: 6% (18/288) Resolving deltas: 7% (21/288) Resolving deltas: 8% (24/288) Resolving deltas: 9% (26/288) Resolving deltas: 10% (29/288) Resolving deltas: 11% (32/288) Resolving deltas: 12% (35/288) Resolving deltas: 13% (38/288) Resolving deltas: 14% (41/288) Resolving deltas: 15% (44/288) Resolving deltas: 16% (47/288) Resolving deltas: 17% (49/288) Resolving deltas: 18% (52/288) Resolving deltas: 19% (55/288) Resolving deltas: 20% (58/288) Resolving deltas: 21% (61/288) Resolving deltas: 22% (64/288) Resolving deltas: 23% (67/288) Resolving deltas: 24% (70/288) Resolving deltas: 25% (72/288) Resolving deltas: 26% (75/288) Resolving deltas: 27% (78/288) Resolving deltas: 28% (81/288) Resolving deltas: 29% (84/288) Resolving deltas: 30% (87/288) Resolving deltas: 31% (90/288) Resolving deltas: 32% (93/288) Resolving deltas: 33% (96/288) Resolving deltas: 34% (98/288) Resolving deltas: 35% (101/288) Resolving deltas: 36% (104/288) Resolving deltas: 37% (107/288) Resolving deltas: 38% (110/288) Resolving deltas: 39% (113/288) Resolving deltas: 40% (116/288) Resolving deltas: 41% (119/288) Resolving deltas: 42% (121/288) Resolving deltas: 43% (124/288) Resolving deltas: 44% (127/288) Resolving deltas: 45% (130/288) Resolving deltas: 46% (133/288) Resolving deltas: 47% (136/288) Resolving deltas: 48% (139/288) Resolving deltas: 49% (142/288) Resolving deltas: 50% (144/288) Resolving deltas: 51% (147/288) Resolving deltas: 52% (150/288) Resolving deltas: 53% (153/288) Resolving deltas: 54% (156/288) Resolving deltas: 55% (159/288) Resolving deltas: 56% (162/288) Resolving deltas: 57% (165/288) Resolving deltas: 58% (168/288) Resolving deltas: 59% (170/288) Resolving deltas: 60% (173/288) Resolving deltas: 61% (176/288) Resolving deltas: 62% (179/288) Resolving deltas: 63% (182/288) Resolving deltas: 64% (185/288) Resolving deltas: 65% (188/288) Resolving deltas: 66% (191/288) Resolving deltas: 67% (193/288) Resolving deltas: 68% (196/288) Resolving deltas: 69% (199/288) Resolving deltas: 70% (202/288) Resolving deltas: 71% (205/288) Resolving deltas: 72% (208/288) Resolving deltas: 73% (211/288) Resolving deltas: 74% (214/288) Resolving deltas: 75% (216/288) Resolving deltas: 76% (219/288) Resolving deltas: 77% (222/288) Resolving deltas: 78% (225/288) Resolving deltas: 79% (228/288) Resolving deltas: 80% (231/288) Resolving deltas: 81% (234/288) Resolving deltas: 82% (237/288) Resolving deltas: 83% (240/288) Resolving deltas: 84% (242/288) Resolving deltas: 85% (245/288) Resolving deltas: 86% (248/288) Resolving deltas: 87% (251/288) Resolving deltas: 88% (254/288) Resolving deltas: 89% (257/288) Resolving deltas: 90% (260/288) Resolving deltas: 91% (263/288) Resolving deltas: 92% (265/288) Resolving deltas: 93% (268/288) Resolving deltas: 94% (271/288) Resolving deltas: 95% (274/288) Resolving deltas: 96% (277/288) Resolving deltas: 97% (280/288) Resolving deltas: 98% (283/288) Resolving deltas: 99% (286/288) Resolving deltas: 100% (288/288) Resolving deltas: 100% (288/288), done. travis_time:end:1c9620d5:start=1709104404722872757,finish=1709104405272699046,duration=549826289,event=checkout [0K$ cd travis-ci/marginalia $ git checkout -qf 07f19a9ee5869a4557437a9f24608c7b1c4275bf travis_fold:end:git.checkout [0K travis_time:end:1c9620d5:start=1709104404722872757,finish=1709104405278937112,duration=556064355,event=checkout [0Ktravis_time:start:0604f258 [0K [33;1mSetting environment variables from .travis.yml[0m $ export MARGINALIA_DB_PORT=5432 $ export MARGINALIA_LOG_FILE=/var/log/postgresql/postgresql-9.6-main.log travis_time:end:0604f258:start=1709104405281977989,finish=1709104405288454512,duration=6476523,event=env [0Ktravis_fold:start:rvm [0Ktravis_time:start:2be993b1 [0K$ rvm use 2.5.0 --install --binary --fuzzy curl: (22) The requested URL returned error: 404 Not Found [33mRequired ruby-2.5.0 is not installed - installing.[0m [0mcurl: (22) The requested URL returned error: 404 Not Found Searching for binary rubies, this might take some time. Found remote file https://storage.googleapis.com/travis-ci-language-archives/ruby/binaries/ubuntu/16.04/x86_64/ruby-2.5.0.tar.bz2 Checking requirements for ubuntu. Requirements installation successful. ruby-2.5.0 - #configure ruby-2.5.0 - #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 100 17.1M 100 17.1M 0 0 82.7M 0 --:--:-- --:--:-- --:--:-- 82.9M [33mNo checksum for downloaded archive, recording checksum in user configuration.[0m [0mruby-2.5.0 - #validate archive ruby-2.5.0 - #extract ruby-2.5.0 - #validate binary ruby-2.5.0 - #setup ruby-2.5.0 - #gemset created /home/travis/.rvm/gems/ruby-2.5.0@global [32mruby-2.5.0 - #importing gemset /home/travis/.rvm/gemsets/global.gems[0m|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-. [32mruby-2.5.0 - #generating global wrappers[0m|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|. [32mruby-2.5.0 - #uninstalling gem rubygems-bundler-1.4.5[0m|/. ruby-2.5.0 - #gemset created /home/travis/.rvm/gems/ruby-2.5.0 [32mruby-2.5.0 - #importing gemset /home/travis/.rvm/gemsets/default.gems[0m|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\. [32mruby-2.5.0 - #generating default wrappers[0m|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/. Using /home/travis/.rvm/gems/ruby-2.5.0 travis_time:end:2be993b1:start=1709104405295213951,finish=1709104435077806244,duration=29782592293,event= [0Ktravis_fold:end:rvm [0K $ export BUNDLE_GEMFILE=$PWD/Gemfile travis_fold:start:ruby.versions [0K$ ruby --version ruby 2.5.0p0 (2017-12-25 revision 61468) [x86_64-linux] $ rvm --version rvm 1.29.12 (latest) by Michal Papis, Piotr Kuczynski, Wayne E. Seguin [https://rvm.io] $ bundle --version Bundler version 1.16.2 $ gem --version 2.7.7 travis_fold:end:ruby.versions [0K travis_fold:start:before_install [0Ktravis_time:start:05f10804 [0K$ bash -c "yes | gem uninstall -i /home/travis/.rvm/gems/ruby-2.5.0@global rake" Removing rake Successfully uninstalled rake-12.3.0 travis_time:end:05f10804:start=1709104435441978765,finish=1709104435616157884,duration=174179119,event=before_install [0Ktravis_fold:end:before_install [0Ktravis_fold:start:install.bundler [0Ktravis_time:start:0f0c6d40 [0K$ bundle install --jobs=3 --retry=3 Fetching gem metadata from https://rubygems.org/........ Resolving dependencies... [32mFetching concurrent-ruby 1.2.3[0m [32mFetching rake 13.1.0[0m [32mInstalling rake 13.1.0[0m [32mInstalling concurrent-ruby 1.2.3[0m [32mFetching minitest 5.15.0[0m [32mFetching thread_safe 0.3.6[0m [32mInstalling minitest 5.15.0[0m [32mFetching arel 9.0.0[0m [32mInstalling thread_safe 0.3.6[0m [32mFetching bigdecimal 3.1.6[0m [32mInstalling arel 9.0.0[0m [32mInstalling bigdecimal 3.1.6 with native extensions[0m Using bundler 1.16.2 [32mFetching pg 1.5.5[0m [32mInstalling pg 1.5.5 with native extensions[0m [32mFetching ruby2_keywords 0.0.5[0m [32mInstalling ruby2_keywords 0.0.5[0m [32mFetching i18n 1.14.1[0m [32mInstalling i18n 1.14.1[0m [32mFetching tzinfo 1.2.11[0m [32mInstalling tzinfo 1.2.11[0m [32mFetching sequel 5.77.0[0m [32mInstalling sequel 5.77.0[0m [32mFetching mocha 2.1.0[0m [32mInstalling mocha 2.1.0[0m [32mFetching activesupport 5.2.6.3[0m [32mInstalling activesupport 5.2.6.3[0m [32mFetching activemodel 5.2.6.3[0m [32mInstalling activemodel 5.2.6.3[0m [32mFetching activerecord 5.2.6.3[0m [32mInstalling activerecord 5.2.6.3[0m Using marginalia 1.6.0 from source at `.` [32mBundle complete! 6 Gemfile dependencies, 17 gems now installed.[0m [32mUse `bundle info [gemname]` to see where a bundled gem is installed.[0m travis_time:end:0f0c6d40:start=1709104435620912676,finish=1709104450165938431,duration=14545025755,event=install [0Ktravis_fold:end:install.bundler [0K travis_fold:start:before_script [0Ktravis_time:start:04e93c7b [0K$ sudo chmod 0644 $MARGINALIA_LOG_FILE travis_time:end:04e93c7b:start=1709104450170342631,finish=1709104450178579835,duration=8237204,event=before_script [0Ktravis_fold:end:before_script [0Ktravis_time:start:03788900 [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-9.6-main.log MARGINALIA_DB_PORT=5432 ruby -Ilib -Itest $file; done [1mTraceback [m(most recent call last): 2: from test/escape_test.rb:2:in `<main>' 1: from test/escape_test.rb:2:in `require' /home/travis/.rvm/gems/ruby-2.5.0/gems/mocha-2.1.0/lib/mocha/test_unit.rb:5:in `<top (required)>': [1mTest::Unit must be loaded *before* `require 'mocha/test_unit'`. ([4;1mRuntimeError[m[1m) [mrake 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-9.6-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-2.5.0/gems/rake-13.1.0/exe/rake:27:in `<top (required)>' /home/travis/.rvm/gems/ruby-2.5.0/bin/ruby_executable_hooks:22:in `eval' /home/travis/.rvm/gems/ruby-2.5.0/bin/ruby_executable_hooks:22:in `<main>' Tasks: TOP => test:postgresql (See full trace by running task with --trace) travis_time:end:03788900:start=1709104450182219545,finish=1709104450926364376,duration=744144831,event=script [0K[31;1mThe command "bundle exec rake db:reset test:postgresql" exited with 1.[0m Done. Your build exited with 1.