DNS error could leave SD stuck in STANDOFF

[Facundo Batista]

Extract of a log:

2010-05-10 21:37:22,347 - ubuntuone.SyncDaemon.Main - NOTE - ---- MARK (state: <State: 'INIT' (queues IDLE connection 'Not User Not Network')>; queues: metadata: 0; content: 0; hash: 0, fsm-cache: hit=1 miss=29) ----
2010-05-10 21:37:22,348 - ubuntuone.SyncDaemon.Main - NOTE - Local rescan starting...
2010-05-10 21:37:22,348 - ubuntuone.SyncDaemon.local_rescan - INFO - start scan all volumes
2010-05-10 21:37:22,453 - ubuntuone.SyncDaemon.local_rescan - INFO - processing trash
2010-05-10 21:37:22,697 - ubuntuone.SyncDaemon.Main - NOTE - Local rescan finished!
2010-05-10 21:37:22,698 - ubuntuone.SyncDaemon.Main - INFO - hash queue empty. We are ready!
2010-05-10 21:39:12,210 - ubuntuone.SyncDaemon.ActionQueue - INFO - SRV lookup error, fallback to 'fs-1.one.ubuntu.com':443
Traceback (most recent call last):
Failure: twisted.internet.defer.TimeoutError: [Query('_https._tcp.fs.ubuntuone.com', 33, 1)]

2010-05-10 21:39:12,282 - ubuntuone.SyncDaemon.ActionQueue - INFO - Connection started to host fs-1.one.ubuntu.com, port 443.
2010-05-10 21:39:12,312 - ubuntuone.SyncDaemon.ActionQueue - INFO - Connection failed: DNS lookup failed: address 'fs-1.one.ubuntu.com' not found: [Errno -5] No address associated with hostname.
2010-05-10 21:39:22,348 - ubuntuone.SyncDaemon.Main - NOTE - ---- MARK (state: <State: 'READY' (queues IDLE connection 'With User Not Network')>; queues: metadata: 0; content: 0; hash: 0, fsm-cache: hit=59 miss=29) ----
2010-05-10 21:39:26,040 - twisted - ERROR - Unhandled error in Deferred:
2010-05-10 21:39:26,041 - twisted - ERROR - Unhandled Error
Traceback (most recent call last):
Failure: twisted.internet.error.DNSLookupError: DNS lookup failed: address 'fs-1.one.ubuntu.com' not found: [Errno -5] No address associated with hostname.

2010-05-10 21:39:31,047 - ubuntuone.SyncDaemon.ActionQueue - INFO - SRV lookup error, fallback to 'fs-1.one.ubuntu.com':443
Traceback (most recent call last):
Failure: twisted.internet.defer.TimeoutError: [Query('_https._tcp.fs.ubuntuone.com', 33, 1)]

2010-05-10 21:39:31,049 - ubuntuone.SyncDaemon.ActionQueue - INFO - Connection started to host fs-1.one.ubuntu.com, port 443.
2010-05-10 21:39:31,146 - ubuntuone.SyncDaemon.ActionQueue - INFO - Connection made.
2010-05-10 21:39:31,147 - ubuntuone.SyncDaemon.StorageClient - INFO - Connection made.
2010-05-10 21:42:36,511 - ubuntuone.SyncDaemon.Main - NOTE - ---- MARK (state: <State: 'STANDOFF' (queues IDLE connection 'With User With Network')>; queues: metadata: 0; content: 0; hash: 0, fsm-cache: hit=59 miss=29) ----

And this is left in STANDOFF for ever from here on.

[Facundo Batista (facundo)]

This is already fixed, as the DNS lookup error is now handled.

Tried it IRL, starting the Ubuntu One client like:

  ubuntuone-syncdaemon --dns_srv=nosrv.com.ar.no --host=fs1.oneubu.com

The relevant part of the log, where we can see that it is working ok, is:

2010-09-02 10:18:48,330 - ubuntuone.SyncDaemon.StateManager - DEBUG - Transition WAITING --[SYS_CONNECTION_RETRY]--> READY (queues: WORKING_ON_BOTH; connection: With User With Network)
2010-09-02 10:18:48,330 - twisted - ERROR - Unhandled error in Deferred:
2010-09-02 10:18:48,331 - twisted - ERROR - Unhandled Error
Traceback (most recent call last):
Failure: twisted.internet.error.DNSLookupError: DNS lookup failed: address 'fs1.oneubu.com' not found: [Errno -5] No address associated with hostname.

2010-09-02 10:18:48,332 - ubuntuone.SyncDaemon.EQ - DEBUG - push_event: SYS_STATE_CHANGED, args:(), kw:{'state': READY (error=False connected=False online=False) Queue: WORKING_ON_BOTH Connection: With User With Network}
2010-09-02 10:18:48,402 - ubuntuone.SyncDaemon.ActionQueue - INFO - SRV lookup error, fallback to 'fs1.oneubu.com':443
Traceback (most recent call last):
Failure: twisted.names.error.DNSNameError: <twisted.names.dns.Message instance at 0x935006c>

2010-09-02 10:18:48,403 - ubuntuone.SyncDaemon.ActionQueue - INFO - Connection started to host fs1.oneubu.com, port 443.
2010-09-02 10:18:48,523 - ubuntuone.SyncDaemon.EQ - DEBUG - push_event: SYS_CONNECTION_FAILED, args:(), kw:{}
2010-09-02 10:18:48,523 - ubuntuone.SyncDaemon.StateManager - DEBUG - received event 'SYS_CONNECTION_FAILED'
2010-09-02 10:18:48,523 - ubuntuone.SyncDaemon.StateManager - DEBUG - Transition READY --[SYS_CONNECTION_FAILED]--> WAITING (queues: WORKING_ON_BOTH; connection: With User With Network)