Transcoder segmentation fault (reproducable)

server-linux

#1

Hi,

I keep getting transcoder segmentation fault when trying to view some webm files. Here's the interesting part of the log file:

Jun 11, 2017 13:01:06.797 [0x7f1cb5bfe700] DEBUG - Job running: EAE_ROOT='/tmp/pms-5bde6dda-8685-418e-b9db-811fab617f59/EasyAudioEncoder' FFMPEG_EXTERNAL_LIBS='/var/lib/plexmediaserver/Library/Application\ Support/Plex\ Media\ Server/Codecs/18f9bcf-1233-linux-ubuntu-x86_64/' XDG_CACHE_HOME='/var/lib/plexmediaserver/Library/Application Support/Plex Media Server/Cache/' XDG_DATA_HOME='/usr/lib/plexmediaserver/Resources/' X_PLEX_TOKEN='xxxxxxxxxxxxxxxxxxxx' '/usr/lib/plexmediaserver/Plex Transcoder' '-codec:0' 'vp8' '-codec:1' 'vorbis' '-i' '/data/Barnserier/mulle_meck/Mulle Meck bygger en bil-6uwiqHiscz8.webm' '-filter_complex' '[0:0]scale=w=480:h=352,format=pix_fmts=yuv420p|nv12[0]' '-map' '[0]' '-codec:0' 'libx264' '-crf:0' '19' '-maxrate:0' '841k' '-bufsize:0' '1682k' '-r:0' '1000' '-preset:0' 'veryfast' '-x264opts:0' 'subme=2:me_range=4:rc_lookahead=10:me=dia:no_chroma_me:8x8dct=0:partitions=none' '-map' '0:1' '-codec:1' 'aac' '-ar:1' '44100' '-channel_layout:1' 'stereo' '-b:1' '193k' '-f' 'segment' '-segment_format' 'matroska' '-segment_format_options' 'live=1' '-segment_time' '1' '-segment_header_filename' 'header' '-segment_start_number' '0' '-segment_list' 'http://127.0.0.1:32400/video/:/transcode/session/pak4k26wcntcat3dx0sokost/dd72ef0b-cb2a-47ec-b3e5-38989f9084f8/seglist' '-segment_list_type' 'csv' '-segment_list_size' '2147483647' '-avoid_negative_ts' 'disabled' '-map_metadata' '-1' '-map_chapters' '-1' 'chunk-%05d' '-start_at_zero' '-copyts' '-y' '-nostats' '-loglevel' 'quiet' '-loglevel_plex' 'error' '-progressurl' 'http://127.0.0.1:32400/video/:/transcode/session/pak4k26wcntcat3dx0sokost/dd72ef0b-cb2a-47ec-b3e5-38989f9084f8/progress'
Jun 11, 2017 13:01:06.928 [0x7f1cc1bff700] DEBUG - Auth: We found auth token (xxxxxxxxxxxxxxxxxxxx), enabling token-based authentication.
Jun 11, 2017 13:01:06.928 [0x7f1cc1bff700] DEBUG - Auth: Came in with the master token, authorization succeeded.
Jun 11, 2017 13:01:06.928 [0x7f1cb3fff700] DEBUG - Request: [127.0.0.1:43029 (Loopback)] PUT /video/:/transcode/session/pak4k26wcntcat3dx0sokost/dd72ef0b-cb2a-47ec-b3e5-38989f9084f8/progress/stream?index=0&id=0&codec=vp8&type=video (8 live) Signed-in Token (martinfrojd)
Jun 11, 2017 13:01:06.929 [0x7f1cc1bff700] DEBUG - Completed: [127.0.0.1:43029] 206 PUT /video/:/transcode/session/pak4k26wcntcat3dx0sokost/dd72ef0b-cb2a-47ec-b3e5-38989f9084f8/progress/stream?index=0&id=0&codec=vp8&type=video (8 live) 0ms 227 bytes
Jun 11, 2017 13:01:06.929 [0x7f1cc1bff700] DEBUG - Auth: We found auth token (xxxxxxxxxxxxxxxxxxxx), enabling token-based authentication.
Jun 11, 2017 13:01:06.929 [0x7f1cc1bff700] DEBUG - Auth: Came in with the master token, authorization succeeded.
Jun 11, 2017 13:01:06.929 [0x7f1cb63ff700] DEBUG - Request: [127.0.0.1:43030 (Loopback)] PUT /video/:/transcode/session/pak4k26wcntcat3dx0sokost/dd72ef0b-cb2a-47ec-b3e5-38989f9084f8/progress/stream?index=1&id=0&codec=vorbis&type=audio (9 live) Signed-in Token (martinfrojd)
Jun 11, 2017 13:01:06.930 [0x7f1cc1bff700] DEBUG - Completed: [127.0.0.1:43030] 206 PUT /video/:/transcode/session/pak4k26wcntcat3dx0sokost/dd72ef0b-cb2a-47ec-b3e5-38989f9084f8/progress/stream?index=1&id=0&codec=vorbis&type=audio (9 live) 0ms 227 bytes
Jun 11, 2017 13:01:07.092 [0x7f1cbe3fe700] DEBUG - JobManager: child process killed by signal: 11 (Segmentation fault)
Jun 11, 2017 13:01:07.092 [0x7f1cbe3fe700] DEBUG - Jobs: '/usr/lib/plexmediaserver/Plex Transcoder' exit code for process 5171 is -11

