"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/03/16 01:22:30 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-lacubiv6yoja"
2025/03/16 01:22:30 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/03/16 01:22:30 DEBUG : Creating backend with remote "TestBox:rclone-test-lacubiv6yoja"
2025/03/16 01:22:31 DEBUG : box root 'rclone-test-lacubiv6yoja': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/03/16 01:22:31 DEBUG : Reset feature "ListR"
2025/03/16 01:22:31 DEBUG : box root 'rclone-test-lacubiv6yoja': Ignoring "Shared folder — ForNick" - unknown type "web_link"
=== RUN   TestIntegration/FsMkdir
=== RUN   TestIntegration/FsMkdir/FsChangeNotify
2025/03/16 01:22:33 INFO  : dir: Making directory
2025/03/16 01:22:34 INFO  : dir/subdir1: Making directory
2025/03/16 01:22:35 INFO  : dir/subdir3: Making directory
2025/03/16 01:22:35 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572900926")
2025/03/16 01:22:35 DEBUG : box root 'rclone-test-lacubiv6yoja': Received 1 events, resulting in 0 paths and 0 notifications
2025/03/16 01:22:35 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572902138")
2025/03/16 01:22:35 DEBUG : box root 'rclone-test-lacubiv6yoja': ["rclone-test-lacubiv6yoja"(0)|folder|ITEM_CREATE|311927178636|7c29f4f6ee1dfb7a2a4a4771e6dea4edc7bc847e] new parent not found
2025/03/16 01:22:35 DEBUG : box root 'rclone-test-lacubiv6yoja': ["dir-methods"(0)|folder|ITEM_CREATE|311927444750|c8348f34074b5f39caa7e1e00eb44a3dbc845ab7] new parent not found
2025/03/16 01:22:35 DEBUG : box root 'rclone-test-lacubiv6yoja': Received 2 events, resulting in 0 paths and 0 notifications
2025/03/16 01:22:35 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572902364")
2025/03/16 01:22:36 INFO  : dir/subdir2: Making directory
2025/03/16 01:22:36 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572902592")
2025/03/16 01:22:37 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572903146")
2025/03/16 01:22:38 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572904137")
2025/03/16 01:22:38 DEBUG : box root 'rclone-test-lacubiv6yoja': ["rclone-test-lacubiv6yoja"(0)|folder|ITEM_CREATE|311927178636|7c29f4f6ee1dfb7a2a4a4771e6dea4edc7bc847e] ignored due to duplicate EventID
2025/03/16 01:22:38 DEBUG : box root 'rclone-test-lacubiv6yoja': ["dir-methods"(0)|folder|ITEM_CREATE|311927444750|c8348f34074b5f39caa7e1e00eb44a3dbc845ab7] ignored due to duplicate EventID
2025/03/16 01:22:38 DEBUG : box root 'rclone-test-lacubiv6yoja': ["dir"(0)|folder|ITEM_CREATE|311927792576|faa4390f3a7e8f2e98eaad50efb4bbccc74505d2] added new path ("dir") for notify
2025/03/16 01:22:38 DEBUG : box root 'rclone-test-lacubiv6yoja': ["subdir1"(0)|folder|ITEM_CREATE|311927339961|fca31e54cbc10e10eb71d404e80dee389e282c84] added new path ("dir/subdir1") for notify
2025/03/16 01:22:38 DEBUG : box root 'rclone-test-lacubiv6yoja': ["subdir3"(0)|folder|ITEM_CREATE|311926451080|c4d1bbccd2f28bd0130545de01940c55b60844b1] added new path ("dir/subdir3") for notify
2025/03/16 01:22:38 DEBUG : doChangeNotify("dir", 0)
2025/03/16 01:22:38 DEBUG : doChangeNotify("dir/subdir1", 0)
2025/03/16 01:22:38 DEBUG : doChangeNotify("dir/subdir3", 0)
2025/03/16 01:22:38 DEBUG : box root 'rclone-test-lacubiv6yoja': Received 6 events, resulting in 3 paths and 3 notifications
2025/03/16 01:22:38 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572905138")
2025/03/16 01:22:39 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572905384")
2025/03/16 01:22:40 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572906137")
2025/03/16 01:22:40 DEBUG : box root 'rclone-test-lacubiv6yoja': ["unknown-size-update.txt.rclone_chunk.001"(2)|file|ITEM_TRASH|1804495386154|f412e65254f4dca9f6b757f0f782191703713821] ignored due to duplicate EventID
2025/03/16 01:22:40 DEBUG : box root 'rclone-test-lacubiv6yoja': ["dir"(0)|folder|ITEM_CREATE|311927792576|faa4390f3a7e8f2e98eaad50efb4bbccc74505d2] ignored due to duplicate EventID
2025/03/16 01:22:40 INFO  : dir/file2.rclone_chunk.001_75fcdp: Moved (server-side) to: dir/file2.rclone_chunk.001
2025/03/16 01:22:41 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572907140")
2025/03/16 01:22:41 INFO  : dir/file2.rclone_chunk.002_75fcdp: Moved (server-side) to: dir/file2.rclone_chunk.002
2025/03/16 01:22:41 DEBUG : box root 'rclone-test-lacubiv6yoja': ["subdir1"(0)|folder|ITEM_CREATE|311927339961|fca31e54cbc10e10eb71d404e80dee389e282c84] ignored due to duplicate EventID
2025/03/16 01:22:41 DEBUG : box root 'rclone-test-lacubiv6yoja': ["subdir3"(0)|folder|ITEM_CREATE|311926451080|c4d1bbccd2f28bd0130545de01940c55b60844b1] ignored due to duplicate EventID
2025/03/16 01:22:42 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572908141")
2025/03/16 01:22:43 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572909138")
2025/03/16 01:22:43 DEBUG : box root 'rclone-test-lacubiv6yoja': ["subdir2"(0)|folder|ITEM_CREATE|311927577563|c086a44ac8b813f9696d54060c76ff765a587dd0] ignored due to old SequenceID ('\x00')
2025/03/16 01:22:43 DEBUG : box root 'rclone-test-lacubiv6yoja': ["file2.rclone_chunk.001"(1)|file|ITEM_RENAME|1804492185549|6457fcc6a1c34978037900a3ce37705dce220978] ignored due to old SequenceID ('\x01')
2025/03/16 01:22:43 DEBUG : box root 'rclone-test-lacubiv6yoja': ["file2.rclone_chunk.002_75fcdp"(0)|file|ITEM_UPLOAD|1804497368934|1c8b9c289e23fc5c1988762d19a69a4b7d515995] ignored due to old SequenceID ('\x01')
2025/03/16 01:22:43 DEBUG : box root 'rclone-test-lacubiv6yoja': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1804497368934|ad2c24d5f43ce6bf53e4879fc11fd65d4573705a] ignored due to old SequenceID ('\x01')
2025/03/16 01:22:43 DEBUG : box root 'rclone-test-lacubiv6yoja': ["file2"(0)|file|ITEM_UPLOAD|1804493910909|0e6a6f0dd6239bc71ac59c19ddf0c41b52ac8727] ignored due to old SequenceID ('\x00')
2025/03/16 01:22:43 DEBUG : box root 'rclone-test-lacubiv6yoja': Received 5 events, resulting in 0 paths and 0 notifications
2025/03/16 01:22:43 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572910141")
2025/03/16 01:22:43 DEBUG : box root 'rclone-test-lacubiv6yoja': ["file2.rclone_chunk.001"(1)|file|ITEM_RENAME|1804492185549|6457fcc6a1c34978037900a3ce37705dce220978] ignored due to duplicate EventID
2025/03/16 01:22:43 DEBUG : box root 'rclone-test-lacubiv6yoja': ["file2.rclone_chunk.002_75fcdp"(0)|file|ITEM_UPLOAD|1804497368934|1c8b9c289e23fc5c1988762d19a69a4b7d515995] ignored due to duplicate EventID
2025/03/16 01:22:43 DEBUG : box root 'rclone-test-lacubiv6yoja': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1804497368934|ad2c24d5f43ce6bf53e4879fc11fd65d4573705a] ignored due to duplicate EventID
2025/03/16 01:22:43 DEBUG : box root 'rclone-test-lacubiv6yoja': ["file2"(0)|file|ITEM_UPLOAD|1804493910909|0e6a6f0dd6239bc71ac59c19ddf0c41b52ac8727] ignored due to duplicate EventID
2025/03/16 01:22:44 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572910397")
2025/03/16 01:22:45 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572911139")
2025/03/16 01:22:46 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572912135")
2025/03/16 01:22:46 DEBUG : box root 'rclone-test-lacubiv6yoja': ["file2.rclone_chunk.001"(1)|file|ITEM_RENAME|1804492185549|6457fcc6a1c34978037900a3ce37705dce220978] ignored due to duplicate EventID
2025/03/16 01:22:47 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572913136")
2025/03/16 01:22:47 DEBUG : box root 'rclone-test-lacubiv6yoja': ["file2.rclone_chunk.002_75fcdp"(0)|file|ITEM_UPLOAD|1804497368934|1c8b9c289e23fc5c1988762d19a69a4b7d515995] ignored due to duplicate EventID
2025/03/16 01:22:47 DEBUG : box root 'rclone-test-lacubiv6yoja': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1804497368934|ad2c24d5f43ce6bf53e4879fc11fd65d4573705a] ignored due to duplicate EventID
2025/03/16 01:22:47 DEBUG : box root 'rclone-test-lacubiv6yoja': ["file2"(0)|file|ITEM_UPLOAD|1804493910909|0e6a6f0dd6239bc71ac59c19ddf0c41b52ac8727] ignored due to duplicate EventID
2025/03/16 01:22:47 INFO  : dir/file4.rclone_chunk.001_75fijy: Moved (server-side) to: dir/file4.rclone_chunk.001
2025/03/16 01:22:47 INFO  : dir/file4.rclone_chunk.002_75fijy: Moved (server-side) to: dir/file4.rclone_chunk.002
2025/03/16 01:22:48 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572914140")
2025/03/16 01:22:49 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572915139")
2025/03/16 01:22:49 DEBUG : box root 'rclone-test-lacubiv6yoja': ["file4.rclone_chunk.001_75fijy"(0)|file|ITEM_UPLOAD|1804492624008|e2d559aa6f29aa3899740263e4657a869ae7b31d] added new path ("dir/file4.rclone_chunk.001_75fijy") for notify
2025/03/16 01:22:49 DEBUG : box root 'rclone-test-lacubiv6yoja': ["file2.rclone_chunk.001_75fcdp"(0)|file|ITEM_UPLOAD|1804492185549|253f0faf04b81dbcde5682a468e29343849d8934] ignored due to old SequenceID ('\x01')
2025/03/16 01:22:49 DEBUG : box root 'rclone-test-lacubiv6yoja': ["file4.rclone_chunk.002_75fijy"(0)|file|ITEM_UPLOAD|1804490250436|7fafc1e90d92c83c9927b32e8047b28c0791be07] added new path ("dir/file4.rclone_chunk.002_75fijy") for notify
2025/03/16 01:22:49 DEBUG : box root 'rclone-test-lacubiv6yoja': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1804492624008|8376dc3e0c1cb48d34127aba9aa6054fd56e6a78] added new path ("dir/file4.rclone_chunk.001") for notify
2025/03/16 01:22:49 DEBUG : doChangeNotify("dir/file4.rclone_chunk.001_75fijy", 1)
2025/03/16 01:22:49 DEBUG : doChangeNotify("dir/file4.rclone_chunk.002_75fijy", 1)
2025/03/16 01:22:49 DEBUG : doChangeNotify("dir/file4", 1)
2025/03/16 01:22:49 DEBUG : box root 'rclone-test-lacubiv6yoja': Received 4 events, resulting in 3 paths and 3 notifications
2025/03/16 01:22:49 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572916143")
2025/03/16 01:22:50 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572916380")
2025/03/16 01:22:50 DEBUG : box root 'rclone-test-lacubiv6yoja': ["file4.rclone_chunk.001_75fijy"(0)|file|ITEM_UPLOAD|1804492624008|e2d559aa6f29aa3899740263e4657a869ae7b31d] ignored due to duplicate EventID
2025/03/16 01:22:50 DEBUG : box root 'rclone-test-lacubiv6yoja': ["file2.rclone_chunk.001_75fcdp"(0)|file|ITEM_UPLOAD|1804492185549|253f0faf04b81dbcde5682a468e29343849d8934] ignored due to duplicate EventID
2025/03/16 01:22:50 DEBUG : box root 'rclone-test-lacubiv6yoja': ["file4.rclone_chunk.002_75fijy"(0)|file|ITEM_UPLOAD|1804490250436|7fafc1e90d92c83c9927b32e8047b28c0791be07] ignored due to duplicate EventID
2025/03/16 01:22:50 DEBUG : box root 'rclone-test-lacubiv6yoja': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1804492624008|8376dc3e0c1cb48d34127aba9aa6054fd56e6a78] ignored due to duplicate EventID
2025/03/16 01:22:50 DEBUG : box root 'rclone-test-lacubiv6yoja': ["file4.rclone_chunk.002"(1)|file|ITEM_RENAME|1804490250436|2f83d008f332afb5c909af54b391ab7226810765] ignored due to old SequenceID ('\x01')
2025/03/16 01:22:50 DEBUG : box root 'rclone-test-lacubiv6yoja': Received 5 events, resulting in 0 paths and 0 notifications
2025/03/16 01:22:50 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572917139")
2025/03/16 01:22:50 DEBUG : box root 'rclone-test-lacubiv6yoja': ["file4.rclone_chunk.001_75fijy"(0)|file|ITEM_UPLOAD|1804492624008|e2d559aa6f29aa3899740263e4657a869ae7b31d] ignored due to duplicate EventID
2025/03/16 01:22:50 DEBUG : box root 'rclone-test-lacubiv6yoja': ["file2.rclone_chunk.001_75fcdp"(0)|file|ITEM_UPLOAD|1804492185549|253f0faf04b81dbcde5682a468e29343849d8934] ignored due to duplicate EventID
2025/03/16 01:22:50 DEBUG : box root 'rclone-test-lacubiv6yoja': ["file4.rclone_chunk.002_75fijy"(0)|file|ITEM_UPLOAD|1804490250436|7fafc1e90d92c83c9927b32e8047b28c0791be07] ignored due to duplicate EventID
2025/03/16 01:22:50 DEBUG : box root 'rclone-test-lacubiv6yoja': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1804492624008|8376dc3e0c1cb48d34127aba9aa6054fd56e6a78] ignored due to duplicate EventID
2025/03/16 01:22:50 DEBUG : box root 'rclone-test-lacubiv6yoja': ["file4.rclone_chunk.002"(1)|file|ITEM_RENAME|1804490250436|2f83d008f332afb5c909af54b391ab7226810765] ignored due to duplicate EventID
2025/03/16 01:22:51 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572917389")
2025/03/16 01:22:52 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572918139")
2025/03/16 01:22:52 DEBUG : box root 'rclone-test-lacubiv6yoja': ["file4.rclone_chunk.001_75fijy"(0)|file|ITEM_UPLOAD|1804492624008|e2d559aa6f29aa3899740263e4657a869ae7b31d] ignored due to duplicate EventID
2025/03/16 01:22:52 DEBUG : box root 'rclone-test-lacubiv6yoja': ["file2.rclone_chunk.001_75fcdp"(0)|file|ITEM_UPLOAD|1804492185549|253f0faf04b81dbcde5682a468e29343849d8934] ignored due to duplicate EventID
2025/03/16 01:22:52 DEBUG : box root 'rclone-test-lacubiv6yoja': ["file4.rclone_chunk.002_75fijy"(0)|file|ITEM_UPLOAD|1804490250436|7fafc1e90d92c83c9927b32e8047b28c0791be07] ignored due to duplicate EventID
2025/03/16 01:22:53 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572919138")
2025/03/16 01:22:53 DEBUG : box root 'rclone-test-lacubiv6yoja': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1804492624008|8376dc3e0c1cb48d34127aba9aa6054fd56e6a78] ignored due to duplicate EventID
2025/03/16 01:22:53 DEBUG : box root 'rclone-test-lacubiv6yoja': ["file4.rclone_chunk.002"(1)|file|ITEM_RENAME|1804490250436|2f83d008f332afb5c909af54b391ab7226810765] ignored due to duplicate EventID
2025/03/16 01:22:53 DEBUG : box root 'rclone-test-lacubiv6yoja': ["file4"(0)|file|ITEM_UPLOAD|1804491385364|b4b42bd77255713019969f28f4d82b9ca7c69c45] ignored due to old SequenceID ('\x00')
2025/03/16 01:22:53 DEBUG : box root 'rclone-test-lacubiv6yoja': Received 3 events, resulting in 0 paths and 0 notifications
2025/03/16 01:22:53 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572920139")
2025/03/16 01:22:53 DEBUG : box root 'rclone-test-lacubiv6yoja': ["file4.rclone_chunk.002"(1)|file|ITEM_RENAME|1804490250436|2f83d008f332afb5c909af54b391ab7226810765] ignored due to duplicate EventID
2025/03/16 01:22:53 DEBUG : box root 'rclone-test-lacubiv6yoja': ["file4"(0)|file|ITEM_UPLOAD|1804491385364|b4b42bd77255713019969f28f4d82b9ca7c69c45] ignored due to duplicate EventID
2025/03/16 01:22:54 INFO  : dir/file3.rclone_chunk.001_75fp0h: Moved (server-side) to: dir/file3.rclone_chunk.001
2025/03/16 01:22:54 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572920370")
2025/03/16 01:22:54 INFO  : dir/file3.rclone_chunk.002_75fp0h: Moved (server-side) to: dir/file3.rclone_chunk.002
2025/03/16 01:22:55 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572921138")
2025/03/16 01:22:55 DEBUG : box root 'rclone-test-lacubiv6yoja': ["file4"(0)|file|ITEM_UPLOAD|1804491385364|b4b42bd77255713019969f28f4d82b9ca7c69c45] ignored due to duplicate EventID
2025/03/16 01:22:56 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572922140")
    fstests.go:931: Try 1/10 waiting for dirChanges and objChanges
