"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024 -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Starting (try 3/5)
=== RUN   TestIntegration
    fstests.go:438: Using remote "TestChunkerChunk50bBox:"
2025/05/07 03:35:33 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-bazaneq0juyi"
2025/05/07 03:35:33 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/05/07 03:35:33 DEBUG : Creating backend with remote "TestBox:rclone-test-bazaneq0juyi"
2025/05/07 03:35:34 DEBUG : box root 'rclone-test-bazaneq0juyi': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/05/07 03:35:35 DEBUG : box root 'rclone-test-bazaneq0juyi': Ignoring "Shared folder — ForNick" - unknown type "web_link"
=== RUN   TestIntegration/FsMkdir
=== RUN   TestIntegration/FsMkdir/FsChangeNotify
2025/05/07 03:35:36 INFO  : dir: Making directory
2025/05/07 03:35:37 INFO  : dir/subdir1: Making directory
2025/05/07 03:35:38 INFO  : dir/subdir3: Making directory
2025/05/07 03:35:38 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073684604")
2025/05/07 03:35:39 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073685828")
2025/05/07 03:35:40 INFO  : dir/subdir2: Making directory
2025/05/07 03:35:40 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073686829")
2025/05/07 03:35:41 DEBUG : box root 'rclone-test-bazaneq0juyi': ["rclone-test-bazaneq0juyi"(0)|folder|ITEM_CREATE|319986604166|8792f6993a69938674b7818473b317c7e6179245] new parent not found
2025/05/07 03:35:41 DEBUG : box root 'rclone-test-bazaneq0juyi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/07 03:35:41 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073687838")
2025/05/07 03:35:41 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073688068")
2025/05/07 03:35:42 DEBUG : box root 'rclone-test-bazaneq0juyi': ["resync"(0)|folder|ITEM_CREATE|319983718930|1244ba80dd88a01ba9e5bcd7cd3bfac067a4b257] new parent not found
2025/05/07 03:35:42 DEBUG : box root 'rclone-test-bazaneq0juyi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/07 03:35:42 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073688827")
2025/05/07 03:35:42 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073689056")
2025/05/07 03:35:43 DEBUG : box root 'rclone-test-bazaneq0juyi': ["path1"(0)|folder|ITEM_CREATE|319987263662|dcc2c87954b1a67e84913a59d04c7b7893004b88] new parent not found
2025/05/07 03:35:43 DEBUG : box root 'rclone-test-bazaneq0juyi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/07 03:35:43 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073689827")
2025/05/07 03:35:43 DEBUG : box root 'rclone-test-bazaneq0juyi': ["dir"(0)|folder|ITEM_CREATE|319987309935|f689516364ce37a9d1d181233be05fbb677c4c95] added new path ("dir") for notify
2025/05/07 03:35:43 DEBUG : doChangeNotify("dir", 0)
2025/05/07 03:35:43 DEBUG : box root 'rclone-test-bazaneq0juyi': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/07 03:35:43 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073690057")
2025/05/07 03:35:43 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073690287")
2025/05/07 03:35:44 DEBUG : box root 'rclone-test-bazaneq0juyi': ["file4.txt"(0)|file|ITEM_UPLOAD|1854739086076|45641f3b456e69517646af841b454076e8dd3aee] new parent not found
2025/05/07 03:35:44 DEBUG : box root 'rclone-test-bazaneq0juyi': ["file1.txt"(0)|file|ITEM_UPLOAD|1854730801851|90f6d7b04f4f49a345c6973567996d8aafcbf321] new parent not found
2025/05/07 03:35:44 DEBUG : box root 'rclone-test-bazaneq0juyi': ["file3.txt"(0)|file|ITEM_UPLOAD|1854738611280|494143fbdcb95846240095befc5c3b98034af9cd] new parent not found
2025/05/07 03:35:44 DEBUG : box root 'rclone-test-bazaneq0juyi': ["file2.txt"(0)|file|ITEM_UPLOAD|1854730353286|fa6ec164da8336e3453f23b0e523dc2844c3006a] new parent not found
2025/05/07 03:35:44 DEBUG : box root 'rclone-test-bazaneq0juyi': Received 4 events, resulting in 0 paths and 0 notifications
2025/05/07 03:35:44 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073690823")
2025/05/07 03:35:44 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073691067")
2025/05/07 03:35:45 DEBUG : box root 'rclone-test-bazaneq0juyi': ["subdir1"(0)|folder|ITEM_CREATE|319984180759|a67ddf2fc31d4110d33a4567a420b6d903f1fea4] added new path ("dir/subdir1") for notify
2025/05/07 03:35:45 DEBUG : doChangeNotify("dir/subdir1", 0)
2025/05/07 03:35:45 DEBUG : box root 'rclone-test-bazaneq0juyi': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/07 03:35:45 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073691830")
2025/05/07 03:35:45 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073692056")
2025/05/07 03:35:46 INFO  : dir/file2.rclone_chunk.001_vm9ir5: Moved (server-side) to: dir/file2.rclone_chunk.001
2025/05/07 03:35:46 DEBUG : box root 'rclone-test-bazaneq0juyi': ["file6.txt"(0)|file|ITEM_UPLOAD|1854705983559|45fd4cc0bc181a336bb2a1abb7a7375866f04241] new parent not found
2025/05/07 03:35:46 DEBUG : box root 'rclone-test-bazaneq0juyi': ["file5.txt"(0)|file|ITEM_UPLOAD|1854706722041|8bd59c03a6b5e7468ca88ae9dd6b9f2b910a2527] new parent not found
2025/05/07 03:35:46 DEBUG : box root 'rclone-test-bazaneq0juyi': ["RCLONE_TEST"(0)|file|ITEM_UPLOAD|1854734778652|ef5120c86d204a4a77090b25a8ad2835a6887d5b] new parent not found
2025/05/07 03:35:46 DEBUG : box root 'rclone-test-bazaneq0juyi': Received 3 events, resulting in 0 paths and 0 notifications
2025/05/07 03:35:46 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073692827")
2025/05/07 03:35:46 DEBUG : box root 'rclone-test-bazaneq0juyi': ["file7.txt"(0)|file|ITEM_UPLOAD|1854738510099|849f79aea6a3da40e310b7d8cf7ed0790ddcc396] new parent not found
2025/05/07 03:35:46 DEBUG : box root 'rclone-test-bazaneq0juyi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/07 03:35:46 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073693063")
2025/05/07 03:35:46 INFO  : dir/file2.rclone_chunk.002_vm9ir5: Moved (server-side) to: dir/file2.rclone_chunk.002
2025/05/07 03:35:46 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073693291")
2025/05/07 03:35:47 DEBUG : box root 'rclone-test-bazaneq0juyi': ["subdir3"(0)|folder|ITEM_CREATE|319984199408|b51e2f9f30bce8aa4712ee1e7b97800e996d5a5b] added new path ("dir/subdir3") for notify
2025/05/07 03:35:47 DEBUG : doChangeNotify("dir/subdir3", 0)
2025/05/07 03:35:47 DEBUG : box root 'rclone-test-bazaneq0juyi': Received 2 events, resulting in 1 paths and 1 notifications
2025/05/07 03:35:47 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073693825")
2025/05/07 03:35:47 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073694056")
2025/05/07 03:35:48 DEBUG : box root 'rclone-test-bazaneq0juyi': ["subdir2"(0)|folder|ITEM_CREATE|319981141226|18b73ee3330f72cf349d115b7e71f84680116b70] added new path ("dir/subdir2") for notify
2025/05/07 03:35:48 DEBUG : doChangeNotify("dir/subdir2", 0)
2025/05/07 03:35:48 DEBUG : box root 'rclone-test-bazaneq0juyi': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/07 03:35:48 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073694824")
2025/05/07 03:35:48 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073695053")
2025/05/07 03:35:49 DEBUG : box root 'rclone-test-bazaneq0juyi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/07 03:35:49 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073695834")
2025/05/07 03:35:49 DEBUG : box root 'rclone-test-bazaneq0juyi': ["file2.rclone_chunk.001_vm9ir5"(0)|file|ITEM_UPLOAD|1854720546501|f9031efbfa7733057249c78c5d542e60428cd66c] ignored due to old SequenceID ('\x01')
2025/05/07 03:35:49 DEBUG : box root 'rclone-test-bazaneq0juyi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/07 03:35:49 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073696056")
2025/05/07 03:35:49 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073696289")
2025/05/07 03:35:50 DEBUG : box root 'rclone-test-bazaneq0juyi': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/07 03:35:50 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073696836")
2025/05/07 03:35:50 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073697068")
2025/05/07 03:35:51 DEBUG : box root 'rclone-test-bazaneq0juyi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/07 03:35:51 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073697827")
2025/05/07 03:35:51 DEBUG : box root 'rclone-test-bazaneq0juyi': ["file2.rclone_chunk.002_vm9ir5"(0)|file|ITEM_UPLOAD|1854738567699|192056683809e076cc1f781b1f0e19b92317181f] ignored due to old SequenceID ('\x01')
2025/05/07 03:35:51 DEBUG : box root 'rclone-test-bazaneq0juyi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/07 03:35:51 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073698054")
2025/05/07 03:35:51 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073698285")
2025/05/07 03:35:52 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073698828")
2025/05/07 03:35:53 DEBUG : box root 'rclone-test-bazaneq0juyi': ["file2.rclone_chunk.001"(1)|file|ITEM_RENAME|1854720546501|e3ad28a46cb378baa1a48a072ff89d86e6d21335] ignored due to old SequenceID ('\x01')
2025/05/07 03:35:53 DEBUG : box root 'rclone-test-bazaneq0juyi': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1854738567699|ba18f8e01a001527380391a0a36867e43557d7e5] ignored due to old SequenceID ('\x01')
2025/05/07 03:35:53 DEBUG : box root 'rclone-test-bazaneq0juyi': Received 3 events, resulting in 0 paths and 0 notifications
2025/05/07 03:35:53 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073699827")
2025/05/07 03:35:53 INFO  : dir/file4.rclone_chunk.001_vm9q2i: Moved (server-side) to: dir/file4.rclone_chunk.001
2025/05/07 03:35:53 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073700063")
2025/05/07 03:35:54 DEBUG : box root 'rclone-test-bazaneq0juyi': ["file2"(0)|file|ITEM_UPLOAD|1854729858569|bbc9d9f4864cd8fe531157619db6bceed1e64cc8] ignored due to old SequenceID ('\x00')
2025/05/07 03:35:54 DEBUG : box root 'rclone-test-bazaneq0juyi': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/07 03:35:54 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073700831")
2025/05/07 03:35:54 INFO  : dir/file4.rclone_chunk.002_vm9q2i: Moved (server-side) to: dir/file4.rclone_chunk.002
2025/05/07 03:35:54 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073701067")
2025/05/07 03:35:55 DEBUG : box root 'rclone-test-bazaneq0juyi': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/07 03:35:55 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073701827")
2025/05/07 03:35:55 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073702062")
2025/05/07 03:35:56 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073702827")
2025/05/07 03:35:57 DEBUG : box root 'rclone-test-bazaneq0juyi': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1854729427048|a426184cd5eb88e699410997f14e66f1216609ac] new parent not found
2025/05/07 03:35:57 DEBUG : box root 'rclone-test-bazaneq0juyi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/07 03:35:57 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073703825")
2025/05/07 03:35:57 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073704054")
2025/05/07 03:35:58 DEBUG : box root 'rclone-test-bazaneq0juyi': ["file4.rclone_chunk.001_vm9q2i"(0)|file|ITEM_UPLOAD|1854738772531|ad32d2062550b8c7f462cadefb2cf4aa5b27035c] ignored due to old SequenceID ('\x01')
2025/05/07 03:35:58 DEBUG : box root 'rclone-test-bazaneq0juyi': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/07 03:35:58 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073704836")
2025/05/07 03:35:58 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073705067")
2025/05/07 03:35:59 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073705827")
2025/05/07 03:36:00 DEBUG : box root 'rclone-test-bazaneq0juyi': ["file4.rclone_chunk.002_vm9q2i"(0)|file|ITEM_UPLOAD|1854738299159|d667e215292ce531d234017c303812370c1d5a82] ignored due to old SequenceID ('\x01')
2025/05/07 03:36:00 DEBUG : box root 'rclone-test-bazaneq0juyi': ["file4.txt"(0)|file|ITEM_UPLOAD|1854736242240|30b37b780d51e9b49650bf57601e8ef19a04b794] new parent not found
2025/05/07 03:36:00 DEBUG : box root 'rclone-test-bazaneq0juyi': ["file3.txt"(0)|file|ITEM_UPLOAD|1854734987053|4ff7c84df14fa6d3875e1630ae03f62801f42c9a] new parent not found
2025/05/07 03:36:00 DEBUG : box root 'rclone-test-bazaneq0juyi': ["file1.txt"(0)|file|ITEM_UPLOAD|1854728656387|adcce2a0def85aea3479ad11273c96f88709b67a] new parent not found
2025/05/07 03:36:00 DEBUG : box root 'rclone-test-bazaneq0juyi': Received 4 events, resulting in 0 paths and 0 notifications
2025/05/07 03:36:00 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073706925")
2025/05/07 03:36:00 DEBUG : box root 'rclone-test-bazaneq0juyi': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1854738772531|c46e5963cedaa6d974899904d417f6857bcae37b] ignored due to old SequenceID ('\x01')
2025/05/07 03:36:00 DEBUG : box root 'rclone-test-bazaneq0juyi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/07 03:36:00 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073707171")
2025/05/07 03:36:00 DEBUG : box root 'rclone-test-bazaneq0juyi': ["file4.rclone_chunk.002"(1)|file|ITEM_RENAME|1854738299159|7df8708b1e9789460d931a0e893afd7498834319] ignored due to old SequenceID ('\x01')
2025/05/07 03:36:00 DEBUG : box root 'rclone-test-bazaneq0juyi': ["file2.txt"(0)|file|ITEM_UPLOAD|1854738428435|021bc07917f07e13716f23f43edf9de3de77bea0] new parent not found
2025/05/07 03:36:00 DEBUG : box root 'rclone-test-bazaneq0juyi': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/07 03:36:00 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073707403")
2025/05/07 03:36:00 DEBUG : box root 'rclone-test-bazaneq0juyi': ["RCLONE_TEST"(0)|file|ITEM_UPLOAD|1854730146088|a03a245bd21f910f896179baed3a42c1a6c806c4] new parent not found
2025/05/07 03:36:00 DEBUG : box root 'rclone-test-bazaneq0juyi': ["file6.txt"(0)|file|ITEM_UPLOAD|1854709077253|3024cd24c31b3e5f39d8bbcfd7552561e59f876c] new parent not found
2025/05/07 03:36:00 DEBUG : box root 'rclone-test-bazaneq0juyi': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/07 03:36:00 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073707637")
2025/05/07 03:36:01 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073707867")
2025/05/07 03:36:01 DEBUG : box root 'rclone-test-bazaneq0juyi': ["file7.txt"(0)|file|ITEM_UPLOAD|1854710098964|4835ebed06fe3f96699382f1a73798de1ba8ae59] new parent not found
2025/05/07 03:36:01 DEBUG : box root 'rclone-test-bazaneq0juyi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/07 03:36:01 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073708090")
2025/05/07 03:36:01 INFO  : dir/file3.rclone_chunk.001_vm9xdj: Moved (server-side) to: dir/file3.rclone_chunk.001
2025/05/07 03:36:01 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073708330")
2025/05/07 03:36:02 DEBUG : box root 'rclone-test-bazaneq0juyi': ["file4"(0)|file|ITEM_UPLOAD|1854735594295|f6702e85decd830c1d5bdaa622c3ec07bc20a87c] ignored due to old SequenceID ('\x00')
2025/05/07 03:36:02 DEBUG : box root 'rclone-test-bazaneq0juyi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/07 03:36:02 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073708827")
2025/05/07 03:36:02 INFO  : dir/file3.rclone_chunk.002_vm9xdj: Moved (server-side) to: dir/file3.rclone_chunk.002
2025/05/07 03:36:02 DEBUG : box root 'rclone-test-bazaneq0juyi': ["file5.txt"(0)|file|ITEM_UPLOAD|1854738686361|8c2089c680963685e7f47e199d2f0bece65235af] new parent not found
2025/05/07 03:36:02 DEBUG : box root 'rclone-test-bazaneq0juyi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/07 03:36:02 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073709052")
2025/05/07 03:36:02 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073709276")
2025/05/07 03:36:03 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073709828")
2025/05/07 03:36:04 DEBUG : box root 'rclone-test-bazaneq0juyi': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1854738618550|ecbd2dcab5d0f7f96e017b0dfee95d441b06679e] new parent not found
2025/05/07 03:36:04 DEBUG : box root 'rclone-test-bazaneq0juyi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/07 03:36:04 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073710837")
2025/05/07 03:36:04 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073711066")
    fstests.go:931: Try 1/10 waiting for dirChanges and objChanges
