"go test -v -timeout 1h0m0s -remote TestCompressDrive: -verbose -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Starting (try 5/5) === RUN TestIntegration fstests.go:418: Using remote "TestCompressDrive:" 2021/12/23 05:51:07 DEBUG : Creating backend with remote "TestCompressDrive:rclone-test-fegipiy7rupacip4vonebeh4" 2021/12/23 05:51:07 DEBUG : Using config file from "/home/rclone/.rclone.conf" === RUN TestIntegration/FsMkdir === RUN TestIntegration/FsMkdir/FsChangeNotify 2021/12/23 05:51:09 DEBUG : dir: Making directory 2021/12/23 05:51:10 DEBUG : dir/subdir1: Making directory 2021/12/23 05:51:11 DEBUG : dir/subdir3: Making directory 2021/12/23 05:51:11 DEBUG : Google drive root 'rclone-test-fegipiy7rupacip4vonebeh4': Checking for changes on remote 2021/12/23 05:51:12 NOTICE: Compressed: TestCompressDrive:rclone-test-fegipiy7rupacip4vonebeh4: path "dir/subdir1" entryType 0 2021/12/23 05:51:12 DEBUG : doChangeNotify("dir/subdir1", 0) 2021/12/23 05:51:12 DEBUG : dir/subdir2: Making directory 2021/12/23 05:51:12 DEBUG : Google drive root 'rclone-test-fegipiy7rupacip4vonebeh4': Checking for changes on remote 2021/12/23 05:51:13 NOTICE: Compressed: TestCompressDrive:rclone-test-fegipiy7rupacip4vonebeh4: path "dir/subdir3" entryType 0 2021/12/23 05:51:13 DEBUG : doChangeNotify("dir/subdir3", 0) 2021/12/23 05:51:13 DEBUG : Google drive root 'rclone-test-fegipiy7rupacip4vonebeh4': Checking for changes on remote 2021/12/23 05:51:14 NOTICE: Compressed: TestCompressDrive:rclone-test-fegipiy7rupacip4vonebeh4: path "dir/subdir2" entryType 0 2021/12/23 05:51:14 DEBUG : doChangeNotify("dir/subdir2", 0) 2021/12/23 05:51:14 DEBUG : Google drive root 'rclone-test-fegipiy7rupacip4vonebeh4': Checking for changes on remote 2021/12/23 05:51:15 DEBUG : Google drive root 'rclone-test-fegipiy7rupacip4vonebeh4': Checking for changes on remote 2021/12/23 05:51:16 NOTICE: Compressed: TestCompressDrive:rclone-test-fegipiy7rupacip4vonebeh4: path "dir/file2.ZAAAAAAAAAA.gz" entryType 1 2021/12/23 05:51:16 DEBUG : doChangeNotify("dir/file2.ZAAAAAAAAAA.gz.json", 1) 2021/12/23 05:51:16 DEBUG : Google drive root 'rclone-test-fegipiy7rupacip4vonebeh4': Checking for changes on remote 2021/12/23 05:51:17 NOTICE: Compressed: TestCompressDrive:rclone-test-fegipiy7rupacip4vonebeh4: path "dir/file2.json" entryType 1 2021/12/23 05:51:17 DEBUG : doChangeNotify("dir/file2.json.json", 1) 2021/12/23 05:51:17 DEBUG : Google drive root 'rclone-test-fegipiy7rupacip4vonebeh4': Checking for changes on remote 2021/12/23 05:51:18 DEBUG : Google drive root 'rclone-test-fegipiy7rupacip4vonebeh4': Checking for changes on remote 2021/12/23 05:51:19 DEBUG : Google drive root 'rclone-test-fegipiy7rupacip4vonebeh4': Checking for changes on remote 2021/12/23 05:51:20 DEBUG : Google drive root 'rclone-test-fegipiy7rupacip4vonebeh4': Checking for changes on remote 2021/12/23 05:51:21 NOTICE: Compressed: TestCompressDrive:rclone-test-fegipiy7rupacip4vonebeh4: path "dir/file4.ZAAAAAAAAAA.gz" entryType 1 2021/12/23 05:51:21 DEBUG : doChangeNotify("dir/file4.ZAAAAAAAAAA.gz.json", 1) 2021/12/23 05:51:21 DEBUG : Google drive root 'rclone-test-fegipiy7rupacip4vonebeh4': Checking for changes on remote 2021/12/23 05:51:22 NOTICE: Compressed: TestCompressDrive:rclone-test-fegipiy7rupacip4vonebeh4: path "dir/file4.json" entryType 1 2021/12/23 05:51:22 DEBUG : doChangeNotify("dir/file4.json.json", 1) 2021/12/23 05:51:22 DEBUG : Google drive root 'rclone-test-fegipiy7rupacip4vonebeh4': Checking for changes on remote 2021/12/23 05:51:23 DEBUG : Google drive root 'rclone-test-fegipiy7rupacip4vonebeh4': Checking for changes on remote 2021/12/23 05:51:24 DEBUG : Google drive root 'rclone-test-fegipiy7rupacip4vonebeh4': Checking for changes on remote 2021/12/23 05:51:25 NOTICE: Compressed: TestCompressDrive:rclone-test-fegipiy7rupacip4vonebeh4: path "dir/file3.ZAAAAAAAAAA.gz" entryType 1 2021/12/23 05:51:25 DEBUG : doChangeNotify("dir/file3.ZAAAAAAAAAA.gz.json", 1) 2021/12/23 05:51:25 DEBUG : Google drive root 'rclone-test-fegipiy7rupacip4vonebeh4': Checking for changes on remote 2021/12/23 05:51:26 DEBUG : Google drive root 'rclone-test-fegipiy7rupacip4vonebeh4': Checking for changes on remote 2021/12/23 05:51:27 NOTICE: Compressed: TestCompressDrive:rclone-test-fegipiy7rupacip4vonebeh4: path "dir/file3.json" entryType 1 2021/12/23 05:51:27 DEBUG : doChangeNotify("dir/file3.json.json", 1) fstests.go:846: Try 1/10 waiting for dirChanges and objChanges 2021/12/23 05:51:27 DEBUG : Google drive root 'rclone-test-fegipiy7rupacip4vonebeh4': Checking for changes on remote 2021/12/23 05:51:28 DEBUG : Google drive root 'rclone-test-fegipiy7rupacip4vonebeh4': Checking for changes on remote 2021/12/23 05:51:29 DEBUG : Google drive root 'rclone-test-fegipiy7rupacip4vonebeh4': Checking for changes on remote fstests.go:846: Try 2/10 waiting for dirChanges and objChanges 2021/12/23 05:51:30 DEBUG : Google drive root 'rclone-test-fegipiy7rupacip4vonebeh4': Checking for changes on remote 2021/12/23 05:51:31 DEBUG : Google drive root 'rclone-test-fegipiy7rupacip4vonebeh4': Checking for changes on remote 2021/12/23 05:51:32 DEBUG : Google drive root 'rclone-test-fegipiy7rupacip4vonebeh4': Checking for changes on remote fstests.go:846: Try 3/10 waiting for dirChanges and objChanges 2021/12/23 05:51:33 DEBUG : Google drive root 'rclone-test-fegipiy7rupacip4vonebeh4': Checking for changes on remote 2021/12/23 05:51:34 DEBUG : Google drive root 'rclone-test-fegipiy7rupacip4vonebeh4': Checking for changes on remote 2021/12/23 05:51:35 DEBUG : Google drive root 'rclone-test-fegipiy7rupacip4vonebeh4': Checking for changes on remote fstests.go:846: Try 4/10 waiting for dirChanges and objChanges 2021/12/23 05:51:36 DEBUG : Google drive root 'rclone-test-fegipiy7rupacip4vonebeh4': Checking for changes on remote 2021/12/23 05:51:37 DEBUG : Google drive root 'rclone-test-fegipiy7rupacip4vonebeh4': Checking for changes on remote 2021/12/23 05:51:38 DEBUG : Google drive root 'rclone-test-fegipiy7rupacip4vonebeh4': Checking for changes on remote fstests.go:846: Try 5/10 waiting for dirChanges and objChanges 2021/12/23 05:51:39 DEBUG : Google drive root 'rclone-test-fegipiy7rupacip4vonebeh4': Checking for changes on remote 2021/12/23 05:51:40 DEBUG : Google drive root 'rclone-test-fegipiy7rupacip4vonebeh4': Checking for changes on remote 2021/12/23 05:51:41 DEBUG : Google drive root 'rclone-test-fegipiy7rupacip4vonebeh4': Checking for changes on remote fstests.go:846: Try 6/10 waiting for dirChanges and objChanges 2021/12/23 05:51:42 DEBUG : Google drive root 'rclone-test-fegipiy7rupacip4vonebeh4': Checking for changes on remote 2021/12/23 05:51:43 DEBUG : Google drive root 'rclone-test-fegipiy7rupacip4vonebeh4': Checking for changes on remote 2021/12/23 05:51:44 DEBUG : Google drive root 'rclone-test-fegipiy7rupacip4vonebeh4': Checking for changes on remote fstests.go:846: Try 7/10 waiting for dirChanges and objChanges 2021/12/23 05:51:45 DEBUG : Google drive root 'rclone-test-fegipiy7rupacip4vonebeh4': Checking for changes on remote 2021/12/23 05:51:46 DEBUG : Google drive root 'rclone-test-fegipiy7rupacip4vonebeh4': Checking for changes on remote 2021/12/23 05:51:47 DEBUG : Google drive root 'rclone-test-fegipiy7rupacip4vonebeh4': Checking for changes on remote fstests.go:846: Try 8/10 waiting for dirChanges and objChanges 2021/12/23 05:51:48 DEBUG : Google drive root 'rclone-test-fegipiy7rupacip4vonebeh4': Checking for changes on remote 2021/12/23 05:51:49 DEBUG : Google drive root 'rclone-test-fegipiy7rupacip4vonebeh4': Checking for changes on remote 2021/12/23 05:51:50 DEBUG : Google drive root 'rclone-test-fegipiy7rupacip4vonebeh4': Checking for changes on remote fstests.go:846: Try 9/10 waiting for dirChanges and objChanges 2021/12/23 05:51:51 DEBUG : Google drive root 'rclone-test-fegipiy7rupacip4vonebeh4': Checking for changes on remote 2021/12/23 05:51:52 DEBUG : Google drive root 'rclone-test-fegipiy7rupacip4vonebeh4': Checking for changes on remote 2021/12/23 05:51:53 DEBUG : Google drive root 'rclone-test-fegipiy7rupacip4vonebeh4': Checking for changes on remote fstests.go:850: map[dir/subdir1:{} dir/subdir2:{} dir/subdir3:{}] does not contain [dir/subdir1 dir/subdir3 dir/subdir2] or map[dir/file2.ZAAAAAAAAAA.gz.json:{} dir/file2.json.json:{} dir/file3.ZAAAAAAAAAA.gz.json:{} dir/file3.json.json:{} dir/file4.ZAAAAAAAAAA.gz.json:{} dir/file4.json.json:{}] does not contain [dir/file2 dir/file4 dir/file3] 2021/12/23 05:51:54 DEBUG : Google drive root 'rclone-test-fegipiy7rupacip4vonebeh4': Checking for changes on remote 2021/12/23 05:51:55 DEBUG : Google drive root 'rclone-test-fegipiy7rupacip4vonebeh4': Checking for changes on remote 2021/12/23 05:51:56 NOTICE: Compressed: TestCompressDrive:rclone-test-fegipiy7rupacip4vonebeh4: path "dir/file2.json" entryType 1 2021/12/23 05:51:56 DEBUG : doChangeNotify("dir/file2.json.json", 1) 2021/12/23 05:51:56 NOTICE: Compressed: TestCompressDrive:rclone-test-fegipiy7rupacip4vonebeh4: path "dir/file2.ZAAAAAAAAAA.gz" entryType 1 2021/12/23 05:51:56 DEBUG : doChangeNotify("dir/file2.ZAAAAAAAAAA.gz.json", 1) 2021/12/23 05:51:56 DEBUG : Google drive root 'rclone-test-fegipiy7rupacip4vonebeh4': Checking for changes on remote 2021/12/23 05:51:57 NOTICE: Compressed: TestCompressDrive:rclone-test-fegipiy7rupacip4vonebeh4: path "dir/file4.json" entryType 1 2021/12/23 05:51:57 DEBUG : doChangeNotify("dir/file4.json.json", 1) 2021/12/23 05:51:57 DEBUG : Google drive root 'rclone-test-fegipiy7rupacip4vonebeh4': Checking for changes on remote 2021/12/23 05:51:58 NOTICE: Compressed: TestCompressDrive:rclone-test-fegipiy7rupacip4vonebeh4: path "dir/file4.ZAAAAAAAAAA.gz" entryType 1 2021/12/23 05:51:58 DEBUG : doChangeNotify("dir/file4.ZAAAAAAAAAA.gz.json", 1) 2021/12/23 05:51:58 NOTICE: Compressed: TestCompressDrive:rclone-test-fegipiy7rupacip4vonebeh4: path "dir/file3.json" entryType 1 2021/12/23 05:51:58 DEBUG : doChangeNotify("dir/file3.json.json", 1) 2021/12/23 05:51:58 DEBUG : Google drive root 'rclone-test-fegipiy7rupacip4vonebeh4': Checking for changes on remote 2021/12/23 05:51:59 NOTICE: Compressed: TestCompressDrive:rclone-test-fegipiy7rupacip4vonebeh4: path "dir/file3.ZAAAAAAAAAA.gz" entryType 1 2021/12/23 05:51:59 DEBUG : doChangeNotify("dir/file3.ZAAAAAAAAAA.gz.json", 1) 2021/12/23 05:51:59 DEBUG : Google drive root 'rclone-test-fegipiy7rupacip4vonebeh4': Checking for changes on remote 2021/12/23 05:52:00 NOTICE: Compressed: TestCompressDrive:rclone-test-fegipiy7rupacip4vonebeh4: path "dir/subdir1" entryType 0 2021/12/23 05:52:00 DEBUG : doChangeNotify("dir/subdir1", 0) 2021/12/23 05:52:00 NOTICE: Compressed: TestCompressDrive:rclone-test-fegipiy7rupacip4vonebeh4: path "dir/subdir3" entryType 0 2021/12/23 05:52:00 DEBUG : doChangeNotify("dir/subdir3", 0) 2021/12/23 05:52:00 DEBUG : Google drive root 'rclone-test-fegipiy7rupacip4vonebeh4': Checking for changes on remote 2021/12/23 05:52:01 NOTICE: Compressed: TestCompressDrive:rclone-test-fegipiy7rupacip4vonebeh4: path "dir/subdir2" entryType 0 2021/12/23 05:52:01 DEBUG : doChangeNotify("dir/subdir2", 0) 2021/12/23 05:52:01 DEBUG : dir: Rmdir: contains trashed file: "file3.ZAAAAAAAAAA.gz" 2021/12/23 05:52:01 DEBUG : dir: Rmdir: contains trashed file: "file3.json" 2021/12/23 05:52:01 DEBUG : dir: Rmdir: contains trashed file: "file4.ZAAAAAAAAAA.gz" 2021/12/23 05:52:01 DEBUG : dir: Rmdir: contains trashed file: "file4.json" 2021/12/23 05:52:01 DEBUG : dir: Rmdir: contains trashed file: "file2.json" 2021/12/23 05:52:01 DEBUG : dir: Rmdir: contains trashed file: "file2.ZAAAAAAAAAA.gz" 2021/12/23 05:52:01 DEBUG : dir: Rmdir: contains trashed file: "subdir2" 2021/12/23 05:52:01 DEBUG : dir: Rmdir: contains trashed file: "subdir3" 2021/12/23 05:52:01 DEBUG : dir: Rmdir: contains trashed file: "subdir1" --- FAIL: TestIntegration (55.76s) --- FAIL: TestIntegration/FsMkdir (53.39s) --- FAIL: TestIntegration/FsMkdir/FsChangeNotify (52.02s) FAIL exit status 1 FAIL github.com/rclone/rclone/backend/compress 55.780s "go test -v -timeout 1h0m0s -remote TestCompressDrive: -verbose -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Finished ERROR in 56.750342124s (try 5/5): exit status 1: Failed [TestIntegration/FsMkdir/FsChangeNotify]