Live TV via Android won't play - Bandwidth Exceeded and Failed to Find SRM Session errors

Live TV & DVR
, ,
1

Server Version#: 1.32.0.6918 (Ubuntu)
Player Version#: 9.20.0.806 (Android)
Tuner Make/Model: XTEVE (Slinger)
Guide/Lineup name: WOW Detroit

Recently my Plex Live TV has stopped working. At the beginning it played on both Windows and Android, then only Android, and now nothing. Visually the app just constantly has the buffering wheel. In the logs I found two interesting pieces. The first involves a bandwidth setting:

Apr 18, 2023 14:38:55.356 [0x7fbc9f2f4b38] Warning — [Req#85a4/Transcode] Streaming Resource: Bandwidth exceeded: 40000 kbps > 4000 kbps
Apr 18, 2023 14:38:55.357 [0x7fbc9f2f4b38] Error — Got exception from request handler: Invalid argument
Apr 18, 2023 14:38:55.397 [0x7fbc9f2f4b38] Debug — [Req#85c9/Transcode/e3c141b9-2a2e-481d-bd65-5e2a168f4437/e6d82fad-d8a4-4ddf-8ad3-4fee4d8de6b4] Transcoder segment range: 0 - 8 (7)

…and the second involved a missing “SRM Session”.

Apr 18, 2023 14:39:02.189 [0x7fbc9f2f4b38] Debug — Request: [[IP obscured] (WAN)] GET /livetv/sessions/e3c141b9-2a2e-481d-bd65-5e2a168f4437/cdd8a85085ae2c35-com-plexapp-android/index.m3u8?autoAdjustQuality=1&hasMDE=1&location=cellular&mediaBufferSize=74944&offset=-1.000000 (12 live) #862c TLS GZIP Signed-in Token ([username obscured]) ([devicename obscured])

Apr 18, 2023 14:39:02.189 [0x7fbc9f2f4b38] Warning — [Req#862c/Live/e3c141b9-2a2e-481d-bd65-5e2a168f4437/cdd8a85085ae2c35-com-plexapp-android] Failed to find SRM session cdd8a85085ae2c35-com-plexapp-android

I assume one causes the other? The bandwidth one is interesting. I have the beta “Auto-Adjust Quality” set on the app and a 4Mbps upload cap on the server. I don’t even know where I would set something to 40,000kbps.

The back-end stuff all appears to be working, xteve is triggering slinger, slinger shows a stream connected the whole time the app is open and showing the buffering screen, when I back out of the app slinger shows the connection closes. So I’m guessing it’s a Plex server setting, and something not in the GUI.

How can I fix it?

2

For completeness, I upgraded to the latest server (v. 1.32.0.6950) and tried from Windows. I got different errors here. The viewer GUI reports:

Error code: s1001 (Network)

It’s most likely not a network error, as I’m attempting to view from inside a LAN. I also successfully pinged the destination IP from the linux box (as it is in a different subnet and I wanted to be sure).

The whole block from the log looks like this but ends in an Exception from Request Handler:

Apr 18, 2023 16:03:22.787 [0x7f40d5501b38] Debug — Request: [10.21.2.2:58543 (WAN)] GET /video/:/transcode/universal/start.mpd?hasMDE=1&path=%2Flivetv%2Fsessions%2F74c542fc-bceb-4192-afc0-fa46d67c12c5&mediaIndex=0&partIndex=0&protocol=dash&fastSeek=1&directPlay=0&directStream=0&subtitleSize=100&audioBoost=100&location=lan&maxVideoBitrate=4000&session=px110lwdysbdjye7h47kv07n&offset=0&subtitles=burn&copyts=0&Accept-Language=en (10 live) #16ff TLS GZIP Signed-in Token ([username obscured]) ([devicename obscured])
Apr 18, 2023 16:03:22.787 [0x7f40d5501b38] Debug — [Req#16ff/Transcode] Found session GUID of px110lwdysbdjye7h47kv07n in session start.
Apr 18, 2023 16:03:22.787 [0x7f40d5501b38] Debug — [Req#16ff/Transcode] TranscodeUniversalRequest: adapting profile with augmentation data: add-limitation(scope=videoCodec&scopeName=*&type=upperBound&name=video.bitrate&value=4000&replace=true)+append-transcode-target-codec(type=videoProfile&context=streaming&audioCodec=aac&protocol=dash)
Apr 18, 2023 16:03:22.787 [0x7f40d5501b38] Debug — [Req#16ff/Transcode] TranscodeUniversalRequest: using augmented profile Firefox
Apr 18, 2023 16:03:22.787 [0x7f40d5501b38] Debug — [Req#16ff/Transcode] Downloading document http://127.0.0.1:32400/livetv/sessions/74c542fc-bceb-4192-afc0-fa46d67c12c5?includeBandwidths=1&offset=0&X-Plex-Incomplete-Segments=1&X-Plex-Session-Identifier=jv5z47ekf2rpktz8iadoncuj
Apr 18, 2023 16:03:22.789 [0x7f40d5501b38] Debug — [Req#16ff/Transcode] We're going to try to auto-select an audio stream for account 1.
Apr 18, 2023 16:03:22.789 [0x7f40d5501b38] Debug — [Req#16ff/Transcode] Selecting best audio stream for part ID 1273 (language: en)
Apr 18, 2023 16:03:22.789 [0x7f40d5501b38] Debug — [Req#16ff/Transcode] We're going to try to auto-select a subtitle.
Apr 18, 2023 16:03:22.789 [0x7f40d5501b38] Debug — [Req#16ff/Transcode] Audio Stream: 3800, Subtitle Stream: -1
Apr 18, 2023 16:03:22.789 [0x7f40d5501b38] Debug — [Req#16ff/Transcode] Streaming Resource: Attempting to create AdHoc transcode session jv5z47ekf2rpktz8iadoncuj
Apr 18, 2023 16:03:22.789 [0x7f40d5501b38] Error — Got exception from request handler: Invalid argument
Apr 18, 2023 16:03:23.911 [0x7f40d5501b38] Debug — [Req#172d/Transcode/74c542fc-bceb-4192-afc0-fa46d67c12c5/0e983ef1-e929-4e5a-a178-48487d554288] Transcoder segment range: 0 - 20 (19)

So two very different errors. For the record, these both worked about 2 months ago. Thoughts?

3

No ideas? Can anyone at least tell me where the appropriate configs would be on Ubuntu so I can go digging manually?

4

I’m going to take a guess here. You have bandwidth limit set in remote access… and you have video transcoding disabled.

I’m gonna take another guess here that your client app isn’t on the same local subnet as the server… it literally says WAN in your first log post.

5

There’s only one NIC on the server, so it probably just assumes it’s WAN.

The Windows test was on same LAN same subnet. The Android test was from the Internet via a port forward from the firewall.

“Internet streaming video quality” is set to 2mbps. “Automatically adjust quality (beta)” is on.

Tried again on Windows (same LAN), same result.

Apr 23, 2023 04:02:18.554 [0x7f608fd16b38] Debug — [Req#629/Transcode] Streaming Resource: Attempting to create AdHoc transcode session zor8aax49ti62d5v2rhhvv17
Apr 23, 2023 04:02:18.555 [0x7f608fd16b38] Error — Got exception from request handler: Invalid argument

Result was the same for Android via the internet:

Apr 23, 2023 04:05:29.139 [0x7f608ee17b38] Debug — Request: [172.56.104.170:62325 (WAN)] GET /livetv/sessions/2f9ebd9e-21a5-4aeb-b6f4-bb5ee3c92e1e/cdd8a85085ae2c35-com-plexapp-android/index.m3u8?autoAdjustQuality=1&hasMDE=1&location=cellular&mediaBufferSize=74944&offset=-1.000000 (15 live) #1a3b TLS GZIP Signed-in Token (muji58) (Jason's S20FE)
Apr 23, 2023 04:05:29.139 [0x7f608ee17b38] Warning — [Req#1a3b/Live/2f9ebd9e-21a5-4aeb-b6f4-bb5ee3c92e1e/cdd8a85085ae2c35-com-plexapp-android] Failed to find SRM session cdd8a85085ae2c35-com-plexapp-android

Other things I’ve tried:

  • Disabled “Direct Play” and “Direct stream” under Plex Web / Debug
  • Upgraded to 1.32.0.6973

No change.

6

For completeness, I turned off “Automatically adjust quality (beta)” and disabled “Home Streaming” and changed it to 4Mbps. I did this in case it was getting confused. Same result (Network error) on the Windows side, but the logs are different:

Apr 23, 2023 04:28:35.352 [0x7f6092f71b38] Debug — [Req#3142/Grabber/5fc76c027c6557002efca5cc-5fc705eb052f6f002ef46069-42mrjdq82mg4y1e92kydcd11] Grabber: Allocated a tuner on device://tv.plex.grabbers.hdhomerun/2022-11-BVLK-OBLUK1 (0 left)
Apr 23, 2023 04:28:35.352 [0x7f6092f71b38] Debug — [Req#3142/Grabber/5fc76c027c6557002efca5cc-5fc705eb052f6f002ef46069-42mrjdq82mg4y1e92kydcd11] We're going to try to auto-select an audio stream for account 1.
Apr 23, 2023 04:28:35.352 [0x7f6092f71b38] Debug — [Req#3142/Grabber/5fc76c027c6557002efca5cc-5fc705eb052f6f002ef46069-42mrjdq82mg4y1e92kydcd11] Selecting best audio stream for part ID -1 (language: en)
Apr 23, 2023 04:28:35.352 [0x7f6092f71b38] Debug — [Req#3142/Grabber/5fc76c027c6557002efca5cc-5fc705eb052f6f002ef46069-42mrjdq82mg4y1e92kydcd11] We're going to try to auto-select a subtitle.
Apr 23, 2023 04:28:35.353 [0x7f6092f71b38] Debug — [Req#3142/Grabber/5fc76c027c6557002efca5cc-5fc705eb052f6f002ef46069-42mrjdq82mg4y1e92kydcd11] Audio Stream: -1, Subtitle Stream: -1
Apr 23, 2023 04:28:35.353 [0x7f6092f71b38] Debug — [Req#3142/Grabber/5fc76c027c6557002efca5cc-5fc705eb052f6f002ef46069-42mrjdq82mg4y1e92kydcd11] MDE: Selected protocol hls; container: mpegts
Apr 23, 2023 04:28:35.353 [0x7f6092f71b38] Error — [Req#3142/Grabber/5fc76c027c6557002efca5cc-5fc705eb052f6f002ef46069-42mrjdq82mg4y1e92kydcd11] Unable to find title for item of type 5
Apr 23, 2023 04:28:35.353 [0x7f6092f71b38] Debug — [Req#3142/Grabber/5fc76c027c6557002efca5cc-5fc705eb052f6f002ef46069-42mrjdq82mg4y1e92kydcd11] MDE: analyzing media item -1
Apr 23, 2023 04:28:35.353 [0x7f6092f71b38] Debug — [Req#3142/Grabber/5fc76c027c6557002efca5cc-5fc705eb052f6f002ef46069-42mrjdq82mg4y1e92kydcd11] MDE: : no direct play video profile exists for http/mpegts/
Apr 23, 2023 04:28:35.353 [0x7f6092f71b38] Debug — [Req#3142/Grabber/5fc76c027c6557002efca5cc-5fc705eb052f6f002ef46069-42mrjdq82mg4y1e92kydcd11] MDE: : no direct play video profile exists for http/mpegts//
Apr 23, 2023 04:28:35.353 [0x7f6092f71b38] Debug — [Req#3142/Grabber/5fc76c027c6557002efca5cc-5fc705eb052f6f002ef46069-42mrjdq82mg4y1e92kydcd11] MDE: : codec is unavailable for analysis
Apr 23, 2023 04:28:35.353 [0x7f6092f71b38] Debug — [Req#3142/Grabber/5fc76c027c6557002efca5cc-5fc705eb052f6f002ef46069-42mrjdq82mg4y1e92kydcd11] MDE: : codec is unavailable for analysis
Apr 23, 2023 04:28:35.353 [0x7f6092f71b38] Error — [Req#3142/Grabber/5fc76c027c6557002efca5cc-5fc705eb052f6f002ef46069-42mrjdq82mg4y1e92kydcd11] Unable to find title for item of type 5
Apr 23, 2023 04:28:35.353 [0x7f6092f71b38] Debug — [Req#3142/Grabber/5fc76c027c6557002efca5cc-5fc705eb052f6f002ef46069-42mrjdq82mg4y1e92kydcd11] MDE: : selected media 0 / -1
7

This topic was automatically closed 90 days after the last reply. New replies are no longer allowed.