October 2013 - Openstack-stable-maint

Build failed in Jenkins: periodic-glance-python26-stable-grizzly #34
by OpenStack Jenkins 18 Nov '13

18 Nov '13

See <https://jenkins02.openstack.org/job/periodic-glance-python26-stable-grizzly…> Changes: [adamg] Bump stable/grizzly next version to 2013.1.5 ------------------------------------------ [...truncated 1477 lines...] iso8601.iso8601: DEBUG: Parsed 2011-09-05 into {'tz_sign': None, 'second_fraction': None, 'hour': None, 'tz_hour': None, 'month': u'09', 'timezone': None, 'second': None, 'tz_minute': None, 'year': u'2011', 'separator': None, 'day': u'05', 'minute': None} with default timezone <iso8601.iso8601.Utc object at 0x158ab10> iso8601.iso8601: DEBUG: Got None for 'second_fraction' with default None iso8601.iso8601: DEBUG: Got u'2011' for 'year' with default None iso8601.iso8601: DEBUG: Got u'09' for 'month' with default None iso8601.iso8601: DEBUG: Got u'05' for 'day' with default None iso8601.iso8601: DEBUG: Got None for 'hour' with default None iso8601.iso8601: DEBUG: Got None for 'minute' with default None iso8601.iso8601: DEBUG: Got None for 'second' with default None glance.registry.api.v1.images: INFO: Returning detailed image list glance.registry.client: DEBUG: Registry request GET /images/detail HTTP 200 request id req-c2bd1ff5-532f-4791-a758-b0a35cd57ee8 --------------------- >> end captured logging << --------------------- ====================================================================== FAIL: glance.tests.unit.v1.test_api.TestRegistryAPI.test_get_details_filter_changes_since ---------------------------------------------------------------------- _StringException: Traceback (most recent call last): File "<https://jenkins02.openstack.org/job/periodic-glance-python26-stable-grizzly…",> line 1414, in test_get_details_filter_changes_since self.assertEquals(res.status_int, 400) File "<https://jenkins02.openstack.org/job/periodic-glance-python26-stable-grizzly…",> line 322, in assertEqual self.assertThat(observed, matcher, message) File "<https://jenkins02.openstack.org/job/periodic-glance-python26-stable-grizzly…",> line 417, in assertThat raise MismatchError(matchee, matcher, mismatch, verbose) MismatchError: 200 != 400 -------------------- >> begin captured logging << -------------------- glance.store: DEBUG: Attempting to import store glance.store.filesystem.Store glance.store.filesystem: ERROR: Could not find filesystem_store_datadir in configuration options. glance.store.base: WARNING: Failed to configure store correctly: Store filesystem could not be configured correctly. Reason: Could not find filesystem_store_datadir in configuration options. Disabling add method. glance.store: DEBUG: Registering store <class 'glance.store.filesystem.Store'> with schemes ('file', 'filesystem') glance.store.base: DEBUG: Late loading location class glance.store.filesystem.StoreLocation glance.store.location: DEBUG: Registering scheme file with {'store_class': <class 'glance.store.filesystem.Store'>, 'location_class': <class 'glance.store.filesystem.StoreLocation'>} glance.store.location: DEBUG: Registering scheme filesystem with {'store_class': <class 'glance.store.filesystem.Store'>, 'location_class': <class 'glance.store.filesystem.StoreLocation'>} glance.store: DEBUG: Attempting to import store glance.store.http.Store glance.store: DEBUG: Registering store <class 'glance.store.http.Store'> with schemes ('http', 'https') glance.store.base: DEBUG: Late loading location class glance.store.http.StoreLocation glance.store.location: DEBUG: Registering scheme http with {'store_class': <class 'glance.store.http.Store'>, 'location_class': <class 'glance.store.http.StoreLocation'>} glance.store.location: DEBUG: Registering scheme https with {'store_class': <class 'glance.store.http.Store'>, 'location_class': <class 'glance.store.http.StoreLocation'>} glance.store: DEBUG: Attempting to import store glance.store.rbd.Store glance.store: DEBUG: Registering store <class 'glance.store.rbd.Store'> with schemes ('rbd',) glance.store.base: DEBUG: Late loading location class glance.store.rbd.StoreLocation glance.store.location: DEBUG: Registering scheme rbd with {'store_class': <class 'glance.store.rbd.Store'>, 'location_class': <class 'glance.store.rbd.StoreLocation'>} glance.store: DEBUG: Attempting to import store glance.store.s3.Store glance.store.s3: DEBUG: Could not find s3_store_host in configuration options. glance.store.base: WARNING: Failed to configure store correctly: Store s3 could not be configured correctly. Reason: Could not find s3_store_host in configuration options. Disabling add method. glance.store: DEBUG: Registering store <class 'glance.store.s3.Store'> with schemes ('s3', 's3+http', 's3+https') glance.store.base: DEBUG: Late loading location class glance.store.s3.StoreLocation glance.store.location: DEBUG: Registering scheme s3 with {'store_class': <class 'glance.store.s3.Store'>, 'location_class': <class 'glance.store.s3.StoreLocation'>} glance.store.location: DEBUG: Registering scheme s3+http with {'store_class': <class 'glance.store.s3.Store'>, 'location_class': <class 'glance.store.s3.StoreLocation'>} glance.store.location: DEBUG: Registering scheme s3+https with {'store_class': <class 'glance.store.s3.Store'>, 'location_class': <class 'glance.store.s3.StoreLocation'>} glance.store: DEBUG: Attempting to import store glance.store.swift.Store glance.store.swift: ERROR: Could not find swift_store_auth_address in configuration options. glance.store.base: WARNING: Failed to configure store correctly: Store swift could not be configured correctly. Reason: Could not find swift_store_auth_address in configuration options. Disabling add method. glance.store: DEBUG: Registering store <function Store at 0x28cb9b0> with schemes ('swift+https', 'swift', 'swift+http') glance.store.base: DEBUG: Late loading location class glance.store.swift.StoreLocation glance.store.location: DEBUG: Registering scheme swift+https with {'store_class': <function Store at 0x28cb9b0>, 'location_class': <class 'glance.store.swift.StoreLocation'>} glance.store.location: DEBUG: Registering scheme swift+http with {'store_class': <function Store at 0x28cb9b0>, 'location_class': <class 'glance.store.swift.StoreLocation'>} glance.store.location: DEBUG: Registering scheme swift with {'store_class': <function Store at 0x28cb9b0>, 'location_class': <class 'glance.store.swift.StoreLocation'>} routes.middleware: DEBUG: Initialized with method overriding = True, and path info altering = True routes.middleware: DEBUG: Matched GET /images/detail routes.middleware: DEBUG: Route path: '/images/detail', defaults: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x5b86550>} routes.middleware: DEBUG: Match dict: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x5b86550>} glance.registry.api.v1.images: INFO: Returning detailed image list routes.middleware: DEBUG: Matched GET /images/detail routes.middleware: DEBUG: Route path: '/images/detail', defaults: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x5b86550>} routes.middleware: DEBUG: Match dict: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x5b86550>} iso8601.iso8601: DEBUG: Parsed 2013-10-17T06:11:50Z into {'tz_sign': None, 'second_fraction': None, 'hour': u'06', 'tz_hour': None, 'month': u'10', 'timezone': u'Z', 'second': u'50', 'tz_minute': None, 'year': u'2013', 'separator': u'T', 'day': u'17', 'minute': u'11'} with default timezone <iso8601.iso8601.Utc object at 0x158ab10> iso8601.iso8601: DEBUG: Got None for 'second_fraction' with default None iso8601.iso8601: DEBUG: Got u'2013' for 'year' with default None iso8601.iso8601: DEBUG: Got u'10' for 'month' with default None iso8601.iso8601: DEBUG: Got u'17' for 'day' with default None iso8601.iso8601: DEBUG: Got u'06' for 'hour' with default None iso8601.iso8601: DEBUG: Got u'11' for 'minute' with default None iso8601.iso8601: DEBUG: Got u'50' for 'second' with default None glance.registry.api.v1.images: INFO: Returning detailed image list routes.middleware: DEBUG: Matched GET /images/detail routes.middleware: DEBUG: Route path: '/images/detail', defaults: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x5b86550>} routes.middleware: DEBUG: Match dict: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x5b86550>} iso8601.iso8601: DEBUG: Parsed 2013-10-19T06:11:50Z into {'tz_sign': None, 'second_fraction': None, 'hour': u'06', 'tz_hour': None, 'month': u'10', 'timezone': u'Z', 'second': u'50', 'tz_minute': None, 'year': u'2013', 'separator': u'T', 'day': u'19', 'minute': u'11'} with default timezone <iso8601.iso8601.Utc object at 0x158ab10> iso8601.iso8601: DEBUG: Got None for 'second_fraction' with default None iso8601.iso8601: DEBUG: Got u'2013' for 'year' with default None iso8601.iso8601: DEBUG: Got u'10' for 'month' with default None iso8601.iso8601: DEBUG: Got u'19' for 'day' with default None iso8601.iso8601: DEBUG: Got u'06' for 'hour' with default None iso8601.iso8601: DEBUG: Got u'11' for 'minute' with default None iso8601.iso8601: DEBUG: Got u'50' for 'second' with default None glance.registry.api.v1.images: INFO: Returning detailed image list routes.middleware: DEBUG: Matched GET /images/detail routes.middleware: DEBUG: Route path: '/images/detail', defaults: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x5b86550>} routes.middleware: DEBUG: Match dict: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x5b86550>} iso8601.iso8601: DEBUG: Parsed 2013-10-20T06:11:50+01:00 into {'tz_sign': u'+', 'second_fraction': None, 'hour': u'06', 'tz_hour': u'01', 'month': u'10', 'timezone': u'+01:00', 'second': u'50', 'tz_minute': u'00', 'year': u'2013', 'separator': u'T', 'day': u'20', 'minute': u'11'} with default timezone <iso8601.iso8601.Utc object at 0x158ab10> iso8601.iso8601: DEBUG: Got u'01' for 'tz_hour' with default None iso8601.iso8601: DEBUG: Got u'00' for 'tz_minute' with default None iso8601.iso8601: DEBUG: Got None for 'second_fraction' with default None iso8601.iso8601: DEBUG: Got u'2013' for 'year' with default None iso8601.iso8601: DEBUG: Got u'10' for 'month' with default None iso8601.iso8601: DEBUG: Got u'20' for 'day' with default None iso8601.iso8601: DEBUG: Got u'06' for 'hour' with default None iso8601.iso8601: DEBUG: Got u'11' for 'minute' with default None iso8601.iso8601: DEBUG: Got u'50' for 'second' with default None glance.registry.api.v1.images: INFO: Returning detailed image list routes.middleware: DEBUG: Matched GET /images/detail routes.middleware: DEBUG: Route path: '/images/detail', defaults: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x5b86550>} routes.middleware: DEBUG: Match dict: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x5b86550>} iso8601.iso8601: DEBUG: Parsed 2013-10-20T06:11:50-01:00 into {'tz_sign': u'-', 'second_fraction': None, 'hour': u'06', 'tz_hour': u'01', 'month': u'10', 'timezone': u'-01:00', 'second': u'50', 'tz_minute': u'00', 'year': u'2013', 'separator': u'T', 'day': u'20', 'minute': u'11'} with default timezone <iso8601.iso8601.Utc object at 0x158ab10> iso8601.iso8601: DEBUG: Got u'01' for 'tz_hour' with default None iso8601.iso8601: DEBUG: Got u'00' for 'tz_minute' with default None iso8601.iso8601: DEBUG: Got None for 'second_fraction' with default None iso8601.iso8601: DEBUG: Got u'2013' for 'year' with default None iso8601.iso8601: DEBUG: Got u'10' for 'month' with default None iso8601.iso8601: DEBUG: Got u'20' for 'day' with default None iso8601.iso8601: DEBUG: Got u'06' for 'hour' with default None iso8601.iso8601: DEBUG: Got u'11' for 'minute' with default None iso8601.iso8601: DEBUG: Got u'50' for 'second' with default None glance.registry.api.v1.images: INFO: Returning detailed image list routes.middleware: DEBUG: Matched GET /images/detail routes.middleware: DEBUG: Route path: '/images/detail', defaults: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x5b86550>} routes.middleware: DEBUG: Match dict: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x5b86550>} iso8601.iso8601: DEBUG: Parsed 2013-10-21T06:11:50Z into {'tz_sign': None, 'second_fraction': None, 'hour': u'06', 'tz_hour': None, 'month': u'10', 'timezone': u'Z', 'second': u'50', 'tz_minute': None, 'year': u'2013', 'separator': u'T', 'day': u'21', 'minute': u'11'} with default timezone <iso8601.iso8601.Utc object at 0x158ab10> iso8601.iso8601: DEBUG: Got None for 'second_fraction' with default None iso8601.iso8601: DEBUG: Got u'2013' for 'year' with default None iso8601.iso8601: DEBUG: Got u'10' for 'month' with default None iso8601.iso8601: DEBUG: Got u'21' for 'day' with default None iso8601.iso8601: DEBUG: Got u'06' for 'hour' with default None iso8601.iso8601: DEBUG: Got u'11' for 'minute' with default None iso8601.iso8601: DEBUG: Got u'50' for 'second' with default None glance.registry.api.v1.images: INFO: Returning detailed image list routes.middleware: DEBUG: Matched GET /images/detail routes.middleware: DEBUG: Route path: '/images/detail', defaults: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x5b86550>} routes.middleware: DEBUG: Match dict: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x5b86550>} routes.middleware: DEBUG: Matched GET /images/detail routes.middleware: DEBUG: Route path: '/images/detail', defaults: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x5b86550>} routes.middleware: DEBUG: Match dict: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x5b86550>} iso8601.iso8601: DEBUG: Parsed 2011-09-05 into {'tz_sign': None, 'second_fraction': None, 'hour': None, 'tz_hour': None, 'month': u'09', 'timezone': None, 'second': None, 'tz_minute': None, 'year': u'2011', 'separator': None, 'day': u'05', 'minute': None} with default timezone <iso8601.iso8601.Utc object at 0x158ab10> iso8601.iso8601: DEBUG: Got None for 'second_fraction' with default None iso8601.iso8601: DEBUG: Got u'2011' for 'year' with default None iso8601.iso8601: DEBUG: Got u'09' for 'month' with default None iso8601.iso8601: DEBUG: Got u'05' for 'day' with default None iso8601.iso8601: DEBUG: Got None for 'hour' with default None iso8601.iso8601: DEBUG: Got None for 'minute' with default None iso8601.iso8601: DEBUG: Got None for 'second' with default None glance.registry.api.v1.images: INFO: Returning detailed image list --------------------- >> end captured logging << --------------------- ---------------------------------------------------------------------- XML: nosetests.xml Slowest 5 tests took 90.82 secs: [31m 26.20 TestScrubber.test_scrubber_app[0m [31m 20.64 TestScrubber.test_delayed_delete[0m [31m 14.76 TestGlanceControl.test_reload[0m [31m 14.72 TestGlanceControl.test_bouncing[0m [31m 14.50 TestGlanceControl.test_respawn[0m ---------------------------------------------------------------------- Ran 1109 tests in 631.837s FAILED (SKIP=42, failures=2) ERROR: InvocationError: '<https://jenkins02.openstack.org/job/periodic-glance-python26-stable-grizzly…'> ___________________________________ summary ____________________________________ ERROR: py26: commands failed + result=1 + echo 'Begin pip freeze output from test virtualenv:' Begin pip freeze output from test virtualenv: + echo ====================================================================== ====================================================================== + .tox/py26/bin/pip freeze Babel==1.3 Jinja2==2.7.1 MarkupSafe==0.18 MySQL-python==1.2.4 Paste==1.7.5.1 PasteDeploy==1.5.0 Pygments==1.6 Routes==1.13 SQLAlchemy==0.7.9 Sphinx==1.2b1 Tempita==0.5.1 WebOb==1.2.3 amqp==1.3.0 anyjson==0.3.3 argparse==1.2.1 boto==2.14.0 cffi==0.7.2 colorama==0.2.7 coverage==3.7 decorator==3.4.0 distribute==0.7.3 docutils==0.10 eventlet==0.14.0 extras==0.0.3 fixtures==0.3.14 glance==jenkins.periodic.glance.python26.stable.grizzly.34 greenlet==0.4.1 httplib2==0.8 importlib==1.0.2 iso8601==0.1.5 jsonschema==2.1.0 kombu==3.0.0 lxml==3.2.3 mox==0.5.3 netaddr==0.7.10 nose==1.3.0 nose-exclude==0.1.10 nosehtmloutput==0.0.5 openstack.nose-plugin==0.11 ordereddict==1.1 oslo.config==1.2.1 passlib==1.6.1 pbr==0.5.21 pep8==1.3.3 prettytable==0.7.2 psycopg2==2.5.1 pycparser==2.10 pycrypto==2.6.1 pysendfile==2.0.0 python-keystoneclient==0.4.1 python-mimeparse==0.1.4 python-swiftclient==1.8.0 pytz==2013.7 repoze.lru==0.6 requests==2.0.0 simplejson==3.3.1 six==1.4.1 sqlalchemy-migrate==0.7.2 termcolor==1.1.0 testtools==0.9.32 wsgiref==0.1.2 xattr==0.7.2 + echo ====================================================================== ====================================================================== + '[' -d .testrepository ']' + sudo /usr/local/jenkins/slave_scripts/jenkins-sudo-grep.sh post + sudoresult=0 + '[' 0 -ne 0 ']' + /usr/local/jenkins/slave_scripts/jenkins-oom-grep.sh post + oomresult=0 + '[' 0 -ne 0 ']' ++ find . -name nose_results.html + htmlreport=./nose_results.html + '[' -f ./nose_results.html ']' ++ grep -c 'tr class=.passClass' ./nose_results.html + passcount=125 + '[' 125 -eq 0 ']' + exit 1 + rm -rf /tmp/tmp.Tw61sm28xu Build step 'Execute shell' marked build as failure [SCP] Connecting to static.openstack.org [SCP] uploading file: '/srv/static/logs/periodic/periodic-glance-python26-stable-grizzly/34/nose_results.html' [SCP] Connecting to static.openstack.org [SCP] Trying to create /srv/static/logs/periodic/periodic-glance-python26-stable-grizzly/centos6-4/34 [SCP] Copying console log.

1 13

Build failed in Jenkins: periodic-glance-python27-stable-grizzly #44
by OpenStack Jenkins 17 Nov '13

17 Nov '13

