"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/20 05:13:52 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-siyaror6xago"
2025/03/20 05:13:52 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/03/20 05:13:52 DEBUG : Creating backend with remote "TestBox:rclone-test-siyaror6xago"
2025/03/20 05:13:53 DEBUG : box root 'rclone-test-siyaror6xago': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/03/20 05:13:53 DEBUG : Reset feature "ListR"
2025/03/20 05:13:54 DEBUG : box root 'rclone-test-siyaror6xago': Ignoring "Shared folder — ForNick" - unknown type "web_link"
=== RUN   TestIntegration/FsMkdir
=== RUN   TestIntegration/FsMkdir/FsChangeNotify
2025/03/20 05:13:55 INFO  : dir: Making directory
2025/03/20 05:13:56 INFO  : dir/subdir1: Making directory
2025/03/20 05:13:57 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932383354")
2025/03/20 05:13:58 INFO  : dir/subdir3: Making directory
2025/03/20 05:13:58 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932384584")
2025/03/20 05:13:59 INFO  : dir/subdir2: Making directory
2025/03/20 05:13:59 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932385600")
2025/03/20 05:14:00 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932386587")
2025/03/20 05:14:00 DEBUG : box root 'rclone-test-siyaror6xago': ["rclone-test-siyaror6xago"(0)|folder|ITEM_CREATE|312610909702|00cdc3805f577948fbc358835a6a332fc7662ce4] new parent not found
2025/03/20 05:14:00 DEBUG : box root 'rclone-test-siyaror6xago': ["dir"(0)|folder|ITEM_CREATE|312612280049|7b3181158de905a463b3501602fa43f7676cbf8e] added new path ("dir") for notify
2025/03/20 05:14:00 DEBUG : box root 'rclone-test-siyaror6xago': ["subdir3"(0)|folder|ITEM_CREATE|312611627112|7b9c09a89051905b4b19d6e7e251ed63328ca08d] added new path ("dir/subdir3") for notify
2025/03/20 05:14:00 DEBUG : doChangeNotify("dir", 0)
2025/03/20 05:14:00 DEBUG : doChangeNotify("dir/subdir3", 0)
2025/03/20 05:14:00 DEBUG : box root 'rclone-test-siyaror6xago': Received 3 events, resulting in 2 paths and 2 notifications
2025/03/20 05:14:00 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932387596")
2025/03/20 05:14:01 DEBUG : box root 'rclone-test-siyaror6xago': ["dir"(0)|folder|ITEM_CREATE|312612280049|7b3181158de905a463b3501602fa43f7676cbf8e] ignored due to duplicate EventID
2025/03/20 05:14:01 DEBUG : box root 'rclone-test-siyaror6xago': ["subdir3"(0)|folder|ITEM_CREATE|312611627112|7b9c09a89051905b4b19d6e7e251ed63328ca08d] ignored due to duplicate EventID
2025/03/20 05:14:01 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932387832")
2025/03/20 05:14:01 DEBUG : box root 'rclone-test-siyaror6xago': ["dir"(0)|folder|ITEM_CREATE|312612280049|7b3181158de905a463b3501602fa43f7676cbf8e] ignored due to duplicate EventID
2025/03/20 05:14:01 DEBUG : box root 'rclone-test-siyaror6xago': ["subdir3"(0)|folder|ITEM_CREATE|312611627112|7b9c09a89051905b4b19d6e7e251ed63328ca08d] ignored due to duplicate EventID
2025/03/20 05:14:01 DEBUG : box root 'rclone-test-siyaror6xago': ["subdir1"(0)|folder|ITEM_CREATE|312611509933|3e38633d9efd2fd76c8522cef4ec82ef2ebf3de8] added new path ("dir/subdir1") for notify
2025/03/20 05:14:01 DEBUG : doChangeNotify("dir/subdir1", 0)
2025/03/20 05:14:01 DEBUG : box root 'rclone-test-siyaror6xago': Received 3 events, resulting in 1 paths and 1 notifications
2025/03/20 05:14:01 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932388586")
2025/03/20 05:14:02 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932388827")
2025/03/20 05:14:02 DEBUG : box root 'rclone-test-siyaror6xago': ["dir"(0)|folder|ITEM_CREATE|312612280049|7b3181158de905a463b3501602fa43f7676cbf8e] ignored due to duplicate EventID
2025/03/20 05:14:03 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932389591")
2025/03/20 05:14:03 DEBUG : box root 'rclone-test-siyaror6xago': ["subdir3"(0)|folder|ITEM_CREATE|312611627112|7b9c09a89051905b4b19d6e7e251ed63328ca08d] ignored due to duplicate EventID
2025/03/20 05:14:03 DEBUG : box root 'rclone-test-siyaror6xago': ["subdir1"(0)|folder|ITEM_CREATE|312611509933|3e38633d9efd2fd76c8522cef4ec82ef2ebf3de8] ignored due to duplicate EventID
2025/03/20 05:14:04 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932390582")
2025/03/20 05:14:04 INFO  : dir/file2.rclone_chunk.001_euszux: Moved (server-side) to: dir/file2.rclone_chunk.001
2025/03/20 05:14:04 DEBUG : box root 'rclone-test-siyaror6xago': ["subdir3"(0)|folder|ITEM_CREATE|312611627112|7b9c09a89051905b4b19d6e7e251ed63328ca08d] ignored due to duplicate EventID
2025/03/20 05:14:05 INFO  : dir/file2.rclone_chunk.002_euszux: Moved (server-side) to: dir/file2.rclone_chunk.002
2025/03/20 05:14:05 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932391582")
2025/03/20 05:14:05 DEBUG : box root 'rclone-test-siyaror6xago': ["subdir1"(0)|folder|ITEM_CREATE|312611509933|3e38633d9efd2fd76c8522cef4ec82ef2ebf3de8] ignored due to duplicate EventID
2025/03/20 05:14:05 DEBUG : box root 'rclone-test-siyaror6xago': ["subdir2"(0)|folder|ITEM_CREATE|312611349058|4fe5995b700a1dc40f638c2cb53094f51d929473] added new path ("dir/subdir2") for notify
2025/03/20 05:14:05 DEBUG : box root 'rclone-test-siyaror6xago': ["file2.rclone_chunk.001"(1)|file|ITEM_RENAME|1808587703105|8e08116ddee6692e2680ef47bbe9be01a2cf72b2] added new path ("dir/file2.rclone_chunk.001") for notify
2025/03/20 05:14:05 DEBUG : doChangeNotify("dir/subdir2", 0)
2025/03/20 05:14:05 DEBUG : doChangeNotify("dir/file2", 1)
2025/03/20 05:14:05 DEBUG : box root 'rclone-test-siyaror6xago': Received 3 events, resulting in 2 paths and 2 notifications
2025/03/20 05:14:05 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932392590")
2025/03/20 05:14:06 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932392830")
2025/03/20 05:14:07 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932393584")
2025/03/20 05:14:08 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932394588")
2025/03/20 05:14:08 DEBUG : box root 'rclone-test-siyaror6xago': ["subdir2"(0)|folder|ITEM_CREATE|312611349058|4fe5995b700a1dc40f638c2cb53094f51d929473] ignored due to duplicate EventID
2025/03/20 05:14:09 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932395587")
2025/03/20 05:14:09 DEBUG : box root 'rclone-test-siyaror6xago': ["file2.rclone_chunk.001"(1)|file|ITEM_RENAME|1808587703105|8e08116ddee6692e2680ef47bbe9be01a2cf72b2] ignored due to duplicate EventID
2025/03/20 05:14:10 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932396587")
2025/03/20 05:14:11 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932397585")
2025/03/20 05:14:11 DEBUG : box root 'rclone-test-siyaror6xago': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1808581132323|3dd9ce41826a4c0e50cb79df4ed0fbc8f9fd3007] ignored due to old SequenceID ('\x01')
2025/03/20 05:14:11 DEBUG : box root 'rclone-test-siyaror6xago': ["file2.rclone_chunk.002_euszux"(0)|file|ITEM_UPLOAD|1808581132323|66853e0058e8e5f0b21cc67c18d81d1ce6750113] ignored due to old SequenceID ('\x01')
2025/03/20 05:14:11 DEBUG : box root 'rclone-test-siyaror6xago': Received 2 events, resulting in 0 paths and 0 notifications
2025/03/20 05:14:11 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932398592")
2025/03/20 05:14:12 DEBUG : box root 'rclone-test-siyaror6xago': ["file2"(0)|file|ITEM_UPLOAD|1808586877518|8fa56e93591be49130ee1445f5fbd2370bcd13ef] ignored due to old SequenceID ('\x00')
2025/03/20 05:14:12 DEBUG : box root 'rclone-test-siyaror6xago': ["file4.rclone_chunk.001_eut7zg"(0)|file|ITEM_UPLOAD|1808591843850|3b99e87c77a965bc7c9dec5a929d692323cd2e11] added new path ("dir/file4.rclone_chunk.001_eut7zg") for notify
2025/03/20 05:14:12 DEBUG : doChangeNotify("dir/file4.rclone_chunk.001_eut7zg", 1)
2025/03/20 05:14:12 DEBUG : box root 'rclone-test-siyaror6xago': Received 2 events, resulting in 1 paths and 1 notifications
2025/03/20 05:14:12 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932398827")
2025/03/20 05:14:12 DEBUG : box root 'rclone-test-siyaror6xago': ["file2"(0)|file|ITEM_UPLOAD|1808586877518|8fa56e93591be49130ee1445f5fbd2370bcd13ef] ignored due to duplicate EventID
2025/03/20 05:14:12 DEBUG : box root 'rclone-test-siyaror6xago': ["file4.rclone_chunk.001_eut7zg"(0)|file|ITEM_UPLOAD|1808591843850|3b99e87c77a965bc7c9dec5a929d692323cd2e11] ignored due to duplicate EventID
2025/03/20 05:14:12 INFO  : dir/file4.rclone_chunk.001_eut7zg: Moved (server-side) to: dir/file4.rclone_chunk.001
2025/03/20 05:14:12 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932399072")
2025/03/20 05:14:12 INFO  : dir/file4.rclone_chunk.002_eut7zg: Moved (server-side) to: dir/file4.rclone_chunk.002
2025/03/20 05:14:13 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932399596")
2025/03/20 05:14:13 DEBUG : box root 'rclone-test-siyaror6xago': ["file2"(0)|file|ITEM_UPLOAD|1808586877518|8fa56e93591be49130ee1445f5fbd2370bcd13ef] ignored due to duplicate EventID
2025/03/20 05:14:14 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932400582")
2025/03/20 05:14:15 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932401589")
2025/03/20 05:14:15 DEBUG : box root 'rclone-test-siyaror6xago': ["file4.rclone_chunk.001_eut7zg"(0)|file|ITEM_UPLOAD|1808591843850|3b99e87c77a965bc7c9dec5a929d692323cd2e11] ignored due to duplicate EventID
2025/03/20 05:14:16 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932402587")
2025/03/20 05:14:16 DEBUG : box root 'rclone-test-siyaror6xago': ["file4.rclone_chunk.002_eut7zg"(0)|file|ITEM_UPLOAD|1808581247485|d224c1f4e8ec501c7d5870e1c7391271247bc735] ignored due to old SequenceID ('\x01')
2025/03/20 05:14:16 DEBUG : box root 'rclone-test-siyaror6xago': ["file2.rclone_chunk.001_euszux"(0)|file|ITEM_UPLOAD|1808587703105|03edf581057bb72fa6b26b0d5852203a68bb33db] ignored due to old SequenceID ('\x01')
2025/03/20 05:14:16 DEBUG : box root 'rclone-test-siyaror6xago': Received 2 events, resulting in 0 paths and 0 notifications
2025/03/20 05:14:16 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932403583")
2025/03/20 05:14:17 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932403815")
2025/03/20 05:14:17 DEBUG : box root 'rclone-test-siyaror6xago': ["file4.rclone_chunk.002_eut7zg"(0)|file|ITEM_UPLOAD|1808581247485|d224c1f4e8ec501c7d5870e1c7391271247bc735] ignored due to duplicate EventID
2025/03/20 05:14:18 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932404593")
2025/03/20 05:14:19 INFO  : dir/file3.rclone_chunk.001_eute4j: Moved (server-side) to: dir/file3.rclone_chunk.001
2025/03/20 05:14:19 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932405586")
2025/03/20 05:14:19 DEBUG : box root 'rclone-test-siyaror6xago': ["file2.rclone_chunk.001_euszux"(0)|file|ITEM_UPLOAD|1808587703105|03edf581057bb72fa6b26b0d5852203a68bb33db] ignored due to duplicate EventID
2025/03/20 05:14:20 INFO  : dir/file3.rclone_chunk.002_eute4j: Moved (server-side) to: dir/file3.rclone_chunk.002
2025/03/20 05:14:20 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932406585")
2025/03/20 05:14:21 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932407589")
2025/03/20 05:14:21 DEBUG : box root 'rclone-test-siyaror6xago': ["file4.rclone_chunk.002"(1)|file|ITEM_RENAME|1808581247485|d47d0d45982889c86979a9bcad6d0e25f4a6476c] ignored due to old SequenceID ('\x01')
2025/03/20 05:14:21 DEBUG : box root 'rclone-test-siyaror6xago': Received 1 events, resulting in 0 paths and 0 notifications
2025/03/20 05:14:21 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932408589")
    fstests.go:931: Try 1/10 waiting for dirChanges and objChanges
