qa:internal

Passed Started 3 years ago by
1Running with gitlab-runner 14.3.0-rc1 (ed15bfbf)
2  on green-2.private.runners-manager.gitlab.com/gitlab.com/gitlab-org GaSD-S1F
3  feature flags: FF_USE_FASTZIP:true
 4  Resolving secrets  
  00:00
 5  Preparing the "docker+machine" executor  
  00:04
6Using Docker executor with image registry.gitlab.com/gitlab-org/gitlab-build-images:ruby-2.7.patched-golang-1.16-git-2.31-lfs-2.9-chrome-89-node-14.15-yarn-1.22-postgresql-11-graphicsmagick-1.3.36 ...
7Authenticating with credentials from job payload (GitLab Registry)
8Pulling docker image registry.gitlab.com/gitlab-org/gitlab-build-images:ruby-2.7.patched-golang-1.16-git-2.31-lfs-2.9-chrome-89-node-14.15-yarn-1.22-postgresql-11-graphicsmagick-1.3.36 ...
9Using docker image sha256:5ba30b2efcbe583314cc76f63951dc9434780296f6f0c0927d24b4ce4fb73622 for registry.gitlab.com/gitlab-org/gitlab-build-images:ruby-2.7.patched-golang-1.16-git-2.31-lfs-2.9-chrome-89-node-14.15-yarn-1.22-postgresql-11-graphicsmagick-1.3.36 with digest registry.gitlab.com/gitlab-org/gitlab-build-images@sha256:c4091382b5a12b75ca112f017f8cecffed2cf1a087968e3a03143d55ec67d3bf ...
 10  Preparing environment  
  00:01
11Running on runner-gasd-s1f-project-278964-concurrent-0 via runner-gasd-s1f-private-1632938400-f0a253b0...
 12  Getting source from Git repository  
  00:33
13$ eval "$CI_PRE_CLONE_SCRIPT"
14Downloading archived master...
15Connecting to storage.googleapis.com (172.217.193.128:443)
16saving to '/tmp/gitlab.tar.gz'
17gitlab.tar.gz         51% |****************                |  176M  0:00:00 ETA
18gitlab.tar.gz        100% |********************************|  344M  0:00:00 ETA
19'/tmp/gitlab.tar.gz' saved
20Extracting tarball into /builds/gitlab-org/gitlab...
21Fetching changes with git depth set to 20...
22Reinitialized existing Git repository in /builds/gitlab-org/gitlab/.git/
23Created fresh repository.
24remote: Enumerating objects: 187, done.        
25remote: Counting objects: 100% (123/123), done.        
26remote: Compressing objects: 100% (54/54), done.        
27remote: Total 63 (delta 43), reused 14 (delta 6), pack-reused 0        
28From https://gitlab.com/gitlab-org/gitlab
29 * [new ref]               6c9cdce57f0e700f6c83b722659fe2d1068e9cb5 -> refs/pipelines/379679459
30Checking out 6c9cdce5 as refs/merge-requests/70878/merge...
31Skipping Git submodules setup
 32  Restoring cache  
  00:03
33Checking cache for qa-ruby-gems-v1-4...
34Downloading cache.zip from https://storage.googleapis.com/gitlab-com-runners-cache/project/278964/qa-ruby-gems-v1-4 
35Successfully extracted cache
 36  Executing "step_script" stage of the job script  
  00:17
