"./sync.test -test.v -test.timeout 1h0m0s -remote TestChunkerMailru: -verbose -test.run '^(TestCopy|TestCopyCheckFirst|TestCopyMetadata|TestCopyMetadataNoEmptyDirs|TestCopyMissingDirectory|TestCopyNoTraverse|TestCopyWithDepth|TestCopyWithDryRun|TestCopyWithFilesFrom|TestCopyWithFilesFromAndNoTraverse|TestSyncEmptyDirectories|TestSyncNoEmptyDirectories|TestSyncNoTraverse)$'" - Starting (try 5/5)
2024/11/14 20:56:44 DEBUG : Creating backend with remote "TestChunkerMailru:rclone-test-zukahiq7luhe"
2024/11/14 20:56:44 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2024/11/14 20:56:44 DEBUG : Creating backend with remote "TestMailru:rclone-test-zukahiq7luhe"
2024/11/14 20:56:44 DEBUG : Reset feature "ListR"
2024/11/14 20:56:44 DEBUG : Creating backend with remote "/tmp/rclone3476659296"
=== RUN   TestCopyWithDryRun
    run.go:180: Remote "Chunked 'TestChunkerMailru:rclone-test-zukahiq7luhe'", Local "Local file system at /tmp/rclone3476659296", Modify Window "1s"
2024/11/14 20:56:44 DEBUG : [rclone-test-zukahiq7luhe]: new meta server: https://cld-extapi.datacloudmail.ru/meta/
2024/11/14 20:56:45 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2024/11/14 20:56:45 NOTICE: sub dir/hello world: Skipped copy as --dry-run is set (size 11)
2024/11/14 20:56:45 DEBUG : Chunked 'TestChunkerMailru:rclone-test-zukahiq7luhe': Waiting for checks to finish
2024/11/14 20:56:45 DEBUG : Chunked 'TestChunkerMailru:rclone-test-zukahiq7luhe': Waiting for transfers to finish
    run.go:180: Remote "Chunked 'TestChunkerMailru:rclone-test-zukahiq7luhe'", Local "Local file system at /tmp/rclone3476659296", Modify Window "1s"
--- PASS: TestCopyWithDryRun (0.87s)
=== RUN   TestCopy
    run.go:180: Remote "Chunked 'TestChunkerMailru:rclone-test-zukahiq7luhe'", Local "Local file system at /tmp/rclone3476659296", Modify Window "1s"
2024/11/14 20:56:45 INFO  : sub dir: Set directory modification time (using DirSetModTime)
2024/11/14 20:56:45 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2024/11/14 20:56:45 DEBUG : Chunked 'TestChunkerMailru:rclone-test-zukahiq7luhe': Waiting for checks to finish
2024/11/14 20:56:45 DEBUG : Chunked 'TestChunkerMailru:rclone-test-zukahiq7luhe': Waiting for transfers to finish
2024/11/14 20:56:45 DEBUG : sub dir/hello world: skip slow MD5 on source file, hashing in-transit
2024/11/14 20:56:46 INFO  : sub dir/hello world.rclone_chunk.001_yqev5c: Moved (server-side) to: sub dir/hello world
2024/11/14 20:56:46 INFO  : sub dir/hello world: Copied (new)
    run.go:180: Remote "Chunked 'TestChunkerMailru:rclone-test-zukahiq7luhe'", Local "Local file system at /tmp/rclone3476659296", Modify Window "1s"
2024/11/14 20:56:46 DEBUG : Chunked 'TestChunkerMailru:rclone-test-zukahiq7luhe': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata
--- PASS: TestCopy (2.13s)
=== RUN   TestCopyMetadata
    run.go:180: Remote "Chunked 'TestChunkerMailru:rclone-test-zukahiq7luhe'", Local "Local file system at /tmp/rclone3476659296", Modify Window "1s"
    sync_test.go:97: Skipping as metadata not supported
--- SKIP: TestCopyMetadata (0.21s)
=== RUN   TestCopyMetadataNoEmptyDirs
    run.go:180: Remote "Chunked 'TestChunkerMailru:rclone-test-zukahiq7luhe'", Local "Local file system at /tmp/rclone3476659296", Modify Window "1s"
    sync_test.go:97: Skipping as metadata not supported
