"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024 -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Starting (try 3/5)
=== RUN   TestIntegration
    fstests.go:438: Using remote "TestChunkerChunk50bBox:"
2025/05/12 01:38:05 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-daleyih9zuqe"
2025/05/12 01:38:05 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/05/12 01:38:05 DEBUG : Creating backend with remote "TestBox:rclone-test-daleyih9zuqe"
2025/05/12 01:38:06 DEBUG : box root 'rclone-test-daleyih9zuqe': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/05/12 01:38:07 DEBUG : box root 'rclone-test-daleyih9zuqe': Ignoring "Shared folder — ForNick" - unknown type "web_link"
=== RUN   TestIntegration/FsMkdir
=== RUN   TestIntegration/FsMkdir/FsChangeNotify
2025/05/12 01:38:08 INFO  : dir: Making directory
2025/05/12 01:38:10 INFO  : dir/subdir1: Making directory
2025/05/12 01:38:11 INFO  : dir/subdir3: Making directory
2025/05/12 01:38:11 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498636944")
2025/05/12 01:38:12 INFO  : dir/subdir2: Making directory
2025/05/12 01:38:12 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498638165")
2025/05/12 01:38:12 DEBUG : box root 'rclone-test-daleyih9zuqe': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/12 01:38:12 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498639172")
2025/05/12 01:38:13 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498639406")
2025/05/12 01:38:13 DEBUG : box root 'rclone-test-daleyih9zuqe': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/12 01:38:13 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498640176")
2025/05/12 01:38:13 DEBUG : box root 'rclone-test-daleyih9zuqe': ["rclone-test-daleyih9zuqe"(0)|folder|ITEM_CREATE|320747403841|3353abfd3c21bc0558dfb213a4749d2c7c2ad7bf] new parent not found
2025/05/12 01:38:13 DEBUG : box root 'rclone-test-daleyih9zuqe': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/12 01:38:13 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498640407")
2025/05/12 01:38:14 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498640637")
2025/05/12 01:38:15 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498641173")
2025/05/12 01:38:15 DEBUG : box root 'rclone-test-daleyih9zuqe': ["dir"(0)|folder|ITEM_CREATE|320749269557|931c57fe2b442f43fd1048abd170f64d6c3dc8e8] new parent not found
2025/05/12 01:38:15 DEBUG : box root 'rclone-test-daleyih9zuqe': ["dir"(0)|folder|ITEM_CREATE|320746259402|89a6a01234d046f59ac979cbe696ed3fb539b252] added new path ("dir") for notify
2025/05/12 01:38:15 DEBUG : doChangeNotify("dir", 0)
2025/05/12 01:38:15 DEBUG : box root 'rclone-test-daleyih9zuqe': Received 2 events, resulting in 1 paths and 1 notifications
2025/05/12 01:38:15 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498642168")
2025/05/12 01:38:16 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498642403")
2025/05/12 01:38:16 DEBUG : box root 'rclone-test-daleyih9zuqe': ["file1"(0)|file|ITEM_UPLOAD|1859387483849|d9bda56e72ea1cfc0290b4c5fe25250d31e51c58] new parent not found
2025/05/12 01:38:16 DEBUG : box root 'rclone-test-daleyih9zuqe': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/12 01:38:16 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498643171")
2025/05/12 01:38:16 DEBUG : box root 'rclone-test-daleyih9zuqe': ["subdir1"(0)|folder|ITEM_CREATE|320749602541|90f82f5fd5b2c0350af5db25ddd04c82cfe94cb3] added new path ("dir/subdir1") for notify
2025/05/12 01:38:16 DEBUG : doChangeNotify("dir/subdir1", 0)
2025/05/12 01:38:16 DEBUG : box root 'rclone-test-daleyih9zuqe': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/12 01:38:16 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498643405")
2025/05/12 01:38:17 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498643644")
2025/05/12 01:38:17 INFO  : dir/file2.rclone_chunk.001_4q5xo4: Moved (server-side) to: dir/file2.rclone_chunk.001
2025/05/12 01:38:18 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498644219")
2025/05/12 01:38:18 DEBUG : box root 'rclone-test-daleyih9zuqe': ["subdir3"(0)|folder|ITEM_CREATE|320748145374|e7cdfcff8b9665bed250b829f2256730f11f6e10] added new path ("dir/subdir3") for notify
2025/05/12 01:38:18 DEBUG : doChangeNotify("dir/subdir3", 0)
2025/05/12 01:38:18 DEBUG : box root 'rclone-test-daleyih9zuqe': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/12 01:38:18 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498645175")
2025/05/12 01:38:18 INFO  : dir/file2.rclone_chunk.002_4q5xo4: Moved (server-side) to: dir/file2.rclone_chunk.002
2025/05/12 01:38:19 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498645415")
2025/05/12 01:38:19 DEBUG : box root 'rclone-test-daleyih9zuqe': ["subdir2"(0)|folder|ITEM_CREATE|320749917470|a304067d28f4628cd1192f5686e38abc7d1493bc] added new path ("dir/subdir2") for notify
2025/05/12 01:38:19 DEBUG : doChangeNotify("dir/subdir2", 0)
2025/05/12 01:38:19 DEBUG : box root 'rclone-test-daleyih9zuqe': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/12 01:38:19 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498646185")
2025/05/12 01:38:20 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498646419")
2025/05/12 01:38:20 DEBUG : box root 'rclone-test-daleyih9zuqe': ["file1"(1)|file|ITEM_UPLOAD|1859387483849|cbb1703b69feea60d357359cf8ade9b2d69db6ca] new parent not found
2025/05/12 01:38:20 DEBUG : box root 'rclone-test-daleyih9zuqe': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/12 01:38:20 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498647175")
2025/05/12 01:38:21 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498647411")
2025/05/12 01:38:21 DEBUG : box root 'rclone-test-daleyih9zuqe': ["file2.rclone_chunk.001_4q5xo4"(0)|file|ITEM_UPLOAD|1859409367078|19ef2498f5698e817575b2d2b2f645b856c5fd09] ignored due to old SequenceID ('\x01')
2025/05/12 01:38:21 DEBUG : box root 'rclone-test-daleyih9zuqe': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/12 01:38:21 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498648175")
2025/05/12 01:38:22 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498648412")
2025/05/12 01:38:23 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498649168")
2025/05/12 01:38:23 DEBUG : box root 'rclone-test-daleyih9zuqe': ["file2.rclone_chunk.002_4q5xo4"(0)|file|ITEM_UPLOAD|1859402759228|b8f2ab5975439bcd1bf1f8b201d55dac374607d4] ignored due to old SequenceID ('\x01')
2025/05/12 01:38:23 DEBUG : box root 'rclone-test-daleyih9zuqe': ["newLeaf"(2)|file|ITEM_MOVE|1859387483849|f4a2c8c4ddb16d2dc0c34a058784aea5a058faae] new parent not found
2025/05/12 01:38:23 DEBUG : box root 'rclone-test-daleyih9zuqe': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/12 01:38:23 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498650169")
2025/05/12 01:38:24 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498650405")
2025/05/12 01:38:24 DEBUG : box root 'rclone-test-daleyih9zuqe': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1859402759228|951a4542a757d26628112086e2a80cf87fa57dec] ignored due to old SequenceID ('\x01')
2025/05/12 01:38:24 DEBUG : box root 'rclone-test-daleyih9zuqe': ["file1"(3)|file|ITEM_MOVE|1859387483849|1f19ddb9997bd264b26fd0bb1fb892a950367183] new parent not found
2025/05/12 01:38:24 DEBUG : box root 'rclone-test-daleyih9zuqe': ["file2.rclone_chunk.001"(1)|file|ITEM_RENAME|1859409367078|fb38b648ebec906bb697c2658ad0fc933aeda6bf] ignored due to old SequenceID ('\x01')
2025/05/12 01:38:24 DEBUG : box root 'rclone-test-daleyih9zuqe': Received 3 events, resulting in 0 paths and 0 notifications
2025/05/12 01:38:24 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498651174")
2025/05/12 01:38:25 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498651412")
2025/05/12 01:38:25 DEBUG : box root 'rclone-test-daleyih9zuqe': ["file2"(0)|file|ITEM_UPLOAD|1859388256696|fdead21854e182beb72a28093133f495172c8bd5] ignored due to old SequenceID ('\x00')
2025/05/12 01:38:25 DEBUG : box root 'rclone-test-daleyih9zuqe': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/12 01:38:25 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498652175")
2025/05/12 01:38:25 INFO  : dir/file4.rclone_chunk.001_4q65lf: Moved (server-side) to: dir/file4.rclone_chunk.001
2025/05/12 01:38:26 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498652404")
2025/05/12 01:38:26 INFO  : dir/file4.rclone_chunk.002_4q65lf: Moved (server-side) to: dir/file4.rclone_chunk.002
2025/05/12 01:38:27 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498653174")
2025/05/12 01:38:28 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498654177")
2025/05/12 01:38:28 DEBUG : box root 'rclone-test-daleyih9zuqe': ["newLeaf"(5)|file|ITEM_UPLOAD|1859387483849|f84887a96a35f7aa4adc39ec3d0001f4277c5569] new parent not found
2025/05/12 01:38:28 DEBUG : box root 'rclone-test-daleyih9zuqe': ["newLeaf"(4)|file|ITEM_MOVE|1859387483849|ece73f25a3dc6aecd9aaf6c1edd96c48eb7f9c17] new parent not found
2025/05/12 01:38:28 DEBUG : box root 'rclone-test-daleyih9zuqe': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/12 01:38:28 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498655173")
2025/05/12 01:38:29 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498655413")
2025/05/12 01:38:29 DEBUG : box root 'rclone-test-daleyih9zuqe': ["file4.rclone_chunk.001_4q65lf"(0)|file|ITEM_UPLOAD|1859386819181|8cb88f3eee336a299d417883b48936e3d4bdc9f5] ignored due to old SequenceID ('\x01')
2025/05/12 01:38:29 DEBUG : box root 'rclone-test-daleyih9zuqe': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/12 01:38:29 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498656172")
2025/05/12 01:38:30 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498656403")
2025/05/12 01:38:31 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498657171")
2025/05/12 01:38:31 DEBUG : box root 'rclone-test-daleyih9zuqe': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/12 01:38:31 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498658171")
2025/05/12 01:38:32 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498658397")
2025/05/12 01:38:32 DEBUG : box root 'rclone-test-daleyih9zuqe': ["file4.rclone_chunk.002_4q65lf"(0)|file|ITEM_UPLOAD|1859405079633|54956d32c44691ac9b6a01a97ec9795bbfe26f02] ignored due to old SequenceID ('\x01')
2025/05/12 01:38:32 DEBUG : box root 'rclone-test-daleyih9zuqe': ["file4.rclone_chunk.002"(1)|file|ITEM_RENAME|1859405079633|fec21ad220f17e9cdd81307bca21b1cde9c38d77] ignored due to old SequenceID ('\x01')
2025/05/12 01:38:32 DEBUG : box root 'rclone-test-daleyih9zuqe': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1859386819181|c84d5f2bb02191ad33d59a020cbb73dbdb358676] ignored due to old SequenceID ('\x01')
2025/05/12 01:38:32 DEBUG : box root 'rclone-test-daleyih9zuqe': Received 4 events, resulting in 0 paths and 0 notifications
2025/05/12 01:38:32 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498659176")
2025/05/12 01:38:33 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498659430")
2025/05/12 01:38:33 INFO  : dir/file3.rclone_chunk.001_4q6d3p: Moved (server-side) to: dir/file3.rclone_chunk.001
2025/05/12 01:38:34 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498660173")
2025/05/12 01:38:34 INFO  : dir/file3.rclone_chunk.002_4q6d3p: Moved (server-side) to: dir/file3.rclone_chunk.002
2025/05/12 01:38:34 DEBUG : box root 'rclone-test-daleyih9zuqe': ["dir"(0)|folder|ITEM_CREATE|320749547892|2b2923d218ce8dea7157f5339f3684e26ca56327] new parent not found
2025/05/12 01:38:34 DEBUG : box root 'rclone-test-daleyih9zuqe': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/12 01:38:34 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498661170")
2025/05/12 01:38:35 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498661414")
2025/05/12 01:38:36 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498662175")
2025/05/12 01:38:36 DEBUG : box root 'rclone-test-daleyih9zuqe': ["file1"(0)|file|ITEM_UPLOAD|1859409647296|93d304bc4b35f040eb70d8832a5be350b1857ced] new parent not found
2025/05/12 01:38:36 DEBUG : box root 'rclone-test-daleyih9zuqe': ["file4"(0)|file|ITEM_UPLOAD|1859400565859|455f5c65ea338765989f657ec52d319974f471db] ignored due to old SequenceID ('\x00')
2025/05/12 01:38:36 DEBUG : box root 'rclone-test-daleyih9zuqe': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/12 01:38:36 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498663174")
    fstests.go:931: Try 1/10 waiting for dirChanges and objChanges
