"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024 -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Starting (try 2/5)
=== RUN   TestIntegration
    fstests.go:438: Using remote "TestChunkerChunk50bBox:"
2025/03/20 05:12:36 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-ranasuq6xofe"
2025/03/20 05:12:36 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/03/20 05:12:36 DEBUG : Creating backend with remote "TestBox:rclone-test-ranasuq6xofe"
2025/03/20 05:12:37 DEBUG : box root 'rclone-test-ranasuq6xofe': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/03/20 05:12:38 DEBUG : Reset feature "ListR"
2025/03/20 05:12:39 DEBUG : box root 'rclone-test-ranasuq6xofe': Ignoring "Shared folder — ForNick" - unknown type "web_link"
=== RUN   TestIntegration/FsMkdir
=== RUN   TestIntegration/FsMkdir/FsChangeNotify
2025/03/20 05:12:40 INFO  : dir: Making directory
2025/03/20 05:12:41 INFO  : dir/subdir1: Making directory
2025/03/20 05:12:42 INFO  : dir/subdir3: Making directory
2025/03/20 05:12:42 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932308201")
2025/03/20 05:12:43 INFO  : dir/subdir2: Making directory
2025/03/20 05:12:43 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932309428")
2025/03/20 05:12:44 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932310424")
2025/03/20 05:12:45 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932311430")
2025/03/20 05:12:46 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932312425")
2025/03/20 05:12:47 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932313433")
2025/03/20 05:12:47 DEBUG : box root 'rclone-test-ranasuq6xofe': ["dir"(0)|folder|ITEM_CREATE|312611370100|ec6385def830b3680ce8a70a15e6c3e68b2ea236] added new path ("dir") for notify
2025/03/20 05:12:47 DEBUG : box root 'rclone-test-ranasuq6xofe': ["subdir3"(0)|folder|ITEM_CREATE|312611634410|54c59f52232b7046615345d6763ae50f988d5a0c] added new path ("dir/subdir3") for notify
2025/03/20 05:12:47 DEBUG : box root 'rclone-test-ranasuq6xofe': ["subdir1"(0)|folder|ITEM_CREATE|312609402595|806e9ad34111afe190f45575e90b66312b15e9e2] added new path ("dir/subdir1") for notify
2025/03/20 05:12:47 DEBUG : box root 'rclone-test-ranasuq6xofe': ["subdir2"(0)|folder|ITEM_CREATE|312612167037|c6c1184da5fde71e30cb9f12581f260adca6f7b1] added new path ("dir/subdir2") for notify
2025/03/20 05:12:47 DEBUG : doChangeNotify("dir", 0)
2025/03/20 05:12:47 DEBUG : doChangeNotify("dir/subdir3", 0)
2025/03/20 05:12:47 DEBUG : doChangeNotify("dir/subdir1", 0)
2025/03/20 05:12:47 DEBUG : doChangeNotify("dir/subdir2", 0)
2025/03/20 05:12:47 DEBUG : box root 'rclone-test-ranasuq6xofe': Received 5 events, resulting in 4 paths and 4 notifications
2025/03/20 05:12:47 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932314425")
2025/03/20 05:12:47 DEBUG : box root 'rclone-test-ranasuq6xofe': ["subdir3"(0)|folder|ITEM_CREATE|312611634410|54c59f52232b7046615345d6763ae50f988d5a0c] ignored due to duplicate EventID
2025/03/20 05:12:47 DEBUG : box root 'rclone-test-ranasuq6xofe': ["subdir1"(0)|folder|ITEM_CREATE|312609402595|806e9ad34111afe190f45575e90b66312b15e9e2] ignored due to duplicate EventID
2025/03/20 05:12:47 DEBUG : box root 'rclone-test-ranasuq6xofe': ["subdir2"(0)|folder|ITEM_CREATE|312612167037|c6c1184da5fde71e30cb9f12581f260adca6f7b1] ignored due to duplicate EventID
2025/03/20 05:12:48 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932314678")
2025/03/20 05:12:48 INFO  : dir/file2.rclone_chunk.001_euqv0e: Moved (server-side) to: dir/file2.rclone_chunk.001
2025/03/20 05:12:49 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932315426")
2025/03/20 05:12:49 INFO  : dir/file2.rclone_chunk.002_euqv0e: Moved (server-side) to: dir/file2.rclone_chunk.002
2025/03/20 05:12:49 DEBUG : box root 'rclone-test-ranasuq6xofe': ["subdir3"(0)|folder|ITEM_CREATE|312611634410|54c59f52232b7046615345d6763ae50f988d5a0c] ignored due to duplicate EventID
2025/03/20 05:12:49 DEBUG : box root 'rclone-test-ranasuq6xofe': ["subdir1"(0)|folder|ITEM_CREATE|312609402595|806e9ad34111afe190f45575e90b66312b15e9e2] ignored due to duplicate EventID
2025/03/20 05:12:50 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932316433")
2025/03/20 05:12:51 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932317426")
2025/03/20 05:12:51 DEBUG : box root 'rclone-test-ranasuq6xofe': ["subdir2"(0)|folder|ITEM_CREATE|312612167037|c6c1184da5fde71e30cb9f12581f260adca6f7b1] ignored due to duplicate EventID
2025/03/20 05:12:52 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932318425")
2025/03/20 05:12:53 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932319432")
2025/03/20 05:12:53 DEBUG : box root 'rclone-test-ranasuq6xofe': ["file2.rclone_chunk.002_euqv0e"(0)|file|ITEM_UPLOAD|1808580309167|4505476d4da084fc047ff27bacfe09b042aa21d8] ignored due to old SequenceID ('\x01')
2025/03/20 05:12:53 DEBUG : box root 'rclone-test-ranasuq6xofe': Received 1 events, resulting in 0 paths and 0 notifications
2025/03/20 05:12:53 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932320434")
2025/03/20 05:12:53 DEBUG : box root 'rclone-test-ranasuq6xofe': ["rclone-test-ranasuq6xofe"(0)|folder|ITEM_CREATE|312611697285|7eee7ff4f2523b7ae35cf417c5372f7853aaadd4] new parent not found
2025/03/20 05:12:53 DEBUG : box root 'rclone-test-ranasuq6xofe': Received 1 events, resulting in 0 paths and 0 notifications
2025/03/20 05:12:53 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932320664")
2025/03/20 05:12:54 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932320898")
2025/03/20 05:12:54 DEBUG : box root 'rclone-test-ranasuq6xofe': ["file2.rclone_chunk.001"(1)|file|ITEM_RENAME|1808580775154|7afb07f9a082852329b565514bac73e34d10addc] ignored due to old SequenceID ('\x01')
2025/03/20 05:12:54 DEBUG : box root 'rclone-test-ranasuq6xofe': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1808580309167|9531b05a0b4754c32639461de06afd88bf838474] ignored due to old SequenceID ('\x01')
2025/03/20 05:12:54 DEBUG : box root 'rclone-test-ranasuq6xofe': ["file2"(0)|file|ITEM_UPLOAD|1808582271736|0ef6149b275100749516cfb87eb3897c77ca3e3e] ignored due to old SequenceID ('\x00')
2025/03/20 05:12:54 DEBUG : box root 'rclone-test-ranasuq6xofe': Received 3 events, resulting in 0 paths and 0 notifications
2025/03/20 05:12:54 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932321425")
2025/03/20 05:12:54 DEBUG : box root 'rclone-test-ranasuq6xofe': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1808580309167|9531b05a0b4754c32639461de06afd88bf838474] ignored due to duplicate EventID
2025/03/20 05:12:54 DEBUG : box root 'rclone-test-ranasuq6xofe': ["file2"(0)|file|ITEM_UPLOAD|1808582271736|0ef6149b275100749516cfb87eb3897c77ca3e3e] ignored due to duplicate EventID
2025/03/20 05:12:54 DEBUG : box root 'rclone-test-ranasuq6xofe': ["file2.rclone_chunk.001_euqv0e"(0)|file|ITEM_UPLOAD|1808580775154|cdccd293901dcb8c7aa300522bff09b0a9228ef6] ignored due to old SequenceID ('\x01')
2025/03/20 05:12:54 DEBUG : box root 'rclone-test-ranasuq6xofe': Received 3 events, resulting in 0 paths and 0 notifications
2025/03/20 05:12:54 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932321663")
2025/03/20 05:12:55 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932321901")
2025/03/20 05:12:55 DEBUG : box root 'rclone-test-ranasuq6xofe': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1808580309167|9531b05a0b4754c32639461de06afd88bf838474] ignored due to duplicate EventID
2025/03/20 05:12:56 INFO  : dir/file4.rclone_chunk.001_eur38l: Moved (server-side) to: dir/file4.rclone_chunk.001
2025/03/20 05:12:56 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932322427")
2025/03/20 05:12:56 INFO  : dir/file4.rclone_chunk.002_eur38l: Moved (server-side) to: dir/file4.rclone_chunk.002
2025/03/20 05:12:56 DEBUG : box root 'rclone-test-ranasuq6xofe': ["file2"(0)|file|ITEM_UPLOAD|1808582271736|0ef6149b275100749516cfb87eb3897c77ca3e3e] ignored due to duplicate EventID
2025/03/20 05:12:57 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932323433")
2025/03/20 05:12:58 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932324435")
2025/03/20 05:12:58 DEBUG : box root 'rclone-test-ranasuq6xofe': ["file2.rclone_chunk.001_euqv0e"(0)|file|ITEM_UPLOAD|1808580775154|cdccd293901dcb8c7aa300522bff09b0a9228ef6] ignored due to duplicate EventID
2025/03/20 05:12:58 DEBUG : box root 'rclone-test-ranasuq6xofe': ["file4.rclone_chunk.001_eur38l"(0)|file|ITEM_UPLOAD|1808588107165|d9b358c7712d9a485e48f010752025c8a223aef3] added new path ("dir/file4.rclone_chunk.001_eur38l") for notify
2025/03/20 05:12:58 DEBUG : box root 'rclone-test-ranasuq6xofe': ["file4.rclone_chunk.002_eur38l"(0)|file|ITEM_UPLOAD|1808580790957|06b70694381e61370bbd4816730ad6ef4a6f5164] added new path ("dir/file4.rclone_chunk.002_eur38l") for notify
2025/03/20 05:12:58 DEBUG : box root 'rclone-test-ranasuq6xofe': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1808588107165|89789667bb2e287de82192a54ffe3586d50f2588] added new path ("dir/file4.rclone_chunk.001") for notify
2025/03/20 05:12:58 DEBUG : doChangeNotify("dir/file4.rclone_chunk.001_eur38l", 1)
2025/03/20 05:12:58 DEBUG : doChangeNotify("dir/file4.rclone_chunk.002_eur38l", 1)
2025/03/20 05:12:58 DEBUG : doChangeNotify("dir/file4", 1)
2025/03/20 05:12:58 DEBUG : box root 'rclone-test-ranasuq6xofe': Received 4 events, resulting in 3 paths and 3 notifications
2025/03/20 05:12:58 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932325433")
2025/03/20 05:12:58 DEBUG : box root 'rclone-test-ranasuq6xofe': ["file2.rclone_chunk.001_euqv0e"(0)|file|ITEM_UPLOAD|1808580775154|cdccd293901dcb8c7aa300522bff09b0a9228ef6] ignored due to duplicate EventID
2025/03/20 05:12:59 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932325680")
2025/03/20 05:12:59 DEBUG : box root 'rclone-test-ranasuq6xofe': ["file4.rclone_chunk.001_eur38l"(0)|file|ITEM_UPLOAD|1808588107165|d9b358c7712d9a485e48f010752025c8a223aef3] ignored due to duplicate EventID
2025/03/20 05:12:59 DEBUG : box root 'rclone-test-ranasuq6xofe': ["file4.rclone_chunk.002_eur38l"(0)|file|ITEM_UPLOAD|1808580790957|06b70694381e61370bbd4816730ad6ef4a6f5164] ignored due to duplicate EventID
2025/03/20 05:12:59 DEBUG : box root 'rclone-test-ranasuq6xofe': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1808588107165|89789667bb2e287de82192a54ffe3586d50f2588] ignored due to duplicate EventID
2025/03/20 05:13:00 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932326430")
2025/03/20 05:13:00 DEBUG : box root 'rclone-test-ranasuq6xofe': ["file4.rclone_chunk.002_eur38l"(0)|file|ITEM_UPLOAD|1808580790957|06b70694381e61370bbd4816730ad6ef4a6f5164] ignored due to duplicate EventID
2025/03/20 05:13:00 DEBUG : box root 'rclone-test-ranasuq6xofe': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1808588107165|89789667bb2e287de82192a54ffe3586d50f2588] ignored due to duplicate EventID
2025/03/20 05:13:01 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932327430")
2025/03/20 05:13:01 DEBUG : box root 'rclone-test-ranasuq6xofe': ["file4.rclone_chunk.002_eur38l"(0)|file|ITEM_UPLOAD|1808580790957|06b70694381e61370bbd4816730ad6ef4a6f5164] ignored due to duplicate EventID
2025/03/20 05:13:02 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932328429")
2025/03/20 05:13:02 DEBUG : box root 'rclone-test-ranasuq6xofe': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1808588107165|89789667bb2e287de82192a54ffe3586d50f2588] ignored due to duplicate EventID
2025/03/20 05:13:02 DEBUG : box root 'rclone-test-ranasuq6xofe': ["file4.rclone_chunk.002"(1)|file|ITEM_RENAME|1808580790957|ceb7bc3f6938a4af1603ebbcc4b39fc2ccf3f6d1] ignored due to old SequenceID ('\x01')
2025/03/20 05:13:02 DEBUG : box root 'rclone-test-ranasuq6xofe': Received 2 events, resulting in 0 paths and 0 notifications
2025/03/20 05:13:02 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932329431")
2025/03/20 05:13:03 INFO  : dir/file3.rclone_chunk.001_eura95: Moved (server-side) to: dir/file3.rclone_chunk.001
2025/03/20 05:13:03 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932329679")
2025/03/20 05:13:03 INFO  : dir/file3.rclone_chunk.002_eura95: Moved (server-side) to: dir/file3.rclone_chunk.002
2025/03/20 05:13:04 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932330426")
2025/03/20 05:13:04 DEBUG : box root 'rclone-test-ranasuq6xofe': ["file4.rclone_chunk.002"(1)|file|ITEM_RENAME|1808580790957|ceb7bc3f6938a4af1603ebbcc4b39fc2ccf3f6d1] ignored due to duplicate EventID
2025/03/20 05:13:04 DEBUG : box root 'rclone-test-ranasuq6xofe': ["file3.rclone_chunk.001_eura95"(0)|file|ITEM_UPLOAD|1808582555668|038a2480cb5e7f97b5d5a05f649fc8988dd664a1] added new path ("dir/file3.rclone_chunk.001_eura95") for notify
2025/03/20 05:13:04 DEBUG : box root 'rclone-test-ranasuq6xofe': ["file3.rclone_chunk.002_eura95"(0)|file|ITEM_UPLOAD|1808580475144|560c74a32bf33faebc622b7dd4fd6b09ba5c73aa] added new path ("dir/file3.rclone_chunk.002_eura95") for notify
2025/03/20 05:13:04 DEBUG : box root 'rclone-test-ranasuq6xofe': ["file3.rclone_chunk.002"(1)|file|ITEM_RENAME|1808580475144|bfbac3c3a4ffd4d5cb09d12d42675743c9006db0] added new path ("dir/file3.rclone_chunk.002") for notify
2025/03/20 05:13:04 DEBUG : doChangeNotify("dir/file3.rclone_chunk.001_eura95", 1)
2025/03/20 05:13:04 DEBUG : doChangeNotify("dir/file3.rclone_chunk.002_eura95", 1)
2025/03/20 05:13:04 DEBUG : doChangeNotify("dir/file3", 1)
2025/03/20 05:13:04 DEBUG : box root 'rclone-test-ranasuq6xofe': Received 4 events, resulting in 3 paths and 3 notifications
2025/03/20 05:13:04 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932331424")
2025/03/20 05:13:04 DEBUG : box root 'rclone-test-ranasuq6xofe': ["file4.rclone_chunk.002"(1)|file|ITEM_RENAME|1808580790957|ceb7bc3f6938a4af1603ebbcc4b39fc2ccf3f6d1] ignored due to duplicate EventID
2025/03/20 05:13:05 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932331679")
    fstests.go:931: Try 1/10 waiting for dirChanges and objChanges
