"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024 -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Starting (try 4/5)
=== RUN   TestIntegration
    fstests.go:438: Using remote "TestChunkerChunk50bBox:"
2025/03/10 04:14:15 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-sulojeb9kexi"
2025/03/10 04:14:15 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/03/10 04:14:15 DEBUG : Creating backend with remote "TestBox:rclone-test-sulojeb9kexi"
2025/03/10 04:14:16 DEBUG : box root 'rclone-test-sulojeb9kexi': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/03/10 04:14:16 DEBUG : Reset feature "ListR"
2025/03/10 04:14:17 DEBUG : box root 'rclone-test-sulojeb9kexi': Ignoring "Shared folder — ForNick" - unknown type "web_link"
=== RUN   TestIntegration/FsMkdir
=== RUN   TestIntegration/FsMkdir/FsChangeNotify
2025/03/10 04:14:18 INFO  : dir: Making directory
2025/03/10 04:14:20 INFO  : dir/subdir1: Making directory
2025/03/10 04:14:21 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064806779")
2025/03/10 04:14:21 INFO  : dir/subdir3: Making directory
2025/03/10 04:14:21 DEBUG : box root 'rclone-test-sulojeb9kexi': Received 2 events, resulting in 0 paths and 0 notifications
2025/03/10 04:14:21 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064808015")
2025/03/10 04:14:22 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064808252")
2025/03/10 04:14:22 DEBUG : box root 'rclone-test-sulojeb9kexi': ["rclone-test-sulojeb9kexi"(0)|folder|ITEM_CREATE|310896400109|b9078e421c5b908f79030feaeae3ae5a8c99b3eb] new parent not found
2025/03/10 04:14:22 DEBUG : box root 'rclone-test-sulojeb9kexi': Received 1 events, resulting in 0 paths and 0 notifications
2025/03/10 04:14:22 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064809009")
2025/03/10 04:14:22 INFO  : dir/subdir2: Making directory
2025/03/10 04:14:23 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064809241")
2025/03/10 04:14:24 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064810007")
2025/03/10 04:14:25 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064811007")
2025/03/10 04:14:26 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064812015")
2025/03/10 04:14:26 DEBUG : box root 'rclone-test-sulojeb9kexi': ["rclone-test-sulojeb9kexi"(0)|folder|ITEM_CREATE|310896400109|b9078e421c5b908f79030feaeae3ae5a8c99b3eb] ignored due to duplicate EventID
2025/03/10 04:14:27 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064813026")
2025/03/10 04:14:28 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064814011")
2025/03/10 04:14:28 INFO  : dir/file2.rclone_chunk.001_w9dfmh: Moved (server-side) to: dir/file2.rclone_chunk.001
2025/03/10 04:14:29 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064815011")
2025/03/10 04:14:29 INFO  : dir/file2.rclone_chunk.002_w9dfmh: Moved (server-side) to: dir/file2.rclone_chunk.002
2025/03/10 04:14:29 DEBUG : box root 'rclone-test-sulojeb9kexi': ["subdir1"(0)|folder|ITEM_CREATE|310897350232|c28375e70f54bc4cda88e27cc4bad983adc48a93] added new path ("dir/subdir1") for notify
2025/03/10 04:14:29 DEBUG : box root 'rclone-test-sulojeb9kexi': ["subdir3"(0)|folder|ITEM_CREATE|310898570047|068c9c447073d18127fae5352bec0d430e83dc13] added new path ("dir/subdir3") for notify
2025/03/10 04:14:29 DEBUG : box root 'rclone-test-sulojeb9kexi': ["subdir2"(0)|folder|ITEM_CREATE|310898737221|d0e0e5ac455e7cd98ea2f4730d790deb01f857ee] added new path ("dir/subdir2") for notify
2025/03/10 04:14:29 DEBUG : doChangeNotify("dir/subdir1", 0)
2025/03/10 04:14:29 DEBUG : doChangeNotify("dir/subdir3", 0)
2025/03/10 04:14:29 DEBUG : doChangeNotify("dir/subdir2", 0)
2025/03/10 04:14:29 DEBUG : box root 'rclone-test-sulojeb9kexi': Received 3 events, resulting in 3 paths and 3 notifications
2025/03/10 04:14:29 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064816006")
2025/03/10 04:14:30 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064816251")
2025/03/10 04:14:31 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064817015")
2025/03/10 04:14:31 DEBUG : box root 'rclone-test-sulojeb9kexi': ["subdir3"(0)|folder|ITEM_CREATE|310898570047|068c9c447073d18127fae5352bec0d430e83dc13] ignored due to duplicate EventID
2025/03/10 04:14:31 DEBUG : box root 'rclone-test-sulojeb9kexi': ["subdir2"(0)|folder|ITEM_CREATE|310898737221|d0e0e5ac455e7cd98ea2f4730d790deb01f857ee] ignored due to duplicate EventID
2025/03/10 04:14:32 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064818015")
2025/03/10 04:14:33 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064819012")
2025/03/10 04:14:34 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064820015")
2025/03/10 04:14:34 DEBUG : box root 'rclone-test-sulojeb9kexi': ["file2.rclone_chunk.001_w9dfmh"(0)|file|ITEM_UPLOAD|1798544308664|733730df20ab0ea634cef7d92047dea72f733d84] ignored due to old SequenceID ('\x01')
2025/03/10 04:14:34 DEBUG : box root 'rclone-test-sulojeb9kexi': ["file2.rclone_chunk.002_w9dfmh"(0)|file|ITEM_UPLOAD|1798536506179|a59c9f29c224d187da809fa345327f88dd6f4733] ignored due to old SequenceID ('\x01')
2025/03/10 04:14:34 DEBUG : box root 'rclone-test-sulojeb9kexi': ["dir"(0)|folder|ITEM_CREATE|310895487602|a3ca20956d0f71ac330219185e837d44e82ea465] added new path ("dir") for notify
2025/03/10 04:14:34 DEBUG : box root 'rclone-test-sulojeb9kexi': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1798536506179|f456b94b78c7b780491ad2f260a78bd18f212255] ignored due to old SequenceID ('\x01')
2025/03/10 04:14:34 DEBUG : box root 'rclone-test-sulojeb9kexi': ["file2"(0)|file|ITEM_UPLOAD|1798541098877|1350de09d69affac3a001159084a81eb60a0bf34] ignored due to old SequenceID ('\x00')
2025/03/10 04:14:34 DEBUG : doChangeNotify("dir", 0)
2025/03/10 04:14:34 DEBUG : box root 'rclone-test-sulojeb9kexi': Received 5 events, resulting in 1 paths and 1 notifications
2025/03/10 04:14:34 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064821010")
2025/03/10 04:14:34 DEBUG : box root 'rclone-test-sulojeb9kexi': ["dir"(0)|folder|ITEM_CREATE|310895487602|a3ca20956d0f71ac330219185e837d44e82ea465] ignored due to duplicate EventID
2025/03/10 04:14:34 DEBUG : box root 'rclone-test-sulojeb9kexi': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1798536506179|f456b94b78c7b780491ad2f260a78bd18f212255] ignored due to duplicate EventID
2025/03/10 04:14:34 DEBUG : box root 'rclone-test-sulojeb9kexi': ["file2"(0)|file|ITEM_UPLOAD|1798541098877|1350de09d69affac3a001159084a81eb60a0bf34] ignored due to duplicate EventID
2025/03/10 04:14:35 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064821268")
2025/03/10 04:14:35 DEBUG : box root 'rclone-test-sulojeb9kexi': ["dir"(0)|folder|ITEM_CREATE|310895487602|a3ca20956d0f71ac330219185e837d44e82ea465] ignored due to duplicate EventID
2025/03/10 04:14:35 DEBUG : box root 'rclone-test-sulojeb9kexi': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1798536506179|f456b94b78c7b780491ad2f260a78bd18f212255] ignored due to duplicate EventID
2025/03/10 04:14:35 DEBUG : box root 'rclone-test-sulojeb9kexi': ["file2"(0)|file|ITEM_UPLOAD|1798541098877|1350de09d69affac3a001159084a81eb60a0bf34] ignored due to duplicate EventID
2025/03/10 04:14:36 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064822002")
2025/03/10 04:14:36 INFO  : dir/file4.rclone_chunk.001_w9doz1: Moved (server-side) to: dir/file4.rclone_chunk.001
2025/03/10 04:14:37 INFO  : dir/file4.rclone_chunk.002_w9doz1: Moved (server-side) to: dir/file4.rclone_chunk.002
2025/03/10 04:14:37 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064823012")
2025/03/10 04:14:37 DEBUG : box root 'rclone-test-sulojeb9kexi': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1798536506179|f456b94b78c7b780491ad2f260a78bd18f212255] ignored due to duplicate EventID
2025/03/10 04:14:37 DEBUG : box root 'rclone-test-sulojeb9kexi': ["file2"(0)|file|ITEM_UPLOAD|1798541098877|1350de09d69affac3a001159084a81eb60a0bf34] ignored due to duplicate EventID
2025/03/10 04:14:38 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064824015")
2025/03/10 04:14:38 DEBUG : box root 'rclone-test-sulojeb9kexi': ["file2"(0)|file|ITEM_UPLOAD|1798541098877|1350de09d69affac3a001159084a81eb60a0bf34] ignored due to duplicate EventID
2025/03/10 04:14:39 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064825010")
2025/03/10 04:14:39 DEBUG : box root 'rclone-test-sulojeb9kexi': ["file4.rclone_chunk.001_w9doz1"(0)|file|ITEM_UPLOAD|1798538126253|efdb9b3f11d39e6de483acdf74c62b5f3df94bbc] added new path ("dir/file4.rclone_chunk.001_w9doz1") for notify
2025/03/10 04:14:39 DEBUG : doChangeNotify("dir/file4.rclone_chunk.001_w9doz1", 1)
2025/03/10 04:14:39 DEBUG : box root 'rclone-test-sulojeb9kexi': Received 1 events, resulting in 1 paths and 1 notifications
2025/03/10 04:14:39 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064826005")
2025/03/10 04:14:40 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064826233")
2025/03/10 04:14:41 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064827010")
2025/03/10 04:14:42 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064828015")
2025/03/10 04:14:42 DEBUG : box root 'rclone-test-sulojeb9kexi': ["file4.rclone_chunk.001_w9doz1"(0)|file|ITEM_UPLOAD|1798538126253|efdb9b3f11d39e6de483acdf74c62b5f3df94bbc] ignored due to duplicate EventID
2025/03/10 04:14:43 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064829016")
2025/03/10 04:14:44 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064830013")
2025/03/10 04:14:44 INFO  : dir/file3.rclone_chunk.001_w9dvzb: Moved (server-side) to: dir/file3.rclone_chunk.001
2025/03/10 04:14:44 INFO  : dir/file3.rclone_chunk.002_w9dvzb: Moved (server-side) to: dir/file3.rclone_chunk.002
2025/03/10 04:14:45 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064831015")
2025/03/10 04:14:46 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064832020")
2025/03/10 04:14:46 DEBUG : box root 'rclone-test-sulojeb9kexi': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1798538126253|d60513a05f48ba879c713a47c8c7680b6e6a2dc7] ignored due to old SequenceID ('\x01')
2025/03/10 04:14:46 DEBUG : box root 'rclone-test-sulojeb9kexi': Received 1 events, resulting in 0 paths and 0 notifications
2025/03/10 04:14:46 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064833017")
2025/03/10 04:14:47 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064833270")
    fstests.go:931: Try 1/10 waiting for dirChanges and objChanges