2025/05/12 01:38:37 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498663412")
2025/05/12 01:38:38 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498664170")
2025/05/12 01:38:38 DEBUG : box root 'rclone-test-daleyih9zuqe': ["file3.rclone_chunk.001_4q6d3p"(0)|file|ITEM_UPLOAD|1859402788608|691252b7dcd022dbe1328b16abf18b249df453cc] ignored due to old SequenceID ('\x01')
2025/05/12 01:38:38 DEBUG : box root 'rclone-test-daleyih9zuqe': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/12 01:38:38 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498665171")
2025/05/12 01:38:39 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498665404")
2025/05/12 01:38:39 DEBUG : box root 'rclone-test-daleyih9zuqe': ["file3.rclone_chunk.002_4q6d3p"(0)|file|ITEM_UPLOAD|1859399882169|ac941dcdc592b1b15063958bfe9aa457a8af8bba] ignored due to old SequenceID ('\x01')
2025/05/12 01:38:39 DEBUG : box root 'rclone-test-daleyih9zuqe': ["newLeaf"(1)|file|ITEM_MOVE|1859409647296|f9edf72392a4d900f90b471cab6cda35754733c3] new parent not found
2025/05/12 01:38:39 DEBUG : box root 'rclone-test-daleyih9zuqe': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/12 01:38:39 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498666180")
    fstests.go:931: Try 2/10 waiting for dirChanges and objChanges
