"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/04/17 05:29:20 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-xumitok0zehi"
2025/04/17 05:29:20 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/04/17 05:29:20 DEBUG : Creating backend with remote "TestBox:rclone-test-xumitok0zehi"
2025/04/17 05:29:22 DEBUG : box root 'rclone-test-xumitok0zehi': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/04/17 05:29:22 DEBUG : box root 'rclone-test-xumitok0zehi': Ignoring "Shared folder — ForNick" - unknown type "web_link"
=== RUN   TestIntegration/FsMkdir
=== RUN   TestIntegration/FsMkdir/FsChangeNotify
2025/04/17 05:29:24 INFO  : dir: Making directory
2025/04/17 05:29:26 INFO  : dir/subdir1: Making directory
2025/04/17 05:29:27 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352512866")
2025/04/17 05:29:27 INFO  : dir/subdir3: Making directory
2025/04/17 05:29:28 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352514097")
2025/04/17 05:29:28 INFO  : dir/subdir2: Making directory
2025/04/17 05:29:29 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352515102")
2025/04/17 05:29:29 DEBUG : box root 'rclone-test-xumitok0zehi': ["banana"(1)|file|ITEM_RENAME|1836711387848|9d666ad1953b70821cd3d709bf17b9ef8f9118ea] new parent not found
2025/04/17 05:29:29 DEBUG : box root 'rclone-test-xumitok0zehi': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/17 05:29:29 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352516100")
2025/04/17 05:29:29 DEBUG : box root 'rclone-test-xumitok0zehi': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/17 05:29:29 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352516334")
2025/04/17 05:29:30 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352516581")
2025/04/17 05:29:31 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352517109")
2025/04/17 05:29:31 DEBUG : box root 'rclone-test-xumitok0zehi': ["rclone-test-xumitok0zehi"(0)|folder|ITEM_CREATE|317126658119|f781ec70430b7341d906445e2c44cc9dbf0bf2de] new parent not found
2025/04/17 05:29:31 DEBUG : box root 'rclone-test-xumitok0zehi': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/17 05:29:31 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352518104")
2025/04/17 05:29:32 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352518345")
2025/04/17 05:29:33 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352519107")
2025/04/17 05:29:34 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352520100")
2025/04/17 05:29:34 DEBUG : box root 'rclone-test-xumitok0zehi': ["subdir1"(0)|folder|ITEM_CREATE|317129838884|018a27826f048f7b5226303a7d8a4168982d9339] added new path ("dir/subdir1") for notify
2025/04/17 05:29:34 DEBUG : doChangeNotify("dir/subdir1", 0)
2025/04/17 05:29:34 DEBUG : box root 'rclone-test-xumitok0zehi': Received 1 events, resulting in 1 paths and 1 notifications
2025/04/17 05:29:34 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352521101")
2025/04/17 05:29:34 DEBUG : box root 'rclone-test-xumitok0zehi': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/17 05:29:34 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352521334")
2025/04/17 05:29:34 INFO  : dir/file2.rclone_chunk.001_uq70yn: Moved (server-side) to: dir/file2.rclone_chunk.001
2025/04/17 05:29:35 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352521569")
2025/04/17 05:29:35 INFO  : dir/file2.rclone_chunk.002_uq70yn: Moved (server-side) to: dir/file2.rclone_chunk.002
2025/04/17 05:29:36 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352522102")
2025/04/17 05:29:36 DEBUG : box root 'rclone-test-xumitok0zehi': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/17 05:29:36 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352523093")
2025/04/17 05:29:36 DEBUG : box root 'rclone-test-xumitok0zehi': ["subdir3"(0)|folder|ITEM_CREATE|317127153013|942d2a720d5790ef35aecc8fd30fe0dc76827e60] added new path ("dir/subdir3") for notify
2025/04/17 05:29:36 DEBUG : doChangeNotify("dir/subdir3", 0)
2025/04/17 05:29:36 DEBUG : box root 'rclone-test-xumitok0zehi': Received 1 events, resulting in 1 paths and 1 notifications
2025/04/17 05:29:36 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352523325")
2025/04/17 05:29:37 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352523568")
2025/04/17 05:29:38 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352524096")
2025/04/17 05:29:38 DEBUG : box root 'rclone-test-xumitok0zehi': ["subdir2"(0)|folder|ITEM_CREATE|317126790200|0d73d698f6121f890431849c82bdd0f5d13fd1c8] ignored due to old SequenceID ('\x00')
2025/04/17 05:29:38 DEBUG : box root 'rclone-test-xumitok0zehi': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/17 05:29:38 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352525105")
2025/04/17 05:29:39 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352525339")
2025/04/17 05:29:39 DEBUG : box root 'rclone-test-xumitok0zehi': ["file2.rclone_chunk.001_uq70yn"(0)|file|ITEM_UPLOAD|1836716024944|f7f184fe6656546b7e7661826a42adf0bc06fc36] ignored due to old SequenceID ('\x01')
2025/04/17 05:29:39 DEBUG : box root 'rclone-test-xumitok0zehi': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/17 05:29:39 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352526107")
2025/04/17 05:29:40 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352526336")
2025/04/17 05:29:40 DEBUG : box root 'rclone-test-xumitok0zehi': ["potato.rclone_chunk.001_uq6u2g"(0)|file|ITEM_UPLOAD|1836712102980|c28fd5faec5443aedfe062b2e3e42961571379db] new parent not found
2025/04/17 05:29:40 DEBUG : box root 'rclone-test-xumitok0zehi': ["dir"(0)|folder|ITEM_CREATE|317128089455|432db0f54eadd0809a795150626d40a5366e4ef8] added new path ("dir") for notify
2025/04/17 05:29:40 DEBUG : doChangeNotify("dir", 0)
2025/04/17 05:29:40 DEBUG : box root 'rclone-test-xumitok0zehi': Received 2 events, resulting in 1 paths and 1 notifications
2025/04/17 05:29:40 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352527098")
2025/04/17 05:29:40 DEBUG : box root 'rclone-test-xumitok0zehi': ["file2.rclone_chunk.001"(1)|file|ITEM_RENAME|1836716024944|71b1f4d6d5351b478227a25b8f3297dc5fb36357] ignored due to old SequenceID ('\x01')
2025/04/17 05:29:40 DEBUG : box root 'rclone-test-xumitok0zehi': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/17 05:29:40 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352527331")
2025/04/17 05:29:41 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352527565")
2025/04/17 05:29:41 DEBUG : box root 'rclone-test-xumitok0zehi': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1836710893332|89e5e7d85c862f12dff4c249c1579e74057fd4d0] ignored due to old SequenceID ('\x01')
2025/04/17 05:29:41 DEBUG : box root 'rclone-test-xumitok0zehi': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/17 05:29:41 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352528104")
2025/04/17 05:29:42 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352528361")
2025/04/17 05:29:42 INFO  : dir/file4.rclone_chunk.001_uq78dx: Moved (server-side) to: dir/file4.rclone_chunk.001
2025/04/17 05:29:43 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352529154")
2025/04/17 05:29:43 DEBUG : box root 'rclone-test-xumitok0zehi': ["test.sum.rclone_chunk.001_uq71ml"(0)|file|ITEM_UPLOAD|1836712026561|473899772e0b4c49d1ed585d3c0ea5ad184d73b3] new parent not found
2025/04/17 05:29:43 DEBUG : box root 'rclone-test-xumitok0zehi': ["file2.rclone_chunk.002_uq70yn"(0)|file|ITEM_UPLOAD|1836710893332|6bcaf6070b8c32f6ac9799a69d7cf25296389c90] ignored due to old SequenceID ('\x01')
2025/04/17 05:29:43 DEBUG : box root 'rclone-test-xumitok0zehi': ["file2"(0)|file|ITEM_UPLOAD|1836720148708|0f1bf0f21ccffb8c72646c2ec494b0c49fb8b9ac] ignored due to old SequenceID ('\x00')
2025/04/17 05:29:43 DEBUG : box root 'rclone-test-xumitok0zehi': Received 3 events, resulting in 0 paths and 0 notifications
2025/04/17 05:29:43 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352530096")
2025/04/17 05:29:43 INFO  : dir/file4.rclone_chunk.002_uq78dx: Moved (server-side) to: dir/file4.rclone_chunk.002
2025/04/17 05:29:43 DEBUG : box root 'rclone-test-xumitok0zehi': ["test.sum.rclone_chunk.002_uq71ml"(0)|file|ITEM_UPLOAD|1836711107674|29cd9231fd6aca3c1acc503509b79f90fd4dd916] new parent not found
2025/04/17 05:29:43 DEBUG : box root 'rclone-test-xumitok0zehi': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/17 05:29:43 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352530339")
2025/04/17 05:29:44 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352530579")
2025/04/17 05:29:45 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352531108")
2025/04/17 05:29:45 DEBUG : box root 'rclone-test-xumitok0zehi': ["potato"(1)|file|ITEM_RENAME|1836712102980|ef7f26600936e5eeb1f42e10d439b7eb361a655e] new parent not found
2025/04/17 05:29:45 DEBUG : box root 'rclone-test-xumitok0zehi': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/17 05:29:45 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352532108")
2025/04/17 05:29:46 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352532345")
2025/04/17 05:29:46 DEBUG : box root 'rclone-test-xumitok0zehi': Received 2 events, resulting in 0 paths and 0 notifications
2025/04/17 05:29:46 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352533100")
2025/04/17 05:29:47 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352533349")
2025/04/17 05:29:47 DEBUG : box root 'rclone-test-xumitok0zehi': ["test.sum.rclone_chunk.002"(1)|file|ITEM_RENAME|1836711107674|616f205b8691416b53e5a72a79b463c847953f4f] new parent not found
2025/04/17 05:29:47 DEBUG : box root 'rclone-test-xumitok0zehi': ["file4.rclone_chunk.001_uq78dx"(0)|file|ITEM_UPLOAD|1836711740595|5aeb6811b53c76601fe0a26c55abf1abaf842984] ignored due to old SequenceID ('\x01')
2025/04/17 05:29:47 DEBUG : box root 'rclone-test-xumitok0zehi': Received 3 events, resulting in 0 paths and 0 notifications
2025/04/17 05:29:47 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352534113")
2025/04/17 05:29:48 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352534358")
2025/04/17 05:29:48 DEBUG : box root 'rclone-test-xumitok0zehi': ["test.sum"(6)|file|ITEM_UPLOAD|1836712695879|e0d549507a7509d53caa8f9d12aeec599430158c] new parent not found
2025/04/17 05:29:48 DEBUG : box root 'rclone-test-xumitok0zehi': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/17 05:29:48 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352535112")
2025/04/17 05:29:49 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352535353")
2025/04/17 05:29:50 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352536103")
2025/04/17 05:29:50 DEBUG : box root 'rclone-test-xumitok0zehi': ["file4.rclone_chunk.002_uq78dx"(0)|file|ITEM_UPLOAD|1836725347013|38262964e469c379b27e5858ef24ed94688b62cb] ignored due to old SequenceID ('\x01')
2025/04/17 05:29:50 DEBUG : box root 'rclone-test-xumitok0zehi': ["test.sum.rclone_chunk.001"(1)|file|ITEM_RENAME|1836712026561|106365c3b3e551869b88b5de4e0a33cafa4bf405] new parent not found
2025/04/17 05:29:50 DEBUG : box root 'rclone-test-xumitok0zehi': ["file4.rclone_chunk.002"(1)|file|ITEM_RENAME|1836725347013|28211096a2f8940748705dab0cd751dd862880b5] ignored due to old SequenceID ('\x01')
2025/04/17 05:29:50 DEBUG : box root 'rclone-test-xumitok0zehi': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1836711740595|f384b2975f8a12eeae752fcaddc7cfbe9e21ee19] ignored due to old SequenceID ('\x01')
2025/04/17 05:29:50 DEBUG : box root 'rclone-test-xumitok0zehi': Received 4 events, resulting in 0 paths and 0 notifications
2025/04/17 05:29:50 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352537099")
2025/04/17 05:29:51 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352537365")
2025/04/17 05:29:51 INFO  : dir/file3.rclone_chunk.001_uq7gek: Moved (server-side) to: dir/file3.rclone_chunk.001
2025/04/17 05:29:51 INFO  : dir/file3.rclone_chunk.002_uq7gek: Moved (server-side) to: dir/file3.rclone_chunk.002
2025/04/17 05:29:52 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352538103")
2025/04/17 05:29:53 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352539099")
2025/04/17 05:29:54 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352540112")
    fstests.go:931: Try 1/10 waiting for dirChanges and objChanges