2025/03/20 05:14:22 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932408819")
2025/03/20 05:14:23 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932409588")
2025/03/20 05:14:23 DEBUG : box root 'rclone-test-siyaror6xago': ["file3.rclone_chunk.001_eute4j"(0)|file|ITEM_UPLOAD|1808581835935|5f9aa7d3c4d43b17dbe27c1b59c3e33742dade0b] ignored due to old SequenceID ('\x01')
2025/03/20 05:14:23 DEBUG : box root 'rclone-test-siyaror6xago': Received 1 events, resulting in 0 paths and 0 notifications
2025/03/20 05:14:23 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932410587")
2025/03/20 05:14:24 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932410819")
2025/03/20 05:14:24 DEBUG : box root 'rclone-test-siyaror6xago': ["file3.rclone_chunk.002_eute4j"(0)|file|ITEM_UPLOAD|1808588726090|f1ce1331cecdd6733e50e49c8c6159a296f05bbb] ignored due to old SequenceID ('\x01')
2025/03/20 05:14:24 DEBUG : box root 'rclone-test-siyaror6xago': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1808581835935|76b5a8108f586e9ec8e3133f3d99e1aa3646d491] ignored due to old SequenceID ('\x01')
2025/03/20 05:14:24 DEBUG : box root 'rclone-test-siyaror6xago': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1808591843850|a2de08dee16743bbd526158108ac55915b3a39e7] ignored due to old SequenceID ('\x01')
2025/03/20 05:14:24 DEBUG : box root 'rclone-test-siyaror6xago': ["file3.rclone_chunk.002"(1)|file|ITEM_RENAME|1808588726090|2a6ee45098efe9ab449575994a28c98cab3a2ec9] ignored due to old SequenceID ('\x01')
2025/03/20 05:14:24 DEBUG : box root 'rclone-test-siyaror6xago': ["file3"(0)|file|ITEM_UPLOAD|1808582663689|80f37e2dedc04e7700ffc94f4718e1a044627475] ignored due to old SequenceID ('\x00')
2025/03/20 05:14:24 DEBUG : box root 'rclone-test-siyaror6xago': Received 5 events, resulting in 0 paths and 0 notifications
2025/03/20 05:14:24 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932411583")
    fstests.go:931: Try 2/10 waiting for dirChanges and objChanges