See <https://jenkins01.openstack.org/job/periodic-glance-python27-stable-grizzly…> ------------------------------------------ [...truncated 1171 lines...] test_image_set_data [32mOK [0m[32m 0.00[0m test_image_set_data_unknown_size [32mOK [0m[32m 0.00[0m TestStoreImageRepo test_add_fetches_members_if_private [32mOK [0m[32m 0.00[0m test_add_ignores_acls_if_no_locations [32mOK [0m[32m 0.00[0m test_add_updates_acls [32mOK [0m[32m 0.00[0m test_member_addition_updates_acls [32mOK [0m[32m 0.00[0m test_member_removal_updates_acls [32mOK [0m[32m 0.00[0m test_save_fetches_members_if_private [32mOK [0m[32m 0.00[0m test_save_updates_acls [32mOK [0m[32m 0.00[0m TestStoreLocation test_bad_store_scheme [32mOK [0m[32m 0.01[0m test_filesystem_store_location [32mOK [0m[32m 0.01[0m test_get_location_from_uri_back_to_uri [32mOK [0m[32m 0.01[0m test_get_store_from_scheme [32mOK [0m[32m 0.01[0m test_http_store_location [32mOK [0m[32m 0.01[0m test_rbd_store_location [32mOK [0m[32m 0.01[0m test_s3_store_location [32mOK [0m[32m 0.01[0m test_swift_store_location [32mOK [0m[32m 0.01[0m TestChunkReader test_read_all_data [32mOK [0m[32m 0.01[0m TestCreatingLocations test_multi_tenant_location [32mOK [0m[32m 0.01[0m test_multi_tenant_location_custom_service_type [32mOK [0m[32m 0.01[0m test_multi_tenant_location_http [32mOK [0m[32m 0.01[0m test_multi_tenant_location_with_region [32mOK [0m[32m 0.01[0m test_single_tenant_location [32mOK [0m[32m 0.01[0m test_single_tenant_location_http [32mOK [0m[32m 0.01[0m TestMultiTenantStoreConnections test_basic_connection [32mOK [0m[32m 0.01[0m test_connection_with_snet [32mOK [0m[32m 0.01[0m TestSingleTenantStoreConnections test_basic_connection [32mOK [0m[32m 0.01[0m test_connection_invalid_user [32mOK [0m[32m 0.01[0m test_connection_missing_user [32mOK [0m[32m 0.01[0m test_connection_with_auth_v1 [32mOK [0m[32m 0.01[0m test_connection_with_endpoint_type [32mOK [0m[32m 0.01[0m test_connection_with_no_trailing_slash [32mOK [0m[32m 0.01[0m test_connection_with_region [32mOK [0m[32m 0.01[0m test_connection_with_service_type [32mOK [0m[32m 0.01[0m test_connection_with_snet [32mOK [0m[32m 0.01[0m TestStoreAuthV1 test_add [32mOK [0m[32m 0.01[0m test_add_already_existing [32mOK [0m[32m 0.01[0m test_add_auth_url_variations [32mOK [0m[32m 0.01[0m test_add_large_object [32mOK [0m[32m 0.01[0m test_add_large_object_zero_size [32mOK [0m[32m 0.01[0m test_add_no_container_and_create [32mOK [0m[32m 0.01[0m test_add_no_container_no_create [32mOK [0m[32m 0.01[0m test_delete [32mOK [0m[32m 0.01[0m test_delete_non_existing [32mOK [0m[32m 0.00[0m test_get [32mOK [0m[32m 0.00[0m test_get_non_existing [32mOK [0m[32m 0.00[0m test_get_size [32mOK [0m[32m 0.00[0m test_get_size_with_multi_tenant_on [32mOK [0m[32m 0.00[0m test_get_with_http_auth [32mOK [0m[32m 0.00[0m test_no_auth_address [32mOK [0m[32m 0.00[0m test_no_key [32mOK [0m[32m 0.00[0m test_no_user [32mOK [0m[32m 0.01[0m test_read_acl_public [32mOK [0m[32m 0.00[0m test_read_acl_tenants [32mOK [0m[32m 0.00[0m test_read_write_public [32mOK [0m[32m 0.00[0m TestStoreAuthV2 test_add [32mOK [0m[32m 0.00[0m test_add_already_existing [32mOK [0m[32m 0.01[0m test_add_auth_url_variations [32mOK [0m[32m 0.01[0m test_add_large_object [32mOK [0m[32m 0.01[0m test_add_large_object_zero_size [32mOK [0m[32m 0.01[0m test_add_no_container_and_create [32mOK [0m[32m 0.01[0m test_add_no_container_no_create [32mOK [0m[32m 0.01[0m test_delete [32mOK [0m[32m 0.00[0m test_delete_non_existing [32mOK [0m[32m 0.00[0m test_get [32mOK [0m[32m 0.00[0m test_get_non_existing [32mOK [0m[32m 0.00[0m test_get_size [32mOK [0m[32m 0.00[0m test_get_size_with_multi_tenant_on [32mOK [0m[32m 0.00[0m test_get_with_http_auth [32mOK [0m[32m 0.00[0m test_no_auth_address [32mOK [0m[32m 0.00[0m test_no_key [32mOK [0m[32m 0.00[0m test_no_user [32mOK [0m[32m 0.01[0m test_read_acl_public [32mOK [0m[32m 0.00[0m test_read_acl_tenants [32mOK [0m[32m 0.00[0m test_read_write_public [32mOK [0m[32m 0.00[0m test_v2_multi_tenant_location [32mOK [0m[32m 0.00[0m test_v2_with_no_tenant [32mOK [0m[32m 0.00[0m TestUtils test_cooperative_reader [32mOK [0m[33m 0.03[0m test_cooperative_reader_of_iterator [32mOK [0m[32m 0.00[0m test_limiting_reader [32mOK [0m[32m 0.00[0m test_limiting_reader_fails [32mOK [0m[32m 0.01[0m VersionNegotiationTest test_request_accept_v1 [32mOK [0m[32m 0.01[0m test_request_url_v1 [32mOK [0m[32m 0.01[0m test_request_url_v1_0 [32mOK [0m[32m 0.01[0m test_request_url_v1_1 [32mOK [0m[32m 0.01[0m test_request_url_v2 [32mOK [0m[32m 0.01[0m test_request_url_v2_0 [32mOK [0m[32m 0.01[0m test_request_url_v2_1 [32mOK [0m[32m 0.01[0m test_request_url_v2_2_unsupported [32mOK [0m[32m 0.01[0m test_request_url_v3_unsupported [32mOK [0m[32m 0.01[0m VersionsTest test_get_version_list [32mOK [0m[32m 0.01[0m JSONRequestDeserializerTest test_default_no_body [32mOK [0m[32m 0.00[0m test_default_with_body [32mOK [0m[32m 0.00[0m test_from_json [32mOK [0m[32m 0.00[0m test_from_json_malformed [32mOK [0m[32m 0.00[0m test_has_body_has_content_length [32mOK [0m[32m 0.00[0m test_has_body_no_content_length [32mOK [0m[32m 0.00[0m test_has_body_zero_content_length [32mOK [0m[32m 0.00[0m test_no_body_no_content_length [32mOK [0m[32m 0.00[0m JSONResponseSerializerTest test_default [32mOK [0m[32m 0.00[0m test_to_json [32mOK [0m[32m 0.00[0m RequestTest test_content_type_accept_default [32mOK [0m[32m 0.00[0m test_content_type_from_accept_json [32mOK [0m[32m 0.00[0m test_content_type_from_accept_json_xml_quality [32mOK [0m[32m 0.00[0m test_content_type_from_accept_xml [32mOK [0m[32m 0.00[0m test_content_type_from_accept_xml_json [32mOK [0m[32m 0.00[0m test_content_type_missing [32mOK [0m[32m 0.00[0m test_content_type_unsupported [32mOK [0m[32m 0.00[0m test_content_type_with_charset [32mOK [0m[32m 0.00[0m ResourceTest test_dispatch [32mOK [0m[32m 0.00[0m test_dispatch_default [32mOK [0m[32m 0.00[0m test_dispatch_no_default [32mOK [0m[32m 0.00[0m test_get_action_args [32mOK [0m[32m 0.00[0m TestHelpers test_data_passed_properly_through_headers [32mOK [0m[32m 0.00[0m test_headers_are_unicode [32mOK [0m[32m 0.00[0m ====================================================================== FAIL: glance.tests.functional.test_bin_glance_control.TestGlanceControl.test_infinite_child_death ---------------------------------------------------------------------- _StringException: Traceback (most recent call last): File "<https://jenkins01.openstack.org/job/periodic-glance-python27-stable-grizzly…",> line 121, in wrapped func(*a, **kwargs) File "<https://jenkins01.openstack.org/job/periodic-glance-python27-stable-grizzly…",> line 267, in test_infinite_child_death self.assertTrue(launch_msg is None, launch_msg) File "/usr/lib/python2.7/unittest/case.py", line 420, in assertTrue raise self.failureException(msg) AssertionError: Unexpected server launch status ---------------------------------------------------------------------- XML: nosetests.xml Slowest 5 tests took 88.21 secs: [31m 25.82 TestScrubber.test_scrubber_app[0m [31m 20.25 TestScrubber.test_delayed_delete[0m [31m 14.51 TestGlanceControl.test_reload[0m [31m 14.26 TestGlanceControl.test_respawn[0m [31m 13.38 TestGlanceControl.test_bouncing[0m ---------------------------------------------------------------------- Ran 1109 tests in 581.030s FAILED (SKIP=42, failures=1) ERROR: InvocationError: '<https://jenkins01.openstack.org/job/periodic-glance-python27-stable-grizzly…'> ___________________________________ summary ____________________________________ ERROR: py27: commands failed + result=1 + echo 'Begin pip freeze output from test virtualenv:' Begin pip freeze output from test virtualenv: + echo ====================================================================== ====================================================================== + .tox/py27/bin/pip freeze Babel==1.3 Jinja2==2.7.1 MarkupSafe==0.18 MySQL-python==1.2.4 Paste==1.7.5.1 PasteDeploy==1.5.0 Pygments==1.6 Routes==1.13 SQLAlchemy==0.7.9 Sphinx==1.2b1 Tempita==0.5.1 WebOb==1.2.3 amqp==1.3.0 anyjson==0.3.3 argparse==1.2.1 boto==2.14.0 cffi==0.7.2 colorama==0.2.7 coverage==3.7 decorator==3.4.0 distribute==0.7.3 docutils==0.10 eventlet==0.14.0 extras==0.0.3 fixtures==0.3.14 glance==jenkins.periodic.glance.python27.stable.grizzly.44 greenlet==0.4.1 httplib2==0.8 iso8601==0.1.4 jsonschema==2.1.0 kombu==3.0.0 lxml==3.2.3 mox==0.5.3 netaddr==0.7.10 nose==1.3.0 nose-exclude==0.1.10 nosehtmloutput==0.0.5 openstack.nose-plugin==0.11 oslo.config==1.2.1 passlib==1.6.1 pbr==0.5.21 pep8==1.3.3 prettytable==0.7.2 psycopg2==2.5.1 pycparser==2.10 pycrypto==2.6 pysendfile==2.0.0 python-keystoneclient==0.4.1 python-mimeparse==0.1.4 python-swiftclient==1.8.0 pytz==2013.7 repoze.lru==0.6 requests==2.0.0 simplejson==3.3.1 six==1.4.1 sqlalchemy-migrate==0.7.2 termcolor==1.1.0 testtools==0.9.32 wsgiref==0.1.2 xattr==0.7.2 + echo ====================================================================== ====================================================================== + '[' -d .testrepository ']' + sudo /usr/local/jenkins/slave_scripts/jenkins-sudo-grep.sh post + sudoresult=0 + '[' 0 -ne 0 ']' + /usr/local/jenkins/slave_scripts/jenkins-oom-grep.sh post + oomresult=0 + '[' 0 -ne 0 ']' ++ find . -name nose_results.html + htmlreport=./nose_results.html + '[' -f ./nose_results.html ']' ++ grep -c 'tr class=.passClass' ./nose_results.html + passcount=126 + '[' 126 -eq 0 ']' + exit 1 + rm -rf /tmp/tmp.uxuI8cpNj9 Build step 'Execute shell' marked build as failure [SCP] Connecting to static.openstack.org [SCP] uploading file: '/srv/static/logs/periodic/periodic-glance-python27-stable-grizzly/44/nose_results.html' [SCP] Connecting to static.openstack.org [SCP] Trying to create /srv/static/logs/periodic/periodic-glance-python27-stable-grizzly/precise3/44 [SCP] Copying console log.

1 13

Build failed in Jenkins: periodic-glance-python26-stable-grizzly #41
by OpenStack Jenkins 14 Nov '13

14 Nov '13

See <https://jenkins01.openstack.org/job/periodic-glance-python26-stable-grizzly…> Changes: [adamg] Bump stable/grizzly next version to 2013.1.5 ------------------------------------------ [...truncated 1465 lines...] routes.middleware: DEBUG: Match dict: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x4456a10>} glance.api.policy: DEBUG: Loaded policy rules: {u'default': '@'} glance.common.client: DEBUG: Constructed URL: http://0.0.0.0:9191/images/detail?changes-since=2011-09-05 routes.middleware: DEBUG: Initialized with method overriding = True, and path info altering = True routes.middleware: DEBUG: Matched GET /images/detail routes.middleware: DEBUG: Route path: '/images/detail', defaults: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x459e390>} routes.middleware: DEBUG: Match dict: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x459e390>} iso8601.iso8601: DEBUG: Parsed 2011-09-05 into {'tz_sign': None, 'second_fraction': None, 'hour': None, 'tz_hour': None, 'month': u'09', 'timezone': None, 'second': None, 'tz_minute': None, 'year': u'2011', 'separator': None, 'day': u'05', 'minute': None} with default timezone <iso8601.iso8601.Utc object at 0x1a1db10> iso8601.iso8601: DEBUG: Got u'2011' for 'year' with default None iso8601.iso8601: DEBUG: Got u'09' for 'month' with default None iso8601.iso8601: DEBUG: Got u'05' for 'day' with default None iso8601.iso8601: DEBUG: Got None for 'hour' with default None iso8601.iso8601: DEBUG: Got None for 'minute' with default None iso8601.iso8601: DEBUG: Got None for 'second' with default None glance.registry.api.v1.images: INFO: Returning detailed image list glance.registry.client: DEBUG: Registry request GET /images/detail HTTP 200 request id req-1f38ad7b-ba82-4e32-9348-754e38254411 --------------------- >> end captured logging << --------------------- ====================================================================== FAIL: glance.tests.unit.v1.test_api.TestRegistryAPI.test_get_details_filter_changes_since ---------------------------------------------------------------------- _StringException: Traceback (most recent call last): File "<https://jenkins01.openstack.org/job/periodic-glance-python26-stable-grizzly…",> line 1414, in test_get_details_filter_changes_since self.assertEquals(res.status_int, 400) File "<https://jenkins01.openstack.org/job/periodic-glance-python26-stable-grizzly…",> line 322, in assertEqual self.assertThat(observed, matcher, message) File "<https://jenkins01.openstack.org/job/periodic-glance-python26-stable-grizzly…",> line 417, in assertThat raise MismatchError(matchee, matcher, mismatch, verbose) MismatchError: 200 != 400 -------------------- >> begin captured logging << -------------------- glance.store: DEBUG: Attempting to import store glance.store.filesystem.Store glance.store.filesystem: ERROR: Could not find filesystem_store_datadir in configuration options. glance.store.base: WARNING: Failed to configure store correctly: Store filesystem could not be configured correctly. Reason: Could not find filesystem_store_datadir in configuration options. Disabling add method. glance.store: DEBUG: Registering store <class 'glance.store.filesystem.Store'> with schemes ('file', 'filesystem') glance.store.base: DEBUG: Late loading location class glance.store.filesystem.StoreLocation glance.store.location: DEBUG: Registering scheme file with {'store_class': <class 'glance.store.filesystem.Store'>, 'location_class': <class 'glance.store.filesystem.StoreLocation'>} glance.store.location: DEBUG: Registering scheme filesystem with {'store_class': <class 'glance.store.filesystem.Store'>, 'location_class': <class 'glance.store.filesystem.StoreLocation'>} glance.store: DEBUG: Attempting to import store glance.store.http.Store glance.store: DEBUG: Registering store <class 'glance.store.http.Store'> with schemes ('http', 'https') glance.store.base: DEBUG: Late loading location class glance.store.http.StoreLocation glance.store.location: DEBUG: Registering scheme http with {'store_class': <class 'glance.store.http.Store'>, 'location_class': <class 'glance.store.http.StoreLocation'>} glance.store.location: DEBUG: Registering scheme https with {'store_class': <class 'glance.store.http.Store'>, 'location_class': <class 'glance.store.http.StoreLocation'>} glance.store: DEBUG: Attempting to import store glance.store.rbd.Store glance.store: DEBUG: Registering store <class 'glance.store.rbd.Store'> with schemes ('rbd',) glance.store.base: DEBUG: Late loading location class glance.store.rbd.StoreLocation glance.store.location: DEBUG: Registering scheme rbd with {'store_class': <class 'glance.store.rbd.Store'>, 'location_class': <class 'glance.store.rbd.StoreLocation'>} glance.store: DEBUG: Attempting to import store glance.store.s3.Store glance.store.s3: DEBUG: Could not find s3_store_host in configuration options. glance.store.base: WARNING: Failed to configure store correctly: Store s3 could not be configured correctly. Reason: Could not find s3_store_host in configuration options. Disabling add method. glance.store: DEBUG: Registering store <class 'glance.store.s3.Store'> with schemes ('s3', 's3+http', 's3+https') glance.store.base: DEBUG: Late loading location class glance.store.s3.StoreLocation glance.store.location: DEBUG: Registering scheme s3 with {'store_class': <class 'glance.store.s3.Store'>, 'location_class': <class 'glance.store.s3.StoreLocation'>} glance.store.location: DEBUG: Registering scheme s3+http with {'store_class': <class 'glance.store.s3.Store'>, 'location_class': <class 'glance.store.s3.StoreLocation'>} glance.store.location: DEBUG: Registering scheme s3+https with {'store_class': <class 'glance.store.s3.Store'>, 'location_class': <class 'glance.store.s3.StoreLocation'>} glance.store: DEBUG: Attempting to import store glance.store.swift.Store glance.store.swift: ERROR: Could not find swift_store_auth_address in configuration options. glance.store.base: WARNING: Failed to configure store correctly: Store swift could not be configured correctly. Reason: Could not find swift_store_auth_address in configuration options. Disabling add method. glance.store: DEBUG: Registering store <function Store at 0x2d5f9b0> with schemes ('swift+https', 'swift', 'swift+http') glance.store.base: DEBUG: Late loading location class glance.store.swift.StoreLocation glance.store.location: DEBUG: Registering scheme swift+https with {'store_class': <function Store at 0x2d5f9b0>, 'location_class': <class 'glance.store.swift.StoreLocation'>} glance.store.location: DEBUG: Registering scheme swift+http with {'store_class': <function Store at 0x2d5f9b0>, 'location_class': <class 'glance.store.swift.StoreLocation'>} glance.store.location: DEBUG: Registering scheme swift with {'store_class': <function Store at 0x2d5f9b0>, 'location_class': <class 'glance.store.swift.StoreLocation'>} routes.middleware: DEBUG: Initialized with method overriding = True, and path info altering = True routes.middleware: DEBUG: Matched GET /images/detail routes.middleware: DEBUG: Route path: '/images/detail', defaults: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x5fe6650>} routes.middleware: DEBUG: Match dict: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x5fe6650>} glance.registry.api.v1.images: INFO: Returning detailed image list routes.middleware: DEBUG: Matched GET /images/detail routes.middleware: DEBUG: Route path: '/images/detail', defaults: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x5fe6650>} routes.middleware: DEBUG: Match dict: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x5fe6650>} iso8601.iso8601: DEBUG: Parsed 2013-10-20T06:11:50Z into {'tz_sign': None, 'second_fraction': None, 'hour': u'06', 'tz_hour': None, 'month': u'10', 'timezone': u'Z', 'second': u'50', 'tz_minute': None, 'year': u'2013', 'separator': u'T', 'day': u'20', 'minute': u'11'} with default timezone <iso8601.iso8601.Utc object at 0x1a1db10> iso8601.iso8601: DEBUG: Got u'2013' for 'year' with default None iso8601.iso8601: DEBUG: Got u'10' for 'month' with default None iso8601.iso8601: DEBUG: Got u'20' for 'day' with default None iso8601.iso8601: DEBUG: Got u'06' for 'hour' with default None iso8601.iso8601: DEBUG: Got u'11' for 'minute' with default None iso8601.iso8601: DEBUG: Got u'50' for 'second' with default None glance.registry.api.v1.images: INFO: Returning detailed image list routes.middleware: DEBUG: Matched GET /images/detail routes.middleware: DEBUG: Route path: '/images/detail', defaults: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x5fe6650>} routes.middleware: DEBUG: Match dict: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x5fe6650>} iso8601.iso8601: DEBUG: Parsed 2013-10-22T06:11:50Z into {'tz_sign': None, 'second_fraction': None, 'hour': u'06', 'tz_hour': None, 'month': u'10', 'timezone': u'Z', 'second': u'50', 'tz_minute': None, 'year': u'2013', 'separator': u'T', 'day': u'22', 'minute': u'11'} with default timezone <iso8601.iso8601.Utc object at 0x1a1db10> iso8601.iso8601: DEBUG: Got u'2013' for 'year' with default None iso8601.iso8601: DEBUG: Got u'10' for 'month' with default None iso8601.iso8601: DEBUG: Got u'22' for 'day' with default None iso8601.iso8601: DEBUG: Got u'06' for 'hour' with default None iso8601.iso8601: DEBUG: Got u'11' for 'minute' with default None iso8601.iso8601: DEBUG: Got u'50' for 'second' with default None glance.registry.api.v1.images: INFO: Returning detailed image list routes.middleware: DEBUG: Matched GET /images/detail routes.middleware: DEBUG: Route path: '/images/detail', defaults: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x5fe6650>} routes.middleware: DEBUG: Match dict: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x5fe6650>} iso8601.iso8601: DEBUG: Parsed 2013-10-23T06:11:50+01:00 into {'tz_sign': u'+', 'second_fraction': None, 'hour': u'06', 'tz_hour': u'01', 'month': u'10', 'timezone': u'+01:00', 'second': u'50', 'tz_minute': u'00', 'year': u'2013', 'separator': u'T', 'day': u'23', 'minute': u'11'} with default timezone <iso8601.iso8601.Utc object at 0x1a1db10> iso8601.iso8601: DEBUG: Got u'01' for 'tz_hour' with default None iso8601.iso8601: DEBUG: Got u'00' for 'tz_minute' with default None iso8601.iso8601: DEBUG: Got u'2013' for 'year' with default None iso8601.iso8601: DEBUG: Got u'10' for 'month' with default None iso8601.iso8601: DEBUG: Got u'23' for 'day' with default None iso8601.iso8601: DEBUG: Got u'06' for 'hour' with default None iso8601.iso8601: DEBUG: Got u'11' for 'minute' with default None iso8601.iso8601: DEBUG: Got u'50' for 'second' with default None glance.registry.api.v1.images: INFO: Returning detailed image list routes.middleware: DEBUG: Matched GET /images/detail routes.middleware: DEBUG: Route path: '/images/detail', defaults: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x5fe6650>} routes.middleware: DEBUG: Match dict: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x5fe6650>} iso8601.iso8601: DEBUG: Parsed 2013-10-23T06:11:50-01:00 into {'tz_sign': u'-', 'second_fraction': None, 'hour': u'06', 'tz_hour': u'01', 'month': u'10', 'timezone': u'-01:00', 'second': u'50', 'tz_minute': u'00', 'year': u'2013', 'separator': u'T', 'day': u'23', 'minute': u'11'} with default timezone <iso8601.iso8601.Utc object at 0x1a1db10> iso8601.iso8601: DEBUG: Got u'01' for 'tz_hour' with default None iso8601.iso8601: DEBUG: Got u'00' for 'tz_minute' with default None iso8601.iso8601: DEBUG: Got u'2013' for 'year' with default None iso8601.iso8601: DEBUG: Got u'10' for 'month' with default None iso8601.iso8601: DEBUG: Got u'23' for 'day' with default None iso8601.iso8601: DEBUG: Got u'06' for 'hour' with default None iso8601.iso8601: DEBUG: Got u'11' for 'minute' with default None iso8601.iso8601: DEBUG: Got u'50' for 'second' with default None glance.registry.api.v1.images: INFO: Returning detailed image list routes.middleware: DEBUG: Matched GET /images/detail routes.middleware: DEBUG: Route path: '/images/detail', defaults: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x5fe6650>} routes.middleware: DEBUG: Match dict: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x5fe6650>} iso8601.iso8601: DEBUG: Parsed 2013-10-24T06:11:50Z into {'tz_sign': None, 'second_fraction': None, 'hour': u'06', 'tz_hour': None, 'month': u'10', 'timezone': u'Z', 'second': u'50', 'tz_minute': None, 'year': u'2013', 'separator': u'T', 'day': u'24', 'minute': u'11'} with default timezone <iso8601.iso8601.Utc object at 0x1a1db10> iso8601.iso8601: DEBUG: Got u'2013' for 'year' with default None iso8601.iso8601: DEBUG: Got u'10' for 'month' with default None iso8601.iso8601: DEBUG: Got u'24' for 'day' with default None iso8601.iso8601: DEBUG: Got u'06' for 'hour' with default None iso8601.iso8601: DEBUG: Got u'11' for 'minute' with default None iso8601.iso8601: DEBUG: Got u'50' for 'second' with default None glance.registry.api.v1.images: INFO: Returning detailed image list routes.middleware: DEBUG: Matched GET /images/detail routes.middleware: DEBUG: Route path: '/images/detail', defaults: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x5fe6650>} routes.middleware: DEBUG: Match dict: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x5fe6650>} routes.middleware: DEBUG: Matched GET /images/detail routes.middleware: DEBUG: Route path: '/images/detail', defaults: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x5fe6650>} routes.middleware: DEBUG: Match dict: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x5fe6650>} iso8601.iso8601: DEBUG: Parsed 2011-09-05 into {'tz_sign': None, 'second_fraction': None, 'hour': None, 'tz_hour': None, 'month': u'09', 'timezone': None, 'second': None, 'tz_minute': None, 'year': u'2011', 'separator': None, 'day': u'05', 'minute': None} with default timezone <iso8601.iso8601.Utc object at 0x1a1db10> iso8601.iso8601: DEBUG: Got u'2011' for 'year' with default None iso8601.iso8601: DEBUG: Got u'09' for 'month' with default None iso8601.iso8601: DEBUG: Got u'05' for 'day' with default None iso8601.iso8601: DEBUG: Got None for 'hour' with default None iso8601.iso8601: DEBUG: Got None for 'minute' with default None iso8601.iso8601: DEBUG: Got None for 'second' with default None glance.registry.api.v1.images: INFO: Returning detailed image list --------------------- >> end captured logging << --------------------- ---------------------------------------------------------------------- XML: nosetests.xml Slowest 5 tests took 90.71 secs: [31m 26.28 TestScrubber.test_scrubber_app[0m [31m 20.72 TestScrubber.test_delayed_delete[0m [31m 14.76 TestGlanceControl.test_reload[0m [31m 14.50 TestGlanceControl.test_respawn[0m [31m 14.44 TestRootApi.test_version_configurations[0m ---------------------------------------------------------------------- Ran 1109 tests in 634.623s FAILED (SKIP=42, failures=2) ERROR: InvocationError: '<https://jenkins01.openstack.org/job/periodic-glance-python26-stable-grizzly…'> ___________________________________ summary ____________________________________ ERROR: py26: commands failed + result=1 + echo 'Begin pip freeze output from test virtualenv:' Begin pip freeze output from test virtualenv: + echo ====================================================================== ====================================================================== + .tox/py26/bin/pip freeze Babel==1.3 Jinja2==2.7.1 MarkupSafe==0.18 MySQL-python==1.2.4 Paste==1.7.5.1 PasteDeploy==1.5.0 Pygments==1.6 Routes==1.13 SQLAlchemy==0.7.9 Sphinx==1.2b1 Tempita==0.5.1 WebOb==1.2.3 amqp==1.3.0 anyjson==0.3.3 argparse==1.2.1 boto==2.15.0 cffi==0.7.2 colorama==0.2.7 coverage==3.7 decorator==3.4.0 distribute==0.7.3 docutils==0.10 eventlet==0.14.0 extras==0.0.3 fixtures==0.3.14 glance==jenkins.periodic.glance.python26.stable.grizzly.41 greenlet==0.4.1 httplib2==0.8 importlib==1.0.2 iso8601==0.1.7 jsonschema==2.2.0 kombu==3.0.0 lxml==3.2.3 mox==0.5.3 netaddr==0.7.10 nose==1.3.0 nose-exclude==0.1.10 nosehtmloutput==0.0.5 openstack.nose-plugin==0.11 ordereddict==1.1 oslo.config==1.2.1 passlib==1.6.1 pbr==0.5.21 pep8==1.3.3 prettytable==0.7.2 psycopg2==2.5.1 pycparser==2.10 pycrypto==2.6.1 pysendfile==2.0.0 python-keystoneclient==0.4.1 python-mimeparse==0.1.4 python-swiftclient==1.8.0 pytz==2013.7 repoze.lru==0.6 requests==2.0.0 simplejson==3.3.1 six==1.4.1 sqlalchemy-migrate==0.7.2 termcolor==1.1.0 testtools==0.9.32 wsgiref==0.1.2 xattr==0.7.2 + echo ====================================================================== ====================================================================== + '[' -d .testrepository ']' + sudo /usr/local/jenkins/slave_scripts/jenkins-sudo-grep.sh post + sudoresult=0 + '[' 0 -ne 0 ']' + /usr/local/jenkins/slave_scripts/jenkins-oom-grep.sh post + oomresult=0 + '[' 0 -ne 0 ']' ++ find . -name nose_results.html + htmlreport=./nose_results.html + '[' -f ./nose_results.html ']' ++ grep -c 'tr class=.passClass' ./nose_results.html + passcount=125 + '[' 125 -eq 0 ']' + exit 1 + rm -rf /tmp/tmp.el6KI8GaEL Build step 'Execute shell' marked build as failure [SCP] Connecting to static.openstack.org [SCP] uploading file: '/srv/static/logs/periodic/periodic-glance-python26-stable-grizzly/41/nose_results.html' [SCP] Connecting to static.openstack.org [SCP] Trying to create /srv/static/logs/periodic/periodic-glance-python26-stable-grizzly/centos6-5/41 [SCP] Copying console log.

