"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024 -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Starting (try 5/5)
=== RUN   TestIntegration
    fstests.go:438: Using remote "TestChunkerChunk50bBox:"
2025/05/23 02:25:53 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-negaleg6heqi"
2025/05/23 02:25:53 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/05/23 02:25:53 DEBUG : Creating backend with remote "TestBox:rclone-test-negaleg6heqi"
2025/05/23 02:25:53 DEBUG : box root 'rclone-test-negaleg6heqi': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/05/23 02:25:54 DEBUG : box root 'rclone-test-negaleg6heqi': Ignoring "Shared folder — ForNick" - unknown type "web_link"
=== RUN   TestIntegration/FsMkdir
=== RUN   TestIntegration/FsMkdir/FsChangeNotify
2025/05/23 02:25:56 INFO  : dir: Making directory
2025/05/23 02:25:57 INFO  : dir/subdir1: Making directory
2025/05/23 02:25:58 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451904177")
2025/05/23 02:25:58 INFO  : dir/subdir3: Making directory
2025/05/23 02:25:59 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451905418")
2025/05/23 02:25:59 INFO  : dir/subdir2: Making directory
2025/05/23 02:26:00 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451906427")
2025/05/23 02:26:01 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451907411")
2025/05/23 02:26:01 DEBUG : box root 'rclone-test-negaleg6heqi': ["rclone-test-negaleg6heqi"(0)|folder|ITEM_CREATE|322528408746|8306f5afd80bc24c3528127a56d8e443d713634c] new parent not found
2025/05/23 02:26:01 DEBUG : box root 'rclone-test-negaleg6heqi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/23 02:26:01 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451908420")
2025/05/23 02:26:02 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451908648")
2025/05/23 02:26:03 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451909410")
2025/05/23 02:26:03 DEBUG : box root 'rclone-test-negaleg6heqi': ["dir"(0)|folder|ITEM_CREATE|322526095187|b408c4491646eb9058c8fd8d26a9811377bdd4e4] added new path ("dir") for notify
2025/05/23 02:26:03 DEBUG : doChangeNotify("dir", 0)
2025/05/23 02:26:03 DEBUG : box root 'rclone-test-negaleg6heqi': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/23 02:26:03 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451910413")
2025/05/23 02:26:04 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451910651")
2025/05/23 02:26:05 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451911414")
2025/05/23 02:26:05 INFO  : dir/file2.rclone_chunk.001_p5plpo: Moved (server-side) to: dir/file2.rclone_chunk.001
2025/05/23 02:26:05 DEBUG : box root 'rclone-test-negaleg6heqi': ["subdir1"(0)|folder|ITEM_CREATE|322525683766|1a7924f60b5d728719a91c5ed63cd093184830f9] added new path ("dir/subdir1") for notify
2025/05/23 02:26:05 DEBUG : doChangeNotify("dir/subdir1", 0)
2025/05/23 02:26:05 DEBUG : box root 'rclone-test-negaleg6heqi': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/23 02:26:05 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451912412")
2025/05/23 02:26:05 DEBUG : box root 'rclone-test-negaleg6heqi': ["subdir3"(0)|folder|ITEM_CREATE|322527916481|2257af46b011be1bfc663b14848b20a2d124a5a6] added new path ("dir/subdir3") for notify
2025/05/23 02:26:05 DEBUG : doChangeNotify("dir/subdir3", 0)
2025/05/23 02:26:05 DEBUG : box root 'rclone-test-negaleg6heqi': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/23 02:26:05 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451912646")
2025/05/23 02:26:06 INFO  : dir/file2.rclone_chunk.002_p5plpo: Moved (server-side) to: dir/file2.rclone_chunk.002
2025/05/23 02:26:06 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451912876")
2025/05/23 02:26:07 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451913413")
2025/05/23 02:26:07 DEBUG : box root 'rclone-test-negaleg6heqi': ["subdir2"(0)|folder|ITEM_CREATE|322529528488|9c0654345677b59404464545edff696eae2f67f1] added new path ("dir/subdir2") for notify
2025/05/23 02:26:07 DEBUG : doChangeNotify("dir/subdir2", 0)
2025/05/23 02:26:07 DEBUG : box root 'rclone-test-negaleg6heqi': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/23 02:26:07 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451914420")
2025/05/23 02:26:08 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451914650")
2025/05/23 02:26:09 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451915410")
2025/05/23 02:26:09 DEBUG : box root 'rclone-test-negaleg6heqi': ["file2.rclone_chunk.001_p5plpo"(0)|file|ITEM_UPLOAD|1870627797323|a03c674bfa83ad975f0eb4d1c52df7a46dda5947] ignored due to old SequenceID ('\x01')
2025/05/23 02:26:09 DEBUG : box root 'rclone-test-negaleg6heqi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/23 02:26:09 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451916414")
2025/05/23 02:26:10 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451916653")
2025/05/23 02:26:11 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451917417")
2025/05/23 02:26:12 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451918407")
2025/05/23 02:26:12 DEBUG : box root 'rclone-test-negaleg6heqi': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1870621079489|77358f55537ebdec5b3d061a71b907a3a11fe0ba] ignored due to old SequenceID ('\x01')
2025/05/23 02:26:12 DEBUG : box root 'rclone-test-negaleg6heqi': ["file2.rclone_chunk.001"(1)|file|ITEM_RENAME|1870627797323|497c2fdd338441ec707566888e994488e82e4fa0] ignored due to old SequenceID ('\x01')
2025/05/23 02:26:12 DEBUG : box root 'rclone-test-negaleg6heqi': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/23 02:26:12 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451919410")
2025/05/23 02:26:13 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451919649")
2025/05/23 02:26:13 INFO  : dir/file4.rclone_chunk.001_p5ptt6: Moved (server-side) to: dir/file4.rclone_chunk.001
2025/05/23 02:26:14 INFO  : dir/file4.rclone_chunk.002_p5ptt6: Moved (server-side) to: dir/file4.rclone_chunk.002
2025/05/23 02:26:14 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451920411")
2025/05/23 02:26:14 DEBUG : box root 'rclone-test-negaleg6heqi': ["file2"(0)|file|ITEM_UPLOAD|1870629232048|0a415ec36f82ad7452eca42d7ef7b049728c2377] ignored due to old SequenceID ('\x00')
2025/05/23 02:26:14 DEBUG : box root 'rclone-test-negaleg6heqi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/23 02:26:14 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451921416")
2025/05/23 02:26:15 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451921649")
2025/05/23 02:26:16 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451922422")
2025/05/23 02:26:17 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451923423")
2025/05/23 02:26:17 DEBUG : box root 'rclone-test-negaleg6heqi': ["file4.rclone_chunk.001_p5ptt6"(0)|file|ITEM_UPLOAD|1870617037933|bed74f9e7ad4e761c5d0a13af677da7b0c1a1852] ignored due to old SequenceID ('\x01')
2025/05/23 02:26:17 DEBUG : box root 'rclone-test-negaleg6heqi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/23 02:26:17 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451924412")
2025/05/23 02:26:18 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451924647")
2025/05/23 02:26:19 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451925424")
2025/05/23 02:26:19 DEBUG : box root 'rclone-test-negaleg6heqi': ["file4.rclone_chunk.002_p5ptt6"(0)|file|ITEM_UPLOAD|1870621071689|d48e5f8ef8ca80b451d63c85a29e116bc2c2be64] ignored due to old SequenceID ('\x01')
2025/05/23 02:26:19 DEBUG : box root 'rclone-test-negaleg6heqi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/23 02:26:19 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451926406")
2025/05/23 02:26:20 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451926639")
2025/05/23 02:26:20 DEBUG : box root 'rclone-test-negaleg6heqi': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1870617037933|2280a05601421ad70191504c38c4672b0b415214] ignored due to old SequenceID ('\x01')
2025/05/23 02:26:20 DEBUG : box root 'rclone-test-negaleg6heqi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/23 02:26:20 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451927411")
2025/05/23 02:26:21 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451927647")
2025/05/23 02:26:21 INFO  : dir/file3.rclone_chunk.001_p5q13l: Moved (server-side) to: dir/file3.rclone_chunk.001
2025/05/23 02:26:21 DEBUG : box root 'rclone-test-negaleg6heqi': ["file4"(0)|file|ITEM_UPLOAD|1870629856442|199a2eefd03188c9c0ea978c0a04759d66f8eff7] ignored due to old SequenceID ('\x00')
2025/05/23 02:26:21 DEBUG : box root 'rclone-test-negaleg6heqi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/23 02:26:21 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451928411")
2025/05/23 02:26:22 INFO  : dir/file3.rclone_chunk.002_p5q13l: Moved (server-side) to: dir/file3.rclone_chunk.002
2025/05/23 02:26:22 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451928645")
2025/05/23 02:26:22 DEBUG : box root 'rclone-test-negaleg6heqi': ["file4.rclone_chunk.002"(1)|file|ITEM_RENAME|1870621071689|2c8c14c4b1e4f153362625221f511cc9ab9f8659] ignored due to old SequenceID ('\x01')
2025/05/23 02:26:22 DEBUG : box root 'rclone-test-negaleg6heqi': ["file2.rclone_chunk.002_p5plpo"(0)|file|ITEM_UPLOAD|1870621079489|37f52a473bfad7e07c2657e613363ad188d82219] ignored due to old SequenceID ('\x01')
2025/05/23 02:26:22 DEBUG : box root 'rclone-test-negaleg6heqi': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/23 02:26:22 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451929415")
2025/05/23 02:26:23 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451929649")
2025/05/23 02:26:24 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451930421")
    fstests.go:931: Try 1/10 waiting for dirChanges and objChanges