2025/03/20 05:13:06 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932332429")
2025/03/20 05:13:07 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932333433")
2025/03/20 05:13:07 DEBUG : box root 'rclone-test-ranasuq6xofe': ["file3.rclone_chunk.001_eura95"(0)|file|ITEM_UPLOAD|1808582555668|038a2480cb5e7f97b5d5a05f649fc8988dd664a1] ignored due to duplicate EventID
2025/03/20 05:13:08 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932334426")
2025/03/20 05:13:08 DEBUG : box root 'rclone-test-ranasuq6xofe': ["file3.rclone_chunk.002_eura95"(0)|file|ITEM_UPLOAD|1808580475144|560c74a32bf33faebc622b7dd4fd6b09ba5c73aa] ignored due to duplicate EventID
2025/03/20 05:13:08 DEBUG : box root 'rclone-test-ranasuq6xofe': ["file3.rclone_chunk.002"(1)|file|ITEM_RENAME|1808580475144|bfbac3c3a4ffd4d5cb09d12d42675743c9006db0] ignored due to duplicate EventID
    fstests.go:931: Try 2/10 waiting for dirChanges and objChanges
2025/03/20 05:13:09 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932335428")
2025/03/20 05:13:09 DEBUG : box root 'rclone-test-ranasuq6xofe': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1808582555668|fcd4c4e6dde77e03bb278d62125e93e8425f632c] ignored due to old SequenceID ('\x01')
2025/03/20 05:13:09 DEBUG : box root 'rclone-test-ranasuq6xofe': Received 1 events, resulting in 0 paths and 0 notifications
2025/03/20 05:13:09 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932336423")
2025/03/20 05:13:10 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932336651")
2025/03/20 05:13:10 DEBUG : box root 'rclone-test-ranasuq6xofe': ["file3"(0)|file|ITEM_UPLOAD|1808582913334|33488ea69cd3180cc25136ac49126ebb8cb6bf0a] ignored due to old SequenceID ('\x00')
2025/03/20 05:13:10 DEBUG : box root 'rclone-test-ranasuq6xofe': Received 1 events, resulting in 0 paths and 0 notifications
2025/03/20 05:13:10 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932337434")
2025/03/20 05:13:11 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932337664")
2025/03/20 05:13:11 DEBUG : box root 'rclone-test-ranasuq6xofe': ["file3"(0)|file|ITEM_UPLOAD|1808582913334|33488ea69cd3180cc25136ac49126ebb8cb6bf0a] ignored due to duplicate EventID
    fstests.go:931: Try 3/10 waiting for dirChanges and objChanges
