"./sync.test -test.v -test.timeout 1h0m0s -remote TestFilesCom: -verbose -test.run '^TestSyncBackupDirWithSuffixKeepExtension$'" - Starting (try 2/5) 2024/09/24 05:21:46 DEBUG : Creating backend with remote "TestFilesCom:rclone-test-lozubuy0baye" 2024/09/24 05:21:46 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2024/09/24 05:21:47 DEBUG : Creating backend with remote "/tmp/rclone887219688" === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:180: Remote "files root 'rclone-test-lozubuy0baye'", Local "Local file system at /tmp/rclone887219688", Modify Window "1s" 2024/09/24 05:21:51 DEBUG : Creating backend with remote "TestFilesCom:rclone-test-lozubuy0baye/dst" 2024/09/24 05:21:51 DEBUG : Creating backend with remote "TestFilesCom:rclone-test-lozubuy0baye/backup" 2024/09/24 05:21:53 DEBUG : one: Sizes differ (src 4 vs dst 3) 2024/09/24 05:21:53 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/09/24 05:21:53 DEBUG : files root 'rclone-test-lozubuy0baye/dst': Waiting for checks to finish 2024/09/24 05:21:53 DEBUG : two: Unchanged skipping 2024/09/24 05:21:53 INFO : one: Moved (server-side) to: one-2019-01-01 2024/09/24 05:21:53 DEBUG : files root 'rclone-test-lozubuy0baye/dst': Waiting for transfers to finish 2024/09/24 05:21:55 DEBUG : one: md5 = c7957179c41f69d44f217a108c7915d8 OK 2024/09/24 05:21:55 INFO : one: Copied (new) 2024/09/24 05:21:55 DEBUG : Waiting for deletions to finish 2024/09/24 05:21:56 INFO : three.txt: Moved (server-side) to: three-2019-01-01.txt 2024/09/24 05:21:56 INFO : three.txt: Moved into backup dir 2024/09/24 05:21:57 DEBUG : pacer: low level retry 1/10 (error Put "https://s3.amazonaws.com/objects.brickftp.com/metadata/126732/026d7f25-5ed2-4a45-92ff-a92493cbfc45?X-Amz-Algorithm=AWS4-HMAC-SHA256&X-Amz-Credential=AKIAIEWLY3MN4YGZQOWA%2F20240924%2Fus-east-1%2Fs3%2Faws4_request&X-Amz-Date=20240924T052156Z&X-Amz-Expires=900&X-Amz-SignedHeaders=host&partNumber=1&response-content-type=application%2Foctet-stream&uploadId=rqyuSJDEP50JXJJW809uOnObTCYOSaDOrQZhRCzCX_69GKn7CCEDJlnu50D5CdB95B8v2_b46O6YaYhtOqdw87blZETH9yEnT6dsQVe6ecUW.9tAV8JUZSvLVvfVFrFL&X-Amz-Signature=7fa57584f72dae5c064b410666e32be6ee10df9f2d084555b6ca5d0e4f0d511f": net/http: HTTP/1.x transport connection broken: http: ContentLength=6 with Body length 0) 2024/09/24 05:21:57 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2024/09/24 05:21:58 DEBUG : pacer: Reducing sleep to 15ms 2024/09/24 05:21:58 DEBUG : pacer: Reducing sleep to 11.25ms 2024/09/24 05:21:58 DEBUG : pacer: Reducing sleep to 10ms fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:292: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:292: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:299: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:299 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2302 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2330 Error: Should be true Test: TestSyncBackupDirWithSuffixKeepExtension Messages: listing wrong, want backup/one-2019-01-01 (3), backup/three-2019-01-01.txt (5), dst/one (4), dst/three.txt (6), dst/two (3) got backup/one-2019-01-01 (3), backup/three-2019-01-01.txt (5), dst/one (4), dst/three.txt (0), dst/two (3) fstest.go:137: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:137 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:143 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:189 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2302 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2330 Error: Should be true Test: TestSyncBackupDirWithSuffixKeepExtension Messages: files root 'rclone-test-lozubuy0baye'/dst/three.txt: md5 hash incorrect - expecting "91341eed84691a83caea73aa785736d5" got "d41d8cd98f00b204e9800998ecf8427e" fstest.go:137: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:137 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:143 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:189 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2302 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2330 Error: Should be true Test: TestSyncBackupDirWithSuffixKeepExtension Messages: files root 'rclone-test-lozubuy0baye'/dst/three.txt: crc32 hash incorrect - expecting "1e485dc0" got "00000000" fstest.go:144: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:144 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:189 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2302 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2330 Error: Not equal: expected: 6 actual : 0 Test: TestSyncBackupDirWithSuffixKeepExtension Messages: dst/three.txt: size incorrect file=6 vs obj=0 2024/09/24 05:22:07 DEBUG : one: Sizes differ (src 5 vs dst 4) 2024/09/24 05:22:07 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2024/09/24 05:22:07 DEBUG : two: Unchanged skipping 2024/09/24 05:22:07 DEBUG : files root 'rclone-test-lozubuy0baye/dst': Waiting for checks to finish 2024/09/24 05:22:07 INFO : one-2019-01-01: Deleted 2024/09/24 05:22:08 INFO : one: Moved (server-side) to: one-2019-01-01 2024/09/24 05:22:08 DEBUG : files root 'rclone-test-lozubuy0baye/dst': Waiting for transfers to finish 2024/09/24 05:22:09 DEBUG : one: Dst hash empty - aborting Src hash check 2024/09/24 05:22:09 INFO : one: Copied (new) 2024/09/24 05:22:09 DEBUG : Waiting for deletions to finish 2024/09/24 05:22:10 INFO : three-2019-01-01.txt: Deleted 2024/09/24 05:22:10 INFO : three.txt: Moved (server-side) to: three-2019-01-01.txt 2024/09/24 05:22:10 INFO : three.txt: Moved into backup dir fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:292: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:292: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:299: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:299 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2321 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2330 Error: Should be true Test: TestSyncBackupDirWithSuffixKeepExtension Messages: listing wrong, want backup/one-2019-01-01 (4), backup/three-2019-01-01.txt (6), dst/one (5), dst/two (3) got backup/one-2019-01-01 (4), backup/three-2019-01-01.txt (0), dst/one (5), dst/two (3) fstest.go:137: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:137 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:143 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:189 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2321 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2330 Error: Should be true Test: TestSyncBackupDirWithSuffixKeepExtension Messages: files root 'rclone-test-lozubuy0baye'/backup/three-2019-01-01.txt: md5 hash incorrect - expecting "91341eed84691a83caea73aa785736d5" got "d41d8cd98f00b204e9800998ecf8427e" fstest.go:137: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:137 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:143 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:189 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2321 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2330 Error: Should be true Test: TestSyncBackupDirWithSuffixKeepExtension Messages: files root 'rclone-test-lozubuy0baye'/backup/three-2019-01-01.txt: crc32 hash incorrect - expecting "1e485dc0" got "00000000" fstest.go:144: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:144 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:189 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2321 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2330 Error: Not equal: expected: 6 actual : 0 Test: TestSyncBackupDirWithSuffixKeepExtension Messages: backup/three-2019-01-01.txt: size incorrect file=6 vs obj=0 --- FAIL: TestSyncBackupDirWithSuffixKeepExtension (32.19s) FAIL 2024/09/24 05:22:19 DEBUG : files root 'rclone-test-lozubuy0baye': Purge remote "./sync.test -test.v -test.timeout 1h0m0s -remote TestFilesCom: -verbose -test.run '^TestSyncBackupDirWithSuffixKeepExtension$'" - Finished ERROR in 33.216527643s (try 2/5): exit status 1: Failed [TestSyncBackupDirWithSuffixKeepExtension]