1 16

Build failed in Jenkins: periodic-glance-python27-stable-grizzly #29
by OpenStack Jenkins 14 Nov '13

14 Nov '13

See <https://jenkins02.openstack.org/job/periodic-glance-python27-stable-grizzly…> Changes: [adamg] Bump stable/grizzly next version to 2013.1.5 ------------------------------------------ [...truncated 1490 lines...] routes.middleware: DEBUG: Route path: '/images/detail', defaults: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x599cfd0>} routes.middleware: DEBUG: Match dict: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x599cfd0>} iso8601.iso8601: DEBUG: Parsed 2011-09-05 into {'tz_sign': None, 'second_fraction': None, 'hour': None, 'tz_hour': None, 'month': u'09', 'timezone': None, 'second': None, 'tz_minute': None, 'year': u'2011', 'separator': None, 'day': u'05', 'minute': None} with default timezone <iso8601.iso8601.Utc object at 0x233c2d0> iso8601.iso8601: DEBUG: Got None for 'second_fraction' with default None iso8601.iso8601: DEBUG: Got u'2011' for 'year' with default None iso8601.iso8601: DEBUG: Got u'09' for 'month' with default None iso8601.iso8601: DEBUG: Got u'05' for 'day' with default None iso8601.iso8601: DEBUG: Got None for 'hour' with default None iso8601.iso8601: DEBUG: Got None for 'minute' with default None iso8601.iso8601: DEBUG: Got None for 'second' with default None glance.registry.api.v1.images: INFO: Returning detailed image list glance.registry.client: DEBUG: Registry request GET /images/detail HTTP 200 request id req-62b80e11-56cd-46e1-80f8-8baab5e431e0 --------------------- >> end captured logging << --------------------- ====================================================================== FAIL: glance.tests.unit.v1.test_api.TestRegistryAPI.test_get_details_filter_changes_since ---------------------------------------------------------------------- _StringException: Traceback (most recent call last): File "<https://jenkins02.openstack.org/job/periodic-glance-python27-stable-grizzly…",> line 1414, in test_get_details_filter_changes_since self.assertEquals(res.status_int, 400) File "<https://jenkins02.openstack.org/job/periodic-glance-python27-stable-grizzly…",> line 322, in assertEqual self.assertThat(observed, matcher, message) File "<https://jenkins02.openstack.org/job/periodic-glance-python27-stable-grizzly…",> line 417, in assertThat raise MismatchError(matchee, matcher, mismatch, verbose) MismatchError: 200 != 400 -------------------- >> begin captured logging << -------------------- glance.store: DEBUG: Attempting to import store glance.store.filesystem.Store glance.store.filesystem: ERROR: Could not find filesystem_store_datadir in configuration options. glance.store.base: WARNING: Failed to configure store correctly: Store filesystem could not be configured correctly. Reason: Could not find filesystem_store_datadir in configuration options. Disabling add method. glance.store: DEBUG: Registering store <class 'glance.store.filesystem.Store'> with schemes ('file', 'filesystem') glance.store.base: DEBUG: Late loading location class glance.store.filesystem.StoreLocation glance.store.location: DEBUG: Registering scheme file with {'store_class': <class 'glance.store.filesystem.Store'>, 'location_class': <class 'glance.store.filesystem.StoreLocation'>} glance.store.location: DEBUG: Registering scheme filesystem with {'store_class': <class 'glance.store.filesystem.Store'>, 'location_class': <class 'glance.store.filesystem.StoreLocation'>} glance.store: DEBUG: Attempting to import store glance.store.http.Store glance.store: DEBUG: Registering store <class 'glance.store.http.Store'> with schemes ('http', 'https') glance.store.base: DEBUG: Late loading location class glance.store.http.StoreLocation glance.store.location: DEBUG: Registering scheme http with {'store_class': <class 'glance.store.http.Store'>, 'location_class': <class 'glance.store.http.StoreLocation'>} glance.store.location: DEBUG: Registering scheme https with {'store_class': <class 'glance.store.http.Store'>, 'location_class': <class 'glance.store.http.StoreLocation'>} glance.store: DEBUG: Attempting to import store glance.store.rbd.Store glance.store: DEBUG: Registering store <class 'glance.store.rbd.Store'> with schemes ('rbd',) glance.store.base: DEBUG: Late loading location class glance.store.rbd.StoreLocation glance.store.location: DEBUG: Registering scheme rbd with {'store_class': <class 'glance.store.rbd.Store'>, 'location_class': <class 'glance.store.rbd.StoreLocation'>} glance.store: DEBUG: Attempting to import store glance.store.s3.Store glance.store.s3: DEBUG: Could not find s3_store_host in configuration options. glance.store.base: WARNING: Failed to configure store correctly: Store s3 could not be configured correctly. Reason: Could not find s3_store_host in configuration options. Disabling add method. glance.store: DEBUG: Registering store <class 'glance.store.s3.Store'> with schemes ('s3', 's3+http', 's3+https') glance.store.base: DEBUG: Late loading location class glance.store.s3.StoreLocation glance.store.location: DEBUG: Registering scheme s3 with {'store_class': <class 'glance.store.s3.Store'>, 'location_class': <class 'glance.store.s3.StoreLocation'>} glance.store.location: DEBUG: Registering scheme s3+http with {'store_class': <class 'glance.store.s3.Store'>, 'location_class': <class 'glance.store.s3.StoreLocation'>} glance.store.location: DEBUG: Registering scheme s3+https with {'store_class': <class 'glance.store.s3.Store'>, 'location_class': <class 'glance.store.s3.StoreLocation'>} glance.store: DEBUG: Attempting to import store glance.store.swift.Store glance.store.swift: ERROR: Could not find swift_store_auth_address in configuration options. glance.store.base: WARNING: Failed to configure store correctly: Store swift could not be configured correctly. Reason: Could not find swift_store_auth_address in configuration options. Disabling add method. glance.store: DEBUG: Registering store <function Store at 0x37997d0> with schemes ('swift+https', 'swift', 'swift+http') glance.store.base: DEBUG: Late loading location class glance.store.swift.StoreLocation glance.store.location: DEBUG: Registering scheme swift+https with {'store_class': <function Store at 0x37997d0>, 'location_class': <class 'glance.store.swift.StoreLocation'>} glance.store.location: DEBUG: Registering scheme swift+http with {'store_class': <function Store at 0x37997d0>, 'location_class': <class 'glance.store.swift.StoreLocation'>} glance.store.location: DEBUG: Registering scheme swift with {'store_class': <function Store at 0x37997d0>, 'location_class': <class 'glance.store.swift.StoreLocation'>} routes.middleware: DEBUG: Initialized with method overriding = True, and path info altering = True routes.middleware: DEBUG: Matched GET /images/detail routes.middleware: DEBUG: Route path: '/images/detail', defaults: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x5978390>} routes.middleware: DEBUG: Match dict: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x5978390>} glance.registry.api.v1.images: INFO: Returning detailed image list routes.middleware: DEBUG: Matched GET /images/detail routes.middleware: DEBUG: Route path: '/images/detail', defaults: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x5978390>} routes.middleware: DEBUG: Match dict: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x5978390>} iso8601.iso8601: DEBUG: Parsed 2013-10-17T06:13:23Z into {'tz_sign': None, 'second_fraction': None, 'hour': u'06', 'tz_hour': None, 'month': u'10', 'timezone': u'Z', 'second': u'23', 'tz_minute': None, 'year': u'2013', 'separator': u'T', 'day': u'17', 'minute': u'13'} with default timezone <iso8601.iso8601.Utc object at 0x233c2d0> iso8601.iso8601: DEBUG: Got None for 'second_fraction' with default None iso8601.iso8601: DEBUG: Got u'2013' for 'year' with default None iso8601.iso8601: DEBUG: Got u'10' for 'month' with default None iso8601.iso8601: DEBUG: Got u'17' for 'day' with default None iso8601.iso8601: DEBUG: Got u'06' for 'hour' with default None iso8601.iso8601: DEBUG: Got u'13' for 'minute' with default None iso8601.iso8601: DEBUG: Got u'23' for 'second' with default None glance.registry.api.v1.images: INFO: Returning detailed image list routes.middleware: DEBUG: Matched GET /images/detail routes.middleware: DEBUG: Route path: '/images/detail', defaults: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x5978390>} routes.middleware: DEBUG: Match dict: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x5978390>} iso8601.iso8601: DEBUG: Parsed 2013-10-19T06:13:23Z into {'tz_sign': None, 'second_fraction': None, 'hour': u'06', 'tz_hour': None, 'month': u'10', 'timezone': u'Z', 'second': u'23', 'tz_minute': None, 'year': u'2013', 'separator': u'T', 'day': u'19', 'minute': u'13'} with default timezone <iso8601.iso8601.Utc object at 0x233c2d0> iso8601.iso8601: DEBUG: Got None for 'second_fraction' with default None iso8601.iso8601: DEBUG: Got u'2013' for 'year' with default None iso8601.iso8601: DEBUG: Got u'10' for 'month' with default None iso8601.iso8601: DEBUG: Got u'19' for 'day' with default None iso8601.iso8601: DEBUG: Got u'06' for 'hour' with default None iso8601.iso8601: DEBUG: Got u'13' for 'minute' with default None iso8601.iso8601: DEBUG: Got u'23' for 'second' with default None glance.registry.api.v1.images: INFO: Returning detailed image list routes.middleware: DEBUG: Matched GET /images/detail routes.middleware: DEBUG: Route path: '/images/detail', defaults: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x5978390>} routes.middleware: DEBUG: Match dict: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x5978390>} iso8601.iso8601: DEBUG: Parsed 2013-10-20T06:13:23+01:00 into {'tz_sign': u'+', 'second_fraction': None, 'hour': u'06', 'tz_hour': u'01', 'month': u'10', 'timezone': u'+01:00', 'second': u'23', 'tz_minute': u'00', 'year': u'2013', 'separator': u'T', 'day': u'20', 'minute': u'13'} with default timezone <iso8601.iso8601.Utc object at 0x233c2d0> iso8601.iso8601: DEBUG: Got u'01' for 'tz_hour' with default None iso8601.iso8601: DEBUG: Got u'00' for 'tz_minute' with default None iso8601.iso8601: DEBUG: Got None for 'second_fraction' with default None iso8601.iso8601: DEBUG: Got u'2013' for 'year' with default None iso8601.iso8601: DEBUG: Got u'10' for 'month' with default None iso8601.iso8601: DEBUG: Got u'20' for 'day' with default None iso8601.iso8601: DEBUG: Got u'06' for 'hour' with default None iso8601.iso8601: DEBUG: Got u'13' for 'minute' with default None iso8601.iso8601: DEBUG: Got u'23' for 'second' with default None glance.registry.api.v1.images: INFO: Returning detailed image list routes.middleware: DEBUG: Matched GET /images/detail routes.middleware: DEBUG: Route path: '/images/detail', defaults: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x5978390>} routes.middleware: DEBUG: Match dict: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x5978390>} iso8601.iso8601: DEBUG: Parsed 2013-10-20T06:13:23-01:00 into {'tz_sign': u'-', 'second_fraction': None, 'hour': u'06', 'tz_hour': u'01', 'month': u'10', 'timezone': u'-01:00', 'second': u'23', 'tz_minute': u'00', 'year': u'2013', 'separator': u'T', 'day': u'20', 'minute': u'13'} with default timezone <iso8601.iso8601.Utc object at 0x233c2d0> iso8601.iso8601: DEBUG: Got u'01' for 'tz_hour' with default None iso8601.iso8601: DEBUG: Got u'00' for 'tz_minute' with default None iso8601.iso8601: DEBUG: Got None for 'second_fraction' with default None iso8601.iso8601: DEBUG: Got u'2013' for 'year' with default None iso8601.iso8601: DEBUG: Got u'10' for 'month' with default None iso8601.iso8601: DEBUG: Got u'20' for 'day' with default None iso8601.iso8601: DEBUG: Got u'06' for 'hour' with default None iso8601.iso8601: DEBUG: Got u'13' for 'minute' with default None iso8601.iso8601: DEBUG: Got u'23' for 'second' with default None glance.registry.api.v1.images: INFO: Returning detailed image list routes.middleware: DEBUG: Matched GET /images/detail routes.middleware: DEBUG: Route path: '/images/detail', defaults: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x5978390>} routes.middleware: DEBUG: Match dict: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x5978390>} iso8601.iso8601: DEBUG: Parsed 2013-10-21T06:13:23Z into {'tz_sign': None, 'second_fraction': None, 'hour': u'06', 'tz_hour': None, 'month': u'10', 'timezone': u'Z', 'second': u'23', 'tz_minute': None, 'year': u'2013', 'separator': u'T', 'day': u'21', 'minute': u'13'} with default timezone <iso8601.iso8601.Utc object at 0x233c2d0> iso8601.iso8601: DEBUG: Got None for 'second_fraction' with default None iso8601.iso8601: DEBUG: Got u'2013' for 'year' with default None iso8601.iso8601: DEBUG: Got u'10' for 'month' with default None iso8601.iso8601: DEBUG: Got u'21' for 'day' with default None iso8601.iso8601: DEBUG: Got u'06' for 'hour' with default None iso8601.iso8601: DEBUG: Got u'13' for 'minute' with default None iso8601.iso8601: DEBUG: Got u'23' for 'second' with default None glance.registry.api.v1.images: INFO: Returning detailed image list routes.middleware: DEBUG: Matched GET /images/detail routes.middleware: DEBUG: Route path: '/images/detail', defaults: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x5978390>} routes.middleware: DEBUG: Match dict: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x5978390>} routes.middleware: DEBUG: Matched GET /images/detail routes.middleware: DEBUG: Route path: '/images/detail', defaults: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x5978390>} routes.middleware: DEBUG: Match dict: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x5978390>} iso8601.iso8601: DEBUG: Parsed 2011-09-05 into {'tz_sign': None, 'second_fraction': None, 'hour': None, 'tz_hour': None, 'month': u'09', 'timezone': None, 'second': None, 'tz_minute': None, 'year': u'2011', 'separator': None, 'day': u'05', 'minute': None} with default timezone <iso8601.iso8601.Utc object at 0x233c2d0> iso8601.iso8601: DEBUG: Got None for 'second_fraction' with default None iso8601.iso8601: DEBUG: Got u'2011' for 'year' with default None iso8601.iso8601: DEBUG: Got u'09' for 'month' with default None iso8601.iso8601: DEBUG: Got u'05' for 'day' with default None iso8601.iso8601: DEBUG: Got None for 'hour' with default None iso8601.iso8601: DEBUG: Got None for 'minute' with default None iso8601.iso8601: DEBUG: Got None for 'second' with default None glance.registry.api.v1.images: INFO: Returning detailed image list --------------------- >> end captured logging << --------------------- ---------------------------------------------------------------------- XML: nosetests.xml Slowest 5 tests took 108.26 secs: [31m 27.63 TestBinGlanceCacheManage.test_queue[0m [31m 27.26 TestScrubber.test_scrubber_app[0m [31m 21.82 TestScrubber.test_delayed_delete[0m [31m 16.29 TestRootApi.test_version_configurations[0m [31m 15.26 TestGlanceControl.test_reload[0m ---------------------------------------------------------------------- Ran 1109 tests in 721.436s FAILED (SKIP=42, failures=3) ERROR: InvocationError: '<https://jenkins02.openstack.org/job/periodic-glance-python27-stable-grizzly…'> ___________________________________ summary ____________________________________ ERROR: py27: commands failed + result=1 + echo 'Begin pip freeze output from test virtualenv:' Begin pip freeze output from test virtualenv: + echo ====================================================================== ====================================================================== + .tox/py27/bin/pip freeze Babel==1.3 Jinja2==2.7.1 MarkupSafe==0.18 MySQL-python==1.2.4 Paste==1.7.5.1 PasteDeploy==1.5.0 Pygments==1.6 Routes==1.13 SQLAlchemy==0.7.9 Sphinx==1.2b1 Tempita==0.5.1 WebOb==1.2.3 amqp==1.3.0 anyjson==0.3.3 argparse==1.2.1 boto==2.14.0 cffi==0.7.2 colorama==0.2.7 coverage==3.7 decorator==3.4.0 distribute==0.7.3 docutils==0.10 eventlet==0.14.0 extras==0.0.3 fixtures==0.3.14 glance==jenkins.periodic.glance.python27.stable.grizzly.29 greenlet==0.4.1 httplib2==0.8 iso8601==0.1.5 jsonschema==2.1.0 kombu==3.0.0 lxml==3.2.3 mox==0.5.3 netaddr==0.7.10 nose==1.3.0 nose-exclude==0.1.10 nosehtmloutput==0.0.5 openstack.nose-plugin==0.11 oslo.config==1.2.1 passlib==1.6.1 pbr==0.5.21 pep8==1.3.3 prettytable==0.7.2 psycopg2==2.5.1 pycparser==2.10 pycrypto==2.6.1 pysendfile==2.0.0 python-keystoneclient==0.4.1 python-mimeparse==0.1.4 python-swiftclient==1.8.0 pytz==2013.7 repoze.lru==0.6 requests==2.0.0 simplejson==3.3.1 six==1.4.1 sqlalchemy-migrate==0.7.2 termcolor==1.1.0 testtools==0.9.32 wsgiref==0.1.2 xattr==0.7.2 + echo ====================================================================== ====================================================================== + '[' -d .testrepository ']' + sudo /usr/local/jenkins/slave_scripts/jenkins-sudo-grep.sh post + sudoresult=0 + '[' 0 -ne 0 ']' + /usr/local/jenkins/slave_scripts/jenkins-oom-grep.sh post + oomresult=0 + '[' 0 -ne 0 ']' ++ find . -name nose_results.html + htmlreport=./nose_results.html + '[' -f ./nose_results.html ']' ++ grep -c 'tr class=.passClass' ./nose_results.html + passcount=124 + '[' 124 -eq 0 ']' + exit 1 + rm -rf /tmp/tmp.gfpTmPJ0gh Build step 'Execute shell' marked build as failure [SCP] Connecting to static.openstack.org [SCP] uploading file: '/srv/static/logs/periodic/periodic-glance-python27-stable-grizzly/29/nose_results.html' [SCP] Connecting to static.openstack.org [SCP] Trying to create /srv/static/logs/periodic/periodic-glance-python27-stable-grizzly/precise32/29 [SCP] Copying console log.

1 16

Build failed in Jenkins: periodic-glance-python27-stable-folsom #35
by OpenStack Jenkins 13 Nov '13

13 Nov '13