2025/03/10 04:14:48 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064834019")
2025/03/10 04:14:48 DEBUG : box root 'rclone-test-sulojeb9kexi': ["file4.rclone_chunk.002_w9doz1"(0)|file|ITEM_UPLOAD|1798533692928|d06b7c18027cde2d0593ba4071e341521006dd80] ignored due to old SequenceID ('\x01')
2025/03/10 04:14:48 DEBUG : box root 'rclone-test-sulojeb9kexi': ["file2.rclone_chunk.001"(1)|file|ITEM_RENAME|1798544308664|41d9e28a5247d22ac8e7158b6d403d476eb73c91] ignored due to old SequenceID ('\x01')
2025/03/10 04:14:48 DEBUG : box root 'rclone-test-sulojeb9kexi': Received 2 events, resulting in 0 paths and 0 notifications
2025/03/10 04:14:48 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064835020")
2025/03/10 04:14:49 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064835267")
2025/03/10 04:14:49 DEBUG : box root 'rclone-test-sulojeb9kexi': ["file4.rclone_chunk.002"(1)|file|ITEM_RENAME|1798533692928|e25badbb18cbe0a63b87009ed6e0b761a3ce2b19] ignored due to old SequenceID ('\x01')
2025/03/10 04:14:49 DEBUG : box root 'rclone-test-sulojeb9kexi': Received 1 events, resulting in 0 paths and 0 notifications
2025/03/10 04:14:49 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064836019")
2025/03/10 04:14:50 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064836261")
2025/03/10 04:14:50 DEBUG : box root 'rclone-test-sulojeb9kexi': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1798536558475|548cb76d54b38b82f4ab5ab3ff683b61520968e7] ignored due to old SequenceID ('\x01')
2025/03/10 04:14:50 DEBUG : box root 'rclone-test-sulojeb9kexi': ["file3.rclone_chunk.002_w9dvzb"(0)|file|ITEM_UPLOAD|1798544893500|baab29f0f292d1851e10cfb624f20b6459558796] ignored due to old SequenceID ('\x01')
2025/03/10 04:14:50 DEBUG : box root 'rclone-test-sulojeb9kexi': ["file4"(0)|file|ITEM_UPLOAD|1798532786043|18d873c06532da270a4c69f477bcee79ba5a2d3e] ignored due to old SequenceID ('\x00')
2025/03/10 04:14:50 DEBUG : box root 'rclone-test-sulojeb9kexi': ["file3"(0)|file|ITEM_UPLOAD|1798538171172|0c0970796249772dc883007d1bc6ffeed822ff39] ignored due to old SequenceID ('\x00')
2025/03/10 04:14:50 DEBUG : box root 'rclone-test-sulojeb9kexi': ["file3.rclone_chunk.001_w9dvzb"(0)|file|ITEM_UPLOAD|1798536558475|a22d441cbbdb25636a77dc3a1ee39a8948d57468] ignored due to old SequenceID ('\x01')
2025/03/10 04:14:50 DEBUG : box root 'rclone-test-sulojeb9kexi': Received 5 events, resulting in 0 paths and 0 notifications
2025/03/10 04:14:50 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064837019")
    fstests.go:931: Try 2/10 waiting for dirChanges and objChanges
