"./sync.test -test.v -test.timeout 1h0m0s -remote TestHdfs: -verbose -test.run '^(TestCopy|TestCopyNoTraverse|TestSyncSuffix|TestSyncWithUpdateOlder)$'" - Starting (try 4/5)
2022/04/20 06:05:30 DEBUG : Creating backend with remote "TestHdfs:rclone-test-hisoyiq1lidugiw0qopapoy6"
2022/04/20 06:05:30 DEBUG : Setting type="hdfs" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_TYPE
2022/04/20 06:05:30 DEBUG : Setting namenode="127.0.0.1:8020" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_NAMENODE
2022/04/20 06:05:30 DEBUG : Setting username="root" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_USERNAME
2022/04/20 06:05:30 DEBUG : TestHdfs: detected overridden config - adding "{cNNQW}" suffix to name
2022/04/20 06:05:30 DEBUG : Setting namenode="127.0.0.1:8020" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_NAMENODE
2022/04/20 06:05:30 DEBUG : Setting username="root" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_USERNAME
2022/04/20 06:05:30 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2022/04/20 06:05:30 DEBUG : Creating backend with remote "/tmp/rclone728005005"
=== RUN   TestCopy
    run.go:181: Remote "hdfs://127.0.0.1:8020", Local "Local file system at /tmp/rclone728005005", Modify Window "1s"
2022/04/20 06:05:30 DEBUG : hdfs://127.0.0.1:8020: mkdir [/rclone-test-hisoyiq1lidugiw0qopapoy6]
2022/04/20 06:05:30 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-hisoyiq1lidugiw0qopapoy6]
2022/04/20 06:05:30 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-hisoyiq1lidugiw0qopapoy6/sub dir/hello world]
2022/04/20 06:05:30 DEBUG : hdfs://127.0.0.1:8020: Waiting for checks to finish
2022/04/20 06:05:30 DEBUG : hdfs://127.0.0.1:8020: Waiting for transfers to finish
2022/04/20 06:05:30 ERROR : sub dir/hello world: Failed to copy: create /rclone-test-hisoyiq1lidugiw0qopapoy6/sub dir/hello world: replication in progress
    sync_test.go:65: 
        	Error Trace:	sync_test.go:65
        	Error:      	Received unexpected error:
        	            	create /rclone-test-hisoyiq1lidugiw0qopapoy6/sub dir/hello world: replication in progress
        	Test:       	TestCopy
2022/04/20 06:05:30 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-hisoyiq1lidugiw0qopapoy6]
2022/04/20 06:05:30 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-hisoyiq1lidugiw0qopapoy6/sub dir]
2022/04/20 06:05:30 DEBUG : hdfs://127.0.0.1:8020: rmdir [/rclone-test-hisoyiq1lidugiw0qopapoy6/sub dir]
2022/04/20 06:05:30 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-hisoyiq1lidugiw0qopapoy6]
--- FAIL: TestCopy (0.21s)
=== RUN   TestCopyNoTraverse
    run.go:181: Remote "hdfs://127.0.0.1:8020", Local "Local file system at /tmp/rclone728005005", Modify Window "1s"
2022/04/20 06:05:30 DEBUG : hdfs://127.0.0.1:8020: new [/rclone-test-hisoyiq1lidugiw0qopapoy6/sub dir/hello world]
2022/04/20 06:05:30 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-hisoyiq1lidugiw0qopapoy6/sub dir/hello world]
2022/04/20 06:05:30 DEBUG : hdfs://127.0.0.1:8020: Waiting for checks to finish
2022/04/20 06:05:30 DEBUG : hdfs://127.0.0.1:8020: Waiting for transfers to finish
2022/04/20 06:05:31 INFO  : sub dir/hello world: Copied (new)
2022/04/20 06:05:31 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-hisoyiq1lidugiw0qopapoy6]
2022/04/20 06:05:31 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-hisoyiq1lidugiw0qopapoy6/sub dir]
2022/04/20 06:05:31 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-hisoyiq1lidugiw0qopapoy6]
2022/04/20 06:05:31 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-hisoyiq1lidugiw0qopapoy6/sub dir]
2022/04/20 06:05:31 DEBUG : hdfs://127.0.0.1:8020: remove [/rclone-test-hisoyiq1lidugiw0qopapoy6/sub dir/hello world]
2022/04/20 06:05:31 DEBUG : hdfs://127.0.0.1:8020: rmdir [/rclone-test-hisoyiq1lidugiw0qopapoy6/sub dir]
2022/04/20 06:05:31 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-hisoyiq1lidugiw0qopapoy6]
--- PASS: TestCopyNoTraverse (0.05s)
=== RUN   TestSyncWithUpdateOlder
    run.go:181: Remote "hdfs://127.0.0.1:8020", Local "Local file system at /tmp/rclone728005005", Modify Window "1s"
