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