"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024 -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Starting (try 2/5) === RUN TestIntegration fstests.go:438: Using remote "TestChunkerChunk50bBox:" 2025/05/10 06:29:58 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-baxusoz1wuze" 2025/05/10 06:29:58 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/05/10 06:29:58 DEBUG : Creating backend with remote "TestBox:rclone-test-baxusoz1wuze" 2025/05/10 06:29:59 DEBUG : box root 'rclone-test-baxusoz1wuze': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/05/10 06:30:00 DEBUG : box root 'rclone-test-baxusoz1wuze': Ignoring "Shared folder — ForNick" - unknown type "web_link" === RUN TestIntegration/FsMkdir === RUN TestIntegration/FsMkdir/FsChangeNotify 2025/05/10 06:30:01 INFO : dir: Making directory 2025/05/10 06:30:02 INFO : dir/subdir1: Making directory 2025/05/10 06:30:03 INFO : dir/subdir3: Making directory 2025/05/10 06:30:03 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343348955") 2025/05/10 06:30:03 DEBUG : box root 'rclone-test-baxusoz1wuze': Received 1 events, resulting in 0 paths and 0 notifications 2025/05/10 06:30:03 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343350170") 2025/05/10 06:30:03 INFO : dir/subdir2: Making directory 2025/05/10 06:30:04 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343350390") 2025/05/10 06:30:04 DEBUG : box root 'rclone-test-baxusoz1wuze': Received 1 events, resulting in 0 paths and 0 notifications 2025/05/10 06:30:04 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343351178") 2025/05/10 06:30:05 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343351403") 2025/05/10 06:30:06 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343352170") 2025/05/10 06:30:06 DEBUG : box root 'rclone-test-baxusoz1wuze': ["rclone-test-baxusoz1wuze"(0)|folder|ITEM_CREATE|320578099193|16fb740d6f348a77c1adf36416117083a869ab32] new parent not found 2025/05/10 06:30:06 DEBUG : box root 'rclone-test-baxusoz1wuze': Received 2 events, resulting in 0 paths and 0 notifications 2025/05/10 06:30:06 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343353172") 2025/05/10 06:30:07 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343353396") 2025/05/10 06:30:08 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343354171") 2025/05/10 06:30:08 DEBUG : box root 'rclone-test-baxusoz1wuze': ["dir"(0)|folder|ITEM_CREATE|320578487299|9fa54687a20c1134ed6e1a92f54e0bf0cbde2079] new parent not found 2025/05/10 06:30:08 DEBUG : box root 'rclone-test-baxusoz1wuze': Received 1 events, resulting in 0 paths and 0 notifications 2025/05/10 06:30:08 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343355168") 2025/05/10 06:30:08 DEBUG : box root 'rclone-test-baxusoz1wuze': ["file1.rclone_chunk.001_1ec8jh"(0)|file|ITEM_UPLOAD|1858258254851|3a586eca31d49f74e22089e0bc2eada012e788b9] new parent not found 2025/05/10 06:30:08 DEBUG : box root 'rclone-test-baxusoz1wuze': ["dir"(0)|folder|ITEM_CREATE|320575948033|91d39052be9645b7b7ef67776f28a879d9a41678] added new path ("dir") for notify 2025/05/10 06:30:08 DEBUG : doChangeNotify("dir", 0) 2025/05/10 06:30:08 DEBUG : box root 'rclone-test-baxusoz1wuze': Received 2 events, resulting in 1 paths and 1 notifications 2025/05/10 06:30:08 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343355392") 2025/05/10 06:30:08 DEBUG : box root 'rclone-test-baxusoz1wuze': ["subdir1"(0)|folder|ITEM_CREATE|320577879641|dea6746e036d530803b920db0c6a16355d04c2f3] added new path ("dir/subdir1") for notify 2025/05/10 06:30:08 DEBUG : doChangeNotify("dir/subdir1", 0) 2025/05/10 06:30:08 DEBUG : box root 'rclone-test-baxusoz1wuze': Received 1 events, resulting in 1 paths and 1 notifications 2025/05/10 06:30:08 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343355618") 2025/05/10 06:30:09 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343355838") 2025/05/10 06:30:09 INFO : dir/file2.rclone_chunk.001_1ecdf1: Moved (server-side) to: dir/file2.rclone_chunk.001 2025/05/10 06:30:09 INFO : dir/file2.rclone_chunk.002_1ecdf1: Moved (server-side) to: dir/file2.rclone_chunk.002 2025/05/10 06:30:10 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343356175") 2025/05/10 06:30:10 DEBUG : box root 'rclone-test-baxusoz1wuze': ["subdir3"(0)|folder|ITEM_CREATE|320575374651|e5cc2d5f61cabc1e3c60fe92f06335ef3401fab2] added new path ("dir/subdir3") for notify 2025/05/10 06:30:10 DEBUG : box root 'rclone-test-baxusoz1wuze': ["file1"(1)|file|ITEM_RENAME|1858258254851|0957afdac98e6dfb5aaadc76d8ad1b09eff15648] new parent not found 2025/05/10 06:30:10 DEBUG : box root 'rclone-test-baxusoz1wuze': ["subdir2"(0)|folder|ITEM_CREATE|320575650508|bc3a0a5b68ba8e040e7d715d1f39fcc77c506e53] added new path ("dir/subdir2") for notify 2025/05/10 06:30:10 DEBUG : doChangeNotify("dir/subdir3", 0) 2025/05/10 06:30:10 DEBUG : doChangeNotify("dir/subdir2", 0) 2025/05/10 06:30:10 DEBUG : box root 'rclone-test-baxusoz1wuze': Received 3 events, resulting in 2 paths and 2 notifications 2025/05/10 06:30:10 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343357171") 2025/05/10 06:30:11 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343357399") 2025/05/10 06:30:12 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343358171") 2025/05/10 06:30:13 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343359177") 2025/05/10 06:30:13 DEBUG : box root 'rclone-test-baxusoz1wuze': ["file2.rclone_chunk.001_1ecdf1"(0)|file|ITEM_UPLOAD|1858248865927|1d036039d771dbec72c7cd9f6ad5fe8e2cb065fb] ignored due to old SequenceID ('\x01') 2025/05/10 06:30:13 DEBUG : box root 'rclone-test-baxusoz1wuze': Received 2 events, resulting in 0 paths and 0 notifications 2025/05/10 06:30:13 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343360170") 2025/05/10 06:30:13 DEBUG : box root 'rclone-test-baxusoz1wuze': Received 1 events, resulting in 0 paths and 0 notifications 2025/05/10 06:30:13 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343360398") 2025/05/10 06:30:14 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343360620") 2025/05/10 06:30:15 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343361170") 2025/05/10 06:30:15 DEBUG : box root 'rclone-test-baxusoz1wuze': ["file2.rclone_chunk.002_1ecdf1"(0)|file|ITEM_UPLOAD|1858257875981|136e00c16c81c1f8322bd8ab0e06c1160071f61e] ignored due to old SequenceID ('\x01') 2025/05/10 06:30:15 DEBUG : box root 'rclone-test-baxusoz1wuze': ["file2.rclone_chunk.001"(1)|file|ITEM_RENAME|1858248865927|a58c6b10cb6a9459d5ae5c241b9b88f2f744e843] ignored due to old SequenceID ('\x01') 2025/05/10 06:30:15 DEBUG : box root 'rclone-test-baxusoz1wuze': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1858257875981|256c8bf29cfc215781fe90cc567d8f575deaac70] ignored due to old SequenceID ('\x01') 2025/05/10 06:30:15 DEBUG : box root 'rclone-test-baxusoz1wuze': Received 3 events, resulting in 0 paths and 0 notifications 2025/05/10 06:30:15 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343362174") 2025/05/10 06:30:16 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343362398") 2025/05/10 06:30:16 INFO : dir/file4.rclone_chunk.001_1eck0x: Moved (server-side) to: dir/file4.rclone_chunk.001 2025/05/10 06:30:16 INFO : dir/file4.rclone_chunk.002_1eck0x: Moved (server-side) to: dir/file4.rclone_chunk.002 2025/05/10 06:30:17 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343363171") 2025/05/10 06:30:17 DEBUG : box root 'rclone-test-baxusoz1wuze': ["file2"(0)|file|ITEM_UPLOAD|1858258122885|d361239145d3046de0039743af77a853cccad79f] ignored due to old SequenceID ('\x00') 2025/05/10 06:30:17 DEBUG : box root 'rclone-test-baxusoz1wuze': ["dir"(0)|folder|ITEM_CREATE|320577724348|c003f363615410b55982b57667b71284b7955946] new parent not found 2025/05/10 06:30:17 DEBUG : box root 'rclone-test-baxusoz1wuze': ["file1.rclone_chunk.001_1ecgog"(0)|file|ITEM_UPLOAD|1858251510200|d49d9a88fb1cd99a409aaa6e745e74dc21485b98] new parent not found 2025/05/10 06:30:17 DEBUG : box root 'rclone-test-baxusoz1wuze': Received 3 events, resulting in 0 paths and 0 notifications 2025/05/10 06:30:17 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343364174") 2025/05/10 06:30:18 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343364402") 2025/05/10 06:30:18 DEBUG : box root 'rclone-test-baxusoz1wuze': ["file1"(1)|file|ITEM_RENAME|1858251510200|600a59530488a33d99046951b900ce533614d3c8] new parent not found 2025/05/10 06:30:18 DEBUG : box root 'rclone-test-baxusoz1wuze': Received 1 events, resulting in 0 paths and 0 notifications 2025/05/10 06:30:18 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343365169") 2025/05/10 06:30:19 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343365386") 2025/05/10 06:30:19 DEBUG : box root 'rclone-test-baxusoz1wuze': ["file4.rclone_chunk.001_1eck0x"(0)|file|ITEM_UPLOAD|1858247202006|275a68cb4f5de82224a8cb31ee6b5d44fe961e2c] ignored due to old SequenceID ('\x01') 2025/05/10 06:30:19 DEBUG : box root 'rclone-test-baxusoz1wuze': Received 1 events, resulting in 0 paths and 0 notifications 2025/05/10 06:30:19 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343366169") 2025/05/10 06:30:20 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343366389") 2025/05/10 06:30:20 DEBUG : box root 'rclone-test-baxusoz1wuze': ["file2.rclone_chunk.001_1eckcg"(0)|file|ITEM_UPLOAD|1858250528798|fce1a7e93b58884e9ebe1f62fdf92bde49b29a34] new parent not found 2025/05/10 06:30:20 DEBUG : box root 'rclone-test-baxusoz1wuze': Received 1 events, resulting in 0 paths and 0 notifications 2025/05/10 06:30:20 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343367171") 2025/05/10 06:30:20 DEBUG : box root 'rclone-test-baxusoz1wuze': ["file2"(1)|file|ITEM_RENAME|1858250528798|ae49c08287ddcd60b7b1a7943964667e52f0850b] new parent not found 2025/05/10 06:30:20 DEBUG : box root 'rclone-test-baxusoz1wuze': Received 1 events, resulting in 0 paths and 0 notifications 2025/05/10 06:30:20 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343367392") 2025/05/10 06:30:21 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343367613") 2025/05/10 06:30:21 DEBUG : box root 'rclone-test-baxusoz1wuze': ["file4.rclone_chunk.002_1eck0x"(0)|file|ITEM_UPLOAD|1858258984580|ff4af186af797e53bd74bf26b9f11acbdb564664] ignored due to old SequenceID ('\x01') 2025/05/10 06:30:21 DEBUG : box root 'rclone-test-baxusoz1wuze': Received 1 events, resulting in 0 paths and 0 notifications 2025/05/10 06:30:21 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343368174") 2025/05/10 06:30:22 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343368395") 2025/05/10 06:30:22 DEBUG : box root 'rclone-test-baxusoz1wuze': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1858247202006|727cff1dbd5f67d21cd33d3b635da0ef4a046a36] ignored due to old SequenceID ('\x01') 2025/05/10 06:30:22 DEBUG : box root 'rclone-test-baxusoz1wuze': Received 1 events, resulting in 0 paths and 0 notifications 2025/05/10 06:30:22 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343369172") 2025/05/10 06:30:23 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343369399") 2025/05/10 06:30:23 INFO : dir/file3.rclone_chunk.001_1ecrvh: Moved (server-side) to: dir/file3.rclone_chunk.001 2025/05/10 06:30:23 DEBUG : box root 'rclone-test-baxusoz1wuze': ["subdir"(0)|folder|ITEM_CREATE|320577431892|0b0b29187db90d4352326776a2f622077d011ef3] new parent not found 2025/05/10 06:30:23 DEBUG : box root 'rclone-test-baxusoz1wuze': Received 1 events, resulting in 0 paths and 0 notifications 2025/05/10 06:30:23 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343370169") 2025/05/10 06:30:23 INFO : dir/file3.rclone_chunk.002_1ecrvh: Moved (server-side) to: dir/file3.rclone_chunk.002 2025/05/10 06:30:24 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343370417") 2025/05/10 06:30:25 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343371170") 2025/05/10 06:30:25 DEBUG : box root 'rclone-test-baxusoz1wuze': ["file4.rclone_chunk.002"(1)|file|ITEM_RENAME|1858258984580|91697aec8ddb42bd7b9e66f48e019dc70e270535] ignored due to old SequenceID ('\x01') 2025/05/10 06:30:25 DEBUG : box root 'rclone-test-baxusoz1wuze': ["file3.rclone_chunk.001_1ecn9l"(0)|file|ITEM_UPLOAD|1858248244533|0034cfc331421141538aef56ebb0a0fb9328a16e] new parent not found 2025/05/10 06:30:25 DEBUG : box root 'rclone-test-baxusoz1wuze': ["file4"(0)|file|ITEM_UPLOAD|1858253967731|c48b00dbdc960a2f60e91b81b4e56aa07e5139dd] ignored due to old SequenceID ('\x00') 2025/05/10 06:30:25 DEBUG : box root 'rclone-test-baxusoz1wuze': ["file3"(1)|file|ITEM_RENAME|1858248244533|fdfb55774bb33eeecf9f7bd4b49c06fc3ddf7c1e] new parent not found 2025/05/10 06:30:25 DEBUG : box root 'rclone-test-baxusoz1wuze': Received 4 events, resulting in 0 paths and 0 notifications 2025/05/10 06:30:25 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343372168") fstests.go:931: Try 1/10 waiting for dirChanges and objChanges 2025/05/10 06:30:26 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343372408") 2025/05/10 06:30:27 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343373171") 2025/05/10 06:30:27 DEBUG : box root 'rclone-test-baxusoz1wuze': ["file3.rclone_chunk.001_1ecrvh"(0)|file|ITEM_UPLOAD|1858251633369|ba12c3974d279ac64c83e9885df09d0c725c99f6] ignored due to old SequenceID ('\x01') 2025/05/10 06:30:27 DEBUG : box root 'rclone-test-baxusoz1wuze': Received 1 events, resulting in 0 paths and 0 notifications 2025/05/10 06:30:27 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343374167") 2025/05/10 06:30:28 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343374394") fstests.go:931: Try 2/10 waiting for dirChanges and objChanges 2025/05/10 06:30:29 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343375174") 2025/05/10 06:30:29 DEBUG : box root 'rclone-test-baxusoz1wuze': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1858251633369|739d8d51d3f9a742eb6c45f028ffd93edba370a8] ignored due to old SequenceID ('\x01') 2025/05/10 06:30:29 DEBUG : box root 'rclone-test-baxusoz1wuze': ["virtualFile.rclone_chunk.001_1ecu1y"(0)|file|ITEM_UPLOAD|1858248575321|5617de755c4e4f409132460d9bc26400fbb0b8e9] new parent not found 2025/05/10 06:30:29 DEBUG : box root 'rclone-test-baxusoz1wuze': ["file3.rclone_chunk.002"(1)|file|ITEM_RENAME|1858249394071|6606516966efe805e8eaa692bedb8ed176195f14] ignored due to old SequenceID ('\x01') 2025/05/10 06:30:29 DEBUG : box root 'rclone-test-baxusoz1wuze': ["file3.rclone_chunk.002_1ecrvh"(0)|file|ITEM_UPLOAD|1858249394071|ce8a63e55f621367d358b021d13a3f100facc4e2] ignored due to old SequenceID ('\x01') 2025/05/10 06:30:29 DEBUG : box root 'rclone-test-baxusoz1wuze': Received 4 events, resulting in 0 paths and 0 notifications 2025/05/10 06:30:29 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343376170") 2025/05/10 06:30:30 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343376412") 2025/05/10 06:30:31 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343377170") 2025/05/10 06:30:31 DEBUG : box root 'rclone-test-baxusoz1wuze': ["virtualFile"(1)|file|ITEM_RENAME|1858248575321|d1f68177e0876118565e6d77d416061e17df0c0e] new parent not found 2025/05/10 06:30:31 DEBUG : box root 'rclone-test-baxusoz1wuze': ["file3"(0)|file|ITEM_UPLOAD|1858257949660|3cd630a1d6bb7a8410683f98cb653d5c3d77e258] ignored due to old SequenceID ('\x00') 2025/05/10 06:30:31 DEBUG : box root 'rclone-test-baxusoz1wuze': Received 2 events, resulting in 0 paths and 0 notifications 2025/05/10 06:30:31 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343378180") fstests.go:931: Try 3/10 waiting for dirChanges and objChanges 2025/05/10 06:30:32 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343378405") 2025/05/10 06:30:33 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343379169") 2025/05/10 06:30:33 DEBUG : box root 'rclone-test-baxusoz1wuze': ["virtualDir"(0)|folder|ITEM_CREATE|320577299264|dc3f8647dfd3228c2471d8fd72f82aae32d3c781] new parent not found 2025/05/10 06:30:33 DEBUG : box root 'rclone-test-baxusoz1wuze': Received 1 events, resulting in 0 paths and 0 notifications 2025/05/10 06:30:33 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343380169") 2025/05/10 06:30:33 DEBUG : box root 'rclone-test-baxusoz1wuze': ["testFile.rclone_chunk.001_1ecxme"(0)|file|ITEM_UPLOAD|1858259134839|9364d732a4c9cf4d7530a05ee9ea186d5c30af88] new parent not found 2025/05/10 06:30:33 DEBUG : box root 'rclone-test-baxusoz1wuze': Received 1 events, resulting in 0 paths and 0 notifications 2025/05/10 06:30:33 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343380387") 2025/05/10 06:30:34 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343380609") fstests.go:931: Try 4/10 waiting for dirChanges and objChanges 2025/05/10 06:30:35 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343381176") 2025/05/10 06:30:35 DEBUG : box root 'rclone-test-baxusoz1wuze': ["testFile"(1)|file|ITEM_RENAME|1858259134839|874ef8aac1afc737f70901e1d8518c04acb30314] new parent not found 2025/05/10 06:30:35 DEBUG : box root 'rclone-test-baxusoz1wuze': Received 1 events, resulting in 0 paths and 0 notifications 2025/05/10 06:30:35 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343382169") 2025/05/10 06:30:36 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343382390") 2025/05/10 06:30:37 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343383170") 2025/05/10 06:30:37 DEBUG : box root 'rclone-test-baxusoz1wuze': Received 3 events, resulting in 0 paths and 0 notifications 2025/05/10 06:30:37 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343384171") fstests.go:931: Try 5/10 waiting for dirChanges and objChanges 2025/05/10 06:30:38 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343384397") 2025/05/10 06:30:39 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343385174") 2025/05/10 06:30:40 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343386172") 2025/05/10 06:30:40 DEBUG : box root 'rclone-test-baxusoz1wuze': Received 1 events, resulting in 0 paths and 0 notifications 2025/05/10 06:30:40 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343387173") fstests.go:931: Try 6/10 waiting for dirChanges and objChanges 2025/05/10 06:30:41 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343387397") 2025/05/10 06:30:42 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343388170") 2025/05/10 06:30:42 DEBUG : box root 'rclone-test-baxusoz1wuze': Received 1 events, resulting in 0 paths and 0 notifications 2025/05/10 06:30:42 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343389172") 2025/05/10 06:30:43 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343389396") 2025/05/10 06:30:43 DEBUG : box root 'rclone-test-baxusoz1wuze': Received 2 events, resulting in 0 paths and 0 notifications 2025/05/10 06:30:43 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343390169") fstests.go:931: Try 7/10 waiting for dirChanges and objChanges 2025/05/10 06:30:44 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343390393") 2025/05/10 06:30:44 DEBUG : box root 'rclone-test-baxusoz1wuze': Received 1 events, resulting in 0 paths and 0 notifications 2025/05/10 06:30:44 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343391168") 2025/05/10 06:30:45 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343391388") 2025/05/10 06:30:46 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343392171") fstests.go:931: Try 8/10 waiting for dirChanges and objChanges 2025/05/10 06:30:47 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343393168") 2025/05/10 06:30:47 DEBUG : box root 'rclone-test-baxusoz1wuze': ["dir"(0)|folder|ITEM_CREATE|320578674122|3fc1c3b5af5c5cb96f69e8011b5a0668c9c92e1f] new parent not found 2025/05/10 06:30:47 DEBUG : box root 'rclone-test-baxusoz1wuze': Received 1 events, resulting in 0 paths and 0 notifications 2025/05/10 06:30:47 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343394170") 2025/05/10 06:30:47 DEBUG : box root 'rclone-test-baxusoz1wuze': ["file1.rclone_chunk.001_1eda49"(0)|file|ITEM_UPLOAD|1858259336826|6f74aa7b858bd57833d9ce7517c419c04a0d4ebe] new parent not found 2025/05/10 06:30:47 DEBUG : box root 'rclone-test-baxusoz1wuze': Received 1 events, resulting in 0 paths and 0 notifications 2025/05/10 06:30:47 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343394399") 2025/05/10 06:30:48 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343394621") 2025/05/10 06:30:49 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343395170") 2025/05/10 06:30:49 DEBUG : box root 'rclone-test-baxusoz1wuze': ["file1"(1)|file|ITEM_RENAME|1858259336826|befe137e9671a0176fff069076d4c6c31bef7974] new parent not found 2025/05/10 06:30:49 DEBUG : box root 'rclone-test-baxusoz1wuze': Received 1 events, resulting in 0 paths and 0 notifications 2025/05/10 06:30:49 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343396170") fstests.go:931: Try 9/10 waiting for dirChanges and objChanges 2025/05/10 06:30:50 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343396390") 2025/05/10 06:30:51 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343397170") 2025/05/10 06:30:51 DEBUG : box root 'rclone-test-baxusoz1wuze': Received 1 events, resulting in 0 paths and 0 notifications 2025/05/10 06:30:51 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343398176") 2025/05/10 06:30:52 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343398392") 2025/05/10 06:30:52 DEBUG : box root 'rclone-test-baxusoz1wuze': Received 1 events, resulting in 0 paths and 0 notifications 2025/05/10 06:30:52 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343399172") 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/10 06:30:53 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343399393") 2025/05/10 06:30:54 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343400172") 2025/05/10 06:30:54 DEBUG : box root 'rclone-test-baxusoz1wuze': ["file1.rclone_chunk.001_1edipb"(0)|file|ITEM_UPLOAD|1858250980553|432babd05fc143cdad94ef6bb6f9de53a00b9b02] new parent not found 2025/05/10 06:30:54 DEBUG : box root 'rclone-test-baxusoz1wuze': Received 1 events, resulting in 0 paths and 0 notifications 2025/05/10 06:30:54 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343401169") 2025/05/10 06:30:55 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343401399") 2025/05/10 06:30:56 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343402169") 2025/05/10 06:30:56 DEBUG : box root 'rclone-test-baxusoz1wuze': ["dir"(0)|folder|ITEM_CREATE|320577098266|f64471e118dd9a79ada01592be6528781e0031ea] new parent not found 2025/05/10 06:30:56 DEBUG : box root 'rclone-test-baxusoz1wuze': ["file1"(1)|file|ITEM_RENAME|1858250980553|55176d0dafbab21cb3f11e8bbc75a1e259963abd] new parent not found 2025/05/10 06:30:56 DEBUG : box root 'rclone-test-baxusoz1wuze': Received 2 events, resulting in 0 paths and 0 notifications 2025/05/10 06:30:56 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343403169") 2025/05/10 06:30:57 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343403394") 2025/05/10 06:30:58 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343404170") 2025/05/10 06:30:59 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343405167") 2025/05/10 06:31:00 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343406174") 2025/05/10 06:31:01 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343407171") 2025/05/10 06:31:01 DEBUG : box root 'rclone-test-baxusoz1wuze': ["potato.rclone_chunk.001_1ednxl"(0)|file|ITEM_UPLOAD|1858251993059|aa8cb727b5587e999611bb1d0e84333947afdeaf] new parent not found 2025/05/10 06:31:01 DEBUG : box root 'rclone-test-baxusoz1wuze': ["file2"(1)|file|ITEM_TRASH|1858258122885|6eacc0387fd59d07cb008fe5c85613a87a961f58] added old path ("dir/file2") for notify 2025/05/10 06:31:01 DEBUG : doChangeNotify("dir/file2", 1) 2025/05/10 06:31:01 DEBUG : box root 'rclone-test-baxusoz1wuze': Received 2 events, resulting in 1 paths and 1 notifications 2025/05/10 06:31:01 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343408171") 2025/05/10 06:31:02 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343408405") 2025/05/10 06:31:02 DEBUG : box root 'rclone-test-baxusoz1wuze': ["potato"(1)|file|ITEM_RENAME|1858251993059|e405c94163a5ce8a605c372d37f6dd0619d41f47] new parent not found 2025/05/10 06:31:02 DEBUG : box root 'rclone-test-baxusoz1wuze': ["file2.rclone_chunk.002"(2)|file|ITEM_TRASH|1858257875981|a467b517c181936348b8abd960f82d006e16501a] added old path ("dir/file2.rclone_chunk.002") for notify 2025/05/10 06:31:02 DEBUG : doChangeNotify("dir/file2", 1) 2025/05/10 06:31:02 DEBUG : box root 'rclone-test-baxusoz1wuze': Received 4 events, resulting in 1 paths and 1 notifications 2025/05/10 06:31:02 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343409171") 2025/05/10 06:31:02 DEBUG : box root 'rclone-test-baxusoz1wuze': ["file2.rclone_chunk.001"(2)|file|ITEM_TRASH|1858248865927|79b246b9f3132d197f69f0ccb8b1e2a6d90555e9] added old path ("dir/file2.rclone_chunk.001") for notify 2025/05/10 06:31:02 DEBUG : doChangeNotify("dir/file2", 1) 2025/05/10 06:31:02 DEBUG : box root 'rclone-test-baxusoz1wuze': Received 1 events, resulting in 1 paths and 1 notifications 2025/05/10 06:31:02 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343409414") 2025/05/10 06:31:03 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343409636") 2025/05/10 06:31:03 DEBUG : box root 'rclone-test-baxusoz1wuze': Received 1 events, resulting in 0 paths and 0 notifications 2025/05/10 06:31:03 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343410170") 2025/05/10 06:31:04 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343410393") 2025/05/10 06:31:05 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343411172") 2025/05/10 06:31:05 DEBUG : box root 'rclone-test-baxusoz1wuze': ["file4"(1)|file|ITEM_TRASH|1858253967731|37ba906836915e830dd07cbc87568fa3781c82e7] added old path ("dir/file4") for notify 2025/05/10 06:31:05 DEBUG : doChangeNotify("dir/file4", 1) 2025/05/10 06:31:05 DEBUG : box root 'rclone-test-baxusoz1wuze': Received 1 events, resulting in 1 paths and 1 notifications 2025/05/10 06:31:05 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343412175") 2025/05/10 06:31:05 DEBUG : box root 'rclone-test-baxusoz1wuze': ["file4.rclone_chunk.001"(2)|file|ITEM_TRASH|1858247202006|56d2e5b124e8a5655b4c7ea3112ef8cc03dca5ac] added old path ("dir/file4.rclone_chunk.001") for notify 2025/05/10 06:31:05 DEBUG : doChangeNotify("dir/file4", 1) 2025/05/10 06:31:05 DEBUG : box root 'rclone-test-baxusoz1wuze': Received 1 events, resulting in 1 paths and 1 notifications 2025/05/10 06:31:05 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343412395") 2025/05/10 06:31:05 DEBUG : box root 'rclone-test-baxusoz1wuze': ["dir"(0)|folder|ITEM_CREATE|320577769707|afdc6e9779b2d56502d38f0620e2ac85d6a68541] new parent not found 2025/05/10 06:31:05 DEBUG : box root 'rclone-test-baxusoz1wuze': Received 1 events, resulting in 0 paths and 0 notifications 2025/05/10 06:31:05 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343412614") 2025/05/10 06:31:06 DEBUG : box root 'rclone-test-baxusoz1wuze': Checking for changes on remote (next_stream_position: "30401044343412834") 2025/05/10 06:31:08 DEBUG : box root 'rclone-test-baxusoz1wuze': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/05/10 06:31:08 ERROR : : error listing: directory not found 2025/05/10 06:31:08 DEBUG : box root 'rclone-test-baxusoz1wuze': Ignoring "Shared folder — ForNick" - unknown type "web_link" --- FAIL: TestIntegration (69.75s) --- FAIL: TestIntegration/FsMkdir (67.75s) --- FAIL: TestIntegration/FsMkdir/FsChangeNotify (65.74s) FAIL exit status 1 FAIL github.com/rclone/rclone/backend/chunker 69.798s "go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024 -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Finished ERROR in 1m12.565976085s (try 2/5): exit status 1: Failed [TestIntegration/FsMkdir/FsChangeNotify]