2025/03/16 01:22:57 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572923137")
2025/03/16 01:22:57 DEBUG : box root 'rclone-test-lacubiv6yoja': ["file3.rclone_chunk.002_75fp0h"(0)|file|ITEM_UPLOAD|1804494829259|e8bc6f1ced1e0f8e9af54fa683f88423aaa50ea9] ignored due to old SequenceID ('\x01')
2025/03/16 01:22:57 DEBUG : box root 'rclone-test-lacubiv6yoja': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1804494102062|88e16b404a8313f04497089ecd3110617c9d6d46] ignored due to old SequenceID ('\x01')
2025/03/16 01:22:57 DEBUG : box root 'rclone-test-lacubiv6yoja': ["file3.rclone_chunk.002"(1)|file|ITEM_RENAME|1804494829259|725b5088d7a6f617ba9ac4adf43a99e9c82a4d95] ignored due to old SequenceID ('\x01')
2025/03/16 01:22:57 DEBUG : box root 'rclone-test-lacubiv6yoja': ["file3"(0)|file|ITEM_UPLOAD|1804491882521|d78cf84301c0f32020ff66f264e91c59c211dc8c] ignored due to old SequenceID ('\x00')
2025/03/16 01:22:57 DEBUG : box root 'rclone-test-lacubiv6yoja': Received 4 events, resulting in 0 paths and 0 notifications
2025/03/16 01:22:57 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572924138")
2025/03/16 01:22:58 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572924377")
2025/03/16 01:22:59 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572925140")
2025/03/16 01:22:59 DEBUG : box root 'rclone-test-lacubiv6yoja': ["file3.rclone_chunk.002_75fp0h"(0)|file|ITEM_UPLOAD|1804494829259|e8bc6f1ced1e0f8e9af54fa683f88423aaa50ea9] ignored due to duplicate EventID
2025/03/16 01:22:59 DEBUG : box root 'rclone-test-lacubiv6yoja': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1804494102062|88e16b404a8313f04497089ecd3110617c9d6d46] ignored due to duplicate EventID
2025/03/16 01:22:59 DEBUG : box root 'rclone-test-lacubiv6yoja': ["file3.rclone_chunk.002"(1)|file|ITEM_RENAME|1804494829259|725b5088d7a6f617ba9ac4adf43a99e9c82a4d95] ignored due to duplicate EventID
2025/03/16 01:22:59 DEBUG : box root 'rclone-test-lacubiv6yoja': ["file3"(0)|file|ITEM_UPLOAD|1804491882521|d78cf84301c0f32020ff66f264e91c59c211dc8c] ignored due to duplicate EventID
    fstests.go:931: Try 2/10 waiting for dirChanges and objChanges
