https://12b5c9445590716cbe81-2eb50734132c0e56282483bcdf57bf8a.ssl.cf2.rackcdn.com/710810/3/check/tripleo-ci-centos-8-scenario001-standalone/8a6d4a7/job-output.txt

2020-03-02 18:07:56.142233 | primary | 2020-03-02 18:07:52.442 135023 WARNING urllib3.connectionpool [-] Retrying (Retry(total=8, connect=None, read=None, redirect=5, status=None)) after connection broken by 'ProtocolError('Connection aborted.', BrokenPipeError(32, 'Broken pipe'))': /v2/images/22582e2f-9ce2-43a6-90e2-fee0ddd283e3/file
2020-03-02 18:07:56.142265 | primary | 2020-03-02 18:07:55.915 135023 INFO tempest.lib.common.rest_client [req-2c4e9f5f-5497-4eae-b26c-9203f8fbc85b ] Request (main): 500 PUT http://192.168.24.1:9292/v2/images/22582e2f-9ce2-43a6-90e2-fee0ddd283e3/file 14.582s
2020-03-02 18:07:56.142297 | primary | 2020-03-02 18:07:55.917 135023 CRITICAL tempest [-] Unhandled error: tempest.lib.exceptions.ServerFault: Got server fault
2020-03-02 18:07:56.142328 | primary | Details: b'500 Internal Server Error\n\nThe server has either erred or is incapable of performing the requested operation.\n\n   '
2020-03-02 18:07:56.142377 | primary | 2020-03-02 18:07:55.917 135023 ERROR tempest Traceback (most recent call last):
2020-03-02 18:07:56.142411 | primary | 2020-03-02 18:07:55.917 135023 ERROR tempest   File "/bin/discover-tempest-config", line 10, in <module>
2020-03-02 18:07:56.142442 | primary | 2020-03-02 18:07:55.917 135023 ERROR tempest     sys.exit(main())
2020-03-02 18:07:56.142473 | primary | 2020-03-02 18:07:55.917 135023 ERROR tempest   File "/usr/lib/python3.6/site-packages/config_tempest/main.py", line 605, in main
2020-03-02 18:07:56.142505 | primary | 2020-03-02 18:07:55.917 135023 ERROR tempest     verbose=args.verbose
2020-03-02 18:07:56.142549 | primary | 2020-03-02 18:07:55.917 135023 ERROR tempest   File "/usr/lib/python3.6/site-packages/config_tempest/main.py", line 545, in config_tempest
2020-03-02 18:07:56.142582 | primary | 2020-03-02 18:07:55.917 135023 ERROR tempest     image.create_tempest_images(conf)
2020-03-02 18:07:56.142612 | primary | 2020-03-02 18:07:55.917 135023 ERROR tempest   File "/usr/lib/python3.6/site-packages/config_tempest/services/image.py", line 113, in create_tempest_images
2020-03-02 18:07:56.142644 | primary | 2020-03-02 18:07:55.917 135023 ERROR tempest     image_dest=img_path)
2020-03-02 18:07:56.142675 | primary | 2020-03-02 18:07:55.917 135023 ERROR tempest   File "/usr/lib/python3.6/site-packages/config_tempest/services/image.py", line 161, in find_or_upload_image
2020-03-02 18:07:56.142706 | primary | 2020-03-02 18:07:55.917 135023 ERROR tempest     image = self._upload_image(image_name, image_dest)
2020-03-02 18:07:56.142737 | primary | 2020-03-02 18:07:55.917 135023 ERROR tempest   File "/usr/lib/python3.6/site-packages/config_tempest/services/image.py", line 212, in _upload_image
2020-03-02 18:07:56.142769 | primary | 2020-03-02 18:07:55.917 135023 ERROR tempest     self.client.store_image_file(image['id'], data)
2020-03-02 18:07:56.142801 | primary | 2020-03-02 18:07:55.917 135023 ERROR tempest   File "/usr/lib/python3.6/site-packages/tempest/lib/services/image/v2/images_client.py", line 151, in store_image_file
2020-03-02 18:07:56.142832 | primary | 2020-03-02 18:07:55.917 135023 ERROR tempest     body=data, chunked=True)
2020-03-02 18:07:56.142863 | primary | 2020-03-02 18:07:55.917 135023 ERROR tempest   File "/usr/lib/python3.6/site-packages/tempest/lib/common/rest_client.py", line 687, in request
2020-03-02 18:07:56.142894 | primary | 2020-03-02 18:07:55.917 135023 ERROR tempest     self._error_checker(resp, resp_body)
2020-03-02 18:07:56.142926 | primary | 2020-03-02 18:07:55.917 135023 ERROR tempest   File "/usr/lib/python3.6/site-packages/tempest/lib/common/rest_client.py", line 864, in _error_checker
2020-03-02 18:07:56.142965 | primary | 2020-03-02 18:07:55.917 135023 ERROR tempest     message=message)
2020-03-02 18:07:56.142996 | primary | 2020-03-02 18:07:55.917 135023 ERROR tempest tempest.lib.exceptions.ServerFault: Got server fault
2020-03-02 18:07:56.143049 | primary | 2020-03-02 18:07:55.917 135023 ERROR tempest Details: b'500 Internal Server Error\n\nThe server has either erred or is incapable of performing the requested operation.\n\n   '
2020-03-02 18:07:56.143083 | primary | 2020-03-02 18:07:55.917 135023 ERROR tempest 
2020-03-02 18:07:56.143113 | primary |
2020-03-02 18:07:56.143144 | primary |
2020-03-02 18:07:56.143192 | primary | STDERR:
2020-03-02 18:07:56.143225 | primary |
2020-03-02 18:07:56.143256 | primary | /usr/lib/python3.6/site-packages/config_tempest/profile.py:45: YAMLLoadWarning: calling yaml.load() without Loader=... is deprecated, as the default Loader is unsafe. Please read https://msg.pyyaml.org/load for full details.
2020-03-02 18:07:56.143286 | primary |   return yaml.load(stream)

