search

leocrawford / picasawebsync

Sync local directories with picasaweb
MIT License
59 stars 16 forks source link

After 30 minutes to upload I have this error #32

Closed emmtte closed 8 years ago

emmtte commented 9 years ago 
Traceback (most recent call last):
  File "/home/pi/picasawebsync/picasawebsync.py", line 746, in <module>
    albums.uploadMissingAlbumsAndFiles(args.compareattributes, mode, args.test, args.allowDelete)
  File "/home/pi/picasawebsync/picasawebsync.py", line 260, in uploadMissingAlbumsAndFiles
    album.writeDate()
  File "/home/pi/picasawebsync/picasawebsync.py", line 296, in writeDate
    album = a.getEditObject()
  File "/home/pi/picasawebsync/picasawebsync.py", line 336, in getEditObject
    return gd_client.GetEntry(self.albumid)
  File "/usr/local/lib/python2.7/dist-packages/gdata-2.0.18-py2.7.egg/gdata/photos/service.py", line 207, in GetEntry
    raise GooglePhotosException(e.args[0])
gdata.photos.service.GooglePhotosException: (403, 'Forbidden', 'Token invalid - Invalid token: Token not found')
leocrawford commented 9 years ago

Sorry for the slow reply. No internet after moving house.

Are you using the latest version of the code?

andreasqueri commented 9 years ago

Same issue for me..

leocrawford commented 9 years ago

Sorry for the delay. I moved house and have very intermittent internet access, which also means I can't replicate the problem

I think the problem is that when we get a sign-on time-out we used to do a gd_client.ProgrammaticLogin() after the time.sleep(6)

This has changed for ouath2 (and seemingly got deleted). I suspect that adding a oauthLogin() after the time.sleep(6)would fix things - but it would be good if someone could test for me before I push out a new version.

mit-brooks commented 9 years ago

I also get this error. My system:

$ python --version
Python 2.7.3
$ pip freeze | grep gdata
gdata==2.0.17
picasawebsync$ git rev-parse --short HEAD
a98f91e

I run this command:

picasawebsync$ ./picasawebsync.py -v -f both -m upload -d /Pictures/google

The script seems to run normally for up to an hour then:

...
UPLOAD_LOCAL (LOCAL_ONLY) #9993/13930 - Visiting the Gills (2015) DSC07639.jpg
UPLOAD_LOCAL (LOCAL_ONLY) #9994/13930 - Visiting the Gills (2015) DSC07415.jpg
Trying UPLOAD_LOCAL on Visiting the Gills (2015) DSC07415.jpg identified as LOCAL_ONLY attempt 1
Trying UPLOAD_LOCAL on Visiting the Gills (2015) DSC07415.jpg identified as LOCAL_ONLY attempt 2
WARNING: Failed to UPLOAD_LOCAL on Visiting the Gills (2015) DSC07415.jpg identified as LOCAL_ONLY. This was due to (403, 'Forbidden', 'Token invalid - Invalid token: Token not found')
UPLOAD_LOCAL (LOCAL_ONLY) #9995/13930 - Visiting the Gills (2015) DSC07534.jpg
Trying UPLOAD_LOCAL on Visiting the Gills (2015) DSC07534.jpg identified as LOCAL_ONLY attempt 1
Trying UPLOAD_LOCAL on Visiting the Gills (2015) DSC07534.jpg identified as LOCAL_ONLY attempt 2
WARNING: Failed to UPLOAD_LOCAL on Visiting the Gills (2015) DSC07534.jpg identified as LOCAL_ONLY. This was due to (403, 'Forbidden', 'Token invalid - Invalid token: Token not found')
...

finishing with 

...
UPLOAD_LOCAL (LOCAL_ONLY) #10027/13930 - Visiting the Gills (2015) DSC07802.jpg
Trying UPLOAD_LOCAL on Visiting the Gills (2015) DSC07802.jpg identified as LOCAL_ONLY attempt 1
Trying UPLOAD_LOCAL on Visiting the Gills (2015) DSC07802.jpg identified as LOCAL_ONLY attempt 2
WARNING: Failed to UPLOAD_LOCAL on Visiting the Gills (2015) DSC07802.jpg identified as LOCAL_ONLY. This was due to (403, 'Forbidden', 'Token invalid - Invalid token: Token not found')
Attempting to write date (1439383635000) to album Visiting the Gills (2015)

I think the issue is that the credentials need to be refreshed periodically. Currently credentials are only refreshed at the start, so after an hour, anything left to upload fails (3 times each (!)) I added gd_client=oauth2Login() after time sleep(6) and that helps for large numbers of photos to upload, but not for one large video that would take longer than 1 hour to upload.

maybe a timed token refresh in a separate tread to the main code?

leocrawford commented 9 years ago

Good diagnosis and suggestion. I must admit to not having done threads in Python before, so was wondering if you'd be able to submit a patch?

ehrepli commented 9 years ago

Adding gd_client=oauth2Login() after time sleep(6) doesn't seem to do anything for me, still getting this error after a while. WARNING: Failed to UPLOAD_LOCAL on XXX.JPG identified as LOCAL_ONLY. This was due to (403, 'Forbidden', 'Token invalid - Invalid token: Stateless token expired') Any other ideas?

leocrawford commented 9 years ago

Does it ever work for you? Is it only failing on certain files? Large files or something else?

ehrepli commented 9 years ago

of course, it fails on large videos, but i tried with photos only, 3-4Mb each, and it fails after maybe one hour or so, every time. Throwing the oauthlogin() after every error does not seem to have any impact.

leocrawford commented 9 years ago

I'm pretty sure that the authentication is timing out. If a large file causes the timeout before it can upload then we have an issue, but otherwise I'd have thought it would reauthenticate and try again. Are you sure that isn't what's happening?

Fixing the large for problem requires threads, and as I don't know how to do that in Python and have just had a baby I'm reliant on a patch submission

ehrepli commented 9 years ago

Congratulations on the baby!

I'm pretty sure reauthentication does not work. Seems to fail about an hour after starting, small files only, no matter if I do the reauth. I've read something about reauth happening in a different way, linke you need to ask for a different token or something, but I did not understand much, not being a programmer myself.

Wish I could do more.

leocrawford commented 9 years ago

Could someone with a large video file test? Also would be good to have reports from a few different systems/python interpreters.

andreasqueri commented 9 years ago

I can test it.. Today or tomorrow I will test it for you and i will reporter the results

andreasqueri commented 9 years ago

No , Unfortunately, it dosen't work. This is the output of the command "python2 /home/andre/bin/picasawebsync.py -m upload -c1 -v -f video -d /mnt/nas/filmati/Video/Cellulare/sync/":

SILENT (SAME) #3580/15791 - 2015_Sheldon_video VID_20150131_192514.mp4 [1150/1749] SILENT (SAME) #3581/15791 - 2015_Sheldon_video VID_20150322_122410.mp4 [1149/1749] UPLOAD_LOCAL (LOCAL_ONLY) #3582/15791 - 2015_Sheldon_video VID_20150809_132234.mp4 [1148/1749] Finished sleeping refreshCreds Expires 2015-10-20 15:58:53.133615 from 2015-10-20 14:58:53.202279 = 3599 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-20 16:58:54.008581 from 2015-10-20 15:58:54.068526 = 3599 Starting refreshCreds About to return refreshCreds Starting refreshCreds Finished sleeping refreshCreds Expires 2015-10-20 17:25:31.691578 from 2015-10-20 16:25:31.741389 = 3599 Starting refreshCredsAbout to return refreshCreds

Trying UPLOAD_LOCAL on 2015_Sheldon_video VID_20150809_132234.mp4 identified as LOCAL_ONLY attempt 1 Finished sleeping refreshCreds Expires 2015-10-20 17:25:31 from 2015-10-20 16:58:53.140772 = 1597 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Finished sleeping refreshCreds Expires 2015-10-20 18:25:31.530278 from 2015-10-20 17:25:31.608161 = 3599 Starting refreshCreds About to return refreshCreds Expires 2015-10-20 18:25:32.484630 from 2015-10-20 17:25:32.538581 = 3599 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-20 18:25:32 from 2015-10-20 18:25:30.693130 = 1 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Finished sleeping refreshCreds Expires 2015-10-20 19:25:32.798955 from 2015-10-20 18:25:32.880548 = 3599 Starting refreshCreds About to return refreshCreds Expires 2015-10-20 19:25:37.474004 from 2015-10-20 18:25:37.550922 = 3599 Starting refreshCreds About to return refreshCreds Starting refreshCreds Finished sleeping refreshCreds Expires 2015-10-20 19:42:14.496125 from 2015-10-20 18:42:14.607498 = 3599 About to return refreshCreds Trying UPLOAD_LOCAL on 2015_Sheldon_video VID_20150809_132234.mp4 identified as LOCAL_ONLY attempt 2 Starting refreshCreds Finished sleeping refreshCreds Expires 2015-10-20 19:42:14 from 2015-10-20 19:25:31.915078 = 1002 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-20 19:42:14 from 2015-10-20 19:25:36.654576 = 997 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Finished sleeping refreshCreds Finished sleeping refreshCreds Expires 2015-10-20 20:42:14.985869 from 2015-10-20 19:42:15.007226 = 3599 Starting refreshCreds About to return refreshCreds Expires 2015-10-20 20:42:15.247554 from 2015-10-20 19:42:15.311289 = 3599 Starting refreshCreds About to return refreshCreds Expires 2015-10-20 20:42:15.345011 from 2015-10-20 19:42:15.364476 = 3599 Starting refreshCreds About to return refreshCreds Starting refreshCreds Finished sleeping refreshCreds Expires 2015-10-20 21:34:11.562730 from 2015-10-20 20:34:11.632786 = 3599 Starting refreshCredsAbout to return refreshCreds

