"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024 -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Starting (try 5/5)
=== RUN   TestIntegration
    fstests.go:438: Using remote "TestChunkerChunk50bBox:"
2025/05/17 04:38:58 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-tupitif8lasi"
2025/05/17 04:38:58 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/05/17 04:38:58 DEBUG : Creating backend with remote "TestBox:rclone-test-tupitif8lasi"
2025/05/17 04:38:59 DEBUG : box root 'rclone-test-tupitif8lasi': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/05/17 04:38:59 DEBUG : box root 'rclone-test-tupitif8lasi': Ignoring "Shared folder — ForNick" - unknown type "web_link"
=== RUN   TestIntegration/FsMkdir
=== RUN   TestIntegration/FsMkdir/FsChangeNotify
2025/05/17 04:39:01 INFO  : dir: Making directory
2025/05/17 04:39:02 INFO  : dir/subdir1: Making directory
2025/05/17 04:39:03 INFO  : dir/subdir3: Making directory
2025/05/17 04:39:03 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941489501")
2025/05/17 04:39:03 DEBUG : box root 'rclone-test-tupitif8lasi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/17 04:39:03 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941490718")
2025/05/17 04:39:04 INFO  : dir/subdir2: Making directory
2025/05/17 04:39:04 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941490947")
2025/05/17 04:39:04 DEBUG : box root 'rclone-test-tupitif8lasi': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/17 04:39:04 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941491722")
2025/05/17 04:39:05 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941491952")
2025/05/17 04:39:06 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941492742")
2025/05/17 04:39:06 DEBUG : box root 'rclone-test-tupitif8lasi': ["rclone-test-tupitif8lasi"(0)|folder|ITEM_CREATE|321612515018|df4dd2c1652424a4c995c803ca9caed2a60ec3d8] new parent not found
2025/05/17 04:39:06 DEBUG : box root 'rclone-test-tupitif8lasi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/17 04:39:06 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941493719")
2025/05/17 04:39:07 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941493938")
2025/05/17 04:39:07 DEBUG : box root 'rclone-test-tupitif8lasi': ["sub dir"(0)|folder|ITEM_CREATE|321609959452|e4b6b1eeeb36d466742606a051335d086511a4ba] new parent not found
2025/05/17 04:39:07 DEBUG : box root 'rclone-test-tupitif8lasi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/17 04:39:07 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941494721")
2025/05/17 04:39:08 DEBUG : box root 'rclone-test-tupitif8lasi': ["dir"(0)|folder|ITEM_CREATE|321611313352|df78ffd4b671422fe9b42327c43eaaa27265f64e] added new path ("dir") for notify
2025/05/17 04:39:08 DEBUG : doChangeNotify("dir", 0)
2025/05/17 04:39:08 DEBUG : box root 'rclone-test-tupitif8lasi': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/17 04:39:08 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941494941")
2025/05/17 04:39:08 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941495164")
2025/05/17 04:39:08 DEBUG : box root 'rclone-test-tupitif8lasi': ["hello world"(0)|file|ITEM_UPLOAD|1864897650744|6f1a8390ffa290e37df9c07aceaa6363a82acdd2] new parent not found
2025/05/17 04:39:08 DEBUG : box root 'rclone-test-tupitif8lasi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/17 04:39:08 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941495721")
2025/05/17 04:39:09 DEBUG : box root 'rclone-test-tupitif8lasi': ["subdir1"(0)|folder|ITEM_CREATE|321612537558|d844e9b6fd19b34b9459c45b15190d31f03a425d] added new path ("dir/subdir1") for notify
2025/05/17 04:39:09 DEBUG : doChangeNotify("dir/subdir1", 0)
2025/05/17 04:39:09 DEBUG : box root 'rclone-test-tupitif8lasi': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/17 04:39:09 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941495944")
2025/05/17 04:39:09 INFO  : dir/file2.rclone_chunk.001_e7vdve: Moved (server-side) to: dir/file2.rclone_chunk.001
2025/05/17 04:39:09 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941496169")
2025/05/17 04:39:09 INFO  : dir/file2.rclone_chunk.002_e7vdve: Moved (server-side) to: dir/file2.rclone_chunk.002
2025/05/17 04:39:10 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941496722")
2025/05/17 04:39:10 DEBUG : box root 'rclone-test-tupitif8lasi': ["subdir3"(0)|folder|ITEM_CREATE|321611073537|f2e854a4574e48a68c9f113a3aa7bb0ce73b0790] added new path ("dir/subdir3") for notify
2025/05/17 04:39:10 DEBUG : doChangeNotify("dir/subdir3", 0)
2025/05/17 04:39:10 DEBUG : box root 'rclone-test-tupitif8lasi': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/17 04:39:10 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941497728")
2025/05/17 04:39:11 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941497950")
2025/05/17 04:39:11 DEBUG : box root 'rclone-test-tupitif8lasi': ["subdir2"(0)|folder|ITEM_CREATE|321612667038|ac87da6c28e8ed937af791416df43b74c3289b95] added new path ("dir/subdir2") for notify
2025/05/17 04:39:11 DEBUG : doChangeNotify("dir/subdir2", 0)
2025/05/17 04:39:11 DEBUG : box root 'rclone-test-tupitif8lasi': Received 3 events, resulting in 1 paths and 1 notifications
2025/05/17 04:39:11 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941498719")
2025/05/17 04:39:12 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941498943")
2025/05/17 04:39:13 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941499719")
2025/05/17 04:39:13 DEBUG : box root 'rclone-test-tupitif8lasi': ["sub dir"(0)|folder|ITEM_CREATE|321611114050|ab9ef52a6ee2cecc7c994095f6033034241e79ba] new parent not found
2025/05/17 04:39:13 DEBUG : box root 'rclone-test-tupitif8lasi': ["file2.rclone_chunk.001_e7vdve"(0)|file|ITEM_UPLOAD|1864900883695|465d5e2b5122eb93b46a056f049763744a4c3972] ignored due to old SequenceID ('\x01')
2025/05/17 04:39:13 DEBUG : box root 'rclone-test-tupitif8lasi': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/17 04:39:13 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941500720")
2025/05/17 04:39:14 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941500946")
2025/05/17 04:39:14 DEBUG : box root 'rclone-test-tupitif8lasi': ["sub dir2"(0)|folder|ITEM_CREATE|321610352470|021a6f43b7e396fa267241963ba68a5bddc5bc94] new parent not found
2025/05/17 04:39:14 DEBUG : box root 'rclone-test-tupitif8lasi': ["file2.rclone_chunk.002_e7vdve"(0)|file|ITEM_UPLOAD|1864902378429|f2c13e121ed4f1a068086aeeab7185deb4f756bd] ignored due to old SequenceID ('\x01')
2025/05/17 04:39:14 DEBUG : box root 'rclone-test-tupitif8lasi': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/17 04:39:14 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941501730")
2025/05/17 04:39:15 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941501962")
2025/05/17 04:39:15 DEBUG : box root 'rclone-test-tupitif8lasi': ["hello world"(0)|file|ITEM_UPLOAD|1864904272545|12b8b8ed9422f0a94564c427c610266cfb74ee72] new parent not found
2025/05/17 04:39:15 DEBUG : box root 'rclone-test-tupitif8lasi': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1864902378429|a99a3146adcdd957a6d30c3bf4260043523e3b77] ignored due to old SequenceID ('\x01')
2025/05/17 04:39:15 DEBUG : box root 'rclone-test-tupitif8lasi': ["file2.rclone_chunk.001"(1)|file|ITEM_RENAME|1864900883695|359e1c1bfef556dbb611ffe3b993a0649cd1141b] ignored due to old SequenceID ('\x01')
2025/05/17 04:39:15 DEBUG : box root 'rclone-test-tupitif8lasi': Received 3 events, resulting in 0 paths and 0 notifications
2025/05/17 04:39:15 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941502722")
2025/05/17 04:39:16 INFO  : dir/file4.rclone_chunk.001_e7vke5: Moved (server-side) to: dir/file4.rclone_chunk.001
2025/05/17 04:39:16 INFO  : dir/file4.rclone_chunk.002_e7vke5: Moved (server-side) to: dir/file4.rclone_chunk.002
2025/05/17 04:39:16 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941502947")
2025/05/17 04:39:16 DEBUG : box root 'rclone-test-tupitif8lasi': ["file2"(0)|file|ITEM_UPLOAD|1864898046289|13668a5791fde89f38915ff95b96a78d6fe7932c] ignored due to old SequenceID ('\x00')
2025/05/17 04:39:16 DEBUG : box root 'rclone-test-tupitif8lasi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/17 04:39:16 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941503718")
2025/05/17 04:39:17 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941503942")
2025/05/17 04:39:18 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941504718")
2025/05/17 04:39:18 DEBUG : box root 'rclone-test-tupitif8lasi': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/17 04:39:18 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941505722")
2025/05/17 04:39:19 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941505953")
2025/05/17 04:39:19 DEBUG : box root 'rclone-test-tupitif8lasi': ["file4.rclone_chunk.001_e7vke5"(0)|file|ITEM_UPLOAD|1864900883206|f2bb17edc1574c2c6e701acc75700850669a371e] ignored due to old SequenceID ('\x01')
2025/05/17 04:39:19 DEBUG : box root 'rclone-test-tupitif8lasi': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/17 04:39:19 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941506720")
2025/05/17 04:39:20 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941506954")
2025/05/17 04:39:21 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941507723")
2025/05/17 04:39:21 DEBUG : box root 'rclone-test-tupitif8lasi': ["file4.rclone_chunk.002_e7vke5"(0)|file|ITEM_UPLOAD|1864894578515|c6ec55add938dddebbff3fa3986151bfe3099c89] ignored due to old SequenceID ('\x01')
2025/05/17 04:39:21 DEBUG : box root 'rclone-test-tupitif8lasi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/17 04:39:21 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941508724")
2025/05/17 04:39:22 DEBUG : box root 'rclone-test-tupitif8lasi': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1864900883206|257ea5a82a5b9b4768dc68d4d71229c1f2453367] ignored due to old SequenceID ('\x01')
2025/05/17 04:39:22 DEBUG : box root 'rclone-test-tupitif8lasi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/17 04:39:22 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941508949")
2025/05/17 04:39:22 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941509169")
2025/05/17 04:39:23 INFO  : dir/file3.rclone_chunk.001_e7vrhe: Moved (server-side) to: dir/file3.rclone_chunk.001
2025/05/17 04:39:23 INFO  : dir/file3.rclone_chunk.002_e7vrhe: Moved (server-side) to: dir/file3.rclone_chunk.002
2025/05/17 04:39:23 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941509723")
2025/05/17 04:39:23 DEBUG : box root 'rclone-test-tupitif8lasi': ["file4.rclone_chunk.002"(1)|file|ITEM_RENAME|1864894578515|f99b68e71e171471a557a6fa8b1235ec8765cfc9] ignored due to old SequenceID ('\x01')
2025/05/17 04:39:23 DEBUG : box root 'rclone-test-tupitif8lasi': ["sub dir"(0)|folder|ITEM_CREATE|321612525119|18f52dc41b971ca59a77ce441cfcf1cbffe3a1ec] new parent not found
2025/05/17 04:39:23 DEBUG : box root 'rclone-test-tupitif8lasi': ["hello world"(0)|file|ITEM_UPLOAD|1864894952417|dff86750751b676d971799f8b678a2f851cdd035] new parent not found
2025/05/17 04:39:23 DEBUG : box root 'rclone-test-tupitif8lasi': Received 3 events, resulting in 0 paths and 0 notifications
2025/05/17 04:39:23 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941510724")
2025/05/17 04:39:24 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941510954")
2025/05/17 04:39:24 DEBUG : box root 'rclone-test-tupitif8lasi': ["file4"(0)|file|ITEM_UPLOAD|1864899195712|6cd29d8a3f6913d99c1ef7ce3ed3d27a8485cc76] ignored due to old SequenceID ('\x00')
2025/05/17 04:39:24 DEBUG : box root 'rclone-test-tupitif8lasi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/17 04:39:24 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941511723")
2025/05/17 04:39:25 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941511948")
    fstests.go:931: Try 1/10 waiting for dirChanges and objChanges