2025/03/16 01:23:00 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572926137")
2025/03/16 01:23:01 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572927135")
2025/03/16 01:23:01 DEBUG : box root 'rclone-test-lacubiv6yoja': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1804494102062|88e16b404a8313f04497089ecd3110617c9d6d46] ignored due to duplicate EventID
2025/03/16 01:23:01 DEBUG : box root 'rclone-test-lacubiv6yoja': ["file3.rclone_chunk.002"(1)|file|ITEM_RENAME|1804494829259|725b5088d7a6f617ba9ac4adf43a99e9c82a4d95] ignored due to duplicate EventID
2025/03/16 01:23:01 DEBUG : box root 'rclone-test-lacubiv6yoja': ["file3"(0)|file|ITEM_UPLOAD|1804491882521|d78cf84301c0f32020ff66f264e91c59c211dc8c] ignored due to duplicate EventID
2025/03/16 01:23:01 DEBUG : box root 'rclone-test-lacubiv6yoja': ["file3.rclone_chunk.001_75fp0h"(0)|file|ITEM_UPLOAD|1804494102062|790964c4c35822b2e272f258b54d54fc7a581c60] ignored due to old SequenceID ('\x01')
2025/03/16 01:23:01 DEBUG : box root 'rclone-test-lacubiv6yoja': Received 4 events, resulting in 0 paths and 0 notifications
2025/03/16 01:23:01 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572928138")
2025/03/16 01:23:02 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572928373")
    fstests.go:931: Try 3/10 waiting for dirChanges and objChanges