WARNING: Failed to UPLOAD_LOCAL on 2015_Sheldon_video VID_20150809_132234.mp4 identified as LOCAL_ONLY. This was due to (403, 'Forbidden', 'Token invalid - Invalid token: Stateless token expi red') SILENT (SAME) #3583/15791 - 2015_Sheldon_video VID_20150809_143635.mp4 UPLOAD_LOCAL (LOCAL_ONLY) #3584/15791 - 2015_Sheldon_video 20150911_150755.mp4 Finished sleeping refreshCreds Expires 2015-10-20 21:34:11 from 2015-10-20 20:42:14.102984 = 3116 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-20 21:34:11 from 2015-10-20 20:42:14.416867 = 3116 Starting refreshCredsAbout to return refreshCreds

Finished sleeping refreshCreds Expires 2015-10-20 21:34:11 from 2015-10-20 20:42:14.453617 = 3116 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Finished sleeping refreshCreds Finished sleeping refreshCreds Finished sleeping refreshCreds Expires 2015-10-20 22:34:11.968960 from 2015-10-20 21:34:12.053744 = 3599 Starting refreshCreds About to return refreshCreds Expires 2015-10-20 22:34:12.063611 from 2015-10-20 21:34:12.088956 = 3599 Starting refreshCredsAbout to return refreshCreds

Expires 2015-10-20 22:34:12.126867 from 2015-10-20 21:34:12.147858 = 3599 Starting refreshCreds About to return refreshCreds Expires 2015-10-20 22:34:12.899029 from 2015-10-20 21:34:12.959327 = 3599 Starting refreshCreds About to return refreshCreds Starting refreshCreds Finished sleeping refreshCreds Expires 2015-10-20 22:50:32.797030 from 2015-10-20 21:50:32.849945 = 3599 Starting refreshCreds About to return refreshCreds Trying UPLOAD_LOCAL on 2015_Sheldon_video 20150911_150755.mp4 identified as LOCAL_ONLY attempt 1 Finished sleeping refreshCreds Expires 2015-10-20 22:50:32 from 2015-10-20 22:34:11.138230 = 980 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-20 22:50:32 from 2015-10-20 22:34:11.186171 = 980 Starting refreshCredsAbout to return refreshCreds

Finished sleeping refreshCreds Expires 2015-10-20 22:50:32 from 2015-10-20 22:34:11.254655 = 980 Starting refreshCredsAbout to return refreshCreds [1029/1749] Finished sleeping refreshCreds Expires 2015-10-20 22:50:32 from 2015-10-20 22:34:12.041675 = 979 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Finished sleeping refreshCreds Finished sleeping refreshCreds Finished sleeping refreshCreds Finished sleeping refreshCreds Expires 2015-10-20 23:50:32.167091 from 2015-10-20 22:50:32.241902 = 3599 Starting refreshCreds About to return refreshCreds Expires 2015-10-20 23:50:32.816602 from 2015-10-20 22:50:32.871405 = 3599 Starting refreshCreds About to return refreshCreds Expires 2015-10-20 23:50:37.109832 from 2015-10-20 22:50:37.191463 = 3599 Starting refreshCreds About to return refreshCreds Expires 2015-10-20 23:50:37.278634 from 2015-10-20 22:50:37.301026 = 3599 Starting refreshCreds About to return refreshCreds Expires 2015-10-20 23:50:38.112679 from 2015-10-20 22:50:38.171542 = 3599 Starting refreshCreds About to return refreshCreds Starting refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 00:11:21.264512 from 2015-10-20 23:11:21.321201 = 3599 Starting refreshCreds About to return refreshCreds Trying UPLOAD_LOCAL on 2015_Sheldon_video 20150911_150755.mp4 identified as LOCAL_ONLY attempt 2 Finished sleeping refreshCreds Expires 2015-10-21 00:11:21 from 2015-10-20 23:50:31.300391 = 1249 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 00:11:21 from 2015-10-20 23:50:31.956867 = 1249 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 00:11:21 from 2015-10-20 23:50:36.291478 = 1244 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 00:11:21 from 2015-10-20 23:50:36.402414 = 1244 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 00:11:21 from 2015-10-20 23:50:37.275876 = 1243 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Finished sleeping refreshCreds Finished sleeping refreshCreds Finished sleeping refreshCreds Finished sleeping refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 01:11:21.969980 from 2015-10-21 00:11:22.058339 = 3599 About to return refreshCreds Starting refreshCreds Expires 2015-10-21 01:11:21.997448 from 2015-10-21 00:11:22.087214 = 3599 Starting refreshCreds About to return refreshCreds Expires 2015-10-21 01:11:22.194631 from 2015-10-21 00:11:22.215802 = 3599 Starting refreshCreds About to return refreshCreds Expires 2015-10-21 01:11:26.544052 from 2015-10-21 00:11:26.622471 = 3599 Starting refreshCreds About to return refreshCreds Expires 2015-10-21 01:11:26.762612 from 2015-10-21 00:11:26.783344 = 3599 Starting refreshCreds About to return refreshCreds Expires 2015-10-21 01:11:26.831750 from 2015-10-21 00:11:26.854565 = 3599 Starting refreshCreds About to return refreshCreds Starting refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 01:29:47.802282 from 2015-10-21 00:29:47.859205 = 3599 Starting refreshCreds About to return refreshCreds WARNING: Failed to UPLOAD_LOCAL on 2015_Sheldon_video 20150911_150755.mp4 identified as LOCAL_ONLY. This was due to (403, 'Forbidden', 'Token invalid - Invalid token: Stateless token expired' ) SILENT (SAME) #3585/15791 - 2015_Sheldon_video 20150510_092746.mp4 UPLOAD_LOCAL (LOCAL_ONLY) #3586/15791 - 2015_Sheldon_video VID_20150828_074736.mp4 Starting refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 01:30:09.009953 from 2015-10-21 00:30:09.083158 = 3599 Starting refreshCreds About to return refreshCreds Trying UPLOAD_LOCAL on 2015_Sheldon_video VID_20150828_074736.mp4 identified as LOCAL_ONLY attempt 1 Starting refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 01:30:16.284914 from 2015-10-21 00:30:16.307158 = 3599 Starting refreshCreds About to return refreshCreds Trying UPLOAD_LOCAL on 2015_Sheldon_video VID_20150828_074736.mp4 identified as LOCAL_ONLY attempt 2 Starting refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 01:30:23.503496 from 2015-10-21 00:30:23.554742 = 3599 Starting refreshCreds About to return refreshCreds WARNING: Failed to UPLOAD_LOCAL on 2015_Sheldon_video VID_20150828_074736.mp4 identified as LOCAL_ONLY. This was due to [Errno 32] Broken pipe SILENT (SAME) #3587/15791 - 2015_Sheldon_video VID_20150301_164225.mp4 UPLOAD_LOCAL (LOCAL_ONLY) #3588/15791 - 2015_Sheldon_video VID_20150824_074000.mp4 Starting refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 02:05:07.932104 from 2015-10-21 01:05:08.080580 = 3599 Starting refreshCredsAbout to return refreshCreds

Trying UPLOAD_LOCAL on 2015_Sheldon_video VID_20150824_074000.mp4 identified as LOCAL_ONLY attempt 1 Finished sleeping refreshCreds Expires 2015-10-21 02:05:07 from 2015-10-21 01:11:21.138920 = 3225 Starting refreshCredsAbout to return refreshCreds

Finished sleeping refreshCreds Expires 2015-10-21 02:05:07 from 2015-10-21 01:11:21.190925 = 3225 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 02:05:07 from 2015-10-21 01:11:21.276148 = 3225 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 02:05:07 from 2015-10-21 01:11:25.722229 = 3221 Starting refreshCredsAbout to return refreshCreds

