Layout plays before files have downloaded- again

Just upgraded from 1.7.4 (with fixed .exe you guys provided for this issue- please see previous thread with same title as this one) to 1.7.9. Unfortunately, the problem of the layout displaying before the powerpoint file has downloaded is back again on all my displays that I’ve tested so far. Can easily replicate. They don’t display the splash screen, just dive pretty much straight into displaying the rest oif the layout, leaving a blank area where the powerpoint should be. If I watch the Library folder, the file continues to download until complete, but never displays. Close and open client, and it then displays as normal. Please can you fix this for me quickly, as I’m having to manually stop and start the clients numerous times a day!! Thanks

hm, well as far as I know it was fixed in 1.7.5 and should remain fixed in current version.

Could you do similar tests like last time?
ie simple layout with ppt in one region and grab schedule.xml after your test

Just so we can see if it’s somehow the same issue or is it something different.

Sure, exactly the same behaviour. File begins to download, layout immediately displays so just a black screen, then powerpoint never displayed once fully downloaded. File is called 3091.ppt, schedule.xml below:

‘<?xml version="1.0"?>





jquery-1.11.1.min.js
xibo-layout-scaler.js
xibo-webpage-render.js
moment.js
jquery.marquee.min.js
jquery-cycle-2.1.6.min.js
xibo-text-render.js
xibo-dataset-render.js
flipclock.min.js


Sorry, try that again:

<?xml version="1.0"?>
<schedule>
  <layout file="46" fromdt="2016-10-10 22:00:00" todt="2016-10-11 07:00:00" scheduleid="688" priority="1" dependents=""/>
  <layout file="46" fromdt="2016-10-11 22:00:00" todt="2016-10-12 07:00:00" scheduleid="688" priority="1" dependents=""/>
  <default file="118"/>
  <dependants>
    <file>jquery-1.11.1.min.js</file>
    <file>xibo-layout-scaler.js</file>
    <file>xibo-webpage-render.js</file>
    <file>moment.js</file>
    <file>jquery.marquee.min.js</file>
    <file>jquery-cycle-2.1.6.min.js</file>
    <file>xibo-text-render.js</file>
    <file>xibo-dataset-render.js</file>
    <file>flipclock.min.js</file>
  </dependants>
</schedule>

Have you upgraded the CMS along with the players? And is the PPT file on the default layout?

Hi Dan yes have upgraded CMS to match and this was the default layout I’m playing with. That’s pretty much all I use on all my displays with just the odd scheduled item for anything out of the ordinary.

We ran into some problems with the fix included for you last time - it turned out to be a far-too time consuming check on the readiness of a layout for the player to do when there were a lot of layouts in the schedule. Therefore (unfortunately) the check had to be removed.

However, I did believe that the implementation of layout dependencies would have covered off your previous issue - but it turns out that has only been included on the default layout from 1.8 onward.

I think the solution is to patch the CMS so that it also produces the dependency information for the default layout and I can work that into the product and provide a patch file. :bug: and patch

In the meantime can you run a quick test with a scheduled layout to confirm that the problem isn’t present in that case?

Thanks Dan,

So I’ve just scheduled the same layout I was using initially, the one with just a powerpoint file and nothing else. I then updated the powerpoint within the layout, but the behaviour remains the same. Blank screen, powerpoint downloads in the background but never displays. Close and open client, and it displays fine :frowning:

Odd - can you provide the schedule.xml for that test so we can make sure the dependants are there?

I’ve just updated the original answer with a patch to include those on the default layout - although if its not working with a regular layout then that won’t help you :slight_smile:

You could also make sure that Expire Modified Layouts is ticked in the Display Settings Profile - it may be that setting is confusing the test.

Expire Modified Layouts is definitely checked, and I can confirm that this has been reflected in the client config file too. Just done the test again, here’s the schedule.xml:

