See <https://jenkins02.openstack.org/job/periodic-neutron-python27-stable-havana/10/> ------------------------------------------ [...truncated 13 lines...] Checking out Revision 496e6f0edac3727cbf54f9fa222d056b385cb3c7 (origin/stable/havana) [periodic-neutron-python27-stable-havana] $ /bin/bash -xe /tmp/hudson4559315476934255233.sh + /usr/local/jenkins/slave_scripts/run-unittests.sh 27 openstack neutron + version=27 + org=openstack + project=neutron + source /usr/local/jenkins/slave_scripts/functions.sh + check_variable_version_org_project 27 openstack neutron /usr/local/jenkins/slave_scripts/run-unittests.sh + version=27 + org=openstack + project=neutron + filename=/usr/local/jenkins/slave_scripts/run-unittests.sh + [[ -z 27 ]] + [[ -z openstack ]] + [[ -z neutron ]] + venv=py27 + export NOSE_WITH_XUNIT=1 + NOSE_WITH_XUNIT=1 + export NOSE_WITH_HTML_OUTPUT=1 + NOSE_WITH_HTML_OUTPUT=1 + export NOSE_HTML_OUT_FILE=nose_results.html + NOSE_HTML_OUT_FILE=nose_results.html ++ /bin/mktemp -d + export TMPDIR=/tmp/tmp.iZD9mYZQhl + TMPDIR=/tmp/tmp.iZD9mYZQhl + trap 'rm -rf /tmp/tmp.iZD9mYZQhl' EXIT + /usr/local/jenkins/slave_scripts/jenkins-oom-grep.sh pre + sudo /usr/local/jenkins/slave_scripts/jenkins-sudo-grep.sh pre + source /usr/local/jenkins/slave_scripts/select-mirror.sh openstack neutron ++ org=openstack ++ project=neutron ++ source /usr/local/jenkins/slave_scripts/functions.sh ++ check_variable_org_project openstack neutron /usr/local/jenkins/slave_scripts/run-unittests.sh ++ org=openstack ++ project=neutron ++ filename=/usr/local/jenkins/slave_scripts/run-unittests.sh ++ [[ -z openstack ]] ++ [[ -z neutron ]] ++ rm -f /home/jenkins/.pydistutils.cfg ++ mkdir -p /home/jenkins/.pip ++ rm -f /home/jenkins/.pip/pip.conf ++ cat ++ '[' openstack == openstack ']' ++ '[' neutron == requirements ']' ++ '[' openstack == openstack ']' ++ export TOX_INDEX_URL=http://pypi.openstack.org/openstack ++ TOX_INDEX_URL=http://pypi.openstack.org/openstack ++ cat ++ cat + tox -epy27 GLOB sdist-make: <https://jenkins02.openstack.org/job/periodic-neutron-python27-stable-havana/ws/setup.py> py27 create: <https://jenkins02.openstack.org/job/periodic-neutron-python27-stable-havana/ws/.tox/py27> py27 installdeps: -r<https://jenkins02.openstack.org/job/periodic-neutron-python27-stable-havana/ws/requirements.txt,> -r<https://jenkins02.openstack.org/job/periodic-neutron-python27-stable-havana/ws/test-requirements.txt,> setuptools_git>=0.4 py27 inst: <https://jenkins02.openstack.org/job/periodic-neutron-python27-stable-havana/ws/.tox/dist/neutron-jenkins.periodic.neutron.python27.stable.havana.10.zip> py27 runtests: commands[0] | python tools/patch_tox_venv.py py27 runtests: commands[1] | python setup.py testr --slowest --testr-args= running testr <https://jenkins02.openstack.org/job/periodic-neutron-python27-stable-havana/ws/.tox/py27/local/lib/python2.7/site-packages/sqlalchemy/ext/declarative.py>:1341: SAWarning: The classname 'NetworkBinding' is already in the registry of this declarative base, mapped to <class 'neutron.plugins.linuxbridge.db.l2network_models_v2.NetworkBinding'> _as_declarative(cls, classname, cls.__dict__) <https://jenkins02.openstack.org/job/periodic-neutron-python27-stable-havana/ws/.tox/py27/local/lib/python2.7/site-packages/sqlalchemy/ext/declarative.py>:1341: SAWarning: The classname 'NetworkBinding' is already in the registry of this declarative base, mapped to <class 'neutron.plugins.openvswitch.ovs_models_v2.NetworkBinding'> _as_declarative(cls, classname, cls.__dict__) <https://jenkins02.openstack.org/job/periodic-neutron-python27-stable-havana/ws/.tox/py27/local/lib/python2.7/site-packages/sqlalchemy/ext/declarative.py>:1341: SAWarning: The classname 'Credential' is already in the registry of this declarative base, mapped to <class 'neutron.plugins.cisco.db.network_models_v2.Credential'> _as_declarative(cls, classname, cls.__dict__) <https://jenkins02.openstack.org/job/periodic-neutron-python27-stable-havana/ws/.tox/py27/local/lib/python2.7/site-packages/sqlalchemy/ext/declarative.py>:1341: SAWarning: The classname 'NexusPortBinding' is already in the registry of this declarative base, mapped to <class 'neutron.plugins.cisco.db.nexus_models_v2.NexusPortBinding'> _as_declarative(cls, classname, cls.__dict__) <https://jenkins02.openstack.org/job/periodic-neutron-python27-stable-havana/ws/.tox/py27/local/lib/python2.7/site-packages/sqlalchemy/ext/declarative.py>:1341: SAWarning: The classname 'VlanAllocation' is already in the registry of this declarative base, mapped to <class 'neutron.plugins.openvswitch.ovs_models_v2.VlanAllocation'> _as_declarative(cls, classname, cls.__dict__) <https://jenkins02.openstack.org/job/periodic-neutron-python27-stable-havana/ws/.tox/py27/local/lib/python2.7/site-packages/sqlalchemy/ext/declarative.py>:1341: SAWarning: The classname 'NetworkBinding' is already in the registry of this declarative base, mapped to <class 'neutron.plugins.linuxbridge.db.l2network_models_v2.NetworkBinding'> _as_declarative(cls, classname, cls.__dict__) <https://jenkins02.openstack.org/job/periodic-neutron-python27-stable-havana/ws/.tox/py27/local/lib/python2.7/site-packages/sqlalchemy/ext/declarative.py>:1341: SAWarning: The classname 'NetworkBinding' is already in the registry of this declarative base, mapped to <class 'neutron.plugins.openvswitch.ovs_models_v2.NetworkBinding'> _as_declarative(cls, classname, cls.__dict__) <https://jenkins02.openstack.org/job/periodic-neutron-python27-stable-havana/ws/.tox/py27/local/lib/python2.7/site-packages/sqlalchemy/ext/declarative.py>:1341: SAWarning: The classname 'NetworkBinding' is already in the registry of this declarative base, mapped to <class 'neutron.plugins.linuxbridge.db.l2network_models_v2.NetworkBinding'> _as_declarative(cls, classname, cls.__dict__) <https://jenkins02.openstack.org/job/periodic-neutron-python27-stable-havana/ws/.tox/py27/local/lib/python2.7/site-packages/sqlalchemy/ext/declarative.py>:1341: SAWarning: The classname 'NetworkBinding' is already in the registry of this declarative base, mapped to <class 'neutron.plugins.linuxbridge.db.l2network_models_v2.NetworkBinding'> _as_declarative(cls, classname, cls.__dict__) <https://jenkins02.openstack.org/job/periodic-neutron-python27-stable-havana/ws/.tox/py27/local/lib/python2.7/site-packages/sqlalchemy/ext/declarative.py>:1341: SAWarning: The classname 'NetworkBinding' is already in the registry of this declarative base, mapped to <class 'neutron.plugins.linuxbridge.db.l2network_models_v2.NetworkBinding'> _as_declarative(cls, classname, cls.__dict__) <https://jenkins02.openstack.org/job/periodic-neutron-python27-stable-havana/ws/.tox/py27/local/lib/python2.7/site-packages/sqlalchemy/ext/declarative.py>:1341: SAWarning: The classname 'NetworkBinding' is already in the registry of this declarative base, mapped to <class 'neutron.plugins.openvswitch.ovs_models_v2.NetworkBinding'> _as_declarative(cls, classname, cls.__dict__) <https://jenkins02.openstack.org/job/periodic-neutron-python27-stable-havana/ws/.tox/py27/local/lib/python2.7/site-packages/sqlalchemy/ext/declarative.py>:1341: SAWarning: The classname 'NetworkBinding' is already in the registry of this declarative base, mapped to <class 'neutron.plugins.openvswitch.ovs_models_v2.NetworkBinding'> _as_declarative(cls, classname, cls.__dict__) <https://jenkins02.openstack.org/job/periodic-neutron-python27-stable-havana/ws/.tox/py27/local/lib/python2.7/site-packages/sqlalchemy/ext/declarative.py>:1341: SAWarning: The classname 'NetworkBinding' is already in the registry of this declarative base, mapped to <class 'neutron.plugins.openvswitch.ovs_models_v2.NetworkBinding'> _as_declarative(cls, classname, cls.__dict__) <https://jenkins02.openstack.org/job/periodic-neutron-python27-stable-havana/ws/.tox/py27/local/lib/python2.7/site-packages/sqlalchemy/ext/declarative.py>:1341: SAWarning: The classname 'Credential' is already in the registry of this declarative base, mapped to <class 'neutron.plugins.cisco.db.network_models_v2.Credential'> _as_declarative(cls, classname, cls.__dict__) <https://jenkins02.openstack.org/job/periodic-neutron-python27-stable-havana/ws/.tox/py27/local/lib/python2.7/site-packages/sqlalchemy/ext/declarative.py>:1341: SAWarning: The classname 'NexusPortBinding' is already in the registry of this declarative base, mapped to <class 'neutron.plugins.cisco.db.nexus_models_v2.NexusPortBinding'> _as_declarative(cls, classname, cls.__dict__) <https://jenkins02.openstack.org/job/periodic-neutron-python27-stable-havana/ws/.tox/py27/local/lib/python2.7/site-packages/sqlalchemy/ext/declarative.py>:1341: SAWarning: The classname 'VlanAllocation' is already in the registry of this declarative base, mapped to <class 'neutron.plugins.openvswitch.ovs_models_v2.VlanAllocation'> _as_declarative(cls, classname, cls.__dict__) <https://jenkins02.openstack.org/job/periodic-neutron-python27-stable-havana/ws/.tox/py27/local/lib/python2.7/site-packages/sqlalchemy/ext/declarative.py>:1341: SAWarning: The classname 'Credential' is already in the registry of this declarative base, mapped to <class 'neutron.plugins.cisco.db.network_models_v2.Credential'> _as_declarative(cls, classname, cls.__dict__) <https://jenkins02.openstack.org/job/periodic-neutron-python27-stable-havana/ws/.tox/py27/local/lib/python2.7/site-packages/sqlalchemy/ext/declarative.py>:1341: SAWarning: The classname 'NexusPortBinding' is already in the registry of this declarative base, mapped to <class 'neutron.plugins.cisco.db.nexus_models_v2.NexusPortBinding'> _as_declarative(cls, classname, cls.__dict__) <https://jenkins02.openstack.org/job/periodic-neutron-python27-stable-havana/ws/.tox/py27/local/lib/python2.7/site-packages/sqlalchemy/ext/declarative.py>:1341: SAWarning: The classname 'Credential' is already in the registry of this declarative base, mapped to <class 'neutron.plugins.cisco.db.network_models_v2.Credential'> _as_declarative(cls, classname, cls.__dict__) <https://jenkins02.openstack.org/job/periodic-neutron-python27-stable-havana/ws/.tox/py27/local/lib/python2.7/site-packages/sqlalchemy/ext/declarative.py>:1341: SAWarning: The classname 'NexusPortBinding' is already in the registry of this declarative base, mapped to <class 'neutron.plugins.cisco.db.nexus_models_v2.NexusPortBinding'> _as_declarative(cls, classname, cls.__dict__) <https://jenkins02.openstack.org/job/periodic-neutron-python27-stable-havana/ws/.tox/py27/local/lib/python2.7/site-packages/sqlalchemy/ext/declarative.py>:1341: SAWarning: The classname 'Credential' is already in the registry of this declarative base, mapped to <class 'neutron.plugins.cisco.db.network_models_v2.Credential'> _as_declarative(cls, classname, cls.__dict__) <https://jenkins02.openstack.org/job/periodic-neutron-python27-stable-havana/ws/.tox/py27/local/lib/python2.7/site-packages/sqlalchemy/ext/declarative.py>:1341: SAWarning: The classname 'NexusPortBinding' is already in the registry of this declarative base, mapped to <class 'neutron.plugins.cisco.db.nexus_models_v2.NexusPortBinding'> _as_declarative(cls, classname, cls.__dict__) <https://jenkins02.openstack.org/job/periodic-neutron-python27-stable-havana/ws/.tox/py27/local/lib/python2.7/site-packages/sqlalchemy/ext/declarative.py>:1341: SAWarning: The classname 'VlanAllocation' is already in the registry of this declarative base, mapped to <class 'neutron.plugins.openvswitch.ovs_models_v2.VlanAllocation'> _as_declarative(cls, classname, cls.__dict__) <https://jenkins02.openstack.org/job/periodic-neutron-python27-stable-havana/ws/.tox/py27/local/lib/python2.7/site-packages/sqlalchemy/ext/declarative.py>:1341: SAWarning: The classname 'VlanAllocation' is already in the registry of this declarative base, mapped to <class 'neutron.plugins.openvswitch.ovs_models_v2.VlanAllocation'> _as_declarative(cls, classname, cls.__dict__) <https://jenkins02.openstack.org/job/periodic-neutron-python27-stable-havana/ws/.tox/py27/local/lib/python2.7/site-packages/sqlalchemy/ext/declarative.py>:1341: SAWarning: The classname 'VlanAllocation' is already in the registry of this declarative base, mapped to <class 'neutron.plugins.openvswitch.ovs_models_v2.VlanAllocation'> _as_declarative(cls, classname, cls.__dict__) WARNING:neutron.plugins.nicira.nvp_cluster:Deprecated: Attribute 'metadata_dhcp_host_route' has been deprecated or moved to a new section. See new configuration file for details. WARNING:neutron.plugins.nicira.nvp_cluster:Deprecated: Attribute 'nvp_controller_connection' has been deprecated or moved to a new section. See new configuration file for details. WARNING:neutron.plugins.nicira.nvp_cluster:Deprecated: Attribute 'metadata_dhcp_host_route' has been deprecated or moved to a new section. See new configuration file for details. WARNING:neutron.plugins.nicira.nvp_cluster:Deprecated: Attribute 'nvp_controller_connection' has been deprecated or moved to a new section. See new configuration file for details. running=OS_STDOUT_CAPTURE=1 OS_STDERR_CAPTURE=1 OS_LOG_CAPTURE=1 ${PYTHON:-python} -m subunit.run discover -t ./ neutron/tests/unit --list running=OS_STDOUT_CAPTURE=1 OS_STDERR_CAPTURE=1 OS_LOG_CAPTURE=1 ${PYTHON:-python} -m subunit.run discover -t ./ neutron/tests/unit --load-list /tmp/tmp.iZD9mYZQhl/tmp6zpQ98 running=OS_STDOUT_CAPTURE=1 OS_STDERR_CAPTURE=1 OS_LOG_CAPTURE=1 ${PYTHON:-python} -m subunit.run discover -t ./ neutron/tests/unit --load-list /tmp/tmp.iZD9mYZQhl/tmpLu8wbF running=OS_STDOUT_CAPTURE=1 OS_STDERR_CAPTURE=1 OS_LOG_CAPTURE=1 ${PYTHON:-python} -m subunit.run discover -t ./ neutron/tests/unit --load-list /tmp/tmp.iZD9mYZQhl/tmp38NQif running=OS_STDOUT_CAPTURE=1 OS_STDERR_CAPTURE=1 OS_LOG_CAPTURE=1 ${PYTHON:-python} -m subunit.run discover -t ./ neutron/tests/unit --load-list /tmp/tmp.iZD9mYZQhl/tmpvltr17 ====================================================================== FAIL: neutron.tests.unit.nicira.test_nvp_sync.SyncLoopingCallTestCase.test_looping_calls tags: worker-2 ---------------------------------------------------------------------- Empty attachments: pythonlogging:'' stderr stdout Traceback (most recent call last): File "<https://jenkins02.openstack.org/job/periodic-neutron-python27-stable-havana/ws/neutron/tests/unit/nicira/test_nvp_sync.py",> line 254, in test_looping_calls 5, synchronizer._synchronize_state.call_count) File "<https://jenkins02.openstack.org/job/periodic-neutron-python27-stable-havana/ws/.tox/py27/local/lib/python2.7/site-packages/testtools/testcase.py",> line 324, in assertEqual self.assertThat(observed, matcher, message) File "<https://jenkins02.openstack.org/job/periodic-neutron-python27-stable-havana/ws/.tox/py27/local/lib/python2.7/site-packages/testtools/testcase.py",> line 414, in assertThat raise MismatchError(matchee, matcher, mismatch, verbose) MismatchError: 5 != 4 ====================================================================== FAIL: process-returncode tags: worker-2 ---------------------------------------------------------------------- Binary content: traceback (test/plain; charset="utf8") Ran 9387 tests in 1252.712s FAILED (id=0, failures=2, skips=328) error: testr failed (1) ERROR: InvocationError: '<https://jenkins02.openstack.org/job/periodic-neutron-python27-stable-havana/ws/.tox/py27/bin/python> setup.py testr --slowest --testr-args=' ___________________________________ 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 Mako==0.9.0 MarkupSafe==0.18 Paste==1.7.5.1 PasteDeploy==1.5.0 Pygments==1.6 Routes==2.0 SQLAlchemy==0.7.10 Sphinx==1.2b1 WebOb==1.2.3 WebTest==2.0.10 alembic==0.6.1 amqp==1.3.3 amqplib==1.0.2 anyjson==0.3.3 argparse==1.2.1 beautifulsoup4==4.3.2 cliff==1.4.5 cmd2==0.6.7 configobj==4.7.2 coverage==3.7 discover==0.4.0 docutils==0.10 eventlet==0.14.0 extras==0.0.3 fixtures==0.3.14 flake8==2.0 greenlet==0.4.1 hacking==0.7.2 httplib2==0.8 iso8601==0.1.8 jsonrpclib==0.1.3 kombu==3.0.6 mccabe==0.2.1 mock==1.0.1 mox==0.5.3 netaddr==0.7.10 neutron==jenkins.periodic.neutron.python27.stable.havana.10 oslo.config==1.2.1 pbr==0.5.23 pep8==1.4.5 prettytable==0.7.2 pyflakes==0.7.3 pyparsing==2.0.1 python-keystoneclient==0.4.1 python-mimeparse==0.1.4 python-neutronclient==2.3.1 python-novaclient==2.15.0 python-subunit==0.0.15 pytz==2013.8 pyudev==0.16.1 repoze.lru==0.6 requests==2.0.1 setuptools-git==1.0 simplejson==3.3.1 six==1.4.1 stevedore==0.13 testrepository==0.0.18 testtools==0.9.34 waitress==0.8.7 wsgiref==0.1.2 + echo ====================================================================== ====================================================================== + '[' -d .testrepository ']' + '[' -f .testrepository/0.2 ']' + '[' -f .testrepository/0 ']' + .tox/py27/bin/subunit-1to2 + .tox/py27/bin/python /usr/local/jenkins/slave_scripts/subunit2html.py ./subunit_log.txt testr_results.html neutron.tests.unit.nicira.test_nvp_sync.SyncLoopingCallTestCase.test_looping_calls process-returncode + gzip -9 ./subunit_log.txt + gzip -9 ./testr_results.html + 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.iZD9mYZQhl 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-neutron-python27-stable-havana/precise18 [SCP] Trying to create /srv/static/logs/periodic/periodic-neutron-python27-stable-havana/precise18/10 [SCP] Copying console log.