Skip to content
Snippets Groups Projects

rails-production-server-boot-puma-example

Passed Started by
Simon Tomlinson
@stomlinson
Log timestamps in UTC.
121:56:36Running with gitlab-runner 17.4.0~pre.110.g27400594 (27400594)
221:56:36 on blue-3.private.runners-manager.gitlab.com/gitlab.com/gitlab-org 6io2xoDD, system ID: s_8f94f7760223
321:56:36 feature flags: FF_NETWORK_PER_BUILD:true, FF_TIMESTAMPS:true
421:56:36Resolving secrets
5 21:56:36 Preparing the "docker+machine" executor 00:10
621:56:36Using Docker executor with image registry.gitlab.com/gitlab-org/gitlab-build-images/debian-bookworm-ruby-3.2.5-golang-1.23-rust-1.73-node-20.12-postgresql-14:rubygems-3.5-git-2.45-lfs-2.9-chrome-123-yarn-1.22-graphicsmagick-1.3.36 ...
721:56:38Starting service registry.gitlab.com/gitlab-org/gitlab-build-images:postgres-14-pgvector-0.4.1...
821:56:38Authenticating with credentials from job payload (GitLab Registry)
921:56:38Pulling docker image registry.gitlab.com/gitlab-org/gitlab-build-images:postgres-14-pgvector-0.4.1 ...
1021:56:38Using docker image sha256:82f132c22567f8ce17cc132c14b2f9aa3eaf9bb5424d91c2d966912433f0257d for registry.gitlab.com/gitlab-org/gitlab-build-images:postgres-14-pgvector-0.4.1 with digest registry.gitlab.com/gitlab-org/gitlab-build-images@sha256:c55e1364ee4327b244a9cfa1750f19feea14fc774eaf792b725967d146eb45f5 ...
1121:56:39WARNING: Service registry.gitlab.com/gitlab-org/gitlab-build-images:redis-cluster-6.2.12 is already created. Ignoring.
1221:56:39WARNING: Service registry.gitlab.com/gitlab-org/gitlab-build-images:redis-cluster-6.2.12 is already created. Ignoring.
1321:56:39Starting service registry.gitlab.com/gitlab-org/gitlab-build-images:redis-cluster-6.2.12...
1421:56:39Authenticating with credentials from job payload (GitLab Registry)
1521:56:39Pulling docker image registry.gitlab.com/gitlab-org/gitlab-build-images:redis-cluster-6.2.12 ...
1621:56:39Using docker image sha256:5c5ba5b83d6c60cb0b225bd670b7a43be8c238cc72347d24af57e5027c3648f3 for registry.gitlab.com/gitlab-org/gitlab-build-images:redis-cluster-6.2.12 with digest registry.gitlab.com/gitlab-org/gitlab-build-images@sha256:46aceab84c42d0e819c8e7940f2f98ce9e184785cd7b22d95872024a35f52407 ...
1721:56:39Starting service redis:6.2-alpine...
1821:56:39Pulling docker image redis:6.2-alpine ...
1921:56:40Using docker image sha256:4100b5bd17430263e85ad9d8ab851959b234acaaf378e093f1f98400f4998815 for redis:6.2-alpine with digest redis@sha256:eaba718fecd1196d88533de7ba49bf903ad33664a92debb24660a922ecd9cac8 ...
2021:56:41Waiting for services to be up and running (timeout 30 seconds)...
2121:56:46Authenticating with credentials from job payload (GitLab Registry)
2221:56:46Pulling docker image registry.gitlab.com/gitlab-org/gitlab-build-images/debian-bookworm-ruby-3.2.5-golang-1.23-rust-1.73-node-20.12-postgresql-14:rubygems-3.5-git-2.45-lfs-2.9-chrome-123-yarn-1.22-graphicsmagick-1.3.36 ...
2321:56:46Using docker image sha256:e83f017c5ffd177beb4bc3b4bfabde989d741e04fef90cd764896cf9b670552f for registry.gitlab.com/gitlab-org/gitlab-build-images/debian-bookworm-ruby-3.2.5-golang-1.23-rust-1.73-node-20.12-postgresql-14:rubygems-3.5-git-2.45-lfs-2.9-chrome-123-yarn-1.22-graphicsmagick-1.3.36 with digest registry.gitlab.com/gitlab-org/gitlab-build-images/debian-bookworm-ruby-3.2.5-golang-1.23-rust-1.73-node-20.12-postgresql-14@sha256:770feb0a974e36f8b83d22a3cb18310d0cfeae11e02f6195b1577c73ce26b398 ...
24 21:56:46 Preparing environment 00:01
2521:56:47Running on runner-6io2xodd-project-278964-concurrent-0 via runner-6io2xodd-private-1731529822-417eb778...
26 21:56:47 Getting source from Git repository 00:34
2721:56:48Fetching changes with git depth set to 20...
2821:56:48Initialized empty Git repository in /builds/gitlab-org/gitlab/.git/
2921:56:48Created fresh repository.
3021:56:49remote: Enumerating objects: 180803, done.
3121:56:49remote: Counting objects: 100% (180803/180803), done.
3221:56:49remote: Compressing objects: 100% (118466/118466), done.
3321:56:49remote: Total 180803 (delta 83876), reused 128168 (delta 55535), pack-reused 0 (from 0)
3421:56:54Receiving objects: 100% (180803/180803), 150.43 MiB | 30.67 MiB/s, done.
3521:56:54Resolving deltas: 100% (83876/83876), done.
3621:57:03From https://us-east1-c.ci-gateway.int.gprd.gitlab.net:8989/gitlab-org/gitlab
3721:57:03 * [new ref] refs/pipelines/1541310000 -> refs/pipelines/1541310000
3821:57:03Checking out 9be0f913 as detached HEAD (ref is refs/merge-requests/172446/merge)...
3921:57:17Skipping Git submodules setup
4021:57:17$ git remote set-url origin "${CI_REPOSITORY_URL}"
41 21:57:21 Restoring cache 00:18
4221:57:21Checking cache for ruby-gems-debian-bookworm-ruby-3.2.5-gemfile-Gemfile-20...
4321:57:21Downloading cache from https://storage.googleapis.com/gitlab-com-runners-cache/project/278964/ruby-gems-debian-bookworm-ruby-3.2.5-gemfile-Gemfile-20 ETag="ba67364f761343c8f313528473af941a"
4421:57:33Successfully extracted cache
45 21:57:39 Executing "step_script" stage of the job script 02:19
4621:57:39Using docker image sha256:e83f017c5ffd177beb4bc3b4bfabde989d741e04fef90cd764896cf9b670552f for registry.gitlab.com/gitlab-org/gitlab-build-images/debian-bookworm-ruby-3.2.5-golang-1.23-rust-1.73-node-20.12-postgresql-14:rubygems-3.5-git-2.45-lfs-2.9-chrome-123-yarn-1.22-graphicsmagick-1.3.36 with digest registry.gitlab.com/gitlab-org/gitlab-build-images/debian-bookworm-ruby-3.2.5-golang-1.23-rust-1.73-node-20.12-postgresql-14@sha256:770feb0a974e36f8b83d22a3cb18310d0cfeae11e02f6195b1577c73ce26b398 ...
4721:57:40$ echo $FOSS_ONLY
4821:57:40$ [ "$FOSS_ONLY" = "1" ] && rm -rf ee/ qa/spec/ee/ qa/qa/specs/features/ee/ qa/qa/ee/ qa/qa/ee.rb
4921:57:40$ export GOPATH=$CI_PROJECT_DIR/.go
5021:57:40$ mkdir -p $GOPATH
5121:57:40$ source scripts/utils.sh
5221:57:40$ log_disk_usage "true"
5321:57:40*******************************************************
5421:57:40This runner currently has 77G free disk space.
5521:57:40*******************************************************
56 21:57:40 Disk usage detail 00:00
10621:57:40$ source scripts/prepare_build.sh
107 21:57:40 Installing gems 00:17
13821:57:57Using decomposed database config (config/database.yml.decomposed-postgresql)
13921:57:57Geo DB won't be set up.
14021:57:57Embedding DB won't be set up.
141 21:57:57 Setting up DBs 01:00
15721:58:57$ cp config/puma.rb.example config/puma.rb
15821:58:57$ sed --in-place "s:/home/git/gitlab:${PWD}:" config/puma.rb
15921:58:57$ echo 'bind "tcp://127.0.0.1:3000"' >> config/puma.rb
16021:58:57$ bundle exec puma --environment production --config config/puma.rb &
16121:58:57$ sleep 50
16221:59:00{"timestamp":"2024-11-13T21:59:00.050Z","pid":281,"message":"Puma starting in cluster mode..."}
16321:59:00{"timestamp":"2024-11-13T21:59:00.066Z","pid":281,"message":"* Puma version: 6.4.3 (ruby 3.2.5-p208) (\"The Eagle of Durango\")"}
16421:59:00{"timestamp":"2024-11-13T21:59:00.066Z","pid":281,"message":"* Min threads: 1"}
16521:59:00{"timestamp":"2024-11-13T21:59:00.066Z","pid":281,"message":"* Max threads: 16"}
16621:59:00{"timestamp":"2024-11-13T21:59:00.066Z","pid":281,"message":"* Environment: production"}
16721:59:00{"timestamp":"2024-11-13T21:59:00.066Z","pid":281,"message":"* Master PID: 281"}
16821:59:00{"timestamp":"2024-11-13T21:59:00.066Z","pid":281,"message":"* Workers: 3"}
16921:59:00{"timestamp":"2024-11-13T21:59:00.066Z","pid":281,"message":"* Restarts: (✔) hot (✖) phased"}
17021:59:00{"timestamp":"2024-11-13T21:59:00.066Z","pid":281,"message":"* Preloading application"}
17121:58:57DEPRECATION WARNING: Support for Rails versions < 7.1 is deprecated and will be removed from ViewComponent 4.0.0 (ViewComponent v4 will remove support for Rails versions < 7.1 no earlier than April 1, 2025) (called from <top (required)> at /builds/gitlab-org/gitlab/config/environment.rb:7)
17221:59:46WARNING: Active Record does not support composite primary key.
17321:59:46security_findings has composite primary key. Composite primary key is ignored.
17421:59:47$ retry_times_sleep 10 5 "curl http://127.0.0.1:3000"
17521:59:48 % Total % Received % Xferd Average Speed Time Time Time Current
17621:59:48 Dload Upload Total Spent Left Speed
17721:59:48 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0
17821:59:48curl: (7) Failed to connect to 127.0.0.1 port 3000 after 0 ms: Couldn't connect to server
17921:59:53[21:59:53] Retry attempts left: 10...
18021:59:53 % Total % Received % Xferd Average Speed Time Time Time Current
18121:59:53 Dload Upload Total Spent Left Speed
18221:59:53 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0
18321:59:53curl: (7) Failed to connect to 127.0.0.1 port 3000 after 14 ms: Couldn't connect to server
18421:59:55DEPRECATION WARNING: The asset "no_avatar.png" is not present in the asset pipeline.
18521:59:55Falling back to an asset that may be in the public folder.
18621:59:55This behavior is deprecated and will be removed.
18721:59:55To bypass the asset pipeline and preserve this behavior,
18821:59:55use the `skip_pipeline: true` option.
18921:59:55 (called from default_avatar_url at /builds/gitlab-org/gitlab/lib/gitlab/gon_helper.rb:142)
19021:59:55DEPRECATION WARNING: The asset "gitlab_logo.png" is not present in the asset pipeline.
19121:59:55Falling back to an asset that may be in the public folder.
19221:59:55This behavior is deprecated and will be removed.
19321:59:55To bypass the asset pipeline and preserve this behavior,
19421:59:55use the `skip_pipeline: true` option.
19521:59:55 (called from add_gon_variables at /builds/gitlab-org/gitlab/lib/gitlab/gon_helper.rb:41)
19621:59:55DEPRECATION WARNING: The asset "icons.svg" is not present in the asset pipeline.
19721:59:55Falling back to an asset that may be in the public folder.
19821:59:55This behavior is deprecated and will be removed.
19921:59:55To bypass the asset pipeline and preserve this behavior,
20021:59:55use the `skip_pipeline: true` option.
20121:59:55 (called from sprite_icon_path at /builds/gitlab-org/gitlab/app/helpers/icons_helper.rb:21)
20221:59:55DEPRECATION WARNING: The asset "file_icons/file_icons.svg" is not present in the asset pipeline.
20321:59:55Falling back to an asset that may be in the public folder.
20421:59:55This behavior is deprecated and will be removed.
20521:59:55To bypass the asset pipeline and preserve this behavior,
20621:59:55use the `skip_pipeline: true` option.
20721:59:55 (called from sprite_file_icons_path at /builds/gitlab-org/gitlab/app/helpers/icons_helper.rb:29)
20821:59:55DEPRECATION WARNING: The asset "emoji_sprites.css" is not present in the asset pipeline.
20921:59:55Falling back to an asset that may be in the public folder.
21021:59:55This behavior is deprecated and will be removed.
21121:59:55To bypass the asset pipeline and preserve this behavior,
21221:59:55use the `skip_pipeline: true` option.
21321:59:55 (called from universal_path_to_stylesheet at /builds/gitlab-org/gitlab/app/helpers/vite_helper.rb:50)
21421:59:55DEPRECATION WARNING: The asset "lazy_bundles/gridstack.css" is not present in the asset pipeline.
21521:59:55Falling back to an asset that may be in the public folder.
21621:59:55This behavior is deprecated and will be removed.
21721:59:55To bypass the asset pipeline and preserve this behavior,
21821:59:55use the `skip_pipeline: true` option.
21921:59:55 (called from universal_path_to_stylesheet at /builds/gitlab-org/gitlab/app/helpers/vite_helper.rb:50)
22021:59:55{"timestamp":"2024-11-13T21:59:55.513Z","pid":281,"message":"* Listening on unix:///builds/gitlab-org/gitlab/tmp/sockets/gitlab.socket"}
22121:59:55{"timestamp":"2024-11-13T21:59:55.513Z","pid":281,"message":"* Listening on http://127.0.0.1:3000"}
22221:59:55{"timestamp":"2024-11-13T21:59:55.513Z","pid":281,"message":"! WARNING: Detected 2 Thread(s) started in app boot:"}
22321:59:55{"timestamp":"2024-11-13T21:59:55.513Z","pid":281,"message":"! #\u003cThread:0x00007c9b0ef10740 /builds/gitlab-org/gitlab/vendor/ruby/3.2.0/gems/rack-timeout-0.7.0/lib/rack/timeout/support/scheduler.rb:72 sleep\u003e - /builds/gitlab-org/gitlab/vendor/ruby/3.2.0/gems/rack-timeout-0.7.0/lib/rack/timeout/support/scheduler.rb:90:in `sleep'"}
22421:59:55{"timestamp":"2024-11-13T21:59:55.513Z","pid":281,"message":"! #\u003cThread:0x00007c9b3295b100 /builds/gitlab-org/gitlab/vendor/ruby/3.2.0/gems/sentry-ruby-5.21.0/lib/sentry/threaded_periodic_worker.rb:18 sleep\u003e - /builds/gitlab-org/gitlab/vendor/ruby/3.2.0/gems/sentry-ruby-5.21.0/lib/sentry/threaded_periodic_worker.rb:20:in `sleep'"}
22521:59:55{"timestamp":"2024-11-13T21:59:55.514Z","pid":281,"message":"Use Ctrl-C to stop"}
22621:59:58[21:59:58] Retry attempts left: 9...
22721:59:58 % Total % Received % Xferd Average Speed Time Time Time Current
22821:59:58 Dload Upload Total Spent Left Speed
22921:59:58100 101 0 101 0 0 1571 0 --:--:-- --:--:-- --:--:-- 1578
23021:59:58<html><body>You are being <a href="http://127.0.0.1:3000/users/sign_in">redirected</a>.</body></html>$ kill $(jobs -p)
231 21:59:58 Saving cache for successful job 00:01
23221:59:58Not uploading cache ruby-gems-debian-bookworm-ruby-3.2.5-gemfile-Gemfile-20 due to policy
233 21:59:59 Uploading artifacts for successful job 00:02
23421:59:59Uploading artifacts...
23521:59:59log/: found 13 matching artifact files and directories
23621:59:59WARNING: Upload request redirected location=https://gitlab.com/api/v4/jobs/8353286586/artifacts?artifact_format=zip&artifact_type=archive&expire_in=7d new-url=https://gitlab.com
23721:59:59WARNING: Retrying... context=artifacts-uploader error=request redirected
23822:00:01Uploading artifacts as "archive" to coordinator... 201 Created id=8353286586 responseStatus=201 Created token=glcbt-66
239 22:00:01 Cleaning up project directory and file based variables 00:01
24022:00:08Job succeeded