Only seems to happen in the browser? (mobile is currently broken and playback works fine through the channel on the TiVo itself in my testing).
Log just shows:
2019-07-20 11:52:49,641 (7fd0367fc700) : DEBUG (runtime:717) - Handling request GET /video/tivotogo/:/function/CreateVideoClipObject?function_args=<snippety-snip>&includeConcerts=1&includeExtras=1&includeOnDeck=1&includePopularLeaves=1&includePreferences=1&includeChapters=1&includeStations=1&includeExternalMedia=1&asyncAugmentMetadata=1&checkFiles=1
2019-07-20 11:52:49,644 (7fd0367fc700) : DEBUG (runtime:814) - Found route matching /video/tivotogo/:/function/CreateVideoClipObject
2019-07-20 11:52:49,645 (7fd0367fc700) : DEBUG (runtime:125) - Calling function 'CreateVideoClipObject'
2019-07-20 11:52:49,646 (7fd0367fc700) : DEBUG (__init__:178) - Starting a thread
2019-07-20 11:52:49,646 (7fd0367fc700) : DEBUG (__init__:180) - Done starting a thread
2019-07-20 11:52:49,647 (7fd0377fe700) : INFO (__init__:378) - Server already running or port in use
2019-07-20 11:52:49,648 (7fd0367fc700) : WARNING (runtime:1065) - Generating a callback path for a function with no route: <function CreateVideoClipObject at 0x7fd05458c6e0>
2019-07-20 11:52:49,654 (7fd0367fc700) : DEBUG (runtime:88) - Sending packed state data (109 bytes)
2019-07-20 11:52:49,655 (7fd0367fc700) : DEBUG (runtime:924) - Response: [200] MediaContainer, 1708 bytes
2019-07-20 11:52:49,694 (7fd0367fc700) : DEBUG (runtime:717) - Handling request GET /video/tivotogo/:/function/CreateVideoClipObject?function_args=<snippety-snip>&includeBandwidths=1&offset=-1
2019-07-20 11:52:49,698 (7fd0367fc700) : DEBUG (runtime:814) - Found route matching /video/tivotogo/:/function/CreateVideoClipObject
2019-07-20 11:52:49,699 (7fd0367fc700) : DEBUG (runtime:125) - Calling function 'CreateVideoClipObject'
2019-07-20 11:52:49,700 (7fd0367fc700) : DEBUG (__init__:178) - Starting a thread
2019-07-20 11:52:49,700 (7fd0367fc700) : DEBUG (__init__:180) - Done starting a thread
2019-07-20 11:52:49,701 (7fd0367fc700) : WARNING (runtime:1065) - Generating a callback path for a function with no route: <function CreateVideoClipObject at 0x7fd05458c6e0>
2019-07-20 11:52:49,701 (7fd0377fe700) : INFO (__init__:378) - Server already running or port in use
2019-07-20 11:52:49,707 (7fd0367fc700) : DEBUG (runtime:88) - Sending packed state data (109 bytes)
2019-07-20 11:52:49,707 (7fd0367fc700) : DEBUG (runtime:924) - Response: [200] MediaContainer, 1708 bytes
whereas a successful playback (via TiVo) looks the same except it continues with the encoder:
2019-07-20 11:54:20,389 (7fd0377fe700) : DEBUG (runtime:717) - Handling request GET /video/tivotogo/:/function/CreateVideoClipObject?function_args=<snippety-snip>&includeBandwidths=1&offset=-1
2019-07-20 11:54:20,391 (7fd0377fe700) : DEBUG (runtime:814) - Found route matching /video/tivotogo/:/function/CreateVideoClipObject
2019-07-20 11:54:20,391 (7fd0377fe700) : DEBUG (runtime:125) - Calling function 'CreateVideoClipObject'
2019-07-20 11:54:20,392 (7fd0377fe700) : DEBUG (__init__:178) - Starting a thread
2019-07-20 11:54:20,392 (7fd0377fe700) : DEBUG (__init__:180) - Done starting a thread
2019-07-20 11:54:20,392 (7fd0377fe700) : WARNING (runtime:1065) - Generating a callback path for a function with no route: <function CreateVideoClipObject at 0x7fd05458c6e0>
2019-07-20 11:54:20,392 (7fd017fff700) : INFO (__init__:378) - Server already running or port in use
2019-07-20 11:54:20,395 (7fd0377fe700) : DEBUG (runtime:88) - Sending packed state data (109 bytes)
2019-07-20 11:54:20,395 (7fd0377fe700) : DEBUG (runtime:924) - Response: [200] MediaContainer, 1708 bytes
2019-07-20 11:54:20,724 (7fd0377fe700) : DEBUG (runtime:717) - Handling request GET /video/tivotogo/:/function/CreateVideoClipObject?function_args=<snippety-snip>&includeBandwidths=1&offset=-1
2019-07-20 11:54:20,726 (7fd0377fe700) : DEBUG (runtime:814) - Found route matching /video/tivotogo/:/function/CreateVideoClipObject
2019-07-20 11:54:20,727 (7fd0377fe700) : DEBUG (runtime:125) - Calling function 'CreateVideoClipObject'
2019-07-20 11:54:20,727 (7fd0377fe700) : DEBUG (__init__:178) - Starting a thread
2019-07-20 11:54:20,727 (7fd0377fe700) : DEBUG (__init__:180) - Done starting a thread
2019-07-20 11:54:20,728 (7fd0377fe700) : WARNING (runtime:1065) - Generating a callback path for a function with no route: <function CreateVideoClipObject at 0x7fd05458c6e0>
2019-07-20 11:54:20,728 (7fd017fff700) : INFO (__init__:378) - Server already running or port in use
2019-07-20 11:54:20,734 (7fd0377fe700) : DEBUG (runtime:88) - Sending packed state data (109 bytes)
2019-07-20 11:54:20,735 (7fd0377fe700) : DEBUG (runtime:924) - Response: [200] MediaContainer, 1708 bytes
2019-07-20 11:54:20,784 (7fd0357fa700) : INFO (__init__:324) - GET URL: http://192.168.1.72:80/download/News%20Ch8%20at%206PM.TiVo?Container=%2FNowPlaying&id=71429
2019-07-20 11:54:20,784 (7fd0357fa700) : DEBUG (__init__:332) - CMD: "/usr/bin/curl" "http://192.168.1.72:80/download/News%20Ch8%20at%206PM.TiVo?Container=%2FNowPlaying&id=71429" --digest -s -u tivo:<snippety-snip> -c "/tmp/cookies.txt"
2019-07-20 11:54:20,789 (7fd0357fa700) : DEBUG (__init__:337) - PIPED to: "/usr/bin/java" -jar "/var/lib/plexmediaserver/Library/Application Support/Plex Media Server/Plug-ins/TiVoToGo.bundle/Contents/Resources/TivoDecoder.jar" -m <snippety-snip> -
2019-07-20 11:54:20,794 (7fd0357fa700) : INFO (__init__:346) - Starting decoder
With Plex removing support for plug-ins and channels, this could just be another sign of things breaking on the back-end and another nail in the coffin for this. ☹️
Reported originally here.
Only seems to happen in the browser? (mobile is currently broken and playback works fine through the channel on the TiVo itself in my testing).
Log just shows:
whereas a successful playback (via TiVo) looks the same except it continues with the encoder:
With Plex removing support for plug-ins and channels, this could just be another sign of things breaking on the back-end and another nail in the coffin for this. ☹️