"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/06 07:15:59 DEBUG : Creating backend with remote "TestBox:rclone-test-yutuqed9luti"
2025/03/06 07:15:59 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/03/06 07:15:59 DEBUG : box root 'rclone-test-yutuqed9luti': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/03/06 07:16:00 DEBUG : box root 'rclone-test-yutuqed9luti': Ignoring "Shared folder — ForNick" - unknown type "web_link"
=== RUN   TestIntegration/FsMkdir
=== RUN   TestIntegration/FsMkdir/FsChangeNotify
2025/03/06 07:16:02 INFO  : dir: Making directory
2025/03/06 07:16:03 INFO  : dir/subdir1: Making directory
2025/03/06 07:16:04 DEBUG : box root 'rclone-test-yutuqed9luti': Checking for changes on remote (next_stream_position: "30401038730110650")
2025/03/06 07:16:04 INFO  : dir/subdir3: Making directory
2025/03/06 07:16:05 DEBUG : box root 'rclone-test-yutuqed9luti': Received 1 events, resulting in 0 paths and 0 notifications
2025/03/06 07:16:05 DEBUG : box root 'rclone-test-yutuqed9luti': Checking for changes on remote (next_stream_position: "30401038730111881")
2025/03/06 07:16:05 DEBUG : box root 'rclone-test-yutuqed9luti': ["êé"(1)|folder|ITEM_TRASH|310385382589|92dcf84619d86cf5acd1830cdd2bbd5eecc81532] ignored due to duplicate EventID
2025/03/06 07:16:05 DEBUG : box root 'rclone-test-yutuqed9luti': Checking for changes on remote (next_stream_position: "30401038730112124")
2025/03/06 07:16:06 INFO  : dir/subdir2: Making directory
2025/03/06 07:16:06 DEBUG : box root 'rclone-test-yutuqed9luti': Checking for changes on remote (next_stream_position: "30401038730112884")
2025/03/06 07:16:07 DEBUG : box root 'rclone-test-yutuqed9luti': ["êé"(1)|folder|ITEM_TRASH|310385382589|92dcf84619d86cf5acd1830cdd2bbd5eecc81532] ignored due to duplicate EventID
2025/03/06 07:16:07 DEBUG : box root 'rclone-test-yutuqed9luti': Checking for changes on remote (next_stream_position: "30401038730113892")
2025/03/06 07:16:08 DEBUG : box root 'rclone-test-yutuqed9luti': ["êé"(1)|folder|ITEM_TRASH|310385382589|92dcf84619d86cf5acd1830cdd2bbd5eecc81532] ignored due to duplicate EventID
2025/03/06 07:16:08 DEBUG : box root 'rclone-test-yutuqed9luti': Received 2 events, resulting in 0 paths and 0 notifications
2025/03/06 07:16:08 DEBUG : box root 'rclone-test-yutuqed9luti': Checking for changes on remote (next_stream_position: "30401038730114889")
2025/03/06 07:16:08 DEBUG : box root 'rclone-test-yutuqed9luti': ["êé"(1)|folder|ITEM_TRASH|310385382589|92dcf84619d86cf5acd1830cdd2bbd5eecc81532] ignored due to duplicate EventID
2025/03/06 07:16:08 DEBUG : box root 'rclone-test-yutuqed9luti': ["file3"(1)|file|ITEM_TRASH|1795259223919|fc161f3f30819740cecdbbfe0935eefdf814e44d] ignored due to duplicate EventID
2025/03/06 07:16:08 DEBUG : box root 'rclone-test-yutuqed9luti': Checking for changes on remote (next_stream_position: "30401038730115144")
2025/03/06 07:16:09 DEBUG : box root 'rclone-test-yutuqed9luti': ["êé"(1)|folder|ITEM_TRASH|310385382589|92dcf84619d86cf5acd1830cdd2bbd5eecc81532] ignored due to duplicate EventID
2025/03/06 07:16:09 DEBUG : box root 'rclone-test-yutuqed9luti': ["file3"(1)|file|ITEM_TRASH|1795259223919|fc161f3f30819740cecdbbfe0935eefdf814e44d] ignored due to duplicate EventID
2025/03/06 07:16:09 DEBUG : box root 'rclone-test-yutuqed9luti': Checking for changes on remote (next_stream_position: "30401038730115886")
2025/03/06 07:16:10 DEBUG : box root 'rclone-test-yutuqed9luti': ["file3"(1)|file|ITEM_TRASH|1795259223919|fc161f3f30819740cecdbbfe0935eefdf814e44d] ignored due to duplicate EventID
2025/03/06 07:16:10 DEBUG : box root 'rclone-test-yutuqed9luti': Checking for changes on remote (next_stream_position: "30401038730116914")
2025/03/06 07:16:11 DEBUG : box root 'rclone-test-yutuqed9luti': ["file3"(1)|file|ITEM_TRASH|1795259223919|fc161f3f30819740cecdbbfe0935eefdf814e44d] ignored due to duplicate EventID
2025/03/06 07:16:11 DEBUG : box root 'rclone-test-yutuqed9luti': Received 2 events, resulting in 0 paths and 0 notifications
2025/03/06 07:16:11 DEBUG : box root 'rclone-test-yutuqed9luti': Checking for changes on remote (next_stream_position: "30401038730117905")
2025/03/06 07:16:11 DEBUG : box root 'rclone-test-yutuqed9luti': Checking for changes on remote (next_stream_position: "30401038730118164")
2025/03/06 07:16:12 DEBUG : box root 'rclone-test-yutuqed9luti': ["file3"(1)|file|ITEM_TRASH|1795259223919|fc161f3f30819740cecdbbfe0935eefdf814e44d] ignored due to duplicate EventID
2025/03/06 07:16:12 DEBUG : box root 'rclone-test-yutuqed9luti': Checking for changes on remote (next_stream_position: "30401038730118894")
2025/03/06 07:16:13 DEBUG : box root 'rclone-test-yutuqed9luti': Checking for changes on remote (next_stream_position: "30401038730119937")
2025/03/06 07:16:14 DEBUG : box root 'rclone-test-yutuqed9luti': Checking for changes on remote (next_stream_position: "30401038730120904")
2025/03/06 07:16:15 DEBUG : box root 'rclone-test-yutuqed9luti': ["file2"(1)|file|ITEM_TRASH|1795265887013|62b36ed5b20e67a95c7ed394be400e22226bfe3f] ignored due to duplicate EventID
2025/03/06 07:16:15 DEBUG : box root 'rclone-test-yutuqed9luti': Received 2 events, resulting in 0 paths and 0 notifications
2025/03/06 07:16:15 DEBUG : box root 'rclone-test-yutuqed9luti': Checking for changes on remote (next_stream_position: "30401038730121890")
    fstests.go:931: Try 1/10 waiting for dirChanges and objChanges