2025/03/10 04:14:51 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064837279")
2025/03/10 04:14:51 DEBUG : box root 'rclone-test-sulojeb9kexi': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1798536558475|548cb76d54b38b82f4ab5ab3ff683b61520968e7] ignored due to duplicate EventID
2025/03/10 04:14:51 DEBUG : box root 'rclone-test-sulojeb9kexi': ["file3.rclone_chunk.002_w9dvzb"(0)|file|ITEM_UPLOAD|1798544893500|baab29f0f292d1851e10cfb624f20b6459558796] ignored due to duplicate EventID
2025/03/10 04:14:52 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064838039")
2025/03/10 04:14:52 DEBUG : box root 'rclone-test-sulojeb9kexi': ["file4"(0)|file|ITEM_UPLOAD|1798532786043|18d873c06532da270a4c69f477bcee79ba5a2d3e] ignored due to duplicate EventID
2025/03/10 04:14:53 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064839012")
2025/03/10 04:14:53 DEBUG : box root 'rclone-test-sulojeb9kexi': ["file3"(0)|file|ITEM_UPLOAD|1798538171172|0c0970796249772dc883007d1bc6ffeed822ff39] ignored due to duplicate EventID
2025/03/10 04:14:53 DEBUG : box root 'rclone-test-sulojeb9kexi': ["file3.rclone_chunk.001_w9dvzb"(0)|file|ITEM_UPLOAD|1798536558475|a22d441cbbdb25636a77dc3a1ee39a8948d57468] ignored due to duplicate EventID
2025/03/10 04:14:53 DEBUG : box root 'rclone-test-sulojeb9kexi': ["file3.rclone_chunk.002"(1)|file|ITEM_RENAME|1798544893500|d1b66969300187a5e5092a8dd302d231440e6fb0] ignored due to old SequenceID ('\x01')
2025/03/10 04:14:53 DEBUG : box root 'rclone-test-sulojeb9kexi': Received 3 events, resulting in 0 paths and 0 notifications
2025/03/10 04:14:53 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064840038")
    fstests.go:931: Try 3/10 waiting for dirChanges and objChanges
