"./sync.test -test.v -test.timeout 1h0m0s -remote TestHdfs: -verbose -test.run '^(TestCopy|TestSyncBackupDirSuffixOnly|TestSyncConcurrentDelete|TestSyncConcurrentTruncate|TestSyncIgnoreErrors)$'" - Starting (try 5/5)
2022/04/15 06:15:18 DEBUG : Creating backend with remote "TestHdfs:rclone-test-qefepes9biqazoy2wizawod7"
2022/04/15 06:15:18 DEBUG : Setting type="hdfs" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_TYPE
2022/04/15 06:15:18 DEBUG : Setting namenode="127.0.0.1:8020" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_NAMENODE
2022/04/15 06:15:18 DEBUG : Setting username="root" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_USERNAME
2022/04/15 06:15:18 DEBUG : TestHdfs: detected overridden config - adding "{cNNQW}" suffix to name
2022/04/15 06:15:18 DEBUG : Setting namenode="127.0.0.1:8020" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_NAMENODE
2022/04/15 06:15:18 DEBUG : Setting username="root" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_USERNAME
2022/04/15 06:15:18 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2022/04/15 06:15:18 DEBUG : Creating backend with remote "/tmp/rclone2713163378"
=== RUN   TestCopy
    run.go:181: Remote "hdfs://127.0.0.1:8020", Local "Local file system at /tmp/rclone2713163378", Modify Window "1s"
2022/04/15 06:15:18 DEBUG : hdfs://127.0.0.1:8020: mkdir [/rclone-test-qefepes9biqazoy2wizawod7]
2022/04/15 06:15:18 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-qefepes9biqazoy2wizawod7]
2022/04/15 06:15:18 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-qefepes9biqazoy2wizawod7/sub dir/hello world]
2022/04/15 06:15:18 DEBUG : hdfs://127.0.0.1:8020: Waiting for checks to finish
2022/04/15 06:15:18 DEBUG : hdfs://127.0.0.1:8020: Waiting for transfers to finish
2022/04/15 06:15:18 ERROR : sub dir/hello world: Failed to copy: create /rclone-test-qefepes9biqazoy2wizawod7/sub dir/hello world: replication in progress
    sync_test.go:65: 
        	Error Trace:	sync_test.go:65
        	Error:      	Received unexpected error:
        	            	create /rclone-test-qefepes9biqazoy2wizawod7/sub dir/hello world: replication in progress
        	Test:       	TestCopy
2022/04/15 06:15:18 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-qefepes9biqazoy2wizawod7]
2022/04/15 06:15:18 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-qefepes9biqazoy2wizawod7/sub dir]
2022/04/15 06:15:18 DEBUG : hdfs://127.0.0.1:8020: rmdir [/rclone-test-qefepes9biqazoy2wizawod7/sub dir]
2022/04/15 06:15:18 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-qefepes9biqazoy2wizawod7]
--- FAIL: TestCopy (0.25s)
=== RUN   TestSyncIgnoreErrors
    run.go:181: Remote "hdfs://127.0.0.1:8020", Local "Local file system at /tmp/rclone2713163378", Modify Window "1s"
