"./sync.test -test.v -test.timeout 1h0m0s -remote TestPcloud: -verbose -fast-list -test.run '^(TestCopyCheckFirst|TestCopyEmptyDirectories|TestCopyNoEmptyDirectories|TestCopyNoTraverse|TestMoveEmptyDirectories|TestMoveNoEmptyDirectories|TestSyncEmptyDirectories|TestSyncNoEmptyDirectories|TestSyncNoTraverse)$'" - Starting (try 2/5)
2025/01/20 05:02:39 DEBUG : Creating backend with remote "TestPcloud:rclone-test-ruqovay0nowi"
2025/01/20 05:02:39 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/01/20 05:02:39 DEBUG : Creating backend with remote "/tmp/rclone3365240398"
=== RUN   TestCopyNoTraverse
    run.go:180: Remote "pcloud root 'rclone-test-ruqovay0nowi'", Local "Local file system at /tmp/rclone3365240398", Modify Window "1s"
2025/01/20 05:02:40 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2025/01/20 05:02:40 DEBUG : pcloud root 'rclone-test-ruqovay0nowi': Waiting for checks to finish
2025/01/20 05:02:40 DEBUG : pcloud root 'rclone-test-ruqovay0nowi': Waiting for transfers to finish
2025/01/20 05:02:40 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK
2025/01/20 05:02:40 DEBUG : sub dir/hello world.adfb51a5.partial: renamed to: sub dir/hello world
2025/01/20 05:02:40 INFO  : sub dir/hello world: Copied (new)
    run.go:180: Remote "pcloud root 'rclone-test-ruqovay0nowi'", Local "Local file system at /tmp/rclone3365240398", Modify Window "1s"
--- PASS: TestCopyNoTraverse (1.55s)
=== RUN   TestCopyCheckFirst
    run.go:180: Remote "pcloud root 'rclone-test-ruqovay0nowi'", Local "Local file system at /tmp/rclone3365240398", Modify Window "1s"
2025/01/20 05:02:41 INFO  : pcloud root 'rclone-test-ruqovay0nowi': Running all checks before starting transfers
2025/01/20 05:02:41 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2025/01/20 05:02:41 DEBUG : pcloud root 'rclone-test-ruqovay0nowi': Waiting for checks to finish
2025/01/20 05:02:41 INFO  : pcloud root 'rclone-test-ruqovay0nowi': Checks finished, now starting transfers
2025/01/20 05:02:41 DEBUG : pcloud root 'rclone-test-ruqovay0nowi': Waiting for transfers to finish
2025/01/20 05:02:41 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK
2025/01/20 05:02:41 DEBUG : sub dir/hello world.adfb51a5.partial: renamed to: sub dir/hello world
2025/01/20 05:02:41 INFO  : sub dir/hello world: Copied (new)
    run.go:180: Remote "pcloud root 'rclone-test-ruqovay0nowi'", Local "Local file system at /tmp/rclone3365240398", Modify Window "1s"
--- PASS: TestCopyCheckFirst (1.13s)
=== RUN   TestSyncNoTraverse
    run.go:180: Remote "pcloud root 'rclone-test-ruqovay0nowi'", Local "Local file system at /tmp/rclone3365240398", Modify Window "1s"
2025/01/20 05:02:42 ERROR : Ignoring --no-traverse with sync
2025/01/20 05:02:42 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2025/01/20 05:02:42 DEBUG : pcloud root 'rclone-test-ruqovay0nowi': Waiting for checks to finish
2025/01/20 05:02:42 DEBUG : pcloud root 'rclone-test-ruqovay0nowi': Waiting for transfers to finish
2025/01/20 05:02:42 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK
2025/01/20 05:02:43 DEBUG : sub dir/hello world.adfb51a5.partial: renamed to: sub dir/hello world
2025/01/20 05:02:43 INFO  : sub dir/hello world: Copied (new)
2025/01/20 05:02:43 DEBUG : Waiting for deletions to finish
    run.go:180: Remote "pcloud root 'rclone-test-ruqovay0nowi'", Local "Local file system at /tmp/rclone3365240398", Modify Window "1s"
--- PASS: TestSyncNoTraverse (1.24s)
=== RUN   TestCopyEmptyDirectories
    run.go:180: Remote "pcloud root 'rclone-test-ruqovay0nowi'", Local "Local file system at /tmp/rclone3365240398", Modify Window "1s"
