Topic: Error report

SVP asked me to post this error report

14:13:26.900; Start: SVPMgr 3.1.6 (1041) starts...
14:13:26.900; AppDataPath: C:\ProgramData (ANSI)
14:13:26.900; Start: read settings file settings.ini
14:13:26.900; Start: load language file - English. Duration: 30 ms
14:13:26.930; Start: check launched instance of SVP-manager
14:13:26.930; Start: check Avisynth installed. Duration: 1646 ms
14:13:28.576; Start: clear Logs folder
14:13:28.576; Start: CPU and threads count detection
CPU: Intel Core i7-3930K @ 3.20GHz [12 threads] (3020)
14:13:28.646; Start: SVPMgr folders prepare. Duration: 100 ms
14:13:28.746; Start: read settings file SVPMgr.ini
14:13:28.746; Start: GPUs settings detection
GPU_11: GeForce GTX 680 (2171)
14:13:28.977; Start: monitors settings detection
Display#00010001: 2560 x 1440 @ 120
Display#00010003: 1920 x 1080 @ 120
14:13:28.987; Start: disable LNG-file write when UAC enabled
14:13:28.987; Start: change SVP-manager priority
14:13:28.987; Start: register hotkeys. Duration: 643 ms
14:13:29.630; Start: get versions of modules used
ffdshow.ax/avisynth.dll: 1.3.4530.0/2.5.8.6
svpflow1/2.dll: 1.3.5.0/1.5.7.0
svpflow_cpu/gpu.dll: 1.7.2.0/1.8.3.0
14:13:29.630; Start: refresh autostart state in registry
14:13:29.630; Start: some more work with registry. Duration: 10 ms
14:13:29.640; Start: create menu. Duration: 40 ms
14:13:29.680; Start: update settings file settings.ini. Duration: 10 ms
14:13:29.690; Start: prepare "About the program" window. Duration: 678 ms
14:13:30.368; Updates: check for updates. Request sended
14:13:30.886; Start: enable ffdShow waiting mode
14:13:30.886; Start: prepare to work is complete
14:13:30.916; RefreshSVP. Duration: 10 ms
14:13:30.926; ===== Waiting for ffdshow video

14:13:41.640; Updates: connection closed

15:12:58.569; ===== Detected playback with ffdShow. AppName: mpc-hc.exe PID: 4124. Duration: 11 ms
15:12:58.580; GetDimensionAndFPS_fromOSD start. Duration: 98 ms
15:12:58.678; GetDimensionAndFPS_fromOSD result: 1920x1036 23.976 1/1
15:12:58.702; T1T: begin. Duration: 834 ms
15:12:59.536; screen settings refinement: Display#00010001: 2560 x 1440 @ 119.992
15:12:59.538; T1T: GetAllMediaParams
15:12:59.540; ### CorrectStereoModeByAppAndFilename: I.Am.Number.Four.2011.BluRay.1080p.DTS.x264-CHD.mkv
15:12:59.541; T1T: SettingsPrepare
15:12:59.546; T1T: Preparing smooth playback...
15:12:59.555; T1T: WriteAllMediaParamsToIni
15:12:59.556; SVPMgr: main "C:\ProgramData\SVP 3.1\" 1920 1036 23.976 1920 1036 5 1. Duration: 307 ms
15:12:59.863; ===== Playback
23.976 * (5 : 1) = 119.88 fps
15:12:59.865; SetPriorityPlayer: 2. Duration: 8012 ms
15:13:07.877; ===== rewind forward 01:21:07 / 01:49:33
15:13:09.971; ===== rewind forward 01:26:16 / 01:49:33
15:13:11.189; ===== rewind forward 01:29:18 / 01:49:33
15:13:13.095; ===== rewind forward 01:32:41 / 01:49:33
15:16:38.408; ===== rewind backward 01:29:35 / 01:49:33
15:16:41.533; ===== rewind forward 01:31:01 / 01:49:33
15:16:43.689; ===== rewind forward 01:32:18 / 01:49:33
15:16:44.721; ===== rewind forward 01:32:41 / 01:49:33
15:16:45.657; ===== rewind forward 01:33:26 / 01:49:33
15:16:47.939; ===== rewind backward 01:33:16 / 01:49:33
15:16:51.095; ===== rewind backward 01:32:39 / 01:49:33
15:16:53.189; FalseVFR ffdShow-framerate: -Dwn-> 18.573 -Up-> 23.976 fps
15:16:53.191; express clear interval. Duration: 7 ms
15:16:53.198; stabilized ffdShow-framerate: 23.976 fps. SVP Index: 0.32/1.46
15:20:38.251; RefreshSVP
15:20:38.254; ===== Waiting for ffdshow video