2025/04/17 05:29:55 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352541105")
2025/04/17 05:29:55 DEBUG : box root 'rclone-test-xumitok0zehi': ["file4"(0)|file|ITEM_UPLOAD|1836719522212|1f7abb3fd67a52d5a122430c2cde94ab9db0c7d6] ignored due to old SequenceID ('\x00')
2025/04/17 05:29:55 DEBUG : box root 'rclone-test-xumitok0zehi': ["file3.rclone_chunk.002_uq7gek"(0)|file|ITEM_UPLOAD|1836710879306|674bcad6d615091fef40a6ea525fe8e8df710644] ignored due to old SequenceID ('\x01')
2025/04/17 05:29:55 DEBUG : box root 'rclone-test-xumitok0zehi': Received 2 events, resulting in 0 paths and 0 notifications
2025/04/17 05:29:55 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352542108")
2025/04/17 05:29:55 DEBUG : box root 'rclone-test-xumitok0zehi': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/17 05:29:55 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352542349")
2025/04/17 05:29:56 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352542592")
2025/04/17 05:29:56 DEBUG : box root 'rclone-test-xumitok0zehi': ["file3.rclone_chunk.001_uq7gek"(0)|file|ITEM_UPLOAD|1836723801423|a7e3eb679d47baebabc44086ee375f9c16063a4e] ignored due to old SequenceID ('\x01')
2025/04/17 05:29:56 DEBUG : box root 'rclone-test-xumitok0zehi': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/17 05:29:56 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352543119")
2025/04/17 05:29:57 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352543369")
    fstests.go:931: Try 2/10 waiting for dirChanges and objChanges