2025/03/06 07:16:15 DEBUG : box root 'rclone-test-yutuqed9luti': Checking for changes on remote (next_stream_position: "30401038730122157")
2025/03/06 07:16:16 DEBUG : box root 'rclone-test-yutuqed9luti': Checking for changes on remote (next_stream_position: "30401038730122890")
2025/03/06 07:16:17 DEBUG : box root 'rclone-test-yutuqed9luti': ["file4"(1)|file|ITEM_TRASH|1795258991145|ef9611d56757d7773219ffb24f3e4359edd2df89] ignored due to duplicate EventID
2025/03/06 07:16:17 DEBUG : box root 'rclone-test-yutuqed9luti': Checking for changes on remote (next_stream_position: "30401038730123871")
    fstests.go:931: Try 2/10 waiting for dirChanges and objChanges
2025/03/06 07:16:18 DEBUG : box root 'rclone-test-yutuqed9luti': Checking for changes on remote (next_stream_position: "30401038730124875")
2025/03/06 07:16:19 DEBUG : box root 'rclone-test-yutuqed9luti': Checking for changes on remote (next_stream_position: "30401038730125876")
2025/03/06 07:16:20 DEBUG : box root 'rclone-test-yutuqed9luti': Received 1 events, resulting in 0 paths and 0 notifications
2025/03/06 07:16:20 DEBUG : box root 'rclone-test-yutuqed9luti': Checking for changes on remote (next_stream_position: "30401038730126874")
2025/03/06 07:16:20 DEBUG : box root 'rclone-test-yutuqed9luti': Received 2 events, resulting in 0 paths and 0 notifications
2025/03/06 07:16:20 DEBUG : box root 'rclone-test-yutuqed9luti': Checking for changes on remote (next_stream_position: "30401038730127118")
2025/03/06 07:16:20 DEBUG : box root 'rclone-test-yutuqed9luti': Checking for changes on remote (next_stream_position: "30401038730127390")
    fstests.go:931: Try 3/10 waiting for dirChanges and objChanges
