"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/15 01:26:23 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-menacab4boxi"
2025/05/15 01:26:23 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/05/15 01:26:23 DEBUG : Creating backend with remote "TestBox:rclone-test-menacab4boxi"
2025/05/15 01:26:24 DEBUG : box root 'rclone-test-menacab4boxi': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/05/15 01:26:26 DEBUG : box root 'rclone-test-menacab4boxi': Ignoring "Shared folder — ForNick" - unknown type "web_link"
=== RUN   TestIntegration/FsMkdir
=== RUN   TestIntegration/FsMkdir/FsChangeNotify
2025/05/15 01:26:27 INFO  : dir: Making directory
2025/05/15 01:26:30 INFO  : dir/subdir1: Making directory
2025/05/15 01:26:31 INFO  : dir/subdir3: Making directory
2025/05/15 01:26:31 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757137244")
2025/05/15 01:26:32 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757138485")
2025/05/15 01:26:32 INFO  : dir/subdir2: Making directory
2025/05/15 01:26:32 DEBUG : box root 'rclone-test-menacab4boxi': ["rclone-test-menacab4boxi"(0)|folder|ITEM_CREATE|321255244186|e2d443dfc4c699012f6db026da724f12195c5526] new parent not found
2025/05/15 01:26:32 DEBUG : box root 'rclone-test-menacab4boxi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/15 01:26:32 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757139471")
2025/05/15 01:26:33 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757139702")
2025/05/15 01:26:33 DEBUG : box root 'rclone-test-menacab4boxi': ["dir"(0)|folder|ITEM_CREATE|321259722795|419e6ff82d7c1500ed02a85fc43dc49bae6b82a9] new parent not found
2025/05/15 01:26:33 DEBUG : box root 'rclone-test-menacab4boxi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/15 01:26:33 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757140479")
2025/05/15 01:26:33 DEBUG : box root 'rclone-test-menacab4boxi': ["two.rclone_chunk.001_a9m9lk"(0)|file|ITEM_UPLOAD|1862658824976|28ca5688db78c03f56b01256b157c3e046f1d1eb] new parent not found
2025/05/15 01:26:33 DEBUG : box root 'rclone-test-menacab4boxi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/15 01:26:33 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757140716")
2025/05/15 01:26:34 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757140952")
2025/05/15 01:26:35 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757141478")
2025/05/15 01:26:35 DEBUG : box root 'rclone-test-menacab4boxi': ["file1.rclone_chunk.001_a9m94x"(0)|file|ITEM_UPLOAD|1862658954641|38968dac6be80da11859f18f9e69c6e4a75cab30] new parent not found
2025/05/15 01:26:35 DEBUG : box root 'rclone-test-menacab4boxi': ["file1"(1)|file|ITEM_RENAME|1862658954641|db7f27d8f51cd7b50af13db763fe1c8ca5072b44] new parent not found
2025/05/15 01:26:35 DEBUG : box root 'rclone-test-menacab4boxi': ["two"(1)|file|ITEM_RENAME|1862658824976|8177358f278708025c0dd9e710239718659f2d74] new parent not found
2025/05/15 01:26:35 DEBUG : box root 'rclone-test-menacab4boxi': Received 3 events, resulting in 0 paths and 0 notifications
2025/05/15 01:26:35 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757142482")
2025/05/15 01:26:36 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757142722")
2025/05/15 01:26:36 DEBUG : box root 'rclone-test-menacab4boxi': ["dir"(0)|folder|ITEM_CREATE|321255880020|d38a5b1dee9da963265ec967f39de92dfcfe56ba] added new path ("dir") for notify
2025/05/15 01:26:36 DEBUG : doChangeNotify("dir", 0)
2025/05/15 01:26:36 DEBUG : box root 'rclone-test-menacab4boxi': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/15 01:26:36 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757143473")
2025/05/15 01:26:37 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757143706")
2025/05/15 01:26:38 INFO  : dir/file2.rclone_chunk.001_a9mhl6: Moved (server-side) to: dir/file2.rclone_chunk.001
2025/05/15 01:26:38 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757144477")
2025/05/15 01:26:38 DEBUG : box root 'rclone-test-menacab4boxi': ["subdir3"(0)|folder|ITEM_CREATE|321256432459|471678e0ac12fc9171e151fcf513af1f05294067] added new path ("dir/subdir3") for notify
2025/05/15 01:26:38 DEBUG : box root 'rclone-test-menacab4boxi': ["subdir1"(0)|folder|ITEM_CREATE|321259207129|522f2d3d75f0be51e39c8beda12f943d2217bbc5] added new path ("dir/subdir1") for notify
2025/05/15 01:26:38 DEBUG : doChangeNotify("dir/subdir3", 0)
2025/05/15 01:26:38 DEBUG : doChangeNotify("dir/subdir1", 0)
2025/05/15 01:26:38 DEBUG : box root 'rclone-test-menacab4boxi': Received 4 events, resulting in 2 paths and 2 notifications
2025/05/15 01:26:38 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757145474")
2025/05/15 01:26:38 INFO  : dir/file2.rclone_chunk.002_a9mhl6: Moved (server-side) to: dir/file2.rclone_chunk.002
2025/05/15 01:26:39 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757145732")
2025/05/15 01:26:39 DEBUG : box root 'rclone-test-menacab4boxi': ["subdir2"(0)|folder|ITEM_CREATE|321255347232|ade75adc0ef835c78f7744cba0ab630341996d26] added new path ("dir/subdir2") for notify
2025/05/15 01:26:39 DEBUG : doChangeNotify("dir/subdir2", 0)
2025/05/15 01:26:39 DEBUG : box root 'rclone-test-menacab4boxi': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/15 01:26:39 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757146477")
2025/05/15 01:26:40 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757146708")
2025/05/15 01:26:41 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757147483")
2025/05/15 01:26:41 DEBUG : box root 'rclone-test-menacab4boxi': ["file2.rclone_chunk.001_a9mhl6"(0)|file|ITEM_UPLOAD|1862659595420|fdcdf320624d14909d0bf7690d961e7da51c361c] ignored due to old SequenceID ('\x01')
2025/05/15 01:26:41 DEBUG : box root 'rclone-test-menacab4boxi': Received 5 events, resulting in 0 paths and 0 notifications
2025/05/15 01:26:41 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757148469")
2025/05/15 01:26:42 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757148728")
2025/05/15 01:26:42 DEBUG : box root 'rclone-test-menacab4boxi': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/15 01:26:42 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757149469")
2025/05/15 01:26:43 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757149716")
2025/05/15 01:26:43 DEBUG : box root 'rclone-test-menacab4boxi': ["dir"(0)|folder|ITEM_CREATE|321259638469|3815508079a99757e3bc4168e802fdcc14978cf1] new parent not found
2025/05/15 01:26:43 DEBUG : box root 'rclone-test-menacab4boxi': ["file2.rclone_chunk.001"(1)|file|ITEM_RENAME|1862659595420|e305754a7264791a9f2afa8eea625bf64b961ff2] ignored due to old SequenceID ('\x01')
2025/05/15 01:26:43 DEBUG : box root 'rclone-test-menacab4boxi': ["file2.rclone_chunk.002_a9mhl6"(0)|file|ITEM_UPLOAD|1862662914318|8c6e601e1d069cdc47f0d419f908934fa350fe0f] ignored due to old SequenceID ('\x01')
2025/05/15 01:26:43 DEBUG : box root 'rclone-test-menacab4boxi': Received 3 events, resulting in 0 paths and 0 notifications
2025/05/15 01:26:43 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757150477")
2025/05/15 01:26:44 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757150722")
2025/05/15 01:26:44 DEBUG : box root 'rclone-test-menacab4boxi': ["pre-dest1"(0)|folder|ITEM_CREATE|321257864873|8c951435ff05deed852b9a9dc89d064a99c336ee] new parent not found
2025/05/15 01:26:44 DEBUG : box root 'rclone-test-menacab4boxi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/15 01:26:44 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757151482")
2025/05/15 01:26:44 DEBUG : box root 'rclone-test-menacab4boxi': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1862662914318|c71219c8b6ba4c352455f5e3a32065cfc26f4b7a] ignored due to old SequenceID ('\x01')
2025/05/15 01:26:44 DEBUG : box root 'rclone-test-menacab4boxi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/15 01:26:44 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757151720")
2025/05/15 01:26:45 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757151963")
2025/05/15 01:26:45 DEBUG : box root 'rclone-test-menacab4boxi': ["file1.rclone_chunk.001_a9mjs9"(0)|file|ITEM_UPLOAD|1862656839810|537264a5fb8ce802a984ec9d78f4c2a7dd6b9fd2] new parent not found
2025/05/15 01:26:45 DEBUG : box root 'rclone-test-menacab4boxi': ["1.rclone_chunk.001_a9mlq1"(0)|file|ITEM_UPLOAD|1862667529389|ef54fa10bddb52a2aaa47061f8fcf25cc539137c] new parent not found
2025/05/15 01:26:45 DEBUG : box root 'rclone-test-menacab4boxi': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/15 01:26:45 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757152472")
2025/05/15 01:26:46 INFO  : dir/file4.rclone_chunk.001_a9mpq1: Moved (server-side) to: dir/file4.rclone_chunk.001
2025/05/15 01:26:46 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757152709")
2025/05/15 01:26:46 DEBUG : box root 'rclone-test-menacab4boxi': ["file2"(0)|file|ITEM_UPLOAD|1862661952720|8e6c25b8828c1c62bb80b7168c5c63f4d8da32b5] ignored due to old SequenceID ('\x00')
2025/05/15 01:26:46 DEBUG : box root 'rclone-test-menacab4boxi': ["file1"(1)|file|ITEM_RENAME|1862656839810|7cd8a6a14d4b8f996a1642d02a2f9bdfad0c3bc8] new parent not found
2025/05/15 01:26:46 DEBUG : box root 'rclone-test-menacab4boxi': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/15 01:26:46 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757153476")
2025/05/15 01:26:46 INFO  : dir/file4.rclone_chunk.002_a9mpq1: Moved (server-side) to: dir/file4.rclone_chunk.002
2025/05/15 01:26:47 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757153725")
2025/05/15 01:26:47 DEBUG : box root 'rclone-test-menacab4boxi': ["1"(1)|file|ITEM_RENAME|1862667529389|902e235f13a30b5b90930988489e5dcf2a66378a] new parent not found
2025/05/15 01:26:47 DEBUG : box root 'rclone-test-menacab4boxi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/15 01:26:47 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757154484")
2025/05/15 01:26:48 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757154725")
2025/05/15 01:26:49 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757155480")
2025/05/15 01:26:49 DEBUG : box root 'rclone-test-menacab4boxi': ["pre-dest2"(0)|folder|ITEM_CREATE|321255829377|679046c63c58acf9d9da1eee7fc54d8004eb674a] new parent not found
2025/05/15 01:26:49 DEBUG : box root 'rclone-test-menacab4boxi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/15 01:26:49 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757156473")
2025/05/15 01:26:50 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757156705")
2025/05/15 01:26:50 DEBUG : box root 'rclone-test-menacab4boxi': ["file4.rclone_chunk.001_a9mpq1"(0)|file|ITEM_UPLOAD|1862661668875|f99a4f400ea63967fd4c91ec3423e0c39c28aad1] ignored due to old SequenceID ('\x01')
2025/05/15 01:26:50 DEBUG : box root 'rclone-test-menacab4boxi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/15 01:26:50 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757157473")
2025/05/15 01:26:50 DEBUG : box root 'rclone-test-menacab4boxi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/15 01:26:50 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757157712")
2025/05/15 01:26:51 DEBUG : box root 'rclone-test-menacab4boxi': ["2.rclone_chunk.001_a9mp2f"(0)|file|ITEM_UPLOAD|1862668590617|fdfb99b011cc065471086128c1e56e3ab52c1a85] new parent not found
2025/05/15 01:26:51 DEBUG : box root 'rclone-test-menacab4boxi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/15 01:26:51 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757157956")
2025/05/15 01:26:51 DEBUG : box root 'rclone-test-menacab4boxi': ["file4.rclone_chunk.002_a9mpq1"(0)|file|ITEM_UPLOAD|1862664762847|ad107cb3f36abedb85807b08fcc822606f05ea96] ignored due to old SequenceID ('\x01')
2025/05/15 01:26:51 DEBUG : box root 'rclone-test-menacab4boxi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/15 01:26:51 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757158191")
2025/05/15 01:26:51 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757158430")
2025/05/15 01:26:51 DEBUG : box root 'rclone-test-menacab4boxi': ["2"(1)|file|ITEM_RENAME|1862668590617|ef221f591efa467f0d6498ad86b8bef0d0383ee0] new parent not found
2025/05/15 01:26:51 DEBUG : box root 'rclone-test-menacab4boxi': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/15 01:26:51 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757158677")
2025/05/15 01:26:52 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757158925")
2025/05/15 01:26:52 DEBUG : box root 'rclone-test-menacab4boxi': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1862661668875|68433ad298e99f05d59296343bedbc5127966213] ignored due to old SequenceID ('\x01')
2025/05/15 01:26:52 DEBUG : box root 'rclone-test-menacab4boxi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/15 01:26:52 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757159473")
2025/05/15 01:26:53 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757159704")
2025/05/15 01:26:53 DEBUG : box root 'rclone-test-menacab4boxi': ["file4.rclone_chunk.002"(1)|file|ITEM_RENAME|1862664762847|26ce695e478f2baab2cddc649d1e98cebf32192c] ignored due to old SequenceID ('\x01')
2025/05/15 01:26:53 DEBUG : box root 'rclone-test-menacab4boxi': ["file4"(0)|file|ITEM_UPLOAD|1862659809167|98c6643f859c03af37cf83d9139b53cd943f7e10] ignored due to old SequenceID ('\x00')
2025/05/15 01:26:53 DEBUG : box root 'rclone-test-menacab4boxi': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/15 01:26:53 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757160491")
2025/05/15 01:26:54 INFO  : dir/file3.rclone_chunk.001_a9mxu8: Moved (server-side) to: dir/file3.rclone_chunk.001
2025/05/15 01:26:54 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757160748")
2025/05/15 01:26:54 INFO  : dir/file3.rclone_chunk.002_a9mxu8: Moved (server-side) to: dir/file3.rclone_chunk.002
2025/05/15 01:26:55 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757161484")
2025/05/15 01:26:55 DEBUG : box root 'rclone-test-menacab4boxi': ["file1.rclone_chunk.001_a9mujm"(0)|file|ITEM_UPLOAD|1862668184781|ce68bc3b1b24d64156fa43db8df9cd299ff2e66d] new parent not found
2025/05/15 01:26:55 DEBUG : box root 'rclone-test-menacab4boxi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/15 01:26:55 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757162477")
2025/05/15 01:26:56 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757162726")
2025/05/15 01:26:56 DEBUG : box root 'rclone-test-menacab4boxi': ["file1"(1)|file|ITEM_RENAME|1862668184781|c05c2806b8fd945b70ba3c6d2b12bb27ab36b741] new parent not found
2025/05/15 01:26:56 DEBUG : box root 'rclone-test-menacab4boxi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/15 01:26:56 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757163474")
    fstests.go:931: Try 1/10 waiting for dirChanges and objChanges