2025/03/20 05:14:25 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932411851")
2025/03/20 05:14:25 DEBUG : box root 'rclone-test-siyaror6xago': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1808581835935|76b5a8108f586e9ec8e3133f3d99e1aa3646d491] ignored due to duplicate EventID
2025/03/20 05:14:26 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932412588")
2025/03/20 05:14:26 DEBUG : box root 'rclone-test-siyaror6xago': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1808591843850|a2de08dee16743bbd526158108ac55915b3a39e7] ignored due to duplicate EventID
2025/03/20 05:14:26 DEBUG : box root 'rclone-test-siyaror6xago': ["file3.rclone_chunk.002"(1)|file|ITEM_RENAME|1808588726090|2a6ee45098efe9ab449575994a28c98cab3a2ec9] ignored due to duplicate EventID
2025/03/20 05:14:26 DEBUG : box root 'rclone-test-siyaror6xago': ["file3"(0)|file|ITEM_UPLOAD|1808582663689|80f37e2dedc04e7700ffc94f4718e1a044627475] ignored due to duplicate EventID
2025/03/20 05:14:27 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932413592")
2025/03/20 05:14:27 DEBUG : box root 'rclone-test-siyaror6xago': ["file3"(0)|file|ITEM_UPLOAD|1808582663689|80f37e2dedc04e7700ffc94f4718e1a044627475] ignored due to duplicate EventID
    fstests.go:931: Try 3/10 waiting for dirChanges and objChanges
