"./sync.test -test.v -test.timeout 1h0m0s -remote TestHdfs: -verbose -test.run '^(TestCopy|TestCopyRedownload|TestServerSideMove|TestSyncAfterChangingModtimeOnly|TestSyncBackupDirSuffixOnly|TestSyncConcurrentDelete|TestSyncConcurrentTruncate)$'" - Starting (try 3/5)
2022/05/21 06:39:13 DEBUG : Creating backend with remote "TestHdfs:rclone-test-siqaxow8toxinak5tipexul9"
2022/05/21 06:39:13 DEBUG : Setting type="hdfs" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_TYPE
2022/05/21 06:39:13 DEBUG : Setting namenode="127.0.0.1:8020" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_NAMENODE
2022/05/21 06:39:13 DEBUG : Setting username="root" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_USERNAME
2022/05/21 06:39:13 DEBUG : TestHdfs: detected overridden config - adding "{cNNQW}" suffix to name
2022/05/21 06:39:13 DEBUG : Setting namenode="127.0.0.1:8020" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_NAMENODE
2022/05/21 06:39:13 DEBUG : Setting username="root" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_USERNAME
2022/05/21 06:39:13 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2022/05/21 06:39:13 DEBUG : Creating backend with remote "/tmp/rclone781942286"
=== RUN   TestCopy
    run.go:181: Remote "hdfs://127.0.0.1:8020", Local "Local file system at /tmp/rclone781942286", Modify Window "1s"
2022/05/21 06:39:13 DEBUG : hdfs://127.0.0.1:8020: mkdir [/rclone-test-siqaxow8toxinak5tipexul9]
2022/05/21 06:39:13 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-siqaxow8toxinak5tipexul9]
2022/05/21 06:39:13 DEBUG : hdfs://127.0.0.1:8020: Waiting for checks to finish
2022/05/21 06:39:13 DEBUG : hdfs://127.0.0.1:8020: Waiting for transfers to finish
2022/05/21 06:39:13 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-siqaxow8toxinak5tipexul9/sub dir/hello world]
2022/05/21 06:39:13 ERROR : sub dir/hello world: Failed to copy: create /rclone-test-siqaxow8toxinak5tipexul9/sub dir/hello world: replication in progress
    sync_test.go:65: 
        	Error Trace:	sync_test.go:65
        	Error:      	Received unexpected error:
        	            	create /rclone-test-siqaxow8toxinak5tipexul9/sub dir/hello world: replication in progress
        	Test:       	TestCopy
2022/05/21 06:39:13 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-siqaxow8toxinak5tipexul9]
2022/05/21 06:39:13 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-siqaxow8toxinak5tipexul9/sub dir]
2022/05/21 06:39:13 DEBUG : hdfs://127.0.0.1:8020: rmdir [/rclone-test-siqaxow8toxinak5tipexul9/sub dir]
2022/05/21 06:39:13 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-siqaxow8toxinak5tipexul9]
--- FAIL: TestCopy (0.25s)
=== RUN   TestCopyRedownload
    run.go:181: Remote "hdfs://127.0.0.1:8020", Local "Local file system at /tmp/rclone781942286", Modify Window "1s"
2022/05/21 06:39:13 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-siqaxow8toxinak5tipexul9/sub dir/hello world]
    run.go:287: Failed to put "sub dir/hello world" to "hdfs://127.0.0.1:8020": create /rclone-test-siqaxow8toxinak5tipexul9/sub dir/hello world: replication in progress
2022/05/21 06:39:13 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-siqaxow8toxinak5tipexul9]
2022/05/21 06:39:13 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-siqaxow8toxinak5tipexul9/sub dir]
2022/05/21 06:39:13 DEBUG : hdfs://127.0.0.1:8020: rmdir [/rclone-test-siqaxow8toxinak5tipexul9/sub dir]
2022/05/21 06:39:13 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-siqaxow8toxinak5tipexul9]
--- FAIL: TestCopyRedownload (0.03s)
=== RUN   TestSyncAfterChangingModtimeOnly
    run.go:181: Remote "hdfs://127.0.0.1:8020", Local "Local file system at /tmp/rclone781942286", Modify Window "1s"
2022/05/21 06:39:13 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-siqaxow8toxinak5tipexul9/empty space]
    run.go:287: Failed to put "empty space" to "hdfs://127.0.0.1:8020": create /rclone-test-siqaxow8toxinak5tipexul9/empty space: replication in progress
2022/05/21 06:39:13 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-siqaxow8toxinak5tipexul9]
2022/05/21 06:39:13 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-siqaxow8toxinak5tipexul9]
--- FAIL: TestSyncAfterChangingModtimeOnly (0.02s)
=== RUN   TestServerSideMove
    run.go:181: Remote "hdfs://127.0.0.1:8020", Local "Local file system at /tmp/rclone781942286", Modify Window "1s"