2025/05/15 01:26:57 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757163717")
2025/05/15 01:26:58 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757164498")
2025/05/15 01:26:58 DEBUG : box root 'rclone-test-menacab4boxi': ["file3.rclone_chunk.001_a9mxu8"(0)|file|ITEM_UPLOAD|1862661313741|a98511b35155115c910fdb44c4eae49149a2ca24] ignored due to old SequenceID ('\x01')
2025/05/15 01:26:58 DEBUG : box root 'rclone-test-menacab4boxi': ["file3.rclone_chunk.002_a9mxu8"(0)|file|ITEM_UPLOAD|1862661884807|2e99e4c4871080b558044b6c249ca2b907cfd911] ignored due to old SequenceID ('\x01')
2025/05/15 01:26:58 DEBUG : box root 'rclone-test-menacab4boxi': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/15 01:26:58 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757165467")
2025/05/15 01:26:59 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757165710")
2025/05/15 01:26:59 DEBUG : box root 'rclone-test-menacab4boxi': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1862661313741|645095adbe9764cd31dbba1516d289cc64869d6d] ignored due to old SequenceID ('\x01')
2025/05/15 01:26:59 DEBUG : box root 'rclone-test-menacab4boxi': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/15 01:26:59 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757166473")
    fstests.go:931: Try 2/10 waiting for dirChanges and objChanges