2025/03/20 05:13:12 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932338426")
2025/03/20 05:13:13 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932339428")
2025/03/20 05:13:14 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932340427")
    fstests.go:931: Try 4/10 waiting for dirChanges and objChanges
2025/03/20 05:13:15 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932341424")
2025/03/20 05:13:16 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932342427")
2025/03/20 05:13:17 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932343426")
    fstests.go:931: Try 5/10 waiting for dirChanges and objChanges
2025/03/20 05:13:18 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932344433")
2025/03/20 05:13:19 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932345430")
2025/03/20 05:13:19 DEBUG : box root 'rclone-test-ranasuq6xofe': ["file4"(0)|file|ITEM_UPLOAD|1808582151848|f8f4e90721563163eacfe14e9025f792a2ca1329] ignored due to old SequenceID ('\x00')
2025/03/20 05:13:19 DEBUG : box root 'rclone-test-ranasuq6xofe': Received 1 events, resulting in 0 paths and 0 notifications
2025/03/20 05:13:19 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932346423")
2025/03/20 05:13:19 DEBUG : box root 'rclone-test-ranasuq6xofe': ["file4"(0)|file|ITEM_UPLOAD|1808582151848|f8f4e90721563163eacfe14e9025f792a2ca1329] ignored due to duplicate EventID
2025/03/20 05:13:20 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932346653")
    fstests.go:931: Try 6/10 waiting for dirChanges and objChanges
