"./sync.test -test.v -test.timeout 1h0m0s -remote TestHdfs: -verbose -test.run '^(TestCopy|TestCopyNoTraverse)$'" - Starting (try 2/5)
2024/10/29 01:22:54 DEBUG : Creating backend with remote "TestHdfs:rclone-test-kexusew3duro"
2024/10/29 01:22:54 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2024/10/29 01:22:54 DEBUG : Setting type="hdfs" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_TYPE
2024/10/29 01:22:54 DEBUG : Setting namenode="127.0.0.1:8020" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_NAMENODE
2024/10/29 01:22:54 DEBUG : Setting username="root" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_USERNAME
2024/10/29 01:22:54 DEBUG : TestHdfs: detected overridden config - adding "{cNNQW}" suffix to name
2024/10/29 01:22:54 DEBUG : Setting namenode="127.0.0.1:8020" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_NAMENODE
2024/10/29 01:22:54 DEBUG : Setting username="root" for "TestHdfs" from environment variable RCLONE_CONFIG_TESTHDFS_USERNAME
2024/10/29 01:22:54 DEBUG : Creating backend with remote "/tmp/rclone3019819016"
=== RUN   TestCopy
    run.go:180: Remote "hdfs://127.0.0.1:8020/rclone-test-kexusew3duro", Local "Local file system at /tmp/rclone3019819016", Modify Window "1s"
2024/10/29 01:22:54 INFO  : sub dir: Set directory modification time (using DirSetModTime)
2024/10/29 01:22:54 DEBUG : hdfs://127.0.0.1:8020/rclone-test-kexusew3duro: mkdir [/rclone-test-kexusew3duro]
2024/10/29 01:22:54 DEBUG : hdfs://127.0.0.1:8020/rclone-test-kexusew3duro: list [/rclone-test-kexusew3duro]
2024/10/29 01:22:54 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2024/10/29 01:22:54 DEBUG : hdfs://127.0.0.1:8020/rclone-test-kexusew3duro: Waiting for checks to finish
2024/10/29 01:22:54 DEBUG : hdfs://127.0.0.1:8020/rclone-test-kexusew3duro: update [/rclone-test-kexusew3duro/sub dir/hello world]
2024/10/29 01:22:54 DEBUG : hdfs://127.0.0.1:8020/rclone-test-kexusew3duro: Waiting for transfers to finish
2024/10/29 01:22:54 DEBUG : pacer: low level retry 1/10 (error create /rclone-test-kexusew3duro/sub dir/hello world: replication in progress)
2024/10/29 01:22:54 DEBUG : pacer: Rate limited, increasing sleep to 40ms
2024/10/29 01:22:54 DEBUG : pacer: low level retry 2/10 (error create /rclone-test-kexusew3duro/sub dir/hello world: replication in progress)
2024/10/29 01:22:54 DEBUG : pacer: Rate limited, increasing sleep to 80ms
2024/10/29 01:22:55 DEBUG : pacer: Reducing sleep to 60ms
2024/10/29 01:22:55 INFO  : sub dir/hello world: Copied (new)
    run.go:180: Remote "hdfs://127.0.0.1:8020/rclone-test-kexusew3duro", Local "Local file system at /tmp/rclone3019819016", Modify Window "1s"
2024/10/29 01:22:55 DEBUG : hdfs://127.0.0.1:8020/rclone-test-kexusew3duro: list [/rclone-test-kexusew3duro]
2024/10/29 01:22:55 DEBUG : hdfs://127.0.0.1:8020/rclone-test-kexusew3duro: list [/rclone-test-kexusew3duro/sub dir]
2024/10/29 01:22:55 DEBUG : hdfs://127.0.0.1:8020/rclone-test-kexusew3duro: Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata
2024/10/29 01:22:55 DEBUG : hdfs://127.0.0.1:8020/rclone-test-kexusew3duro: list [/rclone-test-kexusew3duro]
2024/10/29 01:22:55 DEBUG : hdfs://127.0.0.1:8020/rclone-test-kexusew3duro: list [/rclone-test-kexusew3duro/sub dir]
2024/10/29 01:22:55 DEBUG : hdfs://127.0.0.1:8020/rclone-test-kexusew3duro: remove [/rclone-test-kexusew3duro/sub dir/hello world]
2024/10/29 01:22:55 DEBUG : hdfs://127.0.0.1:8020/rclone-test-kexusew3duro: rmdir [/rclone-test-kexusew3duro/sub dir]
2024/10/29 01:22:55 DEBUG : hdfs://127.0.0.1:8020/rclone-test-kexusew3duro: list [/rclone-test-kexusew3duro]
2024/10/29 01:22:55 DEBUG : hdfs://127.0.0.1:8020/rclone-test-kexusew3duro: list [/rclone-test-kexusew3duro]
2024/10/29 01:22:55 DEBUG : hdfs://127.0.0.1:8020/rclone-test-kexusew3duro: list [/rclone-test-kexusew3duro]
--- PASS: TestCopy (0.36s)
=== RUN   TestCopyNoTraverse
    run.go:180: Remote "hdfs://127.0.0.1:8020/rclone-test-kexusew3duro", Local "Local file system at /tmp/rclone3019819016", Modify Window "1s"