2025/05/15 01:27:00 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757166712")
2025/05/15 01:27:01 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757167483")
2025/05/15 01:27:01 DEBUG : box root 'rclone-test-menacab4boxi': ["file3.rclone_chunk.002"(1)|file|ITEM_RENAME|1862661884807|060d88f0d8de188450d6988df227745946c40eaa] ignored due to old SequenceID ('\x01')
2025/05/15 01:27:01 DEBUG : box root 'rclone-test-menacab4boxi': ["file1.rclone_chunk.001_a9n16c"(0)|file|ITEM_UPLOAD|1862667606637|23852f3a74034385296349512fc8cbef62257fd4] new parent not found
2025/05/15 01:27:01 DEBUG : box root 'rclone-test-menacab4boxi': ["file3"(0)|file|ITEM_UPLOAD|1862656562012|64fc3406467ca38637adad02b8eea6e639bb75d7] ignored due to old SequenceID ('\x00')
2025/05/15 01:27:01 DEBUG : box root 'rclone-test-menacab4boxi': Received 3 events, resulting in 0 paths and 0 notifications
2025/05/15 01:27:01 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757168507")
2025/05/15 01:27:02 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757168758")
    fstests.go:931: Try 3/10 waiting for dirChanges and objChanges
2025/05/15 01:27:03 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757169473")
2025/05/15 01:27:03 DEBUG : box root 'rclone-test-menacab4boxi': ["file1"(1)|file|ITEM_RENAME|1862667606637|205e26357aefcbad87c02df7a71147a029c8af0c] new parent not found
2025/05/15 01:27:03 DEBUG : box root 'rclone-test-menacab4boxi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/15 01:27:03 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757170473")
2025/05/15 01:27:04 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757170720")
2025/05/15 01:27:05 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757171500")
2025/05/15 01:27:05 DEBUG : box root 'rclone-test-menacab4boxi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/15 01:27:05 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757172485")
    fstests.go:931: Try 4/10 waiting for dirChanges and objChanges
