Designate

  1. Bug #1288190
  2. Activity log

Activity log for bug #1288190

Date Who What changed Old value New value Message
2014-03-05 11:13:10 George Shuklin bug added bug
2014-03-05 11:15:00 George Shuklin description designate configured to use powerdns with sql: [service:central] backend_driver = powerdns [backend:powerdns] database_connection = mysql://designate:designate@sqlserver/pdns connection_debug = 100 connection_trace = False sqlite_synchronous = True idle_timeout = 3600 max_retries = 10 retry_interval = 10 after initializing database and pdns database, server, domain and record created: +------------+--------------------------------------+ | Field | Value | +------------+--------------------------------------+ | updated_at | None | | created_at | 2011-01-21T11:33:21.000000 | | id | 384a9b20-239c-11e2-81c1-0800200c9a66 | | name | ns1.example.org. | +------------+--------------------------------------+ +-------------+--------------------------------------+ | Field | Value | +-------------+--------------------------------------+ | description | None | | created_at | 2014-03-04T17:09:55.000000 | | updated_at | 2014-03-05T10:59:23.000000 | | email | nsadmin@example.org | | ttl | 3600 | | serial | 1394017163 | | id | 530b4711-44df-4b85-b709-a949b874c328 | | name | domain1.com. | +-------------+--------------------------------------+ +-------------+--------------------------------------+ | Field | Value | +-------------+--------------------------------------+ | description | None | | type | A | | created_at | 2014-03-05T10:59:23.000000 | | updated_at | None | | domain_id | 530b4711-44df-4b85-b709-a949b874c328 | | priority | None | | ttl | None | | data | 127.0.0.1 | | id | 4df33ea0-7c41-4553-88a4-224b5e29a754 | | name | www.domain1.com. | +-------------+--------------------------------------+ after issuing designate sync-all: 2014-03-05 12:12:36.563 12200 INFO eventlet.wsgi [-] (12200) accepted ('78.140.137.211', 43723) 2014-03-05 12:12:36.564 12200 INFO designate.central.rpcapi [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] sync_domains: Calling central's sync_domains. 2014-03-05 12:12:36.564 12200 DEBUG designate.openstack.common.rpc.amqp [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] Making synchronous call on central ... multicall /root/designate/designate/openstack/common/rpc/amqp.py:554 2014-03-05 12:12:36.564 12200 DEBUG designate.openstack.common.rpc.amqp [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] MSG_ID is e9758e6bea1e42838fa9281e54b0a39f multicall /root/designate/designate/openstack/common/rpc/amqp.py:557 2014-03-05 12:12:36.565 12200 DEBUG designate.openstack.common.rpc.amqp [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] UNIQUE_ID is 16866ce0eb06443bb375f678b74e7aff. _add_unique_id /root/designate/designate/openstack/common/rpc/amqp.py:342 2014-03-05 12:12:36.566 12208 DEBUG designate.openstack.common.rpc.amqp [-] received {u'_context_domain': None, u'_msg_id': u'e9758e6bea1e42838fa9281e54b0a39f', u'_context_request_id': u'req-8b0f8364-64e6-4540-a50c-572049221953', u'_context_service_catalog': None, u'_context_auth_token': '<SANITIZED>', u'_context_instance_uuid': None, u'_context_user_id': u'noauth-user', u'_reply_q': u'reply_9d3c305012984f0e8cf5363a2d3d73f1', u'_context_show_deleted': False, u'namespace': None, u'_context_is_admin': True, u'version': u'3.0', u'_context_project_domain': None, u'_context_user': u'noauth-user', u'method': u'sync_domains', u'_context_roles': [], u'_context_all_tenants': False, u'args': {}, u'_unique_id': u'16866ce0eb06443bb375f678b74e7aff', u'_context_tenant_id': u'noauth-project', u'_context_user_identity': u'noauth-user noauth-project - - -', u'_context_tenant': u'noauth-project', u'_context_read_only': False, u'_context_user_domain': None} _safe_log /root/designate/designate/openstack/common/rpc/common.py:280 2014-03-05 12:12:36.567 12208 DEBUG designate.openstack.common.rpc.amqp [-] unpacked context: {'instance_uuid': None, 'read_only': False, 'domain': None, 'user_id': u'noauth-user', 'show_deleted': False, 'roles': [], 'user_identity': u'noauth-user noauth-project - - -', 'project_domain': None, 'tenant_id': u'noauth-project', 'auth_token': '<SANITIZED>', 'is_admin': True, 'user': u'noauth-user', 'service_catalog': None, 'request_id': u'req-8b0f8364-64e6-4540-a50c-572049221953', 'user_domain': None, 'all_tenants': False, 'tenant': u'noauth-project'} _safe_log /root/designate/designate/openstack/common/rpc/common.py:280 2014-03-05 12:12:36.567 12208 AUDIT designate.policy [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] Policy check succeeded for rule 'diagnostics_sync_domains' on target {} 2014-03-05 12:12:36,573 INFO sqlalchemy.engine.base.Engine SELECT domains.id AS domains_id, domains.designate_id AS domains_designate_id, domains.name AS domains_name, domains.master AS domains_master, domains.last_check AS domains_last_check, domains.type AS domains_type, domains.notified_serial AS domains_notified_serial, domains.account AS domains_account FROM domains WHERE domains.designate_id = %s 2014-03-05 12:12:36.573 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] SELECT domains.id AS domains_id, domains.designate_id AS domains_designate_id, domains.name AS domains_name, domains.master AS domains_master, domains.last_check AS domains_last_check, domains.type AS domains_type, domains.notified_serial AS domains_notified_serial, domains.account AS domains_account FROM domains WHERE domains.designate_id = %s 2014-03-05 12:12:36,574 INFO sqlalchemy.engine.base.Engine ('530b471144df4b85b709a949b874c328',) 2014-03-05 12:12:36.574 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] ('530b471144df4b85b709a949b874c328',) 2014-03-05 12:12:36,574 DEBUG sqlalchemy.engine.base.Engine Col ('domains_id', 'domains_designate_id', 'domains_name', 'domains_master', 'domains_last_check', 'domains_type', 'domains_notified_serial', 'domains_account') 2014-03-05 12:12:36.574 12208 DEBUG sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] Col ('domains_id', 'domains_designate_id', 'domains_name', 'domains_master', 'domains_last_check', 'domains_type', 'domains_notified_serial', 'domains_account') debug /root/designate/.venv/local/lib/python2.7/site-packages/sqlalchemy/log.py:106 2014-03-05 12:12:36,575 DEBUG sqlalchemy.engine.base.Engine Row (5L, '530b471144df4b85b709a949b874c328', 'domain1.com', 'ns1.example.org', None, 'NATIVE', None, 'noauth-project') 2014-03-05 12:12:36.575 12208 DEBUG sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] Row (5L, '530b471144df4b85b709a949b874c328', 'domain1.com', 'ns1.example.org', None, 'NATIVE', None, 'noauth-project') debug /root/designate/.venv/local/lib/python2.7/site-packages/sqlalchemy/log.py:106 2014-03-05 12:12:36,576 INFO sqlalchemy.engine.base.Engine BEGIN (implicit) 2014-03-05 12:12:36.576 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] BEGIN (implicit) 2014-03-05 12:12:36,576 INFO sqlalchemy.engine.base.Engine DELETE FROM domains WHERE domains.id = %s 2014-03-05 12:12:36.576 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] DELETE FROM domains WHERE domains.id = %s 2014-03-05 12:12:36,576 INFO sqlalchemy.engine.base.Engine (5L,) 2014-03-05 12:12:36.576 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] (5L,) 2014-03-05 12:12:36,577 INFO sqlalchemy.engine.base.Engine COMMIT 2014-03-05 12:12:36.577 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] COMMIT 2014-03-05 12:12:36,610 INFO sqlalchemy.engine.base.Engine DELETE FROM records WHERE records.domain_id = %s 2014-03-05 12:12:36.610 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] DELETE FROM records WHERE records.domain_id = %s 2014-03-05 12:12:36,610 INFO sqlalchemy.engine.base.Engine (5L,) 2014-03-05 12:12:36.610 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] (5L,) 2014-03-05 12:12:36,610 INFO sqlalchemy.engine.base.Engine COMMIT 2014-03-05 12:12:36.610 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] COMMIT 2014-03-05 12:12:36,643 INFO sqlalchemy.engine.base.Engine DELETE FROM domainmetadata WHERE domainmetadata.domain_id = %s 2014-03-05 12:12:36.643 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] DELETE FROM domainmetadata WHERE domainmetadata.domain_id = %s 2014-03-05 12:12:36,643 INFO sqlalchemy.engine.base.Engine (5L,) 2014-03-05 12:12:36.643 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] (5L,) 2014-03-05 12:12:36,644 INFO sqlalchemy.engine.base.Engine COMMIT 2014-03-05 12:12:36.644 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] COMMIT 2014-03-05 12:12:36.645 12208 AUDIT designate.policy [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] Policy check succeeded for rule 'find_servers' on target {} 2014-03-05 12:12:36,647 INFO sqlalchemy.engine.base.Engine BEGIN (implicit) 2014-03-05 12:12:36.647 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] BEGIN (implicit) 2014-03-05 12:12:36,647 INFO sqlalchemy.engine.base.Engine INSERT INTO domains (designate_id, name, master, last_check, type, notified_serial, account) VALUES (%s, %s, %s, %s, %s, %s, %s) 2014-03-05 12:12:36.647 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] INSERT INTO domains (designate_id, name, master, last_check, type, notified_serial, account) VALUES (%s, %s, %s, %s, %s, %s, %s) 2014-03-05 12:12:36,648 INFO sqlalchemy.engine.base.Engine ('530b471144df4b85b709a949b874c328', 'domain1.com', 'ns1.example.org', None, 'NATIVE', None, 'noauth-project') 2014-03-05 12:12:36.648 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] ('530b471144df4b85b709a949b874c328', 'domain1.com', 'ns1.example.org', None, 'NATIVE', None, 'noauth-project') 2014-03-05 12:12:36,648 INFO sqlalchemy.engine.base.Engine COMMIT 2014-03-05 12:12:36.648 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] COMMIT 2014-03-05 12:12:36,676 INFO sqlalchemy.engine.base.Engine BEGIN (implicit) 2014-03-05 12:12:36.676 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] BEGIN (implicit) 2014-03-05 12:12:36,676 INFO sqlalchemy.engine.base.Engine INSERT INTO records (designate_id, designate_recordset_id, domain_id, name, type, content, ttl, prio, change_date, ordername, auth, inherit_ttl) VALUES (%s, %s, %s, %s, %s, %s, %s, %s, %s, %s, %s, %s) 2014-03-05 12:12:36.676 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] INSERT INTO records (designate_id, designate_recordset_id, domain_id, name, type, content, ttl, prio, change_date, ordername, auth, inherit_ttl) VALUES (%s, %s, %s, %s, %s, %s, %s, %s, %s, %s, %s, %s) 2014-03-05 12:12:36,677 INFO sqlalchemy.engine.base.Engine ('384a9b20239c11e281c10800200c9a66', None, 6L, 'domain1.com', 'NS', 'ns1.example.org', 3600L, None, None, None, 1, 1) 2014-03-05 12:12:36.677 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] ('384a9b20239c11e281c10800200c9a66', None, 6L, 'domain1.com', 'NS', 'ns1.example.org', 3600L, None, None, None, 1, 1) 2014-03-05 12:12:36,677 INFO sqlalchemy.engine.base.Engine COMMIT 2014-03-05 12:12:36.677 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] COMMIT 2014-03-05 12:12:36,710 INFO sqlalchemy.engine.base.Engine SELECT tsigkeys.id AS tsigkeys_id, tsigkeys.designate_id AS tsigkeys_designate_id, tsigkeys.name AS tsigkeys_name, tsigkeys.algorithm AS tsigkeys_algorithm, tsigkeys.secret AS tsigkeys_secret FROM tsigkeys 2014-03-05 12:12:36.710 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] SELECT tsigkeys.id AS tsigkeys_id, tsigkeys.designate_id AS tsigkeys_designate_id, tsigkeys.name AS tsigkeys_name, tsigkeys.algorithm AS tsigkeys_algorithm, tsigkeys.secret AS tsigkeys_secret FROM tsigkeys 2014-03-05 12:12:36,710 INFO sqlalchemy.engine.base.Engine () 2014-03-05 12:12:36.710 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] () 2014-03-05 12:12:36,711 DEBUG sqlalchemy.engine.base.Engine Col ('tsigkeys_id', 'tsigkeys_designate_id', 'tsigkeys_name', 'tsigkeys_algorithm', 'tsigkeys_secret') 2014-03-05 12:12:36.711 12208 DEBUG sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] Col ('tsigkeys_id', 'tsigkeys_designate_id', 'tsigkeys_name', 'tsigkeys_algorithm', 'tsigkeys_secret') debug /root/designate/.venv/local/lib/python2.7/site-packages/sqlalchemy/log.py:106 2014-03-05 12:12:36,712 INFO sqlalchemy.engine.base.Engine SELECT domainmetadata.id AS domainmetadata_id, domainmetadata.domain_id AS domainmetadata_domain_id, domainmetadata.kind AS domainmetadata_kind, domainmetadata.content AS domainmetadata_content FROM domainmetadata WHERE domainmetadata.kind = %s AND domainmetadata.domain_id = %s 2014-03-05 12:12:36.712 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] SELECT domainmetadata.id AS domainmetadata_id, domainmetadata.domain_id AS domainmetadata_domain_id, domainmetadata.kind AS domainmetadata_kind, domainmetadata.content AS domainmetadata_content FROM domainmetadata WHERE domainmetadata.kind = %s AND domainmetadata.domain_id = %s 2014-03-05 12:12:36,712 INFO sqlalchemy.engine.base.Engine ('TSIG-ALLOW-AXFR', 6L) 2014-03-05 12:12:36.712 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] ('TSIG-ALLOW-AXFR', 6L) 2014-03-05 12:12:36,713 DEBUG sqlalchemy.engine.base.Engine Col ('domainmetadata_id', 'domainmetadata_domain_id', 'domainmetadata_kind', 'domainmetadata_content') 2014-03-05 12:12:36.713 12208 DEBUG sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] Col ('domainmetadata_id', 'domainmetadata_domain_id', 'domainmetadata_kind', 'domainmetadata_content') debug /root/designate/.venv/local/lib/python2.7/site-packages/sqlalchemy/log.py:106 2014-03-05 12:12:36,714 INFO sqlalchemy.engine.base.Engine SELECT domainmetadata.id AS domainmetadata_id, domainmetadata.domain_id AS domainmetadata_domain_id, domainmetadata.kind AS domainmetadata_kind, domainmetadata.content AS domainmetadata_content FROM domainmetadata WHERE domainmetadata.kind = %s AND domainmetadata.domain_id = %s 2014-03-05 12:12:36.714 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] SELECT domainmetadata.id AS domainmetadata_id, domainmetadata.domain_id AS domainmetadata_domain_id, domainmetadata.kind AS domainmetadata_kind, domainmetadata.content AS domainmetadata_content FROM domainmetadata WHERE domainmetadata.kind = %s AND domainmetadata.domain_id = %s 2014-03-05 12:12:36,714 INFO sqlalchemy.engine.base.Engine ('ALSO-NOTIFY', 6L) 2014-03-05 12:12:36.714 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] ('ALSO-NOTIFY', 6L) 2014-03-05 12:12:36,715 DEBUG sqlalchemy.engine.base.Engine Col ('domainmetadata_id', 'domainmetadata_domain_id', 'domainmetadata_kind', 'domainmetadata_content') 2014-03-05 12:12:36.715 12208 DEBUG sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] Col ('domainmetadata_id', 'domainmetadata_domain_id', 'domainmetadata_kind', 'domainmetadata_content') debug /root/designate/.venv/local/lib/python2.7/site-packages/sqlalchemy/log.py:106 2014-03-05 12:12:36,716 INFO sqlalchemy.engine.base.Engine BEGIN (implicit) 2014-03-05 12:12:36.716 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] BEGIN (implicit) 2014-03-05 12:12:36,716 INFO sqlalchemy.engine.base.Engine INSERT INTO records (designate_id, designate_recordset_id, domain_id, name, type, content, ttl, prio, change_date, ordername, auth, inherit_ttl) VALUES (%s, %s, %s, %s, %s, %s, %s, %s, %s, %s, %s, %s) 2014-03-05 12:12:36.716 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] INSERT INTO records (designate_id, designate_recordset_id, domain_id, name, type, content, ttl, prio, change_date, ordername, auth, inherit_ttl) VALUES (%s, %s, %s, %s, %s, %s, %s, %s, %s, %s, %s, %s) 2014-03-05 12:12:36,716 INFO sqlalchemy.engine.base.Engine ('530b471144df4b85b709a949b874c328', None, 6L, 'domain1.com', 'SOA', 'ns1.example.org. nsadmin.example.org. 1394017163 3600 600 86400 3600', None, None, None, None, 1, 1) 2014-03-05 12:12:36.716 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] ('530b471144df4b85b709a949b874c328', None, 6L, 'domain1.com', 'SOA', 'ns1.example.org. nsadmin.example.org. 1394017163 3600 600 86400 3600', None, None, None, None, 1, 1) 2014-03-05 12:12:36,717 INFO sqlalchemy.engine.base.Engine COMMIT 2014-03-05 12:12:36.717 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] COMMIT 2014-03-05 12:12:36.751 12208 ERROR designate.openstack.common.rpc.amqp [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] Exception during message handling 2014-03-05 12:12:36.751 12208 TRACE designate.openstack.common.rpc.amqp Traceback (most recent call last): 2014-03-05 12:12:36.751 12208 TRACE designate.openstack.common.rpc.amqp File "/root/designate/designate/openstack/common/rpc/amqp.py", line 462, in _process_data 2014-03-05 12:12:36.751 12208 TRACE designate.openstack.common.rpc.amqp **args) 2014-03-05 12:12:36.751 12208 TRACE designate.openstack.common.rpc.amqp File "/root/designate/designate/openstack/common/rpc/dispatcher.py", line 172, in dispatch 2014-03-05 12:12:36.751 12208 TRACE designate.openstack.common.rpc.amqp result = getattr(proxyobj, method)(ctxt, **kwargs) 2014-03-05 12:12:36.751 12208 TRACE designate.openstack.common.rpc.amqp File "/root/designate/designate/central/service.py", line 987, in sync_domains 2014-03-05 12:12:36.751 12208 TRACE designate.openstack.common.rpc.amqp records) 2014-03-05 12:12:36.751 12208 TRACE designate.openstack.common.rpc.amqp File "/usr/lib/python2.7/contextlib.py", line 35, in __exit__ 2014-03-05 12:12:36.751 12208 TRACE designate.openstack.common.rpc.amqp self.gen.throw(type, value, traceback) 2014-03-05 12:12:36.751 12208 TRACE designate.openstack.common.rpc.amqp File "/root/designate/designate/central/service.py", line 44, in wrap_backend_call 2014-03-05 12:12:36.751 12208 TRACE designate.openstack.common.rpc.amqp raise exceptions.Backend('Unknown backend failure: %r' % exc) 2014-03-05 12:12:36.751 12208 TRACE designate.openstack.common.rpc.amqp Backend: Unknown backend failure: TypeError('create_record() takes exactly 5 arguments (4 given)',) 2014-03-05 12:12:36.751 12208 TRACE designate.openstack.common.rpc.amqp 2014-03-05 12:12:36.752 12208 ERROR designate.openstack.common.rpc.common [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] Returning exception Unknown backend failure: TypeError('create_record() takes exactly 5 arguments (4 given)',) to caller 2014-03-05 12:12:36.752 12208 ERROR designate.openstack.common.rpc.common [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] ['Traceback (most recent call last):\n', ' File "/root/designate/designate/openstack/common/rpc/amqp.py", line 462, in _process_data\n **args)\n', ' File "/root/designate/designate/openstack/common/rpc/dispatcher.py", line 172, in dispatch\n result = getattr(proxyobj, method)(ctxt, **kwargs)\n', ' File "/root/designate/designate/central/service.py", line 987, in sync_domains\n records)\n', ' File "/usr/lib/python2.7/contextlib.py", line 35, in __exit__\n self.gen.throw(type, value, traceback)\n', ' File "/root/designate/designate/central/service.py", line 44, in wrap_backend_call\n raise exceptions.Backend(\'Unknown backend failure: %r\' % exc)\n', "Backend: Unknown backend failure: TypeError('create_record() takes exactly 5 arguments (4 given)',)\n"] 2014-03-05 12:12:36.752 12208 DEBUG designate.openstack.common.rpc.amqp [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] UNIQUE_ID is cbcbaa6471a24ad794d40e105dbe2df1. _add_unique_id /root/designate/designate/openstack/common/rpc/amqp.py:342 /root/designate/.venv/local/lib/python2.7/site-packages/amqp/channel.py:616: VDeprecationWarning: The auto_delete flag for exchanges has been deprecated and will be removed from py-amqp v1.5.0. warn(VDeprecationWarning(EXCHANGE_AUTODELETE_DEPRECATED)) 2014-03-05 12:12:36.754 12200 ERROR designate.api.middleware [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] Unknown backend failure: TypeError('create_record() takes exactly 5 arguments (4 given)',) Traceback (most recent call last): File "/root/designate/designate/openstack/common/rpc/amqp.py", line 462, in _process_data **args) File "/root/designate/designate/openstack/common/rpc/dispatcher.py", line 172, in dispatch result = getattr(proxyobj, method)(ctxt, **kwargs) File "/root/designate/designate/central/service.py", line 987, in sync_domains records) File "/usr/lib/python2.7/contextlib.py", line 35, in __exit__ self.gen.throw(type, value, traceback) File "/root/designate/designate/central/service.py", line 44, in wrap_backend_call raise exceptions.Backend('Unknown backend failure: %r' % exc) Backend: Unknown backend failure: TypeError('create_record() takes exactly 5 arguments (4 given)',) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware Traceback (most recent call last): 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/designate/api/middleware.py", line 193, in __call__ 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware return request.get_response(self.application) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/.venv/local/lib/python2.7/site-packages/webob/request.py", line 1320, in send 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware application, catch_exc_info=False) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/.venv/local/lib/python2.7/site-packages/webob/request.py", line 1284, in call_application 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware app_iter = application(self.environ, start_response) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/.venv/local/lib/python2.7/site-packages/flask/app.py", line 1836, in __call__ 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware return self.wsgi_app(environ, start_response) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/.venv/local/lib/python2.7/site-packages/flask/app.py", line 1820, in wsgi_app 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware response = self.make_response(self.handle_exception(e)) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/.venv/local/lib/python2.7/site-packages/flask/app.py", line 1403, in handle_exception 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware reraise(exc_type, exc_value, tb) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/.venv/local/lib/python2.7/site-packages/flask/app.py", line 1817, in wsgi_app 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware response = self.full_dispatch_request() 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/.venv/local/lib/python2.7/site-packages/flask/app.py", line 1477, in full_dispatch_request 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware rv = self.handle_user_exception(e) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/.venv/local/lib/python2.7/site-packages/flask/app.py", line 1381, in handle_user_exception 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware reraise(exc_type, exc_value, tb) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/.venv/local/lib/python2.7/site-packages/flask/app.py", line 1475, in full_dispatch_request 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware rv = self.dispatch_request() 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/.venv/local/lib/python2.7/site-packages/flask/app.py", line 1461, in dispatch_request 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware return self.view_functions[rule.endpoint](**req.view_args) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/designate/api/v1/extensions/sync.py", line 29, in sync_domains 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware central_api.sync_domains(context) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/designate/central/rpcapi.py", line 387, in sync_domains 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware return self.call(context, msg) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/designate/openstack/common/rpc/proxy.py", line 125, in call 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware result = rpc.call(context, real_topic, msg, timeout) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/designate/openstack/common/rpc/__init__.py", line 112, in call 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware return _get_impl().call(CONF, context, topic, msg, timeout) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/designate/openstack/common/rpc/impl_kombu.py", line 815, in call 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware rpc_amqp.get_connection_pool(conf, Connection)) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/designate/openstack/common/rpc/amqp.py", line 575, in call 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware rv = list(rv) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/designate/openstack/common/rpc/amqp.py", line 540, in __iter__ 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware raise result 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware Backend_Remote: Unknown backend failure: TypeError('create_record() takes exactly 5 arguments (4 given)',) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware Traceback (most recent call last): 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/designate/openstack/common/rpc/amqp.py", line 462, in _process_data 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware **args) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/designate/openstack/common/rpc/dispatcher.py", line 172, in dispatch 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware result = getattr(proxyobj, method)(ctxt, **kwargs) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/designate/central/service.py", line 987, in sync_domains 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware records) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/usr/lib/python2.7/contextlib.py", line 35, in __exit__ 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware self.gen.throw(type, value, traceback) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/designate/central/service.py", line 44, in wrap_backend_call 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware raise exceptions.Backend('Unknown backend failure: %r' % exc) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware Backend: Unknown backend failure: TypeError('create_record() takes exactly 5 arguments (4 given)',) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware 2014-03-05 12:12:36.756 12200 INFO eventlet.wsgi [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] 78.140.137.211 - - [05/Mar/2014 12:12:36] "POST /v1//domains/sync HTTP/1.1" 500 277 0.192235 ERROR: 'SyncAllCommand' object has no attribute 'formatter' Bug against commit bd9ae5ad80cf29c9b7c7c36df73a9165f04233cc (master) designate configured to use powerdns with sql: [service:central] backend_driver = powerdns [backend:powerdns] database_connection = mysql://designate:designate@sqlserver/pdns connection_debug = 100 connection_trace = False sqlite_synchronous = True idle_timeout = 3600 max_retries = 10 retry_interval = 10 after initializing database and pdns database, server, domain and record created: +------------+--------------------------------------+ | Field | Value | +------------+--------------------------------------+ | updated_at | None | | created_at | 2011-01-21T11:33:21.000000 | | id | 384a9b20-239c-11e2-81c1-0800200c9a66 | | name | ns1.example.org. | +------------+--------------------------------------+ +-------------+--------------------------------------+ | Field | Value | +-------------+--------------------------------------+ | description | None | | created_at | 2014-03-04T17:09:55.000000 | | updated_at | 2014-03-05T10:59:23.000000 | | email | nsadmin@example.org | | ttl | 3600 | | serial | 1394017163 | | id | 530b4711-44df-4b85-b709-a949b874c328 | | name | domain1.com. | +-------------+--------------------------------------+ +-------------+--------------------------------------+ | Field | Value | +-------------+--------------------------------------+ | description | None | | type | A | | created_at | 2014-03-05T10:59:23.000000 | | updated_at | None | | domain_id | 530b4711-44df-4b85-b709-a949b874c328 | | priority | None | | ttl | None | | data | 127.0.0.1 | | id | 4df33ea0-7c41-4553-88a4-224b5e29a754 | | name | www.domain1.com. | +-------------+--------------------------------------+ after issuing designate sync-all: 2014-03-05 12:12:36.563 12200 INFO eventlet.wsgi [-] (12200) accepted ('78.140.137.211', 43723) 2014-03-05 12:12:36.564 12200 INFO designate.central.rpcapi [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] sync_domains: Calling central's sync_domains. 2014-03-05 12:12:36.564 12200 DEBUG designate.openstack.common.rpc.amqp [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] Making synchronous call on central ... multicall /root/designate/designate/openstack/common/rpc/amqp.py:554 2014-03-05 12:12:36.564 12200 DEBUG designate.openstack.common.rpc.amqp [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] MSG_ID is e9758e6bea1e42838fa9281e54b0a39f multicall /root/designate/designate/openstack/common/rpc/amqp.py:557 2014-03-05 12:12:36.565 12200 DEBUG designate.openstack.common.rpc.amqp [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] UNIQUE_ID is 16866ce0eb06443bb375f678b74e7aff. _add_unique_id /root/designate/designate/openstack/common/rpc/amqp.py:342 2014-03-05 12:12:36.566 12208 DEBUG designate.openstack.common.rpc.amqp [-] received {u'_context_domain': None, u'_msg_id': u'e9758e6bea1e42838fa9281e54b0a39f', u'_context_request_id': u'req-8b0f8364-64e6-4540-a50c-572049221953', u'_context_service_catalog': None, u'_context_auth_token': '<SANITIZED>', u'_context_instance_uuid': None, u'_context_user_id': u'noauth-user', u'_reply_q': u'reply_9d3c305012984f0e8cf5363a2d3d73f1', u'_context_show_deleted': False, u'namespace': None, u'_context_is_admin': True, u'version': u'3.0', u'_context_project_domain': None, u'_context_user': u'noauth-user', u'method': u'sync_domains', u'_context_roles': [], u'_context_all_tenants': False, u'args': {}, u'_unique_id': u'16866ce0eb06443bb375f678b74e7aff', u'_context_tenant_id': u'noauth-project', u'_context_user_identity': u'noauth-user noauth-project - - -', u'_context_tenant': u'noauth-project', u'_context_read_only': False, u'_context_user_domain': None} _safe_log /root/designate/designate/openstack/common/rpc/common.py:280 2014-03-05 12:12:36.567 12208 DEBUG designate.openstack.common.rpc.amqp [-] unpacked context: {'instance_uuid': None, 'read_only': False, 'domain': None, 'user_id': u'noauth-user', 'show_deleted': False, 'roles': [], 'user_identity': u'noauth-user noauth-project - - -', 'project_domain': None, 'tenant_id': u'noauth-project', 'auth_token': '<SANITIZED>', 'is_admin': True, 'user': u'noauth-user', 'service_catalog': None, 'request_id': u'req-8b0f8364-64e6-4540-a50c-572049221953', 'user_domain': None, 'all_tenants': False, 'tenant': u'noauth-project'} _safe_log /root/designate/designate/openstack/common/rpc/common.py:280 2014-03-05 12:12:36.567 12208 AUDIT designate.policy [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] Policy check succeeded for rule 'diagnostics_sync_domains' on target {} 2014-03-05 12:12:36,573 INFO sqlalchemy.engine.base.Engine SELECT domains.id AS domains_id, domains.designate_id AS domains_designate_id, domains.name AS domains_name, domains.master AS domains_master, domains.last_check AS domains_last_check, domains.type AS domains_type, domains.notified_serial AS domains_notified_serial, domains.account AS domains_account FROM domains WHERE domains.designate_id = %s 2014-03-05 12:12:36.573 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] SELECT domains.id AS domains_id, domains.designate_id AS domains_designate_id, domains.name AS domains_name, domains.master AS domains_master, domains.last_check AS domains_last_check, domains.type AS domains_type, domains.notified_serial AS domains_notified_serial, domains.account AS domains_account FROM domains WHERE domains.designate_id = %s 2014-03-05 12:12:36,574 INFO sqlalchemy.engine.base.Engine ('530b471144df4b85b709a949b874c328',) 2014-03-05 12:12:36.574 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] ('530b471144df4b85b709a949b874c328',) 2014-03-05 12:12:36,574 DEBUG sqlalchemy.engine.base.Engine Col ('domains_id', 'domains_designate_id', 'domains_name', 'domains_master', 'domains_last_check', 'domains_type', 'domains_notified_serial', 'domains_account') 2014-03-05 12:12:36.574 12208 DEBUG sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] Col ('domains_id', 'domains_designate_id', 'domains_name', 'domains_master', 'domains_last_check', 'domains_type', 'domains_notified_serial', 'domains_account') debug /root/designate/.venv/local/lib/python2.7/site-packages/sqlalchemy/log.py:106 2014-03-05 12:12:36,575 DEBUG sqlalchemy.engine.base.Engine Row (5L, '530b471144df4b85b709a949b874c328', 'domain1.com', 'ns1.example.org', None, 'NATIVE', None, 'noauth-project') 2014-03-05 12:12:36.575 12208 DEBUG sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] Row (5L, '530b471144df4b85b709a949b874c328', 'domain1.com', 'ns1.example.org', None, 'NATIVE', None, 'noauth-project') debug /root/designate/.venv/local/lib/python2.7/site-packages/sqlalchemy/log.py:106 2014-03-05 12:12:36,576 INFO sqlalchemy.engine.base.Engine BEGIN (implicit) 2014-03-05 12:12:36.576 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] BEGIN (implicit) 2014-03-05 12:12:36,576 INFO sqlalchemy.engine.base.Engine DELETE FROM domains WHERE domains.id = %s 2014-03-05 12:12:36.576 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] DELETE FROM domains WHERE domains.id = %s 2014-03-05 12:12:36,576 INFO sqlalchemy.engine.base.Engine (5L,) 2014-03-05 12:12:36.576 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] (5L,) 2014-03-05 12:12:36,577 INFO sqlalchemy.engine.base.Engine COMMIT 2014-03-05 12:12:36.577 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] COMMIT 2014-03-05 12:12:36,610 INFO sqlalchemy.engine.base.Engine DELETE FROM records WHERE records.domain_id = %s 2014-03-05 12:12:36.610 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] DELETE FROM records WHERE records.domain_id = %s 2014-03-05 12:12:36,610 INFO sqlalchemy.engine.base.Engine (5L,) 2014-03-05 12:12:36.610 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] (5L,) 2014-03-05 12:12:36,610 INFO sqlalchemy.engine.base.Engine COMMIT 2014-03-05 12:12:36.610 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] COMMIT 2014-03-05 12:12:36,643 INFO sqlalchemy.engine.base.Engine DELETE FROM domainmetadata WHERE domainmetadata.domain_id = %s 2014-03-05 12:12:36.643 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] DELETE FROM domainmetadata WHERE domainmetadata.domain_id = %s 2014-03-05 12:12:36,643 INFO sqlalchemy.engine.base.Engine (5L,) 2014-03-05 12:12:36.643 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] (5L,) 2014-03-05 12:12:36,644 INFO sqlalchemy.engine.base.Engine COMMIT 2014-03-05 12:12:36.644 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] COMMIT 2014-03-05 12:12:36.645 12208 AUDIT designate.policy [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] Policy check succeeded for rule 'find_servers' on target {} 2014-03-05 12:12:36,647 INFO sqlalchemy.engine.base.Engine BEGIN (implicit) 2014-03-05 12:12:36.647 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] BEGIN (implicit) 2014-03-05 12:12:36,647 INFO sqlalchemy.engine.base.Engine INSERT INTO domains (designate_id, name, master, last_check, type, notified_serial, account) VALUES (%s, %s, %s, %s, %s, %s, %s) 2014-03-05 12:12:36.647 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] INSERT INTO domains (designate_id, name, master, last_check, type, notified_serial, account) VALUES (%s, %s, %s, %s, %s, %s, %s) 2014-03-05 12:12:36,648 INFO sqlalchemy.engine.base.Engine ('530b471144df4b85b709a949b874c328', 'domain1.com', 'ns1.example.org', None, 'NATIVE', None, 'noauth-project') 2014-03-05 12:12:36.648 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] ('530b471144df4b85b709a949b874c328', 'domain1.com', 'ns1.example.org', None, 'NATIVE', None, 'noauth-project') 2014-03-05 12:12:36,648 INFO sqlalchemy.engine.base.Engine COMMIT 2014-03-05 12:12:36.648 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] COMMIT 2014-03-05 12:12:36,676 INFO sqlalchemy.engine.base.Engine BEGIN (implicit) 2014-03-05 12:12:36.676 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] BEGIN (implicit) 2014-03-05 12:12:36,676 INFO sqlalchemy.engine.base.Engine INSERT INTO records (designate_id, designate_recordset_id, domain_id, name, type, content, ttl, prio, change_date, ordername, auth, inherit_ttl) VALUES (%s, %s, %s, %s, %s, %s, %s, %s, %s, %s, %s, %s) 2014-03-05 12:12:36.676 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] INSERT INTO records (designate_id, designate_recordset_id, domain_id, name, type, content, ttl, prio, change_date, ordername, auth, inherit_ttl) VALUES (%s, %s, %s, %s, %s, %s, %s, %s, %s, %s, %s, %s) 2014-03-05 12:12:36,677 INFO sqlalchemy.engine.base.Engine ('384a9b20239c11e281c10800200c9a66', None, 6L, 'domain1.com', 'NS', 'ns1.example.org', 3600L, None, None, None, 1, 1) 2014-03-05 12:12:36.677 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] ('384a9b20239c11e281c10800200c9a66', None, 6L, 'domain1.com', 'NS', 'ns1.example.org', 3600L, None, None, None, 1, 1) 2014-03-05 12:12:36,677 INFO sqlalchemy.engine.base.Engine COMMIT 2014-03-05 12:12:36.677 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] COMMIT 2014-03-05 12:12:36,710 INFO sqlalchemy.engine.base.Engine SELECT tsigkeys.id AS tsigkeys_id, tsigkeys.designate_id AS tsigkeys_designate_id, tsigkeys.name AS tsigkeys_name, tsigkeys.algorithm AS tsigkeys_algorithm, tsigkeys.secret AS tsigkeys_secret FROM tsigkeys 2014-03-05 12:12:36.710 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] SELECT tsigkeys.id AS tsigkeys_id, tsigkeys.designate_id AS tsigkeys_designate_id, tsigkeys.name AS tsigkeys_name, tsigkeys.algorithm AS tsigkeys_algorithm, tsigkeys.secret AS tsigkeys_secret FROM tsigkeys 2014-03-05 12:12:36,710 INFO sqlalchemy.engine.base.Engine () 2014-03-05 12:12:36.710 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] () 2014-03-05 12:12:36,711 DEBUG sqlalchemy.engine.base.Engine Col ('tsigkeys_id', 'tsigkeys_designate_id', 'tsigkeys_name', 'tsigkeys_algorithm', 'tsigkeys_secret') 2014-03-05 12:12:36.711 12208 DEBUG sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] Col ('tsigkeys_id', 'tsigkeys_designate_id', 'tsigkeys_name', 'tsigkeys_algorithm', 'tsigkeys_secret') debug /root/designate/.venv/local/lib/python2.7/site-packages/sqlalchemy/log.py:106 2014-03-05 12:12:36,712 INFO sqlalchemy.engine.base.Engine SELECT domainmetadata.id AS domainmetadata_id, domainmetadata.domain_id AS domainmetadata_domain_id, domainmetadata.kind AS domainmetadata_kind, domainmetadata.content AS domainmetadata_content FROM domainmetadata WHERE domainmetadata.kind = %s AND domainmetadata.domain_id = %s 2014-03-05 12:12:36.712 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] SELECT domainmetadata.id AS domainmetadata_id, domainmetadata.domain_id AS domainmetadata_domain_id, domainmetadata.kind AS domainmetadata_kind, domainmetadata.content AS domainmetadata_content FROM domainmetadata WHERE domainmetadata.kind = %s AND domainmetadata.domain_id = %s 2014-03-05 12:12:36,712 INFO sqlalchemy.engine.base.Engine ('TSIG-ALLOW-AXFR', 6L) 2014-03-05 12:12:36.712 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] ('TSIG-ALLOW-AXFR', 6L) 2014-03-05 12:12:36,713 DEBUG sqlalchemy.engine.base.Engine Col ('domainmetadata_id', 'domainmetadata_domain_id', 'domainmetadata_kind', 'domainmetadata_content') 2014-03-05 12:12:36.713 12208 DEBUG sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] Col ('domainmetadata_id', 'domainmetadata_domain_id', 'domainmetadata_kind', 'domainmetadata_content') debug /root/designate/.venv/local/lib/python2.7/site-packages/sqlalchemy/log.py:106 2014-03-05 12:12:36,714 INFO sqlalchemy.engine.base.Engine SELECT domainmetadata.id AS domainmetadata_id, domainmetadata.domain_id AS domainmetadata_domain_id, domainmetadata.kind AS domainmetadata_kind, domainmetadata.content AS domainmetadata_content FROM domainmetadata WHERE domainmetadata.kind = %s AND domainmetadata.domain_id = %s 2014-03-05 12:12:36.714 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] SELECT domainmetadata.id AS domainmetadata_id, domainmetadata.domain_id AS domainmetadata_domain_id, domainmetadata.kind AS domainmetadata_kind, domainmetadata.content AS domainmetadata_content FROM domainmetadata WHERE domainmetadata.kind = %s AND domainmetadata.domain_id = %s 2014-03-05 12:12:36,714 INFO sqlalchemy.engine.base.Engine ('ALSO-NOTIFY', 6L) 2014-03-05 12:12:36.714 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] ('ALSO-NOTIFY', 6L) 2014-03-05 12:12:36,715 DEBUG sqlalchemy.engine.base.Engine Col ('domainmetadata_id', 'domainmetadata_domain_id', 'domainmetadata_kind', 'domainmetadata_content') 2014-03-05 12:12:36.715 12208 DEBUG sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] Col ('domainmetadata_id', 'domainmetadata_domain_id', 'domainmetadata_kind', 'domainmetadata_content') debug /root/designate/.venv/local/lib/python2.7/site-packages/sqlalchemy/log.py:106 2014-03-05 12:12:36,716 INFO sqlalchemy.engine.base.Engine BEGIN (implicit) 2014-03-05 12:12:36.716 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] BEGIN (implicit) 2014-03-05 12:12:36,716 INFO sqlalchemy.engine.base.Engine INSERT INTO records (designate_id, designate_recordset_id, domain_id, name, type, content, ttl, prio, change_date, ordername, auth, inherit_ttl) VALUES (%s, %s, %s, %s, %s, %s, %s, %s, %s, %s, %s, %s) 2014-03-05 12:12:36.716 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] INSERT INTO records (designate_id, designate_recordset_id, domain_id, name, type, content, ttl, prio, change_date, ordername, auth, inherit_ttl) VALUES (%s, %s, %s, %s, %s, %s, %s, %s, %s, %s, %s, %s) 2014-03-05 12:12:36,716 INFO sqlalchemy.engine.base.Engine ('530b471144df4b85b709a949b874c328', None, 6L, 'domain1.com', 'SOA', 'ns1.example.org. nsadmin.example.org. 1394017163 3600 600 86400 3600', None, None, None, None, 1, 1) 2014-03-05 12:12:36.716 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] ('530b471144df4b85b709a949b874c328', None, 6L, 'domain1.com', 'SOA', 'ns1.example.org. nsadmin.example.org. 1394017163 3600 600 86400 3600', None, None, None, None, 1, 1) 2014-03-05 12:12:36,717 INFO sqlalchemy.engine.base.Engine COMMIT 2014-03-05 12:12:36.717 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] COMMIT 2014-03-05 12:12:36.751 12208 ERROR designate.openstack.common.rpc.amqp [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] Exception during message handling 2014-03-05 12:12:36.751 12208 TRACE designate.openstack.common.rpc.amqp Traceback (most recent call last): 2014-03-05 12:12:36.751 12208 TRACE designate.openstack.common.rpc.amqp File "/root/designate/designate/openstack/common/rpc/amqp.py", line 462, in _process_data 2014-03-05 12:12:36.751 12208 TRACE designate.openstack.common.rpc.amqp **args) 2014-03-05 12:12:36.751 12208 TRACE designate.openstack.common.rpc.amqp File "/root/designate/designate/openstack/common/rpc/dispatcher.py", line 172, in dispatch 2014-03-05 12:12:36.751 12208 TRACE designate.openstack.common.rpc.amqp result = getattr(proxyobj, method)(ctxt, **kwargs) 2014-03-05 12:12:36.751 12208 TRACE designate.openstack.common.rpc.amqp File "/root/designate/designate/central/service.py", line 987, in sync_domains 2014-03-05 12:12:36.751 12208 TRACE designate.openstack.common.rpc.amqp records) 2014-03-05 12:12:36.751 12208 TRACE designate.openstack.common.rpc.amqp File "/usr/lib/python2.7/contextlib.py", line 35, in __exit__ 2014-03-05 12:12:36.751 12208 TRACE designate.openstack.common.rpc.amqp self.gen.throw(type, value, traceback) 2014-03-05 12:12:36.751 12208 TRACE designate.openstack.common.rpc.amqp File "/root/designate/designate/central/service.py", line 44, in wrap_backend_call 2014-03-05 12:12:36.751 12208 TRACE designate.openstack.common.rpc.amqp raise exceptions.Backend('Unknown backend failure: %r' % exc) 2014-03-05 12:12:36.751 12208 TRACE designate.openstack.common.rpc.amqp Backend: Unknown backend failure: TypeError('create_record() takes exactly 5 arguments (4 given)',) 2014-03-05 12:12:36.751 12208 TRACE designate.openstack.common.rpc.amqp 2014-03-05 12:12:36.752 12208 ERROR designate.openstack.common.rpc.common [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] Returning exception Unknown backend failure: TypeError('create_record() takes exactly 5 arguments (4 given)',) to caller 2014-03-05 12:12:36.752 12208 ERROR designate.openstack.common.rpc.common [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] ['Traceback (most recent call last):\n', ' File "/root/designate/designate/openstack/common/rpc/amqp.py", line 462, in _process_data\n **args)\n', ' File "/root/designate/designate/openstack/common/rpc/dispatcher.py", line 172, in dispatch\n result = getattr(proxyobj, method)(ctxt, **kwargs)\n', ' File "/root/designate/designate/central/service.py", line 987, in sync_domains\n records)\n', ' File "/usr/lib/python2.7/contextlib.py", line 35, in __exit__\n self.gen.throw(type, value, traceback)\n', ' File "/root/designate/designate/central/service.py", line 44, in wrap_backend_call\n raise exceptions.Backend(\'Unknown backend failure: %r\' % exc)\n', "Backend: Unknown backend failure: TypeError('create_record() takes exactly 5 arguments (4 given)',)\n"] 2014-03-05 12:12:36.752 12208 DEBUG designate.openstack.common.rpc.amqp [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] UNIQUE_ID is cbcbaa6471a24ad794d40e105dbe2df1. _add_unique_id /root/designate/designate/openstack/common/rpc/amqp.py:342 /root/designate/.venv/local/lib/python2.7/site-packages/amqp/channel.py:616: VDeprecationWarning: The auto_delete flag for exchanges has been deprecated and will be removed from py-amqp v1.5.0.   warn(VDeprecationWarning(EXCHANGE_AUTODELETE_DEPRECATED)) 2014-03-05 12:12:36.754 12200 ERROR designate.api.middleware [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] Unknown backend failure: TypeError('create_record() takes exactly 5 arguments (4 given)',) Traceback (most recent call last):   File "/root/designate/designate/openstack/common/rpc/amqp.py", line 462, in _process_data     **args)   File "/root/designate/designate/openstack/common/rpc/dispatcher.py", line 172, in dispatch     result = getattr(proxyobj, method)(ctxt, **kwargs)   File "/root/designate/designate/central/service.py", line 987, in sync_domains     records)   File "/usr/lib/python2.7/contextlib.py", line 35, in __exit__     self.gen.throw(type, value, traceback)   File "/root/designate/designate/central/service.py", line 44, in wrap_backend_call     raise exceptions.Backend('Unknown backend failure: %r' % exc) Backend: Unknown backend failure: TypeError('create_record() takes exactly 5 arguments (4 given)',) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware Traceback (most recent call last): 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/designate/api/middleware.py", line 193, in __call__ 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware return request.get_response(self.application) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/.venv/local/lib/python2.7/site-packages/webob/request.py", line 1320, in send 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware application, catch_exc_info=False) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/.venv/local/lib/python2.7/site-packages/webob/request.py", line 1284, in call_application 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware app_iter = application(self.environ, start_response) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/.venv/local/lib/python2.7/site-packages/flask/app.py", line 1836, in __call__ 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware return self.wsgi_app(environ, start_response) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/.venv/local/lib/python2.7/site-packages/flask/app.py", line 1820, in wsgi_app 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware response = self.make_response(self.handle_exception(e)) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/.venv/local/lib/python2.7/site-packages/flask/app.py", line 1403, in handle_exception 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware reraise(exc_type, exc_value, tb) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/.venv/local/lib/python2.7/site-packages/flask/app.py", line 1817, in wsgi_app 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware response = self.full_dispatch_request() 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/.venv/local/lib/python2.7/site-packages/flask/app.py", line 1477, in full_dispatch_request 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware rv = self.handle_user_exception(e) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/.venv/local/lib/python2.7/site-packages/flask/app.py", line 1381, in handle_user_exception 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware reraise(exc_type, exc_value, tb) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/.venv/local/lib/python2.7/site-packages/flask/app.py", line 1475, in full_dispatch_request 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware rv = self.dispatch_request() 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/.venv/local/lib/python2.7/site-packages/flask/app.py", line 1461, in dispatch_request 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware return self.view_functions[rule.endpoint](**req.view_args) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/designate/api/v1/extensions/sync.py", line 29, in sync_domains 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware central_api.sync_domains(context) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/designate/central/rpcapi.py", line 387, in sync_domains 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware return self.call(context, msg) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/designate/openstack/common/rpc/proxy.py", line 125, in call 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware result = rpc.call(context, real_topic, msg, timeout) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/designate/openstack/common/rpc/__init__.py", line 112, in call 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware return _get_impl().call(CONF, context, topic, msg, timeout) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/designate/openstack/common/rpc/impl_kombu.py", line 815, in call 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware rpc_amqp.get_connection_pool(conf, Connection)) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/designate/openstack/common/rpc/amqp.py", line 575, in call 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware rv = list(rv) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/designate/openstack/common/rpc/amqp.py", line 540, in __iter__ 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware raise result 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware Backend_Remote: Unknown backend failure: TypeError('create_record() takes exactly 5 arguments (4 given)',) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware Traceback (most recent call last): 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/designate/openstack/common/rpc/amqp.py", line 462, in _process_data 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware **args) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/designate/openstack/common/rpc/dispatcher.py", line 172, in dispatch 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware result = getattr(proxyobj, method)(ctxt, **kwargs) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/designate/central/service.py", line 987, in sync_domains 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware records) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/usr/lib/python2.7/contextlib.py", line 35, in __exit__ 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware self.gen.throw(type, value, traceback) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/designate/central/service.py", line 44, in wrap_backend_call 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware raise exceptions.Backend('Unknown backend failure: %r' % exc) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware Backend: Unknown backend failure: TypeError('create_record() takes exactly 5 arguments (4 given)',) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware 2014-03-05 12:12:36.756 12200 INFO eventlet.wsgi [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] 78.140.137.211 - - [05/Mar/2014 12:12:36] "POST /v1//domains/sync HTTP/1.1" 500 277 0.192235 ERROR: 'SyncAllCommand' object has no attribute 'formatter'
2014-03-05 11:22:44 George Shuklin description Bug against commit bd9ae5ad80cf29c9b7c7c36df73a9165f04233cc (master) designate configured to use powerdns with sql: [service:central] backend_driver = powerdns [backend:powerdns] database_connection = mysql://designate:designate@sqlserver/pdns connection_debug = 100 connection_trace = False sqlite_synchronous = True idle_timeout = 3600 max_retries = 10 retry_interval = 10 after initializing database and pdns database, server, domain and record created: +------------+--------------------------------------+ | Field | Value | +------------+--------------------------------------+ | updated_at | None | | created_at | 2011-01-21T11:33:21.000000 | | id | 384a9b20-239c-11e2-81c1-0800200c9a66 | | name | ns1.example.org. | +------------+--------------------------------------+ +-------------+--------------------------------------+ | Field | Value | +-------------+--------------------------------------+ | description | None | | created_at | 2014-03-04T17:09:55.000000 | | updated_at | 2014-03-05T10:59:23.000000 | | email | nsadmin@example.org | | ttl | 3600 | | serial | 1394017163 | | id | 530b4711-44df-4b85-b709-a949b874c328 | | name | domain1.com. | +-------------+--------------------------------------+ +-------------+--------------------------------------+ | Field | Value | +-------------+--------------------------------------+ | description | None | | type | A | | created_at | 2014-03-05T10:59:23.000000 | | updated_at | None | | domain_id | 530b4711-44df-4b85-b709-a949b874c328 | | priority | None | | ttl | None | | data | 127.0.0.1 | | id | 4df33ea0-7c41-4553-88a4-224b5e29a754 | | name | www.domain1.com. | +-------------+--------------------------------------+ after issuing designate sync-all: 2014-03-05 12:12:36.563 12200 INFO eventlet.wsgi [-] (12200) accepted ('78.140.137.211', 43723) 2014-03-05 12:12:36.564 12200 INFO designate.central.rpcapi [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] sync_domains: Calling central's sync_domains. 2014-03-05 12:12:36.564 12200 DEBUG designate.openstack.common.rpc.amqp [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] Making synchronous call on central ... multicall /root/designate/designate/openstack/common/rpc/amqp.py:554 2014-03-05 12:12:36.564 12200 DEBUG designate.openstack.common.rpc.amqp [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] MSG_ID is e9758e6bea1e42838fa9281e54b0a39f multicall /root/designate/designate/openstack/common/rpc/amqp.py:557 2014-03-05 12:12:36.565 12200 DEBUG designate.openstack.common.rpc.amqp [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] UNIQUE_ID is 16866ce0eb06443bb375f678b74e7aff. _add_unique_id /root/designate/designate/openstack/common/rpc/amqp.py:342 2014-03-05 12:12:36.566 12208 DEBUG designate.openstack.common.rpc.amqp [-] received {u'_context_domain': None, u'_msg_id': u'e9758e6bea1e42838fa9281e54b0a39f', u'_context_request_id': u'req-8b0f8364-64e6-4540-a50c-572049221953', u'_context_service_catalog': None, u'_context_auth_token': '<SANITIZED>', u'_context_instance_uuid': None, u'_context_user_id': u'noauth-user', u'_reply_q': u'reply_9d3c305012984f0e8cf5363a2d3d73f1', u'_context_show_deleted': False, u'namespace': None, u'_context_is_admin': True, u'version': u'3.0', u'_context_project_domain': None, u'_context_user': u'noauth-user', u'method': u'sync_domains', u'_context_roles': [], u'_context_all_tenants': False, u'args': {}, u'_unique_id': u'16866ce0eb06443bb375f678b74e7aff', u'_context_tenant_id': u'noauth-project', u'_context_user_identity': u'noauth-user noauth-project - - -', u'_context_tenant': u'noauth-project', u'_context_read_only': False, u'_context_user_domain': None} _safe_log /root/designate/designate/openstack/common/rpc/common.py:280 2014-03-05 12:12:36.567 12208 DEBUG designate.openstack.common.rpc.amqp [-] unpacked context: {'instance_uuid': None, 'read_only': False, 'domain': None, 'user_id': u'noauth-user', 'show_deleted': False, 'roles': [], 'user_identity': u'noauth-user noauth-project - - -', 'project_domain': None, 'tenant_id': u'noauth-project', 'auth_token': '<SANITIZED>', 'is_admin': True, 'user': u'noauth-user', 'service_catalog': None, 'request_id': u'req-8b0f8364-64e6-4540-a50c-572049221953', 'user_domain': None, 'all_tenants': False, 'tenant': u'noauth-project'} _safe_log /root/designate/designate/openstack/common/rpc/common.py:280 2014-03-05 12:12:36.567 12208 AUDIT designate.policy [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] Policy check succeeded for rule 'diagnostics_sync_domains' on target {} 2014-03-05 12:12:36,573 INFO sqlalchemy.engine.base.Engine SELECT domains.id AS domains_id, domains.designate_id AS domains_designate_id, domains.name AS domains_name, domains.master AS domains_master, domains.last_check AS domains_last_check, domains.type AS domains_type, domains.notified_serial AS domains_notified_serial, domains.account AS domains_account FROM domains WHERE domains.designate_id = %s 2014-03-05 12:12:36.573 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] SELECT domains.id AS domains_id, domains.designate_id AS domains_designate_id, domains.name AS domains_name, domains.master AS domains_master, domains.last_check AS domains_last_check, domains.type AS domains_type, domains.notified_serial AS domains_notified_serial, domains.account AS domains_account FROM domains WHERE domains.designate_id = %s 2014-03-05 12:12:36,574 INFO sqlalchemy.engine.base.Engine ('530b471144df4b85b709a949b874c328',) 2014-03-05 12:12:36.574 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] ('530b471144df4b85b709a949b874c328',) 2014-03-05 12:12:36,574 DEBUG sqlalchemy.engine.base.Engine Col ('domains_id', 'domains_designate_id', 'domains_name', 'domains_master', 'domains_last_check', 'domains_type', 'domains_notified_serial', 'domains_account') 2014-03-05 12:12:36.574 12208 DEBUG sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] Col ('domains_id', 'domains_designate_id', 'domains_name', 'domains_master', 'domains_last_check', 'domains_type', 'domains_notified_serial', 'domains_account') debug /root/designate/.venv/local/lib/python2.7/site-packages/sqlalchemy/log.py:106 2014-03-05 12:12:36,575 DEBUG sqlalchemy.engine.base.Engine Row (5L, '530b471144df4b85b709a949b874c328', 'domain1.com', 'ns1.example.org', None, 'NATIVE', None, 'noauth-project') 2014-03-05 12:12:36.575 12208 DEBUG sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] Row (5L, '530b471144df4b85b709a949b874c328', 'domain1.com', 'ns1.example.org', None, 'NATIVE', None, 'noauth-project') debug /root/designate/.venv/local/lib/python2.7/site-packages/sqlalchemy/log.py:106 2014-03-05 12:12:36,576 INFO sqlalchemy.engine.base.Engine BEGIN (implicit) 2014-03-05 12:12:36.576 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] BEGIN (implicit) 2014-03-05 12:12:36,576 INFO sqlalchemy.engine.base.Engine DELETE FROM domains WHERE domains.id = %s 2014-03-05 12:12:36.576 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] DELETE FROM domains WHERE domains.id = %s 2014-03-05 12:12:36,576 INFO sqlalchemy.engine.base.Engine (5L,) 2014-03-05 12:12:36.576 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] (5L,) 2014-03-05 12:12:36,577 INFO sqlalchemy.engine.base.Engine COMMIT 2014-03-05 12:12:36.577 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] COMMIT 2014-03-05 12:12:36,610 INFO sqlalchemy.engine.base.Engine DELETE FROM records WHERE records.domain_id = %s 2014-03-05 12:12:36.610 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] DELETE FROM records WHERE records.domain_id = %s 2014-03-05 12:12:36,610 INFO sqlalchemy.engine.base.Engine (5L,) 2014-03-05 12:12:36.610 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] (5L,) 2014-03-05 12:12:36,610 INFO sqlalchemy.engine.base.Engine COMMIT 2014-03-05 12:12:36.610 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] COMMIT 2014-03-05 12:12:36,643 INFO sqlalchemy.engine.base.Engine DELETE FROM domainmetadata WHERE domainmetadata.domain_id = %s 2014-03-05 12:12:36.643 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] DELETE FROM domainmetadata WHERE domainmetadata.domain_id = %s 2014-03-05 12:12:36,643 INFO sqlalchemy.engine.base.Engine (5L,) 2014-03-05 12:12:36.643 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] (5L,) 2014-03-05 12:12:36,644 INFO sqlalchemy.engine.base.Engine COMMIT 2014-03-05 12:12:36.644 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] COMMIT 2014-03-05 12:12:36.645 12208 AUDIT designate.policy [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] Policy check succeeded for rule 'find_servers' on target {} 2014-03-05 12:12:36,647 INFO sqlalchemy.engine.base.Engine BEGIN (implicit) 2014-03-05 12:12:36.647 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] BEGIN (implicit) 2014-03-05 12:12:36,647 INFO sqlalchemy.engine.base.Engine INSERT INTO domains (designate_id, name, master, last_check, type, notified_serial, account) VALUES (%s, %s, %s, %s, %s, %s, %s) 2014-03-05 12:12:36.647 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] INSERT INTO domains (designate_id, name, master, last_check, type, notified_serial, account) VALUES (%s, %s, %s, %s, %s, %s, %s) 2014-03-05 12:12:36,648 INFO sqlalchemy.engine.base.Engine ('530b471144df4b85b709a949b874c328', 'domain1.com', 'ns1.example.org', None, 'NATIVE', None, 'noauth-project') 2014-03-05 12:12:36.648 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] ('530b471144df4b85b709a949b874c328', 'domain1.com', 'ns1.example.org', None, 'NATIVE', None, 'noauth-project') 2014-03-05 12:12:36,648 INFO sqlalchemy.engine.base.Engine COMMIT 2014-03-05 12:12:36.648 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] COMMIT 2014-03-05 12:12:36,676 INFO sqlalchemy.engine.base.Engine BEGIN (implicit) 2014-03-05 12:12:36.676 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] BEGIN (implicit) 2014-03-05 12:12:36,676 INFO sqlalchemy.engine.base.Engine INSERT INTO records (designate_id, designate_recordset_id, domain_id, name, type, content, ttl, prio, change_date, ordername, auth, inherit_ttl) VALUES (%s, %s, %s, %s, %s, %s, %s, %s, %s, %s, %s, %s) 2014-03-05 12:12:36.676 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] INSERT INTO records (designate_id, designate_recordset_id, domain_id, name, type, content, ttl, prio, change_date, ordername, auth, inherit_ttl) VALUES (%s, %s, %s, %s, %s, %s, %s, %s, %s, %s, %s, %s) 2014-03-05 12:12:36,677 INFO sqlalchemy.engine.base.Engine ('384a9b20239c11e281c10800200c9a66', None, 6L, 'domain1.com', 'NS', 'ns1.example.org', 3600L, None, None, None, 1, 1) 2014-03-05 12:12:36.677 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] ('384a9b20239c11e281c10800200c9a66', None, 6L, 'domain1.com', 'NS', 'ns1.example.org', 3600L, None, None, None, 1, 1) 2014-03-05 12:12:36,677 INFO sqlalchemy.engine.base.Engine COMMIT 2014-03-05 12:12:36.677 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] COMMIT 2014-03-05 12:12:36,710 INFO sqlalchemy.engine.base.Engine SELECT tsigkeys.id AS tsigkeys_id, tsigkeys.designate_id AS tsigkeys_designate_id, tsigkeys.name AS tsigkeys_name, tsigkeys.algorithm AS tsigkeys_algorithm, tsigkeys.secret AS tsigkeys_secret FROM tsigkeys 2014-03-05 12:12:36.710 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] SELECT tsigkeys.id AS tsigkeys_id, tsigkeys.designate_id AS tsigkeys_designate_id, tsigkeys.name AS tsigkeys_name, tsigkeys.algorithm AS tsigkeys_algorithm, tsigkeys.secret AS tsigkeys_secret FROM tsigkeys 2014-03-05 12:12:36,710 INFO sqlalchemy.engine.base.Engine () 2014-03-05 12:12:36.710 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] () 2014-03-05 12:12:36,711 DEBUG sqlalchemy.engine.base.Engine Col ('tsigkeys_id', 'tsigkeys_designate_id', 'tsigkeys_name', 'tsigkeys_algorithm', 'tsigkeys_secret') 2014-03-05 12:12:36.711 12208 DEBUG sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] Col ('tsigkeys_id', 'tsigkeys_designate_id', 'tsigkeys_name', 'tsigkeys_algorithm', 'tsigkeys_secret') debug /root/designate/.venv/local/lib/python2.7/site-packages/sqlalchemy/log.py:106 2014-03-05 12:12:36,712 INFO sqlalchemy.engine.base.Engine SELECT domainmetadata.id AS domainmetadata_id, domainmetadata.domain_id AS domainmetadata_domain_id, domainmetadata.kind AS domainmetadata_kind, domainmetadata.content AS domainmetadata_content FROM domainmetadata WHERE domainmetadata.kind = %s AND domainmetadata.domain_id = %s 2014-03-05 12:12:36.712 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] SELECT domainmetadata.id AS domainmetadata_id, domainmetadata.domain_id AS domainmetadata_domain_id, domainmetadata.kind AS domainmetadata_kind, domainmetadata.content AS domainmetadata_content FROM domainmetadata WHERE domainmetadata.kind = %s AND domainmetadata.domain_id = %s 2014-03-05 12:12:36,712 INFO sqlalchemy.engine.base.Engine ('TSIG-ALLOW-AXFR', 6L) 2014-03-05 12:12:36.712 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] ('TSIG-ALLOW-AXFR', 6L) 2014-03-05 12:12:36,713 DEBUG sqlalchemy.engine.base.Engine Col ('domainmetadata_id', 'domainmetadata_domain_id', 'domainmetadata_kind', 'domainmetadata_content') 2014-03-05 12:12:36.713 12208 DEBUG sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] Col ('domainmetadata_id', 'domainmetadata_domain_id', 'domainmetadata_kind', 'domainmetadata_content') debug /root/designate/.venv/local/lib/python2.7/site-packages/sqlalchemy/log.py:106 2014-03-05 12:12:36,714 INFO sqlalchemy.engine.base.Engine SELECT domainmetadata.id AS domainmetadata_id, domainmetadata.domain_id AS domainmetadata_domain_id, domainmetadata.kind AS domainmetadata_kind, domainmetadata.content AS domainmetadata_content FROM domainmetadata WHERE domainmetadata.kind = %s AND domainmetadata.domain_id = %s 2014-03-05 12:12:36.714 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] SELECT domainmetadata.id AS domainmetadata_id, domainmetadata.domain_id AS domainmetadata_domain_id, domainmetadata.kind AS domainmetadata_kind, domainmetadata.content AS domainmetadata_content FROM domainmetadata WHERE domainmetadata.kind = %s AND domainmetadata.domain_id = %s 2014-03-05 12:12:36,714 INFO sqlalchemy.engine.base.Engine ('ALSO-NOTIFY', 6L) 2014-03-05 12:12:36.714 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] ('ALSO-NOTIFY', 6L) 2014-03-05 12:12:36,715 DEBUG sqlalchemy.engine.base.Engine Col ('domainmetadata_id', 'domainmetadata_domain_id', 'domainmetadata_kind', 'domainmetadata_content') 2014-03-05 12:12:36.715 12208 DEBUG sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] Col ('domainmetadata_id', 'domainmetadata_domain_id', 'domainmetadata_kind', 'domainmetadata_content') debug /root/designate/.venv/local/lib/python2.7/site-packages/sqlalchemy/log.py:106 2014-03-05 12:12:36,716 INFO sqlalchemy.engine.base.Engine BEGIN (implicit) 2014-03-05 12:12:36.716 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] BEGIN (implicit) 2014-03-05 12:12:36,716 INFO sqlalchemy.engine.base.Engine INSERT INTO records (designate_id, designate_recordset_id, domain_id, name, type, content, ttl, prio, change_date, ordername, auth, inherit_ttl) VALUES (%s, %s, %s, %s, %s, %s, %s, %s, %s, %s, %s, %s) 2014-03-05 12:12:36.716 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] INSERT INTO records (designate_id, designate_recordset_id, domain_id, name, type, content, ttl, prio, change_date, ordername, auth, inherit_ttl) VALUES (%s, %s, %s, %s, %s, %s, %s, %s, %s, %s, %s, %s) 2014-03-05 12:12:36,716 INFO sqlalchemy.engine.base.Engine ('530b471144df4b85b709a949b874c328', None, 6L, 'domain1.com', 'SOA', 'ns1.example.org. nsadmin.example.org. 1394017163 3600 600 86400 3600', None, None, None, None, 1, 1) 2014-03-05 12:12:36.716 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] ('530b471144df4b85b709a949b874c328', None, 6L, 'domain1.com', 'SOA', 'ns1.example.org. nsadmin.example.org. 1394017163 3600 600 86400 3600', None, None, None, None, 1, 1) 2014-03-05 12:12:36,717 INFO sqlalchemy.engine.base.Engine COMMIT 2014-03-05 12:12:36.717 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] COMMIT 2014-03-05 12:12:36.751 12208 ERROR designate.openstack.common.rpc.amqp [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] Exception during message handling 2014-03-05 12:12:36.751 12208 TRACE designate.openstack.common.rpc.amqp Traceback (most recent call last): 2014-03-05 12:12:36.751 12208 TRACE designate.openstack.common.rpc.amqp File "/root/designate/designate/openstack/common/rpc/amqp.py", line 462, in _process_data 2014-03-05 12:12:36.751 12208 TRACE designate.openstack.common.rpc.amqp **args) 2014-03-05 12:12:36.751 12208 TRACE designate.openstack.common.rpc.amqp File "/root/designate/designate/openstack/common/rpc/dispatcher.py", line 172, in dispatch 2014-03-05 12:12:36.751 12208 TRACE designate.openstack.common.rpc.amqp result = getattr(proxyobj, method)(ctxt, **kwargs) 2014-03-05 12:12:36.751 12208 TRACE designate.openstack.common.rpc.amqp File "/root/designate/designate/central/service.py", line 987, in sync_domains 2014-03-05 12:12:36.751 12208 TRACE designate.openstack.common.rpc.amqp records) 2014-03-05 12:12:36.751 12208 TRACE designate.openstack.common.rpc.amqp File "/usr/lib/python2.7/contextlib.py", line 35, in __exit__ 2014-03-05 12:12:36.751 12208 TRACE designate.openstack.common.rpc.amqp self.gen.throw(type, value, traceback) 2014-03-05 12:12:36.751 12208 TRACE designate.openstack.common.rpc.amqp File "/root/designate/designate/central/service.py", line 44, in wrap_backend_call 2014-03-05 12:12:36.751 12208 TRACE designate.openstack.common.rpc.amqp raise exceptions.Backend('Unknown backend failure: %r' % exc) 2014-03-05 12:12:36.751 12208 TRACE designate.openstack.common.rpc.amqp Backend: Unknown backend failure: TypeError('create_record() takes exactly 5 arguments (4 given)',) 2014-03-05 12:12:36.751 12208 TRACE designate.openstack.common.rpc.amqp 2014-03-05 12:12:36.752 12208 ERROR designate.openstack.common.rpc.common [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] Returning exception Unknown backend failure: TypeError('create_record() takes exactly 5 arguments (4 given)',) to caller 2014-03-05 12:12:36.752 12208 ERROR designate.openstack.common.rpc.common [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] ['Traceback (most recent call last):\n', ' File "/root/designate/designate/openstack/common/rpc/amqp.py", line 462, in _process_data\n **args)\n', ' File "/root/designate/designate/openstack/common/rpc/dispatcher.py", line 172, in dispatch\n result = getattr(proxyobj, method)(ctxt, **kwargs)\n', ' File "/root/designate/designate/central/service.py", line 987, in sync_domains\n records)\n', ' File "/usr/lib/python2.7/contextlib.py", line 35, in __exit__\n self.gen.throw(type, value, traceback)\n', ' File "/root/designate/designate/central/service.py", line 44, in wrap_backend_call\n raise exceptions.Backend(\'Unknown backend failure: %r\' % exc)\n', "Backend: Unknown backend failure: TypeError('create_record() takes exactly 5 arguments (4 given)',)\n"] 2014-03-05 12:12:36.752 12208 DEBUG designate.openstack.common.rpc.amqp [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] UNIQUE_ID is cbcbaa6471a24ad794d40e105dbe2df1. _add_unique_id /root/designate/designate/openstack/common/rpc/amqp.py:342 /root/designate/.venv/local/lib/python2.7/site-packages/amqp/channel.py:616: VDeprecationWarning: The auto_delete flag for exchanges has been deprecated and will be removed from py-amqp v1.5.0.   warn(VDeprecationWarning(EXCHANGE_AUTODELETE_DEPRECATED)) 2014-03-05 12:12:36.754 12200 ERROR designate.api.middleware [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] Unknown backend failure: TypeError('create_record() takes exactly 5 arguments (4 given)',) Traceback (most recent call last):   File "/root/designate/designate/openstack/common/rpc/amqp.py", line 462, in _process_data     **args)   File "/root/designate/designate/openstack/common/rpc/dispatcher.py", line 172, in dispatch     result = getattr(proxyobj, method)(ctxt, **kwargs)   File "/root/designate/designate/central/service.py", line 987, in sync_domains     records)   File "/usr/lib/python2.7/contextlib.py", line 35, in __exit__     self.gen.throw(type, value, traceback)   File "/root/designate/designate/central/service.py", line 44, in wrap_backend_call     raise exceptions.Backend('Unknown backend failure: %r' % exc) Backend: Unknown backend failure: TypeError('create_record() takes exactly 5 arguments (4 given)',) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware Traceback (most recent call last): 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/designate/api/middleware.py", line 193, in __call__ 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware return request.get_response(self.application) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/.venv/local/lib/python2.7/site-packages/webob/request.py", line 1320, in send 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware application, catch_exc_info=False) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/.venv/local/lib/python2.7/site-packages/webob/request.py", line 1284, in call_application 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware app_iter = application(self.environ, start_response) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/.venv/local/lib/python2.7/site-packages/flask/app.py", line 1836, in __call__ 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware return self.wsgi_app(environ, start_response) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/.venv/local/lib/python2.7/site-packages/flask/app.py", line 1820, in wsgi_app 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware response = self.make_response(self.handle_exception(e)) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/.venv/local/lib/python2.7/site-packages/flask/app.py", line 1403, in handle_exception 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware reraise(exc_type, exc_value, tb) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/.venv/local/lib/python2.7/site-packages/flask/app.py", line 1817, in wsgi_app 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware response = self.full_dispatch_request() 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/.venv/local/lib/python2.7/site-packages/flask/app.py", line 1477, in full_dispatch_request 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware rv = self.handle_user_exception(e) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/.venv/local/lib/python2.7/site-packages/flask/app.py", line 1381, in handle_user_exception 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware reraise(exc_type, exc_value, tb) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/.venv/local/lib/python2.7/site-packages/flask/app.py", line 1475, in full_dispatch_request 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware rv = self.dispatch_request() 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/.venv/local/lib/python2.7/site-packages/flask/app.py", line 1461, in dispatch_request 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware return self.view_functions[rule.endpoint](**req.view_args) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/designate/api/v1/extensions/sync.py", line 29, in sync_domains 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware central_api.sync_domains(context) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/designate/central/rpcapi.py", line 387, in sync_domains 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware return self.call(context, msg) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/designate/openstack/common/rpc/proxy.py", line 125, in call 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware result = rpc.call(context, real_topic, msg, timeout) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/designate/openstack/common/rpc/__init__.py", line 112, in call 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware return _get_impl().call(CONF, context, topic, msg, timeout) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/designate/openstack/common/rpc/impl_kombu.py", line 815, in call 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware rpc_amqp.get_connection_pool(conf, Connection)) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/designate/openstack/common/rpc/amqp.py", line 575, in call 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware rv = list(rv) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/designate/openstack/common/rpc/amqp.py", line 540, in __iter__ 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware raise result 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware Backend_Remote: Unknown backend failure: TypeError('create_record() takes exactly 5 arguments (4 given)',) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware Traceback (most recent call last): 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/designate/openstack/common/rpc/amqp.py", line 462, in _process_data 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware **args) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/designate/openstack/common/rpc/dispatcher.py", line 172, in dispatch 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware result = getattr(proxyobj, method)(ctxt, **kwargs) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/designate/central/service.py", line 987, in sync_domains 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware records) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/usr/lib/python2.7/contextlib.py", line 35, in __exit__ 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware self.gen.throw(type, value, traceback) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/designate/central/service.py", line 44, in wrap_backend_call 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware raise exceptions.Backend('Unknown backend failure: %r' % exc) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware Backend: Unknown backend failure: TypeError('create_record() takes exactly 5 arguments (4 given)',) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware 2014-03-05 12:12:36.756 12200 INFO eventlet.wsgi [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] 78.140.137.211 - - [05/Mar/2014 12:12:36] "POST /v1//domains/sync HTTP/1.1" 500 277 0.192235 ERROR: 'SyncAllCommand' object has no attribute 'formatter' Bug against commit bd9ae5ad80cf29c9b7c7c36df73a9165f04233cc (master) same bug with designate-2014.1.b2.tar.gz designate configured to use powerdns with sql: [service:central] backend_driver = powerdns [backend:powerdns] database_connection = mysql://designate:designate@sqlserver/pdns connection_debug = 100 connection_trace = False sqlite_synchronous = True idle_timeout = 3600 max_retries = 10 retry_interval = 10 after initializing database and pdns database, server, domain and record created: +------------+--------------------------------------+ | Field | Value | +------------+--------------------------------------+ | updated_at | None | | created_at | 2011-01-21T11:33:21.000000 | | id | 384a9b20-239c-11e2-81c1-0800200c9a66 | | name | ns1.example.org. | +------------+--------------------------------------+ +-------------+--------------------------------------+ | Field | Value | +-------------+--------------------------------------+ | description | None | | created_at | 2014-03-04T17:09:55.000000 | | updated_at | 2014-03-05T10:59:23.000000 | | email | nsadmin@example.org | | ttl | 3600 | | serial | 1394017163 | | id | 530b4711-44df-4b85-b709-a949b874c328 | | name | domain1.com. | +-------------+--------------------------------------+ +-------------+--------------------------------------+ | Field | Value | +-------------+--------------------------------------+ | description | None | | type | A | | created_at | 2014-03-05T10:59:23.000000 | | updated_at | None | | domain_id | 530b4711-44df-4b85-b709-a949b874c328 | | priority | None | | ttl | None | | data | 127.0.0.1 | | id | 4df33ea0-7c41-4553-88a4-224b5e29a754 | | name | www.domain1.com. | +-------------+--------------------------------------+ after issuing designate sync-all: 2014-03-05 12:12:36.563 12200 INFO eventlet.wsgi [-] (12200) accepted ('78.140.137.211', 43723) 2014-03-05 12:12:36.564 12200 INFO designate.central.rpcapi [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] sync_domains: Calling central's sync_domains. 2014-03-05 12:12:36.564 12200 DEBUG designate.openstack.common.rpc.amqp [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] Making synchronous call on central ... multicall /root/designate/designate/openstack/common/rpc/amqp.py:554 2014-03-05 12:12:36.564 12200 DEBUG designate.openstack.common.rpc.amqp [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] MSG_ID is e9758e6bea1e42838fa9281e54b0a39f multicall /root/designate/designate/openstack/common/rpc/amqp.py:557 2014-03-05 12:12:36.565 12200 DEBUG designate.openstack.common.rpc.amqp [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] UNIQUE_ID is 16866ce0eb06443bb375f678b74e7aff. _add_unique_id /root/designate/designate/openstack/common/rpc/amqp.py:342 2014-03-05 12:12:36.566 12208 DEBUG designate.openstack.common.rpc.amqp [-] received {u'_context_domain': None, u'_msg_id': u'e9758e6bea1e42838fa9281e54b0a39f', u'_context_request_id': u'req-8b0f8364-64e6-4540-a50c-572049221953', u'_context_service_catalog': None, u'_context_auth_token': '<SANITIZED>', u'_context_instance_uuid': None, u'_context_user_id': u'noauth-user', u'_reply_q': u'reply_9d3c305012984f0e8cf5363a2d3d73f1', u'_context_show_deleted': False, u'namespace': None, u'_context_is_admin': True, u'version': u'3.0', u'_context_project_domain': None, u'_context_user': u'noauth-user', u'method': u'sync_domains', u'_context_roles': [], u'_context_all_tenants': False, u'args': {}, u'_unique_id': u'16866ce0eb06443bb375f678b74e7aff', u'_context_tenant_id': u'noauth-project', u'_context_user_identity': u'noauth-user noauth-project - - -', u'_context_tenant': u'noauth-project', u'_context_read_only': False, u'_context_user_domain': None} _safe_log /root/designate/designate/openstack/common/rpc/common.py:280 2014-03-05 12:12:36.567 12208 DEBUG designate.openstack.common.rpc.amqp [-] unpacked context: {'instance_uuid': None, 'read_only': False, 'domain': None, 'user_id': u'noauth-user', 'show_deleted': False, 'roles': [], 'user_identity': u'noauth-user noauth-project - - -', 'project_domain': None, 'tenant_id': u'noauth-project', 'auth_token': '<SANITIZED>', 'is_admin': True, 'user': u'noauth-user', 'service_catalog': None, 'request_id': u'req-8b0f8364-64e6-4540-a50c-572049221953', 'user_domain': None, 'all_tenants': False, 'tenant': u'noauth-project'} _safe_log /root/designate/designate/openstack/common/rpc/common.py:280 2014-03-05 12:12:36.567 12208 AUDIT designate.policy [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] Policy check succeeded for rule 'diagnostics_sync_domains' on target {} 2014-03-05 12:12:36,573 INFO sqlalchemy.engine.base.Engine SELECT domains.id AS domains_id, domains.designate_id AS domains_designate_id, domains.name AS domains_name, domains.master AS domains_master, domains.last_check AS domains_last_check, domains.type AS domains_type, domains.notified_serial AS domains_notified_serial, domains.account AS domains_account FROM domains WHERE domains.designate_id = %s 2014-03-05 12:12:36.573 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] SELECT domains.id AS domains_id, domains.designate_id AS domains_designate_id, domains.name AS domains_name, domains.master AS domains_master, domains.last_check AS domains_last_check, domains.type AS domains_type, domains.notified_serial AS domains_notified_serial, domains.account AS domains_account FROM domains WHERE domains.designate_id = %s 2014-03-05 12:12:36,574 INFO sqlalchemy.engine.base.Engine ('530b471144df4b85b709a949b874c328',) 2014-03-05 12:12:36.574 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] ('530b471144df4b85b709a949b874c328',) 2014-03-05 12:12:36,574 DEBUG sqlalchemy.engine.base.Engine Col ('domains_id', 'domains_designate_id', 'domains_name', 'domains_master', 'domains_last_check', 'domains_type', 'domains_notified_serial', 'domains_account') 2014-03-05 12:12:36.574 12208 DEBUG sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] Col ('domains_id', 'domains_designate_id', 'domains_name', 'domains_master', 'domains_last_check', 'domains_type', 'domains_notified_serial', 'domains_account') debug /root/designate/.venv/local/lib/python2.7/site-packages/sqlalchemy/log.py:106 2014-03-05 12:12:36,575 DEBUG sqlalchemy.engine.base.Engine Row (5L, '530b471144df4b85b709a949b874c328', 'domain1.com', 'ns1.example.org', None, 'NATIVE', None, 'noauth-project') 2014-03-05 12:12:36.575 12208 DEBUG sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] Row (5L, '530b471144df4b85b709a949b874c328', 'domain1.com', 'ns1.example.org', None, 'NATIVE', None, 'noauth-project') debug /root/designate/.venv/local/lib/python2.7/site-packages/sqlalchemy/log.py:106 2014-03-05 12:12:36,576 INFO sqlalchemy.engine.base.Engine BEGIN (implicit) 2014-03-05 12:12:36.576 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] BEGIN (implicit) 2014-03-05 12:12:36,576 INFO sqlalchemy.engine.base.Engine DELETE FROM domains WHERE domains.id = %s 2014-03-05 12:12:36.576 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] DELETE FROM domains WHERE domains.id = %s 2014-03-05 12:12:36,576 INFO sqlalchemy.engine.base.Engine (5L,) 2014-03-05 12:12:36.576 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] (5L,) 2014-03-05 12:12:36,577 INFO sqlalchemy.engine.base.Engine COMMIT 2014-03-05 12:12:36.577 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] COMMIT 2014-03-05 12:12:36,610 INFO sqlalchemy.engine.base.Engine DELETE FROM records WHERE records.domain_id = %s 2014-03-05 12:12:36.610 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] DELETE FROM records WHERE records.domain_id = %s 2014-03-05 12:12:36,610 INFO sqlalchemy.engine.base.Engine (5L,) 2014-03-05 12:12:36.610 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] (5L,) 2014-03-05 12:12:36,610 INFO sqlalchemy.engine.base.Engine COMMIT 2014-03-05 12:12:36.610 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] COMMIT 2014-03-05 12:12:36,643 INFO sqlalchemy.engine.base.Engine DELETE FROM domainmetadata WHERE domainmetadata.domain_id = %s 2014-03-05 12:12:36.643 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] DELETE FROM domainmetadata WHERE domainmetadata.domain_id = %s 2014-03-05 12:12:36,643 INFO sqlalchemy.engine.base.Engine (5L,) 2014-03-05 12:12:36.643 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] (5L,) 2014-03-05 12:12:36,644 INFO sqlalchemy.engine.base.Engine COMMIT 2014-03-05 12:12:36.644 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] COMMIT 2014-03-05 12:12:36.645 12208 AUDIT designate.policy [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] Policy check succeeded for rule 'find_servers' on target {} 2014-03-05 12:12:36,647 INFO sqlalchemy.engine.base.Engine BEGIN (implicit) 2014-03-05 12:12:36.647 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] BEGIN (implicit) 2014-03-05 12:12:36,647 INFO sqlalchemy.engine.base.Engine INSERT INTO domains (designate_id, name, master, last_check, type, notified_serial, account) VALUES (%s, %s, %s, %s, %s, %s, %s) 2014-03-05 12:12:36.647 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] INSERT INTO domains (designate_id, name, master, last_check, type, notified_serial, account) VALUES (%s, %s, %s, %s, %s, %s, %s) 2014-03-05 12:12:36,648 INFO sqlalchemy.engine.base.Engine ('530b471144df4b85b709a949b874c328', 'domain1.com', 'ns1.example.org', None, 'NATIVE', None, 'noauth-project') 2014-03-05 12:12:36.648 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] ('530b471144df4b85b709a949b874c328', 'domain1.com', 'ns1.example.org', None, 'NATIVE', None, 'noauth-project') 2014-03-05 12:12:36,648 INFO sqlalchemy.engine.base.Engine COMMIT 2014-03-05 12:12:36.648 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] COMMIT 2014-03-05 12:12:36,676 INFO sqlalchemy.engine.base.Engine BEGIN (implicit) 2014-03-05 12:12:36.676 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] BEGIN (implicit) 2014-03-05 12:12:36,676 INFO sqlalchemy.engine.base.Engine INSERT INTO records (designate_id, designate_recordset_id, domain_id, name, type, content, ttl, prio, change_date, ordername, auth, inherit_ttl) VALUES (%s, %s, %s, %s, %s, %s, %s, %s, %s, %s, %s, %s) 2014-03-05 12:12:36.676 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] INSERT INTO records (designate_id, designate_recordset_id, domain_id, name, type, content, ttl, prio, change_date, ordername, auth, inherit_ttl) VALUES (%s, %s, %s, %s, %s, %s, %s, %s, %s, %s, %s, %s) 2014-03-05 12:12:36,677 INFO sqlalchemy.engine.base.Engine ('384a9b20239c11e281c10800200c9a66', None, 6L, 'domain1.com', 'NS', 'ns1.example.org', 3600L, None, None, None, 1, 1) 2014-03-05 12:12:36.677 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] ('384a9b20239c11e281c10800200c9a66', None, 6L, 'domain1.com', 'NS', 'ns1.example.org', 3600L, None, None, None, 1, 1) 2014-03-05 12:12:36,677 INFO sqlalchemy.engine.base.Engine COMMIT 2014-03-05 12:12:36.677 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] COMMIT 2014-03-05 12:12:36,710 INFO sqlalchemy.engine.base.Engine SELECT tsigkeys.id AS tsigkeys_id, tsigkeys.designate_id AS tsigkeys_designate_id, tsigkeys.name AS tsigkeys_name, tsigkeys.algorithm AS tsigkeys_algorithm, tsigkeys.secret AS tsigkeys_secret FROM tsigkeys 2014-03-05 12:12:36.710 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] SELECT tsigkeys.id AS tsigkeys_id, tsigkeys.designate_id AS tsigkeys_designate_id, tsigkeys.name AS tsigkeys_name, tsigkeys.algorithm AS tsigkeys_algorithm, tsigkeys.secret AS tsigkeys_secret FROM tsigkeys 2014-03-05 12:12:36,710 INFO sqlalchemy.engine.base.Engine () 2014-03-05 12:12:36.710 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] () 2014-03-05 12:12:36,711 DEBUG sqlalchemy.engine.base.Engine Col ('tsigkeys_id', 'tsigkeys_designate_id', 'tsigkeys_name', 'tsigkeys_algorithm', 'tsigkeys_secret') 2014-03-05 12:12:36.711 12208 DEBUG sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] Col ('tsigkeys_id', 'tsigkeys_designate_id', 'tsigkeys_name', 'tsigkeys_algorithm', 'tsigkeys_secret') debug /root/designate/.venv/local/lib/python2.7/site-packages/sqlalchemy/log.py:106 2014-03-05 12:12:36,712 INFO sqlalchemy.engine.base.Engine SELECT domainmetadata.id AS domainmetadata_id, domainmetadata.domain_id AS domainmetadata_domain_id, domainmetadata.kind AS domainmetadata_kind, domainmetadata.content AS domainmetadata_content FROM domainmetadata WHERE domainmetadata.kind = %s AND domainmetadata.domain_id = %s 2014-03-05 12:12:36.712 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] SELECT domainmetadata.id AS domainmetadata_id, domainmetadata.domain_id AS domainmetadata_domain_id, domainmetadata.kind AS domainmetadata_kind, domainmetadata.content AS domainmetadata_content FROM domainmetadata WHERE domainmetadata.kind = %s AND domainmetadata.domain_id = %s 2014-03-05 12:12:36,712 INFO sqlalchemy.engine.base.Engine ('TSIG-ALLOW-AXFR', 6L) 2014-03-05 12:12:36.712 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] ('TSIG-ALLOW-AXFR', 6L) 2014-03-05 12:12:36,713 DEBUG sqlalchemy.engine.base.Engine Col ('domainmetadata_id', 'domainmetadata_domain_id', 'domainmetadata_kind', 'domainmetadata_content') 2014-03-05 12:12:36.713 12208 DEBUG sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] Col ('domainmetadata_id', 'domainmetadata_domain_id', 'domainmetadata_kind', 'domainmetadata_content') debug /root/designate/.venv/local/lib/python2.7/site-packages/sqlalchemy/log.py:106 2014-03-05 12:12:36,714 INFO sqlalchemy.engine.base.Engine SELECT domainmetadata.id AS domainmetadata_id, domainmetadata.domain_id AS domainmetadata_domain_id, domainmetadata.kind AS domainmetadata_kind, domainmetadata.content AS domainmetadata_content FROM domainmetadata WHERE domainmetadata.kind = %s AND domainmetadata.domain_id = %s 2014-03-05 12:12:36.714 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] SELECT domainmetadata.id AS domainmetadata_id, domainmetadata.domain_id AS domainmetadata_domain_id, domainmetadata.kind AS domainmetadata_kind, domainmetadata.content AS domainmetadata_content FROM domainmetadata WHERE domainmetadata.kind = %s AND domainmetadata.domain_id = %s 2014-03-05 12:12:36,714 INFO sqlalchemy.engine.base.Engine ('ALSO-NOTIFY', 6L) 2014-03-05 12:12:36.714 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] ('ALSO-NOTIFY', 6L) 2014-03-05 12:12:36,715 DEBUG sqlalchemy.engine.base.Engine Col ('domainmetadata_id', 'domainmetadata_domain_id', 'domainmetadata_kind', 'domainmetadata_content') 2014-03-05 12:12:36.715 12208 DEBUG sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] Col ('domainmetadata_id', 'domainmetadata_domain_id', 'domainmetadata_kind', 'domainmetadata_content') debug /root/designate/.venv/local/lib/python2.7/site-packages/sqlalchemy/log.py:106 2014-03-05 12:12:36,716 INFO sqlalchemy.engine.base.Engine BEGIN (implicit) 2014-03-05 12:12:36.716 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] BEGIN (implicit) 2014-03-05 12:12:36,716 INFO sqlalchemy.engine.base.Engine INSERT INTO records (designate_id, designate_recordset_id, domain_id, name, type, content, ttl, prio, change_date, ordername, auth, inherit_ttl) VALUES (%s, %s, %s, %s, %s, %s, %s, %s, %s, %s, %s, %s) 2014-03-05 12:12:36.716 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] INSERT INTO records (designate_id, designate_recordset_id, domain_id, name, type, content, ttl, prio, change_date, ordername, auth, inherit_ttl) VALUES (%s, %s, %s, %s, %s, %s, %s, %s, %s, %s, %s, %s) 2014-03-05 12:12:36,716 INFO sqlalchemy.engine.base.Engine ('530b471144df4b85b709a949b874c328', None, 6L, 'domain1.com', 'SOA', 'ns1.example.org. nsadmin.example.org. 1394017163 3600 600 86400 3600', None, None, None, None, 1, 1) 2014-03-05 12:12:36.716 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] ('530b471144df4b85b709a949b874c328', None, 6L, 'domain1.com', 'SOA', 'ns1.example.org. nsadmin.example.org. 1394017163 3600 600 86400 3600', None, None, None, None, 1, 1) 2014-03-05 12:12:36,717 INFO sqlalchemy.engine.base.Engine COMMIT 2014-03-05 12:12:36.717 12208 INFO sqlalchemy.engine.base.Engine [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] COMMIT 2014-03-05 12:12:36.751 12208 ERROR designate.openstack.common.rpc.amqp [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] Exception during message handling 2014-03-05 12:12:36.751 12208 TRACE designate.openstack.common.rpc.amqp Traceback (most recent call last): 2014-03-05 12:12:36.751 12208 TRACE designate.openstack.common.rpc.amqp File "/root/designate/designate/openstack/common/rpc/amqp.py", line 462, in _process_data 2014-03-05 12:12:36.751 12208 TRACE designate.openstack.common.rpc.amqp **args) 2014-03-05 12:12:36.751 12208 TRACE designate.openstack.common.rpc.amqp File "/root/designate/designate/openstack/common/rpc/dispatcher.py", line 172, in dispatch 2014-03-05 12:12:36.751 12208 TRACE designate.openstack.common.rpc.amqp result = getattr(proxyobj, method)(ctxt, **kwargs) 2014-03-05 12:12:36.751 12208 TRACE designate.openstack.common.rpc.amqp File "/root/designate/designate/central/service.py", line 987, in sync_domains 2014-03-05 12:12:36.751 12208 TRACE designate.openstack.common.rpc.amqp records) 2014-03-05 12:12:36.751 12208 TRACE designate.openstack.common.rpc.amqp File "/usr/lib/python2.7/contextlib.py", line 35, in __exit__ 2014-03-05 12:12:36.751 12208 TRACE designate.openstack.common.rpc.amqp self.gen.throw(type, value, traceback) 2014-03-05 12:12:36.751 12208 TRACE designate.openstack.common.rpc.amqp File "/root/designate/designate/central/service.py", line 44, in wrap_backend_call 2014-03-05 12:12:36.751 12208 TRACE designate.openstack.common.rpc.amqp raise exceptions.Backend('Unknown backend failure: %r' % exc) 2014-03-05 12:12:36.751 12208 TRACE designate.openstack.common.rpc.amqp Backend: Unknown backend failure: TypeError('create_record() takes exactly 5 arguments (4 given)',) 2014-03-05 12:12:36.751 12208 TRACE designate.openstack.common.rpc.amqp 2014-03-05 12:12:36.752 12208 ERROR designate.openstack.common.rpc.common [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] Returning exception Unknown backend failure: TypeError('create_record() takes exactly 5 arguments (4 given)',) to caller 2014-03-05 12:12:36.752 12208 ERROR designate.openstack.common.rpc.common [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] ['Traceback (most recent call last):\n', ' File "/root/designate/designate/openstack/common/rpc/amqp.py", line 462, in _process_data\n **args)\n', ' File "/root/designate/designate/openstack/common/rpc/dispatcher.py", line 172, in dispatch\n result = getattr(proxyobj, method)(ctxt, **kwargs)\n', ' File "/root/designate/designate/central/service.py", line 987, in sync_domains\n records)\n', ' File "/usr/lib/python2.7/contextlib.py", line 35, in __exit__\n self.gen.throw(type, value, traceback)\n', ' File "/root/designate/designate/central/service.py", line 44, in wrap_backend_call\n raise exceptions.Backend(\'Unknown backend failure: %r\' % exc)\n', "Backend: Unknown backend failure: TypeError('create_record() takes exactly 5 arguments (4 given)',)\n"] 2014-03-05 12:12:36.752 12208 DEBUG designate.openstack.common.rpc.amqp [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] UNIQUE_ID is cbcbaa6471a24ad794d40e105dbe2df1. _add_unique_id /root/designate/designate/openstack/common/rpc/amqp.py:342 /root/designate/.venv/local/lib/python2.7/site-packages/amqp/channel.py:616: VDeprecationWarning: The auto_delete flag for exchanges has been deprecated and will be removed from py-amqp v1.5.0.   warn(VDeprecationWarning(EXCHANGE_AUTODELETE_DEPRECATED)) 2014-03-05 12:12:36.754 12200 ERROR designate.api.middleware [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] Unknown backend failure: TypeError('create_record() takes exactly 5 arguments (4 given)',) Traceback (most recent call last):   File "/root/designate/designate/openstack/common/rpc/amqp.py", line 462, in _process_data     **args)   File "/root/designate/designate/openstack/common/rpc/dispatcher.py", line 172, in dispatch     result = getattr(proxyobj, method)(ctxt, **kwargs)   File "/root/designate/designate/central/service.py", line 987, in sync_domains     records)   File "/usr/lib/python2.7/contextlib.py", line 35, in __exit__     self.gen.throw(type, value, traceback)   File "/root/designate/designate/central/service.py", line 44, in wrap_backend_call     raise exceptions.Backend('Unknown backend failure: %r' % exc) Backend: Unknown backend failure: TypeError('create_record() takes exactly 5 arguments (4 given)',) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware Traceback (most recent call last): 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/designate/api/middleware.py", line 193, in __call__ 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware return request.get_response(self.application) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/.venv/local/lib/python2.7/site-packages/webob/request.py", line 1320, in send 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware application, catch_exc_info=False) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/.venv/local/lib/python2.7/site-packages/webob/request.py", line 1284, in call_application 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware app_iter = application(self.environ, start_response) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/.venv/local/lib/python2.7/site-packages/flask/app.py", line 1836, in __call__ 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware return self.wsgi_app(environ, start_response) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/.venv/local/lib/python2.7/site-packages/flask/app.py", line 1820, in wsgi_app 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware response = self.make_response(self.handle_exception(e)) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/.venv/local/lib/python2.7/site-packages/flask/app.py", line 1403, in handle_exception 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware reraise(exc_type, exc_value, tb) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/.venv/local/lib/python2.7/site-packages/flask/app.py", line 1817, in wsgi_app 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware response = self.full_dispatch_request() 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/.venv/local/lib/python2.7/site-packages/flask/app.py", line 1477, in full_dispatch_request 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware rv = self.handle_user_exception(e) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/.venv/local/lib/python2.7/site-packages/flask/app.py", line 1381, in handle_user_exception 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware reraise(exc_type, exc_value, tb) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/.venv/local/lib/python2.7/site-packages/flask/app.py", line 1475, in full_dispatch_request 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware rv = self.dispatch_request() 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/.venv/local/lib/python2.7/site-packages/flask/app.py", line 1461, in dispatch_request 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware return self.view_functions[rule.endpoint](**req.view_args) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/designate/api/v1/extensions/sync.py", line 29, in sync_domains 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware central_api.sync_domains(context) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/designate/central/rpcapi.py", line 387, in sync_domains 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware return self.call(context, msg) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/designate/openstack/common/rpc/proxy.py", line 125, in call 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware result = rpc.call(context, real_topic, msg, timeout) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/designate/openstack/common/rpc/__init__.py", line 112, in call 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware return _get_impl().call(CONF, context, topic, msg, timeout) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/designate/openstack/common/rpc/impl_kombu.py", line 815, in call 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware rpc_amqp.get_connection_pool(conf, Connection)) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/designate/openstack/common/rpc/amqp.py", line 575, in call 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware rv = list(rv) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/designate/openstack/common/rpc/amqp.py", line 540, in __iter__ 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware raise result 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware Backend_Remote: Unknown backend failure: TypeError('create_record() takes exactly 5 arguments (4 given)',) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware Traceback (most recent call last): 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/designate/openstack/common/rpc/amqp.py", line 462, in _process_data 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware **args) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/designate/openstack/common/rpc/dispatcher.py", line 172, in dispatch 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware result = getattr(proxyobj, method)(ctxt, **kwargs) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/designate/central/service.py", line 987, in sync_domains 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware records) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/usr/lib/python2.7/contextlib.py", line 35, in __exit__ 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware self.gen.throw(type, value, traceback) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware File "/root/designate/designate/central/service.py", line 44, in wrap_backend_call 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware raise exceptions.Backend('Unknown backend failure: %r' % exc) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware Backend: Unknown backend failure: TypeError('create_record() takes exactly 5 arguments (4 given)',) 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware 2014-03-05 12:12:36.754 12200 TRACE designate.api.middleware 2014-03-05 12:12:36.756 12200 INFO eventlet.wsgi [req-8b0f8364-64e6-4540-a50c-572049221953 noauth-user noauth-project - - -] 78.140.137.211 - - [05/Mar/2014 12:12:36] "POST /v1//domains/sync HTTP/1.1" 500 277 0.192235 ERROR: 'SyncAllCommand' object has no attribute 'formatter'
2014-03-05 11:47:06 Kiall Mac Innes nominated for series designate/icehouse
2014-03-05 11:47:06 Kiall Mac Innes bug task added designate/icehouse
2014-03-05 11:47:19 Kiall Mac Innes designate/icehouse: milestone icehouse-3
2014-03-12 17:18:35 Graham Hayes designate/icehouse: milestone icehouse-3
2014-03-20 11:09:05 Endre Karlson designate/icehouse: milestone icehouse-rc1
2014-03-20 11:09:08 Endre Karlson designate/icehouse: assignee Endre Karlson (endre-karlson)
2014-03-20 11:09:12 Endre Karlson designate/icehouse: status New Confirmed
2014-03-20 11:09:14 Endre Karlson designate/icehouse: importance Undecided Low
2014-03-20 11:29:34 OpenStack Infra designate: status Confirmed In Progress
2014-04-01 01:19:16 OpenStack Infra designate: status In Progress Fix Committed
2014-05-07 13:28:45 Graham Hayes designate: milestone icehouse-rc1 icehouse
2014-05-07 13:28:50 Graham Hayes designate/icehouse: milestone icehouse-rc1 icehouse
2014-08-14 10:37:53 Kiall Mac Innes designate: status Fix Committed Fix Released
2014-08-14 10:37:58 Kiall Mac Innes designate/icehouse: status Fix Committed Fix Released