Error in updater & Failed while executing backup

I’m running Duplicati 2.0.5.114_canary_2021-03-10 on macOS 10.15.7 on a PC that I haven’t interacted with much over the past many months.

I’m having several issues:

  1. I was getting an update notification (for the version I’m already running). Install > activate > (it never restarts duplicati automatically, so I have to manually launch it) > refresh browser page > login > it says an update is available (again, same one I’m already running). After numerous attempts to install/activate from the bottom notification, I finally dismissed the notification.
  2. Under About > Show Log > Stored I’m seeing numerous different errors getting logged as far back as this screen shows (back through April 30, 2021), including “Failed while executing “Backup”” many times.

One error is (and its first run timestamp):

Apr 30, 2021 3:11 PM: Error in updater
System.Exception: Found unexpected file: /Users/name/Library/Application Support/Duplicati/updates/2.0.5.103/OSXTrayHost/rumps.pyc
  at Duplicati.Library.AutoUpdater.UpdaterManager.VerifyUnpackedFolder (System.String folder, Duplicati.Library.AutoUpdater.UpdateInfo version) [0x002a1] in <0a7cf6efd05d4a43aecfe52cee57a507>:0 

I found a topic similar to this from 2017.

It has repeated a dozen+ times up through today.

The second error is:

Apr 30, 2021 3:11 PM: Failed while executing "Backup" with id: 2
Duplicati.Library.Interface.UserInformationException: 
The database has version 11 but the largest supported version is 10.

This is likely caused by upgrading to a newer version and then downgrading.
If this is the case, there is likely a backup file of the previous database version in the folder /Users/name/.config/Duplicati.
  at Duplicati.Library.SQLiteHelper.DatabaseUpgrader.UpgradeDatabase (System.Data.IDbConnection connection, System.String sourcefile, System.String schema, System.Collections.Generic.IList`1[T] versions) [0x000c0] in <27bb620d94b74930aa53f9be283b02a1>:0 
  at Duplicati.Library.SQLiteHelper.DatabaseUpgrader.UpgradeDatabase (System.Data.IDbConnection connection, System.String sourcefile, System.Type eltype) [0x00105] in <27bb620d94b74930aa53f9be283b02a1>:0 
  at Duplicati.Library.Main.Database.LocalDatabase.CreateConnection (System.String path) [0x00027] in <759bd83d98134a149cdf84e129a07d38>:0 
  at Duplicati.Library.Main.Database.LocalDatabase..ctor (System.String path, System.String operation, System.Boolean shouldclose) [0x00000] in <759bd83d98134a149cdf84e129a07d38>:0 
  at Duplicati.Library.Main.Database.LocalBackupDatabase..ctor (System.String path, Duplicati.Library.Main.Options options) [0x00000] in <759bd83d98134a149cdf84e129a07d38>:0 
  at Duplicati.Library.Main.Operation.BackupHandler.RunAsync (System.String[] sources, Duplicati.Library.Utility.IFilter filter, System.Threading.CancellationToken token) [0x00042] in <759bd83d98134a149cdf84e129a07d38>:0 
  at CoCoL.ChannelExtensions.WaitForTaskOrThrow (System.Threading.Tasks.Task task) [0x00050] in <9a758ff4db6c48d6b3d4d0e5c2adf6d1>:0 
  at Duplicati.Library.Main.Operation.BackupHandler.Run (System.String[] sources, Duplicati.Library.Utility.IFilter filter, System.Threading.CancellationToken token) [0x00009] in <759bd83d98134a149cdf84e129a07d38>:0 
  at Duplicati.Library.Main.Controller+<>c__DisplayClass14_0.<Backup>b__0 (Duplicati.Library.Main.BackupResults result) [0x0004b] in <759bd83d98134a149cdf84e129a07d38>:0 
  at Duplicati.Library.Main.Controller.RunAction[T] (T result, System.String[]& paths, Duplicati.Library.Utility.IFilter& filter, System.Action`1[T] method) [0x0026f] in <759bd83d98134a149cdf84e129a07d38>:0 
  at Duplicati.Library.Main.Controller.Backup (System.String[] inputsources, Duplicati.Library.Utility.IFilter filter) [0x00074] in <759bd83d98134a149cdf84e129a07d38>:0 
  at Duplicati.Server.Runner.Run (Duplicati.Server.Runner+IRunnerData data, System.Boolean fromQueue) [0x00349] in <63a01150aadd4a64a4d7c359bdc1e45d>:0 