2025/03/10 04:14:54 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064840273")
2025/03/10 04:14:54 DEBUG : box root 'rclone-test-sulojeb9kexi': ["file3"(0)|file|ITEM_UPLOAD|1798538171172|0c0970796249772dc883007d1bc6ffeed822ff39] ignored due to duplicate EventID
2025/03/10 04:14:54 DEBUG : box root 'rclone-test-sulojeb9kexi': ["file3.rclone_chunk.001_w9dvzb"(0)|file|ITEM_UPLOAD|1798536558475|a22d441cbbdb25636a77dc3a1ee39a8948d57468] ignored due to duplicate EventID
2025/03/10 04:14:55 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064841014")
2025/03/10 04:14:56 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064842031")
2025/03/10 04:14:56 DEBUG : box root 'rclone-test-sulojeb9kexi': ["file3.rclone_chunk.002"(1)|file|ITEM_RENAME|1798544893500|d1b66969300187a5e5092a8dd302d231440e6fb0] ignored due to duplicate EventID
    fstests.go:931: Try 4/10 waiting for dirChanges and objChanges
2025/03/10 04:14:57 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064843026")
2025/03/10 04:14:58 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064844018")
2025/03/10 04:14:59 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064845005")
    fstests.go:931: Try 5/10 waiting for dirChanges and objChanges
