"go test -v -timeout 1h0m0s -remote TestBox: -verbose -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Starting (try 5/5)
=== RUN   TestIntegration
    fstests.go:442: Using remote "TestBox:"
2025/01/31 04:11:48 DEBUG : Creating backend with remote "TestBox:rclone-test-bewixux4yamu"
2025/01/31 04:11:48 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/01/31 04:11:50 DEBUG : box root 'rclone-test-bewixux4yamu': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/01/31 04:11:51 DEBUG : box root 'rclone-test-bewixux4yamu': Ignoring "Shared folder — ForNick" - unknown type "web_link"
=== RUN   TestIntegration/FsMkdir
=== RUN   TestIntegration/FsMkdir/FsChangeNotify
2025/01/31 04:11:53 INFO  : dir: Making directory
2025/01/31 04:11:54 INFO  : dir/subdir1: Making directory
2025/01/31 04:11:55 DEBUG : box root 'rclone-test-bewixux4yamu': Checking for changes on remote (next_stream_position: "30401035781461632")
2025/01/31 04:11:56 DEBUG : box root 'rclone-test-bewixux4yamu': ["file3"(0)|file|ITEM_UPLOAD|1764636628066|577ccfa09c9726f888d0ed3121b3309190068fd4] new parent not found
2025/01/31 04:11:56 DEBUG : box root 'rclone-test-bewixux4yamu': Received 2 events, resulting in 0 paths and 0 notifications
2025/01/31 04:11:56 DEBUG : box root 'rclone-test-bewixux4yamu': Checking for changes on remote (next_stream_position: "30401035781462896")
2025/01/31 04:11:56 INFO  : dir/subdir3: Making directory
2025/01/31 04:11:56 DEBUG : box root 'rclone-test-bewixux4yamu': ["file3"(0)|file|ITEM_UPLOAD|1764636628066|577ccfa09c9726f888d0ed3121b3309190068fd4] ignored due to duplicate EventID
2025/01/31 04:11:56 DEBUG : box root 'rclone-test-bewixux4yamu': ["dir"(1)|folder|ITEM_TRASH|305276128767|f80d2b0c49da72e9c4bffd5fd68b3def613c54b8] ignored due to duplicate EventID
2025/01/31 04:11:56 DEBUG : box root 'rclone-test-bewixux4yamu': Checking for changes on remote (next_stream_position: "30401035781463168")
2025/01/31 04:11:57 DEBUG : box root 'rclone-test-bewixux4yamu': ["file3"(0)|file|ITEM_UPLOAD|1764636628066|577ccfa09c9726f888d0ed3121b3309190068fd4] ignored due to duplicate EventID
2025/01/31 04:11:57 DEBUG : box root 'rclone-test-bewixux4yamu': ["dir"(1)|folder|ITEM_TRASH|305276128767|f80d2b0c49da72e9c4bffd5fd68b3def613c54b8] ignored due to duplicate EventID
2025/01/31 04:11:57 INFO  : dir/subdir2: Making directory
2025/01/31 04:11:57 DEBUG : box root 'rclone-test-bewixux4yamu': Checking for changes on remote (next_stream_position: "30401035781463926")
2025/01/31 04:11:58 DEBUG : box root 'rclone-test-bewixux4yamu': ["dir"(1)|folder|ITEM_TRASH|305276128767|f80d2b0c49da72e9c4bffd5fd68b3def613c54b8] ignored due to duplicate EventID
2025/01/31 04:11:58 DEBUG : box root 'rclone-test-bewixux4yamu': Checking for changes on remote (next_stream_position: "30401035781464909")
2025/01/31 04:11:59 DEBUG : box root 'rclone-test-bewixux4yamu': ["dir"(1)|folder|ITEM_TRASH|305276128767|f80d2b0c49da72e9c4bffd5fd68b3def613c54b8] ignored due to duplicate EventID
2025/01/31 04:11:59 DEBUG : box root 'rclone-test-bewixux4yamu': Received 2 events, resulting in 0 paths and 0 notifications
2025/01/31 04:11:59 DEBUG : box root 'rclone-test-bewixux4yamu': Checking for changes on remote (next_stream_position: "30401035781465903")
2025/01/31 04:11:59 DEBUG : box root 'rclone-test-bewixux4yamu': ["dir"(1)|folder|ITEM_TRASH|305276128767|f80d2b0c49da72e9c4bffd5fd68b3def613c54b8] ignored due to duplicate EventID
2025/01/31 04:11:59 DEBUG : box root 'rclone-test-bewixux4yamu': ["subdir1"(1)|folder|ITEM_TRASH|305278247653|a67d9126414107f349672fcefd6093f95c7c292c] ignored due to duplicate EventID
2025/01/31 04:11:59 DEBUG : box root 'rclone-test-bewixux4yamu': Checking for changes on remote (next_stream_position: "30401035781466167")
2025/01/31 04:12:00 DEBUG : box root 'rclone-test-bewixux4yamu': ["dir"(1)|folder|ITEM_TRASH|305276128767|f80d2b0c49da72e9c4bffd5fd68b3def613c54b8] ignored due to duplicate EventID
2025/01/31 04:12:00 DEBUG : box root 'rclone-test-bewixux4yamu': ["subdir1"(1)|folder|ITEM_TRASH|305278247653|a67d9126414107f349672fcefd6093f95c7c292c] ignored due to duplicate EventID
2025/01/31 04:12:00 DEBUG : box root 'rclone-test-bewixux4yamu': Checking for changes on remote (next_stream_position: "30401035781466902")
2025/01/31 04:12:01 DEBUG : box root 'rclone-test-bewixux4yamu': ["subdir1"(1)|folder|ITEM_TRASH|305278247653|a67d9126414107f349672fcefd6093f95c7c292c] ignored due to duplicate EventID
2025/01/31 04:12:01 DEBUG : box root 'rclone-test-bewixux4yamu': Checking for changes on remote (next_stream_position: "30401035781467986")
2025/01/31 04:12:02 DEBUG : box root 'rclone-test-bewixux4yamu': ["subdir1"(1)|folder|ITEM_TRASH|305278247653|a67d9126414107f349672fcefd6093f95c7c292c] ignored due to duplicate EventID
2025/01/31 04:12:02 DEBUG : box root 'rclone-test-bewixux4yamu': Received 2 events, resulting in 0 paths and 0 notifications
2025/01/31 04:12:02 DEBUG : box root 'rclone-test-bewixux4yamu': Checking for changes on remote (next_stream_position: "30401035781469079")
2025/01/31 04:12:02 DEBUG : box root 'rclone-test-bewixux4yamu': ["file4"(1)|file|ITEM_TRASH|1764646936520|7808569bd3f6ad323e0321e7f9db62c9675bace1] ignored due to duplicate EventID
2025/01/31 04:12:02 DEBUG : box root 'rclone-test-bewixux4yamu': ["subdir2"(0)|folder|ITEM_CREATE|305278137075|26570a05d049d67857437d1c717399ba1bfe2465] added new path ("dir/subdir2") for notify
2025/01/31 04:12:02 DEBUG : doChangeNotify("dir/subdir2", 0)
2025/01/31 04:12:02 DEBUG : box root 'rclone-test-bewixux4yamu': Received 2 events, resulting in 1 paths and 1 notifications
2025/01/31 04:12:02 DEBUG : box root 'rclone-test-bewixux4yamu': Checking for changes on remote (next_stream_position: "30401035781469468")
2025/01/31 04:12:03 DEBUG : box root 'rclone-test-bewixux4yamu': ["file4"(1)|file|ITEM_TRASH|1764646936520|7808569bd3f6ad323e0321e7f9db62c9675bace1] ignored due to duplicate EventID
2025/01/31 04:12:03 DEBUG : box root 'rclone-test-bewixux4yamu': ["subdir2"(0)|folder|ITEM_CREATE|305278137075|26570a05d049d67857437d1c717399ba1bfe2465] ignored due to duplicate EventID
2025/01/31 04:12:03 DEBUG : box root 'rclone-test-bewixux4yamu': Checking for changes on remote (next_stream_position: "30401035781469793")
2025/01/31 04:12:03 DEBUG : box root 'rclone-test-bewixux4yamu': ["file4"(1)|file|ITEM_TRASH|1764646936520|7808569bd3f6ad323e0321e7f9db62c9675bace1] ignored due to duplicate EventID
2025/01/31 04:12:03 DEBUG : box root 'rclone-test-bewixux4yamu': ["subdir2"(0)|folder|ITEM_CREATE|305278137075|26570a05d049d67857437d1c717399ba1bfe2465] ignored due to duplicate EventID
2025/01/31 04:12:03 DEBUG : box root 'rclone-test-bewixux4yamu': Checking for changes on remote (next_stream_position: "30401035781470092")
2025/01/31 04:12:04 DEBUG : box root 'rclone-test-bewixux4yamu': ["file4"(1)|file|ITEM_TRASH|1764646936520|7808569bd3f6ad323e0321e7f9db62c9675bace1] ignored due to duplicate EventID
2025/01/31 04:12:04 DEBUG : box root 'rclone-test-bewixux4yamu': ["subdir2"(0)|folder|ITEM_CREATE|305278137075|26570a05d049d67857437d1c717399ba1bfe2465] ignored due to duplicate EventID
2025/01/31 04:12:04 DEBUG : box root 'rclone-test-bewixux4yamu': Received 3 events, resulting in 0 paths and 0 notifications
2025/01/31 04:12:04 DEBUG : box root 'rclone-test-bewixux4yamu': Checking for changes on remote (next_stream_position: "30401035781470919")
2025/01/31 04:12:04 DEBUG : box root 'rclone-test-bewixux4yamu': ["file4"(1)|file|ITEM_TRASH|1764646936520|7808569bd3f6ad323e0321e7f9db62c9675bace1] ignored due to duplicate EventID
2025/01/31 04:12:04 DEBUG : box root 'rclone-test-bewixux4yamu': ["subdir2"(0)|folder|ITEM_CREATE|305278137075|26570a05d049d67857437d1c717399ba1bfe2465] ignored due to duplicate EventID
2025/01/31 04:12:04 DEBUG : box root 'rclone-test-bewixux4yamu': ["file2"(1)|file|ITEM_TRASH|1764635490115|8e139830d9c3a36a335de2c29ca64d01147bf632] ignored due to duplicate EventID
2025/01/31 04:12:04 DEBUG : box root 'rclone-test-bewixux4yamu': Checking for changes on remote (next_stream_position: "30401035781471175")
2025/01/31 04:12:05 DEBUG : box root 'rclone-test-bewixux4yamu': ["file4"(1)|file|ITEM_TRASH|1764646936520|7808569bd3f6ad323e0321e7f9db62c9675bace1] ignored due to duplicate EventID
2025/01/31 04:12:05 DEBUG : box root 'rclone-test-bewixux4yamu': ["subdir2"(0)|folder|ITEM_CREATE|305278137075|26570a05d049d67857437d1c717399ba1bfe2465] ignored due to duplicate EventID
2025/01/31 04:12:05 DEBUG : box root 'rclone-test-bewixux4yamu': ["file2"(1)|file|ITEM_TRASH|1764635490115|8e139830d9c3a36a335de2c29ca64d01147bf632] ignored due to duplicate EventID
2025/01/31 04:12:05 DEBUG : box root 'rclone-test-bewixux4yamu': Checking for changes on remote (next_stream_position: "30401035781471961")
2025/01/31 04:12:06 DEBUG : box root 'rclone-test-bewixux4yamu': ["file4"(1)|file|ITEM_TRASH|1764646936520|7808569bd3f6ad323e0321e7f9db62c9675bace1] ignored due to duplicate EventID
2025/01/31 04:12:06 DEBUG : box root 'rclone-test-bewixux4yamu': ["subdir2"(0)|folder|ITEM_CREATE|305278137075|26570a05d049d67857437d1c717399ba1bfe2465] ignored due to duplicate EventID
2025/01/31 04:12:06 DEBUG : box root 'rclone-test-bewixux4yamu': ["file2"(1)|file|ITEM_TRASH|1764635490115|8e139830d9c3a36a335de2c29ca64d01147bf632] ignored due to duplicate EventID
    fstests.go:935: Try 1/10 waiting for dirChanges and objChanges
2025/01/31 04:12:06 DEBUG : box root 'rclone-test-bewixux4yamu': Checking for changes on remote (next_stream_position: "30401035781472904")
2025/01/31 04:12:07 DEBUG : box root 'rclone-test-bewixux4yamu': ["subdir2"(0)|folder|ITEM_CREATE|305278137075|26570a05d049d67857437d1c717399ba1bfe2465] ignored due to duplicate EventID
2025/01/31 04:12:07 DEBUG : box root 'rclone-test-bewixux4yamu': ["file2"(1)|file|ITEM_TRASH|1764635490115|8e139830d9c3a36a335de2c29ca64d01147bf632] ignored due to duplicate EventID
2025/01/31 04:12:07 DEBUG : box root 'rclone-test-bewixux4yamu': ["subdir1"(0)|folder|ITEM_CREATE|305279195574|aecc170a225622e4067b7bdcc7af0f807de70378] added new path ("dir/subdir1") for notify
2025/01/31 04:12:07 DEBUG : doChangeNotify("dir/subdir1", 0)
2025/01/31 04:12:07 DEBUG : box root 'rclone-test-bewixux4yamu': Received 3 events, resulting in 1 paths and 1 notifications
2025/01/31 04:12:07 DEBUG : box root 'rclone-test-bewixux4yamu': Checking for changes on remote (next_stream_position: "30401035781473928")
2025/01/31 04:12:07 DEBUG : box root 'rclone-test-bewixux4yamu': ["file2"(1)|file|ITEM_TRASH|1764635490115|8e139830d9c3a36a335de2c29ca64d01147bf632] ignored due to duplicate EventID
2025/01/31 04:12:07 DEBUG : box root 'rclone-test-bewixux4yamu': ["subdir1"(0)|folder|ITEM_CREATE|305279195574|aecc170a225622e4067b7bdcc7af0f807de70378] ignored due to duplicate EventID
2025/01/31 04:12:07 DEBUG : box root 'rclone-test-bewixux4yamu': Checking for changes on remote (next_stream_position: "30401035781474236")
2025/01/31 04:12:08 DEBUG : box root 'rclone-test-bewixux4yamu': ["file2"(1)|file|ITEM_TRASH|1764635490115|8e139830d9c3a36a335de2c29ca64d01147bf632] ignored due to duplicate EventID
2025/01/31 04:12:08 DEBUG : box root 'rclone-test-bewixux4yamu': ["subdir1"(0)|folder|ITEM_CREATE|305279195574|aecc170a225622e4067b7bdcc7af0f807de70378] ignored due to duplicate EventID
2025/01/31 04:12:08 DEBUG : box root 'rclone-test-bewixux4yamu': Checking for changes on remote (next_stream_position: "30401035781474920")
2025/01/31 04:12:09 DEBUG : box root 'rclone-test-bewixux4yamu': ["subdir1"(0)|folder|ITEM_CREATE|305279195574|aecc170a225622e4067b7bdcc7af0f807de70378] ignored due to duplicate EventID
    fstests.go:935: Try 2/10 waiting for dirChanges and objChanges