2025/05/07 03:36:05 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073711828")
2025/05/07 03:36:06 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073712832")
2025/05/07 03:36:07 DEBUG : box root 'rclone-test-bazaneq0juyi': ["file3.rclone_chunk.002_vm9xdj"(0)|file|ITEM_UPLOAD|1854738189197|f81ba4e24283ef0e77245daec637d88b02a24ad8] ignored due to old SequenceID ('\x01')
2025/05/07 03:36:07 DEBUG : box root 'rclone-test-bazaneq0juyi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/07 03:36:07 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073713827")
2025/05/07 03:36:07 DEBUG : box root 'rclone-test-bazaneq0juyi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/07 03:36:07 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073714055")
2025/05/07 03:36:07 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073714282")
    fstests.go:931: Try 2/10 waiting for dirChanges and objChanges
2025/05/07 03:36:08 DEBUG : box root 'rclone-test-bazaneq0juyi': ["file3.rclone_chunk.001_vm9xdj"(0)|file|ITEM_UPLOAD|1854738798939|63860f2f274b48b04305cf8b53d1c1ff036cfa13] ignored due to old SequenceID ('\x01')
2025/05/07 03:36:08 DEBUG : box root 'rclone-test-bazaneq0juyi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/07 03:36:08 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073714821")
2025/05/07 03:36:08 DEBUG : box root 'rclone-test-bazaneq0juyi': ["file3.rclone_chunk.002"(1)|file|ITEM_RENAME|1854738189197|9865882222032f94c47e5321dd219867f219d80d] ignored due to old SequenceID ('\x01')
2025/05/07 03:36:08 DEBUG : box root 'rclone-test-bazaneq0juyi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/07 03:36:08 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073715059")
2025/05/07 03:36:08 DEBUG : box root 'rclone-test-bazaneq0juyi': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1854738798939|60ad01b8824b7321cde19dbcf65d37ac5dc4874e] ignored due to old SequenceID ('\x01')
2025/05/07 03:36:08 DEBUG : box root 'rclone-test-bazaneq0juyi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/07 03:36:08 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073715284")
2025/05/07 03:36:08 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073715513")
2025/05/07 03:36:09 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073715831")
2025/05/07 03:36:10 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073716836")
    fstests.go:931: Try 3/10 waiting for dirChanges and objChanges
