travis_fold:start:worker_info Worker information hostname: 3b98fc58-e78a-436d-84f8-f7a69902b831@1.worker-n2-com-779d777f7b-rxlft.gce-production-1 version: 6.2.22 https://github.com/travis-ci/worker/tree/858cb91994a513269f2fe9782c15fc113e966231 instance: travis-job-cec84bd8-1e5c-4c0b-85d0-e8257759b8a4 travis-ci-ubuntu-1804-1706776257-3d36ff62 (via amqp) startup: 6.29666738s travis_fold:end:worker_info travis_time:start:04c1f11e travis_time:end:04c1f11e:start=1709111219172329175,finish=1709111219378079836,duration=205750661,event=no_world_writable_dirs travis_time:start:00229428 travis_time:end:00229428:start=1709111219381164080,finish=1709111219390391415,duration=9227335,event=agent travis_time:start:10f0f388 travis_time:end:10f0f388:start=1709111219393330108,finish=1709111219395473803,duration=2143695,event=check_unsupported travis_time:start:052de050 travis_fold:start:system_info Build system information Build language: ruby Build dist: bionic Build id: 269163176 Job id: 618437733 Runtime kernel version: 5.4.0-1106-gcp travis-build version: f3de9fb7 Build image provisioning date and time Thu Feb 1 09:04:40 UTC 2024 Operating System Details Distributor ID: Ubuntu Description: Ubuntu 18.04.6 LTS Release: 18.04 Codename: bionic Systemd Version systemd 237 Cookbooks Version 4a0cff6 https://github.com/travis-ci/travis-cookbooks/tree/4a0cff6 git version git version 2.43.0 bash version GNU bash, version 4.4.20(1)-release (x86_64-pc-linux-gnu) gcc version gcc (Ubuntu 7.5.0-3ubuntu1~18.04) 7.5.0 docker version Client: Version: 20.10.21 API version: 1.41 Go version: go1.18.1 Git commit: 20.10.21-0ubuntu1~18.04.3 Built: Thu Apr 27 05:50:21 2023 OS/Arch: linux/amd64 Context: default Experimental: true Server: Engine: Version: 20.10.21 API version: 1.41 (minimum version 1.12) Go version: go1.18.1 Git commit: 20.10.21-0ubuntu1~18.04.3 Built: Thu Apr 27 05:36:22 2023 OS/Arch: linux/amd64 Experimental: false containerd: Version: 1.6.12-0ubuntu1~18.04.1 GitCommit: runc: Version: 1.1.4-0ubuntu1~18.04.2 GitCommit: docker-init: Version: 0.19.0 GitCommit: clang version clang version 16.0.0 jq version jq-1.7 bats version Bats 0.4.0 shellcheck version 0.9.0 shfmt version v3.7.0 ccache version 3.4.1 cmake version cmake version 3.26.3 heroku version heroku/8.7.1 linux-x64 node-v16.19.0 imagemagick version Version: ImageMagick 6.9.7-4 Q16 x86_64 20170114 http://www.imagemagick.org md5deep version 4.4 mercurial version version 5.3 mysql version mysql Ver 14.14 Distrib 5.7.42, for Linux (x86_64) using EditLine wrapper openssl version OpenSSL 1.1.1 11 Sep 2018 packer version 1.9.4 postgresql client version psql (PostgreSQL) 11.20 (Ubuntu 11.20-1.pgdg18.04+1) ragel version Ragel State Machine Compiler version 6.10 March 2017 sudo version 1.8.21p2 gzip version gzip 1.6 zip version Zip 3.0 vim version VIM - Vi IMproved 8.0 (2016 Sep 12, compiled Apr 18 2023 09:20:34) iptables version iptables v1.6.1 curl version curl 7.58.0 (x86_64-pc-linux-gnu) libcurl/7.58.0 OpenSSL/1.1.1 zlib/1.2.11 libidn2/2.0.4 libpsl/0.19.1 (+libidn2/2.0.4) nghttp2/1.30.0 librtmp/2.3 wget version GNU Wget 1.19.4 built on linux-gnu. rsync version rsync version 3.1.2 protocol version 31 gimme version v1.5.4 nvm version 0.39.7 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.17 ElasticSearch version 7.16.3 Installed Firefox version firefox 63.0.1 MongoDB version MongoDB 4.4.28 PhantomJS version 2.1.1 Pre-installed PostgreSQL versions 9.3.25 9.4.26 9.5.25 9.6.24 Redis version redis-server 7.2.4 Pre-installed Go versions 1.11.1 mvn version Apache Maven 3.9.4 (dfbb324ad4a7c8fb0bf182e6d91b0ae20e3d2dd9) gradle version Gradle 8.3! lein version Leiningen 2.11.1 on Java 11.0.21 OpenJDK 64-Bit Server VM Pre-installed Node.js versions v10.24.1 v12.22.12 v14.21.3 v16.15 v16.15.1 v16.20.2 v18.19.0 v20.11.0 v4.9.1 v6.17.1 v8.17.0 phpenv versions system 7.1 7.1.33 7.2 * 7.2.27 (set by /home/travis/.phpenv/version) 7.3 7.3.14 7.4 7.4.2 hhvm-stable hhvm composer --version Composer version 1.9.2 2020-01-14 16:30:31 Pre-installed Ruby versions ruby-2.5.9 ruby-2.7.6 ruby-3.1.2 travis_fold:end:system_info  travis_time:end:052de050:start=1709111219398450570,finish=1709111219407542192,duration=9091622,event=show_system_info travis_time:start:05d8c7c8 travis_time:end:05d8c7c8:start=1709111219411924120,finish=1709111219428952465,duration=17028345,event=rm_riak_source travis_time:start:19a0cd81 travis_time:end:19a0cd81:start=1709111219432361116,finish=1709111219440674007,duration=8312891,event=fix_rwky_redis travis_time:start:1e471648 travis_time:end:1e471648:start=1709111219445871880,finish=1709111220148679441,duration=702807561,event=wait_for_network travis_time:start:0bf785fe travis_time:end:0bf785fe:start=1709111220151680912,finish=1709111220476516131,duration=324835219,event=update_apt_keys travis_time:start:1483d803 travis_time:end:1483d803:start=1709111220479454893,finish=1709111220533409206,duration=53954313,event=fix_hhvm_source travis_time:start:07773b6c travis_time:end:07773b6c:start=1709111220536431922,finish=1709111220538896750,duration=2464828,event=update_mongo_arch travis_time:start:2f0976b1 travis_time:end:2f0976b1:start=1709111220541591928,finish=1709111220581751204,duration=40159276,event=fix_sudo_enabled_trusty travis_time:start:1a5d541c travis_time:end:1a5d541c:start=1709111220584728538,finish=1709111220586797645,duration=2069107,event=update_glibc travis_time:start:20b58720 travis_time:end:20b58720:start=1709111220589451562,finish=1709111220596883961,duration=7432399,event=clean_up_path travis_time:start:2008bcb4 travis_time:end:2008bcb4:start=1709111220599530015,finish=1709111220607669477,duration=8139462,event=fix_resolv_conf travis_time:start:05ec2f9a travis_time:end:05ec2f9a:start=1709111220610404827,finish=1709111220635196391,duration=24791564,event=fix_etc_hosts travis_time:start:049dd2a9 travis_time:end:049dd2a9:start=1709111220638133696,finish=1709111220645758618,duration=7624922,event=fix_mvn_settings_xml travis_time:start:1494dd04 travis_time:end:1494dd04:start=1709111220648543551,finish=1709111220657611251,duration=9067700,event=no_ipv6_localhost travis_time:start:3a8c4f40 travis_time:end:3a8c4f40:start=1709111220660336396,finish=1709111220662326008,duration=1989612,event=fix_etc_mavenrc travis_time:start:190c7bd2 OK travis_time:end:190c7bd2:start=1709111220665034274,finish=1709111221066100846,duration=401066572,event=fix_perforce_key travis_time:start:018efe83 travis_time:end:018efe83:start=1709111221069058749,finish=1709111221071707725,duration=2648976,event=fix_wwdr_certificate travis_time:start:19813340 travis_time:end:19813340:start=1709111221074452869,finish=1709111221136254193,duration=61801324,event=put_localhost_first travis_time:start:0f573956 travis_time:end:0f573956:start=1709111221139157184,finish=1709111221141997664,duration=2840480,event=home_paths travis_time:start:0241cb60 travis_time:end:0241cb60:start=1709111221144842626,finish=1709111221156386778,duration=11544152,event=disable_initramfs travis_time:start:0f579f40 travis_time:end:0f579f40:start=1709111221159128556,finish=1709111221297212698,duration=138084142,event=disable_ssh_roaming travis_time:start:027a3ec0 travis_time:end:027a3ec0:start=1709111221299966024,finish=1709111221301999703,duration=2033679,event=debug_tools travis_time:start:12fae28f travis_time:end:12fae28f:start=1709111221304636035,finish=1709111221307317161,duration=2681126,event=uninstall_oclint travis_time:start:02137de0 travis_time:end:02137de0:start=1709111221309912854,finish=1709111221312486627,duration=2573773,event=rvm_use travis_time:start:3140f088 travis_time:end:3140f088:start=1709111221315033034,finish=1709111221322268107,duration=7235073,event=rm_etc_boto_cfg travis_time:start:21b2cf24 travis_time:end:21b2cf24:start=1709111221324953701,finish=1709111221327264048,duration=2310347,event=rm_oraclejdk8_symlink travis_time:start:1c0edf86 travis_time:end:1c0edf86:start=1709111221329930230,finish=1709111221418276580,duration=88346350,event=enable_i386 travis_time:start:0036c0a8 travis_time:end:0036c0a8:start=1709111221421214860,finish=1709111221424895372,duration=3680512,event=update_rubygems travis_time:start:16f7c0a0 travis_time:end:16f7c0a0:start=1709111221427539930,finish=1709111222322643406,duration=895103476,event=ensure_path_components travis_time:start:00bc9e30 travis_time:end:00bc9e30:start=1709111222326336506,finish=1709111222328800757,duration=2464251,event=redefine_curl travis_time:start:02f1fc78 travis_time:end:02f1fc78:start=1709111222332008250,finish=1709111222334380233,duration=2371983,event=nonblock_pipe travis_time:start:0a2b76e6 travis_time:end:0a2b76e6:start=1709111222337456478,finish=1709111228391457750,duration=6054001272,event=apt_get_update travis_time:start:3388adc3 travis_time:end:3388adc3:start=1709111228394722362,finish=1709111228396834079,duration=2111717,event=deprecate_xcode_64 travis_time:start:1045a08c travis_time:end:1045a08c:start=1709111228399529932,finish=1709111232294104114,duration=3894574182,event=update_heroku travis_time:start:01bbda2c travis_time:end:01bbda2c:start=1709111232297197441,finish=1709111232299350934,duration=2153493,event=shell_session_update travis_time:start:069e0bb4 travis_fold:start:docker_mtu_and_registry_mirrors travis_fold:end:docker_mtu_and_registry_mirrors travis_time:end:069e0bb4:start=1709111232302206652,finish=1709111234524732623,duration=2222525971,event=set_docker_mtu_and_registry_mirrors travis_time:start:19941a68 travis_fold:start:resolvconf travis_fold:end:resolvconf travis_time:end:19941a68:start=1709111234531843368,finish=1709111234613074828,duration=81231460,event=resolvconf travis_time:start:02903af8 travis_time:end:02903af8:start=1709111234617091725,finish=1709111234753870623,duration=136778898,event=maven_central_mirror travis_time:start:2a46aac2 travis_time:end:2a46aac2:start=1709111234756833073,finish=1709111234845799514,duration=88966441,event=maven_https travis_fold:start:apt travis_time:start:03954928 $ travis_apt_get_update travis_time:end:03954928:start=1709111234849628212,finish=1709111247450870570,duration=12601242358,event=prepare Installing APT Packages PostgreSQL package is detected. Stopping postgresql service. See https://github.com/travis-ci/travis-ci/issues/5737 for more information. $ sudo systemctl stop postgresql travis_time:start:03eb7fca $ sudo -E apt-get -yq --no-install-suggests --no-install-recommends $(travis_apt_get_options) install postgresql-11 postgresql-client-11 Reading package lists... Building dependency tree... Reading state information... postgresql-11 is already the newest version (11.20-1.pgdg18.04+1). postgresql-client-11 is already the newest version (11.20-1.pgdg18.04+1). postgresql-client-11 set to manually installed. The following package was automatically installed and is no longer required: libgeos-3.6.2 Use 'sudo apt autoremove' to remove it. 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. travis_time:end:03eb7fca:start=1709111247485968600,finish=1709111248417426464,duration=931457864,event=prepare travis_fold:end:apt travis_time:start:05aa216b travis_fold:start:services travis_fold:end:services travis_time:end:05aa216b:start=1709111248420636464,finish=1709111251426032736,duration=3005396272,event=services travis_time:start:0d1d14e6 travis_time:end:0d1d14e6:start=1709111251429643731,finish=1709111251431973731,duration=2330000,event=fix_ps4 travis_fold:start:postgresql travis_time:start:0f35ae08 $ travis_setup_postgresql 11 Starting PostgreSQL v11 sudo systemctl start postgresql@11-main travis_time:end:0f35ae08:start=1709111251435224836,finish=1709111254590989340,duration=3155764504,event=prepare travis_fold:end:postgresql travis_time:start:08e7c509  travis_fold:start:git.checkout travis_time:start:13e33954 travis_time:end:13e33954:start=1709111254598126285,finish=1709111254603602260,duration=5475975,event=checkout travis_time:start:1739654a $ git clone --depth=50 --branch=ga-test280224 https://github.com/travis-ci/marginalia.git travis-ci/marginalia Cloning into 'travis-ci/marginalia'... remote: Enumerating objects: 570, done. remote: Counting objects: 0% (1/570) remote: Counting objects: 1% (6/570) remote: Counting objects: 2% (12/570) remote: Counting objects: 3% (18/570) remote: Counting objects: 4% (23/570) remote: Counting objects: 5% (29/570) remote: Counting objects: 6% (35/570) remote: Counting objects: 7% (40/570) remote: Counting objects: 8% (46/570) remote: Counting objects: 9% (52/570) remote: Counting objects: 10% (57/570) remote: Counting objects: 11% (63/570) remote: Counting objects: 12% (69/570) remote: Counting objects: 13% (75/570) remote: Counting objects: 14% (80/570) remote: Counting objects: 15% (86/570) remote: Counting objects: 16% (92/570) remote: Counting objects: 17% (97/570) remote: Counting objects: 18% (103/570) remote: Counting objects: 19% (109/570) remote: Counting objects: 20% (114/570) remote: Counting objects: 21% (120/570) remote: Counting objects: 22% (126/570) remote: Counting objects: 23% (132/570) remote: Counting objects: 24% (137/570) remote: Counting objects: 25% (143/570) remote: Counting objects: 26% (149/570) remote: Counting objects: 27% (154/570) remote: Counting objects: 28% (160/570) remote: Counting objects: 29% (166/570) remote: Counting objects: 30% (171/570) remote: Counting objects: 31% (177/570) remote: Counting objects: 32% (183/570) remote: Counting objects: 33% (189/570) remote: Counting objects: 34% (194/570) remote: Counting objects: 35% (200/570) remote: Counting objects: 36% (206/570) remote: Counting objects: 37% (211/570) remote: Counting objects: 38% (217/570) remote: Counting objects: 39% (223/570) remote: Counting objects: 40% (228/570) remote: Counting objects: 41% (234/570) remote: Counting objects: 42% (240/570) remote: Counting objects: 43% (246/570) remote: Counting objects: 44% (251/570) remote: Counting objects: 45% (257/570) remote: Counting objects: 46% (263/570) remote: Counting objects: 47% (268/570) remote: Counting objects: 48% (274/570) remote: Counting objects: 49% (280/570) remote: Counting objects: 50% (285/570) remote: Counting objects: 51% (291/570) remote: Counting objects: 52% (297/570) remote: Counting objects: 53% (303/570) remote: Counting objects: 54% (308/570) remote: Counting objects: 55% (314/570) remote: Counting objects: 56% (320/570) remote: Counting objects: 57% (325/570) remote: Counting objects: 58% (331/570) remote: Counting objects: 59% (337/570) remote: Counting objects: 60% (342/570) remote: Counting objects: 61% (348/570) remote: Counting objects: 62% (354/570) remote: Counting objects: 63% (360/570) remote: Counting objects: 64% (365/570) remote: Counting objects: 65% (371/570) remote: Counting objects: 66% (377/570) remote: Counting objects: 67% (382/570) remote: Counting objects: 68% (388/570) remote: Counting objects: 69% (394/570) remote: Counting objects: 70% (399/570) remote: Counting objects: 71% (405/570) remote: Counting objects: 72% (411/570) remote: Counting objects: 73% (417/570) remote: Counting objects: 74% (422/570) remote: Counting objects: 75% (428/570) remote: Counting objects: 76% (434/570) remote: Counting objects: 77% (439/570) remote: Counting objects: 78% (445/570) remote: Counting objects: 79% (451/570) remote: Counting objects: 80% (456/570) remote: Counting objects: 81% (462/570) remote: Counting objects: 82% (468/570) remote: Counting objects: 83% (474/570) remote: Counting objects: 84% (479/570) remote: Counting objects: 85% (485/570) remote: Counting objects: 86% (491/570) remote: Counting objects: 87% (496/570) remote: Counting objects: 88% (502/570) remote: Counting objects: 89% (508/570) remote: Counting objects: 90% (513/570) remote: Counting objects: 91% (519/570) remote: Counting objects: 92% (525/570) remote: Counting objects: 93% (531/570) remote: Counting objects: 94% (536/570) remote: Counting objects: 95% (542/570) remote: Counting objects: 96% (548/570) remote: Counting objects: 97% (553/570) remote: Counting objects: 98% (559/570) remote: Counting objects: 99% (565/570) remote: Counting objects: 100% (570/570) remote: Counting objects: 100% (570/570), done. remote: Compressing objects: 0% (1/303) remote: Compressing objects: 1% (4/303) remote: Compressing objects: 2% (7/303) remote: Compressing objects: 3% (10/303) remote: Compressing objects: 4% (13/303) remote: Compressing objects: 5% (16/303) remote: Compressing objects: 6% (19/303) remote: Compressing objects: 7% (22/303) remote: Compressing objects: 8% (25/303) remote: Compressing objects: 9% (28/303) remote: Compressing objects: 10% (31/303) remote: Compressing objects: 11% (34/303) remote: Compressing objects: 12% (37/303) remote: Compressing objects: 13% (40/303) remote: Compressing objects: 14% (43/303) remote: Compressing objects: 15% (46/303) remote: Compressing objects: 16% (49/303) remote: Compressing objects: 17% (52/303) remote: Compressing objects: 18% (55/303) remote: Compressing objects: 19% (58/303) remote: Compressing objects: 20% (61/303) remote: Compressing objects: 21% (64/303) remote: Compressing objects: 22% (67/303) remote: Compressing objects: 23% (70/303) remote: Compressing objects: 24% (73/303) remote: Compressing objects: 25% (76/303) remote: Compressing objects: 26% (79/303) remote: Compressing objects: 27% (82/303) remote: Compressing objects: 28% (85/303) remote: Compressing objects: 29% (88/303) remote: Compressing objects: 30% (91/303) remote: Compressing objects: 31% (94/303) remote: Compressing objects: 32% (97/303) remote: Compressing objects: 33% (100/303) remote: Compressing objects: 34% (104/303) remote: Compressing objects: 35% (107/303) remote: Compressing objects: 36% (110/303) remote: Compressing objects: 37% (113/303) remote: Compressing objects: 38% (116/303) remote: Compressing objects: 39% (119/303) remote: Compressing objects: 40% (122/303) remote: Compressing objects: 41% (125/303) remote: Compressing objects: 42% (128/303) remote: Compressing objects: 43% (131/303) remote: Compressing objects: 44% (134/303) remote: Compressing objects: 45% (137/303) remote: Compressing objects: 46% (140/303) remote: Compressing objects: 47% (143/303) remote: Compressing objects: 48% (146/303) remote: Compressing objects: 49% (149/303) remote: Compressing objects: 50% (152/303) remote: Compressing objects: 51% (155/303) remote: Compressing objects: 52% (158/303) remote: Compressing objects: 53% (161/303) remote: Compressing objects: 54% (164/303) remote: Compressing objects: 55% (167/303) remote: Compressing objects: 56% (170/303) remote: Compressing objects: 57% (173/303) remote: Compressing objects: 58% (176/303) remote: Compressing objects: 59% (179/303) remote: Compressing objects: 60% (182/303) remote: Compressing objects: 61% (185/303) remote: Compressing objects: 62% (188/303) remote: Compressing objects: 63% (191/303) remote: Compressing objects: 64% (194/303) remote: Compressing objects: 65% (197/303) remote: Compressing objects: 66% (200/303) remote: Compressing objects: 67% (204/303) remote: Compressing objects: 68% (207/303) remote: Compressing objects: 69% (210/303) remote: Compressing objects: 70% (213/303) remote: Compressing objects: 71% (216/303) remote: Compressing objects: 72% (219/303) remote: Compressing objects: 73% (222/303) remote: Compressing objects: 74% (225/303) remote: Compressing objects: 75% (228/303) remote: Compressing objects: 76% (231/303) remote: Compressing objects: 77% (234/303) remote: Compressing objects: 78% (237/303) remote: Compressing objects: 79% (240/303) remote: Compressing objects: 80% (243/303) remote: Compressing objects: 81% (246/303) remote: Compressing objects: 82% (249/303) remote: Compressing objects: 83% (252/303) remote: Compressing objects: 84% (255/303) remote: Compressing objects: 85% (258/303) remote: Compressing objects: 86% (261/303) remote: Compressing objects: 87% (264/303) remote: Compressing objects: 88% (267/303) remote: Compressing objects: 89% (270/303) remote: Compressing objects: 90% (273/303) remote: Compressing objects: 91% (276/303) remote: Compressing objects: 92% (279/303) remote: Compressing objects: 93% (282/303) remote: Compressing objects: 94% (285/303) remote: Compressing objects: 95% (288/303) remote: Compressing objects: 96% (291/303) remote: Compressing objects: 97% (294/303) remote: Compressing objects: 98% (297/303) remote: Compressing objects: 99% (300/303) remote: Compressing objects: 100% (303/303) remote: Compressing objects: 100% (303/303), done. Receiving objects: 0% (1/570) Receiving objects: 1% (6/570) Receiving objects: 2% (12/570) Receiving objects: 3% (18/570) Receiving objects: 4% (23/570) Receiving objects: 5% (29/570) Receiving objects: 6% (35/570) Receiving objects: 7% (40/570) Receiving objects: 8% (46/570) Receiving objects: 9% (52/570) Receiving objects: 10% (57/570) Receiving objects: 11% (63/570) Receiving objects: 12% (69/570) Receiving objects: 13% (75/570) Receiving objects: 14% (80/570) Receiving objects: 15% (86/570) Receiving objects: 16% (92/570) Receiving objects: 17% (97/570) Receiving objects: 18% (103/570) Receiving objects: 19% (109/570) Receiving objects: 20% (114/570) Receiving objects: 21% (120/570) Receiving objects: 22% (126/570) Receiving objects: 23% (132/570) Receiving objects: 24% (137/570) Receiving objects: 25% (143/570) Receiving objects: 26% (149/570) Receiving objects: 27% (154/570) Receiving objects: 28% (160/570) Receiving objects: 29% (166/570) Receiving objects: 30% (171/570) Receiving objects: 31% (177/570) Receiving objects: 32% (183/570) Receiving objects: 33% (189/570) Receiving objects: 34% (194/570) Receiving objects: 35% (200/570) Receiving objects: 36% (206/570) Receiving objects: 37% (211/570) Receiving objects: 38% (217/570) Receiving objects: 39% (223/570) Receiving objects: 40% (228/570) Receiving objects: 41% (234/570) Receiving objects: 42% (240/570) Receiving objects: 43% (246/570) Receiving objects: 44% (251/570) Receiving objects: 45% (257/570) Receiving objects: 46% (263/570) Receiving objects: 47% (268/570) Receiving objects: 48% (274/570) Receiving objects: 49% (280/570) Receiving objects: 50% (285/570) Receiving objects: 51% (291/570) Receiving objects: 52% (297/570) Receiving objects: 53% (303/570) Receiving objects: 54% (308/570) Receiving objects: 55% (314/570) Receiving objects: 56% (320/570) Receiving objects: 57% (325/570) Receiving objects: 58% (331/570) Receiving objects: 59% (337/570) Receiving objects: 60% (342/570) Receiving objects: 61% (348/570) Receiving objects: 62% (354/570) remote: Total 570 (delta 280), reused 520 (delta 238), pack-reused 0 Receiving objects: 63% (360/570) Receiving objects: 64% (365/570) Receiving objects: 65% (371/570) Receiving objects: 66% (377/570) Receiving objects: 67% (382/570) Receiving objects: 68% (388/570) Receiving objects: 69% (394/570) Receiving objects: 70% (399/570) Receiving objects: 71% (405/570) Receiving objects: 72% (411/570) Receiving objects: 73% (417/570) Receiving objects: 74% (422/570) Receiving objects: 75% (428/570) Receiving objects: 76% (434/570) Receiving objects: 77% (439/570) Receiving objects: 78% (445/570) Receiving objects: 79% (451/570) Receiving objects: 80% (456/570) Receiving objects: 81% (462/570) Receiving objects: 82% (468/570) Receiving objects: 83% (474/570) Receiving objects: 84% (479/570) Receiving objects: 85% (485/570) Receiving objects: 86% (491/570) Receiving objects: 87% (496/570) Receiving objects: 88% (502/570) Receiving objects: 89% (508/570) Receiving objects: 90% (513/570) Receiving objects: 91% (519/570) Receiving objects: 92% (525/570) Receiving objects: 93% (531/570) Receiving objects: 94% (536/570) Receiving objects: 95% (542/570) Receiving objects: 96% (548/570) Receiving objects: 97% (553/570) Receiving objects: 98% (559/570) Receiving objects: 99% (565/570) Receiving objects: 100% (570/570) Receiving objects: 100% (570/570), 81.62 KiB | 2.63 MiB/s, done. Resolving deltas: 0% (0/280) Resolving deltas: 1% (3/280) Resolving deltas: 2% (6/280) Resolving deltas: 3% (9/280) Resolving deltas: 4% (12/280) Resolving deltas: 5% (14/280) Resolving deltas: 6% (17/280) Resolving deltas: 7% (20/280) Resolving deltas: 8% (23/280) Resolving deltas: 9% (26/280) Resolving deltas: 10% (28/280) Resolving deltas: 11% (31/280) Resolving deltas: 12% (34/280) Resolving deltas: 13% (37/280) Resolving deltas: 14% (40/280) Resolving deltas: 15% (42/280) Resolving deltas: 16% (45/280) Resolving deltas: 17% (48/280) Resolving deltas: 18% (51/280) Resolving deltas: 19% (54/280) Resolving deltas: 20% (56/280) Resolving deltas: 21% (59/280) Resolving deltas: 22% (62/280) Resolving deltas: 23% (65/280) Resolving deltas: 24% (68/280) Resolving deltas: 25% (70/280) Resolving deltas: 26% (73/280) Resolving deltas: 27% (76/280) Resolving deltas: 28% (79/280) Resolving deltas: 29% (82/280) Resolving deltas: 30% (84/280) Resolving deltas: 31% (87/280) Resolving deltas: 32% (90/280) Resolving deltas: 33% (93/280) Resolving deltas: 34% (96/280) Resolving deltas: 35% (98/280) Resolving deltas: 36% (101/280) Resolving deltas: 37% (104/280) Resolving deltas: 38% (107/280) Resolving deltas: 39% (110/280) Resolving deltas: 40% (112/280) Resolving deltas: 41% (115/280) Resolving deltas: 42% (118/280) Resolving deltas: 43% (121/280) Resolving deltas: 44% (124/280) Resolving deltas: 45% (126/280) Resolving deltas: 46% (129/280) Resolving deltas: 47% (132/280) Resolving deltas: 48% (135/280) Resolving deltas: 49% (138/280) Resolving deltas: 50% (140/280) Resolving deltas: 51% (143/280) Resolving deltas: 52% (146/280) Resolving deltas: 53% (149/280) Resolving deltas: 54% (152/280) Resolving deltas: 55% (154/280) Resolving deltas: 56% (157/280) Resolving deltas: 57% (160/280) Resolving deltas: 58% (163/280) Resolving deltas: 59% (166/280) Resolving deltas: 60% (168/280) Resolving deltas: 61% (171/280) Resolving deltas: 62% (174/280) Resolving deltas: 63% (177/280) Resolving deltas: 64% (180/280) Resolving deltas: 65% (182/280) Resolving deltas: 66% (185/280) Resolving deltas: 67% (188/280) Resolving deltas: 68% (191/280) Resolving deltas: 69% (194/280) Resolving deltas: 70% (196/280) Resolving deltas: 71% (199/280) Resolving deltas: 72% (202/280) Resolving deltas: 73% (205/280) Resolving deltas: 74% (208/280) Resolving deltas: 75% (210/280) Resolving deltas: 76% (213/280) Resolving deltas: 77% (216/280) Resolving deltas: 78% (219/280) Resolving deltas: 79% (222/280) Resolving deltas: 80% (224/280) Resolving deltas: 81% (227/280) Resolving deltas: 82% (230/280) Resolving deltas: 83% (233/280) Resolving deltas: 84% (236/280) Resolving deltas: 85% (238/280) Resolving deltas: 86% (241/280) Resolving deltas: 87% (244/280) Resolving deltas: 88% (247/280) Resolving deltas: 89% (250/280) Resolving deltas: 90% (252/280) Resolving deltas: 91% (255/280) Resolving deltas: 92% (258/280) Resolving deltas: 93% (261/280) Resolving deltas: 94% (264/280) Resolving deltas: 95% (266/280) Resolving deltas: 96% (269/280) Resolving deltas: 97% (272/280) Resolving deltas: 98% (275/280) Resolving deltas: 99% (278/280) Resolving deltas: 100% (280/280) Resolving deltas: 100% (280/280), done. travis_time:end:1739654a:start=1709111254607144360,finish=1709111255079528758,duration=472384398,event=checkout $ cd travis-ci/marginalia $ git checkout -qf 5e4e9ac48341298b0a409db944a09592b6a2b043 travis_fold:end:git.checkout  travis_time:end:1739654a:start=1709111254607144360,finish=1709111255085326566,duration=478182206,event=checkout travis_time:start:04bfbe68  Setting environment variables from .travis.yml $ export MARGINALIA_DB_PORT=5432 $ export MARGINALIA_LOG_FILE=/var/log/postgresql/postgresql-11-main.log travis_time:end:04bfbe68:start=1709111255088665452,finish=1709111255095892760,duration=7227308,event=env travis_fold:start:rvm travis_time:start:28e1544a $ rvm get head Downloading https://get.rvm.io Downloading https://raw.githubusercontent.com/rvm/rvm/master/binscripts/rvm-installer.asc Verifying /home/travis/.rvm/archives/rvm-installer.asc gpg: Signature made Tue 21 Feb 2023 11:35:16 PM UTC gpg: using RSA key 7D2BAF1CF37B13E2069D6956105BD0E739499BDB gpg: Good signature from "Piotr Kuczynski " [unknown] gpg: WARNING: This key is not certified with a trusted signature! gpg: There is no indication that the signature belongs to the owner. Primary key fingerprint: 7D2B AF1C F37B 13E2 069D 6956 105B D0E7 3949 9BDB GPG verified '/home/travis/.rvm/archives/rvm-installer' Downloading https://github.com/rvm/rvm/archive/master.tar.gz Upgrading the RVM installation in /home/travis/.rvm/  RVM PATH line found in /home/travis/.mkshrc /home/travis/.profile /home/travis/.zshrc.  RVM PATH line not found for Bash, rerun this command with '--auto-dotfiles' flag to fix it.  RVM sourcing line found in /home/travis/.profile /home/travis/.bashrc /home/travis/.zlogin. Upgrade of RVM in /home/travis/.rvm/ is complete.  Thanks for installing RVM 🙏 Please consider donating to our open collective to help us maintain RVM. 👉 Donate: https://opencollective.com/rvm/donate  RVM reloaded! travis_time:end:28e1544a:start=1709111255104820429,finish=1709111257817314709,duration=2712494280,event= travis_time:start:068dfc2e $ rvm use 3.2.2 --install --binary --fuzzy curl: (22) The requested URL returned error: 404 Required ruby-3.2.2 is not installed - installing. curl: (22) The requested URL returned error: 404 Searching for binary rubies, this might take some time. Found remote file https://rubies.travis-ci.org/ubuntu/18.04/x86_64/ruby-3.2.2.tar.bz2 Checking requirements for ubuntu. Requirements installation successful. ruby-3.2.2 - #configure ruby-3.2.2 - #download % Total % Received % Xferd Average Speed Time Time Time Current Dload Upload Total Spent Left Speed 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0 67 29.2M 67 19.7M 0 0 14.0M 0 0:00:02 0:00:01 0:00:01 14.0M 100 29.2M 100 29.2M 0 0 19.6M 0 0:00:01 0:00:01 --:--:-- 117M No checksum for downloaded archive, recording checksum in user configuration. ruby-3.2.2 - #validate archive ruby-3.2.2 - #extract ruby-3.2.2 - #validate binary ruby-3.2.2 - #setup ruby-3.2.2 - #gemset created /home/travis/.rvm/gems/ruby-3.2.2@global ruby-3.2.2 - #importing gemset /home/travis/.rvm/gemsets/global.gems|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.. ruby-3.2.2 - #generating global wrappers|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/. ruby-3.2.2 - #uninstalling gem rubygems-bundler-1.4.5|/. ruby-3.2.2 - #gemset created /home/travis/.rvm/gems/ruby-3.2.2 ruby-3.2.2 - #importing gemset /home/travis/.rvm/gemsets/default.gems|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\. ruby-3.2.2 - #generating default wrappers|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-. Using /home/travis/.rvm/gems/ruby-3.2.2 travis_time:end:068dfc2e:start=1709111257821661909,finish=1709111280130038765,duration=22308376856,event= travis_fold:end:rvm  $ export BUNDLE_GEMFILE=$PWD/Gemfile travis_fold:start:ruby.versions $ ruby --version ruby 3.2.2 (2023-03-30 revision e51014f9c0) [x86_64-linux] $ rvm --version rvm 1.29.12-next (master) by Michal Papis, Piotr Kuczynski, Wayne E. Seguin [https://rvm.io] $ bundle --version Bundler version 2.4.10 $ gem --version 3.4.10 travis_fold:end:ruby.versions  travis_fold:start:before_install travis_time:start:006a71a4 $ bash -c "yes | gem uninstall -i /home/travis/.rvm/gems/ruby-3.2.0@global rake" Gem 'rake' is not installed travis_time:end:006a71a4:start=1709111280585353997,finish=1709111280757569810,duration=172215813,event=before_install travis_fold:end:before_install travis_fold:start:install.bundler travis_time:start:20c16a36 $ bundle install --jobs=3 --retry=3 Fetching gem metadata from https://rubygems.org/....... Resolving dependencies... Fetching rake 13.1.0 Installing rake 13.1.0 Fetching concurrent-ruby 1.2.3 Fetching base64 0.2.0 Fetching bigdecimal 3.1.6 Installing base64 0.2.0 Fetching connection_pool 2.4.1 Installing bigdecimal 3.1.6 with native extensions Installing connection_pool 2.4.1 Installing concurrent-ruby 1.2.3 Using ruby2_keywords 0.0.5 Fetching minitest 5.18.1 Fetching mutex_m 0.2.0 Installing minitest 5.18.1 Installing mutex_m 0.2.0 Fetching timeout 0.4.1 Using bundler 2.4.10 Fetching pg 1.5.5 Installing timeout 0.4.1 Using power_assert 2.0.3 Fetching drb 2.2.0 Installing pg 1.5.5 with native extensions Installing drb 2.2.0 Fetching mocha 2.1.0 Installing mocha 2.1.0 Fetching i18n 1.14.1 Installing i18n 1.14.1 Fetching tzinfo 2.0.6 Installing tzinfo 2.0.6 Fetching test-unit 3.6.2 Installing test-unit 3.6.2 Fetching activesupport 7.1.3.2 Fetching sequel 5.77.0 Installing activesupport 7.1.3.2 Installing sequel 5.77.0 Fetching activemodel 7.1.3.2 Installing activemodel 7.1.3.2 Fetching activerecord 7.1.3.2 Installing activerecord 7.1.3.2 Using marginalia 1.5.0 from source at `.` Bundle complete! 7 Gemfile dependencies, 22 gems now installed. Use `bundle info [gemname]` to see where a bundled gem is installed. travis_time:end:20c16a36:start=1709111280763146836,finish=1709111297538077879,duration=16774931043,event=install travis_fold:end:install.bundler  travis_fold:start:before_script travis_time:start:0af75bc0 $ sudo chmod 0644 $MARGINALIA_LOG_FILE travis_time:end:0af75bc0:start=1709111297544196707,finish=1709111297554500844,duration=10304137,event=before_script travis_fold:end:before_script travis_time:start:03d1b1ce $ bundle exec rake db:reset test:postgresql set -e; for file in $(find test -type f -name '*_test.rb'); do MARGINALIA_LOG_FILE=/var/log/postgresql/postgresql-11-main.log MARGINALIA_DB_PORT=5432 ruby -Ilib -Itest $file; done Run options: --seed 24117 # Running: ...... Finished in 0.005028s, 1193.2598 runs/s, 1591.0130 assertions/s. 6 runs, 8 assertions, 0 failures, 0 errors, 0 skips Run options: --seed 11111 # Running: .. Finished in 0.001670s, 1197.8860 runs/s, 1796.8290 assertions/s. 2 runs, 3 assertions, 0 failures, 0 errors, 0 skips -- create_table("posts", {:force=>true}) -> 0.0075s Run options: --seed 54781 # Running: .E Finished in 0.023781s, 84.1021 runs/s, 126.1532 assertions/s. 1) Error: ActiveRecordMarginaliaTest#test_configuring_application: RuntimeError: Expected to find string /*adapter:active_record,app:customapp*/ in file /var/log/postgresql/postgresql-11-main.log /home/travis/build/travis-ci/marginalia/test/test_helpers.rb:10:in `file_contains_string' test/active_record/query_comments_test.rb:70:in `test_configuring_application' 2 runs, 3 assertions, 0 failures, 1 errors, 0 skips rake aborted! Command failed with status (1): [set -e; for file in $(find test -type f -name '*_test.rb'); do MARGINALIA_LOG_FILE=/var/log/postgresql/postgresql-11-main.log MARGINALIA_DB_PORT=5432 ruby -Ilib -Itest $file; done] /home/travis/build/travis-ci/marginalia/Rakefile:15:in `block (2 levels) in ' /home/travis/.rvm/gems/ruby-3.2.2/gems/rake-13.1.0/exe/rake:27:in `' /home/travis/.rvm/gems/ruby-3.2.2/bin/ruby_executable_hooks:22:in `eval' /home/travis/.rvm/gems/ruby-3.2.2/bin/ruby_executable_hooks:22:in `
' Tasks: TOP => test:postgresql (See full trace by running task with --trace) travis_time:end:03d1b1ce:start=1709111297559914843,finish=1709111299789753003,duration=2229838160,event=script The command "bundle exec rake db:reset test:postgresql" exited with 1. Done. Your build exited with 1.