"./sync.test -test.v -test.timeout 1h0m0s -remote TestnStorage: -verbose -fast-list -test.run '^(TestServerSideCopy|TestServerSideMove|TestServerSideMoveDeleteEmptySourceDirs|TestSyncCompareDest)$'" - Starting (try 2/5) 2026/02/26 03:47:05 DEBUG : Creating backend with remote "TestnStorage:rclone-test-cemuyan3xipa" 2026/02/26 03:47:05 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/02/26 03:47:05 DEBUG : NetStorage NewFS endpoint "https://rclone-nsu.akamaihd.net/1210146/" 2026/02/26 03:47:05 DEBUG : NetStorage API GET call version=1&action=stat&implicit=yes&format=xml&encoding=utf-8&slash=both for path "/1210146/rclone-test-cemuyan3xipa" 2026/02/26 03:47:06 DEBUG : NetStorage action stat failed for "https://rclone-nsu.akamaihd.net/1210146/rclone-test-cemuyan3xipa": object not found 2026/02/26 03:47:06 DEBUG : Creating backend with remote "/tmp/rclone3602475770" === RUN TestServerSideCopy run.go:185: Remote "https://rclone-nsu.akamaihd.net/1210146/rclone-test-cemuyan3xipa/", Local "Local file system at /tmp/rclone3602475770", Modify Window "1s" 2026/02/26 03:47:06 INFO : Implicitly create directory https://rclone-nsu.akamaihd.net/1210146/rclone-test-cemuyan3xipa/ 2026/02/26 03:47:06 DEBUG : NetStorage API POST call version=1&action=mkdir for path "/1210146/rclone-test-cemuyan3xipa/" 2026/02/26 03:47:06 INFO : Implicitly create directory https://rclone-nsu.akamaihd.net/1210146/rclone-test-cemuyan3xipa/sub%20dir/ 2026/02/26 03:47:06 DEBUG : NetStorage API POST call version=1&action=mkdir for path "/1210146/rclone-test-cemuyan3xipa/sub%20dir/" 2026/02/26 03:47:06 DEBUG : NetStorage API PUT call version=1&action=upload&sha256=atend&mtime=atend for path "/1210146/rclone-test-cemuyan3xipa/sub%20dir/hello%20world" 2026/02/26 03:47:07 DEBUG : NetStorage API GET call version=1&action=stat&implicit=yes&format=xml&encoding=utf-8&slash=both for path "/1210146/rclone-test-cemuyan3xipa" 2026/02/26 03:47:07 DEBUG : NetStorage API GET call version=1&action=list&mtime_all=yes&format=xml&encoding=utf-8&end=%2F1210146%2Frclone-test-cemuyan3xipa0 for path "/1210146/rclone-test-cemuyan3xipa/" 2026/02/26 03:47:07 DEBUG : Creating backend with remote "TestnStorage:rclone-test-cuwilic8mazi" 2026/02/26 03:47:07 DEBUG : NetStorage NewFS endpoint "https://rclone-nsu.akamaihd.net/1210146/" 2026/02/26 03:47:07 DEBUG : NetStorage API GET call version=1&action=stat&implicit=yes&format=xml&encoding=utf-8&slash=both for path "/1210146/rclone-test-cuwilic8mazi" 2026/02/26 03:47:07 DEBUG : NetStorage action stat failed for "https://rclone-nsu.akamaihd.net/1210146/rclone-test-cuwilic8mazi": object not found sync_test.go:620: Server side copy (if possible) https://rclone-nsu.akamaihd.net/1210146/rclone-test-cemuyan3xipa/ -> https://rclone-nsu.akamaihd.net/1210146/rclone-test-cuwilic8mazi/ 2026/02/26 03:47:07 DEBUG : NetStorage API GET call version=1&action=stat&implicit=yes&format=xml&encoding=utf-8&slash=both for path "/1210146/rclone-test-cuwilic8mazi" 2026/02/26 03:47:07 DEBUG : NetStorage API GET call version=1&action=list&mtime_all=yes&format=xml&encoding=utf-8&end=%2F1210146%2Frclone-test-cemuyan3xipa0 for path "/1210146/rclone-test-cemuyan3xipa/" 2026/02/26 03:47:07 DEBUG : NetStorage action stat failed for "https://rclone-nsu.akamaihd.net/1210146/rclone-test-cuwilic8mazi": object not found 2026/02/26 03:47:07 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2026/02/26 03:47:07 DEBUG : https://rclone-nsu.akamaihd.net/1210146/rclone-test-cuwilic8mazi/: Waiting for checks to finish 2026/02/26 03:47:07 DEBUG : https://rclone-nsu.akamaihd.net/1210146/rclone-test-cuwilic8mazi/: Waiting for transfers to finish 2026/02/26 03:47:07 DEBUG : NetStorage API GET call version=1&action=download for path "/1210146/rclone-test-cemuyan3xipa/sub%20dir/hello%20world" 2026/02/26 03:47:07 INFO : Implicitly create directory https://rclone-nsu.akamaihd.net/1210146/rclone-test-cuwilic8mazi/ 2026/02/26 03:47:07 DEBUG : NetStorage API POST call version=1&action=mkdir for path "/1210146/rclone-test-cuwilic8mazi/" 2026/02/26 03:47:07 INFO : Implicitly create directory https://rclone-nsu.akamaihd.net/1210146/rclone-test-cuwilic8mazi/sub%20dir/ 2026/02/26 03:47:07 DEBUG : NetStorage API POST call version=1&action=mkdir for path "/1210146/rclone-test-cuwilic8mazi/sub%20dir/" 2026/02/26 03:47:07 DEBUG : NetStorage API PUT call version=1&action=upload&sha256=atend&mtime=atend for path "/1210146/rclone-test-cuwilic8mazi/sub%20dir/hello%20world" 2026/02/26 03:47:08 DEBUG : NetStorage action upload failed for "https://rclone-nsu.akamaihd.net/1210146/rclone-test-cuwilic8mazi/sub%20dir/hello%20world": HTTP error 400 (400 Bad Request) returned body: "XAAA invalid\n" 2026/02/26 03:47:08 DEBUG : NetStorage API POST call version=1&action=delete for path "/1210146/rclone-test-cuwilic8mazi/sub%20dir/hello%20world" 2026/02/26 03:47:08 DEBUG : NetStorage action delete failed for "https://rclone-nsu.akamaihd.net/1210146/rclone-test-cuwilic8mazi/sub%20dir/hello%20world": object not found 2026/02/26 03:47:08 ERROR : sub dir/hello world: Failed to copy: failed to call NetStorage API upload: HTTP error 400 (400 Bad Request) returned body: "XAAA invalid\n" sync_test.go:624: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:624 Error: Received unexpected error: failed to call NetStorage API upload: HTTP error 400 (400 Bad Request) returned body: "XAAA invalid\n" Test: TestServerSideCopy 2026/02/26 03:47:08 DEBUG : https://rclone-nsu.akamaihd.net/1210146/rclone-test-cuwilic8mazi/: Purge remote 2026/02/26 03:47:08 DEBUG : NetStorage API POST call version=1&action=quick-delete&quick-delete=imreallyreallysure for path "/1210146/rclone-test-cuwilic8mazi/" 2026/02/26 03:47:08 NOTICE: Purge using quick-delete failed, fallback on recursive delete: failed to call NetStorage API: HTTP error 403 (403 Forbidden) returned body: "Feature not enabled for this request.\n" 2026/02/26 03:47:08 DEBUG : NetStorage API GET call version=1&action=stat&implicit=yes&format=xml&encoding=utf-8&slash=both for path "/1210146/rclone-test-cuwilic8mazi" 2026/02/26 03:47:09 DEBUG : NetStorage API GET call version=1&action=list&mtime_all=yes&format=xml&encoding=utf-8&end=%2F1210146%2Frclone-test-cuwilic8mazi0 for path "/1210146/rclone-test-cuwilic8mazi/" 2026/02/26 03:47:09 DEBUG : https://rclone-nsu.akamaihd.net/1210146/rclone-test-cuwilic8mazi/: Purge dir "sub dir" 2026/02/26 03:47:09 DEBUG : NetStorage API POST call version=1&action=rmdir for path "/1210146/rclone-test-cuwilic8mazi/sub%20dir" 2026/02/26 03:47:09 DEBUG : https://rclone-nsu.akamaihd.net/1210146/rclone-test-cuwilic8mazi/: Purge dir "" 2026/02/26 03:47:09 DEBUG : NetStorage API POST call version=1&action=rmdir for path "/1210146/rclone-test-cuwilic8mazi/" 2026/02/26 03:47:09 DEBUG : NetStorage API GET call version=1&action=list&mtime_all=yes&format=xml&encoding=utf-8&end=%2F1210146%2Frclone-test-cemuyan3xipa0 for path "/1210146/rclone-test-cemuyan3xipa/" 2026/02/26 03:47:09 DEBUG : NetStorage API POST call version=1&action=delete for path "/1210146/rclone-test-cemuyan3xipa/sub%20dir/hello%20world" 2026/02/26 03:47:09 DEBUG : NetStorage API POST call version=1&action=rmdir for path "/1210146/rclone-test-cemuyan3xipa/sub%20dir" 2026/02/26 03:47:10 DEBUG : NetStorage API GET call version=1&action=list&mtime_all=yes&format=xml&encoding=utf-8&end=%2F1210146%2Frclone-test-cemuyan3xipa0 for path "/1210146/rclone-test-cemuyan3xipa/" --- FAIL: TestServerSideCopy (4.14s) === RUN TestServerSideMove run.go:185: Remote "https://rclone-nsu.akamaihd.net/1210146/rclone-test-cemuyan3xipa/", Local "Local file system at /tmp/rclone3602475770", Modify Window "1s" 2026/02/26 03:47:10 DEBUG : Creating backend with remote "TestnStorage:rclone-test-junexus9quwu" 2026/02/26 03:47:10 DEBUG : NetStorage NewFS endpoint "https://rclone-nsu.akamaihd.net/1210146/" 2026/02/26 03:47:10 DEBUG : NetStorage API GET call version=1&action=stat&implicit=yes&format=xml&encoding=utf-8&slash=both for path "/1210146/rclone-test-junexus9quwu" 2026/02/26 03:47:10 DEBUG : NetStorage action stat failed for "https://rclone-nsu.akamaihd.net/1210146/rclone-test-junexus9quwu": object not found 2026/02/26 03:47:10 DEBUG : NetStorage API PUT call version=1&action=upload&sha256=atend&mtime=atend for path "/1210146/rclone-test-cemuyan3xipa/potato2" 2026/02/26 03:47:10 DEBUG : NetStorage API PUT call version=1&action=upload&sha256=atend&mtime=atend for path "/1210146/rclone-test-cemuyan3xipa/empty%20space" 2026/02/26 03:47:10 DEBUG : NetStorage API PUT call version=1&action=upload&sha256=atend&mtime=atend for path "/1210146/rclone-test-cemuyan3xipa/potato3" 2026/02/26 03:47:11 DEBUG : NetStorage API GET call version=1&action=list&mtime_all=yes&format=xml&encoding=utf-8&end=%2F1210146%2Frclone-test-cemuyan3xipa0 for path "/1210146/rclone-test-cemuyan3xipa/" sync_test.go:1736: Server side move (if possible) https://rclone-nsu.akamaihd.net/1210146/rclone-test-cemuyan3xipa/ -> https://rclone-nsu.akamaihd.net/1210146/rclone-test-junexus9quwu/ 2026/02/26 03:47:11 INFO : Implicitly create directory https://rclone-nsu.akamaihd.net/1210146/rclone-test-junexus9quwu/ 2026/02/26 03:47:11 DEBUG : NetStorage API POST call version=1&action=mkdir for path "/1210146/rclone-test-junexus9quwu/" 2026/02/26 03:47:11 DEBUG : NetStorage API PUT call version=1&action=upload&sha256=atend&mtime=atend for path "/1210146/rclone-test-junexus9quwu/empty%20space" 2026/02/26 03:47:12 DEBUG : NetStorage API PUT call version=1&action=upload&sha256=atend&mtime=atend for path "/1210146/rclone-test-junexus9quwu/potato3" 2026/02/26 03:47:12 DEBUG : NetStorage API GET call version=1&action=stat&implicit=yes&format=xml&encoding=utf-8&slash=both for path "/1210146/rclone-test-junexus9quwu" 2026/02/26 03:47:12 DEBUG : NetStorage API GET call version=1&action=list&mtime_all=yes&format=xml&encoding=utf-8&end=%2F1210146%2Frclone-test-junexus9quwu0 for path "/1210146/rclone-test-junexus9quwu/" 2026/02/26 03:47:12 DEBUG : NetStorage API GET call version=1&action=list&mtime_all=yes&format=xml&encoding=utf-8&end=%2F1210146%2Frclone-test-cemuyan3xipa0 for path "/1210146/rclone-test-cemuyan3xipa/" 2026/02/26 03:47:12 DEBUG : NetStorage API GET call version=1&action=list&mtime_all=yes&format=xml&encoding=utf-8&end=%2F1210146%2Frclone-test-junexus9quwu0 for path "/1210146/rclone-test-junexus9quwu/" 2026/02/26 03:47:12 DEBUG : potato2: Need to transfer - File not found at Destination 2026/02/26 03:47:12 DEBUG : empty space: size = 1 OK 2026/02/26 03:47:12 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2026/02/26 03:47:12 DEBUG : empty space: Unchanged skipping 2026/02/26 03:47:12 DEBUG : potato3: size = 68 (https://rclone-nsu.akamaihd.net/1210146/rclone-test-cemuyan3xipa/) 2026/02/26 03:47:12 DEBUG : potato3: size = 60 (https://rclone-nsu.akamaihd.net/1210146/rclone-test-junexus9quwu/) 2026/02/26 03:47:12 DEBUG : NetStorage API POST call version=1&action=delete for path "/1210146/rclone-test-cemuyan3xipa/empty%20space" 2026/02/26 03:47:12 DEBUG : potato3: Sizes differ 2026/02/26 03:47:12 DEBUG : https://rclone-nsu.akamaihd.net/1210146/rclone-test-junexus9quwu/: Waiting for checks to finish 2026/02/26 03:47:12 DEBUG : NetStorage API GET call version=1&action=download for path "/1210146/rclone-test-cemuyan3xipa/potato2" 2026/02/26 03:47:12 DEBUG : NetStorage API GET call version=1&action=download for path "/1210146/rclone-test-cemuyan3xipa/potato3" 2026/02/26 03:47:12 INFO : empty space: Deleted 2026/02/26 03:47:12 DEBUG : https://rclone-nsu.akamaihd.net/1210146/rclone-test-junexus9quwu/: Waiting for transfers to finish 2026/02/26 03:47:12 DEBUG : NetStorage API PUT call version=1&action=upload&sha256=atend&mtime=atend for path "/1210146/rclone-test-junexus9quwu/potato2" 2026/02/26 03:47:12 DEBUG : potato2: size = 60 OK 2026/02/26 03:47:12 DEBUG : potato2: Dst hash empty - aborting Src hash check 2026/02/26 03:47:12 INFO : potato2: Copied (new) 2026/02/26 03:47:12 DEBUG : NetStorage API POST call version=1&action=delete for path "/1210146/rclone-test-cemuyan3xipa/potato2" 2026/02/26 03:47:12 INFO : potato2: Deleted 2026/02/26 03:47:12 DEBUG : NetStorage API PUT call version=1&action=upload&sha256=atend&mtime=atend for path "/1210146/rclone-test-junexus9quwu/potato3" 2026/02/26 03:47:13 DEBUG : potato3: size = 68 OK 2026/02/26 03:47:13 DEBUG : potato3: Dst hash empty - aborting Src hash check 2026/02/26 03:47:13 INFO : potato3: Copied (replaced existing) 2026/02/26 03:47:13 DEBUG : NetStorage API POST call version=1&action=delete for path "/1210146/rclone-test-cemuyan3xipa/potato3" 2026/02/26 03:47:13 INFO : potato3: Deleted 2026/02/26 03:47:13 DEBUG : NetStorage API GET call version=1&action=list&mtime_all=yes&format=xml&encoding=utf-8&end=%2F1210146%2Frclone-test-cemuyan3xipa0 for path "/1210146/rclone-test-cemuyan3xipa/" 2026/02/26 03:47:13 DEBUG : NetStorage API GET call version=1&action=list&mtime_all=yes&format=xml&encoding=utf-8&end=%2F1210146%2Frclone-test-junexus9quwu0 for path "/1210146/rclone-test-junexus9quwu/" 2026/02/26 03:47:13 DEBUG : Creating backend with remote "TestnStorage:rclone-test-zezatah3wozu" 2026/02/26 03:47:13 DEBUG : NetStorage NewFS endpoint "https://rclone-nsu.akamaihd.net/1210146/" 2026/02/26 03:47:13 DEBUG : NetStorage API GET call version=1&action=stat&implicit=yes&format=xml&encoding=utf-8&slash=both for path "/1210146/rclone-test-zezatah3wozu" 2026/02/26 03:47:13 DEBUG : NetStorage action stat failed for "https://rclone-nsu.akamaihd.net/1210146/rclone-test-zezatah3wozu": object not found 2026/02/26 03:47:13 DEBUG : NetStorage API GET call version=1&action=stat&implicit=yes&format=xml&encoding=utf-8&slash=both for path "/1210146/rclone-test-zezatah3wozu" 2026/02/26 03:47:13 DEBUG : NetStorage API GET call version=1&action=list&mtime_all=yes&format=xml&encoding=utf-8&end=%2F1210146%2Frclone-test-junexus9quwu0 for path "/1210146/rclone-test-junexus9quwu/" 2026/02/26 03:47:13 DEBUG : NetStorage action stat failed for "https://rclone-nsu.akamaihd.net/1210146/rclone-test-zezatah3wozu": object not found 2026/02/26 03:47:13 DEBUG : empty space: Need to transfer - File not found at Destination 2026/02/26 03:47:13 DEBUG : potato2: Need to transfer - File not found at Destination 2026/02/26 03:47:13 DEBUG : potato3: Need to transfer - File not found at Destination 2026/02/26 03:47:13 DEBUG : NetStorage API GET call version=1&action=download for path "/1210146/rclone-test-junexus9quwu/potato2" 2026/02/26 03:47:13 DEBUG : https://rclone-nsu.akamaihd.net/1210146/rclone-test-zezatah3wozu/: Waiting for checks to finish 2026/02/26 03:47:13 DEBUG : https://rclone-nsu.akamaihd.net/1210146/rclone-test-zezatah3wozu/: Waiting for transfers to finish 2026/02/26 03:47:13 DEBUG : NetStorage API GET call version=1&action=download for path "/1210146/rclone-test-junexus9quwu/empty%20space" 2026/02/26 03:47:13 DEBUG : NetStorage API GET call version=1&action=download for path "/1210146/rclone-test-junexus9quwu/potato3" 2026/02/26 03:47:14 INFO : Implicitly create directory https://rclone-nsu.akamaihd.net/1210146/rclone-test-zezatah3wozu/ 2026/02/26 03:47:14 DEBUG : NetStorage API POST call version=1&action=mkdir for path "/1210146/rclone-test-zezatah3wozu/" 2026/02/26 03:47:14 DEBUG : NetStorage API PUT call version=1&action=upload&sha256=atend&mtime=atend for path "/1210146/rclone-test-zezatah3wozu/potato2" 2026/02/26 03:47:14 DEBUG : NetStorage API PUT call version=1&action=upload&sha256=atend&mtime=atend for path "/1210146/rclone-test-zezatah3wozu/potato3" 2026/02/26 03:47:14 DEBUG : NetStorage API PUT call version=1&action=upload&sha256=atend&mtime=atend for path "/1210146/rclone-test-zezatah3wozu/empty%20space" 2026/02/26 03:47:14 DEBUG : NetStorage action upload failed for "https://rclone-nsu.akamaihd.net/1210146/rclone-test-zezatah3wozu/potato2": HTTP error 400 (400 Bad Request) returned body: "XAAA invalid\n" 2026/02/26 03:47:14 DEBUG : NetStorage API POST call version=1&action=delete for path "/1210146/rclone-test-zezatah3wozu/potato2" 2026/02/26 03:47:14 DEBUG : NetStorage action delete failed for "https://rclone-nsu.akamaihd.net/1210146/rclone-test-zezatah3wozu/potato2": object not found 2026/02/26 03:47:14 ERROR : potato2: Failed to copy: failed to call NetStorage API upload: HTTP error 400 (400 Bad Request) returned body: "XAAA invalid\n" 2026/02/26 03:47:14 ERROR : potato2: Not deleting source as copy failed: failed to call NetStorage API upload: HTTP error 400 (400 Bad Request) returned body: "XAAA invalid\n" 2026/02/26 03:47:14 DEBUG : potato3: size = 68 OK 2026/02/26 03:47:14 DEBUG : potato3: Dst hash empty - aborting Src hash check 2026/02/26 03:47:14 INFO : potato3: Copied (new) 2026/02/26 03:47:14 DEBUG : NetStorage API POST call version=1&action=delete for path "/1210146/rclone-test-junexus9quwu/potato3" 2026/02/26 03:47:14 DEBUG : empty space: size = 1 OK 2026/02/26 03:47:14 DEBUG : empty space: Dst hash empty - aborting Src hash check 2026/02/26 03:47:14 INFO : empty space: Copied (new) 2026/02/26 03:47:14 DEBUG : NetStorage API POST call version=1&action=delete for path "/1210146/rclone-test-junexus9quwu/empty%20space" 2026/02/26 03:47:14 INFO : empty space: Deleted 2026/02/26 03:47:14 INFO : potato3: Deleted sync_test.go:1776: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1776 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1912 Error: Received unexpected error: failed to call NetStorage API upload: HTTP error 400 (400 Bad Request) returned body: "XAAA invalid\n" Test: TestServerSideMove 2026/02/26 03:47:14 DEBUG : https://rclone-nsu.akamaihd.net/1210146/rclone-test-zezatah3wozu/: Purge remote 2026/02/26 03:47:14 DEBUG : NetStorage API POST call version=1&action=quick-delete&quick-delete=imreallyreallysure for path "/1210146/rclone-test-zezatah3wozu/" 2026/02/26 03:47:15 NOTICE: Purge using quick-delete failed, fallback on recursive delete: failed to call NetStorage API: HTTP error 403 (403 Forbidden) returned body: "Feature not enabled for this request.\n" 2026/02/26 03:47:15 DEBUG : NetStorage API GET call version=1&action=stat&implicit=yes&format=xml&encoding=utf-8&slash=both for path "/1210146/rclone-test-zezatah3wozu" 2026/02/26 03:47:15 DEBUG : NetStorage API GET call version=1&action=list&mtime_all=yes&format=xml&encoding=utf-8&end=%2F1210146%2Frclone-test-zezatah3wozu0 for path "/1210146/rclone-test-zezatah3wozu/" 2026/02/26 03:47:15 DEBUG : https://rclone-nsu.akamaihd.net/1210146/rclone-test-zezatah3wozu/: Purge object "empty space" 2026/02/26 03:47:15 DEBUG : NetStorage API POST call version=1&action=delete for path "/1210146/rclone-test-zezatah3wozu/empty%20space" 2026/02/26 03:47:15 DEBUG : https://rclone-nsu.akamaihd.net/1210146/rclone-test-zezatah3wozu/: Purge object "potato3" 2026/02/26 03:47:15 DEBUG : NetStorage API POST call version=1&action=delete for path "/1210146/rclone-test-zezatah3wozu/potato3" 2026/02/26 03:47:16 DEBUG : https://rclone-nsu.akamaihd.net/1210146/rclone-test-zezatah3wozu/: Purge dir "" 2026/02/26 03:47:16 DEBUG : NetStorage API POST call version=1&action=rmdir for path "/1210146/rclone-test-zezatah3wozu/" 2026/02/26 03:47:16 DEBUG : https://rclone-nsu.akamaihd.net/1210146/rclone-test-junexus9quwu/: Purge remote 2026/02/26 03:47:16 DEBUG : NetStorage API POST call version=1&action=quick-delete&quick-delete=imreallyreallysure for path "/1210146/rclone-test-junexus9quwu/" 2026/02/26 03:47:16 NOTICE: Purge using quick-delete failed, fallback on recursive delete: failed to call NetStorage API: HTTP error 403 (403 Forbidden) returned body: "Feature not enabled for this request.\n" 2026/02/26 03:47:16 DEBUG : NetStorage API GET call version=1&action=list&mtime_all=yes&format=xml&encoding=utf-8&end=%2F1210146%2Frclone-test-junexus9quwu0 for path "/1210146/rclone-test-junexus9quwu/" 2026/02/26 03:47:16 DEBUG : https://rclone-nsu.akamaihd.net/1210146/rclone-test-junexus9quwu/: Purge object "potato2" 2026/02/26 03:47:16 DEBUG : NetStorage API POST call version=1&action=delete for path "/1210146/rclone-test-junexus9quwu/potato2" 2026/02/26 03:47:16 DEBUG : https://rclone-nsu.akamaihd.net/1210146/rclone-test-junexus9quwu/: Purge dir "" 2026/02/26 03:47:16 DEBUG : NetStorage API POST call version=1&action=rmdir for path "/1210146/rclone-test-junexus9quwu/" 2026/02/26 03:47:16 DEBUG : NetStorage API GET call version=1&action=list&mtime_all=yes&format=xml&encoding=utf-8&end=%2F1210146%2Frclone-test-cemuyan3xipa0 for path "/1210146/rclone-test-cemuyan3xipa/" 2026/02/26 03:47:16 DEBUG : NetStorage API GET call version=1&action=list&mtime_all=yes&format=xml&encoding=utf-8&end=%2F1210146%2Frclone-test-cemuyan3xipa0 for path "/1210146/rclone-test-cemuyan3xipa/" --- FAIL: TestServerSideMove (6.67s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:185: Remote "https://rclone-nsu.akamaihd.net/1210146/rclone-test-cemuyan3xipa/", Local "Local file system at /tmp/rclone3602475770", Modify Window "1s" 2026/02/26 03:47:16 DEBUG : Creating backend with remote "TestnStorage:rclone-test-gisoquq8nadi" 2026/02/26 03:47:16 DEBUG : NetStorage NewFS endpoint "https://rclone-nsu.akamaihd.net/1210146/" 2026/02/26 03:47:16 DEBUG : NetStorage API GET call version=1&action=stat&implicit=yes&format=xml&encoding=utf-8&slash=both for path "/1210146/rclone-test-gisoquq8nadi" 2026/02/26 03:47:17 DEBUG : NetStorage action stat failed for "https://rclone-nsu.akamaihd.net/1210146/rclone-test-gisoquq8nadi": object not found 2026/02/26 03:47:17 DEBUG : NetStorage API PUT call version=1&action=upload&sha256=atend&mtime=atend for path "/1210146/rclone-test-cemuyan3xipa/potato2" 2026/02/26 03:47:17 DEBUG : NetStorage API PUT call version=1&action=upload&sha256=atend&mtime=atend for path "/1210146/rclone-test-cemuyan3xipa/empty%20space" 2026/02/26 03:47:17 DEBUG : NetStorage API PUT call version=1&action=upload&sha256=atend&mtime=atend for path "/1210146/rclone-test-cemuyan3xipa/potato3" 2026/02/26 03:47:18 INFO : tomatoDir: Making directory 2026/02/26 03:47:18 INFO : Implicitly create directory https://rclone-nsu.akamaihd.net/1210146/rclone-test-cemuyan3xipa/tomatoDir/ 2026/02/26 03:47:18 DEBUG : NetStorage API POST call version=1&action=mkdir for path "/1210146/rclone-test-cemuyan3xipa/tomatoDir/" 2026/02/26 03:47:18 DEBUG : NetStorage API GET call version=1&action=list&mtime_all=yes&format=xml&encoding=utf-8&end=%2F1210146%2Frclone-test-cemuyan3xipa0 for path "/1210146/rclone-test-cemuyan3xipa/" sync_test.go:1736: Server side move (if possible) https://rclone-nsu.akamaihd.net/1210146/rclone-test-cemuyan3xipa/ -> https://rclone-nsu.akamaihd.net/1210146/rclone-test-gisoquq8nadi/ 2026/02/26 03:47:18 INFO : Implicitly create directory https://rclone-nsu.akamaihd.net/1210146/rclone-test-gisoquq8nadi/ 2026/02/26 03:47:18 DEBUG : NetStorage API POST call version=1&action=mkdir for path "/1210146/rclone-test-gisoquq8nadi/" 2026/02/26 03:47:18 DEBUG : NetStorage API PUT call version=1&action=upload&sha256=atend&mtime=atend for path "/1210146/rclone-test-gisoquq8nadi/empty%20space" 2026/02/26 03:47:18 DEBUG : NetStorage API PUT call version=1&action=upload&sha256=atend&mtime=atend for path "/1210146/rclone-test-gisoquq8nadi/potato3" 2026/02/26 03:47:18 DEBUG : NetStorage API GET call version=1&action=stat&implicit=yes&format=xml&encoding=utf-8&slash=both for path "/1210146/rclone-test-gisoquq8nadi" 2026/02/26 03:47:18 DEBUG : NetStorage API GET call version=1&action=list&mtime_all=yes&format=xml&encoding=utf-8&end=%2F1210146%2Frclone-test-gisoquq8nadi0 for path "/1210146/rclone-test-gisoquq8nadi/" 2026/02/26 03:47:18 DEBUG : NetStorage API GET call version=1&action=list&mtime_all=yes&format=xml&encoding=utf-8&end=%2F1210146%2Frclone-test-gisoquq8nadi0 for path "/1210146/rclone-test-gisoquq8nadi/" 2026/02/26 03:47:18 DEBUG : NetStorage API GET call version=1&action=list&mtime_all=yes&format=xml&encoding=utf-8&end=%2F1210146%2Frclone-test-cemuyan3xipa0 for path "/1210146/rclone-test-cemuyan3xipa/" 2026/02/26 03:47:19 DEBUG : potato2: Need to transfer - File not found at Destination 2026/02/26 03:47:19 DEBUG : empty space: size = 1 OK 2026/02/26 03:47:19 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2026/02/26 03:47:19 DEBUG : empty space: Unchanged skipping 2026/02/26 03:47:19 DEBUG : NetStorage API POST call version=1&action=delete for path "/1210146/rclone-test-cemuyan3xipa/empty%20space" 2026/02/26 03:47:19 DEBUG : potato3: size = 68 (https://rclone-nsu.akamaihd.net/1210146/rclone-test-cemuyan3xipa/) 2026/02/26 03:47:19 DEBUG : potato3: size = 60 (https://rclone-nsu.akamaihd.net/1210146/rclone-test-gisoquq8nadi/) 2026/02/26 03:47:19 DEBUG : potato3: Sizes differ 2026/02/26 03:47:19 DEBUG : https://rclone-nsu.akamaihd.net/1210146/rclone-test-gisoquq8nadi/: Waiting for checks to finish 2026/02/26 03:47:19 DEBUG : NetStorage API GET call version=1&action=download for path "/1210146/rclone-test-cemuyan3xipa/potato3" 2026/02/26 03:47:19 DEBUG : NetStorage API GET call version=1&action=download for path "/1210146/rclone-test-cemuyan3xipa/potato2" 2026/02/26 03:47:19 DEBUG : NetStorage API PUT call version=1&action=upload&sha256=atend&mtime=atend for path "/1210146/rclone-test-gisoquq8nadi/potato3" 2026/02/26 03:47:19 INFO : empty space: Deleted 2026/02/26 03:47:19 DEBUG : https://rclone-nsu.akamaihd.net/1210146/rclone-test-gisoquq8nadi/: Waiting for transfers to finish 2026/02/26 03:47:19 DEBUG : NetStorage API PUT call version=1&action=upload&sha256=atend&mtime=atend for path "/1210146/rclone-test-gisoquq8nadi/potato2" 2026/02/26 03:47:19 DEBUG : potato3: size = 68 OK 2026/02/26 03:47:19 DEBUG : potato3: Dst hash empty - aborting Src hash check 2026/02/26 03:47:19 INFO : potato3: Copied (replaced existing) 2026/02/26 03:47:19 DEBUG : NetStorage API POST call version=1&action=delete for path "/1210146/rclone-test-cemuyan3xipa/potato3" 2026/02/26 03:47:19 INFO : potato3: Deleted 2026/02/26 03:47:19 DEBUG : NetStorage action upload failed for "https://rclone-nsu.akamaihd.net/1210146/rclone-test-gisoquq8nadi/potato2": HTTP error 400 (400 Bad Request) returned body: "XAAA invalid\n" 2026/02/26 03:47:19 DEBUG : NetStorage API POST call version=1&action=delete for path "/1210146/rclone-test-gisoquq8nadi/potato2" 2026/02/26 03:47:19 DEBUG : NetStorage action delete failed for "https://rclone-nsu.akamaihd.net/1210146/rclone-test-gisoquq8nadi/potato2": object not found 2026/02/26 03:47:19 ERROR : potato2: Failed to copy: failed to call NetStorage API upload: HTTP error 400 (400 Bad Request) returned body: "XAAA invalid\n" 2026/02/26 03:47:19 ERROR : potato2: Not deleting source as copy failed: failed to call NetStorage API upload: HTTP error 400 (400 Bad Request) returned body: "XAAA invalid\n" 2026/02/26 03:47:19 ERROR : https://rclone-nsu.akamaihd.net/1210146/rclone-test-cemuyan3xipa/: not deleting directories as there were IO errors sync_test.go:1747: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1747 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1932 Error: Received unexpected error: not deleting directories as there were IO errors Test: TestServerSideMoveDeleteEmptySourceDirs 2026/02/26 03:47:19 DEBUG : https://rclone-nsu.akamaihd.net/1210146/rclone-test-gisoquq8nadi/: Purge remote 2026/02/26 03:47:19 DEBUG : NetStorage API POST call version=1&action=quick-delete&quick-delete=imreallyreallysure for path "/1210146/rclone-test-gisoquq8nadi/" 2026/02/26 03:47:19 NOTICE: Purge using quick-delete failed, fallback on recursive delete: failed to call NetStorage API: HTTP error 403 (403 Forbidden) returned body: "Feature not enabled for this request.\n" 2026/02/26 03:47:19 DEBUG : NetStorage API GET call version=1&action=list&mtime_all=yes&format=xml&encoding=utf-8&end=%2F1210146%2Frclone-test-gisoquq8nadi0 for path "/1210146/rclone-test-gisoquq8nadi/" 2026/02/26 03:47:20 DEBUG : https://rclone-nsu.akamaihd.net/1210146/rclone-test-gisoquq8nadi/: Purge object "empty space" 2026/02/26 03:47:20 DEBUG : NetStorage API POST call version=1&action=delete for path "/1210146/rclone-test-gisoquq8nadi/empty%20space" 2026/02/26 03:47:20 DEBUG : https://rclone-nsu.akamaihd.net/1210146/rclone-test-gisoquq8nadi/: Purge object "potato3" 2026/02/26 03:47:20 DEBUG : NetStorage API POST call version=1&action=delete for path "/1210146/rclone-test-gisoquq8nadi/potato3" 2026/02/26 03:47:20 DEBUG : https://rclone-nsu.akamaihd.net/1210146/rclone-test-gisoquq8nadi/: Purge dir "" 2026/02/26 03:47:20 DEBUG : NetStorage API POST call version=1&action=rmdir for path "/1210146/rclone-test-gisoquq8nadi/" 2026/02/26 03:47:20 DEBUG : NetStorage API GET call version=1&action=list&mtime_all=yes&format=xml&encoding=utf-8&end=%2F1210146%2Frclone-test-cemuyan3xipa0 for path "/1210146/rclone-test-cemuyan3xipa/" 2026/02/26 03:47:20 DEBUG : NetStorage API POST call version=1&action=delete for path "/1210146/rclone-test-cemuyan3xipa/potato2" 2026/02/26 03:47:20 DEBUG : NetStorage API POST call version=1&action=rmdir for path "/1210146/rclone-test-cemuyan3xipa/tomatoDir" 2026/02/26 03:47:20 DEBUG : NetStorage API GET call version=1&action=list&mtime_all=yes&format=xml&encoding=utf-8&end=%2F1210146%2Frclone-test-cemuyan3xipa0 for path "/1210146/rclone-test-cemuyan3xipa/" --- FAIL: TestServerSideMoveDeleteEmptySourceDirs (4.02s) === RUN TestSyncCompareDest run.go:185: Remote "https://rclone-nsu.akamaihd.net/1210146/rclone-test-cemuyan3xipa/", Local "Local file system at /tmp/rclone3602475770", Modify Window "1s" 2026/02/26 03:47:20 DEBUG : Creating backend with remote "TestnStorage:rclone-test-cemuyan3xipa/dst" 2026/02/26 03:47:20 DEBUG : NetStorage NewFS endpoint "https://rclone-nsu.akamaihd.net/1210146/" 2026/02/26 03:47:20 DEBUG : NetStorage API GET call version=1&action=stat&implicit=yes&format=xml&encoding=utf-8&slash=both for path "/1210146/rclone-test-cemuyan3xipa/dst" 2026/02/26 03:47:21 DEBUG : NetStorage action stat failed for "https://rclone-nsu.akamaihd.net/1210146/rclone-test-cemuyan3xipa/dst": object not found 2026/02/26 03:47:21 DEBUG : Creating backend with remote "TestnStorage:rclone-test-cemuyan3xipa/CompareDest" 2026/02/26 03:47:21 DEBUG : NetStorage NewFS endpoint "https://rclone-nsu.akamaihd.net/1210146/" 2026/02/26 03:47:21 DEBUG : NetStorage API GET call version=1&action=stat&implicit=yes&format=xml&encoding=utf-8&slash=both for path "/1210146/rclone-test-cemuyan3xipa/CompareDest" 2026/02/26 03:47:21 DEBUG : NetStorage action stat failed for "https://rclone-nsu.akamaihd.net/1210146/rclone-test-cemuyan3xipa/CompareDest": object not found 2026/02/26 03:47:21 DEBUG : NetStorage API GET call version=1&action=stat&implicit=yes&format=xml&encoding=utf-8&slash=both for path "/1210146/rclone-test-cemuyan3xipa/dst" 2026/02/26 03:47:21 DEBUG : NetStorage action stat failed for "https://rclone-nsu.akamaihd.net/1210146/rclone-test-cemuyan3xipa/dst": object not found 2026/02/26 03:47:21 DEBUG : NetStorage API GET call version=1&action=stat&implicit=yes&format=xml&encoding=utf-8&slash=both for path "/1210146/rclone-test-cemuyan3xipa/CompareDest/one" 2026/02/26 03:47:21 DEBUG : NetStorage action stat failed for "https://rclone-nsu.akamaihd.net/1210146/rclone-test-cemuyan3xipa/CompareDest/one": object not found 2026/02/26 03:47:21 DEBUG : one: Need to transfer - File not found at Destination 2026/02/26 03:47:21 DEBUG : https://rclone-nsu.akamaihd.net/1210146/rclone-test-cemuyan3xipa/dst/: Waiting for checks to finish 2026/02/26 03:47:21 DEBUG : https://rclone-nsu.akamaihd.net/1210146/rclone-test-cemuyan3xipa/dst/: Waiting for transfers to finish 2026/02/26 03:47:21 INFO : Implicitly create directory https://rclone-nsu.akamaihd.net/1210146/rclone-test-cemuyan3xipa/ 2026/02/26 03:47:21 DEBUG : NetStorage API POST call version=1&action=mkdir for path "/1210146/rclone-test-cemuyan3xipa/" 2026/02/26 03:47:21 INFO : Implicitly create directory https://rclone-nsu.akamaihd.net/1210146/rclone-test-cemuyan3xipa/dst/ 2026/02/26 03:47:21 DEBUG : NetStorage API POST call version=1&action=mkdir for path "/1210146/rclone-test-cemuyan3xipa/dst/" 2026/02/26 03:47:21 DEBUG : NetStorage API PUT call version=1&action=upload&sha256=atend&mtime=atend for path "/1210146/rclone-test-cemuyan3xipa/dst/one" 2026/02/26 03:47:21 DEBUG : one: size = 3 OK 2026/02/26 03:47:21 DEBUG : one: Dst hash empty - aborting Src hash check 2026/02/26 03:47:21 INFO : one: Copied (new) 2026/02/26 03:47:21 DEBUG : Waiting for deletions to finish 2026/02/26 03:47:21 DEBUG : NetStorage API GET call version=1&action=list&mtime_all=yes&format=xml&encoding=utf-8&end=%2F1210146%2Frclone-test-cemuyan3xipa0 for path "/1210146/rclone-test-cemuyan3xipa/" 2026/02/26 03:47:21 DEBUG : NetStorage API GET call version=1&action=list&mtime_all=yes&format=xml&encoding=utf-8&end=%2F1210146%2Frclone-test-cemuyan3xipa0 for path "/1210146/rclone-test-cemuyan3xipa/" 2026/02/26 03:47:21 DEBUG : NetStorage API GET call version=1&action=stat&implicit=yes&format=xml&encoding=utf-8&slash=both for path "/1210146/rclone-test-cemuyan3xipa/dst" 2026/02/26 03:47:22 DEBUG : NetStorage API GET call version=1&action=list&mtime_all=yes&format=xml&encoding=utf-8&end=%2F1210146%2Frclone-test-cemuyan3xipa%2Fdst0 for path "/1210146/rclone-test-cemuyan3xipa/dst/" 2026/02/26 03:47:22 DEBUG : one: size = 5 (Local file system at /tmp/rclone3602475770) 2026/02/26 03:47:22 DEBUG : one: size = 3 (https://rclone-nsu.akamaihd.net/1210146/rclone-test-cemuyan3xipa/dst/) 2026/02/26 03:47:22 DEBUG : one: Sizes differ 2026/02/26 03:47:22 DEBUG : https://rclone-nsu.akamaihd.net/1210146/rclone-test-cemuyan3xipa/dst/: Waiting for checks to finish 2026/02/26 03:47:22 DEBUG : NetStorage API GET call version=1&action=stat&implicit=yes&format=xml&encoding=utf-8&slash=both for path "/1210146/rclone-test-cemuyan3xipa/CompareDest/one" 2026/02/26 03:47:22 DEBUG : NetStorage action stat failed for "https://rclone-nsu.akamaihd.net/1210146/rclone-test-cemuyan3xipa/CompareDest/one": object not found 2026/02/26 03:47:22 DEBUG : https://rclone-nsu.akamaihd.net/1210146/rclone-test-cemuyan3xipa/dst/: Waiting for transfers to finish 2026/02/26 03:47:22 DEBUG : NetStorage API PUT call version=1&action=upload&sha256=atend&mtime=atend for path "/1210146/rclone-test-cemuyan3xipa/dst/one" 2026/02/26 03:47:22 DEBUG : one: size = 5 OK 2026/02/26 03:47:22 DEBUG : one: Dst hash empty - aborting Src hash check 2026/02/26 03:47:22 INFO : one: Copied (replaced existing) 2026/02/26 03:47:22 DEBUG : Waiting for deletions to finish 2026/02/26 03:47:22 DEBUG : NetStorage API GET call version=1&action=list&mtime_all=yes&format=xml&encoding=utf-8&end=%2F1210146%2Frclone-test-cemuyan3xipa0 for path "/1210146/rclone-test-cemuyan3xipa/" 2026/02/26 03:47:22 INFO : Implicitly create directory https://rclone-nsu.akamaihd.net/1210146/rclone-test-cemuyan3xipa/dst/ 2026/02/26 03:47:22 DEBUG : NetStorage API POST call version=1&action=mkdir for path "/1210146/rclone-test-cemuyan3xipa/dst/" 2026/02/26 03:47:22 DEBUG : NetStorage API PUT call version=1&action=upload&sha256=atend&mtime=atend for path "/1210146/rclone-test-cemuyan3xipa/dst/one" 2026/02/26 03:47:22 INFO : Implicitly create directory https://rclone-nsu.akamaihd.net/1210146/rclone-test-cemuyan3xipa/CompareDest/ 2026/02/26 03:47:22 DEBUG : NetStorage API POST call version=1&action=mkdir for path "/1210146/rclone-test-cemuyan3xipa/CompareDest/" 2026/02/26 03:47:22 DEBUG : NetStorage API PUT call version=1&action=upload&sha256=atend&mtime=atend for path "/1210146/rclone-test-cemuyan3xipa/CompareDest/one" 2026/02/26 03:47:22 DEBUG : NetStorage API GET call version=1&action=list&mtime_all=yes&format=xml&encoding=utf-8&end=%2F1210146%2Frclone-test-cemuyan3xipa0 for path "/1210146/rclone-test-cemuyan3xipa/" 2026/02/26 03:47:23 DEBUG : NetStorage API GET call version=1&action=list&mtime_all=yes&format=xml&encoding=utf-8&end=%2F1210146%2Frclone-test-cemuyan3xipa%2Fdst0 for path "/1210146/rclone-test-cemuyan3xipa/dst/" 2026/02/26 03:47:23 DEBUG : one: size = 5 (Local file system at /tmp/rclone3602475770) 2026/02/26 03:47:23 DEBUG : one: size = 3 (https://rclone-nsu.akamaihd.net/1210146/rclone-test-cemuyan3xipa/dst/) 2026/02/26 03:47:23 DEBUG : one: Sizes differ 2026/02/26 03:47:23 DEBUG : https://rclone-nsu.akamaihd.net/1210146/rclone-test-cemuyan3xipa/dst/: Waiting for checks to finish 2026/02/26 03:47:23 DEBUG : NetStorage API GET call version=1&action=stat&implicit=yes&format=xml&encoding=utf-8&slash=both for path "/1210146/rclone-test-cemuyan3xipa/CompareDest/one" 2026/02/26 03:47:23 DEBUG : one: size = 5 OK 2026/02/26 03:47:23 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2026/02/26 03:47:23 DEBUG : one: Destination found in --compare-dest, skipping 2026/02/26 03:47:23 DEBUG : https://rclone-nsu.akamaihd.net/1210146/rclone-test-cemuyan3xipa/dst/: Waiting for transfers to finish 2026/02/26 03:47:23 DEBUG : Waiting for deletions to finish 2026/02/26 03:47:23 INFO : There was nothing to transfer 2026/02/26 03:47:23 DEBUG : NetStorage API GET call version=1&action=list&mtime_all=yes&format=xml&encoding=utf-8&end=%2F1210146%2Frclone-test-cemuyan3xipa0 for path "/1210146/rclone-test-cemuyan3xipa/" 2026/02/26 03:47:23 DEBUG : NetStorage API PUT call version=1&action=upload&sha256=atend&mtime=atend for path "/1210146/rclone-test-cemuyan3xipa/CompareDest/two" 2026/02/26 03:47:23 DEBUG : NetStorage API GET call version=1&action=list&mtime_all=yes&format=xml&encoding=utf-8&end=%2F1210146%2Frclone-test-cemuyan3xipa0 for path "/1210146/rclone-test-cemuyan3xipa/" 2026/02/26 03:47:23 DEBUG : NetStorage API GET call version=1&action=list&mtime_all=yes&format=xml&encoding=utf-8&end=%2F1210146%2Frclone-test-cemuyan3xipa%2Fdst0 for path "/1210146/rclone-test-cemuyan3xipa/dst/" 2026/02/26 03:47:23 DEBUG : NetStorage API GET call version=1&action=stat&implicit=yes&format=xml&encoding=utf-8&slash=both for path "/1210146/rclone-test-cemuyan3xipa/CompareDest/two" 2026/02/26 03:47:23 DEBUG : one: size = 5 (Local file system at /tmp/rclone3602475770) 2026/02/26 03:47:23 DEBUG : one: size = 3 (https://rclone-nsu.akamaihd.net/1210146/rclone-test-cemuyan3xipa/dst/) 2026/02/26 03:47:23 DEBUG : one: Sizes differ 2026/02/26 03:47:23 DEBUG : NetStorage stat cache hit for "https://rclone-nsu.akamaihd.net/1210146/rclone-test-cemuyan3xipa/CompareDest/one" 2026/02/26 03:47:23 DEBUG : one: size = 5 OK 2026/02/26 03:47:23 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2026/02/26 03:47:23 DEBUG : one: Destination found in --compare-dest, skipping 2026/02/26 03:47:23 DEBUG : two: size = 3 OK 2026/02/26 03:47:23 DEBUG : two: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2026/02/26 03:47:23 DEBUG : two: Destination found in --compare-dest, skipping 2026/02/26 03:47:23 DEBUG : https://rclone-nsu.akamaihd.net/1210146/rclone-test-cemuyan3xipa/dst/: Waiting for checks to finish 2026/02/26 03:47:23 DEBUG : https://rclone-nsu.akamaihd.net/1210146/rclone-test-cemuyan3xipa/dst/: Waiting for transfers to finish 2026/02/26 03:47:23 DEBUG : Waiting for deletions to finish 2026/02/26 03:47:23 INFO : There was nothing to transfer 2026/02/26 03:47:23 DEBUG : NetStorage API GET call version=1&action=list&mtime_all=yes&format=xml&encoding=utf-8&end=%2F1210146%2Frclone-test-cemuyan3xipa0 for path "/1210146/rclone-test-cemuyan3xipa/" 2026/02/26 03:47:24 DEBUG : NetStorage API GET call version=1&action=list&mtime_all=yes&format=xml&encoding=utf-8&end=%2F1210146%2Frclone-test-cemuyan3xipa%2Fdst0 for path "/1210146/rclone-test-cemuyan3xipa/dst/" 2026/02/26 03:47:24 DEBUG : NetStorage stat cache hit for "https://rclone-nsu.akamaihd.net/1210146/rclone-test-cemuyan3xipa/CompareDest/two" 2026/02/26 03:47:24 DEBUG : two: size = 3 OK 2026/02/26 03:47:24 DEBUG : two: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2026/02/26 03:47:24 DEBUG : two: Destination found in --compare-dest, skipping 2026/02/26 03:47:24 DEBUG : https://rclone-nsu.akamaihd.net/1210146/rclone-test-cemuyan3xipa/dst/: Waiting for checks to finish 2026/02/26 03:47:24 DEBUG : one: size = 5 (Local file system at /tmp/rclone3602475770) 2026/02/26 03:47:24 DEBUG : one: size = 3 (https://rclone-nsu.akamaihd.net/1210146/rclone-test-cemuyan3xipa/dst/) 2026/02/26 03:47:24 DEBUG : one: Sizes differ 2026/02/26 03:47:24 DEBUG : NetStorage stat cache hit for "https://rclone-nsu.akamaihd.net/1210146/rclone-test-cemuyan3xipa/CompareDest/one" 2026/02/26 03:47:24 DEBUG : one: size = 5 OK 2026/02/26 03:47:24 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2026/02/26 03:47:24 DEBUG : one: Destination found in --compare-dest, skipping 2026/02/26 03:47:24 DEBUG : https://rclone-nsu.akamaihd.net/1210146/rclone-test-cemuyan3xipa/dst/: Waiting for transfers to finish 2026/02/26 03:47:24 DEBUG : Waiting for deletions to finish 2026/02/26 03:47:24 INFO : There was nothing to transfer 2026/02/26 03:47:24 DEBUG : NetStorage API GET call version=1&action=list&mtime_all=yes&format=xml&encoding=utf-8&end=%2F1210146%2Frclone-test-cemuyan3xipa0 for path "/1210146/rclone-test-cemuyan3xipa/" 2026/02/26 03:47:24 DEBUG : NetStorage API GET call version=1&action=stat&implicit=yes&format=xml&encoding=utf-8&slash=both for path "/1210146/rclone-test-cemuyan3xipa/dst/one" 2026/02/26 03:47:24 DEBUG : NetStorage API GET call version=1&action=list&mtime_all=yes&format=xml&encoding=utf-8&end=%2F1210146%2Frclone-test-cemuyan3xipa%2Fdst0 for path "/1210146/rclone-test-cemuyan3xipa/dst/" 2026/02/26 03:47:24 DEBUG : NetStorage stat cache hit for "https://rclone-nsu.akamaihd.net/1210146/rclone-test-cemuyan3xipa/CompareDest/two" 2026/02/26 03:47:24 DEBUG : two: size = 3 OK 2026/02/26 03:47:24 DEBUG : two: Modification times differ by -120h0m0s: 2011-12-30 12:59:59 +0000 UTC, 2011-12-25 12:59:59 +0000 UTC 2026/02/26 03:47:24 DEBUG : one: size = 5 (Local file system at /tmp/rclone3602475770) 2026/02/26 03:47:24 DEBUG : one: size = 3 (https://rclone-nsu.akamaihd.net/1210146/rclone-test-cemuyan3xipa/dst/) 2026/02/26 03:47:24 DEBUG : one: Sizes differ 2026/02/26 03:47:24 DEBUG : NetStorage stat cache hit for "https://rclone-nsu.akamaihd.net/1210146/rclone-test-cemuyan3xipa/CompareDest/one" 2026/02/26 03:47:24 DEBUG : one: size = 5 OK 2026/02/26 03:47:24 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2026/02/26 03:47:24 DEBUG : one: Destination found in --compare-dest, skipping 2026/02/26 03:47:24 DEBUG : two: md5 = b8a9f715dbb64fd5c56e7783c6820a61 OK 2026/02/26 03:47:24 DEBUG : two: Destination found in --compare-dest, skipping 2026/02/26 03:47:24 DEBUG : https://rclone-nsu.akamaihd.net/1210146/rclone-test-cemuyan3xipa/dst/: Waiting for checks to finish 2026/02/26 03:47:24 DEBUG : https://rclone-nsu.akamaihd.net/1210146/rclone-test-cemuyan3xipa/dst/: Waiting for transfers to finish 2026/02/26 03:47:24 DEBUG : Waiting for deletions to finish 2026/02/26 03:47:24 INFO : There was nothing to transfer 2026/02/26 03:47:24 DEBUG : NetStorage API GET call version=1&action=list&mtime_all=yes&format=xml&encoding=utf-8&end=%2F1210146%2Frclone-test-cemuyan3xipa0 for path "/1210146/rclone-test-cemuyan3xipa/" 2026/02/26 03:47:24 DEBUG : NetStorage API GET call version=1&action=list&mtime_all=yes&format=xml&encoding=utf-8&end=%2F1210146%2Frclone-test-cemuyan3xipa0 for path "/1210146/rclone-test-cemuyan3xipa/" 2026/02/26 03:47:24 DEBUG : NetStorage API GET call version=1&action=list&mtime_all=yes&format=xml&encoding=utf-8&end=%2F1210146%2Frclone-test-cemuyan3xipa%2Fdst0 for path "/1210146/rclone-test-cemuyan3xipa/dst/" 2026/02/26 03:47:24 DEBUG : NetStorage stat cache hit for "https://rclone-nsu.akamaihd.net/1210146/rclone-test-cemuyan3xipa/CompareDest/two" 2026/02/26 03:47:24 DEBUG : two: size = 5 (Local file system at /tmp/rclone3602475770) 2026/02/26 03:47:24 DEBUG : two: size = 3 (https://rclone-nsu.akamaihd.net/1210146/rclone-test-cemuyan3xipa/CompareDest/) 2026/02/26 03:47:24 DEBUG : two: Sizes differ 2026/02/26 03:47:24 DEBUG : two: Need to transfer - File not found at Destination 2026/02/26 03:47:24 DEBUG : one: size = 5 (Local file system at /tmp/rclone3602475770) 2026/02/26 03:47:24 DEBUG : one: size = 3 (https://rclone-nsu.akamaihd.net/1210146/rclone-test-cemuyan3xipa/dst/) 2026/02/26 03:47:24 DEBUG : one: Sizes differ 2026/02/26 03:47:24 DEBUG : NetStorage stat cache hit for "https://rclone-nsu.akamaihd.net/1210146/rclone-test-cemuyan3xipa/CompareDest/one" 2026/02/26 03:47:24 DEBUG : one: size = 5 OK 2026/02/26 03:47:24 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2026/02/26 03:47:24 DEBUG : one: Destination found in --compare-dest, skipping 2026/02/26 03:47:24 DEBUG : https://rclone-nsu.akamaihd.net/1210146/rclone-test-cemuyan3xipa/dst/: Waiting for checks to finish 2026/02/26 03:47:24 DEBUG : https://rclone-nsu.akamaihd.net/1210146/rclone-test-cemuyan3xipa/dst/: Waiting for transfers to finish 2026/02/26 03:47:24 DEBUG : NetStorage API PUT call version=1&action=upload&sha256=atend&mtime=atend for path "/1210146/rclone-test-cemuyan3xipa/dst/two" 2026/02/26 03:47:24 DEBUG : two: size = 5 OK 2026/02/26 03:47:24 DEBUG : two: Dst hash empty - aborting Src hash check 2026/02/26 03:47:24 INFO : two: Copied (new) 2026/02/26 03:47:24 DEBUG : Waiting for deletions to finish 2026/02/26 03:47:24 DEBUG : NetStorage API GET call version=1&action=list&mtime_all=yes&format=xml&encoding=utf-8&end=%2F1210146%2Frclone-test-cemuyan3xipa0 for path "/1210146/rclone-test-cemuyan3xipa/" 2026/02/26 03:47:25 DEBUG : NetStorage API GET call version=1&action=list&mtime_all=yes&format=xml&encoding=utf-8&end=%2F1210146%2Frclone-test-cemuyan3xipa0 for path "/1210146/rclone-test-cemuyan3xipa/" 2026/02/26 03:47:25 DEBUG : NetStorage API POST call version=1&action=delete for path "/1210146/rclone-test-cemuyan3xipa/CompareDest/one" 2026/02/26 03:47:25 DEBUG : NetStorage API POST call version=1&action=delete for path "/1210146/rclone-test-cemuyan3xipa/CompareDest/two" 2026/02/26 03:47:25 DEBUG : NetStorage API POST call version=1&action=delete for path "/1210146/rclone-test-cemuyan3xipa/dst/one" 2026/02/26 03:47:25 DEBUG : NetStorage API POST call version=1&action=delete for path "/1210146/rclone-test-cemuyan3xipa/dst/two" 2026/02/26 03:47:25 DEBUG : NetStorage API POST call version=1&action=rmdir for path "/1210146/rclone-test-cemuyan3xipa/dst" 2026/02/26 03:47:25 DEBUG : NetStorage API POST call version=1&action=rmdir for path "/1210146/rclone-test-cemuyan3xipa/CompareDest" 2026/02/26 03:47:25 DEBUG : NetStorage API GET call version=1&action=list&mtime_all=yes&format=xml&encoding=utf-8&end=%2F1210146%2Frclone-test-cemuyan3xipa0 for path "/1210146/rclone-test-cemuyan3xipa/" --- PASS: TestSyncCompareDest (5.10s) FAIL 2026/02/26 03:47:26 DEBUG : https://rclone-nsu.akamaihd.net/1210146/rclone-test-cemuyan3xipa/: Purge remote 2026/02/26 03:47:26 DEBUG : NetStorage API POST call version=1&action=quick-delete&quick-delete=imreallyreallysure for path "/1210146/rclone-test-cemuyan3xipa/" 2026/02/26 03:47:26 NOTICE: Purge using quick-delete failed, fallback on recursive delete: failed to call NetStorage API: HTTP error 403 (403 Forbidden) returned body: "Feature not enabled for this request.\n" 2026/02/26 03:47:26 DEBUG : NetStorage API GET call version=1&action=list&mtime_all=yes&format=xml&encoding=utf-8&end=%2F1210146%2Frclone-test-cemuyan3xipa0 for path "/1210146/rclone-test-cemuyan3xipa/" 2026/02/26 03:47:26 DEBUG : https://rclone-nsu.akamaihd.net/1210146/rclone-test-cemuyan3xipa/: Purge dir "" 2026/02/26 03:47:26 DEBUG : NetStorage API POST call version=1&action=rmdir for path "/1210146/rclone-test-cemuyan3xipa/" "./sync.test -test.v -test.timeout 1h0m0s -remote TestnStorage: -verbose -fast-list -test.run '^(TestServerSideCopy|TestServerSideMove|TestServerSideMoveDeleteEmptySourceDirs|TestSyncCompareDest)$'" - Finished ERROR in 20.492497101s (try 2/5): exit status 1: Failed [TestServerSideCopy TestServerSideMove TestServerSideMoveDeleteEmptySourceDirs]