2022/04/15 06:15:18 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-qefepes9biqazoy2wizawod7/b/potato]
2022/04/15 06:15:18 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-qefepes9biqazoy2wizawod7/c/non empty space]
2022/04/15 06:15:18 DEBUG : d: Making directory
2022/04/15 06:15:18 DEBUG : hdfs://127.0.0.1:8020: mkdir [/rclone-test-qefepes9biqazoy2wizawod7/d]
2022/04/15 06:15:18 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-qefepes9biqazoy2wizawod7]
2022/04/15 06:15:19 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-qefepes9biqazoy2wizawod7/d]
2022/04/15 06:15:19 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-qefepes9biqazoy2wizawod7/b]
2022/04/15 06:15:19 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-qefepes9biqazoy2wizawod7/c]
2022/04/15 06:15:19 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-qefepes9biqazoy2wizawod7]
2022/04/15 06:15:19 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-qefepes9biqazoy2wizawod7/c]
2022/04/15 06:15:19 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-qefepes9biqazoy2wizawod7/a/potato2]
2022/04/15 06:15:19 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-qefepes9biqazoy2wizawod7/b]
2022/04/15 06:15:19 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-qefepes9biqazoy2wizawod7/d]
2022/04/15 06:15:19 DEBUG : c/non empty space: Size and modification time the same (differ by -123.456789ms, within tolerance 1s)
2022/04/15 06:15:19 DEBUG : c/non empty space: Unchanged skipping
2022/04/15 06:15:19 DEBUG : hdfs://127.0.0.1:8020: Waiting for checks to finish
2022/04/15 06:15:19 DEBUG : hdfs://127.0.0.1:8020: Waiting for transfers to finish
2022/04/15 06:15:19 INFO  : a/potato2: Copied (new)
2022/04/15 06:15:19 DEBUG : Waiting for deletions to finish
2022/04/15 06:15:19 DEBUG : hdfs://127.0.0.1:8020: remove [/rclone-test-qefepes9biqazoy2wizawod7/b/potato]
2022/04/15 06:15:19 INFO  : b/potato: Deleted
2022/04/15 06:15:19 INFO  : d: Removing directory
2022/04/15 06:15:19 DEBUG : hdfs://127.0.0.1:8020: rmdir [/rclone-test-qefepes9biqazoy2wizawod7/d]
2022/04/15 06:15:19 INFO  : b: Removing directory
2022/04/15 06:15:19 DEBUG : hdfs://127.0.0.1:8020: rmdir [/rclone-test-qefepes9biqazoy2wizawod7/b]
2022/04/15 06:15:19 DEBUG : hdfs://127.0.0.1:8020: deleted 2 directories
2022/04/15 06:15:19 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-qefepes9biqazoy2wizawod7]
2022/04/15 06:15:19 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-qefepes9biqazoy2wizawod7/c]
2022/04/15 06:15:19 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-qefepes9biqazoy2wizawod7/a]
2022/04/15 06:15:19 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-qefepes9biqazoy2wizawod7]
2022/04/15 06:15:19 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-qefepes9biqazoy2wizawod7/a]
2022/04/15 06:15:19 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-qefepes9biqazoy2wizawod7/c]
2022/04/15 06:15:19 DEBUG : hdfs://127.0.0.1:8020: remove [/rclone-test-qefepes9biqazoy2wizawod7/a/potato2]
2022/04/15 06:15:19 DEBUG : hdfs://127.0.0.1:8020: remove [/rclone-test-qefepes9biqazoy2wizawod7/c/non empty space]
2022/04/15 06:15:19 DEBUG : hdfs://127.0.0.1:8020: rmdir [/rclone-test-qefepes9biqazoy2wizawod7/c]
2022/04/15 06:15:19 DEBUG : hdfs://127.0.0.1:8020: rmdir [/rclone-test-qefepes9biqazoy2wizawod7/a]
2022/04/15 06:15:19 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-qefepes9biqazoy2wizawod7]
--- PASS: TestSyncIgnoreErrors (0.16s)
=== RUN   TestSyncBackupDirSuffixOnly
    run.go:181: Remote "hdfs://127.0.0.1:8020", Local "Local file system at /tmp/rclone2713163378", Modify Window "1s"
2022/04/15 06:15:19 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-qefepes9biqazoy2wizawod7/dst/one]
    run.go:287: Failed to put "dst/one" to "hdfs://127.0.0.1:8020": create /rclone-test-qefepes9biqazoy2wizawod7/dst/one: replication in progress
2022/04/15 06:15:19 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-qefepes9biqazoy2wizawod7]
2022/04/15 06:15:19 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-qefepes9biqazoy2wizawod7/dst]
2022/04/15 06:15:19 DEBUG : hdfs://127.0.0.1:8020: rmdir [/rclone-test-qefepes9biqazoy2wizawod7/dst]
2022/04/15 06:15:19 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-qefepes9biqazoy2wizawod7]
--- FAIL: TestSyncBackupDirSuffixOnly (0.03s)
=== RUN   TestSyncConcurrentDelete
    run.go:181: Remote "hdfs://127.0.0.1:8020", Local "Local file system at /tmp/rclone2713163378", Modify Window "1s"