2025/05/07 03:36:11 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073717828")
2025/05/07 03:36:12 DEBUG : box root 'rclone-test-bazaneq0juyi': ["file3"(0)|file|ITEM_UPLOAD|1854738645384|d205da274b647cbb6de2ec176f7cdd72a202a8b3] ignored due to old SequenceID ('\x00')
2025/05/07 03:36:12 DEBUG : box root 'rclone-test-bazaneq0juyi': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/07 03:36:12 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073718835")
2025/05/07 03:36:12 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073719065")
2025/05/07 03:36:13 DEBUG : box root 'rclone-test-bazaneq0juyi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/07 03:36:13 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073719831")
2025/05/07 03:36:13 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073720057")
    fstests.go:931: Try 4/10 waiting for dirChanges and objChanges
2025/05/07 03:36:14 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073720829")
2025/05/07 03:36:15 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073721830")
2025/05/07 03:36:16 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073722832")
    fstests.go:931: Try 5/10 waiting for dirChanges and objChanges
2025/05/07 03:36:17 DEBUG : box root 'rclone-test-bazaneq0juyi': ["file6.txt"(1)|file|ITEM_UPLOAD|1854709077253|f31bf52d316145ecf3a5467861cbbda2984ceeaf] new parent not found
2025/05/07 03:36:17 DEBUG : box root 'rclone-test-bazaneq0juyi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/07 03:36:17 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073723832")
2025/05/07 03:36:17 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073724059")
2025/05/07 03:36:18 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073724839")
2025/05/07 03:36:19 DEBUG : box root 'rclone-test-bazaneq0juyi': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1854738585509|2d44b9e8c4cccfc7181c22277283c4b822f0aa00] new parent not found
2025/05/07 03:36:19 DEBUG : box root 'rclone-test-bazaneq0juyi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/07 03:36:19 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073725833")
2025/05/07 03:36:19 DEBUG : box root 'rclone-test-bazaneq0juyi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/07 03:36:19 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073726085")
2025/05/07 03:36:19 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073726314")
    fstests.go:931: Try 6/10 waiting for dirChanges and objChanges
