travis_fold:start:worker_info [0K[33;1mWorker information[0m hostname: ed1ee84b-dc6b-43a6-a5e1-7c3d8894683b@1.worker-n2-com-779d777f7b-rxlft.gce-production-1 version: 6.2.22 https://github.com/travis-ci/worker/tree/858cb91994a513269f2fe9782c15fc113e966231 instance: travis-job-22e6ba51-6b08-4486-9f30-d99515592678 travis-ci-ubuntu-1804-1706776257-3d36ff62 (via amqp) startup: 6.217227946s travis_fold:end:worker_info [0Ktravis_time:start:1cb4bee2 [0Ktravis_time:end:1cb4bee2:start=1709113874546894134,finish=1709113874745493352,duration=198599218,event=no_world_writable_dirs [0Ktravis_time:start:18b9a940 [0Ktravis_time:end:18b9a940:start=1709113874748378226,finish=1709113874755522181,duration=7143955,event=agent [0Ktravis_time:start:00fa3e17 [0Ktravis_time:end:00fa3e17:start=1709113874758117306,finish=1709113874759978687,duration=1861381,event=check_unsupported [0Ktravis_time:start:293545b0 [0Ktravis_fold:start:system_info [0K[33;1mBuild system information[0m Build language: ruby Build dist: bionic Build id: 269164340 Job id: 618440649 Runtime kernel version: 5.4.0-1106-gcp travis-build version: f3de9fb7 [34m[1mBuild image provisioning date and time[0m Thu Feb 1 09:04:40 UTC 2024 [34m[1mOperating System Details[0m Distributor ID: Ubuntu Description: Ubuntu 18.04.6 LTS Release: 18.04 Codename: bionic [34m[1mSystemd Version[0m systemd 237 [34m[1mCookbooks Version[0m 4a0cff6 https://github.com/travis-ci/travis-cookbooks/tree/4a0cff6 [34m[1mgit version[0m git version 2.43.0 [34m[1mbash version[0m GNU bash, version 4.4.20(1)-release (x86_64-pc-linux-gnu) [34m[1mgcc version[0m gcc (Ubuntu 7.5.0-3ubuntu1~18.04) 7.5.0 [34m[1mdocker version[0m Client: Version: 20.10.21 API version: 1.41 Go version: go1.18.1 Git commit: 20.10.21-0ubuntu1~18.04.3 Built: Thu Apr 27 05:50:21 2023 OS/Arch: linux/amd64 Context: default Experimental: true Server: Engine: Version: 20.10.21 API version: 1.41 (minimum version 1.12) Go version: go1.18.1 Git commit: 20.10.21-0ubuntu1~18.04.3 Built: Thu Apr 27 05:36:22 2023 OS/Arch: linux/amd64 Experimental: false containerd: Version: 1.6.12-0ubuntu1~18.04.1 GitCommit: runc: Version: 1.1.4-0ubuntu1~18.04.2 GitCommit: docker-init: Version: 0.19.0 GitCommit: [34m[1mclang version[0m clang version 16.0.0 [34m[1mjq version[0m jq-1.7 [34m[1mbats version[0m Bats 0.4.0 [34m[1mshellcheck version[0m 0.9.0 [34m[1mshfmt version[0m v3.7.0 [34m[1mccache version[0m 3.4.1 [34m[1mcmake version[0m cmake version 3.26.3 [34m[1mheroku version[0m heroku/8.7.1 linux-x64 node-v16.19.0 [34m[1mimagemagick version[0m Version: ImageMagick 6.9.7-4 Q16 x86_64 20170114 http://www.imagemagick.org [34m[1mmd5deep version[0m 4.4 [34m[1mmercurial version[0m version 5.3 [34m[1mmysql version[0m mysql Ver 14.14 Distrib 5.7.42, for Linux (x86_64) using EditLine wrapper [34m[1mopenssl version[0m OpenSSL 1.1.1 11 Sep 2018 [34m[1mpacker version[0m 1.9.4 [34m[1mpostgresql client version[0m psql (PostgreSQL) 11.20 (Ubuntu 11.20-1.pgdg18.04+1) [34m[1mragel version[0m Ragel State Machine Compiler version 6.10 March 2017 [34m[1msudo version[0m 1.8.21p2 [34m[1mgzip version[0m gzip 1.6 [34m[1mzip version[0m Zip 3.0 [34m[1mvim version[0m VIM - Vi IMproved 8.0 (2016 Sep 12, compiled Apr 18 2023 09:20:34) [34m[1miptables version[0m iptables v1.6.1 [34m[1mcurl version[0m curl 7.58.0 (x86_64-pc-linux-gnu) libcurl/7.58.0 OpenSSL/1.1.1 zlib/1.2.11 libidn2/2.0.4 libpsl/0.19.1 (+libidn2/2.0.4) nghttp2/1.30.0 librtmp/2.3 [34m[1mwget version[0m GNU Wget 1.19.4 built on linux-gnu. [34m[1mrsync version[0m rsync version 3.1.2 protocol version 31 [34m[1mgimme version[0m v1.5.4 [34m[1mnvm version[0m 0.39.7 [34m[1mperlbrew version[0m /home/travis/perl5/perlbrew/bin/perlbrew - App::perlbrew/0.95 [34m[1mphpenv version[0m rbenv 1.2.0 [34m[1mrvm version[0m rvm 1.29.12 (latest) by Michal Papis, Piotr Kuczynski, Wayne E. Seguin [https://rvm.io] [34m[1mdefault ruby version[0m ruby 2.7.6p219 (2022-04-12 revision c9c2245c0a) [x86_64-linux] [34m[1mdefault python version[0m Python 3.7.17 [34m[1mElasticSearch version[0m 7.16.3 [34m[1mInstalled Firefox version[0m firefox 63.0.1 [34m[1mMongoDB version[0m MongoDB 4.4.28 [34m[1mPhantomJS version[0m 2.1.1 [34m[1mPre-installed PostgreSQL versions[0m 9.3.25 9.4.26 9.5.25 9.6.24 [34m[1mRedis version[0m redis-server 7.2.4 [34m[1mPre-installed Go versions[0m 1.11.1 [34m[1mmvn version[0m Apache Maven 3.9.4 (dfbb324ad4a7c8fb0bf182e6d91b0ae20e3d2dd9) [34m[1mgradle version[0m Gradle 8.3! [34m[1mlein version[0m Leiningen 2.11.1 on Java 11.0.21 OpenJDK 64-Bit Server VM [34m[1mPre-installed Node.js versions[0m v10.24.1 v12.22.12 v14.21.3 v16.15 v16.15.1 v16.20.2 v18.19.0 v20.11.0 v4.9.1 v6.17.1 v8.17.0 [34m[1mphpenv versions[0m system 7.1 7.1.33 7.2 * 7.2.27 (set by /home/travis/.phpenv/version) 7.3 7.3.14 7.4 7.4.2 hhvm-stable hhvm [34m[1mcomposer --version[0m Composer version 1.9.2 2020-01-14 16:30:31 [34m[1mPre-installed Ruby versions[0m ruby-2.5.9 ruby-2.7.6 ruby-3.1.2 travis_fold:end:system_info [0K travis_time:end:293545b0:start=1709113874762692932,finish=1709113874772605086,duration=9912154,event=show_system_info [0Ktravis_time:start:1d2f686e [0Ktravis_time:end:1d2f686e:start=1709113874775845651,finish=1709113874790849583,duration=15003932,event=rm_riak_source [0Ktravis_time:start:01e35ec4 [0Ktravis_time:end:01e35ec4:start=1709113874794047352,finish=1709113874798864220,duration=4816868,event=fix_rwky_redis [0Ktravis_time:start:0882b49c [0Ktravis_time:end:0882b49c:start=1709113874801796255,finish=1709113875380959145,duration=579162890,event=wait_for_network [0Ktravis_time:start:2ba8ef95 [0Ktravis_time:end:2ba8ef95:start=1709113875383990160,finish=1709113875712126806,duration=328136646,event=update_apt_keys [0Ktravis_time:start:1d4bd4cc [0Ktravis_time:end:1d4bd4cc:start=1709113875715171618,finish=1709113875767143915,duration=51972297,event=fix_hhvm_source [0Ktravis_time:start:0361e640 [0Ktravis_time:end:0361e640:start=1709113875770148999,finish=1709113875772611335,duration=2462336,event=update_mongo_arch [0Ktravis_time:start:0afd8da6 [0Ktravis_time:end:0afd8da6:start=1709113875775365240,finish=1709113875815990048,duration=40624808,event=fix_sudo_enabled_trusty [0Ktravis_time:start:366c074c [0Ktravis_time:end:366c074c:start=1709113875818957916,finish=1709113875821017624,duration=2059708,event=update_glibc [0Ktravis_time:start:08366fde [0Ktravis_time:end:08366fde:start=1709113875823582833,finish=1709113875830875213,duration=7292380,event=clean_up_path [0Ktravis_time:start:010d686a [0Ktravis_time:end:010d686a:start=1709113875833489139,finish=1709113875841386509,duration=7897370,event=fix_resolv_conf [0Ktravis_time:start:16acd6d8 [0Ktravis_time:end:16acd6d8:start=1709113875843974097,finish=1709113875869739778,duration=25765681,event=fix_etc_hosts [0Ktravis_time:start:0baab792 [0Ktravis_time:end:0baab792:start=1709113875872492717,finish=1709113875879840151,duration=7347434,event=fix_mvn_settings_xml [0Ktravis_time:start:03f988ab [0Ktravis_time:end:03f988ab:start=1709113875882568896,finish=1709113875891331482,duration=8762586,event=no_ipv6_localhost [0Ktravis_time:start:0aaeceb7 [0Ktravis_time:end:0aaeceb7:start=1709113875893985494,finish=1709113875895889259,duration=1903765,event=fix_etc_mavenrc [0Ktravis_time:start:02f75eda [0KOK travis_time:end:02f75eda:start=1709113875898464479,finish=1709113876277623251,duration=379158772,event=fix_perforce_key [0Ktravis_time:start:067d8254 [0Ktravis_time:end:067d8254:start=1709113876280768321,finish=1709113876283674074,duration=2905753,event=fix_wwdr_certificate [0Ktravis_time:start:1a272cb9 [0Ktravis_time:end:1a272cb9:start=1709113876286780309,finish=1709113876330562376,duration=43782067,event=put_localhost_first [0Ktravis_time:start:04312617 [0Ktravis_time:end:04312617:start=1709113876333371299,finish=1709113876336291025,duration=2919726,event=home_paths [0Ktravis_time:start:056c4050 [0Ktravis_time:end:056c4050:start=1709113876338995575,finish=1709113876350601908,duration=11606333,event=disable_initramfs [0Ktravis_time:start:0070be5e [0Ktravis_time:end:0070be5e:start=1709113876353367686,finish=1709113876500149829,duration=146782143,event=disable_ssh_roaming [0Ktravis_time:start:10156ce0 [0Ktravis_time:end:10156ce0:start=1709113876503130999,finish=1709113876505453215,duration=2322216,event=debug_tools [0Ktravis_time:start:002abfee [0Ktravis_time:end:002abfee:start=1709113876508349314,finish=1709113876511366780,duration=3017466,event=uninstall_oclint [0Ktravis_time:start:0fad620e [0Ktravis_time:end:0fad620e:start=1709113876514297712,finish=1709113876517037232,duration=2739520,event=rvm_use [0Ktravis_time:start:1a168a68 [0Ktravis_time:end:1a168a68:start=1709113876519746698,finish=1709113876527523259,duration=7776561,event=rm_etc_boto_cfg [0Ktravis_time:start:0020a900 [0Ktravis_time:end:0020a900:start=1709113876530277799,finish=1709113876532969325,duration=2691526,event=rm_oraclejdk8_symlink [0Ktravis_time:start:24a7e0bc [0Ktravis_time:end:24a7e0bc:start=1709113876535710336,finish=1709113876632387294,duration=96676958,event=enable_i386 [0Ktravis_time:start:062052c8 [0Ktravis_time:end:062052c8:start=1709113876635561081,finish=1709113876639721984,duration=4160903,event=update_rubygems [0Ktravis_time:start:0d806bc0 [0Ktravis_time:end:0d806bc0:start=1709113876642628249,finish=1709113877561211255,duration=918583006,event=ensure_path_components [0Ktravis_time:start:0c698944 [0Ktravis_time:end:0c698944:start=1709113877564711370,finish=1709113877566995817,duration=2284447,event=redefine_curl [0Ktravis_time:start:12a55386 [0Ktravis_time:end:12a55386:start=1709113877569918743,finish=1709113877572075861,duration=2157118,event=nonblock_pipe [0Ktravis_time:start:002d53be [0Ktravis_time:end:002d53be:start=1709113877574984506,finish=1709113883616817969,duration=6041833463,event=apt_get_update [0Ktravis_time:start:021dae00 [0Ktravis_time:end:021dae00:start=1709113883619671075,finish=1709113883621664674,duration=1993599,event=deprecate_xcode_64 [0Ktravis_time:start:087f78b4 [0Ktravis_time:end:087f78b4:start=1709113883624145799,finish=1709113887475207032,duration=3851061233,event=update_heroku [0Ktravis_time:start:03b77dae [0Ktravis_time:end:03b77dae:start=1709113887478166817,finish=1709113887480170180,duration=2003363,event=shell_session_update [0Ktravis_time:start:084a5483 [0Ktravis_fold:start:docker_mtu_and_registry_mirrors [0Ktravis_fold:end:docker_mtu_and_registry_mirrors [0Ktravis_time:end:084a5483:start=1709113887482835015,finish=1709113889707562445,duration=2224727430,event=set_docker_mtu_and_registry_mirrors [0Ktravis_time:start:10ad085c [0Ktravis_fold:start:resolvconf [0Ktravis_fold:end:resolvconf [0Ktravis_time:end:10ad085c:start=1709113889710583611,finish=1709113889780036065,duration=69452454,event=resolvconf [0Ktravis_time:start:08aafddf [0Ktravis_time:end:08aafddf:start=1709113889784892833,finish=1709113889922050976,duration=137158143,event=maven_central_mirror [0Ktravis_time:start:20c0ae49 [0Ktravis_time:end:20c0ae49:start=1709113889924839916,finish=1709113890010836909,duration=85996993,event=maven_https [0Ktravis_fold:start:apt [0Ktravis_time:start:0316b4c0 [0K$ travis_apt_get_update travis_time:end:0316b4c0:start=1709113890014502441,finish=1709113902597331375,duration=12582828934,event=prepare [0K[33;1mInstalling APT Packages[0m [33;1mPostgreSQL package is detected. Stopping postgresql service. See https://github.com/travis-ci/travis-ci/issues/5737 for more information.[0m $ sudo systemctl stop postgresql travis_time:start:07ede8d0 [0K$ sudo -E apt-get -yq --no-install-suggests --no-install-recommends $(travis_apt_get_options) install postgresql-11 postgresql-client-11 Reading package lists... Building dependency tree... Reading state information... postgresql-11 is already the newest version (11.20-1.pgdg18.04+1). postgresql-client-11 is already the newest version (11.20-1.pgdg18.04+1). postgresql-client-11 set to manually installed. The following package was automatically installed and is no longer required: libgeos-3.6.2 Use 'sudo apt autoremove' to remove it. 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. travis_time:end:07ede8d0:start=1709113902636734053,finish=1709113903497275492,duration=860541439,event=prepare [0Ktravis_fold:end:apt [0Ktravis_time:start:04a28939 [0Ktravis_fold:start:services [0Ktravis_fold:end:services [0Ktravis_time:end:04a28939:start=1709113903500748852,finish=1709113906506280740,duration=3005531888,event=services [0Ktravis_time:start:10e3c582 [0Ktravis_time:end:10e3c582:start=1709113906509552926,finish=1709113906511632853,duration=2079927,event=fix_ps4 [0Ktravis_fold:start:postgresql [0Ktravis_time:start:0e815a1c [0K$ travis_setup_postgresql 11 [33;1mStarting PostgreSQL v11[0K sudo systemctl start postgresql@11-main travis_time:end:0e815a1c:start=1709113906514561163,finish=1709113909672592709,duration=3158031546,event=prepare [0Ktravis_fold:end:postgresql [0Ktravis_time:start:0ca27be1 [0K travis_fold:start:git.checkout [0Ktravis_time:start:11c43396 [0Ktravis_time:end:11c43396:start=1709113909679159477,finish=1709113909684115336,duration=4955859,event=checkout [0Ktravis_time:start:17f8aec8 [0K$ 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: 496, done.[K remote: Counting objects: 0% (1/496)[K remote: Counting objects: 1% (5/496)[K remote: Counting objects: 2% (10/496)[K remote: Counting objects: 3% (15/496)[K remote: Counting objects: 4% (20/496)[K remote: Counting objects: 5% (25/496)[K remote: Counting objects: 6% (30/496)[K remote: Counting objects: 7% (35/496)[K remote: Counting objects: 8% (40/496)[K remote: Counting objects: 9% (45/496)[K remote: Counting objects: 10% (50/496)[K remote: Counting objects: 11% (55/496)[K remote: Counting objects: 12% (60/496)[K remote: Counting objects: 13% (65/496)[K remote: Counting objects: 14% (70/496)[K remote: Counting objects: 15% (75/496)[K remote: Counting objects: 16% (80/496)[K remote: Counting objects: 17% (85/496)[K remote: Counting objects: 18% (90/496)[K remote: Counting objects: 19% (95/496)[K remote: Counting objects: 20% (100/496)[K remote: Counting objects: 21% (105/496)[K remote: Counting objects: 22% (110/496)[K remote: Counting objects: 23% (115/496)[K remote: Counting objects: 24% (120/496)[K remote: Counting objects: 25% (124/496)[K remote: Counting objects: 26% (129/496)[K remote: Counting objects: 27% (134/496)[K remote: Counting objects: 28% (139/496)[K remote: Counting objects: 29% (144/496)[K remote: Counting objects: 30% (149/496)[K remote: Counting objects: 31% (154/496)[K remote: Counting objects: 32% (159/496)[K remote: Counting objects: 33% (164/496)[K remote: Counting objects: 34% (169/496)[K remote: Counting objects: 35% (174/496)[K remote: Counting objects: 36% (179/496)[K remote: Counting objects: 37% (184/496)[K remote: Counting objects: 38% (189/496)[K remote: Counting objects: 39% (194/496)[K remote: Counting objects: 40% (199/496)[K remote: Counting objects: 41% (204/496)[K remote: Counting objects: 42% (209/496)[K remote: Counting objects: 43% (214/496)[K remote: Counting objects: 44% (219/496)[K remote: Counting objects: 45% (224/496)[K remote: Counting objects: 46% (229/496)[K remote: Counting objects: 47% (234/496)[K remote: Counting objects: 48% (239/496)[K remote: Counting objects: 49% (244/496)[K remote: Counting objects: 50% (248/496)[K remote: Counting objects: 51% (253/496)[K remote: Counting objects: 52% (258/496)[K remote: Counting objects: 53% (263/496)[K remote: Counting objects: 54% (268/496)[K remote: Counting objects: 55% (273/496)[K remote: Counting objects: 56% (278/496)[K remote: Counting objects: 57% (283/496)[K remote: Counting objects: 58% (288/496)[K remote: Counting objects: 59% (293/496)[K remote: Counting objects: 60% (298/496)[K remote: Counting objects: 61% (303/496)[K remote: Counting objects: 62% (308/496)[K remote: Counting objects: 63% (313/496)[K remote: Counting objects: 64% (318/496)[K remote: Counting objects: 65% (323/496)[K remote: Counting objects: 66% (328/496)[K remote: Counting objects: 67% (333/496)[K remote: Counting objects: 68% (338/496)[K remote: Counting objects: 69% (343/496)[K remote: Counting objects: 70% (348/496)[K remote: Counting objects: 71% (353/496)[K remote: Counting objects: 72% (358/496)[K remote: Counting objects: 73% (363/496)[K remote: Counting objects: 74% (368/496)[K remote: Counting objects: 75% (372/496)[K remote: Counting objects: 76% (377/496)[K remote: Counting objects: 77% (382/496)[K remote: Counting objects: 78% (387/496)[K remote: Counting objects: 79% (392/496)[K remote: Counting objects: 80% (397/496)[K remote: Counting objects: 81% (402/496)[K remote: Counting objects: 82% (407/496)[K remote: Counting objects: 83% (412/496)[K remote: Counting objects: 84% (417/496)[K remote: Counting objects: 85% (422/496)[K remote: Counting objects: 86% (427/496)[K remote: Counting objects: 87% (432/496)[K remote: Counting objects: 88% (437/496)[K remote: Counting objects: 89% (442/496)[K remote: Counting objects: 90% (447/496)[K remote: Counting objects: 91% (452/496)[K remote: Counting objects: 92% (457/496)[K remote: Counting objects: 93% (462/496)[K remote: Counting objects: 94% (467/496)[K remote: Counting objects: 95% (472/496)[K remote: Counting objects: 96% (477/496)[K remote: Counting objects: 97% (482/496)[K remote: Counting objects: 98% (487/496)[K remote: Counting objects: 99% (492/496)[K remote: Counting objects: 100% (496/496)[K remote: Counting objects: 100% (496/496), done.[K remote: Compressing objects: 0% (1/256)[K remote: Compressing objects: 1% (3/256)[K remote: Compressing objects: 2% (6/256)[K remote: Compressing objects: 3% (8/256)[K remote: Compressing objects: 4% (11/256)[K remote: Compressing objects: 5% (13/256)[K remote: Compressing objects: 6% (16/256)[K remote: Compressing objects: 7% (18/256)[K remote: Compressing objects: 8% (21/256)[K remote: Compressing objects: 9% (24/256)[K remote: Compressing objects: 10% (26/256)[K remote: Compressing objects: 11% (29/256)[K remote: Compressing objects: 12% (31/256)[K remote: Compressing objects: 13% (34/256)[K remote: Compressing objects: 14% (36/256)[K remote: Compressing objects: 15% (39/256)[K remote: Compressing objects: 16% (41/256)[K remote: Compressing objects: 17% (44/256)[K remote: Compressing objects: 18% (47/256)[K remote: Compressing objects: 19% (49/256)[K remote: Compressing objects: 20% (52/256)[K remote: Compressing objects: 21% (54/256)[K remote: Compressing objects: 22% (57/256)[K remote: Compressing objects: 23% (59/256)[K remote: Compressing objects: 24% (62/256)[K remote: Compressing objects: 25% (64/256)[K remote: Compressing objects: 26% (67/256)[K remote: Compressing objects: 27% (70/256)[K remote: Compressing objects: 28% (72/256)[K remote: Compressing objects: 29% (75/256)[K remote: Compressing objects: 30% (77/256)[K remote: Compressing objects: 31% (80/256)[K remote: Compressing objects: 32% (82/256)[K remote: Compressing objects: 33% (85/256)[K remote: Compressing objects: 34% (88/256)[K remote: Compressing objects: 35% (90/256)[K remote: Compressing objects: 36% (93/256)[K remote: Compressing objects: 37% (95/256)[K remote: Compressing objects: 38% (98/256)[K remote: Compressing objects: 39% (100/256)[K remote: Compressing objects: 40% (103/256)[K remote: Compressing objects: 41% (105/256)[K remote: Compressing objects: 42% (108/256)[K remote: Compressing objects: 43% (111/256)[K remote: Compressing objects: 44% (113/256)[K remote: Compressing objects: 45% (116/256)[K remote: Compressing objects: 46% (118/256)[K remote: Compressing objects: 47% (121/256)[K remote: Compressing objects: 48% (123/256)[K remote: Compressing objects: 49% (126/256)[K remote: Compressing objects: 50% (128/256)[K remote: Compressing objects: 51% (131/256)[K remote: Compressing objects: 52% (134/256)[K remote: Compressing objects: 53% (136/256)[K remote: Compressing objects: 54% (139/256)[K remote: Compressing objects: 55% (141/256)[K remote: Compressing objects: 56% (144/256)[K remote: Compressing objects: 57% (146/256)[K remote: Compressing objects: 58% (149/256)[K remote: Compressing objects: 59% (152/256)[K remote: Compressing objects: 60% (154/256)[K remote: Compressing objects: 61% (157/256)[K remote: Compressing objects: 62% (159/256)[K remote: Compressing objects: 63% (162/256)[K remote: Compressing objects: 64% (164/256)[K remote: Compressing objects: 65% (167/256)[K remote: Compressing objects: 66% (169/256)[K remote: Compressing objects: 67% (172/256)[K remote: Compressing objects: 68% (175/256)[K remote: Compressing objects: 69% (177/256)[K remote: Compressing objects: 70% (180/256)[K remote: Compressing objects: 71% (182/256)[K remote: Compressing objects: 72% (185/256)[K remote: Compressing objects: 73% (187/256)[K remote: Compressing objects: 74% (190/256)[K remote: Compressing objects: 75% (192/256)[K remote: Compressing objects: 76% (195/256)[K remote: Compressing objects: 77% (198/256)[K remote: Compressing objects: 78% (200/256)[K remote: Compressing objects: 79% (203/256)[K remote: Compressing objects: 80% (205/256)[K remote: Compressing objects: 81% (208/256)[K remote: Compressing objects: 82% (210/256)[K remote: Compressing objects: 83% (213/256)[K remote: Compressing objects: 84% (216/256)[K remote: Compressing objects: 85% (218/256)[K remote: Compressing objects: 86% (221/256)[K remote: Compressing objects: 87% (223/256)[K remote: Compressing objects: 88% (226/256)[K remote: Compressing objects: 89% (228/256)[K remote: Compressing objects: 90% (231/256)[K remote: Compressing objects: 91% (233/256)[K remote: Compressing objects: 92% (236/256)[K remote: Compressing objects: 93% (239/256)[K remote: Compressing objects: 94% (241/256)[K remote: Compressing objects: 95% (244/256)[K remote: Compressing objects: 96% (246/256)[K remote: Compressing objects: 97% (249/256)[K remote: Compressing objects: 98% (251/256)[K remote: Compressing objects: 99% (254/256)[K remote: Compressing objects: 100% (256/256)[K remote: Compressing objects: 100% (256/256), done.[K Receiving objects: 0% (1/496) Receiving objects: 1% (5/496) Receiving objects: 2% (10/496) Receiving objects: 3% (15/496) Receiving objects: 4% (20/496) Receiving objects: 5% (25/496) Receiving objects: 6% (30/496) Receiving objects: 7% (35/496) Receiving objects: 8% (40/496) Receiving objects: 9% (45/496) Receiving objects: 10% (50/496) Receiving objects: 11% (55/496) Receiving objects: 12% (60/496) Receiving objects: 13% (65/496) Receiving objects: 14% (70/496) Receiving objects: 15% (75/496) Receiving objects: 16% (80/496) Receiving objects: 17% (85/496) Receiving objects: 18% (90/496) Receiving objects: 19% (95/496) Receiving objects: 20% (100/496) Receiving objects: 21% (105/496) Receiving objects: 22% (110/496) Receiving objects: 23% (115/496) Receiving objects: 24% (120/496) Receiving objects: 25% (124/496) Receiving objects: 26% (129/496) Receiving objects: 27% (134/496) Receiving objects: 28% (139/496) Receiving objects: 29% (144/496) Receiving objects: 30% (149/496) Receiving objects: 31% (154/496) Receiving objects: 32% (159/496) Receiving objects: 33% (164/496) Receiving objects: 34% (169/496) Receiving objects: 35% (174/496) Receiving objects: 36% (179/496) Receiving objects: 37% (184/496) Receiving objects: 38% (189/496) Receiving objects: 39% (194/496) Receiving objects: 40% (199/496) Receiving objects: 41% (204/496) Receiving objects: 42% (209/496) Receiving objects: 43% (214/496) Receiving objects: 44% (219/496) Receiving objects: 45% (224/496) Receiving objects: 46% (229/496) Receiving objects: 47% (234/496) Receiving objects: 48% (239/496) Receiving objects: 49% (244/496) Receiving objects: 50% (248/496) Receiving objects: 51% (253/496) Receiving objects: 52% (258/496) Receiving objects: 53% (263/496) Receiving objects: 54% (268/496) Receiving objects: 55% (273/496) Receiving objects: 56% (278/496) Receiving objects: 57% (283/496) Receiving objects: 58% (288/496) Receiving objects: 59% (293/496) Receiving objects: 60% (298/496) Receiving objects: 61% (303/496) Receiving objects: 62% (308/496) Receiving objects: 63% (313/496) Receiving objects: 64% (318/496) Receiving objects: 65% (323/496) Receiving objects: 66% (328/496) Receiving objects: 67% (333/496) Receiving objects: 68% (338/496) Receiving objects: 69% (343/496) Receiving objects: 70% (348/496) Receiving objects: 71% (353/496) Receiving objects: 72% (358/496) Receiving objects: 73% (363/496) Receiving objects: 74% (368/496) Receiving objects: 75% (372/496) Receiving objects: 76% (377/496) Receiving objects: 77% (382/496) Receiving objects: 78% (387/496) Receiving objects: 79% (392/496) Receiving objects: 80% (397/496) Receiving objects: 81% (402/496) Receiving objects: 82% (407/496) Receiving objects: 83% (412/496) Receiving objects: 84% (417/496) Receiving objects: 85% (422/496) Receiving objects: 86% (427/496) Receiving objects: 87% (432/496) Receiving objects: 88% (437/496) Receiving objects: 89% (442/496) Receiving objects: 90% (447/496) Receiving objects: 91% (452/496) Receiving objects: 92% (457/496) Receiving objects: 93% (462/496) Receiving objects: 94% (467/496) Receiving objects: 95% (472/496) remote: Total 496 (delta 247), reused 454 (delta 212), pack-reused 0[K Receiving objects: 96% (477/496) Receiving objects: 97% (482/496) Receiving objects: 98% (487/496) Receiving objects: 99% (492/496) Receiving objects: 100% (496/496) Receiving objects: 100% (496/496), 68.65 KiB | 2.37 MiB/s, done. Resolving deltas: 0% (0/247) Resolving deltas: 1% (3/247) Resolving deltas: 2% (5/247) Resolving deltas: 3% (8/247) Resolving deltas: 4% (10/247) Resolving deltas: 5% (13/247) Resolving deltas: 6% (15/247) Resolving deltas: 7% (18/247) Resolving deltas: 8% (20/247) Resolving deltas: 9% (23/247) Resolving deltas: 10% (25/247) Resolving deltas: 11% (28/247) Resolving deltas: 12% (30/247) Resolving deltas: 13% (33/247) Resolving deltas: 14% (35/247) Resolving deltas: 15% (38/247) Resolving deltas: 16% (40/247) Resolving deltas: 17% (42/247) Resolving deltas: 18% (45/247) Resolving deltas: 19% (47/247) Resolving deltas: 20% (50/247) Resolving deltas: 21% (52/247) Resolving deltas: 22% (55/247) Resolving deltas: 23% (57/247) Resolving deltas: 24% (60/247) Resolving deltas: 25% (62/247) Resolving deltas: 26% (65/247) Resolving deltas: 27% (67/247) Resolving deltas: 28% (70/247) Resolving deltas: 29% (72/247) Resolving deltas: 30% (75/247) Resolving deltas: 31% (77/247) Resolving deltas: 32% (80/247) Resolving deltas: 33% (82/247) Resolving deltas: 34% (84/247) Resolving deltas: 35% (87/247) Resolving deltas: 36% (89/247) Resolving deltas: 37% (92/247) Resolving deltas: 38% (94/247) Resolving deltas: 39% (97/247) Resolving deltas: 40% (99/247) Resolving deltas: 41% (102/247) Resolving deltas: 42% (104/247) Resolving deltas: 43% (107/247) Resolving deltas: 44% (109/247) Resolving deltas: 45% (112/247) Resolving deltas: 46% (114/247) Resolving deltas: 47% (117/247) Resolving deltas: 48% (119/247) Resolving deltas: 49% (122/247) Resolving deltas: 50% (124/247) Resolving deltas: 51% (126/247) Resolving deltas: 52% (129/247) Resolving deltas: 53% (131/247) Resolving deltas: 54% (134/247) Resolving deltas: 55% (136/247) Resolving deltas: 56% (139/247) Resolving deltas: 57% (141/247) Resolving deltas: 58% (144/247) Resolving deltas: 59% (146/247) Resolving deltas: 60% (149/247) Resolving deltas: 61% (151/247) Resolving deltas: 62% (154/247) Resolving deltas: 63% (156/247) Resolving deltas: 64% (159/247) Resolving deltas: 65% (161/247) Resolving deltas: 66% (164/247) Resolving deltas: 67% (166/247) Resolving deltas: 68% (168/247) Resolving deltas: 69% (171/247) Resolving deltas: 70% (173/247) Resolving deltas: 71% (176/247) Resolving deltas: 72% (178/247) Resolving deltas: 73% (181/247) Resolving deltas: 74% (183/247) Resolving deltas: 75% (186/247) Resolving deltas: 76% (188/247) Resolving deltas: 77% (191/247) Resolving deltas: 78% (193/247) Resolving deltas: 79% (196/247) Resolving deltas: 80% (198/247) Resolving deltas: 81% (201/247) Resolving deltas: 82% (203/247) Resolving deltas: 83% (206/247) Resolving deltas: 84% (208/247) Resolving deltas: 85% (210/247) Resolving deltas: 86% (213/247) Resolving deltas: 87% (215/247) Resolving deltas: 88% (218/247) Resolving deltas: 89% (220/247) Resolving deltas: 90% (223/247) Resolving deltas: 91% (225/247) Resolving deltas: 92% (228/247) Resolving deltas: 93% (230/247) Resolving deltas: 94% (233/247) Resolving deltas: 95% (235/247) Resolving deltas: 96% (238/247) Resolving deltas: 97% (240/247) Resolving deltas: 98% (243/247) Resolving deltas: 99% (245/247) Resolving deltas: 100% (247/247) Resolving deltas: 100% (247/247), done. travis_time:end:17f8aec8:start=1709113909687261870,finish=1709113910134721556,duration=447459686,event=checkout [0K$ cd travis-ci/marginalia $ git checkout -qf 353aa6c8714d497350888d092220b2cac6d6e9d8 travis_fold:end:git.checkout [0K travis_time:end:17f8aec8:start=1709113909687261870,finish=1709113910140637863,duration=453375993,event=checkout [0Ktravis_time:start:1c2e54c4 [0K [33;1mSetting environment variables from .travis.yml[0m $ export MARGINALIA_DB_PORT=5432 $ export MARGINALIA_LOG_FILE=/var/log/postgresql/postgresql-11-main.log travis_time:end:1c2e54c4:start=1709113910143826499,finish=1709113910150501764,duration=6675265,event=env [0Ktravis_fold:start:rvm [0Ktravis_time:start:02056f30 [0K$ rvm get head Downloading https://get.rvm.io [32mDownloading https://raw.githubusercontent.com/rvm/rvm/master/binscripts/rvm-installer.asc[0m [0m[32mVerifying /home/travis/.rvm/archives/rvm-installer.asc[0m [0mgpg: Signature made Tue 21 Feb 2023 11:35:16 PM UTC gpg: using RSA key 7D2BAF1CF37B13E2069D6956105BD0E739499BDB gpg: Good signature from "Piotr Kuczynski <piotr.kuczynski@gmail.com>" [unknown] gpg: WARNING: This key is not certified with a trusted signature! gpg: There is no indication that the signature belongs to the owner. Primary key fingerprint: 7D2B AF1C F37B 13E2 069D 6956 105B D0E7 3949 9BDB [32mGPG verified '/home/travis/.rvm/archives/rvm-installer'[0m [0mDownloading https://github.com/rvm/rvm/archive/master.tar.gz [32mUpgrading the RVM installation in /home/travis/.rvm/[0m [0m RVM PATH line found in /home/travis/.mkshrc /home/travis/.profile /home/travis/.zshrc. [33m RVM PATH line not found for Bash, rerun this command with '--auto-dotfiles' flag to fix it.[0m [0m RVM sourcing line found in /home/travis/.profile /home/travis/.bashrc /home/travis/.zlogin. [32mUpgrade of RVM in /home/travis/.rvm/ is complete.[0m [0m [32m[33mThanks for installing RVM ðŸ™[0m Please consider donating to our open collective to help us maintain RVM. 👉 Donate: [34mhttps://opencollective.com/rvm/donate[0m [0m [0m[32mRVM reloaded![0m [0mtravis_time:end:02056f30:start=1709113910158728072,finish=1709113912819254441,duration=2660526369,event= [0Ktravis_time:start:0014023d [0K$ rvm use 3.2.2 --install --binary --fuzzy curl: (22) The requested URL returned error: 404 [33mRequired ruby-3.2.2 is not installed - installing.[0m [0mcurl: (22) The requested URL returned error: 404 Searching for binary rubies, this might take some time. Found remote file https://rubies.travis-ci.org/ubuntu/18.04/x86_64/ruby-3.2.2.tar.bz2 Checking requirements for ubuntu. Requirements installation successful. ruby-3.2.2 - #configure ruby-3.2.2 - #download % Total % Received % Xferd Average Speed Time Time Time Current Dload Upload Total Spent Left Speed 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0 0 0 0 0 0 0 0 0 --:--:-- 0:00:01 --:--:-- 0 0 0 0 0 0 0 0 0 --:--:-- 0:00:01 --:--:-- 0 0 29.2M 0 270k 0 0 197k 0 0:02:31 0:00:01 0:02:30 197k 100 29.2M 100 29.2M 0 0 15.8M 0 0:00:01 0:00:01 --:--:-- 61.6M [33mNo checksum for downloaded archive, recording checksum in user configuration.[0m [0mruby-3.2.2 - #validate archive ruby-3.2.2 - #extract ruby-3.2.2 - #validate binary ruby-3.2.2 - #setup ruby-3.2.2 - #gemset created /home/travis/.rvm/gems/ruby-3.2.2@global [32mruby-3.2.2 - #importing gemset /home/travis/.rvm/gemsets/global.gems[0m|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.. [32mruby-3.2.2 - #generating global wrappers[0m|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/. [32mruby-3.2.2 - #uninstalling gem rubygems-bundler-1.4.5[0m|/. ruby-3.2.2 - #gemset created /home/travis/.rvm/gems/ruby-3.2.2 [32mruby-3.2.2 - #importing gemset /home/travis/.rvm/gemsets/default.gems[0m|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\. [32mruby-3.2.2 - #generating default wrappers[0m|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-\|/-.|/-\|/-\|.-\|/-. Using /home/travis/.rvm/gems/ruby-3.2.2 travis_time:end:0014023d:start=1709113912823583825,finish=1709113932952123333,duration=20128539508,event= [0Ktravis_fold:end:rvm [0K $ export BUNDLE_GEMFILE=$PWD/Gemfile travis_fold:start:ruby.versions [0K$ ruby --version ruby 3.2.2 (2023-03-30 revision e51014f9c0) [x86_64-linux] $ rvm --version rvm 1.29.12-next (master) by Michal Papis, Piotr Kuczynski, Wayne E. Seguin [https://rvm.io] $ bundle --version Bundler version 2.4.10 $ gem --version 3.4.10 travis_fold:end:ruby.versions [0K travis_fold:start:before_install [0Ktravis_time:start:08623422 [0K$ bash -c "yes | gem uninstall -i /home/travis/.rvm/gems/ruby-3.2.0@global rake" Gem 'rake' is not installed travis_time:end:08623422:start=1709113933387440890,finish=1709113933554206229,duration=166765339,event=before_install [0Ktravis_fold:end:before_install [0Ktravis_fold:start:install.bundler [0Ktravis_time:start:04be1949 [0K$ bundle install --jobs=3 --retry=3 Fetching gem metadata from https://rubygems.org/....... Resolving dependencies... [32mFetching rake 13.1.0[0m [32mInstalling rake 13.1.0[0m [32mFetching concurrent-ruby 1.2.3[0m [32mFetching base64 0.2.0[0m [32mFetching bigdecimal 3.1.6[0m [32mInstalling base64 0.2.0[0m [32mFetching connection_pool 2.4.1[0m [32mInstalling bigdecimal 3.1.6 with native extensions[0m [32mInstalling concurrent-ruby 1.2.3[0m [32mInstalling connection_pool 2.4.1[0m Using ruby2_keywords 0.0.5 [32mFetching minitest 5.18.1[0m [32mFetching mutex_m 0.2.0[0m [32mInstalling minitest 5.18.1[0m [32mInstalling mutex_m 0.2.0[0m [32mFetching timeout 0.4.1[0m Using bundler 2.4.10 [32mFetching pg 1.5.5[0m [32mInstalling timeout 0.4.1[0m Using power_assert 2.0.3 [32mFetching drb 2.2.0[0m [32mInstalling pg 1.5.5 with native extensions[0m [32mInstalling drb 2.2.0[0m [32mFetching mocha 2.1.0[0m [32mInstalling mocha 2.1.0[0m [32mFetching i18n 1.14.1[0m [32mInstalling i18n 1.14.1[0m [32mFetching tzinfo 2.0.6[0m [32mInstalling tzinfo 2.0.6[0m [32mFetching test-unit 3.6.2[0m [32mInstalling test-unit 3.6.2[0m [32mFetching activesupport 7.1.3.2[0m [32mFetching sequel 5.77.0[0m [32mInstalling activesupport 7.1.3.2[0m [32mInstalling sequel 5.77.0[0m [32mFetching activemodel 7.1.3.2[0m [32mInstalling activemodel 7.1.3.2[0m [32mFetching activerecord 7.1.3.2[0m [32mInstalling activerecord 7.1.3.2[0m Using marginalia 1.5.0 from source at `.` [32mBundle complete! 7 Gemfile dependencies, 22 gems now installed.[0m [32mUse `bundle info [gemname]` to see where a bundled gem is installed.[0m travis_time:end:04be1949:start=1709113933559647322,finish=1709113950078433010,duration=16518785688,event=install [0Ktravis_fold:end:install.bundler [0K travis_fold:start:before_script [0Ktravis_time:start:02ded761 [0K$ sudo chmod 0644 $MARGINALIA_LOG_FILE travis_time:end:02ded761:start=1709113950084118930,finish=1709113950094208655,duration=10089725,event=before_script [0Ktravis_fold:end:before_script [0Ktravis_time:start:33d904f0 [0K$ bundle exec rake db:reset test:postgresql set -e; for file in $(find test -type f -name '*_test.rb'); do MARGINALIA_LOG_FILE=/var/log/postgresql/postgresql-11-main.log MARGINALIA_DB_PORT=5432 ruby -Ilib -Itest $file; done Run options: --seed 55677 # Running: ...... Finished in 0.006071s, 988.3508 runs/s, 1317.8011 assertions/s. 6 runs, 8 assertions, 0 failures, 0 errors, 0 skips Run options: --seed 46033 # Running: .. Finished in 0.002005s, 997.6889 runs/s, 1496.5333 assertions/s. 2 runs, 3 assertions, 0 failures, 0 errors, 0 skips -- create_table("posts", {:force=>true}) -> 0.0073s Run options: --seed 10447 # Running: . Finished in 0.019897s, 50.2591 runs/s, 150.7773 assertions/s. 1 runs, 3 assertions, 0 failures, 0 errors, 0 skips Run options: --seed 56852 # Running: .. Finished in 0.006196s, 322.7948 runs/s, 645.5896 assertions/s. 2 runs, 4 assertions, 0 failures, 0 errors, 0 skips travis_time:end:33d904f0:start=1709113950099591966,finish=1709113952559660100,duration=2460068134,event=script [0K[32;1mThe command "bundle exec rake db:reset test:postgresql" exited with 0.[0m Done. Your build exited with 0.