2025/04/17 05:29:57 DEBUG : box root 'rclone-test-xumitok0zehi': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1836723801423|78bb90d1896ba4d924c1b3b911692bfa9ce04398] ignored due to old SequenceID ('\x01')
2025/04/17 05:29:57 DEBUG : box root 'rclone-test-xumitok0zehi': Received 2 events, resulting in 0 paths and 0 notifications
2025/04/17 05:29:57 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352544111")
2025/04/17 05:29:57 DEBUG : box root 'rclone-test-xumitok0zehi': ["file3.rclone_chunk.002"(1)|file|ITEM_RENAME|1836710879306|7d0ea7298b1d04ef716e205d402f73ae0f4dfaaf] ignored due to old SequenceID ('\x01')
2025/04/17 05:29:57 DEBUG : box root 'rclone-test-xumitok0zehi': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/17 05:29:57 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352544346")
2025/04/17 05:29:58 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352544576")
2025/04/17 05:29:59 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352545100")
2025/04/17 05:29:59 DEBUG : box root 'rclone-test-xumitok0zehi': Received 2 events, resulting in 0 paths and 0 notifications
2025/04/17 05:29:59 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352546111")
2025/04/17 05:30:00 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352546357")
    fstests.go:931: Try 3/10 waiting for dirChanges and objChanges