--- SKIP: TestCopyMetadataNoEmptyDirs (0.21s)
=== RUN   TestCopyMissingDirectory
    run.go:180: Remote "Chunked 'TestChunkerMailru:rclone-test-zukahiq7luhe'", Local "Local file system at /tmp/rclone3476659296", Modify Window "1s"
2024/11/14 20:56:48 DEBUG : Creating backend with remote "/non-existing"
2024/11/14 20:56:48 ERROR : Local file system at /non-existing: error reading source root directory: directory not found
2024/11/14 20:56:48 DEBUG : Chunked 'TestChunkerMailru:rclone-test-zukahiq7luhe': Waiting for checks to finish
2024/11/14 20:56:48 DEBUG : Chunked 'TestChunkerMailru:rclone-test-zukahiq7luhe': Waiting for transfers to finish
    run.go:180: Remote "Chunked 'TestChunkerMailru:rclone-test-zukahiq7luhe'", Local "Local file system at /tmp/rclone3476659296", Modify Window "1s"
--- PASS: TestCopyMissingDirectory (0.53s)
=== RUN   TestCopyNoTraverse
    run.go:180: Remote "Chunked 'TestChunkerMailru:rclone-test-zukahiq7luhe'", Local "Local file system at /tmp/rclone3476659296", Modify Window "1s"
2024/11/14 20:56:48 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2024/11/14 20:56:48 DEBUG : Chunked 'TestChunkerMailru:rclone-test-zukahiq7luhe': Waiting for checks to finish
2024/11/14 20:56:48 DEBUG : Chunked 'TestChunkerMailru:rclone-test-zukahiq7luhe': Waiting for transfers to finish
2024/11/14 20:56:48 DEBUG : sub dir/hello world: skip slow MD5 on source file, hashing in-transit
2024/11/14 20:56:49 INFO  : sub dir/hello world.rclone_chunk.001_yqey64: Moved (server-side) to: sub dir/hello world
2024/11/14 20:56:49 INFO  : sub dir/hello world: Copied (new)
    run.go:180: Remote "Chunked 'TestChunkerMailru:rclone-test-zukahiq7luhe'", Local "Local file system at /tmp/rclone3476659296", Modify Window "1s"
--- PASS: TestCopyNoTraverse (2.12s)
=== RUN   TestCopyCheckFirst
    run.go:180: Remote "Chunked 'TestChunkerMailru:rclone-test-zukahiq7luhe'", Local "Local file system at /tmp/rclone3476659296", Modify Window "1s"
2024/11/14 20:56:50 INFO  : Chunked 'TestChunkerMailru:rclone-test-zukahiq7luhe': Running all checks before starting transfers
2024/11/14 20:56:50 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2024/11/14 20:56:50 DEBUG : Chunked 'TestChunkerMailru:rclone-test-zukahiq7luhe': Waiting for checks to finish
2024/11/14 20:56:50 INFO  : Chunked 'TestChunkerMailru:rclone-test-zukahiq7luhe': Checks finished, now starting transfers
2024/11/14 20:56:50 DEBUG : Chunked 'TestChunkerMailru:rclone-test-zukahiq7luhe': Waiting for transfers to finish
2024/11/14 20:56:51 DEBUG : sub dir/hello world: skip slow MD5 on source file, hashing in-transit
2024/11/14 20:56:51 INFO  : sub dir/hello world.rclone_chunk.001_yqf11s: Moved (server-side) to: sub dir/hello world
2024/11/14 20:56:51 INFO  : sub dir/hello world: Copied (new)
    run.go:180: Remote "Chunked 'TestChunkerMailru:rclone-test-zukahiq7luhe'", Local "Local file system at /tmp/rclone3476659296", Modify Window "1s"
--- PASS: TestCopyCheckFirst (2.14s)
=== RUN   TestSyncNoTraverse
    run.go:180: Remote "Chunked 'TestChunkerMailru:rclone-test-zukahiq7luhe'", Local "Local file system at /tmp/rclone3476659296", Modify Window "1s"
