"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024 -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Starting (try 4/5)
=== RUN   TestIntegration
    fstests.go:438: Using remote "TestChunkerChunk50bBox:"
2025/05/06 06:19:58 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-voyehub7guju"
2025/05/06 06:19:58 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/05/06 06:19:58 DEBUG : Creating backend with remote "TestBox:rclone-test-voyehub7guju"
2025/05/06 06:19:58 DEBUG : box root 'rclone-test-voyehub7guju': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/05/06 06:19:59 DEBUG : box root 'rclone-test-voyehub7guju': Ignoring "Shared folder — ForNick" - unknown type "web_link"
=== RUN   TestIntegration/FsMkdir
=== RUN   TestIntegration/FsMkdir/FsChangeNotify
2025/05/06 06:20:00 INFO  : dir: Making directory
2025/05/06 06:20:01 INFO  : dir/subdir1: Making directory
2025/05/06 06:20:02 INFO  : dir/subdir3: Making directory
2025/05/06 06:20:02 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997148542")
2025/05/06 06:20:03 DEBUG : box root 'rclone-test-voyehub7guju': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/06 06:20:03 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997149759")
2025/05/06 06:20:03 INFO  : dir/subdir2: Making directory
2025/05/06 06:20:03 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997149983")
2025/05/06 06:20:04 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997150761")
2025/05/06 06:20:05 DEBUG : box root 'rclone-test-voyehub7guju': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1853935269311|2daf1733c203da26fc5aa1b81f57140486eab9b0] new parent not found
2025/05/06 06:20:05 DEBUG : box root 'rclone-test-voyehub7guju': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/06 06:20:05 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997151761")
2025/05/06 06:20:05 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997151980")
2025/05/06 06:20:06 DEBUG : box root 'rclone-test-voyehub7guju': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/06 06:20:06 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997152758")
2025/05/06 06:20:06 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997152984")
2025/05/06 06:20:07 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997153763")
2025/05/06 06:20:08 DEBUG : box root 'rclone-test-voyehub7guju': ["dir"(0)|folder|ITEM_CREATE|319854123780|92c3424c5b575afa5b48c8b5a6c69b1cfbd9505e] added new path ("dir") for notify
2025/05/06 06:20:08 DEBUG : box root 'rclone-test-voyehub7guju': ["rclone-test-voyehub7guju"(0)|folder|ITEM_CREATE|319855288127|397bc682f9475fb6f3e30daa22e5ac74188bba8a] new parent not found
2025/05/06 06:20:08 DEBUG : doChangeNotify("dir", 0)
2025/05/06 06:20:08 DEBUG : box root 'rclone-test-voyehub7guju': Received 2 events, resulting in 1 paths and 1 notifications
2025/05/06 06:20:08 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997154761")
2025/05/06 06:20:08 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997154996")
2025/05/06 06:20:08 INFO  : dir/file2.rclone_chunk.001_tz7hmq: Moved (server-side) to: dir/file2.rclone_chunk.001
2025/05/06 06:20:09 DEBUG : box root 'rclone-test-voyehub7guju': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1853929786984|159fa9c1b4df54084f1fb701cb350dfea48b9e53] new parent not found
2025/05/06 06:20:09 DEBUG : box root 'rclone-test-voyehub7guju': ["subdir1"(0)|folder|ITEM_CREATE|319853173395|efb49359a28fa3358c8db5aaf674d420b20764f5] added new path ("dir/subdir1") for notify
2025/05/06 06:20:09 DEBUG : doChangeNotify("dir/subdir1", 0)
2025/05/06 06:20:09 DEBUG : box root 'rclone-test-voyehub7guju': Received 3 events, resulting in 1 paths and 1 notifications
2025/05/06 06:20:09 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997155764")
2025/05/06 06:20:09 INFO  : dir/file2.rclone_chunk.002_tz7hmq: Moved (server-side) to: dir/file2.rclone_chunk.002
2025/05/06 06:20:09 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997155990")
2025/05/06 06:20:10 DEBUG : box root 'rclone-test-voyehub7guju': ["subdir2"(0)|folder|ITEM_CREATE|319855386659|b8c35b1f9abaa81b262e8fac689988c925b398b0] added new path ("dir/subdir2") for notify
2025/05/06 06:20:10 DEBUG : box root 'rclone-test-voyehub7guju': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1853937635249|2c1a932e8628256bcbb8e5ed015582570a496212] new parent not found
2025/05/06 06:20:10 DEBUG : doChangeNotify("dir/subdir2", 0)
2025/05/06 06:20:10 DEBUG : box root 'rclone-test-voyehub7guju': Received 2 events, resulting in 1 paths and 1 notifications
2025/05/06 06:20:10 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997156759")
2025/05/06 06:20:10 DEBUG : box root 'rclone-test-voyehub7guju': ["subdir3"(0)|folder|ITEM_CREATE|319854476430|f8868b77fa3f2be8342f5b98c2f5c0b47bded7d7] added new path ("dir/subdir3") for notify
2025/05/06 06:20:10 DEBUG : doChangeNotify("dir/subdir3", 0)
2025/05/06 06:20:10 DEBUG : box root 'rclone-test-voyehub7guju': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/06 06:20:10 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997156985")
2025/05/06 06:20:10 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997157207")
2025/05/06 06:20:11 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997157759")
2025/05/06 06:20:12 DEBUG : box root 'rclone-test-voyehub7guju': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/06 06:20:12 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997158762")
2025/05/06 06:20:12 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997158988")
2025/05/06 06:20:13 DEBUG : box root 'rclone-test-voyehub7guju': ["file2.rclone_chunk.001_tz7hmq"(0)|file|ITEM_UPLOAD|1853931438660|867b3e04adfbc311931fec2d0b63678d955a73a9] ignored due to old SequenceID ('\x01')
2025/05/06 06:20:13 DEBUG : box root 'rclone-test-voyehub7guju': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/06 06:20:13 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997159763")
2025/05/06 06:20:13 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997159989")
2025/05/06 06:20:14 DEBUG : box root 'rclone-test-voyehub7guju': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1853937083459|d40d7018c31a71a46ec46f0c0a0552807117371d] new parent not found
2025/05/06 06:20:14 DEBUG : box root 'rclone-test-voyehub7guju': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/06 06:20:14 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997160759")
2025/05/06 06:20:14 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997160981")
2025/05/06 06:20:15 DEBUG : box root 'rclone-test-voyehub7guju': ["file2.rclone_chunk.002_tz7hmq"(0)|file|ITEM_UPLOAD|1853938467636|bccbd5fc8c9a81b8984890b60326d8c528aec829] ignored due to old SequenceID ('\x01')
2025/05/06 06:20:15 DEBUG : box root 'rclone-test-voyehub7guju': ["file2.rclone_chunk.001"(1)|file|ITEM_RENAME|1853931438660|31a314939f6dc7d20c0910b388d7f1f56238d93a] ignored due to old SequenceID ('\x01')
2025/05/06 06:20:15 DEBUG : box root 'rclone-test-voyehub7guju': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1853938467636|2663232e033857f54fe229ff3a665c06c6ead26e] ignored due to old SequenceID ('\x01')
2025/05/06 06:20:15 DEBUG : box root 'rclone-test-voyehub7guju': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1853929893361|165bab22b3d6895868fc25aaa987a1095eb6162c] new parent not found
2025/05/06 06:20:15 DEBUG : box root 'rclone-test-voyehub7guju': Received 5 events, resulting in 0 paths and 0 notifications
2025/05/06 06:20:15 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997161762")
2025/05/06 06:20:15 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997162004")
2025/05/06 06:20:15 INFO  : dir/file4.rclone_chunk.001_tz7ok4: Moved (server-side) to: dir/file4.rclone_chunk.001
2025/05/06 06:20:16 INFO  : dir/file4.rclone_chunk.002_tz7ok4: Moved (server-side) to: dir/file4.rclone_chunk.002
2025/05/06 06:20:16 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997162760")
2025/05/06 06:20:17 DEBUG : box root 'rclone-test-voyehub7guju': ["file2"(0)|file|ITEM_UPLOAD|1853934469941|7d8355e31e0d04cede63ab017c77214079a3ca9e] ignored due to old SequenceID ('\x00')
2025/05/06 06:20:17 DEBUG : box root 'rclone-test-voyehub7guju': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/06 06:20:17 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997163759")
2025/05/06 06:20:17 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997163984")
2025/05/06 06:20:18 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997164763")
2025/05/06 06:20:19 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997165759")
2025/05/06 06:20:20 DEBUG : box root 'rclone-test-voyehub7guju': ["file4.rclone_chunk.001_tz7ok4"(0)|file|ITEM_UPLOAD|1853936181128|31c721dba17c1608270569dde95d658c9fcf2cf7] ignored due to old SequenceID ('\x01')
2025/05/06 06:20:20 DEBUG : box root 'rclone-test-voyehub7guju': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1853932302778|fe7c4acef1911c34508762eabb0b7820a017a5e7] new parent not found
2025/05/06 06:20:20 DEBUG : box root 'rclone-test-voyehub7guju': Received 3 events, resulting in 0 paths and 0 notifications
2025/05/06 06:20:20 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997166763")
2025/05/06 06:20:20 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997166993")
2025/05/06 06:20:21 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997167762")
2025/05/06 06:20:22 DEBUG : box root 'rclone-test-voyehub7guju': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1853936181128|9bb48c616e9b8b570b1d9f59b2bd161ee3d8a80a] ignored due to old SequenceID ('\x01')
2025/05/06 06:20:22 DEBUG : box root 'rclone-test-voyehub7guju': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1853930555341|5293436f84fffb13b18b96ccba7b8679c61868ae] new parent not found
2025/05/06 06:20:22 DEBUG : box root 'rclone-test-voyehub7guju': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/06 06:20:22 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997168767")
2025/05/06 06:20:22 DEBUG : box root 'rclone-test-voyehub7guju': ["file4.rclone_chunk.002_tz7ok4"(0)|file|ITEM_UPLOAD|1853929626832|764ddf8149f0997f0565f233a0f6be13c3540de8] ignored due to old SequenceID ('\x01')
2025/05/06 06:20:22 DEBUG : box root 'rclone-test-voyehub7guju': ["file4.rclone_chunk.002"(1)|file|ITEM_RENAME|1853929626832|f527f2e8a7a4b11c5b7ccb2ac08b30e5edab1d18] ignored due to old SequenceID ('\x01')
2025/05/06 06:20:22 DEBUG : box root 'rclone-test-voyehub7guju': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/06 06:20:22 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997168990")
2025/05/06 06:20:22 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997169228")
2025/05/06 06:20:22 INFO  : dir/file3.rclone_chunk.001_tz7v6i: Moved (server-side) to: dir/file3.rclone_chunk.001
2025/05/06 06:20:23 INFO  : dir/file3.rclone_chunk.002_tz7v6i: Moved (server-side) to: dir/file3.rclone_chunk.002
2025/05/06 06:20:23 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997169763")
2025/05/06 06:20:24 DEBUG : box root 'rclone-test-voyehub7guju': ["file4"(0)|file|ITEM_UPLOAD|1853933824244|20ceaca48f62fbfad1e51a36281e851b1cd14c91] ignored due to old SequenceID ('\x00')
2025/05/06 06:20:24 DEBUG : box root 'rclone-test-voyehub7guju': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/06 06:20:24 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997170761")
2025/05/06 06:20:24 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997170991")
2025/05/06 06:20:25 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997171766")
2025/05/06 06:20:26 DEBUG : box root 'rclone-test-voyehub7guju': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1853934736449|967c14f23a466d7d7fe88e1c3c46948a40983de0] new parent not found
2025/05/06 06:20:26 DEBUG : box root 'rclone-test-voyehub7guju': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/06 06:20:26 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997172762")
    fstests.go:931: Try 1/10 waiting for dirChanges and objChanges