2022/05/21 06:39:13 DEBUG : Creating backend with remote "TestHdfs:rclone-test-koniqib2fuxobar2fojebuc4"
2022/05/21 06:39:13 DEBUG : Setting type="hdfs" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_TYPE
2022/05/21 06:39:13 DEBUG : Setting namenode="127.0.0.1:8020" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_NAMENODE
2022/05/21 06:39:13 DEBUG : Setting username="root" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_USERNAME
2022/05/21 06:39:13 DEBUG : TestHdfs: detected overridden config - adding "{cNNQW}" suffix to name
2022/05/21 06:39:13 DEBUG : Setting namenode="127.0.0.1:8020" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_NAMENODE
2022/05/21 06:39:13 DEBUG : Setting username="root" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_USERNAME
2022/05/21 06:39:13 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-siqaxow8toxinak5tipexul9/potato2]
2022/05/21 06:39:13 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-siqaxow8toxinak5tipexul9/empty space]
2022/05/21 06:39:13 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-siqaxow8toxinak5tipexul9/potato3]
2022/05/21 06:39:13 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-siqaxow8toxinak5tipexul9]
    sync_test.go:1215: Server side move (if possible) hdfs://127.0.0.1:8020 -> hdfs://127.0.0.1:8020
2022/05/21 06:39:13 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-koniqib2fuxobar2fojebuc4/empty space]
2022/05/21 06:39:13 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-koniqib2fuxobar2fojebuc4/potato3]
2022/05/21 06:39:13 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-koniqib2fuxobar2fojebuc4]
2022/05/21 06:39:13 DEBUG : hdfs://127.0.0.1:8020: Using server-side directory move
2022/05/21 06:39:13 DEBUG : hdfs://127.0.0.1:8020: rename [/rclone-test-siqaxow8toxinak5tipexul9] to [/rclone-test-koniqib2fuxobar2fojebuc4]
2022/05/21 06:39:13 DEBUG : hdfs://127.0.0.1:8020: target directory already exits, IsDir = [true]
2022/05/21 06:39:13 INFO  : hdfs://127.0.0.1:8020: Server side directory move failed - fallback to file moves: can't copy directory - destination already exists
2022/05/21 06:39:13 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-koniqib2fuxobar2fojebuc4]
2022/05/21 06:39:13 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-siqaxow8toxinak5tipexul9]
2022/05/21 06:39:13 DEBUG : hdfs://127.0.0.1:8020: rename [/rclone-test-siqaxow8toxinak5tipexul9/potato2] to [/rclone-test-koniqib2fuxobar2fojebuc4/potato2]
2022/05/21 06:39:13 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s)
2022/05/21 06:39:13 DEBUG : empty space: Unchanged skipping
2022/05/21 06:39:13 DEBUG : hdfs://127.0.0.1:8020: remove [/rclone-test-siqaxow8toxinak5tipexul9/empty space]
2022/05/21 06:39:13 DEBUG : potato3: Sizes differ (src 68 vs dst 60)
2022/05/21 06:39:13 DEBUG : hdfs://127.0.0.1:8020: remove [/rclone-test-koniqib2fuxobar2fojebuc4/potato3]
2022/05/21 06:39:13 DEBUG : hdfs://127.0.0.1:8020: Waiting for checks to finish
2022/05/21 06:39:13 INFO  : empty space: Deleted
2022/05/21 06:39:13 DEBUG : hdfs://127.0.0.1:8020: Waiting for transfers to finish
2022/05/21 06:39:13 INFO  : potato3: Deleted
2022/05/21 06:39:13 DEBUG : hdfs://127.0.0.1:8020: rename [/rclone-test-siqaxow8toxinak5tipexul9/potato3] to [/rclone-test-koniqib2fuxobar2fojebuc4/potato3]
2022/05/21 06:39:13 INFO  : potato2: Moved (server-side)
2022/05/21 06:39:13 INFO  : potato3: Moved (server-side)
2022/05/21 06:39:13 INFO  : There was nothing to transfer
2022/05/21 06:39:13 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-siqaxow8toxinak5tipexul9]
2022/05/21 06:39:13 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-koniqib2fuxobar2fojebuc4]
2022/05/21 06:39:13 DEBUG : Creating backend with remote "TestHdfs:rclone-test-guqobof7gugedur3radadob0"
2022/05/21 06:39:13 DEBUG : Setting type="hdfs" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_TYPE
2022/05/21 06:39:13 DEBUG : Setting namenode="127.0.0.1:8020" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_NAMENODE
2022/05/21 06:39:13 DEBUG : Setting username="root" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_USERNAME
2022/05/21 06:39:13 DEBUG : TestHdfs: detected overridden config - adding "{cNNQW}" suffix to name
2022/05/21 06:39:13 DEBUG : Setting namenode="127.0.0.1:8020" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_NAMENODE
2022/05/21 06:39:13 DEBUG : Setting username="root" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_USERNAME
2022/05/21 06:39:13 DEBUG : hdfs://127.0.0.1:8020: Using server-side directory move
2022/05/21 06:39:13 DEBUG : hdfs://127.0.0.1:8020: rename [/rclone-test-koniqib2fuxobar2fojebuc4] to [/rclone-test-guqobof7gugedur3radadob0]
2022/05/21 06:39:13 INFO  : hdfs://127.0.0.1:8020: Server side directory move succeeded
2022/05/21 06:39:13 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-guqobof7gugedur3radadob0]
2022/05/21 06:39:13 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-koniqib2fuxobar2fojebuc4]
2022/05/21 06:39:13 ERROR : : error listing: directory not found
2022/05/21 06:39:13 DEBUG : hdfs://127.0.0.1:8020: Purge remote
2022/05/21 06:39:13 DEBUG : hdfs://127.0.0.1:8020: purge [/rclone-test-guqobof7gugedur3radadob0]
2022/05/21 06:39:13 DEBUG : hdfs://127.0.0.1:8020: Purge remote
2022/05/21 06:39:13 DEBUG : hdfs://127.0.0.1:8020: purge [/rclone-test-koniqib2fuxobar2fojebuc4]
2022/05/21 06:39:13 purge failed: directory not found
2022/05/21 06:39:13 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-siqaxow8toxinak5tipexul9]
2022/05/21 06:39:13 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-siqaxow8toxinak5tipexul9]
--- PASS: TestServerSideMove (0.15s)
=== RUN   TestSyncBackupDirSuffixOnly
    run.go:181: Remote "hdfs://127.0.0.1:8020", Local "Local file system at /tmp/rclone781942286", Modify Window "1s"