Full log attached.

The movie file I try to play is grabbed from youtube:
https://www.youtube.com/watch?v=6uwiqHiscz8

I use Plex Media Server v1.7.2.3878-8088811b8 - ubuntu PC x86_64

Thanks!


#2

Have you been able to solve this? I am having trouble with videos encoded in VP8 as well.


#3

Everything has been forwarded to engineering to recreate and take action on.

I have no other status to update at this time.


#4

Thanks for the information


#5

Also hitting this problem.

Jul 12, 2017 16:40:49.469 [0x7fb04cbfe700] DEBUG - JobManager: child process killed by signal: 11 (Segmentation fault)
Jul 12, 2017 16:40:49.469 [0x7fb04cbfe700] DEBUG - Jobs: '/usr/lib/plexmediaserver/Plex Transcoder' exit code for process 1603 is -11

Tried versions v1.7.3.3937-70f781325 through 1.7.6.4058-8fa494d15

Backed my install all the way down to 1.5.5.3634-995f1dead and the segfault stopped happening.


#6

@tekbickler said:
Also hitting this problem.

Jul 12, 2017 16:40:49.469 [0x7fb04cbfe700] DEBUG - JobManager: child process killed by signal: 11 (Segmentation fault)
Jul 12, 2017 16:40:49.469 [0x7fb04cbfe700] DEBUG - Jobs: '/usr/lib/plexmediaserver/Plex Transcoder' exit code for process 1603 is -11

Tried versions v1.7.3.3937-70f781325 through 1.7.6.4058-8fa494d15

Backed my install all the way down to 1.5.5.3634-995f1dead and the segfault stopped happening.

Please recreate the problem.
Wait 20 seconds.
Grab the log files (settings - server - help - download logs)
Include the XML of what was being played at time of failure


#7

If it helps here are my logs as well. I tried to play 2 videos encoded with VP8 and I get the error. I have tried many other file encodings including VP9 and all of those work. the crash only happens on my files with VP8.


#8

@Quantafac said:
If it helps here are my logs as well. I tried to play 2 videos encoded with VP8 and I get the error. I have tried many other file encodings including VP9 and all of those work. the crash only happens on my files with VP8.

May I also have the XML? I need the XML to see what PMS was dealing with at time of failure.


#9

Thanks for that. whether local or remote.. You have 4 different subnets showing. This confirms what I see. Your server is on the 50.24 net.

You must use the tunnel procedure above to get to it and then use the loopback address 127.0.0.1 to control / setup and sign it in normally.

I am VERY sorry I missed that


#10

I would like to provide the XML file, but I am not sure what your talking about. Where can I find the file you need?


#11

When you hover over any item (episode or movie), you see the ellipsis (3 dots) . click it and you'll see "Get Info". Click that.

It will show you the XML summary in a nicely formatted form

On the bottom left of that popup, you'll see "View XML" . This is the raw XML we need to see. click that and it will open a new tab.

Copy all that text, paste it here between 2 lines of triple-grave

` ` ` (without spaces) to open
then xml
` ` ` (to close the block)

looks like this when done

then xml

#12

This right? Also if it is pertinent, I have been able to play these files before. I upgraded from Ubuntu 14.04 to 16.04 and thats when the issues started for me. I then tried to run on a fresh install with still no luck.