2025/05/15 01:27:06 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757172727")
2025/05/15 01:27:07 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757173479")
2025/05/15 01:27:07 DEBUG : box root 'rclone-test-menacab4boxi': ["3.rclone_chunk.001_a9n5tf"(0)|file|ITEM_UPLOAD|1862662427815|765d94e95c712ee3ec8723bdc750abed5831f941] new parent not found
2025/05/15 01:27:07 DEBUG : box root 'rclone-test-menacab4boxi': ["3"(1)|file|ITEM_RENAME|1862662427815|7494d39dffbf4571567698a0ca6dc0be28afb520] new parent not found
2025/05/15 01:27:07 DEBUG : box root 'rclone-test-menacab4boxi': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/15 01:27:07 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757174473")
2025/05/15 01:27:08 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757174716")
    fstests.go:931: Try 5/10 waiting for dirChanges and objChanges
2025/05/15 01:27:09 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757175472")
2025/05/15 01:27:09 DEBUG : box root 'rclone-test-menacab4boxi': ["dest"(0)|folder|ITEM_CREATE|321255549125|2225ee0912f9ca2d63b2bdeb400caa53be84d68d] new parent not found
2025/05/15 01:27:09 DEBUG : box root 'rclone-test-menacab4boxi': ["file2.rclone_chunk.001_a9n9r5"(0)|file|ITEM_UPLOAD|1862663667832|300802abd51e197b3933841d78676f196fa82209] new parent not found
2025/05/15 01:27:09 DEBUG : box root 'rclone-test-menacab4boxi': ["file1.rclone_chunk.001_a9n87r"(0)|file|ITEM_UPLOAD|1862663440578|ef8786c01d6623c0dd41d7a58c8495fb75d197e5] new parent not found
2025/05/15 01:27:09 DEBUG : box root 'rclone-test-menacab4boxi': ["file2"(1)|file|ITEM_RENAME|1862663667832|aa8386381d719bb42918c806a32412c7855cc475] new parent not found
2025/05/15 01:27:09 DEBUG : box root 'rclone-test-menacab4boxi': Received 4 events, resulting in 0 paths and 0 notifications
2025/05/15 01:27:09 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757176473")
2025/05/15 01:27:09 DEBUG : box root 'rclone-test-menacab4boxi': ["file1"(1)|file|ITEM_RENAME|1862663440578|bc335985ca4684d6bb0a1867bb533d781a9621d0] new parent not found
2025/05/15 01:27:09 DEBUG : box root 'rclone-test-menacab4boxi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/15 01:27:09 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757176737")
2025/05/15 01:27:10 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757177008")
2025/05/15 01:27:11 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757177486")
2025/05/15 01:27:11 DEBUG : box root 'rclone-test-menacab4boxi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/15 01:27:11 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757178474")
    fstests.go:931: Try 6/10 waiting for dirChanges and objChanges