Finished sleeping refreshCreds Expires 2015-10-21 02:05:07 from 2015-10-21 01:11:25.882382 = 3221 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 02:05:07 from 2015-10-21 01:11:25.906575 = 3221 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 02:05:07 from 2015-10-21 01:29:46.959871 = 2120 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 02:05:07 from 2015-10-21 01:30:08.176179 = 2098 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 02:05:07 from 2015-10-21 01:30:15.412967 = 2091 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 02:05:07 from 2015-10-21 01:30:22.658392 = 2084 Starting refreshCreds About to return refreshCreds Starting refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 02:41:29.791088 from 2015-10-21 01:41:29.861733 = 3599 Starting refreshCreds About to return refreshCreds Trying UPLOAD_LOCAL on 2015_Sheldon_video VID_20150824_074000.mp4 identified as LOCAL_ONLY attempt 2 Finished sleeping refreshCreds Expires 2015-10-21 02:41:29 from 2015-10-21 02:05:06.213043 = 2182 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 02:41:29 from 2015-10-21 02:05:06.243819 = 2182 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 02:41:29 from 2015-10-21 02:05:06.295711 = 2182 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 02:41:29 from 2015-10-21 02:05:06.357448 = 2182 Starting refreshCreds About to return refreshCreds

Finished sleeping refreshCreds Expires 2015-10-21 02:41:29 from 2015-10-21 02:05:06.505234 = 2182 Starting refreshCredsAbout to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 02:41:29 from 2015-10-21 02:05:06.505234 = 2182 Starting refreshCredsAbout to return refreshCreds

Finished sleeping refreshCreds Expires 2015-10-21 02:41:29 from 2015-10-21 02:05:06.757218 = 2182 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 02:41:29 from 2015-10-21 02:05:06.813521 = 2182 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 02:41:29 from 2015-10-21 02:05:06.971901 = 2182 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 02:41:29 from 2015-10-21 02:05:07.011489 = 2181 Starting refreshCredsAbout to return refreshCreds

Finished sleeping refreshCreds Expires 2015-10-21 02:41:29 from 2015-10-21 02:05:07.061690 = 2181 Starting refreshCredsAbout to return refreshCreds

Finished sleeping refreshCreds Expires 2015-10-21 02:41:29 from 2015-10-21 02:05:07.172654 = 2181 Starting refreshCreds About to return refreshCreds Starting refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 03:20:00.605324 from 2015-10-21 02:20:00.679315 = 3599 Starting refreshCreds About to return refreshCreds WARNING: Failed to UPLOAD_LOCAL on 2015_Sheldon_video VID_20150824_074000.mp4 identified as LOCAL_ONLY. This was due to (403, 'Forbidden', 'Token invalid - Invalid token: Stateless token expi red') SILENT (SAME) #3589/15791 - 2015_Sheldon_video VID_20150206_192751.mp4 UPLOAD_LOCAL (LOCAL_ONLY) #3590/15791 - 2015_Sheldon_video VID_20150816_123930.mp4 Starting refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 03:20:19.843121 from 2015-10-21 02:20:19.894767 = 3599 Starting refreshCreds About to return refreshCreds Trying UPLOAD_LOCAL on 2015_Sheldon_video VID_20150816_123930.mp4 identified as LOCAL_ONLY attempt 1 Starting refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 03:20:27.146174 from 2015-10-21 02:20:27.245644 = 3599 Starting refreshCreds About to return refreshCreds Trying UPLOAD_LOCAL on 2015_Sheldon_video VID_20150816_123930.mp4 identified as LOCAL_ONLY attempt 2 Starting refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 03:20:34.523290 from 2015-10-21 02:20:34.576729 = 3599 Starting refreshCreds About to return refreshCreds WARNING: Failed to UPLOAD_LOCAL on 2015_Sheldon_video VID_20150816_123930.mp4 identified as LOCAL_ONLY. This was due to [Errno 32] Broken pipe SILENT (SAME) #3591/15791 - 2015_Sheldon_video VID_20150131_192412.mp4 UPLOAD_LOCAL (LOCAL_ONLY) #3592/15791 - 2015_Sheldon_video 20150829_105924.mp4 Finished sleeping refreshCreds Expires 2015-10-21 03:20:34 from 2015-10-21 02:41:28.120002 = 2345 Finished sleeping refreshCreds Expires 2015-10-21 03:20:34 from 2015-10-21 02:41:28.151991 = 2345 Starting refreshCredsAbout to return refreshCreds

Finished sleeping refreshCreds Expires 2015-10-21 03:20:34 from 2015-10-21 02:41:28.268528 = 2345 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 03:20:34 from 2015-10-21 02:41:28.313088 = 2345 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 03:20:34 from 2015-10-21 02:41:28.317145 = 2345 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 03:20:34 from 2015-10-21 02:41:28.370893 = 2345 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 03:20:34 from 2015-10-21 02:41:28.460844 = 2345 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 03:20:34 from 2015-10-21 02:41:28.578239 = 2345 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 03:20:34 from 2015-10-21 02:41:28.833382 = 2345 Starting refreshCredsAbout to return refreshCreds

Finished sleeping refreshCreds Expires 2015-10-21 03:20:34 from 2015-10-21 02:41:28.884094 = 2345 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 03:20:34 from 2015-10-21 02:41:28.961732 = 2345 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 03:20:34 from 2015-10-21 02:41:29.074125 = 2344 Starting refreshCreds About to return refreshCreds Starting refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 04:10:40.465650 from 2015-10-21 03:10:40.531796 = 3599 Starting refreshCreds About to return refreshCreds Trying UPLOAD_LOCAL on 2015_Sheldon_video 20150829_105924.mp4 identified as LOCAL_ONLY attempt 1 Finished sleeping refreshCreds Expires 2015-10-21 04:10:40 from 2015-10-21 03:19:59.777724 = 3040 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 04:10:40 from 2015-10-21 03:20:18.988441 = 3021 Starting refreshCredsAbout to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 04:10:40 from 2015-10-21 03:20:26.324277 = 3013 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 04:10:40 from 2015-10-21 03:20:33.159081 = 3006 Finished sleeping refreshCreds Starting refreshCreds About to return refreshCreds Expires 2015-10-21 04:10:40 from 2015-10-21 03:20:33.164526 = 3006 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 04:10:40 from 2015-10-21 03:20:33.256245 = 3006 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 04:10:40 from 2015-10-21 03:20:33.367629 = 3006 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 04:10:40 from 2015-10-21 03:20:33.410227 = 3006 Starting refreshCredsAbout to return refreshCreds

Finished sleeping refreshCreds Expires 2015-10-21 04:10:40 from 2015-10-21 03:20:33.417157 = 3006 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 04:10:40 from 2015-10-21 03:20:33.474510 = 3006 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 04:10:40 from 2015-10-21 03:20:33.560764 = 3006 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 04:10:40 from 2015-10-21 03:20:33.665788 = 3006 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 04:10:40 from 2015-10-21 03:20:33.670659 = 3006 About to return refreshCreds Starting refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 04:10:40 from 2015-10-21 03:20:33.938334 = 3006 Starting refreshCredsAbout to return refreshCreds

Finished sleeping refreshCreds Expires 2015-10-21 04:10:40 from 2015-10-21 03:20:33.975114 = 3006 Starting refreshCredsAbout to return refreshCreds

Finished sleeping refreshCreds Expires 2015-10-21 04:10:40 from 2015-10-21 03:20:34.062794 = 3005 Starting refreshCreds About to return refreshCreds Starting refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 05:01:14.855106 from 2015-10-21 04:01:14.909174 = 3599 Starting refreshCreds About to return refreshCreds Trying UPLOAD_LOCAL on 2015_Sheldon_video 20150829_105924.mp4 identified as LOCAL_ONLY attempt 2 Finished sleeping refreshCreds Expires 2015-10-21 05:01:14 from 2015-10-21 04:10:39.148337 = 3034 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 05:01:14 from 2015-10-21 04:10:39.210863 = 3034 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 05:01:14 from 2015-10-21 04:10:39.246928 = 3034 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 05:01:14 from 2015-10-21 04:10:39.298476 = 3034 Starting refreshCredsAbout to return refreshCreds

Finished sleeping refreshCreds Expires 2015-10-21 05:01:14 from 2015-10-21 04:10:39.425006 = 3034 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 05:01:14 from 2015-10-21 04:10:39.446821 = 3034 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 05:01:14 from 2015-10-21 04:10:39.509899 = 3034 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 05:01:14 from 2015-10-21 04:10:39.513828 = 3034 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 05:01:14 from 2015-10-21 04:10:39.571967 = 3034 Starting refreshCredsAbout to return refreshCreds

Finished sleeping refreshCreds Expires 2015-10-21 05:01:14 from 2015-10-21 04:10:39.636944 = 3034 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 05:01:14 from 2015-10-21 04:10:39.661319 = 3034 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 05:01:14 from 2015-10-21 04:10:39.770652 = 3034 Starting refreshCredsAbout to return refreshCreds

Finished sleeping refreshCreds Expires 2015-10-21 05:01:14 from 2015-10-21 04:10:39.775473 = 3034 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 05:01:14 from 2015-10-21 04:10:39.825443 = 3034 Starting refreshCreds About to return refreshCreds Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 05:01:14 from 2015-10-21 04:10:40.042220 = 3033 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 05:01:14 from 2015-10-21 04:10:40.061003 = 3033 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 05:01:14 from 2015-10-21 04:10:40.079771 = 3033 Starting refreshCredsAbout to return refreshCreds

Starting refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 05:52:36.057514 from 2015-10-21 04:52:36.103538 = 3599 Starting refreshCredsAbout to return refreshCreds