See <https://jenkins01.openstack.org/job/periodic-glance-python27-stable-folsom/…> ------------------------------------------ [...truncated 1275 lines...] File "<https://jenkins01.openstack.org/job/periodic-glance-python27-stable-folsom/…",> line 89, in do_request action, **kwargs) File "<https://jenkins01.openstack.org/job/periodic-glance-python27-stable-folsom/…",> line 63, in wrapped return func(self, *args, **kwargs) File "<https://jenkins01.openstack.org/job/periodic-glance-python27-stable-folsom/…",> line 444, in do_request headers=headers) File "<https://jenkins01.openstack.org/job/periodic-glance-python27-stable-folsom/…",> line 80, in wrapped return func(self, method, url, body, headers) File "<https://jenkins01.openstack.org/job/periodic-glance-python27-stable-folsom/…",> line 574, in _do_request raise exception.Invalid(res.read()) Invalid: 400 Bad Request The server could not comply with the request since it is either malformed or otherwise incorrect. Unrecognized changes-since value routes.middleware: DEBUG: Matched GET /images/detail routes.middleware: DEBUG: Route path: '/images/detail', defaults: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x4a35b90>} routes.middleware: DEBUG: Match dict: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x4a35b90>} glance.api.policy: DEBUG: Loaded policy rules: {u'default': []} glance.common.client: DEBUG: Constructed URL: http://0.0.0.0:9191/images/detail?changes-since=2011-09-05 routes.middleware: DEBUG: Initialized with method overriding = True, and path info altering = True routes.middleware: DEBUG: Matched GET /images/detail routes.middleware: DEBUG: Route path: '/images/detail', defaults: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x52ef610>} routes.middleware: DEBUG: Match dict: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x52ef610>} iso8601.iso8601: DEBUG: Parsed 2011-09-05 into {'tz_sign': None, 'second_fraction': None, 'hour': None, 'tz_hour': None, 'month': u'09', 'timezone': None, 'second': None, 'tz_minute': None, 'year': u'2011', 'separator': None, 'day': u'05', 'minute': None} with default timezone <iso8601.iso8601.Utc object at 0x23c3d50> iso8601.iso8601: DEBUG: Got u'2011' for 'year' with default None iso8601.iso8601: DEBUG: Got u'09' for 'month' with default None iso8601.iso8601: DEBUG: Got u'05' for 'day' with default None iso8601.iso8601: DEBUG: Got None for 'hour' with default None iso8601.iso8601: DEBUG: Got None for 'minute' with default None iso8601.iso8601: DEBUG: Got None for 'second' with default None glance.registry.api.v1.images: INFO: Returning detailed image list glance.registry.client: DEBUG: Registry request GET /images/detail HTTP 200 request id req-dd41839b-60e5-409e-8aae-0468ac8adf58 --------------------- >> end captured logging << --------------------- ====================================================================== FAIL: Tests that the /images/detail registry API returns list of ---------------------------------------------------------------------- Traceback (most recent call last): File "<https://jenkins01.openstack.org/job/periodic-glance-python27-stable-folsom/…",> line 1409, in test_get_details_filter_changes_since self.assertEquals(res.status_int, 400) AssertionError: 200 != 400 '200 != 400' = '%s != %s' % (safe_repr(200), safe_repr(400)) '200 != 400' = self._formatMessage('200 != 400', '200 != 400') >> raise self.failureException('200 != 400') -------------------- >> begin captured logging << -------------------- glance.store: DEBUG: Attempting to import store glance.store.filesystem.Store glance.store: DEBUG: Registering store <class 'glance.store.filesystem.Store'> with schemes ('file', 'filesystem') glance.store.base: DEBUG: Late loading location class glance.store.filesystem.StoreLocation glance.store.location: DEBUG: Registering scheme file with {'store_class': <class 'glance.store.filesystem.Store'>, 'location_class': <class 'glance.store.filesystem.StoreLocation'>} glance.store.location: DEBUG: Registering scheme filesystem with {'store_class': <class 'glance.store.filesystem.Store'>, 'location_class': <class 'glance.store.filesystem.StoreLocation'>} glance.store: DEBUG: Attempting to import store glance.store.http.Store glance.store: DEBUG: Registering store <class 'glance.store.http.Store'> with schemes ('http', 'https') glance.store.base: DEBUG: Late loading location class glance.store.http.StoreLocation glance.store.location: DEBUG: Registering scheme http with {'store_class': <class 'glance.store.http.Store'>, 'location_class': <class 'glance.store.http.StoreLocation'>} glance.store.location: DEBUG: Registering scheme https with {'store_class': <class 'glance.store.http.Store'>, 'location_class': <class 'glance.store.http.StoreLocation'>} glance.store: DEBUG: Attempting to import store glance.store.rbd.Store glance.store: DEBUG: Registering store <class 'glance.store.rbd.Store'> with schemes ('rbd',) glance.store.base: DEBUG: Late loading location class glance.store.rbd.StoreLocation glance.store.location: DEBUG: Registering scheme rbd with {'store_class': <class 'glance.store.rbd.Store'>, 'location_class': <class 'glance.store.rbd.StoreLocation'>} glance.store: DEBUG: Attempting to import store glance.store.s3.Store glance.store.s3: ERROR: Could not find s3_store_host in configuration options. glance.store.base: ERROR: Failed to configure store correctly. Disabling add method. glance.store: DEBUG: Registering store <class 'glance.store.s3.Store'> with schemes ('s3', 's3+http', 's3+https') glance.store.base: DEBUG: Late loading location class glance.store.s3.StoreLocation glance.store.location: DEBUG: Registering scheme s3 with {'store_class': <class 'glance.store.s3.Store'>, 'location_class': <class 'glance.store.s3.StoreLocation'>} glance.store.location: DEBUG: Registering scheme s3+http with {'store_class': <class 'glance.store.s3.Store'>, 'location_class': <class 'glance.store.s3.StoreLocation'>} glance.store.location: DEBUG: Registering scheme s3+https with {'store_class': <class 'glance.store.s3.Store'>, 'location_class': <class 'glance.store.s3.StoreLocation'>} glance.store: DEBUG: Attempting to import store glance.store.swift.Store glance.store.swift: ERROR: Could not find swift_store_auth_address in configuration options. glance.store.base: ERROR: Failed to configure store correctly. Disabling add method. glance.store: DEBUG: Registering store <class 'glance.store.swift.Store'> with schemes ('swift+https', 'swift', 'swift+http') glance.store.base: DEBUG: Late loading location class glance.store.swift.StoreLocation glance.store.location: DEBUG: Registering scheme swift+https with {'store_class': <class 'glance.store.swift.Store'>, 'location_class': <class 'glance.store.swift.StoreLocation'>} glance.store.location: DEBUG: Registering scheme swift+http with {'store_class': <class 'glance.store.swift.Store'>, 'location_class': <class 'glance.store.swift.StoreLocation'>} glance.store.location: DEBUG: Registering scheme swift with {'store_class': <class 'glance.store.swift.Store'>, 'location_class': <class 'glance.store.swift.StoreLocation'>} routes.middleware: DEBUG: Initialized with method overriding = True, and path info altering = True routes.middleware: DEBUG: Matched GET /images/detail routes.middleware: DEBUG: Route path: '/images/detail', defaults: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x62ce590>} routes.middleware: DEBUG: Match dict: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x62ce590>} glance.registry.api.v1.images: INFO: Returning detailed image list routes.middleware: DEBUG: Matched GET /images/detail routes.middleware: DEBUG: Route path: '/images/detail', defaults: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x62ce590>} routes.middleware: DEBUG: Match dict: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x62ce590>} iso8601.iso8601: DEBUG: Parsed 2013-10-20T06:11:11Z into {'tz_sign': None, 'second_fraction': None, 'hour': u'06', 'tz_hour': None, 'month': u'10', 'timezone': u'Z', 'second': u'11', 'tz_minute': None, 'year': u'2013', 'separator': u'T', 'day': u'20', 'minute': u'11'} with default timezone <iso8601.iso8601.Utc object at 0x23c3d50> iso8601.iso8601: DEBUG: Got u'2013' for 'year' with default None iso8601.iso8601: DEBUG: Got u'10' for 'month' with default None iso8601.iso8601: DEBUG: Got u'20' for 'day' with default None iso8601.iso8601: DEBUG: Got u'06' for 'hour' with default None iso8601.iso8601: DEBUG: Got u'11' for 'minute' with default None iso8601.iso8601: DEBUG: Got u'11' for 'second' with default None glance.registry.api.v1.images: INFO: Returning detailed image list routes.middleware: DEBUG: Matched GET /images/detail routes.middleware: DEBUG: Route path: '/images/detail', defaults: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x62ce590>} routes.middleware: DEBUG: Match dict: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x62ce590>} iso8601.iso8601: DEBUG: Parsed 2013-10-22T06:11:11Z into {'tz_sign': None, 'second_fraction': None, 'hour': u'06', 'tz_hour': None, 'month': u'10', 'timezone': u'Z', 'second': u'11', 'tz_minute': None, 'year': u'2013', 'separator': u'T', 'day': u'22', 'minute': u'11'} with default timezone <iso8601.iso8601.Utc object at 0x23c3d50> iso8601.iso8601: DEBUG: Got u'2013' for 'year' with default None iso8601.iso8601: DEBUG: Got u'10' for 'month' with default None iso8601.iso8601: DEBUG: Got u'22' for 'day' with default None iso8601.iso8601: DEBUG: Got u'06' for 'hour' with default None iso8601.iso8601: DEBUG: Got u'11' for 'minute' with default None iso8601.iso8601: DEBUG: Got u'11' for 'second' with default None glance.registry.api.v1.images: INFO: Returning detailed image list routes.middleware: DEBUG: Matched GET /images/detail routes.middleware: DEBUG: Route path: '/images/detail', defaults: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x62ce590>} routes.middleware: DEBUG: Match dict: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x62ce590>} iso8601.iso8601: DEBUG: Parsed 2013-10-23T06:11:11+01:00 into {'tz_sign': u'+', 'second_fraction': None, 'hour': u'06', 'tz_hour': u'01', 'month': u'10', 'timezone': u'+01:00', 'second': u'11', 'tz_minute': u'00', 'year': u'2013', 'separator': u'T', 'day': u'23', 'minute': u'11'} with default timezone <iso8601.iso8601.Utc object at 0x23c3d50> iso8601.iso8601: DEBUG: Got u'01' for 'tz_hour' with default None iso8601.iso8601: DEBUG: Got u'00' for 'tz_minute' with default None iso8601.iso8601: DEBUG: Got u'2013' for 'year' with default None iso8601.iso8601: DEBUG: Got u'10' for 'month' with default None iso8601.iso8601: DEBUG: Got u'23' for 'day' with default None iso8601.iso8601: DEBUG: Got u'06' for 'hour' with default None iso8601.iso8601: DEBUG: Got u'11' for 'minute' with default None iso8601.iso8601: DEBUG: Got u'11' for 'second' with default None glance.registry.api.v1.images: INFO: Returning detailed image list routes.middleware: DEBUG: Matched GET /images/detail routes.middleware: DEBUG: Route path: '/images/detail', defaults: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x62ce590>} routes.middleware: DEBUG: Match dict: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x62ce590>} iso8601.iso8601: DEBUG: Parsed 2013-10-23T06:11:11-01:00 into {'tz_sign': u'-', 'second_fraction': None, 'hour': u'06', 'tz_hour': u'01', 'month': u'10', 'timezone': u'-01:00', 'second': u'11', 'tz_minute': u'00', 'year': u'2013', 'separator': u'T', 'day': u'23', 'minute': u'11'} with default timezone <iso8601.iso8601.Utc object at 0x23c3d50> iso8601.iso8601: DEBUG: Got u'01' for 'tz_hour' with default None iso8601.iso8601: DEBUG: Got u'00' for 'tz_minute' with default None iso8601.iso8601: DEBUG: Got u'2013' for 'year' with default None iso8601.iso8601: DEBUG: Got u'10' for 'month' with default None iso8601.iso8601: DEBUG: Got u'23' for 'day' with default None iso8601.iso8601: DEBUG: Got u'06' for 'hour' with default None iso8601.iso8601: DEBUG: Got u'11' for 'minute' with default None iso8601.iso8601: DEBUG: Got u'11' for 'second' with default None glance.registry.api.v1.images: INFO: Returning detailed image list routes.middleware: DEBUG: Matched GET /images/detail routes.middleware: DEBUG: Route path: '/images/detail', defaults: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x62ce590>} routes.middleware: DEBUG: Match dict: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x62ce590>} iso8601.iso8601: DEBUG: Parsed 2013-10-24T06:11:11Z into {'tz_sign': None, 'second_fraction': None, 'hour': u'06', 'tz_hour': None, 'month': u'10', 'timezone': u'Z', 'second': u'11', 'tz_minute': None, 'year': u'2013', 'separator': u'T', 'day': u'24', 'minute': u'11'} with default timezone <iso8601.iso8601.Utc object at 0x23c3d50> iso8601.iso8601: DEBUG: Got u'2013' for 'year' with default None iso8601.iso8601: DEBUG: Got u'10' for 'month' with default None iso8601.iso8601: DEBUG: Got u'24' for 'day' with default None iso8601.iso8601: DEBUG: Got u'06' for 'hour' with default None iso8601.iso8601: DEBUG: Got u'11' for 'minute' with default None iso8601.iso8601: DEBUG: Got u'11' for 'second' with default None glance.registry.api.v1.images: INFO: Returning detailed image list routes.middleware: DEBUG: Matched GET /images/detail routes.middleware: DEBUG: Route path: '/images/detail', defaults: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x62ce590>} routes.middleware: DEBUG: Match dict: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x62ce590>} routes.middleware: DEBUG: Matched GET /images/detail routes.middleware: DEBUG: Route path: '/images/detail', defaults: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x62ce590>} routes.middleware: DEBUG: Match dict: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x62ce590>} iso8601.iso8601: DEBUG: Parsed 2011-09-05 into {'tz_sign': None, 'second_fraction': None, 'hour': None, 'tz_hour': None, 'month': u'09', 'timezone': None, 'second': None, 'tz_minute': None, 'year': u'2011', 'separator': None, 'day': u'05', 'minute': None} with default timezone <iso8601.iso8601.Utc object at 0x23c3d50> iso8601.iso8601: DEBUG: Got u'2011' for 'year' with default None iso8601.iso8601: DEBUG: Got u'09' for 'month' with default None iso8601.iso8601: DEBUG: Got u'05' for 'day' with default None iso8601.iso8601: DEBUG: Got None for 'hour' with default None iso8601.iso8601: DEBUG: Got None for 'minute' with default None iso8601.iso8601: DEBUG: Got None for 'second' with default None glance.registry.api.v1.images: INFO: Returning detailed image list --------------------- >> end captured logging << --------------------- ---------------------------------------------------------------------- XML: nosetests.xml Slowest 5 tests took 69.08 secs: [31m 14.99 TestGlanceControl.test_bouncing[0m [31m 14.22 TestScrubber.test_delayed_delete[0m [31m 13.78 TestGlanceControl.test_reload[0m [31m 13.58 TestGlanceControl.test_respawn[0m [31m 12.52 TestApi.test_unsupported_default_store[0m ---------------------------------------------------------------------- Ran 932 tests in 533.603s FAILED (SKIP=89, failures=2) ERROR: InvocationError: '<https://jenkins01.openstack.org/job/periodic-glance-python27-stable-folsom/…'> ___________________________________ summary ____________________________________ ERROR: py27: commands failed + result=1 + echo 'Begin pip freeze output from test virtualenv:' Begin pip freeze output from test virtualenv: + echo ====================================================================== ====================================================================== + .tox/py27/bin/pip freeze Babel==1.3 Jinja2==2.7.1 MarkupSafe==0.18 Paste==1.7.5.1 PasteDeploy==1.5.0 Pygments==1.6 Routes==1.13 SQLAlchemy==0.7.9 Sphinx==1.2b1 Tempita==0.5.1 WebOb==1.0.8 amqp==1.3.0 anyjson==0.3.3 argparse==1.2.1 boto==2.1.1 cffi==0.7.2 colorama==0.2.7 coverage==3.7 decorator==3.4.0 distribute==0.7.3 docutils==0.10 eventlet==0.14.0 glance==jenkins-periodic-glance-python27-stable-folsom-35 greenlet==0.4.1 httplib2==0.8 iso8601==0.1.7 jsonschema==2.2.0 kombu==3.0.0 lxml==3.2.3 mox==0.5.3 nose==1.3.0 nose-exclude==0.1.10 nosehtmloutput==0.0.5 openstack.nose-plugin==0.11 passlib==1.6.1 pep8==1.1 pycparser==2.10 pycrypto==2.6.1 pysendfile==2.0.0 python-swiftclient==1.8.0 pytz==2013.7 repoze.lru==0.6 requests==2.0.0 simplejson==3.3.1 sqlalchemy-migrate==0.7.2 termcolor==1.1.0 wsgiref==0.1.2 xattr==0.7.2 + echo ====================================================================== ====================================================================== + '[' -d .testrepository ']' + sudo /usr/local/jenkins/slave_scripts/jenkins-sudo-grep.sh post + sudoresult=0 + '[' 0 -ne 0 ']' + /usr/local/jenkins/slave_scripts/jenkins-oom-grep.sh post + oomresult=0 + '[' 0 -ne 0 ']' ++ find . -name nose_results.html + htmlreport=./nose_results.html + '[' -f ./nose_results.html ']' ++ grep -c 'tr class=.passClass' ./nose_results.html + passcount=95 + '[' 95 -eq 0 ']' + exit 1 + rm -rf /tmp/tmp.V4baQa85TX Build step 'Execute shell' marked build as failure [SCP] Connecting to static.openstack.org [SCP] uploading file: '/srv/static/logs/periodic/periodic-glance-python27-stable-folsom/35/nose_results.html' [SCP] Connecting to static.openstack.org [SCP] Trying to create /srv/static/logs/periodic/periodic-glance-python27-stable-folsom/precise3/35 [SCP] Copying console log.

1 11

Build failed in Jenkins: periodic-glance-python26-stable-folsom #41
by OpenStack Jenkins 13 Nov '13

13 Nov '13

