Skip to content

Instantly share code, notes, and snippets.

@cwolferh
Last active November 3, 2016 18:59
Show Gist options
  • Star 0 You must be signed in to star a gist
  • Fork 0 You must be signed in to fork a gist
  • Save cwolferh/5cdefccf54166b9839fde6917652e21b to your computer and use it in GitHub Desktop.
Save cwolferh/5cdefccf54166b9839fde6917652e21b to your computer and use it in GitHub Desktop.
Extra debug output with https://github.com/cwolferh/heat-scratch/tree/debug_eager_load_raw_template
See line numbers 665 and 533 below -- unclear why raw_template is not eager loaded in 2nd case
======================================================================
FAIL: heat.tests.convergence.test_converge.ScenarioTest.test_scenario(basic_update_delete)
tags: worker-4
----------------------------------------------------------------------
Empty attachments:
pythonlogging:'alembic'
pythonlogging:'barbicanclient'
pythonlogging:'ceilometerclient'
pythonlogging:'cinderclient'
pythonlogging:'designateclient'
pythonlogging:'dogpile'
pythonlogging:'fasteners'
pythonlogging:'heat-provision'
pythonlogging:'heat.engine.environment'
pythonlogging:'heatclient'
pythonlogging:'keystoneauth'
pythonlogging:'keystoneclient'
pythonlogging:'keystonemiddleware'
pythonlogging:'magnumclient'
pythonlogging:'manilaclient'
pythonlogging:'migrate'
pythonlogging:'mistralclient'
pythonlogging:'monascaclient'
pythonlogging:'neutronclient'
pythonlogging:'novaclient'
pythonlogging:'object'
pythonlogging:'openstack'
pythonlogging:'oslo'
pythonlogging:'oslo_concurrency'
pythonlogging:'oslo_config'
pythonlogging:'oslo_db'
pythonlogging:'oslo_i18n'
pythonlogging:'oslo_log'
pythonlogging:'oslo_messaging'
pythonlogging:'oslo_middleware'
pythonlogging:'oslo_policy'
pythonlogging:'oslo_service'
pythonlogging:'oslo_utils'
pythonlogging:'oslo_versionedobjects'
pythonlogging:'oslotest'
pythonlogging:'osprofiler'
pythonlogging:'requests'
pythonlogging:'routes'
pythonlogging:'saharaclient'
pythonlogging:'stevedore'
pythonlogging:'swiftclient'
pythonlogging:'troveclient'
pythonlogging:'': {{{
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
INFO [heat.tests.convergence.framework.scenario] *** Beginning scenario "basic_update_delete"
INFO [heat.tests.convergence.framework.message_processor] [engine] create_stack(stack_name='foo', scenario_tmpl=Template({'B': <heat.tests.convergence.framework.scenario_template.RsrcDef object at 0x8ac5cd0>, 'C': <heat.tests.convergence.framework.scenario_template.RsrcDef object at 0x8ac5b90>, 'A': <heat.tests.convergence.framework.scenario_template.RsrcDef object at 0x8ac5bd0>, 'D': <heat.tests.convergence.framework.scenario_template.RsrcDef object at 0x8ac5790>, 'E': <heat.tests.convergence.framework.scenario_template.RsrcDef object at 0x8ac56d0>}))
INFO [heat.engine.service] Creating stack foo
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4279750; Stack>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'loader' on path 'Mapper|Stack|stack -> Stack.tags' to 'Load(strategy=(('lazy', 'subquery'),))'
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4279750; Stack>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
INFO [heat.engine.resource] Validating TestResource "B"
INFO [heat.engine.resource] Validating TestResource "A"
INFO [heat.engine.resource] Validating TestResource "C"
INFO [heat.engine.resource] Validating TestResource "E"
INFO [heat.engine.resource] Validating TestResource "D"
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
ERROR [heat.objects.stack] db_stack dict is {'owner_id': None, u'status': 'IN_PROGRESS', u'prev_raw_template_id': None, u'current_traversal': 'c146d44d-fd74-42a7-80db-57604d553c8f', u'backup': False, 'parent_resource_name': None, 'user_creds_id': u'1', u'nested_depth': 0, 'raw_template_id': 1, 'stack_user_project_id': None, 'id': '6a3e3fab-8d7a-46d4-a7a3-c0db6025195c', 'name': 'foo', 'disable_rollback': True, 'created_at': datetime.datetime(2016, 11, 3, 18, 24, 1, 608665), 'updated_at': None, 'timeout': None, u'current_deps': None, u'convergence': True, u'action': 'CREATE', '_sa_instance_state': <sqlalchemy.orm.state.InstanceState object at 0x8bcfd90>, u'status_reason': '', 'tenant': 'test_tenant_id', 'username': 'test_username'}
ERROR [heat.objects.stack] _from_db_object raw_template is None
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x425ccd0; StackTag>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
ERROR [heat.db.sqlalchemy.api] stack_get
DEBUG [sqlalchemy.orm.path_registry] set 'loader' on path 'Mapper|Stack|stack -> Stack.raw_template' to 'Load(strategy=(('lazy', 'joined'),))'
ERROR [heat.db.sqlalchemy.api] stack_get joinedload raw_template
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4279750; Stack>,))' to '{}'
DEBUG [sqlalchemy.orm.path_registry] set 'eager_row_processor' on path 'Mapper|Stack|stack -> Stack.raw_template' to '<sqlalchemy.orm.util.ORMAdapter object at 0x8bcffd0>'
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4279750; Stack>, <RelationshipProperty at 0x426baa0; raw_template>, <Mapper at 0x425c3d0; RawTemplate>))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
ERROR [heat.db.sqlalchemy.api] stack_get raw_template_id is 1
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x425ccd0; StackTag>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
ERROR [heat.db.sqlalchemy.api] stack_get
DEBUG [sqlalchemy.orm.path_registry] set 'loader' on path 'Mapper|Stack|stack -> Stack.raw_template' to 'Load(strategy=(('lazy', 'joined'),))'
ERROR [heat.db.sqlalchemy.api] stack_get joinedload raw_template
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4279750; Stack>,))' to '{}'
DEBUG [sqlalchemy.orm.path_registry] set 'eager_row_processor' on path 'Mapper|Stack|stack -> Stack.raw_template' to '<sqlalchemy.orm.util.ORMAdapter object at 0x67a7610>'
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4279750; Stack>, <RelationshipProperty at 0x426baa0; raw_template>, <Mapper at 0x425c3d0; RawTemplate>))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
ERROR [heat.db.sqlalchemy.api] stack_get raw_template_id is 1
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x425ccd0; StackTag>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x425ccd0; StackTag>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
INFO [heat.engine.stack] Stack CREATE IN_PROGRESS (foo): Stack CREATE started
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'loader' on path 'Mapper|Resource|resource -> Resource.data' to 'Load(strategy=(('lazy', 'joined'),))'
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>,))' to '{}'
DEBUG [sqlalchemy.orm.path_registry] set 'eager_row_processor' on path 'Mapper|Resource|resource -> Resource.data' to '<sqlalchemy.orm.util.ORMAdapter object at 0x8bcf110>'
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>, <RelationshipProperty at 0x4294758; data>, <Mapper at 0x4295e90; ResourceData>))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'loader' on path 'Mapper|Resource|resource -> Resource.data' to 'Load(strategy=(('lazy', 'joined'),))'
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>,))' to '{}'
DEBUG [sqlalchemy.orm.path_registry] set 'eager_row_processor' on path 'Mapper|Resource|resource -> Resource.data' to '<sqlalchemy.orm.util.ORMAdapter object at 0x7545390>'
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>, <RelationshipProperty at 0x4294758; data>, <Mapper at 0x4295e90; ResourceData>))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'loader' on path 'Mapper|Resource|resource -> Resource.data' to 'Load(strategy=(('lazy', 'joined'),))'
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>,))' to '{}'
DEBUG [sqlalchemy.orm.path_registry] set 'eager_row_processor' on path 'Mapper|Resource|resource -> Resource.data' to '<sqlalchemy.orm.util.ORMAdapter object at 0x8c33510>'
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>, <RelationshipProperty at 0x4294758; data>, <Mapper at 0x4295e90; ResourceData>))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'loader' on path 'Mapper|Resource|resource -> Resource.data' to 'Load(strategy=(('lazy', 'joined'),))'
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>,))' to '{}'
DEBUG [sqlalchemy.orm.path_registry] set 'eager_row_processor' on path 'Mapper|Resource|resource -> Resource.data' to '<sqlalchemy.orm.util.ORMAdapter object at 0x8aefb10>'
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>, <RelationshipProperty at 0x4294758; data>, <Mapper at 0x4295e90; ResourceData>))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'loader' on path 'Mapper|Resource|resource -> Resource.data' to 'Load(strategy=(('lazy', 'joined'),))'
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>,))' to '{}'
DEBUG [sqlalchemy.orm.path_registry] set 'eager_row_processor' on path 'Mapper|Resource|resource -> Resource.data' to '<sqlalchemy.orm.util.ORMAdapter object at 0x66e4e90>'
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>, <RelationshipProperty at 0x4294758; data>, <Mapper at 0x4295e90; ResourceData>))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'loader' on path 'Mapper|Resource|resource -> Resource.data' to 'Load(strategy=(('lazy', 'joined'),))'
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>,))' to '{}'
DEBUG [sqlalchemy.orm.path_registry] set 'eager_row_processor' on path 'Mapper|Resource|resource -> Resource.data' to '<sqlalchemy.orm.util.ORMAdapter object at 0x596acd0>'
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>, <RelationshipProperty at 0x4294758; data>, <Mapper at 0x4295e90; ResourceData>))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4295e90; ResourceData>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4295e90; ResourceData>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4295e90; ResourceData>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4295e90; ResourceData>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4295e90; ResourceData>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
ERROR [heat.db.sqlalchemy.api] stack_get
DEBUG [sqlalchemy.orm.path_registry] set 'loader' on path 'Mapper|Stack|stack -> Stack.raw_template' to 'Load(strategy=(('lazy', 'joined'),))'
ERROR [heat.db.sqlalchemy.api] stack_get joinedload raw_template
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4279750; Stack>,))' to '{}'
DEBUG [sqlalchemy.orm.path_registry] set 'eager_row_processor' on path 'Mapper|Stack|stack -> Stack.raw_template' to '<sqlalchemy.orm.util.ORMAdapter object at 0x8ae0c90>'
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4279750; Stack>, <RelationshipProperty at 0x426baa0; raw_template>, <Mapper at 0x425c3d0; RawTemplate>))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
ERROR [heat.db.sqlalchemy.api] stack_get raw_template_id is 1
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x425ccd0; StackTag>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
INFO [heat.engine.stack] convergence_dependencies: (Dependencies([((1, True), (3, True)), ((2, True), (3, True)), ((3, True), (4, True)), ((3, True), (5, True))]),)
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
INFO [heat.engine.stack] Triggering resource 5 for update
INFO [heat.engine.stack] Triggering resource 4 for update
INFO [heat.tests.convergence.framework.message_processor] [worker] check_resource(ctxt=<heat.common.context.RequestContext object at 0x67af810>, resource_id=5, current_traversal='381cfc49-f185-447e-9a1b-dba2938cc31e', data={'input_data': {}}, is_update=True, adopt_stack_data=None)
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4295e90; ResourceData>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
ERROR [heat.engine.stack] load stack is None
ERROR [heat.objects.stack] get_by_id kwargs are {'show_deleted': True}
ERROR [heat.db.sqlalchemy.api] stack_get
DEBUG [sqlalchemy.orm.path_registry] set 'loader' on path 'Mapper|Stack|stack -> Stack.raw_template' to 'Load(strategy=(('lazy', 'joined'),))'
ERROR [heat.db.sqlalchemy.api] stack_get joinedload raw_template
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4279750; Stack>,))' to '{}'
DEBUG [sqlalchemy.orm.path_registry] set 'eager_row_processor' on path 'Mapper|Stack|stack -> Stack.raw_template' to '<sqlalchemy.orm.util.ORMAdapter object at 0x7e71b90>'
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4279750; Stack>, <RelationshipProperty at 0x426baa0; raw_template>, <Mapper at 0x425c3d0; RawTemplate>))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
ERROR [heat.db.sqlalchemy.api] stack_get raw_template_id is 1
ERROR [heat.objects.stack] db_stack dict is {'owner_id': None, u'status': u'IN_PROGRESS', u'prev_raw_template_id': None, 'deleted_at': None, u'current_traversal': u'381cfc49-f185-447e-9a1b-dba2938cc31e', u'backup': False, 'parent_resource_name': None, 'user_creds_id': 1, u'nested_depth': 0, 'raw_template_id': 1, 'stack_user_project_id': u'aprojectid', 'id': u'6a3e3fab-8d7a-46d4-a7a3-c0db6025195c', 'name': u'foo', 'raw_template': <heat.db.sqlalchemy.models.RawTemplate object at 0x7e79390>, 'disable_rollback': True, 'created_at': datetime.datetime(2016, 11, 3, 18, 24, 1, 608665), 'updated_at': None, 'timeout': None, u'current_deps': {u'edges': [[[3, True], [5, True]], [[3, True], [4, True]], [[1, True], [3, True]], [[2, True], [3, True]]]}, u'convergence': True, u'action': u'CREATE', '_sa_instance_state': <sqlalchemy.orm.state.InstanceState object at 0x77ae750>, u'status_reason': u'Stack CREATE started', 'tenant': u'test_tenant_id', 'username': u'test_username'}
DEBUG [sqlalchemy.orm.path_registry] set 'loader' on path 'Mapper|Resource|resource -> Resource.data' to 'Load(strategy=(('lazy', 'joined'),))'
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>,))' to '{}'
DEBUG [sqlalchemy.orm.path_registry] set 'eager_row_processor' on path 'Mapper|Resource|resource -> Resource.data' to '<sqlalchemy.orm.util.ORMAdapter object at 0x8aefad0>'
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>, <RelationshipProperty at 0x4294758; data>, <Mapper at 0x4295e90; ResourceData>))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4295e90; ResourceData>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
INFO [heat.engine.resource] creating TestResource "A" Stack "foo" [6a3e3fab-8d7a-46d4-a7a3-c0db6025195c]
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4295e90; ResourceData>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4295e90; ResourceData>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4295e90; ResourceData>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4295e90; ResourceData>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4295e90; ResourceData>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4295e90; ResourceData>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x426e510; SyncPoint>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
INFO [heat.tests.convergence.framework.message_processor] [engine] noop(count=2)
INFO [heat.tests.convergence.framework.message_processor] [worker] check_resource(ctxt=<heat.common.context.RequestContext object at 0x67af810>, resource_id=4, current_traversal='381cfc49-f185-447e-9a1b-dba2938cc31e', data={'input_data': {}}, is_update=True, adopt_stack_data=None)
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4295e90; ResourceData>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
ERROR [heat.engine.stack] load stack is None
ERROR [heat.objects.stack] get_by_id kwargs are {'show_deleted': True}
ERROR [heat.db.sqlalchemy.api] stack_get
DEBUG [sqlalchemy.orm.path_registry] set 'loader' on path 'Mapper|Stack|stack -> Stack.raw_template' to 'Load(strategy=(('lazy', 'joined'),))'
ERROR [heat.db.sqlalchemy.api] stack_get joinedload raw_template
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4279750; Stack>,))' to '{}'
DEBUG [sqlalchemy.orm.path_registry] set 'eager_row_processor' on path 'Mapper|Stack|stack -> Stack.raw_template' to '<sqlalchemy.orm.util.ORMAdapter object at 0x8ae0a10>'
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4279750; Stack>, <RelationshipProperty at 0x426baa0; raw_template>, <Mapper at 0x425c3d0; RawTemplate>))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
ERROR [heat.db.sqlalchemy.api] stack_get raw_template_id is 1
ERROR [heat.objects.stack] db_stack dict is {'owner_id': None, u'status': u'IN_PROGRESS', u'prev_raw_template_id': None, 'deleted_at': None, u'current_traversal': u'381cfc49-f185-447e-9a1b-dba2938cc31e', u'backup': False, 'parent_resource_name': None, 'user_creds_id': 1, u'nested_depth': 0, 'raw_template_id': 1, 'stack_user_project_id': u'aprojectid', 'id': u'6a3e3fab-8d7a-46d4-a7a3-c0db6025195c', 'name': u'foo', 'raw_template': <heat.db.sqlalchemy.models.RawTemplate object at 0x8ba7890>, 'disable_rollback': True, 'created_at': datetime.datetime(2016, 11, 3, 18, 24, 1, 608665), 'updated_at': None, 'timeout': None, u'current_deps': {u'edges': [[[3, True], [5, True]], [[3, True], [4, True]], [[1, True], [3, True]], [[2, True], [3, True]]]}, u'convergence': True, u'action': u'CREATE', '_sa_instance_state': <sqlalchemy.orm.state.InstanceState object at 0x8ba7d50>, u'status_reason': u'Stack CREATE started', 'tenant': u'test_tenant_id', 'username': u'test_username'}
DEBUG [sqlalchemy.orm.path_registry] set 'loader' on path 'Mapper|Resource|resource -> Resource.data' to 'Load(strategy=(('lazy', 'joined'),))'
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>,))' to '{}'
DEBUG [sqlalchemy.orm.path_registry] set 'eager_row_processor' on path 'Mapper|Resource|resource -> Resource.data' to '<sqlalchemy.orm.util.ORMAdapter object at 0x8ba7d50>'
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>, <RelationshipProperty at 0x4294758; data>, <Mapper at 0x4295e90; ResourceData>))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4295e90; ResourceData>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
INFO [heat.engine.resource] creating TestResource "B" Stack "foo" [6a3e3fab-8d7a-46d4-a7a3-c0db6025195c]
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4295e90; ResourceData>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4295e90; ResourceData>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4295e90; ResourceData>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4295e90; ResourceData>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4295e90; ResourceData>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4295e90; ResourceData>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x426e510; SyncPoint>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
INFO [heat.tests.convergence.framework.message_processor] [engine] noop(count=1)
INFO [heat.tests.convergence.framework.message_processor] [worker] check_resource(ctxt=<heat.common.context.RequestContext object at 0x67af810>, resource_id=3, current_traversal='381cfc49-f185-447e-9a1b-dba2938cc31e', data={'input_data': {u'tuple:(4, True)': {'uuid': u'f8e45585-14bc-47f6-8eb7-de809636d664', 'name': u'B', 'action': 'CREATE', 'status': 'COMPLETE', 'id': 4, 'attrs': {}, 'reference_id': u'foo-B-p5quxt4oivmf'}, u'tuple:(5, True)': {u'uuid': u'dd878b4d-6a15-412c-a7b3-6eb9c2094b51', u'name': u'A', u'action': u'CREATE', u'status': u'COMPLETE', u'id': 5, u'attrs': {}, u'reference_id': u'foo-A-cldkcxoypc2n'}}}, is_update=True, adopt_stack_data=None)
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4295e90; ResourceData>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
ERROR [heat.engine.stack] load stack is None
ERROR [heat.objects.stack] get_by_id kwargs are {'show_deleted': True}
ERROR [heat.db.sqlalchemy.api] stack_get
DEBUG [sqlalchemy.orm.path_registry] set 'loader' on path 'Mapper|Stack|stack -> Stack.raw_template' to 'Load(strategy=(('lazy', 'joined'),))'
ERROR [heat.db.sqlalchemy.api] stack_get joinedload raw_template
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4279750; Stack>,))' to '{}'
DEBUG [sqlalchemy.orm.path_registry] set 'eager_row_processor' on path 'Mapper|Stack|stack -> Stack.raw_template' to '<sqlalchemy.orm.util.ORMAdapter object at 0x596ac10>'
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4279750; Stack>, <RelationshipProperty at 0x426baa0; raw_template>, <Mapper at 0x425c3d0; RawTemplate>))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
ERROR [heat.db.sqlalchemy.api] stack_get raw_template_id is 1
ERROR [heat.objects.stack] db_stack dict is {'owner_id': None, u'status': u'IN_PROGRESS', u'prev_raw_template_id': None, 'deleted_at': None, u'current_traversal': u'381cfc49-f185-447e-9a1b-dba2938cc31e', u'backup': False, 'parent_resource_name': None, 'user_creds_id': 1, u'nested_depth': 0, 'raw_template_id': 1, 'stack_user_project_id': u'aprojectid', 'id': u'6a3e3fab-8d7a-46d4-a7a3-c0db6025195c', 'name': u'foo', 'raw_template': <heat.db.sqlalchemy.models.RawTemplate object at 0x596ab90>, 'disable_rollback': True, 'created_at': datetime.datetime(2016, 11, 3, 18, 24, 1, 608665), 'updated_at': None, 'timeout': None, u'current_deps': {u'edges': [[[3, True], [5, True]], [[3, True], [4, True]], [[1, True], [3, True]], [[2, True], [3, True]]]}, u'convergence': True, u'action': u'CREATE', '_sa_instance_state': <sqlalchemy.orm.state.InstanceState object at 0x596ad10>, u'status_reason': u'Stack CREATE started', 'tenant': u'test_tenant_id', 'username': u'test_username'}
^^^^^^^^^^^^^^^^^^^^^^^^^^^ 'raw_template' is loaded here as expected
DEBUG [sqlalchemy.orm.path_registry] set 'loader' on path 'Mapper|Resource|resource -> Resource.data' to 'Load(strategy=(('lazy', 'joined'),))'
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>,))' to '{}'
DEBUG [sqlalchemy.orm.path_registry] set 'eager_row_processor' on path 'Mapper|Resource|resource -> Resource.data' to '<sqlalchemy.orm.util.ORMAdapter object at 0x8af4490>'
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>, <RelationshipProperty at 0x4294758; data>, <Mapper at 0x4295e90; ResourceData>))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4295e90; ResourceData>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
INFO [heat.engine.resource] creating TestResource "C" Stack "foo" [6a3e3fab-8d7a-46d4-a7a3-c0db6025195c]
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4295e90; ResourceData>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4295e90; ResourceData>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4295e90; ResourceData>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4295e90; ResourceData>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4295e90; ResourceData>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4295e90; ResourceData>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4295e90; ResourceData>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x426e510; SyncPoint>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x426e510; SyncPoint>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
INFO [heat.tests.convergence.framework.message_processor] [engine] update_stack(stack_name='foo', scenario_tmpl=Template({'B': <heat.tests.convergence.framework.scenario_template.RsrcDef object at 0x8ac5250>, 'C': <heat.tests.convergence.framework.scenario_template.RsrcDef object at 0x8ac5e10>, 'A': <heat.tests.convergence.framework.scenario_template.RsrcDef object at 0x8ac5d90>, 'F': <heat.tests.convergence.framework.scenario_template.RsrcDef object at 0x67aff10>, 'D': <heat.tests.convergence.framework.scenario_template.RsrcDef object at 0x67afe50>, 'E': <heat.tests.convergence.framework.scenario_template.RsrcDef object at 0x67af550>}))
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4279750; Stack>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
ERROR [heat.objects.stack] get_by_id kwargs are {'show_deleted': False}
ERROR [heat.db.sqlalchemy.api] stack_get
DEBUG [sqlalchemy.orm.path_registry] set 'loader' on path 'Mapper|Stack|stack -> Stack.raw_template' to 'Load(strategy=(('lazy', 'joined'),))'
ERROR [heat.db.sqlalchemy.api] stack_get joinedload raw_template
ERROR [heat.db.sqlalchemy.api] stack_get raw_template_id is 1
ERROR [heat.objects.stack] db_stack dict is {'owner_id': None, u'status': u'IN_PROGRESS', u'prev_raw_template_id': None, 'deleted_at': None, u'current_traversal': u'381cfc49-f185-447e-9a1b-dba2938cc31e', u'backup': False, 'parent_resource_name': None, 'user_creds_id': 1, u'nested_depth': 0, 'raw_template_id': 1, 'stack_user_project_id': u'aprojectid', 'id': u'6a3e3fab-8d7a-46d4-a7a3-c0db6025195c', 'name': u'foo', 'disable_rollback': True, 'created_at': datetime.datetime(2016, 11, 3, 18, 24, 1, 608665), 'updated_at': None, 'timeout': None, u'current_deps': {u'edges': [[[3, True], [5, True]], [[3, True], [4, True]], [[1, True], [3, True]], [[2, True], [3, True]]]}, u'convergence': True, u'action': u'CREATE', '_sa_instance_state': <sqlalchemy.orm.state.InstanceState object at 0x8a98490>, u'status_reason': u'Stack CREATE started', 'tenant': u'test_tenant_id', 'username': u'test_username'}
^^^^^^^^^^^^^^^^^^^^^^^^^^^ 'raw_template' not loaded here. Why?
ERROR [heat.objects.stack] _from_db_object raw_template is None
INFO [heat.engine.service] Updating stack foo
ERROR [heat.engine.stack] load stack.raw_template_id is 1
ERROR [heat.tests.convergence.framework.message_processor] [engine] Exception in "update_stack": stack.raw_template was not eager loaded for stack id 6a3e3fab-8d7a-46d4-a7a3-c0db6025195c
Traceback (most recent call last):
File "heat/tests/convergence/framework/message_processor.py", line 38, in call_or_send
return function(processor, **args[0]._asdict())
File "heat/tests/convergence/framework/engine_wrapper.py", line 97, in update_stack
params={}, files={}, environment_files=None, args={})
File "/home/cwolfe/rh/heat/.tox/py27/lib/python2.7/site-packages/osprofiler/profiler.py", line 154, in wrapper
return f(*args, **kwargs)
File "heat/common/context.py", line 424, in wrapped
return func(self, ctx, *args, **kwargs)
File "heat/engine/service.py", line 965, in update_stack
current_stack = parser.Stack.load(cnxt, stack=db_stack)
File "heat/engine/stack.py", line 511, in load
resource_validate=resource_validate)
File "heat/engine/stack.py", line 547, in _from_db
context, stack.raw_template_id, stack.raw_template)
File "heat/objects/stack.py", line 97, in raw_template
"stack id %s" % (self.id or "None"))
AttributeError: stack.raw_template was not eager loaded for stack id 6a3e3fab-8d7a-46d4-a7a3-c0db6025195c
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
}}}
pythonlogging:'sqlalchemy': {{{
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4279750; Stack>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'loader' on path 'Mapper|Stack|stack -> Stack.tags' to 'Load(strategy=(('lazy', 'subquery'),))'
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4279750; Stack>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x425ccd0; StackTag>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'loader' on path 'Mapper|Stack|stack -> Stack.raw_template' to 'Load(strategy=(('lazy', 'joined'),))'
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4279750; Stack>,))' to '{}'
DEBUG [sqlalchemy.orm.path_registry] set 'eager_row_processor' on path 'Mapper|Stack|stack -> Stack.raw_template' to '<sqlalchemy.orm.util.ORMAdapter object at 0x8bcffd0>'
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4279750; Stack>, <RelationshipProperty at 0x426baa0; raw_template>, <Mapper at 0x425c3d0; RawTemplate>))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x425ccd0; StackTag>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'loader' on path 'Mapper|Stack|stack -> Stack.raw_template' to 'Load(strategy=(('lazy', 'joined'),))'
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4279750; Stack>,))' to '{}'
DEBUG [sqlalchemy.orm.path_registry] set 'eager_row_processor' on path 'Mapper|Stack|stack -> Stack.raw_template' to '<sqlalchemy.orm.util.ORMAdapter object at 0x67a7610>'
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4279750; Stack>, <RelationshipProperty at 0x426baa0; raw_template>, <Mapper at 0x425c3d0; RawTemplate>))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x425ccd0; StackTag>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x425ccd0; StackTag>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'loader' on path 'Mapper|Resource|resource -> Resource.data' to 'Load(strategy=(('lazy', 'joined'),))'
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>,))' to '{}'
DEBUG [sqlalchemy.orm.path_registry] set 'eager_row_processor' on path 'Mapper|Resource|resource -> Resource.data' to '<sqlalchemy.orm.util.ORMAdapter object at 0x8bcf110>'
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>, <RelationshipProperty at 0x4294758; data>, <Mapper at 0x4295e90; ResourceData>))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'loader' on path 'Mapper|Resource|resource -> Resource.data' to 'Load(strategy=(('lazy', 'joined'),))'
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>,))' to '{}'
DEBUG [sqlalchemy.orm.path_registry] set 'eager_row_processor' on path 'Mapper|Resource|resource -> Resource.data' to '<sqlalchemy.orm.util.ORMAdapter object at 0x7545390>'
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>, <RelationshipProperty at 0x4294758; data>, <Mapper at 0x4295e90; ResourceData>))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'loader' on path 'Mapper|Resource|resource -> Resource.data' to 'Load(strategy=(('lazy', 'joined'),))'
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>,))' to '{}'
DEBUG [sqlalchemy.orm.path_registry] set 'eager_row_processor' on path 'Mapper|Resource|resource -> Resource.data' to '<sqlalchemy.orm.util.ORMAdapter object at 0x8c33510>'
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>, <RelationshipProperty at 0x4294758; data>, <Mapper at 0x4295e90; ResourceData>))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'loader' on path 'Mapper|Resource|resource -> Resource.data' to 'Load(strategy=(('lazy', 'joined'),))'
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>,))' to '{}'
DEBUG [sqlalchemy.orm.path_registry] set 'eager_row_processor' on path 'Mapper|Resource|resource -> Resource.data' to '<sqlalchemy.orm.util.ORMAdapter object at 0x8aefb10>'
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>, <RelationshipProperty at 0x4294758; data>, <Mapper at 0x4295e90; ResourceData>))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'loader' on path 'Mapper|Resource|resource -> Resource.data' to 'Load(strategy=(('lazy', 'joined'),))'
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>,))' to '{}'
DEBUG [sqlalchemy.orm.path_registry] set 'eager_row_processor' on path 'Mapper|Resource|resource -> Resource.data' to '<sqlalchemy.orm.util.ORMAdapter object at 0x66e4e90>'
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>, <RelationshipProperty at 0x4294758; data>, <Mapper at 0x4295e90; ResourceData>))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'loader' on path 'Mapper|Resource|resource -> Resource.data' to 'Load(strategy=(('lazy', 'joined'),))'
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>,))' to '{}'
DEBUG [sqlalchemy.orm.path_registry] set 'eager_row_processor' on path 'Mapper|Resource|resource -> Resource.data' to '<sqlalchemy.orm.util.ORMAdapter object at 0x596acd0>'
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>, <RelationshipProperty at 0x4294758; data>, <Mapper at 0x4295e90; ResourceData>))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4295e90; ResourceData>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4295e90; ResourceData>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4295e90; ResourceData>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4295e90; ResourceData>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4295e90; ResourceData>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'loader' on path 'Mapper|Stack|stack -> Stack.raw_template' to 'Load(strategy=(('lazy', 'joined'),))'
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4279750; Stack>,))' to '{}'
DEBUG [sqlalchemy.orm.path_registry] set 'eager_row_processor' on path 'Mapper|Stack|stack -> Stack.raw_template' to '<sqlalchemy.orm.util.ORMAdapter object at 0x8ae0c90>'
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4279750; Stack>, <RelationshipProperty at 0x426baa0; raw_template>, <Mapper at 0x425c3d0; RawTemplate>))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x425ccd0; StackTag>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4295e90; ResourceData>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'loader' on path 'Mapper|Stack|stack -> Stack.raw_template' to 'Load(strategy=(('lazy', 'joined'),))'
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4279750; Stack>,))' to '{}'
DEBUG [sqlalchemy.orm.path_registry] set 'eager_row_processor' on path 'Mapper|Stack|stack -> Stack.raw_template' to '<sqlalchemy.orm.util.ORMAdapter object at 0x7e71b90>'
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4279750; Stack>, <RelationshipProperty at 0x426baa0; raw_template>, <Mapper at 0x425c3d0; RawTemplate>))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'loader' on path 'Mapper|Resource|resource -> Resource.data' to 'Load(strategy=(('lazy', 'joined'),))'
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>,))' to '{}'
DEBUG [sqlalchemy.orm.path_registry] set 'eager_row_processor' on path 'Mapper|Resource|resource -> Resource.data' to '<sqlalchemy.orm.util.ORMAdapter object at 0x8aefad0>'
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>, <RelationshipProperty at 0x4294758; data>, <Mapper at 0x4295e90; ResourceData>))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4295e90; ResourceData>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4295e90; ResourceData>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4295e90; ResourceData>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4295e90; ResourceData>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4295e90; ResourceData>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4295e90; ResourceData>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4295e90; ResourceData>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x426e510; SyncPoint>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4295e90; ResourceData>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'loader' on path 'Mapper|Stack|stack -> Stack.raw_template' to 'Load(strategy=(('lazy', 'joined'),))'
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4279750; Stack>,))' to '{}'
DEBUG [sqlalchemy.orm.path_registry] set 'eager_row_processor' on path 'Mapper|Stack|stack -> Stack.raw_template' to '<sqlalchemy.orm.util.ORMAdapter object at 0x8ae0a10>'
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4279750; Stack>, <RelationshipProperty at 0x426baa0; raw_template>, <Mapper at 0x425c3d0; RawTemplate>))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'loader' on path 'Mapper|Resource|resource -> Resource.data' to 'Load(strategy=(('lazy', 'joined'),))'
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>,))' to '{}'
DEBUG [sqlalchemy.orm.path_registry] set 'eager_row_processor' on path 'Mapper|Resource|resource -> Resource.data' to '<sqlalchemy.orm.util.ORMAdapter object at 0x8ba7d50>'
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>, <RelationshipProperty at 0x4294758; data>, <Mapper at 0x4295e90; ResourceData>))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4295e90; ResourceData>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4295e90; ResourceData>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4295e90; ResourceData>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4295e90; ResourceData>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4295e90; ResourceData>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4295e90; ResourceData>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4295e90; ResourceData>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x426e510; SyncPoint>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4295e90; ResourceData>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'loader' on path 'Mapper|Stack|stack -> Stack.raw_template' to 'Load(strategy=(('lazy', 'joined'),))'
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4279750; Stack>,))' to '{}'
DEBUG [sqlalchemy.orm.path_registry] set 'eager_row_processor' on path 'Mapper|Stack|stack -> Stack.raw_template' to '<sqlalchemy.orm.util.ORMAdapter object at 0x596ac10>'
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4279750; Stack>, <RelationshipProperty at 0x426baa0; raw_template>, <Mapper at 0x425c3d0; RawTemplate>))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'loader' on path 'Mapper|Resource|resource -> Resource.data' to 'Load(strategy=(('lazy', 'joined'),))'
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>,))' to '{}'
DEBUG [sqlalchemy.orm.path_registry] set 'eager_row_processor' on path 'Mapper|Resource|resource -> Resource.data' to '<sqlalchemy.orm.util.ORMAdapter object at 0x8af4490>'
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>, <RelationshipProperty at 0x4294758; data>, <Mapper at 0x4295e90; ResourceData>))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4295e90; ResourceData>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4295e90; ResourceData>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4295e90; ResourceData>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4295e90; ResourceData>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4295e90; ResourceData>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4295e90; ResourceData>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x436e050; Resource>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4295e90; ResourceData>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4295e90; ResourceData>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x426e510; SyncPoint>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x426e510; SyncPoint>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'memoized_setups' on path 'EntityRegistry((<Mapper at 0x4279750; Stack>,))' to '{}'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.orm.path_registry] set 'loader' on path 'Mapper|Stack|stack -> Stack.raw_template' to 'Load(strategy=(('lazy', 'joined'),))'
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> checked out from pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> being returned to pool
DEBUG [sqlalchemy.pool.StaticPool] Connection <sqlite3.Connection object at 0x82b1688> rollback-on-return
}}}
Traceback (most recent call last):
File "heat/tests/convergence/test_converge.py", line 42, in test_scenario
**testutils.scenario_globals(self.procs, self))
File "heat/tests/convergence/framework/scenario.py", line 51, in __call__
_event_loop()
File "heat/tests/convergence/framework/event_loop.py", line 21, in __call__
while any([processor() for processor in self.processors]):
File "heat/tests/convergence/framework/message_processor.py", line 75, in __call__
method(message.data)
File "heat/tests/convergence/framework/message_processor.py", line 38, in call_or_send
return function(processor, **args[0]._asdict())
File "heat/tests/convergence/framework/engine_wrapper.py", line 97, in update_stack
params={}, files={}, environment_files=None, args={})
File "/home/cwolfe/rh/heat/.tox/py27/lib/python2.7/site-packages/osprofiler/profiler.py", line 154, in wrapper
return f(*args, **kwargs)
File "heat/common/context.py", line 424, in wrapped
return func(self, ctx, *args, **kwargs)
File "heat/engine/service.py", line 965, in update_stack
current_stack = parser.Stack.load(cnxt, stack=db_stack)
File "heat/engine/stack.py", line 511, in load
resource_validate=resource_validate)
File "heat/engine/stack.py", line 547, in _from_db
context, stack.raw_template_id, stack.raw_template)
File "heat/objects/stack.py", line 97, in raw_template
"stack id %s" % (self.id or "None"))
AttributeError: stack.raw_template was not eager loaded for stack id 6a3e3fab-8d7a-46d4-a7a3-c0db6025195c
======================================================================
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment