"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/04/24 05:01:26 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-nexehoj4xowu"
2025/04/24 05:01:26 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/04/24 05:01:26 DEBUG : Creating backend with remote "TestBox:rclone-test-nexehoj4xowu"
2025/04/24 05:01:26 DEBUG : box root 'rclone-test-nexehoj4xowu': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/04/24 05:01:27 DEBUG : box root 'rclone-test-nexehoj4xowu': Ignoring "Shared folder — ForNick" - unknown type "web_link"
=== RUN   TestIntegration/FsMkdir
=== RUN   TestIntegration/FsMkdir/FsChangeNotify
2025/04/24 05:01:29 INFO  : dir: Making directory
2025/04/24 05:01:30 INFO  : dir/subdir1: Making directory
2025/04/24 05:01:31 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955637755")
2025/04/24 05:01:32 INFO  : dir/subdir3: Making directory
2025/04/24 05:01:32 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955638991")
2025/04/24 05:01:33 INFO  : dir/subdir2: Making directory
2025/04/24 05:01:33 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955639989")
2025/04/24 05:01:34 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955641005")
2025/04/24 05:01:35 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955641990")
2025/04/24 05:01:36 DEBUG : box root 'rclone-test-nexehoj4xowu': ["rclone-test-nexehoj4xowu"(0)|folder|ITEM_CREATE|318233961193|f3904ff14a58610796241b3262bbf96ad3275e6a] new parent not found
2025/04/24 05:01:36 DEBUG : box root 'rclone-test-nexehoj4xowu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/24 05:01:36 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955643002")
2025/04/24 05:01:36 DEBUG : box root 'rclone-test-nexehoj4xowu': ["subdir"(0)|folder|ITEM_CREATE|318235856741|cd6c38d93cd1e2f3874aa8298a731dcdc96b9cb4] new parent not found
2025/04/24 05:01:36 DEBUG : box root 'rclone-test-nexehoj4xowu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/24 05:01:36 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955643241")
2025/04/24 05:01:36 DEBUG : box root 'rclone-test-nexehoj4xowu': ["dir"(0)|folder|ITEM_CREATE|318237016588|ccd3fffa587f1bd1692844e13205923ffd2aac5f] added new path ("dir") for notify
2025/04/24 05:01:36 DEBUG : doChangeNotify("dir", 0)
2025/04/24 05:01:36 DEBUG : box root 'rclone-test-nexehoj4xowu': Received 1 events, resulting in 1 paths and 1 notifications
2025/04/24 05:01:36 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955643471")
2025/04/24 05:01:36 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955643704")
2025/04/24 05:01:37 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955643991")
2025/04/24 05:01:38 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955644995")
2025/04/24 05:01:39 DEBUG : box root 'rclone-test-nexehoj4xowu': ["placeholder.txt"(0)|file|ITEM_UPLOAD|1843732972368|207ff544ecb2ee2d0ebe2729ec44069eac722a9f] new parent not found
2025/04/24 05:01:39 DEBUG : box root 'rclone-test-nexehoj4xowu': ["subdir1"(0)|folder|ITEM_CREATE|318236744437|ead6510bf932e6c5c4a383f31f663531870b1407] added new path ("dir/subdir1") for notify
2025/04/24 05:01:39 DEBUG : doChangeNotify("dir/subdir1", 0)
2025/04/24 05:01:39 DEBUG : box root 'rclone-test-nexehoj4xowu': Received 2 events, resulting in 1 paths and 1 notifications
2025/04/24 05:01:39 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955645982")
2025/04/24 05:01:39 INFO  : dir/file2.rclone_chunk.001_7nkngf: Moved (server-side) to: dir/file2.rclone_chunk.001
2025/04/24 05:01:39 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955646229")
2025/04/24 05:01:40 DEBUG : box root 'rclone-test-nexehoj4xowu': ["subdir3"(0)|folder|ITEM_CREATE|318235091301|880fc9d4ad2e4175cebd55515362f550c1588747] added new path ("dir/subdir3") for notify
2025/04/24 05:01:40 DEBUG : doChangeNotify("dir/subdir3", 0)
2025/04/24 05:01:40 DEBUG : box root 'rclone-test-nexehoj4xowu': Received 1 events, resulting in 1 paths and 1 notifications
2025/04/24 05:01:40 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955647005")
2025/04/24 05:01:40 INFO  : dir/file2.rclone_chunk.002_7nkngf: Moved (server-side) to: dir/file2.rclone_chunk.002
2025/04/24 05:01:40 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955647241")
2025/04/24 05:01:41 DEBUG : box root 'rclone-test-nexehoj4xowu': ["subdir2"(0)|folder|ITEM_CREATE|318235110247|c1a9c2b30ef76640705a2eb104f2c2cb76532bed] added new path ("dir/subdir2") for notify
2025/04/24 05:01:41 DEBUG : doChangeNotify("dir/subdir2", 0)
2025/04/24 05:01:41 DEBUG : box root 'rclone-test-nexehoj4xowu': Received 1 events, resulting in 1 paths and 1 notifications
2025/04/24 05:01:41 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955647988")
2025/04/24 05:01:41 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955648228")
2025/04/24 05:01:42 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955648983")
2025/04/24 05:01:43 DEBUG : box root 'rclone-test-nexehoj4xowu': ["file2.rclone_chunk.001_7nkngf"(0)|file|ITEM_UPLOAD|1843738420209|6d09328a1f534fa3440e0ba201dd42a224b4a1cd] added new path ("dir/file2.rclone_chunk.001_7nkngf") for notify
2025/04/24 05:01:43 DEBUG : doChangeNotify("dir/file2.rclone_chunk.001_7nkngf", 1)
2025/04/24 05:01:43 DEBUG : box root 'rclone-test-nexehoj4xowu': Received 1 events, resulting in 1 paths and 1 notifications
2025/04/24 05:01:43 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955649998")
2025/04/24 05:01:43 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955650247")
2025/04/24 05:01:44 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955650981")
2025/04/24 05:01:45 DEBUG : box root 'rclone-test-nexehoj4xowu': ["file2.rclone_chunk.002_7nkngf"(0)|file|ITEM_UPLOAD|1843734267660|b191567bd756356cacf2fa8fda0ae9fab28da293] ignored due to old SequenceID ('\x01')
2025/04/24 05:01:45 DEBUG : box root 'rclone-test-nexehoj4xowu': Received 2 events, resulting in 0 paths and 0 notifications
2025/04/24 05:01:45 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955651990")
2025/04/24 05:01:45 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955652234")
2025/04/24 05:01:46 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955652988")
2025/04/24 05:01:47 DEBUG : box root 'rclone-test-nexehoj4xowu': ["file2.rclone_chunk.001"(1)|file|ITEM_RENAME|1843738420209|088ca3e3c20c2be54abb024fcdbb203458a3a424] ignored due to old SequenceID ('\x01')
2025/04/24 05:01:47 DEBUG : box root 'rclone-test-nexehoj4xowu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/24 05:01:47 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955654007")
2025/04/24 05:01:47 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955654242")
2025/04/24 05:01:48 DEBUG : box root 'rclone-test-nexehoj4xowu': ["file2"(0)|file|ITEM_UPLOAD|1843732033892|4119e21fab8eda4f5852de99a4c968570fae2cb1] ignored due to old SequenceID ('\x00')
2025/04/24 05:01:48 DEBUG : box root 'rclone-test-nexehoj4xowu': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1843736272105|4e7735c4580806ed6dd085337a6ccd8ba7a845bf] new parent not found
2025/04/24 05:01:48 DEBUG : box root 'rclone-test-nexehoj4xowu': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1843734267660|834f9dedf6b1a4937b875abf3882496abf3cba8d] ignored due to old SequenceID ('\x01')
2025/04/24 05:01:48 DEBUG : box root 'rclone-test-nexehoj4xowu': Received 3 events, resulting in 0 paths and 0 notifications
2025/04/24 05:01:48 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955654984")
2025/04/24 05:01:48 INFO  : dir/file4.rclone_chunk.001_7nkw43: Moved (server-side) to: dir/file4.rclone_chunk.001
2025/04/24 05:01:48 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955655242")
2025/04/24 05:01:49 INFO  : dir/file4.rclone_chunk.002_7nkw43: Moved (server-side) to: dir/file4.rclone_chunk.002
2025/04/24 05:01:49 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955655982")
2025/04/24 05:01:50 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955656986")
2025/04/24 05:01:51 DEBUG : box root 'rclone-test-nexehoj4xowu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/24 05:01:51 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955657991")
2025/04/24 05:01:51 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955658234")
2025/04/24 05:01:52 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955658987")
2025/04/24 05:01:53 DEBUG : box root 'rclone-test-nexehoj4xowu': ["file4.rclone_chunk.001_7nkw43"(0)|file|ITEM_UPLOAD|1843730762397|e4b0908e009917988d992f22075dbe9ce2fb9a2d] ignored due to old SequenceID ('\x01')
2025/04/24 05:01:53 DEBUG : box root 'rclone-test-nexehoj4xowu': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1843731971022|c3fc37ba49d9672c3bfa3ad5e830c08f936a24e3] new parent not found
2025/04/24 05:01:53 DEBUG : box root 'rclone-test-nexehoj4xowu': Received 3 events, resulting in 0 paths and 0 notifications
2025/04/24 05:01:53 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955659993")
2025/04/24 05:01:53 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955660248")
2025/04/24 05:01:54 DEBUG : box root 'rclone-test-nexehoj4xowu': ["file4.rclone_chunk.002_7nkw43"(0)|file|ITEM_UPLOAD|1843728766930|496ff5963db1a5fd1c92edea852faf332f2a6543] ignored due to old SequenceID ('\x01')
2025/04/24 05:01:54 DEBUG : box root 'rclone-test-nexehoj4xowu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/24 05:01:54 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955660992")
2025/04/24 05:01:54 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955661229")
2025/04/24 05:01:55 DEBUG : box root 'rclone-test-nexehoj4xowu': ["file4.rclone_chunk.002"(1)|file|ITEM_RENAME|1843728766930|8c14d073ee7f5d617688949e42965602e9d603ba] ignored due to old SequenceID ('\x01')
2025/04/24 05:01:55 DEBUG : box root 'rclone-test-nexehoj4xowu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/24 05:01:55 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955661982")
2025/04/24 05:01:55 DEBUG : box root 'rclone-test-nexehoj4xowu': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1843730762397|075c11989770106bd89dd923ddf552453e181e80] ignored due to old SequenceID ('\x01')
2025/04/24 05:01:55 DEBUG : box root 'rclone-test-nexehoj4xowu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/24 05:01:55 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955662221")
2025/04/24 05:01:55 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955662464")
2025/04/24 05:01:56 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955662984")
2025/04/24 05:01:57 INFO  : dir/file3.rclone_chunk.001_7nl5x2: Moved (server-side) to: dir/file3.rclone_chunk.001
2025/04/24 05:01:57 DEBUG : box root 'rclone-test-nexehoj4xowu': ["file4"(0)|file|ITEM_UPLOAD|1843731844488|7d011b80e264bfecafd63ba87e8d7cb86aa3f7be] ignored due to old SequenceID ('\x00')
2025/04/24 05:01:57 DEBUG : box root 'rclone-test-nexehoj4xowu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/24 05:01:57 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955663992")
2025/04/24 05:01:57 INFO  : dir/file3.rclone_chunk.002_7nl5x2: Moved (server-side) to: dir/file3.rclone_chunk.002
2025/04/24 05:01:57 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955664229")
2025/04/24 05:01:58 DEBUG : box root 'rclone-test-nexehoj4xowu': Received 2 events, resulting in 0 paths and 0 notifications
2025/04/24 05:01:58 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955664988")
2025/04/24 05:01:58 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955665231")
2025/04/24 05:01:59 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955665989")
    fstests.go:931: Try 1/10 waiting for dirChanges and objChanges