2025/05/23 02:26:25 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451931414")
2025/05/23 02:26:26 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451932414")
2025/05/23 02:26:26 DEBUG : box root 'rclone-test-negaleg6heqi': ["file3.rclone_chunk.002_p5q13l"(0)|file|ITEM_UPLOAD|1870628140365|6268585591fdba5b41b9c8e5677ab337ecc78491] ignored due to old SequenceID ('\x01')
2025/05/23 02:26:26 DEBUG : box root 'rclone-test-negaleg6heqi': ["file3.rclone_chunk.001_p5q13l"(0)|file|ITEM_UPLOAD|1870624144464|eaf99f0395b0253ab2428fb79b7b5fe4385c024d] ignored due to old SequenceID ('\x01')
2025/05/23 02:26:26 DEBUG : box root 'rclone-test-negaleg6heqi': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/23 02:26:26 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451933412")
2025/05/23 02:26:27 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451933649")
    fstests.go:931: Try 2/10 waiting for dirChanges and objChanges
2025/05/23 02:26:28 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451934409")
2025/05/23 02:26:28 DEBUG : box root 'rclone-test-negaleg6heqi': ["file3.rclone_chunk.002"(1)|file|ITEM_RENAME|1870628140365|bb0384c810b965e6c00c4e44169029358fdf6893] ignored due to old SequenceID ('\x01')
2025/05/23 02:26:28 DEBUG : box root 'rclone-test-negaleg6heqi': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1870624144464|7b765f60e28c989a58a1af8fd5c75cdb20dd8878] ignored due to old SequenceID ('\x01')
2025/05/23 02:26:28 DEBUG : box root 'rclone-test-negaleg6heqi': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/23 02:26:28 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451935422")
2025/05/23 02:26:29 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451935668")
2025/05/23 02:26:29 DEBUG : box root 'rclone-test-negaleg6heqi': ["file3"(0)|file|ITEM_UPLOAD|1870636031129|0c609be83ac981d2a473fcf78df9e6761bc95c02] ignored due to old SequenceID ('\x00')
2025/05/23 02:26:29 DEBUG : box root 'rclone-test-negaleg6heqi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/23 02:26:29 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451936411")
2025/05/23 02:26:30 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451936649")
    fstests.go:931: Try 3/10 waiting for dirChanges and objChanges
