See <https://jenkins.openstack.org/job/periodic-keystone-python27-stable-folsom/232/> ------------------------------------------ [...truncated 831 lines...] Traceback (most recent call last): File "<https://jenkins.openstack.org/job/periodic-keystone-python27-stable-folsom/ws/tests/test_auth_token_middleware.py",> line 556, in test_get_revocation_list_returns_fetched_list self.assertEqual(self.middleware.token_revocation_list, File "<https://jenkins.openstack.org/job/periodic-keystone-python27-stable-folsom/ws/keystone/middleware/auth_token.py",> line 791, in token_revocation_list self.token_revocation_list = self.fetch_revocation_list() File "<https://jenkins.openstack.org/job/periodic-keystone-python27-stable-folsom/ws/keystone/middleware/auth_token.py",> line 820, in fetch_revocation_list return self.cms_verify(data['signed']) File "<https://jenkins.openstack.org/job/periodic-keystone-python27-stable-folsom/ws/keystone/middleware/auth_token.py",> line 751, in cms_verify raise err CalledProcessError: Command 'openssl' returned non-zero exit status 4 -------------------- >> begin captured logging << -------------------- keystone.middleware.auth_token: INFO: Starting keystone auth_token middleware keystone.middleware.auth_token: INFO: Using signing as cache directory for signing certificate keystone.middleware.auth_token: WARNING: signing_dir mode is 0775 instead of 0700 keystone.common.cms: ERROR: Verify error: Verification failure 139937516246688:error:2E099064:CMS routines:CMS_SIGNERINFO_VERIFY_CERT:certificate verify error:cms_smime.c:304:Verify error:certificate has expired --------------------- >> end captured logging << --------------------- ====================================================================== ERROR: test_verify_signed_token_succeeds_for_unrevoked_token (test_auth_token_middleware.AuthTokenMiddlewareTest) ---------------------------------------------------------------------- Traceback (most recent call last): File "<https://jenkins.openstack.org/job/periodic-keystone-python27-stable-folsom/ws/tests/test_auth_token_middleware.py",> line 533, in test_verify_signed_token_succeeds_for_unrevoked_token self.middleware.verify_signed_token(SIGNED_TOKEN_SCOPED) File "<https://jenkins.openstack.org/job/periodic-keystone-python27-stable-folsom/ws/keystone/middleware/auth_token.py",> line 760, in verify_signed_token return self.cms_verify(formatted) File "<https://jenkins.openstack.org/job/periodic-keystone-python27-stable-folsom/ws/keystone/middleware/auth_token.py",> line 751, in cms_verify raise err CalledProcessError: Command 'openssl' returned non-zero exit status 4 -------------------- >> begin captured logging << -------------------- keystone.middleware.auth_token: INFO: Starting keystone auth_token middleware keystone.middleware.auth_token: INFO: Using signing as cache directory for signing certificate keystone.middleware.auth_token: WARNING: signing_dir mode is 0775 instead of 0700 keystone.common.cms: ERROR: Verify error: Verification failure 140153044399776:error:2E099064:CMS routines:CMS_SIGNERINFO_VERIFY_CERT:certificate verify error:cms_smime.c:304:Verify error:certificate has expired --------------------- >> end captured logging << --------------------- ====================================================================== ERROR: test_fetch_revocation_list_with_expire (test_auth_token_middleware.StackResponseAuthTokenMiddlewareTest) ---------------------------------------------------------------------- Traceback (most recent call last): File "<https://jenkins.openstack.org/job/periodic-keystone-python27-stable-folsom/ws/tests/test_auth_token_middleware.py",> line 422, in test_fetch_revocation_list_with_expire fetched_list = jsonutils.loads(self.middleware.fetch_revocation_list()) File "<https://jenkins.openstack.org/job/periodic-keystone-python27-stable-folsom/ws/keystone/middleware/auth_token.py",> line 820, in fetch_revocation_list return self.cms_verify(data['signed']) File "<https://jenkins.openstack.org/job/periodic-keystone-python27-stable-folsom/ws/keystone/middleware/auth_token.py",> line 751, in cms_verify raise err CalledProcessError: Command 'openssl' returned non-zero exit status 4 -------------------- >> begin captured logging << -------------------- keystone.middleware.auth_token: INFO: Starting keystone auth_token middleware keystone.middleware.auth_token: INFO: Using signing as cache directory for signing certificate keystone.middleware.auth_token: WARNING: signing_dir mode is 0775 instead of 0700 keystone.common.cms: ERROR: Verify error: Verification failure 140597125473952:error:2E099064:CMS routines:CMS_SIGNERINFO_VERIFY_CERT:certificate verify error:cms_smime.c:304:Verify error:certificate has expired --------------------- >> end captured logging << --------------------- ====================================================================== FAIL: test_default_tenant_signed_token (test_auth_token_middleware.AuthTokenMiddlewareTest) ---------------------------------------------------------------------- Traceback (most recent call last): File "<https://jenkins.openstack.org/job/periodic-keystone-python27-stable-folsom/ws/tests/test_auth_token_middleware.py",> line 483, in test_default_tenant_signed_token self.assert_unscoped_default_tenant_auto_scopes(SIGNED_TOKEN_SCOPED) File "<https://jenkins.openstack.org/job/periodic-keystone-python27-stable-folsom/ws/tests/test_auth_token_middleware.py",> line 476, in assert_unscoped_default_tenant_auto_scopes self.assertEqual(self.response_status, 200) AssertionError: 401 != 200 -------------------- >> begin captured logging << -------------------- keystone.middleware.auth_token: INFO: Starting keystone auth_token middleware keystone.middleware.auth_token: INFO: Using signing as cache directory for signing certificate keystone.middleware.auth_token: WARNING: signing_dir mode is 0775 instead of 0700 keystone.middleware.auth_token: DEBUG: Authenticating user token keystone.middleware.auth_token: DEBUG: Removing headers from request environment: X-Identity-Status,X-Tenant-Id,X-Tenant-Name,X-User-Id,X-User-Name,X-Roles,X-Service-Catalog,X-User,X-Tenant,X-Role keystone.common.cms: ERROR: Verify error: Verification failure 139727274346144:error:2E099064:CMS routines:CMS_SIGNERINFO_VERIFY_CERT:certificate verify error:cms_smime.c:304:Verify error:certificate has expired keystone.middleware.auth_token: DEBUG: Token validation failure. Traceback (most recent call last): File "<https://jenkins.openstack.org/job/periodic-keystone-python27-stable-folsom/ws/keystone/middleware/auth_token.py",> line 511, in _validate_user_token verified = self.verify_signed_token(user_token) File "<https://jenkins.openstack.org/job/periodic-keystone-python27-stable-folsom/ws/keystone/middleware/auth_token.py",> line 760, in verify_signed_token return self.cms_verify(formatted) File "<https://jenkins.openstack.org/job/periodic-keystone-python27-stable-folsom/ws/keystone/middleware/auth_token.py",> line 751, in cms_verify raise err CalledProcessError: Command 'openssl' returned non-zero exit status 4 keystone.middleware.auth_token: WARNING: Authorization failed for token MIIG7QYJKoZIhvcNAQcCoIIG3jCCBtoCAQExCTAHBgUrDgMCGjCCBc4GCSqGSIb3DQEHAaCCBb8EggW7eyJhY2Nlc3MiOiB7InNlcnZpY2VDYXRhbG9nIjogW3siZW5kcG9pbnRzIjogW3siYWRtaW5VUkwiOiAiaHR0cDovLzEyNy4wLjAuMTo4Nzc2L3YxLzY0YjZmM2ZiY2M1MzQzNWU4YTYwZmNmODliYjY2MTdhIiwgInJlZ2lvbiI6ICJyZWdpb25PbmUiLCAiaW50ZXJuYWxVUkwiOiAiaHR0cDovLzEyNy4wLjAuMTo4Nzc2L3YxLzY0YjZmM2ZiY2M1MzQzNWU4YTYwZmNmODliYjY2MTdhIiwgInB1YmxpY1VSTCI6ICJodHRwOi8vMTI3LjAuMC4xOjg3NzYvdjEvNjRiNmYzZmJjYzUzNDM1ZThhNjBmY2Y4OWJiNjYxN2EifV0sICJlbmRwb2ludHNfbGlua3MiOiBbXSwgInR5cGUiOiAidm9sdW1lIiwgIm5hbWUiOiAidm9sdW1lIn0sIHsiZW5kcG9pbnRzIjogW3siYWRtaW5VUkwiOiAiaHR0cDovLzEyNy4wLjAuMTo5MjkyL3YxIiwgInJlZ2lvbiI6ICJyZWdpb25PbmUiLCAiaW50ZXJuYWxVUkwiOiAiaHR0cDovLzEyNy4wLjAuMTo5MjkyL3YxIiwgInB1YmxpY1VSTCI6ICJodHRwOi8vMTI3LjAuMC4xOjkyOTIvdjEifV0sICJlbmRwb2ludHNfbGlua3MiOiBbXSwgInR5cGUiOiAiaW1hZ2UiLCAibmFtZSI6ICJnbGFuY2UifSwgeyJlbmRwb2ludHMiOiBbeyJhZG1pblVSTCI6ICJodHRwOi8vMTI3LjAuMC4xOjg3NzQvdjEuMS82NGI2ZjNmYmNjNTM0MzVlOGE2MGZjZjg5YmI2NjE3YSIsICJyZWdpb24iOiAicmVnaW9uT25lIiwgImludGVybmFsVVJMIjogImh0dHA6Ly8xMjcuMC4wLjE6ODc3NC92MS4xLzY0YjZmM2ZiY2M1MzQzNWU4YTYwZmNmODliYjY2MTdhIiwgInB1YmxpY1VSTCI6ICJodHRwOi8vMTI3LjAuMC4xOjg3NzQvdjEuMS82NGI2ZjNmYmNjNTM0MzVlOGE2MGZjZjg5YmI2NjE3YSJ9XSwgImVuZHBvaW50c19saW5rcyI6IFtdLCAidHlwZSI6ICJjb21wdXRlIiwgIm5hbWUiOiAibm92YSJ9LCB7ImVuZHBvaW50cyI6IFt7ImFkbWluVVJMIjogImh0dHA6Ly8xMjcuMC4wLjE6MzUzNTcvdjIuMCIsICJyZWdpb24iOiAiUmVnaW9uT25lIiwgImludGVybmFsVVJMIjogImh0dHA6Ly8xMjcuMC4wLjE6MzUzNTcvdjIuMCIsICJwdWJsaWNVUkwiOiAiaHR0cDovLzEyNy4wLjAuMTo1MDAwL3YyLjAifV0sICJlbmRwb2ludHNfbGlua3MiOiBbXSwgInR5cGUiOiAiaWRlbnRpdHkiLCAibmFtZSI6ICJrZXlzdG9uZSJ9XSwidG9rZW4iOiB7ImV4cGlyZXMiOiAiMjAxMi0wNi0wMlQxNDo0NzozNFoiLCAiaWQiOiAicGxhY2Vob2xkZXIiLCAidGVuYW50IjogeyJlbmFibGVkIjogdHJ1ZSwgImRlc2NyaXB0aW9uIjogbnVsbCwgIm5hbWUiOiAidGVuYW50X25hbWUxIiwgImlkIjogInRlbmFudF9pZDEifX0sICJ1c2VyIjogeyJ1c2VybmFtZSI6ICJ1c2VyX25hbWUxIiwgInJvbGVzX2xpbmtzIjogWyJyb2xlMSIsInJvbGUyIl0sICJpZCI6ICJ1c2VyX2lkMSIsICJyb2xlcyI6IFt7Im5hbWUiOiAicm9sZTEifSwgeyJuYW1lIjogInJvbGUyIn1dLCAibmFtZSI6ICJ1c2VyX25hbWUxIn19fQ0KMYH3MIH0AgEBMFQwTzEVMBMGA1UEChMMUmVkIEhhdCwgSW5jMREwDwYDVQQHEwhXZXN0Zm9yZDEWMBQGA1UECBMNTWFzc2FjaHVzZXR0czELMAkGA1UEBhMCVVMCAQEwBwYFKw4DAhowDQYJKoZIhvcNAQEBBQAEgYAD6hPEpc-0wHe3rYDBFec52h7gxdbrTNEN7jmwdFtoxw0QnucmCREh9IUikJ2ob0c0uUC6cmNPajD9aFkGWhvNswNH2W2BYzUiC3CHM7U07nsIe3OOatqyUAyoQUhHZnIAx1tOgdPBVflnrtdIV1vkdqxednlJZ52Hxob2PP3hxg== keystone.middleware.auth_token: INFO: Invalid user token - rejecting request --------------------- >> end captured logging << --------------------- ====================================================================== FAIL: test_memcache_set_expired (test_auth_token_middleware.AuthTokenMiddlewareTest) ---------------------------------------------------------------------- Traceback (most recent call last): File "<https://jenkins.openstack.org/job/periodic-keystone-python27-stable-folsom/ws/tests/test_auth_token_middleware.py",> line 629, in test_memcache_set_expired self.assertEqual(len(self.middleware._cache.set_value), 2) AssertionError: 7 != 2 -------------------- >> begin captured logging << -------------------- keystone.middleware.auth_token: INFO: Starting keystone auth_token middleware keystone.middleware.auth_token: INFO: Using signing as cache directory for signing certificate keystone.middleware.auth_token: WARNING: signing_dir mode is 0775 instead of 0700 keystone.middleware.auth_token: DEBUG: Authenticating user token keystone.middleware.auth_token: DEBUG: Removing headers from request environment: X-Identity-Status,X-Tenant-Id,X-Tenant-Name,X-User-Id,X-User-Name,X-Roles,X-Service-Catalog,X-User,X-Tenant,X-Role keystone.middleware.auth_token: DEBUG: Cached Token 9bba6849c9e1f77727ae7813fd151115 seems expired keystone.common.cms: ERROR: Verify error: Verification failure 139742296307360:error:2E099064:CMS routines:CMS_SIGNERINFO_VERIFY_CERT:certificate verify error:cms_smime.c:304:Verify error:certificate has expired keystone.middleware.auth_token: DEBUG: Token validation failure. Traceback (most recent call last): File "<https://jenkins.openstack.org/job/periodic-keystone-python27-stable-folsom/ws/keystone/middleware/auth_token.py",> line 511, in _validate_user_token verified = self.verify_signed_token(user_token) File "<https://jenkins.openstack.org/job/periodic-keystone-python27-stable-folsom/ws/keystone/middleware/auth_token.py",> line 760, in verify_signed_token return self.cms_verify(formatted) File "<https://jenkins.openstack.org/job/periodic-keystone-python27-stable-folsom/ws/keystone/middleware/auth_token.py",> line 751, in cms_verify raise err CalledProcessError: Command 'openssl' returned non-zero exit status 4 keystone.middleware.auth_token: DEBUG: Marking token MIIG7QYJKoZIhvcNAQcCoIIG3jCCBtoCAQExCTAHBgUrDgMCGjCCBc4GCSqGSIb3DQEHAaCCBb8EggW7eyJhY2Nlc3MiOiB7InNlcnZpY2VDYXRhbG9nIjogW3siZW5kcG9pbnRzIjogW3siYWRtaW5VUkwiOiAiaHR0cDovLzEyNy4wLjAuMTo4Nzc2L3YxLzY0YjZmM2ZiY2M1MzQzNWU4YTYwZmNmODliYjY2MTdhIiwgInJlZ2lvbiI6ICJyZWdpb25PbmUiLCAiaW50ZXJuYWxVUkwiOiAiaHR0cDovLzEyNy4wLjAuMTo4Nzc2L3YxLzY0YjZmM2ZiY2M1MzQzNWU4YTYwZmNmODliYjY2MTdhIiwgInB1YmxpY1VSTCI6ICJodHRwOi8vMTI3LjAuMC4xOjg3NzYvdjEvNjRiNmYzZmJjYzUzNDM1ZThhNjBmY2Y4OWJiNjYxN2EifV0sICJlbmRwb2ludHNfbGlua3MiOiBbXSwgInR5cGUiOiAidm9sdW1lIiwgIm5hbWUiOiAidm9sdW1lIn0sIHsiZW5kcG9pbnRzIjogW3siYWRtaW5VUkwiOiAiaHR0cDovLzEyNy4wLjAuMTo5MjkyL3YxIiwgInJlZ2lvbiI6ICJyZWdpb25PbmUiLCAiaW50ZXJuYWxVUkwiOiAiaHR0cDovLzEyNy4wLjAuMTo5MjkyL3YxIiwgInB1YmxpY1VSTCI6ICJodHRwOi8vMTI3LjAuMC4xOjkyOTIvdjEifV0sICJlbmRwb2ludHNfbGlua3MiOiBbXSwgInR5cGUiOiAiaW1hZ2UiLCAibmFtZSI6ICJnbGFuY2UifSwgeyJlbmRwb2ludHMiOiBbeyJhZG1pblVSTCI6ICJodHRwOi8vMTI3LjAuMC4xOjg3NzQvdjEuMS82NGI2ZjNmYmNjNTM0MzVlOGE2MGZjZjg5YmI2NjE3YSIsICJyZWdpb24iOiAicmVnaW9uT25lIiwgImludGVybmFsVVJMIjogImh0dHA6Ly8xMjcuMC4wLjE6ODc3NC92MS4xLzY0YjZmM2ZiY2M1MzQzNWU4YTYwZmNmODliYjY2MTdhIiwgInB1YmxpY1VSTCI6ICJodHRwOi8vMTI3LjAuMC4xOjg3NzQvdjEuMS82NGI2ZjNmYmNjNTM0MzVlOGE2MGZjZjg5YmI2NjE3YSJ9XSwgImVuZHBvaW50c19saW5rcyI6IFtdLCAidHlwZSI6ICJjb21wdXRlIiwgIm5hbWUiOiAibm92YSJ9LCB7ImVuZHBvaW50cyI6IFt7ImFkbWluVVJMIjogImh0dHA6Ly8xMjcuMC4wLjE6MzUzNTcvdjIuMCIsICJyZWdpb24iOiAiUmVnaW9uT25lIiwgImludGVybmFsVVJMIjogImh0dHA6Ly8xMjcuMC4wLjE6MzUzNTcvdjIuMCIsICJwdWJsaWNVUkwiOiAiaHR0cDovLzEyNy4wLjAuMTo1MDAwL3YyLjAifV0sICJlbmRwb2ludHNfbGlua3MiOiBbXSwgInR5cGUiOiAiaWRlbnRpdHkiLCAibmFtZSI6ICJrZXlzdG9uZSJ9XSwidG9rZW4iOiB7ImV4cGlyZXMiOiAiMjAxMi0wNi0wMlQxNDo0NzozNFoiLCAiaWQiOiAicGxhY2Vob2xkZXIiLCAidGVuYW50IjogeyJlbmFibGVkIjogdHJ1ZSwgImRlc2NyaXB0aW9uIjogbnVsbCwgIm5hbWUiOiAidGVuYW50X25hbWUxIiwgImlkIjogInRlbmFudF9pZDEifX0sICJ1c2VyIjogeyJ1c2VybmFtZSI6ICJ1c2VyX25hbWUxIiwgInJvbGVzX2xpbmtzIjogWyJyb2xlMSIsInJvbGUyIl0sICJpZCI6ICJ1c2VyX2lkMSIsICJyb2xlcyI6IFt7Im5hbWUiOiAicm9sZTEifSwgeyJuYW1lIjogInJvbGUyIn1dLCAibmFtZSI6ICJ1c2VyX25hbWUxIn19fQ0KMYH3MIH0AgEBMFQwTzEVMBMGA1UEChMMUmVkIEhhdCwgSW5jMREwDwYDVQQHEwhXZXN0Zm9yZDEWMBQGA1UECBMNTWFzc2FjaHVzZXR0czELMAkGA1UEBhMCVVMCAQEwBwYFKw4DAhowDQYJKoZIhvcNAQEBBQAEgYAD6hPEpc-0wHe3rYDBFec52h7gxdbrTNEN7jmwdFtoxw0QnucmCREh9IUikJ2ob0c0uUC6cmNPajD9aFkGWhvNswNH2W2BYzUiC3CHM7U07nsIe3OOatqyUAyoQUhHZnIAx1tOgdPBVflnrtdIV1vkdqxednlJZ52Hxob2PP3hxg== as unauthorized in memcache keystone.middleware.auth_token: WARNING: Authorization failed for token MIIG7QYJKoZIhvcNAQcCoIIG3jCCBtoCAQExCTAHBgUrDgMCGjCCBc4GCSqGSIb3DQEHAaCCBb8EggW7eyJhY2Nlc3MiOiB7InNlcnZpY2VDYXRhbG9nIjogW3siZW5kcG9pbnRzIjogW3siYWRtaW5VUkwiOiAiaHR0cDovLzEyNy4wLjAuMTo4Nzc2L3YxLzY0YjZmM2ZiY2M1MzQzNWU4YTYwZmNmODliYjY2MTdhIiwgInJlZ2lvbiI6ICJyZWdpb25PbmUiLCAiaW50ZXJuYWxVUkwiOiAiaHR0cDovLzEyNy4wLjAuMTo4Nzc2L3YxLzY0YjZmM2ZiY2M1MzQzNWU4YTYwZmNmODliYjY2MTdhIiwgInB1YmxpY1VSTCI6ICJodHRwOi8vMTI3LjAuMC4xOjg3NzYvdjEvNjRiNmYzZmJjYzUzNDM1ZThhNjBmY2Y4OWJiNjYxN2EifV0sICJlbmRwb2ludHNfbGlua3MiOiBbXSwgInR5cGUiOiAidm9sdW1lIiwgIm5hbWUiOiAidm9sdW1lIn0sIHsiZW5kcG9pbnRzIjogW3siYWRtaW5VUkwiOiAiaHR0cDovLzEyNy4wLjAuMTo5MjkyL3YxIiwgInJlZ2lvbiI6ICJyZWdpb25PbmUiLCAiaW50ZXJuYWxVUkwiOiAiaHR0cDovLzEyNy4wLjAuMTo5MjkyL3YxIiwgInB1YmxpY1VSTCI6ICJodHRwOi8vMTI3LjAuMC4xOjkyOTIvdjEifV0sICJlbmRwb2ludHNfbGlua3MiOiBbXSwgInR5cGUiOiAiaW1hZ2UiLCAibmFtZSI6ICJnbGFuY2UifSwgeyJlbmRwb2ludHMiOiBbeyJhZG1pblVSTCI6ICJodHRwOi8vMTI3LjAuMC4xOjg3NzQvdjEuMS82NGI2ZjNmYmNjNTM0MzVlOGE2MGZjZjg5YmI2NjE3YSIsICJyZWdpb24iOiAicmVnaW9uT25lIiwgImludGVybmFsVVJMIjogImh0dHA6Ly8xMjcuMC4wLjE6ODc3NC92MS4xLzY0YjZmM2ZiY2M1MzQzNWU4YTYwZmNmODliYjY2MTdhIiwgInB1YmxpY1VSTCI6ICJodHRwOi8vMTI3LjAuMC4xOjg3NzQvdjEuMS82NGI2ZjNmYmNjNTM0MzVlOGE2MGZjZjg5YmI2NjE3YSJ9XSwgImVuZHBvaW50c19saW5rcyI6IFtdLCAidHlwZSI6ICJjb21wdXRlIiwgIm5hbWUiOiAibm92YSJ9LCB7ImVuZHBvaW50cyI6IFt7ImFkbWluVVJMIjogImh0dHA6Ly8xMjcuMC4wLjE6MzUzNTcvdjIuMCIsICJyZWdpb24iOiAiUmVnaW9uT25lIiwgImludGVybmFsVVJMIjogImh0dHA6Ly8xMjcuMC4wLjE6MzUzNTcvdjIuMCIsICJwdWJsaWNVUkwiOiAiaHR0cDovLzEyNy4wLjAuMTo1MDAwL3YyLjAifV0sICJlbmRwb2ludHNfbGlua3MiOiBbXSwgInR5cGUiOiAiaWRlbnRpdHkiLCAibmFtZSI6ICJrZXlzdG9uZSJ9XSwidG9rZW4iOiB7ImV4cGlyZXMiOiAiMjAxMi0wNi0wMlQxNDo0NzozNFoiLCAiaWQiOiAicGxhY2Vob2xkZXIiLCAidGVuYW50IjogeyJlbmFibGVkIjogdHJ1ZSwgImRlc2NyaXB0aW9uIjogbnVsbCwgIm5hbWUiOiAidGVuYW50X25hbWUxIiwgImlkIjogInRlbmFudF9pZDEifX0sICJ1c2VyIjogeyJ1c2VybmFtZSI6ICJ1c2VyX25hbWUxIiwgInJvbGVzX2xpbmtzIjogWyJyb2xlMSIsInJvbGUyIl0sICJpZCI6ICJ1c2VyX2lkMSIsICJyb2xlcyI6IFt7Im5hbWUiOiAicm9sZTEifSwgeyJuYW1lIjogInJvbGUyIn1dLCAibmFtZSI6ICJ1c2VyX25hbWUxIn19fQ0KMYH3MIH0AgEBMFQwTzEVMBMGA1UEChMMUmVkIEhhdCwgSW5jMREwDwYDVQQHEwhXZXN0Zm9yZDEWMBQGA1UECBMNTWFzc2FjaHVzZXR0czELMAkGA1UEBhMCVVMCAQEwBwYFKw4DAhowDQYJKoZIhvcNAQEBBQAEgYAD6hPEpc-0wHe3rYDBFec52h7gxdbrTNEN7jmwdFtoxw0QnucmCREh9IUikJ2ob0c0uUC6cmNPajD9aFkGWhvNswNH2W2BYzUiC3CHM7U07nsIe3OOatqyUAyoQUhHZnIAx1tOgdPBVflnrtdIV1vkdqxednlJZ52Hxob2PP3hxg== keystone.middleware.auth_token: INFO: Invalid user token - rejecting request --------------------- >> end captured logging << --------------------- ====================================================================== FAIL: test_valid_signed_request (test_auth_token_middleware.AuthTokenMiddlewareTest) ---------------------------------------------------------------------- Traceback (most recent call last): File "<https://jenkins.openstack.org/job/periodic-keystone-python27-stable-folsom/ws/tests/test_auth_token_middleware.py",> line 461, in test_valid_signed_request self.assert_valid_request_200(SIGNED_TOKEN_SCOPED) File "<https://jenkins.openstack.org/job/periodic-keystone-python27-stable-folsom/ws/tests/test_auth_token_middleware.py",> line 450, in assert_valid_request_200 self.assertEqual(self.response_status, 200) AssertionError: 401 != 200 -------------------- >> begin captured logging << -------------------- keystone.middleware.auth_token: INFO: Starting keystone auth_token middleware keystone.middleware.auth_token: INFO: Using signing as cache directory for signing certificate keystone.middleware.auth_token: WARNING: signing_dir mode is 0775 instead of 0700 keystone.middleware.auth_token: DEBUG: Authenticating user token keystone.middleware.auth_token: DEBUG: Removing headers from request environment: X-Identity-Status,X-Tenant-Id,X-Tenant-Name,X-User-Id,X-User-Name,X-Roles,X-Service-Catalog,X-User,X-Tenant,X-Role keystone.common.cms: ERROR: Verify error: Verification failure 140540724024992:error:2E099064:CMS routines:CMS_SIGNERINFO_VERIFY_CERT:certificate verify error:cms_smime.c:304:Verify error:certificate has expired keystone.middleware.auth_token: DEBUG: Token validation failure. Traceback (most recent call last): File "<https://jenkins.openstack.org/job/periodic-keystone-python27-stable-folsom/ws/keystone/middleware/auth_token.py",> line 511, in _validate_user_token verified = self.verify_signed_token(user_token) File "<https://jenkins.openstack.org/job/periodic-keystone-python27-stable-folsom/ws/keystone/middleware/auth_token.py",> line 760, in verify_signed_token return self.cms_verify(formatted) File "<https://jenkins.openstack.org/job/periodic-keystone-python27-stable-folsom/ws/keystone/middleware/auth_token.py",> line 751, in cms_verify raise err CalledProcessError: Command 'openssl' returned non-zero exit status 4 keystone.middleware.auth_token: WARNING: Authorization failed for token MIIG7QYJKoZIhvcNAQcCoIIG3jCCBtoCAQExCTAHBgUrDgMCGjCCBc4GCSqGSIb3DQEHAaCCBb8EggW7eyJhY2Nlc3MiOiB7InNlcnZpY2VDYXRhbG9nIjogW3siZW5kcG9pbnRzIjogW3siYWRtaW5VUkwiOiAiaHR0cDovLzEyNy4wLjAuMTo4Nzc2L3YxLzY0YjZmM2ZiY2M1MzQzNWU4YTYwZmNmODliYjY2MTdhIiwgInJlZ2lvbiI6ICJyZWdpb25PbmUiLCAiaW50ZXJuYWxVUkwiOiAiaHR0cDovLzEyNy4wLjAuMTo4Nzc2L3YxLzY0YjZmM2ZiY2M1MzQzNWU4YTYwZmNmODliYjY2MTdhIiwgInB1YmxpY1VSTCI6ICJodHRwOi8vMTI3LjAuMC4xOjg3NzYvdjEvNjRiNmYzZmJjYzUzNDM1ZThhNjBmY2Y4OWJiNjYxN2EifV0sICJlbmRwb2ludHNfbGlua3MiOiBbXSwgInR5cGUiOiAidm9sdW1lIiwgIm5hbWUiOiAidm9sdW1lIn0sIHsiZW5kcG9pbnRzIjogW3siYWRtaW5VUkwiOiAiaHR0cDovLzEyNy4wLjAuMTo5MjkyL3YxIiwgInJlZ2lvbiI6ICJyZWdpb25PbmUiLCAiaW50ZXJuYWxVUkwiOiAiaHR0cDovLzEyNy4wLjAuMTo5MjkyL3YxIiwgInB1YmxpY1VSTCI6ICJodHRwOi8vMTI3LjAuMC4xOjkyOTIvdjEifV0sICJlbmRwb2ludHNfbGlua3MiOiBbXSwgInR5cGUiOiAiaW1hZ2UiLCAibmFtZSI6ICJnbGFuY2UifSwgeyJlbmRwb2ludHMiOiBbeyJhZG1pblVSTCI6ICJodHRwOi8vMTI3LjAuMC4xOjg3NzQvdjEuMS82NGI2ZjNmYmNjNTM0MzVlOGE2MGZjZjg5YmI2NjE3YSIsICJyZWdpb24iOiAicmVnaW9uT25lIiwgImludGVybmFsVVJMIjogImh0dHA6Ly8xMjcuMC4wLjE6ODc3NC92MS4xLzY0YjZmM2ZiY2M1MzQzNWU4YTYwZmNmODliYjY2MTdhIiwgInB1YmxpY1VSTCI6ICJodHRwOi8vMTI3LjAuMC4xOjg3NzQvdjEuMS82NGI2ZjNmYmNjNTM0MzVlOGE2MGZjZjg5YmI2NjE3YSJ9XSwgImVuZHBvaW50c19saW5rcyI6IFtdLCAidHlwZSI6ICJjb21wdXRlIiwgIm5hbWUiOiAibm92YSJ9LCB7ImVuZHBvaW50cyI6IFt7ImFkbWluVVJMIjogImh0dHA6Ly8xMjcuMC4wLjE6MzUzNTcvdjIuMCIsICJyZWdpb24iOiAiUmVnaW9uT25lIiwgImludGVybmFsVVJMIjogImh0dHA6Ly8xMjcuMC4wLjE6MzUzNTcvdjIuMCIsICJwdWJsaWNVUkwiOiAiaHR0cDovLzEyNy4wLjAuMTo1MDAwL3YyLjAifV0sICJlbmRwb2ludHNfbGlua3MiOiBbXSwgInR5cGUiOiAiaWRlbnRpdHkiLCAibmFtZSI6ICJrZXlzdG9uZSJ9XSwidG9rZW4iOiB7ImV4cGlyZXMiOiAiMjAxMi0wNi0wMlQxNDo0NzozNFoiLCAiaWQiOiAicGxhY2Vob2xkZXIiLCAidGVuYW50IjogeyJlbmFibGVkIjogdHJ1ZSwgImRlc2NyaXB0aW9uIjogbnVsbCwgIm5hbWUiOiAidGVuYW50X25hbWUxIiwgImlkIjogInRlbmFudF9pZDEifX0sICJ1c2VyIjogeyJ1c2VybmFtZSI6ICJ1c2VyX25hbWUxIiwgInJvbGVzX2xpbmtzIjogWyJyb2xlMSIsInJvbGUyIl0sICJpZCI6ICJ1c2VyX2lkMSIsICJyb2xlcyI6IFt7Im5hbWUiOiAicm9sZTEifSwgeyJuYW1lIjogInJvbGUyIn1dLCAibmFtZSI6ICJ1c2VyX25hbWUxIn19fQ0KMYH3MIH0AgEBMFQwTzEVMBMGA1UEChMMUmVkIEhhdCwgSW5jMREwDwYDVQQHEwhXZXN0Zm9yZDEWMBQGA1UECBMNTWFzc2FjaHVzZXR0czELMAkGA1UEBhMCVVMCAQEwBwYFKw4DAhowDQYJKoZIhvcNAQEBBQAEgYAD6hPEpc-0wHe3rYDBFec52h7gxdbrTNEN7jmwdFtoxw0QnucmCREh9IUikJ2ob0c0uUC6cmNPajD9aFkGWhvNswNH2W2BYzUiC3CHM7U07nsIe3OOatqyUAyoQUhHZnIAx1tOgdPBVflnrtdIV1vkdqxednlJZ52Hxob2PP3hxg== keystone.middleware.auth_token: INFO: Invalid user token - rejecting request --------------------- >> end captured logging << --------------------- ---------------------------------------------------------------------- XML: nosetests.xml Slowest 5 tests took 7.66 secs:  1.67 KcMasterTestCase.test_admin_requires_adminness  1.66 KcEssex3TestCase.test_admin_requires_adminness  1.61 Kc11TestCase.test_admin_requires_adminness  1.51 TokenExpirationTest.test_maintain_uuid_token_expiration  1.20 KcMasterSqlTestCase.test_token_expiry_maintained ---------------------------------------------------------------------- Ran 701 tests in 55.346s FAILED (SKIP=11, errors=4, failures=3) ERROR: InvocationError: '/bin/bash run_tests.sh -N --no-pep8' ___________________________________ 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.16 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 WebTest==2.0.2 argparse==1.2.1 beautifulsoup4==4.1.3 colorama==0.2.5 coverage==3.6 decorator==3.4.0 distribute==0.6.34 dnspython==1.10.0 docutils==0.10 eventlet==0.12.1 greenlet==0.4.0 httplib2==0.8 iso8601==0.1.4 keystone==2012.2.5 logilab-astng==0.24.3 logilab-common==0.59.1 lxml==3.2.1 mox==0.5.3 netifaces==0.8 nose==1.3.0 nosehtmloutput==0.0.4 nosexcover==1.0.8 openstack.nose-plugin==0.11 pam==0.1.4 passlib==1.6.1 pep8==1.3.3 prettytable==0.7.2 pylint==0.27.0 python-keystoneclient==0.1.3 python-ldap==2.3.13 python-memcached==1.51 python-swiftclient==1.4.0 repoze.lru==0.6 simplejson==3.3.0 six==1.3.0 sqlalchemy-migrate==0.7.2 swift==1.8.1 termcolor==1.1.0 unittest2==0.5.1 waitress==0.8.2 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=./tests/nose_results.html + '[' -f ./tests/nose_results.html ']' ++ grep -c 'tr class=.passClass' ./tests/nose_results.html + passcount=43 + '[' 43 -eq 0 ']' + exit 1 + rm -rf /tmp/tmp.tvXz1AhJ7O Build step 'Execute shell' marked build as failure [SCP] Connecting to static.openstack.org [SCP] Trying to create /srv/static/logs/periodic/periodic-keystone-python27-stable-folsom/232 [SCP] uploading file: '/srv/static/logs/periodic/periodic-keystone-python27-stable-folsom/232/nose_results.html' [SCP] Connecting to static.openstack.org [SCP] Copying console log.

