"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024 -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Starting (try 2/5)
=== RUN   TestIntegration
    fstests.go:438: Using remote "TestChunkerChunk50bBox:"
2025/05/07 03:34:12 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-jaticor1levi"
2025/05/07 03:34:12 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/05/07 03:34:12 DEBUG : Creating backend with remote "TestBox:rclone-test-jaticor1levi"
2025/05/07 03:34:13 DEBUG : box root 'rclone-test-jaticor1levi': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/05/07 03:34:15 DEBUG : box root 'rclone-test-jaticor1levi': Ignoring "Shared folder — ForNick" - unknown type "web_link"
=== RUN   TestIntegration/FsMkdir
=== RUN   TestIntegration/FsMkdir/FsChangeNotify
2025/05/07 03:34:16 INFO  : dir: Making directory
2025/05/07 03:34:17 INFO  : dir/subdir1: Making directory
2025/05/07 03:34:18 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073604282")
2025/05/07 03:34:18 INFO  : dir/subdir3: Making directory
2025/05/07 03:34:19 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073605509")
2025/05/07 03:34:19 INFO  : dir/subdir2: Making directory
2025/05/07 03:34:20 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073606510")
2025/05/07 03:34:20 DEBUG : box root 'rclone-test-jaticor1levi': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1854719005358|09901d68e875fe399b167db4e82ace6894422bde] new parent not found
2025/05/07 03:34:20 DEBUG : box root 'rclone-test-jaticor1levi': ["KeyRelative"(1)|file|ITEM_RENAME|1854728730907|4be0909d76a9e8761e4a44bd17ebda3496411591] new parent not found
2025/05/07 03:34:20 DEBUG : box root 'rclone-test-jaticor1levi': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/07 03:34:20 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073607512")
2025/05/07 03:34:21 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073607754")
2025/05/07 03:34:22 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073608515")
2025/05/07 03:34:22 DEBUG : box root 'rclone-test-jaticor1levi': ["file1.txt"(1)|file|ITEM_UPLOAD|1854710422845|5d26d7f24dac3a7d9a8c55fafc2325d7bae47088] new parent not found
2025/05/07 03:34:22 DEBUG : box root 'rclone-test-jaticor1levi': ["dir"(0)|folder|ITEM_CREATE|319982995185|ec17ca1a33c334971f45382b0dd75628a9fef74f] added new path ("dir") for notify
2025/05/07 03:34:22 DEBUG : doChangeNotify("dir", 0)
2025/05/07 03:34:22 DEBUG : box root 'rclone-test-jaticor1levi': Received 3 events, resulting in 1 paths and 1 notifications
2025/05/07 03:34:22 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073609509")
2025/05/07 03:34:23 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073609746")
2025/05/07 03:34:23 DEBUG : box root 'rclone-test-jaticor1levi': ["rclone-test-jaticor1levi"(0)|folder|ITEM_CREATE|319986171747|2ddbf134671200d58dc76180c5a29a50bc377862] new parent not found
2025/05/07 03:34:23 DEBUG : box root 'rclone-test-jaticor1levi': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/07 03:34:23 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073610517")
2025/05/07 03:34:24 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073610762")
2025/05/07 03:34:24 DEBUG : box root 'rclone-test-jaticor1levi': ["subdir1"(0)|folder|ITEM_CREATE|319983719186|315c292b9ead4b98b14ad9fe5e8eddd95917a25f] added new path ("dir/subdir1") for notify
2025/05/07 03:34:24 DEBUG : doChangeNotify("dir/subdir1", 0)
2025/05/07 03:34:24 DEBUG : box root 'rclone-test-jaticor1levi': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/07 03:34:24 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073611512")
2025/05/07 03:34:25 INFO  : dir/file2.rclone_chunk.001_vm79qb: Moved (server-side) to: dir/file2.rclone_chunk.001
2025/05/07 03:34:25 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073611745")
2025/05/07 03:34:25 INFO  : dir/file2.rclone_chunk.002_vm79qb: Moved (server-side) to: dir/file2.rclone_chunk.002
2025/05/07 03:34:25 DEBUG : box root 'rclone-test-jaticor1levi': ["subdir3"(0)|folder|ITEM_CREATE|319982022828|5bafef4a12c4cae43e7bfe3d9bd6bcf273d61e87] added new path ("dir/subdir3") for notify
2025/05/07 03:34:25 DEBUG : doChangeNotify("dir/subdir3", 0)
2025/05/07 03:34:25 DEBUG : box root 'rclone-test-jaticor1levi': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/07 03:34:25 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073612511")
2025/05/07 03:34:26 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073612744")
2025/05/07 03:34:26 DEBUG : box root 'rclone-test-jaticor1levi': ["subdir2"(0)|folder|ITEM_CREATE|319982894148|5848e25b9b886b2241832e39943192696d4fde6c] added new path ("dir/subdir2") for notify
2025/05/07 03:34:26 DEBUG : doChangeNotify("dir/subdir2", 0)
2025/05/07 03:34:26 DEBUG : box root 'rclone-test-jaticor1levi': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/07 03:34:26 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073613512")
2025/05/07 03:34:27 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073613784")
2025/05/07 03:34:27 DEBUG : box root 'rclone-test-jaticor1levi': ["file1.txt"(1)|file|ITEM_RENAME|1854710422845|9cf79482a34d00eaf95b81b65d4e57a26e155a0d] new parent not found
2025/05/07 03:34:27 DEBUG : box root 'rclone-test-jaticor1levi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/07 03:34:27 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073614511")
2025/05/07 03:34:28 DEBUG : box root 'rclone-test-jaticor1levi': ["file2.rclone_chunk.001_vm79qb"(0)|file|ITEM_UPLOAD|1854706324185|e1c204d9ea7c5805faf5ad21407cb32b68ee2f7a] added new path ("dir/file2.rclone_chunk.001_vm79qb") for notify
2025/05/07 03:34:28 DEBUG : doChangeNotify("dir/file2.rclone_chunk.001_vm79qb", 1)
2025/05/07 03:34:28 DEBUG : box root 'rclone-test-jaticor1levi': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/07 03:34:28 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073614751")
2025/05/07 03:34:28 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073614990")
2025/05/07 03:34:29 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073615518")
2025/05/07 03:34:29 DEBUG : box root 'rclone-test-jaticor1levi': ["KeyRelative.rclone_chunk.001_vm79hz"(0)|file|ITEM_UPLOAD|1854725063682|694bbcb7a4df8c9b4bbcf8b0e92ec8a2431f4817] new parent not found
2025/05/07 03:34:29 DEBUG : box root 'rclone-test-jaticor1levi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/07 03:34:29 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073616516")
2025/05/07 03:34:30 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073616745")
2025/05/07 03:34:30 DEBUG : box root 'rclone-test-jaticor1levi': ["file2.rclone_chunk.002_vm79qb"(0)|file|ITEM_UPLOAD|1854737478359|dd0af679dd39582edf2e1a35f562c3286f30ad36] ignored due to old SequenceID ('\x01')
2025/05/07 03:34:30 DEBUG : box root 'rclone-test-jaticor1levi': ["KeyRelative"(1)|file|ITEM_RENAME|1854725063682|b1bbf989d2e14da3a2bd26401916771e07dff102] new parent not found
2025/05/07 03:34:30 DEBUG : box root 'rclone-test-jaticor1levi': Received 3 events, resulting in 0 paths and 0 notifications
2025/05/07 03:34:30 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073617510")
2025/05/07 03:34:31 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073617750")
2025/05/07 03:34:31 DEBUG : box root 'rclone-test-jaticor1levi': ["file2.rclone_chunk.001"(1)|file|ITEM_RENAME|1854706324185|ac79222a9d68a1960e547b41d99389063ed5cead] ignored due to old SequenceID ('\x01')
2025/05/07 03:34:31 DEBUG : box root 'rclone-test-jaticor1levi': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1854737478359|927bc28eced36ff2b698737c06b18cd39faa6a56] ignored due to old SequenceID ('\x01')
2025/05/07 03:34:31 DEBUG : box root 'rclone-test-jaticor1levi': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/07 03:34:31 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073618522")
2025/05/07 03:34:32 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073618765")
2025/05/07 03:34:32 DEBUG : box root 'rclone-test-jaticor1levi': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1854737190879|204826afcca407d0307b2cdf29bb547ca841d5a5] new parent not found
2025/05/07 03:34:32 DEBUG : box root 'rclone-test-jaticor1levi': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/07 03:34:32 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073619521")
2025/05/07 03:34:33 DEBUG : box root 'rclone-test-jaticor1levi': ["file1.txt.dinosaur1"(2)|file|ITEM_RENAME|1854710422845|60c0b10c3fa83998588a6b96ab9b29456d8da961] new parent not found
2025/05/07 03:34:33 DEBUG : box root 'rclone-test-jaticor1levi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/07 03:34:33 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073619793")
2025/05/07 03:34:33 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073620029")
2025/05/07 03:34:33 DEBUG : box root 'rclone-test-jaticor1levi': ["file2"(0)|file|ITEM_UPLOAD|1854733761263|0dc703b2fd4885f7e459b59cff2b28578be71dbf] ignored due to old SequenceID ('\x00')
2025/05/07 03:34:33 DEBUG : box root 'rclone-test-jaticor1levi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/07 03:34:33 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073620520")
2025/05/07 03:34:33 INFO  : dir/file4.rclone_chunk.001_vm7hmr: Moved (server-side) to: dir/file4.rclone_chunk.001
2025/05/07 03:34:34 INFO  : dir/file4.rclone_chunk.002_vm7hmr: Moved (server-side) to: dir/file4.rclone_chunk.002
2025/05/07 03:34:34 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073620754")
2025/05/07 03:34:34 DEBUG : box root 'rclone-test-jaticor1levi': ["file1.txt"(0)|file|ITEM_UPLOAD|1854734703895|4d4ae115317b633511c59a5b19961cefa2ade1dd] new parent not found
2025/05/07 03:34:34 DEBUG : box root 'rclone-test-jaticor1levi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/07 03:34:34 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073621528")
2025/05/07 03:34:35 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073621756")
2025/05/07 03:34:36 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073622513")
2025/05/07 03:34:37 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073623513")
2025/05/07 03:34:38 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073624515")
2025/05/07 03:34:38 DEBUG : box root 'rclone-test-jaticor1levi': ["file4.rclone_chunk.002_vm7hmr"(0)|file|ITEM_UPLOAD|1854735602013|18709ff7380281c05ca23bd1558900d9d933e975] ignored due to old SequenceID ('\x01')
2025/05/07 03:34:38 DEBUG : box root 'rclone-test-jaticor1levi': ["file4.rclone_chunk.001_vm7hmr"(0)|file|ITEM_UPLOAD|1854733802063|d529b171891dfffe1fe155da2d7ff70476ad8c4e] ignored due to old SequenceID ('\x01')
2025/05/07 03:34:38 DEBUG : box root 'rclone-test-jaticor1levi': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/07 03:34:38 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073625515")
2025/05/07 03:34:39 DEBUG : box root 'rclone-test-jaticor1levi': ["KeyAbsolute.rclone_chunk.001_vm7kk0"(0)|file|ITEM_UPLOAD|1854692430642|9701f76907df7b9c4726dc53d207e8e6c056399f] new parent not found
2025/05/07 03:34:39 DEBUG : box root 'rclone-test-jaticor1levi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/07 03:34:39 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073625762")
2025/05/07 03:34:39 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073625998")
2025/05/07 03:34:39 DEBUG : box root 'rclone-test-jaticor1levi': ["file1.txt"(1)|file|ITEM_UPLOAD|1854734703895|0919ab01cc4fdff5fecc2751468cf31109c1d7e5] new parent not found
2025/05/07 03:34:39 DEBUG : box root 'rclone-test-jaticor1levi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/07 03:34:39 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073626512")
2025/05/07 03:34:39 DEBUG : box root 'rclone-test-jaticor1levi': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1854733802063|440e06d1dc9a93378fcd2c93bb1e644bc53e110c] ignored due to old SequenceID ('\x01')
2025/05/07 03:34:39 DEBUG : box root 'rclone-test-jaticor1levi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/07 03:34:39 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073626744")
2025/05/07 03:34:40 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073626978")
2025/05/07 03:34:40 DEBUG : box root 'rclone-test-jaticor1levi': ["file4.rclone_chunk.002"(1)|file|ITEM_RENAME|1854735602013|c021fafd27a2497f68c007794a3ceb5e91e0f17b] ignored due to old SequenceID ('\x01')
2025/05/07 03:34:40 DEBUG : box root 'rclone-test-jaticor1levi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/07 03:34:40 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073627515")
2025/05/07 03:34:41 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073627763")
2025/05/07 03:34:41 INFO  : dir/file3.rclone_chunk.001_vm7q5w: Moved (server-side) to: dir/file3.rclone_chunk.001
2025/05/07 03:34:42 INFO  : dir/file3.rclone_chunk.002_vm7q5w: Moved (server-side) to: dir/file3.rclone_chunk.002
2025/05/07 03:34:42 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073628508")
2025/05/07 03:34:42 DEBUG : box root 'rclone-test-jaticor1levi': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1854735788909|1aa7e1cdde4a2a898e6620bbd525e85d8b1e9ffa] new parent not found
2025/05/07 03:34:42 DEBUG : box root 'rclone-test-jaticor1levi': ["KeyAbsolute"(1)|file|ITEM_RENAME|1854692430642|8fe6bddbda91c89ceec7ddb4ed6e24d43316fa81] new parent not found
2025/05/07 03:34:42 DEBUG : box root 'rclone-test-jaticor1levi': ["file4"(0)|file|ITEM_UPLOAD|1854712367430|2359feb3b45b2db366671b53574db37d97df4654] ignored due to old SequenceID ('\x00')
2025/05/07 03:34:42 DEBUG : box root 'rclone-test-jaticor1levi': Received 3 events, resulting in 0 paths and 0 notifications
2025/05/07 03:34:42 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073629514")
2025/05/07 03:34:43 DEBUG : box root 'rclone-test-jaticor1levi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/07 03:34:43 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073629783")
2025/05/07 03:34:43 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073630021")
2025/05/07 03:34:44 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073630509")
    fstests.go:931: Try 1/10 waiting for dirChanges and objChanges