2025/01/20 05:02:43 DEBUG : sub dir2/sub sub dir2: Making directory with metadata
2025/01/20 05:02:43 INFO  : sub dir2/sub sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z)
2025/01/20 05:02:43 INFO  : sub dir2: Set directory modification time (using DirSetModTime)
2025/01/20 05:02:43 INFO  : sub dir: Set directory modification time (using DirSetModTime)
2025/01/20 05:02:43 INFO  : sub dir: Making directory
2025/01/20 05:02:44 INFO  : sub dir2: Making directory
2025/01/20 05:02:44 INFO  : sub dir2/sub sub dir2: Making directory
2025/01/20 05:02:44 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2025/01/20 05:02:44 DEBUG : pcloud root 'rclone-test-ruqovay0nowi': Waiting for checks to finish
2025/01/20 05:02:44 DEBUG : pcloud root 'rclone-test-ruqovay0nowi': Waiting for transfers to finish
2025/01/20 05:02:44 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK
2025/01/20 05:02:44 DEBUG : sub dir/hello world.adfb51a5.partial: renamed to: sub dir/hello world
2025/01/20 05:02:44 INFO  : sub dir/hello world: Copied (new)
    run.go:180: Remote "pcloud root 'rclone-test-ruqovay0nowi'", Local "Local file system at /tmp/rclone3365240398", Modify Window "1s"
2025/01/20 05:02:44 DEBUG : pcloud root 'rclone-test-ruqovay0nowi': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata
--- PASS: TestCopyEmptyDirectories (1.80s)
=== RUN   TestCopyNoEmptyDirectories
    run.go:180: Remote "pcloud root 'rclone-test-ruqovay0nowi'", Local "Local file system at /tmp/rclone3365240398", Modify Window "1s"
2025/01/20 05:02:45 INFO  : sub dir2: Making directory
2025/01/20 05:02:45 DEBUG : sub dir2/sub sub dir2: Making directory with metadata
2025/01/20 05:02:45 INFO  : sub dir2/sub sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z)
2025/01/20 05:02:45 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2025/01/20 05:02:45 DEBUG : pcloud root 'rclone-test-ruqovay0nowi': Waiting for checks to finish
2025/01/20 05:02:45 DEBUG : pcloud root 'rclone-test-ruqovay0nowi': Waiting for transfers to finish
2025/01/20 05:02:45 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK
2025/01/20 05:02:45 DEBUG : sub dir/hello world.adfb51a5.partial: renamed to: sub dir/hello world
2025/01/20 05:02:45 INFO  : sub dir/hello world: Copied (new)
    fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3
    fstest.go:295: Flushing the directory cache
    fstest.go:286: Sleeping for 6s just to make sure
--- PASS: TestCopyNoEmptyDirectories (8.20s)
=== RUN   TestMoveEmptyDirectories
    run.go:180: Remote "pcloud root 'rclone-test-ruqovay0nowi'", Local "Local file system at /tmp/rclone3365240398", Modify Window "1s"
2025/01/20 05:02:53 DEBUG : sub dir2: Making directory with metadata
2025/01/20 05:02:53 INFO  : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z)
2025/01/20 05:02:53 INFO  : sub dir: Making directory
2025/01/20 05:02:54 INFO  : sub dir2: Making directory
2025/01/20 05:02:54 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2025/01/20 05:02:54 DEBUG : pcloud root 'rclone-test-ruqovay0nowi': Waiting for checks to finish
2025/01/20 05:02:54 DEBUG : pcloud root 'rclone-test-ruqovay0nowi': Waiting for transfers to finish
2025/01/20 05:02:54 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK
2025/01/20 05:02:54 DEBUG : sub dir/hello world.adfb51a5.partial: renamed to: sub dir/hello world
2025/01/20 05:02:54 INFO  : sub dir/hello world: Copied (new)
2025/01/20 05:02:54 INFO  : sub dir/hello world: Deleted
    run.go:180: Remote "pcloud root 'rclone-test-ruqovay0nowi'", Local "Local file system at /tmp/rclone3365240398", Modify Window "1s"
    fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3
    fstest.go:295: Flushing the directory cache
    fstest.go:286: Sleeping for 6s just to make sure
