travis_fold:start:worker_info
Worker information
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
travis_time:start:177109aa
travis_time:end:177109aa:start=1709104370492724783,finish=1709104370639572480,duration=146847697,event=no_world_writable_dirs
travis_time:start:1c8be37a
travis_time:end:1c8be37a:start=1709104370642692391,finish=1709104370649794549,duration=7102158,event=agent
travis_time:start:0ca68340
travis_time:end:0ca68340:start=1709104370652564027,finish=1709104370654643747,duration=2079720,event=check_unsupported
travis_time:start:1b8686b0
travis_fold:start:system_info
Build system information
Build language: ruby
Build dist: xenial
Build id: 246801657
Job id: 560569080
Runtime kernel version: 4.15.0-1098-gcp
travis-build version: f3de9fb7
Build image provisioning date and time
Thu May 18 10:07:51 UTC 2023
Operating System Details
Distributor ID:	Ubuntu
Description:	Ubuntu 16.04.7 LTS
Release:	16.04
Codename:	xenial
Systemd Version
systemd 229
Cookbooks Version
d19e5ff https://github.com/travis-ci/travis-cookbooks/tree/d19e5ff
git version
git version 2.40.1
bash version
GNU bash, version 4.3.48(1)-release (x86_64-pc-linux-gnu)
gcc version
gcc (Ubuntu 5.4.0-6ubuntu1~16.04.12) 5.4.0 20160609
docker version
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
clang version
clang version 7.0.0 (tags/RELEASE_700/final)
jq version
jq-1.6
bats version
Bats 0.4.0
shellcheck version
0.7.2
shfmt version
v3.2.1
ccache version
3.2.4
cmake version
cmake version 3.26.3
heroku version
heroku/8.1.3 linux-x64 node-v16.19.0
imagemagick version
Version: ImageMagick 6.8.9-9 Q16 x86_64 2020-12-04 http://www.imagemagick.org
md5deep version
4.4
mercurial version
version 5.9.3
mysql version
mysql  Ver 14.14 Distrib 5.7.33, for Linux (x86_64) using  EditLine wrapper
openssl version
OpenSSL 1.0.2g  1 Mar 2016
packer version
1.7.5
postgresql client version
psql (PostgreSQL) 10.17 (Ubuntu 10.17-1.pgdg16.04+1)
ragel version
Ragel State Machine Compiler version 6.8 Feb 2013
sudo version
1.8.16
gzip version
gzip 1.6
zip version
Zip 3.0
vim version
VIM - Vi IMproved 7.4 (2013 Aug 10, compiled Oct 13 2020 16:04:38)
iptables version
iptables v1.6.0
curl version
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
wget version
GNU Wget 1.17.1 built on linux-gnu.
rsync version
rsync  version 3.1.1  protocol version 31
gimme version
v1.5.4
nvm version
0.39.3
perlbrew version
/home/travis/perl5/perlbrew/bin/perlbrew  - App::perlbrew/0.95
phpenv version
rbenv 1.2.0
rvm version
rvm 1.29.12 (latest) by Michal Papis, Piotr Kuczynski, Wayne E. Seguin [https://rvm.io]
default ruby version
ruby 2.7.6p219 (2022-04-12 revision c9c2245c0a) [x86_64-linux]
default python version
Python 3.7.13
CouchDB version
couchdb 1.6.1
ElasticSearch version
7.16.3
Installed Firefox version
firefox 63.0.1
MongoDB version
MongoDB 4.4.21
PhantomJS version
2.1.1
Pre-installed PostgreSQL versions
9.4.26
9.5.25
9.6.22
Redis version
redis-server 6.0.6
Pre-installed Go versions
1.18.4
ant version
Apache Ant(TM) version 1.9.6 compiled on July 20 2018
mvn version
Apache Maven 3.8.8 (4c87b05d9aedce574290d1acc98575ed5eb6cd39)
gradle version
Gradle 7.5.1!
lein version
Leiningen 2.10.0 on Java 11.0.15.1 OpenJDK 64-Bit Server VM
Pre-installed Node.js versions
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
phpenv versions
  system
  7.4
* 7.4.30 (set by /home/travis/.phpenv/version)
  hhvm-stable
  hhvm
composer --version
Composer version 2.3.7 2022-06-06 16:43:28
Pre-installed Ruby versions
ruby-2.7.6
ruby-3.0.4
ruby-3.1.2
travis_fold:end:system_info

travis_time:end:1b8686b0:start=1709104370657453419,finish=1709104370666356416,duration=8902997,event=show_system_info
travis_time:start:1005e718
travis_time:end:1005e718:start=1709104370670199582,finish=1709104370682833262,duration=12633680,event=rm_riak_source
travis_time:start:14369b68
travis_time:end:14369b68:start=1709104370685706247,finish=1709104370693170361,duration=7464114,event=fix_rwky_redis
travis_time:start:0523e9cc
travis_time:end:0523e9cc:start=1709104370697629331,finish=1709104372018795728,duration=1321166397,event=wait_for_network
travis_time:start:01512ab9
travis_time:end:01512ab9:start=1709104372021907351,finish=1709104384497738063,duration=12475830712,event=update_apt_keys
travis_time:start:18178f25
travis_time:end:18178f25:start=1709104384501063311,finish=1709104384552858664,duration=51795353,event=fix_hhvm_source
travis_time:start:0f0d1388
travis_time:end:0f0d1388:start=1709104384556236986,finish=1709104384558938571,duration=2701585,event=update_mongo_arch
travis_time:start:2c6f5753
travis_time:end:2c6f5753:start=1709104384561888587,finish=1709104384601727046,duration=39838459,event=fix_sudo_enabled_trusty
travis_time:start:073ab608
travis_time:end:073ab608:start=1709104384605079719,finish=1709104384607378518,duration=2298799,event=update_glibc
travis_time:start:008f3974
travis_time:end:008f3974:start=1709104384610460545,finish=1709104384644540589,duration=34080044,event=clean_up_path
travis_time:start:162a2330
travis_time:end:162a2330:start=1709104384647944204,finish=1709104384656175592,duration=8231388,event=fix_resolv_conf
travis_time:start:106b25a0
travis_time:end:106b25a0:start=1709104384659332055,finish=1709104384668420980,duration=9088925,event=fix_etc_hosts
travis_time:start:0174419c
travis_time:end:0174419c:start=1709104384671446614,finish=1709104384678969999,duration=7523385,event=fix_mvn_settings_xml
travis_time:start:18a225c0
travis_time:end:18a225c0:start=1709104384681960136,finish=1709104384690922955,duration=8962819,event=no_ipv6_localhost
travis_time:start:06b1fdd1
travis_time:end:06b1fdd1:start=1709104384693651290,finish=1709104384695843495,duration=2192205,event=fix_etc_mavenrc
travis_time:start:2dd18c5c
OK
travis_time:end:2dd18c5c:start=1709104384698581853,finish=1709104385021873495,duration=323291642,event=fix_perforce_key
travis_time:start:0c605fe2
travis_time:end:0c605fe2:start=1709104385025136374,finish=1709104385028435116,duration=3298742,event=fix_wwdr_certificate
travis_time:start:10cf2a8e
travis_time:end:10cf2a8e:start=1709104385031494318,finish=1709104385054491709,duration=22997391,event=put_localhost_first
travis_time:start:02462e50
travis_time:end:02462e50:start=1709104385057501533,finish=1709104385060497591,duration=2996058,event=home_paths
travis_time:start:1053bbc2
travis_time:end:1053bbc2:start=1709104385063507619,finish=1709104385074753171,duration=11245552,event=disable_initramfs
travis_time:start:2e603850
travis_time:end:2e603850:start=1709104385077782036,finish=1709104385350307528,duration=272525492,event=disable_ssh_roaming
travis_time:start:255f3b35
travis_time:end:255f3b35:start=1709104385353727042,finish=1709104385356051742,duration=2324700,event=debug_tools
travis_time:start:01af9b58
travis_time:end:01af9b58:start=1709104385359156173,finish=1709104385362320161,duration=3163988,event=uninstall_oclint
travis_time:start:0aac0060
travis_time:end:0aac0060:start=1709104385365460710,finish=1709104385368489406,duration=3028696,event=rvm_use
travis_time:start:0b6594b8
travis_time:end:0b6594b8:start=1709104385371613586,finish=1709104385379403924,duration=7790338,event=rm_etc_boto_cfg
travis_time:start:08a09a59
travis_time:end:08a09a59:start=1709104385382443540,finish=1709104385385119632,duration=2676092,event=rm_oraclejdk8_symlink
travis_time:start:1dbb17e2
travis_time:end:1dbb17e2:start=1709104385388208112,finish=1709104385478155600,duration=89947488,event=enable_i386
travis_time:start:10391f50
travis_time:end:10391f50:start=1709104385481699281,finish=1709104385485662361,duration=3963080,event=update_rubygems
travis_time:start:23381c5b
travis_time:end:23381c5b:start=1709104385488909696,finish=1709104386361510754,duration=872601058,event=ensure_path_components
travis_time:start:14a446cc
travis_time:end:14a446cc:start=1709104386364900775,finish=1709104386367261413,duration=2360638,event=redefine_curl
travis_time:start:176f19a8
travis_time:end:176f19a8:start=1709104386370139001,finish=1709104386372213505,duration=2074504,event=nonblock_pipe
travis_time:start:030acc44
travis_time:end:030acc44:start=1709104386375046567,finish=1709104392407581836,duration=6032535269,event=apt_get_update
travis_time:start:0d97e310
travis_time:end:0d97e310:start=1709104392410777591,finish=1709104392413011663,duration=2234072,event=deprecate_xcode_64
travis_time:start:1de16f43
travis_time:end:1de16f43:start=1709104392415977576,finish=1709104396031841367,duration=3615863791,event=update_heroku
travis_time:start:2591b58a
travis_time:end:2591b58a:start=1709104396035070300,finish=1709104396037257471,duration=2187171,event=shell_session_update
travis_time:start:09e69c22
travis_fold:start:docker_mtu_and_registry_mirrors
travis_fold:end:docker_mtu_and_registry_mirrors
travis_time:end:09e69c22:start=1709104396040163088,finish=1709104398478187045,duration=2438023957,event=set_docker_mtu_and_registry_mirrors
travis_time:start:2faf4ec9
travis_fold:start:resolvconf
travis_fold:end:resolvconf
travis_time:end:2faf4ec9:start=1709104398482170916,finish=1709104398540817548,duration=58646632,event=resolvconf
travis_time:start:108e9124
travis_time:end:108e9124:start=1709104398545638727,finish=1709104398676086284,duration=130447557,event=maven_central_mirror
travis_time:start:0ffb7948
travis_time:end:0ffb7948:start=1709104398679280870,finish=1709104398767038742,duration=87757872,event=maven_https
travis_time:start:119d5ffe
travis_fold:start:services
travis_fold:end:services
travis_time:end:119d5ffe:start=1709104398770531028,finish=1709104401774928137,duration=3004397109,event=services
travis_time:start:06ef957a
travis_time:end:06ef957a:start=1709104401778054441,finish=1709104401780183554,duration=2129113,event=fix_ps4
travis_fold:start:postgresql
travis_time:start:081fa7ae
$ travis_setup_postgresql 9.6
Starting PostgreSQL v9.6
sudo systemctl start postgresql@9.6-main
travis_time:end:081fa7ae:start=1709104401783571933,finish=1709104404708155069,duration=2924583136,event=prepare
travis_fold:end:postgresql
travis_time:start:0b6b6d2e

travis_fold:start:git.checkout
travis_time:start:26a70ba5
travis_time:end:26a70ba5:start=1709104404714580998,finish=1709104404719419483,duration=4838485,event=checkout
travis_time:start:1c9620d5
$ 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.
remote: Counting objects:   0% (1/587)
remote: Counting objects:   1% (6/587)
remote: Counting objects:   2% (12/587)
remote: Counting objects:   3% (18/587)
remote: Counting objects:   4% (24/587)
remote: Counting objects:   5% (30/587)
remote: Counting objects:   6% (36/587)
remote: Counting objects:   7% (42/587)
remote: Counting objects:   8% (47/587)
remote: Counting objects:   9% (53/587)
remote: Counting objects:  10% (59/587)
remote: Counting objects:  11% (65/587)
remote: Counting objects:  12% (71/587)
remote: Counting objects:  13% (77/587)
remote: Counting objects:  14% (83/587)
remote: Counting objects:  15% (89/587)
remote: Counting objects:  16% (94/587)
remote: Counting objects:  17% (100/587)
remote: Counting objects:  18% (106/587)
remote: Counting objects:  19% (112/587)
remote: Counting objects:  20% (118/587)
remote: Counting objects:  21% (124/587)
remote: Counting objects:  22% (130/587)
remote: Counting objects:  23% (136/587)
remote: Counting objects:  24% (141/587)
remote: Counting objects:  25% (147/587)
remote: Counting objects:  26% (153/587)
remote: Counting objects:  27% (159/587)
remote: Counting objects:  28% (165/587)
remote: Counting objects:  29% (171/587)
remote: Counting objects:  30% (177/587)
remote: Counting objects:  31% (182/587)
remote: Counting objects:  32% (188/587)
remote: Counting objects:  33% (194/587)
remote: Counting objects:  34% (200/587)
remote: Counting objects:  35% (206/587)
remote: Counting objects:  36% (212/587)
remote: Counting objects:  37% (218/587)
remote: Counting objects:  38% (224/587)
remote: Counting objects:  39% (229/587)
remote: Counting objects:  40% (235/587)
remote: Counting objects:  41% (241/587)
remote: Counting objects:  42% (247/587)
remote: Counting objects:  43% (253/587)
remote: Counting objects:  44% (259/587)
remote: Counting objects:  45% (265/587)
remote: Counting objects:  46% (271/587)
remote: Counting objects:  47% (276/587)
remote: Counting objects:  48% (282/587)
remote: Counting objects:  49% (288/587)
remote: Counting objects:  50% (294/587)
remote: Counting objects:  51% (300/587)
remote: Counting objects:  52% (306/587)
remote: Counting objects:  53% (312/587)
remote: Counting objects:  54% (317/587)
remote: Counting objects:  55% (323/587)
remote: Counting objects:  56% (329/587)
remote: Counting objects:  57% (335/587)
remote: Counting objects:  58% (341/587)
remote: Counting objects:  59% (347/587)
remote: Counting objects:  60% (353/587)
remote: Counting objects:  61% (359/587)
remote: Counting objects:  62% (364/587)
remote: Counting objects:  63% (370/587)
remote: Counting objects:  64% (376/587)
remote: Counting objects:  65% (382/587)
remote: Counting objects:  66% (388/587)
remote: Counting objects:  67% (394/587)
remote: Counting objects:  68% (400/587)
remote: Counting objects:  69% (406/587)
remote: Counting objects:  70% (411/587)
remote: Counting objects:  71% (417/587)
remote: Counting objects:  72% (423/587)
remote: Counting objects:  73% (429/587)
remote: Counting objects:  74% (435/587)
remote: Counting objects:  75% (441/587)
remote: Counting objects:  76% (447/587)
remote: Counting objects:  77% (452/587)
remote: Counting objects:  78% (458/587)
remote: Counting objects:  79% (464/587)
remote: Counting objects:  80% (470/587)
remote: Counting objects:  81% (476/587)
remote: Counting objects:  82% (482/587)
remote: Counting objects:  83% (488/587)
remote: Counting objects:  84% (494/587)
remote: Counting objects:  85% (499/587)
remote: Counting objects:  86% (505/587)
remote: Counting objects:  87% (511/587)
remote: Counting objects:  88% (517/587)
remote: Counting objects:  89% (523/587)
remote: Counting objects:  90% (529/587)
remote: Counting objects:  91% (535/587)
remote: Counting objects:  92% (541/587)
remote: Counting objects:  93% (546/587)
remote: Counting objects:  94% (552/587)
remote: Counting objects:  95% (558/587)
remote: Counting objects:  96% (564/587)
remote: Counting objects:  97% (570/587)
remote: Counting objects:  98% (576/587)
remote: Counting objects:  99% (582/587)
remote: Counting objects: 100% (587/587)
remote: Counting objects: 100% (587/587), done.
remote: Compressing objects:   0% (1/311)
remote: Compressing objects:   1% (4/311)
remote: Compressing objects:   2% (7/311)
remote: Compressing objects:   3% (10/311)
remote: Compressing objects:   4% (13/311)
remote: Compressing objects:   5% (16/311)
remote: Compressing objects:   6% (19/311)
remote: Compressing objects:   7% (22/311)
remote: Compressing objects:   8% (25/311)
remote: Compressing objects:   9% (28/311)
remote: Compressing objects:  10% (32/311)
remote: Compressing objects:  11% (35/311)
remote: Compressing objects:  12% (38/311)
remote: Compressing objects:  13% (41/311)
remote: Compressing objects:  14% (44/311)
remote: Compressing objects:  15% (47/311)
remote: Compressing objects:  16% (50/311)
remote: Compressing objects:  17% (53/311)
remote: Compressing objects:  18% (56/311)
remote: Compressing objects:  19% (60/311)
remote: Compressing objects:  20% (63/311)
remote: Compressing objects:  21% (66/311)
remote: Compressing objects:  22% (69/311)
remote: Compressing objects:  23% (72/311)
remote: Compressing objects:  24% (75/311)
remote: Compressing objects:  25% (78/311)
remote: Compressing objects:  26% (81/311)
remote: Compressing objects:  27% (84/311)
remote: Compressing objects:  28% (88/311)
remote: Compressing objects:  29% (91/311)
remote: Compressing objects:  30% (94/311)
remote: Compressing objects:  31% (97/311)
remote: Compressing objects:  32% (100/311)
remote: Compressing objects:  33% (103/311)
remote: Compressing objects:  34% (106/311)
remote: Compressing objects:  35% (109/311)
remote: Compressing objects:  36% (112/311)
remote: Compressing objects:  37% (116/311)
remote: Compressing objects:  38% (119/311)
remote: Compressing objects:  39% (122/311)
remote: Compressing objects:  40% (125/311)
remote: Compressing objects:  41% (128/311)
remote: Compressing objects:  42% (131/311)
remote: Compressing objects:  43% (134/311)
remote: Compressing objects:  44% (137/311)
remote: Compressing objects:  45% (140/311)
remote: Compressing objects:  46% (144/311)
remote: Compressing objects:  47% (147/311)
remote: Compressing objects:  48% (150/311)
remote: Compressing objects:  49% (153/311)
remote: Compressing objects:  50% (156/311)
remote: Compressing objects:  51% (159/311)
remote: Compressing objects:  52% (162/311)
remote: Compressing objects:  53% (165/311)
remote: Compressing objects:  54% (168/311)
remote: Compressing objects:  55% (172/311)
remote: Compressing objects:  56% (175/311)
remote: Compressing objects:  57% (178/311)
remote: Compressing objects:  58% (181/311)
remote: Compressing objects:  59% (184/311)
remote: Compressing objects:  60% (187/311)
remote: Compressing objects:  61% (190/311)
remote: Compressing objects:  62% (193/311)
remote: Compressing objects:  63% (196/311)
remote: Compressing objects:  64% (200/311)
remote: Compressing objects:  65% (203/311)
remote: Compressing objects:  66% (206/311)
remote: Compressing objects:  67% (209/311)
remote: Compressing objects:  68% (212/311)
remote: Compressing objects:  69% (215/311)
remote: Compressing objects:  70% (218/311)
remote: Compressing objects:  71% (221/311)
remote: Compressing objects:  72% (224/311)
remote: Compressing objects:  73% (228/311)
remote: Compressing objects:  74% (231/311)
remote: Compressing objects:  75% (234/311)
remote: Compressing objects:  76% (237/311)
remote: Compressing objects:  77% (240/311)
remote: Compressing objects:  78% (243/311)
remote: Compressing objects:  79% (246/311)
remote: Compressing objects:  80% (249/311)
remote: Compressing objects:  81% (252/311)
remote: Compressing objects:  82% (256/311)
remote: Compressing objects:  83% (259/311)
remote: Compressing objects:  84% (262/311)
remote: Compressing objects:  85% (265/311)
remote: Compressing objects:  86% (268/311)
remote: Compressing objects:  87% (271/311)
remote: Compressing objects:  88% (274/311)
remote: Compressing objects:  89% (277/311)
remote: Compressing objects:  90% (280/311)
remote: Compressing objects:  91% (284/311)
remote: Compressing objects:  92% (287/311)
remote: Compressing objects:  93% (290/311)
remote: Compressing objects:  94% (293/311)
remote: Compressing objects:  95% (296/311)
remote: Compressing objects:  96% (299/311)
remote: Compressing objects:  97% (302/311)
remote: Compressing objects:  98% (305/311)
remote: Compressing objects:  99% (308/311)
remote: Compressing objects: 100% (311/311)
remote: Compressing objects: 100% (311/311), done.
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
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
$ cd travis-ci/marginalia
$ git checkout -qf 07f19a9ee5869a4557437a9f24608c7b1c4275bf
travis_fold:end:git.checkout

travis_time:end:1c9620d5:start=1709104404722872757,finish=1709104405278937112,duration=556064355,event=checkout
travis_time:start:0604f258

Setting environment variables from .travis.yml
$ 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
travis_fold:start:rvm
travis_time:start:2be993b1
$ rvm use 2.5.0 --install --binary --fuzzy
curl: (22) The requested URL returned error: 404 Not Found
Required ruby-2.5.0 is not installed - installing.
curl: (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
No checksum for downloaded archive, recording checksum in user configuration.
ruby-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
ruby-2.5.0 - #importing gemset /home/travis/.rvm/gemsets/global.gems|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-.
ruby-2.5.0 - #generating global wrappers|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|.
ruby-2.5.0 - #uninstalling gem rubygems-bundler-1.4.5|/.
ruby-2.5.0 - #gemset created /home/travis/.rvm/gems/ruby-2.5.0
ruby-2.5.0 - #importing gemset /home/travis/.rvm/gemsets/default.gems|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\.
ruby-2.5.0 - #generating default wrappers|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/.
Using /home/travis/.rvm/gems/ruby-2.5.0
travis_time:end:2be993b1:start=1709104405295213951,finish=1709104435077806244,duration=29782592293,event=
travis_fold:end:rvm

$ export BUNDLE_GEMFILE=$PWD/Gemfile
travis_fold:start:ruby.versions
$ 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

travis_fold:start:before_install
travis_time:start:05f10804
$ 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
travis_fold:end:before_install
travis_fold:start:install.bundler
travis_time:start:0f0c6d40
$ bundle install --jobs=3 --retry=3
Fetching gem metadata from https://rubygems.org/........
Resolving dependencies...
Fetching concurrent-ruby 1.2.3
Fetching rake 13.1.0
Installing rake 13.1.0
Installing concurrent-ruby 1.2.3
Fetching minitest 5.15.0
Fetching thread_safe 0.3.6
Installing minitest 5.15.0
Fetching arel 9.0.0
Installing thread_safe 0.3.6
Fetching bigdecimal 3.1.6
Installing arel 9.0.0
Installing bigdecimal 3.1.6 with native extensions
Using bundler 1.16.2
Fetching pg 1.5.5
Installing pg 1.5.5 with native extensions
Fetching ruby2_keywords 0.0.5
Installing ruby2_keywords 0.0.5
Fetching i18n 1.14.1
Installing i18n 1.14.1
Fetching tzinfo 1.2.11
Installing tzinfo 1.2.11
Fetching sequel 5.77.0
Installing sequel 5.77.0
Fetching mocha 2.1.0
Installing mocha 2.1.0
Fetching activesupport 5.2.6.3
Installing activesupport 5.2.6.3
Fetching activemodel 5.2.6.3
Installing activemodel 5.2.6.3
Fetching activerecord 5.2.6.3
Installing activerecord 5.2.6.3
Using marginalia 1.6.0 from source at `.`
Bundle complete! 6 Gemfile dependencies, 17 gems now installed.
Use `bundle info [gemname]` to see where a bundled gem is installed.
travis_time:end:0f0c6d40:start=1709104435620912676,finish=1709104450165938431,duration=14545025755,event=install
travis_fold:end:install.bundler

travis_fold:start:before_script
travis_time:start:04e93c7b
$ sudo chmod 0644 $MARGINALIA_LOG_FILE
travis_time:end:04e93c7b:start=1709104450170342631,finish=1709104450178579835,duration=8237204,event=before_script
travis_fold:end:before_script
travis_time:start:03788900
$ 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
Traceback (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)>': Test::Unit must be loaded *before* `require 'mocha/test_unit'`. (RuntimeError)
rake aborted!
Command failed with status (1): [set -e; for file in $(find test -type f -name '*_test.rb'); do MARGINALIA_LOG_FILE=/var/log/postgresql/postgresql-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
The command "bundle exec rake db:reset test:postgresql" exited with 1.


Done. Your build exited with 1.