2025/03/20 05:14:28 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932414584")
2025/03/20 05:14:29 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932415591")
2025/03/20 05:14:30 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932416586")
    fstests.go:931: Try 4/10 waiting for dirChanges and objChanges
2025/03/20 05:14:31 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932417585")
2025/03/20 05:14:32 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932418593")
2025/03/20 05:14:32 DEBUG : box root 'rclone-test-siyaror6xago': ["file4"(0)|file|ITEM_UPLOAD|1808586273150|cfa3c93bd0a8b6d4959bf0b88fb1447a5f5c5829] ignored due to old SequenceID ('\x00')
2025/03/20 05:14:32 DEBUG : box root 'rclone-test-siyaror6xago': Received 1 events, resulting in 0 paths and 0 notifications
2025/03/20 05:14:32 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932419583")
2025/03/20 05:14:33 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932419809")
2025/03/20 05:14:33 DEBUG : box root 'rclone-test-siyaror6xago': ["file4"(0)|file|ITEM_UPLOAD|1808586273150|cfa3c93bd0a8b6d4959bf0b88fb1447a5f5c5829] ignored due to duplicate EventID
    fstests.go:931: Try 5/10 waiting for dirChanges and objChanges
2025/03/20 05:14:34 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932420584")
2025/03/20 05:14:35 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932421590")
2025/03/20 05:14:35 DEBUG : box root 'rclone-test-siyaror6xago': ["file4"(0)|file|ITEM_UPLOAD|1808586273150|cfa3c93bd0a8b6d4959bf0b88fb1447a5f5c5829] ignored due to duplicate EventID
2025/03/20 05:14:36 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932422656")
    fstests.go:931: Try 6/10 waiting for dirChanges and objChanges