<?xml version="1.0"?>
<schedule>
  <layout file="118" fromdt="2016-10-10 13:45:00" todt="2016-10-10 13:55:00" scheduleid="690" priority="0" dependents="3094.ppt"/>
  <layout file="46" fromdt="2016-10-10 22:00:00" todt="2016-10-11 07:00:00" scheduleid="688" priority="1" dependents=""/>
  <layout file="46" fromdt="2016-10-11 22:00:00" todt="2016-10-12 07:00:00" scheduleid="688" priority="1" dependents=""/>
  <default file="131"/>
  <dependants>
    <file>jquery-1.11.1.min.js</file>
    <file>xibo-layout-scaler.js</file>
    <file>xibo-webpage-render.js</file>
    <file>moment.js</file>
    <file>jquery.marquee.min.js</file>
    <file>jquery-cycle-2.1.6.min.js</file>
    <file>xibo-text-render.js</file>
    <file>xibo-dataset-render.js</file>
    <file>flipclock.min.js</file>
  </dependants>
</schedule>

I don’t really understand the problem - layout dependencies should be tested and confirmed present before that layout gets added to the schedule - I can only think that this is a race case something like:

  • Layout is playing
  • Layout updated on the CMS
  • Layout XLF downloaded, Layout Media pending
  • Layout gets expired (due to expire modified layouts)
  • Schedule Manager hasn’t run since pt 3, therefore layout still in the schedule
  • Therefore layout still considered valid in the schedule

I’m following this thread at the moment - in the meantime here is an exe which implements a last ditch (dirty) check that the file exists before loading the layout.


I think I might have tracked down the race condition and fixed it - but there isn’t any harm in leaving the last ditch check in place. If you can try the exe and let me know if it fixes your problem, I will get that committed into the next release.

HI Dan,

First off, I’m really grateful for you picking this up so quickly and providing the fixes!!

However, sorry to have to break this to you but I’ve just tested the .exe and the behaviour remains unchanged. Tried with both default layout and also scheduled, but it’s just the same. Immediate blank screen, .ppt downloads fully but is never displayed, close and open client and there it is! :frowning:

Thanks

OK - i’m stumped then :confounded:

I’ve put it back exactly as it was in the previous topic - to try and isolate whether it is a different problem entirely. Please can you try the EXE (same link).

Thanks for your patience.

Dan,

Have tried the second .exe, and still the same with both default and scheduled :frowning:

Thanks

OK, I think we have found the problem - can you please try the attached MSI? https://dl.dropboxusercontent.com/u/353651/xibo-client-1.7.9-win32-x86.msi

Sorry Dan, still just the same!

We reproduced the issue here, installed that, and then couldn’t from then on, so I’m fairly confident that does address it.

Can you first completely uninstall the Player, then install fresh from that MSI please.

Then once that’s done, if you still see the issue, setup the Player to create a local log file with full auditing so we can see what the Player thinks is happening? Recreate the issue, then let us have the log please.

Something like that will do the job. The log file location needs to be somewhere writeable by the user the Player runs as.

Hi Alex,

I had to do an uninstall first as the msi would not over-install. So I closed the client, renamed the config file temporarily, uninstalled and reinstalled with new .msi, then renamed the config file back again.

I have replicated with audit log enabled:

