"./sync.test -test.v -test.timeout 1h0m0s -remote TestProtonDrive: -verbose -test.run '^(TestSyncWithTrackRenames|TestSyncWithUpdateOlder)$'" - Starting (try 2/5)
2024/11/26 04:48:20 DEBUG : Creating backend with remote "TestProtonDrive:rclone-test-kiwikud5quke"
2024/11/26 04:48:20 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2024/11/26 04:48:20 DEBUG : proton drive root link ID 'rclone-test-kiwikud5quke': Has cached credentials
2024/11/26 04:48:21 DEBUG : proton drive root link ID 'rclone-test-kiwikud5quke': Used cached credential to initialize the ProtonDrive API
2024/11/26 04:48:21 DEBUG : Creating backend with remote "/tmp/rclone2524455035"
=== RUN   TestSyncWithUpdateOlder
    run.go:180: Remote "proton drive root link ID 'rclone-test-kiwikud5quke'", Local "Local file system at /tmp/rclone2524455035", Modify Window "1s"
2024/11/26 04:48:26 DEBUG : five: Need to transfer - File not found at Destination
2024/11/26 04:48:26 DEBUG : four: Sizes differ (src 4 vs dst 8)
2024/11/26 04:48:26 DEBUG : one: Destination is newer than source, skipping
2024/11/26 04:48:26 DEBUG : three: Sizes identical
2024/11/26 04:48:26 DEBUG : proton drive root link ID 'rclone-test-kiwikud5quke': Waiting for checks to finish
2024/11/26 04:48:26 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b (Local file system at /tmp/rclone2524455035)
2024/11/26 04:48:26 DEBUG : two: sha1 = b10e0da85e90399abfec36c7376b20aa4596461b (proton drive root link ID 'rclone-test-kiwikud5quke')
2024/11/26 04:48:26 DEBUG : two: sha1 differ
2024/11/26 04:48:26 DEBUG : four: Destination mod time is within 1s of source but files differ, transferring
2024/11/26 04:48:26 DEBUG : three: Destination mod time is within 1s of source and files identical, skipping
2024/11/26 04:48:26 DEBUG : proton drive root link ID 'rclone-test-kiwikud5quke': Waiting for transfers to finish
2024/11/26 04:48:26.447922 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
2024/11/26 04:48:26.447952 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)
2024/11/26 04:48:26.481890 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
2024/11/26 04:48:26.481914 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)
2024/11/26 04:48:26 DEBUG : five: sha1 = 4db2c1df4610cd6c0da6b9197b066bfb4e9b9d00 OK
2024/11/26 04:48:26 INFO  : five: Copied (new)
2024/11/26 04:48:27 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK
2024/11/26 04:48:27 INFO  : two: Copied (replaced existing)
2024/11/26 04:48:27 DEBUG : four: sha1 = 9f8f7eec5dea5ac43738721939c120318cbff1df OK
2024/11/26 04:48:27 INFO  : four: Copied (replaced existing)
2024/11/26 04:48:27 DEBUG : Waiting for deletions to finish
2024/11/26 04:48:30 DEBUG : one: Destination is newer than source, skipping
2024/11/26 04:48:30 DEBUG : proton drive root link ID 'rclone-test-kiwikud5quke': Waiting for checks to finish
2024/11/26 04:48:30 DEBUG : four: sha1 = 9f8f7eec5dea5ac43738721939c120318cbff1df OK
2024/11/26 04:48:30 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK
2024/11/26 04:48:30 DEBUG : four: Size and sha1 of src and dst objects identical
2024/11/26 04:48:30 DEBUG : two: Size and sha1 of src and dst objects identical
2024/11/26 04:48:30 DEBUG : five: sha1 = 4db2c1df4610cd6c0da6b9197b066bfb4e9b9d00 OK
2024/11/26 04:48:30 DEBUG : three: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb (Local file system at /tmp/rclone2524455035)
2024/11/26 04:48:30 DEBUG : two: Destination mod time is within 1s of source and files identical, skipping
2024/11/26 04:48:30 DEBUG : three: sha1 = 03731cad13f4cf7b59703c77529381cdec1632e5 (proton drive root link ID 'rclone-test-kiwikud5quke')
2024/11/26 04:48:30 DEBUG : five: Size and sha1 of src and dst objects identical
2024/11/26 04:48:30 DEBUG : four: Destination mod time is within 1s of source and files identical, skipping
2024/11/26 04:48:30 DEBUG : three: sha1 differ
2024/11/26 04:48:30 DEBUG : five: Destination mod time is within 1s of source and files identical, skipping
2024/11/26 04:48:30 DEBUG : three: Destination mod time is within 1s of source but files differ, transferring
2024/11/26 04:48:30 DEBUG : proton drive root link ID 'rclone-test-kiwikud5quke': Waiting for transfers to finish
2024/11/26 04:48:30.257604 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
2024/11/26 04:48:30.257632 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)
2024/11/26 04:48:31 DEBUG : three: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK
2024/11/26 04:48:31 INFO  : three: Copied (replaced existing)
2024/11/26 04:48:31 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncWithUpdateOlder (12.57s)
=== RUN   TestSyncWithTrackRenames
    run.go:180: Remote "proton drive root link ID 'rclone-test-kiwikud5quke'", Local "Local file system at /tmp/rclone2524455035", Modify Window "1s"
    sync_test.go:1538: Can track renames: true