See <https://jenkins.openstack.org/job/periodic-keystone-python27-stable-folsom/234/> ------------------------------------------ [...truncated 831 lines...] Traceback (most recent call last): File "<https://jenkins.openstack.org/job/periodic-keystone-python27-stable-folsom/ws/tests/test_auth_token_middleware.py",> line 556, in test_get_revocation_list_returns_fetched_list self.assertEqual(self.middleware.token_revocation_list, File "<https://jenkins.openstack.org/job/periodic-keystone-python27-stable-folsom/ws/keystone/middleware/auth_token.py",> line 791, in token_revocation_list self.token_revocation_list = self.fetch_revocation_list() File "<https://jenkins.openstack.org/job/periodic-keystone-python27-stable-folsom/ws/keystone/middleware/auth_token.py",> line 820, in fetch_revocation_list return self.cms_verify(data['signed']) File "<https://jenkins.openstack.org/job/periodic-keystone-python27-stable-folsom/ws/keystone/middleware/auth_token.py",> line 751, in cms_verify raise err CalledProcessError: Command 'openssl' returned non-zero exit status 4 -------------------- >> begin captured logging << -------------------- keystone.middleware.auth_token: INFO: Starting keystone auth_token middleware keystone.middleware.auth_token: INFO: Using signing as cache directory for signing certificate keystone.middleware.auth_token: WARNING: signing_dir mode is 0775 instead of 0700 keystone.common.cms: ERROR: Verify error: Verification failure 139807477044896:error:2E099064:CMS routines:CMS_SIGNERINFO_VERIFY_CERT:certificate verify error:cms_smime.c:304:Verify error:certificate has expired --------------------- >> end captured logging << --------------------- ====================================================================== ERROR: test_verify_signed_token_succeeds_for_unrevoked_token (test_auth_token_middleware.AuthTokenMiddlewareTest) ---------------------------------------------------------------------- Traceback (most recent call last): File "<https://jenkins.openstack.org/job/periodic-keystone-python27-stable-folsom/ws/tests/test_auth_token_middleware.py",> line 533, in test_verify_signed_token_succeeds_for_unrevoked_token self.middleware.verify_signed_token(SIGNED_TOKEN_SCOPED) File "<https://jenkins.openstack.org/job/periodic-keystone-python27-stable-folsom/ws/keystone/middleware/auth_token.py",> line 760, in verify_signed_token return self.cms_verify(formatted) File "<https://jenkins.openstack.org/job/periodic-keystone-python27-stable-folsom/ws/keystone/middleware/auth_token.py",> line 751, in cms_verify raise err CalledProcessError: Command 'openssl' returned non-zero exit status 4 -------------------- >> begin captured logging << -------------------- keystone.middleware.auth_token: INFO: Starting keystone auth_token middleware keystone.middleware.auth_token: INFO: Using signing as cache directory for signing certificate keystone.middleware.auth_token: WARNING: signing_dir mode is 0775 instead of 0700 keystone.common.cms: ERROR: Verify error: Verification failure 140368607114912:error:2E099064:CMS routines:CMS_SIGNERINFO_VERIFY_CERT:certificate verify error:cms_smime.c:304:Verify error:certificate has expired --------------------- >> end captured logging << --------------------- ====================================================================== ERROR: test_fetch_revocation_list_with_expire (test_auth_token_middleware.StackResponseAuthTokenMiddlewareTest) ---------------------------------------------------------------------- Traceback (most recent call last): File "<https://jenkins.openstack.org/job/periodic-keystone-python27-stable-folsom/ws/tests/test_auth_token_middleware.py",> line 422, in test_fetch_revocation_list_with_expire fetched_list = jsonutils.loads(self.middleware.fetch_revocation_list()) File "<https://jenkins.openstack.org/job/periodic-keystone-python27-stable-folsom/ws/keystone/middleware/auth_token.py",> line 820, in fetch_revocation_list return self.cms_verify(data['signed']) File "<https://jenkins.openstack.org/job/periodic-keystone-python27-stable-folsom/ws/keystone/middleware/auth_token.py",> line 751, in cms_verify raise err CalledProcessError: Command 'openssl' returned non-zero exit status 4 -------------------- >> begin captured logging << -------------------- keystone.middleware.auth_token: INFO: Starting keystone auth_token middleware keystone.middleware.auth_token: INFO: Using signing as cache directory for signing certificate keystone.middleware.auth_token: WARNING: signing_dir mode is 0775 instead of 0700 keystone.common.cms: ERROR: Verify error: Verification failure 140284635092640:error:2E099064:CMS routines:CMS_SIGNERINFO_VERIFY_CERT:certificate verify error:cms_smime.c:304:Verify error:certificate has expired --------------------- >> end captured logging << --------------------- ====================================================================== FAIL: test_default_tenant_signed_token (test_auth_token_middleware.AuthTokenMiddlewareTest) ---------------------------------------------------------------------- Traceback (most recent call last): File "<https://jenkins.openstack.org/job/periodic-keystone-python27-stable-folsom/ws/tests/test_auth_token_middleware.py",> line 483, in test_default_tenant_signed_token self.assert_unscoped_default_tenant_auto_scopes(SIGNED_TOKEN_SCOPED) File "<https://jenkins.openstack.org/job/periodic-keystone-python27-stable-folsom/ws/tests/test_auth_token_middleware.py",> line 476, in assert_unscoped_default_tenant_auto_scopes self.assertEqual(self.response_status, 200) AssertionError: 401 != 200 -------------------- >> begin captured logging << -------------------- keystone.middleware.auth_token: INFO: Starting keystone auth_token middleware keystone.middleware.auth_token: INFO: Using signing as cache directory for signing certificate keystone.middleware.auth_token: WARNING: signing_dir mode is 0775 instead of 0700 keystone.middleware.auth_token: DEBUG: Authenticating user token keystone.middleware.auth_token: DEBUG: Removing headers from request environment: X-Identity-Status,X-Tenant-Id,X-Tenant-Name,X-User-Id,X-User-Name,X-Roles,X-Service-Catalog,X-User,X-Tenant,X-Role keystone.common.cms: ERROR: Verify error: Verification failure 139707626509984:error:2E099064:CMS routines:CMS_SIGNERINFO_VERIFY_CERT:certificate verify error:cms_smime.c:304:Verify error:certificate has expired keystone.middleware.auth_token: DEBUG: Token validation failure. Traceback (most recent call last): File "<https://jenkins.openstack.org/job/periodic-keystone-python27-stable-folsom/ws/keystone/middleware/auth_token.py",> line 511, in _validate_user_token verified = self.verify_signed_token(user_token) File "<https://jenkins.openstack.org/job/periodic-keystone-python27-stable-folsom/ws/keystone/middleware/auth_token.py",> line 760, in verify_signed_token return self.cms_verify(formatted) File "<https://jenkins.openstack.org/job/periodic-keystone-python27-stable-folsom/ws/keystone/middleware/auth_token.py",> line 751, in cms_verify raise err CalledProcessError: Command 'openssl' returned non-zero exit status 4 keystone.middleware.auth_token: WARNING: Authorization failed for token MIIG7QYJKoZIhvcNAQcCoIIG3jCCBtoCAQExCTAHBgUrDgMCGjCCBc4GCSqGSIb3DQEHAaCCBb8EggW7eyJhY2Nlc3MiOiB7InNlcnZpY2VDYXRhbG9nIjogW3siZW5kcG9pbnRzIjogW3siYWRtaW5VUkwiOiAiaHR0cDovLzEyNy4wLjAuMTo4Nzc2L3YxLzY0YjZmM2ZiY2M1MzQzNWU4YTYwZmNmODliYjY2MTdhIiwgInJlZ2lvbiI6ICJyZWdpb25PbmUiLCAiaW50ZXJuYWxVUkwiOiAiaHR0cDovLzEyNy4wLjAuMTo4Nzc2L3YxLzY0YjZmM2ZiY2M1MzQzNWU4YTYwZmNmODliYjY2MTdhIiwgInB1YmxpY1VSTCI6ICJodHRwOi8vMTI3LjAuMC4xOjg3NzYvdjEvNjRiNmYzZmJjYzUzNDM1ZThhNjBmY2Y4OWJiNjYxN2EifV0sICJlbmRwb2ludHNfbGlua3MiOiBbXSwgInR5cGUiOiAidm9sdW1lIiwgIm5hbWUiOiAidm9sdW1lIn0sIHsiZW5kcG9pbnRzIjogW3siYWRtaW5VUkwiOiAiaHR0cDovLzEyNy4wLjAuMTo5MjkyL3YxIiwgInJlZ2lvbiI6ICJyZWdpb25PbmUiLCAiaW50ZXJuYWxVUkwiOiAiaHR0cDovLzEyNy4wLjAuMTo5MjkyL3YxIiwgInB1YmxpY1VSTCI6ICJodHRwOi8vMTI3LjAuMC4xOjkyOTIvdjEifV0sICJlbmRwb2ludHNfbGlua3MiOiBbXSwgInR5cGUiOiAiaW1hZ2UiLCAibmFtZSI6ICJnbGFuY2UifSwgeyJlbmRwb2ludHMiOiBbeyJhZG1pblVSTCI6ICJodHRwOi8vMTI3LjAuMC4xOjg3NzQvdjEuMS82NGI2ZjNmYmNjNTM0MzVlOGE2MGZjZjg5YmI2NjE3YSIsICJyZWdpb24iOiAicmVnaW9uT25lIiwgImludGVybmFsVVJMIjogImh0dHA6Ly8xMjcuMC4wLjE6ODc3NC92MS4xLzY0YjZmM2ZiY2M1MzQzNWU4YTYwZmNmODliYjY2MTdhIiwgInB1YmxpY1VSTCI6ICJodHRwOi8vMTI3LjAuMC4xOjg3NzQvdjEuMS82NGI2ZjNmYmNjNTM0MzVlOGE2MGZjZjg5YmI2NjE3YSJ9XSwgImVuZHBvaW50c19saW5rcyI6IFtdLCAidHlwZSI6ICJjb21wdXRlIiwgIm5hbWUiOiAibm92YSJ9LCB7ImVuZHBvaW50cyI6IFt7ImFkbWluVVJMIjogImh0dHA6Ly8xMjcuMC4wLjE6MzUzNTcvdjIuMCIsICJyZWdpb24iOiAiUmVnaW9uT25lIiwgImludGVybmFsVVJMIjogImh0dHA6Ly8xMjcuMC4wLjE6MzUzNTcvdjIuMCIsICJwdWJsaWNVUkwiOiAiaHR0cDovLzEyNy4wLjAuMTo1MDAwL3YyLjAifV0sICJlbmRwb2ludHNfbGlua3MiOiBbXSwgInR5cGUiOiAiaWRlbnRpdHkiLCAibmFtZSI6ICJrZXlzdG9uZSJ9XSwidG9rZW4iOiB7ImV4cGlyZXMiOiAiMjAxMi0wNi0wMlQxNDo0NzozNFoiLCAiaWQiOiAicGxhY2Vob2xkZXIiLCAidGVuYW50IjogeyJlbmFibGVkIjogdHJ1ZSwgImRlc2NyaXB0aW9uIjogbnVsbCwgIm5hbWUiOiAidGVuYW50X25hbWUxIiwgImlkIjogInRlbmFudF9pZDEifX0sICJ1c2VyIjogeyJ1c2VybmFtZSI6ICJ1c2VyX25hbWUxIiwgInJvbGVzX2xpbmtzIjogWyJyb2xlMSIsInJvbGUyIl0sICJpZCI6ICJ1c2VyX2lkMSIsICJyb2xlcyI6IFt7Im5hbWUiOiAicm9sZTEifSwgeyJuYW1lIjogInJvbGUyIn1dLCAibmFtZSI6ICJ1c2VyX25hbWUxIn19fQ0KMYH3MIH0AgEBMFQwTzEVMBMGA1UEChMMUmVkIEhhdCwgSW5jMREwDwYDVQQHEwhXZXN0Zm9yZDEWMBQGA1UECBMNTWFzc2FjaHVzZXR0czELMAkGA1UEBhMCVVMCAQEwBwYFKw4DAhowDQYJKoZIhvcNAQEBBQAEgYAD6hPEpc-0wHe3rYDBFec52h7gxdbrTNEN7jmwdFtoxw0QnucmCREh9IUikJ2ob0c0uUC6cmNPajD9aFkGWhvNswNH2W2BYzUiC3CHM7U07nsIe3OOatqyUAyoQUhHZnIAx1tOgdPBVflnrtdIV1vkdqxednlJZ52Hxob2PP3hxg== keystone.middleware.auth_token: INFO: Invalid user token - rejecting request --------------------- >> end captured logging << --------------------- ====================================================================== FAIL: test_memcache_set_expired (test_auth_token_middleware.AuthTokenMiddlewareTest) ---------------------------------------------------------------------- Traceback (most recent call last): File "<https://jenkins.openstack.org/job/periodic-keystone-python27-stable-folsom/ws/tests/test_auth_token_middleware.py",> line 629, in test_memcache_set_expired self.assertEqual(len(self.middleware._cache.set_value), 2) AssertionError: 7 != 2 -------------------- >> begin captured logging << -------------------- keystone.middleware.auth_token: INFO: Starting keystone auth_token middleware keystone.middleware.auth_token: INFO: Using signing as cache directory for signing certificate keystone.middleware.auth_token: WARNING: signing_dir mode is 0775 instead of 0700 keystone.middleware.auth_token: DEBUG: Authenticating user token keystone.middleware.auth_token: DEBUG: Removing headers from request environment: X-Identity-Status,X-Tenant-Id,X-Tenant-Name,X-User-Id,X-User-Name,X-Roles,X-Service-Catalog,X-User,X-Tenant,X-Role keystone.middleware.auth_token: DEBUG: Cached Token 9bba6849c9e1f77727ae7813fd151115 seems expired keystone.common.cms: ERROR: Verify error: Verification failure 140323250652832:error:2E099064:CMS routines:CMS_SIGNERINFO_VERIFY_CERT:certificate verify error:cms_smime.c:304:Verify error:certificate has expired keystone.middleware.auth_token: DEBUG: Token validation failure. Traceback (most recent call last): File "<https://jenkins.openstack.org/job/periodic-keystone-python27-stable-folsom/ws/keystone/middleware/auth_token.py",> line 511, in _validate_user_token verified = self.verify_signed_token(user_token) File "<https://jenkins.openstack.org/job/periodic-keystone-python27-stable-folsom/ws/keystone/middleware/auth_token.py",> line 760, in verify_signed_token return self.cms_verify(formatted) File "<https://jenkins.openstack.org/job/periodic-keystone-python27-stable-folsom/ws/keystone/middleware/auth_token.py",> line 751, in cms_verify raise err CalledProcessError: Command 'openssl' returned non-zero exit status 4 keystone.middleware.auth_token: DEBUG: Marking token MIIG7QYJKoZIhvcNAQcCoIIG3jCCBtoCAQExCTAHBgUrDgMCGjCCBc4GCSqGSIb3DQEHAaCCBb8EggW7eyJhY2Nlc3MiOiB7InNlcnZpY2VDYXRhbG9nIjogW3siZW5kcG9pbnRzIjogW3siYWRtaW5VUkwiOiAiaHR0cDovLzEyNy4wLjAuMTo4Nzc2L3YxLzY0YjZmM2ZiY2M1MzQzNWU4YTYwZmNmODliYjY2MTdhIiwgInJlZ2lvbiI6ICJyZWdpb25PbmUiLCAiaW50ZXJuYWxVUkwiOiAiaHR0cDovLzEyNy4wLjAuMTo4Nzc2L3YxLzY0YjZmM2ZiY2M1MzQzNWU4YTYwZmNmODliYjY2MTdhIiwgInB1YmxpY1VSTCI6ICJodHRwOi8vMTI3LjAuMC4xOjg3NzYvdjEvNjRiNmYzZmJjYzUzNDM1ZThhNjBmY2Y4OWJiNjYxN2EifV0sICJlbmRwb2ludHNfbGlua3MiOiBbXSwgInR5cGUiOiAidm9sdW1lIiwgIm5hbWUiOiAidm9sdW1lIn0sIHsiZW5kcG9pbnRzIjogW3siYWRtaW5VUkwiOiAiaHR0cDovLzEyNy4wLjAuMTo5MjkyL3YxIiwgInJlZ2lvbiI6ICJyZWdpb25PbmUiLCAiaW50ZXJuYWxVUkwiOiAiaHR0cDovLzEyNy4wLjAuMTo5MjkyL3YxIiwgInB1YmxpY1VSTCI6ICJodHRwOi8vMTI3LjAuMC4xOjkyOTIvdjEifV0sICJlbmRwb2ludHNfbGlua3MiOiBbXSwgInR5cGUiOiAiaW1hZ2UiLCAibmFtZSI6ICJnbGFuY2UifSwgeyJlbmRwb2ludHMiOiBbeyJhZG1pblVSTCI6ICJodHRwOi8vMTI3LjAuMC4xOjg3NzQvdjEuMS82NGI2ZjNmYmNjNTM0MzVlOGE2MGZjZjg5YmI2NjE3YSIsICJyZWdpb24iOiAicmVnaW9uT25lIiwgImludGVybmFsVVJMIjogImh0dHA6Ly8xMjcuMC4wLjE6ODc3NC92MS4xLzY0YjZmM2ZiY2M1MzQzNWU4YTYwZmNmODliYjY2MTdhIiwgInB1YmxpY1VSTCI6ICJodHRwOi8vMTI3LjAuMC4xOjg3NzQvdjEuMS82NGI2ZjNmYmNjNTM0MzVlOGE2MGZjZjg5YmI2NjE3YSJ9XSwgImVuZHBvaW50c19saW5rcyI6IFtdLCAidHlwZSI6ICJjb21wdXRlIiwgIm5hbWUiOiAibm92YSJ9LCB7ImVuZHBvaW50cyI6IFt7ImFkbWluVVJMIjogImh0dHA6Ly8xMjcuMC4wLjE6MzUzNTcvdjIuMCIsICJyZWdpb24iOiAiUmVnaW9uT25lIiwgImludGVybmFsVVJMIjogImh0dHA6Ly8xMjcuMC4wLjE6MzUzNTcvdjIuMCIsICJwdWJsaWNVUkwiOiAiaHR0cDovLzEyNy4wLjAuMTo1MDAwL3YyLjAifV0sICJlbmRwb2ludHNfbGlua3MiOiBbXSwgInR5cGUiOiAiaWRlbnRpdHkiLCAibmFtZSI6ICJrZXlzdG9uZSJ9XSwidG9rZW4iOiB7ImV4cGlyZXMiOiAiMjAxMi0wNi0wMlQxNDo0NzozNFoiLCAiaWQiOiAicGxhY2Vob2xkZXIiLCAidGVuYW50IjogeyJlbmFibGVkIjogdHJ1ZSwgImRlc2NyaXB0aW9uIjogbnVsbCwgIm5hbWUiOiAidGVuYW50X25hbWUxIiwgImlkIjogInRlbmFudF9pZDEifX0sICJ1c2VyIjogeyJ1c2VybmFtZSI6ICJ1c2VyX25hbWUxIiwgInJvbGVzX2xpbmtzIjogWyJyb2xlMSIsInJvbGUyIl0sICJpZCI6ICJ1c2VyX2lkMSIsICJyb2xlcyI6IFt7Im5hbWUiOiAicm9sZTEifSwgeyJuYW1lIjogInJvbGUyIn1dLCAibmFtZSI6ICJ1c2VyX25hbWUxIn19fQ0KMYH3MIH0AgEBMFQwTzEVMBMGA1UEChMMUmVkIEhhdCwgSW5jMREwDwYDVQQHEwhXZXN0Zm9yZDEWMBQGA1UECBMNTWFzc2FjaHVzZXR0czELMAkGA1UEBhMCVVMCAQEwBwYFKw4DAhowDQYJKoZIhvcNAQEBBQAEgYAD6hPEpc-0wHe3rYDBFec52h7gxdbrTNEN7jmwdFtoxw0QnucmCREh9IUikJ2ob0c0uUC6cmNPajD9aFkGWhvNswNH2W2BYzUiC3CHM7U07nsIe3OOatqyUAyoQUhHZnIAx1tOgdPBVflnrtdIV1vkdqxednlJZ52Hxob2PP3hxg== as unauthorized in memcache keystone.middleware.auth_token: WARNING: Authorization failed for token MIIG7QYJKoZIhvcNAQcCoIIG3jCCBtoCAQExCTAHBgUrDgMCGjCCBc4GCSqGSIb3DQEHAaCCBb8EggW7eyJhY2Nlc3MiOiB7InNlcnZpY2VDYXRhbG9nIjogW3siZW5kcG9pbnRzIjogW3siYWRtaW5VUkwiOiAiaHR0cDovLzEyNy4wLjAuMTo4Nzc2L3YxLzY0YjZmM2ZiY2M1MzQzNWU4YTYwZmNmODliYjY2MTdhIiwgInJlZ2lvbiI6ICJyZWdpb25PbmUiLCAiaW50ZXJuYWxVUkwiOiAiaHR0cDovLzEyNy4wLjAuMTo4Nzc2L3YxLzY0YjZmM2ZiY2M1MzQzNWU4YTYwZmNmODliYjY2MTdhIiwgInB1YmxpY1VSTCI6ICJodHRwOi8vMTI3LjAuMC4xOjg3NzYvdjEvNjRiNmYzZmJjYzUzNDM1ZThhNjBmY2Y4OWJiNjYxN2EifV0sICJlbmRwb2ludHNfbGlua3MiOiBbXSwgInR5cGUiOiAidm9sdW1lIiwgIm5hbWUiOiAidm9sdW1lIn0sIHsiZW5kcG9pbnRzIjogW3siYWRtaW5VUkwiOiAiaHR0cDovLzEyNy4wLjAuMTo5MjkyL3YxIiwgInJlZ2lvbiI6ICJyZWdpb25PbmUiLCAiaW50ZXJuYWxVUkwiOiAiaHR0cDovLzEyNy4wLjAuMTo5MjkyL3YxIiwgInB1YmxpY1VSTCI6ICJodHRwOi8vMTI3LjAuMC4xOjkyOTIvdjEifV0sICJlbmRwb2ludHNfbGlua3MiOiBbXSwgInR5cGUiOiAiaW1hZ2UiLCAibmFtZSI6ICJnbGFuY2UifSwgeyJlbmRwb2ludHMiOiBbeyJhZG1pblVSTCI6ICJodHRwOi8vMTI3LjAuMC4xOjg3NzQvdjEuMS82NGI2ZjNmYmNjNTM0MzVlOGE2MGZjZjg5YmI2NjE3YSIsICJyZWdpb24iOiAicmVnaW9uT25lIiwgImludGVybmFsVVJMIjogImh0dHA6Ly8xMjcuMC4wLjE6ODc3NC92MS4xLzY0YjZmM2ZiY2M1MzQzNWU4YTYwZmNmODliYjY2MTdhIiwgInB1YmxpY1VSTCI6ICJodHRwOi8vMTI3LjAuMC4xOjg3NzQvdjEuMS82NGI2ZjNmYmNjNTM0MzVlOGE2MGZjZjg5YmI2NjE3YSJ9XSwgImVuZHBvaW50c19saW5rcyI6IFtdLCAidHlwZSI6ICJjb21wdXRlIiwgIm5hbWUiOiAibm92YSJ9LCB7ImVuZHBvaW50cyI6IFt7ImFkbWluVVJMIjogImh0dHA6Ly8xMjcuMC4wLjE6MzUzNTcvdjIuMCIsICJyZWdpb24iOiAiUmVnaW9uT25lIiwgImludGVybmFsVVJMIjogImh0dHA6Ly8xMjcuMC4wLjE6MzUzNTcvdjIuMCIsICJwdWJsaWNVUkwiOiAiaHR0cDovLzEyNy4wLjAuMTo1MDAwL3YyLjAifV0sICJlbmRwb2ludHNfbGlua3MiOiBbXSwgInR5cGUiOiAiaWRlbnRpdHkiLCAibmFtZSI6ICJrZXlzdG9uZSJ9XSwidG9rZW4iOiB7ImV4cGlyZXMiOiAiMjAxMi0wNi0wMlQxNDo0NzozNFoiLCAiaWQiOiAicGxhY2Vob2xkZXIiLCAidGVuYW50IjogeyJlbmFibGVkIjogdHJ1ZSwgImRlc2NyaXB0aW9uIjogbnVsbCwgIm5hbWUiOiAidGVuYW50X25hbWUxIiwgImlkIjogInRlbmFudF9pZDEifX0sICJ1c2VyIjogeyJ1c2VybmFtZSI6ICJ1c2VyX25hbWUxIiwgInJvbGVzX2xpbmtzIjogWyJyb2xlMSIsInJvbGUyIl0sICJpZCI6ICJ1c2VyX2lkMSIsICJyb2xlcyI6IFt7Im5hbWUiOiAicm9sZTEifSwgeyJuYW1lIjogInJvbGUyIn1dLCAibmFtZSI6ICJ1c2VyX25hbWUxIn19fQ0KMYH3MIH0AgEBMFQwTzEVMBMGA1UEChMMUmVkIEhhdCwgSW5jMREwDwYDVQQHEwhXZXN0Zm9yZDEWMBQGA1UECBMNTWFzc2FjaHVzZXR0czELMAkGA1UEBhMCVVMCAQEwBwYFKw4DAhowDQYJKoZIhvcNAQEBBQAEgYAD6hPEpc-0wHe3rYDBFec52h7gxdbrTNEN7jmwdFtoxw0QnucmCREh9IUikJ2ob0c0uUC6cmNPajD9aFkGWhvNswNH2W2BYzUiC3CHM7U07nsIe3OOatqyUAyoQUhHZnIAx1tOgdPBVflnrtdIV1vkdqxednlJZ52Hxob2PP3hxg== keystone.middleware.auth_token: INFO: Invalid user token - rejecting request --------------------- >> end captured logging << --------------------- ====================================================================== FAIL: test_valid_signed_request (test_auth_token_middleware.AuthTokenMiddlewareTest) ---------------------------------------------------------------------- Traceback (most recent call last): File "<https://jenkins.openstack.org/job/periodic-keystone-python27-stable-folsom/ws/tests/test_auth_token_middleware.py",> line 461, in test_valid_signed_request self.assert_valid_request_200(SIGNED_TOKEN_SCOPED) File "<https://jenkins.openstack.org/job/periodic-keystone-python27-stable-folsom/ws/tests/test_auth_token_middleware.py",> line 450, in assert_valid_request_200 self.assertEqual(self.response_status, 200) AssertionError: 401 != 200 -------------------- >> begin captured logging << -------------------- keystone.middleware.auth_token: INFO: Starting keystone auth_token middleware keystone.middleware.auth_token: INFO: Using signing as cache directory for signing certificate keystone.middleware.auth_token: WARNING: signing_dir mode is 0775 instead of 0700 keystone.middleware.auth_token: DEBUG: Authenticating user token keystone.middleware.auth_token: DEBUG: Removing headers from request environment: X-Identity-Status,X-Tenant-Id,X-Tenant-Name,X-User-Id,X-User-Name,X-Roles,X-Service-Catalog,X-User,X-Tenant,X-Role keystone.common.cms: ERROR: Verify error: Verification failure 139764932245152:error:2E099064:CMS routines:CMS_SIGNERINFO_VERIFY_CERT:certificate verify error:cms_smime.c:304:Verify error:certificate has expired keystone.middleware.auth_token: DEBUG: Token validation failure. Traceback (most recent call last): File "<https://jenkins.openstack.org/job/periodic-keystone-python27-stable-folsom/ws/keystone/middleware/auth_token.py",> line 511, in _validate_user_token verified = self.verify_signed_token(user_token) File "<https://jenkins.openstack.org/job/periodic-keystone-python27-stable-folsom/ws/keystone/middleware/auth_token.py",> line 760, in verify_signed_token return self.cms_verify(formatted) File "<https://jenkins.openstack.org/job/periodic-keystone-python27-stable-folsom/ws/keystone/middleware/auth_token.py",> line 751, in cms_verify raise err CalledProcessError: Command 'openssl' returned non-zero exit status 4 keystone.middleware.auth_token: WARNING: Authorization failed for token MIIG7QYJKoZIhvcNAQcCoIIG3jCCBtoCAQExCTAHBgUrDgMCGjCCBc4GCSqGSIb3DQEHAaCCBb8EggW7eyJhY2Nlc3MiOiB7InNlcnZpY2VDYXRhbG9nIjogW3siZW5kcG9pbnRzIjogW3siYWRtaW5VUkwiOiAiaHR0cDovLzEyNy4wLjAuMTo4Nzc2L3YxLzY0YjZmM2ZiY2M1MzQzNWU4YTYwZmNmODliYjY2MTdhIiwgInJlZ2lvbiI6ICJyZWdpb25PbmUiLCAiaW50ZXJuYWxVUkwiOiAiaHR0cDovLzEyNy4wLjAuMTo4Nzc2L3YxLzY0YjZmM2ZiY2M1MzQzNWU4YTYwZmNmODliYjY2MTdhIiwgInB1YmxpY1VSTCI6ICJodHRwOi8vMTI3LjAuMC4xOjg3NzYvdjEvNjRiNmYzZmJjYzUzNDM1ZThhNjBmY2Y4OWJiNjYxN2EifV0sICJlbmRwb2ludHNfbGlua3MiOiBbXSwgInR5cGUiOiAidm9sdW1lIiwgIm5hbWUiOiAidm9sdW1lIn0sIHsiZW5kcG9pbnRzIjogW3siYWRtaW5VUkwiOiAiaHR0cDovLzEyNy4wLjAuMTo5MjkyL3YxIiwgInJlZ2lvbiI6ICJyZWdpb25PbmUiLCAiaW50ZXJuYWxVUkwiOiAiaHR0cDovLzEyNy4wLjAuMTo5MjkyL3YxIiwgInB1YmxpY1VSTCI6ICJodHRwOi8vMTI3LjAuMC4xOjkyOTIvdjEifV0sICJlbmRwb2ludHNfbGlua3MiOiBbXSwgInR5cGUiOiAiaW1hZ2UiLCAibmFtZSI6ICJnbGFuY2UifSwgeyJlbmRwb2ludHMiOiBbeyJhZG1pblVSTCI6ICJodHRwOi8vMTI3LjAuMC4xOjg3NzQvdjEuMS82NGI2ZjNmYmNjNTM0MzVlOGE2MGZjZjg5YmI2NjE3YSIsICJyZWdpb24iOiAicmVnaW9uT25lIiwgImludGVybmFsVVJMIjogImh0dHA6Ly8xMjcuMC4wLjE6ODc3NC92MS4xLzY0YjZmM2ZiY2M1MzQzNWU4YTYwZmNmODliYjY2MTdhIiwgInB1YmxpY1VSTCI6ICJodHRwOi8vMTI3LjAuMC4xOjg3NzQvdjEuMS82NGI2ZjNmYmNjNTM0MzVlOGE2MGZjZjg5YmI2NjE3YSJ9XSwgImVuZHBvaW50c19saW5rcyI6IFtdLCAidHlwZSI6ICJjb21wdXRlIiwgIm5hbWUiOiAibm92YSJ9LCB7ImVuZHBvaW50cyI6IFt7ImFkbWluVVJMIjogImh0dHA6Ly8xMjcuMC4wLjE6MzUzNTcvdjIuMCIsICJyZWdpb24iOiAiUmVnaW9uT25lIiwgImludGVybmFsVVJMIjogImh0dHA6Ly8xMjcuMC4wLjE6MzUzNTcvdjIuMCIsICJwdWJsaWNVUkwiOiAiaHR0cDovLzEyNy4wLjAuMTo1MDAwL3YyLjAifV0sICJlbmRwb2ludHNfbGlua3MiOiBbXSwgInR5cGUiOiAiaWRlbnRpdHkiLCAibmFtZSI6ICJrZXlzdG9uZSJ9XSwidG9rZW4iOiB7ImV4cGlyZXMiOiAiMjAxMi0wNi0wMlQxNDo0NzozNFoiLCAiaWQiOiAicGxhY2Vob2xkZXIiLCAidGVuYW50IjogeyJlbmFibGVkIjogdHJ1ZSwgImRlc2NyaXB0aW9uIjogbnVsbCwgIm5hbWUiOiAidGVuYW50X25hbWUxIiwgImlkIjogInRlbmFudF9pZDEifX0sICJ1c2VyIjogeyJ1c2VybmFtZSI6ICJ1c2VyX25hbWUxIiwgInJvbGVzX2xpbmtzIjogWyJyb2xlMSIsInJvbGUyIl0sICJpZCI6ICJ1c2VyX2lkMSIsICJyb2xlcyI6IFt7Im5hbWUiOiAicm9sZTEifSwgeyJuYW1lIjogInJvbGUyIn1dLCAibmFtZSI6ICJ1c2VyX25hbWUxIn19fQ0KMYH3MIH0AgEBMFQwTzEVMBMGA1UEChMMUmVkIEhhdCwgSW5jMREwDwYDVQQHEwhXZXN0Zm9yZDEWMBQGA1UECBMNTWFzc2FjaHVzZXR0czELMAkGA1UEBhMCVVMCAQEwBwYFKw4DAhowDQYJKoZIhvcNAQEBBQAEgYAD6hPEpc-0wHe3rYDBFec52h7gxdbrTNEN7jmwdFtoxw0QnucmCREh9IUikJ2ob0c0uUC6cmNPajD9aFkGWhvNswNH2W2BYzUiC3CHM7U07nsIe3OOatqyUAyoQUhHZnIAx1tOgdPBVflnrtdIV1vkdqxednlJZ52Hxob2PP3hxg== keystone.middleware.auth_token: INFO: Invalid user token - rejecting request --------------------- >> end captured logging << --------------------- ---------------------------------------------------------------------- XML: nosetests.xml Slowest 5 tests took 7.78 secs:  1.78 KcMasterTestCase.test_admin_requires_adminness  1.67 KcEssex3TestCase.test_admin_requires_adminness  1.64 Kc11TestCase.test_admin_requires_adminness  1.51 TokenExpirationTest.test_maintain_uuid_token_expiration  1.19 KcMasterSqlTestCase.test_token_expiry_maintained ---------------------------------------------------------------------- Ran 701 tests in 56.203s FAILED (SKIP=11, errors=4, failures=3) ERROR: InvocationError: '/bin/bash run_tests.sh -N --no-pep8' ___________________________________ 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 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 WebTest==2.0.2 argparse==1.2.1 beautifulsoup4==4.1.3 colorama==0.2.5 coverage==3.6 decorator==3.4.0 distribute==0.6.34 dnspython==1.10.0 docutils==0.10 eventlet==0.12.1 greenlet==0.4.0 httplib2==0.8 iso8601==0.1.4 keystone==2012.2.5 logilab-astng==0.24.3 logilab-common==0.59.1 lxml==3.2.1 mox==0.5.3 netifaces==0.8 nose==1.3.0 nosehtmloutput==0.0.4 nosexcover==1.0.8 openstack.nose-plugin==0.11 pam==0.1.4 passlib==1.6.1 pep8==1.3.3 prettytable==0.7.2 pylint==0.27.0 python-keystoneclient==0.1.3 python-ldap==2.3.13 python-memcached==1.51 python-swiftclient==1.4.0 repoze.lru==0.6 simplejson==3.3.0 six==1.3.0 sqlalchemy-migrate==0.7.2 swift==1.8.1 termcolor==1.1.0 unittest2==0.5.1 waitress==0.8.2 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=./tests/nose_results.html + '[' -f ./tests/nose_results.html ']' ++ grep -c 'tr class=.passClass' ./tests/nose_results.html + passcount=43 + '[' 43 -eq 0 ']' + exit 1 + rm -rf /tmp/tmp.do0W0hnn6a Build step 'Execute shell' marked build as failure [SCP] Connecting to static.openstack.org [SCP] Trying to create /srv/static/logs/periodic/periodic-keystone-python27-stable-folsom/234 [SCP] uploading file: '/srv/static/logs/periodic/periodic-keystone-python27-stable-folsom/234/nose_results.html' [SCP] Connecting to static.openstack.org [SCP] Copying console log.