WARNING: Failed to UPLOAD_LOCAL on 2015_Sheldon_video 20150829_105924.mp4 identified as LOCAL_ONLY. This was due to (403, 'Forbidden', 'Token invalid - Invalid token: Stateless token expired' ) SILENT (SAME) #3593/15791 - 2015_Sheldon_video VID_20150206_083512.mp4 SILENT (SAME) #3594/15791 - 2015_Sheldon_video VID_20141019_145328.mp4 UPLOAD_LOCAL (LOCAL_ONLY) #3595/15791 - 2015_Sheldon_video VID_20150704_071310.mp4 Finished sleeping refreshCreds Expires 2015-10-21 05:52:36 from 2015-10-21 05:01:13.124972 = 3082 Starting refreshCredsAbout to return refreshCreds

Finished sleeping refreshCreds Expires 2015-10-21 05:52:36 from 2015-10-21 05:01:13.165568 = 3082 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 05:52:36 from 2015-10-21 05:01:13.183542 = 3082 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 05:52:36 from 2015-10-21 05:01:13.253319 = 3082 Starting refreshCredsAbout to return refreshCreds

Finished sleeping refreshCreds Expires 2015-10-21 05:52:36 from 2015-10-21 05:01:13.302944 = 3082 Starting refreshCredsAbout to return refreshCreds

Finished sleeping refreshCreds Expires 2015-10-21 05:52:36 from 2015-10-21 05:01:13.348419 = 3082 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 05:52:36 from 2015-10-21 05:01:13.395928 = 3082 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 05:52:36 from 2015-10-21 05:01:13.518596 = 3082 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Finished sleeping refreshCreds [566/1749] Expires 2015-10-21 05:52:36 from 2015-10-21 05:01:13.533773 = 3082 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 05:52:36 from 2015-10-21 05:01:13.613772 = 3082Expires 2015-10-21 05:52:36 from 2015-10-21 05:01:13.615161 = 3082

Starting refreshCreds Starting refreshCreds About to return refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 05:52:36 from 2015-10-21 05:01:13.662610 = 3082 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 05:52:36 from 2015-10-21 05:01:13.735751 = 3082 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 05:52:36 from 2015-10-21 05:01:13.763202 = 3082 Starting refreshCredsAbout to return refreshCreds

Finished sleeping refreshCreds Expires 2015-10-21 05:52:36 from 2015-10-21 05:01:13.859806 = 3082 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 05:52:36 from 2015-10-21 05:01:13.865403 = 3082 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 05:52:36 from 2015-10-21 05:01:13.929530 = 3082 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 05:52:36 from 2015-10-21 05:01:14.002676 = 3081 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Finished sleeping refreshCreds Finished sleeping refreshCreds Finished sleeping refreshCreds Finished sleeping refreshCreds Finished sleeping refreshCreds Finished sleeping refreshCreds

Finished sleeping refreshCreds Finished sleeping refreshCreds Finished sleeping refreshCreds Finished sleeping refreshCreds Finished sleeping refreshCreds Finished sleeping refreshCreds Finished sleeping refreshCreds Finished sleeping refreshCreds Finished sleeping refreshCredsFinished sleeping refreshCreds Finished sleeping refreshCreds

Finished sleeping refreshCreds Expires 2015-10-21 06:52:37.083032 from 2015-10-21 05:52:37.179776 = 3599 Starting refreshCreds [506/1749] About to return refreshCreds Expires 2015-10-21 06:52:37.161417 from 2015-10-21 05:52:37.215602 = 3599 Starting refreshCreds About to return refreshCreds Expires 2015-10-21 06:52:37.230270 from 2015-10-21 05:52:37.255102 = 3599 Starting refreshCreds About to return refreshCreds Expires 2015-10-21 06:52:37.745347 from 2015-10-21 05:52:37.804522 = 3599 Starting refreshCreds About to return refreshCreds Expires 2015-10-21 06:52:37.897987 from 2015-10-21 05:52:37.919969 = 3599 Starting refreshCreds About to return refreshCreds Expires 2015-10-21 06:52:38.367444 from 2015-10-21 05:52:38.432582 = 3599 Starting refreshCreds Expires 2015-10-21 06:52:38.395665 from 2015-10-21 05:52:38.460115 = 3599 About to return refreshCreds Starting refreshCreds About to return refreshCreds Expires 2015-10-21 06:52:38.498918 from 2015-10-21 05:52:38.525957 = 3599 Starting refreshCreds About to return refreshCreds Expires 2015-10-21 06:52:38.578435 from 2015-10-21 05:52:38.599772 = 3599 Starting refreshCreds About to return refreshCreds Expires 2015-10-21 06:52:38.620593 from 2015-10-21 05:52:38.646810 = 3599 Starting refreshCreds About to return refreshCreds Expires 2015-10-21 06:52:38.690884 from 2015-10-21 05:52:38.704964 = 3599 Starting refreshCredsAbout to return refreshCreds

Expires 2015-10-21 06:52:38.977673 from 2015-10-21 05:52:39.035175 = 3599 Starting refreshCreds About to return refreshCreds Expires 2015-10-21 06:52:39.163800 from 2015-10-21 05:52:39.186849 = 3599 Starting refreshCreds About to return refreshCreds Expires 2015-10-21 06:52:39.229588 from 2015-10-21 05:52:39.253954 = 3599 Starting refreshCreds About to return refreshCreds Expires 2015-10-21 06:52:39.366337 from 2015-10-21 05:52:39.395063 = 3599 About to return refreshCreds Starting refreshCreds Expires 2015-10-21 06:52:40.021889 from 2015-10-21 05:52:40.082072 = 3599 Starting refreshCreds About to return refreshCreds Expires 2015-10-21 06:52:40.385038 from 2015-10-21 05:52:40.444509 = 3599 Starting refreshCreds About to return refreshCreds Expires 2015-10-21 06:52:40.703894 from 2015-10-21 05:52:40.762478 = 3599 Starting refreshCredsAbout to return refreshCreds

Expires 2015-10-21 06:52:41.732875 from 2015-10-21 05:52:41.791151 = 3599 Starting refreshCreds About to return refreshCreds Starting refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 06:58:56.253721 from 2015-10-21 05:58:56.268567 = 3599 Starting refreshCreds Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 06:58:56 from 2015-10-21 06:52:36.311314 = 379 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 06:58:56 from 2015-10-21 06:52:36.360587 = 379 Starting refreshCredsAbout to return refreshCreds

Finished sleeping refreshCreds Expires 2015-10-21 06:58:56 from 2015-10-21 06:52:36.896339 = 379 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 06:58:56 from 2015-10-21 06:52:37.018276 = 378 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 06:58:56 from 2015-10-21 06:52:37.544655 = 378 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 06:58:56 from 2015-10-21 06:52:37.550243 = 378 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 06:58:56 from 2015-10-21 06:52:37.598779 = 378 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 06:58:56 from 2015-10-21 06:52:37.697799 = 378 Starting refreshCredsAbout to return refreshCreds

Finished sleeping refreshCreds Expires 2015-10-21 06:58:56 from 2015-10-21 06:52:37.704064 = 378 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 06:58:56 from 2015-10-21 06:52:37.811780 = 378 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 06:58:56 from 2015-10-21 06:52:38.128219 = 377 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 06:58:56 from 2015-10-21 06:52:38.241341 = 377 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 06:58:56 from 2015-10-21 06:52:38.340052 = 377 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 06:58:56 from 2015-10-21 06:52:38.486480 = 377 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 06:58:56 from 2015-10-21 06:52:39.181433 = 376 [383/1749] Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 06:58:56 from 2015-10-21 06:52:39.538037 = 376 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 06:58:56 from 2015-10-21 06:52:39.839487 = 376 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 06:58:56 from 2015-10-21 06:52:40.873746 = 375 Starting refreshCreds About to return refreshCreds Starting refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 07:57:56.106586 from 2015-10-21 06:57:56.161321 = 3599 Starting refreshCredsAbout to return refreshCreds

Trying UPLOAD_LOCAL on 2015_Sheldon_video VID_20150704_071310.mp4 identified as LOCAL_ONLY attempt 2 Finished sleeping refreshCreds Expires 2015-10-21 07:57:56 from 2015-10-21 06:58:55.072454 = 3540 Starting refreshCredsAbout to return refreshCreds

Finished sleeping refreshCreds Expires 2015-10-21 07:57:56 from 2015-10-21 06:58:55.232155 = 3540 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 07:57:56 from 2015-10-21 06:58:55.253189 = 3540 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 07:57:56 from 2015-10-21 06:58:55.336001 = 3540 Expires 2015-10-21 07:57:56 from 2015-10-21 06:58:55.337636 = 3540Starting refreshCreds About to return refreshCreds

Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 07:57:56 from 2015-10-21 06:58:55.394185 = 3540 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 07:57:56 from 2015-10-21 06:58:55.415450 = 3540 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 07:57:56 from 2015-10-21 06:58:55.428141 = 3540 Starting refreshCredsAbout to return refreshCreds