15:20:39.261; ===== Detected playback with ffdShow. AppName: mpc-hc.exe PID: 4124
15:20:39.263; GetDimensionAndFPS_fromOSD start. Duration: 471 ms
15:20:39.734; GetDimensionAndFPS_fromOSD result: 720x480 29.97 32/27
15:20:39.737; T1T: begin. Duration: 8 ms
15:20:39.745; T1T: GetAllMediaParams
15:20:39.747; T1T: SettingsPrepare. Duration: 6 ms
15:20:39.753; T1T: Preparing smooth playback...
15:20:39.756; T1T: WriteAllMediaParamsToIni
15:20:39.757; SVPMgr: main "C:\ProgramData\SVP 3.1\" 720 480 29.97 720 480 4 1. Duration: 170 ms
15:20:39.927; ===== Playback
29.97 * (4 : 1) = 119.88 fps
15:20:39.929; SetPriorityPlayer: 2. Duration: 588 ms
15:20:40.517; Error: Error preparing smooth playback! Script error:
Write: File 'C:\ProgramData\SVP 3.1\Logs\avsFPS.txt' cannot be opened.
(ffdshow_filter_avisynth_script, line 7)
. Duration: 718 ms
15:20:41.235; ===== rewind forward 00:00:02 / --:--:--
15:20:47.048; FalseVFR ffdShow-framerate: -Dwn-> 5.642 -Up-> 35.229 -Up-> 55.075 -Up-> 58.982 -Up-> 59.905 fps
15:20:47.049; express clear interval
15:20:47.051; stabilized ffdShow-framerate: 59.94 fps. SVP Index: 0.00/1.72
15:20:47.055; SVPMgr: main "C:\ProgramData\SVP 3.1\" 720 480 59.94 720 480 2 1. Duration: 168 ms
15:20:47.223; ===== Playback
59.94 * (2 : 1) = 119.88 fps
15:20:49.268; ===== rewind backward 00:00:10 / --:--:--
15:20:50.391; ===== rewind forward 00:00:11 / --:--:--
15:20:54.907; FalseVFR ffdShow-framerate: -Dwn-> 54.665 -Up-> 58.541 -Up-> 59.776 -Up-> 59.94 fps
15:20:54.909; express clear interval
15:20:54.911; stabilized ffdShow-framerate: 59.94 fps. SVP Index: 0.00/2.00
15:20:58.751; RefreshSVP
15:20:58.755; ===== Waiting for ffdshow video

Re: Error report

I also had similar reporting by SVP.
Didnt know where to post exactly, so I am posting it here:

Post's attachments

LastErrorLog.txt 479.29 kb, 509 downloads since 2014-07-12 

  • MAG79
  • SVP developer
  • Offline

Re: Error report

sherink
It is another error. About levels value.

Error: Error preparing smooth playback! Script error:
SVAnalyse: non-valid number of levels (1)
(C:\ProgramData\SVP 3.1\AVS\ffdshow.avs, line 39)
(C:\ProgramData\SVP 3.1\AVS\ffdshow.avs, line 55)
(ffdshow_filter_avisynth_script, line 4)

See there.

4 Reply by xezi (edited by xezi 10-05-2015 01:12:20)

  • xezi
  • Member
  • Offline

Re: Error report

Posting error report...