2025/03/06 07:16:21 DEBUG : box root 'rclone-test-yutuqed9luti': Checking for changes on remote (next_stream_position: "30401038730127880")
2025/03/06 07:16:22 DEBUG : box root 'rclone-test-yutuqed9luti': ["rclone-test-yojacag3colo"(1)|folder|ITEM_TRASH|310385067851|51ae87ac5c422707d5ace9fb0c3475cb019e52ff] ignored due to duplicate EventID
2025/03/06 07:16:22 DEBUG : box root 'rclone-test-yutuqed9luti': Checking for changes on remote (next_stream_position: "30401038730128879")
2025/03/06 07:16:23 DEBUG : box root 'rclone-test-yutuqed9luti': ["rclone-test-yojacag3colo"(1)|folder|ITEM_TRASH|310385067851|51ae87ac5c422707d5ace9fb0c3475cb019e52ff] ignored due to duplicate EventID
2025/03/06 07:16:23 DEBUG : box root 'rclone-test-yutuqed9luti': Checking for changes on remote (next_stream_position: "30401038730129868")
    fstests.go:931: Try 4/10 waiting for dirChanges and objChanges
2025/03/06 07:16:24 DEBUG : box root 'rclone-test-yutuqed9luti': Checking for changes on remote (next_stream_position: "30401038730130891")
2025/03/06 07:16:25 DEBUG : box root 'rclone-test-yutuqed9luti': Checking for changes on remote (next_stream_position: "30401038730131870")
2025/03/06 07:16:26 DEBUG : box root 'rclone-test-yutuqed9luti': Checking for changes on remote (next_stream_position: "30401038730132881")
    fstests.go:931: Try 5/10 waiting for dirChanges and objChanges
2025/03/06 07:16:27 DEBUG : box root 'rclone-test-yutuqed9luti': Checking for changes on remote (next_stream_position: "30401038730133869")
2025/03/06 07:16:28 DEBUG : box root 'rclone-test-yutuqed9luti': Checking for changes on remote (next_stream_position: "30401038730134873")
2025/03/06 07:16:29 DEBUG : box root 'rclone-test-yutuqed9luti': Checking for changes on remote (next_stream_position: "30401038730135868")
    fstests.go:931: Try 6/10 waiting for dirChanges and objChanges
2025/03/06 07:16:30 DEBUG : box root 'rclone-test-yutuqed9luti': Checking for changes on remote (next_stream_position: "30401038730136872")
2025/03/06 07:16:31 DEBUG : box root 'rclone-test-yutuqed9luti': Checking for changes on remote (next_stream_position: "30401038730137874")
2025/03/06 07:16:32 DEBUG : box root 'rclone-test-yutuqed9luti': Checking for changes on remote (next_stream_position: "30401038730138869")
    fstests.go:931: Try 7/10 waiting for dirChanges and objChanges