2025/04/24 05:02:00 DEBUG : box root 'rclone-test-nexehoj4xowu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/24 05:02:00 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955667044")
2025/04/24 05:02:00 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955667285")
2025/04/24 05:02:01 DEBUG : box root 'rclone-test-nexehoj4xowu': ["file3.rclone_chunk.001_7nl5x2"(0)|file|ITEM_UPLOAD|1843729120275|690eb04f8cfa92a3a3bba927949c5597a9fbe35e] ignored due to old SequenceID ('\x01')
2025/04/24 05:02:01 DEBUG : box root 'rclone-test-nexehoj4xowu': Received 3 events, resulting in 0 paths and 0 notifications
2025/04/24 05:02:01 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955667986")
2025/04/24 05:02:01 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955668223")
2025/04/24 05:02:02 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955669009")
    fstests.go:931: Try 2/10 waiting for dirChanges and objChanges
2025/04/24 05:02:03 DEBUG : box root 'rclone-test-nexehoj4xowu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/24 05:02:03 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955669986")
2025/04/24 05:02:03 DEBUG : box root 'rclone-test-nexehoj4xowu': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1843729120275|f7a2e71dc348fb60542fea0a5940e9e69491ca8c] ignored due to old SequenceID ('\x01')
2025/04/24 05:02:03 DEBUG : box root 'rclone-test-nexehoj4xowu': ["file3.rclone_chunk.002_7nl5x2"(0)|file|ITEM_UPLOAD|1843734870316|462b3da4507bb875ebb5782a55db83be1d42801f] ignored due to old SequenceID ('\x01')
2025/04/24 05:02:03 DEBUG : box root 'rclone-test-nexehoj4xowu': Received 2 events, resulting in 0 paths and 0 notifications
2025/04/24 05:02:03 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955670217")
2025/04/24 05:02:03 DEBUG : box root 'rclone-test-nexehoj4xowu': ["file3.rclone_chunk.002"(1)|file|ITEM_RENAME|1843734870316|749deb734326f6a756a6fca2a82731cd337cd76a] ignored due to old SequenceID ('\x01')
2025/04/24 05:02:03 DEBUG : box root 'rclone-test-nexehoj4xowu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/24 05:02:03 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955670457")
2025/04/24 05:02:03 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955670710")
2025/04/24 05:02:04 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955670989")
2025/04/24 05:02:05 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955671983")
    fstests.go:931: Try 3/10 waiting for dirChanges and objChanges