2025/05/06 06:20:26 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997173000")
2025/05/06 06:20:27 DEBUG : box root 'rclone-test-voyehub7guju': ["file3.rclone_chunk.001_tz7v6i"(0)|file|ITEM_UPLOAD|1853931887142|dc772b2d875ef57147302831adef5afdb5e97f99] ignored due to old SequenceID ('\x01')
2025/05/06 06:20:27 DEBUG : box root 'rclone-test-voyehub7guju': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/06 06:20:27 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997173758")
2025/05/06 06:20:27 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997173984")
2025/05/06 06:20:28 DEBUG : box root 'rclone-test-voyehub7guju': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/06 06:20:28 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997174764")
2025/05/06 06:20:28 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997174986")
2025/05/06 06:20:29 DEBUG : box root 'rclone-test-voyehub7guju': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/06 06:20:29 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997175766")
    fstests.go:931: Try 2/10 waiting for dirChanges and objChanges
2025/05/06 06:20:29 DEBUG : box root 'rclone-test-voyehub7guju': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1853931887142|de21ba880e0b1f9566702c640f2d1b44d4f4b3a5] ignored due to old SequenceID ('\x01')
2025/05/06 06:20:29 DEBUG : box root 'rclone-test-voyehub7guju': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/06 06:20:29 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997175988")
2025/05/06 06:20:29 DEBUG : box root 'rclone-test-voyehub7guju': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1853931032953|3f0103f16a31654bc11d852792e9e29cbf3419ff] new parent not found
2025/05/06 06:20:29 DEBUG : box root 'rclone-test-voyehub7guju': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/06 06:20:29 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997176210")
2025/05/06 06:20:29 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997176432")
2025/05/06 06:20:30 DEBUG : box root 'rclone-test-voyehub7guju': ["file3.rclone_chunk.002"(1)|file|ITEM_RENAME|1853935533266|7e248ff53624d01e0d4835d8dd0b7dee22e63dc8] ignored due to old SequenceID ('\x01')
2025/05/06 06:20:30 DEBUG : box root 'rclone-test-voyehub7guju': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/06 06:20:30 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997176759")
2025/05/06 06:20:30 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997176980")
2025/05/06 06:20:31 DEBUG : box root 'rclone-test-voyehub7guju': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1853934028554|fd4314886a020aebfb1224f6ed6b38b30b0709c4] new parent not found
2025/05/06 06:20:31 DEBUG : box root 'rclone-test-voyehub7guju': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/06 06:20:31 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997177766")
2025/05/06 06:20:31 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997177986")
2025/05/06 06:20:32 DEBUG : box root 'rclone-test-voyehub7guju': ["file3.rclone_chunk.002_tz7v6i"(0)|file|ITEM_UPLOAD|1853935533266|212cfc8fa95ffab99b6949ce07d31f5961e17f05] ignored due to old SequenceID ('\x01')
2025/05/06 06:20:32 DEBUG : box root 'rclone-test-voyehub7guju': ["file3"(0)|file|ITEM_UPLOAD|1853934378851|6a569858edaa0dd91930d313a8bb06ef36b1f655] ignored due to old SequenceID ('\x00')
2025/05/06 06:20:32 DEBUG : box root 'rclone-test-voyehub7guju': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/06 06:20:32 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997178758")
    fstests.go:931: Try 3/10 waiting for dirChanges and objChanges