<MediaContainer size="1" allowSync="1" identifier="com.plexapp.plugins.library" librarySectionID="1" librarySectionTitle="Movies" librarySectionUUID="873f340c-a625-441a-8252-7bf78d73e892" mediaTagPrefix="/system/bundle/media/flags/" mediaTagVersion="1498656408"><Video ratingKey="47990" key="/library/metadata/47990" guid="com.plexapp.agents.imdb://tt0093779?lang=en" librarySectionID="1" librarySectionKey="/library/sections/1" studio="Act III Communications" type="movie" title="The Princess Bride" titleSort="Princess Bride" contentRating="PG" summary="In this enchantingly cracked fairy tale, the beautiful Princess Buttercup and the dashing Westley must overcome staggering odds to find happiness amid six-fingered swordsmen, murderous princes, Sicilians and rodents of unusual size. But even death can't stop these true lovebirds from triumphing." rating="7.6" viewCount="1" lastViewedAt="1497917948" year="1987" tagline="It's as real as the feelings you feel." thumb="/library/metadata/47990/thumb/1499994495" art="/library/metadata/47990/art/1499994495" duration="5901438" originallyAvailableAt="1987-09-25" addedAt="1497887992" updatedAt="1499994495" chapterSource="mixed" primaryExtraKey="/library/metadata/47991"><Media videoResolution="480" id="130245" duration="5901438" bitrate="952" width="720" height="464" aspectRatio="1.66" audioChannels="2" audioCodec="opus" videoCodec="vp8" container="mkv" videoFrameRate="24p"><Part accessible="1" exists="1" id="134334" key="/library/parts/134334/1498296884/file.mkv" duration="5901438" file="/media/server/plexdrivetemp/Videos/Movies/Romance/The_Princess_Bride_(1988).mkv" size="702278191" container="mkv"><Stream id="264018" streamType="1" default="1" codec="vp8" index="0" bitrate="952" anamorphic="1" bitDepth="8" chromaSubsampling="4:2:0" frameRate="23.976" height="464" pixelAspectRatio="186:157" refFrames="1" scanType="progressive" width="720"/><Stream id="264019" streamType="2" selected="1" default="1" codec="opus" index="1" channels="2" language="English" languageCode="eng" audioChannelLayout="stereo" samplingRate="48000" title="Stereo"/><Stream id="264020" streamType="2" codec="opus" index="2" channels="2" language="English" languageCode="eng" audioChannelLayout="stereo" samplingRate="48000" title="Stereo"/><Stream id="264021" streamType="3" codec="vobsub" index="3" language="English" languageCode="eng"/><Stream id="264022" streamType="3" codec="ass" index="4" language="English" languageCode="eng"/></Part></Media><Genre id="96" filter="genre=96" tag="Adventure"/><Genre id="17" filter="genre=17" tag="Family"/><Genre id="18" filter="genre=18" tag="Fantasy"/><Genre id="66" filter="genre=66" tag="Comedy"/><Genre id="132" filter="genre=132" tag="Romance"/><Director id="25206" filter="director=25206" tag="Rob Reiner"/><Writer id="5655" filter="writer=5655" tag="William Goldman"/><Producer id="25229" filter="producer=25229" tag="Andrew Scheinman"/><Producer id="25230" filter="producer=25230" tag="Rob Reiner"/><Country id="20" filter="country=20" tag="USA"/><Role id="366" filter="actor=366" tag="Cary Elwes" role="Westley" thumb="http://image.tmdb.org/t/p/original/wmvYoJHStQeQzrpqOM9tkvf1wwF.jpg"/><Role id="25207" filter="actor=25207" tag="Robin Wright" role="The Princess Bride" thumb="http://image.tmdb.org/t/p/original/cke0NNZP4lHRtOethRy2XGSOp3E.jpg"/><Role id="25208" filter="actor=25208" tag="Mandy Patinkin" role="Inigo Montoya" thumb="http://image.tmdb.org/t/p/original/aiHwNtaKkUFd9kZ81wGhMANMKWC.jpg"/><Role id="25209" filter="actor=25209" tag="André the Giant" role="Fezzik" thumb="http://image.tmdb.org/t/p/original/wVlQm9XEs9Nvvmf9vcXEFmXYae2.jpg"/><Role id="25210" filter="actor=25210" tag="Chris Sarandon" role="Prince Humperdinck" thumb="http://image.tmdb.org/t/p/original/1Wf3WoXEdPqGyO6onKfFkseDFef.jpg"/><Role id="2534" filter="actor=2534" tag="Christopher Guest" role="Count Tyrone Rugen" thumb="http://image.tmdb.org/t/p/original/fhEQq0q2aR2sh4HU824xunoyAce.jpg"/><Role id="191" filter="actor=191" tag="Wallace Shawn" role="Vizzini" thumb="http://image.tmdb.org/t/p/original/oGE6JqPP2xH4tNORKNqxbNPYi7u.jpg"/><Role id="25211" filter="actor=25211" tag="Peter Falk" role="The Grandfather / Narrator" thumb="http://image.tmdb.org/t/p/original/mjgykviG6rY2WlF14aeDRsvVA6x.jpg"/><Role id="25212" filter="actor=25212" tag="Billy Crystal" role="Miracle Max" thumb="http://image.tmdb.org/t/p/original/22PBSROMN6GmD7uxHpTNb0Unftt.jpg"/><Role id="25213" filter="actor=25213" tag="Fred Savage" role="The Grandson" thumb="http://image.tmdb.org/t/p/original/q6u7yhINrALOC9wD2tc6mifQ9sJ.jpg"/><Role id="2595" filter="actor=2595" tag="Carol Kane" role="Valerie" thumb="http://image.tmdb.org/t/p/original/tftY60jQYQBcpGjqAzKIiFNZV2J.jpg"/><Role id="25214" filter="actor=25214" tag="Mel Smith" role="The Albino" thumb="http://image.tmdb.org/t/p/original/WutScDw47AhIIErXEZtmI5KvGh.jpg"/><Role id="25215" filter="actor=25215" tag="Peter Cook" role="The Impressive Clergyman" thumb="http://image.tmdb.org/t/p/original/5l1lXeD3cCKQ58AXt5p040LNzpQ.jpg"/><Role id="6265" filter="actor=6265" tag="Willoughby Gray" role="The King" thumb="http://image.tmdb.org/t/p/original/u8auv1S92EtCLfqC0Ov6nugljUc.jpg"/><Role id="25216" filter="actor=25216" tag="Anne Dyson" role="The Queen"/><Role id="25217" filter="actor=25217" tag="Margery Mason" role="The Ancient Booer" thumb="http://image.tmdb.org/t/p/original/A1nJN61RozmvjqJQrHXfHM7F03W.jpg"/><Role id="25218" filter="actor=25218" tag="Malcolm Storry" role="Yellin"/><Role id="25219" filter="actor=25219" tag="Betsy Brantley" role="The Mother" thumb="http://image.tmdb.org/t/p/original/sAJuozmEy1eoD84yeHPdCu50c3p.jpg"/><Role id="25220" filter="actor=25220" tag="Paul Badger" role="The Assistant Brute"/><Role id="25221" filter="actor=25221" tag="Errol Bennett" role="The Balladeer's Percussionist (uncredited)"/><Role id="25222" filter="actor=25222" tag="Willy DeVille" role="The Balladeer (voice) (uncredited)"/><Role id="25223" filter="actor=25223" tag="Mickey Feat" role="The Balladeer's Bassist (uncredited)"/><Role id="25224" filter="actor=25224" tag="Guy Fletcher" role="The Balladeer's Keyboardist (uncredited)"/><Role id="25225" filter="actor=25225" tag="Mark Knopfler" role="The Balladeer's Guitarist (uncredited)" thumb="http://image.tmdb.org/t/p/original/6UIzqRqYBkJ24QtOfT1e8it2W16.jpg"/><Role id="25226" filter="actor=25226" tag="Jamie Lane" role="The Balladeer's Drummer (uncredited)"/><Role id="25227" filter="actor=25227" tag="Sallie McLaughlin" role="(uncredited)"/><Role id="25228" filter="actor=25228" tag="Derek Pykett" role="Villager (uncredited)"/><Extras size="1"><Video ratingKey="47991" key="/library/metadata/47991" guid="iva://api.internetvideoarchive.com/2.0/DataService/VideoAssets(637)?lang=en&bitrates=80,212,450,600,750,1500,2500,5000,8000&duration=136&adaptive=1&dts=0" type="clip" title="The Princess Bride" titleSort="Princess Bride" summary="" index="1" year="1999" thumb="/library/metadata/47991/thumb/-1" duration="136000" originallyAvailableAt="1999-09-27" extraType="1"><Media videoResolution="1080" id="142641" duration="136000" width="1920" height="1080" aspectRatio="1.78" audioCodec="aac" videoCodec="h264" container="mp4" premium="1"><Part id="146820" duration="136000" container="mp4" key="/services/iva/assets/637/video.mp4?bitrate=2500" optimizedForStreaming="1"><Stream id="288973" streamType="1" codec="h264" index="0" height="1080" width="1920"/><Stream id="288974" streamType="2" selected="1" codec="aac" index="1" channels="2" language="English" languageCode="eng"/></Part></Media><Media videoResolution="720" id="142642" duration="136000" bitrate="1500000" width="1280" height="720" aspectRatio="1.78" audioCodec="aac" videoCodec="h264" container="mp4" premium="1"><Part id="146821" duration="136000" container="mp4" key="/services/iva/assets/637/video.mp4?bitrate=1500" optimizedForStreaming="1"><Stream id="288975" streamType="1" codec="h264" index="0" bitrate="1500000" height="720" width="1280"/><Stream id="288976" streamType="2" selected="1" codec="aac" index="1" channels="2" language="English" languageCode="eng"/></Part></Media><Media videoResolution="480" id="142643" duration="136000" bitrate="450000" width="640" height="480" aspectRatio="1.33" audioCodec="aac" videoCodec="h264" container="mp4" premium="1"><Part id="146822" duration="136000" container="mp4" key="/services/iva/assets/637/video.mp4?bitrate=450" optimizedForStreaming="1"><Stream id="288977" streamType="1" codec="h264" index="0" bitrate="450000" height="480" width="640"/><Stream id="288978" streamType="2" selected="1" codec="aac" index="1" channels="2" language="English" languageCode="eng"/></Part></Media></Video></Extras></Video></MediaContainer>