2025/05/12 01:38:40 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498666420")
2025/05/12 01:38:40 DEBUG : box root 'rclone-test-daleyih9zuqe': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1859402788608|cc7ca17a606f87123e0bb52419d04966a1ab56e4] ignored due to old SequenceID ('\x01')
2025/05/12 01:38:40 DEBUG : box root 'rclone-test-daleyih9zuqe': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/12 01:38:40 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498667177")
2025/05/12 01:38:40 DEBUG : box root 'rclone-test-daleyih9zuqe': ["file1"(2)|file|ITEM_MOVE|1859409647296|b83e12ed46086c4f7e4a4f1cd6afa9c8717765be] new parent not found
2025/05/12 01:38:40 DEBUG : box root 'rclone-test-daleyih9zuqe': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/12 01:38:40 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498667410")
2025/05/12 01:38:41 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498667640")
2025/05/12 01:38:41 DEBUG : box root 'rclone-test-daleyih9zuqe': ["file3.rclone_chunk.002"(1)|file|ITEM_RENAME|1859399882169|5e6940ef04831be7e0bbf295f555614ae4bc2b40] ignored due to old SequenceID ('\x01')
2025/05/12 01:38:41 DEBUG : box root 'rclone-test-daleyih9zuqe': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/12 01:38:41 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498668177")
2025/05/12 01:38:42 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498668414")
    fstests.go:931: Try 3/10 waiting for dirChanges and objChanges