2025/05/06 06:20:32 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997178985")
2025/05/06 06:20:33 DEBUG : box root 'rclone-test-voyehub7guju': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1853931198871|da56882091f50008feaa6a071de14778e763b735] new parent not found
2025/05/06 06:20:33 DEBUG : box root 'rclone-test-voyehub7guju': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/06 06:20:33 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997179758")
2025/05/06 06:20:33 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997179981")
2025/05/06 06:20:34 DEBUG : box root 'rclone-test-voyehub7guju': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/06 06:20:34 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997180761")
2025/05/06 06:20:34 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997180981")
2025/05/06 06:20:35 DEBUG : box root 'rclone-test-voyehub7guju': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/06 06:20:35 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997181757")
    fstests.go:931: Try 4/10 waiting for dirChanges and objChanges
2025/05/06 06:20:35 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997181981")
2025/05/06 06:20:36 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997182760")
2025/05/06 06:20:37 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997183759")
    fstests.go:931: Try 5/10 waiting for dirChanges and objChanges
2025/05/06 06:20:38 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997184775")
2025/05/06 06:20:39 DEBUG : box root 'rclone-test-voyehub7guju': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1853936800645|3d3f904346c05e3422c27eba9f9ba924f84ef8cb] new parent not found
2025/05/06 06:20:39 DEBUG : box root 'rclone-test-voyehub7guju': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/06 06:20:39 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997185755")
2025/05/06 06:20:39 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997185984")
2025/05/06 06:20:40 DEBUG : box root 'rclone-test-voyehub7guju': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/06 06:20:40 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997186759")
2025/05/06 06:20:40 DEBUG : box root 'rclone-test-voyehub7guju': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1853938688822|0f9a3b5c43dab7f13d42b646865163e18df6c540] new parent not found
2025/05/06 06:20:40 DEBUG : box root 'rclone-test-voyehub7guju': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/06 06:20:40 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997186981")
2025/05/06 06:20:40 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997187201")
    fstests.go:931: Try 6/10 waiting for dirChanges and objChanges
