Thumbnail create process inconsistency RS

[majstang]

Hi!

 

Perhaps somebody knows more about this one, but most likely this post won't be answered

My questions are regarding vthumbs.exe behaviour. I believe this little application was created by either Lars or Christian, but my main question is about how it is implemented in RS. I don't exactly know how it is supposed to work and having troubles when scripting copy of thumbnails in affiliation to after recording task execution. In 8 cases out of 10 vthumbs.exe creates the thumbnail within a decent timeframe (after recording ends) in order for my script to get a successful copy. In the remaining cases vthumbs.exe can take painfully long time to create the thumbnail and my script ends up with copying an empty thumbnail. The thumbnail name (.jpg) RS creates when recording starts so, it only waits on vthumbs.exe to fill it with picture content when recording ends.

 

Now, what may cause vthumbs.exe to sometimes use this excessive amount of time to create a thumbnail.jpg for ordinary MPEG-2 recordings? It seems unreasonable when thumbnailcreation takes just seconds for all the successful cases.

Comparing a successful case against where it fails gives this:

 

 

Successful case

---------------

21.07.13 11:32:00.525 TRecording ($13A38D70) D:\TV\Recording Service\20130721_11-14-00_SVTBSVT24_Seaside hotell - S01E25 26.ts Discontinuities: 0 - Total size: 529,81 MB - Device:7231 BDA DVBC Tuner (10)

21.07.13 11:32:00.702 TRecording Release 7231 BDA DVBC Tuner (10)

21.07.13 11:32:00.702 TRecording Destroy 7231 BDA DVBC Tuner (10)

21.07.13 11:32:00.829 TRecording Destroyed 7231 BDA DVBC Tuner (10)

21.07.13 11:32:00.829 TRecording hamDeleted 7231 BDA DVBC Tuner (10)

21.07.13 11:32:00.834 CreateProcessW 44480 ; Here vthumbs.exe starts and creates the thumbnail

21.07.13 11:32:00.845 TRecordingEngine Releasereference TRecording: 1

21.07.13 11:32:00.848 TProcessTimer Process Params "D:\TV\Recording Service\20130721_11-14-00_SVTBSVT24_Seaside hotell - S01E25 26.ts"

21.07.13 11:32:30.919 TProcessTimer Proctimer started

21.07.13 11:32:30.919 TRecordingEngine AddReference TProcessTimer: 2

21.07.13 11:32:31.826 TDataReaderRecordings Start

21.07.13 11:32:32.898 CreateProcessW 13680 ; Here the script is started. By now (32 seconds later) vthumbs.exe has finished the thumbnail.

21.07.13 11:32:32.919 TDataReaderRecordings 1092

21.07.13 11:32:32.919 TDataReaderRecordings Destroy

21.07.13 11:32:46.850 CreateProcessW 11188 ; these CreatProcessW doesn't fire in failure case down below

21.07.13 11:32:46.871 CreateProcessW 33884 ; these CreatProcessW doesn't fire in failure case down below

21.07.13 11:32:46.880 Createthumb WM_DATACOPY ; Thumbnail copy delayed for 15 seconds. Now it initiates successfully

21.07.13 11:32:46.880 Createthumb success

21.07.13 11:32:46.880 Createthumb WM_DATACOPY

;------------------------------------------------------------------------------------------------------------

Failure case

-------------

21.07.13 11:22:00.075 TRecording ($13530810) D:\TV\Recording Service\20130721_10-44-02_Sjuan_Australiens räddande änglar - E07 10.ts Discontinuities: 0 - Total size: 1,72 GB - Device:7231 BDA DVBC Tuner (9)

21.07.13 11:22:00.339 TRecording Release 7231 BDA DVBC Tuner (9)

21.07.13 11:22:00.339 TRecording Destroy 7231 BDA DVBC Tuner (9)

21.07.13 11:22:00.467 TRecording Destroyed 7231 BDA DVBC Tuner (9)

21.07.13 11:22:00.467 TRecording hamDeleted 7231 BDA DVBC Tuner (9)

21.07.13 11:22:00.467 Createthumb WM_DATACOPY ; for some reason vthumbs.exe doesn't start when it should to here

21.07.13 11:22:00.468 Createthumb success ; the thumbnail has NOT been created here, it gets finished at 11:23:15 at first

21.07.13 11:22:00.472 TRecordingEngine Releasereference TRecording: 2

21.07.13 11:22:00.475 TProcessTimer Process Params "D:\TV\Recording Service\20130721_10-44-02_Sjuan_Australiens räddande änglar - E07 10.ts"

21.07.13 11:22:30.492 TProcessTimer Proctimer started

21.07.13 11:22:30.492 TRecordingEngine AddReference TProcessTimer: 3

21.07.13 11:22:31.546 TDataReaderRecordings Start

21.07.13 11:22:31.584 Createthumb WM_DATACOPY ; just garbage

21.07.13 11:22:31.584 Createthumb success ; just garbage

21.07.13 11:22:32.615 Createthumb WM_DATACOPY ; just garbage

21.07.13 11:22:32.615 Createthumb success ; just garbage

21.07.13 11:22:32.629 TDataReaderRecordings 1076

21.07.13 11:22:32.629 TDataReaderRecordings Destroy

21.07.13 11:22:46.557 Createthumb WM_DATACOPY ; copy of an empty thumbnail gets carried out

21.07.13 11:22:46.557 Createthumb success ; copy of an empty thumbnail gets carried out

;----------------------------------------------------------------------------------------------------------------

 

Perhaps there's a bug or something in the after recording task process timer which gives me this problem. In such a case threre's no pattern or logic which cases fails or not, that I can see...anyway...yet! In this failure case vthumbs.exe delayed the finishing of the thumbnail about 1 min and 15 seconds. Other bad cases it can be up to 3 or 4 minutes. I simply cant delay thumbnail copy function in my script any longer than these 15 secs I have now, the code coming after it has to be executed. I rather wanna know what's up with the source of my troubles

 

Regards

Majstang

Edited July 21, 2013 by majstang