"go test -v -timeout 1h0m0s -remote TestBox: -verbose -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Starting (try 3/5) === RUN TestIntegration fstests.go:438: Using remote "TestBox:" 2025/03/07 09:18:52 DEBUG : Creating backend with remote "TestBox:rclone-test-ginudok5ladu" 2025/03/07 09:18:52 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/03/07 09:18:52 DEBUG : box root 'rclone-test-ginudok5ladu': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/03/07 09:18:53 DEBUG : box root 'rclone-test-ginudok5ladu': Ignoring "Shared folder — ForNick" - unknown type "web_link" === RUN TestIntegration/FsMkdir === RUN TestIntegration/FsMkdir/FsChangeNotify 2025/03/07 09:18:55 INFO : dir: Making directory 2025/03/07 09:18:56 INFO : dir/subdir1: Making directory 2025/03/07 09:18:57 DEBUG : box root 'rclone-test-ginudok5ladu': Checking for changes on remote (next_stream_position: "30401038823883270") 2025/03/07 09:18:57 INFO : dir/subdir3: Making directory 2025/03/07 09:18:58 DEBUG : box root 'rclone-test-ginudok5ladu': Checking for changes on remote (next_stream_position: "30401038823884521") 2025/03/07 09:18:58 INFO : dir/subdir2: Making directory 2025/03/07 09:18:58 DEBUG : box root 'rclone-test-ginudok5ladu': ["subdir2"(0)|folder|ITEM_CREATE|310581165150|80ab0cec7a2622d172cc268713fc3802650a86c1] new parent not found 2025/03/07 09:18:58 DEBUG : box root 'rclone-test-ginudok5ladu': Received 2 events, resulting in 0 paths and 0 notifications 2025/03/07 09:18:58 DEBUG : box root 'rclone-test-ginudok5ladu': Checking for changes on remote (next_stream_position: "30401038823885519") 2025/03/07 09:18:59 DEBUG : box root 'rclone-test-ginudok5ladu': Received 2 events, resulting in 0 paths and 0 notifications 2025/03/07 09:18:59 DEBUG : box root 'rclone-test-ginudok5ladu': Checking for changes on remote (next_stream_position: "30401038823885763") 2025/03/07 09:18:59 DEBUG : box root 'rclone-test-ginudok5ladu': Checking for changes on remote (next_stream_position: "30401038823886006") 2025/03/07 09:19:00 DEBUG : box root 'rclone-test-ginudok5ladu': Checking for changes on remote (next_stream_position: "30401038823886514") 2025/03/07 09:19:00 DEBUG : box root 'rclone-test-ginudok5ladu': ["subdir3"(1)|folder|ITEM_TRASH|310581236507|57a7220553c91239234a4e0831f862a2641e7f16] ignored due to duplicate EventID 2025/03/07 09:19:01 DEBUG : box root 'rclone-test-ginudok5ladu': Checking for changes on remote (next_stream_position: "30401038823887506") 2025/03/07 09:19:02 DEBUG : box root 'rclone-test-ginudok5ladu': Checking for changes on remote (next_stream_position: "30401038823888513") 2025/03/07 09:19:02 DEBUG : box root 'rclone-test-ginudok5ladu': ["subdir1"(1)|folder|ITEM_TRASH|310581412212|f6b9bdf6f2e6b7843d91bd9e544c2780f07d6eae] ignored due to duplicate EventID 2025/03/07 09:19:02 DEBUG : box root 'rclone-test-ginudok5ladu': Received 2 events, resulting in 0 paths and 0 notifications 2025/03/07 09:19:02 DEBUG : box root 'rclone-test-ginudok5ladu': Checking for changes on remote (next_stream_position: "30401038823889505") 2025/03/07 09:19:02 DEBUG : box root 'rclone-test-ginudok5ladu': ["subdir1"(1)|folder|ITEM_TRASH|310581412212|f6b9bdf6f2e6b7843d91bd9e544c2780f07d6eae] ignored due to duplicate EventID 2025/03/07 09:19:03 DEBUG : box root 'rclone-test-ginudok5ladu': Checking for changes on remote (next_stream_position: "30401038823889749") 2025/03/07 09:19:04 DEBUG : box root 'rclone-test-ginudok5ladu': Checking for changes on remote (next_stream_position: "30401038823890510") 2025/03/07 09:19:04 DEBUG : box root 'rclone-test-ginudok5ladu': ["rclone-test-yibazen7towa"(1)|folder|ITEM_TRASH|310583020499|778e246ef5b1f60d503fab331fd036c04ce41728] ignored due to duplicate EventID 2025/03/07 09:19:04 DEBUG : box root 'rclone-test-ginudok5ladu': Received 2 events, resulting in 0 paths and 0 notifications 2025/03/07 09:19:04 DEBUG : box root 'rclone-test-ginudok5ladu': Checking for changes on remote (next_stream_position: "30401038823891502") 2025/03/07 09:19:04 DEBUG : box root 'rclone-test-ginudok5ladu': ["rclone-test-yibazen7towa"(1)|folder|ITEM_TRASH|310583020499|778e246ef5b1f60d503fab331fd036c04ce41728] ignored due to duplicate EventID 2025/03/07 09:19:04 DEBUG : box root 'rclone-test-ginudok5ladu': ["subdir2"(1)|folder|ITEM_TRASH|310581165150|1c0d452d42ad3020f1968d3f0389a670638ed845] ignored due to duplicate EventID 2025/03/07 09:19:05 DEBUG : box root 'rclone-test-ginudok5ladu': Checking for changes on remote (next_stream_position: "30401038823891741") 2025/03/07 09:19:06 DEBUG : box root 'rclone-test-ginudok5ladu': Checking for changes on remote (next_stream_position: "30401038823892513") fstests.go:931: Try 1/10 waiting for dirChanges and objChanges 2025/03/07 09:19:06 DEBUG : box root 'rclone-test-ginudok5ladu': ["rclone-test-yibazen7towa"(1)|folder|ITEM_TRASH|310583020499|778e246ef5b1f60d503fab331fd036c04ce41728] ignored due to duplicate EventID 2025/03/07 09:19:07 DEBUG : box root 'rclone-test-ginudok5ladu': Checking for changes on remote (next_stream_position: "30401038823893516") 2025/03/07 09:19:07 DEBUG : box root 'rclone-test-ginudok5ladu': ["subdir2"(1)|folder|ITEM_TRASH|310581165150|1c0d452d42ad3020f1968d3f0389a670638ed845] ignored due to duplicate EventID 2025/03/07 09:19:07 DEBUG : box root 'rclone-test-ginudok5ladu': ["rclone-test-ginudok5ladu"(0)|folder|ITEM_CREATE|310583661394|7fbbd5f07ab9a7238759dc9cb2a50dbd5e9f5454] new parent not found 2025/03/07 09:19:07 DEBUG : box root 'rclone-test-ginudok5ladu': ["subdir2"(0)|folder|ITEM_CREATE|310583937123|2cb6a6f03fbc8abe572aa0effbea1ab0d752c85f] added new path ("dir/subdir2") for notify 2025/03/07 09:19:07 DEBUG : doChangeNotify("dir/subdir2", 0) 2025/03/07 09:19:07 DEBUG : box root 'rclone-test-ginudok5ladu': Received 3 events, resulting in 1 paths and 1 notifications 2025/03/07 09:19:07 DEBUG : box root 'rclone-test-ginudok5ladu': Checking for changes on remote (next_stream_position: "30401038823894517") 2025/03/07 09:19:08 DEBUG : box root 'rclone-test-ginudok5ladu': Checking for changes on remote (next_stream_position: "30401038823894755") 2025/03/07 09:19:09 DEBUG : box root 'rclone-test-ginudok5ladu': Checking for changes on remote (next_stream_position: "30401038823895510") fstests.go:931: Try 2/10 waiting for dirChanges and objChanges 2025/03/07 09:19:10 DEBUG : box root 'rclone-test-ginudok5ladu': Checking for changes on remote (next_stream_position: "30401038823896511") 2025/03/07 09:19:11 DEBUG : box root 'rclone-test-ginudok5ladu': Checking for changes on remote (next_stream_position: "30401038823897507") 2025/03/07 09:19:11 DEBUG : box root 'rclone-test-ginudok5ladu': ["rclone-test-ginudok5ladu"(0)|folder|ITEM_CREATE|310583661394|7fbbd5f07ab9a7238759dc9cb2a50dbd5e9f5454] ignored due to duplicate EventID 2025/03/07 09:19:11 DEBUG : box root 'rclone-test-ginudok5ladu': ["subdir2"(0)|folder|ITEM_CREATE|310583937123|2cb6a6f03fbc8abe572aa0effbea1ab0d752c85f] ignored due to duplicate EventID 2025/03/07 09:19:12 DEBUG : box root 'rclone-test-ginudok5ladu': Checking for changes on remote (next_stream_position: "30401038823898506") fstests.go:931: Try 3/10 waiting for dirChanges and objChanges 2025/03/07 09:19:12 DEBUG : box root 'rclone-test-ginudok5ladu': ["dir"(0)|folder|ITEM_CREATE|310580433559|30d106b9d5fce1ac5de8723c84665e8e9ddda8c2] added new path ("dir") for notify 2025/03/07 09:19:12 DEBUG : box root 'rclone-test-ginudok5ladu': ["file2"(0)|file|ITEM_UPLOAD|1796571198379|ba4a48da3446fba955d1679443579c93a84ce628] added new path ("dir/file2") for notify 2025/03/07 09:19:12 DEBUG : box root 'rclone-test-ginudok5ladu': ["file3"(0)|file|ITEM_UPLOAD|1796570444875|b45c6bed6c9bd483e54810e76bd65fb757632c6a] added new path ("dir/file3") for notify 2025/03/07 09:19:12 DEBUG : doChangeNotify("dir", 0) 2025/03/07 09:19:12 DEBUG : doChangeNotify("dir/file2", 1) 2025/03/07 09:19:12 DEBUG : doChangeNotify("dir/file3", 1) 2025/03/07 09:19:12 DEBUG : box root 'rclone-test-ginudok5ladu': Received 4 events, resulting in 3 paths and 3 notifications 2025/03/07 09:19:12 DEBUG : box root 'rclone-test-ginudok5ladu': Checking for changes on remote (next_stream_position: "30401038823899502") 2025/03/07 09:19:13 DEBUG : box root 'rclone-test-ginudok5ladu': ["file2"(0)|file|ITEM_UPLOAD|1796571198379|ba4a48da3446fba955d1679443579c93a84ce628] ignored due to duplicate EventID 2025/03/07 09:19:13 DEBUG : box root 'rclone-test-ginudok5ladu': Checking for changes on remote (next_stream_position: "30401038823899761") 2025/03/07 09:19:13 DEBUG : box root 'rclone-test-ginudok5ladu': ["file3"(0)|file|ITEM_UPLOAD|1796570444875|b45c6bed6c9bd483e54810e76bd65fb757632c6a] ignored due to duplicate EventID 2025/03/07 09:19:14 DEBUG : box root 'rclone-test-ginudok5ladu': Checking for changes on remote (next_stream_position: "30401038823900509") 2025/03/07 09:19:14 DEBUG : box root 'rclone-test-ginudok5ladu': ["dir"(1)|folder|ITEM_TRASH|310583517105|310bd22bc68fcbb08bf4f0b81f7d48c751d9086b] ignored due to duplicate EventID 2025/03/07 09:19:14 DEBUG : box root 'rclone-test-ginudok5ladu': ["file4"(0)|file|ITEM_UPLOAD|1796555185718|80f712e0e86d3394a8abfc5079ce0dda87b18ec4] added new path ("dir/file4") for notify 2025/03/07 09:19:14 DEBUG : box root 'rclone-test-ginudok5ladu': ["subdir3"(0)|folder|ITEM_CREATE|310580200295|1b234c10e42cf8b34e88e535b90edab864dfe8a6] added new path ("dir/subdir3") for notify 2025/03/07 09:19:14 DEBUG : doChangeNotify("dir/file4", 1) 2025/03/07 09:19:14 DEBUG : doChangeNotify("dir/subdir3", 0) 2025/03/07 09:19:14 DEBUG : box root 'rclone-test-ginudok5ladu': Received 3 events, resulting in 2 paths and 2 notifications 2025/03/07 09:19:14 DEBUG : box root 'rclone-test-ginudok5ladu': Checking for changes on remote (next_stream_position: "30401038823901502") 2025/03/07 09:19:15 DEBUG : box root 'rclone-test-ginudok5ladu': Checking for changes on remote (next_stream_position: "30401038823901744") fstests.go:931: Try 4/10 waiting for dirChanges and objChanges 2025/03/07 09:19:15 DEBUG : box root 'rclone-test-ginudok5ladu': ["dir"(1)|folder|ITEM_TRASH|310583517105|310bd22bc68fcbb08bf4f0b81f7d48c751d9086b] ignored due to duplicate EventID 2025/03/07 09:19:16 DEBUG : box root 'rclone-test-ginudok5ladu': Checking for changes on remote (next_stream_position: "30401038823902500") 2025/03/07 09:19:17 DEBUG : box root 'rclone-test-ginudok5ladu': Checking for changes on remote (next_stream_position: "30401038823903502") 2025/03/07 09:19:18 DEBUG : box root 'rclone-test-ginudok5ladu': Checking for changes on remote (next_stream_position: "30401038823904501") fstests.go:931: Try 5/10 waiting for dirChanges and objChanges 2025/03/07 09:19:18 DEBUG : box root 'rclone-test-ginudok5ladu': ["file4"(0)|file|ITEM_UPLOAD|1796555185718|80f712e0e86d3394a8abfc5079ce0dda87b18ec4] ignored due to duplicate EventID 2025/03/07 09:19:18 DEBUG : box root 'rclone-test-ginudok5ladu': ["subdir3"(0)|folder|ITEM_CREATE|310580200295|1b234c10e42cf8b34e88e535b90edab864dfe8a6] ignored due to duplicate EventID 2025/03/07 09:19:19 DEBUG : box root 'rclone-test-ginudok5ladu': Checking for changes on remote (next_stream_position: "30401038823905498") 2025/03/07 09:19:20 DEBUG : box root 'rclone-test-ginudok5ladu': Checking for changes on remote (next_stream_position: "30401038823906502") 2025/03/07 09:19:21 DEBUG : box root 'rclone-test-ginudok5ladu': Checking for changes on remote (next_stream_position: "30401038823907506") fstests.go:931: Try 6/10 waiting for dirChanges and objChanges 2025/03/07 09:19:22 DEBUG : box root 'rclone-test-ginudok5ladu': Checking for changes on remote (next_stream_position: "30401038823908502") 2025/03/07 09:19:23 DEBUG : box root 'rclone-test-ginudok5ladu': Checking for changes on remote (next_stream_position: "30401038823909496") 2025/03/07 09:19:24 DEBUG : box root 'rclone-test-ginudok5ladu': Checking for changes on remote (next_stream_position: "30401038823910493") fstests.go:931: Try 7/10 waiting for dirChanges and objChanges 2025/03/07 09:19:25 DEBUG : box root 'rclone-test-ginudok5ladu': Checking for changes on remote (next_stream_position: "30401038823911502") 2025/03/07 09:19:26 DEBUG : box root 'rclone-test-ginudok5ladu': Checking for changes on remote (next_stream_position: "30401038823912503") 2025/03/07 09:19:27 DEBUG : box root 'rclone-test-ginudok5ladu': Checking for changes on remote (next_stream_position: "30401038823913497") fstests.go:931: Try 8/10 waiting for dirChanges and objChanges 2025/03/07 09:19:28 DEBUG : box root 'rclone-test-ginudok5ladu': Checking for changes on remote (next_stream_position: "30401038823914500") 2025/03/07 09:19:29 DEBUG : box root 'rclone-test-ginudok5ladu': Checking for changes on remote (next_stream_position: "30401038823915501") 2025/03/07 09:19:30 DEBUG : box root 'rclone-test-ginudok5ladu': Checking for changes on remote (next_stream_position: "30401038823916497") fstests.go:931: Try 9/10 waiting for dirChanges and objChanges 2025/03/07 09:19:31 DEBUG : box root 'rclone-test-ginudok5ladu': Checking for changes on remote (next_stream_position: "30401038823917501") 2025/03/07 09:19:32 DEBUG : box root 'rclone-test-ginudok5ladu': Checking for changes on remote (next_stream_position: "30401038823918499") 2025/03/07 09:19:33 DEBUG : box root 'rclone-test-ginudok5ladu': Checking for changes on remote (next_stream_position: "30401038823919495") fstests.go:935: map[dir:{} dir/subdir2:{} dir/subdir3:{}] does not contain [dir/subdir1 dir/subdir3 dir/subdir2] or map[dir/file2:{} dir/file3:{} dir/file4:{}] does not contain [dir/file2 dir/file4 dir/file3] 2025/03/07 09:19:34 DEBUG : box root 'rclone-test-ginudok5ladu': Checking for changes on remote (next_stream_position: "30401038823920493") 2025/03/07 09:19:35 DEBUG : box root 'rclone-test-ginudok5ladu': Checking for changes on remote (next_stream_position: "30401038823921495") 2025/03/07 09:19:36 DEBUG : box root 'rclone-test-ginudok5ladu': Checking for changes on remote (next_stream_position: "30401038823922501") 2025/03/07 09:19:37 DEBUG : box root 'rclone-test-ginudok5ladu': Checking for changes on remote (next_stream_position: "30401038823923498") 2025/03/07 09:19:38 DEBUG : box root 'rclone-test-ginudok5ladu': Checking for changes on remote (next_stream_position: "30401038823924503") 2025/03/07 09:19:40 DEBUG : box root 'rclone-test-ginudok5ladu': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/03/07 09:19:40 ERROR : : error listing: directory not found 2025/03/07 09:19:41 DEBUG : box root 'rclone-test-ginudok5ladu': Ignoring "Shared folder — ForNick" - unknown type "web_link" --- FAIL: TestIntegration (48.99s) --- FAIL: TestIntegration/FsMkdir (46.40s) --- FAIL: TestIntegration/FsMkdir/FsChangeNotify (44.13s) FAIL exit status 1 FAIL github.com/rclone/rclone/backend/box 49.009s "go test -v -timeout 1h0m0s -remote TestBox: -verbose -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Finished ERROR in 49.557422674s (try 3/5): exit status 1: Failed [TestIntegration/FsMkdir/FsChangeNotify]