tofagerl
Contributor
- Joined
- Aug 26, 2013
- Messages
- 118
File plays fine on Apple TV without subtitles, but with subtitles on (forcing a transcode) I get the following log entry (error in red):
Note that the first error, where it can't find the SRT, is wrong - the file is there. There is also no permission problems, all files have the same permissions, 644.
Jun 30, 2016 22:22:08.993 [0x80c49f400] DEBUG - HTTP success requesting GET https://downloads.plex.tv/codecs/2c361e4-1071/freebsd-x86_64/libh264_decoder.so
Jun 30, 2016 22:22:09.000 [0x80c49f400] DEBUG - [Universal] Using local file path instead of URL: /data/tvshows/Inside Amy Schumer/Season 04/04x02 - Welcome to the Gun Show.mkv
Jun 30, 2016 22:22:09.000 [0x80c49f400] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/streams/257932?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Jun 30, 2016 22:22:09.000 [0x80c49f800] DEBUG - Request: [127.0.0.1:36489] GET /library/streams/257932?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx (14 live) GZIP
Jun 30, 2016 22:22:09.000 [0x80c49f800] DEBUG - Auth: We found auth token (xxxxxxxxxxxxxxxxxxxx), enabling token-based authentication.
Jun 30, 2016 22:22:09.000 [0x80c49f800] DEBUG - Auth: authenticated user 1 as tofagerl
Jun 30, 2016 22:22:09.001 [0x80c49f800] DEBUG - Auth: Came in with a super-token, authorization succeeded.
Jun 30, 2016 22:22:09.003 [0x80c49f800] ERROR - Couldn't find the file to stream: /mnt/media/shows/Inside Amy Schumer/Season 04/04x02 - Welcome to the Gun Show.en.srt
Jun 30, 2016 22:22:09.004 [0x80900dc00] DEBUG - Completed: [127.0.0.1:36489] 404 GET /library/streams/257932 (14 live) GZIP 3ms 294 bytes
Jun 30, 2016 22:22:09.004 [0x80c49f400] DEBUG - HTTP success requesting GET http://127.0.0.1:32400/library/streams/257932?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Jun 30, 2016 22:22:09.004 [0x80c49f400] DEBUG - Downloaded stream from [http://127.0.0.1:32400/library/streams/257932?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx] (codec: srt) to temporary file [/var/db/plexdata/Plex Media Server/Cache/Transcode/Sessions/plex-transcode-15CE7CD9-C819-4211-B3BB-D69CCB819F57-eff14980-92f9-4065-a975-b8d37f175c55/temp-0.srt]
Jun 30, 2016 22:22:09.005 [0x80c49f400] DEBUG - Job running: FFMPEG_EXTERNAL_LIBS='/var/db/plexdata/Plex\ Media\ Server/Codecs/2c361e4-1071-freebsd-x86_64/' XDG_CACHE_HOME='/var/db/plexdata/Plex Media Server/Cache/' XDG_DATA_HOME='/usr/pbi/plexmediaserver-amd64/share/plexmediaserver/Resources/' X_PLEX_TOKEN='xxxxxxxxxxxxxxxxxxxx' '/usr/pbi/plexmediaserver-amd64/share/plexmediaserver/Resources/Plex Transcoder' '-codec:0' 'h264' '-noaccurate_seek' '-i' '/data/tvshows/Inside Amy Schumer/Season 04/04x02 - Welcome to the Gun Show.mkv' '-noaccurate_seek' '-i' '/var/db/plexdata/Plex Media Server/Cache/Transcode/Sessions/plex-transcode-15CE7CD9-C819-4211-B3BB-D69CCB819F57-eff14980-92f9-4065-a975-b8d37f175c55/temp-0.srt' '-map' '0:0' '-metadata:s:0' 'language=eng' '-codec:0' 'copy' '-map' '0:1' '-codec:1' 'copy' '-copypriorss:1' '0' '-segment_format' 'mpegts' '-f' 'segment' '-flags' '-global_header' '-segment_time' '10' '-segment_start_number' '0' '-segment_copyts' '1' '-segment_time_delta' '0.0625' '-max_delay' '5000000' '-avoid_negative_ts' 'disabled' '-map_metadata' '-1' '-map_chapters' '-1' 'media-%05d.ts' '-map' '1:s:0' '-metadata:s:0' 'language=eng' '-codec:0' 'webvtt' '-f' 'segment' '-segment_format' 'webvtt' '-segment_time' '10' '-avoid_negative_ts' 'disabled' '-write_empty_segments' '1' '-segment_copyts' '1' '-segment_start_number' '0' '-segment_list' '/var/db/plexdata/Plex Media Server/Cache/Transcode/Sessions/plex-transcode-15CE7CD9-C819-4211-B3BB-D69CCB819F57-eff14980-92f9-4065-a975-b8d37f175c55/temp-1.csv' 'media-%05d.vtt' '-start_at_zero' '-copyts' '-vsync' 'cfr' '-y' '-nostats' '-loglevel' 'quiet' '-loglevel_plex' 'error' '-progressurl' 'http://127.0.0.1:32400/video/:/transcode/session/15CE7CD9-C819-4211-B3BB-D69CCB819F57/progress'
Jun 30, 2016 22:22:09.050 [0x80b512400] DEBUG - Stopping file watcher for com.plexapp.agents.lyricfind
Jun 30, 2016 22:22:09.067 [0x80c820400] DEBUG - Request: [127.0.0.1:36490] PUT /video/:/transcode/session/15CE7CD9-C819-4211-B3BB-D69CCB819F57/progress?index=0&id=0&codec=h264&type=video (15 live)
Jun 30, 2016 22:22:09.067 [0x80c820400] DEBUG - Auth: We found auth token (xxxxxxxxxxxxxxxxxxxx), enabling token-based authentication.
Jun 30, 2016 22:22:09.067 [0x80c820400] DEBUG - Auth: Came in with the master token, authorization succeeded.
Jun 30, 2016 22:22:09.067 [0x80900d800] DEBUG - Completed: [127.0.0.1:36490] 206 PUT /video/:/transcode/session/15CE7CD9-C819-4211-B3BB-D69CCB819F57/progress?index=0&id=0&codec=h264&type=video (15 live) 0ms 190 bytes
Jun 30, 2016 22:22:09.068 [0x80c820400] DEBUG - Request: [127.0.0.1:36491] PUT /video/:/transcode/session/15CE7CD9-C819-4211-B3BB-D69CCB819F57/progress?index=1&id=0&codec=ac3&type=audio (15 live)
Jun 30, 2016 22:22:09.068 [0x80c820400] DEBUG - Auth: We found auth token (xxxxxxxxxxxxxxxxxxxx), enabling token-based authentication.
Jun 30, 2016 22:22:09.068 [0x80c820400] DEBUG - Auth: Came in with the master token, authorization succeeded.
Jun 30, 2016 22:22:09.068 [0x80900d800] DEBUG - Completed: [127.0.0.1:36491] 206 PUT /video/:/transcode/session/15CE7CD9-C819-4211-B3BB-D69CCB819F57/progress?index=1&id=0&codec=ac3&type=audio (15 live) 0ms 190 bytes
Jun 30, 2016 22:22:09.111 [0x80c820400] ERROR - [Transcoder] /var/db/plexdata/Plex Media Server/Cache/Transcode/Sessions/plex-transcode-15CE7CD9-C819-4211-B3BB-D69CCB819F57-eff14980-92f9-4065-a975-b8d37f175c55/temp-0.srt: Invalid data found when processing input
Jun 30, 2016 22:22:09.112 [0x80c49f400] ERROR - Failed to start session successfully.
Jun 30, 2016 22:22:09.112 [0x80c49f400] DEBUG - Streaming Resource: Terminating session 0x80c841440:DF6CA9A2-E395-4BD1-B654-736308276B82 with reason Video conversion failed. The transcoder crashed or failed to start up.
Jun 30, 2016 22:22:09.113 [0x80900dc00] DEBUG - Completed: [10.0.0.107:50753] 500 GET /video/:/transcode/universal/session/15CE7CD9-C819-4211-B3BB-D69CCB819F57/base/index.m3u8 (15 live) TLS GZIP 6188ms 368 bytes (pipelined: 2)
Jun 30, 2016 22:22:09.113 [0x809014000] ERROR - JobManager: child process returned: 1 (Operation not permitted)
Jun 30, 2016 22:22:09.262 [0x80c49f400] DEBUG - Request: [10.0.0.107:50755] GET /errors/404 (16 live) TLS GZIP
Jun 30, 2016 22:22:09.263 [0x80900dc00] DEBUG - Completed: [10.0.0.107:50755] 404 GET /errors/404 (16 live) TLS GZIP 0ms 342 bytes
Jun 30, 2016 22:22:09.344 [0x80c49f400] DEBUG - Request: [10.0.0.107:50740] GET /photo/:/transcode?height=300&minSize=0&url=http%3A//127.0.0.1%3A32400/library/metadata/25876/thumb/1466806005&width=300 (16 live) TLS GZIP
Note that the first error, where it can't find the SRT, is wrong - the file is there. There is also no permission problems, all files have the same permissions, 644.
Jun 30, 2016 22:22:08.993 [0x80c49f400] DEBUG - HTTP success requesting GET https://downloads.plex.tv/codecs/2c361e4-1071/freebsd-x86_64/libh264_decoder.so
Jun 30, 2016 22:22:09.000 [0x80c49f400] DEBUG - [Universal] Using local file path instead of URL: /data/tvshows/Inside Amy Schumer/Season 04/04x02 - Welcome to the Gun Show.mkv
Jun 30, 2016 22:22:09.000 [0x80c49f400] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/streams/257932?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Jun 30, 2016 22:22:09.000 [0x80c49f800] DEBUG - Request: [127.0.0.1:36489] GET /library/streams/257932?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx (14 live) GZIP
Jun 30, 2016 22:22:09.000 [0x80c49f800] DEBUG - Auth: We found auth token (xxxxxxxxxxxxxxxxxxxx), enabling token-based authentication.
Jun 30, 2016 22:22:09.000 [0x80c49f800] DEBUG - Auth: authenticated user 1 as tofagerl
Jun 30, 2016 22:22:09.001 [0x80c49f800] DEBUG - Auth: Came in with a super-token, authorization succeeded.
Jun 30, 2016 22:22:09.003 [0x80c49f800] ERROR - Couldn't find the file to stream: /mnt/media/shows/Inside Amy Schumer/Season 04/04x02 - Welcome to the Gun Show.en.srt
Jun 30, 2016 22:22:09.004 [0x80900dc00] DEBUG - Completed: [127.0.0.1:36489] 404 GET /library/streams/257932 (14 live) GZIP 3ms 294 bytes
Jun 30, 2016 22:22:09.004 [0x80c49f400] DEBUG - HTTP success requesting GET http://127.0.0.1:32400/library/streams/257932?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Jun 30, 2016 22:22:09.004 [0x80c49f400] DEBUG - Downloaded stream from [http://127.0.0.1:32400/library/streams/257932?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx] (codec: srt) to temporary file [/var/db/plexdata/Plex Media Server/Cache/Transcode/Sessions/plex-transcode-15CE7CD9-C819-4211-B3BB-D69CCB819F57-eff14980-92f9-4065-a975-b8d37f175c55/temp-0.srt]
Jun 30, 2016 22:22:09.005 [0x80c49f400] DEBUG - Job running: FFMPEG_EXTERNAL_LIBS='/var/db/plexdata/Plex\ Media\ Server/Codecs/2c361e4-1071-freebsd-x86_64/' XDG_CACHE_HOME='/var/db/plexdata/Plex Media Server/Cache/' XDG_DATA_HOME='/usr/pbi/plexmediaserver-amd64/share/plexmediaserver/Resources/' X_PLEX_TOKEN='xxxxxxxxxxxxxxxxxxxx' '/usr/pbi/plexmediaserver-amd64/share/plexmediaserver/Resources/Plex Transcoder' '-codec:0' 'h264' '-noaccurate_seek' '-i' '/data/tvshows/Inside Amy Schumer/Season 04/04x02 - Welcome to the Gun Show.mkv' '-noaccurate_seek' '-i' '/var/db/plexdata/Plex Media Server/Cache/Transcode/Sessions/plex-transcode-15CE7CD9-C819-4211-B3BB-D69CCB819F57-eff14980-92f9-4065-a975-b8d37f175c55/temp-0.srt' '-map' '0:0' '-metadata:s:0' 'language=eng' '-codec:0' 'copy' '-map' '0:1' '-codec:1' 'copy' '-copypriorss:1' '0' '-segment_format' 'mpegts' '-f' 'segment' '-flags' '-global_header' '-segment_time' '10' '-segment_start_number' '0' '-segment_copyts' '1' '-segment_time_delta' '0.0625' '-max_delay' '5000000' '-avoid_negative_ts' 'disabled' '-map_metadata' '-1' '-map_chapters' '-1' 'media-%05d.ts' '-map' '1:s:0' '-metadata:s:0' 'language=eng' '-codec:0' 'webvtt' '-f' 'segment' '-segment_format' 'webvtt' '-segment_time' '10' '-avoid_negative_ts' 'disabled' '-write_empty_segments' '1' '-segment_copyts' '1' '-segment_start_number' '0' '-segment_list' '/var/db/plexdata/Plex Media Server/Cache/Transcode/Sessions/plex-transcode-15CE7CD9-C819-4211-B3BB-D69CCB819F57-eff14980-92f9-4065-a975-b8d37f175c55/temp-1.csv' 'media-%05d.vtt' '-start_at_zero' '-copyts' '-vsync' 'cfr' '-y' '-nostats' '-loglevel' 'quiet' '-loglevel_plex' 'error' '-progressurl' 'http://127.0.0.1:32400/video/:/transcode/session/15CE7CD9-C819-4211-B3BB-D69CCB819F57/progress'
Jun 30, 2016 22:22:09.050 [0x80b512400] DEBUG - Stopping file watcher for com.plexapp.agents.lyricfind
Jun 30, 2016 22:22:09.067 [0x80c820400] DEBUG - Request: [127.0.0.1:36490] PUT /video/:/transcode/session/15CE7CD9-C819-4211-B3BB-D69CCB819F57/progress?index=0&id=0&codec=h264&type=video (15 live)
Jun 30, 2016 22:22:09.067 [0x80c820400] DEBUG - Auth: We found auth token (xxxxxxxxxxxxxxxxxxxx), enabling token-based authentication.
Jun 30, 2016 22:22:09.067 [0x80c820400] DEBUG - Auth: Came in with the master token, authorization succeeded.
Jun 30, 2016 22:22:09.067 [0x80900d800] DEBUG - Completed: [127.0.0.1:36490] 206 PUT /video/:/transcode/session/15CE7CD9-C819-4211-B3BB-D69CCB819F57/progress?index=0&id=0&codec=h264&type=video (15 live) 0ms 190 bytes
Jun 30, 2016 22:22:09.068 [0x80c820400] DEBUG - Request: [127.0.0.1:36491] PUT /video/:/transcode/session/15CE7CD9-C819-4211-B3BB-D69CCB819F57/progress?index=1&id=0&codec=ac3&type=audio (15 live)
Jun 30, 2016 22:22:09.068 [0x80c820400] DEBUG - Auth: We found auth token (xxxxxxxxxxxxxxxxxxxx), enabling token-based authentication.
Jun 30, 2016 22:22:09.068 [0x80c820400] DEBUG - Auth: Came in with the master token, authorization succeeded.
Jun 30, 2016 22:22:09.068 [0x80900d800] DEBUG - Completed: [127.0.0.1:36491] 206 PUT /video/:/transcode/session/15CE7CD9-C819-4211-B3BB-D69CCB819F57/progress?index=1&id=0&codec=ac3&type=audio (15 live) 0ms 190 bytes
Jun 30, 2016 22:22:09.111 [0x80c820400] ERROR - [Transcoder] /var/db/plexdata/Plex Media Server/Cache/Transcode/Sessions/plex-transcode-15CE7CD9-C819-4211-B3BB-D69CCB819F57-eff14980-92f9-4065-a975-b8d37f175c55/temp-0.srt: Invalid data found when processing input
Jun 30, 2016 22:22:09.112 [0x80c49f400] ERROR - Failed to start session successfully.
Jun 30, 2016 22:22:09.112 [0x80c49f400] DEBUG - Streaming Resource: Terminating session 0x80c841440:DF6CA9A2-E395-4BD1-B654-736308276B82 with reason Video conversion failed. The transcoder crashed or failed to start up.
Jun 30, 2016 22:22:09.113 [0x80900dc00] DEBUG - Completed: [10.0.0.107:50753] 500 GET /video/:/transcode/universal/session/15CE7CD9-C819-4211-B3BB-D69CCB819F57/base/index.m3u8 (15 live) TLS GZIP 6188ms 368 bytes (pipelined: 2)
Jun 30, 2016 22:22:09.113 [0x809014000] ERROR - JobManager: child process returned: 1 (Operation not permitted)
Jun 30, 2016 22:22:09.262 [0x80c49f400] DEBUG - Request: [10.0.0.107:50755] GET /errors/404 (16 live) TLS GZIP
Jun 30, 2016 22:22:09.263 [0x80900dc00] DEBUG - Completed: [10.0.0.107:50755] 404 GET /errors/404 (16 live) TLS GZIP 0ms 342 bytes
Jun 30, 2016 22:22:09.344 [0x80c49f400] DEBUG - Request: [10.0.0.107:50740] GET /photo/:/transcode?height=300&minSize=0&url=http%3A//127.0.0.1%3A32400/library/metadata/25876/thumb/1466806005&width=300 (16 live) TLS GZIP