2022/04/15 06:15:19 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-qefepes9biqazoy2wizawod7/both0]
2022/04/15 06:15:19 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-qefepes9biqazoy2wizawod7/only0]
2022/04/15 06:15:19 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-qefepes9biqazoy2wizawod7/both1]
2022/04/15 06:15:19 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-qefepes9biqazoy2wizawod7/only1]
2022/04/15 06:15:19 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-qefepes9biqazoy2wizawod7/both2]
    run.go:287: Failed to put "both2" to "hdfs://127.0.0.1:8020": create /rclone-test-qefepes9biqazoy2wizawod7/both2: replication in progress
2022/04/15 06:15:19 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-qefepes9biqazoy2wizawod7]
2022/04/15 06:15:19 DEBUG : hdfs://127.0.0.1:8020: remove [/rclone-test-qefepes9biqazoy2wizawod7/both0]
2022/04/15 06:15:19 DEBUG : hdfs://127.0.0.1:8020: remove [/rclone-test-qefepes9biqazoy2wizawod7/both1]
2022/04/15 06:15:19 DEBUG : hdfs://127.0.0.1:8020: remove [/rclone-test-qefepes9biqazoy2wizawod7/only0]
2022/04/15 06:15:19 DEBUG : hdfs://127.0.0.1:8020: remove [/rclone-test-qefepes9biqazoy2wizawod7/only1]
2022/04/15 06:15:19 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-qefepes9biqazoy2wizawod7]
--- FAIL: TestSyncConcurrentDelete (0.13s)
=== RUN   TestSyncConcurrentTruncate
    run.go:181: Remote "hdfs://127.0.0.1:8020", Local "Local file system at /tmp/rclone2713163378", Modify Window "1s"
2022/04/15 06:15:19 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-qefepes9biqazoy2wizawod7/both0]
2022/04/15 06:15:19 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-qefepes9biqazoy2wizawod7/only0]
2022/04/15 06:15:19 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-qefepes9biqazoy2wizawod7/both1]
2022/04/15 06:15:19 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-qefepes9biqazoy2wizawod7/only1]
2022/04/15 06:15:19 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-qefepes9biqazoy2wizawod7/both2]
    run.go:287: Failed to put "both2" to "hdfs://127.0.0.1:8020": create /rclone-test-qefepes9biqazoy2wizawod7/both2: replication in progress
2022/04/15 06:15:19 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-qefepes9biqazoy2wizawod7]
2022/04/15 06:15:19 DEBUG : hdfs://127.0.0.1:8020: remove [/rclone-test-qefepes9biqazoy2wizawod7/both0]
2022/04/15 06:15:19 DEBUG : hdfs://127.0.0.1:8020: remove [/rclone-test-qefepes9biqazoy2wizawod7/both1]
2022/04/15 06:15:19 DEBUG : hdfs://127.0.0.1:8020: remove [/rclone-test-qefepes9biqazoy2wizawod7/only0]
2022/04/15 06:15:19 DEBUG : hdfs://127.0.0.1:8020: remove [/rclone-test-qefepes9biqazoy2wizawod7/only1]
2022/04/15 06:15:19 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-qefepes9biqazoy2wizawod7]
--- FAIL: TestSyncConcurrentTruncate (0.13s)
FAIL
2022/04/15 06:15:19 DEBUG : hdfs://127.0.0.1:8020: Purge remote
2022/04/15 06:15:19 DEBUG : hdfs://127.0.0.1:8020: purge [/rclone-test-qefepes9biqazoy2wizawod7]
"./sync.test -test.v -test.timeout 1h0m0s -remote TestHdfs: -verbose -test.run '^(TestCopy|TestSyncBackupDirSuffixOnly|TestSyncConcurrentDelete|TestSyncConcurrentTruncate|TestSyncIgnoreErrors)$'" - Finished ERROR in 870.107252ms (try 5/5): exit status 1: Failed [TestCopy TestSyncBackupDirSuffixOnly TestSyncConcurrentDelete TestSyncConcurrentTruncate]