"./sync.test -test.v -test.timeout 1h0m0s -remote TestGoFile: -verbose -test.run '^(TestMoveWithDeleteEmptySrcDirs|TestSyncEmptyDirectories)$'" - Starting (try 2/5)
2024/12/22 01:43:29 DEBUG : Creating backend with remote "TestGoFile:rclone-test-hofugiy8pitu"
2024/12/22 01:43:29 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2024/12/22 01:43:29 DEBUG : Creating backend with remote "/tmp/rclone2371981992"
=== RUN   TestSyncEmptyDirectories
    run.go:180: Remote "gofile root 'rclone-test-hofugiy8pitu'", Local "Local file system at /tmp/rclone2371981992", Modify Window "1s"
2024/12/22 01:43:29 DEBUG : sub dir2: Making directory with metadata
2024/12/22 01:43:29 INFO  : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z)
2024/12/22 01:43:29 INFO  : sub dir: Set directory modification time (using DirSetModTime)
2024/12/22 01:43:30 DEBUG : sub dir: Making directory
2024/12/22 01:43:31 INFO  : sub dir: Made directory with modification time 2001-02-03 04:05:06.499999999 +0000 UTC
2024/12/22 01:43:31 DEBUG : Added delayed dir = "sub dir", newDst=<nil>
2024/12/22 01:43:31 DEBUG : sub dir2: Making directory
2024/12/22 01:43:32 INFO  : sub dir2: Made directory with modification time 2011-12-25 12:59:59.123456789 +0000 UTC
2024/12/22 01:43:32 DEBUG : Added delayed dir = "sub dir2", newDst=<nil>
2024/12/22 01:43:32 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2024/12/22 01:43:32 DEBUG : gofile root 'rclone-test-hofugiy8pitu': Waiting for checks to finish
2024/12/22 01:43:32 DEBUG : gofile root 'rclone-test-hofugiy8pitu': Waiting for transfers to finish
2024/12/22 01:43:32 DEBUG : Upload server store-eu-par-1 (eu) responded in 129.001748ms
2024/12/22 01:43:32 DEBUG : Upload server store-eu-par-2 (eu) responded in 129.59266ms
2024/12/22 01:43:32 DEBUG : sub dir/hello world: Using upload server store-eu-par-1 (eu)
2024/12/22 01:43:32 DEBUG : sub dir/hello world: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK
2024/12/22 01:43:32 INFO  : sub dir/hello world: Copied (new)
2024/12/22 01:43:32 DEBUG : Waiting for deletions to finish
2024/12/22 01:43:32 INFO  : sub dir: Set directory modification time (using DirSetModTime)
2024/12/22 01:43:32 INFO  : sub dir2: Set directory modification time (using DirSetModTime)
    run.go:180: Remote "gofile root 'rclone-test-hofugiy8pitu'", Local "Local file system at /tmp/rclone2371981992", Modify Window "1s"
--- PASS: TestSyncEmptyDirectories (5.57s)
=== RUN   TestMoveWithDeleteEmptySrcDirs
    run.go:180: Remote "gofile root 'rclone-test-hofugiy8pitu'", Local "Local file system at /tmp/rclone2371981992", Modify Window "1s"
2024/12/22 01:43:35 DEBUG : Added delayed dir = "nested", newDst=<nil>
2024/12/22 01:43:35 DEBUG : Added delayed dir = "sub dir", newDst=<nil>
2024/12/22 01:43:35 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2024/12/22 01:43:35 DEBUG : Added delayed dir = "nested/sub dir", newDst=<nil>
2024/12/22 01:43:35 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination
2024/12/22 01:43:35 DEBUG : gofile root 'rclone-test-hofugiy8pitu': Waiting for checks to finish
2024/12/22 01:43:35 DEBUG : gofile root 'rclone-test-hofugiy8pitu': Waiting for transfers to finish
2024/12/22 01:43:37 DEBUG : sub dir/hello world: Using upload server store-eu-par-1 (eu)
2024/12/22 01:43:37 DEBUG : nested/sub dir/file: Using upload server store-eu-par-1 (eu)
2024/12/22 01:43:37 DEBUG : sub dir/hello world: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK
2024/12/22 01:43:37 INFO  : sub dir/hello world: Copied (new)
2024/12/22 01:43:37 INFO  : sub dir/hello world: Deleted
2024/12/22 01:43:37 DEBUG : nested/sub dir/file: md5 = 83d3784ea62518eafc60e98d84f877ad OK
2024/12/22 01:43:37 INFO  : nested/sub dir/file: Copied (new)
2024/12/22 01:43:37 INFO  : nested/sub dir/file: Deleted
2024/12/22 01:43:37 INFO  : nested/sub dir: Set directory modification time (using DirSetModTime)
2024/12/22 01:43:38 INFO  : sub dir: Set directory modification time (using DirSetModTime)
2024/12/22 01:43:38 INFO  : nested: Set directory modification time (using DirSetModTime)
2024/12/22 01:43:38 INFO  : sub dir: Removing directory
2024/12/22 01:43:38 INFO  : nested/sub dir: Removing directory
2024/12/22 01:43:38 INFO  : nested: Removing directory
2024/12/22 01:43:38 DEBUG : Local file system at /tmp/rclone2371981992: deleted 3 directories
    run.go:180: Remote "gofile root 'rclone-test-hofugiy8pitu'", Local "Local file system at /tmp/rclone2371981992", Modify Window "1s"
--- PASS: TestMoveWithDeleteEmptySrcDirs (5.77s)
PASS
2024/12/22 01:43:41 DEBUG : gofile root 'rclone-test-hofugiy8pitu': Purge remote
"./sync.test -test.v -test.timeout 1h0m0s -remote TestGoFile: -verbose -test.run '^(TestMoveWithDeleteEmptySrcDirs|TestSyncEmptyDirectories)$'" - Finished OK in 12.114047607s (try 2/5)