2025/05/17 04:39:26 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941512720")
2025/05/17 04:39:26 DEBUG : box root 'rclone-test-tupitif8lasi': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/17 04:39:26 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941513720")
2025/05/17 04:39:27 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941513949")
2025/05/17 04:39:27 DEBUG : box root 'rclone-test-tupitif8lasi': ["file3.rclone_chunk.001_e7vrhe"(0)|file|ITEM_UPLOAD|1864897082357|abd0a3f83f8a5ec8df1b8bd6d1d6828c33eb1bde] ignored due to old SequenceID ('\x01')
2025/05/17 04:39:27 DEBUG : box root 'rclone-test-tupitif8lasi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/17 04:39:27 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941514725")
2025/05/17 04:39:28 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941514954")
    fstests.go:931: Try 2/10 waiting for dirChanges and objChanges
2025/05/17 04:39:28 DEBUG : box root 'rclone-test-tupitif8lasi': ["file3.rclone_chunk.002_e7vrhe"(0)|file|ITEM_UPLOAD|1864903282806|78d3e04d33732dca32df045f06c6591f0f479bf3] ignored due to old SequenceID ('\x01')
2025/05/17 04:39:28 DEBUG : box root 'rclone-test-tupitif8lasi': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1864897082357|a5c923857a8e96793e19b82901105b796640c6fb] ignored due to old SequenceID ('\x01')
2025/05/17 04:39:28 DEBUG : box root 'rclone-test-tupitif8lasi': ["sub dir"(0)|folder|ITEM_CREATE|321610803741|3faac2f240de97c005b58c19991f9f05c4298879] new parent not found
2025/05/17 04:39:28 DEBUG : box root 'rclone-test-tupitif8lasi': Received 3 events, resulting in 0 paths and 0 notifications
2025/05/17 04:39:28 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941515720")
2025/05/17 04:39:29 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941515950")
2025/05/17 04:39:29 DEBUG : box root 'rclone-test-tupitif8lasi': ["hello world"(0)|file|ITEM_UPLOAD|1864902344445|668dabab674de0ba23d63b6344cedd9aff620737] new parent not found
2025/05/17 04:39:29 DEBUG : box root 'rclone-test-tupitif8lasi': ["file3.rclone_chunk.002"(1)|file|ITEM_RENAME|1864903282806|5ab3483a8e8ae3e75963761e796cbde5d5c4b2d3] ignored due to old SequenceID ('\x01')
2025/05/17 04:39:29 DEBUG : box root 'rclone-test-tupitif8lasi': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/17 04:39:29 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941516721")
2025/05/17 04:39:30 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941516950")
2025/05/17 04:39:30 DEBUG : box root 'rclone-test-tupitif8lasi': ["file3"(0)|file|ITEM_UPLOAD|1864901898415|3df96ea384d5fa6f80272ec4bdcb7423e8d97ffa] ignored due to old SequenceID ('\x00')
2025/05/17 04:39:30 DEBUG : box root 'rclone-test-tupitif8lasi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/17 04:39:30 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941517723")
2025/05/17 04:39:31 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941517947")
    fstests.go:931: Try 3/10 waiting for dirChanges and objChanges