2025/01/20 05:03:01 DEBUG : pcloud root 'rclone-test-ruqovay0nowi': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata
2025/01/20 05:03:01 DEBUG : pcloud root 'rclone-test-ruqovay0nowi': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata
--- PASS: TestMoveEmptyDirectories (8.73s)
=== RUN   TestMoveNoEmptyDirectories
    run.go:180: Remote "pcloud root 'rclone-test-ruqovay0nowi'", Local "Local file system at /tmp/rclone3365240398", Modify Window "1s"
2025/01/20 05:03:02 INFO  : sub dir2: Making directory
2025/01/20 05:03:02 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2025/01/20 05:03:02 DEBUG : pcloud root 'rclone-test-ruqovay0nowi': Waiting for checks to finish
2025/01/20 05:03:02 DEBUG : pcloud root 'rclone-test-ruqovay0nowi': Waiting for transfers to finish
2025/01/20 05:03:02 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK
2025/01/20 05:03:02 DEBUG : sub dir/hello world.adfb51a5.partial: renamed to: sub dir/hello world
2025/01/20 05:03:02 INFO  : sub dir/hello world: Copied (new)
2025/01/20 05:03:02 INFO  : sub dir/hello world: Deleted
--- PASS: TestMoveNoEmptyDirectories (0.95s)
=== RUN   TestSyncEmptyDirectories
    run.go:180: Remote "pcloud root 'rclone-test-ruqovay0nowi'", Local "Local file system at /tmp/rclone3365240398", Modify Window "1s"
2025/01/20 05:03:03 DEBUG : sub dir2: Making directory with metadata
2025/01/20 05:03:03 INFO  : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z)
2025/01/20 05:03:03 INFO  : sub dir: Set directory modification time (using DirSetModTime)
2025/01/20 05:03:03 INFO  : sub dir: Making directory
2025/01/20 05:03:03 INFO  : sub dir2: Making directory
2025/01/20 05:03:03 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2025/01/20 05:03:03 DEBUG : pcloud root 'rclone-test-ruqovay0nowi': Waiting for checks to finish
2025/01/20 05:03:03 DEBUG : pcloud root 'rclone-test-ruqovay0nowi': Waiting for transfers to finish
2025/01/20 05:03:03 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK
2025/01/20 05:03:04 DEBUG : sub dir/hello world.adfb51a5.partial: renamed to: sub dir/hello world
2025/01/20 05:03:04 INFO  : sub dir/hello world: Copied (new)
2025/01/20 05:03:04 DEBUG : Waiting for deletions to finish
    run.go:180: Remote "pcloud root 'rclone-test-ruqovay0nowi'", Local "Local file system at /tmp/rclone3365240398", Modify Window "1s"
2025/01/20 05:03:04 DEBUG : pcloud root 'rclone-test-ruqovay0nowi': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata
--- PASS: TestSyncEmptyDirectories (1.37s)
=== RUN   TestSyncNoEmptyDirectories
    run.go:180: Remote "pcloud root 'rclone-test-ruqovay0nowi'", Local "Local file system at /tmp/rclone3365240398", Modify Window "1s"
2025/01/20 05:03:04 INFO  : sub dir2: Making directory
2025/01/20 05:03:04 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2025/01/20 05:03:04 DEBUG : pcloud root 'rclone-test-ruqovay0nowi': Waiting for checks to finish
2025/01/20 05:03:04 DEBUG : pcloud root 'rclone-test-ruqovay0nowi': Waiting for transfers to finish
2025/01/20 05:03:05 DEBUG : sub dir/hello world: sha1 = 2aae6c35c94fcfb415dbe95f408b9ce91ee846ed OK
2025/01/20 05:03:05 DEBUG : sub dir/hello world.adfb51a5.partial: renamed to: sub dir/hello world
2025/01/20 05:03:05 INFO  : sub dir/hello world: Copied (new)
2025/01/20 05:03:05 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncNoEmptyDirectories (0.96s)
PASS
2025/01/20 05:03:05 DEBUG : pcloud root 'rclone-test-ruqovay0nowi': Purge remote
"./sync.test -test.v -test.timeout 1h0m0s -remote TestPcloud: -verbose -fast-list -test.run '^(TestCopyCheckFirst|TestCopyEmptyDirectories|TestCopyNoEmptyDirectories|TestCopyNoTraverse|TestMoveEmptyDirectories|TestMoveNoEmptyDirectories|TestSyncEmptyDirectories|TestSyncNoEmptyDirectories|TestSyncNoTraverse)$'" - Finished OK in 26.504085625s (try 2/5)