[Rellwood]

Hey, could you pretty please check out this bug report and see if you can identify why it takes so long to sync.


DEBUG: 15.4 sync_shelves - start
DEBUG: 18.4 HttpHelper::get_goodreads_books_on_shelves: user_name=Scarlett Rue
DEBUG: 18.4 HttpHelper::get_goodreads_books_on_shelves: shelf='currently-reading', page=1
DEBUG: 18.4 _oauth_request_get: url=https://www.goodreads.com/review/list.xml?v=2&shelf=currently-reading&page=1&per_page=200
DEBUG: 20.7 sync_shelves - returned from ChooseShelvesToSyncDialog
DEBUG: 20.7 sync_shelves - About to open DoShelfSyncDialog
DEBUG: 27.7 CalibreDbHelper::apply_actions_to_calibre - actions: [{u'action': u'ADD', u'value': u'Currently Reading', u'column': u'#exclusiveshelf'}, {u'action': u'ADD', u'value': u'date_added', u'column': u'#grdateadded'}, {u'action': u'ADD', u'value': u'Currently Reading', u'column': u'#readstatus'}, {u'action': u'ADD', u'value': u'date_updated', u'column': u'#gr_updateded'}, {u'action': u'ADD', u'value': u'1.Current', u'column': u'#calibrelibrary'}, {u'action': u'ADD', u'value': u'Y', u'column': u'#ingr'}, {u'action': u'REMOVE', u'value': u'Placeholder.Maybe', u'column': u'#book_style'}, {u'action': u'REMOVE', u'value': u'Placeholder.Pre-Ordered', u'column': u'#book_style'}, {u'action': u'REMOVE', u'value': u'Placeholder.Waiting for it', u'column': u'#book_style'}, {u'action': u'REMOVE', u'value': u'Placeholder.Want to Read', u'column': u'#book_style'}]
DEBUG: 28.0 sync_shelves - returned from DoShelfSyncDialog
DEBUG: 28.0 sync_shelves - About to _update_goodreads_ids
DEBUG: 41.3 sync_shelves - finished _update_goodreads_ids
DEBUG: 47.6 sync_shelves - start
DEBUG: 50.7 HttpHelper::get_goodreads_books_on_shelves: user_name=Scarlett Rue
DEBUG: 50.7 HttpHelper::get_goodreads_books_on_shelves: shelf='dnf', page=1
DEBUG: 50.7 _oauth_request_get: url=https://www.goodreads.com/review/list.xml?v=2&shelf=dnf&page=1&per_page=200
DEBUG: 61.9 _convert_review_xml_node_to_book: length of review_text= 181
DEBUG: 61.9 _convert_review_xml_node_to_book: length of review_text= 193
DEBUG: 61.9 _convert_review_xml_node_to_book: length of review_text= 300
DEBUG: 61.9 _convert_review_xml_node_to_book: length of review_text= 299
DEBUG: 61.9 _convert_review_xml_node_to_book: length of review_text= 299
DEBUG: 61.9 _convert_review_xml_node_to_book: length of review_text= 310
DEBUG: 61.9 _convert_review_xml_node_to_book: length of review_text= 300
DEBUG: 61.9 _convert_review_xml_node_to_book: length of review_text= 310
DEBUG: 61.9 _convert_review_xml_node_to_book: length of review_text= 299
DEBUG: 61.9 _convert_review_xml_node_to_book: length of review_text= 310
DEBUG: 61.9 _convert_review_xml_node_to_book: length of review_text= 230
DEBUG: 61.9 _convert_review_xml_node_to_book: length of review_text= 54
DEBUG: 61.9 _convert_review_xml_node_to_book: length of review_text= 310
DEBUG: 61.9 _convert_review_xml_node_to_book: length of review_text= 320
DEBUG: 61.9 _convert_review_xml_node_to_book: length of review_text= 320
DEBUG: 61.9 _convert_review_xml_node_to_book: length of review_text= 310
DEBUG: 61.9 _convert_review_xml_node_to_book: length of review_text= 260
DEBUG: 61.9 _convert_review_xml_node_to_book: length of review_text= 228
DEBUG: 61.9 _convert_review_xml_node_to_book: length of review_text= 154
DEBUG: 61.9 _convert_review_xml_node_to_book: length of review_text= 300
DEBUG: 61.9 _convert_review_xml_node_to_book: length of review_text= 319
DEBUG: 61.9 _convert_review_xml_node_to_book: length of review_text= 34
DEBUG: 61.9 _convert_review_xml_node_to_book: length of review_text= 300
DEBUG: 62.0 _convert_review_xml_node_to_book: length of review_text= 310
DEBUG: 62.0 _convert_review_xml_node_to_book: length of review_text= 160
DEBUG: 62.0 _convert_review_xml_node_to_book: length of review_text= 236
DEBUG: 62.0 _convert_review_xml_node_to_book: length of review_text= 315
DEBUG: 62.0 _convert_review_xml_node_to_book: length of review_text= 300
DEBUG: 62.0 sync_shelves - returned from ChooseShelvesToSyncDialog
DEBUG: 62.0 sync_shelves - About to open DoShelfSyncDialog
DEBUG: 64.6 CalibreDbHelper::apply_actions_to_calibre - actions: [{u'action': u'ADD', u'value': u'DNF', u'column': u'#exclusiveshelf'}, {u'action': u'ADD', u'value': u'date_updated', u'column': u'#gr_updateded'}, {u'action': u'ADD', u'value': u'date_added', u'column': u'#grdateadded'}, {u'action': u'ADD', u'value': u'Y', u'column': u'#ingr'}, {u'action': u'ADD', u'value': u'DNF', u'column': u'#readstatus'}, {u'action': u'ADD', u'value': u'1.Archived', u'column': u'#calibrelibrary'}, {u'action': u'ADD', u'value': u'none', u'column': u'#dr1'}, {u'action': u'ADD', u'value': u'none', u'column': u'#dr1'}, {u'action': u'ADD', u'value': u'none', u'column': u'#grdateread'}, {u'action': u'REMOVE', u'value': u'1.Current', u'column': u'#calibrelibrary'}, {u'action': u'REMOVE', u'value': u'1.Erotic', u'column': u'#calibrelibrary'}, {u'action': u'REMOVE', u'value': u'1.Erotica', u'column': u'#calibrelibrary'}, {u'action': u'REMOVE', u'value': u'1.Re-reads', u'column': u'#calibrelibrary'}, {u'action': u'REMOVE', u'value': u'1.Unread', u'column': u'#calibrelibrary'}, {u'action': u'REMOVE', u'value': u'1/aNext up tbr', u'column': u'#details'}, {u'action': u'REMOVE', u'value': u'Amazon.On Deck', u'column': u'#details'}, {u'action': u'REMOVE', u'value': u'in1221', u'column': u'#details'}]
DEBUG: 67.4 sync_shelves - returned from DoShelfSyncDialog
DEBUG: 67.4 sync_shelves - About to _update_goodreads_ids
DEBUG: 157.5 sync_shelves - finished _update_goodreads_ids

Actually, it is running a bit faster, but I am trying it on different shelves that either have a lot of reviews, or no review but both have no additional sync rules beyond updating two shelves. I will post the results