View Single Post
Old 04-11-2018, 11:55 PM   #2
jehrler
Enthusiast
jehrler shares his or her toysjehrler shares his or her toysjehrler shares his or her toysjehrler shares his or her toysjehrler shares his or her toysjehrler shares his or her toysjehrler shares his or her toysjehrler shares his or her toysjehrler shares his or her toysjehrler shares his or her toysjehrler shares his or her toys
 
Posts: 41
Karma: 5690
Join Date: Apr 2018
Device: iphone
I used the calibre companion debug to get some log info from that side. At 19:17 began trying to connect using calibre companion via wireless device. At 19:20, while cc was still "waiting for calibre" I accessed the content server via web browser.

At 19:21 I used vpn to connect to the Mac mini but didn't log in. CC immediately connected as wireless device.

Here is the debug log from calibre companion:

Spoiler:
2018-04-11 19:17:07.167 [Default|INFO] Log event: A_ConnectWireless ["MobileDataEnabled": false, "WirelessPortPreset": false, "WirelessIpPreset": false, "WirelessAttemptFailure": false]
2018-04-11 19:17:07.174 [Default|INFO] WirelessDevice: begin scanning
2018-04-11 19:17:07.181 [Default|INFO] ServerScan: Broadcasting on port 54982
2018-04-11 19:17:07.185 [Default|INFO] ServerScan: Broadcasting on port 48123
2018-04-11 19:17:07.187 [Default|INFO] ServerScan: Broadcasting on port 39001
2018-04-11 19:17:07.190 [Default|INFO] ServerScan: Broadcasting on port 44044
2018-04-11 19:17:07.193 [Default|INFO] ServerScan: Broadcasting on port 59678
2018-04-11 19:17:07.197 [Default|INFO] Searching Bonjour
2018-04-11 19:17:07.232 [Default|INFO] Received response from 192.168.0.52 via Bonjour
2018-04-11 19:17:11.204 [Default|INFO] WirelessDevice: Found 1 servers
2018-04-11 19:17:11.211 [Default|INFO] WirelessDevice: Connecting to http://192.168.0.52:9090
2018-04-11 19:17:11.231 [Default|INFO] Communicator connected to host 192.168.0.52 on port 9090
2018-04-11 19:17:21.241 [Default|WARNING] Communicator timed out after 10.0s, extending by another 10 seconds. Has dataHandler: false, combinedDataLength nil
2018-04-11 19:17:26.581 [Default|INFO] Received OpCode: getInitialisationInfo
2018-04-11 19:17:26.586 [Default|INFO] GetInitializationInfo: calibre version: 3, 21, 0
2018-04-11 19:17:26.595 [Default|INFO] GetInitializationInfo: sent sync column info to calibre
2018-04-11 19:17:26.673 [Default|INFO] Received OpCode: getDeviceInformation
2018-04-11 19:17:26.685 [Default|INFO] Received OpCode: setCalibreDeviceInfo
2018-04-11 19:17:27.057 [Default|INFO] Received OpCode: freeSpace
2018-04-11 19:17:27.093 [Default|INFO] Received OpCode: setLibraryInfo
2018-04-11 19:18:17.101 [Default|WARNING] Communicator timed out after 50.0s, extending by another 10 seconds. Has dataHandler: false, combinedDataLength nil
2018-04-11 19:18:27.106 [Default|WARNING] Communicator timed out after 60.0s, extending by another 10 seconds. Has dataHandler: false, combinedDataLength nil
2018-04-11 19:18:37.112 [Default|WARNING] Communicator timed out after 70.0s, extending by another 10 seconds. Has dataHandler: false, combinedDataLength nil
2018-04-11 19:18:47.117 [Default|WARNING] Communicator timed out after 80.0s, extending by another 10 seconds. Has dataHandler: false, combinedDataLength nil
2018-04-11 19:18:57.123 [Default|WARNING] Communicator timed out after 90.0s, extending by another 10 seconds. Has dataHandler: false, combinedDataLength nil
2018-04-11 19:19:07.137 [Default|WARNING] Communicator timed out after 100.0s, extending by another 10 seconds. Has dataHandler: false, combinedDataLength nil
2018-04-11 19:19:17.144 [Default|WARNING] Communicator timed out after 110.0s, extending by another 10 seconds. Has dataHandler: false, combinedDataLength nil
2018-04-11 19:19:27.149 [Default|WARNING] Communicator timed out after 120.0s, extending by another 10 seconds. Has dataHandler: false, combinedDataLength nil
2018-04-11 19:19:37.168 [Default|WARNING] Communicator timed out after 130.0s, extending by another 10 seconds. Has dataHandler: false, combinedDataLength nil
2018-04-11 19:19:47.174 [Default|WARNING] Communicator timed out after 140.0s, extending by another 10 seconds. Has dataHandler: false, combinedDataLength nil
2018-04-11 19:19:57.181 [Default|WARNING] Communicator timed out after 150.0s, extending by another 10 seconds. Has dataHandler: false, combinedDataLength nil
2018-04-11 19:20:07.188 [Default|WARNING] Communicator timed out after 160.0s, extending by another 10 seconds. Has dataHandler: false, combinedDataLength nil
2018-04-11 19:20:17.194 [Default|WARNING] Communicator timed out after 170.0s, extending by another 10 seconds. Has dataHandler: false, combinedDataLength nil
2018-04-11 19:20:27.199 [Default|WARNING] Communicator timed out after 180.0s, extending by another 10 seconds. Has dataHandler: false, combinedDataLength nil
2018-04-11 19:20:37.211 [Default|WARNING] Communicator timed out after 190.0s, extending by another 10 seconds. Has dataHandler: false, combinedDataLength nil
2018-04-11 19:20:47.217 [Default|WARNING] Communicator timed out after 200.0s, extending by another 10 seconds. Has dataHandler: false, combinedDataLength nil
2018-04-11 19:20:57.226 [Default|WARNING] Communicator timed out after 210.0s, extending by another 10 seconds. Has dataHandler: false, combinedDataLength nil
2018-04-11 19:21:07.232 [Default|WARNING] Communicator timed out after 220.0s, extending by another 10 seconds. Has dataHandler: false, combinedDataLength nil
2018-04-11 19:21:17.239 [Default|WARNING] Communicator timed out after 230.0s, extending by another 10 seconds. Has dataHandler: false, combinedDataLength nil
2018-04-11 19:21:27.244 [Default|WARNING] Communicator timed out after 240.0s, extending by another 10 seconds. Has dataHandler: false, combinedDataLength nil
2018-04-11 19:21:37.252 [Default|WARNING] Communicator timed out after 250.0s, extending by another 10 seconds. Has dataHandler: false, combinedDataLength nil
2018-04-11 19:21:43.856 [Default|INFO] Received OpCode: getBookCount
2018-04-11 19:21:43.866 [Default|INFO] Realm instance loaded, schema: 52
2018-04-11 19:21:43.966 [Default|INFO] GetBooks: Total books=334, of which are new=0
2018-04-11 19:21:43.967 [Default|INFO] GetBooks: Asking calibre what metadata it needs
2018-04-11 19:21:43.970 [Default|INFO] GetBooks: Syncing newer books
2018-04-11 19:21:43.972 [Default|INFO] GetBooks: Sending metadata 1. PriKey 1, Dragonfly in Amber - Diana Gabaldon (320).epub
2018-04-11 19:21:44.011 [Default|INFO] GetBooks: Sending metadata 31. PriKey 31, Oathbringer - Brandon Sanderson (506).epub
2018-04-11 19:21:44.050 [Default|INFO] GetBooks: Sending metadata 61. PriKey 61, Promise of Blood_ The Powder Mage Trilogy_ Book 1 - Brian McClellan (452).epub
2018-04-11 19:21:44.088 [Default|INFO] GetBooks: Sending metadata 91. PriKey 91, Ep.#3 - _Resurrection_ (The Frontiers Saga - Part 2_ Rogue Castes) - Ryk Brown (416).epub
2018-04-11 19:21:44.127 [Default|INFO] GetBooks: Sending metadata 121. PriKey 121, Close Your Eyes - Michael Robotham (375).epub
2018-04-11 19:21:44.170 [Default|INFO] GetBooks: Sending metadata 151. PriKey 151, Vital Abyss, The - James S. A. Corey (340).epub
2018-04-11 19:21:44.211 [Default|INFO] GetBooks: Sending metadata 181. PriKey 181, Ivanhoe - Sir Walter Scott (303).epub
2018-04-11 19:21:44.250 [Default|INFO] GetBooks: Sending metadata 211. PriKey 211, In Fire Forged_ Worlds of Honor V - David Weber (203).epub
2018-04-11 19:21:44.288 [Default|INFO] GetBooks: Sending metadata 241. PriKey 241, Shadow of Freedom - David Weber (171).epub
2018-04-11 19:21:44.327 [Default|INFO] GetBooks: Sending metadata 271. PriKey 271, At All Costs - David Weber (126).epub
2018-04-11 19:21:44.365 [Default|INFO] GetBooks: Sending metadata 301. PriKey 301, Antares Victory - Michael McCollum (280).epub
2018-04-11 19:21:44.404 [Default|INFO] GetBooks: Sending metadata 331. PriKey 331, Matter - Iain M. Banks (539).epub
2018-04-11 19:21:44.407 [Default|INFO] GetBooks: Sending metadata 333. PriKey 333, Colony in a Nation, A - Chris Hayes (542).epub
2018-04-11 19:21:44.410 [Default|INFO] GetBooks: Have sent all known book metadata. Books.size=334, including discovered=334
2018-04-11 19:21:44.411 [Default|INFO] GetBooks: Have finished sending placeholders for all discovered books.
2018-04-11 19:21:46.118 [Default|INFO] GetBooks: Number of books needed by Calibre: 0
2018-04-11 19:21:46.124 [Default|INFO] Completed Sending books and paths
2018-04-11 19:21:47.230 [Default|INFO] Received OpCode: sendBooklists
2018-04-11 19:21:47.253 [Default|INFO] SendBookLists: 0 books with updated metadata about to be sent
2018-04-11 19:21:47.776 [Default|INFO] Received OpCode: freeSpace
2018-04-11 19:21:47.802 [Default|INFO] Received OpCode: noOp
2018-04-11 19:21:59.851 [Default|INFO] Received OpCode: noOp
2018-04-11 19:22:12.214 [Default|INFO] Received OpCode: noOp
2018-04-11 19:22:24.300 [Default|INFO] Received OpCode: noOp
2018-04-11 19:22:28.554 [Default|INFO] Received OpCode: noOp
2018-04-11 19:22:30.000 [Default|INFO] Communicator disconnected
2018-04-11 19:22:31.942 [Default|INFO] Log event: A_OpenedExtraMenu [:]
2018-04-11 19:22:34.398 [Default|INFO] Log event: V_Settings [:]
2018-04-11 19:22:39.682 [Default|INFO] Log event: A_EmailLog [:]

Last edited by chaley; 04-12-2018 at 04:20 AM. Reason: Added "Spoiler" button
jehrler is offline   Reply With Quote