[Blink] DNS lookup failure
Conrad Heiney
conrad at tierzero.com
Tue Dec 21 10:06:42 CET 2010
The notification and sip logs are attached.
The DNS servers do in fact return NX on the command line. However,
blink reports a timeout. As you'll see from the logs, though, the udp
record returns. I've attached the command line output.
On Tue, Dec 21, 2010 at 12:56 AM, Dan Pascu <dan at ag-projects.com> wrote:
>> Hi Dan:
>>
>> Did you see the part of the thread where I found the problem? I had to
>> uncheck in SIP preferences the TLS and TCP methods in order to get the
>> UDP method to work. Is that enough for you to investigate?
>
> No it's not. Please send the output of the NAPTR lookup and the
> notifications log. After you enable notifications logging, restart blink. I
> need to see notifications from when blink starts, until it tries to register
> and make a call.
>
> Also can you clarify why your nameservers timeout when asked about the SIP
> TCP/TLS SRV records instead of answering with NXDOMAIN if they do not have
> them?
--
Conrad Heiney, Senior System Administrator
Tierzero, Inc.
conrad at tierzero.com | 213 784 1375
-------------- next part --------------
2010-12-21 00:58:40.266949: Notification name=CFGSettingsObjectDidChange sender=<sipsimple.configuration.settings.SIPSimpleSettings object at 0x15fd4090> data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 0, 58, 40, 260734), modified={'logs.trace_notifications': ModifiedValue(old=False, new=True)})
2010-12-21 00:58:43.379841: Notification name=SIPApplicationWillEnd sender=<sipsimple.application.SIPApplication object at 0x15fbdfd0> data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 0, 58, 43, 379529))
2010-12-21 00:58:43.381886: Notification name=SIPAccountManagerWillEnd sender=<sipsimple.account.AccountManager object at 0x15fd4330> data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 0, 58, 43, 381548))
2010-12-21 00:58:43.383914: Notification name=SIPSessionManagerWillEnd sender=<sipsimple.session.SessionManager object at 0x15feb330> data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 0, 58, 43, 382724))
2010-12-21 00:58:43.384337: Notification name=SIPSessionManagerDidEnd sender=<sipsimple.session.SessionManager object at 0x15feb330> data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 0, 58, 43, 382991))
2010-12-21 00:58:43.384919: Notification name=SIPAccountWillDeactivate sender=Account('3107841375a at voip.tierzero.net') data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 0, 58, 43, 383384))
2010-12-21 00:58:43.385390: Notification name=SIPAccountWillDeactivate sender=BonjourAccount() data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 0, 58, 43, 383663))
2010-12-21 00:58:43.385952: Notification name=SIPAccountDidDeactivate sender=Account('3107841375a at voip.tierzero.net') data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 0, 58, 43, 385588))
2010-12-21 00:58:53.427177: Notification name=SIPEngineWillStart sender=<Engine(Thread-1, initial daemon)> data=NotificationData(timestamp=datetime.datetime(2010, 12, 21, 0, 58, 53, 426495))
2010-12-21 00:58:53.475161: Notification name=SIPEngineDidStart sender=<Engine(Thread-1, started daemon)> data=NotificationData(timestamp=datetime.datetime(2010, 12, 21, 0, 58, 53, 470997))
2010-12-21 00:58:55.881279: Notification name=SIPAccountManagerWillStart sender=<sipsimple.account.AccountManager object at 0x15fd2330> data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 0, 58, 55, 879955))
2010-12-21 00:58:55.889521: Notification name=SIPAccountWillActivate sender=Account('3107841375a at voip.tierzero.net') data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 0, 58, 55, 888815))
2010-12-21 00:58:55.890117: Notification name=SIPAccountDidActivate sender=Account('3107841375a at voip.tierzero.net') data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 0, 58, 55, 889680))
2010-12-21 00:58:55.894486: Notification name=SIPAccountWillActivate sender=BonjourAccount() data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 0, 58, 55, 893964))
2010-12-21 00:58:55.895251: Notification name=SIPAccountDidActivate sender=BonjourAccount() data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 0, 58, 55, 894960))
2010-12-21 00:58:55.898390: Notification name=SIPAccountManagerDidStart sender=<sipsimple.account.AccountManager object at 0x15fd2330> data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 0, 58, 55, 898078))
2010-12-21 00:58:55.899143: Notification name=SIPSessionManagerWillStart sender=<sipsimple.session.SessionManager object at 0x15fe9370> data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 0, 58, 55, 898815))
2010-12-21 00:58:55.899914: Notification name=SIPSessionManagerDidStart sender=<sipsimple.session.SessionManager object at 0x15fe9370> data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 0, 58, 55, 899261))
2010-12-21 00:58:55.900171: Notification name=SIPApplicationDidStart sender=<sipsimple.application.SIPApplication object at 0x15fbbfd0> data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 0, 58, 55, 899604))
2010-12-21 00:58:55.916811: Notification name=SIPAccountWillRegister sender=Account('3107841375a at voip.tierzero.net') data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 0, 58, 55, 916527))
2010-12-21 00:58:55.918597: Notification name=BonjourAccountWillRegister sender=BonjourAccount() data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 0, 58, 55, 918224), transport='udp')
2010-12-21 00:58:55.920833: Notification name=BonjourAccountWillRegister sender=BonjourAccount() data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 0, 58, 55, 919442), transport='tcp')
2010-12-21 00:58:55.928670: Notification name=BonjourAccountWillInitiateDiscovery sender=BonjourAccount() data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 0, 58, 55, 927795), transport='udp')
2010-12-21 00:58:55.931200: Notification name=BonjourAccountWillInitiateDiscovery sender=BonjourAccount() data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 0, 58, 55, 930854), transport='tcp')
2010-12-21 00:58:55.944526: Notification name=DNSLookupTrace sender=<sipsimple.lookup.DNSLookup object at 0x18bc1ad0> data=TimestampedNotificationData(nameservers=['10.0.100.1'], timestamp=datetime.datetime(2010, 12, 21, 0, 58, 55, 944124), error=NoAnswer(), uri=SIPURI('voip.tierzero.net', None, None, None, False, {}, {}), query_name='voip.tierzero.net', context='lookup_sip_proxy', query_type='NAPTR', answer=None)
2010-12-21 00:58:55.948194: Notification name=DNSLookupTrace sender=<sipsimple.lookup.DNSLookup object at 0x18bc19f0> data=TimestampedNotificationData(nameservers=['10.0.100.1'], timestamp=datetime.datetime(2010, 12, 21, 0, 58, 55, 947607), error=NoAnswer(), uri=SIPURI('voip.tierzero.net', None, None, None, False, {}, {}), query_name='voip.tierzero.net', context='lookup_sip_proxy', query_type='NAPTR', answer=None)
2010-12-21 00:58:55.952586: Notification name=BonjourAccountDidAddNeighbour sender=BonjourAccount() data=TimestampedNotificationData(neighbour=BonjourServiceDescription(u'sip:zdovfthx at 10.0.100.5:52742', u'_sipuri._udp.', u'ignatzmous.members.mac.com.'), timestamp=datetime.datetime(2010, 12, 21, 0, 58, 55, 952054), host=u'tertius.ignatzmous.members.mac.com', display_name=u'Conrad Heiney', uri=FrozenSIPURI('10.0.100.5', 'zdovfthx', None, 52742, 0, frozendict({}), frozendict({})))
2010-12-21 00:58:55.961275: Notification name=DNSLookupTrace sender=<sipsimple.lookup.DNSLookup object at 0x18bc19f0> data=TimestampedNotificationData(nameservers=['10.0.100.1'], timestamp=datetime.datetime(2010, 12, 21, 0, 58, 55, 960879), error=None, uri=SIPURI('voip.tierzero.net', None, None, None, False, {}, {}), query_name='_sip._udp.voip.tierzero.net', context='lookup_sip_proxy', query_type='SRV', answer=<dns.resolver.Answer object at 0x18bc1e30>)
2010-12-21 00:58:55.963998: Notification name=DNSLookupTrace sender=<sipsimple.lookup.DNSLookup object at 0x18bc1ad0> data=TimestampedNotificationData(nameservers=['10.0.100.1'], timestamp=datetime.datetime(2010, 12, 21, 0, 58, 55, 963542), error=None, uri=SIPURI('voip.tierzero.net', None, None, None, False, {}, {}), query_name='_sip._udp.voip.tierzero.net', context='lookup_sip_proxy', query_type='SRV', answer=<dns.resolver.Answer object at 0x18bc1bd0>)
2010-12-21 00:58:55.968848: Notification name=DNSLookupTrace sender=<sipsimple.lookup.DNSLookup object at 0x18bc19f0> data=TimestampedNotificationData(nameservers=['10.0.100.1'], timestamp=datetime.datetime(2010, 12, 21, 0, 58, 55, 968488), error=None, uri=SIPURI('voip.tierzero.net', None, None, None, False, {}, {}), query_name='proxy01.voip.tierzero.net.', context='lookup_sip_proxy', query_type='A', answer=<dns.resolver.Answer object at 0x18bc7f50>)
2010-12-21 00:58:55.971697: Notification name=DNSLookupTrace sender=<sipsimple.lookup.DNSLookup object at 0x18bc1ad0> data=TimestampedNotificationData(nameservers=['10.0.100.1'], timestamp=datetime.datetime(2010, 12, 21, 0, 58, 55, 971074), error=None, uri=SIPURI('voip.tierzero.net', None, None, None, False, {}, {}), query_name='proxy01.voip.tierzero.net.', context='lookup_sip_proxy', query_type='A', answer=<dns.resolver.Answer object at 0x18bcf6f0>)
2010-12-21 00:58:56.242303: Notification name=BonjourAccountRegistrationDidSucceed sender=BonjourAccount() data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 0, 58, 56, 241737), name=u'sip:qtpnxlwa at 10.0.100.5:53584', transport='udp')
2010-12-21 00:58:56.578328: Notification name=BonjourAccountRegistrationDidSucceed sender=BonjourAccount() data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 0, 58, 56, 577801), name=u'sip:qtpnxlwa at 10.0.100.5:52836;transport=tcp', transport='tcp')
2010-12-21 00:58:56.605060: Notification name=BonjourAccountDidRemoveNeighbour sender=BonjourAccount() data=TimestampedNotificationData(neighbour=BonjourServiceDescription(u'sip:zdovfthx at 10.0.100.5:52742', u'_sipuri._udp.', u'ignatzmous.members.mac.com.'), timestamp=datetime.datetime(2010, 12, 21, 0, 58, 56, 604665))
2010-12-21 00:58:56.633703: Notification name=BonjourAccountRegistrationDidSucceed sender=BonjourAccount() data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 0, 58, 56, 633386), name=u'sip:qtpnxlwa at 10.0.100.5:52836;transport=tcp', transport='tcp')
2010-12-21 00:58:56.635894: Notification name=BonjourAccountRegistrationDidSucceed sender=BonjourAccount() data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 0, 58, 56, 634751), name=u'sip:qtpnxlwa at 10.0.100.5:53584', transport='udp')
2010-12-21 00:59:10.922734: Notification name=DNSLookupTrace sender=<sipsimple.lookup.DNSLookup object at 0x15ff8c10> data=TimestampedNotificationData(service='stun', nameservers=['10.0.100.1'], timestamp=datetime.datetime(2010, 12, 21, 0, 59, 10, 922001), error=Timeout(), uri=SIPURI('voip.tierzero.net', None, None, None, False, {}, {}), query_name='_stun._udp.voip.tierzero.net', context='lookup_service', query_type='SRV', answer=None)
2010-12-21 00:59:10.923884: Notification name=DNSLookupDidFail sender=<sipsimple.lookup.DNSLookup object at 0x15ff8c10> data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 0, 59, 10, 923538), error='Timeout in lookup for stun servers for domain voip.tierzero.net')
2010-12-21 00:59:10.927669: Notification name=DNSLookupTrace sender=<sipsimple.lookup.DNSLookup object at 0x18bc7230> data=TimestampedNotificationData(service='stun', nameservers=['10.0.100.1'], timestamp=datetime.datetime(2010, 12, 21, 0, 59, 10, 926902), error=Timeout(), uri=SIPURI('voip.tierzero.net', None, None, None, False, {}, {}), query_name='_stun._udp.voip.tierzero.net', context='lookup_service', query_type='SRV', answer=None)
2010-12-21 00:59:10.928336: Notification name=DNSLookupDidFail sender=<sipsimple.lookup.DNSLookup object at 0x18bc7230> data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 0, 59, 10, 927920), error='Timeout in lookup for stun servers for domain voip.tierzero.net')
2010-12-21 00:59:10.929095: Notification name=DNSLookupTrace sender=<sipsimple.lookup.DNSLookup object at 0x18bc19f0> data=TimestampedNotificationData(nameservers=['10.0.100.1'], timestamp=datetime.datetime(2010, 12, 21, 0, 59, 10, 928749), error=Timeout(), uri=SIPURI('voip.tierzero.net', None, None, None, False, {}, {}), query_name='_sip._tcp.voip.tierzero.net', context='lookup_sip_proxy', query_type='SRV', answer=None)
2010-12-21 00:59:10.929927: Notification name=DNSLookupDidFail sender=<sipsimple.lookup.DNSLookup object at 0x18bc19f0> data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 0, 59, 10, 929604), error='Timeout in lookup for routes for SIP URI sip:voip.tierzero.net')
2010-12-21 00:59:10.931076: Notification name=DNSLookupTrace sender=<sipsimple.lookup.DNSLookup object at 0x18bc1ad0> data=TimestampedNotificationData(nameservers=['10.0.100.1'], timestamp=datetime.datetime(2010, 12, 21, 0, 59, 10, 930412), error=Timeout(), uri=SIPURI('voip.tierzero.net', None, None, None, False, {}, {}), query_name='_sip._tcp.voip.tierzero.net', context='lookup_sip_proxy', query_type='SRV', answer=None)
2010-12-21 00:59:10.931520: Notification name=DNSLookupDidFail sender=<sipsimple.lookup.DNSLookup object at 0x18bc1ad0> data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 0, 59, 10, 931247), error='Timeout in lookup for routes for SIP URI sip:voip.tierzero.net')
2010-12-21 00:59:10.932587: Notification name=SIPAccountRegistrationDidFail sender=Account('3107841375a at voip.tierzero.net') data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 0, 59, 10, 931867), timeout=1.8684220504732656, error='DNS lookup failed: Timeout in lookup for routes for SIP URI sip:voip.tierzero.net')
2010-12-21 00:59:11.060203: Notification name=BlinkStreamHandlerChangedState sender=<AudioController: 0x2d64b70> data={'detail': None, 'state': 'WAITING_DNS_LOOKUP'}
2010-12-21 00:59:11.063639: Notification name=BlinkSessionChangedState sender=<SessionController: 0x2e7cbc0> data={'reason': None, 'state': 'DNS_LOOKUP'}
2010-12-21 00:59:11.081269: Notification name=DNSLookupTrace sender=<sipsimple.lookup.DNSLookup object at 0x18bc15f0> data=TimestampedNotificationData(nameservers=['10.0.100.1'], timestamp=datetime.datetime(2010, 12, 21, 0, 59, 11, 78106), error=NoAnswer(), uri=SIPURI('voip.tierzero.net', None, None, None, False, {}, {}), query_name='voip.tierzero.net', context='lookup_sip_proxy', query_type='NAPTR', answer=None)
2010-12-21 00:59:11.081450: Notification name=DNSLookupTrace sender=<sipsimple.lookup.DNSLookup object at 0x18bc15f0> data=TimestampedNotificationData(nameservers=['10.0.100.1'], timestamp=datetime.datetime(2010, 12, 21, 0, 59, 11, 78857), error=None, uri=SIPURI('voip.tierzero.net', None, None, None, False, {}, {}), query_name='_sip._udp.voip.tierzero.net', context='lookup_sip_proxy', query_type='SRV', answer=<dns.resolver.Answer object at 0x18bc1bd0>)
2010-12-21 00:59:11.081601: Notification name=DNSLookupTrace sender=<sipsimple.lookup.DNSLookup object at 0x18bc15f0> data=TimestampedNotificationData(nameservers=['10.0.100.1'], timestamp=datetime.datetime(2010, 12, 21, 0, 59, 11, 79407), error=None, uri=SIPURI('voip.tierzero.net', None, None, None, False, {}, {}), query_name='proxy01.voip.tierzero.net.', context='lookup_sip_proxy', query_type='A', answer=<dns.resolver.Answer object at 0x18bcf6f0>)
2010-12-21 00:59:11.148339: Notification name=ITunesPauseDidExecute sender=<interfaces.itunes.ITunesInterface object at 0x18bdf570> data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 0, 59, 11, 147940))
2010-12-21 00:59:12.802972: Notification name=SIPAccountWillRegister sender=Account('3107841375a at voip.tierzero.net') data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 0, 59, 12, 802466))
2010-12-21 00:59:12.812545: Notification name=DNSLookupTrace sender=<sipsimple.lookup.DNSLookup object at 0x18bdfc90> data=TimestampedNotificationData(nameservers=['10.0.100.1'], timestamp=datetime.datetime(2010, 12, 21, 0, 59, 12, 808872), error=NoAnswer(), uri=SIPURI('voip.tierzero.net', None, None, None, False, {}, {}), query_name='voip.tierzero.net', context='lookup_sip_proxy', query_type='NAPTR', answer=None)
2010-12-21 00:59:12.812829: Notification name=DNSLookupTrace sender=<sipsimple.lookup.DNSLookup object at 0x18bdfc90> data=TimestampedNotificationData(nameservers=['10.0.100.1'], timestamp=datetime.datetime(2010, 12, 21, 0, 59, 12, 810885), error=None, uri=SIPURI('voip.tierzero.net', None, None, None, False, {}, {}), query_name='_sip._udp.voip.tierzero.net', context='lookup_sip_proxy', query_type='SRV', answer=<dns.resolver.Answer object at 0x18bc1bd0>)
2010-12-21 00:59:12.813045: Notification name=DNSLookupTrace sender=<sipsimple.lookup.DNSLookup object at 0x18bdfc90> data=TimestampedNotificationData(nameservers=['10.0.100.1'], timestamp=datetime.datetime(2010, 12, 21, 0, 59, 12, 811545), error=None, uri=SIPURI('voip.tierzero.net', None, None, None, False, {}, {}), query_name='proxy01.voip.tierzero.net.', context='lookup_sip_proxy', query_type='A', answer=<dns.resolver.Answer object at 0x18bcf6f0>)
2010-12-21 00:59:26.070575: Notification name=DNSLookupTrace sender=<sipsimple.lookup.DNSLookup object at 0x18bc15f0> data=TimestampedNotificationData(nameservers=['10.0.100.1'], timestamp=datetime.datetime(2010, 12, 21, 0, 59, 26, 67770), error=Timeout(), uri=SIPURI('voip.tierzero.net', None, None, None, False, {}, {}), query_name='_sip._tcp.voip.tierzero.net', context='lookup_sip_proxy', query_type='SRV', answer=None)
2010-12-21 00:59:26.071628: Notification name=DNSLookupDidFail sender=<sipsimple.lookup.DNSLookup object at 0x18bc15f0> data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 0, 59, 26, 69912), error='Timeout in lookup for routes for SIP URI sip:voip.tierzero.net')
2010-12-21 00:59:26.082694: Notification name=BlinkStreamHandlerChangedState sender=<AudioController: 0x2d64b70> data={'detail': 'DNS Lookup failure', 'state': 'FAILED'}
2010-12-21 00:59:26.083253: Notification name=BlinkSessionChangedState sender=<SessionController: 0x2e7cbc0> data={'reason': u'DNS Lookup for sip:9496422211 at voip.tierzero.net failed: Timeout in lookup for routes for SIP URI sip:voip.tierzero.net',
'state': 'DNS_FAILED'}
2010-12-21 00:59:27.810610: Notification name=DNSLookupTrace sender=<sipsimple.lookup.DNSLookup object at 0x18bdfc90> data=TimestampedNotificationData(nameservers=['10.0.100.1'], timestamp=datetime.datetime(2010, 12, 21, 0, 59, 27, 809451), error=Timeout(), uri=SIPURI('voip.tierzero.net', None, None, None, False, {}, {}), query_name='_sip._tcp.voip.tierzero.net', context='lookup_sip_proxy', query_type='SRV', answer=None)
2010-12-21 00:59:27.811533: Notification name=DNSLookupDidFail sender=<sipsimple.lookup.DNSLookup object at 0x18bdfc90> data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 0, 59, 27, 810881), error='Timeout in lookup for routes for SIP URI sip:voip.tierzero.net')
2010-12-21 00:59:27.812419: Notification name=SIPAccountRegistrationDidFail sender=Account('3107841375a at voip.tierzero.net') data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 0, 59, 27, 811935), timeout=3.8137084661453997, error='DNS lookup failed: Timeout in lookup for routes for SIP URI sip:voip.tierzero.net')
2010-12-21 00:59:31.629297: Notification name=SIPAccountWillRegister sender=Account('3107841375a at voip.tierzero.net') data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 0, 59, 31, 628904))
2010-12-21 00:59:31.634036: Notification name=DNSLookupTrace sender=<sipsimple.lookup.DNSLookup object at 0x18bcfd90> data=TimestampedNotificationData(nameservers=['10.0.100.1'], timestamp=datetime.datetime(2010, 12, 21, 0, 59, 31, 633582), error=NoAnswer(), uri=SIPURI('voip.tierzero.net', None, None, None, False, {}, {}), query_name='voip.tierzero.net', context='lookup_sip_proxy', query_type='NAPTR', answer=None)
2010-12-21 00:59:31.635243: Notification name=DNSLookupTrace sender=<sipsimple.lookup.DNSLookup object at 0x18bcfd90> data=TimestampedNotificationData(nameservers=['10.0.100.1'], timestamp=datetime.datetime(2010, 12, 21, 0, 59, 31, 634935), error=None, uri=SIPURI('voip.tierzero.net', None, None, None, False, {}, {}), query_name='_sip._udp.voip.tierzero.net', context='lookup_sip_proxy', query_type='SRV', answer=<dns.resolver.Answer object at 0x18bc1bd0>)
2010-12-21 00:59:31.636472: Notification name=DNSLookupTrace sender=<sipsimple.lookup.DNSLookup object at 0x18bcfd90> data=TimestampedNotificationData(nameservers=['10.0.100.1'], timestamp=datetime.datetime(2010, 12, 21, 0, 59, 31, 635787), error=None, uri=SIPURI('voip.tierzero.net', None, None, None, False, {}, {}), query_name='proxy01.voip.tierzero.net.', context='lookup_sip_proxy', query_type='A', answer=<dns.resolver.Answer object at 0x18bcf6f0>)
2010-12-21 00:59:39.739578: Notification name=DNSLookupTrace sender=<sipsimple.lookup.DNSLookup object at 0x15ff8eb0> data=TimestampedNotificationData(nameservers=['10.0.100.1'], timestamp=datetime.datetime(2010, 12, 21, 0, 59, 39, 739131), error=NoAnswer(), uri=SIPURI('voip.tierzero.net', None, None, None, False, {}, {}), query_name='voip.tierzero.net', context='lookup_sip_proxy', query_type='NAPTR', answer=None)
2010-12-21 00:59:39.741058: Notification name=DNSLookupTrace sender=<sipsimple.lookup.DNSLookup object at 0x15ff8eb0> data=TimestampedNotificationData(nameservers=['10.0.100.1'], timestamp=datetime.datetime(2010, 12, 21, 0, 59, 39, 740696), error=None, uri=SIPURI('voip.tierzero.net', None, None, None, False, {}, {}), query_name='_sip._udp.voip.tierzero.net', context='lookup_sip_proxy', query_type='SRV', answer=<dns.resolver.Answer object at 0x18bc1bd0>)
2010-12-21 00:59:39.742209: Notification name=DNSLookupTrace sender=<sipsimple.lookup.DNSLookup object at 0x15ff8eb0> data=TimestampedNotificationData(nameservers=['10.0.100.1'], timestamp=datetime.datetime(2010, 12, 21, 0, 59, 39, 741848), error=None, uri=SIPURI('voip.tierzero.net', None, None, None, False, {}, {}), query_name='proxy01.voip.tierzero.net.', context='lookup_sip_proxy', query_type='A', answer=<dns.resolver.Answer object at 0x18bcf6f0>)
2010-12-21 00:59:46.633886: Notification name=DNSLookupTrace sender=<sipsimple.lookup.DNSLookup object at 0x18bcfd90> data=TimestampedNotificationData(nameservers=['10.0.100.1'], timestamp=datetime.datetime(2010, 12, 21, 0, 59, 46, 633241), error=Timeout(), uri=SIPURI('voip.tierzero.net', None, None, None, False, {}, {}), query_name='_sip._tcp.voip.tierzero.net', context='lookup_sip_proxy', query_type='SRV', answer=None)
2010-12-21 00:59:46.635112: Notification name=DNSLookupDidFail sender=<sipsimple.lookup.DNSLookup object at 0x18bcfd90> data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 0, 59, 46, 634685), error='Timeout in lookup for routes for SIP URI sip:voip.tierzero.net')
2010-12-21 00:59:46.636477: Notification name=SIPAccountRegistrationDidFail sender=Account('3107841375a at voip.tierzero.net') data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 0, 59, 46, 635573), timeout=4.1134103045208112, error='DNS lookup failed: Timeout in lookup for routes for SIP URI sip:voip.tierzero.net')
2010-12-21 00:59:50.752519: Notification name=SIPAccountWillRegister sender=Account('3107841375a at voip.tierzero.net') data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 0, 59, 50, 752112))
2010-12-21 00:59:50.760634: Notification name=DNSLookupTrace sender=<sipsimple.lookup.DNSLookup object at 0x18bcf470> data=TimestampedNotificationData(nameservers=['10.0.100.1'], timestamp=datetime.datetime(2010, 12, 21, 0, 59, 50, 760232), error=NoAnswer(), uri=SIPURI('voip.tierzero.net', None, None, None, False, {}, {}), query_name='voip.tierzero.net', context='lookup_sip_proxy', query_type='NAPTR', answer=None)
2010-12-21 00:59:50.762095: Notification name=DNSLookupTrace sender=<sipsimple.lookup.DNSLookup object at 0x18bcf470> data=TimestampedNotificationData(nameservers=['10.0.100.1'], timestamp=datetime.datetime(2010, 12, 21, 0, 59, 50, 761645), error=None, uri=SIPURI('voip.tierzero.net', None, None, None, False, {}, {}), query_name='_sip._udp.voip.tierzero.net', context='lookup_sip_proxy', query_type='SRV', answer=<dns.resolver.Answer object at 0x18bc1bd0>)
2010-12-21 00:59:50.763002: Notification name=DNSLookupTrace sender=<sipsimple.lookup.DNSLookup object at 0x18bcf470> data=TimestampedNotificationData(nameservers=['10.0.100.1'], timestamp=datetime.datetime(2010, 12, 21, 0, 59, 50, 762666), error=None, uri=SIPURI('voip.tierzero.net', None, None, None, False, {}, {}), query_name='proxy01.voip.tierzero.net.', context='lookup_sip_proxy', query_type='A', answer=<dns.resolver.Answer object at 0x18bcf6f0>)
2010-12-21 00:59:54.734508: Notification name=DNSLookupTrace sender=<sipsimple.lookup.DNSLookup object at 0x15ff8eb0> data=TimestampedNotificationData(nameservers=['10.0.100.1'], timestamp=datetime.datetime(2010, 12, 21, 0, 59, 54, 733897), error=Timeout(), uri=SIPURI('voip.tierzero.net', None, None, None, False, {}, {}), query_name='_sip._tcp.voip.tierzero.net', context='lookup_sip_proxy', query_type='SRV', answer=None)
2010-12-21 00:59:54.735520: Notification name=DNSLookupDidFail sender=<sipsimple.lookup.DNSLookup object at 0x15ff8eb0> data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 0, 59, 54, 735165), error='Timeout in lookup for routes for SIP URI sip:voip.tierzero.net')
2010-12-21 01:00:05.757328: Notification name=DNSLookupTrace sender=<sipsimple.lookup.DNSLookup object at 0x18bcf470> data=TimestampedNotificationData(nameservers=['10.0.100.1'], timestamp=datetime.datetime(2010, 12, 21, 1, 0, 5, 756858), error=Timeout(), uri=SIPURI('voip.tierzero.net', None, None, None, False, {}, {}), query_name='_sip._tcp.voip.tierzero.net', context='lookup_sip_proxy', query_type='SRV', answer=None)
2010-12-21 01:00:05.758454: Notification name=DNSLookupDidFail sender=<sipsimple.lookup.DNSLookup object at 0x18bcf470> data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 1, 0, 5, 758103), error='Timeout in lookup for routes for SIP URI sip:voip.tierzero.net')
2010-12-21 01:00:05.759468: Notification name=SIPAccountRegistrationDidFail sender=Account('3107841375a at voip.tierzero.net') data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 1, 0, 5, 758968), timeout=10.597543551034594, error='DNS lookup failed: Timeout in lookup for routes for SIP URI sip:voip.tierzero.net')
2010-12-21 01:00:16.361432: Notification name=SIPAccountWillRegister sender=Account('3107841375a at voip.tierzero.net') data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 1, 0, 16, 359447))
2010-12-21 01:00:16.368209: Notification name=DNSLookupTrace sender=<sipsimple.lookup.DNSLookup object at 0x18beaa70> data=TimestampedNotificationData(nameservers=['10.0.100.1'], timestamp=datetime.datetime(2010, 12, 21, 1, 0, 16, 367772), error=NoAnswer(), uri=SIPURI('voip.tierzero.net', None, None, None, False, {}, {}), query_name='voip.tierzero.net', context='lookup_sip_proxy', query_type='NAPTR', answer=None)
2010-12-21 01:00:16.369729: Notification name=DNSLookupTrace sender=<sipsimple.lookup.DNSLookup object at 0x18beaa70> data=TimestampedNotificationData(nameservers=['10.0.100.1'], timestamp=datetime.datetime(2010, 12, 21, 1, 0, 16, 369362), error=None, uri=SIPURI('voip.tierzero.net', None, None, None, False, {}, {}), query_name='_sip._udp.voip.tierzero.net', context='lookup_sip_proxy', query_type='SRV', answer=<dns.resolver.Answer object at 0x18bc1bd0>)
2010-12-21 01:00:16.371313: Notification name=DNSLookupTrace sender=<sipsimple.lookup.DNSLookup object at 0x18beaa70> data=TimestampedNotificationData(nameservers=['10.0.100.1'], timestamp=datetime.datetime(2010, 12, 21, 1, 0, 16, 370630), error=None, uri=SIPURI('voip.tierzero.net', None, None, None, False, {}, {}), query_name='proxy01.voip.tierzero.net.', context='lookup_sip_proxy', query_type='A', answer=<dns.resolver.Answer object at 0x18bcf6f0>)
2010-12-21 01:00:18.775322: Notification name=DNSLookupTrace sender=<sipsimple.lookup.DNSLookup object at 0x18bc1910> data=TimestampedNotificationData(nameservers=['10.0.100.1'], timestamp=datetime.datetime(2010, 12, 21, 1, 0, 18, 774829), error=NoAnswer(), uri=SIPURI('voip.tierzero.net', None, None, None, False, {}, {}), query_name='voip.tierzero.net', context='lookup_sip_proxy', query_type='NAPTR', answer=None)
2010-12-21 01:00:18.777002: Notification name=DNSLookupTrace sender=<sipsimple.lookup.DNSLookup object at 0x18bc1910> data=TimestampedNotificationData(nameservers=['10.0.100.1'], timestamp=datetime.datetime(2010, 12, 21, 1, 0, 18, 776387), error=None, uri=SIPURI('voip.tierzero.net', None, None, None, False, {}, {}), query_name='_sip._udp.voip.tierzero.net', context='lookup_sip_proxy', query_type='SRV', answer=<dns.resolver.Answer object at 0x18bc1bd0>)
2010-12-21 01:00:18.777989: Notification name=DNSLookupTrace sender=<sipsimple.lookup.DNSLookup object at 0x18bc1910> data=TimestampedNotificationData(nameservers=['10.0.100.1'], timestamp=datetime.datetime(2010, 12, 21, 1, 0, 18, 777541), error=None, uri=SIPURI('voip.tierzero.net', None, None, None, False, {}, {}), query_name='proxy01.voip.tierzero.net.', context='lookup_sip_proxy', query_type='A', answer=<dns.resolver.Answer object at 0x18bcf6f0>)
2010-12-21 01:00:25.931998: Notification name=DNSLookupTrace sender=<sipsimple.lookup.DNSLookup object at 0x18bc7230> data=TimestampedNotificationData(service='stun', nameservers=['10.0.100.1'], timestamp=datetime.datetime(2010, 12, 21, 1, 0, 25, 931351), error=Timeout(), uri=SIPURI('voip.tierzero.net', None, None, None, False, {}, {}), query_name='_stun._udp.voip.tierzero.net', context='lookup_service', query_type='SRV', answer=None)
2010-12-21 01:00:25.933190: Notification name=DNSLookupDidFail sender=<sipsimple.lookup.DNSLookup object at 0x18bc7230> data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 1, 0, 25, 932708), error='Timeout in lookup for stun servers for domain voip.tierzero.net')
2010-12-21 01:00:31.768414: Notification name=DNSLookupTrace sender=<sipsimple.lookup.DNSLookup object at 0x18beaa70> data=TimestampedNotificationData(nameservers=['10.0.100.1'], timestamp=datetime.datetime(2010, 12, 21, 1, 0, 31, 767991), error=Timeout(), uri=SIPURI('voip.tierzero.net', None, None, None, False, {}, {}), query_name='_sip._tcp.voip.tierzero.net', context='lookup_sip_proxy', query_type='SRV', answer=None)
2010-12-21 01:00:31.769693: Notification name=DNSLookupDidFail sender=<sipsimple.lookup.DNSLookup object at 0x18beaa70> data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 1, 0, 31, 769230), error='Timeout in lookup for routes for SIP URI sip:voip.tierzero.net')
2010-12-21 01:00:31.771028: Notification name=SIPAccountRegistrationDidFail sender=Account('3107841375a at voip.tierzero.net') data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 1, 0, 31, 770488), timeout=24.499060579327541, error='DNS lookup failed: Timeout in lookup for routes for SIP URI sip:voip.tierzero.net')
2010-12-21 01:00:33.772926: Notification name=DNSLookupTrace sender=<sipsimple.lookup.DNSLookup object at 0x18bc1910> data=TimestampedNotificationData(nameservers=['10.0.100.1'], timestamp=datetime.datetime(2010, 12, 21, 1, 0, 33, 772411), error=Timeout(), uri=SIPURI('voip.tierzero.net', None, None, None, False, {}, {}), query_name='_sip._tcp.voip.tierzero.net', context='lookup_sip_proxy', query_type='SRV', answer=None)
2010-12-21 01:00:33.774617: Notification name=DNSLookupDidFail sender=<sipsimple.lookup.DNSLookup object at 0x18bc1910> data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 1, 0, 33, 773771), error='Timeout in lookup for routes for SIP URI sip:voip.tierzero.net')
2010-12-21 01:00:56.272966: Notification name=SIPAccountWillRegister sender=Account('3107841375a at voip.tierzero.net') data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 1, 0, 56, 272498))
2010-12-21 01:00:56.282149: Notification name=DNSLookupTrace sender=<sipsimple.lookup.DNSLookup object at 0x18bd8df0> data=TimestampedNotificationData(nameservers=['10.0.100.1'], timestamp=datetime.datetime(2010, 12, 21, 1, 0, 56, 281364), error=NoAnswer(), uri=SIPURI('voip.tierzero.net', None, None, None, False, {}, {}), query_name='voip.tierzero.net', context='lookup_sip_proxy', query_type='NAPTR', answer=None)
2010-12-21 01:00:56.284622: Notification name=DNSLookupTrace sender=<sipsimple.lookup.DNSLookup object at 0x18bd8df0> data=TimestampedNotificationData(nameservers=['10.0.100.1'], timestamp=datetime.datetime(2010, 12, 21, 1, 0, 56, 284033), error=None, uri=SIPURI('voip.tierzero.net', None, None, None, False, {}, {}), query_name='_sip._udp.voip.tierzero.net', context='lookup_sip_proxy', query_type='SRV', answer=<dns.resolver.Answer object at 0x18bc1bd0>)
2010-12-21 01:00:56.285925: Notification name=DNSLookupTrace sender=<sipsimple.lookup.DNSLookup object at 0x18bd8df0> data=TimestampedNotificationData(nameservers=['10.0.100.1'], timestamp=datetime.datetime(2010, 12, 21, 1, 0, 56, 285442), error=None, uri=SIPURI('voip.tierzero.net', None, None, None, False, {}, {}), query_name='proxy01.voip.tierzero.net.', context='lookup_sip_proxy', query_type='A', answer=<dns.resolver.Answer object at 0x18bcf6f0>)
2010-12-21 01:00:59.150795: Notification name=DNSLookupTrace sender=<sipsimple.lookup.DNSLookup object at 0x18bdfa90> data=TimestampedNotificationData(nameservers=['10.0.100.1'], timestamp=datetime.datetime(2010, 12, 21, 1, 0, 59, 150253), error=NoAnswer(), uri=SIPURI('voip.tierzero.net', None, None, None, False, {}, {}), query_name='voip.tierzero.net', context='lookup_sip_proxy', query_type='NAPTR', answer=None)
2010-12-21 01:00:59.152203: Notification name=DNSLookupTrace sender=<sipsimple.lookup.DNSLookup object at 0x18bdfa90> data=TimestampedNotificationData(nameservers=['10.0.100.1'], timestamp=datetime.datetime(2010, 12, 21, 1, 0, 59, 151845), error=None, uri=SIPURI('voip.tierzero.net', None, None, None, False, {}, {}), query_name='_sip._udp.voip.tierzero.net', context='lookup_sip_proxy', query_type='SRV', answer=<dns.resolver.Answer object at 0x18bc1bd0>)
2010-12-21 01:00:59.153223: Notification name=DNSLookupTrace sender=<sipsimple.lookup.DNSLookup object at 0x18bdfa90> data=TimestampedNotificationData(nameservers=['10.0.100.1'], timestamp=datetime.datetime(2010, 12, 21, 1, 0, 59, 152866), error=None, uri=SIPURI('voip.tierzero.net', None, None, None, False, {}, {}), query_name='proxy01.voip.tierzero.net.', context='lookup_sip_proxy', query_type='A', answer=<dns.resolver.Answer object at 0x18bcf6f0>)
2010-12-21 01:01:11.537576: Notification name=DNSLookupTrace sender=<sipsimple.lookup.DNSLookup object at 0x18bd8df0> data=TimestampedNotificationData(nameservers=['10.0.100.1'], timestamp=datetime.datetime(2010, 12, 21, 1, 1, 11, 537152), error=Timeout(), uri=SIPURI('voip.tierzero.net', None, None, None, False, {}, {}), query_name='_sip._tcp.voip.tierzero.net', context='lookup_sip_proxy', query_type='SRV', answer=None)
2010-12-21 01:01:11.538851: Notification name=DNSLookupDidFail sender=<sipsimple.lookup.DNSLookup object at 0x18bd8df0> data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 1, 1, 11, 538372), error='Timeout in lookup for routes for SIP URI sip:voip.tierzero.net')
2010-12-21 01:01:11.540841: Notification name=SIPAccountRegistrationDidFail sender=Account('3107841375a at voip.tierzero.net') data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 1, 1, 11, 540400), timeout=59.186273079510855, error='DNS lookup failed: Timeout in lookup for routes for SIP URI sip:voip.tierzero.net')
2010-12-21 01:01:14.148734: Notification name=DNSLookupTrace sender=<sipsimple.lookup.DNSLookup object at 0x18bdfa90> data=TimestampedNotificationData(nameservers=['10.0.100.1'], timestamp=datetime.datetime(2010, 12, 21, 1, 1, 14, 148119), error=Timeout(), uri=SIPURI('voip.tierzero.net', None, None, None, False, {}, {}), query_name='_sip._tcp.voip.tierzero.net', context='lookup_sip_proxy', query_type='SRV', answer=None)
2010-12-21 01:01:14.150211: Notification name=DNSLookupDidFail sender=<sipsimple.lookup.DNSLookup object at 0x18bdfa90> data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 1, 1, 14, 149587), error='Timeout in lookup for routes for SIP URI sip:voip.tierzero.net')
2010-12-21 01:01:21.246963: Notification name=BlinkStreamHandlerChangedState sender=<AudioController: 0x2d844e0> data={'detail': None, 'state': 'WAITING_DNS_LOOKUP'}
2010-12-21 01:01:21.250318: Notification name=BlinkSessionChangedState sender=<SessionController: 0x2ed8730> data={'reason': None, 'state': 'DNS_LOOKUP'}
2010-12-21 01:01:21.264244: Notification name=DNSLookupTrace sender=<sipsimple.lookup.DNSLookup object at 0x18d6f110> data=TimestampedNotificationData(nameservers=['10.0.100.1'], timestamp=datetime.datetime(2010, 12, 21, 1, 1, 21, 259990), error=NoAnswer(), uri=SIPURI('voip.tierzero.net', None, None, None, False, {}, {}), query_name='voip.tierzero.net', context='lookup_sip_proxy', query_type='NAPTR', answer=None)
2010-12-21 01:01:21.264630: Notification name=DNSLookupTrace sender=<sipsimple.lookup.DNSLookup object at 0x18d6f110> data=TimestampedNotificationData(nameservers=['10.0.100.1'], timestamp=datetime.datetime(2010, 12, 21, 1, 1, 21, 261695), error=None, uri=SIPURI('voip.tierzero.net', None, None, None, False, {}, {}), query_name='_sip._udp.voip.tierzero.net', context='lookup_sip_proxy', query_type='SRV', answer=<dns.resolver.Answer object at 0x18bc1bd0>)
2010-12-21 01:01:21.264929: Notification name=DNSLookupTrace sender=<sipsimple.lookup.DNSLookup object at 0x18d6f110> data=TimestampedNotificationData(nameservers=['10.0.100.1'], timestamp=datetime.datetime(2010, 12, 21, 1, 1, 21, 262250), error=None, uri=SIPURI('voip.tierzero.net', None, None, None, False, {}, {}), query_name='proxy01.voip.tierzero.net.', context='lookup_sip_proxy', query_type='A', answer=<dns.resolver.Answer object at 0x18bcf6f0>)
2010-12-21 01:01:21.268626: Notification name=ITunesPauseDidExecute sender=<interfaces.itunes.ITunesInterface object at 0x18bdf570> data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 1, 1, 21, 267995))
2010-12-21 01:01:29.301999: Notification name=DNSLookupTrace sender=<sipsimple.lookup.DNSLookup object at 0x18beaf10> data=TimestampedNotificationData(nameservers=['10.0.100.1'], timestamp=datetime.datetime(2010, 12, 21, 1, 1, 29, 300914), error=NoAnswer(), uri=SIPURI('voip.tierzero.net', None, None, None, False, {}, {}), query_name='voip.tierzero.net', context='lookup_sip_proxy', query_type='NAPTR', answer=None)
2010-12-21 01:01:29.303577: Notification name=DNSLookupTrace sender=<sipsimple.lookup.DNSLookup object at 0x18beaf10> data=TimestampedNotificationData(nameservers=['10.0.100.1'], timestamp=datetime.datetime(2010, 12, 21, 1, 1, 29, 302486), error=None, uri=SIPURI('voip.tierzero.net', None, None, None, False, {}, {}), query_name='_sip._udp.voip.tierzero.net', context='lookup_sip_proxy', query_type='SRV', answer=<dns.resolver.Answer object at 0x18bc1bd0>)
2010-12-21 01:01:29.304241: Notification name=DNSLookupTrace sender=<sipsimple.lookup.DNSLookup object at 0x18beaf10> data=TimestampedNotificationData(nameservers=['10.0.100.1'], timestamp=datetime.datetime(2010, 12, 21, 1, 1, 29, 303670), error=None, uri=SIPURI('voip.tierzero.net', None, None, None, False, {}, {}), query_name='proxy01.voip.tierzero.net.', context='lookup_sip_proxy', query_type='A', answer=<dns.resolver.Answer object at 0x18bcf6f0>)
2010-12-21 01:01:36.255832: Notification name=DNSLookupTrace sender=<sipsimple.lookup.DNSLookup object at 0x18d6f110> data=TimestampedNotificationData(nameservers=['10.0.100.1'], timestamp=datetime.datetime(2010, 12, 21, 1, 1, 36, 255091), error=Timeout(), uri=SIPURI('voip.tierzero.net', None, None, None, False, {}, {}), query_name='_sip._tcp.voip.tierzero.net', context='lookup_sip_proxy', query_type='SRV', answer=None)
2010-12-21 01:01:36.257822: Notification name=DNSLookupDidFail sender=<sipsimple.lookup.DNSLookup object at 0x18d6f110> data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 1, 1, 36, 256843), error='Timeout in lookup for routes for SIP URI sip:voip.tierzero.net')
2010-12-21 01:01:36.269400: Notification name=BlinkStreamHandlerChangedState sender=<AudioController: 0x2d844e0> data={'detail': 'DNS Lookup failure', 'state': 'FAILED'}
2010-12-21 01:01:36.269779: Notification name=BlinkSessionChangedState sender=<SessionController: 0x2ed8730> data={'reason': u'DNS Lookup for sip:9493945638 at voip.tierzero.net failed: Timeout in lookup for routes for SIP URI sip:voip.tierzero.net',
'state': 'DNS_FAILED'}
2010-12-21 01:01:40.935116: Notification name=DNSLookupTrace sender=<sipsimple.lookup.DNSLookup object at 0x18bc7230> data=TimestampedNotificationData(service='stun', nameservers=['10.0.100.1'], timestamp=datetime.datetime(2010, 12, 21, 1, 1, 40, 934441), error=Timeout(), uri=SIPURI('voip.tierzero.net', None, None, None, False, {}, {}), query_name='_stun._udp.voip.tierzero.net', context='lookup_service', query_type='SRV', answer=None)
2010-12-21 01:01:40.936804: Notification name=DNSLookupDidFail sender=<sipsimple.lookup.DNSLookup object at 0x18bc7230> data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 1, 1, 40, 936237), error='Timeout in lookup for stun servers for domain voip.tierzero.net')
2010-12-21 01:01:44.298252: Notification name=DNSLookupTrace sender=<sipsimple.lookup.DNSLookup object at 0x18beaf10> data=TimestampedNotificationData(nameservers=['10.0.100.1'], timestamp=datetime.datetime(2010, 12, 21, 1, 1, 44, 297591), error=Timeout(), uri=SIPURI('voip.tierzero.net', None, None, None, False, {}, {}), query_name='_sip._tcp.voip.tierzero.net', context='lookup_sip_proxy', query_type='SRV', answer=None)
2010-12-21 01:01:44.301098: Notification name=DNSLookupDidFail sender=<sipsimple.lookup.DNSLookup object at 0x18beaf10> data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 1, 1, 44, 300751), error='Timeout in lookup for routes for SIP URI sip:voip.tierzero.net')
2010-12-21 01:02:05.795858: Notification name=DNSLookupTrace sender=<sipsimple.lookup.DNSLookup object at 0x18bea190> data=TimestampedNotificationData(nameservers=['10.0.100.1'], timestamp=datetime.datetime(2010, 12, 21, 1, 2, 5, 795372), error=NoAnswer(), uri=SIPURI('voip.tierzero.net', None, None, None, False, {}, {}), query_name='voip.tierzero.net', context='lookup_sip_proxy', query_type='NAPTR', answer=None)
2010-12-21 01:02:05.799247: Notification name=DNSLookupTrace sender=<sipsimple.lookup.DNSLookup object at 0x18bea190> data=TimestampedNotificationData(nameservers=['10.0.100.1'], timestamp=datetime.datetime(2010, 12, 21, 1, 2, 5, 797002), error=None, uri=SIPURI('voip.tierzero.net', None, None, None, False, {}, {}), query_name='_sip._udp.voip.tierzero.net', context='lookup_sip_proxy', query_type='SRV', answer=<dns.resolver.Answer object at 0x18bc1bd0>)
2010-12-21 01:02:05.799967: Notification name=DNSLookupTrace sender=<sipsimple.lookup.DNSLookup object at 0x18bea190> data=TimestampedNotificationData(nameservers=['10.0.100.1'], timestamp=datetime.datetime(2010, 12, 21, 1, 2, 5, 798474), error=None, uri=SIPURI('voip.tierzero.net', None, None, None, False, {}, {}), query_name='proxy01.voip.tierzero.net.', context='lookup_sip_proxy', query_type='A', answer=<dns.resolver.Answer object at 0x18bcf6f0>)
2010-12-21 01:02:10.732328: Notification name=SIPAccountWillRegister sender=Account('3107841375a at voip.tierzero.net') data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 1, 2, 10, 731921))
2010-12-21 01:02:10.740443: Notification name=DNSLookupTrace sender=<sipsimple.lookup.DNSLookup object at 0x18d76710> data=TimestampedNotificationData(nameservers=['10.0.100.1'], timestamp=datetime.datetime(2010, 12, 21, 1, 2, 10, 740016), error=NoAnswer(), uri=SIPURI('voip.tierzero.net', None, None, None, False, {}, {}), query_name='voip.tierzero.net', context='lookup_sip_proxy', query_type='NAPTR', answer=None)
2010-12-21 01:02:10.742036: Notification name=DNSLookupTrace sender=<sipsimple.lookup.DNSLookup object at 0x18d76710> data=TimestampedNotificationData(nameservers=['10.0.100.1'], timestamp=datetime.datetime(2010, 12, 21, 1, 2, 10, 741660), error=None, uri=SIPURI('voip.tierzero.net', None, None, None, False, {}, {}), query_name='_sip._udp.voip.tierzero.net', context='lookup_sip_proxy', query_type='SRV', answer=<dns.resolver.Answer object at 0x18bc1bd0>)
2010-12-21 01:02:10.743290: Notification name=DNSLookupTrace sender=<sipsimple.lookup.DNSLookup object at 0x18d76710> data=TimestampedNotificationData(nameservers=['10.0.100.1'], timestamp=datetime.datetime(2010, 12, 21, 1, 2, 10, 742686), error=None, uri=SIPURI('voip.tierzero.net', None, None, None, False, {}, {}), query_name='proxy01.voip.tierzero.net.', context='lookup_sip_proxy', query_type='A', answer=<dns.resolver.Answer object at 0x18bcf6f0>)
2010-12-21 01:02:20.794921: Notification name=DNSLookupTrace sender=<sipsimple.lookup.DNSLookup object at 0x18bea190> data=TimestampedNotificationData(nameservers=['10.0.100.1'], timestamp=datetime.datetime(2010, 12, 21, 1, 2, 20, 794425), error=Timeout(), uri=SIPURI('voip.tierzero.net', None, None, None, False, {}, {}), query_name='_sip._tcp.voip.tierzero.net', context='lookup_sip_proxy', query_type='SRV', answer=None)
2010-12-21 01:02:20.797763: Notification name=DNSLookupDidFail sender=<sipsimple.lookup.DNSLookup object at 0x18bea190> data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 1, 2, 20, 795745), error='Timeout in lookup for routes for SIP URI sip:voip.tierzero.net')
2010-12-21 01:02:25.738666: Notification name=DNSLookupTrace sender=<sipsimple.lookup.DNSLookup object at 0x18d76710> data=TimestampedNotificationData(nameservers=['10.0.100.1'], timestamp=datetime.datetime(2010, 12, 21, 1, 2, 25, 738164), error=Timeout(), uri=SIPURI('voip.tierzero.net', None, None, None, False, {}, {}), query_name='_sip._tcp.voip.tierzero.net', context='lookup_sip_proxy', query_type='SRV', answer=None)
2010-12-21 01:02:25.739838: Notification name=DNSLookupDidFail sender=<sipsimple.lookup.DNSLookup object at 0x18d76710> data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 1, 2, 25, 739509), error='Timeout in lookup for routes for SIP URI sip:voip.tierzero.net')
2010-12-21 01:02:25.741236: Notification name=SIPAccountRegistrationDidFail sender=Account('3107841375a at voip.tierzero.net') data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 1, 2, 25, 740296), timeout=52.504288021501303, error='DNS lookup failed: Timeout in lookup for routes for SIP URI sip:voip.tierzero.net')
2010-12-21 01:02:30.333290: Notification name=SIPApplicationWillEnd sender=<sipsimple.application.SIPApplication object at 0x15fbbfd0> data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 1, 2, 30, 332353))
2010-12-21 01:02:30.347353: Notification name=SIPAccountManagerWillEnd sender=<sipsimple.account.AccountManager object at 0x15fd2330> data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 1, 2, 30, 346965))
2010-12-21 01:02:30.350388: Notification name=SIPSessionManagerWillEnd sender=<sipsimple.session.SessionManager object at 0x15fe9370> data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 1, 2, 30, 350049))
2010-12-21 01:02:30.351137: Notification name=SIPSessionManagerDidEnd sender=<sipsimple.session.SessionManager object at 0x15fe9370> data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 1, 2, 30, 350616))
2010-12-21 01:02:30.351785: Notification name=SIPAccountWillDeactivate sender=Account('3107841375a at voip.tierzero.net') data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 1, 2, 30, 351423))
2010-12-21 01:02:30.352375: Notification name=SIPAccountWillDeactivate sender=BonjourAccount() data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 1, 2, 30, 352142))
2010-12-21 01:02:30.355127: Notification name=SIPAccountDidDeactivate sender=BonjourAccount() data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 1, 2, 30, 354804))
2010-12-21 01:02:30.358856: Notification name=SIPAccountDidDeactivate sender=Account('3107841375a at voip.tierzero.net') data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 1, 2, 30, 358497))
2010-12-21 01:02:30.361527: Notification name=SIPAccountManagerDidEnd sender=<sipsimple.account.AccountManager object at 0x15fd2330> data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 1, 2, 30, 361118))
2010-12-21 01:02:30.393648: Notification name=SIPEngineWillEnd sender=<Engine(Thread-1, started daemon)> data=NotificationData(timestamp=datetime.datetime(2010, 12, 21, 1, 2, 30, 393237))
2010-12-21 01:02:31.005243: Notification name=SIPEngineDidEnd sender=<Engine(Thread-1, started daemon)> data=NotificationData(timestamp=datetime.datetime(2010, 12, 21, 1, 2, 31, 4353))
2010-12-21 01:02:31.008331: Notification name=SIPApplicationDidEnd sender=<sipsimple.application.SIPApplication object at 0x15fbbfd0> data=TimestampedNotificationData(timestamp=datetime.datetime(2010, 12, 21, 1, 2, 31, 7865), end_reason='application request')
-------------- next part --------------
Last login: Tue Dec 21 00:59:30 on ttys001
tertius:~ conradh$ host -t SRV _sip._tcp.voip.tierzero.net
Host _sip._tcp.voip.tierzero.net not found: 3(NXDOMAIN)
tertius:~ conradh$ host -t SRV _sips._tcp.voip.tierzero.net
Host _sips._tcp.voip.tierzero.net not found: 3(NXDOMAIN)
tertius:~ conradh$ host -t SRV _sip._udp.voip.tierzero.net
_sip._udp.voip.tierzero.net has SRV record 0 0 5060 proxy01.voip.tierzero.net.
tertius:~ conradh$
-------------- next part --------------
2010-12-21 00:58:53 Starting VNC server at port 5957...
2010-12-21 00:58:55 Account('3107841375a at voip.tierzero.net') activated
2010-12-21 00:58:55 BonjourAccount() activated
2010-12-21 00:58:55 Bonjour Account listens on sip:qtpnxlwa at 10.0.100.5:53584;transport=udp
2010-12-21 00:58:55 Bonjour Account listens on sip:qtpnxlwa at 10.0.100.5:52836;transport=tcp
2010-12-21 00:58:55 Bonjour Account listens on sip:qtpnxlwa at 10.0.100.5:52837;transport=tls
2010-12-21 00:58:55 Initiating DNS Lookup for STUN servers of domain voip.tierzero.net
2010-12-21 00:58:55 Discovered new Bonjour neighbour: Conrad Heiney sip:zdovfthx at 10.0.100.5:52742
2010-12-21 00:58:56 Bonjour neighbour removed: sip:zdovfthx at 10.0.100.5:52742
2010-12-21 00:59:10 Error: DNS Lookup for voip.tierzero.net failed: Timeout in lookup for stun servers for domain voip.tierzero.net
2010-12-21 00:59:11 Account('3107841375a at voip.tierzero.net') failed to register: DNS lookup failed: Timeout in lookup for routes for SIP URI sip:voip.tierzero.net (retrying in 1.87 seconds)
2010-12-21 00:59:11 Error: The account 3107841375a at voip.tierzero.net failed to register(DNS lookup failed: Timeout in lookup for routes for SIP URI sip:voip.tierzero.net)
2010-12-21 00:59:11 [session to 9496422211 at voip.tierzero.net] Changing audio state to WAITING_DNS_LOOKUP
2010-12-21 00:59:11 [session to 9496422211 at voip.tierzero.net] Initiating DNS Lookup of Account('3107841375a at voip.tierzero.net') to sip:9496422211 at voip.tierzero.net
2010-12-21 00:59:11 [session to 9496422211 at voip.tierzero.net] Changing Session state to DNS_LOOKUP
2010-12-21 00:59:11 Initiating DNS Lookup for SIP routes of sip:9496422211 at voip.tierzero.net (through account 3107841375a at voip.tierzero.net proxy)
2010-12-21 00:59:26 Error: [session to 9496422211 at voip.tierzero.net] DNS Lookup for SIP routes failed: 'DNS Lookup for sip:9496422211 at voip.tierzero.net failed: Timeout in lookup for routes for SIP URI sip:voip.tierzero.net'
2010-12-21 00:59:26 [session to 9496422211 at voip.tierzero.net] Changing Session state to DNS_FAILED
2010-12-21 00:59:26 [session to 9496422211 at voip.tierzero.net] Changing audio state to FAILED
2010-12-21 00:59:26 Session <sipsimple.session.Session object at 0x18bd8070> ended, disposing...
2010-12-21 00:59:26 Error: DNS Lookup for sip:9496422211 at voip.tierzero.net failed: Timeout in lookup for routes for SIP URI sip:voip.tierzero.net
2010-12-21 00:59:27 Account('3107841375a at voip.tierzero.net') failed to register: DNS lookup failed: Timeout in lookup for routes for SIP URI sip:voip.tierzero.net (retrying in 3.81 seconds)
2010-12-21 00:59:27 Error: The account 3107841375a at voip.tierzero.net failed to register(DNS lookup failed: Timeout in lookup for routes for SIP URI sip:voip.tierzero.net)
2010-12-21 00:59:46 Account('3107841375a at voip.tierzero.net') failed to register: DNS lookup failed: Timeout in lookup for routes for SIP URI sip:voip.tierzero.net (retrying in 4.11 seconds)
2010-12-21 00:59:46 Error: The account 3107841375a at voip.tierzero.net failed to register(DNS lookup failed: Timeout in lookup for routes for SIP URI sip:voip.tierzero.net)
2010-12-21 01:00:05 Account('3107841375a at voip.tierzero.net') failed to register: DNS lookup failed: Timeout in lookup for routes for SIP URI sip:voip.tierzero.net (retrying in 10.60 seconds)
2010-12-21 01:00:05 Error: The account 3107841375a at voip.tierzero.net failed to register(DNS lookup failed: Timeout in lookup for routes for SIP URI sip:voip.tierzero.net)
2010-12-21 01:00:31 Account('3107841375a at voip.tierzero.net') failed to register: DNS lookup failed: Timeout in lookup for routes for SIP URI sip:voip.tierzero.net (retrying in 24.50 seconds)
2010-12-21 01:00:31 Error: The account 3107841375a at voip.tierzero.net failed to register(DNS lookup failed: Timeout in lookup for routes for SIP URI sip:voip.tierzero.net)
2010-12-21 01:01:11 Account('3107841375a at voip.tierzero.net') failed to register: DNS lookup failed: Timeout in lookup for routes for SIP URI sip:voip.tierzero.net (retrying in 59.19 seconds)
2010-12-21 01:01:11 Error: The account 3107841375a at voip.tierzero.net failed to register(DNS lookup failed: Timeout in lookup for routes for SIP URI sip:voip.tierzero.net)
2010-12-21 01:01:21 [session to 9493945638 at voip.tierzero.net] Changing audio state to WAITING_DNS_LOOKUP
2010-12-21 01:01:21 [session to 9493945638 at voip.tierzero.net] Initiating DNS Lookup of Account('3107841375a at voip.tierzero.net') to sip:9493945638 at voip.tierzero.net
2010-12-21 01:01:21 [session to 9493945638 at voip.tierzero.net] Changing Session state to DNS_LOOKUP
2010-12-21 01:01:21 Initiating DNS Lookup for SIP routes of sip:9493945638 at voip.tierzero.net (through account 3107841375a at voip.tierzero.net proxy)
2010-12-21 01:01:36 Error: [session to 9493945638 at voip.tierzero.net] DNS Lookup for SIP routes failed: 'DNS Lookup for sip:9493945638 at voip.tierzero.net failed: Timeout in lookup for routes for SIP URI sip:voip.tierzero.net'
2010-12-21 01:01:36 [session to 9493945638 at voip.tierzero.net] Changing Session state to DNS_FAILED
2010-12-21 01:01:36 [session to 9493945638 at voip.tierzero.net] Changing audio state to FAILED
2010-12-21 01:01:36 Session <sipsimple.session.Session object at 0x18d6f7f0> ended, disposing...
2010-12-21 01:01:36 Error: DNS Lookup for sip:9493945638 at voip.tierzero.net failed: Timeout in lookup for routes for SIP URI sip:voip.tierzero.net
More information about the Blink
mailing list