2025/05/12 01:38:43 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498669170")
2025/05/12 01:38:44 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498670174")
2025/05/12 01:38:45 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498671174")
    fstests.go:931: Try 4/10 waiting for dirChanges and objChanges
2025/05/12 01:38:46 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498672208")
2025/05/12 01:38:46 DEBUG : box root 'rclone-test-daleyih9zuqe': ["newLeaf"(4)|file|ITEM_UPLOAD|1859409647296|bcc3e0d793cfcca902af45b65123bf128d158d38] new parent not found
2025/05/12 01:38:46 DEBUG : box root 'rclone-test-daleyih9zuqe': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/12 01:38:46 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498673259")
2025/05/12 01:38:47 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498673515")
2025/05/12 01:38:48 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498674180")
2025/05/12 01:38:48 DEBUG : box root 'rclone-test-daleyih9zuqe': ["newLeaf"(3)|file|ITEM_MOVE|1859409647296|44d53cb9a5ce115c1f69483789b00be01bb619ff] new parent not found
2025/05/12 01:38:48 DEBUG : box root 'rclone-test-daleyih9zuqe': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/12 01:38:48 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498675175")
    fstests.go:931: Try 5/10 waiting for dirChanges and objChanges
2025/05/12 01:38:49 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498675415")
2025/05/12 01:38:49 DEBUG : box root 'rclone-test-daleyih9zuqe': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/12 01:38:49 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498676174")
2025/05/12 01:38:50 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498676417")
2025/05/12 01:38:51 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498677189")
2025/05/12 01:38:51 DEBUG : box root 'rclone-test-daleyih9zuqe': ["dir"(0)|folder|ITEM_CREATE|320746972269|d98aa3e264d115781a5f2a51b67483acbea5a280] new parent not found
2025/05/12 01:38:51 DEBUG : box root 'rclone-test-daleyih9zuqe': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/12 01:38:51 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498678179")
    fstests.go:931: Try 6/10 waiting for dirChanges and objChanges