2025/05/07 03:34:44 DEBUG : box root 'rclone-test-jaticor1levi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/07 03:34:44 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073631512")
2025/05/07 03:34:45 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073631745")
2025/05/07 03:34:45 DEBUG : box root 'rclone-test-jaticor1levi': ["file3.rclone_chunk.001_vm7q5w"(0)|file|ITEM_UPLOAD|1854737800126|3934965af6fa608022ca2659bbc03ea90c02215f] ignored due to old SequenceID ('\x01')
2025/05/07 03:34:45 DEBUG : box root 'rclone-test-jaticor1levi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/07 03:34:45 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073632508")
2025/05/07 03:34:45 DEBUG : box root 'rclone-test-jaticor1levi': ["file1.txt.apple1"(2)|file|ITEM_RENAME|1854734703895|600fd7f62d6f31509c57c30fc505c7937ce34757] new parent not found
2025/05/07 03:34:45 DEBUG : box root 'rclone-test-jaticor1levi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/07 03:34:45 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073632742")
2025/05/07 03:34:46 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073632978")
2025/05/07 03:34:47 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073633520")
    fstests.go:931: Try 2/10 waiting for dirChanges and objChanges
2025/05/07 03:34:47 DEBUG : box root 'rclone-test-jaticor1levi': ["file1.txt.apple2"(0)|file|ITEM_UPLOAD|1854717537288|27280550f8d46ae4619a5d8938c4b40c6d69308b] new parent not found
2025/05/07 03:34:47 DEBUG : box root 'rclone-test-jaticor1levi': ["file3.rclone_chunk.002_vm7q5w"(0)|file|ITEM_UPLOAD|1854737691760|5ac43a97e359fd6d9e99ac5497b7ec8a7a17d1d9] ignored due to old SequenceID ('\x01')
2025/05/07 03:34:47 DEBUG : box root 'rclone-test-jaticor1levi': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/07 03:34:47 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073634513")
2025/05/07 03:34:48 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073634758")
2025/05/07 03:34:48 DEBUG : box root 'rclone-test-jaticor1levi': ["foo.rclone_chunk.001_vm7tuu"(0)|file|ITEM_UPLOAD|1854709103592|1f329dd538af0947df9cbb94a9b01193deb8beec] new parent not found
2025/05/07 03:34:48 DEBUG : box root 'rclone-test-jaticor1levi': ["file3.rclone_chunk.002"(1)|file|ITEM_RENAME|1854737691760|72432dcdf0b3d6c1800832e9bf9f552a9d4dcbaa] ignored due to old SequenceID ('\x01')
2025/05/07 03:34:48 DEBUG : box root 'rclone-test-jaticor1levi': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/07 03:34:48 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073635516")
2025/05/07 03:34:49 DEBUG : box root 'rclone-test-jaticor1levi': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1854737800126|de105e5ba458c2af1de564c547ab74d0818efaf9] ignored due to old SequenceID ('\x01')
2025/05/07 03:34:49 DEBUG : box root 'rclone-test-jaticor1levi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/07 03:34:49 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073635755")
2025/05/07 03:34:49 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073635993")
2025/05/07 03:34:50 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073636512")
    fstests.go:931: Try 3/10 waiting for dirChanges and objChanges
