2024-05-26 10:32:26.142340 | Job console starting...
2024-05-26 10:32:26.148071 | Updating repositories
2024-05-26 10:32:26.156973 | Preparing job workspace
2024-05-26 10:32:30.487047 | Running Ansible setup...
2024-05-26 10:32:33.557783 | RUN START: [trusted : gerrit/zuul-config/playbooks/start-manila-ci.yaml@master]
2024-05-26 10:32:34.041440 | 
2024-05-26 10:32:34.041525 | PLAY [Start Manila CI testing on remote GitLab runner]
2024-05-26 10:32:34.051557 | 
2024-05-26 10:32:34.051642 | TASK [Run GitLab trigger script]
2024-05-26 12:41:55.612806 | localhost | Defaulting to user installation because normal site-packages is not writeable
2024-05-26 12:41:55.613015 | localhost | Collecting real-easypy (from -r requirements.txt (line 3))
2024-05-26 12:41:55.613055 | localhost |   Cloning https://github.com/vast-data/easypy.git (to revision 94f28aa) to /var/lib/zuul/builds/d27aca183c1e40649993d7ec4244ed50/work/tmp/pip-install-35bobwb5/real-easypy_c754810ce7104fcdbcad4b300e701fb8
2024-05-26 12:41:55.613088 | localhost |   Running command git clone --filter=blob:none --quiet https://github.com/vast-data/easypy.git /var/lib/zuul/builds/d27aca183c1e40649993d7ec4244ed50/work/tmp/pip-install-35bobwb5/real-easypy_c754810ce7104fcdbcad4b300e701fb8
2024-05-26 12:41:55.613130 | localhost |   WARNING: Did not find branch or tag '94f28aa', assuming revision or ref.
2024-05-26 12:41:55.613156 | localhost |   Running command git checkout -q 94f28aa
2024-05-26 12:41:55.613178 | localhost |   Resolved https://github.com/vast-data/easypy.git to commit 94f28aa
2024-05-26 12:41:55.613201 | localhost |   Preparing metadata (setup.py): started
2024-05-26 12:41:55.613223 | localhost |   Preparing metadata (setup.py): finished with status 'done'
2024-05-26 12:41:55.613243 | localhost | Collecting python-gitlab==4.5.0 (from -r requirements.txt (line 1))
2024-05-26 12:41:55.613262 | localhost |   Downloading python_gitlab-4.5.0-py3-none-any.whl.metadata (8.2 kB)
2024-05-26 12:41:55.613281 | localhost | Collecting boto3==1.28.10 (from -r requirements.txt (line 2))
2024-05-26 12:41:55.613299 | localhost |   Downloading boto3-1.28.10-py3-none-any.whl.metadata (6.6 kB)
2024-05-26 12:41:55.613318 | localhost | Requirement already satisfied: requests>=2.25.0 in /usr/local/lib/python3.11/site-packages (from python-gitlab==4.5.0->-r requirements.txt (line 1)) (2.31.0)
2024-05-26 12:41:55.613336 | localhost | Collecting requests-toolbelt>=0.10.1 (from python-gitlab==4.5.0->-r requirements.txt (line 1))
2024-05-26 12:41:55.613360 | localhost |   Downloading requests_toolbelt-1.0.0-py2.py3-none-any.whl.metadata (14 kB)
2024-05-26 12:41:55.613400 | localhost | Collecting botocore<1.32.0,>=1.31.10 (from boto3==1.28.10->-r requirements.txt (line 2))
2024-05-26 12:41:55.613443 | localhost |   Downloading botocore-1.31.85-py3-none-any.whl.metadata (6.1 kB)
2024-05-26 12:41:55.613468 | localhost | Requirement already satisfied: jmespath<2.0.0,>=0.7.1 in /usr/local/lib/python3.11/site-packages (from boto3==1.28.10->-r requirements.txt (line 2)) (1.0.1)
2024-05-26 12:41:55.613488 | localhost | Collecting s3transfer<0.7.0,>=0.6.0 (from boto3==1.28.10->-r requirements.txt (line 2))
2024-05-26 12:41:55.613507 | localhost |   Downloading s3transfer-0.6.2-py3-none-any.whl.metadata (1.8 kB)
2024-05-26 12:41:55.613526 | localhost | Requirement already satisfied: python-dateutil<3.0.0,>=2.1 in /usr/local/lib/python3.11/site-packages (from botocore<1.32.0,>=1.31.10->boto3==1.28.10->-r requirements.txt (line 2)) (2.9.0.post0)
2024-05-26 12:41:55.613552 | localhost | Requirement already satisfied: urllib3<2.1,>=1.25.4 in /usr/local/lib/python3.11/site-packages (from botocore<1.32.0,>=1.31.10->boto3==1.28.10->-r requirements.txt (line 2)) (1.26.18)
2024-05-26 12:41:55.613572 | localhost | Requirement already satisfied: charset-normalizer<4,>=2 in /usr/local/lib/python3.11/site-packages (from requests>=2.25.0->python-gitlab==4.5.0->-r requirements.txt (line 1)) (3.3.2)
2024-05-26 12:41:55.613591 | localhost | Requirement already satisfied: idna<4,>=2.5 in /usr/local/lib/python3.11/site-packages (from requests>=2.25.0->python-gitlab==4.5.0->-r requirements.txt (line 1)) (3.7)
2024-05-26 12:41:55.613616 | localhost | Requirement already satisfied: certifi>=2017.4.17 in /usr/local/lib/python3.11/site-packages (from requests>=2.25.0->python-gitlab==4.5.0->-r requirements.txt (line 1)) (2024.2.2)
2024-05-26 12:41:55.613636 | localhost | Requirement already satisfied: six>=1.5 in /usr/local/lib/python3.11/site-packages (from python-dateutil<3.0.0,>=2.1->botocore<1.32.0,>=1.31.10->boto3==1.28.10->-r requirements.txt (line 2)) (1.16.0)
2024-05-26 12:41:55.613655 | localhost | Downloading python_gitlab-4.5.0-py3-none-any.whl (139 kB)
2024-05-26 12:41:55.613674 | localhost |    ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 139.3/139.3 kB 1.3 MB/s eta 0:00:00
2024-05-26 12:41:55.613693 | localhost | Downloading boto3-1.28.10-py3-none-any.whl (135 kB)
2024-05-26 12:41:55.613713 | localhost |    ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 135.8/135.8 kB 5.6 MB/s eta 0:00:00
2024-05-26 12:41:55.613732 | localhost | Downloading botocore-1.31.85-py3-none-any.whl (11.3 MB)
2024-05-26 12:41:55.613750 | localhost |    ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 11.3/11.3 MB 11.0 MB/s eta 0:00:00
2024-05-26 12:41:55.613769 | localhost | Downloading requests_toolbelt-1.0.0-py2.py3-none-any.whl (54 kB)
2024-05-26 12:41:55.613787 | localhost |    ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 54.5/54.5 kB 3.2 MB/s eta 0:00:00
2024-05-26 12:41:55.613806 | localhost | Downloading s3transfer-0.6.2-py3-none-any.whl (79 kB)
2024-05-26 12:41:55.613824 | localhost |    ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 79.8/79.8 kB 5.0 MB/s eta 0:00:00
2024-05-26 12:41:55.613842 | localhost | Building wheels for collected packages: real-easypy
2024-05-26 12:41:55.613859 | localhost |   Building wheel for real-easypy (setup.py): started
2024-05-26 12:41:55.613877 | localhost |   Building wheel for real-easypy (setup.py): finished with status 'done'
2024-05-26 12:41:55.613895 | localhost |   Created wheel for real-easypy: filename=real_easypy-0.4.3-py3-none-any.whl size=151760 sha256=856eb09ae58c45f128f6c184f6829bd19def965c1f05f8cebb0084943ec66d55
2024-05-26 12:41:55.613913 | localhost |   Stored in directory: /var/lib/zuul/builds/d27aca183c1e40649993d7ec4244ed50/work/tmp/pip-ephem-wheel-cache-xpjbk7qy/wheels/c9/39/3a/e885f87d386b416792e2c006fd66e348489cd283272cf0d9e5
2024-05-26 12:41:55.613930 | localhost | Successfully built real-easypy
2024-05-26 12:41:55.613948 | localhost | Installing collected packages: real-easypy, requests-toolbelt, botocore, s3transfer, python-gitlab, boto3
2024-05-26 12:41:55.613966 | localhost |   WARNING: The scripts ezcolorize and eziplog are installed in '/var/lib/zuul/builds/d27aca183c1e40649993d7ec4244ed50/work/.local/bin' which is not on PATH.
2024-05-26 12:41:55.613984 | localhost |   Consider adding this directory to PATH or, if you prefer to suppress this warning, use --no-warn-script-location.
2024-05-26 12:41:55.614001 | localhost |   WARNING: The script gitlab is installed in '/var/lib/zuul/builds/d27aca183c1e40649993d7ec4244ed50/work/.local/bin' which is not on PATH.
2024-05-26 12:41:55.614018 | localhost |   Consider adding this directory to PATH or, if you prefer to suppress this warning, use --no-warn-script-location.
2024-05-26 12:41:55.614036 | localhost | Successfully installed boto3-1.28.10 botocore-1.31.85 python-gitlab-4.5.0 real-easypy-0.4.3 requests-toolbelt-1.0.0 s3transfer-0.6.2
2024-05-26 12:41:55.614053 | localhost | WARNING: Running pip as the 'root' user can result in broken permissions and conflicting behaviour with the system package manager. It is recommended to use a virtual environment instead: https://pip.pypa.io/warnings/venv
2024-05-26 12:41:55.614074 | localhost | <class 'gitlab.v4.objects.pipelines.ProjectPipeline'> =>
2024-05-26 12:41:55.614092 | localhost | {'before_sha': '0000000000000000000000000000000000000000',
2024-05-26 12:41:55.614110 | localhost |  'committed_at': None,
2024-05-26 12:41:55.614128 | localhost |  'coverage': None,
2024-05-26 12:41:55.614146 | localhost |  'created_at': '2024-05-26T10:32:53.227Z',
2024-05-26 12:41:55.614164 | localhost |  'detailed_status': {'details_path': '/dev/orion/-/pipelines/1340161',
2024-05-26 12:41:55.614181 | localhost |                      'favicon': '/assets/ci_favicons/favicon_status_created-4b975aa976d24e5a3ea7cd9a5713e6ce2cd9afd08b910415e96675de35f64955.png',
2024-05-26 12:41:55.614199 | localhost |                      'group': 'created',
2024-05-26 12:41:55.614216 | localhost |                      'has_details': False,
2024-05-26 12:41:55.614233 | localhost |                      'icon': 'status_created',
2024-05-26 12:41:55.614251 | localhost |                      'illustration': None,
2024-05-26 12:41:55.614269 | localhost |                      'label': 'created',
2024-05-26 12:41:55.614287 | localhost |                      'text': 'created',
2024-05-26 12:41:55.614304 | localhost |                      'tooltip': 'created'},
2024-05-26 12:41:55.614321 | localhost |  'duration': None,
2024-05-26 12:41:55.614338 | localhost |  'finished_at': None,
2024-05-26 12:41:55.614356 | localhost |  'id': 1340161,
2024-05-26 12:41:55.614373 | localhost |  'iid': 1390124,
2024-05-26 12:41:55.614390 | localhost |  'project_id': 3,
2024-05-26 12:41:55.614408 | localhost |  'queued_duration': None,
2024-05-26 12:41:55.614425 | localhost |  'ref': 'MANILA_TEMPEST/vlad/devstack',
2024-05-26 12:41:55.614442 | localhost |  'sha': '8d7c801458fdec5c13f8dd1e6680eafaa4e65c20',
2024-05-26 12:41:55.614459 | localhost |  'source': 'trigger',
2024-05-26 12:41:55.614476 | localhost |  'started_at': None,
2024-05-26 12:41:55.614493 | localhost |  'status': 'created',
2024-05-26 12:41:55.614510 | localhost |  'tag': False,
2024-05-26 12:41:55.614527 | localhost |  'updated_at': '2024-05-26T10:32:53.227Z',
2024-05-26 12:41:55.614544 | localhost |  'user': {'avatar_url': 'https://git.vastdata.com/uploads/-/system/user/avatar/121/avatar.png',
2024-05-26 12:41:55.614561 | localhost |           'id': 121,
2024-05-26 12:41:55.614583 | localhost |           'name': 'Ofer Koren',
2024-05-26 12:41:55.614611 | localhost |           'state': 'active',
2024-05-26 12:41:55.614631 | localhost |           'username': 'ofer.koren',
2024-05-26 12:41:55.614648 | localhost |           'web_url': 'https://git.vastdata.com/ofer.koren'},
2024-05-26 12:41:55.614666 | localhost |  'web_url': 'https://git.vastdata.com/dev/orion/-/pipelines/1340161',
2024-05-26 12:41:55.614684 | localhost |  'yaml_errors': None}
2024-05-26 12:41:55.614721 | localhost | ok: Runtime: 2:09:21.288812
2024-05-26 12:41:55.622689 | 
2024-05-26 12:41:55.622739 | PLAY RECAP
2024-05-26 12:41:55.622774 | localhost | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2024-05-26 12:41:55.622795 | 
2024-05-26 12:41:55.704463 | RUN END RESULT_NORMAL: [trusted : gerrit/zuul-config/playbooks/start-manila-ci.yaml@master]
2024-05-26 12:41:55.705473 | POST-RUN START: [trusted : gerrit/zuul-config/playbooks/upload-logs-s3.yaml@master]
2024-05-26 12:41:56.216068 | 
2024-05-26 12:41:56.216161 | PLAY [localhost]
2024-05-26 12:41:56.226171 | 
2024-05-26 12:41:56.226252 | TASK [Remove job-output.json]
2024-05-26 12:41:56.486043 | localhost | changed
2024-05-26 12:41:56.495699 | 
2024-05-26 12:41:56.495775 | PLAY [localhost]
2024-05-26 12:41:56.504076 | 
2024-05-26 12:41:56.504179 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2024-05-26 12:41:56.752550 | localhost | changed
2024-05-26 12:41:56.756402 | 
2024-05-26 12:41:56.756473 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2024-05-26 12:41:56.771719 | localhost | ok
2024-05-26 12:41:56.778547 | 
2024-05-26 12:41:56.778630 | TASK [Set zuul-log-path fact]
2024-05-26 12:41:56.801599 | localhost | skipping: Conditional result was False
2024-05-26 12:41:56.804457 | 
2024-05-26 12:41:56.804519 | TASK [upload-logs-s3 : Debug log_root]
2024-05-26 12:41:56.839425 | log_root /var/lib/zuul/builds/d27aca183c1e40649993d7ec4244ed50/work/logs
2024-05-26 12:41:56.843012 | 
2024-05-26 12:41:56.843087 | TASK [upload-logs-s3 : Ensure logs are readable before uploading]
2024-05-26 12:41:57.160610 | localhost -> localhost | ok: Runtime: 0:00:00.002561
2024-05-26 12:41:57.163554 | 
2024-05-26 12:41:57.163614 | TASK [upload-logs-s3 : Upload logs to S3]