Xibo start to play the video which is not fully downloaded from the server.

Asked by t4ol1n

the xibo client starts to play the video after downloaded the layout files .. but the video is not fully downloaded from the server. It then will search and try to download the other files. after finished downloaded all the files and compared the server side MD5 and local MD5, it will download the first file again. is there any way to guaranty the video is fully downloadded when the first time themedia player start to play the video .

Question information

Language:
English Edit question
Status:
Answered
For:
Xibo Edit question
Assignee:
No assignee Edit question
Last query:
Last reply:
Revision history for this message
Alex Harrington (alexharrington) said :
#1

Which server and client versions are you using? It sounds to me like you have an incompatible mix of versions.

Alex

This email carries a disclaimer, a copy of which may be read at http://learning.longhill.org.uk/disclaimer

Revision history for this message
t4ol1n (t4ol1n) said :
#2

the server side versino 1.2rc
client side is using .net version 1.0.7

Revision history for this message
t4ol1n (t4ol1n) said :
#3

the error message is that ...

FileCollector.xmdsFile_GetFileComplete(), Error Message is: Unhanded Exception when processing getFile response: the process can not access the file "filepath/x.mpg" because it is being used by another process..

then the process will skip the downloading and play this partial video file ..

Revision history for this message
Alex Harrington (alexharrington) said :
#4

Has that file completed downloading previously, then you've deleted it
from the local library on the client?

To prevent massively long startup times with large numbers of files the
client remembers that it has at one point correctly downloaded that file
and doesn't expect you to then delete it from under it.

If you want to clear the local library then you need to stop the client,
clear its contents and then clear the file cache too.

Alex

This email carries a disclaimer, a copy of which may be read at http://learning.longhill.org.uk/disclaimer

Revision history for this message
t4ol1n (t4ol1n) said :
#5

alex, thank you for your advice.

acctually the situation is that ..

i have cleared all the contents inside the xibo library.. then i started the xibo client application, after xibo client successfully downloaded the layout file and was starting to download the video file, this "SignalElapsedEvent()" is triggered and the media player was loading the video file and starting to play .. at this point the error "Unhanded Exception when processing getFile response: the process can not access the file "filepath/x.mpg" because it is being used by another process" is shown.. The downloading process is stopped...

after the other video files are successfully downloaded, this CompareAndCollect() method is triggered to verify all the MD5 from the file list. it will delete the partial file and download it again ..

i think this problem is always been there as if the media player is trying to load the file but the file is still in the downloading process, the downloading process will be stopped. is there any way to "Lock" the file until it is fully downloaded?

Revision history for this message
Alex Harrington (alexharrington) said :
#6

If the file isn't in the md5 cache then this can never happen.

As i said before if you're going to empty the library directory then you need to remove the checksum cache too.

It lives in application data/ local settings/ xibo

Alex

This email carries a disclaimer, a copy of which may be read at http://learning.longhill.org.uk/disclaimer

Revision history for this message
t4ol1n (t4ol1n) said :
#7

what do you mean by remove the MD5 cache, i have deleted the cacheManager.xml file from the appData.. but it works as the same...

Revision history for this message
Alex Harrington (alexharrington) said :
#8

Strange. Can you describe exactly the layouts you have scheduled so I can try and recreate this.

Better still please email over the xlf files for these layouts to <email address hidden>. please also send the contents of the cache manager xml file.

Also please confirm these are unmodified client/ server code bases.

Cheers

Alex

This email carries a disclaimer, a copy of which may be read at http://learning.longhill.org.uk/disclaimer

Revision history for this message
Bartek (czajka) said :
#9

Alex, are You sure about that deleting cache manager is nessessary in normal usage?
As far i know cached record is considered valid if file exists in library and filesize and last modification date is same that one recorded in cache manager.
I don't need to delete cache manager when removing file from lib, and as far I remember it was designed like that after discussion with You and Dan. Or maybe some part of that plan is unimplemented? :)
So any file manipulation should be detected by cache manager, with exception of modifying data file inside and preserving modification date.

Revision history for this message
Alex Harrington (alexharrington) said :
#10

I'm as sure as I can be without reading through the code myself and checking. I discussed this problem though with Dan at length this evening and we simply can't reproduce it here at all. This is the only hypothesis we can come up with that might explain it.

Revision history for this message
Bartek (czajka) said :
#11

I've managed to recreate similat situation, and i'm sorry to say that was quite easy:

Layout with three files,
On third file i've opened file in nonlock mode during transfer, so xibo was able to keep downloading file.
Correctly detected later by md5 and redownloading started.
During second try i've opened in notepad to create lock and got same error as above.
After downloading client started playback of default layout without calling md5 compare on last file.

So when cathing file write error checking md5 was somehow missed (unhandled exception in polish is same that english above):

