Skip to content
Snippets Groups Projects

rspec migration pg14 single-db-ci-connection 5/26

Passed Started by
Simon Tomlinson
@stomlinson
Log timestamps in UTC.
121:21:48Running with gitlab-runner 17.4.0~pre.110.g27400594 (27400594)
221:21:48 on blue-2.shared-gitlab-org.runners-manager.gitlab.com/default NL4gfoBe, system ID: s_74c3e1316164
321:21:48 feature flags: FF_NETWORK_PER_BUILD:true, FF_TIMESTAMPS:true
421:21:48Resolving secrets
5 21:21:48 Preparing the "docker+machine" executor 00:11
621:21:49Using 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:21:51Starting service registry.gitlab.com/gitlab-org/gitlab-build-images:postgres-14-pgvector-0.4.1...
821:21:52Authenticating with credentials from job payload (GitLab Registry)
921:21:52Pulling docker image registry.gitlab.com/gitlab-org/gitlab-build-images:postgres-14-pgvector-0.4.1 ...
1021:21:52Using 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:21:53WARNING: Service registry.gitlab.com/gitlab-org/gitlab-build-images:redis-cluster-6.2.12 is already created. Ignoring.
1221:21:53WARNING: Service registry.gitlab.com/gitlab-org/gitlab-build-images:redis-cluster-6.2.12 is already created. Ignoring.
1321:21:53Starting service registry.gitlab.com/gitlab-org/gitlab-build-images:redis-cluster-6.2.12...
1421:21:53Authenticating with credentials from job payload (GitLab Registry)
1521:21:53Pulling docker image registry.gitlab.com/gitlab-org/gitlab-build-images:redis-cluster-6.2.12 ...
1621:21:53Using 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:21:53Starting service redis:6.2-alpine...
1821:21:53Pulling docker image redis:6.2-alpine ...
1921:21:54Using docker image sha256:4100b5bd17430263e85ad9d8ab851959b234acaaf378e093f1f98400f4998815 for redis:6.2-alpine with digest redis@sha256:eaba718fecd1196d88533de7ba49bf903ad33664a92debb24660a922ecd9cac8 ...
2021:21:55Waiting for services to be up and running (timeout 30 seconds)...
2121:21:58Authenticating with credentials from job payload (GitLab Registry)
2221:21:58Pulling 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:21:59Using 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:21:59 Preparing environment 00:00
2521:21:59Running on runner-nl4gfobe-project-278964-concurrent-0 via runner-nl4gfobe-shared-gitlab-org-1731615390-b08a18dc...
26 21:21:59 Getting source from Git repository 00:01
2721:22:00Skipping Git repository setup
2821:22:00Skipping Git checkout
2921:22:00Skipping Git submodules setup
30 21:22:00 Restoring cache 00:18
3121:22:00Checking cache for ruby-gems-debian-bookworm-ruby-3.2.5-gemfile-Gemfile-20...
3221:22:01Downloading cache from https://storage.googleapis.com/gitlab-com-runners-cache/project/278964/ruby-gems-debian-bookworm-ruby-3.2.5-gemfile-Gemfile-20 ETag="19021ff660774ac886a027bf8fc2c15e"
3321:22:13Successfully extracted cache
34 21:22:18 Downloading artifacts 00:51
3521:22:18Downloading artifacts for clone-gitlab-repo (8368443091)...
3621:22:23Downloading artifacts from coordinator... ok host=storage.googleapis.com id=8368443091 responseStatus=200 OK token=glcbt-66
3721:22:23WARNING: Part of .git directory is on the list of files to extract
3821:22:23WARNING: This may introduce unexpected problems
3921:22:39Downloading artifacts for compile-test-assets (8368443337)...
4021:22:43Downloading artifacts from coordinator... ok host=storage.googleapis.com id=8368443337 responseStatus=200 OK token=glcbt-66
4121:22:50Downloading artifacts for detect-tests (8368443460)...
4221:22:50Downloading artifacts from coordinator... ok host=storage.googleapis.com id=8368443460 responseStatus=200 OK token=glcbt-66
4321:22:50Downloading artifacts for retrieve-tests-metadata (8368443480)...
4421:22:51Downloading artifacts from coordinator... ok host=storage.googleapis.com id=8368443480 responseStatus=200 OK token=glcbt-66
4521:22:51Downloading artifacts for setup-test-env (8368443411)...
4621:22:55Downloading artifacts from coordinator... ok host=storage.googleapis.com id=8368443411 responseStatus=200 OK token=glcbt-66
47 21:23:09 Executing "step_script" stage of the job script
4821:23:09Using 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 ...
4921:23:09$ echo $FOSS_ONLY
5021:23:09$ [ "$FOSS_ONLY" = "1" ] && rm -rf ee/ qa/spec/ee/ qa/qa/specs/features/ee/ qa/qa/ee/ qa/qa/ee.rb
5121:23:09$ export GOPATH=$CI_PROJECT_DIR/.go
5221:23:09$ mkdir -p $GOPATH
5321:23:09$ source scripts/utils.sh
5421:23:09$ log_disk_usage "true"
5521:23:09*******************************************************
5621:23:09This runner currently has 27G free disk space.
5721:23:09*******************************************************
58 21:23:09 Disk usage detail 00:08
5921:23:09df -h
6021:23:09Filesystem Size Used Avail Use% Mounted on
6121:23:09overlay 46G 19G 27G 41% /
6221:23:09tmpfs 64M 0 64M 0% /dev
6321:23:09shm 256M 0 256M 0% /dev/shm
6421:23:09/dev/sda1 46G 19G 27G 41% /cache
6521:23:09tmpfs 3.9G 0 3.9G 0% /sys/devices/virtual/dmi/id
6621:23:09tmpfs 3.9G 0 3.9G 0% /proc/acpi
6721:23:09tmpfs 3.9G 0 3.9G 0% /proc/scsi
6821:23:09tmpfs 3.9G 0 3.9G 0% /sys/firmware
6921:23:09du -h -d 1
7021:23:097.4M ./workhorse
7121:23:09148K ./bin
7221:23:091.2M ./.gitlab
7321:23:09177M ./.git
7421:23:094.0K ./builds
7521:23:0928M ./lib
7621:23:098.0K ./.vscode
7721:23:09560K ./storybook
7821:23:0924K ./log
7921:23:091.8M ./data
8021:23:0911M ./qa
8121:23:093.2M ./.rubocop_todo
8221:23:09856M ./vendor
8321:23:091023M ./public
8421:23:1062M ./doc
8521:23:10484K ./danger
8621:23:1032K ./rspec
8721:23:10556K ./tooling
8821:23:10146M ./ee
8921:23:101.3M ./knapsack
9021:23:10300K ./patches
9121:23:104.3M ./changelogs
9221:23:1020K ./haml_lint
9321:23:1028K ./metrics_server
9421:23:10108K ./keeps
9521:23:1036K ./shared
9621:23:1044K ./generator_templates
9721:23:101.3M ./scripts
9821:23:10763M ./tmp
9921:23:10127M ./spec
10021:23:1020K ./file_hooks
10121:23:1032K ./crystalball
10221:23:1016K ./sidekiq_cluster
10321:23:1017M ./gems
10421:23:101.2M ./fixtures
10521:23:10964K ./rubocop
10621:23:104.0K ./.go
10721:23:1033M ./db
10821:23:1012K ./.github
10921:23:10129M ./locale
11021:23:1020M ./config
11121:23:1082M ./app
11221:23:1020K ./.lefthook
11321:23:103.5G .
11421:23:10$ source scripts/prepare_build.sh
115 21:23:10 Installing gems 00:23
14621:23:33Using two connections, single database config (config/database.yml.postgresql)
14721:23:33Geo DB won't be set up.
14821:23:33Embedding DB won't be set up.
149 21:23:33 Setting up DBs 00:58
16221:24:31$ source ./scripts/rspec_helpers.sh
16321:24:31$ run_timed_command "gem install knapsack --no-document"
16421:24:31$ gem install knapsack --no-document
16521:24:32Successfully installed knapsack-4.0.0
16621:24:321 gem installed
16721:24:31==> 'gem install knapsack --no-document' succeeded in 1 seconds.
16821:24:32$ section_start "gitaly-test-spawn" "Spawning Gitaly"; scripts/gitaly-test-spawn; section_end "gitaly-test-spawn"
169 21:24:32 Spawning Gitaly 00:05
17321:24:37$ export RSPEC_SKIPPED_TESTS_REPORT_PATH="rspec/skipped_tests-${CI_JOB_ID}.txt"
17421:24:37$ export RSPEC_RETRIED_TESTS_REPORT_PATH="rspec/retried_tests-${CI_JOB_ID}.txt"
17521:24:37$ tooling/bin/create_job_metrics_file || true
17621:24:40[job-metrics] Creating the job metrics file for the CI/CD job.
17721:24:40$ rspec_section rspec_parallelized_job "--fail-fast=${RSPEC_FAIL_FAST_THRESHOLD} --tag ~quarantine --tag ~zoekt --tag ~click_house"
178 21:24:40 RSpec 04:38
17921:24:40[21:24:40] Starting rspec_parallelized_job
18021:24:32RETRY_FAILED_TESTS_IN_NEW_PROCESS: true
18121:24:40KNAPSACK_GENERATE_REPORT: true
18221:24:40FLAKY_RSPEC_GENERATE_REPORT: true
18321:24:40KNAPSACK_TEST_FILE_PATTERN: spec/{migrations}{,/**/}*_spec.rb
18421:24:40KNAPSACK_LOG_LEVEL: debug
18521:24:40KNAPSACK_REPORT_PATH: knapsack/rspec_migration_pg14_single-db-ci-connection_5_26_278964_report.json
18621:24:40FLAKY_RSPEC_SUITE_REPORT_PATH: rspec/flaky/report-suite.json
18721:24:40FLAKY_RSPEC_REPORT_PATH: rspec/flaky/all_rspec_migration_pg14_single-db-ci-connection_5_26_278964_report.json
18821:24:40NEW_FLAKY_RSPEC_REPORT_PATH: rspec/flaky/new_rspec_migration_pg14_single-db-ci-connection_5_26_278964_report.json
18921:24:40RSPEC_SKIPPED_TESTS_REPORT_PATH: rspec/skipped_tests-8368446038.txt
19021:24:40CRYSTALBALL:
19121:24:40RSPEC_TESTS_MAPPING_ENABLED:
19221:24:40RSPEC_TESTS_FILTER_FILE:
19321:24:40Shell set options (set -o) enabled:
19421:24:40braceexpand on
19521:24:40hashall on
19621:24:40interactive-comments on
19721:24:40pipefail on
19821:24:47Knapsack report generator started!
19921:24:40/builds/gitlab-org/gitlab/vendor/ruby/3.2.0/gems/io-event-1.6.5/lib/io/event/support.rb:27: warning: IO::Buffer is experimental and both the Ruby and C interface may change in the future!
20021:25:31DEPRECATION 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)
20121:25:42warning: parser/current is loading parser/ruby32, which recognizes 3.2.6-compliant syntax, but you are running 3.2.5.
20221:25:42Please see https://github.com/whitequark/parser#compatibility-with-ruby-mri.
20321:25:48Run options: exclude {:quarantine=>true, :zoekt=>true, :click_house=>true}
20421:25:48# [RSpecRunTime] Starting RSpec timer...
20521:25:48[TEST PROF INFO] EventProf enabled (sql.active_record)
20621:25:48unknown OID 2249: failed to recognize type of 'pg_stat_file'. It will be treated as String.
20721:25:53Test environment set up in 1.277484001 seconds
20821:25:54# [RSpecRunTime] Starting example group spec/migrations/20241004064933_queue_fix_pick_up_at_ci_deleted_object_spec.rb. Expected to take 37.26 seconds.
20921:25:54QueueFixPickUpAtCiDeletedObject
21021:26:04ci: == [advisory_lock_connection] object_id: 2104780, pg_backend_pid: 125
21121:26:04ci: == 20241004064933 QueueFixPickUpAtCiDeletedObject: migrating ==================
21221:26:04ci: == 20241004064933 QueueFixPickUpAtCiDeletedObject: migrated (0.1274s) =========
21321:26:04ci: == [advisory_lock_connection] object_id: 2104780, pg_backend_pid: 125
21421:26:09 schedules a new batched migration
21521:26:09 when executed on .com
21621:26:09ci: == [advisory_lock_connection] object_id: 3010780, pg_backend_pid: 132
21721:26:10ci: == 20241004064933 QueueFixPickUpAtCiDeletedObject: migrating ==================
21821:26:10ci: == 20241004064933 QueueFixPickUpAtCiDeletedObject: migrated (0.0862s) =========
21921:26:10ci: == [advisory_lock_connection] object_id: 3010780, pg_backend_pid: 132
22021:26:14 schedules a new batched migration
22121:26:36# [RSpecRunTime] Finishing example group spec/migrations/20241004064933_queue_fix_pick_up_at_ci_deleted_object_spec.rb. It took 42.51 seconds. Expected to take 37.26 seconds.
22221:26:36# [RSpecRunTime] RSpec elapsed time: 48.33 seconds. Current RSS: ~1196M. Threads: 1. load average: 1.04 1.23 1.25 1/281 389
22321:26:36.
22421:26:36# [RSpecRunTime] Starting example group spec/migrations/20241001115912_queue_set_total_number_of_vulnerabilities_for_existing_projects_spec.rb. Expected to take 15.14 seconds.
22521:26:36QueueSetTotalNumberOfVulnerabilitiesForExistingProjects
22621:26:47main: == [advisory_lock_connection] object_id: 7374160, pg_backend_pid: 145
22721:26:47main: == 20241001115912 QueueSetTotalNumberOfVulnerabilitiesForExistingProjects: migrating
22821:26:47main: == 20241001115912 QueueSetTotalNumberOfVulnerabilitiesForExistingProjects: migrated (0.0763s)
22921:26:47main: == [advisory_lock_connection] object_id: 7374160, pg_backend_pid: 145
23021:26:52 schedules a new batched migration
23121:27:14# [RSpecRunTime] Finishing example group spec/migrations/20241001115912_queue_set_total_number_of_vulnerabilities_for_existing_projects_spec.rb. It took 37.22 seconds. Expected to take 15.14 seconds.
23221:27:14# [RSpecRunTime] RSpec elapsed time: 1 minute 25.78 seconds. Current RSS: ~1204M. Threads: 1. load average: 0.90 1.17 1.23 1/279 391
23321:27:14.
23421:27:14# [RSpecRunTime] Starting example group spec/migrations/20241024062434_queue_create_missing_external_links_for_vulnerabilities_spec.rb. Expected to take 8.17 seconds.
23521:27:14QueueCreateMissingExternalLinksForVulnerabilities
23621:27:18main: == [advisory_lock_connection] object_id: 10893580, pg_backend_pid: 156
23721:27:18main: == 20241024062434 QueueCreateMissingExternalLinksForVulnerabilities: migrating
23821:27:18main: == 20241024062434 QueueCreateMissingExternalLinksForVulnerabilities: migrated (0.0803s)
23921:27:18main: == [advisory_lock_connection] object_id: 10893580, pg_backend_pid: 156
24021:27:23 schedules a new batched migration
24121:27:36# [RSpecRunTime] Finishing example group spec/migrations/20241024062434_queue_create_missing_external_links_for_vulnerabilities_spec.rb. It took 21.93 seconds. Expected to take 8.17 seconds.
24221:27:36# [RSpecRunTime] RSpec elapsed time: 1 minute 47.77 seconds. Current RSS: ~1201M. Threads: 1. load average: 0.93 1.16 1.22 1/278 392
24321:27:36.
24421:27:36# [RSpecRunTime] Starting example group spec/migrations/20230913071219_delete_pages_domain_with_reserved_domains_spec.rb. Missing expected duration from Knapsack report for spec/migrations/20230913071219_delete_pages_domain_with_reserved_domains_spec.rb.
24521:27:36DeletePagesDomainWithReservedDomains
24621:27:36 migrates
24721:27:36 when a reserved domain is provided
24821:27:36 delete the domain (PENDING: Skipping because migration DeletePagesDomainWithReservedDomains is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.)
24921:27:36 when a reserved domain is provided with non standard case
25021:27:36 delete the domain (PENDING: Skipping because migration DeletePagesDomainWithReservedDomains is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.)
25121:27:36 when a non reserved domain is provided
25221:27:36 does not delete the domain (PENDING: Skipping because migration DeletePagesDomainWithReservedDomains is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.)
25321:27:36# [RSpecRunTime] Finishing example group spec/migrations/20230913071219_delete_pages_domain_with_reserved_domains_spec.rb. It took 0.02 second. Missing expected duration from Knapsack report for spec/migrations/20230913071219_delete_pages_domain_with_reserved_domains_spec.rb.
25421:27:36# [RSpecRunTime] Starting example group spec/migrations/20231211154654_add_work_items_rolledup_dates_widget_spec.rb. Missing expected duration from Knapsack report for spec/migrations/20231211154654_add_work_items_rolledup_dates_widget_spec.rb.
25521:27:36AddWorkItemsRolledupDatesWidget
25621:27:36 behaves like migration that adds widget to work items definitions
25721:27:36 #up
25821:27:36 creates widget definition in all types (PENDING: Skipping because migration AddWorkItemsRolledupDatesWidget is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.)
25921:27:36 when the widget already exists
26021:27:36 upserts the widget definitions and raises no error (PENDING: Skipping because migration AddWorkItemsRolledupDatesWidget is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.)
26121:27:36 #down
26221:27:36 removes definitions for widget (PENDING: Skipping because migration AddWorkItemsRolledupDatesWidget is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.)
26321:27:36# [RSpecRunTime] Finishing example group spec/migrations/20231211154654_add_work_items_rolledup_dates_widget_spec.rb. It took 0.02 second. Missing expected duration from Knapsack report for spec/migrations/20231211154654_add_work_items_rolledup_dates_widget_spec.rb.
26421:27:36# [RSpecRunTime] Starting example group spec/migrations/20240222075046_queue_backfill_users_color_mode_id_spec.rb. Missing expected duration from Knapsack report for spec/migrations/20240222075046_queue_backfill_users_color_mode_id_spec.rb.
26521:27:36QueueBackfillUsersColorModeId
26621:27:36 schedules a new batched migration (PENDING: Skipping because migration QueueBackfillUsersColorModeId is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.)
26721:27:36# [RSpecRunTime] Finishing example group spec/migrations/20240222075046_queue_backfill_users_color_mode_id_spec.rb. It took 0.02 second. Missing expected duration from Knapsack report for spec/migrations/20240222075046_queue_backfill_users_color_mode_id_spec.rb.
26821:27:36# [RSpecRunTime] Starting example group spec/migrations/20240501044351_queue_backfill_approval_merge_request_rules_project_id_spec.rb. Missing expected duration from Knapsack report for spec/migrations/20240501044351_queue_backfill_approval_merge_request_rules_project_id_spec.rb.
26921:27:36QueueBackfillApprovalMergeRequestRulesProjectId
27021:27:36 schedules a new batched migration (PENDING: Skipping because migration QueueBackfillApprovalMergeRequestRulesProjectId is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.)
27121:27:36# [RSpecRunTime] Finishing example group spec/migrations/20240501044351_queue_backfill_approval_merge_request_rules_project_id_spec.rb. It took 0.02 second. Missing expected duration from Knapsack report for spec/migrations/20240501044351_queue_backfill_approval_merge_request_rules_project_id_spec.rb.
27221:27:36# [RSpecRunTime] Starting example group spec/migrations/20240523083208_delete_invalid_remote_mirrors_records_spec.rb. Missing expected duration from Knapsack report for spec/migrations/20240523083208_delete_invalid_remote_mirrors_records_spec.rb.
27321:27:36DeleteInvalidRemoteMirrorsRecords
27421:27:36 #up
27521:27:36 deletes records without a project_id (PENDING: Skipping because migration DeleteInvalidRemoteMirrorsRecords is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.)
27621:27:36 does nothing on gitlab.com (PENDING: Skipping because migration DeleteInvalidRemoteMirrorsRecords is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.)
27721:27:36# [RSpecRunTime] Finishing example group spec/migrations/20240523083208_delete_invalid_remote_mirrors_records_spec.rb. It took 0.02 second. Missing expected duration from Knapsack report for spec/migrations/20240523083208_delete_invalid_remote_mirrors_records_spec.rb.
27821:27:36# [RSpecRunTime] Starting example group spec/migrations/20240607104717_queue_backfill_vulnerability_merge_request_links_project_id_spec.rb. Missing expected duration from Knapsack report for spec/migrations/20240607104717_queue_backfill_vulnerability_merge_request_links_project_id_spec.rb.
27921:27:36QueueBackfillVulnerabilityMergeRequestLinksProjectId
28021:27:36 schedules a new batched migration (PENDING: Skipping because migration QueueBackfillVulnerabilityMergeRequestLinksProjectId is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.)
28121:27:36# [RSpecRunTime] Finishing example group spec/migrations/20240607104717_queue_backfill_vulnerability_merge_request_links_project_id_spec.rb. It took 0.02 second. Missing expected duration from Knapsack report for spec/migrations/20240607104717_queue_backfill_vulnerability_merge_request_links_project_id_spec.rb.
28221:27:36# [RSpecRunTime] Starting example group spec/migrations/20240618121521_queue_backfill_vulnerability_findings_remediations_project_id_spec.rb. Missing expected duration from Knapsack report for spec/migrations/20240618121521_queue_backfill_vulnerability_findings_remediations_project_id_spec.rb.
28321:27:36QueueBackfillVulnerabilityFindingsRemediationsProjectId
28421:27:36 schedules a new batched migration (PENDING: Skipping because migration QueueBackfillVulnerabilityFindingsRemediationsProjectId is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.)
28521:27:36# [RSpecRunTime] Finishing example group spec/migrations/20240618121521_queue_backfill_vulnerability_findings_remediations_project_id_spec.rb. It took 0.02 second. Missing expected duration from Knapsack report for spec/migrations/20240618121521_queue_backfill_vulnerability_findings_remediations_project_id_spec.rb.
28621:27:36# [RSpecRunTime] Starting example group spec/migrations/20240708121845_remove_idx_project_statistics_packages_size_and_project_id_sync_spec.rb. Missing expected duration from Knapsack report for spec/migrations/20240708121845_remove_idx_project_statistics_packages_size_and_project_id_sync_spec.rb.
28721:27:36RemoveIdxProjectStatisticsPackagesSizeAndProjectIdSync
28821:27:36 #up
28921:27:36 does nothing when not on gitlab.com (PENDING: Skipping because migration RemoveIdxProjectStatisticsPackagesSizeAndProjectIdSync is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.)
29021:27:36 removes the index when on gitlab.com (PENDING: Skipping because migration RemoveIdxProjectStatisticsPackagesSizeAndProjectIdSync is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.)
29121:27:36 #down
29221:27:36 does nothing when not on gitlab.com (PENDING: Skipping because migration RemoveIdxProjectStatisticsPackagesSizeAndProjectIdSync is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.)
29321:27:36 re-adds the index when on gitlab.com (PENDING: Skipping because migration RemoveIdxProjectStatisticsPackagesSizeAndProjectIdSync is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.)
29421:27:36# [RSpecRunTime] Finishing example group spec/migrations/20240708121845_remove_idx_project_statistics_packages_size_and_project_id_sync_spec.rb. It took 0.02 second. Missing expected duration from Knapsack report for spec/migrations/20240708121845_remove_idx_project_statistics_packages_size_and_project_id_sync_spec.rb.
29521:27:36# [RSpecRunTime] Starting example group spec/migrations/20240730172818_queue_backfill_vulnerability_occurrence_pipelines_project_id_spec.rb. Missing expected duration from Knapsack report for spec/migrations/20240730172818_queue_backfill_vulnerability_occurrence_pipelines_project_id_spec.rb.
29621:27:36QueueBackfillVulnerabilityOccurrencePipelinesProjectId
29721:27:36 does not schedule a new batched migration (PENDING: Skipping because migration QueueBackfillVulnerabilityOccurrencePipelinesProjectId is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.)
29821:27:36# [RSpecRunTime] Finishing example group spec/migrations/20240730172818_queue_backfill_vulnerability_occurrence_pipelines_project_id_spec.rb. It took 0.02 second. Missing expected duration from Knapsack report for spec/migrations/20240730172818_queue_backfill_vulnerability_occurrence_pipelines_project_id_spec.rb.
29921:27:36# [RSpecRunTime] Starting example group spec/migrations/20240827204855_reenqueue_deduplicate_lfs_objects_projects_spec.rb. Missing expected duration from Knapsack report for spec/migrations/20240827204855_reenqueue_deduplicate_lfs_objects_projects_spec.rb.
30021:27:36ReenqueueDeduplicateLfsObjectsProjects
30121:27:36 schedules a new batched migration (PENDING: Skipping because migration ReenqueueDeduplicateLfsObjectsProjects is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.)
30221:27:36# [RSpecRunTime] Finishing example group spec/migrations/20240827204855_reenqueue_deduplicate_lfs_objects_projects_spec.rb. It took 0.02 second. Missing expected duration from Knapsack report for spec/migrations/20240827204855_reenqueue_deduplicate_lfs_objects_projects_spec.rb.
30321:27:36# [RSpecRunTime] Starting example group spec/migrations/db/post_migrate/20240702092809_finalize_backfill_epic_dates_to_work_item_dates_sources_spec.rb. Missing expected duration from Knapsack report for spec/migrations/db/post_migrate/20240702092809_finalize_backfill_epic_dates_to_work_item_dates_sources_spec.rb.
30421:27:36FinalizeBackfillEpicDatesToWorkItemDatesSources
30521:27:36 #up
30621:27:36 ensures the migration is completed for self-managed instances (PENDING: Skipping because migration FinalizeBackfillEpicDatesToWorkItemDatesSources is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.)
30721:27:36# [RSpecRunTime] Finishing example group spec/migrations/db/post_migrate/20240702092809_finalize_backfill_epic_dates_to_work_item_dates_sources_spec.rb. It took 0.02 second. Missing expected duration from Knapsack report for spec/migrations/db/post_migrate/20240702092809_finalize_backfill_epic_dates_to_work_item_dates_sources_spec.rb.
30821:27:38auto_explain log contains 841 entries for main, writing to /builds/gitlab-org/gitlab/auto_explain/rspec-migration-pg14-single-db-ci-connection-5-26.344.main.ndjson.gz
30921:27:38took 2.687167153
31021:27:40auto_explain log contains 842 entries for ci, writing to /builds/gitlab-org/gitlab/auto_explain/rspec-migration-pg14-single-db-ci-connection-5-26.344.ci.ndjson.gz
31121:27:40took 1.947414924
31221:27:40[TEST PROF INFO] EventProf results for sql.active_record
31321:27:40Total time: 00:56.809 of 01:42.193 (55.59%)
31421:27:40Total events: 45365
31521:27:40Top 5 slowest suites (by time):
31621:27:40QueueFixPickU...iDeletedObject (./spec/migrations/20241004064933_queue_fix_pick_up_at_ci_deleted_object_spec.rb:6) – 00:23.357 (18708 / 2) of 00:42.742 (54.65%)
31721:27:40QueueSetTotal...istingProjects (./spec/migrations/20241001115912_queue_set_total_number_of_vulnerabilities_for_existing_projects_spec.rb:6) – 00:21.875 (16633 / 1) of 00:37.277 (58.68%)
31821:27:40QueueCreateMi...ulnerabilities (./spec/migrations/20241024062434_queue_create_missing_external_links_for_vulnerabilities_spec.rb:6) – 00:11.535 (9947 / 1) of 00:21.986 (52.47%)
31921:27:40ReenqueueDedu...bjectsProjects (./spec/migrations/20240827204855_reenqueue_deduplicate_lfs_objects_projects_spec.rb:6) – 00:00.004 (7 / 1) of 00:00.017 (23.16%)
32021:27:40QueueBackfillUsersColorModeId (./spec/migrations/20240222075046_queue_backfill_users_color_mode_id_spec.rb:6) – 00:00.003 (7 / 1) of 00:00.016 (23.59%)
32121:27:40Knapsack report was generated. Preview:
32221:27:40{
32321:27:40 "spec/migrations/20241004064933_queue_fix_pick_up_at_ci_deleted_object_spec.rb": 21.27275307200034,
32421:27:40 "spec/migrations/20241001115912_queue_set_total_number_of_vulnerabilities_for_existing_projects_spec.rb": 15.412138331999813,
32521:27:40 "spec/migrations/20241024062434_queue_create_missing_external_links_for_vulnerabilities_spec.rb": 9.07537349499944
32621:27:40}
32721:27:40Knapsack global time execution for tests: 45s
32821:27:40Pending: (Failures listed here are expected and do not affect your suite's status)
32921:27:40 1) DeletePagesDomainWithReservedDomains migrates when a reserved domain is provided delete the domain
33021:27:40 # Skipping because migration DeletePagesDomainWithReservedDomains is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.
33121:27:40 # ./spec/migrations/20230913071219_delete_pages_domain_with_reserved_domains_spec.rb:9
33221:27:40 2) DeletePagesDomainWithReservedDomains migrates when a reserved domain is provided with non standard case delete the domain
33321:27:40 # Skipping because migration DeletePagesDomainWithReservedDomains is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.
33421:27:40 # ./spec/migrations/20230913071219_delete_pages_domain_with_reserved_domains_spec.rb:16
33521:27:40 3) DeletePagesDomainWithReservedDomains migrates when a non reserved domain is provided does not delete the domain
33621:27:40 # Skipping because migration DeletePagesDomainWithReservedDomains is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.
33721:27:40 # ./spec/migrations/20230913071219_delete_pages_domain_with_reserved_domains_spec.rb:23
33821:27:40 4) AddWorkItemsRolledupDatesWidget behaves like migration that adds widget to work items definitions #up creates widget definition in all types
33921:27:40 # Skipping because migration AddWorkItemsRolledupDatesWidget is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.
34021:27:40 # ./spec/support/shared_examples/migrations/add_work_item_widget_shared_examples.rb:12
34121:27:40 5) AddWorkItemsRolledupDatesWidget behaves like migration that adds widget to work items definitions #up when the widget already exists upserts the widget definitions and raises no error
34221:27:40 # Skipping because migration AddWorkItemsRolledupDatesWidget is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.
34321:27:40 # ./spec/support/shared_examples/migrations/add_work_item_widget_shared_examples.rb:33
34421:27:40 6) AddWorkItemsRolledupDatesWidget behaves like migration that adds widget to work items definitions #down removes definitions for widget
34521:27:40 # Skipping because migration AddWorkItemsRolledupDatesWidget is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.
34621:27:40 # ./spec/support/shared_examples/migrations/add_work_item_widget_shared_examples.rb:42
34721:27:40 7) QueueBackfillUsersColorModeId schedules a new batched migration
34821:27:40 # Skipping because migration QueueBackfillUsersColorModeId is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.
34921:27:40 # ./spec/migrations/20240222075046_queue_backfill_users_color_mode_id_spec.rb:9
35021:27:40 8) QueueBackfillApprovalMergeRequestRulesProjectId schedules a new batched migration
35121:27:40 # Skipping because migration QueueBackfillApprovalMergeRequestRulesProjectId is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.
35221:27:40 # ./spec/migrations/20240501044351_queue_backfill_approval_merge_request_rules_project_id_spec.rb:10
35321:27:40 9) DeleteInvalidRemoteMirrorsRecords#up deletes records without a project_id
35421:27:40 # Skipping because migration DeleteInvalidRemoteMirrorsRecords is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.
35521:27:40 # ./spec/migrations/20240523083208_delete_invalid_remote_mirrors_records_spec.rb:21
35621:27:40 10) DeleteInvalidRemoteMirrorsRecords#up does nothing on gitlab.com
35721:27:40 # Skipping because migration DeleteInvalidRemoteMirrorsRecords is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.
35821:27:40 # ./spec/migrations/20240523083208_delete_invalid_remote_mirrors_records_spec.rb:31
35921:27:40 11) QueueBackfillVulnerabilityMergeRequestLinksProjectId schedules a new batched migration
36021:27:40 # Skipping because migration QueueBackfillVulnerabilityMergeRequestLinksProjectId is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.
36121:27:40 # ./spec/migrations/20240607104717_queue_backfill_vulnerability_merge_request_links_project_id_spec.rb:10
36221:27:40 12) QueueBackfillVulnerabilityFindingsRemediationsProjectId schedules a new batched migration
36321:27:40 # Skipping because migration QueueBackfillVulnerabilityFindingsRemediationsProjectId is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.
36421:27:40 # ./spec/migrations/20240618121521_queue_backfill_vulnerability_findings_remediations_project_id_spec.rb:10
36521:27:40 13) RemoveIdxProjectStatisticsPackagesSizeAndProjectIdSync#up does nothing when not on gitlab.com
36621:27:40 # Skipping because migration RemoveIdxProjectStatisticsPackagesSizeAndProjectIdSync is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.
36721:27:40 # ./spec/migrations/20240708121845_remove_idx_project_statistics_packages_size_and_project_id_sync_spec.rb:13
36821:27:40 14) RemoveIdxProjectStatisticsPackagesSizeAndProjectIdSync#up removes the index when on gitlab.com
36921:27:40 # Skipping because migration RemoveIdxProjectStatisticsPackagesSizeAndProjectIdSync is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.
37021:27:40 # ./spec/migrations/20240708121845_remove_idx_project_statistics_packages_size_and_project_id_sync_spec.rb:19
37121:27:40 15) RemoveIdxProjectStatisticsPackagesSizeAndProjectIdSync#down does nothing when not on gitlab.com
37221:27:40 # Skipping because migration RemoveIdxProjectStatisticsPackagesSizeAndProjectIdSync is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.
37321:27:40 # ./spec/migrations/20240708121845_remove_idx_project_statistics_packages_size_and_project_id_sync_spec.rb:27
37421:27:40 16) RemoveIdxProjectStatisticsPackagesSizeAndProjectIdSync#down re-adds the index when on gitlab.com
37521:27:40 # Skipping because migration RemoveIdxProjectStatisticsPackagesSizeAndProjectIdSync is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.
37621:27:40 # ./spec/migrations/20240708121845_remove_idx_project_statistics_packages_size_and_project_id_sync_spec.rb:33
37721:27:40 17) QueueBackfillVulnerabilityOccurrencePipelinesProjectId does not schedule a new batched migration
37821:27:40 # Skipping because migration QueueBackfillVulnerabilityOccurrencePipelinesProjectId is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.
37921:27:40 # ./spec/migrations/20240730172818_queue_backfill_vulnerability_occurrence_pipelines_project_id_spec.rb:9
38021:27:40 18) ReenqueueDeduplicateLfsObjectsProjects schedules a new batched migration
38121:27:40 # Skipping because migration ReenqueueDeduplicateLfsObjectsProjects is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.
38221:27:40 # ./spec/migrations/20240827204855_reenqueue_deduplicate_lfs_objects_projects_spec.rb:9
38321:27:40 19) FinalizeBackfillEpicDatesToWorkItemDatesSources#up ensures the migration is completed for self-managed instances
38421:27:40 # Skipping because migration FinalizeBackfillEpicDatesToWorkItemDatesSources is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.
38521:27:40 # ./spec/migrations/db/post_migrate/20240702092809_finalize_backfill_epic_dates_to_work_item_dates_sources_spec.rb:8
38621:27:40Finished in 1 minute 52.7 seconds (files took 1 minute 4.19 seconds to load)
38721:27:4023 examples, 0 failures, 19 pending
38821:27:40Randomized with seed 2119
38921:27:46[TEST PROF INFO] Time spent in factories: 00:00.174 (0.15% of total time)
39021:27:47RSpec exited with 0.
39121:27:47No examples to retry, congrats!
392 21:27:47 Running after_script 00:16
39321:27:48Running after script...
39421:27:48$ source scripts/utils.sh
39521:27:48$ log_disk_usage
39621:27:48*******************************************************
39721:27:48This runner currently has 27G free disk space.
39821:27:48*******************************************************
399 21:27:48 Disk usage detail 00:08
45821:27:56$ bundle exec gem list gitlab_quality-test_tooling
45921:27:57gitlab_quality-test_tooling (2.1.0)
46021:27:57$ section_start "failed-test-issues" "Report test failures" # collapsed multi-line command
461 21:27:57 Report test failures 00:00
46321:27:57$ section_start "flaky-test-issues" "Report test flakiness" # collapsed multi-line command
464 21:27:57 Report test flakiness 00:00
46621:27:57$ section_start "slow-test-issues" "Report test slowness" # collapsed multi-line command
467 21:27:57 Report test slowness 00:00
46921:27:57$ section_start "slow-test-merge-request-report-note" "Report test slowness in MR note" # collapsed multi-line command
470 21:27:57 Report test slowness in MR note 00:02
47321:27:59$ section_start "knapsack-report-issues" "Report test files close to timing out" # collapsed multi-line command
474 21:27:59 Report test files close to timing out 00:02
47721:28:01$ tooling/bin/push_job_metrics || true
47821:28:03[job-metrics] Pushing job metrics file for the CI/CD job.
47921:28:03[job-metrics] Pushed 4 CI job metric entries to InfluxDB.
480 21:28:03 Saving cache for successful job 00:01
48121:28:04Not uploading cache ruby-gems-debian-bookworm-ruby-3.2.5-gemfile-Gemfile-20 due to policy
482 21:28:04 Uploading artifacts for successful job 00:06
48321:28:05Uploading artifacts...
48421:28:05auto_explain/: found 3 matching artifact files and directories
48521:28:05coverage/: found 5 matching artifact files and directories
48621:28:05crystalball/: found 2 matching artifact files and directories
48721:28:05WARNING: deprecations/: no matching files. Ensure that the artifact path is relative to the working directory (/builds/gitlab-org/gitlab)
48821:28:05knapsack/: found 4 matching artifact files and directories
48921:28:05rspec/: found 16 matching artifact files and directories
49021:28:05WARNING: tmp/capybara/: no matching files. Ensure that the artifact path is relative to the working directory (/builds/gitlab-org/gitlab)
49121:28:05log/*.log: found 13 matching artifact files and directories
49221:28:05WARNING: Upload request redirected location=https://gitlab.com/api/v4/jobs/8368446038/artifacts?artifact_format=zip&artifact_type=archive&expire_in=31d new-url=https://gitlab.com
49321:28:05WARNING: Retrying... context=artifacts-uploader error=request redirected
49421:28:08Uploading artifacts as "archive" to coordinator... 201 Created id=8368446038 responseStatus=201 Created token=glcbt-66
49521:28:08Uploading artifacts...
49621:28:08rspec/rspec-*.xml: found 1 matching artifact files and directories
49721:28:08WARNING: Upload request redirected location=https://gitlab.com/api/v4/jobs/8368446038/artifacts?artifact_format=gzip&artifact_type=junit&expire_in=31d new-url=https://gitlab.com
49821:28:08WARNING: Retrying... context=artifacts-uploader error=request redirected
49921:28:09Uploading artifacts as "junit" to coordinator... 201 Created id=8368446038 responseStatus=201 Created token=glcbt-66
500 21:28:10 Cleaning up project directory and file based variables 00:00
50121:28:19Job succeeded