Skip to content
Snippets Groups Projects

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

Passed Started by
Simon Tomlinson
@stomlinson
Log timestamps in UTC.
122:07:49Running with gitlab-runner 17.4.0~pre.110.g27400594 (27400594)
222:07:49 on blue-6.private.runners-manager.gitlab.com/gitlab.com/gitlab-org mKJTFBei, system ID: s_90a66139ec06
322:07:49 feature flags: FF_NETWORK_PER_BUILD:true, FF_TIMESTAMPS:true
422:07:49Resolving secrets
5 22:07:49 Preparing the "docker+machine" executor 00:12
622:07: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 ...
722:07:51Starting service registry.gitlab.com/gitlab-org/gitlab-build-images:postgres-14-pgvector-0.4.1...
822:07:51Authenticating with credentials from job payload (GitLab Registry)
922:07:51Pulling docker image registry.gitlab.com/gitlab-org/gitlab-build-images:postgres-14-pgvector-0.4.1 ...
1022:07: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 ...
1122:07:52WARNING: Service registry.gitlab.com/gitlab-org/gitlab-build-images:redis-cluster-6.2.12 is already created. Ignoring.
1222:07:52WARNING: Service registry.gitlab.com/gitlab-org/gitlab-build-images:redis-cluster-6.2.12 is already created. Ignoring.
1322:07:52Starting service registry.gitlab.com/gitlab-org/gitlab-build-images:redis-cluster-6.2.12...
1422:07:52Authenticating with credentials from job payload (GitLab Registry)
1522:07:52Pulling docker image registry.gitlab.com/gitlab-org/gitlab-build-images:redis-cluster-6.2.12 ...
1622:07: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 ...
1722:07:53Starting service redis:6.2-alpine...
1822:07:54Pulling docker image redis:6.2-alpine ...
1922:07:54Using docker image sha256:4100b5bd17430263e85ad9d8ab851959b234acaaf378e093f1f98400f4998815 for redis:6.2-alpine with digest redis@sha256:eaba718fecd1196d88533de7ba49bf903ad33664a92debb24660a922ecd9cac8 ...
2022:07:55Waiting for services to be up and running (timeout 30 seconds)...
2122:08:00Authenticating with credentials from job payload (GitLab Registry)
2222:08:00Pulling 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 ...
2322:08:01Using 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 22:08:01 Preparing environment 00:00
2522:08:01Running on runner-mkjtfbei-project-278964-concurrent-0 via runner-mkjtfbei-private-1731530913-867290e8...
26 22:08:01 Getting source from Git repository 00:01
2722:08:02Skipping Git repository setup
2822:08:02Skipping Git checkout
2922:08:02Skipping Git submodules setup
30 22:08:02 Restoring cache 00:19
3122:08:02Checking cache for ruby-gems-debian-bookworm-ruby-3.2.5-gemfile-Gemfile-20...
3222:08:02Downloading 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"
3322:08:15Successfully extracted cache
34 22:08:21 Downloading artifacts 00:47
3522:08:22Downloading artifacts for clone-gitlab-repo (8353286583)...
3622:08:27Downloading artifacts from coordinator... ok host=storage.googleapis.com id=8353286583 responseStatus=200 OK token=glcbt-66
3722:08:27WARNING: Part of .git directory is on the list of files to extract
3822:08:27WARNING: This may introduce unexpected problems
3922:08:39Downloading artifacts for compile-test-assets (8353286630)...
4022:08:43Downloading artifacts from coordinator... ok host=storage.googleapis.com id=8353286630 responseStatus=200 OK token=glcbt-66
4122:08:49Downloading artifacts for detect-tests (8353286649)...
4222:08:50Downloading artifacts from coordinator... ok host=storage.googleapis.com id=8353286649 responseStatus=200 OK token=glcbt-66
4322:08:50Downloading artifacts for retrieve-tests-metadata (8353286664)...
4422:08:51Downloading artifacts from coordinator... ok host=storage.googleapis.com id=8353286664 responseStatus=200 OK token=glcbt-66
4522:08:51Downloading artifacts for setup-test-env (8353286635)...
4622:08:56Downloading artifacts from coordinator... ok host=storage.googleapis.com id=8353286635 responseStatus=200 OK token=glcbt-66
47 22:09:08 Executing "step_script" stage of the job script
4822:09:08Using 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 ...
4922:09:09$ echo $FOSS_ONLY
5022:09:09$ [ "$FOSS_ONLY" = "1" ] && rm -rf ee/ qa/spec/ee/ qa/qa/specs/features/ee/ qa/qa/ee/ qa/qa/ee.rb
5122:09:09$ export GOPATH=$CI_PROJECT_DIR/.go
5222:09:09$ mkdir -p $GOPATH
5322:09:09$ source scripts/utils.sh
5422:09:09$ log_disk_usage "true"
5522:09:09*******************************************************
5622:09:09This runner currently has 67G free disk space.
5722:09:09*******************************************************
58 22:09:09 Disk usage detail 00:05
5922:09:09df -h
6022:09:09Filesystem Size Used Avail Use% Mounted on
6122:09:09overlay 95G 28G 67G 30% /
6222:09:09tmpfs 64M 0 64M 0% /dev
6322:09:09shm 64M 0 64M 0% /dev/shm
6422:09:09/dev/sda1 95G 28G 67G 30% /cache
6522:09:09tmpfs 3.9G 0 3.9G 0% /sys/devices/virtual/dmi/id
6622:09:09du -h -d 1
6722:09:097.4M ./workhorse
6822:09:09148K ./bin
6922:09:091.2M ./.gitlab
7022:09:09167M ./.git
7122:09:094.0K ./builds
7222:09:0928M ./lib
7322:09:098.0K ./.vscode
7422:09:09560K ./storybook
7522:09:0924K ./log
7622:09:091.8M ./data
7722:09:0911M ./qa
7822:09:093.2M ./.rubocop_todo
7922:09:09856M ./vendor
8022:09:091023M ./public
8122:09:0962M ./doc
8222:09:09484K ./danger
8322:09:0932K ./rspec
8422:09:09556K ./tooling
8522:09:09145M ./ee
8622:09:091.3M ./knapsack
8722:09:09300K ./patches
8822:09:094.3M ./changelogs
8922:09:0920K ./haml_lint
9022:09:0928K ./metrics_server
9122:09:09108K ./keeps
9222:09:0936K ./shared
9322:09:0944K ./generator_templates
9422:09:091.3M ./scripts
9522:09:09763M ./tmp
9622:09:10127M ./spec
9722:09:1020K ./file_hooks
9822:09:1032K ./crystalball
9922:09:1016K ./sidekiq_cluster
10022:09:1017M ./gems
10122:09:101.2M ./fixtures
10222:09:10964K ./rubocop
10322:09:104.0K ./.go
10422:09:1033M ./db
10522:09:1012K ./.github
10622:09:10129M ./locale
10722:09:1020M ./config
10822:09:1082M ./app
10922:09:1020K ./.lefthook
11022:09:103.5G .
11122:09:10$ source scripts/prepare_build.sh
112 22:09:10 Installing gems 00:26
14322:09:36Using two connections, single database config (config/database.yml.postgresql)
14422:09:36Geo DB won't be set up.
14522:09:36Embedding DB won't be set up.
146 22:09:36 Setting up DBs 01:14
15922:10:50$ source ./scripts/rspec_helpers.sh
16022:10:50$ run_timed_command "gem install knapsack --no-document"
16122:10:50$ gem install knapsack --no-document
16222:10:53Successfully installed knapsack-4.0.0
16322:10:531 gem installed
16422:10:50==> 'gem install knapsack --no-document' succeeded in 3 seconds.
16522:10:53$ section_start "gitaly-test-spawn" "Spawning Gitaly"; scripts/gitaly-test-spawn; section_end "gitaly-test-spawn"
166 22:10:53 Spawning Gitaly 00:05
17022:10:58$ export RSPEC_SKIPPED_TESTS_REPORT_PATH="rspec/skipped_tests-${CI_JOB_ID}.txt"
17122:10:58$ export RSPEC_RETRIED_TESTS_REPORT_PATH="rspec/retried_tests-${CI_JOB_ID}.txt"
17222:10:58$ tooling/bin/create_job_metrics_file || true
17322:11:02[job-metrics] Creating the job metrics file for the CI/CD job.
17422:11:02$ rspec_section rspec_parallelized_job "--fail-fast=${RSPEC_FAIL_FAST_THRESHOLD} --tag ~quarantine --tag ~zoekt --tag ~click_house"
175 22:11:02 RSpec 06:05
17622:11:02[22:11:02] Starting rspec_parallelized_job
17722:10:53RETRY_FAILED_TESTS_IN_NEW_PROCESS: true
17822:11:02KNAPSACK_GENERATE_REPORT: true
17922:11:02FLAKY_RSPEC_GENERATE_REPORT: true
18022:11:02KNAPSACK_TEST_FILE_PATTERN: spec/{migrations}{,/**/}*_spec.rb
18122:11:02KNAPSACK_LOG_LEVEL: debug
18222:11:02KNAPSACK_REPORT_PATH: knapsack/rspec_migration_pg14_single-db-ci-connection_19_26_278964_report.json
18322:11:02FLAKY_RSPEC_SUITE_REPORT_PATH: rspec/flaky/report-suite.json
18422:11:02FLAKY_RSPEC_REPORT_PATH: rspec/flaky/all_rspec_migration_pg14_single-db-ci-connection_19_26_278964_report.json
18522:11:02NEW_FLAKY_RSPEC_REPORT_PATH: rspec/flaky/new_rspec_migration_pg14_single-db-ci-connection_19_26_278964_report.json
18622:11:02RSPEC_SKIPPED_TESTS_REPORT_PATH: rspec/skipped_tests-8353287333.txt
18722:11:02CRYSTALBALL:
18822:11:02RSPEC_TESTS_MAPPING_ENABLED:
18922:11:02RSPEC_TESTS_FILTER_FILE:
19022:11:02Shell set options (set -o) enabled:
19122:11:02braceexpand on
19222:11:02hashall on
19322:11:02interactive-comments on
19422:11:02pipefail on
19522:11:08Knapsack report generator started!
19622:11:02/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!
19722:12:06DEPRECATION 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)
19822:12:20warning: parser/current is loading parser/ruby32, which recognizes 3.2.6-compliant syntax, but you are running 3.2.5.
19922:12:20Please see https://github.com/whitequark/parser#compatibility-with-ruby-mri.
20022:12:26Run options: exclude {:quarantine=>true, :zoekt=>true, :click_house=>true}
20122:12:26# [RSpecRunTime] Starting RSpec timer...
20222:12:26[TEST PROF INFO] EventProf enabled (sql.active_record)
20322:12:26unknown OID 2249: failed to recognize type of 'pg_stat_file'. It will be treated as String.
20422:12:36Test environment set up in 3.182383921 seconds
20522:12:37# [RSpecRunTime] Starting example group spec/migrations/20240920072729_remove_dangling_cron_worker_spec.rb. Expected to take 27.9 seconds.
20622:12:37RemoveDanglingCronWorker
20722:12:49 when cron job exists
20822:12:50main: == [advisory_lock_connection] object_id: 2762340, pg_backend_pid: 132
20922:12:50main: == 20240920072729 RemoveDanglingCronWorker: migrating =========================
21022:12:50main: == 20240920072729 RemoveDanglingCronWorker: migrated (0.0407s) ================
21122:12:51main: == [advisory_lock_connection] object_id: 2762340, pg_backend_pid: 132
21222:12:55 deletes the cron job and enqueued jobs
21322:12:55 when cron job does not exist
21422:12:56main: == [advisory_lock_connection] object_id: 3382280, pg_backend_pid: 135
21522:12:56main: == 20240920072729 RemoveDanglingCronWorker: migrating =========================
21622:12:56main: == 20240920072729 RemoveDanglingCronWorker: migrated (0.0086s) ================
21722:12:56main: == [advisory_lock_connection] object_id: 3382280, pg_backend_pid: 135
21822:13:01 no-ops
21922:13:01# [RSpecRunTime] RSpec elapsed time: 35.14 seconds. Current RSS: ~1205M. Threads: 1. load average: 1.18 1.29 1.36 1/268 388
22022:13:01.
22122:13:31# [RSpecRunTime] Finishing example group spec/migrations/20240920072729_remove_dangling_cron_worker_spec.rb. It took 54.72 seconds. Expected to take 27.9 seconds.
22222:13:32# [RSpecRunTime] RSpec elapsed time: 1 minute 5.57 seconds. Current RSS: ~1202M. Threads: 1. load average: 1.11 1.26 1.34 1/268 390
22322:13:32.
22422:13:32# [RSpecRunTime] Starting example group spec/migrations/20240927202948_reenqueue_deduplicate_lfs_objects_projects_with_null_repository_types_spec.rb. Expected to take 20.4 seconds.
22522:13:32ReenqueueDeduplicateLfsObjectsProjectsWithNullRepositoryTypes
22622:13:44main: == [advisory_lock_connection] object_id: 8653860, pg_backend_pid: 145
22722:13:44main: == 20240927202948 ReenqueueDeduplicateLfsObjectsProjectsWithNullRepositoryTypes: migrating
22822:13:45main: == 20240927202948 ReenqueueDeduplicateLfsObjectsProjectsWithNullRepositoryTypes: migrated (0.1045s)
22922:13:45main: == [advisory_lock_connection] object_id: 8653860, pg_backend_pid: 145
23022:13:50 schedules a new batched migration
23122:14:17# [RSpecRunTime] Finishing example group spec/migrations/20240927202948_reenqueue_deduplicate_lfs_objects_projects_with_null_repository_types_spec.rb. It took 45.47 seconds. Expected to take 20.4 seconds.
23222:14:17# [RSpecRunTime] RSpec elapsed time: 1 minute 51.09 seconds. Current RSS: ~1203M. Threads: 1. load average: 0.95 1.21 1.32 1/268 391
23322:14:17.
23422:14:17# [RSpecRunTime] Starting example group spec/migrations/20240918204510_set_correct_id_to_existing_work_item_types_spec.rb. Expected to take 14.47 seconds.
23522:14:17SetCorrectIdToExistingWorkItemTypes
23622:14:31main: == [advisory_lock_connection] object_id: 13913900, pg_backend_pid: 157
23722:14:31main: == 20240918204510 SetCorrectIdToExistingWorkItemTypes: migrating ==============
23822:14:32main: == 20240918204510 SetCorrectIdToExistingWorkItemTypes: migrated (0.0369s) =====
23922:14:32main: == [advisory_lock_connection] object_id: 13913900, pg_backend_pid: 157
24022:14:33 sets the correct id for every record in the table
24122:15:01# [RSpecRunTime] Finishing example group spec/migrations/20240918204510_set_correct_id_to_existing_work_item_types_spec.rb. It took 43.54 seconds. Expected to take 14.47 seconds.
24222:15:01# [RSpecRunTime] RSpec elapsed time: 2 minutes 34.68 seconds. Current RSS: ~1204M. Threads: 1. load average: 1.54 1.31 1.35 1/269 392
24322:15:01.
24422:15:01# [RSpecRunTime] Starting example group spec/migrations/20231025025733_swap_columns_for_ci_pipelines_pipeline_id_bigint_for_self_host_spec.rb. Missing expected duration from Knapsack report for spec/migrations/20231025025733_swap_columns_for_ci_pipelines_pipeline_id_bigint_for_self_host_spec.rb.
24522:15:01SwapColumnsForCiPipelinesPipelineIdBigintForSelfHost
24622:15:01 behaves like swap conversion columns
24722:15:01 correctly swaps conversion columns (PENDING: Skipping because migration SwapColumnsForCiPipelinesPipelineIdBigintForSelfHost is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.)
24822:15:01 when foreign key names are different
24922:15:01 swaps the foreign key properly (PENDING: Skipping because migration SwapColumnsForCiPipelinesPipelineIdBigintForSelfHost is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.)
25022:15:01 when foreign key is missing
25122:15:01 raises error (PENDING: Skipping because migration SwapColumnsForCiPipelinesPipelineIdBigintForSelfHost is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.)
25222:15:01# [RSpecRunTime] Finishing example group spec/migrations/20231025025733_swap_columns_for_ci_pipelines_pipeline_id_bigint_for_self_host_spec.rb. It took 0.02 second. Missing expected duration from Knapsack report for spec/migrations/20231025025733_swap_columns_for_ci_pipelines_pipeline_id_bigint_for_self_host_spec.rb.
25322:15:01# [RSpecRunTime] Starting example group spec/migrations/20240116211138_update_max_code_indexing_concurrency_in_application_settings_for_gitlab_com_spec.rb. Missing expected duration from Knapsack report for spec/migrations/20240116211138_update_max_code_indexing_concurrency_in_application_settings_for_gitlab_com_spec.rb.
25422:15:01UpdateMaxCodeIndexingConcurrencyInApplicationSettingsForGitlabCom
25522:15:01 #up
25622:15:01 does nothing when not in gitlab.com (PENDING: Skipping because migration UpdateMaxCodeIndexingConcurrencyInApplicationSettingsForGitlabCom is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.)
25722:15:01 updates elasticsearch_worker_number_of_shards when gitlab.com (PENDING: Skipping because migration UpdateMaxCodeIndexingConcurrencyInApplicationSettingsForGitlabCom is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.)
25822:15:01 #down
25922:15:01 does nothing when not in gitlab.com (PENDING: Skipping because migration UpdateMaxCodeIndexingConcurrencyInApplicationSettingsForGitlabCom is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.)
26022:15:01 updates elasticsearch_worker_number_of_shards when gitlab.com (PENDING: Skipping because migration UpdateMaxCodeIndexingConcurrencyInApplicationSettingsForGitlabCom is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.)
26122:15:01# [RSpecRunTime] Finishing example group spec/migrations/20240116211138_update_max_code_indexing_concurrency_in_application_settings_for_gitlab_com_spec.rb. It took 0.02 second. Missing expected duration from Knapsack report for spec/migrations/20240116211138_update_max_code_indexing_concurrency_in_application_settings_for_gitlab_com_spec.rb.
26222:15:01# [RSpecRunTime] Starting example group spec/migrations/20240409023046_queue_fix_corrupted_scanner_ids_of_vulnerability_reads_spec.rb. Missing expected duration from Knapsack report for spec/migrations/20240409023046_queue_fix_corrupted_scanner_ids_of_vulnerability_reads_spec.rb.
26322:15:01QueueFixCorruptedScannerIdsOfVulnerabilityReads
26422:15:01 schedules a new batched migration (PENDING: Skipping because migration QueueFixCorruptedScannerIdsOfVulnerabilityReads is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.)
26522:15:01# [RSpecRunTime] Finishing example group spec/migrations/20240409023046_queue_fix_corrupted_scanner_ids_of_vulnerability_reads_spec.rb. It took 0.02 second. Missing expected duration from Knapsack report for spec/migrations/20240409023046_queue_fix_corrupted_scanner_ids_of_vulnerability_reads_spec.rb.
26622:15:01# [RSpecRunTime] Starting example group spec/migrations/20240515155723_queue_backfill_design_management_repositories_namespace_id_spec.rb. Missing expected duration from Knapsack report for spec/migrations/20240515155723_queue_backfill_design_management_repositories_namespace_id_spec.rb.
26722:15:01QueueBackfillDesignManagementRepositoriesNamespaceId
26822:15:01 schedules a new batched migration (PENDING: Skipping because migration QueueBackfillDesignManagementRepositoriesNamespaceId is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.)
26922:15:01# [RSpecRunTime] Finishing example group spec/migrations/20240515155723_queue_backfill_design_management_repositories_namespace_id_spec.rb. It took 0.02 second. Missing expected duration from Knapsack report for spec/migrations/20240515155723_queue_backfill_design_management_repositories_namespace_id_spec.rb.
27022:15:01# [RSpecRunTime] Starting example group spec/migrations/20240604145223_queue_backfill_dast_profiles_tags_project_id_spec.rb. Missing expected duration from Knapsack report for spec/migrations/20240604145223_queue_backfill_dast_profiles_tags_project_id_spec.rb.
27122:15:01QueueBackfillDastProfilesTagsProjectId
27222:15:01 schedules a new batched migration (PENDING: Skipping because migration QueueBackfillDastProfilesTagsProjectId is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.)
27322:15:01# [RSpecRunTime] Finishing example group spec/migrations/20240604145223_queue_backfill_dast_profiles_tags_project_id_spec.rb. It took 0.02 second. Missing expected duration from Knapsack report for spec/migrations/20240604145223_queue_backfill_dast_profiles_tags_project_id_spec.rb.
27422:15:01# [RSpecRunTime] Starting example group spec/migrations/20240612073059_queue_backfill_operations_strategies_user_lists_project_id_spec.rb. Missing expected duration from Knapsack report for spec/migrations/20240612073059_queue_backfill_operations_strategies_user_lists_project_id_spec.rb.
27522:15:01QueueBackfillOperationsStrategiesUserListsProjectId
27622:15:01 schedules a new batched migration (PENDING: Skipping because migration QueueBackfillOperationsStrategiesUserListsProjectId is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.)
27722:15:01# [RSpecRunTime] Finishing example group spec/migrations/20240612073059_queue_backfill_operations_strategies_user_lists_project_id_spec.rb. It took 0.02 second. Missing expected duration from Knapsack report for spec/migrations/20240612073059_queue_backfill_operations_strategies_user_lists_project_id_spec.rb.
27822:15:01# [RSpecRunTime] Starting example group spec/migrations/20240627133840_queue_backfill_packages_debian_project_components_project_id_spec.rb. Missing expected duration from Knapsack report for spec/migrations/20240627133840_queue_backfill_packages_debian_project_components_project_id_spec.rb.
27922:15:01QueueBackfillPackagesDebianProjectComponentsProjectId
28022:15:01 schedules a new batched migration (PENDING: Skipping because migration QueueBackfillPackagesDebianProjectComponentsProjectId is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.)
28122:15:01# [RSpecRunTime] Finishing example group spec/migrations/20240627133840_queue_backfill_packages_debian_project_components_project_id_spec.rb. It took 0.02 second. Missing expected duration from Knapsack report for spec/migrations/20240627133840_queue_backfill_packages_debian_project_components_project_id_spec.rb.
28222:15:01# [RSpecRunTime] Starting example group spec/migrations/20240722095915_queue_backfill_compliance_framework_security_policies_project_id_spec.rb. Missing expected duration from Knapsack report for spec/migrations/20240722095915_queue_backfill_compliance_framework_security_policies_project_id_spec.rb.
28322:15:01QueueBackfillComplianceFrameworkSecurityPoliciesProjectId
28422:15:01 schedules a new batched migration (PENDING: Skipping because migration QueueBackfillComplianceFrameworkSecurityPoliciesProjectId is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.)
28522:15:01# [RSpecRunTime] Finishing example group spec/migrations/20240722095915_queue_backfill_compliance_framework_security_policies_project_id_spec.rb. It took 0.02 second. Missing expected duration from Knapsack report for spec/migrations/20240722095915_queue_backfill_compliance_framework_security_policies_project_id_spec.rb.
28622:15:01# [RSpecRunTime] Starting example group spec/migrations/20240814104154_queue_backfill_protected_env_approval_rules_protected_env_project_id_spec.rb. Missing expected duration from Knapsack report for spec/migrations/20240814104154_queue_backfill_protected_env_approval_rules_protected_env_project_id_spec.rb.
28722:15:01QueueBackfillProtectedEnvApprovalRulesProtectedEnvProjectId
28822:15:01 schedules a new batched migration (PENDING: Skipping because migration QueueBackfillProtectedEnvApprovalRulesProtectedEnvProjectId is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.)
28922:15:01# [RSpecRunTime] Finishing example group spec/migrations/20240814104154_queue_backfill_protected_env_approval_rules_protected_env_project_id_spec.rb. It took 0.02 second. Missing expected duration from Knapsack report for spec/migrations/20240814104154_queue_backfill_protected_env_approval_rules_protected_env_project_id_spec.rb.
29022:15:01# [RSpecRunTime] Starting example group spec/migrations/db/migrate/20231103162825_add_wolfi_purl_type_to_package_metadata_purl_types_spec.rb. Missing expected duration from Knapsack report for spec/migrations/db/migrate/20231103162825_add_wolfi_purl_type_to_package_metadata_purl_types_spec.rb.
29122:15:01AddWolfiPurlTypeToPackageMetadataPurlTypes
29222:15:01 #up
29322:15:01 updates setting (PENDING: Skipping because migration AddWolfiPurlTypeToPackageMetadataPurlTypes is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.)
29422:15:01 #down
29522:15:01 with default value
29622:15:01 updates setting (PENDING: Skipping because migration AddWolfiPurlTypeToPackageMetadataPurlTypes is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.)
29722:15:01# [RSpecRunTime] Finishing example group spec/migrations/db/migrate/20231103162825_add_wolfi_purl_type_to_package_metadata_purl_types_spec.rb. It took 0.02 second. Missing expected duration from Knapsack report for spec/migrations/db/migrate/20231103162825_add_wolfi_purl_type_to_package_metadata_purl_types_spec.rb.
29822:15:01# [RSpecRunTime] Starting example group spec/migrations/fix_sequence_owners_for_ci_builds_spec.rb. Missing expected duration from Knapsack report for spec/migrations/fix_sequence_owners_for_ci_builds_spec.rb.
29922:15:01FixSequenceOwnersForCiBuilds
30022:15:01 #up
30122:15:01 fixes sequence ownership (PENDING: Skipping because migration FixSequenceOwnersForCiBuilds is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.)
30222:15:01 does not modify sequences not owned by ci_builds or p_ci_builds (PENDING: Skipping because migration FixSequenceOwnersForCiBuilds is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.)
30322:15:01 ignores unknown sequences (PENDING: Skipping because migration FixSequenceOwnersForCiBuilds is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.)
30422:15:01# [RSpecRunTime] Finishing example group spec/migrations/fix_sequence_owners_for_ci_builds_spec.rb. It took 0.02 second. Missing expected duration from Knapsack report for spec/migrations/fix_sequence_owners_for_ci_builds_spec.rb.
30522:15:03auto_explain log contains 845 entries for main, writing to /builds/gitlab-org/gitlab/auto_explain/rspec-migration-pg14-single-db-ci-connection-19-26.342.main.ndjson.gz
30622:15:03took 1.997307544
30722:15:05auto_explain log contains 846 entries for ci, writing to /builds/gitlab-org/gitlab/auto_explain/rspec-migration-pg14-single-db-ci-connection-19-26.342.ci.ndjson.gz
30822:15:05took 1.975364025
30922:15:05[TEST PROF INFO] EventProf results for sql.active_record
31022:15:05Total time: 01:12.478 of 02:24.085 (50.3%)
31122:15:05Total events: 55038
31222:15:05Top 5 slowest suites (by time):
31322:15:05RemoveDanglingCronWorker (./spec/migrations/20240920072729_remove_dangling_cron_worker_spec.rb:6) – 00:26.749 (21074 / 2) of 00:54.767 (48.84%)
31422:15:05SetCorrectIdT...gWorkItemTypes (./spec/migrations/20240918204510_set_correct_id_to_existing_work_item_types_spec.rb:6) – 00:22.952 (16438 / 1) of 00:43.587 (52.66%)
31522:15:05ReenqueueDedu...epositoryTypes (./spec/migrations/20240927202948_reenqueue_deduplicate_lfs_objects_projects_with_null_repository_types_spec.rb:6) – 00:22.737 (17449 / 1) of 00:45.521 (49.95%)
31622:15:05AddWolfiPurlT...adataPurlTypes (./spec/migrations/db/migrate/20231103162825_add_wolfi_purl_type_to_package_metadata_purl_types_spec.rb:6) – 00:00.003 (7 / 2) of 00:00.019 (19.76%)
31722:15:05QueueBackfill...iciesProjectId (./spec/migrations/20240722095915_queue_backfill_compliance_framework_security_policies_project_id_spec.rb:6) – 00:00.003 (7 / 1) of 00:00.019 (19.9%)
31822:15:05Knapsack report was generated. Preview:
31922:15:05{
32022:15:05 "spec/migrations/20240920072729_remove_dangling_cron_worker_spec.rb": 24.795910358000583,
32122:15:05 "spec/migrations/20240927202948_reenqueue_deduplicate_lfs_objects_projects_with_null_repository_types_spec.rb": 18.57981551099965,
32222:15:05 "spec/migrations/20240918204510_set_correct_id_to_existing_work_item_types_spec.rb": 15.590752334000172
32322:15:05}
32422:15:05Knapsack global time execution for tests: 58s
32522:15:05Pending: (Failures listed here are expected and do not affect your suite's status)
32622:15:05 1) SwapColumnsForCiPipelinesPipelineIdBigintForSelfHost behaves like swap conversion columns correctly swaps conversion columns
32722:15:05 # Skipping because migration SwapColumnsForCiPipelinesPipelineIdBigintForSelfHost is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.
32822:15:05 # ./spec/support/shared_examples/migrations/swap_conversion_columns_shared_examples.rb:26
32922:15:05 2) SwapColumnsForCiPipelinesPipelineIdBigintForSelfHost when foreign key names are different swaps the foreign key properly
33022:15:05 # Skipping because migration SwapColumnsForCiPipelinesPipelineIdBigintForSelfHost is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.
33122:15:05 # ./spec/migrations/20231025025733_swap_columns_for_ci_pipelines_pipeline_id_bigint_for_self_host_spec.rb:50
33222:15:05 3) SwapColumnsForCiPipelinesPipelineIdBigintForSelfHost when foreign key is missing raises error
33322:15:05 # Skipping because migration SwapColumnsForCiPipelinesPipelineIdBigintForSelfHost is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.
33422:15:05 # ./spec/migrations/20231025025733_swap_columns_for_ci_pipelines_pipeline_id_bigint_for_self_host_spec.rb:83
33522:15:05 4) UpdateMaxCodeIndexingConcurrencyInApplicationSettingsForGitlabCom#up does nothing when not in gitlab.com
33622:15:05 # Skipping because migration UpdateMaxCodeIndexingConcurrencyInApplicationSettingsForGitlabCom is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.
33722:15:05 # ./spec/migrations/20240116211138_update_max_code_indexing_concurrency_in_application_settings_for_gitlab_com_spec.rb:12
33822:15:05 5) UpdateMaxCodeIndexingConcurrencyInApplicationSettingsForGitlabCom#up updates elasticsearch_worker_number_of_shards when gitlab.com
33922:15:05 # Skipping because migration UpdateMaxCodeIndexingConcurrencyInApplicationSettingsForGitlabCom is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.
34022:15:05 # ./spec/migrations/20240116211138_update_max_code_indexing_concurrency_in_application_settings_for_gitlab_com_spec.rb:18
34122:15:05 6) UpdateMaxCodeIndexingConcurrencyInApplicationSettingsForGitlabCom#down does nothing when not in gitlab.com
34222:15:05 # Skipping because migration UpdateMaxCodeIndexingConcurrencyInApplicationSettingsForGitlabCom is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.
34322:15:05 # ./spec/migrations/20240116211138_update_max_code_indexing_concurrency_in_application_settings_for_gitlab_com_spec.rb:30
34422:15:05 7) UpdateMaxCodeIndexingConcurrencyInApplicationSettingsForGitlabCom#down updates elasticsearch_worker_number_of_shards when gitlab.com
34522:15:05 # Skipping because migration UpdateMaxCodeIndexingConcurrencyInApplicationSettingsForGitlabCom is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.
34622:15:05 # ./spec/migrations/20240116211138_update_max_code_indexing_concurrency_in_application_settings_for_gitlab_com_spec.rb:38
34722:15:05 8) QueueFixCorruptedScannerIdsOfVulnerabilityReads schedules a new batched migration
34822:15:05 # Skipping because migration QueueFixCorruptedScannerIdsOfVulnerabilityReads is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.
34922:15:05 # ./spec/migrations/20240409023046_queue_fix_corrupted_scanner_ids_of_vulnerability_reads_spec.rb:9
35022:15:05 9) QueueBackfillDesignManagementRepositoriesNamespaceId schedules a new batched migration
35122:15:05 # Skipping because migration QueueBackfillDesignManagementRepositoriesNamespaceId is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.
35222:15:05 # ./spec/migrations/20240515155723_queue_backfill_design_management_repositories_namespace_id_spec.rb:9
35322:15:05 10) QueueBackfillDastProfilesTagsProjectId schedules a new batched migration
35422:15:05 # Skipping because migration QueueBackfillDastProfilesTagsProjectId is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.
35522:15:05 # ./spec/migrations/20240604145223_queue_backfill_dast_profiles_tags_project_id_spec.rb:10
35622:15:05 11) QueueBackfillOperationsStrategiesUserListsProjectId schedules a new batched migration
35722:15:05 # Skipping because migration QueueBackfillOperationsStrategiesUserListsProjectId is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.
35822:15:05 # ./spec/migrations/20240612073059_queue_backfill_operations_strategies_user_lists_project_id_spec.rb:10
35922:15:05 12) QueueBackfillPackagesDebianProjectComponentsProjectId schedules a new batched migration
36022:15:05 # Skipping because migration QueueBackfillPackagesDebianProjectComponentsProjectId is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.
36122:15:05 # ./spec/migrations/20240627133840_queue_backfill_packages_debian_project_components_project_id_spec.rb:10
36222:15:05 13) QueueBackfillComplianceFrameworkSecurityPoliciesProjectId schedules a new batched migration
36322:15:05 # Skipping because migration QueueBackfillComplianceFrameworkSecurityPoliciesProjectId is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.
36422:15:05 # ./spec/migrations/20240722095915_queue_backfill_compliance_framework_security_policies_project_id_spec.rb:9
36522:15:05 14) QueueBackfillProtectedEnvApprovalRulesProtectedEnvProjectId schedules a new batched migration
36622:15:05 # Skipping because migration QueueBackfillProtectedEnvApprovalRulesProtectedEnvProjectId is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.
36722:15:05 # ./spec/migrations/20240814104154_queue_backfill_protected_env_approval_rules_protected_env_project_id_spec.rb:9
36822:15:05 15) AddWolfiPurlTypeToPackageMetadataPurlTypes#up updates setting
36922:15:05 # Skipping because migration AddWolfiPurlTypeToPackageMetadataPurlTypes is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.
37022:15:05 # ./spec/migrations/db/migrate/20231103162825_add_wolfi_purl_type_to_package_metadata_purl_types_spec.rb:10
37122:15:05 16) AddWolfiPurlTypeToPackageMetadataPurlTypes#down with default value updates setting
37222:15:05 # Skipping because migration AddWolfiPurlTypeToPackageMetadataPurlTypes is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.
37322:15:05 # ./spec/migrations/db/migrate/20231103162825_add_wolfi_purl_type_to_package_metadata_purl_types_spec.rb:23
37422:15:05 17) FixSequenceOwnersForCiBuilds#up fixes sequence ownership
37522:15:05 # Skipping because migration FixSequenceOwnersForCiBuilds is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.
37622:15:05 # ./spec/migrations/fix_sequence_owners_for_ci_builds_spec.rb:27
37722:15:05 18) FixSequenceOwnersForCiBuilds#up does not modify sequences not owned by ci_builds or p_ci_builds
37822:15:05 # Skipping because migration FixSequenceOwnersForCiBuilds is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.
37922:15:05 # ./spec/migrations/fix_sequence_owners_for_ci_builds_spec.rb:39
38022:15:05 19) FixSequenceOwnersForCiBuilds#up ignores unknown sequences
38122:15:05 # Skipping because migration FixSequenceOwnersForCiBuilds is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.
38222:15:05 # ./spec/migrations/fix_sequence_owners_for_ci_builds_spec.rb:52
38322:15:05Finished in 2 minutes 39 seconds (files took 1 minute 21.36 seconds to load)
38422:15:0523 examples, 0 failures, 19 pending
38522:15:05Randomized with seed 37700
38622:15:12[TEST PROF INFO] Time spent in factories: 00:00.206 (0.13% of total time)
38722:15:12RSpec exited with 0.
38822:15:12No examples to retry, congrats!
389 22:15:13 Running after_script 00:13
39022:15:13Running after script...
39122:15:13$ source scripts/utils.sh
39222:15:13$ log_disk_usage
39322:15:14*******************************************************
39422:15:14This runner currently has 66G free disk space.
39522:15:14*******************************************************
396 22:15:14 Disk usage detail 00:05
45222:15:19$ bundle exec gem list gitlab_quality-test_tooling
45322:15:20gitlab_quality-test_tooling (2.1.0)
45422:15:20$ section_start "failed-test-issues" "Report test failures" # collapsed multi-line command
455 22:15:20 Report test failures 00:00
45722:15:20$ section_start "flaky-test-issues" "Report test flakiness" # collapsed multi-line command
458 22:15:20 Report test flakiness 00:00
46022:15:20$ section_start "slow-test-issues" "Report test slowness" # collapsed multi-line command
461 22:15:20 Report test slowness 00:00
46322:15:20$ section_start "slow-test-merge-request-report-note" "Report test slowness in MR note" # collapsed multi-line command
464 22:15:20 Report test slowness in MR note 00:02
46722:15:22$ section_start "knapsack-report-issues" "Report test files close to timing out" # collapsed multi-line command
468 22:15:22 Report test files close to timing out 00:02
47122:15:24$ tooling/bin/push_job_metrics || true
47222:15:25[job-metrics] Pushing job metrics file for the CI/CD job.
47322:15:25[job-metrics] Pushed 4 CI job metric entries to InfluxDB.
474 22:15:26 Saving cache for successful job 00:01
47522:15:26Not uploading cache ruby-gems-debian-bookworm-ruby-3.2.5-gemfile-Gemfile-20 due to policy
476 22:15:27 Uploading artifacts for successful job 00:05
47722:15:28Uploading artifacts...
47822:15:28auto_explain/: found 3 matching artifact files and directories
47922:15:28coverage/: found 5 matching artifact files and directories
48022:15:28crystalball/: found 2 matching artifact files and directories
48122:15:28WARNING: deprecations/: no matching files. Ensure that the artifact path is relative to the working directory (/builds/gitlab-org/gitlab)
48222:15:28knapsack/: found 4 matching artifact files and directories
48322:15:28rspec/: found 16 matching artifact files and directories
48422:15:28WARNING: tmp/capybara/: no matching files. Ensure that the artifact path is relative to the working directory (/builds/gitlab-org/gitlab)
48522:15:28log/*.log: found 13 matching artifact files and directories
48622:15:28WARNING: Upload request redirected location=https://gitlab.com/api/v4/jobs/8353287333/artifacts?artifact_format=zip&artifact_type=archive&expire_in=31d new-url=https://gitlab.com
48722:15:28WARNING: Retrying... context=artifacts-uploader error=request redirected
48822:15:30Uploading artifacts as "archive" to coordinator... 201 Created id=8353287333 responseStatus=201 Created token=glcbt-66
48922:15:30Uploading artifacts...
49022:15:30rspec/rspec-*.xml: found 1 matching artifact files and directories
49122:15:30WARNING: Upload request redirected location=https://gitlab.com/api/v4/jobs/8353287333/artifacts?artifact_format=gzip&artifact_type=junit&expire_in=31d new-url=https://gitlab.com
49222:15:30WARNING: Retrying... context=artifacts-uploader error=request redirected
49322:15:32Uploading artifacts as "junit" to coordinator... 201 Created id=8353287333 responseStatus=201 Created token=glcbt-66
494 22:15:32 Cleaning up project directory and file based variables 00:01
49522:15:40Job succeeded