"./sync.test -test.v -test.timeout 1h0m0s -remote TestGoFile: -verbose -fast-list -test.run '^TestSyncConcurrentTruncate$'" - Starting (try 4/5) 2026/01/01 02:11:36 DEBUG : Creating backend with remote "TestGoFile:rclone-test-jekamiv2xica" 2026/01/01 02:11:36 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/01/01 02:11:36 DEBUG : Creating backend with remote "/tmp/rclone533951030" === RUN TestSyncConcurrentTruncate run.go:185: Remote "gofile root 'rclone-test-jekamiv2xica'", Local "Local file system at /tmp/rclone533951030", Modify Window "1s" 2026/01/01 02:11:47 DEBUG : both0: size = 6 OK 2026/01/01 02:11:47 DEBUG : both0: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2026/01/01 02:11:47 DEBUG : both11: size = 6 OK 2026/01/01 02:11:47 DEBUG : both11: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2026/01/01 02:11:47 DEBUG : both12: size = 6 OK 2026/01/01 02:11:47 DEBUG : both12: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2026/01/01 02:11:47 DEBUG : gofile root 'rclone-test-jekamiv2xica': Waiting for checks to finish 2026/01/01 02:11:47 DEBUG : both10: size = 6 OK 2026/01/01 02:11:47 DEBUG : both10: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2026/01/01 02:11:47 DEBUG : both0: Unchanged skipping 2026/01/01 02:11:47 DEBUG : both13: size = 6 OK 2026/01/01 02:11:47 DEBUG : both13: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2026/01/01 02:11:47 DEBUG : both13: Unchanged skipping 2026/01/01 02:11:47 DEBUG : both14: size = 6 OK 2026/01/01 02:11:47 DEBUG : both14: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2026/01/01 02:11:47 DEBUG : both14: Unchanged skipping 2026/01/01 02:11:47 DEBUG : both15: size = 6 OK 2026/01/01 02:11:47 DEBUG : both15: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2026/01/01 02:11:47 DEBUG : both15: Unchanged skipping 2026/01/01 02:11:47 DEBUG : both16: size = 6 OK 2026/01/01 02:11:47 DEBUG : both16: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2026/01/01 02:11:47 DEBUG : both16: Unchanged skipping 2026/01/01 02:11:47 DEBUG : both17: size = 6 OK 2026/01/01 02:11:47 DEBUG : both17: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2026/01/01 02:11:47 DEBUG : both17: Unchanged skipping 2026/01/01 02:11:47 DEBUG : both18: size = 6 OK 2026/01/01 02:11:47 DEBUG : both18: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2026/01/01 02:11:47 DEBUG : both11: Unchanged skipping 2026/01/01 02:11:47 DEBUG : both19: size = 6 OK 2026/01/01 02:11:47 DEBUG : both19: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2026/01/01 02:11:47 DEBUG : both12: Unchanged skipping 2026/01/01 02:11:47 DEBUG : both1: size = 6 OK 2026/01/01 02:11:47 DEBUG : both1: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2026/01/01 02:11:47 DEBUG : both1: Unchanged skipping 2026/01/01 02:11:47 DEBUG : both2: size = 6 OK 2026/01/01 02:11:47 DEBUG : both2: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2026/01/01 02:11:47 DEBUG : both18: Unchanged skipping 2026/01/01 02:11:47 DEBUG : both3: size = 6 OK 2026/01/01 02:11:47 DEBUG : both3: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2026/01/01 02:11:47 DEBUG : both19: Unchanged skipping 2026/01/01 02:11:47 DEBUG : both4: size = 6 OK 2026/01/01 02:11:47 DEBUG : both4: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2026/01/01 02:11:47 DEBUG : both10: Unchanged skipping 2026/01/01 02:11:47 DEBUG : both5: size = 6 OK 2026/01/01 02:11:47 DEBUG : both5: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2026/01/01 02:11:47 DEBUG : both2: Unchanged skipping 2026/01/01 02:11:47 DEBUG : both6: size = 6 OK 2026/01/01 02:11:47 DEBUG : both6: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2026/01/01 02:11:47 DEBUG : both6: Unchanged skipping 2026/01/01 02:11:47 DEBUG : both7: size = 6 OK 2026/01/01 02:11:47 DEBUG : both7: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2026/01/01 02:11:47 DEBUG : both7: Unchanged skipping 2026/01/01 02:11:47 DEBUG : both8: size = 6 OK 2026/01/01 02:11:47 DEBUG : both8: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2026/01/01 02:11:47 DEBUG : both8: Unchanged skipping 2026/01/01 02:11:47 DEBUG : both9: size = 6 OK 2026/01/01 02:11:47 DEBUG : both9: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2026/01/01 02:11:47 DEBUG : both9: Unchanged skipping 2026/01/01 02:11:47 DEBUG : only0: size = 0 (Local file system at /tmp/rclone533951030) 2026/01/01 02:11:47 DEBUG : only0: size = 6 (gofile root 'rclone-test-jekamiv2xica') 2026/01/01 02:11:47 DEBUG : only0: Sizes differ 2026/01/01 02:11:47 DEBUG : both3: Unchanged skipping 2026/01/01 02:11:47 DEBUG : both4: Unchanged skipping 2026/01/01 02:11:47 DEBUG : only11: size = 0 (Local file system at /tmp/rclone533951030) 2026/01/01 02:11:47 DEBUG : only11: size = 6 (gofile root 'rclone-test-jekamiv2xica') 2026/01/01 02:11:47 DEBUG : only11: Sizes differ 2026/01/01 02:11:47 DEBUG : only10: size = 0 (Local file system at /tmp/rclone533951030) 2026/01/01 02:11:47 DEBUG : only10: size = 6 (gofile root 'rclone-test-jekamiv2xica') 2026/01/01 02:11:47 DEBUG : only10: Sizes differ 2026/01/01 02:11:47 DEBUG : only13: size = 0 (Local file system at /tmp/rclone533951030) 2026/01/01 02:11:47 DEBUG : only13: size = 6 (gofile root 'rclone-test-jekamiv2xica') 2026/01/01 02:11:47 DEBUG : only13: Sizes differ 2026/01/01 02:11:47 DEBUG : only14: size = 0 (Local file system at /tmp/rclone533951030) 2026/01/01 02:11:47 DEBUG : only14: size = 6 (gofile root 'rclone-test-jekamiv2xica') 2026/01/01 02:11:47 DEBUG : only14: Sizes differ 2026/01/01 02:11:47 DEBUG : only15: size = 0 (Local file system at /tmp/rclone533951030) 2026/01/01 02:11:47 DEBUG : only15: size = 6 (gofile root 'rclone-test-jekamiv2xica') 2026/01/01 02:11:47 DEBUG : only15: Sizes differ 2026/01/01 02:11:47 DEBUG : only16: size = 0 (Local file system at /tmp/rclone533951030) 2026/01/01 02:11:47 DEBUG : only16: size = 6 (gofile root 'rclone-test-jekamiv2xica') 2026/01/01 02:11:47 DEBUG : only16: Sizes differ 2026/01/01 02:11:47 DEBUG : only17: size = 0 (Local file system at /tmp/rclone533951030) 2026/01/01 02:11:47 DEBUG : only17: size = 6 (gofile root 'rclone-test-jekamiv2xica') 2026/01/01 02:11:47 DEBUG : only17: Sizes differ 2026/01/01 02:11:47 DEBUG : only18: size = 0 (Local file system at /tmp/rclone533951030) 2026/01/01 02:11:47 DEBUG : only18: size = 6 (gofile root 'rclone-test-jekamiv2xica') 2026/01/01 02:11:47 DEBUG : only18: Sizes differ 2026/01/01 02:11:47 DEBUG : only19: size = 0 (Local file system at /tmp/rclone533951030) 2026/01/01 02:11:47 DEBUG : only19: size = 6 (gofile root 'rclone-test-jekamiv2xica') 2026/01/01 02:11:47 DEBUG : only19: Sizes differ 2026/01/01 02:11:47 DEBUG : only1: size = 0 (Local file system at /tmp/rclone533951030) 2026/01/01 02:11:47 DEBUG : only1: size = 6 (gofile root 'rclone-test-jekamiv2xica') 2026/01/01 02:11:47 DEBUG : only1: Sizes differ 2026/01/01 02:11:47 DEBUG : only2: size = 0 (Local file system at /tmp/rclone533951030) 2026/01/01 02:11:47 DEBUG : only2: size = 6 (gofile root 'rclone-test-jekamiv2xica') 2026/01/01 02:11:47 DEBUG : only2: Sizes differ 2026/01/01 02:11:47 DEBUG : only3: size = 0 (Local file system at /tmp/rclone533951030) 2026/01/01 02:11:47 DEBUG : only3: size = 6 (gofile root 'rclone-test-jekamiv2xica') 2026/01/01 02:11:47 DEBUG : only3: Sizes differ 2026/01/01 02:11:47 DEBUG : only4: size = 0 (Local file system at /tmp/rclone533951030) 2026/01/01 02:11:47 DEBUG : only4: size = 6 (gofile root 'rclone-test-jekamiv2xica') 2026/01/01 02:11:47 DEBUG : only4: Sizes differ 2026/01/01 02:11:47 DEBUG : only5: size = 0 (Local file system at /tmp/rclone533951030) 2026/01/01 02:11:47 DEBUG : only5: size = 6 (gofile root 'rclone-test-jekamiv2xica') 2026/01/01 02:11:47 DEBUG : only5: Sizes differ 2026/01/01 02:11:47 DEBUG : only6: size = 0 (Local file system at /tmp/rclone533951030) 2026/01/01 02:11:47 DEBUG : only6: size = 6 (gofile root 'rclone-test-jekamiv2xica') 2026/01/01 02:11:47 DEBUG : only6: Sizes differ 2026/01/01 02:11:47 DEBUG : only7: size = 0 (Local file system at /tmp/rclone533951030) 2026/01/01 02:11:47 DEBUG : only7: size = 6 (gofile root 'rclone-test-jekamiv2xica') 2026/01/01 02:11:47 DEBUG : only7: Sizes differ 2026/01/01 02:11:47 DEBUG : only12: size = 0 (Local file system at /tmp/rclone533951030) 2026/01/01 02:11:47 DEBUG : only12: size = 6 (gofile root 'rclone-test-jekamiv2xica') 2026/01/01 02:11:47 DEBUG : only12: Sizes differ 2026/01/01 02:11:47 DEBUG : only8: size = 0 (Local file system at /tmp/rclone533951030) 2026/01/01 02:11:47 DEBUG : only8: size = 6 (gofile root 'rclone-test-jekamiv2xica') 2026/01/01 02:11:47 DEBUG : only8: Sizes differ 2026/01/01 02:11:47 DEBUG : both5: Unchanged skipping 2026/01/01 02:11:47 DEBUG : only9: size = 0 (Local file system at /tmp/rclone533951030) 2026/01/01 02:11:47 DEBUG : only9: size = 6 (gofile root 'rclone-test-jekamiv2xica') 2026/01/01 02:11:47 DEBUG : only9: Sizes differ 2026/01/01 02:11:47 DEBUG : gofile root 'rclone-test-jekamiv2xica': Waiting for transfers to finish 2026/01/01 02:11:47 DEBUG : only11: Removing old object on successful upload 2026/01/01 02:11:47 DEBUG : only11: size = 0 OK 2026/01/01 02:11:47 DEBUG : only11: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/01/01 02:11:47 INFO : only11: Copied (replaced existing) 2026/01/01 02:11:47 DEBUG : only10: Removing old object on successful upload 2026/01/01 02:11:47 DEBUG : only15: Removing old object on successful upload 2026/01/01 02:11:47 DEBUG : only14: Removing old object on successful upload 2026/01/01 02:11:47 DEBUG : only13: Removing old object on successful upload 2026/01/01 02:11:47 DEBUG : only10: size = 0 OK 2026/01/01 02:11:47 DEBUG : only10: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/01/01 02:11:47 INFO : only10: Copied (replaced existing) 2026/01/01 02:11:47 DEBUG : only15: size = 0 OK 2026/01/01 02:11:47 DEBUG : only15: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/01/01 02:11:47 INFO : only15: Copied (replaced existing) 2026/01/01 02:11:47 DEBUG : only14: size = 0 OK 2026/01/01 02:11:47 DEBUG : only14: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/01/01 02:11:47 INFO : only14: Copied (replaced existing) 2026/01/01 02:11:47 DEBUG : only13: size = 0 OK 2026/01/01 02:11:47 DEBUG : only13: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/01/01 02:11:47 INFO : only13: Copied (replaced existing) 2026/01/01 02:11:47 DEBUG : only16: Removing old object on successful upload 2026/01/01 02:11:47 DEBUG : only18: Removing old object on successful upload 2026/01/01 02:11:47 DEBUG : only19: Removing old object on successful upload 2026/01/01 02:11:47 DEBUG : only16: size = 0 OK 2026/01/01 02:11:47 DEBUG : only16: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/01/01 02:11:47 INFO : only16: Copied (replaced existing) 2026/01/01 02:11:47 DEBUG : only17: Removing old object on successful upload 2026/01/01 02:11:48 DEBUG : only18: size = 0 OK 2026/01/01 02:11:48 DEBUG : only18: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/01/01 02:11:48 INFO : only18: Copied (replaced existing) 2026/01/01 02:11:48 DEBUG : only1: Removing old object on successful upload 2026/01/01 02:11:48 DEBUG : only19: size = 0 OK 2026/01/01 02:11:48 DEBUG : only19: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/01/01 02:11:48 INFO : only19: Copied (replaced existing) 2026/01/01 02:11:48 DEBUG : only17: size = 0 OK 2026/01/01 02:11:48 DEBUG : only17: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/01/01 02:11:48 INFO : only17: Copied (replaced existing) 2026/01/01 02:11:48 DEBUG : only1: size = 0 OK 2026/01/01 02:11:48 DEBUG : only1: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/01/01 02:11:48 INFO : only1: Copied (replaced existing) 2026/01/01 02:11:48 DEBUG : only4: Removing old object on successful upload 2026/01/01 02:11:48 DEBUG : only3: Removing old object on successful upload 2026/01/01 02:11:48 DEBUG : only4: size = 0 OK 2026/01/01 02:11:48 DEBUG : only4: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/01/01 02:11:48 INFO : only4: Copied (replaced existing) 2026/01/01 02:11:48 DEBUG : only2: Removing old object on successful upload 2026/01/01 02:11:48 DEBUG : only5: Removing old object on successful upload 2026/01/01 02:11:48 DEBUG : only3: size = 0 OK 2026/01/01 02:11:48 DEBUG : only3: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/01/01 02:11:48 INFO : only3: Copied (replaced existing) 2026/01/01 02:11:48 DEBUG : only0: Removing old object on successful upload 2026/01/01 02:11:48 DEBUG : only5: size = 0 OK 2026/01/01 02:11:48 DEBUG : only5: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/01/01 02:11:48 INFO : only5: Copied (replaced existing) 2026/01/01 02:11:48 DEBUG : only2: size = 0 OK 2026/01/01 02:11:48 DEBUG : only2: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/01/01 02:11:48 INFO : only2: Copied (replaced existing) 2026/01/01 02:11:48 DEBUG : only6: Removing old object on successful upload 2026/01/01 02:11:48 DEBUG : only0: size = 0 OK 2026/01/01 02:11:48 DEBUG : only0: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/01/01 02:11:48 INFO : only0: Copied (replaced existing) 2026/01/01 02:11:48 DEBUG : only6: size = 0 OK 2026/01/01 02:11:48 DEBUG : only6: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/01/01 02:11:48 INFO : only6: Copied (replaced existing) 2026/01/01 02:11:48 DEBUG : only7: Removing old object on successful upload 2026/01/01 02:11:48 DEBUG : only12: Removing old object on successful upload 2026/01/01 02:11:48 DEBUG : only7: size = 0 OK 2026/01/01 02:11:48 DEBUG : only7: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/01/01 02:11:48 INFO : only7: Copied (replaced existing) 2026/01/01 02:11:48 DEBUG : only9: Removing old object on successful upload 2026/01/01 02:11:48 DEBUG : only8: Removing old object on successful upload 2026/01/01 02:11:48 DEBUG : only12: size = 0 OK 2026/01/01 02:11:48 DEBUG : only12: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/01/01 02:11:48 INFO : only12: Copied (replaced existing) 2026/01/01 02:11:48 DEBUG : only9: size = 0 OK 2026/01/01 02:11:48 DEBUG : only9: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/01/01 02:11:48 INFO : only9: Copied (replaced existing) 2026/01/01 02:11:48 DEBUG : only8: size = 0 OK 2026/01/01 02:11:48 DEBUG : only8: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2026/01/01 02:11:48 INFO : only8: Copied (replaced existing) 2026/01/01 02:11:48 DEBUG : Waiting for deletions to finish fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:301: Flushing the directory cache fstest.go:305: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:345 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2785 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2793 /usr/local/go/src/runtime/asm_amd64.s:1700 Error: Should be true Test: TestSyncConcurrentTruncate Messages: listing wrong, want both0 (6), both1 (6), both10 (6), both11 (6), both12 (6), both13 (6), both14 (6), both15 (6), both16 (6), both17 (6), both18 (6), both19 (6), both2 (6), both3 (6), both4 (6), both5 (6), both6 (6), both7 (6), both8 (6), both9 (6), only0 (0), only1 (0), only10 (0), only11 (0), only12 (0), only13 (0), only14 (0), only15 (0), only16 (0), only17 (0), only18 (0), only19 (0), only2 (0), only3 (0), only4 (0), only5 (0), only6 (0), only7 (0), only8 (0), only9 (0) got both0 (6), both1 (6), both10 (6), both11 (6), both12 (6), both13 (6), both14 (6), both15 (6), both16 (6), both17 (6), both18 (6), both19 (6), both2 (6), both3 (6), both4 (6), both5 (6), both6 (6), both7 (6), both8 (6), both9 (6) fstest.go:203: Not found "only2" fstest.go:203: Not found "only3" fstest.go:203: Not found "only19" fstest.go:203: Not found "only10" fstest.go:203: Not found "only17" fstest.go:203: Not found "only1" fstest.go:203: Not found "only5" fstest.go:203: Not found "only9" fstest.go:203: Not found "only14" fstest.go:203: Not found "only15" fstest.go:203: Not found "only8" fstest.go:203: Not found "only12" fstest.go:203: Not found "only0" fstest.go:203: Not found "only6" fstest.go:203: Not found "only7" fstest.go:203: Not found "only11" fstest.go:203: Not found "only13" fstest.go:203: Not found "only4" fstest.go:203: Not found "only16" fstest.go:203: Not found "only18" fstest.go:206: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:206 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:310 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:345 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2785 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2793 Error: Not equal: expected: 0 actual : 20 Test: TestSyncConcurrentTruncate Messages: 20 objects not found --- FAIL: TestSyncConcurrentTruncate (22.09s) FAIL 2026/01/01 02:11:58 DEBUG : gofile root 'rclone-test-jekamiv2xica': Purge remote "./sync.test -test.v -test.timeout 1h0m0s -remote TestGoFile: -verbose -fast-list -test.run '^TestSyncConcurrentTruncate$'" - Finished ERROR in 22.619043119s (try 4/5): exit status 1: Failed [TestSyncConcurrentTruncate]