00:58:20 syslog-ng[5768]: Syslog connection established; fd='6', server='AF_INET(192.168.35.20:514)', local='AF_INET(0.0.0.0:0)'
00:58:20 syslog-ng[5768]: syslog-ng starting up; version='3.1.1'
00:58:21 XiboClient[7068]: Get File Completed
00:58:21 XiboClient[7068]: Getting the file : 158.mpeg chunk : 8704000
00:58:24 XiboClient[7068]: Get File Completed
00:58:24 XiboClient[7068]: Getting the file : 158.mpeg chunk : 9216000
00:58:26 XiboClient[7068]: Get File Completed
00:58:26 XiboClient[7068]: Getting the file : 158.mpeg chunk : 9728000
00:58:29 XiboClient[7068]: Get File Completed
00:58:29 XiboClient[7068]: Getting the file : 158.mpeg chunk : 10240000
00:58:31 XiboClient[7068]: Get File Completed
00:58:31 XiboClient[7068]: Getting the file : 158.mpeg chunk : 10752000
00:58:34 XiboClient[7068]: Get File Completed
00:58:34 XiboClient[7068]: Getting the file : 158.mpeg chunk : 11264000
00:58:37 XiboClient[7068]: Get File Completed
00:58:37 XiboClient[7068]: Getting the file : 158.mpeg chunk : 11776000
00:58:38 XiboClient[7068]: Get File Completed
00:58:38 XiboClient[7068]: Info: <message>File has been written to since cache, recalculating</message><method>GetMD5</method>
00:58:38 XiboClient[7068]: Info: <message>Removing stale MD5 from the CacheManager</message><method>Remove</method>
00:58:38 XiboClient[7068]: Info: <message>Adding new MD5 to CacheManager</message><method>Add</method>
00:58:38 XiboClient[7068]: Comparing MD5 of completed download [636daa7848ad07383133ce79983e5c9c] with given MD5 [636daa7848ad07383133ce79983e5c9c]
00:58:38 XiboClient[7068]: Media file changed
00:58:38 XiboClient[7068]: File downloaded: 158.mpeg
00:58:38 XiboClient[7068]: Getting the file : 159.mpeg chunk : 0
00:58:41 XiboClient[7068]: Get File Completed
00:58:41 XiboClient[7068]: Getting the file : 159.mpeg chunk : 512000
00:58:44 XiboClient[7068]: Get File Completed
00:58:44 XiboClient[7068]: Getting the file : 159.mpeg chunk : 1024000
00:58:47 XiboClient[7068]: Get File Completed
00:58:47 XiboClient[7068]: Getting the file : 159.mpeg chunk : 1536000
00:58:49 XiboClient[7068]: Get File Completed
00:58:49 XiboClient[7068]: Getting the file : 159.mpeg chunk : 2048000
00:58:52 XiboClient[7068]: Get File Completed
00:58:52 XiboClient[7068]: Getting the file : 159.mpeg chunk : 2560000
00:58:54 XiboClient[7068]: Get File Completed
00:58:54 XiboClient[7068]: Getting the file : 159.mpeg chunk : 3072000
00:58:57 XiboClient[7068]: Get File Completed
00:58:57 XiboClient[7068]: Getting the file : 159.mpeg chunk : 3584000
00:59:00 XiboClient[7068]: Get File Completed
00:59:00 XiboClient[7068]: Getting the file : 159.mpeg chunk : 4096000
00:59:02 XiboClient[7068]: XmdsTicker: Collection Timer Ticked, but previous request still active
00:59:03 XiboClient[7068]: Get File Completed
00:59:03 XiboClient[7068]: Getting the file : 159.mpeg chunk : 4608000
00:59:06 XiboClient[7068]: Get File Completed
00:59:06 XiboClient[7068]: Getting the file : 159.mpeg chunk : 5120000
00:59:08 XiboClient[7068]: Get File Completed
00:59:08 XiboClient[7068]: Getting the file : 159.mpeg chunk : 5632000
00:59:11 XiboClient[7068]: Get File Completed
00:59:11 XiboClient[7068]: Getting the file : 159.mpeg chunk : 6144000
00:59:14 XiboClient[7068]: Get File Completed
00:59:14 XiboClient[7068]: Getting the file : 159.mpeg chunk : 6656000
00:59:19 XiboClient[7068]: Get File Completed
00:59:19 XiboClient[7068]: Getting the file : 159.mpeg chunk : 7168000
00:59:22 XiboClient[7068]: Get File Completed
00:59:22 XiboClient[7068]: Getting the file : 159.mpeg chunk : 7680000
00:59:25 XiboClient[7068]: Get File Completed
00:59:25 XiboClient[7068]: Getting the file : 159.mpeg chunk : 8192000
00:59:30 XiboClient[7068]: Get File Completed
00:59:30 XiboClient[7068]: Getting the file : 159.mpeg chunk : 8704000
00:59:33 XiboClient[7068]: Get File Completed
00:59:33 XiboClient[7068]: Getting the file : 159.mpeg chunk : 9216000
00:59:36 XiboClient[7068]: Get File Completed
00:59:36 XiboClient[7068]: Getting the file : 159.mpeg chunk : 9728000
00:59:38 XiboClient[7068]: Get File Completed
00:59:38 XiboClient[7068]: Getting the file : 159.mpeg chunk : 10240000
00:59:41 XiboClient[7068]: Get File Completed
00:59:41 XiboClient[7068]: Getting the file : 159.mpeg chunk : 10752000
00:59:44 XiboClient[7068]: Get File Completed
00:59:44 XiboClient[7068]: Getting the file : 159.mpeg chunk : 11264000
00:59:46 XiboClient[7068]: Get File Completed
00:59:46 XiboClient[7068]: Getting the file : 159.mpeg chunk : 11776000
00:59:47 XiboClient[7068]: Get File Completed
00:59:47 XiboClient[7068]: Info: <message>File has been written to since cache, recalculating</message><method>GetMD5</method>
00:59:47 XiboClient[7068]: Info: <message>Removing stale MD5 from the CacheManager</message><method>Remove</method>
00:59:47 XiboClient[7068]: Info: <message>Adding new MD5 to CacheManager</message><method>Add</method>
00:59:47 XiboClient[7068]: Comparing MD5 of completed download [a81e0ce48e2ca8d6c8c53954252deb11] with given MD5 [a81e0ce48e2ca8d6c8c53954252deb11]
00:59:47 XiboClient[7068]: Media file changed
00:59:47 XiboClient[7068]: File downloaded: 159.mpeg
00:59:47 XiboClient[7068]: Getting the file : 160.mpeg chunk : 0
00:59:49 XiboClient[7068]: Get File Completed
00:59:49 XiboClient[7068]: Getting the file : 160.mpeg chunk : 512000
00:59:52 XiboClient[7068]: Get File Completed
00:59:52 XiboClient[7068]: Getting the file : 160.mpeg chunk : 1024000
00:59:54 XiboClient[7068]: Get File Completed
00:59:54 XiboClient[7068]: Getting the file : 160.mpeg chunk : 1536000
00:59:57 XiboClient[7068]: Get File Completed
00:59:57 XiboClient[7068]: Getting the file : 160.mpeg chunk : 2048000
01:00:01 XiboClient[7068]: Get File Completed
01:00:01 XiboClient[7068]: Getting the file : 160.mpeg chunk : 2560000
01:00:03 XiboClient[7068]: Get File Completed
01:00:03 XiboClient[7068]: Getting the file : 160.mpeg chunk : 3072000
01:00:06 XiboClient[7068]: Get File Completed
01:00:06 XiboClient[7068]: Getting the file : 160.mpeg chunk : 3584000
01:00:09 XiboClient[7068]: Get File Completed
01:00:09 XiboClient[7068]: Getting the file : 160.mpeg chunk : 4096000
01:00:12 XiboClient[7068]: Get File Completed
01:00:12 XiboClient[7068]: Getting the file : 160.mpeg chunk : 4608000
01:00:15 XiboClient[7068]: Get File Completed
01:00:15 XiboClient[7068]: Getting the file : 160.mpeg chunk : 5120000
01:00:17 XiboClient[7068]: Get File Completed
01:00:17 XiboClient[7068]: Getting the file : 160.mpeg chunk : 5632000
01:00:20 XiboClient[7068]: Get File Completed
01:00:20 XiboClient[7068]: Getting the file : 160.mpeg chunk : 6144000
01:00:23 XiboClient[7068]: Get File Completed
01:00:23 XiboClient[7068]: Getting the file : 160.mpeg chunk : 6656000
01:00:27 XiboClient[7068]: Get File Completed
01:00:27 XiboClient[7068]: Getting the file : 160.mpeg chunk : 7168000
01:00:30 XiboClient[7068]: Get File Completed
01:00:30 XiboClient[7068]: Getting the file : 160.mpeg chunk : 7680000
01:00:32 XiboClient[7068]: XmdsTicker: Collection Timer Ticked, but previous request still active
01:00:33 XiboClient[7068]: Get File Completed
01:00:33 XiboClient[7068]: Getting the file : 160.mpeg chunk : 8192000
01:00:37 XiboClient[7068]: Get File Completed
01:00:37 XiboClient[7068]: Getting the file : 160.mpeg chunk : 8704000
01:00:40 XiboClient[7068]: Get File Completed
01:00:40 XiboClient[7068]: Getting the file : 160.mpeg chunk : 9216000
01:00:43 XiboClient[7068]: Get File Completed
01:00:43 XiboClient[7068]: Getting the file : 160.mpeg chunk : 9728000
01:00:46 XiboClient[7068]: Get File Completed
01:00:46 XiboClient[7068]: Getting the file : 160.mpeg chunk : 10240000
01:00:48 XiboClient[7068]: Get File Completed
01:00:48 XiboClient[7068]: Getting the file : 160.mpeg chunk : 10752000
01:00:51 XiboClient[7068]: Get File Completed
01:00:51 XiboClient[7068]: Getting the file : 160.mpeg chunk : 11264000
01:00:53 XiboClient[7068]: Get File Completed
01:00:53 XiboClient[7068]: Getting the file : 160.mpeg chunk : 11776000
01:00:54 XiboClient[7068]: Get File Completed
01:00:54 XiboClient[7068]: Info: <message>File has been written to since cache, recalculating</message><method>GetMD5</method>
01:00:55 XiboClient[7068]: Info: <message>Removing stale MD5 from the CacheManager</message><method>Remove</method>
01:00:55 XiboClient[7068]: Info: <message>Adding new MD5 to CacheManager</message><method>Add</method>
01:00:55 XiboClient[7068]: Comparing MD5 of completed download [bf3833a715a1be8d17274b1ed3ad89b4] with given MD5 [c3aefdaf4248b73e531e5d1c17d845e9]
01:00:55 XiboClient[7068]: Error getting file 160.mpeg, HASH failed. Starting again
01:00:55 XiboClient[7068]: Getting the file : 160.mpeg chunk : 0
01:00:57 XiboClient[7068]: Get File Completed
01:00:57 XiboClient[7068]: Getting the file : 160.mpeg chunk : 159101
01:00:59 XiboClient[7068]: Get File Completed
01:00:59 XiboClient[7068]: Getting the file : 160.mpeg chunk : 318202
01:01:01 XiboClient[7068]: Get File Completed
01:01:01 XiboClient[7068]: Getting the file : 160.mpeg chunk : 477303
01:01:02 XiboClient[7068]: Get File Completed
01:01:02 XiboClient[7068]: Getting the file : 160.mpeg chunk : 636404
01:01:04 XiboClient[7068]: Get File Completed
01:01:04 XiboClient[7068]: Getting the file : 160.mpeg chunk : 795505
01:01:05 XiboClient[7068]: Get File Completed
01:01:05 XiboClient[7068]: Getting the file : 160.mpeg chunk : 954606
01:01:07 XiboClient[7068]: Get File Completed
01:01:07 XiboClient[7068]: Getting the file : 160.mpeg chunk : 1113707
01:01:09 XiboClient[7068]: Get File Completed
01:01:09 XiboClient[7068]: Getting the file : 160.mpeg chunk : 1272808
01:01:10 XiboClient[7068]: Get File Completed
01:01:10 XiboClient[7068]: Getting the file : 160.mpeg chunk : 1431909
01:01:12 XiboClient[7068]: Get File Completed
01:01:12 XiboClient[7068]: Getting the file : 160.mpeg chunk : 1591010
01:01:15 XiboClient[7068]: Get File Completed
01:01:15 XiboClient[7068]: Getting the file : 160.mpeg chunk : 1750111
01:01:17 XiboClient[7068]: Get File Completed
01:01:17 XiboClient[7068]: <message>Unhanded Exception when processing getFile response: Proces nie mo?e uzyska? dost?pu do pliku 'H:\XiboLib\160.mpeg', poniewa? jest on u?ywany przez inny proces.</message><method>xmdsFile_GetFileCompleted</method>
01:01:17 XiboClient[7068]: Finished Recieving 4 files
01:01:17 XiboClient[7068]: File Collector Complete - getting Schedule.
01:01:17 XiboClient[7068]: Schedule Retrival Complete.
01:01:17 XiboClient[7068]: Schedule - ScheduleCompleted: Different Schedules Detected, writing new schedule.
01:01:17 XiboClient[7068]: xmds_ScheduleCompleted: New Schedule Recieved
01:01:17 XiboClient[7068]: MainForm - ScheduleChangeEvent: Schedule Changing to H:\XiboLib\227.xlf
01:01:17 XiboClient[7068]: Audit: Recording a Stat Record. Current Count = 0
01:01:17 XiboClient[7068]: MainForm - DestoryLayout: Destroying Layout
01:01:18 XiboClient[7068]: Odwo?anie do obiektu nie zosta?o ustawione na wyst?pienie obiektu.
01:01:18 XiboClient[7068]: HardwareKey: [IN]
01:01:18 XiboClient[7068]: HardwareKey: [OUT]
01:01:18 XiboClient[7068]: MainForm - Prepare Layout: Created new region
01:01:18 XiboClient[7068]: Region - SetNextMediaNode: New media detected video
01:01:18 XiboClient[7068]: Region - EvalOptions: Creating new media: video, 158
01:01:22 XiboClient[7068]: Region - Eval Options: Showing new media
01:01:22 XiboClient[7068]: MainForm - Prepare Layout: Adding region
01:01:46 XiboClient[7068]: Media - SignalElapsedEvent: Media Complete
01:01:47 XiboClient[7068]: Region - DurationElapsedEvent: Media Elapsed: H:\XiboLib\158.mpeg
01:01:47 XiboClient[7068]: Region - SetNextMediaNode: New media detected video
01:01:47 XiboClient[7068]: Region - SetNextMediaNode: Trying to dispose of the current media
01:01:47 XiboClient[7068]: Audit: Recording a Stat Record. Current Count = 1
01:01:47 XiboClient[7068]: Region - EvalOptions: Creating new media: video, 159
01:01:47 XiboClient[7068]: Region - Eval Options: Showing new media
01:02:06 XiboClient[7068]: Media - SignalElapsedEvent: Media Complete
01:02:06 XiboClient[7068]: Region - DurationElapsedEvent: Media Elapsed: H:\XiboLib\159.mpeg
01:02:06 XiboClient[7068]: Region - SetNextMediaNode: No Valid media nodes to display
01:02:06 XiboClient[7068]: Region - EvalOptions: Creating new media: video, 160
01:02:06 XiboClient[7068]: Region - Eval Options: Showing new media
01:02:06 XiboClient[7068]: Collection Timer Ticked, Firing RequiredFilesAsync
01:02:07 XiboClient[7068]: Schedule - RequiredFilesCompleted: RequiredFilesAsync complete.
01:02:07 XiboClient[7068]: HardwareKey: [IN]
01:02:07 XiboClient[7068]: HardwareKey: [OUT]
01:02:07 XiboClient[7068]: Comparing current MD5 [1e6b4d25943fd49ab63a2948b00b34c7] with given MD5 [1e6b4d25943fd49ab63a2948b00b34c7]
01:02:07 XiboClient[7068]: Comparing current MD5 [636daa7848ad07383133ce79983e5c9c] with given MD5 [636daa7848ad07383133ce79983e5c9c]
01:02:07 XiboClient[7068]: Comparing current MD5 [a81e0ce48e2ca8d6c8c53954252deb11] with given MD5 [a81e0ce48e2ca8d6c8c53954252deb11]
01:02:07 XiboClient[7068]: Info: <message>File has been written to since cache, recalculating</message><method>GetMD5</method>
01:02:08 XiboClient[7068]: Info: <message>Removing stale MD5 from the CacheManager</message><method>Remove</method>
01:02:08 XiboClient[7068]: Info: <message>Adding new MD5 to CacheManager</message><method>Add</method>
01:02:08 XiboClient[7068]: Comparing current MD5 [0dcda6ca2f0f39fcf198da2091d164a5] with given MD5 [c3aefdaf4248b73e531e5d1c17d845e9]
01:02:08 XiboClient[7068]: Info: <message>Removing stale MD5 from the CacheManager</message><method>Remove</method>
01:02:08 XiboClient[7068]: <message>Unable to delete incorrect file because: Proces nie mo?e uzyska? dost?pu do pliku 'H:\XiboLib\160.mpeg', poniewa? jest on u?ywany przez inny proces.</message><method>CompareAndCollect</method>
01:02:08 XiboClient[7068]: HardwareKey: [IN]
01:02:08 XiboClient[7068]: HardwareKey: [OUT]
01:02:08 XiboClient[7068]: There are 1 files to get
01:02:08 XiboClient[7068]: Getting the file : 160.mpeg chunk : 0
01:02:08 XiboClient[7068]: Info: <message>About to Write the Cache Manager</message><method>CacheManager - WriteCacheManager</method>

