Uncaught exception: System.Web.HttpException (0x80004005): File does not exist.

MrReis · 2016-10-18, 02:41 AM

Cannot stream live TV with NextPVR web server opened in a remote browser (IE & Chrome). The Home, Now, TV Guide, Recording and Scheduler pages all open OK.

I believe the following is are the relevant events from the NextPVR web log.

Code:
2016-10-17 18:16:37.102    [DEBUG][4]    Got Web Request (192.168.1.123): /modern/player.html    channel_id=8707&title=NBC%20Bay%20Area%20News%20at%206

2016-10-17 18:16:37.444    [DEBUG][3]    Got Web Request (192.168.1.123): /services/service    method=channel.transcode.initiate&channel_id=8707&profile=default&random=0.5659266267159626

2016-10-17 18:16:37.444    [DEBUG][3]    method=channel.transcode.initiate

2016-10-17 18:16:37.444    [DEBUG][3]    parameters: 

2016-10-17 18:16:37.446    [DEBUG][3]       method: channel.transcode.initiate

2016-10-17 18:16:37.446    [DEBUG][3]       channel_id: 8707

2016-10-17 18:16:37.446    [DEBUG][3]       profile: default

2016-10-17 18:16:37.446    [DEBUG][3]       random: 0.5659266267159626

2016-10-17 18:16:37.446    [DEBUG][3]       client_ip: 192.168.1.123

2016-10-17 18:16:37.446    [DEBUG][3]       host_callback: 192.168.1.88:8866

2016-10-17 18:16:37.446    [DEBUG][3]       physical_path: C:\Users\Public\NPVR\web\

2016-10-17 18:16:37.446    [DEBUG][3]       user_agent: Mozilla/5.0 (Windows NT 6.1; WOW64; Trident/7.0; rv:11.0) like Gecko

2016-10-17 18:16:37.446    [DEBUG][3]       range: 

2016-10-17 18:16:37.446    [DEBUG][3]       requested_path: /services/service

2016-10-17 18:16:37.446    [DEBUG][3]       verb: GET

2016-10-17 18:16:37.446    [DEBUG][3]       sid: default

