"./sync.test -test.v -test.timeout 2h0m0s -remote TestPutio: -verbose -test.run '^TestSyncConcurrentTruncate$'" - Starting (try 2/5) 2026/09/29 03:49:19 DEBUG : Creating backend with remote "TestPutio:rclone-test-munayal6wepo" 2026/09/29 03:49:19 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/09/29 03:49:20 DEBUG : Creating backend with remote "/tmp/rclone3227105426" === RUN TestSyncConcurrentTruncate run.go:198: Remote "Putio root 'rclone-test-munayal6wepo'", Local "Local file system at /tmp/rclone3227105426", Modify Window "1s" 2026/09/29 03:49:20 DEBUG : Putio root 'rclone-test-munayal6wepo': chunkStart: 0, reqSize: 6 2026/09/29 03:49:20 DEBUG : Putio root 'rclone-test-munayal6wepo': Sending chunk. transferOffset: 0 length: 6 2026/09/29 03:49:21 DEBUG : Putio root 'rclone-test-munayal6wepo': chunkStart: 0, reqSize: 6 2026/09/29 03:49:21 DEBUG : Putio root 'rclone-test-munayal6wepo': Sending chunk. transferOffset: 0 length: 6 2026/09/29 03:49:22 DEBUG : Putio root 'rclone-test-munayal6wepo': chunkStart: 0, reqSize: 6 2026/09/29 03:49:22 DEBUG : Putio root 'rclone-test-munayal6wepo': Sending chunk. transferOffset: 0 length: 6 2026/09/29 03:49:23 DEBUG : Putio root 'rclone-test-munayal6wepo': chunkStart: 0, reqSize: 6 2026/09/29 03:49:23 DEBUG : Putio root 'rclone-test-munayal6wepo': Sending chunk. transferOffset: 0 length: 6 2026/09/29 03:49:24 DEBUG : Putio root 'rclone-test-munayal6wepo': chunkStart: 0, reqSize: 6 2026/09/29 03:49:24 DEBUG : Putio root 'rclone-test-munayal6wepo': Sending chunk. transferOffset: 0 length: 6 2026/09/29 03:49:24 DEBUG : Putio root 'rclone-test-munayal6wepo': chunkStart: 0, reqSize: 6 2026/09/29 03:49:24 DEBUG : Putio root 'rclone-test-munayal6wepo': Sending chunk. transferOffset: 0 length: 6 2026/09/29 03:49:25 DEBUG : Putio root 'rclone-test-munayal6wepo': chunkStart: 0, reqSize: 6 2026/09/29 03:49:25 DEBUG : Putio root 'rclone-test-munayal6wepo': Sending chunk. transferOffset: 0 length: 6 2026/09/29 03:49:26 DEBUG : Putio root 'rclone-test-munayal6wepo': chunkStart: 0, reqSize: 6 2026/09/29 03:49:26 DEBUG : Putio root 'rclone-test-munayal6wepo': Sending chunk. transferOffset: 0 length: 6 2026/09/29 03:49:27 DEBUG : Putio root 'rclone-test-munayal6wepo': chunkStart: 0, reqSize: 6 2026/09/29 03:49:27 DEBUG : Putio root 'rclone-test-munayal6wepo': Sending chunk. transferOffset: 0 length: 6 2026/09/29 03:49:28 DEBUG : Putio root 'rclone-test-munayal6wepo': chunkStart: 0, reqSize: 6 2026/09/29 03:49:28 DEBUG : Putio root 'rclone-test-munayal6wepo': Sending chunk. transferOffset: 0 length: 6 2026/09/29 03:49:28 DEBUG : Putio root 'rclone-test-munayal6wepo': chunkStart: 0, reqSize: 6 2026/09/29 03:49:28 DEBUG : Putio root 'rclone-test-munayal6wepo': Sending chunk. transferOffset: 0 length: 6 2026/09/29 03:49:29 DEBUG : Putio root 'rclone-test-munayal6wepo': chunkStart: 0, reqSize: 6 2026/09/29 03:49:29 DEBUG : Putio root 'rclone-test-munayal6wepo': Sending chunk. transferOffset: 0 length: 6 2026/09/29 03:49:30 DEBUG : Putio root 'rclone-test-munayal6wepo': chunkStart: 0, reqSize: 6 2026/09/29 03:49:30 DEBUG : Putio root 'rclone-test-munayal6wepo': Sending chunk. transferOffset: 0 length: 6 2026/09/29 03:49:30 DEBUG : Putio root 'rclone-test-munayal6wepo': chunkStart: 0, reqSize: 6 2026/09/29 03:49:30 DEBUG : Putio root 'rclone-test-munayal6wepo': Sending chunk. transferOffset: 0 length: 6 2026/09/29 03:49:31 DEBUG : Putio root 'rclone-test-munayal6wepo': chunkStart: 0, reqSize: 6 2026/09/29 03:49:31 DEBUG : Putio root 'rclone-test-munayal6wepo': Sending chunk. transferOffset: 0 length: 6 2026/09/29 03:49:32 DEBUG : Putio root 'rclone-test-munayal6wepo': chunkStart: 0, reqSize: 6 2026/09/29 03:49:32 DEBUG : Putio root 'rclone-test-munayal6wepo': Sending chunk. transferOffset: 0 length: 6 2026/09/29 03:49:33 DEBUG : Putio root 'rclone-test-munayal6wepo': chunkStart: 0, reqSize: 6 2026/09/29 03:49:33 DEBUG : Putio root 'rclone-test-munayal6wepo': Sending chunk. transferOffset: 0 length: 6 2026/09/29 03:49:34 DEBUG : Putio root 'rclone-test-munayal6wepo': chunkStart: 0, reqSize: 6 2026/09/29 03:49:34 DEBUG : Putio root 'rclone-test-munayal6wepo': Sending chunk. transferOffset: 0 length: 6 2026/09/29 03:49:34 DEBUG : Putio root 'rclone-test-munayal6wepo': chunkStart: 0, reqSize: 6 2026/09/29 03:49:34 DEBUG : Putio root 'rclone-test-munayal6wepo': Sending chunk. transferOffset: 0 length: 6 2026/09/29 03:49:35 DEBUG : Putio root 'rclone-test-munayal6wepo': chunkStart: 0, reqSize: 6 2026/09/29 03:49:35 DEBUG : Putio root 'rclone-test-munayal6wepo': Sending chunk. transferOffset: 0 length: 6 2026/09/29 03:49:36 DEBUG : Putio root 'rclone-test-munayal6wepo': chunkStart: 0, reqSize: 6 2026/09/29 03:49:36 DEBUG : Putio root 'rclone-test-munayal6wepo': Sending chunk. transferOffset: 0 length: 6 2026/09/29 03:49:37 DEBUG : Putio root 'rclone-test-munayal6wepo': chunkStart: 0, reqSize: 6 2026/09/29 03:49:37 DEBUG : Putio root 'rclone-test-munayal6wepo': Sending chunk. transferOffset: 0 length: 6 2026/09/29 03:49:37 DEBUG : Putio root 'rclone-test-munayal6wepo': chunkStart: 0, reqSize: 6 2026/09/29 03:49:37 DEBUG : Putio root 'rclone-test-munayal6wepo': Sending chunk. transferOffset: 0 length: 6 2026/09/29 03:49:38 DEBUG : Putio root 'rclone-test-munayal6wepo': chunkStart: 0, reqSize: 6 2026/09/29 03:49:38 DEBUG : Putio root 'rclone-test-munayal6wepo': Sending chunk. transferOffset: 0 length: 6 2026/09/29 03:49:39 DEBUG : Putio root 'rclone-test-munayal6wepo': chunkStart: 0, reqSize: 6 2026/09/29 03:49:39 DEBUG : Putio root 'rclone-test-munayal6wepo': Sending chunk. transferOffset: 0 length: 6 2026/09/29 03:49:39 DEBUG : pacer: low level retry 1/10 (error unexpected status code (429) response while doing POST to https://upload.put.io/files/: trying again in 21.17102377s) 2026/09/29 03:49:39 DEBUG : pacer: Rate limited, increasing sleep to 21.17102377s 2026/09/29 03:49:39 DEBUG : pacer: low level retry 2/10 (error unexpected status code (429) response while doing POST to https://upload.put.io/files/: trying again in 21.032365776s) 2026/09/29 03:49:39 DEBUG : pacer: Rate limited, increasing sleep to 21.032365776s 2026/09/29 03:50:01 DEBUG : pacer: Reducing sleep to 10.516182888s 2026/09/29 03:50:01 DEBUG : Putio root 'rclone-test-munayal6wepo': chunkStart: 0, reqSize: 6 2026/09/29 03:50:22 DEBUG : Putio root 'rclone-test-munayal6wepo': Sending chunk. transferOffset: 0 length: 6 2026/09/29 03:50:22 DEBUG : pacer: Reducing sleep to 5.258091444s 2026/09/29 03:50:32 DEBUG : pacer: Reducing sleep to 2.629045722s 2026/09/29 03:50:37 DEBUG : pacer: Reducing sleep to 1.314522861s 2026/09/29 03:50:40 DEBUG : pacer: Reducing sleep to 657.26143ms 2026/09/29 03:50:40 DEBUG : Putio root 'rclone-test-munayal6wepo': chunkStart: 0, reqSize: 6 2026/09/29 03:50:41 DEBUG : Putio root 'rclone-test-munayal6wepo': Sending chunk. transferOffset: 0 length: 6 2026/09/29 03:50:42 DEBUG : pacer: Reducing sleep to 328.630715ms 2026/09/29 03:50:42 DEBUG : pacer: Reducing sleep to 164.315357ms 2026/09/29 03:50:42 DEBUG : pacer: Reducing sleep to 82.157678ms 2026/09/29 03:50:43 DEBUG : pacer: Reducing sleep to 41.078839ms 2026/09/29 03:50:43 DEBUG : Putio root 'rclone-test-munayal6wepo': chunkStart: 0, reqSize: 6 2026/09/29 03:50:43 DEBUG : Putio root 'rclone-test-munayal6wepo': Sending chunk. transferOffset: 0 length: 6 2026/09/29 03:50:43 DEBUG : pacer: Reducing sleep to 20.539419ms 2026/09/29 03:50:43 DEBUG : pacer: Reducing sleep to 10.269709ms 2026/09/29 03:50:43 DEBUG : pacer: Reducing sleep to 10ms 2026/09/29 03:50:44 DEBUG : Putio root 'rclone-test-munayal6wepo': chunkStart: 0, reqSize: 6 2026/09/29 03:50:44 DEBUG : Putio root 'rclone-test-munayal6wepo': Sending chunk. transferOffset: 0 length: 6 2026/09/29 03:50:44 DEBUG : Putio root 'rclone-test-munayal6wepo': chunkStart: 0, reqSize: 6 2026/09/29 03:50:44 DEBUG : Putio root 'rclone-test-munayal6wepo': Sending chunk. transferOffset: 0 length: 6 2026/09/29 03:50:45 DEBUG : Putio root 'rclone-test-munayal6wepo': chunkStart: 0, reqSize: 6 2026/09/29 03:50:45 DEBUG : Putio root 'rclone-test-munayal6wepo': Sending chunk. transferOffset: 0 length: 6 2026/09/29 03:50:46 DEBUG : Putio root 'rclone-test-munayal6wepo': chunkStart: 0, reqSize: 6 2026/09/29 03:50:46 DEBUG : Putio root 'rclone-test-munayal6wepo': Sending chunk. transferOffset: 0 length: 6 2026/09/29 03:50:47 DEBUG : Putio root 'rclone-test-munayal6wepo': chunkStart: 0, reqSize: 6 2026/09/29 03:50:47 DEBUG : Putio root 'rclone-test-munayal6wepo': Sending chunk. transferOffset: 0 length: 6 2026/09/29 03:50:47 DEBUG : Putio root 'rclone-test-munayal6wepo': chunkStart: 0, reqSize: 6 2026/09/29 03:50:47 DEBUG : Putio root 'rclone-test-munayal6wepo': Sending chunk. transferOffset: 0 length: 6 2026/09/29 03:50:48 DEBUG : Putio root 'rclone-test-munayal6wepo': chunkStart: 0, reqSize: 6 2026/09/29 03:50:48 DEBUG : Putio root 'rclone-test-munayal6wepo': Sending chunk. transferOffset: 0 length: 6 2026/09/29 03:50:49 DEBUG : Putio root 'rclone-test-munayal6wepo': chunkStart: 0, reqSize: 6 2026/09/29 03:50:49 DEBUG : Putio root 'rclone-test-munayal6wepo': Sending chunk. transferOffset: 0 length: 6 2026/09/29 03:50:50 DEBUG : Putio root 'rclone-test-munayal6wepo': chunkStart: 0, reqSize: 6 2026/09/29 03:50:50 DEBUG : Putio root 'rclone-test-munayal6wepo': Sending chunk. transferOffset: 0 length: 6 2026/09/29 03:50:50 DEBUG : Putio root 'rclone-test-munayal6wepo': chunkStart: 0, reqSize: 6 2026/09/29 03:50:50 DEBUG : Putio root 'rclone-test-munayal6wepo': Sending chunk. transferOffset: 0 length: 6 2026/09/29 03:50:51 DEBUG : Putio root 'rclone-test-munayal6wepo': chunkStart: 0, reqSize: 6 2026/09/29 03:50:51 DEBUG : Putio root 'rclone-test-munayal6wepo': Sending chunk. transferOffset: 0 length: 6 2026/09/29 03:50:52 DEBUG : Putio root 'rclone-test-munayal6wepo': chunkStart: 0, reqSize: 6 2026/09/29 03:50:52 DEBUG : Putio root 'rclone-test-munayal6wepo': Sending chunk. transferOffset: 0 length: 6 2026/09/29 03:50:52 DEBUG : both0: size = 6 OK 2026/09/29 03:50:52 DEBUG : both0: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2026/09/29 03:50:52 DEBUG : both10: size = 6 OK 2026/09/29 03:50:52 DEBUG : both0: Unchanged skipping 2026/09/29 03:50:52 DEBUG : both11: size = 6 OK 2026/09/29 03:50:52 DEBUG : both10: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2026/09/29 03:50:52 DEBUG : both11: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2026/09/29 03:50:52 DEBUG : both12: size = 6 OK 2026/09/29 03:50:52 DEBUG : both12: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2026/09/29 03:50:52 DEBUG : both13: size = 6 OK 2026/09/29 03:50:52 DEBUG : both13: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2026/09/29 03:50:52 DEBUG : Putio root 'rclone-test-munayal6wepo': Waiting for checks to finish 2026/09/29 03:50:52 DEBUG : both10: Unchanged skipping 2026/09/29 03:50:52 DEBUG : both14: size = 6 OK 2026/09/29 03:50:52 DEBUG : both14: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2026/09/29 03:50:52 DEBUG : both14: Unchanged skipping 2026/09/29 03:50:52 DEBUG : both15: size = 6 OK 2026/09/29 03:50:52 DEBUG : both15: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2026/09/29 03:50:52 DEBUG : both15: Unchanged skipping 2026/09/29 03:50:52 DEBUG : both16: size = 6 OK 2026/09/29 03:50:52 DEBUG : both16: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2026/09/29 03:50:52 DEBUG : both11: Unchanged skipping 2026/09/29 03:50:52 DEBUG : both17: size = 6 OK 2026/09/29 03:50:52 DEBUG : both17: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2026/09/29 03:50:52 DEBUG : both17: Unchanged skipping 2026/09/29 03:50:52 DEBUG : both18: size = 6 OK 2026/09/29 03:50:52 DEBUG : both18: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2026/09/29 03:50:52 DEBUG : both18: Unchanged skipping 2026/09/29 03:50:52 DEBUG : both19: size = 6 OK 2026/09/29 03:50:52 DEBUG : both19: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2026/09/29 03:50:52 DEBUG : both19: Unchanged skipping 2026/09/29 03:50:52 DEBUG : both1: size = 6 OK 2026/09/29 03:50:52 DEBUG : both1: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2026/09/29 03:50:52 DEBUG : both1: Unchanged skipping 2026/09/29 03:50:52 DEBUG : both2: size = 6 OK 2026/09/29 03:50:52 DEBUG : both2: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2026/09/29 03:50:52 DEBUG : both2: Unchanged skipping 2026/09/29 03:50:52 DEBUG : both3: size = 6 OK 2026/09/29 03:50:52 DEBUG : both3: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2026/09/29 03:50:52 DEBUG : both3: Unchanged skipping 2026/09/29 03:50:52 DEBUG : both4: size = 6 OK 2026/09/29 03:50:52 DEBUG : both4: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2026/09/29 03:50:52 DEBUG : both4: Unchanged skipping 2026/09/29 03:50:52 DEBUG : both5: size = 6 OK 2026/09/29 03:50:52 DEBUG : both5: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2026/09/29 03:50:52 DEBUG : both5: Unchanged skipping 2026/09/29 03:50:52 DEBUG : both6: size = 6 OK 2026/09/29 03:50:52 DEBUG : both6: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2026/09/29 03:50:52 DEBUG : both6: Unchanged skipping 2026/09/29 03:50:52 DEBUG : both7: size = 6 OK 2026/09/29 03:50:52 DEBUG : both7: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2026/09/29 03:50:52 DEBUG : both13: Unchanged skipping 2026/09/29 03:50:52 DEBUG : both8: size = 6 OK 2026/09/29 03:50:52 DEBUG : both8: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2026/09/29 03:50:52 DEBUG : both7: Unchanged skipping 2026/09/29 03:50:52 DEBUG : both9: size = 6 OK 2026/09/29 03:50:52 DEBUG : both9: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2026/09/29 03:50:52 DEBUG : both9: Unchanged skipping 2026/09/29 03:50:52 DEBUG : only0: size = 0 (Local file system at /tmp/rclone3227105426) 2026/09/29 03:50:52 DEBUG : only0: size = 6 (Putio root 'rclone-test-munayal6wepo') 2026/09/29 03:50:52 DEBUG : only0: Sizes differ 2026/09/29 03:50:52 DEBUG : only10: size = 0 (Local file system at /tmp/rclone3227105426) 2026/09/29 03:50:52 DEBUG : only10: size = 6 (Putio root 'rclone-test-munayal6wepo') 2026/09/29 03:50:52 DEBUG : only10: Sizes differ 2026/09/29 03:50:52 DEBUG : both12: Unchanged skipping 2026/09/29 03:50:52 DEBUG : only12: size = 0 (Local file system at /tmp/rclone3227105426) 2026/09/29 03:50:52 DEBUG : only12: size = 6 (Putio root 'rclone-test-munayal6wepo') 2026/09/29 03:50:52 DEBUG : only12: Sizes differ 2026/09/29 03:50:52 DEBUG : only13: size = 0 (Local file system at /tmp/rclone3227105426) 2026/09/29 03:50:52 DEBUG : only13: size = 6 (Putio root 'rclone-test-munayal6wepo') 2026/09/29 03:50:52 DEBUG : only13: Sizes differ 2026/09/29 03:50:52 DEBUG : only14: size = 0 (Local file system at /tmp/rclone3227105426) 2026/09/29 03:50:52 DEBUG : only14: size = 6 (Putio root 'rclone-test-munayal6wepo') 2026/09/29 03:50:52 DEBUG : only11: size = 0 (Local file system at /tmp/rclone3227105426) 2026/09/29 03:50:52 DEBUG : only14: Sizes differ 2026/09/29 03:50:52 DEBUG : both8: Unchanged skipping 2026/09/29 03:50:52 DEBUG : only11: size = 6 (Putio root 'rclone-test-munayal6wepo') 2026/09/29 03:50:52 DEBUG : only11: Sizes differ 2026/09/29 03:50:52 DEBUG : both16: Unchanged skipping 2026/09/29 03:50:52 DEBUG : only16: size = 0 (Local file system at /tmp/rclone3227105426) 2026/09/29 03:50:52 DEBUG : only16: size = 6 (Putio root 'rclone-test-munayal6wepo') 2026/09/29 03:50:52 DEBUG : only16: Sizes differ 2026/09/29 03:50:52 DEBUG : only15: size = 0 (Local file system at /tmp/rclone3227105426) 2026/09/29 03:50:52 DEBUG : only15: size = 6 (Putio root 'rclone-test-munayal6wepo') 2026/09/29 03:50:52 DEBUG : only15: Sizes differ 2026/09/29 03:50:52 DEBUG : only17: size = 0 (Local file system at /tmp/rclone3227105426) 2026/09/29 03:50:52 DEBUG : only17: size = 6 (Putio root 'rclone-test-munayal6wepo') 2026/09/29 03:50:52 DEBUG : only17: Sizes differ 2026/09/29 03:50:52 DEBUG : only18: size = 0 (Local file system at /tmp/rclone3227105426) 2026/09/29 03:50:52 DEBUG : only18: size = 6 (Putio root 'rclone-test-munayal6wepo') 2026/09/29 03:50:52 DEBUG : only18: Sizes differ 2026/09/29 03:50:52 DEBUG : only19: size = 0 (Local file system at /tmp/rclone3227105426) 2026/09/29 03:50:52 DEBUG : only19: size = 6 (Putio root 'rclone-test-munayal6wepo') 2026/09/29 03:50:52 DEBUG : only19: Sizes differ 2026/09/29 03:50:52 DEBUG : only1: size = 0 (Local file system at /tmp/rclone3227105426) 2026/09/29 03:50:52 DEBUG : only1: size = 6 (Putio root 'rclone-test-munayal6wepo') 2026/09/29 03:50:52 DEBUG : only1: Sizes differ 2026/09/29 03:50:52 DEBUG : only2: size = 0 (Local file system at /tmp/rclone3227105426) 2026/09/29 03:50:52 DEBUG : only2: size = 6 (Putio root 'rclone-test-munayal6wepo') 2026/09/29 03:50:52 DEBUG : only2: Sizes differ 2026/09/29 03:50:52 DEBUG : only3: size = 0 (Local file system at /tmp/rclone3227105426) 2026/09/29 03:50:52 DEBUG : only3: size = 6 (Putio root 'rclone-test-munayal6wepo') 2026/09/29 03:50:52 DEBUG : only3: Sizes differ 2026/09/29 03:50:52 DEBUG : only4: size = 0 (Local file system at /tmp/rclone3227105426) 2026/09/29 03:50:52 DEBUG : only4: size = 6 (Putio root 'rclone-test-munayal6wepo') 2026/09/29 03:50:52 DEBUG : only4: Sizes differ 2026/09/29 03:50:52 DEBUG : only5: size = 0 (Local file system at /tmp/rclone3227105426) 2026/09/29 03:50:52 DEBUG : only5: size = 6 (Putio root 'rclone-test-munayal6wepo') 2026/09/29 03:50:52 DEBUG : only5: Sizes differ 2026/09/29 03:50:52 DEBUG : only6: size = 0 (Local file system at /tmp/rclone3227105426) 2026/09/29 03:50:52 DEBUG : only7: size = 0 (Local file system at /tmp/rclone3227105426) 2026/09/29 03:50:52 DEBUG : only6: size = 6 (Putio root 'rclone-test-munayal6wepo') 2026/09/29 03:50:52 DEBUG : only7: size = 6 (Putio root 'rclone-test-munayal6wepo') 2026/09/29 03:50:52 DEBUG : only6: Sizes differ 2026/09/29 03:50:52 DEBUG : only7: Sizes differ 2026/09/29 03:50:52 DEBUG : only8: size = 0 (Local file system at /tmp/rclone3227105426) 2026/09/29 03:50:52 DEBUG : only8: size = 6 (Putio root 'rclone-test-munayal6wepo') 2026/09/29 03:50:52 DEBUG : only8: Sizes differ 2026/09/29 03:50:52 DEBUG : only9: size = 0 (Local file system at /tmp/rclone3227105426) 2026/09/29 03:50:52 DEBUG : only9: size = 6 (Putio root 'rclone-test-munayal6wepo') 2026/09/29 03:50:52 DEBUG : only9: Sizes differ 2026/09/29 03:50:52 DEBUG : Putio root 'rclone-test-munayal6wepo': Waiting for transfers to finish 2026/09/29 03:50:53 DEBUG : Putio root 'rclone-test-munayal6wepo': Sending zero length chunk 2026/09/29 03:50:53 DEBUG : only0: size = 0 OK 2026/09/29 03:50:53 DEBUG : only0: crc32 = 00000000 OK 2026/09/29 03:50:53 INFO : only0: Copied (replaced existing) 2026/09/29 03:50:54 DEBUG : Putio root 'rclone-test-munayal6wepo': Sending zero length chunk 2026/09/29 03:50:54 DEBUG : Putio root 'rclone-test-munayal6wepo': Sending zero length chunk 2026/09/29 03:50:54 DEBUG : only11: size = 0 OK 2026/09/29 03:50:54 DEBUG : only11: crc32 = 00000000 OK 2026/09/29 03:50:54 INFO : only11: Copied (replaced existing) 2026/09/29 03:50:54 DEBUG : only10: size = 0 OK 2026/09/29 03:50:54 DEBUG : only10: crc32 = 00000000 OK 2026/09/29 03:50:54 INFO : only10: Copied (replaced existing) 2026/09/29 03:50:55 DEBUG : Putio root 'rclone-test-munayal6wepo': Sending zero length chunk 2026/09/29 03:50:55 DEBUG : Putio root 'rclone-test-munayal6wepo': Sending zero length chunk 2026/09/29 03:50:55 DEBUG : only16: size = 0 OK 2026/09/29 03:50:55 DEBUG : only16: crc32 = 00000000 OK 2026/09/29 03:50:55 INFO : only16: Copied (replaced existing) 2026/09/29 03:50:55 DEBUG : Putio root 'rclone-test-munayal6wepo': Sending zero length chunk 2026/09/29 03:50:55 DEBUG : only18: size = 0 OK 2026/09/29 03:50:55 DEBUG : only18: crc32 = 00000000 OK 2026/09/29 03:50:55 INFO : only18: Copied (replaced existing) 2026/09/29 03:50:55 DEBUG : only12: size = 0 OK 2026/09/29 03:50:55 DEBUG : only12: crc32 = 00000000 OK 2026/09/29 03:50:55 INFO : only12: Copied (replaced existing) 2026/09/29 03:50:55 DEBUG : Putio root 'rclone-test-munayal6wepo': Sending zero length chunk 2026/09/29 03:50:56 DEBUG : Putio root 'rclone-test-munayal6wepo': Sending zero length chunk 2026/09/29 03:50:56 DEBUG : only19: size = 0 OK 2026/09/29 03:50:56 DEBUG : only19: crc32 = 00000000 OK 2026/09/29 03:50:56 INFO : only19: Copied (replaced existing) 2026/09/29 03:50:56 DEBUG : Putio root 'rclone-test-munayal6wepo': Sending zero length chunk 2026/09/29 03:50:56 DEBUG : Putio root 'rclone-test-munayal6wepo': Sending zero length chunk 2026/09/29 03:50:56 DEBUG : Putio root 'rclone-test-munayal6wepo': Sending zero length chunk 2026/09/29 03:50:56 DEBUG : only2: size = 0 OK 2026/09/29 03:50:56 DEBUG : only2: crc32 = 00000000 OK 2026/09/29 03:50:56 INFO : only2: Copied (replaced existing) 2026/09/29 03:50:56 DEBUG : only1: size = 0 OK 2026/09/29 03:50:56 DEBUG : only1: crc32 = 00000000 OK 2026/09/29 03:50:56 INFO : only1: Copied (replaced existing) 2026/09/29 03:50:57 DEBUG : only3: size = 0 OK 2026/09/29 03:50:57 DEBUG : only3: crc32 = 00000000 OK 2026/09/29 03:50:57 INFO : only3: Copied (replaced existing) 2026/09/29 03:50:57 DEBUG : only13: size = 0 OK 2026/09/29 03:50:57 DEBUG : only13: crc32 = 00000000 OK 2026/09/29 03:50:57 INFO : only13: Copied (replaced existing) 2026/09/29 03:50:57 DEBUG : Putio root 'rclone-test-munayal6wepo': Sending zero length chunk 2026/09/29 03:50:57 DEBUG : Putio root 'rclone-test-munayal6wepo': Sending zero length chunk 2026/09/29 03:50:57 DEBUG : Putio root 'rclone-test-munayal6wepo': Sending zero length chunk 2026/09/29 03:50:57 DEBUG : only4: size = 0 OK 2026/09/29 03:50:57 DEBUG : only4: crc32 = 00000000 OK 2026/09/29 03:50:57 INFO : only4: Copied (replaced existing) 2026/09/29 03:50:58 DEBUG : only15: size = 0 OK 2026/09/29 03:50:58 DEBUG : only15: crc32 = 00000000 OK 2026/09/29 03:50:58 INFO : only15: Copied (replaced existing) 2026/09/29 03:50:58 DEBUG : Putio root 'rclone-test-munayal6wepo': Sending zero length chunk 2026/09/29 03:50:58 DEBUG : Putio root 'rclone-test-munayal6wepo': Sending zero length chunk 2026/09/29 03:50:58 DEBUG : only14: size = 0 OK 2026/09/29 03:50:58 DEBUG : only14: crc32 = 00000000 OK 2026/09/29 03:50:58 INFO : only14: Copied (replaced existing) 2026/09/29 03:50:59 DEBUG : only8: size = 0 OK 2026/09/29 03:50:59 DEBUG : only8: crc32 = 00000000 OK 2026/09/29 03:50:59 INFO : only8: Copied (replaced existing) 2026/09/29 03:50:59 DEBUG : only5: size = 0 OK 2026/09/29 03:50:59 DEBUG : only5: crc32 = 00000000 OK 2026/09/29 03:50:59 INFO : only5: Copied (replaced existing) 2026/09/29 03:50:59 DEBUG : Putio root 'rclone-test-munayal6wepo': Sending zero length chunk 2026/09/29 03:50:59 DEBUG : Putio root 'rclone-test-munayal6wepo': Sending zero length chunk 2026/09/29 03:50:59 DEBUG : Putio root 'rclone-test-munayal6wepo': Sending zero length chunk 2026/09/29 03:50:59 DEBUG : only6: size = 0 OK 2026/09/29 03:50:59 DEBUG : only6: crc32 = 00000000 OK 2026/09/29 03:50:59 INFO : only6: Copied (replaced existing) 2026/09/29 03:50:59 DEBUG : pacer: low level retry 1/10 (error unexpected status code (500) response while doing PATCH to https://s106.put.io/files/2b9428309412fca423b2bab17ffb54726a6de481) 2026/09/29 03:50:59 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2026/09/29 03:50:59 DEBUG : Putio root 'rclone-test-munayal6wepo': Sending zero length chunk 2026/09/29 03:51:00 DEBUG : pacer: Reducing sleep to 10ms 2026/09/29 03:51:00 ERROR : only7: Failed to copy: unexpected status code (404) response while doing PATCH to https://s106.put.io/files/2b9428309412fca423b2bab17ffb54726a6de481 2026/09/29 03:51:00 DEBUG : only9: size = 0 OK 2026/09/29 03:51:00 DEBUG : only9: crc32 = 00000000 OK 2026/09/29 03:51:00 INFO : only9: Copied (replaced existing) 2026/09/29 03:51:00 DEBUG : Putio root 'rclone-test-munayal6wepo': Sending zero length chunk 2026/09/29 03:51:00 DEBUG : only17: size = 0 OK 2026/09/29 03:51:00 DEBUG : only17: crc32 = 00000000 OK 2026/09/29 03:51:00 INFO : only17: Copied (replaced existing) 2026/09/29 03:51:00 ERROR : Putio root 'rclone-test-munayal6wepo': not deleting files as there were IO errors 2026/09/29 03:51:00 ERROR : Putio root 'rclone-test-munayal6wepo': not deleting directories as there were IO errors sync_test.go:2813: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2813 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2823 Error: Received unexpected error: unexpected status code (404) response while doing PATCH to https://s106.put.io/files/2b9428309412fca423b2bab17ffb54726a6de481 Test: TestSyncConcurrentTruncate Messages: Sync must not return a error sync_test.go:2814: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2814 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2823 Error: Should be false Test: TestSyncConcurrentTruncate Messages: Low level errors must not have happened fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:306 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:339 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:351 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:358 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2815 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2823 /usr/local/go/src/runtime/asm_amd64.s:1264 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), 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), only8 (0), only9 (0) fstest.go:204: Not found "only7" fstest.go:207: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:207 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:311 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:339 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:351 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:358 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2815 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2823 Error: Not equal: expected: 0 actual : 1 Test: TestSyncConcurrentTruncate Messages: 1 objects not found --- FAIL: TestSyncConcurrentTruncate (112.62s) FAIL 2026/09/29 03:51:12 DEBUG : Putio root 'rclone-test-munayal6wepo': Purge remote "./sync.test -test.v -test.timeout 2h0m0s -remote TestPutio: -verbose -test.run '^TestSyncConcurrentTruncate$'" - Finished ERROR in 1m53.106199488s (try 2/5): exit status 1: Failed [TestSyncConcurrentTruncate]