2025/04/17 05:30:01 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352547110")
2025/04/17 05:30:01 DEBUG : box root 'rclone-test-xumitok0zehi': ["file3"(0)|file|ITEM_UPLOAD|1836709182378|b6ca5a5c736d58060e0d008def2eddbceb2e93c9] ignored due to old SequenceID ('\x00')
2025/04/17 05:30:01 DEBUG : box root 'rclone-test-xumitok0zehi': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/17 05:30:01 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352548111")
2025/04/17 05:30:01 DEBUG : box root 'rclone-test-xumitok0zehi': Received 2 events, resulting in 0 paths and 0 notifications
2025/04/17 05:30:01 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352548352")
2025/04/17 05:30:02 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352548612")
2025/04/17 05:30:03 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352549101")
    fstests.go:931: Try 4/10 waiting for dirChanges and objChanges
2025/04/17 05:30:04 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352550102")
2025/04/17 05:30:05 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352551100")
2025/04/17 05:30:05 DEBUG : box root 'rclone-test-xumitok0zehi': ["rclone-test-cunoxam3radi"(0)|folder|ITEM_CREATE|317129017294|767c7bdddcf6b88567571a7c1488e130991590ad] new parent not found
2025/04/17 05:30:05 DEBUG : box root 'rclone-test-xumitok0zehi': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/17 05:30:05 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352552111")
2025/04/17 05:30:06 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352552368")
    fstests.go:931: Try 5/10 waiting for dirChanges and objChanges