2025/05/07 03:34:50 DEBUG : box root 'rclone-test-jaticor1levi': ["file3"(0)|file|ITEM_UPLOAD|1854736732628|47e696158921446751b010a5b9d96a89e1f175a0] ignored due to old SequenceID ('\x00')
2025/05/07 03:34:50 DEBUG : box root 'rclone-test-jaticor1levi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/07 03:34:50 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073637516")
2025/05/07 03:34:51 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073637753")
2025/05/07 03:34:52 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073638515")
2025/05/07 03:34:52 DEBUG : box root 'rclone-test-jaticor1levi': ["foo"(1)|file|ITEM_RENAME|1854709103592|48da1c2cd1b3c46d63f6cfea35508447a528fedb] new parent not found
2025/05/07 03:34:52 DEBUG : box root 'rclone-test-jaticor1levi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/07 03:34:52 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073639508")
2025/05/07 03:34:53 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073639741")
    fstests.go:931: Try 4/10 waiting for dirChanges and objChanges
2025/05/07 03:34:54 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073640515")
2025/05/07 03:34:54 DEBUG : box root 'rclone-test-jaticor1levi': ["file1.txt"(0)|file|ITEM_UPLOAD|1854736730382|02116325db20ee71e54f58256821e3ff0a2a8358] new parent not found
2025/05/07 03:34:54 DEBUG : box root 'rclone-test-jaticor1levi': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1854737658284|b255407b66f767c38fbd743956e8179385a5342f] new parent not found
2025/05/07 03:34:54 DEBUG : box root 'rclone-test-jaticor1levi': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/07 03:34:54 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073641511")
2025/05/07 03:34:55 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073641756")
2025/05/07 03:34:55 DEBUG : box root 'rclone-test-jaticor1levi': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/07 03:34:55 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073642515")
2025/05/07 03:34:56 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073642757")
    fstests.go:931: Try 5/10 waiting for dirChanges and objChanges
