search

idpaterson / alfred-wunderlist-workflow

Unbelievably fast task entry in Wunderlist with due dates, reminders, and recurrence
297 stars 8 forks source link

"---------" failure notification after login attempt; firewall denied connection to Wunderlist #128

Closed davecahill closed 8 years ago

davecahill commented 8 years ago

Steps:

Obtained by clicking bug icon in Alfred and logging all information. Username replaced with "***".

Python version checked on command line:

% python --version
Python 2.7.10

OSX version: El Capitan, 10.11.5

Debug output copied from Alfred preferences:

[STDERR: alfred.workflow.input.scriptfilter] 12:59:02 background.py:188 DEBUG    Command arguments cached to `/Users/***/Library/Caches/com.runningwithcrayons.Alfred-2/Workflow Data/com.ipaterson.alfred.wunderlist/__workflow_update_check.argcache`
2016-08-21 12:59:02,014 workflow     DEBUG    Command arguments cached to `/Users/***/Library/Caches/com.runningwithcrayons.Alfred-2/Workflow Data/com.ipaterson.alfred.wunderlist/__workflow_update_check.argcache`
12:59:02 background.py:192 DEBUG    Calling [u'/usr/bin/python', '/Users/***/Library/Application Support/Alfred 2/Alfred.alfredpreferences/workflows/user.workflow.2F3A2FEB-EFB6-4B8E-9D0F-516184A0D2C5/workflow/background.pyo', u'__workflow_update_check'] ...
2016-08-21 12:59:02,014 workflow     DEBUG    Calling [u'/usr/bin/python', '/Users/***/Library/Application Support/Alfred 2/Alfred.alfredpreferences/workflows/user.workflow.2F3A2FEB-EFB6-4B8E-9D0F-516184A0D2C5/workflow/background.pyo', u'__workflow_update_check'] ...
12:59:02 workflow.py:2205 DEBUG    Workflow finished in 0.003 seconds.
12:59:02 workflow.py:2205 DEBUG    Workflow finished in 0.004 seconds.
12:59:02 background.py:197 DEBUG    Executing task `__workflow_update_check` in background...
2016-08-21 12:59:02,094 workflow     DEBUG    Executing task `__workflow_update_check` in background...
12:59:02 workflow.py:2379 DEBUG    update_data : None
2016-08-21 12:59:02,125 workflow     DEBUG    update_data : None
12:59:02 background.py:188 DEBUG    Command arguments cached to `/Users/***/Library/Caches/com.runningwithcrayons.Alfred-2/Workflow Data/com.ipaterson.alfred.wunderlist/sync.argcache`
2016-08-21 12:59:02,127 workflow     DEBUG    Command arguments cached to `/Users/***/Library/Caches/com.runningwithcrayons.Alfred-2/Workflow Data/com.ipaterson.alfred.wunderlist/sync.argcache`
12:59:02 background.py:192 DEBUG    Calling [u'/usr/bin/python', '/Users/***/Library/Application Support/Alfred 2/Alfred.alfredpreferences/workflows/user.workflow.2F3A2FEB-EFB6-4B8E-9D0F-516184A0D2C5/workflow/background.pyo', 'sync'] ...
2016-08-21 12:59:02,127 workflow     DEBUG    Calling [u'/usr/bin/python', '/Users/***/Library/Application Support/Alfred 2/Alfred.alfredpreferences/workflows/user.workflow.2F3A2FEB-EFB6-4B8E-9D0F-516184A0D2C5/workflow/background.pyo', 'sync'] ...
12:59:02 workflow.py:2205 DEBUG    Workflow finished in 0.003 seconds.
12:59:02 workflow.py:2205 DEBUG    Workflow finished in 0.004 seconds.
12:59:02 background.py:197 DEBUG    Executing task `sync` in background...
2016-08-21 12:59:02,207 workflow     DEBUG    Executing task `sync` in background...
2016-08-21 12:59:02,207 wunderlist   INFO     Workflow response complete
12:59:02 workflow.py:2361 DEBUG    Set last run version : 0.6.0-beta.5
2016-08-21 12:59:02,208 workflow     DEBUG    Set last run version : 0.6.0-beta.5
12:59:02 workflow.py:2205 DEBUG    Workflow finished in 0.211 seconds.
2016-08-21 12:59:02,208 workflow     DEBUG    Workflow finished in 0.211 seconds.
[INFO: alfred.workflow.input.scriptfilter] <?xml version="1.0" encoding="utf-8"?>
<items><item valid="yes"><title>Please log in</title><subtitle>Authorize Alfred Wunderlist Workflow to use your Wunderlist account</subtitle><icon>icons/dark/account.png</icon></item><item autocomplete="-help " valid="no"><title>Having trouble?</title><subtitle /><icon>icons/dark/help.png</icon></item><item autocomplete="-about " valid="no"><title>About</title><subtitle>Learn about the workflow and get support</subtitle><icon>icons/dark/info.png</icon></item></items>
[INFO: alfred.workflow.input.scriptfilter] Processing output 'alfred.workflow.action.script' with arg ''
[ERROR: alfred.workflow.action.script] 12:59:04 background.py:188 DEBUG    Command arguments cached to `/Users/***/Library/Caches/com.runningwithcrayons.Alfred-2/Workflow Data/com.ipaterson.alfred.wunderlist/__workflow_update_check.argcache`
2016-08-21 12:59:04,050 workflow     DEBUG    Command arguments cached to `/Users/***/Library/Caches/com.runningwithcrayons.Alfred-2/Workflow Data/com.ipaterson.alfred.wunderlist/__workflow_update_check.argcache`
12:59:04 background.py:192 DEBUG    Calling [u'/usr/bin/python', '/Users/***/Library/Application Support/Alfred 2/Alfred.alfredpreferences/workflows/user.workflow.2F3A2FEB-EFB6-4B8E-9D0F-516184A0D2C5/workflow/background.pyo', u'__workflow_update_check'] ...
2016-08-21 12:59:04,050 workflow     DEBUG    Calling [u'/usr/bin/python', '/Users/***/Library/Application Support/Alfred 2/Alfred.alfredpreferences/workflows/user.workflow.2F3A2FEB-EFB6-4B8E-9D0F-516184A0D2C5/workflow/background.pyo', u'__workflow_update_check'] ...
12:59:04 workflow.py:2205 DEBUG    Workflow finished in 0.003 seconds.
12:59:04 workflow.py:2205 DEBUG    Workflow finished in 0.004 seconds.
12:59:04 background.py:197 DEBUG    Executing task `__workflow_update_check` in background...
2016-08-21 12:59:04,128 workflow     DEBUG    Executing task `__workflow_update_check` in background...
12:59:04 workflow.py:1777 DEBUG    Stored data saved at : /Users/***/Library/Application Support/Alfred 2/Workflow Data/com.ipaterson.alfred.wunderlist/auth.cpickle
2016-08-21 12:59:04,169 workflow     DEBUG    Stored data saved at : /Users/***/Library/Application Support/Alfred 2/Workflow Data/com.ipaterson.alfred.wunderlist/auth.cpickle
12:59:04 workflow.py:2524 DEBUG    Password exists : com.ipaterson.alfred.wunderlist:oauth_state
2016-08-21 12:59:04,221 workflow     DEBUG    Password exists : com.ipaterson.alfred.wunderlist:oauth_state
12:59:04 workflow.py:2571 DEBUG    Got password : com.ipaterson.alfred.wunderlist:oauth_state
2016-08-21 12:59:04,254 workflow     DEBUG    Got password : com.ipaterson.alfred.wunderlist:oauth_state
12:59:04 workflow.py:2593 DEBUG    Deleted password : com.ipaterson.alfred.wunderlist:oauth_state
2016-08-21 12:59:04,287 workflow     DEBUG    Deleted password : com.ipaterson.alfred.wunderlist:oauth_state
12:59:04 workflow.py:2534 DEBUG    save_password : com.ipaterson.alfred.wunderlist:oauth_state
2016-08-21 12:59:04,350 workflow     DEBUG    save_password : com.ipaterson.alfred.wunderlist:oauth_state
12:59:04 background.py:188 DEBUG    Command arguments cached to `/Users/***/Library/Caches/com.runningwithcrayons.Alfred-2/Workflow Data/com.ipaterson.alfred.wunderlist/sync.argcache`
2016-08-21 12:59:04,481 workflow     DEBUG    Command arguments cached to `/Users/***/Library/Caches/com.runningwithcrayons.Alfred-2/Workflow Data/com.ipaterson.alfred.wunderlist/sync.argcache`
12:59:04 background.py:192 DEBUG    Calling [u'/usr/bin/python', '/Users/***/Library/Application Support/Alfred 2/Alfred.alfredpreferences/workflows/user.workflow.2F3A2FEB-EFB6-4B8E-9D0F-516184A0D2C5/workflow/background.pyo', 'sync'] ...
2016-08-21 12:59:04,483 workflow     DEBUG    Calling [u'/usr/bin/python', '/Users/***/Library/Application Support/Alfred 2/Alfred.alfredpreferences/workflows/user.workflow.2F3A2FEB-EFB6-4B8E-9D0F-516184A0D2C5/workflow/background.pyo', 'sync'] ...
12:59:04 workflow.py:2205 DEBUG    Workflow finished in 0.003 seconds.
12:59:04 workflow.py:2205 DEBUG    Workflow finished in 0.004 seconds.
12:59:04 background.py:197 DEBUG    Executing task `sync` in background...
2016-08-21 12:59:04,617 workflow     DEBUG    Executing task `sync` in background...
2016-08-21 12:59:04,624 wunderlist   INFO     Workflow response complete
12:59:04 workflow.py:2361 DEBUG    Set last run version : 0.6.0-beta.5
2016-08-21 12:59:04,625 workflow     DEBUG    Set last run version : 0.6.0-beta.5
12:59:04 workflow.py:2205 DEBUG    Workflow finished in 0.594 seconds.
2016-08-21 12:59:04,625 workflow     DEBUG    Workflow finished in 0.594 seconds.
12:59:05 workflow.py:2571 DEBUG    Got password : com.ipaterson.alfred.wunde
[INFO: alfred.workflow.action.script] Processing output 'alfred.workflow.output.notification' with arg '----------------------------------------
Exception happened during processing of request from ('127.0.0.1', 64841)
----------------------------------------
'
idpaterson commented 8 years ago

Thank you for including all of that info, this is not something that I have seen before. It is clear that the background server receives the request from your browser after logging in to Wunderlist, but maybe the URL is not what it expected.

First, please try copying the localhost URL from your browser into the workflow's login help screen. When you press return it will validate that URL – if it works you will be logged in but if it does not the error log might show something else to help track this down. screen shot 2016-08-21 at 9 01 28 am

davecahill commented 8 years ago

First, please try copying the localhost URL from your browser into the workflow's login help screen. When you press return it will validate that URL – if it works you will be logged in but if it does not the error log might show something else to help track this down.

This did the trick - turned out to be a silly firewall issue. Debug logs showed "host not found" for www.wunderlist.com, which seemed weird since I could hit than in my browser. Sounded like a firewall issue, so I checked - turns out my firewall (Little Snitch) had just updated, but was in some strange state pending a restart, so wasn't warning when it denied connections. After a restart, the workflow is working great.

Feel free to close this - I won't close it myself in case you want to use it to track adding a warning message when the server can't reach Wunderlist (that's probably a rare case :)). Thanks very much for the quick reply!

idpaterson commented 8 years ago

Thank you, I appreciate the follow-up and am glad you figured it out!