Tonight my PMS DVR stopped working completely. I have rebooted, cancelled and re-set recordings, uninstalled and downgraded all the way to PMS 1.6.1, reset my tuner, and then some and I still can’t record any shows at all. I continually just see “transcoder error”. Logs appear to suggest that really is the issue here, but I have no idea how to resolve.
For some reason I’m also not able to upload the log files here.
Apr 05, 2018 21:18:08.826 [10924] DEBUG - Activity: updated activity d3c83de7-bd33-4de0-936b-1bcd98494142 - completed 66% - Processing subscriptions
Apr 05, 2018 21:18:08.826 [10924] DEBUG - DVR:Subscription: Failed to resolve subscription for episode ‘grandparentGuid: com.gracenote.onconnect://show/191276 grandparentThumb: http://tmsimg.plex.tv/assets/p191276_i_v8_aa.jpg grandparentTitle: NBA Basketball grandparentYear: 2018 guid: com.gracenote.onconnect://episode/SP003718410000 originallyAvailableAt: 2018-04-05 parentIndex: 2018 tagline: This Event title: Los Angeles Clippers at Utah Jazz type: 4 year: 2018’ to library item
Apr 05, 2018 21:18:08.826 [10924] DEBUG - DVR:Subscription: Checking in provider Program Guide
Apr 05, 2018 21:18:08.826 [10924] DEBUG - DVR:Subscription: MATCH for GUID scheme, directly checking.
Apr 05, 2018 21:18:08.826 [10924] DEBUG - Downloading document http://127.0.0.1:32400/tv.plex.providers.epg.onconnect:5/metadata/com.gracenote.onconnect%3A%2F%2Fepisode%2FSP003718410000
Apr 05, 2018 21:18:08.857 [10924] DEBUG - DVR:Subscription: The item at /tv.plex.providers.epg.onconnect:5/metadata/com%2Egracenote%2Eonconnect%3A%2F%2Fepisode%2FSP003718410000 is of type 4
Apr 05, 2018 21:18:08.857 [10924] DEBUG - Downloading document http://127.0.0.1:32400/tv.plex.providers.epg.onconnect:5/metadata/com.gracenote.onconnect%3A%2F%2Fshow%2F191276
Apr 05, 2018 21:18:08.873 [10924] DEBUG - There were 0 top-level paths for NBA Basketball.
Apr 05, 2018 21:18:08.873 [10924] DEBUG - DVR:Subscription: There are 2 airings available.
Apr 05, 2018 21:18:08.873 [10924] DEBUG - DVR:Subscription: No match in the library for ‘NBA Basketball - Los Angeles Clippers at Utah Jazz’, grabbing.
Apr 05, 2018 21:18:08.873 [10924] DEBUG - Activity: updated activity d3c83de7-bd33-4de0-936b-1bcd98494142 - completed 100% - Processing subscriptions
Apr 05, 2018 21:18:08.873 [10924] DEBUG - Activity: registered new activity 5efcc33d-c22f-4fc0-9303-4f831377ef92 - Processing subscriptions
Apr 05, 2018 21:18:17.053 [8764] DEBUG - NAT: UPnP, found device http://10.10.1.12:32469/DeviceDescription.xml with private address <10.10.1.12>
Apr 05, 2018 21:18:17.053 [8764] DEBUG - NAT: UPnP, not an IGD: http://10.10.1.12:32469/DeviceDescription.xml.
Apr 05, 2018 21:18:17.053 [8764] DEBUG - NAT: UPnP, getPublicIP didn’t find usable IGD.
Apr 05, 2018 21:18:17.303 [8764] WARN - NAT: PMP, got an error: NATPMP_ERR_RECVFROM.
Apr 05, 2018 21:18:17.303 [8764] DEBUG - MyPlex: Last published value didn’t change, we’re done.
Apr 05, 2018 21:18:17.303 [10948] DEBUG - MyPlex: Sending Server Info to myPlex (user=CourtimusMaximus@gmail.com, ip=, port=32400)
Apr 05, 2018 21:18:17.303 [10948] DEBUG - HTTP requesting POST https://plex.tv/servers.xml?auth_token=xxxxxxxxxxxxxxxxxxxx&async=1&asyncIdentifier=2fd9aacd-c566-4569-8c89-a5ea4ef076c1
Apr 05, 2018 21:18:17.943 [10948] DEBUG - HTTP 201 response from POST https://plex.tv/servers.xml?auth_token=xxxxxxxxxxxxxxxxxxxx&async=1&asyncIdentifier=2fd9aacd-c566-4569-8c89-a5ea4ef076c1
Apr 05, 2018 21:18:17.943 [10948] DEBUG - MyPlex: Published Mapping State response was 201
Apr 05, 2018 21:18:17.943 [10948] DEBUG - MyPlex: Got response for 3ba76570102277e37ade0d43640c2e33d18753e3 ~ registered 24.10.228.76:32400
Apr 05, 2018 21:18:17.959 [4488] WARN - PubSub: Received notifyConnectivity event with incorrect async identifier (839b5293-3370-41e8-9888-ae2d2a987011, expected 2fd9aacd-c566-4569-8c89-a5ea4ef076c1)
Apr 05, 2018 21:18:17.959 [10948] DEBUG - MyPlex: Last published value didn’t change, we’re done.
Apr 05, 2018 21:18:18.506 [10648] DEBUG - Request: [34.244.6.8:10722 (WAN)] GET /identity (4 live) TLS Signed-in Token (CourtimusMaximus)
Apr 05, 2018 21:18:18.506 [10920] DEBUG - Completed: [34.244.6.8:10722] 200 GET /identity (4 live) TLS 2ms 357 bytes
Apr 05, 2018 21:18:39.943 [10972] DEBUG - Using default transcode duration of 120 minutes
Apr 05, 2018 21:18:39.943 [10972] DEBUG - Started session successfully: 24773708-b329-41c2-b39c-2e9e6c7708bc
Apr 05, 2018 21:18:39.990 [10972] DEBUG - DVR:Recorder: It took 31.0 sec to start the session for http://10.10.1.3:5004/auto/v693
Apr 05, 2018 21:18:39.990 [10972] ERROR - DVR:Recorder: No part because session isn’t reporting one.
Apr 05, 2018 21:18:39.990 [10972] ERROR - DVR:Recorder: Couldn’t obtain a part, something went wrong.
Apr 05, 2018 21:18:39.990 [10972] ERROR - DVR:Recorder: Error 12 (There was a transcoder error) starting the record, shutting things down.
Apr 05, 2018 21:18:39.990 [10972] DEBUG - MediaRecorderVirtual: setting stop time to 1522984719
Apr 05, 2018 21:18:39.990 [10972] DEBUG - DVR:Recorder: Asked to stop recording ‘NBA Basketball - Los Angeles Clippers at Utah Jazz’.
Apr 05, 2018 21:18:39.990 [10972] DEBUG - DVR:Recorder: Stopping transcode session.
Apr 05, 2018 21:18:39.990 [10972] DEBUG - Killing job.
Apr 05, 2018 21:18:39.990 [10972] DEBUG - Job was already killed, not killing again.
Apr 05, 2018 21:18:39.990 [10972] DEBUG - Stopping transcode session 24773708-b329-41c2-b39c-2e9e6c7708bc
Apr 05, 2018 21:18:39.990 [10948] DEBUG - Jobs: ‘C:\Program Files (x86)\Plex\Plex Media Server\PlexTranscoder.exe’ exit code for process 9612 is -1059143458
Apr 05, 2018 21:18:39.990 [7460] DEBUG - Cleaning directory for session 24773708-b329-41c2-b39c-2e9e6c7708bc (C:\Users\Court\AppData\Local\Plex Media Server\Cache\Transcode\Sessions\plex-transcode-24773708-b329-41c2-b39c-2e9e6c7708bc)
Apr 05, 2018 21:18:40.021 [10972] DEBUG - DVR:Grabber: Freed a tuner (now 3 available)
Apr 05, 2018 21:18:40.021 [10972] DEBUG - DVR:Grabber: Operation for NBA Basketball - Los Angeles Clippers at Utah Jazz completed with status error (There was a transcoder error)
Apr 05, 2018 21:18:40.021 [10972] DEBUG - Activity: Ended activity 83cec086-dcab-487f-ab51-6ae3d5ac2f9f.
Apr 05, 2018 21:18:40.021 [10972] ERROR - DVR:Grabber: Starting media grab failed.
Apr 05, 2018 21:18:40.959 [4364] DEBUG - DVR:Recorder: Asked to stop recording ‘NBA Basketball - Los Angeles Clippers at Utah Jazz’.