2025/03/20 05:13:21 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932347426")
2025/03/20 05:13:21 DEBUG : box root 'rclone-test-ranasuq6xofe': ["file4"(0)|file|ITEM_UPLOAD|1808582151848|f8f4e90721563163eacfe14e9025f792a2ca1329] ignored due to duplicate EventID
2025/03/20 05:13:22 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932348431")
2025/03/20 05:13:23 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932349432")
    fstests.go:931: Try 7/10 waiting for dirChanges and objChanges
2025/03/20 05:13:24 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932350429")
2025/03/20 05:13:25 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932351422")
2025/03/20 05:13:26 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932352427")
    fstests.go:931: Try 8/10 waiting for dirChanges and objChanges
2025/03/20 05:13:27 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932353426")
2025/03/20 05:13:28 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932354424")
2025/03/20 05:13:29 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932355426")
    fstests.go:931: Try 9/10 waiting for dirChanges and objChanges
2025/03/20 05:13:30 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932356435")
2025/03/20 05:13:31 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932357434")
2025/03/20 05:13:32 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932358427")
    fstests.go:935: map[dir:{} dir/subdir1:{} dir/subdir2:{} dir/subdir3:{}] does not contain [dir/subdir1 dir/subdir3 dir/subdir2] or 
        map[dir/file3:{} dir/file3.rclone_chunk.001_eura95:{} dir/file3.rclone_chunk.002_eura95:{} dir/file4:{} dir/file4.rclone_chunk.001_eur38l:{} dir/file4.rclone_chunk.002_eur38l:{}] does not contain [dir/file2 dir/file4 dir/file3]