Some strange subtitle rendering behaviour was noticed,
namely, font/color/size were not changed...

hope this helps, keep up the great work

16:27:37.224; Start: SVPMgr 3.1.6 (1041) starts...
16:27:37.224; AppDataPath: C:\ProgramData (ANSI)
16:27:37.225; Start: read settings file settings.ini
16:27:37.226; Start: load language file - English. Duration: 36 ms
16:27:37.262; Start: check launched instance of SVP-manager
16:27:37.262; Start: check Avisynth installed
16:27:37.263; Start: clear Logs folder
16:27:37.264; Start: CPU and threads count detection
CPU: Intel Core i7-3770 @ 3.40GHz [8 threads] (2019)
16:27:37.265; Start: SVPMgr folders prepare. Duration: 13 ms
16:27:37.278; Start: read settings file SVPMgr.ini
16:27:37.280; Start: GPUs settings detection
GPU_11: Intel(R) HD Graphics 4000 (139)
16:27:37.291; Start: monitors settings detection
Display#00010001: 1920 x 1080 @ 60
16:27:37.291; Start: disable LNG-file write when UAC enabled
16:27:37.292; Start: change SVP-manager priority
16:27:37.292; Start: register hotkeys. Duration: 18 ms
16:27:37.310; Start: get versions of modules used
ffdshow.ax/avisynth.dll: 1.3.4530.0/2.5.8.6
svpflow1/2.dll: 1.3.5.0/1.5.7.0
svpflow_cpu/gpu.dll: 1.7.2.0/1.8.3.0
16:27:37.310; Start: refresh autostart state in registry
16:27:37.311; Start: some more work with registry
16:27:37.314; Start: create menu. Duration: 8 ms
16:27:37.322; Start: update settings file settings.ini. Duration: 7 ms
16:27:37.329; Start: prepare "About the program" window
16:27:37.334; Updates: check for updates. Request sended
16:27:37.402; Start: enable ffdShow waiting mode
16:27:37.402; Start: prepare to work is complete
16:27:37.403; RefreshSVP
16:27:37.405; ===== Waiting for ffdshow video

16:27:37.908; ===== Detected playback with ffdShow. AppName: mpc-hc.exe PID: 3216
16:27:37.909; GetDimensionAndFPS_fromOSD start. Duration: 122 ms
16:27:38.031; GetDimensionAndFPS_fromOSD result: 1920x1078 23.976 1/1
16:27:38.033; T1T: begin. Duration: 860 ms
16:27:38.893; screen settings refinement: Display#00010001: 1920 x 1080 @ 60.001
16:27:38.894; T1T: GetAllMediaParams
16:27:38.894; ### CorrectStereoModeByAppAndFilename: Game.of.Thrones.S05E04.1080p.HDTV.x264-BATV.mkv
16:27:38.895; T1T: SettingsPrepare
16:27:38.900; T1T: Preparing smooth playback...
16:27:38.901; T1T: WriteAllMediaParamsToIni
16:27:38.901; SVPMgr: main "C:\ProgramData\SVP 3.1\" 1920 1080 23.976 1920 1078 5 2
16:27:39.241; ===== Playback
23.976 * (5 : 2) = 59.94 fps
16:27:39.241; SetPriorityPlayer: 2. Duration: 5004 ms
16:27:44.245; FalseVFR ffdShow-framerate: -Dwn-> 15.619 -Up-> 18.633 -Up-> 22.894 -Up-> 23.865 -Up-> 23.976 fps
16:27:44.246; express clear interval
16:27:44.246; stabilized ffdShow-framerate: 23.976 fps. SVP Index: 1.09/1.05
16:27:49.204; Updates: connection closed