2025/03/10 04:15:00 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064846014")
2025/03/10 04:15:01 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064847046")
2025/03/10 04:15:02 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064848031")
    fstests.go:931: Try 6/10 waiting for dirChanges and objChanges
2025/03/10 04:15:03 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064849018")
2025/03/10 04:15:04 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064850026")
2025/03/10 04:15:05 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064851027")
    fstests.go:931: Try 7/10 waiting for dirChanges and objChanges
2025/03/10 04:15:06 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064852012")
2025/03/10 04:15:07 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064853021")
2025/03/10 04:15:08 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064854011")
    fstests.go:931: Try 8/10 waiting for dirChanges and objChanges
2025/03/10 04:15:09 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064855020")
2025/03/10 04:15:10 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064856023")
2025/03/10 04:15:11 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064857033")
    fstests.go:931: Try 9/10 waiting for dirChanges and objChanges
2025/03/10 04:15:12 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064858015")
2025/03/10 04:15:13 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064859006")
2025/03/10 04:15:14 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064860012")
    fstests.go:935: map[dir:{} dir/subdir1:{} dir/subdir2:{} dir/subdir3:{}] does not contain [dir/subdir1 dir/subdir3 dir/subdir2] or 
        map[dir/file4.rclone_chunk.001_w9doz1:{}] does not contain [dir/file2 dir/file4 dir/file3]
