"go test -v -timeout 1h0m0s -remote TestBox: -verbose -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Starting (try 2/5)
=== RUN   TestIntegration
    fstests.go:438: Using remote "TestBox:"
2025/08/02 04:45:31 NOTICE: TestBox: Starting server
2025/08/02 04:45:31 DEBUG : Creating backend with remote "TestBox:rclone-test-wehumeg5vunu"
2025/08/02 04:45:31 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/08/02 04:45:32 DEBUG : box root 'rclone-test-wehumeg5vunu': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/08/02 04:45:32 DEBUG : box root 'rclone-test-wehumeg5vunu': Ignoring "Shared folder — ForNick" - unknown type "web_link"
=== RUN   TestIntegration/FsMkdir
=== RUN   TestIntegration/FsMkdir/FsChangeNotify
2025/08/02 04:45:34 INFO  : dir: Making directory
2025/08/02 04:45:35 INFO  : dir/subdir1: Making directory
2025/08/02 04:45:36 DEBUG : box root 'rclone-test-wehumeg5vunu': Checking for changes on remote (next_stream_position: "30401051594682179")
2025/08/02 04:45:36 INFO  : dir/subdir3: Making directory
2025/08/02 04:45:36 DEBUG : box root 'rclone-test-wehumeg5vunu': ["file5.txt"(1)|file|ITEM_UPLOAD|1943340215190|e313c7b4f5f9d44362297228df1dfb3bdd834e86] new parent not found
2025/08/02 04:45:36 DEBUG : box root 'rclone-test-wehumeg5vunu': Received 1 events, resulting in 0 paths and 0 notifications
2025/08/02 04:45:36 DEBUG : box root 'rclone-test-wehumeg5vunu': Checking for changes on remote (next_stream_position: "30401051594683408")
2025/08/02 04:45:37 INFO  : dir/subdir2: Making directory
2025/08/02 04:45:37 DEBUG : box root 'rclone-test-wehumeg5vunu': Checking for changes on remote (next_stream_position: "30401051594683632")
2025/08/02 04:45:38 DEBUG : box root 'rclone-test-wehumeg5vunu': Checking for changes on remote (next_stream_position: "30401051594684411")
2025/08/02 04:45:39 DEBUG : box root 'rclone-test-wehumeg5vunu': Checking for changes on remote (next_stream_position: "30401051594685410")
2025/08/02 04:45:40 DEBUG : box root 'rclone-test-wehumeg5vunu': Checking for changes on remote (next_stream_position: "30401051594686406")
2025/08/02 04:45:41 DEBUG : box root 'rclone-test-wehumeg5vunu': Checking for changes on remote (next_stream_position: "30401051594687408")
2025/08/02 04:45:42 DEBUG : box root 'rclone-test-wehumeg5vunu': Checking for changes on remote (next_stream_position: "30401051594688406")
2025/08/02 04:45:43 DEBUG : box root 'rclone-test-wehumeg5vunu': Checking for changes on remote (next_stream_position: "30401051594689404")
    fstests.go:931: Try 1/10 waiting for dirChanges and objChanges
2025/08/02 04:45:44 DEBUG : box root 'rclone-test-wehumeg5vunu': Checking for changes on remote (next_stream_position: "30401051594690412")
2025/08/02 04:45:45 DEBUG : box root 'rclone-test-wehumeg5vunu': Checking for changes on remote (next_stream_position: "30401051594691412")
2025/08/02 04:45:46 DEBUG : box root 'rclone-test-wehumeg5vunu': Checking for changes on remote (next_stream_position: "30401051594692402")
    fstests.go:931: Try 2/10 waiting for dirChanges and objChanges
2025/08/02 04:45:47 DEBUG : box root 'rclone-test-wehumeg5vunu': Checking for changes on remote (next_stream_position: "30401051594693405")
2025/08/02 04:45:48 DEBUG : box root 'rclone-test-wehumeg5vunu': Checking for changes on remote (next_stream_position: "30401051594694405")
2025/08/02 04:45:49 DEBUG : box root 'rclone-test-wehumeg5vunu': Checking for changes on remote (next_stream_position: "30401051594695406")
    fstests.go:931: Try 3/10 waiting for dirChanges and objChanges
2025/08/02 04:45:50 DEBUG : box root 'rclone-test-wehumeg5vunu': Checking for changes on remote (next_stream_position: "30401051594696409")
2025/08/02 04:45:51 DEBUG : box root 'rclone-test-wehumeg5vunu': Checking for changes on remote (next_stream_position: "30401051594697406")
2025/08/02 04:45:52 DEBUG : box root 'rclone-test-wehumeg5vunu': Checking for changes on remote (next_stream_position: "30401051594698405")
    fstests.go:931: Try 4/10 waiting for dirChanges and objChanges
