"./sync.test -test.v -test.timeout 1h0m0s -remote TestPcloud: -verbose -test.run '^(TestSyncDoesntUpdateModtime|TestSyncOverlapWithFilter)$'" - Starting (try 2/5) 2024/09/20 01:33:15 DEBUG : Creating backend with remote "TestPcloud:rclone-test-kapuzab8xoga" 2024/09/20 01:33:15 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2024/09/20 01:33:15 DEBUG : Creating backend with remote "/tmp/rclone1312662555" === RUN TestSyncDoesntUpdateModtime run.go:180: Remote "pcloud root 'rclone-test-kapuzab8xoga'", Local "Local file system at /tmp/rclone1312662555", Modify Window "1s" 2024/09/20 01:33:16 DEBUG : pcloud root 'rclone-test-kapuzab8xoga': Waiting for checks to finish 2024/09/20 01:33:16 DEBUG : foo: Modification times differ by -95456h54m53.123456789s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06 +0000 UTC 2024/09/20 01:33:16 DEBUG : foo: sha1 = 0beec7b5ea3f0fdbc95d0dd47f3c5bc275da8a33 (Local file system at /tmp/rclone1312662555) 2024/09/20 01:33:16 DEBUG : foo: sha1 = 62cdb7020ff920e5aa642c3d4066950dd1f01f4d (pcloud root 'rclone-test-kapuzab8xoga') 2024/09/20 01:33:16 DEBUG : foo: sha1 differ 2024/09/20 01:33:16 DEBUG : pcloud root 'rclone-test-kapuzab8xoga': Waiting for transfers to finish 2024/09/20 01:33:16 DEBUG : foo: sha1 = 0beec7b5ea3f0fdbc95d0dd47f3c5bc275da8a33 OK 2024/09/20 01:33:16 DEBUG : foo.5d8fa229.partial: renamed to: foo 2024/09/20 01:33:16 INFO : foo: Copied (replaced existing) 2024/09/20 01:33:16 DEBUG : Waiting for deletions to finish run.go:180: Remote "pcloud root 'rclone-test-kapuzab8xoga'", Local "Local file system at /tmp/rclone1312662555", Modify Window "1s" fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:295: Flushing the directory cache fstest.go:286: Sleeping for 6s just to make sure --- PASS: TestSyncDoesntUpdateModtime (8.86s) === RUN TestSyncOverlapWithFilter run.go:180: Remote "pcloud root 'rclone-test-kapuzab8xoga'", Local "Local file system at /tmp/rclone1312662555", Modify Window "1s" 2024/09/20 01:33:24 DEBUG : Creating backend with remote "TestPcloud:rclone-test-kapuzab8xoga/rclone-sync-test" 2024/09/20 01:33:25 DEBUG : Creating backend with remote "TestPcloud:rclone-test-kapuzab8xoga/rclone-sync-test-include/layer2" 2024/09/20 01:33:26 DEBUG : Creating backend with remote "TestPcloud:rclone-test-kapuzab8xoga/rclone-sync-test-ignore-file" 2024/09/20 01:33:27 DEBUG : rclone-sync-test: Excluded 2024/09/20 01:33:27 DEBUG : rclone-sync-test-ignore-file: Excluded 2024/09/20 01:33:28 DEBUG : rclone-sync-test-include/layer2: Excluded 2024/09/20 01:33:28 DEBUG : pcloud root 'rclone-test-kapuzab8xoga/rclone-sync-test': Waiting for checks to finish 2024/09/20 01:33:28 DEBUG : pcloud root 'rclone-test-kapuzab8xoga/rclone-sync-test': Waiting for transfers to finish 2024/09/20 01:33:28 DEBUG : Waiting for deletions to finish 2024/09/20 01:33:28 INFO : There was nothing to transfer 2024/09/20 01:33:28 DEBUG : rclone-sync-test: Excluded 2024/09/20 01:33:28 DEBUG : rclone-sync-test-ignore-file: Excluded 2024/09/20 01:33:28 DEBUG : rclone-sync-test-include/layer2: Excluded 2024/09/20 01:33:28 DEBUG : pcloud root 'rclone-test-kapuzab8xoga': Waiting for checks to finish 2024/09/20 01:33:28 DEBUG : pcloud root 'rclone-test-kapuzab8xoga': Waiting for transfers to finish 2024/09/20 01:33:28 DEBUG : Waiting for deletions to finish 2024/09/20 01:33:28 INFO : rclone-sync-test-include: Removing directory 2024/09/20 01:33:28 DEBUG : rclone-sync-test-include: Failed to Rmdir: rmdir failed: pcloud error: Folder is not empty. (2006) 2024/09/20 01:33:28 DEBUG : pcloud root 'rclone-test-kapuzab8xoga': failed to delete 1 directories 2024/09/20 01:33:28 INFO : There was nothing to transfer run.go:180: Remote "pcloud root 'rclone-test-kapuzab8xoga'", Local "Local file system at /tmp/rclone1312662555", Modify Window "1s" run.go:180: Remote "pcloud root 'rclone-test-kapuzab8xoga'", Local "Local file system at /tmp/rclone1312662555", Modify Window "1s" run.go:180: Remote "pcloud root 'rclone-test-kapuzab8xoga'", Local "Local file system at /tmp/rclone1312662555", Modify Window "1s" run.go:180: Remote "pcloud root 'rclone-test-kapuzab8xoga'", Local "Local file system at /tmp/rclone1312662555", Modify Window "1s" run.go:180: Remote "pcloud root 'rclone-test-kapuzab8xoga'", Local "Local file system at /tmp/rclone1312662555", Modify Window "1s" run.go:180: Remote "pcloud root 'rclone-test-kapuzab8xoga'", Local "Local file system at /tmp/rclone1312662555", Modify Window "1s" 2024/09/20 01:33:29 DEBUG : rclone-sync-test: Excluded 2024/09/20 01:33:29 DEBUG : rclone-sync-test-ignore-file: Excluded 2024/09/20 01:33:29 DEBUG : rclone-sync-test-include/layer2: Excluded 2024/09/20 01:33:29 DEBUG : pcloud root 'rclone-test-kapuzab8xoga/rclone-sync-test-include/layer2': Waiting for checks to finish 2024/09/20 01:33:29 DEBUG : pcloud root 'rclone-test-kapuzab8xoga/rclone-sync-test-include/layer2': Waiting for transfers to finish 2024/09/20 01:33:29 DEBUG : Waiting for deletions to finish 2024/09/20 01:33:29 INFO : There was nothing to transfer run.go:180: Remote "pcloud root 'rclone-test-kapuzab8xoga'", Local "Local file system at /tmp/rclone1312662555", Modify Window "1s" run.go:180: Remote "pcloud root 'rclone-test-kapuzab8xoga'", Local "Local file system at /tmp/rclone1312662555", Modify Window "1s" 2024/09/20 01:33:29 DEBUG : rclone-sync-test: Excluded 2024/09/20 01:33:29 DEBUG : rclone-sync-test-ignore-file: Excluded 2024/09/20 01:33:30 DEBUG : rclone-sync-test-include/layer2: Excluded 2024/09/20 01:33:30 DEBUG : pcloud root 'rclone-test-kapuzab8xoga': Waiting for checks to finish 2024/09/20 01:33:30 DEBUG : pcloud root 'rclone-test-kapuzab8xoga': Waiting for transfers to finish 2024/09/20 01:33:30 DEBUG : Waiting for deletions to finish 2024/09/20 01:33:30 INFO : rclone-sync-test-include: Removing directory 2024/09/20 01:33:30 DEBUG : rclone-sync-test-include: Failed to Rmdir: rmdir failed: pcloud error: Folder is not empty. (2006) 2024/09/20 01:33:30 DEBUG : pcloud root 'rclone-test-kapuzab8xoga': failed to delete 1 directories 2024/09/20 01:33:30 INFO : There was nothing to transfer run.go:180: Remote "pcloud root 'rclone-test-kapuzab8xoga'", Local "Local file system at /tmp/rclone1312662555", Modify Window "1s" run.go:180: Remote "pcloud root 'rclone-test-kapuzab8xoga'", Local "Local file system at /tmp/rclone1312662555", Modify Window "1s" run.go:180: Remote "pcloud root 'rclone-test-kapuzab8xoga'", Local "Local file system at /tmp/rclone1312662555", Modify Window "1s" run.go:180: Remote "pcloud root 'rclone-test-kapuzab8xoga'", Local "Local file system at /tmp/rclone1312662555", Modify Window "1s" 2024/09/20 01:33:30 DEBUG : : Excluded 2024/09/20 01:33:30 DEBUG : rclone-sync-test: Excluded 2024/09/20 01:33:30 DEBUG : rclone-sync-test-ignore-file: Excluded 2024/09/20 01:33:30 DEBUG : rclone-sync-test-include/layer2: Excluded 2024/09/20 01:33:30 DEBUG : pcloud root 'rclone-test-kapuzab8xoga/rclone-sync-test-ignore-file': Waiting for checks to finish 2024/09/20 01:33:30 DEBUG : pcloud root 'rclone-test-kapuzab8xoga/rclone-sync-test-ignore-file': Waiting for transfers to finish 2024/09/20 01:33:30 DEBUG : Waiting for deletions to finish 2024/09/20 01:33:30 INFO : There was nothing to transfer run.go:180: Remote "pcloud root 'rclone-test-kapuzab8xoga'", Local "Local file system at /tmp/rclone1312662555", Modify Window "1s" run.go:180: Remote "pcloud root 'rclone-test-kapuzab8xoga'", Local "Local file system at /tmp/rclone1312662555", Modify Window "1s" run.go:180: Remote "pcloud root 'rclone-test-kapuzab8xoga'", Local "Local file system at /tmp/rclone1312662555", Modify Window "1s" run.go:180: Remote "pcloud root 'rclone-test-kapuzab8xoga'", Local "Local file system at /tmp/rclone1312662555", Modify Window "1s" run.go:180: Remote "pcloud root 'rclone-test-kapuzab8xoga'", Local "Local file system at /tmp/rclone1312662555", Modify Window "1s" --- PASS: TestSyncOverlapWithFilter (9.74s) PASS 2024/09/20 01:33:34 DEBUG : pcloud root 'rclone-test-kapuzab8xoga': Purge remote "./sync.test -test.v -test.timeout 1h0m0s -remote TestPcloud: -verbose -test.run '^(TestSyncDoesntUpdateModtime|TestSyncOverlapWithFilter)$'" - Finished OK in 19.108186307s (try 2/5)