2025/05/15 01:27:12 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757178712")
2025/05/15 01:27:12 DEBUG : box root 'rclone-test-menacab4boxi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/15 01:27:12 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757179474")
2025/05/15 01:27:13 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757179719")
2025/05/15 01:27:13 DEBUG : box root 'rclone-test-menacab4boxi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/15 01:27:13 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757180481")
2025/05/15 01:27:14 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757180714")
2025/05/15 01:27:14 DEBUG : box root 'rclone-test-menacab4boxi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/15 01:27:14 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757181479")
    fstests.go:931: Try 7/10 waiting for dirChanges and objChanges
2025/05/15 01:27:15 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757181715")
2025/05/15 01:27:15 DEBUG : box root 'rclone-test-menacab4boxi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/15 01:27:15 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757182491")
2025/05/15 01:27:16 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757182735")
2025/05/15 01:27:16 DEBUG : box root 'rclone-test-menacab4boxi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/15 01:27:16 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757183481")
2025/05/15 01:27:16 DEBUG : box root 'rclone-test-menacab4boxi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/15 01:27:16 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757183707")
    fstests.go:931: Try 8/10 waiting for dirChanges and objChanges
2025/05/15 01:27:20 DEBUG : box root 'rclone-test-menacab4boxi': ["file1.rclone_chunk.001_a9nhdi"(0)|file|ITEM_UPLOAD|1862669605908|97b7fd7587d2e6cd80e459f8c2519d1d763cae41] new parent not found
2025/05/15 01:27:20 DEBUG : box root 'rclone-test-menacab4boxi': ["file1"(1)|file|ITEM_RENAME|1862669605908|af10e9f81cabf3560559f8be1fbfedfa19638510] new parent not found
2025/05/15 01:27:20 DEBUG : box root 'rclone-test-menacab4boxi': Received 3 events, resulting in 0 paths and 0 notifications
2025/05/15 01:27:20 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757186744")
2025/05/15 01:27:20 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757187002")
2025/05/15 01:27:20 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757187237")
    fstests.go:931: Try 9/10 waiting for dirChanges and objChanges