2022/05/21 06:39:13 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-siqaxow8toxinak5tipexul9/dst/one]
    run.go:287: Failed to put "dst/one" to "hdfs://127.0.0.1:8020": create /rclone-test-siqaxow8toxinak5tipexul9/dst/one: replication in progress
2022/05/21 06:39:13 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-siqaxow8toxinak5tipexul9]
2022/05/21 06:39:13 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-siqaxow8toxinak5tipexul9/dst]
2022/05/21 06:39:13 DEBUG : hdfs://127.0.0.1:8020: rmdir [/rclone-test-siqaxow8toxinak5tipexul9/dst]
2022/05/21 06:39:13 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-siqaxow8toxinak5tipexul9]
--- FAIL: TestSyncBackupDirSuffixOnly (0.02s)
=== RUN   TestSyncConcurrentDelete
    run.go:181: Remote "hdfs://127.0.0.1:8020", Local "Local file system at /tmp/rclone781942286", Modify Window "1s"
2022/05/21 06:39:13 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-siqaxow8toxinak5tipexul9/both0]
2022/05/21 06:39:13 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-siqaxow8toxinak5tipexul9/only0]
    run.go:287: Failed to put "only0" to "hdfs://127.0.0.1:8020": create /rclone-test-siqaxow8toxinak5tipexul9/only0: replication in progress
2022/05/21 06:39:13 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-siqaxow8toxinak5tipexul9]
2022/05/21 06:39:13 DEBUG : hdfs://127.0.0.1:8020: remove [/rclone-test-siqaxow8toxinak5tipexul9/both0]
2022/05/21 06:39:13 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-siqaxow8toxinak5tipexul9]
--- FAIL: TestSyncConcurrentDelete (0.04s)
=== RUN   TestSyncConcurrentTruncate
    run.go:181: Remote "hdfs://127.0.0.1:8020", Local "Local file system at /tmp/rclone781942286", Modify Window "1s"
2022/05/21 06:39:13 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-siqaxow8toxinak5tipexul9/both0]
2022/05/21 06:39:13 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-siqaxow8toxinak5tipexul9/only0]
2022/05/21 06:39:13 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-siqaxow8toxinak5tipexul9/both1]
    run.go:287: Failed to put "both1" to "hdfs://127.0.0.1:8020": create /rclone-test-siqaxow8toxinak5tipexul9/both1: replication in progress
2022/05/21 06:39:13 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-siqaxow8toxinak5tipexul9]
2022/05/21 06:39:13 DEBUG : hdfs://127.0.0.1:8020: remove [/rclone-test-siqaxow8toxinak5tipexul9/both0]
2022/05/21 06:39:13 DEBUG : hdfs://127.0.0.1:8020: remove [/rclone-test-siqaxow8toxinak5tipexul9/only0]
2022/05/21 06:39:13 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-siqaxow8toxinak5tipexul9]
--- FAIL: TestSyncConcurrentTruncate (0.06s)
FAIL
2022/05/21 06:39:13 DEBUG : hdfs://127.0.0.1:8020: Purge remote
2022/05/21 06:39:13 DEBUG : hdfs://127.0.0.1:8020: purge [/rclone-test-siqaxow8toxinak5tipexul9]
"./sync.test -test.v -test.timeout 1h0m0s -remote TestHdfs: -verbose -test.run '^(TestCopy|TestCopyRedownload|TestServerSideMove|TestSyncAfterChangingModtimeOnly|TestSyncBackupDirSuffixOnly|TestSyncConcurrentDelete|TestSyncConcurrentTruncate)$'" - Finished ERROR in 769.087681ms (try 3/5): exit status 1: Failed [TestCopy TestCopyRedownload TestSyncAfterChangingModtimeOnly TestSyncBackupDirSuffixOnly TestSyncConcurrentDelete TestSyncConcurrentTruncate]