"./sync.test -test.v -test.timeout 1h0m0s -remote TestProtonDrive: -verbose -test.run '^(TestBase64|TestManualTransformFile|TestMoveWithDeleteEmptySrcDirs|TestServerSideMove|TestServerSideMoveDeleteEmptySourceDirs|TestServerSideMoveOverSelf|TestServerSideMoveWithFilter|TestSyncBackupDir|TestSyncBackupDirSuffixOnly|TestSyncBackupDirWithSuffix|TestSyncBackupDirWithSuffixKeepExtension|TestSyncConcurrentDelete|TestSyncConcurrentTruncate|TestSyncSuffix|TestSyncSuffixKeepExtension|TestSyncWithTrackRenames|TestSyncWithTrackRenamesStrategyLeaf|TestSyncWithTrackRenamesStrategyModtime|TestTransformFile)$'" - Starting (try 2/5) 2025/07/02 05:50:51 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-hasiwip1mezo" 2025/07/02 05:50:51 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/07/02 05:50:51 DEBUG : proton drive root link ID 'rclone-test-hasiwip1mezo': Has cached credentials 2025/07/02 05:50:53 DEBUG : proton drive root link ID 'rclone-test-hasiwip1mezo': Used cached credential to initialize the ProtonDrive API 2025/07/02 05:50:54 DEBUG : Creating backend with remote "/tmp/rclone531292651" === RUN TestServerSideMoveOverSelf run.go:180: Remote "proton drive root link ID 'rclone-test-hasiwip1mezo'", Local "Local file system at /tmp/rclone531292651", Modify Window "1s" 2025/07/02 05:50:59 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-kifagif0wiri" 2025/07/02 05:50:59 DEBUG : proton drive root link ID 'rclone-test-kifagif0wiri': Has cached credentials 2025/07/02 05:51:01 DEBUG : proton drive root link ID 'rclone-test-kifagif0wiri': Used cached credential to initialize the ProtonDrive API sync_test.go:672: Server side copy (if possible) proton drive root link ID 'rclone-test-hasiwip1mezo' -> proton drive root link ID 'rclone-test-kifagif0wiri' 2025/07/02 05:51:03 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/07/02 05:51:03 DEBUG : proton drive root link ID 'rclone-test-kifagif0wiri': Waiting for checks to finish 2025/07/02 05:51:03 DEBUG : proton drive root link ID 'rclone-test-kifagif0wiri': Waiting for transfers to finish 2025/07/02 05:51:08 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/07/02 05:51:08 INFO : sub dir/hello world: Copied (new) 2025/07/02 05:51:11.609233 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/02 05:51:11.609289 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/02 05:51:15 DEBUG : proton drive root link ID 'rclone-test-kifagif0wiri': Using server-side directory move 2025/07/02 05:51:15 INFO : proton drive root link ID 'rclone-test-kifagif0wiri': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/07/02 05:51:16 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/07/02 05:51:16 DEBUG : proton drive root link ID 'rclone-test-kifagif0wiri': Waiting for checks to finish 2025/07/02 05:51:16 DEBUG : proton drive root link ID 'rclone-test-kifagif0wiri': Waiting for transfers to finish 2025/07/02 05:51:17 INFO : sub dir/hello world: Deleted 2025/07/02 05:51:18.787713 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/MxNqugr0iDQmGTLL51FbZQ6F5VRztXDTxh755LHUJBk4MBmWkNKwOTFSA7imNPYzEpdNEnRkGimWqzyrTSU2NQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/02 05:51:18.787806 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/MxNqugr0iDQmGTLL51FbZQ6F5VRztXDTxh755LHUJBk4MBmWkNKwOTFSA7imNPYzEpdNEnRkGimWqzyrTSU2NQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/02 05:51:18 ERROR : sub dir/hello world: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/MxNqugr0iDQmGTLL51FbZQ6F5VRztXDTxh755LHUJBk4MBmWkNKwOTFSA7imNPYzEpdNEnRkGimWqzyrTSU2NQ==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:685: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:685 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/MxNqugr0iDQmGTLL51FbZQ6F5VRztXDTxh755LHUJBk4MBmWkNKwOTFSA7imNPYzEpdNEnRkGimWqzyrTSU2NQ==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveOverSelf 2025/07/02 05:51:18 DEBUG : proton drive root link ID 'rclone-test-kifagif0wiri': Purge remote --- FAIL: TestServerSideMoveOverSelf (28.37s) === RUN TestSyncWithTrackRenames run.go:180: Remote "proton drive root link ID 'rclone-test-hasiwip1mezo'", Local "Local file system at /tmp/rclone531292651", Modify Window "1s" sync_test.go:1539: Can track renames: true 2025/07/02 05:51:23 INFO : proton drive root link ID 'rclone-test-hasiwip1mezo': Making map for --track-renames 2025/07/02 05:51:23 INFO : proton drive root link ID 'rclone-test-hasiwip1mezo': Finished making map for --track-renames 2025/07/02 05:51:23 DEBUG : proton drive root link ID 'rclone-test-hasiwip1mezo': Waiting for checks to finish 2025/07/02 05:51:23 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/07/02 05:51:23 DEBUG : proton drive root link ID 'rclone-test-hasiwip1mezo': Waiting for renames to finish 2025/07/02 05:51:23 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/07/02 05:51:23 DEBUG : proton drive root link ID 'rclone-test-hasiwip1mezo': Waiting for transfers to finish 2025/07/02 05:51:24 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/07/02 05:51:24 INFO : yam: Copied (new) 2025/07/02 05:51:24 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/07/02 05:51:24 INFO : potato: Copied (new) 2025/07/02 05:51:24 DEBUG : Waiting for deletions to finish 2025/07/02 05:51:26 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/02 05:51:26 INFO : proton drive root link ID 'rclone-test-hasiwip1mezo': Making map for --track-renames 2025/07/02 05:51:26 INFO : proton drive root link ID 'rclone-test-hasiwip1mezo': Finished making map for --track-renames 2025/07/02 05:51:26 DEBUG : proton drive root link ID 'rclone-test-hasiwip1mezo': Waiting for checks to finish 2025/07/02 05:51:26 DEBUG : potato: Unchanged skipping 2025/07/02 05:51:26 DEBUG : proton drive root link ID 'rclone-test-hasiwip1mezo': Waiting for renames to finish 2025/07/02 05:51:27.266872 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/vid1IWxe4xG2WGsWV5U7_7FAaS2hO3svLTXJrJhyhFlNMT8_fL70cfidfZxlD5ozUl85pwPk2eYqeZwcyjLELA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/02 05:51:27.266917 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/vid1IWxe4xG2WGsWV5U7_7FAaS2hO3svLTXJrJhyhFlNMT8_fL70cfidfZxlD5ozUl85pwPk2eYqeZwcyjLELA==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/02 05:51:27 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/vid1IWxe4xG2WGsWV5U7_7FAaS2hO3svLTXJrJhyhFlNMT8_fL70cfidfZxlD5ozUl85pwPk2eYqeZwcyjLELA==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/02 05:51:27 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/vid1IWxe4xG2WGsWV5U7_7FAaS2hO3svLTXJrJhyhFlNMT8_fL70cfidfZxlD5ozUl85pwPk2eYqeZwcyjLELA==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/02 05:51:27 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/07/02 05:51:27 DEBUG : proton drive root link ID 'rclone-test-hasiwip1mezo': Waiting for transfers to finish 2025/07/02 05:51:29 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/07/02 05:51:29 INFO : yaml: Copied (new) 2025/07/02 05:51:29 ERROR : proton drive root link ID 'rclone-test-hasiwip1mezo': not deleting files as there were IO errors 2025/07/02 05:51:29 ERROR : proton drive root link ID 'rclone-test-hasiwip1mezo': not deleting directories as there were IO errors sync_test.go:1557: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1557 Error: Received unexpected error: not deleting files as there were IO errors Test: TestSyncWithTrackRenames --- FAIL: TestSyncWithTrackRenames (10.08s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:180: Remote "proton drive root link ID 'rclone-test-hasiwip1mezo'", Local "Local file system at /tmp/rclone531292651", Modify Window "1s" sync_test.go:1611: Can track renames: true 2025/07/02 05:51:33 INFO : proton drive root link ID 'rclone-test-hasiwip1mezo': Making map for --track-renames 2025/07/02 05:51:33 INFO : proton drive root link ID 'rclone-test-hasiwip1mezo': Finished making map for --track-renames 2025/07/02 05:51:33 DEBUG : proton drive root link ID 'rclone-test-hasiwip1mezo': Waiting for checks to finish 2025/07/02 05:51:33 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/07/02 05:51:33 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/07/02 05:51:33 DEBUG : proton drive root link ID 'rclone-test-hasiwip1mezo': Waiting for renames to finish 2025/07/02 05:51:33 DEBUG : proton drive root link ID 'rclone-test-hasiwip1mezo': Waiting for transfers to finish 2025/07/02 05:51:34 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/07/02 05:51:34 INFO : yam: Copied (new) 2025/07/02 05:51:34 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/07/02 05:51:34 INFO : potato: Copied (new) 2025/07/02 05:51:34 DEBUG : Waiting for deletions to finish 2025/07/02 05:51:36 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/02 05:51:36 INFO : proton drive root link ID 'rclone-test-hasiwip1mezo': Making map for --track-renames 2025/07/02 05:51:36 INFO : proton drive root link ID 'rclone-test-hasiwip1mezo': Finished making map for --track-renames 2025/07/02 05:51:36 DEBUG : proton drive root link ID 'rclone-test-hasiwip1mezo': Waiting for checks to finish 2025/07/02 05:51:36 DEBUG : potato: Unchanged skipping 2025/07/02 05:51:36 DEBUG : proton drive root link ID 'rclone-test-hasiwip1mezo': Waiting for renames to finish 2025/07/02 05:51:37.579221 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/_sciW0BnNu3xuTNutTSreJm4Mv6CXja0jlkHIG9wCr4k5gnfsO5c1wxD7xMnr2ZpTUWlahSTBgprwBvadKnGAw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/02 05:51:37.579351 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/_sciW0BnNu3xuTNutTSreJm4Mv6CXja0jlkHIG9wCr4k5gnfsO5c1wxD7xMnr2ZpTUWlahSTBgprwBvadKnGAw==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/02 05:51:37 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/_sciW0BnNu3xuTNutTSreJm4Mv6CXja0jlkHIG9wCr4k5gnfsO5c1wxD7xMnr2ZpTUWlahSTBgprwBvadKnGAw==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/02 05:51:37 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/_sciW0BnNu3xuTNutTSreJm4Mv6CXja0jlkHIG9wCr4k5gnfsO5c1wxD7xMnr2ZpTUWlahSTBgprwBvadKnGAw==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/02 05:51:37 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/07/02 05:51:37 DEBUG : proton drive root link ID 'rclone-test-hasiwip1mezo': Waiting for transfers to finish 2025/07/02 05:51:39 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/07/02 05:51:39 INFO : yaml: Copied (new) 2025/07/02 05:51:39 ERROR : proton drive root link ID 'rclone-test-hasiwip1mezo': not deleting files as there were IO errors 2025/07/02 05:51:39 ERROR : proton drive root link ID 'rclone-test-hasiwip1mezo': not deleting directories as there were IO errors sync_test.go:1629: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1629 Error: Received unexpected error: not deleting files as there were IO errors Test: TestSyncWithTrackRenamesStrategyModtime --- FAIL: TestSyncWithTrackRenamesStrategyModtime (10.21s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:180: Remote "proton drive root link ID 'rclone-test-hasiwip1mezo'", Local "Local file system at /tmp/rclone531292651", Modify Window "1s" sync_test.go:1650: Can track renames: true 2025/07/02 05:51:43 INFO : proton drive root link ID 'rclone-test-hasiwip1mezo': Making map for --track-renames 2025/07/02 05:51:43 INFO : proton drive root link ID 'rclone-test-hasiwip1mezo': Finished making map for --track-renames 2025/07/02 05:51:43 DEBUG : proton drive root link ID 'rclone-test-hasiwip1mezo': Waiting for checks to finish 2025/07/02 05:51:43 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/07/02 05:51:43 DEBUG : sub/yam: Need to transfer - No matching file found at Destination 2025/07/02 05:51:43 DEBUG : proton drive root link ID 'rclone-test-hasiwip1mezo': Waiting for renames to finish 2025/07/02 05:51:43 DEBUG : proton drive root link ID 'rclone-test-hasiwip1mezo': Waiting for transfers to finish 2025/07/02 05:51:45 DEBUG : sub/yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/07/02 05:51:45 INFO : sub/yam: Copied (new) 2025/07/02 05:51:46 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/07/02 05:51:46 INFO : potato: Copied (new) 2025/07/02 05:51:46 DEBUG : Waiting for deletions to finish 2025/07/02 05:51:48 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/02 05:51:48 DEBUG : potato: Unchanged skipping 2025/07/02 05:51:48 INFO : proton drive root link ID 'rclone-test-hasiwip1mezo': Making map for --track-renames 2025/07/02 05:51:48 INFO : proton drive root link ID 'rclone-test-hasiwip1mezo': Finished making map for --track-renames 2025/07/02 05:51:48 DEBUG : proton drive root link ID 'rclone-test-hasiwip1mezo': Waiting for checks to finish 2025/07/02 05:51:48 DEBUG : proton drive root link ID 'rclone-test-hasiwip1mezo': Waiting for renames to finish 2025/07/02 05:51:49.986727 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/5TGWlvKXnKkQmI3vRrMoPkwGFZCbJfe8dsT0_-gG2WC8pntTI9lGpzEI2dNEuWiwiJAWtDoWz7_l0FyDEj5o_A==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/02 05:51:49.986764 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/5TGWlvKXnKkQmI3vRrMoPkwGFZCbJfe8dsT0_-gG2WC8pntTI9lGpzEI2dNEuWiwiJAWtDoWz7_l0FyDEj5o_A==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/02 05:51:49 ERROR : sub/yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/5TGWlvKXnKkQmI3vRrMoPkwGFZCbJfe8dsT0_-gG2WC8pntTI9lGpzEI2dNEuWiwiJAWtDoWz7_l0FyDEj5o_A==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/02 05:51:49 DEBUG : yam: Failed to rename to "sub/yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/5TGWlvKXnKkQmI3vRrMoPkwGFZCbJfe8dsT0_-gG2WC8pntTI9lGpzEI2dNEuWiwiJAWtDoWz7_l0FyDEj5o_A==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/02 05:51:49 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/07/02 05:51:49 DEBUG : proton drive root link ID 'rclone-test-hasiwip1mezo': Waiting for transfers to finish 2025/07/02 05:51:51 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/07/02 05:51:51 INFO : yam: Copied (new) 2025/07/02 05:51:51 ERROR : proton drive root link ID 'rclone-test-hasiwip1mezo': not deleting files as there were IO errors 2025/07/02 05:51:51 ERROR : proton drive root link ID 'rclone-test-hasiwip1mezo': not deleting directories as there were IO errors sync_test.go:1668: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1668 Error: Received unexpected error: not deleting files as there were IO errors Test: TestSyncWithTrackRenamesStrategyLeaf --- FAIL: TestSyncWithTrackRenamesStrategyLeaf (13.73s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:180: Remote "proton drive root link ID 'rclone-test-hasiwip1mezo'", Local "Local file system at /tmp/rclone531292651", Modify Window "1s" 2025/07/02 05:51:57 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/07/02 05:51:57 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2025/07/02 05:51:57 DEBUG : proton drive root link ID 'rclone-test-hasiwip1mezo': Waiting for checks to finish 2025/07/02 05:51:57 DEBUG : proton drive root link ID 'rclone-test-hasiwip1mezo': Waiting for transfers to finish 2025/07/02 05:52:02 DEBUG : nested/sub dir/file: sha1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK 2025/07/02 05:52:02 INFO : nested/sub dir/file: Copied (new) 2025/07/02 05:52:02 INFO : nested/sub dir/file: Deleted 2025/07/02 05:52:02 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/07/02 05:52:02 INFO : sub dir/hello world: Copied (new) 2025/07/02 05:52:02 INFO : sub dir/hello world: Deleted 2025/07/02 05:52:02 ERROR : Local file system at /tmp/rclone531292651: not deleting directories as there were IO errors sync_test.go:1789: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1789 Error: Received unexpected error: not deleting directories as there were IO errors Test: TestMoveWithDeleteEmptySrcDirs --- FAIL: TestMoveWithDeleteEmptySrcDirs (10.79s) === RUN TestServerSideMove run.go:180: Remote "proton drive root link ID 'rclone-test-hasiwip1mezo'", Local "Local file system at /tmp/rclone531292651", Modify Window "1s" 2025/07/02 05:52:07 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-nozecas5jevi" 2025/07/02 05:52:07 DEBUG : proton drive root link ID 'rclone-test-nozecas5jevi': Has cached credentials 2025/07/02 05:52:09 DEBUG : proton drive root link ID 'rclone-test-nozecas5jevi': Used cached credential to initialize the ProtonDrive API sync_test.go:1706: Server side move (if possible) proton drive root link ID 'rclone-test-hasiwip1mezo' -> proton drive root link ID 'rclone-test-nozecas5jevi' 2025/07/02 05:52:22 DEBUG : proton drive root link ID 'rclone-test-nozecas5jevi': Using server-side directory move 2025/07/02 05:52:22 INFO : proton drive root link ID 'rclone-test-nozecas5jevi': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/07/02 05:52:23 DEBUG : potato2: Need to transfer - File not found at Destination 2025/07/02 05:52:23 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/07/02 05:52:23 DEBUG : empty space: Unchanged skipping 2025/07/02 05:52:23 DEBUG : proton drive root link ID 'rclone-test-nozecas5jevi': Waiting for checks to finish 2025/07/02 05:52:23 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/07/02 05:52:24 INFO : empty space: Deleted 2025/07/02 05:52:24 DEBUG : proton drive root link ID 'rclone-test-nozecas5jevi': Waiting for transfers to finish 2025/07/02 05:52:24 INFO : potato3: Deleted 2025/07/02 05:52:24.926066 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/cK_TF45r8Q2KA_pNqm34yXTqyHiPif64Kp2WPPQ9uId4K89c_2Lo5WfdaVTj5F_28GYaHUkURmNFGuJY8eY0Nw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/02 05:52:24.926100 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/cK_TF45r8Q2KA_pNqm34yXTqyHiPif64Kp2WPPQ9uId4K89c_2Lo5WfdaVTj5F_28GYaHUkURmNFGuJY8eY0Nw==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/02 05:52:24 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/cK_TF45r8Q2KA_pNqm34yXTqyHiPif64Kp2WPPQ9uId4K89c_2Lo5WfdaVTj5F_28GYaHUkURmNFGuJY8eY0Nw==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/02 05:52:25.382226 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/9R7mU-zb4uC7neyPnxvuQzAml6_tGgg-ZHRwcnNCxl7V_KjpRZ9QKVLHlJFRQRwxdIsprEiK_IAjyGQ09apiJw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/02 05:52:25.382295 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/9R7mU-zb4uC7neyPnxvuQzAml6_tGgg-ZHRwcnNCxl7V_KjpRZ9QKVLHlJFRQRwxdIsprEiK_IAjyGQ09apiJw==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/02 05:52:25 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/9R7mU-zb4uC7neyPnxvuQzAml6_tGgg-ZHRwcnNCxl7V_KjpRZ9QKVLHlJFRQRwxdIsprEiK_IAjyGQ09apiJw==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:1717: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1717 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1882 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/9R7mU-zb4uC7neyPnxvuQzAml6_tGgg-ZHRwcnNCxl7V_KjpRZ9QKVLHlJFRQRwxdIsprEiK_IAjyGQ09apiJw==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMove 2025/07/02 05:52:25 DEBUG : proton drive root link ID 'rclone-test-nozecas5jevi': Purge remote --- FAIL: TestServerSideMove (21.58s) === RUN TestServerSideMoveWithFilter run.go:180: Remote "proton drive root link ID 'rclone-test-hasiwip1mezo'", Local "Local file system at /tmp/rclone531292651", Modify Window "1s" 2025/07/02 05:52:29 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-jodelov1kiya" 2025/07/02 05:52:29 DEBUG : proton drive root link ID 'rclone-test-jodelov1kiya': Has cached credentials 2025/07/02 05:52:31 DEBUG : proton drive root link ID 'rclone-test-jodelov1kiya': Used cached credential to initialize the ProtonDrive API sync_test.go:1706: Server side move (if possible) proton drive root link ID 'rclone-test-hasiwip1mezo' -> proton drive root link ID 'rclone-test-jodelov1kiya' 2025/07/02 05:52:45 DEBUG : empty space: Excluded (Size Filter) 2025/07/02 05:52:45 DEBUG : empty space: Excluded 2025/07/02 05:52:46 DEBUG : empty space: Excluded (Size Filter) 2025/07/02 05:52:46 DEBUG : empty space: Excluded 2025/07/02 05:52:46 DEBUG : potato2: Need to transfer - File not found at Destination 2025/07/02 05:52:46 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/07/02 05:52:46 DEBUG : proton drive root link ID 'rclone-test-jodelov1kiya': Waiting for checks to finish 2025/07/02 05:52:46 DEBUG : proton drive root link ID 'rclone-test-jodelov1kiya': Waiting for transfers to finish 2025/07/02 05:52:46 INFO : potato3: Deleted 2025/07/02 05:52:47.058062 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/ZKPu8JihFpQj1qgyYc8m4-pioqIbpmJYBY8i_F811pEzybA1D6fPd9SSz5Dj_BbUtPc3vBTpI-fv_G2wpzCTOQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/02 05:52:47.058155 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/ZKPu8JihFpQj1qgyYc8m4-pioqIbpmJYBY8i_F811pEzybA1D6fPd9SSz5Dj_BbUtPc3vBTpI-fv_G2wpzCTOQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/02 05:52:47 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/ZKPu8JihFpQj1qgyYc8m4-pioqIbpmJYBY8i_F811pEzybA1D6fPd9SSz5Dj_BbUtPc3vBTpI-fv_G2wpzCTOQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/02 05:52:47.280284 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/blo6A_-iYDCBtlQeHmgJ4HCRri6FWWHcHMcayxFgQNXuYXWsvUjMQRKbHEmupCyqhkvBwe4VHqLgB3bZD_zs-Q==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/02 05:52:47.280314 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/blo6A_-iYDCBtlQeHmgJ4HCRri6FWWHcHMcayxFgQNXuYXWsvUjMQRKbHEmupCyqhkvBwe4VHqLgB3bZD_zs-Q==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/02 05:52:47 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/blo6A_-iYDCBtlQeHmgJ4HCRri6FWWHcHMcayxFgQNXuYXWsvUjMQRKbHEmupCyqhkvBwe4VHqLgB3bZD_zs-Q==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:1717: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1717 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1895 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/blo6A_-iYDCBtlQeHmgJ4HCRri6FWWHcHMcayxFgQNXuYXWsvUjMQRKbHEmupCyqhkvBwe4VHqLgB3bZD_zs-Q==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveWithFilter 2025/07/02 05:52:47 DEBUG : proton drive root link ID 'rclone-test-jodelov1kiya': Purge remote --- FAIL: TestServerSideMoveWithFilter (22.53s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:180: Remote "proton drive root link ID 'rclone-test-hasiwip1mezo'", Local "Local file system at /tmp/rclone531292651", Modify Window "1s" 2025/07/02 05:52:51 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-fexukow1hifu" 2025/07/02 05:52:51 DEBUG : proton drive root link ID 'rclone-test-fexukow1hifu': Has cached credentials 2025/07/02 05:52:53 DEBUG : proton drive root link ID 'rclone-test-fexukow1hifu': Used cached credential to initialize the ProtonDrive API 2025/07/02 05:53:00 INFO : tomatoDir: Making directory sync_test.go:1706: Server side move (if possible) proton drive root link ID 'rclone-test-hasiwip1mezo' -> proton drive root link ID 'rclone-test-fexukow1hifu' 2025/07/02 05:53:08 DEBUG : proton drive root link ID 'rclone-test-fexukow1hifu': Using server-side directory move 2025/07/02 05:53:08 INFO : proton drive root link ID 'rclone-test-fexukow1hifu': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/07/02 05:53:10 DEBUG : potato2: Need to transfer - File not found at Destination 2025/07/02 05:53:10 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/07/02 05:53:10 DEBUG : empty space: Unchanged skipping 2025/07/02 05:53:10 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/07/02 05:53:10 DEBUG : proton drive root link ID 'rclone-test-fexukow1hifu': Waiting for checks to finish 2025/07/02 05:53:10 INFO : empty space: Deleted 2025/07/02 05:53:10 DEBUG : proton drive root link ID 'rclone-test-fexukow1hifu': Waiting for transfers to finish 2025/07/02 05:53:10 INFO : potato3: Deleted 2025/07/02 05:53:11.169201 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/7oIoDbHJp1S4wYiuZdfkL6Qz6eLmN_nVQGW86U72q19-mxjknB6SyyhIfF7EeLl1VoMKkPakqiDHDDIYrM0DyA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/02 05:53:11.169252 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/7oIoDbHJp1S4wYiuZdfkL6Qz6eLmN_nVQGW86U72q19-mxjknB6SyyhIfF7EeLl1VoMKkPakqiDHDDIYrM0DyA==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/02 05:53:11 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/7oIoDbHJp1S4wYiuZdfkL6Qz6eLmN_nVQGW86U72q19-mxjknB6SyyhIfF7EeLl1VoMKkPakqiDHDDIYrM0DyA==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/02 05:53:11.504297 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Ib6P74fKn7LRxjRgkOpsB0ZWpXijOsU9HCgTLoKgZApkf0w_yAqG98qrWHZj7KZvMypD-6dVw9rDV0dr3wqARQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/02 05:53:11.504330 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Ib6P74fKn7LRxjRgkOpsB0ZWpXijOsU9HCgTLoKgZApkf0w_yAqG98qrWHZj7KZvMypD-6dVw9rDV0dr3wqARQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/02 05:53:11 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Ib6P74fKn7LRxjRgkOpsB0ZWpXijOsU9HCgTLoKgZApkf0w_yAqG98qrWHZj7KZvMypD-6dVw9rDV0dr3wqARQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/02 05:53:11 ERROR : proton drive root link ID 'rclone-test-hasiwip1mezo': not deleting directories as there were IO errors sync_test.go:1717: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1717 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1902 Error: Received unexpected error: not deleting directories as there were IO errors Test: TestServerSideMoveDeleteEmptySourceDirs 2025/07/02 05:53:11 DEBUG : proton drive root link ID 'rclone-test-fexukow1hifu': Purge remote --- FAIL: TestServerSideMoveDeleteEmptySourceDirs (24.62s) === RUN TestSyncBackupDir run.go:180: Remote "proton drive root link ID 'rclone-test-hasiwip1mezo'", Local "Local file system at /tmp/rclone531292651", Modify Window "1s" 2025/07/02 05:53:24 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-hasiwip1mezo/dst" 2025/07/02 05:53:24 DEBUG : proton drive root link ID 'rclone-test-hasiwip1mezo/dst': Has cached credentials 2025/07/02 05:53:26 DEBUG : proton drive root link ID 'rclone-test-hasiwip1mezo/dst': Used cached credential to initialize the ProtonDrive API 2025/07/02 05:54:48 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-hasiwip1mezo/backup" 2025/07/02 05:54:48 DEBUG : proton drive root link ID 'rclone-test-hasiwip1mezo/backup': Has cached credentials 2025/07/02 05:54:50 DEBUG : proton drive root link ID 'rclone-test-hasiwip1mezo/backup': Used cached credential to initialize the ProtonDrive API 2025/07/02 05:57:04 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/07/02 05:57:04 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/02 05:57:04 DEBUG : two: Unchanged skipping 2025/07/02 05:57:04 DEBUG : proton drive root link ID 'rclone-test-hasiwip1mezo/dst': Waiting for checks to finish 2025/07/02 05:57:07.127845 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/G9O7iBTzO84VRUH-msNfrkqlvmx0vFtImBo770JSs0O9HEuqPlnmwwyq6PFbmHXmR32-5cnQ9GDM5_SGnPEO1A==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/02 05:57:07.127883 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/G9O7iBTzO84VRUH-msNfrkqlvmx0vFtImBo770JSs0O9HEuqPlnmwwyq6PFbmHXmR32-5cnQ9GDM5_SGnPEO1A==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/02 05:57:07 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/G9O7iBTzO84VRUH-msNfrkqlvmx0vFtImBo770JSs0O9HEuqPlnmwwyq6PFbmHXmR32-5cnQ9GDM5_SGnPEO1A==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/02 05:57:07 DEBUG : proton drive root link ID 'rclone-test-hasiwip1mezo/dst': Waiting for transfers to finish 2025/07/02 05:57:07 ERROR : proton drive root link ID 'rclone-test-hasiwip1mezo/dst': not deleting files as there were IO errors 2025/07/02 05:57:07 ERROR : proton drive root link ID 'rclone-test-hasiwip1mezo/dst': not deleting directories as there were IO errors sync_test.go:2386: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2386 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2428 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/G9O7iBTzO84VRUH-msNfrkqlvmx0vFtImBo770JSs0O9HEuqPlnmwwyq6PFbmHXmR32-5cnQ9GDM5_SGnPEO1A==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDir --- FAIL: TestSyncBackupDir (236.94s) === RUN TestSyncBackupDirWithSuffix run.go:180: Remote "proton drive root link ID 'rclone-test-hasiwip1mezo'", Local "Local file system at /tmp/rclone531292651", Modify Window "1s" 2025/07/02 05:57:21 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-hasiwip1mezo/dst" 2025/07/02 05:57:21 DEBUG : proton drive root link ID 'rclone-test-hasiwip1mezo/dst': Has cached credentials 2025/07/02 05:57:23 DEBUG : proton drive root link ID 'rclone-test-hasiwip1mezo/dst': Used cached credential to initialize the ProtonDrive API 2025/07/02 05:58:30 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-hasiwip1mezo/backup" 2025/07/02 05:58:30 DEBUG : proton drive root link ID 'rclone-test-hasiwip1mezo/backup': Has cached credentials 2025/07/02 05:58:32 DEBUG : proton drive root link ID 'rclone-test-hasiwip1mezo/backup': Used cached credential to initialize the ProtonDrive API 2025/07/02 06:00:47 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/07/02 06:00:47 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/02 06:00:47 DEBUG : two: Unchanged skipping 2025/07/02 06:00:47 DEBUG : proton drive root link ID 'rclone-test-hasiwip1mezo/dst': Waiting for checks to finish 2025/07/02 06:00:50.469721 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/wrNaTItNliu7DRA0FOF7uZ0sj3m6QLqAqbZsv46MMbwXfO9eD4CU2Y4jfxunLWIIREV6sgnIcsk31m5QMzSPlA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/02 06:00:50.469749 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/wrNaTItNliu7DRA0FOF7uZ0sj3m6QLqAqbZsv46MMbwXfO9eD4CU2Y4jfxunLWIIREV6sgnIcsk31m5QMzSPlA==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/02 06:00:50 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/wrNaTItNliu7DRA0FOF7uZ0sj3m6QLqAqbZsv46MMbwXfO9eD4CU2Y4jfxunLWIIREV6sgnIcsk31m5QMzSPlA==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/02 06:00:50 DEBUG : proton drive root link ID 'rclone-test-hasiwip1mezo/dst': Waiting for transfers to finish 2025/07/02 06:00:50 ERROR : proton drive root link ID 'rclone-test-hasiwip1mezo/dst': not deleting files as there were IO errors 2025/07/02 06:00:50 ERROR : proton drive root link ID 'rclone-test-hasiwip1mezo/dst': not deleting directories as there were IO errors sync_test.go:2386: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2386 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2432 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/wrNaTItNliu7DRA0FOF7uZ0sj3m6QLqAqbZsv46MMbwXfO9eD4CU2Y4jfxunLWIIREV6sgnIcsk31m5QMzSPlA==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirWithSuffix --- FAIL: TestSyncBackupDirWithSuffix (222.54s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:180: Remote "proton drive root link ID 'rclone-test-hasiwip1mezo'", Local "Local file system at /tmp/rclone531292651", Modify Window "1s" 2025/07/02 06:01:04 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-hasiwip1mezo/dst" 2025/07/02 06:01:04 DEBUG : Config file has changed externally - reloading 2025/07/02 06:01:04 DEBUG : proton drive root link ID 'rclone-test-hasiwip1mezo/dst': Has cached credentials 2025/07/02 06:01:06 DEBUG : proton drive root link ID 'rclone-test-hasiwip1mezo/dst': Used cached credential to initialize the ProtonDrive API 2025/07/02 06:02:13 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-hasiwip1mezo/backup" 2025/07/02 06:02:13 DEBUG : proton drive root link ID 'rclone-test-hasiwip1mezo/backup': Has cached credentials 2025/07/02 06:02:15 DEBUG : proton drive root link ID 'rclone-test-hasiwip1mezo/backup': Used cached credential to initialize the ProtonDrive API 2025/07/02 06:04:29 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/07/02 06:04:29 DEBUG : proton drive root link ID 'rclone-test-hasiwip1mezo/dst': Waiting for checks to finish 2025/07/02 06:04:29 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/02 06:04:29 DEBUG : two: Unchanged skipping 2025/07/02 06:04:31.510925 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/P5d-CetqdiLl0QlKuGmHNjc0KquVDMfZSJoVFUCU4GyZXnaZ9XSI0aD533Jt4uTVukA79vWRJUg0QvZ8lTowdg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/02 06:04:31.510970 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/P5d-CetqdiLl0QlKuGmHNjc0KquVDMfZSJoVFUCU4GyZXnaZ9XSI0aD533Jt4uTVukA79vWRJUg0QvZ8lTowdg==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/02 06:04:31 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/P5d-CetqdiLl0QlKuGmHNjc0KquVDMfZSJoVFUCU4GyZXnaZ9XSI0aD533Jt4uTVukA79vWRJUg0QvZ8lTowdg==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/02 06:04:31 DEBUG : proton drive root link ID 'rclone-test-hasiwip1mezo/dst': Waiting for transfers to finish 2025/07/02 06:04:31 ERROR : proton drive root link ID 'rclone-test-hasiwip1mezo/dst': not deleting files as there were IO errors 2025/07/02 06:04:31 ERROR : proton drive root link ID 'rclone-test-hasiwip1mezo/dst': not deleting directories as there were IO errors sync_test.go:2386: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2386 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2436 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/P5d-CetqdiLl0QlKuGmHNjc0KquVDMfZSJoVFUCU4GyZXnaZ9XSI0aD533Jt4uTVukA79vWRJUg0QvZ8lTowdg==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirWithSuffixKeepExtension --- FAIL: TestSyncBackupDirWithSuffixKeepExtension (221.08s) === RUN TestSyncBackupDirSuffixOnly run.go:180: Remote "proton drive root link ID 'rclone-test-hasiwip1mezo'", Local "Local file system at /tmp/rclone531292651", Modify Window "1s" 2025/07/02 06:04:45 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-hasiwip1mezo/dst" 2025/07/02 06:04:45 DEBUG : proton drive root link ID 'rclone-test-hasiwip1mezo/dst': Has cached credentials 2025/07/02 06:04:47 DEBUG : proton drive root link ID 'rclone-test-hasiwip1mezo/dst': Used cached credential to initialize the ProtonDrive API 2025/07/02 06:05:55 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/07/02 06:05:55 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/02 06:05:55 DEBUG : two: Unchanged skipping 2025/07/02 06:05:55 DEBUG : proton drive root link ID 'rclone-test-hasiwip1mezo/dst': Waiting for checks to finish 2025/07/02 06:05:55.997629 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/ayRoLQcJp9vZ_l6D_d9bpaNBiIIvfY6RfB7eIV4z_jqBCaHjttXzeU9McfRFfT5Um3q0dpEj8pK9r7vNJBavJg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/02 06:05:55.997665 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/ayRoLQcJp9vZ_l6D_d9bpaNBiIIvfY6RfB7eIV4z_jqBCaHjttXzeU9McfRFfT5Um3q0dpEj8pK9r7vNJBavJg==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/02 06:05:55 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/ayRoLQcJp9vZ_l6D_d9bpaNBiIIvfY6RfB7eIV4z_jqBCaHjttXzeU9McfRFfT5Um3q0dpEj8pK9r7vNJBavJg==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/02 06:05:55 DEBUG : proton drive root link ID 'rclone-test-hasiwip1mezo/dst': Waiting for transfers to finish 2025/07/02 06:05:55 ERROR : proton drive root link ID 'rclone-test-hasiwip1mezo/dst': not deleting files as there were IO errors 2025/07/02 06:05:55 ERROR : proton drive root link ID 'rclone-test-hasiwip1mezo/dst': not deleting directories as there were IO errors sync_test.go:2386: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2386 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2440 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/ayRoLQcJp9vZ_l6D_d9bpaNBiIIvfY6RfB7eIV4z_jqBCaHjttXzeU9McfRFfT5Um3q0dpEj8pK9r7vNJBavJg==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirSuffixOnly --- FAIL: TestSyncBackupDirSuffixOnly (83.61s) === RUN TestSyncSuffix run.go:180: Remote "proton drive root link ID 'rclone-test-hasiwip1mezo'", Local "Local file system at /tmp/rclone531292651", Modify Window "1s" 2025/07/02 06:06:08 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-hasiwip1mezo/dst" 2025/07/02 06:06:08 DEBUG : proton drive root link ID 'rclone-test-hasiwip1mezo/dst': Has cached credentials 2025/07/02 06:06:10 DEBUG : proton drive root link ID 'rclone-test-hasiwip1mezo/dst': Used cached credential to initialize the ProtonDrive API 2025/07/02 06:07:16 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/07/02 06:07:17.995702 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/XcWbeU-eDRSjresJnsGCbM7ywmVUzvL0j5skpWLaO30IxDdD7V6LVxRrA2JNJj2RpEAltbQEhBMZL0UlwoIsGA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/02 06:07:17.995729 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/XcWbeU-eDRSjresJnsGCbM7ywmVUzvL0j5skpWLaO30IxDdD7V6LVxRrA2JNJj2RpEAltbQEhBMZL0UlwoIsGA==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/02 06:07:17 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/XcWbeU-eDRSjresJnsGCbM7ywmVUzvL0j5skpWLaO30IxDdD7V6LVxRrA2JNJj2RpEAltbQEhBMZL0UlwoIsGA==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:2474: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2474 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2524 Error: Received unexpected error: moving to --backup-dir failed: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/XcWbeU-eDRSjresJnsGCbM7ywmVUzvL0j5skpWLaO30IxDdD7V6LVxRrA2JNJj2RpEAltbQEhBMZL0UlwoIsGA==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncSuffix --- FAIL: TestSyncSuffix (82.01s) === RUN TestSyncSuffixKeepExtension run.go:180: Remote "proton drive root link ID 'rclone-test-hasiwip1mezo'", Local "Local file system at /tmp/rclone531292651", Modify Window "1s" 2025/07/02 06:07:30 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-hasiwip1mezo/dst" 2025/07/02 06:07:30 DEBUG : proton drive root link ID 'rclone-test-hasiwip1mezo/dst': Has cached credentials 2025/07/02 06:07:33 DEBUG : proton drive root link ID 'rclone-test-hasiwip1mezo/dst': Used cached credential to initialize the ProtonDrive API 2025/07/02 06:08:41 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/07/02 06:08:42.175688 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/0L2Taf6VtBnLsit19EMSAU6JogJxzSXrF6V1sPM0Q-0NX4ZpJCQy1rsqoSrC_879PLDZSo0c7FDO0agEc3SEpA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/02 06:08:42.175720 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/0L2Taf6VtBnLsit19EMSAU6JogJxzSXrF6V1sPM0Q-0NX4ZpJCQy1rsqoSrC_879PLDZSo0c7FDO0agEc3SEpA==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/02 06:08:42 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/0L2Taf6VtBnLsit19EMSAU6JogJxzSXrF6V1sPM0Q-0NX4ZpJCQy1rsqoSrC_879PLDZSo0c7FDO0agEc3SEpA==/move: This value should not be blank. (Code=2000, Status=400) sync_test.go:2474: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2474 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2525 Error: Received unexpected error: moving to --backup-dir failed: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/0L2Taf6VtBnLsit19EMSAU6JogJxzSXrF6V1sPM0Q-0NX4ZpJCQy1rsqoSrC_879PLDZSo0c7FDO0agEc3SEpA==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncSuffixKeepExtension --- FAIL: TestSyncSuffixKeepExtension (84.59s) === RUN TestSyncConcurrentDelete run.go:180: Remote "proton drive root link ID 'rclone-test-hasiwip1mezo'", Local "Local file system at /tmp/rclone531292651", Modify Window "1s" 2025/07/02 06:10:16 DEBUG : both10: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/02 06:10:16 DEBUG : both12: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/02 06:10:16 DEBUG : both0: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/02 06:10:16 DEBUG : both11: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/02 06:10:16 DEBUG : both10: Unchanged skipping 2025/07/02 06:10:16 DEBUG : both13: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/02 06:10:16 DEBUG : both13: Unchanged skipping 2025/07/02 06:10:16 DEBUG : both14: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/02 06:10:16 DEBUG : both14: Unchanged skipping 2025/07/02 06:10:16 DEBUG : both15: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/02 06:10:16 DEBUG : both15: Unchanged skipping 2025/07/02 06:10:16 DEBUG : both16: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/02 06:10:16 DEBUG : both16: Unchanged skipping 2025/07/02 06:10:16 DEBUG : both17: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/02 06:10:16 DEBUG : both17: Unchanged skipping 2025/07/02 06:10:16 DEBUG : both18: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/02 06:10:16 DEBUG : proton drive root link ID 'rclone-test-hasiwip1mezo': Waiting for checks to finish 2025/07/02 06:10:16 DEBUG : both18: Unchanged skipping 2025/07/02 06:10:16 DEBUG : both19: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/02 06:10:16 DEBUG : both11: Unchanged skipping 2025/07/02 06:10:16 DEBUG : both1: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/02 06:10:16 DEBUG : both12: Unchanged skipping 2025/07/02 06:10:16 DEBUG : both2: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/02 06:10:16 DEBUG : both0: Unchanged skipping 2025/07/02 06:10:16 DEBUG : both3: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/02 06:10:16 DEBUG : both19: Unchanged skipping 2025/07/02 06:10:16 DEBUG : both4: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/02 06:10:16 DEBUG : both4: Unchanged skipping 2025/07/02 06:10:16 DEBUG : both5: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/02 06:10:16 DEBUG : both1: Unchanged skipping 2025/07/02 06:10:16 DEBUG : both6: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/02 06:10:16 DEBUG : both6: Unchanged skipping 2025/07/02 06:10:16 DEBUG : both7: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/02 06:10:16 DEBUG : both7: Unchanged skipping 2025/07/02 06:10:16 DEBUG : both8: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/02 06:10:16 DEBUG : both8: Unchanged skipping 2025/07/02 06:10:16 DEBUG : both9: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/02 06:10:16 DEBUG : both9: Unchanged skipping 2025/07/02 06:10:16 DEBUG : both2: Unchanged skipping 2025/07/02 06:10:16 DEBUG : both3: Unchanged skipping 2025/07/02 06:10:16 DEBUG : both5: Unchanged skipping 2025/07/02 06:10:16 DEBUG : proton drive root link ID 'rclone-test-hasiwip1mezo': Waiting for transfers to finish 2025/07/02 06:10:16 DEBUG : Waiting for deletions to finish 2025/07/02 06:10:17 INFO : only17: Deleted 2025/07/02 06:10:17 INFO : only0: Deleted 2025/07/02 06:10:17 INFO : only4: Deleted 2025/07/02 06:10:17 INFO : only12: Deleted 2025/07/02 06:10:17 INFO : only6: Deleted 2025/07/02 06:10:17 INFO : only14: Deleted 2025/07/02 06:10:18 INFO : only7: Deleted 2025/07/02 06:10:18 INFO : only1: Deleted 2025/07/02 06:10:18 INFO : only16: Deleted 2025/07/02 06:10:18 INFO : only5: Deleted 2025/07/02 06:10:18 INFO : only19: Deleted 2025/07/02 06:10:18 INFO : only11: Deleted 2025/07/02 06:10:18 INFO : only2: Deleted 2025/07/02 06:10:19 INFO : only3: Deleted 2025/07/02 06:10:19 INFO : only8: Deleted 2025/07/02 06:10:19 INFO : only13: Deleted 2025/07/02 06:10:19 INFO : only10: Deleted 2025/07/02 06:10:19 INFO : only15: Deleted 2025/07/02 06:10:19 INFO : only18: Deleted 2025/07/02 06:10:19 INFO : only9: Deleted 2025/07/02 06:10:19 INFO : There was nothing to transfer --- PASS: TestSyncConcurrentDelete (116.01s) === RUN TestSyncConcurrentTruncate run.go:180: Remote "proton drive root link ID 'rclone-test-hasiwip1mezo'", Local "Local file system at /tmp/rclone531292651", Modify Window "1s" 2025/07/02 06:12:14 DEBUG : both10: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/02 06:12:14 DEBUG : proton drive root link ID 'rclone-test-hasiwip1mezo': Waiting for checks to finish 2025/07/02 06:12:14 DEBUG : both0: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/02 06:12:14 DEBUG : both11: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/02 06:12:14 DEBUG : both10: Unchanged skipping 2025/07/02 06:12:14 DEBUG : both12: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/02 06:12:14 DEBUG : both13: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/02 06:12:14 DEBUG : both0: Unchanged skipping 2025/07/02 06:12:14 DEBUG : both14: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/02 06:12:14 DEBUG : both14: Unchanged skipping 2025/07/02 06:12:14 DEBUG : both15: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/02 06:12:14 DEBUG : both15: Unchanged skipping 2025/07/02 06:12:14 DEBUG : both16: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/02 06:12:14 DEBUG : both16: Unchanged skipping 2025/07/02 06:12:14 DEBUG : both17: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/02 06:12:14 DEBUG : both11: Unchanged skipping 2025/07/02 06:12:14 DEBUG : both18: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/02 06:12:14 DEBUG : both12: Unchanged skipping 2025/07/02 06:12:14 DEBUG : both19: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/02 06:12:14 DEBUG : both19: Unchanged skipping 2025/07/02 06:12:14 DEBUG : both1: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/02 06:12:14 DEBUG : both13: Unchanged skipping 2025/07/02 06:12:14 DEBUG : both2: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/02 06:12:14 DEBUG : both17: Unchanged skipping 2025/07/02 06:12:14 DEBUG : both3: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/02 06:12:14 DEBUG : both3: Unchanged skipping 2025/07/02 06:12:14 DEBUG : both4: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/02 06:12:14 DEBUG : both4: Unchanged skipping 2025/07/02 06:12:14 DEBUG : both5: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/02 06:12:14 DEBUG : both5: Unchanged skipping 2025/07/02 06:12:14 DEBUG : both6: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/02 06:12:14 DEBUG : both18: Unchanged skipping 2025/07/02 06:12:14 DEBUG : both7: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/02 06:12:14 DEBUG : both1: Unchanged skipping 2025/07/02 06:12:14 DEBUG : both8: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/02 06:12:14 DEBUG : both7: Unchanged skipping 2025/07/02 06:12:14 DEBUG : both9: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/07/02 06:12:14 DEBUG : both9: Unchanged skipping 2025/07/02 06:12:14 DEBUG : only0: Sizes differ (src 0 vs dst 6) 2025/07/02 06:12:14 DEBUG : only10: Sizes differ (src 0 vs dst 6) 2025/07/02 06:12:14 DEBUG : only11: Sizes differ (src 0 vs dst 6) 2025/07/02 06:12:14 DEBUG : only12: Sizes differ (src 0 vs dst 6) 2025/07/02 06:12:14 DEBUG : only13: Sizes differ (src 0 vs dst 6) 2025/07/02 06:12:14 DEBUG : only14: Sizes differ (src 0 vs dst 6) 2025/07/02 06:12:14 DEBUG : only15: Sizes differ (src 0 vs dst 6) 2025/07/02 06:12:14 DEBUG : only16: Sizes differ (src 0 vs dst 6) 2025/07/02 06:12:14 DEBUG : only17: Sizes differ (src 0 vs dst 6) 2025/07/02 06:12:14 DEBUG : only18: Sizes differ (src 0 vs dst 6) 2025/07/02 06:12:14 DEBUG : only19: Sizes differ (src 0 vs dst 6) 2025/07/02 06:12:14 DEBUG : both8: Unchanged skipping 2025/07/02 06:12:14 DEBUG : only1: Sizes differ (src 0 vs dst 6) 2025/07/02 06:12:14 DEBUG : only2: Sizes differ (src 0 vs dst 6) 2025/07/02 06:12:14 DEBUG : both6: Unchanged skipping 2025/07/02 06:12:14 DEBUG : only3: Sizes differ (src 0 vs dst 6) 2025/07/02 06:12:14 DEBUG : only4: Sizes differ (src 0 vs dst 6) 2025/07/02 06:12:14 DEBUG : only5: Sizes differ (src 0 vs dst 6) 2025/07/02 06:12:14 DEBUG : only6: Sizes differ (src 0 vs dst 6) 2025/07/02 06:12:14 DEBUG : only7: Sizes differ (src 0 vs dst 6) 2025/07/02 06:12:14 DEBUG : both2: Unchanged skipping 2025/07/02 06:12:14 DEBUG : only8: Sizes differ (src 0 vs dst 6) 2025/07/02 06:12:14 DEBUG : only9: Sizes differ (src 0 vs dst 6) 2025/07/02 06:12:14 DEBUG : proton drive root link ID 'rclone-test-hasiwip1mezo': Waiting for transfers to finish 2025/07/02 06:12:15.123962 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/02 06:12:15.124009 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/02 06:12:15.388167 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/02 06:12:15.388210 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/02 06:12:15.470170 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/02 06:12:15.470207 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/02 06:12:15.536711 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/02 06:12:15.536749 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/02 06:12:16 DEBUG : only12: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/07/02 06:12:16 INFO : only12: Copied (replaced existing) 2025/07/02 06:12:16 DEBUG : only10: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/07/02 06:12:16 INFO : only10: Copied (replaced existing) 2025/07/02 06:12:16.880078 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/02 06:12:16.880126 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/02 06:12:16.921456 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/02 06:12:16.921538 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/02 06:12:16 DEBUG : only11: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/07/02 06:12:16 INFO : only11: Copied (replaced existing) 2025/07/02 06:12:17 DEBUG : only0: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/07/02 06:12:17 INFO : only0: Copied (replaced existing) 2025/07/02 06:12:17.362809 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/02 06:12:17.362846 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/02 06:12:17.627583 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/02 06:12:17.627625 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/02 06:12:18 DEBUG : only14: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/07/02 06:12:18 INFO : only14: Copied (replaced existing) 2025/07/02 06:12:18 DEBUG : only13: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/07/02 06:12:18 INFO : only13: Copied (replaced existing) 2025/07/02 06:12:18 DEBUG : only15: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/07/02 06:12:18 INFO : only15: Copied (replaced existing) 2025/07/02 06:12:18.934132 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/02 06:12:18.934164 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/02 06:12:19.022705 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/02 06:12:19.022757 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/02 06:12:19.167325 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/02 06:12:19.167361 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/02 06:12:19 DEBUG : only16: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/07/02 06:12:19 INFO : only16: Copied (replaced existing) 2025/07/02 06:12:19.418118 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/02 06:12:19.418177 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/02 06:12:20 DEBUG : only1: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/07/02 06:12:20 INFO : only1: Copied (replaced existing) 2025/07/02 06:12:20.325621 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/02 06:12:20.325704 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/02 06:12:20 DEBUG : only17: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/07/02 06:12:20 INFO : only17: Copied (replaced existing) 2025/07/02 06:12:20 DEBUG : only18: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/07/02 06:12:20 INFO : only18: Copied (replaced existing) 2025/07/02 06:12:20.852898 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/02 06:12:20.852946 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/02 06:12:21.153069 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/02 06:12:21.153105 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/02 06:12:21 DEBUG : only3: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/07/02 06:12:21 INFO : only3: Copied (replaced existing) 2025/07/02 06:12:21.708136 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/02 06:12:21.708176 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/02 06:12:21 DEBUG : only4: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/07/02 06:12:21 INFO : only4: Copied (replaced existing) 2025/07/02 06:12:22.204835 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/02 06:12:22.204906 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/02 06:12:22 DEBUG : only6: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/07/02 06:12:22 INFO : only6: Copied (replaced existing) 2025/07/02 06:12:22 DEBUG : only5: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/07/02 06:12:22 INFO : only5: Copied (replaced existing) 2025/07/02 06:12:22.982231 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/02 06:12:22.982275 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/02 06:12:23.125574 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/02 06:12:23.125612 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/02 06:12:23 DEBUG : only8: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/07/02 06:12:23 INFO : only8: Copied (replaced existing) 2025/07/02 06:12:23 DEBUG : only2: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/07/02 06:12:23 INFO : only2: Copied (replaced existing) 2025/07/02 06:12:23.751335 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/02 06:12:23.751391 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/02 06:12:24 DEBUG : only19: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/07/02 06:12:24 INFO : only19: Copied (replaced existing) 2025/07/02 06:12:24 DEBUG : only7: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/07/02 06:12:24 INFO : only7: Copied (replaced existing) 2025/07/02 06:12:25 DEBUG : only9: sha1 = da39a3ee5e6b4b0d3255bfef95601890afd80709 OK 2025/07/02 06:12:25 INFO : only9: Copied (replaced existing) 2025/07/02 06:12:25 DEBUG : Waiting for deletions to finish --- PASS: TestSyncConcurrentTruncate (146.69s) === RUN TestTransformFile run.go:180: Remote "proton drive root link ID 'rclone-test-hasiwip1mezo'", Local "Local file system at /tmp/rclone531292651", Modify Window "1s" 2025/07/02 06:13:09 DEBUG : empty_dir: Making directory with metadata 2025/07/02 06:13:09 INFO : empty_dir: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z) 2025/07/02 06:13:09 DEBUG : toe: transformed to: tictactoe 2025/07/02 06:13:09 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/07/02 06:13:09 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/07/02 06:13:10 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/07/02 06:13:10 INFO : tictacempty_dir: Making directory 2025/07/02 06:13:10 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/07/02 06:13:10 DEBUG : toe: transformed to: tictactoe 2025/07/02 06:13:10 DEBUG : toe: transformed to: tictactoe 2025/07/02 06:13:10 INFO : tictactoe: Making directory 2025/07/02 06:13:11 DEBUG : toe: transformed to: tictactoe 2025/07/02 06:13:11 DEBUG : toe: transformed to: tictactoe 2025/07/02 06:13:11 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2025/07/02 06:13:11 INFO : tictactoe/tictactoe: Making directory 2025/07/02 06:13:12 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2025/07/02 06:13:12 DEBUG : toe.txt: transformed to: tictactoe.txt 2025/07/02 06:13:12 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2025/07/02 06:13:12 DEBUG : toe/toe/toe.txt: Need to transfer - File not found at Destination 2025/07/02 06:13:12 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2025/07/02 06:13:12 DEBUG : proton drive root link ID 'rclone-test-hasiwip1mezo': Waiting for checks to finish 2025/07/02 06:13:12 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2025/07/02 06:13:12 DEBUG : proton drive root link ID 'rclone-test-hasiwip1mezo': Waiting for transfers to finish 2025/07/02 06:13:14 DEBUG : toe/toe/toe.txt: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/07/02 06:13:14 INFO : toe/toe/toe.txt: Copied (new) to: tictactoe/tictactoe/tictactoe.txt 2025/07/02 06:13:14 INFO : toe/toe/toe.txt: Deleted 2025/07/02 06:13:14 INFO : toe/toe: Removing directory 2025/07/02 06:13:14 INFO : toe: Removing directory 2025/07/02 06:13:14 INFO : empty_dir: Removing directory 2025/07/02 06:13:14 DEBUG : Local file system at /tmp/rclone531292651: deleted 3 directories 2025/07/02 06:13:17 DEBUG : tictactoe/tictactoe/tictactoe.txt: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/07/02 06:13:17 DEBUG : tictactoe/tictactoe/tictactoe.txt: transformed to: toe/toe/toe.txt 2025/07/02 06:13:17 DEBUG : tictactoe/tictactoe/tictactoe.txt: transformed to: toe/toe/toe.txt 2025/07/02 06:13:17 DEBUG : tictactoe/tictactoe/tictactoe.txt: transformed to: toe/toe/toe.txt 2025/07/02 06:13:21.064366 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/0NO06vV1A44AQrnr3LoGKRK09fYDa2GzMtTg60ffCc922f-WRlXBAV14wh4kAGUrBH9O1Bxq8iEanRv_rizn4g==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/07/02 06:13:21.064405 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/0NO06vV1A44AQrnr3LoGKRK09fYDa2GzMtTg60ffCc922f-WRlXBAV14wh4kAGUrBH9O1Bxq8iEanRv_rizn4g==/move: This value should not be blank. (Code=2000, Status=400) 2025/07/02 06:13:21 ERROR : tictactoe/tictactoe/tictactoe.txt: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/0NO06vV1A44AQrnr3LoGKRK09fYDa2GzMtTg60ffCc922f-WRlXBAV14wh4kAGUrBH9O1Bxq8iEanRv_rizn4g==/move: This value should not be blank. (Code=2000, Status=400) sync_transform_test.go:435: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_transform_test.go:435 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/0NO06vV1A44AQrnr3LoGKRK09fYDa2GzMtTg60ffCc922f-WRlXBAV14wh4kAGUrBH9O1Bxq8iEanRv_rizn4g==/move: This value should not be blank. (Code=2000, Status=400) Test: TestTransformFile --- FAIL: TestTransformFile (17.85s) === RUN TestManualTransformFile run.go:180: Remote "proton drive root link ID 'rclone-test-hasiwip1mezo'", Local "Local file system at /tmp/rclone531292651", Modify Window "1s" 2025/07/02 06:13:27 DEBUG : Reset feature "Copy" 2025/07/02 06:13:27 DEBUG : Reset feature "Move" 2025/07/02 06:13:27 DEBUG : Reset feature "Copy" 2025/07/02 06:13:27 DEBUG : Reset feature "Move" 2025/07/02 06:13:27 DEBUG : empty_dir: Making directory with metadata 2025/07/02 06:13:27 INFO : empty_dir: Made directory with metadata (mtime=2001-02-03T04:05:06.499999999Z) 2025/07/02 06:13:27 DEBUG : toe: transformed to: tictactoe 2025/07/02 06:13:27 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/07/02 06:13:27 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/07/02 06:13:28 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/07/02 06:13:28 INFO : tictacempty_dir: Making directory 2025/07/02 06:13:28 DEBUG : empty_dir: transformed to: tictacempty_dir 2025/07/02 06:13:28 DEBUG : toe: transformed to: tictactoe 2025/07/02 06:13:28 DEBUG : toe: transformed to: tictactoe 2025/07/02 06:13:28 INFO : tictactoe: Making directory 2025/07/02 06:13:29 DEBUG : toe: transformed to: tictactoe 2025/07/02 06:13:29 DEBUG : toe: transformed to: tictactoe 2025/07/02 06:13:29 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2025/07/02 06:13:29 INFO : tictactoe/tictactoe: Making directory 2025/07/02 06:13:30 DEBUG : toe/toe: transformed to: tictactoe/tictactoe 2025/07/02 06:13:30 DEBUG : toe.txt: transformed to: tictactoe.txt 2025/07/02 06:13:30 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2025/07/02 06:13:30 DEBUG : toe/toe/toe.txt: Need to transfer - File not found at Destination 2025/07/02 06:13:30 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2025/07/02 06:13:30 DEBUG : toe/toe/toe.txt: transformed to: tictactoe/tictactoe/tictactoe.txt 2025/07/02 06:13:30 DEBUG : proton drive root link ID 'rclone-test-hasiwip1mezo': Waiting for checks to finish 2025/07/02 06:13:30 DEBUG : proton drive root link ID 'rclone-test-hasiwip1mezo': Waiting for transfers to finish 2025/07/02 06:13:32 DEBUG : toe/toe/toe.txt: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/07/02 06:13:32 INFO : toe/toe/toe.txt: Copied (new) to: tictactoe/tictactoe/tictactoe.txt 2025/07/02 06:13:32 INFO : toe/toe/toe.txt: Deleted 2025/07/02 06:13:32 ERROR : Local file system at /tmp/rclone531292651: 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.24s) === RUN TestBase64 run.go:180: Remote "proton drive root link ID 'rclone-test-hasiwip1mezo'", Local "Local file system at /tmp/rclone531292651", Modify Window "1s" 2025/07/02 06:13:37 DEBUG : toe: transformed to: dG9l 2025/07/02 06:13:38 DEBUG : toe: transformed to: dG9l 2025/07/02 06:13:38 INFO : dG9l: Making directory 2025/07/02 06:13:39 DEBUG : toe: transformed to: dG9l 2025/07/02 06:13:39 DEBUG : toe: transformed to: dG9l 2025/07/02 06:13:39 DEBUG : toe/toe: transformed to: dG9l/dG9l 2025/07/02 06:13:39 INFO : dG9l/dG9l: Making directory 2025/07/02 06:13:40 DEBUG : toe/toe: transformed to: dG9l/dG9l 2025/07/02 06:13:40 DEBUG : toe.txt: transformed to: dG9lLnR4dA== 2025/07/02 06:13:40 DEBUG : toe/toe/toe.txt: transformed to: dG9l/dG9l/dG9lLnR4dA== 2025/07/02 06:13:40 DEBUG : toe/toe/toe.txt: Need to transfer - File not found at Destination 2025/07/02 06:13:40 DEBUG : toe/toe/toe.txt: transformed to: dG9l/dG9l/dG9lLnR4dA== 2025/07/02 06:13:40 DEBUG : proton drive root link ID 'rclone-test-hasiwip1mezo': Waiting for checks to finish 2025/07/02 06:13:40 DEBUG : proton drive root link ID 'rclone-test-hasiwip1mezo': Waiting for transfers to finish 2025/07/02 06:13:42 DEBUG : toe/toe/toe.txt: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/07/02 06:13:42 INFO : toe/toe/toe.txt: Copied (new) to: dG9l/dG9l/dG9lLnR4dA== 2025/07/02 06:13:42 ERROR : proton drive root link ID 'rclone-test-hasiwip1mezo': not deleting files as there were IO errors 2025/07/02 06:13:42 ERROR : proton drive root link ID 'rclone-test-hasiwip1mezo': 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.52s) FAIL 2025/07/02 06:13:46 DEBUG : proton drive root link ID 'rclone-test-hasiwip1mezo': 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|TestSyncConcurrentDelete|TestSyncConcurrentTruncate|TestSyncSuffix|TestSyncSuffixKeepExtension|TestSyncWithTrackRenames|TestSyncWithTrackRenamesStrategyLeaf|TestSyncWithTrackRenamesStrategyModtime|TestTransformFile)$'" - Finished ERROR in 22m55.817685996s (try 2/5): exit status 1: Failed [TestServerSideMoveOverSelf TestSyncWithTrackRenames TestSyncWithTrackRenamesStrategyModtime TestSyncWithTrackRenamesStrategyLeaf TestMoveWithDeleteEmptySrcDirs TestServerSideMove TestServerSideMoveWithFilter TestServerSideMoveDeleteEmptySourceDirs TestSyncBackupDir TestSyncBackupDirWithSuffix TestSyncBackupDirWithSuffixKeepExtension TestSyncBackupDirSuffixOnly TestSyncSuffix TestSyncSuffixKeepExtension TestTransformFile TestManualTransformFile TestBase64]