2025/03/20 05:13:33 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932359426")
2025/03/20 05:13:34 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932360432")
2025/03/20 05:13:35 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932361426")
2025/03/20 05:13:36 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932362430")
2025/03/20 05:13:37 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932363428")
2025/03/20 05:13:38 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932364434")
2025/03/20 05:13:39 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932365426")
2025/03/20 05:13:40 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932366427")
2025/03/20 05:13:41 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932367426")
2025/03/20 05:13:41 DEBUG : box root 'rclone-test-ranasuq6xofe': ["file2"(1)|file|ITEM_TRASH|1808582271736|554ed34207988d95d172a1b95eaf74720edb497e] added old path ("dir/file2") for notify
2025/03/20 05:13:41 DEBUG : box root 'rclone-test-ranasuq6xofe': ["file2.rclone_chunk.001"(2)|file|ITEM_TRASH|1808580775154|48357f8408f5349b8cb18fbb5e6cc664d0333baa] added old path ("dir/file2.rclone_chunk.001") for notify
2025/03/20 05:13:41 DEBUG : box root 'rclone-test-ranasuq6xofe': ["file4"(1)|file|ITEM_TRASH|1808582151848|822e22cf3c30ec3f4fdba6d253080854b66b003f] added old path ("dir/file4") for notify
2025/03/20 05:13:41 DEBUG : doChangeNotify("dir/file2", 1)
2025/03/20 05:13:41 DEBUG : doChangeNotify("dir/file2", 1)
2025/03/20 05:13:41 DEBUG : doChangeNotify("dir/file4", 1)
2025/03/20 05:13:41 DEBUG : box root 'rclone-test-ranasuq6xofe': Received 3 events, resulting in 3 paths and 3 notifications
2025/03/20 05:13:41 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932368439")
2025/03/20 05:13:42 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932368672")
2025/03/20 05:13:43 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932369431")
2025/03/20 05:13:43 DEBUG : box root 'rclone-test-ranasuq6xofe': ["file4"(1)|file|ITEM_TRASH|1808582151848|822e22cf3c30ec3f4fdba6d253080854b66b003f] ignored due to duplicate EventID
2025/03/20 05:13:43 DEBUG : box root 'rclone-test-ranasuq6xofe': ["file4.rclone_chunk.001"(2)|file|ITEM_TRASH|1808588107165|d9c6a1faf2fc5835a2184a5078ccfff8a9f7eb76] added old path ("dir/file4.rclone_chunk.001") for notify
2025/03/20 05:13:43 DEBUG : box root 'rclone-test-ranasuq6xofe': ["file4.rclone_chunk.002"(2)|file|ITEM_TRASH|1808580790957|9fcc1d45e1ff99cedd4babfc16703eaab4edd598] added old path ("dir/file4.rclone_chunk.002") for notify
2025/03/20 05:13:43 DEBUG : doChangeNotify("dir/file4", 1)
2025/03/20 05:13:43 DEBUG : doChangeNotify("dir/file4", 1)
2025/03/20 05:13:43 DEBUG : box root 'rclone-test-ranasuq6xofe': Received 3 events, resulting in 2 paths and 2 notifications
2025/03/20 05:13:43 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932370427")
2025/03/20 05:13:44 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932370675")
2025/03/20 05:13:45 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932371433")
2025/03/20 05:13:45 DEBUG : box root 'rclone-test-ranasuq6xofe': ["file4.rclone_chunk.001"(2)|file|ITEM_TRASH|1808588107165|d9c6a1faf2fc5835a2184a5078ccfff8a9f7eb76] ignored due to duplicate EventID
2025/03/20 05:13:45 DEBUG : box root 'rclone-test-ranasuq6xofe': ["file4.rclone_chunk.002"(2)|file|ITEM_TRASH|1808580790957|9fcc1d45e1ff99cedd4babfc16703eaab4edd598] ignored due to duplicate EventID
2025/03/20 05:13:45 DEBUG : box root 'rclone-test-ranasuq6xofe': ["file3"(1)|file|ITEM_TRASH|1808582913334|307f9f77d69bbabdaa50444e55882d55adadc633] added old path ("dir/file3") for notify
2025/03/20 05:13:45 DEBUG : box root 'rclone-test-ranasuq6xofe': ["file3.rclone_chunk.001"(2)|file|ITEM_TRASH|1808582555668|efd5fe91fe00117d89879a848a4308fc4c681eca] added old path ("dir/file3.rclone_chunk.001") for notify
2025/03/20 05:13:45 DEBUG : doChangeNotify("dir/file3", 1)
2025/03/20 05:13:45 DEBUG : doChangeNotify("dir/file3", 1)
2025/03/20 05:13:45 DEBUG : box root 'rclone-test-ranasuq6xofe': Received 4 events, resulting in 2 paths and 2 notifications
2025/03/20 05:13:45 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932372426")
2025/03/20 05:13:46 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932372667")
2025/03/20 05:13:46 DEBUG : box root 'rclone-test-ranasuq6xofe': ["file4.rclone_chunk.001"(2)|file|ITEM_TRASH|1808588107165|d9c6a1faf2fc5835a2184a5078ccfff8a9f7eb76] ignored due to duplicate EventID
2025/03/20 05:13:47 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932373430")
2025/03/20 05:13:47 DEBUG : box root 'rclone-test-ranasuq6xofe': ["file4.rclone_chunk.002"(2)|file|ITEM_TRASH|1808580790957|9fcc1d45e1ff99cedd4babfc16703eaab4edd598] ignored due to duplicate EventID
2025/03/20 05:13:47 DEBUG : box root 'rclone-test-ranasuq6xofe': ["file3"(1)|file|ITEM_TRASH|1808582913334|307f9f77d69bbabdaa50444e55882d55adadc633] ignored due to duplicate EventID
2025/03/20 05:13:47 DEBUG : box root 'rclone-test-ranasuq6xofe': ["file3.rclone_chunk.001"(2)|file|ITEM_TRASH|1808582555668|efd5fe91fe00117d89879a848a4308fc4c681eca] ignored due to duplicate EventID
2025/03/20 05:13:47 DEBUG : box root 'rclone-test-ranasuq6xofe': ["file2.rclone_chunk.002"(2)|file|ITEM_TRASH|1808580309167|61a598e77b3aa094a80ac5c70204a8d0601e5a11] added old path ("dir/file2.rclone_chunk.002") for notify
2025/03/20 05:13:47 DEBUG : doChangeNotify("dir/file2", 1)
2025/03/20 05:13:47 DEBUG : box root 'rclone-test-ranasuq6xofe': Received 4 events, resulting in 1 paths and 1 notifications
2025/03/20 05:13:47 DEBUG : box root 'rclone-test-ranasuq6xofe': Checking for changes on remote (next_stream_position: "30401039932374425")
2025/03/20 05:13:49 DEBUG : box root 'rclone-test-ranasuq6xofe': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/03/20 05:13:49 ERROR : : error listing: directory not found
2025/03/20 05:13:49 DEBUG : box root 'rclone-test-ranasuq6xofe': Ignoring "Shared folder — ForNick" - unknown type "web_link"
--- FAIL: TestIntegration (72.82s)
    --- FAIL: TestIntegration/FsMkdir (69.61s)
        --- FAIL: TestIntegration/FsMkdir/FsChangeNotify (67.50s)
FAIL
exit status 1
FAIL	github.com/rclone/rclone/backend/chunker	72.862s
"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024 -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Finished ERROR in 1m15.528445884s (try 2/5): exit status 1: Failed [TestIntegration/FsMkdir/FsChangeNotify]