2025/05/17 04:39:32 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941518723")
2025/05/17 04:39:33 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941519724")
2025/05/17 04:39:33 DEBUG : box root 'rclone-test-tupitif8lasi': ["rclone-test-nucetik6homa"(0)|folder|ITEM_CREATE|321612515433|1bb56759d9d7e38eddbf52b3887eced33352bbae] new parent not found
2025/05/17 04:39:33 DEBUG : box root 'rclone-test-tupitif8lasi': ["sub dir"(0)|folder|ITEM_CREATE|321612376451|9688329219eaee6bba887d3c8af323269c4e5c3b] new parent not found
2025/05/17 04:39:33 DEBUG : box root 'rclone-test-tupitif8lasi': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/17 04:39:33 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941520724")
2025/05/17 04:39:34 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941520956")
    fstests.go:931: Try 4/10 waiting for dirChanges and objChanges
2025/05/17 04:39:35 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941521729")
2025/05/17 04:39:35 DEBUG : box root 'rclone-test-tupitif8lasi': ["hello world"(0)|file|ITEM_COPY|1864904888711|6827eb6687d9bd7061faead9f675c17f16def005] new parent not found
2025/05/17 04:39:35 DEBUG : box root 'rclone-test-tupitif8lasi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/17 04:39:35 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941522726")
2025/05/17 04:39:36 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941522944")
2025/05/17 04:39:36 DEBUG : box root 'rclone-test-tupitif8lasi': Received 3 events, resulting in 0 paths and 0 notifications
2025/05/17 04:39:36 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941523723")
2025/05/17 04:39:37 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941523955")
    fstests.go:931: Try 5/10 waiting for dirChanges and objChanges