16:28:32.935; RefreshSVP. Duration: 499 ms
16:28:33.434; GetDimensionAndFPS_fromOSD start. Duration: 82 ms
16:28:33.516; GetDimensionAndFPS_fromOSD result: 1920x1078 23.976 1/1
16:28:33.519; T1T: begin
16:28:33.520; T1T: GetAllMediaParams
16:28:33.521; T1T: SettingsPrepare. Duration: 7 ms
16:28:33.528; T1T: Preparing smooth playback...
16:28:33.529; T1T: WriteAllMediaParamsToIni
16:28:33.529; SVPMgr: main "C:\ProgramData\SVP 3.1\" 1920 1080 23.976 1920 1078 5 2. Duration: 225 ms
16:28:33.754; ===== Playback
23.976 * (5 : 2) = 59.94 fps
16:28:33.754; SetPriorityPlayer: 2
16:29:55.135; RefreshSVP. Duration: 501 ms
16:29:55.636; GetDimensionAndFPS_fromOSD start. Duration: 83 ms
16:29:55.719; GetDimensionAndFPS_fromOSD result: 1920x1078 23.976 1/1
16:29:55.722; T1T: begin
16:29:55.723; T1T: GetAllMediaParams
16:29:55.724; T1T: SettingsPrepare. Duration: 7 ms
16:29:55.731; T1T: Preparing smooth playback...
16:29:55.732; T1T: WriteAllMediaParamsToIni
16:29:55.732; SVPMgr: main "C:\ProgramData\SVP 3.1\" 1920 1080 23.976 1920 1078 5 2. Duration: 280 ms
16:29:56.012; ===== Playback
23.976 * (5 : 2) = 59.94 fps
16:29:56.012; SetPriorityPlayer: 2
16:30:23.634; RefreshSVP. Duration: 488 ms
16:30:24.122; GetDimensionAndFPS_fromOSD start. Duration: 121 ms
16:30:24.243; GetDimensionAndFPS_fromOSD result: 1920x1078 23.976 1/1
16:30:24.246; T1T: begin
16:30:24.247; T1T: GetAllMediaParams
16:30:24.248; T1T: SettingsPrepare
16:30:24.253; T1T: Preparing smooth playback...
16:30:24.254; T1T: WriteAllMediaParamsToIni
16:30:24.254; SVPMgr: main "C:\ProgramData\SVP 3.1\" 1920 1080 23.976 1920 1078 5 2. Duration: 225 ms
16:30:24.479; ===== Playback
23.976 * (5 : 2) = 59.94 fps
16:30:24.479; SetPriorityPlayer: 2
16:30:54.180; RefreshSVP. Duration: 490 ms
16:30:54.670; GetDimensionAndFPS_fromOSD start. Duration: 689 ms
16:30:55.359; GetDimensionAndFPS_fromOSD result: 1920x1078 23.976 1/1
16:30:55.361; T1T: begin
16:30:55.362; T1T: GetAllMediaParams
16:30:55.363; T1T: SettingsPrepare. Duration: 6 ms
16:30:55.369; T1T: Preparing smooth playback...
16:30:55.370; T1T: WriteAllMediaParamsToIni
16:30:55.370; SVPMgr: main "C:\ProgramData\SVP 3.1\" 1920 1080 23.976 1920 1078 5 2. Duration: 231 ms
16:30:55.601; ===== Playback
23.976 * (5 : 2) = 59.94 fps
16:30:55.601; SetPriorityPlayer: 2
16:31:28.234; RefreshSVP. Duration: 496 ms
16:31:28.730; GetDimensionAndFPS_fromOSD start. Duration: 83 ms
16:31:28.813; GetDimensionAndFPS_fromOSD result: 1920x1078 23.976 1/1
16:31:28.816; T1T: begin
16:31:28.817; T1T: GetAllMediaParams
16:31:28.818; T1T: SettingsPrepare
16:31:28.823; T1T: Preparing smooth playback...
16:31:28.824; T1T: WriteAllMediaParamsToIni
16:31:28.824; SVPMgr: main "C:\ProgramData\SVP 3.1\" 1920 1080 23.976 1920 1078 5 2. Duration: 226 ms
16:31:29.050; ===== Playback
23.976 * (5 : 2) = 59.94 fps
16:31:29.050; SetPriorityPlayer: 2
16:36:57.980; ===== rewind backward 00:00:00 / 00:50:20
16:39:39.885; ===== rewind forward 00:09:56 / 00:50:20
16:43:28.382; RefreshSVP. Duration: 490 ms
16:43:28.872; GetDimensionAndFPS_fromOSD start. Duration: 102 ms
16:43:28.974; GetDimensionAndFPS_fromOSD result: 1920x1078 23.976 1/1
16:43:28.977; T1T: begin
16:43:28.978; T1T: GetAllMediaParams
16:43:28.979; T1T: SettingsPrepare. Duration: 6 ms
16:43:28.985; T1T: Preparing smooth playback...
16:43:28.986; T1T: WriteAllMediaParamsToIni
16:43:28.986; SVPMgr: main "C:\ProgramData\SVP 3.1\" 1920 1080 23.976 1920 1078 5 2. Duration: 280 ms
16:43:29.266; ===== Playback
23.976 * (5 : 2) = 59.94 fps
16:43:29.266; SetPriorityPlayer: 2. Duration: 10541 ms
16:43:39.807; RefreshSVP. Duration: 502 ms
16:43:40.309; GetDimensionAndFPS_fromOSD start. Duration: 323 ms
16:43:40.632; GetDimensionAndFPS_fromOSD result: 1920x1078 23.976 1/1
16:43:40.634; T1T: begin
16:43:40.635; T1T: GetAllMediaParams
16:43:40.636; T1T: SettingsPrepare
16:43:40.641; T1T: Preparing smooth playback...
16:43:40.642; T1T: WriteAllMediaParamsToIni
16:43:40.642; SVPMgr: main "C:\ProgramData\SVP 3.1\" 1920 1080 23.976 1920 1078 5 2. Duration: 280 ms
16:43:40.922; ===== Playback
23.976 * (5 : 2) = 59.94 fps
16:43:40.922; SetPriorityPlayer: 2
16:50:02.966; RefreshSVP
16:50:02.966; ===== Waiting for ffdshow video