2022/04/20 06:05:31 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-hisoyiq1lidugiw0qopapoy6/one]
2022/04/20 06:05:31 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-hisoyiq1lidugiw0qopapoy6/two]
2022/04/20 06:05:31 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-hisoyiq1lidugiw0qopapoy6/three]
2022/04/20 06:05:31 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-hisoyiq1lidugiw0qopapoy6/four]
2022/04/20 06:05:31 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-hisoyiq1lidugiw0qopapoy6]
2022/04/20 06:05:31 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-hisoyiq1lidugiw0qopapoy6]
2022/04/20 06:05:31 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-hisoyiq1lidugiw0qopapoy6/five]
2022/04/20 06:05:31 DEBUG : four: Sizes differ (src 4 vs dst 8)
2022/04/20 06:05:31 DEBUG : four: Destination mod time is within 1s of source but files differ, transferring
2022/04/20 06:05:31 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-hisoyiq1lidugiw0qopapoy6/four]
2022/04/20 06:05:31 DEBUG : one: Destination is newer than source, skipping
2022/04/20 06:05:31 DEBUG : three: Sizes identical
2022/04/20 06:05:31 DEBUG : three: Destination mod time is within 1s of source and files identical, skipping
2022/04/20 06:05:31 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-hisoyiq1lidugiw0qopapoy6/two]
2022/04/20 06:05:31 DEBUG : hdfs://127.0.0.1:8020: Waiting for checks to finish
2022/04/20 06:05:31 DEBUG : hdfs://127.0.0.1:8020: Waiting for transfers to finish
2022/04/20 06:05:31 INFO  : five: Copied (new)
2022/04/20 06:05:31 ERROR : four: Failed to copy: create /rclone-test-hisoyiq1lidugiw0qopapoy6/four: replication in progress
2022/04/20 06:05:31 ERROR : two: Failed to copy: create /rclone-test-hisoyiq1lidugiw0qopapoy6/two: replication in progress
2022/04/20 06:05:31 ERROR : hdfs://127.0.0.1:8020: not deleting files as there were IO errors
2022/04/20 06:05:31 ERROR : hdfs://127.0.0.1:8020: not deleting directories as there were IO errors
    sync_test.go:988: 
        	Error Trace:	sync_test.go:988
        	Error:      	Received unexpected error:
        	            	create /rclone-test-hisoyiq1lidugiw0qopapoy6/two: replication in progress
        	Test:       	TestSyncWithUpdateOlder
2022/04/20 06:05:31 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-hisoyiq1lidugiw0qopapoy6]
2022/04/20 06:05:31 DEBUG : hdfs://127.0.0.1:8020: remove [/rclone-test-hisoyiq1lidugiw0qopapoy6/five]
2022/04/20 06:05:31 DEBUG : hdfs://127.0.0.1:8020: remove [/rclone-test-hisoyiq1lidugiw0qopapoy6/one]
2022/04/20 06:05:31 DEBUG : hdfs://127.0.0.1:8020: remove [/rclone-test-hisoyiq1lidugiw0qopapoy6/three]
2022/04/20 06:05:31 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-hisoyiq1lidugiw0qopapoy6]
--- FAIL: TestSyncWithUpdateOlder (0.17s)
=== RUN   TestSyncSuffix
    run.go:181: Remote "hdfs://127.0.0.1:8020", Local "Local file system at /tmp/rclone728005005", Modify Window "1s"
2022/04/20 06:05:31 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-hisoyiq1lidugiw0qopapoy6/dst/one]
2022/04/20 06:05:31 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-hisoyiq1lidugiw0qopapoy6/dst/two]
2022/04/20 06:05:31 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-hisoyiq1lidugiw0qopapoy6/dst/three.txt]
    run.go:287: Failed to put "dst/three.txt" to "hdfs://127.0.0.1:8020": create /rclone-test-hisoyiq1lidugiw0qopapoy6/dst/three.txt: replication in progress
2022/04/20 06:05:31 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-hisoyiq1lidugiw0qopapoy6]
2022/04/20 06:05:31 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-hisoyiq1lidugiw0qopapoy6/dst]
2022/04/20 06:05:31 DEBUG : hdfs://127.0.0.1:8020: remove [/rclone-test-hisoyiq1lidugiw0qopapoy6/dst/one]
2022/04/20 06:05:31 DEBUG : hdfs://127.0.0.1:8020: remove [/rclone-test-hisoyiq1lidugiw0qopapoy6/dst/two]
2022/04/20 06:05:31 DEBUG : hdfs://127.0.0.1:8020: rmdir [/rclone-test-hisoyiq1lidugiw0qopapoy6/dst]
2022/04/20 06:05:31 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-hisoyiq1lidugiw0qopapoy6]
--- FAIL: TestSyncSuffix (0.08s)
FAIL
2022/04/20 06:05:31 DEBUG : hdfs://127.0.0.1:8020: Purge remote
2022/04/20 06:05:31 DEBUG : hdfs://127.0.0.1:8020: purge [/rclone-test-hisoyiq1lidugiw0qopapoy6]
"./sync.test -test.v -test.timeout 1h0m0s -remote TestHdfs: -verbose -test.run '^(TestCopy|TestCopyNoTraverse|TestSyncSuffix|TestSyncWithUpdateOlder)$'" - Finished ERROR in 649.317751ms (try 4/5): exit status 1: Failed [TestCopy TestSyncWithUpdateOlder TestSyncSuffix]