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