18:18:30.494; ===== System sleep state detected

18:18:43.424; ===== System resume from sleep state detected
18:31:38.259; ===== Detected playback with ffdShow. AppName: mpc-hc.exe PID: 1932
18:31:38.259; ===== It is first playback with ffdShow after system resume
18:31:38.264; GetDimensionAndFPS_fromOSD start. Duration: 299 ms
18:31:38.563; GetDimensionAndFPS_fromOSD result: 1920x800 23.976 1/1
18:31:38.566; T1T: begin
18:31:38.568; T1T: GetAllMediaParams
18:31:38.569; ### CorrectStereoModeByAppAndFilename: Jupiter.Ascending.2015.1080p.BluRay.x264.YIFY.mp4
18:31:38.570; T1T: SettingsPrepare. Duration: 6 ms
18:31:38.576; T1T: Preparing smooth playback...
18:31:38.576; T1T: WriteAllMediaParamsToIni
18:31:38.577; SVPMgr: main "C:\ProgramData\SVP 3.1\" 1920 800 23.976 1920 800 5 2. Duration: 287 ms
18:31:38.864; ===== Playback
23.976 * (5 : 2) = 59.94 fps
18:31:38.864; SetPriorityPlayer: 2. Duration: 4914 ms
18:31:43.778; FalseVFR ffdShow-framerate: -Dwn-> 17.716 -Up-> 21.634 -Up-> 23.586 -Up-> 23.976 fps
18:31:43.778; express clear interval
18:31:43.778; stabilized ffdShow-framerate: 23.976 fps. SVP Index: 0.99/0.97
18:31:48.747; ===== rewind backward 00:00:09 / 02:07:33
18:31:53.151; FalseVFR ffdShow-framerate: -Dwn-> 17.639 -Up-> 20.735 -Up-> 23.365 -Up-> 23.976 fps
18:31:53.151; express clear interval
18:31:53.151; stabilized ffdShow-framerate: 23.976 fps. SVP Index: 1.08/1.01
18:32:28.763; RefreshSVP. Duration: 499 ms
18:32:29.262; GetDimensionAndFPS_fromOSD start. Duration: 82 ms
18:32:29.344; GetDimensionAndFPS_fromOSD result: 1920x800 23.976 1/1
18:32:29.347; T1T: begin
18:32:29.348; T1T: GetAllMediaParams
18:32:29.349; T1T: SettingsPrepare
18:32:29.354; T1T: Preparing smooth playback...
18:32:29.354; T1T: WriteAllMediaParamsToIni
18:32:29.354; SVPMgr: main "C:\ProgramData\SVP 3.1\" 1920 800 23.976 1920 800 5 2. Duration: 222 ms
18:32:29.576; ===== Playback
23.976 * (5 : 2) = 59.94 fps
18:32:29.577; SetPriorityPlayer: 2
18:39:19.309; RefreshSVP
18:39:19.311; ===== Waiting for ffdshow video

