"./sync.test -test.v -test.timeout 1h0m0s -remote TestMega: -verbose -test.run '^(TestSyncBackupDir|TestSyncBackupDirSuffixOnly|TestSyncBackupDirWithSuffix|TestSyncBackupDirWithSuffixKeepExtension|TestSyncCompareDest|TestSyncOverlapWithFilter)$'" - Starting (try 2/5) 2025/12/12 02:42:27 DEBUG : Creating backend with remote "TestMega:rclone-test-ricodas9qixa" 2025/12/12 02:42:27 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/12/12 02:42:27 DEBUG : mega root 'rclone-test-ricodas9qixa': Using previously stored session ID and master key to initialize the Mega API 2025/12/12 02:42:43 DEBUG : Creating backend with remote "/tmp/rclone1906434077" === RUN TestSyncOverlapWithFilter run.go:185: Remote "mega root 'rclone-test-ricodas9qixa'", Local "Local file system at /tmp/rclone1906434077", Modify Window "876000h0m0s" 2025/12/12 02:42:43 DEBUG : Creating backend with remote "TestMega:rclone-test-ricodas9qixa/rclone-sync-test" 2025/12/12 02:42:43 DEBUG : mega root 'rclone-test-ricodas9qixa/rclone-sync-test': Using previously stored session ID and master key to initialize the Mega API 2025/12/12 02:43:01 DEBUG : Creating backend with remote "TestMega:rclone-test-ricodas9qixa/rclone-sync-test-include/layer2" 2025/12/12 02:43:01 DEBUG : mega root 'rclone-test-ricodas9qixa/rclone-sync-test-include/layer2': Using previously stored session ID and master key to initialize the Mega API 2025/12/12 02:43:17 DEBUG : Creating backend with remote "TestMega:rclone-test-ricodas9qixa/rclone-sync-test-ignore-file" 2025/12/12 02:43:17 DEBUG : mega root 'rclone-test-ricodas9qixa/rclone-sync-test-ignore-file': Using previously stored session ID and master key to initialize the Mega API 2025/12/12 02:47:43 DEBUG : rclone-sync-test: Excluded 2025/12/12 02:47:43 NOTICE: rclone-sync-test-ignore-file: Duplicate directory found in source - ignoring 2025/12/12 02:47:43 DEBUG : rclone-sync-test-include/layer2: Excluded 2025/12/12 02:47:43 DEBUG : mega root 'rclone-test-ricodas9qixa/rclone-sync-test': Waiting for checks to finish 2025/12/12 02:47:43 DEBUG : mega root 'rclone-test-ricodas9qixa/rclone-sync-test': Waiting for transfers to finish 2025/12/12 02:47:43 DEBUG : Waiting for deletions to finish 2025/12/12 02:47:43 INFO : There was nothing to transfer 2025/12/12 02:47:43 DEBUG : rclone-sync-test: Excluded 2025/12/12 02:47:43 NOTICE: rclone-sync-test-ignore-file: Duplicate directory found in destination - ignoring 2025/12/12 02:47:43 DEBUG : rclone-sync-test-include/layer2: Excluded 2025/12/12 02:47:43 DEBUG : mega root 'rclone-test-ricodas9qixa': Waiting for checks to finish 2025/12/12 02:47:43 DEBUG : mega root 'rclone-test-ricodas9qixa': Waiting for transfers to finish 2025/12/12 02:47:43 DEBUG : Waiting for deletions to finish 2025/12/12 02:47:43 INFO : rclone-sync-test-include: Removing directory 2025/12/12 02:47:43 DEBUG : rclone-sync-test-include: Failed to Rmdir: directory not empty 2025/12/12 02:47:43 INFO : rclone-sync-test-ignore-file: Removing directory 2025/12/12 02:47:44 DEBUG : mega root 'rclone-test-ricodas9qixa': failed to delete 1 directories 2025/12/12 02:47:44 DEBUG : mega root 'rclone-test-ricodas9qixa': deleted 1 directories 2025/12/12 02:47:44 INFO : There was nothing to transfer 2025/12/12 02:47:44 DEBUG : rclone-sync-test: Excluded 2025/12/12 02:47:44 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/12/12 02:47:44 DEBUG : rclone-sync-test-include/layer2: Excluded 2025/12/12 02:47:44 DEBUG : mega root 'rclone-test-ricodas9qixa/rclone-sync-test-include/layer2': Waiting for checks to finish 2025/12/12 02:47:44 DEBUG : mega root 'rclone-test-ricodas9qixa/rclone-sync-test-include/layer2': Waiting for transfers to finish 2025/12/12 02:47:44 DEBUG : Waiting for deletions to finish 2025/12/12 02:47:44 INFO : There was nothing to transfer 2025/12/12 02:47:44 DEBUG : rclone-sync-test: Excluded 2025/12/12 02:47:44 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/12/12 02:47:44 DEBUG : rclone-sync-test-include/layer2: Excluded 2025/12/12 02:47:44 DEBUG : mega root 'rclone-test-ricodas9qixa': Waiting for checks to finish 2025/12/12 02:47:44 DEBUG : mega root 'rclone-test-ricodas9qixa': Waiting for transfers to finish 2025/12/12 02:47:44 DEBUG : Waiting for deletions to finish 2025/12/12 02:47:44 INFO : rclone-sync-test-include: Removing directory 2025/12/12 02:47:44 DEBUG : rclone-sync-test-include: Failed to Rmdir: directory not empty 2025/12/12 02:47:44 DEBUG : mega root 'rclone-test-ricodas9qixa': failed to delete 1 directories 2025/12/12 02:47:44 INFO : There was nothing to transfer 2025/12/12 02:47:44 DEBUG : rclone-sync-test: Excluded 2025/12/12 02:47:44 DEBUG : rclone-sync-test-ignore-file: Excluded 2025/12/12 02:47:44 DEBUG : rclone-sync-test-include/layer2: Excluded 2025/12/12 02:47:44 DEBUG : mega root 'rclone-test-ricodas9qixa/rclone-sync-test-ignore-file': Waiting for checks to finish 2025/12/12 02:47:44 DEBUG : mega root 'rclone-test-ricodas9qixa/rclone-sync-test-ignore-file': Waiting for transfers to finish 2025/12/12 02:47:44 DEBUG : Waiting for deletions to finish 2025/12/12 02:47:44 INFO : There was nothing to transfer --- PASS: TestSyncOverlapWithFilter (301.88s) === RUN TestSyncCompareDest run.go:185: Remote "mega root 'rclone-test-ricodas9qixa'", Local "Local file system at /tmp/rclone1906434077", Modify Window "876000h0m0s" 2025/12/12 02:47:45 DEBUG : Creating backend with remote "TestMega:rclone-test-ricodas9qixa/dst" 2025/12/12 02:47:45 DEBUG : mega root 'rclone-test-ricodas9qixa/dst': Using previously stored session ID and master key to initialize the Mega API 2025/12/12 02:48:01 DEBUG : Creating backend with remote "TestMega:rclone-test-ricodas9qixa/CompareDest" 2025/12/12 02:48:01 DEBUG : mega root 'rclone-test-ricodas9qixa/CompareDest': Using previously stored session ID and master key to initialize the Mega API 2025/12/12 02:48:17 DEBUG : one: Need to transfer - File not found at Destination 2025/12/12 02:48:17 DEBUG : mega root 'rclone-test-ricodas9qixa/dst': Waiting for checks to finish 2025/12/12 02:48:17 DEBUG : mega root 'rclone-test-ricodas9qixa/dst': Waiting for transfers to finish 2025/12/12 02:48:17 DEBUG : one: size = 3 OK 2025/12/12 02:48:17 INFO : one: Copied (new) 2025/12/12 02:48:17 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/12 02:48:24 DEBUG : one: size = 5 (Local file system at /tmp/rclone1906434077) 2025/12/12 02:48:24 DEBUG : one: size = 3 (mega root 'rclone-test-ricodas9qixa/dst') 2025/12/12 02:48:24 DEBUG : one: Sizes differ 2025/12/12 02:48:24 DEBUG : mega root 'rclone-test-ricodas9qixa/dst': Waiting for checks to finish 2025/12/12 02:48:24 DEBUG : mega root 'rclone-test-ricodas9qixa/dst': Waiting for transfers to finish 2025/12/12 02:48:24 DEBUG : one: size = 5 OK 2025/12/12 02:48:24 INFO : one: Copied (replaced existing) 2025/12/12 02:48:24 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/12 02:48:34 DEBUG : mega root 'rclone-test-ricodas9qixa/dst': Waiting for checks to finish 2025/12/12 02:48:34 DEBUG : one: size = 5 (Local file system at /tmp/rclone1906434077) 2025/12/12 02:48:34 DEBUG : one: size = 3 (mega root 'rclone-test-ricodas9qixa/dst') 2025/12/12 02:48:34 DEBUG : one: Sizes differ 2025/12/12 02:48:34 DEBUG : mega root 'rclone-test-ricodas9qixa/dst': Waiting for transfers to finish 2025/12/12 02:48:36 DEBUG : one: size = 5 OK 2025/12/12 02:48:36 INFO : one: Copied (replaced existing) 2025/12/12 02:48:36 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: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:2152 Error: Should be true Test: TestSyncCompareDest Messages: listing wrong, want CompareDest/one (5), dst/one (3) got CompareDest/one (5), dst/one (5) 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:2152 Error: Not equal: expected: 3 actual : 5 Test: TestSyncCompareDest Messages: dst/one: size incorrect file=3 vs obj=5 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:2157 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 (5) 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:2157 Error: Not equal: expected: 3 actual : 5 Test: TestSyncCompareDest Messages: dst/one: size incorrect file=3 vs obj=5 2025/12/12 02:48:51 DEBUG : two: size = 3 OK 2025/12/12 02:48:51 DEBUG : two: Sizes identical 2025/12/12 02:48:51 DEBUG : two: Destination found in --compare-dest, skipping 2025/12/12 02:48:51 DEBUG : one: size = 5 OK 2025/12/12 02:48:51 DEBUG : one: Sizes identical 2025/12/12 02:48:51 DEBUG : one: Unchanged skipping 2025/12/12 02:48:51 DEBUG : mega root 'rclone-test-ricodas9qixa/dst': Waiting for checks to finish 2025/12/12 02:48:51 DEBUG : mega root 'rclone-test-ricodas9qixa/dst': Waiting for transfers to finish 2025/12/12 02:48:51 DEBUG : Waiting for deletions to finish 2025/12/12 02:48:51 INFO : There was nothing to transfer 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:2166 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 (5) 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:2166 Error: Not equal: expected: 3 actual : 5 Test: TestSyncCompareDest Messages: dst/one: size incorrect file=3 vs obj=5 2025/12/12 02:48:58 DEBUG : two: size = 3 OK 2025/12/12 02:48:58 DEBUG : two: Sizes identical 2025/12/12 02:48:58 DEBUG : two: Destination found in --compare-dest, skipping 2025/12/12 02:48:58 DEBUG : one: size = 5 OK 2025/12/12 02:48:58 DEBUG : one: Sizes identical 2025/12/12 02:48:58 DEBUG : one: Unchanged skipping 2025/12/12 02:48:58 DEBUG : mega root 'rclone-test-ricodas9qixa/dst': Waiting for checks to finish 2025/12/12 02:48:58 DEBUG : mega root 'rclone-test-ricodas9qixa/dst': Waiting for transfers to finish 2025/12/12 02:48:58 DEBUG : Waiting for deletions to finish 2025/12/12 02:48:58 INFO : There was nothing to transfer 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:2175 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 (5) 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:2175 Error: Not equal: expected: 3 actual : 5 Test: TestSyncCompareDest Messages: dst/one: size incorrect file=3 vs obj=5 sync_test.go:2206: No hash on uploaded file so skipping compare timestamp test 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:2211 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 (5) 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:2211 Error: Not equal: expected: 3 actual : 5 Test: TestSyncCompareDest Messages: dst/one: size incorrect file=3 vs obj=5 2025/12/12 02:49:12 DEBUG : two: size = 5 (Local file system at /tmp/rclone1906434077) 2025/12/12 02:49:12 DEBUG : two: size = 3 (mega root 'rclone-test-ricodas9qixa/CompareDest') 2025/12/12 02:49:12 DEBUG : two: Sizes differ 2025/12/12 02:49:12 DEBUG : two: Need to transfer - File not found at Destination 2025/12/12 02:49:12 DEBUG : one: size = 5 OK 2025/12/12 02:49:12 DEBUG : mega root 'rclone-test-ricodas9qixa/dst': Waiting for checks to finish 2025/12/12 02:49:12 DEBUG : one: Sizes identical 2025/12/12 02:49:12 DEBUG : one: Unchanged skipping 2025/12/12 02:49:12 DEBUG : mega root 'rclone-test-ricodas9qixa/dst': Waiting for transfers to finish 2025/12/12 02:49:12 DEBUG : two: size = 5 OK 2025/12/12 02:49:12 INFO : two: Copied (new) 2025/12/12 02:49:12 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: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:2223 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 (5), dst/two (5) 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:2223 Error: Not equal: expected: 3 actual : 5 Test: TestSyncCompareDest Messages: dst/one: size incorrect file=3 vs obj=5 --- FAIL: TestSyncCompareDest (97.52s) === RUN TestSyncBackupDir run.go:185: Remote "mega root 'rclone-test-ricodas9qixa'", Local "Local file system at /tmp/rclone1906434077", Modify Window "876000h0m0s" 2025/12/12 02:49:24 DEBUG : Creating backend with remote "TestMega:rclone-test-ricodas9qixa/dst" 2025/12/12 02:49:24 DEBUG : mega root 'rclone-test-ricodas9qixa/dst': Using previously stored session ID and master key to initialize the Mega API 2025/12/12 02:49:40 DEBUG : Creating backend with remote "TestMega:rclone-test-ricodas9qixa/backup" 2025/12/12 02:49:40 DEBUG : mega root 'rclone-test-ricodas9qixa/backup': Using previously stored session ID and master key to initialize the Mega API 2025/12/12 02:49:56 DEBUG : mega root 'rclone-test-ricodas9qixa/dst': Waiting for checks to finish 2025/12/12 02:49:56 DEBUG : one: size = 4 (Local file system at /tmp/rclone1906434077) 2025/12/12 02:49:56 DEBUG : one: size = 3 (mega root 'rclone-test-ricodas9qixa/dst') 2025/12/12 02:49:56 DEBUG : one: Sizes differ 2025/12/12 02:49:56 DEBUG : two: size = 3 OK 2025/12/12 02:49:56 DEBUG : two: Sizes identical 2025/12/12 02:49:56 DEBUG : two: Unchanged skipping 2025/12/12 02:49:59 INFO : one: Moved (server-side) 2025/12/12 02:49:59 DEBUG : mega root 'rclone-test-ricodas9qixa/dst': Waiting for transfers to finish 2025/12/12 02:49:59 DEBUG : one: size = 4 OK 2025/12/12 02:49:59 INFO : one: Copied (new) 2025/12/12 02:49:59 DEBUG : Waiting for deletions to finish 2025/12/12 02:49:59 INFO : three.txt: Moved (server-side) 2025/12/12 02:49:59 INFO : three.txt: Moved into backup dir 2025/12/12 02:50:00 DEBUG : one: size = 5 (Local file system at /tmp/rclone1906434077) 2025/12/12 02:50:00 DEBUG : one: size = 4 (mega root 'rclone-test-ricodas9qixa/dst') 2025/12/12 02:50:00 DEBUG : one: Sizes differ 2025/12/12 02:50:00 DEBUG : mega root 'rclone-test-ricodas9qixa/dst': Waiting for checks to finish 2025/12/12 02:50:00 DEBUG : two: size = 3 OK 2025/12/12 02:50:00 DEBUG : two: Sizes identical 2025/12/12 02:50:00 DEBUG : two: Unchanged skipping 2025/12/12 02:50:00 INFO : one: Deleted 2025/12/12 02:50:00 INFO : one: Moved (server-side) 2025/12/12 02:50:00 DEBUG : mega root 'rclone-test-ricodas9qixa/dst': Waiting for transfers to finish 2025/12/12 02:50:02 DEBUG : one: size = 5 OK 2025/12/12 02:50:02 INFO : one: Copied (new) 2025/12/12 02:50:02 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: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:2454 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2458 /usr/local/go/src/runtime/asm_amd64.s:1700 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 (5), dst/one (5), dst/three.txt (6), dst/two (3) 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:2454 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2458 Error: Not equal: expected: 6 actual : 5 Test: TestSyncBackupDir Messages: backup/three.txt: 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:2454 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2458 Error: Should be true Test: TestSyncBackupDir Messages: Unexpected file "dst/three.txt" --- FAIL: TestSyncBackupDir (50.02s) === RUN TestSyncBackupDirWithSuffix run.go:185: Remote "mega root 'rclone-test-ricodas9qixa'", Local "Local file system at /tmp/rclone1906434077", Modify Window "876000h0m0s" 2025/12/12 02:50:13 DEBUG : Creating backend with remote "TestMega:rclone-test-ricodas9qixa/dst" 2025/12/12 02:50:13 DEBUG : mega root 'rclone-test-ricodas9qixa/dst': Using previously stored session ID and master key to initialize the Mega API 2025/12/12 02:50:28 DEBUG : Creating backend with remote "TestMega:rclone-test-ricodas9qixa/backup" 2025/12/12 02:50:28 DEBUG : mega root 'rclone-test-ricodas9qixa/backup': Using previously stored session ID and master key to initialize the Mega API 2025/12/12 02:50:44 DEBUG : one: size = 4 (Local file system at /tmp/rclone1906434077) 2025/12/12 02:50:44 DEBUG : one: size = 3 (mega root 'rclone-test-ricodas9qixa/dst') 2025/12/12 02:50:44 DEBUG : one: Sizes differ 2025/12/12 02:50:44 DEBUG : two: size = 3 OK 2025/12/12 02:50:44 DEBUG : mega root 'rclone-test-ricodas9qixa/dst': Waiting for checks to finish 2025/12/12 02:50:44 DEBUG : two: Sizes identical 2025/12/12 02:50:44 DEBUG : two: Unchanged skipping 2025/12/12 02:50:44 INFO : one: Moved (server-side) to: one.bak 2025/12/12 02:50:44 DEBUG : mega root 'rclone-test-ricodas9qixa/dst': Waiting for transfers to finish 2025/12/12 02:50:45 DEBUG : one: size = 4 OK 2025/12/12 02:50:45 INFO : one: Copied (new) 2025/12/12 02:50:45 DEBUG : Waiting for deletions to finish 2025/12/12 02:50:47 INFO : three.txt: Moved (server-side) to: three.txt.bak 2025/12/12 02:50:47 INFO : three.txt: Moved into backup dir 2025/12/12 02:50:47 DEBUG : two: size = 3 OK 2025/12/12 02:50:47 DEBUG : two: Sizes identical 2025/12/12 02:50:47 DEBUG : two: Unchanged skipping 2025/12/12 02:50:47 DEBUG : one: size = 5 (Local file system at /tmp/rclone1906434077) 2025/12/12 02:50:47 DEBUG : one: size = 4 (mega root 'rclone-test-ricodas9qixa/dst') 2025/12/12 02:50:47 DEBUG : one: Sizes differ 2025/12/12 02:50:47 DEBUG : mega root 'rclone-test-ricodas9qixa/dst': Waiting for checks to finish 2025/12/12 02:50:47 INFO : one.bak: Deleted 2025/12/12 02:50:48 INFO : one: Moved (server-side) to: one.bak 2025/12/12 02:50:48 DEBUG : mega root 'rclone-test-ricodas9qixa/dst': Waiting for transfers to finish 2025/12/12 02:50:50 DEBUG : one: size = 5 OK 2025/12/12 02:50:50 INFO : one: Copied (new) 2025/12/12 02:50:50 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: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:2454 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2462 /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.bak (4), backup/three.txt.bak (5), dst/one (5), dst/three.txt (6), dst/two (3) 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:2454 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2462 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:2454 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2462 Error: Should be true Test: TestSyncBackupDirWithSuffix Messages: Unexpected file "dst/three.txt" --- FAIL: TestSyncBackupDirWithSuffix (45.34s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:185: Remote "mega root 'rclone-test-ricodas9qixa'", Local "Local file system at /tmp/rclone1906434077", Modify Window "876000h0m0s" 2025/12/12 02:51:04 DEBUG : Creating backend with remote "TestMega:rclone-test-ricodas9qixa/dst" 2025/12/12 02:51:04 DEBUG : mega root 'rclone-test-ricodas9qixa/dst': Using previously stored session ID and master key to initialize the Mega API 2025/12/12 02:51:20 DEBUG : Creating backend with remote "TestMega:rclone-test-ricodas9qixa/backup" 2025/12/12 02:51:20 DEBUG : mega root 'rclone-test-ricodas9qixa/backup': Using previously stored session ID and master key to initialize the Mega API 2025/12/12 02:51:37 DEBUG : one: size = 4 (Local file system at /tmp/rclone1906434077) 2025/12/12 02:51:37 DEBUG : one: size = 3 (mega root 'rclone-test-ricodas9qixa/dst') 2025/12/12 02:51:37 DEBUG : one: Sizes differ 2025/12/12 02:51:37 DEBUG : two: size = 3 OK 2025/12/12 02:51:37 DEBUG : two: Sizes identical 2025/12/12 02:51:37 DEBUG : mega root 'rclone-test-ricodas9qixa/dst': Waiting for checks to finish 2025/12/12 02:51:37 DEBUG : two: Unchanged skipping 2025/12/12 02:51:40 INFO : one: Moved (server-side) to: one-2019-01-01 2025/12/12 02:51:40 DEBUG : mega root 'rclone-test-ricodas9qixa/dst': Waiting for transfers to finish 2025/12/12 02:51:42 DEBUG : one: size = 4 OK 2025/12/12 02:51:42 INFO : one: Copied (new) 2025/12/12 02:51:42 DEBUG : Waiting for deletions to finish 2025/12/12 02:51:42 INFO : three.txt: Moved (server-side) to: three-2019-01-01.txt 2025/12/12 02:51:42 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:292: Sleeping for 6s just to make sure 2025/12/12 02:51:49 DEBUG : one: size = 5 (Local file system at /tmp/rclone1906434077) 2025/12/12 02:51:49 DEBUG : one: size = 4 (mega root 'rclone-test-ricodas9qixa/dst') 2025/12/12 02:51:49 DEBUG : one: Sizes differ 2025/12/12 02:51:49 DEBUG : two: size = 3 OK 2025/12/12 02:51:49 DEBUG : two: Sizes identical 2025/12/12 02:51:49 DEBUG : two: Unchanged skipping 2025/12/12 02:51:49 DEBUG : mega root 'rclone-test-ricodas9qixa/dst': Waiting for checks to finish 2025/12/12 02:51:49 INFO : one-2019-01-01: Deleted 2025/12/12 02:51:50 INFO : one: Moved (server-side) to: one-2019-01-01 2025/12/12 02:51:50 DEBUG : mega root 'rclone-test-ricodas9qixa/dst': Waiting for transfers to finish 2025/12/12 02:51:52 DEBUG : one: size = 5 OK 2025/12/12 02:51:52 INFO : one: Copied (new) 2025/12/12 02:51:52 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: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:2454 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2466 /usr/local/go/src/runtime/asm_amd64.s:1700 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 (5), dst/one (5), 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:2454 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2466 Error: Should be true Test: TestSyncBackupDirWithSuffixKeepExtension Messages: Unexpected file "dst/three.txt" 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:2454 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2466 Error: Not equal: expected: 6 actual : 5 Test: TestSyncBackupDirWithSuffixKeepExtension Messages: backup/three-2019-01-01.txt: size incorrect file=6 vs obj=5 --- FAIL: TestSyncBackupDirWithSuffixKeepExtension (64.63s) === RUN TestSyncBackupDirSuffixOnly run.go:185: Remote "mega root 'rclone-test-ricodas9qixa'", Local "Local file system at /tmp/rclone1906434077", Modify Window "876000h0m0s" 2025/12/12 02:52:03 DEBUG : Creating backend with remote "TestMega:rclone-test-ricodas9qixa/dst" 2025/12/12 02:52:03 DEBUG : Config file has changed externally - reloading 2025/12/12 02:52:03 DEBUG : mega root 'rclone-test-ricodas9qixa/dst': Using previously stored session ID and master key to initialize the Mega API 2025/12/12 02:52:20 DEBUG : one: size = 4 (Local file system at /tmp/rclone1906434077) 2025/12/12 02:52:20 DEBUG : one: size = 3 (mega root 'rclone-test-ricodas9qixa/dst') 2025/12/12 02:52:20 DEBUG : two: size = 3 OK 2025/12/12 02:52:20 DEBUG : two: Sizes identical 2025/12/12 02:52:20 DEBUG : two: Unchanged skipping 2025/12/12 02:52:20 DEBUG : mega root 'rclone-test-ricodas9qixa/dst': Waiting for checks to finish 2025/12/12 02:52:20 DEBUG : one: Sizes differ 2025/12/12 02:52:20 INFO : one: Moved (server-side) to: one.bak 2025/12/12 02:52:20 DEBUG : mega root 'rclone-test-ricodas9qixa/dst': Waiting for transfers to finish 2025/12/12 02:52:20 DEBUG : one: size = 4 OK 2025/12/12 02:52:20 INFO : one: Copied (new) 2025/12/12 02:52:20 DEBUG : Waiting for deletions to finish 2025/12/12 02:52:20 INFO : three.txt: Moved (server-side) to: three.txt.bak 2025/12/12 02:52:20 INFO : three.txt: Moved into backup dir 2025/12/12 02:52:21 DEBUG : one.bak: Excluded (Path Filter) 2025/12/12 02:52:21 DEBUG : one.bak: Excluded 2025/12/12 02:52:21 DEBUG : three.txt.bak: Excluded (Path Filter) 2025/12/12 02:52:21 DEBUG : three.txt.bak: Excluded 2025/12/12 02:52:21 DEBUG : one: size = 5 (Local file system at /tmp/rclone1906434077) 2025/12/12 02:52:21 DEBUG : one: size = 4 (mega root 'rclone-test-ricodas9qixa/dst') 2025/12/12 02:52:21 DEBUG : one: Sizes differ 2025/12/12 02:52:21 DEBUG : mega root 'rclone-test-ricodas9qixa/dst': Waiting for checks to finish 2025/12/12 02:52:21 INFO : one.bak: Deleted 2025/12/12 02:52:21 DEBUG : two: size = 3 OK 2025/12/12 02:52:21 DEBUG : two: Sizes identical 2025/12/12 02:52:21 DEBUG : two: Unchanged skipping 2025/12/12 02:52:21 INFO : one: Moved (server-side) to: one.bak 2025/12/12 02:52:21 DEBUG : mega root 'rclone-test-ricodas9qixa/dst': Waiting for transfers to finish 2025/12/12 02:52:23 DEBUG : one: size = 5 OK 2025/12/12 02:52:23 INFO : one: Copied (new) 2025/12/12 02:52:23 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: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:2454 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2470 /usr/local/go/src/runtime/asm_amd64.s:1700 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 (6), dst/three.txt.bak (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:2454 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2470 Error: Should be true Test: TestSyncBackupDirSuffixOnly Messages: Unexpected file "dst/three.txt" 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:2454 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2470 Error: Not equal: expected: 6 actual : 5 Test: TestSyncBackupDirSuffixOnly Messages: dst/three.txt.bak: size incorrect file=6 vs obj=5 --- FAIL: TestSyncBackupDirSuffixOnly (29.08s) FAIL 2025/12/12 02:52:31 DEBUG : mega root 'rclone-test-ricodas9qixa': Purge remote "./sync.test -test.v -test.timeout 1h0m0s -remote TestMega: -verbose -test.run '^(TestSyncBackupDir|TestSyncBackupDirSuffixOnly|TestSyncBackupDirWithSuffix|TestSyncBackupDirWithSuffixKeepExtension|TestSyncCompareDest|TestSyncOverlapWithFilter)$'" - Finished ERROR in 10m4.566183591s (try 2/5): exit status 1: Failed [TestSyncCompareDest TestSyncBackupDir TestSyncBackupDirWithSuffix TestSyncBackupDirWithSuffixKeepExtension TestSyncBackupDirSuffixOnly]