Finished sleeping refreshCreds Expires 2015-10-21 07:57:56 from 2015-10-21 06:58:55.444835 = 3540 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 07:57:56 from 2015-10-21 06:58:55.592325 = 3540 Starting refreshCreds Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 07:57:56 from 2015-10-21 06:58:55.643087 = 3540 Starting refreshCredsAbout to return refreshCreds

Finished sleeping refreshCreds Expires 2015-10-21 07:57:56 from 2015-10-21 06:58:55.649723 = 3540 Starting refreshCreds Finished sleeping refreshCreds About to return refreshCreds Expires 2015-10-21 07:57:56 from 2015-10-21 06:58:55.654696 = 3540 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 07:57:56 from 2015-10-21 06:58:55.687326 = 3540 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 07:57:56 from 2015-10-21 06:58:55.793154 = 3540 Starting refreshCredsAbout to return refreshCreds

Finished sleeping refreshCreds Expires 2015-10-21 07:57:56 from 2015-10-21 06:58:55.804202 = 3540 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 07:57:56 from 2015-10-21 06:58:55.905134 = 3540 Starting refreshCredsAbout to return refreshCreds

Finished sleeping refreshCreds Expires 2015-10-21 07:57:56 from 2015-10-21 06:58:55.942896 = 3540 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 07:57:56 from 2015-10-21 06:58:55.969589 = 3540 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 07:57:56 from 2015-10-21 06:58:56.000866 = 3539 Starting refreshCreds About to return refreshCreds Starting refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 08:57:22.302642 from 2015-10-21 07:57:22.355215 = 3599 Starting refreshCreds About to return refreshCreds WARNING: Failed to UPLOAD_LOCAL on 2015_Sheldon_video VID_20150704_071310.mp4 identified as LOCAL_ONLY. This was due to (403, 'Forbidden', 'Token invalid - Invalid token: Stateless token expi red') UPLOAD_LOCAL (LOCAL_ONLY) #3596/15791 - 2015_Sheldon_video VID_20150716_001543.mp4 Starting refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 08:57:40.746764 from 2015-10-21 07:57:40.800595 = 3599 Starting refreshCreds About to return refreshCreds Trying UPLOAD_LOCAL on 2015_Sheldon_video VID_20150716_001543.mp4 identified as LOCAL_ONLY attempt 1 Starting refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 08:57:48.017303 from 2015-10-21 07:57:48.071277 = 3599 Starting refreshCreds About to return refreshCreds Trying UPLOAD_LOCAL on 2015_Sheldon_video VID_20150716_001543.mp4 identified as LOCAL_ONLY attempt 2 Starting refreshCreds Finished sleeping refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 08:57:48 from 2015-10-21 07:57:55.102116 = 3592 Finished sleeping refreshCreds Starting refreshCredsAbout to return refreshCreds

Expires 2015-10-21 08:57:48 from 2015-10-21 07:57:55.106817 = 3592 Starting refreshCredsAbout to return refreshCreds

Finished sleeping refreshCreds Expires 2015-10-21 08:57:48 from 2015-10-21 07:57:55.251642 = 3592 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 08:57:55.332949 from 2015-10-21 07:57:55.411271 = 3599 Starting refreshCreds Expires 2015-10-21 08:57:55 from 2015-10-21 07:57:55.416642 = 3599 Starting refreshCreds About to return refreshCreds WARNING: Failed to UPLOAD_LOCAL on 2015_Sheldon_video VID_20150716_001543.mp4 identified as LOCAL_ONLY. This was due to [Errno 32] Broken pipe About to return refreshCreds UPLOAD_LOCAL (LOCAL_ONLY) #3597/15791 - 2015_Sheldon_video VID_20150715_191546.mp4 Finished sleeping refreshCreds Expires 2015-10-21 08:57:55 from 2015-10-21 07:57:55.434100 = 3599 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 08:57:55 from 2015-10-21 07:57:55.442320 = 3599 Starting refreshCredsAbout to return refreshCreds

Finished sleeping refreshCreds Expires 2015-10-21 08:57:55 from 2015-10-21 07:57:55.505004 = 3599 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 08:57:55 from 2015-10-21 07:57:55.519124 = 3599 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 08:57:55 from 2015-10-21 07:57:55.533287 = 3599 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 08:57:55 from 2015-10-21 07:57:55.549386 = 3599 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 08:57:55 from 2015-10-21 07:57:55.682074 = 3599 Starting refreshCreds About to return refreshCreds Finished sleeping refreshCreds Expires 2015-10-21 08:57:55 from 2015-10-21 07:57:55.735223 = 3599 Starting refreshCredsAbout to return refreshCreds

leocrawford commented 9 years ago

Thanks for taking a look. I don't think you have the latest copy of the code. If not would you be able to retest with latest version? Many thanks

andreasqueri commented 9 years ago

Ok. I just started a new try with the last source. Tomorrow I'll report you the results

leocrawford commented 9 years ago

Thanks so much.

On Wed, 21 Oct 2015 15:17 andreasqueri notifications@github.com wrote:

Ok. I just started a new try with the last source. Tomorrow I'll report you the results

— Reply to this email directly or view it on GitHub https://github.com/leocrawford/picasawebsync/issues/32#issuecomment-149910242 .

andreasqueri commented 9 years ago

still it does not work.. this is the output.. if you need new tests, I'm available:

SILENT (SAME) #3580/15791 - 2015_Sheldon_video VID_20150131_192514.mp4 SILENT (SAME) #3581/15791 - 2015_Sheldon_video VID_20150322_122410.mp4 UPLOAD_LOCAL (LOCAL_ONLY) #3582/15791 - 2015_Sheldon_video VID_20150809_132234.mp4 Trying UPLOAD_LOCAL on 2015_Sheldon_video VID_20150809_132234.mp4 identified as LOCAL_ONLY attempt 1 Trying UPLOAD_LOCAL on 2015_Sheldon_video VID_20150809_132234.mp4 identified as LOCAL_ONLY attempt 2 WARNING: Failed to UPLOAD_LOCAL on 2015_Sheldon_video VID_20150809_132234.mp4 identified as LOCAL_ONLY. This was due to (403, 'Forbidden', 'Token invalid - Invalid token: Stateless token expi red') SILENT (SAME) #3583/15791 - 2015_Sheldon_video VID_20150809_143635.mp4 UPLOAD_LOCAL (LOCAL_ONLY) #3584/15791 - 2015_Sheldon_video 20150911_150755.mp4 Trying UPLOAD_LOCAL on 2015_Sheldon_video 20150911_150755.mp4 identified as LOCAL_ONLY attempt 1 Trying UPLOAD_LOCAL on 2015_Sheldon_video 20150911_150755.mp4 identified as LOCAL_ONLY attempt 2 WARNING: Failed to UPLOAD_LOCAL on 2015_Sheldon_video 20150911_150755.mp4 identified as LOCAL_ONLY. This was due to (403, 'Forbidden', 'Token invalid - Invalid token: Stateless token expired' ) SILENT (SAME) #3585/15791 - 2015_Sheldon_video 20150510_092746.mp4 UPLOAD_LOCAL (LOCAL_ONLY) #3586/15791 - 2015_Sheldon_video VID_20150828_074736.mp4 Trying UPLOAD_LOCAL on 2015_Sheldon_video VID_20150828_074736.mp4 identified as LOCAL_ONLY attempt 1 Trying UPLOAD_LOCAL on 2015_Sheldon_video VID_20150828_074736.mp4 identified as LOCAL_ONLY attempt 2 WARNING: Failed to UPLOAD_LOCAL on 2015_Sheldon_video VID_20150828_074736.mp4 identified as LOCAL_ONLY. This was due to [Errno 32] Broken pipe SILENT (SAME) #3587/15791 - 2015_Sheldon_video VID_20150301_164225.mp4 UPLOAD_LOCAL (LOCAL_ONLY) #3588/15791 - 2015_Sheldon_video VID_20150824_074000.mp4 Trying UPLOAD_LOCAL on 2015_Sheldon_video VID_20150824_074000.mp4 identified as LOCAL_ONLY attempt 1 Trying UPLOAD_LOCAL on 2015_Sheldon_video VID_20150824_074000.mp4 identified as LOCAL_ONLY attempt 2 WARNING: Failed to UPLOAD_LOCAL on 2015_Sheldon_video VID_20150824_074000.mp4 identified as LOCAL_ONLY. This was due to (403, 'Forbidden', 'Token invalid - Invalid token: Stateless token expi red') SILENT (SAME) #3589/15791 - 2015_Sheldon_video VID_20150206_192751.mp4 UPLOAD_LOCAL (LOCAL_ONLY) #3590/15791 - 2015_Sheldon_video VID_20150816_123930.mp4 Trying UPLOAD_LOCAL on 2015_Sheldon_video VID_20150816_123930.mp4 identified as LOCAL_ONLY attempt 1 Trying UPLOAD_LOCAL on 2015_Sheldon_video VID_20150816_123930.mp4 identified as LOCAL_ONLY attempt 2 WARNING: Failed to UPLOAD_LOCAL on 2015_Sheldon_video VID_20150816_123930.mp4 identified as LOCAL_ONLY. This was due to [Errno 32] Broken pipe SILENT (SAME) #3591/15791 - 2015_Sheldon_video VID_20150131_192412.mp4 UPLOAD_LOCAL (LOCAL_ONLY) #3592/15791 - 2015_Sheldon_video 20150829_105924.mp4 Trying UPLOAD_LOCAL on 2015_Sheldon_video 20150829_105924.mp4 identified as LOCAL_ONLY attempt 1 Trying UPLOAD_LOCAL on 2015_Sheldon_video 20150829_105924.mp4 identified as LOCAL_ONLY attempt 2 WARNING: Failed to UPLOAD_LOCAL on 2015_Sheldon_video 20150829_105924.mp4 identified as LOCAL_ONLY. This was due to (403, 'Forbidden', 'Token invalid - Invalid token: Stateless token expired' ) SILENT (SAME) #3593/15791 - 2015_Sheldon_video VID_20150206_083512.mp4 SILENT (SAME) #3594/15791 - 2015_Sheldon_video VID_20141019_145328.mp4 UPLOAD_LOCAL (LOCAL_ONLY) #3595/15791 - 2015_Sheldon_video VID_20150704_071310.mp4 Trying UPLOAD_LOCAL on 2015_Sheldon_video VID_20150704_071310.mp4 identified as LOCAL_ONLY attempt 1 Trying UPLOAD_LOCAL on 2015_Sheldon_video VID_20150704_071310.mp4 identified as LOCAL_ONLY attempt 2 WARNING: Failed to UPLOAD_LOCAL on 2015_Sheldon_video VID_20150704_071310.mp4 identified as LOCAL_ONLY. This was due to (403, 'Forbidden', 'Token invalid - Invalid token: Stateless token expi red') UPLOAD_LOCAL (LOCAL_ONLY) #3596/15791 - 2015_Sheldon_video VID_20150716_001543.mp4 Trying UPLOAD_LOCAL on 2015_Sheldon_video VID_20150716_001543.mp4 identified as LOCAL_ONLY attempt 1 Trying UPLOAD_LOCAL on 2015_Sheldon_video VID_20150716_001543.mp4 identified as LOCAL_ONLY attempt 2 WARNING: Failed to UPLOAD_LOCAL on 2015_Sheldon_video VID_20150716_001543.mp4 identified as LOCAL_ONLY. This was due to [Errno 32] Broken pipe UPLOAD_LOCAL (LOCAL_ONLY) #3597/15791 - 2015_Sheldon_video VID_20150715_191546.mp4