2025/05/12 01:38:52 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498678409")
2025/05/12 01:38:53 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498679172")
2025/05/12 01:38:54 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498680180")
2025/05/12 01:38:54 DEBUG : box root 'rclone-test-daleyih9zuqe': ["file1"(0)|file|ITEM_UPLOAD|1859400443037|190629eaa73482f383c87c7b955fc025fc09537e] new parent not found
2025/05/12 01:38:54 DEBUG : box root 'rclone-test-daleyih9zuqe': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/12 01:38:54 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498681174")
2025/05/12 01:38:54 DEBUG : box root 'rclone-test-daleyih9zuqe': ["file1"(1)|file|ITEM_UPLOAD|1859400443037|ad06352356abf9a2a00ce37fb91d01e6e24f7f0d] new parent not found
2025/05/12 01:38:54 DEBUG : box root 'rclone-test-daleyih9zuqe': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/12 01:38:54 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498681414")
    fstests.go:931: Try 7/10 waiting for dirChanges and objChanges
2025/05/12 01:38:55 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498681643")
2025/05/12 01:38:56 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498682171")
2025/05/12 01:38:57 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498683179")
    fstests.go:931: Try 8/10 waiting for dirChanges and objChanges
2025/05/12 01:38:58 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498684202")
2025/05/12 01:38:58 DEBUG : box root 'rclone-test-daleyih9zuqe': ["newLeaf"(2)|file|ITEM_MOVE|1859400443037|13ca2033be768f5b1c82cb3e0d278f855d454b8a] new parent not found
2025/05/12 01:38:58 DEBUG : box root 'rclone-test-daleyih9zuqe': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/12 01:38:58 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498685178")
2025/05/12 01:38:59 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498685410")
2025/05/12 01:39:00 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498686174")
2025/05/12 01:39:00 DEBUG : box root 'rclone-test-daleyih9zuqe': ["file1"(3)|file|ITEM_MOVE|1859400443037|d7d33a974a0285b99874758e321d00f656bdac6e] new parent not found
2025/05/12 01:39:00 DEBUG : box root 'rclone-test-daleyih9zuqe': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/12 01:39:00 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498687203")
    fstests.go:931: Try 9/10 waiting for dirChanges and objChanges
