"./sync.test -test.v -test.timeout 1h0m0s -remote TestMega: -verbose" - Starting (try 1/5) 2021/07/25 05:16:58 DEBUG : Creating backend with remote "TestMega:rclone-test-palahut3lelesot5lisohur8" 2021/07/25 05:16:58 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2021/07/25 05:17:07 DEBUG : Creating backend with remote "/tmp/rclone159634013" === RUN TestPipe --- PASS: TestPipe (0.00s) === RUN TestPipeConcurrent --- PASS: TestPipeConcurrent (0.09s) === RUN TestPipeOrderBy === RUN TestPipeOrderBy/#00 === RUN TestPipeOrderBy/size === RUN TestPipeOrderBy/name === RUN TestPipeOrderBy/modtime === RUN TestPipeOrderBy/size,ascending === RUN TestPipeOrderBy/name,asc === RUN TestPipeOrderBy/modtime,ascending === RUN TestPipeOrderBy/size,descending === RUN TestPipeOrderBy/name,desc === RUN TestPipeOrderBy/modtime,descending === RUN TestPipeOrderBy/size,mixed,50 === RUN TestPipeOrderBy/size,mixed,51 --- PASS: TestPipeOrderBy (0.00s) --- PASS: TestPipeOrderBy/#00 (0.00s) --- PASS: TestPipeOrderBy/size (0.00s) --- PASS: TestPipeOrderBy/name (0.00s) --- PASS: TestPipeOrderBy/modtime (0.00s) --- PASS: TestPipeOrderBy/size,ascending (0.00s) --- PASS: TestPipeOrderBy/name,asc (0.00s) --- PASS: TestPipeOrderBy/modtime,ascending (0.00s) --- PASS: TestPipeOrderBy/size,descending (0.00s) --- PASS: TestPipeOrderBy/name,desc (0.00s) --- PASS: TestPipeOrderBy/modtime,descending (0.00s) --- PASS: TestPipeOrderBy/size,mixed,50 (0.00s) --- PASS: TestPipeOrderBy/size,mixed,51 (0.00s) === RUN TestNewLess === RUN TestNewLess/blankOK === RUN TestNewLess/tooManyParts === RUN TestNewLess/tooManyParts2 === RUN TestNewLess/badMixed === RUN TestNewLess/unknownComparison === RUN TestNewLess/unknownSortDirection === RUN TestNewLess/size === RUN TestNewLess/name === RUN TestNewLess/modtime === RUN TestNewLess/size,ascending === RUN TestNewLess/name,asc === RUN TestNewLess/modtime,ascending === RUN TestNewLess/size,descending === RUN TestNewLess/name,desc === RUN TestNewLess/modtime,descending === RUN TestNewLess/modtime,mixed === RUN TestNewLess/modtime,mixed,30 --- PASS: TestNewLess (0.00s) --- PASS: TestNewLess/blankOK (0.00s) --- PASS: TestNewLess/tooManyParts (0.00s) --- PASS: TestNewLess/tooManyParts2 (0.00s) --- PASS: TestNewLess/badMixed (0.00s) --- PASS: TestNewLess/unknownComparison (0.00s) --- PASS: TestNewLess/unknownSortDirection (0.00s) --- PASS: TestNewLess/size (0.00s) --- PASS: TestNewLess/name (0.00s) --- PASS: TestNewLess/modtime (0.00s) --- PASS: TestNewLess/size,ascending (0.00s) --- PASS: TestNewLess/name,asc (0.00s) --- PASS: TestNewLess/modtime,ascending (0.00s) --- PASS: TestNewLess/size,descending (0.00s) --- PASS: TestNewLess/name,desc (0.00s) --- PASS: TestNewLess/modtime,descending (0.00s) --- PASS: TestNewLess/modtime,mixed (0.00s) --- PASS: TestNewLess/modtime,mixed,30 (0.00s) === RUN TestRcCopy rc_test.go:16: Skipping test on non local remote --- SKIP: TestRcCopy (0.00s) === RUN TestRcMove rc_test.go:16: Skipping test on non local remote --- SKIP: TestRcMove (0.00s) === RUN TestRcSync rc_test.go:16: Skipping test on non local remote --- SKIP: TestRcSync (0.00s) === RUN TestCopyWithDryRun run.go:176: Remote "mega root 'rclone-test-palahut3lelesot5lisohur8'", Local "Local file system at /tmp/rclone159634013", Modify Window "876000h0m0s" 2021/07/25 05:17:12 NOTICE: sub dir/hello world: Skipped copy as --dry-run is set (size 11) 2021/07/25 05:17:12 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for checks to finish 2021/07/25 05:17:12 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for transfers to finish --- PASS: TestCopyWithDryRun (5.53s) === RUN TestCopy run.go:176: Remote "mega root 'rclone-test-palahut3lelesot5lisohur8'", Local "Local file system at /tmp/rclone159634013", Modify Window "876000h0m0s" 2021/07/25 05:17:12 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for checks to finish 2021/07/25 05:17:12 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for transfers to finish 2021/07/25 05:17:13 INFO : sub dir/hello world: Copied (new) run.go:121: removing dir "sub dir" failed - try 1/3: directory not empty --- PASS: TestCopy (1.69s) === RUN TestCopyMissingDirectory run.go:176: Remote "mega root 'rclone-test-palahut3lelesot5lisohur8'", Local "Local file system at /tmp/rclone159634013", Modify Window "876000h0m0s" 2021/07/25 05:17:14 DEBUG : Creating backend with remote "/non-existing" 2021/07/25 05:17:14 ERROR : Local file system at /non-existing: error reading source root directory: directory not found 2021/07/25 05:17:14 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for checks to finish 2021/07/25 05:17:14 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for transfers to finish --- PASS: TestCopyMissingDirectory (0.00s) === RUN TestCopyNoTraverse run.go:176: Remote "mega root 'rclone-test-palahut3lelesot5lisohur8'", Local "Local file system at /tmp/rclone159634013", Modify Window "876000h0m0s" 2021/07/25 05:17:14 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for checks to finish 2021/07/25 05:17:14 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for transfers to finish 2021/07/25 05:17:14 INFO : sub dir/hello world: Copied (new) run.go:121: removing dir "sub dir" failed - try 1/3: directory not empty --- PASS: TestCopyNoTraverse (1.83s) === RUN TestCopyCheckFirst run.go:176: Remote "mega root 'rclone-test-palahut3lelesot5lisohur8'", Local "Local file system at /tmp/rclone159634013", Modify Window "876000h0m0s" 2021/07/25 05:17:16 INFO : mega root 'rclone-test-palahut3lelesot5lisohur8': Running all checks before starting transfers 2021/07/25 05:17:16 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for checks to finish 2021/07/25 05:17:16 INFO : mega root 'rclone-test-palahut3lelesot5lisohur8': Checks finished, now starting transfers 2021/07/25 05:17:16 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for transfers to finish 2021/07/25 05:17:16 INFO : sub dir/hello world: Copied (new) run.go:121: removing dir "sub dir" failed - try 1/3: directory not empty run.go:121: removing dir "sub dir" failed - try 2/3: delete directory node failed: Try again --- PASS: TestCopyCheckFirst (20.74s) === RUN TestSyncNoTraverse run.go:176: Remote "mega root 'rclone-test-palahut3lelesot5lisohur8'", Local "Local file system at /tmp/rclone159634013", Modify Window "876000h0m0s" 2021/07/25 05:17:37 ERROR : Ignoring --no-traverse with sync 2021/07/25 05:17:37 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for checks to finish 2021/07/25 05:17:37 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for transfers to finish 2021/07/25 05:17:38 INFO : sub dir/hello world: Copied (new) 2021/07/25 05:17:38 DEBUG : Waiting for deletions to finish run.go:121: removing dir "sub dir" failed - try 1/3: directory not empty --- PASS: TestSyncNoTraverse (4.67s) === RUN TestCopyWithDepth run.go:176: Remote "mega root 'rclone-test-palahut3lelesot5lisohur8'", Local "Local file system at /tmp/rclone159634013", Modify Window "876000h0m0s" 2021/07/25 05:17:41 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for checks to finish 2021/07/25 05:17:41 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for transfers to finish 2021/07/25 05:17:44 INFO : hello world2: Copied (new) fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:293: Sleeping for 6s just to make sure --- PASS: TestCopyWithDepth (10.01s) === RUN TestCopyWithFilesFrom run.go:176: Remote "mega root 'rclone-test-palahut3lelesot5lisohur8'", Local "Local file system at /tmp/rclone159634013", Modify Window "876000h0m0s" 2021/07/25 05:17:51 DEBUG : hello world2: Excluded 2021/07/25 05:17:51 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for checks to finish 2021/07/25 05:17:51 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for transfers to finish 2021/07/25 05:17:51 INFO : potato2: Copied (new) fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:293: Sleeping for 6s just to make sure --- PASS: TestCopyWithFilesFrom (9.48s) === RUN TestCopyWithFilesFromAndNoTraverse run.go:176: Remote "mega root 'rclone-test-palahut3lelesot5lisohur8'", Local "Local file system at /tmp/rclone159634013", Modify Window "876000h0m0s" 2021/07/25 05:18:01 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for checks to finish 2021/07/25 05:18:01 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for transfers to finish 2021/07/25 05:18:02 INFO : potato2: Copied (new) fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:293: Sleeping for 6s just to make sure --- PASS: TestCopyWithFilesFromAndNoTraverse (8.21s) === RUN TestCopyEmptyDirectories run.go:176: Remote "mega root 'rclone-test-palahut3lelesot5lisohur8'", Local "Local file system at /tmp/rclone159634013", Modify Window "876000h0m0s" 2021/07/25 05:18:09 DEBUG : sub dir2: Making directory 2021/07/25 05:18:09 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for checks to finish 2021/07/25 05:18:09 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for transfers to finish 2021/07/25 05:18:13 INFO : sub dir/hello world: Copied (new) 2021/07/25 05:18:13 DEBUG : sub dir2: Making directory 2021/07/25 05:18:13 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': copied 1 directories --- PASS: TestCopyEmptyDirectories (6.22s) === RUN TestMoveEmptyDirectories run.go:176: Remote "mega root 'rclone-test-palahut3lelesot5lisohur8'", Local "Local file system at /tmp/rclone159634013", Modify Window "876000h0m0s" 2021/07/25 05:18:15 DEBUG : sub dir2: Making directory 2021/07/25 05:18:15 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for checks to finish 2021/07/25 05:18:15 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for transfers to finish 2021/07/25 05:18:17 INFO : sub dir/hello world: Copied (new) 2021/07/25 05:18:17 INFO : sub dir/hello world: Deleted 2021/07/25 05:18:17 DEBUG : sub dir: Making directory 2021/07/25 05:18:17 DEBUG : sub dir2: Making directory 2021/07/25 05:18:17 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': copied 2 directories --- PASS: TestMoveEmptyDirectories (2.61s) === RUN TestSyncEmptyDirectories run.go:176: Remote "mega root 'rclone-test-palahut3lelesot5lisohur8'", Local "Local file system at /tmp/rclone159634013", Modify Window "876000h0m0s" 2021/07/25 05:18:18 DEBUG : sub dir2: Making directory 2021/07/25 05:18:18 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for checks to finish 2021/07/25 05:18:18 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for transfers to finish 2021/07/25 05:18:22 INFO : sub dir/hello world: Copied (new) 2021/07/25 05:18:22 DEBUG : sub dir2: Making directory 2021/07/25 05:18:23 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': copied 1 directories 2021/07/25 05:18:23 DEBUG : Waiting for deletions to finish --- PASS: TestSyncEmptyDirectories (5.24s) === RUN TestServerSideCopy run.go:176: Remote "mega root 'rclone-test-palahut3lelesot5lisohur8'", Local "Local file system at /tmp/rclone159634013", Modify Window "876000h0m0s" 2021/07/25 05:18:27 DEBUG : Creating backend with remote "TestMega:rclone-test-gehojaf6zafakub6xeqawil9" sync_test.go:281: Server side copy (if possible) mega root 'rclone-test-palahut3lelesot5lisohur8' -> mega root 'rclone-test-gehojaf6zafakub6xeqawil9' 2021/07/25 05:18:27 DEBUG : mega root 'rclone-test-gehojaf6zafakub6xeqawil9': Waiting for checks to finish 2021/07/25 05:18:27 DEBUG : mega root 'rclone-test-gehojaf6zafakub6xeqawil9': Waiting for transfers to finish 2021/07/25 05:18:31 INFO : sub dir/hello world: Copied (new) 2021/07/25 05:18:31 DEBUG : mega root 'rclone-test-gehojaf6zafakub6xeqawil9': Purge remote --- PASS: TestServerSideCopy (8.58s) === RUN TestCopyAfterDelete run.go:176: Remote "mega root 'rclone-test-palahut3lelesot5lisohur8'", Local "Local file system at /tmp/rclone159634013", Modify Window "876000h0m0s" 2021/07/25 05:18:34 ERROR : : error listing: directory not found 2021/07/25 05:18:34 DEBUG : Local file system at /tmp/rclone159634013: Making directory 2021/07/25 05:18:34 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for checks to finish 2021/07/25 05:18:34 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for transfers to finish run.go:121: removing dir "sub dir" failed - try 1/3: directory not empty --- PASS: TestCopyAfterDelete (3.90s) === RUN TestCopyRedownload run.go:176: Remote "mega root 'rclone-test-palahut3lelesot5lisohur8'", Local "Local file system at /tmp/rclone159634013", Modify Window "876000h0m0s" 2021/07/25 05:18:39 DEBUG : Local file system at /tmp/rclone159634013: Waiting for checks to finish 2021/07/25 05:18:39 DEBUG : Local file system at /tmp/rclone159634013: Waiting for transfers to finish 2021/07/25 05:18:40 INFO : sub dir/hello world: Copied (new) --- PASS: TestCopyRedownload (4.41s) === RUN TestSyncBasedOnCheckSum run.go:176: Remote "mega root 'rclone-test-palahut3lelesot5lisohur8'", Local "Local file system at /tmp/rclone159634013", Modify Window "876000h0m0s" 2021/07/25 05:18:40 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for checks to finish 2021/07/25 05:18:40 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for transfers to finish 2021/07/25 05:18:40 INFO : check sum: Copied (new) 2021/07/25 05:18:40 DEBUG : Waiting for deletions to finish 2021/07/25 05:18:40 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for checks to finish 2021/07/25 05:18:40 NOTICE: mega root 'rclone-test-palahut3lelesot5lisohur8': --checksum is in use but the source and destination have no hashes in common; falling back to --size-only 2021/07/25 05:18:40 DEBUG : check sum: Size of src and dst objects identical 2021/07/25 05:18:40 DEBUG : check sum: Unchanged skipping 2021/07/25 05:18:40 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for transfers to finish 2021/07/25 05:18:40 DEBUG : Waiting for deletions to finish 2021/07/25 05:18:40 INFO : There was nothing to transfer fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:293: Sleeping for 6s just to make sure --- PASS: TestSyncBasedOnCheckSum (10.18s) === RUN TestSyncSizeOnly run.go:176: Remote "mega root 'rclone-test-palahut3lelesot5lisohur8'", Local "Local file system at /tmp/rclone159634013", Modify Window "876000h0m0s" 2021/07/25 05:18:50 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for checks to finish 2021/07/25 05:18:50 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for transfers to finish 2021/07/25 05:18:50 INFO : sizeonly: Copied (new) 2021/07/25 05:18:50 DEBUG : Waiting for deletions to finish 2021/07/25 05:18:50 DEBUG : sizeonly: Sizes identical 2021/07/25 05:18:50 DEBUG : sizeonly: Unchanged skipping 2021/07/25 05:18:50 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for checks to finish 2021/07/25 05:18:50 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for transfers to finish 2021/07/25 05:18:50 DEBUG : Waiting for deletions to finish 2021/07/25 05:18:50 INFO : There was nothing to transfer fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:293: Sleeping for 6s just to make sure --- PASS: TestSyncSizeOnly (7.18s) === RUN TestSyncIgnoreSize run.go:176: Remote "mega root 'rclone-test-palahut3lelesot5lisohur8'", Local "Local file system at /tmp/rclone159634013", Modify Window "876000h0m0s" 2021/07/25 05:18:57 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for checks to finish 2021/07/25 05:18:57 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for transfers to finish 2021/07/25 05:18:59 INFO : ignore-size: Copied (new) 2021/07/25 05:18:59 DEBUG : Waiting for deletions to finish 2021/07/25 05:18:59 DEBUG : ignore-size: Sizes identical 2021/07/25 05:18:59 DEBUG : ignore-size: Unchanged skipping 2021/07/25 05:18:59 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for checks to finish 2021/07/25 05:18:59 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for transfers to finish 2021/07/25 05:18:59 DEBUG : Waiting for deletions to finish 2021/07/25 05:18:59 INFO : There was nothing to transfer fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:293: Sleeping for 6s just to make sure --- PASS: TestSyncIgnoreSize (8.91s) === RUN TestSyncIgnoreTimes run.go:176: Remote "mega root 'rclone-test-palahut3lelesot5lisohur8'", Local "Local file system at /tmp/rclone159634013", Modify Window "876000h0m0s" 2021/07/25 05:19:06 DEBUG : existing: Sizes identical 2021/07/25 05:19:06 DEBUG : existing: Unchanged skipping 2021/07/25 05:19:06 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for checks to finish 2021/07/25 05:19:06 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for transfers to finish 2021/07/25 05:19:06 DEBUG : Waiting for deletions to finish 2021/07/25 05:19:06 INFO : There was nothing to transfer 2021/07/25 05:19:06 DEBUG : existing: Transferring unconditionally as --ignore-times is in use 2021/07/25 05:19:06 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for checks to finish 2021/07/25 05:19:06 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for transfers to finish 2021/07/25 05:19:09 INFO : existing: Copied (replaced existing) 2021/07/25 05:19:09 DEBUG : Waiting for deletions to finish --- PASS: TestSyncIgnoreTimes (2.47s) === RUN TestSyncIgnoreExisting run.go:176: Remote "mega root 'rclone-test-palahut3lelesot5lisohur8'", Local "Local file system at /tmp/rclone159634013", Modify Window "876000h0m0s" 2021/07/25 05:19:09 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for checks to finish 2021/07/25 05:19:09 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for transfers to finish 2021/07/25 05:19:09 INFO : existing: Copied (new) 2021/07/25 05:19:09 DEBUG : Waiting for deletions to finish 2021/07/25 05:19:09 DEBUG : existing: Destination exists, skipping 2021/07/25 05:19:09 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for checks to finish 2021/07/25 05:19:09 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for transfers to finish 2021/07/25 05:19:09 DEBUG : Waiting for deletions to finish 2021/07/25 05:19:09 INFO : There was nothing to transfer fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:293: Sleeping for 6s just to make sure --- PASS: TestSyncIgnoreExisting (7.25s) === RUN TestSyncIgnoreErrors run.go:176: Remote "mega root 'rclone-test-palahut3lelesot5lisohur8'", Local "Local file system at /tmp/rclone159634013", Modify Window "876000h0m0s" 2021/07/25 05:19:19 DEBUG : d: Making directory 2021/07/25 05:19:20 DEBUG : c/non empty space: Sizes identical 2021/07/25 05:19:20 DEBUG : c/non empty space: Unchanged skipping 2021/07/25 05:19:20 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for checks to finish 2021/07/25 05:19:20 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for transfers to finish 2021/07/25 05:19:22 INFO : a/potato2: Copied (new) 2021/07/25 05:19:22 DEBUG : Waiting for deletions to finish 2021/07/25 05:19:24 INFO : b/potato: Deleted 2021/07/25 05:19:24 INFO : d: Removing directory 2021/07/25 05:19:24 INFO : b: Removing directory 2021/07/25 05:19:24 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': deleted 2 directories --- PASS: TestSyncIgnoreErrors (9.18s) === RUN TestSyncAfterChangingModtimeOnly run.go:176: Remote "mega root 'rclone-test-palahut3lelesot5lisohur8'", Local "Local file system at /tmp/rclone159634013", Modify Window "876000h0m0s" 2021/07/25 05:19:27 DEBUG : empty space: Sizes identical 2021/07/25 05:19:27 DEBUG : empty space: Unchanged skipping 2021/07/25 05:19:27 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for checks to finish 2021/07/25 05:19:27 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for transfers to finish 2021/07/25 05:19:27 DEBUG : Waiting for deletions to finish 2021/07/25 05:19:27 INFO : There was nothing to transfer 2021/07/25 05:19:27 DEBUG : empty space: Sizes identical 2021/07/25 05:19:27 DEBUG : empty space: Unchanged skipping 2021/07/25 05:19:27 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for checks to finish 2021/07/25 05:19:27 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for transfers to finish 2021/07/25 05:19:27 DEBUG : Waiting for deletions to finish 2021/07/25 05:19:27 INFO : There was nothing to transfer fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:293: Sleeping for 6s just to make sure --- PASS: TestSyncAfterChangingModtimeOnly (9.01s) === RUN TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime run.go:176: Remote "mega root 'rclone-test-palahut3lelesot5lisohur8'", Local "Local file system at /tmp/rclone159634013", Modify Window "876000h0m0s" sync_test.go:591: Can't check this if no hashes supported --- PASS: TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime (0.00s) === RUN TestSyncDoesntUpdateModtime run.go:176: Remote "mega root 'rclone-test-palahut3lelesot5lisohur8'", Local "Local file system at /tmp/rclone159634013", Modify Window "876000h0m0s" sync_test.go:616: Can't run this test on fs which doesn't support mod time --- SKIP: TestSyncDoesntUpdateModtime (0.00s) === RUN TestSyncAfterAddingAFile run.go:176: Remote "mega root 'rclone-test-palahut3lelesot5lisohur8'", Local "Local file system at /tmp/rclone159634013", Modify Window "876000h0m0s" 2021/07/25 05:19:34 DEBUG : empty space: Sizes identical 2021/07/25 05:19:34 DEBUG : empty space: Unchanged skipping 2021/07/25 05:19:34 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for checks to finish 2021/07/25 05:19:34 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for transfers to finish 2021/07/25 05:19:37 INFO : potato: Copied (new) 2021/07/25 05:19:37 DEBUG : Waiting for deletions to finish --- PASS: TestSyncAfterAddingAFile (8.10s) === RUN TestSyncAfterChangingFilesSizeOnly run.go:176: Remote "mega root 'rclone-test-palahut3lelesot5lisohur8'", Local "Local file system at /tmp/rclone159634013", Modify Window "876000h0m0s" 2021/07/25 05:19:42 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for checks to finish 2021/07/25 05:19:42 DEBUG : potato: Sizes differ (src 21 vs dst 60) 2021/07/25 05:19:42 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for transfers to finish 2021/07/25 05:19:45 INFO : potato: Copied (replaced existing) 2021/07/25 05:19:45 DEBUG : Waiting for deletions to finish --- PASS: TestSyncAfterChangingFilesSizeOnly (2.74s) === RUN TestSyncAfterChangingContentsOnly run.go:176: Remote "mega root 'rclone-test-palahut3lelesot5lisohur8'", Local "Local file system at /tmp/rclone159634013", Modify Window "876000h0m0s" sync_test.go:677: ModTimeNotSupported so forcing file to be a different size 2021/07/25 05:19:47 DEBUG : potato: Sizes differ (src 21 vs dst 36) 2021/07/25 05:19:47 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for checks to finish 2021/07/25 05:19:47 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for transfers to finish 2021/07/25 05:19:50 INFO : potato: Copied (replaced existing) 2021/07/25 05:19:50 DEBUG : Waiting for deletions to finish --- PASS: TestSyncAfterChangingContentsOnly (4.62s) === RUN TestSyncAfterRemovingAFileAndAddingAFileDryRun run.go:176: Remote "mega root 'rclone-test-palahut3lelesot5lisohur8'", Local "Local file system at /tmp/rclone159634013", Modify Window "876000h0m0s" 2021/07/25 05:19:52 NOTICE: potato2: Skipped copy as --dry-run is set (size 60) 2021/07/25 05:19:52 DEBUG : empty space: Sizes identical 2021/07/25 05:19:52 DEBUG : empty space: Unchanged skipping 2021/07/25 05:19:52 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for checks to finish 2021/07/25 05:19:52 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for transfers to finish 2021/07/25 05:19:52 DEBUG : Waiting for deletions to finish 2021/07/25 05:19:52 NOTICE: potato: Skipped delete as --dry-run is set (size 21) fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:293: Sleeping for 6s just to make sure --- PASS: TestSyncAfterRemovingAFileAndAddingAFileDryRun (9.49s) === RUN TestSyncAfterRemovingAFileAndAddingAFile run.go:176: Remote "mega root 'rclone-test-palahut3lelesot5lisohur8'", Local "Local file system at /tmp/rclone159634013", Modify Window "876000h0m0s" 2021/07/25 05:20:02 DEBUG : empty space: Sizes identical 2021/07/25 05:20:02 DEBUG : empty space: Unchanged skipping 2021/07/25 05:20:02 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for checks to finish 2021/07/25 05:20:02 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for transfers to finish 2021/07/25 05:20:02 INFO : potato2: Copied (new) 2021/07/25 05:20:02 DEBUG : Waiting for deletions to finish 2021/07/25 05:20:04 INFO : potato: Deleted --- PASS: TestSyncAfterRemovingAFileAndAddingAFile (4.94s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDir run.go:176: Remote "mega root 'rclone-test-palahut3lelesot5lisohur8'", Local "Local file system at /tmp/rclone159634013", Modify Window "876000h0m0s" 2021/07/25 05:20:09 DEBUG : d: Making directory 2021/07/25 05:20:09 DEBUG : d/e: Making directory 2021/07/25 05:20:09 DEBUG : c/non empty space: Sizes identical 2021/07/25 05:20:09 DEBUG : c/non empty space: Unchanged skipping 2021/07/25 05:20:09 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for checks to finish 2021/07/25 05:20:09 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for transfers to finish 2021/07/25 05:20:09 INFO : a/potato2: Copied (new) 2021/07/25 05:20:09 DEBUG : Waiting for deletions to finish 2021/07/25 05:20:09 INFO : b/potato: Deleted 2021/07/25 05:20:09 INFO : d/e: Removing directory 2021/07/25 05:20:09 INFO : d: Removing directory 2021/07/25 05:20:09 INFO : b: Removing directory 2021/07/25 05:20:10 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': deleted 3 directories --- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDir (7.80s) === RUN TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors run.go:176: Remote "mega root 'rclone-test-palahut3lelesot5lisohur8'", Local "Local file system at /tmp/rclone159634013", Modify Window "876000h0m0s" 2021/07/25 05:20:13 DEBUG : d: Making directory 2021/07/25 05:20:13 DEBUG : c/non empty space: Sizes identical 2021/07/25 05:20:13 DEBUG : c/non empty space: Unchanged skipping 2021/07/25 05:20:13 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for checks to finish 2021/07/25 05:20:13 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for transfers to finish 2021/07/25 05:20:16 INFO : a/potato2: Copied (new) 2021/07/25 05:20:16 ERROR : mega root 'rclone-test-palahut3lelesot5lisohur8': not deleting files as there were IO errors 2021/07/25 05:20:16 ERROR : mega root 'rclone-test-palahut3lelesot5lisohur8': not deleting directories as there were IO errors --- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors (9.07s) === RUN TestSyncDeleteAfter --- PASS: TestSyncDeleteAfter (0.00s) === RUN TestSyncDeleteDuring run.go:176: Remote "mega root 'rclone-test-palahut3lelesot5lisohur8'", Local "Local file system at /tmp/rclone159634013", Modify Window "876000h0m0s" 2021/07/25 05:20:21 DEBUG : Waiting for deletions to finish 2021/07/25 05:20:21 DEBUG : empty space: Sizes identical 2021/07/25 05:20:21 DEBUG : empty space: Unchanged skipping 2021/07/25 05:20:21 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for checks to finish 2021/07/25 05:20:21 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for transfers to finish 2021/07/25 05:20:22 INFO : potato: Deleted 2021/07/25 05:20:27 INFO : potato2: Copied (new) fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:293: Sleeping for 6s just to make sure --- PASS: TestSyncDeleteDuring (15.19s) === RUN TestSyncDeleteBefore run.go:176: Remote "mega root 'rclone-test-palahut3lelesot5lisohur8'", Local "Local file system at /tmp/rclone159634013", Modify Window "876000h0m0s" 2021/07/25 05:20:37 DEBUG : Waiting for deletions to finish 2021/07/25 05:20:37 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for checks to finish 2021/07/25 05:20:37 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for transfers to finish 2021/07/25 05:20:40 INFO : potato: Deleted 2021/07/25 05:20:40 DEBUG : empty space: Sizes identical 2021/07/25 05:20:40 DEBUG : empty space: Unchanged skipping 2021/07/25 05:20:40 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for checks to finish 2021/07/25 05:20:40 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for transfers to finish 2021/07/25 05:20:40 INFO : potato2: Copied (new) fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:293: Sleeping for 6s just to make sure --- PASS: TestSyncDeleteBefore (11.11s) === RUN TestCopyDeleteBefore run.go:176: Remote "mega root 'rclone-test-palahut3lelesot5lisohur8'", Local "Local file system at /tmp/rclone159634013", Modify Window "876000h0m0s" 2021/07/25 05:20:53 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for checks to finish 2021/07/25 05:20:53 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for transfers to finish 2021/07/25 05:20:53 INFO : potato2: Copied (new) fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:293: Sleeping for 6s just to make sure --- PASS: TestCopyDeleteBefore (17.26s) === RUN TestSyncWithExclude run.go:176: Remote "mega root 'rclone-test-palahut3lelesot5lisohur8'", Local "Local file system at /tmp/rclone159634013", Modify Window "876000h0m0s" 2021/07/25 05:21:05 DEBUG : enormous: Excluded 2021/07/25 05:21:05 DEBUG : potato2: Excluded 2021/07/25 05:21:05 DEBUG : potato2: Excluded 2021/07/25 05:21:05 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for checks to finish 2021/07/25 05:21:05 DEBUG : empty space: Sizes identical 2021/07/25 05:21:05 DEBUG : empty space: Unchanged skipping 2021/07/25 05:21:05 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for transfers to finish 2021/07/25 05:21:05 DEBUG : Waiting for deletions to finish 2021/07/25 05:21:05 INFO : There was nothing to transfer 2021/07/25 05:21:05 DEBUG : enormous: Excluded 2021/07/25 05:21:05 DEBUG : potato2: Excluded 2021/07/25 05:21:05 DEBUG : potato2: Excluded 2021/07/25 05:21:05 DEBUG : empty space: Sizes identical 2021/07/25 05:21:05 DEBUG : empty space: Unchanged skipping 2021/07/25 05:21:05 DEBUG : Local file system at /tmp/rclone159634013: Waiting for checks to finish 2021/07/25 05:21:05 DEBUG : Local file system at /tmp/rclone159634013: Waiting for transfers to finish 2021/07/25 05:21:05 DEBUG : Waiting for deletions to finish 2021/07/25 05:21:05 INFO : There was nothing to transfer fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:293: Sleeping for 6s just to make sure --- PASS: TestSyncWithExclude (7.59s) === RUN TestSyncWithExcludeAndDeleteExcluded run.go:176: Remote "mega root 'rclone-test-palahut3lelesot5lisohur8'", Local "Local file system at /tmp/rclone159634013", Modify Window "876000h0m0s" 2021/07/25 05:21:14 DEBUG : enormous: Excluded 2021/07/25 05:21:14 DEBUG : potato2: Excluded 2021/07/25 05:21:14 DEBUG : empty space: Sizes identical 2021/07/25 05:21:14 DEBUG : empty space: Unchanged skipping 2021/07/25 05:21:14 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for checks to finish 2021/07/25 05:21:14 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for transfers to finish 2021/07/25 05:21:14 DEBUG : Waiting for deletions to finish 2021/07/25 05:21:16 INFO : enormous: Deleted 2021/07/25 05:21:17 INFO : potato2: Deleted 2021/07/25 05:21:17 INFO : There was nothing to transfer fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:293: Sleeping for 6s just to make sure 2021/07/25 05:21:24 DEBUG : empty space: Sizes identical 2021/07/25 05:21:24 DEBUG : empty space: Unchanged skipping 2021/07/25 05:21:24 DEBUG : Local file system at /tmp/rclone159634013: Waiting for checks to finish 2021/07/25 05:21:24 DEBUG : Local file system at /tmp/rclone159634013: Waiting for transfers to finish 2021/07/25 05:21:24 DEBUG : Waiting for deletions to finish 2021/07/25 05:21:24 INFO : enormous: Deleted 2021/07/25 05:21:24 INFO : potato2: Deleted 2021/07/25 05:21:24 INFO : There was nothing to transfer --- PASS: TestSyncWithExcludeAndDeleteExcluded (11.67s) === RUN TestSyncWithUpdateOlder run.go:176: Remote "mega root 'rclone-test-palahut3lelesot5lisohur8'", Local "Local file system at /tmp/rclone159634013", Modify Window "876000h0m0s" sync_test.go:998: Can't run this test on fs which doesn't support mod time --- SKIP: TestSyncWithUpdateOlder (0.00s) === RUN TestSyncWithMaxDuration sync_test.go:1039: Skipping test on non local remote --- SKIP: TestSyncWithMaxDuration (0.00s) === RUN TestSyncWithTrackRenames run.go:176: Remote "mega root 'rclone-test-palahut3lelesot5lisohur8'", Local "Local file system at /tmp/rclone159634013", Modify Window "876000h0m0s" sync_test.go:1088: Can track renames: false 2021/07/25 05:21:24 ERROR : mega root 'rclone-test-palahut3lelesot5lisohur8': Ignoring --track-renames as the source and destination do not have a common hash 2021/07/25 05:21:24 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for checks to finish 2021/07/25 05:21:24 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for transfers to finish 2021/07/25 05:21:24 INFO : potato: Copied (new) 2021/07/25 05:21:24 INFO : yam: Copied (new) 2021/07/25 05:21:24 DEBUG : Waiting for deletions to finish 2021/07/25 05:21:24 ERROR : mega root 'rclone-test-palahut3lelesot5lisohur8': Ignoring --track-renames as the source and destination do not have a common hash 2021/07/25 05:21:24 DEBUG : potato: Sizes identical 2021/07/25 05:21:24 DEBUG : potato: Unchanged skipping 2021/07/25 05:21:24 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for checks to finish 2021/07/25 05:21:24 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for transfers to finish 2021/07/25 05:21:26 INFO : yaml: Copied (new) 2021/07/25 05:21:26 DEBUG : Waiting for deletions to finish 2021/07/25 05:21:27 INFO : yam: Deleted --- PASS: TestSyncWithTrackRenames (5.20s) === RUN TestParseRenamesStrategyModtime --- PASS: TestParseRenamesStrategyModtime (0.00s) === RUN TestRenamesStrategyModtime --- PASS: TestRenamesStrategyModtime (0.00s) === RUN TestSyncWithTrackRenamesStrategyModtime run.go:176: Remote "mega root 'rclone-test-palahut3lelesot5lisohur8'", Local "Local file system at /tmp/rclone159634013", Modify Window "876000h0m0s" sync_test.go:1157: Can track renames: false 2021/07/25 05:21:29 ERROR : mega root 'rclone-test-palahut3lelesot5lisohur8': Ignoring --track-renames as either the source or destination do not support modtime 2021/07/25 05:21:29 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for checks to finish 2021/07/25 05:21:29 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for transfers to finish 2021/07/25 05:21:29 INFO : potato: Copied (new) 2021/07/25 05:21:29 INFO : yam: Copied (new) 2021/07/25 05:21:29 DEBUG : Waiting for deletions to finish 2021/07/25 05:21:29 ERROR : mega root 'rclone-test-palahut3lelesot5lisohur8': Ignoring --track-renames as either the source or destination do not support modtime 2021/07/25 05:21:29 DEBUG : potato: Sizes identical 2021/07/25 05:21:29 DEBUG : potato: Unchanged skipping 2021/07/25 05:21:29 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for checks to finish 2021/07/25 05:21:29 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for transfers to finish 2021/07/25 05:21:31 INFO : yaml: Copied (new) 2021/07/25 05:21:31 DEBUG : Waiting for deletions to finish 2021/07/25 05:21:33 INFO : yam: Deleted --- PASS: TestSyncWithTrackRenamesStrategyModtime (4.78s) === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:176: Remote "mega root 'rclone-test-palahut3lelesot5lisohur8'", Local "Local file system at /tmp/rclone159634013", Modify Window "876000h0m0s" sync_test.go:1193: Can track renames: false 2021/07/25 05:21:34 INFO : mega root 'rclone-test-palahut3lelesot5lisohur8': Making map for --track-renames 2021/07/25 05:21:34 INFO : mega root 'rclone-test-palahut3lelesot5lisohur8': Finished making map for --track-renames 2021/07/25 05:21:34 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for checks to finish 2021/07/25 05:21:34 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for renames to finish 2021/07/25 05:21:34 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for transfers to finish 2021/07/25 05:21:34 INFO : potato: Copied (new) 2021/07/25 05:21:34 INFO : sub/yam: Copied (new) 2021/07/25 05:21:34 DEBUG : Waiting for deletions to finish 2021/07/25 05:21:34 INFO : mega root 'rclone-test-palahut3lelesot5lisohur8': Making map for --track-renames 2021/07/25 05:21:34 INFO : mega root 'rclone-test-palahut3lelesot5lisohur8': Finished making map for --track-renames 2021/07/25 05:21:34 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for checks to finish 2021/07/25 05:21:34 DEBUG : potato: Sizes identical 2021/07/25 05:21:34 DEBUG : potato: Unchanged skipping 2021/07/25 05:21:34 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for renames to finish 2021/07/25 05:21:34 INFO : sub/yam: Moved (server-side) to: yam 2021/07/25 05:21:34 INFO : yam: Renamed from "sub/yam" 2021/07/25 05:21:34 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for transfers to finish 2021/07/25 05:21:34 DEBUG : Waiting for deletions to finish 2021/07/25 05:21:34 INFO : There was nothing to transfer fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 fstest.go:351 sync_test.go:1210 Error: Should be true Test: TestSyncWithTrackRenamesStrategyLeaf Messages: listing wrong, want potato (14), yam (11) got potato (14), yam (11), yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 fstest.go:351 sync_test.go:1210 Error: Should be true Test: TestSyncWithTrackRenamesStrategyLeaf Messages: Unexpected file "yam" fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 run.go:169 run.go:339 sync_test.go:1217 Error: Should be true Test: TestSyncWithTrackRenamesStrategyLeaf Messages: listing wrong, want got yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 run.go:169 run.go:339 sync_test.go:1217 Error: Should be true Test: TestSyncWithTrackRenamesStrategyLeaf Messages: Unexpected file "yam" --- FAIL: TestSyncWithTrackRenamesStrategyLeaf (15.23s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:176: Remote "mega root 'rclone-test-palahut3lelesot5lisohur8'", Local "Local file system at /tmp/rclone159634013", Modify Window "876000h0m0s" 2021/07/25 05:21:49 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for checks to finish 2021/07/25 05:21:49 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for transfers to finish 2021/07/25 05:21:59 ERROR : sub dir/hello world: Failed to copy: mkdir create node failed: Try again 2021/07/25 05:21:59 ERROR : sub dir/hello world: Not deleting source as copy failed: mkdir create node failed: Try again 2021/07/25 05:22:10 ERROR : nested/sub dir/file: Failed to copy: mkdir create node failed: Try again 2021/07/25 05:22:10 ERROR : nested/sub dir/file: Not deleting source as copy failed: mkdir create node failed: Try again 2021/07/25 05:22:10 ERROR : Local file system at /tmp/rclone159634013: not deleting directories as there were IO errors sync_test.go:1308: Error Trace: sync_test.go:1308 Error: Received unexpected error: not deleting directories as there were IO errors github.com/rclone/rclone/fs.init /home/rclone/go/src/github.com/rclone/rclone/fs/fs.go:42 runtime.doInit /usr/local/go/src/runtime/proc.go:5625 runtime.doInit /usr/local/go/src/runtime/proc.go:5620 runtime.doInit /usr/local/go/src/runtime/proc.go:5620 runtime.main /usr/local/go/src/runtime/proc.go:191 runtime.goexit /usr/local/go/src/runtime/asm_amd64.s:1374 Test: TestMoveWithDeleteEmptySrcDirs run.go:121: removing file "yam" failed - try 1/3: Remove object failed: Try again run.go:121: removing file "yam" failed - try 2/3: Remove object failed: Try again run.go:121: removing file "yam" failed - try 3/3: Remove object failed: Try again run.go:124: removing file "yam" failed: Remove object failed: Try again fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 run.go:169 run.go:339 panic.go:617 testing.go:732 sync_test.go:1308 Error: Should be true Test: TestMoveWithDeleteEmptySrcDirs Messages: listing wrong, want got yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 run.go:169 run.go:339 panic.go:617 testing.go:732 sync_test.go:1308 Error: Should be true Test: TestMoveWithDeleteEmptySrcDirs Messages: Unexpected file "yam" --- FAIL: TestMoveWithDeleteEmptySrcDirs (62.27s) === RUN TestMoveWithoutDeleteEmptySrcDirs run.go:176: Remote "mega root 'rclone-test-palahut3lelesot5lisohur8'", Local "Local file system at /tmp/rclone159634013", Modify Window "876000h0m0s" 2021/07/25 05:22:51 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for checks to finish 2021/07/25 05:22:51 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for transfers to finish 2021/07/25 05:23:02 ERROR : sub dir/hello world: Failed to copy: mkdir create node failed: Try again 2021/07/25 05:23:02 ERROR : sub dir/hello world: Not deleting source as copy failed: mkdir create node failed: Try again 2021/07/25 05:23:12 ERROR : nested/sub dir/file: Failed to copy: mkdir create node failed: Try again 2021/07/25 05:23:12 ERROR : nested/sub dir/file: Not deleting source as copy failed: mkdir create node failed: Try again sync_test.go:1329: Error Trace: sync_test.go:1329 Error: Received unexpected error: mkdir create node failed: Try again Test: TestMoveWithoutDeleteEmptySrcDirs run.go:121: removing file "yam" failed - try 1/3: Remove object failed: Try again run.go:121: removing file "yam" failed - try 2/3: Remove object failed: Try again run.go:121: removing file "yam" failed - try 3/3: Remove object failed: Try again run.go:124: removing file "yam" failed: Remove object failed: Try again fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 run.go:169 run.go:339 panic.go:617 testing.go:732 sync_test.go:1329 Error: Should be true Test: TestMoveWithoutDeleteEmptySrcDirs Messages: listing wrong, want got yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 run.go:169 run.go:339 panic.go:617 testing.go:732 sync_test.go:1329 Error: Should be true Test: TestMoveWithoutDeleteEmptySrcDirs Messages: Unexpected file "yam" --- FAIL: TestMoveWithoutDeleteEmptySrcDirs (62.29s) === RUN TestServerSideMove run.go:176: Remote "mega root 'rclone-test-palahut3lelesot5lisohur8'", Local "Local file system at /tmp/rclone159634013", Modify Window "876000h0m0s" 2021/07/25 05:23:54 DEBUG : Creating backend with remote "TestMega:rclone-test-yexogey4sufufeq4gigazik4" 2021/07/25 05:23:54 DEBUG : Config file has changed externaly - reloading run.go:282: Failed to put "potato2" to "mega root 'rclone-test-palahut3lelesot5lisohur8'": upload file failed to create session: Try again 2021/07/25 05:24:04 DEBUG : mega root 'rclone-test-yexogey4sufufeq4gigazik4': Purge remote 2021/07/25 05:24:04 purge failed: directory not found run.go:121: removing file "yam" failed - try 1/3: Remove object failed: Try again run.go:121: removing file "yam" failed - try 2/3: Remove object failed: Try again run.go:121: removing file "yam" failed - try 3/3: Remove object failed: Try again run.go:124: removing file "yam" failed: Remove object failed: Try again fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 run.go:169 run.go:339 panic.go:617 testing.go:732 testing.go:806 run.go:282 run.go:289 run.go:300 sync_test.go:1234 sync_test.go:1350 Error: Should be true Test: TestServerSideMove Messages: listing wrong, want got yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 run.go:169 run.go:339 panic.go:617 testing.go:732 testing.go:806 run.go:282 run.go:289 run.go:300 sync_test.go:1234 sync_test.go:1350 Error: Should be true Test: TestServerSideMove Messages: Unexpected file "yam" --- FAIL: TestServerSideMove (51.80s) === RUN TestServerSideMoveWithFilter run.go:176: Remote "mega root 'rclone-test-palahut3lelesot5lisohur8'", Local "Local file system at /tmp/rclone159634013", Modify Window "876000h0m0s" 2021/07/25 05:24:45 DEBUG : Creating backend with remote "TestMega:rclone-test-zeyosaj1xinobon1rihufat2" run.go:282: Failed to put "potato2" to "mega root 'rclone-test-palahut3lelesot5lisohur8'": upload file failed to create session: Try again 2021/07/25 05:24:56 DEBUG : mega root 'rclone-test-zeyosaj1xinobon1rihufat2': Purge remote 2021/07/25 05:24:56 purge failed: directory not found run.go:121: removing file "yam" failed - try 1/3: Remove object failed: Try again run.go:121: removing file "yam" failed - try 2/3: Remove object failed: Try again fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 run.go:169 run.go:339 panic.go:617 testing.go:732 testing.go:806 run.go:282 run.go:289 run.go:300 sync_test.go:1234 sync_test.go:1364 Error: Should be true Test: TestServerSideMoveWithFilter Messages: listing wrong, want got yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 run.go:169 run.go:339 panic.go:617 testing.go:732 testing.go:806 run.go:282 run.go:289 run.go:300 sync_test.go:1234 sync_test.go:1364 Error: Should be true Test: TestServerSideMoveWithFilter Messages: Unexpected file "yam" --- FAIL: TestServerSideMoveWithFilter (46.15s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:176: Remote "mega root 'rclone-test-palahut3lelesot5lisohur8'", Local "Local file system at /tmp/rclone159634013", Modify Window "876000h0m0s" 2021/07/25 05:25:31 DEBUG : Creating backend with remote "TestMega:rclone-test-cicoqey9buhomad0hubokun3" 2021/07/25 05:25:35 DEBUG : tomatoDir: Making directory fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 fstest.go:351 sync_test.go:1243 sync_test.go:1372 Error: Should be true Test: TestServerSideMoveDeleteEmptySourceDirs Messages: listing wrong, want empty space (1), potato2 (60), potato3 (68) got empty space (1), potato2 (60), potato3 (68), yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 fstest.go:351 sync_test.go:1243 sync_test.go:1372 Error: Should be true Test: TestServerSideMoveDeleteEmptySourceDirs Messages: Unexpected file "yam" sync_test.go:1245: Server side move (if possible) mega root 'rclone-test-palahut3lelesot5lisohur8' -> mega root 'rclone-test-cicoqey9buhomad0hubokun3' 2021/07/25 05:25:45 DEBUG : mega root 'rclone-test-cicoqey9buhomad0hubokun3': Using server-side directory move 2021/07/25 05:25:45 INFO : mega root 'rclone-test-cicoqey9buhomad0hubokun3': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2021/07/25 05:25:45 DEBUG : empty space: Sizes identical 2021/07/25 05:25:45 DEBUG : empty space: Unchanged skipping 2021/07/25 05:25:46 INFO : potato2: Moved (server-side) 2021/07/25 05:25:46 INFO : yam: Moved (server-side) 2021/07/25 05:25:47 INFO : empty space: Deleted 2021/07/25 05:25:47 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2021/07/25 05:25:47 DEBUG : mega root 'rclone-test-cicoqey9buhomad0hubokun3': Waiting for checks to finish 2021/07/25 05:25:47 DEBUG : mega root 'rclone-test-cicoqey9buhomad0hubokun3': Waiting for transfers to finish 2021/07/25 05:25:48 INFO : potato3: Deleted 2021/07/25 05:25:48 INFO : potato3: Moved (server-side) 2021/07/25 05:25:48 INFO : tomatoDir: Removing directory 2021/07/25 05:25:48 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': deleted 1 directories 2021/07/25 05:25:48 INFO : There was nothing to transfer fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 fstest.go:351 sync_test.go:1260 sync_test.go:1372 Error: Should be true Test: TestServerSideMoveDeleteEmptySourceDirs Messages: listing wrong, want got yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 fstest.go:351 sync_test.go:1260 sync_test.go:1372 Error: Should be true Test: TestServerSideMoveDeleteEmptySourceDirs Messages: Unexpected file "yam" fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 sync_test.go:1264 sync_test.go:1372 Error: Should be true Test: TestServerSideMoveDeleteEmptySourceDirs Messages: listing wrong, want got yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 sync_test.go:1264 sync_test.go:1372 Error: Should be true Test: TestServerSideMoveDeleteEmptySourceDirs Messages: Unexpected file "yam" fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 fstest.go:351 sync_test.go:1267 sync_test.go:1372 Error: Should be true Test: TestServerSideMoveDeleteEmptySourceDirs Messages: listing wrong, want empty space (1), potato2 (60), potato3 (68) got empty space (1), potato2 (60), potato3 (68), yam (11), yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 fstest.go:351 sync_test.go:1267 sync_test.go:1372 Error: Should be true Test: TestServerSideMoveDeleteEmptySourceDirs Messages: Unexpected file "yam" fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 fstest.go:351 sync_test.go:1267 sync_test.go:1372 Error: Should be true Test: TestServerSideMoveDeleteEmptySourceDirs Messages: Unexpected file "yam" 2021/07/25 05:26:09 DEBUG : Creating backend with remote "TestMega:rclone-test-zonudur4cevikuk6xuguyij5" 2021/07/25 05:26:09 DEBUG : tomatoDir: Making directory 2021/07/25 05:26:09 DEBUG : mega root 'rclone-test-zonudur4cevikuk6xuguyij5': Using server-side directory move 2021/07/25 05:26:09 INFO : mega root 'rclone-test-zonudur4cevikuk6xuguyij5': Server side directory move succeeded fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 fstest.go:351 sync_test.go:1288 sync_test.go:1372 Error: Should be true Test: TestServerSideMoveDeleteEmptySourceDirs Messages: listing wrong, want empty space (1), potato2 (60), potato3 (68) got empty space (1), potato2 (60), potato3 (68), yam (11), yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 fstest.go:351 sync_test.go:1288 sync_test.go:1372 Error: Should be true Test: TestServerSideMoveDeleteEmptySourceDirs Messages: Unexpected file "yam" fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 fstest.go:351 sync_test.go:1288 sync_test.go:1372 Error: Should be true Test: TestServerSideMoveDeleteEmptySourceDirs Messages: Unexpected file "yam" 2021/07/25 05:26:16 ERROR : : error listing: directory not found 2021/07/25 05:26:16 ERROR : : error listing: directory not found 2021/07/25 05:26:16 DEBUG : mega root 'rclone-test-zonudur4cevikuk6xuguyij5': Purge remote 2021/07/25 05:26:16 DEBUG : mega root 'rclone-test-cicoqey9buhomad0hubokun3': Purge remote 2021/07/25 05:26:16 purge failed: directory not found fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 run.go:169 run.go:339 sync_test.go:1373 Error: Should be true Test: TestServerSideMoveDeleteEmptySourceDirs Messages: listing wrong, want got yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 run.go:169 run.go:339 sync_test.go:1373 Error: Should be true Test: TestServerSideMoveDeleteEmptySourceDirs Messages: Unexpected file "yam" --- FAIL: TestServerSideMoveDeleteEmptySourceDirs (52.03s) === RUN TestServerSideMoveOverlap run.go:176: Remote "mega root 'rclone-test-palahut3lelesot5lisohur8'", Local "Local file system at /tmp/rclone159634013", Modify Window "876000h0m0s" sync_test.go:1382: Skipping test as remote supports DirMove fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 run.go:169 run.go:339 panic.go:617 testing.go:832 testing.go:812 sync_test.go:1382 Error: Should be true Test: TestServerSideMoveOverlap Messages: listing wrong, want got yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 run.go:169 run.go:339 panic.go:617 testing.go:832 testing.go:812 sync_test.go:1382 Error: Should be true Test: TestServerSideMoveOverlap Messages: Unexpected file "yam" --- FAIL: TestServerSideMoveOverlap (7.03s) === RUN TestSyncOverlap run.go:176: Remote "mega root 'rclone-test-palahut3lelesot5lisohur8'", Local "Local file system at /tmp/rclone159634013", Modify Window "876000h0m0s" 2021/07/25 05:26:31 DEBUG : Creating backend with remote "TestMega:rclone-test-palahut3lelesot5lisohur8/rclone-sync-test" fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 run.go:169 run.go:339 sync_test.go:1426 Error: Should be true Test: TestSyncOverlap Messages: listing wrong, want got yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 run.go:169 run.go:339 sync_test.go:1426 Error: Should be true Test: TestSyncOverlap Messages: Unexpected file "yam" --- FAIL: TestSyncOverlap (7.07s) === RUN TestSyncCompareDest run.go:176: Remote "mega root 'rclone-test-palahut3lelesot5lisohur8'", Local "Local file system at /tmp/rclone159634013", Modify Window "876000h0m0s" 2021/07/25 05:26:38 DEBUG : Creating backend with remote "TestMega:rclone-test-palahut3lelesot5lisohur8/dst" 2021/07/25 05:26:38 DEBUG : Creating backend with remote "TestMega:rclone-test-palahut3lelesot5lisohur8/CompareDest" 2021/07/25 05:26:38 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8/dst': Waiting for checks to finish 2021/07/25 05:26:38 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8/dst': Waiting for transfers to finish 2021/07/25 05:26:38 INFO : one: Copied (new) 2021/07/25 05:26:38 DEBUG : Waiting for deletions to finish fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 fstest.go:351 sync_test.go:1451 Error: Should be true Test: TestSyncCompareDest Messages: listing wrong, want dst/one (3) got dst/one (3), yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 fstest.go:351 sync_test.go:1451 Error: Should be true Test: TestSyncCompareDest Messages: Unexpected file "yam" fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 fstest.go:351 sync_test.go:1455 Error: Should be true Test: TestSyncCompareDest Messages: listing wrong, want dst/one (3) got dst/one (3), yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 fstest.go:351 sync_test.go:1455 Error: Should be true Test: TestSyncCompareDest Messages: Unexpected file "yam" 2021/07/25 05:26:52 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8/dst': Waiting for checks to finish 2021/07/25 05:26:52 DEBUG : one: Sizes differ (src 5 vs dst 3) 2021/07/25 05:26:52 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8/dst': Waiting for transfers to finish 2021/07/25 05:26:54 INFO : one: Copied (replaced existing) 2021/07/25 05:26:54 DEBUG : Waiting for deletions to finish fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 fstest.go:351 sync_test.go:1465 Error: Should be true Test: TestSyncCompareDest Messages: listing wrong, want dst/one (5) got dst/one (5), yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 fstest.go:351 sync_test.go:1465 Error: Should be true Test: TestSyncCompareDest Messages: Unexpected file "yam" fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 fstest.go:351 sync_test.go:1471 Error: Should be true Test: TestSyncCompareDest Messages: listing wrong, want CompareDest/one (5), dst/one (3) got CompareDest/one (5), dst/one (3), yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 fstest.go:351 sync_test.go:1471 Error: Should be true Test: TestSyncCompareDest Messages: Unexpected file "yam" 2021/07/25 05:27:09 DEBUG : one: Sizes identical 2021/07/25 05:27:09 DEBUG : one: Destination found in --compare-dest, skipping 2021/07/25 05:27:09 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8/dst': Waiting for checks to finish 2021/07/25 05:27:09 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8/dst': Waiting for transfers to finish 2021/07/25 05:27:09 DEBUG : Waiting for deletions to finish 2021/07/25 05:27:09 INFO : There was nothing to transfer fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 fstest.go:351 sync_test.go:1478 Error: Should be true Test: TestSyncCompareDest Messages: listing wrong, want CompareDest/one (5), dst/one (3) got CompareDest/one (5), dst/one (3), yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 fstest.go:351 sync_test.go:1478 Error: Should be true Test: TestSyncCompareDest Messages: Unexpected file "yam" fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 fstest.go:351 sync_test.go:1483 Error: Should be true Test: TestSyncCompareDest Messages: listing wrong, want CompareDest/one (5), CompareDest/two (3), dst/one (3) got CompareDest/one (5), CompareDest/two (3), dst/one (3), yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 fstest.go:351 sync_test.go:1483 Error: Should be true Test: TestSyncCompareDest Messages: Unexpected file "yam" 2021/07/25 05:27:23 DEBUG : two: Sizes identical 2021/07/25 05:27:23 DEBUG : two: Destination found in --compare-dest, skipping 2021/07/25 05:27:23 DEBUG : one: Sizes identical 2021/07/25 05:27:23 DEBUG : one: Destination found in --compare-dest, skipping 2021/07/25 05:27:23 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8/dst': Waiting for checks to finish 2021/07/25 05:27:23 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8/dst': Waiting for transfers to finish 2021/07/25 05:27:23 DEBUG : Waiting for deletions to finish 2021/07/25 05:27:23 INFO : There was nothing to transfer fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 fstest.go:351 sync_test.go:1490 Error: Should be true Test: TestSyncCompareDest Messages: listing wrong, want CompareDest/one (5), CompareDest/two (3), dst/one (3) got CompareDest/one (5), CompareDest/two (3), dst/one (3), yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 fstest.go:351 sync_test.go:1490 Error: Should be true Test: TestSyncCompareDest Messages: Unexpected file "yam" 2021/07/25 05:27:30 DEBUG : two: Sizes identical 2021/07/25 05:27:30 DEBUG : two: Destination found in --compare-dest, skipping 2021/07/25 05:27:30 DEBUG : one: Sizes identical 2021/07/25 05:27:30 DEBUG : one: Destination found in --compare-dest, skipping 2021/07/25 05:27:30 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8/dst': Waiting for checks to finish 2021/07/25 05:27:30 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8/dst': Waiting for transfers to finish 2021/07/25 05:27:30 DEBUG : Waiting for deletions to finish 2021/07/25 05:27:30 INFO : There was nothing to transfer fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 fstest.go:351 sync_test.go:1497 Error: Should be true Test: TestSyncCompareDest Messages: listing wrong, want CompareDest/one (5), CompareDest/two (3), dst/one (3) got CompareDest/one (5), CompareDest/two (3), dst/one (3), yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 fstest.go:351 sync_test.go:1497 Error: Should be true Test: TestSyncCompareDest Messages: Unexpected file "yam" sync_test.go:1526: No hash on uploaded file so skipping compare timestamp test fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 fstest.go:351 sync_test.go:1531 Error: Should be true Test: TestSyncCompareDest Messages: listing wrong, want CompareDest/one (5), CompareDest/two (3), dst/one (3) got CompareDest/one (5), CompareDest/two (3), dst/one (3), yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 fstest.go:351 sync_test.go:1531 Error: Should be true Test: TestSyncCompareDest Messages: Unexpected file "yam" 2021/07/25 05:27:44 DEBUG : two: Sizes differ (src 5 vs dst 3) 2021/07/25 05:27:44 DEBUG : one: Sizes identical 2021/07/25 05:27:44 DEBUG : one: Destination found in --compare-dest, skipping 2021/07/25 05:27:44 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8/dst': Waiting for checks to finish 2021/07/25 05:27:44 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8/dst': Waiting for transfers to finish 2021/07/25 05:27:44 INFO : two: Copied (new) 2021/07/25 05:27:44 DEBUG : Waiting for deletions to finish fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 fstest.go:351 sync_test.go:1541 Error: Should be true Test: TestSyncCompareDest Messages: listing wrong, want CompareDest/one (5), CompareDest/two (3), dst/one (3), dst/two (5) got CompareDest/one (5), CompareDest/two (3), dst/one (3), dst/two (5), yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 fstest.go:351 sync_test.go:1541 Error: Should be true Test: TestSyncCompareDest Messages: Unexpected file "yam" fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 run.go:169 run.go:339 sync_test.go:1542 Error: Should be true Test: TestSyncCompareDest Messages: listing wrong, want got yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 run.go:169 run.go:339 sync_test.go:1542 Error: Should be true Test: TestSyncCompareDest Messages: Unexpected file "yam" --- FAIL: TestSyncCompareDest (81.30s) === RUN TestSyncMultipleCompareDest run.go:176: Remote "mega root 'rclone-test-palahut3lelesot5lisohur8'", Local "Local file system at /tmp/rclone159634013", Modify Window "876000h0m0s" fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 fstest.go:351 sync_test.go:1561 Error: Should be true Test: TestSyncMultipleCompareDest Messages: listing wrong, want pre-dest1/1 (1), pre-dest2/2 (1) got pre-dest1/1 (1), pre-dest2/2 (1), yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 fstest.go:351 sync_test.go:1561 Error: Should be true Test: TestSyncMultipleCompareDest Messages: Unexpected file "yam" 2021/07/25 05:28:06 DEBUG : Creating backend with remote "TestMega:rclone-test-palahut3lelesot5lisohur8/dest" 2021/07/25 05:28:06 DEBUG : Creating backend with remote "TestMega:rclone-test-palahut3lelesot5lisohur8/pre-dest1" 2021/07/25 05:28:06 DEBUG : Creating backend with remote "TestMega:rclone-test-palahut3lelesot5lisohur8/pre-dest2" 2021/07/25 05:28:06 DEBUG : 1: Sizes identical 2021/07/25 05:28:06 DEBUG : 1: Destination found in --compare-dest, skipping 2021/07/25 05:28:06 DEBUG : 2: Sizes identical 2021/07/25 05:28:06 DEBUG : 2: Destination found in --compare-dest, skipping 2021/07/25 05:28:06 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8/dest': Waiting for checks to finish 2021/07/25 05:28:06 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8/dest': Waiting for transfers to finish 2021/07/25 05:28:09 INFO : 3: Copied (new) 2021/07/25 05:28:09 DEBUG : Waiting for deletions to finish fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 fstest.go:351 sync_test.go:1572 Error: Should be true Test: TestSyncMultipleCompareDest Messages: listing wrong, want dest/3 (1), pre-dest1/1 (1), pre-dest2/2 (1) got dest/3 (1), pre-dest1/1 (1), pre-dest2/2 (1), yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 fstest.go:351 sync_test.go:1572 Error: Should be true Test: TestSyncMultipleCompareDest Messages: Unexpected file "yam" fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 run.go:169 run.go:339 sync_test.go:1573 Error: Should be true Test: TestSyncMultipleCompareDest Messages: listing wrong, want got yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 run.go:169 run.go:339 sync_test.go:1573 Error: Should be true Test: TestSyncMultipleCompareDest Messages: Unexpected file "yam" --- FAIL: TestSyncMultipleCompareDest (26.35s) === RUN TestSyncCopyDest run.go:176: Remote "mega root 'rclone-test-palahut3lelesot5lisohur8'", Local "Local file system at /tmp/rclone159634013", Modify Window "876000h0m0s" sync_test.go:1583: Skipping test as remote does not support server-side copy fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 run.go:169 run.go:339 panic.go:617 testing.go:832 testing.go:812 sync_test.go:1583 Error: Should be true Test: TestSyncCopyDest Messages: listing wrong, want got yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 run.go:169 run.go:339 panic.go:617 testing.go:832 testing.go:812 sync_test.go:1583 Error: Should be true Test: TestSyncCopyDest Messages: Unexpected file "yam" --- FAIL: TestSyncCopyDest (7.03s) === RUN TestSyncBackupDir run.go:176: Remote "mega root 'rclone-test-palahut3lelesot5lisohur8'", Local "Local file system at /tmp/rclone159634013", Modify Window "876000h0m0s" fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 fstest.go:351 sync_test.go:1714 sync_test.go:1763 Error: Should be true Test: TestSyncBackupDir Messages: listing wrong, want dst/one (3), dst/three.txt (5), dst/two (3) got dst/one (3), dst/three.txt (5), dst/two (3), yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 fstest.go:351 sync_test.go:1714 sync_test.go:1763 Error: Should be true Test: TestSyncBackupDir Messages: Unexpected file "yam" 2021/07/25 05:28:40 DEBUG : Creating backend with remote "TestMega:rclone-test-palahut3lelesot5lisohur8/dst" 2021/07/25 05:28:40 DEBUG : Creating backend with remote "TestMega:rclone-test-palahut3lelesot5lisohur8/backup" 2021/07/25 05:28:40 DEBUG : one: Sizes differ (src 4 vs dst 3) 2021/07/25 05:28:40 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8/dst': Waiting for checks to finish 2021/07/25 05:28:42 DEBUG : two: Sizes identical 2021/07/25 05:28:42 DEBUG : two: Unchanged skipping 2021/07/25 05:28:42 INFO : one: Moved (server-side) 2021/07/25 05:28:42 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8/dst': Waiting for transfers to finish 2021/07/25 05:28:43 INFO : one: Copied (new) 2021/07/25 05:28:43 DEBUG : Waiting for deletions to finish 2021/07/25 05:28:43 INFO : three.txt: Moved (server-side) 2021/07/25 05:28:43 INFO : three.txt: Moved into backup dir fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 fstest.go:351 sync_test.go:1735 sync_test.go:1763 Error: Should be true Test: TestSyncBackupDir Messages: listing wrong, want backup/one (3), backup/three.txt (5), dst/one (4), dst/two (3) got backup/one (3), backup/three.txt (5), dst/one (4), dst/two (3), yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 fstest.go:351 sync_test.go:1735 sync_test.go:1763 Error: Should be true Test: TestSyncBackupDir Messages: Unexpected file "yam" fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 fstest.go:351 sync_test.go:1741 sync_test.go:1763 Error: Should be true Test: TestSyncBackupDir Messages: listing wrong, want backup/one (3), backup/three.txt (5), dst/one (4), dst/three.txt (6), dst/two (3) got backup/one (3), backup/three.txt (5), dst/one (4), dst/three.txt (6), dst/two (3), yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 fstest.go:351 sync_test.go:1741 sync_test.go:1763 Error: Should be true Test: TestSyncBackupDir Messages: Unexpected file "yam" 2021/07/25 05:28:57 DEBUG : one: Sizes differ (src 5 vs dst 4) 2021/07/25 05:28:57 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8/dst': Waiting for checks to finish 2021/07/25 05:28:57 INFO : one: Deleted 2021/07/25 05:28:57 DEBUG : two: Sizes identical 2021/07/25 05:28:57 DEBUG : two: Unchanged skipping 2021/07/25 05:28:58 INFO : one: Moved (server-side) 2021/07/25 05:28:58 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8/dst': Waiting for transfers to finish 2021/07/25 05:29:00 INFO : one: Copied (new) 2021/07/25 05:29:00 DEBUG : Waiting for deletions to finish 2021/07/25 05:29:00 INFO : three.txt: Deleted 2021/07/25 05:29:00 INFO : three.txt: Moved (server-side) 2021/07/25 05:29:00 INFO : three.txt: Moved into backup dir fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 fstest.go:351 sync_test.go:1760 sync_test.go:1763 Error: Should be true Test: TestSyncBackupDir Messages: listing wrong, want backup/one (4), backup/three.txt (6), dst/one (5), dst/two (3) got backup/one (4), backup/three.txt (6), dst/one (5), dst/two (3), yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 fstest.go:351 sync_test.go:1760 sync_test.go:1763 Error: Should be true Test: TestSyncBackupDir Messages: Unexpected file "yam" fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 run.go:169 run.go:339 sync_test.go:1761 sync_test.go:1763 Error: Should be true Test: TestSyncBackupDir Messages: listing wrong, want got yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 run.go:169 run.go:339 sync_test.go:1761 sync_test.go:1763 Error: Should be true Test: TestSyncBackupDir Messages: Unexpected file "yam" --- FAIL: TestSyncBackupDir (42.70s) === RUN TestSyncBackupDirWithSuffix run.go:176: Remote "mega root 'rclone-test-palahut3lelesot5lisohur8'", Local "Local file system at /tmp/rclone159634013", Modify Window "876000h0m0s" fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 fstest.go:351 sync_test.go:1714 sync_test.go:1766 Error: Should be true Test: TestSyncBackupDirWithSuffix Messages: listing wrong, want dst/one (3), dst/three.txt (5), dst/two (3) got dst/one (3), dst/three.txt (5), dst/two (3), yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 fstest.go:351 sync_test.go:1714 sync_test.go:1766 Error: Should be true Test: TestSyncBackupDirWithSuffix Messages: Unexpected file "yam" 2021/07/25 05:29:23 DEBUG : Creating backend with remote "TestMega:rclone-test-palahut3lelesot5lisohur8/dst" 2021/07/25 05:29:23 DEBUG : Creating backend with remote "TestMega:rclone-test-palahut3lelesot5lisohur8/backup" 2021/07/25 05:29:23 DEBUG : one: Sizes differ (src 4 vs dst 3) 2021/07/25 05:29:23 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8/dst': Waiting for checks to finish 2021/07/25 05:29:25 DEBUG : two: Sizes identical 2021/07/25 05:29:25 DEBUG : two: Unchanged skipping 2021/07/25 05:29:25 INFO : one: Moved (server-side) to: one.bak 2021/07/25 05:29:25 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8/dst': Waiting for transfers to finish 2021/07/25 05:29:25 INFO : one: Copied (new) 2021/07/25 05:29:25 DEBUG : Waiting for deletions to finish 2021/07/25 05:29:25 INFO : three.txt: Moved (server-side) to: three.txt.bak 2021/07/25 05:29:25 INFO : three.txt: Moved into backup dir fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 fstest.go:351 sync_test.go:1735 sync_test.go:1766 Error: Should be true Test: TestSyncBackupDirWithSuffix Messages: listing wrong, want backup/one.bak (3), backup/three.txt.bak (5), dst/one (4), dst/two (3) got backup/one.bak (3), backup/three.txt.bak (5), dst/one (4), dst/two (3), yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 fstest.go:351 sync_test.go:1735 sync_test.go:1766 Error: Should be true Test: TestSyncBackupDirWithSuffix Messages: Unexpected file "yam" fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 fstest.go:351 sync_test.go:1741 sync_test.go:1766 Error: Should be true Test: TestSyncBackupDirWithSuffix Messages: listing wrong, want backup/one.bak (3), backup/three.txt.bak (5), dst/one (4), dst/three.txt (6), dst/two (3) got backup/one.bak (3), backup/three.txt.bak (5), dst/one (4), dst/three.txt (6), dst/two (3), yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 fstest.go:351 sync_test.go:1741 sync_test.go:1766 Error: Should be true Test: TestSyncBackupDirWithSuffix Messages: Unexpected file "yam" 2021/07/25 05:29:40 DEBUG : two: Sizes identical 2021/07/25 05:29:40 DEBUG : two: Unchanged skipping 2021/07/25 05:29:40 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8/dst': Waiting for checks to finish 2021/07/25 05:29:40 DEBUG : one: Sizes differ (src 5 vs dst 4) 2021/07/25 05:29:40 INFO : one.bak: Deleted 2021/07/25 05:29:42 INFO : one: Moved (server-side) to: one.bak 2021/07/25 05:29:42 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8/dst': Waiting for transfers to finish 2021/07/25 05:29:42 INFO : one: Copied (new) 2021/07/25 05:29:42 DEBUG : Waiting for deletions to finish 2021/07/25 05:29:42 INFO : three.txt.bak: Deleted 2021/07/25 05:29:43 INFO : three.txt: Moved (server-side) to: three.txt.bak 2021/07/25 05:29:43 INFO : three.txt: Moved into backup dir fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 fstest.go:351 sync_test.go:1760 sync_test.go:1766 Error: Should be true Test: TestSyncBackupDirWithSuffix Messages: listing wrong, want backup/one.bak (4), backup/three.txt.bak (6), dst/one (5), dst/two (3) got backup/one.bak (4), backup/three.txt.bak (6), dst/one (5), dst/two (3), yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 fstest.go:351 sync_test.go:1760 sync_test.go:1766 Error: Should be true Test: TestSyncBackupDirWithSuffix Messages: Unexpected file "yam" fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 run.go:169 run.go:339 sync_test.go:1761 sync_test.go:1766 Error: Should be true Test: TestSyncBackupDirWithSuffix Messages: listing wrong, want got yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 run.go:169 run.go:339 sync_test.go:1761 sync_test.go:1766 Error: Should be true Test: TestSyncBackupDirWithSuffix Messages: Unexpected file "yam" --- FAIL: TestSyncBackupDirWithSuffix (44.21s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:176: Remote "mega root 'rclone-test-palahut3lelesot5lisohur8'", Local "Local file system at /tmp/rclone159634013", Modify Window "876000h0m0s" fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 fstest.go:351 sync_test.go:1714 sync_test.go:1769 Error: Should be true Test: TestSyncBackupDirWithSuffixKeepExtension Messages: listing wrong, want dst/one (3), dst/three.txt (5), dst/two (3) got dst/one (3), dst/three.txt (5), dst/two (3), yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 fstest.go:351 sync_test.go:1714 sync_test.go:1769 Error: Should be true Test: TestSyncBackupDirWithSuffixKeepExtension Messages: Unexpected file "yam" 2021/07/25 05:30:07 DEBUG : Creating backend with remote "TestMega:rclone-test-palahut3lelesot5lisohur8/dst" 2021/07/25 05:30:07 DEBUG : Config file has changed externaly - reloading 2021/07/25 05:30:07 DEBUG : Creating backend with remote "TestMega:rclone-test-palahut3lelesot5lisohur8/backup" 2021/07/25 05:30:07 DEBUG : two: Sizes identical 2021/07/25 05:30:07 DEBUG : two: Unchanged skipping 2021/07/25 05:30:07 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8/dst': Waiting for checks to finish 2021/07/25 05:30:07 DEBUG : one: Sizes differ (src 4 vs dst 3) 2021/07/25 05:30:07 INFO : one: Moved (server-side) to: one-2019-01-01 2021/07/25 05:30:07 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8/dst': Waiting for transfers to finish 2021/07/25 05:30:09 INFO : one: Copied (new) 2021/07/25 05:30:09 DEBUG : Waiting for deletions to finish 2021/07/25 05:30:10 INFO : three.txt: Moved (server-side) to: three-2019-01-01.txt 2021/07/25 05:30:10 INFO : three.txt: Moved into backup dir fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 fstest.go:351 sync_test.go:1735 sync_test.go:1769 Error: Should be true Test: TestSyncBackupDirWithSuffixKeepExtension Messages: listing wrong, want backup/one-2019-01-01 (3), backup/three-2019-01-01.txt (5), dst/one (4), dst/two (3) got backup/one-2019-01-01 (3), backup/three-2019-01-01.txt (5), dst/one (4), dst/two (3), yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 fstest.go:351 sync_test.go:1735 sync_test.go:1769 Error: Should be true Test: TestSyncBackupDirWithSuffixKeepExtension Messages: Unexpected file "yam" fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 fstest.go:351 sync_test.go:1741 sync_test.go:1769 Error: Should be true Test: TestSyncBackupDirWithSuffixKeepExtension Messages: listing wrong, want backup/one-2019-01-01 (3), backup/three-2019-01-01.txt (5), dst/one (4), dst/three.txt (6), dst/two (3) got backup/one-2019-01-01 (3), backup/three-2019-01-01.txt (5), dst/one (4), dst/three.txt (6), dst/two (3), yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 fstest.go:351 sync_test.go:1741 sync_test.go:1769 Error: Should be true Test: TestSyncBackupDirWithSuffixKeepExtension Messages: Unexpected file "yam" 2021/07/25 05:30:24 DEBUG : one: Sizes differ (src 5 vs dst 4) 2021/07/25 05:30:24 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8/dst': Waiting for checks to finish 2021/07/25 05:30:24 INFO : one-2019-01-01: Deleted 2021/07/25 05:30:24 DEBUG : two: Sizes identical 2021/07/25 05:30:24 DEBUG : two: Unchanged skipping 2021/07/25 05:30:24 INFO : one: Moved (server-side) to: one-2019-01-01 2021/07/25 05:30:24 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8/dst': Waiting for transfers to finish 2021/07/25 05:30:25 INFO : one: Copied (new) 2021/07/25 05:30:25 DEBUG : Waiting for deletions to finish 2021/07/25 05:30:25 INFO : three-2019-01-01.txt: Deleted 2021/07/25 05:30:26 INFO : three.txt: Moved (server-side) to: three-2019-01-01.txt 2021/07/25 05:30:26 INFO : three.txt: Moved into backup dir fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 fstest.go:351 sync_test.go:1760 sync_test.go:1769 Error: Should be true Test: TestSyncBackupDirWithSuffixKeepExtension Messages: listing wrong, want backup/one-2019-01-01 (4), backup/three-2019-01-01.txt (6), dst/one (5), dst/two (3) got backup/one-2019-01-01 (4), backup/three-2019-01-01.txt (6), dst/one (5), dst/two (3), yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 fstest.go:351 sync_test.go:1760 sync_test.go:1769 Error: Should be true Test: TestSyncBackupDirWithSuffixKeepExtension Messages: Unexpected file "yam" fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 run.go:169 run.go:339 sync_test.go:1761 sync_test.go:1769 Error: Should be true Test: TestSyncBackupDirWithSuffixKeepExtension Messages: listing wrong, want got yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 run.go:169 run.go:339 sync_test.go:1761 sync_test.go:1769 Error: Should be true Test: TestSyncBackupDirWithSuffixKeepExtension Messages: Unexpected file "yam" --- FAIL: TestSyncBackupDirWithSuffixKeepExtension (41.79s) === RUN TestSyncBackupDirSuffixOnly run.go:176: Remote "mega root 'rclone-test-palahut3lelesot5lisohur8'", Local "Local file system at /tmp/rclone159634013", Modify Window "876000h0m0s" fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 fstest.go:351 sync_test.go:1714 sync_test.go:1772 Error: Should be true Test: TestSyncBackupDirSuffixOnly Messages: listing wrong, want dst/one (3), dst/three.txt (5), dst/two (3) got dst/one (3), dst/three.txt (5), dst/two (3), yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 fstest.go:351 sync_test.go:1714 sync_test.go:1772 Error: Should be true Test: TestSyncBackupDirSuffixOnly Messages: Unexpected file "yam" 2021/07/25 05:30:49 DEBUG : Creating backend with remote "TestMega:rclone-test-palahut3lelesot5lisohur8/dst" 2021/07/25 05:30:49 DEBUG : one: Sizes differ (src 4 vs dst 3) 2021/07/25 05:30:49 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8/dst': Waiting for checks to finish 2021/07/25 05:30:49 DEBUG : two: Sizes identical 2021/07/25 05:30:49 DEBUG : two: Unchanged skipping 2021/07/25 05:30:49 INFO : one: Moved (server-side) to: one.bak 2021/07/25 05:30:49 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8/dst': Waiting for transfers to finish 2021/07/25 05:30:49 INFO : one: Copied (new) 2021/07/25 05:30:49 DEBUG : Waiting for deletions to finish 2021/07/25 05:30:49 INFO : three.txt: Moved (server-side) to: three.txt.bak 2021/07/25 05:30:49 INFO : three.txt: Moved into backup dir fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 fstest.go:351 sync_test.go:1735 sync_test.go:1772 Error: Should be true Test: TestSyncBackupDirSuffixOnly Messages: listing wrong, want dst/one (4), dst/one.bak (3), dst/three.txt.bak (5), dst/two (3) got dst/one (4), dst/one.bak (3), dst/three.txt.bak (5), dst/two (3), yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 fstest.go:351 sync_test.go:1735 sync_test.go:1772 Error: Should be true Test: TestSyncBackupDirSuffixOnly Messages: Unexpected file "yam" fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 fstest.go:351 sync_test.go:1741 sync_test.go:1772 Error: Should be true Test: TestSyncBackupDirSuffixOnly Messages: listing wrong, want dst/one (4), dst/one.bak (3), dst/three.txt (6), dst/three.txt.bak (5), dst/two (3) got dst/one (4), dst/one.bak (3), dst/three.txt (6), dst/three.txt.bak (5), dst/two (3), yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 fstest.go:351 sync_test.go:1741 sync_test.go:1772 Error: Should be true Test: TestSyncBackupDirSuffixOnly Messages: Unexpected file "yam" 2021/07/25 05:31:04 DEBUG : one.bak: Excluded 2021/07/25 05:31:04 DEBUG : three.txt.bak: Excluded 2021/07/25 05:31:04 DEBUG : one: Sizes differ (src 5 vs dst 4) 2021/07/25 05:31:04 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8/dst': Waiting for checks to finish 2021/07/25 05:31:04 INFO : one.bak: Deleted 2021/07/25 05:31:04 DEBUG : two: Sizes identical 2021/07/25 05:31:04 DEBUG : two: Unchanged skipping 2021/07/25 05:31:04 INFO : one: Moved (server-side) to: one.bak 2021/07/25 05:31:04 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8/dst': Waiting for transfers to finish 2021/07/25 05:31:04 INFO : one: Copied (new) 2021/07/25 05:31:04 DEBUG : Waiting for deletions to finish 2021/07/25 05:31:04 INFO : three.txt.bak: Deleted 2021/07/25 05:31:04 INFO : three.txt: Moved (server-side) to: three.txt.bak 2021/07/25 05:31:04 INFO : three.txt: Moved into backup dir fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 fstest.go:351 sync_test.go:1760 sync_test.go:1772 Error: Should be true Test: TestSyncBackupDirSuffixOnly Messages: listing wrong, want dst/one (5), dst/one.bak (4), dst/three.txt.bak (6), dst/two (3) got dst/one (5), dst/one.bak (4), dst/three.txt.bak (6), dst/two (3), yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 fstest.go:351 sync_test.go:1760 sync_test.go:1772 Error: Should be true Test: TestSyncBackupDirSuffixOnly Messages: Unexpected file "yam" fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 run.go:169 run.go:339 sync_test.go:1761 sync_test.go:1772 Error: Should be true Test: TestSyncBackupDirSuffixOnly Messages: listing wrong, want got yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 run.go:169 run.go:339 sync_test.go:1761 sync_test.go:1772 Error: Should be true Test: TestSyncBackupDirSuffixOnly Messages: Unexpected file "yam" --- FAIL: TestSyncBackupDirSuffixOnly (37.94s) === RUN TestSyncSuffix run.go:176: Remote "mega root 'rclone-test-palahut3lelesot5lisohur8'", Local "Local file system at /tmp/rclone159634013", Modify Window "876000h0m0s" fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 fstest.go:351 sync_test.go:1799 sync_test.go:1857 Error: Should be true Test: TestSyncSuffix Messages: listing wrong, want dst/one (3), dst/three.txt (5), dst/two (3) got dst/one (3), dst/three.txt (5), dst/two (3), yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 fstest.go:351 sync_test.go:1799 sync_test.go:1857 Error: Should be true Test: TestSyncSuffix Messages: Unexpected file "yam" 2021/07/25 05:31:29 DEBUG : Creating backend with remote "TestMega:rclone-test-palahut3lelesot5lisohur8/dst" 2021/07/25 05:31:29 DEBUG : one: Sizes differ (src 4 vs dst 3) 2021/07/25 05:31:29 INFO : one: Moved (server-side) to: one.bak 2021/07/25 05:31:30 INFO : one: Copied (new) 2021/07/25 05:31:30 DEBUG : two: Sizes identical 2021/07/25 05:31:30 DEBUG : two: Unchanged skipping 2021/07/25 05:31:30 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2021/07/25 05:31:30 INFO : three.txt: Moved (server-side) to: three.txt.bak 2021/07/25 05:31:30 INFO : three.txt: Copied (new) fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 fstest.go:351 sync_test.go:1825 sync_test.go:1857 Error: Should be true Test: TestSyncSuffix Messages: listing wrong, want dst/one (4), dst/one.bak (3), dst/three.txt (6), dst/three.txt.bak (5), dst/two (3) got dst/one (4), dst/one.bak (3), dst/three.txt (6), dst/three.txt.bak (5), dst/two (3), yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 fstest.go:351 sync_test.go:1825 sync_test.go:1857 Error: Should be true Test: TestSyncSuffix Messages: Unexpected file "yam" fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 fstest.go:351 sync_test.go:1831 sync_test.go:1857 Error: Should be true Test: TestSyncSuffix Messages: listing wrong, want dst/one (4), dst/one.bak (3), dst/three.txt (6), dst/three.txt.bak (5), dst/two (3) got dst/one (4), dst/one.bak (3), dst/three.txt (6), dst/three.txt.bak (5), dst/two (3), yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 fstest.go:351 sync_test.go:1831 sync_test.go:1857 Error: Should be true Test: TestSyncSuffix Messages: Unexpected file "yam" 2021/07/25 05:31:44 DEBUG : one: Sizes differ (src 5 vs dst 4) 2021/07/25 05:31:44 INFO : one.bak: Deleted 2021/07/25 05:31:44 INFO : one: Moved (server-side) to: one.bak 2021/07/25 05:31:46 INFO : one: Copied (new) 2021/07/25 05:31:46 DEBUG : two: Sizes identical 2021/07/25 05:31:46 DEBUG : two: Unchanged skipping 2021/07/25 05:31:46 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2021/07/25 05:31:46 INFO : three.txt.bak: Deleted 2021/07/25 05:31:47 INFO : three.txt: Moved (server-side) to: three.txt.bak 2021/07/25 05:31:47 INFO : three.txt: Copied (new) fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 fstest.go:351 sync_test.go:1855 sync_test.go:1857 Error: Should be true Test: TestSyncSuffix Messages: listing wrong, want dst/one (5), dst/one.bak (4), dst/three.txt (19), dst/three.txt.bak (6), dst/two (3) got dst/one (5), dst/one.bak (4), dst/three.txt (19), dst/three.txt.bak (6), dst/two (3), yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 fstest.go:351 sync_test.go:1855 sync_test.go:1857 Error: Should be true Test: TestSyncSuffix Messages: Unexpected file "yam" fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 run.go:169 run.go:339 sync_test.go:1856 sync_test.go:1857 Error: Should be true Test: TestSyncSuffix Messages: listing wrong, want got yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 run.go:169 run.go:339 sync_test.go:1856 sync_test.go:1857 Error: Should be true Test: TestSyncSuffix Messages: Unexpected file "yam" --- FAIL: TestSyncSuffix (46.45s) === RUN TestSyncSuffixKeepExtension run.go:176: Remote "mega root 'rclone-test-palahut3lelesot5lisohur8'", Local "Local file system at /tmp/rclone159634013", Modify Window "876000h0m0s" fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 fstest.go:351 sync_test.go:1799 sync_test.go:1858 Error: Should be true Test: TestSyncSuffixKeepExtension Messages: listing wrong, want dst/one (3), dst/three.txt (5), dst/two (3) got dst/one (3), dst/three.txt (5), dst/two (3), yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 fstest.go:351 sync_test.go:1799 sync_test.go:1858 Error: Should be true Test: TestSyncSuffixKeepExtension Messages: Unexpected file "yam" 2021/07/25 05:32:13 DEBUG : Creating backend with remote "TestMega:rclone-test-palahut3lelesot5lisohur8/dst" 2021/07/25 05:32:13 DEBUG : one: Sizes differ (src 4 vs dst 3) 2021/07/25 05:32:13 INFO : one: Moved (server-side) to: one-2019-01-01 2021/07/25 05:32:14 INFO : one: Copied (new) 2021/07/25 05:32:14 DEBUG : two: Sizes identical 2021/07/25 05:32:14 DEBUG : two: Unchanged skipping 2021/07/25 05:32:14 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2021/07/25 05:32:14 INFO : three.txt: Moved (server-side) to: three-2019-01-01.txt 2021/07/25 05:32:14 INFO : three.txt: Copied (new) fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 fstest.go:351 sync_test.go:1825 sync_test.go:1858 Error: Should be true Test: TestSyncSuffixKeepExtension Messages: listing wrong, want dst/one (4), dst/one-2019-01-01 (3), dst/three-2019-01-01.txt (5), dst/three.txt (6), dst/two (3) got dst/one (4), dst/one-2019-01-01 (3), dst/three-2019-01-01.txt (5), dst/three.txt (6), dst/two (3), yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 fstest.go:351 sync_test.go:1825 sync_test.go:1858 Error: Should be true Test: TestSyncSuffixKeepExtension Messages: Unexpected file "yam" fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 fstest.go:351 sync_test.go:1831 sync_test.go:1858 Error: Should be true Test: TestSyncSuffixKeepExtension Messages: listing wrong, want dst/one (4), dst/one-2019-01-01 (3), dst/three-2019-01-01.txt (5), dst/three.txt (6), dst/two (3) got dst/one (4), dst/one-2019-01-01 (3), dst/three-2019-01-01.txt (5), dst/three.txt (6), dst/two (3), yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 fstest.go:351 sync_test.go:1831 sync_test.go:1858 Error: Should be true Test: TestSyncSuffixKeepExtension Messages: Unexpected file "yam" 2021/07/25 05:32:28 DEBUG : one: Sizes differ (src 5 vs dst 4) 2021/07/25 05:32:28 INFO : one-2019-01-01: Deleted 2021/07/25 05:32:28 INFO : one: Moved (server-side) to: one-2019-01-01 2021/07/25 05:32:28 INFO : one: Copied (new) 2021/07/25 05:32:28 DEBUG : two: Sizes identical 2021/07/25 05:32:28 DEBUG : two: Unchanged skipping 2021/07/25 05:32:28 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2021/07/25 05:32:29 INFO : three-2019-01-01.txt: Deleted 2021/07/25 05:32:29 INFO : three.txt: Moved (server-side) to: three-2019-01-01.txt 2021/07/25 05:32:29 INFO : three.txt: Copied (new) fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 fstest.go:351 sync_test.go:1855 sync_test.go:1858 Error: Should be true Test: TestSyncSuffixKeepExtension Messages: listing wrong, want dst/one (5), dst/one-2019-01-01 (4), dst/three-2019-01-01.txt (6), dst/three.txt (19), dst/two (3) got dst/one (5), dst/one-2019-01-01 (4), dst/three-2019-01-01.txt (6), dst/three.txt (19), dst/two (3), yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 fstest.go:351 sync_test.go:1855 sync_test.go:1858 Error: Should be true Test: TestSyncSuffixKeepExtension Messages: Unexpected file "yam" fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 run.go:169 run.go:339 sync_test.go:1856 sync_test.go:1858 Error: Should be true Test: TestSyncSuffixKeepExtension Messages: listing wrong, want got yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 run.go:169 run.go:339 sync_test.go:1856 sync_test.go:1858 Error: Should be true Test: TestSyncSuffixKeepExtension Messages: Unexpected file "yam" --- FAIL: TestSyncSuffixKeepExtension (40.29s) === RUN TestSyncUTFNorm run.go:176: Remote "mega root 'rclone-test-palahut3lelesot5lisohur8'", Local "Local file system at /tmp/rclone159634013", Modify Window "876000h0m0s" fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 fstest.go:351 sync_test.go:1880 Error: Should be true Test: TestSyncUTFNorm Messages: listing wrong, want Testêé (18) got Testêé (18), yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 fstest.go:351 sync_test.go:1880 Error: Should be true Test: TestSyncUTFNorm Messages: Unexpected file "yam" 2021/07/25 05:32:53 DEBUG : Testêé: Sizes differ (src 14 vs dst 18) 2021/07/25 05:32:53 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for checks to finish 2021/07/25 05:32:53 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for transfers to finish 2021/07/25 05:32:55 INFO : Testêé: Copied (replaced existing) to: Testêé 2021/07/25 05:32:55 DEBUG : Waiting for deletions to finish 2021/07/25 05:32:55 INFO : yam: Deleted fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 fstest.go:351 sync_test.go:1891 Error: Should be true Test: TestSyncUTFNorm Messages: listing wrong, want Testêé (14) got Testêé (14), yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 fstest.go:351 sync_test.go:1891 Error: Should be true Test: TestSyncUTFNorm Messages: Unexpected file "yam" fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 run.go:169 run.go:339 sync_test.go:1892 Error: Should be true Test: TestSyncUTFNorm Messages: listing wrong, want got yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 run.go:169 run.go:339 sync_test.go:1892 Error: Should be true Test: TestSyncUTFNorm Messages: Unexpected file "yam" --- FAIL: TestSyncUTFNorm (23.82s) === RUN TestSyncImmutable run.go:176: Remote "mega root 'rclone-test-palahut3lelesot5lisohur8'", Local "Local file system at /tmp/rclone159634013", Modify Window "876000h0m0s" fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 fstest.go:351 sync_test.go:1906 Error: Should be true Test: TestSyncImmutable Messages: listing wrong, want got yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 fstest.go:351 sync_test.go:1906 Error: Should be true Test: TestSyncImmutable Messages: Unexpected file "yam" 2021/07/25 05:33:16 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for checks to finish 2021/07/25 05:33:16 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for transfers to finish 2021/07/25 05:33:17 INFO : existing: Copied (new) 2021/07/25 05:33:17 DEBUG : Waiting for deletions to finish 2021/07/25 05:33:17 INFO : yam: Deleted fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 fstest.go:351 sync_test.go:1913 Error: Should be true Test: TestSyncImmutable Messages: listing wrong, want existing (6) got existing (6), yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 fstest.go:351 sync_test.go:1913 Error: Should be true Test: TestSyncImmutable Messages: Unexpected file "yam" fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 fstest.go:351 sync_test.go:1918 Error: Should be true Test: TestSyncImmutable Messages: listing wrong, want existing (6) got existing (6), yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 fstest.go:351 sync_test.go:1918 Error: Should be true Test: TestSyncImmutable Messages: Unexpected file "yam" 2021/07/25 05:33:31 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for checks to finish 2021/07/25 05:33:31 DEBUG : existing: Sizes differ (src 8 vs dst 6) 2021/07/25 05:33:31 ERROR : existing: Source and destination exist but do not match: immutable file modified 2021/07/25 05:33:31 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for transfers to finish 2021/07/25 05:33:31 ERROR : mega root 'rclone-test-palahut3lelesot5lisohur8': not deleting files as there were IO errors 2021/07/25 05:33:31 ERROR : mega root 'rclone-test-palahut3lelesot5lisohur8': not deleting directories as there were IO errors fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 fstest.go:351 sync_test.go:1925 Error: Should be true Test: TestSyncImmutable Messages: listing wrong, want existing (6) got existing (6), yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 fstest.go:351 sync_test.go:1925 Error: Should be true Test: TestSyncImmutable Messages: Unexpected file "yam" fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 run.go:169 run.go:339 sync_test.go:1926 Error: Should be true Test: TestSyncImmutable Messages: listing wrong, want got yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 run.go:169 run.go:339 sync_test.go:1926 Error: Should be true Test: TestSyncImmutable Messages: Unexpected file "yam" --- FAIL: TestSyncImmutable (35.24s) === RUN TestSyncIgnoreCase run.go:176: Remote "mega root 'rclone-test-palahut3lelesot5lisohur8'", Local "Local file system at /tmp/rclone159634013", Modify Window "876000h0m0s" fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 fstest.go:351 sync_test.go:1946 Error: Should be true Test: TestSyncIgnoreCase Messages: listing wrong, want EXISTING (6) got EXISTING (6), yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 fstest.go:351 sync_test.go:1946 Error: Should be true Test: TestSyncIgnoreCase Messages: Unexpected file "yam" 2021/07/25 05:33:52 DEBUG : existing: Sizes identical 2021/07/25 05:33:52 DEBUG : existing: Unchanged skipping 2021/07/25 05:33:52 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for checks to finish 2021/07/25 05:33:52 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for transfers to finish 2021/07/25 05:33:52 DEBUG : Waiting for deletions to finish 2021/07/25 05:33:52 INFO : yam: Deleted 2021/07/25 05:33:52 INFO : There was nothing to transfer fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 fstest.go:351 sync_test.go:1953 Error: Should be true Test: TestSyncIgnoreCase Messages: listing wrong, want EXISTING (6) got EXISTING (6), yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 fstest.go:351 sync_test.go:1953 Error: Should be true Test: TestSyncIgnoreCase Messages: Unexpected file "yam" fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 run.go:169 run.go:339 sync_test.go:1954 Error: Should be true Test: TestSyncIgnoreCase Messages: listing wrong, want got yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 run.go:169 run.go:339 sync_test.go:1954 Error: Should be true Test: TestSyncIgnoreCase Messages: Unexpected file "yam" --- FAIL: TestSyncIgnoreCase (21.26s) === RUN TestMaxTransfer === RUN TestMaxTransfer/Hard run.go:176: Remote "mega root 'rclone-test-palahut3lelesot5lisohur8'", Local "Local file system at /tmp/rclone159634013", Modify Window "876000h0m0s" sync_test.go:1971: This test only runs on local fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 run.go:169 run.go:339 panic.go:617 testing.go:832 testing.go:812 sync_test.go:1971 sync_test.go:1992 Error: Should be true Test: TestMaxTransfer/Hard Messages: listing wrong, want got yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 run.go:169 run.go:339 panic.go:617 testing.go:832 testing.go:812 sync_test.go:1971 sync_test.go:1992 Error: Should be true Test: TestMaxTransfer/Hard Messages: Unexpected file "yam" === RUN TestMaxTransfer/Soft run.go:176: Remote "mega root 'rclone-test-palahut3lelesot5lisohur8'", Local "Local file system at /tmp/rclone159634013", Modify Window "876000h0m0s" sync_test.go:1971: This test only runs on local fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 run.go:169 run.go:339 panic.go:617 testing.go:832 testing.go:812 sync_test.go:1971 sync_test.go:1993 Error: Should be true Test: TestMaxTransfer/Soft Messages: listing wrong, want got yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 run.go:169 run.go:339 panic.go:617 testing.go:832 testing.go:812 sync_test.go:1971 sync_test.go:1993 Error: Should be true Test: TestMaxTransfer/Soft Messages: Unexpected file "yam" === RUN TestMaxTransfer/Cautious run.go:176: Remote "mega root 'rclone-test-palahut3lelesot5lisohur8'", Local "Local file system at /tmp/rclone159634013", Modify Window "876000h0m0s" sync_test.go:1971: This test only runs on local fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 run.go:169 run.go:339 panic.go:617 testing.go:832 testing.go:812 sync_test.go:1971 sync_test.go:1994 Error: Should be true Test: TestMaxTransfer/Cautious Messages: listing wrong, want got yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 run.go:169 run.go:339 panic.go:617 testing.go:832 testing.go:812 sync_test.go:1971 sync_test.go:1994 Error: Should be true Test: TestMaxTransfer/Cautious Messages: Unexpected file "yam" --- FAIL: TestMaxTransfer (21.08s) --- FAIL: TestMaxTransfer/Hard (7.03s) --- FAIL: TestMaxTransfer/Soft (7.03s) --- FAIL: TestMaxTransfer/Cautious (7.03s) === RUN TestSyncConcurrentDelete run.go:176: Remote "mega root 'rclone-test-palahut3lelesot5lisohur8'", Local "Local file system at /tmp/rclone159634013", Modify Window "876000h0m0s" fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 fstest.go:351 sync_test.go:2032 sync_test.go:2041 Error: Should be true Test: TestSyncConcurrentDelete Messages: listing wrong, want both0 (6), both1 (6), both10 (6), both11 (6), both12 (6), both13 (6), both14 (6), both15 (6), both16 (6), both17 (6), both18 (6), both19 (6), both2 (6), both3 (6), both4 (6), both5 (6), both6 (6), both7 (6), both8 (6), both9 (6), only0 (6), only1 (6), only10 (6), only11 (6), only12 (6), only13 (6), only14 (6), only15 (6), only16 (6), only17 (6), only18 (6), only19 (6), only2 (6), only3 (6), only4 (6), only5 (6), only6 (6), only7 (6), only8 (6), only9 (6) got both0 (6), both1 (6), both10 (6), both11 (6), both12 (6), both13 (6), both14 (6), both15 (6), both16 (6), both17 (6), both18 (6), both19 (6), both2 (6), both3 (6), both4 (6), both5 (6), both6 (6), both7 (6), both8 (6), both9 (6), only0 (6), only1 (6), only10 (6), only11 (6), only12 (6), only13 (6), only14 (6), only15 (6), only16 (6), only17 (6), only18 (6), only19 (6), only2 (6), only3 (6), only4 (6), only5 (6), only6 (6), only7 (6), only8 (6), only9 (6), yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 fstest.go:351 sync_test.go:2032 sync_test.go:2041 Error: Should be true Test: TestSyncConcurrentDelete Messages: Unexpected file "yam" 2021/07/25 05:35:01 DEBUG : both1: Sizes identical 2021/07/25 05:35:01 DEBUG : both1: Unchanged skipping 2021/07/25 05:35:01 DEBUG : both11: Sizes identical 2021/07/25 05:35:01 DEBUG : both11: Unchanged skipping 2021/07/25 05:35:01 DEBUG : both12: Sizes identical 2021/07/25 05:35:01 DEBUG : both12: Unchanged skipping 2021/07/25 05:35:01 DEBUG : both10: Sizes identical 2021/07/25 05:35:01 DEBUG : both10: Unchanged skipping 2021/07/25 05:35:01 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for checks to finish 2021/07/25 05:35:01 DEBUG : both14: Sizes identical 2021/07/25 05:35:01 DEBUG : both14: Unchanged skipping 2021/07/25 05:35:01 DEBUG : both16: Sizes identical 2021/07/25 05:35:01 DEBUG : both16: Unchanged skipping 2021/07/25 05:35:01 DEBUG : both15: Sizes identical 2021/07/25 05:35:01 DEBUG : both15: Unchanged skipping 2021/07/25 05:35:01 DEBUG : both18: Sizes identical 2021/07/25 05:35:01 DEBUG : both18: Unchanged skipping 2021/07/25 05:35:01 DEBUG : both19: Sizes identical 2021/07/25 05:35:01 DEBUG : both19: Unchanged skipping 2021/07/25 05:35:01 DEBUG : both2: Sizes identical 2021/07/25 05:35:01 DEBUG : both2: Unchanged skipping 2021/07/25 05:35:01 DEBUG : both3: Sizes identical 2021/07/25 05:35:01 DEBUG : both3: Unchanged skipping 2021/07/25 05:35:01 DEBUG : both4: Sizes identical 2021/07/25 05:35:01 DEBUG : both4: Unchanged skipping 2021/07/25 05:35:01 DEBUG : both5: Sizes identical 2021/07/25 05:35:01 DEBUG : both5: Unchanged skipping 2021/07/25 05:35:01 DEBUG : both6: Sizes identical 2021/07/25 05:35:01 DEBUG : both6: Unchanged skipping 2021/07/25 05:35:01 DEBUG : both7: Sizes identical 2021/07/25 05:35:01 DEBUG : both7: Unchanged skipping 2021/07/25 05:35:01 DEBUG : both8: Sizes identical 2021/07/25 05:35:01 DEBUG : both8: Unchanged skipping 2021/07/25 05:35:01 DEBUG : both13: Sizes identical 2021/07/25 05:35:01 DEBUG : both13: Unchanged skipping 2021/07/25 05:35:01 DEBUG : both17: Sizes identical 2021/07/25 05:35:01 DEBUG : both17: Unchanged skipping 2021/07/25 05:35:01 DEBUG : both0: Sizes identical 2021/07/25 05:35:01 DEBUG : both0: Unchanged skipping 2021/07/25 05:35:01 DEBUG : both9: Sizes identical 2021/07/25 05:35:01 DEBUG : both9: Unchanged skipping 2021/07/25 05:35:01 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for transfers to finish 2021/07/25 05:35:01 DEBUG : Waiting for deletions to finish 2021/07/25 05:35:01 INFO : only13: Deleted 2021/07/25 05:35:01 INFO : only7: Deleted 2021/07/25 05:35:01 INFO : only18: Deleted 2021/07/25 05:35:02 INFO : only2: Deleted 2021/07/25 05:35:02 INFO : only9: Deleted 2021/07/25 05:35:02 INFO : yam: Deleted 2021/07/25 05:35:02 INFO : only10: Deleted 2021/07/25 05:35:02 INFO : only15: Deleted 2021/07/25 05:35:02 INFO : only17: Deleted 2021/07/25 05:35:02 INFO : only5: Deleted 2021/07/25 05:35:02 INFO : only14: Deleted 2021/07/25 05:35:03 INFO : only3: Deleted 2021/07/25 05:35:03 INFO : only8: Deleted 2021/07/25 05:35:03 INFO : only0: Deleted 2021/07/25 05:35:03 INFO : only1: Deleted 2021/07/25 05:35:03 INFO : only11: Deleted 2021/07/25 05:35:03 INFO : only12: Deleted 2021/07/25 05:35:03 INFO : only16: Deleted 2021/07/25 05:35:03 INFO : only19: Deleted 2021/07/25 05:35:06 INFO : only4: Deleted 2021/07/25 05:35:06 INFO : only6: Deleted 2021/07/25 05:35:06 INFO : There was nothing to transfer fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 fstest.go:351 sync_test.go:2037 sync_test.go:2041 Error: Should be true Test: TestSyncConcurrentDelete Messages: listing wrong, want both0 (6), both1 (6), both10 (6), both11 (6), both12 (6), both13 (6), both14 (6), both15 (6), both16 (6), both17 (6), both18 (6), both19 (6), both2 (6), both3 (6), both4 (6), both5 (6), both6 (6), both7 (6), both8 (6), both9 (6) got both0 (6), both1 (6), both10 (6), both11 (6), both12 (6), both13 (6), both14 (6), both15 (6), both16 (6), both17 (6), both18 (6), both19 (6), both2 (6), both3 (6), both4 (6), both5 (6), both6 (6), both7 (6), both8 (6), both9 (6), yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 fstest.go:351 sync_test.go:2037 sync_test.go:2041 Error: Should be true Test: TestSyncConcurrentDelete Messages: Unexpected file "yam" fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 run.go:169 run.go:339 sync_test.go:2038 sync_test.go:2041 Error: Should be true Test: TestSyncConcurrentDelete Messages: listing wrong, want got yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 run.go:169 run.go:339 sync_test.go:2038 sync_test.go:2041 Error: Should be true Test: TestSyncConcurrentDelete Messages: Unexpected file "yam" --- FAIL: TestSyncConcurrentDelete (61.10s) === RUN TestSyncConcurrentTruncate run.go:176: Remote "mega root 'rclone-test-palahut3lelesot5lisohur8'", Local "Local file system at /tmp/rclone159634013", Modify Window "876000h0m0s" fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 fstest.go:351 sync_test.go:2032 sync_test.go:2045 Error: Should be true Test: TestSyncConcurrentTruncate Messages: listing wrong, want both0 (6), both1 (6), both10 (6), both11 (6), both12 (6), both13 (6), both14 (6), both15 (6), both16 (6), both17 (6), both18 (6), both19 (6), both2 (6), both3 (6), both4 (6), both5 (6), both6 (6), both7 (6), both8 (6), both9 (6), only0 (6), only1 (6), only10 (6), only11 (6), only12 (6), only13 (6), only14 (6), only15 (6), only16 (6), only17 (6), only18 (6), only19 (6), only2 (6), only3 (6), only4 (6), only5 (6), only6 (6), only7 (6), only8 (6), only9 (6) got both0 (6), both1 (6), both10 (6), both11 (6), both12 (6), both13 (6), both14 (6), both15 (6), both16 (6), both17 (6), both18 (6), both19 (6), both2 (6), both3 (6), both4 (6), both5 (6), both6 (6), both7 (6), both8 (6), both9 (6), only0 (6), only1 (6), only10 (6), only11 (6), only12 (6), only13 (6), only14 (6), only15 (6), only16 (6), only17 (6), only18 (6), only19 (6), only2 (6), only3 (6), only4 (6), only5 (6), only6 (6), only7 (6), only8 (6), only9 (6), yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 fstest.go:351 sync_test.go:2032 sync_test.go:2045 Error: Should be true Test: TestSyncConcurrentTruncate Messages: Unexpected file "yam" 2021/07/25 05:36:03 DEBUG : both0: Sizes identical 2021/07/25 05:36:03 DEBUG : both0: Unchanged skipping 2021/07/25 05:36:03 DEBUG : both1: Sizes identical 2021/07/25 05:36:03 DEBUG : both1: Unchanged skipping 2021/07/25 05:36:03 DEBUG : both10: Sizes identical 2021/07/25 05:36:03 DEBUG : both10: Unchanged skipping 2021/07/25 05:36:03 DEBUG : both11: Sizes identical 2021/07/25 05:36:03 DEBUG : both11: Unchanged skipping 2021/07/25 05:36:03 DEBUG : both12: Sizes identical 2021/07/25 05:36:03 DEBUG : both12: Unchanged skipping 2021/07/25 05:36:03 DEBUG : both13: Sizes identical 2021/07/25 05:36:03 DEBUG : both13: Unchanged skipping 2021/07/25 05:36:03 DEBUG : both14: Sizes identical 2021/07/25 05:36:03 DEBUG : both14: Unchanged skipping 2021/07/25 05:36:03 DEBUG : both15: Sizes identical 2021/07/25 05:36:03 DEBUG : both15: Unchanged skipping 2021/07/25 05:36:03 DEBUG : both16: Sizes identical 2021/07/25 05:36:03 DEBUG : both16: Unchanged skipping 2021/07/25 05:36:03 DEBUG : both17: Sizes identical 2021/07/25 05:36:03 DEBUG : both17: Unchanged skipping 2021/07/25 05:36:03 DEBUG : both18: Sizes identical 2021/07/25 05:36:03 DEBUG : both18: Unchanged skipping 2021/07/25 05:36:03 DEBUG : both19: Sizes identical 2021/07/25 05:36:03 DEBUG : both19: Unchanged skipping 2021/07/25 05:36:03 DEBUG : both2: Sizes identical 2021/07/25 05:36:03 DEBUG : both2: Unchanged skipping 2021/07/25 05:36:03 DEBUG : both3: Sizes identical 2021/07/25 05:36:03 DEBUG : both3: Unchanged skipping 2021/07/25 05:36:03 DEBUG : both4: Sizes identical 2021/07/25 05:36:03 DEBUG : both4: Unchanged skipping 2021/07/25 05:36:03 DEBUG : both5: Sizes identical 2021/07/25 05:36:03 DEBUG : both5: Unchanged skipping 2021/07/25 05:36:03 DEBUG : both6: Sizes identical 2021/07/25 05:36:03 DEBUG : both6: Unchanged skipping 2021/07/25 05:36:03 DEBUG : both7: Sizes identical 2021/07/25 05:36:03 DEBUG : both7: Unchanged skipping 2021/07/25 05:36:03 DEBUG : both8: Sizes identical 2021/07/25 05:36:03 DEBUG : both8: Unchanged skipping 2021/07/25 05:36:03 DEBUG : both9: Sizes identical 2021/07/25 05:36:03 DEBUG : both9: Unchanged skipping 2021/07/25 05:36:03 DEBUG : only0: Sizes differ (src 0 vs dst 6) 2021/07/25 05:36:03 DEBUG : only1: Sizes differ (src 0 vs dst 6) 2021/07/25 05:36:03 DEBUG : only10: Sizes differ (src 0 vs dst 6) 2021/07/25 05:36:03 DEBUG : only11: Sizes differ (src 0 vs dst 6) 2021/07/25 05:36:03 DEBUG : only12: Sizes differ (src 0 vs dst 6) 2021/07/25 05:36:03 DEBUG : only13: Sizes differ (src 0 vs dst 6) 2021/07/25 05:36:03 DEBUG : only14: Sizes differ (src 0 vs dst 6) 2021/07/25 05:36:03 DEBUG : only15: Sizes differ (src 0 vs dst 6) 2021/07/25 05:36:03 DEBUG : only16: Sizes differ (src 0 vs dst 6) 2021/07/25 05:36:03 DEBUG : only17: Sizes differ (src 0 vs dst 6) 2021/07/25 05:36:03 DEBUG : only18: Sizes differ (src 0 vs dst 6) 2021/07/25 05:36:03 DEBUG : only19: Sizes differ (src 0 vs dst 6) 2021/07/25 05:36:03 DEBUG : only2: Sizes differ (src 0 vs dst 6) 2021/07/25 05:36:03 DEBUG : only3: Sizes differ (src 0 vs dst 6) 2021/07/25 05:36:03 DEBUG : only4: Sizes differ (src 0 vs dst 6) 2021/07/25 05:36:03 DEBUG : only5: Sizes differ (src 0 vs dst 6) 2021/07/25 05:36:03 DEBUG : only6: Sizes differ (src 0 vs dst 6) 2021/07/25 05:36:03 DEBUG : only7: Sizes differ (src 0 vs dst 6) 2021/07/25 05:36:03 DEBUG : only8: Sizes differ (src 0 vs dst 6) 2021/07/25 05:36:03 DEBUG : only9: Sizes differ (src 0 vs dst 6) 2021/07/25 05:36:03 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for checks to finish 2021/07/25 05:36:03 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Waiting for transfers to finish 2021/07/25 05:36:03 INFO : only0: Copied (replaced existing) 2021/07/25 05:36:08 INFO : only1: Copied (replaced existing) 2021/07/25 05:36:08 INFO : only10: Copied (replaced existing) 2021/07/25 05:36:08 INFO : only11: Copied (replaced existing) 2021/07/25 05:36:08 INFO : only12: Copied (replaced existing) 2021/07/25 05:36:09 INFO : only13: Copied (replaced existing) 2021/07/25 05:36:09 INFO : only14: Copied (replaced existing) 2021/07/25 05:36:09 INFO : only15: Copied (replaced existing) 2021/07/25 05:36:09 INFO : only18: Copied (replaced existing) 2021/07/25 05:36:09 INFO : only16: Copied (replaced existing) 2021/07/25 05:36:09 INFO : only17: Copied (replaced existing) 2021/07/25 05:36:10 INFO : only2: Copied (replaced existing) 2021/07/25 05:36:10 INFO : only19: Copied (replaced existing) 2021/07/25 05:36:11 INFO : only4: Copied (replaced existing) 2021/07/25 05:36:11 INFO : only3: Copied (replaced existing) 2021/07/25 05:36:11 INFO : only5: Copied (replaced existing) 2021/07/25 05:36:11 INFO : only6: Copied (replaced existing) 2021/07/25 05:36:11 INFO : only8: Copied (replaced existing) 2021/07/25 05:36:12 INFO : only7: Copied (replaced existing) 2021/07/25 05:36:12 INFO : only9: Copied (replaced existing) 2021/07/25 05:36:12 DEBUG : Waiting for deletions to finish 2021/07/25 05:36:12 INFO : yam: Deleted fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 fstest.go:351 sync_test.go:2037 sync_test.go:2045 Error: Should be true Test: TestSyncConcurrentTruncate Messages: listing wrong, want both0 (6), both1 (6), both10 (6), both11 (6), both12 (6), both13 (6), both14 (6), both15 (6), both16 (6), both17 (6), both18 (6), both19 (6), both2 (6), both3 (6), both4 (6), both5 (6), both6 (6), both7 (6), both8 (6), both9 (6), only0 (0), only1 (0), only10 (0), only11 (0), only12 (0), only13 (0), only14 (0), only15 (0), only16 (0), only17 (0), only18 (0), only19 (0), only2 (0), only3 (0), only4 (0), only5 (0), only6 (0), only7 (0), only8 (0), only9 (0) got both0 (6), both1 (6), both10 (6), both11 (6), both12 (6), both13 (6), both14 (6), both15 (6), both16 (6), both17 (6), both18 (6), both19 (6), both2 (6), both3 (6), both4 (6), both5 (6), both6 (6), both7 (6), both8 (6), both9 (6), only0 (0), only1 (0), only10 (0), only11 (0), only12 (0), only13 (0), only14 (0), only15 (0), only16 (0), only17 (0), only18 (0), only19 (0), only2 (0), only3 (0), only4 (0), only5 (0), only6 (0), only7 (0), only8 (0), only9 (0), yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 fstest.go:351 sync_test.go:2037 sync_test.go:2045 Error: Should be true Test: TestSyncConcurrentTruncate Messages: Unexpected file "yam" fstest.go:299: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:302: Flushing the directory cache fstest.go:299: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:302: Flushing the directory cache fstest.go:306: Error Trace: fstest.go:306 fstest.go:339 run.go:169 run.go:339 sync_test.go:2038 sync_test.go:2045 Error: Should be true Test: TestSyncConcurrentTruncate Messages: listing wrong, want got yam (11) fstest.go:192: Error Trace: fstest.go:192 fstest.go:309 fstest.go:339 run.go:169 run.go:339 sync_test.go:2038 sync_test.go:2045 Error: Should be true Test: TestSyncConcurrentTruncate Messages: Unexpected file "yam" --- FAIL: TestSyncConcurrentTruncate (64.02s) FAIL 2021/07/25 05:36:32 DEBUG : mega root 'rclone-test-palahut3lelesot5lisohur8': Purge remote "./sync.test -test.v -test.timeout 1h0m0s -remote TestMega: -verbose" - Finished ERROR in 19m33.897866125s (try 1/5): exit status 1: Failed [TestSyncWithTrackRenamesStrategyLeaf TestMoveWithDeleteEmptySrcDirs TestMoveWithoutDeleteEmptySrcDirs TestServerSideMove TestServerSideMoveWithFilter TestServerSideMoveDeleteEmptySourceDirs TestServerSideMoveOverlap TestSyncOverlap TestSyncCompareDest TestSyncMultipleCompareDest TestSyncCopyDest TestSyncBackupDir TestSyncBackupDirWithSuffix TestSyncBackupDirWithSuffixKeepExtension TestSyncBackupDirSuffixOnly TestSyncSuffix TestSyncSuffixKeepExtension TestSyncUTFNorm TestSyncImmutable TestSyncIgnoreCase TestMaxTransfer/Hard TestMaxTransfer/Soft TestMaxTransfer/Cautious TestSyncConcurrentDelete TestSyncConcurrentTruncate]