"./sync.test -test.v -test.timeout 1h0m0s -remote TestProtonDrive: -verbose -test.run '^(TestBase64|TestManualTransformFile|TestMoveWithDeleteEmptySrcDirs|TestServerSideMove|TestServerSideMoveDeleteEmptySourceDirs|TestServerSideMoveOverSelf|TestServerSideMoveWithFilter|TestSyncBackupDir|TestSyncBackupDirSuffixOnly|TestSyncBackupDirWithSuffix|TestSyncBackupDirWithSuffixKeepExtension|TestSyncSuffix|TestSyncSuffixKeepExtension|TestSyncWithTrackRenames|TestSyncWithTrackRenamesStrategyLeaf|TestSyncWithTrackRenamesStrategyModtime|TestTransformFile)$'" - Starting (try 5/5) 2025/07/27 03:39:09 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-piyixez8vogo" 2025/07/27 03:39:09 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/07/27 03:39:09 DEBUG : proton drive root link ID 'rclone-test-piyixez8vogo': Has cached credentials 2025/07/27 03:39:12 DEBUG : proton drive root link ID 'rclone-test-piyixez8vogo': Used cached credential to initialize the ProtonDrive API 2025/07/27 03:39:13 DEBUG : Creating backend with remote "/tmp/rclone2947627714" === RUN TestServerSideMoveOverSelf run.go:180: Remote "proton drive root link ID 'rclone-test-piyixez8vogo'", Local "Local file system at /tmp/rclone2947627714", Modify Window "1s" 2025/07/27 03:39:18 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-taganib6cuco" 2025/07/27 03:39:18 DEBUG : proton drive root link ID 'rclone-test-taganib6cuco': Has cached credentials 2025/07/27 03:39:20 DEBUG : proton drive root link ID 'rclone-test-taganib6cuco': Used cached credential to initialize the ProtonDrive API sync_test.go:701: Server side copy (if possible) proton drive root link ID 'rclone-test-piyixez8vogo' -> proton drive root link ID 'rclone-test-taganib6cuco' 2025/07/27 03:39:22 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/07/27 03:39:22 DEBUG : proton drive root link ID 'rclone-test-taganib6cuco': Waiting for checks to finish 2025/07/27 03:39:22 DEBUG : proton drive root link ID 'rclone-test-taganib6cuco': Waiting for transfers to finish 2025/07/27 03:39:27 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/07/27 03:39:27 INFO : sub dir/hello world: Copied (new) 2025/07/27 03:39:29.813903 WARN RESTY 422 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files: A file or folder with that name already exists (Code=2500, Status=422), Attempt 1 2025/07/27 03:39:29.814133 ERROR RESTY 422 POST https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files: A file or folder with that name already exists (Code=2500, Status=422) 2025/07/27 03:39:33 DEBUG : proton drive root link ID 'rclone-test-taganib6cuco': Using server-side directory move 2025/07/27 03:39:33 INFO : proton drive root link ID 'rclone-test-taganib6cuco': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/07/27 03:39:34 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/07/27 03:39:34 DEBUG : proton drive root link ID 'rclone-test-taganib6cuco': Waiting for checks to finish 2025/07/27 03:39:34 DEBUG : proton drive root link ID 'rclone-test-taganib6cuco': Waiting for transfers to finish 2025/07/27 03:39:35 INFO : sub dir/hello world: Deleted 2025/07/27 03:39:36.441117 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/9qCp11q-xNQukxPjGsZSPtrDX3EIcmeRcEZFQgD8OlEXXCrCjoC_BNVAJB79uXMAAx0Sv4_pJd_7rmlxMHAAfA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/27 03:39:36.441161 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/9qCp11q-xNQukxPjGsZSPtrDX3EIcmeRcEZFQgD8OlEXXCrCjoC_BNVAJB79uXMAAx0Sv4_pJd_7rmlxMHAAfA==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/27 03:39:36 ERROR : sub dir/hello world: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/9qCp11q-xNQukxPjGsZSPtrDX3EIcmeRcEZFQgD8OlEXXCrCjoC_BNVAJB79uXMAAx0Sv4_pJd_7rmlxMHAAfA==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:714: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:714 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/9qCp11q-xNQukxPjGsZSPtrDX3EIcmeRcEZFQgD8OlEXXCrCjoC_BNVAJB79uXMAAx0Sv4_pJd_7rmlxMHAAfA==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveOverSelf 2025/07/27 03:39:36 DEBUG : proton drive root link ID 'rclone-test-taganib6cuco': Purge remote --- FAIL: TestServerSideMoveOverSelf (26.91s) === RUN TestSyncWithTrackRenames run.go:180: Remote "proton drive root link ID 'rclone-test-piyixez8vogo'", Local "Local file system at /tmp/rclone2947627714", Modify Window "1s" sync_test.go:1568: Can track renames: true 2025/07/27 03:39:40 INFO : proton drive root link ID 'rclone-test-piyixez8vogo': Making map for --track-renames 2025/07/27 03:39:40 INFO : proton drive root link ID 'rclone-test-piyixez8vogo': Finished making map for --track-renames 2025/07/27 03:39:40 DEBUG : proton drive root link ID 'rclone-test-piyixez8vogo': Waiting for checks to finish 2025/07/27 03:39:40 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/07/27 03:39:40 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/07/27 03:39:40 DEBUG : proton drive root link ID 'rclone-test-piyixez8vogo': Waiting for renames to finish 2025/07/27 03:39:40 DEBUG : proton drive root link ID 'rclone-test-piyixez8vogo': Waiting for transfers to finish 2025/07/27 03:39:41 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/07/27 03:39:41 INFO : yam: Copied (new) 2025/07/27 03:39:42 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/07/27 03:39:42 INFO : potato: Copied (new) 2025/07/27 03:39:42 DEBUG : Waiting for deletions to finish 2025/07/27 03:39:44 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/27 03:39:44 INFO : proton drive root link ID 'rclone-test-piyixez8vogo': Making map for --track-renames 2025/07/27 03:39:44 INFO : proton drive root link ID 'rclone-test-piyixez8vogo': Finished making map for --track-renames 2025/07/27 03:39:44 DEBUG : proton drive root link ID 'rclone-test-piyixez8vogo': Waiting for checks to finish 2025/07/27 03:39:44 DEBUG : potato: Unchanged skipping 2025/07/27 03:39:44 DEBUG : proton drive root link ID 'rclone-test-piyixez8vogo': Waiting for renames to finish 2025/07/27 03:39:45.180782 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/0rTnniT_I-SO5tK30L3VGCLpZo3RJt9gj8VK-bYzR6uDixs5_bXh9EANxCJToitPvDnRmThunZC3bx514dJBiQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/27 03:39:45.180818 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/0rTnniT_I-SO5tK30L3VGCLpZo3RJt9gj8VK-bYzR6uDixs5_bXh9EANxCJToitPvDnRmThunZC3bx514dJBiQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/27 03:39:45 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/0rTnniT_I-SO5tK30L3VGCLpZo3RJt9gj8VK-bYzR6uDixs5_bXh9EANxCJToitPvDnRmThunZC3bx514dJBiQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/27 03:39:45 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/0rTnniT_I-SO5tK30L3VGCLpZo3RJt9gj8VK-bYzR6uDixs5_bXh9EANxCJToitPvDnRmThunZC3bx514dJBiQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/27 03:39:45 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/07/27 03:39:45 DEBUG : proton drive root link ID 'rclone-test-piyixez8vogo': Waiting for transfers to finish 2025/07/27 03:39:46 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/07/27 03:39:46 INFO : yaml: Copied (new) 2025/07/27 03:39:46 ERROR : proton drive root link ID 'rclone-test-piyixez8vogo': not deleting files as there were IO errors 2025/07/27 03:39:46 ERROR : proton drive root link ID 'rclone-test-piyixez8vogo': not deleting directories as there were IO errors sync_test.go:1586: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1586 Error: Received unexpected error: not deleting files as there were IO errors Test: TestSyncWithTrackRenames --- FAIL: TestSyncWithTrackRenames (9.73s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:180: Remote "proton drive root link ID 'rclone-test-piyixez8vogo'", Local "Local file system at /tmp/rclone2947627714", Modify Window "1s" sync_test.go:1640: Can track renames: true 2025/07/27 03:39:50 INFO : proton drive root link ID 'rclone-test-piyixez8vogo': Making map for --track-renames 2025/07/27 03:39:50 INFO : proton drive root link ID 'rclone-test-piyixez8vogo': Finished making map for --track-renames 2025/07/27 03:39:50 DEBUG : proton drive root link ID 'rclone-test-piyixez8vogo': Waiting for checks to finish 2025/07/27 03:39:50 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/07/27 03:39:50 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/07/27 03:39:50 DEBUG : proton drive root link ID 'rclone-test-piyixez8vogo': Waiting for renames to finish 2025/07/27 03:39:50 DEBUG : proton drive root link ID 'rclone-test-piyixez8vogo': Waiting for transfers to finish 2025/07/27 03:39:51 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/07/27 03:39:51 INFO : yam: Copied (new) 2025/07/27 03:39:51 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/07/27 03:39:51 INFO : potato: Copied (new) 2025/07/27 03:39:51 DEBUG : Waiting for deletions to finish 2025/07/27 03:39:53 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/27 03:39:53 INFO : proton drive root link ID 'rclone-test-piyixez8vogo': Making map for --track-renames 2025/07/27 03:39:53 INFO : proton drive root link ID 'rclone-test-piyixez8vogo': Finished making map for --track-renames 2025/07/27 03:39:53 DEBUG : proton drive root link ID 'rclone-test-piyixez8vogo': Waiting for checks to finish 2025/07/27 03:39:53 DEBUG : potato: Unchanged skipping 2025/07/27 03:39:53 DEBUG : proton drive root link ID 'rclone-test-piyixez8vogo': Waiting for renames to finish 2025/07/27 03:39:54.891353 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/AWW6Yu0ozm_fZ4OR1C8Cn54SphJe3DFN6pUc3s6DqBNnCIgOlAQuSlsyrXp8wdKyYdM90Fknpzgc5P3TZTsy0w==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/27 03:39:54.891391 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/AWW6Yu0ozm_fZ4OR1C8Cn54SphJe3DFN6pUc3s6DqBNnCIgOlAQuSlsyrXp8wdKyYdM90Fknpzgc5P3TZTsy0w==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/27 03:39:54 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/AWW6Yu0ozm_fZ4OR1C8Cn54SphJe3DFN6pUc3s6DqBNnCIgOlAQuSlsyrXp8wdKyYdM90Fknpzgc5P3TZTsy0w==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/27 03:39:54 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/AWW6Yu0ozm_fZ4OR1C8Cn54SphJe3DFN6pUc3s6DqBNnCIgOlAQuSlsyrXp8wdKyYdM90Fknpzgc5P3TZTsy0w==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/27 03:39:54 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/07/27 03:39:54 DEBUG : proton drive root link ID 'rclone-test-piyixez8vogo': Waiting for transfers to finish 2025/07/27 03:39:56 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/07/27 03:39:56 INFO : yaml: Copied (new) 2025/07/27 03:39:56 ERROR : proton drive root link ID 'rclone-test-piyixez8vogo': not deleting files as there were IO errors 2025/07/27 03:39:56 ERROR : proton drive root link ID 'rclone-test-piyixez8vogo': not deleting directories as there were IO errors sync_test.go:1658: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1658 Error: Received unexpected error: not deleting files as there were IO errors Test: TestSyncWithTrackRenamesStrategyModtime --- FAIL: TestSyncWithTrackRenamesStrategyModtime (10.01s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:180: Remote "proton drive root link ID 'rclone-test-piyixez8vogo'", Local "Local file system at /tmp/rclone2947627714", Modify Window "1s" sync_test.go:1679: Can track renames: true 2025/07/27 03:40:00 INFO : proton drive root link ID 'rclone-test-piyixez8vogo': Making map for --track-renames 2025/07/27 03:40:00 INFO : proton drive root link ID 'rclone-test-piyixez8vogo': Finished making map for --track-renames 2025/07/27 03:40:00 DEBUG : proton drive root link ID 'rclone-test-piyixez8vogo': Waiting for checks to finish 2025/07/27 03:40:00 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/07/27 03:40:00 DEBUG : sub/yam: Need to transfer - No matching file found at Destination 2025/07/27 03:40:00 DEBUG : proton drive root link ID 'rclone-test-piyixez8vogo': Waiting for renames to finish 2025/07/27 03:40:00 DEBUG : proton drive root link ID 'rclone-test-piyixez8vogo': Waiting for transfers to finish 2025/07/27 03:40:02 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/07/27 03:40:02 INFO : potato: Copied (new) 2025/07/27 03:40:02 DEBUG : sub/yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/07/27 03:40:02 INFO : sub/yam: Copied (new) 2025/07/27 03:40:02 DEBUG : Waiting for deletions to finish 2025/07/27 03:40:04 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/27 03:40:04 DEBUG : potato: Unchanged skipping 2025/07/27 03:40:05 INFO : proton drive root link ID 'rclone-test-piyixez8vogo': Making map for --track-renames 2025/07/27 03:40:05 INFO : proton drive root link ID 'rclone-test-piyixez8vogo': Finished making map for --track-renames 2025/07/27 03:40:05 DEBUG : proton drive root link ID 'rclone-test-piyixez8vogo': Waiting for checks to finish 2025/07/27 03:40:05 DEBUG : proton drive root link ID 'rclone-test-piyixez8vogo': Waiting for renames to finish 2025/07/27 03:40:06.553897 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/FijpMW4QuKpZ0NNaIYGhkX_mZy89W6qoQs9KOH1rDdxeNVrB0UZ7ao7QVL2yZzo2qj7mc_AZNQkPdBonG2aBhg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/27 03:40:06.554499 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/FijpMW4QuKpZ0NNaIYGhkX_mZy89W6qoQs9KOH1rDdxeNVrB0UZ7ao7QVL2yZzo2qj7mc_AZNQkPdBonG2aBhg==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/27 03:40:06 ERROR : sub/yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/FijpMW4QuKpZ0NNaIYGhkX_mZy89W6qoQs9KOH1rDdxeNVrB0UZ7ao7QVL2yZzo2qj7mc_AZNQkPdBonG2aBhg==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/27 03:40:06 DEBUG : yam: Failed to rename to "sub/yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/FijpMW4QuKpZ0NNaIYGhkX_mZy89W6qoQs9KOH1rDdxeNVrB0UZ7ao7QVL2yZzo2qj7mc_AZNQkPdBonG2aBhg==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/27 03:40:06 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/07/27 03:40:06 DEBUG : proton drive root link ID 'rclone-test-piyixez8vogo': Waiting for transfers to finish 2025/07/27 03:40:08 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/07/27 03:40:08 INFO : yam: Copied (new) 2025/07/27 03:40:08 ERROR : proton drive root link ID 'rclone-test-piyixez8vogo': not deleting files as there were IO errors 2025/07/27 03:40:08 ERROR : proton drive root link ID 'rclone-test-piyixez8vogo': not deleting directories as there were IO errors sync_test.go:1697: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1697 Error: Received unexpected error: not deleting files as there were IO errors Test: TestSyncWithTrackRenamesStrategyLeaf --- FAIL: TestSyncWithTrackRenamesStrategyLeaf (13.12s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:180: Remote "proton drive root link ID 'rclone-test-piyixez8vogo'", Local "Local file system at /tmp/rclone2947627714", Modify Window "1s" 2025/07/27 03:40:13 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/07/27 03:40:13 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2025/07/27 03:40:13 DEBUG : proton drive root link ID 'rclone-test-piyixez8vogo': Waiting for checks to finish 2025/07/27 03:40:13 DEBUG : proton drive root link ID 'rclone-test-piyixez8vogo': Waiting for transfers to finish 2025/07/27 03:40:18 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/07/27 03:40:18 INFO : sub dir/hello world: Copied (new) 2025/07/27 03:40:18 INFO : sub dir/hello world: Deleted 2025/07/27 03:40:18 DEBUG : nested/sub dir/file: sha1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK 2025/07/27 03:40:18 INFO : nested/sub dir/file: Copied (new) 2025/07/27 03:40:18 INFO : nested/sub dir/file: Deleted 2025/07/27 03:40:18 ERROR : Local file system at /tmp/rclone2947627714: not deleting directories as there were IO errors sync_test.go:1818: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1818 Error: Received unexpected error: not deleting directories as there were IO errors Test: TestMoveWithDeleteEmptySrcDirs --- FAIL: TestMoveWithDeleteEmptySrcDirs (10.63s) === RUN TestServerSideMove run.go:180: Remote "proton drive root link ID 'rclone-test-piyixez8vogo'", Local "Local file system at /tmp/rclone2947627714", Modify Window "1s" 2025/07/27 03:40:23 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-vorekac8puha" 2025/07/27 03:40:23 DEBUG : Config file has changed externally - reloading 2025/07/27 03:40:23 DEBUG : proton drive root link ID 'rclone-test-vorekac8puha': Has cached credentials 2025/07/27 03:40:25 DEBUG : proton drive root link ID 'rclone-test-vorekac8puha': Used cached credential to initialize the ProtonDrive API sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-piyixez8vogo' -> proton drive root link ID 'rclone-test-vorekac8puha' 2025/07/27 03:40:38 DEBUG : proton drive root link ID 'rclone-test-vorekac8puha': Using server-side directory move 2025/07/27 03:40:38 INFO : proton drive root link ID 'rclone-test-vorekac8puha': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/07/27 03:40:39 DEBUG : potato2: Need to transfer - File not found at Destination 2025/07/27 03:40:39 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/07/27 03:40:39 DEBUG : empty space: Unchanged skipping 2025/07/27 03:40:39 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/07/27 03:40:39 DEBUG : proton drive root link ID 'rclone-test-vorekac8puha': Waiting for checks to finish 2025/07/27 03:40:40 INFO : potato3: Deleted 2025/07/27 03:40:40 INFO : empty space: Deleted 2025/07/27 03:40:40 DEBUG : proton drive root link ID 'rclone-test-vorekac8puha': Waiting for transfers to finish 2025/07/27 03:40:41.081013 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/2hGZo9R4RGiZ1UrJMrbpxjfpMpeXeTOgz52Tb0_KmKrNJgl-Kh7AknCaQyJKs1TV8LBZjNDYBuCpKDzskc0THA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/27 03:40:41.081048 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/2hGZo9R4RGiZ1UrJMrbpxjfpMpeXeTOgz52Tb0_KmKrNJgl-Kh7AknCaQyJKs1TV8LBZjNDYBuCpKDzskc0THA==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/27 03:40:41 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/2hGZo9R4RGiZ1UrJMrbpxjfpMpeXeTOgz52Tb0_KmKrNJgl-Kh7AknCaQyJKs1TV8LBZjNDYBuCpKDzskc0THA==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/27 03:40:41.162915 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/xjrNoQIUhE3OpRosEFF72n2WnsG5r07naHwlF06jLbFQK-x1yKdizV4GvSrAoYoy6CNyNKfTDxgZlqSiw2v7bA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/27 03:40:41.162973 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/xjrNoQIUhE3OpRosEFF72n2WnsG5r07naHwlF06jLbFQK-x1yKdizV4GvSrAoYoy6CNyNKfTDxgZlqSiw2v7bA==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/27 03:40:41 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/xjrNoQIUhE3OpRosEFF72n2WnsG5r07naHwlF06jLbFQK-x1yKdizV4GvSrAoYoy6CNyNKfTDxgZlqSiw2v7bA==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:1746: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1746 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1911 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/xjrNoQIUhE3OpRosEFF72n2WnsG5r07naHwlF06jLbFQK-x1yKdizV4GvSrAoYoy6CNyNKfTDxgZlqSiw2v7bA==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMove 2025/07/27 03:40:41 DEBUG : proton drive root link ID 'rclone-test-vorekac8puha': Purge remote --- FAIL: TestServerSideMove (20.97s) === RUN TestServerSideMoveWithFilter run.go:180: Remote "proton drive root link ID 'rclone-test-piyixez8vogo'", Local "Local file system at /tmp/rclone2947627714", Modify Window "1s" 2025/07/27 03:40:44 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-setiquf2bago" 2025/07/27 03:40:44 DEBUG : proton drive root link ID 'rclone-test-setiquf2bago': Has cached credentials 2025/07/27 03:40:46 DEBUG : proton drive root link ID 'rclone-test-setiquf2bago': Used cached credential to initialize the ProtonDrive API sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-piyixez8vogo' -> proton drive root link ID 'rclone-test-setiquf2bago' 2025/07/27 03:40:59 DEBUG : empty space: Excluded (Size Filter) 2025/07/27 03:40:59 DEBUG : empty space: Excluded 2025/07/27 03:40:59 DEBUG : empty space: Excluded (Size Filter) 2025/07/27 03:40:59 DEBUG : empty space: Excluded 2025/07/27 03:40:59 DEBUG : potato2: Need to transfer - File not found at Destination 2025/07/27 03:40:59 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/07/27 03:40:59 DEBUG : proton drive root link ID 'rclone-test-setiquf2bago': Waiting for checks to finish 2025/07/27 03:40:59 DEBUG : proton drive root link ID 'rclone-test-setiquf2bago': Waiting for transfers to finish 2025/07/27 03:41:00 INFO : potato3: Deleted 2025/07/27 03:41:00.762685 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/4YYxSTSLU7oI7xq6abDj5tLcUt2NpFX1e08BQ7nHL8oQHNQezBchYD04JQ5d4UtUaMlVe7SySgfm2nnvoxYCKw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/27 03:41:00.762707 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/4YYxSTSLU7oI7xq6abDj5tLcUt2NpFX1e08BQ7nHL8oQHNQezBchYD04JQ5d4UtUaMlVe7SySgfm2nnvoxYCKw==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/27 03:41:00 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/4YYxSTSLU7oI7xq6abDj5tLcUt2NpFX1e08BQ7nHL8oQHNQezBchYD04JQ5d4UtUaMlVe7SySgfm2nnvoxYCKw==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/27 03:41:01.078784 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/wGi8rLUaN5ZoqkWJ1ZtNdGTNAYmFPHx5CyKsjCbNjM8mkEVb3oE8aznCqX4EJ32r4i59-FqkZIjEZQHIWoe_1Q==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/27 03:41:01.078808 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/wGi8rLUaN5ZoqkWJ1ZtNdGTNAYmFPHx5CyKsjCbNjM8mkEVb3oE8aznCqX4EJ32r4i59-FqkZIjEZQHIWoe_1Q==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/27 03:41:01 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/wGi8rLUaN5ZoqkWJ1ZtNdGTNAYmFPHx5CyKsjCbNjM8mkEVb3oE8aznCqX4EJ32r4i59-FqkZIjEZQHIWoe_1Q==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:1746: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1746 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1924 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/wGi8rLUaN5ZoqkWJ1ZtNdGTNAYmFPHx5CyKsjCbNjM8mkEVb3oE8aznCqX4EJ32r4i59-FqkZIjEZQHIWoe_1Q==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveWithFilter 2025/07/27 03:41:01 DEBUG : proton drive root link ID 'rclone-test-setiquf2bago': Purge remote --- FAIL: TestServerSideMoveWithFilter (20.83s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:180: Remote "proton drive root link ID 'rclone-test-piyixez8vogo'", Local "Local file system at /tmp/rclone2947627714", Modify Window "1s" 2025/07/27 03:41:05 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-hofeniv6loro" 2025/07/27 03:41:05 DEBUG : proton drive root link ID 'rclone-test-hofeniv6loro': Has cached credentials 2025/07/27 03:41:07 DEBUG : proton drive root link ID 'rclone-test-hofeniv6loro': Used cached credential to initialize the ProtonDrive API 2025/07/27 03:41:12 INFO : tomatoDir: Making directory sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-piyixez8vogo' -> proton drive root link ID 'rclone-test-hofeniv6loro' 2025/07/27 03:41:20 DEBUG : proton drive root link ID 'rclone-test-hofeniv6loro': Using server-side directory move 2025/07/27 03:41:20 INFO : proton drive root link ID 'rclone-test-hofeniv6loro': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/07/27 03:41:21 DEBUG : potato2: Need to transfer - File not found at Destination 2025/07/27 03:41:21 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/07/27 03:41:21 DEBUG : empty space: Unchanged skipping 2025/07/27 03:41:21 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/07/27 03:41:21 DEBUG : proton drive root link ID 'rclone-test-hofeniv6loro': Waiting for checks to finish 2025/07/27 03:41:21 INFO : empty space: Deleted 2025/07/27 03:41:22 DEBUG : proton drive root link ID 'rclone-test-hofeniv6loro': Waiting for transfers to finish 2025/07/27 03:41:22 INFO : potato3: Deleted 2025/07/27 03:41:22.308566 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/cSUlJmTkJt0neHIwB0xzv-A7UoX2SvC9GEDwbkRMAxEU9WDaJFiafyWG5Of0s2_18lgNg35iC68b0Ey_o7JaKQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/27 03:41:22.308654 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/cSUlJmTkJt0neHIwB0xzv-A7UoX2SvC9GEDwbkRMAxEU9WDaJFiafyWG5Of0s2_18lgNg35iC68b0Ey_o7JaKQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/27 03:41:22 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/cSUlJmTkJt0neHIwB0xzv-A7UoX2SvC9GEDwbkRMAxEU9WDaJFiafyWG5Of0s2_18lgNg35iC68b0Ey_o7JaKQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/27 03:41:22.933918 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/O4tYPKhGNr6D2Zof5rsiwqCi4YBKhOO-Gum0lTGY-B3grp1XCeZirc6rBb8efU9f_b-gSyNMvFRLqTTr3nMIng==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/27 03:41:22.933945 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/O4tYPKhGNr6D2Zof5rsiwqCi4YBKhOO-Gum0lTGY-B3grp1XCeZirc6rBb8efU9f_b-gSyNMvFRLqTTr3nMIng==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/27 03:41:22 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/O4tYPKhGNr6D2Zof5rsiwqCi4YBKhOO-Gum0lTGY-B3grp1XCeZirc6rBb8efU9f_b-gSyNMvFRLqTTr3nMIng==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/27 03:41:22 ERROR : proton drive root link ID 'rclone-test-piyixez8vogo': not deleting directories as there were IO errors sync_test.go:1746: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1746 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1931 Error: Received unexpected error: not deleting directories as there were IO errors Test: TestServerSideMoveDeleteEmptySourceDirs 2025/07/27 03:41:22 DEBUG : proton drive root link ID 'rclone-test-hofeniv6loro': Purge remote --- FAIL: TestServerSideMoveDeleteEmptySourceDirs (22.29s) === RUN TestSyncBackupDir run.go:180: Remote "proton drive root link ID 'rclone-test-piyixez8vogo'", Local "Local file system at /tmp/rclone2947627714", Modify Window "1s" 2025/07/27 03:41:34 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-piyixez8vogo/dst" 2025/07/27 03:41:34 DEBUG : proton drive root link ID 'rclone-test-piyixez8vogo/dst': Has cached credentials 2025/07/27 03:41:37 DEBUG : proton drive root link ID 'rclone-test-piyixez8vogo/dst': Used cached credential to initialize the ProtonDrive API 2025/07/27 03:42:51 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-piyixez8vogo/backup" 2025/07/27 03:42:51 DEBUG : Config file has changed externally - reloading 2025/07/27 03:42:51 DEBUG : proton drive root link ID 'rclone-test-piyixez8vogo/backup': Has cached credentials 2025/07/27 03:42:53 DEBUG : proton drive root link ID 'rclone-test-piyixez8vogo/backup': Used cached credential to initialize the ProtonDrive API 2025/07/27 03:45:22 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/27 03:45:22 DEBUG : proton drive root link ID 'rclone-test-piyixez8vogo/dst': Waiting for checks to finish 2025/07/27 03:45:22 DEBUG : two: Unchanged skipping 2025/07/27 03:45:22 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/07/27 03:45:25.482459 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/D_2UkwwuWKwjpI7nkT_7kZqfyiapewSlkDxo-f3OrE40rwS0njUwhX45bDAibkhdRpaYremiJ5fn2Ekk_Ui6Pg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/27 03:45:25.482560 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/D_2UkwwuWKwjpI7nkT_7kZqfyiapewSlkDxo-f3OrE40rwS0njUwhX45bDAibkhdRpaYremiJ5fn2Ekk_Ui6Pg==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/27 03:45:25 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/D_2UkwwuWKwjpI7nkT_7kZqfyiapewSlkDxo-f3OrE40rwS0njUwhX45bDAibkhdRpaYremiJ5fn2Ekk_Ui6Pg==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/27 03:45:25 DEBUG : proton drive root link ID 'rclone-test-piyixez8vogo/dst': Waiting for transfers to finish 2025/07/27 03:45:25 ERROR : proton drive root link ID 'rclone-test-piyixez8vogo/dst': not deleting files as there were IO errors 2025/07/27 03:45:25 ERROR : proton drive root link ID 'rclone-test-piyixez8vogo/dst': not deleting directories as there were IO errors sync_test.go:2415: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2415 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2457 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/D_2UkwwuWKwjpI7nkT_7kZqfyiapewSlkDxo-f3OrE40rwS0njUwhX45bDAibkhdRpaYremiJ5fn2Ekk_Ui6Pg==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDir --- FAIL: TestSyncBackupDir (243.29s) === RUN TestSyncBackupDirWithSuffix run.go:180: Remote "proton drive root link ID 'rclone-test-piyixez8vogo'", Local "Local file system at /tmp/rclone2947627714", Modify Window "1s" 2025/07/27 03:45:36.153333 WARN RESTY 401 POST https://mail.proton.me/api/drive/blocks: Invalid access token (Code=401, Status=401), Attempt 1 2025/07/27 03:45:36.153375 ERROR RESTY 401 POST https://mail.proton.me/api/drive/blocks: Invalid access token (Code=401, Status=401) 2025/07/27 03:45:36 DEBUG : Saving config "client_uid" in section "TestProtonDrive" of the config file 2025/07/27 03:45:36 DEBUG : Config file has changed externally - reloading 2025/07/27 03:45:36 DEBUG : Saving config "client_access_token" in section "TestProtonDrive" of the config file 2025/07/27 03:45:36 DEBUG : Saving config "client_refresh_token" in section "TestProtonDrive" of the config file 2025/07/27 03:45:36 DEBUG : Saving config "client_salted_key_pass" in section "TestProtonDrive" of the config file 2025/07/27 03:45:39 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-piyixez8vogo/dst" 2025/07/27 03:45:39 DEBUG : proton drive root link ID 'rclone-test-piyixez8vogo/dst': Has cached credentials 2025/07/27 03:45:41 DEBUG : proton drive root link ID 'rclone-test-piyixez8vogo/dst': Used cached credential to initialize the ProtonDrive API 2025/07/27 03:46:55 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-piyixez8vogo/backup" 2025/07/27 03:46:55 DEBUG : Config file has changed externally - reloading 2025/07/27 03:46:55 DEBUG : proton drive root link ID 'rclone-test-piyixez8vogo/backup': Has cached credentials 2025/07/27 03:46:57 DEBUG : proton drive root link ID 'rclone-test-piyixez8vogo/backup': Used cached credential to initialize the ProtonDrive API 2025/07/27 03:49:29 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/07/27 03:49:29 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/27 03:49:29 DEBUG : two: Unchanged skipping 2025/07/27 03:49:29 DEBUG : proton drive root link ID 'rclone-test-piyixez8vogo/dst': Waiting for checks to finish 2025/07/27 03:49:32.379038 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/ougYZzM2Rh1I8X2Hvn_XDXCVVYm5UvvLVV5_FNktANmjRY6gE6Kv-MuEhilhikNSnXjN_gNSO6aZqN0kMztG6Q==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/27 03:49:32.379101 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/ougYZzM2Rh1I8X2Hvn_XDXCVVYm5UvvLVV5_FNktANmjRY6gE6Kv-MuEhilhikNSnXjN_gNSO6aZqN0kMztG6Q==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/27 03:49:32 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/ougYZzM2Rh1I8X2Hvn_XDXCVVYm5UvvLVV5_FNktANmjRY6gE6Kv-MuEhilhikNSnXjN_gNSO6aZqN0kMztG6Q==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/27 03:49:32 DEBUG : proton drive root link ID 'rclone-test-piyixez8vogo/dst': Waiting for transfers to finish 2025/07/27 03:49:32 ERROR : proton drive root link ID 'rclone-test-piyixez8vogo/dst': not deleting files as there were IO errors 2025/07/27 03:49:32 ERROR : proton drive root link ID 'rclone-test-piyixez8vogo/dst': not deleting directories as there were IO errors sync_test.go:2415: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2415 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2461 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/ougYZzM2Rh1I8X2Hvn_XDXCVVYm5UvvLVV5_FNktANmjRY6gE6Kv-MuEhilhikNSnXjN_gNSO6aZqN0kMztG6Q==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirWithSuffix --- FAIL: TestSyncBackupDirWithSuffix (247.02s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:180: Remote "proton drive root link ID 'rclone-test-piyixez8vogo'", Local "Local file system at /tmp/rclone2947627714", Modify Window "1s" 2025/07/27 03:49:45 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-piyixez8vogo/dst" 2025/07/27 03:49:45 DEBUG : proton drive root link ID 'rclone-test-piyixez8vogo/dst': Has cached credentials 2025/07/27 03:49:47 DEBUG : proton drive root link ID 'rclone-test-piyixez8vogo/dst': Used cached credential to initialize the ProtonDrive API 2025/07/27 03:51:02 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-piyixez8vogo/backup" 2025/07/27 03:51:02 DEBUG : proton drive root link ID 'rclone-test-piyixez8vogo/backup': Has cached credentials 2025/07/27 03:51:04 DEBUG : proton drive root link ID 'rclone-test-piyixez8vogo/backup': Used cached credential to initialize the ProtonDrive API 2025/07/27 03:53:34 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/07/27 03:53:34 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/27 03:53:34 DEBUG : two: Unchanged skipping 2025/07/27 03:53:34 DEBUG : proton drive root link ID 'rclone-test-piyixez8vogo/dst': Waiting for checks to finish 2025/07/27 03:53:36.130138 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/M8CsdC7aZT6L8Sastj9n_ICi5UMGrcT87dp0rOAsgsgYph3B6IpmtOyZdjDugQtlXdptuufchSSDJtwUeKC0_w==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/27 03:53:36.130175 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/M8CsdC7aZT6L8Sastj9n_ICi5UMGrcT87dp0rOAsgsgYph3B6IpmtOyZdjDugQtlXdptuufchSSDJtwUeKC0_w==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/27 03:53:36 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/M8CsdC7aZT6L8Sastj9n_ICi5UMGrcT87dp0rOAsgsgYph3B6IpmtOyZdjDugQtlXdptuufchSSDJtwUeKC0_w==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/27 03:53:36 DEBUG : proton drive root link ID 'rclone-test-piyixez8vogo/dst': Waiting for transfers to finish 2025/07/27 03:53:36 ERROR : proton drive root link ID 'rclone-test-piyixez8vogo/dst': not deleting files as there were IO errors 2025/07/27 03:53:36 ERROR : proton drive root link ID 'rclone-test-piyixez8vogo/dst': not deleting directories as there were IO errors sync_test.go:2415: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2415 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2465 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/M8CsdC7aZT6L8Sastj9n_ICi5UMGrcT87dp0rOAsgsgYph3B6IpmtOyZdjDugQtlXdptuufchSSDJtwUeKC0_w==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirWithSuffixKeepExtension --- FAIL: TestSyncBackupDirWithSuffixKeepExtension (243.53s) === RUN TestSyncBackupDirSuffixOnly run.go:180: Remote "proton drive root link ID 'rclone-test-piyixez8vogo'", Local "Local file system at /tmp/rclone2947627714", Modify Window "1s" 2025/07/27 03:53:49 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-piyixez8vogo/dst" 2025/07/27 03:53:49 DEBUG : proton drive root link ID 'rclone-test-piyixez8vogo/dst': Has cached credentials 2025/07/27 03:53:51 DEBUG : proton drive root link ID 'rclone-test-piyixez8vogo/dst': Used cached credential to initialize the ProtonDrive API 2025/07/27 03:55:05 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/07/27 03:55:05 DEBUG : proton drive root link ID 'rclone-test-piyixez8vogo/dst': Waiting for checks to finish 2025/07/27 03:55:05 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/27 03:55:05 DEBUG : two: Unchanged skipping 2025/07/27 03:55:07.011649 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/SBjJaatLuEhl3RGHtvkakBREcj-iGWdGRPMElQ9ErveILzaKui8xl1IO0GLnG76aFSM2k0ghChXkfFJ6ygvY5g==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/27 03:55:07.011686 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/SBjJaatLuEhl3RGHtvkakBREcj-iGWdGRPMElQ9ErveILzaKui8xl1IO0GLnG76aFSM2k0ghChXkfFJ6ygvY5g==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/27 03:55:07 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/SBjJaatLuEhl3RGHtvkakBREcj-iGWdGRPMElQ9ErveILzaKui8xl1IO0GLnG76aFSM2k0ghChXkfFJ6ygvY5g==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/27 03:55:07 DEBUG : proton drive root link ID 'rclone-test-piyixez8vogo/dst': Waiting for transfers to finish 2025/07/27 03:55:07 ERROR : proton drive root link ID 'rclone-test-piyixez8vogo/dst': not deleting files as there were IO errors 2025/07/27 03:55:07 ERROR : proton drive root link ID 'rclone-test-piyixez8vogo/dst': not deleting directories as there were IO errors sync_test.go:2415: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2415 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2469 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/SBjJaatLuEhl3RGHtvkakBREcj-iGWdGRPMElQ9ErveILzaKui8xl1IO0GLnG76aFSM2k0ghChXkfFJ6ygvY5g==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirSuffixOnly --- FAIL: TestSyncBackupDirSuffixOnly (90.38s) === RUN TestSyncSuffix run.go:180: Remote "proton drive root link ID 'rclone-test-piyixez8vogo'", Local "Local file system at /tmp/rclone2947627714", Modify Window "1s" 2025/07/27 03:55:19 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-piyixez8vogo/dst" 2025/07/27 03:55:19 DEBUG : proton drive root link ID 'rclone-test-piyixez8vogo/dst': Has cached credentials 2025/07/27 03:55:21 DEBUG : proton drive root link ID 'rclone-test-piyixez8vogo/dst': Used cached credential to initialize the ProtonDrive API 2025/07/27 03:56:37 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/07/27 03:56:38.900675 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/R_Luc87qwRBaG95j2tUMErm-A3AMtcOed_fh1WA4_TT_WCsAv7DEmCpuRfzKLeVg_mxtXiZ_28ZajdltPsgNYw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/27 03:56:38.900714 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/R_Luc87qwRBaG95j2tUMErm-A3AMtcOed_fh1WA4_TT_WCsAv7DEmCpuRfzKLeVg_mxtXiZ_28ZajdltPsgNYw==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/27 03:56:38 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/R_Luc87qwRBaG95j2tUMErm-A3AMtcOed_fh1WA4_TT_WCsAv7DEmCpuRfzKLeVg_mxtXiZ_28ZajdltPsgNYw==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:2503: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2503 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2553 Error: Received unexpected error: moving to --backup-dir failed: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/R_Luc87qwRBaG95j2tUMErm-A3AMtcOed_fh1WA4_TT_WCsAv7DEmCpuRfzKLeVg_mxtXiZ_28ZajdltPsgNYw==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncSuffix --- FAIL: TestSyncSuffix (91.99s) === RUN TestSyncSuffixKeepExtension run.go:180: Remote "proton drive root link ID 'rclone-test-piyixez8vogo'", Local "Local file system at /tmp/rclone2947627714", Modify Window "1s" 2025/07/27 03:56:51 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-piyixez8vogo/dst" 2025/07/27 03:56:51 DEBUG : Config file has changed externally - reloading 2025/07/27 03:56:51 DEBUG : proton drive root link ID 'rclone-test-piyixez8vogo/dst': Has cached credentials 2025/07/27 03:56:54 DEBUG : proton drive root link ID 'rclone-test-piyixez8vogo/dst': Used cached credential to initialize the ProtonDrive API 2025/07/27 03:58:09 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/07/27 03:58:10.619766 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/leMsWhhjxAeRdOIB1qO7BevUSzKWm22KXR0uKAl8XDRXxC1G3LFahm4-TW_MXX5Mkn7-7IQl7PjwFCXbjZRD3g==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/27 03:58:10.619791 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/leMsWhhjxAeRdOIB1qO7BevUSzKWm22KXR0uKAl8XDRXxC1G3LFahm4-TW_MXX5Mkn7-7IQl7PjwFCXbjZRD3g==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/27 03:58:10 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/leMsWhhjxAeRdOIB1qO7BevUSzKWm22KXR0uKAl8XDRXxC1G3LFahm4-TW_MXX5Mkn7-7IQl7PjwFCXbjZRD3g==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:2503: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2503 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2554 Error: Received unexpected error: moving to --backup-dir failed: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/leMsWhhjxAeRdOIB1qO7BevUSzKWm22KXR0uKAl8XDRXxC1G3LFahm4-TW_MXX5Mkn7-7IQl7PjwFCXbjZRD3g==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncSuffixKeepExtension --- FAIL: TestSyncSuffixKeepExtension (91.48s) === RUN TestTransformFile run.go:180: Remote "proton drive root link ID 'rclone-test-piyixez8vogo'", Local "Local file system at /tmp/rclone2947627714", Modify Window "1s" 2025/07/27 03:58:15 DEBUG : empty_dir: Making directory with metadata 2025/07/27 03:58:15 INFO : empty_dir: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z) 2025/07/27 03:58:15 DEBUG : toe: transformed to: tictactoe 2025/07/27 03:58:15 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/07/27 03:58:15 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/07/27 03:58:15 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/07/27 03:58:15 INFO : tictacempty_dir: Making directory 2025/07/27 03:58:16 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/07/27 03:58:16 DEBUG : toe: transformed to: tictactoe 2025/07/27 03:58:16 DEBUG : toe: transformed to: tictactoe 2025/07/27 03:58:16 INFO : tictactoe: Making directory 2025/07/27 03:58:16 DEBUG : toe: transformed to: tictactoe 2025/07/27 03:58:16 DEBUG : toe: transformed to: tictactoe 2025/07/27 03:58:16 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2025/07/27 03:58:16 INFO : tictactoe/tictactoe: Making directory 2025/07/27 03:58:17 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2025/07/27 03:58:17 DEBUG : toe.txt: transformed to: tictactoe.txt 2025/07/27 03:58:17 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2025/07/27 03:58:17 DEBUG : toe/toe/toe.txt: Need to transfer - File not found at Destination 2025/07/27 03:58:17 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2025/07/27 03:58:17 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2025/07/27 03:58:17 DEBUG : proton drive root link ID 'rclone-test-piyixez8vogo': Waiting for checks to finish 2025/07/27 03:58:17 DEBUG : proton drive root link ID 'rclone-test-piyixez8vogo': Waiting for transfers to finish 2025/07/27 03:58:19 DEBUG : toe/toe/toe.txt: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/07/27 03:58:19 INFO : toe/toe/toe.txt: Copied (new) to: tictactoe/tictactoe/tictactoe.txt 2025/07/27 03:58:19 INFO : toe/toe/toe.txt: Deleted 2025/07/27 03:58:19 ERROR : Local file system at /tmp/rclone2947627714: not deleting directories as there were IO errors sync_transform_test.go:427: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_transform_test.go:427 Error: Received unexpected error: not deleting directories as there were IO errors Test: TestTransformFile --- FAIL: TestTransformFile (9.60s) === RUN TestManualTransformFile run.go:180: Remote "proton drive root link ID 'rclone-test-piyixez8vogo'", Local "Local file system at /tmp/rclone2947627714", Modify Window "1s" 2025/07/27 03:58:24 DEBUG : Reset feature "Copy" 2025/07/27 03:58:24 DEBUG : Reset feature "Move" 2025/07/27 03:58:24 DEBUG : Reset feature "Copy" 2025/07/27 03:58:24 DEBUG : Reset feature "Move" 2025/07/27 03:58:24 DEBUG : empty_dir: Making directory with metadata 2025/07/27 03:58:24 INFO : empty_dir: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z) 2025/07/27 03:58:24 DEBUG : toe: transformed to: tictactoe 2025/07/27 03:58:24 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/07/27 03:58:24 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/07/27 03:58:25 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/07/27 03:58:25 INFO : tictacempty_dir: Making directory 2025/07/27 03:58:26 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/07/27 03:58:26 DEBUG : toe: transformed to: tictactoe 2025/07/27 03:58:26 DEBUG : toe: transformed to: tictactoe 2025/07/27 03:58:26 INFO : tictactoe: Making directory 2025/07/27 03:58:26 DEBUG : toe: transformed to: tictactoe 2025/07/27 03:58:26 DEBUG : toe: transformed to: tictactoe 2025/07/27 03:58:26 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2025/07/27 03:58:26 INFO : tictactoe/tictactoe: Making directory 2025/07/27 03:58:28 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2025/07/27 03:58:28 DEBUG : toe.txt: transformed to: tictactoe.txt 2025/07/27 03:58:28 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2025/07/27 03:58:28 DEBUG : toe/toe/toe.txt: Need to transfer - File not found at Destination 2025/07/27 03:58:28 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2025/07/27 03:58:28 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2025/07/27 03:58:28 DEBUG : proton drive root link ID 'rclone-test-piyixez8vogo': Waiting for checks to finish 2025/07/27 03:58:28 DEBUG : proton drive root link ID 'rclone-test-piyixez8vogo': Waiting for transfers to finish 2025/07/27 03:58:30 DEBUG : toe/toe/toe.txt: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/07/27 03:58:30 INFO : toe/toe/toe.txt: Copied (new) to: tictactoe/tictactoe/tictactoe.txt 2025/07/27 03:58:30 INFO : toe/toe/toe.txt: Deleted 2025/07/27 03:58:30 ERROR : Local file system at /tmp/rclone2947627714: not deleting directories as there were IO errors sync_transform_test.go:457: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_transform_test.go:457 Error: Received unexpected error: not deleting directories as there were IO errors Test: TestManualTransformFile --- FAIL: TestManualTransformFile (10.28s) === RUN TestBase64 run.go:180: Remote "proton drive root link ID 'rclone-test-piyixez8vogo'", Local "Local file system at /tmp/rclone2947627714", Modify Window "1s" 2025/07/27 03:58:35 DEBUG : toe: transformed to: dG9l 2025/07/27 03:58:35 DEBUG : toe: transformed to: dG9l 2025/07/27 03:58:35 INFO : dG9l: Making directory 2025/07/27 03:58:36 DEBUG : toe: transformed to: dG9l 2025/07/27 03:58:36 DEBUG : toe: transformed to: dG9l 2025/07/27 03:58:36 DEBUG : toe/toe: transformed to: dG9l/dG9l 2025/07/27 03:58:36 INFO : dG9l/dG9l: Making directory 2025/07/27 03:58:37 DEBUG : toe/toe: transformed to: dG9l/dG9l 2025/07/27 03:58:37 DEBUG : toe.txt: transformed to: dG9lLnR4dA== 2025/07/27 03:58:37 DEBUG : toe/toe/toe.txt: transformed to: dG9l/dG9l/dG9lLnR4dA== 2025/07/27 03:58:37 DEBUG : toe/toe/toe.txt: Need to transfer - File not found at Destination 2025/07/27 03:58:37 DEBUG : toe/toe/toe.txt: transformed to: dG9l/dG9l/dG9lLnR4dA== 2025/07/27 03:58:37 DEBUG : proton drive root link ID 'rclone-test-piyixez8vogo': Waiting for checks to finish 2025/07/27 03:58:37 DEBUG : proton drive root link ID 'rclone-test-piyixez8vogo': Waiting for transfers to finish 2025/07/27 03:58:39 DEBUG : toe/toe/toe.txt: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/07/27 03:58:39 INFO : toe/toe/toe.txt: Copied (new) to: dG9l/dG9l/dG9lLnR4dA== 2025/07/27 03:58:39 ERROR : proton drive root link ID 'rclone-test-piyixez8vogo': not deleting files as there were IO errors 2025/07/27 03:58:39 ERROR : proton drive root link ID 'rclone-test-piyixez8vogo': not deleting directories as there were IO errors sync_transform_test.go:481: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_transform_test.go:481 Error: Received unexpected error: not deleting files as there were IO errors Test: TestBase64 --- FAIL: TestBase64 (8.13s) FAIL 2025/07/27 03:58:43 DEBUG : proton drive root link ID 'rclone-test-piyixez8vogo': Purge remote "./sync.test -test.v -test.timeout 1h0m0s -remote TestProtonDrive: -verbose -test.run '^(TestBase64|TestManualTransformFile|TestMoveWithDeleteEmptySrcDirs|TestServerSideMove|TestServerSideMoveDeleteEmptySourceDirs|TestServerSideMoveOverSelf|TestServerSideMoveWithFilter|TestSyncBackupDir|TestSyncBackupDirSuffixOnly|TestSyncBackupDirWithSuffix|TestSyncBackupDirWithSuffixKeepExtension|TestSyncSuffix|TestSyncSuffixKeepExtension|TestSyncWithTrackRenames|TestSyncWithTrackRenamesStrategyLeaf|TestSyncWithTrackRenamesStrategyModtime|TestTransformFile)$'" - Finished ERROR in 19m34.257483631s (try 5/5): exit status 1: Failed [TestServerSideMoveOverSelf TestSyncWithTrackRenames TestSyncWithTrackRenamesStrategyModtime TestSyncWithTrackRenamesStrategyLeaf TestMoveWithDeleteEmptySrcDirs TestServerSideMove TestServerSideMoveWithFilter TestServerSideMoveDeleteEmptySourceDirs TestSyncBackupDir TestSyncBackupDirWithSuffix TestSyncBackupDirWithSuffixKeepExtension TestSyncBackupDirSuffixOnly TestSyncSuffix TestSyncSuffixKeepExtension TestTransformFile TestManualTransformFile TestBase64]