2025/04/24 05:02:06 DEBUG : box root 'rclone-test-nexehoj4xowu': ["file3"(0)|file|ITEM_UPLOAD|1843733879543|d323304fc5f4ceac163ca935b02de16af749010a] ignored due to old SequenceID ('\x00')
2025/04/24 05:02:06 DEBUG : box root 'rclone-test-nexehoj4xowu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/24 05:02:06 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955672987")
2025/04/24 05:02:06 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955673228")
2025/04/24 05:02:07 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955674006")
2025/04/24 05:02:08 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955674986")
    fstests.go:931: Try 4/10 waiting for dirChanges and objChanges
2025/04/24 05:02:09 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955675998")
2025/04/24 05:02:10 DEBUG : box root 'rclone-test-nexehoj4xowu': ["file1.txt"(0)|file|ITEM_UPLOAD|1843728532561|46ffaeaf8be711df7a16fce1d0c82fde44f9f073] new parent not found
2025/04/24 05:02:10 DEBUG : box root 'rclone-test-nexehoj4xowu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/24 05:02:10 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955676981")
2025/04/24 05:02:10 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955677213")
2025/04/24 05:02:11 DEBUG : box root 'rclone-test-nexehoj4xowu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/24 05:02:11 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955678005")
2025/04/24 05:02:11 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955678254")
    fstests.go:931: Try 5/10 waiting for dirChanges and objChanges