2016-10-17 18:16:37.512    [ERROR][22]    [color=#FF0000]Uncaught exception: System.Web.HttpException (0x80004005): File does not exist[/color].

   at System.Web.StaticFileHandler.GetFileInfo(String virtualPathWithPathInfo, String physicalPath, HttpResponse response)

   at System.Web.StaticFileHandler.ProcessRequestInternal(HttpContext context, String overrideVirtualPath)

   at System.Web.DefaultHttpHandler.BeginProcessRequest(HttpContext context, AsyncCallback callback, Object state)

   at System.Web.HttpApplication.CallHandlerExecutionStep.System.Web.HttpApplication.IExecutionStep.Execute()

   at System.Web.HttpApplication.ExecuteStep(IExecutionStep step, Boolean& completedSynchronously)

Is the file that does not exist supposed to be a m3u8 file in "C:\Users\Public\NPVR\web\temp\?"

***sub*** · 2016-10-18, 03:03 AM

Can you post the whole log, so we can see what logging lines where happening on [22] prior to that?

MrReis · 2016-10-18, 03:24 AM

sub Wrote:Can you post the whole log, so we can see what logging lines where happening on [22] prior to that?

Thanks for asking. Is the following enough or do you need more?

Code:
2016-10-17 18:16:05.735    [DEBUG][3]    Got Web Request (192.168.1.123): /services/service    method=channel.list&group_id=All%20Channels&format=json&random=0.4001646517615609

2016-10-17 18:16:05.735    [DEBUG][3]    method=channel.list

2016-10-17 18:16:05.736    [DEBUG][3]    parameters: 

2016-10-17 18:16:05.736    [DEBUG][3]       method: channel.list

2016-10-17 18:16:05.736    [DEBUG][3]       group_id: All Channels

2016-10-17 18:16:05.736    [DEBUG][3]       format: json

2016-10-17 18:16:05.736    [DEBUG][3]       random: 0.4001646517615609

2016-10-17 18:16:05.736    [DEBUG][3]       client_ip: 192.168.1.123

2016-10-17 18:16:05.736    [DEBUG][3]       host_callback: 192.168.1.88:8866

2016-10-17 18:16:05.737    [DEBUG][3]       physical_path: C:\Users\Public\NPVR\web\

2016-10-17 18:16:05.737    [DEBUG][3]       user_agent: Mozilla/5.0 (Windows NT 6.1; WOW64; Trident/7.0; rv:11.0) like Gecko

2016-10-17 18:16:05.737    [DEBUG][3]       range: 

2016-10-17 18:16:05.737    [DEBUG][3]       requested_path: /services/service

2016-10-17 18:16:05.748    [DEBUG][3]       verb: GET

2016-10-17 18:16:05.748    [DEBUG][3]       sid: default

2016-10-17 18:16:05.814    [DEBUG][3]    {

"channels": [

  {

    "channelId": 8706,

    "channelNumber": 2,

    "channelMinor": 0,

    "channelNumberFormated": "2",

    "channelName": "KTVU",

    "channelIcon": true

  }

,

  {

    "channelId": 8707,

    "channelNumber": 3,

    "channelMinor": 0,

    "channelNumberFormated": "3",

    "channelName": "KNTV",

    "channelIcon": true

  }

,

  {

    "channelId": 8708,

    "channelNumber": 4,

    "channelMinor": 0,

    "channelNumberFormated": "4",

    "channelName": "KRON",

    "channelIcon": true

  }

,

  {

    "channelId": 8709,

    "channelNumber": 5,

    "channelMinor": 0,

    "channelNumberFormated": "5",

    "channelName": "KPIX",

    "channelIcon": true

  }

,

  {

    "channelId": 8710,

    "channelNumber": 6,

    "channelMinor": 0,

    "channelNumberFormated": "6",

    "channelName": "KICU",

    "channelIcon": true

  }

,

  {

    "channelId": 8711,

    "channelNumber": 7,

    "channelMinor": 0,

    "channelNumberFormated": "7",

    "channelName": "KGO",

    "channelIcon": true

  }

,

  {

    "channelId": 8712,

    "channelNumber": 8,

    "channelMinor": 0,

    "channelNumberFormated": "8",

    "channelName": "KTSF",

    "channelIcon": true

  }

,

  {

    "channelId": 8713,

    "channelNumber": 9,

    "channelMinor": 0,

    "channelNumberFormated": "9",

    "channelName": "KQED",

    "channelIcon": true

  }

,

  {

    "channelId": 8714,

    "channelNumber": 10,

    "channelMinor": 0,

    "channel...snip...

2016-10-17 18:16:06.428    [DEBUG][22]    Got Web Request (192.168.1.123): /services/service    method=channel.listings.current&format=json&random=0.11533776138187102

2016-10-17 18:16:06.428    [DEBUG][22]    method=channel.listings.current

2016-10-17 18:16:06.428    [DEBUG][22]    parameters: 

2016-10-17 18:16:06.429    [DEBUG][22]       method: channel.listings.current

2016-10-17 18:16:06.429    [DEBUG][22]       format: json

2016-10-17 18:16:06.429    [DEBUG][22]       random: 0.11533776138187102

2016-10-17 18:16:06.429    [DEBUG][22]       client_ip: 192.168.1.123

2016-10-17 18:16:06.429    [DEBUG][22]       host_callback: 192.168.1.88:8866

2016-10-17 18:16:06.429    [DEBUG][22]       physical_path: C:\Users\Public\NPVR\web\

2016-10-17 18:16:06.429    [DEBUG][22]       user_agent: Mozilla/5.0 (Windows NT 6.1; WOW64; Trident/7.0; rv:11.0) like Gecko

2016-10-17 18:16:06.429    [DEBUG][22]       range: 

2016-10-17 18:16:06.429    [DEBUG][22]       requested_path: /services/service

2016-10-17 18:16:06.430    [DEBUG][22]       verb: GET

2016-10-17 18:16:06.430    [DEBUG][22]       sid: default

2016-10-17 18:16:06.663    [DEBUG][22]    Took 162.2385ms to query listings

2016-10-17 18:16:13.682    [DEBUG][19]    Loading FanArt from: C:\Users\Public\NPVR\Media\Shows

2016-10-17 18:16:13.682    [DEBUG][19]    FanArt Dictionary Count: 619

2016-10-17 18:16:13.683    [DEBUG][19]    Clearing Dictionary

2016-10-17 18:16:13.683    [DEBUG][19]    FanArt Dictionary Count: 0

2016-10-17 18:16:13.779    [DEBUG][19]    FanArt loaded from directory....  start time:    10/17/2016 6:16:13 PM     end time: 10/17/2016 6:16:13 PM       total elapsed seconds: 0.96

2016-10-17 18:16:13.779    [DEBUG][19]    FanArt Dictionary Count: 619

2016-10-17 18:16:13.779    [DEBUG][19]    Folders processed: 0

2016-10-17 18:16:13.779    [DEBUG][19]    Fanart files processed: 619

2016-10-17 18:16:13.779    [DEBUG][19]    Total files processed: 1025

2016-10-17 18:16:16.340    [DEBUG][19]    **********  Checking VLC Heartbeat Dictionary

2016-10-17 18:16:16.340    [DEBUG][19]    +++++No entries in VLC Heartbeat Dictionary.

2016-10-17 18:16:16.956    [DEBUG][22]    Took 10292.4568ms to generate output for 450 listings

2016-10-17 18:16:16.956    [DEBUG][22]    [

{"channel": {

"channel_id": 8706, "channel_number": 2, "channel_minor": 0, "channel_formatted_number": 2, "channel_name": "KTVU", "listings": [

{"id": 11299822, "name": "KTVU Fox 2 News at 6pm", "description": "Local news, sports and weather.", "firstrun": true, "start": 1476752400, "end": 1476754200, "genre": "News"},

{"id": 11299823, "name": "KTVU FOX 2 News at 6:30pm", "description": "Local news, weather and sports.", "firstrun": true, "start": 1476754200, "end": 1476756000, "genre": "News"}]}}, 

{"channel": {

"channel_id": 8707, "channel_number": 3, "channel_minor": 0, "channel_formatted_number": 3, "channel_name": "KNTV", "listings": [

{"id": 11300038, "name": "NBC Bay Area News at 6", "description": "Local news, sports and weather.", "firstrun": true, "start": 1476752400, "end": 1476756000, "genre": "News"},

{"id": 11300039, "name": "Extra", "description": "Extra: Tom Cruise; Vin Diesel.", "firstrun": false, "start": 1476756000, "end": 1476757800, "genre": "Lifestyle"}]}}, 

{"channel": {

"channel_id": 8708, "channel_number": 4, "channel_minor": 0, "channel_formatted_number": 4, "channel_name": "KRON", "listings": [

{"id": 11300220, "name": "KRON 4 Evening News", "description": "Local news, sports and weather.", "firstrun": true, "start": 1476748800, "end": 1476756000, "genre": "News"},

{"id": 11300221, "name": "The Insider", "description": "The Insider: Taraji P. Henson on her book \"Around the Way Girl.\" Also: a look at Laurie Hernandez and Val Chmerkovs...snip...

2016-10-17 18:16:37.102    [DEBUG][4]    Got Web Request (192.168.1.123): /modern/player.html    channel_id=8707&title=NBC%20Bay%20Area%20News%20at%206

2016-10-17 18:16:37.444    [DEBUG][3]    Got Web Request (192.168.1.123): /services/service    method=channel.transcode.initiate&channel_id=8707&profile=default&random=0.5659266267159626

2016-10-17 18:16:37.444    [DEBUG][3]    method=channel.transcode.initiate

2016-10-17 18:16:37.444    [DEBUG][3]    parameters: 

2016-10-17 18:16:37.446    [DEBUG][3]       method: channel.transcode.initiate

2016-10-17 18:16:37.446    [DEBUG][3]       channel_id: 8707

2016-10-17 18:16:37.446    [DEBUG][3]       profile: default

2016-10-17 18:16:37.446    [DEBUG][3]       random: 0.5659266267159626

2016-10-17 18:16:37.446    [DEBUG][3]       client_ip: 192.168.1.123

2016-10-17 18:16:37.446    [DEBUG][3]       host_callback: 192.168.1.88:8866

2016-10-17 18:16:37.446    [DEBUG][3]       physical_path: C:\Users\Public\NPVR\web\

2016-10-17 18:16:37.446    [DEBUG][3]       user_agent: Mozilla/5.0 (Windows NT 6.1; WOW64; Trident/7.0; rv:11.0) like Gecko

2016-10-17 18:16:37.446    [DEBUG][3]       range: 

2016-10-17 18:16:37.446    [DEBUG][3]       requested_path: /services/service

2016-10-17 18:16:37.446    [DEBUG][3]       verb: GET

2016-10-17 18:16:37.446    [DEBUG][3]       sid: default

2016-10-17 18:16:37.512    [ERROR][22]    Uncaught exception: System.Web.HttpException (0x80004005): File does not exist.

   at System.Web.StaticFileHandler.GetFileInfo(String virtualPathWithPathInfo, String physicalPath, HttpResponse response)

   at System.Web.StaticFileHandler.ProcessRequestInternal(HttpContext context, String overrideVirtualPath)

   at System.Web.DefaultHttpHandler.BeginProcessRequest(HttpContext context, AsyncCallback callback, Object state)

   at System.Web.HttpApplication.CallHandlerExecutionStep.System.Web.HttpApplication.IExecutionStep.Execute()

   at System.Web.HttpApplication.ExecuteStep(IExecutionStep step, Boolean& completedSynchronously)

***sub*** · 2016-10-18, 04:34 AM

I can't really tell what's happening there. Can zip and attach the whole logs directory. There might be something else useful in the logs.

MrReis · 2016-10-18, 05:06 AM

sub Wrote:I can't really tell what's happening there. Can zip and attach the whole logs directory. There might be something else useful in the logs.

the zipped NextPVR logs directory is attached to this post.

***sub*** · 2016-10-18, 05:51 AM

If you run this from a command prompt, what happens?

Quote:"C:\Program Files\NPVR\Other\ffmpeg.exe" -y -i http://127.0.0.1:8866/live?channel=3&tra...7e773a9821 -map_metadata -1 -threads 0 -map 0:0 -map 0:1 -map -0 -codec:v:0 libx264 -pix_fmt yuv420p -preset superfast -crf 23 -b:v 2000000 -maxrate 2000000 -bufsize 4000000 -vsync vfr -profile:v high -level 41 -aspect 16:9 -force_key_frames "expr:gte(t,n_forced*3)" -s 1280x720 -flags -global_header -sc_threshold 0 -codec:a:0 aac -strict experimental -ac 2 -ab 128000 -af "adelay=1,aresample=async=1" -hls_time 3 -start_number 0 -hls_list_size 0 -y "C:\Users\Public\NPVR\web\temp\KNTV-bfaf1fd460644ec7b57ebf7e773a9821.m3u8"

MrReis · 2016-10-18, 07:14 AM

sub Wrote:If you run this from a command prompt, what happens?

Do you mean "run this" from the local or remote machine?

MrReis · 2016-10-18, 07:19 AM

sub Wrote:If you run this from a command prompt, what happens?

From the remote machine the following is the result.

C:\Users\dreis>"C:\Program Files (x86)\NPVR\Other\ffmpeg.exe" -y -i http://127.0
.0.1:8866/live?channel=3...e-bf7e773a9821 -map_metadata -1 -threads 0 -map 0:0 -
map 0:1 -map -0 Confused

-codec:v:0 libx264 -pix_fmt yuv420p -preset superfast -crf 23
-b:v 2000000 -maxrate 2000000 -bufsize 4000000 -vsync vfr -profile:v high -level
41 -aspect 16:9 -force_key_frames "expr:gte(t,n_forced*3)" -s 1280x720 -flags -
global_header -sc_threshold 0 -codec:a:0 aac -strict experimental -ac 2 -ab 1280
00 -af "adelay=1,aresample=async=1" -hls_time 3 -start_number 0 -hls_list_size 0
-y "C:\Users\Public\NPVR\web\temp\KNTV-bfaf1fd460644ec7b57ebf7e773a9821.m3u8"
ffmpeg version N-76598-g2905c51 Copyright © 2000-2015 the FFmpeg developers
built with gcc 5.2.0 (GCC)
configuration: --arch=x86_64 --target-os=mingw32 --cross-prefix=/home/mceuser/
ffmpeg-windows-build-helpers/sandbox/mingw-w64-x86_64/bin/x86_64-w64-mingw32- --
pkg-config=pkg-config --disable-w32threads --enable-gpl --enable-libsoxr --enabl
e-fontconfig --enable-libass --enable-libutvideo --enable-libbluray --enable-ico
nv --enable-libtwolame --extra-cflags=-DLIBTWOLAME_STATIC --enable-libzvbi --ena
ble-libcaca --enable-libmodplug --extra-libs=-lstdc++ --extra-libs=-lpng --enabl
e-libvidstab --enable-libx265 --enable-decklink --extra-libs=-loleaut32 --enable
-libx264 --enable-libxvid --enable-libmp3lame --enable-version3 --enable-zlib --
enable-librtmp --enable-libvorbis --enable-libtheora --enable-libspeex --enable-
libopenjpeg --enable-gnutls --enable-libgsm --enable-libfreetype --enable-libopu
s --enable-frei0r --enable-filter=frei0r --enable-libvo-aacenc --enable-bzlib --
enable-libxavs --enable-libopencore-amrnb --enable-libopencore-amrwb --enable-li
bvo-amrwbenc --enable-libschroedinger --enable-libvpx --enable-libilbc --enable-
libwavpack --enable-libwebp --enable-libgme --enable-dxva2 --enable-libdcadec --
enable-avisynth --enable-gray --enable-libmfx --extra-libs=-lpsapi --extra-cflag
s= --enable-static --disable-shared --prefix=/home/mceuser/ffmpeg-windows-build-
helpers/sandbox/mingw-w64-x86_64/x86_64-w64-mingw32 --enable-runtime-cpudetect
libavutil 55. 5.100 / 55. 5.100
libavcodec 57. 15.100 / 57. 15.100
libavformat 57. 14.100 / 57. 14.100
libavdevice 57. 0.100 / 57. 0.100
libavfilter 6. 15.100 / 6. 15.100
libswscale 4. 0.100 / 4. 0.100
libswresample 2. 0.101 / 2. 0.101
libpostproc 54. 0.100 / 54. 0.100
[http @ 00000000004bf4c0] HTTP error 404 Not FoundServer: NextPVR
http://127.0.0.1:8866/live?channel=3...e-bf7e773a9821: Server returned 404 Not F
ound

***sub*** · 2016-10-18, 07:32 AM

Unfortunately the forum software truncated a URL in a middle of that, breaking it. (I'm about to switch off for the night, so don't sit around waiting for a response now)

Try this:

Code:
"C:\Program Files\NPVR\Other\ffmpeg.exe" -y  -i http://127.0.0.1:8866/live?channel=3 -map_metadata -1 -threads 0 -map 0:0 -map 0:1 -map -0:s -codec:v:0 libx264 -pix_fmt yuv420p -preset superfast -crf 23 -b:v 2000000 -maxrate 2000000 -bufsize 4000000 -vsync vfr -profile:v high -level 41 -aspect 16:9 -force_key_frames "expr:gte(t,n_forced*3)" -s 1280x720  -flags -global_header -sc_threshold 0 -codec:a:0 aac -strict experimental -ac 2 -ab 128000 -af "adelay=1,aresample=async=1" -hls_time 3 -start_number 0 -hls_list_size 0 -y "C:\Users\Public\NPVR\web\temp\KNTV-bfaf1fd460644ec7b57ebf7e773a9821.m3u8"

MrReis · 2016-10-18, 01:24 PM

sub Wrote:Unfortunately the forum software truncated a URL in a middle of that, breaking it...

The following is the result from the local machine using the correct (not truncated) URL in the command line (again, from the local machine).

Code:
C:\Users\dreis>"C:\Program Files (x86)\NPVR\Other\ffmpeg.exe" -y -i http://127.0

.0.1:8866/live?channel=3&transcoder=bfaf1fd4-6064-4ec7-b57e-bf7e773a9821 -map_me

tadata -1 -threads 0 -map 0:0 -map 0:1 -map -0:s -codec:v:0 libx264 -pix_fmt yuv

420p -preset superfast -crf 23 -b:v 2000000 -maxrate 2000000 -bufsize 4000000 -v

sync vfr -profile:v high -level 41 -aspect 16:9 -force_key_frames "expr:gte(t,n_

forced*3)" -s 1280x720 -flags -global_header -sc_threshold 0 -codec:a:0 aac -str

ict experimental -ac 2 -ab 128000 -af "adelay=1,aresample=async=1" -hls_time 3 -

start_number 0 -hls_list_size 0 -y "C:\Users\Public\NPVR\web\temp\KNTV-bfaf1fd46

0644ec7b57ebf7e773a9821.m3u8"

ffmpeg version N-76598-g2905c51 Copyright (c) 2000-2015 the FFmpeg developers

  built with gcc 5.2.0 (GCC)

  configuration: --arch=x86_64 --target-os=mingw32 --cross-prefix=/home/mceuser/

ffmpeg-windows-build-helpers/sandbox/mingw-w64-x86_64/bin/x86_64-w64-mingw32- --

pkg-config=pkg-config --disable-w32threads --enable-gpl --enable-libsoxr --enabl

e-fontconfig --enable-libass --enable-libutvideo --enable-libbluray --enable-ico

nv --enable-libtwolame --extra-cflags=-DLIBTWOLAME_STATIC --enable-libzvbi --ena

ble-libcaca --enable-libmodplug --extra-libs=-lstdc++ --extra-libs=-lpng --enabl

e-libvidstab --enable-libx265 --enable-decklink --extra-libs=-loleaut32 --enable

-libx264 --enable-libxvid --enable-libmp3lame --enable-version3 --enable-zlib --

enable-librtmp --enable-libvorbis --enable-libtheora --enable-libspeex --enable-

libopenjpeg --enable-gnutls --enable-libgsm --enable-libfreetype --enable-libopu

s --enable-frei0r --enable-filter=frei0r --enable-libvo-aacenc --enable-bzlib --

enable-libxavs --enable-libopencore-amrnb --enable-libopencore-amrwb --enable-li

bvo-amrwbenc --enable-libschroedinger --enable-libvpx --enable-libilbc --enable-

libwavpack --enable-libwebp --enable-libgme --enable-dxva2 --enable-libdcadec --

enable-avisynth --enable-gray --enable-libmfx --extra-libs=-lpsapi --extra-cflag

s= --enable-static --disable-shared --prefix=/home/mceuser/ffmpeg-windows-build-

helpers/sandbox/mingw-w64-x86_64/x86_64-w64-mingw32 --enable-runtime-cpudetect

  libavutil      55.  5.100 / 55.  5.100

  libavcodec     57. 15.100 / 57. 15.100

  libavformat    57. 14.100 / 57. 14.100

  libavdevice    57.  0.100 / 57.  0.100

  libavfilter     6. 15.100 /  6. 15.100

  libswscale      4.  0.100 /  4.  0.100

  libswresample   2.  0.101 /  2.  0.101

  libpostproc    54.  0.100 / 54.  0.100

[mpeg2video @ 000000000047b6e0] Invalid frame dimensions 0x0.

    Last message repeated 14 times

Input #0, mpegts, from 'http://127.0.0.1:8866/live?channel=3':

  Duration: N/A, start: 62477.334756, bitrate: N/A

  Program 7972

    Stream #0:0[0x1aa5]: Video: mpeg2video (Main) ([2][0][0][0] / 0x0002), yuv42

0p(tv), 704x480 [SAR 10:11 DAR 4:3], max. 18000 kb/s, 29.97 fps, 29.97 tbr, 90k

tbn, 59.94 tbc

    Stream #0:1[0x1aa6](eng): Audio: ac3 ([129][0][0][0] / 0x0081), 48000 Hz, 5.

1(side), fltp, 384 kb/s

    Stream #0:2[0x1aa7](spa): Audio: ac3 ([129][0][0][0] / 0x0081), 48000 Hz, mo

no, fltp, 192 kb/s (visual impaired)

At least one output file must be specified

'transcoder' is not recognized as an internal or external command,

operable program or batch file.

Possibly Related Threads…
Thread		Author	Replies	Views	Last Post
	Cannot open live tv file with CoreElec test addon	Oempa	9	2,618	2020-02-03, 04:22 PM Last Post: sub
	Kodi log file error	shaneypoopers	1	1,929	2015-04-04, 01:31 PM Last Post: mvallevand
	Unexpected socket exception calling StartStream()		0	420	Less than 1 minute ago Last Post: