Register Guidelines E-Books Search Today's Posts Mark Forums Read

Go Back   MobileRead Forums > E-Book Software > Calibre > Devices

Notices

Reply
 
Thread Tools Search this Thread
Old 08-17-2012, 02:47 PM   #31
chaley
Grand Sorcerer
chaley ought to be getting tired of karma fortunes by now.chaley ought to be getting tired of karma fortunes by now.chaley ought to be getting tired of karma fortunes by now.chaley ought to be getting tired of karma fortunes by now.chaley ought to be getting tired of karma fortunes by now.chaley ought to be getting tired of karma fortunes by now.chaley ought to be getting tired of karma fortunes by now.chaley ought to be getting tired of karma fortunes by now.chaley ought to be getting tired of karma fortunes by now.chaley ought to be getting tired of karma fortunes by now.chaley ought to be getting tired of karma fortunes by now.
 
Posts: 11,713
Karma: 6690879
Join Date: Jan 2010
Location: Notts, England
Device: Kobo Libra 2
Quote:
Originally Posted by K8HW View Post
The error I am getting from Calibre is:
All we can determine from that error is that the calibre companion sent bogus information. We don't know more because CC didn't send it.

Looking more carefully at the sequence, it actually appears that CC is running out of memory while receiving a segment of the book. How much RAM does your nook have? Looking at specs, I see that 8GB tablets have 512mb of RAM and 16GB tablets have 1GB of RAM. Both of these numbers are small, which could be the root of the problem.

This weekend we are redoing how we manage memory. We are also looking at how we send books, with a goal of improving performance. While in the middle of it I will look for what might be using memory in this use case. It isn't obvious, but that doesn't mean much.

I have taken a lot of your time, and I thank you for your responses. If you have even more time, it would help if you ran calibre with the "Extra Debug Information" flag set. You set this flag by going to Preferences -> Plugins -> Device interface plugins -> Smartdevice app and checking the box. If you do this and get a debug log, could you post the entire log? There is information in the non-error messages that will help confirm or deny my current hypothesis. Do note that titles of books will be in the debug log, which you might consider private. If you don't want to post it, send it to me as a PM. Thanks in advance.
chaley is offline   Reply With Quote
Old 08-17-2012, 03:24 PM   #32
Uncle Ned
Member
Uncle Ned began at the beginning.
 
Posts: 18
Karma: 10
Join Date: Jun 2011
Device: Kobo Glo; Nexus 7
I am getting the exact same error string in Calibre as others are reporting. I downloaded the CC app last night and I updated Calibre itself to 0.8.64. I tried sending just one book at a time and only was only able to to get the cover transferred. My Calibre library is about 260 books.

I am running Mac 10.6 on a 2.4 wireless network. I am connecting to a Nexus 7 running Jelly Bean. Let me know of there's more data I can supply. I've got wireless syncing of music working flawlessly & would love to do books the same way.
Uncle Ned is offline   Reply With Quote
Old 08-17-2012, 03:40 PM   #33
chaley
Grand Sorcerer
chaley ought to be getting tired of karma fortunes by now.chaley ought to be getting tired of karma fortunes by now.chaley ought to be getting tired of karma fortunes by now.chaley ought to be getting tired of karma fortunes by now.chaley ought to be getting tired of karma fortunes by now.chaley ought to be getting tired of karma fortunes by now.chaley ought to be getting tired of karma fortunes by now.chaley ought to be getting tired of karma fortunes by now.chaley ought to be getting tired of karma fortunes by now.chaley ought to be getting tired of karma fortunes by now.chaley ought to be getting tired of karma fortunes by now.
 
Posts: 11,713
Karma: 6690879
Join Date: Jan 2010
Location: Notts, England
Device: Kobo Libra 2
Quote:
Originally Posted by Uncle Ned View Post
I am getting the exact same error string in Calibre as others are reporting. I downloaded the CC app last night and I updated Calibre itself to 0.8.64. I tried sending just one book at a time and only was only able to to get the cover transferred. My Calibre library is about 260 books.

I am running Mac 10.6 on a 2.4 wireless network. I am connecting to a Nexus 7 running Jelly Bean. Let me know of there's more data I can supply. I've got wireless syncing of music working flawlessly & would love to do books the same way.
The latest calibre is 0.8.65. MacOS users who also use calibre companion must upgrade calibre to work around a MacOS bug.
chaley is offline   Reply With Quote
Old 08-17-2012, 04:33 PM   #34
Uncle Ned
Member
Uncle Ned began at the beginning.
 
Posts: 18
Karma: 10
Join Date: Jun 2011
Device: Kobo Glo; Nexus 7
Quote:
Originally Posted by chaley View Post
The latest calibre is 0.8.65. MacOS users who also use calibre companion must upgrade calibre to work around a MacOS bug.
Ah ha. That did the trick. Wireless sync is now working fo me. Thanks for this app.
Uncle Ned is offline   Reply With Quote
Old 08-17-2012, 05:43 PM   #35
K8HW
Connoisseur
K8HW began at the beginning.
 
K8HW's Avatar
 
Posts: 90
Karma: 10
Join Date: Aug 2012
Location: Westland, MI
Device: Galaxy A03s, Galaxy Tab A, Kindle Paperwhite (10th Gen), Nexus 7
Quote:
Originally Posted by chaley View Post
All we can determine from that error is that the Calibre companion sent bogus information. We don't know more because CC didn't send it.

Looking more carefully at the sequence, it actually appears that CC is running out of memory while receiving a segment of the book. How much RAM does your nook have? Looking at specs, I see that 8GB tablets have 512mb of RAM and 16GB tablets have 1GB of RAM. Both of these numbers are small, which could be the root of the problem.

This weekend we are redoing how we manage memory. We are also looking at how we send books, with a goal of improving performance. While in the middle of it I will look for what might be using memory in this use case. It isn't obvious, but that doesn't mean much.

I have taken a lot of your time, and I thank you for your responses. If you have even more time, it would help if you ran Calibre with the "Extra Debug Information" flag set. You set this flag by going to Preferences -> Plugins -> Device interface plugins -> Smartdevice app and checking the box. If you do this and get a debug log, could you post the entire log? There is information in the non-error messages that will help confirm or deny my current hypothesis. Do note that titles of books will be in the debug log, which you might consider private. If you don't want to post it, send it to me as a PM. Thanks in advance.
Hello
I turned on the extra debugging. I then did a restart on Calibre. I was able to catch the error message on the nook as follows: The application Google Play Store (process com.android.vending) has stopped unexpectedly. Please try again.

The error from Calibre is:

Calibre, version 0.8.65
ERROR: Error: Error communicating with device

Device responded with incorrect information

Traceback (most recent call last):
File "site-packages\calibre\gui2\device.py", line 83, in run
File "site-packages\calibre\gui2\device.py", line 478, in _upload_books
File "site-packages\calibre\devices\smart_device_app\driver.p y", line 44, in _synchronizer
File "site-packages\calibre\devices\smart_device_app\driver.p y", line 799, in upload_books
File "site-packages\calibre\devices\smart_device_app\driver.p y", line 452, in _put_file
File "site-packages\calibre\devices\smart_device_app\driver.p y", line 425, in _call_client
ControlError: Device responded with incorrect information

Thank you for your patience!

Dave
K8HW is offline   Reply With Quote
Old 08-17-2012, 06:12 PM   #36
chaley
Grand Sorcerer
chaley ought to be getting tired of karma fortunes by now.chaley ought to be getting tired of karma fortunes by now.chaley ought to be getting tired of karma fortunes by now.chaley ought to be getting tired of karma fortunes by now.chaley ought to be getting tired of karma fortunes by now.chaley ought to be getting tired of karma fortunes by now.chaley ought to be getting tired of karma fortunes by now.chaley ought to be getting tired of karma fortunes by now.chaley ought to be getting tired of karma fortunes by now.chaley ought to be getting tired of karma fortunes by now.chaley ought to be getting tired of karma fortunes by now.
 
Posts: 11,713
Karma: 6690879
Join Date: Jan 2010
Location: Notts, England
Device: Kobo Libra 2
Quote:
Originally Posted by K8HW View Post
Hello
I turned on the extra debugging. I then did a restart on Calibre. I was able to catch the error message on the nook as follows: The application Google Play Store (process com.android.vending) has stopped unexpectedly. Please try again.

The error from Calibre is:

Calibre, version 0.8.65
ERROR: Error: Error communicating with device