2025/04/24 05:02:12 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955678992")
2025/04/24 05:02:13 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955679991")
2025/04/24 05:02:14 DEBUG : box root 'rclone-test-nexehoj4xowu': ["file1.copy1.txt"(0)|file|ITEM_UPLOAD|1843734923642|2f8ca0c1077eb39b5504bb14efd6ce6da7089e44] new parent not found
2025/04/24 05:02:14 DEBUG : box root 'rclone-test-nexehoj4xowu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/24 05:02:14 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955680983")
2025/04/24 05:02:14 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955681222")
    fstests.go:931: Try 6/10 waiting for dirChanges and objChanges
2025/04/24 05:02:15 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955681986")
2025/04/24 05:02:16 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955682980")
2025/04/24 05:02:17 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955683984")
    fstests.go:931: Try 7/10 waiting for dirChanges and objChanges
2025/04/24 05:02:18 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955684984")
2025/04/24 05:02:19 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955685985")
2025/04/24 05:02:20 DEBUG : box root 'rclone-test-nexehoj4xowu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/24 05:02:20 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955686982")
2025/04/24 05:02:20 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955687220")
    fstests.go:931: Try 8/10 waiting for dirChanges and objChanges
2025/04/24 05:02:21 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955687990")
2025/04/24 05:02:22 DEBUG : box root 'rclone-test-nexehoj4xowu': ["file1.copy2.txt"(0)|file|ITEM_UPLOAD|1843730209906|d07c2abff3719901828a7c4c54928f96c9d9dfcf] new parent not found
2025/04/24 05:02:22 DEBUG : box root 'rclone-test-nexehoj4xowu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/24 05:02:22 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955689042")
2025/04/24 05:02:22 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955689367")
2025/04/24 05:02:23 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955689996")
    fstests.go:931: Try 9/10 waiting for dirChanges and objChanges