See <https://jenkins01.openstack.org/job/periodic-glance-python26-stable-folsom/…> ------------------------------------------ [...truncated 1276 lines...] File "<https://jenkins01.openstack.org/job/periodic-glance-python26-stable-folsom/…",> line 63, in wrapped return func(self, *args, **kwargs) File "<https://jenkins01.openstack.org/job/periodic-glance-python26-stable-folsom/…",> line 444, in do_request headers=headers) File "<https://jenkins01.openstack.org/job/periodic-glance-python26-stable-folsom/…",> line 80, in wrapped return func(self, method, url, body, headers) File "<https://jenkins01.openstack.org/job/periodic-glance-python26-stable-folsom/…",> line 574, in _do_request raise exception.Invalid(res.read()) Invalid: 400 Bad Request The server could not comply with the request since it is either malformed or otherwise incorrect. Unrecognized changes-since value routes.middleware: DEBUG: Matched GET /images/detail routes.middleware: DEBUG: Route path: '/images/detail', defaults: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x4221a90>} routes.middleware: DEBUG: Match dict: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x4221a90>} glance.api.policy: DEBUG: Loaded policy rules: {u'default': []} glance.common.client: DEBUG: Constructed URL: http://0.0.0.0:9191/images/detail?changes-since=2011-09-05 routes.middleware: DEBUG: Initialized with method overriding = True, and path info altering = True routes.middleware: DEBUG: Matched GET /images/detail routes.middleware: DEBUG: Route path: '/images/detail', defaults: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x43b3250>} routes.middleware: DEBUG: Match dict: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x43b3250>} iso8601.iso8601: DEBUG: Parsed 2011-09-05 into {'tz_sign': None, 'second_fraction': None, 'hour': None, 'tz_hour': None, 'month': u'09', 'timezone': None, 'second': None, 'tz_minute': None, 'year': u'2011', 'separator': None, 'day': u'05', 'minute': None} with default timezone <iso8601.iso8601.Utc object at 0x1db96d0> iso8601.iso8601: DEBUG: Got u'2011' for 'year' with default None iso8601.iso8601: DEBUG: Got u'09' for 'month' with default None iso8601.iso8601: DEBUG: Got u'05' for 'day' with default None iso8601.iso8601: DEBUG: Got None for 'hour' with default None iso8601.iso8601: DEBUG: Got None for 'minute' with default None iso8601.iso8601: DEBUG: Got None for 'second' with default None glance.registry.api.v1.images: INFO: Returning detailed image list glance.registry.client: DEBUG: Registry request GET /images/detail HTTP 200 request id req-98f64849-ff31-4893-ac1e-f63822373ca9 --------------------- >> end captured logging << --------------------- ====================================================================== FAIL: Tests that the /images/detail registry API returns list of ---------------------------------------------------------------------- Traceback (most recent call last): File "<https://jenkins01.openstack.org/job/periodic-glance-python26-stable-folsom/…",> line 1409, in test_get_details_filter_changes_since self.assertEquals(res.status_int, 400) AssertionError: 200 != 400 >> raise self.failureException, \ (None or '%r != %r' % (200, 400)) -------------------- >> begin captured logging << -------------------- glance.store: DEBUG: Attempting to import store glance.store.filesystem.Store glance.store: DEBUG: Registering store <class 'glance.store.filesystem.Store'> with schemes ('file', 'filesystem') glance.store.base: DEBUG: Late loading location class glance.store.filesystem.StoreLocation glance.store.location: DEBUG: Registering scheme file with {'store_class': <class 'glance.store.filesystem.Store'>, 'location_class': <class 'glance.store.filesystem.StoreLocation'>} glance.store.location: DEBUG: Registering scheme filesystem with {'store_class': <class 'glance.store.filesystem.Store'>, 'location_class': <class 'glance.store.filesystem.StoreLocation'>} glance.store: DEBUG: Attempting to import store glance.store.http.Store glance.store: DEBUG: Registering store <class 'glance.store.http.Store'> with schemes ('http', 'https') glance.store.base: DEBUG: Late loading location class glance.store.http.StoreLocation glance.store.location: DEBUG: Registering scheme http with {'store_class': <class 'glance.store.http.Store'>, 'location_class': <class 'glance.store.http.StoreLocation'>} glance.store.location: DEBUG: Registering scheme https with {'store_class': <class 'glance.store.http.Store'>, 'location_class': <class 'glance.store.http.StoreLocation'>} glance.store: DEBUG: Attempting to import store glance.store.rbd.Store glance.store: DEBUG: Registering store <class 'glance.store.rbd.Store'> with schemes ('rbd',) glance.store.base: DEBUG: Late loading location class glance.store.rbd.StoreLocation glance.store.location: DEBUG: Registering scheme rbd with {'store_class': <class 'glance.store.rbd.Store'>, 'location_class': <class 'glance.store.rbd.StoreLocation'>} glance.store: DEBUG: Attempting to import store glance.store.s3.Store glance.store.s3: ERROR: Could not find s3_store_host in configuration options. glance.store.base: ERROR: Failed to configure store correctly. Disabling add method. glance.store: DEBUG: Registering store <class 'glance.store.s3.Store'> with schemes ('s3', 's3+http', 's3+https') glance.store.base: DEBUG: Late loading location class glance.store.s3.StoreLocation glance.store.location: DEBUG: Registering scheme s3 with {'store_class': <class 'glance.store.s3.Store'>, 'location_class': <class 'glance.store.s3.StoreLocation'>} glance.store.location: DEBUG: Registering scheme s3+http with {'store_class': <class 'glance.store.s3.Store'>, 'location_class': <class 'glance.store.s3.StoreLocation'>} glance.store.location: DEBUG: Registering scheme s3+https with {'store_class': <class 'glance.store.s3.Store'>, 'location_class': <class 'glance.store.s3.StoreLocation'>} glance.store: DEBUG: Attempting to import store glance.store.swift.Store glance.store.swift: ERROR: Could not find swift_store_auth_address in configuration options. glance.store.base: ERROR: Failed to configure store correctly. Disabling add method. glance.store: DEBUG: Registering store <class 'glance.store.swift.Store'> with schemes ('swift+https', 'swift', 'swift+http') glance.store.base: DEBUG: Late loading location class glance.store.swift.StoreLocation glance.store.location: DEBUG: Registering scheme swift+https with {'store_class': <class 'glance.store.swift.Store'>, 'location_class': <class 'glance.store.swift.StoreLocation'>} glance.store.location: DEBUG: Registering scheme swift+http with {'store_class': <class 'glance.store.swift.Store'>, 'location_class': <class 'glance.store.swift.StoreLocation'>} glance.store.location: DEBUG: Registering scheme swift with {'store_class': <class 'glance.store.swift.Store'>, 'location_class': <class 'glance.store.swift.StoreLocation'>} routes.middleware: DEBUG: Initialized with method overriding = True, and path info altering = True routes.middleware: DEBUG: Matched GET /images/detail routes.middleware: DEBUG: Route path: '/images/detail', defaults: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x5749210>} routes.middleware: DEBUG: Match dict: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x5749210>} glance.registry.api.v1.images: INFO: Returning detailed image list routes.middleware: DEBUG: Matched GET /images/detail routes.middleware: DEBUG: Route path: '/images/detail', defaults: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x5749210>} routes.middleware: DEBUG: Match dict: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x5749210>} iso8601.iso8601: DEBUG: Parsed 2013-10-20T06:10:59Z into {'tz_sign': None, 'second_fraction': None, 'hour': u'06', 'tz_hour': None, 'month': u'10', 'timezone': u'Z', 'second': u'59', 'tz_minute': None, 'year': u'2013', 'separator': u'T', 'day': u'20', 'minute': u'10'} with default timezone <iso8601.iso8601.Utc object at 0x1db96d0> iso8601.iso8601: DEBUG: Got u'2013' for 'year' with default None iso8601.iso8601: DEBUG: Got u'10' for 'month' with default None iso8601.iso8601: DEBUG: Got u'20' for 'day' with default None iso8601.iso8601: DEBUG: Got u'06' for 'hour' with default None iso8601.iso8601: DEBUG: Got u'10' for 'minute' with default None iso8601.iso8601: DEBUG: Got u'59' for 'second' with default None glance.registry.api.v1.images: INFO: Returning detailed image list routes.middleware: DEBUG: Matched GET /images/detail routes.middleware: DEBUG: Route path: '/images/detail', defaults: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x5749210>} routes.middleware: DEBUG: Match dict: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x5749210>} iso8601.iso8601: DEBUG: Parsed 2013-10-22T06:10:59Z into {'tz_sign': None, 'second_fraction': None, 'hour': u'06', 'tz_hour': None, 'month': u'10', 'timezone': u'Z', 'second': u'59', 'tz_minute': None, 'year': u'2013', 'separator': u'T', 'day': u'22', 'minute': u'10'} with default timezone <iso8601.iso8601.Utc object at 0x1db96d0> iso8601.iso8601: DEBUG: Got u'2013' for 'year' with default None iso8601.iso8601: DEBUG: Got u'10' for 'month' with default None iso8601.iso8601: DEBUG: Got u'22' for 'day' with default None iso8601.iso8601: DEBUG: Got u'06' for 'hour' with default None iso8601.iso8601: DEBUG: Got u'10' for 'minute' with default None iso8601.iso8601: DEBUG: Got u'59' for 'second' with default None glance.registry.api.v1.images: INFO: Returning detailed image list routes.middleware: DEBUG: Matched GET /images/detail routes.middleware: DEBUG: Route path: '/images/detail', defaults: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x5749210>} routes.middleware: DEBUG: Match dict: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x5749210>} iso8601.iso8601: DEBUG: Parsed 2013-10-23T06:10:59+01:00 into {'tz_sign': u'+', 'second_fraction': None, 'hour': u'06', 'tz_hour': u'01', 'month': u'10', 'timezone': u'+01:00', 'second': u'59', 'tz_minute': u'00', 'year': u'2013', 'separator': u'T', 'day': u'23', 'minute': u'10'} with default timezone <iso8601.iso8601.Utc object at 0x1db96d0> iso8601.iso8601: DEBUG: Got u'01' for 'tz_hour' with default None iso8601.iso8601: DEBUG: Got u'00' for 'tz_minute' with default None iso8601.iso8601: DEBUG: Got u'2013' for 'year' with default None iso8601.iso8601: DEBUG: Got u'10' for 'month' with default None iso8601.iso8601: DEBUG: Got u'23' for 'day' with default None iso8601.iso8601: DEBUG: Got u'06' for 'hour' with default None iso8601.iso8601: DEBUG: Got u'10' for 'minute' with default None iso8601.iso8601: DEBUG: Got u'59' for 'second' with default None glance.registry.api.v1.images: INFO: Returning detailed image list routes.middleware: DEBUG: Matched GET /images/detail routes.middleware: DEBUG: Route path: '/images/detail', defaults: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x5749210>} routes.middleware: DEBUG: Match dict: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x5749210>} iso8601.iso8601: DEBUG: Parsed 2013-10-23T06:10:59-01:00 into {'tz_sign': u'-', 'second_fraction': None, 'hour': u'06', 'tz_hour': u'01', 'month': u'10', 'timezone': u'-01:00', 'second': u'59', 'tz_minute': u'00', 'year': u'2013', 'separator': u'T', 'day': u'23', 'minute': u'10'} with default timezone <iso8601.iso8601.Utc object at 0x1db96d0> iso8601.iso8601: DEBUG: Got u'01' for 'tz_hour' with default None iso8601.iso8601: DEBUG: Got u'00' for 'tz_minute' with default None iso8601.iso8601: DEBUG: Got u'2013' for 'year' with default None iso8601.iso8601: DEBUG: Got u'10' for 'month' with default None iso8601.iso8601: DEBUG: Got u'23' for 'day' with default None iso8601.iso8601: DEBUG: Got u'06' for 'hour' with default None iso8601.iso8601: DEBUG: Got u'10' for 'minute' with default None iso8601.iso8601: DEBUG: Got u'59' for 'second' with default None glance.registry.api.v1.images: INFO: Returning detailed image list routes.middleware: DEBUG: Matched GET /images/detail routes.middleware: DEBUG: Route path: '/images/detail', defaults: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x5749210>} routes.middleware: DEBUG: Match dict: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x5749210>} iso8601.iso8601: DEBUG: Parsed 2013-10-24T06:10:59Z into {'tz_sign': None, 'second_fraction': None, 'hour': u'06', 'tz_hour': None, 'month': u'10', 'timezone': u'Z', 'second': u'59', 'tz_minute': None, 'year': u'2013', 'separator': u'T', 'day': u'24', 'minute': u'10'} with default timezone <iso8601.iso8601.Utc object at 0x1db96d0> iso8601.iso8601: DEBUG: Got u'2013' for 'year' with default None iso8601.iso8601: DEBUG: Got u'10' for 'month' with default None iso8601.iso8601: DEBUG: Got u'24' for 'day' with default None iso8601.iso8601: DEBUG: Got u'06' for 'hour' with default None iso8601.iso8601: DEBUG: Got u'10' for 'minute' with default None iso8601.iso8601: DEBUG: Got u'59' for 'second' with default None glance.registry.api.v1.images: INFO: Returning detailed image list routes.middleware: DEBUG: Matched GET /images/detail routes.middleware: DEBUG: Route path: '/images/detail', defaults: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x5749210>} routes.middleware: DEBUG: Match dict: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x5749210>} routes.middleware: DEBUG: Matched GET /images/detail routes.middleware: DEBUG: Route path: '/images/detail', defaults: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x5749210>} routes.middleware: DEBUG: Match dict: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x5749210>} iso8601.iso8601: DEBUG: Parsed 2011-09-05 into {'tz_sign': None, 'second_fraction': None, 'hour': None, 'tz_hour': None, 'month': u'09', 'timezone': None, 'second': None, 'tz_minute': None, 'year': u'2011', 'separator': None, 'day': u'05', 'minute': None} with default timezone <iso8601.iso8601.Utc object at 0x1db96d0> iso8601.iso8601: DEBUG: Got u'2011' for 'year' with default None iso8601.iso8601: DEBUG: Got u'09' for 'month' with default None iso8601.iso8601: DEBUG: Got u'05' for 'day' with default None iso8601.iso8601: DEBUG: Got None for 'hour' with default None iso8601.iso8601: DEBUG: Got None for 'minute' with default None iso8601.iso8601: DEBUG: Got None for 'second' with default None glance.registry.api.v1.images: INFO: Returning detailed image list --------------------- >> end captured logging << --------------------- ---------------------------------------------------------------------- XML: nosetests.xml Slowest 5 tests took 71.53 secs: [31m 14.82 TestScrubber.test_delayed_delete[0m [31m 14.72 TestGlanceControl.test_bouncing[0m [31m 14.18 TestGlanceControl.test_reload[0m [31m 14.02 TestGlanceControl.test_respawn[0m [31m 13.79 TestBinGlanceCacheManage.test_queue[0m ---------------------------------------------------------------------- Ran 932 tests in 604.338s FAILED (SKIP=89, failures=2) ERROR: InvocationError: '<https://jenkins01.openstack.org/job/periodic-glance-python26-stable-folsom/…'> ___________________________________ summary ____________________________________ ERROR: py26: commands failed + result=1 + echo 'Begin pip freeze output from test virtualenv:' Begin pip freeze output from test virtualenv: + echo ====================================================================== ====================================================================== + .tox/py26/bin/pip freeze Babel==1.3 Jinja2==2.7.1 MarkupSafe==0.18 Paste==1.7.5.1 PasteDeploy==1.5.0 Pygments==1.6 Routes==1.13 SQLAlchemy==0.7.9 Sphinx==1.2b1 Tempita==0.5.1 WebOb==1.0.8 amqp==1.3.0 anyjson==0.3.3 argparse==1.2.1 boto==2.1.1 cffi==0.7.2 colorama==0.2.7 coverage==3.7 decorator==3.4.0 distribute==0.7.3 docutils==0.10 eventlet==0.14.0 glance==jenkins-periodic-glance-python26-stable-folsom-41 greenlet==0.4.1 httplib2==0.8 importlib==1.0.2 iso8601==0.1.7 jsonschema==2.2.0 kombu==3.0.0 lxml==3.2.3 mox==0.5.3 nose==1.3.0 nose-exclude==0.1.10 nosehtmloutput==0.0.5 openstack.nose-plugin==0.11 ordereddict==1.1 passlib==1.6.1 pep8==1.1 pycparser==2.10 pycrypto==2.6.1 pysendfile==2.0.0 python-swiftclient==1.8.0 pytz==2013.7 repoze.lru==0.6 requests==2.0.0 simplejson==3.3.1 sqlalchemy-migrate==0.7.2 termcolor==1.1.0 wsgiref==0.1.2 xattr==0.7.2 + echo ====================================================================== ====================================================================== + '[' -d .testrepository ']' + sudo /usr/local/jenkins/slave_scripts/jenkins-sudo-grep.sh post + sudoresult=0 + '[' 0 -ne 0 ']' + /usr/local/jenkins/slave_scripts/jenkins-oom-grep.sh post + oomresult=0 + '[' 0 -ne 0 ']' ++ find . -name nose_results.html + htmlreport=./nose_results.html + '[' -f ./nose_results.html ']' ++ grep -c 'tr class=.passClass' ./nose_results.html + passcount=95 + '[' 95 -eq 0 ']' + exit 1 + rm -rf /tmp/tmp.fmKbIEhFk8 Build step 'Execute shell' marked build as failure [SCP] Connecting to static.openstack.org [SCP] Trying to create /srv/static/logs/periodic/periodic-glance-python26-stable-folsom/41 [SCP] uploading file: '/srv/static/logs/periodic/periodic-glance-python26-stable-folsom/41/nose_results.html' [SCP] Connecting to static.openstack.org [SCP] Trying to create /srv/static/logs/periodic/periodic-glance-python26-stable-folsom/centos6-11/41 [SCP] Copying console log.

1 16

Build failed in Jenkins: periodic-glance-python26-stable-folsom #31
by OpenStack Jenkins 11 Nov '13

11 Nov '13

See <https://jenkins02.openstack.org/job/periodic-glance-python26-stable-folsom/…> Changes: [zhiyanl] Adding 'download_image' policy enforcement to image cache middleware ------------------------------------------ [...truncated 954 lines...] test_add_already_existing [32mOK [0m[32m 0.01[0m test_add_host_variations [32mOK [0m[33m 0.03[0m test_calling_format_default [32mOK [0m[32m 0.01[0m test_calling_format_path [32mOK [0m[32m 0.01[0m test_calling_format_subdomain [32mOK [0m[32m 0.01[0m test_delete [32mOK [0m[32m 0.02[0m test_delete_non_existing [32mOK [0m[32m 0.01[0m test_get [32mOK [0m[32m 0.01[0m test_get_calling_format_default [32mOK [0m[32m 0.01[0m test_get_calling_format_path [32mOK [0m[32m 0.01[0m test_get_non_existing [32mOK [0m[32m 0.01[0m test_get_s3_bad_location [32mOK [0m[32m 0.01[0m test_get_s3_good_location [32mOK [0m[32m 0.01[0m test_no_access_key [32mOK [0m[32m 0.01[0m test_no_host [32mOK [0m[32m 0.01[0m test_no_secret_key [32mOK [0m[32m 0.01[0m TestBasicSchema test_filter_strips_extra_properties [32mOK [0m[32m 0.01[0m test_merge_conflicting_but_identical_properties [32mOK [0m[32m 0.01[0m test_merge_conflicting_properties [32mOK [0m[32m 0.01[0m test_merge_properties [32mOK [0m[32m 0.01[0m test_raw_json_schema [32mOK [0m[32m 0.01[0m test_validate_fails_on_bad_type [32mOK [0m[32m 0.01[0m test_validate_fails_on_extra_properties [32mOK [0m[32m 0.01[0m test_validate_passes [32mOK [0m[32m 0.01[0m TestBasicSchemaLinks test_raw_json_schema [32mOK [0m[32m 0.01[0m TestCollectionSchema test_raw_json_schema [32mOK [0m[32m 0.01[0m TestPermissiveSchema test_filter_passes_extra_properties [32mOK [0m[32m 0.01[0m test_raw_json_schema [32mOK [0m[32m 0.01[0m test_validate_rejects_non_string_extra_properties [32mOK [0m[32m 0.01[0m test_validate_with_additional_properties_allowed [32mOK [0m[32m 0.01[0m TestSkipExamples test_001_increase_test_counter [32mOK [0m[32m 0.01[0m test_002_increase_test_counter [32mOK [0m[32m 0.01[0m test_003_verify_test_counter [32mOK [0m[32m 0.01[0m test_skip_if_example [34mSKIP[0m test_skip_test_example [34mSKIP[0m test_skip_unless_example [34mSKIP[0m TestStoreLocation test_bad_store_scheme [32mOK [0m[32m 0.01[0m test_filesystem_store_location [32mOK [0m[32m 0.02[0m test_get_location_from_uri_back_to_uri [32mOK [0m[32m 0.01[0m test_get_store_from_scheme [32mOK [0m[32m 0.02[0m test_http_store_location [32mOK [0m[32m 0.01[0m test_rbd_store_location [32mOK [0m[32m 0.02[0m test_s3_store_location [32mOK [0m[32m 0.01[0m test_swift_store_location [32mOK [0m[32m 0.01[0m TestChunkReader test_read_all_data [32mOK [0m[32m 0.01[0m TestStoreAuthV1 test_add [32mOK [0m[32m 0.01[0m test_add_already_existing [32mOK [0m[32m 0.01[0m test_add_auth_url_variations [32mOK [0m[32m 0.02[0m test_add_large_object [32mOK [0m[32m 0.01[0m test_add_large_object_zero_size [32mOK [0m[32m 0.01[0m test_add_no_container_and_create [32mOK [0m[32m 0.01[0m test_add_no_container_no_create [32mOK [0m[32m 0.01[0m test_delete [32mOK [0m[32m 0.01[0m test_delete_non_existing [32mOK [0m[32m 0.01[0m test_get [32mOK [0m[32m 0.01[0m test_get_non_existing [32mOK [0m[32m 0.01[0m test_get_size [32mOK [0m[32m 0.01[0m test_get_with_http_auth [32mOK [0m[32m 0.01[0m test_no_auth_address [32mOK [0m[32m 0.01[0m test_no_key [32mOK [0m[32m 0.01[0m test_no_user [32mOK [0m[32m 0.01[0m test_read_acl_public [32mOK [0m[32m 0.01[0m test_read_acl_tenants [32mOK [0m[32m 0.01[0m test_read_write_public [32mOK [0m[32m 0.01[0m TestStoreAuthV2 test_add [32mOK [0m[32m 0.01[0m test_add_already_existing [32mOK [0m[32m 0.01[0m test_add_auth_url_variations [32mOK [0m[32m 0.02[0m test_add_large_object [32mOK [0m[32m 0.01[0m test_add_large_object_zero_size [32mOK [0m[32m 0.01[0m test_add_no_container_and_create [32mOK [0m[32m 0.01[0m test_add_no_container_no_create [32mOK [0m[32m 0.01[0m test_delete [32mOK [0m[31m 0.20[0m test_delete_non_existing [32mOK [0m[32m 0.01[0m test_get [32mOK [0m[32m 0.01[0m test_get_non_existing [32mOK [0m[32m 0.01[0m test_get_size [32mOK [0m[32m 0.01[0m test_get_with_http_auth [32mOK [0m[32m 0.01[0m test_no_auth_address [32mOK [0m[32m 0.01[0m test_no_key [32mOK [0m[32m 0.01[0m test_no_user [32mOK [0m[32m 0.01[0m test_read_acl_public [32mOK [0m[32m 0.01[0m test_read_acl_tenants [32mOK [0m[32m 0.01[0m test_read_write_public [32mOK [0m[32m 0.01[0m test_v2_multi_tenant_location [32mOK [0m[32m 0.01[0m test_v2_with_no_tenant [32mOK [0m[32m 0.01[0m TestUtils test_cooperative_reader [32mOK [0m[33m 0.05[0m test_cooperative_reader_of_iterator [32mOK [0m[32m 0.01[0m test_generate_uuid_format [32mOK [0m[32m 0.01[0m test_generate_uuid_unique [32mOK [0m[32m 0.01[0m test_is_uuid_like_fails [32mOK [0m[32m 0.01[0m test_is_uuid_like_success [32mOK [0m[32m 0.01[0m test_limiting_reader [32mOK [0m[32m 0.01[0m test_limiting_reader_fails [32mOK [0m[32m 0.01[0m VersionNegotiationTest test_request_accept_v1 [32mOK [0m[32m 0.01[0m test_request_url_v1 [32mOK [0m[32m 0.02[0m test_request_url_v1_0 [32mOK [0m[32m 0.01[0m test_request_url_v1_1 [32mOK [0m[32m 0.01[0m test_request_url_v2 [32mOK [0m[32m 0.01[0m test_request_url_v2_0 [32mOK [0m[32m 0.01[0m test_request_url_v2_1_unsupported [32mOK [0m[32m 0.01[0m test_request_url_v3_unsupported [32mOK [0m[32m 0.01[0m VersionsTest test_get_version_list [32mOK [0m[32m 0.01[0m JSONRequestDeserializerTest test_default_no_body [32mOK [0m[32m 0.01[0m test_default_with_body [32mOK [0m[32m 0.01[0m test_from_json [32mOK [0m[32m 0.01[0m test_from_json_malformed [32mOK [0m[32m 0.01[0m test_has_body_has_content_length [32mOK [0m[32m 0.01[0m test_has_body_no_content_length [32mOK [0m[32m 0.01[0m test_has_body_zero_content_length [32mOK [0m[32m 0.01[0m test_no_body_no_content_length [32mOK [0m[32m 0.01[0m JSONResponseSerializerTest test_default [32mOK [0m[32m 0.01[0m test_to_json [32mOK [0m[32m 0.01[0m RequestTest test_content_type_accept_default [32mOK [0m[32m 0.01[0m test_content_type_from_accept_json [32mOK [0m[32m 0.01[0m test_content_type_from_accept_json_xml_quality [32mOK [0m[32m 0.01[0m test_content_type_from_accept_xml [32mOK [0m[32m 0.01[0m test_content_type_from_accept_xml_json [32mOK [0m[32m 0.01[0m test_content_type_missing [32mOK [0m[32m 0.01[0m test_content_type_unsupported [32mOK [0m[32m 0.01[0m test_content_type_with_charset [32mOK [0m[32m 0.01[0m ResourceTest test_dispatch [32mOK [0m[32m 0.01[0m test_dispatch_default [32mOK [0m[32m 0.01[0m test_dispatch_no_default [32mOK [0m[32m 0.01[0m test_get_action_args [32mOK [0m[32m 0.01[0m TestHelpers test_data_passed_properly_through_headers [32mOK [0m[32m 0.01[0m test_headers_are_unicode [32mOK [0m[32m 0.01[0m ====================================================================== FAIL: Ensure an interrupt signal does not cause a respawn storm. ---------------------------------------------------------------------- Traceback (most recent call last): File "<https://jenkins02.openstack.org/job/periodic-glance-python26-stable-folsom/…",> line 71, in test_interrupt_avoids_respawn_storm self.assertTrue(child in children) AssertionError: """Fail the test unless the expression is true.""" >> if not False: raise self.failureException, None ---------------------------------------------------------------------- XML: nosetests.xml Slowest 5 tests took 71.47 secs: [31m 15.57 TestGlanceControl.test_bouncing[0m [31m 14.23 TestGlanceControl.test_reload[0m [31m 14.01 TestGlanceControl.test_respawn[0m [31m 13.87 TestBinGlanceCacheManage.test_queue[0m [31m 13.80 TestRootApi.test_version_configurations[0m ---------------------------------------------------------------------- Ran 932 tests in 602.486s FAILED (SKIP=89, failures=1) ERROR: InvocationError: '<https://jenkins02.openstack.org/job/periodic-glance-python26-stable-folsom/…'> ___________________________________ summary ____________________________________ ERROR: py26: commands failed + result=1 + echo 'Begin pip freeze output from test virtualenv:' Begin pip freeze output from test virtualenv: + echo ====================================================================== ====================================================================== + .tox/py26/bin/pip freeze Babel==1.3 Jinja2==2.7.1 MarkupSafe==0.18 Paste==1.7.5.1 PasteDeploy==1.5.0 Pygments==1.6 Routes==1.13 SQLAlchemy==0.7.9 Sphinx==1.2b1 Tempita==0.5.1 WebOb==1.0.8 amqp==1.0.13 anyjson==0.3.3 argparse==1.2.1 boto==2.1.1 cffi==0.7.2 colorama==0.2.7 coverage==3.7 decorator==3.4.0 distribute==0.7.3 docutils==0.10 eventlet==0.14.0 glance==jenkins-periodic-glance-python26-stable-folsom-31 greenlet==0.4.1 httplib2==0.8 importlib==1.0.2 iso8601==0.1.4 jsonschema==2.1.0 kombu==2.5.15 lxml==3.2.3 mox==0.5.3 nose==1.3.0 nose-exclude==0.1.10 nosehtmloutput==0.0.5 openstack.nose-plugin==0.11 ordereddict==1.1 passlib==1.6.1 pep8==1.1 pycparser==2.10 pycrypto==2.6 pysendfile==2.0.0 python-swiftclient==1.8.0 pytz==2013.7 repoze.lru==0.6 requests==2.0.0 simplejson==3.3.1 sqlalchemy-migrate==0.7.2 termcolor==1.1.0 wsgiref==0.1.2 xattr==0.7.2 + echo ====================================================================== ====================================================================== + '[' -d .testrepository ']' + sudo /usr/local/jenkins/slave_scripts/jenkins-sudo-grep.sh post + sudoresult=0 + '[' 0 -ne 0 ']' + /usr/local/jenkins/slave_scripts/jenkins-oom-grep.sh post + oomresult=0 + '[' 0 -ne 0 ']' ++ find . -name nose_results.html + htmlreport=./nose_results.html + '[' -f ./nose_results.html ']' ++ grep -c 'tr class=.passClass' ./nose_results.html + passcount=96 + '[' 96 -eq 0 ']' + exit 1 + rm -rf /tmp/tmp.zNu4dtb2PY Build step 'Execute shell' marked build as failure [SCP] Connecting to static.openstack.org [SCP] uploading file: '/srv/static/logs/periodic/periodic-glance-python26-stable-folsom/31/nose_results.html' [SCP] Connecting to static.openstack.org [SCP] Trying to create /srv/static/logs/periodic/periodic-glance-python26-stable-folsom/centos6-10/31 [SCP] Copying console log.

