travis_fold:start:worker_info [0K[33;1mWorker information[0m hostname: 13c666fb-9d8b-4647-b2a2-76e766eaa6cd@1.worker-n2-com-779d777f7b-hxsb6.gce-production-1 version: 6.2.22 https://github.com/travis-ci/worker/tree/858cb91994a513269f2fe9782c15fc113e966231 instance: travis-job-e0ee79c1-14bf-463c-bae0-7672af1350dc travis-ci-sardonyx-xenial-1684402799-0876f6f0 (via amqp) startup: 6.08987525s travis_fold:end:worker_info [0Ktravis_time:start:08fc16b0 [0Ktravis_time:end:08fc16b0:start=1709104368001363087,finish=1709104368150731021,duration=149367934,event=no_world_writable_dirs [0Ktravis_time:start:1156bdaa [0Ktravis_time:end:1156bdaa:start=1709104368153962702,finish=1709104368161593229,duration=7630527,event=agent [0Ktravis_time:start:2543d62a [0Ktravis_time:end:2543d62a:start=1709104368164570109,finish=1709104368166691445,duration=2121336,event=check_unsupported [0Ktravis_time:start:11c3ceaa [0Ktravis_fold:start:system_info [0K[33;1mBuild system information[0m Build language: ruby Build dist: xenial Build id: 246801585 Job id: 560568879 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:11c3ceaa:start=1709104368169871316,finish=1709104368179355498,duration=9484182,event=show_system_info [0Ktravis_time:start:138e4d0f [0Ktravis_time:end:138e4d0f:start=1709104368182198720,finish=1709104368194663374,duration=12464654,event=rm_riak_source [0Ktravis_time:start:02427e0a [0Ktravis_time:end:02427e0a:start=1709104368197995463,finish=1709104368203290831,duration=5295368,event=fix_rwky_redis [0Ktravis_time:start:05722970 [0Ktravis_time:end:05722970:start=1709104368206442174,finish=1709104368964109507,duration=757667333,event=wait_for_network [0Ktravis_time:start:043f75f2 [0Ktravis_time:end:043f75f2:start=1709104368967209701,finish=1709104380791625957,duration=11824416256,event=update_apt_keys [0Ktravis_time:start:16479924 [0Ktravis_time:end:16479924:start=1709104380794815138,finish=1709104380848100824,duration=53285686,event=fix_hhvm_source [0Ktravis_time:start:03af63f8 [0Ktravis_time:end:03af63f8:start=1709104380851445892,finish=1709104380854128451,duration=2682559,event=update_mongo_arch [0Ktravis_time:start:17393e1c [0Ktravis_time:end:17393e1c:start=1709104380857102058,finish=1709104380897513767,duration=40411709,event=fix_sudo_enabled_trusty [0Ktravis_time:start:03654200 [0Ktravis_time:end:03654200:start=1709104380900764477,finish=1709104380902963958,duration=2199481,event=update_glibc [0Ktravis_time:start:03ee131e [0Ktravis_time:end:03ee131e:start=1709104380905874593,finish=1709104380941777006,duration=35902413,event=clean_up_path [0Ktravis_time:start:0890d675 [0Ktravis_time:end:0890d675:start=1709104380944972877,finish=1709104380952905679,duration=7932802,event=fix_resolv_conf [0Ktravis_time:start:07b1fb38 [0Ktravis_time:end:07b1fb38:start=1709104380955776467,finish=1709104380964583504,duration=8807037,event=fix_etc_hosts [0Ktravis_time:start:117b3f54 [0Ktravis_time:end:117b3f54:start=1709104380967495723,finish=1709104380977269831,duration=9774108,event=fix_mvn_settings_xml [0Ktravis_time:start:2c7de8bd [0Ktravis_time:end:2c7de8bd:start=1709104380980171707,finish=1709104380989679921,duration=9508214,event=no_ipv6_localhost [0Ktravis_time:start:0c4f03e8 [0Ktravis_time:end:0c4f03e8:start=1709104380992825290,finish=1709104380995098262,duration=2272972,event=fix_etc_mavenrc [0Ktravis_time:start:1fcaa232 [0KOK travis_time:end:1fcaa232:start=1709104380997917079,finish=1709104381332010975,duration=334093896,event=fix_perforce_key [0Ktravis_time:start:02e15134 [0Ktravis_time:end:02e15134:start=1709104381335301504,finish=1709104381338220126,duration=2918622,event=fix_wwdr_certificate [0Ktravis_time:start:1be8153a [0Ktravis_time:end:1be8153a:start=1709104381341140458,finish=1709104381364520596,duration=23380138,event=put_localhost_first [0Ktravis_time:start:0d950144 [0Ktravis_time:end:0d950144:start=1709104381367367205,finish=1709104381370122867,duration=2755662,event=home_paths [0Ktravis_time:start:01247ff7 [0Ktravis_time:end:01247ff7:start=1709104381373117475,finish=1709104381384911872,duration=11794397,event=disable_initramfs [0Ktravis_time:start:08bf6c8c [0Ktravis_time:end:08bf6c8c:start=1709104381387814145,finish=1709104381675435459,duration=287621314,event=disable_ssh_roaming [0Ktravis_time:start:01b59a7b [0Ktravis_time:end:01b59a7b:start=1709104381678610893,finish=1709104381680846511,duration=2235618,event=debug_tools [0Ktravis_time:start:1f507ffe [0Ktravis_time:end:1f507ffe:start=1709104381683766139,finish=1709104381686737064,duration=2970925,event=uninstall_oclint [0Ktravis_time:start:08700ef4 [0Ktravis_time:end:08700ef4:start=1709104381689706249,finish=1709104381692556529,duration=2850280,event=rvm_use [0Ktravis_time:start:0118185c [0Ktravis_time:end:0118185c:start=1709104381695484219,finish=1709104381702859990,duration=7375771,event=rm_etc_boto_cfg [0Ktravis_time:start:295df4e8 [0Ktravis_time:end:295df4e8:start=1709104381705799290,finish=1709104381708499250,duration=2699960,event=rm_oraclejdk8_symlink [0Ktravis_time:start:0922af10 [0Ktravis_time:end:0922af10:start=1709104381711328755,finish=1709104381799664264,duration=88335509,event=enable_i386 [0Ktravis_time:start:0e2a6145 [0Ktravis_time:end:0e2a6145:start=1709104381802764863,finish=1709104381806369058,duration=3604195,event=update_rubygems [0Ktravis_time:start:2a209a7f [0Ktravis_time:end:2a209a7f:start=1709104381809197427,finish=1709104382731003473,duration=921806046,event=ensure_path_components [0Ktravis_time:start:029a020c [0Ktravis_time:end:029a020c:start=1709104382734444625,finish=1709104382736911144,duration=2466519,event=redefine_curl [0Ktravis_time:start:16bd35fc [0Ktravis_time:end:16bd35fc:start=1709104382739996480,finish=1709104382742262728,duration=2266248,event=nonblock_pipe [0Ktravis_time:start:2cf45a10 [0Ktravis_time:end:2cf45a10:start=1709104382745487761,finish=1709104388781015331,duration=6035527570,event=apt_get_update [0Ktravis_time:start:0f4faf84 [0Ktravis_time:end:0f4faf84:start=1709104388784234673,finish=1709104388786312684,duration=2078011,event=deprecate_xcode_64 [0Ktravis_time:start:1f464a02 [0Ktravis_time:end:1f464a02:start=1709104388789137135,finish=1709104392399426255,duration=3610289120,event=update_heroku [0Ktravis_time:start:1b30fccc [0Ktravis_time:end:1b30fccc:start=1709104392402807315,finish=1709104392405099018,duration=2291703,event=shell_session_update [0Ktravis_time:start:0f464649 [0Ktravis_fold:start:docker_mtu_and_registry_mirrors [0Ktravis_fold:end:docker_mtu_and_registry_mirrors [0Ktravis_time:end:0f464649:start=1709104392408100752,finish=1709104394887407930,duration=2479307178,event=set_docker_mtu_and_registry_mirrors [0Ktravis_time:start:14dd21b9 [0Ktravis_fold:start:resolvconf [0Ktravis_fold:end:resolvconf [0Ktravis_time:end:14dd21b9:start=1709104394891591548,finish=1709104394952287721,duration=60696173,event=resolvconf [0Ktravis_time:start:0c6b01d8 [0Ktravis_time:end:0c6b01d8:start=1709104394957202983,finish=1709104395079784642,duration=122581659,event=maven_central_mirror [0Ktravis_time:start:30903b13 [0Ktravis_time:end:30903b13:start=1709104395082872652,finish=1709104395168734476,duration=85861824,event=maven_https [0Ktravis_time:start:094c20da [0Ktravis_fold:start:services [0Ktravis_fold:end:services [0Ktravis_time:end:094c20da:start=1709104395172130944,finish=1709104398176042668,duration=3003911724,event=services [0Ktravis_time:start:085cb8f3 [0Ktravis_time:end:085cb8f3:start=1709104398179288368,finish=1709104398181390490,duration=2102122,event=fix_ps4 [0Ktravis_fold:start:postgresql [0Ktravis_time:start:05a9f810 [0K$ travis_setup_postgresql 9.6 [33;1mStarting PostgreSQL v9.6[0K sudo systemctl start postgresql@9.6-main travis_time:end:05a9f810:start=1709104398184670263,finish=1709104401167184955,duration=2982514692,event=prepare [0Ktravis_fold:end:postgresql [0Ktravis_time:start:0103cb30 [0K travis_fold:start:git.checkout [0Ktravis_time:start:02e8098a [0Ktravis_time:end:02e8098a:start=1709104401173859095,finish=1709104401180648039,duration=6788944,event=checkout [0Ktravis_time:start:01fa08a1 [0K$ git clone --depth=50 --branch=6.1 https://github.com/travis-ci/marginalia.git travis-ci/marginalia Cloning into 'travis-ci/marginalia'... remote: Enumerating objects: 601, done.[K remote: Counting objects: 0% (1/601)[K remote: Counting objects: 1% (7/601)[K remote: Counting objects: 2% (13/601)[K remote: Counting objects: 3% (19/601)[K remote: Counting objects: 4% (25/601)[K remote: Counting objects: 5% (31/601)[K remote: Counting objects: 6% (37/601)[K remote: Counting objects: 7% (43/601)[K remote: Counting objects: 8% (49/601)[K remote: Counting objects: 9% (55/601)[K remote: Counting objects: 10% (61/601)[K remote: Counting objects: 11% (67/601)[K remote: Counting objects: 12% (73/601)[K remote: Counting objects: 13% (79/601)[K remote: Counting objects: 14% (85/601)[K remote: Counting objects: 15% (91/601)[K remote: Counting objects: 16% (97/601)[K remote: Counting objects: 17% (103/601)[K remote: Counting objects: 18% (109/601)[K remote: Counting objects: 19% (115/601)[K remote: Counting objects: 20% (121/601)[K remote: Counting objects: 21% (127/601)[K remote: Counting objects: 22% (133/601)[K remote: Counting objects: 23% (139/601)[K remote: Counting objects: 24% (145/601)[K remote: Counting objects: 25% (151/601)[K remote: Counting objects: 26% (157/601)[K remote: Counting objects: 27% (163/601)[K remote: Counting objects: 28% (169/601)[K remote: Counting objects: 29% (175/601)[K remote: Counting objects: 30% (181/601)[K remote: Counting objects: 31% (187/601)[K remote: Counting objects: 32% (193/601)[K remote: Counting objects: 33% (199/601)[K remote: Counting objects: 34% (205/601)[K remote: Counting objects: 35% (211/601)[K remote: Counting objects: 36% (217/601)[K remote: Counting objects: 37% (223/601)[K remote: Counting objects: 38% (229/601)[K remote: Counting objects: 39% (235/601)[K remote: Counting objects: 40% (241/601)[K remote: Counting objects: 41% (247/601)[K remote: Counting objects: 42% (253/601)[K remote: Counting objects: 43% (259/601)[K remote: Counting objects: 44% (265/601)[K remote: Counting objects: 45% (271/601)[K remote: Counting objects: 46% (277/601)[K remote: Counting objects: 47% (283/601)[K remote: Counting objects: 48% (289/601)[K remote: Counting objects: 49% (295/601)[K remote: Counting objects: 50% (301/601)[K remote: Counting objects: 51% (307/601)[K remote: Counting objects: 52% (313/601)[K remote: Counting objects: 53% (319/601)[K remote: Counting objects: 54% (325/601)[K remote: Counting objects: 55% (331/601)[K remote: Counting objects: 56% (337/601)[K remote: Counting objects: 57% (343/601)[K remote: Counting objects: 58% (349/601)[K remote: Counting objects: 59% (355/601)[K remote: Counting objects: 60% (361/601)[K remote: Counting objects: 61% (367/601)[K remote: Counting objects: 62% (373/601)[K remote: Counting objects: 63% (379/601)[K remote: Counting objects: 64% (385/601)[K remote: Counting objects: 65% (391/601)[K remote: Counting objects: 66% (397/601)[K remote: Counting objects: 67% (403/601)[K remote: Counting objects: 68% (409/601)[K remote: Counting objects: 69% (415/601)[K remote: Counting objects: 70% (421/601)[K remote: Counting objects: 71% (427/601)[K remote: Counting objects: 72% (433/601)[K remote: Counting objects: 73% (439/601)[K remote: Counting objects: 74% (445/601)[K remote: Counting objects: 75% (451/601)[K remote: Counting objects: 76% (457/601)[K remote: Counting objects: 77% (463/601)[K remote: Counting objects: 78% (469/601)[K remote: Counting objects: 79% (475/601)[K remote: Counting objects: 80% (481/601)[K remote: Counting objects: 81% (487/601)[K remote: Counting objects: 82% (493/601)[K remote: Counting objects: 83% (499/601)[K remote: Counting objects: 84% (505/601)[K remote: Counting objects: 85% (511/601)[K remote: Counting objects: 86% (517/601)[K remote: Counting objects: 87% (523/601)[K remote: Counting objects: 88% (529/601)[K remote: Counting objects: 89% (535/601)[K remote: Counting objects: 90% (541/601)[K remote: Counting objects: 91% (547/601)[K remote: Counting objects: 92% (553/601)[K remote: Counting objects: 93% (559/601)[K remote: Counting objects: 94% (565/601)[K remote: Counting objects: 95% (571/601)[K remote: Counting objects: 96% (577/601)[K remote: Counting objects: 97% (583/601)[K remote: Counting objects: 98% (589/601)[K remote: Counting objects: 99% (595/601)[K remote: Counting objects: 100% (601/601)[K remote: Counting objects: 100% (601/601), done.[K remote: Compressing objects: 0% (1/323)[K remote: Compressing objects: 1% (4/323)[K remote: Compressing objects: 2% (7/323)[K remote: Compressing objects: 3% (10/323)[K remote: Compressing objects: 4% (13/323)[K remote: Compressing objects: 5% (17/323)[K remote: Compressing objects: 6% (20/323)[K remote: Compressing objects: 7% (23/323)[K remote: Compressing objects: 8% (26/323)[K remote: Compressing objects: 9% (30/323)[K remote: Compressing objects: 10% (33/323)[K remote: Compressing objects: 11% (36/323)[K remote: Compressing objects: 12% (39/323)[K remote: Compressing objects: 13% (42/323)[K remote: Compressing objects: 14% (46/323)[K remote: Compressing objects: 15% (49/323)[K remote: Compressing objects: 16% (52/323)[K remote: Compressing objects: 17% (55/323)[K remote: Compressing objects: 18% (59/323)[K remote: Compressing objects: 19% (62/323)[K remote: Compressing objects: 20% (65/323)[K remote: Compressing objects: 21% (68/323)[K remote: Compressing objects: 22% (72/323)[K remote: Compressing objects: 23% (75/323)[K remote: Compressing objects: 24% (78/323)[K remote: Compressing objects: 25% (81/323)[K remote: Compressing objects: 26% (84/323)[K remote: Compressing objects: 27% (88/323)[K remote: Compressing objects: 28% (91/323)[K remote: Compressing objects: 29% (94/323)[K remote: Compressing objects: 30% (97/323)[K remote: Compressing objects: 31% (101/323)[K remote: Compressing objects: 32% (104/323)[K remote: Compressing objects: 33% (107/323)[K remote: Compressing objects: 34% (110/323)[K remote: Compressing objects: 35% (114/323)[K remote: Compressing objects: 36% (117/323)[K remote: Compressing objects: 37% (120/323)[K remote: Compressing objects: 38% (123/323)[K remote: Compressing objects: 39% (126/323)[K remote: Compressing objects: 40% (130/323)[K remote: Compressing objects: 41% (133/323)[K remote: Compressing objects: 42% (136/323)[K remote: Compressing objects: 43% (139/323)[K remote: Compressing objects: 44% (143/323)[K remote: Compressing objects: 45% (146/323)[K remote: Compressing objects: 46% (149/323)[K remote: Compressing objects: 47% (152/323)[K remote: Compressing objects: 48% (156/323)[K remote: Compressing objects: 49% (159/323)[K remote: Compressing objects: 50% (162/323)[K remote: Compressing objects: 51% (165/323)[K remote: Compressing objects: 52% (168/323)[K remote: Compressing objects: 53% (172/323)[K remote: Compressing objects: 54% (175/323)[K remote: Compressing objects: 55% (178/323)[K remote: Compressing objects: 56% (181/323)[K remote: Compressing objects: 57% (185/323)[K remote: Compressing objects: 58% (188/323)[K remote: Compressing objects: 59% (191/323)[K remote: Compressing objects: 60% (194/323)[K remote: Compressing objects: 61% (198/323)[K remote: Compressing objects: 62% (201/323)[K remote: Compressing objects: 63% (204/323)[K remote: Compressing objects: 64% (207/323)[K remote: Compressing objects: 65% (210/323)[K remote: Compressing objects: 66% (214/323)[K remote: Compressing objects: 67% (217/323)[K remote: Compressing objects: 68% (220/323)[K remote: Compressing objects: 69% (223/323)[K remote: Compressing objects: 70% (227/323)[K remote: Compressing objects: 71% (230/323)[K remote: Compressing objects: 72% (233/323)[K remote: Compressing objects: 73% (236/323)[K remote: Compressing objects: 74% (240/323)[K remote: Compressing objects: 75% (243/323)[K remote: Compressing objects: 76% (246/323)[K remote: Compressing objects: 77% (249/323)[K remote: Compressing objects: 78% (252/323)[K remote: Compressing objects: 79% (256/323)[K remote: Compressing objects: 80% (259/323)[K remote: Compressing objects: 81% (262/323)[K remote: Compressing objects: 82% (265/323)[K remote: Compressing objects: 83% (269/323)[K remote: Compressing objects: 84% (272/323)[K remote: Compressing objects: 85% (275/323)[K remote: Compressing objects: 86% (278/323)[K remote: Compressing objects: 87% (282/323)[K remote: Compressing objects: 88% (285/323)[K remote: Compressing objects: 89% (288/323)[K remote: Compressing objects: 90% (291/323)[K remote: Compressing objects: 91% (294/323)[K remote: Compressing objects: 92% (298/323)[K remote: Compressing objects: 93% (301/323)[K remote: Compressing objects: 94% (304/323)[K remote: Compressing objects: 95% (307/323)[K remote: Compressing objects: 96% (311/323)[K remote: Compressing objects: 97% (314/323)[K remote: Compressing objects: 98% (317/323)[K remote: Compressing objects: 99% (320/323)[K remote: Compressing objects: 100% (323/323)[K remote: Compressing objects: 100% (323/323), done.[K Receiving objects: 0% (1/601) Receiving objects: 1% (7/601) Receiving objects: 2% (13/601) Receiving objects: 3% (19/601) Receiving objects: 4% (25/601) Receiving objects: 5% (31/601) Receiving objects: 6% (37/601) Receiving objects: 7% (43/601) Receiving objects: 8% (49/601) Receiving objects: 9% (55/601) Receiving objects: 10% (61/601) Receiving objects: 11% (67/601) Receiving objects: 12% (73/601) Receiving objects: 13% (79/601) Receiving objects: 14% (85/601) Receiving objects: 15% (91/601) Receiving objects: 16% (97/601) Receiving objects: 17% (103/601) Receiving objects: 18% (109/601) Receiving objects: 19% (115/601) Receiving objects: 20% (121/601) Receiving objects: 21% (127/601) Receiving objects: 22% (133/601) Receiving objects: 23% (139/601) Receiving objects: 24% (145/601) Receiving objects: 25% (151/601) Receiving objects: 26% (157/601) Receiving objects: 27% (163/601) Receiving objects: 28% (169/601) Receiving objects: 29% (175/601) Receiving objects: 30% (181/601) Receiving objects: 31% (187/601) Receiving objects: 32% (193/601) Receiving objects: 33% (199/601) Receiving objects: 34% (205/601) Receiving objects: 35% (211/601) Receiving objects: 36% (217/601) Receiving objects: 37% (223/601) Receiving objects: 38% (229/601) Receiving objects: 39% (235/601) Receiving objects: 40% (241/601) Receiving objects: 41% (247/601) Receiving objects: 42% (253/601) Receiving objects: 43% (259/601) Receiving objects: 44% (265/601) Receiving objects: 45% (271/601) Receiving objects: 46% (277/601) Receiving objects: 47% (283/601) Receiving objects: 48% (289/601) Receiving objects: 49% (295/601) Receiving objects: 50% (301/601) Receiving objects: 51% (307/601) Receiving objects: 52% (313/601) Receiving objects: 53% (319/601) Receiving objects: 54% (325/601) Receiving objects: 55% (331/601) Receiving objects: 56% (337/601) Receiving objects: 57% (343/601) Receiving objects: 58% (349/601) Receiving objects: 59% (355/601) Receiving objects: 60% (361/601) Receiving objects: 61% (367/601) Receiving objects: 62% (373/601) Receiving objects: 63% (379/601) Receiving objects: 64% (385/601) Receiving objects: 65% (391/601) Receiving objects: 66% (397/601) Receiving objects: 67% (403/601) Receiving objects: 68% (409/601) Receiving objects: 69% (415/601) Receiving objects: 70% (421/601) Receiving objects: 71% (427/601) Receiving objects: 72% (433/601) Receiving objects: 73% (439/601) Receiving objects: 74% (445/601) Receiving objects: 75% (451/601) Receiving objects: 76% (457/601) Receiving objects: 77% (463/601) Receiving objects: 78% (469/601) Receiving objects: 79% (475/601) Receiving objects: 80% (481/601) Receiving objects: 81% (487/601) Receiving objects: 82% (493/601) Receiving objects: 83% (499/601) Receiving objects: 84% (505/601) Receiving objects: 85% (511/601) Receiving objects: 86% (517/601) Receiving objects: 87% (523/601) Receiving objects: 88% (529/601) Receiving objects: 89% (535/601) Receiving objects: 90% (541/601) remote: Total 601 (delta 296), reused 553 (delta 253), pack-reused 0[K Receiving objects: 91% (547/601) Receiving objects: 92% (553/601) Receiving objects: 93% (559/601) Receiving objects: 94% (565/601) Receiving objects: 95% (571/601) Receiving objects: 96% (577/601) Receiving objects: 97% (583/601) Receiving objects: 98% (589/601) Receiving objects: 99% (595/601) Receiving objects: 100% (601/601) Receiving objects: 100% (601/601), 87.54 KiB | 1.75 MiB/s, done. Resolving deltas: 0% (0/296) Resolving deltas: 1% (3/296) Resolving deltas: 2% (6/296) Resolving deltas: 3% (9/296) Resolving deltas: 4% (12/296) Resolving deltas: 5% (15/296) Resolving deltas: 6% (18/296) Resolving deltas: 7% (21/296) Resolving deltas: 8% (24/296) Resolving deltas: 9% (27/296) Resolving deltas: 10% (30/296) Resolving deltas: 11% (33/296) Resolving deltas: 12% (36/296) Resolving deltas: 13% (39/296) Resolving deltas: 14% (42/296) Resolving deltas: 15% (45/296) Resolving deltas: 16% (48/296) Resolving deltas: 17% (51/296) Resolving deltas: 18% (54/296) Resolving deltas: 19% (57/296) Resolving deltas: 20% (60/296) Resolving deltas: 21% (63/296) Resolving deltas: 22% (66/296) Resolving deltas: 23% (69/296) Resolving deltas: 24% (72/296) Resolving deltas: 25% (74/296) Resolving deltas: 26% (77/296) Resolving deltas: 27% (80/296) Resolving deltas: 28% (83/296) Resolving deltas: 29% (86/296) Resolving deltas: 30% (89/296) Resolving deltas: 31% (92/296) Resolving deltas: 32% (95/296) Resolving deltas: 33% (98/296) Resolving deltas: 34% (101/296) Resolving deltas: 35% (104/296) Resolving deltas: 36% (107/296) Resolving deltas: 37% (110/296) Resolving deltas: 38% (113/296) Resolving deltas: 39% (116/296) Resolving deltas: 40% (119/296) Resolving deltas: 41% (122/296) Resolving deltas: 42% (125/296) Resolving deltas: 43% (128/296) Resolving deltas: 44% (131/296) Resolving deltas: 45% (134/296) Resolving deltas: 46% (137/296) Resolving deltas: 47% (140/296) Resolving deltas: 48% (143/296) Resolving deltas: 49% (146/296) Resolving deltas: 50% (148/296) Resolving deltas: 51% (151/296) Resolving deltas: 52% (154/296) Resolving deltas: 53% (157/296) Resolving deltas: 54% (160/296) Resolving deltas: 55% (163/296) Resolving deltas: 56% (166/296) Resolving deltas: 57% (169/296) Resolving deltas: 58% (172/296) Resolving deltas: 59% (175/296) Resolving deltas: 60% (178/296) Resolving deltas: 61% (181/296) Resolving deltas: 62% (184/296) Resolving deltas: 63% (187/296) Resolving deltas: 64% (190/296) Resolving deltas: 65% (193/296) Resolving deltas: 66% (196/296) Resolving deltas: 67% (199/296) Resolving deltas: 68% (202/296) Resolving deltas: 69% (205/296) Resolving deltas: 70% (208/296) Resolving deltas: 71% (211/296) Resolving deltas: 72% (214/296) Resolving deltas: 73% (217/296) Resolving deltas: 74% (220/296) Resolving deltas: 75% (222/296) Resolving deltas: 76% (225/296) Resolving deltas: 77% (228/296) Resolving deltas: 78% (231/296) Resolving deltas: 79% (234/296) Resolving deltas: 80% (237/296) Resolving deltas: 81% (240/296) Resolving deltas: 82% (243/296) Resolving deltas: 83% (246/296) Resolving deltas: 84% (249/296) Resolving deltas: 85% (252/296) Resolving deltas: 86% (255/296) Resolving deltas: 87% (258/296) Resolving deltas: 88% (261/296) Resolving deltas: 89% (264/296) Resolving deltas: 90% (267/296) Resolving deltas: 91% (270/296) Resolving deltas: 92% (273/296) Resolving deltas: 93% (276/296) Resolving deltas: 94% (279/296) Resolving deltas: 95% (282/296) Resolving deltas: 96% (285/296) Resolving deltas: 97% (288/296) Resolving deltas: 98% (291/296) Resolving deltas: 99% (294/296) Resolving deltas: 100% (296/296) Resolving deltas: 100% (296/296), done. travis_time:end:01fa08a1:start=1709104401183983192,finish=1709104401743285821,duration=559302629,event=checkout [0K$ cd travis-ci/marginalia $ git checkout -qf 74ff54cf200678ec2869cf7c9a0f2f7573eec93b travis_fold:end:git.checkout [0K travis_time:end:01fa08a1:start=1709104401183983192,finish=1709104401749338851,duration=565355659,event=checkout [0Ktravis_time:start:1859ed28 [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:1859ed28:start=1709104401752483195,finish=1709104401758919954,duration=6436759,event=env [0Ktravis_fold:start:rvm [0Ktravis_time:start:00111c3f [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 55.4M 0 --:--:-- --:--:-- --:--:-- 55.5M [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:00111c3f:start=1709104401765411245,finish=1709104430722632441,duration=28957221196,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:02adfeda [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:02adfeda:start=1709104431080507169,finish=1709104431254376182,duration=173869013,event=before_install [0Ktravis_fold:end:before_install [0Ktravis_fold:start:install.bundler [0Ktravis_time:start:13ab8398 [0K$ bundle install --jobs=3 --retry=3 Fetching gem metadata from https://rubygems.org/........ Resolving dependencies... [32mFetching rake 13.1.0[0m [32mFetching concurrent-ruby 1.2.3[0m [32mInstalling rake 13.1.0[0m [32mInstalling concurrent-ruby 1.2.3[0m [32mFetching minitest 5.15.0[0m [32mFetching zeitwerk 2.6.13[0m [32mInstalling minitest 5.15.0[0m [32mFetching bigdecimal 3.1.6[0m [32mInstalling zeitwerk 2.6.13[0m Using bundler 1.16.2 [32mFetching pg 1.5.5[0m [32mInstalling bigdecimal 3.1.6 with native extensions[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 2.0.6[0m [32mInstalling tzinfo 2.0.6[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 6.1.4.7[0m [32mInstalling activesupport 6.1.4.7[0m [32mFetching activemodel 6.1.4.7[0m [32mInstalling activemodel 6.1.4.7[0m [32mFetching activerecord 6.1.4.7[0m [32mInstalling activerecord 6.1.4.7[0m Using marginalia 1.6.0 from source at `.` [32mBundle complete! 6 Gemfile dependencies, 16 gems now installed.[0m [32mUse `bundle info [gemname]` to see where a bundled gem is installed.[0m travis_time:end:13ab8398:start=1709104431259011094,finish=1709104445734720719,duration=14475709625,event=install [0Ktravis_fold:end:install.bundler [0K travis_fold:start:before_script [0Ktravis_time:start:06d4ecd0 [0K$ sudo chmod 0644 $MARGINALIA_LOG_FILE travis_time:end:06d4ecd0:start=1709104445739169301,finish=1709104445747262660,duration=8093359,event=before_script [0Ktravis_fold:end:before_script [0Ktravis_time:start:15471dbb [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:15471dbb:start=1709104445751154353,finish=1709104446520706749,duration=769552396,event=script [0K[31;1mThe command "bundle exec rake db:reset test:postgresql" exited with 1.[0m Done. Your build exited with 1.