"./sync.test -test.v -test.timeout 1h0m0s -remote TestMega: -verbose -test.run '^(TestMoveWithDeleteEmptySrcDirs|TestServerSideMove|TestServerSideMoveDeleteEmptySourceDirs|TestServerSideMoveWithFilter|TestSyncBackupDir|TestSyncBackupDirWithSuffix|TestSyncCompareDest|TestSyncOverlapWithFilter|TestSyncWithTrackRenamesStrategyLeaf)$'" - Starting (try 5/5) 2025/12/02 05:29:47 DEBUG : Creating backend with remote "TestMega:rclone-test-sesobej8golu" 2025/12/02 05:29:47 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/12/02 05:29:47 DEBUG : mega root 'rclone-test-sesobej8golu': Using previously stored session ID and master key to initialize the Mega API 2025/12/02 05:30:12 DEBUG : Creating backend with remote "/tmp/rclone3577906329" === RUN TestSyncWithTrackRenamesStrategyLeaf run.go:185: Remote "mega root 'rclone-test-sesobej8golu'", Local "Local file system at /tmp/rclone3577906329", Modify Window "876000h0m0s" sync_test.go:1679: Can track renames: false 2025/12/02 05:30:12 INFO : mega root 'rclone-test-sesobej8golu': Making map for --track-renames 2025/12/02 05:30:12 INFO : mega root 'rclone-test-sesobej8golu': Finished making map for --track-renames 2025/12/02 05:30:12 DEBUG : mega root 'rclone-test-sesobej8golu': Waiting for checks to finish 2025/12/02 05:30:12 DEBUG : potato: Need to transfer - No matching file found at Destination 2025/12/02 05:30:12 DEBUG : sub/yam: Need to transfer - No matching file found at Destination 2025/12/02 05:30:12 DEBUG : mega root 'rclone-test-sesobej8golu': Waiting for renames to finish 2025/12/02 05:30:12 DEBUG : mega root 'rclone-test-sesobej8golu': Waiting for transfers to finish 2025/12/02 05:30:15 DEBUG : sub/yam: size = 11 OK 2025/12/02 05:30:15 INFO : sub/yam: Copied (new) 2025/12/02 05:30:17 DEBUG : potato: size = 14 OK 2025/12/02 05:30:17 INFO : potato: Copied (new) 2025/12/02 05:30:17 DEBUG : Waiting for deletions to finish 2025/12/02 05:30:17 DEBUG : potato: size = 14 OK 2025/12/02 05:30:17 DEBUG : potato: Sizes identical 2025/12/02 05:30:17 DEBUG : potato: Unchanged skipping 2025/12/02 05:30:17 INFO : mega root 'rclone-test-sesobej8golu': Making map for --track-renames 2025/12/02 05:30:17 INFO : mega root 'rclone-test-sesobej8golu': Finished making map for --track-renames 2025/12/02 05:30:17 DEBUG : mega root 'rclone-test-sesobej8golu': Waiting for checks to finish 2025/12/02 05:30:17 DEBUG : mega root 'rclone-test-sesobej8golu': Waiting for renames to finish 2025/12/02 05:30:19 INFO : sub/yam: Moved (server-side) to: yam 2025/12/02 05:30:19 INFO : yam: Renamed from "sub/yam" 2025/12/02 05:30:19 DEBUG : mega root 'rclone-test-sesobej8golu': Waiting for transfers to finish 2025/12/02 05:30:19 DEBUG : Waiting for deletions to finish 2025/12/02 05:30:19 INFO : There was nothing to transfer --- PASS: TestSyncWithTrackRenamesStrategyLeaf (10.91s) === RUN TestMoveWithDeleteEmptySrcDirs run.go:185: Remote "mega root 'rclone-test-sesobej8golu'", Local "Local file system at /tmp/rclone3577906329", Modify Window "876000h0m0s" 2025/12/02 05:30:23 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2025/12/02 05:30:23 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/12/02 05:30:23 DEBUG : mega root 'rclone-test-sesobej8golu': Waiting for checks to finish 2025/12/02 05:30:23 DEBUG : mega root 'rclone-test-sesobej8golu': Waiting for transfers to finish 2025/12/02 05:30:26 DEBUG : nested/sub dir/file: size = 6 OK 2025/12/02 05:30:26 INFO : nested/sub dir/file: Copied (new) 2025/12/02 05:30:26 INFO : nested/sub dir/file: Deleted 2025/12/02 05:30:28 DEBUG : sub dir/hello world: size = 11 OK 2025/12/02 05:30:28 INFO : sub dir/hello world: Copied (new) 2025/12/02 05:30:28 INFO : sub dir/hello world: Deleted 2025/12/02 05:30:28 INFO : sub dir: Removing directory 2025/12/02 05:30:28 INFO : nested/sub dir: Removing directory 2025/12/02 05:30:28 INFO : nested: Removing directory 2025/12/02 05:30:28 DEBUG : Local file system at /tmp/rclone3577906329: deleted 3 directories run.go:130: removing dir "sub dir" failed - try 1/3: directory not empty --- PASS: TestMoveWithDeleteEmptySrcDirs (11.07s) === RUN TestServerSideMove run.go:185: Remote "mega root 'rclone-test-sesobej8golu'", Local "Local file system at /tmp/rclone3577906329", Modify Window "876000h0m0s" 2025/12/02 05:30:34 DEBUG : Creating backend with remote "TestMega:rclone-test-yirobej5mihu" 2025/12/02 05:30:34 DEBUG : mega root 'rclone-test-yirobej5mihu': Using previously stored session ID and master key to initialize the Mega API sync_test.go:1735: Server side move (if possible) mega root 'rclone-test-sesobej8golu' -> mega root 'rclone-test-yirobej5mihu' run.go:290: Failed to put "potato3" to "mega root 'rclone-test-yirobej5mihu'": failed to finish upload: unexpected end of JSON input 2025/12/02 05:31:30 DEBUG : mega root 'rclone-test-yirobej5mihu': Purge remote --- FAIL: TestServerSideMove (58.95s) === RUN TestServerSideMoveWithFilter run.go:185: Remote "mega root 'rclone-test-sesobej8golu'", Local "Local file system at /tmp/rclone3577906329", Modify Window "876000h0m0s" 2025/12/02 05:31:33 DEBUG : Creating backend with remote "TestMega:rclone-test-mehasaq1yuti" 2025/12/02 05:31:33 DEBUG : Config file has changed externally - reloading 2025/12/02 05:31:33 DEBUG : mega root 'rclone-test-mehasaq1yuti': Using previously stored session ID and master key to initialize the Mega API sync_test.go:1735: Server side move (if possible) mega root 'rclone-test-sesobej8golu' -> mega root 'rclone-test-mehasaq1yuti' 2025/12/02 05:32:00 DEBUG : empty space: Excluded (Size Filter) 2025/12/02 05:32:00 DEBUG : empty space: Excluded 2025/12/02 05:32:00 DEBUG : empty space: Excluded (Size Filter) 2025/12/02 05:32:00 DEBUG : empty space: Excluded 2025/12/02 05:32:00 DEBUG : potato2: Need to transfer - File not found at Destination 2025/12/02 05:32:00 DEBUG : mega root 'rclone-test-mehasaq1yuti': Waiting for checks to finish 2025/12/02 05:32:02 DEBUG : potato3: size = 68 (mega root 'rclone-test-sesobej8golu') 2025/12/02 05:32:02 DEBUG : potato3: size = 60 (mega root 'rclone-test-mehasaq1yuti') 2025/12/02 05:32:02 DEBUG : potato3: Sizes differ 2025/12/02 05:32:02 DEBUG : mega root 'rclone-test-mehasaq1yuti': Waiting for transfers to finish 2025/12/02 05:32:02 INFO : potato3: Deleted 2025/12/02 05:32:02 INFO : potato2: Moved (server-side) 2025/12/02 05:32:02 INFO : potato3: Moved (server-side) 2025/12/02 05:32:02 DEBUG : Creating backend with remote "TestMega:rclone-test-gorijuf3senu" 2025/12/02 05:32:02 DEBUG : mega root 'rclone-test-gorijuf3senu': Using previously stored session ID and master key to initialize the Mega API 2025/12/02 05:32:28 DEBUG : empty space: Excluded (Size Filter) 2025/12/02 05:32:28 DEBUG : empty space: Excluded 2025/12/02 05:32:28 DEBUG : potato2: Need to transfer - File not found at Destination 2025/12/02 05:32:28 DEBUG : potato3: Need to transfer - File not found at Destination 2025/12/02 05:32:28 DEBUG : mega root 'rclone-test-gorijuf3senu': Waiting for checks to finish 2025/12/02 05:32:28 DEBUG : mega root 'rclone-test-gorijuf3senu': Waiting for transfers to finish 2025/12/02 05:32:34 INFO : potato2: Moved (server-side) 2025/12/02 05:32:34 INFO : potato3: Moved (server-side) 2025/12/02 05:32:34 DEBUG : mega root 'rclone-test-gorijuf3senu': Purge remote 2025/12/02 05:32:36 DEBUG : mega root 'rclone-test-mehasaq1yuti': Purge remote --- PASS: TestServerSideMoveWithFilter (63.49s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:185: Remote "mega root 'rclone-test-sesobej8golu'", Local "Local file system at /tmp/rclone3577906329", Modify Window "876000h0m0s" 2025/12/02 05:32:37 DEBUG : Creating backend with remote "TestMega:rclone-test-zihacot2viwa" 2025/12/02 05:32:37 DEBUG : mega root 'rclone-test-zihacot2viwa': Using previously stored session ID and master key to initialize the Mega API 2025/12/02 05:33:05 INFO : tomatoDir: Making directory sync_test.go:1735: Server side move (if possible) mega root 'rclone-test-sesobej8golu' -> mega root 'rclone-test-zihacot2viwa' 2025/12/02 05:33:06 DEBUG : mega root 'rclone-test-zihacot2viwa': Using server-side directory move 2025/12/02 05:33:06 INFO : mega root 'rclone-test-zihacot2viwa': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2025/12/02 05:33:06 DEBUG : potato2: Need to transfer - File not found at Destination 2025/12/02 05:33:06 DEBUG : empty space: size = 1 OK 2025/12/02 05:33:06 DEBUG : empty space: Sizes identical 2025/12/02 05:33:06 DEBUG : empty space: Unchanged skipping 2025/12/02 05:33:06 INFO : empty space: Deleted 2025/12/02 05:33:06 DEBUG : mega root 'rclone-test-zihacot2viwa': Waiting for checks to finish 2025/12/02 05:33:06 DEBUG : potato3: size = 68 (mega root 'rclone-test-sesobej8golu') 2025/12/02 05:33:06 DEBUG : potato3: size = 60 (mega root 'rclone-test-zihacot2viwa') 2025/12/02 05:33:06 DEBUG : potato3: Sizes differ 2025/12/02 05:33:06 DEBUG : mega root 'rclone-test-zihacot2viwa': Waiting for transfers to finish 2025/12/02 05:33:06 INFO : potato3: Deleted 2025/12/02 05:33:06 INFO : potato2: Moved (server-side) 2025/12/02 05:33:06 INFO : potato3: Moved (server-side) 2025/12/02 05:33:06 INFO : tomatoDir: Removing directory 2025/12/02 05:33:06 DEBUG : mega root 'rclone-test-sesobej8golu': deleted 1 directories 2025/12/02 05:33:06 DEBUG : Creating backend with remote "TestMega:rclone-test-notocob1voko" 2025/12/02 05:33:06 DEBUG : mega root 'rclone-test-notocob1voko': Using previously stored session ID and master key to initialize the Mega API 2025/12/02 05:33:30 INFO : tomatoDir: Making directory 2025/12/02 05:33:30 DEBUG : mega root 'rclone-test-notocob1voko': Using server-side directory move 2025/12/02 05:33:30 INFO : mega root 'rclone-test-notocob1voko': Server side directory move succeeded 2025/12/02 05:33:30 ERROR : error listing: directory not found 2025/12/02 05:33:30 ERROR : error listing: directory not found 2025/12/02 05:33:30 DEBUG : mega root 'rclone-test-notocob1voko': Purge remote 2025/12/02 05:33:31 DEBUG : mega root 'rclone-test-zihacot2viwa': Purge remote 2025/12/02 05:33:31 NOTICE: purge failed: directory not found --- PASS: TestServerSideMoveDeleteEmptySourceDirs (54.06s) === RUN TestSyncOverlapWithFilter run.go:185: Remote "mega root 'rclone-test-sesobej8golu'", Local "Local file system at /tmp/rclone3577906329", Modify Window "876000h0m0s" 2025/12/02 05:33:31 DEBUG : Creating backend with remote "TestMega:rclone-test-sesobej8golu/rclone-sync-test" 2025/12/02 05:33:31 DEBUG : mega root 'rclone-test-sesobej8golu/rclone-sync-test': Using previously stored session ID and master key to initialize the Mega API 2025/12/02 05:33:52 DEBUG : Creating backend with remote "TestMega:rclone-test-sesobej8golu/rclone-sync-test-include/layer2" 2025/12/02 05:33:52 DEBUG : Config file has changed externally - reloading 2025/12/02 05:33:52 DEBUG : mega root 'rclone-test-sesobej8golu/rclone-sync-test-include/layer2': Using previously stored session ID and master key to initialize the Mega API 2025/12/02 05:34:14 DEBUG : Creating backend with remote "TestMega:rclone-test-sesobej8golu/rclone-sync-test-ignore-file" 2025/12/02 05:34:14 DEBUG : mega root 'rclone-test-sesobej8golu/rclone-sync-test-ignore-file': Using previously stored session ID and master key to initialize the Mega API 2025/12/02 05:34:35 DEBUG : rclone-sync-test: Excluded 2025/12/02 05:34:35 NOTICE: rclone-sync-test-ignore-file: Duplicate directory found in source - ignoring 2025/12/02 05:34:35 DEBUG : rclone-sync-test-include/layer2: Excluded 2025/12/02 05:34:35 DEBUG : mega root 'rclone-test-sesobej8golu/rclone-sync-test': Waiting for checks to finish 2025/12/02 05:34:35 DEBUG : mega root 'rclone-test-sesobej8golu/rclone-sync-test': Waiting for transfers to finish 2025/12/02 05:34:35 DEBUG : Waiting for deletions to finish 2025/12/02 05:34:35 INFO : There was nothing to transfer 2025/12/02 05:34:35 DEBUG : rclone-sync-test: Excluded 2025/12/02 05:34:35 NOTICE: rclone-sync-test-ignore-file: Duplicate directory found in destination - ignoring 2025/12/02 05:34:35 DEBUG : rclone-sync-test-include/layer2: Excluded 2025/12/02 05:34:35 DEBUG : mega root 'rclone-test-sesobej8golu': Waiting for checks to finish 2025/12/02 05:34:35 DEBUG : mega root 'rclone-test-sesobej8golu': Waiting for transfers to finish 2025/12/02 05:34:35 DEBUG : Waiting for deletions to finish 2025/12/02 05:34:35 INFO : rclone-sync-test-include: Removing directory 2025/12/02 05:34:35 DEBUG : rclone-sync-test-include: Failed to Rmdir: directory not empty 2025/12/02 05:34:35 INFO : rclone-sync-test-ignore-file: Removing directory 2025/12/02 05:34:35 DEBUG : mega root 'rclone-test-sesobej8golu': failed to delete 1 directories 2025/12/02 05:34:35 DEBUG : mega root 'rclone-test-sesobej8golu': deleted 1 directories 2025/12/02 05:34:35 INFO : There was nothing to transfer 2025/12/02 05:34:35 DEBUG : rclone-sync-test: Excluded 2025/12/02 05:34:35 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/12/02 05:34:35 DEBUG : rclone-sync-test-include/layer2: Excluded 2025/12/02 05:34:35 DEBUG : mega root 'rclone-test-sesobej8golu/rclone-sync-test-include/layer2': Waiting for checks to finish 2025/12/02 05:34:35 DEBUG : mega root 'rclone-test-sesobej8golu/rclone-sync-test-include/layer2': Waiting for transfers to finish 2025/12/02 05:34:35 DEBUG : Waiting for deletions to finish 2025/12/02 05:34:35 INFO : There was nothing to transfer 2025/12/02 05:34:35 DEBUG : rclone-sync-test: Excluded 2025/12/02 05:34:35 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/12/02 05:34:35 DEBUG : rclone-sync-test-include/layer2: Excluded 2025/12/02 05:34:35 DEBUG : mega root 'rclone-test-sesobej8golu': Waiting for checks to finish 2025/12/02 05:34:35 DEBUG : mega root 'rclone-test-sesobej8golu': Waiting for transfers to finish 2025/12/02 05:34:35 DEBUG : Waiting for deletions to finish 2025/12/02 05:34:35 INFO : rclone-sync-test-include: Removing directory 2025/12/02 05:34:35 DEBUG : rclone-sync-test-include: Failed to Rmdir: directory not empty 2025/12/02 05:34:35 DEBUG : mega root 'rclone-test-sesobej8golu': failed to delete 1 directories 2025/12/02 05:34:35 INFO : There was nothing to transfer 2025/12/02 05:34:35 DEBUG : rclone-sync-test: Excluded 2025/12/02 05:34:35 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/12/02 05:34:35 DEBUG : rclone-sync-test-include/layer2: Excluded 2025/12/02 05:34:35 DEBUG : mega root 'rclone-test-sesobej8golu/rclone-sync-test-ignore-file': Waiting for checks to finish 2025/12/02 05:34:35 DEBUG : mega root 'rclone-test-sesobej8golu/rclone-sync-test-ignore-file': Waiting for transfers to finish 2025/12/02 05:34:35 DEBUG : Waiting for deletions to finish 2025/12/02 05:34:35 INFO : There was nothing to transfer --- PASS: TestSyncOverlapWithFilter (65.62s) === RUN TestSyncCompareDest run.go:185: Remote "mega root 'rclone-test-sesobej8golu'", Local "Local file system at /tmp/rclone3577906329", Modify Window "876000h0m0s" 2025/12/02 05:34:36 DEBUG : Creating backend with remote "TestMega:rclone-test-sesobej8golu/dst" 2025/12/02 05:34:36 DEBUG : mega root 'rclone-test-sesobej8golu/dst': Using previously stored session ID and master key to initialize the Mega API 2025/12/02 05:35:03 DEBUG : Creating backend with remote "TestMega:rclone-test-sesobej8golu/CompareDest" 2025/12/02 05:35:03 DEBUG : mega root 'rclone-test-sesobej8golu/CompareDest': Using previously stored session ID and master key to initialize the Mega API 2025/12/02 05:35:27 DEBUG : one: Need to transfer - File not found at Destination 2025/12/02 05:35:27 DEBUG : mega root 'rclone-test-sesobej8golu/dst': Waiting for checks to finish 2025/12/02 05:35:27 DEBUG : mega root 'rclone-test-sesobej8golu/dst': Waiting for transfers to finish 2025/12/02 05:35:30 DEBUG : one: size = 3 OK 2025/12/02 05:35:30 INFO : one: Copied (new) 2025/12/02 05:35:30 DEBUG : Waiting for deletions to finish fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure 2025/12/02 05:35:37 DEBUG : one: size = 5 (Local file system at /tmp/rclone3577906329) 2025/12/02 05:35:37 DEBUG : one: size = 3 (mega root 'rclone-test-sesobej8golu/dst') 2025/12/02 05:35:37 DEBUG : one: Sizes differ 2025/12/02 05:35:37 DEBUG : mega root 'rclone-test-sesobej8golu/dst': Waiting for checks to finish 2025/12/02 05:35:37 DEBUG : mega root 'rclone-test-sesobej8golu/dst': Waiting for transfers to finish 2025/12/02 05:35:48 DEBUG : one: size = 5 OK 2025/12/02 05:35:48 INFO : one: Copied (replaced existing) 2025/12/02 05:35:48 DEBUG : Waiting for deletions to finish fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure 2025/12/02 05:36:13 DEBUG : one: size = 5 (Local file system at /tmp/rclone3577906329) 2025/12/02 05:36:13 DEBUG : one: size = 3 (mega root 'rclone-test-sesobej8golu/dst') 2025/12/02 05:36:13 DEBUG : one: Sizes differ 2025/12/02 05:36:13 DEBUG : one: size = 5 OK 2025/12/02 05:36:13 DEBUG : one: Sizes identical 2025/12/02 05:36:13 DEBUG : one: Destination found in --compare-dest, skipping 2025/12/02 05:36:13 DEBUG : mega root 'rclone-test-sesobej8golu/dst': Waiting for checks to finish 2025/12/02 05:36:13 DEBUG : mega root 'rclone-test-sesobej8golu/dst': Waiting for transfers to finish 2025/12/02 05:36:13 DEBUG : Waiting for deletions to finish 2025/12/02 05:36:13 INFO : There was nothing to transfer 2025/12/02 05:36:15 DEBUG : two: Need to transfer - File not found at Destination 2025/12/02 05:36:15 DEBUG : one: size = 5 (Local file system at /tmp/rclone3577906329) 2025/12/02 05:36:15 DEBUG : one: size = 3 (mega root 'rclone-test-sesobej8golu/dst') 2025/12/02 05:36:15 DEBUG : one: Sizes differ 2025/12/02 05:36:15 DEBUG : one: size = 5 OK 2025/12/02 05:36:15 DEBUG : one: Sizes identical 2025/12/02 05:36:15 DEBUG : one: Destination found in --compare-dest, skipping 2025/12/02 05:36:15 DEBUG : mega root 'rclone-test-sesobej8golu/dst': Waiting for checks to finish 2025/12/02 05:36:15 DEBUG : mega root 'rclone-test-sesobej8golu/dst': Waiting for transfers to finish 2025/12/02 05:36:15 DEBUG : two: size = 3 OK 2025/12/02 05:36:15 INFO : two: Copied (new) 2025/12/02 05:36:15 DEBUG : Waiting for deletions to finish 2025/12/02 05:36:15 DEBUG : one: size = 5 (Local file system at /tmp/rclone3577906329) 2025/12/02 05:36:15 DEBUG : one: size = 3 (mega root 'rclone-test-sesobej8golu/dst') 2025/12/02 05:36:15 DEBUG : one: Sizes differ 2025/12/02 05:36:15 DEBUG : one: size = 5 OK 2025/12/02 05:36:15 DEBUG : one: Sizes identical 2025/12/02 05:36:15 DEBUG : one: Destination found in --compare-dest, skipping 2025/12/02 05:36:15 DEBUG : two: size = 3 OK 2025/12/02 05:36:15 DEBUG : two: Sizes identical 2025/12/02 05:36:15 DEBUG : two: Unchanged skipping 2025/12/02 05:36:15 DEBUG : mega root 'rclone-test-sesobej8golu/dst': Waiting for checks to finish 2025/12/02 05:36:15 DEBUG : mega root 'rclone-test-sesobej8golu/dst': Waiting for transfers to finish 2025/12/02 05:36:15 DEBUG : Waiting for deletions to finish 2025/12/02 05:36:15 INFO : There was nothing to transfer sync_test.go:2205: No hash on uploaded file so skipping compare timestamp test 2025/12/02 05:36:15 DEBUG : one: size = 5 (Local file system at /tmp/rclone3577906329) 2025/12/02 05:36:15 DEBUG : one: size = 3 (mega root 'rclone-test-sesobej8golu/dst') 2025/12/02 05:36:15 DEBUG : one: Sizes differ 2025/12/02 05:36:15 DEBUG : one: size = 5 OK 2025/12/02 05:36:15 DEBUG : one: Sizes identical 2025/12/02 05:36:15 DEBUG : one: Destination found in --compare-dest, skipping 2025/12/02 05:36:15 DEBUG : two: size = 5 (Local file system at /tmp/rclone3577906329) 2025/12/02 05:36:15 DEBUG : two: size = 3 (mega root 'rclone-test-sesobej8golu/dst') 2025/12/02 05:36:15 DEBUG : two: Sizes differ 2025/12/02 05:36:15 DEBUG : two: size = 5 (Local file system at /tmp/rclone3577906329) 2025/12/02 05:36:15 DEBUG : two: size = 3 (mega root 'rclone-test-sesobej8golu/CompareDest') 2025/12/02 05:36:15 DEBUG : two: Sizes differ 2025/12/02 05:36:15 DEBUG : mega root 'rclone-test-sesobej8golu/dst': Waiting for checks to finish 2025/12/02 05:36:15 DEBUG : mega root 'rclone-test-sesobej8golu/dst': Waiting for transfers to finish 2025/12/02 05:36:19 DEBUG : two: size = 5 OK 2025/12/02 05:36:19 INFO : two: Copied (replaced existing) 2025/12/02 05:36:19 DEBUG : Waiting for deletions to finish fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure --- PASS: TestSyncCompareDest (125.15s) === RUN TestSyncBackupDir run.go:185: Remote "mega root 'rclone-test-sesobej8golu'", Local "Local file system at /tmp/rclone3577906329", Modify Window "876000h0m0s" 2025/12/02 05:36:46 DEBUG : Creating backend with remote "TestMega:rclone-test-sesobej8golu/dst" 2025/12/02 05:36:46 DEBUG : mega root 'rclone-test-sesobej8golu/dst': Using previously stored session ID and master key to initialize the Mega API 2025/12/02 05:37:10 DEBUG : Creating backend with remote "TestMega:rclone-test-sesobej8golu/backup" 2025/12/02 05:37:10 DEBUG : mega root 'rclone-test-sesobej8golu/backup': Using previously stored session ID and master key to initialize the Mega API 2025/12/02 05:37:33 DEBUG : one: size = 4 (Local file system at /tmp/rclone3577906329) 2025/12/02 05:37:33 DEBUG : one: size = 3 (mega root 'rclone-test-sesobej8golu/dst') 2025/12/02 05:37:33 DEBUG : one: Sizes differ 2025/12/02 05:37:33 DEBUG : two: size = 3 OK 2025/12/02 05:37:33 DEBUG : two: Sizes identical 2025/12/02 05:37:33 DEBUG : two: Unchanged skipping 2025/12/02 05:37:33 DEBUG : mega root 'rclone-test-sesobej8golu/dst': Waiting for checks to finish 2025/12/02 05:37:34 INFO : one: Moved (server-side) 2025/12/02 05:37:34 DEBUG : mega root 'rclone-test-sesobej8golu/dst': Waiting for transfers to finish 2025/12/02 05:37:44 ERROR : one: Failed to copy: upload file failed to create session: unexpected end of JSON input 2025/12/02 05:37:44 ERROR : mega root 'rclone-test-sesobej8golu/dst': not deleting files as there were IO errors 2025/12/02 05:37:44 ERROR : mega root 'rclone-test-sesobej8golu/dst': not deleting directories as there were IO errors sync_test.go:2415: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2415 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2457 Error: Received unexpected error: upload file failed to create session: unexpected end of JSON input Test: TestSyncBackupDir --- FAIL: TestSyncBackupDir (64.80s) === RUN TestSyncBackupDirWithSuffix run.go:185: Remote "mega root 'rclone-test-sesobej8golu'", Local "Local file system at /tmp/rclone3577906329", Modify Window "876000h0m0s" 2025/12/02 05:37:50 DEBUG : Creating backend with remote "TestMega:rclone-test-sesobej8golu/dst" 2025/12/02 05:37:50 DEBUG : mega root 'rclone-test-sesobej8golu/dst': Using previously stored session ID and master key to initialize the Mega API 2025/12/02 05:38:14 DEBUG : Creating backend with remote "TestMega:rclone-test-sesobej8golu/backup" 2025/12/02 05:38:14 DEBUG : mega root 'rclone-test-sesobej8golu/backup': Using previously stored session ID and master key to initialize the Mega API 2025/12/02 05:38:34 DEBUG : one: size = 4 (Local file system at /tmp/rclone3577906329) 2025/12/02 05:38:34 DEBUG : one: size = 3 (mega root 'rclone-test-sesobej8golu/dst') 2025/12/02 05:38:34 DEBUG : one: Sizes differ 2025/12/02 05:38:34 DEBUG : two: size = 3 OK 2025/12/02 05:38:34 DEBUG : two: Sizes identical 2025/12/02 05:38:34 DEBUG : two: Unchanged skipping 2025/12/02 05:38:34 DEBUG : mega root 'rclone-test-sesobej8golu/dst': Waiting for checks to finish 2025/12/02 05:38:45 INFO : one: Moved (server-side) to: one.bak 2025/12/02 05:38:45 DEBUG : mega root 'rclone-test-sesobej8golu/dst': Waiting for transfers to finish 2025/12/02 05:38:47 DEBUG : one: size = 4 OK 2025/12/02 05:38:47 INFO : one: Copied (new) 2025/12/02 05:38:47 DEBUG : Waiting for deletions to finish 2025/12/02 05:38:49 INFO : three.txt: Moved (server-side) to: three.txt.bak 2025/12/02 05:38:49 INFO : three.txt: Moved into backup dir fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:301: Flushing the directory cache fstest.go:305: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:345 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2428 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2461 /usr/local/go/src/runtime/asm_amd64.s:1700 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 (3), backup/three.txt.bak (5), dst/one (4), dst/two (3) fstest.go:191: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:345 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2428 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2461 Error: Should be true Test: TestSyncBackupDirWithSuffix Messages: Unexpected file "backup/one" fstest.go:203: Not found "backup/one.bak" fstest.go:206: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:206 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:310 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:345 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2428 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2461 Error: Not equal: expected: 0 actual : 1 Test: TestSyncBackupDirWithSuffix Messages: 1 objects not found fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:301: Flushing the directory cache fstest.go:305: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:345 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2434 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2461 /usr/local/go/src/runtime/asm_amd64.s:1700 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 (3), backup/three.txt.bak (5), dst/one (4), dst/three.txt (6), dst/two (3) fstest.go:191: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:345 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2434 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2461 Error: Should be true Test: TestSyncBackupDirWithSuffix Messages: Unexpected file "backup/one" fstest.go:203: Not found "backup/one.bak" fstest.go:206: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:206 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:310 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:345 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2434 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2461 Error: Not equal: expected: 0 actual : 1 Test: TestSyncBackupDirWithSuffix Messages: 1 objects not found 2025/12/02 05:39:09 DEBUG : one: size = 5 (Local file system at /tmp/rclone3577906329) 2025/12/02 05:39:09 DEBUG : one: size = 4 (mega root 'rclone-test-sesobej8golu/dst') 2025/12/02 05:39:09 DEBUG : one: Sizes differ 2025/12/02 05:39:09 DEBUG : two: size = 3 OK 2025/12/02 05:39:09 DEBUG : two: Sizes identical 2025/12/02 05:39:09 DEBUG : two: Unchanged skipping 2025/12/02 05:39:09 DEBUG : mega root 'rclone-test-sesobej8golu/dst': Waiting for checks to finish 2025/12/02 05:39:09 INFO : one: Moved (server-side) to: one.bak 2025/12/02 05:39:09 DEBUG : mega root 'rclone-test-sesobej8golu/dst': Waiting for transfers to finish 2025/12/02 05:39:10 DEBUG : one: size = 5 OK 2025/12/02 05:39:10 INFO : one: Copied (new) 2025/12/02 05:39:10 DEBUG : Waiting for deletions to finish 2025/12/02 05:39:20 INFO : three.txt.bak: Deleted 2025/12/02 05:39:25 INFO : three.txt: Moved (server-side) to: three.txt.bak 2025/12/02 05:39:25 INFO : three.txt: Moved into backup dir fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:301: Flushing the directory cache fstest.go:305: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:345 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2453 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2461 /usr/local/go/src/runtime/asm_amd64.s:1700 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 (3), backup/one.bak (4), backup/three.txt.bak (5), backup/three.txt.bak (6), dst/one (5), dst/two (3) fstest.go:191: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:345 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2453 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2461 Error: Should be true Test: TestSyncBackupDirWithSuffix Messages: Unexpected file "backup/one" fstest.go:150: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:150 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:195 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:345 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2453 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2461 Error: Not equal: expected: 6 actual : 5 Test: TestSyncBackupDirWithSuffix Messages: backup/three.txt.bak: size incorrect file=6 vs obj=5 fstest.go:191: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:345 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2453 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2461 Error: Should be true Test: TestSyncBackupDirWithSuffix Messages: Unexpected file "backup/three.txt.bak" --- FAIL: TestSyncBackupDirWithSuffix (113.10s) FAIL 2025/12/02 05:39:39 DEBUG : mega root 'rclone-test-sesobej8golu': Purge remote "./sync.test -test.v -test.timeout 1h0m0s -remote TestMega: -verbose -test.run '^(TestMoveWithDeleteEmptySrcDirs|TestServerSideMove|TestServerSideMoveDeleteEmptySourceDirs|TestServerSideMoveWithFilter|TestSyncBackupDir|TestSyncBackupDirWithSuffix|TestSyncCompareDest|TestSyncOverlapWithFilter|TestSyncWithTrackRenamesStrategyLeaf)$'" - Finished ERROR in 9m52.932806096s (try 5/5): exit status 1: Failed [TestServerSideMove TestSyncBackupDir TestSyncBackupDirWithSuffix]