Revision history for this message
Alex Harrington (alexharrington) said :
#12

But surely deliberately preventing the client writing the file to disk is very different from the behavior the op described where adding a new file causes the new version layout to run without the new media having been downloaded first?

Bartek <email address hidden> wrote:

Question #119684 on Xibo changed:
https://answers.launchpad.net/xibo/+question/119684

Bartek posted a new comment:
I've managed to recreate similat situation, and i'm sorry to say that
was quite easy:

Layout with three files,
On third file i've opened file in nonlock mode during transfer, so xibo was able to keep downloading file.
Correctly detected later by md5 and redownloading started.
During second try i've opened in notepad to create lock and got same error as above.
After downloading client started playback of default layout without calling md5 compare on last file.

So when cathing file write error checking md5 was somehow missed
(unhandled exception in polish is same that english above):

00:58:20 syslog-ng[5768]: Syslog connection established; fd='6', server='AF_INET(192.168.35.20:514)', local='AF_INET(0.0.0.0:0)'
00:58:20 syslog-ng[5768]: syslog-ng starting up; version='3.1.1'
00:58:21 XiboClient[7068]: Get File Completed
00:58:21 XiboClient[7068]: Getting the file : 158.mpeg chunk : 8704000
00:58:24 XiboClient[7068]: Get File Completed
00:58:24 XiboClient[7068]: Getting the file : 158.mpeg chunk : 9216000
00:58:26 XiboClient[7068]: Get File Completed
00:58:26 XiboClient[7068]: Getting the file : 158.mpeg chunk : 9728000
00:58:29 XiboClient[7068]: Get File Completed
00:58:29 XiboClient[7068]: Getting the file : 158.mpeg chunk : 10240000
00:58:31 XiboClient[7068]: Get File Completed
00:58:31 XiboClient[7068]: Getting the file : 158.mpeg chunk : 10752000
00:58:34 XiboClient[7068]: Get File Completed
00:58:34 XiboClient[7068]: Getting the file : 158.mpeg chunk : 11264000
00:58:37 XiboClient[7068]: Get File Completed
00:58:37 XiboClient[7068]: Getting the file : 158.mpeg chunk : 11776000
00:58:38 XiboClient[7068]: Get File Completed
00:58:38 XiboClient[7068]: Info: <message>File has been written to since cache, recalculating</message><method>GetMD5</method>
00:58:38 XiboClient[7068]: Info: <message>Removing stale MD5 from the CacheManager</message><method>Remove</method>
00:58:38 XiboClient[7068]: Info: <message>Adding new MD5 to CacheManager</message><method>Add</method>
00:58:38 XiboClient[7068]: Comparing MD5 of completed download [636daa7848ad07383133ce79983e5c9c] with given MD5 [636daa7848ad07383133ce79983e5c9c]
00:58:38 XiboClient[7068]: Media file changed
00:58:38 XiboClient[7068]: File downloaded: 158.mpeg
00:58:38 XiboClient[7068]: Getting the file : 159.mpeg chunk : 0
00:58:41 XiboClient[7068]: Get File Completed
00:58:41 XiboClient[7068]: Getting the file : 159.mpeg chunk : 512000
00:58:44 XiboClient[7068]: Get File Completed
00:58:44 XiboClient[7068]: Getting the file : 159.mpeg chunk : 1024000
00:58:47 XiboClient[7068]: Get File Completed
00:58:47 XiboClient[7068]: Getting the file : 159.mpeg chunk : 1536000
00:58:49 XiboClient[7068]: Get File Completed
00:58:49 XiboClient[7068]: Getting the file : 159.mpeg chunk : 2048000
00:58:52 XiboClient[7068]: Get File Completed
00:58:52 XiboClient[7068]: Getting the file : 159.mpeg chunk : 2560000
00:58:54 XiboClient[7068]: Get File Completed
00:58:54 XiboClient[7068]: Getting the file : 159.mpeg chunk : 3072000
00:58:57 XiboClient[7068]: Get File Completed
00:58:57 XiboClient[7068]: Getting the file : 159.mpeg chunk : 3584000
00:59:00 XiboClient[7068]: Get File Completed
00:59:00 XiboClient[7068]: Getting the file : 159.mpeg chunk : 4096000
00:59:02 XiboClient[7068]: XmdsTicker: Collection Timer Ticked, but previous request still active
00:59:03 XiboClient[7068]: Get File Completed
00:59:03 XiboClient[7068]: Getting the file : 159.mpeg chunk : 4608000
00:59:06 XiboClient[7068]: Get File Completed
00:59:06 XiboClient[7068]: Getting the file : 159.mpeg chunk : 5120000
00:59:08 XiboClient[7068]: Get File Completed
00:59:08 XiboClient[7068]: Getting the file : 159.mpeg chunk : 5632000
00:59:11 XiboClient[7068]: Get File Completed
00:59:11 XiboClient[7068]: Getting the file : 159.mpeg chunk : 6144000
00:59:14 XiboClient[7068]: Get File Completed
00:59:14 XiboClient[7068]: Getting the file : 159.mpeg chunk : 6656000
00:59:19 XiboClient[7068]: Get File Completed
00:59:19 XiboClient[7068]: Getting the file : 159.mpeg chunk : 7168000
00:59:22 XiboClient[7068]: Get File Completed
00:59:22 XiboClient[7068]: Getting the file : 159.mpeg chunk : 7680000
00:59:25 XiboClient[7068]: Get File Completed
00:59:25 XiboClient[7068]: Getting the file : 159.mpeg chunk : 8192000
00:59:30 XiboClient[7068]: Get File Completed
00:59:30 XiboClient[7068]: Getting the file : 159.mpeg chunk : 8704000
00:59:33 XiboClient[7068]: Get File Completed
00:59:33 XiboClient[7068]: Getting the file : 159.mpeg chunk : 9216000
00:59:36 XiboClient[7068]: Get File Completed
00:59:36 XiboClient[7068]: Getting the file : 159.mpeg chunk : 9728000
00:59:38 XiboClient[7068]: Get File Completed
00:59:38 XiboClient[7068]: Getting the file : 159.mpeg chunk : 10240000
00:59:41 XiboClient[7068]: Get File Completed
00:59:41 XiboClient[7068]: Getting the file : 159.mpeg chunk : 10752000
00:59:44 XiboClient[7068]: Get File Completed
00:59:44 XiboClient[7068]: Getting the file : 159.mpeg chunk : 11264000
00:59:46 XiboClient[7068]: Get File Completed
00:59:46 XiboClient[7068]: Getting the file : 159.mpeg chunk : 11776000
00:59:47 XiboClient[7068]: Get File Completed
00:59:47 XiboClient[7068]: Info: <message>File has been written to since cache, recalculating</message><method>GetMD5</method>
00:59:47 XiboClient[7068]: Info: <message>Removing stale MD5 from the CacheManager</message><method>Remove</method>
00:59:47 XiboClient[7068]: Info: <message>Adding new MD5 to CacheManager</message><method>Add</method>
00:59:47 XiboClient[7068]: Comparing MD5 of completed download [a81e0ce48e2ca8d6c8c53954252deb11] with given MD5 [a81e0ce48e2ca8d6c8c53954252deb11]
00:59:47 XiboClient[7068]: Media file changed
00:59:47 XiboClient[7068]: File downloaded: 159.mpeg
00:59:47 XiboClient[7068]: Getting the file : 160.mpeg chunk : 0
00:59:49 XiboClient[7068]: Get File Completed
00:59:49 XiboClient[7068]: Getting the file : 160.mpeg chunk : 512000
00:59:52 XiboClient[7068]: Get File Completed
00:59:52 XiboClient[7068]: Getting the file : 160.mpeg chunk : 1024000
00:59:54 XiboClient[7068]: Get File Completed
00:59:54 XiboClient[7068]: Getting the file : 160.mpeg chunk : 1536000
00:59:57 XiboClient[7068]: Get File Completed
00:59:57 XiboClient[7068]: Getting the file : 160.mpeg chunk : 2048000
01:00:01 XiboClient[7068]: Get File Completed
01:00:01 XiboClient[7068]: Getting the file : 160.mpeg chunk : 2560000
01:00:03 XiboClient[7068]: Get File Completed
01:00:03 XiboClient[7068]: Getting the file : 160.mpeg chunk : 3072000
01:00:06 XiboClient[7068]: Get File Completed
01:00:06 XiboClient[7068]: Getting the file : 160.mpeg chunk : 3584000
01:00:09 XiboClient[7068]: Get File Completed
01:00:09 XiboClient[7068]: Getting the file : 160.mpeg chunk : 4096000
01:00:12 XiboClient[7068]: Get File Completed
01:00:12 XiboClient[7068]: Getting the file : 160.mpeg chunk : 4608000
01:00:15 XiboClient[7068]: Get File Completed
01:00:15 XiboClient[7068]: Getting the file : 160.mpeg chunk : 5120000
01:00:17 XiboClient[7068]: Get File Completed
01:00:17 XiboClient[7068]: Getting the file : 160.mpeg chunk : 5632000
01:00:20 XiboClient[7068]: Get File Completed
01:00:20 XiboClient[7068]: Getting the file : 160.mpeg chunk : 6144000
01:00:23 XiboClient[7068]: Get File Completed
01:00:23 XiboClient[7068]: Getting the file : 160.mpeg chunk : 6656000
01:00:27 XiboClient[7068]: Get File Completed
01:00:27 XiboClient[7068]: Getting the file : 160.mpeg chunk : 7168000
01:00:30 XiboClient[7068]: Get File Completed
01:00:30 XiboClient[7068]: Getting the file : 160.mpeg chunk : 7680000
01:00:32 XiboClient[7068]: XmdsTicker: Collection Timer Ticked, but previous request still active
01:00:33 XiboClient[7068]: Get File Completed
01:00:33 XiboClient[7068]: Getting the file : 160.mpeg chunk : 8192000
01:00:37 XiboClient[7068]: Get File Completed
01:00:37 XiboClient[7068]: Getting the file : 160.mpeg chunk : 8704000
01:00:40 XiboClient[7068]: Get File Completed
01:00:40 XiboClient[7068]: Getting the file : 160.mpeg chunk : 9216000
01:00:43 XiboClient[7068]: Get File Completed
01:00:43 XiboClient[7068]: Getting the file : 160.mpeg chunk : 9728000
01:00:46 XiboClient[7068]: Get File Completed
01:00:46 XiboClient[7068]: Getting the file : 160.mpeg chunk : 10240000
01:00:48 XiboClient[7068]: Get File Completed
01:00:48 XiboClient[7068]: Getting the file : 160.mpeg chunk : 10752000
01:00:51 XiboClient[7068]: Get File Completed
01:00:51 XiboClient[7068]: Getting the file : 160.mpeg chunk : 11264000
01:00:53 XiboClient[7068]: Get File Completed
01:00:53 XiboClient[7068]: Getting the file : 160.mpeg chunk : 11776000
01:00:54 XiboClient[7068]: Get File Completed
01:00:54 XiboClient[7068]: Info: <message>File has been written to since cache, recalculating</message><method>GetMD5</method>
01:00:55 XiboClient[7068]: Info: <message>Removing stale MD5 from the CacheManager</message><method>Remove</method>
01:00:55 XiboClient[7068]: Info: <message>Adding new MD5 to CacheManager</message><method>Add</method>
01:00:55 XiboClient[7068]: Comparing MD5 of completed download [bf3833a715a1be8d17274b1ed3ad89b4] with given MD5 [c3aefdaf4248b73e531e5d1c17d845e9]
01:00:55 XiboClient[7068]: Error getting file 160.mpeg, HASH failed. Starting again
01:00:55 XiboClient[7068]: Getting the file : 160.mpeg chunk : 0
01:00:57 XiboClient[7068]: Get File Completed
01:00:57 XiboClient[7068]: Getting the file : 160.mpeg chunk : 159101
01:00:59 XiboClient[7068]: Get File Completed
01:00:59 XiboClient[7068]: Getting the file : 160.mpeg chunk : 318202
01:01:01 XiboClient[7068]: Get File Completed
01:01:01 XiboClient[7068]: Getting the file : 160.mpeg chunk : 477303
01:01:02 XiboClient[7068]: Get File Completed
01:01:02 XiboClient[7068]: Getting the file : 160.mpeg chunk : 636404
01:01:04 XiboClient[7068]: Get File Completed
01:01:04 XiboClient[7068]: Getting the file : 160.mpeg chunk : 795505
01:01:05 XiboClient[7068]: Get File Completed
01:01:05 XiboClient[7068]: Getting the file : 160.mpeg chunk : 954606
01:01:07 XiboClient[7068]: Get File Completed
01:01:07 XiboClient[7068]: Getting the file : 160.mpeg chunk : 1113707
01:01:09 XiboClient[7068]: Get File Completed
01:01:09 XiboClient[7068]: Getting the file : 160.mpeg chunk : 1272808
01:01:10 XiboClient[7068]: Get File Completed
01:01:10 XiboClient[7068]: Getting the file : 160.mpeg chunk : 1431909
01:01:12 XiboClient[7068]: Get File Completed
01:01:12 XiboClient[7068]: Getting the file : 160.mpeg chunk : 1591010
01:01:15 XiboClient[7068]: Get File Completed
01:01:15 XiboClient[7068]: Getting the file : 160.mpeg chunk : 1750111
01:01:17 XiboClient[7068]: Get File Completed
01:01:17 XiboClient[7068]: <message>Unhanded Exception when processing getFile response: Proces nie mo?e uzyska? dost?pu do pliku 'H:\XiboLib\160.mpeg', poniewa? jest on u?ywany przez inny proces.</message><method>xmdsFile_GetFileCompleted</method>
01:01:17 XiboClient[7068]: Finished Recieving 4 files
01:01:17 XiboClient[7068]: File Collector Complete - getting Schedule.
01:01:17 XiboClient[7068]: Schedule Retrival Complete.
01:01:17 XiboClient[7068]: Schedule - ScheduleCompleted: Different Schedules Detected, writing new schedule.
01:01:17 XiboClient[7068]: xmds_ScheduleCompleted: New Schedule Recieved
01:01:17 XiboClient[7068]: MainForm - ScheduleChangeEvent: Schedule Changing to H:\XiboLib\227.xlf
01:01:17 XiboClient[7068]: Audit: Recording a Stat Record. Current Count = 0
01:01:17 XiboClient[7068]: MainForm - DestoryLayout: Destroying Layout
01:01:18 XiboClient[7068]: Odwo?anie do obiektu nie zosta?o ustawione na wyst?pienie obiektu.
01:01:18 XiboClient[7068]: HardwareKey: [IN]
01:01:18 XiboClient[7068]: HardwareKey: [OUT]
01:01:18 XiboClient[7068]: MainForm - Prepare Layout: Created new region
01:01:18 XiboClient[7068]: Region - SetNextMediaNode: New media detected video
01:01:18 XiboClient[7068]: Region - EvalOptions: Creating new media: video, 158
01:01:22 XiboClient[7068]: Region - Eval Options: Showing new media
01:01:22 XiboClient[7068]: MainForm - Prepare Layout: Adding region
01:01:46 XiboClient[7068]: Media - SignalElapsedEvent: Media Complete
01:01:47 XiboClient[7068]: Region - DurationElapsedEvent: Media Elapsed: H:\XiboLib\158.mpeg
01:01:47 XiboClient[7068]: Region - SetNextMediaNode: New media detected video
01:01:47 XiboClient[7068]: Region - SetNextMediaNode: Trying to dispose of the current media
01:01:47 XiboClient[7068]: Audit: Recording a Stat Record. Current Count = 1
01:01:47 XiboClient[7068]: Region - EvalOptions: Creating new media: video, 159
01:01:47 XiboClient[7068]: Region - Eval Options: Showing new media
01:02:06 XiboClient[7068]: Media - SignalElapsedEvent: Media Complete
01:02:06 XiboClient[7068]: Region - DurationElapsedEvent: Media Elapsed: H:\XiboLib\159.mpeg
01:02:06 XiboClient[7068]: Region - SetNextMediaNode: No Valid media nodes to display
01:02:06 XiboClient[7068]: Region - EvalOptions: Creating new media: video, 160
01:02:06 XiboClient[7068]: Region - Eval Options: Showing new media
01:02:06 XiboClient[7068]: Collection Timer Ticked, Firing RequiredFilesAsync
01:02:07 XiboClient[7068]: Schedule - RequiredFilesCompleted: RequiredFilesAsync complete.
01:02:07 XiboClient[7068]: HardwareKey: [IN]
01:02:07 XiboClient[7068]: HardwareKey: [OUT]
01:02:07 XiboClient[7068]: Comparing current MD5 [1e6b4d25943fd49ab63a2948b00b34c7] with given MD5 [1e6b4d25943fd49ab63a2948b00b34c7]
01:02:07 XiboClient[7068]: Comparing current MD5 [636daa7848ad07383133ce79983e5c9c] with given MD5 [636daa7848ad07383133ce79983e5c9c]
01:02:07 XiboClient[7068]: Comparing current MD5 [a81e0ce48e2ca8d6c8c53954252deb11] with given MD5 [a81e0ce48e2ca8d6c8c53954252deb11]
01:02:07 XiboClient[7068]: Info: <message>File has been written to since cache, recalculating</message><method>GetMD5</method>
01:02:08 XiboClient[7068]: Info: <message>Removing stale MD5 from the CacheManager</message><method>Remove</method>
01:02:08 XiboClient[7068]: Info: <message>Adding new MD5 to CacheManager</message><method>Add</method>
01:02:08 XiboClient[7068]: Comparing current MD5 [0dcda6ca2f0f39fcf198da2091d164a5] with given MD5 [c3aefdaf4248b73e531e5d1c17d845e9]
01:02:08 XiboClient[7068]: Info: <message>Removing stale MD5 from the CacheManager</message><method>Remove</method>
01:02:08 XiboClient[7068]: <message>Unable to delete incorrect file because: Proces nie mo?e uzyska? dost?pu do pliku 'H:\XiboLib\160.mpeg', poniewa? jest on u?ywany przez inny proces.</message><method>CompareAndCollect</method>
01:02:08 XiboClient[7068]: HardwareKey: [IN]
01:02:08 XiboClient[7068]: HardwareKey: [OUT]
01:02:08 XiboClient[7068]: There are 1 files to get
01:02:08 XiboClient[7068]: Getting the file : 160.mpeg chunk : 0
01:02:08 XiboClient[7068]: Info: <message>About to Write the Cache Manager</message><method>CacheManager - WriteCacheManager</method>