2025/05/23 02:26:31 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451937405")
2025/05/23 02:26:32 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451938405")
2025/05/23 02:26:33 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451939412")
    fstests.go:931: Try 4/10 waiting for dirChanges and objChanges
2025/05/23 02:26:34 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451940413")
2025/05/23 02:26:35 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451941407")
2025/05/23 02:26:36 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451942406")
    fstests.go:931: Try 5/10 waiting for dirChanges and objChanges
2025/05/23 02:26:37 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451943408")
2025/05/23 02:26:38 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451944428")
2025/05/23 02:26:39 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451945412")
    fstests.go:931: Try 6/10 waiting for dirChanges and objChanges
2025/05/23 02:26:40 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451946416")
2025/05/23 02:26:41 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451947413")
2025/05/23 02:26:42 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451948408")
    fstests.go:931: Try 7/10 waiting for dirChanges and objChanges
2025/05/23 02:26:43 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451949439")
2025/05/23 02:26:44 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451950411")
2025/05/23 02:26:45 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451951408")
    fstests.go:931: Try 8/10 waiting for dirChanges and objChanges
2025/05/23 02:26:46 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451952410")
2025/05/23 02:26:47 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451953422")
2025/05/23 02:26:48 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451954476")
    fstests.go:931: Try 9/10 waiting for dirChanges and objChanges