I installed canary on this PC and haven’t installed anything else, AFAICR. It repeats numerous times up through this morning.

The third error doesn’t show up until 5/13:

May 13, 2021 6:43 AM: Reporting error gave error
System.ObjectDisposedException: Can not write to a closed TextWriter.
  at System.IO.StreamWriter.Flush (System.Boolean flushStream, System.Boolean flushEncoder) [0x00008] in <b814b509d4ad406fb40c6c93e38929e7>:0 
  at System.IO.StreamWriter.Flush () [0x00006] in <b814b509d4ad406fb40c6c93e38929e7>:0 
  at Duplicati.Server.WebServer.RESTHandler.DoProcess (Duplicati.Server.WebServer.RESTMethods.RequestInfo info, System.String method, System.String module, System.String key) [0x003bc] in <d38f460035ab4f3b9bab2fc91e2cec32>:0 

…followed immediately by this error:

May 13, 2021 6:43 AM: Request for http://localhost:8200/api/v1/remoteoperation/test gave error
Duplicati.Library.Interface.UserInformationException: Failed to authorize using the OAuth service: Server error. If the problem persists, try generating a new authid token from: https://duplicati-oauth-handler.appspot.com?type=onedrivev2 ---> System.Net.WebException: The remote server returned an error: (500) Internal Server Error.
  at System.Net.HttpWebRequest.GetResponseFromData (System.Net.WebResponseStream stream, System.Threading.CancellationToken cancellationToken) [0x00146] in <6aa0b19d109a447c94d1b43ec4471dc6>:0 
  at System.Net.HttpWebRequest.RunWithTimeoutWorker[T] (System.Threading.Tasks.Task`1[TResult] workerTask, System.Int32 timeout, System.Action abort, System.Func`1[TResult] aborted, System.Threading.CancellationTokenSource cts) [0x000f8] in <6aa0b19d109a447c94d1b43ec4471dc6>:0 
  at Duplicati.Library.Utility.AsyncHttpRequest+AsyncWrapper.GetResponseOrStream () [0x0004d] in <1b35de2536e5489e93307d4ad0240fd2>:0 
  at Duplicati.Library.Utility.AsyncHttpRequest.GetResponse () [0x00044] in <1b35de2536e5489e93307d4ad0240fd2>:0 
  at Duplicati.Library.JSONWebHelper.GetResponse (Duplicati.Library.Utility.AsyncHttpRequest req, System.Object requestdata) [0x000c9] in <f0d969e53b444e228a09a72d3769a5ee>:0 
  at Duplicati.Library.JSONWebHelper.ReadJSONResponse[T] (Duplicati.Library.Utility.AsyncHttpRequest req, System.Object requestdata) [0x00000] in <f0d969e53b444e228a09a72d3769a5ee>:0 
  at Duplicati.Library.JSONWebHelper.ReadJSONResponse[T] (System.Net.HttpWebRequest req, System.Object requestdata) [0x00007] in <f0d969e53b444e228a09a72d3769a5ee>:0 
  at Duplicati.Library.OAuthHelper.GetTokenResponse[T] () [0x00040] in <f0d969e53b444e228a09a72d3769a5ee>:0 
  at Duplicati.Library.OAuthHelper.get_AccessToken () [0x0002f] in <f0d969e53b444e228a09a72d3769a5ee>:0 
   --- End of inner exception stack trace ---
  at Duplicati.Library.OAuthHelper.get_AccessToken () [0x00169] in <f0d969e53b444e228a09a72d3769a5ee>:0 
  at Duplicati.Library.OAuthHelper.CreateRequest (System.String url, System.String method, System.Boolean noAuthorization) [0x00027] in <f0d969e53b444e228a09a72d3769a5ee>:0 
  at Duplicati.Library.OAuthHelper.CreateRequest (System.String url, System.String method) [0x00000] in <f0d969e53b444e228a09a72d3769a5ee>:0 
  at Duplicati.Library.JSONWebHelper.GetResponseWithoutException (System.String url, System.Object requestdata, System.String method) [0x00020] in <f0d969e53b444e228a09a72d3769a5ee>:0 
  at Duplicati.Library.Backend.MicrosoftGraphBackend.SendRequest[T] (System.Net.Http.HttpMethod method, System.String url) [0x00032] in <22708b578dd647fbafbabbcba5b0fd68>:0 
  at Duplicati.Library.Backend.MicrosoftGraphBackend.Get[T] (System.String url) [0x00006] in <22708b578dd647fbafbabbcba5b0fd68>:0 
  at Duplicati.Library.Backend.MicrosoftGraphBackend.Test () [0x00017] in <22708b578dd647fbafbabbcba5b0fd68>:0 
  at Duplicati.Server.WebServer.RESTMethods.RemoteOperation.TestConnection (System.String url, Duplicati.Server.WebServer.RESTMethods.RequestInfo info) [0x000b7] in <d38f460035ab4f3b9bab2fc91e2cec32>:0 
  at Duplicati.Server.WebServer.RESTMethods.RemoteOperation.POST (System.String key, Duplicati.Server.WebServer.RESTMethods.RequestInfo info) [0x00094] in <d38f460035ab4f3b9bab2fc91e2cec32>:0 
  at Duplicati.Server.WebServer.RESTHandler.DoProcess (Duplicati.Server.WebServer.RESTMethods.RequestInfo info, System.String method, System.String module, System.String key) [0x00289] in <d38f460035ab4f3b9bab2fc91e2cec32>:0 