#13

@Quantafac

Are you certain these logs are current?

The most recent date in them is over 30 days old.

Jun 11, 2017 13:01:25.654 [0x7f1cc13fe700] DEBUG - Auth: We found auth token (xxxxxxxxxxxxxxxxxxxx), enabling token-based authentication.
Jun 11, 2017 13:01:25.654 [0x7f1cc13fe700] DEBUG - Auth: authenticated user 1 as martinfrojd
Jun 11, 2017 13:01:25.654 [0x7f1cc13fe700] DEBUG - Auth: Came in with a super-token, authorization succeeded.

#14

Hi there, i think i have the same problem here,

Let me describe in details

PMS 1.7.5.4035 on Ubuntu 16.04.2 LTS (uptodate) on HyperV Virtual Machine - Core i7 3770 - 2Vcores - VRam : 4Gb.

Downloaded a youtube video using youtube-dl - got a webm file - vp8 - Vorbis (Youtube does not yet support remember last position!)
https://www.youtube.com/watch?v=cGnMCv-85Ew&list=PLMwDGj-9r3hyN_VCCSlLG5ZqgFs3F4p4L&index=1

When playing this file using direct play (no transcoding) it works fine (tested in chrome and on Nvidia shield TV with Direct Play set to Forced).

When using transcoder it fails