2025/03/16 01:23:03 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572929146")
2025/03/16 01:23:04 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572930143")
2025/03/16 01:23:05 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572931138")
2025/03/16 01:23:05 DEBUG : box root 'rclone-test-lacubiv6yoja': ["file3.rclone_chunk.001_75fp0h"(0)|file|ITEM_UPLOAD|1804494102062|790964c4c35822b2e272f258b54d54fc7a581c60] ignored due to duplicate EventID
    fstests.go:931: Try 4/10 waiting for dirChanges and objChanges
2025/03/16 01:23:06 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572932140")
2025/03/16 01:23:07 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572933141")
2025/03/16 01:23:08 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572934140")
    fstests.go:931: Try 5/10 waiting for dirChanges and objChanges
2025/03/16 01:23:09 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572935138")
2025/03/16 01:23:10 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572936139")
2025/03/16 01:23:11 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572937137")
    fstests.go:931: Try 6/10 waiting for dirChanges and objChanges
2025/03/16 01:23:12 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572938136")
2025/03/16 01:23:13 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572939136")
2025/03/16 01:23:14 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572940139")
    fstests.go:931: Try 7/10 waiting for dirChanges and objChanges
2025/03/16 01:23:15 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572941142")
2025/03/16 01:23:16 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572942138")
2025/03/16 01:23:17 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572943136")
    fstests.go:931: Try 8/10 waiting for dirChanges and objChanges