1 12

Build failed in Jenkins: periodic-glance-python27-stable-folsom #40
by OpenStack Jenkins 10 Nov '13

10 Nov '13

See <https://jenkins02.openstack.org/job/periodic-glance-python27-stable-folsom/…> ------------------------------------------ [...truncated 1304 lines...] File "<https://jenkins02.openstack.org/job/periodic-glance-python27-stable-folsom/…",> line 574, in _do_request raise exception.Invalid(res.read()) Invalid: 400 Bad Request The server could not comply with the request since it is either malformed or otherwise incorrect. Unrecognized changes-since value routes.middleware: DEBUG: Matched GET /images/detail routes.middleware: DEBUG: Route path: '/images/detail', defaults: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x541e950>} routes.middleware: DEBUG: Match dict: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x541e950>} glance.api.policy: DEBUG: Loaded policy rules: {u'default': []} glance.common.client: DEBUG: Constructed URL: http://0.0.0.0:9191/images/detail?changes-since=2011-09-05 routes.middleware: DEBUG: Initialized with method overriding = True, and path info altering = True routes.middleware: DEBUG: Matched GET /images/detail routes.middleware: DEBUG: Route path: '/images/detail', defaults: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x49ae850>} routes.middleware: DEBUG: Match dict: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x49ae850>} iso8601.iso8601: DEBUG: Parsed 2011-09-05 into {'tz_sign': None, 'second_fraction': None, 'hour': None, 'tz_hour': None, 'month': u'09', 'timezone': None, 'second': None, 'tz_minute': None, 'year': u'2011', 'separator': None, 'day': u'05', 'minute': None} with default timezone <iso8601.iso8601.Utc object at 0x28fdd50> iso8601.iso8601: DEBUG: Got None for 'second_fraction' with default None iso8601.iso8601: DEBUG: Got u'2011' for 'year' with default None iso8601.iso8601: DEBUG: Got u'09' for 'month' with default None iso8601.iso8601: DEBUG: Got u'05' for 'day' with default None iso8601.iso8601: DEBUG: Got None for 'hour' with default None iso8601.iso8601: DEBUG: Got None for 'minute' with default None iso8601.iso8601: DEBUG: Got None for 'second' with default None glance.registry.api.v1.images: INFO: Returning detailed image list glance.registry.client: DEBUG: Registry request GET /images/detail HTTP 200 request id req-14748b8b-c499-4b01-9f64-fb27aa397f81 --------------------- >> end captured logging << --------------------- ====================================================================== FAIL: Tests that the /images/detail registry API returns list of ---------------------------------------------------------------------- Traceback (most recent call last): File "<https://jenkins02.openstack.org/job/periodic-glance-python27-stable-folsom/…",> line 1409, in test_get_details_filter_changes_since self.assertEquals(res.status_int, 400) AssertionError: 200 != 400 '200 != 400' = '%s != %s' % (safe_repr(200), safe_repr(400)) '200 != 400' = self._formatMessage('200 != 400', '200 != 400') >> raise self.failureException('200 != 400') -------------------- >> begin captured logging << -------------------- glance.store: DEBUG: Attempting to import store glance.store.filesystem.Store glance.store: DEBUG: Registering store <class 'glance.store.filesystem.Store'> with schemes ('file', 'filesystem') glance.store.base: DEBUG: Late loading location class glance.store.filesystem.StoreLocation glance.store.location: DEBUG: Registering scheme file with {'store_class': <class 'glance.store.filesystem.Store'>, 'location_class': <class 'glance.store.filesystem.StoreLocation'>} glance.store.location: DEBUG: Registering scheme filesystem with {'store_class': <class 'glance.store.filesystem.Store'>, 'location_class': <class 'glance.store.filesystem.StoreLocation'>} glance.store: DEBUG: Attempting to import store glance.store.http.Store glance.store: DEBUG: Registering store <class 'glance.store.http.Store'> with schemes ('http', 'https') glance.store.base: DEBUG: Late loading location class glance.store.http.StoreLocation glance.store.location: DEBUG: Registering scheme http with {'store_class': <class 'glance.store.http.Store'>, 'location_class': <class 'glance.store.http.StoreLocation'>} glance.store.location: DEBUG: Registering scheme https with {'store_class': <class 'glance.store.http.Store'>, 'location_class': <class 'glance.store.http.StoreLocation'>} glance.store: DEBUG: Attempting to import store glance.store.rbd.Store glance.store: DEBUG: Registering store <class 'glance.store.rbd.Store'> with schemes ('rbd',) glance.store.base: DEBUG: Late loading location class glance.store.rbd.StoreLocation glance.store.location: DEBUG: Registering scheme rbd with {'store_class': <class 'glance.store.rbd.Store'>, 'location_class': <class 'glance.store.rbd.StoreLocation'>} glance.store: DEBUG: Attempting to import store glance.store.s3.Store glance.store.s3: ERROR: Could not find s3_store_host in configuration options. glance.store.base: ERROR: Failed to configure store correctly. Disabling add method. glance.store: DEBUG: Registering store <class 'glance.store.s3.Store'> with schemes ('s3', 's3+http', 's3+https') glance.store.base: DEBUG: Late loading location class glance.store.s3.StoreLocation glance.store.location: DEBUG: Registering scheme s3 with {'store_class': <class 'glance.store.s3.Store'>, 'location_class': <class 'glance.store.s3.StoreLocation'>} glance.store.location: DEBUG: Registering scheme s3+http with {'store_class': <class 'glance.store.s3.Store'>, 'location_class': <class 'glance.store.s3.StoreLocation'>} glance.store.location: DEBUG: Registering scheme s3+https with {'store_class': <class 'glance.store.s3.Store'>, 'location_class': <class 'glance.store.s3.StoreLocation'>} glance.store: DEBUG: Attempting to import store glance.store.swift.Store glance.store.swift: ERROR: Could not find swift_store_auth_address in configuration options. glance.store.base: ERROR: Failed to configure store correctly. Disabling add method. glance.store: DEBUG: Registering store <class 'glance.store.swift.Store'> with schemes ('swift+https', 'swift', 'swift+http') glance.store.base: DEBUG: Late loading location class glance.store.swift.StoreLocation glance.store.location: DEBUG: Registering scheme swift+https with {'store_class': <class 'glance.store.swift.Store'>, 'location_class': <class 'glance.store.swift.StoreLocation'>} glance.store.location: DEBUG: Registering scheme swift+http with {'store_class': <class 'glance.store.swift.Store'>, 'location_class': <class 'glance.store.swift.StoreLocation'>} glance.store.location: DEBUG: Registering scheme swift with {'store_class': <class 'glance.store.swift.Store'>, 'location_class': <class 'glance.store.swift.StoreLocation'>} routes.middleware: DEBUG: Initialized with method overriding = True, and path info altering = True routes.middleware: DEBUG: Matched GET /images/detail routes.middleware: DEBUG: Route path: '/images/detail', defaults: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x6552750>} routes.middleware: DEBUG: Match dict: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x6552750>} glance.registry.api.v1.images: INFO: Returning detailed image list routes.middleware: DEBUG: Matched GET /images/detail routes.middleware: DEBUG: Route path: '/images/detail', defaults: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x6552750>} routes.middleware: DEBUG: Match dict: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x6552750>} iso8601.iso8601: DEBUG: Parsed 2013-10-17T06:11:12Z into {'tz_sign': None, 'second_fraction': None, 'hour': u'06', 'tz_hour': None, 'month': u'10', 'timezone': u'Z', 'second': u'12', 'tz_minute': None, 'year': u'2013', 'separator': u'T', 'day': u'17', 'minute': u'11'} with default timezone <iso8601.iso8601.Utc object at 0x28fdd50> iso8601.iso8601: DEBUG: Got None for 'second_fraction' with default None iso8601.iso8601: DEBUG: Got u'2013' for 'year' with default None iso8601.iso8601: DEBUG: Got u'10' for 'month' with default None iso8601.iso8601: DEBUG: Got u'17' for 'day' with default None iso8601.iso8601: DEBUG: Got u'06' for 'hour' with default None iso8601.iso8601: DEBUG: Got u'11' for 'minute' with default None iso8601.iso8601: DEBUG: Got u'12' for 'second' with default None glance.registry.api.v1.images: INFO: Returning detailed image list routes.middleware: DEBUG: Matched GET /images/detail routes.middleware: DEBUG: Route path: '/images/detail', defaults: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x6552750>} routes.middleware: DEBUG: Match dict: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x6552750>} iso8601.iso8601: DEBUG: Parsed 2013-10-19T06:11:12Z into {'tz_sign': None, 'second_fraction': None, 'hour': u'06', 'tz_hour': None, 'month': u'10', 'timezone': u'Z', 'second': u'12', 'tz_minute': None, 'year': u'2013', 'separator': u'T', 'day': u'19', 'minute': u'11'} with default timezone <iso8601.iso8601.Utc object at 0x28fdd50> iso8601.iso8601: DEBUG: Got None for 'second_fraction' with default None iso8601.iso8601: DEBUG: Got u'2013' for 'year' with default None iso8601.iso8601: DEBUG: Got u'10' for 'month' with default None iso8601.iso8601: DEBUG: Got u'19' for 'day' with default None iso8601.iso8601: DEBUG: Got u'06' for 'hour' with default None iso8601.iso8601: DEBUG: Got u'11' for 'minute' with default None iso8601.iso8601: DEBUG: Got u'12' for 'second' with default None glance.registry.api.v1.images: INFO: Returning detailed image list routes.middleware: DEBUG: Matched GET /images/detail routes.middleware: DEBUG: Route path: '/images/detail', defaults: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x6552750>} routes.middleware: DEBUG: Match dict: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x6552750>} iso8601.iso8601: DEBUG: Parsed 2013-10-20T06:11:12+01:00 into {'tz_sign': u'+', 'second_fraction': None, 'hour': u'06', 'tz_hour': u'01', 'month': u'10', 'timezone': u'+01:00', 'second': u'12', 'tz_minute': u'00', 'year': u'2013', 'separator': u'T', 'day': u'20', 'minute': u'11'} with default timezone <iso8601.iso8601.Utc object at 0x28fdd50> iso8601.iso8601: DEBUG: Got u'01' for 'tz_hour' with default None iso8601.iso8601: DEBUG: Got u'00' for 'tz_minute' with default None iso8601.iso8601: DEBUG: Got None for 'second_fraction' with default None iso8601.iso8601: DEBUG: Got u'2013' for 'year' with default None iso8601.iso8601: DEBUG: Got u'10' for 'month' with default None iso8601.iso8601: DEBUG: Got u'20' for 'day' with default None iso8601.iso8601: DEBUG: Got u'06' for 'hour' with default None iso8601.iso8601: DEBUG: Got u'11' for 'minute' with default None iso8601.iso8601: DEBUG: Got u'12' for 'second' with default None glance.registry.api.v1.images: INFO: Returning detailed image list routes.middleware: DEBUG: Matched GET /images/detail routes.middleware: DEBUG: Route path: '/images/detail', defaults: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x6552750>} routes.middleware: DEBUG: Match dict: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x6552750>} iso8601.iso8601: DEBUG: Parsed 2013-10-20T06:11:12-01:00 into {'tz_sign': u'-', 'second_fraction': None, 'hour': u'06', 'tz_hour': u'01', 'month': u'10', 'timezone': u'-01:00', 'second': u'12', 'tz_minute': u'00', 'year': u'2013', 'separator': u'T', 'day': u'20', 'minute': u'11'} with default timezone <iso8601.iso8601.Utc object at 0x28fdd50> iso8601.iso8601: DEBUG: Got u'01' for 'tz_hour' with default None iso8601.iso8601: DEBUG: Got u'00' for 'tz_minute' with default None iso8601.iso8601: DEBUG: Got None for 'second_fraction' with default None iso8601.iso8601: DEBUG: Got u'2013' for 'year' with default None iso8601.iso8601: DEBUG: Got u'10' for 'month' with default None iso8601.iso8601: DEBUG: Got u'20' for 'day' with default None iso8601.iso8601: DEBUG: Got u'06' for 'hour' with default None iso8601.iso8601: DEBUG: Got u'11' for 'minute' with default None iso8601.iso8601: DEBUG: Got u'12' for 'second' with default None glance.registry.api.v1.images: INFO: Returning detailed image list routes.middleware: DEBUG: Matched GET /images/detail routes.middleware: DEBUG: Route path: '/images/detail', defaults: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x6552750>} routes.middleware: DEBUG: Match dict: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x6552750>} iso8601.iso8601: DEBUG: Parsed 2013-10-21T06:11:12Z into {'tz_sign': None, 'second_fraction': None, 'hour': u'06', 'tz_hour': None, 'month': u'10', 'timezone': u'Z', 'second': u'12', 'tz_minute': None, 'year': u'2013', 'separator': u'T', 'day': u'21', 'minute': u'11'} with default timezone <iso8601.iso8601.Utc object at 0x28fdd50> iso8601.iso8601: DEBUG: Got None for 'second_fraction' with default None iso8601.iso8601: DEBUG: Got u'2013' for 'year' with default None iso8601.iso8601: DEBUG: Got u'10' for 'month' with default None iso8601.iso8601: DEBUG: Got u'21' for 'day' with default None iso8601.iso8601: DEBUG: Got u'06' for 'hour' with default None iso8601.iso8601: DEBUG: Got u'11' for 'minute' with default None iso8601.iso8601: DEBUG: Got u'12' for 'second' with default None glance.registry.api.v1.images: INFO: Returning detailed image list routes.middleware: DEBUG: Matched GET /images/detail routes.middleware: DEBUG: Route path: '/images/detail', defaults: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x6552750>} routes.middleware: DEBUG: Match dict: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x6552750>} routes.middleware: DEBUG: Matched GET /images/detail routes.middleware: DEBUG: Route path: '/images/detail', defaults: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x6552750>} routes.middleware: DEBUG: Match dict: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x6552750>} iso8601.iso8601: DEBUG: Parsed 2011-09-05 into {'tz_sign': None, 'second_fraction': None, 'hour': None, 'tz_hour': None, 'month': u'09', 'timezone': None, 'second': None, 'tz_minute': None, 'year': u'2011', 'separator': None, 'day': u'05', 'minute': None} with default timezone <iso8601.iso8601.Utc object at 0x28fdd50> iso8601.iso8601: DEBUG: Got None for 'second_fraction' with default None iso8601.iso8601: DEBUG: Got u'2011' for 'year' with default None iso8601.iso8601: DEBUG: Got u'09' for 'month' with default None iso8601.iso8601: DEBUG: Got u'05' for 'day' with default None iso8601.iso8601: DEBUG: Got None for 'hour' with default None iso8601.iso8601: DEBUG: Got None for 'minute' with default None iso8601.iso8601: DEBUG: Got None for 'second' with default None glance.registry.api.v1.images: INFO: Returning detailed image list --------------------- >> end captured logging << --------------------- ---------------------------------------------------------------------- XML: nosetests.xml Slowest 5 tests took 68.21 secs: [31m 14.29 TestGlanceControl.test_bouncing[0m [31m 14.14 TestScrubber.test_delayed_delete[0m [31m 13.76 TestGlanceControl.test_reload[0m [31m 13.52 TestGlanceControl.test_respawn[0m [31m 12.50 TestApi.test_unsupported_default_store[0m ---------------------------------------------------------------------- Ran 932 tests in 527.639s FAILED (SKIP=89, errors=1, failures=2) ERROR: InvocationError: '<https://jenkins02.openstack.org/job/periodic-glance-python27-stable-folsom/…'> ___________________________________ summary ____________________________________ ERROR: py27: commands failed + result=1 + echo 'Begin pip freeze output from test virtualenv:' Begin pip freeze output from test virtualenv: + echo ====================================================================== ====================================================================== + .tox/py27/bin/pip freeze Babel==1.3 Jinja2==2.7.1 MarkupSafe==0.18 Paste==1.7.5.1 PasteDeploy==1.5.0 Pygments==1.6 Routes==1.13 SQLAlchemy==0.7.9 Sphinx==1.2b1 Tempita==0.5.1 WebOb==1.0.8 amqp==1.3.0 anyjson==0.3.3 argparse==1.2.1 boto==2.1.1 cffi==0.7.2 colorama==0.2.7 coverage==3.7 decorator==3.4.0 distribute==0.7.3 docutils==0.10 eventlet==0.14.0 glance==jenkins-periodic-glance-python27-stable-folsom-40 greenlet==0.4.1 httplib2==0.8 iso8601==0.1.5 jsonschema==2.1.0 kombu==3.0.0 lxml==3.2.3 mox==0.5.3 nose==1.3.0 nose-exclude==0.1.10 nosehtmloutput==0.0.5 openstack.nose-plugin==0.11 passlib==1.6.1 pep8==1.1 pycparser==2.10 pycrypto==2.6.1 pysendfile==2.0.0 python-swiftclient==1.8.0 pytz==2013.7 repoze.lru==0.6 requests==2.0.0 simplejson==3.3.1 sqlalchemy-migrate==0.7.2 termcolor==1.1.0 wsgiref==0.1.2 xattr==0.7.2 + echo ====================================================================== ====================================================================== + '[' -d .testrepository ']' + sudo /usr/local/jenkins/slave_scripts/jenkins-sudo-grep.sh post + sudoresult=0 + '[' 0 -ne 0 ']' + /usr/local/jenkins/slave_scripts/jenkins-oom-grep.sh post + oomresult=0 + '[' 0 -ne 0 ']' ++ find . -name nose_results.html + htmlreport=./nose_results.html + '[' -f ./nose_results.html ']' ++ grep -c 'tr class=.passClass' ./nose_results.html + passcount=94 + '[' 94 -eq 0 ']' + exit 1 + rm -rf /tmp/tmp.1w2nV2oVkP Build step 'Execute shell' marked build as failure [SCP] Connecting to static.openstack.org [SCP] Trying to create /srv/static/logs/periodic/periodic-glance-python27-stable-folsom/40 [SCP] uploading file: '/srv/static/logs/periodic/periodic-glance-python27-stable-folsom/40/nose_results.html' [SCP] Connecting to static.openstack.org [SCP] Trying to create /srv/static/logs/periodic/periodic-glance-python27-stable-folsom/precise4/40 [SCP] Copying console log.

1 15

Build failed in Jenkins: periodic-heat-python27-stable-grizzly #37
by OpenStack Jenkins 03 Nov '13

03 Nov '13

