review-qa-reliable 3/5
Passed Started
by
@pedropombeiro
Pedro Pombeiro
1Running with gitlab-runner 14.6.0~beta.30.g4c96395a (4c96395a)2 on blue-2.private.runners-manager.gitlab.com/gitlab.com/gitlab-org QvBVRoXM3 feature flags: FF_USE_FASTZIP:true6Using Docker executor with image registry.gitlab.com/gitlab-org/gitlab/gitlab-ee-qa:8511ff6261605aa1245fb5cf10718ffb773350bb ...7Starting service docker:20.10.1-dind ...8Pulling docker image docker:20.10.1-dind ...9Using docker image sha256:8d54f09a2b777ef4b919ec16217a8b67e1f388f61b5c6bf6b3d8e8a06e74caab for docker:20.10.1-dind with digest docker@sha256:b890370b484eb4d72989e632b524bdfb482f939bb5af4a6739445e26ba564368 ...10Waiting for services to be up and running...11*** WARNING: Service runner-qvbvroxm-project-278964-concurrent-0-fba37eef635ac8b6-docker-0 probably didn't start properly.12Health check error:13service "runner-qvbvroxm-project-278964-concurrent-0-fba37eef635ac8b6-docker-0-wait-for-service" timeout14Health check container logs:15Service container logs:162022-01-10T14:55:23.276073785Z time="2022-01-10T14:55:23.275841165Z" level=info msg="Starting up"172022-01-10T14:55:23.293300544Z time="2022-01-10T14:55:23.293236934Z" level=warning msg="could not change group /var/run/docker.sock to docker: group docker not found"182022-01-10T14:55:23.293469554Z time="2022-01-10T14:55:23.293372404Z" level=warning msg="Binding to IP address without --tlsverify is insecure and gives root access on this machine to everyone who has access to your network." host="tcp://0.0.0.0:2375"192022-01-10T14:55:23.293481074Z time="2022-01-10T14:55:23.293399834Z" level=warning msg="Binding to an IP address, even on localhost, can also give access to scripts run in a browser. Be safe out there!" host="tcp://0.0.0.0:2375"202022-01-10T14:55:24.293702301Z time="2022-01-10T14:55:24.293547071Z" level=warning msg="Binding to an IP address without --tlsverify is deprecated. Startup is intentionally being slowed down to show this message" host="tcp://0.0.0.0:2375"212022-01-10T14:55:24.293748481Z time="2022-01-10T14:55:24.293603231Z" level=warning msg="Please consider generating tls certificates with client validation to prevent exposing unauthenticated root access to your network" host="tcp://0.0.0.0:2375"222022-01-10T14:55:24.293807631Z time="2022-01-10T14:55:24.293758581Z" level=warning msg="You can override this by explicitly specifying '--tls=false' or '--tlsverify=false'" host="tcp://0.0.0.0:2375"232022-01-10T14:55:24.293876621Z time="2022-01-10T14:55:24.293783311Z" level=warning msg="Support for listening on TCP without authentication or explicit intent to run without authentication will be removed in the next release" host="tcp://0.0.0.0:2375"242022-01-10T14:55:39.448983386Z time="2022-01-10T14:55:39.448836886Z" level=info msg="libcontainerd: started new containerd process" pid=21252022-01-10T14:55:39.449016896Z time="2022-01-10T14:55:39.448911696Z" level=info msg="parsed scheme: \"unix\"" module=grpc262022-01-10T14:55:39.449021456Z time="2022-01-10T14:55:39.448924906Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc272022-01-10T14:55:39.449084366Z time="2022-01-10T14:55:39.448949666Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/containerd/containerd.sock <nil> 0 <nil>}] <nil> <nil>}" module=grpc282022-01-10T14:55:39.449093616Z time="2022-01-10T14:55:39.448975346Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc292022-01-10T14:55:40.064662121Z time="2022-01-10T14:55:40.064508401Z" level=info msg="starting containerd" revision=269548fa27e0089a8b8278fc4fc781d7f65a939b version=v1.4.3302022-01-10T14:55:40.110196378Z time="2022-01-10T14:55:40.110109238Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1312022-01-10T14:55:40.110323708Z time="2022-01-10T14:55:40.110287928Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1322022-01-10T14:55:40.126291557Z time="2022-01-10T14:55:40.126218027Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.aufs\"..." error="aufs is not supported (modprobe aufs failed: exit status 1 \"ip: can't find device 'aufs'\\nmodprobe: can't change directory to '/lib/modules': No such file or directory\\n\"): skip plugin" type=io.containerd.snapshotter.v1332022-01-10T14:55:40.126355747Z time="2022-01-10T14:55:40.126258937Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1342022-01-10T14:55:40.126587027Z time="2022-01-10T14:55:40.126536617Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." error="path /var/lib/docker/containerd/daemon/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1352022-01-10T14:55:40.126641847Z time="2022-01-10T14:55:40.126565917Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1362022-01-10T14:55:40.126648277Z time="2022-01-10T14:55:40.126593497Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.devmapper" error="devmapper not configured"372022-01-10T14:55:40.126652697Z time="2022-01-10T14:55:40.126606837Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1382022-01-10T14:55:40.126741367Z time="2022-01-10T14:55:40.126699427Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1392022-01-10T14:55:40.126931777Z time="2022-01-10T14:55:40.126895127Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1402022-01-10T14:55:40.128347337Z time="2022-01-10T14:55:40.128283767Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.zfs\"..." error="path /var/lib/docker/containerd/daemon/io.containerd.snapshotter.v1.zfs must be a zfs filesystem to be used with the zfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1412022-01-10T14:55:40.128389117Z time="2022-01-10T14:55:40.128313307Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1422022-01-10T14:55:40.128411407Z time="2022-01-10T14:55:40.128384847Z" level=warning msg="could not use snapshotter devmapper in metadata plugin" error="devmapper not configured"432022-01-10T14:55:40.128432177Z time="2022-01-10T14:55:40.128398597Z" level=info msg="metadata content store policy set" policy=shared442022-01-10T14:55:40.174927444Z time="2022-01-10T14:55:40.174870054Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1452022-01-10T14:55:40.174971434Z time="2022-01-10T14:55:40.174904014Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1462022-01-10T14:55:40.186773443Z time="2022-01-10T14:55:40.186733293Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1472022-01-10T14:55:40.186857983Z time="2022-01-10T14:55:40.186836193Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1482022-01-10T14:55:40.186980273Z time="2022-01-10T14:55:40.186920593Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1492022-01-10T14:55:40.186990753Z time="2022-01-10T14:55:40.186945413Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1502022-01-10T14:55:40.187050303Z time="2022-01-10T14:55:40.186964723Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1512022-01-10T14:55:40.187100533Z time="2022-01-10T14:55:40.187015063Z" level=info msg="loading plugin \"io.containerd.service.v1.leases-service\"..." type=io.containerd.service.v1522022-01-10T14:55:40.187145583Z time="2022-01-10T14:55:40.187089843Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1532022-01-10T14:55:40.187203773Z time="2022-01-10T14:55:40.187121593Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1542022-01-10T14:55:40.187250713Z time="2022-01-10T14:55:40.187182443Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1552022-01-10T14:55:40.187474863Z time="2022-01-10T14:55:40.187385273Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2562022-01-10T14:55:40.187646343Z time="2022-01-10T14:55:40.187578153Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1572022-01-10T14:55:40.189301643Z time="2022-01-10T14:55:40.189216623Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1582022-01-10T14:55:40.189314113Z time="2022-01-10T14:55:40.189261083Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1592022-01-10T14:55:40.189434432Z time="2022-01-10T14:55:40.189354393Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1602022-01-10T14:55:40.189444063Z time="2022-01-10T14:55:40.189380853Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1612022-01-10T14:55:40.189448463Z time="2022-01-10T14:55:40.189396853Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1622022-01-10T14:55:40.189493223Z time="2022-01-10T14:55:40.189411653Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1632022-01-10T14:55:40.189500703Z time="2022-01-10T14:55:40.189427912Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1642022-01-10T14:55:40.189504603Z time="2022-01-10T14:55:40.189460532Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1652022-01-10T14:55:40.189584272Z time="2022-01-10T14:55:40.189526012Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1662022-01-10T14:55:40.189593083Z time="2022-01-10T14:55:40.189554963Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1672022-01-10T14:55:40.189687183Z time="2022-01-10T14:55:40.189612532Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1682022-01-10T14:55:40.189979463Z time="2022-01-10T14:55:40.189904443Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1692022-01-10T14:55:40.189996192Z time="2022-01-10T14:55:40.189935192Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1702022-01-10T14:55:40.190000612Z time="2022-01-10T14:55:40.189951283Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1712022-01-10T14:55:40.190092712Z time="2022-01-10T14:55:40.190019292Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1722022-01-10T14:55:40.190345632Z time="2022-01-10T14:55:40.190257952Z" level=info msg=serving... address=/var/run/docker/containerd/containerd-debug.sock732022-01-10T14:55:40.190456032Z time="2022-01-10T14:55:40.190376952Z" level=info msg=serving... address=/var/run/docker/containerd/containerd.sock.ttrpc742022-01-10T14:55:40.190487932Z time="2022-01-10T14:55:40.190443372Z" level=info msg=serving... address=/var/run/docker/containerd/containerd.sock752022-01-10T14:55:40.190531332Z time="2022-01-10T14:55:40.190480123Z" level=info msg="containerd successfully booted in 0.126723s"762022-01-10T14:55:40.312590004Z time="2022-01-10T14:55:40.312485784Z" level=info msg="Setting the storage driver from the $DOCKER_DRIVER environment variable (overlay2)"772022-01-10T14:55:40.329822562Z time="2022-01-10T14:55:40.329771132Z" level=info msg="parsed scheme: \"unix\"" module=grpc782022-01-10T14:55:40.329910342Z time="2022-01-10T14:55:40.329855312Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc792022-01-10T14:55:40.329968402Z time="2022-01-10T14:55:40.329892772Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/containerd/containerd.sock <nil> 0 <nil>}] <nil> <nil>}" module=grpc802022-01-10T14:55:40.329976492Z time="2022-01-10T14:55:40.329906172Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc812022-01-10T14:55:40.347783421Z time="2022-01-10T14:55:40.347709821Z" level=info msg="parsed scheme: \"unix\"" module=grpc822022-01-10T14:55:40.347794981Z time="2022-01-10T14:55:40.347732841Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc832022-01-10T14:55:40.347799671Z time="2022-01-10T14:55:40.347748111Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/containerd/containerd.sock <nil> 0 <nil>}] <nil> <nil>}" module=grpc842022-01-10T14:55:40.347824521Z time="2022-01-10T14:55:40.347783061Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc852022-01-10T14:55:40.406385477Z time="2022-01-10T14:55:40.406325487Z" level=warning msg="Your kernel does not support cgroup blkio weight"862022-01-10T14:55:40.406410637Z time="2022-01-10T14:55:40.406347507Z" level=warning msg="Your kernel does not support cgroup blkio weight_device"872022-01-10T14:55:40.407763827Z time="2022-01-10T14:55:40.407708127Z" level=info msg="Loading containers: start."882022-01-10T14:55:40.683474477Z time="2022-01-10T14:55:40.683383937Z" level=info msg="Default bridge (docker0) is assigned with an IP address 172.18.0.0/16. Daemon option --bip can be used to set a preferred IP address"892022-01-10T14:55:40.733575963Z time="2022-01-10T14:55:40.733483543Z" level=info msg="Loading containers: done."902022-01-10T14:55:41.151215883Z time="2022-01-10T14:55:41.151076683Z" level=info msg="Docker daemon" commit=f001486 graphdriver(s)=overlay2 version=20.10.1912022-01-10T14:55:41.158569643Z time="2022-01-10T14:55:41.158498363Z" level=info msg="Daemon has completed initialization"922022-01-10T14:55:41.447923392Z time="2022-01-10T14:55:41.446960742Z" level=info msg="API listen on /var/run/docker.sock"932022-01-10T14:55:41.450836182Z time="2022-01-10T14:55:41.450759552Z" level=info msg="API listen on [::]:2375"94*********95Authenticating with credentials from job payload (GitLab Registry)96Pulling docker image registry.gitlab.com/gitlab-org/gitlab/gitlab-ee-qa:8511ff6261605aa1245fb5cf10718ffb773350bb ...97Using docker image sha256:f65033c4ef3617cc77eb9eb4719aa76afa1332fcc1accde618fb55496a92f2b6 for registry.gitlab.com/gitlab-org/gitlab/gitlab-ee-qa:8511ff6261605aa1245fb5cf10718ffb773350bb with digest registry.gitlab.com/gitlab-org/gitlab/gitlab-ee-qa@sha256:c60f94dba5bd0bd312892c468f71de598068901010d2492a254cb187b4104923 ...99Running on runner-qvbvroxm-project-278964-concurrent-0 via runner-qvbvroxm-private-1641824259-3a1d0b00...101$ eval "$CI_PRE_CLONE_SCRIPT"102Fetching changes with git depth set to 20...103Initialized empty Git repository in /builds/gitlab-org-forks/gitlab/.git/104Created fresh repository.105remote: Enumerating objects: 108529, done. 106remote: Counting objects: 100% (108529/108529), done. 107remote: Compressing objects: 100% (78121/78121), done. 108remote: Total 108529 (delta 42498), reused 72398 (delta 25870), pack-reused 0 109Receiving objects: 100% (108529/108529), 116.64 MiB | 32.15 MiB/s, done.110Resolving deltas: 100% (42498/42498), done.112 * [new ref] 08a1614488295a435ddcfc0220b361fd8f5fb92b -> refs/pipelines/444817032113Checking out 08a16144 as refs/merge-requests/77779/merge...114Skipping Git submodules setup116Downloading artifacts for review-deploy (1958299550)...117Downloading artifacts from coordinator... ok id=1958299550 responseStatus=200 OK token=Ju7jmB_y119Using docker image sha256:f65033c4ef3617cc77eb9eb4719aa76afa1332fcc1accde618fb55496a92f2b6 for registry.gitlab.com/gitlab-org/gitlab/gitlab-ee-qa:8511ff6261605aa1245fb5cf10718ffb773350bb with digest registry.gitlab.com/gitlab-org/gitlab/gitlab-ee-qa@sha256:c60f94dba5bd0bd312892c468f71de598068901010d2492a254cb187b4104923 ...120$ export EE_LICENSE="$(cat $REVIEW_APPS_EE_LICENSE_FILE)"121$ if [ -n "$CI_MERGE_REQUEST_SOURCE_BRANCH_SHA" ]; then git checkout -f ${CI_MERGE_REQUEST_SOURCE_BRANCH_SHA}; fi122Previous HEAD position was 08a161448 Merge branch 'pedropombeiro/348299/2-add-notes-param-in-rest-api' into 'pedropombeiro/348299/1-add-notes-field'123HEAD is now at 8511ff626 Accept notes parameter in REST runner registration124$ export CI_ENVIRONMENT_URL="$(cat environment_url.txt)"125$ echo "${CI_ENVIRONMENT_URL}"127$ cd qa128$ bin/test "${QA_SCENARIO}" "${CI_ENVIRONMENT_URL}" \ # collapsed multi-line command129D, [2022-01-10T14:57:02.775975 #79] DEBUG -- : Downloading latest knapsack report for 'review-qa-reliable' to 'knapsack/review-qa-reliable.json'130/usr/local/bundle/gems/capybara-3.35.3/lib/capybara/registration_container.rb:21: warning: DEPRECATED: Calling 'include?' on the drivers/servers container is deprecated without replacement131/usr/local/bundle/gems/chemlab-0.9.2/lib/chemlab/configuration.rb:81: warning: already initialized constant Chemlab::Vendor132/usr/local/bundle/gems/chemlab-0.9.2/lib/chemlab/configuration.rb:81: warning: previous definition of Vendor was here1332022-01-10 14:57:06 / CONF :: 134 ==> Base URL: https://gitlab-review-pedropombe-dh031e.gitlab-review.app135 ==> Browser: #<Selenium::WebDriver::Chrome::Driver:0x000055a6c6e07ed8>136 ==> Libraries: Chemlab::Vendor137D, [2022-01-10T14:57:07.158563 #79] DEBUG -- : has_element? :login_page (wait: 60) returned: true138D, [2022-01-10T14:57:07.179910 #79] DEBUG -- : has_element? :login_page (wait: 0) returned: true139D, [2022-01-10T14:57:07.301663 #79] DEBUG -- : waiting for loading to complete...140D, [2022-01-10T14:57:07.306384 #79] DEBUG -- : loading complete after 0.004664759 seconds141D, [2022-01-10T14:57:08.311115 #79] DEBUG -- : has_element? :sign_in_tab (wait: 0) returned: false142D, [2022-01-10T14:57:08.321587 #79] DEBUG -- : waiting for loading to complete...143D, [2022-01-10T14:57:08.326180 #79] DEBUG -- : loading complete after 0.00455593 seconds144D, [2022-01-10T14:57:09.334736 #79] DEBUG -- : has_element? :standard_tab (wait: 0) returned: false145D, [2022-01-10T14:57:09.334781 #79] DEBUG -- : filling :login_field with "root"146D, [2022-01-10T14:57:09.334795 #79] DEBUG -- : finding :login_field with args {}147D, [2022-01-10T14:57:09.337152 #79] DEBUG -- : waiting for loading to complete...148D, [2022-01-10T14:57:09.341743 #79] DEBUG -- : loading complete after 0.004559169 seconds149D, [2022-01-10T14:57:09.352729 #79] DEBUG -- : found :login_field150D, [2022-01-10T14:57:09.385088 #79] DEBUG -- : filling :password_field with "*****"151D, [2022-01-10T14:57:09.385137 #79] DEBUG -- : finding :password_field with args {}152D, [2022-01-10T14:57:09.387584 #79] DEBUG -- : waiting for loading to complete...153D, [2022-01-10T14:57:09.392260 #79] DEBUG -- : loading complete after 0.004649148 seconds154D, [2022-01-10T14:57:09.404590 #79] DEBUG -- : found :password_field155D, [2022-01-10T14:57:09.469615 #79] DEBUG -- : clicking :sign_in_button with args {}156D, [2022-01-10T14:57:09.472173 #79] DEBUG -- : waiting for loading to complete...157D, [2022-01-10T14:57:09.476892 #79] DEBUG -- : loading complete after 0.004684959 seconds158D, [2022-01-10T14:57:11.708843 #79] DEBUG -- : waiting for loading to complete...159D, [2022-01-10T14:57:11.717385 #79] DEBUG -- : loading complete after 0.008495898 seconds160D, [2022-01-10T14:57:11.818812 #79] DEBUG -- : has_no_element? :#<QA::Page::Element:0x000055a6c57b9168> (wait: 0) returned: false161D, [2022-01-10T14:57:11.821192 #79] DEBUG -- : waiting for loading to complete...162D, [2022-01-10T14:57:11.829250 #79] DEBUG -- : loading complete after 0.008025238 seconds163D, [2022-01-10T14:57:11.836856 #79] DEBUG -- : has_no_element? :#<QA::Page::Element:0x000055a6c57b8ec0> (wait: 0) returned: true164D, [2022-01-10T14:57:12.015574 #79] DEBUG -- : has_element? :navbar (wait: 60) returned: true165D, [2022-01-10T14:57:12.026185 #79] DEBUG -- : has_element? :user_avatar (wait: 60) returned: true166D, [2022-01-10T14:57:12.037011 #79] DEBUG -- : has_element? :user_menu (wait: 60) returned: true167D, [2022-01-10T14:57:12.048066 #79] DEBUG -- : has_element? :issues_shortcut_button (wait: 60) returned: true168D, [2022-01-10T14:57:12.059111 #79] DEBUG -- : has_element? :merge_requests_shortcut_button (wait: 60) returned: true169D, [2022-01-10T14:57:12.070877 #79] DEBUG -- : has_element? :todos_shortcut_button (wait: 60) returned: true170D, [2022-01-10T14:57:12.078890 #79] DEBUG -- : has_element? :user_avatar (wait: 10) returned: true171D, [2022-01-10T14:57:12.078922 #79] DEBUG -- : within element :navbar with args {}172D, [2022-01-10T14:57:12.081400 #79] DEBUG -- : waiting for loading to complete...173D, [2022-01-10T14:57:12.088967 #79] DEBUG -- : loading complete after 0.007536859 seconds174D, [2022-01-10T14:57:12.099681 #79] DEBUG -- : clicking :navbar_dropdown with args {:title=>"Menu"}175D, [2022-01-10T14:57:12.101863 #79] DEBUG -- : waiting for loading to complete...176D, [2022-01-10T14:57:12.112285 #79] DEBUG -- : loading complete after 0.010391907 seconds177D, [2022-01-10T14:57:12.182146 #79] DEBUG -- : clicking :admin_area_link with args {}178D, [2022-01-10T14:57:12.185741 #79] DEBUG -- : waiting for loading to complete...179D, [2022-01-10T14:57:12.209226 #79] DEBUG -- : loading complete after 0.023437355 seconds180D, [2022-01-10T14:57:13.179417 #79] DEBUG -- : end within element :navbar with args {}181D, [2022-01-10T14:57:13.398944 #79] DEBUG -- : waiting for loading to complete...182D, [2022-01-10T14:57:13.408671 #79] DEBUG -- : loading complete after 0.009668258 seconds183D, [2022-01-10T14:57:14.505532 #79] DEBUG -- : has_text?('Enter Admin Mode', wait: 1.0) returned false184D, [2022-01-10T14:57:14.517420 #79] DEBUG -- : clicking :link_subscription_menu with args {}185D, [2022-01-10T14:57:14.520050 #79] DEBUG -- : waiting for loading to complete...186D, [2022-01-10T14:57:14.528610 #79] DEBUG -- : loading complete after 0.008524669 seconds187D, [2022-01-10T14:57:15.028092 #79] DEBUG -- : has_element? :remove_license_link (wait: 10) returned: true188D, [2022-01-10T14:57:15.039659 #79] DEBUG -- : waiting for loading to complete...189D, [2022-01-10T14:57:15.125139 #79] DEBUG -- : loading complete after 0.08540929 seconds190D, [2022-01-10T14:57:16.136537 #79] DEBUG -- : has_element? :login_page (wait: 0) returned: false191D, [2022-01-10T14:57:16.145204 #79] DEBUG -- : has_element? :user_avatar (wait: 0) returned: true192D, [2022-01-10T14:57:16.376570 #79] DEBUG -- : waiting for loading to complete...193D, [2022-01-10T14:57:16.385488 #79] DEBUG -- : loading complete after 0.008870798 seconds194D, [2022-01-10T14:57:17.397884 #79] DEBUG -- : has_element? :login_page (wait: 0) returned: false195D, [2022-01-10T14:57:17.407777 #79] DEBUG -- : has_element? :user_avatar (wait: 0) returned: true196D, [2022-01-10T14:57:17.407828 #79] DEBUG -- : within element :navbar with args {}197D, [2022-01-10T14:57:17.410098 #79] DEBUG -- : waiting for loading to complete...198D, [2022-01-10T14:57:17.418698 #79] DEBUG -- : loading complete after 0.008566538 seconds199D, [2022-01-10T14:57:17.427294 #79] DEBUG -- : clicking :user_avatar with args {}200D, [2022-01-10T14:57:17.429596 #79] DEBUG -- : waiting for loading to complete...201D, [2022-01-10T14:57:17.440685 #79] DEBUG -- : loading complete after 0.011063907 seconds202D, [2022-01-10T14:57:17.490802 #79] DEBUG -- : within element :user_menu with args {}203D, [2022-01-10T14:57:17.495052 #79] DEBUG -- : waiting for loading to complete...204D, [2022-01-10T14:57:17.509141 #79] DEBUG -- : loading complete after 0.014033607 seconds205D, [2022-01-10T14:57:17.542297 #79] DEBUG -- : clicking :sign_out_link with args {}206D, [2022-01-10T14:57:17.544889 #79] DEBUG -- : waiting for loading to complete...207D, [2022-01-10T14:57:17.552991 #79] DEBUG -- : loading complete after 0.008067538 seconds208D, [2022-01-10T14:57:17.917338 #79] DEBUG -- : end within element :user_menu with args {}209D, [2022-01-10T14:57:17.917383 #79] DEBUG -- : end within element :navbar with args {}210D, [2022-01-10T14:57:17.926089 #79] DEBUG -- : has_element? :login_page (wait: 0) returned: true211D, [2022-01-10T14:57:17.926162 #79] DEBUG -- : ==> Built a QA::EE::Resource::License via browser_ui in 10.725046212 seconds212I, [2022-01-10T14:57:17.946558 #79] INFO -- : ==== Knapsack specs to execute =====213I, [2022-01-10T14:57:17.946602 #79] INFO -- : Report specs:214I, [2022-01-10T14:57:17.948760 #79] INFO -- : qa/specs/features/ee/browser_ui/4_verify/pipelines_for_merged_results_and_merge_trains_spec.rb, qa/specs/features/ee/browser_ui/2_plan/multiple_assignees_for_issues/more_than_four_assignees_spec.rb, qa/specs/features/ee/browser_ui/2_plan/issue_boards/read_only_board_configuration_spec.rb, qa/specs/features/browser_ui/2_plan/issue/check_mentions_for_xss_spec.rb, qa/specs/features/browser_ui/2_plan/issue/mentions_spec.rb, qa/specs/features/ee/browser_ui/2_plan/issues_weight/issue_weight_visualization_spec.rb, qa/specs/features/browser_ui/2_plan/issue/comment_issue_spec.rb, qa/specs/features/ee/browser_ui/2_plan/issue_boards/sum_of_issues_weights_spec.rb215I, [2022-01-10T14:57:17.948786 #79] INFO -- : Leftover specs:216I, [2022-01-10T14:57:17.950438 #79] INFO -- : qa/specs/features/api/1_manage/import_github_repo_spec.rb, qa/specs/features/api/1_manage/users_spec.rb, qa/specs/features/api/3_create/gitaly/distributed_reads_spec.rb, qa/specs/features/api/3_create/merge_request/push_options_mwps_spec.rb, qa/specs/features/api/3_create/repository/files_spec.rb, qa/specs/features/api/5_package/container_registry_spec.rb, qa/specs/features/browser_ui/1_manage/group/create_group_with_mattermost_team_spec.rb, qa/specs/features/browser_ui/1_manage/login/log_in_spec.rb, qa/specs/features/browser_ui/1_manage/login/maintain_log_in_mixed_env_spec.rb, qa/specs/features/browser_ui/1_manage/project/import_github_repo_spec.rb, qa/specs/features/browser_ui/1_manage/user/follow_user_activity_spec.rb, qa/specs/features/browser_ui/2_plan/issue/filter_issue_comments_spec.rb, qa/specs/features/browser_ui/3_create/design_management/archive_design_content_spec.rb, qa/specs/features/browser_ui/3_create/merge_request/cherry_pick/cherry_pick_commit_spec.rb, qa/specs/features/browser_ui/3_create/merge_request/rebase_merge_request_spec.rb, qa/specs/features/browser_ui/3_create/merge_request/suggestions/custom_commit_suggestion_spec.rb, qa/specs/features/browser_ui/3_create/repository/branch_with_unusual_name_spec.rb, qa/specs/features/browser_ui/3_create/repository/file/file_with_unusual_name_spec.rb, qa/specs/features/browser_ui/3_create/repository/push_mirroring_lfs_over_http_spec.rb, qa/specs/features/browser_ui/3_create/repository/push_protected_branch_spec.rb, qa/specs/features/browser_ui/3_create/snippet/clone_push_pull_personal_snippet_spec.rb, qa/specs/features/browser_ui/3_create/snippet/create_project_snippet_spec.rb, qa/specs/features/browser_ui/3_create/web_ide/add_file_template_spec.rb, qa/specs/features/browser_ui/3_create/web_ide/open_web_ide_from_diff_tab_spec.rb, qa/specs/features/browser_ui/3_create/wiki/project_based_content_creation_spec.rb, qa/specs/features/browser_ui/4_verify/ci_variable/add_remove_ci_variable_spec.rb, qa/specs/features/browser_ui/4_verify/pipeline/locked_artifacts_spec.rb, qa/specs/features/browser_ui/4_verify/pipeline/run_pipeline_via_web_only_spec.rb, qa/specs/features/browser_ui/4_verify/testing/view_code_coverage_spec.rb, qa/specs/features/browser_ui/5_package/package_registry/composer_registry_spec.rb, qa/specs/features/browser_ui/5_package/package_registry/maven_repository_spec.rb, qa/specs/features/browser_ui/6_release/deploy_key/clone_using_deploy_key_spec.rb, qa/specs/features/browser_ui/7_configure/kubernetes/kubernetes_integration_spec.rb, qa/specs/features/ee/api/2_plan/epics_milestone_dates_spec.rb, qa/specs/features/ee/api/9_enablement/elasticsearch/index_tests/issues_index/issue_index_spec.rb, qa/specs/features/ee/browser_ui/10_protect/policies_list_spec.rb, qa/specs/features/ee/browser_ui/11_fulfillment/purchase/purchase_storage_spec.rb, qa/specs/features/ee/browser_ui/12_geo/geo_replication_ci_job_log_artifacts_spec.rb, qa/specs/features/ee/browser_ui/12_geo/http_push_to_secondary_spec.rb, qa/specs/features/ee/browser_ui/12_geo/wiki_http_push_to_secondary_spec.rb, qa/specs/features/ee/browser_ui/13_secure/license_compliance_spec.rb, qa/specs/features/ee/browser_ui/1_manage/group/group_audit_logs_1_spec.rb, qa/specs/features/ee/browser_ui/1_manage/group/group_saml_enforced_sso_new_account_spec.rb, qa/specs/features/ee/browser_ui/1_manage/insights/default_insights_spec.rb, qa/specs/features/ee/browser_ui/1_manage/user/minimal_access_user_spec.rb, qa/specs/features/ee/browser_ui/2_plan/scoped_labels/editing_scoped_labels_spec.rb, qa/specs/features/ee/browser_ui/3_create/repository/assign_code_owners_spec.rb, qa/specs/features/ee/browser_ui/3_create/repository/merge_with_code_owner_in_subgroup_spec.rb, qa/specs/features/ee/browser_ui/3_create/wiki/create_group_wiki_page_spec.rb, qa/specs/features/ee/browser_ui/4_verify/pipeline_subscription_with_group_owned_project_spec.rb, qa/specs/features/ee/browser_ui/9_enablement/elasticsearch/elasticsearch_reindexing_spec.rb217/usr/local/bundle/gems/capybara-3.35.3/lib/capybara/registration_container.rb:21: warning: DEPRECATED: Calling 'include?' on the drivers/servers container is deprecated without replacement218I, [2022-01-10T14:57:18.024547 #79] INFO -- : Knapsack time offset warning enabled!219Run options:220 include {:reliable=>true}221 exclude {:geo=>true, :skip_signup_disabled=>true, :requires_git_protocol_v2=>true}222Randomized with seed 20791223Plan224 Sum of issues weights on issue board225D, [2022-01-10T14:57:18.389475 #79] DEBUG -- : 226Starting test: Plan Sum of issues weights on issue board shows the sum of issues weights in the board list's header227D, [2022-01-10T14:57:18.409677 #79] DEBUG -- : has_element? :login_page (wait: 0) returned: true228D, [2022-01-10T14:57:18.417333 #79] DEBUG -- : has_element? :login_page (wait: 0) returned: true229D, [2022-01-10T14:57:18.529736 #79] DEBUG -- : waiting for loading to complete...230D, [2022-01-10T14:57:18.535001 #79] DEBUG -- : loading complete after 0.005191849 seconds231D, [2022-01-10T14:57:19.538804 #79] DEBUG -- : has_element? :sign_in_tab (wait: 0) returned: false232D, [2022-01-10T14:57:19.548930 #79] DEBUG -- : waiting for loading to complete...233D, [2022-01-10T14:57:19.554391 #79] DEBUG -- : loading complete after 0.005411639 seconds234D, [2022-01-10T14:57:20.559424 #79] DEBUG -- : has_element? :standard_tab (wait: 0) returned: false235D, [2022-01-10T14:57:20.559507 #79] DEBUG -- : filling :login_field with "root"236D, [2022-01-10T14:57:20.559758 #79] DEBUG -- : finding :login_field with args {}237D, [2022-01-10T14:57:20.562344 #79] DEBUG -- : waiting for loading to complete...238D, [2022-01-10T14:57:20.567103 #79] DEBUG -- : loading complete after 0.004710579 seconds239D, [2022-01-10T14:57:20.579316 #79] DEBUG -- : found :login_field240D, [2022-01-10T14:57:20.610478 #79] DEBUG -- : filling :password_field with "*****"241D, [2022-01-10T14:57:20.610540 #79] DEBUG -- : finding :password_field with args {}242D, [2022-01-10T14:57:20.613438 #79] DEBUG -- : waiting for loading to complete...243D, [2022-01-10T14:57:20.618385 #79] DEBUG -- : loading complete after 0.004898889 seconds244D, [2022-01-10T14:57:20.630750 #79] DEBUG -- : found :password_field245D, [2022-01-10T14:57:20.690974 #79] DEBUG -- : clicking :sign_in_button with args {}246D, [2022-01-10T14:57:20.693794 #79] DEBUG -- : waiting for loading to complete...247D, [2022-01-10T14:57:20.699828 #79] DEBUG -- : loading complete after 0.005980968 seconds248D, [2022-01-10T14:57:21.851810 #79] DEBUG -- : waiting for loading to complete...249D, [2022-01-10T14:57:21.859858 #79] DEBUG -- : loading complete after 0.007979109 seconds250D, [2022-01-10T14:57:21.880910 #79] DEBUG -- : has_no_element? :#<QA::Page::Element:0x000055a6c57b9168> (wait: 0) returned: false251D, [2022-01-10T14:57:21.883439 #79] DEBUG -- : waiting for loading to complete...252D, [2022-01-10T14:57:21.891901 #79] DEBUG -- : loading complete after 0.008419048 seconds253D, [2022-01-10T14:57:21.900227 #79] DEBUG -- : has_no_element? :#<QA::Page::Element:0x000055a6c57b8ec0> (wait: 0) returned: true254D, [2022-01-10T14:57:22.064509 #79] DEBUG -- : has_element? :navbar (wait: 60) returned: true255D, [2022-01-10T14:57:22.073193 #79] DEBUG -- : has_element? :user_avatar (wait: 60) returned: true256D, [2022-01-10T14:57:22.085412 #79] DEBUG -- : has_element? :user_menu (wait: 60) returned: true257D, [2022-01-10T14:57:22.096415 #79] DEBUG -- : has_element? :issues_shortcut_button (wait: 60) returned: true258D, [2022-01-10T14:57:22.107588 #79] DEBUG -- : has_element? :merge_requests_shortcut_button (wait: 60) returned: true259D, [2022-01-10T14:57:22.119354 #79] DEBUG -- : has_element? :todos_shortcut_button (wait: 60) returned: true260D, [2022-01-10T14:57:22.265570 #79] DEBUG -- : waiting for loading to complete...261D, [2022-01-10T14:57:22.274142 #79] DEBUG -- : loading complete after 0.008513818 seconds262D, [2022-01-10T14:57:23.275879 #79] DEBUG -- : has_element? :login_page (wait: 0) returned: false263D, [2022-01-10T14:57:23.284234 #79] DEBUG -- : has_element? :user_avatar (wait: 0) returned: true264D, [2022-01-10T14:57:23.284319 #79] DEBUG -- : within element :navbar with args {}265D, [2022-01-10T14:57:23.286670 #79] DEBUG -- : waiting for loading to complete...266D, [2022-01-10T14:57:23.294405 #79] DEBUG -- : loading complete after 0.007688528 seconds267D, [2022-01-10T14:57:23.306236 #79] DEBUG -- : clicking :user_avatar with args {}268D, [2022-01-10T14:57:23.308647 #79] DEBUG -- : waiting for loading to complete...269D, [2022-01-10T14:57:23.318845 #79] DEBUG -- : loading complete after 0.010149227 seconds270D, [2022-01-10T14:57:23.358835 #79] DEBUG -- : within element :user_menu with args {}271D, [2022-01-10T14:57:23.361711 #79] DEBUG -- : waiting for loading to complete...272D, [2022-01-10T14:57:23.372207 #79] DEBUG -- : loading complete after 0.010450537 seconds273D, [2022-01-10T14:57:23.385429 #79] DEBUG -- : clicking :edit_profile_link with args {}274D, [2022-01-10T14:57:23.387949 #79] DEBUG -- : waiting for loading to complete...275D, [2022-01-10T14:57:23.395344 #79] DEBUG -- : loading complete after 0.007346069 seconds276D, [2022-01-10T14:57:24.274399 #79] DEBUG -- : end within element :user_menu with args {}277D, [2022-01-10T14:57:24.274470 #79] DEBUG -- : end within element :navbar with args {}278D, [2022-01-10T14:57:24.277380 #79] DEBUG -- : waiting for loading to complete...279D, [2022-01-10T14:57:24.290667 #79] DEBUG -- : loading complete after 0.013240907 seconds280D, [2022-01-10T14:57:24.457445 #79] DEBUG -- : has_text?('User Settings', wait: 10) returned true281D, [2022-01-10T14:57:25.312040 #79] DEBUG -- : filling :access_token_name_field with "*****"282D, [2022-01-10T14:57:25.312415 #79] DEBUG -- : finding :access_token_name_field with args {}283D, [2022-01-10T14:57:25.381806 #79] DEBUG -- : waiting for loading to complete...284D, [2022-01-10T14:57:25.412546 #79] DEBUG -- : loading complete after 0.030355733 seconds285D, [2022-01-10T14:57:25.425928 #79] DEBUG -- : found :access_token_name_field286D, [2022-01-10T14:57:25.476700 #79] DEBUG -- : checking :api_checkbox287D, [2022-01-10T14:57:25.476777 #79] DEBUG -- : finding :api_checkbox with args {:visible=>false}288D, [2022-01-10T14:57:25.482271 #79] DEBUG -- : waiting for loading to complete...289D, [2022-01-10T14:57:25.490652 #79] DEBUG -- : loading complete after 0.008313008 seconds290D, [2022-01-10T14:57:25.501519 #79] DEBUG -- : found :api_checkbox291D, [2022-01-10T14:57:25.507647 #79] DEBUG -- : finding :api_checkbox with args {:visible=>false}292D, [2022-01-10T14:57:25.510142 #79] DEBUG -- : waiting for loading to complete...293D, [2022-01-10T14:57:25.519483 #79] DEBUG -- : loading complete after 0.009291488 seconds294D, [2022-01-10T14:57:25.525498 #79] DEBUG -- : found :api_checkbox295D, [2022-01-10T14:57:25.558614 #79] DEBUG -- : finding :api_checkbox with args {:visible=>false}296D, [2022-01-10T14:57:25.561293 #79] DEBUG -- : waiting for loading to complete...297D, [2022-01-10T14:57:25.571896 #79] DEBUG -- : loading complete after 0.010549087 seconds298D, [2022-01-10T14:57:25.577062 #79] DEBUG -- : found :api_checkbox299D, [2022-01-10T14:57:25.583633 #79] DEBUG -- : api_checkbox was checked300D, [2022-01-10T14:57:25.583841 #79] DEBUG -- : filling :expiry_date_field with "2022-01-12"301D, [2022-01-10T14:57:25.583950 #79] DEBUG -- : finding :expiry_date_field with args {}302D, [2022-01-10T14:57:25.586635 #79] DEBUG -- : waiting for loading to complete...303D, [2022-01-10T14:57:25.594916 #79] DEBUG -- : loading complete after 0.008234608 seconds304D, [2022-01-10T14:57:25.608805 #79] DEBUG -- : found :expiry_date_field305D, [2022-01-10T14:57:25.665913 #79] DEBUG -- : clicking :create_token_button with args {}306D, [2022-01-10T14:57:25.668681 #79] DEBUG -- : waiting for loading to complete...307D, [2022-01-10T14:57:25.676755 #79] DEBUG -- : loading complete after 0.008024568 seconds308D, [2022-01-10T14:57:26.322768 #79] DEBUG -- : finding :created_access_token with args {:wait=>30}309D, [2022-01-10T14:57:26.326709 #79] DEBUG -- : waiting for loading to complete...310D, [2022-01-10T14:57:26.401968 #79] DEBUG -- : loading complete after 0.074980973 seconds311D, [2022-01-10T14:57:26.416505 #79] DEBUG -- : found :created_access_token312D, [2022-01-10T14:57:26.422982 #79] DEBUG -- : ==> Built a QA::Resource::PersonalAccessToken via api in 4.166065812 seconds313D, [2022-01-10T14:57:27.755666 #79] DEBUG -- : ==> Built a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group' via api in 5.501580604 seconds314D, [2022-01-10T14:57:28.750978 #79] DEBUG -- : <QA::Resource::Group> Attribute :full_path has both API response `gitlab-qa-sandbox-group/qa-test-2022-01-10-14-57-22-941745e58b2d5a1c` and a block. API response will be picked. Block will be ignored.315D, [2022-01-10T14:57:28.751100 #79] DEBUG -- : ==> Built a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group/qa-test-2022-01-10-14-57-22-941745e58b2d5a1c' via api in 6.499441984 seconds316D, [2022-01-10T14:57:30.339325 #79] DEBUG -- : ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group/qa-test-2022-01-10-14-57-22-941745e58b2d5a1c/project-with-board-list-545832576f4219c0' via api in 8.091622719 seconds317D, [2022-01-10T14:57:30.998422 #79] DEBUG -- : ==> Built a QA::EE::Resource::Board::ProjectBoard with name 'Downstream' via api in 0.659001538 seconds318D, [2022-01-10T14:57:31.326363 #79] DEBUG -- : ==> Built a QA::Resource::ProjectLabel with id '31' via api in 0.321681977 seconds319D, [2022-01-10T14:57:31.545176 #79] DEBUG -- : ==> Built a QA::EE::Resource::Board::BoardList::Project::LabelBoardList with id '3' via api in 9.310599448 seconds320D, [2022-01-10T14:57:32.466185 #79] DEBUG -- : ==> Built a QA::Resource::Issue with id '31' via api in 0.920874758 seconds321D, [2022-01-10T14:57:33.228423 #79] DEBUG -- : ==> Built a QA::Resource::Issue with id '32' via api in 0.759204754 seconds322D, [2022-01-10T14:57:33.228526 #79] DEBUG -- : Visiting QA::Resource::Project at "https://gitlab-review-pedropombe-dh031e.gitlab-review.app/gitlab-qa-sandbox-group/qa-test-2022-01-10-14-57-22-941745e58b2d5a1c/project-with-board-list-545832576f4219c0"323D, [2022-01-10T14:57:36.458856 #79] DEBUG -- : waiting for loading to complete...324D, [2022-01-10T14:57:36.470814 #79] DEBUG -- : loading complete after 0.011895878 seconds325D, [2022-01-10T14:57:36.470866 #79] DEBUG -- : within element :project_sidebar with args {}326D, [2022-01-10T14:57:36.473261 #79] DEBUG -- : waiting for loading to complete...327D, [2022-01-10T14:57:36.485109 #79] DEBUG -- : loading complete after 0.011779627 seconds328D, [2022-01-10T14:57:36.496668 #79] DEBUG -- : scrolling to :[data-qa-selector="sidebar_menu_link"],.qa-sidebar-menu-link329D, [2022-01-10T14:57:36.499153 #79] DEBUG -- : waiting for loading to complete...330D, [2022-01-10T14:57:36.506522 #79] DEBUG -- : loading complete after 0.007322518 seconds331D, [2022-01-10T14:57:36.509724 #79] DEBUG -- : finding :sidebar_menu_link with args {:menu_item=>"Issues"}332D, [2022-01-10T14:57:36.512167 #79] DEBUG -- : waiting for loading to complete...333D, [2022-01-10T14:57:36.517104 #79] DEBUG -- : loading complete after 0.004891169 seconds334D, [2022-01-10T14:57:36.528048 #79] DEBUG -- : found :sidebar_menu_link335D, [2022-01-10T14:57:36.806406 #79] DEBUG -- : clicking :sidebar_menu_item_link with args {:menu_item=>"Boards"}336D, [2022-01-10T14:57:36.808918 #79] DEBUG -- : waiting for loading to complete...337D, [2022-01-10T14:57:36.816326 #79] DEBUG -- : loading complete after 0.007356699 seconds338D, [2022-01-10T14:57:38.251388 #79] DEBUG -- : end within element :project_sidebar with args {}339D, [2022-01-10T14:57:38.289770 #79] DEBUG -- : within element :boards_list with args {}340D, [2022-01-10T14:57:38.389883 #79] DEBUG -- : waiting for loading to complete...341D, [2022-01-10T14:57:38.491680 #79] DEBUG -- : loading complete after 0.101708886 seconds342D, [2022-01-10T14:57:38.505115 #79] DEBUG -- : waiting for loading to complete...343D, [2022-01-10T14:57:38.513775 #79] DEBUG -- : loading complete after 0.008590338 seconds344D, [2022-01-10T14:57:38.513823 #79] DEBUG -- : within elements :board_list at index 1345D, [2022-01-10T14:57:38.513862 #79] DEBUG -- : finding all :board_list with args {:minimum=>2}346D, [2022-01-10T14:57:38.516492 #79] DEBUG -- : waiting for loading to complete...347D, [2022-01-10T14:57:38.522104 #79] DEBUG -- : loading complete after 0.005569398 seconds348D, [2022-01-10T14:57:38.921406 #79] DEBUG -- : found 3 :board_list349D, [2022-01-10T14:57:38.921506 #79] DEBUG -- : finding :board_list_header with args {}350D, [2022-01-10T14:57:38.924794 #79] DEBUG -- : waiting for loading to complete...351D, [2022-01-10T14:57:39.389495 #79] DEBUG -- : loading complete after 0.464621433 seconds352D, [2022-01-10T14:57:39.427532 #79] DEBUG -- : found :board_list_header353D, [2022-01-10T14:57:39.427599 #79] DEBUG -- : end within elements :board_list at index 1354D, [2022-01-10T14:57:39.427620 #79] DEBUG -- : end within element :boards_list with args {}355 shows the sum of issues weights in the board list's header356Plan357 Read-only board configuration358D, [2022-01-10T14:57:39.529707 #79] DEBUG -- : 359Starting test: Plan Read-only board configuration shows board configuration to user without edit permission360D, [2022-01-10T14:57:39.794943 #79] DEBUG -- : ==> Built a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group' via api in 0.252798311 seconds361D, [2022-01-10T14:57:40.118158 #79] DEBUG -- : <QA::Resource::Group> Attribute :full_path has both API response `gitlab-qa-sandbox-group/qa-test-2022-01-10-14-57-22-941745e58b2d5a1c` and a block. API response will be picked. Block will be ignored.362D, [2022-01-10T14:57:40.118241 #79] DEBUG -- : ==> Built a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group/qa-test-2022-01-10-14-57-22-941745e58b2d5a1c' via api in 0.578197256 seconds363D, [2022-01-10T14:57:41.333582 #79] DEBUG -- : ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group/qa-test-2022-01-10-14-57-22-941745e58b2d5a1c/project-with-board-list-2af3852e8cb947c2' via api in 1.795808895 seconds364D, [2022-01-10T14:57:41.757321 #79] DEBUG -- : ==> Built a QA::EE::Resource::Board::ProjectBoard with name 'Downstream' via api in 0.423641802 seconds365D, [2022-01-10T14:57:42.021543 #79] DEBUG -- : ==> Built a QA::Resource::ProjectLabel with id '32' via api in 0.260966891 seconds366D, [2022-01-10T14:57:42.213518 #79] DEBUG -- : ==> Built a QA::EE::Resource::Board::BoardList::Project::LabelBoardList with id '6' via api in 2.680104612 seconds367I, [2022-01-10T14:57:42.213601 #79] INFO -- : Enabling feature: invite_members_group_modal for scope "project: gitlab-qa-sandbox-group/qa-test-2022-01-10-14-57-22-941745e58b2d5a1c/project-with-board-list-2af3852e8cb947c2"368D, [2022-01-10T14:57:43.555128 #79] DEBUG -- : Retrying action with: max_duration: 60; sleep_interval: 1; raise_on_failure: true; retry_on_exception: false369D, [2022-01-10T14:57:43.684566 #79] DEBUG -- : ended retry370I, [2022-01-10T14:57:43.684626 #79] INFO -- : Successfully enabled and verified feature flag: invite_members_group_modal371/usr/local/bundle/gems/capybara-3.35.3/lib/capybara/registration_container.rb:21: warning: DEPRECATED: Calling 'include?' on the drivers/servers container is deprecated without replacement372D, [2022-01-10T14:57:43.985217 #79] DEBUG -- : has_element? :login_page (wait: 60) returned: true373D, [2022-01-10T14:57:43.994128 #79] DEBUG -- : has_element? :login_page (wait: 0) returned: true374D, [2022-01-10T14:57:44.004522 #79] DEBUG -- : has_element? :login_page (wait: 0) returned: true375D, [2022-01-10T14:57:44.104523 #79] DEBUG -- : waiting for loading to complete...376D, [2022-01-10T14:57:44.109634 #79] DEBUG -- : loading complete after 0.005030329 seconds377D, [2022-01-10T14:57:45.120515 #79] DEBUG -- : has_element? :sign_in_tab (wait: 0) returned: false378D, [2022-01-10T14:57:45.130812 #79] DEBUG -- : waiting for loading to complete...379D, [2022-01-10T14:57:45.135697 #79] DEBUG -- : loading complete after 0.004826709 seconds380D, [2022-01-10T14:57:46.137586 #79] DEBUG -- : has_element? :standard_tab (wait: 0) returned: false381D, [2022-01-10T14:57:46.137687 #79] DEBUG -- : filling :login_field with "root"382D, [2022-01-10T14:57:46.137724 #79] DEBUG -- : finding :login_field with args {}383D, [2022-01-10T14:57:46.140199 #79] DEBUG -- : waiting for loading to complete...384D, [2022-01-10T14:57:46.145054 #79] DEBUG -- : loading complete after 0.004804879 seconds385D, [2022-01-10T14:57:46.157686 #79] DEBUG -- : found :login_field386D, [2022-01-10T14:57:46.186300 #79] DEBUG -- : filling :password_field with "*****"387D, [2022-01-10T14:57:46.186412 #79] DEBUG -- : finding :password_field with args {}388D, [2022-01-10T14:57:46.189051 #79] DEBUG -- : waiting for loading to complete...389D, [2022-01-10T14:57:46.194105 #79] DEBUG -- : loading complete after 0.005003039 seconds390D, [2022-01-10T14:57:46.207915 #79] DEBUG -- : found :password_field391D, [2022-01-10T14:57:46.271278 #79] DEBUG -- : clicking :sign_in_button with args {}392D, [2022-01-10T14:57:46.274123 #79] DEBUG -- : waiting for loading to complete...393D, [2022-01-10T14:57:46.280846 #79] DEBUG -- : loading complete after 0.006670529 seconds394D, [2022-01-10T14:57:47.209637 #79] DEBUG -- : waiting for loading to complete...395D, [2022-01-10T14:57:47.218135 #79] DEBUG -- : loading complete after 0.008417928 seconds396D, [2022-01-10T14:57:47.240511 #79] DEBUG -- : has_no_element? :#<QA::Page::Element:0x000055a6c57b9168> (wait: 0) returned: false397D, [2022-01-10T14:57:47.243096 #79] DEBUG -- : waiting for loading to complete...398D, [2022-01-10T14:57:47.251312 #79] DEBUG -- : loading complete after 0.008167107 seconds399D, [2022-01-10T14:57:47.259680 #79] DEBUG -- : has_no_element? :#<QA::Page::Element:0x000055a6c57b8ec0> (wait: 0) returned: true400D, [2022-01-10T14:57:47.474197 #79] DEBUG -- : has_element? :navbar (wait: 60) returned: true401D, [2022-01-10T14:57:47.484843 #79] DEBUG -- : has_element? :user_avatar (wait: 60) returned: true402D, [2022-01-10T14:57:47.496289 #79] DEBUG -- : has_element? :user_menu (wait: 60) returned: true403D, [2022-01-10T14:57:47.508360 #79] DEBUG -- : has_element? :issues_shortcut_button (wait: 60) returned: true404D, [2022-01-10T14:57:47.519489 #79] DEBUG -- : has_element? :merge_requests_shortcut_button (wait: 60) returned: true405D, [2022-01-10T14:57:47.530804 #79] DEBUG -- : has_element? :todos_shortcut_button (wait: 60) returned: true406D, [2022-01-10T14:57:48.279935 #79] DEBUG -- : ==> Built a QA::Resource::User with username 'gitlab-qa-user1' via api in 0.593699513 seconds407D, [2022-01-10T14:57:48.280082 #79] DEBUG -- : Adding user gitlab-qa-user1 to gitlab-qa-sandbox-group/qa-test-2022-01-10-14-57-22-941745e58b2d5a1c/project-with-board-list-2af3852e8cb947c2 QA::Resource::Project408D, [2022-01-10T14:57:49.010206 #79] DEBUG -- : waiting for loading to complete...409D, [2022-01-10T14:57:49.019186 #79] DEBUG -- : loading complete after 0.008914818 seconds410D, [2022-01-10T14:57:50.035139 #79] DEBUG -- : has_element? :login_page (wait: 0) returned: false411D, [2022-01-10T14:57:50.043454 #79] DEBUG -- : has_element? :user_avatar (wait: 0) returned: true412D, [2022-01-10T14:57:50.260966 #79] DEBUG -- : waiting for loading to complete...413D, [2022-01-10T14:57:50.268997 #79] DEBUG -- : loading complete after 0.007944938 seconds414D, [2022-01-10T14:57:51.269479 #79] DEBUG -- : has_element? :login_page (wait: 0) returned: false415D, [2022-01-10T14:57:51.278706 #79] DEBUG -- : has_element? :user_avatar (wait: 0) returned: true416D, [2022-01-10T14:57:51.278753 #79] DEBUG -- : within element :navbar with args {}417D, [2022-01-10T14:57:51.281290 #79] DEBUG -- : waiting for loading to complete...418D, [2022-01-10T14:57:51.289881 #79] DEBUG -- : loading complete after 0.008545707 seconds419D, [2022-01-10T14:57:51.300503 #79] DEBUG -- : clicking :user_avatar with args {}420D, [2022-01-10T14:57:51.303095 #79] DEBUG -- : waiting for loading to complete...421D, [2022-01-10T14:57:51.313577 #79] DEBUG -- : loading complete after 0.010430827 seconds422D, [2022-01-10T14:57:51.361544 #79] DEBUG -- : within element :user_menu with args {}423D, [2022-01-10T14:57:51.371145 #79] DEBUG -- : waiting for loading to complete...424D, [2022-01-10T14:57:51.386439 #79] DEBUG -- : loading complete after 0.015205206 seconds425D, [2022-01-10T14:57:51.424683 #79] DEBUG -- : clicking :sign_out_link with args {}426D, [2022-01-10T14:57:51.427649 #79] DEBUG -- : waiting for loading to complete...427D, [2022-01-10T14:57:51.436507 #79] DEBUG -- : loading complete after 0.008805938 seconds428D, [2022-01-10T14:57:51.957385 #79] DEBUG -- : end within element :user_menu with args {}429D, [2022-01-10T14:57:51.957448 #79] DEBUG -- : end within element :navbar with args {}430D, [2022-01-10T14:57:51.968529 #79] DEBUG -- : has_element? :login_page (wait: 0) returned: true431D, [2022-01-10T14:58:01.976382 #79] DEBUG -- : waiting for loading to complete...432D, [2022-01-10T14:58:01.982131 #79] DEBUG -- : loading complete after 0.005682689 seconds433D, [2022-01-10T14:58:02.989640 #79] DEBUG -- : has_element? :sign_in_tab (wait: 10) returned: false434D, [2022-01-10T14:58:02.997628 #79] DEBUG -- : has_element? :login_page (wait: 0) returned: true435D, [2022-01-10T14:58:03.121753 #79] DEBUG -- : waiting for loading to complete...436D, [2022-01-10T14:58:03.126517 #79] DEBUG -- : loading complete after 0.004690729 seconds437D, [2022-01-10T14:58:04.141001 #79] DEBUG -- : has_element? :sign_in_tab (wait: 0) returned: false438D, [2022-01-10T14:58:04.152193 #79] DEBUG -- : waiting for loading to complete...439D, [2022-01-10T14:58:04.156899 #79] DEBUG -- : loading complete after 0.004650539 seconds440D, [2022-01-10T14:58:05.159657 #79] DEBUG -- : has_element? :standard_tab (wait: 0) returned: false441D, [2022-01-10T14:58:05.159731 #79] DEBUG -- : filling :login_field with "gitlab-qa-user1"442D, [2022-01-10T14:58:05.159755 #79] DEBUG -- : finding :login_field with args {}443D, [2022-01-10T14:58:05.162217 #79] DEBUG -- : waiting for loading to complete...444D, [2022-01-10T14:58:05.166964 #79] DEBUG -- : loading complete after 0.004699609 seconds445D, [2022-01-10T14:58:05.179221 #79] DEBUG -- : found :login_field446D, [2022-01-10T14:58:05.225283 #79] DEBUG -- : filling :password_field with "*****"447D, [2022-01-10T14:58:05.225358 #79] DEBUG -- : finding :password_field with args {}448D, [2022-01-10T14:58:05.228234 #79] DEBUG -- : waiting for loading to complete...449D, [2022-01-10T14:58:05.233174 #79] DEBUG -- : loading complete after 0.004893799 seconds450D, [2022-01-10T14:58:05.244559 #79] DEBUG -- : found :password_field451D, [2022-01-10T14:58:05.283849 #79] DEBUG -- : clicking :sign_in_button with args {}452D, [2022-01-10T14:58:05.286536 #79] DEBUG -- : waiting for loading to complete...453D, [2022-01-10T14:58:05.291574 #79] DEBUG -- : loading complete after 0.004989089 seconds454D, [2022-01-10T14:58:06.191743 #79] DEBUG -- : waiting for loading to complete...455D, [2022-01-10T14:58:06.200105 #79] DEBUG -- : loading complete after 0.008285898 seconds456D, [2022-01-10T14:58:06.221467 #79] DEBUG -- : has_no_element? :#<QA::Page::Element:0x000055a6c57b9168> (wait: 0) returned: false457D, [2022-01-10T14:58:06.223903 #79] DEBUG -- : waiting for loading to complete...458D, [2022-01-10T14:58:06.231810 #79] DEBUG -- : loading complete after 0.007858608 seconds459D, [2022-01-10T14:58:06.239163 #79] DEBUG -- : has_no_element? :#<QA::Page::Element:0x000055a6c57b8ec0> (wait: 0) returned: true460D, [2022-01-10T14:58:06.381206 #79] DEBUG -- : has_element? :navbar (wait: 60) returned: true461D, [2022-01-10T14:58:06.391765 #79] DEBUG -- : has_element? :user_avatar (wait: 60) returned: true462D, [2022-01-10T14:58:06.402827 #79] DEBUG -- : has_element? :user_menu (wait: 60) returned: true463D, [2022-01-10T14:58:06.414878 #79] DEBUG -- : has_element? :issues_shortcut_button (wait: 60) returned: true464D, [2022-01-10T14:58:06.426086 #79] DEBUG -- : has_element? :merge_requests_shortcut_button (wait: 60) returned: true465D, [2022-01-10T14:58:06.437201 #79] DEBUG -- : has_element? :todos_shortcut_button (wait: 60) returned: true466D, [2022-01-10T14:58:06.522912 #79] DEBUG -- : Visiting QA::Resource::Project at "https://gitlab-review-pedropombe-dh031e.gitlab-review.app/gitlab-qa-sandbox-group/qa-test-2022-01-10-14-57-22-941745e58b2d5a1c/project-with-board-list-2af3852e8cb947c2"467D, [2022-01-10T14:58:07.313986 #79] DEBUG -- : waiting for loading to complete...468D, [2022-01-10T14:58:07.322141 #79] DEBUG -- : loading complete after 0.008065208 seconds469D, [2022-01-10T14:58:07.322196 #79] DEBUG -- : within element :project_sidebar with args {}470D, [2022-01-10T14:58:07.324804 #79] DEBUG -- : waiting for loading to complete...471D, [2022-01-10T14:58:07.332686 #79] DEBUG -- : loading complete after 0.007834548 seconds472D, [2022-01-10T14:58:07.343969 #79] DEBUG -- : scrolling to :[data-qa-selector="sidebar_menu_link"],.qa-sidebar-menu-link473D, [2022-01-10T14:58:07.346585 #79] DEBUG -- : waiting for loading to complete...474D, [2022-01-10T14:58:07.354911 #79] DEBUG -- : loading complete after 0.008278018 seconds475D, [2022-01-10T14:58:07.358183 #79] DEBUG -- : finding :sidebar_menu_link with args {:menu_item=>"Issues"}476D, [2022-01-10T14:58:07.360679 #79] DEBUG -- : waiting for loading to complete...477D, [2022-01-10T14:58:07.366252 #79] DEBUG -- : loading complete after 0.005512379 seconds478D, [2022-01-10T14:58:07.377570 #79] DEBUG -- : found :sidebar_menu_link479D, [2022-01-10T14:58:07.654947 #79] DEBUG -- : clicking :sidebar_menu_item_link with args {:menu_item=>"Boards"}480D, [2022-01-10T14:58:07.657556 #79] DEBUG -- : waiting for loading to complete...481D, [2022-01-10T14:58:07.664886 #79] DEBUG -- : loading complete after 0.007281839 seconds482D, [2022-01-10T14:58:08.478303 #79] DEBUG -- : end within element :project_sidebar with args {}483D, [2022-01-10T14:58:08.478711 #79] DEBUG -- : clicking :boards_config_button with args {}484D, [2022-01-10T14:58:08.562673 #79] DEBUG -- : waiting for loading to complete...485D, [2022-01-10T14:58:09.265609 #79] DEBUG -- : loading complete after 0.702623468 seconds486D, [2022-01-10T14:58:09.459402 #79] DEBUG -- : waiting for loading to complete...487D, [2022-01-10T14:58:09.472163 #79] DEBUG -- : loading complete after 0.012383987 seconds488D, [2022-01-10T14:58:09.472228 #79] DEBUG -- : finding :board_scope_modal with args {}489D, [2022-01-10T14:58:09.474784 #79] DEBUG -- : waiting for loading to complete...490D, [2022-01-10T14:58:09.488599 #79] DEBUG -- : loading complete after 0.013766107 seconds491D, [2022-01-10T14:58:09.504976 #79] DEBUG -- : found :board_scope_modal492D, [2022-01-10T14:58:10.517095 #79] DEBUG -- : waiting for loading to complete...493D, [2022-01-10T14:58:10.525087 #79] DEBUG -- : loading complete after 0.007919238 seconds494D, [2022-01-10T14:58:11.526080 #79] DEBUG -- : has_element? :board_name_field (wait: 1) returned: false495 shows board configuration to user without edit permission496Plan497 Issues weight visualization498D, [2022-01-10T14:58:11.579600 #79] DEBUG -- : 499Starting test: Plan Issues weight visualization shows the set weight in the issue page, in the milestone page, and in the issues list page500/usr/local/bundle/gems/capybara-3.35.3/lib/capybara/registration_container.rb:21: warning: DEPRECATED: Calling 'include?' on the drivers/servers container is deprecated without replacement501D, [2022-01-10T14:58:11.869717 #79] DEBUG -- : has_element? :login_page (wait: 60) returned: true502D, [2022-01-10T14:58:11.879420 #79] DEBUG -- : has_element? :login_page (wait: 0) returned: true503D, [2022-01-10T14:58:11.887509 #79] DEBUG -- : has_element? :login_page (wait: 0) returned: true504D, [2022-01-10T14:58:11.991642 #79] DEBUG -- : waiting for loading to complete...505D, [2022-01-10T14:58:11.997479 #79] DEBUG -- : loading complete after 0.005772148 seconds506D, [2022-01-10T14:58:12.999525 #79] DEBUG -- : has_element? :sign_in_tab (wait: 0) returned: false507D, [2022-01-10T14:58:13.010139 #79] DEBUG -- : waiting for loading to complete...508D, [2022-01-10T14:58:13.015054 #79] DEBUG -- : loading complete after 0.004822188 seconds509D, [2022-01-10T14:58:14.022041 #79] DEBUG -- : has_element? :standard_tab (wait: 0) returned: false510D, [2022-01-10T14:58:14.022142 #79] DEBUG -- : filling :login_field with "root"511D, [2022-01-10T14:58:14.022186 #79] DEBUG -- : finding :login_field with args {}512D, [2022-01-10T14:58:14.024604 #79] DEBUG -- : waiting for loading to complete...513D, [2022-01-10T14:58:14.029458 #79] DEBUG -- : loading complete after 0.004799359 seconds514D, [2022-01-10T14:58:14.038353 #79] DEBUG -- : found :login_field515D, [2022-01-10T14:58:14.068685 #79] DEBUG -- : filling :password_field with "*****"516D, [2022-01-10T14:58:14.068755 #79] DEBUG -- : finding :password_field with args {}517D, [2022-01-10T14:58:14.071372 #79] DEBUG -- : waiting for loading to complete...518D, [2022-01-10T14:58:14.076328 #79] DEBUG -- : loading complete after 0.004908189 seconds519D, [2022-01-10T14:58:14.086753 #79] DEBUG -- : found :password_field520D, [2022-01-10T14:58:14.155014 #79] DEBUG -- : clicking :sign_in_button with args {}521D, [2022-01-10T14:58:14.157788 #79] DEBUG -- : waiting for loading to complete...522D, [2022-01-10T14:58:14.164378 #79] DEBUG -- : loading complete after 0.006536819 seconds523D, [2022-01-10T14:58:15.547307 #79] DEBUG -- : waiting for loading to complete...524D, [2022-01-10T14:58:15.556273 #79] DEBUG -- : loading complete after 0.008894148 seconds525D, [2022-01-10T14:58:15.579077 #79] DEBUG -- : has_no_element? :#<QA::Page::Element:0x000055a6c57b9168> (wait: 0) returned: false526D, [2022-01-10T14:58:15.581536 #79] DEBUG -- : waiting for loading to complete...527D, [2022-01-10T14:58:15.589418 #79] DEBUG -- : loading complete after 0.007781749 seconds528D, [2022-01-10T14:58:15.596897 #79] DEBUG -- : has_no_element? :#<QA::Page::Element:0x000055a6c57b8ec0> (wait: 0) returned: true529D, [2022-01-10T14:58:15.943991 #79] DEBUG -- : has_element? :navbar (wait: 60) returned: true530D, [2022-01-10T14:58:15.954496 #79] DEBUG -- : has_element? :user_avatar (wait: 60) returned: true531D, [2022-01-10T14:58:15.965281 #79] DEBUG -- : has_element? :user_menu (wait: 60) returned: true532D, [2022-01-10T14:58:15.976309 #79] DEBUG -- : has_element? :issues_shortcut_button (wait: 60) returned: true533D, [2022-01-10T14:58:15.987333 #79] DEBUG -- : has_element? :merge_requests_shortcut_button (wait: 60) returned: true534D, [2022-01-10T14:58:15.998377 #79] DEBUG -- : has_element? :todos_shortcut_button (wait: 60) returned: true535D, [2022-01-10T14:58:16.466729 #79] DEBUG -- : ==> Built a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group' via api in 0.243909014 seconds536D, [2022-01-10T14:58:17.269163 #79] DEBUG -- : <QA::Resource::Group> Attribute :full_path has both API response `gitlab-qa-sandbox-group/qa-test-2022-01-10-14-57-22-941745e58b2d5a1c` and a block. API response will be picked. Block will be ignored.537D, [2022-01-10T14:58:17.269295 #79] DEBUG -- : ==> Built a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group/qa-test-2022-01-10-14-57-22-941745e58b2d5a1c' via api in 1.048452207 seconds538D, [2022-01-10T14:58:18.132220 #79] DEBUG -- : ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group/qa-test-2022-01-10-14-57-22-941745e58b2d5a1c/project-with-milestone-ed09b015939fc623' via api in 1.913577359 seconds539D, [2022-01-10T14:58:18.610611 #79] DEBUG -- : ==> Built a QA::Resource::ProjectMilestone with id '5' via api in 2.394108339 seconds540D, [2022-01-10T14:58:19.255658 #79] DEBUG -- : ==> Built a QA::Resource::Issue with id '41' via api in 0.644767721 seconds541D, [2022-01-10T14:58:19.255738 #79] DEBUG -- : Visiting QA::Resource::Issue at "https://gitlab-review-pedropombe-dh031e.gitlab-review.app/gitlab-qa-sandbox-group/qa-test-2022-01-10-14-57-22-941745e58b2d5a1c/project-with-milestone-ed09b015939fc623/-/issues/1"542D, [2022-01-10T14:58:21.894223 #79] DEBUG -- : finding :weight_label_value with args {}543D, [2022-01-10T14:58:21.898853 #79] DEBUG -- : waiting for loading to complete...544D, [2022-01-10T14:58:21.908585 #79] DEBUG -- : loading complete after 0.009676358 seconds545D, [2022-01-10T14:58:21.922712 #79] DEBUG -- : found :weight_label_value546D, [2022-01-10T14:58:21.933068 #79] DEBUG -- : clicking :milestone_link with args {}547D, [2022-01-10T14:58:21.935805 #79] DEBUG -- : waiting for loading to complete...548D, [2022-01-10T14:58:21.945946 #79] DEBUG -- : loading complete after 0.010094938 seconds549D, [2022-01-10T14:58:24.545524 #79] DEBUG -- : finding :total_issue_weight_value with args {}550D, [2022-01-10T14:58:24.659727 #79] DEBUG -- : waiting for loading to complete...551D, [2022-01-10T14:58:24.705228 #79] DEBUG -- : loading complete after 0.04542165 seconds552D, [2022-01-10T14:58:24.717077 #79] DEBUG -- : found :total_issue_weight_value553D, [2022-01-10T14:58:24.728377 #79] DEBUG -- : waiting for loading to complete...554D, [2022-01-10T14:58:24.738012 #79] DEBUG -- : loading complete after 0.009579657 seconds555D, [2022-01-10T14:58:24.738093 #79] DEBUG -- : within element :project_sidebar with args {}556D, [2022-01-10T14:58:24.740514 #79] DEBUG -- : waiting for loading to complete...557D, [2022-01-10T14:58:24.748696 #79] DEBUG -- : loading complete after 0.008135498 seconds558D, [2022-01-10T14:58:24.761197 #79] DEBUG -- : clicking :sidebar_menu_link with args {:menu_item=>"Issues"}559D, [2022-01-10T14:58:24.763591 #79] DEBUG -- : waiting for loading to complete...560D, [2022-01-10T14:58:24.770903 #79] DEBUG -- : loading complete after 0.007263148 seconds561D, [2022-01-10T14:58:26.467788 #79] DEBUG -- : end within element :project_sidebar with args {}562D, [2022-01-10T14:58:26.469119 #79] DEBUG -- : finding :issuable_weight_content with args {}563D, [2022-01-10T14:58:26.471891 #79] DEBUG -- : waiting for loading to complete...564D, [2022-01-10T14:58:26.595884 #79] DEBUG -- : loading complete after 0.123938122 seconds565D, [2022-01-10T14:58:26.608932 #79] DEBUG -- : found :issuable_weight_content566 shows the set weight in the issue page, in the milestone page, and in the issues list page567Plan568 Multiple assignees per issue569D, [2022-01-10T14:58:26.673223 #79] DEBUG -- : 570Starting test: Plan Multiple assignees per issue shows the first three assignees and a +n sign in the issues list571D, [2022-01-10T14:58:26.917926 #79] DEBUG -- : ==> Built a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group' via api in 0.237793876 seconds572D, [2022-01-10T14:58:27.559973 #79] DEBUG -- : <QA::Resource::Group> Attribute :full_path has both API response `gitlab-qa-sandbox-group/qa-test-2022-01-10-14-57-22-941745e58b2d5a1c` and a block. API response will be picked. Block will be ignored.573D, [2022-01-10T14:58:27.560091 #79] DEBUG -- : ==> Built a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group/qa-test-2022-01-10-14-57-22-941745e58b2d5a1c' via api in 0.882026997 seconds574D, [2022-01-10T14:58:28.904752 #79] DEBUG -- : ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group/qa-test-2022-01-10-14-57-22-941745e58b2d5a1c/project-to-test-issue-with-multiple-assignees-93b7c48740b929d2' via api in 2.229019836 seconds575I, [2022-01-10T14:58:28.904853 #79] INFO -- : Enabling feature: invite_members_group_modal for scope "project: gitlab-qa-sandbox-group/qa-test-2022-01-10-14-57-22-941745e58b2d5a1c/project-to-test-issue-with-multiple-assignees-93b7c48740b929d2"576I, [2022-01-10T14:58:29.267267 #79] INFO -- : Successfully enabled and verified feature flag: invite_members_group_modal577/usr/local/bundle/gems/capybara-3.35.3/lib/capybara/registration_container.rb:21: warning: DEPRECATED: Calling 'include?' on the drivers/servers container is deprecated without replacement578D, [2022-01-10T14:58:29.630654 #79] DEBUG -- : has_element? :login_page (wait: 60) returned: true579D, [2022-01-10T14:58:29.639134 #79] DEBUG -- : has_element? :login_page (wait: 0) returned: true580D, [2022-01-10T14:58:29.647629 #79] DEBUG -- : has_element? :login_page (wait: 0) returned: true581D, [2022-01-10T14:58:29.749557 #79] DEBUG -- : waiting for loading to complete...582D, [2022-01-10T14:58:29.754403 #79] DEBUG -- : loading complete after 0.004779529 seconds583D, [2022-01-10T14:58:30.756239 #79] DEBUG -- : has_element? :sign_in_tab (wait: 0) returned: false584D, [2022-01-10T14:58:30.763597 #79] DEBUG -- : waiting for loading to complete...585D, [2022-01-10T14:58:30.768363 #79] DEBUG -- : loading complete after 0.004707439 seconds586D, [2022-01-10T14:58:31.773912 #79] DEBUG -- : has_element? :standard_tab (wait: 0) returned: false587D, [2022-01-10T14:58:31.773996 #79] DEBUG -- : filling :login_field with "root"588D, [2022-01-10T14:58:31.774270 #79] DEBUG -- : finding :login_field with args {}589D, [2022-01-10T14:58:31.776756 #79] DEBUG -- : waiting for loading to complete...590D, [2022-01-10T14:58:31.781396 #79] DEBUG -- : loading complete after 0.004593289 seconds591D, [2022-01-10T14:58:31.789997 #79] DEBUG -- : found :login_field592D, [2022-01-10T14:58:31.819294 #79] DEBUG -- : filling :password_field with "*****"593D, [2022-01-10T14:58:31.819363 #79] DEBUG -- : finding :password_field with args {}594D, [2022-01-10T14:58:31.821841 #79] DEBUG -- : waiting for loading to complete...595D, [2022-01-10T14:58:31.827472 #79] DEBUG -- : loading complete after 0.005580448 seconds596D, [2022-01-10T14:58:31.836349 #79] DEBUG -- : found :password_field597D, [2022-01-10T14:58:31.902635 #79] DEBUG -- : clicking :sign_in_button with args {}598D, [2022-01-10T14:58:31.905318 #79] DEBUG -- : waiting for loading to complete...599D, [2022-01-10T14:58:31.910355 #79] DEBUG -- : loading complete after 0.004985759 seconds600D, [2022-01-10T14:58:32.847972 #79] DEBUG -- : waiting for loading to complete...601D, [2022-01-10T14:58:32.856329 #79] DEBUG -- : loading complete after 0.008258858 seconds602D, [2022-01-10T14:58:32.874475 #79] DEBUG -- : has_no_element? :#<QA::Page::Element:0x000055a6c57b9168> (wait: 0) returned: false603D, [2022-01-10T14:58:32.877138 #79] DEBUG -- : waiting for loading to complete...604D, [2022-01-10T14:58:32.885225 #79] DEBUG -- : loading complete after 0.007995968 seconds605D, [2022-01-10T14:58:32.890144 #79] DEBUG -- : has_no_element? :#<QA::Page::Element:0x000055a6c57b8ec0> (wait: 0) returned: true606D, [2022-01-10T14:58:33.294993 #79] DEBUG -- : has_element? :navbar (wait: 60) returned: true607D, [2022-01-10T14:58:33.304182 #79] DEBUG -- : has_element? :user_avatar (wait: 60) returned: true608D, [2022-01-10T14:58:33.312922 #79] DEBUG -- : has_element? :user_menu (wait: 60) returned: true609D, [2022-01-10T14:58:33.322207 #79] DEBUG -- : has_element? :issues_shortcut_button (wait: 60) returned: true610D, [2022-01-10T14:58:33.331169 #79] DEBUG -- : has_element? :merge_requests_shortcut_button (wait: 60) returned: true611D, [2022-01-10T14:58:33.340358 #79] DEBUG -- : has_element? :todos_shortcut_button (wait: 60) returned: true612D, [2022-01-10T14:58:33.926818 #79] DEBUG -- : ==> Built a QA::Resource::User with username 'gitlab-qa-user1' via api in 0.342348321 seconds613D, [2022-01-10T14:58:35.066341 #79] DEBUG -- : ==> Built a QA::Resource::User with username 'gitlab-qa-user2' via api in 1.136672229 seconds614D, [2022-01-10T14:58:36.090478 #79] DEBUG -- : ==> Built a QA::Resource::User with username 'gitlab-qa-user3' via api in 1.020471655 seconds615D, [2022-01-10T14:58:36.554153 #79] DEBUG -- : ==> Built a QA::Resource::User with username 'gitlab-qa-user4' via api in 0.460678383 seconds616D, [2022-01-10T14:58:37.073185 #79] DEBUG -- : ==> Built a QA::Resource::User with username 'gitlab-qa-user5' via api in 0.516379811 seconds617D, [2022-01-10T14:58:37.545181 #79] DEBUG -- : ==> Built a QA::Resource::User with username 'gitlab-qa-user6' via api in 0.469045301 seconds618D, [2022-01-10T14:58:37.545315 #79] DEBUG -- : Adding user gitlab-qa-user1 to gitlab-qa-sandbox-group/qa-test-2022-01-10-14-57-22-941745e58b2d5a1c/project-to-test-issue-with-multiple-assignees-93b7c48740b929d2 QA::Resource::Project619D, [2022-01-10T14:58:38.331997 #79] DEBUG -- : Adding user gitlab-qa-user2 to gitlab-qa-sandbox-group/qa-test-2022-01-10-14-57-22-941745e58b2d5a1c/project-to-test-issue-with-multiple-assignees-93b7c48740b929d2 QA::Resource::Project620D, [2022-01-10T14:58:39.154707 #79] DEBUG -- : Adding user gitlab-qa-user3 to gitlab-qa-sandbox-group/qa-test-2022-01-10-14-57-22-941745e58b2d5a1c/project-to-test-issue-with-multiple-assignees-93b7c48740b929d2 QA::Resource::Project621D, [2022-01-10T14:58:40.155923 #79] DEBUG -- : Adding user gitlab-qa-user4 to gitlab-qa-sandbox-group/qa-test-2022-01-10-14-57-22-941745e58b2d5a1c/project-to-test-issue-with-multiple-assignees-93b7c48740b929d2 QA::Resource::Project622D, [2022-01-10T14:58:41.556584 #79] DEBUG -- : Adding user gitlab-qa-user5 to gitlab-qa-sandbox-group/qa-test-2022-01-10-14-57-22-941745e58b2d5a1c/project-to-test-issue-with-multiple-assignees-93b7c48740b929d2 QA::Resource::Project623D, [2022-01-10T14:58:42.114886 #79] DEBUG -- : Adding user gitlab-qa-user6 to gitlab-qa-sandbox-group/qa-test-2022-01-10-14-57-22-941745e58b2d5a1c/project-to-test-issue-with-multiple-assignees-93b7c48740b929d2 QA::Resource::Project624D, [2022-01-10T14:58:43.746661 #79] DEBUG -- : ==> Built a QA::Resource::Issue with id '44' via api in 1.231655246 seconds625D, [2022-01-10T14:58:43.746774 #79] DEBUG -- : Visiting QA::Resource::Project at "https://gitlab-review-pedropombe-dh031e.gitlab-review.app/gitlab-qa-sandbox-group/qa-test-2022-01-10-14-57-22-941745e58b2d5a1c/project-to-test-issue-with-multiple-assignees-93b7c48740b929d2"626D, [2022-01-10T14:58:45.517576 #79] DEBUG -- : waiting for loading to complete...627D, [2022-01-10T14:58:45.528884 #79] DEBUG -- : loading complete after 0.011228468 seconds628D, [2022-01-10T14:58:45.528944 #79] DEBUG -- : within element :project_sidebar with args {}629D, [2022-01-10T14:58:45.531312 #79] DEBUG -- : waiting for loading to complete...630D, [2022-01-10T14:58:45.541847 #79] DEBUG -- : loading complete after 0.010488298 seconds631D, [2022-01-10T14:58:45.550845 #79] DEBUG -- : clicking :sidebar_menu_link with args {:menu_item=>"Issues"}632D, [2022-01-10T14:58:45.553385 #79] DEBUG -- : waiting for loading to complete...633D, [2022-01-10T14:58:45.560932 #79] DEBUG -- : loading complete after 0.007499528 seconds634D, [2022-01-10T14:58:46.984459 #79] DEBUG -- : end within element :project_sidebar with args {}635D, [2022-01-10T14:58:46.984789 #79] DEBUG -- : finding all :assignee_link with args {:count=>3}636D, [2022-01-10T14:58:46.987607 #79] DEBUG -- : waiting for loading to complete...637D, [2022-01-10T14:58:47.012713 #79] DEBUG -- : loading complete after 0.025040624 seconds638D, [2022-01-10T14:58:47.104251 #79] DEBUG -- : found 3 :assignee_link639D, [2022-01-10T14:58:47.104329 #79] DEBUG -- : finding :avatar_counter_content with args {}640D, [2022-01-10T14:58:47.106681 #79] DEBUG -- : waiting for loading to complete...641D, [2022-01-10T14:58:47.115320 #79] DEBUG -- : loading complete after 0.008588788 seconds642D, [2022-01-10T14:58:47.126586 #79] DEBUG -- : found :avatar_counter_content643D, [2022-01-10T14:58:47.129686 #79] DEBUG -- : finding :avatar_counter_content with args {}644D, [2022-01-10T14:58:47.132104 #79] DEBUG -- : waiting for loading to complete...645D, [2022-01-10T14:58:47.140263 #79] DEBUG -- : loading complete after 0.008110868 seconds646D, [2022-01-10T14:58:47.148331 #79] DEBUG -- : found :avatar_counter_content647 shows the first three assignees and a +n sign in the issues list648D, [2022-01-10T14:58:47.213275 #79] DEBUG -- : 649Starting test: Plan Multiple assignees per issue shows the first five assignees and a +n more link in the issue page650D, [2022-01-10T14:58:47.736728 #79] DEBUG -- : ==> Built a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group' via api in 0.516653921 seconds651D, [2022-01-10T14:58:48.265615 #79] DEBUG -- : <QA::Resource::Group> Attribute :full_path has both API response `gitlab-qa-sandbox-group/qa-test-2022-01-10-14-57-22-941745e58b2d5a1c` and a block. API response will be picked. Block will be ignored.652D, [2022-01-10T14:58:48.265691 #79] DEBUG -- : ==> Built a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group/qa-test-2022-01-10-14-57-22-941745e58b2d5a1c' via api in 1.047664839 seconds653D, [2022-01-10T14:58:50.465497 #79] DEBUG -- : ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group/qa-test-2022-01-10-14-57-22-941745e58b2d5a1c/project-to-test-issue-with-multiple-assignees-9c1b3510fd46c252' via api in 3.249602642 seconds654I, [2022-01-10T14:58:50.465593 #79] INFO -- : Enabling feature: invite_members_group_modal for scope "project: gitlab-qa-sandbox-group/qa-test-2022-01-10-14-57-22-941745e58b2d5a1c/project-to-test-issue-with-multiple-assignees-9c1b3510fd46c252"655D, [2022-01-10T14:58:51.852188 #79] DEBUG -- : Retrying action with: max_duration: 60; sleep_interval: 1; raise_on_failure: true; retry_on_exception: false656D, [2022-01-10T14:58:51.979001 #79] DEBUG -- : ended retry657I, [2022-01-10T14:58:51.979070 #79] INFO -- : Successfully enabled and verified feature flag: invite_members_group_modal658/usr/local/bundle/gems/capybara-3.35.3/lib/capybara/registration_container.rb:21: warning: DEPRECATED: Calling 'include?' on the drivers/servers container is deprecated without replacement659D, [2022-01-10T14:58:52.277353 #79] DEBUG -- : has_element? :login_page (wait: 60) returned: true660D, [2022-01-10T14:58:52.285256 #79] DEBUG -- : has_element? :login_page (wait: 0) returned: true661D, [2022-01-10T14:58:52.293956 #79] DEBUG -- : has_element? :login_page (wait: 0) returned: true662D, [2022-01-10T14:58:52.394234 #79] DEBUG -- : waiting for loading to complete...663D, [2022-01-10T14:58:52.398910 #79] DEBUG -- : loading complete after 0.004613088 seconds664D, [2022-01-10T14:58:53.408692 #79] DEBUG -- : has_element? :sign_in_tab (wait: 0) returned: false665D, [2022-01-10T14:58:53.416239 #79] DEBUG -- : waiting for loading to complete...666D, [2022-01-10T14:58:53.420988 #79] DEBUG -- : loading complete after 0.004699299 seconds667D, [2022-01-10T14:58:54.431713 #79] DEBUG -- : has_element? :standard_tab (wait: 0) returned: false668D, [2022-01-10T14:58:54.431788 #79] DEBUG -- : filling :login_field with "root"669D, [2022-01-10T14:58:54.431809 #79] DEBUG -- : finding :login_field with args {}670D, [2022-01-10T14:58:54.445211 #79] DEBUG -- : waiting for loading to complete...671D, [2022-01-10T14:58:54.451417 #79] DEBUG -- : loading complete after 0.006133818 seconds672D, [2022-01-10T14:58:54.460563 #79] DEBUG -- : found :login_field673D, [2022-01-10T14:58:54.491288 #79] DEBUG -- : filling :password_field with "*****"674D, [2022-01-10T14:58:54.491359 #79] DEBUG -- : finding :password_field with args {}675D, [2022-01-10T14:58:54.495109 #79] DEBUG -- : waiting for loading to complete...676D, [2022-01-10T14:58:54.500319 #79] DEBUG -- : loading complete after 0.005158109 seconds677D, [2022-01-10T14:58:54.510050 #79] DEBUG -- : found :password_field678D, [2022-01-10T14:58:54.573197 #79] DEBUG -- : clicking :sign_in_button with args {}679D, [2022-01-10T14:58:54.575873 #79] DEBUG -- : waiting for loading to complete...680D, [2022-01-10T14:58:54.582628 #79] DEBUG -- : loading complete after 0.006695358 seconds681D, [2022-01-10T14:58:56.139240 #79] DEBUG -- : waiting for loading to complete...682D, [2022-01-10T14:58:56.147728 #79] DEBUG -- : loading complete after 0.008416248 seconds683D, [2022-01-10T14:58:56.169464 #79] DEBUG -- : has_no_element? :#<QA::Page::Element:0x000055a6c57b9168> (wait: 0) returned: false684D, [2022-01-10T14:58:56.172113 #79] DEBUG -- : waiting for loading to complete...685D, [2022-01-10T14:58:56.180802 #79] DEBUG -- : loading complete after 0.008645817 seconds686D, [2022-01-10T14:58:56.188329 #79] DEBUG -- : has_no_element? :#<QA::Page::Element:0x000055a6c57b8ec0> (wait: 0) returned: true687D, [2022-01-10T14:58:56.642509 #79] DEBUG -- : has_element? :navbar (wait: 60) returned: true688D, [2022-01-10T14:58:56.654774 #79] DEBUG -- : has_element? :user_avatar (wait: 60) returned: true689D, [2022-01-10T14:58:56.665655 #79] DEBUG -- : has_element? :user_menu (wait: 60) returned: true690D, [2022-01-10T14:58:56.676923 #79] DEBUG -- : has_element? :issues_shortcut_button (wait: 60) returned: true691D, [2022-01-10T14:58:56.688063 #79] DEBUG -- : has_element? :merge_requests_shortcut_button (wait: 60) returned: true692D, [2022-01-10T14:58:56.699984 #79] DEBUG -- : has_element? :todos_shortcut_button (wait: 60) returned: true693D, [2022-01-10T14:58:57.648065 #79] DEBUG -- : ==> Built a QA::Resource::User with username 'gitlab-qa-user1' via api in 0.678102793 seconds694D, [2022-01-10T14:58:58.330342 #79] DEBUG -- : ==> Built a QA::Resource::User with username 'gitlab-qa-user2' via api in 0.679566534 seconds695D, [2022-01-10T14:58:58.760937 #79] DEBUG -- : ==> Built a QA::Resource::User with username 'gitlab-qa-user3' via api in 0.427673961 seconds696D, [2022-01-10T14:58:59.417015 #79] DEBUG -- : ==> Built a QA::Resource::User with username 'gitlab-qa-user4' via api in 0.65299713 seconds697D, [2022-01-10T14:59:00.033885 #79] DEBUG -- : ==> Built a QA::Resource::User with username 'gitlab-qa-user5' via api in 0.613684148 seconds698D, [2022-01-10T14:59:00.826701 #79] DEBUG -- : ==> Built a QA::Resource::User with username 'gitlab-qa-user6' via api in 0.789913079 seconds699D, [2022-01-10T14:59:00.826793 #79] DEBUG -- : Adding user gitlab-qa-user1 to gitlab-qa-sandbox-group/qa-test-2022-01-10-14-57-22-941745e58b2d5a1c/project-to-test-issue-with-multiple-assignees-9c1b3510fd46c252 QA::Resource::Project700D, [2022-01-10T14:59:01.417199 #79] DEBUG -- : Adding user gitlab-qa-user2 to gitlab-qa-sandbox-group/qa-test-2022-01-10-14-57-22-941745e58b2d5a1c/project-to-test-issue-with-multiple-assignees-9c1b3510fd46c252 QA::Resource::Project701D, [2022-01-10T14:59:02.451154 #79] DEBUG -- : Adding user gitlab-qa-user3 to gitlab-qa-sandbox-group/qa-test-2022-01-10-14-57-22-941745e58b2d5a1c/project-to-test-issue-with-multiple-assignees-9c1b3510fd46c252 QA::Resource::Project702D, [2022-01-10T14:59:02.826067 #79] DEBUG -- : Adding user gitlab-qa-user4 to gitlab-qa-sandbox-group/qa-test-2022-01-10-14-57-22-941745e58b2d5a1c/project-to-test-issue-with-multiple-assignees-9c1b3510fd46c252 QA::Resource::Project703D, [2022-01-10T14:59:03.430276 #79] DEBUG -- : Adding user gitlab-qa-user5 to gitlab-qa-sandbox-group/qa-test-2022-01-10-14-57-22-941745e58b2d5a1c/project-to-test-issue-with-multiple-assignees-9c1b3510fd46c252 QA::Resource::Project704D, [2022-01-10T14:59:04.457536 #79] DEBUG -- : Adding user gitlab-qa-user6 to gitlab-qa-sandbox-group/qa-test-2022-01-10-14-57-22-941745e58b2d5a1c/project-to-test-issue-with-multiple-assignees-9c1b3510fd46c252 QA::Resource::Project705D, [2022-01-10T14:59:05.789679 #79] DEBUG -- : ==> Built a QA::Resource::Issue with id '48' via api in 0.666622016 seconds706D, [2022-01-10T14:59:05.789774 #79] DEBUG -- : Visiting QA::Resource::Issue at "https://gitlab-review-pedropombe-dh031e.gitlab-review.app/gitlab-qa-sandbox-group/qa-test-2022-01-10-14-57-22-941745e58b2d5a1c/project-to-test-issue-with-multiple-assignees-9c1b3510fd46c252/-/issues/1"707D, [2022-01-10T14:59:08.471408 #79] DEBUG -- : within element :assignee_block with args {}708D, [2022-01-10T14:59:08.473920 #79] DEBUG -- : waiting for loading to complete...709D, [2022-01-10T14:59:08.483803 #79] DEBUG -- : loading complete after 0.009826409 seconds710D, [2022-01-10T14:59:08.499274 #79] DEBUG -- : waiting for loading to complete...711D, [2022-01-10T14:59:08.511378 #79] DEBUG -- : loading complete after 0.012008919 seconds712D, [2022-01-10T14:59:08.519313 #79] DEBUG -- : finding all :avatar_image with args {:count=>5}713D, [2022-01-10T14:59:08.521687 #79] DEBUG -- : waiting for loading to complete...714D, [2022-01-10T14:59:08.530919 #79] DEBUG -- : loading complete after 0.009182899 seconds715D, [2022-01-10T14:59:08.546173 #79] DEBUG -- : found 5 :avatar_image716D, [2022-01-10T14:59:08.546241 #79] DEBUG -- : end within element :assignee_block with args {}717D, [2022-01-10T14:59:08.546279 #79] DEBUG -- : finding :more_assignees_link with args {}718D, [2022-01-10T14:59:08.548758 #79] DEBUG -- : waiting for loading to complete...719D, [2022-01-10T14:59:08.557377 #79] DEBUG -- : loading complete after 0.00857012 seconds720D, [2022-01-10T14:59:08.570204 #79] DEBUG -- : found :more_assignees_link721D, [2022-01-10T14:59:08.573371 #79] DEBUG -- : finding :more_assignees_link with args {}722D, [2022-01-10T14:59:08.576341 #79] DEBUG -- : waiting for loading to complete...723D, [2022-01-10T14:59:08.586228 #79] DEBUG -- : loading complete after 0.009825269 seconds724D, [2022-01-10T14:59:08.596603 #79] DEBUG -- : found :more_assignees_link725D, [2022-01-10T14:59:08.606809 #79] DEBUG -- : clicking :more_assignees_link with args {}726D, [2022-01-10T14:59:08.610967 #79] DEBUG -- : waiting for loading to complete...727D, [2022-01-10T14:59:08.619869 #79] DEBUG -- : loading complete after 0.00884369 seconds728D, [2022-01-10T14:59:08.672425 #79] DEBUG -- : within element :assignee_block with args {}729D, [2022-01-10T14:59:08.677632 #79] DEBUG -- : waiting for loading to complete...730D, [2022-01-10T14:59:08.699230 #79] DEBUG -- : loading complete after 0.021516578 seconds731D, [2022-01-10T14:59:08.722219 #79] DEBUG -- : waiting for loading to complete...732D, [2022-01-10T14:59:08.739674 #79] DEBUG -- : loading complete after 0.017052079 seconds733D, [2022-01-10T14:59:08.777260 #79] DEBUG -- : finding all :avatar_image with args {:count=>6}734D, [2022-01-10T14:59:08.779788 #79] DEBUG -- : waiting for loading to complete...735D, [2022-01-10T14:59:08.788196 #79] DEBUG -- : loading complete after 0.008358569 seconds736D, [2022-01-10T14:59:08.798822 #79] DEBUG -- : found 6 :avatar_image737D, [2022-01-10T14:59:08.798878 #79] DEBUG -- : end within element :assignee_block with args {}738D, [2022-01-10T14:59:08.798914 #79] DEBUG -- : finding :more_assignees_link with args {}739D, [2022-01-10T14:59:08.801300 #79] DEBUG -- : waiting for loading to complete...740D, [2022-01-10T14:59:08.809663 #79] DEBUG -- : loading complete after 0.00831634 seconds741D, [2022-01-10T14:59:08.819011 #79] DEBUG -- : found :more_assignees_link742 shows the first five assignees and a +n more link in the issue page743Plan744 Issue comments745D, [2022-01-10T14:59:08.882517 #79] DEBUG -- : 746Starting test: Plan Issue comments comments on an issue and edits the comment747/usr/local/bundle/gems/capybara-3.35.3/lib/capybara/registration_container.rb:21: warning: DEPRECATED: Calling 'include?' on the drivers/servers container is deprecated without replacement748D, [2022-01-10T14:59:09.237157 #79] DEBUG -- : has_element? :login_page (wait: 60) returned: true749D, [2022-01-10T14:59:09.245921 #79] DEBUG -- : has_element? :login_page (wait: 0) returned: true750D, [2022-01-10T14:59:09.253866 #79] DEBUG -- : has_element? :login_page (wait: 0) returned: true751D, [2022-01-10T14:59:09.348009 #79] DEBUG -- : waiting for loading to complete...752D, [2022-01-10T14:59:09.352909 #79] DEBUG -- : loading complete after 0.00481071 seconds753D, [2022-01-10T14:59:10.367780 #79] DEBUG -- : has_element? :sign_in_tab (wait: 0) returned: false754D, [2022-01-10T14:59:10.377913 #79] DEBUG -- : waiting for loading to complete...755D, [2022-01-10T14:59:10.382674 #79] DEBUG -- : loading complete after 0.00471142 seconds756D, [2022-01-10T14:59:11.383724 #79] DEBUG -- : has_element? :standard_tab (wait: 0) returned: false757D, [2022-01-10T14:59:11.383801 #79] DEBUG -- : filling :login_field with "root"758D, [2022-01-10T14:59:11.383822 #79] DEBUG -- : finding :login_field with args {}759D, [2022-01-10T14:59:11.386405 #79] DEBUG -- : waiting for loading to complete...760D, [2022-01-10T14:59:11.391801 #79] DEBUG -- : loading complete after 0.00535214 seconds761D, [2022-01-10T14:59:11.403171 #79] DEBUG -- : found :login_field762D, [2022-01-10T14:59:11.432718 #79] DEBUG -- : filling :password_field with "*****"763D, [2022-01-10T14:59:11.432788 #79] DEBUG -- : finding :password_field with args {}764D, [2022-01-10T14:59:11.435507 #79] DEBUG -- : waiting for loading to complete...765D, [2022-01-10T14:59:11.440484 #79] DEBUG -- : loading complete after 0.00492979 seconds766D, [2022-01-10T14:59:11.452311 #79] DEBUG -- : found :password_field767D, [2022-01-10T14:59:11.517971 #79] DEBUG -- : clicking :sign_in_button with args {}768D, [2022-01-10T14:59:11.520830 #79] DEBUG -- : waiting for loading to complete...769D, [2022-01-10T14:59:11.526937 #79] DEBUG -- : loading complete after 0.006053139 seconds770D, [2022-01-10T14:59:12.492761 #79] DEBUG -- : waiting for loading to complete...771D, [2022-01-10T14:59:12.501236 #79] DEBUG -- : loading complete after 0.008391339 seconds772D, [2022-01-10T14:59:12.521755 #79] DEBUG -- : has_no_element? :#<QA::Page::Element:0x000055a6c57b9168> (wait: 0) returned: false773D, [2022-01-10T14:59:12.524691 #79] DEBUG -- : waiting for loading to complete...774D, [2022-01-10T14:59:12.532713 #79] DEBUG -- : loading complete after 0.007974099 seconds775D, [2022-01-10T14:59:12.541258 #79] DEBUG -- : has_no_element? :#<QA::Page::Element:0x000055a6c57b8ec0> (wait: 0) returned: true776D, [2022-01-10T14:59:13.023598 #79] DEBUG -- : has_element? :navbar (wait: 60) returned: true777D, [2022-01-10T14:59:13.034576 #79] DEBUG -- : has_element? :user_avatar (wait: 60) returned: true778D, [2022-01-10T14:59:13.046971 #79] DEBUG -- : has_element? :user_menu (wait: 60) returned: true779D, [2022-01-10T14:59:13.059162 #79] DEBUG -- : has_element? :issues_shortcut_button (wait: 60) returned: true780D, [2022-01-10T14:59:13.070173 #79] DEBUG -- : has_element? :merge_requests_shortcut_button (wait: 60) returned: true781D, [2022-01-10T14:59:13.083041 #79] DEBUG -- : has_element? :todos_shortcut_button (wait: 60) returned: true782D, [2022-01-10T14:59:13.539497 #79] DEBUG -- : ==> Built a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group' via api in 0.220712142 seconds783D, [2022-01-10T14:59:14.010914 #79] DEBUG -- : <QA::Resource::Group> Attribute :full_path has both API response `gitlab-qa-sandbox-group/qa-test-2022-01-10-14-57-22-941745e58b2d5a1c` and a block. API response will be picked. Block will be ignored.784D, [2022-01-10T14:59:14.011008 #79] DEBUG -- : ==> Built a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group/qa-test-2022-01-10-14-57-22-941745e58b2d5a1c' via api in 0.694325613 seconds785D, [2022-01-10T14:59:15.068992 #79] DEBUG -- : ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group/qa-test-2022-01-10-14-57-22-941745e58b2d5a1c/project-for-issues-a9a06ccc184d7262' via api in 1.754606079 seconds786D, [2022-01-10T14:59:15.742225 #79] DEBUG -- : ==> Built a QA::Resource::Issue with id '50' via api in 2.430042855 seconds787D, [2022-01-10T14:59:15.742304 #79] DEBUG -- : Visiting QA::Resource::Issue at "https://gitlab-review-pedropombe-dh031e.gitlab-review.app/gitlab-qa-sandbox-group/qa-test-2022-01-10-14-57-22-941745e58b2d5a1c/project-for-issues-a9a06ccc184d7262/-/issues/1"788D, [2022-01-10T14:59:17.796592 #79] DEBUG -- : clicking :title with args {}789D, [2022-01-10T14:59:17.799116 #79] DEBUG -- : waiting for loading to complete...790D, [2022-01-10T14:59:17.810679 #79] DEBUG -- : loading complete after 0.011510769 seconds791D, [2022-01-10T14:59:17.853470 #79] DEBUG -- : clicking :discussion_filter_dropdown with args {}792D, [2022-01-10T14:59:17.856206 #79] DEBUG -- : waiting for loading to complete...793D, [2022-01-10T14:59:17.866561 #79] DEBUG -- : loading complete after 0.01030377 seconds794D, [2022-01-10T14:59:17.904298 #79] DEBUG -- : finding :filter_menu_item with args {:text=>"Show all activity"}795D, [2022-01-10T14:59:17.906842 #79] DEBUG -- : waiting for loading to complete...796D, [2022-01-10T14:59:17.927912 #79] DEBUG -- : loading complete after 0.021013549 seconds797D, [2022-01-10T14:59:17.955369 #79] DEBUG -- : found :filter_menu_item798D, [2022-01-10T14:59:17.990657 #79] DEBUG -- : waiting for loading to complete...799D, [2022-01-10T14:59:18.003916 #79] DEBUG -- : loading complete after 0.013178479 seconds800D, [2022-01-10T14:59:18.006388 #79] DEBUG -- : waiting for loading to complete...801D, [2022-01-10T14:59:18.021336 #79] DEBUG -- : loading complete after 0.014895969 seconds802D, [2022-01-10T14:59:18.036148 #79] DEBUG -- : has_no_element? :discussion_filter_container (wait: 10) returned: true803D, [2022-01-10T14:59:18.050514 #79] DEBUG -- : has_element? :comment_field (wait: 10) returned: true804D, [2022-01-10T14:59:18.050585 #79] DEBUG -- : filling :comment_field with "First version of the comment805"806D, [2022-01-10T14:59:18.050605 #79] DEBUG -- : finding :comment_field with args {}807D, [2022-01-10T14:59:18.053008 #79] DEBUG -- : waiting for loading to complete...808D, [2022-01-10T14:59:18.063682 #79] DEBUG -- : loading complete after 0.010610839 seconds809D, [2022-01-10T14:59:18.078315 #79] DEBUG -- : found :comment_field810D, [2022-01-10T14:59:18.263138 #79] DEBUG -- : clicking :comment_button with args {}811D, [2022-01-10T14:59:18.369675 #79] DEBUG -- : waiting for loading to complete...812D, [2022-01-10T14:59:18.378763 #79] DEBUG -- : loading complete after 0.009012819 seconds813D, [2022-01-10T14:59:19.210563 #79] DEBUG -- : has_element? :noteable_note_container with text "First version of the comment" (wait: 60) returned: true814D, [2022-01-10T14:59:19.210659 #79] DEBUG -- : clicking :note_edit_button with args {}815D, [2022-01-10T14:59:19.624983 #79] DEBUG -- : waiting for loading to complete...816D, [2022-01-10T14:59:19.634585 #79] DEBUG -- : loading complete after 0.009464069 seconds817D, [2022-01-10T14:59:19.716130 #79] DEBUG -- : filling :reply_field with "Second version of the comment"818D, [2022-01-10T14:59:19.716622 #79] DEBUG -- : finding :reply_field with args {}819D, [2022-01-10T14:59:19.725562 #79] DEBUG -- : waiting for loading to complete...820D, [2022-01-10T14:59:19.739312 #79] DEBUG -- : loading complete after 0.013657529 seconds821D, [2022-01-10T14:59:19.753596 #79] DEBUG -- : found :reply_field822D, [2022-01-10T14:59:19.899206 #79] DEBUG -- : clicking :reply_comment_button with args {}823D, [2022-01-10T14:59:20.108074 #79] DEBUG -- : waiting for loading to complete...824D, [2022-01-10T14:59:20.117250 #79] DEBUG -- : loading complete after 0.00909251 seconds825D, [2022-01-10T14:59:20.273251 #79] DEBUG -- : has_element? :noteable_note_container with text "Second version of the comment" (wait: 60) returned: true826 comments on an issue and edits the comment827Plan828 check xss occurence in @mentions in issues829D, [2022-01-10T14:59:20.644097 #79] DEBUG -- : 830Starting test: Plan check xss occurence in @mentions in issues mentions a user in a comment831D, [2022-01-10T14:59:21.737569 #79] DEBUG -- : ==> Built a QA::Resource::User with username 'qa-user-81c58be0a9ae6ceb' via api in 1.091008282 seconds832D, [2022-01-10T14:59:22.035280 #79] DEBUG -- : ==> Built a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group' via api in 0.290167636 seconds833D, [2022-01-10T14:59:23.311129 #79] DEBUG -- : <QA::Resource::Group> Attribute :full_path has both API response `gitlab-qa-sandbox-group/qa-test-2022-01-10-14-57-22-941745e58b2d5a1c` and a block. API response will be picked. Block will be ignored.834D, [2022-01-10T14:59:23.311226 #79] DEBUG -- : ==> Built a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group/qa-test-2022-01-10-14-57-22-941745e58b2d5a1c' via api in 1.568232693 seconds835D, [2022-01-10T14:59:24.189186 #79] DEBUG -- : ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group/qa-test-2022-01-10-14-57-22-941745e58b2d5a1c/xss-test-for-mentions-project-3bf262dedead58b9' via api in 2.448521483 seconds836I, [2022-01-10T14:59:24.189380 #79] INFO -- : Enabling feature: invite_members_group_modal837D, [2022-01-10T14:59:25.465921 #79] DEBUG -- : Retrying action with: max_duration: 60; sleep_interval: 1; raise_on_failure: true; retry_on_exception: false838D, [2022-01-10T14:59:25.640277 #79] DEBUG -- : ended retry839I, [2022-01-10T14:59:25.640367 #79] INFO -- : Successfully enabled and verified feature flag: invite_members_group_modal840/usr/local/bundle/gems/capybara-3.35.3/lib/capybara/registration_container.rb:21: warning: DEPRECATED: Calling 'include?' on the drivers/servers container is deprecated without replacement841D, [2022-01-10T14:59:25.956117 #79] DEBUG -- : has_element? :login_page (wait: 60) returned: true842D, [2022-01-10T14:59:25.964316 #79] DEBUG -- : has_element? :login_page (wait: 0) returned: true843D, [2022-01-10T14:59:25.972349 #79] DEBUG -- : has_element? :login_page (wait: 0) returned: true844D, [2022-01-10T14:59:26.081881 #79] DEBUG -- : waiting for loading to complete...845D, [2022-01-10T14:59:26.086889 #79] DEBUG -- : loading complete after 0.004933429 seconds846D, [2022-01-10T14:59:27.099199 #79] DEBUG -- : has_element? :sign_in_tab (wait: 0) returned: false847D, [2022-01-10T14:59:27.109281 #79] DEBUG -- : waiting for loading to complete...848D, [2022-01-10T14:59:27.114921 #79] DEBUG -- : loading complete after 0.00558831 seconds849D, [2022-01-10T14:59:28.117276 #79] DEBUG -- : has_element? :standard_tab (wait: 0) returned: false850D, [2022-01-10T14:59:28.117346 #79] DEBUG -- : filling :login_field with "root"851D, [2022-01-10T14:59:28.117365 #79] DEBUG -- : finding :login_field with args {}852D, [2022-01-10T14:59:28.119978 #79] DEBUG -- : waiting for loading to complete...853D, [2022-01-10T14:59:28.124824 #79] DEBUG -- : loading complete after 0.004798509 seconds854D, [2022-01-10T14:59:28.135967 #79] DEBUG -- : found :login_field855D, [2022-01-10T14:59:28.165303 #79] DEBUG -- : filling :password_field with "*****"856D, [2022-01-10T14:59:28.165373 #79] DEBUG -- : finding :password_field with args {}857D, [2022-01-10T14:59:28.167898 #79] DEBUG -- : waiting for loading to complete...858D, [2022-01-10T14:59:28.172945 #79] DEBUG -- : loading complete after 0.004998439 seconds859D, [2022-01-10T14:59:28.185337 #79] DEBUG -- : found :password_field860D, [2022-01-10T14:59:28.245277 #79] DEBUG -- : clicking :sign_in_button with args {}861D, [2022-01-10T14:59:28.247953 #79] DEBUG -- : waiting for loading to complete...862D, [2022-01-10T14:59:28.253698 #79] DEBUG -- : loading complete after 0.00569449 seconds863D, [2022-01-10T14:59:29.935611 #79] DEBUG -- : waiting for loading to complete...864D, [2022-01-10T14:59:29.943707 #79] DEBUG -- : loading complete after 0.008020589 seconds865D, [2022-01-10T14:59:29.964151 #79] DEBUG -- : has_no_element? :#<QA::Page::Element:0x000055a6c57b9168> (wait: 0) returned: false866D, [2022-01-10T14:59:29.966602 #79] DEBUG -- : waiting for loading to complete...867D, [2022-01-10T14:59:29.974387 #79] DEBUG -- : loading complete after 0.00773503 seconds868D, [2022-01-10T14:59:29.981815 #79] DEBUG -- : has_no_element? :#<QA::Page::Element:0x000055a6c57b8ec0> (wait: 0) returned: true869D, [2022-01-10T14:59:30.465517 #79] DEBUG -- : has_element? :navbar (wait: 60) returned: true870D, [2022-01-10T14:59:30.476150 #79] DEBUG -- : has_element? :user_avatar (wait: 60) returned: true871D, [2022-01-10T14:59:30.487402 #79] DEBUG -- : has_element? :user_menu (wait: 60) returned: true872D, [2022-01-10T14:59:30.501509 #79] DEBUG -- : has_element? :issues_shortcut_button (wait: 60) returned: true873D, [2022-01-10T14:59:30.513005 #79] DEBUG -- : has_element? :merge_requests_shortcut_button (wait: 60) returned: true874D, [2022-01-10T14:59:30.525121 #79] DEBUG -- : has_element? :todos_shortcut_button (wait: 60) returned: true875D, [2022-01-10T14:59:30.809863 #79] DEBUG -- : Adding user qa-user-81c58be0a9ae6ceb to gitlab-qa-sandbox-group/qa-test-2022-01-10-14-57-22-941745e58b2d5a1c/xss-test-for-mentions-project-3bf262dedead58b9 QA::Resource::Project876D, [2022-01-10T14:59:32.157393 #79] DEBUG -- : ==> Built a QA::Resource::Issue with id '53' via api in 0.700233793 seconds877D, [2022-01-10T14:59:32.157481 #79] DEBUG -- : Visiting QA::Resource::Issue at "https://gitlab-review-pedropombe-dh031e.gitlab-review.app/gitlab-qa-sandbox-group/qa-test-2022-01-10-14-57-22-941745e58b2d5a1c/xss-test-for-mentions-project-3bf262dedead58b9/-/issues/1"878D, [2022-01-10T14:59:34.812019 #79] DEBUG -- : clicking :title with args {}879D, [2022-01-10T14:59:34.814648 #79] DEBUG -- : waiting for loading to complete...880D, [2022-01-10T14:59:34.823364 #79] DEBUG -- : loading complete after 0.008667209 seconds881D, [2022-01-10T14:59:34.877675 #79] DEBUG -- : clicking :discussion_filter_dropdown with args {}882D, [2022-01-10T14:59:34.888386 #79] DEBUG -- : waiting for loading to complete...883D, [2022-01-10T14:59:34.917572 #79] DEBUG -- : loading complete after 0.029099677 seconds884D, [2022-01-10T14:59:34.982200 #79] DEBUG -- : finding :filter_menu_item with args {:text=>"Show all activity"}885D, [2022-01-10T14:59:34.984701 #79] DEBUG -- : waiting for loading to complete...886D, [2022-01-10T14:59:35.005706 #79] DEBUG -- : loading complete after 0.020940028 seconds887D, [2022-01-10T14:59:35.037743 #79] DEBUG -- : found :filter_menu_item888D, [2022-01-10T14:59:35.078304 #79] DEBUG -- : waiting for loading to complete...889D, [2022-01-10T14:59:35.087476 #79] DEBUG -- : loading complete after 0.009084399 seconds890D, [2022-01-10T14:59:35.089940 #79] DEBUG -- : waiting for loading to complete...891D, [2022-01-10T14:59:35.101613 #79] DEBUG -- : loading complete after 0.0116173 seconds892D, [2022-01-10T14:59:35.115238 #79] DEBUG -- : has_no_element? :discussion_filter_container (wait: 10) returned: true893D, [2022-01-10T14:59:35.129594 #79] DEBUG -- : has_element? :comment_field (wait: 10) returned: true894D, [2022-01-10T14:59:35.129702 #79] DEBUG -- : clicking :title with args {}895D, [2022-01-10T14:59:35.132153 #79] DEBUG -- : waiting for loading to complete...896D, [2022-01-10T14:59:35.142964 #79] DEBUG -- : loading complete after 0.010758379 seconds897D, [2022-01-10T14:59:35.171205 #79] DEBUG -- : clicking :discussion_filter_dropdown with args {}898D, [2022-01-10T14:59:35.174160 #79] DEBUG -- : waiting for loading to complete...899D, [2022-01-10T14:59:35.186638 #79] DEBUG -- : loading complete after 0.012014789 seconds900D, [2022-01-10T14:59:35.215409 #79] DEBUG -- : finding :filter_menu_item with args {:text=>"Show all activity"}901D, [2022-01-10T14:59:35.217969 #79] DEBUG -- : waiting for loading to complete...902D, [2022-01-10T14:59:35.234523 #79] DEBUG -- : loading complete after 0.016492009 seconds903D, [2022-01-10T14:59:35.256750 #79] DEBUG -- : found :filter_menu_item904D, [2022-01-10T14:59:35.284131 #79] DEBUG -- : waiting for loading to complete...905D, [2022-01-10T14:59:35.294938 #79] DEBUG -- : loading complete after 0.010719589 seconds906D, [2022-01-10T14:59:35.297440 #79] DEBUG -- : waiting for loading to complete...907D, [2022-01-10T14:59:35.305738 #79] DEBUG -- : loading complete after 0.008255589 seconds908D, [2022-01-10T14:59:35.315401 #79] DEBUG -- : has_no_element? :discussion_filter_container (wait: 10) returned: true909D, [2022-01-10T14:59:35.323705 #79] DEBUG -- : has_element? :comment_field (wait: 10) returned: true910D, [2022-01-10T14:59:35.323757 #79] DEBUG -- : filling :comment_field with "cc-ing you here @qa-user-81c58be0a9ae6ceb911"912D, [2022-01-10T14:59:35.323779 #79] DEBUG -- : finding :comment_field with args {}913D, [2022-01-10T14:59:35.328137 #79] DEBUG -- : waiting for loading to complete...914D, [2022-01-10T14:59:35.337146 #79] DEBUG -- : loading complete after 0.008946469 seconds915D, [2022-01-10T14:59:35.349939 #79] DEBUG -- : found :comment_field916D, [2022-01-10T14:59:35.468921 #79] DEBUG -- : clicking :comment_button with args {}917D, [2022-01-10T14:59:35.986823 #79] DEBUG -- : waiting for loading to complete...918D, [2022-01-10T14:59:35.996152 #79] DEBUG -- : loading complete after 0.00925479 seconds919D, [2022-01-10T14:59:36.548536 #79] DEBUG -- : has_element? :noteable_note_container with text "cc-ing you here" (wait: 60) returned: true920D, [2022-01-10T14:59:36.748635 #79] DEBUG -- : Deleted user 'qa-user-81c58be0a9ae6ceb'921 mentions a user in a comment922Verify923 Pipelines for merged results and merge trains924D, [2022-01-10T14:59:36.804732 #79] DEBUG -- : 925Starting test: Verify Pipelines for merged results and merge trains merges via a merge train926D, [2022-01-10T14:59:37.023624 #79] DEBUG -- : ==> Built a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group' via api in 0.212023973 seconds927D, [2022-01-10T14:59:37.479227 #79] DEBUG -- : <QA::Resource::Group> Attribute :full_path has both API response `gitlab-qa-sandbox-group/qa-test-2022-01-10-14-57-22-941745e58b2d5a1c` and a block. API response will be picked. Block will be ignored.928D, [2022-01-10T14:59:37.479330 #79] DEBUG -- : ==> Built a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group/qa-test-2022-01-10-14-57-22-941745e58b2d5a1c' via api in 0.669776876 seconds929D, [2022-01-10T14:59:38.409457 #79] DEBUG -- : ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group/qa-test-2022-01-10-14-57-22-941745e58b2d5a1c/pipelines-for-merge-trains-80baee37afad7e86' via api in 1.602124351 seconds930/builds/gitlab-org-forks/gitlab/qa/qa/specs/features/ee/browser_ui/4_verify/pipelines_for_merged_results_and_merge_trains_spec.rb:12: Passing `number` with the 1st argument of `alphanumeric` is deprecated. Use keyword argument like `alphanumeric(number: ...)` instead.931To automatically update from positional arguments to keyword arguments,932install rubocop-faker and run:933rubocop \934 --require rubocop-faker \935 --only Faker/DeprecatedArguments \936 --auto-correct937Executing `docker pull gitlab/gitlab-runner:alpine`938alpine: Pulling from gitlab/gitlab-runner939df20fa9351a1: Pulling fs layer940262d98bee1df: Pulling fs layer941708e557c2e00: Pulling fs layer942708e557c2e00: Verifying Checksum943708e557c2e00: Download complete944df20fa9351a1: Verifying Checksum945df20fa9351a1: Download complete946df20fa9351a1: Pull complete947262d98bee1df: Verifying Checksum948262d98bee1df: Download complete949262d98bee1df: Pull complete950708e557c2e00: Pull complete951Digest: sha256:21e3237510a39b0cb4c68e8b7ae04cc5912c6b5b73d4e2969d4069ec2f655a04952Status: Downloaded newer image for gitlab/gitlab-runner:alpine953Executing `docker network inspect test`954[]955Error: No such network: test956Executing `docker network inspect test`957[]958Error: No such network: test959Executing `docker run -d --rm --network bridge --name qa-runner-ips6x2l78guzfnghr35q1fo2f5nkjnio --privileged registry.gitlab.com/gitlab-org/gitlab-runner:alpine && docker cp /tmp/gitlab-cert20220110-79-153w06y qa-runner-ips6x2l78guzfnghr35q1fo2f5nkjnio:/etc/gitlab-runner/certs/gitlab.test.crt && docker exec --detach qa-runner-ips6x2l78guzfnghr35q1fo2f5nkjnio sh -c "printf 'concurrent = 1\ncheck_interval = 0\n\n[session_server]\n session_timeout = 1800' > /etc/gitlab-runner/config.toml && gitlab-runner register --non-interactive --name qa-runner-ips6x2l78guzfnghr35q1fo2f5nkjnio --url https://gitlab-review-pedropombe-dh031e.gitlab-review.app --registration-token 2wCG3_3GM7QZHGn1jX3t --tag-list qa-runner-ips6x2l78guzfnghr35q1fo2f5nkjnio --executor shell && gitlab-runner run" `960Unable to find image 'registry.gitlab.com/gitlab-org/gitlab-runner:alpine' locally961alpine: Pulling from gitlab-org/gitlab-runner962Digest: sha256:21e3237510a39b0cb4c68e8b7ae04cc5912c6b5b73d4e2969d4069ec2f655a04963Status: Downloaded newer image for registry.gitlab.com/gitlab-org/gitlab-runner:alpine96474b9d6bee9344ff2f6b595aec5f3437bb19a5ef660085bd93d5c6c35bfdaaed3965Executing `docker network inspect test`966[]967Error: No such network: test968Executing `docker network inspect test`969[]970Error: No such network: test971D, [2022-01-10T14:59:47.185473 #79] DEBUG -- : ==> Built a QA::Resource::Runner with name 'qa-runner-ips6x2l78guzfnghr35q1fo2f5nkjnio' via api in 8.770887746 seconds972D, [2022-01-10T14:59:48.935292 #79] DEBUG -- : ==> Built a QA::Resource::Repository::Commit via api in 1.734622661 seconds973/usr/local/bundle/gems/capybara-3.35.3/lib/capybara/registration_container.rb:21: warning: DEPRECATED: Calling 'include?' on the drivers/servers container is deprecated without replacement974D, [2022-01-10T14:59:49.420746 #79] DEBUG -- : has_element? :login_page (wait: 60) returned: true975D, [2022-01-10T14:59:49.429794 #79] DEBUG -- : has_element? :login_page (wait: 0) returned: true976D, [2022-01-10T14:59:49.437893 #79] DEBUG -- : has_element? :login_page (wait: 0) returned: true977D, [2022-01-10T14:59:49.548745 #79] DEBUG -- : waiting for loading to complete...978D, [2022-01-10T14:59:49.553566 #79] DEBUG -- : loading complete after 0.0047475 seconds979D, [2022-01-10T14:59:50.555624 #79] DEBUG -- : has_element? :sign_in_tab (wait: 0) returned: false980D, [2022-01-10T14:59:50.567052 #79] DEBUG -- : waiting for loading to complete...981D, [2022-01-10T14:59:50.571984 #79] DEBUG -- : loading complete after 0.004876469 seconds982D, [2022-01-10T14:59:51.578664 #79] DEBUG -- : has_element? :standard_tab (wait: 0) returned: false983D, [2022-01-10T14:59:51.578744 #79] DEBUG -- : filling :login_field with "root"984D, [2022-01-10T14:59:51.578792 #79] DEBUG -- : finding :login_field with args {}985D, [2022-01-10T14:59:51.581430 #79] DEBUG -- : waiting for loading to complete...986D, [2022-01-10T14:59:51.586835 #79] DEBUG -- : loading complete after 0.00536092 seconds987D, [2022-01-10T14:59:51.598218 #79] DEBUG -- : found :login_field988D, [2022-01-10T14:59:51.627486 #79] DEBUG -- : filling :password_field with "*****"989D, [2022-01-10T14:59:51.627570 #79] DEBUG -- : finding :password_field with args {}990D, [2022-01-10T14:59:51.630382 #79] DEBUG -- : waiting for loading to complete...991D, [2022-01-10T14:59:51.635416 #79] DEBUG -- : loading complete after 0.00498345 seconds992D, [2022-01-10T14:59:51.647497 #79] DEBUG -- : found :password_field993D, [2022-01-10T14:59:51.707311 #79] DEBUG -- : clicking :sign_in_button with args {}994D, [2022-01-10T14:59:51.710377 #79] DEBUG -- : waiting for loading to complete...995D, [2022-01-10T14:59:51.715372 #79] DEBUG -- : loading complete after 0.00494323 seconds996D, [2022-01-10T14:59:53.027259 #79] DEBUG -- : waiting for loading to complete...997D, [2022-01-10T14:59:53.035473 #79] DEBUG -- : loading complete after 0.00812306 seconds998D, [2022-01-10T14:59:53.056912 #79] DEBUG -- : has_no_element? :#<QA::Page::Element:0x000055a6c57b9168> (wait: 0) returned: false999D, [2022-01-10T14:59:53.059553 #79] DEBUG -- : waiting for loading to complete...1000D, [2022-01-10T14:59:53.067830 #79] DEBUG -- : loading complete after 0.008233089 seconds1001D, [2022-01-10T14:59:53.075391 #79] DEBUG -- : has_no_element? :#<QA::Page::Element:0x000055a6c57b8ec0> (wait: 0) returned: true1002D, [2022-01-10T14:59:53.541531 #79] DEBUG -- : has_element? :navbar (wait: 60) returned: true1003D, [2022-01-10T14:59:53.552571 #79] DEBUG -- : has_element? :user_avatar (wait: 60) returned: true1004D, [2022-01-10T14:59:53.563948 #79] DEBUG -- : has_element? :user_menu (wait: 60) returned: true1005D, [2022-01-10T14:59:53.575328 #79] DEBUG -- : has_element? :issues_shortcut_button (wait: 60) returned: true1006D, [2022-01-10T14:59:53.587786 #79] DEBUG -- : has_element? :merge_requests_shortcut_button (wait: 60) returned: true1007D, [2022-01-10T14:59:53.599314 #79] DEBUG -- : has_element? :todos_shortcut_button (wait: 60) returned: true1008D, [2022-01-10T14:59:53.839063 #79] DEBUG -- : Visiting QA::Resource::Project at "https://gitlab-review-pedropombe-dh031e.gitlab-review.app/gitlab-qa-sandbox-group/qa-test-2022-01-10-14-57-22-941745e58b2d5a1c/pipelines-for-merge-trains-80baee37afad7e86"1009D, [2022-01-10T14:59:55.237660 #79] DEBUG -- : waiting for loading to complete...1010D, [2022-01-10T14:59:55.292458 #79] DEBUG -- : loading complete after 0.054722005 seconds1011D, [2022-01-10T14:59:55.292531 #79] DEBUG -- : within element :project_sidebar with args {}1012D, [2022-01-10T14:59:55.294923 #79] DEBUG -- : waiting for loading to complete...1013D, [2022-01-10T14:59:55.310606 #79] DEBUG -- : loading complete after 0.015630019 seconds1014D, [2022-01-10T14:59:55.323603 #79] DEBUG -- : scrolling to :[data-qa-selector="sidebar_menu_link"],.qa-sidebar-menu-link1015D, [2022-01-10T14:59:55.326009 #79] DEBUG -- : waiting for loading to complete...1016D, [2022-01-10T14:59:55.344186 #79] DEBUG -- : loading complete after 0.018100999 seconds1017D, [2022-01-10T14:59:55.348942 #79] DEBUG -- : finding :sidebar_menu_link with args {:menu_item=>"Settings"}1018D, [2022-01-10T14:59:55.351624 #79] DEBUG -- : waiting for loading to complete...1019D, [2022-01-10T14:59:55.357795 #79] DEBUG -- : loading complete after 0.00612796 seconds1020D, [2022-01-10T14:59:55.368876 #79] DEBUG -- : found :sidebar_menu_link1021D, [2022-01-10T14:59:55.645993 #79] DEBUG -- : clicking :sidebar_menu_item_link with args {:menu_item=>"General"}1022D, [2022-01-10T14:59:55.648443 #79] DEBUG -- : waiting for loading to complete...1023D, [2022-01-10T14:59:55.655761 #79] DEBUG -- : loading complete after 0.00726819 seconds1024D, [2022-01-10T14:59:58.086771 #79] DEBUG -- : end within element :project_sidebar with args {}1025D, [2022-01-10T14:59:58.121722 #79] DEBUG -- : within element :merge_request_settings_content with args {}1026D, [2022-01-10T14:59:58.776222 #79] DEBUG -- : waiting for loading to complete...1027D, [2022-01-10T14:59:58.786885 #79] DEBUG -- : loading complete after 0.010575669 seconds1028D, [2022-01-10T15:00:00.008310 #79] DEBUG -- : end within element :merge_request_settings_content with args {}1029D, [2022-01-10T15:00:00.008798 #79] DEBUG -- : checking :merged_results_pipeline_checkbox1030D, [2022-01-10T15:00:00.009002 #79] DEBUG -- : finding :merged_results_pipeline_checkbox with args {:visible=>false}1031D, [2022-01-10T15:00:00.012339 #79] DEBUG -- : waiting for loading to complete...1032D, [2022-01-10T15:00:00.051789 #79] DEBUG -- : loading complete after 0.039378437 seconds1033D, [2022-01-10T15:00:00.071885 #79] DEBUG -- : found :merged_results_pipeline_checkbox1034D, [2022-01-10T15:00:00.086674 #79] DEBUG -- : finding :merged_results_pipeline_checkbox with args {:visible=>false}1035D, [2022-01-10T15:00:00.089729 #79] DEBUG -- : waiting for loading to complete...1036D, [2022-01-10T15:00:00.119309 #79] DEBUG -- : loading complete after 0.029507727 seconds1037D, [2022-01-10T15:00:00.133041 #79] DEBUG -- : found :merged_results_pipeline_checkbox1038D, [2022-01-10T15:00:00.199343 #79] DEBUG -- : finding :merged_results_pipeline_checkbox with args {:visible=>false}1039D, [2022-01-10T15:00:00.202072 #79] DEBUG -- : waiting for loading to complete...1040D, [2022-01-10T15:00:00.216743 #79] DEBUG -- : loading complete after 0.014609798 seconds1041D, [2022-01-10T15:00:00.222184 #79] DEBUG -- : found :merged_results_pipeline_checkbox1042D, [2022-01-10T15:00:00.230586 #79] DEBUG -- : merged_results_pipeline_checkbox was checked1043D, [2022-01-10T15:00:00.230672 #79] DEBUG -- : checking :merge_trains_checkbox1044D, [2022-01-10T15:00:00.230709 #79] DEBUG -- : finding :merge_trains_checkbox with args {:visible=>false}1045D, [2022-01-10T15:00:00.233344 #79] DEBUG -- : waiting for loading to complete...1046D, [2022-01-10T15:00:00.246191 #79] DEBUG -- : loading complete after 0.012796019 seconds1047D, [2022-01-10T15:00:00.254395 #79] DEBUG -- : found :merge_trains_checkbox1048D, [2022-01-10T15:00:00.265676 #79] DEBUG -- : finding :merge_trains_checkbox with args {:visible=>false}1049D, [2022-01-10T15:00:00.268359 #79] DEBUG -- : waiting for loading to complete...1050D, [2022-01-10T15:00:00.280679 #79] DEBUG -- : loading complete after 0.012267268 seconds1051D, [2022-01-10T15:00:00.286402 #79] DEBUG -- : found :merge_trains_checkbox1052D, [2022-01-10T15:00:00.326675 #79] DEBUG -- : finding :merge_trains_checkbox with args {:visible=>false}1053D, [2022-01-10T15:00:00.329422 #79] DEBUG -- : waiting for loading to complete...1054D, [2022-01-10T15:00:00.337993 #79] DEBUG -- : loading complete after 0.008522099 seconds1055D, [2022-01-10T15:00:00.344463 #79] DEBUG -- : found :merge_trains_checkbox1056D, [2022-01-10T15:00:00.348413 #79] DEBUG -- : merge_trains_checkbox was checked1057D, [2022-01-10T15:00:00.348467 #79] DEBUG -- : clicking :save_merge_request_changes_button with args {}1058D, [2022-01-10T15:00:00.351013 #79] DEBUG -- : waiting for loading to complete...1059D, [2022-01-10T15:00:00.359698 #79] DEBUG -- : loading complete after 0.008620789 seconds1060D, [2022-01-10T15:00:05.490814 #79] DEBUG -- : ==> Built a QA::Resource::Repository::Commit via api in 0.442480774 seconds1061D, [2022-01-10T15:00:06.428557 #79] DEBUG -- : ==> Built a QA::Resource::MergeRequest via api in 1.617833439 seconds1062D, [2022-01-10T15:00:06.428658 #79] DEBUG -- : Visiting QA::Resource::MergeRequest at "https://gitlab-review-pedropombe-dh031e.gitlab-review.app/gitlab-qa-sandbox-group/qa-test-2022-01-10-14-57-22-941745e58b2d5a1c/pipelines-for-merge-trains-80baee37afad7e86/-/merge_requests/1"1063D, [2022-01-10T15:00:20.554914 #79] DEBUG -- : has_element? :merge_request_pipeline_info_content with text "passed" (wait: 15) returned: true1064D, [2022-01-10T15:00:20.570515 #79] DEBUG -- : has_element? :merge_button (wait: 10) returned: true1065D, [2022-01-10T15:00:20.570602 #79] DEBUG -- : finding :merge_button with args {}1066D, [2022-01-10T15:00:20.575159 #79] DEBUG -- : waiting for loading to complete...1067D, [2022-01-10T15:00:20.584123 #79] DEBUG -- : loading complete after 0.00889853 seconds1068D, [2022-01-10T15:00:20.597854 #79] DEBUG -- : found :merge_button1069D, [2022-01-10T15:00:20.601125 #79] DEBUG -- : finding :merge_button with args {}1070D, [2022-01-10T15:00:20.603574 #79] DEBUG -- : waiting for loading to complete...1071D, [2022-01-10T15:00:20.613226 #79] DEBUG -- : loading complete after 0.00959085 seconds1072D, [2022-01-10T15:00:20.621749 #79] DEBUG -- : found :merge_button1073D, [2022-01-10T15:00:30.625341 #79] DEBUG -- : clicking :merge_button with args {}1074D, [2022-01-10T15:00:30.627792 #79] DEBUG -- : waiting for loading to complete...1075D, [2022-01-10T15:00:30.636225 #79] DEBUG -- : loading complete after 0.00838734 seconds1076D, [2022-01-10T15:00:30.697989 #79] DEBUG -- : waiting for loading to complete...1077D, [2022-01-10T15:00:31.399620 #79] DEBUG -- : loading complete after 0.701295194 seconds1078D, [2022-01-10T15:00:40.100584 #79] DEBUG -- : has_element? :merged_status_content with text "The changes were merged into" (wait: 20) returned: true1079Executing `docker rm -f qa-runner-ips6x2l78guzfnghr35q1fo2f5nkjnio`1080qa-runner-ips6x2l78guzfnghr35q1fo2f5nkjnio1081 merges via a merge train1082D, [2022-01-10T15:00:40.812464 #79] DEBUG -- : 1083Starting test: Verify Pipelines for merged results and merge trains creates a pipeline with merged results1084D, [2022-01-10T15:00:41.036916 #79] DEBUG -- : ==> Built a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group' via api in 0.216889822 seconds1085D, [2022-01-10T15:00:41.644309 #79] DEBUG -- : <QA::Resource::Group> Attribute :full_path has both API response `gitlab-qa-sandbox-group/qa-test-2022-01-10-14-57-22-941745e58b2d5a1c` and a block. API response will be picked. Block will be ignored.1086D, [2022-01-10T15:00:41.644370 #79] DEBUG -- : ==> Built a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group/qa-test-2022-01-10-14-57-22-941745e58b2d5a1c' via api in 0.826548423 seconds1087D, [2022-01-10T15:00:43.531203 #79] DEBUG -- : ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group/qa-test-2022-01-10-14-57-22-941745e58b2d5a1c/pipelines-for-merge-trains-25967a5b662d7119' via api in 2.715643151 seconds1088/builds/gitlab-org-forks/gitlab/qa/qa/specs/features/ee/browser_ui/4_verify/pipelines_for_merged_results_and_merge_trains_spec.rb:12: Passing `number` with the 1st argument of `alphanumeric` is deprecated. Use keyword argument like `alphanumeric(number: ...)` instead.1089To automatically update from positional arguments to keyword arguments,1090install rubocop-faker and run:1091rubocop \1092 --require rubocop-faker \1093 --only Faker/DeprecatedArguments \1094 --auto-correct1095Executing `docker pull gitlab/gitlab-runner:alpine`1096alpine: Pulling from gitlab/gitlab-runner1097Digest: sha256:21e3237510a39b0cb4c68e8b7ae04cc5912c6b5b73d4e2969d4069ec2f655a041098Status: Image is up to date for gitlab/gitlab-runner:alpine1099Executing `docker network inspect test`1100[]1101Error: No such network: test1102Executing `docker network inspect test`1103[]1104Error: No such network: test1105Executing `docker run -d --rm --network bridge --name qa-runner-l4fats5b6wxozns1eqavh0a8krsgiebv --privileged registry.gitlab.com/gitlab-org/gitlab-runner:alpine && docker cp /tmp/gitlab-cert20220110-79-4gyaxk qa-runner-l4fats5b6wxozns1eqavh0a8krsgiebv:/etc/gitlab-runner/certs/gitlab.test.crt && docker exec --detach qa-runner-l4fats5b6wxozns1eqavh0a8krsgiebv sh -c "printf 'concurrent = 1\ncheck_interval = 0\n\n[session_server]\n session_timeout = 1800' > /etc/gitlab-runner/config.toml && gitlab-runner register --non-interactive --name qa-runner-l4fats5b6wxozns1eqavh0a8krsgiebv --url https://gitlab-review-pedropombe-dh031e.gitlab-review.app --registration-token zST_2xz8XfQLCJDS1uit --tag-list qa-runner-l4fats5b6wxozns1eqavh0a8krsgiebv --executor shell && gitlab-runner run" `11067c111d78babefeaa3e368a8a0a5994afafaf80997205ef4d3cf1441e36ad12961107Executing `docker network inspect test`1108[]1109Error: No such network: test1110Executing `docker network inspect test`1111[]1112Error: No such network: test1113D, [2022-01-10T15:00:44.413644 #79] DEBUG -- : ==> Built a QA::Resource::Runner with name 'qa-runner-l4fats5b6wxozns1eqavh0a8krsgiebv' via api in 0.878156621 seconds1114D, [2022-01-10T15:00:45.352315 #79] DEBUG -- : ==> Built a QA::Resource::Repository::Commit via api in 0.932883965 seconds1115/usr/local/bundle/gems/capybara-3.35.3/lib/capybara/registration_container.rb:21: warning: DEPRECATED: Calling 'include?' on the drivers/servers container is deprecated without replacement1116D, [2022-01-10T15:00:45.752967 #79] DEBUG -- : has_element? :login_page (wait: 60) returned: true1117D, [2022-01-10T15:00:45.761829 #79] DEBUG -- : has_element? :login_page (wait: 0) returned: true1118D, [2022-01-10T15:00:45.770457 #79] DEBUG -- : has_element? :login_page (wait: 0) returned: true1119D, [2022-01-10T15:00:45.889237 #79] DEBUG -- : waiting for loading to complete...1120D, [2022-01-10T15:00:45.894168 #79] DEBUG -- : loading complete after 0.004856249 seconds1121D, [2022-01-10T15:00:46.895094 #79] DEBUG -- : has_element? :sign_in_tab (wait: 0) returned: false1122D, [2022-01-10T15:00:46.905458 #79] DEBUG -- : waiting for loading to complete...1123D, [2022-01-10T15:00:46.910188 #79] DEBUG -- : loading complete after 0.00466993 seconds1124D, [2022-01-10T15:00:47.911990 #79] DEBUG -- : has_element? :standard_tab (wait: 0) returned: false1125D, [2022-01-10T15:00:47.912116 #79] DEBUG -- : filling :login_field with "root"1126D, [2022-01-10T15:00:47.912191 #79] DEBUG -- : finding :login_field with args {}1127D, [2022-01-10T15:00:47.914560 #79] DEBUG -- : waiting for loading to complete...1128D, [2022-01-10T15:00:47.919466 #79] DEBUG -- : loading complete after 0.00483842 seconds1129D, [2022-01-10T15:00:47.930953 #79] DEBUG -- : found :login_field1130D, [2022-01-10T15:00:47.961346 #79] DEBUG -- : filling :password_field with "*****"1131D, [2022-01-10T15:00:47.961413 #79] DEBUG -- : finding :password_field with args {}1132D, [2022-01-10T15:00:47.964066 #79] DEBUG -- : waiting for loading to complete...1133D, [2022-01-10T15:00:47.969079 #79] DEBUG -- : loading complete after 0.00496397 seconds1134D, [2022-01-10T15:00:47.980504 #79] DEBUG -- : found :password_field1135D, [2022-01-10T15:00:48.053141 #79] DEBUG -- : clicking :sign_in_button with args {}1136D, [2022-01-10T15:00:48.057370 #79] DEBUG -- : waiting for loading to complete...1137D, [2022-01-10T15:00:48.063329 #79] DEBUG -- : loading complete after 0.005905139 seconds1138D, [2022-01-10T15:00:49.392711 #79] DEBUG -- : waiting for loading to complete...1139D, [2022-01-10T15:00:49.400870 #79] DEBUG -- : loading complete after 0.00804361 seconds1140D, [2022-01-10T15:00:49.421156 #79] DEBUG -- : has_no_element? :#<QA::Page::Element:0x000055a6c57b9168> (wait: 0) returned: false1141D, [2022-01-10T15:00:49.423788 #79] DEBUG -- : waiting for loading to complete...1142D, [2022-01-10T15:00:49.432664 #79] DEBUG -- : loading complete after 0.008825769 seconds1143D, [2022-01-10T15:00:49.440155 #79] DEBUG -- : has_no_element? :#<QA::Page::Element:0x000055a6c57b8ec0> (wait: 0) returned: true1144D, [2022-01-10T15:00:49.875600 #79] DEBUG -- : has_element? :navbar (wait: 60) returned: true1145D, [2022-01-10T15:00:49.886435 #79] DEBUG -- : has_element? :user_avatar (wait: 60) returned: true1146D, [2022-01-10T15:00:49.897624 #79] DEBUG -- : has_element? :user_menu (wait: 60) returned: true1147D, [2022-01-10T15:00:49.909263 #79] DEBUG -- : has_element? :issues_shortcut_button (wait: 60) returned: true1148D, [2022-01-10T15:00:49.920503 #79] DEBUG -- : has_element? :merge_requests_shortcut_button (wait: 60) returned: true1149D, [2022-01-10T15:00:49.933239 #79] DEBUG -- : has_element? :todos_shortcut_button (wait: 60) returned: true1150D, [2022-01-10T15:00:50.148610 #79] DEBUG -- : Visiting QA::Resource::Project at "https://gitlab-review-pedropombe-dh031e.gitlab-review.app/gitlab-qa-sandbox-group/qa-test-2022-01-10-14-57-22-941745e58b2d5a1c/pipelines-for-merge-trains-25967a5b662d7119"1151D, [2022-01-10T15:00:51.896868 #79] DEBUG -- : waiting for loading to complete...1152D, [2022-01-10T15:00:51.908691 #79] DEBUG -- : loading complete after 0.011754839 seconds1153D, [2022-01-10T15:00:51.908752 #79] DEBUG -- : within element :project_sidebar with args {}1154D, [2022-01-10T15:00:51.911376 #79] DEBUG -- : waiting for loading to complete...1155D, [2022-01-10T15:00:51.922145 #79] DEBUG -- : loading complete after 0.010720939 seconds1156D, [2022-01-10T15:00:51.933551 #79] DEBUG -- : scrolling to :[data-qa-selector="sidebar_menu_link"],.qa-sidebar-menu-link1157D, [2022-01-10T15:00:51.936100 #79] DEBUG -- : waiting for loading to complete...1158D, [2022-01-10T15:00:51.944649 #79] DEBUG -- : loading complete after 0.00846779 seconds1159D, [2022-01-10T15:00:51.947957 #79] DEBUG -- : finding :sidebar_menu_link with args {:menu_item=>"Settings"}1160D, [2022-01-10T15:00:51.950317 #79] DEBUG -- : waiting for loading to complete...1161D, [2022-01-10T15:00:51.955166 #79] DEBUG -- : loading complete after 0.00480549 seconds1162D, [2022-01-10T15:00:51.967316 #79] DEBUG -- : found :sidebar_menu_link1163D, [2022-01-10T15:00:52.244987 #79] DEBUG -- : clicking :sidebar_menu_item_link with args {:menu_item=>"General"}1164D, [2022-01-10T15:00:52.247682 #79] DEBUG -- : waiting for loading to complete...1165D, [2022-01-10T15:00:52.254983 #79] DEBUG -- : loading complete after 0.00724606 seconds1166D, [2022-01-10T15:00:53.949724 #79] DEBUG -- : end within element :project_sidebar with args {}1167D, [2022-01-10T15:00:53.950043 #79] DEBUG -- : within element :merge_request_settings_content with args {}1168D, [2022-01-10T15:00:54.692187 #79] DEBUG -- : waiting for loading to complete...1169D, [2022-01-10T15:00:54.711021 #79] DEBUG -- : loading complete after 0.018679489 seconds1170D, [2022-01-10T15:00:55.922865 #79] DEBUG -- : end within element :merge_request_settings_content with args {}1171D, [2022-01-10T15:00:55.923203 #79] DEBUG -- : checking :merged_results_pipeline_checkbox1172D, [2022-01-10T15:00:55.923425 #79] DEBUG -- : finding :merged_results_pipeline_checkbox with args {:visible=>false}1173D, [2022-01-10T15:00:55.926651 #79] DEBUG -- : waiting for loading to complete...1174D, [2022-01-10T15:00:55.960755 #79] DEBUG -- : loading complete after 0.033936427 seconds1175D, [2022-01-10T15:00:55.971410 #79] DEBUG -- : found :merged_results_pipeline_checkbox1176D, [2022-01-10T15:00:55.996917 #79] DEBUG -- : finding :merged_results_pipeline_checkbox with args {:visible=>false}1177D, [2022-01-10T15:00:56.014415 #79] DEBUG -- : waiting for loading to complete...1178D, [2022-01-10T15:00:56.043355 #79] DEBUG -- : loading complete after 0.028601428 seconds1179D, [2022-01-10T15:00:56.066903 #79] DEBUG -- : found :merged_results_pipeline_checkbox1180D, [2022-01-10T15:00:56.130691 #79] DEBUG -- : finding :merged_results_pipeline_checkbox with args {:visible=>false}1181D, [2022-01-10T15:00:56.133532 #79] DEBUG -- : waiting for loading to complete...1182D, [2022-01-10T15:00:56.146975 #79] DEBUG -- : loading complete after 0.013388289 seconds1183D, [2022-01-10T15:00:56.152745 #79] DEBUG -- : found :merged_results_pipeline_checkbox1184D, [2022-01-10T15:00:56.160531 #79] DEBUG -- : merged_results_pipeline_checkbox was checked1185D, [2022-01-10T15:00:56.160626 #79] DEBUG -- : checking :merge_trains_checkbox1186D, [2022-01-10T15:00:56.160701 #79] DEBUG -- : finding :merge_trains_checkbox with args {:visible=>false}1187D, [2022-01-10T15:00:56.163428 #79] DEBUG -- : waiting for loading to complete...1188D, [2022-01-10T15:00:56.177341 #79] DEBUG -- : loading complete after 0.013858269 seconds1189D, [2022-01-10T15:00:56.185497 #79] DEBUG -- : found :merge_trains_checkbox1190D, [2022-01-10T15:00:56.194958 #79] DEBUG -- : finding :merge_trains_checkbox with args {:visible=>false}1191D, [2022-01-10T15:00:56.197872 #79] DEBUG -- : waiting for loading to complete...1192D, [2022-01-10T15:00:56.211648 #79] DEBUG -- : loading complete after 0.013718279 seconds1193D, [2022-01-10T15:00:56.217332 #79] DEBUG -- : found :merge_trains_checkbox1194D, [2022-01-10T15:00:56.257162 #79] DEBUG -- : finding :merge_trains_checkbox with args {:visible=>false}1195D, [2022-01-10T15:00:56.260773 #79] DEBUG -- : waiting for loading to complete...1196D, [2022-01-10T15:00:56.270066 #79] DEBUG -- : loading complete after 0.009092629 seconds1197D, [2022-01-10T15:00:56.276436 #79] DEBUG -- : found :merge_trains_checkbox1198D, [2022-01-10T15:00:56.280508 #79] DEBUG -- : merge_trains_checkbox was checked1199D, [2022-01-10T15:00:56.280560 #79] DEBUG -- : clicking :save_merge_request_changes_button with args {}1200D, [2022-01-10T15:00:56.283018 #79] DEBUG -- : waiting for loading to complete...1201D, [2022-01-10T15:00:56.291528 #79] DEBUG -- : loading complete after 0.00844809 seconds1202D, [2022-01-10T15:01:00.027546 #79] DEBUG -- : ==> Built a QA::Resource::Repository::Commit via api in 1.288163726 seconds1203D, [2022-01-10T15:01:00.868766 #79] DEBUG -- : ==> Built a QA::Resource::MergeRequest via api in 2.62338846 seconds1204D, [2022-01-10T15:01:00.868859 #79] DEBUG -- : Visiting QA::Resource::MergeRequest at "https://gitlab-review-pedropombe-dh031e.gitlab-review.app/gitlab-qa-sandbox-group/qa-test-2022-01-10-14-57-22-941745e58b2d5a1c/pipelines-for-merge-trains-25967a5b662d7119/-/merge_requests/1"1205D, [2022-01-10T15:01:14.173175 #79] DEBUG -- : has_element? :merge_request_pipeline_info_content with text "passed" (wait: 15) returned: true1206D, [2022-01-10T15:01:14.173264 #79] DEBUG -- : clicking :merge_moment_dropdown with args {}1207D, [2022-01-10T15:01:14.175949 #79] DEBUG -- : waiting for loading to complete...1208D, [2022-01-10T15:01:14.184483 #79] DEBUG -- : loading complete after 0.008484729 seconds1209D, [2022-01-10T15:01:14.231226 #79] DEBUG -- : clicking :merge_immediately_menu_item with args {}1210D, [2022-01-10T15:01:14.233913 #79] DEBUG -- : waiting for loading to complete...1211D, [2022-01-10T15:01:14.244780 #79] DEBUG -- : loading complete after 0.010811179 seconds1212D, [2022-01-10T15:01:14.332108 #79] DEBUG -- : waiting for animated element: merge_immediately_button1213D, [2022-01-10T15:01:14.383973 #79] DEBUG -- : has_element? :merge_immediately_button (wait: 10) returned: true1214D, [2022-01-10T15:01:15.384935 #79] DEBUG -- : clicking :merge_immediately_button with args {}1215D, [2022-01-10T15:01:15.388098 #79] DEBUG -- : waiting for loading to complete...1216D, [2022-01-10T15:01:15.400351 #79] DEBUG -- : loading complete after 0.012195789 seconds1217D, [2022-01-10T15:01:15.465505 #79] DEBUG -- : waiting for loading to complete...1218D, [2022-01-10T15:01:20.952340 #79] DEBUG -- : loading complete after 5.486749611 seconds1219D, [2022-01-10T15:01:22.370258 #79] DEBUG -- : has_element? :merged_status_content with text "The changes were merged into" (wait: 20) returned: true1220Executing `docker rm -f qa-runner-l4fats5b6wxozns1eqavh0a8krsgiebv`1221qa-runner-l4fats5b6wxozns1eqavh0a8krsgiebv1222 creates a pipeline with merged results1223Plan1224 mention1225D, [2022-01-10T15:01:23.106660 #79] DEBUG -- : 1226Starting test: Plan mention mentions another user in an issue1227/usr/local/bundle/gems/capybara-3.35.3/lib/capybara/registration_container.rb:21: warning: DEPRECATED: Calling 'include?' on the drivers/servers container is deprecated without replacement1228D, [2022-01-10T15:01:23.424138 #79] DEBUG -- : has_element? :login_page (wait: 60) returned: true1229D, [2022-01-10T15:01:23.432211 #79] DEBUG -- : has_element? :login_page (wait: 0) returned: true1230D, [2022-01-10T15:01:23.441256 #79] DEBUG -- : has_element? :login_page (wait: 0) returned: true1231D, [2022-01-10T15:01:23.548966 #79] DEBUG -- : waiting for loading to complete...1232D, [2022-01-10T15:01:23.553966 #79] DEBUG -- : loading complete after 0.004914559 seconds1233D, [2022-01-10T15:01:24.558708 #79] DEBUG -- : has_element? :sign_in_tab (wait: 0) returned: false1234D, [2022-01-10T15:01:24.568799 #79] DEBUG -- : waiting for loading to complete...1235D, [2022-01-10T15:01:24.573564 #79] DEBUG -- : loading complete after 0.004709549 seconds1236D, [2022-01-10T15:01:25.575412 #79] DEBUG -- : has_element? :standard_tab (wait: 0) returned: false1237D, [2022-01-10T15:01:25.575488 #79] DEBUG -- : filling :login_field with "root"1238D, [2022-01-10T15:01:25.575744 #79] DEBUG -- : finding :login_field with args {}1239D, [2022-01-10T15:01:25.578233 #79] DEBUG -- : waiting for loading to complete...1240D, [2022-01-10T15:01:25.583137 #79] DEBUG -- : loading complete after 0.00485102 seconds1241D, [2022-01-10T15:01:25.595642 #79] DEBUG -- : found :login_field1242D, [2022-01-10T15:01:25.626751 #79] DEBUG -- : filling :password_field with "*****"1243D, [2022-01-10T15:01:25.626809 #79] DEBUG -- : finding :password_field with args {}1244D, [2022-01-10T15:01:25.629463 #79] DEBUG -- : waiting for loading to complete...1245D, [2022-01-10T15:01:25.634422 #79] DEBUG -- : loading complete after 0.00491175 seconds1246D, [2022-01-10T15:01:25.646740 #79] DEBUG -- : found :password_field1247D, [2022-01-10T15:01:25.714693 #79] DEBUG -- : clicking :sign_in_button with args {}1248D, [2022-01-10T15:01:25.717521 #79] DEBUG -- : waiting for loading to complete...1249D, [2022-01-10T15:01:25.724528 #79] DEBUG -- : loading complete after 0.00696032 seconds1250D, [2022-01-10T15:01:27.495501 #79] DEBUG -- : waiting for loading to complete...1251D, [2022-01-10T15:01:27.505134 #79] DEBUG -- : loading complete after 0.00937786 seconds1252D, [2022-01-10T15:01:27.525945 #79] DEBUG -- : has_no_element? :#<QA::Page::Element:0x000055a6c57b9168> (wait: 0) returned: false1253D, [2022-01-10T15:01:27.528510 #79] DEBUG -- : waiting for loading to complete...1254D, [2022-01-10T15:01:27.536412 #79] DEBUG -- : loading complete after 0.007854369 seconds1255D, [2022-01-10T15:01:27.544854 #79] DEBUG -- : has_no_element? :#<QA::Page::Element:0x000055a6c57b8ec0> (wait: 0) returned: true1256D, [2022-01-10T15:01:28.011620 #79] DEBUG -- : has_element? :navbar (wait: 60) returned: true1257D, [2022-01-10T15:01:28.022281 #79] DEBUG -- : has_element? :user_avatar (wait: 60) returned: true1258D, [2022-01-10T15:01:28.033513 #79] DEBUG -- : has_element? :user_menu (wait: 60) returned: true1259D, [2022-01-10T15:01:28.044659 #79] DEBUG -- : has_element? :issues_shortcut_button (wait: 60) returned: true1260D, [2022-01-10T15:01:28.055951 #79] DEBUG -- : has_element? :merge_requests_shortcut_button (wait: 60) returned: true1261D, [2022-01-10T15:01:28.066798 #79] DEBUG -- : has_element? :todos_shortcut_button (wait: 60) returned: true1262D, [2022-01-10T15:01:28.572342 #79] DEBUG -- : ==> Built a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group' via api in 0.228744282 seconds1263D, [2022-01-10T15:01:29.615982 #79] DEBUG -- : <QA::Resource::Group> Attribute :full_path has both API response `gitlab-qa-sandbox-group/qa-test-2022-01-10-14-57-22-941745e58b2d5a1c` and a block. API response will be picked. Block will be ignored.1264D, [2022-01-10T15:01:29.616086 #79] DEBUG -- : ==> Built a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group/qa-test-2022-01-10-14-57-22-941745e58b2d5a1c' via api in 1.274457632 seconds1265D, [2022-01-10T15:01:30.551566 #79] DEBUG -- : ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group/qa-test-2022-01-10-14-57-22-941745e58b2d5a1c/project-to-test-mention-ef6d6d3dda1c7c3b' via api in 2.21216523 seconds1266I, [2022-01-10T15:01:30.551749 #79] INFO -- : Enabling feature: invite_members_group_modal for scope "project: gitlab-qa-sandbox-group/qa-test-2022-01-10-14-57-22-941745e58b2d5a1c/project-to-test-mention-ef6d6d3dda1c7c3b"1267I, [2022-01-10T15:01:30.850599 #79] INFO -- : Successfully enabled and verified feature flag: invite_members_group_modal1268D, [2022-01-10T15:01:31.234659 #79] DEBUG -- : ==> Built a QA::Resource::User with username 'gitlab-qa-user1' via api in 0.380904771 seconds1269D, [2022-01-10T15:01:31.234806 #79] DEBUG -- : Adding user gitlab-qa-user1 to gitlab-qa-sandbox-group/qa-test-2022-01-10-14-57-22-941745e58b2d5a1c/project-to-test-mention-ef6d6d3dda1c7c3b QA::Resource::Project1270D, [2022-01-10T15:01:33.019806 #79] DEBUG -- : ==> Built a QA::Resource::Issue with id '60' via api in 0.889523542 seconds1271D, [2022-01-10T15:01:33.019892 #79] DEBUG -- : Visiting QA::Resource::Issue at "https://gitlab-review-pedropombe-dh031e.gitlab-review.app/gitlab-qa-sandbox-group/qa-test-2022-01-10-14-57-22-941745e58b2d5a1c/project-to-test-mention-ef6d6d3dda1c7c3b/-/issues/1"1272D, [2022-01-10T15:01:34.906391 #79] DEBUG -- : clicking :title with args {}1273D, [2022-01-10T15:01:34.909468 #79] DEBUG -- : waiting for loading to complete...1274D, [2022-01-10T15:01:34.925936 #79] DEBUG -- : loading complete after 0.016103969 seconds1275D, [2022-01-10T15:01:34.965786 #79] DEBUG -- : clicking :discussion_filter_dropdown with args {}1276D, [2022-01-10T15:01:34.968378 #79] DEBUG -- : waiting for loading to complete...1277D, [2022-01-10T15:01:34.977572 #79] DEBUG -- : loading complete after 0.009147539 seconds1278D, [2022-01-10T15:01:35.026661 #79] DEBUG -- : finding :filter_menu_item with args {:text=>"Show all activity"}1279D, [2022-01-10T15:01:35.029758 #79] DEBUG -- : waiting for loading to complete...1280D, [2022-01-10T15:01:35.041537 #79] DEBUG -- : loading complete after 0.011720739 seconds1281D, [2022-01-10T15:01:35.074699 #79] DEBUG -- : found :filter_menu_item1282D, [2022-01-10T15:01:35.108932 #79] DEBUG -- : waiting for loading to complete...1283D, [2022-01-10T15:01:35.117522 #79] DEBUG -- : loading complete after 0.008517649 seconds1284D, [2022-01-10T15:01:35.122590 #79] DEBUG -- : waiting for loading to complete...1285D, [2022-01-10T15:01:35.131731 #79] DEBUG -- : loading complete after 0.009082819 seconds1286D, [2022-01-10T15:01:35.146502 #79] DEBUG -- : has_no_element? :discussion_filter_container (wait: 10) returned: true1287D, [2022-01-10T15:01:35.160111 #79] DEBUG -- : has_element? :comment_field (wait: 10) returned: true1288D, [2022-01-10T15:01:35.160214 #79] DEBUG -- : clicking :title with args {}1289D, [2022-01-10T15:01:35.162729 #79] DEBUG -- : waiting for loading to complete...1290D, [2022-01-10T15:01:35.174219 #79] DEBUG -- : loading complete after 0.011437759 seconds1291D, [2022-01-10T15:01:35.201259 #79] DEBUG -- : clicking :discussion_filter_dropdown with args {}1292D, [2022-01-10T15:01:35.208658 #79] DEBUG -- : waiting for loading to complete...1293D, [2022-01-10T15:01:35.217311 #79] DEBUG -- : loading complete after 0.00858696 seconds1294D, [2022-01-10T15:01:35.246270 #79] DEBUG -- : finding :filter_menu_item with args {:text=>"Show all activity"}1295D, [2022-01-10T15:01:35.248897 #79] DEBUG -- : waiting for loading to complete...1296D, [2022-01-10T15:01:35.264105 #79] DEBUG -- : loading complete after 0.015156329 seconds1297D, [2022-01-10T15:01:35.283982 #79] DEBUG -- : found :filter_menu_item1298D, [2022-01-10T15:01:35.311055 #79] DEBUG -- : waiting for loading to complete...1299D, [2022-01-10T15:01:35.321930 #79] DEBUG -- : loading complete after 0.010788709 seconds1300D, [2022-01-10T15:01:35.324527 #79] DEBUG -- : waiting for loading to complete...1301D, [2022-01-10T15:01:35.332920 #79] DEBUG -- : loading complete after 0.008349029 seconds1302D, [2022-01-10T15:01:35.343288 #79] DEBUG -- : has_no_element? :discussion_filter_container (wait: 10) returned: true1303D, [2022-01-10T15:01:35.382690 #79] DEBUG -- : has_element? :comment_field (wait: 10) returned: true1304D, [2022-01-10T15:01:35.382811 #79] DEBUG -- : filling :comment_field with "@gitlab-qa-user11305"1306D, [2022-01-10T15:01:35.382856 #79] DEBUG -- : finding :comment_field with args {}1307D, [2022-01-10T15:01:35.392000 #79] DEBUG -- : waiting for loading to complete...1308D, [2022-01-10T15:01:35.413440 #79] DEBUG -- : loading complete after 0.021339228 seconds1309D, [2022-01-10T15:01:35.444534 #79] DEBUG -- : found :comment_field1310D, [2022-01-10T15:01:35.628000 #79] DEBUG -- : clicking :comment_button with args {}1311D, [2022-01-10T15:01:36.249160 #79] DEBUG -- : waiting for loading to complete...1312D, [2022-01-10T15:01:36.257987 #79] DEBUG -- : loading complete after 0.008751209 seconds1313 mentions another user in an issue1314I, [2022-01-10T15:01:37.352105 #79] INFO -- : 1315========= Knapsack Time Offset Warning ==========1316Time offset: 30s1317Max allowed node time execution: 06m 14s1318Exceeded time: -01m 55s1320Global time execution for this CI node is fine.1321Happy testing!1322Need explanation? See FAQ:1324=================================================1325Read up on the benefits of a dynamic test split with Knapsack Pro Queue Mode:1326https://docs.knapsackpro.com/2020/how-to-speed-up-ruby-and-javascript-tests-with-ci-parallelisation1327Sign up for Knapsack Pro here:1329=================================================1330I, [2022-01-10T15:01:37.352231 #79] INFO -- : 1331Knapsack global time execution for tests: 04m 18s1332I, [2022-01-10T15:01:38.018630 #79] INFO -- : influxdb exporter: Pushed 10 entries to influxdb1333Top 10 slowest examples (258.91 seconds, 100.0% of total time):1334 Verify Pipelines for merged results and merge trains merges via a merge train1335 64.01 seconds ./qa/specs/features/ee/browser_ui/4_verify/pipelines_for_merged_results_and_merge_trains_spec.rb:801336 Verify Pipelines for merged results and merge trains creates a pipeline with merged results1337 42.29 seconds ./qa/specs/features/ee/browser_ui/4_verify/pipelines_for_merged_results_and_merge_trains_spec.rb:661338 Plan Read-only board configuration shows board configuration to user without edit permission1339 32.05 seconds ./qa/specs/features/ee/browser_ui/2_plan/issue_boards/read_only_board_configuration_spec.rb:301340 Plan Multiple assignees per issue shows the first five assignees and a +n more link in the issue page1341 21.66 seconds ./qa/specs/features/ee/browser_ui/2_plan/multiple_assignees_for_issues/more_than_four_assignees_spec.rb:571342 Plan Sum of issues weights on issue board shows the sum of issues weights in the board list's header1343 21.13 seconds ./qa/specs/features/ee/browser_ui/2_plan/issue_boards/sum_of_issues_weights_spec.rb:331344 Plan Multiple assignees per issue shows the first three assignees and a +n sign in the issues list1345 20.54 seconds ./qa/specs/features/ee/browser_ui/2_plan/multiple_assignees_for_issues/more_than_four_assignees_spec.rb:451346 Plan check xss occurence in @mentions in issues mentions a user in a comment1347 16.16 seconds ./qa/specs/features/browser_ui/2_plan/issue/check_mentions_for_xss_spec.rb:361348 Plan Issues weight visualization shows the set weight in the issue page, in the milestone page, and in the issues list page1349 15.09 seconds ./qa/specs/features/ee/browser_ui/2_plan/issues_weight/issue_weight_visualization_spec.rb:251350 Plan mention mentions another user in an issue1351 14.24 seconds ./qa/specs/features/browser_ui/2_plan/issue/mentions_spec.rb:261352 Plan Issue comments comments on an issue and edits the comment1353 11.76 seconds ./qa/specs/features/browser_ui/2_plan/issue/comment_issue_spec.rb:121354Top 8 slowest example groups:1355 Verify1356 53.15 seconds average (106.3 seconds / 2 examples) ./qa/specs/features/ee/browser_ui/4_verify/pipelines_for_merged_results_and_merge_trains_spec.rb:41357 Plan1358 32.05 seconds average (32.05 seconds / 1 example) ./qa/specs/features/ee/browser_ui/2_plan/issue_boards/read_only_board_configuration_spec.rb:51359 Plan1360 21.14 seconds average (21.14 seconds / 1 example) ./qa/specs/features/ee/browser_ui/2_plan/issue_boards/sum_of_issues_weights_spec.rb:41361 Plan1362 21.1 seconds average (42.21 seconds / 2 examples) ./qa/specs/features/ee/browser_ui/2_plan/multiple_assignees_for_issues/more_than_four_assignees_spec.rb:51363 Plan1364 16.16 seconds average (16.16 seconds / 1 example) ./qa/specs/features/browser_ui/2_plan/issue/check_mentions_for_xss_spec.rb:41365 Plan1366 15.09 seconds average (15.09 seconds / 1 example) ./qa/specs/features/ee/browser_ui/2_plan/issues_weight/issue_weight_visualization_spec.rb:41367 Plan1368 14.24 seconds average (14.24 seconds / 1 example) ./qa/specs/features/browser_ui/2_plan/issue/mentions_spec.rb:51369 Plan1370 11.76 seconds average (11.76 seconds / 1 example) ./qa/specs/features/browser_ui/2_plan/issue/comment_issue_spec.rb:41371Finished in 4 minutes 19 seconds (files took 17.44 seconds to load)137210 examples, 0 failures1373Randomized with seed 207911375Uploading artifacts...1376qa/tmp: found 40 matching files and directories 1377Uploading artifacts as "archive" to coordinator... ok id=1958299574 responseStatus=201 Created token=hp_DEyzm1378Uploading artifacts...1379qa/tmp/rspec.xml: found 1 matching files and directories 1380Uploading artifacts as "junit" to coordinator... ok id=1958299574 responseStatus=201 Created token=hp_DEyzm1382Job succeeded