2025/01/31 04:12:09 DEBUG : box root 'rclone-test-bewixux4yamu': Checking for changes on remote (next_stream_position: "30401035781475897")
    fstests.go:935: Try 3/10 waiting for dirChanges and objChanges
    fstests.go:935: Try 4/10 waiting for dirChanges and objChanges
    fstests.go:935: Try 5/10 waiting for dirChanges and objChanges
    fstests.go:935: Try 6/10 waiting for dirChanges and objChanges
    fstests.go:935: Try 7/10 waiting for dirChanges and objChanges
    fstests.go:935: Try 8/10 waiting for dirChanges and objChanges
    fstests.go:935: Try 9/10 waiting for dirChanges and objChanges
    fstests.go:939: map[dir/subdir1:{} dir/subdir2:{}] does not contain [dir/subdir1 dir/subdir3 dir/subdir2] or 
        map[] does not contain [dir/file2 dir/file4 dir/file3]
2025/01/31 04:12:40 DEBUG : box root 'rclone-test-bewixux4yamu': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/01/31 04:12:40 ERROR : : error listing: directory not found
2025/01/31 04:12:41 DEBUG : box root 'rclone-test-bewixux4yamu': Ignoring "Shared folder — ForNick" - unknown type "web_link"
--- FAIL: TestIntegration (52.57s)
    --- FAIL: TestIntegration/FsMkdir (48.60s)
        --- FAIL: TestIntegration/FsMkdir/FsChangeNotify (46.18s)
FAIL
exit status 1
FAIL	github.com/rclone/rclone/backend/box	52.585s
"go test -v -timeout 1h0m0s -remote TestBox: -verbose -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Finished ERROR in 53.105677141s (try 5/5): exit status 1: Failed [TestIntegration/FsMkdir/FsChangeNotify]