2025/03/16 01:23:18 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572944137")
2025/03/16 01:23:19 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572945139")
2025/03/16 01:23:20 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572946144")
    fstests.go:931: Try 9/10 waiting for dirChanges and objChanges
2025/03/16 01:23:21 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572947139")
2025/03/16 01:23:22 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572948137")
2025/03/16 01:23:23 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572949139")
    fstests.go:935: map[dir:{} dir/subdir1:{} dir/subdir3:{}] does not contain [dir/subdir1 dir/subdir3 dir/subdir2] or 
        map[dir/file4:{} dir/file4.rclone_chunk.001_75fijy:{} dir/file4.rclone_chunk.002_75fijy:{}] does not contain [dir/file2 dir/file4 dir/file3]
2025/03/16 01:23:24 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572950138")
2025/03/16 01:23:25 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572951139")
2025/03/16 01:23:26 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572952136")
2025/03/16 01:23:27 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572953139")
2025/03/16 01:23:28 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572954144")
2025/03/16 01:23:29 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572955138")
2025/03/16 01:23:29 DEBUG : box root 'rclone-test-lacubiv6yoja': ["file2.rclone_chunk.001"(2)|file|ITEM_TRASH|1804492185549|8a23af1dd8e27bdedc272b6e7c85abb867ce215a] added old path ("dir/file2.rclone_chunk.001") for notify
2025/03/16 01:23:29 DEBUG : box root 'rclone-test-lacubiv6yoja': ["file2"(1)|file|ITEM_TRASH|1804493910909|ea57b129971eadf35b04ef95f3d7a5936fe42cbe] added old path ("dir/file2") for notify
2025/03/16 01:23:29 DEBUG : box root 'rclone-test-lacubiv6yoja': ["file2.rclone_chunk.002"(2)|file|ITEM_TRASH|1804497368934|b09693b27e38a6380a4eb0ec4d6b5373923ff314] added old path ("dir/file2.rclone_chunk.002") for notify
2025/03/16 01:23:29 DEBUG : doChangeNotify("dir/file2", 1)
2025/03/16 01:23:29 DEBUG : doChangeNotify("dir/file2", 1)
2025/03/16 01:23:29 DEBUG : doChangeNotify("dir/file2", 1)
2025/03/16 01:23:29 DEBUG : box root 'rclone-test-lacubiv6yoja': Received 3 events, resulting in 3 paths and 3 notifications
2025/03/16 01:23:29 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572956142")
2025/03/16 01:23:30 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572956366")
2025/03/16 01:23:30 DEBUG : box root 'rclone-test-lacubiv6yoja': ["file2.rclone_chunk.001"(2)|file|ITEM_TRASH|1804492185549|8a23af1dd8e27bdedc272b6e7c85abb867ce215a] ignored due to duplicate EventID
2025/03/16 01:23:30 DEBUG : box root 'rclone-test-lacubiv6yoja': ["file2"(1)|file|ITEM_TRASH|1804493910909|ea57b129971eadf35b04ef95f3d7a5936fe42cbe] ignored due to duplicate EventID
2025/03/16 01:23:30 DEBUG : box root 'rclone-test-lacubiv6yoja': ["file2.rclone_chunk.002"(2)|file|ITEM_TRASH|1804497368934|b09693b27e38a6380a4eb0ec4d6b5373923ff314] ignored due to duplicate EventID
2025/03/16 01:23:30 DEBUG : box root 'rclone-test-lacubiv6yoja': ["file4"(1)|file|ITEM_TRASH|1804491385364|28777932cb535f79f5697bb1980c4c57f7511f44] added old path ("dir/file4") for notify
2025/03/16 01:23:30 DEBUG : doChangeNotify("dir/file4", 1)
2025/03/16 01:23:30 DEBUG : box root 'rclone-test-lacubiv6yoja': Received 4 events, resulting in 1 paths and 1 notifications
2025/03/16 01:23:30 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572957142")
2025/03/16 01:23:31 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572957382")
2025/03/16 01:23:31 DEBUG : box root 'rclone-test-lacubiv6yoja': ["file2.rclone_chunk.001"(2)|file|ITEM_TRASH|1804492185549|8a23af1dd8e27bdedc272b6e7c85abb867ce215a] ignored due to duplicate EventID
2025/03/16 01:23:31 DEBUG : box root 'rclone-test-lacubiv6yoja': ["file2"(1)|file|ITEM_TRASH|1804493910909|ea57b129971eadf35b04ef95f3d7a5936fe42cbe] ignored due to duplicate EventID
2025/03/16 01:23:31 DEBUG : box root 'rclone-test-lacubiv6yoja': ["file2.rclone_chunk.002"(2)|file|ITEM_TRASH|1804497368934|b09693b27e38a6380a4eb0ec4d6b5373923ff314] ignored due to duplicate EventID
2025/03/16 01:23:31 DEBUG : box root 'rclone-test-lacubiv6yoja': ["file4"(1)|file|ITEM_TRASH|1804491385364|28777932cb535f79f5697bb1980c4c57f7511f44] ignored due to duplicate EventID
2025/03/16 01:23:32 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572958137")
2025/03/16 01:23:33 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572959136")
2025/03/16 01:23:33 DEBUG : box root 'rclone-test-lacubiv6yoja': ["file2.rclone_chunk.001"(2)|file|ITEM_TRASH|1804492185549|8a23af1dd8e27bdedc272b6e7c85abb867ce215a] ignored due to duplicate EventID
2025/03/16 01:23:33 DEBUG : box root 'rclone-test-lacubiv6yoja': ["file2"(1)|file|ITEM_TRASH|1804493910909|ea57b129971eadf35b04ef95f3d7a5936fe42cbe] ignored due to duplicate EventID
2025/03/16 01:23:33 DEBUG : box root 'rclone-test-lacubiv6yoja': ["file2.rclone_chunk.002"(2)|file|ITEM_TRASH|1804497368934|b09693b27e38a6380a4eb0ec4d6b5373923ff314] ignored due to duplicate EventID
2025/03/16 01:23:34 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572960141")
2025/03/16 01:23:34 DEBUG : box root 'rclone-test-lacubiv6yoja': ["file4"(1)|file|ITEM_TRASH|1804491385364|28777932cb535f79f5697bb1980c4c57f7511f44] ignored due to duplicate EventID
2025/03/16 01:23:34 DEBUG : box root 'rclone-test-lacubiv6yoja': ["file4.rclone_chunk.002"(2)|file|ITEM_TRASH|1804490250436|9bde2ac5efeb3d95acbddbd04c875d71f667782d] added old path ("dir/file4.rclone_chunk.002") for notify
2025/03/16 01:23:34 DEBUG : doChangeNotify("dir/file4", 1)
2025/03/16 01:23:34 DEBUG : box root 'rclone-test-lacubiv6yoja': Received 2 events, resulting in 1 paths and 1 notifications
2025/03/16 01:23:34 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572961137")
2025/03/16 01:23:35 DEBUG : box root 'rclone-test-lacubiv6yoja': Checking for changes on remote (next_stream_position: "30401039572961360")
2025/03/16 01:23:36 DEBUG : box root 'rclone-test-lacubiv6yoja': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/03/16 01:23:36 ERROR : : error listing: directory not found
2025/03/16 01:23:37 DEBUG : box root 'rclone-test-lacubiv6yoja': Ignoring "Shared folder — ForNick" - unknown type "web_link"
--- FAIL: TestIntegration (66.68s)
    --- FAIL: TestIntegration/FsMkdir (64.59s)
        --- FAIL: TestIntegration/FsMkdir/FsChangeNotify (62.55s)
FAIL
exit status 1
FAIL	github.com/rclone/rclone/backend/chunker	66.707s
"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024 -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Finished ERROR in 1m9.112486909s (try 2/5): exit status 1: Failed [TestIntegration/FsMkdir/FsChangeNotify]