Dec 03, 2018 10:01:04.064 [0x7fd54ce63700] INFO - Plex Media Server v1.14.0.5470-9d51fdfaa - ubuntu docker x86_64 - build: linux-ubuntu-x86_64 ubuntu - GMT -05:00
Dec 03, 2018 10:01:04.069 [0x7fd54ce63700] INFO - Linux version: 4.19.1 (#1 SMP Sun Nov 11 07:20:56 EST 2018), language: en-US
Dec 03, 2018 10:01:04.069 [0x7fd54ce63700] INFO - Processor       Intel(R) Atom(TM) x5-Z8350  CPU @ 1.44GHz
Dec 03, 2018 10:01:04.069 [0x7fd54ce63700] INFO - /usr/lib/plexmediaserver/Plex Media Server
Dec 03, 2018 10:01:04.064 [0x7fd558eec840] DEBUG - BPQ: [Idle] -> [Starting]
Dec 03, 2018 10:01:04.082 [0x7fd558eec840] DEBUG - FeatureManager: Using cached data for features list
Dec 03, 2018 10:01:04.091 [0x7fd558eec840] DEBUG - Opening 20 database sessions to library (com.plexapp.plugins.library), SQLite 3.13.0, threadsafe=1
Dec 03, 2018 10:01:04.115 [0x7fd558eec840] INFO - SQLITE3:0x10, 283, recovered 420 frames from WAL file /config/Library/Application Support/Plex Media Server/Plug-in Support/Databases/com.plexapp.plugins.library.db-wal
Dec 03, 2018 10:01:04.391 [0x7fd558eec840] DEBUG - Running migrations. (EPG 0)
Dec 03, 2018 10:01:04.494 [0x7fd558eec840] DEBUG - ChangestampAllocator: initialized to 9645
Dec 03, 2018 10:01:04.495 [0x7fd558eec840] DEBUG - Opening 2 database sessions to library (com.plexapp.plugins.library.blobs), SQLite 3.13.0, threadsafe=1
Dec 03, 2018 10:01:04.526 [0x7fd558eec840] DEBUG - Running migrations. (EPG 0)
Dec 03, 2018 10:01:04.589 [0x7fd558eec840] DEBUG - CERT: Installed certificate with fingerprint 1f:dc:bd:b0:f7:f8:66:86:3b:5e:90:7b:a0:d5:71:cf:d2:e9:ae:6a.
Dec 03, 2018 10:01:04.589 [0x7fd558eec840] DEBUG - CERT: Installed new private key.
Dec 03, 2018 10:01:04.589 [0x7fd558eec840] DEBUG - CERT: Subject name is /C=US/ST=California/L=Los Gatos/O=Plex, Inc./CN=*.eae34eddb47e44b5ac252e37b8f343cf.plex.direct
Dec 03, 2018 10:01:04.591 [0x7fd558eec840] DEBUG - CERT: OCSP requests for stapling will be made to 'http://ocspx.digicert.com/'.
Dec 03, 2018 10:01:04.593 [0x7fd558eec840] INFO - OCSP: Successfully retrieved response from cache.
Dec 03, 2018 10:01:04.594 [0x7fd558eec840] DEBUG - CERT: Installed intermediate certificate.
Dec 03, 2018 10:01:04.595 [0x7fd558eec840] DEBUG - HttpServer: Listening on port 32400 with queue of 128 connections.
Dec 03, 2018 10:01:04.596 [0x7fd558eec840] DEBUG - HttpServer: Listening on port 32401 with queue of 128 connections.
Dec 03, 2018 10:01:04.641 [0x7fd5497fd700] DEBUG - DVR:Grabber: Cleaning up orphaned grabs.
Dec 03, 2018 10:01:04.650 [0x7fd558eec840] DEBUG - Media Provider: Registering provider com.plexapp.plugins.library
Dec 03, 2018 10:01:04.650 [0x7fd558eec840] DEBUG - Auth: Refreshing tokens inside the token-based authentication filter.
Dec 03, 2018 10:01:04.656 [0x7fd558eec840] DEBUG - Relay: read 9 cached entries from hosts file
Dec 03, 2018 10:01:04.658 [0x7fd558eec840] DEBUG - MyPlex: using cached data for request for https://plex.tv/servers/e7f44c013808a4bef0c9631d075fbb02c00bf13b/access_tokens.xml?auth_token=xxxxxxxxxxxxxxxxxxxx&includeProfiles=1&includeProviders=1
Dec 03, 2018 10:01:04.659 [0x7fd5487ff700] DEBUG - HTTP requesting GET https://plex.tv/media/providers?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Dec 03, 2018 10:01:04.664 [0x7fd558eec840] DEBUG - MyPlex: updating with 26 access tokens
Dec 03, 2018 10:01:04.674 [0x7fd545ffc700] DEBUG - Auth: Refreshing tokens inside the token-based authentication filter.
Dec 03, 2018 10:01:04.676 [0x7fd545ffc700] DEBUG - HTTP requesting GET https://plex.tv/servers/e7f44c013808a4bef0c9631d075fbb02c00bf13b/access_tokens.xml?auth_token=xxxxxxxxxxxxxxxxxxxx&includeProfiles=1&includeProviders=1
Dec 03, 2018 10:01:04.689 [0x7fd542bfe700] DEBUG - File "/usr/lib/plexmediaserver/Resources/Plug-ins-9d51fdfaa" changed: -1 => 2018-11-30 18:16:15 (1543619775).
Dec 03, 2018 10:01:04.690 [0x7fd542bfe700] DEBUG - File "/config/Library/Application Support/Plex Media Server/Plug-ins" changed: -1 => 2018-11-24 10:57:08 (1543075028).
Dec 03, 2018 10:01:04.690 [0x7fd542bfe700] DEBUG - Scanning for plug-ins in "/usr/lib/plexmediaserver/Resources/Plug-ins-9d51fdfaa"
Dec 03, 2018 10:01:04.698 [0x7fd5497fd700] DEBUG - DVR:Grabber: Cleaned up 0 decrepit directories in 0.1 sec.
Dec 03, 2018 10:01:04.742 [0x7fd542bfe700] DEBUG - Scanning for plug-ins in "/config/Library/Application Support/Plex Media Server/Plug-ins"
Dec 03, 2018 10:01:04.752 [0x7fd542bfe700] DEBUG - PluginRepository::setStartState: 1, startingSystem
Dec 03, 2018 10:01:04.753 [0x7fd542bfe700] DEBUG - Starting plug-in /usr/lib/plexmediaserver/Resources/Plug-ins-9d51fdfaa/System.bundle.
Dec 03, 2018 10:01:04.755 [0x7fd542bfe700] DEBUG - [com.plexapp.system] Setting plug-in to always running (daemon mode).
Dec 03, 2018 10:01:04.779 [0x7fd542bfe700] DEBUG - Starting file watcher for com.plexapp.system
Dec 03, 2018 10:01:04.785 [0x7fd542bfe700] DEBUG - Spawned plug-in com.plexapp.system with PID 317
Dec 03, 2018 10:01:04.786 [0x7fd542bfe700] DEBUG - [com.plexapp.system] Sending command: GET /:/prefixes
Dec 03, 2018 10:01:04.978 [0x7fd5487ff700] DEBUG - HTTP 200 response from GET https://plex.tv/media/providers?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Dec 03, 2018 10:01:05.056 [0x7fd545ffc700] DEBUG - HTTP 200 response from GET https://plex.tv/servers/e7f44c013808a4bef0c9631d075fbb02c00bf13b/access_tokens.xml?auth_token=xxxxxxxxxxxxxxxxxxxx&includeProfiles=1&includeProviders=1
Dec 03, 2018 10:01:05.065 [0x7fd545ffc700] DEBUG - MyPlex: updating with 26 access tokens
Dec 03, 2018 10:01:05.068 [0x7fd546ffe700] DEBUG - HTTP requesting GET https://plex.tv/media/providers?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Dec 03, 2018 10:01:05.327 [0x7fd546ffe700] DEBUG - HTTP 200 response from GET https://plex.tv/media/providers?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Dec 03, 2018 10:01:05.329 [0x7fd546ffe700] DEBUG - HTTP requesting GET https://plex.tv/media/providers?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Dec 03, 2018 10:01:05.594 [0x7fd546ffe700] DEBUG - HTTP 200 response from GET https://plex.tv/media/providers?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Dec 03, 2018 10:01:06.026 [0x7fd5487ff700] DEBUG - Job running: '/usr/lib/plexmediaserver/CrashUploader' '--directory=/config/Library/Application Support/Plex Media Server/Crash Reports/1.14.0.5470-9d51fdfaa' '--version=1.14.0.5470-9d51fdfaa' '--platform=linux-ubuntu-x86_64 (4.19.1 (#1 SMP Sun Nov 11 07:20:56 EST 2018))' '--serverUuid=e7f44c013808a4bef0c9631d075fbb02c00bf13b' '--userId=a@gmail.com' '--url=https://crashreport.plexapp.com'
Dec 03, 2018 10:01:06.031 [0x7fd5487ff700] DEBUG - Jobs: Starting child process with pid 318
Dec 03, 2018 10:01:06.115 [0x7fd5433ff700] DEBUG - Jobs: '/usr/lib/plexmediaserver/CrashUploader' exit code for process 318 is 0 (success)
Dec 03, 2018 10:01:14.665 [0x7fd545ffc700] DEBUG - DVR:Device: Discovering and refreshing all devices.
Dec 03, 2018 10:01:14.671 [0x7fd545ffc700] DEBUG - Creating NetworkServices singleton.
Dec 03, 2018 10:01:14.674 [0x7fd545ffc700] DEBUG - NetworkService: Creating new service.
Dec 03, 2018 10:01:14.675 [0x7fd545ffc700] DEBUG - NetworkService: Got notification of changed network (first change: 1)
Dec 03, 2018 10:01:14.675 [0x7fd545ffc700] DEBUG - NetworkService: Quick dispatch of network change.
Dec 03, 2018 10:01:14.676 [0x7fd545ffc700] DEBUG - DVR:Grabber: HDHomerun discovered 0 compatible devices.
Dec 03, 2018 10:01:14.677 [0x7fd5407ff700] DEBUG - NetworkService: Network change for browser (polled=0), closing 0 browse sockets.
Dec 03, 2018 10:01:14.678 [0x7fd5407ff700] DEBUG - NetworkService: Setting up multicast listener on 0.0.0.0:1901 (outbound: 0)
Dec 03, 2018 10:01:14.681 [0x7fd545ffc700] DEBUG - HTTP requesting POST http://127.0.0.1:32600/devices/discover
Dec 03, 2018 10:01:14.685 [0x7fd545ffc700] ERROR - Error issuing curl_easy_perform(handle): 7
Dec 03, 2018 10:01:14.685 [0x7fd545ffc700] WARN - HTTP error requesting POST http://127.0.0.1:32600/devices/discover (0, No error) (Failed connect to 127.0.0.1:32600; Connection refused)
Dec 03, 2018 10:01:14.687 [0x7fd545ffc700] DEBUG - DVR:Grabber: Failed to retrieve device data
Dec 03, 2018 10:01:17.512 [0x7fd542bfe700] DEBUG - Reading 486 bytes in the body, code is 200
Dec 03, 2018 10:01:17.513 [0x7fd542bfe700] DEBUG - [com.plexapp.system] Plug-in running on port 39479.
Dec 03, 2018 10:01:17.513 [0x7fd542bfe700] DEBUG -  * Plug-in handles prefix: /system
Dec 03, 2018 10:01:17.513 [0x7fd542bfe700] DEBUG -  * Plug-in handles prefix: /player
Dec 03, 2018 10:01:17.514 [0x7fd542bfe700] DEBUG - Read configuration for [com.plexapp.system], had 2 prefixes
Dec 03, 2018 10:01:17.522 [0x7fd542bfe700] DEBUG - Done with 1 synchronous plug-in starts, starting the rest in parallel.
Dec 03, 2018 10:01:17.522 [0x7fd542bfe700] DEBUG - PluginRepository::setStartState: 2, startingPlugins
Dec 03, 2018 10:01:17.522 [0x7fd542bfe700] DEBUG - Updating the list of agents known by the system.
Dec 03, 2018 10:01:17.522 [0x7fd542bfe700] DEBUG - [com.plexapp.system] Sending command over HTTP (GET): /system/agents
Dec 03, 2018 10:01:17.523 [0x7fd542bfe700] DEBUG - HTTP requesting GET http://127.0.0.1:39479/system/agents
Dec 03, 2018 10:01:17.527 [0x7fd558eec840] DEBUG - Image transcode cache directory: "/config/Library/Application Support/Plex Media Server/Cache/PhotoTranscoder"
Dec 03, 2018 10:01:17.528 [0x7fd558eec840] DEBUG - Transcoder: Cleaning old transcode directories.
Dec 03, 2018 10:01:17.541 [0x7fd558eec840] DEBUG - MyPlex: using cached data for request for https://plex.tv/servers/e7f44c013808a4bef0c9631d075fbb02c00bf13b/access_tokens.xml?auth_token=xxxxxxxxxxxxxxxxxxxx&includeProfiles=1&includeProviders=1
Dec 03, 2018 10:01:17.543 [0x7fd558eec840] DEBUG - MyPlex: updating with 26 access tokens
Dec 03, 2018 10:01:17.548 [0x7fd558eec840] DEBUG - MyPlex: using cached data for request for https://plex.tv/users/account.xml?auth_token=xxxxxxxxxxxxxxxxxxxx&includeGeolocation=1
Dec 03, 2018 10:01:17.548 [0x7fd5467fd700] DEBUG - HTTP requesting GET https://plex.tv/media/providers?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Dec 03, 2018 10:01:17.554 [0x7fd558eec840] DEBUG - MyPlex: username is a@gmail.com, login is a@gmail.com, home is 1, has pin
Dec 03, 2018 10:01:17.561 [0x7fd558eec840] DEBUG - PublicAddressManager: Starting.
Dec 03, 2018 10:01:17.561 [0x7fd558eec840] DEBUG - PublicAddressManager: Obtaining public address and mapping port.
Dec 03, 2018 10:01:17.562 [0x7fd546ffe700] DEBUG - PublicAddressManager: Obtaining public IP.
Dec 03, 2018 10:01:17.562 [0x7fd546ffe700] DEBUG - HTTP requesting GET http://plex.tv/pms/:/ip
Dec 03, 2018 10:01:17.564 [0x7fd545ffc700] DEBUG - NAT: UPnP, attempting port mapping.
Dec 03, 2018 10:01:17.567 [0x7fd558eec840] DEBUG - NetworkInterface: Starting watch thread.
Dec 03, 2018 10:01:17.568 [0x7fd558eec840] DEBUG - Network change.
Dec 03, 2018 10:01:17.568 [0x7fd558eec840] DEBUG - NetworkInterface: Notified of network changed (force=0)
Dec 03, 2018 10:01:17.570 [0x7fd5477ff700] DEBUG - NetworkInterface: Watching for changes on the interfaces.
Dec 03, 2018 10:01:17.573 [0x7fd558eec840] DEBUG - Detected primary interface: 192.168.1.24
Dec 03, 2018 10:01:17.573 [0x7fd558eec840] DEBUG - Network interfaces:
Dec 03, 2018 10:01:17.573 [0x7fd558eec840] DEBUG -  * 1 lo (127.0.0.1) (loopback: 1)
Dec 03, 2018 10:01:17.573 [0x7fd558eec840] DEBUG -  * 2 eth0 (192.168.1.24) (loopback: 0)
Dec 03, 2018 10:01:17.573 [0x7fd558eec840] DEBUG -  * 3 br-bb2049b50d9a (172.18.0.1) (loopback: 0)
Dec 03, 2018 10:01:17.573 [0x7fd558eec840] DEBUG -  * 4 docker0 (172.17.0.1) (loopback: 0)
Dec 03, 2018 10:01:17.573 [0x7fd558eec840] DEBUG - NetworkService: Got notification of changed network (first change: 0)
Dec 03, 2018 10:01:17.573 [0x7fd558eec840] DEBUG - NetworkService: Dispatch network change after two second delay.
Dec 03, 2018 10:01:17.574 [0x7fd558eec840] DEBUG - NetworkServices: Initializing...
Dec 03, 2018 10:01:17.574 [0x7fd558eec840] DEBUG - NetworkService: Creating new service.
Dec 03, 2018 10:01:17.574 [0x7fd558eec840] DEBUG - NetworkService: Got notification of changed network (first change: 1)
Dec 03, 2018 10:01:17.574 [0x7fd558eec840] DEBUG - NetworkService: Quick dispatch of network change.
Dec 03, 2018 10:01:17.574 [0x7fd5407ff700] DEBUG - Network change for advertiser.
Dec 03, 2018 10:01:17.574 [0x7fd5407ff700] DEBUG - NetworkService: Setting up multicast listener on 0.0.0.0:32414 (outbound: 0)
Dec 03, 2018 10:01:17.576 [0x7fd558eec840] DEBUG - NetworkService: Creating new service.
Dec 03, 2018 10:01:17.576 [0x7fd558eec840] DEBUG - NetworkService: Got notification of changed network (first change: 1)
Dec 03, 2018 10:01:17.576 [0x7fd558eec840] DEBUG - NetworkService: Quick dispatch of network change.
Dec 03, 2018 10:01:17.576 [0x7fd5407ff700] DEBUG - Network change for advertiser.
Dec 03, 2018 10:01:17.576 [0x7fd5407ff700] DEBUG - NetworkService: Setting up multicast listener on 0.0.0.0:32410 (outbound: 0)
Dec 03, 2018 10:01:17.586 [0x7fd558eec840] DEBUG - NetworkService: Creating new service.
Dec 03, 2018 10:01:17.586 [0x7fd558eec840] DEBUG - NetworkService: Got notification of changed network (first change: 1)
Dec 03, 2018 10:01:17.586 [0x7fd558eec840] DEBUG - NetworkService: Quick dispatch of network change.
Dec 03, 2018 10:01:17.586 [0x7fd5407ff700] DEBUG - Network change for advertiser.
Dec 03, 2018 10:01:17.586 [0x7fd5407ff700] DEBUG - NetworkService: Setting up multicast listener on 0.0.0.0:32412 (outbound: 0)
Dec 03, 2018 10:01:17.587 [0x7fd558eec840] DEBUG - NetworkService: Creating new service.
Dec 03, 2018 10:01:17.588 [0x7fd5497fd700] DEBUG - HTTP requesting GET https://plex.tv/users/account.xml?auth_token=xxxxxxxxxxxxxxxxxxxx&includeGeolocation=1
Dec 03, 2018 10:01:17.591 [0x7fd558eec840] DEBUG - NetworkService: Got notification of changed network (first change: 1)
Dec 03, 2018 10:01:17.592 [0x7fd558eec840] DEBUG - NetworkService: Quick dispatch of network change.
Dec 03, 2018 10:01:17.592 [0x7fd5407ff700] DEBUG - NetworkService: Network change for browser (polled=0), closing 0 browse sockets.
Dec 03, 2018 10:01:17.592 [0x7fd5407ff700] DEBUG - NetworkService: Setting up multicast listener on 0.0.0.0:32413 (outbound: 0)
Dec 03, 2018 10:01:17.593 [0x7fd5407ff700] DEBUG - NetworkService: Browsing on interface 127.0.0.1 on broadcast address 127.255.255.255 (index: 0)
Dec 03, 2018 10:01:17.593 [0x7fd5407ff700] DEBUG - NetworkService: Browsing on interface 192.168.1.24 on broadcast address 192.168.1.255 (index: 1)
Dec 03, 2018 10:01:17.593 [0x7fd5407ff700] DEBUG - NetworkService: Browsing on interface 172.18.0.1 on broadcast address 172.18.255.255 (index: 2)
Dec 03, 2018 10:01:17.593 [0x7fd5407ff700] DEBUG - NetworkService: Browsing on interface 172.17.0.1 on broadcast address 172.17.255.255 (index: 3)
Dec 03, 2018 10:01:17.594 [0x7fd558eec840] DEBUG - NetworkService: Creating new service.
Dec 03, 2018 10:01:17.594 [0x7fd558eec840] DEBUG - NetworkService: Got notification of changed network (first change: 1)
Dec 03, 2018 10:01:17.594 [0x7fd558eec840] DEBUG - NetworkService: Quick dispatch of network change.
Dec 03, 2018 10:01:17.595 [0x7fd5407ff700] DEBUG - NetworkService: Network change for browser (polled=1), closing 0 browse sockets.
Dec 03, 2018 10:01:17.595 [0x7fd5407ff700] DEBUG - NetworkService: Browsing on interface 127.0.0.1 on broadcast address 127.255.255.255 (index: 0)
Dec 03, 2018 10:01:17.595 [0x7fd5407ff700] DEBUG - NetworkService: Browsing on interface 192.168.1.24 on broadcast address 192.168.1.255 (index: 1)
Dec 03, 2018 10:01:17.595 [0x7fd5407ff700] DEBUG - NetworkService: Browsing on interface 172.18.0.1 on broadcast address 172.18.255.255 (index: 2)
Dec 03, 2018 10:01:17.595 [0x7fd5407ff700] DEBUG - NetworkService: Browsing on interface 172.17.0.1 on broadcast address 172.17.255.255 (index: 3)
Dec 03, 2018 10:01:17.675 [0x7fd546ffe700] DEBUG - HTTP 200 response from GET http://plex.tv/pms/:/ip
Dec 03, 2018 10:01:17.677 [0x7fd546ffe700] DEBUG - PublicAddressManager: Got public IP from http://plex.tv: 82.158.132.TRUNCATED
Dec 03, 2018 10:01:17.836 [0x7fd5467fd700] DEBUG - HTTP 200 response from GET https://plex.tv/media/providers?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Dec 03, 2018 10:01:17.867 [0x7fd558eec840] DEBUG - Gracenote Version 3.07.7.3686 (build: 2015-07-05 11:45-0700)
Dec 03, 2018 10:01:17.885 [0x7fd558eec840] DEBUG - Gracenote: Using SQLite 3.13.0
Dec 03, 2018 10:01:17.887 [0x7fd54b7ff700] DEBUG - HTTP requesting GET https://plex.tv/media/providers?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Dec 03, 2018 10:01:17.889 [0x7fd558eec840] DEBUG - Starting HTTP server.
Dec 03, 2018 10:01:17.889 [0x7fd558eec840] DEBUG - Running server...
Dec 03, 2018 10:01:17.890 [0x7fd558eec840] DEBUG - Waiting for server condition to be signaled.
Dec 03, 2018 10:01:17.891 [0x7fd53f7ff700] DEBUG - Plex Tuner Service starting.
Dec 03, 2018 10:01:17.892 [0x7fd53effe700] DEBUG - HttpServer: Set up a thread pool with 2 threads.
Dec 03, 2018 10:01:17.892 [0x7fd53effe700] DEBUG - PublicAddressManager: Obtaining public address and mapping port.
Dec 03, 2018 10:01:17.893 [0x7fd53f7ff700] DEBUG - Job running: '/usr/lib/plexmediaserver/Plex Tuner Service' '/usr/lib/plexmediaserver/Resources/Tuner/Private' '/usr/lib/plexmediaserver/Resources/Tuner/Shared' '1.14.0.5470-9d51fdfaa' '32600' '/waitmutex'
Dec 03, 2018 10:01:17.893 [0x7fd53effe700] DEBUG - HTTP requesting GET https://plex.tv/api/v2/release_channels?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Dec 03, 2018 10:01:17.903 [0x7fd53f7ff700] DEBUG - Jobs: Starting child process with pid 366
Dec 03, 2018 10:01:17.941 [0x7fd549ffe700] DEBUG - CERT: incomplete TLS handshake: short read
Dec 03, 2018 10:01:17.970 [0x7fd53d3ff700] DEBUG - Request: [127.0.0.1:58572 (Loopback)] GET / (7 live) GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:01:17.976 [0x7fd53d3ff700] DEBUG - Translator: Found locale da
Dec 03, 2018 10:01:17.977 [0x7fd53d3ff700] DEBUG - Translator: Found locale it
Dec 03, 2018 10:01:17.977 [0x7fd53d3ff700] DEBUG - Translator: Found locale fr
Dec 03, 2018 10:01:17.977 [0x7fd53d3ff700] DEBUG - Translator: Found locale es
Dec 03, 2018 10:01:17.977 [0x7fd53d3ff700] DEBUG - Translator: Found locale hr_HR
Dec 03, 2018 10:01:17.977 [0x7fd53d3ff700] DEBUG - Translator: Found locale lt
Dec 03, 2018 10:01:17.977 [0x7fd53d3ff700] DEBUG - Translator: Found locale ar
Dec 03, 2018 10:01:17.977 [0x7fd53d3ff700] DEBUG - Translator: Found locale nl
Dec 03, 2018 10:01:17.977 [0x7fd53d3ff700] DEBUG - Translator: Found locale de
Dec 03, 2018 10:01:17.977 [0x7fd53d3ff700] DEBUG - Translator: Found locale sv
Dec 03, 2018 10:01:17.977 [0x7fd53d3ff700] DEBUG - Translator: Found locale pt_BR
Dec 03, 2018 10:01:17.977 [0x7fd53d3ff700] DEBUG - Translator: Found locale nl_BE
Dec 03, 2018 10:01:17.977 [0x7fd53d3ff700] DEBUG - Translator: Found locale he
Dec 03, 2018 10:01:17.977 [0x7fd53d3ff700] DEBUG - Translator: Found locale zh_CN
Dec 03, 2018 10:01:17.978 [0x7fd53d3ff700] DEBUG - Translator: Found locale ro
Dec 03, 2018 10:01:17.978 [0x7fd53d3ff700] DEBUG - Translator: Found locale ja_JP
Dec 03, 2018 10:01:17.978 [0x7fd53d3ff700] DEBUG - Translator: Found locale hu_HU
Dec 03, 2018 10:01:17.978 [0x7fd53d3ff700] DEBUG - Translator: Found locale ru
Dec 03, 2018 10:01:17.978 [0x7fd53d3ff700] DEBUG - Translator: Found locale et_EE
Dec 03, 2018 10:01:17.978 [0x7fd53d3ff700] DEBUG - Translator: Found locale sr
Dec 03, 2018 10:01:17.978 [0x7fd53d3ff700] DEBUG - Translator: Found locale en
Dec 03, 2018 10:01:17.979 [0x7fd53cbfe700] DEBUG - Request: [127.0.0.1:58570 (Loopback)] GET /:/plugins/com.plexapp.system/messaging/function/X0J1bmRsZVNlcnZpY2U6QWxsU2VydmljZXM_/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMApyMAo_ (7 live) GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:01:17.981 [0x7fd53d3ff700] DEBUG - Translator: Found locale ko
Dec 03, 2018 10:01:17.982 [0x7fd53d3ff700] DEBUG - Translator: Found locale cs_CZ
Dec 03, 2018 10:01:17.982 [0x7fd53d3ff700] DEBUG - Translator: Found locale no
Dec 03, 2018 10:01:17.993 [0x7fd53c3fd700] DEBUG - Request: [127.0.0.1:58604 (Loopback)] GET / (7 live) GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:01:17.990 [0x7fd53bbfc700] DEBUG - Request: [127.0.0.1:58606 (Loopback)] GET /servers (7 live) GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:01:18.025 [0x7fd5497fd700] DEBUG - HTTP 200 response from GET https://plex.tv/users/account.xml?auth_token=xxxxxxxxxxxxxxxxxxxx&includeGeolocation=1
Dec 03, 2018 10:01:18.035 [0x7fd5497fd700] DEBUG - MyPlex: username is a@gmail.com, login is a@gmail.com, home is 1, has pin
Dec 03, 2018 10:01:18.040 [0x7fd5497fd700] DEBUG - EventSource: Resolving 178.79.168.142 port 443s
Dec 03, 2018 10:01:18.043 [0x7fd54a7ff700] DEBUG - Completed: [127.0.0.1:58606] 200 GET /servers (7 live) GZIP 61ms 491 bytes
Dec 03, 2018 10:01:18.044 [0x7fd53cbfe700] DEBUG - [com.plexapp.system] Sending command over HTTP (GET): /:/plugins/com.plexapp.system/messaging/function/X0J1bmRsZVNlcnZpY2U6QWxsU2VydmljZXM_/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMApyMAo_
Dec 03, 2018 10:01:18.045 [0x7fd53cbfe700] DEBUG - HTTP requesting GET http://127.0.0.1:39479/:/plugins/com.plexapp.system/messaging/function/X0J1bmRsZVNlcnZpY2U6QWxsU2VydmljZXM_/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMApyMAo_
Dec 03, 2018 10:01:18.047 [0x7fd5497fd700] DEBUG - HTTP requesting GET https://plex.tv/api/v2/release_channels?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Dec 03, 2018 10:01:18.050 [0x7fd53abfa700] DEBUG - DVR: Starting up.
Dec 03, 2018 10:01:18.055 [0x7fd54a7ff700] DEBUG - Completed: [127.0.0.1:58572] 200 GET / (6 live) GZIP 109ms 2575 bytes
Dec 03, 2018 10:01:18.059 [0x7fd549ffe700] DEBUG - Completed: [127.0.0.1:58604] 200 GET / (6 live) GZIP 82ms 2575 bytes
Dec 03, 2018 10:01:18.065 [0x7fd549ffe700] DEBUG - EventSource: Resolved 178.79.168.142 to 178.79.168.142
Dec 03, 2018 10:01:18.084 [0x7fd53a3f9700] DEBUG - HTTP requesting GET https://plex.tv/api/v2/server/webhooks?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Dec 03, 2018 10:01:18.093 [0x7fd53abfa700] DEBUG - Activity: registered new activity 94b63547-0290-4f6d-bca9-52d8736d5293 - Processing subscriptions
Dec 03, 2018 10:01:18.200 [0x7fd54a7ff700] DEBUG - EventSource: Connected in 96 ms.
Dec 03, 2018 10:01:18.201 [0x7fd54a7ff700] DEBUG - EventSource: Wrote data, reading reply.
Dec 03, 2018 10:01:18.217 [0x7fd53bbfc700] DEBUG - Request: [127.0.0.1:58632 (Loopback)] GET / (6 live) GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:01:18.223 [0x7fd549ffe700] DEBUG - Completed: [127.0.0.1:58632] 200 GET / (6 live) GZIP 7ms 2575 bytes
Dec 03, 2018 10:01:18.231 [0x7fd53effe700] DEBUG - HTTP 200 response from GET https://plex.tv/api/v2/release_channels?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Dec 03, 2018 10:01:18.262 [0x7fd53effe700] DEBUG - HTTP requesting GET https://plex.tv/api/v2/features?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Dec 03, 2018 10:01:18.265 [0x7fd53d3ff700] DEBUG - Request: [127.0.0.1:58634 (Loopback)] GET /library/sections (6 live) GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:01:18.319 [0x7fd549ffe700] DEBUG - Completed: [127.0.0.1:58634] 200 GET /library/sections (6 live) GZIP 54ms 1027 bytes
Dec 03, 2018 10:01:18.328 [0x7fd54a7ff700] DEBUG - EventSource: Read HTTP reply header.
Dec 03, 2018 10:01:18.328 [0x7fd54a7ff700] DEBUG - MyPlex: We appear to have regained Internet connectivity.
Dec 03, 2018 10:01:18.328 [0x7fd54a7ff700] DEBUG - PublicAddressManager: Obtaining public address and mapping port.
Dec 03, 2018 10:01:18.328 [0x7fd54a7ff700] DEBUG - EventSource: Successfully connected to 178.79.168.142.
Dec 03, 2018 10:01:18.388 [0x7fd53c3fd700] DEBUG - Request: [127.0.0.1:58640 (Loopback)] GET /channels/all (6 live) GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:01:18.390 [0x7fd549ffe700] DEBUG - Completed: [127.0.0.1:58640] 200 GET /channels/all (6 live) GZIP 2ms 387 bytes
Dec 03, 2018 10:01:18.397 [0x7fd54b7ff700] DEBUG - HTTP 200 response from GET https://plex.tv/media/providers?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Dec 03, 2018 10:01:18.408 [0x7fd54b7ff700] DEBUG - HTTP requesting GET https://plex.tv/media/providers?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Dec 03, 2018 10:01:18.410 [0x7fd5497fd700] DEBUG - HTTP 200 response from GET https://plex.tv/api/v2/release_channels?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Dec 03, 2018 10:01:18.413 [0x7fd54a7ff700] DEBUG - EventSource: Got event [data] '<Message host="178.79.148.211" port="443" command="startRelay"/>'
Dec 03, 2018 10:01:18.414 [0x7fd54a7ff700] DEBUG - HTTP requesting GET https://downloads.plex.tv/relay/relay_v1.pub
Dec 03, 2018 10:01:18.417 [0x7fd5497fd700] DEBUG - Sync: onMyPlexSignIn
Dec 03, 2018 10:01:18.418 [0x7fd5497fd700] DEBUG - HTTP requesting GET https://plex.tv/servers/e7f44c013808a4bef0c9631d075fbb02c00bf13b/sync_lists?auth_token=xxxxxxxxxxxxxxxxxxxx
Dec 03, 2018 10:01:18.523 [0x7fd53bbfc700] DEBUG - Request: [127.0.0.1:58648 (Loopback)] GET /library/sections (6 live) GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:01:18.533 [0x7fd549ffe700] DEBUG - Completed: [127.0.0.1:58648] 200 GET /library/sections (6 live) GZIP 10ms 1027 bytes
Dec 03, 2018 10:01:18.607 [0x7fd54a7ff700] DEBUG - HTTP 200 response from GET https://downloads.plex.tv/relay/relay_v1.pub
Dec 03, 2018 10:01:18.629 [0x7fd54a7ff700] DEBUG - Relay: refreshed host key from https://downloads.plex.tv/relay/relay_v1.pub
Dec 03, 2018 10:01:18.629 [0x7fd54a7ff700] DEBUG - Relay: starting relay.
Dec 03, 2018 10:01:18.630 [0x7fd54a7ff700] DEBUG - Job running: PLEXTOKEN='xxxxxxxxxxxxxxxxxxxx' '/usr/lib/plexmediaserver/Plex Relay' '-p' '443' '-N' '-R' '0:localhost:32401' '-o' 'StrictHostKeyChecking=yes' '-o' 'UserKnownHostsFile=/config/Library/Application Support/Plex Media Server/Cache/relayHostKey.txt' '-o' 'NoneSwitch=yes' '-o' 'NoneEnabled=yes' '-o' 'LogLevel=VERBOSE' '-o' 'PreferredAuthentications=password' '-o' 'PubkeyAuthentication=no' '-l' 'a@gmail.com' '-F' '/dev/null' '178.79.148.211'
Dec 03, 2018 10:01:18.615 [0x7fd53effe700] DEBUG - HTTP 200 response from GET https://plex.tv/api/v2/features?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Dec 03, 2018 10:01:18.653 [0x7fd53d3ff700] DEBUG - Request: [127.0.0.1:58650 (Loopback)] GET /channels/all (6 live) GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:01:18.659 [0x7fd53effe700] DEBUG - Running database fix-ups.
Dec 03, 2018 10:01:18.660 [0x7fd54a7ff700] DEBUG - Jobs: Starting child process with pid 386
Dec 03, 2018 10:01:18.676 [0x7fd54a7ff700] DEBUG - Completed: [127.0.0.1:58650] 200 GET /channels/all (6 live) GZIP 25ms 387 bytes
Dec 03, 2018 10:01:18.700 [0x7fd53a3f9700] DEBUG - HTTP 200 response from GET https://plex.tv/api/v2/server/webhooks?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Dec 03, 2018 10:01:18.720 [0x7fd53effe700] DEBUG - Database Fixups: Destroyed 0 transient items.
Dec 03, 2018 10:01:18.704 [0x7fd54b7ff700] DEBUG - HTTP 200 response from GET https://plex.tv/media/providers?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Dec 03, 2018 10:01:18.757 [0x7fd5497fd700] DEBUG - HTTP 200 response from GET https://plex.tv/servers/e7f44c013808a4bef0c9631d075fbb02c00bf13b/sync_lists?auth_token=xxxxxxxxxxxxxxxxxxxx
Dec 03, 2018 10:01:18.777 [0x7fd5497fd700] DEBUG - Sync: downloaded 1 sync lists, analyzing now...
Dec 03, 2018 10:01:18.778 [0x7fd5497fd700] DEBUG - Sync: sync list 28849206: user 1 (a@gmail.com), device aifon, profile iOS, id 2FC33889-9F0E-49EF-AFC4-260353B50DBB, sync item(s): 31847138
Dec 03, 2018 10:01:18.786 [0x7fd5497fd700] DEBUG - Sync: synchronizing 1 sync lists to generators
Dec 03, 2018 10:01:18.796 [0x7fd5497fd700] DEBUG - BPQ: generator 36 is in complete state
Dec 03, 2018 10:01:18.796 [0x7fd5497fd700] DEBUG - Sync: sync list 28849206, sync item 31847138 is in complete state
Dec 03, 2018 10:01:18.801 [0x7fd5497fd700] DEBUG - Sync: synchronized 1 sync list(s) to 1 generators
Dec 03, 2018 10:01:18.804 [0x7fd5497fd700] INFO - Sync: downloaded 1 sync list(s) with 1 sync items(s): 0 new, 0 updated, 0 deleted
Dec 03, 2018 10:01:18.812 [0x7fd5497fd700] DEBUG - HTTP requesting GET https://plex.tv/api/v2/features?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Dec 03, 2018 10:01:18.820 [0x7fd539bf8700] DEBUG - BPQ: garbageCollect - sync - forced - 10
Dec 03, 2018 10:01:18.829 [0x7fd539bf8700] DEBUG - Sync: starting Sync garbage collection: 10, forced
Dec 03, 2018 10:01:18.829 [0x7fd539bf8700] DEBUG - Sync: garbage collecting filesystem
Dec 03, 2018 10:01:18.839 [0x7fd539bf8700] DEBUG - Sync: garbage collected filesystem
Dec 03, 2018 10:01:18.839 [0x7fd539bf8700] DEBUG - Sync: scanning for items to reprocess in sync list 28849206
Dec 03, 2018 10:01:18.841 [0x7fd539bf8700] DEBUG - Sync: scanned for items to reprocess in sync list 28849206
Dec 03, 2018 10:01:18.841 [0x7fd539bf8700] DEBUG - Sync: finished Sync garbage collection: 10
Dec 03, 2018 10:01:18.841 [0x7fd539bf8700] DEBUG - Sync: updating status for sync list 28849206, sync item 31847138, generator 36
Dec 03, 2018 10:01:18.883 [0x7fd544fff700] DEBUG - Gracenote: Loading 29 locales in 1.0 seconds.
Dec 03, 2018 10:01:18.897 [0x7fd53effe700] DEBUG - Collections: Found 42 collections tags in section 1.
Dec 03, 2018 10:01:18.899 [0x7fd53effe700] DEBUG - Collections: We had 45 collections in the library already.
Dec 03, 2018 10:01:18.899 [0x7fd53effe700] DEBUG - Collections: Synced tags in section 1 in 150ms.
Dec 03, 2018 10:01:19.054 [0x7fd53effe700] WARN - Held transaction for too long (../Library/MetadataCollection.cpp:236): 0.130000 seconds
Dec 03, 2018 10:01:19.058 [0x7fd53effe700] DEBUG - Collections: Refreshed attributes for 42 collections in section 1 in 158ms.
Dec 03, 2018 10:01:19.075 [0x7fd53effe700] DEBUG - Collection: Refreshed visibility in section 1 in 15ms.
Dec 03, 2018 10:01:19.080 [0x7fd53effe700] DEBUG - Collections: Found 0 collections tags in section 4.
Dec 03, 2018 10:01:19.081 [0x7fd53effe700] DEBUG - Collections: We had 0 collections in the library already.
Dec 03, 2018 10:01:19.081 [0x7fd53effe700] DEBUG - Collections: Synced tags in section 4 in 3ms.
Dec 03, 2018 10:01:19.085 [0x7fd53effe700] DEBUG - Collections: Refreshed attributes for 0 collections in section 4 in 4ms.
Dec 03, 2018 10:01:19.092 [0x7fd53effe700] DEBUG - Collection: Refreshed visibility in section 4 in 6ms.
Dec 03, 2018 10:01:19.097 [0x7fd53effe700] DEBUG - Collections: Found 0 collections tags in section 6.
Dec 03, 2018 10:01:19.098 [0x7fd53effe700] DEBUG - Collections: We had 0 collections in the library already.
Dec 03, 2018 10:01:19.098 [0x7fd53effe700] DEBUG - Collections: Synced tags in section 6 in 3ms.
Dec 03, 2018 10:01:19.102 [0x7fd53effe700] DEBUG - Collections: Refreshed attributes for 0 collections in section 6 in 3ms.
Dec 03, 2018 10:01:19.108 [0x7fd53effe700] DEBUG - Collection: Refreshed visibility in section 6 in 4ms.
Dec 03, 2018 10:01:19.108 [0x7fd53effe700] DEBUG - Running database fix-ups completed in 0.4 seconds.
Dec 03, 2018 10:01:19.109 [0x7fd53effe700] DEBUG - HTTP requesting GET https://plex.tv/api/v2/user/privacy?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Dec 03, 2018 10:01:19.126 [0x7fd5497fd700] DEBUG - HTTP 200 response from GET https://plex.tv/api/v2/features?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Dec 03, 2018 10:01:19.132 [0x7fd5497fd700] DEBUG - HTTP requesting GET https://plex.tv/api/v2/user/privacy?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Dec 03, 2018 10:01:19.341 [0x7fd53c3fd700] DEBUG - [PlexRelay] Authenticated to 178.79.148.211 ([178.79.148.211]:443).
Dec 03, 2018 10:01:19.367 [0x7fd542bfe700] DEBUG - HTTP 200 response from GET http://127.0.0.1:39479/system/agents
Dec 03, 2018 10:01:19.369 [0x7fd542bfe700] DEBUG - [com.plexapp.system] HTTP reply status 200, with 9478 bytes of content.
Dec 03, 2018 10:01:19.371 [0x7fd53effe700] DEBUG - HTTP 200 response from GET https://plex.tv/api/v2/user/privacy?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Dec 03, 2018 10:01:19.390 [0x7fd5497fd700] DEBUG - HTTP 200 response from GET https://plex.tv/api/v2/user/privacy?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Dec 03, 2018 10:01:19.391 [0x7fd542bfe700] DEBUG - The system knows about 15 agents.
Dec 03, 2018 10:01:19.392 [0x7fd5393f7700] DEBUG - Starting plug-in /usr/lib/plexmediaserver/Resources/Plug-ins-9d51fdfaa/HTbackdrops.bundle.
Dec 03, 2018 10:01:19.396 [0x7fd542bfe700] DEBUG - Waiting for 20 plug-ins to finish starting.
Dec 03, 2018 10:01:19.396 [0x7fd54b7ff700] DEBUG - HTTP requesting GET https://plex.tv/media/providers?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Dec 03, 2018 10:01:19.396 [0x7fd5497fd700] DEBUG - HTTP requesting GET https://plex.tv/api/resources.xml?includeHttps=1&auth_token=xxxxxxxxxxxxxxxxxxxx
Dec 03, 2018 10:01:19.396 [0x7fd538bf6700] DEBUG - Starting plug-in /usr/lib/plexmediaserver/Resources/Plug-ins-9d51fdfaa/PlexMusic.bundle.
Dec 03, 2018 10:01:19.397 [0x7fd5383f5700] DEBUG - Starting plug-in /usr/lib/plexmediaserver/Resources/Plug-ins-9d51fdfaa/LocalMedia.bundle.
Dec 03, 2018 10:01:19.398 [0x7fd5393f7700] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.htbackdrops] yet.
Dec 03, 2018 10:01:19.398 [0x7fd5393f7700] DEBUG - Starting plug-in /usr/lib/plexmediaserver/Resources/Plug-ins-9d51fdfaa/PlexMovie.bundle.
Dec 03, 2018 10:01:19.400 [0x7fd538bf6700] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.plexmusic] yet.
Dec 03, 2018 10:01:19.401 [0x7fd538bf6700] DEBUG - Starting plug-in /usr/lib/plexmediaserver/Resources/Plug-ins-9d51fdfaa/Media-Flags.bundle.
Dec 03, 2018 10:01:19.402 [0x7fd5393f7700] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.imdb] yet.
Dec 03, 2018 10:01:19.402 [0x7fd5393f7700] DEBUG - Starting plug-in /usr/lib/plexmediaserver/Resources/Plug-ins-9d51fdfaa/Scanners.bundle.
Dec 03, 2018 10:01:19.402 [0x7fd5383f5700] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.localmedia] yet.
Dec 03, 2018 10:01:19.402 [0x7fd5383f5700] DEBUG - Starting plug-in /usr/lib/plexmediaserver/Resources/Plug-ins-9d51fdfaa/PersonalMedia.bundle.
Dec 03, 2018 10:01:19.403 [0x7fd538bf6700] DEBUG - Starting plug-in /usr/lib/plexmediaserver/Resources/Plug-ins-9d51fdfaa/LastFM.bundle.
Dec 03, 2018 10:01:19.404 [0x7fd5393f7700] DEBUG - Starting plug-in /usr/lib/plexmediaserver/Resources/Plug-ins-9d51fdfaa/WebClient.bundle.
Dec 03, 2018 10:01:19.406 [0x7fd5383f5700] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.none] yet.
Dec 03, 2018 10:01:19.406 [0x7fd5383f5700] DEBUG - Starting plug-in /usr/lib/plexmediaserver/Resources/Plug-ins-9d51fdfaa/Framework.bundle.
Dec 03, 2018 10:01:19.406 [0x7fd538bf6700] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.lastfm] yet.
Dec 03, 2018 10:01:19.407 [0x7fd538bf6700] DEBUG - Starting plug-in /usr/lib/plexmediaserver/Resources/Plug-ins-9d51fdfaa/TheMovieDB.bundle.
Dec 03, 2018 10:01:19.407 [0x7fd5393f7700] DEBUG - Starting plug-in /usr/lib/plexmediaserver/Resources/Plug-ins-9d51fdfaa/OpenSubtitles.bundle.
Dec 03, 2018 10:01:19.410 [0x7fd5393f7700] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.opensubtitles] yet.
Dec 03, 2018 10:01:19.410 [0x7fd5383f5700] DEBUG - Starting plug-in /usr/lib/plexmediaserver/Resources/Plug-ins-9d51fdfaa/LyricFind.bundle.
Dec 03, 2018 10:01:19.410 [0x7fd538bf6700] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.themoviedb] yet.
Dec 03, 2018 10:01:19.410 [0x7fd5393f7700] DEBUG - Starting plug-in /usr/lib/plexmediaserver/Resources/Plug-ins-9d51fdfaa/PlexThemeMusic.bundle.
Dec 03, 2018 10:01:19.410 [0x7fd538bf6700] DEBUG - Starting plug-in /usr/lib/plexmediaserver/Resources/Plug-ins-9d51fdfaa/TheTVDB.bundle.
Dec 03, 2018 10:01:19.414 [0x7fd5393f7700] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.plexthememusic] yet.
Dec 03, 2018 10:01:19.414 [0x7fd538bf6700] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.thetvdb] yet.
Dec 03, 2018 10:01:19.414 [0x7fd538bf6700] DEBUG - Starting plug-in /usr/lib/plexmediaserver/Resources/Plug-ins-9d51fdfaa/Fanart-TV.bundle.
Dec 03, 2018 10:01:19.414 [0x7fd5393f7700] DEBUG - Starting plug-in /usr/lib/plexmediaserver/Resources/Plug-ins-9d51fdfaa/MoviePosterDB.bundle.
Dec 03, 2018 10:01:19.415 [0x7fd5383f5700] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.lyricfind] yet.
Dec 03, 2018 10:01:19.415 [0x7fd5383f5700] DEBUG - Starting plug-in /config/Library/Application Support/Plex Media Server/Plug-ins/XBMCnfoMoviesImporter.bundle.
Dec 03, 2018 10:01:19.416 [0x7fd53cbfe700] DEBUG - HTTP 200 response from GET http://127.0.0.1:39479/:/plugins/com.plexapp.system/messaging/function/X0J1bmRsZVNlcnZpY2U6QWxsU2VydmljZXM_/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMApyMAo_
Dec 03, 2018 10:01:19.417 [0x7fd53cbfe700] DEBUG - [com.plexapp.system] HTTP reply status 200, with 59986 bytes of content.
Dec 03, 2018 10:01:19.418 [0x7fd538bf6700] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.fanarttv] yet.
Dec 03, 2018 10:01:19.418 [0x7fd538bf6700] DEBUG - Starting plug-in /config/Library/Application Support/Plex Media Server/Plug-ins/Services.bundle.
Dec 03, 2018 10:01:19.419 [0x7fd5393f7700] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.movieposterdb] yet.
Dec 03, 2018 10:01:19.419 [0x7fd5393f7700] DEBUG - Starting plug-in /config/Library/Application Support/Plex Media Server/Plug-ins/FilmAffinity.bundle.
Dec 03, 2018 10:01:19.419 [0x7fd5383f5700] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.xbmcnfo] yet.
Dec 03, 2018 10:01:19.423 [0x7fd5393f7700] DEBUG - Perfect cache hit, we don't need to start [com.plexapp.agents.filmaffinity] yet.
Dec 03, 2018 10:01:19.425 [0x7fd542bfe700] DEBUG - Starting scheduled updates, every 7200 seconds
Dec 03, 2018 10:01:19.425 [0x7fd542bfe700] INFO - Refreshing paths watched by LibraryUpdateManager
Dec 03, 2018 10:01:19.427 [0x7fd542bfe700] DEBUG - LibraryUpdateManager will start watching /data/movies/musica
Dec 03, 2018 10:01:19.427 [0x7fd537bf4700] DEBUG - Downloading document http://127.0.0.1:32400/:/plugins/com.plexapp.agents.imdb/prefs
Dec 03, 2018 10:01:19.428 [0x7fd542bfe700] DEBUG - LibraryUpdateManager will start watching /data/movies/xxx
Dec 03, 2018 10:01:19.429 [0x7fd542bfe700] DEBUG - LibraryUpdateManager will start watching /data/movies/peliculas
Dec 03, 2018 10:01:19.430 [0x7fd542bfe700] DEBUG - LibraryUpdateManager will start watching /data/movies/series
Dec 03, 2018 10:01:19.430 [0x7fd542bfe700] DEBUG - [Notify] Initializing.
Dec 03, 2018 10:01:19.431 [0x7fd53abfa700] DEBUG - [Notify] Now watching /data/movies/musica
Dec 03, 2018 10:01:19.431 [0x7fd537bf4700] DEBUG - Starting file watcher for com.plexapp.agents.imdb
Dec 03, 2018 10:01:19.431 [0x7fd53abfa700] DEBUG - [Notify] Now watching /data/movies/musica/Bonfire - Legends (2018)
Dec 03, 2018 10:01:19.432 [0x7fd53abfa700] DEBUG - [Notify] Now watching /data/movies/musica/Bonfire - Legends (2018)/CD1
Dec 03, 2018 10:01:19.432 [0x7fd53abfa700] DEBUG - [Notify] Now watching /data/movies/musica/Bonfire - Legends (2018)/CD2
Dec 03, 2018 10:01:19.433 [0x7fd5373f3700] DEBUG - [Notify] Waiting for inotify notifications...
Dec 03, 2018 10:01:19.433 [0x7fd53abfa700] DEBUG - [Notify] Now watching /data/movies/musica/Muse - Simulation Theory (Deluxe Edition) (2018)
Dec 03, 2018 10:01:19.433 [0x7fd542bfe700] DEBUG - Done waiting for all plug-ins to start.
Dec 03, 2018 10:01:19.433 [0x7fd542bfe700] DEBUG - PluginRepository::setStartState: 3, complete
Dec 03, 2018 10:01:19.433 [0x7fd53abfa700] DEBUG - [Notify] Now watching /data/movies/musica/Slash - Living The Dream (2018)
Dec 03, 2018 10:01:19.434 [0x7fd53abfa700] DEBUG - [Notify] Now watching /data/movies/musica/The Midnight - Kids (2018)
Dec 03, 2018 10:01:19.434 [0x7fd53abfa700] DEBUG - [Notify] Now watching /data/movies/musica/Gunship - Dark All Day (2018)
Dec 03, 2018 10:01:19.435 [0x7fd53abfa700] DEBUG - [Notify] Now watching /data/movies/musica/Manic Street Preachers - Resistance Is Futile (Deluxe Edition) (2018)
Dec 03, 2018 10:01:19.435 [0x7fd53abfa700] DEBUG - [Notify] Now watching /data/movies/musica/Manic Street Preachers - Resistance Is Futile (Deluxe Edition) (2018)/Disc 01
Dec 03, 2018 10:01:19.435 [0x7fd53abfa700] DEBUG - [Notify] Now watching /data/movies/musica/Manic Street Preachers - Resistance Is Futile (Deluxe Edition) (2018)/Disc 02
Dec 03, 2018 10:01:19.436 [0x7fd53abfa700] DEBUG - [Notify] Now watching /data/movies/musica/Mumford & Sons - Delta (2018)
Dec 03, 2018 10:01:19.436 [0x7fd54a7ff700] DEBUG - Completed: [127.0.0.1:58570] 200 GET /:/plugins/com.plexapp.system/messaging/function/X0J1bmRsZVNlcnZpY2U6QWxsU2VydmljZXM_/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMApyMAo_ (6 live) GZIP 1475ms 19409 bytes
Dec 03, 2018 10:01:19.436 [0x7fd53abfa700] DEBUG - [Notify] Now watching /data/movies/musica/Café Quijano - La Vida No Es La La La (2018)
Dec 03, 2018 10:01:19.436 [0x7fd53abfa700] DEBUG - [Notify] Now watching /data/movies/musica/Vanesa Martín - Todas Las Mujeres Que Habitan En Mí (2018)
Dec 03, 2018 10:01:19.437 [0x7fd53abfa700] DEBUG - [Notify] Now watching /data/movies/peliculas
Dec 03, 2018 10:01:19.437 [0x7fd53abfa700] DEBUG - [Notify] Now watching /data/movies/peliculas/piniculas
Dec 03, 2018 10:01:19.437 [0x7fd537bf4700] DEBUG - Spawned plug-in com.plexapp.agents.imdb with PID 398
Dec 03, 2018 10:01:19.438 [0x7fd537bf4700] DEBUG - [com.plexapp.agents.imdb] Sending command: GET /:/prefixes
Dec 03, 2018 10:01:19.438 [0x7fd53abfa700] DEBUG - [Notify] Now watching /data/movies/peliculas/piniculas/Aprendiz De Gigolo [BluRay Rip][AC3 5.1 Español Castellano][2014]
Dec 03, 2018 10:01:19.439 [0x7fd53abfa700] DEBUG - [Notify] Now watching /data/movies/peliculas/piniculas/Dallas buyers club (2013).HDrip
Dec 03, 2018 10:01:19.439 [0x7fd53abfa700] DEBUG - [Notify] Now watching /data/movies/peliculas/piniculas/Hijos de los Hombres.DVDRip.Spanish.(www.lokotorrents.com)
Dec 03, 2018 10:01:19.440 [0x7fd53abfa700] DEBUG - [Notify] Now watching /data/movies/peliculas/piniculas/Historias de nueva york.HDrip
Dec 03, 2018 10:01:19.440 [0x7fd53abfa700] DEBUG - [Notify] Now watching /data/movies/peliculas/piniculas/Miss Bala 2011 BRRip 720p x264 AAC
Dec 03, 2018 10:01:19.440 [0x7fd53abfa700] DEBUG - [Notify] Now watching /data/movies/peliculas/piniculas/The bling ring (2013).HDrip
Dec 03, 2018 10:01:19.441 [0x7fd53abfa700] DEBUG - [Notify] Now watching /data/movies/peliculas/piniculas/Vivir es facil con los ojos cerrados (2013).HDrip
Dec 03, 2018 10:01:19.444 [0x7fd53abfa700] DEBUG - [Notify] Now watching /data/movies/series
Dec 03, 2018 10:01:19.444 [0x7fd53abfa700] DEBUG - [Notify] Now watching /data/movies/series/El infiltrado
Dec 03, 2018 10:01:19.445 [0x7fd53abfa700] DEBUG - [Notify] Now watching /data/movies/series/Mira Lo Que Has Hecho
Dec 03, 2018 10:01:19.445 [0x7fd53abfa700] DEBUG - [Notify] Now watching /data/movies/series/Gigantes
Dec 03, 2018 10:01:19.446 [0x7fd53abfa700] DEBUG - [Notify] Now watching /data/movies/series/Crematorio
Dec 03, 2018 10:01:19.446 [0x7fd53abfa700] DEBUG - [Notify] Now watching /data/movies/series/Stranger Things
Dec 03, 2018 10:01:19.446 [0x7fd53abfa700] DEBUG - [Notify] Now watching /data/movies/series/Stranger Things/Temporada 2
Dec 03, 2018 10:01:19.447 [0x7fd53abfa700] DEBUG - [Notify] Now watching /data/movies/xxx
Dec 03, 2018 10:01:19.574 [0x7fd5407ff700] DEBUG - NetworkService: Network change for browser (polled=0), closing 0 browse sockets.
Dec 03, 2018 10:01:19.574 [0x7fd5407ff700] DEBUG - NetworkService: Setting up multicast listener on 0.0.0.0:1901 (outbound: 0)
Dec 03, 2018 10:01:19.574 [0x7fd5407ff700] DEBUG - NetworkService: Browsing on interface 192.168.1.24 on broadcast address 239.255.255.250 (index: 0)
Dec 03, 2018 10:01:19.574 [0x7fd5407ff700] DEBUG - NetworkService: Browsing on interface 172.18.0.1 on broadcast address 239.255.255.250 (index: 1)
Dec 03, 2018 10:01:19.574 [0x7fd5407ff700] DEBUG - NetworkService: Browsing on interface 172.17.0.1 on broadcast address 239.255.255.250 (index: 2)
Dec 03, 2018 10:01:19.575 [0x7fd5407ff700] ERROR - Network Service: Error in browser handle read: 125 (Operation canceled) socket=-1
Dec 03, 2018 10:01:19.609 [0x7fd53bbfc700] ERROR - [PlexRelay] kex protocol error: type 7 seq 11
Dec 03, 2018 10:01:19.675 [0x7fd5407ff700] INFO - Network Service: Abandoning browse socket, it was closed.
Dec 03, 2018 10:01:19.679 [0x7fd5497fd700] DEBUG - HTTP 200 response from GET https://plex.tv/api/resources.xml?includeHttps=1&auth_token=xxxxxxxxxxxxxxxxxxxx
Dec 03, 2018 10:01:19.684 [0x7fd53a3f9700] DEBUG - Media Server: Tested all servers in 0.0 seconds.
Dec 03, 2018 10:01:19.684 [0x7fd5497fd700] DEBUG - MyPlex: Updating device connections (from timer: 0)
Dec 03, 2018 10:01:19.685 [0x7fd5497fd700] DEBUG - HTTP requesting PUT https://plex.tv/devices/e7f44c013808a4bef0c9631d075fbb02c00bf13b?Connection[][uri]=http://192.168.1.24:32400&Connection[][uri]=http://172.18.0.1:32400&Connection[][uri]=http://172.17.0.1:32400&httpsEnabled=1&httpsRequired=0&X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Dec 03, 2018 10:01:19.688 [0x7fd54b7ff700] DEBUG - HTTP 200 response from GET https://plex.tv/media/providers?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Dec 03, 2018 10:01:19.694 [0x7fd5393f7700] DEBUG - MyPlex: Sending Server Info to myPlex (user=a@gmail.com, ip=, port=0)
Dec 03, 2018 10:01:19.697 [0x7fd5393f7700] DEBUG - HTTP requesting POST https://plex.tv/servers.xml?auth_token=xxxxxxxxxxxxxxxxxxxx&async=1&asyncIdentifier=61c63132-14e4-497b-bd58-b1c6b703a9cd
Dec 03, 2018 10:01:19.755 [0x7fd53d3ff700] INFO - [PlexRelay] Allocated port 30827 for remote forward to localhost:32401
Dec 03, 2018 10:01:19.959 [0x7fd5497fd700] DEBUG - HTTP 200 response from PUT https://plex.tv/devices/e7f44c013808a4bef0c9631d075fbb02c00bf13b?Connection[][uri]=http://192.168.1.24:32400&Connection[][uri]=http://172.18.0.1:32400&Connection[][uri]=http://172.17.0.1:32400&httpsEnabled=1&httpsRequired=0&X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Dec 03, 2018 10:01:19.977 [0x7fd5497fd700] DEBUG - CERT: Certificate will not expire soon.
Dec 03, 2018 10:01:19.998 [0x7fd5393f7700] DEBUG - HTTP 201 response from POST https://plex.tv/servers.xml?auth_token=xxxxxxxxxxxxxxxxxxxx&async=1&asyncIdentifier=61c63132-14e4-497b-bd58-b1c6b703a9cd
Dec 03, 2018 10:01:19.999 [0x7fd5393f7700] DEBUG - MyPlex: Published Mapping State response was 201
Dec 03, 2018 10:01:20.000 [0x7fd5393f7700] DEBUG - MyPlex: Got response for e7f44c013808a4bef0c9631d075fbb02c00bf13b ~ registered :0
Dec 03, 2018 10:01:20.015 [0x7fd549ffe700] DEBUG - EventSource: Got event [data] '<Message address="" port="0" asyncIdentifier="61c63132-14e4-497b-bd58-b1c6b703a9cd" connectivity="0" command="notifyConnectivity"/>'
Dec 03, 2018 10:01:20.015 [0x7fd549ffe700] DEBUG - MyPlex: inaccessibility report ignored because NAT punch is still pending.
Dec 03, 2018 10:01:20.015 [0x7fd549ffe700] DEBUG - PubSub: Got notified of reachability: 0 for :0
Dec 03, 2018 10:01:20.673 [0x7fd545ffc700] DEBUG - NAT: UPnP, found device <http://192.168.1.1:80/RootDevice.xml> with private address <192.168.1.24>
Dec 03, 2018 10:01:20.693 [0x7fd545ffc700] DEBUG - NAT: UPnP, usable device <http://192.168.1.1:80/RootDevice.xml> with private address <192.168.1.24>.
Dec 03, 2018 10:01:20.703 [0x7fd546ffe700] DEBUG - NAT: UPnP, found device <http://192.168.1.1:80/RootDevice.xml> with private address <192.168.1.24>
Dec 03, 2018 10:01:20.741 [0x7fd545ffc700] DEBUG - NAT: UPnP, mapped port 18191 to 192.168.1.24:32400.
Dec 03, 2018 10:01:20.741 [0x7fd545ffc700] DEBUG - PublicAddressManager: Mapping succeeded for 192.168.1.24:18191.
Dec 03, 2018 10:01:20.743 [0x7fd545ffc700] DEBUG - MyPlex: Last published value didn't change, we're done.
Dec 03, 2018 10:01:20.743 [0x7fd546ffe700] DEBUG - NAT: UPnP, usable device <http://192.168.1.1:80/RootDevice.xml> with private address <192.168.1.24>.
Dec 03, 2018 10:01:20.752 [0x7fd546ffe700] DEBUG - NAT: UPnP, public address is 82.158.132.TRUNCATED
Dec 03, 2018 10:01:20.793 [0x7fd546ffe700] DEBUG - MyPlex: Sending Server Info to myPlex (user=a@gmail.com, ip=, port=18191)
Dec 03, 2018 10:01:20.795 [0x7fd546ffe700] DEBUG - HTTP requesting POST https://plex.tv/servers.xml?auth_token=xxxxxxxxxxxxxxxxxxxx&async=1&asyncIdentifier=b4659541-0009-42b0-be7c-14a0fc21fab3
Dec 03, 2018 10:01:21.127 [0x7fd546ffe700] DEBUG - HTTP 201 response from POST https://plex.tv/servers.xml?auth_token=xxxxxxxxxxxxxxxxxxxx&async=1&asyncIdentifier=b4659541-0009-42b0-be7c-14a0fc21fab3
Dec 03, 2018 10:01:21.128 [0x7fd546ffe700] DEBUG - MyPlex: Published Mapping State response was 201
Dec 03, 2018 10:01:21.129 [0x7fd546ffe700] DEBUG - MyPlex: Got response for e7f44c013808a4bef0c9631d075fbb02c00bf13b ~ registered :0
Dec 03, 2018 10:01:21.131 [0x7fd546ffe700] DEBUG - MyPlex: Last published value didn't change, we're done.
Dec 03, 2018 10:01:21.877 [0x7fd53c3fd700] DEBUG - Request: [127.0.0.1:58694 (Loopback)] GET /system/messaging/clear_events/com.plexapp.agents.imdb (6 live) GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:01:21.878 [0x7fd53c3fd700] DEBUG - [com.plexapp.system] Sending command over HTTP (GET): /system/messaging/clear_events/com.plexapp.agents.imdb
Dec 03, 2018 10:01:21.878 [0x7fd53c3fd700] DEBUG - HTTP requesting GET http://127.0.0.1:39479/system/messaging/clear_events/com.plexapp.agents.imdb
Dec 03, 2018 10:01:22.044 [0x7fd53c3fd700] DEBUG - HTTP 200 response from GET http://127.0.0.1:39479/system/messaging/clear_events/com.plexapp.agents.imdb
Dec 03, 2018 10:01:22.045 [0x7fd53c3fd700] DEBUG - [com.plexapp.system] HTTP reply status 200, with 0 bytes of content.
Dec 03, 2018 10:01:22.046 [0x7fd54a7ff700] DEBUG - Completed: [127.0.0.1:58694] 200 GET /system/messaging/clear_events/com.plexapp.agents.imdb (6 live) GZIP 169ms 330 bytes
Dec 03, 2018 10:01:22.177 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:01:22.178 [0x7fd53cbfe700] DEBUG - Request: [192.168.1.10:54885 (Subnet)] GET /media/providers (6 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:01:22.228 [0x7fd549ffe700] DEBUG - Completed: [192.168.1.10:54885] 200 GET /media/providers (6 live) TLS GZIP 50ms 3021 bytes (pipelined: 1)
Dec 03, 2018 10:01:22.351 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:01:22.353 [0x7fd53bbfc700] DEBUG - Request: [192.168.1.10:54885 (Subnet)] GET /updater/status (6 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:01:22.360 [0x7fd54a7ff700] DEBUG - Completed: [192.168.1.10:54885] 200 GET /updater/status (7 live) TLS GZIP 8ms 506 bytes (pipelined: 2)
Dec 03, 2018 10:01:22.383 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:01:22.384 [0x7fd53d3ff700] DEBUG - Request: [192.168.1.10:54889 (Subnet)] GET /:/websockets/notifications (6 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:01:22.385 [0x7fd53d3ff700] DEBUG - WebSocket: Performing handshake from origin https://app.plex.tv
Dec 03, 2018 10:01:22.386 [0x7fd53d3ff700] DEBUG - Beginning read from WebSocket
Dec 03, 2018 10:01:22.409 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:01:22.410 [0x7fd53c3fd700] DEBUG - Request: [192.168.1.10:54885 (Subnet)] PUT /updater/check?download=0 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:01:22.411 [0x7fd53c3fd700] DEBUG - AutoUpdate: requesting check endpoint: /updater/products/1/check.xml?build=linux-ubuntu-x86_64&channel=16&distribution=ubuntu&version=1.14.0.5470-9d51fdfaa, download: NO
Dec 03, 2018 10:01:22.412 [0x7fd53c3fd700] DEBUG - Downloading document https://plex.tv/updater/products/1/check.xml?build=linux-ubuntu-x86_64&channel=16&distribution=ubuntu&version=1.14.0.5470-9d51fdfaa
Dec 03, 2018 10:01:22.412 [0x7fd53c3fd700] DEBUG - HTTP requesting GET https://plex.tv/updater/products/1/check.xml?build=linux-ubuntu-x86_64&channel=16&distribution=ubuntu&version=1.14.0.5470-9d51fdfaa
Dec 03, 2018 10:01:22.455 [0x7fd53cbfe700] DEBUG - Request: [127.0.0.1:58706 (Loopback)] GET /:/plugins/com.plexapp.system/resourceHashes (7 live) GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:01:22.456 [0x7fd53cbfe700] DEBUG - [com.plexapp.system] Sending command over HTTP (GET): /:/plugins/com.plexapp.system/resourceHashes
Dec 03, 2018 10:01:22.457 [0x7fd53cbfe700] DEBUG - HTTP requesting GET http://127.0.0.1:39479/:/plugins/com.plexapp.system/resourceHashes
Dec 03, 2018 10:01:22.459 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:01:22.460 [0x7fd53bbfc700] DEBUG - Request: [192.168.1.10:54890 (Subnet)] GET /activities (7 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:01:22.466 [0x7fd54a7ff700] DEBUG - Completed: [192.168.1.10:54890] 200 GET /activities (7 live) TLS GZIP 6ms 566 bytes (pipelined: 1)
Dec 03, 2018 10:01:22.483 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:01:22.483 [0x7fd53d3ff700] DEBUG - Request: [127.0.0.1:50214 (WAN)] GET /media/providers (7 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:01:22.492 [0x7fd549ffe700] DEBUG - Completed: [127.0.0.1:50214] 200 GET /media/providers (7 live) TLS GZIP 8ms 3093 bytes (pipelined: 1)
Dec 03, 2018 10:01:22.537 [0x7fd53cbfe700] DEBUG - HTTP 200 response from GET http://127.0.0.1:39479/:/plugins/com.plexapp.system/resourceHashes
Dec 03, 2018 10:01:22.538 [0x7fd53cbfe700] DEBUG - [com.plexapp.system] HTTP reply status 200, with 13276 bytes of content.
Dec 03, 2018 10:01:22.543 [0x7fd549ffe700] DEBUG - Completed: [127.0.0.1:58706] 200 GET /:/plugins/com.plexapp.system/resourceHashes (7 live) GZIP 88ms 3498 bytes
Dec 03, 2018 10:01:22.596 [0x7fd5407ff700] DEBUG - NetworkServiceBrowser: SERVER arrived: 127.0.0.1 (KodiServer)
Dec 03, 2018 10:01:22.596 [0x7fd5407ff700] DEBUG - Notifying the system bundle an update to server /system/notify/serverUpdated?host=127.0.0.1
Dec 03, 2018 10:01:22.596 [0x7fd5407ff700] DEBUG - [com.plexapp.system] Sending command over HTTP (GET): /system/notify/serverUpdated?host=127.0.0.1
Dec 03, 2018 10:01:22.597 [0x7fd5407ff700] DEBUG - HTTP requesting GET http://127.0.0.1:39479/system/notify/serverUpdated?host=127.0.0.1
Dec 03, 2018 10:01:22.607 [0x7fd53bbfc700] DEBUG - Request: [127.0.0.1:58714 (Loopback)] GET / (8 live) GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:01:22.611 [0x7fd54a7ff700] DEBUG - Completed: [127.0.0.1:58714] 200 GET / (9 live) GZIP 4ms 2562 bytes
Dec 03, 2018 10:01:22.612 [0x7fd53d3ff700] DEBUG - Request: [127.0.0.1:58716 (Loopback)] GET /:/plugins/com.plexapp.system/messaging/function/X0J1bmRsZVNlcnZpY2U6QWxsU2VydmljZXM_/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMApyMAo_ (9 live) GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:01:22.613 [0x7fd53d3ff700] DEBUG - [com.plexapp.system] Sending command over HTTP (GET): /:/plugins/com.plexapp.system/messaging/function/X0J1bmRsZVNlcnZpY2U6QWxsU2VydmljZXM_/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMApyMAo_
Dec 03, 2018 10:01:22.613 [0x7fd53d3ff700] DEBUG - HTTP requesting GET http://127.0.0.1:39479/:/plugins/com.plexapp.system/messaging/function/X0J1bmRsZVNlcnZpY2U6QWxsU2VydmljZXM_/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMApyMAo_
Dec 03, 2018 10:01:22.624 [0x7fd53cbfe700] DEBUG - Request: [127.0.0.1:58720 (Loopback)] GET /servers (10 live) GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:01:22.626 [0x7fd549ffe700] DEBUG - Completed: [127.0.0.1:58720] 200 GET /servers (10 live) GZIP 2ms 491 bytes
Dec 03, 2018 10:01:22.657 [0x7fd53c3fd700] DEBUG - HTTP 200 response from GET https://plex.tv/updater/products/1/check.xml?build=linux-ubuntu-x86_64&channel=16&distribution=ubuntu&version=1.14.0.5470-9d51fdfaa
Dec 03, 2018 10:01:22.659 [0x7fd53c3fd700] INFO - AutoUpdate: no updates available
Dec 03, 2018 10:01:22.665 [0x7fd54a7ff700] DEBUG - Completed: [192.168.1.10:54885] 200 PUT /updater/check?download=0 (10 live) TLS GZIP 255ms 268 bytes (pipelined: 3)
Dec 03, 2018 10:01:22.761 [0x7fd53d3ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:39479/:/plugins/com.plexapp.system/messaging/function/X0J1bmRsZVNlcnZpY2U6QWxsU2VydmljZXM_/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMApyMAo_
Dec 03, 2018 10:01:22.762 [0x7fd53d3ff700] DEBUG - [com.plexapp.system] HTTP reply status 200, with 59986 bytes of content.
Dec 03, 2018 10:01:22.766 [0x7fd53bbfc700] DEBUG - Request: [127.0.0.1:58722 (Loopback)] GET /library/sections (10 live) GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:01:22.776 [0x7fd54a7ff700] DEBUG - Completed: [127.0.0.1:58722] 200 GET /library/sections (10 live) GZIP 10ms 1027 bytes
Dec 03, 2018 10:01:22.778 [0x7fd549ffe700] DEBUG - Completed: [127.0.0.1:58716] 200 GET /:/plugins/com.plexapp.system/messaging/function/X0J1bmRsZVNlcnZpY2U6QWxsU2VydmljZXM_/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMApyMAo_ (10 live) GZIP 166ms 19409 bytes
Dec 03, 2018 10:01:22.793 [0x7fd53cbfe700] DEBUG - Request: [127.0.0.1:58724 (Loopback)] GET /channels/all (10 live) GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:01:22.794 [0x7fd54a7ff700] DEBUG - Completed: [127.0.0.1:58724] 200 GET /channels/all (10 live) GZIP 2ms 387 bytes
Dec 03, 2018 10:01:22.809 [0x7fd5407ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:39479/system/notify/serverUpdated?host=127.0.0.1
Dec 03, 2018 10:01:22.810 [0x7fd5407ff700] DEBUG - [com.plexapp.system] HTTP reply status 200, with 0 bytes of content.
Dec 03, 2018 10:01:23.042 [0x7fd544fff700] DEBUG - HTTP requesting GET https://plex.tv/services/pubsub/servers
Dec 03, 2018 10:01:23.286 [0x7fd544fff700] DEBUG - HTTP 200 response from GET https://plex.tv/services/pubsub/servers
Dec 03, 2018 10:01:24.111 [0x7fd544fff700] DEBUG - PubSubManager: Time to connect to 139.162.215.242 was 90 ms.
Dec 03, 2018 10:01:24.112 [0x7fd544fff700] DEBUG - PubSubManager: Time to connect to 178.79.168.142 was 93 ms.
Dec 03, 2018 10:01:24.112 [0x7fd544fff700] DEBUG - PubSubManager: Time to connect to 82.94.168.47 was 100 ms.
Dec 03, 2018 10:01:24.112 [0x7fd544fff700] DEBUG - PubSubManager: Time to connect to 172.104.225.166 was 117 ms.
Dec 03, 2018 10:01:24.112 [0x7fd544fff700] DEBUG - PubSubManager: Time to connect to 97.107.142.226 was 240 ms.
Dec 03, 2018 10:01:24.112 [0x7fd544fff700] DEBUG - PubSubManager: Time to connect to 173.230.131.250 was 255 ms.
Dec 03, 2018 10:01:24.112 [0x7fd544fff700] DEBUG - PubSubManager: Time to connect to 66.228.52.149 was 302 ms.
Dec 03, 2018 10:01:24.112 [0x7fd544fff700] DEBUG - PubSubManager: Time to connect to 184.105.148.101 was 346 ms.
Dec 03, 2018 10:01:24.112 [0x7fd544fff700] DEBUG - PubSubManager: Time to connect to 139.162.117.249 was 465 ms.
Dec 03, 2018 10:01:24.112 [0x7fd544fff700] DEBUG - PubSubManager: Time to connect to 172.104.173.210 was 539 ms.
Dec 03, 2018 10:01:24.113 [0x7fd544fff700] DEBUG - PubSubManager: Another server (139.162.215.242) beat the current one (178.79.168.142).
Dec 03, 2018 10:01:24.137 [0x7fd544fff700] DEBUG - EventSource: Stopping.
Dec 03, 2018 10:01:24.138 [0x7fd544fff700] DEBUG - Relay: stopping relay connection to 178.79.148.211
Dec 03, 2018 10:01:24.138 [0x7fd544fff700] DEBUG - Killing job.
Dec 03, 2018 10:01:24.138 [0x7fd544fff700] DEBUG - Signalling job ID 386 with 9
Dec 03, 2018 10:01:24.138 [0x7fd544fff700] DEBUG - EventSource: Resolving 139.162.215.242 port 443s
Dec 03, 2018 10:01:24.139 [0x7fd544fff700] DEBUG - PubSubManager: Updating best host to 139.162.215.242.
Dec 03, 2018 10:01:24.139 [0x7fd5433ff700] DEBUG - Jobs: '/usr/lib/plexmediaserver/Plex Relay' exit code for process 386 is -9 (signal: Killed)
Dec 03, 2018 10:01:24.139 [0x7fd54a7ff700] DEBUG - EventSource: Resolved 139.162.215.242 to 139.162.215.242
Dec 03, 2018 10:01:24.140 [0x7fd544fff700] DEBUG - PubSubManager: Updating best ping time for 139.162.215.242 to 90 ms.
Dec 03, 2018 10:01:24.266 [0x7fd549ffe700] DEBUG - EventSource: Connected in 85 ms.
Dec 03, 2018 10:01:24.266 [0x7fd549ffe700] DEBUG - EventSource: Wrote data, reading reply.
Dec 03, 2018 10:01:24.394 [0x7fd549ffe700] DEBUG - EventSource: Read HTTP reply header.
Dec 03, 2018 10:01:24.394 [0x7fd549ffe700] DEBUG - MyPlex: We appear to have regained Internet connectivity.
Dec 03, 2018 10:01:24.394 [0x7fd549ffe700] DEBUG - PublicAddressManager: Obtaining public address and mapping port.
Dec 03, 2018 10:01:24.394 [0x7fd545ffc700] DEBUG - PublicAddressManager: Obtaining public IP.
Dec 03, 2018 10:01:24.394 [0x7fd549ffe700] DEBUG - EventSource: Successfully connected to 139.162.215.242.
Dec 03, 2018 10:01:24.394 [0x7fd54b7ff700] DEBUG - NAT: UPnP, attempting port mapping.
Dec 03, 2018 10:01:24.394 [0x7fd545ffc700] DEBUG - HTTP requesting GET http://plex.tv/pms/:/ip
Dec 03, 2018 10:01:24.493 [0x7fd545ffc700] DEBUG - HTTP 200 response from GET http://plex.tv/pms/:/ip
Dec 03, 2018 10:01:24.494 [0x7fd545ffc700] DEBUG - PublicAddressManager: Got public IP from http://plex.tv: 82.158.132.TRUNCATED
Dec 03, 2018 10:01:24.678 [0x7fd5407ff700] DEBUG - NetworkServiceBrowser: Parsing SSDP schema for http://192.168.1.1:80/RootDevice.xml
Dec 03, 2018 10:01:24.678 [0x7fd5407ff700] DEBUG - HTTP requesting GET http://192.168.1.1:80/RootDevice.xml
Dec 03, 2018 10:01:24.686 [0x7fd5407ff700] DEBUG - HTTP 200 response from GET http://192.168.1.1:80/RootDevice.xml
Dec 03, 2018 10:01:24.688 [0x7fd5407ff700] DEBUG - NetworkServiceBrowser: found 3 SSDP devices via http://192.168.1.1:80/RootDevice.xml
Dec 03, 2018 10:01:24.689 [0x7fd5407ff700] DEBUG - NetworkServiceBrowser: SSDP arrived: 192.168.1.1 (Compal Broadband Networks CG7486E)
Dec 03, 2018 10:01:24.689 [0x7fd5407ff700] DEBUG - NetworkServiceBrowser: SSDP arrived: 192.168.1.1 (Compal Broadband Networks CG7486E)
Dec 03, 2018 10:01:24.689 [0x7fd5407ff700] DEBUG - NetworkServiceBrowser: SSDP arrived: 192.168.1.1 (Compal Broadband Networks CG7486E)
Dec 03, 2018 10:01:25.669 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:01:25.671 [0x7fd53c3fd700] DEBUG - Request: [192.168.1.10:54885 (Subnet)] GET /library/sections/1/all?type=1&includeCollections=1 (9 live) TLS Page 0-49 GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:01:25.680 [0x7fd53c3fd700] DEBUG - Setting container serialization range to [0, 49] (total=-1)
Dec 03, 2018 10:01:25.697 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:01:25.698 [0x7fd53bbfc700] DEBUG - Request: [192.168.1.10:54890 (Subnet)] GET /music/iTunes (8 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:01:25.704 [0x7fd549ffe700] DEBUG - Completed: [192.168.1.10:54890] 404 GET /music/iTunes (8 live) TLS GZIP 5ms 452 bytes (pipelined: 2)
Dec 03, 2018 10:01:25.711 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:01:25.711 [0x7fd53d3ff700] DEBUG - Request: [192.168.1.10:54890 (Subnet)] GET /library/sections (8 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:01:25.724 [0x7fd549ffe700] DEBUG - Completed: [192.168.1.10:54890] 200 GET /library/sections (8 live) TLS GZIP 12ms 1107 bytes (pipelined: 3)
Dec 03, 2018 10:01:25.729 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:01:25.729 [0x7fd53cbfe700] DEBUG - Request: [192.168.1.10:54891 (Subnet)] GET /media/providers (7 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:01:25.739 [0x7fd54a7ff700] DEBUG - Completed: [192.168.1.10:54891] 200 GET /media/providers (7 live) TLS GZIP 10ms 3021 bytes (pipelined: 1)
Dec 03, 2018 10:01:25.771 [0x7fd53c3fd700] DEBUG - It took 70.000000 ms to retrieve 50 items.
Dec 03, 2018 10:01:25.782 [0x7fd53c3fd700] DEBUG - Setting container serialization range to [0, 49] (total=173)
Dec 03, 2018 10:01:25.820 [0x7fd54a7ff700] DEBUG - Completed: [192.168.1.10:54885] 200 GET /library/sections/1/all?type=1&includeCollections=1 (7 live) TLS GZIP Page 0-49 150ms 18786 bytes (pipelined: 4)
Dec 03, 2018 10:01:26.026 [0x7fd53bbfc700] DEBUG - Request: [127.0.0.1:58754 (Loopback)] GET /:/plugins/com.plexapp.system/messaging/function/X0FnZW50U2VydmljZTpVcGRhdGVJbmZv/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQo3CmRpY3QKbGlzdApkaWN0Cmxpc3QKbGlzdApsaXN0Cmxpc3QKMgpzMjMKY29tLnBsZXhhcHAuYWdlbnRzLmltZGJzMTAKaWRlbnRpZmllcnIxCnMxMAphZ2VudF9pbmZvMQpyMgoxMApyMwpzMTEKbWVkaWFfdHlwZXNyNApzMTIKYWNjZXB0c19mcm9tbnMxNApmYWxsYmFja19hZ2VudHI1CnMxNApjb250cmlidXRlc190b3I2CnM5Cmxhbmd1YWdlc2IxczIwCnBlcnNpc3Rfc3RvcmVkX2ZpbGVzaTAKczcKdmVyc2lvbmIxczE2CnByaW1hcnlfcHJvdmlkZXJiMXM1CnByZWZzczEwClBsZXggTW92aWVzNApuYW1lMQpzNQpNb3ZpZTEKczI5CmNvbS5wbGV4YXBwLmFnZW50cy5sb2NhbG1lZGlhMQpzMjkKY29tLnBsZXhhcHAuYWdlbnRzLnRoZW1vdmllZGIzMwpzMgplbnMyCnN2czIKZnJzMgplc3MyCm5sczIKZGVzMgppdHMyCmRhczIKYXJzMgpjYXMyCnpoczIKY3NzMgpldHMyCmZpczIKZWxzMgpoZXMyCmhpczIKaHVzMgppZHMyCmphczIKa29zMgpsdnMyCm5vczIKZmFzMgpwbHMyCnB0czIKcm9zMgpydXMyCnNrczIKdGhzMgp0cnMyCnVrczIKdmlyMAo_ (8 live) GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:01:26.029 [0x7fd53bbfc700] DEBUG - [com.plexapp.system] Sending command over HTTP (GET): /:/plugins/com.plexapp.system/messaging/function/X0FnZW50U2VydmljZTpVcGRhdGVJbmZv/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQo3CmRpY3QKbGlzdApkaWN0Cmxpc3QKbGlzdApsaXN0Cmxpc3QKMgpzMjMKY29tLnBsZXhhcHAuYWdlbnRzLmltZGJzMTAKaWRlbnRpZmllcnIxCnMxMAphZ2VudF9pbmZvMQpyMgoxMApyMwpzMTEKbWVkaWFfdHlwZXNyNApzMTIKYWNjZXB0c19mcm9tbnMxNApmYWxsYmFja19hZ2VudHI1CnMxNApjb250cmlidXRlc190b3I2CnM5Cmxhbmd1YWdlc2IxczIwCnBlcnNpc3Rfc3RvcmVkX2ZpbGVzaTAKczcKdmVyc2lvbmIxczE2CnByaW1hcnlfcHJvdmlkZXJiMXM1CnByZWZzczEwClBsZXggTW92aWVzNApuYW1lMQpzNQpNb3ZpZTEKczI5CmNvbS5wbGV4YXBwLmFnZW50cy5sb2NhbG1lZGlhMQpzMjkKY29tLnBsZXhhcHAuYWdlbnRzLnRoZW1vdmllZGIzMwpzMgplbnMyCnN2czIKZnJzMgplc3MyCm5sczIKZGVzMgppdHMyCmRhczIKYXJzMgpjYXMyCnpoczIKY3NzMgpldHMyCmZpczIKZWxzMgpoZXMyCmhpczIKaHVzMgppZHMyCmphczIKa29zMgpsdnMyCm5vczIKZmFzMgpwbHMyCnB0czIKcm9zMgpydXMyCnNrczIKdGhzMgp0cnMyCnVrczIKdmlyMAo_
Dec 03, 2018 10:01:26.030 [0x7fd53bbfc700] DEBUG - HTTP requesting GET http://127.0.0.1:39479/:/plugins/com.plexapp.system/messaging/function/X0FnZW50U2VydmljZTpVcGRhdGVJbmZv/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQo3CmRpY3QKbGlzdApkaWN0Cmxpc3QKbGlzdApsaXN0Cmxpc3QKMgpzMjMKY29tLnBsZXhhcHAuYWdlbnRzLmltZGJzMTAKaWRlbnRpZmllcnIxCnMxMAphZ2VudF9pbmZvMQpyMgoxMApyMwpzMTEKbWVkaWFfdHlwZXNyNApzMTIKYWNjZXB0c19mcm9tbnMxNApmYWxsYmFja19hZ2VudHI1CnMxNApjb250cmlidXRlc190b3I2CnM5Cmxhbmd1YWdlc2IxczIwCnBlcnNpc3Rfc3RvcmVkX2ZpbGVzaTAKczcKdmVyc2lvbmIxczE2CnByaW1hcnlfcHJvdmlkZXJiMXM1CnByZWZzczEwClBsZXggTW92aWVzNApuYW1lMQpzNQpNb3ZpZTEKczI5CmNvbS5wbGV4YXBwLmFnZW50cy5sb2NhbG1lZGlhMQpzMjkKY29tLnBsZXhhcHAuYWdlbnRzLnRoZW1vdmllZGIzMwpzMgplbnMyCnN2czIKZnJzMgplc3MyCm5sczIKZGVzMgppdHMyCmRhczIKYXJzMgpjYXMyCnpoczIKY3NzMgpldHMyCmZpczIKZWxzMgpoZXMyCmhpczIKaHVzMgppZHMyCmphczIKa29zMgpsdnMyCm5vczIKZmFzMgpwbHMyCnB0czIKcm9zMgpydXMyCnNrczIKdGhzMgp0cnMyCnVrczIKdmlyMAo_
Dec 03, 2018 10:01:26.053 [0x7fd53bbfc700] DEBUG - HTTP 200 response from GET http://127.0.0.1:39479/:/plugins/com.plexapp.system/messaging/function/X0FnZW50U2VydmljZTpVcGRhdGVJbmZv/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQo3CmRpY3QKbGlzdApkaWN0Cmxpc3QKbGlzdApsaXN0Cmxpc3QKMgpzMjMKY29tLnBsZXhhcHAuYWdlbnRzLmltZGJzMTAKaWRlbnRpZmllcnIxCnMxMAphZ2VudF9pbmZvMQpyMgoxMApyMwpzMTEKbWVkaWFfdHlwZXNyNApzMTIKYWNjZXB0c19mcm9tbnMxNApmYWxsYmFja19hZ2VudHI1CnMxNApjb250cmlidXRlc190b3I2CnM5Cmxhbmd1YWdlc2IxczIwCnBlcnNpc3Rfc3RvcmVkX2ZpbGVzaTAKczcKdmVyc2lvbmIxczE2CnByaW1hcnlfcHJvdmlkZXJiMXM1CnByZWZzczEwClBsZXggTW92aWVzNApuYW1lMQpzNQpNb3ZpZTEKczI5CmNvbS5wbGV4YXBwLmFnZW50cy5sb2NhbG1lZGlhMQpzMjkKY29tLnBsZXhhcHAuYWdlbnRzLnRoZW1vdmllZGIzMwpzMgplbnMyCnN2czIKZnJzMgplc3MyCm5sczIKZGVzMgppdHMyCmRhczIKYXJzMgpjYXMyCnpoczIKY3NzMgpldHMyCmZpczIKZWxzMgpoZXMyCmhpczIKaHVzMgppZHMyCmphczIKa29zMgpsdnMyCm5vczIKZmFzMgpwbHMyCnB0czIKcm9zMgpydXMyCnNrczIKdGhzMgp0cnMyCnVrczIKdmlyMAo_
Dec 03, 2018 10:01:26.053 [0x7fd53bbfc700] DEBUG - [com.plexapp.system] HTTP reply status 200, with 16 bytes of content.
Dec 03, 2018 10:01:26.056 [0x7fd54a7ff700] DEBUG - Completed: [127.0.0.1:58754] 200 GET /:/plugins/com.plexapp.system/messaging/function/X0FnZW50U2VydmljZTpVcGRhdGVJbmZv/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQo3CmRpY3QKbGlzdApkaWN0Cmxpc3QKbGlzdApsaXN0Cmxpc3QKMgpzMjMKY29tLnBsZXhhcHAuYWdlbnRzLmltZGJzMTAKaWRlbnRpZmllcnIxCnMxMAphZ2VudF9pbmZvMQpyMgoxMApyMwpzMTEKbWVkaWFfdHlwZXNyNApzMTIKYWNjZXB0c19mcm9tbnMxNApmYWxsYmFja19hZ2VudHI1CnMxNApjb250cmlidXRlc190b3I2CnM5Cmxhbmd1YWdlc2IxczIwCnBlcnNpc3Rfc3RvcmVkX2ZpbGVzaTAKczcKdmVyc2lvbmIxczE2CnByaW1hcnlfcHJvdmlkZXJiMXM1CnByZWZzczEwClBsZXggTW92aWVzNApuYW1lMQpzNQpNb3ZpZTEKczI5CmNvbS5wbGV4YXBwLmFnZW50cy5sb2NhbG1lZGlhMQpzMjkKY29tLnBsZXhhcHAuYWdlbnRzLnRoZW1vdmllZGIzMwpzMgplbnMyCnN2czIKZnJzMgplc3MyCm5sczIKZGVzMgppdHMyCmRhczIKYXJzMgpjYXMyCnpoczIKY3NzMgpldHMyCmZpczIKZWxzMgpoZXMyCmhpczIKaHVzMgppZHMyCmphczIKa29zMgpsdnMyCm5vczIKZmFzMgpwbHMyCnB0czIKcm9zMgpydXMyCnNrczIKdGhzMgp0cnMyCnVrczIKdmlyMAo_ (8 live) GZIP 30ms 465 bytes
Dec 03, 2018 10:01:26.078 [0x7fd537bf4700] DEBUG - Reading 148 bytes in the body, code is 200
Dec 03, 2018 10:01:26.078 [0x7fd537bf4700] DEBUG - [com.plexapp.agents.imdb] Plug-in running on port 40325.
Dec 03, 2018 10:01:26.078 [0x7fd537bf4700] DEBUG - Read configuration for [com.plexapp.agents.imdb], had 0 prefixes
Dec 03, 2018 10:01:26.081 [0x7fd537bf4700] DEBUG - [com.plexapp.agents.imdb] Sending command over HTTP (GET): /:/plugins/com.plexapp.agents.imdb/prefs
Dec 03, 2018 10:01:26.082 [0x7fd537bf4700] DEBUG - HTTP requesting GET http://127.0.0.1:40325/:/plugins/com.plexapp.agents.imdb/prefs
Dec 03, 2018 10:01:26.132 [0x7fd549ffe700] DEBUG - EventSource: Got event [data] '<Message address="82.158.132.TRUNCATED" port="18191" asyncIdentifier="b4659541-0009-42b0-be7c-14a0fc21fab3" connectivity="0" command="notifyConnectivity"/>'
Dec 03, 2018 10:01:26.133 [0x7fd549ffe700] DEBUG - PubSub: Got notified of reachability: 0 for 82.158.132.TRUNCATED:18191
Dec 03, 2018 10:01:26.151 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:01:26.152 [0x7fd53d3ff700] DEBUG - Request: [192.168.1.10:54885 (Subnet)] GET /myplex/account (8 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:01:26.163 [0x7fd549ffe700] DEBUG - Completed: [192.168.1.10:54885] 200 GET /myplex/account (8 live) TLS GZIP 11ms 1923 bytes (pipelined: 5)
Dec 03, 2018 10:01:26.185 [0x7fd537bf4700] DEBUG - HTTP 200 response from GET http://127.0.0.1:40325/:/plugins/com.plexapp.agents.imdb/prefs
Dec 03, 2018 10:01:26.187 [0x7fd537bf4700] DEBUG - [com.plexapp.agents.imdb] HTTP reply status 200, with 2223 bytes of content.
Dec 03, 2018 10:01:26.188 [0x7fd537bf4700] DEBUG - Caching document http://127.0.0.1:32400/:/plugins/com.plexapp.agents.imdb/prefs as 8e5d50c49ef8d4b295ba64bbbee0d5f5d4130df3
Dec 03, 2018 10:01:26.189 [0x7fd537bf4700] DEBUG - IVA: Downloading trailer lists.
Dec 03, 2018 10:01:26.328 [0x7fd537bf4700] DEBUG - IVA: Downloaded 18 trailers for source 1.
Dec 03, 2018 10:01:26.483 [0x7fd537bf4700] DEBUG - IVA: Downloaded 26 trailers for source 2.
Dec 03, 2018 10:01:26.864 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:01:26.865 [0x7fd53cbfe700] DEBUG - Request: [192.168.1.10:54885 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (8 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:01:26.867 [0x7fd53cbfe700] DEBUG - [CompanionProxy] registered new player: j2k37oddmpjjd0onjj77pazx (192.168.1.10)
Dec 03, 2018 10:01:26.871 [0x7fd53cbfe700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:01:27.501 [0x7fd54b7ff700] DEBUG - NAT: UPnP, found device <http://192.168.1.1:80/RootDevice.xml> with private address <192.168.1.24>
Dec 03, 2018 10:01:27.510 [0x7fd545ffc700] DEBUG - NAT: UPnP, found device <http://192.168.1.1:80/RootDevice.xml> with private address <192.168.1.24>
Dec 03, 2018 10:01:27.539 [0x7fd54b7ff700] DEBUG - NAT: UPnP, usable device <http://192.168.1.1:80/RootDevice.xml> with private address <192.168.1.24>.
Dec 03, 2018 10:01:27.549 [0x7fd545ffc700] DEBUG - NAT: UPnP, usable device <http://192.168.1.1:80/RootDevice.xml> with private address <192.168.1.24>.
Dec 03, 2018 10:01:27.569 [0x7fd545ffc700] DEBUG - NAT: UPnP, public address is 82.158.132.TRUNCATED
Dec 03, 2018 10:01:27.589 [0x7fd54b7ff700] DEBUG - NAT: UPnP, mapped port 18191 to 192.168.1.24:32400.
Dec 03, 2018 10:01:27.591 [0x7fd54b7ff700] DEBUG - PublicAddressManager: Mapping succeeded for 192.168.1.24:18191.
Dec 03, 2018 10:01:27.592 [0x7fd545ffc700] DEBUG - MyPlex: Last published value didn't change, we're done.
Dec 03, 2018 10:01:27.594 [0x7fd5407ff700] DEBUG - NetworkServiceBrowser: PLAYER arrived: 127.0.0.1
Dec 03, 2018 10:01:27.596 [0x7fd54b7ff700] DEBUG - MyPlex: Last published value didn't change, we're done.
Dec 03, 2018 10:01:28.101 [0x7fd53a3f9700] DEBUG - Activity: registered new activity 821f2353-b806-4f31-907d-fdf1358b5997 - Processing subscriptions
Dec 03, 2018 10:01:28.132 [0x7fd53a3f9700] DEBUG - DVR:Subscription: Scheduling subscriptions.
Dec 03, 2018 10:01:28.136 [0x7fd53a3f9700] DEBUG - DVR:Subscription: Initialized 0 schedulers.
Dec 03, 2018 10:01:28.136 [0x7fd53a3f9700] DEBUG - DVR:Subscription: Starting with 0 grabs, scheduled 0 active ones preemptively.
Dec 03, 2018 10:01:28.136 [0x7fd53a3f9700] DEBUG - DVR:Subscription: Scheduled all subscriptions in 4 ms.
Dec 03, 2018 10:01:28.137 [0x7fd53a3f9700] DEBUG - Activity: Ended activity 821f2353-b806-4f31-907d-fdf1358b5997.
Dec 03, 2018 10:01:28.139 [0x7fd53a3f9700] DEBUG - DVR:Subscription: There are 0 active grabs at the end.
Dec 03, 2018 10:01:28.139 [0x7fd53a3f9700] DEBUG - Activity: Ended activity 94b63547-0290-4f6d-bca9-52d8736d5293.
Dec 03, 2018 10:01:28.140 [0x7fd53a3f9700] DEBUG - DVR:Subscription: Refreshed all content in 44 ms.
Dec 03, 2018 10:01:46.871 [0x7fd54a7ff700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:01:46.961 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:01:46.964 [0x7fd53cbfe700] DEBUG - Request: [192.168.1.10:54895 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:01:46.967 [0x7fd53cbfe700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:01:52.562 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:01:52.563 [0x7fd53cbfe700] DEBUG - Request: [192.168.1.10:54899 (Subnet)] GET /library/sections/1/all?type=1&includeCollections=1 (6 live) TLS Page 50-153 GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:01:52.570 [0x7fd53cbfe700] DEBUG - Setting container serialization range to [50, 153] (total=-1)
Dec 03, 2018 10:01:52.667 [0x7fd53cbfe700] DEBUG - It took 90.000000 ms to retrieve 104 items.
Dec 03, 2018 10:01:52.675 [0x7fd53cbfe700] DEBUG - Setting container serialization range to [50, 153] (total=173)
Dec 03, 2018 10:01:52.740 [0x7fd549ffe700] DEBUG - Completed: [192.168.1.10:54899] 200 GET /library/sections/1/all?type=1&includeCollections=1 (6 live) TLS GZIP Page 50-153 177ms 38665 bytes (pipelined: 1)
Dec 03, 2018 10:01:59.695 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:01:59.696 [0x7fd53cbfe700] DEBUG - Request: [192.168.1.10:54899 (Subnet)] GET /photo/:/transcode?width=120&height=180&minSize=1&url=%2Flibrary%2Fmetadata%2F1546%2Fthumb%2F1543848692%3FX-Plex-Token%3Dxxxxxxxxxxxxxxxxxxxx (6 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:01:59.698 [0x7fd53cbfe700] DEBUG - Photo transcoder: Request for url [/library/metadata/1546/thumb/1543848692?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx] (is local: 1 upscaled: 0)
Dec 03, 2018 10:01:59.712 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:01:59.713 [0x7fd53d3ff700] DEBUG - Request: [192.168.1.10:54907 (Subnet)] GET /photo/:/transcode?width=120&height=180&minSize=1&url=%2Flibrary%2Fmetadata%2F1563%2Fthumb%2F1543849224%3FX-Plex-Token%3Dxxxxxxxxxxxxxxxxxxxx (7 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:01:59.715 [0x7fd53d3ff700] DEBUG - Photo transcoder: Request for url [/library/metadata/1563/thumb/1543849224?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx] (is local: 1 upscaled: 0)
Dec 03, 2018 10:01:59.724 [0x7fd53cbfe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:01:59.729 [0x7fd53d3ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:01:59.730 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:01:59.731 [0x7fd53c3fd700] DEBUG - Request: [192.168.1.10:54908 (Subnet)] GET /photo/:/transcode?width=120&height=180&minSize=1&url=%2Flibrary%2Fmetadata%2F1543%2Fthumb%2F1543846512%3FX-Plex-Token%3Dxxxxxxxxxxxxxxxxxxxx (9 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:01:59.732 [0x7fd53c3fd700] DEBUG - Photo transcoder: Request for url [/library/metadata/1543/thumb/1543846512?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx] (is local: 1 upscaled: 0)
Dec 03, 2018 10:01:59.737 [0x7fd53cbfe700] DEBUG - Calculated media file path for item 1546: "/config/Library/Application Support/Plex Media Server/Media/localhost/e/f4d8ce2f3964d32590ab70eb15e904ea48dfa9a.bundle/Contents/Thumbnails/thumb1.jpg"
Dec 03, 2018 10:01:59.741 [0x7fd53d3ff700] DEBUG - Computed media url for item 1563: http://127.0.0.1:39479/system/agents/media/get?guid=com%2Eplexapp%2Eagents%2Ethemoviedb%3A%2F%2F9686%3Flang%3Des&mediaType=1&url=metadata%3A%2F%2Fposters%2Fcom%2Eplexapp%2Eagents%2Ethemoviedb_f0cf2d9b21857710bf6a865594da070fd221a759
Dec 03, 2018 10:01:59.742 [0x7fd53d3ff700] DEBUG - HTTP requesting GET http://127.0.0.1:39479/system/agents/media/get?guid=com%2Eplexapp%2Eagents%2Ethemoviedb%3A%2F%2F9686%3Flang%3Des&mediaType=1&url=metadata%3A%2F%2Fposters%2Fcom%2Eplexapp%2Eagents%2Ethemoviedb_f0cf2d9b21857710bf6a865594da070fd221a759
Dec 03, 2018 10:01:59.742 [0x7fd53c3fd700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:01:59.751 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:01:59.750 [0x7fd53cbfe700] DEBUG - Calling back into ourselves for photo to transcode, optimizing the process (status: -1)
Dec 03, 2018 10:01:59.753 [0x7fd53bbfc700] DEBUG - Request: [192.168.1.10:54909 (Subnet)] GET /photo/:/transcode?width=120&height=180&minSize=1&url=%2Flibrary%2Fmetadata%2F1564%2Fthumb%2F1543848718%3FX-Plex-Token%3Dxxxxxxxxxxxxxxxxxxxx (10 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:01:59.754 [0x7fd53bbfc700] DEBUG - Photo transcoder: Request for url [/library/metadata/1564/thumb/1543848718?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx] (is local: 1 upscaled: 0)
Dec 03, 2018 10:01:59.755 [0x7fd53cbfe700] DEBUG - Photo cache obtained 13650 bytes from /library/metadata/1546/thumb/1543848692?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Dec 03, 2018 10:01:59.755 [0x7fd53cbfe700] DEBUG - Saving original media file to /config/Library/Application Support/Plex Media Server/Cache/PhotoTranscoder/fd/fd3c05b90b6d1bb6a089765b2b5cb2bfff06db89.jpg
Dec 03, 2018 10:01:59.757 [0x7fd53bbfc700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:01:59.758 [0x7fd53c3fd700] DEBUG - Computed media url for item 1543: http://127.0.0.1:39479/system/agents/media/get?guid=com%2Eplexapp%2Eagents%2Ethemoviedb%3A%2F%2F77338%3Flang%3Des&mediaType=1&url=metadata%3A%2F%2Fposters%2Fcom%2Eplexapp%2Eagents%2Ethemoviedb_a31bcf14914adcf40e874d83b0eed25e7faa3910
Dec 03, 2018 10:01:59.758 [0x7fd53c3fd700] DEBUG - HTTP requesting GET http://127.0.0.1:39479/system/agents/media/get?guid=com%2Eplexapp%2Eagents%2Ethemoviedb%3A%2F%2F77338%3Flang%3Des&mediaType=1&url=metadata%3A%2F%2Fposters%2Fcom%2Eplexapp%2Eagents%2Ethemoviedb_a31bcf14914adcf40e874d83b0eed25e7faa3910
Dec 03, 2018 10:01:59.770 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:01:59.772 [0x7fd53bbfc700] DEBUG - Calculated media file path for item 1564: "/config/Library/Application Support/Plex Media Server/Media/localhost/8/25e6f6bc1a1051088ff00f45f7c4a5ac9f61fb1.bundle/Contents/Thumbnails/thumb1.jpg"
Dec 03, 2018 10:01:59.773 [0x7fd5497fd700] DEBUG - Request: [192.168.1.10:54910 (Subnet)] GET /photo/:/transcode?width=120&height=180&minSize=1&url=%2Flibrary%2Fmetadata%2F1523%2Fthumb%2F1543848716%3FX-Plex-Token%3Dxxxxxxxxxxxxxxxxxxxx (10 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:01:59.775 [0x7fd5497fd700] DEBUG - Photo transcoder: Request for url [/library/metadata/1523/thumb/1543848716?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx] (is local: 1 upscaled: 0)
Dec 03, 2018 10:01:59.780 [0x7fd5497fd700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:01:59.789 [0x7fd53bbfc700] DEBUG - Calling back into ourselves for photo to transcode, optimizing the process (status: -1)
Dec 03, 2018 10:01:59.793 [0x7fd53bbfc700] DEBUG - Photo cache obtained 4047 bytes from /library/metadata/1564/thumb/1543848718?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Dec 03, 2018 10:01:59.793 [0x7fd53bbfc700] DEBUG - Saving original media file to /config/Library/Application Support/Plex Media Server/Cache/PhotoTranscoder/e9/e9e1fc27604f629bb0f15bfdc6ca274609d1c72a.jpg
Dec 03, 2018 10:01:59.816 [0x7fd5497fd700] DEBUG - Computed media url for item 1523: http://127.0.0.1:39479/system/agents/media/get?guid=com%2Eplexapp%2Eagents%2Ethemoviedb%3A%2F%2F228326%3Flang%3Des&mediaType=1&url=metadata%3A%2F%2Fposters%2Fcom%2Eplexapp%2Eagents%2Ethemoviedb_654f8732fbb761e4da6c7ad3209b15822ddb25a6
Dec 03, 2018 10:01:59.817 [0x7fd5497fd700] DEBUG - HTTP requesting GET http://127.0.0.1:39479/system/agents/media/get?guid=com%2Eplexapp%2Eagents%2Ethemoviedb%3A%2F%2F228326%3Flang%3Des&mediaType=1&url=metadata%3A%2F%2Fposters%2Fcom%2Eplexapp%2Eagents%2Ethemoviedb_654f8732fbb761e4da6c7ad3209b15822ddb25a6
Dec 03, 2018 10:01:59.825 [0x7fd53cbfe700] DEBUG - Created thumbnail of size 495x180, has pixels: 1
Dec 03, 2018 10:01:59.850 [0x7fd54a7ff700] DEBUG - Completed: [192.168.1.10:54899] 200 GET /photo/:/transcode?width=120&height=180&minSize=1&url=%2Flibrary%2Fmetadata%2F1546%2Fthumb%2F1543848692%3FX-Plex-Token%3Dxxxxxxxxxxxxxxxxxxxx (10 live) TLS GZIP 154ms 9383 bytes (pipelined: 2)
Dec 03, 2018 10:01:59.857 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:01:59.858 [0x7fd53cbfe700] DEBUG - Request: [192.168.1.10:54899 (Subnet)] GET /photo/:/transcode?width=120&height=180&minSize=1&url=%2Flibrary%2Fmetadata%2F561%2Fcomposite%2F1543772860%3Fwidth%3D400%26height%3D600%26X-Plex-Token%3Dxxxxxxxxxxxxxxxxxxxx (10 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:01:59.859 [0x7fd53cbfe700] DEBUG - Photo transcoder: Request for url [/library/metadata/561/composite/1543772860?width=400&height=600&X-Plex-Token=xxxxxxxxxxxxxxxxxxxx] (is local: 1 upscaled: 0)
Dec 03, 2018 10:01:59.862 [0x7fd53cbfe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:01:59.875 [0x7fd53bbfc700] DEBUG - Created thumbnail of size 426x180, has pixels: 1
Dec 03, 2018 10:01:59.879 [0x7fd53cbfe700] DEBUG - Calling back into ourselves for photo to transcode, optimizing the process (status: 404)
Dec 03, 2018 10:01:59.884 [0x7fd54a7ff700] DEBUG - Completed: [192.168.1.10:54899] 404 GET /photo/:/transcode?width=120&height=180&minSize=1&url=%2Flibrary%2Fmetadata%2F561%2Fcomposite%2F1543772860%3Fwidth%3D400%26height%3D600%26X-Plex-Token%3Dxxxxxxxxxxxxxxxxxxxx (10 live) TLS GZIP 25ms 452 bytes (pipelined: 3)
Dec 03, 2018 10:01:59.899 [0x7fd54a7ff700] DEBUG - Completed: [192.168.1.10:54909] 200 GET /photo/:/transcode?width=120&height=180&minSize=1&url=%2Flibrary%2Fmetadata%2F1564%2Fthumb%2F1543848718%3FX-Plex-Token%3Dxxxxxxxxxxxxxxxxxxxx (10 live) TLS GZIP 148ms 578 bytes (pipelined: 1)
Dec 03, 2018 10:01:59.974 [0x7fd53d3ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:39479/system/agents/media/get?guid=com%2Eplexapp%2Eagents%2Ethemoviedb%3A%2F%2F9686%3Flang%3Des&mediaType=1&url=metadata%3A%2F%2Fposters%2Fcom%2Eplexapp%2Eagents%2Ethemoviedb_f0cf2d9b21857710bf6a865594da070fd221a759
Dec 03, 2018 10:01:59.977 [0x7fd53d3ff700] DEBUG - Calculated media file path for item 1563: "/config/Library/Application Support/Plex Media Server/Metadata/Movies/9/704113cb92207b23b73276e1d7d2ae4fff1243d.bundle/Contents/_combined/posters/com.plexapp.agents.themoviedb_f0cf2d9b21857710bf6a865594da070fd221a759"
Dec 03, 2018 10:01:59.984 [0x7fd53d3ff700] DEBUG - Calling back into ourselves for photo to transcode, optimizing the process (status: -1)
Dec 03, 2018 10:01:59.985 [0x7fd53c3fd700] DEBUG - HTTP 200 response from GET http://127.0.0.1:39479/system/agents/media/get?guid=com%2Eplexapp%2Eagents%2Ethemoviedb%3A%2F%2F77338%3Flang%3Des&mediaType=1&url=metadata%3A%2F%2Fposters%2Fcom%2Eplexapp%2Eagents%2Ethemoviedb_a31bcf14914adcf40e874d83b0eed25e7faa3910
Dec 03, 2018 10:01:59.986 [0x7fd53d3ff700] DEBUG - Photo cache obtained 164637 bytes from /library/metadata/1563/thumb/1543849224?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Dec 03, 2018 10:01:59.987 [0x7fd53d3ff700] DEBUG - Saving original media file to /config/Library/Application Support/Plex Media Server/Cache/PhotoTranscoder/f3/f34ba15ecb8030d35c7e5b058da986a110ca6745.jpg
Dec 03, 2018 10:01:59.988 [0x7fd53c3fd700] DEBUG - Calculated media file path for item 1543: "/config/Library/Application Support/Plex Media Server/Metadata/Movies/5/37c70d04e2d883d22bcedd8b311ab3e41837fe7.bundle/Contents/_combined/posters/com.plexapp.agents.themoviedb_a31bcf14914adcf40e874d83b0eed25e7faa3910"
Dec 03, 2018 10:01:59.995 [0x7fd53c3fd700] DEBUG - Calling back into ourselves for photo to transcode, optimizing the process (status: -1)
Dec 03, 2018 10:01:59.997 [0x7fd53c3fd700] DEBUG - Photo cache obtained 238337 bytes from /library/metadata/1543/thumb/1543846512?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Dec 03, 2018 10:01:59.997 [0x7fd53c3fd700] DEBUG - Saving original media file to /config/Library/Application Support/Plex Media Server/Cache/PhotoTranscoder/ad/ada3d25547d2cf251b117551ed9a802bc607bc4b.jpg
Dec 03, 2018 10:02:00.027 [0x7fd5497fd700] DEBUG - HTTP 200 response from GET http://127.0.0.1:39479/system/agents/media/get?guid=com%2Eplexapp%2Eagents%2Ethemoviedb%3A%2F%2F228326%3Flang%3Des&mediaType=1&url=metadata%3A%2F%2Fposters%2Fcom%2Eplexapp%2Eagents%2Ethemoviedb_654f8732fbb761e4da6c7ad3209b15822ddb25a6
Dec 03, 2018 10:02:00.036 [0x7fd5497fd700] DEBUG - Calculated media file path for item 1523: "/config/Library/Application Support/Plex Media Server/Metadata/Movies/b/589f7a412a3ede745d7e0d3f8c67892c8de9b0e.bundle/Contents/_combined/posters/com.plexapp.agents.themoviedb_654f8732fbb761e4da6c7ad3209b15822ddb25a6"
Dec 03, 2018 10:02:00.046 [0x7fd5497fd700] DEBUG - Calling back into ourselves for photo to transcode, optimizing the process (status: -1)
Dec 03, 2018 10:02:00.053 [0x7fd5497fd700] DEBUG - Photo cache obtained 867659 bytes from /library/metadata/1523/thumb/1543848716?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Dec 03, 2018 10:02:00.054 [0x7fd5497fd700] DEBUG - Saving original media file to /config/Library/Application Support/Plex Media Server/Cache/PhotoTranscoder/50/502d053bf453558008222dc9d2d061e031371907.jpg
Dec 03, 2018 10:02:00.107 [0x7fd53d3ff700] DEBUG - Created thumbnail of size 125x180, has pixels: 1
Dec 03, 2018 10:02:00.125 [0x7fd54a7ff700] DEBUG - Completed: [192.168.1.10:54907] 200 GET /photo/:/transcode?width=120&height=180&minSize=1&url=%2Flibrary%2Fmetadata%2F1563%2Fthumb%2F1543849224%3FX-Plex-Token%3Dxxxxxxxxxxxxxxxxxxxx (10 live) TLS GZIP 412ms 10261 bytes (pipelined: 1)
Dec 03, 2018 10:02:00.169 [0x7fd53c3fd700] DEBUG - Created thumbnail of size 120x180, has pixels: 1
Dec 03, 2018 10:02:00.185 [0x7fd54a7ff700] DEBUG - Completed: [192.168.1.10:54908] 200 GET /photo/:/transcode?width=120&height=180&minSize=1&url=%2Flibrary%2Fmetadata%2F1543%2Fthumb%2F1543846512%3FX-Plex-Token%3Dxxxxxxxxxxxxxxxxxxxx (10 live) TLS GZIP 454ms 6790 bytes (pipelined: 1)
Dec 03, 2018 10:02:00.286 [0x7fd5497fd700] DEBUG - Created thumbnail of size 120x180, has pixels: 1
Dec 03, 2018 10:02:00.301 [0x7fd54a7ff700] DEBUG - Completed: [192.168.1.10:54910] 200 GET /photo/:/transcode?width=120&height=180&minSize=1&url=%2Flibrary%2Fmetadata%2F1523%2Fthumb%2F1543848716%3FX-Plex-Token%3Dxxxxxxxxxxxxxxxxxxxx (10 live) TLS GZIP 530ms 10726 bytes (pipelined: 1)
Dec 03, 2018 10:02:00.855 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 20997727 as Lau
Dec 03, 2018 10:02:00.860 [0x7fd53cbfe700] DEBUG - Request: [192.168.1.10:54912 (Subnet)] GET / (11 live) TLS GZIP Signed-in Token (Lau)
Dec 03, 2018 10:02:00.882 [0x7fd53cbfe700] DEBUG - (Capabilities) Platform 'Windows' not matched by plugin platform requirements
Dec 03, 2018 10:02:00.889 [0x7fd54a7ff700] DEBUG - Completed: [192.168.1.10:54912] 200 GET / (11 live) TLS GZIP 30ms 2586 bytes (pipelined: 1)
Dec 03, 2018 10:02:00.962 [0x7fd549ffe700] DEBUG - Auth: authenticated user 20997727 as Lau
Dec 03, 2018 10:02:00.964 [0x7fd53bbfc700] DEBUG - Request: [192.168.1.10:54912 (Subnet)] GET /library/onDeck (12 live) TLS GZIP Signed-in Token (Lau)
Dec 03, 2018 10:02:00.971 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 20997727 as Lau
Dec 03, 2018 10:02:00.973 [0x7fd539bf8700] DEBUG - Request: [192.168.1.10:54913 (Subnet)] GET /library/recentlyAdded (12 live) TLS GZIP Signed-in Token (Lau)
Dec 03, 2018 10:02:01.039 [0x7fd54a7ff700] DEBUG - Completed: [192.168.1.10:54912] 200 GET /library/onDeck (12 live) TLS GZIP 76ms 500 bytes (pipelined: 2)
Dec 03, 2018 10:02:01.083 [0x7fd539bf8700] DEBUG - It took 70.000000 ms to retrieve 49 items.
Dec 03, 2018 10:02:01.173 [0x7fd54a7ff700] DEBUG - Completed: [192.168.1.10:54913] 200 GET /library/recentlyAdded (12 live) TLS GZIP 201ms 20535 bytes (pipelined: 1)
Dec 03, 2018 10:02:06.968 [0x7fd54a7ff700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:02:06.999 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:02:07.001 [0x7fd53d3ff700] DEBUG - Request: [192.168.1.10:54899 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (11 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:02:07.005 [0x7fd53d3ff700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:02:27.005 [0x7fd549ffe700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:02:27.135 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:02:27.137 [0x7fd53c3fd700] DEBUG - Request: [192.168.1.10:54917 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:02:27.142 [0x7fd53c3fd700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:02:47.141 [0x7fd54a7ff700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:02:47.244 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:02:47.246 [0x7fd53d3ff700] DEBUG - Request: [192.168.1.10:54918 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:02:47.248 [0x7fd53d3ff700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:03:04.070 [0x7fd53d3ff700] DEBUG - BPQ: [Starting] -> [Processing]
Dec 03, 2018 10:03:04.101 [0x7fd53d3ff700] DEBUG - BPQ: generating queue items from 1 generator(s)
Dec 03, 2018 10:03:04.116 [0x7fd53d3ff700] DEBUG - Sync: updating status for sync list 28849206, sync item 31847138, generator 36
Dec 03, 2018 10:03:04.134 [0x7fd53d3ff700] DEBUG - BPQ: generated 0 item(s) for queue
Dec 03, 2018 10:03:04.135 [0x7fd53d3ff700] DEBUG - PlayQueue: 0 generated IDs compressed down to a 2 byte blob.
Dec 03, 2018 10:03:04.135 [0x7fd53d3ff700] DEBUG - PlayQueue: 0 generated IDs compressed down to a 2 byte blob.
Dec 03, 2018 10:03:04.140 [0x7fd53d3ff700] DEBUG - BPQ: [Processing] -> [Idle]
Dec 03, 2018 10:03:07.250 [0x7fd549ffe700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:03:07.349 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:03:07.351 [0x7fd53c3fd700] DEBUG - Request: [192.168.1.10:54919 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:03:07.357 [0x7fd53c3fd700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:03:17.364 [0x7fd539bf8700] DEBUG - Request: [127.0.0.1:58790 (Loopback)] GET /servers (6 live) GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:03:17.369 [0x7fd54a7ff700] DEBUG - Completed: [127.0.0.1:58790] 200 GET /servers (6 live) GZIP 7ms 491 bytes
Dec 03, 2018 10:03:17.394 [0x7fd53c3fd700] DEBUG - Request: [127.0.0.1:58792 (Loopback)] GET /library/sections (6 live) GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:03:17.410 [0x7fd54a7ff700] DEBUG - Completed: [127.0.0.1:58792] 200 GET /library/sections (6 live) GZIP 16ms 1027 bytes
Dec 03, 2018 10:03:17.433 [0x7fd539bf8700] DEBUG - Request: [127.0.0.1:58794 (Loopback)] GET /channels/all (7 live) GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:03:17.436 [0x7fd54a7ff700] DEBUG - Completed: [127.0.0.1:58794] 200 GET /channels/all (6 live) GZIP 4ms 387 bytes
Dec 03, 2018 10:03:17.463 [0x7fd53c3fd700] DEBUG - Request: [127.0.0.1:58796 (Loopback)] GET /library/sections (6 live) GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:03:17.472 [0x7fd549ffe700] DEBUG - Completed: [127.0.0.1:58796] 200 GET /library/sections (6 live) GZIP 9ms 1027 bytes
Dec 03, 2018 10:03:17.490 [0x7fd539bf8700] DEBUG - Request: [127.0.0.1:58798 (Loopback)] GET /channels/all (7 live) GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:03:17.493 [0x7fd549ffe700] DEBUG - Completed: [127.0.0.1:58798] 200 GET /channels/all (7 live) GZIP 3ms 387 bytes
Dec 03, 2018 10:03:27.355 [0x7fd549ffe700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:03:27.495 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:03:27.497 [0x7fd53c3fd700] DEBUG - Request: [192.168.1.10:54920 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:03:27.500 [0x7fd53c3fd700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:03:38.059 [0x7fd5373f3700] INFO - Library section 1 (Películas) will be updated because of a change in /data/movies/peliculas/piniculas
Dec 03, 2018 10:03:41.587 [0x7fd5373f3700] INFO - Library section 1 (Películas) will be updated because of a change in /data/movies/peliculas/piniculas/Vivir es facil con los ojos cerrados (2013).HDrip
Dec 03, 2018 10:03:47.499 [0x7fd549ffe700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:03:47.594 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:03:47.596 [0x7fd53d3ff700] DEBUG - Request: [192.168.1.10:54921 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:03:47.598 [0x7fd53d3ff700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:04:07.598 [0x7fd549ffe700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:04:07.603 [0x7fd544fff700] DEBUG - [CompanionProxy] player j2k37oddmpjjd0onjj77pazx was last refreshed 10 seconds ago
Dec 03, 2018 10:04:07.690 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:04:07.694 [0x7fd53c3fd700] DEBUG - Request: [192.168.1.10:54922 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:04:07.700 [0x7fd53c3fd700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:04:27.698 [0x7fd54a7ff700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:04:27.780 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:04:27.781 [0x7fd53c3fd700] DEBUG - Request: [192.168.1.10:54923 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:04:27.783 [0x7fd53c3fd700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:04:47.783 [0x7fd54a7ff700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:04:47.875 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:04:47.876 [0x7fd53d3ff700] DEBUG - Request: [192.168.1.10:54928 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:04:47.878 [0x7fd53d3ff700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:05:07.880 [0x7fd549ffe700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:05:07.951 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:05:07.953 [0x7fd53d3ff700] DEBUG - Request: [192.168.1.10:54929 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:05:07.954 [0x7fd53d3ff700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:05:27.955 [0x7fd54a7ff700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:05:28.059 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:05:28.061 [0x7fd53d3ff700] DEBUG - Request: [192.168.1.10:54930 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:05:28.063 [0x7fd53d3ff700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:05:48.063 [0x7fd54a7ff700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:05:48.238 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:05:48.243 [0x7fd53d3ff700] DEBUG - Request: [192.168.1.10:54931 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:05:48.245 [0x7fd53d3ff700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:06:08.245 [0x7fd549ffe700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:06:08.304 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:06:08.305 [0x7fd53d3ff700] DEBUG - Request: [192.168.1.10:54933 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:06:08.307 [0x7fd53d3ff700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:06:09.437 [0x7fd544fff700] DEBUG - Library Updater: Requested that section 1 be updated, force=0, deep=0, subdir=/data/movies/peliculas/piniculas/Vivir es facil con los ojos cerrados (2013).HDrip iTunes=0
Dec 03, 2018 10:06:09.437 [0x7fd544fff700] DEBUG - Library Updater: Queueing section 1
Dec 03, 2018 10:06:09.465 [0x7fd539bf8700] DEBUG - Scanning section 1
Dec 03, 2018 10:06:09.564 [0x7fd539bf8700] DEBUG - Job running: EAE_ROOT='/tmp/pms-b010e6ce-5dd7-43d3-ae68-444aba69332b/EasyAudioEncoder' FFMPEG_EXTERNAL_LIBS='/config/Library/Application\ Support/Plex\ Media\ Server/Codecs/531e313-1328-linux-ubuntu-x86_64/' X_PLEX_TOKEN='xxxxxxxxxxxxxxxxxxxx' '/usr/lib/plexmediaserver/Plex Media Scanner' '--scan' '--refresh' '--section' '1' '--directory' '/data/movies/peliculas/piniculas/Vivir es facil con los ojos cerrados (2013).HDrip'
Dec 03, 2018 10:06:09.571 [0x7fd539bf8700] DEBUG - Jobs: Starting child process with pid 451
Dec 03, 2018 10:06:09.648 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:06:09.649 [0x7fd53c3fd700] DEBUG - Request: [192.168.1.10:54934 (Subnet)] GET /library/sections (6 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:06:09.674 [0x7fd54a7ff700] DEBUG - Completed: [192.168.1.10:54934] 200 GET /library/sections (7 live) TLS GZIP 25ms 1111 bytes (pipelined: 1)
Dec 03, 2018 10:06:09.685 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:06:09.686 [0x7fd53c3fd700] DEBUG - Request: [192.168.1.10:54935 (Subnet)] GET /hubs/home/continueWatching (7 live) TLS Page 0-15 GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:06:09.706 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:06:09.708 [0x7fd53cbfe700] DEBUG - Request: [192.168.1.10:54934 (Subnet)] GET /hubs/home/onDeck (7 live) TLS Page 0-15 GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:06:09.728 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:06:09.730 [0x7fd53d3ff700] DEBUG - Request: [192.168.1.10:54936 (Subnet)] GET /hubs/home/recentlyAdded?type=1 (8 live) TLS Page 0-47 GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:06:09.737 [0x7fd53d3ff700] DEBUG - Setting container serialization range to [0, 47] (total=-1)
Dec 03, 2018 10:06:09.746 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:06:09.749 [0x7fd5497fd700] DEBUG - Request: [192.168.1.10:54937 (Subnet)] GET /hubs/home/recentlyAdded?type=2 (10 live) TLS Page 0-15 GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:06:09.761 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:06:09.763 [0x7fd533fff700] DEBUG - Request: [192.168.1.10:54938 (Subnet)] GET /hubs/home/recentlyAdded?type=1&personal=1 (10 live) TLS Page 0-15 GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:06:09.767 [0x7fd533fff700] DEBUG - Setting container serialization range to [0, 15] (total=-1)
Dec 03, 2018 10:06:09.809 [0x7fd533fff700] DEBUG - Setting container serialization range to [0, 15] (total=5)
Dec 03, 2018 10:06:09.837 [0x7fd549ffe700] DEBUG - Completed: [192.168.1.10:54938] 200 GET /hubs/home/recentlyAdded?type=1&personal=1 (10 live) TLS GZIP Page 0-15 75ms 1876 bytes (pipelined: 1)
Dec 03, 2018 10:06:09.848 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:06:09.849 [0x7fd533fff700] DEBUG - Request: [192.168.1.10:54938 (Subnet)] GET /hubs/home/recentlyAdded?type=8 (10 live) TLS Page 0-15 GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:06:09.853 [0x7fd533fff700] DEBUG - Setting container serialization range to [0, 15] (total=-1)
Dec 03, 2018 10:06:09.890 [0x7fd53c3fd700] DEBUG - It took 70.000000 ms to retrieve 1 items.
Dec 03, 2018 10:06:09.906 [0x7fd53c3fd700] DEBUG - Setting container serialization range to [0, 15] (total=-1)
Dec 03, 2018 10:06:09.915 [0x7fd54a7ff700] DEBUG - Completed: [192.168.1.10:54935] 200 GET /hubs/home/continueWatching (10 live) TLS GZIP Page 0-15 229ms 1441 bytes (pipelined: 1)
Dec 03, 2018 10:06:09.919 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:06:09.921 [0x7fd5337fe700] DEBUG - Request: [192.168.1.10:54935 (Subnet)] GET /hubs/home/recentlyAdded?type=13 (10 live) TLS Page 0-15 GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:06:09.924 [0x7fd5337fe700] DEBUG - Setting container serialization range to [0, 15] (total=-1)
Dec 03, 2018 10:06:09.933 [0x7fd549ffe700] DEBUG - Completed: [192.168.1.10:54935] 200 GET /hubs/home/recentlyAdded?type=13 (10 live) TLS GZIP Page 0-15 12ms 553 bytes (pipelined: 2)
Dec 03, 2018 10:06:09.941 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:06:09.946 [0x7fd53c3fd700] DEBUG - Request: [192.168.1.10:54935 (Subnet)] GET /library/sections/1/all?type=1&includeCollections=1 (10 live) TLS Page 0-153 GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:06:09.946 [0x7fd533fff700] DEBUG - It took 110.000000 ms to retrieve 11 items.
Dec 03, 2018 10:06:09.950 [0x7fd53c3fd700] DEBUG - Setting container serialization range to [0, 153] (total=-1)
Dec 03, 2018 10:06:09.951 [0x7fd533fff700] DEBUG - Setting container serialization range to [0, 15] (total=11)
Dec 03, 2018 10:06:09.961 [0x7fd5497fd700] WARN - SLOW QUERY: It took 390.000000 ms to retrieve 35 items.
Dec 03, 2018 10:06:09.968 [0x7fd54a7ff700] DEBUG - Completed: [192.168.1.10:54938] 200 GET /hubs/home/recentlyAdded?type=8 (10 live) TLS GZIP Page 0-15 119ms 1704 bytes (pipelined: 2)
Dec 03, 2018 10:06:09.975 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:06:09.975 [0x7fd5337fe700] DEBUG - Request: [192.168.1.10:54938 (Subnet)] GET /library/sections/1/firstCharacter?type=1&includeCollections=1 (10 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:06:09.984 [0x7fd53cbfe700] DEBUG - Setting container serialization range to [0, 15] (total=-1)
Dec 03, 2018 10:06:09.991 [0x7fd53cbfe700] DEBUG - We're going to try to auto-select an audio stream for account 1.
Dec 03, 2018 10:06:09.991 [0x7fd53cbfe700] DEBUG - Selecting best audio stream for part ID 1153 (autoselect: 1 language: es)
Dec 03, 2018 10:06:09.991 [0x7fd53cbfe700] DEBUG - We're going to try to auto-select a subtitle.
Dec 03, 2018 10:06:09.991 [0x7fd53cbfe700] DEBUG - Audio Stream: 2231, Subtitle Stream: -1
Dec 03, 2018 10:06:10.020 [0x7fd53d3ff700] WARN - SLOW QUERY: It took 250.000000 ms to retrieve 48 items.
Dec 03, 2018 10:06:10.021 [0x7fd54a7ff700] DEBUG - Completed: [192.168.1.10:54934] 200 GET /hubs/home/onDeck (10 live) TLS GZIP Page 0-15 314ms 1482 bytes (pipelined: 2)
Dec 03, 2018 10:06:10.022 [0x7fd5497fd700] DEBUG - It took 120.000000 ms to retrieve 5 items.
Dec 03, 2018 10:06:10.032 [0x7fd53d3ff700] DEBUG - Setting container serialization range to [0, 47] (total=200)
Dec 03, 2018 10:06:10.057 [0x7fd5497fd700] DEBUG - Setting container serialization range to [0, 15] (total=-1)
Dec 03, 2018 10:06:10.092 [0x7fd54a7ff700] DEBUG - Completed: [192.168.1.10:54938] 200 GET /library/sections/1/firstCharacter?type=1&includeCollections=1 (10 live) TLS GZIP 117ms 835 bytes (pipelined: 3)
Dec 03, 2018 10:06:10.176 [0x7fd54a7ff700] DEBUG - Completed: [192.168.1.10:54936] 200 GET /hubs/home/recentlyAdded?type=1 (10 live) TLS GZIP Page 0-47 447ms 21033 bytes (pipelined: 1)
Dec 03, 2018 10:06:10.191 [0x7fd54a7ff700] DEBUG - Completed: [192.168.1.10:54937] 200 GET /hubs/home/recentlyAdded?type=2 (10 live) TLS GZIP Page 0-15 444ms 1193 bytes (pipelined: 1)
Dec 03, 2018 10:06:10.394 [0x7fd53c3fd700] DEBUG - It took 490.000000 ms to retrieve 154 items.
Dec 03, 2018 10:06:10.411 [0x7fd53c3fd700] DEBUG - Setting container serialization range to [0, 153] (total=173)
Dec 03, 2018 10:06:10.569 [0x7fd54a7ff700] DEBUG - Completed: [192.168.1.10:54935] 200 GET /library/sections/1/all?type=1&includeCollections=1 (10 live) TLS GZIP Page 0-153 623ms 55392 bytes (pipelined: 3)
Dec 03, 2018 10:06:11.626 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:06:11.627 [0x7fd53cbfe700] DEBUG - Request: [192.168.1.10:54935 (Subnet)] GET /media/providers (10 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:06:11.642 [0x7fd54a7ff700] DEBUG - Completed: [192.168.1.10:54935] 200 GET /media/providers (10 live) TLS GZIP 15ms 3028 bytes (pipelined: 4)
Dec 03, 2018 10:06:11.832 [0x7fd549ffe700] DEBUG - EventSource: Got event [data] '<Message host="178.79.148.211" port="443" command="startRelay"/>'
Dec 03, 2018 10:06:11.833 [0x7fd549ffe700] DEBUG - Relay: reused an existing key for https://downloads.plex.tv/relay/relay_v1.pub
Dec 03, 2018 10:06:11.833 [0x7fd549ffe700] DEBUG - Relay: starting relay.
Dec 03, 2018 10:06:11.833 [0x7fd549ffe700] DEBUG - Job running: PLEXTOKEN='xxxxxxxxxxxxxxxxxxxx' '/usr/lib/plexmediaserver/Plex Relay' '-p' '443' '-N' '-R' '0:localhost:32401' '-o' 'StrictHostKeyChecking=yes' '-o' 'UserKnownHostsFile=/config/Library/Application Support/Plex Media Server/Cache/relayHostKey.txt' '-o' 'NoneSwitch=yes' '-o' 'NoneEnabled=yes' '-o' 'LogLevel=VERBOSE' '-o' 'PreferredAuthentications=password' '-o' 'PubkeyAuthentication=no' '-l' 'a@gmail.com' '-F' '/dev/null' '178.79.148.211'
Dec 03, 2018 10:06:11.838 [0x7fd549ffe700] DEBUG - Jobs: Starting child process with pid 458
Dec 03, 2018 10:06:12.462 [0x7fd5337fe700] DEBUG - [PlexRelay] Authenticated to 178.79.148.211 ([178.79.148.211]:443).
Dec 03, 2018 10:06:12.716 [0x7fd533fff700] DEBUG - Request: [127.0.0.1:58808 (Loopback)] GET /:/metadata/notify/cullTimeline?librarySectionID=1&sinceTime=1543848372 (12 live) GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:06:12.717 [0x7fd533fff700] DEBUG - Asked to cull library timeline before time 1543848372, we're starting with 0 items.
Dec 03, 2018 10:06:12.717 [0x7fd533fff700] DEBUG - Library timeline cull complete with 0 items left.
Dec 03, 2018 10:06:12.717 [0x7fd549ffe700] DEBUG - Completed: [127.0.0.1:58808] 200 GET /:/metadata/notify/cullTimeline?librarySectionID=1&sinceTime=1543848372 (12 live) GZIP 2ms 166 bytes
Dec 03, 2018 10:06:12.961 [0x7fd5497fd700] ERROR - [PlexRelay] kex protocol error: type 7 seq 11
Dec 03, 2018 10:06:13.091 [0x7fd53d3ff700] INFO - [PlexRelay] Allocated port 4733 for remote forward to localhost:32401
Dec 03, 2018 10:06:13.480 [0x7fd53cbfe700] DEBUG - Request: [127.0.0.1:58816 (Loopback)] GET /library/changestamp (16 live) GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:06:13.483 [0x7fd549ffe700] DEBUG - Completed: [127.0.0.1:58816] 200 GET /library/changestamp (16 live) GZIP 3ms 466 bytes
Dec 03, 2018 10:06:13.492 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:06:13.494 [0x7fd53c3fd700] DEBUG - Request: [127.0.0.1:50330 (WAN)] GET /media/providers (16 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:06:13.549 [0x7fd54a7ff700] DEBUG - Completed: [127.0.0.1:50330] 200 GET /media/providers (15 live) TLS GZIP 56ms 3099 bytes (pipelined: 1)
Dec 03, 2018 10:06:14.227 [0x7fd5337fe700] DEBUG - Request: [127.0.0.1:58818 (Loopback)] GET /library/changestamp (15 live) GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:06:14.229 [0x7fd54a7ff700] DEBUG - Completed: [127.0.0.1:58818] 200 GET /library/changestamp (15 live) GZIP 2ms 466 bytes
Dec 03, 2018 10:06:14.270 [0x7fd533fff700] DEBUG - Request: [127.0.0.1:58820 (Loopback)] GET /:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=1565&metadataType=1&state=-1&mediaState=analyzing (16 live) GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:06:14.271 [0x7fd54a7ff700] DEBUG - Completed: [127.0.0.1:58820] 200 GET /:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=1565&metadataType=1&state=-1&mediaState=analyzing (15 live) GZIP 1ms 166 bytes
Dec 03, 2018 10:06:14.292 [0x7fd5497fd700] DEBUG - Request: [127.0.0.1:58822 (Loopback)] GET /:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=1565&metadataType=1&state=-1&mediaState=thumbnailing (16 live) GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:06:14.294 [0x7fd549ffe700] DEBUG - Completed: [127.0.0.1:58822] 200 GET /:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=1565&metadataType=1&state=-1&mediaState=thumbnailing (15 live) GZIP 2ms 166 bytes
Dec 03, 2018 10:06:14.301 [0x7fd53d3ff700] DEBUG - Request: [127.0.0.1:58824 (Loopback)] GET /:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=1565&metadataType=1&state=-1&mediaState=idle (15 live) GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:06:14.303 [0x7fd549ffe700] DEBUG - Completed: [127.0.0.1:58824] 200 GET /:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=1565&metadataType=1&state=-1&mediaState=idle (15 live) GZIP 1ms 166 bytes
Dec 03, 2018 10:06:14.307 [0x7fd53cbfe700] DEBUG - Request: [127.0.0.1:58826 (Loopback)] GET /:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=1565&metadataType=1&state=1 (16 live) GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:06:14.309 [0x7fd549ffe700] DEBUG - Completed: [127.0.0.1:58826] 200 GET /:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=1565&metadataType=1&state=1 (16 live) GZIP 2ms 166 bytes
Dec 03, 2018 10:06:14.332 [0x7fd5433ff700] DEBUG - Jobs: '/usr/lib/plexmediaserver/Plex Media Scanner' exit code for process 451 is 0 (success)
Dec 03, 2018 10:06:14.436 [0x7fd5433ff700] DEBUG - Collections: Found 42 collections tags in section 1.
Dec 03, 2018 10:06:14.444 [0x7fd5433ff700] DEBUG - Collections: We had 45 collections in the library already.
Dec 03, 2018 10:06:14.444 [0x7fd5433ff700] DEBUG - Collections: Synced tags in section 1 in 102ms.
Dec 03, 2018 10:06:14.456 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:06:14.456 [0x7fd53c3fd700] DEBUG - Request: [192.168.1.10:54935 (Subnet)] GET /library/metadata/1565?skipRefresh=1 (15 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:06:14.485 [0x7fd53c3fd700] DEBUG - We're going to try to auto-select an audio stream for account 1.
Dec 03, 2018 10:06:14.485 [0x7fd53c3fd700] DEBUG - Selecting best audio stream for part ID 3311 (autoselect: 1 language: es)
Dec 03, 2018 10:06:14.485 [0x7fd53c3fd700] DEBUG - We're going to try to auto-select a subtitle.
Dec 03, 2018 10:06:14.486 [0x7fd53c3fd700] DEBUG - Audio Stream: 6664, Subtitle Stream: -1
Dec 03, 2018 10:06:14.494 [0x7fd549ffe700] DEBUG - Completed: [192.168.1.10:54935] 200 GET /library/metadata/1565?skipRefresh=1 (15 live) TLS GZIP 37ms 1223 bytes (pipelined: 5)
Dec 03, 2018 10:06:14.692 [0x7fd5433ff700] WARN - Held transaction for too long (../Library/MetadataCollection.cpp:236): 0.420000 seconds
Dec 03, 2018 10:06:14.724 [0x7fd5433ff700] DEBUG - Collections: Refreshed attributes for 42 collections in section 1 in 279ms.
Dec 03, 2018 10:06:14.756 [0x7fd5433ff700] DEBUG - Collection: Refreshed visibility in section 1 in 30ms.
Dec 03, 2018 10:06:14.760 [0x7fd539bf8700] DEBUG - Activity: registered new activity a2158edd-923d-43f4-84d4-6cff0a2461df - Processing subscriptions
Dec 03, 2018 10:06:14.765 [0x7fd544fff700] DEBUG - Activity: registered new activity bb3634ad-faaf-4c54-9892-09abc395c35f - Processing subscriptions
Dec 03, 2018 10:06:14.766 [0x7fd544fff700] DEBUG - DVR:Subscription: Scheduling subscriptions.
Dec 03, 2018 10:06:14.768 [0x7fd544fff700] DEBUG - DVR:Subscription: Initialized 0 schedulers.
Dec 03, 2018 10:06:14.768 [0x7fd544fff700] DEBUG - DVR:Subscription: Starting with 0 grabs, scheduled 0 active ones preemptively.
Dec 03, 2018 10:06:14.769 [0x7fd544fff700] DEBUG - DVR:Subscription: Scheduled all subscriptions in 2 ms.
Dec 03, 2018 10:06:14.769 [0x7fd544fff700] DEBUG - Activity: Ended activity bb3634ad-faaf-4c54-9892-09abc395c35f.
Dec 03, 2018 10:06:14.771 [0x7fd544fff700] DEBUG - DVR:Subscription: There are 0 active grabs at the end.
Dec 03, 2018 10:06:14.771 [0x7fd544fff700] DEBUG - Activity: Ended activity a2158edd-923d-43f4-84d4-6cff0a2461df.
Dec 03, 2018 10:06:14.771 [0x7fd544fff700] DEBUG - DVR:Subscription: Refreshed all content in 9 ms.
Dec 03, 2018 10:06:14.866 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:06:14.867 [0x7fd5337fe700] DEBUG - Request: [192.168.1.10:54935 (Subnet)] GET /library/sections (14 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:06:14.894 [0x7fd549ffe700] DEBUG - Completed: [192.168.1.10:54935] 200 GET /library/sections (14 live) TLS GZIP 27ms 1107 bytes (pipelined: 6)
Dec 03, 2018 10:06:14.897 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:06:14.899 [0x7fd533fff700] DEBUG - Request: [192.168.1.10:54936 (Subnet)] GET /hubs/home/continueWatching (14 live) TLS Page 0-15 GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:06:14.925 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:06:14.926 [0x7fd5497fd700] DEBUG - Request: [192.168.1.10:54935 (Subnet)] GET /hubs/home/onDeck (12 live) TLS Page 0-15 GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:06:14.928 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:06:14.929 [0x7fd53d3ff700] DEBUG - Request: [192.168.1.10:54938 (Subnet)] GET /hubs/home/recentlyAdded?type=1 (12 live) TLS Page 0-47 GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:06:14.934 [0x7fd53d3ff700] DEBUG - Setting container serialization range to [0, 47] (total=-1)
Dec 03, 2018 10:06:14.942 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:06:14.945 [0x7fd53cbfe700] DEBUG - Request: [192.168.1.10:54934 (Subnet)] GET /hubs/home/recentlyAdded?type=2 (11 live) TLS Page 0-15 GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:06:14.962 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:06:14.964 [0x7fd53c3fd700] DEBUG - Request: [192.168.1.10:54937 (Subnet)] GET /hubs/home/recentlyAdded?type=1&personal=1 (11 live) TLS Page 0-15 GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:06:14.971 [0x7fd53c3fd700] DEBUG - Setting container serialization range to [0, 15] (total=-1)
Dec 03, 2018 10:06:15.000 [0x7fd53cbfe700] DEBUG - It took 120.000000 ms to retrieve 35 items.
Dec 03, 2018 10:06:15.004 [0x7fd533fff700] DEBUG - It took 60.000000 ms to retrieve 1 items.
Dec 03, 2018 10:06:15.008 [0x7fd533fff700] DEBUG - Setting container serialization range to [0, 15] (total=-1)
Dec 03, 2018 10:06:15.009 [0x7fd5497fd700] DEBUG - Setting container serialization range to [0, 15] (total=-1)
Dec 03, 2018 10:06:15.020 [0x7fd5497fd700] DEBUG - We're going to try to auto-select an audio stream for account 1.
Dec 03, 2018 10:06:15.020 [0x7fd5497fd700] DEBUG - Selecting best audio stream for part ID 1153 (autoselect: 1 language: es)
Dec 03, 2018 10:06:15.020 [0x7fd5497fd700] DEBUG - We're going to try to auto-select a subtitle.
Dec 03, 2018 10:06:15.020 [0x7fd5497fd700] DEBUG - Audio Stream: 2231, Subtitle Stream: -1
Dec 03, 2018 10:06:15.012 [0x7fd53c3fd700] DEBUG - It took 70.000000 ms to retrieve 5 items.
Dec 03, 2018 10:06:15.026 [0x7fd53c3fd700] DEBUG - Setting container serialization range to [0, 15] (total=5)
Dec 03, 2018 10:06:15.030 [0x7fd54a7ff700] DEBUG - Completed: [192.168.1.10:54936] 200 GET /hubs/home/continueWatching (11 live) TLS GZIP Page 0-15 131ms 1441 bytes (pipelined: 2)
Dec 03, 2018 10:06:15.030 [0x7fd549ffe700] DEBUG - Completed: [192.168.1.10:54935] 200 GET /hubs/home/onDeck (11 live) TLS GZIP Page 0-15 104ms 1482 bytes (pipelined: 7)
Dec 03, 2018 10:06:15.035 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:06:15.037 [0x7fd533fff700] DEBUG - Request: [192.168.1.10:54935 (Subnet)] GET /hubs/home/recentlyAdded?type=8 (11 live) TLS Page 0-15 GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:06:15.036 [0x7fd549ffe700] DEBUG - Completed: [192.168.1.10:54937] 200 GET /hubs/home/recentlyAdded?type=1&personal=1 (11 live) TLS GZIP Page 0-15 72ms 1876 bytes (pipelined: 2)
Dec 03, 2018 10:06:15.041 [0x7fd533fff700] DEBUG - Setting container serialization range to [0, 15] (total=-1)
Dec 03, 2018 10:06:15.042 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:06:15.051 [0x7fd5497fd700] DEBUG - Request: [192.168.1.10:54937 (Subnet)] GET /hubs/home/recentlyAdded?type=13 (11 live) TLS Page 0-15 GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:06:15.056 [0x7fd5497fd700] DEBUG - Setting container serialization range to [0, 15] (total=-1)
Dec 03, 2018 10:06:15.060 [0x7fd549ffe700] DEBUG - Completed: [192.168.1.10:54937] 200 GET /hubs/home/recentlyAdded?type=13 (11 live) TLS GZIP Page 0-15 10ms 553 bytes (pipelined: 3)
Dec 03, 2018 10:06:15.061 [0x7fd533fff700] DEBUG - Setting container serialization range to [0, 15] (total=11)
Dec 03, 2018 10:06:15.069 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:06:15.070 [0x7fd53c3fd700] DEBUG - Request: [192.168.1.10:54937 (Subnet)] GET /library/sections/1/all?type=1&includeCollections=1 (11 live) TLS Page 0-153 GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:06:15.073 [0x7fd53c3fd700] DEBUG - Setting container serialization range to [0, 153] (total=-1)
Dec 03, 2018 10:06:15.074 [0x7fd54a7ff700] DEBUG - Completed: [192.168.1.10:54935] 200 GET /hubs/home/recentlyAdded?type=8 (11 live) TLS GZIP Page 0-15 36ms 1704 bytes (pipelined: 8)
Dec 03, 2018 10:06:15.079 [0x7fd53cbfe700] DEBUG - Setting container serialization range to [0, 15] (total=-1)
Dec 03, 2018 10:06:15.080 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:06:15.080 [0x7fd5497fd700] DEBUG - Request: [192.168.1.10:54935 (Subnet)] GET /library/sections/1/firstCharacter?type=1&includeCollections=1 (11 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:06:15.120 [0x7fd53d3ff700] WARN - SLOW QUERY: It took 330.000000 ms to retrieve 48 items.
Dec 03, 2018 10:06:15.124 [0x7fd53d3ff700] DEBUG - Setting container serialization range to [0, 47] (total=200)
Dec 03, 2018 10:06:15.134 [0x7fd549ffe700] DEBUG - Completed: [192.168.1.10:54934] 200 GET /hubs/home/recentlyAdded?type=2 (11 live) TLS GZIP Page 0-15 189ms 1193 bytes (pipelined: 3)
Dec 03, 2018 10:06:15.162 [0x7fd549ffe700] DEBUG - Completed: [192.168.1.10:54935] 200 GET /library/sections/1/firstCharacter?type=1&includeCollections=1 (11 live) TLS GZIP 81ms 835 bytes (pipelined: 9)
Dec 03, 2018 10:06:15.228 [0x7fd549ffe700] DEBUG - Completed: [192.168.1.10:54938] 200 GET /hubs/home/recentlyAdded?type=1 (11 live) TLS GZIP Page 0-47 299ms 21040 bytes (pipelined: 4)
Dec 03, 2018 10:06:15.268 [0x7fd53c3fd700] DEBUG - It took 250.000000 ms to retrieve 154 items.
Dec 03, 2018 10:06:15.279 [0x7fd53c3fd700] DEBUG - Setting container serialization range to [0, 153] (total=173)
Dec 03, 2018 10:06:15.385 [0x7fd549ffe700] DEBUG - Completed: [192.168.1.10:54937] 200 GET /library/sections/1/all?type=1&includeCollections=1 (11 live) TLS GZIP Page 0-153 316ms 55392 bytes (pipelined: 4)
Dec 03, 2018 10:06:16.788 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:06:16.789 [0x7fd5337fe700] DEBUG - Request: [192.168.1.10:54935 (Subnet)] GET /media/providers (11 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:06:16.804 [0x7fd549ffe700] DEBUG - Completed: [192.168.1.10:54935] 200 GET /media/providers (11 live) TLS GZIP 15ms 3022 bytes (pipelined: 10)
Dec 03, 2018 10:06:16.857 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:06:16.858 [0x7fd533fff700] DEBUG - Request: [127.0.0.1:50330 (WAN)] GET /media/providers (11 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:06:16.881 [0x7fd54a7ff700] DEBUG - Completed: [127.0.0.1:50330] 200 GET /media/providers (11 live) TLS GZIP 23ms 3093 bytes (pipelined: 2)
Dec 03, 2018 10:06:28.307 [0x7fd54a7ff700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:06:28.364 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:06:28.364 [0x7fd53cbfe700] DEBUG - Request: [192.168.1.10:54937 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (10 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:06:28.366 [0x7fd53cbfe700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:06:48.368 [0x7fd549ffe700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:06:48.482 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:06:48.485 [0x7fd533fff700] DEBUG - Request: [192.168.1.10:54942 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (6 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:06:48.489 [0x7fd533fff700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:07:08.487 [0x7fd549ffe700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:07:08.541 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:07:08.543 [0x7fd53cbfe700] DEBUG - Request: [192.168.1.10:54952 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:07:08.545 [0x7fd53cbfe700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:07:28.545 [0x7fd549ffe700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:07:28.692 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:07:28.693 [0x7fd53cbfe700] DEBUG - Request: [192.168.1.10:54959 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:07:28.694 [0x7fd53cbfe700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:07:48.694 [0x7fd54a7ff700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:07:48.808 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:07:48.809 [0x7fd533fff700] DEBUG - Request: [192.168.1.10:54963 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:07:48.811 [0x7fd533fff700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:08:08.811 [0x7fd54a7ff700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:08:08.870 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:08:08.872 [0x7fd53cbfe700] DEBUG - Request: [192.168.1.10:54981 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:08:08.874 [0x7fd53cbfe700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:08:28.874 [0x7fd549ffe700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:08:29.014 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:08:29.015 [0x7fd53cbfe700] DEBUG - Request: [192.168.1.10:54984 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:08:29.018 [0x7fd53cbfe700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:08:49.017 [0x7fd54a7ff700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:08:49.103 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:08:49.108 [0x7fd533fff700] DEBUG - Request: [192.168.1.10:55013 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:08:49.112 [0x7fd533fff700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:09:09.110 [0x7fd549ffe700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:09:09.238 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:09:09.243 [0x7fd533fff700] DEBUG - Request: [192.168.1.10:55016 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:09:09.251 [0x7fd533fff700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:09:29.248 [0x7fd54a7ff700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:09:29.405 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:09:29.409 [0x7fd53cbfe700] DEBUG - Request: [192.168.1.10:55019 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:09:29.411 [0x7fd53cbfe700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:09:49.411 [0x7fd549ffe700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:09:49.511 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:09:49.512 [0x7fd533fff700] DEBUG - Request: [192.168.1.10:55031 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:09:49.514 [0x7fd533fff700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:10:09.514 [0x7fd549ffe700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:10:09.574 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:10:09.575 [0x7fd53cbfe700] DEBUG - Request: [192.168.1.10:55034 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:10:09.577 [0x7fd53cbfe700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:10:29.577 [0x7fd549ffe700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:10:29.663 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:10:29.664 [0x7fd533fff700] DEBUG - Request: [192.168.1.10:55037 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:10:29.666 [0x7fd533fff700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:10:49.666 [0x7fd549ffe700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:10:49.764 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:10:49.765 [0x7fd53cbfe700] DEBUG - Request: [192.168.1.10:55040 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:10:49.766 [0x7fd53cbfe700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:11:09.769 [0x7fd54a7ff700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:11:09.830 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:11:09.830 [0x7fd54b7ff700] DEBUG - Auth: Refreshing tokens inside the token-based authentication filter.
Dec 03, 2018 10:11:09.831 [0x7fd533fff700] DEBUG - Request: [192.168.1.10:55043 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:11:09.833 [0x7fd533fff700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:11:09.887 [0x7fd54b7ff700] DEBUG - HTTP requesting GET https://plex.tv/servers/e7f44c013808a4bef0c9631d075fbb02c00bf13b/access_tokens.xml?auth_token=xxxxxxxxxxxxxxxxxxxx&includeProfiles=1&includeProviders=1
Dec 03, 2018 10:11:10.305 [0x7fd54b7ff700] DEBUG - HTTP 200 response from GET https://plex.tv/servers/e7f44c013808a4bef0c9631d075fbb02c00bf13b/access_tokens.xml?auth_token=xxxxxxxxxxxxxxxxxxxx&includeProfiles=1&includeProviders=1
Dec 03, 2018 10:11:10.350 [0x7fd54b7ff700] DEBUG - MyPlex: updating with 26 access tokens
Dec 03, 2018 10:11:10.373 [0x7fd545ffc700] DEBUG - HTTP requesting GET https://plex.tv/media/providers?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Dec 03, 2018 10:11:10.681 [0x7fd545ffc700] DEBUG - HTTP 200 response from GET https://plex.tv/media/providers?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Dec 03, 2018 10:11:29.832 [0x7fd549ffe700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:11:29.923 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:11:29.924 [0x7fd53cbfe700] DEBUG - Request: [192.168.1.10:55048 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:11:29.925 [0x7fd53cbfe700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:11:37.520 [0x7fd533fff700] DEBUG - [PlexRelay] Transferred: sent 14420, received 6388 bytes, in 325.0 seconds
Dec 03, 2018 10:11:37.525 [0x7fd533fff700] DEBUG - [PlexRelay] Bytes per second: sent 44.4, received 19.7
Dec 03, 2018 10:11:37.553 [0x7fd5373f3700] WARN - SLOW QUERY: It took 250.000000 ms to retrieve 1 items.
Dec 03, 2018 10:11:37.554 [0x7fd5433ff700] DEBUG - Jobs: '/usr/lib/plexmediaserver/Plex Relay' exit code for process 458 is 255 (failure)
Dec 03, 2018 10:11:49.926 [0x7fd54a7ff700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:11:50.021 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:11:50.022 [0x7fd533fff700] DEBUG - Request: [192.168.1.10:55051 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:11:50.024 [0x7fd533fff700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:12:10.026 [0x7fd54a7ff700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:12:10.063 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:12:10.064 [0x7fd53cbfe700] DEBUG - Request: [192.168.1.10:55076 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:12:10.065 [0x7fd53cbfe700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:12:30.066 [0x7fd54a7ff700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:12:30.144 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:12:30.146 [0x7fd533fff700] DEBUG - Request: [192.168.1.10:55080 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:12:30.147 [0x7fd533fff700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:12:50.147 [0x7fd54a7ff700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:12:50.190 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:12:50.195 [0x7fd53cbfe700] DEBUG - Request: [192.168.1.10:55084 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:12:50.197 [0x7fd53cbfe700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:13:10.197 [0x7fd549ffe700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:13:10.291 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:13:10.292 [0x7fd533fff700] DEBUG - Request: [192.168.1.10:55087 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:13:10.294 [0x7fd533fff700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:13:30.294 [0x7fd54a7ff700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:13:30.369 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:13:30.371 [0x7fd53cbfe700] DEBUG - Request: [192.168.1.10:55090 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:13:30.373 [0x7fd53cbfe700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:13:50.373 [0x7fd54a7ff700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:13:50.493 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:13:50.494 [0x7fd53cbfe700] DEBUG - Request: [192.168.1.10:55093 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:13:50.496 [0x7fd53cbfe700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:14:10.499 [0x7fd549ffe700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:14:10.565 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:14:10.566 [0x7fd533fff700] DEBUG - Request: [192.168.1.10:55117 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:14:10.570 [0x7fd533fff700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:14:30.570 [0x7fd549ffe700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:14:30.644 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:14:30.645 [0x7fd53cbfe700] DEBUG - Request: [192.168.1.10:55151 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:14:30.647 [0x7fd53cbfe700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:14:50.650 [0x7fd54a7ff700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:14:50.765 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:14:50.766 [0x7fd533fff700] DEBUG - Request: [192.168.1.10:55175 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:14:50.769 [0x7fd533fff700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:15:10.768 [0x7fd549ffe700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:15:10.855 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:15:10.857 [0x7fd533fff700] DEBUG - Request: [192.168.1.10:55180 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:15:10.859 [0x7fd533fff700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:15:30.858 [0x7fd54a7ff700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:15:30.943 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:15:30.946 [0x7fd533fff700] DEBUG - Request: [192.168.1.10:55185 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:15:30.951 [0x7fd533fff700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:15:50.949 [0x7fd54a7ff700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:15:51.034 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:15:51.035 [0x7fd533fff700] DEBUG - Request: [192.168.1.10:55190 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:15:51.037 [0x7fd533fff700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:16:11.037 [0x7fd549ffe700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:16:11.079 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:16:11.080 [0x7fd53cbfe700] DEBUG - Request: [192.168.1.10:55193 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:16:11.082 [0x7fd53cbfe700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:16:11.878 [0x7fd544fff700] DEBUG - Relay: cleaning up inactive relay connection to 178.79.148.211
Dec 03, 2018 10:16:31.082 [0x7fd54a7ff700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:16:31.147 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:16:31.148 [0x7fd53cbfe700] DEBUG - Request: [192.168.1.10:55199 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:16:31.150 [0x7fd53cbfe700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:16:51.149 [0x7fd549ffe700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:16:51.273 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:16:51.275 [0x7fd533fff700] DEBUG - Request: [192.168.1.10:55203 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:16:51.277 [0x7fd533fff700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:17:06.234 [0x7fd549ffe700] DEBUG - Auth: authenticated user 20997727 as Lau
Dec 03, 2018 10:17:06.241 [0x7fd53cbfe700] DEBUG - Request: [192.168.1.10:55208 (Subnet)] GET / (6 live) TLS GZIP Signed-in Token (Lau)
Dec 03, 2018 10:17:06.277 [0x7fd53cbfe700] DEBUG - (Capabilities) Platform 'Windows' not matched by plugin platform requirements
Dec 03, 2018 10:17:06.333 [0x7fd549ffe700] DEBUG - Completed: [192.168.1.10:55208] 200 GET / (6 live) TLS GZIP 92ms 2586 bytes (pipelined: 1)
Dec 03, 2018 10:17:06.404 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 20997727 as Lau
Dec 03, 2018 10:17:06.405 [0x7fd533fff700] DEBUG - Request: [192.168.1.10:55208 (Subnet)] GET /library/onDeck (6 live) TLS GZIP Signed-in Token (Lau)
Dec 03, 2018 10:17:06.415 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 20997727 as Lau
Dec 03, 2018 10:17:06.417 [0x7fd5337fe700] DEBUG - Request: [192.168.1.10:55210 (Subnet)] GET /library/recentlyAdded (7 live) TLS GZIP Signed-in Token (Lau)
Dec 03, 2018 10:17:06.507 [0x7fd5337fe700] DEBUG - It took 60.000000 ms to retrieve 5 items.
Dec 03, 2018 10:17:06.541 [0x7fd549ffe700] DEBUG - Completed: [192.168.1.10:55208] 200 GET /library/onDeck (7 live) TLS GZIP 136ms 500 bytes (pipelined: 2)
Dec 03, 2018 10:17:06.571 [0x7fd5337fe700] DEBUG - It took 120.000000 ms to retrieve 49 items.
Dec 03, 2018 10:17:06.674 [0x7fd549ffe700] DEBUG - Completed: [192.168.1.10:55210] 200 GET /library/recentlyAdded (7 live) TLS GZIP 258ms 20539 bytes (pipelined: 1)
Dec 03, 2018 10:17:11.277 [0x7fd54a7ff700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:17:11.321 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:17:11.322 [0x7fd53cbfe700] DEBUG - Request: [192.168.1.10:55233 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (7 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:17:11.324 [0x7fd53cbfe700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:17:31.323 [0x7fd54a7ff700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:17:31.421 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:17:31.422 [0x7fd533fff700] DEBUG - Request: [192.168.1.10:55295 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:17:31.424 [0x7fd533fff700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:17:51.425 [0x7fd549ffe700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:17:51.495 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:17:51.496 [0x7fd53cbfe700] DEBUG - Request: [192.168.1.10:55300 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:17:51.498 [0x7fd53cbfe700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:18:11.498 [0x7fd549ffe700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:18:11.575 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:18:11.577 [0x7fd533fff700] DEBUG - Request: [192.168.1.10:55314 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:18:11.579 [0x7fd533fff700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:18:31.579 [0x7fd549ffe700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:18:31.674 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:18:31.675 [0x7fd53cbfe700] DEBUG - Request: [192.168.1.10:55327 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:18:31.677 [0x7fd53cbfe700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:18:51.677 [0x7fd549ffe700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:18:51.759 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:18:51.760 [0x7fd533fff700] DEBUG - Request: [192.168.1.10:55332 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:18:51.762 [0x7fd533fff700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:19:11.761 [0x7fd549ffe700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:19:11.835 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:19:11.836 [0x7fd53cbfe700] DEBUG - Request: [192.168.1.10:55337 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:19:11.839 [0x7fd53cbfe700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:19:31.838 [0x7fd54a7ff700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:19:31.936 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:19:31.937 [0x7fd53cbfe700] DEBUG - Request: [192.168.1.10:55342 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:19:31.939 [0x7fd53cbfe700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:19:51.939 [0x7fd549ffe700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:19:52.081 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:19:52.082 [0x7fd53cbfe700] DEBUG - Request: [192.168.1.10:55352 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:19:52.084 [0x7fd53cbfe700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:20:12.084 [0x7fd54a7ff700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:20:12.164 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:20:12.166 [0x7fd53cbfe700] DEBUG - Request: [192.168.1.10:55362 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:20:12.168 [0x7fd53cbfe700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:20:32.173 [0x7fd54a7ff700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:20:32.243 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:20:32.245 [0x7fd533fff700] DEBUG - Request: [192.168.1.10:55368 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:20:32.246 [0x7fd533fff700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:20:52.246 [0x7fd549ffe700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:20:52.349 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:20:52.350 [0x7fd533fff700] DEBUG - Request: [192.168.1.10:55371 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:20:52.352 [0x7fd533fff700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:21:12.354 [0x7fd549ffe700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:21:12.503 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:21:12.503 [0x7fd5467fd700] DEBUG - Auth: Refreshing tokens inside the token-based authentication filter.
Dec 03, 2018 10:21:12.504 [0x7fd53cbfe700] DEBUG - Request: [192.168.1.10:55375 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:21:12.506 [0x7fd53cbfe700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:21:12.555 [0x7fd5467fd700] DEBUG - HTTP requesting GET https://plex.tv/servers/e7f44c013808a4bef0c9631d075fbb02c00bf13b/access_tokens.xml?auth_token=xxxxxxxxxxxxxxxxxxxx&includeProfiles=1&includeProviders=1
Dec 03, 2018 10:21:13.010 [0x7fd5467fd700] DEBUG - HTTP 200 response from GET https://plex.tv/servers/e7f44c013808a4bef0c9631d075fbb02c00bf13b/access_tokens.xml?auth_token=xxxxxxxxxxxxxxxxxxxx&includeProfiles=1&includeProviders=1
Dec 03, 2018 10:21:13.051 [0x7fd5467fd700] DEBUG - MyPlex: updating with 26 access tokens
Dec 03, 2018 10:21:13.074 [0x7fd54b7ff700] DEBUG - HTTP requesting GET https://plex.tv/media/providers?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Dec 03, 2018 10:21:13.371 [0x7fd54b7ff700] DEBUG - HTTP 200 response from GET https://plex.tv/media/providers?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Dec 03, 2018 10:21:32.505 [0x7fd549ffe700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:21:32.600 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:21:32.601 [0x7fd533fff700] DEBUG - Request: [192.168.1.10:55378 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:21:32.603 [0x7fd533fff700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:21:52.603 [0x7fd549ffe700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:21:52.752 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:21:52.757 [0x7fd53cbfe700] DEBUG - Request: [192.168.1.10:55381 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:21:52.760 [0x7fd53cbfe700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:22:12.760 [0x7fd549ffe700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:22:12.827 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:22:12.828 [0x7fd533fff700] DEBUG - Request: [192.168.1.10:55388 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:22:12.830 [0x7fd533fff700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:22:32.829 [0x7fd54a7ff700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:22:32.896 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:22:32.897 [0x7fd53cbfe700] DEBUG - Request: [192.168.1.10:55395 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:22:32.899 [0x7fd53cbfe700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:22:52.900 [0x7fd54a7ff700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:22:52.977 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:22:52.979 [0x7fd533fff700] DEBUG - Request: [192.168.1.10:55402 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:22:52.981 [0x7fd533fff700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:22:53.058 [0x7fd544fff700] DEBUG - Library Updater: Requested that section 1 be updated, force=0, deep=0, subdir=/data/movies/peliculas/piniculas iTunes=0
Dec 03, 2018 10:22:53.058 [0x7fd544fff700] DEBUG - Library Updater: Queueing section 1
Dec 03, 2018 10:22:53.077 [0x7fd5337fe700] DEBUG - Scanning section 1
Dec 03, 2018 10:22:53.078 [0x7fd5337fe700] DEBUG - Killing job.
Dec 03, 2018 10:22:53.078 [0x7fd5337fe700] DEBUG - Signalling job ID 451 with 9
Dec 03, 2018 10:22:53.202 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:22:53.203 [0x7fd53cbfe700] DEBUG - Request: [192.168.1.10:55403 (Subnet)] GET /library/sections (6 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:22:53.223 [0x7fd5337fe700] DEBUG - Job running: EAE_ROOT='/tmp/pms-b010e6ce-5dd7-43d3-ae68-444aba69332b/EasyAudioEncoder' FFMPEG_EXTERNAL_LIBS='/config/Library/Application\ Support/Plex\ Media\ Server/Codecs/531e313-1328-linux-ubuntu-x86_64/' X_PLEX_TOKEN='xxxxxxxxxxxxxxxxxxxx' '/usr/lib/plexmediaserver/Plex Media Scanner' '--scan' '--refresh' '--section' '1' '--directory' '/data/movies/peliculas/piniculas'
Dec 03, 2018 10:22:53.251 [0x7fd5337fe700] DEBUG - Jobs: Starting child process with pid 515
Dec 03, 2018 10:22:53.271 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:22:53.274 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:22:53.275 [0x7fd53c3fd700] DEBUG - Request: [192.168.1.10:55404 (Subnet)] GET /hubs/home/continueWatching (8 live) TLS Page 0-15 GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:22:53.276 [0x7fd533fff700] DEBUG - Request: [192.168.1.10:55405 (Subnet)] GET /hubs/home/onDeck (8 live) TLS Page 0-15 GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:22:53.306 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:22:53.307 [0x7fd53cbfe700] DEBUG - Request: [192.168.1.10:55406 (Subnet)] GET /hubs/home/recentlyAdded?type=1 (9 live) TLS Page 0-47 GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:22:53.315 [0x7fd549ffe700] DEBUG - Completed: [192.168.1.10:55403] 200 GET /library/sections (10 live) TLS GZIP 112ms 1111 bytes (pipelined: 1)
Dec 03, 2018 10:22:53.323 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:22:53.327 [0x7fd53d3ff700] DEBUG - Request: [192.168.1.10:55403 (Subnet)] GET /hubs/home/recentlyAdded?type=1&personal=1 (10 live) TLS Page 0-15 GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:22:53.333 [0x7fd53cbfe700] DEBUG - Setting container serialization range to [0, 47] (total=-1)
Dec 03, 2018 10:22:53.338 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:22:53.344 [0x7fd5497fd700] DEBUG - Request: [192.168.1.10:55407 (Subnet)] GET /hubs/home/recentlyAdded?type=2 (10 live) TLS Page 0-15 GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:22:53.348 [0x7fd53d3ff700] DEBUG - Setting container serialization range to [0, 15] (total=-1)
Dec 03, 2018 10:22:53.476 [0x7fd53d3ff700] DEBUG - It took 60.000000 ms to retrieve 5 items.
Dec 03, 2018 10:22:53.495 [0x7fd53d3ff700] DEBUG - Setting container serialization range to [0, 15] (total=5)
Dec 03, 2018 10:22:53.497 [0x7fd533fff700] DEBUG - Setting container serialization range to [0, 15] (total=-1)
Dec 03, 2018 10:22:53.530 [0x7fd533fff700] DEBUG - We're going to try to auto-select an audio stream for account 1.
Dec 03, 2018 10:22:53.532 [0x7fd533fff700] DEBUG - Selecting best audio stream for part ID 1153 (autoselect: 1 language: es)
Dec 03, 2018 10:22:53.533 [0x7fd533fff700] DEBUG - We're going to try to auto-select a subtitle.
Dec 03, 2018 10:22:53.533 [0x7fd533fff700] DEBUG - Audio Stream: 2231, Subtitle Stream: -1
Dec 03, 2018 10:22:53.556 [0x7fd54a7ff700] DEBUG - Completed: [192.168.1.10:55403] 200 GET /hubs/home/recentlyAdded?type=1&personal=1 (10 live) TLS GZIP Page 0-15 230ms 1876 bytes (pipelined: 2)
Dec 03, 2018 10:22:53.569 [0x7fd54a7ff700] DEBUG - Completed: [192.168.1.10:55405] 200 GET /hubs/home/onDeck (10 live) TLS GZIP Page 0-15 292ms 1482 bytes (pipelined: 1)
Dec 03, 2018 10:22:53.578 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:22:53.579 [0x7fd53d3ff700] DEBUG - Request: [192.168.1.10:55405 (Subnet)] GET /hubs/home/recentlyAdded?type=8 (10 live) TLS Page 0-15 GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:22:53.581 [0x7fd53c3fd700] DEBUG - Setting container serialization range to [0, 15] (total=-1)
Dec 03, 2018 10:22:53.592 [0x7fd53d3ff700] DEBUG - Setting container serialization range to [0, 15] (total=-1)
Dec 03, 2018 10:22:53.606 [0x7fd54a7ff700] DEBUG - Completed: [192.168.1.10:55404] 200 GET /hubs/home/continueWatching (10 live) TLS GZIP Page 0-15 333ms 1441 bytes (pipelined: 1)
Dec 03, 2018 10:22:53.631 [0x7fd5497fd700] WARN - SLOW QUERY: It took 360.000000 ms to retrieve 35 items.
Dec 03, 2018 10:22:53.672 [0x7fd53d3ff700] DEBUG - Setting container serialization range to [0, 15] (total=11)
Dec 03, 2018 10:22:53.688 [0x7fd5497fd700] DEBUG - Setting container serialization range to [0, 15] (total=-1)
Dec 03, 2018 10:22:53.688 [0x7fd54a7ff700] DEBUG - Completed: [192.168.1.10:55405] 200 GET /hubs/home/recentlyAdded?type=8 (10 live) TLS GZIP Page 0-15 109ms 1704 bytes (pipelined: 2)
Dec 03, 2018 10:22:53.714 [0x7fd53cbfe700] WARN - SLOW QUERY: It took 300.000000 ms to retrieve 48 items.
Dec 03, 2018 10:22:53.720 [0x7fd53cbfe700] DEBUG - Setting container serialization range to [0, 47] (total=200)
Dec 03, 2018 10:22:53.739 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:22:53.741 [0x7fd53bbfc700] DEBUG - Request: [192.168.1.10:55405 (Subnet)] GET /hubs/home/recentlyAdded?type=13 (10 live) TLS Page 0-15 GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:22:53.747 [0x7fd53bbfc700] DEBUG - Setting container serialization range to [0, 15] (total=-1)
Dec 03, 2018 10:22:53.756 [0x7fd549ffe700] DEBUG - Completed: [192.168.1.10:55405] 200 GET /hubs/home/recentlyAdded?type=13 (10 live) TLS GZIP Page 0-15 16ms 553 bytes (pipelined: 3)
Dec 03, 2018 10:22:53.761 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:22:53.762 [0x7fd533fff700] DEBUG - Request: [192.168.1.10:55405 (Subnet)] GET /library/sections/1/all?type=1&includeCollections=1 (10 live) TLS Page 0-153 GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:22:53.770 [0x7fd533fff700] DEBUG - Setting container serialization range to [0, 153] (total=-1)
Dec 03, 2018 10:22:53.802 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:22:53.804 [0x7fd53d3ff700] DEBUG - Request: [192.168.1.10:55403 (Subnet)] GET /library/sections/1/firstCharacter?type=1&includeCollections=1 (10 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:22:53.811 [0x7fd549ffe700] DEBUG - Completed: [192.168.1.10:55407] 200 GET /hubs/home/recentlyAdded?type=2 (10 live) TLS GZIP Page 0-15 471ms 1193 bytes (pipelined: 1)
Dec 03, 2018 10:22:53.854 [0x7fd549ffe700] DEBUG - Completed: [192.168.1.10:55406] 200 GET /hubs/home/recentlyAdded?type=1 (10 live) TLS GZIP Page 0-47 547ms 21040 bytes (pipelined: 1)
Dec 03, 2018 10:22:53.899 [0x7fd549ffe700] DEBUG - Completed: [192.168.1.10:55403] 200 GET /library/sections/1/firstCharacter?type=1&includeCollections=1 (10 live) TLS GZIP 96ms 835 bytes (pipelined: 3)
Dec 03, 2018 10:22:54.017 [0x7fd533fff700] DEBUG - It took 220.000000 ms to retrieve 154 items.
Dec 03, 2018 10:22:54.038 [0x7fd533fff700] DEBUG - Setting container serialization range to [0, 153] (total=173)
Dec 03, 2018 10:22:54.163 [0x7fd549ffe700] DEBUG - Completed: [192.168.1.10:55405] 200 GET /library/sections/1/all?type=1&includeCollections=1 (10 live) TLS GZIP Page 0-153 401ms 55392 bytes (pipelined: 4)
Dec 03, 2018 10:22:55.226 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:22:55.227 [0x7fd53c3fd700] DEBUG - Request: [192.168.1.10:55405 (Subnet)] GET /media/providers (10 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:22:55.245 [0x7fd549ffe700] DEBUG - Completed: [192.168.1.10:55405] 200 GET /media/providers (10 live) TLS GZIP 18ms 3028 bytes (pipelined: 5)
Dec 03, 2018 10:22:55.473 [0x7fd54a7ff700] DEBUG - EventSource: Got event [data] '<Message host="178.79.148.211" port="443" command="startRelay"/>'
Dec 03, 2018 10:22:55.473 [0x7fd54a7ff700] DEBUG - Relay: reused an existing key for https://downloads.plex.tv/relay/relay_v1.pub
Dec 03, 2018 10:22:55.474 [0x7fd54a7ff700] DEBUG - Relay: starting relay.
Dec 03, 2018 10:22:55.474 [0x7fd54a7ff700] DEBUG - Job running: PLEXTOKEN='xxxxxxxxxxxxxxxxxxxx' '/usr/lib/plexmediaserver/Plex Relay' '-p' '443' '-N' '-R' '0:localhost:32401' '-o' 'StrictHostKeyChecking=yes' '-o' 'UserKnownHostsFile=/config/Library/Application Support/Plex Media Server/Cache/relayHostKey.txt' '-o' 'NoneSwitch=yes' '-o' 'NoneEnabled=yes' '-o' 'LogLevel=VERBOSE' '-o' 'PreferredAuthentications=password' '-o' 'PubkeyAuthentication=no' '-l' 'a@gmail.com' '-F' '/dev/null' '178.79.148.211'
Dec 03, 2018 10:22:55.479 [0x7fd54a7ff700] DEBUG - Jobs: Starting child process with pid 522
Dec 03, 2018 10:22:56.145 [0x7fd53bbfc700] DEBUG - [PlexRelay] Authenticated to 178.79.148.211 ([178.79.148.211]:443).
Dec 03, 2018 10:22:56.164 [0x7fd5497fd700] DEBUG - Request: [127.0.0.1:58934 (Loopback)] GET /:/metadata/notify/cullTimeline?librarySectionID=1&sinceTime=1543849376 (12 live) GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:22:56.165 [0x7fd5497fd700] DEBUG - Asked to cull library timeline before time 1543849376, we're starting with 1 items.
Dec 03, 2018 10:22:56.165 [0x7fd5497fd700] DEBUG - Library timeline cull complete with 1 items left.
Dec 03, 2018 10:22:56.165 [0x7fd54a7ff700] DEBUG - Completed: [127.0.0.1:58934] 200 GET /:/metadata/notify/cullTimeline?librarySectionID=1&sinceTime=1543849376 (12 live) GZIP 1ms 166 bytes
Dec 03, 2018 10:22:56.394 [0x7fd53cbfe700] ERROR - [PlexRelay] kex protocol error: type 7 seq 11
Dec 03, 2018 10:22:56.565 [0x7fd533fff700] INFO - [PlexRelay] Allocated port 25549 for remote forward to localhost:32401
Dec 03, 2018 10:22:56.583 [0x7fd5433ff700] DEBUG - Jobs: '/usr/lib/plexmediaserver/Plex Media Scanner' exit code for process 515 is 0 (success)
Dec 03, 2018 10:22:56.631 [0x7fd5433ff700] DEBUG - Collections: Found 42 collections tags in section 1.
Dec 03, 2018 10:22:56.635 [0x7fd5433ff700] DEBUG - Collections: We had 45 collections in the library already.
Dec 03, 2018 10:22:56.635 [0x7fd5433ff700] DEBUG - Collections: Synced tags in section 1 in 46ms.
Dec 03, 2018 10:22:56.747 [0x7fd5433ff700] DEBUG - Collections: Refreshed attributes for 42 collections in section 1 in 112ms.
Dec 03, 2018 10:22:56.759 [0x7fd5433ff700] DEBUG - Collection: Refreshed visibility in section 1 in 11ms.
Dec 03, 2018 10:22:56.763 [0x7fd5337fe700] DEBUG - Activity: registered new activity ed8b88a6-fe64-419c-8c18-dd99965b585c - Processing subscriptions
Dec 03, 2018 10:22:56.771 [0x7fd53a3f9700] DEBUG - Activity: registered new activity 4ccf82e6-b154-416e-935d-7c1dcecb7f5d - Processing subscriptions
Dec 03, 2018 10:22:56.771 [0x7fd53a3f9700] DEBUG - DVR:Subscription: Scheduling subscriptions.
Dec 03, 2018 10:22:56.775 [0x7fd53a3f9700] DEBUG - DVR:Subscription: Initialized 0 schedulers.
Dec 03, 2018 10:22:56.776 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:22:56.776 [0x7fd53a3f9700] DEBUG - DVR:Subscription: Starting with 0 grabs, scheduled 0 active ones preemptively.
Dec 03, 2018 10:22:56.777 [0x7fd53a3f9700] DEBUG - DVR:Subscription: Scheduled all subscriptions in 5 ms.
Dec 03, 2018 10:22:56.777 [0x7fd53d3ff700] DEBUG - Request: [127.0.0.1:50456 (WAN)] GET /media/providers (15 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:22:56.777 [0x7fd53a3f9700] DEBUG - Activity: Ended activity 4ccf82e6-b154-416e-935d-7c1dcecb7f5d.
Dec 03, 2018 10:22:56.777 [0x7fd53a3f9700] DEBUG - DVR:Subscription: There are 0 active grabs at the end.
Dec 03, 2018 10:22:56.777 [0x7fd53a3f9700] DEBUG - Activity: Ended activity ed8b88a6-fe64-419c-8c18-dd99965b585c.
Dec 03, 2018 10:22:56.778 [0x7fd53a3f9700] DEBUG - DVR:Subscription: Refreshed all content in 12 ms.
Dec 03, 2018 10:22:56.786 [0x7fd54a7ff700] DEBUG - Completed: [127.0.0.1:50456] 200 GET /media/providers (15 live) TLS GZIP 9ms 3093 bytes (pipelined: 1)
Dec 03, 2018 10:22:56.890 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:22:56.891 [0x7fd53c3fd700] DEBUG - Request: [192.168.1.10:55405 (Subnet)] GET /library/sections (15 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:22:56.892 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:22:56.893 [0x7fd53bbfc700] DEBUG - Request: [192.168.1.10:55406 (Subnet)] GET /hubs/home/continueWatching (13 live) TLS Page 0-15 GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:22:56.904 [0x7fd54a7ff700] DEBUG - Completed: [192.168.1.10:55405] 200 GET /library/sections (13 live) TLS GZIP 13ms 1107 bytes (pipelined: 6)
Dec 03, 2018 10:22:56.906 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:22:56.906 [0x7fd5497fd700] DEBUG - Request: [192.168.1.10:55403 (Subnet)] GET /hubs/home/onDeck (13 live) TLS Page 0-15 GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:22:56.937 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:22:56.938 [0x7fd53cbfe700] DEBUG - Request: [192.168.1.10:55405 (Subnet)] GET /hubs/home/recentlyAdded?type=1 (11 live) TLS Page 0-47 GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:22:56.943 [0x7fd53cbfe700] DEBUG - Setting container serialization range to [0, 47] (total=-1)
Dec 03, 2018 10:22:56.949 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:22:56.950 [0x7fd533fff700] DEBUG - Request: [192.168.1.10:55404 (Subnet)] GET /hubs/home/recentlyAdded?type=2 (11 live) TLS Page 0-15 GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:22:56.969 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:22:56.968 [0x7fd5497fd700] DEBUG - Setting container serialization range to [0, 15] (total=-1)
Dec 03, 2018 10:22:56.971 [0x7fd53c3fd700] DEBUG - Request: [192.168.1.10:55407 (Subnet)] GET /hubs/home/recentlyAdded?type=1&personal=1 (11 live) TLS Page 0-15 GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:22:56.980 [0x7fd5497fd700] DEBUG - We're going to try to auto-select an audio stream for account 1.
Dec 03, 2018 10:22:56.985 [0x7fd5497fd700] DEBUG - Selecting best audio stream for part ID 1153 (autoselect: 1 language: es)
Dec 03, 2018 10:22:56.986 [0x7fd5497fd700] DEBUG - We're going to try to auto-select a subtitle.
Dec 03, 2018 10:22:56.986 [0x7fd5497fd700] DEBUG - Audio Stream: 2231, Subtitle Stream: -1
Dec 03, 2018 10:22:56.991 [0x7fd549ffe700] DEBUG - Completed: [192.168.1.10:55403] 200 GET /hubs/home/onDeck (11 live) TLS GZIP Page 0-15 84ms 1482 bytes (pipelined: 4)
Dec 03, 2018 10:22:56.997 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:22:56.984 [0x7fd53c3fd700] DEBUG - Setting container serialization range to [0, 15] (total=-1)
Dec 03, 2018 10:22:56.999 [0x7fd53d3ff700] DEBUG - Request: [192.168.1.10:55403 (Subnet)] GET /hubs/home/recentlyAdded?type=8 (11 live) TLS Page 0-15 GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:22:57.000 [0x7fd53bbfc700] DEBUG - Setting container serialization range to [0, 15] (total=-1)
Dec 03, 2018 10:22:57.007 [0x7fd54a7ff700] DEBUG - Completed: [192.168.1.10:55406] 200 GET /hubs/home/continueWatching (11 live) TLS GZIP Page 0-15 114ms 1441 bytes (pipelined: 2)
Dec 03, 2018 10:22:57.010 [0x7fd53d3ff700] DEBUG - Setting container serialization range to [0, 15] (total=-1)
Dec 03, 2018 10:22:57.015 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:22:57.016 [0x7fd532ffd700] DEBUG - Request: [192.168.1.10:55406 (Subnet)] GET /hubs/home/recentlyAdded?type=13 (11 live) TLS Page 0-15 GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:22:57.018 [0x7fd533fff700] DEBUG - It took 150.000000 ms to retrieve 35 items.
Dec 03, 2018 10:22:57.019 [0x7fd532ffd700] DEBUG - Setting container serialization range to [0, 15] (total=-1)
Dec 03, 2018 10:22:57.024 [0x7fd54a7ff700] DEBUG - Completed: [192.168.1.10:55406] 200 GET /hubs/home/recentlyAdded?type=13 (11 live) TLS GZIP Page 0-15 8ms 553 bytes (pipelined: 3)
Dec 03, 2018 10:22:57.035 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:22:57.036 [0x7fd532ffd700] DEBUG - Request: [192.168.1.10:55406 (Subnet)] GET /library/sections/1/all?type=1&includeCollections=1 (11 live) TLS Page 0-153 GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:22:57.039 [0x7fd532ffd700] DEBUG - Setting container serialization range to [0, 153] (total=-1)
Dec 03, 2018 10:22:57.040 [0x7fd53c3fd700] DEBUG - It took 70.000000 ms to retrieve 5 items.
Dec 03, 2018 10:22:57.042 [0x7fd53c3fd700] DEBUG - Setting container serialization range to [0, 15] (total=5)
Dec 03, 2018 10:22:57.053 [0x7fd53cbfe700] DEBUG - It took 180.000000 ms to retrieve 48 items.
Dec 03, 2018 10:22:57.061 [0x7fd54a7ff700] DEBUG - Completed: [192.168.1.10:55407] 200 GET /hubs/home/recentlyAdded?type=1&personal=1 (11 live) TLS GZIP Page 0-15 91ms 1876 bytes (pipelined: 2)
Dec 03, 2018 10:22:57.066 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:22:57.067 [0x7fd53bbfc700] DEBUG - Request: [192.168.1.10:55407 (Subnet)] GET /library/sections/1/firstCharacter?type=1&includeCollections=1 (11 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:22:57.067 [0x7fd533fff700] DEBUG - Setting container serialization range to [0, 15] (total=-1)
Dec 03, 2018 10:22:57.085 [0x7fd53cbfe700] DEBUG - Setting container serialization range to [0, 47] (total=200)
Dec 03, 2018 10:22:57.093 [0x7fd53d3ff700] DEBUG - It took 120.000000 ms to retrieve 11 items.
Dec 03, 2018 10:22:57.094 [0x7fd53d3ff700] DEBUG - Setting container serialization range to [0, 15] (total=11)
Dec 03, 2018 10:22:57.112 [0x7fd54a7ff700] DEBUG - Completed: [192.168.1.10:55404] 200 GET /hubs/home/recentlyAdded?type=2 (11 live) TLS GZIP Page 0-15 161ms 1193 bytes (pipelined: 2)
Dec 03, 2018 10:22:57.125 [0x7fd54a7ff700] DEBUG - Completed: [192.168.1.10:55403] 200 GET /hubs/home/recentlyAdded?type=8 (11 live) TLS GZIP Page 0-15 127ms 1704 bytes (pipelined: 5)
Dec 03, 2018 10:22:57.138 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:22:57.139 [0x7fd53c3fd700] DEBUG - Request: [192.168.1.10:55403 (Subnet)] GET /media/providers (11 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:22:57.148 [0x7fd54a7ff700] DEBUG - Completed: [192.168.1.10:55403] 200 GET /media/providers (11 live) TLS GZIP 9ms 3022 bytes (pipelined: 6)
Dec 03, 2018 10:22:57.156 [0x7fd54a7ff700] DEBUG - Completed: [192.168.1.10:55407] 200 GET /library/sections/1/firstCharacter?type=1&includeCollections=1 (11 live) TLS GZIP 89ms 835 bytes (pipelined: 3)
Dec 03, 2018 10:22:57.172 [0x7fd54a7ff700] DEBUG - Completed: [192.168.1.10:55405] 200 GET /hubs/home/recentlyAdded?type=1 (11 live) TLS GZIP Page 0-47 234ms 21040 bytes (pipelined: 7)
Dec 03, 2018 10:22:57.267 [0x7fd532ffd700] DEBUG - It took 160.000000 ms to retrieve 154 items.
Dec 03, 2018 10:22:57.277 [0x7fd532ffd700] DEBUG - Setting container serialization range to [0, 153] (total=173)
Dec 03, 2018 10:22:57.380 [0x7fd54a7ff700] DEBUG - Completed: [192.168.1.10:55406] 200 GET /library/sections/1/all?type=1&includeCollections=1 (11 live) TLS GZIP Page 0-153 343ms 55392 bytes (pipelined: 4)
Dec 03, 2018 10:23:12.982 [0x7fd54a7ff700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:23:13.091 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:23:13.093 [0x7fd5497fd700] DEBUG - Request: [192.168.1.10:55405 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (10 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:23:13.098 [0x7fd5497fd700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:23:33.097 [0x7fd54a7ff700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:23:33.197 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:23:33.200 [0x7fd5497fd700] DEBUG - Request: [192.168.1.10:55415 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:23:33.205 [0x7fd5497fd700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:23:53.204 [0x7fd54a7ff700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:23:53.348 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:23:53.351 [0x7fd532ffd700] DEBUG - Request: [192.168.1.10:55418 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:23:53.356 [0x7fd532ffd700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:23:55.413 [0x7fd5373f3700] INFO - Library section 1 (Películas) will be updated because of a change in /data/movies/peliculas/piniculas
Dec 03, 2018 10:24:00.419 [0x7fd545ffc700] DEBUG - Library Updater: Requested that section 1 be updated, force=0, deep=0, subdir=/data/movies/peliculas/piniculas iTunes=0
Dec 03, 2018 10:24:00.420 [0x7fd545ffc700] DEBUG - Library Updater: Queueing section 1
Dec 03, 2018 10:24:00.426 [0x7fd53cbfe700] DEBUG - Scanning section 1
Dec 03, 2018 10:24:00.426 [0x7fd53cbfe700] DEBUG - Killing job.
Dec 03, 2018 10:24:00.426 [0x7fd53cbfe700] DEBUG - Signalling job ID 515 with 9
Dec 03, 2018 10:24:00.427 [0x7fd53cbfe700] DEBUG - Job running: EAE_ROOT='/tmp/pms-b010e6ce-5dd7-43d3-ae68-444aba69332b/EasyAudioEncoder' FFMPEG_EXTERNAL_LIBS='/config/Library/Application\ Support/Plex\ Media\ Server/Codecs/531e313-1328-linux-ubuntu-x86_64/' X_PLEX_TOKEN='xxxxxxxxxxxxxxxxxxxx' '/usr/lib/plexmediaserver/Plex Media Scanner' '--scan' '--refresh' '--section' '1' '--directory' '/data/movies/peliculas/piniculas'
Dec 03, 2018 10:24:00.433 [0x7fd53cbfe700] DEBUG - Jobs: Starting child process with pid 530
Dec 03, 2018 10:24:00.531 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:24:00.533 [0x7fd5497fd700] DEBUG - Request: [192.168.1.10:55434 (Subnet)] GET /library/sections (6 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:24:00.547 [0x7fd54a7ff700] DEBUG - Completed: [192.168.1.10:55434] 200 GET /library/sections (7 live) TLS GZIP 14ms 1111 bytes (pipelined: 1)
Dec 03, 2018 10:24:00.559 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:24:00.559 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:24:00.560 [0x7fd532ffd700] DEBUG - Request: [192.168.1.10:55435 (Subnet)] GET /hubs/home/continueWatching (7 live) TLS Page 0-15 GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:24:00.561 [0x7fd5497fd700] DEBUG - Request: [192.168.1.10:55434 (Subnet)] GET /hubs/home/onDeck (7 live) TLS Page 0-15 GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:24:00.584 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:24:00.586 [0x7fd53bbfc700] DEBUG - Request: [192.168.1.10:55436 (Subnet)] GET /hubs/home/recentlyAdded?type=1 (9 live) TLS Page 0-47 GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:24:00.593 [0x7fd53bbfc700] DEBUG - Setting container serialization range to [0, 47] (total=-1)
Dec 03, 2018 10:24:00.597 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:24:00.599 [0x7fd53c3fd700] DEBUG - Request: [192.168.1.10:55437 (Subnet)] GET /hubs/home/recentlyAdded?type=2 (10 live) TLS Page 0-15 GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:24:00.605 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:24:00.606 [0x7fd53d3ff700] DEBUG - Request: [192.168.1.10:55438 (Subnet)] GET /hubs/home/recentlyAdded?type=1&personal=1 (10 live) TLS Page 0-15 GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:24:00.611 [0x7fd53d3ff700] DEBUG - Setting container serialization range to [0, 15] (total=-1)
Dec 03, 2018 10:24:00.627 [0x7fd5497fd700] DEBUG - Setting container serialization range to [0, 15] (total=-1)
Dec 03, 2018 10:24:00.630 [0x7fd5497fd700] DEBUG - We're going to try to auto-select an audio stream for account 1.
Dec 03, 2018 10:24:00.630 [0x7fd5497fd700] DEBUG - Selecting best audio stream for part ID 1153 (autoselect: 1 language: es)
Dec 03, 2018 10:24:00.630 [0x7fd5497fd700] DEBUG - We're going to try to auto-select a subtitle.
Dec 03, 2018 10:24:00.630 [0x7fd5497fd700] DEBUG - Audio Stream: 2231, Subtitle Stream: -1
Dec 03, 2018 10:24:00.631 [0x7fd532ffd700] DEBUG - Setting container serialization range to [0, 15] (total=-1)
Dec 03, 2018 10:24:00.637 [0x7fd549ffe700] DEBUG - Completed: [192.168.1.10:55434] 200 GET /hubs/home/onDeck (10 live) TLS GZIP Page 0-15 76ms 1482 bytes (pipelined: 2)
Dec 03, 2018 10:24:00.638 [0x7fd54a7ff700] DEBUG - Completed: [192.168.1.10:55435] 200 GET /hubs/home/continueWatching (10 live) TLS GZIP Page 0-15 78ms 1441 bytes (pipelined: 1)
Dec 03, 2018 10:24:00.641 [0x7fd53c3fd700] DEBUG - It took 90.000000 ms to retrieve 35 items.
Dec 03, 2018 10:24:00.642 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:24:00.641 [0x7fd53d3ff700] DEBUG - Setting container serialization range to [0, 15] (total=5)
Dec 03, 2018 10:24:00.644 [0x7fd539bf8700] DEBUG - Request: [192.168.1.10:55434 (Subnet)] GET /hubs/home/recentlyAdded?type=8 (10 live) TLS Page 0-15 GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:24:00.645 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:24:00.645 [0x7fd5497fd700] DEBUG - Request: [192.168.1.10:55435 (Subnet)] GET /hubs/home/recentlyAdded?type=13 (10 live) TLS Page 0-15 GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:24:00.647 [0x7fd539bf8700] DEBUG - Setting container serialization range to [0, 15] (total=-1)
Dec 03, 2018 10:24:00.648 [0x7fd5497fd700] DEBUG - Setting container serialization range to [0, 15] (total=-1)
Dec 03, 2018 10:24:00.653 [0x7fd54a7ff700] DEBUG - Completed: [192.168.1.10:55435] 200 GET /hubs/home/recentlyAdded?type=13 (10 live) TLS GZIP Page 0-15 7ms 553 bytes (pipelined: 2)
Dec 03, 2018 10:24:00.660 [0x7fd54a7ff700] DEBUG - Completed: [192.168.1.10:55438] 200 GET /hubs/home/recentlyAdded?type=1&personal=1 (10 live) TLS GZIP Page 0-15 55ms 1876 bytes (pipelined: 1)
Dec 03, 2018 10:24:00.662 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:24:00.662 [0x7fd532ffd700] DEBUG - Request: [192.168.1.10:55435 (Subnet)] GET /library/sections/1/all?type=1&includeCollections=1 (10 live) TLS Page 0-153 GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:24:00.665 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:24:00.666 [0x7fd532ffd700] DEBUG - Setting container serialization range to [0, 153] (total=-1)
Dec 03, 2018 10:24:00.666 [0x7fd5497fd700] DEBUG - Request: [192.168.1.10:55438 (Subnet)] GET /library/sections/1/firstCharacter?type=1&includeCollections=1 (10 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:24:00.675 [0x7fd539bf8700] DEBUG - It took 60.000000 ms to retrieve 11 items.
Dec 03, 2018 10:24:00.676 [0x7fd539bf8700] DEBUG - Setting container serialization range to [0, 15] (total=11)
Dec 03, 2018 10:24:00.681 [0x7fd53c3fd700] DEBUG - Setting container serialization range to [0, 15] (total=-1)
Dec 03, 2018 10:24:00.697 [0x7fd54a7ff700] DEBUG - Completed: [192.168.1.10:55434] 200 GET /hubs/home/recentlyAdded?type=8 (10 live) TLS GZIP Page 0-15 53ms 1704 bytes (pipelined: 3)
Dec 03, 2018 10:24:00.715 [0x7fd54a7ff700] DEBUG - Completed: [192.168.1.10:55438] 200 GET /library/sections/1/firstCharacter?type=1&includeCollections=1 (10 live) TLS GZIP 49ms 835 bytes (pipelined: 2)
Dec 03, 2018 10:24:00.731 [0x7fd53bbfc700] WARN - SLOW QUERY: It took 280.000000 ms to retrieve 48 items.
Dec 03, 2018 10:24:00.736 [0x7fd53bbfc700] DEBUG - Setting container serialization range to [0, 47] (total=200)
Dec 03, 2018 10:24:00.739 [0x7fd54a7ff700] DEBUG - Completed: [192.168.1.10:55437] 200 GET /hubs/home/recentlyAdded?type=2 (10 live) TLS GZIP Page 0-15 141ms 1193 bytes (pipelined: 1)
Dec 03, 2018 10:24:00.783 [0x7fd54a7ff700] DEBUG - Completed: [192.168.1.10:55436] 200 GET /hubs/home/recentlyAdded?type=1 (10 live) TLS GZIP Page 0-47 197ms 21040 bytes (pipelined: 1)
Dec 03, 2018 10:24:00.847 [0x7fd532ffd700] DEBUG - It took 230.000000 ms to retrieve 154 items.
Dec 03, 2018 10:24:00.857 [0x7fd532ffd700] DEBUG - Setting container serialization range to [0, 153] (total=173)
Dec 03, 2018 10:24:00.953 [0x7fd54a7ff700] DEBUG - Completed: [192.168.1.10:55435] 200 GET /library/sections/1/all?type=1&includeCollections=1 (10 live) TLS GZIP Page 0-153 290ms 55392 bytes (pipelined: 3)
Dec 03, 2018 10:24:01.873 [0x7fd533fff700] DEBUG - Request: [127.0.0.1:58942 (Loopback)] GET /:/metadata/notify/cullTimeline?librarySectionID=1&sinceTime=1543849441 (11 live) GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:24:01.874 [0x7fd533fff700] DEBUG - Asked to cull library timeline before time 1543849441, we're starting with 1 items.
Dec 03, 2018 10:24:01.874 [0x7fd533fff700] DEBUG - Library timeline cull complete with 1 items left.
Dec 03, 2018 10:24:01.875 [0x7fd54a7ff700] DEBUG - Completed: [127.0.0.1:58942] 200 GET /:/metadata/notify/cullTimeline?librarySectionID=1&sinceTime=1543849441 (11 live) GZIP 2ms 166 bytes
Dec 03, 2018 10:24:02.230 [0x7fd5433ff700] DEBUG - Jobs: '/usr/lib/plexmediaserver/Plex Media Scanner' exit code for process 530 is 0 (success)
Dec 03, 2018 10:24:02.247 [0x7fd5433ff700] DEBUG - Collections: Found 42 collections tags in section 1.
Dec 03, 2018 10:24:02.249 [0x7fd5433ff700] DEBUG - Collections: We had 45 collections in the library already.
Dec 03, 2018 10:24:02.250 [0x7fd5433ff700] DEBUG - Collections: Synced tags in section 1 in 6ms.
Dec 03, 2018 10:24:02.341 [0x7fd5433ff700] DEBUG - Collections: Refreshed attributes for 42 collections in section 1 in 90ms.
Dec 03, 2018 10:24:02.359 [0x7fd5433ff700] DEBUG - Collection: Refreshed visibility in section 1 in 18ms.
Dec 03, 2018 10:24:02.361 [0x7fd53cbfe700] DEBUG - Activity: registered new activity b9b7eee0-97a2-47ea-b157-ec25cabc00d0 - Processing subscriptions
Dec 03, 2018 10:24:02.373 [0x7fd546ffe700] DEBUG - Activity: registered new activity 153f464e-41b2-4ad0-8f55-4563dff17f4a - Processing subscriptions
Dec 03, 2018 10:24:02.373 [0x7fd546ffe700] DEBUG - DVR:Subscription: Scheduling subscriptions.
Dec 03, 2018 10:24:02.375 [0x7fd546ffe700] DEBUG - DVR:Subscription: Initialized 0 schedulers.
Dec 03, 2018 10:24:02.375 [0x7fd546ffe700] DEBUG - DVR:Subscription: Starting with 0 grabs, scheduled 0 active ones preemptively.
Dec 03, 2018 10:24:02.375 [0x7fd546ffe700] DEBUG - DVR:Subscription: Scheduled all subscriptions in 1 ms.
Dec 03, 2018 10:24:02.375 [0x7fd546ffe700] DEBUG - Activity: Ended activity 153f464e-41b2-4ad0-8f55-4563dff17f4a.
Dec 03, 2018 10:24:02.375 [0x7fd546ffe700] DEBUG - DVR:Subscription: There are 0 active grabs at the end.
Dec 03, 2018 10:24:02.375 [0x7fd546ffe700] DEBUG - Activity: Ended activity b9b7eee0-97a2-47ea-b157-ec25cabc00d0.
Dec 03, 2018 10:24:02.376 [0x7fd546ffe700] DEBUG - DVR:Subscription: Refreshed all content in 13 ms.
Dec 03, 2018 10:24:02.449 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:24:02.450 [0x7fd539bf8700] DEBUG - Request: [192.168.1.10:55435 (Subnet)] GET /library/sections (11 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:24:02.461 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:24:02.463 [0x7fd5497fd700] DEBUG - Request: [192.168.1.10:55436 (Subnet)] GET /hubs/home/continueWatching (11 live) TLS Page 0-15 GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:24:02.473 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:24:02.474 [0x7fd549ffe700] DEBUG - Completed: [192.168.1.10:55435] 200 GET /library/sections (11 live) TLS GZIP 24ms 1107 bytes (pipelined: 4)
Dec 03, 2018 10:24:02.474 [0x7fd53d3ff700] DEBUG - Request: [192.168.1.10:55438 (Subnet)] GET /hubs/home/onDeck (11 live) TLS Page 0-15 GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:24:02.476 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:24:02.477 [0x7fd53c3fd700] DEBUG - Request: [192.168.1.10:55434 (Subnet)] GET /hubs/home/recentlyAdded?type=1 (11 live) TLS Page 0-47 GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:24:02.480 [0x7fd53c3fd700] DEBUG - Setting container serialization range to [0, 47] (total=-1)
Dec 03, 2018 10:24:02.482 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:24:02.483 [0x7fd53bbfc700] DEBUG - Request: [192.168.1.10:55437 (Subnet)] GET /hubs/home/recentlyAdded?type=2 (11 live) TLS Page 0-15 GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:24:02.498 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:24:02.499 [0x7fd532ffd700] DEBUG - Request: [192.168.1.10:55435 (Subnet)] GET /hubs/home/recentlyAdded?type=1&personal=1 (11 live) TLS Page 0-15 GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:24:02.503 [0x7fd532ffd700] DEBUG - Setting container serialization range to [0, 15] (total=-1)
Dec 03, 2018 10:24:02.522 [0x7fd532ffd700] DEBUG - Setting container serialization range to [0, 15] (total=5)
Dec 03, 2018 10:24:02.524 [0x7fd5497fd700] DEBUG - Setting container serialization range to [0, 15] (total=-1)
Dec 03, 2018 10:24:02.530 [0x7fd549ffe700] DEBUG - Completed: [192.168.1.10:55436] 200 GET /hubs/home/continueWatching (10 live) TLS GZIP Page 0-15 67ms 1441 bytes (pipelined: 2)
Dec 03, 2018 10:24:02.531 [0x7fd53bbfc700] DEBUG - It took 160.000000 ms to retrieve 35 items.
Dec 03, 2018 10:24:02.534 [0x7fd53d3ff700] DEBUG - Setting container serialization range to [0, 15] (total=-1)
Dec 03, 2018 10:24:02.537 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:24:02.537 [0x7fd539bf8700] DEBUG - Request: [192.168.1.10:55436 (Subnet)] GET /hubs/home/recentlyAdded?type=8 (10 live) TLS Page 0-15 GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:24:02.537 [0x7fd53d3ff700] DEBUG - We're going to try to auto-select an audio stream for account 1.
Dec 03, 2018 10:24:02.538 [0x7fd53d3ff700] DEBUG - Selecting best audio stream for part ID 1153 (autoselect: 1 language: es)
Dec 03, 2018 10:24:02.538 [0x7fd53d3ff700] DEBUG - We're going to try to auto-select a subtitle.
Dec 03, 2018 10:24:02.538 [0x7fd53d3ff700] DEBUG - Audio Stream: 2231, Subtitle Stream: -1
Dec 03, 2018 10:24:02.538 [0x7fd549ffe700] DEBUG - Completed: [192.168.1.10:55435] 200 GET /hubs/home/recentlyAdded?type=1&personal=1 (10 live) TLS GZIP Page 0-15 39ms 1876 bytes (pipelined: 5)
Dec 03, 2018 10:24:02.541 [0x7fd539bf8700] DEBUG - Setting container serialization range to [0, 15] (total=-1)
Dec 03, 2018 10:24:02.543 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:24:02.544 [0x7fd533fff700] DEBUG - Request: [192.168.1.10:55435 (Subnet)] GET /hubs/home/recentlyAdded?type=13 (10 live) TLS Page 0-15 GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:24:02.545 [0x7fd549ffe700] DEBUG - Completed: [192.168.1.10:55438] 200 GET /hubs/home/onDeck (10 live) TLS GZIP Page 0-15 70ms 1482 bytes (pipelined: 3)
Dec 03, 2018 10:24:02.547 [0x7fd533fff700] DEBUG - Setting container serialization range to [0, 15] (total=-1)
Dec 03, 2018 10:24:02.550 [0x7fd53bbfc700] DEBUG - It took 60.000000 ms to retrieve 5 items.
Dec 03, 2018 10:24:02.550 [0x7fd53c3fd700] WARN - SLOW QUERY: It took 210.000000 ms to retrieve 48 items.
Dec 03, 2018 10:24:02.551 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:24:02.552 [0x7fd532ffd700] DEBUG - Request: [192.168.1.10:55438 (Subnet)] GET /library/sections/1/all?type=1&includeCollections=1 (10 live) TLS Page 0-153 GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:24:02.552 [0x7fd54a7ff700] DEBUG - Completed: [192.168.1.10:55435] 200 GET /hubs/home/recentlyAdded?type=13 (10 live) TLS GZIP Page 0-15 8ms 553 bytes (pipelined: 6)
Dec 03, 2018 10:24:02.555 [0x7fd53c3fd700] DEBUG - Setting container serialization range to [0, 47] (total=200)
Dec 03, 2018 10:24:02.556 [0x7fd532ffd700] DEBUG - Setting container serialization range to [0, 153] (total=-1)
Dec 03, 2018 10:24:02.558 [0x7fd53bbfc700] DEBUG - Setting container serialization range to [0, 15] (total=-1)
Dec 03, 2018 10:24:02.560 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:24:02.561 [0x7fd5497fd700] DEBUG - Request: [192.168.1.10:55435 (Subnet)] GET /library/sections/1/firstCharacter?type=1&includeCollections=1 (10 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:24:02.577 [0x7fd539bf8700] DEBUG - It took 80.000000 ms to retrieve 11 items.
Dec 03, 2018 10:24:02.579 [0x7fd539bf8700] DEBUG - Setting container serialization range to [0, 15] (total=11)
Dec 03, 2018 10:24:02.588 [0x7fd549ffe700] DEBUG - Completed: [192.168.1.10:55436] 200 GET /hubs/home/recentlyAdded?type=8 (10 live) TLS GZIP Page 0-15 50ms 1704 bytes (pipelined: 3)
Dec 03, 2018 10:24:02.604 [0x7fd54a7ff700] DEBUG - Completed: [192.168.1.10:55437] 200 GET /hubs/home/recentlyAdded?type=2 (10 live) TLS GZIP Page 0-15 121ms 1193 bytes (pipelined: 2)
Dec 03, 2018 10:24:02.606 [0x7fd549ffe700] DEBUG - Completed: [192.168.1.10:55434] 200 GET /hubs/home/recentlyAdded?type=1 (10 live) TLS GZIP Page 0-47 129ms 21040 bytes (pipelined: 4)
Dec 03, 2018 10:24:02.614 [0x7fd549ffe700] DEBUG - Completed: [192.168.1.10:55435] 200 GET /library/sections/1/firstCharacter?type=1&includeCollections=1 (10 live) TLS GZIP 53ms 835 bytes (pipelined: 7)
Dec 03, 2018 10:24:02.693 [0x7fd532ffd700] DEBUG - It took 150.000000 ms to retrieve 154 items.
Dec 03, 2018 10:24:02.702 [0x7fd532ffd700] DEBUG - Setting container serialization range to [0, 153] (total=173)
Dec 03, 2018 10:24:02.738 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:24:02.739 [0x7fd53d3ff700] DEBUG - Request: [192.168.1.10:55435 (Subnet)] GET /media/providers (10 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:24:02.753 [0x7fd54a7ff700] DEBUG - Completed: [192.168.1.10:55435] 200 GET /media/providers (10 live) TLS GZIP 15ms 3022 bytes (pipelined: 8)
Dec 03, 2018 10:24:02.795 [0x7fd54a7ff700] DEBUG - Completed: [192.168.1.10:55438] 200 GET /library/sections/1/all?type=1&includeCollections=1 (10 live) TLS GZIP Page 0-153 243ms 55392 bytes (pipelined: 4)
Dec 03, 2018 10:24:03.060 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:24:03.061 [0x7fd533fff700] DEBUG - Request: [127.0.0.1:50460 (WAN)] GET /media/providers (11 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:24:03.076 [0x7fd54a7ff700] DEBUG - Completed: [127.0.0.1:50460] 200 GET /media/providers (11 live) TLS GZIP 15ms 3093 bytes (pipelined: 1)
Dec 03, 2018 10:24:13.356 [0x7fd54a7ff700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:24:13.433 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:24:13.435 [0x7fd539bf8700] DEBUG - Request: [192.168.1.10:55435 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (10 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:24:13.440 [0x7fd539bf8700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:24:33.440 [0x7fd54a7ff700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:24:33.481 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:24:33.483 [0x7fd533fff700] DEBUG - Request: [192.168.1.10:55445 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:24:33.487 [0x7fd533fff700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:24:53.487 [0x7fd549ffe700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:24:53.523 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:24:53.526 [0x7fd533fff700] DEBUG - Request: [192.168.1.10:55449 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:24:53.531 [0x7fd533fff700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:25:13.530 [0x7fd54a7ff700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:25:13.854 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:25:13.857 [0x7fd533fff700] DEBUG - Request: [192.168.1.10:55452 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:25:13.862 [0x7fd533fff700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:25:33.862 [0x7fd549ffe700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:25:33.927 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:25:33.930 [0x7fd533fff700] DEBUG - Request: [192.168.1.10:55455 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:25:33.935 [0x7fd533fff700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:25:53.932 [0x7fd549ffe700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:25:53.995 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:25:53.996 [0x7fd539bf8700] DEBUG - Request: [192.168.1.10:55458 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:25:53.998 [0x7fd539bf8700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:26:14.000 [0x7fd549ffe700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:26:14.103 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:26:14.105 [0x7fd533fff700] DEBUG - Request: [192.168.1.10:55463 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:26:14.107 [0x7fd533fff700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:26:34.108 [0x7fd54a7ff700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:26:34.187 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:26:34.190 [0x7fd533fff700] DEBUG - Request: [192.168.1.10:55483 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:26:34.194 [0x7fd533fff700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:26:54.193 [0x7fd54a7ff700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:26:54.304 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:26:54.306 [0x7fd539bf8700] DEBUG - Request: [192.168.1.10:55488 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:26:54.309 [0x7fd539bf8700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:27:14.309 [0x7fd54a7ff700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:27:14.359 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:27:14.361 [0x7fd533fff700] DEBUG - Request: [192.168.1.10:55494 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:27:14.363 [0x7fd533fff700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:27:34.364 [0x7fd54a7ff700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:27:34.433 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:27:34.436 [0x7fd539bf8700] DEBUG - Request: [192.168.1.10:55498 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:27:34.441 [0x7fd539bf8700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:27:54.441 [0x7fd549ffe700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:27:54.482 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:27:54.484 [0x7fd539bf8700] DEBUG - Request: [192.168.1.10:55524 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:27:54.486 [0x7fd539bf8700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:28:14.487 [0x7fd54a7ff700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:28:14.566 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:28:14.568 [0x7fd533fff700] DEBUG - Request: [192.168.1.10:55557 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:28:14.570 [0x7fd533fff700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:28:34.571 [0x7fd549ffe700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:28:34.626 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:28:34.628 [0x7fd539bf8700] DEBUG - Request: [192.168.1.10:55583 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:28:34.629 [0x7fd539bf8700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:28:54.631 [0x7fd549ffe700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:28:54.741 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:28:54.744 [0x7fd533fff700] DEBUG - Request: [192.168.1.10:55593 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:28:54.748 [0x7fd533fff700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:29:14.748 [0x7fd549ffe700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:29:14.821 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:29:14.824 [0x7fd539bf8700] DEBUG - Request: [192.168.1.10:55605 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:29:14.827 [0x7fd539bf8700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:29:23.658 [0x7fd533fff700] DEBUG - [PlexRelay] Transferred: sent 18136, received 7224 bytes, in 387.5 seconds
Dec 03, 2018 10:29:23.664 [0x7fd539bf8700] DEBUG - [PlexRelay] Bytes per second: sent 46.8, received 18.6
Dec 03, 2018 10:29:23.677 [0x7fd5433ff700] DEBUG - Jobs: '/usr/lib/plexmediaserver/Plex Relay' exit code for process 522 is 255 (failure)
Dec 03, 2018 10:29:34.828 [0x7fd54a7ff700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:29:34.879 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:29:34.881 [0x7fd533fff700] DEBUG - Request: [192.168.1.10:55665 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:29:34.884 [0x7fd533fff700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:29:54.885 [0x7fd54a7ff700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:29:54.949 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:29:54.952 [0x7fd539bf8700] DEBUG - Request: [192.168.1.10:55671 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:29:54.956 [0x7fd539bf8700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:30:14.956 [0x7fd549ffe700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:30:15.063 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:30:15.064 [0x7fd533fff700] DEBUG - Request: [192.168.1.10:55687 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:30:15.066 [0x7fd533fff700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:30:35.067 [0x7fd549ffe700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:30:35.159 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:30:35.162 [0x7fd533fff700] DEBUG - Request: [192.168.1.10:55698 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:30:35.167 [0x7fd533fff700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:30:55.167 [0x7fd549ffe700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:30:55.331 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:30:55.334 [0x7fd539bf8700] DEBUG - Request: [192.168.1.10:55701 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:30:55.339 [0x7fd539bf8700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:31:04.044 [0x7fd546ffe700] DEBUG - Sync: uploadStatus
Dec 03, 2018 10:31:15.339 [0x7fd549ffe700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:31:15.386 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:31:15.387 [0x7fd544fff700] DEBUG - Auth: Refreshing tokens inside the token-based authentication filter.
Dec 03, 2018 10:31:15.389 [0x7fd539bf8700] DEBUG - Request: [192.168.1.10:55706 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:31:15.391 [0x7fd539bf8700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:31:15.394 [0x7fd544fff700] DEBUG - HTTP requesting GET https://plex.tv/servers/e7f44c013808a4bef0c9631d075fbb02c00bf13b/access_tokens.xml?auth_token=xxxxxxxxxxxxxxxxxxxx&includeProfiles=1&includeProviders=1
Dec 03, 2018 10:31:15.759 [0x7fd544fff700] DEBUG - HTTP 200 response from GET https://plex.tv/servers/e7f44c013808a4bef0c9631d075fbb02c00bf13b/access_tokens.xml?auth_token=xxxxxxxxxxxxxxxxxxxx&includeProfiles=1&includeProviders=1
Dec 03, 2018 10:31:15.782 [0x7fd544fff700] DEBUG - MyPlex: updating with 26 access tokens
Dec 03, 2018 10:31:15.786 [0x7fd546ffe700] DEBUG - HTTP requesting GET https://plex.tv/media/providers?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Dec 03, 2018 10:31:16.059 [0x7fd546ffe700] DEBUG - HTTP 200 response from GET https://plex.tv/media/providers?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Dec 03, 2018 10:31:28.965 [0x7fd536bf2700] DEBUG - Putting plug-in com.plexapp.agents.imdb to sleep.
Dec 03, 2018 10:31:28.966 [0x7fd536bf2700] DEBUG - Stopping [com.plexapp.agents.imdb].
Dec 03, 2018 10:31:28.966 [0x7fd536bf2700] DEBUG - [com.plexapp.agents.imdb] Killing.
Dec 03, 2018 10:31:35.393 [0x7fd549ffe700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:31:35.511 [0x7fd54a7ff700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:31:35.514 [0x7fd539bf8700] DEBUG - Request: [192.168.1.10:55712 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:31:35.518 [0x7fd539bf8700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:31:38.972 [0x7fd536bf2700] DEBUG - Stopping file watcher for com.plexapp.agents.imdb
Dec 03, 2018 10:31:55.518 [0x7fd54a7ff700] DEBUG - handleStreamRead code 335544539: short read
Dec 03, 2018 10:31:55.633 [0x7fd549ffe700] DEBUG - Auth: authenticated user 1 as a@gmail.com
Dec 03, 2018 10:31:55.636 [0x7fd533fff700] DEBUG - Request: [192.168.1.10:55719 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=1&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (5 live) TLS GZIP Signed-in Token (a@gmail.com)
Dec 03, 2018 10:31:55.640 [0x7fd533fff700] DEBUG - Beginning read from two-way stream.
Dec 03, 2018 10:32:12.362 [0x7fd558eec840] DEBUG - Shutting down with signal 15
Dec 03, 2018 10:32:12.362 [0x7fd558eec840] DEBUG - Ordered to stop server.
Dec 03, 2018 10:32:12.370 [0x7fd558eec840] WARN - Timed out waiting for server to finish.
Dec 03, 2018 10:32:12.370 [0x7fd558eec840] DEBUG - Stopping server...
Dec 03, 2018 10:32:12.370 [0x7fd558eec840] DEBUG - HttpServer: Stopping server.
Dec 03, 2018 10:32:12.371 [0x7fd53effe700] DEBUG - MetadataItemClusterRequestHandler: a shutdown event has been received
Dec 03, 2018 10:32:12.375 [0x7fd53effe700] DEBUG - TranscodeJobManager: [Running] onServerShutdown
Dec 03, 2018 10:32:12.375 [0x7fd53effe700] DEBUG - TranscodeJobManager: [Running] -> [Shutdown]
Dec 03, 2018 10:32:12.377 [0x7fd558eec840] DEBUG - Server stopped.
Dec 03, 2018 10:32:12.377 [0x7fd558eec840] DEBUG - NetworkService: Stopping advertisement.
Dec 03, 2018 10:32:12.377 [0x7fd558eec840] DEBUG - Killing plug-ins.
Dec 03, 2018 10:32:12.377 [0x7fd558eec840] DEBUG - [com.plexapp.system] Killing.
Dec 03, 2018 10:32:12.377 [0x7fd558eec840] DEBUG - Waiting for Plex Tuner Service to exit.
Dec 03, 2018 10:32:12.504 [0x7fd5433ff700] DEBUG - Jobs: '/usr/lib/plexmediaserver/Plex Tuner Service' exit code for process 366 is 0 (success)
Dec 03, 2018 10:32:12.505 [0x7fd53f7ff700] DEBUG - Plex Tuner Service exited.
Dec 03, 2018 10:32:12.513 [0x7fd558eec840] DEBUG - Killing job.
Dec 03, 2018 10:32:12.513 [0x7fd558eec840] DEBUG - Signalling job ID 530 with 9
Dec 03, 2018 10:32:12.514 [0x7fd558eec840] DEBUG - Database: Shutting down.
Dec 03, 2018 10:32:12.514 [0x7fd558eec840] DEBUG - Captured session 0.
Dec 03, 2018 10:32:12.514 [0x7fd558eec840] DEBUG - Captured session 1.
Dec 03, 2018 10:32:12.514 [0x7fd558eec840] DEBUG - Captured session 2.
Dec 03, 2018 10:32:12.514 [0x7fd558eec840] DEBUG - Captured session 3.
Dec 03, 2018 10:32:12.514 [0x7fd558eec840] DEBUG - Captured session 4.
Dec 03, 2018 10:32:12.514 [0x7fd558eec840] DEBUG - Captured session 5.
Dec 03, 2018 10:32:12.514 [0x7fd558eec840] DEBUG - Captured session 6.
Dec 03, 2018 10:32:12.514 [0x7fd558eec840] DEBUG - Captured session 7.
Dec 03, 2018 10:32:12.514 [0x7fd558eec840] DEBUG - Captured session 8.
Dec 03, 2018 10:32:12.514 [0x7fd558eec840] DEBUG - Captured session 9.
Dec 03, 2018 10:32:12.514 [0x7fd558eec840] DEBUG - Captured session 10.
Dec 03, 2018 10:32:12.514 [0x7fd558eec840] DEBUG - Captured session 11.
Dec 03, 2018 10:32:12.514 [0x7fd558eec840] DEBUG - Captured session 12.
Dec 03, 2018 10:32:12.514 [0x7fd558eec840] DEBUG - Captured session 13.
Dec 03, 2018 10:32:12.514 [0x7fd558eec840] DEBUG - Captured session 14.
Dec 03, 2018 10:32:12.515 [0x7fd558eec840] DEBUG - Captured session 15.
Dec 03, 2018 10:32:12.515 [0x7fd558eec840] DEBUG - Captured session 16.
Dec 03, 2018 10:32:12.515 [0x7fd558eec840] DEBUG - Captured session 17.
Dec 03, 2018 10:32:12.515 [0x7fd558eec840] DEBUG - Captured session 18.
Dec 03, 2018 10:32:12.515 [0x7fd558eec840] DEBUG - Captured session 19.
Dec 03, 2018 10:32:12.535 [0x7fd558eec840] DEBUG - Server is already in shutdown mode, ignoring this signal...
Dec 03, 2018 10:32:12.535 [0x7fd558eec840] DEBUG - Server is already in shutdown mode, ignoring this signal...
Dec 03, 2018 10:32:12.628 [0x7fd558eec840] DEBUG - Database: Shutting down.
Dec 03, 2018 10:32:12.629 [0x7fd558eec840] DEBUG - Captured session 0.
Dec 03, 2018 10:32:12.629 [0x7fd558eec840] DEBUG - Captured session 1.