2025/05/07 03:34:57 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073643531")
2025/05/07 03:34:57 DEBUG : box root 'rclone-test-jaticor1levi': ["SHA256E-s1048576--7ba87e06b9b7903cfbaf4a38736766c161e3e7b42f06fe57f040aa410a8f0701.this-is-a-test-key.rclone_chunk.001_vm821q"(0)|file|ITEM_UPLOAD|1854737769492|1806e536400d241c38ee3e73a48a865989060164] new parent not found
2025/05/07 03:34:57 DEBUG : box root 'rclone-test-jaticor1levi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/07 03:34:57 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073644514")
2025/05/07 03:34:58 DEBUG : box root 'rclone-test-jaticor1levi': ["file1.txt.cloud1"(1)|file|ITEM_RENAME|1854736730382|cb9d4210117bbaa502f7b90984fde13a0e0cf5a5] new parent not found
2025/05/07 03:34:58 DEBUG : box root 'rclone-test-jaticor1levi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/07 03:34:58 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073644748")
2025/05/07 03:34:58 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073644986")
2025/05/07 03:34:59 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073645512")
    fstests.go:931: Try 6/10 waiting for dirChanges and objChanges
2025/05/07 03:34:59 DEBUG : box root 'rclone-test-jaticor1levi': ["SHA256E-s1048576--7ba87e06b9b7903cfbaf4a38736766c161e3e7b42f06fe57f040aa410a8f0701.this-is-a-test-key"(1)|file|ITEM_RENAME|1854737769492|7f98c520a031134f1d82def43f801ee63e01ec72] new parent not found
2025/05/07 03:34:59 DEBUG : box root 'rclone-test-jaticor1levi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/07 03:34:59 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073646509")
2025/05/07 03:34:59 DEBUG : box root 'rclone-test-jaticor1levi': ["file1.txt.local1"(0)|file|ITEM_UPLOAD|1854723500939|87b5987aeee7edfbd0638ac2ad73f1de163f2e5b] new parent not found
2025/05/07 03:34:59 DEBUG : box root 'rclone-test-jaticor1levi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/07 03:34:59 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073646745")
2025/05/07 03:35:00 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073646984")
2025/05/07 03:35:01 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073647516")
2025/05/07 03:35:02 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073648517")
    fstests.go:931: Try 7/10 waiting for dirChanges and objChanges
