Open Stack

See <https://jenkins.openstack.org/job/periodic-glance-python27-stable-grizzly/62/>

------------------------------------------
[...truncated 7528 lines...]
sqlalchemy.engine.base.Engine: DEBUG: Row ('utf16_roman_ci', 'utf16', 116L, '', 'Yes', 8L)
sqlalchemy.engine.base.Engine: DEBUG: Row ('utf16_persian_ci', 'utf16', 117L, '', 'Yes', 8L)
sqlalchemy.engine.base.Engine: DEBUG: Row ('utf16_esperanto_ci', 'utf16', 118L, '', 'Yes', 8L)
sqlalchemy.engine.base.Engine: DEBUG: Row ('utf16_hungarian_ci', 'utf16', 119L, '', 'Yes', 8L)
sqlalchemy.engine.base.Engine: DEBUG: Row ('utf16_sinhala_ci', 'utf16', 120L, '', 'Yes', 8L)
sqlalchemy.engine.base.Engine: DEBUG: Row ('cp1256_general_ci', 'cp1256', 57L, 'Yes', 'Yes', 1L)
sqlalchemy.engine.base.Engine: DEBUG: Row ('cp1256_bin', 'cp1256', 67L, '', 'Yes', 1L)
sqlalchemy.engine.base.Engine: DEBUG: Row ('cp1257_lithuanian_ci', 'cp1257', 29L, '', 'Yes', 1L)
sqlalchemy.engine.base.Engine: DEBUG: Row ('cp1257_bin', 'cp1257', 58L, '', 'Yes', 1L)
sqlalchemy.engine.base.Engine: DEBUG: Row ('cp1257_general_ci', 'cp1257', 59L, 'Yes', 'Yes', 1L)
sqlalchemy.engine.base.Engine: DEBUG: Row ('utf32_general_ci', 'utf32', 60L, 'Yes', 'Yes', 1L)
sqlalchemy.engine.base.Engine: DEBUG: Row ('utf32_bin', 'utf32', 61L, '', 'Yes', 1L)
sqlalchemy.engine.base.Engine: DEBUG: Row ('utf32_unicode_ci', 'utf32', 160L, '', 'Yes', 8L)
sqlalchemy.engine.base.Engine: DEBUG: Row ('utf32_icelandic_ci', 'utf32', 161L, '', 'Yes', 8L)
sqlalchemy.engine.base.Engine: DEBUG: Row ('utf32_latvian_ci', 'utf32', 162L, '', 'Yes', 8L)
sqlalchemy.engine.base.Engine: DEBUG: Row ('utf32_romanian_ci', 'utf32', 163L, '', 'Yes', 8L)
sqlalchemy.engine.base.Engine: DEBUG: Row ('utf32_slovenian_ci', 'utf32', 164L, '', 'Yes', 8L)
sqlalchemy.engine.base.Engine: DEBUG: Row ('utf32_polish_ci', 'utf32', 165L, '', 'Yes', 8L)
sqlalchemy.engine.base.Engine: DEBUG: Row ('utf32_estonian_ci', 'utf32', 166L, '', 'Yes', 8L)
sqlalchemy.engine.base.Engine: DEBUG: Row ('utf32_spanish_ci', 'utf32', 167L, '', 'Yes', 8L)
sqlalchemy.engine.base.Engine: DEBUG: Row ('utf32_swedish_ci', 'utf32', 168L, '', 'Yes', 8L)
sqlalchemy.engine.base.Engine: DEBUG: Row ('utf32_turkish_ci', 'utf32', 169L, '', 'Yes', 8L)
sqlalchemy.engine.base.Engine: DEBUG: Row ('utf32_czech_ci', 'utf32', 170L, '', 'Yes', 8L)
sqlalchemy.engine.base.Engine: DEBUG: Row ('utf32_danish_ci', 'utf32', 171L, '', 'Yes', 8L)
sqlalchemy.engine.base.Engine: DEBUG: Row ('utf32_lithuanian_ci', 'utf32', 172L, '', 'Yes', 8L)
sqlalchemy.engine.base.Engine: DEBUG: Row ('utf32_slovak_ci', 'utf32', 173L, '', 'Yes', 8L)
sqlalchemy.engine.base.Engine: DEBUG: Row ('utf32_spanish2_ci', 'utf32', 174L, '', 'Yes', 8L)
sqlalchemy.engine.base.Engine: DEBUG: Row ('utf32_roman_ci', 'utf32', 175L, '', 'Yes', 8L)
sqlalchemy.engine.base.Engine: DEBUG: Row ('utf32_persian_ci', 'utf32', 176L, '', 'Yes', 8L)
sqlalchemy.engine.base.Engine: DEBUG: Row ('utf32_esperanto_ci', 'utf32', 177L, '', 'Yes', 8L)
sqlalchemy.engine.base.Engine: DEBUG: Row ('utf32_hungarian_ci', 'utf32', 178L, '', 'Yes', 8L)
sqlalchemy.engine.base.Engine: DEBUG: Row ('utf32_sinhala_ci', 'utf32', 179L, '', 'Yes', 8L)
sqlalchemy.engine.base.Engine: DEBUG: Row ('binary', 'binary', 63L, 'Yes', 'Yes', 1L)
sqlalchemy.engine.base.Engine: DEBUG: Row ('geostd8_general_ci', 'geostd8', 92L, 'Yes', 'Yes', 1L)
sqlalchemy.engine.base.Engine: DEBUG: Row ('geostd8_bin', 'geostd8', 93L, '', 'Yes', 1L)
sqlalchemy.engine.base.Engine: DEBUG: Row ('cp932_japanese_ci', 'cp932', 95L, 'Yes', 'Yes', 1L)
sqlalchemy.engine.base.Engine: DEBUG: Row ('cp932_bin', 'cp932', 96L, '', 'Yes', 1L)
sqlalchemy.engine.base.Engine: DEBUG: Row ('eucjpms_japanese_ci', 'eucjpms', 97L, 'Yes', 'Yes', 1L)
sqlalchemy.engine.base.Engine: DEBUG: Row ('eucjpms_bin', 'eucjpms', 98L, '', 'Yes', 1L)
sqlalchemy.engine.base.Engine: INFO: SHOW VARIABLES LIKE 'sql_mode'
sqlalchemy.engine.base.Engine: INFO: ()
sqlalchemy.engine.base.Engine: DEBUG: Col ('Variable_name', 'Value')
sqlalchemy.engine.base.Engine: DEBUG: Row ('sql_mode', '')
sqlalchemy.engine.base.Engine: INFO: SHOW CREATE TABLE `migrate_version`
sqlalchemy.engine.base.Engine: INFO: ()
sqlalchemy.engine.base.Engine: DEBUG: Col ('Table', 'Create Table')
sqlalchemy.engine.base.Engine: DEBUG: Row ('migrate_version', 'CREATE TABLE `migrate_version` (\n  `repository_id` varchar(250) NOT NULL,\n  `repository_path` text,\n  `version` int(11) DEFAULT NULL,\n  PRIMARY KEY (`repository_id`)\n) ENGINE=MyISAM DEFAULT CHARSET=latin1')
sqlalchemy.engine.base.Engine: INFO: SELECT migrate_version.repository_id, migrate_version.repository_path, migrate_version.version 
FROM migrate_version 
WHERE migrate_version.repository_id = %s
sqlalchemy.engine.base.Engine: INFO: ('Glance Migrations',)
sqlalchemy.engine.base.Engine: DEBUG: Col ('repository_id', 'repository_path', 'version')
sqlalchemy.engine.base.Engine: DEBUG: Row ('Glance Migrations', '<https://jenkins.openstack.org/job/periodic-glance-python27-stable-grizzly/ws/glance/db/sqlalchemy/migrate_repo',> 11L)
migrate.versioning.api: INFO: 11 -> 12... 
sqlalchemy.engine.base.Engine: INFO: SHOW CREATE TABLE `images`
sqlalchemy.engine.base.Engine: INFO: ()
sqlalchemy.engine.base.Engine: DEBUG: Col ('Table', 'Create Table')
sqlalchemy.engine.base.Engine: DEBUG: Row ('images', 'CREATE TABLE `images` (\n  `id` int(11) NOT NULL AUTO_INCREMENT,\n  `name` varchar(255) DEFAULT NULL,\n  `size` bigint(20) DEFAULT NULL,\n  `status` varchar(30) NOT NULL,\n  `is_public` tinyint(1) NOT NULL,\n  `location` text,\n  `created_at` datetime NOT NULL,\n  `updated_at` datetime DEFAULT NULL,\n  `deleted_at` datetime DEFAULT NULL,\n  `deleted` tinyint(1) NOT NULL,\n  `disk_format` varchar(20) DEFAULT NULL,\n  `container_format` varchar(20) DEFAULT NULL,\n  `checksum` varchar(32) DEFAULT NULL,\n  `owner` varchar(255) DEFAULT NULL,\n  `min_disk` int(11) NOT NULL,\n  `min_ram` int(11) NOT NULL,\n  PRIMARY KEY (`id`),\n  KEY `ix_images_is_public` (`is_public`),\n  KEY `ix_images_deleted` (`deleted`)\n) ENGINE=InnoDB AUTO_INCREMENT=10000 DEFAULT CHARSET=latin1')
sqlalchemy.engine.base.Engine: INFO: SHOW CREATE TABLE `image_members`
sqlalchemy.engine.base.Engine: INFO: ()
sqlalchemy.engine.base.Engine: DEBUG: Col ('Table', 'Create Table')
sqlalchemy.engine.base.Engine: DEBUG: Row ('image_members', 'CREATE TABLE `image_members` (\n  `id` int(11) NOT NULL AUTO_INCREMENT,\n  `image_id` int(11) NOT NULL,\n  `member` varchar(255) NOT NULL,\n  `can_share` tinyint(1) NOT NULL,\n  `created_at` datetime NOT NULL,\n  `updated_at` datetime DEFAULT NULL,\n  `deleted_at` datetime DEFAULT NULL,\n  `deleted` tinyint(1) NOT NULL,\n  PRIMARY KEY (`id`),\n  UNIQUE KEY `image_id` (`image_id`,`member`),\n  KEY `ix_image_members_deleted` (`deleted`),\n  KEY `ix_image_members_image_id` (`image_id`),\n  KEY `ix_image_members_image_id_member` (`image_id`,`member`),\n  CONSTRAINT `image_members_ibfk_1` FOREIGN KEY (`image_id`) REFERENCES `images` (`id`)\n) ENGINE=InnoDB DEFAULT CHARSET=utf8')
sqlalchemy.engine.base.Engine: INFO: SHOW CREATE TABLE `image_properties`
sqlalchemy.engine.base.Engine: INFO: ()
sqlalchemy.engine.base.Engine: DEBUG: Col ('Table', 'Create Table')
sqlalchemy.engine.base.Engine: DEBUG: Row ('image_properties', 'CREATE TABLE `image_properties` (\n  `id` int(11) NOT NULL AUTO_INCREMENT,\n  `image_id` int(11) NOT NULL,\n  `name` varchar(255) NOT NULL,\n  `value` text,\n  `created_at` datetime NOT NULL,\n  `updated_at` datetime DEFAULT NULL,\n  `deleted_at` datetime DEFAULT NULL,\n  `deleted` tinyint(1) NOT NULL,\n  PRIMARY KEY (`id`),\n  UNIQUE KEY `image_id` (`image_id`,`name`),\n  UNIQUE KEY `ix_image_properties_image_id_name` (`image_id`,`name`),\n  KEY `ix_image_properties_deleted` (`deleted`),\n  KEY `ix_image_properties_image_id` (`image_id`),\n  CONSTRAINT `image_properties_ibfk_1` FOREIGN KEY (`image_id`) REFERENCES `images` (`id`)\n) ENGINE=InnoDB AUTO_INCREMENT=11 DEFAULT CHARSET=latin1')
sqlalchemy.engine.base.Engine: INFO: ALTER TABLE image_members DROP FOREIGN KEY image_members_ibfk_1
sqlalchemy.engine.base.Engine: INFO: ()
sqlalchemy.engine.base.Engine: INFO: COMMIT
sqlalchemy.engine.base.Engine: INFO: ALTER TABLE image_properties DROP FOREIGN KEY image_properties_ibfk_1
sqlalchemy.engine.base.Engine: INFO: ()
sqlalchemy.engine.base.Engine: INFO: COMMIT
sqlalchemy.engine.base.Engine: INFO: 
ALTER TABLE images CHANGE COLUMN id id VARCHAR(36) NOT NULL
sqlalchemy.engine.base.Engine: INFO: ()
sqlalchemy.engine.base.Engine: INFO: COMMIT
sqlalchemy.engine.base.Engine: INFO: 
ALTER TABLE image_members CHANGE COLUMN image_id image_id VARCHAR(36) NOT NULL
sqlalchemy.engine.base.Engine: INFO: ()
sqlalchemy.engine.base.Engine: INFO: COMMIT
sqlalchemy.engine.base.Engine: INFO: 
ALTER TABLE image_properties CHANGE COLUMN image_id image_id VARCHAR(36) NOT NULL
sqlalchemy.engine.base.Engine: INFO: ()
sqlalchemy.engine.base.Engine: INFO: COMMIT
sqlalchemy.engine.base.Engine: INFO: SELECT images.id, images.name, images.size, images.status, images.is_public, images.location, images.created_at, images.updated_at, images.deleted_at, images.deleted, images.disk_format, images.container_format, images.checksum, images.owner, images.min_disk, images.min_ram 
FROM images
sqlalchemy.engine.base.Engine: INFO: ()
sqlalchemy.engine.base.Engine: DEBUG: Col ('id', 'name', 'size', 'status', 'is_public', 'location', 'created_at', 'updated_at', 'deleted_at', 'deleted', 'disk_format', 'container_format', 'checksum', 'owner', 'min_disk', 'min_ram')
sqlalchemy.engine.base.Engine: DEBUG: Row ('1', None, None, 'active', 1, None, datetime.datetime(2013, 6, 11, 6, 15, 40), datetime.datetime(2013, 6, 11, 6, 15, 40), None, 0, None, None, None, None, 0L, 0L)
sqlalchemy.engine.base.Engine: DEBUG: Row ('2', None, None, 'active', 1, None, datetime.datetime(2013, 6, 11, 6, 15, 40), datetime.datetime(2013, 6, 11, 6, 15, 40), None, 0, None, None, None, None, 0L, 0L)
sqlalchemy.engine.base.Engine: DEBUG: Row ('3', None, 2147483647L, 'active', 1, None, datetime.datetime(2013, 6, 11, 6, 15, 40), datetime.datetime(2013, 6, 11, 6, 15, 40), None, 0, None, None, None, None, 0L, 0L)
sqlalchemy.engine.base.Engine: DEBUG: Row ('9999', None, None, 'active', 1, None, datetime.datetime(2013, 6, 11, 6, 15, 40), datetime.datetime(2013, 6, 11, 6, 15, 40), None, 0, None, None, None, None, 0L, 0L)
sqlalchemy.engine.base.Engine: INFO: UPDATE images SET id=%s WHERE images.id = %s
sqlalchemy.engine.base.Engine: INFO: ('08e7f0c9-a4af-4773-b463-14633241d5fe', '1')
sqlalchemy.engine.base.Engine: INFO: COMMIT
sqlalchemy.engine.base.Engine: INFO: UPDATE image_members SET image_id=%s WHERE image_members.image_id = %s
sqlalchemy.engine.base.Engine: INFO: ('08e7f0c9-a4af-4773-b463-14633241d5fe', '1')
sqlalchemy.engine.base.Engine: INFO: COMMIT
sqlalchemy.engine.base.Engine: INFO: UPDATE image_properties SET image_id=%s WHERE image_properties.image_id = %s
sqlalchemy.engine.base.Engine: INFO: ('08e7f0c9-a4af-4773-b463-14633241d5fe', '1')
sqlalchemy.engine.base.Engine: INFO: COMMIT
sqlalchemy.engine.base.Engine: INFO: UPDATE image_properties SET value=%s WHERE (image_properties.name = %s OR image_properties.name = %s) AND image_properties.value = %s
sqlalchemy.engine.base.Engine: INFO: ('08e7f0c9-a4af-4773-b463-14633241d5fe', 'kernel_id', 'ramdisk_id', '1')
sqlalchemy.engine.base.Engine: INFO: COMMIT
sqlalchemy.engine.base.Engine: INFO: UPDATE images SET id=%s WHERE images.id = %s
sqlalchemy.engine.base.Engine: INFO: ('dfc0747d-522a-4018-8be9-833a7558cd41', '2')
sqlalchemy.engine.base.Engine: INFO: COMMIT
sqlalchemy.engine.base.Engine: INFO: UPDATE image_members SET image_id=%s WHERE image_members.image_id = %s
sqlalchemy.engine.base.Engine: INFO: ('dfc0747d-522a-4018-8be9-833a7558cd41', '2')
sqlalchemy.engine.base.Engine: INFO: COMMIT
sqlalchemy.engine.base.Engine: INFO: UPDATE image_properties SET image_id=%s WHERE image_properties.image_id = %s
sqlalchemy.engine.base.Engine: INFO: ('dfc0747d-522a-4018-8be9-833a7558cd41', '2')
sqlalchemy.engine.base.Engine: INFO: COMMIT
sqlalchemy.engine.base.Engine: INFO: UPDATE image_properties SET value=%s WHERE (image_properties.name = %s OR image_properties.name = %s) AND image_properties.value = %s
sqlalchemy.engine.base.Engine: INFO: ('dfc0747d-522a-4018-8be9-833a7558cd41', 'kernel_id', 'ramdisk_id', '2')
sqlalchemy.engine.base.Engine: INFO: COMMIT
sqlalchemy.engine.base.Engine: INFO: UPDATE images SET id=%s WHERE images.id = %s
sqlalchemy.engine.base.Engine: INFO: ('361cbd0e-e5cc-49b7-a273-67e93c345ddc', '3')
sqlalchemy.engine.base.Engine: INFO: COMMIT
sqlalchemy.engine.base.Engine: INFO: UPDATE image_members SET image_id=%s WHERE image_members.image_id = %s
sqlalchemy.engine.base.Engine: INFO: ('361cbd0e-e5cc-49b7-a273-67e93c345ddc', '3')
sqlalchemy.engine.base.Engine: INFO: COMMIT
sqlalchemy.engine.base.Engine: INFO: UPDATE image_properties SET image_id=%s WHERE image_properties.image_id = %s
sqlalchemy.engine.base.Engine: INFO: ('361cbd0e-e5cc-49b7-a273-67e93c345ddc', '3')
sqlalchemy.engine.base.Engine: INFO: COMMIT
sqlalchemy.engine.base.Engine: INFO: UPDATE image_properties SET value=%s WHERE (image_properties.name = %s OR image_properties.name = %s) AND image_properties.value = %s
sqlalchemy.engine.base.Engine: INFO: ('361cbd0e-e5cc-49b7-a273-67e93c345ddc', 'kernel_id', 'ramdisk_id', '3')
sqlalchemy.engine.base.Engine: INFO: COMMIT
sqlalchemy.engine.base.Engine: INFO: UPDATE images SET id=%s WHERE images.id = %s
sqlalchemy.engine.base.Engine: INFO: ('6beda164-3456-4677-a563-4956336cd2a7', '9999')
sqlalchemy.engine.base.Engine: INFO: COMMIT
sqlalchemy.engine.base.Engine: INFO: UPDATE image_members SET image_id=%s WHERE image_members.image_id = %s
sqlalchemy.engine.base.Engine: INFO: ('6beda164-3456-4677-a563-4956336cd2a7', '9999')
sqlalchemy.engine.base.Engine: INFO: COMMIT
sqlalchemy.engine.base.Engine: INFO: UPDATE image_properties SET image_id=%s WHERE image_properties.image_id = %s
sqlalchemy.engine.base.Engine: INFO: ('6beda164-3456-4677-a563-4956336cd2a7', '9999')
sqlalchemy.engine.base.Engine: INFO: COMMIT
sqlalchemy.engine.base.Engine: INFO: UPDATE image_properties SET value=%s WHERE (image_properties.name = %s OR image_properties.name = %s) AND image_properties.value = %s
sqlalchemy.engine.base.Engine: INFO: ('6beda164-3456-4677-a563-4956336cd2a7', 'kernel_id', 'ramdisk_id', '9999')
sqlalchemy.engine.base.Engine: INFO: COMMIT
sqlalchemy.engine.base.Engine: INFO: ALTER TABLE image_members ADD CONSTRAINT image_members_ibfk_1 FOREIGN KEY(image_id) REFERENCES images (id)
sqlalchemy.engine.base.Engine: INFO: ()
sqlalchemy.engine.base.Engine: INFO: ROLLBACK
migrate.versioning.util: DEBUG: Disposing SQLAlchemy engine Engine(mysql+mysqldb://openstack_citest:openstack_citest@localhost/openstack_citest)
glance.tests.unit.test_migrations: DEBUG: 
--------------------- >> end captured logging << ---------------------

----------------------------------------------------------------------
XML: nosetests.xml
Slowest 5 tests took 98.86 secs:
    27.89    TestScrubber.test_scrubber_app
    22.20    TestScrubber.test_delayed_delete
    16.95    TestRootApi.test_version_configurations
    16.25    TestBinGlanceCacheManage.test_queue
    15.56    TestGlanceControl.test_reload
----------------------------------------------------------------------
Ran 1101 tests in 716.863s

FAILED (SKIP=38, errors=1)
ERROR: InvocationError: '<https://jenkins.openstack.org/job/periodic-glance-python27-stable-grizzly/ws/.tox/py27/bin/nosetests'>
___________________________________ 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==0.9.6
Jinja2==2.7
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.0.11
anyjson==0.3.3
argparse==1.2.1
boto==2.9.5
colorama==0.2.5
coverage==3.6
d2to1==0.2.10
decorator==3.4.0
distribute==0.6.34
docutils==0.10
eventlet==0.12.1
extras==0.0.3
fixtures==0.3.12
glance==jenkins.periodic.glance.python27.stable.grizzly.62
greenlet==0.4.1
httplib2==0.8
iso8601==0.1.4
jsonschema==2.0.0
kombu==2.5.10
lxml==3.2.1
mox==0.5.3
nose==1.3.0
nose-exclude==0.1.9
nosehtmloutput==0.0.4
openstack.nose-plugin==0.11
oslo.config==1.1.1
passlib==1.6.1
pbr==0.5.14
pep8==1.3.3
prettytable==0.7.2
psycopg2==2.5
pycrypto==2.6
pysendfile==2.0.0
python-keystoneclient==0.2.5
python-mimeparse==0.1.4
python-swiftclient==1.4.0
repoze.lru==0.6
requests==1.2.3
setuptools-git==1.0b1
simplejson==3.3.0
six==1.3.0
sqlalchemy-migrate==0.7.2
termcolor==1.1.0
testtools==0.9.31
wsgiref==0.1.2
xattr==0.6.4
+ 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.INb6AbFCMV
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-grizzly/62
[SCP] uploading file: '/srv/static/logs/periodic/periodic-glance-python27-stable-grizzly/62/nose_results.html'
[SCP] Connecting to static.openstack.org
[SCP] Copying console log.