Mar 03 22:08:01 railcore DuetWebServer[1095]: Microsoft.AspNetCore.Hosting.Diagnostics[1] Request starting HTTP/1.1 POST http://railcore.local/machine/startPlugin text/plain;charset=UTF-8 10 Mar 03 22:08:01 railcore DuetWebServer[1095]: Microsoft.AspNetCore.Cors.Infrastructure.CorsService[5] CORS policy execution failed. Mar 03 22:08:01 railcore DuetWebServer[1095]: Microsoft.AspNetCore.Cors.Infrastructure.CorsService[6] Request origin http://railcore.local does not have permission to access the resource. Mar 03 22:08:01 railcore DuetWebServer[1095]: Microsoft.AspNetCore.Routing.EndpointMiddleware[0] Executing endpoint 'DuetWebServer.Controllers.MachineController.StartPlugin (DuetWebServer)' Mar 03 22:08:01 railcore DuetWebServer[1095]: Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker[3] Route matched with {action = "StartPlugin", controller = "Machine"}. Executing controller action with signature System.Threading.Tasks.Task`1[Microsoft.AspNetCore.Mvc.IActionResult] StartPlugin() on controller DuetWebServer.Controllers.MachineController (DuetWebServer). Mar 03 22:08:01 railcore DuetPluginService[1446]: [info] Plugin duetBackup: Process has been started (pid 29825) Mar 03 22:08:01 railcore DuetWebServer[1095]: Microsoft.AspNetCore.Mvc.StatusCodeResult[1] Executing StatusCodeResult, setting HTTP status code 204 Mar 03 22:08:01 railcore DuetWebServer[1095]: Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker[2] Executed action DuetWebServer.Controllers.MachineController.StartPlugin (DuetWebServer) in 68.5665ms Mar 03 22:08:01 railcore DuetWebServer[1095]: Microsoft.AspNetCore.Routing.EndpointMiddleware[1] Executed endpoint 'DuetWebServer.Controllers.MachineController.StartPlugin (DuetWebServer)' Mar 03 22:08:01 railcore DuetWebServer[1095]: Microsoft.AspNetCore.Hosting.Diagnostics[2] Request finished HTTP/1.1 POST http://railcore.local/machine/startPlugin text/plain;charset=UTF-8 10 - 204 - - 70.5123ms Mar 03 22:08:02 railcore DuetPluginService[29825]: Logging in to Printer Mar 03 22:08:02 railcore DuetPluginService[29825]: 0 url: http://127.0.0.1/machine/disconnect post: False Mar 03 22:08:02 railcore DuetWebServer[1095]: Microsoft.AspNetCore.Hosting.Diagnostics[1] Request starting HTTP/1.1 GET http://127.0.0.1/machine/disconnect - - Mar 03 22:08:02 railcore DuetWebServer[1095]: DuetWebServer.Singletons.SessionStorage[0] Session 5eaf27b7c7dc476ca0c2e2bbcced6980 added (readWrite) Mar 03 22:08:02 railcore DuetWebServer[1095]: Microsoft.AspNetCore.Routing.EndpointMiddleware[0] Executing endpoint 'DuetWebServer.Controllers.MachineController.Disconnect (DuetWebServer)' Mar 03 22:08:02 railcore DuetWebServer[1095]: Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker[3] Route matched with {action = "Disconnect", controller = "Machine"}. Executing controller action with signature System.Threading.Tasks.Task`1[Microsoft.AspNetCore.Mvc.IActionResult] Disconnect(DuetWebServer.Singletons.ISessionStorage) on controller DuetWebServer.Controllers.MachineController (DuetWebServer). Mar 03 22:08:02 railcore DuetWebServer[1095]: DuetWebServer.Singletons.SessionStorage[0] Session 5eaf27b7c7dc476ca0c2e2bbcced6980 removed Mar 03 22:08:02 railcore DuetWebServer[1095]: Microsoft.AspNetCore.Mvc.StatusCodeResult[1] Executing StatusCodeResult, setting HTTP status code 204 Mar 03 22:08:02 railcore DuetWebServer[1095]: Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker[2] Executed action DuetWebServer.Controllers.MachineController.Disconnect (DuetWebServer) in 9.8966ms Mar 03 22:08:02 railcore DuetWebServer[1095]: Microsoft.AspNetCore.Routing.EndpointMiddleware[1] Executed endpoint 'DuetWebServer.Controllers.MachineController.Disconnect (DuetWebServer)' Mar 03 22:08:02 railcore DuetWebServer[1095]: Microsoft.AspNetCore.Hosting.Diagnostics[2] Request finished HTTP/1.1 GET http://127.0.0.1/machine/disconnect - - - 204 - - 21.1374ms Mar 03 22:08:03 railcore DuetPluginService[29825]: 1 url: http://127.0.0.1/machine/disconnect post: False Mar 03 22:08:03 railcore DuetWebServer[1095]: Microsoft.AspNetCore.Hosting.Diagnostics[1] Request starting HTTP/1.1 GET http://127.0.0.1/machine/disconnect - - Mar 03 22:08:03 railcore DuetWebServer[1095]: DuetWebServer.Singletons.SessionStorage[0] Session ca3c7695c8d04c16bb95b3dd4afa2fb7 added (readWrite) Mar 03 22:08:03 railcore DuetWebServer[1095]: Microsoft.AspNetCore.Routing.EndpointMiddleware[0] Executing endpoint 'DuetWebServer.Controllers.MachineController.Disconnect (DuetWebServer)' Mar 03 22:08:03 railcore DuetWebServer[1095]: Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker[3] Route matched with {action = "Disconnect", controller = "Machine"}. Executing controller action with signature System.Threading.Tasks.Task`1[Microsoft.AspNetCore.Mvc.IActionResult] Disconnect(DuetWebServer.Singletons.ISessionStorage) on controller DuetWebServer.Controllers.MachineController (DuetWebServer). Mar 03 22:08:03 railcore DuetWebServer[1095]: DuetWebServer.Singletons.SessionStorage[0] Session ca3c7695c8d04c16bb95b3dd4afa2fb7 removed Mar 03 22:08:03 railcore DuetWebServer[1095]: Microsoft.AspNetCore.Mvc.StatusCodeResult[1] Executing StatusCodeResult, setting HTTP status code 204 Mar 03 22:08:03 railcore DuetWebServer[1095]: Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker[2] Executed action DuetWebServer.Controllers.MachineController.Disconnect (DuetWebServer) in 12.8887ms Mar 03 22:08:03 railcore DuetWebServer[1095]: Microsoft.AspNetCore.Routing.EndpointMiddleware[1] Executed endpoint 'DuetWebServer.Controllers.MachineController.Disconnect (DuetWebServer)' Mar 03 22:08:03 railcore DuetWebServer[1095]: Microsoft.AspNetCore.Hosting.Diagnostics[2] Request finished HTTP/1.1 GET http://127.0.0.1/machine/disconnect - - - 204 - - 24.4475ms Mar 03 22:08:04 railcore DuetPluginService[29825]: 0 url: http://127.0.0.1/machine/connect?password=Sony1620 post: False Mar 03 22:08:04 railcore DuetWebServer[1095]: Microsoft.AspNetCore.Hosting.Diagnostics[1] Request starting HTTP/1.1 GET http://127.0.0.1/machine/connect?password=Sony1620 - - Mar 03 22:08:04 railcore DuetWebServer[1095]: DuetWebServer.Singletons.SessionStorage[0] Session 2a1198f7423e414f9287f85023e7a9ca added (readWrite) Mar 03 22:08:04 railcore DuetWebServer[1095]: Microsoft.AspNetCore.Routing.EndpointMiddleware[0] Executing endpoint 'DuetWebServer.Controllers.MachineController.Connect (DuetWebServer)' Mar 03 22:08:04 railcore DuetWebServer[1095]: Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker[3] Route matched with {action = "Connect", controller = "Machine"}. Executing controller action with signature System.Threading.Tasks.Task`1[Microsoft.AspNetCore.Mvc.IActionResult] Connect(System.String, DuetWebServer.Singletons.ISessionStorage) on controller DuetWebServer.Controllers.MachineController (DuetWebServer). Mar 03 22:08:04 railcore DuetWebServer[1095]: DuetWebServer.Singletons.SessionStorage[0] Session 64b220f74da04d0dbf8fed833856e625 added (readWrite) Mar 03 22:08:04 railcore DuetWebServer[1095]: Microsoft.AspNetCore.Mvc.Infrastructure.ContentResultExecutor[1] Executing ContentResult with HTTP Response ContentType of application/json Mar 03 22:08:04 railcore DuetWebServer[1095]: Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker[2] Executed action DuetWebServer.Controllers.MachineController.Connect (DuetWebServer) in 11.5232ms Mar 03 22:08:04 railcore DuetWebServer[1095]: Microsoft.AspNetCore.Routing.EndpointMiddleware[1] Executed endpoint 'DuetWebServer.Controllers.MachineController.Connect (DuetWebServer)' Mar 03 22:08:04 railcore DuetWebServer[1095]: Microsoft.AspNetCore.Hosting.Diagnostics[2] Request finished HTTP/1.1 GET http://127.0.0.1/machine/connect?password=Sony1620 - - - 200 49 application/json 28.0325ms Mar 03 22:08:04 railcore DuetPluginService[29825]: !!!!! Connected to printer !!!!! Mar 03 22:08:04 railcore DuetPluginService[29825]: 0 url: http://127.0.0.1/machine/code post: M291 S1 T5 P"duetBackup Connected" Mar 03 22:08:04 railcore DuetWebServer[1095]: Microsoft.AspNetCore.Hosting.Diagnostics[1] Request starting HTTP/1.1 POST http://127.0.0.1/machine/code - 34 Mar 03 22:08:04 railcore DuetWebServer[1095]: Microsoft.AspNetCore.Routing.EndpointMiddleware[0] Executing endpoint 'DuetWebServer.Controllers.MachineController.DoCode (DuetWebServer)' Mar 03 22:08:04 railcore DuetWebServer[1095]: Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker[3] Route matched with {action = "DoCode", controller = "Machine"}. Executing controller action with signature System.Threading.Tasks.Task`1[Microsoft.AspNetCore.Mvc.IActionResult] DoCode(DuetWebServer.Singletons.ISessionStorage, Boolean) on controller DuetWebServer.Controllers.MachineController (DuetWebServer). Mar 03 22:08:04 railcore DuetWebServer[1095]: DuetWebServer.Singletons.SessionStorage[0] Session 64b220f74da04d0dbf8fed833856e625 started a long-running request Mar 03 22:08:04 railcore DuetWebServer[1095]: DuetWebServer.Controllers.MachineController[0] [DoCode] Executing code 'M291 S1 T5 P"duetBackup Connected"' Mar 03 22:08:04 railcore DuetWebServer[1095]: DuetWebServer.Singletons.SessionStorage[0] Session 64b220f74da04d0dbf8fed833856e625 finished a long-running request Mar 03 22:08:04 railcore DuetWebServer[1095]: Microsoft.AspNetCore.Mvc.Infrastructure.ContentResultExecutor[1] Executing ContentResult with HTTP Response ContentType of text/plain; charset=utf-8 Mar 03 22:08:04 railcore DuetWebServer[1095]: Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker[2] Executed action DuetWebServer.Controllers.MachineController.DoCode (DuetWebServer) in 85.0421ms Mar 03 22:08:04 railcore DuetWebServer[1095]: Microsoft.AspNetCore.Routing.EndpointMiddleware[1] Executed endpoint 'DuetWebServer.Controllers.MachineController.DoCode (DuetWebServer)' Mar 03 22:08:04 railcore DuetWebServer[1095]: Microsoft.AspNetCore.Hosting.Diagnostics[2] Request finished HTTP/1.1 POST http://127.0.0.1/machine/code - 34 - 200 0 text/plain;+charset=utf-8 86.0734ms Mar 03 22:08:04 railcore DuetPluginService[29825]: Logging into Github as gdwinslow Mar 03 22:08:05 railcore DuetPluginService[29825]: Last commit was 2024-08-29 09:34:12 Mar 03 22:08:05 railcore DuetPluginService[29825]: Current time is 04 Mar 2025 06:08 GMT Mar 03 22:08:05 railcore DuetPluginService[29825]: 0 url: http://127.0.0.1/machine/code post: M291 S1 T5 P"Starting backup" Mar 03 22:08:05 railcore DuetWebServer[1095]: Microsoft.AspNetCore.Hosting.Diagnostics[1] Request starting HTTP/1.1 POST http://127.0.0.1/machine/code - 29 Mar 03 22:08:05 railcore DuetWebServer[1095]: Microsoft.AspNetCore.Routing.EndpointMiddleware[0] Executing endpoint 'DuetWebServer.Controllers.MachineController.DoCode (DuetWebServer)' Mar 03 22:08:05 railcore DuetWebServer[1095]: Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker[3] Route matched with {action = "DoCode", controller = "Machine"}. Executing controller action with signature System.Threading.Tasks.Task`1[Microsoft.AspNetCore.Mvc.IActionResult] DoCode(DuetWebServer.Singletons.ISessionStorage, Boolean) on controller DuetWebServer.Controllers.MachineController (DuetWebServer). Mar 03 22:08:05 railcore DuetWebServer[1095]: DuetWebServer.Singletons.SessionStorage[0] Session 64b220f74da04d0dbf8fed833856e625 started a long-running request Mar 03 22:08:05 railcore DuetWebServer[1095]: DuetWebServer.Controllers.MachineController[0] [DoCode] Executing code 'M291 S1 T5 P"Starting backup"' Mar 03 22:08:05 railcore DuetWebServer[1095]: DuetWebServer.Singletons.SessionStorage[0] Session 64b220f74da04d0dbf8fed833856e625 finished a long-running request Mar 03 22:08:05 railcore DuetWebServer[1095]: Microsoft.AspNetCore.Mvc.Infrastructure.ContentResultExecutor[1] Executing ContentResult with HTTP Response ContentType of text/plain; charset=utf-8 Mar 03 22:08:05 railcore DuetWebServer[1095]: Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker[2] Executed action DuetWebServer.Controllers.MachineController.DoCode (DuetWebServer) in 91.8285ms Mar 03 22:08:05 railcore DuetWebServer[1095]: Microsoft.AspNetCore.Routing.EndpointMiddleware[1] Executed endpoint 'DuetWebServer.Controllers.MachineController.DoCode (DuetWebServer)' Mar 03 22:08:05 railcore DuetWebServer[1095]: Microsoft.AspNetCore.Hosting.Diagnostics[2] Request finished HTTP/1.1 POST http://127.0.0.1/machine/code - 29 - 200 0 text/plain;+charset=utf-8 93.2247ms Mar 03 22:08:05 railcore DuetPluginService[29825]: Starting backup Mar 03 22:08:05 railcore DuetPluginService[29825]: Getting files in Repository(full_name="gdwinslow/Railcore") from branch main Mar 03 22:08:05 railcore DuetPluginService[29825]: The following dirs will be backed up [['sd/sys'], ['sd/macros']] Mar 03 22:08:05 railcore DuetPluginService[29825]: List files in directory = /opt/dsf/sd/sys Mar 03 22:08:05 railcore DuetPluginService[29825]: 0 url: http://127.0.0.1/machine/code post: M291 S1 T5 P"Error listing files!!" Mar 03 22:08:05 railcore DuetWebServer[1095]: Microsoft.AspNetCore.Hosting.Diagnostics[1] Request starting HTTP/1.1 POST http://127.0.0.1/machine/code - 35 Mar 03 22:08:05 railcore DuetWebServer[1095]: Microsoft.AspNetCore.Routing.EndpointMiddleware[0] Executing endpoint 'DuetWebServer.Controllers.MachineController.DoCode (DuetWebServer)' Mar 03 22:08:05 railcore DuetWebServer[1095]: Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker[3] Route matched with {action = "DoCode", controller = "Machine"}. Executing controller action with signature System.Threading.Tasks.Task`1[Microsoft.AspNetCore.Mvc.IActionResult] DoCode(DuetWebServer.Singletons.ISessionStorage, Boolean) on controller DuetWebServer.Controllers.MachineController (DuetWebServer). Mar 03 22:08:05 railcore DuetWebServer[1095]: DuetWebServer.Singletons.SessionStorage[0] Session 64b220f74da04d0dbf8fed833856e625 started a long-running request Mar 03 22:08:05 railcore DuetWebServer[1095]: DuetWebServer.Controllers.MachineController[0] [DoCode] Executing code 'M291 S1 T5 P"Error listing files!!"' Mar 03 22:08:05 railcore DuetWebServer[1095]: DuetWebServer.Singletons.SessionStorage[0] Session 64b220f74da04d0dbf8fed833856e625 finished a long-running request Mar 03 22:08:05 railcore DuetWebServer[1095]: Microsoft.AspNetCore.Mvc.Infrastructure.ContentResultExecutor[1] Executing ContentResult with HTTP Response ContentType of text/plain; charset=utf-8 Mar 03 22:08:05 railcore DuetWebServer[1095]: Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker[2] Executed action DuetWebServer.Controllers.MachineController.DoCode (DuetWebServer) in 75.5539ms Mar 03 22:08:05 railcore DuetWebServer[1095]: Microsoft.AspNetCore.Routing.EndpointMiddleware[1] Executed endpoint 'DuetWebServer.Controllers.MachineController.DoCode (DuetWebServer)' Mar 03 22:08:05 railcore DuetWebServer[1095]: Microsoft.AspNetCore.Hosting.Diagnostics[2] Request finished HTTP/1.1 POST http://127.0.0.1/machine/code - 35 - 200 0 text/plain;+charset=utf-8 76.6783ms Mar 03 22:08:05 railcore DuetPluginService[29825]: Error listing files!! Mar 03 22:08:05 railcore DuetPluginService[29825]: 'NoneType' object is not iterable Mar 03 22:08:05 railcore DuetPluginService[1446]: [info] Plugin duetBackup: Process has been stopped with exit code 137