2025/05/07 03:35:02 DEBUG : box root 'rclone-test-jaticor1levi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/07 03:35:02 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073649517")
2025/05/07 03:35:03 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073649763")
2025/05/07 03:35:04 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073650509")
2025/05/07 03:35:05 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073651515")
    fstests.go:931: Try 8/10 waiting for dirChanges and objChanges
2025/05/07 03:35:05 DEBUG : box root 'rclone-test-jaticor1levi': ["file1.txt"(0)|file|ITEM_UPLOAD|1854709088696|b8dad181b607e55549dcb1300e287363a1cf1aba] new parent not found
2025/05/07 03:35:05 DEBUG : box root 'rclone-test-jaticor1levi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/07 03:35:05 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073652514")
2025/05/07 03:35:06 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073652750")
2025/05/07 03:35:07 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073653521")
2025/05/07 03:35:07 DEBUG : box root 'rclone-test-jaticor1levi': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1854738476764|0aee94665b75ff9d937b3e6ee7fb79136a28400d] new parent not found
2025/05/07 03:35:07 DEBUG : box root 'rclone-test-jaticor1levi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/07 03:35:07 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073654512")
2025/05/07 03:35:08 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073654741")
    fstests.go:931: Try 9/10 waiting for dirChanges and objChanges
2025/05/07 03:35:09 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073655512")
2025/05/07 03:35:10 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073656517")
2025/05/07 03:35:10 DEBUG : box root 'rclone-test-jaticor1levi': ["SomeKey.rclone_chunk.001_vm8epp"(0)|file|ITEM_UPLOAD|1854728509966|b0ba22c35499ade4d91171ec2baf761bc8275cd7] new parent not found
2025/05/07 03:35:10 DEBUG : box root 'rclone-test-jaticor1levi': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/07 03:35:10 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073657512")
2025/05/07 03:35:11 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073657754")
    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_vm79qb:{}] does not contain [dir/file2 dir/file4 dir/file3]
