praefect 2/5
Passed Started
by
@gitlab-bot

🤖 GitLab Bot 🤖
1Running with gitlab-runner 15.11.0 (436955cb)2 on gitlab-org-qa-runner ss7o3c7p, system ID: s_6a73791243695Using Docker executor with image registry.gitlab.com/gitlab-org/gitlab-build-images/debian-bullseye-ruby-3.0:bundler-2.3-docker-23.0.1 ...6Starting service docker:23.0.1-dind ...7Pulling docker image docker:23.0.1-dind ...8Using docker image sha256:0965b14b96d892eee2a963801769af5328817a64ed1af67ec4d76364ddd62706 for docker:23.0.1-dind with digest docker@sha256:d9a0fd8bdd156aae6e9be5db0264e0bc99e000e89e92055d4567e27ff13daff0 ...9Waiting for services to be up and running (timeout 30 seconds)...10Authenticating with credentials from job payload (GitLab Registry)11Pulling docker image registry.gitlab.com/gitlab-org/gitlab-build-images/debian-bullseye-ruby-3.0:bundler-2.3-docker-23.0.1 ...12Using docker image sha256:5a7c4217b9356aeaa6ac75a2c357d6340db62f2cec6c7eaa5abb0a0dd6790f75 for registry.gitlab.com/gitlab-org/gitlab-build-images/debian-bullseye-ruby-3.0:bundler-2.3-docker-23.0.1 with digest registry.gitlab.com/gitlab-org/gitlab-build-images/debian-bullseye-ruby-3.0@sha256:8ef72d41bf089694a13bb148e12368e5fc1cfe1322d56e98f151b703153efe57 ...14Running on runner-ss7o3c7p-project-278964-concurrent-0 via runner-ss7o3c7p-gitlab-org-qa-1685414021-1ce1f6e8-gcp...16Fetching changes with git depth set to 20...17Initialized empty Git repository in /builds/gitlab-org/gitlab/.git/18Created fresh repository.19remote: Enumerating objects: 154155, done. 20remote: Counting objects: 100% (154155/154155), done. 21remote: Compressing objects: 100% (96439/96439), done. 22remote: Total 154155 (delta 72479), reused 107333 (delta 51924), pack-reused 0 23Receiving objects: 100% (154155/154155), 128.75 MiB | 40.59 MiB/s, done.24Resolving deltas: 100% (72479/72479), done.26 * [new ref] refs/pipelines/882411299 -> refs/pipelines/88241129927 * [new branch] master -> origin/master28Checking out 29999e7d as detached HEAD (ref is master)...29Skipping Git submodules setup31Checking cache for qa-e2e-ruby-3.0-6a056e500f83db53eb3d88c766f9864d-16...32cache.zip is up to date 33WARNING: .gems/gems/deprecation_toolkit-2.0.3/gemfiles/test/deprecations: chmod .gems/gems/deprecation_toolkit-2.0.3/gemfiles/test/deprecations: no such file or directory (suppressing repeats) 34Successfully extracted cache36Downloading artifacts for trigger-omnibus-env-ce (4370061730)...37Downloading artifacts from coordinator... ok host=storage.googleapis.com id=4370061730 responseStatus=200 OK token=64_MC7yR38Downloading artifacts for download-knapsack-report (4370061733)...39Downloading artifacts from coordinator... ok host=storage.googleapis.com id=4370061733 responseStatus=200 OK token=64_MC7yR41Using docker image sha256:5a7c4217b9356aeaa6ac75a2c357d6340db62f2cec6c7eaa5abb0a0dd6790f75 for registry.gitlab.com/gitlab-org/gitlab-build-images/debian-bullseye-ruby-3.0:bundler-2.3-docker-23.0.1 with digest registry.gitlab.com/gitlab-org/gitlab-build-images/debian-bullseye-ruby-3.0@sha256:8ef72d41bf089694a13bb148e12368e5fc1cfe1322d56e98f151b703153efe57 ...42$ echo "SUITE_RAN=true" > $QA_SUITE_STATUS_ENV_FILE43$ export BUNDLE_PREFIX=$([ "$RUN_WITH_BUNDLE" != "true" ] || echo "bundle exec")44$ if [ "$RUN_WITH_BUNDLE" == "true" ]; then # collapsed multi-line command45Bundle complete! 37 Gemfile dependencies, 129 gems now installed.46Use `bundle info [gemname]` to see where a bundled gem is installed.47$ export QA_COMMAND="$BUNDLE_PREFIX gitlab-qa ${QA_SCENARIO:=Test::Instance::Image} $RELEASE $GITLAB_QA_OPTS -- $QA_TESTS $QA_RSPEC_TAGS $RSPEC_REPORT_OPTS"48$ echo "Running - '$QA_COMMAND'"49Running - 'bundle exec gitlab-qa Test::Integration::Praefect registry.gitlab.com/gitlab-org/build/omnibus-gitlab-mirror/gitlab-ce:29999e7df1369e9013fd24ccd7e45971a743d462 --set-feature-flags super_sidebar_nav_enrolled=enabled -- --format QA::Support::JsonFormatter --out tmp/rspec-4370061748.json --format RspecJunitFormatter --out tmp/rspec-4370061748.xml --format html --out tmp/rspec-$(echo praefect 2/5 | sed 's/[ /]/_/g').htm --color --format documentation'50$ eval "$QA_COMMAND"51[May 30 2023 03:00:17 UTC (Gitlab QA)] INFO -- Shell command: `docker pull -q postgres:11`52[May 30 2023 03:00:21 UTC (Gitlab QA)] INFO -- Shell command: `docker container list --all --format '{{.Names}}' --filter name=^postgres$`53[May 30 2023 03:00:21 UTC (Gitlab QA)] INFO -- Shell command: `docker network list --format '{{.Name}}' --filter name=^test$`54[May 30 2023 03:00:21 UTC (Gitlab QA)] INFO -- Shell command: `docker network create test`55[May 30 2023 03:00:21 UTC (Gitlab QA)] INFO -- Shell command: `docker run -d --name postgres --net test --env POSTGRES_PASSWORD="SQL_PASSWORD" postgres:11`56[May 30 2023 03:00:23 UTC (Gitlab QA)] INFO -- Shell command: `docker exec postgres bash -c "psql -U postgres template1"`57[May 30 2023 03:00:23 UTC (Gitlab QA)] ERROR -- Shell command output:58psql: connection to server on socket "/var/run/postgresql/.s.PGSQL.5432" failed: No such file or directory59 Is the server running locally and accepting connections on that socket?60[May 30 2023 03:00:28 UTC (Gitlab QA)] INFO -- Shell command: `docker exec postgres bash -c "psql -U postgres template1"`61[May 30 2023 03:00:29 UTC (Gitlab QA)] INFO -- Shell command: `docker exec postgres bash -c "psql -U postgres -d template1 -c \"CREATE DATABASE praefect_production OWNER postgres\""`62[May 30 2023 03:00:29 UTC (Gitlab QA)] INFO -- Starting Gitaly Cluster63[May 30 2023 03:00:29 UTC (Gitlab QA)] INFO -- Shell command: `docker container list --all --format '{{.Names}}' --filter name=^alpine-eee8ce8d$`64[May 30 2023 03:00:29 UTC (Gitlab QA)] INFO -- Shell command: `docker login --username "[MASKED]-token" --password "*****" registry.gitlab.com`65[May 30 2023 03:00:29 UTC (Gitlab QA)] INFO -- Shell command: `docker run -d --name alpine-eee8ce8d --volume authority:/etc/gitlab/trusted-certs:Z --volume gitlab-ssl:/etc/gitlab/ssl:Z alpine:latest tail -f /dev/null`66[May 30 2023 03:00:29 UTC (Gitlab QA)] INFO -- Shell command: `docker pull -q registry.gitlab.com/gitlab-org/build/omnibus-gitlab-mirror/gitlab-ce:29999e7df1369e9013fd24ccd7e45971a743d462`67[May 30 2023 03:00:31 UTC (Gitlab QA)] INFO -- Shell command: `docker cp /builds/gitlab-org/gitlab/.gems/gems/gitlab-qa-10.4.1/tls_certificates/authority/. alpine-eee8ce8d:/etc/gitlab/trusted-certs`68[May 30 2023 03:00:32 UTC (Gitlab QA)] INFO -- Shell command: `docker cp /builds/gitlab-org/gitlab/.gems/gems/gitlab-qa-10.4.1/tls_certificates/gitlab/. alpine-eee8ce8d:/etc/gitlab/ssl`69[May 30 2023 03:00:32 UTC (Gitlab QA)] INFO -- Shell command: `docker ps -f name=alpine-eee8ce8d`70[May 30 2023 03:00:32 UTC (Gitlab QA)] INFO -- Shell command: `docker rm -f alpine-eee8ce8d`71[May 30 2023 03:00:33 UTC (Gitlab QA)] INFO -- Shell command: `docker login --username "[MASKED]-token" --password "*****" registry.gitlab.com`72[May 30 2023 03:00:33 UTC (Gitlab QA)] INFO -- Shell command: `docker pull -q registry.gitlab.com/gitlab-org/build/omnibus-gitlab-mirror/gitlab-ce:29999e7df1369e9013fd24ccd7e45971a743d462`73[May 30 2023 03:03:01 UTC (Gitlab QA)] INFO -- Shell command: `docker container list --all --format '{{.Names}}' --filter name=^gitaly1$`74[May 30 2023 03:03:01 UTC (Gitlab QA)] INFO -- Shell command: `docker container list --all --format '{{.Names}}' --filter name=^gitlab-gitaly-cluster$`75[May 30 2023 03:03:01 UTC (Gitlab QA)] INFO -- Shell command: `docker network list --format '{{.Name}}' --filter name=^test$`76[May 30 2023 03:03:01 UTC (Gitlab QA)] INFO -- Shell command: `docker network list --format '{{.Name}}' --filter name=^test$`77[May 30 2023 03:03:01 UTC (Gitlab QA)] INFO -- Shell command: `docker run -d --name gitaly1 --net test --hostname gitaly1.test -p 8075 --volume /builds/gitlab-org/gitlab/gitlab-qa-run-2023-05-30-03-00-17-4a08bcdf/gitaly1/logs:/var/log/gitlab:z registry.gitlab.com/gitlab-org/build/omnibus-gitlab-mirror/gitlab-ce:29999e7df1369e9013fd24ccd7e45971a743d462`78[May 30 2023 03:03:01 UTC (Gitlab QA)] INFO -- Shell command: `docker run -d --name gitlab-gitaly-cluster --net test --hostname gitlab-gitaly-cluster.test -p 80 --volume authority:/etc/gitlab/trusted-certs:Z --volume gitlab-ssl:/etc/gitlab/ssl:Z --volume /builds/gitlab-org/gitlab/gitlab-qa-run-2023-05-30-03-00-17-4a08bcdf/gitlab-gitaly-cluster/logs:/var/log/gitlab:Z registry.gitlab.com/gitlab-org/build/omnibus-gitlab-mirror/gitlab-ce:29999e7df1369e9013fd24ccd7e45971a743d462`79[May 30 2023 03:03:21 UTC (Gitlab QA)] INFO -- Shell command: `docker exec gitlab-gitaly-cluster bash -c "echo \"# Generated by GitLab QA Omnibus Configurator at 2023-05-30 03:00:1780# Gitlab::QA::Runtime::OmnibusConfigurations::Default81gitlab_rails['gitlab_default_theme'] = 10 # Light Red Theme82gitlab_rails['gitlab_disable_animations'] = true # Disable animations83gitlab_rails['application_settings_cache_seconds'] = 0 # Settings cache expiry84gitlab_rails['initial_root_password'] = '5iveL!fe' # Initial root password85external_url 'http://gitlab-gitaly-cluster.test';86git_data_dirs({87 'default' => {88 'gitaly_address' => 'tcp://praefect.test:2305',89 'gitaly_token' => 'PRAEFECT_EXTERNAL_TOKEN'90 },91 'gitaly' => {92 'gitaly_address' => 'tcp://gitlab-gitaly-cluster.test:8075',93 'path' => '/var/opt/gitlab/git-data'94 }95});96gitaly['enable'] = true;97gitaly['configuration'] = {98 auth: {99 token: 'secret-token',100 },101 listen_addr: '0.0.0.0:8075',102 tls: {103 certificate_path: '/etc/gitlab/ssl/gitaly.test.crt',104 key_path: '/etc/gitlab/ssl/gitaly.test.key',105 },106 storage: [107 {108 name: 'gitaly',109 path: '/var/opt/gitlab/git-data/repositories',110 },111 ],112};113gitlab_rails['gitaly_token'] = 'secret-token';114gitlab_shell['secret_token'] = 'GITLAB_SHELL_SECRET_TOKEN';115prometheus['scrape_configs'] = [116 {117 'job_name' => 'praefect',118 'static_configs' => [119 'targets' => [120 'praefect.test:9652'121 ]122 ]123 },124 {125 'job_name' => 'praefect-gitaly',126 'static_configs' => [127 'targets' => [128 'gitaly1.test:9236',129 'gitaly2.test:9236',130 'gitaly3.test:9236'131 ]132 ]133 }134];135grafana['disable_login_form'] = false;136grafana['admin_password'] = 'GRAFANA_ADMIN_PASSWORD';137gitlab_rails['env'] = {'GITLAB_LICENSE_MODE'=>'test', 'CUSTOMER_PORTAL_URL'=>'https://customers.staging.gitlab.com', 'GITLAB_QA_USER_AGENT'=>'*****', 'GITLAB_ALLOW_SEPARATE_CI_DATABASE'=>'true'}\" > /etc/gitlab/gitlab.rb;"`138[May 30 2023 03:03:21 UTC (Gitlab QA)] INFO -- Shell command: `docker exec gitaly1 bash -c "echo \"postgresql['enable'] = false;139redis['enable'] = false;140nginx['enable'] = false;141grafana['enable'] = false;142puma['enable'] = false;143sidekiq['enable'] = false;144gitlab_workhorse['enable'] = false;145gitlab_rails['rake_cache_clear'] = false;146gitlab_rails['auto_migrate'] = false;147gitlab_exporter['enable'] = false;148praefect['enable'] = false;149prometheus['enable'] = true;150gitaly['enable'] = true;151gitaly['configuration'] = {152 'listen_addr': '0.0.0.0:8075',153 'prometheus_listen_addr': '0.0.0.0:9236',154 'auth_token': 'PRAEFECT_INTERNAL_TOKEN'155}156gitlab_shell['secret_token'] = 'GITLAB_SHELL_SECRET_TOKEN';157gitlab_rails['internal_api_url'] = 'http://gitlab-gitaly-cluster.test';158git_data_dirs({159 'gitaly1' => {160 'path' => '/var/opt/gitlab/git-data'161 },162 'gitaly2' => {163 'path' => '/var/opt/gitlab/git-data'164 },165 'gitaly3' => {166 'path' => '/var/opt/gitlab/git-data'167 }168});169\" > /etc/gitlab/gitlab.rb;"`170[May 30 2023 03:03:21 UTC (Gitlab QA)] INFO -- Shell command: `docker attach --sig-proxy=false gitlab-gitaly-cluster`171[May 30 2023 03:03:21 UTC (Gitlab QA)] INFO -- Shell command: `docker attach --sig-proxy=false gitaly1`172[May 30 2023 03:04:18 UTC (Gitlab QA)] INFO -- Shell command: `docker exec gitaly1 bash -c "mkdir -p /opt/gitlab/embedded/service/gitlab-shell/hooks/pre-receive.d"`173[May 30 2023 03:04:18 UTC (Gitlab QA)] INFO -- Shell command: `docker exec gitaly1 bash -c "echo '#!/usr/bin/env bash174if [[ \$GL_PROJECT_PATH =~ 'reject-prereceive' ]]; then175 echo 'GL-HOOK-ERR: Custom error message rejecting prereceive hook for projects with GL_PROJECT_PATH matching pattern reject-prereceive'176 exit 1177fi178' > /opt/gitlab/embedded/service/gitlab-shell/hooks/pre-receive.d/pre-receive.d;"`179[May 30 2023 03:04:18 UTC (Gitlab QA)] INFO -- Shell command: `docker exec gitaly1 bash -c "chmod +x /opt/gitlab/embedded/service/gitlab-shell/hooks/pre-receive.d/*"`180[May 30 2023 03:04:18 UTC (Gitlab QA)] INFO -- Shell command: `docker login --username "[MASKED]-token" --password "*****" registry.gitlab.com`181[May 30 2023 03:04:19 UTC (Gitlab QA)] INFO -- Shell command: `docker pull -q registry.gitlab.com/gitlab-org/build/omnibus-gitlab-mirror/gitlab-ce:29999e7df1369e9013fd24ccd7e45971a743d462`182[May 30 2023 03:04:19 UTC (Gitlab QA)] INFO -- Shell command: `docker container list --all --format '{{.Names}}' --filter name=^gitaly2$`183[May 30 2023 03:04:19 UTC (Gitlab QA)] INFO -- Shell command: `docker network list --format '{{.Name}}' --filter name=^test$`184[May 30 2023 03:04:19 UTC (Gitlab QA)] INFO -- Shell command: `docker run -d --name gitaly2 --net test --hostname gitaly2.test -p 8075 --volume /builds/gitlab-org/gitlab/gitlab-qa-run-2023-05-30-03-00-17-4a08bcdf/gitaly2/logs:/var/log/gitlab:z registry.gitlab.com/gitlab-org/build/omnibus-gitlab-mirror/gitlab-ce:29999e7df1369e9013fd24ccd7e45971a743d462`185[May 30 2023 03:04:21 UTC (Gitlab QA)] INFO -- Shell command: `docker exec gitaly2 bash -c "echo \"postgresql['enable'] = false;186redis['enable'] = false;187nginx['enable'] = false;188grafana['enable'] = false;189puma['enable'] = false;190sidekiq['enable'] = false;191gitlab_workhorse['enable'] = false;192gitlab_rails['rake_cache_clear'] = false;193gitlab_rails['auto_migrate'] = false;194gitlab_exporter['enable'] = false;195praefect['enable'] = false;196prometheus['enable'] = true;197gitaly['enable'] = true;198gitaly['configuration'] = {199 'listen_addr': '0.0.0.0:8075',200 'prometheus_listen_addr': '0.0.0.0:9236',201 'auth_token': 'PRAEFECT_INTERNAL_TOKEN'202}203gitlab_shell['secret_token'] = 'GITLAB_SHELL_SECRET_TOKEN';204gitlab_rails['internal_api_url'] = 'http://gitlab-gitaly-cluster.test';205git_data_dirs({206 'gitaly1' => {207 'path' => '/var/opt/gitlab/git-data'208 },209 'gitaly2' => {210 'path' => '/var/opt/gitlab/git-data'211 },212 'gitaly3' => {213 'path' => '/var/opt/gitlab/git-data'214 }215});216\" > /etc/gitlab/gitlab.rb;"`217[May 30 2023 03:04:21 UTC (Gitlab QA)] INFO -- Shell command: `docker attach --sig-proxy=false gitaly2`218[May 30 2023 03:05:20 UTC (Gitlab QA)] INFO -- Shell command: `docker exec gitaly2 bash -c "mkdir -p /opt/gitlab/embedded/service/gitlab-shell/hooks/pre-receive.d"`219[May 30 2023 03:05:20 UTC (Gitlab QA)] INFO -- Shell command: `docker exec gitaly2 bash -c "echo '#!/usr/bin/env bash220if [[ \$GL_PROJECT_PATH =~ 'reject-prereceive' ]]; then221 echo 'GL-HOOK-ERR: Custom error message rejecting prereceive hook for projects with GL_PROJECT_PATH matching pattern reject-prereceive'222 exit 1223fi224' > /opt/gitlab/embedded/service/gitlab-shell/hooks/pre-receive.d/pre-receive.d;"`225[May 30 2023 03:05:20 UTC (Gitlab QA)] INFO -- Shell command: `docker exec gitaly2 bash -c "chmod +x /opt/gitlab/embedded/service/gitlab-shell/hooks/pre-receive.d/*"`226[May 30 2023 03:05:20 UTC (Gitlab QA)] INFO -- Shell command: `docker login --username "[MASKED]-token" --password "*****" registry.gitlab.com`227[May 30 2023 03:05:20 UTC (Gitlab QA)] INFO -- Shell command: `docker pull -q registry.gitlab.com/gitlab-org/build/omnibus-gitlab-mirror/gitlab-ce:29999e7df1369e9013fd24ccd7e45971a743d462`228[May 30 2023 03:05:21 UTC (Gitlab QA)] INFO -- Shell command: `docker container list --all --format '{{.Names}}' --filter name=^gitaly3$`229[May 30 2023 03:05:21 UTC (Gitlab QA)] INFO -- Shell command: `docker network list --format '{{.Name}}' --filter name=^test$`230[May 30 2023 03:05:21 UTC (Gitlab QA)] INFO -- Shell command: `docker run -d --name gitaly3 --net test --hostname gitaly3.test -p 8075 --volume /builds/gitlab-org/gitlab/gitlab-qa-run-2023-05-30-03-00-17-4a08bcdf/gitaly3/logs:/var/log/gitlab:z registry.gitlab.com/gitlab-org/build/omnibus-gitlab-mirror/gitlab-ce:29999e7df1369e9013fd24ccd7e45971a743d462`231[May 30 2023 03:05:22 UTC (Gitlab QA)] INFO -- Shell command: `docker exec gitaly3 bash -c "echo \"postgresql['enable'] = false;232redis['enable'] = false;233nginx['enable'] = false;234grafana['enable'] = false;235puma['enable'] = false;236sidekiq['enable'] = false;237gitlab_workhorse['enable'] = false;238gitlab_rails['rake_cache_clear'] = false;239gitlab_rails['auto_migrate'] = false;240gitlab_exporter['enable'] = false;241praefect['enable'] = false;242prometheus['enable'] = true;243gitaly['enable'] = true;244gitaly['configuration'] = {245 'listen_addr': '0.0.0.0:8075',246 'prometheus_listen_addr': '0.0.0.0:9236',247 'auth_token': 'PRAEFECT_INTERNAL_TOKEN'248}249gitlab_shell['secret_token'] = 'GITLAB_SHELL_SECRET_TOKEN';250gitlab_rails['internal_api_url'] = 'http://gitlab-gitaly-cluster.test';251git_data_dirs({252 'gitaly1' => {253 'path' => '/var/opt/gitlab/git-data'254 },255 'gitaly2' => {256 'path' => '/var/opt/gitlab/git-data'257 },258 'gitaly3' => {259 'path' => '/var/opt/gitlab/git-data'260 }261});262\" > /etc/gitlab/gitlab.rb;"`263[May 30 2023 03:05:22 UTC (Gitlab QA)] INFO -- Shell command: `docker attach --sig-proxy=false gitaly3`264[May 30 2023 03:06:20 UTC (Gitlab QA)] INFO -- Shell command: `docker exec gitaly3 bash -c "mkdir -p /opt/gitlab/embedded/service/gitlab-shell/hooks/pre-receive.d"`265[May 30 2023 03:06:20 UTC (Gitlab QA)] INFO -- Shell command: `docker exec gitaly3 bash -c "echo '#!/usr/bin/env bash266if [[ \$GL_PROJECT_PATH =~ 'reject-prereceive' ]]; then267 echo 'GL-HOOK-ERR: Custom error message rejecting prereceive hook for projects with GL_PROJECT_PATH matching pattern reject-prereceive'268 exit 1269fi270' > /opt/gitlab/embedded/service/gitlab-shell/hooks/pre-receive.d/pre-receive.d;"`271[May 30 2023 03:06:20 UTC (Gitlab QA)] INFO -- Shell command: `docker exec gitaly3 bash -c "chmod +x /opt/gitlab/embedded/service/gitlab-shell/hooks/pre-receive.d/*"`272[May 30 2023 03:06:20 UTC (Gitlab QA)] INFO -- Shell command: `docker login --username "[MASKED]-token" --password "*****" registry.gitlab.com`273[May 30 2023 03:06:20 UTC (Gitlab QA)] INFO -- Shell command: `docker pull -q registry.gitlab.com/gitlab-org/build/omnibus-gitlab-mirror/gitlab-ce:29999e7df1369e9013fd24ccd7e45971a743d462`274[May 30 2023 03:06:21 UTC (Gitlab QA)] INFO -- Shell command: `docker container list --all --format '{{.Names}}' --filter name=^praefect$`275[May 30 2023 03:06:21 UTC (Gitlab QA)] INFO -- Shell command: `docker network list --format '{{.Name}}' --filter name=^test$`276[May 30 2023 03:06:21 UTC (Gitlab QA)] INFO -- Shell command: `docker run -d --name praefect --net test --hostname praefect.test -p 2305 --volume /builds/gitlab-org/gitlab/gitlab-qa-run-2023-05-30-03-00-17-4a08bcdf/praefect/logs:/var/log/gitlab:z registry.gitlab.com/gitlab-org/build/omnibus-gitlab-mirror/gitlab-ce:29999e7df1369e9013fd24ccd7e45971a743d462`277[May 30 2023 03:06:22 UTC (Gitlab QA)] INFO -- Shell command: `docker exec praefect bash -c "echo \"postgresql['enable'] = false;278redis['enable'] = false;279nginx['enable'] = false;280grafana['enable'] = false;281puma['enable'] = false;282sidekiq['enable'] = false;283gitlab_workhorse['enable'] = false;284gitlab_rails['rake_cache_clear'] = false;285gitlab_rails['auto_migrate'] = false;286gitlab_exporter['enable'] = false;287gitaly['enable'] = false;288prometheus['enable'] = true;289praefect['enable'] = true;290praefect['configuration'] = {291 listen_addr: '0.0.0.0:2305',292 prometheus_listen_addr: '0.0.0.0:9652',293 auth: {294 token: 'PRAEFECT_EXTERNAL_TOKEN'295 },296 reconciliation: {297 scheduling_interval: '10s'298 },299 database: {300 host: 'postgres.test',301 port: 5432,302 user: 'postgres',303 password: 'SQL_PASSWORD',304 dbname: 'praefect_production',305 sslmode: 'disable'306 },307 virtual_storage: [308 {309 name: 'default',310 node: [311 {312 'storage': 'gitaly1',313 'address': 'tcp://gitaly1.test:8075',314 'token': 'PRAEFECT_INTERNAL_TOKEN'315 },316 {317 'storage': 'gitaly2',318 'address': 'tcp://gitaly2.test:8075',319 'token': 'PRAEFECT_INTERNAL_TOKEN'320 },321 {322 'storage': 'gitaly3',323 'address': 'tcp://gitaly3.test:8075',324 'token': 'PRAEFECT_INTERNAL_TOKEN'325 }326 ],327 }328 ]329}330\" > /etc/gitlab/gitlab.rb;"`331[May 30 2023 03:06:22 UTC (Gitlab QA)] INFO -- Shell command: `docker attach --sig-proxy=false praefect`332[May 30 2023 03:06:43 UTC (Gitlab QA)] INFO -- Waiting for GitLab to become healthy ...333[May 30 2023 03:06:43 UTC (Gitlab QA)] INFO -- Shell command: `docker inspect --format='{{json .State.Health.Status}}' gitlab-gitaly-cluster`334[May 30 2023 03:06:43 UTC (Gitlab QA)] INFO -- Shell command: `docker port gitlab-gitaly-cluster 80/tcp`335[May 30 2023 03:06:44 UTC (Gitlab QA)] INFO -- -> GitLab is available at `http://docker:32768`!336[May 30 2023 03:06:44 UTC (Gitlab QA)] INFO -- Shell command: `docker exec gitlab-gitaly-cluster bash -c "mkdir -p /opt/gitlab/embedded/service/gitlab-shell/hooks/pre-receive.d"`337[May 30 2023 03:06:44 UTC (Gitlab QA)] INFO -- Shell command: `docker exec gitlab-gitaly-cluster bash -c "echo '#!/usr/bin/env bash338if [[ \$GL_PROJECT_PATH =~ 'reject-prereceive' ]]; then339 echo 'GL-HOOK-ERR: Custom error message rejecting prereceive hook for projects with GL_PROJECT_PATH matching pattern reject-prereceive'340 exit 1341fi342' > /opt/gitlab/embedded/service/gitlab-shell/hooks/pre-receive.d/pre-receive.d;"`343[May 30 2023 03:06:44 UTC (Gitlab QA)] INFO -- Shell command: `docker exec gitlab-gitaly-cluster bash -c "chmod +x /opt/gitlab/embedded/service/gitlab-shell/hooks/pre-receive.d/*"`344[May 30 2023 03:06:44 UTC (Gitlab QA)] INFO -- Shell command: `docker cp /builds/gitlab-org/gitlab/.gems/gems/gitlab-qa-10.4.1/support/data gitlab-gitaly-cluster:/tmp/data-seeds`345[May 30 2023 03:06:44 UTC (Gitlab QA)] INFO -- Running exec_commands...346[May 30 2023 03:06:44 UTC (Gitlab QA)] INFO -- Shell command: `docker exec gitlab-gitaly-cluster bash -c "gitlab-rails runner /tmp/data-seeds/admin_access_token_seed.rb"`347[May 30 2023 03:07:20 UTC (Gitlab QA)] INFO -- Shell command: `docker exec praefect bash -c "praefect -config /var/opt/gitlab/praefect/cluster_config.toml check || true"`348[May 30 2023 03:07:21 UTC (Gitlab QA)] INFO -- Shell command: `docker inspect -f '{{range.NetworkSettings.Networks}}{{.IPAddress}}{{end}}' praefect`349[May 30 2023 03:07:21 UTC (Gitlab QA)] INFO -- Gitaly Cluster Ready350[May 30 2023 03:07:36 UTC (Gitlab QA)] INFO -- Running Gitaly Cluster specs!351[May 30 2023 03:07:36 UTC (Gitlab QA)] INFO -- Shell command: `docker login --username "[MASKED]-token" --password "*****" registry.gitlab.com`352[May 30 2023 03:07:36 UTC (Gitlab QA)] INFO -- Shell command: `docker pull -q registry.gitlab.com/gitlab-org/gitlab/gitlab-ce-qa:29999e7df1369e9013fd24ccd7e45971a743d462`353[May 30 2023 03:08:19 UTC (Gitlab QA)] INFO -- Running test suite `Test::Instance::All` for gitlab-ce354[May 30 2023 03:08:19 UTC (Gitlab QA)] INFO -- Running with feature flag: --set-feature-flags super_sidebar_nav_enrolled=enabled355[May 30 2023 03:08:19 UTC (Gitlab QA)] INFO -- Shell command: `docker run -t --rm --net=test --env QA_AWS_S3_REGION="$QA_AWS_S3_REGION" --env QA_GOOGLE_CDN_JSON_KEY="$QA_GOOGLE_CDN_JSON_KEY" --env QA_SUITE_STATUS_ENV_FILE="$QA_SUITE_STATUS_ENV_FILE" --env QA_THIRD_PARTY_DOCKER_REGISTRY="$QA_THIRD_PARTY_DOCKER_REGISTRY" --env QA_SAVE_TEST_METRICS="$QA_SAVE_TEST_METRICS" --env QA_GOOGLE_CDN_SIGNURL_KEY_NAME="$QA_GOOGLE_CDN_SIGNURL_KEY_NAME" --env QA_1P_PASSWORD="$QA_1P_PASSWORD" --env QA_REMOTE_GRID_USERNAME="$QA_REMOTE_GRID_USERNAME" --env QA_GOOGLE_CDN_SIGNURL_KEY="$QA_GOOGLE_CDN_SIGNURL_KEY" --env QA_TEST_CASE_PROJECT_TOKEN="$QA_TEST_CASE_PROJECT_TOKEN" --env QA_GITHUB_USERNAME="$QA_GITHUB_USERNAME" --env QA_SLOW_CONNECTION_THROUGHPUT_KBPS="$QA_SLOW_CONNECTION_THROUGHPUT_KBPS" --env QA_GITHUB_PASSWORD="$QA_GITHUB_PASSWORD" --env QA_ARTIFACTS_DIR="$QA_ARTIFACTS_DIR" --env QA_GITLAB_TLS_CERTIFICATE="$QA_GITLAB_TLS_CERTIFICATE" --env QA_RUN_TYPE="$QA_RUN_TYPE" --env QA_JIRA_ADMIN_PASSWORD="$QA_JIRA_ADMIN_PASSWORD" --env QA_KNAPSACK_REPORT_PATH="$QA_KNAPSACK_REPORT_PATH" --env QA_GITHUB_OAUTH_APP_SECRET="$QA_GITHUB_OAUTH_APP_SECRET" --env QA_PATH="$QA_PATH" --env QA_JIRA_ADMIN_USERNAME="$QA_JIRA_ADMIN_USERNAME" --env QA_ADMIN_ACCESS_TOKEN="$QA_ADMIN_ACCESS_TOKEN" --env QA_COMMAND="$QA_COMMAND" --env QA_EE_LICENSE="$QA_EE_LICENSE" --env QA_1P_EMAIL="$QA_1P_EMAIL" --env QA_EE_ACTIVATION_CODE="$QA_EE_ACTIVATION_CODE" --env QA_GOOGLE_CLIENT_EMAIL="$QA_GOOGLE_CLIENT_EMAIL" --env QA_ALLURE_AWS_SECRET_ACCESS_KEY="$QA_ALLURE_AWS_SECRET_ACCESS_KEY" --env QA_GCS_BUCKET_NAME="$QA_GCS_BUCKET_NAME" --env QA_GOOGLE_PROJECT="$QA_GOOGLE_PROJECT" --env QA_KNAPSACK_REPORT_GCS_CREDENTIALS="$QA_KNAPSACK_REPORT_GCS_CREDENTIALS" --env QA_AWS_S3_KEY_ID="$QA_AWS_S3_KEY_ID" --env QA_RUN_ALL_TESTS="$QA_RUN_ALL_TESTS" --env QA_GITLAB_CI_TOKEN="$QA_GITLAB_CI_TOKEN" --env QA_REMOTE_GRID_ACCESS_KEY="$QA_REMOTE_GRID_ACCESS_KEY" --env QA_FRAMEWORK_CHANGES="$QA_FRAMEWORK_CHANGES" --env QA_INTERCEPT_REQUESTS="$QA_INTERCEPT_REQUESTS" --env QA_INFLUXDB_URL="$QA_INFLUXDB_URL" --env QA_THIRD_PARTY_DOCKER_USER="$QA_THIRD_PARTY_DOCKER_USER" --env QA_THIRD_PARTY_DOCKER_PASSWORD="$QA_THIRD_PARTY_DOCKER_PASSWORD" --env QA_1P_SECRET="$QA_1P_SECRET" --env QA_AWS_S3_ACCESS_KEY="$QA_AWS_S3_ACCESS_KEY" --env QA_LOG_LEVEL="$QA_LOG_LEVEL" --env QA_GITHUB_OAUTH_APP_ID="$QA_GITHUB_OAUTH_APP_ID" --env QA_EXPORT_TEST_METRICS="$QA_EXPORT_TEST_METRICS" --env QA_GOOGLE_CDN_LB="$QA_GOOGLE_CDN_LB" --env QA_1P_GITHUB_UUID="$QA_1P_GITHUB_UUID" --env QA_GCS_CDN_BUCKET_NAME="$QA_GCS_CDN_BUCKET_NAME" --env QA_SCENARIO="$QA_SCENARIO" --env QA_GOOGLE_JSON_KEY="$QA_GOOGLE_JSON_KEY" --env QA_TRIGGER_AUTO_QUARANTINE="$QA_TRIGGER_AUTO_QUARANTINE" --env QA_SUITES="$QA_SUITES" --env QA_RUN_ALL_E2E_LABEL="$QA_RUN_ALL_E2E_LABEL" --env QA_ALLURE_AWS_ACCESS_KEY_ID="$QA_ALLURE_AWS_ACCESS_KEY_ID" --env QA_AWS_S3_BUCKET_NAME="$QA_AWS_S3_BUCKET_NAME" --env QA_GENERATE_ALLURE_REPORT="$QA_GENERATE_ALLURE_REPORT" --env QA_CAN_TEST_PRAEFECT="$QA_CAN_TEST_PRAEFECT" --env QA_RUN_TESTS_ON_GDK="$QA_RUN_TESTS_ON_GDK" --env QA_INFLUXDB_TOKEN="$QA_INFLUXDB_TOKEN" --env QA_TEST_LICENSE_MODE="$QA_TEST_LICENSE_MODE" --env QA_TEST_SESSION_TOKEN="$QA_TEST_SESSION_TOKEN" --env QA_SLOW_CONNECTION_LATENCY_MS="$QA_SLOW_CONNECTION_LATENCY_MS" --env QA_RESULTS_ISSUE_PROJECT_TOKEN="$QA_RESULTS_ISSUE_PROJECT_TOKEN" --env QA_GITHUB_ACCESS_TOKEN="$QA_GITHUB_ACCESS_TOKEN" --env QA_THIRD_PARTY_DOCKER_REPOSITORY="$QA_THIRD_PARTY_DOCKER_REPOSITORY" --env GITLAB_QA_ADMIN_ACCESS_TOKEN="$GITLAB_QA_ADMIN_ACCESS_TOKEN" --env GITHUB_ACCESS_TOKEN="$GITHUB_ACCESS_TOKEN" --env EE_LICENSE="$EE_LICENSE" --env GITLAB_QA_PASSWORD_1="$GITLAB_QA_PASSWORD_1" --env GITLAB_QA_PASSWORD_2="$GITLAB_QA_PASSWORD_2" --env CI="$CI" --env CI_COMMIT_REF_NAME="$CI_COMMIT_REF_NAME" --env CI_JOB_NAME="$CI_JOB_NAME" --env CI_JOB_URL="$CI_JOB_URL" --env CI_JOB_TOKEN="$CI_JOB_TOKEN" --env CI_RUNNER_ID="$CI_RUNNER_ID" --env CI_SERVER_HOST="$CI_SERVER_HOST" --env CI_NODE_INDEX="$CI_NODE_INDEX" --env CI_NODE_TOTAL="$CI_NODE_TOTAL" --env CI_PROJECT_ID="$CI_PROJECT_ID" --env CI_PROJECT_NAME="$CI_PROJECT_NAME" --env CI_PROJECT_PATH="$CI_PROJECT_PATH" --env CI_SLACK_WEBHOOK_URL="$CI_SLACK_WEBHOOK_URL" --env CI_PIPELINE_ID="$CI_PIPELINE_ID" --env CI_PIPELINE_SOURCE="$CI_PIPELINE_SOURCE" --env CI_PIPELINE_URL="$CI_PIPELINE_URL" --env CI_PIPELINE_CREATED_AT="$CI_PIPELINE_CREATED_AT" --env CI_API_V4_URL="$CI_API_V4_URL" --env GITLAB_CI="$GITLAB_CI" --env GITLAB_QA_USER_AGENT="$GITLAB_QA_USER_AGENT" --env GITLAB_INITIAL_ROOT_PASSWORD="5iveL!fe" --env COLORIZED_LOGS="$COLORIZED_LOGS" --env RELEASE="$RELEASE" --env RELEASE_REGISTRY_URL="registry.gitlab.com" --env RELEASE_REGISTRY_USERNAME="[MASKED]-token" --env RELEASE_REGISTRY_PASSWORD="[MASKED]" --env SELENOID_DIRECTORY="/builds/gitlab-org/gitlab/gitlab-qa-run-2023-05-30-03-00-17-4a08bcdf/selenoid" --env QA_PRAEFECT_REPOSITORY_STORAGE="default" --volume /builds/gitlab-org/gitlab/gitlab-qa-run-2023-05-30-03-00-17-4a08bcdf/gitlab-ce-qa-4e2676a3:/home/gitlab/qa/tmp:z --volume /var/run/docker.sock:/var/run/docker.sock:z --volume /builds/gitlab-org/gitlab/qa/knapsack:/home/gitlab/qa/knapsack:z --name gitlab-ce-qa-4e2676a3 registry.gitlab.com/gitlab-org/gitlab/gitlab-ce-qa:29999e7df1369e9013fd24ccd7e45971a743d462 Test::Instance::All http://gitlab-gitaly-cluster.test --set-feature-flags super_sidebar_nav_enrolled=enabled -- --format QA::Support::JsonFormatter --out tmp/rspec-4370061748.json --format RspecJunitFormatter --out tmp/rspec-4370061748.xml --format html --out tmp/rspec-praefect_2_5.htm --color --format documentation`356warning: parser/current is loading parser/ruby30, which recognizes3.0.5-compliant syntax, but you are running 3.0.6.3582023-05-30 03:08:37 WARN Selenium [:logger_info] Details on how to use and modify Selenium logger:3602023-05-30 03:08:37 WARN Selenium [DEPRECATION] [:caps_browsers] Remote::Capabilities.chrome is deprecated. Use Options.chrome instead.3612023-05-30 03:08:37 WARN Selenium [DEPRECATION] [:capabilities] The :capabilities parameter for Selenium::WebDriver::Chrome::Driver is deprecated. Use :options argument with an instance of Selenium::WebDriver::Chrome::Driver instead.3622023-05-30 03:08:37 / CONF :: 363 ==> Base URL: http://gitlab-gitaly-cluster.test364 ==> Browser: #<Selenium::WebDriver::Chrome::Driver:0x00007f126e59fd80>365 ==> Libraries: Chemlab::Vendor366[May 30 2023 03:08:38 UTC (QA Tests)] INFO -- Caching token for username: root, last six chars of token:sixwPA367[May 30 2023 03:08:38 UTC (QA Tests)] INFO -- Browser: chrome368[May 30 2023 03:08:38 UTC (QA Tests)] INFO -- Browser version: latest369[May 30 2023 03:08:38 UTC (QA Tests)] INFO -- Performing sanity check for environment!370[May 30 2023 03:08:38 UTC (QA Tests)] INFO -- Enabling feature: super_sidebar_nav_enrolled371[May 30 2023 03:08:39 UTC (QA Tests)] INFO -- Successfully enabled and verified feature flag: super_sidebar_nav_enrolled372[May 30 2023 03:08:39 UTC (QA Tests)] INFO -- Downloading latest knapsack report for 'praefect' to 'knapsack/praefect.json'373[May 30 2023 03:08:39 UTC (QA Tests)] INFO -- Report already exists, skipping!374[May 30 2023 03:08:39 UTC (QA Tests)] INFO -- ==== Knapsack specs to execute =====375[May 30 2023 03:08:39 UTC (QA Tests)] INFO -- Report specs:376[May 30 2023 03:08:39 UTC (QA Tests)] INFO -- ["qa/specs/features/browser_ui/4_verify/ci_job_artifacts/unlocking_job_artifacts_across_parent_child_pipelines_spec.rb", "qa/specs/features/browser_ui/4_verify/pipeline/run_pipeline_with_manual_jobs_spec.rb", "qa/specs/features/browser_ui/3_create/repository/add_file_template_spec.rb", "qa/specs/features/browser_ui/2_plan/milestone/assign_milestone_spec.rb", "qa/specs/features/browser_ui/3_create/snippet/delete_file_from_snippet_spec.rb", "qa/specs/features/browser_ui/3_create/web_ide/add_new_directory_in_web_ide_spec.rb", "qa/specs/features/browser_ui/3_create/snippet/clone_push_pull_personal_snippet_spec.rb", "qa/specs/features/browser_ui/4_verify/ci_variable/prefill_variables_spec.rb", "qa/specs/features/browser_ui/2_plan/issue/create_issue_spec.rb", "qa/specs/features/browser_ui/4_verify/pipeline/include_multiple_files_from_a_project_spec.rb", "qa/specs/features/browser_ui/4_verify/pipeline/include_multiple_files_from_multiple_projects_spec.rb", "qa/specs/features/browser_ui/8_monitor/alert_management/alert_settings_create_new_alerts_spec.rb", "qa/specs/features/browser_ui/4_verify/runner/register_runner_spec.rb", "qa/specs/features/browser_ui/3_create/repository/push_over_ssh_spec.rb", "qa/specs/features/browser_ui/14_analytics/performance_bar_spec.rb", "qa/specs/features/browser_ui/4_verify/ci_variable/custom_variable_spec.rb", "qa/specs/features/browser_ui/4_verify/pipeline/pipeline_editor_can_create_merge_request_spec.rb", "qa/specs/features/browser_ui/4_verify/ci_variable/raw_variables_defined_in_yaml_spec.rb", "qa/specs/features/browser_ui/4_verify/pipeline/run_pipeline_via_web_only_spec.rb", "qa/specs/features/browser_ui/9_data_stores/user/follow_user_activity_spec.rb", "qa/specs/features/browser_ui/2_plan/project_wiki/project_based_directory_management_spec.rb", "qa/specs/features/browser_ui/9_data_stores/project/dashboard_images_spec.rb", "qa/specs/features/browser_ui/1_manage/project/project_access_token_spec.rb", "qa/specs/features/browser_ui/3_create/repository/file/file_with_unusual_name_spec.rb", "qa/specs/features/browser_ui/2_plan/project_wiki/project_based_page_deletion_spec.rb", "qa/specs/features/browser_ui/3_create/repository/push_http_private_token_spec.rb", "qa/specs/features/browser_ui/3_create/web_ide_old/link_to_line_in_web_ide_spec.rb", "qa/specs/features/api/3_create/merge_request/push_options_title_description_spec.rb", "qa/specs/features/browser_ui/1_manage/login/log_in_spec.rb", "qa/specs/features/api/3_create/repository/tag_revision_trigger_prereceive_hook_spec.rb", "qa/specs/features/api/1_manage/rate_limits_spec.rb"]377[May 30 2023 03:08:39 UTC (QA Tests)] INFO -- Leftover specs:378[May 30 2023 03:08:39 UTC (QA Tests)] INFO -- ["qa/specs/features/api/12_systems/gitaly/backend_node_recovery_spec.rb", "qa/specs/features/api/12_systems/gitaly/praefect_replication_queue_spec.rb", "qa/specs/features/api/1_manage/migration/gitlab_migration_group_spec.rb", "qa/specs/features/api/1_manage/migration/gitlab_migration_pipeline_spec.rb", "qa/specs/features/browser_ui/14_analytics/service_ping_disabled_spec.rb", "qa/specs/features/browser_ui/1_manage/integrations/pipeline_status_emails_spec.rb", "qa/specs/features/browser_ui/1_manage/login/oauth_login_with_github_spec.rb", "qa/specs/features/browser_ui/3_create/merge_request/merge_when_pipeline_succeeds_spec.rb", "qa/specs/features/browser_ui/5_package/container_registry/saas/container_registry_spec.rb", "qa/specs/features/browser_ui/5_package/package_registry/conan_repository_spec.rb", "qa/specs/features/browser_ui/5_package/package_registry/maven_gradle_repository_spec.rb", "qa/specs/features/browser_ui/5_package/package_registry/pypi_repository_spec.rb", "qa/specs/features/browser_ui/8_monitor/incident_management/recovery_alert_closes_correct_incident_spec.rb"]379[May 30 2023 03:08:39 UTC (QA Tests)] INFO -- Knapsack time offset warning enabled!380[May 30 2023 03:08:39 UTC (QA Tests)] INFO -- Downloading latest knapsack report for 'praefect' to 'knapsack/praefect.json'381[May 30 2023 03:08:39 UTC (QA Tests)] INFO -- Report already exists, skipping!382Run options: exclude {:orchestrated=>true, :transient=>true, :sanity_feature_flags=>true, :geo=>true}383Randomized with seed 11599384Monitor385 Recovery alert386 when using HTTP endpoint integration387 behaves like triggers recovery alert388 only closes the correct incident (PENDING: In quarantine : https://gitlab.com/gitlab-org/gitlab/-/issues/395512)389 when using Prometheus integration390 behaves like triggers recovery alert391 only closes the correct incident (PENDING: In quarantine : https://gitlab.com/gitlab-org/gitlab/-/issues/395512)392Data Stores393 User394[May 30 2023 03:08:40 UTC (QA Tests)] INFO -- Starting test: Data Stores User can be followed and their activity seen395[May 30 2023 03:08:41 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::User with username 'qa-user-7d983fe394ae1d59' via api in 0.88 seconds396[May 30 2023 03:08:41 UTC (QA Tests)] INFO -- No cached token found for username: qa-user-7d983fe394ae1d59397[May 30 2023 03:08:41 UTC (QA Tests)] INFO -- Caching token for username: qa-user-7d983fe394ae1d59, last six chars of token:3jFVkW398[May 30 2023 03:08:41 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::PersonalAccessToken with name 'api-pat-qa-user-7d983fe394ae1d59-hbst7o31' via api in 0.1 seconds399[May 30 2023 03:08:42 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::User with username 'qa-user-7e4d30126aa348c1' via api in 0.88 seconds400[May 30 2023 03:08:42 UTC (QA Tests)] INFO -- filling :login_field with "qa-user-7e4d30126aa348c1"401[May 30 2023 03:08:42 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field402[May 30 2023 03:08:43 UTC (QA Tests)] INFO -- filling :password_field with "*****"403[May 30 2023 03:08:43 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field404[May 30 2023 03:08:43 UTC (QA Tests)] INFO -- clicking :sign_in_button405[May 30 2023 03:08:45 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 1.656s406[May 30 2023 03:08:45 UTC (QA Tests)] INFO -- Enabling super sidebar!407[May 30 2023 03:08:45 UTC (QA Tests)] INFO -- Super sidebar is already enabled408[May 30 2023 03:08:47 UTC (QA Tests)] INFO -- clicking :follow_user_link409[May 30 2023 03:08:48 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element follow_user_link' took 0.89s410[May 30 2023 03:08:49 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-3' via api in 0.52 seconds411[May 30 2023 03:08:50 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-3/group_for_follow_user_activity_d0278a4a2a49080b' via api in 1.34 seconds412[May 30 2023 03:08:50 UTC (QA Tests)] INFO -- Adding user qa-user-7d983fe394ae1d59 to gitlab-qa-sandbox-group-3/group_for_follow_user_activity_d0278a4a2a49080b QA::Resource::Group413[May 30 2023 03:08:52 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-3/group_for_follow_user_activity_d0278a4a2a49080b/project-for-tags-0c2b008d00c02262' via api in 1.97 seconds414[May 30 2023 03:08:53 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Repository::Commit via api in 0.76 seconds415[May 30 2023 03:08:54 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::MergeRequest with iid '1' via api in 1.83 seconds416[May 30 2023 03:08:55 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Issue with id '1' via api in 0.97 seconds417[May 30 2023 03:08:55 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::ProjectIssueNote with id '1' via api in 0.29 seconds418[May 30 2023 03:08:56 UTC (QA Tests)] WARN -- Potentially Slow Code 'has_element? user_profile_link' took 1.023s419[May 30 2023 03:08:56 UTC (QA Tests)] INFO -- clicking :user_avatar_content420[May 30 2023 03:08:56 UTC (QA Tests)] INFO -- clicking :user_profile_link421[May 30 2023 03:08:57 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element user_profile_link' took 0.83s422[May 30 2023 03:08:57 UTC (QA Tests)] INFO -- clicking :nav_item_link423[May 30 2023 03:08:58 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element nav_item_link' took 0.922s424[May 30 2023 03:08:58 UTC (QA Tests)] INFO -- clicking :user_link425[May 30 2023 03:08:59 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element user_link' took 0.655s426[May 30 2023 03:09:00 UTC (QA Tests)] INFO -- Removed a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-3/group_for_follow_user_activity_d0278a4a2a49080b/project-for-tags-0c2b008d00c02262'427[May 30 2023 03:09:00 UTC (QA Tests)] INFO -- Removed a QA::Resource::User with username 'qa-user-7d983fe394ae1d59'428[May 30 2023 03:09:00 UTC (QA Tests)] INFO -- Removed a QA::Resource::User with username 'qa-user-7e4d30126aa348c1'429 can be followed and their activity seen430Verify431 Pipeline with customizable variable432[May 30 2023 03:09:00 UTC (QA Tests)] INFO -- Starting test: Verify Pipeline with customizable variable manually creates a pipeline and uses the defined custom variable value433[May 30 2023 03:09:00 UTC (QA Tests)] INFO -- Retrieved cached token for username: root, last six chars of token:sixwPA434[May 30 2023 03:09:00 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::PersonalAccessToken with name 'api-pat-root-bh3390ei' via cache in 0.0 seconds435[May 30 2023 03:09:00 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-3' via api in 0.13 seconds436[May 30 2023 03:09:01 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04' via api in 0.43 seconds437[May 30 2023 03:09:01 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/project-with-customizable-variable-pipeline-e70e9e7c691670e2' via api in 0.9 seconds438[May 30 2023 03:09:01 UTC (QA Tests)] INFO -- Runner api_get exception caught and handled: No value was computed for id of QA::Resource::ProjectRunner.439[May 30 2023 03:09:01 UTC (QA Tests)] INFO -- Executing: `docker pull registry.gitlab.com/gitlab-org/gitlab-runner:alpine`440[May 30 2023 03:09:04 UTC (QA Tests)] INFO -- Executing: `docker network inspect test`441[May 30 2023 03:09:04 UTC (QA Tests)] INFO -- Executing: `docker run -d --rm --network test --name qa-runner-1685416141 --privileged registry.gitlab.com/gitlab-org/gitlab-runner:alpine && docker exec --detach qa-runner-1685416141 sh -c "printf 'concurrent = 1\ncheck_interval = 0\n\n[session_server]\n session_timeout = 1800' > /etc/gitlab-runner/config.toml && gitlab-runner register --non-interactive --name qa-runner-1685416141 --url http://gitlab-gitaly-cluster.test --registration-token **** --tag-list qa-runner-1685416141 --executor shell && gitlab-runner run" `442[May 30 2023 03:09:07 UTC (QA Tests)] INFO -- Executing: `docker logs qa-runner-1685416141`443[May 30 2023 03:09:07 UTC (QA Tests)] INFO -- Executing: `docker network inspect test`444[May 30 2023 03:09:09 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::ProjectRunner with name 'qa-runner-1685416141' via api in 7.52 seconds445[May 30 2023 03:09:10 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Repository::Commit via api in 1.12 seconds446[May 30 2023 03:09:10 UTC (QA Tests)] INFO -- filling :login_field with "root"447[May 30 2023 03:09:10 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field448[May 30 2023 03:09:11 UTC (QA Tests)] INFO -- filling :password_field with "*****"449[May 30 2023 03:09:11 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field450[May 30 2023 03:09:11 UTC (QA Tests)] INFO -- clicking :sign_in_button451[May 30 2023 03:09:12 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 1.382s452[May 30 2023 03:09:13 UTC (QA Tests)] INFO -- Enabling super sidebar!453[May 30 2023 03:09:13 UTC (QA Tests)] INFO -- Super sidebar is already enabled454[May 30 2023 03:09:14 UTC (QA Tests)] INFO -- Visiting QA::Resource::Project at http://gitlab-gitaly-cluster.test/gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/project-with-customizable-variable-pipeline-e70e9e7c691670e2455[May 30 2023 03:09:16 UTC (QA Tests)] INFO -- clicking :menu_section_button456[May 30 2023 03:09:16 UTC (QA Tests)] INFO -- clicking :nav_item_link457[May 30 2023 03:09:17 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element nav_item_link' took 0.877s458[May 30 2023 03:09:17 UTC (QA Tests)] INFO -- clicking :run_pipeline_button and ensuring QA::Page::Project::Pipeline::New is present459[May 30 2023 03:09:18 UTC (QA Tests)] WARN -- Potentially Slow Code 'wait_for_requests ' took 1.029s460[May 30 2023 03:09:19 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element run_pipeline_button' took 1.987s461[May 30 2023 03:09:20 UTC (QA Tests)] WARN -- Potentially Slow Code 'finished_loading? ' took 1.022s462[May 30 2023 03:09:21 UTC (QA Tests)] WARN -- Potentially Slow Code 'finished_loading? ' took 0.701s463[May 30 2023 03:09:21 UTC (QA Tests)] WARN -- Potentially Slow Code 'wait_for_requests ' took 1.832s464[May 30 2023 03:09:21 UTC (QA Tests)] WARN -- Potentially Slow Code 'all_elements ci_variable_row_container' took 1.848s465[May 30 2023 03:09:21 UTC (QA Tests)] INFO -- filling :ci_variable_value_field with "Custom Foo"466[May 30 2023 03:09:21 UTC (QA Tests)] INFO -- clicking the coordinates of :ci_variable_value_field467[May 30 2023 03:09:22 UTC (QA Tests)] INFO -- clicking :run_pipeline_button and ensuring QA::Page::Project::Pipeline::Show is present468[May 30 2023 03:09:24 UTC (QA Tests)] WARN -- Potentially Slow Code 'has_element? pipeline_header' took 2.142s469[May 30 2023 03:09:24 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element run_pipeline_button' took 2.417s470[May 30 2023 03:09:36 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Job with name 'customizable-variable' via api in 0.1 seconds471[May 30 2023 03:09:36 UTC (QA Tests)] INFO -- Visiting QA::Resource::Job at http://gitlab-gitaly-cluster.test/gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/project-with-customizable-variable-pipeline-e70e9e7c691670e2/-/jobs/2472[May 30 2023 03:09:38 UTC (QA Tests)] INFO -- Removed a QA::Resource::ProjectRunner with name 'qa-runner-1685416141'473[May 30 2023 03:09:38 UTC (QA Tests)] INFO -- Executing: `docker rm -f qa-runner-1685416141`474 manually creates a pipeline and uses the defined custom variable value475Plan476 A project wiki477[May 30 2023 03:09:39 UTC (QA Tests)] INFO -- Starting test: Plan A project wiki can change the directory path of a page478[May 30 2023 03:09:39 UTC (QA Tests)] INFO -- filling :login_field with "root"479[May 30 2023 03:09:39 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field480[May 30 2023 03:09:40 UTC (QA Tests)] INFO -- filling :password_field with "*****"481[May 30 2023 03:09:40 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field482[May 30 2023 03:09:40 UTC (QA Tests)] INFO -- clicking :sign_in_button483[May 30 2023 03:09:41 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 0.882s484[May 30 2023 03:09:41 UTC (QA Tests)] INFO -- Enabling super sidebar!485[May 30 2023 03:09:41 UTC (QA Tests)] INFO -- Super sidebar is already enabled486[May 30 2023 03:09:42 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-3' via api in 0.07 seconds487[May 30 2023 03:09:43 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04' via api in 0.21 seconds488[May 30 2023 03:09:44 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/wiki_testing-a222e71044ac8846' via api in 1.31 seconds489[May 30 2023 03:09:44 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Wiki::ProjectPage via api in 1.89 seconds490[May 30 2023 03:09:44 UTC (QA Tests)] INFO -- Visiting QA::Resource::Wiki::ProjectPage at http://gitlab-gitaly-cluster.test/gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/wiki_testing-a222e71044ac8846/-/wikis/Home491[May 30 2023 03:09:46 UTC (QA Tests)] INFO -- clicking :edit_page_button492[May 30 2023 03:09:46 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element edit_page_button' took 0.786s493[May 30 2023 03:09:46 UTC (QA Tests)] INFO -- filling :wiki_title_textbox with "a/new/path-with-spaces/home"494[May 30 2023 03:09:46 UTC (QA Tests)] INFO -- clicking the coordinates of :wiki_title_textbox495[May 30 2023 03:09:47 UTC (QA Tests)] INFO -- filling :wiki_message_textbox with "changing the path of the home page"496[May 30 2023 03:09:47 UTC (QA Tests)] INFO -- clicking the coordinates of :wiki_message_textbox497[May 30 2023 03:09:48 UTC (QA Tests)] INFO -- clicking :wiki_submit_button498[May 30 2023 03:09:49 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element wiki_submit_button' took 1.466s499 can change the directory path of a page500Verify501 Run pipeline502 with web only rule503[May 30 2023 03:09:50 UTC (QA Tests)] INFO -- Starting test: Verify Run pipeline with web only rule can trigger pipeline504[May 30 2023 03:09:50 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-3' via api in 0.08 seconds505[May 30 2023 03:09:50 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04' via api in 0.14 seconds506[May 30 2023 03:09:51 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/web-only-pipeline-3af8d36f6811a3e1' via api in 0.81 seconds507[May 30 2023 03:09:51 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Repository::Commit via api in 0.58 seconds508[May 30 2023 03:09:52 UTC (QA Tests)] INFO -- filling :login_field with "root"509[May 30 2023 03:09:52 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field510[May 30 2023 03:09:52 UTC (QA Tests)] INFO -- filling :password_field with "*****"511[May 30 2023 03:09:52 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field512[May 30 2023 03:09:52 UTC (QA Tests)] INFO -- clicking :sign_in_button513[May 30 2023 03:09:53 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 0.75s514[May 30 2023 03:09:53 UTC (QA Tests)] INFO -- Enabling super sidebar!515[May 30 2023 03:09:53 UTC (QA Tests)] INFO -- Super sidebar is already enabled516[May 30 2023 03:09:55 UTC (QA Tests)] INFO -- Visiting QA::Resource::Project at http://gitlab-gitaly-cluster.test/gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/web-only-pipeline-3af8d36f6811a3e1517[May 30 2023 03:09:56 UTC (QA Tests)] INFO -- clicking :menu_section_button518[May 30 2023 03:09:56 UTC (QA Tests)] INFO -- clicking :nav_item_link519[May 30 2023 03:09:57 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element nav_item_link' took 0.893s520[May 30 2023 03:09:58 UTC (QA Tests)] INFO -- clicking :run_pipeline_button and ensuring QA::Page::Project::Pipeline::New is present521[May 30 2023 03:09:58 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element run_pipeline_button' took 0.882s522[May 30 2023 03:09:58 UTC (QA Tests)] INFO -- clicking :run_pipeline_button and ensuring QA::Page::Project::Pipeline::Show is present523[May 30 2023 03:09:59 UTC (QA Tests)] WARN -- Potentially Slow Code 'finished_loading? ' took 1.017s524[May 30 2023 03:10:00 UTC (QA Tests)] WARN -- Potentially Slow Code 'finished_loading? ' took 0.681s525[May 30 2023 03:10:00 UTC (QA Tests)] WARN -- Potentially Slow Code 'wait_for_requests ' took 1.808s526[May 30 2023 03:10:02 UTC (QA Tests)] WARN -- Potentially Slow Code 'has_element? pipeline_header' took 1.301s527[May 30 2023 03:10:02 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element run_pipeline_button' took 3.501s528 can trigger pipeline529Create530 Link to line in Web IDE531[May 30 2023 03:10:02 UTC (QA Tests)] INFO -- Starting test: Create Link to line in Web IDE can link to a specific line of code in Web IDE532[May 30 2023 03:10:02 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-3' via api in 0.08 seconds533[May 30 2023 03:10:02 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04' via api in 0.14 seconds534[May 30 2023 03:10:08 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/the_awesome_project-b1205a4ec2434562' via api in 5.93 seconds535[May 30 2023 03:10:08 UTC (QA Tests)] INFO -- Removed a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/the_awesome_project-b1205a4ec2434562'536 can link to a specific line of code in Web IDE (PENDING: Skipped but kept as reference. https://gitlab.com/gitlab-org/gitlab/-/merge_requests/115741#note_1330720944)537Verify538 Pipeline with prefill variables539[May 30 2023 03:10:08 UTC (QA Tests)] INFO -- Starting test: Verify Pipeline with prefill variables shows dropdown for variables with description, value, and options defined540[May 30 2023 03:10:08 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-3' via api in 0.07 seconds541[May 30 2023 03:10:08 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04' via api in 0.14 seconds542[May 30 2023 03:10:09 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/project-with-prefill-variables-71d1d69f6bb4ba88' via api in 0.8 seconds543[May 30 2023 03:10:10 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Repository::Commit via api in 0.56 seconds544[May 30 2023 03:10:11 UTC (QA Tests)] INFO -- filling :login_field with "root"545[May 30 2023 03:10:11 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field546[May 30 2023 03:10:11 UTC (QA Tests)] INFO -- filling :password_field with "*****"547[May 30 2023 03:10:11 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field548[May 30 2023 03:10:12 UTC (QA Tests)] INFO -- clicking :sign_in_button549[May 30 2023 03:10:13 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 0.835s550[May 30 2023 03:10:13 UTC (QA Tests)] INFO -- Enabling super sidebar!551[May 30 2023 03:10:13 UTC (QA Tests)] INFO -- Super sidebar is already enabled552[May 30 2023 03:10:14 UTC (QA Tests)] INFO -- Visiting QA::Resource::Project at http://gitlab-gitaly-cluster.test/gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/project-with-prefill-variables-71d1d69f6bb4ba88553[May 30 2023 03:10:16 UTC (QA Tests)] INFO -- clicking :menu_section_button554[May 30 2023 03:10:16 UTC (QA Tests)] INFO -- clicking :nav_item_link555[May 30 2023 03:10:17 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element nav_item_link' took 0.691s556[May 30 2023 03:10:17 UTC (QA Tests)] INFO -- clicking :run_pipeline_button and ensuring QA::Page::Project::Pipeline::New is present557[May 30 2023 03:10:18 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element run_pipeline_button' took 1.087s558[May 30 2023 03:10:19 UTC (QA Tests)] WARN -- Potentially Slow Code 'finished_loading? ' took 0.829s559[May 30 2023 03:10:19 UTC (QA Tests)] WARN -- Potentially Slow Code 'wait_for_requests ' took 0.832s560[May 30 2023 03:10:19 UTC (QA Tests)] WARN -- Potentially Slow Code 'has_element? ci_variable_value_dropdown' took 1.859s561[May 30 2023 03:10:20 UTC (QA Tests)] INFO -- clicking :ci_variable_value_dropdown562 shows dropdown for variables with description, value, and options defined563[May 30 2023 03:10:20 UTC (QA Tests)] INFO -- Starting test: Verify Pipeline with prefill variables shows only variables with description as prefill variables on the run pipeline page564[May 30 2023 03:10:20 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-3' via api in 0.07 seconds565[May 30 2023 03:10:20 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04' via api in 0.13 seconds566[May 30 2023 03:10:20 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/project-with-prefill-variables-26425feac89b0834' via api in 0.74 seconds567[May 30 2023 03:10:21 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Repository::Commit via api in 0.54 seconds568[May 30 2023 03:10:22 UTC (QA Tests)] INFO -- filling :login_field with "root"569[May 30 2023 03:10:22 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field570[May 30 2023 03:10:22 UTC (QA Tests)] INFO -- filling :password_field with "*****"571[May 30 2023 03:10:22 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field572[May 30 2023 03:10:22 UTC (QA Tests)] INFO -- clicking :sign_in_button573[May 30 2023 03:10:23 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 0.965s574[May 30 2023 03:10:24 UTC (QA Tests)] INFO -- Enabling super sidebar!575[May 30 2023 03:10:24 UTC (QA Tests)] INFO -- Super sidebar is already enabled576[May 30 2023 03:10:25 UTC (QA Tests)] INFO -- Visiting QA::Resource::Project at http://gitlab-gitaly-cluster.test/gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/project-with-prefill-variables-26425feac89b0834577[May 30 2023 03:10:26 UTC (QA Tests)] INFO -- clicking :menu_section_button578[May 30 2023 03:10:27 UTC (QA Tests)] INFO -- clicking :nav_item_link579[May 30 2023 03:10:27 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element nav_item_link' took 0.768s580[May 30 2023 03:10:27 UTC (QA Tests)] INFO -- clicking :run_pipeline_button and ensuring QA::Page::Project::Pipeline::New is present581[May 30 2023 03:10:28 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element run_pipeline_button' took 1.113s582 shows only variables with description as prefill variables on the run pipeline page583Plan584 Issue creation585[May 30 2023 03:10:31 UTC (QA Tests)] INFO -- Starting test: Plan Issue creation closes an issue586[May 30 2023 03:10:31 UTC (QA Tests)] INFO -- filling :login_field with "root"587[May 30 2023 03:10:31 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field588[May 30 2023 03:10:32 UTC (QA Tests)] INFO -- filling :password_field with "*****"589[May 30 2023 03:10:32 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field590[May 30 2023 03:10:32 UTC (QA Tests)] INFO -- clicking :sign_in_button591[May 30 2023 03:10:33 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 0.783s592[May 30 2023 03:10:33 UTC (QA Tests)] INFO -- Enabling super sidebar!593[May 30 2023 03:10:33 UTC (QA Tests)] INFO -- Super sidebar is already enabled594[May 30 2023 03:10:35 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-3' via api in 0.07 seconds595[May 30 2023 03:10:35 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04' via api in 0.14 seconds596[May 30 2023 03:10:35 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/project-for-issues-c5c33846d39d35c2' via api in 0.69 seconds597[May 30 2023 03:10:35 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Issue with id '2' via api in 1.04 seconds598[May 30 2023 03:10:35 UTC (QA Tests)] INFO -- Visiting QA::Resource::Issue at http://gitlab-gitaly-cluster.test/gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/project-for-issues-c5c33846d39d35c2/-/issues/1599[May 30 2023 03:10:38 UTC (QA Tests)] INFO -- clicking :menu_section_button600[May 30 2023 03:10:38 UTC (QA Tests)] INFO -- clicking :nav_item_link601[May 30 2023 03:10:40 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element nav_item_link' took 1.205s602[May 30 2023 03:10:40 UTC (QA Tests)] INFO -- clicking :closed_issuables_tab603 closes an issue604[May 30 2023 03:10:40 UTC (QA Tests)] INFO -- Starting test: Plan Issue creation creates an issue605[May 30 2023 03:10:41 UTC (QA Tests)] INFO -- filling :login_field with "root"606[May 30 2023 03:10:41 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field607[May 30 2023 03:10:41 UTC (QA Tests)] INFO -- filling :password_field with "*****"608[May 30 2023 03:10:41 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field609[May 30 2023 03:10:41 UTC (QA Tests)] INFO -- clicking :sign_in_button610[May 30 2023 03:10:42 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 0.813s611[May 30 2023 03:10:42 UTC (QA Tests)] INFO -- Enabling super sidebar!612[May 30 2023 03:10:42 UTC (QA Tests)] INFO -- Super sidebar is already enabled613[May 30 2023 03:10:44 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-3' via api in 0.05 seconds614[May 30 2023 03:10:44 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04' via api in 0.11 seconds615[May 30 2023 03:10:44 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/the_awesome_project-0bf3dc995c179d7f' via api in 0.53 seconds616[May 30 2023 03:10:44 UTC (QA Tests)] INFO -- Visiting QA::Resource::Project at http://gitlab-gitaly-cluster.test/gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/the_awesome_project-0bf3dc995c179d7f617[May 30 2023 03:10:45 UTC (QA Tests)] INFO -- clicking :new_menu_toggle618[May 30 2023 03:10:45 UTC (QA Tests)] INFO -- clicking :create_menu_item619[May 30 2023 03:10:46 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element create_menu_item' took 1.15s620[May 30 2023 03:10:46 UTC (QA Tests)] INFO -- filling :issuable_form_title_field with "Issue title 980f5de1460c282c"621[May 30 2023 03:10:46 UTC (QA Tests)] INFO -- clicking the coordinates of :issuable_form_title_field622[May 30 2023 03:10:47 UTC (QA Tests)] INFO -- filling :issuable_form_description_field with "Issue description 4a3eee047070f7e8"623[May 30 2023 03:10:47 UTC (QA Tests)] INFO -- clicking the coordinates of :issuable_form_description_field624[May 30 2023 03:10:47 UTC (QA Tests)] INFO -- clicking :issuable_create_button and ensuring QA::Page::Project::Issue::Show is present625[May 30 2023 03:10:50 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element issuable_create_button' took 2.564s626[May 30 2023 03:10:50 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Issue via browser_ui in 5.77 seconds627[May 30 2023 03:10:50 UTC (QA Tests)] INFO -- clicking :menu_section_button628[May 30 2023 03:10:50 UTC (QA Tests)] INFO -- clicking :nav_item_link629[May 30 2023 03:10:51 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element nav_item_link' took 0.858s630 creates an issue631 when using attachments in comments632[May 30 2023 03:10:51 UTC (QA Tests)] INFO -- Starting test: Plan Issue creation when using attachments in comments comments on an issue with an attachment633[May 30 2023 03:10:52 UTC (QA Tests)] INFO -- filling :login_field with "root"634[May 30 2023 03:10:52 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field635[May 30 2023 03:10:52 UTC (QA Tests)] INFO -- filling :password_field with "*****"636[May 30 2023 03:10:52 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field637[May 30 2023 03:10:53 UTC (QA Tests)] INFO -- clicking :sign_in_button638[May 30 2023 03:10:54 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 0.971s639[May 30 2023 03:10:54 UTC (QA Tests)] INFO -- Enabling super sidebar!640[May 30 2023 03:10:54 UTC (QA Tests)] INFO -- Super sidebar is already enabled641[May 30 2023 03:10:55 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-3' via api in 0.06 seconds642[May 30 2023 03:10:55 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04' via api in 0.11 seconds643[May 30 2023 03:10:56 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/project-for-issues-0fec9e843e388462' via api in 0.59 seconds644[May 30 2023 03:10:56 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Issue with id '4' via api in 0.97 seconds645[May 30 2023 03:10:56 UTC (QA Tests)] INFO -- Visiting QA::Resource::Issue at http://gitlab-gitaly-cluster.test/gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/project-for-issues-0fec9e843e388462/-/issues/1646[May 30 2023 03:10:58 UTC (QA Tests)] INFO -- clicking :title_content647[May 30 2023 03:10:58 UTC (QA Tests)] INFO -- clicking :discussion_preferences_dropdown648[May 30 2023 03:10:58 UTC (QA Tests)] INFO -- filling :comment_field with "See attached image for scale649"650[May 30 2023 03:10:58 UTC (QA Tests)] INFO -- clicking the coordinates of :comment_field651[May 30 2023 03:10:59 UTC (QA Tests)] INFO -- clicking :comment_button652[May 30 2023 03:11:00 UTC (QA Tests)] WARN -- Potentially Slow Code 'wait_for_requests ' took 0.542s653[May 30 2023 03:11:00 UTC (QA Tests)] WARN -- Potentially Slow Code 'find_element noteable_note_container' took 0.558s654 comments on an issue with an attachment655Plan656 Milestones657 Group milestone658 behaves like milestone assigned to existing issue659[May 30 2023 03:11:00 UTC (QA Tests)] INFO -- Starting test: Plan Milestones Group milestone behaves like milestone assigned to existing issue is assigned to an existing issue660[May 30 2023 03:11:00 UTC (QA Tests)] INFO -- filling :login_field with "root"661[May 30 2023 03:11:00 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field662[May 30 2023 03:11:01 UTC (QA Tests)] INFO -- filling :password_field with "*****"663[May 30 2023 03:11:01 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field664[May 30 2023 03:11:01 UTC (QA Tests)] INFO -- clicking :sign_in_button665[May 30 2023 03:11:02 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 0.906s666[May 30 2023 03:11:02 UTC (QA Tests)] INFO -- Enabling super sidebar!667[May 30 2023 03:11:02 UTC (QA Tests)] INFO -- Super sidebar is already enabled668[May 30 2023 03:11:04 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-3' via api in 0.06 seconds669[May 30 2023 03:11:04 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-3/group-to-test-milestones-e992fe3a' via api in 0.3 seconds670[May 30 2023 03:11:04 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-3/group-to-test-milestones-e992fe3a/project-to-test-milestones-470e7105-f926efede4431981' via api in 0.47 seconds671[May 30 2023 03:11:05 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Issue with id '5' via api in 0.33 seconds672[May 30 2023 03:11:05 UTC (QA Tests)] INFO -- Visiting QA::Resource::Issue at http://gitlab-gitaly-cluster.test/gitlab-qa-sandbox-group-3/group-to-test-milestones-e992fe3a/project-to-test-milestones-470e7105-f926efede4431981/-/issues/1673[May 30 2023 03:11:07 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::GroupMilestone with id '1' via api in 0.12 seconds674[May 30 2023 03:11:07 UTC (QA Tests)] INFO -- clicking :edit_link675[May 30 2023 03:11:07 UTC (QA Tests)] INFO -- refreshing http://gitlab-gitaly-cluster.test/gitlab-qa-sandbox-group-3/group-to-test-milestones-e992fe3a/project-to-test-milestones-470e7105-f926efede4431981/-/issues/1676 is assigned to an existing issue677 behaves like milestone assigned to new issue678[May 30 2023 03:11:09 UTC (QA Tests)] INFO -- Starting test: Plan Milestones Group milestone behaves like milestone assigned to new issue is assigned to a new issue679[May 30 2023 03:11:10 UTC (QA Tests)] INFO -- filling :login_field with "root"680[May 30 2023 03:11:10 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field681[May 30 2023 03:11:10 UTC (QA Tests)] INFO -- filling :password_field with "*****"682[May 30 2023 03:11:10 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field683[May 30 2023 03:11:10 UTC (QA Tests)] INFO -- clicking :sign_in_button684[May 30 2023 03:11:11 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 0.965s685[May 30 2023 03:11:12 UTC (QA Tests)] INFO -- Enabling super sidebar!686[May 30 2023 03:11:12 UTC (QA Tests)] INFO -- Super sidebar is already enabled687[May 30 2023 03:11:13 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-3' via api in 0.06 seconds688[May 30 2023 03:11:13 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-3/group-to-test-milestones-688ea8ae' via api in 0.3 seconds689[May 30 2023 03:11:14 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-3/group-to-test-milestones-688ea8ae/project-to-test-milestones-4c0d9ff6-c59b09a437d4a0f8' via api in 0.44 seconds690[May 30 2023 03:11:14 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::GroupMilestone with id '2' via api in 0.1 seconds691[May 30 2023 03:11:14 UTC (QA Tests)] INFO -- Visiting QA::Resource::Project at http://gitlab-gitaly-cluster.test/gitlab-qa-sandbox-group-3/group-to-test-milestones-688ea8ae/project-to-test-milestones-4c0d9ff6-c59b09a437d4a0f8692[May 30 2023 03:11:15 UTC (QA Tests)] INFO -- clicking :new_menu_toggle693[May 30 2023 03:11:15 UTC (QA Tests)] INFO -- clicking :create_menu_item694[May 30 2023 03:11:16 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element create_menu_item' took 0.897s695[May 30 2023 03:11:16 UTC (QA Tests)] INFO -- filling :issuable_form_title_field with "Issue title 91666aea35f3e85e"696[May 30 2023 03:11:16 UTC (QA Tests)] INFO -- clicking the coordinates of :issuable_form_title_field697[May 30 2023 03:11:16 UTC (QA Tests)] INFO -- filling :issuable_form_description_field with "Issue description 21260dfa7bfeaef2"698[May 30 2023 03:11:16 UTC (QA Tests)] INFO -- clicking the coordinates of :issuable_form_description_field699[May 30 2023 03:11:17 UTC (QA Tests)] INFO -- clicking :issuable_create_button and ensuring QA::Page::Project::Issue::Show is present700[May 30 2023 03:11:19 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element issuable_create_button' took 2.328s701[May 30 2023 03:11:19 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Issue via browser_ui in 5.71 seconds702 is assigned to a new issue703 Project milestone704 behaves like milestone assigned to new issue705[May 30 2023 03:11:20 UTC (QA Tests)] INFO -- Starting test: Plan Milestones Project milestone behaves like milestone assigned to new issue is assigned to a new issue706[May 30 2023 03:11:20 UTC (QA Tests)] INFO -- filling :login_field with "root"707[May 30 2023 03:11:20 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field708[May 30 2023 03:11:20 UTC (QA Tests)] INFO -- filling :password_field with "*****"709[May 30 2023 03:11:20 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field710[May 30 2023 03:11:21 UTC (QA Tests)] INFO -- clicking :sign_in_button711[May 30 2023 03:11:22 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 0.924s712[May 30 2023 03:11:22 UTC (QA Tests)] INFO -- Enabling super sidebar!713[May 30 2023 03:11:22 UTC (QA Tests)] INFO -- Super sidebar is already enabled714[May 30 2023 03:11:23 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-3' via api in 0.06 seconds715[May 30 2023 03:11:24 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-3/group-to-test-milestones-f37d17e4' via api in 0.35 seconds716[May 30 2023 03:11:24 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-3/group-to-test-milestones-f37d17e4/project-to-test-milestones-f5657cdd-49b68964d849ea83' via api in 0.43 seconds717[May 30 2023 03:11:24 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::ProjectMilestone with id '3' via api in 0.14 seconds718[May 30 2023 03:11:24 UTC (QA Tests)] INFO -- Visiting QA::Resource::Project at http://gitlab-gitaly-cluster.test/gitlab-qa-sandbox-group-3/group-to-test-milestones-f37d17e4/project-to-test-milestones-f5657cdd-49b68964d849ea83719[May 30 2023 03:11:25 UTC (QA Tests)] INFO -- clicking :new_menu_toggle720[May 30 2023 03:11:25 UTC (QA Tests)] INFO -- clicking :create_menu_item721[May 30 2023 03:11:26 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element create_menu_item' took 0.995s722[May 30 2023 03:11:26 UTC (QA Tests)] INFO -- filling :issuable_form_title_field with "Issue title a27731efc35c2bc7"723[May 30 2023 03:11:26 UTC (QA Tests)] INFO -- clicking the coordinates of :issuable_form_title_field724[May 30 2023 03:11:27 UTC (QA Tests)] INFO -- filling :issuable_form_description_field with "Issue description e9fab5d207196f75"725[May 30 2023 03:11:27 UTC (QA Tests)] INFO -- clicking the coordinates of :issuable_form_description_field726[May 30 2023 03:11:28 UTC (QA Tests)] INFO -- clicking :issuable_create_button and ensuring QA::Page::Project::Issue::Show is present727[May 30 2023 03:11:30 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element issuable_create_button' took 2.55s728[May 30 2023 03:11:30 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Issue via browser_ui in 5.94 seconds729 is assigned to a new issue730 behaves like milestone assigned to existing issue731[May 30 2023 03:11:30 UTC (QA Tests)] INFO -- Starting test: Plan Milestones Project milestone behaves like milestone assigned to existing issue is assigned to an existing issue732[May 30 2023 03:11:31 UTC (QA Tests)] INFO -- filling :login_field with "root"733[May 30 2023 03:11:31 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field734[May 30 2023 03:11:31 UTC (QA Tests)] INFO -- filling :password_field with "*****"735[May 30 2023 03:11:31 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field736[May 30 2023 03:11:32 UTC (QA Tests)] INFO -- clicking :sign_in_button737[May 30 2023 03:11:33 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 0.928s738[May 30 2023 03:11:33 UTC (QA Tests)] INFO -- Enabling super sidebar!739[May 30 2023 03:11:33 UTC (QA Tests)] INFO -- Super sidebar is already enabled740[May 30 2023 03:11:34 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-3' via api in 0.06 seconds741[May 30 2023 03:11:35 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-3/group-to-test-milestones-8e33c54a' via api in 0.31 seconds742[May 30 2023 03:11:35 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-3/group-to-test-milestones-8e33c54a/project-to-test-milestones-ce7ac017-f45a7136bd93dd5d' via api in 0.45 seconds743[May 30 2023 03:11:35 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Issue with id '8' via api in 0.25 seconds744[May 30 2023 03:11:35 UTC (QA Tests)] INFO -- Visiting QA::Resource::Issue at http://gitlab-gitaly-cluster.test/gitlab-qa-sandbox-group-3/group-to-test-milestones-8e33c54a/project-to-test-milestones-ce7ac017-f45a7136bd93dd5d/-/issues/1745[May 30 2023 03:11:37 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::ProjectMilestone with id '4' via api in 0.12 seconds746[May 30 2023 03:11:37 UTC (QA Tests)] INFO -- clicking :edit_link747[May 30 2023 03:11:38 UTC (QA Tests)] INFO -- refreshing http://gitlab-gitaly-cluster.test/gitlab-qa-sandbox-group-3/group-to-test-milestones-8e33c54a/project-to-test-milestones-ce7ac017-f45a7136bd93dd5d/-/issues/1748[May 30 2023 03:11:40 UTC (QA Tests)] WARN -- Potentially Slow Code 'wait_for_requests ' took 1.816s749 is assigned to an existing issue750Create751 SSH key support752[May 30 2023 03:11:40 UTC (QA Tests)] INFO -- Executing: `ssh-keygen -t rsa -b 4096 -f /tmp/d20230530-38-peo897/id_rsa -N `753[May 30 2023 03:11:40 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::SSHKey with id '1' via api in 0.44 seconds754[May 30 2023 03:11:40 UTC (QA Tests)] INFO -- Starting test: Create SSH key support pushes multiple branches and tags together755[May 30 2023 03:11:41 UTC (QA Tests)] INFO -- filling :login_field with "root"756[May 30 2023 03:11:41 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field757[May 30 2023 03:11:41 UTC (QA Tests)] INFO -- filling :password_field with "*****"758[May 30 2023 03:11:41 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field759[May 30 2023 03:11:42 UTC (QA Tests)] INFO -- clicking :sign_in_button760[May 30 2023 03:11:43 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 0.965s761[May 30 2023 03:11:43 UTC (QA Tests)] INFO -- Enabling super sidebar!762[May 30 2023 03:11:43 UTC (QA Tests)] INFO -- Super sidebar is already enabled763[May 30 2023 03:11:44 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-3' via api in 0.05 seconds764[May 30 2023 03:11:44 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04' via api in 0.11 seconds765[May 30 2023 03:11:45 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/ssh-tests-9b3efa85284d568b' via api in 0.57 seconds766 pushes multiple branches and tags together767[May 30 2023 03:11:47 UTC (QA Tests)] INFO -- Starting test: Create SSH key support pushes code to the repository via SSH768[May 30 2023 03:11:48 UTC (QA Tests)] INFO -- filling :login_field with "root"769[May 30 2023 03:11:48 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field770[May 30 2023 03:11:48 UTC (QA Tests)] INFO -- filling :password_field with "*****"771[May 30 2023 03:11:48 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field772[May 30 2023 03:11:48 UTC (QA Tests)] INFO -- clicking :sign_in_button773[May 30 2023 03:11:49 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 1.092s774[May 30 2023 03:11:50 UTC (QA Tests)] INFO -- Enabling super sidebar!775[May 30 2023 03:11:50 UTC (QA Tests)] INFO -- Super sidebar is already enabled776[May 30 2023 03:11:51 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-3' via api in 0.06 seconds777[May 30 2023 03:11:51 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04' via api in 0.11 seconds778[May 30 2023 03:11:52 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/ssh-tests-a164b574726d7389' via api in 0.58 seconds779[May 30 2023 03:11:53 UTC (QA Tests)] INFO -- QA::Resource::Project - wait_for_push with commit message "Add README.md"780[May 30 2023 03:11:53 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Repository::ProjectPush via browser_ui in 1.43 seconds781[May 30 2023 03:11:53 UTC (QA Tests)] INFO -- Visiting QA::Resource::Project at http://gitlab-gitaly-cluster.test/gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/ssh-tests-a164b574726d7389782 pushes code to the repository via SSH783[May 30 2023 03:11:55 UTC (QA Tests)] INFO -- Removed a QA::Resource::SSHKey with id '1'784Create785 File templates786[May 30 2023 03:11:55 UTC (QA Tests)] INFO -- Starting test: Create File templates user adds Dockerfile via file template Python787[May 30 2023 03:11:55 UTC (QA Tests)] INFO -- filling :login_field with "root"788[May 30 2023 03:11:55 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field789[May 30 2023 03:11:56 UTC (QA Tests)] INFO -- filling :password_field with "*****"790[May 30 2023 03:11:56 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field791[May 30 2023 03:11:56 UTC (QA Tests)] INFO -- clicking :sign_in_button792[May 30 2023 03:11:57 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 1.076s793[May 30 2023 03:11:57 UTC (QA Tests)] INFO -- Enabling super sidebar!794[May 30 2023 03:11:57 UTC (QA Tests)] INFO -- Super sidebar is already enabled795[May 30 2023 03:11:59 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-3' via api in 0.06 seconds796[May 30 2023 03:11:59 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04' via api in 0.12 seconds797[May 30 2023 03:12:00 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/file-template-project-9bb5f0dbf60889d1' via api in 0.9 seconds798[May 30 2023 03:12:00 UTC (QA Tests)] INFO -- Visiting QA::Resource::Project at http://gitlab-gitaly-cluster.test/gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/file-template-project-9bb5f0dbf60889d1799[May 30 2023 03:12:01 UTC (QA Tests)] INFO -- clicking :add_to_tree_dropdown800[May 30 2023 03:12:01 UTC (QA Tests)] INFO -- clicking :new_file_menu_item801[May 30 2023 03:12:02 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element new_file_menu_item' took 1.121s802[May 30 2023 03:12:02 UTC (QA Tests)] INFO -- filling :file_name_field with "fca5ed1370588a9b/Dockerfile"803[May 30 2023 03:12:02 UTC (QA Tests)] INFO -- clicking the coordinates of :file_name_field804[May 30 2023 03:12:03 UTC (QA Tests)] INFO -- clicking :dockerfile_dropdown805[May 30 2023 03:12:04 UTC (QA Tests)] WARN -- Potentially Slow Code 'has_element? blob_viewer_file_content' took 1.126s806[May 30 2023 03:12:04 UTC (QA Tests)] INFO -- clicking :commit_button807[May 30 2023 03:12:06 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element commit_button' took 1.323s808 user adds Dockerfile via file template Python809[May 30 2023 03:12:06 UTC (QA Tests)] INFO -- Starting test: Create File templates user adds .gitignore via file template Android810[May 30 2023 03:12:07 UTC (QA Tests)] INFO -- filling :login_field with "root"811[May 30 2023 03:12:07 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field812[May 30 2023 03:12:07 UTC (QA Tests)] INFO -- filling :password_field with "*****"813[May 30 2023 03:12:07 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field814[May 30 2023 03:12:08 UTC (QA Tests)] INFO -- clicking :sign_in_button815[May 30 2023 03:12:09 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 1.014s816[May 30 2023 03:12:09 UTC (QA Tests)] INFO -- Enabling super sidebar!817[May 30 2023 03:12:09 UTC (QA Tests)] INFO -- Super sidebar is already enabled818[May 30 2023 03:12:11 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-3' via api in 0.06 seconds819[May 30 2023 03:12:11 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04' via api in 0.12 seconds820[May 30 2023 03:12:11 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/file-template-project-df2cc78211212f1e' via api in 0.92 seconds821[May 30 2023 03:12:11 UTC (QA Tests)] INFO -- Visiting QA::Resource::Project at http://gitlab-gitaly-cluster.test/gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/file-template-project-df2cc78211212f1e822[May 30 2023 03:12:13 UTC (QA Tests)] INFO -- clicking :add_to_tree_dropdown823[May 30 2023 03:12:13 UTC (QA Tests)] INFO -- clicking :new_file_menu_item824[May 30 2023 03:12:14 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element new_file_menu_item' took 1.099s825[May 30 2023 03:12:14 UTC (QA Tests)] INFO -- filling :file_name_field with "04e533bf956e7034/.gitignore"826[May 30 2023 03:12:14 UTC (QA Tests)] INFO -- clicking the coordinates of :file_name_field827[May 30 2023 03:12:14 UTC (QA Tests)] INFO -- clicking :gitignore_dropdown828[May 30 2023 03:12:16 UTC (QA Tests)] WARN -- Potentially Slow Code 'has_element? blob_viewer_file_content' took 1.124s829[May 30 2023 03:12:16 UTC (QA Tests)] INFO -- clicking :commit_button830[May 30 2023 03:12:17 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element commit_button' took 1.266s831 user adds .gitignore via file template Android832[May 30 2023 03:12:18 UTC (QA Tests)] INFO -- Starting test: Create File templates user adds .[MASKED].yml via file template Julia833[May 30 2023 03:12:19 UTC (QA Tests)] INFO -- filling :login_field with "root"834[May 30 2023 03:12:19 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field835[May 30 2023 03:12:19 UTC (QA Tests)] INFO -- filling :password_field with "*****"836[May 30 2023 03:12:19 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field837[May 30 2023 03:12:19 UTC (QA Tests)] INFO -- clicking :sign_in_button838[May 30 2023 03:12:20 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 1.073s839[May 30 2023 03:12:21 UTC (QA Tests)] INFO -- Enabling super sidebar!840[May 30 2023 03:12:21 UTC (QA Tests)] INFO -- Super sidebar is already enabled841[May 30 2023 03:12:22 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-3' via api in 0.06 seconds842[May 30 2023 03:12:22 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04' via api in 0.11 seconds843[May 30 2023 03:12:23 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/file-template-project-be443b052cb489b5' via api in 0.93 seconds844[May 30 2023 03:12:23 UTC (QA Tests)] INFO -- Visiting QA::Resource::Project at http://gitlab-gitaly-cluster.test/gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/file-template-project-be443b052cb489b5845[May 30 2023 03:12:25 UTC (QA Tests)] INFO -- clicking :add_to_tree_dropdown846[May 30 2023 03:12:25 UTC (QA Tests)] INFO -- clicking :new_file_menu_item847[May 30 2023 03:12:26 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element new_file_menu_item' took 0.964s848[May 30 2023 03:12:26 UTC (QA Tests)] INFO -- filling :file_name_field with "3328ec68375bb4e9/.[MASKED].yml"849[May 30 2023 03:12:26 UTC (QA Tests)] INFO -- clicking the coordinates of :file_name_field850[May 30 2023 03:12:26 UTC (QA Tests)] INFO -- clicking :gitlab_ci_yml_dropdown851[May 30 2023 03:12:27 UTC (QA Tests)] WARN -- Potentially Slow Code 'has_element? blob_viewer_file_content' took 1.143s852[May 30 2023 03:12:28 UTC (QA Tests)] INFO -- clicking :commit_button853[May 30 2023 03:12:29 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element commit_button' took 1.498s854 user adds .[MASKED].yml via file template Julia855[May 30 2023 03:12:30 UTC (QA Tests)] INFO -- Starting test: Create File templates user adds LICENSE via file template Mozilla Public License 2.0856[May 30 2023 03:12:31 UTC (QA Tests)] INFO -- filling :login_field with "root"857[May 30 2023 03:12:31 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field858[May 30 2023 03:12:31 UTC (QA Tests)] INFO -- filling :password_field with "*****"859[May 30 2023 03:12:31 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field860[May 30 2023 03:12:32 UTC (QA Tests)] INFO -- clicking :sign_in_button861[May 30 2023 03:12:33 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 1.043s862[May 30 2023 03:12:33 UTC (QA Tests)] INFO -- Enabling super sidebar!863[May 30 2023 03:12:33 UTC (QA Tests)] INFO -- Super sidebar is already enabled864[May 30 2023 03:12:35 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-3' via api in 0.06 seconds865[May 30 2023 03:12:35 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04' via api in 0.13 seconds866[May 30 2023 03:12:36 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/file-template-project-9edef60752bc03b0' via api in 1.03 seconds867[May 30 2023 03:12:36 UTC (QA Tests)] INFO -- Visiting QA::Resource::Project at http://gitlab-gitaly-cluster.test/gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/file-template-project-9edef60752bc03b0868[May 30 2023 03:12:37 UTC (QA Tests)] INFO -- clicking :add_to_tree_dropdown869[May 30 2023 03:12:37 UTC (QA Tests)] INFO -- clicking :new_file_menu_item870[May 30 2023 03:12:38 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element new_file_menu_item' took 0.927s871[May 30 2023 03:12:38 UTC (QA Tests)] INFO -- filling :file_name_field with "LICENSE"872[May 30 2023 03:12:38 UTC (QA Tests)] INFO -- clicking the coordinates of :file_name_field873[May 30 2023 03:12:38 UTC (QA Tests)] INFO -- clicking :license_dropdown874[May 30 2023 03:12:40 UTC (QA Tests)] WARN -- Potentially Slow Code 'has_element? blob_viewer_file_content' took 1.142s875[May 30 2023 03:12:40 UTC (QA Tests)] INFO -- clicking :commit_button876[May 30 2023 03:12:41 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element commit_button' took 1.493s877 user adds LICENSE via file template Mozilla Public License 2.0878Data Stores879 Check for broken images880 when logged in as a new admin881 behaves like loads all images882[May 30 2023 03:12:44 UTC (QA Tests)] INFO -- Starting test: Data Stores Check for broken images when logged in as a new admin behaves like loads all images loads all images883[May 30 2023 03:12:44 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::User with username 'qa-user-6e7e30a17d48b5e4' via api in 0.26 seconds884[May 30 2023 03:12:44 UTC (QA Tests)] INFO -- filling :login_field with "qa-user-6e7e30a17d48b5e4"885[May 30 2023 03:12:44 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field886[May 30 2023 03:12:45 UTC (QA Tests)] INFO -- filling :password_field with "*****"887[May 30 2023 03:12:45 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field888[May 30 2023 03:12:45 UTC (QA Tests)] INFO -- clicking :sign_in_button889[May 30 2023 03:12:46 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 0.747s890[May 30 2023 03:12:46 UTC (QA Tests)] INFO -- Enabling super sidebar!891[May 30 2023 03:12:46 UTC (QA Tests)] INFO -- Super sidebar is already enabled892[May 30 2023 03:12:47 UTC (QA Tests)] INFO -- refreshing http://gitlab-gitaly-cluster.test/893[May 30 2023 03:12:49 UTC (QA Tests)] INFO -- Removed a QA::Resource::User with username 'qa-user-6e7e30a17d48b5e4'894 loads all images895 when logged in as a new user896 behaves like loads all images897[May 30 2023 03:12:49 UTC (QA Tests)] INFO -- Starting test: Data Stores Check for broken images when logged in as a new user behaves like loads all images loads all images898[May 30 2023 03:12:49 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::User with username 'qa-user-bbbadfa3410bab3e' via api in 0.23 seconds899[May 30 2023 03:12:50 UTC (QA Tests)] INFO -- filling :login_field with "qa-user-bbbadfa3410bab3e"900[May 30 2023 03:12:50 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field901[May 30 2023 03:12:50 UTC (QA Tests)] INFO -- filling :password_field with "*****"902[May 30 2023 03:12:50 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field903[May 30 2023 03:12:50 UTC (QA Tests)] INFO -- clicking :sign_in_button904[May 30 2023 03:12:51 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 0.696s905[May 30 2023 03:12:51 UTC (QA Tests)] INFO -- Enabling super sidebar!906[May 30 2023 03:12:51 UTC (QA Tests)] INFO -- Super sidebar is already enabled907[May 30 2023 03:12:52 UTC (QA Tests)] INFO -- refreshing http://gitlab-gitaly-cluster.test/908[May 30 2023 03:12:54 UTC (QA Tests)] INFO -- Removed a QA::Resource::User with username 'qa-user-bbbadfa3410bab3e'909 loads all images910Verify911 Run pipeline with manual jobs912[May 30 2023 03:12:54 UTC (QA Tests)] INFO -- Starting test: Verify Run pipeline with manual jobs does not leave any job in skipped state913[May 30 2023 03:12:54 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-3' via api in 0.06 seconds914[May 30 2023 03:12:54 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04' via api in 0.12 seconds915[May 30 2023 03:12:55 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/pipeline-with-manual-job-432d7a2bdafd9c11' via api in 0.58 seconds916[May 30 2023 03:12:55 UTC (QA Tests)] INFO -- Runner api_get exception caught and handled: No value was computed for id of QA::Resource::ProjectRunner.917[May 30 2023 03:12:55 UTC (QA Tests)] INFO -- Executing: `docker pull registry.gitlab.com/gitlab-org/gitlab-runner:alpine`918[May 30 2023 03:12:55 UTC (QA Tests)] INFO -- Executing: `docker network inspect test`919[May 30 2023 03:12:55 UTC (QA Tests)] INFO -- Executing: `docker run -d --rm --network test --name qa-runner-2234b614 --privileged registry.gitlab.com/gitlab-org/gitlab-runner:alpine && docker exec --detach qa-runner-2234b614 sh -c "printf 'concurrent = 1\ncheck_interval = 0\n\n[session_server]\n session_timeout = 1800' > /etc/gitlab-runner/config.toml && gitlab-runner register --non-interactive --name qa-runner-2234b614 --url http://gitlab-gitaly-cluster.test --registration-token **** --tag-list qa-runner-2234b614 --executor shell && gitlab-runner run" `920[May 30 2023 03:12:55 UTC (QA Tests)] INFO -- Executing: `docker logs qa-runner-2234b614`921[May 30 2023 03:12:55 UTC (QA Tests)] INFO -- Executing: `docker network inspect test`922[May 30 2023 03:12:56 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::ProjectRunner with name 'qa-runner-2234b614' via api in 1.19 seconds923[May 30 2023 03:12:56 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Repository::Commit via api in 0.56 seconds924[May 30 2023 03:12:56 UTC (QA Tests)] INFO -- Waiting for pipeline to have status "skipped"...925[May 30 2023 03:13:00 UTC (QA Tests)] INFO -- filling :login_field with "root"926[May 30 2023 03:13:00 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field927[May 30 2023 03:13:00 UTC (QA Tests)] INFO -- filling :password_field with "*****"928[May 30 2023 03:13:00 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field929[May 30 2023 03:13:01 UTC (QA Tests)] INFO -- clicking :sign_in_button930[May 30 2023 03:13:02 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 1.161s931[May 30 2023 03:13:02 UTC (QA Tests)] INFO -- Enabling super sidebar!932[May 30 2023 03:13:02 UTC (QA Tests)] INFO -- Super sidebar is already enabled933[May 30 2023 03:13:04 UTC (QA Tests)] INFO -- Visiting QA::Resource::Project at http://gitlab-gitaly-cluster.test/gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/pipeline-with-manual-job-432d7a2bdafd9c11934[May 30 2023 03:13:05 UTC (QA Tests)] INFO -- clicking :menu_section_button935[May 30 2023 03:13:05 UTC (QA Tests)] INFO -- clicking :nav_item_link936[May 30 2023 03:13:06 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element nav_item_link' took 0.698s937[May 30 2023 03:13:08 UTC (QA Tests)] INFO -- clicking :job_action_button938[May 30 2023 03:13:33 UTC (QA Tests)] INFO -- clicking :job_dropdown_container939[May 30 2023 03:13:43 UTC (QA Tests)] INFO -- clicking :job_dropdown_container940[May 30 2023 03:13:43 UTC (QA Tests)] INFO -- clicking :job_dropdown_container941[May 30 2023 03:13:54 UTC (QA Tests)] INFO -- Removed a QA::Resource::ProjectRunner with name 'qa-runner-2234b614'942[May 30 2023 03:13:54 UTC (QA Tests)] INFO -- Executing: `docker rm -f qa-runner-2234b614`943 does not leave any job in skipped state944Verify945 Unlocking job artifacts across parent-child pipelines946 without strategy:depend947 when latest pipeline family is successful948[May 30 2023 03:13:54 UTC (QA Tests)] INFO -- Starting test: Verify Unlocking job artifacts across parent-child pipelines without strategy:depend when latest pipeline family is successful unlocks job artifacts from previous successful pipeline family949[May 30 2023 03:13:54 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-3' via api in 0.06 seconds950[May 30 2023 03:13:54 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04' via api in 0.12 seconds951[May 30 2023 03:13:55 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/unlock-job-artifacts-parent-child-project-a53480ab418214c7' via api in 0.6 seconds952[May 30 2023 03:13:55 UTC (QA Tests)] INFO -- Runner api_get exception caught and handled: No value was computed for id of QA::Resource::ProjectRunner.953[May 30 2023 03:13:55 UTC (QA Tests)] INFO -- Executing: `docker pull registry.gitlab.com/gitlab-org/gitlab-runner:alpine`954[May 30 2023 03:14:00 UTC (QA Tests)] INFO -- Executing: `docker network inspect test`955[May 30 2023 03:14:00 UTC (QA Tests)] INFO -- Executing: `docker run -d --rm --network test --name qa-runner-vsgvfmx3 --privileged registry.gitlab.com/gitlab-org/gitlab-runner:alpine && docker exec --detach qa-runner-vsgvfmx3 sh -c "printf 'concurrent = 1\ncheck_interval = 0\n\n[session_server]\n session_timeout = 1800' > /etc/gitlab-runner/config.toml && gitlab-runner register --non-interactive --name qa-runner-vsgvfmx3 --url http://gitlab-gitaly-cluster.test --registration-token **** --tag-list qa-runner-vsgvfmx3 --executor shell && gitlab-runner run" `956[May 30 2023 03:14:01 UTC (QA Tests)] INFO -- Executing: `docker logs qa-runner-vsgvfmx3`957[May 30 2023 03:14:01 UTC (QA Tests)] INFO -- Executing: `docker network inspect test`958[May 30 2023 03:14:01 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::ProjectRunner with name 'qa-runner-vsgvfmx3' via api in 6.16 seconds959[May 30 2023 03:14:01 UTC (QA Tests)] INFO -- filling :login_field with "root"960[May 30 2023 03:14:01 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field961[May 30 2023 03:14:02 UTC (QA Tests)] INFO -- filling :password_field with "*****"962[May 30 2023 03:14:02 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field963[May 30 2023 03:14:02 UTC (QA Tests)] INFO -- clicking :sign_in_button964[May 30 2023 03:14:03 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 1.236s965[May 30 2023 03:14:04 UTC (QA Tests)] INFO -- Enabling super sidebar!966[May 30 2023 03:14:04 UTC (QA Tests)] INFO -- Super sidebar is already enabled967[May 30 2023 03:14:05 UTC (QA Tests)] INFO -- Visiting QA::Resource::Project at http://gitlab-gitaly-cluster.test/gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/unlock-job-artifacts-parent-child-project-a53480ab418214c7968[May 30 2023 03:14:07 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Repository::Commit via api in 0.55 seconds969[May 30 2023 03:14:07 UTC (QA Tests)] INFO -- clicking :menu_section_button970[May 30 2023 03:14:07 UTC (QA Tests)] INFO -- clicking :nav_item_link971[May 30 2023 03:14:08 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element nav_item_link' took 0.777s972[May 30 2023 03:14:19 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Repository::Commit via api in 0.53 seconds973[May 30 2023 03:14:19 UTC (QA Tests)] INFO -- clicking :nav_item_link974[May 30 2023 03:14:20 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element nav_item_link' took 1.001s975[May 30 2023 03:14:21 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Job with id '28' via api in 0.1 seconds976[May 30 2023 03:14:21 UTC (QA Tests)] INFO -- Visiting QA::Resource::Job at http://gitlab-gitaly-cluster.test/gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/unlock-job-artifacts-parent-child-project-a53480ab418214c7/-/jobs/28977[May 30 2023 03:14:32 UTC (QA Tests)] WARN -- Potentially Slow Code 'has_element? artifacts_locked_message_content' took 10.064s978[May 30 2023 03:14:32 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Job with id '29' via api in 0.1 seconds979[May 30 2023 03:14:32 UTC (QA Tests)] INFO -- Visiting QA::Resource::Job at http://gitlab-gitaly-cluster.test/gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/unlock-job-artifacts-parent-child-project-a53480ab418214c7/-/jobs/29980[May 30 2023 03:14:33 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Job with id '25' via api in 0.09 seconds981[May 30 2023 03:14:33 UTC (QA Tests)] INFO -- Visiting QA::Resource::Job at http://gitlab-gitaly-cluster.test/gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/unlock-job-artifacts-parent-child-project-a53480ab418214c7/-/jobs/25982[May 30 2023 03:14:35 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Job with id '26' via api in 0.09 seconds983[May 30 2023 03:14:35 UTC (QA Tests)] INFO -- Visiting QA::Resource::Job at http://gitlab-gitaly-cluster.test/gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/unlock-job-artifacts-parent-child-project-a53480ab418214c7/-/jobs/26984 unlocks job artifacts from previous successful pipeline family985 when latest child pipeline failed986[May 30 2023 03:14:36 UTC (QA Tests)] INFO -- Starting test: Verify Unlocking job artifacts across parent-child pipelines without strategy:depend when latest child pipeline failed unlocks job artifacts from previous successful pipeline family because the latest parent is successful987[May 30 2023 03:14:36 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-3' via api in 0.06 seconds988[May 30 2023 03:14:36 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04' via api in 0.12 seconds989[May 30 2023 03:14:37 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/unlock-job-artifacts-parent-child-project-150db1754fda89f5' via api in 0.6 seconds990[May 30 2023 03:14:37 UTC (QA Tests)] INFO -- Runner api_get exception caught and handled: No value was computed for id of QA::Resource::ProjectRunner.991[May 30 2023 03:14:37 UTC (QA Tests)] INFO -- Executing: `docker pull registry.gitlab.com/gitlab-org/gitlab-runner:alpine`992[May 30 2023 03:14:37 UTC (QA Tests)] INFO -- Executing: `docker network inspect test`993[May 30 2023 03:14:37 UTC (QA Tests)] INFO -- Executing: `docker run -d --rm --network test --name qa-runner-wg0yftes --privileged registry.gitlab.com/gitlab-org/gitlab-runner:alpine && docker exec --detach qa-runner-wg0yftes sh -c "printf 'concurrent = 1\ncheck_interval = 0\n\n[session_server]\n session_timeout = 1800' > /etc/gitlab-runner/config.toml && gitlab-runner register --non-interactive --name qa-runner-wg0yftes --url http://gitlab-gitaly-cluster.test --registration-token **** --tag-list qa-runner-wg0yftes --executor shell && gitlab-runner run" `994[May 30 2023 03:14:37 UTC (QA Tests)] INFO -- Executing: `docker logs qa-runner-wg0yftes`995[May 30 2023 03:14:37 UTC (QA Tests)] INFO -- Executing: `docker network inspect test`996[May 30 2023 03:14:38 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::ProjectRunner with name 'qa-runner-wg0yftes' via api in 1.18 seconds997[May 30 2023 03:14:38 UTC (QA Tests)] INFO -- filling :login_field with "root"998[May 30 2023 03:14:38 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field999[May 30 2023 03:14:39 UTC (QA Tests)] INFO -- filling :password_field with "*****"1000[May 30 2023 03:14:39 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field1001[May 30 2023 03:14:39 UTC (QA Tests)] INFO -- clicking :sign_in_button1002[May 30 2023 03:14:40 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 1.171s1003[May 30 2023 03:14:40 UTC (QA Tests)] INFO -- Enabling super sidebar!1004[May 30 2023 03:14:41 UTC (QA Tests)] INFO -- Super sidebar is already enabled1005[May 30 2023 03:14:42 UTC (QA Tests)] INFO -- Visiting QA::Resource::Project at http://gitlab-gitaly-cluster.test/gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/unlock-job-artifacts-parent-child-project-150db1754fda89f51006[May 30 2023 03:14:43 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Repository::Commit via api in 0.5 seconds1007[May 30 2023 03:14:43 UTC (QA Tests)] INFO -- clicking :menu_section_button1008[May 30 2023 03:14:44 UTC (QA Tests)] INFO -- clicking :nav_item_link1009[May 30 2023 03:14:44 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element nav_item_link' took 0.866s1010[May 30 2023 03:14:56 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Repository::Commit via api in 0.49 seconds1011[May 30 2023 03:14:56 UTC (QA Tests)] INFO -- clicking :nav_item_link1012[May 30 2023 03:14:56 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element nav_item_link' took 0.804s1013[May 30 2023 03:14:57 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Job with id '34' via api in 0.1 seconds1014[May 30 2023 03:14:57 UTC (QA Tests)] INFO -- Visiting QA::Resource::Job at http://gitlab-gitaly-cluster.test/gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/unlock-job-artifacts-parent-child-project-150db1754fda89f5/-/jobs/341015[May 30 2023 03:15:08 UTC (QA Tests)] WARN -- Potentially Slow Code 'has_element? artifacts_locked_message_content' took 10.023s1016[May 30 2023 03:15:08 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Job with id '35' via api in 0.1 seconds1017[May 30 2023 03:15:08 UTC (QA Tests)] INFO -- Visiting QA::Resource::Job at http://gitlab-gitaly-cluster.test/gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/unlock-job-artifacts-parent-child-project-150db1754fda89f5/-/jobs/351018[May 30 2023 03:15:10 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Job with id '31' via api in 0.1 seconds1019[May 30 2023 03:15:10 UTC (QA Tests)] INFO -- Visiting QA::Resource::Job at http://gitlab-gitaly-cluster.test/gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/unlock-job-artifacts-parent-child-project-150db1754fda89f5/-/jobs/311020[May 30 2023 03:15:11 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Job with id '32' via api in 0.1 seconds1021[May 30 2023 03:15:11 UTC (QA Tests)] INFO -- Visiting QA::Resource::Job at http://gitlab-gitaly-cluster.test/gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/unlock-job-artifacts-parent-child-project-150db1754fda89f5/-/jobs/321022 unlocks job artifacts from previous successful pipeline family because the latest parent is successful1023 when latest parent pipeline failed1024[May 30 2023 03:15:12 UTC (QA Tests)] INFO -- Starting test: Verify Unlocking job artifacts across parent-child pipelines without strategy:depend when latest parent pipeline failed does not unlock job artifacts from previous successful pipeline family1025[May 30 2023 03:15:12 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-3' via api in 0.06 seconds1026[May 30 2023 03:15:13 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04' via api in 0.11 seconds1027[May 30 2023 03:15:13 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/unlock-job-artifacts-parent-child-project-babcf09d907d5a31' via api in 0.57 seconds1028[May 30 2023 03:15:13 UTC (QA Tests)] INFO -- Runner api_get exception caught and handled: No value was computed for id of QA::Resource::ProjectRunner.1029[May 30 2023 03:15:13 UTC (QA Tests)] INFO -- Executing: `docker pull registry.gitlab.com/gitlab-org/gitlab-runner:alpine`1030[May 30 2023 03:15:13 UTC (QA Tests)] INFO -- Executing: `docker network inspect test`1031[May 30 2023 03:15:13 UTC (QA Tests)] INFO -- Executing: `docker run -d --rm --network test --name qa-runner-zdoz7qfy --privileged registry.gitlab.com/gitlab-org/gitlab-runner:alpine && docker exec --detach qa-runner-zdoz7qfy sh -c "printf 'concurrent = 1\ncheck_interval = 0\n\n[session_server]\n session_timeout = 1800' > /etc/gitlab-runner/config.toml && gitlab-runner register --non-interactive --name qa-runner-zdoz7qfy --url http://gitlab-gitaly-cluster.test --registration-token **** --tag-list qa-runner-zdoz7qfy --executor shell && gitlab-runner run" `1032[May 30 2023 03:15:14 UTC (QA Tests)] INFO -- Executing: `docker logs qa-runner-zdoz7qfy`1033[May 30 2023 03:15:14 UTC (QA Tests)] INFO -- Executing: `docker network inspect test`1034[May 30 2023 03:15:14 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::ProjectRunner with name 'qa-runner-zdoz7qfy' via api in 1.14 seconds1035[May 30 2023 03:15:15 UTC (QA Tests)] INFO -- filling :login_field with "root"1036[May 30 2023 03:15:15 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field1037[May 30 2023 03:15:15 UTC (QA Tests)] INFO -- filling :password_field with "*****"1038[May 30 2023 03:15:15 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field1039[May 30 2023 03:15:15 UTC (QA Tests)] INFO -- clicking :sign_in_button1040[May 30 2023 03:15:17 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 1.188s1041[May 30 2023 03:15:17 UTC (QA Tests)] INFO -- Enabling super sidebar!1042[May 30 2023 03:15:17 UTC (QA Tests)] INFO -- Super sidebar is already enabled1043[May 30 2023 03:15:19 UTC (QA Tests)] INFO -- Visiting QA::Resource::Project at http://gitlab-gitaly-cluster.test/gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/unlock-job-artifacts-parent-child-project-babcf09d907d5a311044[May 30 2023 03:15:20 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Repository::Commit via api in 0.57 seconds1045[May 30 2023 03:15:20 UTC (QA Tests)] INFO -- clicking :menu_section_button1046[May 30 2023 03:15:20 UTC (QA Tests)] INFO -- clicking :nav_item_link1047[May 30 2023 03:15:21 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element nav_item_link' took 0.84s1048[May 30 2023 03:15:32 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Repository::Commit via api in 0.49 seconds1049[May 30 2023 03:15:32 UTC (QA Tests)] INFO -- clicking :nav_item_link1050[May 30 2023 03:15:33 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element nav_item_link' took 0.857s1051[May 30 2023 03:15:44 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Job with id '40' via api in 0.1 seconds1052[May 30 2023 03:15:44 UTC (QA Tests)] INFO -- Visiting QA::Resource::Job at http://gitlab-gitaly-cluster.test/gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/unlock-job-artifacts-parent-child-project-babcf09d907d5a31/-/jobs/401053[May 30 2023 03:15:46 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Job with id '41' via api in 0.1 seconds1054[May 30 2023 03:15:46 UTC (QA Tests)] INFO -- Visiting QA::Resource::Job at http://gitlab-gitaly-cluster.test/gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/unlock-job-artifacts-parent-child-project-babcf09d907d5a31/-/jobs/411055[May 30 2023 03:15:47 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Job with id '37' via api in 0.1 seconds1056[May 30 2023 03:15:47 UTC (QA Tests)] INFO -- Visiting QA::Resource::Job at http://gitlab-gitaly-cluster.test/gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/unlock-job-artifacts-parent-child-project-babcf09d907d5a31/-/jobs/371057[May 30 2023 03:15:48 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Job with id '38' via api in 0.09 seconds1058[May 30 2023 03:15:48 UTC (QA Tests)] INFO -- Visiting QA::Resource::Job at http://gitlab-gitaly-cluster.test/gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/unlock-job-artifacts-parent-child-project-babcf09d907d5a31/-/jobs/381059 does not unlock job artifacts from previous successful pipeline family1060 with strategy:depend1061 when latest parent pipeline failed1062[May 30 2023 03:15:49 UTC (QA Tests)] INFO -- Starting test: Verify Unlocking job artifacts across parent-child pipelines with strategy:depend when latest parent pipeline failed does not unlock job artifacts from previous successful pipeline family1063[May 30 2023 03:15:49 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-3' via api in 0.06 seconds1064[May 30 2023 03:15:50 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04' via api in 0.12 seconds1065[May 30 2023 03:15:50 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/unlock-job-artifacts-parent-child-project-3de493f1ca8f074a' via api in 0.58 seconds1066[May 30 2023 03:15:50 UTC (QA Tests)] INFO -- Runner api_get exception caught and handled: No value was computed for id of QA::Resource::ProjectRunner.1067[May 30 2023 03:15:50 UTC (QA Tests)] INFO -- Executing: `docker pull registry.gitlab.com/gitlab-org/gitlab-runner:alpine`1068[May 30 2023 03:15:55 UTC (QA Tests)] INFO -- Executing: `docker network inspect test`1069[May 30 2023 03:15:55 UTC (QA Tests)] INFO -- Executing: `docker run -d --rm --network test --name qa-runner-jvy6ccgw --privileged registry.gitlab.com/gitlab-org/gitlab-runner:alpine && docker exec --detach qa-runner-jvy6ccgw sh -c "printf 'concurrent = 1\ncheck_interval = 0\n\n[session_server]\n session_timeout = 1800' > /etc/gitlab-runner/config.toml && gitlab-runner register --non-interactive --name qa-runner-jvy6ccgw --url http://gitlab-gitaly-cluster.test --registration-token **** --tag-list qa-runner-jvy6ccgw --executor shell && gitlab-runner run" `1070[May 30 2023 03:15:56 UTC (QA Tests)] INFO -- Executing: `docker logs qa-runner-jvy6ccgw`1071[May 30 2023 03:15:56 UTC (QA Tests)] INFO -- Executing: `docker network inspect test`1072[May 30 2023 03:15:56 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::ProjectRunner with name 'qa-runner-jvy6ccgw' via api in 6.17 seconds1073[May 30 2023 03:15:57 UTC (QA Tests)] INFO -- filling :login_field with "root"1074[May 30 2023 03:15:57 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field1075[May 30 2023 03:15:57 UTC (QA Tests)] INFO -- filling :password_field with "*****"1076[May 30 2023 03:15:57 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field1077[May 30 2023 03:15:57 UTC (QA Tests)] INFO -- clicking :sign_in_button1078[May 30 2023 03:15:59 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 1.242s1079[May 30 2023 03:15:59 UTC (QA Tests)] INFO -- Enabling super sidebar!1080[May 30 2023 03:15:59 UTC (QA Tests)] INFO -- Super sidebar is already enabled1081[May 30 2023 03:16:01 UTC (QA Tests)] INFO -- Visiting QA::Resource::Project at http://gitlab-gitaly-cluster.test/gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/unlock-job-artifacts-parent-child-project-3de493f1ca8f074a1082[May 30 2023 03:16:02 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Repository::Commit via api in 0.54 seconds1083[May 30 2023 03:16:02 UTC (QA Tests)] INFO -- clicking :menu_section_button1084[May 30 2023 03:16:02 UTC (QA Tests)] INFO -- clicking :nav_item_link1085[May 30 2023 03:16:03 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element nav_item_link' took 0.84s1086[May 30 2023 03:16:14 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Repository::Commit via api in 0.52 seconds1087[May 30 2023 03:16:14 UTC (QA Tests)] INFO -- clicking :nav_item_link1088[May 30 2023 03:16:15 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element nav_item_link' took 0.989s1089[May 30 2023 03:16:26 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Job with id '46' via api in 0.1 seconds1090[May 30 2023 03:16:26 UTC (QA Tests)] INFO -- Visiting QA::Resource::Job at http://gitlab-gitaly-cluster.test/gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/unlock-job-artifacts-parent-child-project-3de493f1ca8f074a/-/jobs/461091[May 30 2023 03:16:28 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Job with id '47' via api in 0.09 seconds1092[May 30 2023 03:16:28 UTC (QA Tests)] INFO -- Visiting QA::Resource::Job at http://gitlab-gitaly-cluster.test/gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/unlock-job-artifacts-parent-child-project-3de493f1ca8f074a/-/jobs/471093[May 30 2023 03:16:30 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Job with id '43' via api in 0.11 seconds1094[May 30 2023 03:16:30 UTC (QA Tests)] INFO -- Visiting QA::Resource::Job at http://gitlab-gitaly-cluster.test/gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/unlock-job-artifacts-parent-child-project-3de493f1ca8f074a/-/jobs/431095[May 30 2023 03:16:32 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Job with id '44' via api in 0.1 seconds1096[May 30 2023 03:16:32 UTC (QA Tests)] INFO -- Visiting QA::Resource::Job at http://gitlab-gitaly-cluster.test/gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/unlock-job-artifacts-parent-child-project-3de493f1ca8f074a/-/jobs/441097 does not unlock job artifacts from previous successful pipeline family1098 when latest pipeline family is successful1099[May 30 2023 03:16:33 UTC (QA Tests)] INFO -- Starting test: Verify Unlocking job artifacts across parent-child pipelines with strategy:depend when latest pipeline family is successful unlocks job artifacts from previous successful pipeline family1100[May 30 2023 03:16:33 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-3' via api in 0.06 seconds1101[May 30 2023 03:16:33 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04' via api in 0.13 seconds1102[May 30 2023 03:16:33 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/unlock-job-artifacts-parent-child-project-cfd1dde43c9d50b9' via api in 0.59 seconds1103[May 30 2023 03:16:33 UTC (QA Tests)] INFO -- Runner api_get exception caught and handled: No value was computed for id of QA::Resource::ProjectRunner.1104[May 30 2023 03:16:33 UTC (QA Tests)] INFO -- Executing: `docker pull registry.gitlab.com/gitlab-org/gitlab-runner:alpine`1105[May 30 2023 03:16:34 UTC (QA Tests)] INFO -- Executing: `docker network inspect test`1106[May 30 2023 03:16:34 UTC (QA Tests)] INFO -- Executing: `docker run -d --rm --network test --name qa-runner-ypxm1ho6 --privileged registry.gitlab.com/gitlab-org/gitlab-runner:alpine && docker exec --detach qa-runner-ypxm1ho6 sh -c "printf 'concurrent = 1\ncheck_interval = 0\n\n[session_server]\n session_timeout = 1800' > /etc/gitlab-runner/config.toml && gitlab-runner register --non-interactive --name qa-runner-ypxm1ho6 --url http://gitlab-gitaly-cluster.test --registration-token **** --tag-list qa-runner-ypxm1ho6 --executor shell && gitlab-runner run" `1107[May 30 2023 03:16:34 UTC (QA Tests)] INFO -- Executing: `docker logs qa-runner-ypxm1ho6`1108[May 30 2023 03:16:34 UTC (QA Tests)] INFO -- Executing: `docker network inspect test`1109[May 30 2023 03:16:35 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::ProjectRunner with name 'qa-runner-ypxm1ho6' via api in 1.21 seconds1110[May 30 2023 03:16:35 UTC (QA Tests)] INFO -- filling :login_field with "root"1111[May 30 2023 03:16:35 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field1112[May 30 2023 03:16:35 UTC (QA Tests)] INFO -- filling :password_field with "*****"1113[May 30 2023 03:16:35 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field1114[May 30 2023 03:16:36 UTC (QA Tests)] INFO -- clicking :sign_in_button1115[May 30 2023 03:16:37 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 1.287s1116[May 30 2023 03:16:37 UTC (QA Tests)] INFO -- Enabling super sidebar!1117[May 30 2023 03:16:38 UTC (QA Tests)] INFO -- Super sidebar is already enabled1118[May 30 2023 03:16:39 UTC (QA Tests)] INFO -- Visiting QA::Resource::Project at http://gitlab-gitaly-cluster.test/gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/unlock-job-artifacts-parent-child-project-cfd1dde43c9d50b91119[May 30 2023 03:16:41 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Repository::Commit via api in 0.58 seconds1120[May 30 2023 03:16:41 UTC (QA Tests)] INFO -- clicking :menu_section_button1121[May 30 2023 03:16:41 UTC (QA Tests)] INFO -- clicking :nav_item_link1122[May 30 2023 03:16:42 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element nav_item_link' took 0.88s1123[May 30 2023 03:16:53 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Repository::Commit via api in 0.5 seconds1124[May 30 2023 03:16:53 UTC (QA Tests)] INFO -- clicking :nav_item_link1125[May 30 2023 03:16:54 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element nav_item_link' took 1.348s1126[May 30 2023 03:16:55 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Job with id '52' via api in 0.09 seconds1127[May 30 2023 03:16:55 UTC (QA Tests)] INFO -- Visiting QA::Resource::Job at http://gitlab-gitaly-cluster.test/gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/unlock-job-artifacts-parent-child-project-cfd1dde43c9d50b9/-/jobs/521128[May 30 2023 03:17:06 UTC (QA Tests)] WARN -- Potentially Slow Code 'has_element? artifacts_locked_message_content' took 9.922s1129[May 30 2023 03:17:06 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Job with id '53' via api in 0.1 seconds1130[May 30 2023 03:17:06 UTC (QA Tests)] INFO -- Visiting QA::Resource::Job at http://gitlab-gitaly-cluster.test/gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/unlock-job-artifacts-parent-child-project-cfd1dde43c9d50b9/-/jobs/531131[May 30 2023 03:17:07 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Job with id '49' via api in 0.1 seconds1132[May 30 2023 03:17:07 UTC (QA Tests)] INFO -- Visiting QA::Resource::Job at http://gitlab-gitaly-cluster.test/gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/unlock-job-artifacts-parent-child-project-cfd1dde43c9d50b9/-/jobs/491133[May 30 2023 03:17:09 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Job with id '50' via api in 0.09 seconds1134[May 30 2023 03:17:09 UTC (QA Tests)] INFO -- Visiting QA::Resource::Job at http://gitlab-gitaly-cluster.test/gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/unlock-job-artifacts-parent-child-project-cfd1dde43c9d50b9/-/jobs/501135 unlocks job artifacts from previous successful pipeline family1136 when latest child pipeline failed1137[May 30 2023 03:17:10 UTC (QA Tests)] INFO -- Starting test: Verify Unlocking job artifacts across parent-child pipelines with strategy:depend when latest child pipeline failed does not unlock job artifacts from previous successful pipeline family1138[May 30 2023 03:17:10 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-3' via api in 0.06 seconds1139[May 30 2023 03:17:10 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04' via api in 0.12 seconds1140[May 30 2023 03:17:11 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/unlock-job-artifacts-parent-child-project-cab1daa62befcfae' via api in 0.59 seconds1141[May 30 2023 03:17:11 UTC (QA Tests)] INFO -- Runner api_get exception caught and handled: No value was computed for id of QA::Resource::ProjectRunner.1142[May 30 2023 03:17:11 UTC (QA Tests)] INFO -- Executing: `docker pull registry.gitlab.com/gitlab-org/gitlab-runner:alpine`1143[May 30 2023 03:17:16 UTC (QA Tests)] INFO -- Executing: `docker network inspect test`1144[May 30 2023 03:17:16 UTC (QA Tests)] INFO -- Executing: `docker run -d --rm --network test --name qa-runner-nw0jh40i --privileged registry.gitlab.com/gitlab-org/gitlab-runner:alpine && docker exec --detach qa-runner-nw0jh40i sh -c "printf 'concurrent = 1\ncheck_interval = 0\n\n[session_server]\n session_timeout = 1800' > /etc/gitlab-runner/config.toml && gitlab-runner register --non-interactive --name qa-runner-nw0jh40i --url http://gitlab-gitaly-cluster.test --registration-token **** --tag-list qa-runner-nw0jh40i --executor shell && gitlab-runner run" `1145[May 30 2023 03:17:16 UTC (QA Tests)] INFO -- Executing: `docker logs qa-runner-nw0jh40i`1146[May 30 2023 03:17:17 UTC (QA Tests)] INFO -- Executing: `docker network inspect test`1147[May 30 2023 03:17:17 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::ProjectRunner with name 'qa-runner-nw0jh40i' via api in 6.54 seconds1148[May 30 2023 03:17:18 UTC (QA Tests)] INFO -- filling :login_field with "root"1149[May 30 2023 03:17:18 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field1150[May 30 2023 03:17:18 UTC (QA Tests)] INFO -- filling :password_field with "*****"1151[May 30 2023 03:17:18 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field1152[May 30 2023 03:17:18 UTC (QA Tests)] INFO -- clicking :sign_in_button1153[May 30 2023 03:17:21 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 2.316s1154[May 30 2023 03:17:21 UTC (QA Tests)] INFO -- Enabling super sidebar!1155[May 30 2023 03:17:21 UTC (QA Tests)] INFO -- Super sidebar is already enabled1156[May 30 2023 03:17:23 UTC (QA Tests)] INFO -- Visiting QA::Resource::Project at http://gitlab-gitaly-cluster.test/gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/unlock-job-artifacts-parent-child-project-cab1daa62befcfae1157[May 30 2023 03:17:25 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Repository::Commit via api in 1.48 seconds1158[May 30 2023 03:17:25 UTC (QA Tests)] INFO -- clicking :menu_section_button1159[May 30 2023 03:17:25 UTC (QA Tests)] INFO -- clicking :nav_item_link1160[May 30 2023 03:17:27 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element nav_item_link' took 1.513s1161[May 30 2023 03:17:27 UTC (QA Tests)] WARN -- Potentially Slow Code 'has_element? pipeline_row_container' took 0.669s1162[May 30 2023 03:17:39 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Repository::Commit via api in 0.5 seconds1163[May 30 2023 03:17:39 UTC (QA Tests)] INFO -- clicking :nav_item_link1164[May 30 2023 03:17:40 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element nav_item_link' took 1.432s1165[May 30 2023 03:17:51 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Job with id '58' via api in 0.09 seconds1166[May 30 2023 03:17:51 UTC (QA Tests)] INFO -- Visiting QA::Resource::Job at http://gitlab-gitaly-cluster.test/gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/unlock-job-artifacts-parent-child-project-cab1daa62befcfae/-/jobs/581167[May 30 2023 03:17:53 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Job with id '59' via api in 0.09 seconds1168[May 30 2023 03:17:53 UTC (QA Tests)] INFO -- Visiting QA::Resource::Job at http://gitlab-gitaly-cluster.test/gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/unlock-job-artifacts-parent-child-project-cab1daa62befcfae/-/jobs/591169[May 30 2023 03:17:55 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Job with id '55' via api in 0.1 seconds1170[May 30 2023 03:17:55 UTC (QA Tests)] INFO -- Visiting QA::Resource::Job at http://gitlab-gitaly-cluster.test/gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/unlock-job-artifacts-parent-child-project-cab1daa62befcfae/-/jobs/551171[May 30 2023 03:17:56 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Job with id '56' via api in 0.09 seconds1172[May 30 2023 03:17:56 UTC (QA Tests)] INFO -- Visiting QA::Resource::Job at http://gitlab-gitaly-cluster.test/gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/unlock-job-artifacts-parent-child-project-cab1daa62befcfae/-/jobs/561173 does not unlock job artifacts from previous successful pipeline family1174Analytics1175 Performance bar display1176 when logged in as an admin user1177[May 30 2023 03:17:58 UTC (QA Tests)] INFO -- Starting test: Analytics Performance bar display when logged in as an admin user shows results for the original request and AJAX requests1178[May 30 2023 03:17:58 UTC (QA Tests)] INFO -- filling :login_field with "root"1179[May 30 2023 03:17:58 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field1180[May 30 2023 03:17:59 UTC (QA Tests)] INFO -- filling :password_field with "*****"1181[May 30 2023 03:17:59 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field1182[May 30 2023 03:17:59 UTC (QA Tests)] INFO -- clicking :sign_in_button1183[May 30 2023 03:18:01 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 1.659s1184[May 30 2023 03:18:01 UTC (QA Tests)] INFO -- Enabling super sidebar!1185[May 30 2023 03:18:01 UTC (QA Tests)] INFO -- Super sidebar is already enabled1186[May 30 2023 03:18:03 UTC (QA Tests)] INFO -- clicking :context_switcher1187[May 30 2023 03:18:03 UTC (QA Tests)] INFO -- clicking :nav_item_link1188[May 30 2023 03:18:04 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element nav_item_link' took 0.907s1189[May 30 2023 03:18:05 UTC (QA Tests)] WARN -- Potentially Slow Code 'has_text? Enter admin mode' took 1.189s1190[May 30 2023 03:18:05 UTC (QA Tests)] INFO -- clicking :menu_section_button1191[May 30 2023 03:18:05 UTC (QA Tests)] INFO -- clicking :nav_item_link1192[May 30 2023 03:18:05 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element nav_item_link' took 0.559s1193[May 30 2023 03:18:07 UTC (QA Tests)] INFO -- checking via JS :enable_performance_bar_checkbox with args {}1194[May 30 2023 03:18:07 UTC (QA Tests)] INFO -- clicking :save_changes_button1195[May 30 2023 03:18:13 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element save_changes_button' took 6.355s1196[May 30 2023 03:18:13 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-3' via api in 0.11 seconds1197[May 30 2023 03:18:13 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04' via api in 0.17 seconds1198[May 30 2023 03:18:14 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/project-for-issues-c32e600a2ff26c71' via api in 0.82 seconds1199[May 30 2023 03:18:14 UTC (QA Tests)] INFO -- Visiting QA::Resource::Project at http://gitlab-gitaly-cluster.test/gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/project-for-issues-c32e600a2ff26c711200[May 30 2023 03:18:16 UTC (QA Tests)] INFO -- clicking :new_menu_toggle1201[May 30 2023 03:18:16 UTC (QA Tests)] INFO -- clicking :create_menu_item1202[May 30 2023 03:18:18 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element create_menu_item' took 2.153s1203[May 30 2023 03:18:18 UTC (QA Tests)] INFO -- filling :issuable_form_title_field with "Performance bar test"1204[May 30 2023 03:18:18 UTC (QA Tests)] INFO -- clicking the coordinates of :issuable_form_title_field1205[May 30 2023 03:18:18 UTC (QA Tests)] INFO -- filling :issuable_form_description_field with "Issue description 4fa24ef1d94bbee2"1206[May 30 2023 03:18:18 UTC (QA Tests)] INFO -- clicking the coordinates of :issuable_form_description_field1207[May 30 2023 03:18:19 UTC (QA Tests)] INFO -- clicking :issuable_create_button and ensuring QA::Page::Project::Issue::Show is present1208[May 30 2023 03:18:23 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element issuable_create_button' took 3.494s1209[May 30 2023 03:18:23 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Issue via browser_ui in 9.56 seconds1210[May 30 2023 03:18:23 UTC (QA Tests)] INFO -- clicking :request_dropdown1211 shows results for the original request and AJAX requests1212Create1213 Multiple file snippet1214 behaves like deleting file from snippet1215[May 30 2023 03:18:23 UTC (QA Tests)] INFO -- Starting test: Create Multiple file snippet behaves like deleting file from snippet deletes second file from an existing project_snippet to make it single-file1216[May 30 2023 03:18:24 UTC (QA Tests)] INFO -- filling :login_field with "root"1217[May 30 2023 03:18:24 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field1218[May 30 2023 03:18:24 UTC (QA Tests)] INFO -- filling :password_field with "*****"1219[May 30 2023 03:18:24 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field1220[May 30 2023 03:18:25 UTC (QA Tests)] INFO -- clicking :sign_in_button1221[May 30 2023 03:18:26 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 1.271s1222[May 30 2023 03:18:26 UTC (QA Tests)] INFO -- Enabling super sidebar!1223[May 30 2023 03:18:26 UTC (QA Tests)] INFO -- Super sidebar is already enabled1224[May 30 2023 03:18:28 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-3' via api in 0.07 seconds1225[May 30 2023 03:18:28 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04' via api in 0.13 seconds1226[May 30 2023 03:18:29 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/project-with-snippets-f49b851c1a93aee0' via api in 0.9 seconds1227[May 30 2023 03:18:29 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::ProjectSnippet with id '1' via api in 1.52 seconds1228[May 30 2023 03:18:29 UTC (QA Tests)] INFO -- Visiting QA::Resource::ProjectSnippet at http://gitlab-gitaly-cluster.test/gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/project-with-snippets-f49b851c1a93aee0/-/snippets/11229[May 30 2023 03:18:31 UTC (QA Tests)] INFO -- clicking :snippet_action_button and ensuring QA::Page::Dashboard::Snippet::Edit is present1230[May 30 2023 03:18:32 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element snippet_action_button' took 1.334s1231[May 30 2023 03:18:32 UTC (QA Tests)] INFO -- clicking :delete_file_button1232[May 30 2023 03:18:32 UTC (QA Tests)] INFO -- clicking the coordinates of :submit_button1233[May 30 2023 03:18:35 UTC (QA Tests)] WARN -- Potentially Slow Code 'wait_for_requests ' took 2.445s1234[May 30 2023 03:18:35 UTC (QA Tests)] WARN -- Potentially Slow Code 'has_no_element? file_name_field' took 2.455s1235[May 30 2023 03:18:45 UTC (QA Tests)] WARN -- Potentially Slow Code 'has_text? Second file name' took 10.028s1236 deletes second file from an existing project_snippet to make it single-file1237 behaves like deleting file from snippet1238[May 30 2023 03:18:45 UTC (QA Tests)] INFO -- Starting test: Create Multiple file snippet behaves like deleting file from snippet deletes second file from an existing personal_snippet to make it single-file1239[May 30 2023 03:18:46 UTC (QA Tests)] INFO -- filling :login_field with "root"1240[May 30 2023 03:18:46 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field1241[May 30 2023 03:18:46 UTC (QA Tests)] INFO -- filling :password_field with "*****"1242[May 30 2023 03:18:46 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field1243[May 30 2023 03:18:46 UTC (QA Tests)] INFO -- clicking :sign_in_button1244[May 30 2023 03:18:48 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 1.479s1245[May 30 2023 03:18:48 UTC (QA Tests)] INFO -- Enabling super sidebar!1246[May 30 2023 03:18:48 UTC (QA Tests)] INFO -- Super sidebar is already enabled1247[May 30 2023 03:18:50 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Snippet with id '2' via api in 0.53 seconds1248[May 30 2023 03:18:50 UTC (QA Tests)] INFO -- Visiting QA::Resource::Snippet at http://gitlab-gitaly-cluster.test/-/snippets/21249[May 30 2023 03:18:51 UTC (QA Tests)] INFO -- clicking :snippet_action_button and ensuring QA::Page::Dashboard::Snippet::Edit is present1250[May 30 2023 03:18:52 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element snippet_action_button' took 0.834s1251[May 30 2023 03:18:52 UTC (QA Tests)] INFO -- clicking :delete_file_button1252[May 30 2023 03:18:52 UTC (QA Tests)] INFO -- clicking the coordinates of :submit_button1253[May 30 2023 03:18:54 UTC (QA Tests)] WARN -- Potentially Slow Code 'wait_for_requests ' took 1.118s1254[May 30 2023 03:18:54 UTC (QA Tests)] WARN -- Potentially Slow Code 'has_no_element? file_name_field' took 1.128s1255[May 30 2023 03:19:04 UTC (QA Tests)] WARN -- Potentially Slow Code 'has_text? Second file name' took 10.023s1256 deletes second file from an existing personal_snippet to make it single-file1257Create1258 Add a directory in Web IDE1259 when a directory with the same name already exists1260[May 30 2023 03:19:04 UTC (QA Tests)] INFO -- Starting test: Create Add a directory in Web IDE when a directory with the same name already exists throws an error1261[May 30 2023 03:19:05 UTC (QA Tests)] INFO -- filling :login_field with "root"1262[May 30 2023 03:19:05 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field1263[May 30 2023 03:19:05 UTC (QA Tests)] INFO -- filling :password_field with "*****"1264[May 30 2023 03:19:05 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field1265[May 30 2023 03:19:05 UTC (QA Tests)] INFO -- clicking :sign_in_button1266[May 30 2023 03:19:07 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 1.549s1267[May 30 2023 03:19:07 UTC (QA Tests)] INFO -- Enabling super sidebar!1268[May 30 2023 03:19:07 UTC (QA Tests)] INFO -- Super sidebar is already enabled1269[May 30 2023 03:19:09 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-3' via api in 0.1 seconds1270[May 30 2023 03:19:09 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04' via api in 0.16 seconds1271[May 30 2023 03:19:10 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/add-directory-project-32d469c1b52cb548' via api in 1.03 seconds1272[May 30 2023 03:19:10 UTC (QA Tests)] INFO -- Visiting QA::Resource::Project at http://gitlab-gitaly-cluster.test/gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/add-directory-project-32d469c1b52cb5481273[May 30 2023 03:19:12 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Repository::Commit via api in 0.61 seconds1274[May 30 2023 03:19:12 UTC (QA Tests)] INFO -- Visiting QA::Resource::Project at http://gitlab-gitaly-cluster.test/gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/add-directory-project-32d469c1b52cb5481275[May 30 2023 03:19:14 UTC (QA Tests)] INFO -- clicking :web_ide_button1276 throws an error1277 when user adds a new empty directory1278[May 30 2023 03:19:18 UTC (QA Tests)] INFO -- Starting test: Create Add a directory in Web IDE when user adds a new empty directory shows successfully but not able to be committed1279[May 30 2023 03:19:18 UTC (QA Tests)] INFO -- filling :login_field with "root"1280[May 30 2023 03:19:18 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field1281[May 30 2023 03:19:19 UTC (QA Tests)] INFO -- filling :password_field with "*****"1282[May 30 2023 03:19:19 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field1283[May 30 2023 03:19:19 UTC (QA Tests)] INFO -- clicking :sign_in_button1284[May 30 2023 03:19:20 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 1.443s1285[May 30 2023 03:19:21 UTC (QA Tests)] INFO -- Enabling super sidebar!1286[May 30 2023 03:19:21 UTC (QA Tests)] INFO -- Super sidebar is already enabled1287[May 30 2023 03:19:23 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-3' via api in 0.09 seconds1288[May 30 2023 03:19:23 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04' via api in 0.16 seconds1289[May 30 2023 03:19:24 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/add-directory-project-b68035e085c2e643' via api in 1.21 seconds1290[May 30 2023 03:19:24 UTC (QA Tests)] INFO -- Visiting QA::Resource::Project at http://gitlab-gitaly-cluster.test/gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/add-directory-project-b68035e085c2e6431291[May 30 2023 03:19:25 UTC (QA Tests)] INFO -- clicking :web_ide_button1292 shows successfully but not able to be committed1293Create1294 Version control for personal snippets1295[May 30 2023 03:19:49 UTC (QA Tests)] INFO -- Starting test: Create Version control for personal snippets clones, pushes, and pulls a snippet over HTTP, edits via UI1296[May 30 2023 03:19:49 UTC (QA Tests)] INFO -- filling :login_field with "root"1297[May 30 2023 03:19:49 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field1298[May 30 2023 03:19:50 UTC (QA Tests)] INFO -- filling :password_field with "*****"1299[May 30 2023 03:19:50 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field1300[May 30 2023 03:19:50 UTC (QA Tests)] INFO -- clicking :sign_in_button1301[May 30 2023 03:19:51 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 1.366s1302[May 30 2023 03:19:52 UTC (QA Tests)] INFO -- Enabling super sidebar!1303[May 30 2023 03:19:52 UTC (QA Tests)] INFO -- Super sidebar is already enabled1304[May 30 2023 03:19:54 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Snippet with id '3' via api in 0.41 seconds1305[May 30 2023 03:19:54 UTC (QA Tests)] INFO -- Visiting QA::Resource::Snippet at http://gitlab-gitaly-cluster.test/-/snippets/31306[May 30 2023 03:19:55 UTC (QA Tests)] INFO -- clicking :clone_button1307[May 30 2023 03:19:56 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Repository::Push via browser_ui in 0.97 seconds1308[May 30 2023 03:19:57 UTC (QA Tests)] INFO -- clicking :snippet_action_button and ensuring QA::Page::Dashboard::Snippet::Edit is present1309[May 30 2023 03:19:58 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element snippet_action_button' took 0.914s1310[May 30 2023 03:20:08 UTC (QA Tests)] INFO -- clicking the coordinates of :submit_button1311[May 30 2023 03:20:09 UTC (QA Tests)] WARN -- Potentially Slow Code 'wait_for_requests ' took 1.361s1312[May 30 2023 03:20:09 UTC (QA Tests)] WARN -- Potentially Slow Code 'has_no_element? file_name_field' took 1.373s1313[May 30 2023 03:20:10 UTC (QA Tests)] INFO -- Removed a QA::Resource::Snippet with id '3'1314[May 30 2023 03:20:10 UTC (QA Tests)] INFO -- Executing: `ssh-keygen -t rsa -b 4096 -f /tmp/d20230530-38-c5dkme/id_rsa -N `1315[May 30 2023 03:20:11 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::SSHKey with id '2' via api in 0.71 seconds1316[May 30 2023 03:20:11 UTC (QA Tests)] INFO -- Removed a QA::Resource::SSHKey with id '2'1317 clones, pushes, and pulls a snippet over HTTP, edits via UI1318[May 30 2023 03:20:11 UTC (QA Tests)] INFO -- Starting test: Create Version control for personal snippets clones, pushes, and pulls a snippet over SSH, deletes via UI1319[May 30 2023 03:20:11 UTC (QA Tests)] INFO -- filling :login_field with "root"1320[May 30 2023 03:20:11 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field1321[May 30 2023 03:20:12 UTC (QA Tests)] INFO -- filling :password_field with "*****"1322[May 30 2023 03:20:12 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field1323[May 30 2023 03:20:12 UTC (QA Tests)] INFO -- clicking :sign_in_button1324[May 30 2023 03:20:13 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 1.331s1325[May 30 2023 03:20:14 UTC (QA Tests)] INFO -- Enabling super sidebar!1326[May 30 2023 03:20:14 UTC (QA Tests)] INFO -- Super sidebar is already enabled1327[May 30 2023 03:20:15 UTC (QA Tests)] INFO -- Executing: `ssh-keygen -t rsa -b 4096 -f /tmp/d20230530-38-ufh4q8/id_rsa -N `1328[May 30 2023 03:20:16 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::SSHKey with id '3' via api in 0.39 seconds1329[May 30 2023 03:20:16 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Snippet with id '4' via api in 0.43 seconds1330[May 30 2023 03:20:16 UTC (QA Tests)] INFO -- Visiting QA::Resource::Snippet at http://gitlab-gitaly-cluster.test/-/snippets/41331[May 30 2023 03:20:17 UTC (QA Tests)] INFO -- clicking :clone_button1332[May 30 2023 03:20:18 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Repository::Push via browser_ui in 0.92 seconds1333[May 30 2023 03:20:19 UTC (QA Tests)] WARN -- Potentially Slow Code 'wait_for_requests ' took 0.626s1334[May 30 2023 03:20:19 UTC (QA Tests)] INFO -- clicking :snippet_action_button1335[May 30 2023 03:20:19 UTC (QA Tests)] INFO -- clicking :delete_snippet_button1336[May 30 2023 03:20:19 UTC (QA Tests)] WARN -- Potentially Slow Code 'wait_for_requests ' took 0.605s1337[May 30 2023 03:20:19 UTC (QA Tests)] WARN -- Potentially Slow Code 'has_no_element? delete_snippet_button' took 0.613s1338[May 30 2023 03:20:20 UTC (QA Tests)] INFO -- Removed a QA::Resource::SSHKey with id '3'1339 clones, pushes, and pulls a snippet over SSH, deletes via UI1340Create1341 Merge requests1342 when merging once1343 behaves like merge when pipeline succeeds1344 merges after pipeline succeeds (PENDING: In quarantine : https://gitlab.com/gitlab-org/gitlab/-/issues/403017)1345Monitor1346 Alert settings1347 when using Prometheus integration1348 behaves like sends test alert1349[May 30 2023 03:20:20 UTC (QA Tests)] INFO -- Starting test: Monitor Alert settings when using Prometheus integration behaves like sends test alert creates new alert1350[May 30 2023 03:20:20 UTC (QA Tests)] INFO -- filling :login_field with "root"1351[May 30 2023 03:20:20 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field1352[May 30 2023 03:20:21 UTC (QA Tests)] INFO -- filling :password_field with "*****"1353[May 30 2023 03:20:21 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field1354[May 30 2023 03:20:21 UTC (QA Tests)] INFO -- clicking :sign_in_button1355[May 30 2023 03:20:23 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 1.321s1356[May 30 2023 03:20:23 UTC (QA Tests)] INFO -- Enabling super sidebar!1357[May 30 2023 03:20:23 UTC (QA Tests)] INFO -- Super sidebar is already enabled1358[May 30 2023 03:20:25 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-3' via api in 0.06 seconds1359[May 30 2023 03:20:25 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04' via api in 0.12 seconds1360[May 30 2023 03:20:25 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/project-for-alerts-30995477ac25fdde' via api in 0.71 seconds1361[May 30 2023 03:20:25 UTC (QA Tests)] INFO -- Visiting QA::Resource::Project at http://gitlab-gitaly-cluster.test/gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/project-for-alerts-30995477ac25fdde1362[May 30 2023 03:20:26 UTC (QA Tests)] INFO -- clicking :menu_section_button1363[May 30 2023 03:20:26 UTC (QA Tests)] INFO -- clicking :nav_item_link1364[May 30 2023 03:20:27 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element nav_item_link' took 0.995s1365[May 30 2023 03:20:29 UTC (QA Tests)] INFO -- clicking :add_integration_button1366[May 30 2023 03:20:29 UTC (QA Tests)] INFO -- clicking :integration_type_dropdown1367[May 30 2023 03:20:29 UTC (QA Tests)] INFO -- clicking :prometheus_url_field1368[May 30 2023 03:20:29 UTC (QA Tests)] INFO -- filling :prometheus_url_field with "http://gitlab-gitaly-cluster.test"1369[May 30 2023 03:20:29 UTC (QA Tests)] INFO -- clicking the coordinates of :prometheus_url_field1370[May 30 2023 03:20:30 UTC (QA Tests)] INFO -- clicking :save_and_create_alert_button1371[May 30 2023 03:20:30 UTC (QA Tests)] INFO -- filling :test_payload_field with "{"version":"4","groupKey":null,"status":"firing","receiver":"","groupLabels":{},"commonLabels":{},"commonAnnotations":{},"externalURL":"","alerts":[{"startsAt":"2023-05-30 03:20:30 +0000","generatorURL":"http://roberts.test/kyle","endsAt":null,"status":"firing","labels":{"gitlab_environment_name":"amet"},"annotations":{"title":"veritatis","gitlab_y_label":"status"}}]}"1372[May 30 2023 03:20:30 UTC (QA Tests)] INFO -- clicking the coordinates of :test_payload_field1373[May 30 2023 03:20:30 UTC (QA Tests)] INFO -- clicking :send_test_alert_button1374[May 30 2023 03:20:31 UTC (QA Tests)] INFO -- clicking :menu_section_button1375[May 30 2023 03:20:31 UTC (QA Tests)] INFO -- clicking :nav_item_link1376[May 30 2023 03:20:32 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element nav_item_link' took 0.797s1377 creates new alert1378 when using HTTP endpoint integration1379 behaves like sends test alert1380[May 30 2023 03:20:32 UTC (QA Tests)] INFO -- Starting test: Monitor Alert settings when using HTTP endpoint integration behaves like sends test alert creates new alert1381[May 30 2023 03:20:32 UTC (QA Tests)] INFO -- filling :login_field with "root"1382[May 30 2023 03:20:32 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field1383[May 30 2023 03:20:33 UTC (QA Tests)] INFO -- filling :password_field with "*****"1384[May 30 2023 03:20:33 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field1385[May 30 2023 03:20:33 UTC (QA Tests)] INFO -- clicking :sign_in_button1386[May 30 2023 03:20:34 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 1.267s1387[May 30 2023 03:20:35 UTC (QA Tests)] INFO -- Enabling super sidebar!1388[May 30 2023 03:20:35 UTC (QA Tests)] INFO -- Super sidebar is already enabled1389[May 30 2023 03:20:37 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-3' via api in 0.1 seconds1390[May 30 2023 03:20:37 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04' via api in 0.16 seconds1391[May 30 2023 03:20:37 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/project-for-alerts-dcf6bd75d267e00a' via api in 0.87 seconds1392[May 30 2023 03:20:37 UTC (QA Tests)] INFO -- Visiting QA::Resource::Project at http://gitlab-gitaly-cluster.test/gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/project-for-alerts-dcf6bd75d267e00a1393[May 30 2023 03:20:38 UTC (QA Tests)] INFO -- clicking :menu_section_button1394[May 30 2023 03:20:38 UTC (QA Tests)] INFO -- clicking :nav_item_link1395[May 30 2023 03:20:39 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element nav_item_link' took 0.935s1396[May 30 2023 03:20:41 UTC (QA Tests)] INFO -- clicking :add_integration_button1397[May 30 2023 03:20:41 UTC (QA Tests)] INFO -- clicking :integration_type_dropdown1398[May 30 2023 03:20:41 UTC (QA Tests)] INFO -- clicking :integration_name_field1399[May 30 2023 03:20:41 UTC (QA Tests)] INFO -- filling :integration_name_field with "cupiditate"1400[May 30 2023 03:20:41 UTC (QA Tests)] INFO -- clicking the coordinates of :integration_name_field1401[May 30 2023 03:20:42 UTC (QA Tests)] INFO -- clicking :save_and_create_alert_button1402[May 30 2023 03:20:42 UTC (QA Tests)] INFO -- filling :test_payload_field with "{"title":"reiciendis","description":"reiciendis"}"1403[May 30 2023 03:20:42 UTC (QA Tests)] INFO -- clicking the coordinates of :test_payload_field1404[May 30 2023 03:20:42 UTC (QA Tests)] INFO -- clicking :send_test_alert_button1405[May 30 2023 03:20:43 UTC (QA Tests)] INFO -- clicking :menu_section_button1406[May 30 2023 03:20:43 UTC (QA Tests)] INFO -- clicking :nav_item_link1407[May 30 2023 03:20:44 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element nav_item_link' took 0.776s1408 creates new alert1409Create1410 File with unusual name1411 when file name starts with a dash and contains hash, semicolon, colon, and question mark1412[May 30 2023 03:20:44 UTC (QA Tests)] INFO -- Starting test: Create File with unusual name when file name starts with a dash and contains hash, semicolon, colon, and question mark renders repository file tree correctly1413[May 30 2023 03:20:44 UTC (QA Tests)] INFO -- filling :login_field with "root"1414[May 30 2023 03:20:44 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field1415[May 30 2023 03:20:45 UTC (QA Tests)] INFO -- filling :password_field with "*****"1416[May 30 2023 03:20:45 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field1417[May 30 2023 03:20:45 UTC (QA Tests)] INFO -- clicking :sign_in_button1418[May 30 2023 03:20:46 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 1.199s1419[May 30 2023 03:20:47 UTC (QA Tests)] INFO -- Enabling super sidebar!1420[May 30 2023 03:20:47 UTC (QA Tests)] INFO -- Super sidebar is already enabled1421[May 30 2023 03:20:48 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-3' via api in 0.08 seconds1422[May 30 2023 03:20:48 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04' via api in 0.15 seconds1423[May 30 2023 03:20:49 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/project-with-new-file-7f391438cafbc64d' via api in 0.97 seconds1424[May 30 2023 03:20:49 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-3' via api in 0.09 seconds1425[May 30 2023 03:20:49 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04' via api in 0.17 seconds1426[May 30 2023 03:20:50 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/unusually-named-file-project-a62186c5a9f4e9ae' via api in 0.95 seconds1427[May 30 2023 03:20:51 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::File with name 'test-folder/-un:usually;named#file?.md' via api in 0.56 seconds1428[May 30 2023 03:20:51 UTC (QA Tests)] INFO -- Visiting QA::Resource::Project at http://gitlab-gitaly-cluster.test/gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/unusually-named-file-project-a62186c5a9f4e9ae1429[May 30 2023 03:20:52 UTC (QA Tests)] INFO -- clicking :file_name_link1430[May 30 2023 03:20:53 UTC (QA Tests)] INFO -- clicking :file_name_link1431 renders repository file tree correctly1432Verify1433 Include multiple files from a project1434[May 30 2023 03:20:54 UTC (QA Tests)] INFO -- Starting test: Verify Include multiple files from a project runs the pipeline with composed config1435[May 30 2023 03:20:54 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-3' via api in 0.06 seconds1436[May 30 2023 03:20:54 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04' via api in 0.12 seconds1437[May 30 2023 03:20:54 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/project-with-pipeline-1-6ebd983b7126d6de' via api in 0.56 seconds1438[May 30 2023 03:20:54 UTC (QA Tests)] INFO -- Runner api_get exception caught and handled: No value was computed for id of QA::Resource::ProjectRunner.1439[May 30 2023 03:20:54 UTC (QA Tests)] INFO -- Executing: `docker pull registry.gitlab.com/gitlab-org/gitlab-runner:alpine`1440[May 30 2023 03:20:55 UTC (QA Tests)] INFO -- Executing: `docker network inspect test`1441[May 30 2023 03:20:55 UTC (QA Tests)] INFO -- Executing: `docker run -d --rm --network test --name qa-runner-s4su10rx --privileged registry.gitlab.com/gitlab-org/gitlab-runner:alpine && docker exec --detach qa-runner-s4su10rx sh -c "printf 'concurrent = 1\ncheck_interval = 0\n\n[session_server]\n session_timeout = 1800' > /etc/gitlab-runner/config.toml && gitlab-runner register --non-interactive --name qa-runner-s4su10rx --url http://gitlab-gitaly-cluster.test --registration-token **** --tag-list qa-runner-s4su10rx --executor shell && gitlab-runner run" `1442[May 30 2023 03:20:55 UTC (QA Tests)] INFO -- Executing: `docker logs qa-runner-s4su10rx`1443[May 30 2023 03:20:55 UTC (QA Tests)] INFO -- Executing: `docker network inspect test`1444[May 30 2023 03:20:56 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::ProjectRunner with name 'qa-runner-s4su10rx' via api in 1.36 seconds1445[May 30 2023 03:20:56 UTC (QA Tests)] INFO -- filling :login_field with "root"1446[May 30 2023 03:20:56 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field1447[May 30 2023 03:20:57 UTC (QA Tests)] INFO -- filling :password_field with "*****"1448[May 30 2023 03:20:57 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field1449[May 30 2023 03:20:57 UTC (QA Tests)] INFO -- clicking :sign_in_button1450[May 30 2023 03:20:58 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 1.113s1451[May 30 2023 03:20:58 UTC (QA Tests)] INFO -- Enabling super sidebar!1452[May 30 2023 03:20:58 UTC (QA Tests)] INFO -- Super sidebar is already enabled1453[May 30 2023 03:21:00 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-3' via api in 0.08 seconds1454[May 30 2023 03:21:00 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04' via api in 0.14 seconds1455[May 30 2023 03:21:01 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/project-with-pipeline-2-a10fd0b512a04de8' via api in 0.57 seconds1456[May 30 2023 03:21:01 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Repository::Commit via api in 0.54 seconds1457[May 30 2023 03:21:02 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Repository::Commit via api in 0.6 seconds1458[May 30 2023 03:21:02 UTC (QA Tests)] INFO -- Visiting QA::Resource::Project at http://gitlab-gitaly-cluster.test/gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/project-with-pipeline-1-6ebd983b7126d6de1459[May 30 2023 03:21:03 UTC (QA Tests)] INFO -- clicking :menu_section_button1460[May 30 2023 03:21:03 UTC (QA Tests)] INFO -- clicking :nav_item_link1461[May 30 2023 03:21:04 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element nav_item_link' took 0.977s1462[May 30 2023 03:21:17 UTC (QA Tests)] INFO -- clicking :job_link and ensuring QA::Page::Project::Job::Show is present1463[May 30 2023 03:21:18 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element job_link' took 1.027s1464[May 30 2023 03:21:18 UTC (QA Tests)] INFO -- Removed a QA::Resource::ProjectRunner with name 'qa-runner-s4su10rx'1465[May 30 2023 03:21:18 UTC (QA Tests)] INFO -- Executing: `docker rm -f qa-runner-s4su10rx`1466 runs the pipeline with composed config1467Create1468 Git push over HTTP1469[May 30 2023 03:21:18 UTC (QA Tests)] INFO -- Starting test: Create Git push over HTTP user using a personal access token pushes code to the repository1470[May 30 2023 03:21:19 UTC (QA Tests)] INFO -- filling :login_field with "root"1471[May 30 2023 03:21:19 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field1472[May 30 2023 03:21:19 UTC (QA Tests)] INFO -- filling :password_field with "*****"1473[May 30 2023 03:21:19 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field1474[May 30 2023 03:21:20 UTC (QA Tests)] INFO -- clicking :sign_in_button1475[May 30 2023 03:21:21 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 1.211s1476[May 30 2023 03:21:21 UTC (QA Tests)] INFO -- Enabling super sidebar!1477[May 30 2023 03:21:21 UTC (QA Tests)] INFO -- Super sidebar is already enabled1478[May 30 2023 03:21:23 UTC (QA Tests)] INFO -- Retrieved cached token for username: root, last six chars of token:sixwPA1479[May 30 2023 03:21:23 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::PersonalAccessToken with name 'api-pat-root-hk25au50' via cache in 0.0 seconds1480[May 30 2023 03:21:23 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-3' via api in 0.05 seconds1481[May 30 2023 03:21:23 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04' via api in 0.12 seconds1482[May 30 2023 03:21:24 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/project-with-code-7769d40445129b7c' via api in 0.63 seconds1483[May 30 2023 03:21:25 UTC (QA Tests)] INFO -- QA::Resource::Project - wait_for_push with commit message "Add README.md"1484[May 30 2023 03:21:25 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Repository::ProjectPush via browser_ui in 2.15 seconds1485[May 30 2023 03:21:25 UTC (QA Tests)] INFO -- Visiting QA::Resource::Project at http://gitlab-gitaly-cluster.test/gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/project-with-code-7769d40445129b7c1486 user using a personal access token pushes code to the repository1487Verify1488 Pipeline with raw variables in YAML1489[May 30 2023 03:21:27 UTC (QA Tests)] INFO -- Starting test: Verify Pipeline with raw variables in YAML expands variables according to expand: true/false1490[May 30 2023 03:21:27 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-3' via api in 0.06 seconds1491[May 30 2023 03:21:27 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04' via api in 0.13 seconds1492[May 30 2023 03:21:27 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/project-with-raw-variable-pipeline-c60983015d8d0d4d' via api in 0.63 seconds1493[May 30 2023 03:21:27 UTC (QA Tests)] INFO -- Runner api_get exception caught and handled: No value was computed for id of QA::Resource::ProjectRunner.1494[May 30 2023 03:21:27 UTC (QA Tests)] INFO -- Executing: `docker pull registry.gitlab.com/gitlab-org/gitlab-runner:alpine`1495[May 30 2023 03:21:28 UTC (QA Tests)] INFO -- Executing: `docker network inspect test`1496[May 30 2023 03:21:28 UTC (QA Tests)] INFO -- Executing: `docker run -d --rm --network test --name qa-runner-1685416887 --privileged registry.gitlab.com/gitlab-org/gitlab-runner:alpine && docker exec --detach qa-runner-1685416887 sh -c "printf 'concurrent = 1\ncheck_interval = 0\n\n[session_server]\n session_timeout = 1800' > /etc/gitlab-runner/config.toml && gitlab-runner register --non-interactive --name qa-runner-1685416887 --url http://gitlab-gitaly-cluster.test --registration-token **** --tag-list qa-runner-1685416887 --executor shell && gitlab-runner run" `1497[May 30 2023 03:21:28 UTC (QA Tests)] INFO -- Executing: `docker logs qa-runner-1685416887`1498[May 30 2023 03:21:28 UTC (QA Tests)] INFO -- Executing: `docker network inspect test`1499[May 30 2023 03:21:29 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::ProjectRunner with name 'qa-runner-1685416887' via api in 1.19 seconds1500[May 30 2023 03:21:29 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Repository::Commit via api in 0.56 seconds1501[May 30 2023 03:21:30 UTC (QA Tests)] INFO -- filling :login_field with "root"1502[May 30 2023 03:21:30 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field1503[May 30 2023 03:21:30 UTC (QA Tests)] INFO -- filling :password_field with "*****"1504[May 30 2023 03:21:30 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field1505[May 30 2023 03:21:31 UTC (QA Tests)] INFO -- clicking :sign_in_button1506[May 30 2023 03:21:32 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 1.216s1507[May 30 2023 03:21:32 UTC (QA Tests)] INFO -- Enabling super sidebar!1508[May 30 2023 03:21:32 UTC (QA Tests)] INFO -- Super sidebar is already enabled1509[May 30 2023 03:21:34 UTC (QA Tests)] INFO -- Visiting QA::Resource::Project at http://gitlab-gitaly-cluster.test/gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/project-with-raw-variable-pipeline-c60983015d8d0d4d1510[May 30 2023 03:21:35 UTC (QA Tests)] INFO -- clicking :menu_section_button1511[May 30 2023 03:21:35 UTC (QA Tests)] INFO -- clicking :nav_item_link1512[May 30 2023 03:21:36 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element nav_item_link' took 0.736s1513[May 30 2023 03:21:37 UTC (QA Tests)] INFO -- clicking :job_link and ensuring QA::Page::Project::Job::Show is present1514[May 30 2023 03:21:39 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element job_link' took 1.205s1515[May 30 2023 03:21:39 UTC (QA Tests)] INFO -- Removed a QA::Resource::ProjectRunner with name 'qa-runner-1685416887'1516[May 30 2023 03:21:39 UTC (QA Tests)] INFO -- Executing: `docker rm -f qa-runner-1685416887`1517 expands variables according to expand: true/false1518Manage1519 rate limits1520[May 30 2023 03:21:40 UTC (QA Tests)] INFO -- Starting test: Manage rate limits throttles authenticated api requests by user1521[May 30 2023 03:21:40 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::User with username 'qa-user-3cfb72af0b0bb323' via api in 0.29 seconds1522[May 30 2023 03:21:40 UTC (QA Tests)] INFO -- No cached token found for username: qa-user-3cfb72af0b0bb3231523[May 30 2023 03:21:40 UTC (QA Tests)] INFO -- Caching token for username: qa-user-3cfb72af0b0bb323, last six chars of token:xWVCg41524[May 30 2023 03:21:40 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::PersonalAccessToken with name 'api-pat-qa-user-3cfb72af0b0bb323-q7vd8h10' via api in 0.09 seconds1525[May 30 2023 03:21:40 UTC (QA Tests)] INFO -- Setting application settings: {:throttle_authenticated_api_requests_per_period=>5, :throttle_authenticated_api_period_in_seconds=>60, :throttle_authenticated_api_enabled=>true}1526[May 30 2023 03:21:41 UTC (QA Tests)] INFO -- Setting application settings: {:throttle_authenticated_api_requests_per_period=>7200, :throttle_authenticated_api_period_in_seconds=>3600, :throttle_authenticated_api_enabled=>false}1527[May 30 2023 03:21:41 UTC (QA Tests)] INFO -- Removed a QA::Resource::User with username 'qa-user-3cfb72af0b0bb323'1528 throttles authenticated api requests by user1529Create1530 Prereceive hook1531 when creating a tag for a ref1532 when it triggers a prereceive hook configured with a custom error1533[May 30 2023 03:21:41 UTC (QA Tests)] INFO -- Starting test: Create Prereceive hook when creating a tag for a ref when it triggers a prereceive hook configured with a custom error returns a custom server hook error1534[May 30 2023 03:21:41 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-3' via api in 0.06 seconds1535[May 30 2023 03:21:41 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04' via api in 0.12 seconds1536[May 30 2023 03:21:42 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/the_awesome_project-9f7e5922d9a9c1dd' via api in 0.95 seconds1537 returns a custom server hook error1538Verify1539 Pipeline editor1540[May 30 2023 03:21:43 UTC (QA Tests)] INFO -- Starting test: Verify Pipeline editor can create merge request1541[May 30 2023 03:21:43 UTC (QA Tests)] INFO -- filling :login_field with "root"1542[May 30 2023 03:21:43 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field1543[May 30 2023 03:21:44 UTC (QA Tests)] INFO -- filling :password_field with "*****"1544[May 30 2023 03:21:44 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field1545[May 30 2023 03:21:44 UTC (QA Tests)] INFO -- clicking :sign_in_button1546[May 30 2023 03:21:45 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 1.143s1547[May 30 2023 03:21:46 UTC (QA Tests)] INFO -- Enabling super sidebar!1548[May 30 2023 03:21:46 UTC (QA Tests)] INFO -- Super sidebar is already enabled1549[May 30 2023 03:21:47 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-3' via api in 0.06 seconds1550[May 30 2023 03:21:47 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04' via api in 0.13 seconds1551[May 30 2023 03:21:48 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/pipeline-editor-project-93ff5f2811bbc4b7' via api in 1.04 seconds1552[May 30 2023 03:21:48 UTC (QA Tests)] INFO -- Visiting QA::Resource::Project at http://gitlab-gitaly-cluster.test/gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/pipeline-editor-project-93ff5f2811bbc4b71553[May 30 2023 03:21:50 UTC (QA Tests)] INFO -- clicking :menu_section_button1554[May 30 2023 03:21:50 UTC (QA Tests)] INFO -- clicking :nav_item_link1555[May 30 2023 03:21:51 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element nav_item_link' took 0.885s1556[May 30 2023 03:21:51 UTC (QA Tests)] INFO -- clicking :create_new_ci_button and ensuring QA::Page::Project::PipelineEditor::Show is present1557[May 30 2023 03:21:52 UTC (QA Tests)] INFO -- clicking :pipeline_editor_app1558[May 30 2023 03:21:52 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element create_new_ci_button' took 1.297s1559[May 30 2023 03:21:52 UTC (QA Tests)] INFO -- clicking :pipeline_editor_app1560[May 30 2023 03:21:53 UTC (QA Tests)] INFO -- checking via JS :new_mr_checkbox with args {}1561[May 30 2023 03:21:53 UTC (QA Tests)] INFO -- clicking :commit_changes_button1562[May 30 2023 03:21:54 UTC (QA Tests)] WARN -- Potentially Slow Code 'wait_for_requests ' took 1.788s1563[May 30 2023 03:21:54 UTC (QA Tests)] INFO -- clicking :issuable_create_button and ensuring QA::Page::MergeRequest::Show is present1564[May 30 2023 03:21:58 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element issuable_create_button' took 3.331s1565[May 30 2023 03:21:58 UTC (QA Tests)] INFO -- Removed a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/pipeline-editor-project-93ff5f2811bbc4b7'1566[May 30 2023 03:21:58 UTC (QA Tests)] ERROR -- Interceptor Api Errors1567[-1] POST /api/graphql -- Correlation Id: Correlation Id not found1568 can create merge request1569Verify1570 Runner registration1571[May 30 2023 03:21:58 UTC (QA Tests)] INFO -- Starting test: Verify Runner registration user registers a new project runner1572[May 30 2023 03:21:58 UTC (QA Tests)] INFO -- Runner api_get exception caught and handled: No value was computed for id of QA::Resource::ProjectRunner.1573[May 30 2023 03:21:58 UTC (QA Tests)] INFO -- Executing: `docker pull registry.gitlab.com/gitlab-org/gitlab-runner:alpine`1574[May 30 2023 03:21:58 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-3' via api in 0.07 seconds1575[May 30 2023 03:21:59 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04' via api in 0.14 seconds1576[May 30 2023 03:21:59 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/project-with-ci-cd-2ecf6f9224ade760' via api in 0.61 seconds1577[May 30 2023 03:21:59 UTC (QA Tests)] INFO -- Executing: `docker network inspect test`1578[May 30 2023 03:21:59 UTC (QA Tests)] INFO -- Executing: `docker run -d --rm --network test --name qa-runner-1685416918 --privileged registry.gitlab.com/gitlab-org/gitlab-runner:alpine && docker exec --detach qa-runner-1685416918 sh -c "printf 'concurrent = 1\ncheck_interval = 0\n\n[session_server]\n session_timeout = 1800' > /etc/gitlab-runner/config.toml && gitlab-runner register --non-interactive --name qa-runner-1685416918 --url http://gitlab-gitaly-cluster.test --registration-token **** --tag-list e2e-test --executor shell && gitlab-runner run" `1579[May 30 2023 03:22:00 UTC (QA Tests)] INFO -- Executing: `docker logs qa-runner-1685416918`1580[May 30 2023 03:22:00 UTC (QA Tests)] INFO -- Executing: `docker network inspect test`1581[May 30 2023 03:22:00 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::ProjectRunner with name 'qa-runner-1685416918' via api in 2.0 seconds1582[May 30 2023 03:22:01 UTC (QA Tests)] INFO -- filling :login_field with "root"1583[May 30 2023 03:22:01 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field1584[May 30 2023 03:22:01 UTC (QA Tests)] INFO -- filling :password_field with "*****"1585[May 30 2023 03:22:01 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field1586[May 30 2023 03:22:01 UTC (QA Tests)] INFO -- clicking :sign_in_button1587[May 30 2023 03:22:03 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 1.158s1588[May 30 2023 03:22:03 UTC (QA Tests)] INFO -- Enabling super sidebar!1589[May 30 2023 03:22:03 UTC (QA Tests)] INFO -- Super sidebar is already enabled1590[May 30 2023 03:22:05 UTC (QA Tests)] INFO -- Visiting QA::Resource::Project at http://gitlab-gitaly-cluster.test/gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/project-with-ci-cd-2ecf6f9224ade7601591[May 30 2023 03:22:06 UTC (QA Tests)] INFO -- clicking :menu_section_button1592[May 30 2023 03:22:06 UTC (QA Tests)] INFO -- clicking :nav_item_link1593[May 30 2023 03:22:08 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element nav_item_link' took 1.662s1594[May 30 2023 03:22:09 UTC (QA Tests)] INFO -- Removed a QA::Resource::ProjectRunner with name 'qa-runner-1685416918'1595[May 30 2023 03:22:09 UTC (QA Tests)] INFO -- Executing: `docker rm -f qa-runner-1685416918`1596 user registers a new project runner1597Package1598 SaaS Container Registry1599 pushes project image to the container registry and deletes tag (PENDING: Test is not compatible with this environment or pipeline)1600Manage1601 basic user login1602[May 30 2023 03:22:10 UTC (QA Tests)] INFO -- Starting test: Manage basic user login user logs in using basic credentials and logs out1603[May 30 2023 03:22:10 UTC (QA Tests)] INFO -- filling :login_field with "root"1604[May 30 2023 03:22:10 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field1605[May 30 2023 03:22:11 UTC (QA Tests)] INFO -- filling :password_field with "*****"1606[May 30 2023 03:22:11 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field1607[May 30 2023 03:22:11 UTC (QA Tests)] INFO -- clicking :sign_in_button1608[May 30 2023 03:22:12 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 1.088s1609[May 30 2023 03:22:12 UTC (QA Tests)] INFO -- Enabling super sidebar!1610[May 30 2023 03:22:12 UTC (QA Tests)] INFO -- Super sidebar is already enabled1611[May 30 2023 03:22:15 UTC (QA Tests)] WARN -- Potentially Slow Code 'has_element? user_profile_link' took 1.058s1612[May 30 2023 03:22:15 UTC (QA Tests)] INFO -- clicking :user_avatar_content1613[May 30 2023 03:22:16 UTC (QA Tests)] INFO -- clicking :sign_out_link1614 user logs in using basic credentials and logs out1615Verify1616 Include multiple files from multiple projects1617[May 30 2023 03:22:16 UTC (QA Tests)] INFO -- Starting test: Verify Include multiple files from multiple projects runs the pipeline with composed config1618[May 30 2023 03:22:16 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-3' via api in 0.06 seconds1619[May 30 2023 03:22:16 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04' via api in 0.13 seconds1620[May 30 2023 03:22:17 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/project-with-pipeline-094bcafa7bfe0512' via api in 0.62 seconds1621[May 30 2023 03:22:17 UTC (QA Tests)] INFO -- Runner api_get exception caught and handled: No value was computed for id of QA::Resource::ProjectRunner.1622[May 30 2023 03:22:17 UTC (QA Tests)] INFO -- Executing: `docker pull registry.gitlab.com/gitlab-org/gitlab-runner:alpine`1623[May 30 2023 03:22:22 UTC (QA Tests)] INFO -- Executing: `docker network inspect test`1624[May 30 2023 03:22:22 UTC (QA Tests)] INFO -- Executing: `docker run -d --rm --network test --name qa-runner-sv5ro93b --privileged registry.gitlab.com/gitlab-org/gitlab-runner:alpine && docker exec --detach qa-runner-sv5ro93b sh -c "printf 'concurrent = 1\ncheck_interval = 0\n\n[session_server]\n session_timeout = 1800' > /etc/gitlab-runner/config.toml && gitlab-runner register --non-interactive --name qa-runner-sv5ro93b --url http://gitlab-gitaly-cluster.test --registration-token **** --tag-list qa-runner-sv5ro93b --executor shell && gitlab-runner run" `1625[May 30 2023 03:22:23 UTC (QA Tests)] INFO -- Executing: `docker logs qa-runner-sv5ro93b`1626[May 30 2023 03:22:23 UTC (QA Tests)] INFO -- Executing: `docker network inspect test`1627[May 30 2023 03:22:23 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::ProjectRunner with name 'qa-runner-sv5ro93b' via api in 6.2 seconds1628[May 30 2023 03:22:23 UTC (QA Tests)] INFO -- filling :login_field with "root"1629[May 30 2023 03:22:23 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field1630[May 30 2023 03:22:24 UTC (QA Tests)] INFO -- filling :password_field with "*****"1631[May 30 2023 03:22:24 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field1632[May 30 2023 03:22:24 UTC (QA Tests)] INFO -- clicking :sign_in_button1633[May 30 2023 03:22:25 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 1.158s1634[May 30 2023 03:22:26 UTC (QA Tests)] INFO -- Enabling super sidebar!1635[May 30 2023 03:22:26 UTC (QA Tests)] INFO -- Super sidebar is already enabled1636[May 30 2023 03:22:28 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Repository::Commit via api in 0.57 seconds1637[May 30 2023 03:22:28 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-3' via api in 0.08 seconds1638[May 30 2023 03:22:28 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04' via api in 0.14 seconds1639[May 30 2023 03:22:28 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/external-project-1-794177d5a75f8c15' via api in 0.65 seconds1640[May 30 2023 03:22:29 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Repository::Commit via api in 0.56 seconds1641[May 30 2023 03:22:29 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-3' via api in 0.07 seconds1642[May 30 2023 03:22:29 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04' via api in 0.14 seconds1643[May 30 2023 03:22:30 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/external-project-2-c7a7f903ab260d9b' via api in 0.61 seconds1644[May 30 2023 03:22:30 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Repository::Commit via api in 0.54 seconds1645[May 30 2023 03:22:31 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Repository::Commit via api in 0.58 seconds1646[May 30 2023 03:22:31 UTC (QA Tests)] INFO -- Visiting QA::Resource::Project at http://gitlab-gitaly-cluster.test/gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/project-with-pipeline-094bcafa7bfe05121647[May 30 2023 03:22:32 UTC (QA Tests)] INFO -- clicking :menu_section_button1648[May 30 2023 03:22:33 UTC (QA Tests)] INFO -- clicking :nav_item_link1649[May 30 2023 03:22:33 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element nav_item_link' took 0.775s1650[May 30 2023 03:22:46 UTC (QA Tests)] INFO -- Removed a QA::Resource::ProjectRunner with name 'qa-runner-sv5ro93b'1651[May 30 2023 03:22:46 UTC (QA Tests)] INFO -- Executing: `docker rm -f qa-runner-sv5ro93b`1652 runs the pipeline with composed config1653Manage1654 Project access tokens1655[May 30 2023 03:22:46 UTC (QA Tests)] INFO -- Starting test: Manage Project access tokens can be created and revoked via the UI1656[May 30 2023 03:22:47 UTC (QA Tests)] INFO -- filling :login_field with "root"1657[May 30 2023 03:22:47 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field1658[May 30 2023 03:22:47 UTC (QA Tests)] INFO -- filling :password_field with "*****"1659[May 30 2023 03:22:47 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field1660[May 30 2023 03:22:47 UTC (QA Tests)] INFO -- clicking :sign_in_button1661[May 30 2023 03:22:48 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 1.147s1662[May 30 2023 03:22:49 UTC (QA Tests)] INFO -- Enabling super sidebar!1663[May 30 2023 03:22:49 UTC (QA Tests)] INFO -- Super sidebar is already enabled1664[May 30 2023 03:22:51 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-3' via api in 0.06 seconds1665[May 30 2023 03:22:51 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04' via api in 0.12 seconds1666[May 30 2023 03:22:51 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/the_awesome_project-d3627c04b0f36976' via api in 0.63 seconds1667[May 30 2023 03:22:51 UTC (QA Tests)] INFO -- Visiting QA::Resource::Project at http://gitlab-gitaly-cluster.test/gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/the_awesome_project-d3627c04b0f369761668[May 30 2023 03:22:52 UTC (QA Tests)] INFO -- clicking :menu_section_button1669[May 30 2023 03:22:52 UTC (QA Tests)] INFO -- clicking :nav_item_link1670[May 30 2023 03:22:53 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element nav_item_link' took 0.79s1671[May 30 2023 03:22:53 UTC (QA Tests)] INFO -- filling :access_token_name_field with "*****"1672[May 30 2023 03:22:53 UTC (QA Tests)] INFO -- clicking the coordinates of :access_token_name_field1673[May 30 2023 03:22:53 UTC (QA Tests)] INFO -- clicking :api_label1674[May 30 2023 03:22:53 UTC (QA Tests)] INFO -- filling :expiry_date_field with "2023-06-01"1675[May 30 2023 03:22:53 UTC (QA Tests)] INFO -- clicking the coordinates of :expiry_date_field1676[May 30 2023 03:22:54 UTC (QA Tests)] INFO -- clicking :create_token_button1677[May 30 2023 03:22:54 UTC (QA Tests)] INFO -- clicking :toggle_visibility_button1678[May 30 2023 03:22:55 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::ProjectAccessToken with name 'api-project-access-token-w7bvabhd', token's bot username 'project_46_bot_e423758140184bc23706e59672509aa7' via browser_ui in 8.44 seconds1679[May 30 2023 03:22:55 UTC (QA Tests)] INFO -- clicking :revoke_button1680[May 30 2023 03:22:55 UTC (QA Tests)] INFO -- clicking :confirm_ok_button1681[May 30 2023 03:22:56 UTC (QA Tests)] INFO -- Removed a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/the_awesome_project-d3627c04b0f36976'1682 can be created and revoked via the UI1683Create1684 Merge request push options1685[May 30 2023 03:22:56 UTC (QA Tests)] INFO -- Starting test: Create Merge request push options sets title and description1686[May 30 2023 03:22:56 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-3' via api in 0.07 seconds1687[May 30 2023 03:22:56 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04' via api in 0.13 seconds1688[May 30 2023 03:22:57 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/merge-request-push-options-552e0910afcb4efa' via api in 0.99 seconds1689[May 30 2023 03:22:59 UTC (QA Tests)] INFO -- QA::Resource::Project - wait_for_push with commit message "This is a test commit"1690[May 30 2023 03:22:59 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Repository::ProjectPush via browser_ui in 1.53 seconds1691[May 30 2023 03:22:59 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::MergeRequest with iid '1' via api in 0.21 seconds1692[May 30 2023 03:22:59 UTC (QA Tests)] INFO -- Merging via PUT /projects/47/merge_requests/1/merge1693[May 30 2023 03:23:05 UTC (QA Tests)] INFO -- QA::Resource::Project - wait_for_merge with title "MR push options test 03e118c5c7d6bd58"1694 sets title and description1695Plan1696 Testing project wiki1697[May 30 2023 03:23:06 UTC (QA Tests)] INFO -- Starting test: Plan Testing project wiki can delete a page1698[May 30 2023 03:23:06 UTC (QA Tests)] INFO -- filling :login_field with "root"1699[May 30 2023 03:23:06 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field1700[May 30 2023 03:23:06 UTC (QA Tests)] INFO -- filling :password_field with "*****"1701[May 30 2023 03:23:06 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field1702[May 30 2023 03:23:07 UTC (QA Tests)] INFO -- clicking :sign_in_button1703[May 30 2023 03:23:08 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 1.124s1704[May 30 2023 03:23:08 UTC (QA Tests)] INFO -- Enabling super sidebar!1705[May 30 2023 03:23:08 UTC (QA Tests)] INFO -- Super sidebar is already enabled1706[May 30 2023 03:23:10 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-3' via api in 0.06 seconds1707[May 30 2023 03:23:10 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04' via api in 0.11 seconds1708[May 30 2023 03:23:11 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/wiki_testing-4ed610548fab6d81' via api in 0.72 seconds1709[May 30 2023 03:23:11 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Wiki::ProjectPage via api in 1.18 seconds1710[May 30 2023 03:23:11 UTC (QA Tests)] INFO -- Visiting QA::Resource::Wiki::ProjectPage at http://gitlab-gitaly-cluster.test/gitlab-qa-sandbox-group-3/qa-test-2023-05-30-03-08-49-4c01bce091402e04/wiki_testing-4ed610548fab6d81/-/wikis/Home1711[May 30 2023 03:23:12 UTC (QA Tests)] INFO -- clicking :edit_page_button1712[May 30 2023 03:23:13 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element edit_page_button' took 0.916s1713[May 30 2023 03:23:13 UTC (QA Tests)] INFO -- clicking :delete_button and ensuring QA::Page::Modal::DeleteWiki is present1714[May 30 2023 03:23:13 UTC (QA Tests)] INFO -- clicking :confirm_deletion_button1715[May 30 2023 03:23:14 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element confirm_deletion_button' took 1.188s1716 can delete a page1717[May 30 2023 03:23:14 UTC (QA Tests)] INFO -- 1718========= Knapsack Time Offset Warning ==========1719Time offset: 30s1720Max allowed node time execution: 15m 21s1721Exceeded time: -47s1723Global time execution for this CI node is fine.1724Happy testing!1725Need explanation? See FAQ:1727=================================================1728Read up on the benefits of a dynamic test split with Knapsack Pro Queue Mode:1729https://docs.knapsackpro.com/2020/how-to-speed-up-ruby-and-javascript-tests-with-ci-parallelisation1730Sign up for Knapsack Pro here:1732=================================================1733[May 30 2023 03:23:14 UTC (QA Tests)] INFO -- 1734Knapsack global time execution for tests: 14m 34s1735Pending: (Failures listed here are expected and do not affect your suite's status)1736 1) Monitor Recovery alert when using HTTP endpoint integration behaves like triggers recovery alert only closes the correct incident1737 # In quarantine : https://gitlab.com/gitlab-org/gitlab/-/issues/3955121738 # ./qa/specs/features/browser_ui/8_monitor/incident_management/recovery_alert_closes_correct_incident_spec.rb:101739 2) Monitor Recovery alert when using Prometheus integration behaves like triggers recovery alert only closes the correct incident1740 # In quarantine : https://gitlab.com/gitlab-org/gitlab/-/issues/3955121741 # ./qa/specs/features/browser_ui/8_monitor/incident_management/recovery_alert_closes_correct_incident_spec.rb:101742 3) Create Link to line in Web IDE can link to a specific line of code in Web IDE1743 # Skipped but kept as reference. https://gitlab.com/gitlab-org/gitlab/-/merge_requests/115741#note_13307209441744 # ./qa/specs/features/browser_ui/3_create/web_ide_old/link_to_line_in_web_ide_spec.rb:261745 4) Create Merge requests when merging once behaves like merge when pipeline succeeds merges after pipeline succeeds1746 # In quarantine : https://gitlab.com/gitlab-org/gitlab/-/issues/4030171747 # ./qa/specs/features/browser_ui/3_create/merge_request/merge_when_pipeline_succeeds_spec.rb:531748 5) Package SaaS Container Registry pushes project image to the container registry and deletes tag1749 # Test is not compatible with this environment or pipeline1750 # ./qa/specs/features/browser_ui/5_package/container_registry/saas/container_registry_spec.rb:531751Finished in 14 minutes 35 seconds (files took 3.58 seconds to load)175255 examples, 0 failures, 5 pending1753Randomized with seed 115991754[May 30 2023 03:23:15 UTC (Gitlab QA)] INFO -- Shell command: `docker ps -f name=gitlab-gitaly-cluster`1755[May 30 2023 03:23:15 UTC (Gitlab QA)] INFO -- Shell command: `docker rm -f gitlab-gitaly-cluster`1757Running after script...1758$ if [ "$CI_JOB_STATUS" == "failed" ]; then # collapsed multi-line command1759$ export BUNDLE_PREFIX=$([ "$RUN_WITH_BUNDLE" != "true" ] || echo "bundle exec")1760$ echo -e "\e[0Ksection_start:`date +%s`:report_results_section[collapsed=true]\r\e[0KReport results"1872Not uploading cache qa-e2e-ruby-3.0-6a056e500f83db53eb3d88c766f9864d-16 due to policy1874Uploading artifacts...1875gitlab-qa-run-*: found 430 matching artifact files and directories 1876Uploading artifacts as "archive" to coordinator... 201 Created id=4370061748 responseStatus=201 Created token=64_MC7yR1877Uploading artifacts...1878gitlab-qa-run-*/**/rspec-*.xml: found 1 matching artifact files and directories 1879Uploading artifacts as "junit" to coordinator... 201 Created id=4370061748 responseStatus=201 Created token=64_MC7yR1880Uploading artifacts...1881/builds/gitlab-org/gitlab/suite_status.env: found 1 matching artifact files and directories 1882Uploading artifacts as "dotenv" to coordinator... 201 Created id=4370061748 responseStatus=201 Created token=64_MC7yR1884Job succeeded