"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024 -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Starting (try 3/5)
=== RUN   TestIntegration
    fstests.go:438: Using remote "TestChunkerChunk50bBox:"
2025/03/06 05:39:34 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-vixopix6vahe"
2025/03/06 05:39:34 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/03/06 05:39:34 DEBUG : Creating backend with remote "TestBox:rclone-test-vixopix6vahe"
2025/03/06 05:39:35 DEBUG : box root 'rclone-test-vixopix6vahe': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/03/06 05:39:36 DEBUG : Reset feature "ListR"
2025/03/06 05:39:36 DEBUG : box root 'rclone-test-vixopix6vahe': Ignoring "Shared folder — ForNick" - unknown type "web_link"
=== RUN   TestIntegration/FsMkdir
=== RUN   TestIntegration/FsMkdir/FsChangeNotify
2025/03/06 05:39:38 INFO  : dir: Making directory
2025/03/06 05:39:39 INFO  : dir/subdir1: Making directory
2025/03/06 05:39:40 DEBUG : box root 'rclone-test-vixopix6vahe': Checking for changes on remote (next_stream_position: "30401038724325902")
2025/03/06 05:39:40 INFO  : dir/subdir3: Making directory
2025/03/06 05:39:41 DEBUG : box root 'rclone-test-vixopix6vahe': Checking for changes on remote (next_stream_position: "30401038724327115")
2025/03/06 05:39:41 INFO  : dir/subdir2: Making directory
2025/03/06 05:39:42 DEBUG : box root 'rclone-test-vixopix6vahe': Checking for changes on remote (next_stream_position: "30401038724328121")
2025/03/06 05:39:43 DEBUG : box root 'rclone-test-vixopix6vahe': Checking for changes on remote (next_stream_position: "30401038724329119")
2025/03/06 05:39:44 DEBUG : box root 'rclone-test-vixopix6vahe': Checking for changes on remote (next_stream_position: "30401038724330120")
2025/03/06 05:39:45 DEBUG : box root 'rclone-test-vixopix6vahe': Checking for changes on remote (next_stream_position: "30401038724331623")
2025/03/06 05:39:46 DEBUG : box root 'rclone-test-vixopix6vahe': Checking for changes on remote (next_stream_position: "30401038724332182")
2025/03/06 05:39:47 DEBUG : box root 'rclone-test-vixopix6vahe': Checking for changes on remote (next_stream_position: "30401038724333158")
2025/03/06 05:39:48 DEBUG : box root 'rclone-test-vixopix6vahe': Checking for changes on remote (next_stream_position: "30401038724334221")
2025/03/06 05:39:49 DEBUG : box root 'rclone-test-vixopix6vahe': Checking for changes on remote (next_stream_position: "30401038724335201")
2025/03/06 05:39:49 INFO  : dir/file2.rclone_chunk.001_oynm3s: Moved (server-side) to: dir/file2.rclone_chunk.001
2025/03/06 05:39:50 INFO  : dir/file2.rclone_chunk.002_oynm3s: Moved (server-side) to: dir/file2.rclone_chunk.002
2025/03/06 05:39:50 DEBUG : box root 'rclone-test-vixopix6vahe': Checking for changes on remote (next_stream_position: "30401038724336253")
2025/03/06 05:39:50 DEBUG : box root 'rclone-test-vixopix6vahe': ["file3.rclone_chunk.002_oylxvh"(0)|file|ITEM_UPLOAD|1795187198148|9aef46d9d7b61d6948044a1e1d0251b073f647dd] new parent not found
2025/03/06 05:39:50 DEBUG : box root 'rclone-test-vixopix6vahe': Received 1 events, resulting in 0 paths and 0 notifications
2025/03/06 05:39:50 DEBUG : box root 'rclone-test-vixopix6vahe': Checking for changes on remote (next_stream_position: "30401038724337237")
2025/03/06 05:39:51 DEBUG : box root 'rclone-test-vixopix6vahe': Checking for changes on remote (next_stream_position: "30401038724337554")
2025/03/06 05:39:52 DEBUG : box root 'rclone-test-vixopix6vahe': Checking for changes on remote (next_stream_position: "30401038724338212")
2025/03/06 05:39:52 DEBUG : box root 'rclone-test-vixopix6vahe': ["file3.rclone_chunk.002_oylxvh"(0)|file|ITEM_UPLOAD|1795187198148|9aef46d9d7b61d6948044a1e1d0251b073f647dd] ignored due to duplicate EventID
2025/03/06 05:39:53 DEBUG : box root 'rclone-test-vixopix6vahe': Checking for changes on remote (next_stream_position: "30401038724339183")
2025/03/06 05:39:53 DEBUG : box root 'rclone-test-vixopix6vahe': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1795186640702|e2c75c998efb6ccd3dad1daf926880cea9395b1d] new parent not found
2025/03/06 05:39:53 DEBUG : box root 'rclone-test-vixopix6vahe': Received 1 events, resulting in 0 paths and 0 notifications
2025/03/06 05:39:53 DEBUG : box root 'rclone-test-vixopix6vahe': Checking for changes on remote (next_stream_position: "30401038724340239")
2025/03/06 05:39:53 DEBUG : box root 'rclone-test-vixopix6vahe': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1795186640702|e2c75c998efb6ccd3dad1daf926880cea9395b1d] ignored due to duplicate EventID
2025/03/06 05:39:54 DEBUG : box root 'rclone-test-vixopix6vahe': Checking for changes on remote (next_stream_position: "30401038724340689")
2025/03/06 05:39:55 DEBUG : box root 'rclone-test-vixopix6vahe': Checking for changes on remote (next_stream_position: "30401038724341264")
2025/03/06 05:39:56 DEBUG : box root 'rclone-test-vixopix6vahe': Checking for changes on remote (next_stream_position: "30401038724342208")
2025/03/06 05:39:57 DEBUG : box root 'rclone-test-vixopix6vahe': Checking for changes on remote (next_stream_position: "30401038724343166")
2025/03/06 05:39:57 DEBUG : box root 'rclone-test-vixopix6vahe': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1795186640702|e2c75c998efb6ccd3dad1daf926880cea9395b1d] ignored due to duplicate EventID
2025/03/06 05:39:57 DEBUG : box root 'rclone-test-vixopix6vahe': Received 4 events, resulting in 0 paths and 0 notifications
2025/03/06 05:39:57 DEBUG : box root 'rclone-test-vixopix6vahe': Checking for changes on remote (next_stream_position: "30401038724344221")
2025/03/06 05:39:57 DEBUG : box root 'rclone-test-vixopix6vahe': ["file3.rclone_chunk.001"(2)|file|ITEM_TRASH|1795186640702|48b5ae6edb7462eb790a124c601de6666e8d1879] ignored due to duplicate EventID
2025/03/06 05:39:57 DEBUG : box root 'rclone-test-vixopix6vahe': ["file2.rclone_chunk.001"(2)|file|ITEM_TRASH|1795180806898|fbfb0eb00bf9e6b21b2e40eec45707d12c164ca0] ignored due to duplicate EventID
2025/03/06 05:39:57 DEBUG : box root 'rclone-test-vixopix6vahe': ["file4.rclone_chunk.001"(2)|file|ITEM_TRASH|1795178702143|153dec05d1d35d4d73e5170fea30a399c9020414] ignored due to duplicate EventID
2025/03/06 05:39:58 DEBUG : box root 'rclone-test-vixopix6vahe': Checking for changes on remote (next_stream_position: "30401038724344556")
2025/03/06 05:39:58 DEBUG : box root 'rclone-test-vixopix6vahe': ["file3.rclone_chunk.001"(2)|file|ITEM_TRASH|1795186640702|48b5ae6edb7462eb790a124c601de6666e8d1879] ignored due to duplicate EventID
2025/03/06 05:39:58 DEBUG : box root 'rclone-test-vixopix6vahe': ["file2.rclone_chunk.001"(2)|file|ITEM_TRASH|1795180806898|fbfb0eb00bf9e6b21b2e40eec45707d12c164ca0] ignored due to duplicate EventID
2025/03/06 05:39:58 DEBUG : box root 'rclone-test-vixopix6vahe': ["file4.rclone_chunk.001"(2)|file|ITEM_TRASH|1795178702143|153dec05d1d35d4d73e5170fea30a399c9020414] ignored due to duplicate EventID
2025/03/06 05:39:58 DEBUG : box root 'rclone-test-vixopix6vahe': Received 4 events, resulting in 0 paths and 0 notifications
2025/03/06 05:39:58 DEBUG : box root 'rclone-test-vixopix6vahe': Checking for changes on remote (next_stream_position: "30401038724345218")
2025/03/06 05:39:58 INFO  : dir/file4.rclone_chunk.001_oynx0h: Moved (server-side) to: dir/file4.rclone_chunk.001
2025/03/06 05:39:59 DEBUG : box root 'rclone-test-vixopix6vahe': Checking for changes on remote (next_stream_position: "30401038724345588")
2025/03/06 05:39:59 DEBUG : box root 'rclone-test-vixopix6vahe': ["file3.rclone_chunk.001"(2)|file|ITEM_TRASH|1795186640702|48b5ae6edb7462eb790a124c601de6666e8d1879] ignored due to duplicate EventID
2025/03/06 05:39:59 DEBUG : box root 'rclone-test-vixopix6vahe': ["file2.rclone_chunk.001"(2)|file|ITEM_TRASH|1795180806898|fbfb0eb00bf9e6b21b2e40eec45707d12c164ca0] ignored due to duplicate EventID
2025/03/06 05:39:59 DEBUG : box root 'rclone-test-vixopix6vahe': ["file4.rclone_chunk.001"(2)|file|ITEM_TRASH|1795178702143|153dec05d1d35d4d73e5170fea30a399c9020414] ignored due to duplicate EventID
2025/03/06 05:39:59 DEBUG : box root 'rclone-test-vixopix6vahe': ["subdir2"(1)|folder|ITEM_TRASH|310373587116|07a5fd3cae1a1e71c8585095ee50a17221405be8] ignored due to duplicate EventID
2025/03/06 05:39:59 DEBUG : box root 'rclone-test-vixopix6vahe': Received 6 events, resulting in 0 paths and 0 notifications
2025/03/06 05:39:59 DEBUG : box root 'rclone-test-vixopix6vahe': Checking for changes on remote (next_stream_position: "30401038724346189")
2025/03/06 05:39:59 INFO  : dir/file4.rclone_chunk.002_oynx0h: Moved (server-side) to: dir/file4.rclone_chunk.002
2025/03/06 05:39:59 DEBUG : box root 'rclone-test-vixopix6vahe': ["file3.rclone_chunk.001"(2)|file|ITEM_TRASH|1795186640702|48b5ae6edb7462eb790a124c601de6666e8d1879] ignored due to duplicate EventID
2025/03/06 05:40:00 DEBUG : box root 'rclone-test-vixopix6vahe': Checking for changes on remote (next_stream_position: "30401038724346503")
2025/03/06 05:40:00 DEBUG : box root 'rclone-test-vixopix6vahe': ["file2.rclone_chunk.001"(2)|file|ITEM_TRASH|1795180806898|fbfb0eb00bf9e6b21b2e40eec45707d12c164ca0] ignored due to duplicate EventID
2025/03/06 05:40:01 DEBUG : box root 'rclone-test-vixopix6vahe': Checking for changes on remote (next_stream_position: "30401038724347327")
2025/03/06 05:40:01 DEBUG : box root 'rclone-test-vixopix6vahe': ["file4.rclone_chunk.001"(2)|file|ITEM_TRASH|1795178702143|153dec05d1d35d4d73e5170fea30a399c9020414] ignored due to duplicate EventID
2025/03/06 05:40:02 DEBUG : box root 'rclone-test-vixopix6vahe': Checking for changes on remote (next_stream_position: "30401038724348320")
2025/03/06 05:40:08 INFO  : dir/file3.rclone_chunk.001_oyo7cv: Moved (server-side) to: dir/file3.rclone_chunk.001
2025/03/06 05:40:08 INFO  : dir/file3.rclone_chunk.002_oyo7cv: Moved (server-side) to: dir/file3.rclone_chunk.002
    fstests.go:931: Try 1/10 waiting for dirChanges and objChanges
    fstests.go:931: Try 2/10 waiting for dirChanges and objChanges
    fstests.go:931: Try 3/10 waiting for dirChanges and objChanges
    fstests.go:931: Try 4/10 waiting for dirChanges and objChanges
    fstests.go:931: Try 5/10 waiting for dirChanges and objChanges
    fstests.go:931: Try 6/10 waiting for dirChanges and objChanges
    fstests.go:931: Try 7/10 waiting for dirChanges and objChanges
    fstests.go:931: Try 8/10 waiting for dirChanges and objChanges
    fstests.go:931: Try 9/10 waiting for dirChanges and objChanges
    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/03/06 05:40:57 DEBUG : box root 'rclone-test-vixopix6vahe': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/03/06 05:40:57 ERROR : : error listing: directory not found
2025/03/06 05:40:57 DEBUG : box root 'rclone-test-vixopix6vahe': Ignoring "Shared folder — ForNick" - unknown type "web_link"
--- FAIL: TestIntegration (82.83s)
    --- FAIL: TestIntegration/FsMkdir (80.09s)
        --- FAIL: TestIntegration/FsMkdir/FsChangeNotify (77.46s)
FAIL
exit status 1
FAIL	github.com/rclone/rclone/backend/chunker	82.861s
"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024 -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Finished ERROR in 1m24.809676887s (try 3/5): exit status 1: Failed [TestIntegration/FsMkdir/FsChangeNotify]