37Using docker image sha256:5ba30b2efcbe583314cc76f63951dc9434780296f6f0c0927d24b4ce4fb73622 for registry.gitlab.com/gitlab-org/gitlab-build-images:ruby-2.7.patched-golang-1.16-git-2.31-lfs-2.9-chrome-89-node-14.15-yarn-1.22-postgresql-11-graphicsmagick-1.3.36 with digest registry.gitlab.com/gitlab-org/gitlab-build-images@sha256:c4091382b5a12b75ca112f017f8cecffed2cf1a087968e3a03143d55ec67d3bf ...
38$ [ "$FOSS_ONLY" = "1" ] && rm -rf ee/ qa/spec/ee/ qa/qa/specs/features/ee/ qa/qa/ee/ qa/qa/ee.rb
39$ export GOPATH=$CI_PROJECT_DIR/.go
40$ mkdir -p $GOPATH
41$ source scripts/utils.sh
42$ source scripts/prepare_build.sh
43$ cd qa/
44$ bundle_install_script
45Bundler version 2.1.4
46production:development
47Settings are listed in order of priority. The top value will be used.
48path
49Set for the current user (/root/.bundle/config): "/builds/gitlab-org/gitlab/qa/vendor"
50clean
51Set for the current user (/root/.bundle/config): "true"
52without
53Set via BUNDLE_WITHOUT: [:production, :development]
54install_flags
55Set via BUNDLE_INSTALL_FLAGS: "--jobs=$(nproc) --retry=3 --quiet"
56$ bundle install --jobs=$(nproc) --retry=3 --quiet  && bundle check
57Warning: the running version of Bundler (2.1.4) is older than the version that created the lockfile (2.2.22). We suggest you to upgrade to the version that created the lockfile by running `gem install bundler:2.2.22`.
58The Gemfile's dependencies are satisfied
59==> 'bundle install --jobs=$(nproc) --retry=3 --quiet  && bundle check' succeeded in 1 seconds.
60Could not find gem 'pg'.
61$ bundle exec rspec
62warning: parser/current is loading parser/ruby27, which recognizes
63warning: 2.7.1-compliant syntax, but you are running 2.7.4.
64warning: please see https://github.com/whitequark/parser#compatibility-with-ruby-mri.
65/builds/gitlab-org/gitlab/qa/vendor/ruby/2.7.0/gems/capybara-3.35.3/lib/capybara/registration_container.rb:21: warning: DEPRECATED: Calling 'include?' on the drivers/servers container is deprecated without replacement
66/builds/gitlab-org/gitlab/qa/vendor/ruby/2.7.0/gems/chemlab-0.8.1/lib/chemlab/configuration.rb:79: warning: already initialized constant Chemlab::Vendor
67/builds/gitlab-org/gitlab/qa/vendor/ruby/2.7.0/gems/chemlab-0.8.1/lib/chemlab/configuration.rb:79: warning: previous definition of Vendor was here
682021-09-29 19:27:25 / CONF	:: 
69      ==> Base URL: 
70      ==> Browser: #<Selenium::WebDriver::Chrome::Driver:0x00007f276e20f520>
71      ==> Libraries: Chemlab::Vendor
72Randomized with seed 18651
73QA::Support::Formatters::AllureMetadataFormatter
74  adds additional data to report
75QA::Resource::Events::Base
76  #events
77    fetches events with a specified action type
78    fetches all events when called without parameters
79QA::Runtime::Release
80  when release version has extension strategy
81    delegated class methods
82      delegates all calls to strategy class
83    #version
84      return either CE or EE version
85    #strategy
86      return the strategy constant
87QA::Resource::User
88  #fabricate_via_api!
89    tries to create a user if it does not exist
90    fetches an existing user
91QA::Scenario::Bootable
92  does not require attributes to be defined
93  makes it possible to define the scenario attribute
94QA::Specs::Helpers::Quarantine
95  .skip_or_run_quarantined_tests_or_contexts
96    with a non-quarantine tag focused
97      executes non-quarantined focused tests
98      ignores quarantined tests
99      ignores non-quarantined non-focused tests
100      skips quarantined focused tests
101    with no tag focused
102      skips quarantined tests
103      executes non-quarantined tests
104      with environment set
105        multiple pipelines specified
106          behaves like skipped in project
107            is skipped in PRODUCTION
108          behaves like skipped in project
109            is skipped in CANARY
110          behaves like skipped in project
111            is skipped in STAGING
112        no pipeline specified
113          is skipped when set on contexts or descriptions
114          is skipped only in staging
115      quarantine message
116        behaves like test with quarantine message
117          outputs the quarantine message
118        behaves like test with quarantine message
119          outputs the quarantine message
120    with :quarantine focused
121      ignores non-quarantined tests
122      executes quarantined tests
123    with :quarantine and non-quarantine tags focused
124      skips non-quarantined focused tests
125      executes quarantined focused tests
126      skips quarantined non-focused tests
127      ignores non-quarantined non-focused tests
128  .skip_or_run_quarantined_contexts
129    with :quarantine focused
130      skips before hooks of non-quarantined contexts
131      executes before hooks of quarantined contexts
132    with no tag focused
133      skips before hooks of quarantined contexts
134      executes before hooks of non-quarantined contexts
135QA::Git::Location
136  .new
137    when URI does not start with ssh://
138      when host does not have colons
139        parses correctly
140      when host has a colon
141        parses correctly
142    when URI starts with ssh://
143      when URI does not have port
144        parses correctly
145      when URI has port
146        parses correctly
147QA::Support::WaitForRequests
148  .wait_for_requests
149    when skip_finished_loading_check is defaulted to false
150      calls finished_loading?
151    when skip_finished_loading_check is true
152      does not call finished_loading?
153QA::Runtime::Logger
154  logs error
155D, [2021-09-29T19:27:26.496271 #49] DEBUG -- : 
156Starting test: QA::Runtime::Logger logs debug
157  logs debug
158D, [2021-09-29T19:27:26.497223 #49] DEBUG -- : 
159Starting test: QA::Runtime::Logger logs info
160  logs info
161D, [2021-09-29T19:27:26.498121 #49] DEBUG -- : 
162Starting test: QA::Runtime::Logger logs warn
163  logs warn
164D, [2021-09-29T19:27:26.498910 #49] DEBUG -- : 
165Starting test: QA::Runtime::Logger logs fatal
166  logs fatal
167D, [2021-09-29T19:27:26.499731 #49] DEBUG -- : 
168Starting test: QA::Runtime::Logger logs unknown
169  logs unknown
170QA::Scenario::Test::Integration::InstanceSAML
171  #perform
172    behaves like a QA scenario class
173D, [2021-09-29T19:27:26.504159 #49] DEBUG -- : 
174Starting test: QA::Scenario::Test::Integration::InstanceSAML#perform behaves like a QA scenario class sets an address of the subject
175      sets an address of the subject
176D, [2021-09-29T19:27:26.506426 #49] DEBUG -- : 
177Starting test: QA::Scenario::Test::Integration::InstanceSAML#perform behaves like a QA scenario class responds to perform
178      responds to perform
179D, [2021-09-29T19:27:26.509621 #49] DEBUG -- : 
180Starting test: QA::Scenario::Test::Integration::InstanceSAML#perform behaves like a QA scenario class performs before hooks only once
181      performs before hooks only once
182D, [2021-09-29T19:27:26.511374 #49] DEBUG -- : 
183Starting test: QA::Scenario::Test::Integration::InstanceSAML#perform behaves like a QA scenario class sets tags on runner
184      sets tags on runner
185      with named command-line options
186D, [2021-09-29T19:27:26.513270 #49] DEBUG -- : 
187Starting test: QA::Scenario::Test::Integration::InstanceSAML#perform behaves like a QA scenario class with named command-line options raises an error if the option is invalid
188        raises an error if the option is invalid
189D, [2021-09-29T19:27:26.517442 #49] DEBUG -- : 
190Starting test: QA::Scenario::Test::Integration::InstanceSAML#perform behaves like a QA scenario class with named command-line options converts options to attributes
191        converts options to attributes
192D, [2021-09-29T19:27:26.519584 #49] DEBUG -- : 
193Starting test: QA::Scenario::Test::Integration::InstanceSAML#perform behaves like a QA scenario class with named command-line options passes on options after --
194        passes on options after --
195      specifying RSpec options
196D, [2021-09-29T19:27:26.521715 #49] DEBUG -- : 
197Starting test: QA::Scenario::Test::Integration::InstanceSAML#perform behaves like a QA scenario class specifying RSpec options sets options on runner
198        sets options on runner
199QA::Scenario::Test::Instance::Smoke
200  behaves like a QA scenario class
201D, [2021-09-29T19:27:26.526782 #49] DEBUG -- : 
202Starting test: QA::Scenario::Test::Instance::Smoke behaves like a QA scenario class performs before hooks only once
203    performs before hooks only once
204D, [2021-09-29T19:27:26.528635 #49] DEBUG -- : 
205Starting test: QA::Scenario::Test::Instance::Smoke behaves like a QA scenario class sets an address of the subject
206    sets an address of the subject
207D, [2021-09-29T19:27:26.530217 #49] DEBUG -- : 
208Starting test: QA::Scenario::Test::Instance::Smoke behaves like a QA scenario class responds to perform
209    responds to perform
210D, [2021-09-29T19:27:26.531618 #49] DEBUG -- : 
211Starting test: QA::Scenario::Test::Instance::Smoke behaves like a QA scenario class sets tags on runner
212    sets tags on runner
213    specifying RSpec options
214D, [2021-09-29T19:27:26.533405 #49] DEBUG -- : 
215Starting test: QA::Scenario::Test::Instance::Smoke behaves like a QA scenario class specifying RSpec options sets options on runner
216      sets options on runner
217    with named command-line options
218D, [2021-09-29T19:27:26.535124 #49] DEBUG -- : 
219Starting test: QA::Scenario::Test::Instance::Smoke behaves like a QA scenario class with named command-line options passes on options after --
220      passes on options after --
221D, [2021-09-29T19:27:26.537023 #49] DEBUG -- : 
222Starting test: QA::Scenario::Test::Instance::Smoke behaves like a QA scenario class with named command-line options raises an error if the option is invalid
223      raises an error if the option is invalid
224D, [2021-09-29T19:27:26.539113 #49] DEBUG -- : 
225Starting test: QA::Scenario::Test::Instance::Smoke behaves like a QA scenario class with named command-line options converts options to attributes
226      converts options to attributes
227QA::Resource::SSHKey
228  #title
229D, [2021-09-29T19:27:26.544725 #49] DEBUG -- : 
230Starting test: QA::Resource::SSHKey#title is possible to set the title
231    is possible to set the title
232D, [2021-09-29T19:27:26.545632 #49] DEBUG -- : 
233Starting test: QA::Resource::SSHKey#title generates a default title
234    generates a default title
235  #key
236D, [2021-09-29T19:27:26.547962 #49] DEBUG -- : 
237Starting test: QA::Resource::SSHKey#key generates a default key
238Executing `["ssh-keygen", "-t", "rsa", "-b", "4096", "-f", "/tmp/d20210929-49-461b26/id_rsa", "-N", ""]`
239Generating public/private rsa key pair.
240Your identification has been saved in /tmp/d20210929-49-461b26/id_rsa.
241Your public key has been saved in /tmp/d20210929-49-461b26/id_rsa.pub.
242The key fingerprint is:
243SHA256:OEufgkQ3s7QVYh39Y6i6N2aQ6JeexUXJNwuVKgdvVBM root@runner-gasd-s1f-project-278964-concurrent-0
244The key's randomart image is:
245+---[RSA 4096]----+
246|      o.oo .Eo   |
247|     . .oooo..   |
248|    . = .+=+o    |
249|   . o B..*o+o   |
250|    ..*.S=....   |
251|   ..oo=.o       |
252|   .. o+=        |
253|    . ++=        |
254|     o+= .       |
255+----[SHA256]-----+
256    generates a default key
257QA::Resource::Events::Project
258  #wait_for_push
259D, [2021-09-29T19:27:26.887307 #49] DEBUG -- : 
260Starting test: QA::Resource::Events::Project#wait_for_push raises an error if a push with the specified commit message is not found
261D, [2021-09-29T19:27:26.888237 #49] DEBUG -- :  - wait_for_push with commit message "bar"
262D, [2021-09-29T19:27:26.888483 #49] DEBUG -- : with wait_until: max_duration: 0.01; reload_page: ; sleep_interval: 0.1; raise_on_failure: false 
263D, [2021-09-29T19:27:26.988989 #49] DEBUG -- : ended wait_until
264    raises an error if a push with the specified commit message is not found
265D, [2021-09-29T19:27:26.990132 #49] DEBUG -- : 
266Starting test: QA::Resource::Events::Project#wait_for_push waits for a push with a specified commit message
267D, [2021-09-29T19:27:26.990845 #49] DEBUG -- :  - wait_for_push with commit message "foo commit"
268D, [2021-09-29T19:27:26.991000 #49] DEBUG -- : with wait_until: max_duration: 0.01; reload_page: ; sleep_interval: 0.1; raise_on_failure: false 
269D, [2021-09-29T19:27:26.991182 #49] DEBUG -- : ended wait_until
270    waits for a push with a specified commit message
271  #wait_for_push_new_branch
272D, [2021-09-29T19:27:26.991980 #49] DEBUG -- : 
273Starting test: QA::Resource::Events::Project#wait_for_push_new_branch waits for a push to the default branch if no branch is given
274D, [2021-09-29T19:27:26.992476 #49] DEBUG -- :  - wait_for_push_new_branch with branch_name "master"
275D, [2021-09-29T19:27:26.992630 #49] DEBUG -- : with wait_until: max_duration: 0.01; reload_page: ; sleep_interval: 0.1; raise_on_failure: false 
276D, [2021-09-29T19:27:26.992791 #49] DEBUG -- : ended wait_until
277    waits for a push to the default branch if no branch is given
278D, [2021-09-29T19:27:26.993555 #49] DEBUG -- : 
279Starting test: QA::Resource::Events::Project#wait_for_push_new_branch waits for a push to the given branch
280D, [2021-09-29T19:27:26.994140 #49] DEBUG -- :  - wait_for_push_new_branch with branch_name "another-branch"
281D, [2021-09-29T19:27:26.994259 #49] DEBUG -- : with wait_until: max_duration: 0.01; reload_page: ; sleep_interval: 0.1; raise_on_failure: false 
282D, [2021-09-29T19:27:26.994363 #49] DEBUG -- : ended wait_until
283    waits for a push to the given branch
284D, [2021-09-29T19:27:26.994940 #49] DEBUG -- : 
285Starting test: QA::Resource::Events::Project#wait_for_push_new_branch raises an error if a push with the specified branch is not found
286D, [2021-09-29T19:27:26.995576 #49] DEBUG -- :  - wait_for_push_new_branch with branch_name "bar"
287D, [2021-09-29T19:27:26.995695 #49] DEBUG -- : with wait_until: max_duration: 0.01; reload_page: ; sleep_interval: 0.1; raise_on_failure: false 
288D, [2021-09-29T19:27:27.096064 #49] DEBUG -- : ended wait_until
289    raises an error if a push with the specified branch is not found
290QA::Support::Run
291D, [2021-09-29T19:27:27.101072 #49] DEBUG -- : 
292Starting test: QA::Support::Run runs successfully
293D, [2021-09-29T19:27:27.101626 #49] DEBUG -- : Attempt number 1
294D, [2021-09-29T19:27:27.101681 #49] DEBUG -- : pwd=[/builds/gitlab-org/gitlab/qa], command=[some command 2>&1]
295D, [2021-09-29T19:27:27.101827 #49] DEBUG -- : output=[successful response], exitstatus=[0]
296  runs successfully
297D, [2021-09-29T19:27:27.102693 #49] DEBUG -- : 
298Starting test: QA::Support::Run raises an exception on 3rd failure
299D, [2021-09-29T19:27:27.103219 #49] DEBUG -- : Attempt number 1
300D, [2021-09-29T19:27:27.103264 #49] DEBUG -- : pwd=[/builds/gitlab-org/gitlab/qa], command=[some command 2>&1]
301D, [2021-09-29T19:27:27.103434 #49] DEBUG -- : output=[FAILURE], exitstatus=[1]
302  raises an exception on 3rd failure
303D, [2021-09-29T19:27:27.104183 #49] DEBUG -- : 
304Starting test: QA::Support::Run retries twice and succeeds the third time
305D, [2021-09-29T19:27:27.104686 #49] DEBUG -- : Attempt number 1
306D, [2021-09-29T19:27:27.104736 #49] DEBUG -- : pwd=[/builds/gitlab-org/gitlab/qa], command=[some command 2>&1]
307D, [2021-09-29T19:27:27.104825 #49] DEBUG -- : output=[successful response], exitstatus=[0]
308  retries twice and succeeds the third time
309QA::Specs::Helpers::ContextSelector
310D, [2021-09-29T19:27:27.109376 #49] DEBUG -- : 
311Starting test: QA::Specs::Helpers::ContextSelector outputs a message for invalid environments
312  outputs a message for invalid environments
313D, [2021-09-29T19:27:27.110993 #49] DEBUG -- : 
314Starting test: QA::Specs::Helpers::ContextSelector runs only in staging
315  runs only in staging
316  when excluding contexts
317D, [2021-09-29T19:27:27.113207 #49] DEBUG -- : 
318Starting test: QA::Specs::Helpers::ContextSelector when excluding contexts skips staging
319    skips staging
320  description and context blocks
321    with environment set
322D, [2021-09-29T19:27:27.115185 #49] DEBUG -- : 
323Starting test: QA::Specs::Helpers::ContextSelector description and context blocks with environment set can apply to contexts or descriptions
324      can apply to contexts or descriptions
325      when excluding contexts
326D, [2021-09-29T19:27:27.116794 #49] DEBUG -- : 
327Starting test: QA::Specs::Helpers::ContextSelector description and context blocks with environment set when excluding contexts can apply to contexts or descriptions
328        can apply to contexts or descriptions
329    with different environment set
330D, [2021-09-29T19:27:27.118410 #49] DEBUG -- : 
331Starting test: QA::Specs::Helpers::ContextSelector description and context blocks with different environment set does not run against production
332      does not run against production
333      when excluding contexts
334D, [2021-09-29T19:27:27.119963 #49] DEBUG -- : 
335Starting test: QA::Specs::Helpers::ContextSelector description and context blocks with different environment set when excluding contexts runs against production
336        runs against production
337  .context_matches?
338D, [2021-09-29T19:27:27.121633 #49] DEBUG -- : 
339Starting test: QA::Specs::Helpers::ContextSelector.context_matches? returns false for mismatching
340    returns false for mismatching
341D, [2021-09-29T19:27:27.122504 #49] DEBUG -- : 
342Starting test: QA::Specs::Helpers::ContextSelector.context_matches? returns true when url has .com
343    returns true when url has .com
344D, [2021-09-29T19:27:27.123454 #49] DEBUG -- : 
345Starting test: QA::Specs::Helpers::ContextSelector.context_matches? returns false when url does not have .com
346    returns false when url does not have .com
347    with arguments
348D, [2021-09-29T19:27:27.124490 #49] DEBUG -- : 
349Starting test: QA::Specs::Helpers::ContextSelector.context_matches? with arguments returns true when :subdomain is set
350      returns true when :subdomain is set
351D, [2021-09-29T19:27:27.125327 #49] DEBUG -- : 
352Starting test: QA::Specs::Helpers::ContextSelector.context_matches? with arguments doesnt match with mismatching switches
353      doesnt match with mismatching switches
354D, [2021-09-29T19:27:27.126364 #49] DEBUG -- : 
355Starting test: QA::Specs::Helpers::ContextSelector.context_matches? with arguments matches :production
356      matches :production
357D, [2021-09-29T19:27:27.127326 #49] DEBUG -- : 
358Starting test: QA::Specs::Helpers::ContextSelector.context_matches? with arguments matches multiple subdomains
359      matches multiple subdomains
360  production
361D, [2021-09-29T19:27:27.128579 #49] DEBUG -- : 
362Starting test: QA::Specs::Helpers::ContextSelector production runs on production
363    runs on production
364    when excluding contexts
365D, [2021-09-29T19:27:27.130507 #49] DEBUG -- : 
366Starting test: QA::Specs::Helpers::ContextSelector production when excluding contexts skips production
367      skips production
368  with pipeline constraints
369    without CI_PROJECT_NAME set
370D, [2021-09-29T19:27:27.132547 #49] DEBUG -- : 
371Starting test: QA::Specs::Helpers::ContextSelector with pipeline constraints without CI_PROJECT_NAME set runs on any pipeline
372      runs on any pipeline
373      when excluding contexts
374D, [2021-09-29T19:27:27.135354 #49] DEBUG -- : 
375Starting test: QA::Specs::Helpers::ContextSelector with pipeline constraints without CI_PROJECT_NAME set when excluding contexts runs in any pipeline
376        runs in any pipeline
377    when a pipeline triggered from the default branch runs in gitlab-qa
378D, [2021-09-29T19:27:27.138086 #49] DEBUG -- : 
379Starting test: QA::Specs::Helpers::ContextSelector with pipeline constraints when a pipeline triggered from the default branch runs in gitlab-qa runs on default branch pipelines
380      runs on default branch pipelines
381      when excluding contexts
382D, [2021-09-29T19:27:27.141002 #49] DEBUG -- : 
383Starting test: QA::Specs::Helpers::ContextSelector with pipeline constraints when a pipeline triggered from the default branch runs in gitlab-qa when excluding contexts skips default branch pipelines
384        skips default branch pipelines
385    with CI_PROJECT_NAME set
386D, [2021-09-29T19:27:27.144068 #49] DEBUG -- : 
387Starting test: QA::Specs::Helpers::ContextSelector with pipeline constraints with CI_PROJECT_NAME set runs on designated pipeline
388      runs on designated pipeline
389      when excluding contexts
390D, [2021-09-29T19:27:27.146881 #49] DEBUG -- : 
391Starting test: QA::Specs::Helpers::ContextSelector with pipeline constraints with CI_PROJECT_NAME set when excluding contexts skips designated pipeline
392        skips designated pipeline
393  custom env
394D, [2021-09-29T19:27:27.150027 #49] DEBUG -- : 
395Starting test: QA::Specs::Helpers::ContextSelector custom env runs on a custom environment
396    runs on a custom environment
397    when excluding contexts
398D, [2021-09-29T19:27:27.151722 #49] DEBUG -- : 
399Starting test: QA::Specs::Helpers::ContextSelector custom env when excluding contexts skips a custom environment
400      skips a custom environment
401  with job constraints
402    without CI_JOB_NAME set
403      when excluding contexts
404D, [2021-09-29T19:27:27.153650 #49] DEBUG -- : 
405Starting test: QA::Specs::Helpers::ContextSelector with job constraints without CI_JOB_NAME set when excluding contexts runs in any job
406        runs in any job
407      when including only specific contexts
408D, [2021-09-29T19:27:27.156653 #49] DEBUG -- : 
409Starting test: QA::Specs::Helpers::ContextSelector with job constraints without CI_JOB_NAME set when including only specific contexts runs in any job
410        runs in any job
411    with CI_JOB_NAME set
412      when excluding contexts
413D, [2021-09-29T19:27:27.159978 #49] DEBUG -- : 
414Starting test: QA::Specs::Helpers::ContextSelector with job constraints with CI_JOB_NAME set when excluding contexts runs in jobs that do not match
415        runs in jobs that do not match
416D, [2021-09-29T19:27:27.163288 #49] DEBUG -- : 
417Starting test: QA::Specs::Helpers::ContextSelector with job constraints with CI_JOB_NAME set when excluding contexts does not run in the specified job
418        does not run in the specified job
419      when including only specific contexts
420D, [2021-09-29T19:27:27.166480 #49] DEBUG -- : 
421Starting test: QA::Specs::Helpers::ContextSelector with job constraints with CI_JOB_NAME set when including only specific contexts runs only in the specified jobs
422        runs only in the specified jobs
423D, [2021-09-29T19:27:27.169569 #49] DEBUG -- : 
424Starting test: QA::Specs::Helpers::ContextSelector with job constraints with CI_JOB_NAME set when including only specific contexts does not run in jobs that do not match
425        does not run in jobs that do not match
426QA::Runtime::Scenario
427D, [2021-09-29T19:27:27.176107 #49] DEBUG -- : 
428Starting test: QA::Runtime::Scenario raises error when attribute is not known
429  raises error when attribute is not known
430D, [2021-09-29T19:27:27.176865 #49] DEBUG -- : 
431Starting test: QA::Runtime::Scenario raises error when attribute is empty
432  raises error when attribute is empty
433D, [2021-09-29T19:27:27.177568 #49] DEBUG -- : 
434Starting test: QA::Runtime::Scenario makes it possible to define global scenario attributes
435  makes it possible to define global scenario attributes
436D, [2021-09-29T19:27:27.178212 #49] DEBUG -- : 
437Starting test: QA::Runtime::Scenario replaces an existing attribute
438  replaces an existing attribute
439QA::Scenario::Test::Integration::LDAPNoTLS
440  #perform
441    behaves like a QA scenario class
442D, [2021-09-29T19:27:27.182590 #49] DEBUG -- : 
443Starting test: QA::Scenario::Test::Integration::LDAPNoTLS#perform behaves like a QA scenario class sets tags on runner
444      sets tags on runner
445D, [2021-09-29T19:27:27.184237 #49] DEBUG -- : 
446Starting test: QA::Scenario::Test::Integration::LDAPNoTLS#perform behaves like a QA scenario class sets an address of the subject
447      sets an address of the subject
448D, [2021-09-29T19:27:27.185494 #49] DEBUG -- : 
449Starting test: QA::Scenario::Test::Integration::LDAPNoTLS#perform behaves like a QA scenario class performs before hooks only once
450      performs before hooks only once
451D, [2021-09-29T19:27:27.186742 #49] DEBUG -- : 
452Starting test: QA::Scenario::Test::Integration::LDAPNoTLS#perform behaves like a QA scenario class responds to perform
453      responds to perform
454      with named command-line options
455D, [2021-09-29T19:27:27.188109 #49] DEBUG -- : 
456Starting test: QA::Scenario::Test::Integration::LDAPNoTLS#perform behaves like a QA scenario class with named command-line options converts options to attributes
457        converts options to attributes
458D, [2021-09-29T19:27:27.189661 #49] DEBUG -- : 
459Starting test: QA::Scenario::Test::Integration::LDAPNoTLS#perform behaves like a QA scenario class with named command-line options passes on options after --
460        passes on options after --
461D, [2021-09-29T19:27:27.191189 #49] DEBUG -- : 
462Starting test: QA::Scenario::Test::Integration::LDAPNoTLS#perform behaves like a QA scenario class with named command-line options raises an error if the option is invalid
463        raises an error if the option is invalid
464      specifying RSpec options
465D, [2021-09-29T19:27:27.192874 #49] DEBUG -- : 
466Starting test: QA::Scenario::Test::Integration::LDAPNoTLS#perform behaves like a QA scenario class specifying RSpec options sets options on runner
467        sets options on runner
468QA::EE::Scenario::Test::Integration::GroupSAML
469  #perform
470    behaves like a QA scenario class
471D, [2021-09-29T19:27:27.197983 #49] DEBUG -- : 
472Starting test: QA::EE::Scenario::Test::Integration::GroupSAML#perform behaves like a QA scenario class performs before hooks only once
473      performs before hooks only once
474D, [2021-09-29T19:27:27.199597 #49] DEBUG -- : 
475Starting test: QA::EE::Scenario::Test::Integration::GroupSAML#perform behaves like a QA scenario class responds to perform
476      responds to perform
477D, [2021-09-29T19:27:27.200779 #49] DEBUG -- : 
478Starting test: QA::EE::Scenario::Test::Integration::GroupSAML#perform behaves like a QA scenario class sets an address of the subject
479      sets an address of the subject
480D, [2021-09-29T19:27:27.202064 #49] DEBUG -- : 
481Starting test: QA::EE::Scenario::Test::Integration::GroupSAML#perform behaves like a QA scenario class sets tags on runner
482      sets tags on runner
483      specifying RSpec options
484D, [2021-09-29T19:27:27.203520 #49] DEBUG -- : 
485Starting test: QA::EE::Scenario::Test::Integration::GroupSAML#perform behaves like a QA scenario class specifying RSpec options sets options on runner
486        sets options on runner
487      with named command-line options
488D, [2021-09-29T19:27:27.205079 #49] DEBUG -- : 
489Starting test: QA::EE::Scenario::Test::Integration::GroupSAML#perform behaves like a QA scenario class with named command-line options passes on options after --
490        passes on options after --
491D, [2021-09-29T19:27:27.206782 #49] DEBUG -- : 
492Starting test: QA::EE::Scenario::Test::Integration::GroupSAML#perform behaves like a QA scenario class with named command-line options raises an error if the option is invalid
493        raises an error if the option is invalid
494D, [2021-09-29T19:27:27.208487 #49] DEBUG -- : 
495Starting test: QA::EE::Scenario::Test::Integration::GroupSAML#perform behaves like a QA scenario class with named command-line options converts options to attributes
496        converts options to attributes
497QA::Scenario::Test::Integration::LDAPTLS
498  #perform
499    behaves like a QA scenario class
500D, [2021-09-29T19:27:27.214316 #49] DEBUG -- : 
501Starting test: QA::Scenario::Test::Integration::LDAPTLS#perform behaves like a QA scenario class sets tags on runner
502      sets tags on runner
503D, [2021-09-29T19:27:27.215970 #49] DEBUG -- : 
504Starting test: QA::Scenario::Test::Integration::LDAPTLS#perform behaves like a QA scenario class performs before hooks only once
505      performs before hooks only once
506D, [2021-09-29T19:27:27.217373 #49] DEBUG -- : 
507Starting test: QA::Scenario::Test::Integration::LDAPTLS#perform behaves like a QA scenario class responds to perform
508      responds to perform
509D, [2021-09-29T19:27:27.218595 #49] DEBUG -- : 
510Starting test: QA::Scenario::Test::Integration::LDAPTLS#perform behaves like a QA scenario class sets an address of the subject
511      sets an address of the subject
512      with named command-line options
513D, [2021-09-29T19:27:27.220220 #49] DEBUG -- : 
514Starting test: QA::Scenario::Test::Integration::LDAPTLS#perform behaves like a QA scenario class with named command-line options converts options to attributes
515        converts options to attributes
516D, [2021-09-29T19:27:27.221924 #49] DEBUG -- : 
517Starting test: QA::Scenario::Test::Integration::LDAPTLS#perform behaves like a QA scenario class with named command-line options passes on options after --
518        passes on options after --
519D, [2021-09-29T19:27:27.223550 #49] DEBUG -- : 
520Starting test: QA::Scenario::Test::Integration::LDAPTLS#perform behaves like a QA scenario class with named command-line options raises an error if the option is invalid
521        raises an error if the option is invalid
522      specifying RSpec options
523D, [2021-09-29T19:27:27.225361 #49] DEBUG -- : 
524Starting test: QA::Scenario::Test::Integration::LDAPTLS#perform behaves like a QA scenario class specifying RSpec options sets options on runner
525        sets options on runner
526QA::Runtime::Key::ECDSA
527  #public_key
528D, [2021-09-29T19:27:27.230411 #49] DEBUG -- : 
529Starting test: QA::Runtime::Key::ECDSA#public_key generates a public 384-bits ECDSA key
530Executing `["ssh-keygen", "-t", "ecdsa", "-b", "384", "-f", "/tmp/d20210929-49-u5azqf/id_ecdsa", "-N", ""]`
531Generating public/private ecdsa key pair.
532Your identification has been saved in /tmp/d20210929-49-u5azqf/id_ecdsa.
533Your public key has been saved in /tmp/d20210929-49-u5azqf/id_ecdsa.pub.
534The key fingerprint is:
535SHA256:553pjUn4uxUHkV3Y4+Uhkr5hVu08tYBEDPj9KpvHx/A root@runner-gasd-s1f-project-278964-concurrent-0
536The key's randomart image is:
537+---[ECDSA 384]---+
538|        ..=oo o=o|
539|       .   = +o==|
540|        . o o B.*|
541|         . *   B.|
542|        S + + . o|
543|         o = + o |
544|          + X .  |
545|         ..B E   |
546|         o+ Oo.  |
547+----[SHA256]-----+
548    generates a public 384-bits ECDSA key
549D, [2021-09-29T19:27:27.252197 #49] DEBUG -- : 
550Starting test: QA::Runtime::Key::ECDSA#public_key generates a public 256-bits ECDSA key
551Executing `["ssh-keygen", "-t", "ecdsa", "-b", "256", "-f", "/tmp/d20210929-49-467ag/id_ecdsa", "-N", ""]`
552Generating public/private ecdsa key pair.
553Your identification has been saved in /tmp/d20210929-49-467ag/id_ecdsa.
554Your public key has been saved in /tmp/d20210929-49-467ag/id_ecdsa.pub.
555The key fingerprint is:
556SHA256:92G8gcvQKuzY183KqxObRXLYM8s3LH21jTZKhxxyt+M root@runner-gasd-s1f-project-278964-concurrent-0
557The key's randomart image is:
558+---[ECDSA 256]---+
559|                 |
560|                 |
561|         o       |
562|        o.Boo . .|
563|        S=+X=+ +o|
564|     .  .==+O+O..|
565|      o .*o*oB o |
566|     + .=.. + E  |
567|    . o..o+o     |
568+----[SHA256]-----+
569    generates a public 256-bits ECDSA key
570D, [2021-09-29T19:27:27.271277 #49] DEBUG -- : 
571Starting test: QA::Runtime::Key::ECDSA#public_key generates a public 521-bits ECDSA key
572Executing `["ssh-keygen", "-t", "ecdsa", "-b", "521", "-f", "/tmp/d20210929-49-5g2xt3/id_ecdsa", "-N", ""]`
573Generating public/private ecdsa key pair.
574Your identification has been saved in /tmp/d20210929-49-5g2xt3/id_ecdsa.
575Your public key has been saved in /tmp/d20210929-49-5g2xt3/id_ecdsa.pub.
576The key fingerprint is:
577SHA256:ge5IqJ7uD3tWotzuNI/ypBwFHABIbvwaFzl/uCY0c7g root@runner-gasd-s1f-project-278964-concurrent-0
578The key's randomart image is:
579+---[ECDSA 521]---+
580|Bo               |
581|= . .  .         |
582| * +  . .        |
583|. o.=..  .       |
584| ..O.+..S        |
585| .*o=+o          |
586|o+oE+o.          |
587|o+O+*            |
588|oOO* .           |
589+----[SHA256]-----+
590    generates a public 521-bits ECDSA key
591  #new
592D, [2021-09-29T19:27:27.292240 #49] DEBUG -- : 
593Starting test: QA::Runtime::Key::ECDSA#new does not support arbitrary bits
594Executing `["ssh-keygen", "-t", "ecdsa", "-b", "123", "-f", "/tmp/d20210929-49-1lufc58/id_ecdsa", "-N", ""]`
595Invalid ECDSA key length: valid lengths are 256, 384 or 521 bits
596    does not support arbitrary bits
597QA::Runtime::Key::ED25519
598  #public_key
599D, [2021-09-29T19:27:27.306399 #49] DEBUG -- : 
600Starting test: QA::Runtime::Key::ED25519#public_key generates a public ED25519 key
601Executing `["ssh-keygen", "-t", "ed25519", "-b", "256", "-f", "/tmp/d20210929-49-10h7bcg/id_ed25519", "-N", ""]`
602Generating public/private ed25519 key pair.
603Your identification has been saved in /tmp/d20210929-49-10h7bcg/id_ed25519.
604Your public key has been saved in /tmp/d20210929-49-10h7bcg/id_ed25519.pub.
605The key fingerprint is:
606SHA256:gFhQhekzwXt4bxjcRgw0ST27tPGs+P9UiBemTLuItwg root@runner-gasd-s1f-project-278964-concurrent-0
607The key's randomart image is:
608+--[ED25519 256]--+
609|  .+o**=         |
610|   o=...=        |
611|  ...=.o o. o    |
612|    * =.*o = o   |
613|     = *S*= o .  |
614|      ..=.oo .   |
615|    E .oo.. .    |
616|     ..o.. .     |
617|      ..o....    |
618+----[SHA256]-----+
619    generates a public ED25519 key
620QA::Scenario::Test::Integration::Kubernetes
621  #perform
622    behaves like a QA scenario class
623D, [2021-09-29T19:27:27.338493 #49] DEBUG -- : 
624Starting test: QA::Scenario::Test::Integration::Kubernetes#perform behaves like a QA scenario class sets an address of the subject
625      sets an address of the subject
626D, [2021-09-29T19:27:27.340400 #49] DEBUG -- : 
627Starting test: QA::Scenario::Test::Integration::Kubernetes#perform behaves like a QA scenario class performs before hooks only once
628      performs before hooks only once
629D, [2021-09-29T19:27:27.341904 #49] DEBUG -- : 
630Starting test: QA::Scenario::Test::Integration::Kubernetes#perform behaves like a QA scenario class sets tags on runner
631      sets tags on runner
632D, [2021-09-29T19:27:27.343443 #49] DEBUG -- : 
633Starting test: QA::Scenario::Test::Integration::Kubernetes#perform behaves like a QA scenario class responds to perform
634      responds to perform
635      specifying RSpec options
636D, [2021-09-29T19:27:27.344996 #49] DEBUG -- : 
637Starting test: QA::Scenario::Test::Integration::Kubernetes#perform behaves like a QA scenario class specifying RSpec options sets options on runner
638        sets options on runner
639      with named command-line options
640D, [2021-09-29T19:27:27.346716 #49] DEBUG -- : 
641Starting test: QA::Scenario::Test::Integration::Kubernetes#perform behaves like a QA scenario class with named command-line options passes on options after --
642        passes on options after --
643D, [2021-09-29T19:27:27.348613 #49] DEBUG -- : 
644Starting test: QA::Scenario::Test::Integration::Kubernetes#perform behaves like a QA scenario class with named command-line options raises an error if the option is invalid
645        raises an error if the option is invalid
646D, [2021-09-29T19:27:27.350481 #49] DEBUG -- : 
647Starting test: QA::Scenario::Test::Integration::Kubernetes#perform behaves like a QA scenario class with named command-line options converts options to attributes
648        converts options to attributes
649QA::Scenario::Test::Sanity::Selectors
650  when there are no errors detected
651D, [2021-09-29T19:27:27.356115 #49] DEBUG -- : 
652Starting test: QA::Scenario::Test::Sanity::Selectors when there are no errors detected triggers validation
653Views / selectors validation passed!
654    triggers validation
655D, [2021-09-29T19:27:27.357933 #49] DEBUG -- : 
656Starting test: QA::Scenario::Test::Sanity::Selectors when there are no errors detected processes pages module
657Views / selectors validation passed!
658    processes pages module
659  when there are errors detected
660D, [2021-09-29T19:27:27.359256 #49] DEBUG -- : 
661Starting test: QA::Scenario::Test::Sanity::Selectors when there are errors detected outputs information about errors
662Views / selectors validation passed!
663Views / selectors validation passed!
664    outputs information about errors
665QA::Support::Waiter
666  .wait_until
667D, [2021-09-29T19:27:27.364173 #49] DEBUG -- : 
668Starting test: QA::Support::Waiter.wait_until allows logs to be silenced
669    allows logs to be silenced
670D, [2021-09-29T19:27:27.365196 #49] DEBUG -- : 
671Starting test: QA::Support::Waiter.wait_until sets raise_on_failure to true by default
672D, [2021-09-29T19:27:27.365609 #49] DEBUG -- : with wait_until: max_duration: 60; reload_page: ; sleep_interval: 0.1; raise_on_failure: true 
673D, [2021-09-29T19:27:27.365754 #49] DEBUG -- : ended wait_until
674    sets raise_on_failure to true by default
675D, [2021-09-29T19:27:27.366407 #49] DEBUG -- : 
676Starting test: QA::Support::Waiter.wait_until sets sleep_interval to 0.1 by default
677D, [2021-09-29T19:27:27.366720 #49] DEBUG -- : with wait_until: max_duration: 60; reload_page: ; sleep_interval: 0.1; raise_on_failure: true 
678D, [2021-09-29T19:27:27.366842 #49] DEBUG -- : ended wait_until
679    sets sleep_interval to 0.1 by default
680D, [2021-09-29T19:27:27.367446 #49] DEBUG -- : 
681Starting test: QA::Support::Waiter.wait_until sets max_duration to 60 by default
682D, [2021-09-29T19:27:27.367782 #49] DEBUG -- : with wait_until: max_duration: 60; reload_page: ; sleep_interval: 0.1; raise_on_failure: true 
683D, [2021-09-29T19:27:27.367893 #49] DEBUG -- : ended wait_until
684    sets max_duration to 60 by default
685D, [2021-09-29T19:27:27.368520 #49] DEBUG -- : 
686Starting test: QA::Support::Waiter.wait_until sets retry_on_exception to false by default
687D, [2021-09-29T19:27:27.368787 #49] DEBUG -- : with wait_until: max_duration: 60; reload_page: ; sleep_interval: 0.1; raise_on_failure: true 
688D, [2021-09-29T19:27:27.368910 #49] DEBUG -- : ended wait_until
689    sets retry_on_exception to false by default
690    when the condition is false
691D, [2021-09-29T19:27:27.369737 #49] DEBUG -- : 
692Starting test: QA::Support::Waiter.wait_until when the condition is false logs the end
693      logs the end
694D, [2021-09-29T19:27:27.370681 #49] DEBUG -- : 
695Starting test: QA::Support::Waiter.wait_until when the condition is false logs the start
696      logs the start
697    when the condition is true
698D, [2021-09-29T19:27:27.371772 #49] DEBUG -- : 
699Starting test: QA::Support::Waiter.wait_until when the condition is true logs the end
700      logs the end
701D, [2021-09-29T19:27:27.372682 #49] DEBUG -- : 
702Starting test: QA::Support::Waiter.wait_until when the condition is true logs the start
703      logs the start
704QA::Page::Base
705  elements
706    #visible? Page is currently visible
707      with elements
708D, [2021-09-29T19:27:27.377771 #49] DEBUG -- : 
709Starting test: QA::Page::Base elements #visible? Page is currently visible with elements does not raise error if page has elements
710D, [2021-09-29T19:27:27.384004 #49] DEBUG -- : with retry_on_exception: max_attempts: 3; sleep_interval: 0.5
711D, [2021-09-29T19:27:27.384090 #49] DEBUG -- : Attempt number 1
712D, [2021-09-29T19:27:27.397180 #49] DEBUG -- : ended retry_on_exception
713        does not raise error if page has elements
714        not on the page
715D, [2021-09-29T19:27:27.408339 #49] DEBUG -- : 
716Starting test: QA::Page::Base elements #visible? Page is currently visible with elements not on the page is not visible
717          is not visible
718        on the page
719D, [2021-09-29T19:27:27.411074 #49] DEBUG -- : 
720Starting test: QA::Page::Base elements #visible? Page is currently visible with elements on the page is visible
721          is visible
722      no elements
723D, [2021-09-29T19:27:27.412409 #49] DEBUG -- : 
724Starting test: QA::Page::Base elements #visible? Page is currently visible no elements raises error if page has no required elements
725        raises error if page has no required elements
726    #elements
727D, [2021-09-29T19:27:27.413396 #49] DEBUG -- : 
728Starting test: QA::Page::Base elements #elements returns all elements
729      returns all elements
730    #required_elements
731D, [2021-09-29T19:27:27.414282 #49] DEBUG -- : 
732Starting test: QA::Page::Base elements #required_elements returns only required elements
733      returns only required elements
734  #all_elements
735D, [2021-09-29T19:27:27.415255 #49] DEBUG -- : 
736Starting test: QA::Page::Base#all_elements raises an error if count or minimum are not specified
737    raises an error if count or minimum are not specified
738D, [2021-09-29T19:27:27.416246 #49] DEBUG -- : 
739Starting test: QA::Page::Base#all_elements does not raise an error if :minimum, :maximum, :count, or :between is specified
740D, [2021-09-29T19:27:27.420113 #49] DEBUG -- : with retry_on_exception: max_attempts: 3; sleep_interval: 0.5
741D, [2021-09-29T19:27:27.420181 #49] DEBUG -- : Attempt number 1
742D, [2021-09-29T19:27:27.427075 #49] DEBUG -- : ended retry_on_exception
743D, [2021-09-29T19:27:27.430663 #49] DEBUG -- : with retry_on_exception: max_attempts: 3; sleep_interval: 0.5
744D, [2021-09-29T19:27:27.430738 #49] DEBUG -- : Attempt number 1
745D, [2021-09-29T19:27:27.437253 #49] DEBUG -- : ended retry_on_exception
746D, [2021-09-29T19:27:27.440618 #49] DEBUG -- : with retry_on_exception: max_attempts: 3; sleep_interval: 0.5
747D, [2021-09-29T19:27:27.440685 #49] DEBUG -- : Attempt number 1
748D, [2021-09-29T19:27:27.446531 #49] DEBUG -- : ended retry_on_exception
749D, [2021-09-29T19:27:27.450530 #49] DEBUG -- : with retry_on_exception: max_attempts: 3; sleep_interval: 0.5
750D, [2021-09-29T19:27:27.450597 #49] DEBUG -- : Attempt number 1
751D, [2021-09-29T19:27:27.456608 #49] DEBUG -- : ended retry_on_exception
752    does not raise an error if :minimum, :maximum, :count, or :between is specified
753  page helpers
754D, [2021-09-29T19:27:27.458242 #49] DEBUG -- : 
755Starting test: QA::Page::Base page helpers exposes helpful page helpers
756    exposes helpful page helpers
757  .errors
758    when page has no views and elements defined
759D, [2021-09-29T19:27:27.459477 #49] DEBUG -- : 
760Starting test: QA::Page::Base.errors when page has no views and elements defined appends an error about missing views / elements block
761      appends an error about missing views / elements block
762    when page has views and elements defined
763D, [2021-09-29T19:27:27.471256 #49] DEBUG -- : 
764Starting test: QA::Page::Base.errors when page has views and elements defined iterates views composite and returns errors
765      iterates views composite and returns errors
766  .view DSL for defining view partials
767D, [2021-09-29T19:27:27.472884 #49] DEBUG -- : 
768Starting test: QA::Page::Base.view DSL for defining view partials populates views objects with data about elements
769    populates views objects with data about elements
770D, [2021-09-29T19:27:27.476025 #49] DEBUG -- : 
771Starting test: QA::Page::Base.view DSL for defining view partials makes it possible to define page views
772    makes it possible to define page views
773  #wait_until
774    when the condition is false
775D, [2021-09-29T19:27:27.477198 #49] DEBUG -- : 
776Starting test: QA::Page::Base#wait_until when the condition is false refreshes
777D, [2021-09-29T19:27:27.477594 #49] DEBUG -- : with wait_until: max_duration: 0.01; reload_page: ; sleep_interval: 0.1; raise_on_failure: false 
778D, [2021-09-29T19:27:27.578024 #49] DEBUG -- : ended wait_until
779      refreshes
780D, [2021-09-29T19:27:27.579284 #49] DEBUG -- : 
781Starting test: QA::Page::Base#wait_until when the condition is false returns false
782D, [2021-09-29T19:27:27.579722 #49] DEBUG -- : with wait_until: max_duration: 0.01; reload_page: ; sleep_interval: 0.1; raise_on_failure: false 
783D, [2021-09-29T19:27:27.680169 #49] DEBUG -- : ended wait_until
784      returns false
785    when the condition is true
786D, [2021-09-29T19:27:27.681751 #49] DEBUG -- : 
787Starting test: QA::Page::Base#wait_until when the condition is true does not refresh
788D, [2021-09-29T19:27:27.682252 #49] DEBUG -- : with wait_until: max_duration: 0.01; reload_page: ; sleep_interval: 0.1; raise_on_failure: false 
789D, [2021-09-29T19:27:27.682336 #49] DEBUG -- : ended wait_until
790      does not refresh
791D, [2021-09-29T19:27:27.683024 #49] DEBUG -- : 
792Starting test: QA::Page::Base#wait_until when the condition is true returns true
793D, [2021-09-29T19:27:27.683132 #49] DEBUG -- : with wait_until: max_duration: 0.1; reload_page: ; sleep_interval: 0.1; raise_on_failure: false 
794D, [2021-09-29T19:27:27.683191 #49] DEBUG -- : ended wait_until
795      returns true
796QA::Runtime::Env
797  remote grid credentials
798D, [2021-09-29T19:27:27.688175 #49] DEBUG -- : 
799Starting test: QA::Runtime::Env remote grid credentials throws ArgumentError if GRID_ACCESS_KEY is not specified with USERNAME
800    throws ArgumentError if GRID_ACCESS_KEY is not specified with USERNAME
801D, [2021-09-29T19:27:27.690543 #49] DEBUG -- : 
802Starting test: QA::Runtime::Env remote grid credentials is blank if username is empty
803    is blank if username is empty
804D, [2021-09-29T19:27:27.692570 #49] DEBUG -- : 
805Starting test: QA::Runtime::Env remote grid credentials returns a user:key@ combination when all args are satiated
806    returns a user:key@ combination when all args are satiated
807  .github_access_token
808D, [2021-09-29T19:27:27.695196 #49] DEBUG -- : 
809Starting test: QA::Runtime::Env.github_access_token returns "" if GITHUB_ACCESS_TOKEN is not defined
810    returns "" if GITHUB_ACCESS_TOKEN is not defined
811D, [2021-09-29T19:27:27.697158 #49] DEBUG -- : 
812Starting test: QA::Runtime::Env.github_access_token returns stripped string if GITHUB_ACCESS_TOKEN is defined
813    returns stripped string if GITHUB_ACCESS_TOKEN is defined
814  .signup_disabled?
815    behaves like boolean method
816      behaves like boolean method with parameter
817        when there is no env variable set
818D, [2021-09-29T19:27:27.699641 #49] DEBUG -- : 
819Starting test: QA::Runtime::Env.signup_disabled? behaves like boolean method behaves like boolean method with parameter when there is no env variable set returns the default, false
820          returns the default, false
821        when there is an env variable set
822D, [2021-09-29T19:27:27.701834 #49] DEBUG -- : 
823Starting test: QA::Runtime::Env.signup_disabled? behaves like boolean method behaves like boolean method with parameter when there is an env variable set returns true when anything else specified
824          returns true when anything else specified
825D, [2021-09-29T19:27:27.704573 #49] DEBUG -- : 
826Starting test: QA::Runtime::Env.signup_disabled? behaves like boolean method behaves like boolean method with parameter when there is an env variable set returns false when falsey values specified
827          returns false when falsey values specified
828  .can_test?
829D, [2021-09-29T19:27:27.707654 #49] DEBUG -- : 
830Starting test: QA::Runtime::Env.can_test? raises ArgumentError if feature is unknown
831    raises ArgumentError if feature is unknown
832    behaves like boolean method with parameter
833      when there is an env variable set
834D, [2021-09-29T19:27:27.708846 #49] DEBUG -- : 
835Starting test: QA::Runtime::Env.can_test? behaves like boolean method with parameter when there is an env variable set returns true when anything else specified
836        returns true when anything else specified
837D, [2021-09-29T19:27:27.711789 #49] DEBUG -- : 
838Starting test: QA::Runtime::Env.can_test? behaves like boolean method with parameter when there is an env variable set returns false when falsey values specified
839        returns false when falsey values specified
840      when there is no env variable set
841D, [2021-09-29T19:27:27.714780 #49] DEBUG -- : 
842Starting test: QA::Runtime::Env.can_test? behaves like boolean method with parameter when there is no env variable set returns the default, true
843        returns the default, true
844    behaves like boolean method with parameter
845      when there is no env variable set
846D, [2021-09-29T19:27:27.717402 #49] DEBUG -- : 
847Starting test: QA::Runtime::Env.can_test? behaves like boolean method with parameter when there is no env variable set returns the default, true
848        returns the default, true
849      when there is an env variable set
850D, [2021-09-29T19:27:27.719681 #49] DEBUG -- : 
851Starting test: QA::Runtime::Env.can_test? behaves like boolean method with parameter when there is an env variable set returns false when falsey values specified
852        returns false when falsey values specified
853D, [2021-09-29T19:27:27.722570 #49] DEBUG -- : 
854Starting test: QA::Runtime::Env.can_test? behaves like boolean method with parameter when there is an env variable set returns true when anything else specified
855        returns true when anything else specified
856    behaves like boolean method with parameter
857      when there is no env variable set
858D, [2021-09-29T19:27:27.725914 #49] DEBUG -- : 
859Starting test: QA::Runtime::Env.can_test? behaves like boolean method with parameter when there is no env variable set returns the default, true
860        returns the default, true
861      when there is an env variable set
862D, [2021-09-29T19:27:27.728301 #49] DEBUG -- : 
863Starting test: QA::Runtime::Env.can_test? behaves like boolean method with parameter when there is an env variable set returns false when falsey values specified
864        returns false when falsey values specified
865D, [2021-09-29T19:27:27.731271 #49] DEBUG -- : 
866Starting test: QA::Runtime::Env.can_test? behaves like boolean method with parameter when there is an env variable set returns true when anything else specified
867        returns true when anything else specified
868  .require_github_access_token!
869D, [2021-09-29T19:27:27.734459 #49] DEBUG -- : 
870Starting test: QA::Runtime::Env.require_github_access_token! does not raise if GITHUB_ACCESS_TOKEN is defined
871    does not raise if GITHUB_ACCESS_TOKEN is defined
872D, [2021-09-29T19:27:27.736489 #49] DEBUG -- : 
873Starting test: QA::Runtime::Env.require_github_access_token! raises ArgumentError if GITHUB_ACCESS_TOKEN is not defined
874    raises ArgumentError if GITHUB_ACCESS_TOKEN is not defined
875  .forker?
876D, [2021-09-29T19:27:27.738719 #49] DEBUG -- : 
877Starting test: QA::Runtime::Env.forker? returns true if forker username and password are defined
878    returns true if forker username and password are defined
879D, [2021-09-29T19:27:27.741751 #49] DEBUG -- : 
880Starting test: QA::Runtime::Env.forker? returns false if only forker password is defined
881    returns false if only forker password is defined
882D, [2021-09-29T19:27:27.744474 #49] DEBUG -- : 
883Starting test: QA::Runtime::Env.forker? returns false if only forker username is defined
884    returns false if only forker username is defined
885D, [2021-09-29T19:27:27.747219 #49] DEBUG -- : 
886Starting test: QA::Runtime::Env.forker? returns false if no forker credentials are defined
887    returns false if no forker credentials are defined
888  .webdriver_headless?
889    behaves like boolean method
890      behaves like boolean method with parameter
891        when there is an env variable set
892D, [2021-09-29T19:27:27.750360 #49] DEBUG -- : 
893Starting test: QA::Runtime::Env.webdriver_headless? behaves like boolean method behaves like boolean method with parameter when there is an env variable set returns false when falsey values specified
894          returns false when falsey values specified
895D, [2021-09-29T19:27:27.753557 #49] DEBUG -- : 
896Starting test: QA::Runtime::Env.webdriver_headless? behaves like boolean method behaves like boolean method with parameter when there is an env variable set returns true when anything else specified
897          returns true when anything else specified
898        when there is no env variable set
899D, [2021-09-29T19:27:27.756873 #49] DEBUG -- : 
900Starting test: QA::Runtime::Env.webdriver_headless? behaves like boolean method behaves like boolean method with parameter when there is no env variable set returns the default, true
901          returns the default, true
902  .personal_access_token
903    when GITLAB_QA_ACCESS_TOKEN is set
904D, [2021-09-29T19:27:27.759444 #49] DEBUG -- : 
905Starting test: QA::Runtime::Env.personal_access_token when GITLAB_QA_ACCESS_TOKEN is set returns specified token from env
906      returns specified token from env
907    when @personal_access_token is set
908D, [2021-09-29T19:27:27.761513 #49] DEBUG -- : 
909Starting test: QA::Runtime::Env.personal_access_token when @personal_access_token is set returns the instance variable value
910      returns the instance variable value
911  .remote_grid
912D, [2021-09-29T19:27:27.762401 #49] DEBUG -- : 
913Starting test: QA::Runtime::Env.remote_grid is falsey if QA_REMOTE_GRID is not set
914    is falsey if QA_REMOTE_GRID is not set
915D, [2021-09-29T19:27:27.763000 #49] DEBUG -- : 
916Starting test: QA::Runtime::Env.remote_grid accepts https protocol
917    accepts https protocol
918    without credentials
919D, [2021-09-29T19:27:27.765471 #49] DEBUG -- : 
920Starting test: QA::Runtime::Env.remote_grid without credentials has a grid of http://grid/wd/hub
921      has a grid of http://grid/wd/hub
922    with credentials
923D, [2021-09-29T19:27:27.767607 #49] DEBUG -- : 
924Starting test: QA::Runtime::Env.remote_grid with credentials has a grid of http://user:key@grid/wd/hub
925      has a grid of http://user:key@grid/wd/hub
926  .debug?
927    behaves like boolean method
928      behaves like boolean method with parameter
929        when there is no env variable set
930D, [2021-09-29T19:27:27.770978 #49] DEBUG -- : 
931Starting test: QA::Runtime::Env.debug? behaves like boolean method behaves like boolean method with parameter when there is no env variable set returns the default, false
932          returns the default, false
933        when there is an env variable set
934D, [2021-09-29T19:27:27.773271 #49] DEBUG -- : 
935Starting test: QA::Runtime::Env.debug? behaves like boolean method behaves like boolean method with parameter when there is an env variable set returns true when anything else specified
936          returns true when anything else specified
937D, [2021-09-29T19:27:27.775992 #49] DEBUG -- : 
938Starting test: QA::Runtime::Env.debug? behaves like boolean method behaves like boolean method with parameter when there is an env variable set returns false when falsey values specified
939          returns false when falsey values specified
940  .require_admin_access_token!
941D, [2021-09-29T19:27:27.778966 #49] DEBUG -- : 
942Starting test: QA::Runtime::Env.require_admin_access_token! does not raise exception if GITLAB_QA_ADMIN_ACCESS_TOKEN is specified
943    does not raise exception if GITLAB_QA_ADMIN_ACCESS_TOKEN is specified
944D, [2021-09-29T19:27:27.781005 #49] DEBUG -- : 
945Starting test: QA::Runtime::Env.require_admin_access_token! raises ArgumentError if GITLAB_QA_ADMIN_ACCESS_TOKEN is not specified
946    raises ArgumentError if GITLAB_QA_ADMIN_ACCESS_TOKEN is not specified
947  .knapsack?
948D, [2021-09-29T19:27:27.783347 #49] DEBUG -- : 
949Starting test: QA::Runtime::Env.knapsack? returns true if KNAPSACK_TEST_FILE_PATTERN is defined
950    returns true if KNAPSACK_TEST_FILE_PATTERN is defined
951D, [2021-09-29T19:27:27.785521 #49] DEBUG -- : 
952Starting test: QA::Runtime::Env.knapsack? returns true if KNAPSACK_REPORT_PATH is defined
953    returns true if KNAPSACK_REPORT_PATH is defined
954D, [2021-09-29T19:27:27.787630 #49] DEBUG -- : 
955Starting test: QA::Runtime::Env.knapsack? returns false if neither KNAPSACK_GENERATE_REPORT nor KNAPSACK_REPORT_PATH nor KNAPSACK_TEST_FILE_PATTERN are defined
956    returns false if neither KNAPSACK_GENERATE_REPORT nor KNAPSACK_REPORT_PATH nor KNAPSACK_TEST_FILE_PATTERN are defined
957D, [2021-09-29T19:27:27.788352 #49] DEBUG -- : 
958Starting test: QA::Runtime::Env.knapsack? returns true if KNAPSACK_GENERATE_REPORT is defined
959    returns true if KNAPSACK_GENERATE_REPORT is defined
960  .running_in_ci?
961    when there is an env variable set
962D, [2021-09-29T19:27:27.790889 #49] DEBUG -- : 
963Starting test: QA::Runtime::Env.running_in_ci? when there is an env variable set returns true if CI
964      returns true if CI
965D, [2021-09-29T19:27:27.793016 #49] DEBUG -- : 
966Starting test: QA::Runtime::Env.running_in_ci? when there is an env variable set returns true if CI_SERVER
967      returns true if CI_SERVER
968    when there is no env variable set
969D, [2021-09-29T19:27:27.795339 #49] DEBUG -- : 
970Starting test: QA::Runtime::Env.running_in_ci? when there is no env variable set returns true
971      returns true
972  .knapsack?
973D, [2021-09-29T19:27:27.798106 #49] DEBUG -- : 
974Starting test: QA::Runtime::Env.knapsack? returns true if KNAPSACK_TEST_FILE_PATTERN is defined
975    returns true if KNAPSACK_TEST_FILE_PATTERN is defined
976D, [2021-09-29T19:27:27.800298 #49] DEBUG -- : 
977Starting test: QA::Runtime::Env.knapsack? returns true if KNAPSACK_GENERATE_REPORT is defined
978    returns true if KNAPSACK_GENERATE_REPORT is defined
979D, [2021-09-29T19:27:27.802310 #49] DEBUG -- : 
980Starting test: QA::Runtime::Env.knapsack? returns false if neither KNAPSACK_GENERATE_REPORT nor KNAPSACK_REPORT_PATH nor KNAPSACK_TEST_FILE_PATTERN are defined
981    returns false if neither KNAPSACK_GENERATE_REPORT nor KNAPSACK_REPORT_PATH nor KNAPSACK_TEST_FILE_PATTERN are defined
982D, [2021-09-29T19:27:27.802987 #49] DEBUG -- : 
983Starting test: QA::Runtime::Env.knapsack? returns true if KNAPSACK_REPORT_PATH is defined
984    returns true if KNAPSACK_REPORT_PATH is defined
985  .personal_access_token=
986D, [2021-09-29T19:27:27.805269 #49] DEBUG -- : 
987Starting test: QA::Runtime::Env.personal_access_token= saves the token
988    saves the token
989  .log_destination
990D, [2021-09-29T19:27:27.806195 #49] DEBUG -- : 
991Starting test: QA::Runtime::Env.log_destination returns the path if QA_LOG_PATH is defined
992    returns the path if QA_LOG_PATH is defined
993D, [2021-09-29T19:27:27.808229 #49] DEBUG -- : 
994Starting test: QA::Runtime::Env.log_destination returns $stdout if QA_LOG_PATH is not defined
995    returns $stdout if QA_LOG_PATH is not defined
996  .remote_grid_protocol
997D, [2021-09-29T19:27:27.810539 #49] DEBUG -- : 
998Starting test: QA::Runtime::Env.remote_grid_protocol defaults protocol to http
999    defaults protocol to http
1000QA::Support::Page::Logging
1001D, [2021-09-29T19:27:27.816364 #49] DEBUG -- : 
1002Starting test: QA::Support::Page::Logging logs asset_exists?
1003  logs asset_exists?
1004D, [2021-09-29T19:27:27.818453 #49] DEBUG -- : 
1005Starting test: QA::Support::Page::Logging logs find_element with class
1006  logs find_element with class
1007D, [2021-09-29T19:27:27.820429 #49] DEBUG -- : 
1008Starting test: QA::Support::Page::Logging logs refresh
1009  logs refresh
1010D, [2021-09-29T19:27:27.822299 #49] DEBUG -- : 
1011Starting test: QA::Support::Page::Logging logs has_text?
1012  logs has_text?
1013D, [2021-09-29T19:27:27.824274 #49] DEBUG -- : 
1014Starting test: QA::Support::Page::Logging logs has_no_element?
1015  logs has_no_element?
1016D, [2021-09-29T19:27:27.826166 #49] DEBUG -- : 
1017Starting test: QA::Support::Page::Logging logs find_element with text
1018  logs find_element with text
1019D, [2021-09-29T19:27:27.828337 #49] DEBUG -- : 
1020Starting test: QA::Support::Page::Logging logs fill_element
1021  logs fill_element
1022D, [2021-09-29T19:27:27.829992 #49] DEBUG -- : 
1023Starting test: QA::Support::Page::Logging logs click_element
1024  logs click_element
1025D, [2021-09-29T19:27:27.831705 #49] DEBUG -- : 
1026Starting test: QA::Support::Page::Logging logs find_element with wait
1027  logs find_element with wait
1028D, [2021-09-29T19:27:27.833537 #49] DEBUG -- : 
1029Starting test: QA::Support::Page::Logging logs has_element?
1030  logs has_element?
1031D, [2021-09-29T19:27:27.835226 #49] DEBUG -- : 
1032Starting test: QA::Support::Page::Logging logs within_element
1033  logs within_element
1034D, [2021-09-29T19:27:27.837646 #49] DEBUG -- : 
1035Starting test: QA::Support::Page::Logging logs has_element? with text
1036  logs has_element? with text
1037D, [2021-09-29T19:27:27.839354 #49] DEBUG -- : 
1038Starting test: QA::Support::Page::Logging logs finished_loading?
1039  logs finished_loading?
1040D, [2021-09-29T19:27:27.841485 #49] DEBUG -- : 
1041Starting test: QA::Support::Page::Logging logs has_no_text?
1042  logs has_no_text?
1043D, [2021-09-29T19:27:27.843509 #49] DEBUG -- : 
1044Starting test: QA::Support::Page::Logging logs has_no_element? with text
1045  logs has_no_element? with text
1046D, [2021-09-29T19:27:27.845431 #49] DEBUG -- : 
1047Starting test: QA::Support::Page::Logging logs find_element
1048  logs find_element
1049D, [2021-09-29T19:27:27.847852 #49] DEBUG -- : 
1050Starting test: QA::Support::Page::Logging logs scroll_to
1051  logs scroll_to
1052  all_elements
1053D, [2021-09-29T19:27:27.849887 #49] DEBUG -- : 
1054Starting test: QA::Support::Page::Logging all_elements logs the number of elements found
1055    logs the number of elements found
1056D, [2021-09-29T19:27:27.852445 #49] DEBUG -- : 
1057Starting test: QA::Support::Page::Logging all_elements logs 0 if no elements are found
1058    logs 0 if no elements are found
1059QA::Scenario::Actable
1060  .perform
1061D, [2021-09-29T19:27:27.858692 #49] DEBUG -- : 
1062Starting test: QA::Scenario::Actable.perform makes it possible to pass binding
1063    makes it possible to pass binding
1064  .act
1065D, [2021-09-29T19:27:27.859899 #49] DEBUG -- : 
1066Starting test: QA::Scenario::Actable.act returns value from the last method
1067    returns value from the last method
1068D, [2021-09-29T19:27:27.860629 #49] DEBUG -- : 
1069Starting test: QA::Scenario::Actable.act supports passing variables
1070    supports passing variables
1071D, [2021-09-29T19:27:27.861357 #49] DEBUG -- : 
1072Starting test: QA::Scenario::Actable.act provides means to run steps
1073    provides means to run steps
1074QA::Page::Validator
1075  #constants
1076D, [2021-09-29T19:27:27.865873 #49] DEBUG -- : 
1077Starting test: QA::Page::Validator#constants returns all constants that are module children
1078    returns all constants that are module children
1079  when checking validation errors
1080    when there are validation errors
1081      #errors
1082D, [2021-09-29T19:27:27.891038 #49] DEBUG -- : 
1083Starting test: QA::Page::Validator when checking validation errors when there are validation errors #errors returns errors
1084        returns errors
1085      #validate!
1086D, [2021-09-29T19:27:28.021489 #49] DEBUG -- : 
1087Starting test: QA::Page::Validator when checking validation errors when there are validation errors #validate! raises validation error
1088        raises validation error
1089    when there are no validation errors
1090      #validate!
1091D, [2021-09-29T19:27:28.023367 #49] DEBUG -- : 
1092Starting test: QA::Page::Validator when checking validation errors when there are no validation errors #validate! does not raise error
1093        does not raise error
1094      #errors
1095D, [2021-09-29T19:27:28.024769 #49] DEBUG -- : 
1096Starting test: QA::Page::Validator when checking validation errors when there are no validation errors #errors does not return errors
1097        does not return errors
1098  #descendants
1099D, [2021-09-29T19:27:28.026299 #49] DEBUG -- : 
1100Starting test: QA::Page::Validator#descendants does not return modules that aggregate page objects
1101    does not return modules that aggregate page objects
1102D, [2021-09-29T19:27:28.070091 #49] DEBUG -- : 
1103Starting test: QA::Page::Validator#descendants recursively returns all descendants that are page objects
1104    recursively returns all descendants that are page objects
1105QA::Support::SSH
1106  #setup
1107    behaves like providing correct ports
1108      when no port specified in https uri
1109D, [2021-09-29T19:27:28.075009 #49] DEBUG -- : 
1110Starting test: QA::Support::SSH#setup behaves like providing correct ports when no port specified in https uri does not provide port in ssh command
1111        does not provide port in ssh command
1112      when port 80 specified in uri
1113D, [2021-09-29T19:27:28.077393 #49] DEBUG -- : 
1114Starting test: QA::Support::SSH#setup behaves like providing correct ports when port 80 specified in uri does not provide port in ssh command
1115        does not provide port in ssh command
1116      when other port is specified in uri
1117D, [2021-09-29T19:27:28.079454 #49] DEBUG -- : 
1118Starting test: QA::Support::SSH#setup behaves like providing correct ports when other port is specified in uri provides other port in ssh command
1119        provides other port in ssh command
1120      when no port specified in uri
1121D, [2021-09-29T19:27:28.081479 #49] DEBUG -- : 
1122Starting test: QA::Support::SSH#setup behaves like providing correct ports when no port specified in uri does not provide port in ssh command
1123        does not provide port in ssh command
1124  #git_user
1125    when running on a review app in CI
1126D, [2021-09-29T19:27:28.083746 #49] DEBUG -- : 
1127Starting test: QA::Support::SSH#git_user when running on a review app in CI returns git user
1128      returns git user
1129    when running on CI
1130D, [2021-09-29T19:27:28.085300 #49] DEBUG -- : 
1131Starting test: QA::Support::SSH#git_user when running on CI returns git user
1132      returns git user
1133    when running against environment on a port other than 80 or 443
1134D, [2021-09-29T19:27:28.086767 #49] DEBUG -- : 
1135Starting test: QA::Support::SSH#git_user when running against environment on a port other than 80 or 443 returns the local user
1136      returns the local user
1137    when running against environment on port 80 and not on CI (docker)
1138D, [2021-09-29T19:27:28.088383 #49] DEBUG -- : 
1139Starting test: QA::Support::SSH#git_user when running against environment on port 80 and not on CI (docker) returns git user
1140      returns git user
1141  #reset_2fa_codes
1142    behaves like providing correct ports
1143      when no port specified in uri
1144D, [2021-09-29T19:27:28.090353 #49] DEBUG -- : 
1145Starting test: QA::Support::SSH#reset_2fa_codes behaves like providing correct ports when no port specified in uri does not provide port in ssh command
1146        does not provide port in ssh command
1147      when no port specified in https uri
1148D, [2021-09-29T19:27:28.092151 #49] DEBUG -- : 
1149Starting test: QA::Support::SSH#reset_2fa_codes behaves like providing correct ports when no port specified in https uri does not provide port in ssh command
1150        does not provide port in ssh command
1151      when other port is specified in uri
1152D, [2021-09-29T19:27:28.093865 #49] DEBUG -- : 
1153Starting test: QA::Support::SSH#reset_2fa_codes behaves like providing correct ports when other port is specified in uri provides other port in ssh command
1154        provides other port in ssh command
1155      when port 80 specified in uri
1156D, [2021-09-29T19:27:28.095653 #49] DEBUG -- : 
1157Starting test: QA::Support::SSH#reset_2fa_codes behaves like providing correct ports when port 80 specified in uri does not provide port in ssh command
1158        does not provide port in ssh command
1159QA::Runtime::Key::RSA
1160  #public_key
1161D, [2021-09-29T19:27:28.100940 #49] DEBUG -- : 
1162Starting test: QA::Runtime::Key::RSA#public_key generates a public RSA key
1163Executing `["ssh-keygen", "-t", "rsa", "-b", "4096", "-f", "/tmp/d20210929-49-18tj28f/id_rsa", "-N", ""]`
1164Generating public/private rsa key pair.
1165Your identification has been saved in /tmp/d20210929-49-18tj28f/id_rsa.
1166Your public key has been saved in /tmp/d20210929-49-18tj28f/id_rsa.pub.
1167The key fingerprint is:
1168SHA256:cEchtd42I840VMARrj78d+tfUh9V9KnrV7Z3XpzOdHY root@runner-gasd-s1f-project-278964-concurrent-0
1169The key's randomart image is:
1170+---[RSA 4096]----+
1171|        .oB=.  .o|
1172|         +.o    +|
1173|      . . =    .o|
1174|       o = .  . .|
1175|        S = =. ..|
1176|       o + + o.o*|
1177|        + o  ..+E|
1178|         o  o ==B|
1179|          .. ++*=|
1180+----[SHA256]-----+
1181    generates a public RSA key
1182QA::Support::Repeater
1183  .repeat_until
1184D, [2021-09-29T19:27:28.369839 #49] DEBUG -- : 
1185Starting test: QA::Support::Repeater.repeat_until allows logging to be silenced
1186    allows logging to be silenced
1187D, [2021-09-29T19:27:28.370945 #49] DEBUG -- : 
1188Starting test: QA::Support::Repeater.repeat_until logs attempts
1189    logs attempts
1190    when raise_on_failure is false
1191      when retry_on_exception is true
1192        when max duration is not reached
1193D, [2021-09-29T19:27:28.372482 #49] DEBUG -- : 
1194Starting test: QA::Support::Repeater.repeat_until when raise_on_failure is false when retry_on_exception is true when max duration is not reached returns the value from the block
1195          returns the value from the block
1196D, [2021-09-29T19:27:28.373506 #49] DEBUG -- : 
1197Starting test: QA::Support::Repeater.repeat_until when raise_on_failure is false when retry_on_exception is true when max duration is not reached does not raise an exception
1198          does not raise an exception
1199        when both max_attempts and max_duration are provided
1200          when max_attempts is reached first
1201            behaves like repeat until
1202D, [2021-09-29T19:27:28.374851 #49] DEBUG -- : 
1203Starting test: QA::Support::Repeater.repeat_until when raise_on_failure is false when retry_on_exception is true when both max_attempts and max_duration are provided when max_attempts is reached first behaves like repeat until returns when max_attempts is reached
1204D, [2021-09-29T19:27:28.374967 #49] DEBUG -- : Attempt number 1
1205              returns when max_attempts is reached
1206          when max_duration is reached first
1207            behaves like repeat until
1208D, [2021-09-29T19:27:28.376375 #49] DEBUG -- : 
1209Starting test: QA::Support::Repeater.repeat_until when raise_on_failure is false when retry_on_exception is true when both max_attempts and max_duration are provided when max_duration is reached first behaves like repeat until returns when max_duration is reached
1210D, [2021-09-29T19:27:28.376474 #49] DEBUG -- : Attempt number 1
1211              returns when max_duration is reached
1212        when max duration is reached
1213D, [2021-09-29T19:27:28.377549 #49] DEBUG -- : 
1214Starting test: QA::Support::Repeater.repeat_until when raise_on_failure is false when retry_on_exception is true when max duration is reached does not raise an exception
1215          does not raise an exception
1216D, [2021-09-29T19:27:28.378368 #49] DEBUG -- : 
1217Starting test: QA::Support::Repeater.repeat_until when raise_on_failure is false when retry_on_exception is true when max duration is reached returns the value from the block
1218          returns the value from the block
1219      when retry_on_exception is not provided (default: false)
1220        when both max_attempts and max_duration are provided
1221          when max_duration is reached first
1222            behaves like repeat until
1223D, [2021-09-29T19:27:28.379900 #49] DEBUG -- : 
1224Starting test: QA::Support::Repeater.repeat_until when raise_on_failure is false when retry_on_exception is not provided (default: false) when both max_attempts and max_duration are provided when max_duration is reached first behaves like repeat until returns when max_duration is reached
1225D, [2021-09-29T19:27:28.379986 #49] DEBUG -- : Attempt number 1
1226              returns when max_duration is reached
1227          when max_attempts is reached first
1228            behaves like repeat until
1229D, [2021-09-29T19:27:28.381291 #49] DEBUG -- : 
1230Starting test: QA::Support::Repeater.repeat_until when raise_on_failure is false when retry_on_exception is not provided (default: false) when both max_attempts and max_duration are provided when max_attempts is reached first behaves like repeat until returns when max_attempts is reached
1231D, [2021-09-29T19:27:28.381387 #49] DEBUG -- : Attempt number 1
1232              returns when max_attempts is reached
1233        when max duration is reached
1234D, [2021-09-29T19:27:28.382513 #49] DEBUG -- : 
1235Starting test: QA::Support::Repeater.repeat_until when raise_on_failure is false when retry_on_exception is not provided (default: false) when max duration is reached returns the value from the block
1236          returns the value from the block
1237D, [2021-09-29T19:27:28.383321 #49] DEBUG -- : 
1238Starting test: QA::Support::Repeater.repeat_until when raise_on_failure is false when retry_on_exception is not provided (default: false) when max duration is reached does not raise an exception
1239          does not raise an exception
1240        when max duration is not reached
1241D, [2021-09-29T19:27:28.384332 #49] DEBUG -- : 
1242Starting test: QA::Support::Repeater.repeat_until when raise_on_failure is false when retry_on_exception is not provided (default: false) when max duration is not reached raises an exception
1243          raises an exception
1244D, [2021-09-29T19:27:28.385301 #49] DEBUG -- : 
1245Starting test: QA::Support::Repeater.repeat_until when raise_on_failure is false when retry_on_exception is not provided (default: false) when max duration is not reached returns the value from the block
1246          returns the value from the block
1247    when raise_on_failure is not provided (default: true)
1248      when retry_on_exception is not provided (default: false)
1249        when both max_attempts and max_duration are provided
1250          when max_attempts is reached first
1251D, [2021-09-29T19:27:28.386770 #49] DEBUG -- : 
1252Starting test: QA::Support::Repeater.repeat_until when raise_on_failure is not provided (default: true) when retry_on_exception is not provided (default: false) when both max_attempts and max_duration are provided when max_attempts is reached first raises an exception
1253D, [2021-09-29T19:27:28.386917 #49] DEBUG -- : Attempt number 1
1254            raises an exception
1255          when max_duration is reached first
1256D, [2021-09-29T19:27:28.388097 #49] DEBUG -- : 
1257Starting test: QA::Support::Repeater.repeat_until when raise_on_failure is not provided (default: true) when retry_on_exception is not provided (default: false) when both max_attempts and max_duration are provided when max_duration is reached first raises an exception
1258D, [2021-09-29T19:27:28.388216 #49] DEBUG -- : Attempt number 1
1259            raises an exception
1260        when max_attempts is provided
1261          when max_attempts is not reached
1262D, [2021-09-29T19:27:28.389492 #49] DEBUG -- : 
1263Starting test: QA::Support::Repeater.repeat_until when raise_on_failure is not provided (default: true) when retry_on_exception is not provided (default: false) when max_attempts is provided when max_attempts is not reached returns value from block
1264D, [2021-09-29T19:27:28.389615 #49] DEBUG -- : Attempt number 1
1265            returns value from block
1266          when max_attempts is reached
1267D, [2021-09-29T19:27:28.390643 #49] DEBUG -- : 
1268Starting test: QA::Support::Repeater.repeat_until when raise_on_failure is not provided (default: true) when retry_on_exception is not provided (default: false) when max_attempts is provided when max_attempts is reached ignores duration
1269D, [2021-09-29T19:27:28.390776 #49] DEBUG -- : Attempt number 1
1270D, [2022-09-29T19:27:28.390867 #49] DEBUG -- : Attempt number 2
1271            ignores duration
1272D, [2021-09-29T19:27:28.392259 #49] DEBUG -- : 
1273Starting test: QA::Support::Repeater.repeat_until when raise_on_failure is not provided (default: true) when retry_on_exception is not provided (default: false) when max_attempts is provided when max_attempts is reached raises an exception
1274D, [2021-09-29T19:27:28.397804 #49] DEBUG -- : Attempt number 1
1275            raises an exception
1276        when max_duration is provided
1277          when max duration is reached
1278D, [2021-09-29T19:27:28.399475 #49] DEBUG -- : 
1279Starting test: QA::Support::Repeater.repeat_until when raise_on_failure is not provided (default: true) when retry_on_exception is not provided (default: false) when max_duration is provided when max duration is reached ignores attempts
1280            ignores attempts
1281D, [2021-09-29T19:27:28.400344 #49] DEBUG -- : 
1282Starting test: QA::Support::Repeater.repeat_until when raise_on_failure is not provided (default: true) when retry_on_exception is not provided (default: false) when max_duration is provided when max duration is reached raises an exception
1283            raises an exception
1284          when max duration is not reached
1285D, [2021-09-29T19:27:28.401370 #49] DEBUG -- : 
1286Starting test: QA::Support::Repeater.repeat_until when raise_on_failure is not provided (default: true) when retry_on_exception is not provided (default: false) when max_duration is provided when max duration is not reached returns value from block
1287            returns value from block
1288      when retry_on_exception is true
1289        when max duration is reached
1290D, [2021-09-29T19:27:28.402606 #49] DEBUG -- : 
1291Starting test: QA::Support::Repeater.repeat_until when raise_on_failure is not provided (default: true) when retry_on_exception is true when max duration is reached does not raise an exception until max_duration is reached
1292          does not raise an exception until max_duration is reached
1293D, [2021-09-29T19:27:28.403680 #49] DEBUG -- : 
1294Starting test: QA::Support::Repeater.repeat_until when raise_on_failure is not provided (default: true) when retry_on_exception is true when max duration is reached raises an exception
1295          raises an exception
1296        when both max_attempts and max_duration are provided
1297          when max_attempts is reached first
1298D, [2021-09-29T19:27:28.404827 #49] DEBUG -- : 
1299Starting test: QA::Support::Repeater.repeat_until when raise_on_failure is not provided (default: true) when retry_on_exception is true when both max_attempts and max_duration are provided when max_attempts is reached first raises an exception
1300D, [2021-09-29T19:27:28.404945 #49] DEBUG -- : Attempt number 1
1301            raises an exception
1302          when max_duration is reached first
1303D, [2021-09-29T19:27:28.405924 #49] DEBUG -- : 
1304Starting test: QA::Support::Repeater.repeat_until when raise_on_failure is not provided (default: true) when retry_on_exception is true when both max_attempts and max_duration are provided when max_duration is reached first raises an exception
1305D, [2021-09-29T19:27:28.406023 #49] DEBUG -- : Attempt number 1
1306            raises an exception
1307        when max duration is not reached
1308D, [2021-09-29T19:27:28.407095 #49] DEBUG -- : 
1309Starting test: QA::Support::Repeater.repeat_until when raise_on_failure is not provided (default: true) when retry_on_exception is true when max duration is not reached returns value from block
1310          returns value from block
1311QA::Runtime::AllureReport
1312  with report generation disabled
1313D, [2021-09-29T19:27:28.411850 #49] DEBUG -- : 
1314Starting test: QA::Runtime::AllureReport with report generation disabled does not perform configuration
1315    does not perform configuration
1316  with report generation enabled
1317D, [2021-09-29T19:27:28.414807 #49] DEBUG -- : 
1318Starting test: QA::Runtime::AllureReport with report generation enabled configures Allure options
1319    configures Allure options
1320D, [2021-09-29T19:27:28.418882 #49] DEBUG -- : 
1321Starting test: QA::Runtime::AllureReport with report generation enabled adds rspec and metadata formatter
1322    adds rspec and metadata formatter
1323D, [2021-09-29T19:27:28.423155 #49] DEBUG -- : 
1324Starting test: QA::Runtime::AllureReport with report generation enabled configures screenshot saving
1325    configures screenshot saving
1326QA::Resource::ApiFabricator
1327  #api_support?
1328    when resource supports fabrication via the API
1329D, [2021-09-29T19:27:28.431038 #49] DEBUG -- : 
1330Starting test: QA::Resource::ApiFabricator#api_support? when resource supports fabrication via the API returns false
1331      returns false
1332    when resource does not support fabrication via the API
1333D, [2021-09-29T19:27:28.432259 #49] DEBUG -- : 
1334Starting test: QA::Resource::ApiFabricator#api_support? when resource does not support fabrication via the API returns false
1335      returns false
1336  #fabricate_via_api!
1337    when resource does not support fabrication via the API
1338D, [2021-09-29T19:27:28.433511 #49] DEBUG -- : 
1339Starting test: QA::Resource::ApiFabricator#fabricate_via_api! when resource does not support fabrication via the API raises a NotImplementedError exception
1340      raises a NotImplementedError exception
1341    when resource supports fabrication via the API
1342      when creating a resource
1343D, [2021-09-29T19:27:28.435073 #49] DEBUG -- : 
1344Starting test: QA::Resource::ApiFabricator#fabricate_via_api! when resource supports fabrication via the API when creating a resource returns the resource URL
1345        returns the resource URL
1346D, [2021-09-29T19:27:28.437000 #49] DEBUG -- : 
1347Starting test: QA::Resource::ApiFabricator#fabricate_via_api! when resource supports fabrication via the API when creating a resource populates api_resource with the resource
1348        populates api_resource with the resource
1349        when the POST fails
1350D, [2021-09-29T19:27:28.438788 #49] DEBUG -- : 
1351Starting test: QA::Resource::ApiFabricator#fabricate_via_api! when resource supports fabrication via the API when creating a resource when the POST fails raises a ResourceFabricationFailedError exception
1352          raises a ResourceFabricationFailedError exception
1353      #transform_api_resource
1354D, [2021-09-29T19:27:28.440813 #49] DEBUG -- : 
1355Starting test: QA::Resource::ApiFabricator#fabricate_via_api! when resource supports fabrication via the API #transform_api_resource transforms the resource
1356        transforms the resource
1357QA::Support::Formatters::TestStatsFormatter
1358  with influxdb variables configured
1359    with staging full run
1360D, [2021-09-29T19:27:28.446742 #49] DEBUG -- : 
1361Starting test: QA::Support::Formatters::TestStatsFormatter with influxdb variables configured with staging full run exports data to influxdb with correct run type
1362I, [2021-09-29T19:27:28.452992 #49]  INFO -- : influxdb exporter: Pushed 1 entries to influxdb
1363      exports data to influxdb with correct run type
1364    with staging sanity no admin
1365D, [2021-09-29T19:27:28.454728 #49] DEBUG -- : 
1366Starting test: QA::Support::Formatters::TestStatsFormatter with influxdb variables configured with staging sanity no admin exports data to influxdb with correct run type
1367I, [2021-09-29T19:27:28.461122 #49]  INFO -- : influxdb exporter: Pushed 1 entries to influxdb
1368      exports data to influxdb with correct run type
1369    with quarantined spec
1370D, [2021-09-29T19:27:28.462904 #49] DEBUG -- : 
1371Starting test: QA::Support::Formatters::TestStatsFormatter with influxdb variables configured with quarantined spec exports data to influxdb with correct quarantine tag
1372I, [2021-09-29T19:27:28.467940 #49]  INFO -- : influxdb exporter: Pushed 1 entries to influxdb
1373      exports data to influxdb with correct quarantine tag
1374    with reliable spec
1375D, [2021-09-29T19:27:28.469783 #49] DEBUG -- : 
1376Starting test: QA::Support::Formatters::TestStatsFormatter with influxdb variables configured with reliable spec exports data to influxdb with correct reliable tag
1377I, [2021-09-29T19:27:28.475398 #49]  INFO -- : influxdb exporter: Pushed 1 entries to influxdb
1378      exports data to influxdb with correct reliable tag
1379  without influxdb variables configured
1380D, [2021-09-29T19:27:28.477243 #49] DEBUG -- : 
1381Starting test: QA::Support::Formatters::TestStatsFormatter without influxdb variables configured skips export without influxdb url
1382W, [2021-09-29T19:27:28.479431 #49]  WARN -- : influxdb exporter: Missing QA_INFLUXDB_URL, skipping metrics export!
1383    skips export without influxdb url
1384D, [2021-09-29T19:27:28.480953 #49] DEBUG -- : 
1385Starting test: QA::Support::Formatters::TestStatsFormatter without influxdb variables configured skips export without influxdb token
1386W, [2021-09-29T19:27:28.482885 #49]  WARN -- : influxdb exporter: Missing QA_INFLUXDB_TOKEN, skipping metrics export!
1387    skips export without influxdb token
1388QA::EE::Runtime::Geo
1389  .max_file_replication_time
1390    when the environment variable is not set
1391D, [2021-09-29T19:27:28.487845 #49] DEBUG -- : 
1392Starting test: QA::EE::Runtime::Geo.max_file_replication_time when the environment variable is not set returns the default
1393      returns the default
1394    when the environment variable is set
1395D, [2021-09-29T19:27:28.488814 #49] DEBUG -- : 
1396Starting test: QA::EE::Runtime::Geo.max_file_replication_time when the environment variable is set returns the environment variable as a float
1397      returns the environment variable as a float
1398  .max_db_replication_time
1399    when the environment variable is set
1400D, [2021-09-29T19:27:28.490256 #49] DEBUG -- : 
1401Starting test: QA::EE::Runtime::Geo.max_db_replication_time when the environment variable is set returns the environment variable as a float
1402      returns the environment variable as a float
1403    when the environment variable is not set
1404D, [2021-09-29T19:27:28.491329 #49] DEBUG -- : 
1405Starting test: QA::EE::Runtime::Geo.max_db_replication_time when the environment variable is not set returns the default
1406      returns the default
1407QA::Scenario::Test::Integration::LDAPNoServer
1408  #perform
1409    behaves like a QA scenario class
1410D, [2021-09-29T19:27:28.495760 #49] DEBUG -- : 
1411Starting test: QA::Scenario::Test::Integration::LDAPNoServer#perform behaves like a QA scenario class sets tags on runner
1412      sets tags on runner
1413D, [2021-09-29T19:27:28.497473 #49] DEBUG -- : 
1414Starting test: QA::Scenario::Test::Integration::LDAPNoServer#perform behaves like a QA scenario class responds to perform
1415      responds to perform
1416D, [2021-09-29T19:27:28.498750 #49] DEBUG -- : 
1417Starting test: QA::Scenario::Test::Integration::LDAPNoServer#perform behaves like a QA scenario class performs before hooks only once
1418      performs before hooks only once
1419D, [2021-09-29T19:27:28.500172 #49] DEBUG -- : 
1420Starting test: QA::Scenario::Test::Integration::LDAPNoServer#perform behaves like a QA scenario class sets an address of the subject
1421      sets an address of the subject
1422      with named command-line options
1423D, [2021-09-29T19:27:28.501870 #49] DEBUG -- : 
1424Starting test: QA::Scenario::Test::Integration::LDAPNoServer#perform behaves like a QA scenario class with named command-line options converts options to attributes
1425        converts options to attributes
1426D, [2021-09-29T19:27:28.503507 #49] DEBUG -- : 
1427Starting test: QA::Scenario::Test::Integration::LDAPNoServer#perform behaves like a QA scenario class with named command-line options raises an error if the option is invalid
1428        raises an error if the option is invalid
1429D, [2021-09-29T19:27:28.505328 #49] DEBUG -- : 
1430Starting test: QA::Scenario::Test::Integration::LDAPNoServer#perform behaves like a QA scenario class with named command-line options passes on options after --
1431        passes on options after --
1432      specifying RSpec options
1433D, [2021-09-29T19:27:28.507216 #49] DEBUG -- : 
1434Starting test: QA::Scenario::Test::Integration::LDAPNoServer#perform behaves like a QA scenario class specifying RSpec options sets options on runner
1435        sets options on runner
1436QA::Specs::ParallelRunner
1437D, [2021-09-29T19:27:28.512279 #49] DEBUG -- : 
1438Starting test: QA::Specs::ParallelRunner passes tags and test paths to parallel_tests and adds a separator
1439  passes tags and test paths to parallel_tests and adds a separator
1440D, [2021-09-29T19:27:28.517945 #49] DEBUG -- : 
1441Starting test: QA::Specs::ParallelRunner passes a given test path to parallel_tests and adds a separator
1442  passes a given test path to parallel_tests and adds a separator
1443D, [2021-09-29T19:27:28.523636 #49] DEBUG -- : 
1444Starting test: QA::Specs::ParallelRunner passes tags and test paths with separators to parallel_tests
1445  passes tags and test paths with separators to parallel_tests
1446D, [2021-09-29T19:27:28.528797 #49] DEBUG -- : 
1447Starting test: QA::Specs::ParallelRunner passes args to parallel_tests
1448  passes args to parallel_tests
1449D, [2021-09-29T19:27:28.537784 #49] DEBUG -- : 
1450Starting test: QA::Specs::ParallelRunner passes supported environment variables
1451  passes supported environment variables
1452QA::Scenario::Test::Integration::Mattermost
1453  #perform
1454    behaves like a QA scenario class
1455D, [2021-09-29T19:27:28.557663 #49] DEBUG -- : 
1456Starting test: QA::Scenario::Test::Integration::Mattermost#perform behaves like a QA scenario class sets an address of the subject
1457      sets an address of the subject
1458D, [2021-09-29T19:27:28.559410 #49] DEBUG -- : 
1459Starting test: QA::Scenario::Test::Integration::Mattermost#perform behaves like a QA scenario class requires a GitHub access token
1460      requires a GitHub access token
1461D, [2021-09-29T19:27:28.560863 #49] DEBUG -- : 
1462Starting test: QA::Scenario::Test::Integration::Mattermost#perform behaves like a QA scenario class responds to perform
1463      responds to perform
1464D, [2021-09-29T19:27:28.562085 #49] DEBUG -- : 
1465Starting test: QA::Scenario::Test::Integration::Mattermost#perform behaves like a QA scenario class sets tags on runner
1466      sets tags on runner
1467D, [2021-09-29T19:27:28.563533 #49] DEBUG -- : 
1468Starting test: QA::Scenario::Test::Integration::Mattermost#perform behaves like a QA scenario class performs before hooks only once
1469      performs before hooks only once
1470      specifying RSpec options
1471D, [2021-09-29T19:27:28.565282 #49] DEBUG -- : 
1472Starting test: QA::Scenario::Test::Integration::Mattermost#perform behaves like a QA scenario class specifying RSpec options sets options on runner
1473        sets options on runner
1474      with named command-line options
1475D, [2021-09-29T19:27:28.566934 #49] DEBUG -- : 
1476Starting test: QA::Scenario::Test::Integration::Mattermost#perform behaves like a QA scenario class with named command-line options converts options to attributes
1477        converts options to attributes
1478D, [2021-09-29T19:27:28.568650 #49] DEBUG -- : 
1479Starting test: QA::Scenario::Test::Integration::Mattermost#perform behaves like a QA scenario class with named command-line options raises an error if the option is invalid
1480        raises an error if the option is invalid
1481D, [2021-09-29T19:27:28.570394 #49] DEBUG -- : 
1482Starting test: QA::Scenario::Test::Integration::Mattermost#perform behaves like a QA scenario class with named command-line options passes on options after --
1483        passes on options after --
1484QA::Service::DockerRun::GitlabRunner
1485D, [2021-09-29T19:27:28.575668 #49] DEBUG -- : 
1486Starting test: QA::Service::DockerRun::GitlabRunner defaults to run untagged
1487  defaults to run untagged
1488  #register!
1489    defaults
1490D, [2021-09-29T19:27:28.576888 #49] DEBUG -- : 
1491Starting test: QA::Service::DockerRun::GitlabRunner#register! defaults has no tags
1492      has no tags
1493D, [2021-09-29T19:27:28.578115 #49] DEBUG -- : 
1494Starting test: QA::Service::DockerRun::GitlabRunner#register! defaults runs non-interactively
1495      runs non-interactively
1496D, [2021-09-29T19:27:28.579097 #49] DEBUG -- : 
1497Starting test: QA::Service::DockerRun::GitlabRunner#register! defaults sets pertinent information
1498      sets pertinent information
1499D, [2021-09-29T19:27:28.580127 #49] DEBUG -- : 
1500Starting test: QA::Service::DockerRun::GitlabRunner#register! defaults runs daemonized
1501      runs daemonized
1502D, [2021-09-29T19:27:28.581090 #49] DEBUG -- : 
1503Starting test: QA::Service::DockerRun::GitlabRunner#register! defaults cleans itself up
1504      cleans itself up
1505D, [2021-09-29T19:27:28.582088 #49] DEBUG -- : 
1506Starting test: QA::Service::DockerRun::GitlabRunner#register! defaults runs untagged
1507      runs untagged
1508    running tagged
1509      when specifying contradicting variables
1510D, [2021-09-29T19:27:28.583370 #49] DEBUG -- : 
1511Starting test: QA::Service::DockerRun::GitlabRunner#register! running tagged when specifying contradicting variables raises an error
1512        raises an error
1513      with only tags set
1514D, [2021-09-29T19:27:28.584455 #49] DEBUG -- : 
1515Starting test: QA::Service::DockerRun::GitlabRunner#register! running tagged with only tags set does not pass --run-untagged
1516        does not pass --run-untagged
1517D, [2021-09-29T19:27:28.585496 #49] DEBUG -- : 
1518Starting test: QA::Service::DockerRun::GitlabRunner#register! running tagged with only tags set passes the tags with comma-separation
1519        passes the tags with comma-separation
1520      with specifying only run_untagged
1521D, [2021-09-29T19:27:28.586655 #49] DEBUG -- : 
1522Starting test: QA::Service::DockerRun::GitlabRunner#register! running tagged with specifying only run_untagged raises an error if tags are not specified
1523        raises an error if tags are not specified
1524    executors
1525D, [2021-09-29T19:27:28.587735 #49] DEBUG -- : 
1526Starting test: QA::Service::DockerRun::GitlabRunner#register! executors defaults to the shell executor
1527      defaults to the shell executor
1528      docker
1529D, [2021-09-29T19:27:28.588874 #49] DEBUG -- : 
1530Starting test: QA::Service::DockerRun::GitlabRunner#register! executors docker mounts the docker socket to the host runner
1531        mounts the docker socket to the host runner
1532D, [2021-09-29T19:27:28.589890 #49] DEBUG -- : 
1533Starting test: QA::Service::DockerRun::GitlabRunner#register! executors docker passes the host network
1534        passes the host network
1535D, [2021-09-29T19:27:28.590853 #49] DEBUG -- : 
1536Starting test: QA::Service::DockerRun::GitlabRunner#register! executors docker runs in privileged mode
1537        runs in privileged mode
1538D, [2021-09-29T19:27:28.591912 #49] DEBUG -- : 
1539Starting test: QA::Service::DockerRun::GitlabRunner#register! executors docker specifies the docker executor
1540        specifies the docker executor
1541D, [2021-09-29T19:27:28.592950 #49] DEBUG -- : 
1542Starting test: QA::Service::DockerRun::GitlabRunner#register! executors docker does not verify TLS
1543        does not verify TLS
1544D, [2021-09-29T19:27:28.593933 #49] DEBUG -- : 
1545Starting test: QA::Service::DockerRun::GitlabRunner#register! executors docker passes privileged mode
1546        passes privileged mode
1547D, [2021-09-29T19:27:28.594825 #49] DEBUG -- : 
1548Starting test: QA::Service::DockerRun::GitlabRunner#register! executors docker has a default image
1549        has a default image
1550    running untagged
1551D, [2021-09-29T19:27:28.596006 #49] DEBUG -- : 
1552Starting test: QA::Service::DockerRun::GitlabRunner#register! running untagged passes --run-untagged=true
1553      passes --run-untagged=true
1554D, [2021-09-29T19:27:28.596901 #49] DEBUG -- : 
1555Starting test: QA::Service::DockerRun::GitlabRunner#register! running untagged does not pass tag list
1556      does not pass tag list
1557  #tags=
1558D, [2021-09-29T19:27:28.597982 #49] DEBUG -- : 
1559Starting test: QA::Service::DockerRun::GitlabRunner#tags= sets the tags
1560    sets the tags
1561D, [2021-09-29T19:27:28.598693 #49] DEBUG -- : 
1562Starting test: QA::Service::DockerRun::GitlabRunner#tags= sets run_untagged
1563    sets run_untagged
1564QA::Runtime::Feature
1565  feature_flag: :a_flag
1566    .enabled?
1567D, [2021-09-29T19:27:28.603254 #49] DEBUG -- : 
1568Starting test: QA::Runtime::Feature feature_flag: :a_flag .enabled? returns a feature flag state
1569      returns a feature flag state
1570      when a project scope is provided
1571        behaves like checks a feature flag
1572          when the flag is enabled for a scope
1573D, [2021-09-29T19:27:28.605118 #49] DEBUG -- : 
1574Starting test: QA::Runtime::Feature feature_flag: :a_flag .enabled? when a project scope is provided behaves like checks a feature flag when the flag is enabled for a scope returns the feature flag state
1575            returns the feature flag state
1576      when a user scope is provided
1577        behaves like checks a feature flag
1578          when the flag is enabled for a scope
1579D, [2021-09-29T19:27:28.606884 #49] DEBUG -- : 
1580Starting test: QA::Runtime::Feature feature_flag: :a_flag .enabled? when a user scope is provided behaves like checks a feature flag when the flag is enabled for a scope returns the feature flag state
1581            returns the feature flag state
1582      when a group scope is provided
1583        behaves like checks a feature flag
1584          when the flag is enabled for a scope
1585D, [2021-09-29T19:27:28.608608 #49] DEBUG -- : 
1586Starting test: QA::Runtime::Feature feature_flag: :a_flag .enabled? when a group scope is provided behaves like checks a feature flag when the flag is enabled for a scope returns the feature flag state
1587            returns the feature flag state
1588      when a feature group scope is provided
1589        behaves like checks a feature flag
1590          when the flag is enabled for a scope
1591D, [2021-09-29T19:27:28.610297 #49] DEBUG -- : 
1592Starting test: QA::Runtime::Feature feature_flag: :a_flag .enabled? when a feature group scope is provided behaves like checks a feature flag when the flag is enabled for a scope returns the feature flag state
1593            returns the feature flag state
1594    .disable
1595D, [2021-09-29T19:27:28.612001 #49] DEBUG -- : 
1596Starting test: QA::Runtime::Feature feature_flag: :a_flag .disable disables a feature flag
1597I, [2021-09-29T19:27:28.612802 #49]  INFO -- : Disabling feature: a_flag
1598D, [2021-09-29T19:27:28.612855 #49] DEBUG -- : with retry_on_exception: max_attempts: 3; sleep_interval: 2
1599D, [2021-09-29T19:27:28.612891 #49] DEBUG -- : Attempt number 1
1600D, [2021-09-29T19:27:28.613157 #49] DEBUG -- : with wait_until: max_duration: 60; reload_page: ; sleep_interval: 1; raise_on_failure: true 
1601D, [2021-09-29T19:27:28.613364 #49] DEBUG -- : ended wait_until
1602I, [2021-09-29T19:27:28.613410 #49]  INFO -- : Successfully disabled and verified feature flag: a_flag
1603D, [2021-09-29T19:27:28.613473 #49] DEBUG -- : ended retry_on_exception
1604      disables a feature flag
1605      when a group scope is provided
1606        behaves like disables a feature flag
1607D, [2021-09-29T19:27:28.614486 #49] DEBUG -- : 
1608Starting test: QA::Runtime::Feature feature_flag: :a_flag .disable when a group scope is provided behaves like disables a feature flag disables a feature flag for a scope
1609D, [2021-09-29T19:27:28.615600 #49] DEBUG -- : with retry_on_exception: max_attempts: 3; sleep_interval: 2
1610D, [2021-09-29T19:27:28.615642 #49] DEBUG -- : Attempt number 1
1611D, [2021-09-29T19:27:28.615825 #49] DEBUG -- : with wait_until: max_duration: 60; reload_page: ; sleep_interval: 1; raise_on_failure: true 
1612D, [2021-09-29T19:27:28.616072 #49] DEBUG -- : ended wait_until
1613D, [2021-09-29T19:27:28.616155 #49] DEBUG -- : ended retry_on_exception
1614          disables a feature flag for a scope
1615      when a project scope is provided
1616        behaves like disables a feature flag
1617D, [2021-09-29T19:27:28.617188 #49] DEBUG -- : 
1618Starting test: QA::Runtime::Feature feature_flag: :a_flag .disable when a project scope is provided behaves like disables a feature flag disables a feature flag for a scope
1619D, [2021-09-29T19:27:28.618278 #49] DEBUG -- : with retry_on_exception: max_attempts: 3; sleep_interval: 2
1620D, [2021-09-29T19:27:28.618323 #49] DEBUG -- : Attempt number 1
1621D, [2021-09-29T19:27:28.618508 #49] DEBUG -- : with wait_until: max_duration: 60; reload_page: ; sleep_interval: 1; raise_on_failure: true 
1622D, [2021-09-29T19:27:28.618830 #49] DEBUG -- : ended wait_until
1623D, [2021-09-29T19:27:28.618923 #49] DEBUG -- : ended retry_on_exception
1624          disables a feature flag for a scope
1625      when a feature group scope is provided
1626        behaves like disables a feature flag
1627D, [2021-09-29T19:27:28.620093 #49] DEBUG -- : 
1628Starting test: QA::Runtime::Feature feature_flag: :a_flag .disable when a feature group scope is provided behaves like disables a feature flag disables a feature flag for a scope
1629D, [2021-09-29T19:27:28.621115 #49] DEBUG -- : with retry_on_exception: max_attempts: 3; sleep_interval: 2
1630D, [2021-09-29T19:27:28.621159 #49] DEBUG -- : Attempt number 1
1631D, [2021-09-29T19:27:28.621330 #49] DEBUG -- : with wait_until: max_duration: 60; reload_page: ; sleep_interval: 1; raise_on_failure: true 
1632D, [2021-09-29T19:27:28.621568 #49] DEBUG -- : ended wait_until
1633D, [2021-09-29T19:27:28.621642 #49] DEBUG -- : ended retry_on_exception
1634          disables a feature flag for a scope
1635      when a user scope is provided
1636        behaves like disables a feature flag
1637D, [2021-09-29T19:27:28.622630 #49] DEBUG -- : 
1638Starting test: QA::Runtime::Feature feature_flag: :a_flag .disable when a user scope is provided behaves like disables a feature flag disables a feature flag for a scope
1639D, [2021-09-29T19:27:28.623757 #49] DEBUG -- : with retry_on_exception: max_attempts: 3; sleep_interval: 2
1640D, [2021-09-29T19:27:28.623812 #49] DEBUG -- : Attempt number 1
1641D, [2021-09-29T19:27:28.623991 #49] DEBUG -- : with wait_until: max_duration: 60; reload_page: ; sleep_interval: 1; raise_on_failure: true 
1642D, [2021-09-29T19:27:28.624251 #49] DEBUG -- : ended wait_until
1643D, [2021-09-29T19:27:28.624373 #49] DEBUG -- : ended retry_on_exception
1644          disables a feature flag for a scope
1645    .enable
1646D, [2021-09-29T19:27:28.625330 #49] DEBUG -- : 
1647Starting test: QA::Runtime::Feature feature_flag: :a_flag .enable enables a feature flag
1648I, [2021-09-29T19:27:28.626201 #49]  INFO -- : Enabling feature: a_flag
1649D, [2021-09-29T19:27:28.626246 #49] DEBUG -- : with retry_on_exception: max_attempts: 3; sleep_interval: 2
1650D, [2021-09-29T19:27:28.626281 #49] DEBUG -- : Attempt number 1
1651D, [2021-09-29T19:27:28.626490 #49] DEBUG -- : with wait_until: max_duration: 60; reload_page: ; sleep_interval: 1; raise_on_failure: true 
1652D, [2021-09-29T19:27:28.626723 #49] DEBUG -- : ended wait_until
1653I, [2021-09-29T19:27:28.626763 #49]  INFO -- : Successfully enabled and verified feature flag: a_flag
1654D, [2021-09-29T19:27:28.626790 #49] DEBUG -- : ended retry_on_exception
1655      enables a feature flag
1656      when a project scope is provided
1657        behaves like enables a feature flag
1658D, [2021-09-29T19:27:28.627909 #49] DEBUG -- : 
1659Starting test: QA::Runtime::Feature feature_flag: :a_flag .enable when a project scope is provided behaves like enables a feature flag enables a feature flag for a scope
1660D, [2021-09-29T19:27:28.628939 #49] DEBUG -- : with retry_on_exception: max_attempts: 3; sleep_interval: 2
1661D, [2021-09-29T19:27:28.628984 #49] DEBUG -- : Attempt number 1
1662D, [2021-09-29T19:27:28.629199 #49] DEBUG -- : with wait_until: max_duration: 60; reload_page: ; sleep_interval: 1; raise_on_failure: true 
1663D, [2021-09-29T19:27:28.629451 #49] DEBUG -- : ended wait_until
1664D, [2021-09-29T19:27:28.629621 #49] DEBUG -- : ended retry_on_exception
1665          enables a feature flag for a scope
1666      when a user scope is provided
1667        behaves like enables a feature flag
1668D, [2021-09-29T19:27:28.630760 #49] DEBUG -- : 
1669Starting test: QA::Runtime::Feature feature_flag: :a_flag .enable when a user scope is provided behaves like enables a feature flag enables a feature flag for a scope
1670D, [2021-09-29T19:27:28.631755 #49] DEBUG -- : with retry_on_exception: max_attempts: 3; sleep_interval: 2
1671D, [2021-09-29T19:27:28.631797 #49] DEBUG -- : Attempt number 1
1672D, [2021-09-29T19:27:28.631959 #49] DEBUG -- : with wait_until: max_duration: 60; reload_page: ; sleep_interval: 1; raise_on_failure: true 
1673D, [2021-09-29T19:27:28.632203 #49] DEBUG -- : ended wait_until
1674D, [2021-09-29T19:27:28.632281 #49] DEBUG -- : ended retry_on_exception
1675          enables a feature flag for a scope
1676      when a group scope is provided
1677        behaves like enables a feature flag
1678D, [2021-09-29T19:27:28.633319 #49] DEBUG -- : 
1679Starting test: QA::Runtime::Feature feature_flag: :a_flag .enable when a group scope is provided behaves like enables a feature flag enables a feature flag for a scope
1680D, [2021-09-29T19:27:28.634399 #49] DEBUG -- : with retry_on_exception: max_attempts: 3; sleep_interval: 2
1681D, [2021-09-29T19:27:28.634442 #49] DEBUG -- : Attempt number 1
1682D, [2021-09-29T19:27:28.634664 #49] DEBUG -- : with wait_until: max_duration: 60; reload_page: ; sleep_interval: 1; raise_on_failure: true 
1683D, [2021-09-29T19:27:28.634869 #49] DEBUG -- : ended wait_until
1684D, [2021-09-29T19:27:28.635000 #49] DEBUG -- : ended retry_on_exception
1685          enables a feature flag for a scope
1686      when a feature group scope is provided
1687        behaves like enables a feature flag
1688D, [2021-09-29T19:27:28.636201 #49] DEBUG -- : 
1689Starting test: QA::Runtime::Feature feature_flag: :a_flag .enable when a feature group scope is provided behaves like enables a feature flag enables a feature flag for a scope
1690D, [2021-09-29T19:27:28.637207 #49] DEBUG -- : with retry_on_exception: max_attempts: 3; sleep_interval: 2
1691D, [2021-09-29T19:27:28.637250 #49] DEBUG -- : Attempt number 1
1692D, [2021-09-29T19:27:28.637412 #49] DEBUG -- : with wait_until: max_duration: 60; reload_page: ; sleep_interval: 1; raise_on_failure: true 
1693D, [2021-09-29T19:27:28.637675 #49] DEBUG -- : ended wait_until
1694D, [2021-09-29T19:27:28.637754 #49] DEBUG -- : ended retry_on_exception
1695          enables a feature flag for a scope
1696  feature_flag: "a_flag"
1697    .enabled?
1698D, [2021-09-29T19:27:28.638959 #49] DEBUG -- : 
1699Starting test: QA::Runtime::Feature feature_flag: "a_flag" .enabled? returns a feature flag state
1700      returns a feature flag state
1701      when a feature group scope is provided
1702        behaves like checks a feature flag
1703          when the flag is enabled for a scope
1704D, [2021-09-29T19:27:28.640729 #49] DEBUG -- : 
1705Starting test: QA::Runtime::Feature feature_flag: "a_flag" .enabled? when a feature group scope is provided behaves like checks a feature flag when the flag is enabled for a scope returns the feature flag state
1706            returns the feature flag state
1707      when a user scope is provided
1708        behaves like checks a feature flag
1709          when the flag is enabled for a scope
1710D, [2021-09-29T19:27:28.642585 #49] DEBUG -- : 
1711Starting test: QA::Runtime::Feature feature_flag: "a_flag" .enabled? when a user scope is provided behaves like checks a feature flag when the flag is enabled for a scope returns the feature flag state
1712            returns the feature flag state
1713      when a group scope is provided
1714        behaves like checks a feature flag
1715          when the flag is enabled for a scope
1716D, [2021-09-29T19:27:28.644351 #49] DEBUG -- : 
1717Starting test: QA::Runtime::Feature feature_flag: "a_flag" .enabled? when a group scope is provided behaves like checks a feature flag when the flag is enabled for a scope returns the feature flag state
1718            returns the feature flag state
1719      when a project scope is provided
1720        behaves like checks a feature flag
1721          when the flag is enabled for a scope
1722D, [2021-09-29T19:27:28.646060 #49] DEBUG -- : 
1723Starting test: QA::Runtime::Feature feature_flag: "a_flag" .enabled? when a project scope is provided behaves like checks a feature flag when the flag is enabled for a scope returns the feature flag state
1724            returns the feature flag state
1725    .enable
1726D, [2021-09-29T19:27:28.647684 #49] DEBUG -- : 
1727Starting test: QA::Runtime::Feature feature_flag: "a_flag" .enable enables a feature flag
1728I, [2021-09-29T19:27:28.648479 #49]  INFO -- : Enabling feature: a_flag
1729D, [2021-09-29T19:27:28.648525 #49] DEBUG -- : with retry_on_exception: max_attempts: 3; sleep_interval: 2
1730D, [2021-09-29T19:27:28.648565 #49] DEBUG -- : Attempt number 1
1731D, [2021-09-29T19:27:28.648766 #49] DEBUG -- : with wait_until: max_duration: 60; reload_page: ; sleep_interval: 1; raise_on_failure: true 
1732D, [2021-09-29T19:27:28.648990 #49] DEBUG -- : ended wait_until
1733I, [2021-09-29T19:27:28.649026 #49]  INFO -- : Successfully enabled and verified feature flag: a_flag
1734D, [2021-09-29T19:27:28.649073 #49] DEBUG -- : ended retry_on_exception
1735      enables a feature flag
1736      when a project scope is provided
1737        behaves like enables a feature flag
1738D, [2021-09-29T19:27:28.650146 #49] DEBUG -- : 
1739Starting test: QA::Runtime::Feature feature_flag: "a_flag" .enable when a project scope is provided behaves like enables a feature flag enables a feature flag for a scope
1740D, [2021-09-29T19:27:28.651296 #49] DEBUG -- : with retry_on_exception: max_attempts: 3; sleep_interval: 2
1741D, [2021-09-29T19:27:28.651342 #49] DEBUG -- : Attempt number 1
1742D, [2021-09-29T19:27:28.651535 #49] DEBUG -- : with wait_until: max_duration: 60; reload_page: ; sleep_interval: 1; raise_on_failure: true 
1743D, [2021-09-29T19:27:28.651785 #49] DEBUG -- : ended wait_until
1744D, [2021-09-29T19:27:28.651895 #49] DEBUG -- : ended retry_on_exception
1745          enables a feature flag for a scope
1746      when a user scope is provided
1747        behaves like enables a feature flag
1748D, [2021-09-29T19:27:28.652992 #49] DEBUG -- : 
1749Starting test: QA::Runtime::Feature feature_flag: "a_flag" .enable when a user scope is provided behaves like enables a feature flag enables a feature flag for a scope
1750D, [2021-09-29T19:27:28.654015 #49] DEBUG -- : with retry_on_exception: max_attempts: 3; sleep_interval: 2
1751D, [2021-09-29T19:27:28.654077 #49] DEBUG -- : Attempt number 1
1752D, [2021-09-29T19:27:28.654266 #49] DEBUG -- : with wait_until: max_duration: 60; reload_page: ; sleep_interval: 1; raise_on_failure: true 
1753D, [2021-09-29T19:27:28.654504 #49] DEBUG -- : ended wait_until
1754D, [2021-09-29T19:27:28.654590 #49] DEBUG -- : ended retry_on_exception
1755          enables a feature flag for a scope
1756      when a group scope is provided
1757        behaves like enables a feature flag
1758D, [2021-09-29T19:27:28.655628 #49] DEBUG -- : 
1759Starting test: QA::Runtime::Feature feature_flag: "a_flag" .enable when a group scope is provided behaves like enables a feature flag enables a feature flag for a scope
1760D, [2021-09-29T19:27:28.656627 #49] DEBUG -- : with retry_on_exception: max_attempts: 3; sleep_interval: 2
1761D, [2021-09-29T19:27:28.656670 #49] DEBUG -- : Attempt number 1
1762D, [2021-09-29T19:27:28.656853 #49] DEBUG -- : with wait_until: max_duration: 60; reload_page: ; sleep_interval: 1; raise_on_failure: true 
1763D, [2021-09-29T19:27:28.657092 #49] DEBUG -- : ended wait_until
1764D, [2021-09-29T19:27:28.657156 #49] DEBUG -- : ended retry_on_exception
1765          enables a feature flag for a scope
1766      when a feature group scope is provided
1767        behaves like enables a feature flag
1768D, [2021-09-29T19:27:28.658498 #49] DEBUG -- : 
1769Starting test: QA::Runtime::Feature feature_flag: "a_flag" .enable when a feature group scope is provided behaves like enables a feature flag enables a feature flag for a scope
1770D, [2021-09-29T19:27:28.659471 #49] DEBUG -- : with retry_on_exception: max_attempts: 3; sleep_interval: 2
1771D, [2021-09-29T19:27:28.659513 #49] DEBUG -- : Attempt number 1
1772D, [2021-09-29T19:27:28.659688 #49] DEBUG -- : with wait_until: max_duration: 60; reload_page: ; sleep_interval: 1; raise_on_failure: true 
1773D, [2021-09-29T19:27:28.659921 #49] DEBUG -- : ended wait_until
1774D, [2021-09-29T19:27:28.660013 #49] DEBUG -- : ended retry_on_exception
1775          enables a feature flag for a scope
1776    .disable
1777D, [2021-09-29T19:27:28.661029 #49] DEBUG -- : 
1778Starting test: QA::Runtime::Feature feature_flag: "a_flag" .disable disables a feature flag
1779I, [2021-09-29T19:27:28.661889 #49]  INFO -- : Disabling feature: a_flag
1780D, [2021-09-29T19:27:28.661935 #49] DEBUG -- : with retry_on_exception: max_attempts: 3; sleep_interval: 2
1781D, [2021-09-29T19:27:28.661963 #49] DEBUG -- : Attempt number 1
1782D, [2021-09-29T19:27:28.662184 #49] DEBUG -- : with wait_until: max_duration: 60; reload_page: ; sleep_interval: 1; raise_on_failure: true 
1783D, [2021-09-29T19:27:28.662412 #49] DEBUG -- : ended wait_until
1784I, [2021-09-29T19:27:28.662478 #49]  INFO -- : Successfully disabled and verified feature flag: a_flag
1785D, [2021-09-29T19:27:28.662512 #49] DEBUG -- : ended retry_on_exception
1786      disables a feature flag
1787      when a feature group scope is provided
1788        behaves like disables a feature flag
1789D, [2021-09-29T19:27:28.663600 #49] DEBUG -- : 
1790Starting test: QA::Runtime::Feature feature_flag: "a_flag" .disable when a feature group scope is provided behaves like disables a feature flag disables a feature flag for a scope
1791D, [2021-09-29T19:27:28.664685 #49] DEBUG -- : with retry_on_exception: max_attempts: 3; sleep_interval: 2
1792D, [2021-09-29T19:27:28.664730 #49] DEBUG -- : Attempt number 1
1793D, [2021-09-29T19:27:28.664981 #49] DEBUG -- : with wait_until: max_duration: 60; reload_page: ; sleep_interval: 1; raise_on_failure: true 
1794D, [2021-09-29T19:27:28.665249 #49] DEBUG -- : ended wait_until
1795D, [2021-09-29T19:27:28.665342 #49] DEBUG -- : ended retry_on_exception
1796          disables a feature flag for a scope
1797      when a user scope is provided
1798        behaves like disables a feature flag
1799D, [2021-09-29T19:27:28.666482 #49] DEBUG -- : 
1800Starting test: QA::Runtime::Feature feature_flag: "a_flag" .disable when a user scope is provided behaves like disables a feature flag disables a feature flag for a scope
1801D, [2021-09-29T19:27:28.667564 #49] DEBUG -- : with retry_on_exception: max_attempts: 3; sleep_interval: 2
1802D, [2021-09-29T19:27:28.667610 #49] DEBUG -- : Attempt number 1
1803D, [2021-09-29T19:27:28.671628 #49] DEBUG -- : with wait_until: max_duration: 60; reload_page: ; sleep_interval: 1; raise_on_failure: true 
1804D, [2021-09-29T19:27:28.671888 #49] DEBUG -- : ended wait_until
1805D, [2021-09-29T19:27:28.671969 #49] DEBUG -- : ended retry_on_exception
1806          disables a feature flag for a scope
1807      when a group scope is provided
1808        behaves like disables a feature flag
1809D, [2021-09-29T19:27:28.673145 #49] DEBUG -- : 
1810Starting test: QA::Runtime::Feature feature_flag: "a_flag" .disable when a group scope is provided behaves like disables a feature flag disables a feature flag for a scope
1811D, [2021-09-29T19:27:28.674204 #49] DEBUG -- : with retry_on_exception: max_attempts: 3; sleep_interval: 2
1812D, [2021-09-29T19:27:28.674251 #49] DEBUG -- : Attempt number 1
1813D, [2021-09-29T19:27:28.674420 #49] DEBUG -- : with wait_until: max_duration: 60; reload_page: ; sleep_interval: 1; raise_on_failure: true 
1814D, [2021-09-29T19:27:28.674628 #49] DEBUG -- : ended wait_until
1815D, [2021-09-29T19:27:28.674753 #49] DEBUG -- : ended retry_on_exception
1816          disables a feature flag for a scope
1817      when a project scope is provided
1818        behaves like disables a feature flag
1819D, [2021-09-29T19:27:28.675862 #49] DEBUG -- : 
1820Starting test: QA::Runtime::Feature feature_flag: "a_flag" .disable when a project scope is provided behaves like disables a feature flag disables a feature flag for a scope
1821D, [2021-09-29T19:27:28.676831 #49] DEBUG -- : with retry_on_exception: max_attempts: 3; sleep_interval: 2
1822D, [2021-09-29T19:27:28.676875 #49] DEBUG -- : Attempt number 1
1823D, [2021-09-29T19:27:28.677034 #49] DEBUG -- : with wait_until: max_duration: 60; reload_page: ; sleep_interval: 1; raise_on_failure: true 
1824D, [2021-09-29T19:27:28.677275 #49] DEBUG -- : ended wait_until
1825D, [2021-09-29T19:27:28.677389 #49] DEBUG -- : ended retry_on_exception
1826          disables a feature flag for a scope
1827QA::Specs::Runner
1828  #perform
1829    when running against a Geo environment
1830D, [2021-09-29T19:27:28.682004 #49] DEBUG -- : 
1831Starting test: QA::Specs::Runner#perform when running against a Geo environment includes the geo tag
1832      includes the geo tag
1833    when SIGNUP_DISABLED is true
1834D, [2021-09-29T19:27:28.683518 #49] DEBUG -- : 
1835Starting test: QA::Specs::Runner#perform when SIGNUP_DISABLED is true includes default args and excludes the skip_signup_disabled tag
1836      includes default args and excludes the skip_signup_disabled tag
1837    testable features
1838      when no features are supported
1839        behaves like one supported feature
1840D, [2021-09-29T19:27:28.685189 #49] DEBUG -- : 
1841Starting test: QA::Specs::Runner#perform testable features when no features are supported behaves like one supported feature includes default args and excludes all unsupported tags
1842          includes default args and excludes all unsupported tags
1843      when only admin features are supported
1844        behaves like one supported feature
1845D, [2021-09-29T19:27:28.686834 #49] DEBUG -- : 
1846Starting test: QA::Specs::Runner#perform testable features when only admin features are supported behaves like one supported feature includes default args and excludes all unsupported tags
1847          includes default args and excludes all unsupported tags
1848      when features are not specified
1849        behaves like excludes orchestrated, transient, and geo
1850D, [2021-09-29T19:27:28.688533 #49] DEBUG -- : 
1851Starting test: QA::Specs::Runner#perform testable features when features are not specified behaves like excludes orchestrated, transient, and geo excludes the orchestrated, transient, and geo tags, and includes default args
1852          excludes the orchestrated, transient, and geo tags, and includes default args
1853      when only git protocol 2 is supported
1854        behaves like one supported feature
1855D, [2021-09-29T19:27:28.689835 #49] DEBUG -- : 
1856Starting test: QA::Specs::Runner#perform testable features when only git protocol 2 is supported behaves like one supported feature includes default args and excludes all unsupported tags
1857          includes default args and excludes all unsupported tags
1858      when all features are supported
1859        behaves like excludes orchestrated, transient, and geo
1860D, [2021-09-29T19:27:28.691663 #49] DEBUG -- : 
1861Starting test: QA::Specs::Runner#perform testable features when all features are supported behaves like excludes orchestrated, transient, and geo excludes the orchestrated, transient, and geo tags, and includes default args
1862          excludes the orchestrated, transient, and geo tags, and includes default args
1863    when running against live environment
1864D, [2021-09-29T19:27:28.693204 #49] DEBUG -- : 
1865Starting test: QA::Specs::Runner#perform when running against live environment includes default args and excludes the skip_live_env tag
1866      includes default args and excludes the skip_live_env tag
1867    when "--tag smoke" is set as options
1868D, [2021-09-29T19:27:28.694491 #49] DEBUG -- : 
1869Starting test: QA::Specs::Runner#perform when "--tag smoke" is set as options focuses on the given tag without excluded tags
1870      focuses on the given tag without excluded tags
1871    when tty is set
1872D, [2021-09-29T19:27:28.695698 #49] DEBUG -- : 
1873Starting test: QA::Specs::Runner#perform when tty is set sets the `--tty` flag
1874      sets the `--tty` flag
1875    when tags are set
1876D, [2021-09-29T19:27:28.697067 #49] DEBUG -- : 
1877Starting test: QA::Specs::Runner#perform when tags are set focuses on the given tags
1878      focuses on the given tags
1879    behaves like excludes orchestrated, transient, and geo
1880D, [2021-09-29T19:27:28.698315 #49] DEBUG -- : 
1881Starting test: QA::Specs::Runner#perform behaves like excludes orchestrated, transient, and geo excludes the orchestrated, transient, and geo tags, and includes default args
1882      excludes the orchestrated, transient, and geo tags, and includes default args
1883    when "qa/specs/features/foo" is set as options
1884D, [2021-09-29T19:27:28.699472 #49] DEBUG -- : 
1885Starting test: QA::Specs::Runner#perform when "qa/specs/features/foo" is set as options passes the given tests path and excludes the orchestrated, transient, and geo tags
1886      passes the given tests path and excludes the orchestrated, transient, and geo tags
1887    when "--tag smoke" and "qa/specs/features/foo" are set as options
1888D, [2021-09-29T19:27:28.700669 #49] DEBUG -- : 
1889Starting test: QA::Specs::Runner#perform when "--tag smoke" and "qa/specs/features/foo" are set as options focuses on the given tag and includes the path without excluding the orchestrated or transient tags
1890      focuses on the given tag and includes the path without excluding the orchestrated or transient tags
1891QA::Runtime::Namespace
1892  .name
1893    when CACHE_NAMESPACE_NAME is not defined
1894D, [2021-09-29T19:27:28.706219 #49] DEBUG -- : 
1895Starting test: QA::Runtime::Namespace.name when CACHE_NAMESPACE_NAME is not defined caches name by default
1896      caches name by default
1897D, [2021-09-29T19:27:28.708569 #49] DEBUG -- : 
1898Starting test: QA::Runtime::Namespace.name when CACHE_NAMESPACE_NAME is not defined does not cache name when reset_cache is true
1899      does not cache name when reset_cache is true
1900    when CACHE_NAMESPACE_NAME is defined
1901D, [2021-09-29T19:27:28.710769 #49] DEBUG -- : 
1902Starting test: QA::Runtime::Namespace.name when CACHE_NAMESPACE_NAME is defined caches name when reset_cache is false
1903      caches name when reset_cache is false
1904D, [2021-09-29T19:27:28.712629 #49] DEBUG -- : 
1905Starting test: QA::Runtime::Namespace.name when CACHE_NAMESPACE_NAME is defined does not cache name when reset_cache is true
1906      does not cache name when reset_cache is true
1907D, [2021-09-29T19:27:28.714538 #49] DEBUG -- : 
1908Starting test: QA::Runtime::Namespace.name when CACHE_NAMESPACE_NAME is defined caches name by default
1909      caches name by default
1910  .path
1911D, [2021-09-29T19:27:28.716647 #49] DEBUG -- : 
1912Starting test: QA::Runtime::Namespace.path is always cached
1913    is always cached
1914QA::Scenario::Test::Sanity::Framework
1915  behaves like a QA scenario class
1916D, [2021-09-29T19:27:28.720888 #49] DEBUG -- : 
1917Starting test: QA::Scenario::Test::Sanity::Framework behaves like a QA scenario class sets tags on runner
1918    sets tags on runner
1919D, [2021-09-29T19:27:28.722750 #49] DEBUG -- : 
1920Starting test: QA::Scenario::Test::Sanity::Framework behaves like a QA scenario class responds to perform
1921    responds to perform
1922D, [2021-09-29T19:27:28.724097 #49] DEBUG -- : 
1923Starting test: QA::Scenario::Test::Sanity::Framework behaves like a QA scenario class sets an address of the subject
1924    sets an address of the subject
1925D, [2021-09-29T19:27:28.725676 #49] DEBUG -- : 
1926Starting test: QA::Scenario::Test::Sanity::Framework behaves like a QA scenario class performs before hooks only once
1927    performs before hooks only once
1928    specifying RSpec options
1929D, [2021-09-29T19:27:28.727352 #49] DEBUG -- : 
1930Starting test: QA::Scenario::Test::Sanity::Framework behaves like a QA scenario class specifying RSpec options sets options on runner
1931      sets options on runner
1932    with named command-line options
1933D, [2021-09-29T19:27:28.729321 #49] DEBUG -- : 
1934Starting test: QA::Scenario::Test::Sanity::Framework behaves like a QA scenario class with named command-line options raises an error if the option is invalid
1935      raises an error if the option is invalid
1936D, [2021-09-29T19:27:28.731397 #49] DEBUG -- : 
1937Starting test: QA::Scenario::Test::Sanity::Framework behaves like a QA scenario class with named command-line options passes on options after --
1938      passes on options after --
1939D, [2021-09-29T19:27:28.733376 #49] DEBUG -- : 
1940Starting test: QA::Scenario::Test::Sanity::Framework behaves like a QA scenario class with named command-line options converts options to attributes
1941      converts options to attributes
1942QA::Resource::User
1943  #name
1944D, [2021-09-29T19:27:28.739183 #49] DEBUG -- : 
1945Starting test: QA::Resource::User#name is possible to set the name
1946    is possible to set the name
1947D, [2021-09-29T19:27:28.740007 #49] DEBUG -- : 
1948Starting test: QA::Resource::User#name retrieves the name from the api_resource if present
1949    retrieves the name from the api_resource if present
1950D, [2021-09-29T19:27:28.740675 #49] DEBUG -- : 
1951Starting test: QA::Resource::User#name defaults to a name based on the username
1952    defaults to a name based on the username
1953  #public_email
1954D, [2021-09-29T19:27:28.741583 #49] DEBUG -- : 
1955Starting test: QA::Resource::User#public_email defaults to QA::Runtime::User.default_email if the public_email from the api_resource is blank
1956    defaults to QA::Runtime::User.default_email if the public_email from the api_resource is blank
1957D, [2021-09-29T19:27:28.742260 #49] DEBUG -- : 
1958Starting test: QA::Resource::User#public_email retrieves the public_email from the api_resource if present
1959    retrieves the public_email from the api_resource if present
1960D, [2021-09-29T19:27:28.742893 #49] DEBUG -- : 
1961Starting test: QA::Resource::User#public_email defaults to QA::Runtime::User.default_email
1962    defaults to QA::Runtime::User.default_email
1963  #email
1964D, [2021-09-29T19:27:28.743675 #49] DEBUG -- : 
1965Starting test: QA::Resource::User#email defaults to the <username>@example.com
1966    defaults to the <username>@example.com
1967D, [2021-09-29T19:27:28.744349 #49] DEBUG -- : 
1968Starting test: QA::Resource::User#email is possible to set the email
1969    is possible to set the email
1970  #password
1971D, [2021-09-29T19:27:28.745195 #49] DEBUG -- : 
1972Starting test: QA::Resource::User#password generates a default password
1973    generates a default password
1974D, [2021-09-29T19:27:28.745802 #49] DEBUG -- : 
1975Starting test: QA::Resource::User#password is possible to set the password
1976    is possible to set the password
1977  #username
1978D, [2021-09-29T19:27:28.746637 #49] DEBUG -- : 
1979Starting test: QA::Resource::User#username generates a default username
1980    generates a default username
1981D, [2021-09-29T19:27:28.747343 #49] DEBUG -- : 
1982Starting test: QA::Resource::User#username is possible to set the username
1983    is possible to set the username
1984  #credentials_given?
1985D, [2021-09-29T19:27:28.748224 #49] DEBUG -- : 
1986Starting test: QA::Resource::User#credentials_given? returns false even after username and email have been called
1987    returns false even after username and email have been called
1988D, [2021-09-29T19:27:28.748911 #49] DEBUG -- : 
1989Starting test: QA::Resource::User#credentials_given? returns false if only the password has been overridden
1990    returns false if only the password has been overridden
1991D, [2021-09-29T19:27:28.749618 #49] DEBUG -- : 
1992Starting test: QA::Resource::User#credentials_given? returns false when username and email have not been overridden
1993    returns false when username and email have not been overridden
1994D, [2021-09-29T19:27:28.750276 #49] DEBUG -- : 
1995Starting test: QA::Resource::User#credentials_given? returns false if only the username has been overridden
1996    returns false if only the username has been overridden
1997D, [2021-09-29T19:27:28.750907 #49] DEBUG -- : 
1998Starting test: QA::Resource::User#credentials_given? returns true if both the username and password have been overridden
1999    returns true if both the username and password have been overridden
2000QA::Resource::Repository::Push
2001  .files=
2002D, [2021-09-29T19:27:28.755242 #49] DEBUG -- : 
2003Starting test: QA::Resource::Repository::Push.files= raises an error if files is an empty array
2004    raises an error if files is an empty array
2005D, [2021-09-29T19:27:28.756129 #49] DEBUG -- : 
2006Starting test: QA::Resource::Repository::Push.files= raises an error if files is not an array
2007    raises an error if files is not an array
2008D, [2021-09-29T19:27:28.756823 #49] DEBUG -- : 
2009Starting test: QA::Resource::Repository::Push.files= does not raise if files is an array of hashes with :name and :content keys
2010    does not raise if files is an array of hashes with :name and :content keys
2011D, [2021-09-29T19:27:28.757508 #49] DEBUG -- : 
2012Starting test: QA::Resource::Repository::Push.files= raises an error if files is not an array of hashes with :name and :content keys
2013    raises an error if files is not an array of hashes with :name and :content keys
2014QA::Git::Repository
2015  with specific credentials
2016    before setting credentials
2017D, [2021-09-29T19:27:28.762675 #49] DEBUG -- : 
2018Starting test: QA::Git::Repository with specific credentials before setting credentials does not add credentials to .netrc
2019      does not add credentials to .netrc
2020    #password=
2021D, [2021-09-29T19:27:28.766164 #49] DEBUG -- : 
2022Starting test: QA::Git::Repository with specific credentials #password= adds credentials to .netrc
2023      adds credentials to .netrc
2024D, [2021-09-29T19:27:28.769452 #49] DEBUG -- : 
2025Starting test: QA::Git::Repository with specific credentials #password= raises an error if no username was given
2026      raises an error if no username was given
2027D, [2021-09-29T19:27:28.772507 #49] DEBUG -- : 
2028Starting test: QA::Git::Repository with specific credentials #password= adds credentials with special characters
2029      adds credentials with special characters
2030  with default credentials
2031    #clone
2032      when opts is given
2033        behaves like command with retries
2034          when command is successful
2035D, [2021-09-29T19:27:28.776718 #49] DEBUG -- : 
2036Starting test: QA::Git::Repository with default credentials #clone when opts is given behaves like command with retries when command is successful returns the #run command Result output
2037            returns the #run command Result output
2038          when command is not successful the first time
2039            and retried command is successful
2040D, [2021-09-29T19:27:28.781134 #49] DEBUG -- : 
2041Starting test: QA::Git::Repository with default credentials #clone when opts is given behaves like command with retries when command is not successful the first time and retried command is successful retries the command twice and returns the successful #run command Result output
2042D, [2021-09-29T19:27:28.783672 #49] DEBUG -- : Attempt number 1
2043D, [2021-09-29T19:27:28.783738 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-6s9g0l], command=[HOME="temp" git clone --depth 1 http://root@foo/bar.git ./ 2>&1]
2044D, [2021-09-29T19:27:28.783857 #49] DEBUG -- : Git: output=[], exitstatus=[1]
2045D, [2021-09-29T19:27:28.783921 #49] DEBUG -- : Attempt number 2
2046D, [2021-09-29T19:27:28.783966 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-6s9g0l], command=[HOME="temp" git clone --depth 1 http://root@foo/bar.git ./ 2>&1]
2047D, [2021-09-29T19:27:28.784062 #49] DEBUG -- : Git: output=[], exitstatus=[1]
2048D, [2021-09-29T19:27:28.784113 #49] DEBUG -- : Attempt number 3
2049D, [2021-09-29T19:27:28.784138 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-6s9g0l], command=[HOME="temp" git clone --depth 1 http://root@foo/bar.git ./ 2>&1]
2050D, [2021-09-29T19:27:28.784221 #49] DEBUG -- : Git: output=[Command successful], exitstatus=[0]
2051              retries the command twice and returns the successful #run command Result output
2052            and retried command is not successful after 3 attempts
2053D, [2021-09-29T19:27:28.786083 #49] DEBUG -- : 
2054Starting test: QA::Git::Repository with default credentials #clone when opts is given behaves like command with retries when command is not successful the first time and retried command is not successful after 3 attempts raises a CommandError exception
2055D, [2021-09-29T19:27:28.788525 #49] DEBUG -- : Attempt number 1
2056D, [2021-09-29T19:27:28.788580 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-8zlv4u], command=[HOME="temp" git clone --depth 1 http://root@foo/bar.git ./ 2>&1]
2057D, [2021-09-29T19:27:28.788676 #49] DEBUG -- : Git: output=[FAILURE], exitstatus=[42]
2058D, [2021-09-29T19:27:28.788734 #49] DEBUG -- : Attempt number 2
2059D, [2021-09-29T19:27:28.788770 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-8zlv4u], command=[HOME="temp" git clone --depth 1 http://root@foo/bar.git ./ 2>&1]
2060D, [2021-09-29T19:27:28.788854 #49] DEBUG -- : Git: output=[FAILURE], exitstatus=[42]
2061D, [2021-09-29T19:27:28.788920 #49] DEBUG -- : Attempt number 3
2062D, [2021-09-29T19:27:28.788957 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-8zlv4u], command=[HOME="temp" git clone --depth 1 http://root@foo/bar.git ./ 2>&1]
2063D, [2021-09-29T19:27:28.789066 #49] DEBUG -- : Git: output=[FAILURE], exitstatus=[42]
2064              raises a CommandError exception
2065      when no opts is given
2066        behaves like command with retries
2067          when command is successful
2068D, [2021-09-29T19:27:28.791259 #49] DEBUG -- : 
2069Starting test: QA::Git::Repository with default credentials #clone when no opts is given behaves like command with retries when command is successful returns the #run command Result output
2070            returns the #run command Result output
2071          when command is not successful the first time
2072            and retried command is not successful after 3 attempts
2073D, [2021-09-29T19:27:28.795363 #49] DEBUG -- : 
2074Starting test: QA::Git::Repository with default credentials #clone when no opts is given behaves like command with retries when command is not successful the first time and retried command is not successful after 3 attempts raises a CommandError exception
2075D, [2021-09-29T19:27:28.797789 #49] DEBUG -- : Attempt number 1
2076D, [2021-09-29T19:27:28.797850 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-ax1zlx], command=[HOME="temp" git clone  http://root@foo/bar.git ./ 2>&1]
2077D, [2021-09-29T19:27:28.797969 #49] DEBUG -- : Git: output=[FAILURE], exitstatus=[42]
2078D, [2021-09-29T19:27:28.798031 #49] DEBUG -- : Attempt number 2
2079D, [2021-09-29T19:27:28.798075 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-ax1zlx], command=[HOME="temp" git clone  http://root@foo/bar.git ./ 2>&1]
2080D, [2021-09-29T19:27:28.798165 #49] DEBUG -- : Git: output=[FAILURE], exitstatus=[42]
2081D, [2021-09-29T19:27:28.798232 #49] DEBUG -- : Attempt number 3
2082D, [2021-09-29T19:27:28.798259 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-ax1zlx], command=[HOME="temp" git clone  http://root@foo/bar.git ./ 2>&1]
2083D, [2021-09-29T19:27:28.798342 #49] DEBUG -- : Git: output=[FAILURE], exitstatus=[42]
2084              raises a CommandError exception
2085            and retried command is successful
2086D, [2021-09-29T19:27:28.800025 #49] DEBUG -- : 
2087Starting test: QA::Git::Repository with default credentials #clone when no opts is given behaves like command with retries when command is not successful the first time and retried command is successful retries the command twice and returns the successful #run command Result output
2088D, [2021-09-29T19:27:28.802356 #49] DEBUG -- : Attempt number 1
2089D, [2021-09-29T19:27:28.802403 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-1ow9t6k], command=[HOME="temp" git clone  http://root@foo/bar.git ./ 2>&1]
2090D, [2021-09-29T19:27:28.802495 #49] DEBUG -- : Git: output=[], exitstatus=[1]
2091D, [2021-09-29T19:27:28.802554 #49] DEBUG -- : Attempt number 2
2092D, [2021-09-29T19:27:28.802593 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-1ow9t6k], command=[HOME="temp" git clone  http://root@foo/bar.git ./ 2>&1]
2093D, [2021-09-29T19:27:28.802719 #49] DEBUG -- : Git: output=[], exitstatus=[1]
2094D, [2021-09-29T19:27:28.802779 #49] DEBUG -- : Attempt number 3
2095D, [2021-09-29T19:27:28.802818 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-1ow9t6k], command=[HOME="temp" git clone  http://root@foo/bar.git ./ 2>&1]
2096D, [2021-09-29T19:27:28.802915 #49] DEBUG -- : Git: output=[Command successful], exitstatus=[0]
2097              retries the command twice and returns the successful #run command Result output
2098    #shallow_clone
2099      behaves like command with retries
2100        when command is not successful the first time
2101          and retried command is not successful after 3 attempts
2102D, [2021-09-29T19:27:28.805001 #49] DEBUG -- : 
2103Starting test: QA::Git::Repository with default credentials #shallow_clone behaves like command with retries when command is not successful the first time and retried command is not successful after 3 attempts raises a CommandError exception
2104D, [2021-09-29T19:27:28.807279 #49] DEBUG -- : Attempt number 1
2105D, [2021-09-29T19:27:28.807324 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-1rqcovs], command=[HOME="temp" git clone --depth 1 http://root@foo/bar.git ./ 2>&1]
2106D, [2021-09-29T19:27:28.807430 #49] DEBUG -- : Git: output=[FAILURE], exitstatus=[42]
2107D, [2021-09-29T19:27:28.807490 #49] DEBUG -- : Attempt number 2
2108D, [2021-09-29T19:27:28.807526 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-1rqcovs], command=[HOME="temp" git clone --depth 1 http://root@foo/bar.git ./ 2>&1]
2109D, [2021-09-29T19:27:28.807605 #49] DEBUG -- : Git: output=[FAILURE], exitstatus=[42]
2110D, [2021-09-29T19:27:28.807660 #49] DEBUG -- : Attempt number 3
2111D, [2021-09-29T19:27:28.807700 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-1rqcovs], command=[HOME="temp" git clone --depth 1 http://root@foo/bar.git ./ 2>&1]
2112D, [2021-09-29T19:27:28.807816 #49] DEBUG -- : Git: output=[FAILURE], exitstatus=[42]
2113            raises a CommandError exception
2114          and retried command is successful
2115D, [2021-09-29T19:27:28.809353 #49] DEBUG -- : 
2116Starting test: QA::Git::Repository with default credentials #shallow_clone behaves like command with retries when command is not successful the first time and retried command is successful retries the command twice and returns the successful #run command Result output
2117D, [2021-09-29T19:27:28.811631 #49] DEBUG -- : Attempt number 1
2118D, [2021-09-29T19:27:28.811678 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-1h0tf89], command=[HOME="temp" git clone --depth 1 http://root@foo/bar.git ./ 2>&1]
2119D, [2021-09-29T19:27:28.811780 #49] DEBUG -- : Git: output=[], exitstatus=[1]
2120D, [2021-09-29T19:27:28.811831 #49] DEBUG -- : Attempt number 2
2121D, [2021-09-29T19:27:28.811868 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-1h0tf89], command=[HOME="temp" git clone --depth 1 http://root@foo/bar.git ./ 2>&1]
2122D, [2021-09-29T19:27:28.811970 #49] DEBUG -- : Git: output=[], exitstatus=[1]
2123D, [2021-09-29T19:27:28.812068 #49] DEBUG -- : Attempt number 3
2124D, [2021-09-29T19:27:28.812132 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-1h0tf89], command=[HOME="temp" git clone --depth 1 http://root@foo/bar.git ./ 2>&1]
2125D, [2021-09-29T19:27:28.812243 #49] DEBUG -- : Git: output=[Command successful], exitstatus=[0]
2126            retries the command twice and returns the successful #run command Result output
2127        when command is successful
2128D, [2021-09-29T19:27:28.813883 #49] DEBUG -- : 
2129Starting test: QA::Git::Repository with default credentials #shallow_clone behaves like command with retries when command is successful returns the #run command Result output
2130          returns the #run command Result output
2131    #delete_tag
2132      behaves like command with retries
2133        when command is not successful the first time
2134          and retried command is successful
2135D, [2021-09-29T19:27:28.818154 #49] DEBUG -- : 
2136Starting test: QA::Git::Repository with default credentials #delete_tag behaves like command with retries when command is not successful the first time and retried command is successful retries the command twice and returns the successful #run command Result output
2137D, [2021-09-29T19:27:28.820487 #49] DEBUG -- : Attempt number 1
2138D, [2021-09-29T19:27:28.820538 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-qsis3o], command=[HOME="temp" git push origin --delete v1.0 2>&1]
2139D, [2021-09-29T19:27:28.820642 #49] DEBUG -- : Git: output=[], exitstatus=[1]
2140D, [2021-09-29T19:27:28.820700 #49] DEBUG -- : Attempt number 2
2141D, [2021-09-29T19:27:28.820739 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-qsis3o], command=[HOME="temp" git push origin --delete v1.0 2>&1]
2142D, [2021-09-29T19:27:28.820845 #49] DEBUG -- : Git: output=[], exitstatus=[1]
2143D, [2021-09-29T19:27:28.820904 #49] DEBUG -- : Attempt number 3
2144D, [2021-09-29T19:27:28.820952 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-qsis3o], command=[HOME="temp" git push origin --delete v1.0 2>&1]
2145D, [2021-09-29T19:27:28.821097 #49] DEBUG -- : Git: output=[Command successful], exitstatus=[0]
2146            retries the command twice and returns the successful #run command Result output
2147          and retried command is not successful after 3 attempts
2148D, [2021-09-29T19:27:28.822654 #49] DEBUG -- : 
2149Starting test: QA::Git::Repository with default credentials #delete_tag behaves like command with retries when command is not successful the first time and retried command is not successful after 3 attempts raises a CommandError exception
2150D, [2021-09-29T19:27:28.824997 #49] DEBUG -- : Attempt number 1
2151D, [2021-09-29T19:27:28.825072 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-1wca89p], command=[HOME="temp" git push origin --delete v1.0 2>&1]
2152D, [2021-09-29T19:27:28.825164 #49] DEBUG -- : Git: output=[FAILURE], exitstatus=[42]
2153D, [2021-09-29T19:27:28.825241 #49] DEBUG -- : Attempt number 2
2154D, [2021-09-29T19:27:28.825280 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-1wca89p], command=[HOME="temp" git push origin --delete v1.0 2>&1]
2155D, [2021-09-29T19:27:28.825381 #49] DEBUG -- : Git: output=[FAILURE], exitstatus=[42]
2156D, [2021-09-29T19:27:28.825436 #49] DEBUG -- : Attempt number 3
2157D, [2021-09-29T19:27:28.825472 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-1wca89p], command=[HOME="temp" git push origin --delete v1.0 2>&1]
2158D, [2021-09-29T19:27:28.825581 #49] DEBUG -- : Git: output=[FAILURE], exitstatus=[42]
2159            raises a CommandError exception
2160        when command is successful
2161D, [2021-09-29T19:27:28.827265 #49] DEBUG -- : 
2162Starting test: QA::Git::Repository with default credentials #delete_tag behaves like command with retries when command is successful returns the #run command Result output
2163          returns the #run command Result output
2164    #fetch_supported_git_protocol
2165D, [2021-09-29T19:27:28.831028 #49] DEBUG -- : 
2166Starting test: QA::Git::Repository with default credentials #fetch_supported_git_protocol reports unknown if version is unknown
2167      reports unknown if version is unknown
2168D, [2021-09-29T19:27:28.834359 #49] DEBUG -- : 
2169Starting test: QA::Git::Repository with default credentials #fetch_supported_git_protocol reports the detected version
2170      reports the detected version
2171D, [2021-09-29T19:27:28.837924 #49] DEBUG -- : 
2172Starting test: QA::Git::Repository with default credentials #fetch_supported_git_protocol reports unknown if content does not identify a version
2173      reports unknown if content does not identify a version
2174      behaves like command with retries
2175        when command is not successful the first time
2176          and retried command is not successful after 3 attempts
2177D, [2021-09-29T19:27:28.842249 #49] DEBUG -- : 
2178Starting test: QA::Git::Repository with default credentials #fetch_supported_git_protocol behaves like command with retries when command is not successful the first time and retried command is not successful after 3 attempts raises a CommandError exception
2179D, [2021-09-29T19:27:28.844814 #49] DEBUG -- : Attempt number 1
2180D, [2021-09-29T19:27:28.844877 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-y9vxm1], command=[HOME="temp" GIT_TRACE_PACKET=1 git ls-remote http://root@foo/bar.git 2>&1]
2181D, [2021-09-29T19:27:28.844976 #49] DEBUG -- : Git: output=[FAILURE], exitstatus=[42]
2182D, [2021-09-29T19:27:28.845038 #49] DEBUG -- : Attempt number 2
2183D, [2021-09-29T19:27:28.845090 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-y9vxm1], command=[HOME="temp" GIT_TRACE_PACKET=1 git ls-remote http://root@foo/bar.git 2>&1]
2184D, [2021-09-29T19:27:28.845183 #49] DEBUG -- : Git: output=[FAILURE], exitstatus=[42]
2185D, [2021-09-29T19:27:28.845235 #49] DEBUG -- : Attempt number 3
2186D, [2021-09-29T19:27:28.845258 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-y9vxm1], command=[HOME="temp" GIT_TRACE_PACKET=1 git ls-remote http://root@foo/bar.git 2>&1]
2187D, [2021-09-29T19:27:28.845343 #49] DEBUG -- : Git: output=[FAILURE], exitstatus=[42]
2188            raises a CommandError exception
2189          and retried command is successful
2190D, [2021-09-29T19:27:28.847301 #49] DEBUG -- : 
2191Starting test: QA::Git::Repository with default credentials #fetch_supported_git_protocol behaves like command with retries when command is not successful the first time and retried command is successful retries the command twice and returns the successful #run command Result output
2192D, [2021-09-29T19:27:28.850128 #49] DEBUG -- : Attempt number 1
2193D, [2021-09-29T19:27:28.850188 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-ei6miq], command=[HOME="temp" GIT_TRACE_PACKET=1 git ls-remote http://root@foo/bar.git 2>&1]
2194D, [2021-09-29T19:27:28.850292 #49] DEBUG -- : Git: output=[], exitstatus=[1]
2195D, [2021-09-29T19:27:28.850351 #49] DEBUG -- : Attempt number 2
2196D, [2021-09-29T19:27:28.850401 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-ei6miq], command=[HOME="temp" GIT_TRACE_PACKET=1 git ls-remote http://root@foo/bar.git 2>&1]
2197D, [2021-09-29T19:27:28.850489 #49] DEBUG -- : Git: output=[], exitstatus=[1]
2198D, [2021-09-29T19:27:28.850546 #49] DEBUG -- : Attempt number 3
2199D, [2021-09-29T19:27:28.850583 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-ei6miq], command=[HOME="temp" GIT_TRACE_PACKET=1 git ls-remote http://root@foo/bar.git 2>&1]
2200D, [2021-09-29T19:27:28.850693 #49] DEBUG -- : Git: output=[packet: git< version 2], exitstatus=[0]
2201            retries the command twice and returns the successful #run command Result output
2202        when command is successful
2203D, [2021-09-29T19:27:28.852760 #49] DEBUG -- : 
2204Starting test: QA::Git::Repository with default credentials #fetch_supported_git_protocol behaves like command with retries when command is successful returns the #run command Result output
2205          returns the #run command Result output
2206    #use_default_credentials
2207D, [2021-09-29T19:27:28.857142 #49] DEBUG -- : 
2208Starting test: QA::Git::Repository with default credentials #use_default_credentials adds credentials to .netrc
2209      adds credentials to .netrc
2210    #git_protocol=
2211D, [2021-09-29T19:27:28.861363 #49] DEBUG -- : 
2212Starting test: QA::Git::Repository with default credentials #git_protocol= configures git to use protocol version 1
2213      configures git to use protocol version 1
2214D, [2021-09-29T19:27:28.869851 #49] DEBUG -- : 
2215Starting test: QA::Git::Repository with default credentials #git_protocol= configures git to use protocol version 2
2216      configures git to use protocol version 2
2217D, [2021-09-29T19:27:28.873637 #49] DEBUG -- : 
2218Starting test: QA::Git::Repository with default credentials #git_protocol= configures git to use protocol version 0
2219      configures git to use protocol version 0
2220D, [2021-09-29T19:27:28.877556 #49] DEBUG -- : 
2221Starting test: QA::Git::Repository with default credentials #git_protocol= raises an error if the version is unsupported
2222      raises an error if the version is unsupported
2223    #push_changes
2224      with push options
2225        when set to remove source branch
2226          behaves like command with retries
2227            when command is successful
2228D, [2021-09-29T19:27:28.882169 #49] DEBUG -- : 
2229Starting test: QA::Git::Repository with default credentials #push_changes with push options when set to remove source branch behaves like command with retries when command is successful returns the #run command Result output
2230              returns the #run command Result output
2231            when command is not successful the first time
2232              and retried command is successful
2233D, [2021-09-29T19:27:28.886715 #49] DEBUG -- : 
2234Starting test: QA::Git::Repository with default credentials #push_changes with push options when set to remove source branch behaves like command with retries when command is not successful the first time and retried command is successful retries the command twice and returns the successful #run command Result output
2235D, [2021-09-29T19:27:28.889247 #49] DEBUG -- : Attempt number 1
2236D, [2021-09-29T19:27:28.889307 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-1ojsj31], command=[HOME="temp" git push -o merge_request.remove_source_branch http://root@foo/bar.git main 2>&1]
2237D, [2021-09-29T19:27:28.889424 #49] DEBUG -- : Git: output=[], exitstatus=[1]
2238D, [2021-09-29T19:27:28.889485 #49] DEBUG -- : Attempt number 2
2239D, [2021-09-29T19:27:28.889521 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-1ojsj31], command=[HOME="temp" git push -o merge_request.remove_source_branch http://root@foo/bar.git main 2>&1]
2240D, [2021-09-29T19:27:28.889606 #49] DEBUG -- : Git: output=[], exitstatus=[1]
2241D, [2021-09-29T19:27:28.889658 #49] DEBUG -- : Attempt number 3
2242D, [2021-09-29T19:27:28.889698 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-1ojsj31], command=[HOME="temp" git push -o merge_request.remove_source_branch http://root@foo/bar.git main 2>&1]
2243D, [2021-09-29T19:27:28.889786 #49] DEBUG -- : Git: output=[Command successful], exitstatus=[0]
2244                retries the command twice and returns the successful #run command Result output
2245              and retried command is not successful after 3 attempts
2246D, [2021-09-29T19:27:28.891743 #49] DEBUG -- : 
2247Starting test: QA::Git::Repository with default credentials #push_changes with push options when set to remove source branch behaves like command with retries when command is not successful the first time and retried command is not successful after 3 attempts raises a CommandError exception
2248D, [2021-09-29T19:27:28.894335 #49] DEBUG -- : Attempt number 1
2249D, [2021-09-29T19:27:28.894390 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-53fnp1], command=[HOME="temp" git push -o merge_request.remove_source_branch http://root@foo/bar.git main 2>&1]
2250D, [2021-09-29T19:27:28.894487 #49] DEBUG -- : Git: output=[FAILURE], exitstatus=[42]
2251D, [2021-09-29T19:27:28.894538 #49] DEBUG -- : Attempt number 2
2252D, [2021-09-29T19:27:28.894577 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-53fnp1], command=[HOME="temp" git push -o merge_request.remove_source_branch http://root@foo/bar.git main 2>&1]
2253D, [2021-09-29T19:27:28.894672 #49] DEBUG -- : Git: output=[FAILURE], exitstatus=[42]
2254D, [2021-09-29T19:27:28.894729 #49] DEBUG -- : Attempt number 3
2255D, [2021-09-29T19:27:28.894774 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-53fnp1], command=[HOME="temp" git push -o merge_request.remove_source_branch http://root@foo/bar.git main 2>&1]
2256D, [2021-09-29T19:27:28.894888 #49] DEBUG -- : Git: output=[FAILURE], exitstatus=[42]
2257                raises a CommandError exception
2258        when title is given
2259          behaves like command with retries
2260            when command is successful
2261D, [2021-09-29T19:27:28.897231 #49] DEBUG -- : 
2262Starting test: QA::Git::Repository with default credentials #push_changes with push options when title is given behaves like command with retries when command is successful returns the #run command Result output
2263              returns the #run command Result output
2264            when command is not successful the first time
2265              and retried command is successful
2266D, [2021-09-29T19:27:28.901602 #49] DEBUG -- : 
2267Starting test: QA::Git::Repository with default credentials #push_changes with push options when title is given behaves like command with retries when command is not successful the first time and retried command is successful retries the command twice and returns the successful #run command Result output
2268D, [2021-09-29T19:27:28.904176 #49] DEBUG -- : Attempt number 1
2269D, [2021-09-29T19:27:28.904233 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-7c44td], command=[HOME="temp" git push -o merge_request.title="Is A Title" http://root@foo/bar.git main 2>&1]
2270D, [2021-09-29T19:27:28.904316 #49] DEBUG -- : Git: output=[], exitstatus=[1]
2271D, [2021-09-29T19:27:28.904384 #49] DEBUG -- : Attempt number 2
2272D, [2021-09-29T19:27:28.904420 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-7c44td], command=[HOME="temp" git push -o merge_request.title="Is A Title" http://root@foo/bar.git main 2>&1]
2273D, [2021-09-29T19:27:28.904506 #49] DEBUG -- : Git: output=[], exitstatus=[1]
2274D, [2021-09-29T19:27:28.904558 #49] DEBUG -- : Attempt number 3
2275D, [2021-09-29T19:27:28.904593 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-7c44td], command=[HOME="temp" git push -o merge_request.title="Is A Title" http://root@foo/bar.git main 2>&1]
2276D, [2021-09-29T19:27:28.904679 #49] DEBUG -- : Git: output=[Command successful], exitstatus=[0]
2277                retries the command twice and returns the successful #run command Result output
2278              and retried command is not successful after 3 attempts
2279D, [2021-09-29T19:27:28.906586 #49] DEBUG -- : 
2280Starting test: QA::Git::Repository with default credentials #push_changes with push options when title is given behaves like command with retries when command is not successful the first time and retried command is not successful after 3 attempts raises a CommandError exception
2281D, [2021-09-29T19:27:28.909030 #49] DEBUG -- : Attempt number 1
2282D, [2021-09-29T19:27:28.909099 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-5p8k67], command=[HOME="temp" git push -o merge_request.title="Is A Title" http://root@foo/bar.git main 2>&1]
2283D, [2021-09-29T19:27:28.909197 #49] DEBUG -- : Git: output=[FAILURE], exitstatus=[42]
2284D, [2021-09-29T19:27:28.909274 #49] DEBUG -- : Attempt number 2
2285D, [2021-09-29T19:27:28.909317 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-5p8k67], command=[HOME="temp" git push -o merge_request.title="Is A Title" http://root@foo/bar.git main 2>&1]
2286D, [2021-09-29T19:27:28.909406 #49] DEBUG -- : Git: output=[FAILURE], exitstatus=[42]
2287D, [2021-09-29T19:27:28.909452 #49] DEBUG -- : Attempt number 3
2288D, [2021-09-29T19:27:28.909490 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-5p8k67], command=[HOME="temp" git push -o merge_request.title="Is A Title" http://root@foo/bar.git main 2>&1]
2289D, [2021-09-29T19:27:28.909573 #49] DEBUG -- : Git: output=[FAILURE], exitstatus=[42]
2290                raises a CommandError exception
2291        when two labels are given
2292          behaves like command with retries
2293            when command is successful
2294D, [2021-09-29T19:27:28.911835 #49] DEBUG -- : 
2295Starting test: QA::Git::Repository with default credentials #push_changes with push options when two labels are given behaves like command with retries when command is successful returns the #run command Result output
2296              returns the #run command Result output
2297            when command is not successful the first time
2298              and retried command is not successful after 3 attempts
2299D, [2021-09-29T19:27:28.916229 #49] DEBUG -- : 
2300Starting test: QA::Git::Repository with default credentials #push_changes with push options when two labels are given behaves like command with retries when command is not successful the first time and retried command is not successful after 3 attempts raises a CommandError exception
2301D, [2021-09-29T19:27:28.918827 #49] DEBUG -- : Attempt number 1
2302D, [2021-09-29T19:27:28.918889 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-1vmp7o9], command=[HOME="temp" git push -o merge_request.label="is-a-label" -o merge_request.label="is-another-label" http://root@foo/bar.git main 2>&1]
2303D, [2021-09-29T19:27:28.918996 #49] DEBUG -- : Git: output=[FAILURE], exitstatus=[42]
2304D, [2021-09-29T19:27:28.919060 #49] DEBUG -- : Attempt number 2
2305D, [2021-09-29T19:27:28.919097 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-1vmp7o9], command=[HOME="temp" git push -o merge_request.label="is-a-label" -o merge_request.label="is-another-label" http://root@foo/bar.git main 2>&1]
2306D, [2021-09-29T19:27:28.919179 #49] DEBUG -- : Git: output=[FAILURE], exitstatus=[42]
2307D, [2021-09-29T19:27:28.919227 #49] DEBUG -- : Attempt number 3
2308D, [2021-09-29T19:27:28.919262 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-1vmp7o9], command=[HOME="temp" git push -o merge_request.label="is-a-label" -o merge_request.label="is-another-label" http://root@foo/bar.git main 2>&1]
2309D, [2021-09-29T19:27:28.919369 #49] DEBUG -- : Git: output=[FAILURE], exitstatus=[42]
2310                raises a CommandError exception
2311              and retried command is successful
2312D, [2021-09-29T19:27:28.921323 #49] DEBUG -- : 
2313Starting test: QA::Git::Repository with default credentials #push_changes with push options when two labels are given behaves like command with retries when command is not successful the first time and retried command is successful retries the command twice and returns the successful #run command Result output
2314D, [2021-09-29T19:27:28.923929 #49] DEBUG -- : Attempt number 1
2315D, [2021-09-29T19:27:28.924002 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-849te7], command=[HOME="temp" git push -o merge_request.label="is-a-label" -o merge_request.label="is-another-label" http://root@foo/bar.git main 2>&1]
2316D, [2021-09-29T19:27:28.924145 #49] DEBUG -- : Git: output=[], exitstatus=[1]
2317D, [2021-09-29T19:27:28.924207 #49] DEBUG -- : Attempt number 2
2318D, [2021-09-29T19:27:28.924243 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-849te7], command=[HOME="temp" git push -o merge_request.label="is-a-label" -o merge_request.label="is-another-label" http://root@foo/bar.git main 2>&1]
2319D, [2021-09-29T19:27:28.924317 #49] DEBUG -- : Git: output=[], exitstatus=[1]
2320D, [2021-09-29T19:27:28.924375 #49] DEBUG -- : Attempt number 3
2321D, [2021-09-29T19:27:28.924401 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-849te7], command=[HOME="temp" git push -o merge_request.label="is-a-label" -o merge_request.label="is-another-label" http://root@foo/bar.git main 2>&1]
2322D, [2021-09-29T19:27:28.924496 #49] DEBUG -- : Git: output=[Command successful], exitstatus=[0]
2323                retries the command twice and returns the successful #run command Result output
2324        when target branch is given
2325          behaves like command with retries
2326            when command is successful
2327D, [2021-09-29T19:27:28.926759 #49] DEBUG -- : 
2328Starting test: QA::Git::Repository with default credentials #push_changes with push options when target branch is given behaves like command with retries when command is successful returns the #run command Result output
2329              returns the #run command Result output
2330            when command is not successful the first time
2331              and retried command is not successful after 3 attempts
2332D, [2021-09-29T19:27:28.931079 #49] DEBUG -- : 
2333Starting test: QA::Git::Repository with default credentials #push_changes with push options when target branch is given behaves like command with retries when command is not successful the first time and retried command is not successful after 3 attempts raises a CommandError exception
2334D, [2021-09-29T19:27:28.933586 #49] DEBUG -- : Attempt number 1
2335D, [2021-09-29T19:27:28.933651 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-jgoc4q], command=[HOME="temp" git push -o merge_request.target="is-a-target-branch" http://root@foo/bar.git main 2>&1]
2336D, [2021-09-29T19:27:28.933735 #49] DEBUG -- : Git: output=[FAILURE], exitstatus=[42]
2337D, [2021-09-29T19:27:28.933781 #49] DEBUG -- : Attempt number 2
2338D, [2021-09-29T19:27:28.933816 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-jgoc4q], command=[HOME="temp" git push -o merge_request.target="is-a-target-branch" http://root@foo/bar.git main 2>&1]
2339D, [2021-09-29T19:27:28.933911 #49] DEBUG -- : Git: output=[FAILURE], exitstatus=[42]
2340D, [2021-09-29T19:27:28.933972 #49] DEBUG -- : Attempt number 3
2341D, [2021-09-29T19:27:28.933998 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-jgoc4q], command=[HOME="temp" git push -o merge_request.target="is-a-target-branch" http://root@foo/bar.git main 2>&1]
2342D, [2021-09-29T19:27:28.934106 #49] DEBUG -- : Git: output=[FAILURE], exitstatus=[42]
2343                raises a CommandError exception
2344              and retried command is successful
2345D, [2021-09-29T19:27:28.935905 #49] DEBUG -- : 
2346Starting test: QA::Git::Repository with default credentials #push_changes with push options when target branch is given behaves like command with retries when command is not successful the first time and retried command is successful retries the command twice and returns the successful #run command Result output
2347D, [2021-09-29T19:27:28.938555 #49] DEBUG -- : Attempt number 1
2348D, [2021-09-29T19:27:28.938628 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-1ov2b9n], command=[HOME="temp" git push -o merge_request.target="is-a-target-branch" http://root@foo/bar.git main 2>&1]
2349D, [2021-09-29T19:27:28.938713 #49] DEBUG -- : Git: output=[], exitstatus=[1]
2350D, [2021-09-29T19:27:28.938770 #49] DEBUG -- : Attempt number 2
2351D, [2021-09-29T19:27:28.938797 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-1ov2b9n], command=[HOME="temp" git push -o merge_request.target="is-a-target-branch" http://root@foo/bar.git main 2>&1]
2352D, [2021-09-29T19:27:28.938885 #49] DEBUG -- : Git: output=[], exitstatus=[1]
2353D, [2021-09-29T19:27:28.938934 #49] DEBUG -- : Attempt number 3
2354D, [2021-09-29T19:27:28.938988 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-1ov2b9n], command=[HOME="temp" git push -o merge_request.target="is-a-target-branch" http://root@foo/bar.git main 2>&1]
2355D, [2021-09-29T19:27:28.939093 #49] DEBUG -- : Git: output=[Command successful], exitstatus=[0]
2356                retries the command twice and returns the successful #run command Result output
2357        when set to create a merge request
2358          behaves like command with retries
2359            when command is not successful the first time
2360              and retried command is successful
2361D, [2021-09-29T19:27:28.941547 #49] DEBUG -- : 
2362Starting test: QA::Git::Repository with default credentials #push_changes with push options when set to create a merge request behaves like command with retries when command is not successful the first time and retried command is successful retries the command twice and returns the successful #run command Result output
2363D, [2021-09-29T19:27:28.944202 #49] DEBUG -- : Attempt number 1
2364D, [2021-09-29T19:27:28.944262 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-1u9hsh9], command=[HOME="temp" git push -o merge_request.create http://root@foo/bar.git main 2>&1]
2365D, [2021-09-29T19:27:28.944364 #49] DEBUG -- : Git: output=[], exitstatus=[1]
2366D, [2021-09-29T19:27:28.944414 #49] DEBUG -- : Attempt number 2
2367D, [2021-09-29T19:27:28.944451 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-1u9hsh9], command=[HOME="temp" git push -o merge_request.create http://root@foo/bar.git main 2>&1]
2368D, [2021-09-29T19:27:28.944536 #49] DEBUG -- : Git: output=[], exitstatus=[1]
2369D, [2021-09-29T19:27:28.944586 #49] DEBUG -- : Attempt number 3
2370D, [2021-09-29T19:27:28.944613 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-1u9hsh9], command=[HOME="temp" git push -o merge_request.create http://root@foo/bar.git main 2>&1]
2371D, [2021-09-29T19:27:28.944737 #49] DEBUG -- : Git: output=[Command successful], exitstatus=[0]
2372                retries the command twice and returns the successful #run command Result output
2373              and retried command is not successful after 3 attempts
2374D, [2021-09-29T19:27:28.946672 #49] DEBUG -- : 
2375Starting test: QA::Git::Repository with default credentials #push_changes with push options when set to create a merge request behaves like command with retries when command is not successful the first time and retried command is not successful after 3 attempts raises a CommandError exception
2376D, [2021-09-29T19:27:28.949126 #49] DEBUG -- : Attempt number 1
2377D, [2021-09-29T19:27:28.949180 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-1djam76], command=[HOME="temp" git push -o merge_request.create http://root@foo/bar.git main 2>&1]
2378D, [2021-09-29T19:27:28.949275 #49] DEBUG -- : Git: output=[FAILURE], exitstatus=[42]
2379D, [2021-09-29T19:27:28.949334 #49] DEBUG -- : Attempt number 2
2380D, [2021-09-29T19:27:28.949370 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-1djam76], command=[HOME="temp" git push -o merge_request.create http://root@foo/bar.git main 2>&1]
2381D, [2021-09-29T19:27:28.949456 #49] DEBUG -- : Git: output=[FAILURE], exitstatus=[42]
2382D, [2021-09-29T19:27:28.949519 #49] DEBUG -- : Attempt number 3
2383D, [2021-09-29T19:27:28.949551 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-1djam76], command=[HOME="temp" git push -o merge_request.create http://root@foo/bar.git main 2>&1]
2384D, [2021-09-29T19:27:28.949639 #49] DEBUG -- : Git: output=[FAILURE], exitstatus=[42]
2385                raises a CommandError exception
2386            when command is successful
2387D, [2021-09-29T19:27:28.951572 #49] DEBUG -- : 
2388Starting test: QA::Git::Repository with default credentials #push_changes with push options when set to create a merge request behaves like command with retries when command is successful returns the #run command Result output
2389              returns the #run command Result output
2390        when set to merge when pipeline succeeds
2391          behaves like command with retries
2392            when command is not successful the first time
2393              and retried command is successful
2394D, [2021-09-29T19:27:28.956190 #49] DEBUG -- : 
2395Starting test: QA::Git::Repository with default credentials #push_changes with push options when set to merge when pipeline succeeds behaves like command with retries when command is not successful the first time and retried command is successful retries the command twice and returns the successful #run command Result output
2396D, [2021-09-29T19:27:28.958752 #49] DEBUG -- : Attempt number 1
2397D, [2021-09-29T19:27:28.958814 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-1b5a38x], command=[HOME="temp" git push -o merge_request.merge_when_pipeline_succeeds http://root@foo/bar.git main 2>&1]
2398D, [2021-09-29T19:27:28.958897 #49] DEBUG -- : Git: output=[], exitstatus=[1]
2399D, [2021-09-29T19:27:28.958974 #49] DEBUG -- : Attempt number 2
2400D, [2021-09-29T19:27:28.959012 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-1b5a38x], command=[HOME="temp" git push -o merge_request.merge_when_pipeline_succeeds http://root@foo/bar.git main 2>&1]
2401D, [2021-09-29T19:27:28.959109 #49] DEBUG -- : Git: output=[], exitstatus=[1]
2402D, [2021-09-29T19:27:28.959159 #49] DEBUG -- : Attempt number 3
2403D, [2021-09-29T19:27:28.959187 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-1b5a38x], command=[HOME="temp" git push -o merge_request.merge_when_pipeline_succeeds http://root@foo/bar.git main 2>&1]
2404D, [2021-09-29T19:27:28.959291 #49] DEBUG -- : Git: output=[Command successful], exitstatus=[0]
2405                retries the command twice and returns the successful #run command Result output
2406              and retried command is not successful after 3 attempts
2407D, [2021-09-29T19:27:28.961229 #49] DEBUG -- : 
2408Starting test: QA::Git::Repository with default credentials #push_changes with push options when set to merge when pipeline succeeds behaves like command with retries when command is not successful the first time and retried command is not successful after 3 attempts raises a CommandError exception
2409D, [2021-09-29T19:27:28.963719 #49] DEBUG -- : Attempt number 1
2410D, [2021-09-29T19:27:28.963773 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-1xd6oqk], command=[HOME="temp" git push -o merge_request.merge_when_pipeline_succeeds http://root@foo/bar.git main 2>&1]
2411D, [2021-09-29T19:27:28.963857 #49] DEBUG -- : Git: output=[FAILURE], exitstatus=[42]
2412D, [2021-09-29T19:27:28.963914 #49] DEBUG -- : Attempt number 2
2413D, [2021-09-29T19:27:28.963957 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-1xd6oqk], command=[HOME="temp" git push -o merge_request.merge_when_pipeline_succeeds http://root@foo/bar.git main 2>&1]
2414D, [2021-09-29T19:27:28.964097 #49] DEBUG -- : Git: output=[FAILURE], exitstatus=[42]
2415D, [2021-09-29T19:27:28.964148 #49] DEBUG -- : Attempt number 3
2416D, [2021-09-29T19:27:28.964179 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-1xd6oqk], command=[HOME="temp" git push -o merge_request.merge_when_pipeline_succeeds http://root@foo/bar.git main 2>&1]
2417D, [2021-09-29T19:27:28.964276 #49] DEBUG -- : Git: output=[FAILURE], exitstatus=[42]
2418                raises a CommandError exception
2419            when command is successful
2420D, [2021-09-29T19:27:28.966162 #49] DEBUG -- : 
2421Starting test: QA::Git::Repository with default credentials #push_changes with push options when set to merge when pipeline succeeds behaves like command with retries when command is successful returns the #run command Result output
2422              returns the #run command Result output
2423        when description is given
2424          behaves like command with retries
2425            when command is successful
2426D, [2021-09-29T19:27:28.970660 #49] DEBUG -- : 
2427Starting test: QA::Git::Repository with default credentials #push_changes with push options when description is given behaves like command with retries when command is successful returns the #run command Result output
2428              returns the #run command Result output
2429            when command is not successful the first time
2430              and retried command is not successful after 3 attempts
2431D, [2021-09-29T19:27:28.975222 #49] DEBUG -- : 
2432Starting test: QA::Git::Repository with default credentials #push_changes with push options when description is given behaves like command with retries when command is not successful the first time and retried command is not successful after 3 attempts raises a CommandError exception
2433D, [2021-09-29T19:27:28.977861 #49] DEBUG -- : Attempt number 1
2434D, [2021-09-29T19:27:28.977924 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-1nxw7gt], command=[HOME="temp" git push -o merge_request.description="Is A Description" http://root@foo/bar.git main 2>&1]
2435D, [2021-09-29T19:27:28.978034 #49] DEBUG -- : Git: output=[FAILURE], exitstatus=[42]
2436D, [2021-09-29T19:27:28.978112 #49] DEBUG -- : Attempt number 2
2437D, [2021-09-29T19:27:28.978150 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-1nxw7gt], command=[HOME="temp" git push -o merge_request.description="Is A Description" http://root@foo/bar.git main 2>&1]
2438D, [2021-09-29T19:27:28.978250 #49] DEBUG -- : Git: output=[FAILURE], exitstatus=[42]
2439D, [2021-09-29T19:27:28.978292 #49] DEBUG -- : Attempt number 3
2440D, [2021-09-29T19:27:28.978318 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-1nxw7gt], command=[HOME="temp" git push -o merge_request.description="Is A Description" http://root@foo/bar.git main 2>&1]
2441D, [2021-09-29T19:27:28.978398 #49] DEBUG -- : Git: output=[FAILURE], exitstatus=[42]
2442                raises a CommandError exception
2443              and retried command is successful
2444D, [2021-09-29T19:27:28.980371 #49] DEBUG -- : 
2445Starting test: QA::Git::Repository with default credentials #push_changes with push options when description is given behaves like command with retries when command is not successful the first time and retried command is successful retries the command twice and returns the successful #run command Result output
2446D, [2021-09-29T19:27:28.983026 #49] DEBUG -- : Attempt number 1
2447D, [2021-09-29T19:27:28.983105 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-1qvs7fi], command=[HOME="temp" git push -o merge_request.description="Is A Description" http://root@foo/bar.git main 2>&1]
2448D, [2021-09-29T19:27:28.983201 #49] DEBUG -- : Git: output=[], exitstatus=[1]
2449D, [2021-09-29T19:27:28.983262 #49] DEBUG -- : Attempt number 2
2450D, [2021-09-29T19:27:28.983298 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-1qvs7fi], command=[HOME="temp" git push -o merge_request.description="Is A Description" http://root@foo/bar.git main 2>&1]
2451D, [2021-09-29T19:27:28.983387 #49] DEBUG -- : Git: output=[], exitstatus=[1]
2452D, [2021-09-29T19:27:28.983434 #49] DEBUG -- : Attempt number 3
2453D, [2021-09-29T19:27:28.983460 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-1qvs7fi], command=[HOME="temp" git push -o merge_request.description="Is A Description" http://root@foo/bar.git main 2>&1]
2454D, [2021-09-29T19:27:28.983556 #49] DEBUG -- : Git: output=[Command successful], exitstatus=[0]
2455                retries the command twice and returns the successful #run command Result output
2456        when a label is given
2457          behaves like command with retries
2458            when command is not successful the first time
2459              and retried command is not successful after 3 attempts
2460D, [2021-09-29T19:27:28.986083 #49] DEBUG -- : 
2461Starting test: QA::Git::Repository with default credentials #push_changes with push options when a label is given behaves like command with retries when command is not successful the first time and retried command is not successful after 3 attempts raises a CommandError exception
2462D, [2021-09-29T19:27:28.988673 #49] DEBUG -- : Attempt number 1
2463D, [2021-09-29T19:27:28.988734 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-c4asz3], command=[HOME="temp" git push -o merge_request.label="is-a-label" http://root@foo/bar.git main 2>&1]
2464D, [2021-09-29T19:27:28.988834 #49] DEBUG -- : Git: output=[FAILURE], exitstatus=[42]
2465D, [2021-09-29T19:27:28.988896 #49] DEBUG -- : Attempt number 2
2466D, [2021-09-29T19:27:28.988955 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-c4asz3], command=[HOME="temp" git push -o merge_request.label="is-a-label" http://root@foo/bar.git main 2>&1]
2467D, [2021-09-29T19:27:28.989066 #49] DEBUG -- : Git: output=[FAILURE], exitstatus=[42]
2468D, [2021-09-29T19:27:28.989110 #49] DEBUG -- : Attempt number 3
2469D, [2021-09-29T19:27:28.989147 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-c4asz3], command=[HOME="temp" git push -o merge_request.label="is-a-label" http://root@foo/bar.git main 2>&1]
2470D, [2021-09-29T19:27:28.989236 #49] DEBUG -- : Git: output=[FAILURE], exitstatus=[42]
2471                raises a CommandError exception
2472              and retried command is successful
2473D, [2021-09-29T19:27:28.991113 #49] DEBUG -- : 
2474Starting test: QA::Git::Repository with default credentials #push_changes with push options when a label is given behaves like command with retries when command is not successful the first time and retried command is successful retries the command twice and returns the successful #run command Result output
2475D, [2021-09-29T19:27:28.993725 #49] DEBUG -- : Attempt number 1
2476D, [2021-09-29T19:27:28.993784 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-1gqnl75], command=[HOME="temp" git push -o merge_request.label="is-a-label" http://root@foo/bar.git main 2>&1]
2477D, [2021-09-29T19:27:28.993879 #49] DEBUG -- : Git: output=[], exitstatus=[1]
2478D, [2021-09-29T19:27:28.993939 #49] DEBUG -- : Attempt number 2
2479D, [2021-09-29T19:27:28.993985 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-1gqnl75], command=[HOME="temp" git push -o merge_request.label="is-a-label" http://root@foo/bar.git main 2>&1]
2480D, [2021-09-29T19:27:28.994096 #49] DEBUG -- : Git: output=[], exitstatus=[1]
2481D, [2021-09-29T19:27:28.994148 #49] DEBUG -- : Attempt number 3
2482D, [2021-09-29T19:27:28.994179 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-1gqnl75], command=[HOME="temp" git push -o merge_request.label="is-a-label" http://root@foo/bar.git main 2>&1]
2483D, [2021-09-29T19:27:28.994288 #49] DEBUG -- : Git: output=[Command successful], exitstatus=[0]
2484                retries the command twice and returns the successful #run command Result output
2485            when command is successful
2486D, [2021-09-29T19:27:28.996245 #49] DEBUG -- : 
2487Starting test: QA::Git::Repository with default credentials #push_changes with push options when a label is given behaves like command with retries when command is successful returns the #run command Result output
2488              returns the #run command Result output
2489      when branch is given
2490        behaves like command with retries
2491          when command is successful
2492D, [2021-09-29T19:27:29.001374 #49] DEBUG -- : 
2493Starting test: QA::Git::Repository with default credentials #push_changes when branch is given behaves like command with retries when command is successful returns the #run command Result output
2494            returns the #run command Result output
2495          when command is not successful the first time
2496            and retried command is not successful after 3 attempts
2497D, [2021-09-29T19:27:29.005970 #49] DEBUG -- : 
2498Starting test: QA::Git::Repository with default credentials #push_changes when branch is given behaves like command with retries when command is not successful the first time and retried command is not successful after 3 attempts raises a CommandError exception
2499D, [2021-09-29T19:27:29.008429 #49] DEBUG -- : Attempt number 1
2500D, [2021-09-29T19:27:29.008487 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-15ptrv7], command=[HOME="temp" git push http://root@foo/bar.git my-branch 2>&1]
2501D, [2021-09-29T19:27:29.008583 #49] DEBUG -- : Git: output=[FAILURE], exitstatus=[42]
2502D, [2021-09-29T19:27:29.008654 #49] DEBUG -- : Attempt number 2
2503D, [2021-09-29T19:27:29.008681 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-15ptrv7], command=[HOME="temp" git push http://root@foo/bar.git my-branch 2>&1]
2504D, [2021-09-29T19:27:29.008768 #49] DEBUG -- : Git: output=[FAILURE], exitstatus=[42]
2505D, [2021-09-29T19:27:29.008822 #49] DEBUG -- : Attempt number 3
2506D, [2021-09-29T19:27:29.008868 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-15ptrv7], command=[HOME="temp" git push http://root@foo/bar.git my-branch 2>&1]
2507D, [2021-09-29T19:27:29.008982 #49] DEBUG -- : Git: output=[FAILURE], exitstatus=[42]
2508              raises a CommandError exception
2509            and retried command is successful
2510D, [2021-09-29T19:27:29.010786 #49] DEBUG -- : 
2511Starting test: QA::Git::Repository with default credentials #push_changes when branch is given behaves like command with retries when command is not successful the first time and retried command is successful retries the command twice and returns the successful #run command Result output
2512D, [2021-09-29T19:27:29.013290 #49] DEBUG -- : Attempt number 1
2513D, [2021-09-29T19:27:29.013346 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-1ctvm5t], command=[HOME="temp" git push http://root@foo/bar.git my-branch 2>&1]
2514D, [2021-09-29T19:27:29.013455 #49] DEBUG -- : Git: output=[], exitstatus=[1]
2515D, [2021-09-29T19:27:29.013512 #49] DEBUG -- : Attempt number 2
2516D, [2021-09-29T19:27:29.013550 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-1ctvm5t], command=[HOME="temp" git push http://root@foo/bar.git my-branch 2>&1]
2517D, [2021-09-29T19:27:29.013635 #49] DEBUG -- : Git: output=[], exitstatus=[1]
2518D, [2021-09-29T19:27:29.013676 #49] DEBUG -- : Attempt number 3
2519D, [2021-09-29T19:27:29.013711 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-1ctvm5t], command=[HOME="temp" git push http://root@foo/bar.git my-branch 2>&1]
2520D, [2021-09-29T19:27:29.013816 #49] DEBUG -- : Git: output=[Command successful], exitstatus=[0]
2521              retries the command twice and returns the successful #run command Result output
2522      when no branch is given
2523        behaves like command with retries
2524          when command is successful
2525D, [2021-09-29T19:27:29.016132 #49] DEBUG -- : 
2526Starting test: QA::Git::Repository with default credentials #push_changes when no branch is given behaves like command with retries when command is successful returns the #run command Result output
2527            returns the #run command Result output
2528          when command is not successful the first time
2529            and retried command is successful
2530D, [2021-09-29T19:27:29.020430 #49] DEBUG -- : 
2531Starting test: QA::Git::Repository with default credentials #push_changes when no branch is given behaves like command with retries when command is not successful the first time and retried command is successful retries the command twice and returns the successful #run command Result output
2532D, [2021-09-29T19:27:29.023067 #49] DEBUG -- : Attempt number 1
2533D, [2021-09-29T19:27:29.023126 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-7yefo1], command=[HOME="temp" git push http://root@foo/bar.git main 2>&1]
2534D, [2021-09-29T19:27:29.023232 #49] DEBUG -- : Git: output=[], exitstatus=[1]
2535D, [2021-09-29T19:27:29.023292 #49] DEBUG -- : Attempt number 2
2536D, [2021-09-29T19:27:29.023329 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-7yefo1], command=[HOME="temp" git push http://root@foo/bar.git main 2>&1]
2537D, [2021-09-29T19:27:29.023412 #49] DEBUG -- : Git: output=[], exitstatus=[1]
2538D, [2021-09-29T19:27:29.023465 #49] DEBUG -- : Attempt number 3
2539D, [2021-09-29T19:27:29.023495 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-7yefo1], command=[HOME="temp" git push http://root@foo/bar.git main 2>&1]
2540D, [2021-09-29T19:27:29.023601 #49] DEBUG -- : Git: output=[Command successful], exitstatus=[0]
2541              retries the command twice and returns the successful #run command Result output
2542            and retried command is not successful after 3 attempts
2543D, [2021-09-29T19:27:29.025522 #49] DEBUG -- : 
2544Starting test: QA::Git::Repository with default credentials #push_changes when no branch is given behaves like command with retries when command is not successful the first time and retried command is not successful after 3 attempts raises a CommandError exception
2545D, [2021-09-29T19:27:29.028032 #49] DEBUG -- : Attempt number 1
2546D, [2021-09-29T19:27:29.028113 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-1bs9bbv], command=[HOME="temp" git push http://root@foo/bar.git main 2>&1]
2547D, [2021-09-29T19:27:29.028213 #49] DEBUG -- : Git: output=[FAILURE], exitstatus=[42]
2548D, [2021-09-29T19:27:29.028274 #49] DEBUG -- : Attempt number 2
2549D, [2021-09-29T19:27:29.028316 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-1bs9bbv], command=[HOME="temp" git push http://root@foo/bar.git main 2>&1]
2550D, [2021-09-29T19:27:29.028415 #49] DEBUG -- : Git: output=[FAILURE], exitstatus=[42]
2551D, [2021-09-29T19:27:29.028473 #49] DEBUG -- : Attempt number 3
2552D, [2021-09-29T19:27:29.028502 #49] DEBUG -- : Git: pwd=[/tmp/d20210929-49-1bs9bbv], command=[HOME="temp" git push http://root@foo/bar.git main 2>&1]
2553D, [2021-09-29T19:27:29.028605 #49] DEBUG -- : Git: output=[FAILURE], exitstatus=[42]
2554              raises a CommandError exception
2555QA::Scenario::Test::Integration::Github
2556  #perform
2557    behaves like a QA scenario class
2558D, [2021-09-29T19:27:29.034329 #49] DEBUG -- : 
2559Starting test: QA::Scenario::Test::Integration::Github#perform behaves like a QA scenario class requires a GitHub access token
2560      requires a GitHub access token
2561D, [2021-09-29T19:27:29.036362 #49] DEBUG -- : 
2562Starting test: QA::Scenario::Test::Integration::Github#perform behaves like a QA scenario class sets tags on runner
2563      sets tags on runner
2564D, [2021-09-29T19:27:29.038112 #49] DEBUG -- : 
2565Starting test: QA::Scenario::Test::Integration::Github#perform behaves like a QA scenario class responds to perform
2566      responds to perform
2567D, [2021-09-29T19:27:29.039545 #49] DEBUG -- : 
2568Starting test: QA::Scenario::Test::Integration::Github#perform behaves like a QA scenario class sets an address of the subject
2569      sets an address of the subject
2570D, [2021-09-29T19:27:29.041336 #49] DEBUG -- : 
2571Starting test: QA::Scenario::Test::Integration::Github#perform behaves like a QA scenario class performs before hooks only once
2572      performs before hooks only once
2573      specifying RSpec options
2574D, [2021-09-29T19:27:29.043441 #49] DEBUG -- : 
2575Starting test: QA::Scenario::Test::Integration::Github#perform behaves like a QA scenario class specifying RSpec options sets options on runner
2576        sets options on runner
2577      with named command-line options
2578D, [2021-09-29T19:27:29.049870 #49] DEBUG -- : 
2579Starting test: QA::Scenario::Test::Integration::Github#perform behaves like a QA scenario class with named command-line options passes on options after --
2580        passes on options after --
2581D, [2021-09-29T19:27:29.052071 #49] DEBUG -- : 
2582Starting test: QA::Scenario::Test::Integration::Github#perform behaves like a QA scenario class with named command-line options raises an error if the option is invalid
2583        raises an error if the option is invalid
2584D, [2021-09-29T19:27:29.054186 #49] DEBUG -- : 
2585Starting test: QA::Scenario::Test::Integration::Github#perform behaves like a QA scenario class with named command-line options converts options to attributes
2586        converts options to attributes
2587QA::Runtime::API::Client
2588  #personal_access_token
2589    when user is present and QA::Runtime::Env.personal_access_token is present
2590D, [2021-09-29T19:27:29.060184 #49] DEBUG -- : 
2591Starting test: QA::Runtime::API::Client#personal_access_token when user is present and QA::Runtime::Env.personal_access_token is present returns a created token
2592      returns a created token
2593    when user is present and QA::Runtime::Env.personal_access_token is nil
2594D, [2021-09-29T19:27:29.061788 #49] DEBUG -- : 
2595Starting test: QA::Runtime::API::Client#personal_access_token when user is present and QA::Runtime::Env.personal_access_token is nil returns a created token
2596      returns a created token
2597    when user is nil and QA::Runtime::Env.personal_access_token is present
2598D, [2021-09-29T19:27:29.063197 #49] DEBUG -- : 
2599Starting test: QA::Runtime::API::Client#personal_access_token when user is nil and QA::Runtime::Env.personal_access_token is present returns specified token from env
2600      returns specified token from env
2601    when user is nil and QA::Runtime::Env.personal_access_token is nil
2602D, [2021-09-29T19:27:29.064291 #49] DEBUG -- : 
2603Starting test: QA::Runtime::API::Client#personal_access_token when user is nil and QA::Runtime::Env.personal_access_token is nil returns a created token
2604      returns a created token
2605  initialization
2606D, [2021-09-29T19:27:29.065602 #49] DEBUG -- : 
2607Starting test: QA::Runtime::API::Client initialization defaults to :gitlab address
2608    defaults to :gitlab address
2609D, [2021-09-29T19:27:29.066299 #49] DEBUG -- : 
2610Starting test: QA::Runtime::API::Client initialization uses specified address
2611    uses specified address
2612QA::Support::Retrier
2613  .retry_until
2614D, [2021-09-29T19:27:29.070610 #49] DEBUG -- : 
2615Starting test: QA::Support::Retrier.retry_until sets raise_on_failure to true by default
2616D, [2021-09-29T19:27:29.071145 #49] DEBUG -- : with retry_until: max_attempts: 3; reload_page: ; sleep_interval: 0; raise_on_failure: true; retry_on_exception: false
2617D, [2021-09-29T19:27:29.071283 #49] DEBUG -- : ended retry_until
2618    sets raise_on_failure to true by default
2619D, [2021-09-29T19:27:29.072017 #49] DEBUG -- : 
2620Starting test: QA::Support::Retrier.retry_until sets retry_on_exception to false by default
2621D, [2021-09-29T19:27:29.072382 #49] DEBUG -- : with retry_until: max_attempts: 3; reload_page: ; sleep_interval: 0; raise_on_failure: true; retry_on_exception: false
2622D, [2021-09-29T19:27:29.072513 #49] DEBUG -- : ended retry_until
2623    sets retry_on_exception to false by default
2624D, [2021-09-29T19:27:29.073247 #49] DEBUG -- : 
2625Starting test: QA::Support::Retrier.retry_until sets sleep_interval to 0 by default
2626D, [2021-09-29T19:27:29.073603 #49] DEBUG -- : with retry_until: max_attempts: 3; reload_page: ; sleep_interval: 0; raise_on_failure: true; retry_on_exception: false
2627D, [2021-09-29T19:27:29.073725 #49] DEBUG -- : ended retry_until
2628    sets sleep_interval to 0 by default
2629    when the condition is false
2630D, [2021-09-29T19:27:29.074628 #49] DEBUG -- : 
2631Starting test: QA::Support::Retrier.retry_until when the condition is false logs the start
2632      logs the start
2633D, [2021-09-29T19:27:29.075656 #49] DEBUG -- : 
2634Starting test: QA::Support::Retrier.retry_until when the condition is false logs the end
2635      logs the end
2636    when the condition is true
2637D, [2021-09-29T19:27:29.076815 #49] DEBUG -- : 
2638Starting test: QA::Support::Retrier.retry_until when the condition is true logs max attempts (3 by default)
2639      logs max attempts (3 by default)
2640D, [2021-09-29T19:27:29.077732 #49] DEBUG -- : 
2641Starting test: QA::Support::Retrier.retry_until when the condition is true logs max duration
2642      logs max duration
2643D, [2021-09-29T19:27:29.078650 #49] DEBUG -- : 
2644Starting test: QA::Support::Retrier.retry_until when the condition is true logs the end
2645      logs the end
2646    when max_duration and max_attempts are nil
2647D, [2021-09-29T19:27:29.079753 #49] DEBUG -- : 
2648Starting test: QA::Support::Retrier.retry_until when max_duration and max_attempts are nil sets max attempts to 3 by default
2649D, [2021-09-29T19:27:29.080200 #49] DEBUG -- : with retry_until: max_attempts: 3; reload_page: ; sleep_interval: 0; raise_on_failure: true; retry_on_exception: false
2650D, [2021-09-29T19:27:29.080336 #49] DEBUG -- : ended retry_until
2651      sets max attempts to 3 by default
2652  .retry_on_exception
2653D, [2021-09-29T19:27:29.081249 #49] DEBUG -- : 
2654Starting test: QA::Support::Retrier.retry_on_exception sets retry_on_exception to true
2655D, [2021-09-29T19:27:29.081624 #49] DEBUG -- : with retry_on_exception: max_attempts: 3; sleep_interval: 0.5
2656D, [2021-09-29T19:27:29.081748 #49] DEBUG -- : ended retry_on_exception
2657    sets retry_on_exception to true
2658D, [2021-09-29T19:27:29.082427 #49] DEBUG -- : 
2659Starting test: QA::Support::Retrier.retry_on_exception does not repeat if no exception is raised
2660D, [2021-09-29T19:27:29.082516 #49] DEBUG -- : with retry_on_exception: max_attempts: 2; sleep_interval: 0.5
2661D, [2021-09-29T19:27:29.082565 #49] DEBUG -- : Attempt number 1
2662D, [2021-09-29T19:27:29.082587 #49] DEBUG -- : ended retry_on_exception
2663    does not repeat if no exception is raised
2664D, [2021-09-29T19:27:29.083238 #49] DEBUG -- : 
2665Starting test: QA::Support::Retrier.retry_on_exception sets sleep_interval to 0.5 by default
2666D, [2021-09-29T19:27:29.083583 #49] DEBUG -- : with retry_on_exception: max_attempts: 3; sleep_interval: 0.5
2667D, [2021-09-29T19:27:29.083700 #49] DEBUG -- : ended retry_on_exception
2668    sets sleep_interval to 0.5 by default
2669D, [2021-09-29T19:27:29.084376 #49] DEBUG -- : 
2670Starting test: QA::Support::Retrier.retry_on_exception sets max_attempts to 3 by default
2671D, [2021-09-29T19:27:29.084689 #49] DEBUG -- : with retry_on_exception: max_attempts: 3; sleep_interval: 0.5
2672D, [2021-09-29T19:27:29.084794 #49] DEBUG -- : ended retry_on_exception
2673    sets max_attempts to 3 by default
2674    when the condition is true
2675D, [2021-09-29T19:27:29.085676 #49] DEBUG -- : 
2676Starting test: QA::Support::Retrier.retry_on_exception when the condition is true logs the end
2677      logs the end
2678D, [2021-09-29T19:27:29.086750 #49] DEBUG -- : 
2679Starting test: QA::Support::Retrier.retry_on_exception when the condition is true logs max_attempts, reload_page, and sleep_interval parameters
2680      logs max_attempts, reload_page, and sleep_interval parameters
2681    when the condition is false
2682D, [2021-09-29T19:27:29.087956 #49] DEBUG -- : 
2683Starting test: QA::Support::Retrier.retry_on_exception when the condition is false logs the end
2684      logs the end
2685D, [2021-09-29T19:27:29.088989 #49] DEBUG -- : 
2686Starting test: QA::Support::Retrier.retry_on_exception when the condition is false logs the start
2687      logs the start
2688QA::Scenario::Test::Instance::Airgapped
2689  #perform
2690    behaves like a QA scenario class
2691D, [2021-09-29T19:27:29.093913 #49] DEBUG -- : 
2692Starting test: QA::Scenario::Test::Instance::Airgapped#perform behaves like a QA scenario class sets tags on runner
2693      sets tags on runner
2694D, [2021-09-29T19:27:29.095865 #49] DEBUG -- : 
2695Starting test: QA::Scenario::Test::Instance::Airgapped#perform behaves like a QA scenario class sets an address of the subject
2696      sets an address of the subject
2697D, [2021-09-29T19:27:29.097441 #49] DEBUG -- : 
2698Starting test: QA::Scenario::Test::Instance::Airgapped#perform behaves like a QA scenario class responds to perform
2699      responds to perform
2700D, [2021-09-29T19:27:29.098811 #49] DEBUG -- : 
2701Starting test: QA::Scenario::Test::Instance::Airgapped#perform behaves like a QA scenario class performs before hooks only once
2702      performs before hooks only once
2703      with named command-line options
2704D, [2021-09-29T19:27:29.100694 #49] DEBUG -- : 
2705Starting test: QA::Scenario::Test::Instance::Airgapped#perform behaves like a QA scenario class with named command-line options raises an error if the option is invalid
2706        raises an error if the option is invalid
2707D, [2021-09-29T19:27:29.102817 #49] DEBUG -- : 
2708Starting test: QA::Scenario::Test::Instance::Airgapped#perform behaves like a QA scenario class with named command-line options passes on options after --
2709        passes on options after --
2710D, [2021-09-29T19:27:29.104843 #49] DEBUG -- : 
2711Starting test: QA::Scenario::Test::Instance::Airgapped#perform behaves like a QA scenario class with named command-line options converts options to attributes
2712        converts options to attributes
2713      specifying RSpec options
2714D, [2021-09-29T19:27:29.106998 #49] DEBUG -- : 
2715Starting test: QA::Scenario::Test::Instance::Airgapped#perform behaves like a QA scenario class specifying RSpec options sets options on runner
2716        sets options on runner
2717QA::Runtime::API::Request
2718  #request_path
2719D, [2021-09-29T19:27:29.112367 #49] DEBUG -- : 
2720Starting test: QA::Runtime::API::Request#request_path adds the oauth access token
2721    adds the oauth access token
2722D, [2021-09-29T19:27:29.113571 #49] DEBUG -- : 
2723Starting test: QA::Runtime::API::Request#request_path uses a different api version
2724    uses a different api version
2725D, [2021-09-29T19:27:29.114492 #49] DEBUG -- : 
2726Starting test: QA::Runtime::API::Request#request_path adds the personal access token
2727    adds the personal access token
2728D, [2021-09-29T19:27:29.115406 #49] DEBUG -- : 
2729Starting test: QA::Runtime::API::Request#request_path respects query parameters
2730    respects query parameters
2731D, [2021-09-29T19:27:29.116353 #49] DEBUG -- : 
2732Starting test: QA::Runtime::API::Request#request_path prepends the api path
2733    prepends the api path
2734  #url
2735D, [2021-09-29T19:27:29.117391 #49] DEBUG -- : 
2736Starting test: QA::Runtime::API::Request#url returns the full API request url
2737    returns the full API request url
2738    when oauth_access_token is passed in the query string
2739D, [2021-09-29T19:27:29.118415 #49] DEBUG -- : 
2740Starting test: QA::Runtime::API::Request#url when oauth_access_token is passed in the query string does not adds a private_token query string
2741      does not adds a private_token query string
2742  #mask_url
2743D, [2021-09-29T19:27:29.119480 #49] DEBUG -- : 
2744Starting test: QA::Runtime::API::Request#mask_url returns the full API request url with the token masked
2745    returns the full API request url with the token masked
2746QA::Service::DockerRun::K3s
2747  #host_name
2748    not in CI
2749D, [2021-09-29T19:27:29.124844 #49] DEBUG -- : 
2750Starting test: QA::Service::DockerRun::K3s#host_name not in CI returns localhost if not running in a CI environment
2751      returns localhost if not running in a CI environment
2752    in CI
2753D, [2021-09-29T19:27:29.126178 #49] DEBUG -- : 
2754Starting test: QA::Service::DockerRun::K3s#host_name in CI returns name.network
2755      returns name.network
2756QA::Runtime::ApplicationSettings
2757  .get_application_settings
2758D, [2021-09-29T19:27:29.130574 #49] DEBUG -- : 
2759Starting test: QA::Runtime::ApplicationSettings.get_application_settings gets application settings
2760    gets application settings
2761  .set_application_settings
2762D, [2021-09-29T19:27:29.132366 #49] DEBUG -- : 
2763Starting test: QA::Runtime::ApplicationSettings.set_application_settings sets application settings
2764I, [2021-09-29T19:27:29.133250 #49]  INFO -- : Setting application settings: {:allow_local_requests_from_web_hooks_and_services=>true}
2765    sets application settings
2766QA::Page::Element
2767  when pattern is not provided
2768D, [2021-09-29T19:27:29.137808 #49] DEBUG -- : 
2769Starting test: QA::Page::Element when pattern is not provided matches when element name is specified
2770    matches when element name is specified
2771D, [2021-09-29T19:27:29.138638 #49] DEBUG -- : 
2772Starting test: QA::Page::Element when pattern is not provided does not match if QA selector is not there
2773    does not match if QA selector is not there
2774D, [2021-09-29T19:27:29.139366 #49] DEBUG -- : 
2775Starting test: QA::Page::Element when pattern is not provided matches when QA specific selector is present
2776    matches when QA specific selector is present
2777  data-qa selectors
2778D, [2021-09-29T19:27:29.140225 #49] DEBUG -- : 
2779Starting test: QA::Page::Element data-qa selectors properly translates to a data-qa-selector
2780    properly translates to a data-qa-selector
2781    additional selectors
2782D, [2021-09-29T19:27:29.141093 #49] DEBUG -- : 
2783Starting test: QA::Page::Element data-qa selectors additional selectors translates snake_case to kebab-case
2784      translates snake_case to kebab-case
2785D, [2021-09-29T19:27:29.141755 #49] DEBUG -- : 
2786Starting test: QA::Page::Element data-qa selectors additional selectors matches on additional data-qa properties
2787      matches on additional data-qa properties
2788D, [2021-09-29T19:27:29.142443 #49] DEBUG -- : 
2789Starting test: QA::Page::Element data-qa selectors additional selectors doesnt conflict with element requirement
2790      doesnt conflict with element requirement
2791  #selector
2792D, [2021-09-29T19:27:29.143362 #49] DEBUG -- : 
2793Starting test: QA::Page::Element#selector transforms element name into QA-specific selector
2794    transforms element name into QA-specific selector
2795  when pattern is a string
2796D, [2021-09-29T19:27:29.144209 #49] DEBUG -- : 
2797Starting test: QA::Page::Element when pattern is a string matches when there is match
2798    matches when there is match
2799D, [2021-09-29T19:27:29.144891 #49] DEBUG -- : 
2800Starting test: QA::Page::Element when pattern is a string does not match if pattern is not present
2801    does not match if pattern is not present
2802  attributes
2803    element with requirement; no pattern
2804D, [2021-09-29T19:27:29.145984 #49] DEBUG -- : 
2805Starting test: QA::Page::Element attributes element with requirement; no pattern has an attribute[pattern] of the selector
2806      has an attribute[pattern] of the selector
2807D, [2021-09-29T19:27:29.146648 #49] DEBUG -- : 
2808Starting test: QA::Page::Element attributes element with requirement; no pattern is required
2809      is required
2810    element with requirement and pattern
2811D, [2021-09-29T19:27:29.147516 #49] DEBUG -- : 
2812Starting test: QA::Page::Element attributes element with requirement and pattern has a selector of the name
2813      has a selector of the name
2814D, [2021-09-29T19:27:29.148209 #49] DEBUG -- : 
2815Starting test: QA::Page::Element attributes element with requirement and pattern has an attribute[pattern] of the passed pattern
2816      has an attribute[pattern] of the passed pattern
2817D, [2021-09-29T19:27:29.148864 #49] DEBUG -- : 
2818Starting test: QA::Page::Element attributes element with requirement and pattern is required
2819      is required
2820    element with a pattern
2821D, [2021-09-29T19:27:29.149689 #49] DEBUG -- : 
2822Starting test: QA::Page::Element attributes element with a pattern is not required by default
2823      is not required by default
2824D, [2021-09-29T19:27:29.150358 #49] DEBUG -- : 
2825Starting test: QA::Page::Element attributes element with a pattern has an attribute[pattern] of the pattern
2826      has an attribute[pattern] of the pattern
2827    element with no args
2828D, [2021-09-29T19:27:29.151213 #49] DEBUG -- : 
2829Starting test: QA::Page::Element attributes element with no args defaults pattern to #selector
2830      defaults pattern to #selector
2831D, [2021-09-29T19:27:29.151853 #49] DEBUG -- : 
2832Starting test: QA::Page::Element attributes element with no args is not required by default
2833      is not required by default
2834  when pattern is an expression
2835D, [2021-09-29T19:27:29.152747 #49] DEBUG -- : 
2836Starting test: QA::Page::Element when pattern is an expression matches when there is a match
2837    matches when there is a match
2838D, [2021-09-29T19:27:29.153461 #49] DEBUG -- : 
2839Starting test: QA::Page::Element when pattern is an expression does not match if pattern is not present
2840    does not match if pattern is not present
2841  #selector_css
2842D, [2021-09-29T19:27:29.154287 #49] DEBUG -- : 
2843Starting test: QA::Page::Element#selector_css transforms element name into QA-specific clickable css selector
2844    transforms element name into QA-specific clickable css selector
2845QA::Scenario::Test::Instance::All
2846  behaves like a QA scenario class
2847D, [2021-09-29T19:27:29.158663 #49] DEBUG -- : 
2848Starting test: QA::Scenario::Test::Instance::All behaves like a QA scenario class sets tags on runner
2849    sets tags on runner
2850D, [2021-09-29T19:27:29.160566 #49] DEBUG -- : 
2851Starting test: QA::Scenario::Test::Instance::All behaves like a QA scenario class responds to perform
2852    responds to perform
2853D, [2021-09-29T19:27:29.161888 #49] DEBUG -- : 
2854Starting test: QA::Scenario::Test::Instance::All behaves like a QA scenario class sets an address of the subject
2855    sets an address of the subject
2856D, [2021-09-29T19:27:29.163441 #49] DEBUG -- : 
2857Starting test: QA::Scenario::Test::Instance::All behaves like a QA scenario class performs before hooks only once
2858    performs before hooks only once
2859    with named command-line options
2860D, [2021-09-29T19:27:29.165179 #49] DEBUG -- : 
2861Starting test: QA::Scenario::Test::Instance::All behaves like a QA scenario class with named command-line options raises an error if the option is invalid
2862      raises an error if the option is invalid
2863D, [2021-09-29T19:27:29.167145 #49] DEBUG -- : 
2864Starting test: QA::Scenario::Test::Instance::All behaves like a QA scenario class with named command-line options passes on options after --
2865      passes on options after --
2866D, [2021-09-29T19:27:29.169036 #49] DEBUG -- : 
2867Starting test: QA::Scenario::Test::Instance::All behaves like a QA scenario class with named command-line options converts options to attributes
2868      converts options to attributes
2869    specifying RSpec options
2870D, [2021-09-29T19:27:29.171113 #49] DEBUG -- : 
2871Starting test: QA::Scenario::Test::Instance::All behaves like a QA scenario class specifying RSpec options sets options on runner
2872      sets options on runner
2873QA::Resource::Base
2874  .fabricate_via_browser_ui!
2875D, [2021-09-29T19:27:29.176533 #49] DEBUG -- : 
2876Starting test: QA::Resource::Base.fabricate_via_browser_ui! returns fabrication resource
2877D, [2021-09-29T19:27:29.177132 #49] DEBUG -- : ==> Built a MyResource via browser_ui in 2.707e-05 seconds
2878    returns fabrication resource
2879D, [2021-09-29T19:27:29.177931 #49] DEBUG -- : 
2880Starting test: QA::Resource::Base.fabricate_via_browser_ui! instantiates the resource and calls resource method
2881D, [2021-09-29T19:27:29.178420 #49] DEBUG -- : ==> Built a MyResource via browser_ui in 1.366e-05 seconds
2882    instantiates the resource and calls resource method
2883    behaves like fabrication method
2884D, [2021-09-29T19:27:29.179330 #49] DEBUG -- : 
2885Starting test: QA::Resource::Base.fabricate_via_browser_ui! behaves like fabrication method yields resource before calling resource method
2886D, [2021-09-29T19:27:29.180036 #49] DEBUG -- : ==> Built a MyResource via browser_ui in 3.201e-05 seconds
2887      yields resource before calling resource method
2888    with debug log level
2889D, [2021-09-29T19:27:29.180912 #49] DEBUG -- : 
2890Starting test: QA::Resource::Base.fabricate_via_browser_ui! with debug log level logs the resource and build method
2891      logs the resource and build method
2892  #visit!
2893D, [2021-09-29T19:27:29.183211 #49] DEBUG -- : 
2894Starting test: QA::Resource::Base#visit! calls #visit with the underlying #web_url
2895D, [2021-09-29T19:27:29.183643 #49] DEBUG -- : Visiting  at "http://stub"
2896D, [2021-09-29T19:27:29.187292 #49] DEBUG -- : with retry_on_exception: max_attempts: 3; sleep_interval: 0.5
2897D, [2021-09-29T19:27:29.187348 #49] DEBUG -- : Attempt number 1
2898D, [2021-09-29T19:27:29.193925 #49] DEBUG -- : ended retry_on_exception
2899D, [2021-09-29T19:27:29.194002 #49] DEBUG -- : with retry_until: max_attempts: 3; reload_page: ; sleep_interval: 0; raise_on_failure: true; retry_on_exception: false
2900D, [2021-09-29T19:27:29.194083 #49] DEBUG -- : Attempt number 1
2901D, [2021-09-29T19:27:29.194287 #49] DEBUG -- : with wait_until: max_duration: 60; reload_page: ; sleep_interval: 0.1; raise_on_failure: true 
2902D, [2021-09-29T19:27:29.194564 #49] DEBUG -- : ended wait_until
2903D, [2021-09-29T19:27:29.194601 #49] DEBUG -- : ended retry_until
2904D, [2021-09-29T19:27:29.197743 #49] DEBUG -- : with retry_on_exception: max_attempts: 3; sleep_interval: 0.5
2905D, [2021-09-29T19:27:29.197797 #49] DEBUG -- : Attempt number 1
2906D, [2021-09-29T19:27:29.204307 #49] DEBUG -- : ended retry_on_exception
2907    calls #visit with the underlying #web_url
2908  #web_url
2909D, [2021-09-29T19:27:29.205592 #49] DEBUG -- : 
2910Starting test: QA::Resource::Base#web_url sets #web_url to #current_url after fabrication
2911D, [2021-09-29T19:27:29.205784 #49] DEBUG -- : ==> Built a  via browser_ui in 1.359e-05 seconds
2912    sets #web_url to #current_url after fabrication
2913  .fabricate!
2914    when resource does not support fabrication via the API
2915D, [2021-09-29T19:27:29.206672 #49] DEBUG -- : 
2916Starting test: QA::Resource::Base.fabricate! when resource does not support fabrication via the API calls .fabricate_via_browser_ui!
2917      calls .fabricate_via_browser_ui!
2918    when resource supports fabrication via the API
2919D, [2021-09-29T19:27:29.207857 #49] DEBUG -- : 
2920Starting test: QA::Resource::Base.fabricate! when resource supports fabrication via the API calls .fabricate_via_browser_ui!
2921      calls .fabricate_via_browser_ui!
2922  .fabricate_via_api!
2923D, [2021-09-29T19:27:29.208889 #49] DEBUG -- : 
2924Starting test: QA::Resource::Base.fabricate_via_api! instantiates the resource, calls resource method returns the resource
2925D, [2021-09-29T19:27:29.209487 #49] DEBUG -- : ==> Built a MyResource via api in 4.34e-05 seconds
2926    instantiates the resource, calls resource method returns the resource
2927    behaves like fabrication method
2928D, [2021-09-29T19:27:29.210245 #49] DEBUG -- : 
2929Starting test: QA::Resource::Base.fabricate_via_api! behaves like fabrication method yields resource before calling resource method
2930D, [2021-09-29T19:27:29.210923 #49] DEBUG -- : ==> Built a MyResource via api in 4.225e-05 seconds
2931      yields resource before calling resource method
2932    with debug log level
2933D, [2021-09-29T19:27:29.211653 #49] DEBUG -- : 
2934Starting test: QA::Resource::Base.fabricate_via_api! with debug log level logs the resource and build method
2935      logs the resource and build method
2936  .attribute
2937    when the attribute is populated via direct assignment
2938D, [2021-09-29T19:27:29.213928 #49] DEBUG -- : 
2939Starting test: QA::Resource::Base.attribute when the attribute is populated via direct assignment returns value from the assignment
2940D, [2021-09-29T19:27:29.214096 #49] DEBUG -- : ==> Built a  via browser_ui in 1.19e-05 seconds
2941      returns value from the assignment
2942      when the api also has such response
2943D, [2021-09-29T19:27:29.214894 #49] DEBUG -- : 
2944Starting test: QA::Resource::Base.attribute when the attribute is populated via direct assignment when the api also has such response returns value from the assignment
2945D, [2021-09-29T19:27:29.215277 #49] DEBUG -- : ==> Built a  via browser_ui in 4.018e-05 seconds
2946        returns value from the assignment
2947    when the attribute has no value
2948D, [2021-09-29T19:27:29.216085 #49] DEBUG -- : 
2949Starting test: QA::Resource::Base.attribute when the attribute has no value raises an error because no values could be found
2950D, [2021-09-29T19:27:29.216227 #49] DEBUG -- : ==> Built a  via browser_ui in 9.96e-06 seconds
2951      raises an error because no values could be found
2952    when the attribute is populated via the api
2953D, [2021-09-29T19:27:29.217072 #49] DEBUG -- : 
2954Starting test: QA::Resource::Base.attribute when the attribute is populated via the api returns value from api
2955D, [2021-09-29T19:27:29.217399 #49] DEBUG -- : ==> Built a  via browser_ui in 1.0431e-05 seconds
2956      returns value from api
2957      when the attribute also has a block
2958D, [2021-09-29T19:27:29.218273 #49] DEBUG -- : 
2959Starting test: QA::Resource::Base.attribute when the attribute is populated via the api when the attribute also has a block returns value from api and emits an debug log entry
2960        returns value from api and emits an debug log entry
2961    when the attribute is populated via a block
2962D, [2021-09-29T19:27:29.219558 #49] DEBUG -- : 
2963Starting test: QA::Resource::Base.attribute when the attribute is populated via a block returns value from the block
2964D, [2021-09-29T19:27:29.219677 #49] DEBUG -- : ==> Built a  via browser_ui in 9.82e-06 seconds
2965      returns value from the block
2966    when multiple resources have the same attribute name
2967D, [2021-09-29T19:27:29.220395 #49] DEBUG -- : 
2968Starting test: QA::Resource::Base.attribute when multiple resources have the same attribute name has unique attribute values
2969D, [2021-09-29T19:27:29.220546 #49] DEBUG -- : ==> Built a  via browser_ui in 2.165e-05 seconds
2970D, [2021-09-29T19:27:29.220642 #49] DEBUG -- : ==> Built a  via browser_ui in 7.7e-06 seconds
2971      has unique attribute values
2972QA::Scenario::Template
2973D, [2021-09-29T19:27:29.225922 #49] DEBUG -- : 
2974Starting test: QA::Scenario::Template allows a feature to be enabled
2975  allows a feature to be enabled
2976D, [2021-09-29T19:27:29.227507 #49] DEBUG -- : 
2977Starting test: QA::Scenario::Template does not disable a feature if already disabled
2978  does not disable a feature if already disabled
2979D, [2021-09-29T19:27:29.228688 #49] DEBUG -- : 
2980Starting test: QA::Scenario::Template ensures a disabled feature is not enabled afterwards if it was disabled earlier
2981  ensures a disabled feature is not enabled afterwards if it was disabled earlier
2982D, [2021-09-29T19:27:29.230005 #49] DEBUG -- : 
2983Starting test: QA::Scenario::Template defines an about address by default
2984  defines an about address by default
2985D, [2021-09-29T19:27:29.231147 #49] DEBUG -- : 
2986Starting test: QA::Scenario::Template ensures a disabled feature is enabled afterwards
2987  ensures a disabled feature is enabled afterwards
2988D, [2021-09-29T19:27:29.232341 #49] DEBUG -- : 
2989Starting test: QA::Scenario::Template allows a feature to be disabled
2990  allows a feature to be disabled
2991D, [2021-09-29T19:27:29.233502 #49] DEBUG -- : 
2992Starting test: QA::Scenario::Template ensures an enabled feature is disabled afterwards
2993  ensures an enabled feature is disabled afterwards
2994QA::Page::View
2995  #pathname
2996D, [2021-09-29T19:27:29.238381 #49] DEBUG -- : 
2997Starting test: QA::Page::View#pathname returns an absolute and clean path to the view
2998    returns an absolute and clean path to the view
2999  .evaluate
3000D, [2021-09-29T19:27:29.239337 #49] DEBUG -- : 
3001Starting test: QA::Page::View.evaluate evaluates a block and returns a DSL object
3002    evaluates a block and returns a DSL object
3003  #errors
3004    when view partial has not been found
3005D, [2021-09-29T19:27:29.240205 #49] DEBUG -- : 
3006Starting test: QA::Page::View#errors when view partial has not been found returns an error when it is not able to find the partial
3007      returns an error when it is not able to find the partial
3008    when view partial is present
3009      when pattern is found
3010D, [2021-09-29T19:27:29.241222 #49] DEBUG -- : 
3011Starting test: QA::Page::View#errors when view partial is present when pattern is found walks through the view and asserts on elements existence
3012        walks through the view and asserts on elements existence
3013      when pattern has not been found
3014D, [2021-09-29T19:27:29.242538 #49] DEBUG -- : 
3015Starting test: QA::Page::View#errors when view partial is present when pattern has not been found returns an array of errors related to missing elements
3016        returns an array of errors related to missing elements
3017Top 10 slowest examples (1.24 seconds, 43.4% of total time):
3018  QA::Resource::SSHKey#key generates a default key
3019    0.32422 seconds ./spec/resource/ssh_key_spec.rb:5
3020  QA::Runtime::Key::RSA#public_key generates a public RSA key
3021    0.26471 seconds ./spec/runtime/key/rsa_spec.rb:7
3022  QA::Page::Validator when checking validation errors when there are validation errors #errors returns errors
3023    0.13001 seconds ./spec/page/validator_spec.rb:68
3024  QA::Resource::Events::Project#wait_for_push raises an error if a push with the specified commit message is not found
3025    0.10254 seconds ./spec/resource/events/project_spec.rb:53
3026  QA::Resource::Events::Project#wait_for_push_new_branch raises an error if a push with the specified branch is not found
3027    0.10193 seconds ./spec/resource/events/project_spec.rb:70
3028  QA::Page::Base#wait_until when the condition is false returns false
3029    0.10189 seconds ./spec/page/base_spec.rb:87
3030  QA::Page::Base#wait_until when the condition is false refreshes
3031    0.10179 seconds ./spec/page/base_spec.rb:81
3032  QA::Page::Validator#descendants does not return modules that aggregate page objects
3033    0.04346 seconds ./spec/page/validator_spec.rb:25
3034  QA::Page::Base#all_elements does not raise an error if :minimum, :maximum, :count, or :between is specified
3035    0.04133 seconds ./spec/page/base_spec.rb:104
3036  QA::Page::Base elements #visible? Page is currently visible with elements does not raise error if page has elements
3037    0.0302 seconds ./spec/page/base_spec.rb:159
3038Top 10 slowest example groups:
3039  QA::Runtime::Key::RSA
3040    0.2688 seconds average (0.2688 seconds / 1 example) ./spec/runtime/key/rsa_spec.rb:3
3041  QA::Resource::SSHKey
3042    0.11055 seconds average (0.33164 seconds / 3 examples) ./spec/resource/ssh_key_spec.rb:3
3043  QA::Resource::Events::Project
3044    0.04493 seconds average (0.22463 seconds / 5 examples) ./spec/resource/events/project_spec.rb:3
3045  QA::Runtime::Key::ED25519
3046    0.03177 seconds average (0.03177 seconds / 1 example) ./spec/runtime/key/ed25519_spec.rb:3
3047  QA::Page::Validator
3048    0.02981 seconds average (0.20864 seconds / 7 examples) ./spec/page/validator_spec.rb:3
3049  QA::Runtime::Key::ECDSA
3050    0.01893 seconds average (0.07572 seconds / 4 examples) ./spec/runtime/key/ecdsa_spec.rb:3
3051  QA::Page::Base
3052    0.01823 seconds average (0.30996 seconds / 17 examples) ./spec/page/base_spec.rb:3
3053  QA::Support::Formatters::AllureMetadataFormatter
3054    0.01563 seconds average (0.01563 seconds / 1 example) ./spec/support/formatters/allure_metadata_formatter_spec.rb:3
3055  QA::Specs::ParallelRunner
3056    0.00902 seconds average (0.04511 seconds / 5 examples) ./spec/specs/parallel_runner_spec.rb:3
3057  QA::Support::Formatters::TestStatsFormatter
3058    0.0069 seconds average (0.04141 seconds / 6 examples) ./spec/support/formatters/test_stats_formatter_spec.rb:5
3059Finished in 2.86 seconds (files took 8.97 seconds to load)
3060609 examples, 0 failures
3061Randomized with seed 18651
 3062  Saving cache for successful job  
  00:01
3063Not uploading cache qa-ruby-gems-v1-4 due to policy
 3064  Cleaning up project directory and file based variables  
  00:00
3065Job succeeded
Tags: gitlab-org
Commit 6c9cdce5 in !70878
Merge branch 'imrishabh18-338445' into 'master'
Related jobs

secret_detection
brakeman-sast
bundle-size-review
code_quality
compile-storybook
danger-review
db:check-schema
eslint-as-if-foss
gitlab_git_test
gosec-sast
graphql-verify
jest 1/5
jest 2/5
jest 3/5
jest 4/5
jest 5/5
jest-integration
license_scanning
memory-on-boot
memory-static
nodejs-scan-sast
qa:internal
qa:selectors
rspec fail-fast
rspec foss-impact
rspec system pg12 1/24
rspec system pg12 10/24
rspec system pg12 11/24
rspec system pg12 12/24
rspec system pg12 13/24
rspec system pg12 14/24
rspec system pg12 15/24
rspec system pg12 16/24
rspec system pg12 17/24
rspec system pg12 18/24
rspec system pg12 19/24
rspec system pg12 2/24
rspec system pg12 20/24
rspec system pg12 21/24
rspec system pg12 22/24
rspec system pg12 23/24
rspec system pg12 24/24
rspec system pg12 3/24
rspec system pg12 4/24
rspec system pg12 5/24
rspec system pg12 6/24
rspec system pg12 7/24
rspec system pg12 8/24
rspec system pg12 9/24
rspec-ee system pg12 1/6
rspec-ee system pg12 2/6
rspec-ee system pg12 3/6
rspec-ee system pg12 4/6
rspec-ee system pg12 5/6
rspec-ee system pg12 6/6
rspec-ee system pg12 geo
run-dev-fixtures
run-dev-fixtures-ee
semgrep-sast
startup-css-check
static-analysis 1/4
static-analysis 2/4
static-analysis 3/4
static-analysis 4/4
verify-tests-yml
webpack-dev-server