"./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 2/5) 2025/10/11 02:36:21 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-goxodah8liba" 2025/10/11 02:36:21 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/10/11 02:36:21 DEBUG : proton drive root link ID 'rclone-test-goxodah8liba': Has cached credentials 2025/10/11 02:36:22 DEBUG : proton drive root link ID 'rclone-test-goxodah8liba': Used cached credential to initialize the ProtonDrive API 2025/10/11 02:36:23 DEBUG : Creating backend with remote "/tmp/rclone3145443714" === RUN TestServerSideMoveOverSelf run.go:180: Remote "proton drive root link ID 'rclone-test-goxodah8liba'", Local "Local file system at /tmp/rclone3145443714", Modify Window "1s" 2025/10/11 02:36:32 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-xozesuz2rife" 2025/10/11 02:36:32 DEBUG : proton drive root link ID 'rclone-test-xozesuz2rife': Has cached credentials 2025/10/11 02:36:34 DEBUG : proton drive root link ID 'rclone-test-xozesuz2rife': Used cached credential to initialize the ProtonDrive API sync_test.go:701: Server side copy (if possible) proton drive root link ID 'rclone-test-goxodah8liba' -> proton drive root link ID 'rclone-test-xozesuz2rife' 2025/10/11 02:36:35 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/10/11 02:36:35 DEBUG : proton drive root link ID 'rclone-test-xozesuz2rife': Waiting for checks to finish 2025/10/11 02:36:35 DEBUG : proton drive root link ID 'rclone-test-xozesuz2rife': Waiting for transfers to finish 2025/10/11 02:36:40 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/10/11 02:36:40 INFO : sub dir/hello world: Copied (new) 2025/10/11 02:36:41.911919 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/10/11 02:36:41.911942 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/10/11 02:36:45 DEBUG : proton drive root link ID 'rclone-test-xozesuz2rife': Using server-side directory move 2025/10/11 02:36:45 INFO : proton drive root link ID 'rclone-test-xozesuz2rife': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/10/11 02:36:45 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2025/10/11 02:36:45 DEBUG : proton drive root link ID 'rclone-test-xozesuz2rife': Waiting for checks to finish 2025/10/11 02:36:45 DEBUG : proton drive root link ID 'rclone-test-xozesuz2rife': Waiting for transfers to finish 2025/10/11 02:36:46 INFO : sub dir/hello world: Deleted 2025/10/11 02:36:47.198746 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/x9mNZ5MJnfS84HPB3VpBptGnVNarc46ApwzwGjFXXxMOKFpy2Dov0mawiy6n0alOLvJf07MGfCIV9TMimaj6iw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/11 02:36:47.198778 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/x9mNZ5MJnfS84HPB3VpBptGnVNarc46ApwzwGjFXXxMOKFpy2Dov0mawiy6n0alOLvJf07MGfCIV9TMimaj6iw==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/11 02:36:47 ERROR : sub dir/hello world: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/x9mNZ5MJnfS84HPB3VpBptGnVNarc46ApwzwGjFXXxMOKFpy2Dov0mawiy6n0alOLvJf07MGfCIV9TMimaj6iw==/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/x9mNZ5MJnfS84HPB3VpBptGnVNarc46ApwzwGjFXXxMOKFpy2Dov0mawiy6n0alOLvJf07MGfCIV9TMimaj6iw==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveOverSelf 2025/10/11 02:36:47 DEBUG : proton drive root link ID 'rclone-test-xozesuz2rife': Purge remote --- FAIL: TestServerSideMoveOverSelf (26.73s) === RUN TestSyncWithTrackRenames run.go:180: Remote "proton drive root link ID 'rclone-test-goxodah8liba'", Local "Local file system at /tmp/rclone3145443714", Modify Window "1s" sync_test.go:1568: Can track renames: true 2025/10/11 02:36:50 INFO : proton drive root link ID 'rclone-test-goxodah8liba': Making map for --track-renames 2025/10/11 02:36:50 INFO : proton drive root link ID 'rclone-test-goxodah8liba': Finished making map for --track-renames 2025/10/11 02:36:50 DEBUG : proton drive root link ID 'rclone-test-goxodah8liba': Waiting for checks to finish 2025/10/11 02:36:50 DEBUG : proton drive root link ID 'rclone-test-goxodah8liba': Waiting for renames to finish 2025/10/11 02:36:50 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/10/11 02:36:50 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/10/11 02:36:50 DEBUG : proton drive root link ID 'rclone-test-goxodah8liba': Waiting for transfers to finish 2025/10/11 02:36:52 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/10/11 02:36:52 INFO : potato: Copied (new) 2025/10/11 02:36:52 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/10/11 02:36:52 INFO : yam: Copied (new) 2025/10/11 02:36:52 DEBUG : Waiting for deletions to finish 2025/10/11 02:36:53 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/10/11 02:36:53 INFO : proton drive root link ID 'rclone-test-goxodah8liba': Making map for --track-renames 2025/10/11 02:36:53 INFO : proton drive root link ID 'rclone-test-goxodah8liba': Finished making map for --track-renames 2025/10/11 02:36:53 DEBUG : proton drive root link ID 'rclone-test-goxodah8liba': Waiting for checks to finish 2025/10/11 02:36:53 DEBUG : potato: Unchanged skipping 2025/10/11 02:36:53 DEBUG : proton drive root link ID 'rclone-test-goxodah8liba': Waiting for renames to finish 2025/10/11 02:36:54.471837 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/yxkLUNc5pMwpCyZzfucrUdhs1s4WbxEuhQ6mruzatS-o1AcvncbraLnbGUK4mHZkYPHvlrKUcBq-N0Ot2vMq4A==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/11 02:36:54.471870 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/yxkLUNc5pMwpCyZzfucrUdhs1s4WbxEuhQ6mruzatS-o1AcvncbraLnbGUK4mHZkYPHvlrKUcBq-N0Ot2vMq4A==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/11 02:36:54 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/yxkLUNc5pMwpCyZzfucrUdhs1s4WbxEuhQ6mruzatS-o1AcvncbraLnbGUK4mHZkYPHvlrKUcBq-N0Ot2vMq4A==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/11 02:36:54 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/yxkLUNc5pMwpCyZzfucrUdhs1s4WbxEuhQ6mruzatS-o1AcvncbraLnbGUK4mHZkYPHvlrKUcBq-N0Ot2vMq4A==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/11 02:36:54 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/10/11 02:36:54 DEBUG : proton drive root link ID 'rclone-test-goxodah8liba': Waiting for transfers to finish 2025/10/11 02:36:56 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/10/11 02:36:56 INFO : yaml: Copied (new) 2025/10/11 02:36:56 ERROR : proton drive root link ID 'rclone-test-goxodah8liba': not deleting files as there were IO errors 2025/10/11 02:36:56 ERROR : proton drive root link ID 'rclone-test-goxodah8liba': 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 (8.87s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:180: Remote "proton drive root link ID 'rclone-test-goxodah8liba'", Local "Local file system at /tmp/rclone3145443714", Modify Window "1s" sync_test.go:1640: Can track renames: true 2025/10/11 02:36:59 INFO : proton drive root link ID 'rclone-test-goxodah8liba': Making map for --track-renames 2025/10/11 02:36:59 INFO : proton drive root link ID 'rclone-test-goxodah8liba': Finished making map for --track-renames 2025/10/11 02:36:59 DEBUG : proton drive root link ID 'rclone-test-goxodah8liba': Waiting for checks to finish 2025/10/11 02:36:59 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/10/11 02:36:59 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/10/11 02:36:59 DEBUG : proton drive root link ID 'rclone-test-goxodah8liba': Waiting for renames to finish 2025/10/11 02:36:59 DEBUG : proton drive root link ID 'rclone-test-goxodah8liba': Waiting for transfers to finish 2025/10/11 02:37:01 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/10/11 02:37:01 INFO : yam: Copied (new) 2025/10/11 02:37:01 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/10/11 02:37:01 INFO : potato: Copied (new) 2025/10/11 02:37:01 DEBUG : Waiting for deletions to finish 2025/10/11 02:37:02 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/10/11 02:37:02 INFO : proton drive root link ID 'rclone-test-goxodah8liba': Making map for --track-renames 2025/10/11 02:37:02 INFO : proton drive root link ID 'rclone-test-goxodah8liba': Finished making map for --track-renames 2025/10/11 02:37:02 DEBUG : proton drive root link ID 'rclone-test-goxodah8liba': Waiting for checks to finish 2025/10/11 02:37:02 DEBUG : potato: Unchanged skipping 2025/10/11 02:37:02 DEBUG : proton drive root link ID 'rclone-test-goxodah8liba': Waiting for renames to finish 2025/10/11 02:37:03.200498 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/vJZ6UrAVpOKQHRKtmJGDIrAwX7vVClxCXI-NGB14HANYf-0z_NFRlkHEri4UVUfIxeaOezUpigN49OW6Uq3Cyw==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/11 02:37:03.200533 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/vJZ6UrAVpOKQHRKtmJGDIrAwX7vVClxCXI-NGB14HANYf-0z_NFRlkHEri4UVUfIxeaOezUpigN49OW6Uq3Cyw==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/11 02:37:03 ERROR : yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/vJZ6UrAVpOKQHRKtmJGDIrAwX7vVClxCXI-NGB14HANYf-0z_NFRlkHEri4UVUfIxeaOezUpigN49OW6Uq3Cyw==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/11 02:37:03 DEBUG : yaml: Failed to rename to "yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/vJZ6UrAVpOKQHRKtmJGDIrAwX7vVClxCXI-NGB14HANYf-0z_NFRlkHEri4UVUfIxeaOezUpigN49OW6Uq3Cyw==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/11 02:37:03 DEBUG : yaml: Need to transfer - No matching file found at Destination 2025/10/11 02:37:03 DEBUG : proton drive root link ID 'rclone-test-goxodah8liba': Waiting for transfers to finish 2025/10/11 02:37:05 DEBUG : yaml: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/10/11 02:37:05 INFO : yaml: Copied (new) 2025/10/11 02:37:05 ERROR : proton drive root link ID 'rclone-test-goxodah8liba': not deleting files as there were IO errors 2025/10/11 02:37:05 ERROR : proton drive root link ID 'rclone-test-goxodah8liba': 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 (8.76s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:180: Remote "proton drive root link ID 'rclone-test-goxodah8liba'", Local "Local file system at /tmp/rclone3145443714", Modify Window "1s" sync_test.go:1679: Can track renames: true 2025/10/11 02:37:07 INFO : proton drive root link ID 'rclone-test-goxodah8liba': Making map for --track-renames 2025/10/11 02:37:07 INFO : proton drive root link ID 'rclone-test-goxodah8liba': Finished making map for --track-renames 2025/10/11 02:37:07 DEBUG : proton drive root link ID 'rclone-test-goxodah8liba': Waiting for checks to finish 2025/10/11 02:37:07 DEBUG : sub/yam: Need to transfer - No matching file found at Destination 2025/10/11 02:37:07 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/10/11 02:37:07 DEBUG : proton drive root link ID 'rclone-test-goxodah8liba': Waiting for renames to finish 2025/10/11 02:37:07 DEBUG : proton drive root link ID 'rclone-test-goxodah8liba': Waiting for transfers to finish 2025/10/11 02:37:10 DEBUG : sub/yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/10/11 02:37:10 INFO : sub/yam: Copied (new) 2025/10/11 02:37:10 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK 2025/10/11 02:37:10 INFO : potato: Copied (new) 2025/10/11 02:37:10 DEBUG : Waiting for deletions to finish 2025/10/11 02:37:12 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/10/11 02:37:12 DEBUG : potato: Unchanged skipping 2025/10/11 02:37:12 INFO : proton drive root link ID 'rclone-test-goxodah8liba': Making map for --track-renames 2025/10/11 02:37:12 INFO : proton drive root link ID 'rclone-test-goxodah8liba': Finished making map for --track-renames 2025/10/11 02:37:12 DEBUG : proton drive root link ID 'rclone-test-goxodah8liba': Waiting for checks to finish 2025/10/11 02:37:12 DEBUG : proton drive root link ID 'rclone-test-goxodah8liba': Waiting for renames to finish 2025/10/11 02:37:13.355859 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/oUSBZaGEPIeb4J6OyIF-MUs2YgApTCsYVAvapsO_y-XmtVSGGoZgx7XPSMgvrEA7uEGEXCcZG40eReMkksB1Sg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/11 02:37:13.355910 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/oUSBZaGEPIeb4J6OyIF-MUs2YgApTCsYVAvapsO_y-XmtVSGGoZgx7XPSMgvrEA7uEGEXCcZG40eReMkksB1Sg==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/11 02:37:13 ERROR : sub/yam: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/oUSBZaGEPIeb4J6OyIF-MUs2YgApTCsYVAvapsO_y-XmtVSGGoZgx7XPSMgvrEA7uEGEXCcZG40eReMkksB1Sg==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/11 02:37:13 DEBUG : yam: Failed to rename to "sub/yam": 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/oUSBZaGEPIeb4J6OyIF-MUs2YgApTCsYVAvapsO_y-XmtVSGGoZgx7XPSMgvrEA7uEGEXCcZG40eReMkksB1Sg==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/11 02:37:13 DEBUG : yam: Need to transfer - No matching file found at Destination 2025/10/11 02:37:13 DEBUG : proton drive root link ID 'rclone-test-goxodah8liba': Waiting for transfers to finish 2025/10/11 02:37:15 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK 2025/10/11 02:37:15 INFO : yam: Copied (new) 2025/10/11 02:37:15 ERROR : proton drive root link ID 'rclone-test-goxodah8liba': not deleting files as there were IO errors 2025/10/11 02:37:15 ERROR : proton drive root link ID 'rclone-test-goxodah8liba': 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 (10.88s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:180: Remote "proton drive root link ID 'rclone-test-goxodah8liba'", Local "Local file system at /tmp/rclone3145443714", Modify Window "1s" 2025/10/11 02:37:18 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/10/11 02:37:18 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2025/10/11 02:37:18 DEBUG : proton drive root link ID 'rclone-test-goxodah8liba': Waiting for checks to finish 2025/10/11 02:37:18 DEBUG : proton drive root link ID 'rclone-test-goxodah8liba': Waiting for transfers to finish 2025/10/11 02:37:23 DEBUG : nested/sub dir/file: sha1 = b4b3e0a278988bc15f2913af3f4153ccef74e465 OK 2025/10/11 02:37:23 INFO : nested/sub dir/file: Copied (new) 2025/10/11 02:37:23 INFO : nested/sub dir/file: Deleted 2025/10/11 02:37:23 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK 2025/10/11 02:37:23 INFO : sub dir/hello world: Copied (new) 2025/10/11 02:37:23 INFO : sub dir/hello world: Deleted 2025/10/11 02:37:23 ERROR : Local file system at /tmp/rclone3145443714: 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 (8.37s) === RUN TestServerSideMove run.go:180: Remote "proton drive root link ID 'rclone-test-goxodah8liba'", Local "Local file system at /tmp/rclone3145443714", Modify Window "1s" 2025/10/11 02:37:26 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-gomuquk4boke" 2025/10/11 02:37:26 DEBUG : proton drive root link ID 'rclone-test-gomuquk4boke': Has cached credentials 2025/10/11 02:37:28 DEBUG : proton drive root link ID 'rclone-test-gomuquk4boke': Used cached credential to initialize the ProtonDrive API sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-goxodah8liba' -> proton drive root link ID 'rclone-test-gomuquk4boke' 2025/10/11 02:37:41 DEBUG : proton drive root link ID 'rclone-test-gomuquk4boke': Using server-side directory move 2025/10/11 02:37:41 INFO : proton drive root link ID 'rclone-test-gomuquk4boke': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/10/11 02:37:42 DEBUG : potato2: Need to transfer - File not found at Destination 2025/10/11 02:37:42 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/10/11 02:37:42 DEBUG : empty space: Unchanged skipping 2025/10/11 02:37:42 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/10/11 02:37:42 DEBUG : proton drive root link ID 'rclone-test-gomuquk4boke': Waiting for checks to finish 2025/10/11 02:37:42 INFO : empty space: Deleted 2025/10/11 02:37:42 DEBUG : proton drive root link ID 'rclone-test-gomuquk4boke': Waiting for transfers to finish 2025/10/11 02:37:42 INFO : potato3: Deleted 2025/10/11 02:37:42.842529 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/CY6ks3yQO9lNpCkp6GMtn4p6DM7v3-dSg4nGCoeYgy1-PoApSh7yQi1G8d_UTk49SJLON9J3mSrHxqObbGftjA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/11 02:37:42.842552 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/CY6ks3yQO9lNpCkp6GMtn4p6DM7v3-dSg4nGCoeYgy1-PoApSh7yQi1G8d_UTk49SJLON9J3mSrHxqObbGftjA==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/11 02:37:42 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/CY6ks3yQO9lNpCkp6GMtn4p6DM7v3-dSg4nGCoeYgy1-PoApSh7yQi1G8d_UTk49SJLON9J3mSrHxqObbGftjA==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/11 02:37:43.120455 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/f8pN4GZmJ_ezLVEfpKh8HGA0GED62WfycEiRqkvoHTU1QJt8y7svcMprfzBfbg0FDwk1MaloF8d3FKYfo4Zeag==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/11 02:37:43.120487 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/f8pN4GZmJ_ezLVEfpKh8HGA0GED62WfycEiRqkvoHTU1QJt8y7svcMprfzBfbg0FDwk1MaloF8d3FKYfo4Zeag==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/11 02:37:43 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/f8pN4GZmJ_ezLVEfpKh8HGA0GED62WfycEiRqkvoHTU1QJt8y7svcMprfzBfbg0FDwk1MaloF8d3FKYfo4Zeag==/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/f8pN4GZmJ_ezLVEfpKh8HGA0GED62WfycEiRqkvoHTU1QJt8y7svcMprfzBfbg0FDwk1MaloF8d3FKYfo4Zeag==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMove 2025/10/11 02:37:43 DEBUG : proton drive root link ID 'rclone-test-gomuquk4boke': Purge remote --- FAIL: TestServerSideMove (18.73s) === RUN TestServerSideMoveWithFilter run.go:180: Remote "proton drive root link ID 'rclone-test-goxodah8liba'", Local "Local file system at /tmp/rclone3145443714", Modify Window "1s" 2025/10/11 02:37:45 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-xeyavun3zobu" 2025/10/11 02:37:45 DEBUG : Config file has changed externally - reloading 2025/10/11 02:37:45 DEBUG : proton drive root link ID 'rclone-test-xeyavun3zobu': Has cached credentials 2025/10/11 02:37:47 DEBUG : proton drive root link ID 'rclone-test-xeyavun3zobu': Used cached credential to initialize the ProtonDrive API sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-goxodah8liba' -> proton drive root link ID 'rclone-test-xeyavun3zobu' 2025/10/11 02:38:00 DEBUG : empty space: Excluded (Size Filter) 2025/10/11 02:38:00 DEBUG : empty space: Excluded 2025/10/11 02:38:00 DEBUG : empty space: Excluded (Size Filter) 2025/10/11 02:38:00 DEBUG : empty space: Excluded 2025/10/11 02:38:00 DEBUG : potato2: Need to transfer - File not found at Destination 2025/10/11 02:38:00 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/10/11 02:38:00 DEBUG : proton drive root link ID 'rclone-test-xeyavun3zobu': Waiting for checks to finish 2025/10/11 02:38:00 DEBUG : proton drive root link ID 'rclone-test-xeyavun3zobu': Waiting for transfers to finish 2025/10/11 02:38:01 INFO : potato3: Deleted 2025/10/11 02:38:01.610051 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/ek_6si2N3HzHW0AS1kKckqMq6K_WSwUO99n4PKdQjPqKjtjMrSzJE-37NRUOA4GVBX-JTXhREShcgtK7-gbdjA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/11 02:38:01.610092 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/ek_6si2N3HzHW0AS1kKckqMq6K_WSwUO99n4PKdQjPqKjtjMrSzJE-37NRUOA4GVBX-JTXhREShcgtK7-gbdjA==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/11 02:38:01 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/ek_6si2N3HzHW0AS1kKckqMq6K_WSwUO99n4PKdQjPqKjtjMrSzJE-37NRUOA4GVBX-JTXhREShcgtK7-gbdjA==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/11 02:38:01.867074 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/UAupxzTVeMG1xvrpWcWgifyHBqGYhhA44pmLNPgzqv2AcwKVRzjJe_OsRtFt_Bp8FbzCcPLe3SXKvKeW2AzYPQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/11 02:38:01.867113 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/UAupxzTVeMG1xvrpWcWgifyHBqGYhhA44pmLNPgzqv2AcwKVRzjJe_OsRtFt_Bp8FbzCcPLe3SXKvKeW2AzYPQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/11 02:38:01 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/UAupxzTVeMG1xvrpWcWgifyHBqGYhhA44pmLNPgzqv2AcwKVRzjJe_OsRtFt_Bp8FbzCcPLe3SXKvKeW2AzYPQ==/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/UAupxzTVeMG1xvrpWcWgifyHBqGYhhA44pmLNPgzqv2AcwKVRzjJe_OsRtFt_Bp8FbzCcPLe3SXKvKeW2AzYPQ==/move: This value should not be blank. (Code=2000, Status=400) Test: TestServerSideMoveWithFilter 2025/10/11 02:38:01 DEBUG : proton drive root link ID 'rclone-test-xeyavun3zobu': Purge remote --- FAIL: TestServerSideMoveWithFilter (19.31s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:180: Remote "proton drive root link ID 'rclone-test-goxodah8liba'", Local "Local file system at /tmp/rclone3145443714", Modify Window "1s" 2025/10/11 02:38:04 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-kutasuj3tebi" 2025/10/11 02:38:04 DEBUG : proton drive root link ID 'rclone-test-kutasuj3tebi': Has cached credentials 2025/10/11 02:38:06 DEBUG : proton drive root link ID 'rclone-test-kutasuj3tebi': Used cached credential to initialize the ProtonDrive API 2025/10/11 02:38:12 INFO : tomatoDir: Making directory sync_test.go:1735: Server side move (if possible) proton drive root link ID 'rclone-test-goxodah8liba' -> proton drive root link ID 'rclone-test-kutasuj3tebi' 2025/10/11 02:38:20 DEBUG : proton drive root link ID 'rclone-test-kutasuj3tebi': Using server-side directory move 2025/10/11 02:38:20 INFO : proton drive root link ID 'rclone-test-kutasuj3tebi': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/10/11 02:38:20 DEBUG : potato2: Need to transfer - File not found at Destination 2025/10/11 02:38:20 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s) 2025/10/11 02:38:20 DEBUG : empty space: Unchanged skipping 2025/10/11 02:38:20 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/10/11 02:38:20 DEBUG : proton drive root link ID 'rclone-test-kutasuj3tebi': Waiting for checks to finish 2025/10/11 02:38:21 INFO : potato3: Deleted 2025/10/11 02:38:21 INFO : empty space: Deleted 2025/10/11 02:38:21 DEBUG : proton drive root link ID 'rclone-test-kutasuj3tebi': Waiting for transfers to finish 2025/10/11 02:38:21.452968 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/_xo_yt69oTOoYnr_FhAFgFkf13uye2fn8LffTkNunctXwteiqqZvlBY613_LBcWpkCIuX0J5do4Df7XRk1SuuQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/11 02:38:21.453003 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/_xo_yt69oTOoYnr_FhAFgFkf13uye2fn8LffTkNunctXwteiqqZvlBY613_LBcWpkCIuX0J5do4Df7XRk1SuuQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/11 02:38:21 ERROR : potato2: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/_xo_yt69oTOoYnr_FhAFgFkf13uye2fn8LffTkNunctXwteiqqZvlBY613_LBcWpkCIuX0J5do4Df7XRk1SuuQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/11 02:38:21.748953 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/rWpjYPZZ_59CRnGrKBuCcY5eixesfyChohGtOV91tr-erWSvtBoDlAznZv0XFygIEm1JecNDEz0LS0tKlANyAQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/11 02:38:21.748997 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/rWpjYPZZ_59CRnGrKBuCcY5eixesfyChohGtOV91tr-erWSvtBoDlAznZv0XFygIEm1JecNDEz0LS0tKlANyAQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/11 02:38:21 ERROR : potato3: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/rWpjYPZZ_59CRnGrKBuCcY5eixesfyChohGtOV91tr-erWSvtBoDlAznZv0XFygIEm1JecNDEz0LS0tKlANyAQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/11 02:38:21 ERROR : proton drive root link ID 'rclone-test-goxodah8liba': 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/10/11 02:38:21 DEBUG : proton drive root link ID 'rclone-test-kutasuj3tebi': Purge remote --- FAIL: TestServerSideMoveDeleteEmptySourceDirs (19.99s) === RUN TestSyncBackupDir run.go:180: Remote "proton drive root link ID 'rclone-test-goxodah8liba'", Local "Local file system at /tmp/rclone3145443714", Modify Window "1s" 2025/10/11 02:38:33 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-goxodah8liba/dst" 2025/10/11 02:38:33 DEBUG : proton drive root link ID 'rclone-test-goxodah8liba/dst': Has cached credentials 2025/10/11 02:38:34 DEBUG : proton drive root link ID 'rclone-test-goxodah8liba/dst': Used cached credential to initialize the ProtonDrive API 2025/10/11 02:40:29 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-goxodah8liba/backup" 2025/10/11 02:40:29 DEBUG : proton drive root link ID 'rclone-test-goxodah8liba/backup': Has cached credentials 2025/10/11 02:40:30 DEBUG : proton drive root link ID 'rclone-test-goxodah8liba/backup': Used cached credential to initialize the ProtonDrive API 2025/10/11 02:44:18 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/10/11 02:44:18 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/10/11 02:44:18 DEBUG : two: Unchanged skipping 2025/10/11 02:44:18 DEBUG : proton drive root link ID 'rclone-test-goxodah8liba/dst': Waiting for checks to finish 2025/10/11 02:44:20.324207 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/dA3_MSJyGsk2eCe9WvMbrgtKgunGLH8K55o_E2h40uvHa4r2NF9EuCDtJUQX7wORqRE0lW4GmzG8MFNoEov64A==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/11 02:44:20.324259 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/dA3_MSJyGsk2eCe9WvMbrgtKgunGLH8K55o_E2h40uvHa4r2NF9EuCDtJUQX7wORqRE0lW4GmzG8MFNoEov64A==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/11 02:44:20 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/dA3_MSJyGsk2eCe9WvMbrgtKgunGLH8K55o_E2h40uvHa4r2NF9EuCDtJUQX7wORqRE0lW4GmzG8MFNoEov64A==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/11 02:44:20 DEBUG : proton drive root link ID 'rclone-test-goxodah8liba/dst': Waiting for transfers to finish 2025/10/11 02:44:20 ERROR : proton drive root link ID 'rclone-test-goxodah8liba/dst': not deleting files as there were IO errors 2025/10/11 02:44:20 ERROR : proton drive root link ID 'rclone-test-goxodah8liba/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/dA3_MSJyGsk2eCe9WvMbrgtKgunGLH8K55o_E2h40uvHa4r2NF9EuCDtJUQX7wORqRE0lW4GmzG8MFNoEov64A==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDir --- FAIL: TestSyncBackupDir (359.02s) === RUN TestSyncBackupDirWithSuffix run.go:180: Remote "proton drive root link ID 'rclone-test-goxodah8liba'", Local "Local file system at /tmp/rclone3145443714", Modify Window "1s" 2025/10/11 02:44:32 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-goxodah8liba/dst" 2025/10/11 02:44:32 DEBUG : proton drive root link ID 'rclone-test-goxodah8liba/dst': Has cached credentials 2025/10/11 02:44:33 DEBUG : proton drive root link ID 'rclone-test-goxodah8liba/dst': Used cached credential to initialize the ProtonDrive API 2025/10/11 02:46:27 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-goxodah8liba/backup" 2025/10/11 02:46:27 DEBUG : Config file has changed externally - reloading 2025/10/11 02:46:27 DEBUG : proton drive root link ID 'rclone-test-goxodah8liba/backup': Has cached credentials 2025/10/11 02:46:28 DEBUG : proton drive root link ID 'rclone-test-goxodah8liba/backup': Used cached credential to initialize the ProtonDrive API 2025/10/11 02:50:14 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/10/11 02:50:14 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/10/11 02:50:14 DEBUG : two: Unchanged skipping 2025/10/11 02:50:14 DEBUG : proton drive root link ID 'rclone-test-goxodah8liba/dst': Waiting for checks to finish 2025/10/11 02:50:16.584289 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/BJ0JFfI2jbFdw_5Tzzcqf_nv3BA2mhQGbQfMWWKJPZEQ_Z463abywd7S1lnlwn3kinIrU2h2DSQBrNui3DVxfQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/11 02:50:16.584325 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/BJ0JFfI2jbFdw_5Tzzcqf_nv3BA2mhQGbQfMWWKJPZEQ_Z463abywd7S1lnlwn3kinIrU2h2DSQBrNui3DVxfQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/11 02:50:16 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/BJ0JFfI2jbFdw_5Tzzcqf_nv3BA2mhQGbQfMWWKJPZEQ_Z463abywd7S1lnlwn3kinIrU2h2DSQBrNui3DVxfQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/11 02:50:16 DEBUG : proton drive root link ID 'rclone-test-goxodah8liba/dst': Waiting for transfers to finish 2025/10/11 02:50:16 ERROR : proton drive root link ID 'rclone-test-goxodah8liba/dst': not deleting files as there were IO errors 2025/10/11 02:50:16 ERROR : proton drive root link ID 'rclone-test-goxodah8liba/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/BJ0JFfI2jbFdw_5Tzzcqf_nv3BA2mhQGbQfMWWKJPZEQ_Z463abywd7S1lnlwn3kinIrU2h2DSQBrNui3DVxfQ==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirWithSuffix --- FAIL: TestSyncBackupDirWithSuffix (356.42s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:180: Remote "proton drive root link ID 'rclone-test-goxodah8liba'", Local "Local file system at /tmp/rclone3145443714", Modify Window "1s" 2025/10/11 02:50:28 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-goxodah8liba/dst" 2025/10/11 02:50:28 DEBUG : Config file has changed externally - reloading 2025/10/11 02:50:28 DEBUG : proton drive root link ID 'rclone-test-goxodah8liba/dst': Has cached credentials 2025/10/11 02:50:29 DEBUG : proton drive root link ID 'rclone-test-goxodah8liba/dst': Used cached credential to initialize the ProtonDrive API 2025/10/11 02:52:22 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-goxodah8liba/backup" 2025/10/11 02:52:22 DEBUG : proton drive root link ID 'rclone-test-goxodah8liba/backup': Has cached credentials 2025/10/11 02:52:24 DEBUG : proton drive root link ID 'rclone-test-goxodah8liba/backup': Used cached credential to initialize the ProtonDrive API 2025/10/11 02:56:09 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/10/11 02:56:09 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/10/11 02:56:09 DEBUG : two: Unchanged skipping 2025/10/11 02:56:09 DEBUG : proton drive root link ID 'rclone-test-goxodah8liba/dst': Waiting for checks to finish 2025/10/11 02:56:11.394428 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Xvju0w8iWro7xVUx4U6cAkKdQZusmBf64xfAcgBEey-ccTEcRW3v3s4LeYcEIsjEsRn1CT_CJ99AUVLUURkvoQ==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/11 02:56:11.394471 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Xvju0w8iWro7xVUx4U6cAkKdQZusmBf64xfAcgBEey-ccTEcRW3v3s4LeYcEIsjEsRn1CT_CJ99AUVLUURkvoQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/11 02:56:11 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/Xvju0w8iWro7xVUx4U6cAkKdQZusmBf64xfAcgBEey-ccTEcRW3v3s4LeYcEIsjEsRn1CT_CJ99AUVLUURkvoQ==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/11 02:56:11 DEBUG : proton drive root link ID 'rclone-test-goxodah8liba/dst': Waiting for transfers to finish 2025/10/11 02:56:11 ERROR : proton drive root link ID 'rclone-test-goxodah8liba/dst': not deleting files as there were IO errors 2025/10/11 02:56:11 ERROR : proton drive root link ID 'rclone-test-goxodah8liba/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/Xvju0w8iWro7xVUx4U6cAkKdQZusmBf64xfAcgBEey-ccTEcRW3v3s4LeYcEIsjEsRn1CT_CJ99AUVLUURkvoQ==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirWithSuffixKeepExtension --- FAIL: TestSyncBackupDirWithSuffixKeepExtension (354.73s) === RUN TestSyncBackupDirSuffixOnly run.go:180: Remote "proton drive root link ID 'rclone-test-goxodah8liba'", Local "Local file system at /tmp/rclone3145443714", Modify Window "1s" 2025/10/11 02:56:23 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-goxodah8liba/dst" 2025/10/11 02:56:23 DEBUG : proton drive root link ID 'rclone-test-goxodah8liba/dst': Has cached credentials 2025/10/11 02:56:24 DEBUG : proton drive root link ID 'rclone-test-goxodah8liba/dst': Used cached credential to initialize the ProtonDrive API 2025/10/11 02:58:20 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/10/11 02:58:20 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/10/11 02:58:20 DEBUG : proton drive root link ID 'rclone-test-goxodah8liba/dst': Waiting for checks to finish 2025/10/11 02:58:20 DEBUG : two: Unchanged skipping 2025/10/11 02:58:20.764792 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/1DHKWWwAPgmjSQPF9uZ4KPXqNAoaEPIMmWQ676hktrHygLHnkoLSlL8rwey_H8gBYHW7ZuQ2dzNpmlDq27Ydeg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/11 02:58:20.764921 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/1DHKWWwAPgmjSQPF9uZ4KPXqNAoaEPIMmWQ676hktrHygLHnkoLSlL8rwey_H8gBYHW7ZuQ2dzNpmlDq27Ydeg==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/11 02:58:20 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/1DHKWWwAPgmjSQPF9uZ4KPXqNAoaEPIMmWQ676hktrHygLHnkoLSlL8rwey_H8gBYHW7ZuQ2dzNpmlDq27Ydeg==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/11 02:58:20 DEBUG : proton drive root link ID 'rclone-test-goxodah8liba/dst': Waiting for transfers to finish 2025/10/11 02:58:20 ERROR : proton drive root link ID 'rclone-test-goxodah8liba/dst': not deleting files as there were IO errors 2025/10/11 02:58:20 ERROR : proton drive root link ID 'rclone-test-goxodah8liba/dst': not deleting directories as there were IO errors sync_test.go:2415: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2415 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2469 Error: Received unexpected error: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/1DHKWWwAPgmjSQPF9uZ4KPXqNAoaEPIMmWQ676hktrHygLHnkoLSlL8rwey_H8gBYHW7ZuQ2dzNpmlDq27Ydeg==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncBackupDirSuffixOnly --- FAIL: TestSyncBackupDirSuffixOnly (128.92s) === RUN TestSyncSuffix run.go:180: Remote "proton drive root link ID 'rclone-test-goxodah8liba'", Local "Local file system at /tmp/rclone3145443714", Modify Window "1s" 2025/10/11 02:58:32 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-goxodah8liba/dst" 2025/10/11 02:58:32 DEBUG : proton drive root link ID 'rclone-test-goxodah8liba/dst': Has cached credentials 2025/10/11 02:58:33 DEBUG : proton drive root link ID 'rclone-test-goxodah8liba/dst': Used cached credential to initialize the ProtonDrive API 2025/10/11 03:00:29 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/10/11 03:00:29.996469 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/zIJ4zU8h8XeWkZ8LHiVF033BPcgogAbDdTZAxBvf5LlLQry5R-qVU57KpPnLyCsDinhe2gAWc0CJCvS4b7gfjg==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/11 03:00:29.996498 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/zIJ4zU8h8XeWkZ8LHiVF033BPcgogAbDdTZAxBvf5LlLQry5R-qVU57KpPnLyCsDinhe2gAWc0CJCvS4b7gfjg==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/11 03:00:29 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/zIJ4zU8h8XeWkZ8LHiVF033BPcgogAbDdTZAxBvf5LlLQry5R-qVU57KpPnLyCsDinhe2gAWc0CJCvS4b7gfjg==/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/zIJ4zU8h8XeWkZ8LHiVF033BPcgogAbDdTZAxBvf5LlLQry5R-qVU57KpPnLyCsDinhe2gAWc0CJCvS4b7gfjg==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncSuffix --- FAIL: TestSyncSuffix (129.17s) === RUN TestSyncSuffixKeepExtension run.go:180: Remote "proton drive root link ID 'rclone-test-goxodah8liba'", Local "Local file system at /tmp/rclone3145443714", Modify Window "1s" 2025/10/11 03:00:41 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-goxodah8liba/dst" 2025/10/11 03:00:41 DEBUG : proton drive root link ID 'rclone-test-goxodah8liba/dst': Has cached credentials 2025/10/11 03:00:42 DEBUG : proton drive root link ID 'rclone-test-goxodah8liba/dst': Used cached credential to initialize the ProtonDrive API 2025/10/11 03:02:37 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/10/11 03:02:38.057550 WARN RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/5xX5uAvjJMGKYkcIB_ACza18U_IujdefgiWW3BpjJEk11SXn9kx6rq5ibm91uYJgrgLyexuat-XuArJCsxReFA==/move: This value should not be blank. (Code=2000, Status=400), Attempt 1 2025/10/11 03:02:38.057587 ERROR RESTY 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/5xX5uAvjJMGKYkcIB_ACza18U_IujdefgiWW3BpjJEk11SXn9kx6rq5ibm91uYJgrgLyexuat-XuArJCsxReFA==/move: This value should not be blank. (Code=2000, Status=400) 2025/10/11 03:02:38 ERROR : one: Couldn't move: 400 PUT https://mail.proton.me/api/drive/shares/gYxulUP2_XOrbAxegpHKiBy09cfvss6mjykkd2Z3ZDpMFCmoWX4bC2TTm-Gl2UwrjReC8te_lFsQyeXT74Vgfw==/links/5xX5uAvjJMGKYkcIB_ACza18U_IujdefgiWW3BpjJEk11SXn9kx6rq5ibm91uYJgrgLyexuat-XuArJCsxReFA==/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/5xX5uAvjJMGKYkcIB_ACza18U_IujdefgiWW3BpjJEk11SXn9kx6rq5ibm91uYJgrgLyexuat-XuArJCsxReFA==/move: This value should not be blank. (Code=2000, Status=400) Test: TestSyncSuffixKeepExtension --- FAIL: TestSyncSuffixKeepExtension (128.21s) FAIL 2025/10/11 03:02:41 DEBUG : proton drive root link ID 'rclone-test-goxodah8liba': 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 26m20.786496948s (try 2/5): exit status 1: Failed [TestServerSideMoveOverSelf TestSyncWithTrackRenames TestSyncWithTrackRenamesStrategyModtime TestSyncWithTrackRenamesStrategyLeaf TestMoveWithDeleteEmptySrcDirs TestServerSideMove TestServerSideMoveWithFilter TestServerSideMoveDeleteEmptySourceDirs TestSyncBackupDir TestSyncBackupDirWithSuffix TestSyncBackupDirWithSuffixKeepExtension TestSyncBackupDirSuffixOnly TestSyncSuffix TestSyncSuffixKeepExtension]