2025/05/17 04:39:38 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941524719")
2025/05/17 04:39:39 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941525725")
2025/05/17 04:39:39 DEBUG : box root 'rclone-test-tupitif8lasi': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/17 04:39:39 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941526719")
2025/05/17 04:39:40 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941526957")
    fstests.go:931: Try 6/10 waiting for dirChanges and objChanges
2025/05/17 04:39:41 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941527724")
2025/05/17 04:39:41 DEBUG : box root 'rclone-test-tupitif8lasi': ["sub dir"(0)|folder|ITEM_CREATE|321611411747|233f703dada835da40ae20bde086a07e5a307215] new parent not found
2025/05/17 04:39:41 DEBUG : box root 'rclone-test-tupitif8lasi': ["hello world"(0)|file|ITEM_UPLOAD|1864904492583|6187c8083c3c574bdf763d936fb3d93d1179c6e9] new parent not found
2025/05/17 04:39:41 DEBUG : box root 'rclone-test-tupitif8lasi': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/17 04:39:41 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941528724")
2025/05/17 04:39:42 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941528953")
2025/05/17 04:39:43 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941529725")
    fstests.go:931: Try 7/10 waiting for dirChanges and objChanges
2025/05/17 04:39:44 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941530722")
2025/05/17 04:39:44 DEBUG : box root 'rclone-test-tupitif8lasi': ["hello world"(1)|file|ITEM_UPLOAD|1864904492583|141c1ce21c1ce87420d419892c89c5fed5bf41af] new parent not found
2025/05/17 04:39:44 DEBUG : box root 'rclone-test-tupitif8lasi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/17 04:39:44 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941531719")
2025/05/17 04:39:45 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941531945")
2025/05/17 04:39:46 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941532723")
    fstests.go:931: Try 8/10 waiting for dirChanges and objChanges