=====================================

Actual error: is here:

https://12b5c9445590716cbe81-2eb50734132c0e56282483bcdf57bf8a.ssl.cf2.rackcdn.com/710810/3/check/tripleo-ci-centos-8-scenario001-standalone/8a6d4a7/logs/undercloud/var/log/containers/glance/api.log


InvalidArgumentError('RADOS invalid argument (error calling conf_read_file)',) trace_logging_wrapper /usr/lib/python3.6/site-packages/os_brick/utils.py:156
2020-03-02 18:07:51.999 40 ERROR glance_store._drivers.cinder [req-5076b6b5-c8d6-4743-83dc-245492610376 b9f74f3fb12843818bc784bf2f81fca2 966194a384e641598d107cdf193a9a39 - default default] Exception while accessing to cinder volume 17a385a3-9331-4513-9a81-37a99200cefd.: rados.InvalidArgumentError: [errno 22] RADOS invalid argument (error calling conf_read_file)
2020-03-02 18:07:51.999 40 ERROR glance_store._drivers.cinder Traceback (most recent call last):
2020-03-02 18:07:51.999 40 ERROR glance_store._drivers.cinder   File "/usr/lib/python3.6/site-packages/glance_store/_drivers/cinder.py", line 554, in _open_cinder_volume
2020-03-02 18:07:51.999 40 ERROR glance_store._drivers.cinder     device = conn.connect_volume(connection_info['data'])
2020-03-02 18:07:51.999 40 ERROR glance_store._drivers.cinder   File "/usr/lib/python3.6/site-packages/os_brick/utils.py", line 150, in trace_logging_wrapper
2020-03-02 18:07:51.999 40 ERROR glance_store._drivers.cinder     result = f(*args, **kwargs)
2020-03-02 18:07:51.999 40 ERROR glance_store._drivers.cinder   File "/usr/lib/python3.6/site-packages/os_brick/initiator/connectors/rbd.py", line 203, in connect_volume
2020-03-02 18:07:51.999 40 ERROR glance_store._drivers.cinder     rbd_handle = self._get_rbd_handle(connection_properties)
2020-03-02 18:07:51.999 40 ERROR glance_store._drivers.cinder   File "/usr/lib/python3.6/site-packages/os_brick/initiator/connectors/rbd.py", line 122, in _get_rbd_handle
2020-03-02 18:07:51.999 40 ERROR glance_store._drivers.cinder     rbd_cluster_name=str(cluster_name))
2020-03-02 18:07:51.999 40 ERROR glance_store._drivers.cinder   File "/usr/lib/python3.6/site-packages/os_brick/initiator/linuxrbd.py", line 60, in __init__
2020-03-02 18:07:51.999 40 ERROR glance_store._drivers.cinder     self.client, self.ioctx = self.connect()
2020-03-02 18:07:51.999 40 ERROR glance_store._drivers.cinder   File "/usr/lib/python3.6/site-packages/os_brick/initiator/linuxrbd.py", line 73, in connect
2020-03-02 18:07:51.999 40 ERROR glance_store._drivers.cinder     conffile=self.rbd_conf)
2020-03-02 18:07:51.999 40 ERROR glance_store._drivers.cinder   File "rados.pyx", line 692, in rados.Rados.__init__
2020-03-02 18:07:51.999 40 ERROR glance_store._drivers.cinder   File "rados.pyx", line 578, in rados.requires.wrapper.validate_func
2020-03-02 18:07:51.999 40 ERROR glance_store._drivers.cinder   File "rados.pyx", line 743, in rados.Rados.__setup
2020-03-02 18:07:51.999 40 ERROR glance_store._drivers.cinder   File "rados.pyx", line 578, in rados.requires.wrapper.validate_func
2020-03-02 18:07:51.999 40 ERROR glance_store._drivers.cinder   File "rados.pyx", line 826, in rados.Rados.conf_read_file
2020-03-02 18:07:51.999 40 ERROR glance_store._drivers.cinder rados.InvalidArgumentError: [errno 22] RADOS invalid argument (error calling conf_read_file)
2020-03-02 18:07:51.999 40 ERROR glance_store._drivers.cinder 
2020-03-02 18:07:52.296 40 ERROR glance_store._drivers.cinder [req-5076b6b5-c8d6-4743-83dc-245492610376 b9f74f3fb12843818bc784bf2f81fca2 966194a384e641598d107cdf193a9a39 - default default] Failed to write to volume 17a385a3-9331-4513-9a81-37a99200cefd.: rados.InvalidArgumentError: [errno 22] RADOS invalid argument (error calling conf_read_file)
2020-03-02 18:07:52.386 40 ERROR glance.api.v2.image_data [req-5076b6b5-c8d6-4743-83dc-245492610376 b9f74f3fb12843818bc784bf2f81fca2 966194a384e641598d107cdf193a9a39 - default default] Failed to upload image data due to internal error: rados.InvalidArgumentError: [errno 22] RADOS invalid argument (error calling conf_read_file)
2020-03-02 18:07:52.438 40 ERROR glance.common.wsgi [req-5076b6b5-c8d6-4743-83dc-245492610376 b9f74f3fb12843818bc784bf2f81fca2 966194a384e641598d107cdf193a9a39 - default default] Caught error: [errno 22] RADOS invalid argument (error calling conf_read_file): rados.InvalidArgumentError: [errno 22] RADOS invalid argument (error calling conf_read_file)
2020-03-02 18:07:52.438 40 ERROR glance.common.wsgi Traceback (most recent call last):
2020-03-02 18:07:52.438 40 ERROR glance.common.wsgi   File "/usr/lib/python3.6/site-packages/glance/common/wsgi.py", line 1347, in __call__
2020-03-02 18:07:52.438 40 ERROR glance.common.wsgi     request, **action_args)
2020-03-02 18:07:52.438 40 ERROR glance.common.wsgi   File "/usr/lib/python3.6/site-packages/glance/common/wsgi.py", line 1390, in dispatch
2020-03-02 18:07:52.438 40 ERROR glance.common.wsgi     return method(*args, **kwargs)
2020-03-02 18:07:52.438 40 ERROR glance.common.wsgi   File "/usr/lib/python3.6/site-packages/glance/common/utils.py", line 415, in wrapped
2020-03-02 18:07:52.438 40 ERROR glance.common.wsgi     return func(self, req, *args, **kwargs)
2020-03-02 18:07:52.438 40 ERROR glance.common.wsgi   File "/usr/lib/python3.6/site-packages/glance/api/v2/image_data.py", line 299, in upload
2020-03-02 18:07:52.438 40 ERROR glance.common.wsgi     self._restore(image_repo, image)
2020-03-02 18:07:52.438 40 ERROR glance.common.wsgi   File "/usr/lib/python3.6/site-packages/oslo_utils/excutils.py", line 220, in __exit__
2020-03-02 18:07:52.438 40 ERROR glance.common.wsgi     self.force_reraise()
2020-03-02 18:07:52.438 40 ERROR glance.common.wsgi   File "/usr/lib/python3.6/site-packages/oslo_utils/excutils.py", line 196, in force_reraise
2020-03-02 18:07:52.438 40 ERROR glance.common.wsgi     six.reraise(self.type_, self.value, self.tb)
2020-03-02 18:07:52.438 40 ERROR glance.common.wsgi   File "/usr/lib/python3.6/site-packages/six.py", line 693, in reraise
2020-03-02 18:07:52.438 40 ERROR glance.common.wsgi     raise value
2020-03-02 18:07:52.438 40 ERROR glance.common.wsgi   File "/usr/lib/python3.6/site-packages/glance/api/v2/image_data.py", line 164, in upload
2020-03-02 18:07:52.438 40 ERROR glance.common.wsgi     image.set_data(data, size, backend=backend)
2020-03-02 18:07:52.438 40 ERROR glance.common.wsgi   File "/usr/lib/python3.6/site-packages/glance/domain/proxy.py", line 198, in set_data
2020-03-02 18:07:52.438 40 ERROR glance.common.wsgi     self.base.set_data(data, size, backend=backend, set_active=set_active)
2020-03-02 18:07:52.438 40 ERROR glance.common.wsgi   File "/usr/lib/python3.6/site-packages/glance/notifier.py", line 501, in set_data
2020-03-02 18:07:52.438 40 ERROR glance.common.wsgi     _send_notification(notify_error, 'image.upload', msg)
2020-03-02 18:07:52.438 40 ERROR glance.common.wsgi   File "/usr/lib/python3.6/site-packages/oslo_utils/excutils.py", line 220, in __exit__
2020-03-02 18:07:52.438 40 ERROR glance.common.wsgi     self.force_reraise()
2020-03-02 18:07:52.438 40 ERROR glance.common.wsgi   File "/usr/lib/python3.6/site-packages/oslo_utils/excutils.py", line 196, in force_reraise
2020-03-02 18:07:52.438 40 ERROR glance.common.wsgi     six.reraise(self.type_, self.value, self.tb)
2020-03-02 18:07:52.438 40 ERROR glance.common.wsgi   File "/usr/lib/python3.6/site-packages/six.py", line 693, in reraise
2020-03-02 18:07:52.438 40 ERROR glance.common.wsgi     raise value
2020-03-02 18:07:52.438 40 ERROR glance.common.wsgi   File "/usr/lib/python3.6/site-packages/glance/notifier.py", line 448, in set_data
2020-03-02 18:07:52.438 40 ERROR glance.common.wsgi     set_active=set_active)
2020-03-02 18:07:52.438 40 ERROR glance.common.wsgi   File "/usr/lib/python3.6/site-packages/glance/api/policy.py", line 204, in set_data
2020-03-02 18:07:52.438 40 ERROR glance.common.wsgi     return self.image.set_data(*args, **kwargs)
2020-03-02 18:07:52.438 40 ERROR glance.common.wsgi   File "/usr/lib/python3.6/site-packages/glance/quota/__init__.py", line 319, in set_data
2020-03-02 18:07:52.438 40 ERROR glance.common.wsgi     set_active=set_active)
2020-03-02 18:07:52.438 40 ERROR glance.common.wsgi   File "/usr/lib/python3.6/site-packages/glance/location.py", line 548, in set_data
2020-03-02 18:07:52.438 40 ERROR glance.common.wsgi     self._upload_to_store(data, verifier, backend, size)
2020-03-02 18:07:52.438 40 ERROR glance.common.wsgi   File "/usr/lib/python3.6/site-packages/glance/location.py", line 461, in _upload_to_store
2020-03-02 18:07:52.438 40 ERROR glance.common.wsgi     verifier=verifier)
2020-03-02 18:07:52.438 40 ERROR glance.common.wsgi   File "/usr/lib/python3.6/site-packages/glance_store/multi_backend.py", line 396, in add_with_multihash
2020-03-02 18:07:52.438 40 ERROR glance.common.wsgi     image_id, data, size, hashing_algo, store, context, verifier)
2020-03-02 18:07:52.438 40 ERROR glance.common.wsgi   File "/usr/lib/python3.6/site-packages/glance_store/multi_backend.py", line 478, in store_add_to_backend_with_multihash
2020-03-02 18:07:52.438 40 ERROR glance.common.wsgi     image_id, data, size, hashing_algo, context=context, verifier=verifier)
2020-03-02 18:07:52.438 40 ERROR glance.common.wsgi   File "/usr/lib/python3.6/site-packages/glance_store/driver.py", line 279, in add_adapter
2020-03-02 18:07:52.438 40 ERROR glance.common.wsgi     metadata_dict) = store_add_fun(*args, **kwargs)
2020-03-02 18:07:52.438 40 ERROR glance.common.wsgi   File "/usr/lib/python3.6/site-packages/glance_store/capabilities.py", line 176, in op_checker
2020-03-02 18:07:52.438 40 ERROR glance.common.wsgi     return store_op_fun(store, *args, **kwargs)
2020-03-02 18:07:52.438 40 ERROR glance.common.wsgi   File "/usr/lib/python3.6/site-packages/glance_store/_drivers/cinder.py", line 747, in add
2020-03-02 18:07:52.438 40 ERROR glance.common.wsgi     with self._open_cinder_volume(client, volume, 'wb') as f:
2020-03-02 18:07:52.438 40 ERROR glance.common.wsgi   File "/usr/lib64/python3.6/contextlib.py", line 81, in __enter__
2020-03-02 18:07:52.438 40 ERROR glance.common.wsgi     return next(self.gen)
2020-03-02 18:07:52.438 40 ERROR glance.common.wsgi   File "/usr/lib/python3.6/site-packages/glance_store/_drivers/cinder.py", line 554, in _open_cinder_volume
2020-03-02 18:07:52.438 40 ERROR glance.common.wsgi     device = conn.connect_volume(connection_info['data'])
2020-03-02 18:07:52.438 40 ERROR glance.common.wsgi   File "/usr/lib/python3.6/site-packages/os_brick/utils.py", line 150, in trace_logging_wrapper
2020-03-02 18:07:52.438 40 ERROR glance.common.wsgi     result = f(*args, **kwargs)
2020-03-02 18:07:52.438 40 ERROR glance.common.wsgi   File "/usr/lib/python3.6/site-packages/os_brick/initiator/connectors/rbd.py", line 203, in connect_volume
2020-03-02 18:07:52.438 40 ERROR glance.common.wsgi     rbd_handle = self._get_rbd_handle(connection_properties)
2020-03-02 18:07:52.438 40 ERROR glance.common.wsgi   File "/usr/lib/python3.6/site-packages/os_brick/initiator/connectors/rbd.py", line 122, in _get_rbd_handle
2020-03-02 18:07:52.438 40 ERROR glance.common.wsgi     rbd_cluster_name=str(cluster_name))
2020-03-02 18:07:52.438 40 ERROR glance.common.wsgi   File "/usr/lib/python3.6/site-packages/os_brick/initiator/linuxrbd.py", line 60, in __init__
2020-03-02 18:07:52.438 40 ERROR glance.common.wsgi     self.client, self.ioctx = self.connect()
2020-03-02 18:07:52.438 40 ERROR glance.common.wsgi   File "/usr/lib/python3.6/site-packages/os_brick/initiator/linuxrbd.py", line 73, in connect
2020-03-02 18:07:52.438 40 ERROR glance.common.wsgi     conffile=self.rbd_conf)
2020-03-02 18:07:52.438 40 ERROR glance.common.wsgi   File "rados.pyx", line 692, in rados.Rados.__init__
2020-03-02 18:07:52.438 40 ERROR glance.common.wsgi   File "rados.pyx", line 578, in rados.requires.wrapper.validate_func
2020-03-02 18:07:52.438 40 ERROR glance.common.wsgi   File "rados.pyx", line 743, in rados.Rados.__setup
2020-03-02 18:07:52.438 40 ERROR glance.common.wsgi   File "rados.pyx", line 578, in rados.requires.wrapper.validate_func
2020-03-02 18:07:52.438 40 ERROR glance.common.wsgi   File "rados.pyx", line 826, in rados.Rados.conf_read_file
2020-03-02 18:07:52.438 40 ERROR glance.common.wsgi rados.InvalidArgumentError: [errno 22] RADOS invalid argument (error calling conf_read_file)