2025/05/12 01:39:01 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498687458")
2025/05/12 01:39:02 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498688167")
2025/05/12 01:39:03 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498689171")
2025/05/12 01:39:03 DEBUG : box root 'rclone-test-daleyih9zuqe': ["newLeaf"(4)|file|ITEM_MOVE|1859400443037|eff5fd41086f273b59c51bf7ad412a89aa5ed25e] new parent not found
2025/05/12 01:39:03 DEBUG : box root 'rclone-test-daleyih9zuqe': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/12 01:39:03 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498690171")
    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/12 01:39:04 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498690415")
2025/05/12 01:39:04 DEBUG : box root 'rclone-test-daleyih9zuqe': ["newLeaf"(5)|file|ITEM_UPLOAD|1859400443037|7718017b2ed18e4b150a3d92dcce5771aaedcfaf] new parent not found
2025/05/12 01:39:04 DEBUG : box root 'rclone-test-daleyih9zuqe': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/12 01:39:04 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498691192")
2025/05/12 01:39:05 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498691420")
2025/05/12 01:39:06 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498692178")
2025/05/12 01:39:07 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498693180")
2025/05/12 01:39:08 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498694174")
2025/05/12 01:39:08 DEBUG : box root 'rclone-test-daleyih9zuqe': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/12 01:39:08 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498695173")
2025/05/12 01:39:09 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498695412")
2025/05/12 01:39:10 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498696176")
2025/05/12 01:39:10 DEBUG : box root 'rclone-test-daleyih9zuqe': ["dir"(0)|folder|ITEM_CREATE|320746431724|e4d1cee4cc79d76275493abdcd5aa92f64d3e8d4] new parent not found
2025/05/12 01:39:10 DEBUG : box root 'rclone-test-daleyih9zuqe': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/12 01:39:10 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498697177")
2025/05/12 01:39:11 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498697409")
2025/05/12 01:39:12 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498698177")
2025/05/12 01:39:12 DEBUG : box root 'rclone-test-daleyih9zuqe': ["file2"(1)|file|ITEM_TRASH|1859388256696|a80466118083a7f2e0a911429b2f8df75875ef6c] added old path ("dir/file2") for notify
2025/05/12 01:39:12 DEBUG : box root 'rclone-test-daleyih9zuqe': ["file1"(0)|file|ITEM_UPLOAD|1859408835887|d2e5c92ded47969edfcb289660c7e6011e0dcb8a] new parent not found
2025/05/12 01:39:12 DEBUG : doChangeNotify("dir/file2", 1)
2025/05/12 01:39:12 DEBUG : box root 'rclone-test-daleyih9zuqe': Received 2 events, resulting in 1 paths and 1 notifications
2025/05/12 01:39:12 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498699179")
2025/05/12 01:39:13 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498699419")
2025/05/12 01:39:13 DEBUG : box root 'rclone-test-daleyih9zuqe': ["file2.rclone_chunk.001"(2)|file|ITEM_TRASH|1859409367078|a5a9b7d78851c40fa742a4480bd6bce710aaf0ff] added old path ("dir/file2.rclone_chunk.001") for notify
2025/05/12 01:39:13 DEBUG : doChangeNotify("dir/file2", 1)
2025/05/12 01:39:13 DEBUG : box root 'rclone-test-daleyih9zuqe': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/12 01:39:13 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498700178")
2025/05/12 01:39:14 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498700430")
2025/05/12 01:39:15 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498701176")
2025/05/12 01:39:15 DEBUG : box root 'rclone-test-daleyih9zuqe': ["file2.rclone_chunk.002"(2)|file|ITEM_TRASH|1859402759228|57fe4f97e1e3fe49a1cc8123cae04df314714677] added old path ("dir/file2.rclone_chunk.002") for notify
2025/05/12 01:39:15 DEBUG : box root 'rclone-test-daleyih9zuqe': ["newLeaf"(1)|file|ITEM_MOVE|1859408835887|bb5169a163dbc6e7e0ebc7edf1dc25ac406b7e96] new parent not found
2025/05/12 01:39:15 DEBUG : doChangeNotify("dir/file2", 1)
2025/05/12 01:39:15 DEBUG : box root 'rclone-test-daleyih9zuqe': Received 2 events, resulting in 1 paths and 1 notifications
2025/05/12 01:39:15 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498702171")
2025/05/12 01:39:16 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498702414")
2025/05/12 01:39:16 DEBUG : box root 'rclone-test-daleyih9zuqe': ["file4"(1)|file|ITEM_TRASH|1859400565859|6b2575a4d6464ae6a31a3a8a281be2bd5ee814cc] added old path ("dir/file4") for notify
2025/05/12 01:39:16 DEBUG : doChangeNotify("dir/file4", 1)
2025/05/12 01:39:16 DEBUG : box root 'rclone-test-daleyih9zuqe': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/12 01:39:16 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498703197")
2025/05/12 01:39:17 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498703432")
2025/05/12 01:39:18 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498704165")
2025/05/12 01:39:18 DEBUG : box root 'rclone-test-daleyih9zuqe': ["file4.rclone_chunk.002"(2)|file|ITEM_TRASH|1859405079633|d6b2b63753ca93a34360c65f80936f7705512df1] added old path ("dir/file4.rclone_chunk.002") for notify
2025/05/12 01:39:18 DEBUG : box root 'rclone-test-daleyih9zuqe': ["file1"(2)|file|ITEM_MOVE|1859408835887|bf4f0602abba10017b5c7a557c7fed9a94c8d236] new parent not found
2025/05/12 01:39:18 DEBUG : doChangeNotify("dir/file4", 1)
2025/05/12 01:39:18 DEBUG : box root 'rclone-test-daleyih9zuqe': Received 2 events, resulting in 1 paths and 1 notifications
2025/05/12 01:39:18 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498705174")
2025/05/12 01:39:19 DEBUG : box root 'rclone-test-daleyih9zuqe': Checking for changes on remote (next_stream_position: "30401044498705412")
2025/05/12 01:39:20 DEBUG : box root 'rclone-test-daleyih9zuqe': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/05/12 01:39:20 ERROR : : error listing: directory not found
2025/05/12 01:39:21 DEBUG : box root 'rclone-test-daleyih9zuqe': Ignoring "Shared folder — ForNick" - unknown type "web_link"
--- FAIL: TestIntegration (75.44s)
    --- FAIL: TestIntegration/FsMkdir (73.05s)
        --- FAIL: TestIntegration/FsMkdir/FsChangeNotify (70.80s)
FAIL
exit status 1
FAIL	github.com/rclone/rclone/backend/chunker	75.477s
"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024 -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Finished ERROR in 1m18.800516671s (try 3/5): exit status 1: Failed [TestIntegration/FsMkdir/FsChangeNotify]