2025/05/17 04:39:46 DEBUG : box root 'rclone-test-tupitif8lasi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/17 04:39:46 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941533720")
2025/05/17 04:39:47 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941533943")
2025/05/17 04:39:47 DEBUG : box root 'rclone-test-tupitif8lasi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/17 04:39:47 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941534727")
2025/05/17 04:39:48 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941534948")
2025/05/17 04:39:49 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941535727")
    fstests.go:931: Try 9/10 waiting for dirChanges and objChanges
2025/05/17 04:39:49 DEBUG : box root 'rclone-test-tupitif8lasi': ["sub dir"(0)|folder|ITEM_CREATE|321611434879|d41ddd7dc8be75126cb4dd945059cb5b664507af] new parent not found
2025/05/17 04:39:49 DEBUG : box root 'rclone-test-tupitif8lasi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/17 04:39:49 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941536722")
2025/05/17 04:39:50 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941536947")
2025/05/17 04:39:50 DEBUG : box root 'rclone-test-tupitif8lasi': ["hello world"(0)|file|ITEM_UPLOAD|1864900712777|e705ee636944b35560b265b5a3d2aec0ff5a3db9] new parent not found
2025/05/17 04:39:50 DEBUG : box root 'rclone-test-tupitif8lasi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/17 04:39:50 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941537727")
2025/05/17 04:39:51 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941537953")
2025/05/17 04:39:52 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941538719")
    fstests.go:935: map[dir:{} dir/subdir1:{} dir/subdir2:{} dir/subdir3:{}] does not contain [dir/subdir1 dir/subdir3 dir/subdir2] or 
        map[] does not contain [dir/file2 dir/file4 dir/file3]