2024/11/14 20:56:52 ERROR : Ignoring --no-traverse with sync
2024/11/14 20:56:53 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2024/11/14 20:56:53 DEBUG : Chunked 'TestChunkerMailru:rclone-test-zukahiq7luhe': Waiting for checks to finish
2024/11/14 20:56:53 DEBUG : Chunked 'TestChunkerMailru:rclone-test-zukahiq7luhe': Waiting for transfers to finish
2024/11/14 20:56:53 DEBUG : sub dir/hello world: skip slow MD5 on source file, hashing in-transit
2024/11/14 20:56:54 INFO  : sub dir/hello world.rclone_chunk.001_yqf343: Moved (server-side) to: sub dir/hello world
2024/11/14 20:56:54 INFO  : sub dir/hello world: Copied (new)
2024/11/14 20:56:54 DEBUG : Waiting for deletions to finish
    run.go:180: Remote "Chunked 'TestChunkerMailru:rclone-test-zukahiq7luhe'", Local "Local file system at /tmp/rclone3476659296", Modify Window "1s"
--- PASS: TestSyncNoTraverse (2.13s)
=== RUN   TestCopyWithDepth
    run.go:180: Remote "Chunked 'TestChunkerMailru:rclone-test-zukahiq7luhe'", Local "Local file system at /tmp/rclone3476659296", Modify Window "1s"
2024/11/14 20:56:55 DEBUG : hello world2: Need to transfer - File not found at Destination
2024/11/14 20:56:55 DEBUG : Chunked 'TestChunkerMailru:rclone-test-zukahiq7luhe': Waiting for checks to finish
2024/11/14 20:56:55 DEBUG : Chunked 'TestChunkerMailru:rclone-test-zukahiq7luhe': Waiting for transfers to finish
2024/11/14 20:56:55 DEBUG : hello world2: skip slow MD5 on source file, hashing in-transit
2024/11/14 20:56:56 INFO  : hello world2.rclone_chunk.001_yqf5vw: Moved (server-side) to: hello world2
2024/11/14 20:56:56 INFO  : hello world2: Copied (new)
    run.go:180: Remote "Chunked 'TestChunkerMailru:rclone-test-zukahiq7luhe'", Local "Local file system at /tmp/rclone3476659296", Modify Window "1s"
--- PASS: TestCopyWithDepth (1.79s)
=== RUN   TestCopyWithFilesFrom
    run.go:180: Remote "Chunked 'TestChunkerMailru:rclone-test-zukahiq7luhe'", Local "Local file system at /tmp/rclone3476659296", Modify Window "1s"
2024/11/14 20:56:56 DEBUG : potato2: Need to transfer - File not found at Destination
2024/11/14 20:56:56 DEBUG : Chunked 'TestChunkerMailru:rclone-test-zukahiq7luhe': Waiting for checks to finish
2024/11/14 20:56:56 DEBUG : Chunked 'TestChunkerMailru:rclone-test-zukahiq7luhe': Waiting for transfers to finish
2024/11/14 20:56:57 DEBUG : potato2: skip slow MD5 on source file, hashing in-transit
2024/11/14 20:56:58 INFO  : potato2.rclone_chunk.001_yqf70p: Moved (server-side) to: potato2
2024/11/14 20:56:58 INFO  : potato2: Copied (new)
    run.go:180: Remote "Chunked 'TestChunkerMailru:rclone-test-zukahiq7luhe'", Local "Local file system at /tmp/rclone3476659296", Modify Window "1s"
--- PASS: TestCopyWithFilesFrom (1.73s)
=== RUN   TestCopyWithFilesFromAndNoTraverse
    run.go:180: Remote "Chunked 'TestChunkerMailru:rclone-test-zukahiq7luhe'", Local "Local file system at /tmp/rclone3476659296", Modify Window "1s"
2024/11/14 20:56:58 DEBUG : potato2: Need to transfer - File not found at Destination
2024/11/14 20:56:58 DEBUG : Chunked 'TestChunkerMailru:rclone-test-zukahiq7luhe': Waiting for checks to finish
2024/11/14 20:56:58 DEBUG : Chunked 'TestChunkerMailru:rclone-test-zukahiq7luhe': Waiting for transfers to finish
2024/11/14 20:56:58 DEBUG : potato2: skip slow MD5 on source file, hashing in-transit
2024/11/14 20:56:59 INFO  : potato2.rclone_chunk.001_yqf8ml: Moved (server-side) to: potato2
2024/11/14 20:56:59 INFO  : potato2: Copied (new)
    run.go:180: Remote "Chunked 'TestChunkerMailru:rclone-test-zukahiq7luhe'", Local "Local file system at /tmp/rclone3476659296", Modify Window "1s"