2025/05/06 06:20:41 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997187761")
2025/05/06 06:20:42 DEBUG : box root 'rclone-test-voyehub7guju': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/06 06:20:42 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997188758")
2025/05/06 06:20:42 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997188979")
2025/05/06 06:20:43 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997189760")
2025/05/06 06:20:44 DEBUG : box root 'rclone-test-voyehub7guju': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/06 06:20:44 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997190755")
    fstests.go:931: Try 7/10 waiting for dirChanges and objChanges
2025/05/06 06:20:44 DEBUG : box root 'rclone-test-voyehub7guju': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/06 06:20:44 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997190980")
2025/05/06 06:20:44 DEBUG : box root 'rclone-test-voyehub7guju': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/06 06:20:44 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997191204")
2025/05/06 06:20:44 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997191427")
2025/05/06 06:20:45 DEBUG : box root 'rclone-test-voyehub7guju': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/06 06:20:45 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997191759")
2025/05/06 06:20:45 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997191982")
2025/05/06 06:20:46 DEBUG : box root 'rclone-test-voyehub7guju': Received 6 events, resulting in 0 paths and 0 notifications
2025/05/06 06:20:46 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997192759")
2025/05/06 06:20:46 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997192992")
    fstests.go:931: Try 8/10 waiting for dirChanges and objChanges
