"./sync.test -test.v -test.timeout 1h0m0s -remote TestHdfs: -verbose -test.run '^(TestCopy|TestCopyDeleteBefore|TestCopyRedownload|TestServerSideCopy|TestServerSideMove|TestSyncAfterChangingModtimeOnly|TestSyncBackupDirSuffixOnly|TestSyncBackupDirWithSuffixKeepExtension|TestSyncCompareDest|TestSyncConcurrentDelete|TestSyncConcurrentTruncate|TestSyncSuffixKeepExtension)$'" - Starting (try 2/5) 2022/05/21 06:38:36 DEBUG : Creating backend with remote "TestHdfs:rclone-test-wuyesoy2rayunom4wojipik2" 2022/05/21 06:38:36 DEBUG : Setting type="hdfs" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_TYPE 2022/05/21 06:38:36 DEBUG : Setting namenode="127.0.0.1:8020" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_NAMENODE 2022/05/21 06:38:36 DEBUG : Setting username="root" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_USERNAME 2022/05/21 06:38:36 DEBUG : TestHdfs: detected overridden config - adding "{cNNQW}" suffix to name 2022/05/21 06:38:36 DEBUG : Setting namenode="127.0.0.1:8020" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_NAMENODE 2022/05/21 06:38:36 DEBUG : Setting username="root" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_USERNAME 2022/05/21 06:38:36 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2022/05/21 06:38:36 DEBUG : Creating backend with remote "/tmp/rclone1023257012" === RUN TestCopy run.go:181: Remote "hdfs://127.0.0.1:8020", Local "Local file system at /tmp/rclone1023257012", Modify Window "1s" 2022/05/21 06:38:36 DEBUG : hdfs://127.0.0.1:8020: mkdir [/rclone-test-wuyesoy2rayunom4wojipik2] 2022/05/21 06:38:36 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2] 2022/05/21 06:38:36 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-wuyesoy2rayunom4wojipik2/sub dir/hello world] 2022/05/21 06:38:36 DEBUG : hdfs://127.0.0.1:8020: Waiting for checks to finish 2022/05/21 06:38:36 DEBUG : hdfs://127.0.0.1:8020: Waiting for transfers to finish 2022/05/21 06:38:36 ERROR : sub dir/hello world: Failed to copy: create /rclone-test-wuyesoy2rayunom4wojipik2/sub dir/hello world: replication in progress sync_test.go:65: Error Trace: sync_test.go:65 Error: Received unexpected error: create /rclone-test-wuyesoy2rayunom4wojipik2/sub dir/hello world: replication in progress Test: TestCopy 2022/05/21 06:38:36 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2] 2022/05/21 06:38:36 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2/sub dir] 2022/05/21 06:38:36 DEBUG : hdfs://127.0.0.1:8020: rmdir [/rclone-test-wuyesoy2rayunom4wojipik2/sub dir] 2022/05/21 06:38:36 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2] --- FAIL: TestCopy (0.34s) === RUN TestServerSideCopy run.go:181: Remote "hdfs://127.0.0.1:8020", Local "Local file system at /tmp/rclone1023257012", Modify Window "1s" 2022/05/21 06:38:36 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-wuyesoy2rayunom4wojipik2/sub dir/hello world] 2022/05/21 06:38:36 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2] 2022/05/21 06:38:36 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2/sub dir] 2022/05/21 06:38:36 DEBUG : Creating backend with remote "TestHdfs:rclone-test-qibilud3zikixun2fagajuz9" 2022/05/21 06:38:36 DEBUG : Setting type="hdfs" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_TYPE 2022/05/21 06:38:36 DEBUG : Setting namenode="127.0.0.1:8020" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_NAMENODE 2022/05/21 06:38:36 DEBUG : Setting username="root" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_USERNAME 2022/05/21 06:38:36 DEBUG : TestHdfs: detected overridden config - adding "{cNNQW}" suffix to name 2022/05/21 06:38:36 DEBUG : Setting namenode="127.0.0.1:8020" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_NAMENODE 2022/05/21 06:38:36 DEBUG : Setting username="root" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_USERNAME sync_test.go:275: Server side copy (if possible) hdfs://127.0.0.1:8020 -> hdfs://127.0.0.1:8020 2022/05/21 06:38:36 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-qibilud3zikixun2fagajuz9] 2022/05/21 06:38:36 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2] 2022/05/21 06:38:36 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2/sub dir] 2022/05/21 06:38:36 DEBUG : hdfs://127.0.0.1:8020: Waiting for checks to finish 2022/05/21 06:38:36 DEBUG : hdfs://127.0.0.1:8020: open [/rclone-test-wuyesoy2rayunom4wojipik2/sub dir/hello world] 2022/05/21 06:38:36 DEBUG : hdfs://127.0.0.1:8020: Waiting for transfers to finish 2022/05/21 06:38:36 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-qibilud3zikixun2fagajuz9/sub dir/hello world] 2022/05/21 06:38:36 INFO : sub dir/hello world: Copied (new) 2022/05/21 06:38:36 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-qibilud3zikixun2fagajuz9] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-qibilud3zikixun2fagajuz9/sub dir] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: Purge remote 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: purge [/rclone-test-qibilud3zikixun2fagajuz9] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2/sub dir] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: remove [/rclone-test-wuyesoy2rayunom4wojipik2/sub dir/hello world] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: rmdir [/rclone-test-wuyesoy2rayunom4wojipik2/sub dir] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2] --- PASS: TestServerSideCopy (0.30s) === RUN TestCopyRedownload run.go:181: Remote "hdfs://127.0.0.1:8020", Local "Local file system at /tmp/rclone1023257012", Modify Window "1s" 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-wuyesoy2rayunom4wojipik2/sub dir/hello world] run.go:287: Failed to put "sub dir/hello world" to "hdfs://127.0.0.1:8020": create /rclone-test-wuyesoy2rayunom4wojipik2/sub dir/hello world: replication in progress 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2/sub dir] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: rmdir [/rclone-test-wuyesoy2rayunom4wojipik2/sub dir] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2] --- FAIL: TestCopyRedownload (0.08s) === RUN TestSyncAfterChangingModtimeOnly run.go:181: Remote "hdfs://127.0.0.1:8020", Local "Local file system at /tmp/rclone1023257012", Modify Window "1s" 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-wuyesoy2rayunom4wojipik2/empty space] run.go:287: Failed to put "empty space" to "hdfs://127.0.0.1:8020": create /rclone-test-wuyesoy2rayunom4wojipik2/empty space: replication in progress 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2] --- FAIL: TestSyncAfterChangingModtimeOnly (0.04s) === RUN TestCopyDeleteBefore run.go:181: Remote "hdfs://127.0.0.1:8020", Local "Local file system at /tmp/rclone1023257012", Modify Window "1s" 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-wuyesoy2rayunom4wojipik2/potato] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-wuyesoy2rayunom4wojipik2/potato2] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: Waiting for checks to finish 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: Waiting for transfers to finish 2022/05/21 06:38:37 INFO : potato2: Copied (new) 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: remove [/rclone-test-wuyesoy2rayunom4wojipik2/potato] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: remove [/rclone-test-wuyesoy2rayunom4wojipik2/potato2] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2] --- PASS: TestCopyDeleteBefore (0.06s) === RUN TestServerSideMove run.go:181: Remote "hdfs://127.0.0.1:8020", Local "Local file system at /tmp/rclone1023257012", Modify Window "1s" 2022/05/21 06:38:37 DEBUG : Creating backend with remote "TestHdfs:rclone-test-fugajab4bokuxak4sadujow7" 2022/05/21 06:38:37 DEBUG : Setting type="hdfs" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_TYPE 2022/05/21 06:38:37 DEBUG : Setting namenode="127.0.0.1:8020" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_NAMENODE 2022/05/21 06:38:37 DEBUG : Setting username="root" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_USERNAME 2022/05/21 06:38:37 DEBUG : TestHdfs: detected overridden config - adding "{cNNQW}" suffix to name 2022/05/21 06:38:37 DEBUG : Setting namenode="127.0.0.1:8020" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_NAMENODE 2022/05/21 06:38:37 DEBUG : Setting username="root" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_USERNAME 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-wuyesoy2rayunom4wojipik2/potato2] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-wuyesoy2rayunom4wojipik2/empty space] run.go:287: Failed to put "empty space" to "hdfs://127.0.0.1:8020": create /rclone-test-wuyesoy2rayunom4wojipik2/empty space: replication in progress 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: Purge remote 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: purge [/rclone-test-fugajab4bokuxak4sadujow7] 2022/05/21 06:38:37 purge failed: directory not found 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: remove [/rclone-test-wuyesoy2rayunom4wojipik2/potato2] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2] --- FAIL: TestServerSideMove (0.06s) === RUN TestSyncCompareDest run.go:181: Remote "hdfs://127.0.0.1:8020", Local "Local file system at /tmp/rclone1023257012", Modify Window "1s" 2022/05/21 06:38:37 DEBUG : Creating backend with remote "TestHdfs:rclone-test-wuyesoy2rayunom4wojipik2/dst" 2022/05/21 06:38:37 DEBUG : Setting type="hdfs" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_TYPE 2022/05/21 06:38:37 DEBUG : Setting namenode="127.0.0.1:8020" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_NAMENODE 2022/05/21 06:38:37 DEBUG : Setting username="root" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_USERNAME 2022/05/21 06:38:37 DEBUG : TestHdfs: detected overridden config - adding "{cNNQW}" suffix to name 2022/05/21 06:38:37 DEBUG : Setting namenode="127.0.0.1:8020" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_NAMENODE 2022/05/21 06:38:37 DEBUG : Setting username="root" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_USERNAME 2022/05/21 06:38:37 DEBUG : Creating backend with remote "TestHdfs:rclone-test-wuyesoy2rayunom4wojipik2/CompareDest" 2022/05/21 06:38:37 DEBUG : Setting type="hdfs" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_TYPE 2022/05/21 06:38:37 DEBUG : Setting namenode="127.0.0.1:8020" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_NAMENODE 2022/05/21 06:38:37 DEBUG : Setting username="root" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_USERNAME 2022/05/21 06:38:37 DEBUG : TestHdfs: detected overridden config - adding "{cNNQW}" suffix to name 2022/05/21 06:38:37 DEBUG : Setting namenode="127.0.0.1:8020" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_NAMENODE 2022/05/21 06:38:37 DEBUG : Setting username="root" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_USERNAME 2022/05/21 06:38:37 DEBUG : fs cache: renaming cache item "TestHdfs:rclone-test-wuyesoy2rayunom4wojipik2/CompareDest" to be canonical "TestHdfs{cNNQW}:rclone-test-wuyesoy2rayunom4wojipik2/CompareDest" 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2/dst] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: new [/rclone-test-wuyesoy2rayunom4wojipik2/CompareDest/one] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-wuyesoy2rayunom4wojipik2/dst/one] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: Waiting for checks to finish 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: Waiting for transfers to finish 2022/05/21 06:38:37 INFO : one: Copied (new) 2022/05/21 06:38:37 DEBUG : Waiting for deletions to finish 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2/dst] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2/dst] 2022/05/21 06:38:37 DEBUG : fs cache: switching user supplied name "TestHdfs:rclone-test-wuyesoy2rayunom4wojipik2/CompareDest" for canonical name "TestHdfs{cNNQW}:rclone-test-wuyesoy2rayunom4wojipik2/CompareDest" 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2/dst] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: new [/rclone-test-wuyesoy2rayunom4wojipik2/CompareDest/one] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: Waiting for checks to finish 2022/05/21 06:38:37 DEBUG : one: Sizes differ (src 5 vs dst 3) 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: Waiting for transfers to finish 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-wuyesoy2rayunom4wojipik2/dst/one] 2022/05/21 06:38:37 INFO : one: Copied (replaced existing) 2022/05/21 06:38:37 DEBUG : Waiting for deletions to finish 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2/dst] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-wuyesoy2rayunom4wojipik2/dst/one] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-wuyesoy2rayunom4wojipik2/CompareDest/one] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2/dst] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2/CompareDest] 2022/05/21 06:38:37 DEBUG : fs cache: switching user supplied name "TestHdfs:rclone-test-wuyesoy2rayunom4wojipik2/CompareDest" for canonical name "TestHdfs{cNNQW}:rclone-test-wuyesoy2rayunom4wojipik2/CompareDest" 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2/dst] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: new [/rclone-test-wuyesoy2rayunom4wojipik2/CompareDest/one] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: Waiting for checks to finish 2022/05/21 06:38:37 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2022/05/21 06:38:37 DEBUG : one: Destination found in --compare-dest, skipping 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: Waiting for transfers to finish 2022/05/21 06:38:37 DEBUG : Waiting for deletions to finish 2022/05/21 06:38:37 INFO : There was nothing to transfer 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2/dst] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2/CompareDest] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-wuyesoy2rayunom4wojipik2/CompareDest/two] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2/dst] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2/CompareDest] 2022/05/21 06:38:37 DEBUG : fs cache: switching user supplied name "TestHdfs:rclone-test-wuyesoy2rayunom4wojipik2/CompareDest" for canonical name "TestHdfs{cNNQW}:rclone-test-wuyesoy2rayunom4wojipik2/CompareDest" 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2/dst] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: new [/rclone-test-wuyesoy2rayunom4wojipik2/CompareDest/two] 2022/05/21 06:38:37 DEBUG : two: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2022/05/21 06:38:37 DEBUG : two: Destination found in --compare-dest, skipping 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: new [/rclone-test-wuyesoy2rayunom4wojipik2/CompareDest/one] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: Waiting for checks to finish 2022/05/21 06:38:37 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2022/05/21 06:38:37 DEBUG : one: Destination found in --compare-dest, skipping 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: Waiting for transfers to finish 2022/05/21 06:38:37 DEBUG : Waiting for deletions to finish 2022/05/21 06:38:37 INFO : There was nothing to transfer 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2/dst] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2/CompareDest] 2022/05/21 06:38:37 DEBUG : fs cache: switching user supplied name "TestHdfs:rclone-test-wuyesoy2rayunom4wojipik2/CompareDest" for canonical name "TestHdfs{cNNQW}:rclone-test-wuyesoy2rayunom4wojipik2/CompareDest" 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2/dst] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: new [/rclone-test-wuyesoy2rayunom4wojipik2/CompareDest/two] 2022/05/21 06:38:37 DEBUG : two: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2022/05/21 06:38:37 DEBUG : two: Destination found in --compare-dest, skipping 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: new [/rclone-test-wuyesoy2rayunom4wojipik2/CompareDest/one] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: Waiting for checks to finish 2022/05/21 06:38:37 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2022/05/21 06:38:37 DEBUG : one: Destination found in --compare-dest, skipping 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: Waiting for transfers to finish 2022/05/21 06:38:37 DEBUG : Waiting for deletions to finish 2022/05/21 06:38:37 INFO : There was nothing to transfer 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2/dst] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2/CompareDest] sync_test.go:1543: No hash on uploaded file so skipping compare timestamp test 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2/dst] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2/CompareDest] 2022/05/21 06:38:37 DEBUG : fs cache: switching user supplied name "TestHdfs:rclone-test-wuyesoy2rayunom4wojipik2/CompareDest" for canonical name "TestHdfs{cNNQW}:rclone-test-wuyesoy2rayunom4wojipik2/CompareDest" 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2/dst] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: new [/rclone-test-wuyesoy2rayunom4wojipik2/CompareDest/two] 2022/05/21 06:38:37 DEBUG : two: Sizes differ (src 5 vs dst 3) 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-wuyesoy2rayunom4wojipik2/dst/two] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: new [/rclone-test-wuyesoy2rayunom4wojipik2/CompareDest/one] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: Waiting for checks to finish 2022/05/21 06:38:37 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s) 2022/05/21 06:38:37 DEBUG : one: Destination found in --compare-dest, skipping 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: Waiting for transfers to finish 2022/05/21 06:38:37 INFO : two: Copied (new) 2022/05/21 06:38:37 DEBUG : Waiting for deletions to finish 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2/dst] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2/CompareDest] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2/CompareDest] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2/dst] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: remove [/rclone-test-wuyesoy2rayunom4wojipik2/CompareDest/one] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: remove [/rclone-test-wuyesoy2rayunom4wojipik2/CompareDest/two] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: remove [/rclone-test-wuyesoy2rayunom4wojipik2/dst/one] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: remove [/rclone-test-wuyesoy2rayunom4wojipik2/dst/two] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: rmdir [/rclone-test-wuyesoy2rayunom4wojipik2/dst] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: rmdir [/rclone-test-wuyesoy2rayunom4wojipik2/CompareDest] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2] --- PASS: TestSyncCompareDest (0.30s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:181: Remote "hdfs://127.0.0.1:8020", Local "Local file system at /tmp/rclone1023257012", Modify Window "1s" 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-wuyesoy2rayunom4wojipik2/dst/one] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-wuyesoy2rayunom4wojipik2/dst/two] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-wuyesoy2rayunom4wojipik2/dst/three.txt] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2/dst] 2022/05/21 06:38:37 DEBUG : Creating backend with remote "TestHdfs:rclone-test-wuyesoy2rayunom4wojipik2/dst" 2022/05/21 06:38:37 DEBUG : Setting type="hdfs" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_TYPE 2022/05/21 06:38:37 DEBUG : Setting namenode="127.0.0.1:8020" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_NAMENODE 2022/05/21 06:38:37 DEBUG : Setting username="root" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_USERNAME 2022/05/21 06:38:37 DEBUG : TestHdfs: detected overridden config - adding "{cNNQW}" suffix to name 2022/05/21 06:38:37 DEBUG : Setting namenode="127.0.0.1:8020" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_NAMENODE 2022/05/21 06:38:37 DEBUG : Setting username="root" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_USERNAME 2022/05/21 06:38:37 DEBUG : Creating backend with remote "TestHdfs:rclone-test-wuyesoy2rayunom4wojipik2/backup" 2022/05/21 06:38:37 DEBUG : Setting type="hdfs" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_TYPE 2022/05/21 06:38:37 DEBUG : Setting namenode="127.0.0.1:8020" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_NAMENODE 2022/05/21 06:38:37 DEBUG : Setting username="root" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_USERNAME 2022/05/21 06:38:37 DEBUG : TestHdfs: detected overridden config - adding "{cNNQW}" suffix to name 2022/05/21 06:38:37 DEBUG : Setting namenode="127.0.0.1:8020" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_NAMENODE 2022/05/21 06:38:37 DEBUG : Setting username="root" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_USERNAME 2022/05/21 06:38:37 DEBUG : fs cache: renaming cache item "TestHdfs:rclone-test-wuyesoy2rayunom4wojipik2/backup" to be canonical "TestHdfs{cNNQW}:rclone-test-wuyesoy2rayunom4wojipik2/backup" 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2/dst] 2022/05/21 06:38:37 DEBUG : one: Sizes differ (src 4 vs dst 3) 2022/05/21 06:38:37 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: new [/rclone-test-wuyesoy2rayunom4wojipik2/backup/one-2019-01-01] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: Waiting for checks to finish 2022/05/21 06:38:37 DEBUG : two: Unchanged skipping 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: rename [/rclone-test-wuyesoy2rayunom4wojipik2/dst/one] to [/rclone-test-wuyesoy2rayunom4wojipik2/backup/one-2019-01-01] 2022/05/21 06:38:37 INFO : one: Moved (server-side) to: one-2019-01-01 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: Waiting for transfers to finish 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-wuyesoy2rayunom4wojipik2/dst/one] 2022/05/21 06:38:37 INFO : one: Copied (new) 2022/05/21 06:38:37 DEBUG : Waiting for deletions to finish 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: new [/rclone-test-wuyesoy2rayunom4wojipik2/backup/three-2019-01-01.txt] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: rename [/rclone-test-wuyesoy2rayunom4wojipik2/dst/three.txt] to [/rclone-test-wuyesoy2rayunom4wojipik2/backup/three-2019-01-01.txt] 2022/05/21 06:38:37 INFO : three.txt: Moved (server-side) to: three-2019-01-01.txt 2022/05/21 06:38:37 INFO : three.txt: Moved into backup dir 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2/dst] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2/backup] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-wuyesoy2rayunom4wojipik2/dst/three.txt] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2/dst] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2/backup] 2022/05/21 06:38:37 DEBUG : fs cache: switching user supplied name "TestHdfs:rclone-test-wuyesoy2rayunom4wojipik2/backup" for canonical name "TestHdfs{cNNQW}:rclone-test-wuyesoy2rayunom4wojipik2/backup" 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2/dst] 2022/05/21 06:38:37 DEBUG : one: Sizes differ (src 5 vs dst 4) 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: new [/rclone-test-wuyesoy2rayunom4wojipik2/backup/one-2019-01-01] 2022/05/21 06:38:37 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2022/05/21 06:38:37 DEBUG : two: Unchanged skipping 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: Waiting for checks to finish 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: remove [/rclone-test-wuyesoy2rayunom4wojipik2/backup/one-2019-01-01] 2022/05/21 06:38:37 INFO : one-2019-01-01: Deleted 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: rename [/rclone-test-wuyesoy2rayunom4wojipik2/dst/one] to [/rclone-test-wuyesoy2rayunom4wojipik2/backup/one-2019-01-01] 2022/05/21 06:38:37 INFO : one: Moved (server-side) to: one-2019-01-01 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: Waiting for transfers to finish 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-wuyesoy2rayunom4wojipik2/dst/one] 2022/05/21 06:38:37 INFO : one: Copied (new) 2022/05/21 06:38:37 DEBUG : Waiting for deletions to finish 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: new [/rclone-test-wuyesoy2rayunom4wojipik2/backup/three-2019-01-01.txt] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: remove [/rclone-test-wuyesoy2rayunom4wojipik2/backup/three-2019-01-01.txt] 2022/05/21 06:38:37 INFO : three-2019-01-01.txt: Deleted 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: rename [/rclone-test-wuyesoy2rayunom4wojipik2/dst/three.txt] to [/rclone-test-wuyesoy2rayunom4wojipik2/backup/three-2019-01-01.txt] 2022/05/21 06:38:37 INFO : three.txt: Moved (server-side) to: three-2019-01-01.txt 2022/05/21 06:38:37 INFO : three.txt: Moved into backup dir 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2/dst] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2/backup] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2/dst] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2/backup] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: remove [/rclone-test-wuyesoy2rayunom4wojipik2/dst/one] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: remove [/rclone-test-wuyesoy2rayunom4wojipik2/dst/two] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: remove [/rclone-test-wuyesoy2rayunom4wojipik2/backup/one-2019-01-01] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: remove [/rclone-test-wuyesoy2rayunom4wojipik2/backup/three-2019-01-01.txt] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: rmdir [/rclone-test-wuyesoy2rayunom4wojipik2/dst] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: rmdir [/rclone-test-wuyesoy2rayunom4wojipik2/backup] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2] --- PASS: TestSyncBackupDirWithSuffixKeepExtension (0.21s) === RUN TestSyncBackupDirSuffixOnly run.go:181: Remote "hdfs://127.0.0.1:8020", Local "Local file system at /tmp/rclone1023257012", Modify Window "1s" 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-wuyesoy2rayunom4wojipik2/dst/one] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-wuyesoy2rayunom4wojipik2/dst/two] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-wuyesoy2rayunom4wojipik2/dst/three.txt] run.go:287: Failed to put "dst/three.txt" to "hdfs://127.0.0.1:8020": create /rclone-test-wuyesoy2rayunom4wojipik2/dst/three.txt: replication in progress 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2/dst] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: remove [/rclone-test-wuyesoy2rayunom4wojipik2/dst/one] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: remove [/rclone-test-wuyesoy2rayunom4wojipik2/dst/two] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: rmdir [/rclone-test-wuyesoy2rayunom4wojipik2/dst] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2] --- FAIL: TestSyncBackupDirSuffixOnly (0.09s) === RUN TestSyncSuffixKeepExtension run.go:181: Remote "hdfs://127.0.0.1:8020", Local "Local file system at /tmp/rclone1023257012", Modify Window "1s" 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-wuyesoy2rayunom4wojipik2/dst/one] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-wuyesoy2rayunom4wojipik2/dst/two] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-wuyesoy2rayunom4wojipik2/dst/three.txt] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2/dst] 2022/05/21 06:38:37 DEBUG : Creating backend with remote "TestHdfs:rclone-test-wuyesoy2rayunom4wojipik2/dst" 2022/05/21 06:38:37 DEBUG : Setting type="hdfs" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_TYPE 2022/05/21 06:38:37 DEBUG : Setting namenode="127.0.0.1:8020" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_NAMENODE 2022/05/21 06:38:37 DEBUG : Setting username="root" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_USERNAME 2022/05/21 06:38:37 DEBUG : TestHdfs: detected overridden config - adding "{cNNQW}" suffix to name 2022/05/21 06:38:37 DEBUG : Setting namenode="127.0.0.1:8020" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_NAMENODE 2022/05/21 06:38:37 DEBUG : Setting username="root" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_USERNAME 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: new [/rclone-test-wuyesoy2rayunom4wojipik2/dst/one] 2022/05/21 06:38:37 DEBUG : one: Sizes differ (src 4 vs dst 3) 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: new [/rclone-test-wuyesoy2rayunom4wojipik2/dst/one-2019-01-01] 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: rename [/rclone-test-wuyesoy2rayunom4wojipik2/dst/one] to [/rclone-test-wuyesoy2rayunom4wojipik2/dst/one-2019-01-01] 2022/05/21 06:38:37 INFO : one: Moved (server-side) to: one-2019-01-01 2022/05/21 06:38:37 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-wuyesoy2rayunom4wojipik2/dst/one] 2022/05/21 06:38:38 INFO : one: Copied (new) 2022/05/21 06:38:38 DEBUG : hdfs://127.0.0.1:8020: new [/rclone-test-wuyesoy2rayunom4wojipik2/dst/two] 2022/05/21 06:38:38 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2022/05/21 06:38:38 DEBUG : two: Unchanged skipping 2022/05/21 06:38:38 DEBUG : hdfs://127.0.0.1:8020: new [/rclone-test-wuyesoy2rayunom4wojipik2/dst/three.txt] 2022/05/21 06:38:38 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2022/05/21 06:38:38 DEBUG : hdfs://127.0.0.1:8020: new [/rclone-test-wuyesoy2rayunom4wojipik2/dst/three-2019-01-01.txt] 2022/05/21 06:38:38 DEBUG : hdfs://127.0.0.1:8020: rename [/rclone-test-wuyesoy2rayunom4wojipik2/dst/three.txt] to [/rclone-test-wuyesoy2rayunom4wojipik2/dst/three-2019-01-01.txt] 2022/05/21 06:38:38 INFO : three.txt: Moved (server-side) to: three-2019-01-01.txt 2022/05/21 06:38:38 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-wuyesoy2rayunom4wojipik2/dst/three.txt] 2022/05/21 06:38:38 INFO : three.txt: Copied (new) 2022/05/21 06:38:38 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2] 2022/05/21 06:38:38 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2/dst] 2022/05/21 06:38:38 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2] 2022/05/21 06:38:38 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2/dst] 2022/05/21 06:38:38 DEBUG : hdfs://127.0.0.1:8020: new [/rclone-test-wuyesoy2rayunom4wojipik2/dst/one] 2022/05/21 06:38:38 DEBUG : one: Sizes differ (src 5 vs dst 4) 2022/05/21 06:38:38 DEBUG : hdfs://127.0.0.1:8020: new [/rclone-test-wuyesoy2rayunom4wojipik2/dst/one-2019-01-01] 2022/05/21 06:38:38 DEBUG : hdfs://127.0.0.1:8020: remove [/rclone-test-wuyesoy2rayunom4wojipik2/dst/one-2019-01-01] 2022/05/21 06:38:38 INFO : one-2019-01-01: Deleted 2022/05/21 06:38:38 DEBUG : hdfs://127.0.0.1:8020: rename [/rclone-test-wuyesoy2rayunom4wojipik2/dst/one] to [/rclone-test-wuyesoy2rayunom4wojipik2/dst/one-2019-01-01] 2022/05/21 06:38:38 INFO : one: Moved (server-side) to: one-2019-01-01 2022/05/21 06:38:38 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-wuyesoy2rayunom4wojipik2/dst/one] 2022/05/21 06:38:38 INFO : one: Copied (new) 2022/05/21 06:38:38 DEBUG : hdfs://127.0.0.1:8020: new [/rclone-test-wuyesoy2rayunom4wojipik2/dst/two] 2022/05/21 06:38:38 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2022/05/21 06:38:38 DEBUG : two: Unchanged skipping 2022/05/21 06:38:38 DEBUG : hdfs://127.0.0.1:8020: new [/rclone-test-wuyesoy2rayunom4wojipik2/dst/three.txt] 2022/05/21 06:38:38 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2022/05/21 06:38:38 DEBUG : hdfs://127.0.0.1:8020: new [/rclone-test-wuyesoy2rayunom4wojipik2/dst/three-2019-01-01.txt] 2022/05/21 06:38:38 DEBUG : hdfs://127.0.0.1:8020: remove [/rclone-test-wuyesoy2rayunom4wojipik2/dst/three-2019-01-01.txt] 2022/05/21 06:38:38 INFO : three-2019-01-01.txt: Deleted 2022/05/21 06:38:38 DEBUG : hdfs://127.0.0.1:8020: rename [/rclone-test-wuyesoy2rayunom4wojipik2/dst/three.txt] to [/rclone-test-wuyesoy2rayunom4wojipik2/dst/three-2019-01-01.txt] 2022/05/21 06:38:38 INFO : three.txt: Moved (server-side) to: three-2019-01-01.txt 2022/05/21 06:38:38 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-wuyesoy2rayunom4wojipik2/dst/three.txt] 2022/05/21 06:38:38 INFO : three.txt: Copied (new) 2022/05/21 06:38:38 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2] 2022/05/21 06:38:38 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2/dst] 2022/05/21 06:38:38 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2] 2022/05/21 06:38:38 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2/dst] 2022/05/21 06:38:38 DEBUG : hdfs://127.0.0.1:8020: remove [/rclone-test-wuyesoy2rayunom4wojipik2/dst/one] 2022/05/21 06:38:38 DEBUG : hdfs://127.0.0.1:8020: remove [/rclone-test-wuyesoy2rayunom4wojipik2/dst/one-2019-01-01] 2022/05/21 06:38:38 DEBUG : hdfs://127.0.0.1:8020: remove [/rclone-test-wuyesoy2rayunom4wojipik2/dst/three-2019-01-01.txt] 2022/05/21 06:38:38 DEBUG : hdfs://127.0.0.1:8020: remove [/rclone-test-wuyesoy2rayunom4wojipik2/dst/three.txt] 2022/05/21 06:38:38 DEBUG : hdfs://127.0.0.1:8020: remove [/rclone-test-wuyesoy2rayunom4wojipik2/dst/two] 2022/05/21 06:38:38 DEBUG : hdfs://127.0.0.1:8020: rmdir [/rclone-test-wuyesoy2rayunom4wojipik2/dst] 2022/05/21 06:38:38 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2] --- PASS: TestSyncSuffixKeepExtension (0.19s) === RUN TestSyncConcurrentDelete run.go:181: Remote "hdfs://127.0.0.1:8020", Local "Local file system at /tmp/rclone1023257012", Modify Window "1s" 2022/05/21 06:38:38 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-wuyesoy2rayunom4wojipik2/both0] run.go:287: Failed to put "both0" to "hdfs://127.0.0.1:8020": create /rclone-test-wuyesoy2rayunom4wojipik2/both0: replication in progress 2022/05/21 06:38:38 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2] 2022/05/21 06:38:38 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2] --- FAIL: TestSyncConcurrentDelete (0.01s) === RUN TestSyncConcurrentTruncate run.go:181: Remote "hdfs://127.0.0.1:8020", Local "Local file system at /tmp/rclone1023257012", Modify Window "1s" 2022/05/21 06:38:38 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-wuyesoy2rayunom4wojipik2/both0] 2022/05/21 06:38:38 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-wuyesoy2rayunom4wojipik2/only0] 2022/05/21 06:38:38 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-wuyesoy2rayunom4wojipik2/both1] 2022/05/21 06:38:38 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-wuyesoy2rayunom4wojipik2/only1] 2022/05/21 06:38:38 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-wuyesoy2rayunom4wojipik2/both2] 2022/05/21 06:38:38 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-wuyesoy2rayunom4wojipik2/only2] 2022/05/21 06:38:38 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-wuyesoy2rayunom4wojipik2/both3] 2022/05/21 06:38:38 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-wuyesoy2rayunom4wojipik2/only3] 2022/05/21 06:38:38 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-wuyesoy2rayunom4wojipik2/both4] 2022/05/21 06:38:38 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-wuyesoy2rayunom4wojipik2/only4] 2022/05/21 06:38:38 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-wuyesoy2rayunom4wojipik2/both5] 2022/05/21 06:38:38 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-wuyesoy2rayunom4wojipik2/only5] 2022/05/21 06:38:38 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-wuyesoy2rayunom4wojipik2/both6] 2022/05/21 06:38:38 DEBUG : hdfs://127.0.0.1:8020: update [/rclone-test-wuyesoy2rayunom4wojipik2/only6] run.go:287: Failed to put "only6" to "hdfs://127.0.0.1:8020": create /rclone-test-wuyesoy2rayunom4wojipik2/only6: replication in progress 2022/05/21 06:38:38 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2] 2022/05/21 06:38:38 DEBUG : hdfs://127.0.0.1:8020: remove [/rclone-test-wuyesoy2rayunom4wojipik2/both0] 2022/05/21 06:38:38 DEBUG : hdfs://127.0.0.1:8020: remove [/rclone-test-wuyesoy2rayunom4wojipik2/both1] 2022/05/21 06:38:38 DEBUG : hdfs://127.0.0.1:8020: remove [/rclone-test-wuyesoy2rayunom4wojipik2/both2] 2022/05/21 06:38:38 DEBUG : hdfs://127.0.0.1:8020: remove [/rclone-test-wuyesoy2rayunom4wojipik2/both3] 2022/05/21 06:38:38 DEBUG : hdfs://127.0.0.1:8020: remove [/rclone-test-wuyesoy2rayunom4wojipik2/both4] 2022/05/21 06:38:38 DEBUG : hdfs://127.0.0.1:8020: remove [/rclone-test-wuyesoy2rayunom4wojipik2/both5] 2022/05/21 06:38:38 DEBUG : hdfs://127.0.0.1:8020: remove [/rclone-test-wuyesoy2rayunom4wojipik2/both6] 2022/05/21 06:38:38 DEBUG : hdfs://127.0.0.1:8020: remove [/rclone-test-wuyesoy2rayunom4wojipik2/only0] 2022/05/21 06:38:38 DEBUG : hdfs://127.0.0.1:8020: remove [/rclone-test-wuyesoy2rayunom4wojipik2/only1] 2022/05/21 06:38:38 DEBUG : hdfs://127.0.0.1:8020: remove [/rclone-test-wuyesoy2rayunom4wojipik2/only2] 2022/05/21 06:38:38 DEBUG : hdfs://127.0.0.1:8020: remove [/rclone-test-wuyesoy2rayunom4wojipik2/only3] 2022/05/21 06:38:38 DEBUG : hdfs://127.0.0.1:8020: remove [/rclone-test-wuyesoy2rayunom4wojipik2/only4] 2022/05/21 06:38:38 DEBUG : hdfs://127.0.0.1:8020: remove [/rclone-test-wuyesoy2rayunom4wojipik2/only5] 2022/05/21 06:38:38 DEBUG : hdfs://127.0.0.1:8020: list [/rclone-test-wuyesoy2rayunom4wojipik2] --- FAIL: TestSyncConcurrentTruncate (0.16s) FAIL 2022/05/21 06:38:38 DEBUG : hdfs://127.0.0.1:8020: Purge remote 2022/05/21 06:38:38 DEBUG : hdfs://127.0.0.1:8020: purge [/rclone-test-wuyesoy2rayunom4wojipik2] "./sync.test -test.v -test.timeout 1h0m0s -remote TestHdfs: -verbose -test.run '^(TestCopy|TestCopyDeleteBefore|TestCopyRedownload|TestServerSideCopy|TestServerSideMove|TestSyncAfterChangingModtimeOnly|TestSyncBackupDirSuffixOnly|TestSyncBackupDirWithSuffixKeepExtension|TestSyncCompareDest|TestSyncConcurrentDelete|TestSyncConcurrentTruncate|TestSyncSuffixKeepExtension)$'" - Finished ERROR in 2.007541901s (try 2/5): exit status 1: Failed [TestCopy TestCopyRedownload TestSyncAfterChangingModtimeOnly TestServerSideMove TestSyncBackupDirSuffixOnly TestSyncConcurrentDelete TestSyncConcurrentTruncate]