I generated a new authid token shortly after that and the last successful backup shows “05/14/2021 (took 00:01:03)”. Strangely, there are numerous “Failed while executing “Backup” with id: 2” errors before and after the authid token update date.

Since the successful backup on 5/14, I’ve seen the “Error in updater” error 6 times; the “Failed while executing “Backup” with id: 2” 8 times; and the newest (different) errors:

May 25, 2021 10:09 AM: Reporting error gave error
System.InvalidOperationException
  at (wrapper managed-to-native) System.Reflection.Emit.DynamicMethod.create_dynamic_method(System.Reflection.Emit.DynamicMethod)
  at System.Reflection.Emit.DynamicMethod.CreateDynMethod () [0x000b9] in <b814b509d4ad406fb40c6c93e38929e7>:0 
  at System.Reflection.Emit.DynamicMethod.CreateDelegate (System.Type delegateType) [0x00023] in <b814b509d4ad406fb40c6c93e38929e7>:0 
  at Newtonsoft.Json.Utilities.DynamicReflectionDelegateFactory.CreateParameterizedConstructor (System.Reflection.MethodBase method) [0x0003e] in <d47de75a7e3f422ca4ca64a654c80495>:0 
  at Newtonsoft.Json.Serialization.DefaultContractResolver.CreateObjectContract (System.Type objectType) [0x0016a] in <d47de75a7e3f422ca4ca64a654c80495>:0 
  at Newtonsoft.Json.Serialization.DefaultContractResolver.CreateContract (System.Type objectType) [0x0010f] in <d47de75a7e3f422ca4ca64a654c80495>:0 
  at System.Collections.Concurrent.ConcurrentDictionary`2[TKey,TValue].GetOrAdd (TKey key, System.Func`2[T,TResult] valueFactory) [0x00034] in <b814b509d4ad406fb40c6c93e38929e7>:0 
  at Newtonsoft.Json.Utilities.ThreadSafeStore`2[TKey,TValue].Get (TKey key) [0x00000] in <d47de75a7e3f422ca4ca64a654c80495>:0 
  at Newtonsoft.Json.Serialization.DefaultContractResolver.ResolveContract (System.Type type) [0x0000b] in <d47de75a7e3f422ca4ca64a654c80495>:0 
  at Newtonsoft.Json.Serialization.JsonSerializerInternalWriter.GetContractSafe (System.Object value) [0x00016] in <d47de75a7e3f422ca4ca64a654c80495>:0 
  at Newtonsoft.Json.Serialization.JsonSerializerInternalWriter.Serialize (Newtonsoft.Json.JsonWriter jsonWriter, System.Object value, System.Type objectType) [0x00028] in <d47de75a7e3f422ca4ca64a654c80495>:0 
  at Newtonsoft.Json.JsonSerializer.SerializeInternal (Newtonsoft.Json.JsonWriter jsonWriter, System.Object value, System.Type objectType) [0x0023a] in <d47de75a7e3f422ca4ca64a654c80495>:0 
  at Newtonsoft.Json.JsonSerializer.Serialize (Newtonsoft.Json.JsonWriter jsonWriter, System.Object value) [0x00000] in <d47de75a7e3f422ca4ca64a654c80495>:0 
  at Duplicati.Server.Serialization.Serializer.SerializeJson (System.IO.TextWriter sw, System.Object o, System.Boolean preventDispose) [0x00025] in <b5a9229c590043f79d2dfbdb71fadb24>:0 
  at Duplicati.Server.WebServer.BodyWriter.WriteJsonObject (System.Object o) [0x00040] in <63a01150aadd4a64a4d7c359bdc1e45d>:0 
  at (wrapper remoting-invoke-with-check) Duplicati.Server.WebServer.BodyWriter.WriteJsonObject(object)
  at Duplicati.Server.WebServer.RESTHandler.DoProcess (Duplicati.Server.WebServer.RESTMethods.RequestInfo info, System.String method, System.String module, System.String key) [0x003b1] in <63a01150aadd4a64a4d7c359bdc1e45d>:0 

Followed by:

May 25, 2021 10:09 AM: Request for http://localhost:8200/api/v1/serverstate?longpoll=true&lasteventid=131&format=json&duration=5m gave error
System.Threading.ThreadAbortException: Thread was being aborted.
  at (wrapper managed-to-native) System.Threading.WaitHandle.Wait_internal(intptr*,int,bool,int)
  at System.Threading.WaitHandle.WaitOneNative (System.Runtime.InteropServices.SafeHandle waitableSafeHandle, System.UInt32 millisecondsTimeout, System.Boolean hasThreadAffinity, System.Boolean exitContext) [0x00044] in <b814b509d4ad406fb40c6c93e38929e7>:0 
  at System.Threading.WaitHandle.InternalWaitOne (System.Runtime.InteropServices.SafeHandle waitableSafeHandle, System.Int64 millisecondsTimeout, System.Boolean hasThreadAffinity, System.Boolean exitContext) [0x00014] in <b814b509d4ad406fb40c6c93e38929e7>:0 
  at System.Threading.WaitHandle.WaitOne (System.Int64 timeout, System.Boolean exitContext) [0x00000] in <b814b509d4ad406fb40c6c93e38929e7>:0 
  at System.Threading.WaitHandle.WaitOne (System.Int32 millisecondsTimeout, System.Boolean exitContext) [0x00019] in <b814b509d4ad406fb40c6c93e38929e7>:0 
  at Duplicati.Server.EventPollNotify.Wait (System.Int64 eventId, System.Int32 milliseconds) [0x00042] in <63a01150aadd4a64a4d7c359bdc1e45d>:0 
  at Duplicati.Server.WebServer.RESTMethods.RequestInfo.LongPollCheck (Duplicati.Server.EventPollNotify poller, System.Int64& id, System.Boolean& isError) [0x00119] in <63a01150aadd4a64a4d7c359bdc1e45d>:0 
  at Duplicati.Server.WebServer.RESTMethods.ServerState.GET (System.String key, Duplicati.Server.WebServer.RESTMethods.RequestInfo info) [0x0000c] in <63a01150aadd4a64a4d7c359bdc1e45d>:0 
  at Duplicati.Server.WebServer.RESTHandler.DoProcess (Duplicati.Server.WebServer.RESTMethods.RequestInfo info, System.String method, System.String module, System.String key) [0x00146] in <63a01150aadd4a64a4d7c359bdc1e45d>:0

Out of curiosity, I tried manually starting a backup. It took 26 seconds and in the live log ended with “The operation Backup has completed” and the dblock & dlist files are in the cloud as expected.

I didn’t expect the manually run backup to complete successfully when the scheduled backups apparently hadn’t worked in nearly 2 weeks.

After a reboot, going to About shows:

You are currently running Duplicati - 2.0.4.34_canary_2019-11-05
Update 2.0.5.114_canary_2021-03-10 is available, download now

I ran the update > clicked Activate > noticed the duplicati notification icon in the top bar disappeared & Activity monitor showed duplicati and its child processes were closed but never relaunched (so the “Connection lost” modal sits there endlessly trying to connect to the server). Launched duplicati manually > refreshed page > it says I’m not logged in > sign in > go to About and see that it now (again) says I’m running 2.0.5.114_canary_2021-03-10.

4 errors since reboot:

The first is repeated 6 times:

May 25, 2021 12:25 PM: Error in updater
System.Exception: Found unexpected file: /Users/user/Library/Application Support/Duplicati/updates/2.0.5.114/OSXTrayHost/rumps.pyc
  at Duplicati.Library.AutoUpdater.UpdaterManager.VerifyUnpackedFolder (System.String folder, Duplicati.Library.AutoUpdater.UpdateInfo version) [0x002a1] in <0a7cf6efd05d4a43aecfe52cee57a507>:0

The 2nd:

May 25, 2021 12:27 PM: Reporting error gave error
System.InvalidOperationException
  at (wrapper managed-to-native) System.Reflection.Emit.DynamicMethod.create_dynamic_method(System.Reflection.Emit.DynamicMethod)
  at System.Reflection.Emit.DynamicMethod.CreateDynMethod () [0x000b9] in <b814b509d4ad406fb40c6c93e38929e7>:0 
  at System.Reflection.Emit.DynamicMethod.CreateDelegate (System.Type delegateType) [0x00023] in <b814b509d4ad406fb40c6c93e38929e7>:0 
  at Newtonsoft.Json.Utilities.DynamicReflectionDelegateFactory.CreateParameterizedConstructor (System.Reflection.MethodBase method) [0x0003e] in <d47de75a7e3f422ca4ca64a654c80495>:0 
  at Newtonsoft.Json.Serialization.DefaultContractResolver.CreateObjectContract (System.Type objectType) [0x0016a] in <d47de75a7e3f422ca4ca64a654c80495>:0 
  at Newtonsoft.Json.Serialization.DefaultContractResolver.CreateContract (System.Type objectType) [0x0010f] in <d47de75a7e3f422ca4ca64a654c80495>:0 
  at System.Collections.Concurrent.ConcurrentDictionary`2[TKey,TValue].GetOrAdd (TKey key, System.Func`2[T,TResult] valueFactory) [0x00034] in <b814b509d4ad406fb40c6c93e38929e7>:0 
  at Newtonsoft.Json.Utilities.ThreadSafeStore`2[TKey,TValue].Get (TKey key) [0x00000] in <d47de75a7e3f422ca4ca64a654c80495>:0 
  at Newtonsoft.Json.Serialization.DefaultContractResolver.ResolveContract (System.Type type) [0x0000b] in <d47de75a7e3f422ca4ca64a654c80495>:0 
  at Newtonsoft.Json.Serialization.JsonSerializerInternalWriter.GetContractSafe (System.Object value) [0x00016] in <d47de75a7e3f422ca4ca64a654c80495>:0 
  at Newtonsoft.Json.Serialization.JsonSerializerInternalWriter.Serialize (Newtonsoft.Json.JsonWriter jsonWriter, System.Object value, System.Type objectType) [0x00028] in <d47de75a7e3f422ca4ca64a654c80495>:0 
  at Newtonsoft.Json.JsonSerializer.SerializeInternal (Newtonsoft.Json.JsonWriter jsonWriter, System.Object value, System.Type objectType) [0x0023a] in <d47de75a7e3f422ca4ca64a654c80495>:0 
  at Newtonsoft.Json.JsonSerializer.Serialize (Newtonsoft.Json.JsonWriter jsonWriter, System.Object value) [0x00000] in <d47de75a7e3f422ca4ca64a654c80495>:0 
  at Duplicati.Server.Serialization.Serializer.SerializeJson (System.IO.TextWriter sw, System.Object o, System.Boolean preventDispose) [0x00025] in <b5a9229c590043f79d2dfbdb71fadb24>:0 
  at Duplicati.Server.WebServer.BodyWriter.WriteJsonObject (System.Object o) [0x00040] in <63a01150aadd4a64a4d7c359bdc1e45d>:0 
  at (wrapper remoting-invoke-with-check) Duplicati.Server.WebServer.BodyWriter.WriteJsonObject(object)
  at Duplicati.Server.WebServer.RESTHandler.DoProcess (Duplicati.Server.WebServer.RESTMethods.RequestInfo info, System.String method, System.String module, System.String key) [0x003b1] in <63a01150aadd4a64a4d7c359bdc1e45d>:0

3rd:

May 25, 2021 12:27 PM: Request for http://localhost:8200/api/v1/notification/1 gave error
System.Threading.ThreadAbortException: Thread was being aborted.
  at Duplicati.Server.Database.Connection.DismissNotification (System.Int64 id) [0x0009b] in <63a01150aadd4a64a4d7c359bdc1e45d>:0 
  at Duplicati.Server.WebServer.RESTMethods.Notification.DELETE (System.String key, Duplicati.Server.WebServer.RESTMethods.RequestInfo info) [0x00053] in <63a01150aadd4a64a4d7c359bdc1e45d>:0 
  at Duplicati.Server.WebServer.RESTHandler.DoProcess (Duplicati.Server.WebServer.RESTMethods.RequestInfo info, System.String method, System.String module, System.String key) [0x002ad] in <63a01150aadd4a64a4d7c359bdc1e45d>:0

4th:

May 25, 2021 12:27 PM: Request for http://localhost:8200/api/v1/serverstate/?lasteventid=124&longpoll=true&duration=299s gave error
System.Threading.ThreadAbortException: Thread was being aborted.
  at (wrapper managed-to-native) System.Object.__icall_wrapper_ves_icall_thread_finish_async_abort()
  at Duplicati.Server.WebServer.BodyWriter.WriteJsonObject (System.Object o) [0x00063] in <63a01150aadd4a64a4d7c359bdc1e45d>:0 
  at Duplicati.Server.WebServer.BodyWriter.OutputOK (System.Object result) [0x00006] in <63a01150aadd4a64a4d7c359bdc1e45d>:0 
  at (wrapper remoting-invoke-with-check) Duplicati.Server.WebServer.BodyWriter.OutputOK(object)
  at Duplicati.Server.WebServer.RESTMethods.RequestInfo.OutputOK (System.Object item) [0x00006] in <63a01150aadd4a64a4d7c359bdc1e45d>:0 
  at Duplicati.Server.WebServer.RESTMethods.ServerState.GET (System.String key, Duplicati.Server.WebServer.RESTMethods.RequestInfo info) [0x0002a] in <63a01150aadd4a64a4d7c359bdc1e45d>:0 
  at Duplicati.Server.WebServer.RESTHandler.DoProcess (Duplicati.Server.WebServer.RESTMethods.RequestInfo info, System.String method, System.String module, System.String key) [0x00146] in <63a01150aadd4a64a4d7c359bdc1e45d>:0

Since the “Error in updater” topic mentioned that removing the duplicati.app and reinstalling fixed that particular issue, I gave that a try.

After running duplicati, the Stored log shows that the “Error in updater” error isn’t showing up anymore, but the
Reporting error gave error
and
Request for http://localhost:8200/api/v1/serverstate/?lasteventid=12&longpoll=true&duration=299s gave error

errors have already happened since reinstalling the latest available canary.

Does PC mean a Mac, or is this an unusual setup? I don’t have macOS or a Mac to run…

https://usage-reporter.duplicati.com/ shows OSX somewhat rare compared to other OSs.
Still, I’m not seeing reports of such problems, and 2.0.6.1 Beta is basically 2.0.5.114 code.
If there are any Mac users who would share their experiences, please add your comment.

The most-worked issue here is that the Activate button is unreliable, but hasn’t been fixable.
Sometimes an alternative Duplicati restart is needed. Update notifications may also repeat.

The .pyc bug seems rare. These are sometimes compiled .py files (per my research), but
I’m not a Python dev. You could look for rumps* in the new Duplicati install. Is it a new date?
I believe the original install (wherever it is on a Mac) isn’t verified for file content as update is.

Now that you’ve updated your base version, you can probably delete the update folder, BTW.
It’s a long shot that it will fix anything, but you don’t need it after base install is same version.

You can also run mono --version to make sure that it’s at least 5.10. If too old, upgrade it…

They are possibly related. Do they occur in pairs? I don’t know cause, but
.looking at code finds two potential messages like that close to each other:

I think poll is for status updates to browser and/or tray icon. Sample activity:

GET /api/v1/serverstate/?lasteventid=4170&longpoll=true&duration=299s HTTP/1.1
Host: localhost:8200
Connection: keep-alive
sec-ch-ua: " Not A;Brand";v="99", "Chromium";v="90", "Microsoft Edge";v="90"
Pragma: no-cache
X-XSRF-Token: rEJfR+sHuCOuHsC/rgY0yzSdw9g013FpgcRvsLlCkl0=
X-UI-Language: en
User-Agent: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Edg/90.0.818.66
Accept: application/json, text/plain, */*
Cache-Control: no-cache
sec-ch-ua-mobile: ?0
Sec-Fetch-Site: same-origin
Sec-Fetch-Mode: cors
Sec-Fetch-Dest: empty
Referer: http://localhost:8200/ngax/index.html
Accept-Encoding: gzip, deflate, br
Accept-Language: en-US,en;q=0.9
Cookie: default-theme=ngax; xsrf-token=rEJfR%2BsHuCOuHsC%2FrgY0yzSdw9g013FpgcRvsLlCkl0%3D

HTTP/1.1 200 OK
Cache-Control: no-cache, no-store, must-revalidate, max-age=0
Content-Language: en
Date: Thu, 27 May 2021 12:01:42 GMT
Content-Length: 563
Content-Type: application/json
Server: Tiny WebServer
Keep-Alive: timeout=20, max=400
Connection: Keep-Alive
Set-Cookie: xsrf-token=rEJfR%2BsHuCOuHsC%2FrgY0yzSdw9g013FpgcRvsLlCkl0%3D; expires=Thu, 27 May 2021 12:11:42 GMT;path=/; 

...{
  "ProgramState": "Running",
  "UpdatedVersion": null,
  "UpdaterState": "Waiting",
  "UpdateReady": false,
  "UpdateDownloadProgress": 0.0,
  "ActiveTask": {
    "Item1": 230,
    "Item2": "1"
  },
  "SchedulerQueueIds": [],
  "ProposedSchedule": [
    {
      "Item1": "1",
      "Item2": "2021-05-27T12:40:00Z"
    }
  ],
  "HasWarning": false,
  "HasError": false,
  "SuggestedStatusIcon": "Active",
  "EstimatedPauseEnd": "0001-01-01T00:00:00",
  "LastEventID": 4172,
  "LastDataUpdateID": 458,
  "LastNotificationUpdateID": 18
}

It’s an iMac. I was just stating that I hadn’t interacted w/ that PC in some time.

Yes, that’s been my experience. Duplicati (on macOS) has never activated properly. I.e., installation seemed to go smoothly (until recently), but it never relaunches the tray icon app. Manually launching usually works.

The /updates/2.0.5.103/ folder disappeared (I’m assuming after the last upgrade attempt/success) so the the version number in the path within the error eventually changed. Is duplicati expecting only one folder underneath the /updates folder?

Currently, I have 2 folders under /updates: 2.0.5.111 & 2.0.5.114 and, like I mentioned, removing the duplicati.app from Applications and reinstalling it seems to have resolved the issue with the rumps.pyc (which is a compiled python file used to display the tray icon). I guess I’ll leave them for now.

mono --version
Mono JIT compiler version 6.4.0.198 (2019-06/fe64a4765e6 Wed Sep 18 14:14:51 EDT 2019)
Copyright (C) 2002-2014 Novell, Inc, Xamarin Inc and Contributors. www.mono-project.com
	TLS:           
	SIGSEGV:       altstack
	Notification:  kqueue
	Architecture:  amd64
	Disabled:      none
	Misc:          softdebug 
	Interpreter:   yes
	LLVM:          yes(610)
	Suspend:       hybrid
	GC:            sgen (concurrent by default)

Yes, they do appear at the same time. I’m not certain if they are an underlying bug or if they were generated because the update killed off the running instance of duplicati.

I don’t see any further errors since those 2 on 5/25.

Thanks for taking the time to rummage through the errors and provide feedback. I guess the manual removal/reinstall managed to sort out the underlying issues.

1 Like

No, but eventually the old ones are removed. I forget the exact method.

I’m not sure why this isn’t a constant pain for macOS users on updates, but it doesn’t seem to be.
How to avoid .pyc files? has several methods, but a Duplicati fix (if this keeps coming up) may be:

import sys; sys.dont_write_bytecode = True

Perhaps because (all?) macOS users have to launch duplicati after an update and the error logged doesn’t seem to interfere with functionality.

It’s my understanding that the compiled python file is required for the notification tray icon so we want/need to generate them.