--
You received this question notification because you are a member of Xibo
Developers, which is an answer contact for Xibo.

This email carries a disclaimer, a copy of which may be read at http://learning.longhill.org.uk/disclaimer

Revision history for this message
Bartek (czajka) said :
#13

I've focused on subject part - why file is even played when it was never downloaded correctly.

Maybe reason is differrent in both situations (file locked becouse some other reason), but effect probably same: file is locked during (re)download, exception is raised, damaged file is played becouse md5 check was omitted.

Revision history for this message
Bartek (czajka) said :
#14

So we don't know why downloading is interrupted (maybe fs is damaged - chkdsk??, some antivirus locks it etc), but we know why xibo tries to play file, and it's looks like no fault in cache manager becouse it's not even called in that situation.

Revision history for this message
Dan Garner (dangarner) said :
#15

What we are actually saying here is that when a file is downloaded by Xibo
it should always be removed from the cache manager first.

I.e. when the file is deleted, it should also be removed from the cache
manager - I thought it already did this. I will have to look through the
code later to be sure.

Revision history for this message
Alex Harrington (alexharrington) said :
#16

Seems similar to this bug so linking for now.

Revision history for this message
Teiwaz (danielbc) said :
#17

Hi,

We have a similar problem, but we know why: Our administrator modified directly the file in conflict on Library folder (server side), then when Xibo compare hashes, they are differents. Delete and upload the file on admin interface resolved the problem.