Logs here :
Jul 14, 2017 14:16:50.385 [0x7fad427ff700] DEBUG - Request: [192.168.112.76:55977 (Allowed Network)] GET /photo/:/transcode?url=%2Flibrary%2Fmetadata%2F96919%2Fthumb%2F1499897762&width=70&height=39&minSize=1 (10 live) GZIP Signed-in
Jul 14, 2017 14:16:50.385 [0x7fad427ff700] DEBUG - Photo transcoder: Request for url /library/metadata/96919/thumb/1499897762
Jul 14, 2017 14:16:50.386 [0x7fad427ff700] DEBUG - Content-Length of /var/lib/plexmediaserver/Library/Application Support/Plex Media Server/Cache/PhotoTranscoder/6f/6f642eb1d33c9bafd840a4364918bf9e73a26b88.jpg is 1818.
Jul 14, 2017 14:16:50.388 [0x7fad44ffe700] DEBUG - Completed: [192.168.112.76:55977] 200 GET /photo/:/transcode?url=%2Flibrary%2Fmetadata%2F96919%2Fthumb%2F1499897762&width=70&height=39&minSize=1 (10 live) GZIP 2ms 1818 bytes (pipelined: 15)
Jul 14, 2017 14:16:50.463 [0x7fad38fff700] DEBUG - Request: [192.168.112.76:55977 (Allowed Network)] GET /video/:/transcode/universal/decision?hasMDE=1&path=%2Flibrary%2Fmetadata%2F96918&mediaIndex=0&partIndex=0&protocol=http&fastSeek=1&directPlay=0&directStream=1&subtitleSize=100&audioBoost=100&location=lan&maxVideoBitrate=320&videoQuality=30&videoResolution=420x240&session=psdxofsxpeohcawmgn5a76sa&offset=0&subtitles=burn&copyts=1&Accept-Language=fr (10 live) GZIP Signed-in
Jul 14, 2017 14:16:50.463 [0x7fad38fff700] DEBUG - Found session GUID of psdxofsxpeohcawmgn5a76sa in session start.
Jul 14, 2017 14:16:50.463 [0x7fad38fff700] DEBUG - TranscodeUniversalRequest: using profile Web
Jul 14, 2017 14:16:50.464 [0x7fad38fff700] DEBUG - Downloading document http://127.0.0.1:32400/library/metadata/96918?includeBandwidths=1&X-Plex-Session-Identifier=ft9etcts1mik923g0caaygfd
Jul 14, 2017 14:16:50.465 [0x7fad38fff700] DEBUG - Auth: We found auth token (xxxxxxxxxxxxxxxxxxxx), enabling token-based authentication.
Jul 14, 2017 14:16:50.465 [0x7fad38fff700] DEBUG - Auth: Came in with the master token, authorization succeeded.
Jul 14, 2017 14:16:50.473 [0x7fad38fff700] DEBUG - We're going to try to auto-select an audio stream for account 1.
Jul 14, 2017 14:16:50.473 [0x7fad38fff700] DEBUG - Selecting best audio stream for part ID 158309 (autoselect: 0 language: en)
Jul 14, 2017 14:16:50.473 [0x7fad38fff700] DEBUG - Audio Stream: 241150, Subtitle Stream: -1
Jul 14, 2017 14:16:50.474 [0x7fad38fff700] DEBUG - MDE: analyzing media item 158237
Jul 14, 2017 14:16:50.474 [0x7fad38fff700] DEBUG - MDE: E1 - The New Soccer Star: Direct Play is disabled
Jul 14, 2017 14:16:50.474 [0x7fad38fff700] DEBUG - MDE: E1 - The New Soccer Star: no direct play video profile exists for http/mkv/vp8
Jul 14, 2017 14:16:50.474 [0x7fad38fff700] DEBUG - MDE: E1 - The New Soccer Star: no direct play video profile exists for http/mkv/vp8/vorbis
Jul 14, 2017 14:16:50.475 [0x7fad38fff700] DEBUG - The New Soccer Star - video.width limitation applies: 480 > 420
Jul 14, 2017 14:16:50.475 [0x7fad38fff700] DEBUG - MDE: E1 - The New Soccer Star: no remuxable profile found, so video stream will be transcoded
Jul 14, 2017 14:16:50.475 [0x7fad38fff700] DEBUG - Scaled up video bitrate to 1087Kbps based on 1.500000x fudge factor.
Jul 14, 2017 14:16:50.475 [0x7fad38fff700] DEBUG - Scaled maximum bitrate for resolution reduction to 483Kbps.
Jul 14, 2017 14:16:50.475 [0x7fad38fff700] DEBUG - MDE: Captain Tsubasa - S1 E1 - The New Soccer Star: selected media 0 / 158237
Jul 14, 2017 14:16:50.475 [0x7fad38fff700] DEBUG - Streaming Resource: Changing decision parameters to fit bandwidth limit of 320kbps
Jul 14, 2017 14:16:50.475 [0x7fad38fff700] DEBUG - MDE: analyzing media item 158237
Jul 14, 2017 14:16:50.475 [0x7fad38fff700] DEBUG - MDE: E1 - The New Soccer Star: Direct Play is disabled
Jul 14, 2017 14:16:50.475 [0x7fad38fff700] DEBUG - MDE: E1 - The New Soccer Star: no direct play video profile exists for http/mkv/vp8
Jul 14, 2017 14:16:50.475 [0x7fad38fff700] DEBUG - MDE: E1 - The New Soccer Star: no direct play video profile exists for http/mkv/vp8/vorbis
Jul 14, 2017 14:16:50.475 [0x7fad38fff700] DEBUG - The New Soccer Star - video.width limitation applies: 480 > 420
Jul 14, 2017 14:16:50.476 [0x7fad38fff700] DEBUG - MDE: E1 - The New Soccer Star: Direct Streaming is disabled, so video stream will be transcoded
Jul 14, 2017 14:16:50.476 [0x7fad38fff700] DEBUG - MDE: E1 - The New Soccer Star: no remuxable profile found, so video stream will be transcoded
Jul 14, 2017 14:16:50.476 [0x7fad38fff700] DEBUG - Scaled up video bitrate to 1087Kbps based on 1.500000x fudge factor.
Jul 14, 2017 14:16:50.476 [0x7fad38fff700] DEBUG - Scaled maximum bitrate for resolution reduction to 483Kbps.
Jul 14, 2017 14:16:50.476 [0x7fad38fff700] DEBUG - MDE: E1 - The New Soccer Star: Audio Direct Streaming is disabled, so video's audio stream will be transcoded
Jul 14, 2017 14:16:50.476 [0x7fad38fff700] DEBUG - MDE: Captain Tsubasa - S1 E1 - The New Soccer Star: selected media 0 / 158237
Jul 14, 2017 14:16:50.476 [0x7fad38fff700] DEBUG - Streaming Resource: Reducing playback quality for 304kbps stream bitrate: video resolution to 160x120, audio channels to 1
Jul 14, 2017 14:16:50.476 [0x7fad38fff700] DEBUG - MDE: analyzing media item 158237
Jul 14, 2017 14:16:50.476 [0x7fad38fff700] DEBUG - MDE: E1 - The New Soccer Star: Direct Play is disabled
Jul 14, 2017 14:16:50.476 [0x7fad38fff700] DEBUG - MDE: E1 - The New Soccer Star: no direct play video profile exists for http/mkv/vp8
Jul 14, 2017 14:16:50.476 [0x7fad38fff700] DEBUG - MDE: E1 - The New Soccer Star: no direct play video profile exists for http/mkv/vp8/vorbis
Jul 14, 2017 14:16:50.476 [0x7fad38fff700] DEBUG - The New Soccer Star - video.width limitation applies: 480 > 160
Jul 14, 2017 14:16:50.476 [0x7fad38fff700] DEBUG - The New Soccer Star - audio.channels limitation applies: 2 > 1
Jul 14, 2017 14:16:50.477 [0x7fad38fff700] DEBUG - MDE: E1 - The New Soccer Star: Direct Streaming is disabled, so video stream will be transcoded
Jul 14, 2017 14:16:50.477 [0x7fad38fff700] DEBUG - MDE: E1 - The New Soccer Star: no remuxable profile found, so video stream will be transcoded
Jul 14, 2017 14:16:50.477 [0x7fad38fff700] DEBUG - Scaled up video bitrate to 1087Kbps based on 1.500000x fudge factor.
Jul 14, 2017 14:16:50.477 [0x7fad38fff700] DEBUG - Scaled maximum bitrate for resolution reduction to 120Kbps.
Jul 14, 2017 14:16:50.477 [0x7fad38fff700] DEBUG - MDE: E1 - The New Soccer Star: Audio Direct Streaming is disabled, so video's audio stream will be transcoded
Jul 14, 2017 14:16:50.477 [0x7fad38fff700] DEBUG - MDE: Captain Tsubasa - S1 E1 - The New Soccer Star: selected media 0 / 158237
Jul 14, 2017 14:16:50.477 [0x7fad38fff700] DEBUG - Streaming Resource: Adding session 0x7fad34f02ce0:ft9etcts1mik923g0caaygfd which is using transcoder slot. Used slots is now 1
Jul 14, 2017 14:16:50.477 [0x7fad38fff700] DEBUG - Streaming Resource: Added session 0x7fad34f02ce0:ft9etcts1mik923g0caaygfd
Jul 14, 2017 14:16:50.477 [0x7fad38fff700] DEBUG - Streaming Resource: Reached Decision id=96918 codes=(General=1001,Direct play not available; Conversion OK. Direct Play=3000,App cannot direct play this item. Direct play is disabled. Transcode=1001,Direct play not available; Conversion OK.) media=(id=158237 part=(id=158309 decision=transcode container=mkv protocol=http streams=(Video=(id=241149 decision=transcode bitrate=120 encoder=libx264 width=160 height=120) Audio=(id=241150 decision=transcode bitrate=72 encoder=aac channels=1 rate=44100))))
Jul 14, 2017 14:16:50.479 [0x7fad457ff700] DEBUG - Completed: [192.168.112.76:55977] 200 GET /video/:/transcode/universal/decision?hasMDE=1&path=%2Flibrary%2Fmetadata%2F96918&mediaIndex=0&partIndex=0&protocol=http&fastSeek=1&directPlay=0&directStream=1&subtitleSize=100&audioBoost=100&location=lan&maxVideoBitrate=320&videoQuality=30&videoResolution=420x240&session=psdxofsxpeohcawmgn5a76sa&offset=0&subtitles=burn&copyts=1&Accept-Language=fr (10 live) GZIP 16ms 1360 bytes (pipelined: 16)
Jul 14, 2017 14:16:50.497 [0x7fad467ff700] DEBUG - Request: [192.168.112.76:55977 (Allowed Network)] GET /video/:/transcode/universal/start?hasMDE=1&path=%2Flibrary%2Fmetadata%2F96918&mediaIndex=0&partIndex=0&protocol=http&fastSeek=1&directPlay=0&directStream=1&subtitleSize=100&audioBoost=100&location=lan&maxVideoBitrate=320&videoQuality=30&videoResolution=420x240&session=psdxofsxpeohcawmgn5a76sa&offset=0&subtitles=burn&copyts=1&Accept-Language=fr (10 live) Signed-in
Jul 14, 2017 14:16:50.497 [0x7fad467ff700] DEBUG - Found session GUID of psdxofsxpeohcawmgn5a76sa in session start.
Jul 14, 2017 14:16:50.497 [0x7fad467ff700] DEBUG - TranscodeUniversalRequest: using profile Web
Jul 14, 2017 14:16:50.498 [0x7fad467ff700] DEBUG - Downloading document http://127.0.0.1:32400/library/metadata/96918?checkFiles=1&includeBandwidths=1&X-Plex-Session-Identifier=ft9etcts1mik923g0caaygfd
Jul 14, 2017 14:16:50.499 [0x7fad467ff700] DEBUG - Auth: We found auth token (xxxxxxxxxxxxxxxxxxxx), enabling token-based authentication.
Jul 14, 2017 14:16:50.499 [0x7fad467ff700] DEBUG - Auth: Came in with the master token, authorization succeeded.
Jul 14, 2017 14:16:50.506 [0x7fad467ff700] DEBUG - Media part for /media/matou/shared/EnfantsCourts/Olive Et Tom/Olive et Tom - Episode 01 - La rencontre.webm previously failed BIF generation with the same FFMPEG version (46b03cf-1241), skipping BIF generation
Jul 14, 2017 14:16:50.508 [0x7fad467ff700] DEBUG - We're going to try to auto-select an audio stream for account 1.
Jul 14, 2017 14:16:50.508 [0x7fad467ff700] DEBUG - Selecting best audio stream for part ID 158309 (autoselect: 0 language: en)
Jul 14, 2017 14:16:50.508 [0x7fad467ff700] DEBUG - Audio Stream: 241150, Subtitle Stream: -1
Jul 14, 2017 14:16:50.509 [0x7fad467ff700] DEBUG - Cleaning directory for session psdxofsxpeohcawmgn5a76sa ()
Jul 14, 2017 14:16:50.510 [0x7fad467ff700] DEBUG - Starting a transcode session psdxofsxpeohcawmgn5a76sa at offset -1.0 (state=3)
Jul 14, 2017 14:16:50.512 [0x7fad467ff700] DEBUG - [Universal] Using local file path instead of URL: /media/matou/shared/EnfantsCourts/Olive Et Tom/Olive et Tom - Episode 01 - La rencontre.webm
Jul 14, 2017 14:16:50.512 [0x7fad467ff700] DEBUG - TPU: hardware transcoding: zero-copy support not present
Jul 14, 2017 14:16:50.514 [0x7fad467ff700] DEBUG - Job running: EAE_ROOT='/tmp/pms-34b6b54a-69b1-405d-9497-25182c6190c1/EasyAudioEncoder' FFMPEG_EXTERNAL_LIBS='/var/lib/plexmediaserver/Library/Application\ Support/Plex\ Media\ Server/Codecs/46b03cf-1241-linux-ubuntu-x86_64/' XDG_CACHE_HOME='/var/lib/plexmediaserver/Library/Application Support/Plex Media Server/Cache/' XDG_DATA_HOME='/usr/lib/plexmediaserver/Resources/' X_PLEX_TOKEN='xxxxxxxxxxxxxxxxxxxx' '/usr/lib/plexmediaserver/Plex Transcoder' '-codec:0' 'vp8' '-codec:1' 'vorbis' '-i' '/media/matou/shared/EnfantsCourts/Olive Et Tom/Olive et Tom - Episode 01 - La rencontre.webm' '-filter_complex' '[0:0]scale=w=160:h=120,format=pix_fmts=yuv420p|nv12[0]' '-map' '[0]' '-codec:0' 'libx264' '-crf:0' '22' '-maxrate:0' '120k' '-bufsize:0' '240k' '-r:0' '25' '-preset:0' 'veryfast' '-x264opts:0' 'subme=2:me_range=4:rc_lookahead=10:me=dia:no_chroma_me:8x8dct=0:partitions=none' '-map' '0:1' '-codec:1' 'aac' '-ar:1' '44100' '-channel_layout:1' 'mono' '-b:1' '72k' '-f' 'segment' '-segment_format' 'matroska' '-segment_format_options' 'live=1' '-segment_time' '1' '-segment_header_filename' 'header' '-segment_start_number' '0' '-segment_list' 'http://127.0.0.1:32400/video/:/transcode/session/psdxofsxpeohcawmgn5a76sa/51fbc942-680e-415b-a57b-a3b32a4b11a4/seglist' '-segment_list_type' 'csv' '-segment_list_size' '2147483647' '-avoid_negative_ts' 'disabled' '-map_metadata' '-1' '-map_chapters' '-1' 'chunk-%05d' '-start_at_zero' '-copyts' '-y' '-nostats' '-loglevel' 'quiet' '-loglevel_plex' 'error' '-progressurl' 'http://127.0.0.1:32400/video/:/transcode/session/psdxofsxpeohcawmgn5a76sa/51fbc942-680e-415b-a57b-a3b32a4b11a4/progress'
Jul 14, 2017 14:16:50.612 [0x7fad44ffe700] DEBUG - Auth: We found auth token (xxxxxxxxxxxxxxxxxxxx), enabling token-based authentication.
Jul 14, 2017 14:16:50.612 [0x7fad44ffe700] DEBUG - Auth: Came in with the master token, authorization succeeded.
Jul 14, 2017 14:16:50.612 [0x7fad3a7fc700] DEBUG - Request: [127.0.0.1:43578 (Loopback)] PUT /video/:/transcode/session/psdxofsxpeohcawmgn5a76sa/51fbc942-680e-415b-a57b-a3b32a4b11a4/progress/stream?index=0&id=0&codec=vp8&type=video (11 live) Signed-in Token (plex@codingf.net)
Jul 14, 2017 14:16:50.613 [0x7fad44ffe700] DEBUG - Completed: [127.0.0.1:43578] 206 PUT /video/:/transcode/session/psdxofsxpeohcawmgn5a76sa/51fbc942-680e-415b-a57b-a3b32a4b11a4/progress/stream?index=0&id=0&codec=vp8&type=video (11 live) 0ms 227 bytes
Jul 14, 2017 14:16:50.614 [0x7fad44ffe700] DEBUG - Auth: We found auth token (xxxxxxxxxxxxxxxxxxxx), enabling token-based authentication.
Jul 14, 2017 14:16:50.614 [0x7fad44ffe700] DEBUG - Auth: Came in with the master token, authorization succeeded.
Jul 14, 2017 14:16:50.614 [0x7fad445e2700] DEBUG - Request: [127.0.0.1:43580 (Loopback)] PUT /video/:/transcode/session/psdxofsxpeohcawmgn5a76sa/51fbc942-680e-415b-a57b-a3b32a4b11a4/progress/stream?index=1&id=0&codec=vorbis&type=audio (12 live) Signed-in Token (plex@codingf.net)
Jul 14, 2017 14:16:50.615 [0x7fad44ffe700] DEBUG - Completed: [127.0.0.1:43580] 206 PUT /video/:/transcode/session/psdxofsxpeohcawmgn5a76sa/51fbc942-680e-415b-a57b-a3b32a4b11a4/progress/stream?index=1&id=0&codec=vorbis&type=audio (12 live) 0ms 227 bytes
Jul 14, 2017 14:16:50.791 [0x7fad40fff700] DEBUG - JobManager: child process killed by signal: 11 (Segmentation fault)
Jul 14, 2017 14:16:50.791 [0x7fad40fff700] DEBUG - Jobs: '/usr/lib/plexmediaserver/Plex Transcoder' exit code for process 44560 is -11
Jul 14, 2017 14:16:50.791 [0x7fad40fff700] DEBUG - Streaming Resource: Terminating session 0x7fad34f02ce0:ft9etcts1mik923g0caaygfd which is using transcoder slot. Used slots is now 0
Jul 14, 2017 14:16:50.791 [0x7fad40fff700] DEBUG - Streaming Resource: Terminated session 0x7fad34f02ce0:ft9etcts1mik923g0caaygfd with reason Conversion failed. The transcoder crashed or failed to start up.
Jul 14, 2017 14:16:50.791 [0x7fad467ff700] DEBUG - Using default transcode duration of 120 minutes
Jul 14, 2017 14:16:50.791 [0x7fad467ff700] DEBUG - Started session successfully: psdxofsxpeohcawmgn5a76sa
Jul 14, 2017 14:16:50.792 [0x7fad467ff700] ERROR - [TranscodeOutputStream] Streaming Session 0x7fad34f02ce0 appears to have died from under us
Jul 14, 2017 14:16:50.792 [0x7fad24fff700] DEBUG - Killing job.
Jul 14, 2017 14:16:50.792 [0x7fad24fff700] DEBUG - Signalling job ID 44560 with 9
Jul 14, 2017 14:16:50.792 [0x7fad24fff700] DEBUG - Job was already killed, not killing again.
Jul 14, 2017 14:16:50.792 [0x7fad24fff700] DEBUG - Stopping transcode session psdxofsxpeohcawmgn5a76sa
Jul 14, 2017 14:16:50.792 [0x7fad24fff700] DEBUG - Cleaning directory for session psdxofsxpeohcawmgn5a76sa (/var/lib/plexmediaserver/Library/Application Support/Plex Media Server/Cache/Transcode/Sessions/plex-transcode-psdxofsxpeohcawmgn5a76sa-51fbc942-680e-415b-a57b-a3b32a4b11a4)
Jul 14, 2017 14:16:50.793 [0x7fad24fff700] DEBUG - Transcoder: Cleaning old transcode directories.

Other Informations :
Transcoder works great when transcoding other files : H264, HEVC, MPEG4.

I hope this can helps

Regards.


#15

@ChuckPA
I thought those were the most current. I will go through the reboot, test, download logs process again as soon as I get home.


#16

@ChuckPA
Here are the logs from just a few minutes ago, I restarted the service on the server, then waited a few minutes, tried playing 3 different VP8 files (which failed) then a different one (that works). Do you need the XML for the files I tried?


#17

That's great where it's at. I'm going to talk to the transcoding team. There was discussion about the VP8 codec in the past. I forget what the outcome was and where it's at currently.


#18

The transcoder team responded almost immediately.

May they have samples please (enough to reproduce the fault) ?

It will let me verify and them diagnose why it's doing it

To confirm. Pure VP8 codec samples. https://support.plex.tv/hc/en-us/articles/201035968-Generating-Sample-Files-from-Media


#19

@ChuckPA

Here is a sample of one of the videos. I get the error immediately. It never starts the file at all. Let me know if you need more or if the sample is no good.


#20

Thank you. I am able to verify locally.
I have written this up and submitted it.

Please leave the logs and sample file here as I have linked this thread as the source for the sample file and logs they will need.