2025/04/17 05:30:07 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352553102")
2025/04/17 05:30:08 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352554104")
2025/04/17 05:30:09 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352555109")
    fstests.go:931: Try 6/10 waiting for dirChanges and objChanges
2025/04/17 05:30:10 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352556104")
2025/04/17 05:30:11 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352557105")
2025/04/17 05:30:12 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352558113")
    fstests.go:931: Try 7/10 waiting for dirChanges and objChanges
2025/04/17 05:30:13 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352559114")
2025/04/17 05:30:14 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352560104")
2025/04/17 05:30:14 DEBUG : box root 'rclone-test-xumitok0zehi': ["rclone-test-wiliqox4yace"(0)|folder|ITEM_CREATE|317124255708|19ea01fa127242b61dd43bb3594f00bcf5cb005b] new parent not found
2025/04/17 05:30:14 DEBUG : box root 'rclone-test-xumitok0zehi': ["hello, world!.rclone_chunk.001_uq7suo"(0)|file|ITEM_UPLOAD|1836718659867|9c462d64446b8ce6a55c4d451dd1282f7ae86eed] new parent not found
2025/04/17 05:30:14 DEBUG : box root 'rclone-test-xumitok0zehi': Received 2 events, resulting in 0 paths and 0 notifications
2025/04/17 05:30:14 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352561105")
2025/04/17 05:30:15 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352561376")
    fstests.go:931: Try 8/10 waiting for dirChanges and objChanges
2025/04/17 05:30:15 DEBUG : box root 'rclone-test-xumitok0zehi': ["HELLO, WORLD!.rclone_chunk.001_uq80w0"(0)|file|ITEM_UPLOAD|1836716229507|285312d41d45342f2bca47f7840b41c9e6b7b0b3] new parent not found
2025/04/17 05:30:15 DEBUG : box root 'rclone-test-xumitok0zehi': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/17 05:30:15 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352562110")
2025/04/17 05:30:16 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352562347")
2025/04/17 05:30:17 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352563103")
2025/04/17 05:30:17 DEBUG : box root 'rclone-test-xumitok0zehi': ["hello, world!"(1)|file|ITEM_RENAME|1836718659867|a5f88e7da18d84bbbaffbe62480765d4e9a1f541] new parent not found
2025/04/17 05:30:17 DEBUG : box root 'rclone-test-xumitok0zehi': ["HELLO, WORLD!"(1)|file|ITEM_RENAME|1836716229507|2a5b8528fc87445b4b77628dec677f6ef31ab9ad] new parent not found
2025/04/17 05:30:17 DEBUG : box root 'rclone-test-xumitok0zehi': Received 2 events, resulting in 0 paths and 0 notifications
2025/04/17 05:30:17 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352564101")
2025/04/17 05:30:18 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352564352")
    fstests.go:931: Try 9/10 waiting for dirChanges and objChanges
