"./sync.test -test.v -test.timeout 1h0m0s -remote TestProtonDrive: -verbose -test.run '^(TestMoveWithDeleteEmptySrcDirs|TestServerSideMove|TestServerSideMoveDeleteEmptySourceDirs|TestServerSideMoveOverSelf|TestServerSideMoveWithFilter|TestSyncBackupDir|TestSyncBackupDirSuffixOnly|TestSyncBackupDirWithSuffix|TestSyncBackupDirWithSuffixKeepExtension|TestSyncSuffix|TestSyncSuffixKeepExtension|TestSyncWithTrackRenames|TestSyncWithTrackRenamesStrategyLeaf|TestSyncWithTrackRenamesStrategyModtime)$'" - Starting (try 5/5) 2025/08/23 06:16:00 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-xigizoj8dure" 2025/08/23 06:16:00 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/08/23 06:16:00 DEBUG : proton drive root link ID 'rclone-test-xigizoj8dure': Has cached credentials 2025/08/23 06:16:00 DEBUG : proton drive root link ID 'rclone-test-xigizoj8dure': Used cached credential to initialize the ProtonDrive API 2025/08/23 06:16:01 DEBUG : Creating backend with remote "/tmp/rclone1075629447" === RUN TestServerSideMoveOverSelf run.go:180: Remote "proton drive root link ID 'rclone-test-xigizoj8dure'", Local "Local file system at /tmp/rclone1075629447", Modify Window "1s" 2025/08/23 06:16:03 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-subenif3leqa" 2025/08/23 06:16:03 DEBUG : proton drive root link ID 'rclone-test-subenif3leqa': Has cached credentials 2025/08/23 06:16:04 DEBUG : proton drive root link ID 'rclone-test-subenif3leqa': Used cached credential to initialize the ProtonDrive API sync_test.go:701: Server side copy (if possible) proton drive root link ID 'rclone-test-xigizoj8dure' -> proton drive root link ID 'rclone-test-subenif3leqa' 2025/08/23 06:16:05 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/08/23 06:16:05 DEBUG : proton drive root link ID 'rclone-test-subenif3leqa': Waiting for checks to finish 2025/08/23 06:16:05 DEBUG : proton drive root link ID 'rclone-test-subenif3leqa': Waiting for transfers to finish 2025/08/23 06:16:08 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/08/23 06:16:08 INFO : sub dir/hello world: Copied (new) 2025/08/23 06:16:09.403793 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/08/23 06:16:09.403831 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/08/23 06:16:11 DEBUG : proton drive root link ID 'rclone-test-subenif3leqa': Using server-side directory move 2025/08/23 06:16:11 INFO : proton drive root link ID 'rclone-test-subenif3leqa': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/08/23 06:16:12 DEBUG : proton drive root link ID 'rclone-test-subenif3leqa': Waiting for checks to finish 2025/08/23 06:16:12 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/08/23 06:16:12 DEBUG : proton drive root link ID 'rclone-test-subenif3leqa': Waiting for transfers to finish 2025/08/23 06:16:12 INFO : sub dir/hello world: Deleted 2025/08/23 06:16:12.779874 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/17ad8vc9ip4KFH9epqXnv1NY1DUEHtdj_nbc33MfW_HZVTxDMWoXvD5vYmR9yr2WzUlRG98xBudvH-KDMQWWeQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/23 06:16:12.779917 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/17ad8vc9ip4KFH9epqXnv1NY1DUEHtdj_nbc33MfW_HZVTxDMWoXvD5vYmR9yr2WzUlRG98xBudvH-KDMQWWeQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/23 06:16:12 ERROR : sub dir/hello world: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/17ad8vc9ip4KFH9epqXnv1NY1DUEHtdj_nbc33MfW_HZVTxDMWoXvD5vYmR9yr2WzUlRG98xBudvH-KDMQWWeQ==/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/17ad8vc9ip4KFH9epqXnv1NY1DUEHtdj_nbc33MfW_HZVTxDMWoXvD5vYmR9yr2WzUlRG98xBudvH-KDMQWWeQ==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveOverSelf 2025/08/23 06:16:12 DEBUG : proton drive root link ID 'rclone-test-subenif3leqa': Purge remote --- FAIL: TestServerSideMoveOverSelf (13.03s) === RUN TestSyncWithTrackRenames run.go:180: Remote "proton drive root link ID 'rclone-test-xigizoj8dure'", Local "Local file system at /tmp/rclone1075629447", Modify Window "1s" sync_test.go:1568: Can track renames: true 2025/08/23 06:16:14 INFO : proton drive root link ID 'rclone-test-xigizoj8dure': Making map for --track-renames 2025/08/23 06:16:14 INFO : proton drive root link ID 'rclone-test-xigizoj8dure': Finished making map for --track-renames 2025/08/23 06:16:14 DEBUG : proton drive root link ID 'rclone-test-xigizoj8dure': Waiting for checks to finish 2025/08/23 06:16:14 DEBUG : proton drive root link ID 'rclone-test-xigizoj8dure': Waiting for renames to finish 2025/08/23 06:16:14 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/08/23 06:16:14 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/08/23 06:16:14 DEBUG : proton drive root link ID 'rclone-test-xigizoj8dure': Waiting for transfers to finish 2025/08/23 06:16:15 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/08/23 06:16:15 INFO : yam: Copied (new) 2025/08/23 06:16:15 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/08/23 06:16:15 INFO : potato: Copied (new) 2025/08/23 06:16:15 DEBUG : Waiting for deletions to finish 2025/08/23 06:16:16 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/23 06:16:16 INFO : proton drive root link ID 'rclone-test-xigizoj8dure': Making map for --track-renames 2025/08/23 06:16:16 INFO : proton drive root link ID 'rclone-test-xigizoj8dure': Finished making map for --track-renames 2025/08/23 06:16:16 DEBUG : proton drive root link ID 'rclone-test-xigizoj8dure': Waiting for checks to finish 2025/08/23 06:16:16 DEBUG : potato: Unchanged skipping 2025/08/23 06:16:16 DEBUG : proton drive root link ID 'rclone-test-xigizoj8dure': Waiting for renames to finish 2025/08/23 06:16:17.056133 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/FdgxYZwK95Y9JCPPgajSOWgFLqULRC-X-iY6SG9mN2zvwvLLAq9jXVOLxDRYLmast4cFzTDLNnpjT3ygU0xfLw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/23 06:16:17.056174 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/FdgxYZwK95Y9JCPPgajSOWgFLqULRC-X-iY6SG9mN2zvwvLLAq9jXVOLxDRYLmast4cFzTDLNnpjT3ygU0xfLw==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/23 06:16:17 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/FdgxYZwK95Y9JCPPgajSOWgFLqULRC-X-iY6SG9mN2zvwvLLAq9jXVOLxDRYLmast4cFzTDLNnpjT3ygU0xfLw==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/23 06:16:17 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/FdgxYZwK95Y9JCPPgajSOWgFLqULRC-X-iY6SG9mN2zvwvLLAq9jXVOLxDRYLmast4cFzTDLNnpjT3ygU0xfLw==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/23 06:16:17 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/08/23 06:16:17 DEBUG : proton drive root link ID 'rclone-test-xigizoj8dure': Waiting for transfers to finish 2025/08/23 06:16:18 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/08/23 06:16:18 INFO : yaml: Copied (new) 2025/08/23 06:16:18 ERROR : proton drive root link ID 'rclone-test-xigizoj8dure': not deleting files as there were IO errors 2025/08/23 06:16:18 ERROR : proton drive root link ID 'rclone-test-xigizoj8dure': 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 (5.32s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:180: Remote "proton drive root link ID 'rclone-test-xigizoj8dure'", Local "Local file system at /tmp/rclone1075629447", Modify Window "1s" sync_test.go:1640: Can track renames: true 2025/08/23 06:16:19 INFO : proton drive root link ID 'rclone-test-xigizoj8dure': Making map for --track-renames 2025/08/23 06:16:19 INFO : proton drive root link ID 'rclone-test-xigizoj8dure': Finished making map for --track-renames 2025/08/23 06:16:19 DEBUG : proton drive root link ID 'rclone-test-xigizoj8dure': Waiting for checks to finish 2025/08/23 06:16:19 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/08/23 06:16:19 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/08/23 06:16:19 DEBUG : proton drive root link ID 'rclone-test-xigizoj8dure': Waiting for renames to finish 2025/08/23 06:16:19 DEBUG : proton drive root link ID 'rclone-test-xigizoj8dure': Waiting for transfers to finish 2025/08/23 06:16:21 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/08/23 06:16:21 INFO : potato: Copied (new) 2025/08/23 06:16:21 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/08/23 06:16:21 INFO : yam: Copied (new) 2025/08/23 06:16:21 DEBUG : Waiting for deletions to finish 2025/08/23 06:16:22 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/23 06:16:22 INFO : proton drive root link ID 'rclone-test-xigizoj8dure': Making map for --track-renames 2025/08/23 06:16:22 INFO : proton drive root link ID 'rclone-test-xigizoj8dure': Finished making map for --track-renames 2025/08/23 06:16:22 DEBUG : proton drive root link ID 'rclone-test-xigizoj8dure': Waiting for checks to finish 2025/08/23 06:16:22 DEBUG : potato: Unchanged skipping 2025/08/23 06:16:22 DEBUG : proton drive root link ID 'rclone-test-xigizoj8dure': Waiting for renames to finish 2025/08/23 06:16:22.455488 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/8_r4Vxak2r2JFJIYqLLW8rhWNZLFl4Q0zARvGEX5uhrsazkt0bcd5ruOuBRNe5IzwiywC5RMjXBUEA8d3bed7g==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/23 06:16:22.455534 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/8_r4Vxak2r2JFJIYqLLW8rhWNZLFl4Q0zARvGEX5uhrsazkt0bcd5ruOuBRNe5IzwiywC5RMjXBUEA8d3bed7g==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/23 06:16:22 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/8_r4Vxak2r2JFJIYqLLW8rhWNZLFl4Q0zARvGEX5uhrsazkt0bcd5ruOuBRNe5IzwiywC5RMjXBUEA8d3bed7g==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/23 06:16:22 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/8_r4Vxak2r2JFJIYqLLW8rhWNZLFl4Q0zARvGEX5uhrsazkt0bcd5ruOuBRNe5IzwiywC5RMjXBUEA8d3bed7g==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/23 06:16:22 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/08/23 06:16:22 DEBUG : proton drive root link ID 'rclone-test-xigizoj8dure': Waiting for transfers to finish 2025/08/23 06:16:23 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/08/23 06:16:23 INFO : yaml: Copied (new) 2025/08/23 06:16:23 ERROR : proton drive root link ID 'rclone-test-xigizoj8dure': not deleting files as there were IO errors 2025/08/23 06:16:23 ERROR : proton drive root link ID 'rclone-test-xigizoj8dure': 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 (5.36s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:180: Remote "proton drive root link ID 'rclone-test-xigizoj8dure'", Local "Local file system at /tmp/rclone1075629447", Modify Window "1s" sync_test.go:1679: Can track renames: true 2025/08/23 06:16:25 INFO : proton drive root link ID 'rclone-test-xigizoj8dure': Making map for --track-renames 2025/08/23 06:16:25 INFO : proton drive root link ID 'rclone-test-xigizoj8dure': Finished making map for --track-renames 2025/08/23 06:16:25 DEBUG : proton drive root link ID 'rclone-test-xigizoj8dure': Waiting for checks to finish 2025/08/23 06:16:25 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/08/23 06:16:25 DEBUG : proton drive root link ID 'rclone-test-xigizoj8dure': Waiting for renames to finish 2025/08/23 06:16:25 DEBUG : sub/yam: Need to transfer - No matching file found at Destination 2025/08/23 06:16:25 DEBUG : proton drive root link ID 'rclone-test-xigizoj8dure': Waiting for transfers to finish 2025/08/23 06:16:26 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/08/23 06:16:26 INFO : potato: Copied (new) 2025/08/23 06:16:26 DEBUG : sub/yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/08/23 06:16:26 INFO : sub/yam: Copied (new) 2025/08/23 06:16:26 DEBUG : Waiting for deletions to finish 2025/08/23 06:16:27 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/23 06:16:27 DEBUG : potato: Unchanged skipping 2025/08/23 06:16:28 INFO : proton drive root link ID 'rclone-test-xigizoj8dure': Making map for --track-renames 2025/08/23 06:16:28 INFO : proton drive root link ID 'rclone-test-xigizoj8dure': Finished making map for --track-renames 2025/08/23 06:16:28 DEBUG : proton drive root link ID 'rclone-test-xigizoj8dure': Waiting for checks to finish 2025/08/23 06:16:28 DEBUG : proton drive root link ID 'rclone-test-xigizoj8dure': Waiting for renames to finish 2025/08/23 06:16:28.525111 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/1hXihMboPLp0SVElCXcBeneej08tOREUP76HpueWzH5zjkpQ7CwQRH6PNt-HA_bVJw1MFNSsRVyYjCBEIRIDVQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/23 06:16:28.525149 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/1hXihMboPLp0SVElCXcBeneej08tOREUP76HpueWzH5zjkpQ7CwQRH6PNt-HA_bVJw1MFNSsRVyYjCBEIRIDVQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/23 06:16:28 ERROR : sub/yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/1hXihMboPLp0SVElCXcBeneej08tOREUP76HpueWzH5zjkpQ7CwQRH6PNt-HA_bVJw1MFNSsRVyYjCBEIRIDVQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/23 06:16:28 DEBUG : yam: Failed to rename to "sub/yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/1hXihMboPLp0SVElCXcBeneej08tOREUP76HpueWzH5zjkpQ7CwQRH6PNt-HA_bVJw1MFNSsRVyYjCBEIRIDVQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/23 06:16:28 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/08/23 06:16:28 DEBUG : proton drive root link ID 'rclone-test-xigizoj8dure': Waiting for transfers to finish 2025/08/23 06:16:29 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/08/23 06:16:29 INFO : yam: Copied (new) 2025/08/23 06:16:29 ERROR : proton drive root link ID 'rclone-test-xigizoj8dure': not deleting files as there were IO errors 2025/08/23 06:16:29 ERROR : proton drive root link ID 'rclone-test-xigizoj8dure': 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 (6.63s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:180: Remote "proton drive root link ID 'rclone-test-xigizoj8dure'", Local "Local file system at /tmp/rclone1075629447", Modify Window "1s" 2025/08/23 06:16:31 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/08/23 06:16:31 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2025/08/23 06:16:31 DEBUG : proton drive root link ID 'rclone-test-xigizoj8dure': Waiting for checks to finish 2025/08/23 06:16:31 DEBUG : proton drive root link ID 'rclone-test-xigizoj8dure': Waiting for transfers to finish 2025/08/23 06:16:34 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/08/23 06:16:34 INFO : sub dir/hello world: Copied (new) 2025/08/23 06:16:34 INFO : sub dir/hello world: Deleted 2025/08/23 06:16:34 DEBUG : nested/sub dir/file: sha1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK 2025/08/23 06:16:34 INFO : nested/sub dir/file: Copied (new) 2025/08/23 06:16:34 INFO : nested/sub dir/file: Deleted 2025/08/23 06:16:34 ERROR : Local file system at /tmp/rclone1075629447: 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 (4.76s) === RUN TestServerSideMove run.go:180: Remote "proton drive root link ID 'rclone-test-xigizoj8dure'", Local "Local file system at /tmp/rclone1075629447", Modify Window "1s" 2025/08/23 06:16:36 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-gaqanep4vicu" 2025/08/23 06:16:36 DEBUG : proton drive root link ID 'rclone-test-gaqanep4vicu': Has cached credentials 2025/08/23 06:16:37 DEBUG : proton drive root link ID 'rclone-test-gaqanep4vicu': Used cached credential to initialize the ProtonDrive API sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-xigizoj8dure' -> proton drive root link ID 'rclone-test-gaqanep4vicu' 2025/08/23 06:16:45 DEBUG : proton drive root link ID 'rclone-test-gaqanep4vicu': Using server-side directory move 2025/08/23 06:16:45 INFO : proton drive root link ID 'rclone-test-gaqanep4vicu': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/08/23 06:16:45 DEBUG : potato2: Need to transfer - File not found at Destination 2025/08/23 06:16:45 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/08/23 06:16:45 DEBUG : empty space: Unchanged skipping 2025/08/23 06:16:45 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/08/23 06:16:45 DEBUG : proton drive root link ID 'rclone-test-gaqanep4vicu': Waiting for checks to finish 2025/08/23 06:16:45 INFO : empty space: Deleted 2025/08/23 06:16:45 DEBUG : proton drive root link ID 'rclone-test-gaqanep4vicu': Waiting for transfers to finish 2025/08/23 06:16:45 INFO : potato3: Deleted 2025/08/23 06:16:46.019770 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/28aSBGHg0OOjeIUJS_QMc9ZwJjSq-1twKsyYXx9zkBUpNLxWufz9W-0ZtCUQ61QpptmDTfNK5W4yqaFtNenYLw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/23 06:16:46.019819 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/28aSBGHg0OOjeIUJS_QMc9ZwJjSq-1twKsyYXx9zkBUpNLxWufz9W-0ZtCUQ61QpptmDTfNK5W4yqaFtNenYLw==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/23 06:16:46 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/28aSBGHg0OOjeIUJS_QMc9ZwJjSq-1twKsyYXx9zkBUpNLxWufz9W-0ZtCUQ61QpptmDTfNK5W4yqaFtNenYLw==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/23 06:16:46.123806 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/BEf3VAvBa5Ni3NPWnWDI07VblTPusg9KZKLqSReWxOdHegZ5f7MFaVFUftAerYLPu2-MFn3BKPg6B9dYwz2CNA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/23 06:16:46.123891 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/BEf3VAvBa5Ni3NPWnWDI07VblTPusg9KZKLqSReWxOdHegZ5f7MFaVFUftAerYLPu2-MFn3BKPg6B9dYwz2CNA==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/23 06:16:46 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/BEf3VAvBa5Ni3NPWnWDI07VblTPusg9KZKLqSReWxOdHegZ5f7MFaVFUftAerYLPu2-MFn3BKPg6B9dYwz2CNA==/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/BEf3VAvBa5Ni3NPWnWDI07VblTPusg9KZKLqSReWxOdHegZ5f7MFaVFUftAerYLPu2-MFn3BKPg6B9dYwz2CNA==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMove 2025/08/23 06:16:46 DEBUG : proton drive root link ID 'rclone-test-gaqanep4vicu': Purge remote --- FAIL: TestServerSideMove (11.19s) === RUN TestServerSideMoveWithFilter run.go:180: Remote "proton drive root link ID 'rclone-test-xigizoj8dure'", Local "Local file system at /tmp/rclone1075629447", Modify Window "1s" 2025/08/23 06:16:47 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-rezedit5qaqu" 2025/08/23 06:16:47 DEBUG : proton drive root link ID 'rclone-test-rezedit5qaqu': Has cached credentials 2025/08/23 06:16:48 DEBUG : proton drive root link ID 'rclone-test-rezedit5qaqu': Used cached credential to initialize the ProtonDrive API sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-xigizoj8dure' -> proton drive root link ID 'rclone-test-rezedit5qaqu' 2025/08/23 06:16:56 DEBUG : empty space: Excluded (Size Filter) 2025/08/23 06:16:56 DEBUG : empty space: Excluded 2025/08/23 06:16:56 DEBUG : empty space: Excluded (Size Filter) 2025/08/23 06:16:56 DEBUG : empty space: Excluded 2025/08/23 06:16:56 DEBUG : potato2: Need to transfer - File not found at Destination 2025/08/23 06:16:56 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/08/23 06:16:56 DEBUG : proton drive root link ID 'rclone-test-rezedit5qaqu': Waiting for checks to finish 2025/08/23 06:16:56 DEBUG : proton drive root link ID 'rclone-test-rezedit5qaqu': Waiting for transfers to finish 2025/08/23 06:16:57 INFO : potato3: Deleted 2025/08/23 06:16:57.244859 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/F-q4VF8ZM3RHEeWrFy9jMEhrLnzBVTYg_XnjP0hmb0xjLzU_Sk4dQSxqOMbzX2YvtfxpKSLmVHYGeFOcuLr-pA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/23 06:16:57.244894 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/F-q4VF8ZM3RHEeWrFy9jMEhrLnzBVTYg_XnjP0hmb0xjLzU_Sk4dQSxqOMbzX2YvtfxpKSLmVHYGeFOcuLr-pA==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/23 06:16:57 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/F-q4VF8ZM3RHEeWrFy9jMEhrLnzBVTYg_XnjP0hmb0xjLzU_Sk4dQSxqOMbzX2YvtfxpKSLmVHYGeFOcuLr-pA==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/23 06:16:57.328106 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/geJn2kQJJWxuznvnYoQSUuZpQp_rhiy2E_3jdcXKKANVqZyXcT5unbs8DKC_UMJYAhVVqLtd34qBKW_-ECsQMg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/23 06:16:57.328154 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/geJn2kQJJWxuznvnYoQSUuZpQp_rhiy2E_3jdcXKKANVqZyXcT5unbs8DKC_UMJYAhVVqLtd34qBKW_-ECsQMg==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/23 06:16:57 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/geJn2kQJJWxuznvnYoQSUuZpQp_rhiy2E_3jdcXKKANVqZyXcT5unbs8DKC_UMJYAhVVqLtd34qBKW_-ECsQMg==/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/geJn2kQJJWxuznvnYoQSUuZpQp_rhiy2E_3jdcXKKANVqZyXcT5unbs8DKC_UMJYAhVVqLtd34qBKW_-ECsQMg==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveWithFilter 2025/08/23 06:16:57 DEBUG : proton drive root link ID 'rclone-test-rezedit5qaqu': Purge remote --- FAIL: TestServerSideMoveWithFilter (11.48s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:180: Remote "proton drive root link ID 'rclone-test-xigizoj8dure'", Local "Local file system at /tmp/rclone1075629447", Modify Window "1s" 2025/08/23 06:16:59 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-nifebib6sura" 2025/08/23 06:16:59 DEBUG : proton drive root link ID 'rclone-test-nifebib6sura': Has cached credentials 2025/08/23 06:16:59 DEBUG : proton drive root link ID 'rclone-test-nifebib6sura': Used cached credential to initialize the ProtonDrive API 2025/08/23 06:17:03 INFO : tomatoDir: Making directory sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-xigizoj8dure' -> proton drive root link ID 'rclone-test-nifebib6sura' 2025/08/23 06:17:08 DEBUG : proton drive root link ID 'rclone-test-nifebib6sura': Using server-side directory move 2025/08/23 06:17:08 INFO : proton drive root link ID 'rclone-test-nifebib6sura': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/08/23 06:17:08 DEBUG : potato2: Need to transfer - File not found at Destination 2025/08/23 06:17:08 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/08/23 06:17:08 DEBUG : empty space: Unchanged skipping 2025/08/23 06:17:08 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/08/23 06:17:09 DEBUG : proton drive root link ID 'rclone-test-nifebib6sura': Waiting for checks to finish 2025/08/23 06:17:09 INFO : empty space: Deleted 2025/08/23 06:17:09 DEBUG : proton drive root link ID 'rclone-test-nifebib6sura': Waiting for transfers to finish 2025/08/23 06:17:09 INFO : potato3: Deleted 2025/08/23 06:17:09.400066 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/c6v829_O9Grhhguulwby-goLepEU--sDCVuuI097qIzPrbCewGvIFbNTomtNt6R3fbCndMzV0jcGCf5V53HxKg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/23 06:17:09.400115 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/c6v829_O9Grhhguulwby-goLepEU--sDCVuuI097qIzPrbCewGvIFbNTomtNt6R3fbCndMzV0jcGCf5V53HxKg==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/23 06:17:09 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/c6v829_O9Grhhguulwby-goLepEU--sDCVuuI097qIzPrbCewGvIFbNTomtNt6R3fbCndMzV0jcGCf5V53HxKg==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/23 06:17:09.493867 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Wi3JGzDFwiGPaP_QpwFJW8TKwXItrjQ4iWi0czGtQaPdOJH_Br06nliPBbFqrD1hbB4fbtkVflKoziLzMwvH9g==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/23 06:17:09.493901 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Wi3JGzDFwiGPaP_QpwFJW8TKwXItrjQ4iWi0czGtQaPdOJH_Br06nliPBbFqrD1hbB4fbtkVflKoziLzMwvH9g==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/23 06:17:09 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Wi3JGzDFwiGPaP_QpwFJW8TKwXItrjQ4iWi0czGtQaPdOJH_Br06nliPBbFqrD1hbB4fbtkVflKoziLzMwvH9g==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/23 06:17:09 ERROR : proton drive root link ID 'rclone-test-xigizoj8dure': 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/08/23 06:17:09 DEBUG : proton drive root link ID 'rclone-test-nifebib6sura': Purge remote --- FAIL: TestServerSideMoveDeleteEmptySourceDirs (12.26s) === RUN TestSyncBackupDir run.go:180: Remote "proton drive root link ID 'rclone-test-xigizoj8dure'", Local "Local file system at /tmp/rclone1075629447", Modify Window "1s" 2025/08/23 06:17:16 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-xigizoj8dure/dst" 2025/08/23 06:17:16 DEBUG : proton drive root link ID 'rclone-test-xigizoj8dure/dst': Has cached credentials 2025/08/23 06:17:17 DEBUG : proton drive root link ID 'rclone-test-xigizoj8dure/dst': Used cached credential to initialize the ProtonDrive API 2025/08/23 06:18:56 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-xigizoj8dure/backup" 2025/08/23 06:18:56 DEBUG : proton drive root link ID 'rclone-test-xigizoj8dure/backup': Has cached credentials 2025/08/23 06:18:57 DEBUG : proton drive root link ID 'rclone-test-xigizoj8dure/backup': Used cached credential to initialize the ProtonDrive API 2025/08/23 06:22:15 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/08/23 06:22:15 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/23 06:22:15 DEBUG : two: Unchanged skipping 2025/08/23 06:22:15 DEBUG : proton drive root link ID 'rclone-test-xigizoj8dure/dst': Waiting for checks to finish 2025/08/23 06:22:16.206912 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/6Qe0R_56g0Yrnu0PO62PDrTS3XvbjdS_gPloMSL3Qkum1pvPWZhi4qQKn-MIRrxrI95cuN_XZ_9zKtEEgip-HQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/23 06:22:16.206953 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/6Qe0R_56g0Yrnu0PO62PDrTS3XvbjdS_gPloMSL3Qkum1pvPWZhi4qQKn-MIRrxrI95cuN_XZ_9zKtEEgip-HQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/23 06:22:16 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/6Qe0R_56g0Yrnu0PO62PDrTS3XvbjdS_gPloMSL3Qkum1pvPWZhi4qQKn-MIRrxrI95cuN_XZ_9zKtEEgip-HQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/23 06:22:16 DEBUG : proton drive root link ID 'rclone-test-xigizoj8dure/dst': Waiting for transfers to finish 2025/08/23 06:22:16 ERROR : proton drive root link ID 'rclone-test-xigizoj8dure/dst': not deleting files as there were IO errors 2025/08/23 06:22:16 ERROR : proton drive root link ID 'rclone-test-xigizoj8dure/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/6Qe0R_56g0Yrnu0PO62PDrTS3XvbjdS_gPloMSL3Qkum1pvPWZhi4qQKn-MIRrxrI95cuN_XZ_9zKtEEgip-HQ==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDir --- FAIL: TestSyncBackupDir (307.00s) === RUN TestSyncBackupDirWithSuffix run.go:180: Remote "proton drive root link ID 'rclone-test-xigizoj8dure'", Local "Local file system at /tmp/rclone1075629447", Modify Window "1s" 2025/08/23 06:22:23 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-xigizoj8dure/dst" 2025/08/23 06:22:23 DEBUG : Config file has changed externally - reloading 2025/08/23 06:22:23 DEBUG : proton drive root link ID 'rclone-test-xigizoj8dure/dst': Has cached credentials 2025/08/23 06:22:24 DEBUG : proton drive root link ID 'rclone-test-xigizoj8dure/dst': Used cached credential to initialize the ProtonDrive API 2025/08/23 06:24:03 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-xigizoj8dure/backup" 2025/08/23 06:24:03 DEBUG : proton drive root link ID 'rclone-test-xigizoj8dure/backup': Has cached credentials 2025/08/23 06:24:04 DEBUG : proton drive root link ID 'rclone-test-xigizoj8dure/backup': Used cached credential to initialize the ProtonDrive API 2025/08/23 06:27:21 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/08/23 06:27:21 DEBUG : proton drive root link ID 'rclone-test-xigizoj8dure/dst': Waiting for checks to finish 2025/08/23 06:27:21 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/23 06:27:21 DEBUG : two: Unchanged skipping 2025/08/23 06:27:21.927682 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/C0wLSMMX1hhaEBtkUcUDDFFFjv5eNhr_w3DTrgQvS_wqXHcgobyi_nE4UPUp3EGXO7-73mIcXDuV5w_Wzr3dhQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/23 06:27:21.927780 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/C0wLSMMX1hhaEBtkUcUDDFFFjv5eNhr_w3DTrgQvS_wqXHcgobyi_nE4UPUp3EGXO7-73mIcXDuV5w_Wzr3dhQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/23 06:27:21 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/C0wLSMMX1hhaEBtkUcUDDFFFjv5eNhr_w3DTrgQvS_wqXHcgobyi_nE4UPUp3EGXO7-73mIcXDuV5w_Wzr3dhQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/23 06:27:21 DEBUG : proton drive root link ID 'rclone-test-xigizoj8dure/dst': Waiting for transfers to finish 2025/08/23 06:27:21 ERROR : proton drive root link ID 'rclone-test-xigizoj8dure/dst': not deleting files as there were IO errors 2025/08/23 06:27:21 ERROR : proton drive root link ID 'rclone-test-xigizoj8dure/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/C0wLSMMX1hhaEBtkUcUDDFFFjv5eNhr_w3DTrgQvS_wqXHcgobyi_nE4UPUp3EGXO7-73mIcXDuV5w_Wzr3dhQ==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirWithSuffix --- FAIL: TestSyncBackupDirWithSuffix (305.70s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:180: Remote "proton drive root link ID 'rclone-test-xigizoj8dure'", Local "Local file system at /tmp/rclone1075629447", Modify Window "1s" 2025/08/23 06:27:29 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-xigizoj8dure/dst" 2025/08/23 06:27:29 DEBUG : proton drive root link ID 'rclone-test-xigizoj8dure/dst': Has cached credentials 2025/08/23 06:27:29 DEBUG : proton drive root link ID 'rclone-test-xigizoj8dure/dst': Used cached credential to initialize the ProtonDrive API 2025/08/23 06:29:09 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-xigizoj8dure/backup" 2025/08/23 06:29:09 DEBUG : proton drive root link ID 'rclone-test-xigizoj8dure/backup': Has cached credentials 2025/08/23 06:29:09 DEBUG : proton drive root link ID 'rclone-test-xigizoj8dure/backup': Used cached credential to initialize the ProtonDrive API 2025/08/23 06:32:27 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/08/23 06:32:27 DEBUG : proton drive root link ID 'rclone-test-xigizoj8dure/dst': Waiting for checks to finish 2025/08/23 06:32:27 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/08/23 06:32:27 DEBUG : two: Unchanged skipping 2025/08/23 06:32:28.162830 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/OKx5va4LtMxgYF9ckbtlxcky4dEFVOyo1kpXl-sP6Gm-Y_VP6t-a47dJ5ytZyLgm-RAVfvMCYmZN6XMyMzXCUQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/23 06:32:28.162878 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/OKx5va4LtMxgYF9ckbtlxcky4dEFVOyo1kpXl-sP6Gm-Y_VP6t-a47dJ5ytZyLgm-RAVfvMCYmZN6XMyMzXCUQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/23 06:32:28 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/OKx5va4LtMxgYF9ckbtlxcky4dEFVOyo1kpXl-sP6Gm-Y_VP6t-a47dJ5ytZyLgm-RAVfvMCYmZN6XMyMzXCUQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/23 06:32:28 DEBUG : proton drive root link ID 'rclone-test-xigizoj8dure/dst': Waiting for transfers to finish 2025/08/23 06:32:28 ERROR : proton drive root link ID 'rclone-test-xigizoj8dure/dst': not deleting files as there were IO errors 2025/08/23 06:32:28 ERROR : proton drive root link ID 'rclone-test-xigizoj8dure/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/OKx5va4LtMxgYF9ckbtlxcky4dEFVOyo1kpXl-sP6Gm-Y_VP6t-a47dJ5ytZyLgm-RAVfvMCYmZN6XMyMzXCUQ==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirWithSuffixKeepExtension --- FAIL: TestSyncBackupDirWithSuffixKeepExtension (306.23s) === RUN TestSyncBackupDirSuffixOnly run.go:180: Remote "proton drive root link ID 'rclone-test-xigizoj8dure'", Local "Local file system at /tmp/rclone1075629447", Modify Window "1s" 2025/08/23 06:32:33.000034 WARN RESTY 502 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/dCIuMIOIX7R_fLQuUFB79QVQVuqwJ42rWq6u39mTq7u-460zGpnAKjlebUyX6erHHIfU94s7OInBdUcGLFC_nQ==/revisions/WREyS-x_V_TRC3E-JSKlY7gAc57LJss35DayKFA2Woc1ey-2Knvqmicpdv74MIFwWtrWqIaEBHhg89uKBVDvpw==: 502 Bad Gateway (Code=0, Status=502), Attempt 1 2025/08/23 06:32:33.000070 ERROR RESTY 502 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/dCIuMIOIX7R_fLQuUFB79QVQVuqwJ42rWq6u39mTq7u-460zGpnAKjlebUyX6erHHIfU94s7OInBdUcGLFC_nQ==/revisions/WREyS-x_V_TRC3E-JSKlY7gAc57LJss35DayKFA2Woc1ey-2Knvqmicpdv74MIFwWtrWqIaEBHhg89uKBVDvpw==: 502 Bad Gateway (Code=0, Status=502) run.go:285: Failed to put "dst/two" to "proton drive root link ID 'rclone-test-xigizoj8dure'": 502 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/files/dCIuMIOIX7R_fLQuUFB79QVQVuqwJ42rWq6u39mTq7u-460zGpnAKjlebUyX6erHHIfU94s7OInBdUcGLFC_nQ==/revisions/WREyS-x_V_TRC3E-JSKlY7gAc57LJss35DayKFA2Woc1ey-2Knvqmicpdv74MIFwWtrWqIaEBHhg89uKBVDvpw==: 502 Bad Gateway (Code=0, Status=502) --- FAIL: TestSyncBackupDirSuffixOnly (4.02s) === RUN TestSyncSuffix run.go:180: Remote "proton drive root link ID 'rclone-test-xigizoj8dure'", Local "Local file system at /tmp/rclone1075629447", Modify Window "1s" 2025/08/23 06:32:39 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-xigizoj8dure/dst" 2025/08/23 06:32:39 DEBUG : proton drive root link ID 'rclone-test-xigizoj8dure/dst': Has cached credentials 2025/08/23 06:32:39 DEBUG : proton drive root link ID 'rclone-test-xigizoj8dure/dst': Used cached credential to initialize the ProtonDrive API 2025/08/23 06:34:19 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/08/23 06:34:19.693792 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/kDv2fhwMSsbP4iF6czkWDrcl59rQAcUAVvpwTOJ_QjilE2jP2ABtWMAsjFulaO7uHEQ2_qBEtAuX9jcELHFUQw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/23 06:34:19.693832 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/kDv2fhwMSsbP4iF6czkWDrcl59rQAcUAVvpwTOJ_QjilE2jP2ABtWMAsjFulaO7uHEQ2_qBEtAuX9jcELHFUQw==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/23 06:34:19 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/kDv2fhwMSsbP4iF6czkWDrcl59rQAcUAVvpwTOJ_QjilE2jP2ABtWMAsjFulaO7uHEQ2_qBEtAuX9jcELHFUQw==/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/kDv2fhwMSsbP4iF6czkWDrcl59rQAcUAVvpwTOJ_QjilE2jP2ABtWMAsjFulaO7uHEQ2_qBEtAuX9jcELHFUQw==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncSuffix --- FAIL: TestSyncSuffix (107.25s) === RUN TestSyncSuffixKeepExtension run.go:180: Remote "proton drive root link ID 'rclone-test-xigizoj8dure'", Local "Local file system at /tmp/rclone1075629447", Modify Window "1s" 2025/08/23 06:34:26 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-xigizoj8dure/dst" 2025/08/23 06:34:26 DEBUG : proton drive root link ID 'rclone-test-xigizoj8dure/dst': Has cached credentials 2025/08/23 06:34:27 DEBUG : proton drive root link ID 'rclone-test-xigizoj8dure/dst': Used cached credential to initialize the ProtonDrive API 2025/08/23 06:36:07 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/08/23 06:36:08.124878 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/keBkhO_UlY0uXjQq793CUYFKL-fwMnQ3NGEhjBJ93kki5FbJjQ5JeDy3LO6VYzqhagvnExp8KhenTXOfz2iz6g==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/08/23 06:36:08.124919 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/keBkhO_UlY0uXjQq793CUYFKL-fwMnQ3NGEhjBJ93kki5FbJjQ5JeDy3LO6VYzqhagvnExp8KhenTXOfz2iz6g==/move: This value should not be blank. (Code=2000, Status=400) 2025/08/23 06:36:08 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/keBkhO_UlY0uXjQq793CUYFKL-fwMnQ3NGEhjBJ93kki5FbJjQ5JeDy3LO6VYzqhagvnExp8KhenTXOfz2iz6g==/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/keBkhO_UlY0uXjQq793CUYFKL-fwMnQ3NGEhjBJ93kki5FbJjQ5JeDy3LO6VYzqhagvnExp8KhenTXOfz2iz6g==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncSuffixKeepExtension --- FAIL: TestSyncSuffixKeepExtension (108.43s) FAIL 2025/08/23 06:36:09 DEBUG : proton drive root link ID 'rclone-test-xigizoj8dure': Purge remote "./sync.test -test.v -test.timeout 1h0m0s -remote TestProtonDrive: -verbose -test.run '^(TestMoveWithDeleteEmptySrcDirs|TestServerSideMove|TestServerSideMoveDeleteEmptySourceDirs|TestServerSideMoveOverSelf|TestServerSideMoveWithFilter|TestSyncBackupDir|TestSyncBackupDirSuffixOnly|TestSyncBackupDirWithSuffix|TestSyncBackupDirWithSuffixKeepExtension|TestSyncSuffix|TestSyncSuffixKeepExtension|TestSyncWithTrackRenames|TestSyncWithTrackRenamesStrategyLeaf|TestSyncWithTrackRenamesStrategyModtime)$'" - Finished ERROR in 20m10.189012975s (try 5/5): exit status 1: Failed [TestServerSideMoveOverSelf TestSyncWithTrackRenames TestSyncWithTrackRenamesStrategyModtime TestSyncWithTrackRenamesStrategyLeaf TestMoveWithDeleteEmptySrcDirs TestServerSideMove TestServerSideMoveWithFilter TestServerSideMoveDeleteEmptySourceDirs TestSyncBackupDir TestSyncBackupDirWithSuffix TestSyncBackupDirWithSuffixKeepExtension TestSyncBackupDirSuffixOnly TestSyncSuffix TestSyncSuffixKeepExtension]