Hello Xibo Community,
We have two Xibo server Docker installations running in AWS, one for production and a transient one for development. For many iterations we have followed the same upgrade path. We upgrade dev to the next version, export current layouts from production, import the layouts into dev, and then cycle through the layouts assigning each in turn to a Windows Xibo client running in a VM on my linux box. This has worked without any problems over the past couple of years.
Yesterday, I chose to do something slightly different in the upgrade process for dev. The layouts currently in use in prod had not changed since the last upgrade, so I deleted all of the layouts and media in dev before re-importing the production layouts. Now when I start my Xibo client I get errors when communicating with the dev server. There are references to media and layout IDs which no longer exist.
Assuming I had yanked the rug out from under the Xibo client causing mismatched IDs I deleted the Xibo client and reinstalled it the lates version. This did not fix my problem.
A couple of things do stand out in the log file: 1) a series for Forbidden errors; and 2) Client found response content type of ‘text/plain;charset=UTF-8’, but expected ‘text/xml’. I found steps in this forum suggesting that I delete the hardware key in the client and reconnect to the server in order to deal with the Forbidden 403 errors. This did not help. The references I found regarding the content type error suggested upgrading the version of PHP; since this is a Docker installation I did nothing for this.
Here is one of the client log files showing the client startup:
<trace date="2023-09-19 09:38:01" category="Info"><logdate>2023-09-19 09:38:01</logdate><thread></thread><method>Main</method><message>Client Started</message>
</trace>
<trace date="2023-09-19 09:38:01" category="Info"><logdate>2023-09-19 09:38:01</logdate><thread></thread><method>MainForm</method><message>Player Initialised</message>
</trace>
<trace date="2023-09-19 09:38:03" category="Info"><logdate>2023-09-19 09:38:03</logdate><thread>RegisterAgentThread</thread><method>RegisterAgent - Run</method><message>Thread Started</message>
</trace>
<trace date="2023-09-19 09:38:03" category="Info"><logdate>2023-09-19 09:38:03</logdate><thread>RegisterAgentThread</thread><method>RegisterAgent - Run</method><message>Thread Woken and Lock Obtained</message>
</trace>
<trace date="2023-09-19 09:38:03" category="Info"><logdate>2023-09-19 09:38:03</logdate><thread>RequiredFilesAgentThread</thread><method>RequiredFilesAgent - Run</method><message>Thread Started</message>
</trace>
<trace date="2023-09-19 09:38:03" category="Info"><logdate>2023-09-19 09:38:03</logdate><thread>ScheduleManagerThread</thread><method>ScheduleManager - Run</method><message>Thread Started</message>
</trace>
<trace date="2023-09-19 09:38:03" category="Info"><logdate>2023-09-19 09:38:03</logdate><thread>ScheduleManagerThread</thread><method>ScheduleManager - LoadNewSchedule</method><message>Layout invalid: 42</message>
</trace>
<trace date="2023-09-19 09:38:03" category="Info"><logdate>2023-09-19 09:38:03</logdate><thread>ScheduleManagerThread</thread><method>ScheduleManager - LoadNewSchedule</method><message>Layout invalid: 1</message>
</trace>
<trace date="2023-09-19 09:38:03" category="Info"><logdate>2023-09-19 09:38:03</logdate><thread>LibraryAgent</thread><method>LibraryAgent - Run</method><message>Thread Started</message>
</trace>
<trace date="2023-09-19 09:38:03" category="Info"><logdate>2023-09-19 09:38:03</logdate><thread>LogAgent</thread><method>LogAgent - Run</method><message>Thread Started</message>
</trace>
<trace date="2023-09-19 09:38:03" category="Info"><logdate>2023-09-19 09:38:03</logdate><thread>FaultsAgent</thread><method>FaultsAgent - Run</method><message>Thread Started</message>
</trace>
<trace date="2023-09-19 09:38:03" category="Info"><logdate>2023-09-19 09:38:03</logdate><thread>StatAgentThread</thread><method>StatAgent</method><message>Run: Thread Started</message>
</trace>
<trace date="2023-09-19 09:38:03" category="Info"><logdate>2023-09-19 09:38:03</logdate><thread>XmrSubscriber</thread><method>XmrSubscriber - Run</method><message>Thread Started</message>
</trace>
<trace date="2023-09-19 09:38:04" category="Info"><logdate>2023-09-19 09:38:04</logdate><thread></thread><method>ScheduleManager</method><message>Watcher_StatusChanged: Working on location fix</message>
</trace>
<trace date="2023-09-19 09:38:04" category="Info"><logdate>2023-09-19 09:38:04</logdate><thread></thread><method>ScheduleManager</method><message>Watcher_StatusChanged: No data</message>
</trace>
<trace date="2023-09-19 09:38:04" category="Error"><logdate>2023-09-19 09:38:04</logdate><thread>LogAgent</thread><method>LogAgent - Run</method><message>Exception in Run: Client found response content type of 'text/plain;charset=UTF-8', but expected 'text/xml'.
The request failed with the error message:
--
There has been an unknown error with XMDS, it has been logged. Please contact your administrator.
--.</message>
</trace>
<trace date="2023-09-19 09:38:04" category="Info"><logdate>2023-09-19 09:38:04</logdate><thread>RequiredFilesAgentThread</thread><method>RequiredFiles - ReportInventory</method><message>Reporting Inventory</message>
</trace>
<trace date="2023-09-19 09:38:04" category="Info"><logdate>2023-09-19 09:38:04</logdate><thread>FileAgent_media_Id_25</thread><method>FileAgent - Run</method><message>Web Exception in Run: The remote server returned an error: (403) Forbidden.</message>
</trace>
<trace date="2023-09-19 09:38:04" category="Info"><logdate>2023-09-19 09:38:04</logdate><thread>FileAgent_media_Id_2</thread><method>FileAgent - Run</method><message>Web Exception in Run: The remote server returned an error: (403) Forbidden.</message>
</trace>
<trace date="2023-09-19 09:38:04" category="Info"><logdate>2023-09-19 09:38:04</logdate><thread>FileAgent_media_Id_24</thread><method>FileAgent - Run</method><message>Web Exception in Run: The remote server returned an error: (403) Forbidden.</message>
</trace>
<trace date="2023-09-19 09:38:05" category="Info"><logdate>2023-09-19 09:38:05</logdate><thread>FileAgent_media_Id_23</thread><method>FileAgent - Run</method><message>Web Exception in Run: The remote server returned an error: (403) Forbidden.</message>
</trace>
<trace date="2023-09-19 09:38:05" category="Info"><logdate>2023-09-19 09:38:05</logdate><thread>FileAgent_media_Id_22</thread><method>FileAgent - Run</method><message>Web Exception in Run: The remote server returned an error: (403) Forbidden.</message>
</trace>
<trace date="2023-09-19 09:38:05" category="Info"><logdate>2023-09-19 09:38:05</logdate><thread>FileAgent_media_Id_21</thread><method>FileAgent - Run</method><message>Web Exception in Run: The remote server returned an error: (403) Forbidden.</message>
</trace>
<trace date="2023-09-19 09:38:05" category="Info"><logdate>2023-09-19 09:38:05</logdate><thread>FileAgent_media_Id_20</thread><method>FileAgent - Run</method><message>Web Exception in Run: The remote server returned an error: (403) Forbidden.</message>
</trace>
<trace date="2023-09-19 09:38:05" category="Info"><logdate>2023-09-19 09:38:05</logdate><thread>FileAgent_media_Id_19</thread><method>FileAgent - Run</method><message>Web Exception in Run: The remote server returned an error: (403) Forbidden.</message>
</trace>
<trace date="2023-09-19 09:38:05" category="Info"><logdate>2023-09-19 09:38:05</logdate><thread>FileAgent_media_Id_18</thread><method>FileAgent - Run</method><message>Web Exception in Run: The remote server returned an error: (403) Forbidden.</message>
</trace>
And below is the corresponding output of the CMS container:
10.0.2.107 - - [19/Sep/2023:16:38:04 +0000] "POST /xmds.php?v=6&method=submitLog HTTP/1.1" 500 97 "-" "Mozilla/4.0 (compatible; MSIE 6.0; MS Web Services Client Protocol 4.0.30319.42000)"
10.0.2.107 - - [19/Sep/2023:16:38:04 +0000] "POST /xmds.php?v=6&method=schedule HTTP/1.1" 200 2264 "-" "Mozilla/4.0 (compatible; MSIE 6.0; MS Web Services Client Protocol 4.0.30319.42000)"
10.0.2.107 - - [19/Sep/2023:16:38:04 +0000] "POST /xmds.php?v=6&method=requiredFiles HTTP/1.1" 200 8382 "-" "Mozilla/4.0 (compatible; MSIE 6.0; MS Web Services Client Protocol 4.0.30319.42000)"
10.0.2.107 - - [19/Sep/2023:16:38:04 +0000] "POST /xmds.php?v=6&method=reportFaults HTTP/1.1" 200 514 "-" "Mozilla/4.0 (compatible; MSIE 6.0; MS Web Services Client Protocol 4.0.30319.42000)"
10.0.2.107 - - [19/Sep/2023:16:38:04 +0000] "POST /xmds.php?v=6&method=registerDisplay HTTP/1.1" 200 3474 "-" "Mozilla/4.0 (compatible; MSIE 6.0; MS Web Services Client Protocol 4.0.30319.42000)"
10.0.2.107 - - [19/Sep/2023:16:38:05 +0000] "POST /xmds.php?v=6&method=mediaInventory HTTP/1.1" 200 518 "-" "Mozilla/4.0 (compatible; MSIE 6.0; MS Web Services Client Protocol 4.0.30319.42000)"
10.0.2.107 - - [19/Sep/2023:16:38:05 +0000] "POST /xmds.php?v=6&method=notifyStatus HTTP/1.1" 200 514 "-" "Mozilla/4.0 (compatible; MSIE 6.0; MS Web Services Client Protocol 4.0.30319.42000)"
Any suggestions as to how I should proceed would be appreciated.
Thanks,
Terrence