travis_fold:start:worker_info Worker information hostname: 57461d45-d579-403a-85bd-2f75dcaad31b@1.worker-n2-com-779d777f7b-nfhng.gce-production-1 version: 6.2.22 https://github.com/travis-ci/worker/tree/858cb91994a513269f2fe9782c15fc113e966231 instance: travis-job-e9e956a9-9e34-45b8-b85a-f23806865338 travis-ci-ubuntu-2004-1707238145-6d1d1b02 (via amqp) startup: 6.195044305s travis_fold:end:worker_info travis_time:start:0e7b8b86 travis_time:end:0e7b8b86:start=1709052868810646857,finish=1709052869160624132,duration=349977275,event=no_world_writable_dirs travis_time:start:186af6f2 travis_time:end:186af6f2:start=1709052869163824416,finish=1709052869172063854,duration=8239438,event=agent travis_time:start:09f1242c travis_time:end:09f1242c:start=1709052869174675065,finish=1709052869176663769,duration=1988704,event=check_unsupported travis_time:start:0233a068 travis_fold:start:system_info Build system information Build language: ruby Build dist: focal Build id: 269148893 Job id: 618400328 Runtime kernel version: 5.15.0-1049-gcp travis-build version: f3de9fb7 Build image provisioning date and time Tue 06 Feb 2024 05:15:48 PM UTC Operating System Details Distributor ID: Ubuntu Description: Ubuntu 20.04.6 LTS Release: 20.04 Codename: focal Systemd Version systemd 245 (245.4-4ubuntu3.23) Cookbooks Version 4a0cff6 https://github.com/travis-ci/travis-cookbooks/tree/4a0cff6 git version git version 2.43.0 bash version GNU bash, version 5.0.17(1)-release (x86_64-pc-linux-gnu) gcc version gcc (Ubuntu 9.4.0-1ubuntu1~20.04.2) 9.4.0 docker version Client: Version: 24.0.5 API version: 1.43 Go version: go1.20.3 Git commit: 24.0.5-0ubuntu1~20.04.1 Built: Mon Aug 21 19:50:14 2023 OS/Arch: linux/amd64 Context: default Server: Engine: Version: 24.0.5 API version: 1.43 (minimum version 1.12) Go version: go1.20.3 Git commit: 24.0.5-0ubuntu1~20.04.1 Built: Mon Aug 21 19:50:14 2023 OS/Arch: linux/amd64 Experimental: false containerd: Version: 1.7.2 GitCommit: runc: Version: 1.1.7-0ubuntu1~20.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.7.7 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.10-23 Q16 x86_64 20190101 https://imagemagick.org md5deep version 4.4 mercurial version version 6.5.2 mysql version mysql Ver 8.0.36-0ubuntu0.20.04.1 for Linux on x86_64 ((Ubuntu)) openssl version OpenSSL 1.1.1f 31 Mar 2020 packer version 1.9.4 postgresql client version psql (PostgreSQL) 13.13 (Ubuntu 13.13-1.pgdg20.04+1) ragel version Ragel State Machine Compiler version 6.10 March 2017 sudo version 1.8.31 gzip version gzip 1.10 zip version Zip 3.0 vim version VIM - Vi IMproved 8.1 (2018 May 18, compiled Dec 07 2023 15:42:49) iptables version iptables v1.8.4 (legacy) curl version curl 7.68.0 (x86_64-pc-linux-gnu) libcurl/7.68.0 OpenSSL/1.1.1f zlib/1.2.11 brotli/1.0.7 libidn2/2.2.0 libpsl/0.21.0 (+libidn2/2.2.0) libssh/0.9.3/openssl/zlib nghttp2/1.40.0 librtmp/2.3 wget version GNU Wget 1.20.3 built on linux-gnu. rsync version rsync version 3.1.3 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 99.0 MongoDB version MongoDB 4.4.28 PhantomJS version 2.1.1 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.20.2 v18.19.0 v18.4.0 v20.11.0 v4.9.1 v6.17.1 v8.17.0 phpenv versions system 7.4 * 7.4.6 (set by /home/travis/.phpenv/version) hhvm-stable hhvm composer --version Composer version 1.10.6 2020-05-06 10:28:10 Pre-installed Ruby versions ruby-2.5.9 ruby-2.7.6 ruby-3.1.2 travis_fold:end:system_info  travis_time:end:0233a068:start=1709052869179211546,finish=1709052869188245551,duration=9034005,event=show_system_info travis_time:start:01708136 travis_time:end:01708136:start=1709052869192170353,finish=1709052869219902650,duration=27732297,event=rm_riak_source travis_time:start:3389903a travis_time:end:3389903a:start=1709052869223271086,finish=1709052869230147943,duration=6876857,event=fix_rwky_redis travis_time:start:1a15081e travis_time:end:1a15081e:start=1709052869233742890,finish=1709052869956475746,duration=722732856,event=wait_for_network travis_time:start:00df198e travis_time:end:00df198e:start=1709052869959861891,finish=1709052870289476287,duration=329614396,event=update_apt_keys travis_time:start:024cbade travis_time:end:024cbade:start=1709052870292737806,finish=1709052870354316283,duration=61578477,event=fix_hhvm_source travis_time:start:00396498 travis_time:end:00396498:start=1709052870357651295,finish=1709052870371296080,duration=13644785,event=update_mongo_arch travis_time:start:05cadb90 travis_time:end:05cadb90:start=1709052870374449603,finish=1709052870415181466,duration=40731863,event=fix_sudo_enabled_trusty travis_time:start:19ec94cd travis_time:end:19ec94cd:start=1709052870418493293,finish=1709052870420916292,duration=2422999,event=update_glibc travis_time:start:05582cd4 travis_time:end:05582cd4:start=1709052870423972190,finish=1709052870433383409,duration=9411219,event=clean_up_path travis_time:start:13d4d5c0 travis_time:end:13d4d5c0:start=1709052870436516055,finish=1709052870450254694,duration=13738639,event=fix_resolv_conf travis_time:start:0b93b66c travis_time:end:0b93b66c:start=1709052870453426315,finish=1709052870483856355,duration=30430040,event=fix_etc_hosts travis_time:start:00ff6cc0 travis_time:end:00ff6cc0:start=1709052870487125071,finish=1709052870495150806,duration=8025735,event=fix_mvn_settings_xml travis_time:start:1e09f027 travis_time:end:1e09f027:start=1709052870498182358,finish=1709052870509209957,duration=11027599,event=no_ipv6_localhost travis_time:start:09b939e0 travis_time:end:09b939e0:start=1709052870512239577,finish=1709052870514432198,duration=2192621,event=fix_etc_mavenrc travis_time:start:012f35d3 OK travis_time:end:012f35d3:start=1709052870517393398,finish=1709052870910873373,duration=393479975,event=fix_perforce_key travis_time:start:04df494b travis_time:end:04df494b:start=1709052870914078383,finish=1709052870917146962,duration=3068579,event=fix_wwdr_certificate travis_time:start:01cbb1c0 travis_time:end:01cbb1c0:start=1709052870920294298,finish=1709052870977305033,duration=57010735,event=put_localhost_first travis_time:start:0792b628 travis_time:end:0792b628:start=1709052870980424056,finish=1709052870983558017,duration=3133961,event=home_paths travis_time:start:02ea05ae travis_time:end:02ea05ae:start=1709052870986892615,finish=1709052871002310372,duration=15417757,event=disable_initramfs travis_time:start:06fe1324 travis_time:end:06fe1324:start=1709052871005530086,finish=1709052871175846649,duration=170316563,event=disable_ssh_roaming travis_time:start:23377cb7 travis_time:end:23377cb7:start=1709052871179247392,finish=1709052871181671217,duration=2423825,event=debug_tools travis_time:start:28736758 travis_time:end:28736758:start=1709052871184928447,finish=1709052871188308152,duration=3379705,event=uninstall_oclint travis_time:start:01cfc008 travis_time:end:01cfc008:start=1709052871191542423,finish=1709052871194782768,duration=3240345,event=rvm_use travis_time:start:0a25ad74 travis_time:end:0a25ad74:start=1709052871198026788,finish=1709052871207586966,duration=9560178,event=rm_etc_boto_cfg travis_time:start:00411257 travis_time:end:00411257:start=1709052871210914707,finish=1709052871213385486,duration=2470779,event=rm_oraclejdk8_symlink travis_time:start:006c0a40 travis_time:end:006c0a40:start=1709052871216615007,finish=1709052871316373149,duration=99758142,event=enable_i386 travis_time:start:0b6ce242 travis_time:end:0b6ce242:start=1709052871319722102,finish=1709052871323986635,duration=4264533,event=update_rubygems travis_time:start:17917e48 travis_time:end:17917e48:start=1709052871327167391,finish=1709052872336811662,duration=1009644271,event=ensure_path_components travis_time:start:15fdca04 travis_time:end:15fdca04:start=1709052872340463881,finish=1709052872342869879,duration=2405998,event=redefine_curl travis_time:start:1c2ed1a8 travis_time:end:1c2ed1a8:start=1709052872346113432,finish=1709052872348463141,duration=2349709,event=nonblock_pipe travis_time:start:000856d4 travis_time:end:000856d4:start=1709052872351610581,finish=1709052878403874374,duration=6052263793,event=apt_get_update travis_time:start:05cedca6 travis_time:end:05cedca6:start=1709052878407008008,finish=1709052878409107042,duration=2099034,event=deprecate_xcode_64 travis_time:start:15dd5fc2 travis_time:end:15dd5fc2:start=1709052878411994924,finish=1709052882388157499,duration=3976162575,event=update_heroku travis_time:start:0500eda6 travis_time:end:0500eda6:start=1709052882391175342,finish=1709052882393234189,duration=2058847,event=shell_session_update travis_time:start:00228048 travis_fold:start:docker_mtu_and_registry_mirrors travis_fold:end:docker_mtu_and_registry_mirrors travis_time:end:00228048:start=1709052882395950588,finish=1709052884624439992,duration=2228489404,event=set_docker_mtu_and_registry_mirrors travis_time:start:1647cff0 travis_fold:start:resolvconf travis_fold:end:resolvconf travis_time:end:1647cff0:start=1709052884628657814,finish=1709052884690329855,duration=61672041,event=resolvconf travis_time:start:051b461c travis_time:end:051b461c:start=1709052884693862271,finish=1709052884811092724,duration=117230453,event=maven_central_mirror travis_time:start:0a160fea travis_time:end:0a160fea:start=1709052884814133855,finish=1709052884907758554,duration=93624699,event=maven_https travis_fold:start:apt travis_time:start:0005b6f5 $ travis_apt_get_update travis_time:end:0005b6f5:start=1709052884911350255,finish=1709052897399700639,duration=12488350384,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:3816b406 $ 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... The following packages were automatically installed and are no longer required: libjs-jquery-metadata libjs-jquery-tablesorter postgresql-client-12 Use 'sudo apt autoremove' to remove them. Suggested packages: postgresql-doc-11 Recommended packages: sysstat The following NEW packages will be installed: postgresql-11 postgresql-client-11 0 upgraded, 2 newly installed, 0 to remove and 43 not upgraded. Need to get 15.8 MB of archives. After this operation, 54.1 MB of additional disk space will be used. Get:1 http://apt.postgresql.org/pub/repos/apt focal-pgdg/main amd64 postgresql-client-11 amd64 11.22-2.pgdg20.04+1 [1,494 kB] Get:2 http://apt.postgresql.org/pub/repos/apt focal-pgdg/main amd64 postgresql-11 amd64 11.22-2.pgdg20.04+1 [14.3 MB] Fetched 15.8 MB in 2s (8,495 kB/s) Preconfiguring packages ... Selecting previously unselected package postgresql-client-11. (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 198539 files and directories currently installed.) Preparing to unpack .../postgresql-client-11_11.22-2.pgdg20.04+1_amd64.deb ... Unpacking postgresql-client-11 (11.22-2.pgdg20.04+1) ... Selecting previously unselected package postgresql-11. Preparing to unpack .../postgresql-11_11.22-2.pgdg20.04+1_amd64.deb ... Unpacking postgresql-11 (11.22-2.pgdg20.04+1) ... Setting up postgresql-client-11 (11.22-2.pgdg20.04+1) ... Setting up postgresql-11 (11.22-2.pgdg20.04+1) ... Creating new PostgreSQL cluster 11/main ... /usr/lib/postgresql/11/bin/initdb -D /var/lib/postgresql/11/main --auth-local peer --auth-host md5 The files belonging to this database system will be owned by user "postgres". This user must also own the server process. The database cluster will be initialized with locale "en_US.UTF-8". The default database encoding has accordingly been set to "UTF8". The default text search configuration will be set to "english". Data page checksums are disabled. fixing permissions on existing directory /var/lib/postgresql/11/main ... ok creating subdirectories ... ok selecting default max_connections ... 100 selecting default shared_buffers ... 128MB selecting default timezone ... UTC selecting dynamic shared memory implementation ... posix creating configuration files ... ok running bootstrap script ... ok performing post-bootstrap initialization ... ok syncing data to disk ... ok Success. You can now start the database server using: pg_ctlcluster 11 main start Processing triggers for postgresql-common (256.pgdg20.04+1) ... Building PostgreSQL dictionaries from installed myspell/hunspell packages... en_us Removing obsolete dictionary files: travis_time:end:3816b406:start=1709052897420804443,finish=1709052910321070247,duration=12900265804,event=prepare travis_fold:end:apt travis_time:start:0c9b792a travis_fold:start:services travis_fold:end:services travis_time:end:0c9b792a:start=1709052910324344844,finish=1709052913329800194,duration=3005455350,event=services travis_time:start:327258d4 travis_time:end:327258d4:start=1709052913332959473,finish=1709052913335009483,duration=2050010,event=fix_ps4 travis_fold:start:postgresql travis_time:start:09cb7e6c $ travis_setup_postgresql 11 Starting PostgreSQL v11 sudo systemctl start postgresql@11-main travis_time:end:09cb7e6c:start=1709052913337967564,finish=1709052916107584731,duration=2769617167,event=prepare travis_fold:end:postgresql travis_time:start:00f610bc  travis_fold:start:git.checkout travis_time:start:21b7623c travis_time:end:21b7623c:start=1709052916114513556,finish=1709052916120158082,duration=5644526,event=checkout travis_time:start:014de1c0 $ git clone --depth=50 --branch=prd-ruby-upgrade-dev https://github.com/travis-ci/marginalia.git travis-ci/marginalia Cloning into 'travis-ci/marginalia'... remote: Enumerating objects: 606, done. remote: Counting objects: 0% (1/606) remote: Counting objects: 1% (7/606) remote: Counting objects: 2% (13/606) remote: Counting objects: 3% (19/606) remote: Counting objects: 4% (25/606) remote: Counting objects: 5% (31/606) remote: Counting objects: 6% (37/606) remote: Counting objects: 7% (43/606) remote: Counting objects: 8% (49/606) remote: Counting objects: 9% (55/606) remote: Counting objects: 10% (61/606) remote: Counting objects: 11% (67/606) remote: Counting objects: 12% (73/606) remote: Counting objects: 13% (79/606) remote: Counting objects: 14% (85/606) remote: Counting objects: 15% (91/606) remote: Counting objects: 16% (97/606) remote: Counting objects: 17% (104/606) remote: Counting objects: 18% (110/606) remote: Counting objects: 19% (116/606) remote: Counting objects: 20% (122/606) remote: Counting objects: 21% (128/606) remote: Counting objects: 22% (134/606) remote: Counting objects: 23% (140/606) remote: Counting objects: 24% (146/606) remote: Counting objects: 25% (152/606) remote: Counting objects: 26% (158/606) remote: Counting objects: 27% (164/606) remote: Counting objects: 28% (170/606) remote: Counting objects: 29% (176/606) remote: Counting objects: 30% (182/606) remote: Counting objects: 31% (188/606) remote: Counting objects: 32% (194/606) remote: Counting objects: 33% (200/606) remote: Counting objects: 34% (207/606) remote: Counting objects: 35% (213/606) remote: Counting objects: 36% (219/606) remote: Counting objects: 37% (225/606) remote: Counting objects: 38% (231/606) remote: Counting objects: 39% (237/606) remote: Counting objects: 40% (243/606) remote: Counting objects: 41% (249/606) remote: Counting objects: 42% (255/606) remote: Counting objects: 43% (261/606) remote: Counting objects: 44% (267/606) remote: Counting objects: 45% (273/606) remote: Counting objects: 46% (279/606) remote: Counting objects: 47% (285/606) remote: Counting objects: 48% (291/606) remote: Counting objects: 49% (297/606) remote: Counting objects: 50% (303/606) remote: Counting objects: 51% (310/606) remote: Counting objects: 52% (316/606) remote: Counting objects: 53% (322/606) remote: Counting objects: 54% (328/606) remote: Counting objects: 55% (334/606) remote: Counting objects: 56% (340/606) remote: Counting objects: 57% (346/606) remote: Counting objects: 58% (352/606) remote: Counting objects: 59% (358/606) remote: Counting objects: 60% (364/606) remote: Counting objects: 61% (370/606) remote: Counting objects: 62% (376/606) remote: Counting objects: 63% (382/606) remote: Counting objects: 64% (388/606) remote: Counting objects: 65% (394/606) remote: Counting objects: 66% (400/606) remote: Counting objects: 67% (407/606) remote: Counting objects: 68% (413/606) remote: Counting objects: 69% (419/606) remote: Counting objects: 70% (425/606) remote: Counting objects: 71% (431/606) remote: Counting objects: 72% (437/606) remote: Counting objects: 73% (443/606) remote: Counting objects: 74% (449/606) remote: Counting objects: 75% (455/606) remote: Counting objects: 76% (461/606) remote: Counting objects: 77% (467/606) remote: Counting objects: 78% (473/606) remote: Counting objects: 79% (479/606) remote: Counting objects: 80% (485/606) remote: Counting objects: 81% (491/606) remote: Counting objects: 82% (497/606) remote: Counting objects: 83% (503/606) remote: Counting objects: 84% (510/606) remote: Counting objects: 85% (516/606) remote: Counting objects: 86% (522/606) remote: Counting objects: 87% (528/606) remote: Counting objects: 88% (534/606) remote: Counting objects: 89% (540/606) remote: Counting objects: 90% (546/606) remote: Counting objects: 91% (552/606) remote: Counting objects: 92% (558/606) remote: Counting objects: 93% (564/606) remote: Counting objects: 94% (570/606) remote: Counting objects: 95% (576/606) remote: Counting objects: 96% (582/606) remote: Counting objects: 97% (588/606) remote: Counting objects: 98% (594/606) remote: Counting objects: 99% (600/606) remote: Counting objects: 100% (606/606) remote: Counting objects: 100% (606/606), done. remote: Compressing objects: 0% (1/322) remote: Compressing objects: 1% (4/322) remote: Compressing objects: 2% (7/322) remote: Compressing objects: 3% (10/322) remote: Compressing objects: 4% (13/322) remote: Compressing objects: 5% (17/322) remote: Compressing objects: 6% (20/322) remote: Compressing objects: 7% (23/322) remote: Compressing objects: 8% (26/322) remote: Compressing objects: 9% (29/322) remote: Compressing objects: 10% (33/322) remote: Compressing objects: 11% (36/322) remote: Compressing objects: 12% (39/322) remote: Compressing objects: 13% (42/322) remote: Compressing objects: 14% (46/322) remote: Compressing objects: 15% (49/322) remote: Compressing objects: 16% (52/322) remote: Compressing objects: 17% (55/322) remote: Compressing objects: 18% (58/322) remote: Compressing objects: 19% (62/322) remote: Compressing objects: 20% (65/322) remote: Compressing objects: 21% (68/322) remote: Compressing objects: 22% (71/322) remote: Compressing objects: 23% (75/322) remote: Compressing objects: 24% (78/322) remote: Compressing objects: 25% (81/322) remote: Compressing objects: 26% (84/322) remote: Compressing objects: 27% (87/322) remote: Compressing objects: 28% (91/322) remote: Compressing objects: 29% (94/322) remote: Compressing objects: 30% (97/322) remote: Compressing objects: 31% (100/322) remote: Compressing objects: 32% (104/322) remote: Compressing objects: 33% (107/322) remote: Compressing objects: 34% (110/322) remote: Compressing objects: 35% (113/322) remote: Compressing objects: 36% (116/322) remote: Compressing objects: 37% (120/322) remote: Compressing objects: 38% (123/322) remote: Compressing objects: 39% (126/322) remote: Compressing objects: 40% (129/322) remote: Compressing objects: 41% (133/322) remote: Compressing objects: 42% (136/322) remote: Compressing objects: 43% (139/322) remote: Compressing objects: 44% (142/322) remote: Compressing objects: 45% (145/322) remote: Compressing objects: 46% (149/322) remote: Compressing objects: 47% (152/322) remote: Compressing objects: 48% (155/322) remote: Compressing objects: 49% (158/322) remote: Compressing objects: 50% (161/322) remote: Compressing objects: 51% (165/322) remote: Compressing objects: 52% (168/322) remote: Compressing objects: 53% (171/322) remote: Compressing objects: 54% (174/322) remote: Compressing objects: 55% (178/322) remote: Compressing objects: 56% (181/322) remote: Compressing objects: 57% (184/322) remote: Compressing objects: 58% (187/322) remote: Compressing objects: 59% (190/322) remote: Compressing objects: 60% (194/322) remote: Compressing objects: 61% (197/322) remote: Compressing objects: 62% (200/322) remote: Compressing objects: 63% (203/322) remote: Compressing objects: 64% (207/322) remote: Compressing objects: 65% (210/322) remote: Compressing objects: 66% (213/322) remote: Compressing objects: 67% (216/322) remote: Compressing objects: 68% (219/322) remote: Compressing objects: 69% (223/322) remote: Compressing objects: 70% (226/322) remote: Compressing objects: 71% (229/322) remote: Compressing objects: 72% (232/322) remote: Compressing objects: 73% (236/322) remote: Compressing objects: 74% (239/322) remote: Compressing objects: 75% (242/322) remote: Compressing objects: 76% (245/322) remote: Compressing objects: 77% (248/322) remote: Compressing objects: 78% (252/322) remote: Compressing objects: 79% (255/322) remote: Compressing objects: 80% (258/322) remote: Compressing objects: 81% (261/322) remote: Compressing objects: 82% (265/322) remote: Compressing objects: 83% (268/322) remote: Compressing objects: 84% (271/322) remote: Compressing objects: 85% (274/322) remote: Compressing objects: 86% (277/322) remote: Compressing objects: 87% (281/322) remote: Compressing objects: 88% (284/322) remote: Compressing objects: 89% (287/322) remote: Compressing objects: 90% (290/322) remote: Compressing objects: 91% (294/322) remote: Compressing objects: 92% (297/322) remote: Compressing objects: 93% (300/322) remote: Compressing objects: 94% (303/322) remote: Compressing objects: 95% (306/322) remote: Compressing objects: 96% (310/322) remote: Compressing objects: 97% (313/322) remote: Compressing objects: 98% (316/322) remote: Compressing objects: 99% (319/322) remote: Compressing objects: 100% (322/322) remote: Compressing objects: 100% (322/322), done. Receiving objects: 0% (1/606) Receiving objects: 1% (7/606) Receiving objects: 2% (13/606) Receiving objects: 3% (19/606) Receiving objects: 4% (25/606) Receiving objects: 5% (31/606) Receiving objects: 6% (37/606) Receiving objects: 7% (43/606) Receiving objects: 8% (49/606) Receiving objects: 9% (55/606) Receiving objects: 10% (61/606) Receiving objects: 11% (67/606) Receiving objects: 12% (73/606) Receiving objects: 13% (79/606) Receiving objects: 14% (85/606) Receiving objects: 15% (91/606) Receiving objects: 16% (97/606) Receiving objects: 17% (104/606) Receiving objects: 18% (110/606) Receiving objects: 19% (116/606) Receiving objects: 20% (122/606) Receiving objects: 21% (128/606) Receiving objects: 22% (134/606) Receiving objects: 23% (140/606) Receiving objects: 24% (146/606) Receiving objects: 25% (152/606) Receiving objects: 26% (158/606) Receiving objects: 27% (164/606) Receiving objects: 28% (170/606) Receiving objects: 29% (176/606) Receiving objects: 30% (182/606) Receiving objects: 31% (188/606) Receiving objects: 32% (194/606) Receiving objects: 33% (200/606) Receiving objects: 34% (207/606) Receiving objects: 35% (213/606) Receiving objects: 36% (219/606) Receiving objects: 37% (225/606) Receiving objects: 38% (231/606) Receiving objects: 39% (237/606) Receiving objects: 40% (243/606) Receiving objects: 41% (249/606) Receiving objects: 42% (255/606) Receiving objects: 43% (261/606) Receiving objects: 44% (267/606) Receiving objects: 45% (273/606) Receiving objects: 46% (279/606) Receiving objects: 47% (285/606) Receiving objects: 48% (291/606) Receiving objects: 49% (297/606) Receiving objects: 50% (303/606) Receiving objects: 51% (310/606) Receiving objects: 52% (316/606) Receiving objects: 53% (322/606) Receiving objects: 54% (328/606) Receiving objects: 55% (334/606) Receiving objects: 56% (340/606) Receiving objects: 57% (346/606) Receiving objects: 58% (352/606) Receiving objects: 59% (358/606) Receiving objects: 60% (364/606) Receiving objects: 61% (370/606) Receiving objects: 62% (376/606) Receiving objects: 63% (382/606) Receiving objects: 64% (388/606) Receiving objects: 65% (394/606) Receiving objects: 66% (400/606) Receiving objects: 67% (407/606) Receiving objects: 68% (413/606) Receiving objects: 69% (419/606) Receiving objects: 70% (425/606) Receiving objects: 71% (431/606) Receiving objects: 72% (437/606) Receiving objects: 73% (443/606) Receiving objects: 74% (449/606) Receiving objects: 75% (455/606) Receiving objects: 76% (461/606) Receiving objects: 77% (467/606) Receiving objects: 78% (473/606) Receiving objects: 79% (479/606) Receiving objects: 80% (485/606) Receiving objects: 81% (491/606) Receiving objects: 82% (497/606) Receiving objects: 83% (503/606) Receiving objects: 84% (510/606) Receiving objects: 85% (516/606) Receiving objects: 86% (522/606) Receiving objects: 87% (528/606) Receiving objects: 88% (534/606) Receiving objects: 89% (540/606) Receiving objects: 90% (546/606) remote: Total 606 (delta 300), reused 559 (delta 258), pack-reused 0 Receiving objects: 91% (552/606) Receiving objects: 92% (558/606) Receiving objects: 93% (564/606) Receiving objects: 94% (570/606) Receiving objects: 95% (576/606) Receiving objects: 96% (582/606) Receiving objects: 97% (588/606) Receiving objects: 98% (594/606) Receiving objects: 99% (600/606) Receiving objects: 100% (606/606) Receiving objects: 100% (606/606), 87.52 KiB | 2.19 MiB/s, done. Resolving deltas: 0% (0/300) Resolving deltas: 1% (3/300) Resolving deltas: 2% (6/300) Resolving deltas: 3% (9/300) Resolving deltas: 4% (12/300) Resolving deltas: 5% (15/300) Resolving deltas: 6% (18/300) Resolving deltas: 7% (21/300) Resolving deltas: 8% (24/300) Resolving deltas: 9% (27/300) Resolving deltas: 10% (30/300) Resolving deltas: 11% (33/300) Resolving deltas: 12% (36/300) Resolving deltas: 13% (39/300) Resolving deltas: 14% (42/300) Resolving deltas: 15% (45/300) Resolving deltas: 16% (48/300) Resolving deltas: 17% (51/300) Resolving deltas: 18% (54/300) Resolving deltas: 19% (57/300) Resolving deltas: 20% (60/300) Resolving deltas: 21% (63/300) Resolving deltas: 22% (66/300) Resolving deltas: 23% (69/300) Resolving deltas: 24% (72/300) Resolving deltas: 25% (75/300) Resolving deltas: 26% (78/300) Resolving deltas: 27% (81/300) Resolving deltas: 28% (84/300) Resolving deltas: 29% (87/300) Resolving deltas: 30% (90/300) Resolving deltas: 31% (93/300) Resolving deltas: 32% (96/300) Resolving deltas: 33% (99/300) Resolving deltas: 34% (102/300) Resolving deltas: 35% (105/300) Resolving deltas: 36% (108/300) Resolving deltas: 37% (111/300) Resolving deltas: 38% (114/300) Resolving deltas: 39% (117/300) Resolving deltas: 40% (120/300) Resolving deltas: 41% (123/300) Resolving deltas: 42% (126/300) Resolving deltas: 43% (129/300) Resolving deltas: 44% (132/300) Resolving deltas: 45% (135/300) Resolving deltas: 46% (138/300) Resolving deltas: 47% (141/300) Resolving deltas: 48% (144/300) Resolving deltas: 49% (147/300) Resolving deltas: 50% (150/300) Resolving deltas: 51% (153/300) Resolving deltas: 52% (156/300) Resolving deltas: 53% (159/300) Resolving deltas: 54% (162/300) Resolving deltas: 55% (165/300) Resolving deltas: 56% (168/300) Resolving deltas: 57% (171/300) Resolving deltas: 58% (174/300) Resolving deltas: 59% (177/300) Resolving deltas: 60% (180/300) Resolving deltas: 61% (183/300) Resolving deltas: 62% (186/300) Resolving deltas: 63% (189/300) Resolving deltas: 64% (192/300) Resolving deltas: 65% (195/300) Resolving deltas: 66% (198/300) Resolving deltas: 67% (201/300) Resolving deltas: 68% (204/300) Resolving deltas: 69% (207/300) Resolving deltas: 70% (210/300) Resolving deltas: 71% (213/300) Resolving deltas: 72% (216/300) Resolving deltas: 73% (219/300) Resolving deltas: 74% (222/300) Resolving deltas: 75% (225/300) Resolving deltas: 76% (228/300) Resolving deltas: 77% (231/300) Resolving deltas: 78% (234/300) Resolving deltas: 79% (237/300) Resolving deltas: 80% (240/300) Resolving deltas: 81% (243/300) Resolving deltas: 82% (246/300) Resolving deltas: 83% (249/300) Resolving deltas: 84% (252/300) Resolving deltas: 85% (255/300) Resolving deltas: 86% (258/300) Resolving deltas: 87% (261/300) Resolving deltas: 88% (264/300) Resolving deltas: 89% (267/300) Resolving deltas: 90% (270/300) Resolving deltas: 91% (273/300) Resolving deltas: 92% (276/300) Resolving deltas: 93% (279/300) Resolving deltas: 94% (282/300) Resolving deltas: 95% (285/300) Resolving deltas: 96% (288/300) Resolving deltas: 97% (291/300) Resolving deltas: 98% (294/300) Resolving deltas: 99% (297/300) Resolving deltas: 100% (300/300) Resolving deltas: 100% (300/300), done. travis_time:end:014de1c0:start=1709052916123537531,finish=1709052916625607465,duration=502069934,event=checkout $ cd travis-ci/marginalia $ git checkout -qf af24f2a6d2c5da19626bfc469194aecf058e7b3f travis_fold:end:git.checkout  travis_time:end:014de1c0:start=1709052916123537531,finish=1709052916631616415,duration=508078884,event=checkout travis_time:start:0b55a83f  Setting environment variables from .travis.yml $ export PGPORT=5432 $ export PGUSER=travis $ export MARGINALIA_DB_PORT=5432 $ export MARGINALIA_LOG_FILE=/var/log/postgresql/postgresql-11-main.log travis_time:end:0b55a83f:start=1709052916635267098,finish=1709052916645830540,duration=10563442,event=env travis_fold:start:rvm travis_time:start:0e1bcdd1 $ 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:0e1bcdd1:start=1709052916654809307,finish=1709052919497606353,duration=2842797046,event= travis_time:start:14383f3a $ 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/20.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 100 32.4M 100 32.4M 0 0 19.5M 0 0:00:01 0:00:01 --:--:-- 19.5M 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:14383f3a:start=1709052919501788213,finish=1709052939564958090,duration=20063169877,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:1bb3e308 $ bash -c "yes | gem uninstall -i /home/travis/.rvm/gems/ruby-3.2.0@global rake" Gem 'rake' is not installed travis_time:end:1bb3e308:start=1709052940021224638,finish=1709052940202033553,duration=180808915,event=before_install travis_fold:end:before_install travis_fold:start:install.bundler travis_time:start:02be60ca $ 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 base64 0.2.0 Fetching concurrent-ruby 1.2.3 Fetching bigdecimal 3.1.6 Installing base64 0.2.0 Fetching connection_pool 2.4.1 Installing concurrent-ruby 1.2.3 Installing connection_pool 2.4.1 Installing bigdecimal 3.1.6 with native extensions Using ruby2_keywords 0.0.5 Fetching minitest 5.22.2 Fetching mutex_m 0.2.0 Installing minitest 5.22.2 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 Installing pg 1.5.5 with native extensions Using power_assert 2.0.3 Fetching drb 2.2.0 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:02be60ca:start=1709052940207335416,finish=1709052958939056405,duration=18731720989,event=install travis_fold:end:install.bundler  travis_fold:start:before_script travis_time:start:0025b754 $ sudo chmod 0644 $MARGINALIA_LOG_FILE travis_time:end:0025b754:start=1709052958944108754,finish=1709052958953557164,duration=9448410,event=before_script travis_fold:end:before_script travis_time:start:0a66a98b $ ls /var/log/postgresql/ postgresql-11-main.log postgresql-13-main.log travis_time:end:0a66a98b:start=1709052958958303893,finish=1709052958963074307,duration=4770414,event=script The command "ls /var/log/postgresql/" exited with 0. Done. Your build exited with 0.