See <https://jenkins01.openstack.org/job/periodic-heat-python27-stable-grizzly/3…> ------------------------------------------ [...truncated 638 lines...] test_update_template_diff_properties_notallowed (heat.tests.test_resource.ResourceTest) ... ok test_update_template_diff_properties_removed (heat.tests.test_resource.ResourceTest) ... ok test_updated_time (heat.tests.test_resource.ResourceTest) ... ok test_create_stack (heat.tests.test_rpc_client.EngineRpcAPITestCase) ... ok test_create_watch_data (heat.tests.test_rpc_client.EngineRpcAPITestCase) ... ok test_delete_stack_call (heat.tests.test_rpc_client.EngineRpcAPITestCase) ... ok test_delete_stack_cast (heat.tests.test_rpc_client.EngineRpcAPITestCase) ... ok test_describe_stack_resource (heat.tests.test_rpc_client.EngineRpcAPITestCase) ... ok test_describe_stack_resources (heat.tests.test_rpc_client.EngineRpcAPITestCase) ... ok test_find_physical_resource (heat.tests.test_rpc_client.EngineRpcAPITestCase) ... ok test_get_template (heat.tests.test_rpc_client.EngineRpcAPITestCase) ... ok test_list_events (heat.tests.test_rpc_client.EngineRpcAPITestCase) ... ok test_list_stack_resources (heat.tests.test_rpc_client.EngineRpcAPITestCase) ... ok test_metadata_update (heat.tests.test_rpc_client.EngineRpcAPITestCase) ... ok test_set_watch_state (heat.tests.test_rpc_client.EngineRpcAPITestCase) ... ok test_show_stack (heat.tests.test_rpc_client.EngineRpcAPITestCase) ... ok test_show_watch (heat.tests.test_rpc_client.EngineRpcAPITestCase) ... ok test_show_watch_metric (heat.tests.test_rpc_client.EngineRpcAPITestCase) ... ok test_update_stack (heat.tests.test_rpc_client.EngineRpcAPITestCase) ... ok test_validate_template (heat.tests.test_rpc_client.EngineRpcAPITestCase) ... ok test_attributes (heat.tests.test_s3.s3Test) ... ok test_authenticated_read (heat.tests.test_s3.s3Test) ... ok test_create_container_name (heat.tests.test_s3.s3Test) ... ok test_delete_exception (heat.tests.test_s3.s3Test) ... ok test_delete_retain (heat.tests.test_s3.s3Test) ... ok test_public_read (heat.tests.test_s3.s3Test) ... ok test_public_read_write (heat.tests.test_s3.s3Test) ... ok test_website (heat.tests.test_s3.s3Test) ... ok test_security_group_nova (heat.tests.test_security_group.SecurityGroupTest) ... ok test_security_group_nova_exception (heat.tests.test_security_group.SecurityGroupTest) ... ok test_byte_string_12 (heat.tests.test_short_id.ShortIdTest) ... ok test_byte_string_16 (heat.tests.test_short_id.ShortIdTest) ... ok test_byte_string_60 (heat.tests.test_short_id.ShortIdTest) ... ok test_byte_string_8 (heat.tests.test_short_id.ShortIdTest) ... ok test_generate_ids (heat.tests.test_short_id.ShortIdTest) ... ok test_get_id_string (heat.tests.test_short_id.ShortIdTest) ... ok test_get_id_uuid1 (heat.tests.test_short_id.ShortIdTest) ... ok test_get_id_uuid_0 (heat.tests.test_short_id.ShortIdTest) ... ok test_get_id_uuid_1 (heat.tests.test_short_id.ShortIdTest) ... ok test_get_id_uuid_endianness (heat.tests.test_short_id.ShortIdTest) ... ok test_get_id_uuid_f (heat.tests.test_short_id.ShortIdTest) ... ok test_user_creds_none (heat.tests.test_sqlalchemy_api.SqlAlchemyTest) ... ok test_user_creds_password (heat.tests.test_sqlalchemy_api.SqlAlchemyTest) ... ok test_attributes (heat.tests.test_swift.swiftTest) ... ok test_build_meta_headers (heat.tests.test_swift.swiftTest) ... ok test_create_container_name (heat.tests.test_swift.swiftTest) ... ok test_delete_exception (heat.tests.test_swift.swiftTest) ... ok test_delete_retain (heat.tests.test_swift.swiftTest) ... ok test_public_read (heat.tests.test_swift.swiftTest) ... ok test_public_read_write (heat.tests.test_swift.swiftTest) ... ok test_website (heat.tests.test_swift.swiftTest) ... ok test_convert_all_templates (heat.tests.test_template_format.JsonToYamlTest) ... ok test_quantum_resolved (heat.tests.test_template_format.JsonYamlResolvedCompareTest) ... ok test_wordpress_resolved (heat.tests.test_template_format.JsonYamlResolvedCompareTest) ... ok test_minimal_yaml (heat.tests.test_template_format.YamlMinimalTest) ... ok test_file_scheme (heat.tests.test_urlfetch.UrlFetchTest) ... ok test_garbage (heat.tests.test_urlfetch.UrlFetchTest) ... ok test_http_error (heat.tests.test_urlfetch.UrlFetchTest) ... ok test_http_scheme (heat.tests.test_urlfetch.UrlFetchTest) ... ok test_https_scheme (heat.tests.test_urlfetch.UrlFetchTest) ... ok test_access_key (heat.tests.test_user.AccessKeyTest) ... ok test_access_key_no_user (heat.tests.test_user.AccessKeyTest) ... ok test_accesspolicy_access_allowed (heat.tests.test_user.AccessPolicyTest) ... ok test_accesspolicy_create_err_notfound (heat.tests.test_user.AccessPolicyTest) ... ok test_accesspolicy_create_ok (heat.tests.test_user.AccessPolicyTest) ... ok test_accesspolicy_create_ok_empty (heat.tests.test_user.AccessPolicyTest) ... ok test_accesspolicy_update (heat.tests.test_user.AccessPolicyTest) ... ok test_user (heat.tests.test_user.UserTest) ... ok test_user_access_allowed (heat.tests.test_user.UserTest) ... ok test_user_access_allowed_ignorepolicy (heat.tests.test_user.UserTest) ... ok test_user_create_bad_policies (heat.tests.test_user.UserTest) ... ok test_user_validate_policies (heat.tests.test_user.UserTest) ... ok test_validate_findinmap_invalid (heat.tests.test_validate.validateTest) ... ok test_validate_findinmap_valid (heat.tests.test_validate.validateTest) ... ok test_validate_ref_invalid (heat.tests.test_validate.validateTest) ... ok test_validate_ref_valid (heat.tests.test_validate.validateTest) ... ok test_validate_volumeattach_invalid (heat.tests.test_validate.validateTest) ... ok test_validate_volumeattach_valid (heat.tests.test_validate.validateTest) ... ok test_volume (heat.tests.test_volume.VolumeTest) ... ok test_volume_attachment (heat.tests.test_volume.VolumeTest) ... ok test_volume_attachment_error (heat.tests.test_volume.VolumeTest) ... ok test_volume_create_error (heat.tests.test_volume.VolumeTest) ... ok test_internet_gateway (heat.tests.test_vpc.InternetGatewayTest) ... ok test_network_interface (heat.tests.test_vpc.NetworkInterfaceTest) ... ok test_route_table (heat.tests.test_vpc.RouteTableTest) ... ok test_subnet (heat.tests.test_vpc.SubnetTest) ... ok test_vpc (heat.tests.test_vpc.VPCTest) ... ok test_get_status (heat.tests.test_waitcondition.WaitConditionHandleTest) ... ok test_get_status_reason (heat.tests.test_waitcondition.WaitConditionHandleTest) ... ok test_handle (heat.tests.test_waitcondition.WaitConditionHandleTest) ... ok test_metadata_update (heat.tests.test_waitcondition.WaitConditionHandleTest) ... ok test_metadata_update_invalid (heat.tests.test_waitcondition.WaitConditionHandleTest) ... ok test_FnGetAtt (heat.tests.test_waitcondition.WaitConditionTest) ... ok test_post_failure_to_handle (heat.tests.test_waitcondition.WaitConditionTest) ... ok test_post_failure_to_handle_count (heat.tests.test_waitcondition.WaitConditionTest) ... ok test_post_success_to_handle (heat.tests.test_waitcondition.WaitConditionTest) ... ok test_post_success_to_handle_count (heat.tests.test_waitcondition.WaitConditionTest) ... ok test_timeout (heat.tests.test_waitcondition.WaitConditionTest) ... ok test_validate_handle_url_bad_resource (heat.tests.test_waitcondition.WaitConditionTest) ... ok test_validate_handle_url_bad_resource_type (heat.tests.test_waitcondition.WaitConditionTest) ... ok test_validate_handle_url_bad_stackid (heat.tests.test_waitcondition.WaitConditionTest) ... ok test_validate_handle_url_bad_stackname (heat.tests.test_waitcondition.WaitConditionTest) ... ok test_validate_handle_url_bad_tenant (heat.tests.test_waitcondition.WaitConditionTest) ... ok test_ave (heat.tests.test_watch.WatchRuleTest) ... ok test_create_watch_data (heat.tests.test_watch.WatchRuleTest) ... ok test_evaluate (heat.tests.test_watch.WatchRuleTest) ... ok test_load (heat.tests.test_watch.WatchRuleTest) ... ok test_maximum (heat.tests.test_watch.WatchRuleTest) ... ok test_minimum (heat.tests.test_watch.WatchRuleTest) ... ok test_rule_actions_alarm_alarm (heat.tests.test_watch.WatchRuleTest) ... ok test_rule_actions_alarm_normal (heat.tests.test_watch.WatchRuleTest) ... ok test_rule_actions_alarm_two_actions (heat.tests.test_watch.WatchRuleTest) ... ok test_rule_actions_nodata (heat.tests.test_watch.WatchRuleTest) ... ok test_rule_actions_ok_alarm (heat.tests.test_watch.WatchRuleTest) ... ok test_samplecount (heat.tests.test_watch.WatchRuleTest) ... ok test_set_watch_state (heat.tests.test_watch.WatchRuleTest) ... ok test_set_watch_state_invalid (heat.tests.test_watch.WatchRuleTest) ... ok test_store (heat.tests.test_watch.WatchRuleTest) ... ok test_sum (heat.tests.test_watch.WatchRuleTest) ... ok ====================================================================== FAIL: test_FnGetAtt (heat.tests.test_metadata_refresh.MetadataRefreshTest) ---------------------------------------------------------------------- Traceback (most recent call last): File "<https://jenkins01.openstack.org/job/periodic-heat-python27-stable-grizzly/w…",> line 75, in wrapped_test test_fn(test_cls) File "<https://jenkins01.openstack.org/job/periodic-heat-python27-stable-grizzly/w…",> line 178, in test_FnGetAtt self.assertEqual(cont, 's2-ip=1.2.3.5') AssertionError: u's2-ip=' != 's2-ip=1.2.3.5' -------------------- >> begin captured stdout << --------------------- Running test test_FnGetAtt --------------------- >> end captured stdout << ---------------------- "u's2-ip=' != 's2-ip=1.2.3.5'" = '%s != %s' % (safe_repr(u's2-ip='), safe_repr('s2-ip=1.2.3.5')) "u's2-ip=' != 's2-ip=1.2.3.5'" = self._formatMessage("u's2-ip=' != 's2-ip=1.2.3.5'", "u's2-ip=' != 's2-ip=1.2.3.5'") >> raise self.failureException("u's2-ip=' != 's2-ip=1.2.3.5'") -------------------- >> begin captured logging << -------------------- heat.engine.resource: INFO: creating Instance "S1" heat.engine.resource: INFO: creating Instance "S2" heat.engine.resource: INFO: deleting Instance "S1" (inst:None db_id:15) heat.engine.resource: INFO: deleting Instance "S2" (inst:None db_id:16) --------------------- >> end captured logging << --------------------- ---------------------------------------------------------------------- XML: nosetests.xml ---------------------------------------------------------------------- Ran 698 tests in 13.890s FAILED (failures=1) ERROR: InvocationError: '<https://jenkins01.openstack.org/job/periodic-heat-python27-stable-grizzly/w…> -a tag=unit' ___________________________________ summary ____________________________________ ERROR: py27: commands failed + result=1 + echo 'Begin pip freeze output from test virtualenv:' Begin pip freeze output from test virtualenv: + echo ====================================================================== ====================================================================== + .tox/py27/bin/pip freeze Babel==1.3 Jinja2==2.7.1 MarkupSafe==0.18 PasteDeploy==1.5.0 PyYAML==3.10 Pygments==1.6 Routes==1.12.3 SQLAlchemy==0.7.10 Sphinx==1.2b1 Tempita==0.5.1 WebOb==1.2.3 amqp==1.3.2 anyjson==0.3.3 argparse==1.2.1 boto==2.15.0 cliff==1.4.5 cmd2==0.6.7 colorama==0.2.7 coverage==3.7 decorator==3.4.0 distribute==0.7.3 docutils==0.10 ecdsa==0.10 eventlet==0.14.0 greenlet==0.4.1 heat==jenkins.periodic.heat.python27.stable.grizzly.37 httplib2==0.8 iso8601==0.1.8 jsonpatch==1.3 jsonpointer==1.1 jsonschema==2.2.0 kombu==3.0.2 lxml==2.3.5 mox==0.5.3 netaddr==0.7.10 nose==1.3.0 nosexcover==1.0.8 openstack.nose-plugin==0.11 oslo.config==1.2.1 paramiko==1.12.0 pbr==0.5.23 pep8==1.3.4 prettytable==0.7.2 pyOpenSSL==0.13.1 pycrypto==2.6.1 pyflakes==0.7.3 pyparsing==2.0.1 python-cinderclient==1.0.6 python-glanceclient==0.11.0 python-keystoneclient==0.4.1 python-memcached==1.53 python-neutronclient==2.3.1 python-novaclient==2.15.0 python-quantumclient==2.2.4.3 python-swiftclient==1.8.0 pytz==2013.7 requests==2.0.1 simplejson==3.3.1 six==1.4.1 sqlalchemy-migrate==0.7.2 termcolor==1.1.0 warlock==1.0.1 wsgiref==0.1.2 + echo ====================================================================== ====================================================================== + '[' -d .testrepository ']' + sudo /usr/local/jenkins/slave_scripts/jenkins-sudo-grep.sh post + sudoresult=0 + '[' 0 -ne 0 ']' + /usr/local/jenkins/slave_scripts/jenkins-oom-grep.sh post + oomresult=0 + '[' 0 -ne 0 ']' ++ find . -name nose_results.html + htmlreport= + '[' -f '' ']' + echo + echo 'WARNING: Unable to find to confirm results!' WARNING: Unable to find to confirm results! + echo + exit 1 + rm -rf /tmp/tmp.zcdirjyD6Y Build step 'Execute shell' marked build as failure [SCP] Connecting to static.openstack.org [SCP] No file(s) found: **/*nose_results.html [SCP] '**/*nose_results.html' doesn't match anything: '**' exists but not '**/*nose_results.html' [SCP] Connecting to static.openstack.org [SCP] Trying to create /srv/static/logs/periodic/periodic-heat-python27-stable-grizzly/precise5/37 [SCP] Copying console log.

1 1

Build failed in Jenkins: periodic-tempest-devstack-vm-stable-grizzly #43
by OpenStack Jenkins 02 Nov '13

02 Nov '13