2024/10/29 01:22:55 DEBUG : hdfs://127.0.0.1:8020/rclone-test-kexusew3duro: new [/rclone-test-kexusew3duro/sub dir/hello world]
2024/10/29 01:22:55 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2024/10/29 01:22:55 DEBUG : hdfs://127.0.0.1:8020/rclone-test-kexusew3duro: Waiting for checks to finish
2024/10/29 01:22:55 DEBUG : hdfs://127.0.0.1:8020/rclone-test-kexusew3duro: Waiting for transfers to finish
2024/10/29 01:22:55 DEBUG : hdfs://127.0.0.1:8020/rclone-test-kexusew3duro: update [/rclone-test-kexusew3duro/sub dir/hello world]
2024/10/29 01:22:55 DEBUG : pacer: Reducing sleep to 45ms
2024/10/29 01:22:55 INFO  : sub dir/hello world: Copied (new)
    run.go:180: Remote "hdfs://127.0.0.1:8020/rclone-test-kexusew3duro", Local "Local file system at /tmp/rclone3019819016", Modify Window "1s"
2024/10/29 01:22:55 DEBUG : hdfs://127.0.0.1:8020/rclone-test-kexusew3duro: list [/rclone-test-kexusew3duro]
2024/10/29 01:22:55 DEBUG : hdfs://127.0.0.1:8020/rclone-test-kexusew3duro: list [/rclone-test-kexusew3duro/sub dir]
2024/10/29 01:22:55 DEBUG : hdfs://127.0.0.1:8020/rclone-test-kexusew3duro: list [/rclone-test-kexusew3duro]
2024/10/29 01:22:55 DEBUG : hdfs://127.0.0.1:8020/rclone-test-kexusew3duro: list [/rclone-test-kexusew3duro/sub dir]
2024/10/29 01:22:55 DEBUG : hdfs://127.0.0.1:8020/rclone-test-kexusew3duro: remove [/rclone-test-kexusew3duro/sub dir/hello world]
2024/10/29 01:22:55 DEBUG : hdfs://127.0.0.1:8020/rclone-test-kexusew3duro: rmdir [/rclone-test-kexusew3duro/sub dir]
2024/10/29 01:22:55 DEBUG : hdfs://127.0.0.1:8020/rclone-test-kexusew3duro: list [/rclone-test-kexusew3duro]
2024/10/29 01:22:55 DEBUG : hdfs://127.0.0.1:8020/rclone-test-kexusew3duro: list [/rclone-test-kexusew3duro]
2024/10/29 01:22:55 DEBUG : hdfs://127.0.0.1:8020/rclone-test-kexusew3duro: list [/rclone-test-kexusew3duro]
--- PASS: TestCopyNoTraverse (0.10s)
PASS
2024/10/29 01:22:55 DEBUG : hdfs://127.0.0.1:8020/rclone-test-kexusew3duro: Purge remote
2024/10/29 01:22:55 DEBUG : hdfs://127.0.0.1:8020/rclone-test-kexusew3duro: purge [/rclone-test-kexusew3duro]
"./sync.test -test.v -test.timeout 1h0m0s -remote TestHdfs: -verbose -test.run '^(TestCopy|TestCopyNoTraverse)$'" - Finished OK in 751.19446ms (try 2/5)