leocrawford commented 9 years ago

hmm. Thanks for taking a look. I'm baffled. The second thread seems to be re-authenticating on schedule. I'll have a think and see if I can come up with another attempt.

leocrawford commented 9 years ago

I've made a small change which has allowed my setup to do a sizeable upload. Could you maybe test again? Cheers.

andreasqueri commented 9 years ago

I have start ti test it just now.. I'll report you the result

Il giorno sab 7 nov 2015 19:38 Leo Crawford notifications@github.com ha scritto:

I've made a small change which has allowed my setup to do a sizeable upload. Could you maybe test again? Cheers.

— Reply to this email directly or view it on GitHub https://github.com/leocrawford/picasawebsync/issues/32#issuecomment-154735386 .

andreasqueri commented 9 years ago

It still dosen't work.. This is the output:

UPLOAD_LOCAL (LOCAL_ONLY) #3582/15814 - 2015_Sheldon_video VID_20150809_132234.mp4 Trying UPLOAD_LOCAL on 2015_Sheldon_video VID_20150809_132234.mp4 identified as LOCAL_ONLY attempt 1 Trying UPLOAD_LOCAL on 2015_Sheldon_video VID_20150809_132234.mp4 identified as LOCAL_ONLY attempt 2 WARNING: Failed to UPLOAD_LOCAL on 2015_Sheldon_video VID_20150809_132234.mp4 identified as LOCAL_ONLY. This was due to (403, 'Forbidden', 'Token invalid - Invalid token: Stateless token expi red') SILENT (SAME) #3583/15814 - 2015_Sheldon_video VID_20150809_143635.mp4 UPLOAD_LOCAL (LOCAL_ONLY) #3584/15814 - 2015_Sheldon_video 20150911_150755.mp4 Trying UPLOAD_LOCAL on 2015_Sheldon_video 20150911_150755.mp4 identified as LOCAL_ONLY attempt 1 Trying UPLOAD_LOCAL on 2015_Sheldon_video 20150911_150755.mp4 identified as LOCAL_ONLY attempt 2 WARNING: Failed to UPLOAD_LOCAL on 2015_Sheldon_video 20150911_150755.mp4 identified as LOCAL_ONLY. This was due to (403, 'Forbidden', 'Token invalid - Invalid token: Stateless token expired' ) SILENT (SAME) #3585/15814 - 2015_Sheldon_video 20150510_092746.mp4 UPLOAD_LOCAL (LOCAL_ONLY) #3586/15814 - 2015_Sheldon_video VID_20150828_074736.mp4 Trying UPLOAD_LOCAL on 2015_Sheldon_video VID_20150828_074736.mp4 identified as LOCAL_ONLY attempt 1 Trying UPLOAD_LOCAL on 2015_Sheldon_video VID_20150828_074736.mp4 identified as LOCAL_ONLY attempt 2 WARNING: Failed to UPLOAD_LOCAL on 2015_Sheldon_video VID_20150828_074736.mp4 identified as LOCAL_ONLY. This was due to [Errno 32] Broken pipe SILENT (SAME) #3587/15814 - 2015_Sheldon_video VID_20150301_164225.mp4 UPLOAD_LOCAL (LOCAL_ONLY) #3588/15814 - 2015_Sheldon_video VID_20150824_074000.mp4 Trying UPLOAD_LOCAL on 2015_Sheldon_video VID_20150824_074000.mp4 identified as LOCAL_ONLY attempt 1 Trying UPLOAD_LOCAL on 2015_Sheldon_video VID_20150824_074000.mp4 identified as LOCAL_ONLY attempt 2 WARNING: Failed to UPLOAD_LOCAL on 2015_Sheldon_video VID_20150824_074000.mp4 identified as LOCAL_ONLY. This was due to (403, 'Forbidden', 'Token invalid - Invalid token: Stateless token expi red') SILENT (SAME) #3589/15814 - 2015_Sheldon_video VID_20150206_192751.mp4 UPLOAD_LOCAL (LOCAL_ONLY) #3590/15814 - 2015_Sheldon_video VID_20150816_123930.mp4 Trying UPLOAD_LOCAL on 2015_Sheldon_video VID_20150816_123930.mp4 identified as LOCAL_ONLY attempt 1 Trying UPLOAD_LOCAL on 2015_Sheldon_video VID_20150816_123930.mp4 identified as LOCAL_ONLY attempt 2 WARNING: Failed to UPLOAD_LOCAL on 2015_Sheldon_video VID_20150816_123930.mp4 identified as LOCAL_ONLY. This was due to [Errno 32] Broken pipe SILENT (SAME) #3591/15814 - 2015_Sheldon_video VID_20150131_192412.mp4 UPLOAD_LOCAL (LOCAL_ONLY) #3592/15814 - 2015_Sheldon_video 20150829_105924.mp4 Trying UPLOAD_LOCAL on 2015_Sheldon_video 20150829_105924.mp4 identified as LOCAL_ONLY attempt 1 Trying UPLOAD_LOCAL on 2015_Sheldon_video 20150829_105924.mp4 identified as LOCAL_ONLY attempt 2 WARNING: Failed to UPLOAD_LOCAL on 2015_Sheldon_video 20150829_105924.mp4 identified as LOCAL_ONLY. This was due to (403, 'Forbidden', 'Token invalid - Invalid token: Stateless token expired' ) SILENT (SAME) #3593/15814 - 2015_Sheldon_video VID_20150206_083512.mp4 SILENT (SAME) #3594/15814 - 2015_Sheldon_video VID_20141019_145328.mp4 UPLOAD_LOCAL (LOCAL_ONLY) #3595/15814 - 2015_Sheldon_video VID_20150704_071310.mp4 ^[ Trying UPLOAD_LOCAL on 2015_Sheldon_video VID_20150704_071310.mp4 identified as LOCAL_ONLY attempt 1 Trying UPLOAD_LOCAL on 2015_Sheldon_video VID_20150704_071310.mp4 identified as LOCAL_ONLY attempt 2 WARNING: Failed to UPLOAD_LOCAL on 2015_Sheldon_video VID_20150704_071310.mp4 identified as LOCAL_ONLY. This was due to (403, 'Forbidden', 'Token invalid - Invalid token: Stateless token expi red') UPLOAD_LOCAL (LOCAL_ONLY) #3596/15814 - 2015_Sheldon_video VID_20150716_001543.mp4 Trying UPLOAD_LOCAL on 2015_Sheldon_video VID_20150716_001543.mp4 identified as LOCAL_ONLY attempt 1 Trying UPLOAD_LOCAL on 2015_Sheldon_video VID_20150716_001543.mp4 identified as LOCAL_ONLY attempt 2 WARNING: Failed to UPLOAD_LOCAL on 2015_Sheldon_video VID_20150716_001543.mp4 identified as LOCAL_ONLY. This was due to [Errno 32] Broken pipe UPLOAD_LOCAL (LOCAL_ONLY) #3597/15814 - 2015_Sheldon_video VID_20150715_191546.mp4 Trying UPLOAD_LOCAL on 2015_Sheldon_video VID_20150715_191546.mp4 identified as LOCAL_ONLY attempt 1 Trying UPLOAD_LOCAL on 2015_Sheldon_video VID_20150715_191546.mp4 identified as LOCAL_ONLY attempt 2 WARNING: Failed to UPLOAD_LOCAL on 2015_Sheldon_video VID_20150715_191546.mp4 identified as LOCAL_ONLY. This was due to (403, 'Forbidden', 'Token invalid - Invalid token: Stateless token expi red') SILENT (SAME) #3598/15814 - 2015_Sheldon_video VID_20150124_121124.mp4 UPLOAD_LOCAL (LOCAL_ONLY) #3599/15814 - 2015_Sheldon_video VID_20150707_152151.mp4 Trying UPLOAD_LOCAL on 2015_Sheldon_video VID_20150707_152151.mp4 identified as LOCAL_ONLY attempt 1 Trying UPLOAD_LOCAL on 2015_Sheldon_video VID_20150707_152151.mp4 identified as LOCAL_ONLY attempt 2 WARNING: Failed to UPLOAD_LOCAL on 2015_Sheldon_video VID_20150707_152151.mp4 identified as LOCAL_ONLY. This was due to (403, 'Forbidden', 'Token invalid - Invalid token: Stateless token expi red') UPLOAD_LOCAL (LOCAL_ONLY) #3600/15814 - 2015_Sheldon_video VID_20150920_200016.mp4 Trying UPLOAD_LOCAL on 2015_Sheldon_video VID_20150920_200016.mp4 identified as LOCAL_ONLY attempt 1 WARNING: Failed to UPLOAD_LOCAL on 2015_Sheldon_video VID_20150920_200016.mp4 identified as LOCAL_ONLY. This was due to (403, 'Forbidden', 'Token invalid - Invalid token: Stateless t[15/1924] red') SILENT (SAME) #3601/15814 - 2015_Sheldon_video VID_20150601_145404.mp4 UPLOAD_LOCAL (LOCAL_ONLY) #3602/15814 - 2015_Sheldon_video VID-20150802-WA0003.mp4 Trying UPLOAD_LOCAL on 2015_Sheldon_video VID-20150802-WA0003.mp4 identified as LOCAL_ONLY attempt 1 Trying UPLOAD_LOCAL on 2015_Sheldon_video VID-20150802-WA0003.mp4 identified as LOCAL_ONLY attempt 2 WARNING: Failed to UPLOAD_LOCAL on 2015_Sheldon_video VID-20150802-WA0003.mp4 identified as LOCAL_ONLY. This was due to (403, 'Forbidden', 'Token invalid - Invalid token: Stateless token expi red') SILENT (SAME) #3603/15814 - 2015_Sheldon_video VID_20150131_192313.mp4 SILENT (SAME) #3604/15814 - 2015_Sheldon_video VID_20150208_125753.mp4 SILENT (SAME) #3605/15814 - 2015_Sheldon_video VID_20150301_164426.mp4 SILENT (SAME) #3606/15814 - 2015_Sheldon_video VID_20150430_144607.mp4 SILENT (SAME) #3607/15814 - 2015_Sheldon_video VID_20150319_192130.mp4 SILENT (SAME) #3608/15814 - 2015_Sheldon_video 20150403_232423.mp4 UPLOAD_LOCAL (LOCAL_ONLY) #3609/15814 - 2015_Sheldon_video 20151028_231647.mp4 Trying UPLOAD_LOCAL on 2015_Sheldon_video 20151028_231647.mp4 identified as LOCAL_ONLY attempt 1 Trying UPLOAD_LOCAL on 2015_Sheldon_video 20151028_231647.mp4 identified as LOCAL_ONLY attempt 2 WARNING: Failed to UPLOAD_LOCAL on 2015_Sheldon_video 20151028_231647.mp4 identified as LOCAL_ONLY. This was due to (403, 'Forbidden', 'Token invalid - Invalid token: Stateless token expired' ) UPLOAD_LOCAL (LOCAL_ONLY) #3610/15814 - 2015_Sheldon_video VID_20150716_070142.mp4 Trying UPLOAD_LOCAL on 2015_Sheldon_video VID_20150716_070142.mp4 identified as LOCAL_ONLY attempt 1 Trying UPLOAD_LOCAL on 2015_Sheldon_video VID_20150716_070142.mp4 identified as LOCAL_ONLY attempt 2 WARNING: Failed to UPLOAD_LOCAL on 2015_Sheldon_video VID_20150716_070142.mp4 identified as LOCAL_ONLY. This was due to (403, 'Forbidden', 'Token invalid - Invalid token: Stateless token expi red') SILENT (SAME) #3611/15814 - 2015_Sheldon_video VID_20150205_143644.mp4 SILENT (SAME) #3612/15814 - 2015_Sheldon_video VID_20150301_164528.mp4 UPLOAD_LOCAL (LOCAL_ONLY) #3613/15814 - 2015_Sheldon_video VID_20150322_122625.mp4 Trying UPLOAD_LOCAL on 2015_Sheldon_video VID_20150322_122625.mp4 identified as LOCAL_ONLY attempt 1 Trying UPLOAD_LOCAL on 2015_Sheldon_video VID_20150322_122625.mp4 identified as LOCAL_ONLY attempt 2 WARNING: Failed to UPLOAD_LOCAL on 2015_Sheldon_video VID_20150322_122625.mp4 identified as LOCAL_ONLY. This was due to (403, 'Forbidden', 'Token invalid - Invalid token: Stateless token expi red') SILENT (SAME) #3614/15814 - 2015_Sheldon_video VID_20150323_141452.mp4 UPLOAD_LOCAL (LOCAL_ONLY) #3615/15814 - 2015_Sheldon_video VID_20150920_200050.mp4 Trying UPLOAD_LOCAL on 2015_Sheldon_video VID_20150920_200050.mp4 identified as LOCAL_ONLY attempt 1 Trying UPLOAD_LOCAL on 2015_Sheldon_video VID_20150920_200050.mp4 identified as LOCAL_ONLY attempt 2 WARNING: Failed to UPLOAD_LOCAL on 2015_Sheldon_video VID_20150920_200050.mp4 identified as LOCAL_ONLY. This was due to (403, 'Forbidden', 'Token invalid - Invalid token: Stateless token expi red') UPLOAD_LOCAL (LOCAL_ONLY) #3616/15814 - 2015_Sheldon_video VID_20150619_071802.mp4 ^CTraceback (most recent call last): File "/home/andre/bin/picasawebsync.py", line 768, in albums.uploadMissingAlbumsAndFiles(args.compareattributes, mode, args.test, args.allowDelete) File "/home/andre/bin/picasawebsync.py", line 260, in uploadMissingAlbumsAndFiles "%s on %s identified as %s" % (mode[changed], file.getFullName(), changed), False) File "/home/andre/bin/picasawebsync.py", line 641, in repeat return function() File "/home/andre/bin/picasawebsync.py", line 259, in repeat(lambda: getattr(file, mode[changed].lower())(changed), File "/home/andre/bin/picasawebsync.py", line 497, in upload_local photo = self.upload_local_video(subAlbum) File "/home/andre/bin/picasawebsync.py", line 522, in upload_local_video photo = gd_client.InsertVideo(subAlbum.albumUri, metadata, self.path, self.type) File "/home/andre/bin/picasawebsync.py", line 134, in InsertVideo converter=None) File "/usr/lib/python2.7/site-packages/gdata/service.py", line 1236, in Post media_source=media_source, converter=converter) File "/usr/lib/python2.7/site-packages/gdata/service.py", line 1303, in PostOrPut multipart[2]], headers=extra_headers, url_params=url_params) File "/usr/lib/python2.7/site-packages/atom/init.py", line 93, in optional_warn_function return f(_args, *_kwargs) File "/usr/lib/python2.7/site-packages/atom/service.py", line 186, in request data=data, headers=all_headers) File "/usr/lib/python2.7/site-packages/atom/http_interface.py", line 148, in perform_request return http_client.request(operation, url, data=data, headers=headers) File "/usr/lib/python2.7/site-packages/atom/http.py", line 169, in request _send_data_part(data_part, connection) File "/usr/lib/python2.7/site-packages/atom/http.py", line 355, in _send_data_part connection.send(binarydata) File "/usr/lib/python2.7/httplib.py", line 869, in send self.sock.sendall(data) File "/usr/lib/python2.7/ssl.py", line 721, in sendall v = self.send(data[count:]) File "/usr/lib/python2.7/ssl.py", line 687, in send v = self._sslobj.write(data) KeyboardInterrupt [andre@cubox picasawebsync-master]$