2025/05/07 03:35:11 DEBUG : box root 'rclone-test-jaticor1levi': ["file1.txt..path1"(1)|file|ITEM_RENAME|1854709088696|51a18ffdcd13dc8212a852aaff3a8bfba31a5baf] new parent not found
2025/05/07 03:35:11 DEBUG : box root 'rclone-test-jaticor1levi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/07 03:35:11 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073658514")
2025/05/07 03:35:12 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073658747")
2025/05/07 03:35:12 DEBUG : box root 'rclone-test-jaticor1levi': ["file1.txt..path2"(0)|file|ITEM_UPLOAD|1854733658300|4b1082306ca050e1b71b5e203b2b64302c738911] new parent not found
2025/05/07 03:35:12 DEBUG : box root 'rclone-test-jaticor1levi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/07 03:35:12 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073659509")
2025/05/07 03:35:13 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073659750")
2025/05/07 03:35:13 DEBUG : box root 'rclone-test-jaticor1levi': ["SomeKey"(1)|file|ITEM_RENAME|1854728509966|d99c6b6c6325cb9ff1733161d2e7d2d1fb76d1e1] new parent not found
2025/05/07 03:35:13 DEBUG : box root 'rclone-test-jaticor1levi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/07 03:35:13 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073660515")
2025/05/07 03:35:14 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073660751")
2025/05/07 03:35:15 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073661514")
2025/05/07 03:35:16 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073662516")
2025/05/07 03:35:16 DEBUG : box root 'rclone-test-jaticor1levi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/07 03:35:16 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073663515")
2025/05/07 03:35:17 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073663753")
2025/05/07 03:35:18 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073664522")
2025/05/07 03:35:19 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073665512")
2025/05/07 03:35:19 DEBUG : box root 'rclone-test-jaticor1levi': ["SomeKey.rclone_chunk.001_vm8owk"(0)|file|ITEM_UPLOAD|1854729301227|3bccd88f42a3ccbd7d3b34816c745940f80adc8a] new parent not found
2025/05/07 03:35:19 DEBUG : box root 'rclone-test-jaticor1levi': ["file2"(1)|file|ITEM_TRASH|1854733761263|9811af9c55e28f1579682bb83747d7e2439c3340] added old path ("dir/file2") for notify
2025/05/07 03:35:19 DEBUG : doChangeNotify("dir/file2", 1)
2025/05/07 03:35:19 DEBUG : box root 'rclone-test-jaticor1levi': Received 2 events, resulting in 1 paths and 1 notifications
2025/05/07 03:35:19 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073666514")
2025/05/07 03:35:20 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073666760")
2025/05/07 03:35:20 DEBUG : box root 'rclone-test-jaticor1levi': ["SomeKey"(1)|file|ITEM_RENAME|1854729301227|951ad191e4dccc21c3134effe7bc8566e303dc30] new parent not found
2025/05/07 03:35:20 DEBUG : box root 'rclone-test-jaticor1levi': ["file2.txt"(1)|file|ITEM_UPLOAD|1854733934023|3a30251e19c93ed8a55ccde442876bf5133d0bd1] new parent not found
2025/05/07 03:35:20 DEBUG : box root 'rclone-test-jaticor1levi': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/07 03:35:20 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073667523")
2025/05/07 03:35:21 DEBUG : box root 'rclone-test-jaticor1levi': ["file2.rclone_chunk.002"(2)|file|ITEM_TRASH|1854737478359|b8ec82297d8f6b77c14626cf6f781c90d44ae189] added old path ("dir/file2.rclone_chunk.002") for notify
2025/05/07 03:35:21 DEBUG : doChangeNotify("dir/file2", 1)
2025/05/07 03:35:21 DEBUG : box root 'rclone-test-jaticor1levi': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/07 03:35:21 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073667766")
2025/05/07 03:35:21 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073668003")
2025/05/07 03:35:22 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073668510")
2025/05/07 03:35:22 DEBUG : box root 'rclone-test-jaticor1levi': ["file1.txt"(0)|file|ITEM_UPLOAD|1854709149276|178c61fe4572a974e25ef0fae1a8f34bafba1eb3] new parent not found
2025/05/07 03:35:22 DEBUG : box root 'rclone-test-jaticor1levi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/07 03:35:22 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073669513")
2025/05/07 03:35:23 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073669750")
2025/05/07 03:35:23 DEBUG : box root 'rclone-test-jaticor1levi': ["file4"(1)|file|ITEM_TRASH|1854712367430|490648cd8baa18f6a2154011d6ac8f2320c41d1e] added old path ("dir/file4") for notify
2025/05/07 03:35:23 DEBUG : doChangeNotify("dir/file4", 1)
2025/05/07 03:35:23 DEBUG : box root 'rclone-test-jaticor1levi': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/07 03:35:23 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073670514")
2025/05/07 03:35:24 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073670750")
2025/05/07 03:35:24 DEBUG : box root 'rclone-test-jaticor1levi': ["file4.rclone_chunk.001"(2)|file|ITEM_TRASH|1854733802063|98d8ac45ff1023228e42ce9a5ac1aff624097a88] added old path ("dir/file4.rclone_chunk.001") for notify
2025/05/07 03:35:24 DEBUG : box root 'rclone-test-jaticor1levi': ["file2.rclone_chunk.001"(2)|file|ITEM_TRASH|1854706324185|dee2e970dd060f69537a856fe56b8170c0738dfc] added old path ("dir/file2.rclone_chunk.001") for notify
2025/05/07 03:35:24 DEBUG : doChangeNotify("dir/file4", 1)
2025/05/07 03:35:24 DEBUG : doChangeNotify("dir/file2", 1)
2025/05/07 03:35:24 DEBUG : box root 'rclone-test-jaticor1levi': Received 2 events, resulting in 2 paths and 2 notifications
2025/05/07 03:35:24 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073671513")
2025/05/07 03:35:25 DEBUG : box root 'rclone-test-jaticor1levi': Checking for changes on remote (next_stream_position: "30401044073671750")
2025/05/07 03:35:27 DEBUG : box root 'rclone-test-jaticor1levi': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/05/07 03:35:27 ERROR : : error listing: directory not found
2025/05/07 03:35:27 DEBUG : box root 'rclone-test-jaticor1levi': Ignoring "Shared folder — ForNick" - unknown type "web_link"
--- FAIL: TestIntegration (75.41s)
    --- FAIL: TestIntegration/FsMkdir (71.95s)
        --- FAIL: TestIntegration/FsMkdir/FsChangeNotify (69.75s)
FAIL
exit status 1
FAIL	github.com/rclone/rclone/backend/chunker	75.455s
"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024 -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Finished ERROR in 1m18.005353493s (try 2/5): exit status 1: Failed [TestIntegration/FsMkdir/FsChangeNotify]