2025/05/17 04:39:53 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941539722")
2025/05/17 04:39:54 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941540728")
2025/05/17 04:39:55 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941541722")
2025/05/17 04:39:56 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941542736")
2025/05/17 04:39:56 DEBUG : box root 'rclone-test-tupitif8lasi': ["rclone-test-coqapim7nipu"(0)|folder|ITEM_CREATE|321612104659|0de9ba666eac02011fc5ea884c2e8440e29e87e3] new parent not found
2025/05/17 04:39:56 DEBUG : box root 'rclone-test-tupitif8lasi': ["hello world"(0)|file|ITEM_COPY|1864905748587|8bb13384a8b80a71aad7ee71a721ca8fb342dd85] new parent not found
2025/05/17 04:39:56 DEBUG : box root 'rclone-test-tupitif8lasi': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/17 04:39:56 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941543721")
2025/05/17 04:39:57 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941543947")
2025/05/17 04:39:57 DEBUG : box root 'rclone-test-tupitif8lasi': ["sub dir"(0)|folder|ITEM_CREATE|321612202864|cb372a19a17499387119c19487ccf780e8123377] new parent not found
2025/05/17 04:39:57 DEBUG : box root 'rclone-test-tupitif8lasi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/17 04:39:57 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941544719")
2025/05/17 04:39:58 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941544943")
2025/05/17 04:39:58 DEBUG : box root 'rclone-test-tupitif8lasi': ["hello world"(1)|file|ITEM_UPLOAD|1864900712777|1a112f82432aa01bbec7565a96b98270c2b84ded] new parent not found
2025/05/17 04:39:58 DEBUG : box root 'rclone-test-tupitif8lasi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/17 04:39:58 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941545720")
2025/05/17 04:39:59 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941545943")
2025/05/17 04:40:00 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941546720")
2025/05/17 04:40:00 DEBUG : box root 'rclone-test-tupitif8lasi': ["file2"(1)|file|ITEM_TRASH|1864898046289|3e11e3f761f70dde94361a31f6601ffb00e036ab] added old path ("dir/file2") for notify
2025/05/17 04:40:00 DEBUG : box root 'rclone-test-tupitif8lasi': ["file2.rclone_chunk.001"(2)|file|ITEM_TRASH|1864900883695|da2d127cd1fef6621c27c4c7defb1bf95c1ca730] added old path ("dir/file2.rclone_chunk.001") for notify
2025/05/17 04:40:00 DEBUG : doChangeNotify("dir/file2", 1)
2025/05/17 04:40:00 DEBUG : doChangeNotify("dir/file2", 1)
2025/05/17 04:40:00 DEBUG : box root 'rclone-test-tupitif8lasi': Received 2 events, resulting in 2 paths and 2 notifications
2025/05/17 04:40:00 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941547719")
2025/05/17 04:40:01 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941547951")
2025/05/17 04:40:01 DEBUG : box root 'rclone-test-tupitif8lasi': ["hello world-rclone-copy-yizoner2"(0)|file|ITEM_COPY|1864898310635|d5831a697605bc27dc847af8cbdbfe5b195baed6] new parent not found
2025/05/17 04:40:01 DEBUG : box root 'rclone-test-tupitif8lasi': ["file2.rclone_chunk.002"(2)|file|ITEM_TRASH|1864902378429|707a5b1606fd48a4020b23e556c4e05d68c62e36] added old path ("dir/file2.rclone_chunk.002") for notify
2025/05/17 04:40:01 DEBUG : doChangeNotify("dir/file2", 1)
2025/05/17 04:40:01 DEBUG : box root 'rclone-test-tupitif8lasi': Received 2 events, resulting in 1 paths and 1 notifications
2025/05/17 04:40:01 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941548722")
2025/05/17 04:40:02 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941548956")
2025/05/17 04:40:02 DEBUG : box root 'rclone-test-tupitif8lasi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/17 04:40:02 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941549723")
2025/05/17 04:40:03 DEBUG : box root 'rclone-test-tupitif8lasi': ["hello world"(1)|file|ITEM_RENAME|1864898310635|b2b05e7026e883c0d57d037c23f4151a839eaeb2] new parent not found
2025/05/17 04:40:03 DEBUG : box root 'rclone-test-tupitif8lasi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/17 04:40:03 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941549950")
2025/05/17 04:40:03 DEBUG : box root 'rclone-test-tupitif8lasi': ["file4"(1)|file|ITEM_TRASH|1864899195712|775a78f3d1208ccc0190326fb9e8f8f9f288ebd4] added old path ("dir/file4") for notify
2025/05/17 04:40:03 DEBUG : doChangeNotify("dir/file4", 1)
2025/05/17 04:40:03 DEBUG : box root 'rclone-test-tupitif8lasi': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/17 04:40:03 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941550171")
2025/05/17 04:40:03 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941550399")
2025/05/17 04:40:04 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941550730")
2025/05/17 04:40:05 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941551719")
2025/05/17 04:40:05 DEBUG : box root 'rclone-test-tupitif8lasi': ["file4.rclone_chunk.001"(2)|file|ITEM_TRASH|1864900883206|ccad5c7658085999f73cf7fd4d52cab2cbc888bd] old parent not cached
2025/05/17 04:40:05 DEBUG : box root 'rclone-test-tupitif8lasi': ["file4.rclone_chunk.002"(2)|file|ITEM_TRASH|1864894578515|232e50bf52cb3b712f90d1c702d405a1aa95737e] old parent not cached
2025/05/17 04:40:05 DEBUG : box root 'rclone-test-tupitif8lasi': Received 5 events, resulting in 0 paths and 0 notifications
2025/05/17 04:40:05 DEBUG : box root 'rclone-test-tupitif8lasi': Checking for changes on remote (next_stream_position: "30401044941552722")
2025/05/17 04:40:06 DEBUG : box root 'rclone-test-tupitif8lasi': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/05/17 04:40:06 ERROR : : error listing: directory not found
2025/05/17 04:40:07 DEBUG : box root 'rclone-test-tupitif8lasi': Ignoring "Shared folder — ForNick" - unknown type "web_link"
--- FAIL: TestIntegration (69.22s)
    --- FAIL: TestIntegration/FsMkdir (66.11s)
        --- FAIL: TestIntegration/FsMkdir/FsChangeNotify (64.33s)
FAIL
exit status 1
FAIL	github.com/rclone/rclone/backend/chunker	69.274s
"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024 -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Finished ERROR in 1m12.056344304s (try 5/5): exit status 1: Failed [TestIntegration/FsMkdir/FsChangeNotify]