2025/03/20 05:14:37 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932423583")
2025/03/20 05:14:38 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932424583")
2025/03/20 05:14:39 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932425589")
    fstests.go:931: Try 7/10 waiting for dirChanges and objChanges
2025/03/20 05:14:40 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932426583")
2025/03/20 05:14:41 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932427587")
2025/03/20 05:14:42 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932428582")
    fstests.go:931: Try 8/10 waiting for dirChanges and objChanges
2025/03/20 05:14:43 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932429588")
2025/03/20 05:14:44 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932430584")
2025/03/20 05:14:45 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932431586")
    fstests.go:931: Try 9/10 waiting for dirChanges and objChanges
2025/03/20 05:14:46 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932432585")
2025/03/20 05:14:47 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932433587")
2025/03/20 05:14:48 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932434588")
    fstests.go:935: map[dir:{} dir/subdir1:{} dir/subdir2:{} dir/subdir3:{}] does not contain [dir/subdir1 dir/subdir3 dir/subdir2] or 
        map[dir/file2:{} dir/file4.rclone_chunk.001_eut7zg:{}] does not contain [dir/file2 dir/file4 dir/file3]
2025/03/20 05:14:49 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932435586")
2025/03/20 05:14:50 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932436584")
2025/03/20 05:14:51 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932437581")
2025/03/20 05:14:52 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932438587")
2025/03/20 05:14:53 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932439590")
2025/03/20 05:14:53 DEBUG : box root 'rclone-test-siyaror6xago': ["file2"(1)|file|ITEM_TRASH|1808586877518|485f76205c48f0ccc5b3e47fe7c010b3780d9585] added old path ("dir/file2") for notify
2025/03/20 05:14:53 DEBUG : doChangeNotify("dir/file2", 1)
2025/03/20 05:14:53 DEBUG : box root 'rclone-test-siyaror6xago': Received 1 events, resulting in 1 paths and 1 notifications
2025/03/20 05:14:53 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932440584")
2025/03/20 05:14:54 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932440810")
2025/03/20 05:14:55 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932441589")
2025/03/20 05:14:56 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932442598")
2025/03/20 05:14:56 DEBUG : box root 'rclone-test-siyaror6xago': ["file2"(1)|file|ITEM_TRASH|1808586877518|485f76205c48f0ccc5b3e47fe7c010b3780d9585] ignored due to duplicate EventID
2025/03/20 05:14:56 DEBUG : box root 'rclone-test-siyaror6xago': ["file2.rclone_chunk.001"(2)|file|ITEM_TRASH|1808587703105|649a2c27163f231355b5e4efbfd67a0b543abafb] added old path ("dir/file2.rclone_chunk.001") for notify
2025/03/20 05:14:56 DEBUG : box root 'rclone-test-siyaror6xago': ["file2.rclone_chunk.002"(2)|file|ITEM_TRASH|1808581132323|dc612e2787b5a289da4d8a0ab94184670e08ba36] added old path ("dir/file2.rclone_chunk.002") for notify
2025/03/20 05:14:56 DEBUG : doChangeNotify("dir/file2", 1)
2025/03/20 05:14:56 DEBUG : doChangeNotify("dir/file2", 1)
2025/03/20 05:14:56 DEBUG : box root 'rclone-test-siyaror6xago': Received 3 events, resulting in 2 paths and 2 notifications
2025/03/20 05:14:56 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932443590")
2025/03/20 05:14:57 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932443832")
2025/03/20 05:14:57 DEBUG : box root 'rclone-test-siyaror6xago': ["file2"(1)|file|ITEM_TRASH|1808586877518|485f76205c48f0ccc5b3e47fe7c010b3780d9585] ignored due to duplicate EventID
2025/03/20 05:14:58 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932444590")
2025/03/20 05:14:58 DEBUG : box root 'rclone-test-siyaror6xago': ["file2.rclone_chunk.001"(2)|file|ITEM_TRASH|1808587703105|649a2c27163f231355b5e4efbfd67a0b543abafb] ignored due to duplicate EventID
2025/03/20 05:14:58 DEBUG : box root 'rclone-test-siyaror6xago': ["file2.rclone_chunk.002"(2)|file|ITEM_TRASH|1808581132323|dc612e2787b5a289da4d8a0ab94184670e08ba36] ignored due to duplicate EventID
2025/03/20 05:14:58 DEBUG : box root 'rclone-test-siyaror6xago': ["file4"(1)|file|ITEM_TRASH|1808586273150|b54866b0cb1d27651864030f97cb7ce0fca1a9ec] added old path ("dir/file4") for notify
2025/03/20 05:14:58 DEBUG : box root 'rclone-test-siyaror6xago': ["file4.rclone_chunk.001"(2)|file|ITEM_TRASH|1808591843850|07850cdbc8c81cafc0b9d1c6dfcf6be8085bffda] added old path ("dir/file4.rclone_chunk.001") for notify
2025/03/20 05:14:58 DEBUG : box root 'rclone-test-siyaror6xago': ["file4.rclone_chunk.002"(2)|file|ITEM_TRASH|1808581247485|92fb412d88e993d2308fef9a7db187c07d2a9585] added old path ("dir/file4.rclone_chunk.002") for notify
2025/03/20 05:14:58 DEBUG : doChangeNotify("dir/file4", 1)
2025/03/20 05:14:58 DEBUG : doChangeNotify("dir/file4", 1)
2025/03/20 05:14:58 DEBUG : doChangeNotify("dir/file4", 1)
2025/03/20 05:14:58 DEBUG : box root 'rclone-test-siyaror6xago': Received 5 events, resulting in 3 paths and 3 notifications
2025/03/20 05:14:58 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932445588")
2025/03/20 05:14:59 DEBUG : box root 'rclone-test-siyaror6xago': ["file2.rclone_chunk.002"(2)|file|ITEM_TRASH|1808581132323|dc612e2787b5a289da4d8a0ab94184670e08ba36] ignored due to duplicate EventID
2025/03/20 05:14:59 DEBUG : box root 'rclone-test-siyaror6xago': ["file4"(1)|file|ITEM_TRASH|1808586273150|b54866b0cb1d27651864030f97cb7ce0fca1a9ec] ignored due to duplicate EventID
2025/03/20 05:14:59 DEBUG : box root 'rclone-test-siyaror6xago': ["file4.rclone_chunk.001"(2)|file|ITEM_TRASH|1808591843850|07850cdbc8c81cafc0b9d1c6dfcf6be8085bffda] ignored due to duplicate EventID
2025/03/20 05:14:59 DEBUG : box root 'rclone-test-siyaror6xago': ["file4.rclone_chunk.002"(2)|file|ITEM_TRASH|1808581247485|92fb412d88e993d2308fef9a7db187c07d2a9585] ignored due to duplicate EventID
2025/03/20 05:14:59 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932445838")
2025/03/20 05:14:59 DEBUG : box root 'rclone-test-siyaror6xago': ["file2.rclone_chunk.002"(2)|file|ITEM_TRASH|1808581132323|dc612e2787b5a289da4d8a0ab94184670e08ba36] ignored due to duplicate EventID
2025/03/20 05:14:59 DEBUG : box root 'rclone-test-siyaror6xago': ["file4"(1)|file|ITEM_TRASH|1808586273150|b54866b0cb1d27651864030f97cb7ce0fca1a9ec] ignored due to duplicate EventID
2025/03/20 05:14:59 DEBUG : box root 'rclone-test-siyaror6xago': ["file4.rclone_chunk.001"(2)|file|ITEM_TRASH|1808591843850|07850cdbc8c81cafc0b9d1c6dfcf6be8085bffda] ignored due to duplicate EventID
2025/03/20 05:14:59 DEBUG : box root 'rclone-test-siyaror6xago': ["file4.rclone_chunk.002"(2)|file|ITEM_TRASH|1808581247485|92fb412d88e993d2308fef9a7db187c07d2a9585] ignored due to duplicate EventID
2025/03/20 05:14:59 DEBUG : box root 'rclone-test-siyaror6xago': ["file3"(1)|file|ITEM_TRASH|1808582663689|cb1e7a18bc2ed75b6ae9e1f511b7e91d4be99ceb] added old path ("dir/file3") for notify
2025/03/20 05:14:59 DEBUG : doChangeNotify("dir/file3", 1)
2025/03/20 05:14:59 DEBUG : box root 'rclone-test-siyaror6xago': Received 5 events, resulting in 1 paths and 1 notifications
2025/03/20 05:14:59 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932446598")
2025/03/20 05:15:00 DEBUG : box root 'rclone-test-siyaror6xago': ["file2.rclone_chunk.002"(2)|file|ITEM_TRASH|1808581132323|dc612e2787b5a289da4d8a0ab94184670e08ba36] ignored due to duplicate EventID
2025/03/20 05:15:00 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932446849")
2025/03/20 05:15:00 DEBUG : box root 'rclone-test-siyaror6xago': ["file4"(1)|file|ITEM_TRASH|1808586273150|b54866b0cb1d27651864030f97cb7ce0fca1a9ec] ignored due to duplicate EventID
2025/03/20 05:15:00 DEBUG : box root 'rclone-test-siyaror6xago': ["file4.rclone_chunk.001"(2)|file|ITEM_TRASH|1808591843850|07850cdbc8c81cafc0b9d1c6dfcf6be8085bffda] ignored due to duplicate EventID
2025/03/20 05:15:00 DEBUG : box root 'rclone-test-siyaror6xago': ["file4.rclone_chunk.002"(2)|file|ITEM_TRASH|1808581247485|92fb412d88e993d2308fef9a7db187c07d2a9585] ignored due to duplicate EventID
2025/03/20 05:15:00 DEBUG : box root 'rclone-test-siyaror6xago': ["file3"(1)|file|ITEM_TRASH|1808582663689|cb1e7a18bc2ed75b6ae9e1f511b7e91d4be99ceb] ignored due to duplicate EventID
2025/03/20 05:15:00 DEBUG : box root 'rclone-test-siyaror6xago': ["file3.rclone_chunk.001"(2)|file|ITEM_TRASH|1808581835935|f4ea33d989142166e4eed022869b73543ff178cb] added old path ("dir/file3.rclone_chunk.001") for notify
2025/03/20 05:15:00 DEBUG : doChangeNotify("dir/file3", 1)
2025/03/20 05:15:00 DEBUG : box root 'rclone-test-siyaror6xago': Received 5 events, resulting in 1 paths and 1 notifications
2025/03/20 05:15:00 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932447590")
2025/03/20 05:15:01 DEBUG : box root 'rclone-test-siyaror6xago': ["file4"(1)|file|ITEM_TRASH|1808586273150|b54866b0cb1d27651864030f97cb7ce0fca1a9ec] ignored due to duplicate EventID
2025/03/20 05:15:01 DEBUG : box root 'rclone-test-siyaror6xago': ["file4.rclone_chunk.001"(2)|file|ITEM_TRASH|1808591843850|07850cdbc8c81cafc0b9d1c6dfcf6be8085bffda] ignored due to duplicate EventID
2025/03/20 05:15:01 DEBUG : box root 'rclone-test-siyaror6xago': ["file4.rclone_chunk.002"(2)|file|ITEM_TRASH|1808581247485|92fb412d88e993d2308fef9a7db187c07d2a9585] ignored due to duplicate EventID
2025/03/20 05:15:01 DEBUG : box root 'rclone-test-siyaror6xago': ["file3"(1)|file|ITEM_TRASH|1808582663689|cb1e7a18bc2ed75b6ae9e1f511b7e91d4be99ceb] ignored due to duplicate EventID
2025/03/20 05:15:01 DEBUG : box root 'rclone-test-siyaror6xago': ["file3.rclone_chunk.001"(2)|file|ITEM_TRASH|1808581835935|f4ea33d989142166e4eed022869b73543ff178cb] ignored due to duplicate EventID
2025/03/20 05:15:01 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932447848")
2025/03/20 05:15:01 DEBUG : box root 'rclone-test-siyaror6xago': ["file4.rclone_chunk.001"(2)|file|ITEM_TRASH|1808591843850|07850cdbc8c81cafc0b9d1c6dfcf6be8085bffda] ignored due to duplicate EventID
2025/03/20 05:15:02 DEBUG : box root 'rclone-test-siyaror6xago': Checking for changes on remote (next_stream_position: "30401039932448591")
2025/03/20 05:15:02 DEBUG : box root 'rclone-test-siyaror6xago': ["file4.rclone_chunk.002"(2)|file|ITEM_TRASH|1808581247485|92fb412d88e993d2308fef9a7db187c07d2a9585] ignored due to duplicate EventID
2025/03/20 05:15:04 DEBUG : box root 'rclone-test-siyaror6xago': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/03/20 05:15:04 ERROR : : error listing: directory not found
2025/03/20 05:15:05 DEBUG : box root 'rclone-test-siyaror6xago': Ignoring "Shared folder — ForNick" - unknown type "web_link"
--- FAIL: TestIntegration (72.82s)
    --- FAIL: TestIntegration/FsMkdir (70.08s)
        --- FAIL: TestIntegration/FsMkdir/FsChangeNotify (67.87s)
FAIL
exit status 1
FAIL	github.com/rclone/rclone/backend/chunker	72.873s
"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024 -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Finished ERROR in 1m15.630317916s (try 3/5): exit status 1: Failed [TestIntegration/FsMkdir/FsChangeNotify]