ehrepli commented 9 years ago

Hey

I've tried with your latest version and a couple of changes, and tried to upload my whole picture collection again.

The changes are, I added a time print to the output, so i can check what happens. I added a print "Refresh creds now" in the refreshCreds() just to make sure it was happening, and I threw a gd_client=oauthLogin() after time.sleep(6).

Output is as follows:

11:04:33 Refreshing creds now
11:04:33  Excluding .*\.ini\Z(?ms)|.*\.db\Z(?ms)|.*\.ion\Z(?ms) on client and $. on server
11:04:33 Refreshing creds now
11:05:52 Found 571 albums on the filesystem
11:05:53 Scanning web-album Auto-Backup (containing 0 files)
11:05:54 Scanning web-album Nosotros-Nuevas-móvil ale 150915-20160622 (containing 1 files)
11:05:54 Scanning web-album Nosotros-Nuevas-móvil ale 150915-20160622 (containing 1 files)
[...]
11:08:50 UPLOAD_LOCAL (LOCAL_ONLY) #2436/23387 - Nosotros-Ale, Laura y Dani Clase CE1.jpg
11:11:47 Refreshing creds now
11:11:48 Trying UPLOAD_LOCAL on Nosotros-Ale, Laura y Dani Clase CE1.jpg identified as LOCAL_ONLY attempt 1
11:11:48 Refreshing creds now
11:15:59 Refreshing creds now
11:16:00 Trying UPLOAD_LOCAL on Nosotros-Ale, Laura y Dani Clase CE1.jpg identified as LOCAL_ONLY attempt 2
11:16:00 Refreshing creds now
11:19:36 Refreshing creds now
11:19:37 WARNING: Failed to UPLOAD_LOCAL on Nosotros-Ale, Laura y Dani Clase CE1.jpg identified as LOCAL_ONLY. This was due to (400, 'Bad Request', 'Image too large.')
11:19:37 Refreshing creds now
[...]
12:03:53 UPLOAD_LOCAL (LOCAL_ONLY) #3565/23387 - Nosotros-Ale, Laura y Dani-2012-Judo-Tercer torneo SaintHyppo DSCF5686.JPG
12:04:22 Refreshing creds now
12:04:48 Refreshing creds now
12:04:48 Trying UPLOAD_LOCAL on Nosotros-Ale, Laura y Dani-2012-Judo-Tercer torneo SaintHyppo DSCF5686.JPG identified as LOCAL_ONLY attempt 1
12:04:48 Refreshing creds now
12:06:02 Refreshing creds now
12:06:04 Trying UPLOAD_LOCAL on Nosotros-Ale, Laura y Dani-2012-Judo-Tercer torneo SaintHyppo DSCF5686.JPG identified as LOCAL_ONLY attempt 2
12:06:04 Refreshing creds now
[...]
12:17:23 Attempting to write date (1331671947000) to album Nosotros-Ale, Laura y Dani-2012-Judo-Tercer torneo SaintHyppo
Traceback (most recent call last):
  File "/usr/local/bin/picasawebsync.py", line 777, in <module>
    albums.uploadMissingAlbumsAndFiles(args.compareattributes, mode, args.test, args.allowDelete)
  File "/usr/local/bin/picasawebsync.py", line 271, in uploadMissingAlbumsAndFiles
    album.writeDate()
  File "/usr/local/bin/picasawebsync.py", line 307, in writeDate
    album = a.getEditObject()
  File "/usr/local/bin/picasawebsync.py", line 347, in getEditObject
    return gd_client.GetEntry(self.albumid)
  File "/usr/lib/python2.7/dist-packages/gdata/photos/service.py", line 207, in GetEntry
    raise GooglePhotosException(e.args[0])