2025/05/06 06:20:47 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997193759")
2025/05/06 06:20:48 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997194765")
2025/05/06 06:20:49 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997195762")
    fstests.go:931: Try 9/10 waiting for dirChanges and objChanges
2025/05/06 06:20:50 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997196760")
2025/05/06 06:20:51 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997197759")
2025/05/06 06:20:52 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997198761")
    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/06 06:20:53 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997199757")
2025/05/06 06:20:54 DEBUG : box root 'rclone-test-voyehub7guju': ["ignorelistingchecksum"(0)|folder|ITEM_CREATE|319853277074|3e29b09de86e3fcfe0e72e7fd938c129f520af39] new parent not found
2025/05/06 06:20:54 DEBUG : box root 'rclone-test-voyehub7guju': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/06 06:20:54 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997200769")
2025/05/06 06:20:54 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997200991")
2025/05/06 06:20:55 DEBUG : box root 'rclone-test-voyehub7guju': ["path1"(0)|folder|ITEM_CREATE|319853147420|3331e06fae729971da78d6b4784da6d10543f8c1] new parent not found
2025/05/06 06:20:55 DEBUG : box root 'rclone-test-voyehub7guju': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/06 06:20:55 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997201763")
2025/05/06 06:20:55 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997201985")
2025/05/06 06:20:56 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997202763")
2025/05/06 06:20:57 DEBUG : box root 'rclone-test-voyehub7guju': ["file1.copy1.txt"(0)|file|ITEM_UPLOAD|1853930990364|1d7196a4c70e136c98a05633de83163d3425e42e] new parent not found
2025/05/06 06:20:57 DEBUG : box root 'rclone-test-voyehub7guju': ["file1.copy3.txt"(0)|file|ITEM_UPLOAD|1853935725266|baa3c7a7fe3601d24b9f126d5456bbbe749e58c0] new parent not found
2025/05/06 06:20:57 DEBUG : box root 'rclone-test-voyehub7guju': ["file1.copy4.txt"(0)|file|ITEM_UPLOAD|1853938239627|6109d095d7167387ddb8f741386016b0a355d5f0] new parent not found
2025/05/06 06:20:57 DEBUG : box root 'rclone-test-voyehub7guju': ["file1.copy2.txt"(0)|file|ITEM_UPLOAD|1853936991947|7bec0be624b02b87a9459f198432f5d19631add2] new parent not found
2025/05/06 06:20:57 DEBUG : box root 'rclone-test-voyehub7guju': Received 4 events, resulting in 0 paths and 0 notifications
2025/05/06 06:20:57 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997203758")
2025/05/06 06:20:57 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997203986")
2025/05/06 06:20:58 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997204760")
2025/05/06 06:20:59 DEBUG : box root 'rclone-test-voyehub7guju': ["subdir"(0)|folder|ITEM_CREATE|319853984644|f365e8119661b5961d5ca35f9dd9ec9e3e20f514] new parent not found
2025/05/06 06:20:59 DEBUG : box root 'rclone-test-voyehub7guju': ["file1.txt"(0)|file|ITEM_UPLOAD|1853933613109|a44b16c239e66cd3fc21d6926ac240a1b8abe12c] new parent not found
2025/05/06 06:20:59 DEBUG : box root 'rclone-test-voyehub7guju': ["RCLONE_TEST"(0)|file|ITEM_UPLOAD|1853935259619|6ebb67cbe485c1b4a20685d9300545227a517a93] new parent not found
2025/05/06 06:20:59 DEBUG : box root 'rclone-test-voyehub7guju': ["file1.copy5.txt"(0)|file|ITEM_UPLOAD|1853933144518|92b2009c5e894132a7f4f0e7e73d48ac7c60a22c] new parent not found
2025/05/06 06:20:59 DEBUG : box root 'rclone-test-voyehub7guju': Received 4 events, resulting in 0 paths and 0 notifications
2025/05/06 06:20:59 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997205760")
2025/05/06 06:20:59 DEBUG : box root 'rclone-test-voyehub7guju': ["file20.txt"(0)|file|ITEM_UPLOAD|1853932919836|c4cdd9951a34cce4e86165c295171cab69bedea3] new parent not found
2025/05/06 06:20:59 DEBUG : box root 'rclone-test-voyehub7guju': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/06 06:20:59 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997206007")
2025/05/06 06:20:59 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997206230")
2025/05/06 06:21:00 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997206766")
2025/05/06 06:21:01 DEBUG : box root 'rclone-test-voyehub7guju': ["file2"(1)|file|ITEM_TRASH|1853934469941|6235ed35a6a3436f51c362c24cc518b0fd2583e5] added old path ("dir/file2") for notify
2025/05/06 06:21:01 DEBUG : doChangeNotify("dir/file2", 1)
2025/05/06 06:21:01 DEBUG : box root 'rclone-test-voyehub7guju': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/06 06:21:01 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997207768")
2025/05/06 06:21:01 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997207991")
2025/05/06 06:21:02 DEBUG : box root 'rclone-test-voyehub7guju': ["path2"(0)|folder|ITEM_CREATE|319853310838|28a348e2b1f509bc78f488a95d5b2bf29b0f61ac] new parent not found
2025/05/06 06:21:02 DEBUG : box root 'rclone-test-voyehub7guju': ["file2.rclone_chunk.001"(2)|file|ITEM_TRASH|1853931438660|68b3cb3e9014fb04486f64f76210529d423bdbeb] added old path ("dir/file2.rclone_chunk.001") for notify
2025/05/06 06:21:02 DEBUG : doChangeNotify("dir/file2", 1)
2025/05/06 06:21:02 DEBUG : box root 'rclone-test-voyehub7guju': Received 2 events, resulting in 1 paths and 1 notifications
2025/05/06 06:21:02 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997208763")
2025/05/06 06:21:02 DEBUG : box root 'rclone-test-voyehub7guju': ["subdir"(0)|folder|ITEM_CREATE|319854532348|0bb9eb9a88e4e7b0b122e410866a30aff2c4ab76] new parent not found
2025/05/06 06:21:02 DEBUG : box root 'rclone-test-voyehub7guju': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/06 06:21:02 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997208990")
2025/05/06 06:21:02 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997209215")
2025/05/06 06:21:03 DEBUG : box root 'rclone-test-voyehub7guju': ["file2.rclone_chunk.002"(2)|file|ITEM_TRASH|1853938467636|eb5736471a3f8900becbe1c06445027d0494f67e] added old path ("dir/file2.rclone_chunk.002") for notify
2025/05/06 06:21:03 DEBUG : box root 'rclone-test-voyehub7guju': ["file1.copy1.txt"(0)|file|ITEM_UPLOAD|1853936017743|5439468c62376c8d4d61c83e2553e17d5a11d9d1] new parent not found
2025/05/06 06:21:03 DEBUG : doChangeNotify("dir/file2", 1)
2025/05/06 06:21:03 DEBUG : box root 'rclone-test-voyehub7guju': Received 2 events, resulting in 1 paths and 1 notifications
2025/05/06 06:21:03 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997209762")
2025/05/06 06:21:03 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997209985")
2025/05/06 06:21:04 DEBUG : box root 'rclone-test-voyehub7guju': ["file1.copy3.txt"(0)|file|ITEM_UPLOAD|1853930241361|7ea5bda5a87e633e517c84d815e63d1789baf18f] new parent not found
2025/05/06 06:21:04 DEBUG : box root 'rclone-test-voyehub7guju': ["file1.copy2.txt"(0)|file|ITEM_UPLOAD|1853937119428|416dedb753cd52159f519a285f1fe0b9d21c2239] new parent not found
2025/05/06 06:21:04 DEBUG : box root 'rclone-test-voyehub7guju': ["file4"(1)|file|ITEM_TRASH|1853933824244|4ed821e696835830d9c84f62b90227405853fd2d] added old path ("dir/file4") for notify
2025/05/06 06:21:04 DEBUG : box root 'rclone-test-voyehub7guju': ["file1.copy4.txt"(0)|file|ITEM_UPLOAD|1853934938393|f0fd8a55ed59264c1f7b804d632996b0db8a2a01] new parent not found
2025/05/06 06:21:04 DEBUG : doChangeNotify("dir/file4", 1)
2025/05/06 06:21:04 DEBUG : box root 'rclone-test-voyehub7guju': Received 4 events, resulting in 1 paths and 1 notifications
2025/05/06 06:21:04 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997210760")
2025/05/06 06:21:04 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997210995")
2025/05/06 06:21:05 DEBUG : box root 'rclone-test-voyehub7guju': ["file1.txt"(0)|file|ITEM_UPLOAD|1853936094275|53f16b8bb303f64017952ad3256a007caf5553a5] new parent not found
2025/05/06 06:21:05 DEBUG : box root 'rclone-test-voyehub7guju': ["RCLONE_TEST"(0)|file|ITEM_UPLOAD|1853936373407|e4e03ab97cc6650b901667ad69f0f473260f48ff] new parent not found
2025/05/06 06:21:05 DEBUG : box root 'rclone-test-voyehub7guju': ["file1.copy5.txt"(0)|file|ITEM_UPLOAD|1853935859295|7a145784e2d79fcf4daf98bfec0f8081422b4f23] new parent not found
2025/05/06 06:21:05 DEBUG : box root 'rclone-test-voyehub7guju': ["file20.txt"(0)|file|ITEM_UPLOAD|1853933043629|f30b80c3e6d4e51b8d331ef3c63ebc4ccefdb429] new parent not found
2025/05/06 06:21:05 DEBUG : box root 'rclone-test-voyehub7guju': Received 4 events, resulting in 0 paths and 0 notifications
2025/05/06 06:21:05 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997211792")
2025/05/06 06:21:05 DEBUG : box root 'rclone-test-voyehub7guju': ["file4.rclone_chunk.001"(2)|file|ITEM_TRASH|1853936181128|af1d5014da94aa4ce405d8ca57920cf381060029] added old path ("dir/file4.rclone_chunk.001") for notify
2025/05/06 06:21:05 DEBUG : doChangeNotify("dir/file4", 1)
2025/05/06 06:21:05 DEBUG : box root 'rclone-test-voyehub7guju': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/06 06:21:05 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997212025")
2025/05/06 06:21:05 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997212249")
2025/05/06 06:21:06 DEBUG : box root 'rclone-test-voyehub7guju': ["file4.rclone_chunk.002"(2)|file|ITEM_TRASH|1853929626832|ed01e4b52547329044f10859089a5528c33df4cf] added old path ("dir/file4.rclone_chunk.002") for notify
2025/05/06 06:21:06 DEBUG : doChangeNotify("dir/file4", 1)
2025/05/06 06:21:06 DEBUG : box root 'rclone-test-voyehub7guju': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/06 06:21:06 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997212760")
2025/05/06 06:21:06 DEBUG : box root 'rclone-test-voyehub7guju': Checking for changes on remote (next_stream_position: "30401043997212982")
2025/05/06 06:21:08 DEBUG : box root 'rclone-test-voyehub7guju': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/05/06 06:21:08 ERROR : : error listing: directory not found
2025/05/06 06:21:08 DEBUG : box root 'rclone-test-voyehub7guju': Ignoring "Shared folder — ForNick" - unknown type "web_link"
--- FAIL: TestIntegration (70.48s)
    --- FAIL: TestIntegration/FsMkdir (68.33s)
        --- FAIL: TestIntegration/FsMkdir/FsChangeNotify (66.38s)
FAIL
exit status 1
FAIL	github.com/rclone/rclone/backend/chunker	70.540s
"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024 -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Finished ERROR in 1m13.206303812s (try 4/5): exit status 1: Failed [TestIntegration/FsMkdir/FsChangeNotify]