2025/03/06 07:16:33 DEBUG : box root 'rclone-test-yutuqed9luti': Checking for changes on remote (next_stream_position: "30401038730139872")
2025/03/06 07:16:34 DEBUG : box root 'rclone-test-yutuqed9luti': Checking for changes on remote (next_stream_position: "30401038730140871")
2025/03/06 07:16:35 DEBUG : box root 'rclone-test-yutuqed9luti': Checking for changes on remote (next_stream_position: "30401038730141875")
    fstests.go:931: Try 8/10 waiting for dirChanges and objChanges
2025/03/06 07:16:36 DEBUG : box root 'rclone-test-yutuqed9luti': Checking for changes on remote (next_stream_position: "30401038730142886")
2025/03/06 07:16:37 DEBUG : box root 'rclone-test-yutuqed9luti': Checking for changes on remote (next_stream_position: "30401038730143879")
2025/03/06 07:16:38 DEBUG : box root 'rclone-test-yutuqed9luti': Checking for changes on remote (next_stream_position: "30401038730144874")
    fstests.go:931: Try 9/10 waiting for dirChanges and objChanges
2025/03/06 07:16:39 DEBUG : box root 'rclone-test-yutuqed9luti': Checking for changes on remote (next_stream_position: "30401038730145869")
2025/03/06 07:16:40 DEBUG : box root 'rclone-test-yutuqed9luti': Checking for changes on remote (next_stream_position: "30401038730146871")
2025/03/06 07:16:41 DEBUG : box root 'rclone-test-yutuqed9luti': Checking for changes on remote (next_stream_position: "30401038730147866")
    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 07:16:42 DEBUG : box root 'rclone-test-yutuqed9luti': Checking for changes on remote (next_stream_position: "30401038730148875")
2025/03/06 07:16:43 DEBUG : box root 'rclone-test-yutuqed9luti': Checking for changes on remote (next_stream_position: "30401038730149890")
2025/03/06 07:16:44 DEBUG : box root 'rclone-test-yutuqed9luti': Checking for changes on remote (next_stream_position: "30401038730150902")
2025/03/06 07:16:45 DEBUG : box root 'rclone-test-yutuqed9luti': Checking for changes on remote (next_stream_position: "30401038730151918")
2025/03/06 07:16:46 DEBUG : box root 'rclone-test-yutuqed9luti': Received 1 events, resulting in 0 paths and 0 notifications
2025/03/06 07:16:46 DEBUG : box root 'rclone-test-yutuqed9luti': Checking for changes on remote (next_stream_position: "30401038730152999")
2025/03/06 07:16:46 DEBUG : box root 'rclone-test-yutuqed9luti': Checking for changes on remote (next_stream_position: "30401038730153408")
2025/03/06 07:16:47 DEBUG : box root 'rclone-test-yutuqed9luti': Checking for changes on remote (next_stream_position: "30401038730154010")
2025/03/06 07:16:48 DEBUG : box root 'rclone-test-yutuqed9luti': Checking for changes on remote (next_stream_position: "30401038730154989")
2025/03/06 07:16:51 DEBUG : box root 'rclone-test-yutuqed9luti': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/03/06 07:16:51 ERROR : : error listing: directory not found
2025/03/06 07:16:51 DEBUG : box root 'rclone-test-yutuqed9luti': Ignoring "Shared folder — ForNick" - unknown type "web_link"
--- FAIL: TestIntegration (52.66s)
    --- FAIL: TestIntegration/FsMkdir (49.85s)
        --- FAIL: TestIntegration/FsMkdir/FsChangeNotify (47.13s)
FAIL
exit status 1
FAIL	github.com/rclone/rclone/backend/box	52.677s
"go test -v -timeout 1h0m0s -remote TestBox: -verbose -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Finished ERROR in 53.189699574s (try 3/5): exit status 1: Failed [TestIntegration/FsMkdir/FsChangeNotify]