18:53:22.702; ===== Detected playback with ffdShow. AppName: mpc-hc.exe PID: 6092
18:53:22.703; GetDimensionAndFPS_fromOSD start. Duration: 311 ms
18:53:23.014; GetDimensionAndFPS_fromOSD result: 1920x800 23.976 1/1
18:53:23.018; T1T: begin
18:53:23.020; T1T: GetAllMediaParams
18:53:23.022; ### CorrectStereoModeByAppAndFilename: Jupiter.Ascending.2015.1080p.BluRay.x264.YIFY.mp4
18:53:23.022; T1T: SettingsPrepare. Duration: 6 ms
18:53:23.028; T1T: Preparing smooth playback...
18:53:23.029; T1T: WriteAllMediaParamsToIni
18:53:23.029; SVPMgr: main "C:\ProgramData\SVP 3.1\" 1920 800 23.976 1920 800 5 2. Duration: 71 ms
18:53:23.100; ===== Playback
23.976 * (5 : 2) = 59.94 fps
18:53:23.100; SetPriorityPlayer: 2. Duration: 5011 ms
18:53:28.111; FalseVFR ffdShow-framerate: -Dwn-> 21.755 -Dwn-> 13.867 -Up-> 21.986 -Up-> 23.672 -Up-> 23.976 fps
18:53:28.111; express clear interval
18:53:28.111; stabilized ffdShow-framerate: 23.976 fps. SVP Index: 1.01/1.01
19:17:43.037; ===== rewind backward 00:22:07 / 02:07:33
19:17:48.192; FalseVFR ffdShow-framerate: -Dwn-> 17.827 -Up-> 19.49 -Up-> 23.093 -Up-> 23.944 fps
19:17:48.192; express clear interval
19:17:48.193; stabilized ffdShow-framerate: 23.976 fps. SVP Index: 1.06/1.01
20:13:22.902; ===== rewind backward 00:32:38 / 02:07:33
20:13:28.526; FalseVFR ffdShow-framerate: -Dwn-> 17.716 -Up-> 21.634 -Up-> 23.586 -Up-> 23.976 fps
20:13:28.527; express clear interval
20:13:28.527; stabilized ffdShow-framerate: 23.976 fps. SVP Index: 0.99/1.01
21:06:28.542; ===== rewind backward 01:11:58 / 02:07:33
21:06:34.261; FalseVFR ffdShow-framerate: -Dwn-> 21.755 -Dwn-> 13.867 -Up-> 21.986 -Up-> 23.672 -Up-> 23.976 fps
21:06:34.261; express clear interval
21:06:34.261; stabilized ffdShow-framerate: 23.976 fps. SVP Index: 1.06/0.97
21:52:47.333; Error: Avisynth processing was unexpectedly turned off 
in ffdshow while playing smooth video
and was turned back on by SVP Manager.
21:53:22.932; ===== rewind backward 00:24:15 / 02:07:33
21:55:06.997; ===== rewind forward 00:31:59 / 02:07:33
21:57:54.182; RefreshSVP
21:57:54.184; ===== Waiting for ffdshow video