2025/05/15 01:27:21 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757187477")
2025/05/15 01:27:21 DEBUG : box root 'rclone-test-menacab4boxi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/15 01:27:21 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757188471")
2025/05/15 01:27:22 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757188717")
2025/05/15 01:27:23 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757189477")
2025/05/15 01:27:23 DEBUG : box root 'rclone-test-menacab4boxi': ["file1.rclone_chunk.001_a9nnym"(0)|file|ITEM_UPLOAD|1862658867855|f7e2e703f51de292885eb0876dbcc3f8831b9763] new parent not found
2025/05/15 01:27:23 DEBUG : box root 'rclone-test-menacab4boxi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/15 01:27:23 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757190488")
    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/15 01:27:24 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757190723")
2025/05/15 01:27:25 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757191473")
2025/05/15 01:27:25 DEBUG : box root 'rclone-test-menacab4boxi': ["file1"(1)|file|ITEM_RENAME|1862658867855|69ff441e91a14c420bc7dbec55706976f400dd2f] new parent not found
2025/05/15 01:27:25 DEBUG : box root 'rclone-test-menacab4boxi': ["dst"(0)|folder|ITEM_CREATE|321256686803|73cafa9270822fe43d45cdf89bc8813dc4e3128e] new parent not found
2025/05/15 01:27:25 DEBUG : box root 'rclone-test-menacab4boxi': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/15 01:27:25 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757192472")
2025/05/15 01:27:26 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757192720")
2025/05/15 01:27:26 DEBUG : box root 'rclone-test-menacab4boxi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/15 01:27:26 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757193477")
2025/05/15 01:27:27 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757193717")
2025/05/15 01:27:27 DEBUG : box root 'rclone-test-menacab4boxi': ["one.rclone_chunk.001_a9np3n"(0)|file|ITEM_UPLOAD|1862659878307|1ac7cc1752501541d9b3883b49900812ddf95105] new parent not found
2025/05/15 01:27:27 DEBUG : box root 'rclone-test-menacab4boxi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/15 01:27:27 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757194472")
2025/05/15 01:27:28 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757194713")
2025/05/15 01:27:29 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757195476")
2025/05/15 01:27:29 DEBUG : box root 'rclone-test-menacab4boxi': ["dir"(0)|folder|ITEM_CREATE|321256688567|6493051367e722c8fc3666c3b23da4b32346fb6f] new parent not found
2025/05/15 01:27:29 DEBUG : box root 'rclone-test-menacab4boxi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/15 01:27:29 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757196484")
2025/05/15 01:27:30 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757196723")
2025/05/15 01:27:31 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757197492")
2025/05/15 01:27:31 DEBUG : box root 'rclone-test-menacab4boxi': ["file1.rclone_chunk.001_a9ntgh"(0)|file|ITEM_UPLOAD|1862659698446|4de8817e59d26d7da6f7168885df0e1b16d12ece] new parent not found
2025/05/15 01:27:31 DEBUG : box root 'rclone-test-menacab4boxi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/15 01:27:31 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757198478")
2025/05/15 01:27:32 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757198712")
2025/05/15 01:27:33 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757199471")
2025/05/15 01:27:33 DEBUG : box root 'rclone-test-menacab4boxi': ["one"(1)|file|ITEM_RENAME|1862659878307|c773b19c9c1bc07666f0e17548878a5b05c2c3b3] new parent not found
2025/05/15 01:27:33 DEBUG : box root 'rclone-test-menacab4boxi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/15 01:27:33 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757200470")
2025/05/15 01:27:33 DEBUG : box root 'rclone-test-menacab4boxi': ["file2.rclone_chunk.001"(2)|file|ITEM_TRASH|1862659595420|b5bdb0d6a6baecf680c38c8f5edf078955fb194d] added old path ("dir/file2.rclone_chunk.001") for notify
2025/05/15 01:27:33 DEBUG : doChangeNotify("dir/file2", 1)
2025/05/15 01:27:33 DEBUG : box root 'rclone-test-menacab4boxi': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/15 01:27:33 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757200714")
2025/05/15 01:27:34 DEBUG : box root 'rclone-test-menacab4boxi': ["file2"(1)|file|ITEM_TRASH|1862661952720|9cbca6974b402c01db0c86aafbdcdc78bde19427] added old path ("dir/file2") for notify
2025/05/15 01:27:34 DEBUG : box root 'rclone-test-menacab4boxi': ["file2.rclone_chunk.002"(2)|file|ITEM_TRASH|1862662914318|7a3f2ad86051e32eebe206b3b8a5ee5180c7d526] added old path ("dir/file2.rclone_chunk.002") for notify
2025/05/15 01:27:34 DEBUG : box root 'rclone-test-menacab4boxi': ["file1"(1)|file|ITEM_RENAME|1862659698446|446eb1094f996dab8cd470722fc97b756fdf77d9] new parent not found
2025/05/15 01:27:34 DEBUG : doChangeNotify("dir/file2", 1)
2025/05/15 01:27:34 DEBUG : doChangeNotify("dir/file2", 1)
2025/05/15 01:27:34 DEBUG : box root 'rclone-test-menacab4boxi': Received 3 events, resulting in 2 paths and 2 notifications
2025/05/15 01:27:34 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757200957")
2025/05/15 01:27:34 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757201199")
2025/05/15 01:27:34 DEBUG : box root 'rclone-test-menacab4boxi': ["one.rclone_chunk.001_a9nw5a"(0)|file|ITEM_UPLOAD|1862663937492|8849175bec8e39307b7fd0019d0a85dfea9ef96b] new parent not found
2025/05/15 01:27:34 DEBUG : box root 'rclone-test-menacab4boxi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/15 01:27:34 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757201478")
2025/05/15 01:27:35 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757201713")
2025/05/15 01:27:35 DEBUG : box root 'rclone-test-menacab4boxi': ["one"(1)|file|ITEM_RENAME|1862663937492|7c044002e1121d28180b12fbded8fb92b3dfa886] new parent not found
2025/05/15 01:27:35 DEBUG : box root 'rclone-test-menacab4boxi': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/15 01:27:35 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757202477")
2025/05/15 01:27:36 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757202721")
2025/05/15 01:27:37 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757203490")
2025/05/15 01:27:37 DEBUG : box root 'rclone-test-menacab4boxi': ["file4"(1)|file|ITEM_TRASH|1862659809167|317a7cc888ac8851add437d8b7db5009f0ecaade] added old path ("dir/file4") for notify
2025/05/15 01:27:37 DEBUG : box root 'rclone-test-menacab4boxi': ["file1.rclone_chunk.001_a9nzui"(0)|file|ITEM_UPLOAD|1862668582915|e76bdf12b9989419c6654a86e42e9a7d50e5031a] new parent not found
2025/05/15 01:27:37 DEBUG : box root 'rclone-test-menacab4boxi': ["file4.rclone_chunk.001"(2)|file|ITEM_TRASH|1862661668875|ec595130882a1c1988e903cfd283a241f9ce72f5] added old path ("dir/file4.rclone_chunk.001") for notify
2025/05/15 01:27:37 DEBUG : doChangeNotify("dir/file4", 1)
2025/05/15 01:27:37 DEBUG : doChangeNotify("dir/file4", 1)
2025/05/15 01:27:37 DEBUG : box root 'rclone-test-menacab4boxi': Received 3 events, resulting in 2 paths and 2 notifications
2025/05/15 01:27:37 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757204481")
2025/05/15 01:27:38 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757204721")
2025/05/15 01:27:38 DEBUG : box root 'rclone-test-menacab4boxi': ["file4.rclone_chunk.002"(2)|file|ITEM_TRASH|1862664762847|6fd19110acf4733b2f5fe85ef5e8e4379b65adac] added old path ("dir/file4.rclone_chunk.002") for notify
2025/05/15 01:27:38 DEBUG : doChangeNotify("dir/file4", 1)
2025/05/15 01:27:38 DEBUG : box root 'rclone-test-menacab4boxi': Received 2 events, resulting in 1 paths and 1 notifications
2025/05/15 01:27:38 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757205471")
2025/05/15 01:27:39 DEBUG : box root 'rclone-test-menacab4boxi': Checking for changes on remote (next_stream_position: "30401044757205720")
2025/05/15 01:27:40 DEBUG : box root 'rclone-test-menacab4boxi': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/05/15 01:27:40 ERROR : : error listing: directory not found
2025/05/15 01:27:41 DEBUG : box root 'rclone-test-menacab4boxi': Ignoring "Shared folder — ForNick" - unknown type "web_link"
--- FAIL: TestIntegration (78.18s)
    --- FAIL: TestIntegration/FsMkdir (74.26s)
        --- FAIL: TestIntegration/FsMkdir/FsChangeNotify (72.02s)
FAIL
exit status 1
FAIL	github.com/rclone/rclone/backend/chunker	78.230s
"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024 -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Finished ERROR in 1m21.165695947s (try 4/5): exit status 1: Failed [TestIntegration/FsMkdir/FsChangeNotify]