2025/08/02 04:45:53 DEBUG : box root 'rclone-test-wehumeg5vunu': Checking for changes on remote (next_stream_position: "30401051594699404")
2025/08/02 04:45:54 DEBUG : box root 'rclone-test-wehumeg5vunu': Checking for changes on remote (next_stream_position: "30401051594700403")
2025/08/02 04:45:55 DEBUG : box root 'rclone-test-wehumeg5vunu': Checking for changes on remote (next_stream_position: "30401051594701406")
    fstests.go:931: Try 5/10 waiting for dirChanges and objChanges
2025/08/02 04:45:56 DEBUG : box root 'rclone-test-wehumeg5vunu': Checking for changes on remote (next_stream_position: "30401051594702408")
2025/08/02 04:45:57 DEBUG : box root 'rclone-test-wehumeg5vunu': Checking for changes on remote (next_stream_position: "30401051594703406")
2025/08/02 04:45:58 DEBUG : box root 'rclone-test-wehumeg5vunu': Checking for changes on remote (next_stream_position: "30401051594704405")
2025/08/02 04:45:58 DEBUG : box root 'rclone-test-wehumeg5vunu': [".chk_file"(0)|file|ITEM_UPLOAD|1943341735050|3c6a68b1e9ef308967dad2127eed87464902cf79] new parent not found
2025/08/02 04:45:58 DEBUG : box root 'rclone-test-wehumeg5vunu': Received 1 events, resulting in 0 paths and 0 notifications
2025/08/02 04:45:58 DEBUG : box root 'rclone-test-wehumeg5vunu': Checking for changes on remote (next_stream_position: "30401051594705402")
2025/08/02 04:45:58 DEBUG : box root 'rclone-test-wehumeg5vunu': [".chk_file"(0)|file|ITEM_UPLOAD|1943341735050|3c6a68b1e9ef308967dad2127eed87464902cf79] ignored due to duplicate EventID
    fstests.go:931: Try 6/10 waiting for dirChanges and objChanges
2025/08/02 04:45:59 DEBUG : box root 'rclone-test-wehumeg5vunu': Checking for changes on remote (next_stream_position: "30401051594705625")
2025/08/02 04:45:59 DEBUG : box root 'rclone-test-wehumeg5vunu': [".chk_file"(0)|file|ITEM_UPLOAD|1943341735050|3c6a68b1e9ef308967dad2127eed87464902cf79] ignored due to duplicate EventID
2025/08/02 04:46:00 DEBUG : box root 'rclone-test-wehumeg5vunu': Checking for changes on remote (next_stream_position: "30401051594706405")
2025/08/02 04:46:00 DEBUG : box root 'rclone-test-wehumeg5vunu': [".chk_file"(0)|file|ITEM_UPLOAD|1943341735050|3c6a68b1e9ef308967dad2127eed87464902cf79] ignored due to duplicate EventID
2025/08/02 04:46:01 DEBUG : box root 'rclone-test-wehumeg5vunu': Checking for changes on remote (next_stream_position: "30401051594707404")
2025/08/02 04:46:01 DEBUG : box root 'rclone-test-wehumeg5vunu': [".chk_file"(0)|file|ITEM_UPLOAD|1943341735050|3c6a68b1e9ef308967dad2127eed87464902cf79] ignored due to duplicate EventID
    fstests.go:931: Try 7/10 waiting for dirChanges and objChanges
2025/08/02 04:46:02 DEBUG : box root 'rclone-test-wehumeg5vunu': Checking for changes on remote (next_stream_position: "30401051594708406")
2025/08/02 04:46:02 DEBUG : box root 'rclone-test-wehumeg5vunu': [".chk_file"(0)|file|ITEM_UPLOAD|1943341735050|3c6a68b1e9ef308967dad2127eed87464902cf79] ignored due to duplicate EventID
2025/08/02 04:46:03 DEBUG : box root 'rclone-test-wehumeg5vunu': Checking for changes on remote (next_stream_position: "30401051594709407")
2025/08/02 04:46:04 DEBUG : box root 'rclone-test-wehumeg5vunu': Checking for changes on remote (next_stream_position: "30401051594710407")
    fstests.go:931: Try 8/10 waiting for dirChanges and objChanges
2025/08/02 04:46:05 DEBUG : box root 'rclone-test-wehumeg5vunu': Checking for changes on remote (next_stream_position: "30401051594711410")
2025/08/02 04:46:06 DEBUG : box root 'rclone-test-wehumeg5vunu': Checking for changes on remote (next_stream_position: "30401051594712408")
2025/08/02 04:46:07 DEBUG : box root 'rclone-test-wehumeg5vunu': Checking for changes on remote (next_stream_position: "30401051594713411")
    fstests.go:931: Try 9/10 waiting for dirChanges and objChanges