2025/05/07 03:36:20 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073726834")
2025/05/07 03:36:21 DEBUG : box root 'rclone-test-bazaneq0juyi': ["file4.txt"(0)|file|ITEM_UPLOAD|1854726975726|f84b0bb0082d54889d87e9936eb0d618b9ba5252] new parent not found
2025/05/07 03:36:21 DEBUG : box root 'rclone-test-bazaneq0juyi': ["file2.txt"(0)|file|ITEM_UPLOAD|1854737181221|77f0cc84666ec6a3843734ce272c353eb99affa2] new parent not found
2025/05/07 03:36:21 DEBUG : box root 'rclone-test-bazaneq0juyi': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/07 03:36:21 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073727830")
2025/05/07 03:36:21 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073728063")
2025/05/07 03:36:22 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073728829")
    fstests.go:931: Try 7/10 waiting for dirChanges and objChanges
2025/05/07 03:36:23 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073729836")
2025/05/07 03:36:24 DEBUG : box root 'rclone-test-bazaneq0juyi': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1854737046801|cdbe51dbc8a393ab1e4d6f173dd2162a5ce4219e] new parent not found
2025/05/07 03:36:24 DEBUG : box root 'rclone-test-bazaneq0juyi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/07 03:36:24 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073730832")
2025/05/07 03:36:24 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073731066")
2025/05/07 03:36:25 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073731830")
    fstests.go:931: Try 8/10 waiting for dirChanges and objChanges