See <https://jenkins01.openstack.org/job/periodic-tempest-devstack-vm-stable-gri…> ------------------------------------------ [...truncated 15132 lines...] 2013-10-30 06:06:03,673 string_to_sign: POST 127.0.0.1:8773 /services/Cloud/ AWSAccessKeyId=e0938fb037574111b9c384dbc896b130&Action=RunInstances&ImageId=ami-00000001&InstanceType=m1.nano&KernelId=aki-00000003&KeyName=keypair-115425&MaxCount=1&MinCount=1&RamdiskId=ari-00000002&SecurityGroup.1=securitygroup-813653&SignatureMethod=HmacSHA256&SignatureVersion=2&Timestamp=2013-10-30T06%3A06%3A03Z&Version=2011-12-15 2013-10-30 06:06:03,673 len(b64)=44 2013-10-30 06:06:03,673 base64 encoded digest: IobEzDBdG0gUyV3/ym0oUzhmOie8p2mMFbBnjC+1RUA= 2013-10-30 06:06:03,673 query_string: AWSAccessKeyId=e0938fb037574111b9c384dbc896b130&Action=RunInstances&ImageId=ami-00000001&InstanceType=m1.nano&KernelId=aki-00000003&KeyName=keypair-115425&MaxCount=1&MinCount=1&RamdiskId=ari-00000002&SecurityGroup.1=securitygroup-813653&SignatureMethod=HmacSHA256&SignatureVersion=2&Timestamp=2013-10-30T06%3A06%3A03Z&Version=2011-12-15 Signature: IobEzDBdG0gUyV3/ym0oUzhmOie8p2mMFbBnjC+1RUA= 2013-10-30 06:06:04,146 <?xml version="1.0" ?><RunInstancesResponse xmlns="http://ec2.amazonaws.com/doc/2011-12-15/"><requestId>req-e1ea8cdc-0f5f-4553-aa9b-bf3067c8cfe2</requestId><ownerId>5f129ddaacbf4681b5bebed29c3df47b</ownerId><groupSet><item><groupId>securitygroup-813653</groupId></item></groupSet><reservationId>r-zu2k8b5u</reservationId><instancesSet><item><placement><availabilityZone>nova</availabilityZone></placement><rootDeviceType>instance-store</rootDeviceType><keyName>keypair-115425</keyName><instanceId>i-00000001</instanceId><instanceState><code>0</code><name>pending</name></instanceState><publicDnsName/><imageId>ami-00000001</imageId><productCodesSet/><privateDnsName>server-15d80a51-a09a-4c52-a504-bda1bd0b2b4b</privateDnsName><dnsName>server-15d80a51-a09a-4c52-a504-bda1bd0b2b4b</dnsName><launchTime>2013-10-30T06:06:04.000Z</launchTime><amiLaunchIndex>0</amiLaunchIndex><rootDeviceName>/dev/sda1</rootDeviceName><kernelId>aki-00000003</kernelId><ramdiskId>ari-00000002</ramdiskId><ipAddress/><instanceType>m1.nano</instanceType><privateIpAddress/></item></instancesSet></RunInstancesResponse> 2013-10-30 06:06:04,147 Method: POST 2013-10-30 06:06:04,148 Path: /services/Cloud/ 2013-10-30 06:06:04,148 Data: 2013-10-30 06:06:04,148 Headers: {} 2013-10-30 06:06:04,148 Host: 127.0.0.1:8773 2013-10-30 06:06:04,148 establishing HTTP connection: kwargs={'timeout': 30} 2013-10-30 06:06:04,148 Token: None 2013-10-30 06:06:04,148 using _calc_signature_2 2013-10-30 06:06:04,148 query string: AWSAccessKeyId=e0938fb037574111b9c384dbc896b130&Action=CreateVolume&AvailabilityZone=nova&SignatureMethod=HmacSHA256&SignatureVersion=2&Size=1&Timestamp=2013-10-30T06%3A06%3A04Z&Version=2011-12-15 2013-10-30 06:06:04,148 string_to_sign: POST 127.0.0.1:8773 /services/Cloud/ AWSAccessKeyId=e0938fb037574111b9c384dbc896b130&Action=CreateVolume&AvailabilityZone=nova&SignatureMethod=HmacSHA256&SignatureVersion=2&Size=1&Timestamp=2013-10-30T06%3A06%3A04Z&Version=2011-12-15 2013-10-30 06:06:04,148 len(b64)=44 2013-10-30 06:06:04,148 base64 encoded digest: guTA4HJwkwqTP0zgKtms/ml8UHNZN+XJ5UGh/my1lNQ= 2013-10-30 06:06:04,148 query_string: AWSAccessKeyId=e0938fb037574111b9c384dbc896b130&Action=CreateVolume&AvailabilityZone=nova&SignatureMethod=HmacSHA256&SignatureVersion=2&Size=1&Timestamp=2013-10-30T06%3A06%3A04Z&Version=2011-12-15 Signature: guTA4HJwkwqTP0zgKtms/ml8UHNZN+XJ5UGh/my1lNQ= 2013-10-30 06:06:04,655 <?xml version="1.0" ?><CreateVolumeResponse xmlns="http://ec2.amazonaws.com/doc/2011-12-15/"><requestId>req-535e4427-f694-4d07-a903-3a8b86b336f6</requestId><status>creating</status><availabilityZone>nova</availabilityZone><volumeId>vol-00000001</volumeId><attachmentSet><item/></attachmentSet><snapshotId/><createTime>2013-10-30T06:06:04.530601</createTime><size>1</size></CreateVolumeResponse> 2013-10-30 06:06:04,655 closing all HTTP connections 2013-10-30 06:06:04,655 state: pending 2013-10-30 06:06:04,656 Method: POST 2013-10-30 06:06:04,656 Path: /services/Cloud/ 2013-10-30 06:06:04,656 Data: 2013-10-30 06:06:04,656 Headers: {} 2013-10-30 06:06:04,656 Host: 127.0.0.1:8773 2013-10-30 06:06:04,656 Token: None 2013-10-30 06:06:04,656 using _calc_signature_2 2013-10-30 06:06:04,656 query string: AWSAccessKeyId=e0938fb037574111b9c384dbc896b130&Action=DescribeInstances&InstanceId.1=i-00000001&SignatureMethod=HmacSHA256&SignatureVersion=2&Timestamp=2013-10-30T06%3A06%3A04Z&Version=2011-12-15 2013-10-30 06:06:04,656 string_to_sign: POST 127.0.0.1:8773 /services/Cloud/ AWSAccessKeyId=e0938fb037574111b9c384dbc896b130&Action=DescribeInstances&InstanceId.1=i-00000001&SignatureMethod=HmacSHA256&SignatureVersion=2&Timestamp=2013-10-30T06%3A06%3A04Z&Version=2011-12-15 2013-10-30 06:06:04,656 len(b64)=44 2013-10-30 06:06:04,656 base64 encoded digest: SHG9092hrkFjjYlIYe7E4UWzYqDIh5l9OsX7+BKl0Es= 2013-10-30 06:06:04,656 query_string: AWSAccessKeyId=e0938fb037574111b9c384dbc896b130&Action=DescribeInstances&InstanceId.1=i-00000001&SignatureMethod=HmacSHA256&SignatureVersion=2&Timestamp=2013-10-30T06%3A06%3A04Z&Version=2011-12-15 Signature: SHG9092hrkFjjYlIYe7E4UWzYqDIh5l9OsX7+BKl0Es= 2013-10-30 06:06:04,834 <?xml version="1.0" ?><DescribeInstancesResponse xmlns="http://ec2.amazonaws.com/doc/2011-12-15/"><requestId>req-001459f5-0069-4c0f-89ee-83b21cd877fc</requestId><reservationSet><item><ownerId>5f129ddaacbf4681b5bebed29c3df47b</ownerId><groupSet><item><groupId>securitygroup-813653</groupId></item></groupSet><reservationId>r-zu2k8b5u</reservationId><instancesSet><item><placement><availabilityZone>nova</availabilityZone></placement><rootDeviceType>instance-store</rootDeviceType><keyName>keypair-115425</keyName><instanceId>i-00000001</instanceId><instanceState><code>0</code><name>error</name></instanceState><publicDnsName/><imageId>ami-00000001</imageId><productCodesSet/><privateDnsName>server-15d80a51-a09a-4c52-a504-bda1bd0b2b4b</privateDnsName><dnsName>server-15d80a51-a09a-4c52-a504-bda1bd0b2b4b</dnsName><launchTime>2013-10-30T06:06:04.000Z</launchTime><amiLaunchIndex>0</amiLaunchIndex><rootDeviceName>/dev/sda1</rootDeviceName><kernelId>aki-00000003</kernelId><ramdiskId>ari-00000002</ramdiskId><ipAddress/><instanceType>m1.nano</instanceType><privateIpAddress/></item></instancesSet></item></reservationSet></DescribeInstancesResponse> --------------------- >> end captured logging << --------------------- ====================================================================== FAIL: tempest.tests.boto.test_ec2_instance_run.InstanceRunTest.test_run_stop_terminate_instance[smoke] ---------------------------------------------------------------------- _StringException: Traceback (most recent call last): File "/opt/stack/new/tempest/tempest/tests/boto/test_ec2_instance_run.py", line 105, in test_run_stop_terminate_instance self.assertInstanceStateWait(instance, "running") File "/opt/stack/new/tempest/tempest/testboto.py", line 348, in assertInstanceStateWait state = self.waitInstanceState(lfunction, wait_for) File "/opt/stack/new/tempest/tempest/testboto.py", line 333, in waitInstanceState self.valid_instance_state) File "/opt/stack/new/tempest/tempest/testboto.py", line 324, in state_wait_gone self.assertIn(state, valid_set | self.gone_set) File "/usr/local/lib/python2.7/dist-packages/testtools/testcase.py", line 328, in assertIn self.assertThat(haystack, Contains(needle)) File "/usr/local/lib/python2.7/dist-packages/testtools/testcase.py", line 417, in assertThat raise MismatchError(matchee, matcher, mismatch, verbose) MismatchError: u'error' not in set(['paused', 'terminated', 'running', 'stopped', 'pending', '_GONE', 'stopping', 'shutting-down']) -------------------- >> begin captured logging << -------------------- 2013-10-30 06:06:04,850 Method: POST 2013-10-30 06:06:04,850 Path: /services/Cloud/ 2013-10-30 06:06:04,850 Data: 2013-10-30 06:06:04,850 Headers: {} 2013-10-30 06:06:04,850 Host: 127.0.0.1:8773 2013-10-30 06:06:04,851 establishing HTTP connection: kwargs={'timeout': 30} 2013-10-30 06:06:04,851 Token: None 2013-10-30 06:06:04,851 using _calc_signature_2 2013-10-30 06:06:04,851 query string: AWSAccessKeyId=e0938fb037574111b9c384dbc896b130&Action=DescribeImages&ImageId.1=ami-00000001&SignatureMethod=HmacSHA256&SignatureVersion=2&Timestamp=2013-10-30T06%3A06%3A04Z&Version=2011-12-15 2013-10-30 06:06:04,851 string_to_sign: POST 127.0.0.1:8773 /services/Cloud/ AWSAccessKeyId=e0938fb037574111b9c384dbc896b130&Action=DescribeImages&ImageId.1=ami-00000001&SignatureMethod=HmacSHA256&SignatureVersion=2&Timestamp=2013-10-30T06%3A06%3A04Z&Version=2011-12-15 2013-10-30 06:06:04,851 len(b64)=44 2013-10-30 06:06:04,851 base64 encoded digest: FoopZ8oSsKLboUc4ZU9HN81OcmzWF3Y91X7je6u1J2U= 2013-10-30 06:06:04,851 query_string: AWSAccessKeyId=e0938fb037574111b9c384dbc896b130&Action=DescribeImages&ImageId.1=ami-00000001&SignatureMethod=HmacSHA256&SignatureVersion=2&Timestamp=2013-10-30T06%3A06%3A04Z&Version=2011-12-15 Signature: FoopZ8oSsKLboUc4ZU9HN81OcmzWF3Y91X7je6u1J2U= 2013-10-30 06:06:05,068 <?xml version="1.0" ?><DescribeImagesResponse xmlns="http://ec2.amazonaws.com/doc/2011-12-15/"><requestId>req-086348bd-5b84-4f80-8b88-408d45bf7a2c</requestId><imagesSet><item><description/><imageOwnerId>5f129ddaacbf4681b5bebed29c3df47b</imageOwnerId><isPublic>false</isPublic><imageId>ami-00000001</imageId><imageState>available</imageState><architecture>x86_64</architecture><imageLocation>s3bucket-159703/cirros-0.3.1-x86_64-blank.img.manifest.xml</imageLocation><rootDeviceType>instance-store</rootDeviceType><rootDeviceName>/dev/sda1</rootDeviceName><imageType>machine</imageType><name>ami-name-43463</name></item></imagesSet></DescribeImagesResponse> 2013-10-30 06:06:05,069 closing all HTTP connections 2013-10-30 06:06:05,069 Method: POST 2013-10-30 06:06:05,069 Path: /services/Cloud/ 2013-10-30 06:06:05,069 Data: 2013-10-30 06:06:05,069 Headers: {} 2013-10-30 06:06:05,069 Host: 127.0.0.1:8773 2013-10-30 06:06:05,069 Token: None 2013-10-30 06:06:05,069 using _calc_signature_2 2013-10-30 06:06:05,069 query string: AWSAccessKeyId=e0938fb037574111b9c384dbc896b130&Action=RunInstances&ImageId=ami-00000001&InstanceType=m1.nano&KernelId=aki-00000003&MaxCount=1&MinCount=1&RamdiskId=ari-00000002&SignatureMethod=HmacSHA256&SignatureVersion=2&Timestamp=2013-10-30T06%3A06%3A05Z&Version=2011-12-15 2013-10-30 06:06:05,070 string_to_sign: POST 127.0.0.1:8773 /services/Cloud/ AWSAccessKeyId=e0938fb037574111b9c384dbc896b130&Action=RunInstances&ImageId=ami-00000001&InstanceType=m1.nano&KernelId=aki-00000003&MaxCount=1&MinCount=1&RamdiskId=ari-00000002&SignatureMethod=HmacSHA256&SignatureVersion=2&Timestamp=2013-10-30T06%3A06%3A05Z&Version=2011-12-15 2013-10-30 06:06:05,070 len(b64)=44 2013-10-30 06:06:05,070 base64 encoded digest: aDZjQBBEewIbeOxrFFppqOTS/6FFKtvnQWlxsjLdN6A= 2013-10-30 06:06:05,070 query_string: AWSAccessKeyId=e0938fb037574111b9c384dbc896b130&Action=RunInstances&ImageId=ami-00000001&InstanceType=m1.nano&KernelId=aki-00000003&MaxCount=1&MinCount=1&RamdiskId=ari-00000002&SignatureMethod=HmacSHA256&SignatureVersion=2&Timestamp=2013-10-30T06%3A06%3A05Z&Version=2011-12-15 Signature: aDZjQBBEewIbeOxrFFppqOTS/6FFKtvnQWlxsjLdN6A= 2013-10-30 06:06:05,503 <?xml version="1.0" ?><RunInstancesResponse xmlns="http://ec2.amazonaws.com/doc/2011-12-15/"><requestId>req-9fb9c9e3-86fc-4539-bad2-3125214ba067</requestId><ownerId>5f129ddaacbf4681b5bebed29c3df47b</ownerId><groupSet><item><groupId>default</groupId></item></groupSet><reservationId>r-qmm02msg</reservationId><instancesSet><item><placement><availabilityZone>nova</availabilityZone></placement><rootDeviceType>instance-store</rootDeviceType><keyName/><instanceId>i-00000002</instanceId><instanceState><code>0</code><name>pending</name></instanceState><publicDnsName/><imageId>ami-00000001</imageId><productCodesSet/><privateDnsName>server-56244b78-5a8f-4ad0-ac98-4d544dea0d84</privateDnsName><dnsName>server-56244b78-5a8f-4ad0-ac98-4d544dea0d84</dnsName><launchTime>2013-10-30T06:06:05.000Z</launchTime><amiLaunchIndex>0</amiLaunchIndex><rootDeviceName>/dev/sda1</rootDeviceName><kernelId>aki-00000003</kernelId><ramdiskId>ari-00000002</ramdiskId><ipAddress/><instanceType>m1.nano</instanceType><privateIpAddress/></item></instancesSet></RunInstancesResponse> 2013-10-30 06:06:05,504 state: pending 2013-10-30 06:06:05,504 Method: POST 2013-10-30 06:06:05,504 Path: /services/Cloud/ 2013-10-30 06:06:05,504 Data: 2013-10-30 06:06:05,504 Headers: {} 2013-10-30 06:06:05,504 Host: 127.0.0.1:8773 2013-10-30 06:06:05,504 Token: None 2013-10-30 06:06:05,504 using _calc_signature_2 2013-10-30 06:06:05,504 query string: AWSAccessKeyId=e0938fb037574111b9c384dbc896b130&Action=DescribeInstances&InstanceId.1=i-00000002&SignatureMethod=HmacSHA256&SignatureVersion=2&Timestamp=2013-10-30T06%3A06%3A05Z&Version=2011-12-15 2013-10-30 06:06:05,504 string_to_sign: POST 127.0.0.1:8773 /services/Cloud/ AWSAccessKeyId=e0938fb037574111b9c384dbc896b130&Action=DescribeInstances&InstanceId.1=i-00000002&SignatureMethod=HmacSHA256&SignatureVersion=2&Timestamp=2013-10-30T06%3A06%3A05Z&Version=2011-12-15 2013-10-30 06:06:05,504 len(b64)=44 2013-10-30 06:06:05,504 base64 encoded digest: h+5w/7G9q3VsafQV1Rt6KgM3tfG7+d++GvIBOOxVnjo= 2013-10-30 06:06:05,504 query_string: AWSAccessKeyId=e0938fb037574111b9c384dbc896b130&Action=DescribeInstances&InstanceId.1=i-00000002&SignatureMethod=HmacSHA256&SignatureVersion=2&Timestamp=2013-10-30T06%3A06%3A05Z&Version=2011-12-15 Signature: h+5w/7G9q3VsafQV1Rt6KgM3tfG7+d++GvIBOOxVnjo= 2013-10-30 06:06:05,691 <?xml version="1.0" ?><DescribeInstancesResponse xmlns="http://ec2.amazonaws.com/doc/2011-12-15/"><requestId>req-8ef7f6ae-a899-4fea-aa2f-2604bc91ac65</requestId><reservationSet><item><ownerId>5f129ddaacbf4681b5bebed29c3df47b</ownerId><groupSet><item><groupId>default</groupId></item></groupSet><reservationId>r-qmm02msg</reservationId><instancesSet><item><placement><availabilityZone>nova</availabilityZone></placement><rootDeviceType>instance-store</rootDeviceType><keyName/><instanceId>i-00000002</instanceId><instanceState><code>0</code><name>error</name></instanceState><publicDnsName/><imageId>ami-00000001</imageId><productCodesSet/><privateDnsName>server-56244b78-5a8f-4ad0-ac98-4d544dea0d84</privateDnsName><dnsName>server-56244b78-5a8f-4ad0-ac98-4d544dea0d84</dnsName><launchTime>2013-10-30T06:06:05.000Z</launchTime><amiLaunchIndex>0</amiLaunchIndex><rootDeviceName>/dev/sda1</rootDeviceName><kernelId>aki-00000003</kernelId><ramdiskId>ari-00000002</ramdiskId><ipAddress/><instanceType>m1.nano</instanceType><privateIpAddress/></item></instancesSet></item></reservationSet></DescribeInstancesResponse> --------------------- >> end captured logging << --------------------- ---------------------------------------------------------------------- XML: nosetests-full.xml ---------------------------------------------------------------------- Ran 826 tests in 1371.334s FAILED (SKIP=73, failures=2) ERROR: InvocationError: '/usr/local/bin/nosetests --logging-format %(asctime)-15s %(message)s --with-xunit --xunit-file=nosetests-full.xml -sv tempest' full runtests: commands[1] | nosetests --logging-format %(asctime)-15s %(message)s --with-xunit --xunit-file=nosetests-cli.xml -sv cli WARNING:test command found but not installed in testenv cmd: /usr/local/bin/nosetests env: /opt/stack/new/tempest/.tox/full Maybe forgot to specify a dependency? nose.config: INFO: Ignoring files matching ['^\\.', '^_', '^setup\\.py$'] cli.simple_read_only.test_compute.SimpleReadOnlyNovaClientTest.test_admin_absolute_limites ... ok cli.simple_read_only.test_compute.SimpleReadOnlyNovaClientTest.test_admin_aggregate_list ... ok cli.simple_read_only.test_compute.SimpleReadOnlyNovaClientTest.test_admin_availability_zone_list ... ok cli.simple_read_only.test_compute.SimpleReadOnlyNovaClientTest.test_admin_cloudpipe_list ... ok cli.simple_read_only.test_compute.SimpleReadOnlyNovaClientTest.test_admin_credentials ... ok cli.simple_read_only.test_compute.SimpleReadOnlyNovaClientTest.test_admin_debug_list ... ok cli.simple_read_only.test_compute.SimpleReadOnlyNovaClientTest.test_admin_dns_domains ... ok cli.simple_read_only.test_compute.SimpleReadOnlyNovaClientTest.test_admin_dns_list ... SKIP: Test needs parameters, Bug: 1157349 cli.simple_read_only.test_compute.SimpleReadOnlyNovaClientTest.test_admin_endpoints ... ok cli.simple_read_only.test_compute.SimpleReadOnlyNovaClientTest.test_admin_fake_action ... ok cli.simple_read_only.test_compute.SimpleReadOnlyNovaClientTest.test_admin_flavor_acces_list ... ok cli.simple_read_only.test_compute.SimpleReadOnlyNovaClientTest.test_admin_flavor_list ... ok cli.simple_read_only.test_compute.SimpleReadOnlyNovaClientTest.test_admin_floating_ip_bulk_list ... ok cli.simple_read_only.test_compute.SimpleReadOnlyNovaClientTest.test_admin_floating_ip_list ... ok cli.simple_read_only.test_compute.SimpleReadOnlyNovaClientTest.test_admin_floating_ip_pool_list ... ok cli.simple_read_only.test_compute.SimpleReadOnlyNovaClientTest.test_admin_help ... ok cli.simple_read_only.test_compute.SimpleReadOnlyNovaClientTest.test_admin_host_list ... ok cli.simple_read_only.test_compute.SimpleReadOnlyNovaClientTest.test_admin_hypervisor_list ... ok cli.simple_read_only.test_compute.SimpleReadOnlyNovaClientTest.test_admin_image_list ... ok cli.simple_read_only.test_compute.SimpleReadOnlyNovaClientTest.test_admin_interface_list ... SKIP: Test needs parameters, Bug: 1157349 cli.simple_read_only.test_compute.SimpleReadOnlyNovaClientTest.test_admin_keypair_list ... ok cli.simple_read_only.test_compute.SimpleReadOnlyNovaClientTest.test_admin_list ... ok cli.simple_read_only.test_compute.SimpleReadOnlyNovaClientTest.test_admin_list_extensions ... ok cli.simple_read_only.test_compute.SimpleReadOnlyNovaClientTest.test_admin_net_list ... ok cli.simple_read_only.test_compute.SimpleReadOnlyNovaClientTest.test_admin_network_list ... ok cli.simple_read_only.test_compute.SimpleReadOnlyNovaClientTest.test_admin_rate_limits ... ok cli.simple_read_only.test_compute.SimpleReadOnlyNovaClientTest.test_admin_secgroup_list ... ok cli.simple_read_only.test_compute.SimpleReadOnlyNovaClientTest.test_admin_secgroup_list_rules ... SKIP: Test needs parameters, Bug: 1157349 cli.simple_read_only.test_compute.SimpleReadOnlyNovaClientTest.test_admin_servce_list ... ok cli.simple_read_only.test_compute.SimpleReadOnlyNovaClientTest.test_admin_timeout ... ok cli.simple_read_only.test_compute.SimpleReadOnlyNovaClientTest.test_admin_timing ... ok cli.simple_read_only.test_compute.SimpleReadOnlyNovaClientTest.test_admin_usage ... ok cli.simple_read_only.test_compute.SimpleReadOnlyNovaClientTest.test_admin_usage_list ... ok cli.simple_read_only.test_compute.SimpleReadOnlyNovaClientTest.test_admin_version ... ok cli.simple_read_only.test_compute.SimpleReadOnlyNovaClientTest.test_admin_volume_list ... ok cli.simple_read_only.test_compute.SimpleReadOnlyNovaClientTest.test_admin_volume_snapshot_list ... ok cli.simple_read_only.test_compute.SimpleReadOnlyNovaClientTest.test_admin_volume_type_list ... ok cli.simple_read_only.test_compute_manage.SimpleReadOnlyNovaManageTest.test_admin_fake_action ... ok cli.simple_read_only.test_compute_manage.SimpleReadOnlyNovaManageTest.test_flavor_list ... ok cli.simple_read_only.test_compute_manage.SimpleReadOnlyNovaManageTest.test_help_flag ... ok cli.simple_read_only.test_compute_manage.SimpleReadOnlyNovaManageTest.test_version ... ok cli.simple_read_only.test_compute_manage.SimpleReadOnlyNovaManageTest.test_version_flag ... SKIP: version is empty, bug 1138844 cli.simple_read_only.test_keystone.SimpleReadOnlyKeystoneClientTest.test_admin_bashcompletion ... ok cli.simple_read_only.test_keystone.SimpleReadOnlyKeystoneClientTest.test_admin_catalog_list ... ok cli.simple_read_only.test_keystone.SimpleReadOnlyKeystoneClientTest.test_admin_discover ... ok cli.simple_read_only.test_keystone.SimpleReadOnlyKeystoneClientTest.test_admin_endpoint_list ... ok cli.simple_read_only.test_keystone.SimpleReadOnlyKeystoneClientTest.test_admin_endpoint_service_match ... ok cli.simple_read_only.test_keystone.SimpleReadOnlyKeystoneClientTest.test_admin_fake_action ... ok cli.simple_read_only.test_keystone.SimpleReadOnlyKeystoneClientTest.test_admin_help ... ok cli.simple_read_only.test_keystone.SimpleReadOnlyKeystoneClientTest.test_admin_role_list ... ok cli.simple_read_only.test_keystone.SimpleReadOnlyKeystoneClientTest.test_admin_service_list ... ok cli.simple_read_only.test_keystone.SimpleReadOnlyKeystoneClientTest.test_admin_tenant_list ... ok cli.simple_read_only.test_keystone.SimpleReadOnlyKeystoneClientTest.test_admin_user_list ... ok cli.simple_read_only.test_keystone.SimpleReadOnlyKeystoneClientTest.test_admin_user_role_list ... ok ---------------------------------------------------------------------- XML: nosetests-cli.xml ---------------------------------------------------------------------- Ran 54 tests in 32.414s OK (SKIP=4) ___________________________________ summary ____________________________________ ERROR: full: commands failed Process leaked file descriptors. See http://wiki.jenkins-ci.org/display/JENKINS/Spawning+processes+from+build for more information Build step 'Execute shell' marked build as failure [SCP] Connecting to static.openstack.org [SCP] Trying to create /srv/static/logs/periodic/periodic-tempest-devstack-vm-stable-grizzly/devstack-precise-hpcloud-az1-619325 [SCP] Trying to create /srv/static/logs/periodic/periodic-tempest-devstack-vm-stable-grizzly/devstack-precise-hpcloud-az1-619325/43 [SCP] Trying to create /srv/static/logs/periodic/periodic-tempest-devstack-vm-stable-grizzly/devstack-precise-hpcloud-az1-619325/43/logs [SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-stable-grizzly/devstack-precise-hpcloud-az1-619325/43/logs/devstack-gate-cleanup-host.txt.gz' [SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-stable-grizzly/devstack-precise-hpcloud-az1-619325/43/logs/devstack-gate-setup-host.txt.gz' [SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-stable-grizzly/devstack-precise-hpcloud-az1-619325/43/logs/devstack-gate-setup-workspace-new.txt.gz' [SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-stable-grizzly/devstack-precise-hpcloud-az1-619325/43/logs/devstacklog.txt.gz' [SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-stable-grizzly/devstack-precise-hpcloud-az1-619325/43/logs/iptables.txt.gz' [SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-stable-grizzly/devstack-precise-hpcloud-az1-619325/43/logs/kern_log.txt.gz' [SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-stable-grizzly/devstack-precise-hpcloud-az1-619325/43/logs/localrc.txt.gz' [SCP] Trying to create /srv/static/logs/periodic/periodic-tempest-devstack-vm-stable-grizzly/devstack-precise-hpcloud-az1-619325/43/logs/mysql [SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-stable-grizzly/devstack-precise-hpcloud-az1-619325/43/logs/mysql/error.txt.gz' [SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-stable-grizzly/devstack-precise-hpcloud-az1-619325/43/logs/mysql/mysql-slow.txt.gz' [SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-stable-grizzly/devstack-precise-hpcloud-az1-619325/43/logs/pip-freeze.txt.gz' [SCP] Trying to create /srv/static/logs/periodic/periodic-tempest-devstack-vm-stable-grizzly/devstack-precise-hpcloud-az1-619325/43/logs/rabbitmq [SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-stable-grizzly/devstack-precise-hpcloud-az1-619325/43/logs/rabbitmq/rabbit(a)devstack-precise-hpcloud-az1-619325-sasl.txt.gz' [SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-stable-grizzly/devstack-precise-hpcloud-az1-619325/43/logs/rabbitmq/rabbit(a)devstack-precise-hpcloud-az1-619325.txt.gz' [SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-stable-grizzly/devstack-precise-hpcloud-az1-619325/43/logs/rabbitmq/startup_log.txt.gz' [SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-stable-grizzly/devstack-precise-hpcloud-az1-619325/43/logs/screen-c-api.txt.gz' [SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-stable-grizzly/devstack-precise-hpcloud-az1-619325/43/logs/screen-c-sch.txt.gz' [SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-stable-grizzly/devstack-precise-hpcloud-az1-619325/43/logs/screen-c-vol.txt.gz' [SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-stable-grizzly/devstack-precise-hpcloud-az1-619325/43/logs/screen-g-api.txt.gz' [SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-stable-grizzly/devstack-precise-hpcloud-az1-619325/43/logs/screen-g-reg.txt.gz' [SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-stable-grizzly/devstack-precise-hpcloud-az1-619325/43/logs/screen-horizon.txt.gz' [SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-stable-grizzly/devstack-precise-hpcloud-az1-619325/43/logs/screen-key.txt.gz' [SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-stable-grizzly/devstack-precise-hpcloud-az1-619325/43/logs/screen-n-api.txt.gz' [SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-stable-grizzly/devstack-precise-hpcloud-az1-619325/43/logs/screen-n-cond.txt.gz' [SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-stable-grizzly/devstack-precise-hpcloud-az1-619325/43/logs/screen-n-cpu.txt.gz' [SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-stable-grizzly/devstack-precise-hpcloud-az1-619325/43/logs/screen-n-crt.txt.gz' [SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-stable-grizzly/devstack-precise-hpcloud-az1-619325/43/logs/screen-n-net.txt.gz' [SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-stable-grizzly/devstack-precise-hpcloud-az1-619325/43/logs/screen-n-obj.txt.gz' [SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-stable-grizzly/devstack-precise-hpcloud-az1-619325/43/logs/screen-n-sch.txt.gz' [SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-stable-grizzly/devstack-precise-hpcloud-az1-619325/43/logs/screen-s-account.txt.gz' [SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-stable-grizzly/devstack-precise-hpcloud-az1-619325/43/logs/screen-s-container.txt.gz' [SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-stable-grizzly/devstack-precise-hpcloud-az1-619325/43/logs/screen-s-object.txt.gz' [SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-stable-grizzly/devstack-precise-hpcloud-az1-619325/43/logs/screen-s-proxy.txt.gz' [SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-stable-grizzly/devstack-precise-hpcloud-az1-619325/43/logs/screen-sysstat.txt.gz' [SCP] Trying to create /srv/static/logs/periodic/periodic-tempest-devstack-vm-stable-grizzly/devstack-precise-hpcloud-az1-619325/43/logs/sudoers.d [SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-stable-grizzly/devstack-precise-hpcloud-az1-619325/43/logs/sudoers.d/51_tempest_sh.txt.gz' [SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-stable-grizzly/devstack-precise-hpcloud-az1-619325/43/logs/sudoers.d/90-cloudimg-ubuntu.txt.gz' [SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-stable-grizzly/devstack-precise-hpcloud-az1-619325/43/logs/sudoers.d/README.txt.gz' [SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-stable-grizzly/devstack-precise-hpcloud-az1-619325/43/logs/sudoers.d/cinder-rootwrap.txt.gz' [SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-stable-grizzly/devstack-precise-hpcloud-az1-619325/43/logs/sudoers.d/jenkins-sudo-grep.txt.gz' [SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-stable-grizzly/devstack-precise-hpcloud-az1-619325/43/logs/sudoers.d/nova-rootwrap.txt.gz' [SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-stable-grizzly/devstack-precise-hpcloud-az1-619325/43/logs/sudoers.txt.gz' [SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-stable-grizzly/devstack-precise-hpcloud-az1-619325/43/logs/syslog.txt.gz' [SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-stable-grizzly/devstack-precise-hpcloud-az1-619325/43/logs/sysstat.dat.gz' [SCP] No file(s) found: **/testr_results.html.gz [SCP] '**/testr_results.html.gz' doesn't match anything: '**' exists but not '**/testr_results.html.gz' [SCP] No file(s) found: **/subunit_log.txt.gz [SCP] '**/subunit_log.txt.gz' doesn't match anything: '**' exists but not '**/subunit_log.txt.gz' [SCP] Connecting to static.openstack.org [SCP] Copying console log.

1 1