2025/08/02 04:46:08 DEBUG : box root 'rclone-test-wehumeg5vunu': Checking for changes on remote (next_stream_position: "30401051594714408")
2025/08/02 04:46:08 DEBUG : box root 'rclone-test-wehumeg5vunu': Received 1 events, resulting in 0 paths and 0 notifications
2025/08/02 04:46:08 DEBUG : box root 'rclone-test-wehumeg5vunu': Checking for changes on remote (next_stream_position: "30401051594715408")
2025/08/02 04:46:08 DEBUG : box root 'rclone-test-wehumeg5vunu': ["modtime_write_test"(1)|file|ITEM_TRASH|1943336697027|35f3ce4c92e70bcd671b1aa8800d094fd40ea4aa] ignored due to duplicate EventID
2025/08/02 04:46:09 DEBUG : box root 'rclone-test-wehumeg5vunu': Checking for changes on remote (next_stream_position: "30401051594715633")
2025/08/02 04:46:09 DEBUG : box root 'rclone-test-wehumeg5vunu': ["modtime_write_test"(1)|file|ITEM_TRASH|1943336697027|35f3ce4c92e70bcd671b1aa8800d094fd40ea4aa] ignored due to duplicate EventID
2025/08/02 04:46:10 DEBUG : box root 'rclone-test-wehumeg5vunu': Checking for changes on remote (next_stream_position: "30401051594716406")
2025/08/02 04:46:10 DEBUG : box root 'rclone-test-wehumeg5vunu': ["modtime_write_test"(1)|file|ITEM_TRASH|1943336697027|35f3ce4c92e70bcd671b1aa8800d094fd40ea4aa] ignored due to duplicate EventID
    fstests.go:935: map[] does not contain [dir/subdir1 dir/subdir3 dir/subdir2] or 
        map[] does not contain [dir/file2 dir/file4 dir/file3]
2025/08/02 04:46:11 DEBUG : box root 'rclone-test-wehumeg5vunu': Checking for changes on remote (next_stream_position: "30401051594717404")
2025/08/02 04:46:11 DEBUG : box root 'rclone-test-wehumeg5vunu': ["modtime_write_test"(1)|file|ITEM_TRASH|1943336697027|35f3ce4c92e70bcd671b1aa8800d094fd40ea4aa] ignored due to duplicate EventID
2025/08/02 04:46:12 DEBUG : box root 'rclone-test-wehumeg5vunu': Checking for changes on remote (next_stream_position: "30401051594718407")
2025/08/02 04:46:12 DEBUG : box root 'rclone-test-wehumeg5vunu': ["modtime_write_test"(1)|file|ITEM_TRASH|1943336697027|35f3ce4c92e70bcd671b1aa8800d094fd40ea4aa] ignored due to duplicate EventID
2025/08/02 04:46:13 DEBUG : box root 'rclone-test-wehumeg5vunu': Checking for changes on remote (next_stream_position: "30401051594719405")
2025/08/02 04:46:14 DEBUG : box root 'rclone-test-wehumeg5vunu': Checking for changes on remote (next_stream_position: "30401051594720405")
2025/08/02 04:46:15 DEBUG : box root 'rclone-test-wehumeg5vunu': Checking for changes on remote (next_stream_position: "30401051594721404")
2025/08/02 04:46:16 DEBUG : box root 'rclone-test-wehumeg5vunu': Checking for changes on remote (next_stream_position: "30401051594722409")
2025/08/02 04:46:17 DEBUG : box root 'rclone-test-wehumeg5vunu': Checking for changes on remote (next_stream_position: "30401051594723414")
2025/08/02 04:46:18 DEBUG : box root 'rclone-test-wehumeg5vunu': Checking for changes on remote (next_stream_position: "30401051594724403")
2025/08/02 04:46:20 DEBUG : box root 'rclone-test-wehumeg5vunu': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/08/02 04:46:20 ERROR : error listing: directory not found
2025/08/02 04:46:21 DEBUG : box root 'rclone-test-wehumeg5vunu': Ignoring "Shared folder — ForNick" - unknown type "web_link"
--- FAIL: TestIntegration (49.63s)
    --- FAIL: TestIntegration/FsMkdir (47.39s)
        --- FAIL: TestIntegration/FsMkdir/FsChangeNotify (45.01s)
FAIL
exit status 1
FAIL	github.com/rclone/rclone/backend/box	49.657s
"go test -v -timeout 1h0m0s -remote TestBox: -verbose -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Finished ERROR in 50.670601267s (try 2/5): exit status 1: Failed [TestIntegration/FsMkdir/FsChangeNotify]