2025/05/23 02:26:49 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451955405")
2025/05/23 02:26:50 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451956419")
2025/05/23 02:26:51 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451957415")
    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/23 02:26:52 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451958411")
2025/05/23 02:26:53 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451959419")
2025/05/23 02:26:54 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451960409")
2025/05/23 02:26:55 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451961415")
2025/05/23 02:26:56 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451962412")
2025/05/23 02:26:57 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451963411")
2025/05/23 02:26:58 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451964426")
2025/05/23 02:26:59 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451965410")
2025/05/23 02:26:59 DEBUG : box root 'rclone-test-negaleg6heqi': ["file2"(1)|file|ITEM_TRASH|1870629232048|ce7cce28c0ffa09ea2e8e197042e1ca2fbb4cb9a] added old path ("dir/file2") for notify
2025/05/23 02:26:59 DEBUG : doChangeNotify("dir/file2", 1)
2025/05/23 02:26:59 DEBUG : box root 'rclone-test-negaleg6heqi': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/23 02:26:59 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451966408")
2025/05/23 02:27:00 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451966649")
2025/05/23 02:27:01 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451967412")
2025/05/23 02:27:01 DEBUG : box root 'rclone-test-negaleg6heqi': ["file2.rclone_chunk.001"(2)|file|ITEM_TRASH|1870627797323|db845dec84c619a306b42d470a9a6ef9efe93242] added old path ("dir/file2.rclone_chunk.001") for notify
2025/05/23 02:27:01 DEBUG : doChangeNotify("dir/file2", 1)
2025/05/23 02:27:01 DEBUG : box root 'rclone-test-negaleg6heqi': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/23 02:27:01 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451968408")
2025/05/23 02:27:02 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451968646")
2025/05/23 02:27:03 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451969411")
2025/05/23 02:27:04 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451970414")
2025/05/23 02:27:05 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451971416")
2025/05/23 02:27:05 DEBUG : box root 'rclone-test-negaleg6heqi': ["file4"(1)|file|ITEM_TRASH|1870629856442|f078b29ecbff7435a9299773124ea8c84a0f0b2e] added old path ("dir/file4") for notify
2025/05/23 02:27:05 DEBUG : box root 'rclone-test-negaleg6heqi': ["file2.rclone_chunk.002"(2)|file|ITEM_TRASH|1870621079489|35e9d190548422187eddbb8eceaf6435203c14b5] added old path ("dir/file2.rclone_chunk.002") for notify
2025/05/23 02:27:05 DEBUG : doChangeNotify("dir/file4", 1)
2025/05/23 02:27:05 DEBUG : doChangeNotify("dir/file2", 1)
2025/05/23 02:27:05 DEBUG : box root 'rclone-test-negaleg6heqi': Received 2 events, resulting in 2 paths and 2 notifications
2025/05/23 02:27:05 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451972414")
2025/05/23 02:27:06 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451972648")
2025/05/23 02:27:07 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451973408")
2025/05/23 02:27:07 DEBUG : box root 'rclone-test-negaleg6heqi': ["file4.rclone_chunk.001"(2)|file|ITEM_TRASH|1870617037933|f60c0bf9131e1478e671721f008689df98f5c2cc] added old path ("dir/file4.rclone_chunk.001") for notify
2025/05/23 02:27:07 DEBUG : box root 'rclone-test-negaleg6heqi': ["file4.rclone_chunk.002"(2)|file|ITEM_TRASH|1870621071689|2ace0c986742761fa73ac5e4d4b7d2511ee54552] added old path ("dir/file4.rclone_chunk.002") for notify
2025/05/23 02:27:07 DEBUG : doChangeNotify("dir/file4", 1)
2025/05/23 02:27:07 DEBUG : doChangeNotify("dir/file4", 1)
2025/05/23 02:27:07 DEBUG : box root 'rclone-test-negaleg6heqi': Received 2 events, resulting in 2 paths and 2 notifications
2025/05/23 02:27:07 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451974408")
2025/05/23 02:27:08 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451974649")
2025/05/23 02:27:09 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451975410")
2025/05/23 02:27:10 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451976409")
2025/05/23 02:27:10 DEBUG : box root 'rclone-test-negaleg6heqi': ["file3"(1)|file|ITEM_TRASH|1870636031129|31082ee3cdcccdd80b754f062a77b4d1f48edad7] added old path ("dir/file3") for notify
2025/05/23 02:27:10 DEBUG : doChangeNotify("dir/file3", 1)
2025/05/23 02:27:10 DEBUG : box root 'rclone-test-negaleg6heqi': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/23 02:27:10 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451977421")
2025/05/23 02:27:11 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451977653")
2025/05/23 02:27:11 DEBUG : box root 'rclone-test-negaleg6heqi': ["file3.rclone_chunk.001"(2)|file|ITEM_TRASH|1870624144464|cf24f1707256063c87d6a5292ab504cc6a29428c] old parent not cached
2025/05/23 02:27:11 DEBUG : box root 'rclone-test-negaleg6heqi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/23 02:27:11 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451978413")
2025/05/23 02:27:11 DEBUG : box root 'rclone-test-negaleg6heqi': ["file3.rclone_chunk.002"(2)|file|ITEM_TRASH|1870628140365|f3759be7caddd7cd7df5ce6aece883ed2f09fb85] old parent not cached
2025/05/23 02:27:11 DEBUG : box root 'rclone-test-negaleg6heqi': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/23 02:27:11 DEBUG : box root 'rclone-test-negaleg6heqi': Checking for changes on remote (next_stream_position: "30401045451978667")
2025/05/23 02:27:13 DEBUG : box root 'rclone-test-negaleg6heqi': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/05/23 02:27:13 ERROR : : error listing: directory not found
2025/05/23 02:27:13 DEBUG : box root 'rclone-test-negaleg6heqi': Ignoring "Shared folder — ForNick" - unknown type "web_link"
--- FAIL: TestIntegration (80.48s)
    --- FAIL: TestIntegration/FsMkdir (77.89s)
        --- FAIL: TestIntegration/FsMkdir/FsChangeNotify (75.51s)
FAIL
exit status 1
FAIL	github.com/rclone/rclone/backend/chunker	80.532s
"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024 -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Finished ERROR in 1m23.282246589s (try 5/5): exit status 1: Failed [TestIntegration/FsMkdir/FsChangeNotify]