Info: <logdate>10/11/2016 1:01:50 PM</logdate><thread>UI Thread</thread><method>MainForm</method><message>Client Initialised</message>
Audit: <logdate>10/11/2016 1:01:50 PM</logdate><thread>UI Thread</thread><method>GetMD5</method><message>648a7b038cc539e67b97be8d23842f35.htm has been written to since cache, recalculating</message>
XMDS Location: http://172.17.3.39/xibo/xmds.php?v=4
Info: <logdate>10/11/2016 1:01:50 PM</logdate><thread>RegisterAgentThread</thread><method>RegisterAgent - Run</method><message>Thread Started</message>
Info: <logdate>10/11/2016 1:01:50 PM</logdate><thread>RequiredFilesAgentThread</thread><method>RequiredFilesAgent - Run</method><message>Thread Started</message>
Info: <logdate>10/11/2016 1:01:50 PM</logdate><thread>ScheduleAgentThread</thread><method>ScheduleAgent - Run</method><message>Thread Started</message>
Audit: <logdate>10/11/2016 1:01:50 PM</logdate><thread>ScheduleAgentThread</thread><method>ScheduleAgent - Run</method><message>Thread Woken and Lock Obtained</message>
Info: <logdate>10/11/2016 1:01:50 PM</logdate><thread>ScheduleManagerThread</thread><method>ScheduleManager - Run</method><message>Thread Started</message>
Audit: <logdate>10/11/2016 1:01:50 PM</logdate><thread>ScheduleManagerThread</thread><method>ScheduleManager - Run</method><message>Schedule Timer Ticked</message>
Audit: <logdate>10/11/2016 1:01:50 PM</logdate><thread>ScheduleManagerThread</thread><method>ScheduleManager - IsNewScheduleAvailable</method><message>Layouts in Current Schedule: </message>
Audit: <logdate>10/11/2016 1:01:50 PM</logdate><thread>ScheduleManagerThread</thread><method>ScheduleManager - IsNewScheduleAvailable</method><message>Layouts in New Schedule: </message>
Audit: <logdate>10/11/2016 1:01:50 PM</logdate><thread>ScheduleManagerThread</thread><method>MainForm - ScheduleChangeEvent</method><message>Schedule Changing to C:\Library\131.xlf</message>
Error: <logdate>10/11/2016 1:01:50 PM</logdate><thread>ScheduleManagerThread</thread><method>Schedule - OnScheduleManagerCheckComplete</method><message>Agent threads are dead, not updating status.json</message>
Info: <logdate>10/11/2016 1:01:50 PM</logdate><thread>LibraryAgent</thread><method>LibraryAgent - Run</method><message>Thread Started</message>
Info: <logdate>10/11/2016 1:01:50 PM</logdate><thread>LogAgent</thread><method>LogAgent - Run</method><message>Thread Started</message>
Audit: <logdate>10/11/2016 1:01:50 PM</logdate><thread>LibraryAgent</thread><method>LibraryAgent - Run</method><message>Number of required files = 17</message>
Info: <logdate>10/11/2016 1:01:50 PM</logdate><thread>RegisterAgentThread</thread><method>RegisterAgent - Run</method><message>Thread Woken and Lock Obtained</message>
Audit: <logdate>10/11/2016 1:01:50 PM</logdate><thread>LogAgent</thread><method>RegisterAgent - Run</method><message>Thread Woken and Lock Obtained</message>
Audit: <logdate>10/11/2016 1:01:50 PM</logdate><thread>UI Thread</thread><method>Region - SetNextMediaNode</method><message>New media detected embedded</message>
Audit: <logdate>10/11/2016 1:01:50 PM</logdate><thread>UI Thread</thread><method>Region - CreateNextMediaNode</method><message>Creating new media: embedded, 648a7b038cc539e67b97be8d23842f35</message>
Audit: <logdate>10/11/2016 1:01:50 PM</logdate><thread>UI Thread</thread><method>Region - StartMedia</method><message>Starting media</message>
Audit: <logdate>10/11/2016 1:01:50 PM</logdate><thread>UI Thread</thread><method>Region - SetNextMediaNode</method><message>New media detected powerpoint</message>
Audit: <logdate>10/11/2016 1:01:50 PM</logdate><thread>UI Thread</thread><method>Region - CreateNextMediaNode</method><message>Creating new media: powerpoint, 3077</message>
Error: <logdate>10/11/2016 1:01:50 PM</logdate><thread>UI Thread</thread><method>Region - CreateNextMediaNode</method><message>PowerPoint 3077.ppt is in the CacheManager and is valid.</message>
Audit: <logdate>10/11/2016 1:01:50 PM</logdate><thread>UI Thread</thread><method>Region - StartMedia</method><message>Starting media</message>
Audit: <logdate>10/11/2016 1:01:50 PM</logdate><thread>UI Thread</thread><method>Region - SetNextMediaNode</method><message>New media detected webpage</message>
Audit: <logdate>10/11/2016 1:01:51 PM</logdate><thread>UI Thread</thread><method>Region - CreateNextMediaNode</method><message>Creating new media: webpage, edb0648ad86069229f2583f102de5c1f</message>
Audit: <logdate>10/11/2016 1:01:51 PM</logdate><thread>UI Thread</thread><method>Region - StartMedia</method><message>Starting media</message>
Audit: <logdate>10/11/2016 1:01:51 PM</logdate><thread>UI Thread</thread><method>Region - SetNextMediaNode</method><message>New media detected flash</message>
Audit: <logdate>10/11/2016 1:01:51 PM</logdate><thread>UI Thread</thread><method>Region - CreateNextMediaNode</method><message>Creating new media: flash, 1960</message>
Audit: <logdate>10/11/2016 1:01:51 PM</logdate><thread>UI Thread</thread><method>Region - StartMedia</method><message>Starting media</message>
Audit: <logdate>10/11/2016 1:01:51 PM</logdate><thread>ScheduleAgentThread</thread><method>ScheduleManager - GetScheduleXmlString</method><message>Getting the Schedule XML</message>
Info: <logdate>10/11/2016 1:01:51 PM</logdate><thread>RequiredFilesAgentThread</thread><method>RequiredFiles - ReportInventory</method><message>Reporting Inventory</message>
Audit: <logdate>10/11/2016 1:02:00 PM</logdate><thread>ScheduleManagerThread</thread><method>ScheduleManager - Run</method><message>Schedule Timer Ticked</message>
Audit: <logdate>10/11/2016 1:02:00 PM</logdate><thread>ScheduleManagerThread</thread><method>ScheduleManager - IsNewScheduleAvailable</method><message>Layouts in Current Schedule: [131] From 1/1/0001 12:00:00 AM to 1/1/0001 12:00:00 AM with priority False. 0 dependents.</message>
Audit: <logdate>10/11/2016 1:02:00 PM</logdate><thread>ScheduleManagerThread</thread><method>ScheduleManager - IsNewScheduleAvailable</method><message>Layouts in New Schedule: [131] From 1/1/0001 12:00:00 AM to 1/1/0001 12:00:00 AM with priority False. 0 dependents.</message>
Audit: <logdate>10/11/2016 1:02:10 PM</logdate><thread>ScheduleManagerThread</thread><method>ScheduleManager - Run</method><message>Schedule Timer Ticked</message>
Audit: <logdate>10/11/2016 1:02:10 PM</logdate><thread>ScheduleManagerThread</thread><method>ScheduleManager - IsNewScheduleAvailable</method><message>Layouts in Current Schedule: [131] From 1/1/0001 12:00:00 AM to 1/1/0001 12:00:00 AM with priority False. 0 dependents.</message>
Audit: <logdate>10/11/2016 1:02:10 PM</logdate><thread>ScheduleManagerThread</thread><method>ScheduleManager - IsNewScheduleAvailable</method><message>Layouts in New Schedule: [131] From 1/1/0001 12:00:00 AM to 1/1/0001 12:00:00 AM with priority False. 0 dependents.</message>
Audit: <logdate>10/11/2016 1:02:20 PM</logdate><thread>ScheduleManagerThread</thread><method>ScheduleManager - Run</method><message>Schedule Timer Ticked</message>
Audit: <logdate>10/11/2016 1:02:20 PM</logdate><thread>ScheduleManagerThread</thread><method>ScheduleManager - IsNewScheduleAvailable</method><message>Layouts in Current Schedule: [131] From 1/1/0001 12:00:00 AM to 1/1/0001 12:00:00 AM with priority False. 0 dependents.</message>
Audit: <logdate>10/11/2016 1:02:20 PM</logdate><thread>ScheduleManagerThread</thread><method>ScheduleManager - IsNewScheduleAvailable</method><message>Layouts in New Schedule: [131] From 1/1/0001 12:00:00 AM to 1/1/0001 12:00:00 AM with priority False. 0 dependents.</message>
Audit: <logdate>10/11/2016 1:02:21 PM</logdate><thread>ScheduleAgentThread</thread><method>ScheduleAgent - Run</method><message>Thread Woken and Lock Obtained</message>
Info: <logdate>10/11/2016 1:02:21 PM</logdate><thread>RegisterAgentThread</thread><method>RegisterAgent - Run</method><message>Thread Woken and Lock Obtained</message>
Audit: <logdate>10/11/2016 1:02:21 PM</logdate><thread>ScheduleAgentThread</thread><method>ScheduleManager - GetScheduleXmlString</method><message>Getting the Schedule XML</message>
Info: <logdate>10/11/2016 1:02:21 PM</logdate><thread>RequiredFilesAgentThread</thread><method>RequiredFiles - ReportInventory</method><message>Reporting Inventory</message>
Audit: <logdate>10/11/2016 1:02:22 PM</logdate><thread>LogAgent</thread><method>RegisterAgent - Run</method><message>Thread Woken and Lock Obtained</message>
Audit: <logdate>10/11/2016 1:02:30 PM</logdate><thread>ScheduleManagerThread</thread><method>ScheduleManager - Run</method><message>Schedule Timer Ticked</message>
Audit: <logdate>10/11/2016 1:02:30 PM</logdate><thread>ScheduleManagerThread</thread><method>ScheduleManager - IsNewScheduleAvailable</method><message>Layouts in Current Schedule: [131] From 1/1/0001 12:00:00 AM to 1/1/0001 12:00:00 AM with priority False. 0 dependents.</message>
Audit: <logdate>10/11/2016 1:02:30 PM</logdate><thread>ScheduleManagerThread</thread><method>ScheduleManager - IsNewScheduleAvailable</method><message>Layouts in New Schedule: [131] From 1/1/0001 12:00:00 AM to 1/1/0001 12:00:00 AM with priority False. 0 dependents.</message>
Audit: <logdate>10/11/2016 1:02:40 PM</logdate><thread>ScheduleManagerThread</thread><method>ScheduleManager - Run</method><message>Schedule Timer Ticked</message>
Audit: <logdate>10/11/2016 1:02:40 PM</logdate><thread>ScheduleManagerThread</thread><method>ScheduleManager - IsNewScheduleAvailable</method><message>Layouts in Current Schedule: [131] From 1/1/0001 12:00:00 AM to 1/1/0001 12:00:00 AM with priority False. 0 dependents.</message>
Audit: <logdate>10/11/2016 1:02:40 PM</logdate><thread>ScheduleManagerThread</thread><method>ScheduleManager - IsNewScheduleAvailable</method><message>Layouts in New Schedule: [131] From 1/1/0001 12:00:00 AM to 1/1/0001 12:00:00 AM with priority False. 0 dependents.</message>
Audit: <logdate>10/11/2016 1:02:50 PM</logdate><thread>ScheduleManagerThread</thread><method>ScheduleManager - Run</method><message>Schedule Timer Ticked</message>
Audit: <logdate>10/11/2016 1:02:50 PM</logdate><thread>ScheduleManagerThread</thread><method>ScheduleManager - IsNewScheduleAvailable</method><message>Layouts in Current Schedule: [131] From 1/1/0001 12:00:00 AM to 1/1/0001 12:00:00 AM with priority False. 0 dependents.</message>
Audit: <logdate>10/11/2016 1:02:50 PM</logdate><thread>ScheduleManagerThread</thread><method>ScheduleManager - IsNewScheduleAvailable</method><message>Layouts in New Schedule: [131] From 1/1/0001 12:00:00 AM to 1/1/0001 12:00:00 AM with priority False. 0 dependents.</message>
Audit: <logdate>10/11/2016 1:02:51 PM</logdate><thread>ScheduleAgentThread</thread><method>ScheduleAgent - Run</method><message>Thread Woken and Lock Obtained</message>
Info: <logdate>10/11/2016 1:02:52 PM</logdate><thread>RegisterAgentThread</thread><method>RegisterAgent - Run</method><message>Thread Woken and Lock Obtained</message>
Audit: <logdate>10/11/2016 1:02:52 PM</logdate><thread>ScheduleAgentThread</thread><method>ScheduleManager - GetScheduleXmlString</method><message>Getting the Schedule XML</message>
<logdate>10/11/2016 1:02:52 PM</logdate><thread>ScheduleAgentThread</thread><method>Schedule Agent - Run</method><message>Received new schedule</message>
Audit: <logdate>10/11/2016 1:02:52 PM</logdate><thread>LogAgent</thread><method>RegisterAgent - Run</method><message>Thread Woken and Lock Obtained</message>
Info: <logdate>10/11/2016 1:02:52 PM</logdate><thread>RequiredFilesAgentThread</thread><method>RequiredFiles - SetRequiredFiles</method><message>MD5 different for existing file: 118.xlf</message>
Info: <logdate>10/11/2016 1:02:52 PM</logdate><thread>RequiredFilesAgentThread</thread><method>RequiredFiles - ReportInventory</method><message>Reporting Inventory</message>
Audit: <logdate>10/11/2016 1:02:52 PM</logdate><thread>FileAgent_layout_Id_118</thread><method>FileAgent - Run</method><message>Thread Started</message>
Audit: <logdate>10/11/2016 1:02:52 PM</logdate><thread>FileAgent_layout_Id_118</thread><method>FileAgent - Run</method><message>Thread alive and Lock Obtained</message>
Info: <logdate>10/11/2016 1:02:53 PM</logdate><thread>FileAgent_layout_Id_118</thread><method>FileAgent - Run</method><message>File Downloaded Successfully. 118.xlf</message>
<logdate>10/11/2016 1:02:53 PM</logdate><thread>FileAgent_layout_Id_118</thread><method>RequiredFilesAgent - fileAgent_OnComplete</method><message>FileId finished downloading118</message>
Info: <logdate>10/11/2016 1:02:53 PM</logdate><thread>FileAgent_layout_Id_118</thread><method>Schedule - LayoutFileModified</method><message>Layout file changed: 118.xlf</message>
Audit: <logdate>10/11/2016 1:02:53 PM</logdate><thread>FileAgent_layout_Id_118</thread><method>FileAgent - Run</method><message>Releasing Lock</message>
Audit: <logdate>10/11/2016 1:03:00 PM</logdate><thread>ScheduleManagerThread</thread><method>ScheduleManager - Run</method><message>Schedule Timer Ticked</message>
Audit: <logdate>10/11/2016 1:03:00 PM</logdate><thread>ScheduleManagerThread</thread><method>ScheduleManager - IsNewScheduleAvailable</method><message>New Schedule does not contain 131</message>
Audit: <logdate>10/11/2016 1:03:00 PM</logdate><thread>ScheduleManagerThread</thread><method>ScheduleManager - IsNewScheduleAvailable</method><message>Layouts in Current Schedule: [131] From 1/1/0001 12:00:00 AM to 1/1/0001 12:00:00 AM with priority False. 0 dependents.</message>
Audit: <logdate>10/11/2016 1:03:00 PM</logdate><thread>ScheduleManagerThread</thread><method>ScheduleManager - IsNewScheduleAvailable</method><message>Layouts in New Schedule: [131] From 1/1/0001 12:00:00 AM to 1/1/0001 12:00:00 AM with priority False. 0 dependents.</message>
Audit: <logdate>10/11/2016 1:03:00 PM</logdate><thread>ScheduleManagerThread</thread><method>MainForm - ScheduleChangeEvent</method><message>Schedule Changing to C:\Library\118.xlf</message>
Audit: <logdate>10/11/2016 1:03:00 PM</logdate><thread>UI Thread</thread><method>MainForm - DestoryLayout</method><message>Calling Dispose on Region 2039757c040a6a3d62</message>
Audit: <logdate>10/11/2016 1:03:00 PM</logdate><thread>UI Thread</thread><method>MainForm - DestoryLayout</method><message>Calling Dispose on Region 2885057c0575f3b4f1</message>
Audit: <logdate>10/11/2016 1:03:00 PM</logdate><thread>UI Thread</thread><method>MainForm - DestoryLayout</method><message>Calling Dispose on Region 1824657da74f431b03</message>
Audit: <logdate>10/11/2016 1:03:00 PM</logdate><thread>UI Thread</thread><method>MainForm - DestoryLayout</method><message>Calling Dispose on Region 142857fb3dcb4d880</message>
Audit: <logdate>10/11/2016 1:03:00 PM</logdate><thread>UI Thread</thread><method>Region - SetNextMediaNode</method><message>New media detected powerpoint</message>
Audit: <logdate>10/11/2016 1:03:00 PM</logdate><thread>UI Thread</thread><method>Region - CreateNextMediaNode</method><message>Creating new media: powerpoint, 3107</message>
Error: <logdate>10/11/2016 1:03:00 PM</logdate><thread>UI Thread</thread><method>Region - CreateNextMediaNode</method><message>PowerPoint 3107.ppt is in the CacheManager and is valid.</message>
Audit: <logdate>10/11/2016 1:03:01 PM</logdate><thread>UI Thread</thread><method>Region - StartMedia</method><message>Starting media</message>
Audit: <logdate>10/11/2016 1:03:10 PM</logdate><thread>ScheduleManagerThread</thread><method>ScheduleManager - Run</method><message>Schedule Timer Ticked</message>
Audit: <logdate>10/11/2016 1:03:10 PM</logdate><thread>ScheduleManagerThread</thread><method>ScheduleManager - IsNewScheduleAvailable</method><message>Layouts in Current Schedule: [118] From 1/1/0001 12:00:00 AM to 1/1/0001 12:00:00 AM with priority False. 0 dependents.</message>
Audit: <logdate>10/11/2016 1:03:10 PM</logdate><thread>ScheduleManagerThread</thread><method>ScheduleManager - IsNewScheduleAvailable</method><message>Layouts in New Schedule: [118] From 1/1/0001 12:00:00 AM to 1/1/0001 12:00:00 AM with priority False. 0 dependents.</message>
Audit: <logdate>10/11/2016 1:03:20 PM</logdate><thread>ScheduleManagerThread</thread><method>ScheduleManager - Run</method><message>Schedule Timer Ticked</message>
Audit: <logdate>10/11/2016 1:03:20 PM</logdate><thread>ScheduleManagerThread</thread><method>ScheduleManager - IsNewScheduleAvailable</method><message>Layouts in Current Schedule: [118] From 1/1/0001 12:00:00 AM to 1/1/0001 12:00:00 AM with priority False. 0 dependents.</message>
Audit: <logdate>10/11/2016 1:03:20 PM</logdate><thread>ScheduleManagerThread</thread><method>ScheduleManager - IsNewScheduleAvailable</method><message>Layouts in New Schedule: [118] From 1/1/0001 12:00:00 AM to 1/1/0001 12:00:00 AM with priority False. 0 dependents.</message>
Audit: <logdate>10/11/2016 1:03:22 PM</logdate><thread>ScheduleAgentThread</thread><method>ScheduleAgent - Run</method><message>Thread Woken and Lock Obtained</message>
Audit: <logdate>10/11/2016 1:03:22 PM</logdate><thread>ScheduleAgentThread</thread><method>ScheduleManager - GetScheduleXmlString</method><message>Getting the Schedule XML</message>
Audit: <logdate>10/11/2016 1:03:23 PM</logdate><thread>LogAgent</thread><method>RegisterAgent - Run</method><message>Thread Woken and Lock Obtained</message>
Info: <logdate>10/11/2016 1:03:23 PM</logdate><thread>RegisterAgentThread</thread><method>RegisterAgent - Run</method><message>Thread Woken and Lock Obtained</message>
Info: <logdate>10/11/2016 1:03:23 PM</logdate><thread>RequiredFilesAgentThread</thread><method>RequiredFiles - SetRequiredFiles</method><message>MD5 different for existing file: 118.xlf</message>
Audit: <logdate>10/11/2016 1:03:23 PM</logdate><thread>FileAgent_media_Id_3108</thread><method>FileAgent - Run</method><message>Thread Started</message>
Audit: <logdate>10/11/2016 1:03:23 PM</logdate><thread>FileAgent_media_Id_3108</thread><method>FileAgent - Run</method><message>Thread alive and Lock Obtained</message>
Audit: <logdate>10/11/2016 1:03:23 PM</logdate><thread>FileAgent_layout_Id_118</thread><method>FileAgent - Run</method><message>Thread Started</message>
Audit: <logdate>10/11/2016 1:03:23 PM</logdate><thread>FileAgent_layout_Id_118</thread><method>FileAgent - Run</method><message>Thread alive and Lock Obtained</message>
Info: <logdate>10/11/2016 1:03:23 PM</logdate><thread>RequiredFilesAgentThread</thread><method>RequiredFiles - ReportInventory</method><message>Reporting Inventory</message>
Info: <logdate>10/11/2016 1:03:24 PM</logdate><thread>FileAgent_layout_Id_118</thread><method>FileAgent - Run</method><message>File Downloaded Successfully. 118.xlf</message>
<logdate>10/11/2016 1:03:24 PM</logdate><thread>FileAgent_layout_Id_118</thread><method>RequiredFilesAgent - fileAgent_OnComplete</method><message>FileId finished downloading118</message>
Info: <logdate>10/11/2016 1:03:24 PM</logdate><thread>FileAgent_layout_Id_118</thread><method>Schedule - LayoutFileModified</method><message>Layout file changed: 118.xlf</message>
Audit: <logdate>10/11/2016 1:03:24 PM</logdate><thread>FileAgent_layout_Id_118</thread><method>Schedule - LayoutFileModified</method><message>Forcing the current layout to change: 118.xlf</message>
Audit: <logdate>10/11/2016 1:03:24 PM</logdate><thread>FileAgent_layout_Id_118</thread><method>MainForm - ScheduleChangeEvent</method><message>Schedule Changing to C:\Library\118.xlf</message>
Audit: <logdate>10/11/2016 1:03:24 PM</logdate><thread>FileAgent_layout_Id_118</thread><method>FileAgent - Run</method><message>Releasing Lock</message>
Audit: <logdate>10/11/2016 1:03:24 PM</logdate><thread>UI Thread</thread><method>MainForm - DestoryLayout</method><message>Calling Dispose on Region 1386255c3060b96b63</message>
Audit: <logdate>10/11/2016 1:03:24 PM</logdate><thread>UI Thread</thread><method>MainForm - DurationElapsedEvent</method><message>Region Elapsed</message>
Audit: <logdate>10/11/2016 1:03:24 PM</logdate><thread>UI Thread</thread><method>MainForm - DurationElapsedEvent</method><message>Already Changing Layout</message>
Audit: <logdate>10/11/2016 1:03:30 PM</logdate><thread>ScheduleManagerThread</thread><method>ScheduleManager - Run</method><message>Schedule Timer Ticked</message>
Audit: <logdate>10/11/2016 1:03:30 PM</logdate><thread>ScheduleManagerThread</thread><method>ScheduleManager - IsNewScheduleAvailable</method><message>Layouts in Current Schedule: [118] From 1/1/0

Are you testing with the Default Layout - and if so, did you apply the CMS patch provided above?

Reason being Layouts in New Schedule: [118] From 1/1/0001 12:00:00 AM to 1/1/0001 12:00:00 AM with priority False. 0 dependents. would imply that 118 is the default and that it doesn’t have any dependents

That last test was just the default layout, and no I didn’t apply the CMS patch with you saying about it not working with a scheduled layout so it wouldn’t help me. I did test with scheduled and default layouts the first time around with that fixed .msi, but only default when I had the log file running.
Just have to leave the office for an hour, but I’ll repeat the test with a scheduled layout when I get back and send the log file again. Should I patch the CMS anyway?

Thanks