2025/03/10 04:15:15 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064861015")
2025/03/10 04:15:16 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064862032")
2025/03/10 04:15:17 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064863013")
2025/03/10 04:15:18 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064864016")
2025/03/10 04:15:19 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064865019")
2025/03/10 04:15:20 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064866024")
2025/03/10 04:15:21 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064867033")
2025/03/10 04:15:21 DEBUG : box root 'rclone-test-sulojeb9kexi': ["file2"(1)|file|ITEM_TRASH|1798541098877|250fd6bc067b6a25058b01dad6fae92e06a55d08] added old path ("dir/file2") for notify
2025/03/10 04:15:21 DEBUG : doChangeNotify("dir/file2", 1)
2025/03/10 04:15:21 DEBUG : box root 'rclone-test-sulojeb9kexi': Received 1 events, resulting in 1 paths and 1 notifications
2025/03/10 04:15:21 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064868015")
2025/03/10 04:15:22 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064868252")
2025/03/10 04:15:23 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064869012")
2025/03/10 04:15:24 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064870011")
2025/03/10 04:15:24 DEBUG : box root 'rclone-test-sulojeb9kexi': ["file2"(1)|file|ITEM_TRASH|1798541098877|250fd6bc067b6a25058b01dad6fae92e06a55d08] ignored due to duplicate EventID
2025/03/10 04:15:24 DEBUG : box root 'rclone-test-sulojeb9kexi': ["file2.rclone_chunk.002"(2)|file|ITEM_TRASH|1798536506179|4fb53af139473d5aa151757fb17fba1376e30872] added old path ("dir/file2.rclone_chunk.002") for notify
2025/03/10 04:15:24 DEBUG : box root 'rclone-test-sulojeb9kexi': ["file2.rclone_chunk.001"(2)|file|ITEM_TRASH|1798544308664|f05e786b2323783b43c5d4774975231dcba3c08d] added old path ("dir/file2.rclone_chunk.001") for notify
2025/03/10 04:15:24 DEBUG : box root 'rclone-test-sulojeb9kexi': ["file4"(1)|file|ITEM_TRASH|1798532786043|ebb872c8810fc56dc8128b46edafff8a06889e8c] added old path ("dir/file4") for notify
2025/03/10 04:15:24 DEBUG : doChangeNotify("dir/file2", 1)
2025/03/10 04:15:24 DEBUG : doChangeNotify("dir/file2", 1)
2025/03/10 04:15:24 DEBUG : doChangeNotify("dir/file4", 1)
2025/03/10 04:15:24 DEBUG : box root 'rclone-test-sulojeb9kexi': Received 4 events, resulting in 3 paths and 3 notifications
2025/03/10 04:15:24 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064871016")
2025/03/10 04:15:24 DEBUG : box root 'rclone-test-sulojeb9kexi': ["file2"(1)|file|ITEM_TRASH|1798541098877|250fd6bc067b6a25058b01dad6fae92e06a55d08] ignored due to duplicate EventID
2025/03/10 04:15:24 DEBUG : box root 'rclone-test-sulojeb9kexi': ["file2.rclone_chunk.002"(2)|file|ITEM_TRASH|1798536506179|4fb53af139473d5aa151757fb17fba1376e30872] ignored due to duplicate EventID
2025/03/10 04:15:24 DEBUG : box root 'rclone-test-sulojeb9kexi': ["file2.rclone_chunk.001"(2)|file|ITEM_TRASH|1798544308664|f05e786b2323783b43c5d4774975231dcba3c08d] ignored due to duplicate EventID
2025/03/10 04:15:24 DEBUG : box root 'rclone-test-sulojeb9kexi': ["file4"(1)|file|ITEM_TRASH|1798532786043|ebb872c8810fc56dc8128b46edafff8a06889e8c] ignored due to duplicate EventID
2025/03/10 04:15:25 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064871278")
2025/03/10 04:15:25 DEBUG : box root 'rclone-test-sulojeb9kexi': ["file2"(1)|file|ITEM_TRASH|1798541098877|250fd6bc067b6a25058b01dad6fae92e06a55d08] ignored due to duplicate EventID
2025/03/10 04:15:25 DEBUG : box root 'rclone-test-sulojeb9kexi': ["file2.rclone_chunk.002"(2)|file|ITEM_TRASH|1798536506179|4fb53af139473d5aa151757fb17fba1376e30872] ignored due to duplicate EventID
2025/03/10 04:15:25 DEBUG : box root 'rclone-test-sulojeb9kexi': ["file2.rclone_chunk.001"(2)|file|ITEM_TRASH|1798544308664|f05e786b2323783b43c5d4774975231dcba3c08d] ignored due to duplicate EventID
2025/03/10 04:15:25 DEBUG : box root 'rclone-test-sulojeb9kexi': ["file4"(1)|file|ITEM_TRASH|1798532786043|ebb872c8810fc56dc8128b46edafff8a06889e8c] ignored due to duplicate EventID
2025/03/10 04:15:25 DEBUG : box root 'rclone-test-sulojeb9kexi': ["file4.rclone_chunk.002"(2)|file|ITEM_TRASH|1798533692928|0446cffaa01d269ce345f4f4f0bed5a9f1da858f] added old path ("dir/file4.rclone_chunk.002") for notify
2025/03/10 04:15:25 DEBUG : box root 'rclone-test-sulojeb9kexi': ["file4.rclone_chunk.001"(2)|file|ITEM_TRASH|1798538126253|b1c2b803b78e2c2022529e8958ba2b749713e59e] added old path ("dir/file4.rclone_chunk.001") for notify
2025/03/10 04:15:25 DEBUG : doChangeNotify("dir/file4", 1)
2025/03/10 04:15:25 DEBUG : doChangeNotify("dir/file4", 1)
2025/03/10 04:15:25 DEBUG : box root 'rclone-test-sulojeb9kexi': Received 6 events, resulting in 2 paths and 2 notifications
2025/03/10 04:15:25 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064872007")
2025/03/10 04:15:26 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064872270")
2025/03/10 04:15:27 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064873009")
2025/03/10 04:15:27 DEBUG : box root 'rclone-test-sulojeb9kexi': ["file2.rclone_chunk.002"(2)|file|ITEM_TRASH|1798536506179|4fb53af139473d5aa151757fb17fba1376e30872] ignored due to duplicate EventID
2025/03/10 04:15:27 DEBUG : box root 'rclone-test-sulojeb9kexi': ["file2.rclone_chunk.001"(2)|file|ITEM_TRASH|1798544308664|f05e786b2323783b43c5d4774975231dcba3c08d] ignored due to duplicate EventID
2025/03/10 04:15:28 DEBUG : box root 'rclone-test-sulojeb9kexi': Checking for changes on remote (next_stream_position: "30401039064874044")
2025/03/10 04:15:28 DEBUG : box root 'rclone-test-sulojeb9kexi': ["file4"(1)|file|ITEM_TRASH|1798532786043|ebb872c8810fc56dc8128b46edafff8a06889e8c] ignored due to duplicate EventID
2025/03/10 04:15:30 DEBUG : box root 'rclone-test-sulojeb9kexi': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/03/10 04:15:30 ERROR : : error listing: directory not found
2025/03/10 04:15:30 DEBUG : box root 'rclone-test-sulojeb9kexi': Ignoring "Shared folder — ForNick" - unknown type "web_link"
--- FAIL: TestIntegration (75.20s)
    --- FAIL: TestIntegration/FsMkdir (72.66s)
        --- FAIL: TestIntegration/FsMkdir/FsChangeNotify (70.10s)
FAIL
exit status 1
FAIL	github.com/rclone/rclone/backend/chunker	75.225s
"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024 -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Finished ERROR in 1m17.124383269s (try 4/5): exit status 1: Failed [TestIntegration/FsMkdir/FsChangeNotify]