2024/11/26 04:48:34 INFO  : proton drive root link ID 'rclone-test-kiwikud5quke': Making map for --track-renames
2024/11/26 04:48:34 INFO  : proton drive root link ID 'rclone-test-kiwikud5quke': Finished making map for --track-renames
2024/11/26 04:48:34 DEBUG : proton drive root link ID 'rclone-test-kiwikud5quke': Waiting for checks to finish
2024/11/26 04:48:34 DEBUG : proton drive root link ID 'rclone-test-kiwikud5quke': Waiting for renames to finish
2024/11/26 04:48:34 DEBUG : potato: Need to transfer - No matching file found at Destination
2024/11/26 04:48:34 DEBUG : yam: Need to transfer - No matching file found at Destination
2024/11/26 04:48:34 DEBUG : proton drive root link ID 'rclone-test-kiwikud5quke': Waiting for transfers to finish
2024/11/26 04:48:34 DEBUG : potato: sha1 = 1d1ac61cfffcfdd0a15cc9ae575fb06ca8c11fb5 OK
2024/11/26 04:48:34 INFO  : potato: Copied (new)
2024/11/26 04:48:34 DEBUG : yam: sha1 = ad84b2fb6729688a5ee3225164a6d4d58465b33e OK
2024/11/26 04:48:34 INFO  : yam: Copied (new)
2024/11/26 04:48:34 DEBUG : Waiting for deletions to finish
    run.go:180: Remote "proton drive root link ID 'rclone-test-kiwikud5quke'", Local "Local file system at /tmp/rclone2524455035", Modify Window "1s"
2024/11/26 04:48:35 DEBUG : potato: Size and modification time the same (differ by -499.999999ms, within tolerance 1s)
2024/11/26 04:48:35 INFO  : proton drive root link ID 'rclone-test-kiwikud5quke': Making map for --track-renames
2024/11/26 04:48:35 INFO  : proton drive root link ID 'rclone-test-kiwikud5quke': Finished making map for --track-renames
2024/11/26 04:48:35 DEBUG : proton drive root link ID 'rclone-test-kiwikud5quke': Waiting for checks to finish
2024/11/26 04:48:35 DEBUG : potato: Unchanged skipping
2024/11/26 04:48:35 DEBUG : proton drive root link ID 'rclone-test-kiwikud5quke': Waiting for renames to finish
2024/11/26 04:48:41 INFO  : yam: Moved (server-side) to: yaml
2024/11/26 04:48:41 INFO  : yaml: Renamed from "yam"
2024/11/26 04:48:41 DEBUG : proton drive root link ID 'rclone-test-kiwikud5quke': Waiting for transfers to finish
2024/11/26 04:48:41 DEBUG : Waiting for deletions to finish
2024/11/26 04:48:41 INFO  : There was nothing to transfer
    run.go:180: Remote "proton drive root link ID 'rclone-test-kiwikud5quke'", Local "Local file system at /tmp/rclone2524455035", Modify Window "1s"
--- PASS: TestSyncWithTrackRenames (10.69s)
PASS
2024/11/26 04:48:44 DEBUG : proton drive root link ID 'rclone-test-kiwikud5quke': Purge remote
"./sync.test -test.v -test.timeout 1h0m0s -remote TestProtonDrive: -verbose -test.run '^(TestSyncWithTrackRenames|TestSyncWithUpdateOlder)$'" - Finished OK in 24.69428128s (try 2/5)