OneDrive: Cannot finish backup

I have a problem that a backup from Win to OneDrive does not finish properly. I always get an error during the “Backend event: list”. While at first this step was successful after raising http-operation-timeout to 300 and reruning again (maybe unrelated, but I have seen some sporadic timeouts), it now happens every time. Any hints are appreciated.

Here is the error message:
Duplicati.Library.Backend.MicrosoftGraph.MicrosoftGraphException: InternalServerError: Internal Server Error error from request
https://graph.microsoft.com/v1.0/me/drive/root:/NAS-Musik:/children Method: GET, RequestUri: ‘https://graph.microsoft.com/v1.0/me/drive/root:/NAS-Musik:/children’, Version: 1.1, Content: ,
Headers: {
User-Agent: Duplicati/2.0.5.1
Authorization: Bearer ABC…XYZ
}
StatusCode: 500, ReasonPhrase: ‘Internal Server Error’, Version: 1.1, Content: System.Net.Http.StreamContent,
Headers:
{
request-id: 867aeab4-fa0e-4587-a6e2-b9abbf1f3d7c
client-request-id: 867aeab4-fa0e-4587-a6e2-b9abbf1f3d7c
x-ms-ags-diagnostic: {“ServerInfo”{“DataCenter”:“NorthEurope”,“Slice”:“SliceC”,“Ring”:“3”,“ScaleUnit”:“000”,“RoleInstance”:“AGSFE_IN_169”}}
Strict-Transport-Security: max-age=31536000
Cache-Control: private
Date: Tue, 24 Mar 2020 09:05:27 GMT
Content-Length: 238
Content-Type: application/json
}
{ “error”:
{ “code”: “generalException”,
“message”: “An error occurred in the data store.”,
“innerError”: { “request-id”: “867aeab4-fa0e-4587-a6e2-b9abbf1f3d7c”,
“date”: “2020-03-24T09:05:28” } }
}
bei Duplicati.Library.Main.BackendManager.List()
bei Duplicati.Library.Main.Operation.FilelistProcessor.RemoteListAnalysis(BackendManager backend, Options options, LocalDatabase database, IBackendWriter log, String protectedfile)
bei Duplicati.Library.Main.Operation.FilelistProcessor.VerifyRemoteList(BackendManager backend, Options options, LocalDatabase database, IBackendWriter log, String protectedfile)
bei Duplicati.Library.Main.Operation.BackupHandler.PreBackupVerify(BackendManager backend, String protectedfile) bei Duplicati.Library.Main.Operation.BackupHandler.d__20.MoveNext() — Ende der Stapelüberwachung vom vorhergehenden Ort, an dem die Ausnahme ausgelöst wurde —
bei System.Runtime.ExceptionServices.ExceptionDispatchInfo.Throw()
bei CoCoL.ChannelExtensions.WaitForTaskOrThrow(Task task) bei Duplicati.Library.Main.Controller.<>c__DisplayClass14_0.b__0(BackupResults result)
bei Duplicati.Library.Main.Controller.RunAction[T](T result, String& paths, IFilter& filter, Action`1 method) bei Duplicati.Library.Main.Controller.Backup(String inputsources, IFilter filter)
bei Duplicati.Server.Runner.Run(IRunnerData data, Boolean fromQueue)

I was going to point to OneDrive issue with too many files? and its several reports, but you’re one…
“DataCenter”:“NorthEurope”,“Slice”:“SliceC” is the source of all. I look forward to news on:

Hi, @ts678 . I was opening an additional thread as I do not think it’s a problem of too many files. And I do not get any error messages concerning path or task.

Still failing consistently. Even now, after everything is uploaded, the backup does not finish.

I have some lenghty log, but I did not find any hints.

2020-04-01 16:45:22 +02 - [Profiling-Timer.Begin-Duplicati.Library.Main.Database.ExtensionMethods-ExecuteScalarInt64]: Starting - ExecuteScalarInt64: SELECT COUNT() FROM “FilesetEntry” WHERE “FilesetEntry”.“FilesetID” = 7
2020-04-01 16:45:22 +02 - [Profiling-Timer.Finished-Duplicati.Library.Main.Database.ExtensionMethods-ExecuteScalarInt64]: ExecuteScalarInt64: SELECT COUNT(
) FROM “FilesetEntry” WHERE “FilesetEntry”.“FilesetID” = 7 took 0:00:00:00.002
2020-04-01 16:45:22 +02 - [Profiling-Timer.Begin-Duplicati.Library.Main.Database.ExtensionMethods-ExecuteScalarInt64]: Starting - ExecuteScalarInt64: SELECT COUNT(*) FROM (SELECT DISTINCT “Path” FROM (
SELECT
“L”.“Path”,
“L”.“Lastmodified”,
“L”.“Filelength”,
“L”.“Filehash”,
“L”.“Metahash”,
“L”.“Metalength”,
“L”.“BlocklistHash”,
“L”.“FirstBlockHash”,
“L”.“FirstBlockSize”,
“L”.“FirstMetaBlockHash”,
“L”.“FirstMetaBlockSize”,
“M”.“Hash” AS “MetaBlocklistHash”
FROM
(
SELECT
“J”.“Path”,
“J”.“Lastmodified”,
“J”.“Filelength”,
“J”.“Filehash”,
“J”.“Metahash”,
“J”.“Metalength”,
“K”.“Hash” AS “BlocklistHash”,
“J”.“FirstBlockHash”,
“J”.“FirstBlockSize”,
“J”.“FirstMetaBlockHash”,
“J”.“FirstMetaBlockSize”,
“J”.“MetablocksetID”
FROM
(
SELECT
“A”.“Path” AS “Path”,
“D”.“Lastmodified” AS “Lastmodified”,
“B”.“Length” AS “Filelength”,
“B”.“FullHash” AS “Filehash”,
“E”.“FullHash” AS “Metahash”,
“E”.“Length” AS “Metalength”,
“A”.“BlocksetID” AS “BlocksetID”,
“F”.“Hash” AS “FirstBlockHash”,
“F”.“Size” AS “FirstBlockSize”,
“H”.“Hash” AS “FirstMetaBlockHash”,
“H”.“Size” AS “FirstMetaBlockSize”,
“C”.“BlocksetID” AS “MetablocksetID”
FROM
“File” A
LEFT JOIN “Blockset” B
ON “A”.“BlocksetID” = “B”.“ID”
LEFT JOIN “Metadataset” C
ON “A”.“MetadataID” = “C”.“ID”
LEFT JOIN “FilesetEntry” D
ON “A”.“ID” = “D”.“FileID”
LEFT JOIN “Blockset” E
ON “E”.“ID” = “C”.“BlocksetID”
LEFT JOIN “BlocksetEntry” G
ON “B”.“ID” = “G”.“BlocksetID”
LEFT JOIN “Block” F
ON “G”.“BlockID” = “F”.“ID”
LEFT JOIN “BlocksetEntry” I
ON “E”.“ID” = “I”.“BlocksetID”
LEFT JOIN “Block” H
ON “I”.“BlockID” = “H”.“ID”
WHERE
“A”.“BlocksetId” >= 0 AND
“D”.“FilesetID” = 8 AND
(“I”.“Index” = 0 OR “I”.“Index” IS NULL) AND
(“G”.“Index” = 0 OR “G”.“Index” IS NULL)
) J
LEFT OUTER JOIN
“BlocklistHash” K
ON
“K”.“BlocksetID” = “J”.“BlocksetID”
ORDER BY “J”.“Path”, “K”.“Index”
) L

LEFT OUTER JOIN
“BlocklistHash” M
ON
“M”.“BlocksetID” = “L”.“MetablocksetID”
) UNION SELECT DISTINCT “Path” FROM (
SELECT
“G”.“BlocksetID”,
“G”.“ID”,
“G”.“Path”,
“G”.“Length”,
“G”.“FullHash”,
“G”.“Lastmodified”,
“G”.“FirstMetaBlockHash”,
“H”.“Hash” AS “MetablocklistHash”
FROM
(
SELECT
“B”.“BlocksetID”,
“B”.“ID”,
“B”.“Path”,
“D”.“Length”,
“D”.“FullHash”,
“A”.“Lastmodified”,
“F”.“Hash” AS “FirstMetaBlockHash”,
“C”.“BlocksetID” AS “MetaBlocksetID”
FROM
“FilesetEntry” A,
“File” B,
“Metadataset” C,
“Blockset” D,
“BlocksetEntry” E,
“Block” F
WHERE
“A”.“FileID” = “B”.“ID”
AND “B”.“MetadataID” = “C”.“ID”
AND “C”.“BlocksetID” = “D”.“ID”
AND “E”.“BlocksetID” = “C”.“BlocksetID”
AND “E”.“BlockID” = “F”.“ID”
AND “E”.“Index” = 0
AND (“B”.“BlocksetID” = -100 OR “B”.“BlocksetID” = -200)
AND “A”.“FilesetID” = 8
) G
LEFT OUTER JOIN
“BlocklistHash” H
ON
“H”.“BlocksetID” = “G”.“MetaBlocksetID”
ORDER BY
“G”.“Path”, “H”.“Index”

))
2020-04-01 16:49:14 +02 - [Profiling-Timer.Finished-Duplicati.Library.Main.Database.ExtensionMethods-ExecuteScalarInt64]: ExecuteScalarInt64: SELECT COUNT(*) FROM (SELECT DISTINCT “Path” FROM (
SELECT
“L”.“Path”,
“L”.“Lastmodified”,
“L”.“Filelength”,
“L”.“Filehash”,
“L”.“Metahash”,
“L”.“Metalength”,
“L”.“BlocklistHash”,
“L”.“FirstBlockHash”,
“L”.“FirstBlockSize”,
“L”.“FirstMetaBlockHash”,
“L”.“FirstMetaBlockSize”,
“M”.“Hash” AS “MetaBlocklistHash”
FROM
(
SELECT
“J”.“Path”,
“J”.“Lastmodified”,
“J”.“Filelength”,
“J”.“Filehash”,
“J”.“Metahash”,
“J”.“Metalength”,
“K”.“Hash” AS “BlocklistHash”,
“J”.“FirstBlockHash”,
“J”.“FirstBlockSize”,
“J”.“FirstMetaBlockHash”,
“J”.“FirstMetaBlockSize”,
“J”.“MetablocksetID”
FROM
(
SELECT
“A”.“Path” AS “Path”,
“D”.“Lastmodified” AS “Lastmodified”,
“B”.“Length” AS “Filelength”,
“B”.“FullHash” AS “Filehash”,
“E”.“FullHash” AS “Metahash”,
“E”.“Length” AS “Metalength”,
“A”.“BlocksetID” AS “BlocksetID”,
“F”.“Hash” AS “FirstBlockHash”,
“F”.“Size” AS “FirstBlockSize”,
“H”.“Hash” AS “FirstMetaBlockHash”,
“H”.“Size” AS “FirstMetaBlockSize”,
“C”.“BlocksetID” AS “MetablocksetID”
FROM
“File” A
LEFT JOIN “Blockset” B
ON “A”.“BlocksetID” = “B”.“ID”
LEFT JOIN “Metadataset” C
ON “A”.“MetadataID” = “C”.“ID”
LEFT JOIN “FilesetEntry” D
ON “A”.“ID” = “D”.“FileID”
LEFT JOIN “Blockset” E
ON “E”.“ID” = “C”.“BlocksetID”
LEFT JOIN “BlocksetEntry” G
ON “B”.“ID” = “G”.“BlocksetID”
LEFT JOIN “Block” F
ON “G”.“BlockID” = “F”.“ID”
LEFT JOIN “BlocksetEntry” I
ON “E”.“ID” = “I”.“BlocksetID”
LEFT JOIN “Block” H
ON “I”.“BlockID” = “H”.“ID”
WHERE
“A”.“BlocksetId” >= 0 AND
“D”.“FilesetID” = 8 AND
(“I”.“Index” = 0 OR “I”.“Index” IS NULL) AND
(“G”.“Index” = 0 OR “G”.“Index” IS NULL)
) J
LEFT OUTER JOIN
“BlocklistHash” K
ON
“K”.“BlocksetID” = “J”.“BlocksetID”
ORDER BY “J”.“Path”, “K”.“Index”
) L

LEFT OUTER JOIN
“BlocklistHash” M
ON
“M”.“BlocksetID” = “L”.“MetablocksetID”
) UNION SELECT DISTINCT “Path” FROM (
SELECT
“G”.“BlocksetID”,
“G”.“ID”,
“G”.“Path”,
“G”.“Length”,
“G”.“FullHash”,
“G”.“Lastmodified”,
“G”.“FirstMetaBlockHash”,
“H”.“Hash” AS “MetablocklistHash”
FROM
(
SELECT
“B”.“BlocksetID”,
“B”.“ID”,
“B”.“Path”,
“D”.“Length”,
“D”.“FullHash”,
“A”.“Lastmodified”,
“F”.“Hash” AS “FirstMetaBlockHash”,
“C”.“BlocksetID” AS “MetaBlocksetID”
FROM
“FilesetEntry” A,
“File” B,
“Metadataset” C,
“Blockset” D,
“BlocksetEntry” E,
“Block” F
WHERE
“A”.“FileID” = “B”.“ID”
AND “B”.“MetadataID” = “C”.“ID”
AND “C”.“BlocksetID” = “D”.“ID”
AND “E”.“BlocksetID” = “C”.“BlocksetID”
AND “E”.“BlockID” = “F”.“ID”
AND “E”.“Index” = 0
AND (“B”.“BlocksetID” = -100 OR “B”.“BlocksetID” = -200)
AND “A”.“FilesetID” = 8
) G
LEFT OUTER JOIN
“BlocklistHash” H
ON
“H”.“BlocksetID” = “G”.“MetaBlocksetID”
ORDER BY
“G”.“Path”, “H”.“Index”

)) took 0:00:03:52.665
2020-04-01 16:49:14 +02 - [Profiling-Timer.Begin-Duplicati.Library.Main.Database.ExtensionMethods-ExecuteScalarInt64]: Starting - ExecuteScalarInt64: SELECT COUNT() FROM “FilesetEntry” WHERE “FilesetEntry”.“FilesetID” = 8
2020-04-01 16:49:14 +02 - [Profiling-Timer.Finished-Duplicati.Library.Main.Database.ExtensionMethods-ExecuteScalarInt64]: ExecuteScalarInt64: SELECT COUNT(
) FROM “FilesetEntry” WHERE “FilesetEntry”.“FilesetID” = 8 took 0:00:00:00.004
2020-04-01 16:49:14 +02 - [Profiling-Timer.Begin-Duplicati.Library.Main.Database.ExtensionMethods-ExecuteReader]: Starting - ExecuteReader: SELECT DISTINCT “Fileset”.“ID”, “Fileset”.“Timestamp” FROM “Fileset”, “RemoteVolume” WHERE “RemoteVolume”.“ID” = “Fileset”.“VolumeID” AND “Fileset”.“ID” IN (SELECT “FilesetID” FROM “FilesetEntry”) AND (“RemoteVolume”.“State” = “Uploading” OR “RemoteVolume”.“State” = “Temporary”)
2020-04-01 16:49:14 +02 - [Profiling-Timer.Finished-Duplicati.Library.Main.Database.ExtensionMethods-ExecuteReader]: ExecuteReader: SELECT DISTINCT “Fileset”.“ID”, “Fileset”.“Timestamp” FROM “Fileset”, “RemoteVolume” WHERE “RemoteVolume”.“ID” = “Fileset”.“VolumeID” AND “Fileset”.“ID” IN (SELECT “FilesetID” FROM “FilesetEntry”) AND (“RemoteVolume”.“State” = “Uploading” OR “RemoteVolume”.“State” = “Temporary”) took 0:00:00:00.095
2020-04-01 16:49:14 +02 - [Profiling-Timer.Begin-Duplicati.Library.Main.Operation.BackupHandler-PreBackupVerify]: Starting - PreBackupVerify
2020-04-01 16:49:14 +02 - [Profiling-Timer.Begin-Duplicati.Library.Main.BackendManager-RemoteOperationList]: Starting - RemoteOperationList
2020-04-01 16:49:14 +02 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: List - Started: ()
2020-04-01 16:49:39 +02 - [Profiling-Timer.Finished-Duplicati.Library.Main.BackendManager-RemoteOperationList]: RemoteOperationList took 0:00:00:24.355
2020-04-01 16:49:39 +02 - [Retry-Duplicati.Library.Main.BackendManager-RetryList]: Operation List with file attempt 1 of 5 failed with message: InternalServerError: Internal Server Error error from request https://graph.microsoft.com/v1.0/me/drive/root:/NAS-Musik:/children
Method: GET, RequestUri: ‘https://graph.microsoft.com/v1.0/me/drive/root:/NAS-Musik:/children’, Version: 1.1, Content: , Headers:
{
User-Agent: Duplicati/2.0.5.1
Authorization: Bearer ABC…XYZ
}
StatusCode: 500, ReasonPhrase: ‘Internal Server Error’, Version: 1.1, Content: System.Net.Http.StreamContent, Headers:
{
request-id: 981f26ba-3e45-4ba4-b6cf-2a74720a6a17
client-request-id: 981f26ba-3e45-4ba4-b6cf-2a74720a6a17
x-ms-ags-diagnostic: {“ServerInfo”:{“DataCenter”:“North Europe”,“Slice”:“SliceC”,“Ring”:“4”,“ScaleUnit”:“002”,“RoleInstance”:“AGSFE_IN_83”}}
Strict-Transport-Security: max-age=31536000
Cache-Control: private
Date: Wed, 01 Apr 2020 14:49:42 GMT
Content-Length: 238
Content-Type: application/json
}
{
“error”: {
“code”: “generalException”,
“message”: “An error occurred in the data store.”,
“innerError”: {
“request-id”: “981f26ba-3e45-4ba4-b6cf-2a74720a6a17”,
“date”: “2020-04-01T14:49:43”
}
}
}
Duplicati.Library.Backend.MicrosoftGraph.MicrosoftGraphException: InternalServerError: Internal Server Error error from request https://graph.microsoft.com/v1.0/me/drive/root:/NAS-Musik:/children
Method: GET, RequestUri: ‘https://graph.microsoft.com/v1.0/me/drive/root:/NAS-Musik:/children’, Version: 1.1, Content: , Headers:
{
User-Agent: Duplicati/2.0.5.1
Authorization: Bearer ABC…XYZ
}
StatusCode: 500, ReasonPhrase: ‘Internal Server Error’, Version: 1.1, Content: System.Net.Http.StreamContent, Headers:
{
request-id: 981f26ba-3e45-4ba4-b6cf-2a74720a6a17
client-request-id: 981f26ba-3e45-4ba4-b6cf-2a74720a6a17
x-ms-ags-diagnostic: {“ServerInfo”:{“DataCenter”:“North Europe”,“Slice”:“SliceC”,“Ring”:“4”,“ScaleUnit”:“002”,“RoleInstance”:“AGSFE_IN_83”}}
Strict-Transport-Security: max-age=31536000
Cache-Control: private
Date: Wed, 01 Apr 2020 14:49:42 GMT
Content-Length: 238
Content-Type: application/json
}
{
“error”: {
“code”: “generalException”,
“message”: “An error occurred in the data store.”,
“innerError”: {
“request-id”: “981f26ba-3e45-4ba4-b6cf-2a74720a6a17”,
“date”: “2020-04-01T14:49:43”
}
}
}
bei Duplicati.Library.Backend.MicrosoftGraphBackend.CheckResponse(HttpResponseMessage response)
bei Duplicati.Library.Backend.MicrosoftGraphBackend.ParseResponse[T](HttpResponseMessage response)
bei Duplicati.Library.Backend.MicrosoftGraphBackend.SendRequest[T](HttpRequestMessage request)
bei Duplicati.Library.Backend.MicrosoftGraphBackend.SendRequest[T](HttpMethod method, String url)
bei Duplicati.Library.Backend.MicrosoftGraphBackend.d__651.MoveNext() bei Duplicati.Library.Backend.MicrosoftGraphBackend.<List>d__49.MoveNext() bei System.Collections.Generic.List1…ctor(IEnumerable1 collection) bei System.Linq.Enumerable.ToList[TSource](IEnumerable1 source)
bei Duplicati.Library.Main.BackendManager.DoList(FileEntryItem item)
bei Duplicati.Library.Main.BackendManager.ThreadRun()
2020-04-01 16:49:39 +02 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: List - Retrying: ()
2020-04-01 16:49:49 +02 - [Profiling-Timer.Begin-Duplicati.Library.Main.BackendManager-RemoteOperationList]: Starting - RemoteOperationList
2020-04-01 16:49:49 +02 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: List - Started: ()
2020-04-01 16:50:07 +02 - [Profiling-Timer.Finished-Duplicati.Library.Main.BackendManager-RemoteOperationList]: RemoteOperationList took 0:00:00:17.954
2020-04-01 16:50:07 +02 - [Retry-Duplicati.Library.Main.BackendManager-RetryList]: Operation List with file attempt 2 of 5 failed with message: InternalServerError: Internal Server Error error from request https://graph.microsoft.com/v1.0/me/drive/root:/NAS-Musik:/children
Method: GET, RequestUri: ‘https://graph.microsoft.com/v1.0/me/drive/root:/NAS-Musik:/children’, Version: 1.1, Content: , Headers:
{
User-Agent: Duplicati/2.0.5.1
Authorization: Bearer ABC…XYZ
}
StatusCode: 500, ReasonPhrase: ‘Internal Server Error’, Version: 1.1, Content: System.Net.Http.StreamContent, Headers:
{
request-id: 28ed2025-054f-4e45-a7b4-57079b03c1cc
client-request-id: 28ed2025-054f-4e45-a7b4-57079b03c1cc
x-ms-ags-diagnostic: {“ServerInfo”:{“DataCenter”:“North Europe”,“Slice”:“SliceC”,“Ring”:“4”,“ScaleUnit”:“002”,“RoleInstance”:“AGSFE_IN_150”}}
Strict-Transport-Security: max-age=31536000
Cache-Control: private
Date: Wed, 01 Apr 2020 14:50:10 GMT
Content-Length: 238
Content-Type: application/json
}
{
“error”: {
“code”: “generalException”,
“message”: “An error occurred in the data store.”,
“innerError”: {
“request-id”: “28ed2025-054f-4e45-a7b4-57079b03c1cc”,
“date”: “2020-04-01T14:50:11”
}
}
}
Duplicati.Library.Backend.MicrosoftGraph.MicrosoftGraphException: InternalServerError: Internal Server Error error from request https://graph.microsoft.com/v1.0/me/drive/root:/NAS-Musik:/children
Method: GET, RequestUri: ‘https://graph.microsoft.com/v1.0/me/drive/root:/NAS-Musik:/children’, Version: 1.1, Content: , Headers:
{
User-Agent: Duplicati/2.0.5.1
Authorization: Bearer ABC…XYZ
}
StatusCode: 500, ReasonPhrase: ‘Internal Server Error’, Version: 1.1, Content: System.Net.Http.StreamContent, Headers:
{
request-id: 28ed2025-054f-4e45-a7b4-57079b03c1cc
client-request-id: 28ed2025-054f-4e45-a7b4-57079b03c1cc
x-ms-ags-diagnostic: {“ServerInfo”:{“DataCenter”:“North Europe”,“Slice”:“SliceC”,“Ring”:“4”,“ScaleUnit”:“002”,“RoleInstance”:“AGSFE_IN_150”}}
Strict-Transport-Security: max-age=31536000
Cache-Control: private
Date: Wed, 01 Apr 2020 14:50:10 GMT
Content-Length: 238
Content-Type: application/json
}
{
“error”: {
“code”: “generalException”,
“message”: “An error occurred in the data store.”,
“innerError”: {
“request-id”: “28ed2025-054f-4e45-a7b4-57079b03c1cc”,
“date”: “2020-04-01T14:50:11”
}
}
}
bei Duplicati.Library.Backend.MicrosoftGraphBackend.CheckResponse(HttpResponseMessage response)
bei Duplicati.Library.Backend.MicrosoftGraphBackend.ParseResponse[T](HttpResponseMessage response)
bei Duplicati.Library.Backend.MicrosoftGraphBackend.SendRequest[T](HttpRequestMessage request)
bei Duplicati.Library.Backend.MicrosoftGraphBackend.SendRequest[T](HttpMethod method, String url)
bei Duplicati.Library.Backend.MicrosoftGraphBackend.d__651.MoveNext() bei Duplicati.Library.Backend.MicrosoftGraphBackend.<List>d__49.MoveNext() bei System.Collections.Generic.List1…ctor(IEnumerable1 collection) bei System.Linq.Enumerable.ToList[TSource](IEnumerable1 source)
bei Duplicati.Library.Main.BackendManager.DoList(FileEntryItem item)
bei Duplicati.Library.Main.BackendManager.ThreadRun()
2020-04-01 16:50:07 +02 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: List - Retrying: ()
2020-04-01 16:50:17 +02 - [Profiling-Timer.Begin-Duplicati.Library.Main.BackendManager-RemoteOperationList]: Starting - RemoteOperationList
2020-04-01 16:50:17 +02 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: List - Started: ()
2020-04-01 16:50:36 +02 - [Profiling-Timer.Finished-Duplicati.Library.Main.BackendManager-RemoteOperationList]: RemoteOperationList took 0:00:00:19.106
2020-04-01 16:50:36 +02 - [Retry-Duplicati.Library.Main.BackendManager-RetryList]: Operation List with file attempt 3 of 5 failed with message: InternalServerError: Internal Server Error error from request https://graph.microsoft.com/v1.0/me/drive/root:/NAS-Musik:/children
Method: GET, RequestUri: ‘https://graph.microsoft.com/v1.0/me/drive/root:/NAS-Musik:/children’, Version: 1.1, Content: , Headers:
{
User-Agent: Duplicati/2.0.5.1
Authorization: Bearer ABC…XYZ
}
StatusCode: 500, ReasonPhrase: ‘Internal Server Error’, Version: 1.1, Content: System.Net.Http.StreamContent, Headers:
{
request-id: 5a2044bc-4a8a-44f9-8dd8-2055e5c0e6d5
client-request-id: 5a2044bc-4a8a-44f9-8dd8-2055e5c0e6d5
x-ms-ags-diagnostic: {“ServerInfo”:{“DataCenter”:“North Europe”,“Slice”:“SliceC”,“Ring”:“4”,“ScaleUnit”:“002”,“RoleInstance”:“AGSFE_IN_78”}}
Strict-Transport-Security: max-age=31536000
Cache-Control: private
Date: Wed, 01 Apr 2020 14:50:39 GMT
Content-Length: 238
Content-Type: application/json
}
{
“error”: {
“code”: “generalException”,
“message”: “An error occurred in the data store.”,
“innerError”: {
“request-id”: “5a2044bc-4a8a-44f9-8dd8-2055e5c0e6d5”,
“date”: “2020-04-01T14:50:40”
}
}
}
Duplicati.Library.Backend.MicrosoftGraph.MicrosoftGraphException: InternalServerError: Internal Server Error error from request https://graph.microsoft.com/v1.0/me/drive/root:/NAS-Musik:/children
Method: GET, RequestUri: ‘https://graph.microsoft.com/v1.0/me/drive/root:/NAS-Musik:/children’, Version: 1.1, Content: , Headers:
{
User-Agent: Duplicati/2.0.5.1
Authorization: Bearer ABC…XYZ
}
StatusCode: 500, ReasonPhrase: ‘Internal Server Error’, Version: 1.1, Content: System.Net.Http.StreamContent, Headers:
{
request-id: 5a2044bc-4a8a-44f9-8dd8-2055e5c0e6d5
client-request-id: 5a2044bc-4a8a-44f9-8dd8-2055e5c0e6d5
x-ms-ags-diagnostic: {“ServerInfo”:{“DataCenter”:“North Europe”,“Slice”:“SliceC”,“Ring”:“4”,“ScaleUnit”:“002”,“RoleInstance”:“AGSFE_IN_78”}}
Strict-Transport-Security: max-age=31536000
Cache-Control: private
Date: Wed, 01 Apr 2020 14:50:39 GMT
Content-Length: 238
Content-Type: application/json
}
{
“error”: {
“code”: “generalException”,
“message”: “An error occurred in the data store.”,
“innerError”: {
“request-id”: “5a2044bc-4a8a-44f9-8dd8-2055e5c0e6d5”,
“date”: “2020-04-01T14:50:40”
}
}
}
bei Duplicati.Library.Backend.MicrosoftGraphBackend.CheckResponse(HttpResponseMessage response)
bei Duplicati.Library.Backend.MicrosoftGraphBackend.ParseResponse[T](HttpResponseMessage response)
bei Duplicati.Library.Backend.MicrosoftGraphBackend.SendRequest[T](HttpRequestMessage request)
bei Duplicati.Library.Backend.MicrosoftGraphBackend.SendRequest[T](HttpMethod method, String url)
bei Duplicati.Library.Backend.MicrosoftGraphBackend.d__651.MoveNext() bei Duplicati.Library.Backend.MicrosoftGraphBackend.<List>d__49.MoveNext() bei System.Collections.Generic.List1…ctor(IEnumerable1 collection) bei System.Linq.Enumerable.ToList[TSource](IEnumerable1 source)
bei Duplicati.Library.Main.BackendManager.DoList(FileEntryItem item)
bei Duplicati.Library.Main.BackendManager.ThreadRun()
2020-04-01 16:50:36 +02 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: List - Retrying: ()
2020-04-01 16:50:46 +02 - [Profiling-Timer.Begin-Duplicati.Library.Main.BackendManager-RemoteOperationList]: Starting - RemoteOperationList
2020-04-01 16:50:46 +02 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: List - Started: ()
2020-04-01 16:51:05 +02 - [Profiling-Timer.Finished-Duplicati.Library.Main.BackendManager-RemoteOperationList]: RemoteOperationList took 0:00:00:19.011
2020-04-01 16:51:05 +02 - [Retry-Duplicati.Library.Main.BackendManager-RetryList]: Operation List with file attempt 4 of 5 failed with message: InternalServerError: Internal Server Error error from request https://graph.microsoft.com/v1.0/me/drive/root:/NAS-Musik:/children
Method: GET, RequestUri: ‘https://graph.microsoft.com/v1.0/me/drive/root:/NAS-Musik:/children’, Version: 1.1, Content: , Headers:
{
User-Agent: Duplicati/2.0.5.1
Authorization: Bearer ABC…XYZ
}
StatusCode: 500, ReasonPhrase: ‘Internal Server Error’, Version: 1.1, Content: System.Net.Http.StreamContent, Headers:
{
request-id: f51d3fa2-1645-4476-b9f7-0cf65c242194
client-request-id: f51d3fa2-1645-4476-b9f7-0cf65c242194
x-ms-ags-diagnostic: {“ServerInfo”:{“DataCenter”:“North Europe”,“Slice”:“SliceC”,“Ring”:“4”,“ScaleUnit”:“002”,“RoleInstance”:“AGSFE_IN_156”}}
Strict-Transport-Security: max-age=31536000
Cache-Control: private
Date: Wed, 01 Apr 2020 14:51:08 GMT
Content-Length: 238
Content-Type: application/json
}
{
“error”: {
“code”: “generalException”,
“message”: “An error occurred in the data store.”,
“innerError”: {
“request-id”: “f51d3fa2-1645-4476-b9f7-0cf65c242194”,
“date”: “2020-04-01T14:51:09”
}
}
}
Duplicati.Library.Backend.MicrosoftGraph.MicrosoftGraphException: InternalServerError: Internal Server Error error from request https://graph.microsoft.com/v1.0/me/drive/root:/NAS-Musik:/children
Method: GET, RequestUri: ‘https://graph.microsoft.com/v1.0/me/drive/root:/NAS-Musik:/children’, Version: 1.1, Content: , Headers:
{
User-Agent: Duplicati/2.0.5.1
Authorization: Bearer ABC…XYZ
}
StatusCode: 500, ReasonPhrase: ‘Internal Server Error’, Version: 1.1, Content: System.Net.Http.StreamContent, Headers:
{
request-id: f51d3fa2-1645-4476-b9f7-0cf65c242194
client-request-id: f51d3fa2-1645-4476-b9f7-0cf65c242194
x-ms-ags-diagnostic: {“ServerInfo”:{“DataCenter”:“North Europe”,“Slice”:“SliceC”,“Ring”:“4”,“ScaleUnit”:“002”,“RoleInstance”:“AGSFE_IN_156”}}
Strict-Transport-Security: max-age=31536000
Cache-Control: private
Date: Wed, 01 Apr 2020 14:51:08 GMT
Content-Length: 238
Content-Type: application/json
}
{
“error”: {
“code”: “generalException”,
“message”: “An error occurred in the data store.”,
“innerError”: {
“request-id”: “f51d3fa2-1645-4476-b9f7-0cf65c242194”,
“date”: “2020-04-01T14:51:09”
}
}
}
bei Duplicati.Library.Backend.MicrosoftGraphBackend.CheckResponse(HttpResponseMessage response)
bei Duplicati.Library.Backend.MicrosoftGraphBackend.ParseResponse[T](HttpResponseMessage response)
bei Duplicati.Library.Backend.MicrosoftGraphBackend.SendRequest[T](HttpRequestMessage request)
bei Duplicati.Library.Backend.MicrosoftGraphBackend.SendRequest[T](HttpMethod method, String url)
bei Duplicati.Library.Backend.MicrosoftGraphBackend.d__651.MoveNext() bei Duplicati.Library.Backend.MicrosoftGraphBackend.<List>d__49.MoveNext() bei System.Collections.Generic.List1…ctor(IEnumerable1 collection) bei System.Linq.Enumerable.ToList[TSource](IEnumerable1 source)
bei Duplicati.Library.Main.BackendManager.DoList(FileEntryItem item)
bei Duplicati.Library.Main.BackendManager.ThreadRun()
2020-04-01 16:51:05 +02 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: List - Retrying: ()
2020-04-01 16:51:15 +02 - [Profiling-Timer.Begin-Duplicati.Library.Main.BackendManager-RemoteOperationList]: Starting - RemoteOperationList
2020-04-01 16:51:15 +02 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: List - Started: ()
2020-04-01 16:51:35 +02 - [Profiling-Timer.Finished-Duplicati.Library.Main.BackendManager-RemoteOperationList]: RemoteOperationList took 0:00:00:19.993
2020-04-01 16:51:35 +02 - [Retry-Duplicati.Library.Main.BackendManager-RetryList]: Operation List with file attempt 5 of 5 failed with message: InternalServerError: Internal Server Error error from request https://graph.microsoft.com/v1.0/me/drive/root:/NAS-Musik:/children
Method: GET, RequestUri: ‘https://graph.microsoft.com/v1.0/me/drive/root:/NAS-Musik:/children’, Version: 1.1, Content: , Headers:
{
User-Agent: Duplicati/2.0.5.1
Authorization: Bearer ABC…XYZ
}
StatusCode: 500, ReasonPhrase: ‘Internal Server Error’, Version: 1.1, Content: System.Net.Http.StreamContent, Headers:
{
request-id: cd470291-388e-41fb-b8bf-c55b54ecc7ab
client-request-id: cd470291-388e-41fb-b8bf-c55b54ecc7ab
x-ms-ags-diagnostic: {“ServerInfo”:{“DataCenter”:“North Europe”,“Slice”:“SliceC”,“Ring”:“4”,“ScaleUnit”:“002”,“RoleInstance”:“AGSFE_IN_145”}}
Strict-Transport-Security: max-age=31536000
Cache-Control: private
Date: Wed, 01 Apr 2020 14:51:38 GMT
Content-Length: 238
Content-Type: application/json
}
{
“error”: {
“code”: “generalException”,
“message”: “An error occurred in the data store.”,
“innerError”: {
“request-id”: “cd470291-388e-41fb-b8bf-c55b54ecc7ab”,
“date”: “2020-04-01T14:51:39”
}
}
}
Duplicati.Library.Backend.MicrosoftGraph.MicrosoftGraphException: InternalServerError: Internal Server Error error from request https://graph.microsoft.com/v1.0/me/drive/root:/NAS-Musik:/children
Method: GET, RequestUri: ‘https://graph.microsoft.com/v1.0/me/drive/root:/NAS-Musik:/children’, Version: 1.1, Content: , Headers:
{
User-Agent: Duplicati/2.0.5.1
Authorization: Bearer ABC…XYZ
}
StatusCode: 500, ReasonPhrase: ‘Internal Server Error’, Version: 1.1, Content: System.Net.Http.StreamContent, Headers:
{
request-id: cd470291-388e-41fb-b8bf-c55b54ecc7ab
client-request-id: cd470291-388e-41fb-b8bf-c55b54ecc7ab
x-ms-ags-diagnostic: {“ServerInfo”:{“DataCenter”:“North Europe”,“Slice”:“SliceC”,“Ring”:“4”,“ScaleUnit”:“002”,“RoleInstance”:“AGSFE_IN_145”}}
Strict-Transport-Security: max-age=31536000
Cache-Control: private
Date: Wed, 01 Apr 2020 14:51:38 GMT
Content-Length: 238
Content-Type: application/json
}
{
“error”: {
“code”: “generalException”,
“message”: “An error occurred in the data store.”,
“innerError”: {
“request-id”: “cd470291-388e-41fb-b8bf-c55b54ecc7ab”,
“date”: “2020-04-01T14:51:39”
}
}
}
bei Duplicati.Library.Backend.MicrosoftGraphBackend.CheckResponse(HttpResponseMessage response)
bei Duplicati.Library.Backend.MicrosoftGraphBackend.ParseResponse[T](HttpResponseMessage response)
bei Duplicati.Library.Backend.MicrosoftGraphBackend.SendRequest[T](HttpRequestMessage request)
bei Duplicati.Library.Backend.MicrosoftGraphBackend.SendRequest[T](HttpMethod method, String url)
bei Duplicati.Library.Backend.MicrosoftGraphBackend.d__651.MoveNext() bei Duplicati.Library.Backend.MicrosoftGraphBackend.<List>d__49.MoveNext() bei System.Collections.Generic.List1…ctor(IEnumerable1 collection) bei System.Linq.Enumerable.ToList[TSource](IEnumerable1 source)
bei Duplicati.Library.Main.BackendManager.DoList(FileEntryItem item)
bei Duplicati.Library.Main.BackendManager.ThreadRun()
2020-04-01 16:51:35 +02 - [Information-Duplicati.Library.Main.BasicResults-BackendEvent]: Backend event: List - Failed: ()
2020-04-01 16:51:35 +02 - [Profiling-Timer.Finished-Duplicati.Library.Main.Operation.BackupHandler-PreBackupVerify]: PreBackupVerify took 0:00:02:20.462
2020-04-01 16:51:35 +02 - [Error-Duplicati.Library.Main.Operation.BackupHandler-FatalError]: Fatal error
Duplicati.Library.Backend.MicrosoftGraph.MicrosoftGraphException: InternalServerError: Internal Server Error error from request https://graph.microsoft.com/v1.0/me/drive/root:/NAS-Musik:/children
Method: GET, RequestUri: ‘https://graph.microsoft.com/v1.0/me/drive/root:/NAS-Musik:/children’, Version: 1.1, Content: , Headers:
{
User-Agent: Duplicati/2.0.5.1
Authorization: Bearer ABC…XYZ
}
StatusCode: 500, ReasonPhrase: ‘Internal Server Error’, Version: 1.1, Content: System.Net.Http.StreamContent, Headers:
{
request-id: cd470291-388e-41fb-b8bf-c55b54ecc7ab
client-request-id: cd470291-388e-41fb-b8bf-c55b54ecc7ab
x-ms-ags-diagnostic: {“ServerInfo”:{“DataCenter”:“North Europe”,“Slice”:“SliceC”,“Ring”:“4”,“ScaleUnit”:“002”,“RoleInstance”:“AGSFE_IN_145”}}
Strict-Transport-Security: max-age=31536000
Cache-Control: private
Date: Wed, 01 Apr 2020 14:51:38 GMT
Content-Length: 238
Content-Type: application/json
}
{
“error”: {
“code”: “generalException”,
“message”: “An error occurred in the data store.”,
“innerError”: {
“request-id”: “cd470291-388e-41fb-b8bf-c55b54ecc7ab”,
“date”: “2020-04-01T14:51:39”
}
}
}
bei Duplicati.Library.Main.BackendManager.List()
bei Duplicati.Library.Main.Operation.FilelistProcessor.RemoteListAnalysis(BackendManager backend, Options options, LocalDatabase database, IBackendWriter log, String protectedfile)
bei Duplicati.Library.Main.Operation.FilelistProcessor.VerifyRemoteList(BackendManager backend, Options options, LocalDatabase database, IBackendWriter log, String protectedfile)
bei Duplicati.Library.Main.Operation.BackupHandler.PreBackupVerify(BackendManager backend, String protectedfile)
bei Duplicati.Library.Main.Operation.BackupHandler.d__20.MoveNext()
2020-04-01 16:51:35 +02 - [Profiling-Timer.Begin-Duplicati.Library.Main.Database.ExtensionMethods-ExecuteNonQuery]: Starting - ExecuteNonQuery: PRAGMA optimize
2020-04-01 16:51:35 +02 - [Profiling-Timer.Finished-Duplicati.Library.Main.Database.ExtensionMethods-ExecuteNonQuery]: ExecuteNonQuery: PRAGMA optimize took 0:00:00:00.002
2020-04-01 16:51:35 +02 - [Profiling-Timer.Finished-Duplicati.Library.Main.Controller-RunBackup]: Running Backup took 0:00:30:12.443