--- PASS: TestCopyWithFilesFromAndNoTraverse (1.77s)
=== RUN   TestSyncEmptyDirectories
    run.go:180: Remote "Chunked 'TestChunkerMailru:rclone-test-zukahiq7luhe'", Local "Local file system at /tmp/rclone3476659296", Modify Window "1s"
2024/11/14 20:57:00 DEBUG : sub dir2: Making directory with metadata
2024/11/14 20:57:00 INFO  : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z)
2024/11/14 20:57:00 INFO  : sub dir: Set directory modification time (using DirSetModTime)
2024/11/14 20:57:00 DEBUG : sub dir: Making directory
2024/11/14 20:57:00 DEBUG : sub dir2: Making directory
2024/11/14 20:57:00 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2024/11/14 20:57:00 DEBUG : Chunked 'TestChunkerMailru:rclone-test-zukahiq7luhe': Waiting for checks to finish
2024/11/14 20:57:00 DEBUG : Chunked 'TestChunkerMailru:rclone-test-zukahiq7luhe': Waiting for transfers to finish
2024/11/14 20:57:00 DEBUG : sub dir/hello world: skip slow MD5 on source file, hashing in-transit
2024/11/14 20:57:01 INFO  : sub dir/hello world.rclone_chunk.001_yqfaym: Moved (server-side) to: sub dir/hello world
2024/11/14 20:57:01 INFO  : sub dir/hello world: Copied (new)
2024/11/14 20:57:01 DEBUG : Waiting for deletions to finish
    run.go:180: Remote "Chunked 'TestChunkerMailru:rclone-test-zukahiq7luhe'", Local "Local file system at /tmp/rclone3476659296", Modify Window "1s"
2024/11/14 20:57:02 DEBUG : Chunked 'TestChunkerMailru:rclone-test-zukahiq7luhe': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata
--- PASS: TestSyncEmptyDirectories (2.70s)
=== RUN   TestSyncNoEmptyDirectories
    run.go:180: Remote "Chunked 'TestChunkerMailru:rclone-test-zukahiq7luhe'", Local "Local file system at /tmp/rclone3476659296", Modify Window "1s"
2024/11/14 20:57:03 DEBUG : sub dir2: Making directory
2024/11/14 20:57:03 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2024/11/14 20:57:03 DEBUG : Chunked 'TestChunkerMailru:rclone-test-zukahiq7luhe': Waiting for checks to finish
2024/11/14 20:57:03 DEBUG : Chunked 'TestChunkerMailru:rclone-test-zukahiq7luhe': Waiting for transfers to finish
2024/11/14 20:57:03 DEBUG : sub dir/hello world: skip slow MD5 on source file, hashing in-transit
2024/11/14 20:57:04 INFO  : sub dir/hello world.rclone_chunk.001_yqfdla: Moved (server-side) to: sub dir/hello world
2024/11/14 20:57:04 INFO  : sub dir/hello world: Copied (new)
2024/11/14 20:57:04 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncNoEmptyDirectories (1.93s)
PASS
2024/11/14 20:57:05 DEBUG : Chunked 'TestChunkerMailru:rclone-test-zukahiq7luhe': Purge remote
"./sync.test -test.v -test.timeout 1h0m0s -remote TestChunkerMailru: -verbose -test.run '^(TestCopy|TestCopyCheckFirst|TestCopyMetadata|TestCopyMetadataNoEmptyDirs|TestCopyMissingDirectory|TestCopyNoTraverse|TestCopyWithDepth|TestCopyWithDryRun|TestCopyWithFilesFrom|TestCopyWithFilesFromAndNoTraverse|TestSyncEmptyDirectories|TestSyncNoEmptyDirectories|TestSyncNoTraverse)$'" - Finished OK in 20.636217949s (try 5/5)