Here is part of my log:

HardwareKey: [IN]
HardwareKey: [OUT]
Getting the file : 15.png chunk : 0
Get File Completed
Comparing MD5 of completed download [81e9e09803ad15060d6f769b0c0d35ee] with given MD5 [51d693db2bd554ce2ae31698c25fb80a]
Error getting file 15.png, HASH failed. Starting again
Getting the file : 15.png chunk : 0
Get File Completed
Comparing MD5 of completed download [81e9e09803ad15060d6f769b0c0d35ee] with given MD5 [51d693db2bd554ce2ae31698c25fb80a]
Error getting file 15.png, HASH failed. Starting again
Getting the file : 15.png chunk : 0
Get File Completed
Comparing MD5 of completed download [81e9e09803ad15060d6f769b0c0d35ee] with given MD5 [51d693db2bd554ce2ae31698c25fb80a]
Error getting file 15.png, HASH failed. Starting again
Getting the file : 15.png chunk : 0
Get File Completed
Comparing MD5 of completed download [81e9e09803ad15060d6f769b0c0d35ee] with given MD5 [51d693db2bd554ce2ae31698c25fb80a]
Error getting file 15.png, HASH failed. Starting again

Can you help with this problem?

Provide an answer of your own, or ask t4ol1n for more information if necessary.

To post a message you must log in.