Device responded with incorrect information
Thank you for the response, but it cannot be the entire log. For example, the log should begin with something like:
Quote:
SMART_DEV ( 0.04: 0.036) startup_on_demand try port 19636
SMART_DEV ( 0.92: 0.816) startup_on_demand listening on port 19636
Started up in 3.94 seconds with 2149 books
SMART_DEV ( 51.55: 50.617) reset
SMART_DEV ( 51.55: 0.000) set_progress_reporter
SMART_DEV ( 51.56: 0.000) open
SMART_DEV ( 51.61: 0.046) _call_client GET_INITIALIZATION_INFO {u'validExtensions': ['lrf', 'rar', 'zip', 'rtf', 'lit', 'txt', 'txtz', 'text', 'htm', 'xhtm', 'html', 'htmlz', 'xhtml', 'pdf', 'pdb', 'updb', 'pdr', 'prc', 'mobi', 'azw', 'doc', 'epub', 'fb2', 'djv', 'djvu', 'lrx', 'cbr', 'cbz', 'cbc', 'oebzip', 'rb', 'imp', 'odt', 'chm', 'tpz', 'azw1', 'pml', 'pmlz', 'mbp', 'tan', 'snb','xps', 'oxps', 'azw4', 'book', 'zbf', 'pobi', 'docx', 'md', 'textile', 'markdown', 'ibook', 'iba', 'azw3', 'ps'], u'currentLibrary
Name': u'library', u'currentLibraryUUID': u'3127fd4f-6e7e-4058-bdd0-7c911eac6456', u'serverProtocolVersion': 1, u'passwordChallenge': u''}
SMART_DEV ( 51.61: 0.000) _call_client send string [9, {"validExtensions": ["lrf", "rar", "zip", "rtf", "lit", "txt", "txtz", "text", "htm", "xhtm", "html", "htmlz", "xhtml", "pdf", "pdb", "updb", "pdr", "prc", "mobi", "azw", "doc", "epub", "fb2", "djv", "djvu", "lrx", "cbr", "cbz", "cbc", "oebzip", "rb", "imp", "odt", "chm", "tpz", "azw1", "pml", "pmlz", "mbp", "tan", "snb", "xps", "oxps", "azw4", "book", "zbf", "pobi", "docx", "md", "textile", "markdown", "ibook", "iba", "azw3", "ps"], "currentLibraryName": "library", "currentLibraryUUID": "3127fd4f-6e7e-4058-bdd0-7c911eac6456", "serverProtocolVersion": 1, "passwordChallenge": ""}]
SMART_DEV ( 52.17: 0.546) _call_client received string [0,{"ccVersionNumber":3,"acceptedExtensions":["epub","mobi"],"passwordHash":"","versionOK":true,"maxBookConten tPacketLen":204800}]
SMART_DEV ( 52.19: 0.000) _call_client receive after decode
SMART_DEV ( 52.19: 0.000) open CC version #: 3
SMART_DEV ( 52.22: 0.016) open selected formats [u'epub', u'mobi']
SMART_DEV ( 52.23: 0.000) card_prefix
and go on for some time about sending metadata and (possibly) books.

Are you not seeing information like the above at the beginning of the log?
chaley is offline   Reply With Quote
Old 08-17-2012, 07:04 PM   #37
GoghGirl
Member
GoghGirl began at the beginning.
 
Posts: 20
Karma: 10
Join Date: Nov 2011
Device: Nook Color Rooted
Hello! First of all, Thanks for giving us an app that can sync wirelessly! I dislike having to continually drag wires around everywhere. And I love having all of my tags listed and sortable. (Also love the sort by series function)

I am having problem with syncing.

My first attempt I synced one book which worked marvelously.

For my second attempt I synced 200 books. It froze and forced closed after 30 or so books. After this it would not connect to my library. At one point my device showed up in Calibre but did not show it was connected in the app. Attempting to sync ended up with a failed to connect message in calibre. Rebooting my nook fixed the connecting issue.

Third try, I selected 47 books to attempt to sync. It failed again. (It seems to have synced about 10 books before it failed)

Quote:
calibre, version 0.8.65
ERROR: Error: Error communicating with device

Device responded with incorrect information

Traceback (most recent call last):
File "site-packages\calibre\gui2\device.py", line 83, in run
File "site-packages\calibre\gui2\device.py", line 478, in _upload_books
File "site-packages\calibre\devices\smart_device_app\driver.p y", line 44, in _synchronizer
File "site-packages\calibre\devices\smart_device_app\driver.p y", line 799, in upload_books
File "site-packages\calibre\devices\smart_device_app\driver.p y", line 452, in _put_file
File "site-packages\calibre\devices\smart_device_app\driver.p y", line 425, in _call_client
ControlError: Device responded with incorrect information
This is the only log info that it provides. Is there somewhere else I go for the full log?
I used Advanced Task manager to check my available memory since you mentioned it. After killing all of my background apps it shows 171m. If I wait a few minutes some reopen automatically and causes it to go down to 160m.Ive been checking it during normal use and I just watched it go down to 129m.

I just attempted it with 10 books. Error. It synced 8 books before failing.

Quote:
calibre, version 0.8.65
ERROR: Error: Error communicating with device

Device responded with incorrect information
It just failed syncing 5 books.

~~~~~~~

After playing around with I have discovered I can only reliably sync 5 books at a time. After each sync I have to close the app, reopen and reconnect it to sync another set of 5. If I do not close after every set then it force closes either when it attempts to sync metadata or when I am attempting to add books.
~~~~
I started calibre in its error/safe mode. Its syncing almost perfectly. I've been getting very few error messages since.

My goal is to add about 950 books so Im willing to sync in smaller sections but not if I have to go reqeue books every 'n'th book.


My Requests!
I would like a function where I can mark a book as 'read'(by adding a tag?) so that I know I can take the book off of my nook. I see there are category options but I don't see how they work.


Thanks!

Last edited by GoghGirl; 08-18-2012 at 04:03 AM.
GoghGirl is offline   Reply With Quote
Old 08-18-2012, 04:26 AM   #38
chaley
Grand Sorcerer
chaley ought to be getting tired of karma fortunes by now.chaley ought to be getting tired of karma fortunes by now.chaley ought to be getting tired of karma fortunes by now.chaley ought to be getting tired of karma fortunes by now.chaley ought to be getting tired of karma fortunes by now.chaley ought to be getting tired of karma fortunes by now.chaley ought to be getting tired of karma fortunes by now.chaley ought to be getting tired of karma fortunes by now.chaley ought to be getting tired of karma fortunes by now.chaley ought to be getting tired of karma fortunes by now.chaley ought to be getting tired of karma fortunes by now.
 
Posts: 11,713
Karma: 6690879
Join Date: Jan 2010
Location: Notts, England
Device: Kobo Libra 2
Quote:
Originally Posted by GoghGirl View Post
This is the only log info that it provides. Is there somewhere else I go for the full log?
Yes. Take a look at FAQ answer number 3 on this thread. This gets you the complete calibre log.

It would be even more useful if you asked calibre to include more debug info in the log. Do this in calibre by going to preferences -> plugins -> device interface plugins -> Smartdevice app driver. Push the "customize plugin" button and check the "More debug information" box (spelled something like that).

It is worth noting that the advanced debug information can include detailed information about your books, such as title, author, and series. You might consider this to be a privacy concern. If so, then "private message" the log to me instead of posting it here.

Be sure to uncheck that box when you are done. Leaving it on makes calibre do a fair amount of extra work, which could slow it down.
Quote:
I used Advanced Task manager to check my available memory since you mentioned it. After killing all of my background apps it shows 171m. If I wait a few minutes some reopen automatically and causes it to go down to 160m.Ive been checking it during normal use and I just watched it go down to 129m.
That is interesting information. It says that you don't have a lot of memory. If I may ask, what kind of device is it?

We know we have some memory leaks and will fix those. While there we will look at why CC seems to be running out of memory while writing the book files. This isn't where I would expect it, but there is probably some kind of interplay with other windows via the progress dialog.
Quote:
I started calibre in its error/safe mode. Its syncing almost perfectly. I've been getting very few error messages since.
Oh dear, another timing problem. Sigh...
Quote:
I would like a function where I can mark a book as 'read'(by adding a tag?) so that I know I can take the book off of my nook. I see there are category options but I don't see how they work.
We could add a "star" or some such to CC. Unfortunately, there isn't any way for CC to pass information like this back to calibre, so you would need to look at the device to see what to remove. This is not at all ideal. I can see people deleting the wrong thing.

I am looking at ways to change calibre to permit CC to "talk" back to it. The first goal was to permit searching for books in calibre from CC, then asking calibre to "send" them. If I can make this work (and that isn't at all certain), then I could also consider sending new metadata back to calibre. We will see ...
chaley is offline   Reply With Quote
Old 08-18-2012, 05:22 AM   #39
amelith
Junior Member
amelith began at the beginning.
 
Posts: 1
Karma: 10
Join Date: Aug 2012
Device: prs-650
License Error - Multiple Accounts?

Hi,

I'm getting a licensing error on my tablet. I suspect this is because I have multiple accounts on there and the primary account is not the one that I used to buy the app. Is there anything you can do to make this situation work?

Thanks.
amelith is offline   Reply With Quote
Old 08-18-2012, 05:30 AM   #40
GoghGirl
Member
GoghGirl began at the beginning.
 
Posts: 20
Karma: 10
Join Date: Nov 2011
Device: Nook Color Rooted
Quote:
Yes. Take a look at FAQ answer number 3 on this thread. This gets you the complete calibre log.

It would be even more useful if you asked calibre to include more debug info in the log. Do this in calibre by going to preferences -> plugins -> device interface plugins -> Smartdevice app driver. Push the "customize plugin" button and check the "More debug information" box (spelled something like that).

It is worth noting that the advanced debug information can include detailed information about your books, such as title, author, and series. You might consider this to be a privacy concern. If so, then "private message" the log to me instead of posting it here.
I have turned on "Print extra debug information". I don't care as long as you don't make fun of all of my romancey series.

I attempted sycing 50 books. It made it to all the way to 39. It is still giving the same error message.

calibre, version 0.8.65
ERROR: Error: Error communicating with device

Device responded with incorrect information

Traceback (most recent call last):
File "site-packages\calibre\gui2\device.py", line 83, in run
File "site-packages\calibre\gui2\device.py", line 478, in _upload_books
File "site-packages\calibre\devices\smart_device_app\driver.p y", line 44, in _synchronizer
File "site-packages\calibre\devices\smart_device_app\driver.p y", line 799, in upload_books
File "site-packages\calibre\devices\smart_device_app\driver.p y", line 439, in _put_file
File "site-packages\calibre\devices\smart_device_app\driver.p y", line 425, in _call_client
ControlError: Device responded with incorrect information

I checked and I still have 'print' turned on.

Oh, the debug mode gives more information? The debug mode was working very well earlier even with a largish amount of books. Would it be helpful if I try syncing even large amounts of books to make even the debug mode give an error?

Quote:
That is interesting information. It says that you don't have a lot of memory. If I may ask, what kind of device is it?
A rooted Nook Color.

Quote:
We could add a "star" or some such to CC. Unfortunately, there isn't any way for CC to pass information like this back to calibre, so you would need to look at the device to see what to remove. This is not at all ideal. I can see people deleting the wrong thing.

I am looking at ways to change calibre to permit CC to "talk" back to it. The first goal was to permit searching for books in calibre from CC, then asking calibre to "send" them. If I can make this work (and that isn't at all certain), then I could also consider sending new metadata back to calibre. We will see ...
A star even if it doesn't send the information back might actually really help keep track of what I have read. Having it send the information back itself would be appreciated even more. I hope you accomplish it!
Another possibility could be a 'recently opened book list' which also shows the percentage of how of the book you have read. Right now I am using my reader app (FBReader) to keep track but it doesn't have a simple option 'read' either.

Oh. And I encountered another problem. I read about half of a book in calibre. When I sent the book to the app and opened it the first page showed 'chapter 19' and I could not go back to any previous chapter. In FBReader it opened onto chapter 19 but Moon+ wouldn't even open the book and complained of an I/O error. The book was fine when I went back to calibre.

Thanks again for the app! I for see it being much more convenient!

Last edited by GoghGirl; 08-18-2012 at 05:36 AM.
GoghGirl is offline   Reply With Quote
Old 08-18-2012, 05:36 AM   #41
DoctorOhh
US Navy, Retired
DoctorOhh ought to be getting tired of karma fortunes by now.DoctorOhh ought to be getting tired of karma fortunes by now.DoctorOhh ought to be getting tired of karma fortunes by now.DoctorOhh ought to be getting tired of karma fortunes by now.DoctorOhh ought to be getting tired of karma fortunes by now.DoctorOhh ought to be getting tired of karma fortunes by now.DoctorOhh ought to be getting tired of karma fortunes by now.DoctorOhh ought to be getting tired of karma fortunes by now.DoctorOhh ought to be getting tired of karma fortunes by now.DoctorOhh ought to be getting tired of karma fortunes by now.DoctorOhh ought to be getting tired of karma fortunes by now.
 
DoctorOhh's Avatar
 
Posts: 9,864
Karma: 13806776
Join Date: Feb 2009
Location: North Carolina
Device: Icarus Illumina XL HD, Nexus 7
Quote:
Originally Posted by GoghGirl View Post
A rooted Nook Color.
What version number of Android do you have on your device.

Last edited by DoctorOhh; 08-18-2012 at 06:08 AM. Reason: fixed sp
DoctorOhh is offline   Reply With Quote
Old 08-18-2012, 05:44 AM   #42
GoghGirl
Member
GoghGirl began at the beginning.
 
Posts: 20
Karma: 10
Join Date: Nov 2011
Device: Nook Color Rooted
Quote:
Originally Posted by dwanthny View Post
What version number of Android do you have on you device.
Android version 2.3.7
Mod CyanogenMod-7.1.0-encore
Mem info 115/480 (avail/total)
Kernal 2.6.32.9

I believe it is the most advanced version available for the Nook color.

I made debug crash! And I hadn't even been attempting it yet... >.<
-Opened debug calibre
- sent 2 books separately to nook
-I must have disconnected at this point?
-Connected. As it was finishing checking the metdata it crashed.
-Connected again. Attempted to delete 30 books I had added in the last post and then it crashed.
Here is the fun code. O.O
Spoiler:
calibre Debug log
calibre 0.8.65
Windows-7-6.1.7601-SP1
Windows
('Windows', '7', '6.1.7601')
Python 2.7.3
Windows: ('7', '6.1.7601', 'SP1', 'Multiprocessor Free')
Starting up...
SMART_DEV ( 0.00: 0.004) startup_on_demand try port 10135
SMART_DEV ( 1.15: 0.815) startup_on_demand listening on port 10135
Started up in 670.40 seconds with 2421 books
SMART_DEV ( 952.68:951.357) reset
SMART_DEV ( 952.76: 0.000) set_progress_reporter
SMART_DEV ( 952.85: 0.000) open
SMART_DEV ( 952.93: 0.008) _call_client GET_INITIALIZATION_INFO {u'validExtensions': ['lrf', 'rar', 'zip', 'rtf', 'lit', 'txt', 'txtz', 'text', 'htm', 'xhtm', 'html', 'htmlz', 'xhtml', 'pdf', 'pdb', 'updb', 'pdr', 'prc', 'mobi', 'azw', 'doc', 'epub', 'fb2', 'djv', 'djvu', 'lrx', 'cbr', 'cbz', 'cbc', 'oebzip', 'rb', 'imp', 'odt', 'chm', 'tpz', 'azw1', 'pml', 'pmlz', 'mbp', 'tan', 'snb', 'xps', 'oxps', 'azw4', 'book', 'zbf', 'pobi', 'docx', 'md', 'textile', 'markdown', 'ibook', 'iba', 'azw3', 'ps'], u'currentLibraryName': u'Calibre Library', u'currentLibraryUUID': u'7f7a8ee2-038e-40eb-a1c2-c5fac3831769', u'serverProtocolVersion': 1, u'passwordChallenge': u''}
SMART_DEV ( 953.02: 0.000) _call_client send string [9, {"validExtensions": ["lrf", "rar", "zip", "rtf", "lit", "txt", "txtz", "text", "htm", "xhtm", "html", "htmlz", "xhtml", "pdf", "pdb", "updb", "pdr", "prc", "mobi", "azw", "doc", "epub", "fb2", "djv", "djvu", "lrx", "cbr", "cbz", "cbc", "oebzip", "rb", "imp", "odt", "chm", "tpz", "azw1", "pml", "pmlz", "mbp", "tan", "snb", "xps", "oxps", "azw4", "book", "zbf", "pobi", "docx", "md", "textile", "markdown", "ibook", "iba", "azw3", "ps"], "currentLibraryName": "Calibre Library", "currentLibraryUUID": "7f7a8ee2-038e-40eb-a1c2-c5fac3831769", "serverProtocolVersion": 1, "passwordChallenge": ""}]
SMART_DEV ( 953.50: 0.394) _call_client received string [0,{"ccVersionNumber":6,"acceptedExtensions":["epub","mobi"],"passwordHash":"","versionOK":true,"maxBookConten tPacketLen":204800}]
SMART_DEV ( 953.58: 0.000) _call_client receive after decode
SMART_DEV ( 953.66: 0.000) open CC version #: 6
SMART_DEV ( 953.74: 0.008) open selected formats [u'epub', u'mobi']
SMART_DEV ( 953.82: 0.002) card_prefix
SMART_DEV ( 953.96: 0.032) set_progress_reporter
Job: 1 Get device information started
SMART_DEV ( 954.10: 0.001) get_device_information
SMART_DEV ( 954.31: 0.006) _call_client GET_DEVICE_INFORMATION {}
SMART_DEV ( 954.52: 0.000) _call_client send string [3, {}]
SMART_DEV ( 954.93: 0.325) _call_client received string [0,{"device_info":{"last_library_uuid":"7f7a8ee2-038e-40eb-a1c2-c5fac3831769","calibre_version":"0.8.65","device_n ame":"SmartDevice","date_last_connected":"2012-08-18T09:13:50.625000+00:00","device_store_uuid":"16e a48c9-e0ea-4f9a-95cf-67e4ec12e2f9","location_code":"main","prefix":""}, "version":"6","device_version":"10, encore"}]
SMART_DEV ( 955.01: 0.000) _call_client receive after decode
SMART_DEV ( 955.10: 0.005) _call_client SET_CALIBRE_DEVICE_INFO {u'device_store_uuid': u'16ea48c9-e0ea-4f9a-95cf-67e4ec12e2f9', u'location_code': u'main', u'device_name': u'SmartDevice', u'calibre_version': u'0.8.65', u'prefix': u'', u'last_library_uuid': u'7f7a8ee2-038e-40eb-a1c2-c5fac3831769', u'date_last_connected': u'2012-08-18T09:33:59.732000+00:00'}
SMART_DEV ( 955.18: 0.001) _call_client send string [1, {"device_store_uuid": "16ea48c9-e0ea-4f9a-95cf-67e4ec12e2f9", "location_code": "main", "device_name": "SmartDevice", "calibre_version": "0.8.65", "prefix": "", "last_library_uuid": "7f7a8ee2-038e-40eb-a1c2-c5fac3831769", "date_last_connected": "2012-08-18T09:33:59.732000+00:00"}]
SMART_DEV ( 955.65: 0.383) _call_client received string [0,{}]
SMART_DEV ( 955.73: 0.000) _call_client receive after decode
SMART_DEV ( 955.82: 0.000) card_prefix
SMART_DEV ( 955.89: 0.001) free_space
SMART_DEV ( 955.98: 0.004) _call_client FREE_SPACE {}
SMART_DEV ( 956.06: 0.000) _call_client send string [5, {}]
SMART_DEV ( 956.46: 0.320) _call_client received string [0,{"free_space_on_device":4641083392}]
SMART_DEV ( 956.56: 0.000) _call_client receive after decode
DeviceJob: 1 Get device information done, calling callback
DeviceJob: 1 Get device information callback returned
SMART_DEV ( 956.71: 0.063) set_progress_reporter
Job: 2 Get list of books on device started
SMART_DEV ( 956.78: 0.000) books None
SMART_DEV ( 956.85: 0.005) _call_client GET_BOOK_COUNT {}
SMART_DEV ( 956.94: 0.000) _call_client send string [6, {}]
Job: 1 Get device information finished
No details available.
SMART_DEV ( 974.79: 17.768) _call_client received string [0,{"count":312}]
SMART_DEV ( 974.88: 0.000) _call_client receive after decode
SMART_DEV ( 974.97: 0.006) _call_client GET_BOOK_METADATA {u'index': 0}
SMART_DEV ( 975.23: 0.172) _call_client GET_BOOK_METADATA {u'index': 1}
SMART_DEV ( 975.59: 0.269) _call_client GET_BOOK_METADATA {u'index': 2}
SMART_DEV ( 975.85: 0.168) _call_client GET_BOOK_METADATA {u'index': 3}
SMART_DEV ( 976.34: 0.408) _call_client GET_BOOK_METADATA {u'index': 4}
SMART_DEV ( 976.75: 0.196) _call_client GET_BOOK_METADATA {u'index': 5}
SMART_DEV ( 977.08: 0.253) _call_client GET_BOOK_METADATA {u'index': 6}
SMART_DEV ( 977.37: 0.204) _call_client GET_BOOK_METADATA {u'index': 7}
SMART_DEV ( 977.69: 0.235) _call_client GET_BOOK_METADATA {u'index': 8}
SMART_DEV ( 977.98: 0.199) _call_client GET_BOOK_METADATA {u'index': 9}
SMART_DEV ( 978.30: 0.227) _call_client GET_BOOK_METADATA {u'index': 10}
SMART_DEV ( 978.64: 0.258) _call_client GET_BOOK_METADATA {u'index': 11}
SMART_DEV ( 979.06: 0.335) _call_client GET_BOOK_METADATA {u'index': 12}
SMART_DEV ( 979.31: 0.163) _call_client GET_BOOK_METADATA {u'index': 13}
SMART_DEV ( 979.60: 0.214) _call_client GET_BOOK_METADATA {u'index': 14}
SMART_DEV ( 980.04: 0.190) _call_client GET_BOOK_METADATA {u'index': 15}
SMART_DEV ( 980.36: 0.233) _call_client GET_BOOK_METADATA {u'index': 16}
SMART_DEV ( 980.65: 0.207) _call_client GET_BOOK_METADATA {u'index': 17}
SMART_DEV ( 981.13: 0.401) _call_client GET_BOOK_METADATA {u'index': 18}
SMART_DEV ( 981.36: 0.131) _call_client GET_BOOK_METADATA {u'index': 19}
SMART_DEV ( 981.57: 0.126) _call_client GET_BOOK_METADATA {u'index': 20}
SMART_DEV ( 981.87: 0.195) _call_client GET_BOOK_METADATA {u'index': 21}
SMART_DEV ( 982.08: 0.123) _call_client GET_BOOK_METADATA {u'index': 22}
SMART_DEV ( 982.71: 0.352) _call_client GET_BOOK_METADATA {u'index': 23}
SMART_DEV ( 983.00: 0.188) _call_client GET_BOOK_METADATA {u'index': 24}
SMART_DEV ( 983.35: 0.251) _call_client GET_BOOK_METADATA {u'index': 25}
SMART_DEV ( 983.63: 0.198) _call_client GET_BOOK_METADATA {u'index': 26}
SMART_DEV ( 983.98: 0.267) _call_client GET_BOOK_METADATA {u'index': 27}
SMART_DEV ( 984.24: 0.162) _call_client GET_BOOK_METADATA {u'index': 28}
SMART_DEV ( 984.59: 0.255) _call_client GET_BOOK_METADATA {u'index': 29}
SMART_DEV ( 984.86: 0.187) _call_client GET_BOOK_METADATA {u'index': 30}
SMART_DEV ( 985.15: 0.178) _call_client GET_BOOK_METADATA {u'index': 31}
SMART_DEV ( 985.46: 0.214) _call_client GET_BOOK_METADATA {u'index': 32}
SMART_DEV ( 985.77: 0.207) _call_client GET_BOOK_METADATA {u'index': 33}
SMART_DEV ( 986.15: 0.281) _call_client GET_BOOK_METADATA {u'index': 34}
SMART_DEV ( 986.38: 0.152) _call_client GET_BOOK_METADATA {u'index': 35}
SMART_DEV ( 986.74: 0.263) _call_client GET_BOOK_METADATA {u'index': 36}
SMART_DEV ( 987.01: 0.192) _call_client GET_BOOK_METADATA {u'index': 37}
SMART_DEV ( 987.30: 0.200) _call_client GET_BOOK_METADATA {u'index': 38}
SMART_DEV ( 987.60: 0.212) _call_client GET_BOOK_METADATA {u'index': 39}
SMART_DEV ( 987.86: 0.170) _call_client GET_BOOK_METADATA {u'index': 40}
SMART_DEV ( 988.12: 0.177) _call_client GET_BOOK_METADATA {u'index': 41}
SMART_DEV ( 988.48: 0.270) _call_client GET_BOOK_METADATA {u'index': 42}
SMART_DEV ( 988.73: 0.163) _call_client GET_BOOK_METADATA {u'index': 43}
SMART_DEV ( 989.04: 0.230) _call_client GET_BOOK_METADATA {u'index': 44}
SMART_DEV ( 989.36: 0.227) _call_client GET_BOOK_METADATA {u'index': 45}
SMART_DEV ( 989.77: 0.324) _call_client GET_BOOK_METADATA {u'index': 46}
SMART_DEV ( 990.07: 0.218) _call_client GET_BOOK_METADATA {u'index': 47}
SMART_DEV ( 990.51: 0.356) _call_client GET_BOOK_METADATA {u'index': 48}
SMART_DEV ( 990.78: 0.178) _call_client GET_BOOK_METADATA {u'index': 49}
SMART_DEV ( 990.99: 0.127) _call_client GET_BOOK_METADATA {u'index': 50}
SMART_DEV ( 991.29: 0.224) _call_client GET_BOOK_METADATA {u'index': 51}
SMART_DEV ( 991.80: 0.428) _call_client GET_BOOK_METADATA {u'index': 52}
SMART_DEV ( 992.00: 0.117) _call_client GET_BOOK_METADATA {u'index': 53}
SMART_DEV ( 992.22: 0.132) _call_client GET_BOOK_METADATA {u'index': 54}
SMART_DEV ( 992.52: 0.218) _call_client GET_BOOK_METADATA {u'index': 55}
SMART_DEV ( 992.82: 0.213) _call_client GET_BOOK_METADATA {u'index': 56}
SMART_DEV ( 993.05: 0.145) _call_client GET_BOOK_METADATA {u'index': 57}
SMART_DEV ( 993.35: 0.215) _call_client GET_BOOK_METADATA {u'index': 58}
SMART_DEV ( 993.65: 0.215) _call_client GET_BOOK_METADATA {u'index': 59}
SMART_DEV ( 993.96: 0.225) _call_client GET_BOOK_METADATA {u'index': 60}
SMART_DEV ( 994.28: 0.236) _call_client GET_BOOK_METADATA {u'index': 61}
SMART_DEV ( 994.58: 0.221) _call_client GET_BOOK_METADATA {u'index': 62}
SMART_DEV ( 994.93: 0.263) _call_client GET_BOOK_METADATA {u'index': 63}
SMART_DEV ( 995.18: 0.170) _call_client GET_BOOK_METADATA {u'index': 64}
SMART_DEV ( 995.38: 0.116) _call_client GET_BOOK_METADATA {u'index': 65}
SMART_DEV ( 995.59: 0.120) _call_client GET_BOOK_METADATA {u'index': 66}
SMART_DEV ( 995.80: 0.125) _call_client GET_BOOK_METADATA {u'index': 67}
SMART_DEV ( 996.09: 0.208) _call_client GET_BOOK_METADATA {u'index': 68}
SMART_DEV ( 996.31: 0.139) _call_client GET_BOOK_METADATA {u'index': 69}
SMART_DEV ( 996.64: 0.240) _call_client GET_BOOK_METADATA {u'index': 70}
SMART_DEV ( 996.92: 0.198) _call_client GET_BOOK_METADATA {u'index': 71}
SMART_DEV ( 997.23: 0.221) _call_client GET_BOOK_METADATA {u'index': 72}
SMART_DEV ( 997.54: 0.221) _call_client GET_BOOK_METADATA {u'index': 73}
SMART_DEV ( 997.85: 0.223) _call_client GET_BOOK_METADATA {u'index': 74}
SMART_DEV ( 998.04: 0.113) _call_client GET_BOOK_METADATA {u'index': 75}
SMART_DEV ( 998.27: 0.143) _call_client GET_BOOK_METADATA {u'index': 76}
SMART_DEV ( 998.65: 0.299) _call_client GET_BOOK_METADATA {u'index': 77}
SMART_DEV ( 998.85: 0.119) _call_client GET_BOOK_METADATA {u'index': 78}
SMART_DEV ( 999.07: 0.136) _call_client GET_BOOK_METADATA {u'index': 79}
SMART_DEV ( 999.41: 0.236) _call_client GET_BOOK_METADATA {u'index': 80}
SMART_DEV ( 999.68: 0.186) _call_client GET_BOOK_METADATA {u'index': 81}
SMART_DEV ( 999.90: 0.136) _call_client GET_BOOK_METADATA {u'index': 82}
SMART_DEV (1000.20: 0.213) _call_client GET_BOOK_METADATA {u'index': 83}
SMART_DEV (1000.44: 0.152) _call_client GET_BOOK_METADATA {u'index': 84}
SMART_DEV (1000.81: 0.286) _call_client GET_BOOK_METADATA {u'index': 85}
SMART_DEV (1001.05: 0.159) _call_client GET_BOOK_METADATA {u'index': 86}
SMART_DEV (1001.32: 0.188) _call_client GET_BOOK_METADATA {u'index': 87}
SMART_DEV (1001.57: 0.163) _call_client GET_BOOK_METADATA {u'index': 88}
SMART_DEV (1001.84: 0.177) _call_client GET_BOOK_METADATA {u'index': 89}
SMART_DEV (1002.08: 0.157) _call_client GET_BOOK_METADATA {u'index': 90}
SMART_DEV (1002.36: 0.193) _call_client GET_BOOK_METADATA {u'index': 91}
SMART_DEV (1002.72: 0.279) _call_client GET_BOOK_METADATA {u'index': 92}
SMART_DEV (1002.96: 0.151) _call_client GET_BOOK_METADATA {u'index': 93}
SMART_DEV (1003.28: 0.226) _call_client GET_BOOK_METADATA {u'index': 94}
SMART_DEV (1003.59: 0.224) _call_client GET_BOOK_METADATA {u'index': 95}
SMART_DEV (1003.89: 0.221) _call_client GET_BOOK_METADATA {u'index': 96}
SMART_DEV (1004.19: 0.213) _call_client GET_BOOK_METADATA {u'index': 97}
SMART_DEV (1004.58: 0.301) _call_client GET_BOOK_METADATA {u'index': 98}
SMART_DEV (1004.90: 0.242) _call_client GET_BOOK_METADATA {u'index': 99}
SMART_DEV (1005.17: 0.183) _call_client GET_BOOK_METADATA {u'index': 100}
SMART_DEV (1005.49: 0.227) _call_client GET_BOOK_METADATA {u'index': 101}
SMART_DEV (1005.79: 0.198) _call_client GET_BOOK_METADATA {u'index': 102}
SMART_DEV (1006.28: 0.405) _call_client GET_BOOK_METADATA {u'index': 103}
SMART_DEV (1006.60: 0.231) _call_client GET_BOOK_METADATA {u'index': 104}
SMART_DEV (1006.91: 0.229) _call_client GET_BOOK_METADATA {u'index': 105}
SMART_DEV (1007.27: 0.271) _call_client GET_BOOK_METADATA {u'index': 106}
SMART_DEV (1007.78: 0.427) _call_client GET_BOOK_METADATA {u'index': 107}
SMART_DEV (1008.19: 0.316) _call_client GET_BOOK_METADATA {u'index': 108}
SMART_DEV (1008.69: 0.419) _call_client GET_BOOK_METADATA {u'index': 109}
SMART_DEV (1008.96: 0.185) _call_client GET_BOOK_METADATA {u'index': 110}
SMART_DEV (1009.35: 0.293) _call_client GET_BOOK_METADATA {u'index': 111}
SMART_DEV (1009.73: 0.295) _call_client GET_BOOK_METADATA {u'index': 112}
SMART_DEV (1010.13: 0.322) _call_client GET_BOOK_METADATA {u'index': 113}
SMART_DEV (1010.55: 0.310) _call_client GET_BOOK_METADATA {u'index': 114}
SMART_DEV (1011.09: 0.435) _call_client GET_BOOK_METADATA {u'index': 115}
SMART_DEV (1011.48: 0.309) _call_client GET_BOOK_METADATA {u'index': 116}
SMART_DEV (1011.83: 0.244) _call_client GET_BOOK_METADATA {u'index': 117}
SMART_DEV (1012.14: 0.224) _call_client GET_BOOK_METADATA {u'index': 118}
SMART_DEV (1012.44: 0.225) _call_client GET_BOOK_METADATA {u'index': 119}
SMART_DEV (1012.80: 0.264) _call_client GET_BOOK_METADATA {u'index': 120}
SMART_DEV (1013.23: 0.354) _call_client GET_BOOK_METADATA {u'index': 121}
SMART_DEV (1013.52: 0.183) _call_client GET_BOOK_METADATA {u'index': 122}
SMART_DEV (1013.88: 0.260) _call_client GET_BOOK_METADATA {u'index': 123}
SMART_DEV (1014.34: 0.348) _call_client GET_BOOK_METADATA {u'index': 124}
SMART_DEV (1014.72: 0.303) _call_client GET_BOOK_METADATA {u'index': 125}
SMART_DEV (1015.01: 0.198) _call_client GET_BOOK_METADATA {u'index': 126}
SMART_DEV (1015.35: 0.258) _call_client GET_BOOK_METADATA {u'index': 127}
SMART_DEV (1015.62: 0.183) _call_client GET_BOOK_METADATA {u'index': 128}
SMART_DEV (1016.11: 0.402) _call_client GET_BOOK_METADATA {u'index': 129}
SMART_DEV (1016.48: 0.298) _call_client GET_BOOK_METADATA {u'index': 130}
SMART_DEV (1016.85: 0.261) _call_client GET_BOOK_METADATA {u'index': 131}
SMART_DEV (1017.16: 0.228) _call_client GET_BOOK_METADATA {u'index': 132}
SMART_DEV (1017.51: 0.264) _call_client GET_BOOK_METADATA {u'index': 133}
SMART_DEV (1018.00: 0.410) _call_client GET_BOOK_METADATA {u'index': 134}
SMART_DEV (1018.29: 0.208) _call_client GET_BOOK_METADATA {u'index': 135}
SMART_DEV (1018.66: 0.281) _call_client GET_BOOK_METADATA {u'index': 136}
SMART_DEV (1019.00: 0.255) _call_client GET_BOOK_METADATA {u'index': 137}
SMART_DEV (1019.36: 0.276) _call_client GET_BOOK_METADATA {u'index': 138}
SMART_DEV (1019.75: 0.307) _call_client GET_BOOK_METADATA {u'index': 139}
SMART_DEV (1020.02: 0.190) _call_client GET_BOOK_METADATA {u'index': 140}
SMART_DEV (1020.38: 0.270) _call_client GET_BOOK_METADATA {u'index': 141}
SMART_DEV (1020.74: 0.280) _call_client GET_BOOK_METADATA {u'index': 142}
SMART_DEV (1021.04: 0.219) _call_client GET_BOOK_METADATA {u'index': 143}
SMART_DEV (1021.36: 0.233) _call_client GET_BOOK_METADATA {u'index': 144}
SMART_DEV (1021.71: 0.263) _call_client GET_BOOK_METADATA {u'index': 145}
SMART_DEV (1022.12: 0.327) _call_client GET_BOOK_METADATA {u'index': 146}
SMART_DEV (1022.63: 0.429) _call_client GET_BOOK_METADATA {u'index': 147}
SMART_DEV (1023.01: 0.294) _call_client GET_BOOK_METADATA {u'index': 148}
SMART_DEV (1023.30: 0.198) _call_client GET_BOOK_METADATA {u'index': 149}
SMART_DEV (1023.66: 0.271) _call_client GET_BOOK_METADATA {u'index': 150}
SMART_DEV (1024.02: 0.276) _call_client GET_BOOK_METADATA {u'index': 151}
SMART_DEV (1024.37: 0.262) _call_client GET_BOOK_METADATA {u'index': 152}
SMART_DEV (1024.77: 0.324) _call_client GET_BOOK_METADATA {u'index': 153}
SMART_DEV (1025.07: 0.213) _call_client GET_BOOK_METADATA {u'index': 154}
SMART_DEV (1025.48: 0.320) _call_client GET_BOOK_METADATA {u'index': 155}
SMART_DEV (1025.81: 0.240) _call_client GET_BOOK_METADATA {u'index': 156}
SMART_DEV (1026.16: 0.277) _call_client GET_BOOK_METADATA {u'index': 157}
SMART_DEV (1026.52: 0.271) _call_client GET_BOOK_METADATA {u'index': 158}
SMART_DEV (1026.89: 0.271) _call_client GET_BOOK_METADATA {u'index': 159}
SMART_DEV (1027.19: 0.207) _call_client GET_BOOK_METADATA {u'index': 160}
SMART_DEV (1027.64: 0.366) _call_client GET_BOOK_METADATA {u'index': 161}
SMART_DEV (1028.19: 0.454) _call_client GET_BOOK_METADATA {u'index': 162}
SMART_DEV (1028.51: 0.238) _call_client GET_BOOK_METADATA {u'index': 163}
SMART_DEV (1028.88: 0.270) _call_client GET_BOOK_METADATA {u'index': 164}
SMART_DEV (1029.34: 0.380) _call_client GET_BOOK_METADATA {u'index': 165}
SMART_DEV (1029.66: 0.229) _call_client GET_BOOK_METADATA {u'index': 166}
SMART_DEV (1029.98: 0.234) _call_client GET_BOOK_METADATA {u'index': 167}
SMART_DEV (1030.32: 0.249) _call_client GET_BOOK_METADATA {u'index': 168}
SMART_DEV (1030.68: 0.280) _call_client GET_BOOK_METADATA {u'index': 169}
SMART_DEV (1031.02: 0.251) _call_client GET_BOOK_METADATA {u'index': 170}
SMART_DEV (1031.45: 0.348) _call_client GET_BOOK_METADATA {u'index': 171}
SMART_DEV (1031.80: 0.224) _call_client GET_BOOK_METADATA {u'index': 172}
SMART_DEV (1032.11: 0.225) _call_client GET_BOOK_METADATA {u'index': 173}
SMART_DEV (1032.44: 0.246) _call_client GET_BOOK_METADATA {u'index': 174}
SMART_DEV (1032.81: 0.278) _call_client GET_BOOK_METADATA {u'index': 175}
SMART_DEV (1033.16: 0.266) _call_client GET_BOOK_METADATA {u'index': 176}
SMART_DEV (1033.43: 0.183) _call_client GET_BOOK_METADATA {u'index': 177}
SMART_DEV (1033.91: 0.388) _call_client GET_BOOK_METADATA {u'index': 178}
SMART_DEV (1034.32: 0.278) _call_client GET_BOOK_METADATA {u'index': 179}
SMART_DEV (1034.71: 0.293) _call_client GET_BOOK_METADATA {u'index': 180}
SMART_DEV (1035.09: 0.265) _call_client GET_BOOK_METADATA {u'index': 181}
SMART_DEV (1035.48: 0.303) _call_client GET_BOOK_METADATA {u'index': 182}
SMART_DEV (1035.94: 0.362) _call_client GET_BOOK_METADATA {u'index': 183}
SMART_DEV (1036.31: 0.210) _call_client GET_BOOK_METADATA {u'index': 184}
SMART_DEV (1036.61: 0.201) _call_client GET_BOOK_METADATA {u'index': 185}
SMART_DEV (1036.96: 0.261) _call_client GET_BOOK_METADATA {u'index': 186}
SMART_DEV (1037.41: 0.361) _call_client GET_BOOK_METADATA {u'index': 187}
SMART_DEV (1037.85: 0.353) _call_client GET_BOOK_METADATA {u'index': 188}
SMART_DEV (1038.15: 0.199) _call_client GET_BOOK_METADATA {u'index': 189}
SMART_DEV (1038.46: 0.218) _call_client GET_BOOK_METADATA {u'index': 190}
SMART_DEV (1038.80: 0.257) _call_client GET_BOOK_METADATA {u'index': 191}
SMART_DEV (1039.26: 0.373) _call_client GET_BOOK_METADATA {u'index': 192}
SMART_DEV (1039.58: 0.225) _call_client GET_BOOK_METADATA {u'index': 193}
SMART_DEV (1039.92: 0.243) _call_client GET_BOOK_METADATA {u'index': 194}
SMART_DEV (1040.24: 0.242) _call_client GET_BOOK_METADATA {u'index': 195}
SMART_DEV (1040.65: 0.261) _call_client GET_BOOK_METADATA {u'index': 196}
SMART_DEV (1041.01: 0.233) _call_client GET_BOOK_METADATA {u'index': 197}
SMART_DEV (1041.43: 0.266) _call_client GET_BOOK_METADATA {u'index': 198}
SMART_DEV (1041.72: 0.205) _call_client GET_BOOK_METADATA {u'index': 199}
SMART_DEV (1042.03: 0.217) _call_client GET_BOOK_METADATA {u'index': 200}
SMART_DEV (1042.42: 0.301) _call_client GET_BOOK_METADATA {u'index': 201}
SMART_DEV (1042.75: 0.238) _call_client GET_BOOK_METADATA {u'index': 202}
SMART_DEV (1043.11: 0.273) _call_client GET_BOOK_METADATA {u'index': 203}
SMART_DEV (1043.56: 0.363) _call_client GET_BOOK_METADATA {u'index': 204}
SMART_DEV (1043.88: 0.185) _call_client GET_BOOK_METADATA {u'index': 205}
SMART_DEV (1044.23: 0.246) _call_client GET_BOOK_METADATA {u'index': 206}
SMART_DEV (1044.64: 0.319) _call_client GET_BOOK_METADATA {u'index': 207}
SMART_DEV (1044.92: 0.198) _call_client GET_BOOK_METADATA {u'index': 208}
SMART_DEV (1045.25: 0.244) _call_client GET_BOOK_METADATA {u'index': 209}
SMART_DEV (1045.65: 0.315) _call_client GET_BOOK_METADATA {u'index': 210}
SMART_DEV (1046.04: 0.291) _call_client GET_BOOK_METADATA {u'index': 211}
SMART_DEV (1046.39: 0.257) _call_client GET_BOOK_METADATA {u'index': 212}
SMART_DEV (1046.65: 0.177) _call_client GET_BOOK_METADATA {u'index': 213}
SMART_DEV (1046.95: 0.200) _call_client GET_BOOK_METADATA {u'index': 214}
SMART_DEV (1047.44: 0.407) _call_client GET_BOOK_METADATA {u'index': 215}
SMART_DEV (1047.77: 0.238) _call_client GET_BOOK_METADATA {u'index': 216}
SMART_DEV (1048.12: 0.253) _call_client GET_BOOK_METADATA {u'index': 217}
SMART_DEV (1048.63: 0.415) _call_client GET_BOOK_METADATA {u'index': 218}
SMART_DEV (1049.08: 0.362) _call_client GET_BOOK_METADATA {u'index': 219}
SMART_DEV (1049.41: 0.237) _call_client GET_BOOK_METADATA {u'index': 220}
SMART_DEV (1049.71: 0.220) _call_client GET_BOOK_METADATA {u'index': 221}
SMART_DEV (1050.06: 0.252) _call_client GET_BOOK_METADATA {u'index': 222}
SMART_DEV (1052.41: 2.265) _call_client GET_BOOK_METADATA {u'index': 223}
SMART_DEV (1052.94: 0.431) _call_client GET_BOOK_METADATA {u'index': 224}
SMART_DEV (1053.35: 0.331) _call_client GET_BOOK_METADATA {u'index': 225}
SMART_DEV (1053.86: 0.419) _call_client GET_BOOK_METADATA {u'index': 226}
SMART_DEV (1054.27: 0.325) _call_client GET_BOOK_METADATA {u'index': 227}
SMART_DEV (1054.67: 0.315) _call_client GET_BOOK_METADATA {u'index': 228}
SMART_DEV (1055.08: 0.312) _call_client GET_BOOK_METADATA {u'index': 229}
SMART_DEV (1055.47: 0.291) _call_client GET_BOOK_METADATA {u'index': 230}
SMART_DEV (1055.83: 0.272) _call_client GET_BOOK_METADATA {u'index': 231}
SMART_DEV (1056.21: 0.295) _call_client GET_BOOK_METADATA {u'index': 232}
SMART_DEV (1056.58: 0.282) _call_client GET_BOOK_METADATA {u'index': 233}
SMART_DEV (1056.89: 0.212) _call_client GET_BOOK_METADATA {u'index': 234}
SMART_DEV (1057.19: 0.206) _call_client GET_BOOK_METADATA {u'index': 235}
SMART_DEV (1057.49: 0.216) _call_client GET_BOOK_METADATA {u'index': 236}
SMART_DEV (1057.85: 0.274) _call_client GET_BOOK_METADATA {u'index': 237}
SMART_DEV (1058.21: 0.273) _call_client GET_BOOK_METADATA {u'index': 238}
SMART_DEV (1058.52: 0.222) _call_client GET_BOOK_METADATA {u'index': 239}
SMART_DEV (1058.83: 0.221) _call_client GET_BOOK_METADATA {u'index': 240}
SMART_DEV (1059.18: 0.272) _call_client GET_BOOK_METADATA {u'index': 241}
SMART_DEV (1059.70: 0.428) _call_client GET_BOOK_METADATA {u'index': 242}
SMART_DEV (1060.11: 0.320) _call_client GET_BOOK_METADATA {u'index': 243}
SMART_DEV (1060.47: 0.269) _call_client GET_BOOK_METADATA {u'index': 244}
SMART_DEV (1060.78: 0.229) _call_client GET_BOOK_METADATA {u'index': 245}
SMART_DEV (1061.12: 0.257) _call_client GET_BOOK_METADATA {u'index': 246}
SMART_DEV (1061.60: 0.389) _call_client GET_BOOK_METADATA {u'index': 247}
SMART_DEV (1061.95: 0.248) _call_client GET_BOOK_METADATA {u'index': 248}
SMART_DEV (1062.40: 0.364) _call_client GET_BOOK_METADATA {u'index': 249}
SMART_DEV (1062.72: 0.245) _call_client GET_BOOK_METADATA {u'index': 250}
SMART_DEV (1063.04: 0.226) _call_client GET_BOOK_METADATA {u'index': 251}
SMART_DEV (1063.39: 0.263) _call_client GET_BOOK_METADATA {u'index': 252}
SMART_DEV (1063.80: 0.328) _call_client GET_BOOK_METADATA {u'index': 253}
SMART_DEV (1064.15: 0.271) _call_client GET_BOOK_METADATA {u'index': 254}
SMART_DEV (1064.50: 0.259) _call_client GET_BOOK_METADATA {u'index': 255}
SMART_DEV (1064.77: 0.180) _call_client GET_BOOK_METADATA {u'index': 256}
SMART_DEV (1065.13: 0.281) _call_client GET_BOOK_METADATA {u'index': 257}
SMART_DEV (1065.53: 0.310) _call_client GET_BOOK_METADATA {u'index': 258}
SMART_DEV (1065.89: 0.257) _call_client GET_BOOK_METADATA {u'index': 259}
SMART_DEV (1066.32: 0.341) _call_client GET_BOOK_METADATA {u'index': 260}
SMART_DEV (1066.61: 0.209) _call_client GET_BOOK_METADATA {u'index': 261}
SMART_DEV (1066.93: 0.211) _call_client GET_BOOK_METADATA {u'index': 262}
SMART_DEV (1067.31: 0.296) _call_client GET_BOOK_METADATA {u'index': 263}
SMART_DEV (1067.74: 0.336) _call_client GET_BOOK_METADATA {u'index': 264}
SMART_DEV (1068.09: 0.264) _call_client GET_BOOK_METADATA {u'index': 265}
SMART_DEV (1068.46: 0.286) _call_client GET_BOOK_METADATA {u'index': 266}
SMART_DEV (1068.76: 0.206) _call_client GET_BOOK_METADATA {u'index': 267}
SMART_DEV (1069.09: 0.241) _call_client GET_BOOK_METADATA {u'index': 268}
SMART_DEV (1069.38: 0.201) _call_client GET_BOOK_METADATA {u'index': 269}
SMART_DEV (1069.68: 0.218) _call_client GET_BOOK_METADATA {u'index': 270}
SMART_DEV (1070.14: 0.371) _call_client GET_BOOK_METADATA {u'index': 271}
SMART_DEV (1070.55: 0.321) _call_client GET_BOOK_METADATA {u'index': 272}
SMART_DEV (1070.92: 0.287) _call_client GET_BOOK_METADATA {u'index': 273}
SMART_DEV (1071.23: 0.220) _call_client GET_BOOK_METADATA {u'index': 274}
SMART_DEV (1071.52: 0.200) _call_client GET_BOOK_METADATA {u'index': 275}
SMART_DEV (1071.84: 0.211) _call_client GET_BOOK_METADATA {u'index': 276}
SMART_DEV (1072.31: 0.376) _call_client GET_BOOK_METADATA {u'index': 277}
SMART_DEV (1072.65: 0.250) _call_client GET_BOOK_METADATA {u'index': 278}
SMART_DEV (1072.96: 0.227) _call_client GET_BOOK_METADATA {u'index': 279}
SMART_DEV (1073.33: 0.273) _call_client GET_BOOK_METADATA {u'index': 280}
SMART_DEV (1073.72: 0.313) _call_client GET_BOOK_METADATA {u'index': 281}
SMART_DEV (1074.13: 0.316) _call_client GET_BOOK_METADATA {u'index': 282}
SMART_DEV (1074.65: 0.434) _call_client GET_BOOK_METADATA {u'index': 283}
SMART_DEV (1075.04: 0.296) _call_client GET_BOOK_METADATA {u'index': 284}
SMART_DEV (1075.32: 0.184) _call_client GET_BOOK_METADATA {u'index': 285}
SMART_DEV (1075.64: 0.246) _call_client GET_BOOK_METADATA {u'index': 286}
SMART_DEV (1075.93: 0.190) _call_client GET_BOOK_METADATA {u'index': 287}
SMART_DEV (1076.28: 0.269) _call_client GET_BOOK_METADATA {u'index': 288}
SMART_DEV (1076.77: 0.405) _call_client GET_BOOK_METADATA {u'index': 289}
SMART_DEV (1077.07: 0.212) _call_client GET_BOOK_METADATA {u'index': 290}
SMART_DEV (1077.36: 0.205) _call_client GET_BOOK_METADATA {u'index': 291}
SMART_DEV (1077.71: 0.263) _call_client GET_BOOK_METADATA {u'index': 292}
SMART_DEV (1078.13: 0.329) _call_client GET_BOOK_METADATA {u'index': 293}
SMART_DEV (1078.54: 0.319) _call_client GET_BOOK_METADATA {u'index': 294}
SMART_DEV (1079.05: 0.422) _call_client GET_BOOK_METADATA {u'index': 295}
SMART_DEV (1079.45: 0.323) _call_client GET_BOOK_METADATA {u'index': 296}
SMART_DEV (1079.84: 0.286) _call_client GET_BOOK_METADATA {u'index': 297}
SMART_DEV (1080.17: 0.242) _call_client GET_BOOK_METADATA {u'index': 298}
SMART_DEV (1080.69: 0.432) _call_client GET_BOOK_METADATA {u'index': 299}
SMART_DEV (1081.10: 0.325) _call_client GET_BOOK_METADATA {u'index': 300}
SMART_DEV (1081.50: 0.315) _call_client GET_BOOK_METADATA {u'index': 301}
SMART_DEV (1082.02: 0.430) _call_client GET_BOOK_METADATA {u'index': 302}
SMART_DEV (1082.42: 0.318) _call_client GET_BOOK_METADATA {u'index': 303}
SMART_DEV (1082.79: 0.272) _call_client GET_BOOK_METADATA {u'index': 304}
SMART_DEV (1083.14: 0.266) _call_client GET_BOOK_METADATA {u'index': 305}
SMART_DEV (1083.55: 0.315) _call_client GET_BOOK_METADATA {u'index': 306}
SMART_DEV (1083.96: 0.330) _call_client GET_BOOK_METADATA {u'index': 307}
SMART_DEV (1084.38: 0.325) _call_client GET_BOOK_METADATA {u'index': 308}
SMART_DEV (1084.88: 0.416) _call_client GET_BOOK_METADATA {u'index': 309}
SMART_DEV (1085.27: 0.305) _call_client GET_BOOK_METADATA {u'index': 310}
SMART_DEV (1085.55: 0.194) _call_client GET_BOOK_METADATA {u'index': 311}
SMART_DEV (1085.88: 0.245) books carda
SMART_DEV (1085.96: 0.000) books cardb
DeviceJob: 2 Get list of books on device done, calling callback
SMART_DEV (1108.72: 22.687) set_plugboards
DeviceJob: 2 Get list of books on device callback returned
SMART_DEV (1109.46: 0.636) set_progress_reporter
Job: 3 Send metadata to device started
SMART_DEV (1109.54: 0.005) sync_booklists collection attributes [u'']
DEBUG: 0.0 Starting get_collections: on_connect
DEBUG: 0.0 Renaming rules: {}
DEBUG: 0.0 Formatting template: {value}{category:| (|)}
DEBUG: 0.0 Sorting rules: []
SMART_DEV (1109.81: 0.077) _call_client SEND_BOOKLISTS {u'count': 312, u'collections': {}}
Job: 2 Get list of books on device finished
No details available.
SMART_DEV (1109.97: 0.001) _call_client send string [7, {"count": 312, "collections": {}}]
SMART_DEV (1110.37: 0.309) _call_client received string [0,{}]
SMART_DEV (1110.45: 0.000) _call_client receive after decode
SMART_DEV (1110.84: 0.294) card_prefix
SMART_DEV (1110.92: 0.000) free_space
SMART_DEV (1111.00: 0.004) _call_client FREE_SPACE {}
SMART_DEV (1111.09: 0.001) _call_client send string [5, {}]
SMART_DEV (1111.49: 0.316) _call_client received string [0,{"free_space_on_device":4641083392}]
SMART_DEV (1111.58: 0.000) _call_client receive after decode
DeviceJob: 3 Send metadata to device done, calling callback
DeviceJob: 3 Send metadata to device callback returned
SMART_DEV (1111.76: 0.089) _call_client NOOP {}
SMART_DEV (1111.86: 0.000) _call_client send string [12, {}]
SMART_DEV (1112.31: 0.359) _call_client received string [0,{}]
SMART_DEV (1112.40: 0.000) _call_client receive after decode
Job: 3 Send metadata to device finished
No details available.
SMART_DEV (1122.54: 10.043) _call_client NOOP {}
SMART_DEV (1122.65: 0.001) _call_client send string [12, {}]
SMART_DEV (1123.06: 0.320) _call_client received string [0,{}]
SMART_DEV (1123.15: 0.000) _call_client receive after decode
SMART_DEV (1133.28: 10.047) _call_client NOOP {}
SMART_DEV (1133.47: 0.000) _call_client send string [12, {}]
SMART_DEV (1134.01: 0.317) _call_client received string [0,{}]
SMART_DEV (1134.10: 0.000) _call_client receive after decode
SMART_DEV (1144.23: 10.047) _call_client NOOP {}
SMART_DEV (1144.36: 0.000) _call_client send string [12, {}]
SMART_DEV (1144.87: 0.408) _call_client received string [0,{}]
SMART_DEV (1144.97: 0.000) _call_client receive after decode
SMART_DEV (1155.13: 10.043) _call_client NOOP {}
SMART_DEV (1155.22: 0.000) _call_client send string [12, {}]
SMART_DEV (1155.62: 0.321) _call_client received string [0,{}]
SMART_DEV (1155.71: 0.000) _call_client receive after decode
SMART_DEV (1165.84: 10.044) _call_client NOOP {}
SMART_DEV (1165.92: 0.000) _call_client send string [12, {}]
SMART_DEV (1166.37: 0.366) _call_client received string [0,{}]
SMART_DEV (1166.45: 0.001) _call_client receive after decode
SMART_DEV (1176.62: 10.076) _call_client NOOP {}
SMART_DEV (1176.72: 0.000) _call_client send string [12, {}]
SMART_DEV (1177.22: 0.397) _call_client received string [0,{}]
SMART_DEV (1177.31: 0.000) _call_client receive after decode
SMART_DEV (1187.55: 10.106) _call_client NOOP {}
SMART_DEV (1187.64: 0.000) _call_client send string [12, {}]
SMART_DEV (1188.08: 0.356) _call_client received string [0,{}]
SMART_DEV (1188.16: 0.000) _call_client receive after decode
SMART_DEV (1188.25: 0.001) set_progress_reporter
Job: 4 Upload 1 books to device:Proven Guilty started
SMART_DEV (1188.30: 0.001) set_plugboards
Device using plugboard epub SMART_DEVICE_APP None
Setting metadata in: Proven Guilty at: C:\Users\Owner\AppData\Local\Temp\calibre_0.8.65_t mp_vifk1q\rmnzsdcaltmpfmt.epub
SMART_DEV (1188.60: 0.228) upload_books [u'Proven Guilty - Jim Butcher_1681.epub']
SMART_DEV (1188.74: 0.041) _put_file Proven Guilty - Jim Butcher.epub 437018
SMART_DEV (1188.83: 0.004) _call_client SEND_BOOK {u'length': 437018L, u'thisBook': 0, u'lpath': 'Proven Guilty - Jim Butcher.epub', u'totalBooks': 1, u'metadata': <calibre.devices.usbms.books.Book object at 0x0BCB3850>}
SMART_DEV (1189.53: 0.607) _call_client BOOK_DATA {u'position': 0, u'lpath': 'Proven Guilty - Jim Butcher.epub', u'data': u'too long'}
SMART_DEV (1191.16: 1.529) _call_client BOOK_DATA {u'position': 204800, u'lpath': 'Proven Guilty - Jim Butcher.epub', u'data': u'too long'}
SMART_DEV (1192.18: 0.919) _call_client BOOK_DATA {u'position': 409600, u'lpath': 'Proven Guilty - Jim Butcher.epub', u'data': u'too long'}
SMART_DEV (1192.69: 0.415) _call_client BOOK_DONE {u'lpath': 'Proven Guilty - Jim Butcher.epub'}
SMART_DEV (1192.79: 0.000) _call_client send string [11, {"lpath": "Proven Guilty - Jim Butcher.epub"}]
SMART_DEV (1193.30: 0.414) _call_client received string [0,{}]
SMART_DEV (1193.40: 0.000) _call_client receive after decode
SMART_DEV (1193.49: 0.000) upload_books finished uploading 1 books
DeviceJob: 4 Upload 1 books to device:Proven Guilty done, calling callback
SMART_DEV (1193.57: 0.001) add_books_to_metadata adding metadata for 1 books
SMART_DEV (1193.70: 0.007) add_books_to_metadata finished adding metadata
SMART_DEV (1213.32: 19.507) set_plugboards
DeviceJob: 4 Upload 1 books to device:Proven Guilty callback returned
SMART_DEV (1213.78: 0.397) set_progress_reporter
Job: 5 Send metadata to device started
SMART_DEV (1213.87: 0.049) sync_booklists collection attributes [u'']
DEBUG: 104.2 Starting get_collections: on_connect
DEBUG: 104.2 Renaming rules: {}
DEBUG: 104.2 Formatting template: {value}{category:| (|)}
DEBUG: 104.2 Sorting rules: []
Job: 4 Upload 1 books to device:Proven Guilty finished
No details available.
SMART_DEV (1213.95: 0.037) _call_client SEND_BOOKLISTS {u'count': 313, u'collections': {}}
SMART_DEV (1214.04: 0.000) _call_client send string [7, {"count": 313, "collections": {}}]
SMART_DEV (1214.49: 0.367) _call_client received string [0,{}]
SMART_DEV (1214.58: 0.000) _call_client receive after decode
SMART_DEV (1214.96: 0.293) card_prefix
SMART_DEV (1215.04: 0.000) free_space
SMART_DEV (1215.12: 0.005) _call_client FREE_SPACE {}
SMART_DEV (1215.21: 0.000) _call_client send string [5, {}]
SMART_DEV (1215.72: 0.396) _call_client received string [0,{"free_space_on_device":4640645120}]
SMART_DEV (1215.81: 0.000) _call_client receive after decode
DeviceJob: 5 Send metadata to device done, calling callback
DeviceJob: 5 Send metadata to device callback returned
Job: 5 Send metadata to device finished
No details available.
SMART_DEV (1215.94: 0.020) _call_client NOOP {}
SMART_DEV (1216.05: 0.000) _call_client send string [12, {}]
SMART_DEV (1216.54: 0.381) _call_client received string [0,{}]
SMART_DEV (1216.63: 0.000) _call_client receive after decode
SMART_DEV (1230.29: 13.572) _call_client NOOP {}
SMART_DEV (1230.38: 0.000) _call_client send string [12, {}]
SMART_DEV (1230.98: 0.512) _call_client received string [0,{}]
SMART_DEV (1231.07: 0.001) _call_client receive after decode
SMART_DEV (1241.20: 10.044) _call_client NOOP {}
SMART_DEV (1241.29: 0.000) _call_client send string [12, {}]
SMART_DEV (1241.74: 0.365) _call_client received string [0,{}]
SMART_DEV (1241.83: 0.001) _call_client receive after decode
SMART_DEV (1251.98: 10.049) _call_client NOOP {}
SMART_DEV (1252.08: 0.000) _call_client send string [12, {}]
SMART_DEV (1252.48: 0.317) _call_client received string [0,{}]
SMART_DEV (1252.57: 0.000) _call_client receive after decode
SMART_DEV (1262.85: 10.048) _call_client NOOP {}
SMART_DEV (1262.93: 0.000) _call_client send string [12, {}]
SMART_DEV (1263.34: 0.259) _call_client received string [0,{}]
SMART_DEV (1263.43: 0.000) _call_client receive after decode
SMART_DEV (1267.53: 4.014) set_progress_reporter
Job: 6 Upload 1 books to device:The Darkest Kiss started
SMART_DEV (1267.59: 0.001) set_plugboards
Device using plugboard epub SMART_DEVICE_APP None
Setting metadata in: The Darkest Kiss at: C:\Users\Owner\AppData\Local\Temp\calibre_0.8.65_t mp_vifk1q\pzhhtocaltmpfmt.epub
SMART_DEV (1267.85: 0.184) upload_books [u'The Darkest Kiss - Keri Arthur_3213.epub']
SMART_DEV (1267.95: 0.018) _put_file Darkest Kiss, The - Keri Arthur.epub 334958
SMART_DEV (1268.04: 0.004) _call_client SEND_BOOK {u'length': 334958L, u'thisBook': 0, u'lpath': 'Darkest Kiss, The - Keri Arthur.epub', u'totalBooks': 1, u'metadata': <calibre.devices.usbms.books.Book object at 0x0B710410>}
SMART_DEV (1268.57: 0.434) _call_client BOOK_DATA {u'position': 0, u'lpath': 'Darkest Kiss, The - Keri Arthur.epub', u'data': u'too long'}
SMART_DEV (1269.90: 1.229) _call_client BOOK_DATA {u'position': 204800, u'lpath': 'Darkest Kiss, The - Keri Arthur.epub', u'data': u'too long'}
SMART_DEV (1270.61: 0.611) _call_client BOOK_DONE {u'lpath': 'Darkest Kiss, The - Keri Arthur.epub'}
SMART_DEV (1270.70: 0.000) _call_client send string [11, {"lpath": "Darkest Kiss, The - Keri Arthur.epub"}]
SMART_DEV (1271.12: 0.275) _call_client received string [0,{}]
SMART_DEV (1271.32: 0.000) _call_client receive after decode
SMART_DEV (1271.43: 0.001) upload_books finished uploading 1 books
DeviceJob: 6 Upload 1 books to device:The Darkest Kiss done, calling callback
SMART_DEV (1271.54: 0.008) add_books_to_metadata adding metadata for 1 books
SMART_DEV (1271.67: 0.007) add_books_to_metadata finished adding metadata
SMART_DEV (1289.81: 18.031) set_plugboards
DeviceJob: 6 Upload 1 books to device:The Darkest Kiss callback returned
SMART_DEV (1290.26: 0.380) set_progress_reporter
Job: 7 Send metadata to device started
SMART_DEV (1290.37: 0.037) sync_booklists collection attributes [u'']
DEBUG: 180.7 Starting get_collections: on_connect
DEBUG: 180.7 Renaming rules: {}
DEBUG: 180.7 Formatting template: {value}{category:| (|)}
DEBUG: 180.7 Sorting rules: []
SMART_DEV (1290.48: 0.042) _call_client SEND_BOOKLISTS {u'count': 314, u'collections': {}}
SMART_DEV (1290.53: 0.000) _call_client send string [7, {"count": 314, "collections": {}}]
Job: 6 Upload 1 books to device:The Darkest Kiss finished
No details available.
SMART_DEV (1290.98: 0.381) _call_client received string [0,{}]
SMART_DEV (1291.07: 0.000) _call_client receive after decode
SMART_DEV (1291.47: 0.300) card_prefix
SMART_DEV (1291.54: 0.000) free_space
SMART_DEV (1294.52: 2.896) _call_client FREE_SPACE {}
SMART_DEV (1294.61: 0.000) _call_client send string [5, {}]
SMART_DEV (1295.08: 0.386) _call_client received string [0,{"free_space_on_device":4640309248}]
SMART_DEV (1295.16: 0.000) _call_client receive after decode
DeviceJob: 7 Send metadata to device done, calling callback
DeviceJob: 7 Send metadata to device callback returned
SMART_DEV (1295.27: 0.020) _call_client NOOP {}
SMART_DEV (1295.36: 0.000) _call_client send string [12, {}]
SMART_DEV (1295.69: 0.244) _call_client received string [0,{}]
SMART_DEV (1295.78: 0.000) _call_client receive after decode
Job: 7 Send metadata to device finished
No details available.
SMART_DEV (1305.94: 10.073) _call_client NOOP {}
SMART_DEV (1306.02: 0.000) _call_client send string [12, {}]
SMART_DEV (1306.44: 0.332) _call_client received string [0,{}]
SMART_DEV (1306.53: 0.000) _call_client receive after decode
SMART_DEV (1316.72: 10.101) _call_client NOOP {}
SMART_DEV (1316.80: 0.000) _call_client send string [12, {}]
SMART_DEV (1317.30: 0.406) _call_client received string [0,{}]
SMART_DEV (1317.38: 0.000) _call_client receive after decode
SMART_DEV (1319.48: 2.014) _call_client NOOP {}
SMART_DEV (1319.57: 0.000) _call_client send string [12, {}]
SMART_DEV (1319.66: 0.000) _call_client received string
SMART_DEV (1319.75: 0.000) _call_client protocol error -- empty json string
SMART_DEV (1319.84: 0.001) post_yank_cleanup
SMART_DEV (2098.60:778.670) reset
SMART_DEV (2098.67: 0.000) set_progress_reporter
SMART_DEV (2098.77: 0.000) open
SMART_DEV (2098.86: 0.008) _call_client GET_INITIALIZATION_INFO {u'validExtensions': ['lrf', 'rar', 'zip', 'rtf', 'lit', 'txt', 'txtz', 'text', 'htm', 'xhtm', 'html', 'htmlz', 'xhtml', 'pdf', 'pdb', 'updb', 'pdr', 'prc', 'mobi', 'azw', 'doc', 'epub', 'fb2', 'djv', 'djvu', 'lrx', 'cbr', 'cbz', 'cbc', 'oebzip', 'rb', 'imp', 'odt', 'chm', 'tpz', 'azw1', 'pml', 'pmlz', 'mbp', 'tan', 'snb', 'xps', 'oxps', 'azw4', 'book', 'zbf', 'pobi', 'docx', 'md', 'textile', 'markdown', 'ibook', 'iba', 'azw3', 'ps'], u'currentLibraryName': u'Calibre Library', u'currentLibraryUUID': u'7f7a8ee2-038e-40eb-a1c2-c5fac3831769', u'serverProtocolVersion': 1, u'passwordChallenge': u''}
SMART_DEV (2098.94: 0.000) _call_client send string [9, {"validExtensions": ["lrf", "rar", "zip", "rtf", "lit", "txt", "txtz", "text", "htm", "xhtm", "html", "htmlz", "xhtml", "pdf", "pdb", "updb", "pdr", "prc", "mobi", "azw", "doc", "epub", "fb2", "djv", "djvu", "lrx", "cbr", "cbz", "cbc", "oebzip", "rb", "imp", "odt", "chm", "tpz", "azw1", "pml", "pmlz", "mbp", "tan", "snb", "xps", "oxps", "azw4", "book", "zbf", "pobi", "docx", "md", "textile", "markdown", "ibook", "iba", "azw3", "ps"], "currentLibraryName": "Calibre Library", "currentLibraryUUID": "7f7a8ee2-038e-40eb-a1c2-c5fac3831769", "serverProtocolVersion": 1, "passwordChallenge": ""}]
SMART_DEV (2099.28: 0.249) _call_client received string [0,{"ccVersionNumber":6,"acceptedExtensions":["epub","mobi"],"passwordHash":"","versionOK":true,"maxBookConten tPacketLen":204800}]
SMART_DEV (2099.36: 0.000) _call_client receive after decode
SMART_DEV (2099.44: 0.000) open CC version #: 6
SMART_DEV (2099.53: 0.009) open selected formats [u'epub', u'mobi']
SMART_DEV (2099.61: 0.001) card_prefix
SMART_DEV (2099.97: 0.250) set_progress_reporter
Job: 8 Get device information started
SMART_DEV (2100.11: 0.000) get_device_information
SMART_DEV (2100.32: 0.010) _call_client GET_DEVICE_INFORMATION {}
SMART_DEV (2100.55: 0.000) _call_client send string [3, {}]
SMART_DEV (2101.11: 0.402) _call_client received string [0,{"device_info":{"last_library_uuid":"7f7a8ee2-038e-40eb-a1c2-c5fac3831769","calibre_version":"0.8.65","device_n ame":"SmartDevice","date_last_connected":"2012-08-18T09:33:59.732000+00:00","device_store_uuid":"16e a48c9-e0ea-4f9a-95cf-67e4ec12e2f9","location_code":"main","prefix":""}, "version":"6","device_version":"10, encore"}]
SMART_DEV (2101.19: 0.000) _call_client receive after decode
SMART_DEV (2101.29: 0.006) _call_client SET_CALIBRE_DEVICE_INFO {u'device_store_uuid': u'16ea48c9-e0ea-4f9a-95cf-67e4ec12e2f9', u'location_code': u'main', u'device_name': u'SmartDevice', u'calibre_version': u'0.8.65', u'prefix': u'', u'last_library_uuid': u'7f7a8ee2-038e-40eb-a1c2-c5fac3831769', u'date_last_connected': u'2012-08-18T09:53:05.921000+00:00'}
SMART_DEV (2101.37: 0.000) _call_client send string [1, {"device_store_uuid": "16ea48c9-e0ea-4f9a-95cf-67e4ec12e2f9", "location_code": "main", "device_name": "SmartDevice", "calibre_version": "0.8.65", "prefix": "", "last_library_uuid": "7f7a8ee2-038e-40eb-a1c2-c5fac3831769", "date_last_connected": "2012-08-18T09:53:05.921000+00:00"}]
SMART_DEV (2101.72: 0.258) _call_client received string [0,{}]
SMART_DEV (2101.81: 0.000) _call_client receive after decode
SMART_DEV (2101.89: 0.000) card_prefix
SMART_DEV (2101.97: 0.000) free_space
SMART_DEV (2102.06: 0.005) _call_client FREE_SPACE {}
SMART_DEV (2102.14: 0.000) _call_client send string [5, {}]
SMART_DEV (2102.54: 0.309) _call_client received string [0,{"free_space_on_device":4639707136}]
SMART_DEV (2102.63: 0.000) _call_client receive after decode
DeviceJob: 8 Get device information done, calling callback
DeviceJob: 8 Get device information callback returned
SMART_DEV (2102.75: 0.039) set_progress_reporter
Job: 9 Get list of books on device started
SMART_DEV (2102.83: 0.001) books None
SMART_DEV (2102.91: 0.004) _call_client GET_BOOK_COUNT {}
SMART_DEV (2102.99: 0.001) _call_client send string [6, {}]
Job: 8 Get device information finished
No details available.
SMART_DEV (2121.99: 18.914) _call_client received string [0,{"count":314}]
SMART_DEV (2122.08: 0.000) _call_client receive after decode
SMART_DEV (2122.17: 0.005) _call_client GET_BOOK_METADATA {u'index': 0}
SMART_DEV (2122.53: 0.272) _call_client GET_BOOK_METADATA {u'index': 1}
SMART_DEV (2122.83: 0.210) _call_client GET_BOOK_METADATA {u'index': 2}
SMART_DEV (2123.14: 0.222) _call_client GET_BOOK_METADATA {u'index': 3}
SMART_DEV (2123.44: 0.190) _call_client GET_BOOK_METADATA {u'index': 4}
SMART_DEV (2123.84: 0.309) _call_client GET_BOOK_METADATA {u'index': 5}
SMART_DEV (2124.16: 0.221) _call_client GET_BOOK_METADATA {u'index': 6}
SMART_DEV (2124.57: 0.327) _call_client GET_BOOK_METADATA {u'index': 7}
SMART_DEV (2124.99: 0.334) _call_client GET_BOOK_METADATA {u'index': 8}
SMART_DEV (2125.32: 0.243) _call_client GET_BOOK_METADATA {u'index': 9}
SMART_DEV (2125.59: 0.186) _call_client GET_BOOK_METADATA {u'index': 10}
SMART_DEV (2125.93: 0.249) _call_client GET_BOOK_METADATA {u'index': 11}
SMART_DEV (2126.21: 0.195) _call_client GET_BOOK_METADATA {u'index': 12}
SMART_DEV (2126.76: 0.463) _call_client GET_BOOK_METADATA {u'index': 13}
SMART_DEV (2127.04: 0.190) _call_client GET_BOOK_METADATA {u'index': 14}
SMART_DEV (2127.54: 0.416) _call_client GET_BOOK_METADATA {u'index': 15}
SMART_DEV (2127.85: 0.221) _call_client GET_BOOK_METADATA {u'index': 16}
SMART_DEV (2128.16: 0.212) _call_client GET_BOOK_METADATA {u'index': 17}
SMART_DEV (2128.63: 0.382) _call_client GET_BOOK_METADATA {u'index': 18}
SMART_DEV (2128.87: 0.148) _call_client GET_BOOK_METADATA {u'index': 19}
SMART_DEV (2129.18: 0.217) _call_client GET_BOOK_METADATA {u'index': 20}
SMART_DEV (2129.49: 0.226) _call_client GET_BOOK_METADATA {u'index': 21}
SMART_DEV (2129.80: 0.211) _call_client GET_BOOK_METADATA {u'index': 22}
SMART_DEV (2130.21: 0.322) _call_client GET_BOOK_METADATA {u'index': 23}
SMART_DEV (2130.61: 0.310) _call_client GET_BOOK_METADATA {u'index': 24}
SMART_DEV (2130.93: 0.236) _call_client GET_BOOK_METADATA {u'index': 25}
SMART_DEV (2131.44: 0.418) _call_client GET_BOOK_METADATA {u'index': 26}
SMART_DEV (2131.74: 0.196) _call_client GET_BOOK_METADATA {u'index': 27}
SMART_DEV (2132.05: 0.217) _call_client GET_BOOK_METADATA {u'index': 28}
SMART_DEV (2132.36: 0.215) _call_client GET_BOOK_METADATA {u'index': 29}
SMART_DEV (2132.66: 0.215) _call_client GET_BOOK_METADATA {u'index': 30}
SMART_DEV (2132.99: 0.214) _call_client GET_BOOK_METADATA {u'index': 31}
SMART_DEV (2133.29: 0.210) _call_client GET_BOOK_METADATA {u'index': 32}
SMART_DEV (2133.58: 0.175) _call_client GET_BOOK_METADATA {u'index': 33}
SMART_DEV (2133.91: 0.202) _call_client GET_BOOK_METADATA {u'index': 34}
SMART_DEV (2134.20: 0.240) _call_client GET_BOOK_METADATA {u'index': 35}
SMART_DEV (2134.50: 0.213) _call_client GET_BOOK_METADATA {u'index': 36}
SMART_DEV (2134.81: 0.219) _call_client GET_BOOK_METADATA {u'index': 37}
SMART_DEV (2135.12: 0.221) _call_client GET_BOOK_METADATA {u'index': 38}
SMART_DEV (2135.43: 0.221) _call_client GET_BOOK_METADATA {u'index': 39}
SMART_DEV (2135.73: 0.199) _call_client GET_BOOK_METADATA {u'index': 40}
SMART_DEV (2136.14: 0.305) _call_client GET_BOOK_METADATA {u'index': 41}
SMART_DEV (2136.45: 0.224) _call_client GET_BOOK_METADATA {u'index': 42}
SMART_DEV (2136.96: 0.423) _call_client GET_BOOK_METADATA {u'index': 43}
SMART_DEV (2137.31: 0.252) _call_client GET_BOOK_METADATA {u'index': 44}
SMART_DEV (2137.56: 0.174) _call_client GET_BOOK_METADATA {u'index': 45}
SMART_DEV (2137.79: 0.131) _call_client GET_BOOK_METADATA {u'index': 46}
SMART_DEV (2138.08: 0.205) _call_client GET_BOOK_METADATA {u'index': 47}
SMART_DEV (2138.45: 0.288) _call_client GET_BOOK_METADATA {u'index': 48}
SMART_DEV (2138.70: 0.158) _call_client GET_BOOK_METADATA {u'index': 49}
SMART_DEV (2139.12: 0.332) _call_client GET_BOOK_METADATA {u'index': 50}
SMART_DEV (2139.41: 0.208) _call_client GET_BOOK_METADATA {u'index': 51}
SMART_DEV (2140.11: 0.600) _call_client GET_BOOK_METADATA {u'index': 52}
SMART_DEV (2140.34: 0.149) _call_client GET_BOOK_METADATA {u'index': 53}
SMART_DEV (2140.65: 0.221) _call_client GET_BOOK_METADATA {u'index': 54}
SMART_DEV (2140.96: 0.222) _call_client GET_BOOK_METADATA {u'index': 55}
SMART_DEV (2141.29: 0.253) _call_client GET_BOOK_METADATA {u'index': 56}
SMART_DEV (2141.57: 0.187) _call_client GET_BOOK_METADATA {u'index': 57}
SMART_DEV (2141.87: 0.220) _call_client GET_BOOK_METADATA {u'index': 58}
SMART_DEV (2142.39: 0.431) _call_client GET_BOOK_METADATA {u'index': 59}
SMART_DEV (2142.69: 0.211) _call_client GET_BOOK_METADATA {u'index': 60}
SMART_DEV (2143.00: 0.221) _call_client GET_BOOK_METADATA {u'index': 61}
SMART_DEV (2143.31: 0.218) _call_client GET_BOOK_METADATA {u'index': 62}
SMART_DEV (2143.63: 0.229) _call_client GET_BOOK_METADATA {u'index': 63}
SMART_DEV (2143.92: 0.193) _call_client GET_BOOK_METADATA {u'index': 64}
SMART_DEV (2144.23: 0.203) _call_client GET_BOOK_METADATA {u'index': 65}
SMART_DEV (2144.53: 0.213) _call_client GET_BOOK_METADATA {u'index': 66}
SMART_DEV (2144.74: 0.121) _call_client GET_BOOK_METADATA {u'index': 67}
SMART_DEV (2145.16: 0.337) _call_client GET_BOOK_METADATA {u'index': 68}
SMART_DEV (2145.46: 0.215) _call_client GET_BOOK_METADATA {u'index': 69}
SMART_DEV (2145.87: 0.315) _call_client GET_BOOK_METADATA {u'index': 70}
SMART_DEV (2146.17: 0.214) _call_client GET_BOOK_METADATA {u'index': 71}
SMART_DEV (2146.48: 0.226) _call_client GET_BOOK_METADATA {u'index': 72}
SMART_DEV (2146.79: 0.219) _call_client GET_BOOK_METADATA {u'index': 73}
SMART_DEV (2147.14: 0.256) _call_client GET_BOOK_METADATA {u'index': 74}
SMART_DEV (2147.50: 0.282) _call_client GET_BOOK_METADATA {u'index': 75}
SMART_DEV (2148.02: 0.427) _call_client GET_BOOK_METADATA {u'index': 76}
SMART_DEV (2148.32: 0.217) _call_client GET_BOOK_METADATA {u'index': 77}
SMART_DEV (2148.63: 0.208) _call_client GET_BOOK_METADATA {u'index': 78}
SMART_DEV (2148.94: 0.212) _call_client GET_BOOK_METADATA {u'index': 79}
SMART_DEV (2149.24: 0.218) _call_client GET_BOOK_METADATA {u'index': 80}
SMART_DEV (2149.54: 0.206) _call_client GET_BOOK_METADATA {u'index': 81}
SMART_DEV (2149.76: 0.127) _call_client GET_BOOK_METADATA {u'index': 82}
SMART_DEV (2149.96: 0.118) _call_client GET_BOOK_METADATA {u'index': 83}
SMART_DEV (2150.26: 0.215) _call_client GET_BOOK_METADATA {u'index': 84}
SMART_DEV (2150.57: 0.208) _call_client GET_BOOK_METADATA {u'index': 85}
SMART_DEV (2151.00: 0.352) _call_client GET_BOOK_METADATA {u'index': 86}
SMART_DEV (2151.30: 0.205) _call_client GET_BOOK_METADATA {u'index': 87}
SMART_DEV (2151.60: 0.219) _call_client GET_BOOK_METADATA {u'index': 88}
SMART_DEV (2151.92: 0.227) _call_client GET_BOOK_METADATA {u'index': 89}
SMART_DEV (2152.22: 0.210) _call_client GET_BOOK_METADATA {u'index': 90}
SMART_DEV (2152.52: 0.217) _call_client GET_BOOK_METADATA {u'index': 91}
SMART_DEV (2152.83: 0.216) _call_client GET_BOOK_METADATA {u'index': 92}
SMART_DEV (2153.14: 0.212) _call_client GET_BOOK_METADATA {u'index': 93}
SMART_DEV (2153.46: 0.232) _call_client GET_BOOK_METADATA {u'index': 94}
SMART_DEV (2153.77: 0.220) _call_client GET_BOOK_METADATA {u'index': 95}
SMART_DEV (2154.06: 0.200) _call_client GET_BOOK_METADATA {u'index': 96}
SMART_DEV (2154.38: 0.210) _call_client GET_BOOK_METADATA {u'index': 97}
SMART_DEV (2154.74: 0.276) _call_client GET_BOOK_METADATA {u'index': 98}
SMART_DEV (2155.26: 0.434) _call_client GET_BOOK_METADATA {u'index': 99}
SMART_DEV (2155.57: 0.219) _call_client GET_BOOK_METADATA {u'index': 100}
SMART_DEV (2155.87: 0.220) _call_client GET_BOOK_METADATA {u'index': 101}
SMART_DEV (2156.19: 0.224) _call_client GET_BOOK_METADATA {u'index': 102}
SMART_DEV (2156.49: 0.223) _call_client GET_BOOK_METADATA {u'index': 103}
SMART_DEV (2156.95: 0.368) _call_client GET_BOOK_METADATA {u'index': 104}
SMART_DEV (2157.29: 0.255) _call_client GET_BOOK_METADATA {u'index': 105}
SMART_DEV (2157.59: 0.214) _call_client GET_BOOK_METADATA {u'index': 106}
SMART_DEV (2157.95: 0.274) _call_client GET_BOOK_METADATA {u'index': 107}
SMART_DEV (2158.33: 0.288) _call_client GET_BOOK_METADATA {u'index': 108}
SMART_DEV (2158.63: 0.201) _call_client GET_BOOK_METADATA {u'index': 109}
SMART_DEV (2158.95: 0.235) _call_client GET_BOOK_METADATA {u'index': 110}
SMART_DEV (2159.28: 0.238) _call_client GET_BOOK_METADATA {u'index': 111}
SMART_DEV (2159.86: 0.491) _call_client GET_BOOK_METADATA {u'index': 112}
SMART_DEV (2160.17: 0.224) _call_client GET_BOOK_METADATA {u'index': 113}
SMART_DEV (2160.48: 0.224) _call_client GET_BOOK_METADATA {u'index': 114}
SMART_DEV (2160.76: 0.194) _call_client GET_BOOK_METADATA {u'index': 115}
SMART_DEV (2161.12: 0.264) _call_client GET_BOOK_METADATA {u'index': 116}
SMART_DEV (2161.50: 0.290) _call_client GET_BOOK_METADATA {u'index': 117}
SMART_DEV (2161.80: 0.209) _call_client GET_BOOK_METADATA {u'index': 118}
SMART_DEV (2162.12: 0.233) _call_client GET_BOOK_METADATA {u'index': 119}
SMART_DEV (2162.48: 0.264) _call_client GET_BOOK_METADATA {u'index': 120}
SMART_DEV (2162.84: 0.279) _call_client GET_BOOK_METADATA {u'index': 121}
SMART_DEV (2163.15: 0.228) _call_client GET_BOOK_METADATA {u'index': 122}
SMART_DEV (2163.56: 0.299) _call_client GET_BOOK_METADATA {u'index': 123}
SMART_DEV (2163.86: 0.214) _call_client GET_BOOK_METADATA {u'index': 124}
SMART_DEV (2164.17: 0.218) _call_client GET_BOOK_METADATA {u'index': 125}
SMART_DEV (2164.50: 0.237) _call_client GET_BOOK_METADATA {u'index': 126}
SMART_DEV (2164.88: 0.292) _call_client GET_BOOK_METADATA {u'index': 127}
SMART_DEV (2165.20: 0.235) _call_client GET_BOOK_METADATA {u'index': 128}
SMART_DEV (2165.63: 0.341) _call_client GET_BOOK_METADATA {u'index': 129}
SMART_DEV (2166.04: 0.319) _call_client GET_BOOK_METADATA {u'index': 130}
SMART_DEV (2166.40: 0.276) _call_client GET_BOOK_METADATA {u'index': 131}
SMART_DEV (2166.75: 0.266) _call_client GET_BOOK_METADATA {u'index': 132}
SMART_DEV (2167.14: 0.297) _call_client GET_BOOK_METADATA {u'index': 133}
SMART_DEV (2167.47: 0.240) _call_client GET_BOOK_METADATA {u'index': 134}
SMART_DEV (2167.76: 0.200) _call_client GET_BOOK_METADATA {u'index': 135}
SMART_DEV (2168.08: 0.236) _call_client GET_BOOK_METADATA {u'index': 136}
SMART_DEV (2168.47: 0.303) _call_client GET_BOOK_METADATA {u'index': 137}
SMART_DEV (2168.78: 0.223) _call_client GET_BOOK_METADATA {u'index': 138}
SMART_DEV (2169.09: 0.215) _call_client GET_BOOK_METADATA {u'index': 139}
SMART_DEV (2169.39: 0.218) _call_client GET_BOOK_METADATA {u'index': 140}
SMART_DEV (2169.73: 0.238) _call_client GET_BOOK_METADATA {u'index': 141}
SMART_DEV (2170.12: 0.298) _call_client GET_BOOK_METADATA {u'index': 142}
SMART_DEV (2170.44: 0.243) _call_client GET_BOOK_METADATA {u'index': 143}
SMART_DEV (2170.75: 0.223) _call_client GET_BOOK_METADATA {u'index': 144}
SMART_DEV (2171.33: 0.490) _call_client GET_BOOK_METADATA {u'index': 145}
SMART_DEV (2171.63: 0.213) _call_client GET_BOOK_METADATA {u'index': 146}
SMART_DEV (2171.98: 0.260) _call_client GET_BOOK_METADATA {u'index': 147}
SMART_DEV (2172.39: 0.321) _call_client GET_BOOK_METADATA {u'index': 148}
SMART_DEV (2172.80: 0.315) _call_client GET_BOOK_METADATA {u'index': 149}
SMART_DEV (2173.24: 0.347) _call_client GET_BOOK_METADATA {u'index': 150}
SMART_DEV (2173.58: 0.244) _call_client GET_BOOK_METADATA {u'index': 151}
SMART_DEV (2173.89: 0.214) _call_client GET_BOOK_METADATA {u'index': 152}
SMART_DEV (2174.20: 0.227) _call_client GET_BOOK_METADATA {u'index': 153}
SMART_DEV (2174.73: 0.440) _call_client GET_BOOK_METADATA {u'index': 154}
SMART_DEV (2175.03: 0.222) _call_client GET_BOOK_METADATA {u'index': 155}
SMART_DEV (2175.33: 0.208) _call_client GET_BOOK_METADATA {u'index': 156}
SMART_DEV (2175.62: 0.209) _call_client GET_BOOK_METADATA {u'index': 157}
SMART_DEV (2175.93: 0.214) _call_client GET_BOOK_METADATA {u'index': 158}
SMART_DEV (2176.28: 0.259) _call_client GET_BOOK_METADATA {u'index': 159}
SMART_DEV (2176.66: 0.301) _call_client GET_BOOK_METADATA {u'index': 160}
SMART_DEV (2177.00: 0.246) _call_client GET_BOOK_METADATA {u'index': 161}
SMART_DEV (2177.38: 0.292) _call_client GET_BOOK_METADATA {u'index': 162}
SMART_DEV (2177.68: 0.212) _call_client GET_BOOK_METADATA {u'index': 163}
SMART_DEV (2177.99: 0.229) _call_client GET_BOOK_METADATA {u'index': 164}
SMART_DEV (2178.31: 0.221) _call_client GET_BOOK_METADATA {u'index': 165}
SMART_DEV (2178.64: 0.233) _call_client GET_BOOK_METADATA {u'index': 166}
SMART_DEV (2179.01: 0.287) _call_client GET_BOOK_METADATA {u'index': 167}
SMART_DEV (2179.32: 0.213) _call_client GET_BOOK_METADATA {u'index': 168}
SMART_DEV (2179.95: 0.551) _call_client GET_BOOK_METADATA {u'index': 169}
SMART_DEV (2180.38: 0.343) _call_client GET_BOOK_METADATA {u'index': 170}
SMART_DEV (2180.73: 0.271) _call_client GET_BOOK_METADATA {u'index': 171}
SMART_DEV (2181.05: 0.238) _call_client GET_BOOK_METADATA {u'index': 172}
SMART_DEV (2181.35: 0.210) _call_client GET_BOOK_METADATA {u'index': 173}
SMART_DEV (2181.67: 0.228) _call_client GET_BOOK_METADATA {u'index': 174}
SMART_DEV (2181.98: 0.217) _call_client GET_BOOK_METADATA {u'index': 175}
SMART_DEV (2182.28: 0.215) _call_client GET_BOOK_METADATA {u'index': 176}
SMART_DEV (2182.59: 0.217) _call_client GET_BOOK_METADATA {u'index': 177}
SMART_DEV (2183.12: 0.450) _call_client GET_BOOK_METADATA {u'index': 178}
SMART_DEV (2183.41: 0.201) _call_client GET_BOOK_METADATA {u'index': 179}
SMART_DEV (2183.75: 0.247) _call_client GET_BOOK_METADATA {u'index': 180}
SMART_DEV (2184.13: 0.291) _call_client GET_BOOK_METADATA {u'index': 181}
SMART_DEV (2184.44: 0.221) _call_client GET_BOOK_METADATA {u'index': 182}
SMART_DEV (2184.75: 0.219) _call_client GET_BOOK_METADATA {u'index': 183}
SMART_DEV (2185.05: 0.221) _call_client GET_BOOK_METADATA {u'index': 184}
SMART_DEV (2185.35: 0.204) _call_client GET_BOOK_METADATA {u'index': 185}
SMART_DEV (2185.70: 0.265) _call_client GET_BOOK_METADATA {u'index': 186}
SMART_DEV (2186.21: 0.424) _call_client GET_BOOK_METADATA {u'index': 187}
SMART_DEV (2186.63: 0.330) _call_client GET_BOOK_METADATA {u'index': 188}
SMART_DEV (2187.02: 0.304) _call_client GET_BOOK_METADATA {u'index': 189}
SMART_DEV (2187.41: 0.288) _call_client GET_BOOK_METADATA {u'index': 190}
SMART_DEV (2187.75: 0.248) _call_client GET_BOOK_METADATA {u'index': 191}
SMART_DEV (2188.31: 0.477) _call_client GET_BOOK_METADATA {u'index': 192}
SMART_DEV (2188.67: 0.261) _call_client GET_BOOK_METADATA {u'index': 193}
SMART_DEV (2189.08: 0.250) _call_client GET_BOOK_METADATA {u'index': 194}
SMART_DEV (2189.49: 0.312) _call_client GET_BOOK_METADATA {u'index': 195}
SMART_DEV (2189.86: 0.262) _call_client GET_BOOK_METADATA {u'index': 196}
SMART_DEV (2190.17: 0.224) _call_client GET_BOOK_METADATA {u'index': 197}
SMART_DEV (2190.47: 0.208) _call_client GET_BOOK_METADATA {u'index': 198}
SMART_DEV (2190.82: 0.268) _call_client GET_BOOK_METADATA {u'index': 199}
SMART_DEV (2191.21: 0.296) _call_client GET_BOOK_METADATA {u'index': 200}
SMART_DEV (2191.64: 0.334) _call_client GET_BOOK_METADATA {u'index': 201}
SMART_DEV (2192.04: 0.319) _call_client GET_BOOK_METADATA {u'index': 202}
SMART_DEV (2192.46: 0.327) _call_client GET_BOOK_METADATA {u'index': 203}
SMART_DEV (2192.87: 0.319) _call_client GET_BOOK_METADATA {u'index': 204}
SMART_DEV (2193.25: 0.292) _call_client GET_BOOK_METADATA {u'index': 205}
SMART_DEV (2193.55: 0.209) _call_client GET_BOOK_METADATA {u'index': 206}
SMART_DEV (2193.86: 0.222) _call_client GET_BOOK_METADATA {u'index': 207}
SMART_DEV (2194.27: 0.303) _call_client GET_BOOK_METADATA {u'index': 208}
SMART_DEV (2194.71: 0.269) _call_client GET_BOOK_METADATA {u'index': 209}
SMART_DEV (2195.11: 0.303) _call_client GET_BOOK_METADATA {u'index': 210}
SMART_DEV (2195.43: 0.233) _call_client GET_BOOK_METADATA {u'index': 211}
SMART_DEV (2195.74: 0.235) _call_client GET_BOOK_METADATA {u'index': 212}
SMART_DEV (2196.12: 0.286) _call_client GET_BOOK_METADATA {u'index': 213}
SMART_DEV (2196.42: 0.210) _call_client GET_BOOK_METADATA {u'index': 214}
SMART_DEV (2196.72: 0.210) _call_client GET_BOOK_METADATA {u'index': 215}
SMART_DEV (2197.03: 0.220) _call_client GET_BOOK_METADATA {u'index': 216}
SMART_DEV (2197.37: 0.251) _call_client GET_BOOK_METADATA {u'index': 217}
SMART_DEV (2197.99: 0.528) _call_client GET_BOOK_METADATA {u'index': 218}
SMART_DEV (2198.37: 0.293) _call_client GET_BOOK_METADATA {u'index': 219}
SMART_DEV (2198.67: 0.203) _call_client GET_BOOK_METADATA {u'index': 220}
SMART_DEV (2198.98: 0.207) _call_client GET_BOOK_METADATA {u'index': 221}
SMART_DEV (2199.32: 0.254) _call_client GET_BOOK_METADATA {u'index': 222}
SMART_DEV (2199.73: 0.311) _call_client GET_BOOK_METADATA {u'index': 223}
SMART_DEV (2200.11: 0.288) _call_client GET_BOOK_METADATA {u'index': 224}
SMART_DEV (2200.44: 0.243) _call_client GET_BOOK_METADATA {u'index': 225}
SMART_DEV (2200.85: 0.318) _call_client GET_BOOK_METADATA {u'index': 226}
SMART_DEV (2201.52: 0.583) _call_client GET_BOOK_METADATA {u'index': 227}
SMART_DEV (2201.85: 0.235) _call_client GET_BOOK_METADATA {u'index': 228}
SMART_DEV (2202.19: 0.250) _call_client GET_BOOK_METADATA {u'index': 229}
SMART_DEV (2202.55: 0.281) _call_client GET_BOOK_METADATA {u'index': 230}
SMART_DEV (2202.91: 0.266) _call_client GET_BOOK_METADATA {u'index': 231}
SMART_DEV (2203.32: 0.332) _call_client GET_BOOK_METADATA {u'index': 232}
SMART_DEV (2203.86: 0.439) _call_client GET_BOOK_METADATA {u'index': 233}
SMART_DEV (2204.19: 0.240) _call_client GET_BOOK_METADATA {u'index': 234}
SMART_DEV (2204.50: 0.220) _call_client GET_BOOK_METADATA {u'index': 235}
SMART_DEV (2204.85: 0.259) _call_client GET_BOOK_METADATA {u'index': 236}
SMART_DEV (2205.21: 0.271) _call_client GET_BOOK_METADATA {u'index': 237}
SMART_DEV (2205.52: 0.212) _call_client GET_BOOK_METADATA {u'index': 238}
SMART_DEV (2205.83: 0.207) _call_client GET_BOOK_METADATA {u'index': 239}
SMART_DEV (2206.15: 0.214) _call_client GET_BOOK_METADATA {u'index': 240}
SMART_DEV (2206.49: 0.247) _call_client GET_BOOK_METADATA {u'index': 241}
SMART_DEV (2206.88: 0.307) _call_client GET_BOOK_METADATA {u'index': 242}
SMART_DEV (2207.31: 0.337) _call_client GET_BOOK_METADATA {u'index': 243}
SMART_DEV (2207.72: 0.325) _call_client GET_BOOK_METADATA {u'index': 244}
SMART_DEV (2208.12: 0.305) _call_client GET_BOOK_METADATA {u'index': 245}
SMART_DEV (2208.50: 0.289) _call_client GET_BOOK_METADATA {u'index': 246}
SMART_DEV (2208.80: 0.204) _call_client GET_BOOK_METADATA {u'index': 247}
SMART_DEV (2209.26: 0.379) _call_client GET_BOOK_METADATA {u'index': 248}
SMART_DEV (2209.62: 0.269) _call_client GET_BOOK_METADATA {u'index': 249}
SMART_DEV (2209.97: 0.260) _call_client GET_BOOK_METADATA {u'index': 250}
SMART_DEV (2210.41: 0.356) _call_client GET_BOOK_METADATA {u'index': 251}
SMART_DEV (2210.79: 0.291) _call_client GET_BOOK_METADATA {u'index': 252}
SMART_DEV (2211.19: 0.320) _call_client GET_BOOK_METADATA {u'index': 253}
SMART_DEV (2211.61: 0.334) _call_client GET_BOOK_METADATA {u'index': 254}
SMART_DEV (2212.22: 0.530) _call_client GET_BOOK_METADATA {u'index': 255}
SMART_DEV (2212.60: 0.294) _call_client GET_BOOK_METADATA {u'index': 256}
SMART_DEV (2212.91: 0.219) _call_client GET_BOOK_METADATA {u'index': 257}
SMART_DEV (2213.24: 0.244) _call_client GET_BOOK_METADATA {u'index': 258}
SMART_DEV (2213.61: 0.267) _call_client GET_BOOK_METADATA {u'index': 259}
SMART_DEV (2214.07: 0.383) _call_client GET_BOOK_METADATA {u'index': 260}
SMART_DEV (2214.48: 0.309) _call_client GET_BOOK_METADATA {u'index': 261}
SMART_DEV (2214.85: 0.281) _call_client GET_BOOK_METADATA {u'index': 262}
SMART_DEV (2215.16: 0.230) _call_client GET_BOOK_METADATA {u'index': 263}
SMART_DEV (2215.46: 0.209) _call_client GET_BOOK_METADATA {u'index': 264}
SMART_DEV (2215.80: 0.259) _call_client GET_BOOK_METADATA {u'index': 265}
SMART_DEV (2216.18: 0.294) _call_client GET_BOOK_METADATA {u'index': 266}
SMART_DEV (2216.49: 0.225) _call_client GET_BOOK_METADATA {u'index': 267}
SMART_DEV (2216.83: 0.249) _call_client GET_BOOK_METADATA {u'index': 268}
SMART_DEV (2217.20: 0.287) _call_client GET_BOOK_METADATA {u'index': 269}
SMART_DEV (2217.52: 0.225) _call_client GET_BOOK_METADATA {u'index': 270}
SMART_DEV (2217.82: 0.220) _call_client GET_BOOK_METADATA {u'index': 271}
SMART_DEV (2218.13: 0.217) _call_client GET_BOOK_METADATA {u'index': 272}
SMART_DEV (2218.43: 0.209) _call_client GET_BOOK_METADATA {u'index': 273}
SMART_DEV (2218.73: 0.209) _call_client GET_BOOK_METADATA {u'index': 274}
SMART_DEV (2219.06: 0.241) _call_client GET_BOOK_METADATA {u'index': 275}
SMART_DEV (2219.38: 0.232) _call_client GET_BOOK_METADATA {u'index': 276}
SMART_DEV (2219.77: 0.305) _call_client GET_BOOK_METADATA {u'index': 277}
SMART_DEV (2220.11: 0.254) _call_client GET_BOOK_METADATA {u'index': 278}
SMART_DEV (2220.48: 0.278) _call_client GET_BOOK_METADATA {u'index': 279}
SMART_DEV (2220.76: 0.196) _call_client GET_BOOK_METADATA {u'index': 280}
SMART_DEV (2221.13: 0.278) _call_client GET_BOOK_METADATA {u'index': 281}
SMART_DEV (2221.54: 0.319) _call_client GET_BOOK_METADATA {u'index': 282}
SMART_DEV (2221.93: 0.309) _call_client GET_BOOK_METADATA {u'index': 283}
SMART_DEV (2222.31: 0.284) _call_client GET_BOOK_METADATA {u'index': 284}
SMART_DEV (2222.63: 0.241) _call_client GET_BOOK_METADATA {u'index': 285}
SMART_DEV (2222.92: 0.200) _call_client GET_BOOK_METADATA {u'index': 286}
SMART_DEV (2223.28: 0.264) _call_client GET_BOOK_METADATA {u'index': 287}
SMART_DEV (2223.66: 0.283) _call_client GET_BOOK_METADATA {u'index': 288}
SMART_DEV (2223.99: 0.248) _call_client GET_BOOK_METADATA {u'index': 289}
SMART_DEV (2224.39: 0.307) _call_client GET_BOOK_METADATA {u'index': 290}
SMART_DEV (2224.75: 0.273) _call_client GET_BOOK_METADATA {u'index': 291}
SMART_DEV (2225.12: 0.280) _call_client GET_BOOK_METADATA {u'index': 292}
SMART_DEV (2225.50: 0.294) _call_client GET_BOOK_METADATA {u'index': 293}
SMART_DEV (2225.81: 0.217) _call_client GET_BOOK_METADATA {u'index': 294}
SMART_DEV (2226.13: 0.228) _call_client GET_BOOK_METADATA {u'index': 295}
SMART_DEV (2226.45: 0.245) _call_client GET_BOOK_METADATA {u'index': 296}
SMART_DEV (2226.83: 0.291) _call_client GET_BOOK_METADATA {u'index': 297}
SMART_DEV (2227.16: 0.244) _call_client GET_BOOK_METADATA {u'index': 298}
SMART_DEV (2227.63: 0.383) _call_client GET_BOOK_METADATA {u'index': 299}
SMART_DEV (2227.94: 0.217) _call_client GET_BOOK_METADATA {u'index': 300}
SMART_DEV (2228.24: 0.216) _call_client GET_BOOK_METADATA {u'index': 301}
SMART_DEV (2228.56: 0.225) _call_client GET_BOOK_METADATA {u'index': 302}
SMART_DEV (2228.87: 0.215) _call_client GET_BOOK_METADATA {u'index': 303}
SMART_DEV (2229.18: 0.223) _call_client GET_BOOK_METADATA {u'index': 304}
SMART_DEV (2229.50: 0.225) _call_client GET_BOOK_METADATA {u'index': 305}
SMART_DEV (2229.80: 0.207) _call_client GET_BOOK_METADATA {u'index': 306}
SMART_DEV (2230.32: 0.429) _call_client GET_BOOK_METADATA {u'index': 307}
SMART_DEV (2230.62: 0.217) _call_client GET_BOOK_METADATA {u'index': 308}
SMART_DEV (2230.96: 0.247) _call_client GET_BOOK_METADATA {u'index': 309}
SMART_DEV (2231.34: 0.294) _call_client GET_BOOK_METADATA {u'index': 310}
SMART_DEV (2231.64: 0.217) _call_client GET_BOOK_METADATA {u'index': 311}
SMART_DEV (2231.95: 0.218) _call_client GET_BOOK_METADATA {u'index': 312}
SMART_DEV (2232.25: 0.219) _call_client GET_BOOK_METADATA {u'index': 313}
SMART_DEV (2232.56: 0.219) books carda
SMART_DEV (2232.64: 0.000) books cardb
DeviceJob: 9 Get list of books on device done, calling callback
SMART_DEV (2246.57: 13.855) set_plugboards
DeviceJob: 9 Get list of books on device callback returned
SMART_DEV (2247.25: 0.615) set_progress_reporter
Job: 10 Send metadata to device started
SMART_DEV (2247.32: 0.010) sync_booklists collection attributes [u'']
DEBUG: 1137.7 Starting get_collections: on_connect
DEBUG: 1137.7 Renaming rules: {}
DEBUG: 1137.7 Formatting template: {value}{category:| (|)}
DEBUG: 1137.7 Sorting rules: []
SMART_DEV (2247.43: 0.041) _call_client SEND_BOOKLISTS {u'count': 314, u'collections': {}}
Job: 9 Get list of books on device finished
No details available.
SMART_DEV (2247.53: 0.001) _call_client send string [7, {"count": 314, "collections": {}}]
SMART_DEV (2247.94: 0.348) _call_client received string [0,{}]
SMART_DEV (2248.05: 0.001) _call_client receive after decode
SMART_DEV (2248.51: 0.332) card_prefix
SMART_DEV (2248.60: 0.000) free_space
SMART_DEV (2248.68: 0.004) _call_client FREE_SPACE {}
SMART_DEV (2248.76: 0.000) _call_client send string [5, {}]
SMART_DEV (2249.16: 0.316) _call_client received string [0,{"free_space_on_device":4639707136}]
SMART_DEV (2249.25: 0.000) _call_client receive after decode
DeviceJob: 10 Send metadata to device done, calling callback
DeviceJob: 10 Send metadata to device callback returned
SMART_DEV (2249.37: 0.024) _call_client NOOP {}
SMART_DEV (2249.46: 0.000) _call_client send string [12, {}]
SMART_DEV (2249.98: 0.442) _call_client received string [0,{}]
SMART_DEV (2250.07: 0.000) _call_client receive after decode
Job: 10 Send metadata to device finished
No details available.
SMART_DEV (2260.22: 10.061) _call_client NOOP {}
SMART_DEV (2260.32: 0.000) _call_client send string [12, {}]
SMART_DEV (2260.64: 0.232) _call_client received string [0,{}]
SMART_DEV (2260.73: 0.000) _call_client receive after decode
SMART_DEV (2270.88: 10.066) _call_client NOOP {}
SMART_DEV (2270.97: 0.000) _call_client send string [12, {}]
SMART_DEV (2271.49: 0.428) _call_client received string [0,{}]
SMART_DEV (2271.58: 0.000) _call_client receive after decode
SMART_DEV (2275.69: 4.022) _call_client NOOP {}
SMART_DEV (2275.78: 0.000) _call_client send string [12, {}]
SMART_DEV (2275.86: 0.001) _call_client received string
SMART_DEV (2275.95: 0.000) _call_client protocol error -- empty json string
SMART_DEV (2276.03: 0.000) post_yank_cleanup
SMART_DEV (2335.49: 59.389) reset
SMART_DEV (2335.58: 0.000) set_progress_reporter
SMART_DEV (2335.67: 0.000) open
SMART_DEV (2335.76: 0.010) _call_client GET_INITIALIZATION_INFO {u'validExtensions': ['lrf', 'rar', 'zip', 'rtf', 'lit', 'txt', 'txtz', 'text', 'htm', 'xhtm', 'html', 'htmlz', 'xhtml', 'pdf', 'pdb', 'updb', 'pdr', 'prc', 'mobi', 'azw', 'doc', 'epub', 'fb2', 'djv', 'djvu', 'lrx', 'cbr', 'cbz', 'cbc', 'oebzip', 'rb', 'imp', 'odt', 'chm', 'tpz', 'azw1', 'pml', 'pmlz', 'mbp', 'tan', 'snb', 'xps', 'oxps', 'azw4', 'book', 'zbf', 'pobi', 'docx', 'md', 'textile', 'markdown', 'ibook', 'iba', 'azw3', 'ps'], u'currentLibraryName': u'Calibre Library', u'currentLibraryUUID': u'7f7a8ee2-038e-40eb-a1c2-c5fac3831769', u'serverProtocolVersion': 1, u'passwordChallenge': u''}
SMART_DEV (2335.85: 0.001) _call_client send string [9, {"validExtensions": ["lrf", "rar", "zip", "rtf", "lit", "txt", "txtz", "text", "htm", "xhtm", "html", "htmlz", "xhtml", "pdf", "pdb", "updb", "pdr", "prc", "mobi", "azw", "doc", "epub", "fb2", "djv", "djvu", "lrx", "cbr", "cbz", "cbc", "oebzip", "rb", "imp", "odt", "chm", "tpz", "azw1", "pml", "pmlz", "mbp", "tan", "snb", "xps", "oxps", "azw4", "book", "zbf", "pobi", "docx", "md", "textile", "markdown", "ibook", "iba", "azw3", "ps"], "currentLibraryName": "Calibre Library", "currentLibraryUUID": "7f7a8ee2-038e-40eb-a1c2-c5fac3831769", "serverProtocolVersion": 1, "passwordChallenge": ""}]
SMART_DEV (2336.30: 0.372) _call_client received string [0,{"ccVersionNumber":6,"acceptedExtensions":["epub","mobi"],"passwordHash":"","versionOK":true,"maxBookConten tPacketLen":204800}]
SMART_DEV (2336.39: 0.000) _call_client receive after decode
SMART_DEV (2336.48: 0.000) open CC version #: 6
SMART_DEV (2336.57: 0.008) open selected formats [u'epub', u'mobi']
SMART_DEV (2336.64: 0.000) card_prefix
SMART_DEV (2336.79: 0.028) set_progress_reporter
Job: 11 Get device information started
SMART_DEV (2336.86: 0.000) get_device_information
SMART_DEV (2336.96: 0.005) _call_client GET_DEVICE_INFORMATION {}
SMART_DEV (2337.06: 0.000) _call_client send string [3, {}]
SMART_DEV (2337.53: 0.378) _call_client received string [0,{"device_info":{"last_library_uuid":"7f7a8ee2-038e-40eb-a1c2-c5fac3831769","calibre_version":"0.8.65","device_n ame":"SmartDevice","date_last_connected":"2012-08-18T09:53:05.921000+00:00","device_store_uuid":"16e a48c9-e0ea-4f9a-95cf-67e4ec12e2f9","location_code":"main","prefix":""}, "version":"6","device_version":"10, encore"}]
SMART_DEV (2337.62: 0.000) _call_client receive after decode
SMART_DEV (2337.71: 0.006) _call_client SET_CALIBRE_DEVICE_INFO {u'device_store_uuid': u'16ea48c9-e0ea-4f9a-95cf-67e4ec12e2f9', u'location_code': u'main', u'device_name': u'SmartDevice', u'calibre_version': u'0.8.65', u'prefix': u'', u'last_library_uuid': u'7f7a8ee2-038e-40eb-a1c2-c5fac3831769', u'date_last_connected': u'2012-08-18T09:57:02.340000+00:00'}
SMART_DEV (2337.80: 0.000) _call_client send string [1, {"device_store_uuid": "16ea48c9-e0ea-4f9a-95cf-67e4ec12e2f9", "location_code": "main", "device_name": "SmartDevice", "calibre_version": "0.8.65", "prefix": "", "last_library_uuid": "7f7a8ee2-038e-40eb-a1c2-c5fac3831769", "date_last_connected": "2012-08-18T09:57:02.340000+00:00"}]
SMART_DEV (2338.25: 0.364) _call_client received string [0,{}]
SMART_DEV (2338.33: 0.000) _call_client receive after decode
SMART_DEV (2338.42: 0.000) card_prefix
SMART_DEV (2338.50: 0.000) free_space
SMART_DEV (2338.63: 0.005) _call_client FREE_SPACE {}
SMART_DEV (2338.72: 0.001) _call_client send string [5, {}]
SMART_DEV (2339.07: 0.276) _call_client received string [0,{"free_space_on_device":4639707136}]
SMART_DEV (2339.15: 0.001) _call_client receive after decode
DeviceJob: 11 Get device information done, calling callback
DeviceJob: 11 Get device information callback returned
SMART_DEV (2339.25: 0.006) set_progress_reporter
Job: 12 Get list of books on device started
SMART_DEV (2339.31: 0.000) books None
SMART_DEV (2339.40: 0.008) _call_client GET_BOOK_COUNT {}
Job: 11 Get device information finished
No details available.
SMART_DEV (2339.48: 0.000) _call_client send string [6, {}]
SMART_DEV (2358.42: 18.844) _call_client received string [0,{"count":314}]
SMART_DEV (2358.51: 0.000) _call_client receive after decode
SMART_DEV (2358.61: 0.006) _call_client GET_BOOK_METADATA {u'index': 0}
SMART_DEV (2358.98: 0.260) _call_client GET_BOOK_METADATA {u'index': 1}
SMART_DEV (2359.28: 0.205) _call_client GET_BOOK_METADATA {u'index': 2}
SMART_DEV (2359.56: 0.202) _call_client GET_BOOK_METADATA {u'index': 3}
SMART_DEV (2359.86: 0.208) _call_client GET_BOOK_METADATA {u'index': 4}
SMART_DEV (2360.08: 0.133) _call_client GET_BOOK_METADATA {u'index': 5}
SMART_DEV (2360.38: 0.212) _call_client GET_BOOK_METADATA {u'index': 6}
SMART_DEV (2360.69: 0.214) _call_client GET_BOOK_METADATA {u'index': 7}
SMART_DEV (2361.01: 0.241) _call_client GET_BOOK_METADATA {u'index': 8}
SMART_DEV (2361.30: 0.199) _call_client GET_BOOK_METADATA {u'index': 9}
SMART_DEV (2361.61: 0.199) _call_client GET_BOOK_METADATA {u'index': 10}
SMART_DEV (2361.81: 0.115) _call_client GET_BOOK_METADATA {u'index': 11}
SMART_DEV (2362.13: 0.232) _call_client GET_BOOK_METADATA {u'index': 12}
SMART_DEV (2362.64: 0.419) _call_client GET_BOOK_METADATA {u'index': 13}
SMART_DEV (2362.94: 0.218) _call_client GET_BOOK_METADATA {u'index': 14}
SMART_DEV (2363.16: 0.135) _call_client GET_BOOK_METADATA {u'index': 15}
SMART_DEV (2363.48: 0.233) _call_client GET_BOOK_METADATA {u'index': 16}
SMART_DEV (2363.76: 0.187) _call_client GET_BOOK_METADATA {u'index': 17}
SMART_DEV (2364.25: 0.411) _call_client GET_BOOK_METADATA {u'index': 18}
SMART_DEV (2364.48: 0.135) _call_client GET_BOOK_METADATA {u'index': 19}
SMART_DEV (2364.78: 0.214) _call_client GET_BOOK_METADATA {u'index': 20}
SMART_DEV (2365.09: 0.225) _call_client GET_BOOK_METADATA {u'index': 21}
SMART_DEV (2365.40: 0.220) _call_client GET_BOOK_METADATA {u'index': 22}
SMART_DEV (2365.81: 0.327) _call_client GET_BOOK_METADATA {u'index': 23}
SMART_DEV (2366.12: 0.217) _call_client GET_BOOK_METADATA {u'index': 24}
SMART_DEV (2366.43: 0.226) _call_client GET_BOOK_METADATA {u'index': 25}
SMART_DEV (2367.03: 0.516) _call_client GET_BOOK_METADATA {u'index': 26}
SMART_DEV (2367.34: 0.210) _call_client GET_BOOK_METADATA {u'index': 27}
SMART_DEV (2367.54: 0.119) _call_client GET_BOOK_METADATA {u'index': 28}
SMART_DEV (2367.86: 0.221) _call_client GET_BOOK_METADATA {u'index': 29}
SMART_DEV (2368.18: 0.235) _call_client GET_BOOK_METADATA {u'index': 30}
SMART_DEV (2368.48: 0.215) _call_client GET_BOOK_METADATA {u'index': 31}
SMART_DEV (2368.77: 0.193) _call_client GET_BOOK_METADATA {u'index': 32}
SMART_DEV (2369.08: 0.216) _call_client GET_BOOK_METADATA {u'index': 33}
SMART_DEV (2369.40: 0.228) _call_client GET_BOOK_METADATA {u'index': 34}
SMART_DEV (2369.71: 0.229) _call_client GET_BOOK_METADATA {u'index': 35}
SMART_DEV (2370.00: 0.205) _call_client GET_BOOK_METADATA {u'index': 36}
SMART_DEV (2370.31: 0.217) _call_client GET_BOOK_METADATA {u'index': 37}
SMART_DEV (2370.62: 0.204) _call_client GET_BOOK_METADATA {u'index': 38}
SMART_DEV (2370.93: 0.227) _call_client GET_BOOK_METADATA {u'index': 39}
SMART_DEV (2371.23: 0.208) _call_client GET_BOOK_METADATA {u'index': 40}
SMART_DEV (2371.54: 0.220) _call_client GET_BOOK_METADATA {u'index': 41}
SMART_DEV (2371.87: 0.234) _call_client GET_BOOK_METADATA {u'index': 42}
SMART_DEV (2372.16: 0.198) _call_client GET_BOOK_METADATA {u'index': 43}
SMART_DEV (2372.48: 0.239) _call_client GET_BOOK_METADATA {u'index': 44}
SMART_DEV (2372.77: 0.192) _call_client GET_BOOK_METADATA {u'index': 45}
SMART_DEV (2372.99: 0.143) _call_client GET_BOOK_METADATA {u'index': 46}
SMART_DEV (2373.45: 0.372) _call_client GET_BOOK_METADATA {u'index': 47}
SMART_DEV (2373.70: 0.167) _call_client GET_BOOK_METADATA {u'index': 48}
SMART_DEV (2374.00: 0.199) _call_client GET_BOOK_METADATA {u'index': 49}
SMART_DEV (2374.30: 0.223) _call_client GET_BOOK_METADATA {u'index': 50}
SMART_DEV (2374.61: 0.217) _call_client GET_BOOK_METADATA {u'index': 51}
SMART_DEV (2375.28: 0.588) _call_client GET_BOOK_METADATA {u'index': 52}
SMART_DEV (2375.53: 0.157) _call_client GET_BOOK_METADATA {u'index': 53}
SMART_DEV (2375.84: 0.215) _call_client GET_BOOK_METADATA {u'index': 54}
SMART_DEV (2376.15: 0.227) _call_client GET_BOOK_METADATA {u'index': 55}
SMART_DEV (2376.49: 0.245) _call_client GET_BOOK_METADATA {u'index': 56}
SMART_DEV (2376.75: 0.175) _call_client GET_BOOK_METADATA {u'index': 57}
SMART_DEV (2377.11: 0.268) _call_client GET_BOOK_METADATA {u'index': 58}
SMART_DEV (2377.38: 0.184) _call_client GET_BOOK_METADATA {u'index': 59}
SMART_DEV (2377.69: 0.218) _call_client GET_BOOK_METADATA {u'index': 60}
SMART_DEV (2377.99: 0.215) _call_client GET_BOOK_METADATA {u'index': 61}
SMART_DEV (2378.30: 0.222) _call_client GET_BOOK_METADATA {u'index': 62}
SMART_DEV (2378.61: 0.194) _call_client GET_BOOK_METADATA {u'index': 63}
SMART_DEV (2378.91: 0.193) _call_client GET_BOOK_METADATA {u'index': 64}
SMART_DEV (2379.23: 0.235) _call_client GET_BOOK_METADATA {u'index': 65}
SMART_DEV (2379.53: 0.202) _call_client GET_BOOK_METADATA {u'index': 66}
SMART_DEV (2379.82: 0.207) _call_client GET_BOOK_METADATA {u'index': 67}
SMART_DEV (2380.04: 0.130) _call_client GET_BOOK_METADATA {u'index': 68}
SMART_DEV (2380.35: 0.223) _call_client GET_BOOK_METADATA {u'index': 69}
SMART_DEV (2380.66: 0.223) _call_client GET_BOOK_METADATA {u'index': 70}
SMART_DEV (2380.96: 0.217) _call_client GET_BOOK_METADATA {u'index': 71}
SMART_DEV (2381.27: 0.219) _call_client GET_BOOK_METADATA {u'index': 72}
SMART_DEV (2381.57: 0.219) _call_client GET_BOOK_METADATA {u'index': 73}
SMART_DEV (2382.08: 0.415) _call_client GET_BOOK_METADATA {u'index': 74}
SMART_DEV (2382.29: 0.129) _call_client GET_BOOK_METADATA {u'index': 75}
SMART_DEV (2382.60: 0.217) _call_client GET_BOOK_METADATA {u'index': 76}
SMART_DEV (2382.91: 0.222) _call_client GET_BOOK_METADATA {u'index': 77}
SMART_DEV (2383.21: 0.218) _call_client GET_BOOK_METADATA {u'index': 78}
SMART_DEV (2383.52: 0.220) _call_client GET_BOOK_METADATA {u'index': 79}
SMART_DEV (2383.74: 0.116) _call_client GET_BOOK_METADATA {u'index': 80}
SMART_DEV (2384.03: 0.195) _call_client GET_BOOK_METADATA {u'index': 81}
SMART_DEV (2384.34: 0.216) _call_client GET_BOOK_METADATA {u'index': 82}
SMART_DEV (2384.67: 0.247) _call_client GET_BOOK_METADATA {u'index': 83}
SMART_DEV (2384.95: 0.200) _call_client GET_BOOK_METADATA {u'index': 84}
SMART_DEV (2385.26: 0.215) _call_client GET_BOOK_METADATA {u'index': 85}
SMART_DEV (2385.46: 0.123) _call_client GET_BOOK_METADATA {u'index': 86}
SMART_DEV (2385.77: 0.218) _call_client GET_BOOK_METADATA {u'index': 87}
SMART_DEV (2386.07: 0.215) _call_client GET_BOOK_METADATA {u'index': 88}
SMART_DEV (2386.28: 0.124) _call_client GET_BOOK_METADATA {u'index': 89}
SMART_DEV (2386.59: 0.224) _call_client GET_BOOK_METADATA {u'index': 90}
SMART_DEV (2387.00: 0.324) _call_client GET_BOOK_METADATA {u'index': 91}
SMART_DEV (2387.62: 0.527) _call_client GET_BOOK_METADATA {u'index': 92}
SMART_DEV (2387.92: 0.216) _call_client GET_BOOK_METADATA {u'index': 93}
SMART_DEV (2388.23: 0.224) _call_client GET_BOOK_METADATA {u'index': 94}
SMART_DEV (2388.54: 0.222) _call_client GET_BOOK_METADATA {u'index': 95}
SMART_DEV (2388.85: 0.197) _call_client GET_BOOK_METADATA {u'index': 96}
SMART_DEV (2389.25: 0.324) _call_client GET_BOOK_METADATA {u'index': 97}
SMART_DEV (2389.65: 0.314) _call_client GET_BOOK_METADATA {u'index': 98}
SMART_DEV (2390.19: 0.447) _call_client GET_BOOK_METADATA {u'index': 99}
SMART_DEV (2390.56: 0.269) _call_client GET_BOOK_METADATA {u'index': 100}
SMART_DEV (2390.86: 0.204) _call_client GET_BOOK_METADATA {u'index': 101}
SMART_DEV (2391.17: 0.225) _call_client GET_BOOK_METADATA {u'index': 102}
SMART_DEV (2391.48: 0.222) _call_client GET_BOOK_METADATA {u'index': 103}
SMART_DEV (2392.03: 0.467) _call_client GET_BOOK_METADATA {u'index': 104}
SMART_DEV (2392.42: 0.307) _call_client GET_BOOK_METADATA {u'index': 105}
SMART_DEV (2392.80: 0.285) _call_client GET_BOOK_METADATA {u'index': 106}
SMART_DEV (2393.11: 0.222) _call_client GET_BOOK_METADATA {u'index': 107}
SMART_DEV (2393.43: 0.237) _call_client GET_BOOK_METADATA {u'index': 108}
SMART_DEV (2393.76: 0.246) _call_client GET_BOOK_METADATA {u'index': 109}
SMART_DEV (2394.14: 0.290) _call_client GET_BOOK_METADATA {u'index': 110}
SMART_DEV (2394.48: 0.246) _call_client GET_BOOK_METADATA {u'index': 111}
SMART_DEV (2394.89: 0.326) _call_client GET_BOOK_METADATA {u'index': 112}
SMART_DEV (2395.30: 0.326) _call_client GET_BOOK_METADATA {u'index': 113}
SMART_DEV (2395.67: 0.290) _call_client GET_BOOK_METADATA {u'index': 114}
SMART_DEV (2396.06: 0.298) _call_client GET_BOOK_METADATA {u'index': 115}
SMART_DEV (2396.38: 0.238) _call_client GET_BOOK_METADATA {u'index': 116}
SMART_DEV (2396.72: 0.248) _call_client GET_BOOK_METADATA {u'index': 117}
SMART_DEV (2397.01: 0.213) _call_client GET_BOOK_METADATA {u'index': 118}
SMART_DEV (2397.39: 0.281) _call_client GET_BOOK_METADATA {u'index': 119}
SMART_DEV (2397.75: 0.280) _call_client GET_BOOK_METADATA {u'index': 120}
SMART_DEV (2398.13: 0.290) _call_client GET_BOOK_METADATA {u'index': 121}
SMART_DEV (2398.44: 0.229) _call_client GET_BOOK_METADATA {u'index': 122}
SMART_DEV (2398.74: 0.212) _call_client GET_BOOK_METADATA {u'index': 123}
SMART_DEV (2399.05: 0.218) _call_client GET_BOOK_METADATA {u'index': 124}
SMART_DEV (2399.42: 0.282) _call_client GET_BOOK_METADATA {u'index': 125}
SMART_DEV (2399.75: 0.246) _call_client GET_BOOK_METADATA {u'index': 126}
SMART_DEV (2400.09: 0.251) _call_client GET_BOOK_METADATA {u'index': 127}
SMART_DEV (2400.45: 0.275) _call_client GET_BOOK_METADATA {u'index': 128}
SMART_DEV (2400.82: 0.284) _call_client GET_BOOK_METADATA {u'index': 129}
SMART_DEV (2401.23: 0.320) _call_client GET_BOOK_METADATA {u'index': 130}
SMART_DEV (2401.61: 0.289) _call_client GET_BOOK_METADATA {u'index': 131}
SMART_DEV (2401.95: 0.247) _call_client GET_BOOK_METADATA {u'index': 132}
SMART_DEV (2402.36: 0.328) _call_client GET_BOOK_METADATA {u'index': 133}
SMART_DEV (2402.74: 0.268) _call_client GET_BOOK_METADATA {u'index': 134}
SMART_DEV (2403.29: 0.452) _call_client GET_BOOK_METADATA {u'index': 135}
SMART_DEV (2403.70: 0.309) _call_client GET_BOOK_METADATA {u'index': 136}
SMART_DEV (2404.07: 0.275) _call_client GET_BOOK_METADATA {u'index': 137}
SMART_DEV (2404.46: 0.296) _call_client GET_BOOK_METADATA {u'index': 138}
SMART_DEV (2404.79: 0.233) _call_client GET_BOOK_METADATA {u'index': 139}
SMART_DEV (2405.08: 0.214) _call_client GET_BOOK_METADATA {u'index': 140}
SMART_DEV (2405.43: 0.257) _call_client GET_BOOK_METADATA {u'index': 141}
SMART_DEV (2405.79: 0.258) _call_client GET_BOOK_METADATA {u'index': 142}
SMART_DEV (2406.11: 0.231) _call_client GET_BOOK_METADATA {u'index': 143}
SMART_DEV (2406.62: 0.423) _call_client GET_BOOK_METADATA {u'index': 144}
SMART_DEV (2406.93: 0.223) _call_client GET_BOOK_METADATA {u'index': 145}
SMART_DEV (2407.27: 0.251) _call_client GET_BOOK_METADATA {u'index': 146}
SMART_DEV (2407.68: 0.318) _call_client GET_BOOK_METADATA {u'index': 147}
SMART_DEV (2408.06: 0.291) _call_client GET_BOOK_METADATA {u'index': 148}
SMART_DEV (2408.37: 0.213) _call_client GET_BOOK_METADATA {u'index': 149}
SMART_DEV (2408.67: 0.214) _call_client GET_BOOK_METADATA {u'index': 150}
SMART_DEV (2408.99: 0.215) _call_client GET_BOOK_METADATA {u'index': 151}
SMART_DEV (2409.30: 0.222) _call_client GET_BOOK_METADATA {u'index': 152}
SMART_DEV (2409.85: 0.446) _call_client GET_BOOK_METADATA {u'index': 153}
SMART_DEV (2410.24: 0.310) _call_client GET_BOOK_METADATA {u'index': 154}
SMART_DEV (2410.66: 0.328) _call_client GET_BOOK_METADATA {u'index': 155}
SMART_DEV (2411.04: 0.285) _call_client GET_BOOK_METADATA {u'index': 156}
SMART_DEV (2411.35: 0.227) _call_client GET_BOOK_METADATA {u'index': 157}
SMART_DEV (2411.65: 0.219) _call_client GET_BOOK_METADATA {u'index': 158}
SMART_DEV (2411.95: 0.208) _call_client GET_BOOK_METADATA {u'index': 159}
SMART_DEV (2412.26: 0.226) _call_client GET_BOOK_METADATA {u'index': 160}
SMART_DEV (2412.79: 0.438) _call_client GET_BOOK_METADATA {u'index': 161}
SMART_DEV (2413.08: 0.209) _call_client GET_BOOK_METADATA {u'index': 162}
SMART_DEV (2413.39: 0.216) _call_client GET_BOOK_METADATA {u'index': 163}
SMART_DEV (2413.69: 0.218) _call_client GET_BOOK_METADATA {u'index': 164}
SMART_DEV (2414.01: 0.211) _call_client GET_BOOK_METADATA {u'index': 165}
SMART_DEV (2414.32: 0.225) _call_client GET_BOOK_METADATA {u'index': 166}
SMART_DEV (2414.62: 0.209) _call_client GET_BOOK_METADATA {u'index': 167}
SMART_DEV (2414.91: 0.200) _call_client GET_BOOK_METADATA {u'index': 168}
SMART_DEV (2415.40: 0.401) _call_client GET_BOOK_METADATA {u'index': 169}
SMART_DEV (2415.78: 0.282) _call_client GET_BOOK_METADATA {u'index': 170}
SMART_DEV (2416.16: 0.291) _call_client GET_BOOK_METADATA {u'index': 171}
SMART_DEV (2416.47: 0.224) _call_client GET_BOOK_METADATA {u'index': 172}
SMART_DEV (2416.77: 0.206) _call_client GET_BOOK_METADATA {u'index': 173}
SMART_DEV (2417.08: 0.212) _call_client GET_BOOK_METADATA {u'index': 174}
SMART_DEV (2417.60: 0.305) _call_client GET_BOOK_METADATA {u'index': 175}
SMART_DEV (2418.03: 0.322) _call_client GET_BOOK_METADATA {u'index': 176}
SMART_DEV (2418.44: 0.301) _call_client GET_BOOK_METADATA {u'index': 177}
SMART_DEV (2418.92: 0.410) _call_client GET_BOOK_METADATA {u'index': 178}
SMART_DEV (2419.21: 0.198) _call_client GET_BOOK_METADATA {u'index': 179}
SMART_DEV (2419.53: 0.236) _call_client GET_BOOK_METADATA {u'index': 180}
SMART_DEV (2419.83: 0.212) _call_client GET_BOOK_METADATA {u'index': 181}
SMART_DEV (2420.18: 0.255) _call_client GET_BOOK_METADATA {u'index': 182}
SMART_DEV (2420.56: 0.291) _call_client GET_BOOK_METADATA {u'index': 183}
SMART_DEV (2420.86: 0.210) _call_client GET_BOOK_METADATA {u'index': 184}
SMART_DEV (2421.17: 0.226) _call_client GET_BOOK_METADATA {u'index': 185}
SMART_DEV (2421.56: 0.300) _call_client GET_BOOK_METADATA {u'index': 186}
SMART_DEV (2421.91: 0.266) _call_client GET_BOOK_METADATA {u'index': 187}
SMART_DEV (2422.32: 0.318) _call_client GET_BOOK_METADATA {u'index': 188}
SMART_DEV (2422.72: 0.311) _call_client GET_BOOK_METADATA {u'index': 189}
SMART_DEV (2423.02: 0.203) _call_client GET_BOOK_METADATA {u'index': 190}
SMART_DEV (2423.33: 0.225) _call_client GET_BOOK_METADATA {u'index': 191}
SMART_DEV (2423.87: 0.452) _call_client GET_BOOK_METADATA {u'index': 192}
SMART_DEV (2424.24: 0.285) _call_client GET_BOOK_METADATA {u'index': 193}
SMART_DEV (2424.54: 0.206) _call_client GET_BOOK_METADATA {u'index': 194}
SMART_DEV (2424.89: 0.255) _call_client GET_BOOK_METADATA {u'index': 195}
SMART_DEV (2425.26: 0.290) _call_client GET_BOOK_METADATA {u'index': 196}
SMART_DEV (2425.60: 0.255) _call_client GET_BOOK_METADATA {u'index': 197}
SMART_DEV (2426.11: 0.425) _call_client GET_BOOK_METADATA {u'index': 198}
SMART_DEV (2426.52: 0.323) _call_client GET_BOOK_METADATA {u'index': 199}
SMART_DEV (2427.11: 0.496) _call_client GET_BOOK_METADATA {u'index': 200}
SMART_DEV (2427.41: 0.216) _call_client GET_BOOK_METADATA {u'index': 201}
SMART_DEV (2427.71: 0.217) _call_client GET_BOOK_METADATA {u'index': 202}
SMART_DEV (2428.03: 0.225) _call_client GET_BOOK_METADATA {u'index': 203}
SMART_DEV (2428.34: 0.225) _call_client GET_BOOK_METADATA {u'index': 204}
SMART_DEV (2428.63: 0.207) _call_client GET_BOOK_METADATA {u'index': 205}
SMART_DEV (2428.98: 0.248) _call_client GET_BOOK_METADATA {u'index': 206}
SMART_DEV (2429.35: 0.284) _call_client GET_BOOK_METADATA {u'index': 207}
SMART_DEV (2429.70: 0.253) _call_client GET_BOOK_METADATA {u'index': 208}
SMART_DEV (2430.00: 0.220) _call_client GET_BOOK_METADATA {u'index': 209}
SMART_DEV (2430.42: 0.332) _call_client GET_BOOK_METADATA {u'index': 210}
SMART_DEV (2430.81: 0.305) _call_client GET_BOOK_METADATA {u'index': 211}
SMART_DEV (2431.12: 0.230) _call_client GET_BOOK_METADATA {u'index': 212}
SMART_DEV (2431.42: 0.211) _call_client GET_BOOK_METADATA {u'index': 213}
SMART_DEV (2431.73: 0.222) _call_client GET_BOOK_METADATA {u'index': 214}
SMART_DEV (2432.06: 0.245) _call_client GET_BOOK_METADATA {u'index': 215}
SMART_DEV (2432.46: 0.310) _call_client GET_BOOK_METADATA {u'index': 216}
SMART_DEV (2432.87: 0.326) _call_client GET_BOOK_METADATA {u'index': 217}
SMART_DEV (2433.45: 0.474) _call_client GET_BOOK_METADATA {u'index': 218}
SMART_DEV (2433.75: 0.201) _call_client GET_BOOK_METADATA {u'index': 219}
SMART_DEV (2434.14: 0.287) _call_client GET_BOOK_METADATA {u'index': 220}
SMART_DEV (2434.49: 0.266) _call_client GET_BOOK_METADATA {u'index': 221}
SMART_DEV (2434.79: 0.211) _call_client GET_BOOK_METADATA {u'index': 222}
SMART_DEV (2435.12: 0.234) _call_client GET_BOOK_METADATA {u'index': 223}
SMART_DEV (2435.40: 0.199) _call_client GET_BOOK_METADATA {u'index': 224}
SMART_DEV (2435.74: 0.247) _call_client GET_BOOK_METADATA {u'index': 225}
SMART_DEV (2436.12: 0.289) _call_client GET_BOOK_METADATA {u'index': 226}
SMART_DEV (2436.64: 0.439) _call_client GET_BOOK_METADATA {u'index': 227}
SMART_DEV (2436.94: 0.218) _call_client GET_BOOK_METADATA {u'index': 228}
SMART_DEV (2437.27: 0.237) _call_client GET_BOOK_METADATA {u'index': 229}
SMART_DEV (2437.58: 0.224) _call_client GET_BOOK_METADATA {u'index': 230}
SMART_DEV (2437.99: 0.322) _call_client GET_BOOK_METADATA {u'index': 231}
SMART_DEV (2438.42: 0.340) _call_client GET_BOOK_METADATA {u'index': 232}
SMART_DEV (2439.03: 0.516) _call_client GET_BOOK_METADATA {u'index': 233}
SMART_DEV (2439.40: 0.280) _call_client GET_BOOK_METADATA {u'index': 234}
SMART_DEV (2439.70: 0.206) _call_client GET_BOOK_METADATA {u'index': 235}
SMART_DEV (2440.00: 0.219) _call_client GET_BOOK_METADATA {u'index': 236}
SMART_DEV (2440.31: 0.218) _call_client GET_BOOK_METADATA {u'index': 237}
SMART_DEV (2440.65: 0.259) _call_client GET_BOOK_METADATA {u'index': 238}
SMART_DEV (2441.03: 0.287) _call_client GET_BOOK_METADATA {u'index': 239}
SMART_DEV (2441.34: 0.217) _call_client GET_BOOK_METADATA {u'index': 240}
SMART_DEV (2441.65: 0.223) _call_client GET_BOOK_METADATA {u'index': 241}
SMART_DEV (2441.97: 0.231) _call_client GET_BOOK_METADATA {u'index': 242}
SMART_DEV (2442.33: 0.274) _call_client GET_BOOK_METADATA {u'index': 243}
SMART_DEV (2442.71: 0.275) _call_client GET_BOOK_METADATA {u'index': 244}
SMART_DEV (2443.09: 0.291) _call_client GET_BOOK_METADATA {u'index': 245}
SMART_DEV (2443.37: 0.194) _call_client GET_BOOK_METADATA {u'index': 246}
SMART_DEV (2443.69: 0.228) _call_client GET_BOOK_METADATA {u'index': 247}
SMART_DEV (2444.18: 0.389) _call_client GET_BOOK_METADATA {u'index': 248}
SMART_DEV (2444.54: 0.275) _call_client GET_BOOK_METADATA {u'index': 249}
SMART_DEV (2444.82: 0.201) _call_client GET_BOOK_METADATA {u'index': 250}
SMART_DEV (2445.14: 0.222) _call_client GET_BOOK_METADATA {u'index': 251}
SMART_DEV (2445.44: 0.218) _call_client GET_BOOK_METADATA {u'index': 252}
SMART_DEV (2445.78: 0.254) _call_client GET_BOOK_METADATA {u'index': 253}
SMART_DEV (2446.15: 0.284) _call_client GET_BOOK_METADATA {u'index': 254}
SMART_DEV (2446.70: 0.459) _call_client GET_BOOK_METADATA {u'index': 255}
SMART_DEV (2447.07: 0.291) _call_client GET_BOOK_METADATA {u'index': 256}
SMART_DEV (2447.38: 0.213) _call_client GET_BOOK_METADATA {u'index': 257}
SMART_DEV (2447.67: 0.210) _call_client GET_BOOK_METADATA {u'index': 258}
SMART_DEV (2447.98: 0.216) _call_client GET_BOOK_METADATA {u'index': 259}
SMART_DEV (2448.29: 0.232) _call_client GET_BOOK_METADATA {u'index': 260}
SMART_DEV (2448.64: 0.259) _call_client GET_BOOK_METADATA {u'index': 261}
SMART_DEV (2449.03: 0.284) _call_client GET_BOOK_METADATA {u'index': 262}
SMART_DEV (2449.33: 0.216) _call_client GET_BOOK_METADATA {u'index': 263}
SMART_DEV (2449.64: 0.225) _call_client GET_BOOK_METADATA {u'index': 264}
SMART_DEV (2449.95: 0.216) _call_client GET_BOOK_METADATA {u'index': 265}
SMART_DEV (2450.28: 0.246) _call_client GET_BOOK_METADATA {u'index': 266}
SMART_DEV (2450.66: 0.295) _call_client GET_BOOK_METADATA {u'index': 267}
SMART_DEV (2450.97: 0.211) _call_client GET_BOOK_METADATA {u'index': 268}
SMART_DEV (2451.29: 0.239) _call_client GET_BOOK_METADATA {u'index': 269}
SMART_DEV (2451.82: 0.441) _call_client GET_BOOK_METADATA {u'index': 270}
SMART_DEV (2452.19: 0.280) _call_client GET_BOOK_METADATA {u'index': 271}
SMART_DEV (2452.54: 0.261) _call_client GET_BOOK_METADATA {u'index': 272}
SMART_DEV (2452.90: 0.279) _call_client GET_BOOK_METADATA {u'index': 273}
SMART_DEV (2453.25: 0.266) _call_client GET_BOOK_METADATA {u'index': 274}
SMART_DEV (2453.65: 0.307) _call_client GET_BOOK_METADATA {u'index': 275}
SMART_DEV (2454.04: 0.284) _call_client GET_BOOK_METADATA {u'index': 276}
SMART_DEV (2454.37: 0.243) _call_client GET_BOOK_METADATA {u'index': 277}
SMART_DEV (2454.87: 0.423) _call_client GET_BOOK_METADATA {u'index': 278}
SMART_DEV (2455.16: 0.196) _call_client GET_BOOK_METADATA {u'index': 279}
SMART_DEV (2455.46: 0.216) _call_client GET_BOOK_METADATA {u'index': 280}
SMART_DEV (2455.78: 0.225) _call_client GET_BOOK_METADATA {u'index': 281}
SMART_DEV (2456.16: 0.299) _call_client GET_BOOK_METADATA {u'index': 282}
SMART_DEV (2456.53: 0.283) _call_client GET_BOOK_METADATA {u'index': 283}
SMART_DEV (2456.89: 0.276) _call_client GET_BOOK_METADATA {u'index': 284}
SMART_DEV (2457.40: 0.419) _call_client GET_BOOK_METADATA {u'index': 285}
SMART_DEV (2457.71: 0.228) _call_client GET_BOOK_METADATA {u'index': 286}
SMART_DEV (2458.04: 0.234) _call_client GET_BOOK_METADATA {u'index': 287}
SMART_DEV (2458.35: 0.227) _call_client GET_BOOK_METADATA {u'index': 288}
SMART_DEV (2458.65: 0.209) _call_client GET_BOOK_METADATA {u'index': 289}
SMART_DEV (2458.96: 0.219) _call_client GET_BOOK_METADATA {u'index': 290}
SMART_DEV (2459.29: 0.243) _call_client GET_BOOK_METADATA {u'index': 291}
SMART_DEV (2459.87: 0.493) _call_client GET_BOOK_METADATA {u'index': 292}
SMART_DEV (2460.18: 0.224) _call_client GET_BOOK_METADATA {u'index': 293}
SMART_DEV (2460.49: 0.220) _call_client GET_BOOK_METADATA {u'index': 294}
SMART_DEV (2460.83: 0.251) _call_client GET_BOOK_METADATA {u'index': 295}
SMART_DEV (2461.20: 0.288) _call_client GET_BOOK_METADATA {u'index': 296}
SMART_DEV (2461.51: 0.229) _call_client GET_BOOK_METADATA {u'index': 297}
SMART_DEV (2461.85: 0.251) _call_client GET_BOOK_METADATA {u'index': 298}
SMART_DEV (2462.12: 0.181) _call_client GET_BOOK_METADATA {u'index': 299}
SMART_DEV (2462.61: 0.412) _call_client GET_BOOK_METADATA {u'index': 300}
SMART_DEV (2462.94: 0.243) _call_client GET_BOOK_METADATA {u'index': 301}
SMART_DEV (2463.29: 0.254) _call_client GET_BOOK_METADATA {u'index': 302}
SMART_DEV (2463.69: 0.323) _call_client GET_BOOK_METADATA {u'index': 303}
SMART_DEV (2464.07: 0.278) _call_client GET_BOOK_METADATA {u'index': 304}
SMART_DEV (2464.38: 0.223) _call_client GET_BOOK_METADATA {u'index': 305}
SMART_DEV (2464.68: 0.220) _call_client GET_BOOK_METADATA {u'index': 306}
SMART_DEV (2464.99: 0.222) _call_client GET_BOOK_METADATA {u'index': 307}
SMART_DEV (2465.30: 0.224) _call_client GET_BOOK_METADATA {u'index': 308}
SMART_DEV (2465.82: 0.433) _call_client GET_BOOK_METADATA {u'index': 309}
SMART_DEV (2466.15: 0.250) _call_client GET_BOOK_METADATA {u'index': 310}
SMART_DEV (2466.54: 0.299) _call_client GET_BOOK_METADATA {u'index': 311}
SMART_DEV (2466.87: 0.247) _call_client GET_BOOK_METADATA {u'index': 312}
SMART_DEV (2467.24: 0.285) _call_client GET_BOOK_METADATA {u'index': 313}
SMART_DEV (2467.55: 0.223) books carda
SMART_DEV (2467.63: 0.000) books cardb
DeviceJob: 12 Get list of books on device done, calling callback
SMART_DEV (2482.65: 14.942) set_plugboards
DeviceJob: 12 Get list of books on device callback returned
Job: 12 Get list of books on device finished
No details available.
SMART_DEV (2483.32: 0.603) set_progress_reporter
Job: 13 Send metadata to device started
SMART_DEV (2483.37: 0.003) sync_booklists collection attributes [u'']
DEBUG: 1373.7 Starting get_collections: on_connect
DEBUG: 1373.7 Renaming rules: {}
DEBUG: 1373.7 Formatting template: {value}{category:| (|)}
DEBUG: 1373.7 Sorting rules: []
SMART_DEV (2483.46: 0.032) _call_client SEND_BOOKLISTS {u'count': 314, u'collections': {}}
SMART_DEV (2483.51: 0.000) _call_client send string [7, {"count": 314, "collections": {}}]
SMART_DEV (2483.95: 0.398) _call_client received string [0,{}]
SMART_DEV (2484.04: 0.001) _call_client receive after decode
SMART_DEV (2484.43: 0.307) card_prefix
SMART_DEV (2484.51: 0.000) free_space
SMART_DEV (2484.60: 0.004) _call_client FREE_SPACE {}
SMART_DEV (2484.68: 0.001) _call_client send string [5, {}]
SMART_DEV (2485.18: 0.410) _call_client received string [0,{"free_space_on_device":4639707136}]
SMART_DEV (2485.27: 0.000) _call_client receive after decode
DeviceJob: 13 Send metadata to device done, calling callback
DeviceJob: 13 Send metadata to device callback returned
SMART_DEV (2485.38: 0.018) _call_client NOOP {}
SMART_DEV (2485.47: 0.000) _call_client send string [12, {}]
Job: 13 Send metadata to device finished
No details available.
SMART_DEV (2485.90: 0.361) _call_client received string [0,{}]
SMART_DEV (2485.99: 0.000) _call_client receive after decode
SMART_DEV (2496.14: 10.049) _call_client NOOP {}
SMART_DEV (2496.22: 0.000) _call_client send string [12, {}]
SMART_DEV (2496.65: 0.331) _call_client received string [0,{}]
SMART_DEV (2496.73: 0.000) _call_client receive after decode
SMART_DEV (2506.87: 10.052) _call_client NOOP {}
SMART_DEV (2506.96: 0.000) _call_client send string [12, {}]
SMART_DEV (2507.40: 0.358) _call_client received string [0,{}]
SMART_DEV (2507.48: 0.000) _call_client receive after decode
SMART_DEV (2517.61: 10.047) _call_client NOOP {}
SMART_DEV (2517.70: 0.000) _call_client send string [12, {}]
SMART_DEV (2518.63: 0.844) _call_client received string [0,{}]
SMART_DEV (2518.71: 0.002) _call_client receive after decode
SMART_DEV (2528.91: 10.051) _call_client NOOP {}
SMART_DEV (2529.03: 0.000) _call_client send string [12, {}]
SMART_DEV (2529.52: 0.393) _call_client received string [0,{}]
SMART_DEV (2529.63: 0.000) _call_client receive after decode
SMART_DEV (2539.76: 10.049) _call_client NOOP {}
SMART_DEV (2539.85: 0.000) _call_client send string [12, {}]
SMART_DEV (2540.27: 0.328) _call_client received string [0,{}]
SMART_DEV (2540.35: 0.000) _call_client receive after decode
SMART_DEV (2550.52: 10.075) _call_client NOOP {}
SMART_DEV (2550.70: 0.000) _call_client send string [12, {}]
SMART_DEV (2551.22: 0.327) _call_client received string [0,{}]
SMART_DEV (2551.40: 0.000) _call_client receive after decode
SMART_DEV (2561.58: 10.043) _call_client NOOP {}
SMART_DEV (2561.67: 0.000) _call_client send string [12, {}]
SMART_DEV (2562.08: 0.318) _call_client received string [0,{}]
SMART_DEV (2562.16: 0.000) _call_client receive after decode
SMART_DEV (2570.28: 8.028) set_progress_reporter
Job: 14 Delete books from device started
SMART_DEV (2570.36: 0.000) delete_books [u'Blue Diablo - Ann Aguirre.epub', u'Broken - Kelley Armstrong.epub', u'Darkest Kiss, The - Keri Arthur.epub', u'Diaries of an Urban Panther - Amanda Arista.epub', u'Dime Store Magic - Kelley Armstrong.epub', u'Doubleblind - Ann Aguirre.epub', u'Dragon Actually - G. A. Aiken.epub', u'Enclave - Ann Aguirre.epub', u"Fate's Edge - Ilona Andrews.epub", u'Granite Lake Wolves 2.1_ First Howl - Vivian Arend.epub', u'Grimspace - Ann Aguirre.epub', u'Haunted - Kelley Armstrong.epub', u'Hell Fire - Ann Aguirre.epub', u'Industrial Magic - Kelley Armstrong.epub', u'Killbox - Ann Aguirre.epub', u'Living With The Dead - Kelley Armstrong.epub', u'Magic Bites - Ilona Andrews.epub', u'Magic Bleeds - Ilona Andrews.epub', u'Magic Burns - Ilona Andrews.epub', u'Magic Mourns - Ilona Andrews.epub', u'Magic Strikes - Ilona Andrews.epub', u'No Humans Involved - Kelley Armstrong.epub', u'On the Edge - Ilona Andrews.epub', u'Personal Demon - Kelley Armstrong.epub', u'Reckoning, The - Kelley Armstrong.epub', u'Second Howl - Vivian Arend.epub', u'Shady Lady - Ann Aguirre.epub', u'Silent Blade - Ilona Andrews.epub', u'Stolen - Kelley Armstrong.epub', u'Stormy Seduction - Vivian Arend.epub', u'Summoning, The - Kelley Armstrong.epub', u'Wanderlust - Ann Aguirre.epub', u'Wolf Flight - Vivian Arend.epub', u'Wolf Games - Vivian Arend.epub', u'Wolf Signs - Vivian Arend.epub', u'Wolf Tracks - Vivian Arend.epub']
SMART_DEV (2570.45: 0.006) _call_client DELETE_BOOK {u'lpath': u'Blue Diablo - Ann Aguirre.epub'}
SMART_DEV (2570.54: 0.000) _call_client send string [13, {"lpath": "Blue Diablo - Ann Aguirre.epub"}]
SMART_DEV (2572.42: 1.701) _call_client received string [0,{"uuid":"d8ecc2a4-093b-4ce4-8cdc-a59545f44775"}]
SMART_DEV (2572.53: 0.000) _call_client receive after decode
SMART_DEV (2572.65: 0.000) delete_books removed book with UUID d8ecc2a4-093b-4ce4-8cdc-a59545f44775
SMART_DEV (2572.75: 0.005) _call_client DELETE_BOOK {u'lpath': u'Broken - Kelley Armstrong.epub'}
SMART_DEV (2572.85: 0.000) _call_client send string [13, {"lpath": "Broken - Kelley Armstrong.epub"}]
SMART_DEV (2575.43: 2.495) _call_client received string
SMART_DEV (2575.54: 0.000) _call_client protocol error -- empty json string
DeviceJob: 14 Delete books from device done, calling callback
Device responded with incorrect information

Traceback (most recent call last):
File "site-packages\calibre\gui2\device.py", line 83, in run
File "site-packages\calibre\gui2\device.py", line 502, in _delete_books
File "site-packages\calibre\devices\smart_device_app\driver.p y", line 44, in _synchronizer
File "site-packages\calibre\devices\smart_device_app\driver.p y", line 838, in delete_books
File "site-packages\calibre\devices\smart_device_app\driver.p y", line 425, in _call_client
ControlError: Device responded with incorrect information

DeviceJob: 14 Delete books from device callback returned
SMART_DEV (2576.02: 0.206) _call_client NOOP {}
SMART_DEV (2576.10: 0.000) _call_client send string [12, {}]
SMART_DEV (2576.17: 0.001) _call_client received string
SMART_DEV (2576.24: 0.000) _call_client protocol error -- empty json string
SMART_DEV (2576.31: 0.000) post_yank_cleanup
Job: 14 Delete books from device finished
Device responded with incorrect information

Traceback (most recent call last):
File "site-packages\calibre\gui2\device.py", line 83, in run
File "site-packages\calibre\gui2\device.py", line 502, in _delete_books
File "site-packages\calibre\devices\smart_device_app\driver.p y", line 44, in _synchronizer
File "site-packages\calibre\devices\smart_device_app\driver.p y", line 838, in delete_books
File "site-packages\calibre\devices\smart_device_app\driver.p y", line 425, in _call_client
ControlError: Device responded with incorrect information

Last edited by GoghGirl; 08-18-2012 at 06:10 AM.
GoghGirl is offline   Reply With Quote
Old 08-18-2012, 09:19 AM   #43
K8HW
Connoisseur
K8HW began at the beginning.
 
K8HW's Avatar
 
Posts: 90
Karma: 10
Join Date: Aug 2012
Location: Westland, MI
Device: Galaxy A03s, Galaxy Tab A, Kindle Paperwhite (10th Gen), Nexus 7
Quote:
Originally Posted by K8HW View Post
Hello
I turned on the extra debugging. I then did a restart on Calibre. I was able to catch the error message on the nook as follows: The application Google Play Store (process com.android.vending) has stopped unexpectedly. Please try again.

The error from Calibre is:

Calibre, version 0.8.65
ERROR: Error: Error communicating with device

Device responded with incorrect information

Traceback (most recent call last):
File "site-packages\calibre\gui2\device.py", line 83, in run
File "site-packages\calibre\gui2\device.py", line 478, in _upload_books
File "site-packages\calibre\devices\smart_device_app\driver.p y", line 44, in _synchronizer
File "site-packages\calibre\devices\smart_device_app\driver.p y", line 799, in upload_books
File "site-packages\calibre\devices\smart_device_app\driver.p y", line 452, in _put_file
File "site-packages\calibre\devices\smart_device_app\driver.p y", line 425, in _call_client
ControlError: Device responded with incorrect information

Thank you for your patience!

Dave
I finally got a log out of Calibre:
calibre Debug log
Spoiler:

calibre 0.8.65
Windows-Vista-6.0.6002-SP2
Windows
('Windows', 'Vista', '6.0.6002')
Python 2.7.3
Windows: ('Vista', '6.0.6002', 'SP2', 'Multiprocessor Free')
Starting up...
Failed to check for plugin update: HTTP Error 500: Internal Server Error
SMART_DEV ( 0.00: 0.005) startup_on_demand try port 18384
SMART_DEV ( 1.45: 0.803) startup_on_demand listening on port 18384
Started up in 44.28 seconds with 704 books
SMART_DEV ( 84.74: 82.985) reset
SMART_DEV ( 84.86: 0.000) set_progress_reporter
SMART_DEV ( 85.01: 0.000) open
SMART_DEV ( 85.15: 0.009) _call_client GET_INITIALIZATION_INFO {u'validExtensions': ['lrf', 'rar', 'zip', 'rtf', 'lit', 'txt', 'txtz', 'text', 'htm', 'xhtm', 'html', 'htmlz', 'xhtml', 'pdf', 'pdb', 'updb', 'pdr', 'prc', 'mobi', 'azw', 'doc', 'epub', 'fb2', 'djv', 'djvu', 'lrx', 'cbr', 'cbz', 'cbc', 'oebzip', 'rb', 'imp', 'odt', 'chm', 'tpz', 'azw1', 'pml', 'pmlz', 'mbp', 'tan', 'snb', 'xps', 'oxps', 'azw4', 'book', 'zbf', 'pobi', 'docx', 'md', 'textile', 'markdown', 'ibook', 'iba', 'azw3', 'ps'], u'currentLibraryName': u'Library', u'currentLibraryUUID': u'e12c2734-6469-468e-b0f9-ec5394b19b81', u'serverProtocolVersion': 1, u'passwordChallenge': u''}
SMART_DEV ( 85.29: 0.000) _call_client send string [9, {"validExtensions": ["lrf", "rar", "zip", "rtf", "lit", "txt", "txtz", "text", "htm", "xhtm", "html", "htmlz", "xhtml", "pdf", "pdb", "updb", "pdr", "prc", "mobi", "azw", "doc", "epub", "fb2", "djv", "djvu", "lrx", "cbr", "cbz", "cbc", "oebzip", "rb", "imp", "odt", "chm", "tpz", "azw1", "pml", "pmlz", "mbp", "tan", "snb", "xps", "oxps", "azw4", "book", "zbf", "pobi", "docx", "md", "textile", "markdown", "ibook", "iba", "azw3", "ps"], "currentLibraryName": "Library", "currentLibraryUUID": "e12c2734-6469-468e-b0f9-ec5394b19b81", "serverProtocolVersion": 1, "passwordChallenge": ""}]
SMART_DEV ( 85.64: 0.212) _call_client received string [0,{"ccVersionNumber":6,"acceptedExtensions":["epub"],"passwordHash":"","versionOK":true,"maxBookConten tPacketLen":204800}]
SMART_DEV ( 85.78: 0.000) _call_client receive after decode
SMART_DEV ( 85.92: 0.000) open CC version #: 6
SMART_DEV ( 86.05: 0.014) open selected formats [u'epub']
SMART_DEV ( 86.20: 0.006) card_prefix
SMART_DEV ( 86.42: 0.035) set_progress_reporter
Job: 1 Get device information started
SMART_DEV ( 86.62: 0.000) get_device_information
SMART_DEV ( 86.87: 0.007) _call_client GET_DEVICE_INFORMATION {}
SMART_DEV ( 87.17: 0.000) _call_client send string [3, {}]
SMART_DEV ( 87.80: 0.356) _call_client received string [0,{"device_info":{"last_library_uuid":"e12c2734-6469-468e-b0f9-ec5394b19b81","calibre_version":"0.8.65","device_n ame":"SmartDevice","date_last_connected":"2012-08-17T21:44:47.503000+00:00","device_store_uuid":"026 21f4d-5dd6-4985-97a0-c6eb182dc0a8","location_code":"main","prefix":""}, "version":"6","device_version":"10, encore"}]
SMART_DEV ( 87.94: 0.000) _call_client receive after decode
SMART_DEV ( 88.08: 0.005) _call_client SET_CALIBRE_DEVICE_INFO {u'device_store_uuid': u'02621f4d-5dd6-4985-97a0-c6eb182dc0a8', u'location_code': u'main', u'device_name': u'SmartDevice', u'calibre_version': u'0.8.65', u'prefix': u'', u'last_library_uuid': u'e12c2734-6469-468e-b0f9-ec5394b19b81', u'date_last_connected': u'2012-08-18T11:25:37.993000+00:00'}
SMART_DEV ( 88.25: 0.000) _call_client send string [1, {"device_store_uuid": "02621f4d-5dd6-4985-97a0-c6eb182dc0a8", "location_code": "main", "device_name": "SmartDevice", "calibre_version": "0.8.65", "prefix": "", "last_library_uuid": "e12c2734-6469-468e-b0f9-ec5394b19b81", "date_last_connected": "2012-08-18T11:25:37.993000+00:00"}]
SMART_DEV ( 88.73: 0.344) _call_client received string [0,{}]
SMART_DEV ( 88.87: 0.000) _call_client receive after decode
SMART_DEV ( 89.01: 0.000) card_prefix
SMART_DEV ( 89.14: 0.000) free_space
SMART_DEV ( 89.29: 0.005) _call_client FREE_SPACE {}
SMART_DEV ( 89.42: 0.000) _call_client send string [5, {}]
SMART_DEV ( 89.96: 0.399) _call_client received string [0,{"free_space_on_device":11208679424}]
SMART_DEV ( 90.10: 0.001) _call_client receive after decode
DeviceJob: 1 Get device information done, calling callback
DeviceJob: 1 Get device information callback returned
SMART_DEV ( 90.27: 0.007) set_progress_reporter
Job: 2 Get list of books on device started
Job: 1 Get device information finished
No details available.
SMART_DEV ( 90.37: 0.001) books None
SMART_DEV ( 90.50: 0.004) _call_client GET_BOOK_COUNT {}
SMART_DEV ( 90.64: 0.000) _call_client send string [6, {}]
SMART_DEV ( 92.78: 1.991) _call_client received string [0,{"count":95}]
SMART_DEV ( 92.91: 0.000) _call_client receive after decode
SMART_DEV ( 93.06: 0.005) _call_client GET_BOOK_METADATA {u'index': 0}
SMART_DEV ( 93.34: 0.151) _call_client GET_BOOK_METADATA {u'index': 1}
SMART_DEV ( 93.54: 0.062) _call_client GET_BOOK_METADATA {u'index': 2}
SMART_DEV ( 93.84: 0.163) _call_client GET_BOOK_METADATA {u'index': 3}
SMART_DEV ( 94.12: 0.131) _call_client GET_BOOK_METADATA {u'index': 4}
SMART_DEV ( 94.42: 0.154) _call_client GET_BOOK_METADATA {u'index': 5}
SMART_DEV ( 94.77: 0.209) _call_client GET_BOOK_METADATA {u'index': 6}
SMART_DEV ( 95.04: 0.132) _call_client GET_BOOK_METADATA {u'index': 7}
SMART_DEV ( 95.25: 0.068) _call_client GET_BOOK_METADATA {u'index': 8}
SMART_DEV ( 95.59: 0.206) _call_client GET_BOOK_METADATA {u'index': 9}
SMART_DEV ( 95.86: 0.123) _call_client GET_BOOK_METADATA {u'index': 10}
SMART_DEV ( 96.17: 0.172) _call_client GET_BOOK_METADATA {u'index': 11}
SMART_DEV ( 96.47: 0.160) _call_client GET_BOOK_METADATA {u'index': 12}
SMART_DEV ( 96.68: 0.062) _call_client GET_BOOK_METADATA {u'index': 13}
SMART_DEV ( 96.98: 0.168) _call_client GET_BOOK_METADATA {u'index': 14}
SMART_DEV ( 97.29: 0.168) _call_client GET_BOOK_METADATA {u'index': 15}
SMART_DEV ( 97.60: 0.171) _call_client GET_BOOK_METADATA {u'index': 16}
SMART_DEV ( 98.03: 0.296) _call_client GET_BOOK_METADATA {u'index': 17}
SMART_DEV ( 98.31: 0.139) _call_client GET_BOOK_METADATA {u'index': 18}
SMART_DEV ( 98.61: 0.163) _call_client GET_BOOK_METADATA {u'index': 19}
SMART_DEV ( 98.92: 0.168) _call_client GET_BOOK_METADATA {u'index': 20}
SMART_DEV ( 99.24: 0.117) _call_client GET_BOOK_METADATA {u'index': 21}
SMART_DEV ( 99.62: 0.087) _call_client GET_BOOK_METADATA {u'index': 22}
SMART_DEV ( 100.06: 0.196) _call_client GET_BOOK_METADATA {u'index': 23}
SMART_DEV ( 100.36: 0.073) _call_client GET_BOOK_METADATA {u'index': 24}
SMART_DEV ( 100.66: 0.165) _call_client GET_BOOK_METADATA {u'index': 25}
SMART_DEV ( 100.87: 0.068) _call_client GET_BOOK_METADATA {u'index': 26}
SMART_DEV ( 101.18: 0.180) _call_client GET_BOOK_METADATA {u'index': 27}
SMART_DEV ( 101.59: 0.162) _call_client GET_BOOK_METADATA {u'index': 28}
SMART_DEV ( 101.89: 0.154) _call_client GET_BOOK_METADATA {u'index': 29}
SMART_DEV ( 102.37: 0.325) _call_client GET_BOOK_METADATA {u'index': 30}
SMART_DEV ( 102.62: 0.104) _call_client GET_BOOK_METADATA {u'index': 31}
SMART_DEV ( 102.93: 0.170) _call_client GET_BOOK_METADATA {u'index': 32}
SMART_DEV ( 103.23: 0.162) _call_client GET_BOOK_METADATA {u'index': 33}
SMART_DEV ( 103.54: 0.172) _call_client GET_BOOK_METADATA {u'index': 34}
SMART_DEV ( 103.86: 0.175) _call_client GET_BOOK_METADATA {u'index': 35}
SMART_DEV ( 104.16: 0.169) _call_client GET_BOOK_METADATA {u'index': 36}
SMART_DEV ( 104.46: 0.152) _call_client GET_BOOK_METADATA {u'index': 37}
SMART_DEV ( 104.93: 0.335) _call_client GET_BOOK_METADATA {u'index': 38}
SMART_DEV ( 105.17: 0.100) _call_client GET_BOOK_METADATA {u'index': 39}
SMART_DEV ( 105.47: 0.153) _call_client GET_BOOK_METADATA {u'index': 40}
SMART_DEV ( 105.68: 0.072) _call_client GET_BOOK_METADATA {u'index': 41}
SMART_DEV ( 105.99: 0.168) _call_client GET_BOOK_METADATA {u'index': 42}
SMART_DEV ( 106.30: 0.161) _call_client GET_BOOK_METADATA {u'index': 43}
SMART_DEV ( 106.50: 0.066) _call_client GET_BOOK_METADATA {u'index': 44}
SMART_DEV ( 106.82: 0.183) _call_client GET_BOOK_METADATA {u'index': 45}
SMART_DEV ( 107.12: 0.164) _call_client GET_BOOK_METADATA {u'index': 46}
SMART_DEV ( 107.44: 0.167) _call_client GET_BOOK_METADATA {u'index': 47}
SMART_DEV ( 107.73: 0.153) _call_client GET_BOOK_METADATA {u'index': 48}
SMART_DEV ( 108.22: 0.349) _call_client GET_BOOK_METADATA {u'index': 49}
SMART_DEV ( 108.46: 0.104) _call_client GET_BOOK_METADATA {u'index': 50}
SMART_DEV ( 108.76: 0.162) _call_client GET_BOOK_METADATA {u'index': 51}
SMART_DEV ( 109.07: 0.172) _call_client GET_BOOK_METADATA {u'index': 52}
SMART_DEV ( 109.36: 0.139) _call_client GET_BOOK_METADATA {u'index': 53}
SMART_DEV ( 109.68: 0.170) _call_client GET_BOOK_METADATA {u'index': 54}
SMART_DEV ( 109.98: 0.170) _call_client GET_BOOK_METADATA {u'index': 55}
SMART_DEV ( 110.56: 0.435) _call_client GET_BOOK_METADATA {u'index': 56}
SMART_DEV ( 110.80: 0.098) _call_client GET_BOOK_METADATA {u'index': 57}
SMART_DEV ( 111.11: 0.166) _call_client GET_BOOK_METADATA {u'index': 58}
SMART_DEV ( 111.43: 0.168) _call_client GET_BOOK_METADATA {u'index': 59}
SMART_DEV ( 111.73: 0.161) _call_client GET_BOOK_METADATA {u'index': 60}
SMART_DEV ( 112.04: 0.169) _call_client GET_BOOK_METADATA {u'index': 61}
SMART_DEV ( 112.47: 0.275) _call_client GET_BOOK_METADATA {u'index': 62}
SMART_DEV ( 112.75: 0.144) _call_client GET_BOOK_METADATA {u'index': 63}
SMART_DEV ( 113.07: 0.172) _call_client GET_BOOK_METADATA {u'index': 64}
SMART_DEV ( 113.37: 0.156) _call_client GET_BOOK_METADATA {u'index': 65}
SMART_DEV ( 113.67: 0.163) _call_client GET_BOOK_METADATA {u'index': 66}
SMART_DEV ( 113.98: 0.174) _call_client GET_BOOK_METADATA {u'index': 67}
SMART_DEV ( 114.29: 0.169) _call_client GET_BOOK_METADATA {u'index': 68}
SMART_DEV ( 114.60: 0.167) _call_client GET_BOOK_METADATA {u'index': 69}
SMART_DEV ( 114.93: 0.190) _call_client GET_BOOK_METADATA {u'index': 70}
SMART_DEV ( 115.21: 0.143) _call_client GET_BOOK_METADATA {u'index': 71}
SMART_DEV ( 115.52: 0.166) _call_client GET_BOOK_METADATA {u'index': 72}
SMART_DEV ( 115.83: 0.168) _call_client GET_BOOK_METADATA {u'index': 73}
SMART_DEV ( 116.13: 0.160) _call_client GET_BOOK_METADATA {u'index': 74}
SMART_DEV ( 116.44: 0.155) _call_client GET_BOOK_METADATA {u'index': 75}
SMART_DEV ( 116.74: 0.171) _call_client GET_BOOK_METADATA {u'index': 76}
SMART_DEV ( 117.17: 0.282) _call_client GET_BOOK_METADATA {u'index': 77}
SMART_DEV ( 117.46: 0.145) _call_client GET_BOOK_METADATA {u'index': 78}
SMART_DEV ( 117.66: 0.067) _call_client GET_BOOK_METADATA {u'index': 79}
SMART_DEV ( 117.97: 0.169) _call_client GET_BOOK_METADATA {u'index': 80}
SMART_DEV ( 118.18: 0.073) _call_client GET_BOOK_METADATA {u'index': 81}
SMART_DEV ( 118.49: 0.163) _call_client GET_BOOK_METADATA {u'index': 82}
SMART_DEV ( 118.80: 0.169) _call_client GET_BOOK_METADATA {u'index': 83}
SMART_DEV ( 119.27: 0.337) _call_client GET_BOOK_METADATA {u'index': 84}
SMART_DEV ( 119.51: 0.100) _call_client GET_BOOK_METADATA {u'index': 85}
SMART_DEV ( 119.82: 0.176) _call_client GET_BOOK_METADATA {u'index': 86}
SMART_DEV ( 120.13: 0.168) _call_client GET_BOOK_METADATA {u'index': 87}
SMART_DEV ( 120.43: 0.150) _call_client GET_BOOK_METADATA {u'index': 88}
SMART_DEV ( 120.74: 0.174) _call_client GET_BOOK_METADATA {u'index': 89}
SMART_DEV ( 121.05: 0.161) _call_client GET_BOOK_METADATA {u'index': 90}
SMART_DEV ( 121.48: 0.285) _call_client GET_BOOK_METADATA {u'index': 91}
SMART_DEV ( 121.78: 0.148) _call_client GET_BOOK_METADATA {u'index': 92}
SMART_DEV ( 122.08: 0.163) _call_client GET_BOOK_METADATA {u'index': 93}
SMART_DEV ( 122.49: 0.268) _call_client GET_BOOK_METADATA {u'index': 94}
SMART_DEV ( 122.81: 0.169) books carda
SMART_DEV ( 122.93: 0.001) books cardb
DeviceJob: 2 Get list of books on device done, calling callback
READING LIST: Metadata available: {u'main': {u'device_store_uuid': u'02621f4d-5dd6-4985-97a0-c6eb182dc0a8', u'prefix': u'', u'device_name': u'SmartDevice', u'calibre_version': u'0.8.65', u'location_code': u'main', u'last_library_uuid': u'e12c2734-6469-468e-b0f9-ec5394b19b81', u'date_last_connected': u'2012-08-18T11:25:37.993000+00:00'}}
READING LIST: Sync Now - force_sync= False
DeviceJob: 2 Get list of books on device callback returned
SMART_DEV ( 123.49: 0.437) _call_client NOOP {}
SMART_DEV ( 123.77: 0.000) _call_client send string [12, {}]
Job: 2 Get list of books on device finished
No details available.
SMART_DEV ( 124.39: 0.329) _call_client received string [0,{}]
SMART_DEV ( 124.56: 0.000) _call_client receive after decode
SMART_DEV ( 134.81: 10.097) _call_client NOOP {}
SMART_DEV ( 134.96: 0.000) _call_client send string [12, {}]
SMART_DEV ( 135.45: 0.341) _call_client received string [0,{}]
SMART_DEV ( 135.59: 0.000) _call_client receive after decode
SMART_DEV ( 141.77: 6.045) set_progress_reporter
Job: 3 Upload 4 books to device:A Shot in the Bark, Coming Home, Dark Lullaby: A Harbinger Short Story, Dearly Departed started
SMART_DEV ( 141.87: 0.000) set_plugboards
Device using plugboard epub SMART_DEVICE_APP None
Setting metadata in: A Shot in the Bark at: C:\Users\David\AppData\Local\Temp\calibre_0.8.65_t mp_s820ne\bmvetbcaltmpfmt.epub
Device using plugboard epub SMART_DEVICE_APP None
Setting metadata in: Coming Home at: C:\Users\David\AppData\Local\Temp\calibre_0.8.65_t mp_s820ne\lm2o_ycaltmpfmt.epub
Device using plugboard epub SMART_DEVICE_APP None
Setting metadata in: Dark Lullaby: A Harbinger Short Story at: C:\Users\David\AppData\Local\Temp\calibre_0.8.65_t mp_s820ne\afklljcaltmpfmt.epub
Device using plugboard epub SMART_DEVICE_APP None
Setting metadata in: Dearly Departed at: C:\Users\David\AppData\Local\Temp\calibre_0.8.65_t mp_s820ne\qzfqvdcaltmpfmt.epub
SMART_DEV ( 143.85: 1.851) upload_books [u'A Shot in the Bark - Carol Ann Newsome & C. A. Newsome_956.epub', u'Coming Home - P. D. Martin_955.epub', u'Dark Lullaby_ A Harbinger Short Story - Carolyn McCray_954.epub', u'Dearly Departed - Rachael Rawlings_953.epub']
SMART_DEV ( 144.00: 0.021) _put_file Shot in the Bark, A - Carol Ann Newsome & C. A. Newsome.epub 258736
SMART_DEV ( 144.16: 0.004) _call_client SEND_BOOK {u'length': 258736L, u'thisBook': 0, u'lpath': u'too long', u'totalBooks': 4, u'metadata': <calibre.devices.usbms.books.Book object at 0x0DB06C30>}
SMART_DEV ( 145.17: 0.846) _call_client BOOK_DATA {u'position': 0, u'lpath': u'too long', u'data': u'too long'}
SMART_DEV ( 146.98: 1.654) _call_client BOOK_DATA {u'position': 204800, u'lpath': u'too long', u'data': u'too long'}
SMART_DEV ( 147.49: 0.349) _call_client BOOK_DONE {u'lpath': u'too long'}
SMART_DEV ( 147.65: 0.001) _call_client send string [11, {"lpath": "Shot in the Bark, A - Carol Ann Newsome & C. A. Newsome.epub"}]
SMART_DEV ( 148.10: 0.288) _call_client received string [0,{}]
SMART_DEV ( 148.27: 0.000) _call_client receive after decode
SMART_DEV ( 148.45: 0.018) _put_file Coming Home - P. D. Martin.epub 891070
SMART_DEV ( 148.60: 0.004) _call_client SEND_BOOK {u'length': 891070L, u'thisBook': 1, u'lpath': 'Coming Home - P. D. Martin.epub', u'totalBooks': 4, u'metadata': <calibre.devices.usbms.books.Book object at 0x0DD5DED0>}
SMART_DEV ( 150.18: 1.416) _call_client BOOK_DATA {u'position': 0, u'lpath': 'Coming Home - P. D. Martin.epub', u'data': u'too long'}
SMART_DEV ( 151.81: 1.464) _call_client BOOK_DATA {u'position': 204800, u'lpath': 'Coming Home - P. D. Martin.epub', u'data': u'too long'}
SMART_DEV ( 152.94: 0.965) _call_client BOOK_DATA {u'position': 409600, u'lpath': 'Coming Home - P. D. Martin.epub', u'data': u'too long'}
SMART_DEV ( 154.57: 1.477) _call_client BOOK_DATA {u'position': 614400, u'lpath': 'Coming Home - P. D. Martin.epub', u'data': u'too long'}
SMART_DEV ( 156.20: 1.466) _call_client BOOK_DATA {u'position': 819200, u'lpath': 'Coming Home - P. D. Martin.epub', u'data': u'too long'}
SMART_DEV ( 156.91: 0.554) _call_client BOOK_DONE {u'lpath': 'Coming Home - P. D. Martin.epub'}
SMART_DEV ( 157.07: 0.000) _call_client send string [11, {"lpath": "Coming Home - P. D. Martin.epub"}]
SMART_DEV ( 157.63: 0.387) _call_client received string [0,{}]
SMART_DEV ( 157.79: 0.001) _call_client receive after decode
SMART_DEV ( 157.96: 0.017) _put_file Dark Lullaby_ A Harbinger Short Story - Carolyn McCray.epub 187228
SMART_DEV ( 158.11: 0.004) _call_client SEND_BOOK {u'length': 187228L, u'thisBook': 2, u'lpath': u'too long', u'totalBooks': 4, u'metadata': <calibre.devices.usbms.books.Book object at 0x0DD5DAD0>}
SMART_DEV ( 158.88: 0.595) _call_client BOOK_DATA {u'position': 0, u'lpath': u'too long', u'data': u'too long'}
SMART_DEV ( 160.29: 1.256) _call_client BOOK_DONE {u'lpath': u'too long'}
SMART_DEV ( 160.46: 0.000) _call_client send string [11, {"lpath": "Dark Lullaby_ A Harbinger Short Story - Carolyn McCray.epub"}]
SMART_DEV ( 160.90: 0.277) _call_client received string [0,{}]
SMART_DEV ( 161.06: 0.000) _call_client receive after decode
SMART_DEV ( 161.25: 0.019) _put_file Dearly Departed - Rachael Rawlings.epub 356728
SMART_DEV ( 161.40: 0.004) _call_client SEND_BOOK {u'length': 356728L, u'thisBook': 3, u'lpath': 'Dearly Departed - Rachael Rawlings.epub', u'totalBooks': 4, u'metadata': <calibre.devices.usbms.books.Book object at 0x0DAF98F0>}
SMART_DEV ( 164.02: 2.469) _call_client BOOK_DATA {u'position': 0, u'lpath': 'Dearly Departed - Rachael Rawlings.epub', u'data': u'too long'}
SMART_DEV ( 165.55: 1.367) _call_client BOOK_DATA {u'position': 204800, u'lpath': 'Dearly Departed - Rachael Rawlings.epub', u'data': u'too long'}
SMART_DEV ( 166.87: 1.159) _call_client BOOK_DONE {u'lpath': 'Dearly Departed - Rachael Rawlings.epub'}
SMART_DEV ( 167.02: 0.000) _call_client send string [11, {"lpath": "Dearly Departed - Rachael Rawlings.epub"}]
SMART_DEV ( 167.48: 0.287) _call_client received string [0,{}]
SMART_DEV ( 167.63: 0.000) _call_client receive after decode
SMART_DEV ( 167.80: 0.000) upload_books finished uploading 4 books
DeviceJob: 3 Upload 4 books to device:A Shot in the Bark, Coming Home, Dark Lullaby: A Harbinger Short Story, Dearly Departed done, calling callback
SMART_DEV ( 167.93: 0.007) add_books_to_metadata adding metadata for 4 books
SMART_DEV ( 168.15: 0.024) add_books_to_metadata finished adding metadata
SMART_DEV ( 168.45: 0.094) set_plugboards
DeviceJob: 3 Upload 4 books to device:A Shot in the Bark, Coming Home, Dark Lullaby: A Harbinger Short Story, Dearly Departed callback returned
SMART_DEV ( 168.96: 0.306) set_progress_reporter
Job: 4 Send metadata to device started
SMART_DEV ( 169.06: 0.005) sync_booklists collection attributes [u'series']
DEBUG: 0.0 Starting get_collections: manual
DEBUG: 0.0 Renaming rules: {}
DEBUG: 0.0 Formatting template: {value}{category:| (|)}
DEBUG: 0.0 Sorting rules: []
SMART_DEV ( 169.27: 0.050) _call_client SEND_BOOKLISTS {u'count': 99, u'collections': {}}
SMART_DEV ( 169.42: 0.001) _call_client send string [7, {"count": 99, "collections": {}}]
Job: 3 Upload 4 books to device:A Shot in the Bark, Coming Home, Dark Lullaby: A Harbinger Short Story, Dearly Departed finished
No details available.
SMART_DEV ( 170.04: 0.483) _call_client received string [0,{}]
SMART_DEV ( 170.31: 0.000) _call_client receive after decode
SMART_DEV ( 170.83: 0.226) card_prefix
SMART_DEV ( 171.09: 0.000) free_space
SMART_DEV ( 171.37: 0.006) _call_client FREE_SPACE {}
SMART_DEV ( 171.52: 0.000) _call_client send string [5, {}]
SMART_DEV ( 172.09: 0.404) _call_client received string [0,{"free_space_on_device":11206975488}]
SMART_DEV ( 172.25: 0.000) _call_client receive after decode
DeviceJob: 4 Send metadata to device done, calling callback
DeviceJob: 4 Send metadata to device callback returned
Job: 4 Send metadata to device finished
No details available.
SMART_DEV ( 172.45: 0.029) _call_client NOOP {}
SMART_DEV ( 172.60: 0.001) _call_client send string [12, {}]
SMART_DEV ( 173.11: 0.365) _call_client received string [0,{}]
SMART_DEV ( 173.26: 0.000) _call_client receive after decode
SMART_DEV ( 183.49: 10.086) _call_client NOOP {}
SMART_DEV ( 183.64: 0.000) _call_client send string [12, {}]
SMART_DEV ( 184.17: 0.378) _call_client received string [0,{}]
SMART_DEV ( 184.31: 0.000) _call_client receive after decode
SMART_DEV ( 194.60: 10.093) _call_client NOOP {}
SMART_DEV ( 194.75: 0.000) _call_client send string [12, {}]
SMART_DEV ( 195.23: 0.324) _call_client received string [0,{}]
SMART_DEV ( 195.37: 0.000) _call_client receive after decode
SMART_DEV ( 205.95: 10.429) _call_client NOOP {}
SMART_DEV ( 206.15: 0.000) _call_client send string [12, {}]
SMART_DEV ( 206.70: 0.383) _call_client received string [0,{}]
SMART_DEV ( 206.84: 0.000) _call_client receive after decode
SMART_DEV ( 206.99: 0.000) set_progress_reporter
Job: 5 Upload 10 books to device:Mortal Choices, The Men Who Sleep With My Husband, The Ninth District, The Devil's Pitchfork, A Tale of 3 Witches, As I Was Cutting and Other Nastinesses, Gods of Mars, A Princess of Mars, The Warlord of Mars, 30 Pieces of Silver started
SMART_DEV ( 207.08: 0.001) set_plugboards
Device using plugboard epub SMART_DEVICE_APP None
Setting metadata in: Mortal Choices at: C:\Users\David\AppData\Local\Temp\calibre_0.8.65_t mp_s820ne\bselawcaltmpfmt.epub
Device using plugboard epub SMART_DEVICE_APP None
Setting metadata in: The Men Who Sleep With My Husband at: C:\Users\David\AppData\Local\Temp\calibre_0.8.65_t mp_s820ne\wth8eccaltmpfmt.epub
Device using plugboard epub SMART_DEVICE_APP None
Setting metadata in: The Ninth District at: C:\Users\David\AppData\Local\Temp\calibre_0.8.65_t mp_s820ne\fnvepkcaltmpfmt.epub
Device using plugboard epub SMART_DEVICE_APP None
Setting metadata in: The Devil's Pitchfork at: C:\Users\David\AppData\Local\Temp\calibre_0.8.65_t mp_s820ne\mofv7ccaltmpfmt.epub
Device using plugboard epub SMART_DEVICE_APP None
Setting metadata in: A Tale of 3 Witches at: C:\Users\David\AppData\Local\Temp\calibre_0.8.65_t mp_s820ne\nao8vrcaltmpfmt.epub
Device using plugboard epub SMART_DEVICE_APP None
Setting metadata in: As I Was Cutting and Other Nastinesses at: C:\Users\David\AppData\Local\Temp\calibre_0.8.65_t mp_s820ne\8wlkmhcaltmpfmt.epub
Device using plugboard epub SMART_DEVICE_APP None
Setting metadata in: Gods of Mars at: C:\Users\David\AppData\Local\Temp\calibre_0.8.65_t mp_s820ne\mf9yv6caltmpfmt.epub
Device using plugboard epub SMART_DEVICE_APP None
Setting metadata in: A Princess of Mars at: C:\Users\David\AppData\Local\Temp\calibre_0.8.65_t mp_s820ne\0a3mgccaltmpfmt.epub
Device using plugboard epub SMART_DEVICE_APP None
Setting metadata in: The Warlord of Mars at: C:\Users\David\AppData\Local\Temp\calibre_0.8.65_t mp_s820ne\dxwd_zcaltmpfmt.epub
Device using plugboard epub SMART_DEVICE_APP None
Setting metadata in: 30 Pieces of Silver at: C:\Users\David\AppData\Local\Temp\calibre_0.8.65_t mp_s820ne\pf0szzcaltmpfmt.epub
SMART_DEV ( 211.71: 4.492) upload_books [u'Mortal Choices - D. E. Newcomb_952.epub', u'The Men Who Sleep With My Husband - Alicia Coston_951.epub', u'The Ninth District - Douglas Dorow_950.epub', u"The Devil's Pitchfork - Mark Terry_949.epub", u'A Tale of 3 Witches - Christiana Miller & Barbra Annino_948.epub', u'As I Was Cutting and Other Nastinesses - L. V. Rautenbaumgrabner_947.epub', u'Gods of Mars - Edgar Rice Burroughs_946.epub', u'A Princess of Mars - Edgar Rice Burroughs_945.epub', u'The Warlord of Mars - Edgar Rice Burroughs_944.epub', u'30 Pieces of Silver - Carolyn McCray_942.epub']
SMART_DEV ( 211.86: 0.020) _put_file Mortal Choices - D. E. Newcomb.epub 259441
SMART_DEV ( 212.01: 0.008) _call_client SEND_BOOK {u'length': 259441L, u'thisBook': 0, u'lpath': 'Mortal Choices - D. E. Newcomb.epub', u'totalBooks': 10, u'metadata': <calibre.devices.usbms.books.Book object at 0x0DA31AD0>}
SMART_DEV ( 212.97: 0.784) _call_client BOOK_DATA {u'position': 0, u'lpath': 'Mortal Choices - D. E. Newcomb.epub', u'data': u'too long'}
SMART_DEV ( 217.88: 4.741) _call_client device went away
DeviceJob: 5 Upload 10 books to device:Mortal Choices, The Men Who Sleep With My Husband, The Ninth District, The Devil's Pitchfork, A Tale of 3 Witches, As I Was Cutting and Other Nastinesses, Gods of Mars, A Princess of Mars, The Warlord of Mars, 30 Pieces of Silver done, calling callback
Device closed the network connection

Traceback (most recent call last):
File "site-packages\calibre\gui2\device.py", line 83, in run
File "site-packages\calibre\gui2\device.py", line 478, in _upload_books
File "site-packages\calibre\devices\smart_device_app\driver.p y", line 44, in _synchronizer
File "site-packages\calibre\devices\smart_device_app\driver.p y", line 799, in upload_books
File "site-packages\calibre\devices\smart_device_app\driver.p y", line 452, in _put_file
File "site-packages\calibre\devices\smart_device_app\driver.p y", line 419, in _call_client
ControlError: Device closed the network connection

DeviceJob: 5 Upload 10 books to device:Mortal Choices, The Men Who Sleep With My Husband, The Ninth District, The Devil's Pitchfork, A Tale of 3 Witches, As I Was Cutting and Other Nastinesses, Gods of Mars, A Princess of Mars, The Warlord of Mars, 30 Pieces of Silver callback returned
SMART_DEV ( 218.09: 0.045) post_yank_cleanup
READING LIST: Device disconnected
Job: 5 Upload 10 books to device:Mortal Choices, The Men Who Sleep With My Husband, The Ninth District, The Devil's Pitchfork, A Tale of 3 Witches, As I Was Cutting and Other Nastinesses, Gods of Mars, A Princess of Mars, The Warlord of Mars, 30 Pieces of Silver finished
Device closed the network connection

Traceback (most recent call last):
File "site-packages\calibre\gui2\device.py", line 83, in run
File "site-packages\calibre\gui2\device.py", line 478, in _upload_books
File "site-packages\calibre\devices\smart_device_app\driver.p y", line 44, in _synchronizer
File "site-packages\calibre\devices\smart_device_app\driver.p y", line 799, in upload_books
File "site-packages\calibre\devices\smart_device_app\driver.p y", line 452, in _put_file
File "site-packages\calibre\devices\smart_device_app\driver.p y", line 419, in _call_client
ControlError: Device closed the network connection

Thank you
Dave

Last edited by chaley; 08-18-2012 at 04:41 PM. Reason: Added spoiler tags to hide the debug log
K8HW is offline   Reply With Quote
Old 08-18-2012, 03:08 PM   #44
chaley
Grand Sorcerer
chaley ought to be getting tired of karma fortunes by now.chaley ought to be getting tired of karma fortunes by now.chaley ought to be getting tired of karma fortunes by now.chaley ought to be getting tired of karma fortunes by now.chaley ought to be getting tired of karma fortunes by now.chaley ought to be getting tired of karma fortunes by now.chaley ought to be getting tired of karma fortunes by now.chaley ought to be getting tired of karma fortunes by now.chaley ought to be getting tired of karma fortunes by now.chaley ought to be getting tired of karma fortunes by now.chaley ought to be getting tired of karma fortunes by now.
 
Posts: 11,713
Karma: 6690879
Join Date: Jan 2010
Location: Notts, England
Device: Kobo Libra 2
@K8HW and @GoghGirl: these logs add a lot of credence to the "random running out of memory" problem that we have been trying to "fix".

Today we completely changed how memory is used, and I hope we have fixed the problems. It is hard to know because we can't make it fail, but I simulated having less tham 1MB of free memory and the app didn't crash. We will see ...

Thank you both again for your help!

EDIT: Calibre Companion V1.6, containing the above-mentioned changes, is now available.

Last edited by chaley; 08-18-2012 at 04:38 PM.
chaley is offline   Reply With Quote
Old 08-19-2012, 08:55 AM   #45
K8HW
Connoisseur
K8HW began at the beginning.
 
K8HW's Avatar
 
Posts: 90
Karma: 10
Join Date: Aug 2012
Location: Westland, MI
Device: Galaxy A03s, Galaxy Tab A, Kindle Paperwhite (10th Gen), Nexus 7
Thumbs up Great Job!

Quote:
Originally Posted by chaley View Post
@K8HW and @GoghGirl: these logs add a lot of credence to the "random running out of memory" problem that we have been trying to "fix".

Today we completely changed how memory is used, and I hope we have fixed the problems. It is hard to know because we can't make it fail, but I simulated having less tham 1MB of free memory and the app didn't crash. We will see ...

Thank you both again for your help!

EDIT: Calibre Companion V1.6, containing the above-mentioned changes, is now available.
Chaley, thank you very much. I can load my books without any errors!

I do however have a question. How do I find a particular book without having to wade through all of them? I tapped on group and selected "Series." I now see my books grouped by series. When I tap on a series selection I see the message "Loading you books" and then the same list of books. I don't see how I can get a particular book! Thanks in advance.

Dave

Last edited by K8HW; 08-19-2012 at 09:28 AM.
K8HW is offline   Reply With Quote
Reply

Thread Tools Search this Thread
Search this Thread:

Advanced Search

Forum Jump

Similar Threads
Thread Thread Starter Forum Replies Last Post
[Android App] Calibre Companion - My Thoughts DoctorOhh Devices 9 09-18-2012 08:41 AM
[Android App] Calibre Companion 1.7 Beta testing Adoby Devices 31 09-07-2012 10:13 PM
[Android App] Calibre Companion - future ability? Perkin Devices 3 09-06-2012 01:19 PM
[Android App] Can't get Calibre Companion to connect theangelicious1 Devices 2 09-01-2012 04:09 AM
[Android App] getting started with Calibre Companion BeccaPrice Devices 10 08-27-2012 05:20 PM


All times are GMT -4. The time now is 04:02 AM.


MobileRead.com is a privately owned, operated and funded community.