2025/05/07 03:36:26 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073732836")
2025/05/07 03:36:27 DEBUG : box root 'rclone-test-bazaneq0juyi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/07 03:36:27 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073733827")
2025/05/07 03:36:27 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073734051")
2025/05/07 03:36:28 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073734863")
    fstests.go:931: Try 9/10 waiting for dirChanges and objChanges
2025/05/07 03:36:29 DEBUG : box root 'rclone-test-bazaneq0juyi': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1854731255220|41d5eaac1f5f6cc8c388ff654eae15b551ce4043] new parent not found
2025/05/07 03:36:29 DEBUG : box root 'rclone-test-bazaneq0juyi': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/07 03:36:29 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073735831")
2025/05/07 03:36:29 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073736058")
2025/05/07 03:36:30 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073736829")
2025/05/07 03:36:31 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073737827")
    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/07 03:36:32 DEBUG : box root 'rclone-test-bazaneq0juyi': Received 7 events, resulting in 0 paths and 0 notifications
2025/05/07 03:36:32 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073738828")
2025/05/07 03:36:32 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073739091")
2025/05/07 03:36:33 DEBUG : box root 'rclone-test-bazaneq0juyi': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/07 03:36:33 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073739826")
2025/05/07 03:36:33 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073740061")
2025/05/07 03:36:34 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073740829")
2025/05/07 03:36:35 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073741830")
2025/05/07 03:36:36 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073742828")
2025/05/07 03:36:37 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073743830")
2025/05/07 03:36:38 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073744833")
2025/05/07 03:36:39 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073745834")
2025/05/07 03:36:40 DEBUG : box root 'rclone-test-bazaneq0juyi': ["file2"(1)|file|ITEM_TRASH|1854729858569|833543013c824d797324263346a46e3d8d57439a] added old path ("dir/file2") for notify
2025/05/07 03:36:40 DEBUG : box root 'rclone-test-bazaneq0juyi': ["path1"(0)|folder|ITEM_CREATE|319987331547|2b043d9405847d9501bc6055aae1f1880e9f27a1] new parent not found
2025/05/07 03:36:40 DEBUG : doChangeNotify("dir/file2", 1)
2025/05/07 03:36:40 DEBUG : box root 'rclone-test-bazaneq0juyi': Received 2 events, resulting in 1 paths and 1 notifications
2025/05/07 03:36:40 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073746825")
2025/05/07 03:36:40 DEBUG : box root 'rclone-test-bazaneq0juyi': ["file1.txt"(0)|file|ITEM_UPLOAD|1854731697020|0b3b3770074b719ac64aeb187118b2c9a55999c6] new parent not found
2025/05/07 03:36:40 DEBUG : box root 'rclone-test-bazaneq0juyi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/07 03:36:40 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073747051")
2025/05/07 03:36:40 DEBUG : box root 'rclone-test-bazaneq0juyi': ["resync_modes"(0)|folder|ITEM_CREATE|319983536971|9e94f53126481dbd9d399a6bef4eda4c61b2c8bf] new parent not found
2025/05/07 03:36:40 DEBUG : box root 'rclone-test-bazaneq0juyi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/07 03:36:40 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073747280")
2025/05/07 03:36:40 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073747502")
2025/05/07 03:36:41 DEBUG : box root 'rclone-test-bazaneq0juyi': ["file2.rclone_chunk.002"(2)|file|ITEM_TRASH|1854738567699|8bbe63e3677c3e5d9116b229382db7f83bceddad] added old path ("dir/file2.rclone_chunk.002") for notify
2025/05/07 03:36:41 DEBUG : box root 'rclone-test-bazaneq0juyi': ["RCLONE_TEST"(0)|file|ITEM_UPLOAD|1854719934515|4b9051d3064534dba4b430f91309f9f2e40a8b53] new parent not found
2025/05/07 03:36:41 DEBUG : doChangeNotify("dir/file2", 1)
2025/05/07 03:36:41 DEBUG : box root 'rclone-test-bazaneq0juyi': Received 2 events, resulting in 1 paths and 1 notifications
2025/05/07 03:36:41 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073747832")
2025/05/07 03:36:41 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073748062")
2025/05/07 03:36:42 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073748834")
2025/05/07 03:36:43 DEBUG : box root 'rclone-test-bazaneq0juyi': ["file2.rclone_chunk.001"(2)|file|ITEM_TRASH|1854720546501|2222e1364ea07f80aea6cdfb1e83650f5f6c95af] added old path ("dir/file2.rclone_chunk.001") for notify
2025/05/07 03:36:43 DEBUG : doChangeNotify("dir/file2", 1)
2025/05/07 03:36:43 DEBUG : box root 'rclone-test-bazaneq0juyi': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/07 03:36:43 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073749825")
2025/05/07 03:36:43 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073750051")
2025/05/07 03:36:44 DEBUG : box root 'rclone-test-bazaneq0juyi': ["file2.txt"(0)|file|ITEM_UPLOAD|1854729810392|e8d4a9627cfff95e6e5e746ecef2fd37177f3391] new parent not found
2025/05/07 03:36:44 DEBUG : box root 'rclone-test-bazaneq0juyi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/07 03:36:44 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073750824")
2025/05/07 03:36:44 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073751058")
2025/05/07 03:36:45 DEBUG : box root 'rclone-test-bazaneq0juyi': ["file4"(1)|file|ITEM_TRASH|1854735594295|93a9c4f9de409ad97ff5504b9e2573b850a09c63] added old path ("dir/file4") for notify
2025/05/07 03:36:45 DEBUG : doChangeNotify("dir/file4", 1)
2025/05/07 03:36:45 DEBUG : box root 'rclone-test-bazaneq0juyi': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/07 03:36:45 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073751825")
2025/05/07 03:36:45 DEBUG : box root 'rclone-test-bazaneq0juyi': ["file1.txt"(1)|file|ITEM_UPLOAD|1854731697020|00e357ff767f932cc5d38c135a9309806c47d20b] new parent not found
2025/05/07 03:36:45 DEBUG : box root 'rclone-test-bazaneq0juyi': ["file4.rclone_chunk.001"(2)|file|ITEM_TRASH|1854738772531|aa2f67e9bbc1b9fe4c9318f0f49905b99159a5fb] added old path ("dir/file4.rclone_chunk.001") for notify
2025/05/07 03:36:45 DEBUG : doChangeNotify("dir/file4", 1)
2025/05/07 03:36:45 DEBUG : box root 'rclone-test-bazaneq0juyi': Received 2 events, resulting in 1 paths and 1 notifications
2025/05/07 03:36:45 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073752052")
2025/05/07 03:36:45 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073752297")
2025/05/07 03:36:46 DEBUG : box root 'rclone-test-bazaneq0juyi': ["file4.rclone_chunk.002"(2)|file|ITEM_TRASH|1854738299159|5091fb281a2d46bd55fb7fea4ae5614398bac242] added old path ("dir/file4.rclone_chunk.002") for notify
2025/05/07 03:36:46 DEBUG : doChangeNotify("dir/file4", 1)
2025/05/07 03:36:46 DEBUG : box root 'rclone-test-bazaneq0juyi': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/07 03:36:46 DEBUG : box root 'rclone-test-bazaneq0juyi': Checking for changes on remote (next_stream_position: "30401044073752836")
2025/05/07 03:36:47 DEBUG : box root 'rclone-test-bazaneq0juyi': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/05/07 03:36:47 ERROR : : error listing: directory not found
2025/05/07 03:36:48 DEBUG : box root 'rclone-test-bazaneq0juyi': Ignoring "Shared folder — ForNick" - unknown type "web_link"
--- FAIL: TestIntegration (74.50s)
    --- FAIL: TestIntegration/FsMkdir (72.09s)
        --- FAIL: TestIntegration/FsMkdir/FsChangeNotify (69.92s)
FAIL
exit status 1
FAIL	github.com/rclone/rclone/backend/chunker	74.559s
"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024 -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Finished ERROR in 1m17.39026772s (try 3/5): exit status 1: Failed [TestIntegration/FsMkdir/FsChangeNotify]