2025/04/24 05:02:24 DEBUG : box root 'rclone-test-nexehoj4xowu': ["file1.copy3.txt"(0)|file|ITEM_UPLOAD|1843729592589|8d8cf5787f11a9fe72baa6322c922f5efc9d6338] new parent not found
2025/04/24 05:02:24 DEBUG : box root 'rclone-test-nexehoj4xowu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/24 05:02:24 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955690994")
2025/04/24 05:02:24 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955691233")
2025/04/24 05:02:25 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955691984")
2025/04/24 05:02:26 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955692988")
    fstests.go:935: map[dir:{} dir/subdir1:{} dir/subdir2:{} dir/subdir3:{}] does not contain [dir/subdir1 dir/subdir3 dir/subdir2] or 
        map[dir/file2.rclone_chunk.001_7nkngf:{}] does not contain [dir/file2 dir/file4 dir/file3]
2025/04/24 05:02:27 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955693988")
2025/04/24 05:02:28 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955694997")
2025/04/24 05:02:29 DEBUG : box root 'rclone-test-nexehoj4xowu': ["file1.copy4.txt"(0)|file|ITEM_UPLOAD|1843732343932|c11786097eb96670f743b77d44f3e6647f89565d] new parent not found
2025/04/24 05:02:29 DEBUG : box root 'rclone-test-nexehoj4xowu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/24 05:02:29 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955696018")
2025/04/24 05:02:29 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955696247")
2025/04/24 05:02:30 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955696988")
2025/04/24 05:02:31 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955697985")
2025/04/24 05:02:32 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955698984")
2025/04/24 05:02:33 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955699986")
2025/04/24 05:02:34 DEBUG : box root 'rclone-test-nexehoj4xowu': ["file1.copy5.txt"(0)|file|ITEM_UPLOAD|1843730365958|54a7cfe085f80a85598f2204fd0250b6c3f582c0] new parent not found
2025/04/24 05:02:34 DEBUG : box root 'rclone-test-nexehoj4xowu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/24 05:02:34 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955701025")
2025/04/24 05:02:34 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955701255")
2025/04/24 05:02:35 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955701988")
2025/04/24 05:02:36 DEBUG : box root 'rclone-test-nexehoj4xowu': ["file2"(1)|file|ITEM_TRASH|1843732033892|6a1a2111c3d56d0c5a3065a83fd5ba2909b9b214] added old path ("dir/file2") for notify
2025/04/24 05:02:36 DEBUG : doChangeNotify("dir/file2", 1)
2025/04/24 05:02:36 DEBUG : box root 'rclone-test-nexehoj4xowu': Received 1 events, resulting in 1 paths and 1 notifications
2025/04/24 05:02:36 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955703007")
2025/04/24 05:02:36 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955703243")
2025/04/24 05:02:37 DEBUG : box root 'rclone-test-nexehoj4xowu': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1843727622611|e25dd2481c05ea1fdc40612693f20657ee9f5d3e] new parent not found
2025/04/24 05:02:37 DEBUG : box root 'rclone-test-nexehoj4xowu': ["file2.rclone_chunk.001"(2)|file|ITEM_TRASH|1843738420209|80e7cdb283e9945c5855cad3dda23cad3ff7c3eb] added old path ("dir/file2.rclone_chunk.001") for notify
2025/04/24 05:02:37 DEBUG : doChangeNotify("dir/file2", 1)
2025/04/24 05:02:37 DEBUG : box root 'rclone-test-nexehoj4xowu': Received 2 events, resulting in 1 paths and 1 notifications
2025/04/24 05:02:37 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955703997")
2025/04/24 05:02:37 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955704236")
2025/04/24 05:02:38 DEBUG : box root 'rclone-test-nexehoj4xowu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/24 05:02:38 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955704994")
2025/04/24 05:02:38 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955705226")
2025/04/24 05:02:39 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955705989")
2025/04/24 05:02:40 DEBUG : box root 'rclone-test-nexehoj4xowu': ["file4"(1)|file|ITEM_TRASH|1843731844488|59f2e726b9bbb095dd25e6527db71405ea21e04d] added old path ("dir/file4") for notify
2025/04/24 05:02:40 DEBUG : box root 'rclone-test-nexehoj4xowu': ["file2.rclone_chunk.002"(2)|file|ITEM_TRASH|1843734267660|83fd8bf60df5cc01677f0b67fd56f1e85c64e114] added old path ("dir/file2.rclone_chunk.002") for notify
2025/04/24 05:02:40 DEBUG : box root 'rclone-test-nexehoj4xowu': ["file4.rclone_chunk.001"(2)|file|ITEM_TRASH|1843730762397|85422beb82bd70000cf92e830c60caa598f85a96] added old path ("dir/file4.rclone_chunk.001") for notify
2025/04/24 05:02:40 DEBUG : doChangeNotify("dir/file4", 1)
2025/04/24 05:02:40 DEBUG : doChangeNotify("dir/file2", 1)
2025/04/24 05:02:40 DEBUG : doChangeNotify("dir/file4", 1)
2025/04/24 05:02:40 DEBUG : box root 'rclone-test-nexehoj4xowu': Received 3 events, resulting in 3 paths and 3 notifications
2025/04/24 05:02:40 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955706986")
2025/04/24 05:02:40 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955707233")
2025/04/24 05:02:41 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955707986")
2025/04/24 05:02:42 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955708993")
2025/04/24 05:02:43 DEBUG : box root 'rclone-test-nexehoj4xowu': ["file4.rclone_chunk.002"(2)|file|ITEM_TRASH|1843728766930|ec1ec0e1b430edf379f191dcf89cf7366caebbeb] old parent not cached
2025/04/24 05:02:43 DEBUG : box root 'rclone-test-nexehoj4xowu': Received 2 events, resulting in 0 paths and 0 notifications
2025/04/24 05:02:43 DEBUG : box root 'rclone-test-nexehoj4xowu': Checking for changes on remote (next_stream_position: "30401042955709983")
2025/04/24 05:02:44 DEBUG : box root 'rclone-test-nexehoj4xowu': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/04/24 05:02:44 ERROR : : error listing: directory not found
2025/04/24 05:02:45 DEBUG : box root 'rclone-test-nexehoj4xowu': Ignoring "Shared folder — ForNick" - unknown type "web_link"
--- FAIL: TestIntegration (79.10s)
    --- FAIL: TestIntegration/FsMkdir (75.97s)
        --- FAIL: TestIntegration/FsMkdir/FsChangeNotify (73.59s)
FAIL
exit status 1
FAIL	github.com/rclone/rclone/backend/chunker	79.161s
"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024 -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Finished ERROR in 1m21.92706547s (try 5/5): exit status 1: Failed [TestIntegration/FsMkdir/FsChangeNotify]