gdata.photos.service.GooglePhotosException: (403, 'Forbidden', 'Token invalid - Invalid token: Stateless token expired')

So, basically, to summarize:

  1. Start the process..
  2. At some point it tries to upload a 16Mb image that fails with Image to large error message. However I can upload the image using picasa on windows, so i don't understand, maybe there is a smaller limit using the api?
  3. After one hour running it starts to fail with the 403 error, the refresh creds seems to run, but does not seem to work, and after some 13 minutes trying, it throws that error at the end and the script ends.

Not sure what to make of it, but I hope this can help you. I have not tried big files though.

ehrepli commented 9 years ago

I'm now running this every couple hours on my setup, I can confirm that the intial auth expires after exactly 1 hour, and that the attempts to renew it don't work. After starting to fail it seems to keep trying for a variable time, i've seen 10 minutes up to more than one hour, before it exits.

All this with pictures only, no large files.

ehrepli commented 9 years ago

So, I've been doing some digging today and I'm really confused. The thread you created for the token refresh is kicking off correctly at the specified intervals. However, although it actually uses the refresh token to get a new auth token, it still expires after the first hour (like if the new tokens were not used at all)

This is an extract of my log, where I added some extended output

Right after starting

15:24:33 Called refreshCred now with sleep 0 seconds
Your access token is: ya29.KwJKhgxXr3XaAcvcLzbk1l1RMGdUDN8jJ0njuQ5GnIw1WHfOLofTs2IIXb4GI8BA3Xuv
Your refresh token is: 1/EePSJyk_7cXYULk3pGuP-zbbXKJqSlbHQ8tPgFQ2S5Y
Token will expire in 3416 seconds from now
Next refreshCreds run in 3316 seconds

After around 50 minutes when the first refresh kicks in:

16:19:50 Running refresh
Your access token is: ya29.KwKIq29tx5Lr3HyWo7rKoqq2Pne-uVrpV_qUs3AdwZf7yJ1Z_xzQSU2cqCPEfT1O-_jY
Your refresh token is: 1/EePSJyk_7cXYULk3pGuP-zbbXKJqSlbHQ8tPgFQ2S5Y
Token will expire in 3599 seconds from now
Next refreshCreds run in 3499 seconds

After this, even if the auth token has been refreshed, the uploads keep failing, since the first token has expired. It goes on for some time, another refresh is triggered after a while:

17:18:10 Running refresh
Your access token is: ya29.KwJnGJRmwDGCqKBvh6zvw_iXs070Y_aSqDQLT3cmpCwMn4h0M4fdziw79IVpH0bkwyS-
Your refresh token is: 1/EePSJyk_7cXYULk3pGuP-zbbXKJqSlbHQ8tPgFQ2S5Y
Token will expire in 3599 seconds from now
Next refreshCreds run in 3499 seconds

So it looks like it refreshes the tokens correctlly, but the new one is never used.

leocrawford commented 9 years ago

Thanks so much for looking into this. You're a real credit to open source!

I'm afraid I'm only getting a few brief minutes to look at this. I suspect that the problem is that gd_client is being changed locally in the thread, but this is not updating the global variable.

I'm not too familiar with the python variable scope semantics, so found this useful:

http://stackoverflow.com/questions/423379/using-global-variables-in-a-function-other-than-the-one-that-created-them

My guess is that changing the gd_client as global would probably get it working. Would be awesome if you could give it a go and see.

I do still worry that single big uploads that exceed the refresh period will still fail, but at least we'll be closer.

ehrepli commented 9 years ago

That did the trick!!

I'm taking a look at the large uploads now, seems like requesting an offline token at the beginning should work, but not sure how to do it.

Also, my working version of the script is a total mess now after all the changes i've made, most of them not needed. I'll try to produce a clean version and will post it in a few days.

leocrawford commented 9 years ago

That's great news. I'll look forward to the clean version. Any ideas for the large uploads would be gratefully appreciated too! Cheers.

ehrepli commented 9 years ago

Reading about it, looks like the picasa API has a limitation of 100Mb for uploaded videos, which is unlikely to take more than one hour. I've been experimenting, and in fact this seems true, you can't upload bigger videos using the API. However, through the web or the picasa app, the limit seems to be 10Gb. This is another nonsense form google. I've also had errors when uploading a 16Mb picture, file too big. But at the moment I don't know if it's a size or resolution issue.

leocrawford commented 8 years ago

ehrepli - did you ever manage to produce a clear version for a commit?

ehrepli commented 8 years ago

Hi guys

Apologies for the delay, been crazy at work lately. I'll try to look at this in the next few days and submit the clean version.

leocrawford commented 8 years ago

thanks

On Wed, 6 Jan 2016 at 10:33 ehrepli notifications@github.com wrote:

Hi guys

Apologies for the delay, been crazy at work lately. I'll try to look at this in the next few days and submit the clean version.

— Reply to this email directly or view it on GitHub https://github.com/leocrawford/picasawebsync/issues/32#issuecomment-169291992 .

ehrepli commented 8 years ago

I've been comparing my working file with the original file and I believe the only thing required is to define gd_client as global. I've added it in line 661 after "from oauth2client.file import Storage" All the other edits I have done seem to be only to increase the verbosity so that I knew what was going on. Would be great if someone tried this and reported back. I don't have enough free time at the moment to test myself.