2025/04/17 05:30:19 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352565104")
2025/04/17 05:30:20 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352566108")
2025/04/17 05:30:21 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352567192")
    fstests.go:935: map[dir:{} dir/subdir1:{} dir/subdir3:{}] does not contain [dir/subdir1 dir/subdir3 dir/subdir2] or 
        map[] does not contain [dir/file2 dir/file4 dir/file3]
2025/04/17 05:30:22 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352568122")
2025/04/17 05:30:22 DEBUG : box root 'rclone-test-xumitok0zehi': ["rclone-test-gaqejoq2wize"(0)|folder|ITEM_CREATE|317126113619|173c713fad313982de1ffb8ea7118a705b6f08cb] new parent not found
2025/04/17 05:30:22 DEBUG : box root 'rclone-test-xumitok0zehi': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/17 05:30:22 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352569098")
2025/04/17 05:30:23 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352569339")
2025/04/17 05:30:24 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352570105")
2025/04/17 05:30:25 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352571108")
2025/04/17 05:30:25 DEBUG : box root 'rclone-test-xumitok0zehi': ["HeLlO, wOrLd!.rclone_chunk.001_uq8akh"(0)|file|ITEM_UPLOAD|1836714405071|cddac17d9055c8fb0dfb1a64f5ecb8ef6eed23b9] new parent not found
2025/04/17 05:30:25 DEBUG : box root 'rclone-test-xumitok0zehi': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/17 05:30:25 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352572103")
2025/04/17 05:30:26 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352572345")
2025/04/17 05:30:26 DEBUG : box root 'rclone-test-xumitok0zehi': ["HeLlO, wOrLd!"(1)|file|ITEM_RENAME|1836714405071|abb1b530a00ad221b61cabb9debcbdb433b0f1f9] new parent not found
2025/04/17 05:30:26 DEBUG : box root 'rclone-test-xumitok0zehi': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/17 05:30:26 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352573114")
2025/04/17 05:30:27 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352573355")
2025/04/17 05:30:28 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352574103")
2025/04/17 05:30:29 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352575104")
2025/04/17 05:30:29 DEBUG : box root 'rclone-test-xumitok0zehi': ["file2"(1)|file|ITEM_TRASH|1836720148708|ce51b46e4a7c73043f33d31d5cfac50168760386] added old path ("dir/file2") for notify
2025/04/17 05:30:29 DEBUG : doChangeNotify("dir/file2", 1)
2025/04/17 05:30:29 DEBUG : box root 'rclone-test-xumitok0zehi': Received 1 events, resulting in 1 paths and 1 notifications
2025/04/17 05:30:29 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352576108")
2025/04/17 05:30:30 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352576346")
2025/04/17 05:30:31 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352577106")
2025/04/17 05:30:31 DEBUG : box root 'rclone-test-xumitok0zehi': ["file2.rclone_chunk.001"(2)|file|ITEM_TRASH|1836716024944|fcd4a386a4ff2bf08e96db2af8338c7b15797110] added old path ("dir/file2.rclone_chunk.001") for notify
2025/04/17 05:30:31 DEBUG : box root 'rclone-test-xumitok0zehi': ["file2.rclone_chunk.002"(2)|file|ITEM_TRASH|1836710893332|f552c7a4c41ca31e0359b32b085a2c672b24bd63] added old path ("dir/file2.rclone_chunk.002") for notify
2025/04/17 05:30:31 DEBUG : doChangeNotify("dir/file2", 1)
2025/04/17 05:30:31 DEBUG : doChangeNotify("dir/file2", 1)
2025/04/17 05:30:31 DEBUG : box root 'rclone-test-xumitok0zehi': Received 2 events, resulting in 2 paths and 2 notifications
2025/04/17 05:30:31 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352578107")
2025/04/17 05:30:32 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352578350")
2025/04/17 05:30:33 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352579112")
2025/04/17 05:30:33 DEBUG : box root 'rclone-test-xumitok0zehi': ["rclone-test-cecalat2cawi"(0)|folder|ITEM_CREATE|317131048331|ece61908dace130732bd1024662bd7d1f6941264] new parent not found
2025/04/17 05:30:33 DEBUG : box root 'rclone-test-xumitok0zehi': ["file4"(1)|file|ITEM_TRASH|1836719522212|c00d474ac2eff4e470888503f38b407f82c23771] added old path ("dir/file4") for notify
2025/04/17 05:30:33 DEBUG : doChangeNotify("dir/file4", 1)
2025/04/17 05:30:33 DEBUG : box root 'rclone-test-xumitok0zehi': Received 2 events, resulting in 1 paths and 1 notifications
2025/04/17 05:30:33 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352580107")
2025/04/17 05:30:34 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352580342")
2025/04/17 05:30:35 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352581104")
2025/04/17 05:30:35 DEBUG : box root 'rclone-test-xumitok0zehi': ["HELLO, WORLD!.rclone_chunk.001_uq8jgr"(0)|file|ITEM_UPLOAD|1836723805450|1607ccf30f5aef5f70ce0a4df832ba285948217e] new parent not found
2025/04/17 05:30:35 DEBUG : box root 'rclone-test-xumitok0zehi': ["file4.rclone_chunk.001"(2)|file|ITEM_TRASH|1836711740595|8550278bd19f732b09843e6318795ff437c7c3d3] added old path ("dir/file4.rclone_chunk.001") for notify
2025/04/17 05:30:35 DEBUG : doChangeNotify("dir/file4", 1)
2025/04/17 05:30:35 DEBUG : box root 'rclone-test-xumitok0zehi': Received 2 events, resulting in 1 paths and 1 notifications
2025/04/17 05:30:35 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352582103")
2025/04/17 05:30:36 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352582345")
2025/04/17 05:30:36 DEBUG : box root 'rclone-test-xumitok0zehi': ["file4.rclone_chunk.002"(2)|file|ITEM_TRASH|1836725347013|fec75a84df1552bf15ded5779e147627da883256] added old path ("dir/file4.rclone_chunk.002") for notify
2025/04/17 05:30:36 DEBUG : box root 'rclone-test-xumitok0zehi': ["HELLO, WORLD!"(1)|file|ITEM_RENAME|1836723805450|1f79ecf2149a841ed70e22e65e2aaa3992354228] new parent not found
2025/04/17 05:30:36 DEBUG : doChangeNotify("dir/file4", 1)
2025/04/17 05:30:36 DEBUG : box root 'rclone-test-xumitok0zehi': Received 2 events, resulting in 1 paths and 1 notifications
2025/04/17 05:30:36 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352583105")
2025/04/17 05:30:37 DEBUG : box root 'rclone-test-xumitok0zehi': Checking for changes on remote (next_stream_position: "30401042352583349")
2025/04/17 05:30:38 DEBUG : box root 'rclone-test-xumitok0zehi': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/04/17 05:30:38 ERROR : : error listing: directory not found
2025/04/17 05:30:39 DEBUG : box root 'rclone-test-xumitok0zehi': Ignoring "Shared folder — ForNick" - unknown type "web_link"
--- FAIL: TestIntegration (78.27s)
    --- FAIL: TestIntegration/FsMkdir (74.75s)
        --- FAIL: TestIntegration/FsMkdir/FsChangeNotify (72.33s)
FAIL
exit status 1
FAIL	github.com/rclone/rclone/backend/chunker	78.445s
"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024 -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Finished ERROR in 1m26.750492366s (try 2/5): exit status 1: Failed [TestIntegration/FsMkdir/FsChangeNotify]